How to access different endpoints?

Unfortunately it does not change anything. There is still only an update to Endpoint 0.
It is also curious to see, that I cannot set a new association to the Switch_Binary1 or Switch_Binary2 association group. Only the lifeline default reporting group works. Habmin also accepts entries in the other groups, you can apparently save them, but when you call Habmin next time (after having closed the browser) they have disappeared again…

I just excluded now 2 ZMNHBD devices and reincluded them as new nodes in the network to test if that finally helps. Unfortunately they still appear as “unknown device” in Habmin even after 1,5 hours. Is there any way to speed that up?

I am close to give up. Even the resetted and completely new included node shows the same old odd behaviour and only updates the Switch 0. This ZMNHBD device had never any contact with OH1, it even forgot all of the config (like push button etc.) , came freshly in the network and it is exactly the same.
NOTHING improved , it is the same as in OH1. Not a very satisfying result after nearly 24 hours only dedicated to that problem :frowning:
@pdegeus: How did you configure your ZMNHBD devices with OH2 at last? And do they really work in a way to update Q1 und Q2 separately when activated by the physically switch?

@chris: Is there any possibility to check what kind of association is set to the device? A kind of reporting or loggin tool or whatever to query this technical detail?

If you can provide a debug log of the commands sent when you set the associations I’ll take a look over the next few days.

Ok, I will preapre that. Just to make sure what you exactly mean with “when you set the associations”:
The association for liefeline (default reporting group 1) is already set automatically after the “new thing” is added to OH2. So it will be difficult to provide a debug log for this very moment. When I open the thing for the first time with habmin the association for group 1 to the Openhab Controller is already there.
AND: It is NOT possible to set any other additional associations groups with Habmin. I can enter the association, save the settings but a few moments later they disappear again. So this is what remains:

So which moment should I try to catch in the debug log?

We should try and find out why the association group is disappearing - this might be related. So I suggest to grab a log of what’s happening when you set the association in one of the other groups.

I’m about to get on a longhaul flight so won’t be able to look at this until tomorrow or Sunday probably.

Ok, thank you for the clarification.
I noticed one curious thing: I can set the associations only when no channels are set for the endpoints of the device. Without defined channels the Save Process for the associations is successful. BUT: When I then try to define the channels(items) for the endpoints afterwards, the system leaves the name empty and the channels cannot be saved. The only way to bring back channels/items is to delete the associations and then I can define items for the 3 switch channels of the devices…Is that a bug in the device or in Habmin?

Thank you very much for your guidance and help so far. Have a good flight!

It seems to be a more fundamental problem than just an issue with one device.
I just unboxed a brand new purchased Fibaro Double Relay Switch FGS223 (Zwave+ also), included it, wired it, set the associations and tried the same thing (switching the physical switches). Result: The same problem, only switch 0 gets updated in OH, Switches 1 and 2 never report that they have been triggered.
So my conclusion for the moment is: OH Zwave Binding presently seems to have a problem to handle Zwave±Double-Relays correctly. The Fibaro FGS223 shows exactly the same behaviour as the Qubino ZMNHBD… :frowning:

And this conclusion seems to be confirmed when I have a look at this thread

And for completeness I tried yet another device, a Qubino ZWAVE+ Dimmer ZMNHDD. It only switches one dimmable load, but offers also up to 3 endpoints which can be wired to different switches or sensors.
The result is the same: When physically switching Input Switch I1 or Input Switch I2 the reporting to OH controller is always with endpoint 0. Endpoints 1 and 2 are never updated (the same story as with Qubino ZMNHBD and Fibaro FGS223).
I finally believe that here is really an issue with the OH binding as already 3 new devices show the same behaviour.
It would be great if we could get the additional endpoints usable (which was easy with the old ZWAVE-Generation devices with multi instance endpoints). At the moment the new devices are a step back with OH as they cannot be used completely.

Hi Chris,

here comes the debug log when trying to set the association on node 101:



2017-01-07 02:07:51.609 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 101: Configuration update received
2017-01-07 02:07:51.632 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 06 00 49 81 00 00 31 
2017-01-07 02:07:51.633 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-01-07 02:07:51.633 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 06 00 49 81 00 00 31 
2017-01-07 02:07:51.633 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 06 00 49 81 00 00 31 
2017-01-07 02:07:51.633 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationUpdate[0x49], type=Request[0x00], priority=High, dest=255, callback=0, payload=81 00 00 
2017-01-07 02:07:51.633 [DEBUG] [essage.ApplicationUpdateMessageClass] - NODE 255: Application update request. Node Info Request Failed.
2017-01-07 02:07:51.633 [WARN ] [essage.ApplicationUpdateMessageClass] - NODE 255: Node Info Request Failed 3x. Discarding message: Message: class=RequestNodeInfo[0x60], type=Request[0x00], priority=High, dest=255, callback=0, payload=4F 
2017-01-07 02:07:51.633 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=RequestNodeInfo[0x60], type=Request[0x00], priority=High, dest=255, callback=0, payload=4F 
2017-01-07 02:07:51.633 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=ApplicationUpdate[0x49], type=Request[0x00], priority=High, dest=255, callback=0, payload=81 00 00 
2017-01-07 02:07:51.633 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationUpdate, callback id=0, expected=ApplicationUpdate, cancelled=true      MISMATCH
2017-01-07 02:07:51.647 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 101: Configuration update group_5 to [node_1_0]
2017-01-07 02:07:51.647 [DEBUG] [ndclass.ZWaveAssociationCommandClass] - NODE 101: Creating new message for application command ASSOCIATIONCMD_SET
2017-01-07 02:07:51.647 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 1. Queue={}
2017-01-07 02:07:51.647 [DEBUG] [ss.ZWaveMultiAssociationCommandClass] - NODE 101: Creating new message for command MULTI_ASSOCIATIONCMD_GET group 5
2017-01-07 02:07:51.647 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 2. Queue={}
2017-01-07 02:07:51.647 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 101: Configuration update group_2 to [node_1_0]
2017-01-07 02:07:51.647 [DEBUG] [ndclass.ZWaveAssociationCommandClass] - NODE 101: Creating new message for application command ASSOCIATIONCMD_SET
2017-01-07 02:07:51.648 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 3. Queue={}
2017-01-07 02:07:51.648 [DEBUG] [ss.ZWaveMultiAssociationCommandClass] - NODE 101: Creating new message for command MULTI_ASSOCIATIONCMD_GET group 2
2017-01-07 02:07:51.648 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 4. Queue={}
2017-01-07 02:07:52.526 [WARN ] [ocol.ZWaveController$ZWaveSendThread] - NODE 255: Too many retries. Discarding message: Message: class=RequestNodeInfo[0x60], type=Request[0x00], priority=High, dest=255, callback=0, payload=4F 
2017-01-07 02:07:52.527 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 3
2017-01-07 02:07:52.527 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 65 03 8E 02 05 25 3D 11 
2017-01-07 02:07:52.527 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 101: Sending REQUEST Message = 01 0A 00 13 65 03 8E 02 05 25 3D 11 
2017-01-07 02:07:52.536 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2017-01-07 02:07:52.537 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-01-07 02:07:52.537 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8 
2017-01-07 02:07:52.537 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8 
2017-01-07 02:07:52.537 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Response[0x01], priority=High, dest=255, callback=0, payload=01 
2017-01-07 02:07:52.537 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 101: Sent Data successfully placed on stack.
2017-01-07 02:07:52.680 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 3D 00 00 0F D9 
2017-01-07 02:07:52.681 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-01-07 02:07:52.681 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 3D 00 00 0F 00 00 D7 
2017-01-07 02:07:52.681 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 3D 00 00 0F 00 00 D7 
2017-01-07 02:07:52.681 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=3D 00 00 0F 
2017-01-07 02:07:52.681 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 101: SendData Request. CallBack ID = 61, Status = Transmission complete and ACK received(0)
2017-01-07 02:07:52.681 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 101: Starting initialisation from DONE
2017-01-07 02:07:52.682 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@56fc0c38 already registered
2017-01-07 02:07:52.682 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Get, dest=101, callback=61, payload=65 03 8E 02 05 
2017-01-07 02:07:52.682 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=3D 00 00 0F 
2017-01-07 02:07:52.682 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, callback id=61, expected=ApplicationCommandHandler, cancelled=false      MISMATCH
2017-01-07 02:07:52.809 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0D 00 04 00 65 07 8E 03 05 10 00 55 00 59 
2017-01-07 02:07:52.810 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-01-07 02:07:52.810 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0D 00 04 00 65 07 8E 03 05 10 00 55 00 59 
2017-01-07 02:07:52.810 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 0D 00 04 00 65 07 8E 03 05 10 00 55 00 59 
2017-01-07 02:07:52.810 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 65 07 8E 03 05 10 00 55 00 
2017-01-07 02:07:52.810 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 101: Application Command Request (ALIVE:DONE)
2017-01-07 02:07:52.810 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 101: Starting initialisation from DONE
2017-01-07 02:07:52.811 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@56fc0c38 already registered
2017-01-07 02:07:52.811 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 101: Incoming command class MULTI_INSTANCE_ASSOCIATION
2017-01-07 02:07:52.811 [DEBUG] [ss.ZWaveMultiAssociationCommandClass] - NODE 101: Received MULTI_INSTANCE_ASSOCIATION command V3
2017-01-07 02:07:52.811 [DEBUG] [ss.ZWaveMultiAssociationCommandClass] - NODE 101: association group 5 has max associations 16
2017-01-07 02:07:52.811 [DEBUG] [ss.ZWaveMultiAssociationCommandClass] - NODE 101: Association group 5 includes the following nodes:
2017-01-07 02:07:52.811 [DEBUG] [ss.ZWaveMultiAssociationCommandClass] - NODE 101: Associated with Node 85 in group 5
2017-01-07 02:07:52.811 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveAssociationEvent
2017-01-07 02:07:52.811 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 101: Got an event from Z-Wave network: ZWaveAssociationEvent
2017-01-07 02:07:52.811 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 101: Got a value event from Z-Wave network, endpoint = 0, command class = ASSOCIATION, value = 0
2017-01-07 02:07:52.811 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 101: Update ASSOCIATION group_5
2017-01-07 02:07:52.811 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 101: Update ASSOCIATION group_5: Adding node_85_0
2017-01-07 02:07:52.811 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 101: Update ASSOCIATION group_5: 1 members
2017-01-07 02:07:52.811 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 101: Config updated
2017-01-07 02:07:52.814 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Get, dest=101, callback=61, payload=65 03 8E 02 05 
2017-01-07 02:07:52.814 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 65 07 8E 03 05 10 00 55 00 
2017-01-07 02:07:52.814 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationCommandHandler, callback id=61, expected=ApplicationCommandHandler, cancelled=false        transaction complete!
2017-01-07 02:07:52.814 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent
2017-01-07 02:07:52.814 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 101: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2017-01-07 02:07:52.815 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 101: Response processed after 288ms/4893ms.
2017-01-07 02:07:52.815 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 2
2017-01-07 02:07:52.815 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0A 00 13 65 03 8E 02 02 25 3F 14 
2017-01-07 02:07:52.815 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 101: Sending REQUEST Message = 01 0A 00 13 65 03 8E 02 02 25 3F 14 
2017-01-07 02:07:52.824 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2017-01-07 02:07:52.825 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-01-07 02:07:52.825 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8 
2017-01-07 02:07:52.825 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8 
2017-01-07 02:07:52.825 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Response[0x01], priority=High, dest=255, callback=0, payload=01 
2017-01-07 02:07:52.825 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 101: Sent Data successfully placed on stack.
2017-01-07 02:07:53.070 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 3F 00 00 19 CD 
2017-01-07 02:07:53.071 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-01-07 02:07:53.071 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 3F 00 00 19 00 00 C3 
2017-01-07 02:07:53.071 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 3F 00 00 19 00 00 C3 
2017-01-07 02:07:53.071 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=3F 00 00 19 
2017-01-07 02:07:53.071 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 101: SendData Request. CallBack ID = 63, Status = Transmission complete and ACK received(0)
2017-01-07 02:07:53.071 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 101: Starting initialisation from DONE
2017-01-07 02:07:53.072 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@56fc0c38 already registered
2017-01-07 02:07:53.072 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Get, dest=101, callback=63, payload=65 03 8E 02 02 
2017-01-07 02:07:53.072 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=3F 00 00 19 
2017-01-07 02:07:53.072 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, callback id=63, expected=ApplicationCommandHandler, cancelled=false      MISMATCH
2017-01-07 02:07:53.196 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 0B 00 04 00 65 05 8E 03 02 10 00 0F 
2017-01-07 02:07:53.197 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-01-07 02:07:53.197 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0B 00 04 00 65 05 8E 03 02 10 00 0F 
2017-01-07 02:07:53.197 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 0B 00 04 00 65 05 8E 03 02 10 00 0F 
2017-01-07 02:07:53.197 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 65 05 8E 03 02 10 00 
2017-01-07 02:07:53.197 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 101: Application Command Request (ALIVE:DONE)
2017-01-07 02:07:53.197 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 101: Starting initialisation from DONE
2017-01-07 02:07:53.197 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@56fc0c38 already registered
2017-01-07 02:07:53.197 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 101: Incoming command class MULTI_INSTANCE_ASSOCIATION
2017-01-07 02:07:53.197 [DEBUG] [ss.ZWaveMultiAssociationCommandClass] - NODE 101: Received MULTI_INSTANCE_ASSOCIATION command V3
2017-01-07 02:07:53.197 [DEBUG] [ss.ZWaveMultiAssociationCommandClass] - NODE 101: association group 2 has max associations 16
2017-01-07 02:07:53.197 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveAssociationEvent
2017-01-07 02:07:53.197 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 101: Got an event from Z-Wave network: ZWaveAssociationEvent
2017-01-07 02:07:53.197 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 101: Got a value event from Z-Wave network, endpoint = 0, command class = ASSOCIATION, value = 0
2017-01-07 02:07:53.197 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 101: Update ASSOCIATION group_2
2017-01-07 02:07:53.197 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 101: Update ASSOCIATION group_2: 0 members
2017-01-07 02:07:53.197 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 101: Config updated
2017-01-07 02:07:53.220 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Get, dest=101, callback=63, payload=65 03 8E 02 02 
2017-01-07 02:07:53.220 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 65 05 8E 03 02 10 00 
2017-01-07 02:07:53.220 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationCommandHandler, callback id=63, expected=ApplicationCommandHandler, cancelled=false        transaction complete!
2017-01-07 02:07:53.220 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent
2017-01-07 02:07:53.220 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 101: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2017-01-07 02:07:53.220 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 101: Response processed after 405ms/4893ms.
2017-01-07 02:07:53.220 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 1
2017-01-07 02:07:53.220 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0B 00 13 65 04 85 01 05 01 25 3C 1F 
2017-01-07 02:07:53.220 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 101: Sending REQUEST Message = 01 0B 00 13 65 04 85 01 05 01 25 3C 1F 
2017-01-07 02:07:53.230 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2017-01-07 02:07:53.231 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-01-07 02:07:53.231 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8 
2017-01-07 02:07:53.231 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8 
2017-01-07 02:07:53.231 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Response[0x01], priority=High, dest=255, callback=0, payload=01 
2017-01-07 02:07:53.231 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 101: Sent Data successfully placed on stack.
2017-01-07 02:07:53.477 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 3C 00 00 1A CD 
2017-01-07 02:07:53.478 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-01-07 02:07:53.478 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 3C 00 00 1A 00 00 C3 
2017-01-07 02:07:53.479 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 3C 00 00 1A 00 00 C3 
2017-01-07 02:07:53.479 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=3C 00 00 1A 
2017-01-07 02:07:53.479 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 101: SendData Request. CallBack ID = 60, Status = Transmission complete and ACK received(0)
2017-01-07 02:07:53.479 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 101: Starting initialisation from DONE
2017-01-07 02:07:53.479 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@56fc0c38 already registered
2017-01-07 02:07:53.479 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Config, dest=101, callback=60, payload=65 04 85 01 05 01 
2017-01-07 02:07:53.479 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=3C 00 00 1A 
2017-01-07 02:07:53.479 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, callback id=60, expected=SendData, cancelled=false        transaction complete!
2017-01-07 02:07:53.479 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent
2017-01-07 02:07:53.479 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 101: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2017-01-07 02:07:53.479 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 101: Response processed after 259ms/4893ms.
2017-01-07 02:07:53.479 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0
2017-01-07 02:07:53.479 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 0B 00 13 65 04 85 01 02 01 25 3E 1A 
2017-01-07 02:07:53.479 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 101: Sending REQUEST Message = 01 0B 00 13 65 04 85 01 02 01 25 3E 1A 
2017-01-07 02:07:53.488 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 
2017-01-07 02:07:53.489 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-01-07 02:07:53.489 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8 
2017-01-07 02:07:53.489 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8 
2017-01-07 02:07:53.489 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Response[0x01], priority=High, dest=255, callback=0, payload=01 
2017-01-07 02:07:53.489 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 101: Sent Data successfully placed on stack.
2017-01-07 02:07:53.662 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 3E 00 00 12 C7 
2017-01-07 02:07:53.663 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-01-07 02:07:53.663 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 3E 00 00 12 00 00 C9 
2017-01-07 02:07:53.663 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 3E 00 00 12 00 00 C9 
2017-01-07 02:07:53.663 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=3E 00 00 12 
2017-01-07 02:07:53.663 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 101: SendData Request. CallBack ID = 62, Status = Transmission complete and ACK received(0)
2017-01-07 02:07:53.663 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 101: Starting initialisation from DONE
2017-01-07 02:07:53.663 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@56fc0c38 already registered
2017-01-07 02:07:53.663 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Config, dest=101, callback=62, payload=65 04 85 01 02 01 
2017-01-07 02:07:53.663 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=3E 00 00 12 
2017-01-07 02:07:53.663 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, callback id=62, expected=SendData, cancelled=false        transaction complete!
2017-01-07 02:07:53.663 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent
2017-01-07 02:07:53.663 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 101: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2017-01-07 02:07:53.664 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 101: Response processed after 185ms/4893ms.
2017-01-07 02:07:59.322 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 00 51 0A 32 02 21 34 00 00 00 00 00 00 95 


Hope it helps!

I think the newer fibaro devices are using the same multi channel concept as the qubino ones - I came across that a few days ago.

I’ll take a look at the log when I get a chance.

Thanks for the log - the system is not using the multi channel association SET for some reason. The GET is using the multi channel so I’m not sure why the SET isn’t… I’ll try and look at this either later tonight or tomorrow.

Thank you for the update, Chris. If you need another log or whatever let me know.

@chris:
As already stated in the FGS-223 thread, the Qubino ZMNHBD is still NOT working (I tested with Z-Wave binding build 2.1.0.201702181609). I excluded and freshly reincluded 2 of the devices to be sure. The results:

  1. When only the lifeline association is set, no reporting is done to endpoints 1 and 2 (neither for Switch 1/2 nor Power(Watts)1/2).
  2. Even when the association groups for Switch binary or Basic On/Off are set (or both, also tested), NO update comes to the controller for Switch 1/2.
  3. When the assocation groups for power reporting are set, the Power Consumption (Watts) is reported correctly for both endpoints separately(!)

Is there a chance to also get the status reporting of the switches correctly? I have moren than 10 of them installed and can provide any kind of debug log if you tell me what you need. Thanks for your help!

I seem to have the same issue with my newly bought Qubino flush 2 relays.
My system is a clean install of OH2. I can control both switches from the GUI but when I use the physical switches openhab never receives an update on switch 1 or 2 but only on the ‘common switch’. Hence the status on my sitemap is never updated. I have setup associations as per the following image

Here is a DEBUG log when i switch on switch 2

2017-02-28 20:23:02.542 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 11 03 25 03 FF 39
2017-02-28 20:23:02.546 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-02-28 20:23:02.547 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 04 00 11 03 25 03 FF 39
2017-02-28 20:23:02.549 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 04 00 11 03 25 03 FF 39
2017-02-28 20:23:02.551 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 11 03 25 03 FF
2017-02-28 20:23:02.552 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 17: Application Command Request (ALIVE:DONE)
2017-02-28 20:23:02.553 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 17: Starting initialisation from DONE
2017-02-28 20:23:02.554 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@1b01cb6 already registered
2017-02-28 20:23:02.555 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 17: Incoming command class SWITCH_BINARY
2017-02-28 20:23:02.556 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - Received Switch Binary Request for Node ID = 17
2017-02-28 20:23:02.557 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - NODE 17: Switch Binary report, value = 255
2017-02-28 20:23:02.558 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveCommandClassValueEvent
2017-02-28 20:23:02.559 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 17: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2017-02-28 20:23:02.560 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 17: Got a value event from Z-Wave network, endpoint = 0, command class = SWITCH_BINARY, value = 255
2017-02-28 20:23:02.562 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 17: Updating channel state zwave:device:2947fb5e:node17:switch_binary to ON [OnOffType]
2017-02-28 20:23:02.565 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Set, dest=17, callback=42, payload=11 07 60 0D 01 02 25 01 00
2017-02-28 20:23:02.572 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 11 03 25 03 FF
2017-02-28 20:23:02.573 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationCommandHandler, callback id=42, expected=SendData, cancelled=false      MISMATCH
2017-02-28 20:23:03.352 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 00 11 0A 32 02 21 34 00 00 00 C6 00 00 13
2017-02-28 20:23:03.356 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-02-28 20:23:03.358 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 10 00 04 00 11 0A 32 02 21 34 00 00 00 C6 00 00 13
2017-02-28 20:23:03.360 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 10 00 04 00 11 0A 32 02 21 34 00 00 00 C6 00 00 13
2017-02-28 20:23:03.362 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 11 0A 32 02 21 34 00 00 00 C6 00 00
2017-02-28 20:23:03.363 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 17: Application Command Request (ALIVE:DONE)
2017-02-28 20:23:03.364 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 17: Starting initialisation from DONE
2017-02-28 20:23:03.365 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@1b01cb6 already registered
2017-02-28 20:23:03.366 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 17: Incoming command class METER
2017-02-28 20:23:03.367 [DEBUG] [.commandclass.ZWaveMeterCommandClass] - NODE 17: Received METER command V3
2017-02-28 20:23:03.368 [DEBUG] [.commandclass.ZWaveMeterCommandClass] - NODE 17: Meter: Type=Electric(1), Scale=W(2), Value=19.8
2017-02-28 20:23:03.369 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveMeterValueEvent
2017-02-28 20:23:03.370 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 17: Got an event from Z-Wave network: ZWaveMeterValueEvent
2017-02-28 20:23:03.371 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 17: Got a value event from Z-Wave network, endpoint = 0, command class = METER, value = 19.8
2017-02-28 20:23:03.373 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 17: Updating channel state zwave:device:2947fb5e:node17:meter_watts to 19.8 [DecimalType]
2017-02-28 20:23:03.375 [DEBUG] [ternal.converter.ZWaveMeterConverter] - Not the right scale E_KWh <> E_W
2017-02-28 20:23:03.376 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Set, dest=17, callback=42, payload=11 07 60 0D 01 02 25 01 00
2017-02-28 20:23:03.378 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 11 0A 32 02 21 34 00 00 00 C6 00 00
2017-02-28 20:23:03.379 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationCommandHandler, callback id=42, expected=SendData, cancelled=false      MISMATCH
2017-02-28 20:23:04.353 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 00 11 0A 32 02 21 34 00 00 00 98 00 00 4D
2017-02-28 20:23:04.355 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-02-28 20:23:04.357 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 10 00 04 00 11 0A 32 02 21 34 00 00 00 98 00 00 4D
2017-02-28 20:23:04.358 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 10 00 04 00 11 0A 32 02 21 34 00 00 00 98 00 00 4D
2017-02-28 20:23:04.359 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 11 0A 32 02 21 34 00 00 00 98 00 00
2017-02-28 20:23:04.359 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 17: Application Command Request (ALIVE:DONE)
2017-02-28 20:23:04.360 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 17: Starting initialisation from DONE
2017-02-28 20:23:04.361 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@1b01cb6 already registered
2017-02-28 20:23:04.361 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 17: Incoming command class METER
2017-02-28 20:23:04.362 [DEBUG] [.commandclass.ZWaveMeterCommandClass] - NODE 17: Received METER command V3
2017-02-28 20:23:04.363 [DEBUG] [.commandclass.ZWaveMeterCommandClass] - NODE 17: Meter: Type=Electric(1), Scale=W(2), Value=15.2
2017-02-28 20:23:04.363 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveMeterValueEvent
2017-02-28 20:23:04.364 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 17: Got an event from Z-Wave network: ZWaveMeterValueEvent
2017-02-28 20:23:04.364 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 17: Got a value event from Z-Wave network, endpoint = 0, command class = METER, value = 15.2
2017-02-28 20:23:04.365 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 17: Updating channel state zwave:device:2947fb5e:node17:meter_watts to 15.2 [DecimalType]
2017-02-28 20:23:04.366 [DEBUG] [ternal.converter.ZWaveMeterConverter] - Not the right scale E_KWh <> E_W
2017-02-28 20:23:04.367 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Set, dest=17, callback=42, payload=11 07 60 0D 01 02 25 01 00
2017-02-28 20:23:04.368 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 11 0A 32 02 21 34 00 00 00 98 00 00
2017-02-28 20:23:04.369 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationCommandHandler, callback id=42, expected=SendData, cancelled=false      MISMATCH
2017-02-28 20:23:05.884 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 11 03 20 01 FF 3E
2017-02-28 20:23:05.927 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-02-28 20:23:05.928 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 04 00 11 03 20 01 FF 3E
2017-02-28 20:23:05.930 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 04 00 11 03 20 01 FF 3E
2017-02-28 20:23:05.932 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 11 03 20 01 FF
2017-02-28 20:23:05.933 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 17: Application Command Request (ALIVE:DONE)
2017-02-28 20:23:05.934 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 17: Starting initialisation from DONE
2017-02-28 20:23:05.935 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@1b01cb6 already registered
2017-02-28 20:23:05.936 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 17: Incoming command class BASIC
2017-02-28 20:23:05.940 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 17: Received Basic Request
2017-02-28 20:23:05.941 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 17: Basic Set sent to the controller will be processed as Basic Report
2017-02-28 20:23:05.943 [DEBUG] [.commandclass.ZWaveBasicCommandClass] - NODE 17: Basic report, value = 0xFF
2017-02-28 20:23:05.948 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveCommandClassValueEvent
2017-02-28 20:23:05.949 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 17: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2017-02-28 20:23:05.950 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 17: Got a value event from Z-Wave network, endpoint = 0, command class = BASIC, value = 255
2017-02-28 20:23:05.951 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 17: Updating channel state zwave:device:2947fb5e:node17:switch_binary to ON [OnOffType]
2017-02-28 20:23:05.955 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Set, dest=17, callback=42, payload=11 07 60 0D 01 02 25 01 00
2017-02-28 20:23:05.957 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 11 03 20 01 FF
2017-02-28 20:23:05.964 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationCommandHandler, callback id=42, expected=SendData, cancelled=false      MISMATCH
2017-02-28 20:23:06.886 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 11 03 25 03 FF 39
2017-02-28 20:23:06.889 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-02-28 20:23:06.891 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 04 00 11 03 25 03 FF 39
2017-02-28 20:23:06.893 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 04 00 11 03 25 03 FF 39
2017-02-28 20:23:06.894 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 11 03 25 03 FF
2017-02-28 20:23:06.896 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 17: Application Command Request (ALIVE:DONE)
2017-02-28 20:23:06.897 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 17: Starting initialisation from DONE
2017-02-28 20:23:06.899 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@1b01cb6 already registered
2017-02-28 20:23:06.900 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 17: Incoming command class SWITCH_BINARY
2017-02-28 20:23:06.901 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - Received Switch Binary Request for Node ID = 17
2017-02-28 20:23:06.902 [DEBUG] [dclass.ZWaveBinarySwitchCommandClass] - NODE 17: Switch Binary report, value = 255
2017-02-28 20:23:06.903 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveCommandClassValueEvent
2017-02-28 20:23:06.904 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 17: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
2017-02-28 20:23:06.905 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 17: Got a value event from Z-Wave network, endpoint = 0, command class = SWITCH_BINARY, value = 255
2017-02-28 20:23:06.907 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 17: Updating channel state zwave:device:2947fb5e:node17:switch_binary to ON [OnOffType]
2017-02-28 20:23:06.910 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Set, dest=17, callback=42, payload=11 07 60 0D 01 02 25 01 00
2017-02-28 20:23:06.912 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 11 03 25 03 FF
2017-02-28 20:23:06.913 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationCommandHandler, callback id=42, expected=SendData, cancelled=false      MISMATCH
2017-02-28 20:23:07.916 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 00 11 0A 32 02 21 34 00 00 00 98 00 00 4D
2017-02-28 20:23:07.919 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
2017-02-28 20:23:07.923 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 10 00 04 00 11 0A 32 02 21 34 00 00 00 98 00 00 4D
2017-02-28 20:23:07.925 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 10 00 04 00 11 0A 32 02 21 34 00 00 00 98 00 00 4D
2017-02-28 20:23:07.926 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 11 0A 32 02 21 34 00 00 00 98 00 00
2017-02-28 20:23:07.927 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 17: Application Command Request (ALIVE:DONE)
2017-02-28 20:23:07.928 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 17: Starting initialisation from DONE
2017-02-28 20:23:07.929 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@1b01cb6 already registered
2017-02-28 20:23:07.930 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 17: Incoming command class METER
2017-02-28 20:23:07.931 [DEBUG] [.commandclass.ZWaveMeterCommandClass] - NODE 17: Received METER command V3
2017-02-28 20:23:07.932 [DEBUG] [.commandclass.ZWaveMeterCommandClass] - NODE 17: Meter: Type=Electric(1), Scale=W(2), Value=15.2
2017-02-28 20:23:07.933 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveMeterValueEvent
2017-02-28 20:23:07.933 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 17: Got an event from Z-Wave network: ZWaveMeterValueEvent
2017-02-28 20:23:07.934 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 17: Got a value event from Z-Wave network, endpoint = 0, command class = METER, value = 15.2
2017-02-28 20:23:07.935 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 17: Updating channel state zwave:device:2947fb5e:node17:meter_watts to 15.2 [DecimalType]
2017-02-28 20:23:07.936 [DEBUG] [ternal.converter.ZWaveMeterConverter] - Not the right scale E_KWh <> E_W
2017-02-28 20:23:07.938 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Set, dest=17, callback=42, payload=11 07 60 0D 01 02 25 01 00
2017-02-28 20:23:07.939 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 11 0A 32 02 21 34 00 00 00 98 00 00
2017-02-28 20:23:07.940 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationCommandHandler, callback id=42, expected=SendData, cancelled=false      MISMATCH
^C
pi@raspberrypi:~ $

I am running the latest stable release 2.0.0

How did you include the device to the Z-Wave network? Make sure that you use the inclusion function from within OH2 (worked for me with both Paper UI and Habmin) when your Z-Wave stick is connected. I had trouble when I included the devices first decentrally with my Aeon Z-Stick5 and then started OH2, as in these cases the different endpoints were never usable.
So if you included it otherwise you will have to exclude and reinclude the device.
For associations I only set lifeline and this is enough. Endpoints get correct updates and also the energy consumption for each switch.

BUT: The Qubinos react relatively slow, updates take always between 4-8 seconds. While this may be ok to see if a light is still on, it is not usable if you want to react quickly in a rule to this event. For this reason I replaced some of my Qubinos with the Fibaro FGS-223 which is the better choice for quick updates.

The ZMNHBD Flush 2 relay is running fine here with OH2 2.1.0.
The way I included it was with OH2 Habmin and not with the Gen5 Z-Stick Button.

Additionally, I didn’t link the “general Channels” - the ones first in the list for “compatibiltiy”, but only the “:switch_binary1” and “:switch_binary2” as well as their meter_watts. This works fine,
with the exception that when I used OH2 Paper GUI to change properties, I got the the group asscociations wrong in the json config, ie. the Error 404 discussed here.

Hope that helps anyone.

