2019-12-05 09:46:13.779 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 26: Updating channel state zwave:device:4296a94a:node26:meter_watts to 0 [DecimalType] 2019-12-05 09:46:13.780 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: Commands processed 1. 2019-12-05 09:46:13.780 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@2b2c2640. 2019-12-05 09:46:13.780 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@2b2c2640. 2019-12-05 09:46:13.780 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: notifyTransactionResponse TID:19347 DONE 2019-12-05 09:46:13.783 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 26: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent 2019-12-05 09:46:13.783 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1 2019-12-05 09:46:13.783 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2019-12-05 09:46:13.783 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2019-12-05 09:46:13.783 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2019-12-05 09:46:21.819 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 26: Command received zwave:device:4296a94a:node26:switch_dimmer --> 70 [PercentType] 2019-12-05 09:46:21.820 [DEBUG] [col.commandclass.ZWaveMultiLevelSwitchCommandClass] - NODE 26: Creating new message for command SWITCH_MULTILEVEL_SET 2019-12-05 09:46:21.821 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 26: SECURITY not supported 2019-12-05 09:46:21.821 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 26: Command Class COMMAND_CLASS_SWITCH_MULTILEVEL is NOT required to be secured 2019-12-05 09:46:21.822 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: Adding to device queue 2019-12-05 09:46:21.822 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: Added 19348 to queue - size 9 2019-12-05 09:46:21.822 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2019-12-05 09:46:21.822 [DEBUG] [nhab.binding.zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 1A 03 26 01 46 25 EC 57 2019-12-05 09:46:21.822 [DEBUG] [g.openhab.binding.zwave.handler.ZWaveSerialHandler] - NODE 26: Sending REQUEST Message = 01 0A 00 13 1A 03 26 01 46 25 EC 57 2019-12-05 09:46:21.822 [DEBUG] [g.openhab.binding.zwave.handler.ZWaveSerialHandler] - Message SENT 2019-12-05 09:46:21.822 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 19348: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 236 2019-12-05 09:46:21.822 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 26: Polling initialised at 86400 seconds - start in 2500 milliseconds. 2019-12-05 09:46:21.825 [DEBUG] [wave.handler.ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06 2019-12-05 09:46:21.825 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2019-12-05 09:46:21.825 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2019-12-05 09:46:21.825 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - lastTransaction TID 19348: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 236 2019-12-05 09:46:21.825 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Received msg: ACK 2019-12-05 09:46:21.826 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2019-12-05 09:46:21.826 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2019-12-05 09:46:21.832 [DEBUG] [wave.handler.ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 2019-12-05 09:46:21.832 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2019-12-05 09:46:21.832 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2019-12-05 09:46:21.832 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - lastTransaction TID 19348: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 236 2019-12-05 09:46:21.832 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1 2019-12-05 09:46:21.832 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Last transaction: TID 19348: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 236 2019-12-05 09:46:21.832 [DEBUG] [ab.binding.zwave.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2019-12-05 09:46:21.832 [DEBUG] [ternal.protocol.serialmessage.SendDataMessageClass] - NODE 26: sentData successfully placed on stack. 2019-12-05 09:46:21.832 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - TID 19348: Advanced to WAIT_REQUEST 2019-12-05 09:46:21.832 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: TID 19348: Transaction not completed 2019-12-05 09:46:21.832 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2019-12-05 09:46:21.832 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2019-12-05 09:46:21.974 [DEBUG] [wave.handler.ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 EC 00 00 0E 09 2019-12-05 09:46:21.974 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=236, payload=EC 00 00 0E 2019-12-05 09:46:21.974 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=236, payload=EC 00 00 0E 2019-12-05 09:46:21.974 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - lastTransaction TID 19348: [WAIT_REQUEST] priority=Set, requiresResponse=true, callback: 236 2019-12-05 09:46:21.974 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1 2019-12-05 09:46:21.974 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Last transaction: TID 19348: [WAIT_REQUEST] priority=Set, requiresResponse=true, callback: 236 2019-12-05 09:46:21.975 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Checking TID 19348: (Callback 236) 2019-12-05 09:46:21.975 [DEBUG] [ernal.protocol.serialmessage.ZWaveCommandProcessor] - Callback match! 2019-12-05 09:46:21.975 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Correlated to TID 19348: callback 236 2019-12-05 09:46:21.975 [DEBUG] [ab.binding.zwave.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=236, payload=EC 00 00 0E 2019-12-05 09:46:21.975 [DEBUG] [ternal.protocol.serialmessage.SendDataMessageClass] - NODE 26: SendData Request. CallBack ID = 236, Status = Transmission complete and ACK received(0) 2019-12-05 09:46:21.975 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 26: resetResendCount initComplete=true isDead=false 2019-12-05 09:46:21.975 [DEBUG] [b.binding.zwave.internal.protocol.ZWaveTransaction] - TID 19348: Transaction COMPLETED 2019-12-05 09:46:21.975 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: Response processed after 153ms 2019-12-05 09:46:21.975 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: TID 19348: Transaction completed 2019-12-05 09:46:21.975 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: notifyTransactionResponse TID:19348 DONE 2019-12-05 09:46:21.975 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 26: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent 2019-12-05 09:46:21.975 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2019-12-05 09:46:21.975 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2019-12-05 09:46:23.597 [DEBUG] [wave.handler.ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 1A 03 20 03 46 8E 2019-12-05 09:46:23.597 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=26, callback=0, payload=00 1A 03 20 03 46 2019-12-05 09:46:23.598 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=26, callback=0, payload=00 1A 03 20 03 46 2019-12-05 09:46:23.598 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - lastTransaction null 2019-12-05 09:46:23.598 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: Application Command Request (ALIVE:DONE) 2019-12-05 09:46:23.598 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 26: resetResendCount initComplete=true isDead=false 2019-12-05 09:46:23.598 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 26: Incoming command class COMMAND_CLASS_BASIC, endpoint 0 2019-12-05 09:46:23.598 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 26: SECURITY not supported 2019-12-05 09:46:23.598 [DEBUG] [e.internal.protocol.commandclass.ZWaveCommandClass] - NODE 26: Received COMMAND_CLASS_BASIC V1 BASIC_REPORT 2019-12-05 09:46:23.598 [DEBUG] [ernal.protocol.commandclass.ZWaveBasicCommandClass] - NODE 26: Basic report, value = 70 2019-12-05 09:46:23.598 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 26: Got an event from Z-Wave network: ZWaveCommandClassValueEvent 2019-12-05 09:46:23.598 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 26: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_BASIC, value=70 2019-12-05 09:46:23.598 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 26: Updating channel state zwave:device:4296a94a:node26:switch_dimmer to 70 [PercentType] 2019-12-05 09:46:23.598 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: Commands processed 1. 2019-12-05 09:46:23.598 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1f9cd940. 2019-12-05 09:46:23.598 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2019-12-05 09:46:23.599 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2019-12-05 09:46:23.599 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2019-12-05 09:46:23.599 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2019-12-05 09:46:24.322 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 26: Polling... 2019-12-05 09:46:24.323 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 26: Polling zwave:device:4296a94a:node26:switch_dimmer 2019-12-05 09:46:24.323 [DEBUG] [.internal.converter.ZWaveMultiLevelSwitchConverter] - NODE 26: Generating poll message for COMMAND_CLASS_SWITCH_MULTILEVEL, endpoint 0 2019-12-05 09:46:24.323 [DEBUG] [col.commandclass.ZWaveMultiLevelSwitchCommandClass] - NODE 26: Creating new message for command SWITCH_MULTILEVEL_GET 2019-12-05 09:46:24.323 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 26: SECURITY not supported 2019-12-05 09:46:24.323 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 26: Command Class COMMAND_CLASS_SWITCH_MULTILEVEL is NOT required to be secured 2019-12-05 09:46:24.323 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 26: Polling skipped for zwave:device:4296a94a:node26:switch_dimmer on COMMAND_CLASS_BASIC 2019-12-05 09:46:24.323 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 26: Polling zwave:device:4296a94a:node26:meter_kwh 2019-12-05 09:46:24.323 [DEBUG] [nding.zwave.internal.converter.ZWaveMeterConverter] - NODE 26: Generating poll message for COMMAND_CLASS_METER, endpoint 0 2019-12-05 09:46:24.323 [DEBUG] [nding.zwave.internal.converter.ZWaveMeterConverter] - NODE 26: Generating poll message for COMMAND_CLASS_METER, endpoint 0 2019-12-05 09:46:24.323 [DEBUG] [ernal.protocol.commandclass.ZWaveMeterCommandClass] - NODE 26: Creating new message for application command METER_GET 2019-12-05 09:46:24.323 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 26: SECURITY not supported 2019-12-05 09:46:24.323 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 26: Command Class COMMAND_CLASS_METER is NOT required to be secured 2019-12-05 09:46:24.323 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 26: Polling zwave:device:4296a94a:node26:meter_watts 2019-12-05 09:46:24.323 [DEBUG] [nding.zwave.internal.converter.ZWaveMeterConverter] - NODE 26: Generating poll message for COMMAND_CLASS_METER, endpoint 0 2019-12-05 09:46:24.323 [DEBUG] [nding.zwave.internal.converter.ZWaveMeterConverter] - NODE 26: Generating poll message for COMMAND_CLASS_METER, endpoint 0 2019-12-05 09:46:24.323 [DEBUG] [ernal.protocol.commandclass.ZWaveMeterCommandClass] - NODE 26: Creating new message for application command METER_GET 2019-12-05 09:46:24.323 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 26: SECURITY not supported 2019-12-05 09:46:24.323 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 26: Command Class COMMAND_CLASS_METER is NOT required to be secured 2019-12-05 09:46:24.323 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 26: Polling zwave:device:4296a94a:node26:meter_reset 2019-12-05 09:46:24.323 [DEBUG] [nding.zwave.internal.converter.ZWaveMeterConverter] - NODE 26: Generating poll message for COMMAND_CLASS_METER, endpoint 0 2019-12-05 09:46:24.323 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: Adding to device queue 2019-12-05 09:46:24.323 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: Added 19349 to queue - size 9 2019-12-05 09:46:24.323 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2019-12-05 09:46:24.324 [DEBUG] [nhab.binding.zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 1A 02 26 02 25 ED 11 2019-12-05 09:46:24.324 [DEBUG] [g.openhab.binding.zwave.handler.ZWaveSerialHandler] - NODE 26: Sending REQUEST Message = 01 09 00 13 1A 02 26 02 25 ED 11 2019-12-05 09:46:24.324 [DEBUG] [g.openhab.binding.zwave.handler.ZWaveSerialHandler] - Message SENT 2019-12-05 09:46:24.324 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 19349: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 237 2019-12-05 09:46:24.324 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: Adding to device queue 2019-12-05 09:46:24.324 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: Added 19350 to queue - size 9 2019-12-05 09:46:24.324 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2019-12-05 09:46:24.324 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: Adding to device queue 2019-12-05 09:46:24.324 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: Added 19351 to queue - size 10 2019-12-05 09:46:24.324 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2019-12-05 09:46:24.326 [DEBUG] [wave.handler.ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06 2019-12-05 09:46:24.326 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2019-12-05 09:46:24.326 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2019-12-05 09:46:24.326 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - lastTransaction TID 19349: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 237 2019-12-05 09:46:24.326 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Received msg: ACK 2019-12-05 09:46:24.326 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2019-12-05 09:46:24.326 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2019-12-05 09:46:24.337 [DEBUG] [wave.handler.ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 2019-12-05 09:46:24.337 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2019-12-05 09:46:24.337 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2019-12-05 09:46:24.337 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - lastTransaction TID 19349: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 237 2019-12-05 09:46:24.337 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1 2019-12-05 09:46:24.337 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Last transaction: TID 19349: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 237 2019-12-05 09:46:24.337 [DEBUG] [ab.binding.zwave.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2019-12-05 09:46:24.337 [DEBUG] [ternal.protocol.serialmessage.SendDataMessageClass] - NODE 26: sentData successfully placed on stack. 2019-12-05 09:46:24.338 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - TID 19349: Advanced to WAIT_REQUEST 2019-12-05 09:46:24.338 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: TID 19349: Transaction not completed 2019-12-05 09:46:24.338 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2019-12-05 09:46:24.338 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2019-12-05 09:46:24.477 [DEBUG] [wave.handler.ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 ED 00 00 0E 08 2019-12-05 09:46:24.477 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=237, payload=ED 00 00 0E 2019-12-05 09:46:24.478 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=237, payload=ED 00 00 0E 2019-12-05 09:46:24.478 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - lastTransaction TID 19349: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 237 2019-12-05 09:46:24.478 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1 2019-12-05 09:46:24.478 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Last transaction: TID 19349: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 237 2019-12-05 09:46:24.478 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Checking TID 19349: (Callback 237) 2019-12-05 09:46:24.478 [DEBUG] [ernal.protocol.serialmessage.ZWaveCommandProcessor] - Callback match! 2019-12-05 09:46:24.478 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Correlated to TID 19349: callback 237 2019-12-05 09:46:24.478 [DEBUG] [ab.binding.zwave.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=237, payload=ED 00 00 0E 2019-12-05 09:46:24.478 [DEBUG] [ternal.protocol.serialmessage.SendDataMessageClass] - NODE 26: SendData Request. CallBack ID = 237, Status = Transmission complete and ACK received(0) 2019-12-05 09:46:24.478 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 26: resetResendCount initComplete=true isDead=false 2019-12-05 09:46:24.478 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - TID 19349: Advanced to WAIT_DATA 2019-12-05 09:46:24.478 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: TID 19349: Transaction not completed 2019-12-05 09:46:24.478 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2019-12-05 09:46:24.478 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2019-12-05 09:46:24.607 [DEBUG] [wave.handler.ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 1A 03 26 03 46 88 2019-12-05 09:46:24.607 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=26, callback=0, payload=00 1A 03 26 03 46 2019-12-05 09:46:24.608 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=26, callback=0, payload=00 1A 03 26 03 46 2019-12-05 09:46:24.608 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - lastTransaction null 2019-12-05 09:46:24.608 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: Application Command Request (ALIVE:DONE) 2019-12-05 09:46:24.608 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 26: resetResendCount initComplete=true isDead=false 2019-12-05 09:46:24.608 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 26: Incoming command class COMMAND_CLASS_SWITCH_MULTILEVEL, endpoint 0 2019-12-05 09:46:24.608 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 26: SECURITY not supported 2019-12-05 09:46:24.608 [DEBUG] [e.internal.protocol.commandclass.ZWaveCommandClass] - NODE 26: Received COMMAND_CLASS_SWITCH_MULTILEVEL V3 SWITCH_MULTILEVEL_REPORT 2019-12-05 09:46:24.608 [DEBUG] [col.commandclass.ZWaveMultiLevelSwitchCommandClass] - NODE 26: Switch Multi Level report, value = 70 2019-12-05 09:46:24.608 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 26: Got an event from Z-Wave network: ZWaveCommandClassValueEvent 2019-12-05 09:46:24.608 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 26: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_SWITCH_MULTILEVEL, value=70 2019-12-05 09:46:24.608 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 26: Updating channel state zwave:device:4296a94a:node26:switch_dimmer to 70 [PercentType] 2019-12-05 09:46:24.609 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: Commands processed 1. 2019-12-05 09:46:24.609 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@55cfe8b7. 2019-12-05 09:46:24.609 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@55cfe8b7. 2019-12-05 09:46:24.609 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: notifyTransactionResponse TID:19349 DONE 2019-12-05 09:46:24.609 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 26: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent 2019-12-05 09:46:24.609 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1 2019-12-05 09:46:24.609 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2019-12-05 09:46:24.609 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2019-12-05 09:46:24.609 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2019-12-05 09:46:24.609 [DEBUG] [nhab.binding.zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 1A 03 32 01 00 25 EE 07 2019-12-05 09:46:24.609 [DEBUG] [g.openhab.binding.zwave.handler.ZWaveSerialHandler] - NODE 26: Sending REQUEST Message = 01 0A 00 13 1A 03 32 01 00 25 EE 07 2019-12-05 09:46:24.609 [DEBUG] [g.openhab.binding.zwave.handler.ZWaveSerialHandler] - Message SENT 2019-12-05 09:46:24.609 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 19350: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 238 2019-12-05 09:46:24.612 [DEBUG] [wave.handler.ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06 2019-12-05 09:46:24.612 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2019-12-05 09:46:24.612 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2019-12-05 09:46:24.612 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - lastTransaction TID 19350: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 238 2019-12-05 09:46:24.612 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Received msg: ACK 2019-12-05 09:46:24.612 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2019-12-05 09:46:24.612 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2019-12-05 09:46:24.618 [DEBUG] [wave.handler.ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 2019-12-05 09:46:24.618 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2019-12-05 09:46:24.618 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2019-12-05 09:46:24.618 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - lastTransaction TID 19350: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 238 2019-12-05 09:46:24.618 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1 2019-12-05 09:46:24.618 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Last transaction: TID 19350: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 238 2019-12-05 09:46:24.618 [DEBUG] [ab.binding.zwave.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2019-12-05 09:46:24.618 [DEBUG] [ternal.protocol.serialmessage.SendDataMessageClass] - NODE 26: sentData successfully placed on stack. 2019-12-05 09:46:24.619 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - TID 19350: Advanced to WAIT_REQUEST 2019-12-05 09:46:24.619 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: TID 19350: Transaction not completed 2019-12-05 09:46:24.619 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2019-12-05 09:46:24.619 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2019-12-05 09:46:24.867 [DEBUG] [wave.handler.ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 EE 00 00 1A 1F 2019-12-05 09:46:24.867 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=238, payload=EE 00 00 1A 2019-12-05 09:46:24.868 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=238, payload=EE 00 00 1A 2019-12-05 09:46:24.868 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - lastTransaction TID 19350: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 238 2019-12-05 09:46:24.868 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1 2019-12-05 09:46:24.868 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Last transaction: TID 19350: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 238 2019-12-05 09:46:24.868 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Checking TID 19350: (Callback 238) 2019-12-05 09:46:24.868 [DEBUG] [ernal.protocol.serialmessage.ZWaveCommandProcessor] - Callback match! 2019-12-05 09:46:24.868 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Correlated to TID 19350: callback 238 2019-12-05 09:46:24.868 [DEBUG] [ab.binding.zwave.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=238, payload=EE 00 00 1A 2019-12-05 09:46:24.868 [DEBUG] [ternal.protocol.serialmessage.SendDataMessageClass] - NODE 26: SendData Request. CallBack ID = 238, Status = Transmission complete and ACK received(0) 2019-12-05 09:46:24.868 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 26: resetResendCount initComplete=true isDead=false 2019-12-05 09:46:24.868 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - TID 19350: Advanced to WAIT_DATA 2019-12-05 09:46:24.868 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: TID 19350: Transaction not completed 2019-12-05 09:46:24.868 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2019-12-05 09:46:24.868 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2019-12-05 09:46:25.017 [DEBUG] [wave.handler.ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 14 00 04 00 1A 0E 32 02 21 64 00 00 00 00 00 0B 00 00 00 00 85 2019-12-05 09:46:25.017 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=26, callback=0, payload=00 1A 0E 32 02 21 64 00 00 00 00 00 0B 00 00 00 00 2019-12-05 09:46:25.018 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=26, callback=0, payload=00 1A 0E 32 02 21 64 00 00 00 00 00 0B 00 00 00 00 2019-12-05 09:46:25.018 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - lastTransaction null 2019-12-05 09:46:25.018 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: Application Command Request (ALIVE:DONE) 2019-12-05 09:46:25.018 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 26: resetResendCount initComplete=true isDead=false 2019-12-05 09:46:25.018 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 26: Incoming command class COMMAND_CLASS_METER, endpoint 0 2019-12-05 09:46:25.018 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 26: SECURITY not supported 2019-12-05 09:46:25.018 [DEBUG] [e.internal.protocol.commandclass.ZWaveCommandClass] - NODE 26: Received COMMAND_CLASS_METER V3 METER_REPORT 2019-12-05 09:46:25.018 [DEBUG] [ernal.protocol.commandclass.ZWaveMeterCommandClass] - NODE 26: Meter: Type=Electric(1), Scale=kWh(0), Value=0E+1 2019-12-05 09:46:25.018 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 26: Got an event from Z-Wave network: ZWaveMeterValueEvent 2019-12-05 09:46:25.018 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 26: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_METER, value=0E+1 2019-12-05 09:46:25.018 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 26: Updating channel state zwave:device:4296a94a:node26:meter_kwh to 0 [DecimalType] 2019-12-05 09:46:25.018 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: Commands processed 1. 2019-12-05 09:46:25.018 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@7468bea3. 2019-12-05 09:46:25.018 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@7468bea3. 2019-12-05 09:46:25.018 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: notifyTransactionResponse TID:19350 DONE 2019-12-05 09:46:25.019 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 26: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent 2019-12-05 09:46:25.019 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1 2019-12-05 09:46:25.019 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2019-12-05 09:46:25.019 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2019-12-05 09:46:25.019 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false. 2019-12-05 09:46:25.019 [DEBUG] [nhab.binding.zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 1A 03 32 01 10 25 EF 16 2019-12-05 09:46:25.019 [DEBUG] [g.openhab.binding.zwave.handler.ZWaveSerialHandler] - NODE 26: Sending REQUEST Message = 01 0A 00 13 1A 03 32 01 10 25 EF 16 2019-12-05 09:46:25.019 [DEBUG] [g.openhab.binding.zwave.handler.ZWaveSerialHandler] - Message SENT 2019-12-05 09:46:25.019 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 19351: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 239 2019-12-05 09:46:25.021 [DEBUG] [wave.handler.ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06 2019-12-05 09:46:25.021 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2019-12-05 09:46:25.021 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload= 2019-12-05 09:46:25.021 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - lastTransaction TID 19351: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 239 2019-12-05 09:46:25.021 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Received msg: ACK 2019-12-05 09:46:25.021 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2019-12-05 09:46:25.021 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2019-12-05 09:46:25.028 [DEBUG] [wave.handler.ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 2019-12-05 09:46:25.028 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2019-12-05 09:46:25.028 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2019-12-05 09:46:25.028 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - lastTransaction TID 19351: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 239 2019-12-05 09:46:25.028 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1 2019-12-05 09:46:25.028 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Last transaction: TID 19351: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 239 2019-12-05 09:46:25.028 [DEBUG] [ab.binding.zwave.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 2019-12-05 09:46:25.028 [DEBUG] [ternal.protocol.serialmessage.SendDataMessageClass] - NODE 26: sentData successfully placed on stack. 2019-12-05 09:46:25.028 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - TID 19351: Advanced to WAIT_REQUEST 2019-12-05 09:46:25.028 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: TID 19351: Transaction not completed 2019-12-05 09:46:25.028 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2019-12-05 09:46:25.028 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2019-12-05 09:46:25.275 [DEBUG] [wave.handler.ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 EF 00 00 1A 1E 2019-12-05 09:46:25.275 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=239, payload=EF 00 00 1A 2019-12-05 09:46:25.275 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=239, payload=EF 00 00 1A 2019-12-05 09:46:25.275 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - lastTransaction TID 19351: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 239 2019-12-05 09:46:25.275 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1 2019-12-05 09:46:25.275 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Last transaction: TID 19351: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 239 2019-12-05 09:46:25.275 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Checking TID 19351: (Callback 239) 2019-12-05 09:46:25.276 [DEBUG] [ernal.protocol.serialmessage.ZWaveCommandProcessor] - Callback match! 2019-12-05 09:46:25.276 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Correlated to TID 19351: callback 239 2019-12-05 09:46:25.276 [DEBUG] [ab.binding.zwave.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=239, payload=EF 00 00 1A 2019-12-05 09:46:25.276 [DEBUG] [ternal.protocol.serialmessage.SendDataMessageClass] - NODE 26: SendData Request. CallBack ID = 239, Status = Transmission complete and ACK received(0) 2019-12-05 09:46:25.276 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 26: resetResendCount initComplete=true isDead=false 2019-12-05 09:46:25.276 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - TID 19351: Advanced to WAIT_DATA 2019-12-05 09:46:25.276 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: TID 19351: Transaction not completed 2019-12-05 09:46:25.276 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2019-12-05 09:46:25.276 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false. 2019-12-05 09:46:25.427 [DEBUG] [wave.handler.ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 14 00 04 00 1A 0E 32 02 21 74 00 00 13 92 00 00 00 00 00 00 1F 2019-12-05 09:46:25.427 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=26, callback=0, payload=00 1A 0E 32 02 21 74 00 00 13 92 00 00 00 00 00 00 2019-12-05 09:46:25.428 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=26, callback=0, payload=00 1A 0E 32 02 21 74 00 00 13 92 00 00 00 00 00 00 2019-12-05 09:46:25.428 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - lastTransaction null 2019-12-05 09:46:25.428 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: Application Command Request (ALIVE:DONE) 2019-12-05 09:46:25.428 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 26: resetResendCount initComplete=true isDead=false 2019-12-05 09:46:25.428 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 26: Incoming command class COMMAND_CLASS_METER, endpoint 0 2019-12-05 09:46:25.428 [DEBUG] [.openhab.binding.zwave.internal.protocol.ZWaveNode] - NODE 26: SECURITY not supported 2019-12-05 09:46:25.428 [DEBUG] [e.internal.protocol.commandclass.ZWaveCommandClass] - NODE 26: Received COMMAND_CLASS_METER V3 METER_REPORT 2019-12-05 09:46:25.428 [DEBUG] [ernal.protocol.commandclass.ZWaveMeterCommandClass] - NODE 26: Meter: Type=Electric(1), Scale=W(2), Value=5.01 2019-12-05 09:46:25.428 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 26: Got an event from Z-Wave network: ZWaveMeterValueEvent 2019-12-05 09:46:25.428 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 26: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_METER, value=5.01 2019-12-05 09:46:25.428 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 26: Updating channel state zwave:device:4296a94a:node26:meter_watts to 5.01 [DecimalType] 2019-12-05 09:46:25.428 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: Commands processed 1. 2019-12-05 09:46:25.428 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@3e3c8848. 2019-12-05 09:46:25.428 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@3e3c8848. 2019-12-05 09:46:25.428 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - NODE 26: notifyTransactionResponse TID:19351 DONE 2019-12-05 09:46:25.429 [DEBUG] [rg.openhab.binding.zwave.handler.ZWaveThingHandler] - NODE 26: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent 2019-12-05 09:46:25.429 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1 2019-12-05 09:46:25.429 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0 2019-12-05 09:46:25.429 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty 2019-12-05 09:46:25.429 [DEBUG] [ng.zwave.internal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.