ZD2102-5 (Vision Door Sensor) only generates CLOSED state

Hi all,

I have a Vision ZD2102-5 (gen 5, z-wave plus) device which I have integrated with openHAB and I’m having a problem with the state of the sensor as it’s only reporting one state - closed.
2.4.0.M3 - ZWave Binding / openHAB Core

The device has the default configuration - there isn’t much to configure with these - but I’m not getting a satisfactory response from it.

I have tried excluding it and re-adding it from the controller, I have reset the device and I have also manually created items for it to see if I had a problem with the mapping of the automatically created items via PaperUI. But, none of this has helped.

The problem looks similar to this problem, but it’s not a dead-ringer.

When I pull the debug data from a manual open-close cycle of the device and input it into the z-wave log viewer, I can see the basic-set alarm-report being sent for the device opening and a v1level of 0xFF (255), but there is no corresponding state-update command being created.
When the device is closed, again I can see the basic-set alarm-report but with a v1level of 0x00 (0), but it’s followed by state-update CLOSED command.

Here’s the debug file with the open event at 21:34:13 and the corresponding close-event at 21:34:18…

21:34:13.624 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 0C 03 20 01 FF 23 
21:34:13.628 [DEBUG] [ave.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
21:34:13.632 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 04 00 0C 03 20 01 FF 23 
21:34:13.634 [DEBUG] [ave.internal.protocol.ZWaveController] - Process Message = 01 09 00 04 00 0C 03 20 01 FF 23 
21:34:13.636 [DEBUG] [ave.internal.protocol.ZWaveController] - Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 0C 03 20 01 FF 
21:34:13.638 [DEBUG] [essage.ApplicationCommandMessageClass] - NODE 12: Application Command Request (ALIVE:DONE)
21:34:13.640 [DEBUG] [ialization.ZWaveNodeInitStageAdvancer] - NODE 12: Starting initialisation from DONE
21:34:13.642 [DEBUG] [ave.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@1565ee1e already registered
21:34:13.644 [DEBUG] [essage.ApplicationCommandMessageClass] - NODE 12: Incoming command class BASIC
21:34:13.644 [DEBUG] [l.commandclass.ZWaveBasicCommandClass] - NODE 12: Received Basic Request
21:34:13.645 [DEBUG] [l.commandclass.ZWaveBasicCommandClass] - NODE 12: Basic Set sent to the controller will be processed as Basic Report
21:34:13.646 [DEBUG] [l.commandclass.ZWaveBasicCommandClass] - NODE 12: Basic report, value = 0xFF
21:34:13.647 [DEBUG] [ave.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveCommandClassValueEvent
21:34:13.648 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 12: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
21:34:13.649 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 12: Got a value event from Z-Wave network, endpoint = 0, command class = BASIC, value = 255
21:34:13.650 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 12: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
21:34:13.651 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 12: Got a value event from Z-Wave network, endpoint = 0, command class = BASIC, value = 255
21:34:13.652 [DEBUG] [essage.ApplicationCommandMessageClass] - NODE 9: Transaction not completed: node address inconsistent.  lastSent=9, incoming=255
21:34:13.807 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 00 0C 0A 71 05 06 FF 00 FF 06 16 00 00 8F 
21:34:13.809 [DEBUG] [ave.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
21:34:13.811 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 10 00 04 00 0C 0A 71 05 06 FF 00 FF 06 16 00 00 8F 
21:34:13.812 [DEBUG] [ave.internal.protocol.ZWaveController] - Process Message = 01 10 00 04 00 0C 0A 71 05 06 FF 00 FF 06 16 00 00 8F 
21:34:13.813 [DEBUG] [ave.internal.protocol.ZWaveController] - Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 0C 0A 71 05 06 FF 00 FF 06 16 00 00 
21:34:13.814 [DEBUG] [essage.ApplicationCommandMessageClass] - NODE 12: Application Command Request (ALIVE:DONE)
21:34:13.816 [DEBUG] [ialization.ZWaveNodeInitStageAdvancer] - NODE 12: Starting initialisation from DONE
21:34:13.817 [DEBUG] [ave.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@1565ee1e already registered
21:34:13.819 [DEBUG] [essage.ApplicationCommandMessageClass] - NODE 12: Incoming command class ALARM
21:34:13.820 [DEBUG] [l.commandclass.ZWaveAlarmCommandClass] - NODE 12: Received ALARM command V4
21:34:13.821 [DEBUG] [l.commandclass.ZWaveAlarmCommandClass] - NODE 12: Process NOTIFICATION_REPORT V4
21:34:13.822 [DEBUG] [l.commandclass.ZWaveAlarmCommandClass] - NODE 12: NOTIFICATION report - 6 = 255, event=22, status=255
21:34:13.824 [DEBUG] [l.commandclass.ZWaveAlarmCommandClass] - NODE 12: Alarm Type = ACCESS_CONTROL (6)
21:34:13.825 [DEBUG] [ave.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveAlarmValueEvent
21:34:13.826 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 12: Got an event from Z-Wave network: ZWaveAlarmValueEvent
21:34:13.828 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 12: Got a value event from Z-Wave network, endpoint = 0, command class = ALARM, value = 255
21:34:13.829 [DEBUG] [nternal.converter.ZWaveAlarmConverter] - Alarm converter processing NOTIFICATION
21:34:13.831 [DEBUG] [nternal.converter.ZWaveAlarmConverter] - Alarm converter NOTIFICATION event is 22, type OpenClosedType
21:34:13.832 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 12: Got an event from Z-Wave network: ZWaveAlarmValueEvent
21:34:13.834 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 12: Got a value event from Z-Wave network, endpoint = 0, command class = ALARM, value = 255
21:34:13.835 [DEBUG] [nternal.converter.ZWaveAlarmConverter] - Alarm converter processing NOTIFICATION
21:34:13.836 [DEBUG] [nternal.converter.ZWaveAlarmConverter] - Alarm converter NOTIFICATION event is 22, type OpenClosedType
21:34:13.837 [DEBUG] [essage.ApplicationCommandMessageClass] - NODE 9: Transaction not completed: node address inconsistent.  lastSent=9, incoming=255



21:34:18.301 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 09 00 04 00 0C 03 20 01 00 DC 
21:34:18.304 [DEBUG] [ave.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
21:34:18.307 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 04 00 0C 03 20 01 00 DC 
21:34:18.308 [DEBUG] [ave.internal.protocol.ZWaveController] - Process Message = 01 09 00 04 00 0C 03 20 01 00 DC 
21:34:18.312 [DEBUG] [ave.internal.protocol.ZWaveController] - Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 0C 03 20 01 00 
21:34:18.314 [DEBUG] [essage.ApplicationCommandMessageClass] - NODE 12: Application Command Request (ALIVE:DONE)
21:34:18.315 [DEBUG] [ialization.ZWaveNodeInitStageAdvancer] - NODE 12: Starting initialisation from DONE
21:34:18.316 [DEBUG] [ave.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@1565ee1e already registered
21:34:18.318 [DEBUG] [essage.ApplicationCommandMessageClass] - NODE 12: Incoming command class BASIC
21:34:18.319 [DEBUG] [l.commandclass.ZWaveBasicCommandClass] - NODE 12: Received Basic Request
21:34:18.321 [DEBUG] [l.commandclass.ZWaveBasicCommandClass] - NODE 12: Basic Set sent to the controller will be processed as Basic Report
21:34:18.323 [DEBUG] [l.commandclass.ZWaveBasicCommandClass] - NODE 12: Basic report, value = 0x00
21:34:18.324 [DEBUG] [ave.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveCommandClassValueEvent
21:34:18.325 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 12: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
21:34:18.326 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 12: Got a value event from Z-Wave network, endpoint = 0, command class = BASIC, value = 0
21:34:18.327 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 12: Got an event from Z-Wave network: ZWaveCommandClassValueEvent
21:34:18.328 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 12: Got a value event from Z-Wave network, endpoint = 0, command class = BASIC, value = 0
21:34:18.329 [DEBUG] [essage.ApplicationCommandMessageClass] - NODE 9: Transaction not completed: node address inconsistent.  lastSent=9, incoming=255
21:34:18.484 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 00 0C 0A 71 05 06 00 00 FF 06 17 00 00 71 
21:34:18.485 [DEBUG] [ave.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
21:34:18.487 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 10 00 04 00 0C 0A 71 05 06 00 00 FF 06 17 00 00 71 
21:34:18.491 [DEBUG] [ave.internal.protocol.ZWaveController] - Process Message = 01 10 00 04 00 0C 0A 71 05 06 00 00 FF 06 17 00 00 71 
21:34:18.493 [DEBUG] [ave.internal.protocol.ZWaveController] - Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 0C 0A 71 05 06 00 00 FF 06 17 00 00 
21:34:18.495 [DEBUG] [essage.ApplicationCommandMessageClass] - NODE 12: Application Command Request (ALIVE:DONE)
21:34:18.496 [DEBUG] [ialization.ZWaveNodeInitStageAdvancer] - NODE 12: Starting initialisation from DONE
21:34:18.496 [DEBUG] [ave.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@1565ee1e already registered
21:34:18.497 [DEBUG] [essage.ApplicationCommandMessageClass] - NODE 12: Incoming command class ALARM
21:34:18.498 [DEBUG] [l.commandclass.ZWaveAlarmCommandClass] - NODE 12: Received ALARM command V4
21:34:18.499 [DEBUG] [l.commandclass.ZWaveAlarmCommandClass] - NODE 12: Process NOTIFICATION_REPORT V4
21:34:18.500 [DEBUG] [l.commandclass.ZWaveAlarmCommandClass] - NODE 12: NOTIFICATION report - 6 = 0, event=23, status=255
21:34:18.501 [DEBUG] [l.commandclass.ZWaveAlarmCommandClass] - NODE 12: Alarm Type = ACCESS_CONTROL (6)
21:34:18.502 [DEBUG] [ave.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveAlarmValueEvent
21:34:18.503 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 12: Got an event from Z-Wave network: ZWaveAlarmValueEvent
21:34:18.504 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 12: Got a value event from Z-Wave network, endpoint = 0, command class = ALARM, value = 255
21:34:18.506 [DEBUG] [nternal.converter.ZWaveAlarmConverter] - Alarm converter processing NOTIFICATION
21:34:18.507 [DEBUG] [nternal.converter.ZWaveAlarmConverter] - Alarm converter NOTIFICATION event is 23, type OpenClosedType
21:34:18.508 [DEBUG] [nternal.converter.ZWaveAlarmConverter] - Alarm converter NOTIFICATION 3
21:34:18.510 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 12: Updating channel state zwave:device:c7937d7e:node12:sensor_door to CLOSED [OpenClosedType]
21:34:18.512 [WARN ] [e.core.thing.binding.BaseThingHandler] - Handler ZWaveThingHandler of thing zwave:device:c7937d7e:node12 tried updating channel sensor_door although the handler was already disposed.
21:34:18.513 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 12: Got an event from Z-Wave network: ZWaveAlarmValueEvent
21:34:18.514 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 12: Got a value event from Z-Wave network, endpoint = 0, command class = ALARM, value = 255
21:34:18.516 [DEBUG] [nternal.converter.ZWaveAlarmConverter] - Alarm converter processing NOTIFICATION
21:34:18.517 [DEBUG] [nternal.converter.ZWaveAlarmConverter] - Alarm converter NOTIFICATION event is 23, type OpenClosedType
21:34:18.519 [DEBUG] [nternal.converter.ZWaveAlarmConverter] - Alarm converter NOTIFICATION 3
21:34:18.520 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 12: Updating channel state zwave:device:c7937d7e:node12:sensor_door to CLOSED [OpenClosedType]
21:34:18.522 [DEBUG] [essage.ApplicationCommandMessageClass] - NODE 9: Transaction not completed: node address inconsistent.  lastSent=9, incoming=255
21:34:18.674 [DEBUG] [ZWaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 00 0C 0A 71 05 06 00 00 FF 06 17 00 00 71 
21:34:18.677 [DEBUG] [ave.internal.protocol.ZWaveController] - Receive queue TAKE: Length=0
21:34:18.679 [DEBUG] [zwave.internal.protocol.SerialMessage] - Assembled message buffer = 01 10 00 04 00 0C 0A 71 05 06 00 00 FF 06 17 00 00 71 
21:34:18.680 [DEBUG] [ave.internal.protocol.ZWaveController] - Process Message = 01 10 00 04 00 0C 0A 71 05 06 00 00 FF 06 17 00 00 71 
21:34:18.682 [DEBUG] [ave.internal.protocol.ZWaveController] - Message: class=ApplicationCommandHandler[0x04], type=Request[0x00], priority=High, dest=255, callback=0, payload=00 0C 0A 71 05 06 00 00 FF 06 17 00 00 
21:34:18.683 [DEBUG] [essage.ApplicationCommandMessageClass] - NODE 12: Application Command Request (ALIVE:DONE)
21:34:18.684 [DEBUG] [ialization.ZWaveNodeInitStageAdvancer] - NODE 12: Starting initialisation from DONE
21:34:18.685 [DEBUG] [ave.internal.protocol.ZWaveController] - Event Listener org.openhab.binding.zwave.internal.protocol.initialization.ZWaveNodeInitStageAdvancer@1565ee1e already registered
21:34:18.687 [DEBUG] [essage.ApplicationCommandMessageClass] - NODE 12: Incoming command class ALARM
21:34:18.692 [DEBUG] [l.commandclass.ZWaveAlarmCommandClass] - NODE 12: Received ALARM command V4
21:34:18.693 [DEBUG] [l.commandclass.ZWaveAlarmCommandClass] - NODE 12: Process NOTIFICATION_REPORT V4
21:34:18.694 [DEBUG] [l.commandclass.ZWaveAlarmCommandClass] - NODE 12: NOTIFICATION report - 6 = 0, event=23, status=255
21:34:18.695 [DEBUG] [l.commandclass.ZWaveAlarmCommandClass] - NODE 12: Alarm Type = ACCESS_CONTROL (6)
21:34:18.696 [DEBUG] [ave.internal.protocol.ZWaveController] - Notifying event listeners: ZWaveAlarmValueEvent
21:34:18.697 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 12: Got an event from Z-Wave network: ZWaveAlarmValueEvent
21:34:18.699 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 12: Got a value event from Z-Wave network, endpoint = 0, command class = ALARM, value = 255
21:34:18.703 [DEBUG] [nternal.converter.ZWaveAlarmConverter] - Alarm converter processing NOTIFICATION
21:34:18.704 [DEBUG] [nternal.converter.ZWaveAlarmConverter] - Alarm converter NOTIFICATION event is 23, type OpenClosedType
21:34:18.705 [DEBUG] [nternal.converter.ZWaveAlarmConverter] - Alarm converter NOTIFICATION 3
21:34:18.706 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 12: Updating channel state zwave:device:c7937d7e:node12:sensor_door to CLOSED [OpenClosedType]
21:34:18.708 [WARN ] [e.core.thing.binding.BaseThingHandler] - Handler ZWaveThingHandler of thing zwave:device:c7937d7e:node12 tried updating channel sensor_door although the handler was already disposed.
21:34:18.712 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 12: Got an event from Z-Wave network: ZWaveAlarmValueEvent
21:34:18.713 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 12: Got a value event from Z-Wave network, endpoint = 0, command class = ALARM, value = 255
21:34:18.714 [DEBUG] [nternal.converter.ZWaveAlarmConverter] - Alarm converter processing NOTIFICATION
21:34:18.715 [DEBUG] [nternal.converter.ZWaveAlarmConverter] - Alarm converter NOTIFICATION event is 23, type OpenClosedType
21:34:18.716 [DEBUG] [nternal.converter.ZWaveAlarmConverter] - Alarm converter NOTIFICATION 3
21:34:18.725 [DEBUG] [nding.zwave.handler.ZWaveThingHandler] - NODE 12: Updating channel state zwave:device:c7937d7e:node12:sensor_door to CLOSED [OpenClosedType]
21:34:18.728 [DEBUG] [essage.ApplicationCommandMessageClass] - NODE 9: Transaction not completed: node address inconsistent.  lastSent=9, incoming=255

Can anybody shed some light on the issue as it’s evading my attempts at prodding it.
Thanks, R.

Please try the latest snapshot - see the link below -:

Oh wow, that was quick. Thanks Chris.
I’ll read into that now.

If you still have problems, let me know, but I think it will work in that version.

Just for the record and completeness, I followed these two articles:

Updating from STABLE to SNAPSHOT:

Working around a stuck milestone:

More to follow…

Yay, progress.

09:21:59.351 [INFO ] [smarthome.event.ItemStateChangedEvent] - zwave_device_c7937d7e_node13_sensor_door changed from NULL to CLOSED
09:22:04.744 [INFO ] [smarthome.event.ItemStateChangedEvent] - zwave_device_c7937d7e_node13_sensor_door changed from CLOSED to OPEN
09:22:12.534 [INFO ] [smarthome.event.ItemStateChangedEvent] - zwave_device_c7937d7e_node13_sensor_door changed from OPEN to CLOSED
09:22:13.632 [INFO ] [smarthome.event.ItemStateChangedEvent] - zwave_device_c7937d7e_node13_sensor_door changed from CLOSED to OPEN

But I do find this little device is hard to include into the network as it sleeps frequently. If I had more than one, which I plan on having, it’s going to be very difficult to manage all of their inclusions.
I suppose that’s more of a design/firmware problem on the hardware side than on openHAB’s side.
I’ll see what happens now that I have set the polling period from 1 day to 10 mins under this snapshot build of openhab.

This is standard for ZWave battery devices.

Why? Just do them one at a time - it should not be an issue.

I would not recommend using a 10 minute polling period - it will reduce battery life, and is not necessary unless you are planning on changing parameters very often (which shouldn’t be necessary on a door sensor as there’s not a lot that should need changing on a regular basis?). I would recommend sticking to 1 hour or above, but up to you :wink: .

Hi Chris,

Yes, the sleeping I understand, but the device is overly sleepy and that’s adding to delays in it coming fully online, even after a full 24hrs. I can wake the device manually, but pending commands don’t complete on it even when it’s awake. Let me work on that to see if it’s me or my process as it just seems to be finicky.

The 10min polling period is just for the initial config, I’ll set it to something longer once I work out all the creases.

Wanted to also chime in, and thank @RonnieLast I have the same door/window sensor and not entirely sure what happened other than giving the zwave beta a test drive and downgrading the binding did not fix the issue.

At the moment I do see the sensors opening now, however battery status are not showing on the item. Other battery devices report in, so I’m not 100% sure how to troubleshoot that. I was under the impression it would be sent during its wakeup time or when the sensor changes its state?
Currently running 2.4.0~20181004001205-1.