Does power and state reporting (on/off) work reliably for both endpoints after you included via Habmin? Just wondering why including via Habmin would make a difference. Does that mean I need to move the whole server around the house to include these devices again?

Does changing parameters via Habmin work, or do you also get messed up group associations?

In any case, this sounds like a real PITA and a no-go for buying further Qubino Flush 2 Relays.

I tried exactly that, have same setup as you, doesn’t work:

  • OH2 2.10 Snapshot
  • Qubino Flush Relay 2
  • Aeon Z-Stick Gen5
  • Excluded
  • Included via Habmin

Reporting back states / power doesn’t work (control does). Tried various settings for association groups.

Is this a OH2 specific problem? Are these devices the same PITA for solutions like Vera and Homeseer? What am I missing?

It used to be a problem some time ago. Since Release Version 2.0 I can confirm that it worked for me. I did not try all recent snapshot versions but they should work.
The dev branch of the Z-Wave binding has a problem with this at the moment, but snapshot should be fine.

Did you set the association group 1 to the controller?

Yes, but unfortunately setting Association Group 1 to “OpenHAB Controller” makes no difference. It also makes no difference how the device was included (directly via ZStick or via Habmin). Receiving state updates of switches/dimmers may have worked in the past for you, but it is not working in stable 2.1.0 and neither in current 2.2 snapshots (or at least for devices included in those releases). The problem is more generalized, see this thread: Status updates for Qubino Relays/Dimmers generally do not work