2019-11-18 11:38:00.124 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - NODE 2: Device discovery completed
2019-11-18 11:38:00.554 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - NODE 2: Device discovery resolved to thingType zwave:hank_hkzwfld01_00_000
2019-11-18 11:38:00.570 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - NODE 3: Device discovery completed
2019-11-18 11:38:00.594 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - NODE 3: Device discovery resolved to thingType zwave:heiman_hs1sa_00_000
2019-11-18 11:38:00.623 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - NODE 4: Device discovery completed
2019-11-18 11:38:00.634 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - NODE 4: Device discovery resolved to thingType zwave:everspring_st812_00_000
2019-11-18 11:38:02.045 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - NODE 5: Device discovery completed
2019-11-18 11:38:02.058 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - NODE 5: Device discovery resolved to thingType zwave:everspring_se812_00_000
2019-11-18 11:38:03.461 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - NODE 6: Device discovery completed
2019-11-18 11:38:03.467 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - NODE 6: Device discovery resolved to thingType zwave:shenzhen_nas-wr01ze_00_000
2019-11-18 11:38:03.893 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing 'zwave:device:f707659e:node6' to inbox.
2019-11-18 11:38:03.906 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - NODE 7: Device discovery completed
2019-11-18 11:38:03.916 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - NODE 7: Device discovery resolved to thingType zwave:heiman_hs1htz_00_000
2019-11-18 11:38:21.286 [DEBUG] [org.openhab.binding.zwave           ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.core.status.ConfigStatusProvider}={service.id=395, service.bundleid=217, service.scope=singleton} - org.openhab.binding.zwave
2019-11-18 11:38:21.327 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - Initializing ZWave thing handler zwave:device:f707659e:node6.
2019-11-18 11:38:21.347 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Controller status changed to ONLINE.
2019-11-18 11:38:21.350 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Controller is ONLINE. Starting device initialisation.
2019-11-18 11:38:21.718 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Updating node properties.
2019-11-18 11:38:21.749 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Updating node properties. MAN=600
2019-11-18 11:38:21.753 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Updating node properties. MAN=600. SET. Was 600
2019-11-18 11:38:21.756 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Properties synchronised
2019-11-18 11:38:23.095 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Update ASSOCIATION group_ZWaveAssociationGroup [index=1, name=Lifeline, profile1=0, profile2=1, associations=[node_1]]: Adding Controller (node_1)
2019-11-18 11:38:23.097 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Configuration synchronised
2019-11-18 11:38:23.942 [DEBUG] [ve.internal.protocol.ZWaveController] - Event listener added.
2019-11-18 11:38:23.946 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Initialising Thing Node...
2019-11-18 11:38:23.951 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Initialising cmd channel zwave:device:f707659e:node6:switch_binary for OnOffType
2019-11-18 11:38:23.955 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Initialising state channel zwave:device:f707659e:node6:switch_binary for OnOffType
2019-11-18 11:38:23.960 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Initialising cmd channel zwave:device:f707659e:node6:meter_voltage for DecimalType
2019-11-18 11:38:23.966 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Initialising state channel zwave:device:f707659e:node6:meter_voltage for DecimalType
2019-11-18 11:38:23.972 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Initialising cmd channel zwave:device:f707659e:node6:meter_current for DecimalType
2019-11-18 11:38:23.977 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Initialising state channel zwave:device:f707659e:node6:meter_current for DecimalType
2019-11-18 11:38:23.982 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Initialising cmd channel zwave:device:f707659e:node6:meter_kwh for DecimalType
2019-11-18 11:38:23.987 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Initialising state channel zwave:device:f707659e:node6:meter_kwh for DecimalType
2019-11-18 11:38:23.991 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Initialising cmd channel zwave:device:f707659e:node6:meter_watts for DecimalType
2019-11-18 11:38:23.996 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Initialising state channel zwave:device:f707659e:node6:meter_watts for DecimalType
2019-11-18 11:38:24.000 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Initialising cmd channel zwave:device:f707659e:node6:alarm_power for OnOffType
2019-11-18 11:38:24.005 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Initialising state channel zwave:device:f707659e:node6:alarm_power for OnOffType
2019-11-18 11:38:24.009 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Polling initialised at 1800 seconds - start in 853200 milliseconds.
2019-11-18 11:38:24.012 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Device initialisation complete.
2019-11-18 11:38:58.063 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - ZWave discovery: Stop zwave:serial_zstick:f707659e
2019-11-18 11:38:58.069 [DEBUG] [al.protocol.ZWaveInclusionController] - ZWave controller stopping inclusion at IncludeStart
2019-11-18 11:38:58.073 [DEBUG] [ol.serialmessage.AddNodeMessageClass] - Ending INCLUSION mode.
2019-11-18 11:38:58.077 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Added 98 to queue - size 1
2019-11-18 11:38:58.081 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-11-18 11:38:58.087 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 05 00 4A 05 4F FA 
2019-11-18 11:38:58.091 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 05 00 4A 05 4F FA 
2019-11-18 11:38:58.096 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2019-11-18 11:38:58.099 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 98: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 79
2019-11-18 11:38:58.099 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2019-11-18 11:38:58.111 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2019-11-18 11:38:58.116 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2019-11-18 11:38:58.119 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 98: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 79
2019-11-18 11:38:58.121 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2019-11-18 11:38:58.123 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-11-18 11:38:58.125 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2019-11-18 11:38:58.152 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 4A 4F 06 07 00 FC 
2019-11-18 11:38:58.159 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=AddNodeToNetwork[74], type=Request[0], dest=6, callback=79, payload=4F 06 07 00 
2019-11-18 11:38:58.165 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=AddNodeToNetwork[74], type=Request[0], dest=6, callback=79, payload=4F 06 07 00 
2019-11-18 11:38:58.167 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 98: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 79
2019-11-18 11:38:58.170 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2019-11-18 11:38:58.172 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 98: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 79
2019-11-18 11:38:58.174 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 98: (Callback 79)
2019-11-18 11:38:58.176 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2019-11-18 11:38:58.179 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 98: callback 79
2019-11-18 11:38:58.182 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=AddNodeToNetwork[74], type=Request[0], dest=6, callback=79, payload=4F 06 07 00 
2019-11-18 11:38:58.184 [DEBUG] [ol.serialmessage.AddNodeMessageClass] - Add Node: Done.
2019-11-18 11:38:58.187 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - NODE 7: Device discovered
2019-11-18 11:38:58.196 [DEBUG] [al.protocol.ZWaveInclusionController] - Inclusion event: Current state IncludeDone, new event IncludeDone
2019-11-18 11:38:58.198 [DEBUG] [ol.serialmessage.AddNodeMessageClass] - Ending INCLUSION mode.
2019-11-18 11:38:58.201 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Added 99 to queue - size 1
2019-11-18 11:38:58.203 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2019-11-18 11:38:58.206 [DEBUG] [al.protocol.ZWaveInclusionController] - ZWave controller end exclusion
2019-11-18 11:38:58.208 [DEBUG] [ve.internal.protocol.ZWaveController] - ZWaveController include done
2019-11-18 11:38:58.210 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 98: Advanced to DONE
2019-11-18 11:38:58.212 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Response processed after 113ms
2019-11-18 11:38:58.214 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: TID 98: Transaction completed
2019-11-18 11:38:58.216 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: notifyTransactionResponse TID:98 DONE
2019-11-18 11:38:58.219 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-11-18 11:38:58.224 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-11-18 11:38:58.228 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 05 00 4A 05 00 B5 
2019-11-18 11:38:58.232 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 05 00 4A 05 00 B5 
2019-11-18 11:38:58.234 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2019-11-18 11:38:58.236 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2019-11-18 11:38:58.236 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 99: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 0
2019-11-18 11:38:58.239 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2019-11-18 11:38:58.243 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2019-11-18 11:38:58.246 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 99: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 0
2019-11-18 11:38:58.250 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2019-11-18 11:38:58.253 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-11-18 11:38:58.256 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2019-11-18 11:39:03.240 [DEBUG] [sactionManager$ZWaveTransactionTimer] - NODE 255: TID 99: Timeout at state WAIT_REQUEST. 3 retries remaining.
2019-11-18 11:39:03.244 [DEBUG] [sactionManager$ZWaveTransactionTimer] - TID 99: Transaction is current transaction, so clearing!!!!!
2019-11-18 11:39:03.246 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 99: Transaction CANCELLED
2019-11-18 11:39:03.248 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: notifyTransactionResponse TID:99 CANCELLED
2019-11-18 11:39:03.251 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-11-18 11:40:08.334 [DEBUG] [g.zwave.internal.ZWaveConfigProvider] - getConfigDescriptions called
2019-11-18 11:40:10.192 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Channel zwave:device:f707659e:node6:switch_binary linked - polling started.
2019-11-18 11:40:21.533 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Command received zwave:device:f707659e:node6:switch_binary --> ON [OnOffType]
2019-11-18 11:40:21.537 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - NODE 6: Creating new message for application command SWITCH_BINARY_SET
2019-11-18 11:40:21.547 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: SECURITY NOT required on COMMAND_CLASS_SWITCH_BINARY
2019-11-18 11:40:21.551 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Command Class COMMAND_CLASS_SWITCH_BINARY is NOT required to be secured
2019-11-18 11:40:21.556 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Adding to device queue
2019-11-18 11:40:21.560 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Added 100 to queue - size 3
2019-11-18 11:40:21.564 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-11-18 11:40:21.570 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 06 03 25 01 FF 25 51 4C 
2019-11-18 11:40:21.576 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 6: Sending REQUEST Message = 01 0A 00 13 06 03 25 01 FF 25 51 4C 
2019-11-18 11:40:21.579 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2019-11-18 11:40:21.583 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2019-11-18 11:40:21.583 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 100: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 81
2019-11-18 11:40:21.586 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2019-11-18 11:40:21.589 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2019-11-18 11:40:21.591 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 100: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 81
2019-11-18 11:40:21.593 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2019-11-18 11:40:21.593 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2019-11-18 11:40:21.596 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-11-18 11:40:21.592 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Polling initialised at 1800 seconds - start in 1500 milliseconds.
2019-11-18 11:40:21.598 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2019-11-18 11:40:21.602 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2019-11-18 11:40:21.605 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2019-11-18 11:40:21.607 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 100: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 81
2019-11-18 11:40:21.609 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2019-11-18 11:40:21.611 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 100: [WAIT_RESPONSE] priority=Set, requiresResponse=true, callback: 81
2019-11-18 11:40:21.614 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2019-11-18 11:40:21.616 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 6: sentData successfully placed on stack.
2019-11-18 11:40:21.618 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 100: Advanced to WAIT_REQUEST
2019-11-18 11:40:21.620 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: TID 100: Transaction not completed
2019-11-18 11:40:21.622 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-11-18 11:40:21.625 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2019-11-18 11:40:21.658 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 51 00 00 08 B2 
2019-11-18 11:40:21.665 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=81, payload=51 00 00 08 
2019-11-18 11:40:21.670 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=81, payload=51 00 00 08 
2019-11-18 11:40:21.672 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 100: [WAIT_REQUEST] priority=Set, requiresResponse=true, callback: 81
2019-11-18 11:40:21.674 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2019-11-18 11:40:21.677 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 100: [WAIT_REQUEST] priority=Set, requiresResponse=true, callback: 81
2019-11-18 11:40:21.679 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 100: (Callback 81)
2019-11-18 11:40:21.680 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 06 03 25 03 FF 2E 
2019-11-18 11:40:21.682 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2019-11-18 11:40:21.684 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 100: callback 81
2019-11-18 11:40:21.688 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=81, payload=51 00 00 08 
2019-11-18 11:40:21.690 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 6: SendData Request. CallBack ID = 81, Status = Transmission complete and ACK received(0)
2019-11-18 11:40:21.693 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=0, payload=00 06 03 25 03 FF 
2019-11-18 11:40:21.693 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: resetResendCount initComplete=true isDead=false
2019-11-18 11:40:21.695 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 100: Transaction COMPLETED
2019-11-18 11:40:21.698 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Response processed after 114ms
2019-11-18 11:40:21.700 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: TID 100: Transaction completed
2019-11-18 11:40:21.702 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: notifyTransactionResponse TID:100 DONE
2019-11-18 11:40:21.708 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2019-11-18 11:40:21.712 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=0, payload=00 06 03 25 03 FF 
2019-11-18 11:40:21.714 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-11-18 11:40:21.717 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Application Command Request (ALIVE:DONE)
2019-11-18 11:40:21.719 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: resetResendCount initComplete=true isDead=false
2019-11-18 11:40:21.721 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Incoming command class COMMAND_CLASS_SWITCH_BINARY, endpoint 0
2019-11-18 11:40:21.724 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: SECURITY NOT required on COMMAND_CLASS_SWITCH_BINARY
2019-11-18 11:40:21.726 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Received COMMAND_CLASS_SWITCH_BINARY V1 SWITCH_BINARY_REPORT
2019-11-18 11:40:21.728 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - NODE 6: Switch Binary report, value = 255
2019-11-18 11:40:21.730 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2019-11-18 11:40:21.733 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_SWITCH_BINARY, value=255
2019-11-18 11:40:21.736 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Updating channel state zwave:device:f707659e:node6:switch_binary to ON [OnOffType]
2019-11-18 11:40:21.741 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Commands processed 1.
2019-11-18 11:40:21.744 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1d3fbc4.
2019-11-18 11:40:21.748 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-11-18 11:40:21.751 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-11-18 11:40:21.754 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-11-18 11:40:21.757 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-11-18 11:40:23.088 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Polling...
2019-11-18 11:40:23.092 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Polling zwave:device:f707659e:node6:switch_binary
2019-11-18 11:40:23.095 [DEBUG] [converter.ZWaveBinarySwitchConverter] - NODE 6: Generating poll message for COMMAND_CLASS_SWITCH_BINARY, endpoint 0
2019-11-18 11:40:23.098 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - NODE 6: Creating new message for application command SWITCH_BINARY_GET
2019-11-18 11:40:23.101 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: SECURITY NOT required on COMMAND_CLASS_SWITCH_BINARY
2019-11-18 11:40:23.105 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Command Class COMMAND_CLASS_SWITCH_BINARY is NOT required to be secured
2019-11-18 11:40:23.108 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Adding to device queue
2019-11-18 11:40:23.111 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Added 101 to queue - size 3
2019-11-18 11:40:23.115 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-11-18 11:40:23.120 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 06 02 25 02 25 52 B1 
2019-11-18 11:40:23.125 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 6: Sending REQUEST Message = 01 09 00 13 06 02 25 02 25 52 B1 
2019-11-18 11:40:23.128 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2019-11-18 11:40:23.130 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2019-11-18 11:40:23.132 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 101: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 82
2019-11-18 11:40:23.135 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2019-11-18 11:40:23.142 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2019-11-18 11:40:23.144 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2019-11-18 11:40:23.148 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 101: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 82
2019-11-18 11:40:23.151 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2019-11-18 11:40:23.152 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2019-11-18 11:40:23.154 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-11-18 11:40:23.159 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2019-11-18 11:40:23.164 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2019-11-18 11:40:23.167 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 101: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 82
2019-11-18 11:40:23.170 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 06 03 25 03 FF 2E 
2019-11-18 11:40:23.170 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2019-11-18 11:40:23.172 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 101: [WAIT_RESPONSE] priority=Get, requiresResponse=true, callback: 82
2019-11-18 11:40:23.175 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2019-11-18 11:40:23.178 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=0, payload=00 06 03 25 03 FF 
2019-11-18 11:40:23.178 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 6: sentData successfully placed on stack.
2019-11-18 11:40:23.181 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 101: Advanced to WAIT_REQUEST
2019-11-18 11:40:23.183 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: TID 101: Transaction not completed
2019-11-18 11:40:23.187 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=0, payload=00 06 03 25 03 FF 
2019-11-18 11:40:23.190 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 101: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 82
2019-11-18 11:40:23.192 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Application Command Request (ALIVE:DONE)
2019-11-18 11:40:23.195 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: resetResendCount initComplete=true isDead=false
2019-11-18 11:40:23.198 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Incoming command class COMMAND_CLASS_SWITCH_BINARY, endpoint 0
2019-11-18 11:40:23.201 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: SECURITY NOT required on COMMAND_CLASS_SWITCH_BINARY
2019-11-18 11:40:23.203 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Received COMMAND_CLASS_SWITCH_BINARY V1 SWITCH_BINARY_REPORT
2019-11-18 11:40:23.206 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - NODE 6: Switch Binary report, value = 255
2019-11-18 11:40:23.209 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2019-11-18 11:40:23.212 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_SWITCH_BINARY, value=255
2019-11-18 11:40:23.215 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Updating channel state zwave:device:f707659e:node6:switch_binary to ON [OnOffType]
2019-11-18 11:40:23.219 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Commands processed 1.
2019-11-18 11:40:23.223 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 52 00 00 09 B0 
2019-11-18 11:40:23.225 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1b8043a.
2019-11-18 11:40:23.228 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2019-11-18 11:40:23.230 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=82, payload=52 00 00 09 
2019-11-18 11:40:23.231 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2019-11-18 11:40:23.234 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-11-18 11:40:23.236 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2019-11-18 11:40:23.237 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 06 03 25 03 FF 2E 
2019-11-18 11:40:23.241 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=82, payload=52 00 00 09 
2019-11-18 11:40:23.244 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 101: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 82
2019-11-18 11:40:23.244 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=0, payload=00 06 03 25 03 FF 
2019-11-18 11:40:23.246 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2019-11-18 11:40:23.249 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 101: [WAIT_REQUEST] priority=Get, requiresResponse=true, callback: 82
2019-11-18 11:40:23.252 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 101: (Callback 82)
2019-11-18 11:40:23.254 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2019-11-18 11:40:23.257 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 101: callback 82
2019-11-18 11:40:23.260 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=82, payload=52 00 00 09 
2019-11-18 11:40:23.263 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 6: SendData Request. CallBack ID = 82, Status = Transmission complete and ACK received(0)
2019-11-18 11:40:23.266 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: resetResendCount initComplete=true isDead=false
2019-11-18 11:40:23.269 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 101: Advanced to WAIT_DATA
2019-11-18 11:40:23.272 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: TID 101: Transaction not completed
2019-11-18 11:40:23.275 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=0, payload=00 06 03 25 03 FF 
2019-11-18 11:40:23.277 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-11-18 11:40:23.280 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Application Command Request (ALIVE:DONE)
2019-11-18 11:40:23.282 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: resetResendCount initComplete=true isDead=false
2019-11-18 11:40:23.284 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Incoming command class COMMAND_CLASS_SWITCH_BINARY, endpoint 0
2019-11-18 11:40:23.286 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: SECURITY NOT required on COMMAND_CLASS_SWITCH_BINARY
2019-11-18 11:40:23.289 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Received COMMAND_CLASS_SWITCH_BINARY V1 SWITCH_BINARY_REPORT
2019-11-18 11:40:23.291 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - NODE 6: Switch Binary report, value = 255
2019-11-18 11:40:23.294 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2019-11-18 11:40:23.296 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_SWITCH_BINARY, value=255
2019-11-18 11:40:23.299 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Updating channel state zwave:device:f707659e:node6:switch_binary to ON [OnOffType]
2019-11-18 11:40:23.303 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Commands processed 1.
2019-11-18 11:40:23.305 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@fe680.
2019-11-18 11:40:23.308 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@fe680.
2019-11-18 11:40:23.311 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: notifyTransactionResponse TID:101 DONE
2019-11-18 11:40:23.320 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2019-11-18 11:40:23.324 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2019-11-18 11:40:23.327 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-11-18 11:40:23.329 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-11-18 11:40:23.332 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-11-18 11:40:26.766 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 14 00 04 00 06 0E 32 02 21 44 00 00 00 05 00 CD 00 00 00 05 7F 
2019-11-18 11:40:26.777 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=0, payload=00 06 0E 32 02 21 44 00 00 00 05 00 CD 00 00 00 05 
2019-11-18 11:40:26.783 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=0, payload=00 06 0E 32 02 21 44 00 00 00 05 00 CD 00 00 00 05 
2019-11-18 11:40:26.786 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-11-18 11:40:26.788 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Application Command Request (ALIVE:DONE)
2019-11-18 11:40:26.790 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: resetResendCount initComplete=true isDead=false
2019-11-18 11:40:26.793 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Incoming command class COMMAND_CLASS_METER, endpoint 0
2019-11-18 11:40:26.795 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: SECURITY NOT required on COMMAND_CLASS_METER
2019-11-18 11:40:26.798 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Received COMMAND_CLASS_METER V3 METER_REPORT
2019-11-18 11:40:26.799 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 14 00 04 00 06 0E 32 02 21 54 00 00 06 47 00 CD 00 00 00 00 2E 
2019-11-18 11:40:26.801 [DEBUG] [.commandclass.ZWaveMeterCommandClass] - NODE 6: Meter: Type=Electric(1), Scale=kWh(0), Value=0.05
2019-11-18 11:40:26.803 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got an event from Z-Wave network: ZWaveMeterValueEvent
2019-11-18 11:40:26.806 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_METER, value=0.05
2019-11-18 11:40:26.809 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Updating channel state zwave:device:f707659e:node6:meter_kwh to 0.05 [DecimalType]
2019-11-18 11:40:26.812 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Commands processed 1.
2019-11-18 11:40:26.812 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=0, payload=00 06 0E 32 02 21 54 00 00 06 47 00 CD 00 00 00 00 
2019-11-18 11:40:26.815 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@17e13b1.
2019-11-18 11:40:26.817 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-11-18 11:40:26.819 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-11-18 11:40:26.823 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 00 06 0A 32 02 A1 42 5A 3C 00 CD 00 00 9F 
2019-11-18 11:40:26.824 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=0, payload=00 06 0E 32 02 21 54 00 00 06 47 00 CD 00 00 00 00 
2019-11-18 11:40:26.827 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-11-18 11:40:26.829 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Application Command Request (ALIVE:DONE)
2019-11-18 11:40:26.832 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: resetResendCount initComplete=true isDead=false
2019-11-18 11:40:26.834 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=0, payload=00 06 0A 32 02 A1 42 5A 3C 00 CD 00 00 
2019-11-18 11:40:26.835 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Incoming command class COMMAND_CLASS_METER, endpoint 0
2019-11-18 11:40:26.838 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: SECURITY NOT required on COMMAND_CLASS_METER
2019-11-18 11:40:26.842 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Received COMMAND_CLASS_METER V3 METER_REPORT
2019-11-18 11:40:26.847 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 00 06 0A 32 02 A1 4A 00 0E 00 CD 00 00 FF 
2019-11-18 11:40:26.846 [DEBUG] [.commandclass.ZWaveMeterCommandClass] - NODE 6: Meter: Type=Electric(1), Scale=W(2), Value=16.07
2019-11-18 11:40:26.850 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got an event from Z-Wave network: ZWaveMeterValueEvent
2019-11-18 11:40:26.854 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_METER, value=16.07
2019-11-18 11:40:26.855 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 1<>127 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=0, payload=00 06 0A 32 02 A1 4A 00 0E 00 CD 00 00 
2019-11-18 11:40:26.858 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Updating channel state zwave:device:f707659e:node6:meter_watts to 16.07 [DecimalType]
2019-11-18 11:40:26.862 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Commands processed 1.
2019-11-18 11:40:26.865 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1c3df81.
2019-11-18 11:40:26.868 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-11-18 11:40:26.871 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-11-18 11:40:26.876 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (1): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=0, payload=00 06 0A 32 02 A1 42 5A 3C 00 CD 00 00 
2019-11-18 11:40:26.878 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-11-18 11:40:26.881 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Application Command Request (ALIVE:DONE)
2019-11-18 11:40:26.884 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: resetResendCount initComplete=true isDead=false
2019-11-18 11:40:26.886 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Incoming command class COMMAND_CLASS_METER, endpoint 0
2019-11-18 11:40:26.889 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: SECURITY NOT required on COMMAND_CLASS_METER
2019-11-18 11:40:26.891 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Received COMMAND_CLASS_METER V3 METER_REPORT
2019-11-18 11:40:26.894 [DEBUG] [.commandclass.ZWaveMeterCommandClass] - NODE 6: Meter: Type=Electric(1), Scale=V(4), Value=231
2019-11-18 11:40:26.897 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got an event from Z-Wave network: ZWaveMeterValueEvent
2019-11-18 11:40:26.899 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_METER, value=231
2019-11-18 11:40:26.902 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Updating channel state zwave:device:f707659e:node6:meter_voltage to 231 [DecimalType]
2019-11-18 11:40:26.905 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Commands processed 1.
2019-11-18 11:40:26.908 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@279e57.
2019-11-18 11:40:26.910 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-11-18 11:40:26.913 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-11-18 11:40:26.916 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=6, callback=0, payload=00 06 0A 32 02 A1 4A 00 0E 00 CD 00 00 
2019-11-18 11:40:26.918 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-11-18 11:40:26.920 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Application Command Request (ALIVE:DONE)
2019-11-18 11:40:26.923 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: resetResendCount initComplete=true isDead=false
2019-11-18 11:40:26.925 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: Incoming command class COMMAND_CLASS_METER, endpoint 0
2019-11-18 11:40:26.928 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 6: SECURITY NOT required on COMMAND_CLASS_METER
2019-11-18 11:40:26.930 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 6: Received COMMAND_CLASS_METER V3 METER_REPORT
2019-11-18 11:40:26.933 [DEBUG] [.commandclass.ZWaveMeterCommandClass] - NODE 6: Meter: Type=Electric(1), Scale=A(5), Value=0.14
2019-11-18 11:40:26.936 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got an event from Z-Wave network: ZWaveMeterValueEvent
2019-11-18 11:40:26.938 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Got a value event from Z-Wave network, endpoint=0, command class=COMMAND_CLASS_METER, value=0.14
2019-11-18 11:40:26.941 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 6: Updating channel state zwave:device:f707659e:node6:meter_current to 0.14 [DecimalType]
2019-11-18 11:40:26.944 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Commands processed 1.
2019-11-18 11:40:26.947 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 6: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1b740b5.
2019-11-18 11:40:26.949 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-11-18 11:40:26.951 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-11-18 11:40:26.954 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-11-18 11:40:26.956 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-11-18 11:40:44.595 [DEBUG] [al.protocol.ZWaveInclusionController] - ZWave inclusion controller finalised