What does the Thing show in Paper UI or HABmin? It should be showing up as a VRCS4, which is incorrect. I made the change in the DB so that it will discover as a VRCZ4, but that change is not included in the zwave binding yet.
Can you put the binding into debug mode and then post the debug log from when you push a button?
It may be showing up as Unknown because, even though itās in the database, it might not have been in the database when the OH release was built. Youāre on 2.3, right? Thatās pretty dated at this point (May, I think).
Until youāre running a version of the binding that includes this device, you wonāt be able to do anything with it.
Thereās a way to switch from an OH release version to a snapshot version, but I donāt know how to do that. Thereās also a new release process called milestone builds, which are intended to be a good compromise between full releases and snapshots.
Personally, I run all my OH systems (I have three) on snapshot releases.
As for debug mode, in the karaf console, you would type:
@mhilbush It is being added as a VRCZ4. When I configure the association on the device, it appears to take it, but when I go back in the configuration is gone. When I push a left side of the rocker on the device, it lights up all the LEDs, and the openHAB log shows: DownstairsHallPanelLeft_SceneNumber changed from 0 to 255. Then when I push the right side, it turns all the LEDs off and the log shows: DownstairsHallPanelLeft_SceneNumber changed from 255 to 0.
@mhilbush It is a zone controller, so I would expect that once I configured the association groups, it would control those devices in that group. I activate the binding debug and this is what I am seeing in the log:
2018-09-23 09:46:17.027 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Configuration update received
2018-09-23 09:46:17.033 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Configuration update set binding_cmdrepollperiod to 1500 (BigDecimal)
2018-09-23 09:46:17.056 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Configuration update set group_4 to null (null)
2018-09-23 09:46:17.059 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Unknown association group 4
2018-09-23 09:46:17.061 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Configuration update set action_failed to false (Boolean)
2018-09-23 09:46:17.062 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Configuration update set action_remove to false (Boolean)
2018-09-23 09:46:17.064 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Configuration update set group_1 to [node_3, node_2] (ArrayList)
2018-09-23 09:46:17.066 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Unknown association group 1
2018-09-23 09:46:17.067 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Configuration update set binding_pollperiod to 86400 (BigDecimal)
2018-09-23 09:46:17.081 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Polling intialised at 86400 seconds - start in 39225600 milliseconds.
2018-09-23 09:46:17.083 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Configuration update set group_3 to null (null)
2018-09-23 09:46:17.085 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Unknown association group 3
2018-09-23 09:46:17.087 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Configuration update set group_2 to null (null)
2018-09-23 09:46:17.089 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Unknown association group 2
2018-09-23 09:46:17.091 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Configuration update set action_heal to false (Boolean)
2018-09-23 09:46:17.093 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Configuration update set nodename_name to null (null)
2018-09-23 09:46:17.095 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Error setting NodeNamingCommandClass name to invalid value null
2018-09-23 09:46:17.097 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Configuration update set nodename_location to null (null)
2018-09-23 09:46:17.099 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Error setting NodeNamingCommandClass location to invalid value null
2018-09-23 09:46:17.101 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Configuration update set node_id to 12 (BigDecimal)
2018-09-23 09:46:17.103 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE12: Configuration invalid node_id
I am new to this whole ZWave thing, but it looks like device is not being sent the correct data to do the association.
Can you post the contents of the node xml file for this device? The file is in the userdata/zwave directory, and will be of the form network_nnnnnnnn__node12.xml, where nnnnnnnn is the network ID
Please use code fences when posting. Code fences also are helpful when posting debug logs, like this:
2018-09-23 09:46:17.027 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Configuration update received
2018-09-23 09:46:17.033 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Configuration update set binding_cmdrepollperiod to 1500 (BigDecimal)
2018-09-23 09:46:17.056 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Configuration update set group_4 to null (null)
2018-09-23 09:46:17.059 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Unknown association group 4
2018-09-23 09:46:17.061 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Configuration update set action_failed to false (Boolean)
2018-09-23 09:46:17.062 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Configuration update set action_remove to false (Boolean)
2018-09-23 09:46:17.064 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Configuration update set group_1 to [node_3, node_2] (ArrayList)
2018-09-23 09:46:17.066 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Unknown association group 1
2018-09-23 09:46:17.067 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Configuration update set binding_pollperiod to 86400 (BigDecimal)
2018-09-23 09:46:17.081 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Polling intialised at 86400 seconds - start in 39225600 milliseconds.
2018-09-23 09:46:17.083 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Configuration update set group_3 to null (null)
2018-09-23 09:46:17.085 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Unknown association group 3
2018-09-23 09:46:17.087 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Configuration update set group_2 to null (null)
2018-09-23 09:46:17.089 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 12: Unknown association group 2
@mhilbush OK, now I am seeing something strange. I added another couple of the VRCZ4 controllers, and the XML files are not appearing. I can see the XML files for the first two, but am not seeing them for the new ones. Is there something that could cause a delay in the creation?
The XML is created once the device has completed initialization. This can sometimes involve quite a few transactions between the binding and the device. For mains devices, this usually happens within a couple minutes. If there are problems communicating with the device, it could take longer.