FGPB-101 not recognized properly

I run it in scene mode and I use the same rule as here: FGPB-101 not recognized properly - #22 by brononius

I think that you did the right move and send your xml to Chris… I don’t know what could be wrong here :slight_smile:

By the way: I think that number is the color code (Mine is Red = 3… your is Blue? = 6)… I may be wrong

@Dim
By the way: I think that number is the color code (Mine is Red = 3… your is Blue? = 6)… I may be wrong

Yes, you are right. My button is blue.- thx

@Dim
I run it in scene mode and I use the same rule as here: FGPB-101 not recognized properly - #22 by brononius

ok, thanks. I have got this rule as well but it doesn’t trigger since the button is not correctly initialized which is strange as it worked with openhab 1 previously.

try removing the xml file (back it up first) and the thing from openHAB2 and scan for new things again.
Maybe the original initialization was not performed correctly.

edit: I just saw that you already tried this and it didn’t help … :frowning:

Hi. Sorry for the delay - I’ve been travelling on holiday for the past few weeks… Anyway, you should now have access.

Chris

@chris, np. Hope you had a great holiday.

I uploaded node38.xml to Device Overview and requested review. Let me know if you need anything e.g. logs … -thx

@chris, have you had the chance to look at the xml file for the FGPB-101, I uplouded to Device Overview? Let me know whether I can help. -thx

No - I don’t tend to look at these files as they are processed by the system. I double checked though and your device is already listed in the database so it should really be detected. Which version of the binding are you running? If it’s a recent version, then please provide a debug log and I’ll have a look at what’s up.

Yes, it is detected but it looks like the FGPB-101 gets mapped to the wrong device classes:

23:19:07.111 [DEBUG] [class.ZWaveMultiInstanceCommandClass] - NODE 38: Received MULTI_INSTANCE command V0
23:19:07.112 [DEBUG] [class.ZWaveMultiInstanceCommandClass] - NODE 38: Requested Command Class = SWITCH_MULTILEVEL (0x26)
23:19:07.112 [ERROR] [class.ZWaveMultiInstanceCommandClass] - NODE 38: Endpoint 0 not found. Cannot set command classes.

Z-WAVE binding version: binding-zwave - 2.1.0.SNAPSHOT.

I did exclude the device first and included it again hence it is NODE 41.
DEBUG logs for device inclusion:

17:45:58.291 [INFO ] [smarthome.event.BindingEvent        ] - org.openhab.binding.zwave.event.BindingEvent@1f87e52
17:46:00.453 [INFO ] [mmandclass.ZWaveSecurityCommandClass] - NODE 41: setupNetworkKey useSchemeZero=false
17:46:03.488 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing 'zwave:device:1598d492b5d:node41' to inbox.
17:46:03.489 [INFO ] [smarthome.event.InboxAddedEvent     ] - Discovery Result with UID 'zwave:device:1598d492b5d:node41' has been added.
17:46:03.509 [INFO ] [smarthome.event.BindingEvent        ] - org.openhab.binding.zwave.event.BindingEvent@fafa89
17:46:17.627 [DEBUG] [io.socket.engineio.client.Socket    ] - writing ping packet - expecting pong within 60000ms
17:46:17.629 [DEBUG] [io.socket.engineio.client.Socket    ] - flushing 1 packets in socket
17:46:17.654 [DEBUG] [io.socket.engineio.client.Socket    ] - socket received: type 'pong', data 'null'
17:46:24.169 [INFO ] [smarthome.event.BindingEvent        ] - org.openhab.binding.zwave.event.BindingEvent@1ec57c7
17:46:27.847 [INFO ] [marthome.event.ItemStateChangedEvent] - insideLuminance changed from 5 to 7
17:46:27.857 [INFO ] [marthome.event.ItemStateChangedEvent] - MultiSensor_SensorLuminance changed from 5 to 7
17:53:47.447 [INFO ] [smarthome.event.InboxRemovedEvent   ] - Discovery Result with UID 'zwave:device:1598d492b5d:node41' has been removed.
17:53:47.477 [INFO ] [smarthome.event.ThingAddedEvent     ] - Thing 'zwave:device:1598d492b5d:node41' has been added.
17:53:47.583 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'zwave:device:1598d492b5d:node41' changed from UNINITIALIZED to INITIALIZING
17:53:47.627 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'zwave:device:1598d492b5d:node41' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
17:53:47.667 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'zwave:device:1598d492b5d:node41' changed from OFFLINE (BRIDGE_OFFLINE): Controller is offline to UNINITIALIZED (HANDLER_MISSING_ERROR)
17:53:47.927 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'zwave:device:1598d492b5d:node41' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
17:53:47.938 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'zwave:device:1598d492b5d:node41' changed from INITIALIZING to OFFLINE (BRIDGE_OFFLINE): Controller is offline
17:53:48.022 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'zwave:device:1598d492b5d:node41' changed from OFFLINE (BRIDGE_OFFLINE): Controller is offline to ONLINE
17:53:48.030 [INFO ] [smarthome.event.ThingUpdatedEvent   ] - Thing 'zwave:device:1598d492b5d:node41' has been updated.
17:53:48.164 [WARN ] [ding.zwave.handler.ZWaveThingHandler] - NODE 41: Initialising Thing Node...
17:53:48.166 [INFO ] [smarthome.event.ThingUpdatedEvent   ] - Thing 'zwave:device:1598d492b5d:node41' has been updated.
17:53:48.177 [INFO ] [marthome.event.ConfigStatusInfoEvent] - ConfigStatusInfo [configStatusMessages=[]]
17:53:48.543 [DEBUG] [io.socket.engineio.client.Socket    ] - writing ping packet - expecting pong within 60000ms
17:53:48.544 [DEBUG] [io.socket.engineio.client.Socket    ] - flushing 1 packets in socket
17:53:48.889 [DEBUG] [io.socket.engineio.client.Socket    ] - socket received: type 'pong', data 'null'
17:54:13.898 [DEBUG] [io.socket.engineio.client.Socket    ] - writing ping packet - expecting pong within 60000ms
17:54:13.910 [DEBUG] [io.socket.engineio.client.Socket    ] - flushing 1 packets in socket
17:54:13.939 [DEBUG] [io.socket.engineio.client.Socket    ] - socket received: type 'pong', data 'null'

