Hi
I have a problem with a Logic Group ZHC5010 zwave device. The device has 4 buttons (1 endpoint for each button and a common endpoint for the entire device) and the default setup is that button 1 controls a build in relay. I have created a switch item from which it is possible to control the relay. This is working just fine. I can also control the relay locally on button 1 and the state is reflected in the switch item. But for some reason this is not the case for button 2, 3 and 4! I can control these buttons from switch items, but when operating button 2,3 and 4 locally, their states is not relayed to the switch items. I have done some debugging and I have seen the following behaviour:
When button 1 is pressed locally, the log shows that the received message is sent from node 12 endpoint 1 and the channel zwave:device:63ab8ea1:node12:switch_binary1 is updated (as expected):
2018-10-24 15:03:26.195 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 12: Incoming command class MULTI_INSTANCE
2018-10-24 15:03:26.197 [DEBUG] [class.ZWaveMultiInstanceCommandClass] - NODE 12: Received MULTI_INSTANCE command V2
2018-10-24 15:03:26.199 [DEBUG] [class.ZWaveMultiInstanceCommandClass] - NODE 12: Requested Command Class = SWITCH_BINARY (0x25)
2018-10-24 15:03:26.200 [DEBUG] [class.ZWaveMultiInstanceCommandClass] - NODE 12: Endpoint = 1, calling handleApplicationCommandRequest.
2018-10-24 15:03:26.202 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - Received Switch Binary Request for Node ID = 12
2018-10-24 15:03:26.204 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - NODE 12: Switch Binary SET
2018-10-24 15:03:26.206 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - NODE 12: Switch Binary report, value = 255
2018-10-24 15:03:26.208 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveCommandClassValueEvent
2018-10-24 15:03:26.210 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2018-10-24 15:03:26.212 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Got a value event from Z-Wave network, endpoint = 1, command class = SWITCH_BINARY, value = 255
2018-10-24 15:03:26.218 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Updating channel state zwave:device:63ab8ea1:node12:switch_binary1 to ON [OnOffType]
2018-10-24 15:03:26.223 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Set, dest=12, callback=150, payload=0C 07 60 0D 01 04 25 01 00
2018-10-24 15:03:26.226 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 0C 07 60 0D 01 00 25 01 FF
2018-10-24 15:03:26.229 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationCommandHandler, callback id=150, expected=SendData, cancelled=false MISMATCH
But when activating button 4 the log shows that a message from node 12 endpoint 0 is received and channel zwave:device:63ab8ea1:node12:switch_binary is updated. (I would expect a message from node 12 endpoint 4 and update of channel zwave:device:63ab8ea1:node12:switch_binary4)
2018-10-24 15:06:51.855 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 12: Incoming command class SWITCH_BINARY
2018-10-24 15:06:51.860 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - Received Switch Binary Request for Node ID = 12
2018-10-24 15:06:51.864 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - NODE 12: Switch Binary SET
2018-10-24 15:06:51.868 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - NODE 12: Switch Binary report, value = 255
2018-10-24 15:06:51.872 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveCommandClassValueEvent
2018-10-24 15:06:51.875 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2018-10-24 15:06:51.879 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Got a value event from Z-Wave network, endpoint = 0, command class = SWITCH_BINARY, value = 255
2018-10-24 15:06:51.885 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Updating channel state zwave:device:63ab8ea1:node12:switch_binary to ON [OnOffType]
2018-10-24 15:06:51.893 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Set, dest=12, callback=150, payload=0C 07 60 0D 01 04 25 01 00
2018-10-24 15:06:51.898 [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 01 FF
2018-10-24 15:06:51.903 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationCommandHandler, callback id=150, expected=SendData, cancelled=false MISMATCH
I can add that association group 4 and 19 is set to OpenHabController.
I am running openhab2 on a Raspberry Pi with a Zwave.me usb controller connected. Zwave binding 2.3.0.
How do I find out whether the device sends the a wrong message for button 4 or the binding decodes the message errorneously? Any help will be appreciated.
Best regards
Thomas