Simple z-wave switch task generates a lot of traffic using ZHC5010

andreasbrinch · May 1, 2019, 7:33pm

My z-wave setup only includes a single device, a ZHC5010 switch/relay and it is setup with openhab 2.4 within docker without modifications. I have configured four switch items. When pressing the button it works, but sometimes it takes a long time. I tried pushing one of the switches four times with about half a minute in between. The log shows trafic for much longer than I would expect. The fastest takes around 700ms which I guess is acceptable, but the other three tries shows entries for 4, 13 and 13 seconds. Sometimes, it can take even longer. Is this setup wrongly or a faulty device? It looks like the device is sending many messages for a single press.

This is the log for a single press. I wasn’t allowed to post the full log, so I have cut out the middle:

2019-05-01 20:26:30.415 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0F 00 04 00 04 09 60 0D 00 01 5B 03 B3 00 01 7F 
2019-05-01 20:26:30.417 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 09 60 0D 00 01 5B 03 B3 00 01 
2019-05-01 20:26:30.418 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 09 60 0D 00 01 5B 03 B3 00 01 
2019-05-01 20:26:30.419 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-05-01 20:26:30.419 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Application Command Request (ALIVE:ASSOCIATIONS)
2019-05-01 20:26:30.419 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2019-05-01 20:26:30.420 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Incoming command class COMMAND_CLASS_CENTRAL_SCENE, endpoint 0
2019-05-01 20:26:30.421 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: SECURITY not supported
2019-05-01 20:26:30.421 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 4: Received COMMAND_CLASS_CENTRAL_SCENE V2 CENTRAL_SCENE_NOTIFICATION
2019-05-01 20:26:30.424 [DEBUG] [dclass.ZWaveCentralSceneCommandClass] - NODE 4: Received scene 1 at key 0 [Single Press]
2019-05-01 20:26:30.425 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2019-05-01 20:26:30.425 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_CENTRAL_SCENE, value = 1.0
2019-05-01 20:26:30.426 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Updating channel state zwave:device:c7543ef2:node4:scene_number to 1.0 [DecimalType]
2019-05-01 20:26:30.426 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Commands processed 1.
2019-05-01 20:26:30.427 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@24f4b5f.
2019-05-01 20:26:30.427 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:30.427 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:30.428 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-05-01 20:26:30.428 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-05-01 20:26:30.439 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0F 00 04 00 04 09 60 0D 00 01 5B 03 B3 00 01 7F 
2019-05-01 20:26:30.445 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 09 60 0D 00 01 5B 03 B3 00 01 
2019-05-01 20:26:30.446 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 09 60 0D 00 01 5B 03 B3 00 01 
2019-05-01 20:26:30.446 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-05-01 20:26:30.447 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Application Command Request (ALIVE:ASSOCIATIONS)
2019-05-01 20:26:30.447 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2019-05-01 20:26:30.453 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Incoming command class COMMAND_CLASS_CENTRAL_SCENE, endpoint 0
2019-05-01 20:26:30.453 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: SECURITY not supported
2019-05-01 20:26:30.454 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 4: Received COMMAND_CLASS_CENTRAL_SCENE V2 CENTRAL_SCENE_NOTIFICATION
2019-05-01 20:26:30.454 [DEBUG] [dclass.ZWaveCentralSceneCommandClass] - NODE 4: Received scene 1 at key 0 [Single Press]
2019-05-01 20:26:30.454 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2019-05-01 20:26:30.455 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_CENTRAL_SCENE, value = 1.0
2019-05-01 20:26:30.459 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Updating channel state zwave:device:c7543ef2:node4:scene_number to 1.0 [DecimalType]
2019-05-01 20:26:30.460 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Commands processed 1.
2019-05-01 20:26:30.460 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@5ac9bf0e.
2019-05-01 20:26:30.460 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:30.461 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:30.461 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-05-01 20:26:30.461 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-05-01 20:26:30.494 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0F 00 04 00 04 09 60 0D 00 01 5B 03 B3 00 01 7F 
2019-05-01 20:26:30.497 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 09 60 0D 00 01 5B 03 B3 00 01 
2019-05-01 20:26:30.497 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 09 60 0D 00 01 5B 03 B3 00 01 
2019-05-01 20:26:30.498 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-05-01 20:26:30.498 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Application Command Request (ALIVE:ASSOCIATIONS)
2019-05-01 20:26:30.498 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2019-05-01 20:26:30.499 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Incoming command class COMMAND_CLASS_CENTRAL_SCENE, endpoint 0
2019-05-01 20:26:30.499 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: SECURITY not supported
2019-05-01 20:26:30.499 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 4: Received COMMAND_CLASS_CENTRAL_SCENE V2 CENTRAL_SCENE_NOTIFICATION
2019-05-01 20:26:30.499 [DEBUG] [dclass.ZWaveCentralSceneCommandClass] - NODE 4: Received scene 1 at key 0 [Single Press]
2019-05-01 20:26:30.500 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2019-05-01 20:26:30.501 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_CENTRAL_SCENE, value = 1.0
2019-05-01 20:26:30.501 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Updating channel state zwave:device:c7543ef2:node4:scene_number to 1.0 [DecimalType]
2019-05-01 20:26:30.502 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Commands processed 1.
2019-05-01 20:26:30.502 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@763c94d9.
2019-05-01 20:26:30.502 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:30.502 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:30.503 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-05-01 20:26:30.503 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-05-01 20:26:30.520 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0F 00 04 00 04 09 60 0D 00 01 5B 03 B3 00 01 7F 
2019-05-01 20:26:30.522 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 09 60 0D 00 01 5B 03 B3 00 01 
2019-05-01 20:26:30.522 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 09 60 0D 00 01 5B 03 B3 00 01 
2019-05-01 20:26:30.523 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-05-01 20:26:30.523 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Application Command Request (ALIVE:ASSOCIATIONS)
2019-05-01 20:26:30.523 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2019-05-01 20:26:30.524 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Incoming command class COMMAND_CLASS_CENTRAL_SCENE, endpoint 0
2019-05-01 20:26:30.524 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: SECURITY not supported
2019-05-01 20:26:30.524 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 4: Received COMMAND_CLASS_CENTRAL_SCENE V2 CENTRAL_SCENE_NOTIFICATION
2019-05-01 20:26:30.524 [DEBUG] [dclass.ZWaveCentralSceneCommandClass] - NODE 4: Received scene 1 at key 0 [Single Press]
2019-05-01 20:26:30.525 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2019-05-01 20:26:30.525 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_CENTRAL_SCENE, value = 1.0
2019-05-01 20:26:30.525 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Updating channel state zwave:device:c7543ef2:node4:scene_number to 1.0 [DecimalType]
2019-05-01 20:26:30.525 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Commands processed 1.
2019-05-01 20:26:30.526 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@60197f96.
2019-05-01 20:26:30.526 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:30.526 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:30.526 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-05-01 20:26:30.526 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-05-01 20:26:30.557 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0F 00 04 00 04 09 60 0D 00 01 5B 03 B3 00 01 7F 
2019-05-01 20:26:30.559 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 09 60 0D 00 01 5B 03 B3 00 01 
2019-05-01 20:26:30.559 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 09 60 0D 00 01 5B 03 B3 00 01 
2019-05-01 20:26:30.560 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-05-01 20:26:30.563 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Application Command Request (ALIVE:ASSOCIATIONS)
2019-05-01 20:26:30.563 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2019-05-01 20:26:30.563 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Incoming command class COMMAND_CLASS_CENTRAL_SCENE, endpoint 0
2019-05-01 20:26:30.564 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: SECURITY not supported
2019-05-01 20:26:30.564 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 4: Received COMMAND_CLASS_CENTRAL_SCENE V2 CENTRAL_SCENE_NOTIFICATION
2019-05-01 20:26:30.564 [DEBUG] [dclass.ZWaveCentralSceneCommandClass] - NODE 4: Received scene 1 at key 0 [Single Press]
2019-05-01 20:26:30.565 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2019-05-01 20:26:30.565 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_CENTRAL_SCENE, value = 1.0
2019-05-01 20:26:30.565 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Updating channel state zwave:device:c7543ef2:node4:scene_number to 1.0 [DecimalType]
2019-05-01 20:26:30.573 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Commands processed 1.
2019-05-01 20:26:30.573 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1874d579.
2019-05-01 20:26:30.573 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:30.574 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:30.574 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-05-01 20:26:30.574 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-05-01 20:26:30.627 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0F 00 04 00 04 09 60 0D 00 01 5B 03 B3 00 01 7F 
2019-05-01 20:26:30.630 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 09 60 0D 00 01 5B 03 B3 00 01 
2019-05-01 20:26:30.631 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 09 60 0D 00 01 5B 03 B3 00 01 
2019-05-01 20:26:30.632 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-05-01 20:26:30.632 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Application Command Request (ALIVE:ASSOCIATIONS)
2019-05-01 20:26:30.632 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2019-05-01 20:26:30.633 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Incoming command class COMMAND_CLASS_CENTRAL_SCENE, endpoint 0
2019-05-01 20:26:30.633 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: SECURITY not supported
2019-05-01 20:26:30.633 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 4: Received COMMAND_CLASS_CENTRAL_SCENE V2 CENTRAL_SCENE_NOTIFICATION
2019-05-01 20:26:30.634 [DEBUG] [dclass.ZWaveCentralSceneCommandClass] - NODE 4: Received scene 1 at key 0 [Single Press]
2019-05-01 20:26:30.634 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2019-05-01 20:26:30.634 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_CENTRAL_SCENE, value = 1.0
2019-05-01 20:26:30.634 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Updating channel state zwave:device:c7543ef2:node4:scene_number to 1.0 [DecimalType]
2019-05-01 20:26:30.635 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Commands processed 1.
2019-05-01 20:26:30.635 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@fd228b6.
2019-05-01 20:26:30.635 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:30.635 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:30.636 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-05-01 20:26:30.636 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-05-01 20:26:30.651 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0F 00 04 00 04 09 60 0D 00 01 5B 03 B3 00 01 7F 
2019-05-01 20:26:30.655 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 09 60 0D 00 01 5B 03 B3 00 01 
2019-05-01 20:26:30.656 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 09 60 0D 00 01 5B 03 B3 00 01 
2019-05-01 20:26:30.656 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-05-01 20:26:30.656 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Application Command Request (ALIVE:ASSOCIATIONS)
2019-05-01 20:26:30.657 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2019-05-01 20:26:30.657 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Incoming command class COMMAND_CLASS_CENTRAL_SCENE, endpoint 0
2019-05-01 20:26:30.657 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: SECURITY not supported
2019-05-01 20:26:30.658 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 4: Received COMMAND_CLASS_CENTRAL_SCENE V2 CENTRAL_SCENE_NOTIFICATION
2019-05-01 20:26:30.658 [DEBUG] [dclass.ZWaveCentralSceneCommandClass] - NODE 4: Received scene 1 at key 0 [Single Press]
2019-05-01 20:26:30.658 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2019-05-01 20:26:30.659 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_CENTRAL_SCENE, value = 1.0
2019-05-01 20:26:30.659 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Updating channel state zwave:device:c7543ef2:node4:scene_number to 1.0 [DecimalType]
2019-05-01 20:26:30.660 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Commands processed 1.
2019-05-01 20:26:30.660 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1d5affc9.
2019-05-01 20:26:30.660 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:30.660 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:30.661 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-05-01 20:26:30.661 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-05-01 20:26:30.719 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0F 00 04 00 04 09 60 0D 00 01 5B 03 B3 00 01 7F 
2019-05-01 20:26:30.722 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 09 60 0D 00 01 5B 03 B3 00 01 
2019-05-01 20:26:30.723 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 09 60 0D 00 01 5B 03 B3 00 01 
2019-05-01 20:26:30.724 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-05-01 20:26:30.725 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Application Command Request (ALIVE:ASSOCIATIONS)
2019-05-01 20:26:30.725 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2019-05-01 20:26:30.725 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Incoming command class COMMAND_CLASS_CENTRAL_SCENE, endpoint 0
2019-05-01 20:26:30.726 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: SECURITY not supported
2019-05-01 20:26:30.726 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 4: Received COMMAND_CLASS_CENTRAL_SCENE V2 CENTRAL_SCENE_NOTIFICATION
2019-05-01 20:26:30.727 [DEBUG] [dclass.ZWaveCentralSceneCommandClass] - NODE 4: Received scene 1 at key 0 [Single Press]
2019-05-01 20:26:30.727 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2019-05-01 20:26:30.728 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_CENTRAL_SCENE, value = 1.0
2019-05-01 20:26:30.728 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Updating channel state zwave:device:c7543ef2:node4:scene_number to 1.0 [DecimalType]
2019-05-01 20:26:30.729 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Commands processed 1.
2019-05-01 20:26:30.729 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@3614c63b.
2019-05-01 20:26:30.729 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:30.730 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:30.730 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-05-01 20:26:30.730 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-05-01 20:26:34.785 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0D 00 04 00 04 07 60 0D 01 01 20 03 00 BB 
2019-05-01 20:26:34.788 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 07 60 0D 01 01 20 03 00 
2019-05-01 20:26:34.789 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 07 60 0D 01 01 20 03 00 
2019-05-01 20:26:34.789 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-05-01 20:26:34.789 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Application Command Request (ALIVE:ASSOCIATIONS)
2019-05-01 20:26:34.790 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2019-05-01 20:26:34.790 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Incoming command class COMMAND_CLASS_BASIC, endpoint 1
2019-05-01 20:26:34.790 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: SECURITY not supported
2019-05-01 20:26:34.791 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 4: Received COMMAND_CLASS_BASIC V0 BASIC_REPORT
2019-05-01 20:26:34.791 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 4: Basic report, value = 0
2019-05-01 20:26:34.791 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2019-05-01 20:26:34.792 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got a value event from Z-Wave network, endpoint = 1, command class = COMMAND_CLASS_BASIC, value = 0
2019-05-01 20:26:34.792 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Commands processed 1.
2019-05-01 20:26:34.795 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@875029d.
2019-05-01 20:26:34.795 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:34.795 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:34.796 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-05-01 20:26:34.796 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-05-01 20:26:34.891 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0D 00 04 00 04 07 60 0D 01 01 20 03 00 BB 
2019-05-01 20:26:34.894 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 07 60 0D 01 01 20 03 00 
2019-05-01 20:26:34.894 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 07 60 0D 01 01 20 03 00 
2019-05-01 20:26:34.895 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-05-01 20:26:34.895 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Application Command Request (ALIVE:ASSOCIATIONS)
2019-05-01 20:26:34.896 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2019-05-01 20:26:34.896 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Incoming command class COMMAND_CLASS_BASIC, endpoint 1
2019-05-01 20:26:34.897 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: SECURITY not supported
2019-05-01 20:26:34.897 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 4: Received COMMAND_CLASS_BASIC V0 BASIC_REPORT
2019-05-01 20:26:34.898 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 4: Basic report, value = 0
2019-05-01 20:26:34.898 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2019-05-01 20:26:34.898 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got a value event from Z-Wave network, endpoint = 1, command class = COMMAND_CLASS_BASIC, value = 0
2019-05-01 20:26:34.899 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Commands processed 1.
2019-05-01 20:26:34.899 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@16fc1cbd.
2019-05-01 20:26:34.900 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:34.900 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:34.900 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-05-01 20:26:34.901 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-05-01 20:26:34.915 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0D 00 04 00 04 07 60 0D 01 01 20 03 00 BB 
2019-05-01 20:26:34.919 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 07 60 0D 01 01 20 03 00 
2019-05-01 20:26:34.920 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 07 60 0D 01 01 20 03 00 
2019-05-01 20:26:34.921 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-05-01 20:26:34.921 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Application Command Request (ALIVE:ASSOCIATIONS)
2019-05-01 20:26:34.922 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2019-05-01 20:26:34.922 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Incoming command class COMMAND_CLASS_BASIC, endpoint 1
2019-05-01 20:26:34.922 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: SECURITY not supported
2019-05-01 20:26:34.922 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 4: Received COMMAND_CLASS_BASIC V0 BASIC_REPORT
2019-05-01 20:26:34.923 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 4: Basic report, value = 0
2019-05-01 20:26:34.923 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2019-05-01 20:26:34.924 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got a value event from Z-Wave network, endpoint = 1, command class = COMMAND_CLASS_BASIC, value = 0
2019-05-01 20:26:34.924 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Commands processed 1.
2019-05-01 20:26:34.924 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@5c121d1c.
2019-05-01 20:26:34.924 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:34.925 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:34.925 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-05-01 20:26:34.926 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-05-01 20:26:34.968 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0D 00 04 00 04 07 60 0D 01 01 20 03 00 BB 
2019-05-01 20:26:34.971 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 07 60 0D 01 01 20 03 00 
2019-05-01 20:26:34.972 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 07 60 0D 01 01 20 03 00 
2019-05-01 20:26:34.972 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-05-01 20:26:34.973 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Application Command Request (ALIVE:ASSOCIATIONS)
2019-05-01 20:26:34.973 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2019-05-01 20:26:34.974 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Incoming command class COMMAND_CLASS_BASIC, endpoint 1
2019-05-01 20:26:34.974 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: SECURITY not supported
2019-05-01 20:26:34.975 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 4: Received COMMAND_CLASS_BASIC V0 BASIC_REPORT
2019-05-01 20:26:34.975 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 4: Basic report, value = 0
2019-05-01 20:26:34.975 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2019-05-01 20:26:34.976 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got a value event from Z-Wave network, endpoint = 1, command class = COMMAND_CLASS_BASIC, value = 0
2019-05-01 20:26:34.976 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Commands processed 1.
2019-05-01 20:26:34.977 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@4ca73dbb.
2019-05-01 20:26:34.977 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:34.977 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:34.978 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-05-01 20:26:34.978 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-05-01 20:26:35.008 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0D 00 04 00 04 07 60 0D 01 01 20 03 00 BB 
2019-05-01 20:26:35.010 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 07 60 0D 01 01 20 03 00 
2019-05-01 20:26:35.011 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 07 60 0D 01 01 20 03 00 
2019-05-01 20:26:35.011 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-05-01 20:26:35.011 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Application Command Request (ALIVE:ASSOCIATIONS)
2019-05-01 20:26:35.012 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2019-05-01 20:26:35.012 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Incoming command class COMMAND_CLASS_BASIC, endpoint 1
2019-05-01 20:26:35.012 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: SECURITY not supported
2019-05-01 20:26:35.013 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 4: Received COMMAND_CLASS_BASIC V0 BASIC_REPORT
2019-05-01 20:26:35.013 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 4: Basic report, value = 0
2019-05-01 20:26:35.014 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2019-05-01 20:26:35.018 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got a value event from Z-Wave network, endpoint = 1, command class = COMMAND_CLASS_BASIC, value = 0
2019-05-01 20:26:35.019 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Commands processed 1.
2019-05-01 20:26:35.019 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@6ce6bf58.
2019-05-01 20:26:35.020 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:35.020 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:35.020 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-05-01 20:26:35.020 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-05-01 20:26:35.031 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0D 00 04 00 04 07 60 0D 01 01 20 03 00 BB 
2019-05-01 20:26:35.033 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 07 60 0D 01 01 20 03 00 
2019-05-01 20:26:35.034 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 07 60 0D 01 01 20 03 00 
2019-05-01 20:26:35.034 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-05-01 20:26:35.034 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Application Command Request (ALIVE:ASSOCIATIONS)
2019-05-01 20:26:35.034 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2019-05-01 20:26:35.035 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Incoming command class COMMAND_CLASS_BASIC, endpoint 1
2019-05-01 20:26:35.035 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: SECURITY not supported
2019-05-01 20:26:35.035 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 4: Received COMMAND_CLASS_BASIC V0 BASIC_REPORT
2019-05-01 20:26:35.035 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 4: Basic report, value = 0
2019-05-01 20:26:35.036 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2019-05-01 20:26:35.036 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got a value event from Z-Wave network, endpoint = 1, command class = COMMAND_CLASS_BASIC, value = 0
2019-05-01 20:26:35.036 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Commands processed 1.
2019-05-01 20:26:35.036 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@1a895f8d.
2019-05-01 20:26:35.040 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:35.040 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:35.040 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-05-01 20:26:35.046 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
...
2019-05-01 20:26:43.776 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0E 00 04 00 04 08 60 0D 01 01 26 01 00 00 B3 
2019-05-01 20:26:43.778 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 08 60 0D 01 01 26 01 00 00 
2019-05-01 20:26:43.779 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=4, callback=0, payload=00 04 08 60 0D 01 01 26 01 00 00 
2019-05-01 20:26:43.779 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-05-01 20:26:43.779 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Application Command Request (ALIVE:ASSOCIATIONS)
2019-05-01 20:26:43.779 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Decapsulating COMMAND_CLASS_MULTI_CHANNEL
2019-05-01 20:26:43.779 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: Incoming command class COMMAND_CLASS_SWITCH_MULTILEVEL, endpoint 1
2019-05-01 20:26:43.779 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 4: SECURITY not supported
2019-05-01 20:26:43.780 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 4: Received COMMAND_CLASS_SWITCH_MULTILEVEL V3 SWITCH_MULTILEVEL_SET
2019-05-01 20:26:43.780 [DEBUG] [ss.ZWaveMultiLevelSwitchCommandClass] - NODE 4: Switch Multi Level set, value = 0
2019-05-01 20:26:43.780 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2019-05-01 20:26:43.780 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Got a value event from Z-Wave network, endpoint = 1, command class = COMMAND_CLASS_SWITCH_MULTILEVEL, value = 0
2019-05-01 20:26:43.780 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 4: Updating channel state zwave:device:c7543ef2:node4:switch_dimmer1 to 0 [PercentType]
2019-05-01 20:26:43.780 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Commands processed 1.
2019-05-01 20:26:43.780 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 4: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@3dd8de81.
2019-05-01 20:26:43.780 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:43.780 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-01 20:26:43.780 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-05-01 20:26:43.780 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

