[SOLVED] Queue full exception in zwave network heal

Hi @chris,
I recently upgraded from openhab 2.4 to 2.5.5 and since the zwave binding experiences a queue full exception every night about 40 minutes after the 2am network heal process commences. I didn’t have this issue with openhab 2.4.

My installation is on a Synology NAS DS415+ running on Docker. CPU and memory usage looks fine. I have a large zwave network with about 50 nodes in total. I am using a AeoTec USB zwave stick gen 5.

I have tried deleting all the node things and other suggestions from other posts, nothing seems to help and would greatly appreciate any suggestions.

The exception is

2020-06-07 02:41:32.067 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Exception during ZWave thread. 
java.lang.IllegalStateException: Queue full
	at java.util.AbstractQueue.add(AbstractQueue.java:98) ~[?:1.8.0_232]
	at java.util.concurrent.ArrayBlockingQueue.add(ArrayBlockingQueue.java:312) ~[?:1.8.0_232]
	at org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager.processReceiveMessage(ZWaveTransactionManager.java:435) ~[bundleFile:?]
	at org.openhab.binding.zwave.internal.protocol.ZWaveController.incomingPacket(ZWaveController.java:1078) ~[bundleFile:?]
	at org.openhab.binding.zwave.handler.ZWaveControllerHandler.incomingMessage(ZWaveControllerHandler.java:437) ~[bundleFile:?]
	at org.openhab.binding.zwave.handler.ZWaveSerialHandler$ZWaveReceiveThread.run(ZWaveSerialHandler.java:420) [bundleFile:?]
2020-06-07 02:41:32.106 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Stopped ZWave thread: Receive

After the exception about 7 nodes will be in the failed state and the zwave network viewer looks like this.

Restarting openhab will restore the failed nodes.

The zwave log viewer at the start of the heal looks like this.



a short time later I start seeing

The log text for the period from the start of the heal process until nodes start failing is as follows. Please note I have truncated some repetitive sections.

2020-06-07 02:23:28.142 [DEBUG] [zwave.handler.ZWaveControllerHandler] - Starting network mesh heal for controller zwave:serial_zstick:85a23c30.
2020-06-07 02:23:28.143 [DEBUG] [zwave.handler.ZWaveControllerHandler] - Starting network mesh heal for controller zwave:serial_zstick:85a23c30.
2020-06-07 02:23:28.143 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 1: Starting network mesh heal.
2020-06-07 02:23:28.159 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 1: Starting initialisation from HEAL_START
2020-06-07 02:23:28.162 [DEBUG] [zwave.handler.ZWaveControllerHandler] - Starting network mesh heal for controller zwave:serial_zstick:85a23c30.
2020-06-07 02:23:28.162 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Starting network mesh heal.
2020-06-07 02:23:28.163 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 2: Starting initialisation from HEAL_START
2020-06-07 02:23:28.163 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 1: Node advancer - advancing to HEAL_START
2020-06-07 02:23:28.163 [DEBUG] [zwave.handler.ZWaveControllerHandler] - Starting network mesh heal for controller zwave:serial_zstick:85a23c30.
2020-06-07 02:23:28.163 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 2: Node advancer - advancing to HEAL_START
2020-06-07 02:23:28.164 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 3: Starting network mesh heal.
2020-06-07 02:23:28.164 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 3: Starting initialisation from HEAL_START
2020-06-07 02:23:28.164 [DEBUG] [zwave.handler.ZWaveControllerHandler] - Starting network mesh heal for controller zwave:serial_zstick:85a23c30.
2020-06-07 02:23:28.165 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 3: Node advancer - advancing to HEAL_START
2020-06-07 02:23:28.165 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Starting network mesh heal.
2020-06-07 02:23:28.165 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 4: Starting initialisation from HEAL_START
2020-06-07 02:23:28.165 [DEBUG] [zwave.handler.ZWaveControllerHandler] - Starting network mesh heal for controller zwave:serial_zstick:85a23c30.
2020-06-07 02:23:28.166 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 4: Node advancer - advancing to HEAL_START
2020-06-07 02:23:28.166 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 5: Starting network mesh heal.
2020-06-07 02:23:28.166 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 5: Starting initialisation from HEAL_START

...

