Skip to content

Instantly share code, notes, and snippets.

@holmes

holmes/family_room_not_working.log

Created July 1, 2017 15:52
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 holmes/a223ccf12ffe739e2e294644c385fa31 to your computer and use it in GitHub Desktop.
Save holmes/a223ccf12ffe739e2e294644c385fa31 to your computer and use it in GitHub Desktop.
Download ZIP
Raw
family_room_not_working.log
08:07:16.133 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 19 00 49 84 04 13 04 11 01 5E 86 72 5A 85 59 73 26 27 70 2C 2B 5B 7A EF 5B 94
08:07:16.133 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
08:07:16.134 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 19 00 49 84 04 13 04 11 01 5E 86 72 5A 85 59 73 26 27 70 2C 2B 5B 7A EF 5B 94
08:07:16.134 [INFO ] [marthome.event.ItemStateChangedEvent] - zwave_serial_zstick_d2ae07db_serial_sof changed from 3428 to 3429
08:07:16.134 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 19 00 49 84 04 13 04 11 01 5E 86 72 5A 85 59 73 26 27 70 2C 2B 5B 7A EF 5B 94
08:07:16.134 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationUpdate[0x49], type=Request[0x00], priority=High, dest=255, callback=0, payload=84 04 13 04 11 01 5E 86 72 5A 85 59 73 26 27 70 2C 2B 5B 7A EF 5B
08:07:16.134 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 4: Application update request. Node information received.
08:07:16.134 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 4: Starting initialisation from DONE
08:07:16.134 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@764801 already registered
08:07:16.134 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Set, dest=4, callback=109, payload=04 03 26 01 00
08:07:16.135 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=ApplicationUpdate[0x49], type=Request[0x00], priority=High, dest=255, callback=0, payload=84 04 13 04 11 01 5E 86 72 5A 85 59 73 26 27 70 2C 2B 5B 7A EF 5B
08:07:16.135 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationUpdate, callback id=109, expected=SendData, cancelled=false MISMATCH
08:07:16.154 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0B 00 04 00 04 05 5B 03 6A 00 01 C2
08:07:16.155 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
08:07:16.155 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0B 00 04 00 04 05 5B 03 6A 00 01 C2
08:07:16.155 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 0B 00 04 00 04 05 5B 03 6A 00 01 C2
08:07:16.156 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 04 05 5B 03 6A 00 01
08:07:16.156 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 4: Application Command Request (ALIVE:DONE)
08:07:16.156 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 4: Starting initialisation from DONE
08:07:16.156 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@764801 already registered
08:07:16.156 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 4: Incoming command class CENTRAL_SCENE
08:07:16.156 [DEBUG] [dclass.ZWaveCentralSceneCommandClass] - NODE 4: Received CENTRAL_SCENE command V2
08:07:16.156 [DEBUG] [dclass.ZWaveCentralSceneCommandClass] - NODE 4: Received scene 1 at key 0 [Single Press]
08:07:16.156 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveCommandClassValueEvent
08:07:16.156 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
08:07:16.156 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got a value event from Z-Wave network, endpoint = 0, command class = CENTRAL_SCENE, value = 1.0
08:07:16.156 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Updating channel state zwave:device:d2ae07db:node4:scene_number to 1.0 [DecimalType]
08:07:16.156 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Set, dest=4, callback=109, payload=04 03 26 01 00
08:07:16.157 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 04 05 5B 03 6A 00 01
08:07:16.157 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationCommandHandler, callback id=109, expected=SendData, cancelled=false MISMATCH
08:07:16.157 [INFO ] [marthome.event.ItemStateChangedEvent] - family_room_dimmer_scene changed from 2.0 to 1.0
08:07:16.158 [INFO ] [marthome.event.ItemStateChangedEvent] - zwave_serial_zstick_d2ae07db_serial_sof changed from 3429 to 3430
08:07:16.163 [INFO ] [e.smarthome.model.script.RULE.DIMMER] - Family Room Single Tap: ON
08:07:16.166 [INFO ] [smarthome.event.ItemCommandEvent ] - Item 'family_room_dimmer_proxy' received command ON
08:07:16.168 [INFO ] [marthome.event.ItemStateChangedEvent] - family_room_dimmer_proxy changed from OFF to ON
08:07:16.170 [INFO ] [.smarthome.model.script.RULE.TOGGLER] - Family Room Dimmer Switch is currently at: 0
08:07:16.179 [INFO ] [.smarthome.model.script.RULE.TOGGLER] - About to set Family Room Dimmer Switch to 35
08:07:16.180 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Command received zwave:device:d2ae07db:node4:switch_dimmer --> 35
08:07:16.180 [INFO ] [.smarthome.model.script.RULE.TOGGLER] - Set Family Room Dimmer Switch to 35
08:07:16.180 [DEBUG] [ss.ZWaveMultiLevelSwitchCommandClass] - NODE 4: Creating new message for command SWITCH_MULTILEVEL_SET
08:07:16.181 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 1. Queue={}
08:07:16.181 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0
08:07:16.181 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 04 03 26 01 23 25 6E AE
08:07:16.181 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 4: Sending REQUEST Message = 01 0A 00 13 04 03 26 01 23 25 6E AE
08:07:16.186 [INFO ] [smarthome.event.ItemCommandEvent ] - Item 'family_room_dimmer' received command 35
08:07:16.189 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8
08:07:16.189 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
08:07:16.189 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8
08:07:16.190 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8
08:07:16.190 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Response[0x01], priority=High, dest=255, callback=0, payload=01
08:07:16.190 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 4: Sent Data successfully placed on stack.
08:07:16.190 [INFO ] [marthome.event.ItemStateChangedEvent] - family_room_dimmer changed from 0 to 35
08:07:16.191 [INFO ] [ome.event.GroupItemStateChangedEvent] - Dimmers changed from 0 to UNDEF through family_room_dimmer
08:07:16.192 [INFO ] [marthome.event.ItemStateChangedEvent] - zwave_serial_zstick_d2ae07db_serial_ack changed from 1121 to 1122
08:07:16.193 [INFO ] [marthome.event.ItemStateChangedEvent] - zwave_serial_zstick_d2ae07db_serial_sof changed from 3430 to 3431
08:07:16.265 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 05 00 13 6E 00 87
08:07:16.265 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
08:07:16.266 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 07 00 13 6E 00 00 00 85
08:07:16.266 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 07 00 13 6E 00 00 00 85
08:07:16.266 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=6E 00
08:07:16.266 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 4: SendData Request. CallBack ID = 110, Status = Transmission complete and ACK received(0)
08:07:16.266 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 4: Starting initialisation from DONE
08:07:16.266 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@764801 already registered
08:07:16.266 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Set, dest=4, callback=110, payload=04 03 26 01 23
08:07:16.266 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=6E 00
08:07:16.266 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, callback id=110, expected=SendData, cancelled=false transaction complete!
08:07:16.266 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent
08:07:16.266 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
08:07:16.267 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 4: Response processed after 85ms/1189ms.
08:07:16.268 [INFO ] [marthome.event.ItemStateChangedEvent] - zwave_serial_zstick_d2ae07db_serial_sof changed from 3431 to 3432
08:07:17.136 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 04 03 26 03 23 F3
08:07:17.137 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
08:07:17.137 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 04 00 04 03 26 03 23 F3
08:07:17.137 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 04 00 04 03 26 03 23 F3
08:07:17.137 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 04 03 26 03 23
08:07:17.137 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 4: Application Command Request (ALIVE:DONE)
08:07:17.137 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 4: Starting initialisation from DONE
08:07:17.137 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@764801 already registered
08:07:17.138 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 4: Incoming command class SWITCH_MULTILEVEL
08:07:17.138 [DEBUG] [ss.ZWaveMultiLevelSwitchCommandClass] - NODE 4: Received SWITCH_MULTILEVEL command V1
08:07:17.138 [DEBUG] [ss.ZWaveMultiLevelSwitchCommandClass] - NODE 4: Switch Multi Level report, value = 35
08:07:17.138 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveCommandClassValueEvent
08:07:17.138 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
08:07:17.138 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got a value event from Z-Wave network, endpoint = 0, command class = SWITCH_MULTILEVEL, value = 35
08:07:17.138 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Updating channel state zwave:device:d2ae07db:node4:switch_dimmer to 35 [PercentType]
08:07:17.138 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Set, dest=4, callback=110, payload=04 03 26 01 23
08:07:17.138 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 04 03 26 03 23
08:07:17.138 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationCommandHandler, callback id=110, expected=SendData, cancelled=false MISMATCH
08:07:17.140 [INFO ] [marthome.event.ItemStateChangedEvent] - zwave_serial_zstick_d2ae07db_serial_sof changed from 3432 to 3433
08:07:24.475 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 19 00 49 84 04 13 04 11 01 5E 86 72 5A 85 59 73 26 27 70 2C 2B 5B 7A EF 5B 94
08:07:24.476 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
08:07:24.476 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 19 00 49 84 04 13 04 11 01 5E 86 72 5A 85 59 73 26 27 70 2C 2B 5B 7A EF 5B 94
08:07:24.476 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 19 00 49 84 04 13 04 11 01 5E 86 72 5A 85 59 73 26 27 70 2C 2B 5B 7A EF 5B 94
08:07:24.476 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationUpdate[0x49], type=Request[0x00], priority=High, dest=255, callback=0, payload=84 04 13 04 11 01 5E 86 72 5A 85 59 73 26 27 70 2C 2B 5B 7A EF 5B
08:07:24.476 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 4: Application update request. Node information received.
08:07:24.476 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 4: Starting initialisation from DONE
08:07:24.476 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@764801 already registered
08:07:24.476 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Set, dest=4, callback=110, payload=04 03 26 01 23
08:07:24.477 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=ApplicationUpdate[0x49], type=Request[0x00], priority=High, dest=255, callback=0, payload=84 04 13 04 11 01 5E 86 72 5A 85 59 73 26 27 70 2C 2B 5B 7A EF 5B
08:07:24.477 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationUpdate, callback id=110, expected=SendData, cancelled=false MISMATCH
08:07:24.477 [INFO ] [marthome.event.ItemStateChangedEvent] - zwave_serial_zstick_d2ae07db_serial_sof changed from 3433 to 3434
08:07:24.496 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0B 00 04 00 04 05 5B 03 6B 00 01 C3
08:07:24.497 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
08:07:24.497 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0B 00 04 00 04 05 5B 03 6B 00 01 C3
08:07:24.497 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 0B 00 04 00 04 05 5B 03 6B 00 01 C3
08:07:24.498 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 04 05 5B 03 6B 00 01
08:07:24.498 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 4: Application Command Request (ALIVE:DONE)
08:07:24.498 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 4: Starting initialisation from DONE
08:07:24.498 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@764801 already registered
08:07:24.498 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 4: Incoming command class CENTRAL_SCENE
08:07:24.498 [DEBUG] [dclass.ZWaveCentralSceneCommandClass] - NODE 4: Received CENTRAL_SCENE command V2
08:07:24.498 [DEBUG] [dclass.ZWaveCentralSceneCommandClass] - NODE 4: Received scene 1 at key 0 [Single Press]
08:07:24.498 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveCommandClassValueEvent
08:07:24.498 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
08:07:24.498 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got a value event from Z-Wave network, endpoint = 0, command class = CENTRAL_SCENE, value = 1.0
08:07:24.498 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Updating channel state zwave:device:d2ae07db:node4:scene_number to 1.0 [DecimalType]
08:07:24.499 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Set, dest=4, callback=110, payload=04 03 26 01 23
08:07:24.499 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 04 05 5B 03 6B 00 01
08:07:24.499 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationCommandHandler, callback id=110, expected=SendData, cancelled=false MISMATCH
08:07:24.501 [INFO ] [marthome.event.ItemStateChangedEvent] - zwave_serial_zstick_d2ae07db_serial_sof changed from 3434 to 3435
08:07:24.505 [INFO ] [e.smarthome.model.script.RULE.DIMMER] - Family Room Single Tap: ON
08:07:24.507 [INFO ] [smarthome.event.ItemCommandEvent ] - Item 'family_room_dimmer_proxy' received command ON
08:07:24.510 [INFO ] [.smarthome.model.script.RULE.TOGGLER] - Family Room Dimmer Switch is currently at: 35
08:07:24.518 [INFO ] [.smarthome.model.script.RULE.TOGGLER] - About to set Family Room Dimmer Switch to 85
08:07:24.519 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Command received zwave:device:d2ae07db:node4:switch_dimmer --> 85
08:07:24.519 [INFO ] [.smarthome.model.script.RULE.TOGGLER] - Set Family Room Dimmer Switch to 85
08:07:24.520 [DEBUG] [ss.ZWaveMultiLevelSwitchCommandClass] - NODE 4: Creating new message for command SWITCH_MULTILEVEL_SET
08:07:24.520 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 1. Queue={}
08:07:24.520 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0
08:07:24.520 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 04 03 26 01 55 25 6F D9
08:07:24.520 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 4: Sending REQUEST Message = 01 0A 00 13 04 03 26 01 55 25 6F D9
08:07:24.522 [INFO ] [smarthome.event.ItemCommandEvent ] - Item 'family_room_dimmer' received command 85
08:07:24.523 [INFO ] [marthome.event.ItemStateChangedEvent] - zwave_serial_zstick_d2ae07db_serial_ack changed from 1122 to 1123
08:07:24.526 [INFO ] [marthome.event.ItemStateChangedEvent] - family_room_dimmer changed from 35 to 85
08:07:24.528 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8
08:07:24.529 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
08:07:24.529 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8
08:07:24.529 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8
08:07:24.529 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Response[0x01], priority=High, dest=255, callback=0, payload=01
08:07:24.529 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 4: Sent Data successfully placed on stack.
08:07:24.530 [INFO ] [marthome.event.ItemStateChangedEvent] - zwave_serial_zstick_d2ae07db_serial_sof changed from 3435 to 3436
08:07:24.544 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 04 03 26 03 23 F3
08:07:24.545 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
08:07:24.545 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 04 00 04 03 26 03 23 F3
08:07:24.545 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 04 00 04 03 26 03 23 F3
08:07:24.545 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 04 03 26 03 23
08:07:24.545 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 4: Application Command Request (ALIVE:DONE)
08:07:24.545 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 4: Starting initialisation from DONE
08:07:24.545 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@764801 already registered
08:07:24.546 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 4: Incoming command class SWITCH_MULTILEVEL
08:07:24.546 [DEBUG] [ss.ZWaveMultiLevelSwitchCommandClass] - NODE 4: Received SWITCH_MULTILEVEL command V1
08:07:24.546 [DEBUG] [ss.ZWaveMultiLevelSwitchCommandClass] - NODE 4: Switch Multi Level report, value = 35
08:07:24.546 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveCommandClassValueEvent
08:07:24.546 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
08:07:24.546 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got a value event from Z-Wave network, endpoint = 0, command class = SWITCH_MULTILEVEL, value = 35
08:07:24.546 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Updating channel state zwave:device:d2ae07db:node4:switch_dimmer to 35 [PercentType]
08:07:24.546 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Set, dest=4, callback=111, payload=04 03 26 01 55
08:07:24.546 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 04 03 26 03 23
08:07:24.546 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationCommandHandler, callback id=111, expected=SendData, cancelled=false MISMATCH
08:07:24.547 [INFO ] [marthome.event.ItemStateChangedEvent] - zwave_serial_zstick_d2ae07db_serial_sof changed from 3436 to 3437
08:07:24.549 [INFO ] [marthome.event.ItemStateChangedEvent] - family_room_dimmer changed from 85 to 35
08:07:24.670 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 05 00 13 6F 00 86
08:07:24.671 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
08:07:24.671 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 07 00 13 6F 00 00 00 84
08:07:24.671 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 07 00 13 6F 00 00 00 84
08:07:24.671 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=6F 00
08:07:24.671 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 4: SendData Request. CallBack ID = 111, Status = Transmission complete and ACK received(0)
08:07:24.671 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 4: Starting initialisation from DONE
08:07:24.671 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@764801 already registered
08:07:24.672 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Set, dest=4, callback=111, payload=04 03 26 01 55
08:07:24.672 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=6F 00
08:07:24.672 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, callback id=111, expected=SendData, cancelled=false transaction complete!
08:07:24.672 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent
08:07:24.672 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
08:07:24.675 [INFO ] [marthome.event.ItemStateChangedEvent] - zwave_serial_zstick_d2ae07db_serial_sof changed from 3437 to 3438
08:07:24.676 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 4: Response processed after 155ms/1189ms.
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment