2021-06-10 23:50:49.457 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@5a486616.
2021-06-10 23:50:49.457 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:49.457 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:49.457 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:49.458 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:53.957 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 08 00 04 00 0F 02 98 40 26 
2021-06-10 23:50:53.959 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 02 98 40 
2021-06-10 23:50:53.959 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 02 98 40 
2021-06-10 23:50:53.959 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2021-06-10 23:50:53.959 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Application Command Request (ALIVE:DONE)
2021-06-10 23:50:53.960 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:53.960 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: Incoming command class COMMAND_CLASS_SECURITY, endpoint 0
2021-06-10 23:50:53.960 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: SECURITY check internal
2021-06-10 23:50:53.960 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 15: Received COMMAND_CLASS_SECURITY V1 SECURITY_NONCE_GET
2021-06-10 23:50:53.960 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Added to secure queue - size 1
2021-06-10 23:50:53.960 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Commands processed 1.
2021-06-10 23:50:53.960 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@d28ea20.
2021-06-10 23:50:53.960 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:53.960 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:53.960 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:53.961 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:53.961 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 15: Sending REQUEST Message = 01 11 00 13 0F 0A 98 80 4F 75 29 A2 70 33 C2 CA 25 AD 92 
2021-06-10 23:50:53.962 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2021-06-10 23:50:53.962 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 30691: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 173
2021-06-10 23:50:53.964 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2021-06-10 23:50:53.964 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-06-10 23:50:53.964 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-06-10 23:50:53.964 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30691: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 173
2021-06-10 23:50:53.964 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2021-06-10 23:50:53.964 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:53.964 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:50:53.973 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2021-06-10 23:50:53.975 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:53.975 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:53.975 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30691: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 173
2021-06-10 23:50:53.975 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-06-10 23:50:53.976 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 30691: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 173
2021-06-10 23:50:53.976 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:53.976 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 30691: Advanced to WAIT_REQUEST
2021-06-10 23:50:53.976 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: TID 30691: Transaction not completed
2021-06-10 23:50:53.976 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:53.976 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:50:53.989 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 AD 00 00 02 44 
2021-06-10 23:50:53.991 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=173, payload=AD 00 00 02 
2021-06-10 23:50:53.993 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=173, payload=AD 00 00 02 
2021-06-10 23:50:53.993 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30691: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 173
2021-06-10 23:50:53.993 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-06-10 23:50:53.993 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 30691: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 173
2021-06-10 23:50:53.993 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 30691: (Callback 173)
2021-06-10 23:50:53.994 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2021-06-10 23:50:53.994 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 30691: callback 173
2021-06-10 23:50:53.994 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=173, payload=AD 00 00 02 
2021-06-10 23:50:53.994 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:53.994 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 30691: Transaction COMPLETED
2021-06-10 23:50:53.994 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Response processed after 32ms
2021-06-10 23:50:53.994 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: TID 30691: Transaction completed
2021-06-10 23:50:53.994 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: notifyTransactionResponse TID:30691 DONE
2021-06-10 23:50:53.995 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 15: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2021-06-10 23:50:53.995 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:53.995 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:54.020 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 23 00 04 00 0F 1D 98 81 8D 70 88 EA 4E 99 99 B9 37 E6 69 E9 DC 53 04 F9 F3 C2 4F 07 8B EE A7 66 F0 7A 61 AE 
2021-06-10 23:50:54.022 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 1D 98 81 8D 70 88 EA 4E 99 99 B9 37 E6 69 E9 DC 53 04 F9 F3 C2 4F 07 8B EE A7 66 F0 7A 61 
2021-06-10 23:50:54.022 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 1D 98 81 8D 70 88 EA 4E 99 99 B9 37 E6 69 E9 DC 53 04 F9 F3 C2 4F 07 8B EE A7 66 F0 7A 61 
2021-06-10 23:50:54.022 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2021-06-10 23:50:54.022 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Application Command Request (ALIVE:DONE)
2021-06-10 23:50:54.022 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:54.022 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: Decapsulating COMMAND_CLASS_SECURITY
2021-06-10 23:50:54.022 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 15: SECURITY_RXD 60 0D 00 01 5B 03 30 80 01 
2021-06-10 23:50:54.023 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2021-06-10 23:50:54.023 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: Incoming command class COMMAND_CLASS_CENTRAL_SCENE, endpoint 0
2021-06-10 23:50:54.023 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 15: Received COMMAND_CLASS_CENTRAL_SCENE V3 CENTRAL_SCENE_NOTIFICATION
2021-06-10 23:50:54.023 [DEBUG] [dclass.ZWaveCentralSceneCommandClass] - NODE 15: Received scene 1 at key 0 [Single Press]
2021-06-10 23:50:54.023 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 15: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2021-06-10 23:50:54.023 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 15: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_CENTRAL_SCENE, value=1.0
2021-06-10 23:50:54.023 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 15: Updating channel state zwave:device:8f57dbad:node15:scene_number to 1.0 [DecimalType]
2021-06-10 23:50:54.024 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Commands processed 1.
2021-06-10 23:50:54.025 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@7dc36510.
2021-06-10 23:50:54.025 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:54.025 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:54.025 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:54.025 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:54.217 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 08 00 04 00 0F 02 98 40 26 
2021-06-10 23:50:54.219 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 02 98 40 
2021-06-10 23:50:54.220 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 02 98 40 
2021-06-10 23:50:54.220 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2021-06-10 23:50:54.220 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Application Command Request (ALIVE:DONE)
2021-06-10 23:50:54.220 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:54.220 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: Incoming command class COMMAND_CLASS_SECURITY, endpoint 0
2021-06-10 23:50:54.220 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: SECURITY check internal
2021-06-10 23:50:54.220 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 15: Received COMMAND_CLASS_SECURITY V1 SECURITY_NONCE_GET
2021-06-10 23:50:54.220 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Added to secure queue - size 1
2021-06-10 23:50:54.221 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Commands processed 1.
2021-06-10 23:50:54.221 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1d739aa8.
2021-06-10 23:50:54.221 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:54.221 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:54.221 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:54.221 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:54.221 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 15: Sending REQUEST Message = 01 11 00 13 0F 0A 98 80 84 EB 13 02 78 39 16 D4 25 AE 96 
2021-06-10 23:50:54.222 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2021-06-10 23:50:54.222 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 30692: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 174
2021-06-10 23:50:54.224 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2021-06-10 23:50:54.224 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-06-10 23:50:54.224 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-06-10 23:50:54.224 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30692: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 174
2021-06-10 23:50:54.224 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2021-06-10 23:50:54.224 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:54.224 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:50:54.234 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2021-06-10 23:50:54.236 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:54.236 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:54.236 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30692: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 174
2021-06-10 23:50:54.236 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-06-10 23:50:54.236 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 30692: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 174
2021-06-10 23:50:54.237 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:54.237 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 30692: Advanced to WAIT_REQUEST
2021-06-10 23:50:54.237 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: TID 30692: Transaction not completed
2021-06-10 23:50:54.237 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:54.237 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:50:54.251 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 AE 00 00 02 47 
2021-06-10 23:50:54.254 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=174, payload=AE 00 00 02 
2021-06-10 23:50:54.254 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=174, payload=AE 00 00 02 
2021-06-10 23:50:54.254 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30692: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 174
2021-06-10 23:50:54.254 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-06-10 23:50:54.254 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 30692: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 174
2021-06-10 23:50:54.254 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 30692: (Callback 174)
2021-06-10 23:50:54.255 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2021-06-10 23:50:54.255 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 30692: callback 174
2021-06-10 23:50:54.255 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=174, payload=AE 00 00 02 
2021-06-10 23:50:54.255 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:54.255 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 30692: Transaction COMPLETED
2021-06-10 23:50:54.255 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Response processed after 33ms
2021-06-10 23:50:54.255 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: TID 30692: Transaction completed
2021-06-10 23:50:54.255 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: notifyTransactionResponse TID:30692 DONE
2021-06-10 23:50:54.256 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 15: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2021-06-10 23:50:54.256 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:54.256 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:54.276 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 21 00 04 00 0F 1B 98 81 7C 96 5B 75 0E 88 50 08 96 2C 04 E6 31 2A 52 8D 84 96 12 88 39 8E B9 5B 4E C2 
2021-06-10 23:50:54.279 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 1B 98 81 7C 96 5B 75 0E 88 50 08 96 2C 04 E6 31 2A 52 8D 84 96 12 88 39 8E B9 5B 4E 
2021-06-10 23:50:54.279 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 1B 98 81 7C 96 5B 75 0E 88 50 08 96 2C 04 E6 31 2A 52 8D 84 96 12 88 39 8E B9 5B 4E 
2021-06-10 23:50:54.279 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2021-06-10 23:50:54.279 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Application Command Request (ALIVE:DONE)
2021-06-10 23:50:54.279 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:54.280 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: Decapsulating COMMAND_CLASS_SECURITY
2021-06-10 23:50:54.280 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 15: SECURITY_RXD 60 0D 01 01 25 03 FF 
2021-06-10 23:50:54.280 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2021-06-10 23:50:54.280 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: Incoming command class COMMAND_CLASS_SWITCH_BINARY, endpoint 1
2021-06-10 23:50:54.280 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 15: Received COMMAND_CLASS_SWITCH_BINARY V0 SWITCH_BINARY_REPORT
2021-06-10 23:50:54.280 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - NODE 15: Switch Binary report, value = 255
2021-06-10 23:50:54.280 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 15: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2021-06-10 23:50:54.280 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 15: Got a value event from Z-Wave network, endpoint=1, command class=COMMAND_CLASS_SWITCH_BINARY, value=255
2021-06-10 23:50:54.280 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 15: Updating channel state zwave:device:8f57dbad:node15:switch_binary1 to ON [OnOffType]
2021-06-10 23:50:54.285 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Commands processed 1.
2021-06-10 23:50:54.285 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@49237c6.
2021-06-10 23:50:54.285 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:54.285 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:54.286 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:54.286 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:55.683 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 08 00 04 00 02 02 98 40 2B 
2021-06-10 23:50:55.685 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 02 98 40 
2021-06-10 23:50:55.685 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 02 98 40 
2021-06-10 23:50:55.685 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2021-06-10 23:50:55.685 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Application Command Request (ALIVE:DONE)
2021-06-10 23:50:55.685 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:55.685 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Incoming command class COMMAND_CLASS_SECURITY, endpoint 0
2021-06-10 23:50:55.685 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY check internal
2021-06-10 23:50:55.685 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 2: Received COMMAND_CLASS_SECURITY V1 SECURITY_NONCE_GET
2021-06-10 23:50:55.685 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Added to secure queue - size 1
2021-06-10 23:50:55.686 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Commands processed 1.
2021-06-10 23:50:55.686 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@4ea1b49e.
2021-06-10 23:50:55.686 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:55.686 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:55.686 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:55.686 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:55.686 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 2: Sending REQUEST Message = 01 11 00 13 02 0A 98 80 88 68 5C FA 5B 08 EF 69 25 AF F4 
2021-06-10 23:50:55.687 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2021-06-10 23:50:55.687 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 30693: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 175
2021-06-10 23:50:55.689 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2021-06-10 23:50:55.689 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-06-10 23:50:55.689 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-06-10 23:50:55.689 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30693: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 175
2021-06-10 23:50:55.689 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2021-06-10 23:50:55.689 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:55.689 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:50:55.697 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2021-06-10 23:50:55.700 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:55.701 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:55.701 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30693: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 175
2021-06-10 23:50:55.701 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-06-10 23:50:55.701 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 30693: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 175
2021-06-10 23:50:55.701 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:55.701 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 30693: Advanced to WAIT_REQUEST
2021-06-10 23:50:55.701 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: TID 30693: Transaction not completed
2021-06-10 23:50:55.701 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:55.701 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:50:55.802 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 08 00 04 00 0F 02 98 40 26 
2021-06-10 23:50:55.805 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 02 98 40 
2021-06-10 23:50:55.805 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 02 98 40 
2021-06-10 23:50:55.805 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30693: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 175
2021-06-10 23:50:55.805 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Application Command Request (ALIVE:DONE)
2021-06-10 23:50:55.805 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:55.805 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: Incoming command class COMMAND_CLASS_SECURITY, endpoint 0
2021-06-10 23:50:55.805 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: SECURITY check internal
2021-06-10 23:50:55.805 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 15: Received COMMAND_CLASS_SECURITY V1 SECURITY_NONCE_GET
2021-06-10 23:50:55.806 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Added to secure queue - size 1
2021-06-10 23:50:55.806 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Commands processed 1.
2021-06-10 23:50:55.806 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@282ca3bf.
2021-06-10 23:50:55.806 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2021-06-10 23:50:55.806 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2021-06-10 23:50:55.806 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:55.806 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:50:55.831 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 AF 00 00 0D 49 
2021-06-10 23:50:55.833 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=175, payload=AF 00 00 0D 
2021-06-10 23:50:55.834 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=175, payload=AF 00 00 0D 
2021-06-10 23:50:55.834 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30693: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 175
2021-06-10 23:50:55.834 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-06-10 23:50:55.834 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 30693: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 175
2021-06-10 23:50:55.834 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 30693: (Callback 175)
2021-06-10 23:50:55.834 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2021-06-10 23:50:55.834 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 30693: callback 175
2021-06-10 23:50:55.834 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=175, payload=AF 00 00 0D 
2021-06-10 23:50:55.834 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:55.835 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 30693: Transaction COMPLETED
2021-06-10 23:50:55.835 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Response processed after 148ms
2021-06-10 23:50:55.835 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: TID 30693: Transaction completed
2021-06-10 23:50:55.835 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: notifyTransactionResponse TID:30693 DONE
2021-06-10 23:50:55.835 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2021-06-10 23:50:55.835 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:55.835 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:55.836 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 15: Sending REQUEST Message = 01 11 00 13 0F 0A 98 80 9F C9 5F 9E 44 84 FC 59 25 B0 87 
2021-06-10 23:50:55.836 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2021-06-10 23:50:55.836 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 30694: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 176
2021-06-10 23:50:55.837 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2021-06-10 23:50:55.837 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-06-10 23:50:55.838 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-06-10 23:50:55.838 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30694: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 176
2021-06-10 23:50:55.838 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2021-06-10 23:50:55.838 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:55.838 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:50:55.847 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2021-06-10 23:50:55.849 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:55.850 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:55.850 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30694: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 176
2021-06-10 23:50:55.850 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-06-10 23:50:55.850 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 30694: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 176
2021-06-10 23:50:55.850 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:55.850 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 30694: Advanced to WAIT_REQUEST
2021-06-10 23:50:55.850 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: TID 30694: Transaction not completed
2021-06-10 23:50:55.850 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:55.850 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:50:55.864 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 B0 00 00 02 59 
2021-06-10 23:50:55.867 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=176, payload=B0 00 00 02 
2021-06-10 23:50:55.868 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=176, payload=B0 00 00 02 
2021-06-10 23:50:55.868 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30694: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 176
2021-06-10 23:50:55.868 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-06-10 23:50:55.868 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 30694: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 176
2021-06-10 23:50:55.868 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 30694: (Callback 176)
2021-06-10 23:50:55.868 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2021-06-10 23:50:55.868 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 30694: callback 176
2021-06-10 23:50:55.868 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=176, payload=B0 00 00 02 
2021-06-10 23:50:55.869 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:55.869 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 30694: Transaction COMPLETED
2021-06-10 23:50:55.869 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Response processed after 33ms
2021-06-10 23:50:55.869 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: TID 30694: Transaction completed
2021-06-10 23:50:55.869 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: notifyTransactionResponse TID:30694 DONE
2021-06-10 23:50:55.869 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 15: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2021-06-10 23:50:55.869 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:55.869 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:55.931 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 2C 00 04 00 02 26 98 81 73 0B 89 56 26 1C 51 54 C7 D4 B1 53 3F 83 38 0E 9C 3D 0F 28 6E 4A 1D 35 5A 26 80 88 5F 67 A3 93 77 4E B8 1C 62 
2021-06-10 23:50:55.934 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 26 98 81 73 0B 89 56 26 1C 51 54 C7 D4 B1 53 3F 83 38 0E 9C 3D 0F 28 6E 4A 1D 35 5A 26 80 88 5F 67 A3 93 77 4E B8 1C 
2021-06-10 23:50:55.935 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 26 98 81 73 0B 89 56 26 1C 51 54 C7 D4 B1 53 3F 83 38 0E 9C 3D 0F 28 6E 4A 1D 35 5A 26 80 88 5F 67 A3 93 77 4E B8 1C 
2021-06-10 23:50:55.935 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2021-06-10 23:50:55.935 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Application Command Request (ALIVE:DONE)
2021-06-10 23:50:55.935 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:55.935 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Decapsulating COMMAND_CLASS_SECURITY
2021-06-10 23:50:55.935 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 2: SECURITY_RXD 60 0D 04 01 32 02 21 24 00 00 1C 32 00 00 00 00 00 00 
2021-06-10 23:50:55.935 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2021-06-10 23:50:55.935 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Incoming command class COMMAND_CLASS_METER, endpoint 4
2021-06-10 23:50:55.936 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 2: Received COMMAND_CLASS_METER V0 METER_REPORT
2021-06-10 23:50:55.936 [DEBUG] [.commandclass.ZWaveMeterCommandClass] - NODE 2: Meter: Type=Electric(1), Scale=kWh(0), Value=721.8
2021-06-10 23:50:55.936 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveMeterValueEvent
2021-06-10 23:50:55.936 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got a value event from Z-Wave network, endpoint=4, command class=COMMAND_CLASS_METER, value=721.8
2021-06-10 23:50:55.936 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Updating channel state zwave:device:8f57dbad:node2:meter_kwh4 to 721.8 [DecimalType]
2021-06-10 23:50:55.936 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Commands processed 1.
2021-06-10 23:50:55.936 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@290bcac8.
2021-06-10 23:50:55.936 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:55.936 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:55.936 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:55.937 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:55.992 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 08 00 04 00 02 02 98 40 2B 
2021-06-10 23:50:55.994 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 02 98 40 
2021-06-10 23:50:55.994 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 02 98 40 
2021-06-10 23:50:55.994 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2021-06-10 23:50:55.994 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Application Command Request (ALIVE:DONE)
2021-06-10 23:50:55.994 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:55.994 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Incoming command class COMMAND_CLASS_SECURITY, endpoint 0
2021-06-10 23:50:55.995 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY check internal
2021-06-10 23:50:55.995 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 2: Received COMMAND_CLASS_SECURITY V1 SECURITY_NONCE_GET
2021-06-10 23:50:55.995 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Added to secure queue - size 1
2021-06-10 23:50:55.995 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Commands processed 1.
2021-06-10 23:50:55.995 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@3c32e428.
2021-06-10 23:50:55.995 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:55.995 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:55.995 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:55.995 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:55.996 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 2: Sending REQUEST Message = 01 11 00 13 02 0A 98 80 54 C6 16 24 23 EC AA 01 25 B1 BD 
2021-06-10 23:50:55.997 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2021-06-10 23:50:55.997 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 30695: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 177
2021-06-10 23:50:55.998 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2021-06-10 23:50:55.998 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-06-10 23:50:55.999 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-06-10 23:50:55.999 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30695: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 177
2021-06-10 23:50:55.999 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2021-06-10 23:50:55.999 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:55.999 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:50:56.007 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2021-06-10 23:50:56.010 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:56.010 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:56.010 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30695: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 177
2021-06-10 23:50:56.010 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-06-10 23:50:56.010 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 30695: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 177
2021-06-10 23:50:56.010 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:56.011 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 30695: Advanced to WAIT_REQUEST
2021-06-10 23:50:56.011 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: TID 30695: Transaction not completed
2021-06-10 23:50:56.011 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:56.011 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:50:56.070 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 23 00 04 00 0F 1D 98 81 19 E4 31 93 EB CE 0B 27 F5 66 BC 03 2B BC 38 09 F2 FA 9F 3D E2 E2 E2 7E BF D3 30 65 
2021-06-10 23:50:56.073 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 1D 98 81 19 E4 31 93 EB CE 0B 27 F5 66 BC 03 2B BC 38 09 F2 FA 9F 3D E2 E2 E2 7E BF D3 30 
2021-06-10 23:50:56.074 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 1D 98 81 19 E4 31 93 EB CE 0B 27 F5 66 BC 03 2B BC 38 09 F2 FA 9F 3D E2 E2 E2 7E BF D3 30 
2021-06-10 23:50:56.074 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30695: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 177
2021-06-10 23:50:56.074 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Application Command Request (ALIVE:DONE)
2021-06-10 23:50:56.074 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:56.074 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: Decapsulating COMMAND_CLASS_SECURITY
2021-06-10 23:50:56.074 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 15: SECURITY_RXD 60 0D 00 01 5B 03 31 80 01 
2021-06-10 23:50:56.074 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2021-06-10 23:50:56.074 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: Incoming command class COMMAND_CLASS_CENTRAL_SCENE, endpoint 0
2021-06-10 23:50:56.074 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 15: Received COMMAND_CLASS_CENTRAL_SCENE V3 CENTRAL_SCENE_NOTIFICATION
2021-06-10 23:50:56.075 [DEBUG] [dclass.ZWaveCentralSceneCommandClass] - NODE 15: Received scene 1 at key 0 [Single Press]
2021-06-10 23:50:56.075 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 15: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2021-06-10 23:50:56.075 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 15: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_CENTRAL_SCENE, value=1.0
2021-06-10 23:50:56.075 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 15: Updating channel state zwave:device:8f57dbad:node15:scene_number to 1.0 [DecimalType]
2021-06-10 23:50:56.076 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Commands processed 1.
2021-06-10 23:50:56.076 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@7ff4a274.
2021-06-10 23:50:56.076 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2021-06-10 23:50:56.076 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2021-06-10 23:50:56.076 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:56.076 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:50:56.170 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 B1 00 00 10 4A 
2021-06-10 23:50:56.171 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=177, payload=B1 00 00 10 
2021-06-10 23:50:56.171 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=177, payload=B1 00 00 10 
2021-06-10 23:50:56.171 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30695: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 177
2021-06-10 23:50:56.171 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-06-10 23:50:56.171 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 30695: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 177
2021-06-10 23:50:56.171 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 30695: (Callback 177)
2021-06-10 23:50:56.172 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2021-06-10 23:50:56.172 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 30695: callback 177
2021-06-10 23:50:56.172 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=177, payload=B1 00 00 10 
2021-06-10 23:50:56.172 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:56.172 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 30695: Transaction COMPLETED
2021-06-10 23:50:56.172 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Response processed after 175ms
2021-06-10 23:50:56.172 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: TID 30695: Transaction completed
2021-06-10 23:50:56.172 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: notifyTransactionResponse TID:30695 DONE
2021-06-10 23:50:56.173 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2021-06-10 23:50:56.173 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:56.173 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:56.198 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 23 00 04 00 0F 1D 98 81 19 E4 31 93 EB CE 0B 27 F5 66 BC 03 2B BC 38 09 F2 FA 9F 3D E2 E2 E2 7E BF D3 30 65 
2021-06-10 23:50:56.199 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 1D 98 81 19 E4 31 93 EB CE 0B 27 F5 66 BC 03 2B BC 38 09 F2 FA 9F 3D E2 E2 E2 7E BF D3 30 
2021-06-10 23:50:56.199 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 1D 98 81 19 E4 31 93 EB CE 0B 27 F5 66 BC 03 2B BC 38 09 F2 FA 9F 3D E2 E2 E2 7E BF D3 30 
2021-06-10 23:50:56.199 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2021-06-10 23:50:56.199 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Application Command Request (ALIVE:DONE)
2021-06-10 23:50:56.199 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:56.200 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: Decapsulating COMMAND_CLASS_SECURITY
2021-06-10 23:50:56.200 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 15: SECURITY_ERR No valid NONCE! null
2021-06-10 23:50:56.200 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:56.200 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:56.270 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 2C 00 04 00 02 26 98 81 F2 B9 1F 96 55 B5 FA 3F FD B9 C4 2B CB 06 3D 0B 00 58 99 BF 25 B8 09 F5 65 BE F0 54 44 48 8B E1 A2 6A D1 6E 2C 
2021-06-10 23:50:56.274 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 26 98 81 F2 B9 1F 96 55 B5 FA 3F FD B9 C4 2B CB 06 3D 0B 00 58 99 BF 25 B8 09 F5 65 BE F0 54 44 48 8B E1 A2 6A D1 6E 
2021-06-10 23:50:56.275 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 26 98 81 F2 B9 1F 96 55 B5 FA 3F FD B9 C4 2B CB 06 3D 0B 00 58 99 BF 25 B8 09 F5 65 BE F0 54 44 48 8B E1 A2 6A D1 6E 
2021-06-10 23:50:56.275 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2021-06-10 23:50:56.275 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Application Command Request (ALIVE:DONE)
2021-06-10 23:50:56.275 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:56.275 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Decapsulating COMMAND_CLASS_SECURITY
2021-06-10 23:50:56.275 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 2: SECURITY_RXD 60 0D 04 01 32 02 21 54 00 00 00 00 00 00 00 00 00 00 
2021-06-10 23:50:56.275 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2021-06-10 23:50:56.275 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Incoming command class COMMAND_CLASS_METER, endpoint 4
2021-06-10 23:50:56.275 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 2: Received COMMAND_CLASS_METER V0 METER_REPORT
2021-06-10 23:50:56.276 [DEBUG] [.commandclass.ZWaveMeterCommandClass] - NODE 2: Meter: Type=Electric(1), Scale=W(2), Value=0E+1
2021-06-10 23:50:56.276 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveMeterValueEvent
2021-06-10 23:50:56.276 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got a value event from Z-Wave network, endpoint=4, command class=COMMAND_CLASS_METER, value=0E+1
2021-06-10 23:50:56.276 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Updating channel state zwave:device:8f57dbad:node2:meter_watts4 to 0 [DecimalType]
2021-06-10 23:50:56.277 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Commands processed 1.
2021-06-10 23:50:56.278 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@3208d76e.
2021-06-10 23:50:56.278 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:56.278 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:56.278 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:56.278 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:56.324 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 08 00 04 00 02 02 98 40 2B 
2021-06-10 23:50:56.325 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 02 98 40 
2021-06-10 23:50:56.326 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 02 98 40 
2021-06-10 23:50:56.326 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2021-06-10 23:50:56.326 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Application Command Request (ALIVE:DONE)
2021-06-10 23:50:56.326 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:56.326 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Incoming command class COMMAND_CLASS_SECURITY, endpoint 0
2021-06-10 23:50:56.326 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY check internal
2021-06-10 23:50:56.326 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 2: Received COMMAND_CLASS_SECURITY V1 SECURITY_NONCE_GET
2021-06-10 23:50:56.326 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Added to secure queue - size 1
2021-06-10 23:50:56.326 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Commands processed 1.
2021-06-10 23:50:56.327 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@4522066d.
2021-06-10 23:50:56.327 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:56.327 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:56.327 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:56.327 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:56.327 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 2: Sending REQUEST Message = 01 11 00 13 02 0A 98 80 6E 0C 7D 7D E5 B8 A2 1B 25 B2 FC 
2021-06-10 23:50:56.330 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2021-06-10 23:50:56.330 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 30696: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 178
2021-06-10 23:50:56.331 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2021-06-10 23:50:56.331 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-06-10 23:50:56.332 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-06-10 23:50:56.332 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30696: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 178
2021-06-10 23:50:56.332 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2021-06-10 23:50:56.332 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:56.332 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:50:56.345 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2021-06-10 23:50:56.347 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:56.347 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:56.347 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30696: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 178
2021-06-10 23:50:56.347 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-06-10 23:50:56.347 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 30696: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 178
2021-06-10 23:50:56.347 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:56.347 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 30696: Advanced to WAIT_REQUEST
2021-06-10 23:50:56.348 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: TID 30696: Transaction not completed
2021-06-10 23:50:56.348 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:56.348 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:50:56.489 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 B2 00 00 0F 56 
2021-06-10 23:50:56.491 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=178, payload=B2 00 00 0F 
2021-06-10 23:50:56.491 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=178, payload=B2 00 00 0F 
2021-06-10 23:50:56.491 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30696: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 178
2021-06-10 23:50:56.491 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-06-10 23:50:56.491 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 30696: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 178
2021-06-10 23:50:56.491 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 30696: (Callback 178)
2021-06-10 23:50:56.491 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2021-06-10 23:50:56.491 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 30696: callback 178
2021-06-10 23:50:56.492 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=178, payload=B2 00 00 0F 
2021-06-10 23:50:56.492 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:56.492 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 30696: Transaction COMPLETED
2021-06-10 23:50:56.492 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Response processed after 162ms
2021-06-10 23:50:56.492 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: TID 30696: Transaction completed
2021-06-10 23:50:56.492 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: notifyTransactionResponse TID:30696 DONE
2021-06-10 23:50:56.492 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2021-06-10 23:50:56.492 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:56.492 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:56.581 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 28 00 04 00 02 22 98 81 F4 53 D4 5D 41 66 CD 2E 43 77 C2 BC 03 09 16 F8 69 47 EB 9F C5 03 A9 6E E9 D7 92 46 44 6E 67 B1 E3 
2021-06-10 23:50:56.583 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 22 98 81 F4 53 D4 5D 41 66 CD 2E 43 77 C2 BC 03 09 16 F8 69 47 EB 9F C5 03 A9 6E E9 D7 92 46 44 6E 67 B1 
2021-06-10 23:50:56.583 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 22 98 81 F4 53 D4 5D 41 66 CD 2E 43 77 C2 BC 03 09 16 F8 69 47 EB 9F C5 03 A9 6E E9 D7 92 46 44 6E 67 B1 
2021-06-10 23:50:56.583 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2021-06-10 23:50:56.583 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Application Command Request (ALIVE:DONE)
2021-06-10 23:50:56.583 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:56.583 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Decapsulating COMMAND_CLASS_SECURITY
2021-06-10 23:50:56.583 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 2: SECURITY_RXD 60 0D 04 01 32 02 A1 22 09 4B 00 00 00 00 
2021-06-10 23:50:56.584 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2021-06-10 23:50:56.584 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Incoming command class COMMAND_CLASS_METER, endpoint 4
2021-06-10 23:50:56.584 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 2: Received COMMAND_CLASS_METER V0 METER_REPORT
2021-06-10 23:50:56.584 [DEBUG] [.commandclass.ZWaveMeterCommandClass] - NODE 2: Meter: Type=Electric(1), Scale=kWh(0), Value=237.9
2021-06-10 23:50:56.584 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveMeterValueEvent
2021-06-10 23:50:56.584 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got a value event from Z-Wave network, endpoint=4, command class=COMMAND_CLASS_METER, value=237.9
2021-06-10 23:50:56.584 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Updating channel state zwave:device:8f57dbad:node2:meter_kwh4 to 237.9 [DecimalType]
2021-06-10 23:50:56.584 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Commands processed 1.
2021-06-10 23:50:56.584 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@6e9ab945.
2021-06-10 23:50:56.584 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:56.585 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:56.585 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:56.585 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:56.645 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 08 00 04 00 02 02 98 40 2B 
2021-06-10 23:50:56.647 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 02 98 40 
2021-06-10 23:50:56.647 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 02 98 40 
2021-06-10 23:50:56.647 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2021-06-10 23:50:56.647 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Application Command Request (ALIVE:DONE)
2021-06-10 23:50:56.647 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:56.647 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Incoming command class COMMAND_CLASS_SECURITY, endpoint 0
2021-06-10 23:50:56.648 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY check internal
2021-06-10 23:50:56.648 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 2: Received COMMAND_CLASS_SECURITY V1 SECURITY_NONCE_GET
2021-06-10 23:50:56.648 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Added to secure queue - size 1
2021-06-10 23:50:56.648 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Commands processed 1.
2021-06-10 23:50:56.648 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@342741e0.
2021-06-10 23:50:56.648 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:56.648 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:56.648 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:56.648 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:56.649 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 2: Sending REQUEST Message = 01 11 00 13 02 0A 98 80 8B 0A CC 4F 8A 0C 3F 65 25 B3 A5 
2021-06-10 23:50:56.649 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2021-06-10 23:50:56.649 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 30697: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 179
2021-06-10 23:50:56.651 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2021-06-10 23:50:56.651 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-06-10 23:50:56.651 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-06-10 23:50:56.651 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30697: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 179
2021-06-10 23:50:56.651 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2021-06-10 23:50:56.651 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:56.651 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:50:56.660 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2021-06-10 23:50:56.663 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:56.663 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:56.663 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30697: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 179
2021-06-10 23:50:56.663 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-06-10 23:50:56.663 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 30697: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 179
2021-06-10 23:50:56.664 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:56.664 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 30697: Advanced to WAIT_REQUEST
2021-06-10 23:50:56.664 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: TID 30697: Transaction not completed
2021-06-10 23:50:56.664 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:56.664 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:50:56.785 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 B3 00 00 0D 55 
2021-06-10 23:50:56.787 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=179, payload=B3 00 00 0D 
2021-06-10 23:50:56.787 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=179, payload=B3 00 00 0D 
2021-06-10 23:50:56.787 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30697: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 179
2021-06-10 23:50:56.787 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-06-10 23:50:56.787 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 30697: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 179
2021-06-10 23:50:56.788 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 30697: (Callback 179)
2021-06-10 23:50:56.788 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2021-06-10 23:50:56.788 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 30697: callback 179
2021-06-10 23:50:56.788 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=179, payload=B3 00 00 0D 
2021-06-10 23:50:56.788 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:56.788 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 30697: Transaction COMPLETED
2021-06-10 23:50:56.788 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Response processed after 139ms
2021-06-10 23:50:56.788 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: TID 30697: Transaction completed
2021-06-10 23:50:56.789 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: notifyTransactionResponse TID:30697 DONE
2021-06-10 23:50:56.789 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2021-06-10 23:50:56.789 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:56.789 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:56.879 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 24 00 04 00 02 1E 98 81 FA DB 03 36 57 9D 7C 25 03 6B 4C EA FE 6D 4B 03 3F 71 94 8B 1A 42 9D D6 05 ED DC 82 BC 
2021-06-10 23:50:56.882 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 1E 98 81 FA DB 03 36 57 9D 7C 25 03 6B 4C EA FE 6D 4B 03 3F 71 94 8B 1A 42 9D D6 05 ED DC 82 
2021-06-10 23:50:56.882 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 1E 98 81 FA DB 03 36 57 9D 7C 25 03 6B 4C EA FE 6D 4B 03 3F 71 94 8B 1A 42 9D D6 05 ED DC 82 
2021-06-10 23:50:56.883 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2021-06-10 23:50:56.883 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Application Command Request (ALIVE:DONE)
2021-06-10 23:50:56.883 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:56.883 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Decapsulating COMMAND_CLASS_SECURITY
2021-06-10 23:50:56.883 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 2: SECURITY_RXD 60 0D 02 01 31 05 01 22 00 00 
2021-06-10 23:50:56.883 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2021-06-10 23:50:56.883 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Incoming command class COMMAND_CLASS_SENSOR_MULTILEVEL, endpoint 2
2021-06-10 23:50:56.883 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 2: Received COMMAND_CLASS_SENSOR_MULTILEVEL V0 SENSOR_MULTILEVEL_REPORT
2021-06-10 23:50:56.883 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 2: Sensor Type = Temperature(1), Scale = 0
2021-06-10 23:50:56.883 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 2: Sensor Value = 0E+1
2021-06-10 23:50:56.883 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveMultiLevelSensorValueEvent
2021-06-10 23:50:56.884 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got a value event from Z-Wave network, endpoint=2, command class=COMMAND_CLASS_SENSOR_MULTILEVEL, value=0E+1
2021-06-10 23:50:56.884 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Updating channel state zwave:device:8f57dbad:node2:sensor_temperature2 to 0E+1 °C [QuantityType]
2021-06-10 23:50:56.884 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Commands processed 1.
2021-06-10 23:50:56.884 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@40e043ad.
2021-06-10 23:50:56.884 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:56.884 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:56.884 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:56.884 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:56.940 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 08 00 04 00 02 02 98 40 2B 
2021-06-10 23:50:56.943 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 02 98 40 
2021-06-10 23:50:56.943 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 02 98 40 
2021-06-10 23:50:56.943 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2021-06-10 23:50:56.943 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Application Command Request (ALIVE:DONE)
2021-06-10 23:50:56.943 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:56.944 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Incoming command class COMMAND_CLASS_SECURITY, endpoint 0
2021-06-10 23:50:56.944 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY check internal
2021-06-10 23:50:56.944 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 2: Received COMMAND_CLASS_SECURITY V1 SECURITY_NONCE_GET
2021-06-10 23:50:56.944 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Added to secure queue - size 1
2021-06-10 23:50:56.944 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Commands processed 1.
2021-06-10 23:50:56.944 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@15a424b2.
2021-06-10 23:50:56.944 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:56.944 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:56.944 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:56.945 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:56.945 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 2: Sending REQUEST Message = 01 11 00 13 02 0A 98 80 79 5E 79 4C B4 A5 B4 DD 25 B4 16 
2021-06-10 23:50:56.945 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2021-06-10 23:50:56.946 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 30698: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 180
2021-06-10 23:50:56.947 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2021-06-10 23:50:56.947 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-06-10 23:50:56.947 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-06-10 23:50:56.947 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30698: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 180
2021-06-10 23:50:56.947 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2021-06-10 23:50:56.947 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:56.947 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:50:56.955 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2021-06-10 23:50:56.958 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:56.959 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:56.959 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30698: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 180
2021-06-10 23:50:56.959 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-06-10 23:50:56.959 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 30698: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 180
2021-06-10 23:50:56.959 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:56.959 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 30698: Advanced to WAIT_REQUEST
2021-06-10 23:50:56.959 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: TID 30698: Transaction not completed
2021-06-10 23:50:56.960 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:56.960 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:50:57.096 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 B4 00 00 0E 51 
2021-06-10 23:50:57.099 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=180, payload=B4 00 00 0E 
2021-06-10 23:50:57.100 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=180, payload=B4 00 00 0E 
2021-06-10 23:50:57.100 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30698: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 180
2021-06-10 23:50:57.100 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-06-10 23:50:57.100 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 30698: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 180
2021-06-10 23:50:57.100 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 30698: (Callback 180)
2021-06-10 23:50:57.100 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2021-06-10 23:50:57.100 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 30698: callback 180
2021-06-10 23:50:57.100 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=180, payload=B4 00 00 0E 
2021-06-10 23:50:57.100 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:57.101 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 30698: Transaction COMPLETED
2021-06-10 23:50:57.101 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Response processed after 155ms
2021-06-10 23:50:57.101 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: TID 30698: Transaction completed
2021-06-10 23:50:57.101 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: notifyTransactionResponse TID:30698 DONE
2021-06-10 23:50:57.101 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2021-06-10 23:50:57.101 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:57.101 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:57.193 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 24 00 04 00 02 1E 98 81 2F C5 F8 91 E7 B0 B7 C6 4F 45 D6 20 7D B5 2B B2 7D C9 CC 79 A4 28 47 12 4B B6 E6 45 54 
2021-06-10 23:50:57.195 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 1E 98 81 2F C5 F8 91 E7 B0 B7 C6 4F 45 D6 20 7D B5 2B B2 7D C9 CC 79 A4 28 47 12 4B B6 E6 45 
2021-06-10 23:50:57.196 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 1E 98 81 2F C5 F8 91 E7 B0 B7 C6 4F 45 D6 20 7D B5 2B B2 7D C9 CC 79 A4 28 47 12 4B B6 E6 45 
2021-06-10 23:50:57.196 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2021-06-10 23:50:57.196 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Application Command Request (ALIVE:DONE)
2021-06-10 23:50:57.196 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:57.196 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Decapsulating COMMAND_CLASS_SECURITY
2021-06-10 23:50:57.196 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 2: SECURITY_RXD 60 0D 02 01 31 05 01 22 00 00 
2021-06-10 23:50:57.196 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2021-06-10 23:50:57.196 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Incoming command class COMMAND_CLASS_SENSOR_MULTILEVEL, endpoint 2
2021-06-10 23:50:57.196 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 2: Received COMMAND_CLASS_SENSOR_MULTILEVEL V0 SENSOR_MULTILEVEL_REPORT
2021-06-10 23:50:57.196 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 2: Sensor Type = Temperature(1), Scale = 0
2021-06-10 23:50:57.197 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 2: Sensor Value = 0E+1
2021-06-10 23:50:57.197 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveMultiLevelSensorValueEvent
2021-06-10 23:50:57.197 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got a value event from Z-Wave network, endpoint=2, command class=COMMAND_CLASS_SENSOR_MULTILEVEL, value=0E+1
2021-06-10 23:50:57.197 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Updating channel state zwave:device:8f57dbad:node2:sensor_temperature2 to 0E+1 °C [QuantityType]
2021-06-10 23:50:57.197 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Commands processed 1.
2021-06-10 23:50:57.197 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@2ecff7d2.
2021-06-10 23:50:57.197 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:57.197 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:57.197 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:57.198 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:57.250 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 08 00 04 00 02 02 98 40 2B 
2021-06-10 23:50:57.253 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 02 98 40 
2021-06-10 23:50:57.253 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 02 98 40 
2021-06-10 23:50:57.253 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2021-06-10 23:50:57.253 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Application Command Request (ALIVE:DONE)
2021-06-10 23:50:57.254 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:57.254 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Incoming command class COMMAND_CLASS_SECURITY, endpoint 0
2021-06-10 23:50:57.254 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY check internal
2021-06-10 23:50:57.254 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 2: Received COMMAND_CLASS_SECURITY V1 SECURITY_NONCE_GET
2021-06-10 23:50:57.254 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Added to secure queue - size 1
2021-06-10 23:50:57.254 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Commands processed 1.
2021-06-10 23:50:57.254 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@20698baa.
2021-06-10 23:50:57.254 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:57.254 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:57.255 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:57.255 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:57.255 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 2: Sending REQUEST Message = 01 11 00 13 02 0A 98 80 3E E3 E2 1B C1 45 F1 58 25 B5 74 
2021-06-10 23:50:57.257 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2021-06-10 23:50:57.258 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 30699: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 181
2021-06-10 23:50:57.259 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2021-06-10 23:50:57.260 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-06-10 23:50:57.260 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-06-10 23:50:57.260 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30699: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 181
2021-06-10 23:50:57.260 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2021-06-10 23:50:57.260 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:57.260 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:50:57.271 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2021-06-10 23:50:57.274 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:57.274 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:57.274 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30699: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 181
2021-06-10 23:50:57.274 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-06-10 23:50:57.274 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 30699: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 181
2021-06-10 23:50:57.274 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:57.275 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 30699: Advanced to WAIT_REQUEST
2021-06-10 23:50:57.275 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: TID 30699: Transaction not completed
2021-06-10 23:50:57.275 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:57.275 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:50:57.398 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 08 00 04 00 0F 02 98 40 26 
2021-06-10 23:50:57.402 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 02 98 40 
2021-06-10 23:50:57.402 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 02 98 40 
2021-06-10 23:50:57.402 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30699: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 181
2021-06-10 23:50:57.402 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Application Command Request (ALIVE:DONE)
2021-06-10 23:50:57.402 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:57.403 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: Incoming command class COMMAND_CLASS_SECURITY, endpoint 0
2021-06-10 23:50:57.403 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: SECURITY check internal
2021-06-10 23:50:57.403 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 15: Received COMMAND_CLASS_SECURITY V1 SECURITY_NONCE_GET
2021-06-10 23:50:57.403 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Added to secure queue - size 1
2021-06-10 23:50:57.403 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Commands processed 1.
2021-06-10 23:50:57.403 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@62565921.
2021-06-10 23:50:57.403 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2021-06-10 23:50:57.403 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2021-06-10 23:50:57.404 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:57.404 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:50:57.414 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 B5 00 00 0E 50 
2021-06-10 23:50:57.416 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=181, payload=B5 00 00 0E 
2021-06-10 23:50:57.416 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=181, payload=B5 00 00 0E 
2021-06-10 23:50:57.417 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30699: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 181
2021-06-10 23:50:57.417 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-06-10 23:50:57.417 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 30699: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 181
2021-06-10 23:50:57.417 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 30699: (Callback 181)
2021-06-10 23:50:57.417 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2021-06-10 23:50:57.417 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 30699: callback 181
2021-06-10 23:50:57.417 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=181, payload=B5 00 00 0E 
2021-06-10 23:50:57.417 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:57.417 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 30699: Transaction COMPLETED
2021-06-10 23:50:57.418 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Response processed after 161ms
2021-06-10 23:50:57.418 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: TID 30699: Transaction completed
2021-06-10 23:50:57.418 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: notifyTransactionResponse TID:30699 DONE
2021-06-10 23:50:57.418 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2021-06-10 23:50:57.418 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:57.418 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:57.418 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 15: Sending REQUEST Message = 01 11 00 13 0F 0A 98 80 84 34 8A F0 C6 70 66 BA 25 B6 D3 
2021-06-10 23:50:57.419 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2021-06-10 23:50:57.419 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 30700: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 182
2021-06-10 23:50:57.420 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2021-06-10 23:50:57.420 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-06-10 23:50:57.420 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-06-10 23:50:57.420 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30700: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 182
2021-06-10 23:50:57.420 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2021-06-10 23:50:57.421 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:57.421 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:50:57.436 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2021-06-10 23:50:57.438 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:57.438 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:57.438 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30700: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 182
2021-06-10 23:50:57.438 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-06-10 23:50:57.439 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 30700: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 182
2021-06-10 23:50:57.439 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:57.439 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 30700: Advanced to WAIT_REQUEST
2021-06-10 23:50:57.439 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: TID 30700: Transaction not completed
2021-06-10 23:50:57.439 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:57.439 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:50:57.557 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 24 00 04 00 02 1E 98 81 34 42 F4 73 43 DB CF 7F 3D 33 9C D9 78 A0 6E 73 76 CC F6 3E E2 48 1A A0 41 11 C7 E3 9B 
2021-06-10 23:50:57.559 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 1E 98 81 34 42 F4 73 43 DB CF 7F 3D 33 9C D9 78 A0 6E 73 76 CC F6 3E E2 48 1A A0 41 11 C7 E3 
2021-06-10 23:50:57.559 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 1E 98 81 34 42 F4 73 43 DB CF 7F 3D 33 9C D9 78 A0 6E 73 76 CC F6 3E E2 48 1A A0 41 11 C7 E3 
2021-06-10 23:50:57.559 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30700: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 182
2021-06-10 23:50:57.559 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Application Command Request (ALIVE:DONE)
2021-06-10 23:50:57.560 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:57.560 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Decapsulating COMMAND_CLASS_SECURITY
2021-06-10 23:50:57.560 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 2: SECURITY_RXD 60 0D 03 01 31 05 01 22 01 0E 
2021-06-10 23:50:57.560 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2021-06-10 23:50:57.560 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Incoming command class COMMAND_CLASS_SENSOR_MULTILEVEL, endpoint 3
2021-06-10 23:50:57.560 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 2: Received COMMAND_CLASS_SENSOR_MULTILEVEL V0 SENSOR_MULTILEVEL_REPORT
2021-06-10 23:50:57.560 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 2: Sensor Type = Temperature(1), Scale = 0
2021-06-10 23:50:57.561 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 2: Sensor Value = 27
2021-06-10 23:50:57.561 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveMultiLevelSensorValueEvent
2021-06-10 23:50:57.561 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got a value event from Z-Wave network, endpoint=3, command class=COMMAND_CLASS_SENSOR_MULTILEVEL, value=27
2021-06-10 23:50:57.561 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Updating channel state zwave:device:8f57dbad:node2:sensor_temperature3 to 27 °C [QuantityType]
2021-06-10 23:50:57.561 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Commands processed 1.
2021-06-10 23:50:57.561 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@5663706d.
2021-06-10 23:50:57.562 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2021-06-10 23:50:57.562 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2021-06-10 23:50:57.562 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:57.562 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:50:57.577 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 21 00 04 00 0F 1B 98 81 5D D7 27 80 DA 3A F8 38 6E 0D 40 A9 61 14 53 A0 84 B5 C4 0A E3 41 51 D0 AD A7 
2021-06-10 23:50:57.577 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 1B 98 81 5D D7 27 80 DA 3A F8 38 6E 0D 40 A9 61 14 53 A0 84 B5 C4 0A E3 41 51 D0 AD 
2021-06-10 23:50:57.578 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 1B 98 81 5D D7 27 80 DA 3A F8 38 6E 0D 40 A9 61 14 53 A0 84 B5 C4 0A E3 41 51 D0 AD 
2021-06-10 23:50:57.578 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30700: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 182
2021-06-10 23:50:57.578 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Application Command Request (ALIVE:DONE)
2021-06-10 23:50:57.578 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:57.578 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: Decapsulating COMMAND_CLASS_SECURITY
2021-06-10 23:50:57.578 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 15: SECURITY_RXD 60 0D 01 01 25 03 00 
2021-06-10 23:50:57.578 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2021-06-10 23:50:57.578 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: Incoming command class COMMAND_CLASS_SWITCH_BINARY, endpoint 1
2021-06-10 23:50:57.578 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 15: Received COMMAND_CLASS_SWITCH_BINARY V0 SWITCH_BINARY_REPORT
2021-06-10 23:50:57.579 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - NODE 15: Switch Binary report, value = 0
2021-06-10 23:50:57.579 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 15: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2021-06-10 23:50:57.579 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 15: Got a value event from Z-Wave network, endpoint=1, command class=COMMAND_CLASS_SWITCH_BINARY, value=0
2021-06-10 23:50:57.579 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 15: Updating channel state zwave:device:8f57dbad:node15:switch_binary1 to OFF [OnOffType]
2021-06-10 23:50:57.584 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Commands processed 1.
2021-06-10 23:50:57.584 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@7c36c14.
2021-06-10 23:50:57.584 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2021-06-10 23:50:57.584 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2021-06-10 23:50:57.584 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:57.584 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:50:57.602 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 B6 00 00 10 4D 
2021-06-10 23:50:57.605 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=182, payload=B6 00 00 10 
2021-06-10 23:50:57.605 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=182, payload=B6 00 00 10 
2021-06-10 23:50:57.605 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30700: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 182
2021-06-10 23:50:57.605 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-06-10 23:50:57.605 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 30700: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 182
2021-06-10 23:50:57.606 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 30700: (Callback 182)
2021-06-10 23:50:57.606 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2021-06-10 23:50:57.606 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 30700: callback 182
2021-06-10 23:50:57.606 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=182, payload=B6 00 00 10 
2021-06-10 23:50:57.606 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:57.606 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 30700: Transaction COMPLETED
2021-06-10 23:50:57.606 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Response processed after 187ms
2021-06-10 23:50:57.606 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: TID 30700: Transaction completed
2021-06-10 23:50:57.606 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: notifyTransactionResponse TID:30700 DONE
2021-06-10 23:50:57.607 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 15: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2021-06-10 23:50:57.607 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:57.607 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:57.655 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 08 00 04 00 02 02 98 40 2B 
2021-06-10 23:50:57.657 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 02 98 40 
2021-06-10 23:50:57.657 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 02 98 40 
2021-06-10 23:50:57.657 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2021-06-10 23:50:57.657 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Application Command Request (ALIVE:DONE)
2021-06-10 23:50:57.657 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:57.657 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Incoming command class COMMAND_CLASS_SECURITY, endpoint 0
2021-06-10 23:50:57.657 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY check internal
2021-06-10 23:50:57.657 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 2: Received COMMAND_CLASS_SECURITY V1 SECURITY_NONCE_GET
2021-06-10 23:50:57.657 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Added to secure queue - size 1
2021-06-10 23:50:57.658 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Commands processed 1.
2021-06-10 23:50:57.658 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@6b9b939d.
2021-06-10 23:50:57.658 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:57.658 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:57.658 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:57.658 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:57.658 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 2: Sending REQUEST Message = 01 11 00 13 02 0A 98 80 C1 9F D6 8F 02 D2 66 14 25 B7 DA 
2021-06-10 23:50:57.660 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2021-06-10 23:50:57.661 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 30701: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 183
2021-06-10 23:50:57.662 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2021-06-10 23:50:57.662 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-06-10 23:50:57.662 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-06-10 23:50:57.662 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30701: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 183
2021-06-10 23:50:57.662 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2021-06-10 23:50:57.662 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:57.662 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:50:57.670 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2021-06-10 23:50:57.672 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:57.673 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:57.673 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30701: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 183
2021-06-10 23:50:57.673 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-06-10 23:50:57.673 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 30701: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 183
2021-06-10 23:50:57.673 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:57.673 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 30701: Advanced to WAIT_REQUEST
2021-06-10 23:50:57.673 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: TID 30701: Transaction not completed
2021-06-10 23:50:57.673 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:57.673 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:50:57.812 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 B7 00 00 0E 52 
2021-06-10 23:50:57.815 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=183, payload=B7 00 00 0E 
2021-06-10 23:50:57.815 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=183, payload=B7 00 00 0E 
2021-06-10 23:50:57.815 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30701: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 183
2021-06-10 23:50:57.815 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-06-10 23:50:57.815 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 30701: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 183
2021-06-10 23:50:57.816 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 30701: (Callback 183)
2021-06-10 23:50:57.816 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2021-06-10 23:50:57.816 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 30701: callback 183
2021-06-10 23:50:57.816 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=183, payload=B7 00 00 0E 
2021-06-10 23:50:57.816 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:57.816 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 30701: Transaction COMPLETED
2021-06-10 23:50:57.816 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Response processed after 155ms
2021-06-10 23:50:57.816 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: TID 30701: Transaction completed
2021-06-10 23:50:57.816 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: notifyTransactionResponse TID:30701 DONE
2021-06-10 23:50:57.817 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2021-06-10 23:50:57.817 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:57.817 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:57.898 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 24 00 04 00 02 1E 98 81 66 84 88 86 F2 17 FF 62 C3 06 21 53 1A 06 FE BE 8D 79 F6 C1 07 CF 59 CA 5C 78 E7 27 D9 
2021-06-10 23:50:57.901 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 1E 98 81 66 84 88 86 F2 17 FF 62 C3 06 21 53 1A 06 FE BE 8D 79 F6 C1 07 CF 59 CA 5C 78 E7 27 
2021-06-10 23:50:57.901 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 1E 98 81 66 84 88 86 F2 17 FF 62 C3 06 21 53 1A 06 FE BE 8D 79 F6 C1 07 CF 59 CA 5C 78 E7 27 
2021-06-10 23:50:57.901 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2021-06-10 23:50:57.901 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Application Command Request (ALIVE:DONE)
2021-06-10 23:50:57.901 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:57.901 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Decapsulating COMMAND_CLASS_SECURITY
2021-06-10 23:50:57.901 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 2: SECURITY_RXD 60 0D 03 01 31 05 01 22 01 0E 
2021-06-10 23:50:57.901 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2021-06-10 23:50:57.901 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Incoming command class COMMAND_CLASS_SENSOR_MULTILEVEL, endpoint 3
2021-06-10 23:50:57.902 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 2: Received COMMAND_CLASS_SENSOR_MULTILEVEL V0 SENSOR_MULTILEVEL_REPORT
2021-06-10 23:50:57.902 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 2: Sensor Type = Temperature(1), Scale = 0
2021-06-10 23:50:57.902 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 2: Sensor Value = 27
2021-06-10 23:50:57.902 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveMultiLevelSensorValueEvent
2021-06-10 23:50:57.902 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got a value event from Z-Wave network, endpoint=3, command class=COMMAND_CLASS_SENSOR_MULTILEVEL, value=27
2021-06-10 23:50:57.902 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Updating channel state zwave:device:8f57dbad:node2:sensor_temperature3 to 27 °C [QuantityType]
2021-06-10 23:50:57.903 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Commands processed 1.
2021-06-10 23:50:57.903 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@3b54409e.
2021-06-10 23:50:57.903 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:57.903 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:57.903 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:57.903 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:59.188 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 08 00 04 00 0F 02 98 40 26 
2021-06-10 23:50:59.191 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 02 98 40 
2021-06-10 23:50:59.191 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 02 98 40 
2021-06-10 23:50:59.191 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2021-06-10 23:50:59.191 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Application Command Request (ALIVE:DONE)
2021-06-10 23:50:59.191 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:59.191 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: Incoming command class COMMAND_CLASS_SECURITY, endpoint 0
2021-06-10 23:50:59.191 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: SECURITY check internal
2021-06-10 23:50:59.192 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 15: Received COMMAND_CLASS_SECURITY V1 SECURITY_NONCE_GET
2021-06-10 23:50:59.192 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Added to secure queue - size 1
2021-06-10 23:50:59.192 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Commands processed 1.
2021-06-10 23:50:59.192 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@76f9af81.
2021-06-10 23:50:59.192 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:59.192 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:50:59.192 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:59.192 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:59.193 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 15: Sending REQUEST Message = 01 11 00 13 0F 0A 98 80 6A 33 45 45 F6 AE CE D0 25 B8 62 
2021-06-10 23:50:59.194 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2021-06-10 23:50:59.194 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 30702: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 184
2021-06-10 23:50:59.195 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2021-06-10 23:50:59.195 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-06-10 23:50:59.195 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-06-10 23:50:59.196 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30702: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 184
2021-06-10 23:50:59.196 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2021-06-10 23:50:59.196 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:59.196 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:50:59.205 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2021-06-10 23:50:59.207 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:59.207 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:59.207 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30702: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 184
2021-06-10 23:50:59.207 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-06-10 23:50:59.207 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 30702: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 184
2021-06-10 23:50:59.207 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:50:59.208 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 30702: Advanced to WAIT_REQUEST
2021-06-10 23:50:59.208 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: TID 30702: Transaction not completed
2021-06-10 23:50:59.208 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:59.208 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:50:59.317 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 B8 00 00 0C 5F 
2021-06-10 23:50:59.319 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=184, payload=B8 00 00 0C 
2021-06-10 23:50:59.319 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=184, payload=B8 00 00 0C 
2021-06-10 23:50:59.319 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30702: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 184
2021-06-10 23:50:59.319 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-06-10 23:50:59.319 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 30702: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 184
2021-06-10 23:50:59.319 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 30702: (Callback 184)
2021-06-10 23:50:59.320 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2021-06-10 23:50:59.320 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 30702: callback 184
2021-06-10 23:50:59.320 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=184, payload=B8 00 00 0C 
2021-06-10 23:50:59.320 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:59.320 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 30702: Transaction COMPLETED
2021-06-10 23:50:59.320 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Response processed after 126ms
2021-06-10 23:50:59.320 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: TID 30702: Transaction completed
2021-06-10 23:50:59.320 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: notifyTransactionResponse TID:30702 DONE
2021-06-10 23:50:59.321 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 15: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2021-06-10 23:50:59.321 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:59.321 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:50:59.415 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 23 00 04 00 0F 1D 98 81 6C 39 58 8B 38 94 20 A3 55 F5 9F C4 20 0D 73 D6 6C 83 84 5D 78 4F A2 63 12 EA 1E 2F 
2021-06-10 23:50:59.417 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 1D 98 81 6C 39 58 8B 38 94 20 A3 55 F5 9F C4 20 0D 73 D6 6C 83 84 5D 78 4F A2 63 12 EA 1E 
2021-06-10 23:50:59.418 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 1D 98 81 6C 39 58 8B 38 94 20 A3 55 F5 9F C4 20 0D 73 D6 6C 83 84 5D 78 4F A2 63 12 EA 1E 
2021-06-10 23:50:59.418 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2021-06-10 23:50:59.418 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Application Command Request (ALIVE:DONE)
2021-06-10 23:50:59.418 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: resetResendCount initComplete=true isDead=false
2021-06-10 23:50:59.418 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: Decapsulating COMMAND_CLASS_SECURITY
2021-06-10 23:50:59.418 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 15: SECURITY_ERR NONCE ID invalid! 132<>106
2021-06-10 23:50:59.418 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:50:59.418 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:51:00.543 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 08 00 04 00 0F 02 98 40 26 
2021-06-10 23:51:00.545 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 02 98 40 
2021-06-10 23:51:00.545 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 02 98 40 
2021-06-10 23:51:00.545 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2021-06-10 23:51:00.545 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Application Command Request (ALIVE:DONE)
2021-06-10 23:51:00.545 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: resetResendCount initComplete=true isDead=false
2021-06-10 23:51:00.545 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: Incoming command class COMMAND_CLASS_SECURITY, endpoint 0
2021-06-10 23:51:00.546 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: SECURITY check internal
2021-06-10 23:51:00.546 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 15: Received COMMAND_CLASS_SECURITY V1 SECURITY_NONCE_GET
2021-06-10 23:51:00.546 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Added to secure queue - size 1
2021-06-10 23:51:00.546 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Commands processed 1.
2021-06-10 23:51:00.546 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@6ac6de86.
2021-06-10 23:51:00.546 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:51:00.546 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:51:00.546 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:51:00.546 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:51:00.547 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 15: Sending REQUEST Message = 01 11 00 13 0F 0A 98 80 29 C7 2B B8 81 9E CB 42 25 B9 97 
2021-06-10 23:51:00.548 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2021-06-10 23:51:00.548 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 30703: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 185
2021-06-10 23:51:00.549 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2021-06-10 23:51:00.549 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-06-10 23:51:00.549 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-06-10 23:51:00.550 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30703: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 185
2021-06-10 23:51:00.550 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2021-06-10 23:51:00.550 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:51:00.550 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:51:00.558 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2021-06-10 23:51:00.561 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:51:00.561 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:51:00.562 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30703: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 185
2021-06-10 23:51:00.562 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-06-10 23:51:00.562 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 30703: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 185
2021-06-10 23:51:00.562 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:51:00.562 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 30703: Advanced to WAIT_REQUEST
2021-06-10 23:51:00.562 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: TID 30703: Transaction not completed
2021-06-10 23:51:00.562 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:51:00.562 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:51:00.577 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 B9 00 00 02 50 
2021-06-10 23:51:00.580 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=185, payload=B9 00 00 02 
2021-06-10 23:51:00.581 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=185, payload=B9 00 00 02 
2021-06-10 23:51:00.581 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30703: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 185
2021-06-10 23:51:00.581 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-06-10 23:51:00.581 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 30703: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 185
2021-06-10 23:51:00.581 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 30703: (Callback 185)
2021-06-10 23:51:00.581 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2021-06-10 23:51:00.581 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 30703: callback 185
2021-06-10 23:51:00.581 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=185, payload=B9 00 00 02 
2021-06-10 23:51:00.582 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: resetResendCount initComplete=true isDead=false
2021-06-10 23:51:00.582 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 30703: Transaction COMPLETED
2021-06-10 23:51:00.582 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Response processed after 34ms
2021-06-10 23:51:00.582 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: TID 30703: Transaction completed
2021-06-10 23:51:00.582 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: notifyTransactionResponse TID:30703 DONE
2021-06-10 23:51:00.582 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 15: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2021-06-10 23:51:00.582 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:51:00.582 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:51:00.655 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 21 00 04 00 0F 1B 98 81 EF 4C B3 48 50 38 FD 1E B2 A7 AD A5 85 E3 CB E2 6A AA 4E 84 54 D2 90 D2 FA 62 
2021-06-10 23:51:00.657 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 1B 98 81 EF 4C B3 48 50 38 FD 1E B2 A7 AD A5 85 E3 CB E2 6A AA 4E 84 54 D2 90 D2 FA 
2021-06-10 23:51:00.658 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 1B 98 81 EF 4C B3 48 50 38 FD 1E B2 A7 AD A5 85 E3 CB E2 6A AA 4E 84 54 D2 90 D2 FA 
2021-06-10 23:51:00.658 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2021-06-10 23:51:00.658 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Application Command Request (ALIVE:DONE)
2021-06-10 23:51:00.658 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: resetResendCount initComplete=true isDead=false
2021-06-10 23:51:00.658 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: Decapsulating COMMAND_CLASS_SECURITY
2021-06-10 23:51:00.658 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 15: SECURITY_ERR NONCE ID invalid! 106<>41
2021-06-10 23:51:00.658 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:51:00.658 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:51:03.826 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 08 00 04 00 0F 02 98 40 26 
2021-06-10 23:51:03.829 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 02 98 40 
2021-06-10 23:51:03.829 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 02 98 40 
2021-06-10 23:51:03.829 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2021-06-10 23:51:03.829 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Application Command Request (ALIVE:DONE)
2021-06-10 23:51:03.829 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: resetResendCount initComplete=true isDead=false
2021-06-10 23:51:03.829 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: Incoming command class COMMAND_CLASS_SECURITY, endpoint 0
2021-06-10 23:51:03.829 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: SECURITY check internal
2021-06-10 23:51:03.829 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 15: Received COMMAND_CLASS_SECURITY V1 SECURITY_NONCE_GET
2021-06-10 23:51:03.830 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Added to secure queue - size 1
2021-06-10 23:51:03.830 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Commands processed 1.
2021-06-10 23:51:03.830 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@5df6af38.
2021-06-10 23:51:03.830 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:51:03.830 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2021-06-10 23:51:03.830 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:51:03.830 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:51:03.830 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 15: Sending REQUEST Message = 01 11 00 13 0F 0A 98 80 C0 A6 0A 30 46 F0 4B 17 25 BA C9 
2021-06-10 23:51:03.834 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2021-06-10 23:51:03.834 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 30704: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 186
2021-06-10 23:51:03.835 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2021-06-10 23:51:03.835 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-06-10 23:51:03.835 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2021-06-10 23:51:03.835 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30704: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 186
2021-06-10 23:51:03.835 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2021-06-10 23:51:03.835 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:51:03.836 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:51:03.848 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2021-06-10 23:51:03.850 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:51:03.850 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:51:03.850 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30704: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 186
2021-06-10 23:51:03.850 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-06-10 23:51:03.850 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 30704: [WAIT_RESPONSE] priority=NonceResponse, requiresResponse=true, callback: 186
2021-06-10 23:51:03.850 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2021-06-10 23:51:03.850 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 30704: Advanced to WAIT_REQUEST
2021-06-10 23:51:03.850 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: TID 30704: Transaction not completed
2021-06-10 23:51:03.851 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:51:03.851 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2021-06-10 23:51:03.943 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 BA 00 00 0A 5B 
2021-06-10 23:51:03.946 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=186, payload=BA 00 00 0A 
2021-06-10 23:51:03.946 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=186, payload=BA 00 00 0A 
2021-06-10 23:51:03.946 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 30704: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 186
2021-06-10 23:51:03.946 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2021-06-10 23:51:03.946 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 30704: [WAIT_REQUEST] priority=NonceResponse, requiresResponse=true, callback: 186
2021-06-10 23:51:03.946 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 30704: (Callback 186)
2021-06-10 23:51:03.946 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2021-06-10 23:51:03.946 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 30704: callback 186
2021-06-10 23:51:03.946 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=186, payload=BA 00 00 0A 
2021-06-10 23:51:03.947 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 15: resetResendCount initComplete=true isDead=false
2021-06-10 23:51:03.947 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 30704: Transaction COMPLETED
2021-06-10 23:51:03.947 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: Response processed after 113ms
2021-06-10 23:51:03.947 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: TID 30704: Transaction completed
2021-06-10 23:51:03.947 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 15: notifyTransactionResponse TID:30704 DONE
2021-06-10 23:51:03.947 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 15: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2021-06-10 23:51:03.947 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2021-06-10 23:51:03.947 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2021-06-10 23:51:04.099 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 28 00 04 00 0F 22 98 81 7A 33 7D DC 76 E7 AF 17 78 C1 C8 3F B6 43 3E 15 8D 83 E9 9F DD AA E6 C0 F6 5A C6 97 37 E2 78 21 EE 
2021-06-10 23:51:04.100 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 22 98 81 7A 33 7D DC 76 E7 AF 17 78 C1 C8 3F B6 43 3E 15 8D 83 E9 9F DD AA E6 C0 F6 5A C6 97 37 E2 78 21 
2021-06-10 23:51:04.100 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=15, callback=0, payload=00 0F 22 98 81 7A 33 7D DC 76 E7 AF 17 78 C1 C8 3F B6 43 3E 15 8D 83 E9 9F DD AA E6 C0 F6 5A C6 97 37 E2 78 21 
2021-06-10 23:51:04.100 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2021-06-10 23:51:04.100 [DEBUG] [nal.protocol.ZWaveTransactionMa