2020-06-07 02:23:28.210 [DEBUG] [zwave.handler.ZWaveControllerHandler] - Starting network mesh heal for controller zwave:serial_zstick:85a23c30.
2020-06-07 02:23:28.205 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 10: Got an event from Z-Wave network: ZWaveInitializationStateEvent
2020-06-07 02:23:28.210 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 10: Node advancer: UPDATE_NEIGHBORS - updating neighbor list
2020-06-07 02:23:28.210 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 27: Starting network mesh heal.
2020-06-07 02:23:28.205 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 21: Got an event from Z-Wave network: ZWaveInitializationStateEvent
2020-06-07 02:23:28.201 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 19: Node advancer - advancing to UPDATE_NEIGHBORS
2020-06-07 02:23:28.210 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 27: Starting initialisation from HEAL_START
2020-06-07 02:23:28.211 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 19: Got an event from Z-Wave network: ZWaveInitializationStateEvent
2020-06-07 02:23:28.211 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 19: Node advancer: UPDATE_NEIGHBORS - updating neighbor list
2020-06-07 02:23:28.209 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 25: Node advancer: UPDATE_NEIGHBORS - updating neighbor list
2020-06-07 02:23:28.211 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 26: Node advancer - advancing to HEAL_START
2020-06-07 02:23:28.212 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 26: Got an event from Z-Wave network: ZWaveInitializationStateEvent
2020-06-07 02:23:28.212 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 26: Node advancer - advancing to UPDATE_NEIGHBORS
2020-06-07 02:23:28.210 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 21: Node advancer - advancing to UPDATE_NEIGHBORS
2020-06-07 02:23:28.213 [DEBUG] [zwave.handler.ZWaveControllerHandler] - Starting network mesh heal for controller zwave:serial_zstick:85a23c30.
2020-06-07 02:23:28.213 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 21: Got an event from Z-Wave network: ZWaveInitializationStateEvent
2020-06-07 02:23:28.213 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 29: Starting network mesh heal.
2020-06-07 02:23:28.213 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 21: Node advancer: UPDATE_NEIGHBORS - updating neighbor list
2020-06-07 02:23:28.213 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 29: Starting initialisation from HEAL_START
2020-06-07 02:23:28.213 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 26: Got an event from Z-Wave network: ZWaveInitializationStateEvent
2020-06-07 02:23:28.214 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 26: Node advancer: UPDATE_NEIGHBORS - updating neighbor list
2020-06-07 02:23:28.216 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 27: Node advancer - advancing to HEAL_START
2020-06-07 02:23:28.217 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 27: Got an event from Z-Wave network: ZWaveInitializationStateEvent
2020-06-07 02:23:28.218 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 27: Node advancer - advancing to UPDATE_NEIGHBORS
2020-06-07 02:23:28.219 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 27: Got an event from Z-Wave network: ZWaveInitializationStateEvent
2020-06-07 02:23:28.219 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 27: Node advancer: UPDATE_NEIGHBORS - updating neighbor list
2020-06-07 02:23:28.220 [DEBUG] [zwave.handler.ZWaveControllerHandler] - Starting network mesh heal for controller zwave:serial_zstick:85a23c30.
2020-06-07 02:23:28.221 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 30: Starting network mesh heal.
2020-06-07 02:23:28.221 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 30: Starting initialisation from HEAL_START
2020-06-07 02:23:28.223 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 29: Node advancer - advancing to HEAL_START
2020-06-07 02:23:28.224 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 29: Got an event from Z-Wave network: ZWaveInitializationStateEvent
2020-06-07 02:23:28.225 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 29: Node advancer - advancing to UPDATE_NEIGHBORS
2020-06-07 02:23:28.226 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 29: Got an event from Z-Wave network: ZWaveInitializationStateEvent
2020-06-07 02:23:28.227 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 29: Node advancer: UPDATE_NEIGHBORS - updating neighbor list
2020-06-07 02:23:28.228 [DEBUG] [zwave.handler.ZWaveControllerHandler] - Starting network mesh heal for controller zwave:serial_zstick:85a23c30.
2020-06-07 02:23:28.228 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 31: Starting network mesh heal.

...

2020-06-07 02:23:28.303 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2020-06-07 02:23:28.303 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 35: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@af7eeda
2020-06-07 02:23:28.306 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 22: Request neighbor update
2020-06-07 02:23:28.306 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 7: Request neighbor update
2020-06-07 02:23:28.306 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 42: Request neighbor update
2020-06-07 02:23:28.306 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 37: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@34c6747c
2020-06-07 02:23:28.307 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 7: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@49cd8097
2020-06-07 02:23:28.306 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 11: Request neighbor update
2020-06-07 02:23:28.307 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 42: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@1556b91e
2020-06-07 02:23:28.307 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 11: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@385bd914
2020-06-07 02:23:28.307 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 24: Request neighbor update
2020-06-07 02:23:28.306 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 4: Request neighbor update
2020-06-07 02:23:28.303 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 30: Request neighbor update
2020-06-07 02:23:28.307 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@114e44c7
2020-06-07 02:23:28.300 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 40: Request neighbor update
2020-06-07 02:23:28.307 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 20: Request neighbor update
2020-06-07 02:23:28.307 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 23: Request neighbor update
2020-06-07 02:23:28.307 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 40: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@721f1385
2020-06-07 02:23:28.308 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 23: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@25103f99
2020-06-07 02:23:28.308 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 16: Request neighbor update
2020-06-07 02:23:28.308 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 17: Request neighbor update
2020-06-07 02:23:28.306 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 10: Request neighbor update
2020-06-07 02:23:28.308 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 10: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@71643156
2020-06-07 02:23:28.306 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 18: Request neighbor update
2020-06-07 02:23:28.308 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 8: Request neighbor update
2020-06-07 02:23:28.309 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 18: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@63025034
2020-06-07 02:23:28.309 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 8: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@752afc72
2020-06-07 02:23:28.309 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 3: Request neighbor update
2020-06-07 02:23:28.309 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 3: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@133f0d94
2020-06-07 02:23:28.306 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 19: Request neighbor update
2020-06-07 02:23:28.310 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 19: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@37244759
2020-06-07 02:23:28.310 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 46: Request neighbor update
2020-06-07 02:23:28.310 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 2: Request neighbor update
2020-06-07 02:23:28.310 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 9: Request neighbor update
2020-06-07 02:23:28.310 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@8fefcae
2020-06-07 02:23:28.305 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 25: Request neighbor update
2020-06-07 02:23:28.311 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 12: Request neighbor update
2020-06-07 02:23:28.311 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 25: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@299de14c
2020-06-07 02:23:28.305 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 21: Request neighbor update
2020-06-07 02:23:28.311 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 12: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@471ded34
2020-06-07 02:23:28.311 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 21: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@15ebbdf
2020-06-07 02:23:28.305 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 26: Request neighbor update
2020-06-07 02:23:28.311 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 6: Request neighbor update
2020-06-07 02:23:28.312 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 26: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@a516579
2020-06-07 02:23:28.312 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@644e09c9
2020-06-07 02:23:28.305 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 27: Request neighbor update
2020-06-07 02:23:28.312 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 1: Request neighbor update
2020-06-07 02:23:28.312 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 27: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@34220b5b
2020-06-07 02:23:28.312 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 1: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@3aeedb40
2020-06-07 02:23:28.305 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 29: Request neighbor update
2020-06-07 02:23:28.312 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 46: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@17270eaf
2020-06-07 02:23:28.312 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@282c1baf
2020-06-07 02:23:28.313 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 29: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@4fa96301
2020-06-07 02:23:28.304 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 31: Request neighbor update
2020-06-07 02:23:28.313 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 31: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@1a616489
2020-06-07 02:23:28.304 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2020-06-07 02:23:28.304 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 34: Request neighbor update
2020-06-07 02:23:28.313 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2020-06-07 02:23:28.313 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 34: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@1f3fbaa0
2020-06-07 02:23:28.308 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 5: Request neighbor update
2020-06-07 02:23:28.308 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 17: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@1981ca17
2020-06-07 02:23:28.314 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 5: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@22b6e8be
2020-06-07 02:23:28.308 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 13: Request neighbor update
2020-06-07 02:23:28.308 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@7e8be723
2020-06-07 02:23:28.308 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 30: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@72617c4a
2020-06-07 02:23:28.307 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 24: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@30efdb66
2020-06-07 02:23:28.314 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@30e5dfe
2020-06-07 02:23:28.304 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 5521: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 74
2020-06-07 02:23:28.298 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 45: Request neighbor update
2020-06-07 02:23:28.306 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 22: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@44df2e17
2020-06-07 02:23:28.308 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 20: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@7829a725
2020-06-07 02:23:28.306 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 15: Request neighbor update
2020-06-07 02:23:28.313 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2020-06-07 02:23:28.315 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@45624cdd
2020-06-07 02:23:28.315 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 5521: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 74
2020-06-07 02:23:28.315 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2020-06-07 02:23:28.314 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 44: Adding to device queue
2020-06-07 02:23:28.315 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2020-06-07 02:23:28.315 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 45: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@1b53b9bb
2020-06-07 02:23:28.316 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 44: Added 5524 to queue - size 1
2020-06-07 02:23:28.317 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2020-06-07 02:23:28.318 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 36: Adding to device queue
2020-06-07 02:23:28.345 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 32: Node advancer - advancing to HEAL_START
2020-06-07 02:23:28.353 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 36: Added 5523 to queue - size 2
2020-06-07 02:23:28.353 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2020-06-07 02:23:28.353 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 32: Got an event from Z-Wave network: ZWaveInitializationStateEvent
2020-06-07 02:23:28.353 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 32: Node advancer - advancing to UPDATE_NEIGHBORS
2020-06-07 02:23:28.354 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 32: Got an event from Z-Wave network: ZWaveInitializationStateEvent
2020-06-07 02:23:28.354 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 32: Node advancer: UPDATE_NEIGHBORS - updating neighbor list
2020-06-07 02:23:28.354 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 32: Request neighbor update
2020-06-07 02:23:28.354 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Adding to device queue
2020-06-07 02:23:28.355 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 32: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@5b210475
2020-06-07 02:23:28.355 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 33: Added 5522 to queue - size 3
2020-06-07 02:23:28.355 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2020-06-07 02:23:28.355 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 45: Adding to device queue
2020-06-07 02:23:28.356 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 45: Added 5565 to queue - size 4
2020-06-07 02:23:28.356 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2020-06-07 02:23:28.356 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 20: Adding to device queue
2020-06-07 02:23:28.357 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 20: Added 5564 to queue - size 5
2020-06-07 02:23:28.357 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2020-06-07 02:23:28.357 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Adding to device queue
2020-06-07 02:23:28.357 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 13: Added 5563 to queue - size 6
2020-06-07 02:23:28.358 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