DEBUG logs when I push the button once:

17:57:08.700 [ERROR] [class.ZWaveMultiInstanceCommandClass] - NODE 41: Endpoint 0 not found. Cannot set command classes.
17:57:09.534 [DEBUG] [io.socket.engineio.client.Socket    ] - writing ping packet - expecting pong within 60000ms
17:57:09.540 [DEBUG] [io.socket.engineio.client.Socket    ] - flushing 1 packets in socket
17:57:09.580 [DEBUG] [io.socket.engineio.client.Socket    ] - socket received: type 'pong', data 'null'

My items definition is as follows. Please note the battery items works, but not the mushroomNumber

Number mushroomNumber "Mushroom Scene" (gBedroom, gDebug) { channel="zwave:device:1598d492b5d:node40:scene_number" }
Number mushroomBattery "Mushroom Battery[%s %%]" <battery> (gBattery) { channel="zwave:device:1598d492b5d:node40:battery-level" }

This button worked properly when I used it in openHAB1. But I cannot get it working in openHAB2. I successfully included my other 20 ZWAVE devices, but not the FGPB-101 :frowning: , what do I wrong?

-thx

I’m not sure what you mean - the device classes aren’t really used for anything, but can you provide some information on this please. It’s quite unlikely it’s using the wrong device class anyway unless the device is reporting this :confused:.

For the received messages, I really need to see the debug message shows the data being received.

Also, can you confirm that you’re using the latest snapshot binding or are you using something older (like the release version)?

I did run the release version, which I updated to the latest snapshot: http://dl.bintray.com/openhab/apt-repo2 unstable main. The FGPB-101 button works fine now. Thanks for that hint.

1 Like

I am having trouble with the button. I do not get scene_number identified.
Could someone please help me with analyzing the log below finding what is wrong?

2018-08-25 23:21:45.519 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 08 00 04 00 09 02 84 07 7B 

2018-08-25 23:21:45.528 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0

2018-08-25 23:21:45.535 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 08 00 04 00 09 02 84 07 7B 

2018-08-25 23:21:45.540 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 08 00 04 00 09 02 84 07 7B 

2018-08-25 23:21:45.557 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 09 02 84 07 

2018-08-25 23:21:45.561 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 9: Application Command Request (ALIVE:DONE)

2018-08-25 23:21:45.575 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 9: Starting initialisation from DONE

