2018-12-15 23:16:49.011 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 08 00 04 00 02 02 84 07 70 
2018-12-15 23:16:49.018 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 02 84 07 
2018-12-15 23:16:49.024 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 02 84 07 
2018-12-15 23:16:49.028 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2018-12-15 23:16:49.034 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Application Command Request (ALIVE:DONE)
2018-12-15 23:16:49.039 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2018-12-15 23:16:49.042 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Is awake with 6 messages in the queue
2018-12-15 23:16:49.045 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Start sleep timer at 1000ms
2018-12-15 23:16:49.047 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveNodeStatusEvent
2018-12-15 23:16:49.071 [DEBUG] [ve.internal.protocol.ZWaveController] - NODE 2: Node Status event - Node is AWAKE
2018-12-15 23:16:49.072 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Commands processed 1.
2018-12-15 23:16:49.074 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@cca3bf.
2018-12-15 23:16:49.079 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2018-12-15 23:16:49.082 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2018-12-15 23:16:49.085 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-12-15 23:16:49.087 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2018-12-15 23:16:49.090 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 02 02 30 02 25 28 DA 
2018-12-15 23:16:49.093 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 2: Sending REQUEST Message = 01 09 00 13 02 02 30 02 25 28 DA 
2018-12-15 23:16:49.095 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2018-12-15 23:16:49.098 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2018-12-15 23:16:49.098 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 139: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 40
2018-12-15 23:16:49.100 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2018-12-15 23:16:49.101 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2018-12-15 23:16:49.104 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 139: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 40
2018-12-15 23:16:49.105 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2018-12-15 23:16:49.107 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2018-12-15 23:16:49.107 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-12-15 23:16:49.110 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-12-15 23:16:49.112 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 139: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 40
2018-12-15 23:16:49.113 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2018-12-15 23:16:49.115 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 139: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 40
2018-12-15 23:16:49.117 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-12-15 23:16:49.119 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 28 00 00 02 C1 
2018-12-15 23:16:49.119 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 2: sentData successfully placed on stack.
2018-12-15 23:16:49.122 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 139: Advanced to WAIT_REQUEST
2018-12-15 23:16:49.124 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=40, payload=28 00 00 02 
2018-12-15 23:16:49.126 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: TID 139: Transaction not completed
2018-12-15 23:16:49.131 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 02 03 30 03 00 C0 
2018-12-15 23:16:49.129 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=40, payload=28 00 00 02 
2018-12-15 23:16:49.134 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 03 30 03 00 
2018-12-15 23:16:49.134 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 139: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 40
2018-12-15 23:16:49.136 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2018-12-15 23:16:49.139 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 139: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 40
2018-12-15 23:16:49.140 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 139: (Callback 40)
2018-12-15 23:16:49.142 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2018-12-15 23:16:49.144 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 139: callback 40
2018-12-15 23:16:49.146 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=40, payload=28 00 00 02 
2018-12-15 23:16:49.148 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 2: SendData Request. CallBack ID = 40, Status = Transmission complete and ACK received(0)
2018-12-15 23:16:49.151 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2018-12-15 23:16:49.152 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 139: Advanced to WAIT_DATA
2018-12-15 23:16:49.155 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: TID 139: Transaction not completed
2018-12-15 23:16:49.156 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 03 30 03 00 
2018-12-15 23:16:49.158 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2018-12-15 23:16:49.160 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Application Command Request (ALIVE:DONE)
2018-12-15 23:16:49.161 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2018-12-15 23:16:49.163 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Incoming command class COMMAND_CLASS_SENSOR_BINARY, endpoint 0
2018-12-15 23:16:49.164 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY NOT required on COMMAND_CLASS_SENSOR_BINARY
2018-12-15 23:16:49.166 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 2: Received COMMAND_CLASS_SENSOR_BINARY V1 SENSOR_BINARY_REPORT
2018-12-15 23:16:49.168 [DEBUG] [dclass.ZWaveBinarySensorCommandClass] - NODE 2: Sensor Binary report, type=Unknown, value=0
2018-12-15 23:16:49.169 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveBinarySensorValueEvent
2018-12-15 23:16:49.171 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_SENSOR_BINARY, value = 0
2018-12-15 23:16:49.173 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Updating channel state zwave:device:512:node2:sensor_binary to OFF [OnOffType]
2018-12-15 23:16:49.176 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Commands processed 1.
2018-12-15 23:16:49.178 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@78fbf0.
2018-12-15 23:16:49.179 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@78fbf0.
2018-12-15 23:16:49.181 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: notifyTransactionResponse TID:139 DONE
2018-12-15 23:16:49.187 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2018-12-15 23:16:49.188 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2018-12-15 23:16:49.190 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2018-12-15 23:16:49.191 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-12-15 23:16:49.193 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2018-12-15 23:16:49.195 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0B 00 13 02 04 31 04 01 00 25 29 D9 
2018-12-15 23:16:49.198 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 2: Sending REQUEST Message = 01 0B 00 13 02 04 31 04 01 00 25 29 D9 
2018-12-15 23:16:49.200 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2018-12-15 23:16:49.201 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 140: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 41
2018-12-15 23:16:49.202 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2018-12-15 23:16:49.204 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2018-12-15 23:16:49.206 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2018-12-15 23:16:49.208 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 140: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 41
2018-12-15 23:16:49.209 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2018-12-15 23:16:49.210 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2018-12-15 23:16:49.210 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-12-15 23:16:49.212 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2018-12-15 23:16:49.214 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-12-15 23:16:49.216 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-12-15 23:16:49.218 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 140: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 41
2018-12-15 23:16:49.219 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2018-12-15 23:16:49.221 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 140: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 41
2018-12-15 23:16:49.222 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-12-15 23:16:49.224 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 2: sentData successfully placed on stack.
2018-12-15 23:16:49.225 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 140: Advanced to WAIT_REQUEST
2018-12-15 23:16:49.225 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 29 00 00 02 C0 
2018-12-15 23:16:49.227 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: TID 140: Transaction not completed
2018-12-15 23:16:49.229 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-12-15 23:16:49.230 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2018-12-15 23:16:49.230 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=41, payload=29 00 00 02 
2018-12-15 23:16:49.233 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=41, payload=29 00 00 02 
2018-12-15 23:16:49.235 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 140: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 41
2018-12-15 23:16:49.237 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2018-12-15 23:16:49.237 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0C 00 04 00 02 06 31 05 01 22 00 C9 2D 
2018-12-15 23:16:49.238 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 140: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 41
2018-12-15 23:16:49.240 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 06 31 05 01 22 00 C9 
2018-12-15 23:16:49.240 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 140: (Callback 41)
2018-12-15 23:16:49.242 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2018-12-15 23:16:49.244 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 140: callback 41
2018-12-15 23:16:49.245 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=41, payload=29 00 00 02 
2018-12-15 23:16:49.247 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 2: SendData Request. CallBack ID = 41, Status = Transmission complete and ACK received(0)
2018-12-15 23:16:49.249 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2018-12-15 23:16:49.251 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 140: Advanced to WAIT_DATA
2018-12-15 23:16:49.252 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: TID 140: Transaction not completed
2018-12-15 23:16:49.255 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 06 31 05 01 22 00 C9 
2018-12-15 23:16:49.256 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2018-12-15 23:16:49.258 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Application Command Request (ALIVE:DONE)
2018-12-15 23:16:49.260 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2018-12-15 23:16:49.262 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Incoming command class COMMAND_CLASS_SENSOR_MULTILEVEL, endpoint 0
2018-12-15 23:16:49.263 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY NOT required on COMMAND_CLASS_SENSOR_MULTILEVEL
2018-12-15 23:16:49.265 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 2: Received COMMAND_CLASS_SENSOR_MULTILEVEL V8 SENSOR_MULTILEVEL_REPORT
2018-12-15 23:16:49.266 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 2: Sensor Type = Temperature(1), Scale = 0
2018-12-15 23:16:49.268 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 2: Sensor Value = 20.1
2018-12-15 23:16:49.269 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveMultiLevelSensorValueEvent
2018-12-15 23:16:49.271 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_SENSOR_MULTILEVEL, value = 20.1
2018-12-15 23:16:49.273 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Updating channel state zwave:device:512:node2:sensor_temperature to 20.1 °C [QuantityType]
2018-12-15 23:16:49.278 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Commands processed 1.
2018-12-15 23:16:49.280 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@15526e4.
2018-12-15 23:16:49.281 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@15526e4.
2018-12-15 23:16:49.283 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: notifyTransactionResponse TID:140 DONE
2018-12-15 23:16:49.287 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2018-12-15 23:16:49.288 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2018-12-15 23:16:49.290 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2018-12-15 23:16:49.291 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-12-15 23:16:49.292 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2018-12-15 23:16:49.294 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0B 00 13 02 04 31 04 19 00 25 2A C2 
2018-12-15 23:16:49.296 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 2: Sending REQUEST Message = 01 0B 00 13 02 04 31 04 19 00 25 2A C2 
2018-12-15 23:16:49.298 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2018-12-15 23:16:49.299 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 141: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 42
2018-12-15 23:16:49.300 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2018-12-15 23:16:49.301 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2018-12-15 23:16:49.303 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2018-12-15 23:16:49.304 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 141: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 42
2018-12-15 23:16:49.306 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2018-12-15 23:16:49.307 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2018-12-15 23:16:49.307 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-12-15 23:16:49.308 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2018-12-15 23:16:49.309 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-12-15 23:16:49.310 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-12-15 23:16:49.312 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 141: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 42
2018-12-15 23:16:49.314 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2018-12-15 23:16:49.315 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 141: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 42
2018-12-15 23:16:49.317 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-12-15 23:16:49.319 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 2: sentData successfully placed on stack.
2018-12-15 23:16:49.320 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 141: Advanced to WAIT_REQUEST
2018-12-15 23:16:49.322 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: TID 141: Transaction not completed
2018-12-15 23:16:49.323 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 2A 00 00 02 C3 
2018-12-15 23:16:49.324 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-12-15 23:16:49.325 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=42, payload=2A 00 00 02 
2018-12-15 23:16:49.326 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2018-12-15 23:16:49.328 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=42, payload=2A 00 00 02 
2018-12-15 23:16:49.330 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 141: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 42
2018-12-15 23:16:49.331 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2018-12-15 23:16:49.333 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 141: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 42
2018-12-15 23:16:49.334 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0B 00 04 00 02 05 31 05 19 21 00 FB 
2018-12-15 23:16:49.334 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 141: (Callback 42)
2018-12-15 23:16:49.336 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2018-12-15 23:16:49.337 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 05 31 05 19 21 00 
2018-12-15 23:16:49.338 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 141: callback 42
2018-12-15 23:16:49.341 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=42, payload=2A 00 00 02 
2018-12-15 23:16:49.342 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 2: SendData Request. CallBack ID = 42, Status = Transmission complete and ACK received(0)
2018-12-15 23:16:49.344 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2018-12-15 23:16:49.346 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 141: Advanced to WAIT_DATA
2018-12-15 23:16:49.348 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: TID 141: Transaction not completed
2018-12-15 23:16:49.350 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 05 31 05 19 21 00 
2018-12-15 23:16:49.352 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2018-12-15 23:16:49.353 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Application Command Request (ALIVE:DONE)
2018-12-15 23:16:49.355 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2018-12-15 23:16:49.357 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Incoming command class COMMAND_CLASS_SENSOR_MULTILEVEL, endpoint 0
2018-12-15 23:16:49.359 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY NOT required on COMMAND_CLASS_SENSOR_MULTILEVEL
2018-12-15 23:16:49.360 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 2: Received COMMAND_CLASS_SENSOR_MULTILEVEL V8 SENSOR_MULTILEVEL_REPORT
2018-12-15 23:16:49.362 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 2: Sensor Type = SeismicIntensity(25), Scale = 0
2018-12-15 23:16:49.364 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 2: Sensor Value = 0E+1
2018-12-15 23:16:49.366 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveMultiLevelSensorValueEvent
2018-12-15 23:16:49.368 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_SENSOR_MULTILEVEL, value = 0E+1
2018-12-15 23:16:49.370 [DEBUG] [erter.ZWaveMultiLevelSensorConverter] - NODE 2: Sensor conversion not performed for SEISMIC_INTENSITY.
2018-12-15 23:16:49.372 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Updating channel state zwave:device:512:node2:sensor_seismicintensity to 0 [DecimalType]
2018-12-15 23:16:49.377 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Commands processed 1.
2018-12-15 23:16:49.378 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@e0b83f.
2018-12-15 23:16:49.380 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@e0b83f.
2018-12-15 23:16:49.383 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: notifyTransactionResponse TID:141 DONE
2018-12-15 23:16:49.385 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2018-12-15 23:16:49.386 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2018-12-15 23:16:49.390 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2018-12-15 23:16:49.391 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-12-15 23:16:49.393 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2018-12-15 23:16:49.395 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0B 00 13 02 04 31 04 03 00 25 2B D9 
2018-12-15 23:16:49.397 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 2: Sending REQUEST Message = 01 0B 00 13 02 04 31 04 03 00 25 2B D9 
2018-12-15 23:16:49.399 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2018-12-15 23:16:49.400 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 142: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 43
2018-12-15 23:16:49.401 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2018-12-15 23:16:49.404 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2018-12-15 23:16:49.405 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2018-12-15 23:16:49.407 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 142: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 43
2018-12-15 23:16:49.408 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2018-12-15 23:16:49.408 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2018-12-15 23:16:49.410 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-12-15 23:16:49.411 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-12-15 23:16:49.412 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2018-12-15 23:16:49.414 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-12-15 23:16:49.416 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 142: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 43
2018-12-15 23:16:49.417 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2018-12-15 23:16:49.419 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 142: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 43
2018-12-15 23:16:49.421 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-12-15 23:16:49.422 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 2: sentData successfully placed on stack.
2018-12-15 23:16:49.424 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 142: Advanced to WAIT_REQUEST
2018-12-15 23:16:49.424 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 2B 00 00 02 C2 
2018-12-15 23:16:49.425 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: TID 142: Transaction not completed
2018-12-15 23:16:49.426 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=43, payload=2B 00 00 02 
2018-12-15 23:16:49.427 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-12-15 23:16:49.428 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2018-12-15 23:16:49.430 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=43, payload=2B 00 00 02 
2018-12-15 23:16:49.431 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 142: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 43
2018-12-15 23:16:49.433 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2018-12-15 23:16:49.434 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 142: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 43
2018-12-15 23:16:49.435 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0C 00 04 00 02 06 31 05 03 0A 00 00 CE 
2018-12-15 23:16:49.436 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 142: (Callback 43)
2018-12-15 23:16:49.437 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2018-12-15 23:16:49.439 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 142: callback 43
2018-12-15 23:16:49.439 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 06 31 05 03 0A 00 00 
2018-12-15 23:16:49.440 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=43, payload=2B 00 00 02 
2018-12-15 23:16:49.442 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 2: SendData Request. CallBack ID = 43, Status = Transmission complete and ACK received(0)
2018-12-15 23:16:49.444 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2018-12-15 23:16:49.445 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 142: Advanced to WAIT_DATA
2018-12-15 23:16:49.446 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: TID 142: Transaction not completed
2018-12-15 23:16:49.448 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 06 31 05 03 0A 00 00 
2018-12-15 23:16:49.450 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2018-12-15 23:16:49.451 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Application Command Request (ALIVE:DONE)
2018-12-15 23:16:49.452 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2018-12-15 23:16:49.454 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Incoming command class COMMAND_CLASS_SENSOR_MULTILEVEL, endpoint 0
2018-12-15 23:16:49.455 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY NOT required on COMMAND_CLASS_SENSOR_MULTILEVEL
2018-12-15 23:16:49.456 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 2: Received COMMAND_CLASS_SENSOR_MULTILEVEL V8 SENSOR_MULTILEVEL_REPORT
2018-12-15 23:16:49.458 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 2: Sensor Type = Luminance(3), Scale = 1
2018-12-15 23:16:49.459 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 2: Sensor Value = 0E+1
2018-12-15 23:16:49.461 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveMultiLevelSensorValueEvent
2018-12-15 23:16:49.463 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_SENSOR_MULTILEVEL, value = 0E+1
2018-12-15 23:16:49.466 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Updating channel state zwave:device:512:node2:sensor_luminance to 0E+1 % [QuantityType]
2018-12-15 23:16:49.469 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Commands processed 1.
2018-12-15 23:16:49.471 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1c83c87.
2018-12-15 23:16:49.473 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1c83c87.
2018-12-15 23:16:49.474 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: notifyTransactionResponse TID:142 DONE
2018-12-15 23:16:49.478 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2018-12-15 23:16:49.481 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2018-12-15 23:16:49.482 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2018-12-15 23:16:49.484 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-12-15 23:16:49.485 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2018-12-15 23:16:49.487 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 02 02 80 02 25 2C 6E 
2018-12-15 23:16:49.488 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 2: Sending REQUEST Message = 01 09 00 13 02 02 80 02 25 2C 6E 
2018-12-15 23:16:49.490 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2018-12-15 23:16:49.491 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 143: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 44
2018-12-15 23:16:49.493 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2018-12-15 23:16:49.494 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2018-12-15 23:16:49.496 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2018-12-15 23:16:49.498 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2018-12-15 23:16:49.498 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 143: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 44
2018-12-15 23:16:49.500 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2018-12-15 23:16:49.501 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-12-15 23:16:49.502 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-12-15 23:16:49.504 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2018-12-15 23:16:49.506 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-12-15 23:16:49.508 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 143: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 44
2018-12-15 23:16:49.510 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2018-12-15 23:16:49.512 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 143: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 44
2018-12-15 23:16:49.515 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 2C 00 00 02 C5 
2018-12-15 23:16:49.514 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-12-15 23:16:49.518 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 2: sentData successfully placed on stack.
2018-12-15 23:16:49.518 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=44, payload=2C 00 00 02 
2018-12-15 23:16:49.521 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 143: Advanced to WAIT_REQUEST
2018-12-15 23:16:49.523 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: TID 143: Transaction not completed
2018-12-15 23:16:49.526 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=44, payload=2C 00 00 02 
2018-12-15 23:16:49.527 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 02 03 80 03 64 14 
2018-12-15 23:16:49.529 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 143: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 44
2018-12-15 23:16:49.531 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 03 80 03 64 
2018-12-15 23:16:49.532 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2018-12-15 23:16:49.535 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 143: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 44
2018-12-15 23:16:49.537 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 143: (Callback 44)
2018-12-15 23:16:49.540 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2018-12-15 23:16:49.542 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 143: callback 44
2018-12-15 23:16:49.545 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=44, payload=2C 00 00 02 
2018-12-15 23:16:49.547 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 2: SendData Request. CallBack ID = 44, Status = Transmission complete and ACK received(0)
2018-12-15 23:16:49.548 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: WakeupTimerTask 2 Messages waiting, state DONE
2018-12-15 23:16:49.550 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2018-12-15 23:16:49.552 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 143: Advanced to WAIT_DATA
2018-12-15 23:16:49.554 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: TID 143: Transaction not completed
2018-12-15 23:16:49.557 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 03 80 03 64 
2018-12-15 23:16:49.559 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2018-12-15 23:16:49.561 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Application Command Request (ALIVE:DONE)
2018-12-15 23:16:49.563 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2018-12-15 23:16:49.565 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Incoming command class COMMAND_CLASS_BATTERY, endpoint 0
2018-12-15 23:16:49.568 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY NOT required on COMMAND_CLASS_BATTERY
2018-12-15 23:16:49.570 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 2: Received COMMAND_CLASS_BATTERY V1 BATTERY_REPORT
2018-12-15 23:16:49.572 [DEBUG] [ommandclass.ZWaveBatteryCommandClass] - NODE 2: Battery report value = 100
2018-12-15 23:16:49.575 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2018-12-15 23:16:49.577 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_BATTERY, value = 100
2018-12-15 23:16:49.580 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Updating channel state zwave:device:512:node2:battery-level to 100 [DecimalType]
2018-12-15 23:16:49.588 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Commands processed 1.
2018-12-15 23:16:49.594 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@caf175.
2018-12-15 23:16:49.596 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@caf175.
2018-12-15 23:16:49.599 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: notifyTransactionResponse TID:143 DONE
2018-12-15 23:16:49.604 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2018-12-15 23:16:49.606 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2018-12-15 23:16:49.608 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2018-12-15 23:16:49.611 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-12-15 23:16:49.612 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2018-12-15 23:16:49.615 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 02 03 9C 01 00 25 2D 72 
2018-12-15 23:16:49.617 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 2: Sending REQUEST Message = 01 0A 00 13 02 03 9C 01 00 25 2D 72 
2018-12-15 23:16:49.619 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2018-12-15 23:16:49.621 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2018-12-15 23:16:49.621 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 144: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 45
2018-12-15 23:16:49.623 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2018-12-15 23:16:49.625 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2018-12-15 23:16:49.628 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 144: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 45
2018-12-15 23:16:49.628 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2018-12-15 23:16:49.630 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2018-12-15 23:16:49.631 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-12-15 23:16:49.632 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-12-15 23:16:49.634 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2018-12-15 23:16:49.636 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-12-15 23:16:49.638 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 144: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 45
2018-12-15 23:16:49.640 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2018-12-15 23:16:49.642 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 144: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 45
2018-12-15 23:16:49.643 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-12-15 23:16:49.644 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 2D 00 00 02 C4 
2018-12-15 23:16:49.646 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=45, payload=2D 00 00 02 
2018-12-15 23:16:49.649 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 2: sentData successfully placed on stack.
2018-12-15 23:16:49.651 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 144: Advanced to WAIT_REQUEST
2018-12-15 23:16:49.653 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: TID 144: Transaction not completed
2018-12-15 23:16:49.655 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=45, payload=2D 00 00 02 
2018-12-15 23:16:49.655 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0D 00 04 00 02 07 9C 02 02 00 00 00 00 6F 
2018-12-15 23:16:49.657 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 144: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 45
2018-12-15 23:16:49.658 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 07 9C 02 02 00 00 00 00 
2018-12-15 23:16:49.659 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2018-12-15 23:16:49.661 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 144: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 45
2018-12-15 23:16:49.663 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 144: (Callback 45)
2018-12-15 23:16:49.665 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2018-12-15 23:16:49.666 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 144: callback 45
2018-12-15 23:16:49.668 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=45, payload=2D 00 00 02 
2018-12-15 23:16:49.670 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 2: SendData Request. CallBack ID = 45, Status = Transmission complete and ACK received(0)
2018-12-15 23:16:49.672 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2018-12-15 23:16:49.673 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 144: Advanced to WAIT_DATA
2018-12-15 23:16:49.675 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: TID 144: Transaction not completed
2018-12-15 23:16:49.677 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 07 9C 02 02 00 00 00 00 
2018-12-15 23:16:49.678 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2018-12-15 23:16:49.680 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Application Command Request (ALIVE:DONE)
2018-12-15 23:16:49.682 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2018-12-15 23:16:49.683 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Incoming command class COMMAND_CLASS_SENSOR_ALARM, endpoint 0
2018-12-15 23:16:49.685 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY NOT required on COMMAND_CLASS_SENSOR_ALARM
2018-12-15 23:16:49.687 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 2: Received COMMAND_CLASS_SENSOR_ALARM V1 SENSOR_ALARM_REPORT
2018-12-15 23:16:49.689 [DEBUG] [ndclass.ZWaveAlarmSensorCommandClass] - NODE 2: Alarm Report: Source=2, Type=General(0), Value=0
2018-12-15 23:16:49.691 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveAlarmSensorValueEvent
2018-12-15 23:16:49.693 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_SENSOR_ALARM, value = 0
2018-12-15 23:16:49.694 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Updating channel state zwave:device:512:node2:alarm_general to OFF [OnOffType]
2018-12-15 23:16:49.699 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Commands processed 1.
2018-12-15 23:16:49.702 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1e8f626.
2018-12-15 23:16:49.704 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1e8f626.
2018-12-15 23:16:49.706 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: notifyTransactionResponse TID:144 DONE
2018-12-15 23:16:49.720 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2018-12-15 23:16:49.722 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2018-12-15 23:16:49.723 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2018-12-15 23:16:49.725 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-12-15 23:16:49.726 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2018-12-15 23:16:50.048 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: WakeupTimerTask 0 Messages waiting, state DONE
2018-12-15 23:16:50.547 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: WakeupTimerTask 0 Messages waiting, state DONE
2018-12-15 23:16:50.550 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: No more messages, go back to sleep
2018-12-15 23:16:50.553 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 2: Creating new message for application command WAKE_UP_NO_MORE_INFORMATION
2018-12-15 23:16:50.555 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY NOT required on COMMAND_CLASS_WAKE_UP
2018-12-15 23:16:50.558 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Command Class COMMAND_CLASS_WAKE_UP is NOT required to be secured
2018-12-15 23:16:50.560 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: sendTransaction org.openhab.binding.zwave.internal.protocol.transaction.ZWaveCommandClassTransactionPayload@196b0d5
2018-12-15 23:16:50.564 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Bump transaction 145 priority from Immediate to Immediate
2018-12-15 23:16:50.567 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Adding to device queue
2018-12-15 23:16:50.571 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Added 145 to queue - size 1
2018-12-15 23:16:50.573 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2018-12-15 23:16:50.577 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 02 02 84 08 25 2E 62 
2018-12-15 23:16:50.580 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 2: Sending REQUEST Message = 01 09 00 13 02 02 84 08 25 2E 62 
2018-12-15 23:16:50.584 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2018-12-15 23:16:50.586 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 145: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 46
2018-12-15 23:16:50.586 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2018-12-15 23:16:50.589 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2018-12-15 23:16:50.592 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2018-12-15 23:16:50.595 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 145: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 46
2018-12-15 23:16:50.597 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2018-12-15 23:16:50.597 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2018-12-15 23:16:50.600 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-12-15 23:16:50.602 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-12-15 23:16:50.602 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2018-12-15 23:16:50.605 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-12-15 23:16:50.608 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 145: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 46
2018-12-15 23:16:50.609 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 2E 00 00 02 C7 
2018-12-15 23:16:50.610 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2018-12-15 23:16:50.613 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=46, payload=2E 00 00 02 
2018-12-15 23:16:50.613 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 145: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 46
2018-12-15 23:16:50.616 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01 
2018-12-15 23:16:50.618 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 2: sentData successfully placed on stack.
2018-12-15 23:16:50.621 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 145: Advanced to WAIT_REQUEST
2018-12-15 23:16:50.623 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: TID 145: Transaction not completed
2018-12-15 23:16:50.626 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=46, payload=2E 00 00 02 
2018-12-15 23:16:50.628 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 145: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 46
2018-12-15 23:16:50.631 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2018-12-15 23:16:50.633 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 145: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 46
2018-12-15 23:16:50.635 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 145: (Callback 46)
2018-12-15 23:16:50.638 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2018-12-15 23:16:50.640 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 145: callback 46
2018-12-15 23:16:50.643 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=46, payload=2E 00 00 02 
2018-12-15 23:16:50.646 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 2: SendData Request. CallBack ID = 46, Status = Transmission complete and ACK received(0)
2018-12-15 23:16:50.648 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: resetResendCount initComplete=true isDead=false
2018-12-15 23:16:50.651 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 145: Transaction COMPLETED
2018-12-15 23:16:50.653 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Response processed after 67ms
2018-12-15 23:16:50.656 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: TID 145: Transaction completed
2018-12-15 23:16:50.658 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: notifyTransactionResponse TID:145 DONE
2018-12-15 23:16:50.660 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2018-12-15 23:16:50.660 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 145: Transaction event listener: DONE: DONE -> 
2018-12-15 23:16:50.666 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Went to sleep COMPLETE
2018-12-15 23:16:50.661 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2018-12-15 23:16:50.667 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2018-12-15 23:24:01.287 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Polling...
2018-12-15 23:24:01.292 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Polling zwave:device:512:node2:sensor_binary
2018-12-15 23:24:01.295 [DEBUG] [converter.ZWaveBinarySensorConverter] - NODE 2: Generating poll message for COMMAND_CLASS_SENSOR_BINARY, endpoint 0
2018-12-15 23:24:01.298 [DEBUG] [dclass.ZWaveBinarySensorCommandClass] - NODE 2: Creating new message for application command SENSOR_BINARY_GET
2018-12-15 23:24:01.302 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY NOT required on COMMAND_CLASS_SENSOR_BINARY
2018-12-15 23:24:01.305 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Command Class COMMAND_CLASS_SENSOR_BINARY is NOT required to be secured
2018-12-15 23:24:01.308 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Polling skipped for zwave:device:512:node2:sensor_binary on COMMAND_CLASS_BASIC
2018-12-15 23:24:01.311 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Polling zwave:device:512:node2:sensor_temperature
2018-12-15 23:24:01.315 [DEBUG] [erter.ZWaveMultiLevelSensorConverter] - NODE 2: Generating poll message for COMMAND_CLASS_SENSOR_MULTILEVEL, endpoint 0
2018-12-15 23:24:01.318 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 2: Creating new message for command SENSOR_MULTILEVEL_GET
2018-12-15 23:24:01.321 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY NOT required on COMMAND_CLASS_SENSOR_MULTILEVEL
2018-12-15 23:24:01.324 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Command Class COMMAND_CLASS_SENSOR_MULTILEVEL is NOT required to be secured
2018-12-15 23:24:01.328 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Polling zwave:device:512:node2:sensor_seismicintensity
2018-12-15 23:24:01.331 [DEBUG] [erter.ZWaveMultiLevelSensorConverter] - NODE 2: Generating poll message for COMMAND_CLASS_SENSOR_MULTILEVEL, endpoint 0
2018-12-15 23:24:01.334 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 2: Creating new message for command SENSOR_MULTILEVEL_GET
2018-12-15 23:24:01.337 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY NOT required on COMMAND_CLASS_SENSOR_MULTILEVEL
2018-12-15 23:24:01.341 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Command Class COMMAND_CLASS_SENSOR_MULTILEVEL is NOT required to be secured
2018-12-15 23:24:01.344 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Polling zwave:device:512:node2:sensor_luminance
2018-12-15 23:24:01.347 [DEBUG] [erter.ZWaveMultiLevelSensorConverter] - NODE 2: Generating poll message for COMMAND_CLASS_SENSOR_MULTILEVEL, endpoint 0
2018-12-15 23:24:01.350 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 2: Creating new message for command SENSOR_MULTILEVEL_GET
2018-12-15 23:24:01.353 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY NOT required on COMMAND_CLASS_SENSOR_MULTILEVEL
2018-12-15 23:24:01.357 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Command Class COMMAND_CLASS_SENSOR_MULTILEVEL is NOT required to be secured
2018-12-15 23:24:01.360 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Polling zwave:device:512:node2:alarm_motion
2018-12-15 23:24:01.363 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Polling zwave:device:512:node2:alarm_tamper
2018-12-15 23:24:01.365 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Polling zwave:device:512:node2:battery-level
2018-12-15 23:24:01.367 [DEBUG] [rnal.converter.ZWaveBatteryConverter] - NODE 2: Generating poll message for COMMAND_CLASS_BATTERY endpoint 0
2018-12-15 23:24:01.369 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY NOT required on COMMAND_CLASS_BATTERY
2018-12-15 23:24:01.370 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Command Class COMMAND_CLASS_BATTERY is NOT required to be secured
2018-12-15 23:24:01.372 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Polling zwave:device:512:node2:alarm_general
2018-12-15 23:24:01.374 [DEBUG] [.converter.ZWaveAlarmSensorConverter] - NODE 2: Generating poll message for COMMAND_CLASS_SENSOR_ALARM, endpoint 0, alarm null
2018-12-15 23:24:01.376 [DEBUG] [ndclass.ZWaveAlarmSensorCommandClass] - NODE 2: Creating new message for command SENSOR_ALARM_GET, type General
2018-12-15 23:24:01.378 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY NOT required on COMMAND_CLASS_SENSOR_ALARM
2018-12-15 23:24:01.380 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Command Class COMMAND_CLASS_SENSOR_ALARM is NOT required to be secured
2018-12-15 23:24:01.382 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Bump transaction 146 priority from Get to Immediate
2018-12-15 23:24:01.384 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Adding to device queue
2018-12-15 23:24:01.385 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Added 146 to queue - size 1
2018-12-15 23:24:01.387 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2018-12-15 23:24:01.389 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Bump transaction 147 priority from Get to Immediate
2018-12-15 23:24:01.390 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Adding to device queue
2018-12-15 23:24:01.392 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Added 147 to queue - size 2
2018-12-15 23:24:01.393 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2018-12-15 23:24:01.395 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Bump transaction 148 priority from Get to Immediate
2018-12-15 23:24:01.396 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Adding to device queue
2018-12-15 23:24:01.398 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Added 148 to queue - size 3
2018-12-15 23:24:01.399 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2018-12-15 23:24:01.401 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Bump transaction 149 priority from Get to Immediate
2018-12-15 23:24:01.402 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Adding to device queue
2018-12-15 23:24:01.404 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Added 149 to queue - size 4
2018-12-15 23:24:01.405 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2018-12-15 23:24:01.407 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Bump transaction 150 priority from Get to Immediate
2018-12-15 23:24:01.408 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Adding to device queue
2018-12-15 23:24:01.410 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Added 150 to queue - size 5
2018-12-15 23:24:01.411 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2018-12-15 23:24:01.413 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Bump transaction 151 priority from Get to Immediate
2018-12-15 23:24:01.415 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Adding to device queue
2018-12-15 23:24:01.416 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Added 151 to queue - size 6
2018-12-15 23:24:01.418 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2018-12-15 23:54:01.287 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Polling...
2018-12-15 23:54:01.293 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Polling zwave:device:512:node2:sensor_binary
2018-12-15 23:54:01.298 [DEBUG] [converter.ZWaveBinarySensorConverter] - NODE 2: Generating poll message for COMMAND_CLASS_SENSOR_BINARY, endpoint 0
2018-12-15 23:54:01.302 [DEBUG] [dclass.ZWaveBinarySensorCommandClass] - NODE 2: Creating new message for application command SENSOR_BINARY_GET
2018-12-15 23:54:01.306 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY NOT required on COMMAND_CLASS_SENSOR_BINARY
2018-12-15 23:54:01.310 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Command Class COMMAND_CLASS_SENSOR_BINARY is NOT required to be secured
2018-12-15 23:54:01.315 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Polling skipped for zwave:device:512:node2:sensor_binary on COMMAND_CLASS_BASIC
2018-12-15 23:54:01.319 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Polling zwave:device:512:node2:sensor_temperature
2018-12-15 23:54:01.323 [DEBUG] [erter.ZWaveMultiLevelSensorConverter] - NODE 2: Generating poll message for COMMAND_CLASS_SENSOR_MULTILEVEL, endpoint 0
2018-12-15 23:54:01.327 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 2: Creating new message for command SENSOR_MULTILEVEL_GET
2018-12-15 23:54:01.331 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY NOT required on COMMAND_CLASS_SENSOR_MULTILEVEL
2018-12-15 23:54:01.334 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Command Class COMMAND_CLASS_SENSOR_MULTILEVEL is NOT required to be secured
2018-12-15 23:54:01.339 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Polling zwave:device:512:node2:sensor_seismicintensity
2018-12-15 23:54:01.341 [DEBUG] [erter.ZWaveMultiLevelSensorConverter] - NODE 2: Generating poll message for COMMAND_CLASS_SENSOR_MULTILEVEL, endpoint 0
2018-12-15 23:54:01.343 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 2: Creating new message for command SENSOR_MULTILEVEL_GET
2018-12-15 23:54:01.346 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY NOT required on COMMAND_CLASS_SENSOR_MULTILEVEL
2018-12-15 23:54:01.348 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Command Class COMMAND_CLASS_SENSOR_MULTILEVEL is NOT required to be secured
2018-12-15 23:54:01.350 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Polling zwave:device:512:node2:sensor_luminance
2018-12-15 23:54:01.352 [DEBUG] [erter.ZWaveMultiLevelSensorConverter] - NODE 2: Generating poll message for COMMAND_CLASS_SENSOR_MULTILEVEL, endpoint 0
2018-12-15 23:54:01.355 [DEBUG] [ss.ZWaveMultiLevelSensorCommandClass] - NODE 2: Creating new message for command SENSOR_MULTILEVEL_GET
2018-12-15 23:54:01.357 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY NOT required on COMMAND_CLASS_SENSOR_MULTILEVEL
2018-12-15 23:54:01.359 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Command Class COMMAND_CLASS_SENSOR_MULTILEVEL is NOT required to be secured
2018-12-15 23:54:01.361 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Polling zwave:device:512:node2:alarm_motion
2018-12-15 23:54:01.363 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Polling zwave:device:512:node2:alarm_tamper
2018-12-15 23:54:01.365 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Polling zwave:device:512:node2:battery-level
2018-12-15 23:54:01.368 [DEBUG] [rnal.converter.ZWaveBatteryConverter] - NODE 2: Generating poll message for COMMAND_CLASS_BATTERY endpoint 0
2018-12-15 23:54:01.370 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY NOT required on COMMAND_CLASS_BATTERY
2018-12-15 23:54:01.372 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Command Class COMMAND_CLASS_BATTERY is NOT required to be secured
2018-12-15 23:54:01.374 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Polling zwave:device:512:node2:alarm_general
2018-12-15 23:54:01.377 [DEBUG] [.converter.ZWaveAlarmSensorConverter] - NODE 2: Generating poll message for COMMAND_CLASS_SENSOR_ALARM, endpoint 0, alarm null
2018-12-15 23:54:01.379 [DEBUG] [ndclass.ZWaveAlarmSensorCommandClass] - NODE 2: Creating new message for command SENSOR_ALARM_GET, type General
2018-12-15 23:54:01.381 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY NOT required on COMMAND_CLASS_SENSOR_ALARM
2018-12-15 23:54:01.383 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Command Class COMMAND_CLASS_SENSOR_ALARM is NOT required to be secured
2018-12-15 23:54:01.385 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Bump transaction 152 priority from Get to Immediate
2018-12-15 23:54:01.387 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Adding to device queue
2018-12-15 23:54:01.389 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Transaction already in queue - removed original
2018-12-15 23:54:01.391 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Added 152 to queue - size 6
2018-12-15 23:54:01.394 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2018-12-15 23:54:01.396 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Bump transaction 153 priority from Get to Immediate
2018-12-15 23:54:01.398 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Adding to device queue
2018-12-15 23:54:01.400 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Transaction already in queue - removed original
2018-12-15 23:54:01.402 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Added 153 to queue - size 6
2018-12-15 23:54:01.404 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2018-12-15 23:54:01.407 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Bump transaction 154 priority from Get to Immediate
2018-12-15 23:54:01.409 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Adding to device queue
2018-12-15 23:54:01.411 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Transaction already in queue - removed original
2018-12-15 23:54:01.413 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Added 154 to queue - size 6
2018-12-15 23:54:01.415 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2018-12-15 23:54:01.417 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Bump transaction 155 priority from Get to Immediate
2018-12-15 23:54:01.419 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Adding to device queue
2018-12-15 23:54:01.421 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Transaction already in queue - removed original
2018-12-15 23:54:01.422 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Added 155 to queue - size 6
2018-12-15 23:54:01.424 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2018-12-15 23:54:01.426 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Bump transaction 156 priority from Get to Immediate
2018-12-15 23:54:01.429 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Adding to device queue
2018-12-15 23:54:01.430 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Transaction already in queue - removed original
2018-12-15 23:54:01.432 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Added 156 to queue - size 6
2018-12-15 23:54:01.433 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2018-12-15 23:54:01.435 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Bump transaction 157 priority from Get to Immediate
2018-12-15 23:54:01.437 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Adding to device queue
2018-12-15 23:54:01.438 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Transaction already in queue - removed original
2018-12-15 23:54:01.440 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Added 157 to queue - size 6
2018-12-15 23:54:01.441 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.