...

2020-06-07 02:23:28.389 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 32: Adding to device queue
2020-06-07 02:23:28.389 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 32: Added 5566 to queue - size 45
2020-06-07 02:23:28.389 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2020-06-07 02:23:28.526 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 05 00 48 4A 21 D9 
2020-06-07 02:23:28.526 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=RequestNodeNeighborUpdate[72], type=Request[0], dest=33, callback=74, payload=4A 21 
2020-06-07 02:23:28.527 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=RequestNodeNeighborUpdate[72], type=Request[0], dest=33, callback=74, payload=4A 21 
2020-06-07 02:23:28.527 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 5521: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 74
2020-06-07 02:23:28.527 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2020-06-07 02:23:28.527 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 5521: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 74
2020-06-07 02:23:28.527 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 5521: (Callback 74)
2020-06-07 02:23:28.528 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2020-06-07 02:23:28.529 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 5521: callback 74
2020-06-07 02:23:28.529 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=RequestNodeNeighborUpdate[72], type=Request[0], dest=33, callback=74, payload=4A 21 
2020-06-07 02:23:28.529 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 14: Got NodeNeighborUpdate request.
2020-06-07 02:23:28.529 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 14: NodeNeighborUpdate STARTED
2020-06-07 02:23:28.530 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 5521: Advanced to WAIT_DATA
2020-06-07 02:23:28.530 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 14: TID 5521: Transaction not completed
2020-06-07 02:23:28.530 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2020-06-07 02:23:28.530 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2020-06-07 02:23:28.823 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 05 00 48 4A 21 D9 
2020-06-07 02:23:28.823 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=RequestNodeNeighborUpdate[72], type=Request[0], dest=33, callback=74, payload=4A 21 
2020-06-07 02:23:28.824 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=RequestNodeNeighborUpdate[72], type=Request[0], dest=33, callback=74, payload=4A 21 
2020-06-07 02:23:28.824 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2020-06-07 02:23:28.824 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2020-06-07 02:23:28.824 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: null
2020-06-07 02:23:28.824 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 5521: (Callback 74)
2020-06-07 02:23:28.825 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2020-06-07 02:23:28.825 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 5521: callback 74
2020-06-07 02:23:28.825 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=RequestNodeNeighborUpdate[72], type=Request[0], dest=33, callback=74, payload=4A 21 
2020-06-07 02:23:28.825 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 14: Got NodeNeighborUpdate request.
2020-06-07 02:23:28.825 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 14: NodeNeighborUpdate STARTED
2020-06-07 02:23:28.826 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 14: TID 5521: Transaction not completed
2020-06-07 02:23:28.826 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2020-06-07 02:23:28.826 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2020-06-07 02:23:32.388 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 05 00 48 4A 22 DA 
2020-06-07 02:23:32.388 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=RequestNodeNeighborUpdate[72], type=Request[0], dest=34, callback=74, payload=4A 22 
2020-06-07 02:23:32.389 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=RequestNodeNeighborUpdate[72], type=Request[0], dest=34, callback=74, payload=4A 22 
2020-06-07 02:23:32.389 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2020-06-07 02:23:32.389 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2020-06-07 02:23:32.389 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: null
2020-06-07 02:23:32.390 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 5521: (Callback 74)
2020-06-07 02:23:32.390 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2020-06-07 02:23:32.390 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 5521: callback 74
2020-06-07 02:23:32.390 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=RequestNodeNeighborUpdate[72], type=Request[0], dest=34, callback=74, payload=4A 22 
2020-06-07 02:23:32.390 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 14: Got NodeNeighborUpdate request.
2020-06-07 02:23:32.391 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 14: NodeNeighborUpdate DONE
2020-06-07 02:23:32.426 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 14: Got an event from Z-Wave network: ZWaveNetworkEvent
2020-06-07 02:23:32.427 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 5521: Transaction COMPLETED
2020-06-07 02:23:32.427 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 14: Response processed after 4123ms
2020-06-07 02:23:32.428 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 14: TID 5521: Transaction completed
2020-06-07 02:23:32.428 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 14: notifyTransactionResponse TID:5521 DONE
2020-06-07 02:23:32.429 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 14: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2020-06-07 02:23:32.430 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 5521: Transaction event listener: DONE: DONE -> 
2020-06-07 02:23:32.430 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2020-06-07 02:23:32.430 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 14: Node Init response (0) org.openhab.binding.zwave.internal.protocol.ZWaveTransactionResponse@14b7228f
2020-06-07 02:23:32.430 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2020-06-07 02:23:32.430 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 14: Node Init transaction completed with response COMPLETE
2020-06-07 02:23:32.430 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 14: Node advancer - advancing to GET_NEIGHBORS
2020-06-07 02:23:32.431 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 05 00 48 21 4B D8 
2020-06-07 02:23:32.431 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 05 00 48 21 4B D8 
2020-06-07 02:23:32.431 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 14: Got an event from Z-Wave network: ZWaveInitializationStateEvent
2020-06-07 02:23:32.431 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 14: Node advancer: GET_NEIGHBORS - get RoutingInfo
2020-06-07 02:23:32.431 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2020-06-07 02:23:32.431 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 5522: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 75
2020-06-07 02:23:32.432 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2020-06-07 02:23:32.432 [DEBUG] [almessage.GetRoutingInfoMessageClass] - NODE 14: Request routing info
2020-06-07 02:23:32.432 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2020-06-07 02:23:32.432 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: sendTransaction org.openhab.binding.zwave.internal.protocol.ZWaveSerialPayload@51b5be7d
2020-06-07 02:23:32.432 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2020-06-07 02:23:32.433 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 5522: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 75
2020-06-07 02:23:32.433 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2020-06-07 02:23:32.433 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2020-06-07 02:23:32.433 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Added 5567 to queue - size 1
2020-06-07 02:23:32.433 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2020-06-07 02:23:32.433 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2020-06-07 02:23:32.654 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 05 00 48 4B 21 D8 
2020-06-07 02:23:32.655 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=RequestNodeNeighborUpdate[72], type=Request[0], dest=33, callback=75, payload=4B 21 
2020-06-07 02:23:32.655 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=RequestNodeNeighborUpdate[72], type=Request[0], dest=33, callback=75, payload=4B 21 
2020-06-07 02:23:32.656 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 5522: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 75
2020-06-07 02:23:32.656 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2020-06-07 02:23:32.656 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 5522: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 75
2020-06-07 02:23:32.656 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 5522: (Callback 75)
2020-06-07 02:23:32.657 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2020-06-07 02:23:32.657 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 5522: callback 75
2020-06-07 02:23:32.657 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=RequestNodeNeighborUpdate[72], type=Request[0], dest=33, callback=75, payload=4B 21 
2020-06-07 02:23:32.657 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 33: Got NodeNeighborUpdate request.
2020-06-07 02:23:32.657 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 33: NodeNeighborUpdate STARTED

...

2020-06-07 02:23:33.205 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 36: Got NodeNeighborUpdate request.
2020-06-07 02:23:33.205 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 36: NodeNeighborUpdate FAILED
2020-06-07 02:23:33.205 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 36: Got an event from Z-Wave network: ZWaveNetworkEvent
2020-06-07 02:23:33.205 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 5523: Transaction CANCELLED
2020-06-07 02:23:33.206 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 36: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2020-06-07 02:23:33.206 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 36: CANCEL while sending message. Requeueing - 1 attempts left!
2020-06-07 02:23:33.206 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 5523: Transaction RESET with 1 retries remaining.
2020-06-07 02:23:33.206 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 36: Adding to device queue
2020-06-07 02:23:33.206 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 36: Added 5523 to queue - size 44
2020-06-07 02:23:33.207 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2020-06-07 02:23:33.207 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 05 00 48 24 4E D8 
2020-06-07 02:23:33.207 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 05 00 48 24 4E D8 
2020-06-07 02:23:33.207 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2020-06-07 02:23:33.208 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 5523: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 78
2020-06-07 02:23:33.208 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 36: TID 5523: Transaction not completed
2020-06-07 02:23:33.208 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2020-06-07 02:23:33.208 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2020-06-07 02:23:33.208 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2020-06-07 02:23:33.208 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2020-06-07 02:23:33.209 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2020-06-07 02:23:33.209 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 5523: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 78
2020-06-07 02:23:33.210 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2020-06-07 02:23:33.209 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 05 00 48 4E 23 DF 
2020-06-07 02:23:33.210 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2020-06-07 02:23:33.210 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2020-06-07 02:23:33.210 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=RequestNodeNeighborUpdate[72], type=Request[0], dest=35, callback=78, payload=4E 23 
2020-06-07 02:23:33.210 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=RequestNodeNeighborUpdate[72], type=Request[0], dest=35, callback=78, payload=4E 23 
2020-06-07 02:23:33.211 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 5523: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 78
2020-06-07 02:23:33.211 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2020-06-07 02:23:33.211 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 5523: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 78
2020-06-07 02:23:33.211 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 5523: (Callback 78)
2020-06-07 02:23:33.211 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2020-06-07 02:23:33.212 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 5523: callback 78
2020-06-07 02:23:33.212 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=RequestNodeNeighborUpdate[72], type=Request[0], dest=35, callback=78, payload=4E 23 
2020-06-07 02:23:33.258 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 36: Got NodeNeighborUpdate request.
2020-06-07 02:23:33.258 [DEBUG] [equestNodeNeighborUpdateMessageClass] - NODE 36: NodeNeighborUpdate FAILED
2020-06-07 02:23:33.258 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 36: Got an event from Z-Wave network: ZWaveNetworkEvent
2020-06-07 02:23:33.271 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 5523: Transaction CANCELLED
2020-06-07 02:23:33.288 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 36: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2020-06-07 02:23:33.288 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 36: Retry count exceeded. Discarding message: TID 5523: [CANCELLED] priority=Controller, requiresResponse=true, callback: 78
2020-06-07 02:23:33.289 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 36: Got an event from Z-Wave network: ZWaveNodeStatusEvent
2020-06-07 02:23:33.289 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 36: Setting OFFLINE
2020-06-07 02:23:33.349 [DEBUG] [ve.internal.protocol.ZWaveController] - NODE 36: Node Status event - Node is DEAD
2020-06-07 02:23:33.350 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 36: Node is DEAD.
2020-06-07 02:23:33.351 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 36: Got an event from Z-Wave network: ZWaveNodeStatusEvent
2020-06-07 02:23:33.351 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 36: Setting OFFLINE
2020-06-07 02:23:33.352 [DEBUG] [ve.internal.protocol.ZWaveController] - NODE 36: Node Status event - Node is DEAD
2020-06-07 02:23:33.353 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 36: TID 5523: Transaction completed
2020-06-07 02:23:33.354 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 36: notifyTransactionResponse TID:5523 CANCELLED
2020-06-07 02:23:33.355 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 36: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2020-06-07 02:23:33.355 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 5523: Transaction event listener: DONE: CANCELLED -> 
2020-06-07 02:23:33.355 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2020-06-07 02:23:33.355 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 36: Node Init response (0) org.openhab.binding.zwave.internal.protocol.ZWaveTransactionResponse@31a48ced

Disable the nightly heal. There are some serious issues with it. There are some forum posts and github issues that describe the types of behavior you’re seeing.

Thanks Mark, Disabled the heal and will continue to monitor.