mstormi · May 2, 2019, 7:10am

Look more carefully. It’s different type of messages, only the first one (CENTRAL_SCENE) is caused by the key press and is what you need to trigger upon.
Then there’s reports and one dimmer command (SWITCH_MULTILEVEL).
Seems your device is configured to send them. You need to configure it the way you want it to behave.
That’s specific to that device which I don’t know and cannot help with.

andreasbrinch · May 2, 2019, 6:44pm

I did a complete factory reset of the device and dongle and that has helped a lot. I only get the central scene now. I still find it odd that for a single press of a button I get the messages four times:

2019-05-02 20:39:35.648 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0B 00 04 00 02 05 5B 03 28 00 01 86 
2019-05-02 20:39:35.651 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 05 5B 03 28 00 01 
2019-05-02 20:39:35.652 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 05 5B 03 28 00 01 
2019-05-02 20:39:35.653 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-05-02 20:39:35.654 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Application Command Request (ALIVE:STATIC_VALUES)
2019-05-02 20:39:35.654 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Incoming command class COMMAND_CLASS_CENTRAL_SCENE, endpoint 0
2019-05-02 20:39:35.655 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY not supported
2019-05-02 20:39:35.658 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 2: Received COMMAND_CLASS_CENTRAL_SCENE V2 CENTRAL_SCENE_NOTIFICATION
2019-05-02 20:39:35.658 [DEBUG] [dclass.ZWaveCentralSceneCommandClass] - NODE 2: Received scene 1 at key 0 [Single Press]
2019-05-02 20:39:35.659 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2019-05-02 20:39:35.660 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_CENTRAL_SCENE, value = 1.0
2019-05-02 20:39:35.661 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Updating channel state zwave:device:02602d7f:node2:scene_number to 1.0 [DecimalType]
2019-05-02 20:39:35.661 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Commands processed 1.
2019-05-02 20:39:35.662 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@30b6d46e.
2019-05-02 20:39:35.663 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-02 20:39:35.663 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-02 20:39:35.664 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-05-02 20:39:35.664 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-05-02 20:39:35.687 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0B 00 04 00 02 05 5B 03 28 00 01 86 
2019-05-02 20:39:35.691 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 05 5B 03 28 00 01 
2019-05-02 20:39:35.692 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 05 5B 03 28 00 01 
2019-05-02 20:39:35.693 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-05-02 20:39:35.693 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Application Command Request (ALIVE:STATIC_VALUES)
2019-05-02 20:39:35.694 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Incoming command class COMMAND_CLASS_CENTRAL_SCENE, endpoint 0
2019-05-02 20:39:35.695 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY not supported
2019-05-02 20:39:35.695 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 2: Received COMMAND_CLASS_CENTRAL_SCENE V2 CENTRAL_SCENE_NOTIFICATION
2019-05-02 20:39:35.696 [DEBUG] [dclass.ZWaveCentralSceneCommandClass] - NODE 2: Received scene 1 at key 0 [Single Press]
2019-05-02 20:39:35.696 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2019-05-02 20:39:35.699 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_CENTRAL_SCENE, value = 1.0
2019-05-02 20:39:35.699 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Updating channel state zwave:device:02602d7f:node2:scene_number to 1.0 [DecimalType]
2019-05-02 20:39:35.700 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Commands processed 1.
2019-05-02 20:39:35.700 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@6740ed71.
2019-05-02 20:39:35.700 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-02 20:39:35.702 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-02 20:39:35.702 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-05-02 20:39:35.703 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-05-02 20:39:35.728 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0B 00 04 00 02 05 5B 03 28 00 01 86 
2019-05-02 20:39:35.731 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 05 5B 03 28 00 01 
2019-05-02 20:39:35.733 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 05 5B 03 28 00 01 
2019-05-02 20:39:35.733 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-05-02 20:39:35.734 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Application Command Request (ALIVE:STATIC_VALUES)
2019-05-02 20:39:35.734 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Incoming command class COMMAND_CLASS_CENTRAL_SCENE, endpoint 0
2019-05-02 20:39:35.735 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY not supported
2019-05-02 20:39:35.735 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 2: Received COMMAND_CLASS_CENTRAL_SCENE V2 CENTRAL_SCENE_NOTIFICATION
2019-05-02 20:39:35.736 [DEBUG] [dclass.ZWaveCentralSceneCommandClass] - NODE 2: Received scene 1 at key 0 [Single Press]
2019-05-02 20:39:35.736 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2019-05-02 20:39:35.737 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_CENTRAL_SCENE, value = 1.0
2019-05-02 20:39:35.737 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Updating channel state zwave:device:02602d7f:node2:scene_number to 1.0 [DecimalType]
2019-05-02 20:39:35.738 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Commands processed 1.
2019-05-02 20:39:35.738 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@551a6fec.
2019-05-02 20:39:35.738 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-02 20:39:35.739 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-02 20:39:35.740 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-05-02 20:39:35.740 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-05-02 20:39:35.777 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0B 00 04 00 02 05 5B 03 28 00 01 86 
2019-05-02 20:39:35.781 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 05 5B 03 28 00 01 
2019-05-02 20:39:35.782 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=2, callback=0, payload=00 02 05 5B 03 28 00 01 
2019-05-02 20:39:35.783 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-05-02 20:39:35.783 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Application Command Request (ALIVE:STATIC_VALUES)
2019-05-02 20:39:35.784 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: Incoming command class COMMAND_CLASS_CENTRAL_SCENE, endpoint 0
2019-05-02 20:39:35.785 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 2: SECURITY not supported
2019-05-02 20:39:35.786 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 2: Received COMMAND_CLASS_CENTRAL_SCENE V2 CENTRAL_SCENE_NOTIFICATION
2019-05-02 20:39:35.786 [DEBUG] [dclass.ZWaveCentralSceneCommandClass] - NODE 2: Received scene 1 at key 0 [Single Press]
2019-05-02 20:39:35.787 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2019-05-02 20:39:35.788 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Got a value event from Z-Wave network, endpoint = 0, command class = COMMAND_CLASS_CENTRAL_SCENE, value = 1.0
2019-05-02 20:39:35.788 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 2: Updating channel state zwave:device:02602d7f:node2:scene_number to 1.0 [DecimalType]
2019-05-02 20:39:35.789 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Commands processed 1.
2019-05-02 20:39:35.790 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 2: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@33b56dda.
2019-05-02 20:39:35.790 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-02 20:39:35.791 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-05-02 20:39:35.791 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-05-02 20:39:35.792 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.