Skip to content

Instantly share code, notes, and snippets.

@dominicdesu

dominicdesu/openhab.log Secret

Created September 24, 2016 21:16
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save dominicdesu/7a7482b3597fed22c19042a8b00a569a to your computer and use it in GitHub Desktop.
Save dominicdesu/7a7482b3597fed22c19042a8b00a569a to your computer and use it in GitHub Desktop.
Download ZIP
Raw
openhab.log
2016-09-24 22:45:35.070 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 3
2016-09-24 22:45:35.074 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 0C 02 25 02 25 09 E0
2016-09-24 22:45:35.076 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 12: Sending REQUEST Message = 01 09 00 13 0C 02 25 02 25 09 E0
2016-09-24 22:45:35.088 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8
2016-09-24 22:45:35.092 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2016-09-24 22:45:35.094 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8
2016-09-24 22:45:35.096 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8
2016-09-24 22:45:35.098 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Response[0x01], priority=High, dest=255, callback=0, payload=01
2016-09-24 22:45:35.100 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 12: Sent Data successfully placed on stack.
2016-09-24 22:45:35.104 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 09 00 00 02 E0
2016-09-24 22:45:35.108 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2016-09-24 22:45:35.111 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 09 00 00 02 00 00 EE
2016-09-24 22:45:35.114 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 09 00 00 02 00 00 EE
2016-09-24 22:45:35.115 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 0C 03 25 03 FF 24
2016-09-24 22:45:35.117 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=09 00 00 02
2016-09-24 22:45:35.125 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 12: SendData Request. CallBack ID = 9, Status = Transmission complete and ACK received(0)
2016-09-24 22:45:35.127 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 12: Starting initialisation from DONE
2016-09-24 22:45:35.128 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@163fede already registered
2016-09-24 22:45:35.131 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Get, dest=12, callback=9, payload=0C 02 25 02
2016-09-24 22:45:35.133 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=09 00 00 02
2016-09-24 22:45:35.135 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, callback id=9, expected=ApplicationCommandHandler, cancelled=false MISMATCH
2016-09-24 22:45:35.137 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2016-09-24 22:45:35.139 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 04 00 0C 03 25 03 FF 24
2016-09-24 22:45:35.143 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 04 00 0C 03 25 03 FF 24
2016-09-24 22:45:35.145 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 0C 03 25 03 FF
2016-09-24 22:45:35.147 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 12: Application Command Request (ALIVE:DONE)
2016-09-24 22:45:35.149 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 12: Starting initialisation from DONE
2016-09-24 22:45:35.150 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@163fede already registered
2016-09-24 22:45:35.152 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 12: Incoming command class SWITCH_BINARY
2016-09-24 22:45:35.153 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - Received Switch Binary Request for Node ID = 12
2016-09-24 22:45:35.154 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - NODE 12: Switch Binary report, value = 255
2016-09-24 22:45:35.156 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveCommandClassValueEvent
2016-09-24 22:45:35.157 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2016-09-24 22:45:35.159 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Got a value event from Z-Wave network, endpoint = 0, command class = SWITCH_BINARY, value = 255
2016-09-24 22:45:35.162 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Updating channel state zwave:device:a367f17a:node12:switch_binary to ON [OnOffType]
2016-09-24 22:45:35.165 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Get, dest=12, callback=9, payload=0C 02 25 02
2016-09-24 22:45:35.168 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 0C 03 25 03 FF
2016-09-24 22:45:35.169 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationCommandHandler, callback id=9, expected=ApplicationCommandHandler, cancelled=false transaction complete!
2016-09-24 22:45:35.170 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent
2016-09-24 22:45:35.171 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2016-09-24 22:45:35.173 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 12: Response processed after 94ms/3727ms.
2016-09-24 22:45:35.175 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 2
2016-09-24 22:45:35.177 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 0C 03 32 01 10 25 0A E5
2016-09-24 22:45:35.180 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 12: Sending REQUEST Message = 01 0A 00 13 0C 03 32 01 10 25 0A E5
2016-09-24 22:45:35.191 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8
2016-09-24 22:45:35.194 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2016-09-24 22:45:35.196 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8
2016-09-24 22:45:35.197 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8
2016-09-24 22:45:35.199 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Response[0x01], priority=High, dest=255, callback=0, payload=01
2016-09-24 22:45:35.200 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 12: Sent Data successfully placed on stack.
2016-09-24 22:45:35.205 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 0A 00 00 02 E3
2016-09-24 22:45:35.208 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2016-09-24 22:45:35.210 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 0A 00 00 02 00 00 ED
2016-09-24 22:45:35.211 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 0A 00 00 02 00 00 ED
2016-09-24 22:45:35.212 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=0A 00 00 02
2016-09-24 22:45:35.214 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 12: SendData Request. CallBack ID = 10, Status = Transmission complete and ACK received(0)
2016-09-24 22:45:35.215 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 12: Starting initialisation from DONE
2016-09-24 22:45:35.216 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@163fede already registered
2016-09-24 22:45:35.218 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Get, dest=12, callback=10, payload=0C 03 32 01 10
2016-09-24 22:45:35.219 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 14 00 04 00 0C 0E 32 02 21 34 00 00 00 23 00 01 00 00 00 21 CB
2016-09-24 22:45:35.219 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=0A 00 00 02
2016-09-24 22:45:35.221 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, callback id=10, expected=ApplicationCommandHandler, cancelled=false MISMATCH
2016-09-24 22:45:35.223 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2016-09-24 22:45:35.226 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 14 00 04 00 0C 0E 32 02 21 34 00 00 00 23 00 01 00 00 00 21 CB
2016-09-24 22:45:35.228 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 14 00 04 00 0C 0E 32 02 21 34 00 00 00 23 00 01 00 00 00 21 CB
2016-09-24 22:45:35.230 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 0C 0E 32 02 21 34 00 00 00 23 00 01 00 00 00 21
2016-09-24 22:45:35.231 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 12: Application Command Request (ALIVE:DONE)
2016-09-24 22:45:35.232 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 12: Starting initialisation from DONE
2016-09-24 22:45:35.233 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@163fede already registered
2016-09-24 22:45:35.234 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 12: Incoming command class METER
2016-09-24 22:45:35.235 [DEBUG] [.commandclass.ZWaveMeterCommandClass] - NODE 12: Received METER command V2
2016-09-24 22:45:35.236 [DEBUG] [.commandclass.ZWaveMeterCommandClass] - NODE 12: Meter: Type=Electric(1), Scale=W(2), Value=3.5
2016-09-24 22:45:35.237 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveMeterValueEvent
2016-09-24 22:45:35.238 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Got an event from Z-Wave network: ZWaveMeterValueEvent
2016-09-24 22:45:35.238 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Got a value event from Z-Wave network, endpoint = 0, command class = METER, value = 3.5
2016-09-24 22:45:35.240 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Updating channel state zwave:device:a367f17a:node12:meter_watts to 3.5 [DecimalType]
2016-09-24 22:45:35.241 [DEBUG] [ternal.converter.ZWaveMeterConverter] - Not the right scale E_KWh <> E_W
2016-09-24 22:45:35.243 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Get, dest=12, callback=10, payload=0C 03 32 01 10
2016-09-24 22:45:35.245 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 0C 0E 32 02 21 34 00 00 00 23 00 01 00 00 00 21
2016-09-24 22:45:35.246 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationCommandHandler, callback id=10, expected=ApplicationCommandHandler, cancelled=false transaction complete!
2016-09-24 22:45:35.247 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent
2016-09-24 22:45:35.247 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2016-09-24 22:45:35.248 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 12: Response processed after 67ms/3727ms.
2016-09-24 22:45:35.249 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 1
2016-09-24 22:45:35.251 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 0C 03 32 01 00 25 0B F4
2016-09-24 22:45:35.253 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 12: Sending REQUEST Message = 01 0A 00 13 0C 03 32 01 00 25 0B F4
2016-09-24 22:45:35.264 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8
2016-09-24 22:45:35.267 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2016-09-24 22:45:35.268 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8
2016-09-24 22:45:35.270 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8
2016-09-24 22:45:35.271 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Response[0x01], priority=High, dest=255, callback=0, payload=01
2016-09-24 22:45:35.272 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 12: Sent Data successfully placed on stack.
2016-09-24 22:45:35.279 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 0B 00 00 02 E2
2016-09-24 22:45:35.281 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2016-09-24 22:45:35.283 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 0B 00 00 02 00 00 EC
2016-09-24 22:45:35.284 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 0B 00 00 02 00 00 EC
2016-09-24 22:45:35.286 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=0B 00 00 02
2016-09-24 22:45:35.287 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 12: SendData Request. CallBack ID = 11, Status = Transmission complete and ACK received(0)
2016-09-24 22:45:35.288 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 12: Starting initialisation from DONE
2016-09-24 22:45:35.289 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@163fede already registered
2016-09-24 22:45:35.291 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Get, dest=12, callback=11, payload=0C 03 32 01 00
2016-09-24 22:45:35.293 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=0B 00 00 02
2016-09-24 22:45:35.293 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 14 00 04 00 0C 0E 32 02 21 84 00 00 E9 06 00 01 00 00 E9 06 79
2016-09-24 22:45:35.294 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, callback id=11, expected=ApplicationCommandHandler, cancelled=false MISMATCH
2016-09-24 22:45:35.298 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2016-09-24 22:45:35.300 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 14 00 04 00 0C 0E 32 02 21 84 00 00 E9 06 00 01 00 00 E9 06 79
2016-09-24 22:45:35.302 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 14 00 04 00 0C 0E 32 02 21 84 00 00 E9 06 00 01 00 00 E9 06 79
2016-09-24 22:45:35.304 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 0C 0E 32 02 21 84 00 00 E9 06 00 01 00 00 E9 06
2016-09-24 22:45:35.305 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 12: Application Command Request (ALIVE:DONE)
2016-09-24 22:45:35.306 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 12: Starting initialisation from DONE
2016-09-24 22:45:35.307 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@163fede already registered
2016-09-24 22:45:35.308 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 12: Incoming command class METER
2016-09-24 22:45:35.309 [DEBUG] [.commandclass.ZWaveMeterCommandClass] - NODE 12: Received METER command V2
2016-09-24 22:45:35.311 [DEBUG] [.commandclass.ZWaveMeterCommandClass] - NODE 12: Meter: Type=Electric(1), Scale=kWh(0), Value=5.9654
2016-09-24 22:45:35.312 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveMeterValueEvent
2016-09-24 22:45:35.313 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Got an event from Z-Wave network: ZWaveMeterValueEvent
2016-09-24 22:45:35.314 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Got a value event from Z-Wave network, endpoint = 0, command class = METER, value = 5.9654
2016-09-24 22:45:35.315 [DEBUG] [ternal.converter.ZWaveMeterConverter] - Not the right scale E_W <> E_KWh
2016-09-24 22:45:35.316 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Updating channel state zwave:device:a367f17a:node12:meter_kwh to 5.9654 [DecimalType]
2016-09-24 22:45:35.318 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Get, dest=12, callback=11, payload=0C 03 32 01 00
2016-09-24 22:45:35.320 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 0C 0E 32 02 21 84 00 00 E9 06 00 01 00 00 E9 06
2016-09-24 22:45:35.321 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationCommandHandler, callback id=11, expected=ApplicationCommandHandler, cancelled=false transaction complete!
2016-09-24 22:45:35.322 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent
2016-09-24 22:45:35.323 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2016-09-24 22:45:35.324 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 12: Response processed after 69ms/3727ms.
2016-09-24 22:45:35.325 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0
2016-09-24 22:45:35.327 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 0C 03 71 04 00 25 0C B5
2016-09-24 22:45:35.328 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 12: Sending REQUEST Message = 01 0A 00 13 0C 03 71 04 00 25 0C B5
2016-09-24 22:45:35.338 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8
2016-09-24 22:45:35.340 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2016-09-24 22:45:35.342 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8
2016-09-24 22:45:35.343 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8
2016-09-24 22:45:35.344 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Response[0x01], priority=High, dest=255, callback=0, payload=01
2016-09-24 22:45:35.345 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 12: Sent Data successfully placed on stack.
2016-09-24 22:45:35.353 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 0C 00 00 02 E5
2016-09-24 22:45:35.356 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2016-09-24 22:45:35.357 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 0C 00 00 02 00 00 EB
2016-09-24 22:45:35.359 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 0C 00 00 02 00 00 EB
2016-09-24 22:45:35.360 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=0C 00 00 02
2016-09-24 22:45:35.361 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 12: SendData Request. CallBack ID = 12, Status = Transmission complete and ACK received(0)
2016-09-24 22:45:35.362 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 12: Starting initialisation from DONE
2016-09-24 22:45:35.364 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@163fede already registered
2016-09-24 22:45:35.365 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Get, dest=12, callback=12, payload=0C 03 71 04 00
2016-09-24 22:45:35.366 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=0C 00 00 02
2016-09-24 22:45:35.368 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, callback id=12, expected=ApplicationCommandHandler, cancelled=false MISMATCH
2016-09-24 22:45:40.330 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 12: Timeout while sending message. Requeueing - 2 attempts left!
2016-09-24 22:45:40.332 [ERROR] [l.serialmessage.SendDataMessageClass] - NODE 12: Got an error while sending data. Resending message.
2016-09-24 22:45:40.334 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 1. Queue={}
2016-09-24 22:45:40.335 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0
2016-09-24 22:45:40.337 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 0C 03 71 04 00 25 10 A9
2016-09-24 22:45:40.340 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 12: Sending REQUEST Message = 01 0A 00 13 0C 03 71 04 00 25 10 A9
2016-09-24 22:45:40.351 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8
2016-09-24 22:45:40.353 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2016-09-24 22:45:40.355 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8
2016-09-24 22:45:40.357 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8
2016-09-24 22:45:40.358 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Response[0x01], priority=High, dest=255, callback=0, payload=01
2016-09-24 22:45:40.360 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 12: Sent Data successfully placed on stack.
2016-09-24 22:45:40.366 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 10 00 00 02 F9
2016-09-24 22:45:40.370 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2016-09-24 22:45:40.381 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 10 00 00 02 00 00 F7
2016-09-24 22:45:40.384 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 10 00 00 02 00 00 F7
2016-09-24 22:45:40.386 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=10 00 00 02
2016-09-24 22:45:40.388 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 12: SendData Request. CallBack ID = 16, Status = Transmission complete and ACK received(0)
2016-09-24 22:45:40.389 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 12: Starting initialisation from DONE
2016-09-24 22:45:40.390 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@163fede already registered
2016-09-24 22:45:40.392 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Get, dest=12, callback=16, payload=0C 03 71 04 00
2016-09-24 22:45:40.394 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=10 00 00 02
2016-09-24 22:45:40.396 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, callback id=16, expected=ApplicationCommandHandler, cancelled=false MISMATCH
2016-09-24 22:45:45.342 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 12: Timeout while sending message. Requeueing - 1 attempts left!
2016-09-24 22:45:45.345 [ERROR] [l.serialmessage.SendDataMessageClass] - NODE 12: Got an error while sending data. Resending message.
2016-09-24 22:45:45.346 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 1. Queue={}
2016-09-24 22:45:45.347 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0
2016-09-24 22:45:45.349 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 0C 03 71 04 00 25 11 A8
2016-09-24 22:45:45.351 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 12: Sending REQUEST Message = 01 0A 00 13 0C 03 71 04 00 25 11 A8
2016-09-24 22:45:45.362 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8
2016-09-24 22:45:45.364 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2016-09-24 22:45:45.366 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8
2016-09-24 22:45:45.367 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8
2016-09-24 22:45:45.368 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Response[0x01], priority=High, dest=255, callback=0, payload=01
2016-09-24 22:45:45.370 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 12: Sent Data successfully placed on stack.
2016-09-24 22:45:45.376 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 11 00 00 02 F8
2016-09-24 22:45:45.379 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2016-09-24 22:45:45.381 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 11 00 00 02 00 00 F6
2016-09-24 22:45:45.383 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 11 00 00 02 00 00 F6
2016-09-24 22:45:45.385 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=11 00 00 02
2016-09-24 22:45:45.386 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 12: SendData Request. CallBack ID = 17, Status = Transmission complete and ACK received(0)
2016-09-24 22:45:45.388 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 12: Starting initialisation from DONE
2016-09-24 22:45:45.389 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@163fede already registered
2016-09-24 22:45:45.391 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Get, dest=12, callback=17, payload=0C 03 71 04 00
2016-09-24 22:45:45.393 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=11 00 00 02
2016-09-24 22:45:45.395 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, callback id=17, expected=ApplicationCommandHandler, cancelled=false MISMATCH
2016-09-24 22:45:50.353 [ERROR] [ocol.ZWaveController$ZWaveSendThread] - NODE 12: Timeout while sending message. Requeueing - 0 attempts left!
2016-09-24 22:45:50.356 [ERROR] [l.serialmessage.SendDataMessageClass] - NODE 12: Got an error while sending data. Resending message.
2016-09-24 22:45:50.358 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 1. Queue={}
2016-09-24 22:45:50.359 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0
2016-09-24 22:45:50.360 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 0C 03 71 04 00 25 12 AB
2016-09-24 22:45:50.362 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 12: Sending REQUEST Message = 01 0A 00 13 0C 03 71 04 00 25 12 AB
2016-09-24 22:45:50.373 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8
2016-09-24 22:45:50.376 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2016-09-24 22:45:50.377 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8
2016-09-24 22:45:50.378 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8
2016-09-24 22:45:50.380 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Response[0x01], priority=High, dest=255, callback=0, payload=01
2016-09-24 22:45:50.381 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 12: Sent Data successfully placed on stack.
2016-09-24 22:45:50.387 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 12 00 00 02 FB
2016-09-24 22:45:50.389 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2016-09-24 22:45:50.391 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 12 00 00 02 00 00 F5
2016-09-24 22:45:50.393 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 12 00 00 02 00 00 F5
2016-09-24 22:45:50.394 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=12 00 00 02
2016-09-24 22:45:50.395 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 12: SendData Request. CallBack ID = 18, Status = Transmission complete and ACK received(0)
2016-09-24 22:45:50.397 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 12: Starting initialisation from DONE
2016-09-24 22:45:50.397 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@163fede already registered
2016-09-24 22:45:50.399 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Get, dest=12, callback=18, payload=0C 03 71 04 00
2016-09-24 22:45:50.400 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=12 00 00 02
2016-09-24 22:45:50.401 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, callback id=18, expected=ApplicationCommandHandler, cancelled=false MISMATCH
2016-09-24 22:45:55.365 [WARN ] [ocol.ZWaveController$ZWaveSendThread] - NODE 12: Too many retries. Discarding message: Message: class=SendData[0x13], type=Request[0x00], priority=Get, dest=12, callback=18, payload=0C 03 71 04 00
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment