2019-07-29 14:47:45.452 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: SECURITY NOT required on COMMAND_CLASS_SENSOR_MULTILEVEL
2019-07-29 14:47:45.453 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 4: Received COMMAND_CLASS_SENSOR_MULTILEVEL V5 SENSOR_MULTILEVEL_REPORT
2019-07-29 14:47:45.453 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 4: Sensor Type = Power(4), Scale = 0
2019-07-29 14:47:45.453 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 4: Sensor Value = 2.6
2019-07-29 14:47:45.453 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Commands processed 1.
2019-07-29 14:47:45.453 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@6b4c9d4e.
2019-07-29 14:47:45.453 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-07-29 14:47:45.453 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-07-29 14:47:45.453 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-07-29 14:47:45.453 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-07-29 14:47:56.224 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Command received zwave:device:468c4dcd:node9:blinds_control --> 50 [PercentType]
2019-07-29 14:47:56.225 [DEBUG] [ss.ZWaveMultiLevelSwitchCommandClass] - NODE 9: Creating new message for command SWITCH_MULTILEVEL_SET
2019-07-29 14:47:56.225 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: SECURITY NOT required on COMMAND_CLASS_SWITCH_MULTILEVEL
2019-07-29 14:47:56.225 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: Command Class COMMAND_CLASS_SWITCH_MULTILEVEL is NOT required to be secured
2019-07-29 14:47:56.225 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Adding to device queue
2019-07-29 14:47:56.225 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Added 90 to queue - size 1
2019-07-29 14:47:56.226 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-07-29 14:47:56.226 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 09 03 26 01 32 25 49 95
2019-07-29 14:47:56.226 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 9: Sending REQUEST Message = 01 0A 00 13 09 03 26 01 32 25 49 95
2019-07-29 14:47:56.226 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2019-07-29 14:47:56.226 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 90: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 73
2019-07-29 14:47:56.227 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2019-07-29 14:47:56.228 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2019-07-29 14:47:56.228 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2019-07-29 14:47:56.228 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 90: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 73
2019-07-29 14:47:56.228 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2019-07-29 14:47:56.228 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-07-29 14:47:56.228 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2019-07-29 14:47:56.229 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Polling intialised at 86400 seconds - start in 1500 milliseconds.
2019-07-29 14:47:56.234 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8
2019-07-29 14:47:56.234 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2019-07-29 14:47:56.234 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2019-07-29 14:47:56.234 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 90: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 73
2019-07-29 14:47:56.234 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2019-07-29 14:47:56.235 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 90: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 73
2019-07-29 14:47:56.235 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2019-07-29 14:47:56.235 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 9: sentData successfully placed on stack.
2019-07-29 14:47:56.235 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 90: Advanced to WAIT_REQUEST
2019-07-29 14:47:56.235 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: TID 90: Transaction not completed
2019-07-29 14:47:56.235 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-07-29 14:47:56.235 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2019-07-29 14:47:56.254 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 49 00 00 02 A0
2019-07-29 14:47:56.255 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=73, payload=49 00 00 02
2019-07-29 14:47:56.255 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=73, payload=49 00 00 02
2019-07-29 14:47:56.256 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 90: [WAIT_REQUEST] priority=Set, requiresResponse=true, callback: 73
2019-07-29 14:47:56.256 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2019-07-29 14:47:56.256 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 90: [WAIT_REQUEST] priority=Set, requiresResponse=true, callback: 73
2019-07-29 14:47:56.256 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 90: (Callback 73)
2019-07-29 14:47:56.256 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2019-07-29 14:47:56.256 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 90: callback 73
2019-07-29 14:47:56.256 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=73, payload=49 00 00 02
2019-07-29 14:47:56.256 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 9: SendData Request. CallBack ID = 73, Status = Transmission complete and ACK received(0)
2019-07-29 14:47:56.256 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: resetResendCount initComplete=true isDead=false
2019-07-29 14:47:56.256 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 90: Transaction COMPLETED
2019-07-29 14:47:56.257 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Response processed after 31ms
2019-07-29 14:47:56.257 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: TID 90: Transaction completed
2019-07-29 14:47:56.257 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: notifyTransactionResponse TID:90 DONE
2019-07-29 14:47:56.257 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2019-07-29 14:47:56.257 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-07-29 14:47:56.257 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-07-29 14:47:56.814 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0D 00 04 00 09 07 60 0D 01 01 20 01 FF 4B
2019-07-29 14:47:56.815 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=9, callback=0, payload=00 09 07 60 0D 01 01 20 01 FF
2019-07-29 14:47:56.815 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=9, callback=0, payload=00 09 07 60 0D 01 01 20 01 FF
2019-07-29 14:47:56.815 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-07-29 14:47:56.816 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Application Command Request (ALIVE:DONE)
2019-07-29 14:47:56.816 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: resetResendCount initComplete=true isDead=false
2019-07-29 14:47:56.816 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2019-07-29 14:47:56.816 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: Incoming command class COMMAND_CLASS_BASIC, endpoint 1
2019-07-29 14:47:56.816 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: SECURITY NOT required on COMMAND_CLASS_BASIC
2019-07-29 14:47:56.816 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 9: Received COMMAND_CLASS_BASIC V0 BASIC_SET
2019-07-29 14:47:56.817 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 9: Basic report, value = 255
2019-07-29 14:47:56.817 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2019-07-29 14:47:56.817 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Got a value event from Z-Wave network, endpoint = 1, command class = COMMAND_CLASS_BASIC, value = 255
2019-07-29 14:47:56.817 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Updating channel state zwave:device:468c4dcd:node9:blinds_control1 to 100 [PercentType]
2019-07-29 14:47:56.818 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Commands processed 1.
2019-07-29 14:47:56.818 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@6c11023f.
2019-07-29 14:47:56.818 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-07-29 14:47:56.818 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-07-29 14:47:56.818 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-07-29 14:47:56.819 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-07-29 14:47:57.727 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Polling...
2019-07-29 14:47:57.727 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Polling zwave:device:468c4dcd:node9:blinds_control
2019-07-29 14:47:57.728 [DEBUG] [erter.ZWaveMultiLevelSwitchConverter] - NODE 9: Generating poll message for COMMAND_CLASS_SWITCH_MULTILEVEL, endpoint 0
2019-07-29 14:47:57.728 [DEBUG] [ss.ZWaveMultiLevelSwitchCommandClass] - NODE 9: Creating new message for command SWITCH_MULTILEVEL_GET
2019-07-29 14:47:57.728 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: SECURITY NOT required on COMMAND_CLASS_SWITCH_MULTILEVEL
2019-07-29 14:47:57.728 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: Command Class COMMAND_CLASS_SWITCH_MULTILEVEL is NOT required to be secured
2019-07-29 14:47:57.729 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Polling skipped for zwave:device:468c4dcd:node9:blinds_control on COMMAND_CLASS_BASIC
2019-07-29 14:47:57.729 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Polling zwave:device:468c4dcd:node9:meter_watts
2019-07-29 14:47:57.729 [DEBUG] [ternal.converter.ZWaveMeterConverter] - NODE 9: Generating poll message for COMMAND_CLASS_METER, endpoint 0
2019-07-29 14:47:57.729 [DEBUG] [ternal.converter.ZWaveMeterConverter] - NODE 9: Generating poll message for COMMAND_CLASS_METER, endpoint 0
2019-07-29 14:47:57.729 [DEBUG] [.commandclass.ZWaveMeterCommandClass] - NODE 9: Creating new message for application command METER_GET
2019-07-29 14:47:57.730 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: SECURITY NOT required on COMMAND_CLASS_METER
2019-07-29 14:47:57.730 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: Command Class COMMAND_CLASS_METER is NOT required to be secured
2019-07-29 14:47:57.730 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Adding to device queue
2019-07-29 14:47:57.730 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Added 91 to queue - size 1
2019-07-29 14:47:57.731 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-07-29 14:47:57.731 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 09 02 26 02 25 4A A5
2019-07-29 14:47:57.731 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 9: Sending REQUEST Message = 01 09 00 13 09 02 26 02 25 4A A5
2019-07-29 14:47:57.732 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2019-07-29 14:47:57.732 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 91: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 74
2019-07-29 14:47:57.732 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Adding to device queue
2019-07-29 14:47:57.733 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Added 92 to queue - size 1
2019-07-29 14:47:57.733 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2019-07-29 14:47:57.733 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2019-07-29 14:47:57.733 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2019-07-29 14:47:57.733 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2019-07-29 14:47:57.733 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 91: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 74
2019-07-29 14:47:57.734 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2019-07-29 14:47:57.734 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-07-29 14:47:57.734 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2019-07-29 14:47:57.739 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8
2019-07-29 14:47:57.739 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2019-07-29 14:47:57.740 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2019-07-29 14:47:57.740 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 91: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 74
2019-07-29 14:47:57.740 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2019-07-29 14:47:57.740 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 91: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 74
2019-07-29 14:47:57.740 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2019-07-29 14:47:57.740 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 9: sentData successfully placed on stack.
2019-07-29 14:47:57.741 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 91: Advanced to WAIT_REQUEST
2019-07-29 14:47:57.741 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: TID 91: Transaction not completed
2019-07-29 14:47:57.741 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-07-29 14:47:57.741 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2019-07-29 14:47:57.760 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 4A 00 00 03 A2
2019-07-29 14:47:57.760 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=74, payload=4A 00 00 03
2019-07-29 14:47:57.761 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=74, payload=4A 00 00 03
2019-07-29 14:47:57.761 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 91: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 74
2019-07-29 14:47:57.761 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2019-07-29 14:47:57.761 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 91: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 74
2019-07-29 14:47:57.761 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 91: (Callback 74)
2019-07-29 14:47:57.761 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2019-07-29 14:47:57.761 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 91: callback 74
2019-07-29 14:47:57.762 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=74, payload=4A 00 00 03
2019-07-29 14:47:57.762 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 9: SendData Request. CallBack ID = 74, Status = Transmission complete and ACK received(0)
2019-07-29 14:47:57.762 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: resetResendCount initComplete=true isDead=false
2019-07-29 14:47:57.762 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 91: Advanced to WAIT_DATA
2019-07-29 14:47:57.762 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: TID 91: Transaction not completed
2019-07-29 14:47:57.762 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-07-29 14:47:57.763 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2019-07-29 14:47:57.793 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 09 03 26 03 06 DB
2019-07-29 14:47:57.794 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=9, callback=0, payload=00 09 03 26 03 06
2019-07-29 14:47:57.794 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=9, callback=0, payload=00 09 03 26 03 06
2019-07-29 14:47:57.794 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-07-29 14:47:57.794 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Application Command Request (ALIVE:DONE)
2019-07-29 14:47:57.795 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: resetResendCount initComplete=true isDead=false
2019-07-29 14:47:57.795 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: Incoming command class COMMAND_CLASS_SWITCH_MULTILEVEL, endpoint 0
2019-07-29 14:47:57.795 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: SECURITY NOT required on COMMAND_CLASS_SWITCH_MULTILEVEL
2019-07-29 14:47:57.795 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 9: Received COMMAND_CLASS_SWITCH_MULTILEVEL V3 SWITCH_MULTILEVEL_REPORT
2019-07-29 14:47:57.795 [DEBUG] [ss.ZWaveMultiLevelSwitchCommandClass] - NODE 9: Switch Multi Level report, value = 6
2019-07-29 14:47:57.795 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2019-07-29 14:47:57.795 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_SWITCH_MULTILEVEL, value = 6
2019-07-29 14:47:57.796 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Updating channel state zwave:device:468c4dcd:node9:blinds_control to 94 [PercentType]
2019-07-29 14:47:57.796 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Commands processed 1.
2019-07-29 14:47:57.797 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@6a2154b8.
2019-07-29 14:47:57.797 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@6a2154b8.
2019-07-29 14:47:57.797 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: notifyTransactionResponse TID:91 DONE
2019-07-29 14:47:57.798 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2019-07-29 14:47:57.798 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2019-07-29 14:47:57.798 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-07-29 14:47:57.798 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-07-29 14:47:57.798 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-07-29 14:47:57.799 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 09 03 32 01 10 25 4B A1
2019-07-29 14:47:57.799 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 9: Sending REQUEST Message = 01 0A 00 13 09 03 32 01 10 25 4B A1
2019-07-29 14:47:57.799 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2019-07-29 14:47:57.800 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 92: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 75
2019-07-29 14:47:57.801 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2019-07-29 14:47:57.802 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2019-07-29 14:47:57.802 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2019-07-29 14:47:57.802 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 92: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 75
2019-07-29 14:47:57.802 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2019-07-29 14:47:57.802 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-07-29 14:47:57.803 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2019-07-29 14:47:57.807 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8
2019-07-29 14:47:57.807 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2019-07-29 14:47:57.807 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2019-07-29 14:47:57.807 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 92: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 75
2019-07-29 14:47:57.807 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2019-07-29 14:47:57.808 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 92: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 75
2019-07-29 14:47:57.808 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2019-07-29 14:47:57.808 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 9: sentData successfully placed on stack.
2019-07-29 14:47:57.808 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 92: Advanced to WAIT_REQUEST
2019-07-29 14:47:57.808 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: TID 92: Transaction not completed
2019-07-29 14:47:57.808 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-07-29 14:47:57.808 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2019-07-29 14:47:57.828 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 4B 00 00 03 A3
2019-07-29 14:47:57.828 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=75, payload=4B 00 00 03
2019-07-29 14:47:57.828 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=75, payload=4B 00 00 03
2019-07-29 14:47:57.828 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 92: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 75
2019-07-29 14:47:57.829 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2019-07-29 14:47:57.829 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 92: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 75
2019-07-29 14:47:57.829 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 92: (Callback 75)
2019-07-29 14:47:57.829 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2019-07-29 14:47:57.829 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 92: callback 75
2019-07-29 14:47:57.829 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=75, payload=4B 00 00 03
2019-07-29 14:47:57.829 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 9: SendData Request. CallBack ID = 75, Status = Transmission complete and ACK received(0)
2019-07-29 14:47:57.829 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: resetResendCount initComplete=true isDead=false
2019-07-29 14:47:57.830 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 92: Advanced to WAIT_DATA
2019-07-29 14:47:57.830 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: TID 92: Transaction not completed
2019-07-29 14:47:57.830 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-07-29 14:47:57.830 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2019-07-29 14:47:57.880 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 00 09 0A 32 02 21 34 00 00 05 6D 00 00 A5
2019-07-29 14:47:57.881 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=9, callback=0, payload=00 09 0A 32 02 21 34 00 00 05 6D 00 00
2019-07-29 14:47:57.881 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=9, callback=0, payload=00 09 0A 32 02 21 34 00 00 05 6D 00 00
2019-07-29 14:47:57.881 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-07-29 14:47:57.881 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Application Command Request (ALIVE:DONE)
2019-07-29 14:47:57.881 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: resetResendCount initComplete=true isDead=false
2019-07-29 14:47:57.881 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: Incoming command class COMMAND_CLASS_METER, endpoint 0
2019-07-29 14:47:57.882 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: SECURITY NOT required on COMMAND_CLASS_METER
2019-07-29 14:47:57.882 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 9: Received COMMAND_CLASS_METER V3 METER_REPORT
2019-07-29 14:47:57.882 [DEBUG] [.commandclass.ZWaveMeterCommandClass] - NODE 9: Meter: Type=Electric(1), Scale=W(2), Value=138.9
2019-07-29 14:47:57.882 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Got an event from Z-Wave network: ZWaveMeterValueEvent
2019-07-29 14:47:57.882 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_METER, value = 138.9
2019-07-29 14:47:57.882 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Updating channel state zwave:device:468c4dcd:node9:meter_watts to 138.9 [DecimalType]
2019-07-29 14:47:57.883 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Commands processed 1.
2019-07-29 14:47:57.884 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@50241001.
2019-07-29 14:47:57.884 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@50241001.
2019-07-29 14:47:57.884 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: notifyTransactionResponse TID:92 DONE
2019-07-29 14:47:57.885 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2019-07-29 14:47:57.886 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2019-07-29 14:47:57.886 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-07-29 14:47:57.886 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-07-29 14:47:57.887 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-07-29 14:47:59.390 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 14 00 04 00 09 0E 60 0D 01 01 32 02 21 34 00 00 05 65 00 00 C0
2019-07-29 14:47:59.391 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=9, callback=0, payload=00 09 0E 60 0D 01 01 32 02 21 34 00 00 05 65 00 00
2019-07-29 14:47:59.391 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=9, callback=0, payload=00 09 0E 60 0D 01 01 32 02 21 34 00 00 05 65 00 00
2019-07-29 14:47:59.392 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-07-29 14:47:59.392 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Application Command Request (ALIVE:DONE)
2019-07-29 14:47:59.392 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: resetResendCount initComplete=true isDead=false
2019-07-29 14:47:59.392 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2019-07-29 14:47:59.392 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: Incoming command class COMMAND_CLASS_METER, endpoint 1
2019-07-29 14:47:59.392 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: SECURITY NOT required on COMMAND_CLASS_METER
2019-07-29 14:47:59.393 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 9: Received COMMAND_CLASS_METER V3 METER_REPORT
2019-07-29 14:47:59.393 [DEBUG] [.commandclass.ZWaveMeterCommandClass] - NODE 9: Meter: Type=Electric(1), Scale=W(2), Value=138.1
2019-07-29 14:47:59.393 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Got an event from Z-Wave network: ZWaveMeterValueEvent
2019-07-29 14:47:59.393 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Got a value event from Z-Wave network, endpoint = 1, command class = COMMAND_CLASS_METER, value = 138.1
2019-07-29 14:47:59.393 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Updating channel state zwave:device:468c4dcd:node9:meter_watts1 to 138.1 [DecimalType]
2019-07-29 14:47:59.394 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Commands processed 1.
2019-07-29 14:47:59.394 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@5f0d51a6.
2019-07-29 14:47:59.394 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-07-29 14:47:59.394 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-07-29 14:47:59.394 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-07-29 14:47:59.394 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-07-29 14:48:08.089 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0D 00 04 00 09 07 60 0D 01 01 20 01 00 B4
2019-07-29 14:48:08.089 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=9, callback=0, payload=00 09 07 60 0D 01 01 20 01 00
2019-07-29 14:48:08.090 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=9, callback=0, payload=00 09 07 60 0D 01 01 20 01 00
2019-07-29 14:48:08.090 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-07-29 14:48:08.090 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Application Command Request (ALIVE:DONE)
2019-07-29 14:48:08.091 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: resetResendCount initComplete=true isDead=false
2019-07-29 14:48:08.091 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2019-07-29 14:48:08.091 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: Incoming command class COMMAND_CLASS_BASIC, endpoint 1
2019-07-29 14:48:08.091 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: SECURITY NOT required on COMMAND_CLASS_BASIC
2019-07-29 14:48:08.092 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 9: Received COMMAND_CLASS_BASIC V0 BASIC_SET
2019-07-29 14:48:08.092 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 9: Basic report, value = 0
2019-07-29 14:48:08.092 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2019-07-29 14:48:08.092 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Got a value event from Z-Wave network, endpoint = 1, command class = COMMAND_CLASS_BASIC, value = 0
2019-07-29 14:48:08.093 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Updating channel state zwave:device:468c4dcd:node9:blinds_control1 to 0 [PercentType]
2019-07-29 14:48:08.093 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Commands processed 1.
2019-07-29 14:48:08.093 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@3be9b082.
2019-07-29 14:48:08.094 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-07-29 14:48:08.094 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-07-29 14:48:08.094 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-07-29 14:48:08.094 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-07-29 14:48:08.451 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0C 00 04 00 04 06 31 05 04 22 00 19 FE
2019-07-29 14:48:08.452 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 06 31 05 04 22 00 19
2019-07-29 14:48:08.453 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 06 31 05 04 22 00 19
2019-07-29 14:48:08.453 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-07-29 14:48:08.453 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Application Command Request (ALIVE:DONE)
2019-07-29 14:48:08.453 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: resetResendCount initComplete=true isDead=false
2019-07-29 14:48:08.454 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Incoming command class COMMAND_CLASS_SENSOR_MULTILEVEL, endpoint 0
2019-07-29 14:48:08.454 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: SECURITY NOT required on COMMAND_CLASS_SENSOR_MULTILEVEL
2019-07-29 14:48:08.454 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 4: Received COMMAND_CLASS_SENSOR_MULTILEVEL V5 SENSOR_MULTILEVEL_REPORT
2019-07-29 14:48:08.454 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 4: Sensor Type = Power(4), Scale = 0
2019-07-29 14:48:08.455 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 4: Sensor Value = 2.5
2019-07-29 14:48:08.455 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Commands processed 1.
2019-07-29 14:48:08.455 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@5b8da7d3.
2019-07-29 14:48:08.455 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-07-29 14:48:08.455 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-07-29 14:48:08.456 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-07-29 14:48:08.456 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-07-29 14:48:10.451 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0C 00 04 00 04 06 31 05 04 22 00 1A FD
2019-07-29 14:48:10.452 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 06 31 05 04 22 00 1A
2019-07-29 14:48:10.453 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 06 31 05 04 22 00 1A
2019-07-29 14:48:10.453 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-07-29 14:48:10.453 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Application Command Request (ALIVE:DONE)
2019-07-29 14:48:10.453 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: resetResendCount initComplete=true isDead=false
2019-07-29 14:48:10.454 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Incoming command class COMMAND_CLASS_SENSOR_MULTILEVEL, endpoint 0
2019-07-29 14:48:10.454 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: SECURITY NOT required on COMMAND_CLASS_SENSOR_MULTILEVEL
2019-07-29 14:48:10.454 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 4: Received COMMAND_CLASS_SENSOR_MULTILEVEL V5 SENSOR_MULTILEVEL_REPORT
2019-07-29 14:48:10.454 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 4: Sensor Type = Power(4), Scale = 0
2019-07-29 14:48:10.454 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 4: Sensor Value = 2.6
2019-07-29 14:48:10.455 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Commands processed 1.
2019-07-29 14:48:10.455 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@2b5900bb.
2019-07-29 14:48:10.455 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-07-29 14:48:10.455 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-07-29 14:48:10.455 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-07-29 14:48:10.456 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-07-29 14:48:12.452 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0C 00 04 00 04 06 31 05 04 22 00 18 FF
2019-07-29 14:48:12.452 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 06 31 05 04 22 00 18
2019-07-29 14:48:12.453 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 06 31 05 04 22 00 18
2019-07-29 14:48:12.453 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-07-29 14:48:12.453 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Application Command Request (ALIVE:DONE)
2019-07-29 14:48:12.453 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: resetResendCount initComplete=true isDead=false
2019-07-29 14:48:12.454 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Incoming command class COMMAND_CLASS_SENSOR_MULTILEVEL, endpoint 0
2019-07-29 14:48:12.454 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: SECURITY NOT required on COMMAND_CLASS_SENSOR_MULTILEVEL
2019-07-29 14:48:12.454 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 4: Received COMMAND_CLASS_SENSOR_MULTILEVEL V5 SENSOR_MULTILEVEL_REPORT
2019-07-29 14:48:12.454 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 4: Sensor Type = Power(4), Scale = 0
2019-07-29 14:48:12.454 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 4: Sensor Value = 2.4
2019-07-29 14:48:12.455 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Commands processed 1.
2019-07-29 14:48:12.455 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1e6cf417.
2019-07-29 14:48:12.455 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-07-29 14:48:12.455 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-07-29 14:48:12.455 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-07-29 14:48:12.456 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-07-29 14:48:13.451 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0C 00 04 00 04 06 31 05 04 22 00 19 FE
2019-07-29 14:48:13.452 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 06 31 05 04 22 00 19
2019-07-29 14:48:13.453 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 06 31 05 04 22 00 19
2019-07-29 14:48:13.453 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-07-29 14:48:13.453 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Application Command Request (ALIVE:DONE)
2019-07-29 14:48:13.453 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: resetResendCount initComplete=true isDead=false
2019-07-29 14:48:13.453 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Incoming command class COMMAND_CLASS_SENSOR_MULTILEVEL, endpoint 0
2019-07-29 14:48:13.454 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: SECURITY NOT required on COMMAND_CLASS_SENSOR_MULTILEVEL
2019-07-29 14:48:13.454 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 4: Received COMMAND_CLASS_SENSOR_MULTILEVEL V5 SENSOR_MULTILEVEL_REPORT
2019-07-29 14:48:13.454 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 4: Sensor Type = Power(4), Scale = 0
2019-07-29 14:48:13.454 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 4: Sensor Value = 2.5
2019-07-29 14:48:13.454 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Commands processed 1.
2019-07-29 14:48:13.454 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@68773af8.
2019-07-29 14:48:13.454 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-07-29 14:48:13.454 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-07-29 14:48:13.454 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-07-29 14:48:13.455 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-07-29 14:48:13.705 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0D 00 04 00 09 07 60 0D 01 01 26 03 32 82
2019-07-29 14:48:13.705 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=9, callback=0, payload=00 09 07 60 0D 01 01 26 03 32
2019-07-29 14:48:13.706 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=9, callback=0, payload=00 09 07 60 0D 01 01 26 03 32
2019-07-29 14:48:13.706 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-07-29 14:48:13.706 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Application Command Request (ALIVE:DONE)
2019-07-29 14:48:13.706 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: resetResendCount initComplete=true isDead=false
2019-07-29 14:48:13.706 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2019-07-29 14:48:13.707 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: Incoming command class COMMAND_CLASS_SWITCH_MULTILEVEL, endpoint 1
2019-07-29 14:48:13.707 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: SECURITY NOT required on COMMAND_CLASS_SWITCH_MULTILEVEL
2019-07-29 14:48:13.707 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 9: Received COMMAND_CLASS_SWITCH_MULTILEVEL V3 SWITCH_MULTILEVEL_REPORT
2019-07-29 14:48:13.707 [DEBUG] [ss.ZWaveMultiLevelSwitchCommandClass] - NODE 9: Switch Multi Level report, value = 50
2019-07-29 14:48:13.707 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2019-07-29 14:48:13.707 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Got a value event from Z-Wave network, endpoint = 1, command class = COMMAND_CLASS_SWITCH_MULTILEVEL, value = 50
2019-07-29 14:48:13.708 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Updating channel state zwave:device:468c4dcd:node9:blinds_control1 to 50 [PercentType]
2019-07-29 14:48:13.708 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Commands processed 1.
2019-07-29 14:48:13.708 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@5e72bb1a.
2019-07-29 14:48:13.708 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-07-29 14:48:13.708 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-07-29 14:48:13.708 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-07-29 14:48:13.709 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-07-29 14:48:14.724 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 14 00 04 00 09 0E 60 0D 01 01 32 02 21 34 00 00 00 00 00 00 A0
2019-07-29 14:48:14.725 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=9, callback=0, payload=00 09 0E 60 0D 01 01 32 02 21 34 00 00 00 00 00 00
2019-07-29 14:48:14.725 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=9, callback=0, payload=00 09 0E 60 0D 01 01 32 02 21 34 00 00 00 00 00 00
2019-07-29 14:48:14.726 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-07-29 14:48:14.726 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Application Command Request (ALIVE:DONE)
2019-07-29 14:48:14.727 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: resetResendCount initComplete=true isDead=false
2019-07-29 14:48:14.727 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2019-07-29 14:48:14.727 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: Incoming command class COMMAND_CLASS_METER, endpoint 1
2019-07-29 14:48:14.727 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: SECURITY NOT required on COMMAND_CLASS_METER
2019-07-29 14:48:14.727 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 9: Received COMMAND_CLASS_METER V3 METER_REPORT
2019-07-29 14:48:14.728 [DEBUG] [.commandclass.ZWaveMeterCommandClass] - NODE 9: Meter: Type=Electric(1), Scale=W(2), Value=0E+1
2019-07-29 14:48:14.728 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Got an event from Z-Wave network: ZWaveMeterValueEvent
2019-07-29 14:48:14.728 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Got a value event from Z-Wave network, endpoint = 1, command class = COMMAND_CLASS_METER, value = 0E+1
2019-07-29 14:48:14.728 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Updating channel state zwave:device:468c4dcd:node9:meter_watts1 to 0 [DecimalType]
2019-07-29 14:48:14.729 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Commands processed 1.
2019-07-29 14:48:14.729 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@3d4d24b7.
2019-07-29 14:48:14.729 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-07-29 14:48:14.729 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-07-29 14:48:14.730 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-07-29 14:48:14.730 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-07-29 14:48:15.710 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0D 00 04 00 09 07 60 0D 02 01 26 03 00 B3
2019-07-29 14:48:15.711 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=9, callback=0, payload=00 09 07 60 0D 02 01 26 03 00
2019-07-29 14:48:15.711 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=9, callback=0, payload=00 09 07 60 0D 02 01 26 03 00
2019-07-29 14:48:15.712 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-07-29 14:48:15.712 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Application Command Request (ALIVE:DONE)
2019-07-29 14:48:15.713 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: resetResendCount initComplete=true isDead=false
2019-07-29 14:48:15.713 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2019-07-29 14:48:15.713 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: Incoming command class COMMAND_CLASS_SWITCH_MULTILEVEL, endpoint 2
2019-07-29 14:48:15.713 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 9: SECURITY NOT required on COMMAND_CLASS_SWITCH_MULTILEVEL
2019-07-29 14:48:15.713 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 9: Received COMMAND_CLASS_SWITCH_MULTILEVEL V3 SWITCH_MULTILEVEL_REPORT
2019-07-29 14:48:15.714 [DEBUG] [ss.ZWaveMultiLevelSwitchCommandClass] - NODE 9: Switch Multi Level report, value = 0
2019-07-29 14:48:15.714 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2019-07-29 14:48:15.714 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Got a value event from Z-Wave network, endpoint = 2, command class = COMMAND_CLASS_SWITCH_MULTILEVEL, value = 0
2019-07-29 14:48:15.715 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Updating channel state zwave:device:468c4dcd:node9:blinds_control2 to 0 [PercentType]
2019-07-29 14:48:15.715 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Commands processed 1.
2019-07-29 14:48:15.715 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 9: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@44f8b345.
2019-07-29 14:48:15.715 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-07-29 14:48:15.715 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-07-29 14:48:15.716 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-07-29 14:48:15.716 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-07-29 14:48:23.452 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0C 00 04 00 04 06 31 05 04 22 00 1A FD
2019-07-29 14:48:23.452 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 06 31 05 04 22 00 1A