2018-08-25 23:21:45.579 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@3410a already registered

2018-08-25 23:21:45.585 [DEBUG] [ssage.ApplicationCommandMessageClass] - NODE 9: Incoming command class WAKE_UP

2018-08-25 23:21:45.590 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 9: Received Wake Up Request

2018-08-25 23:21:45.596 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 9: Received WAKE_UP_NOTIFICATION

2018-08-25 23:21:45.600 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 9: Is awake with 0 messages in the wake-up queue.

2018-08-25 23:21:45.605 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveWakeUpEvent

2018-08-25 23:21:45.610 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Got an event from Z-Wave network: ZWaveWakeUpEvent

2018-08-25 23:21:45.659 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Immediate, dest=9, callback=167, payload=09 02 84 08 

==> /var/log/openhab2/events.log <==

2018-08-25 23:21:45.682 [me.event.ThingUpdatedEvent] - Thing 'zwave:device:15cf518cecd:node9' has been updated.

==> /var/log/openhab2/openhab.log <==

2018-08-25 23:21:45.692 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 09 02 84 07 

2018-08-25 23:21:45.698 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=ApplicationCommandHandler, callback id=167, expected=SendData, cancelled=true      MISMATCH

2018-08-25 23:21:46.649 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 9: No more messages, go back to sleep

2018-08-25 23:21:46.655 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 9: Creating new message for application command WAKE_UP_NO_MORE_INFORMATION

2018-08-25 23:21:46.659 [DEBUG] [ve.internal.protocol.ZWaveController] - Message queued. Queue length = 1. Queue={}

2018-08-25 23:21:46.659 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - Took message from queue for sending. Queue length = 0

2018-08-25 23:21:46.665 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 09 02 84 08 25 A8 EF 

2018-08-25 23:21:46.669 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 9: Sending REQUEST Message = 01 09 00 13 09 02 84 08 25 A8 EF 

2018-08-25 23:21:46.684 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8 

2018-08-25 23:21:46.688 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0

2018-08-25 23:21:46.691 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 04 01 13 01 E8 

2018-08-25 23:21:46.695 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 04 01 13 01 E8 

2018-08-25 23:21:46.699 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Response[0x01], priority=High, dest=255, callback=0, payload=01 

2018-08-25 23:21:46.703 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 9: Sent Data successfully placed on stack.

2018-08-25 23:21:46.700 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 A8 00 00 02 41 

2018-08-25 23:21:46.717 [DEBUG] [ve.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0

2018-08-25 23:21:46.722 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 A8 00 00 02 00 00 4F 

2018-08-25 23:21:46.726 [DEBUG] [ve.internal.protocol.ZWaveController] - Process Message = 01 09 00 13 A8 00 00 02 00 00 4F 

2018-08-25 23:21:46.731 [DEBUG] [ve.internal.protocol.ZWaveController] - Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=A8 00 00 02 

2018-08-25 23:21:46.735 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 9: SendData Request. CallBack ID = 168, Status = Transmission complete and ACK received(0)

2018-08-25 23:21:46.739 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 9: Starting initialisation from DONE

2018-08-25 23:21:46.743 [DEBUG] [ve.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@3410a already registered

2018-08-25 23:21:46.747 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Sent Message: class=SendData[0x13], type=Request[0x00], priority=Immediate, dest=9, callback=168, payload=09 02 84 08 

2018-08-25 23:21:46.750 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: Recv Message: class=SendData[0x13], type=Request[0x00], priority=High, dest=255, callback=0, payload=A8 00 00 02 

2018-08-25 23:21:46.753 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Checking transaction complete: class=SendData, callback id=168, expected=SendData, cancelled=false        transaction complete!

2018-08-25 23:21:46.755 [DEBUG] [ve.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveTransactionCompletedEvent

2018-08-25 23:21:46.758 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 9: Went to sleep

2018-08-25 23:21:46.760 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 9: Is sleeping

2018-08-25 23:21:46.763 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 9: Went to sleep

2018-08-25 23:21:46.765 [DEBUG] [commandclass.ZWaveWakeUpCommandClass] - NODE 9: Is sleeping

2018-08-25 23:21:46.768 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 9: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent

2018-08-25 23:21:46.771 [DEBUG] [ocol.ZWaveController$ZWaveSendThread] - NODE 9: Response processed after 100ms/4990ms.