No devices found with Vision ZU1401-5 Z-Wave USB dongle

Tags: #<Tag:0x00007f1872e0baf0>
  • Platform information:
    • Hardware: Raspberry Pi 3B
    • OS: Openhabian 1.5
    • Java Runtime Environment: I do not know, I ran all updates in the config tool
    • openHAB version: 2.4.0-1

I am not able to discover any Z-Wave devices with the Vision ZU1401-5 USB dongle. The Z-Wave binding is installed and shows “online” (I installed and configured it in PaperUI). When I click on the ‘+’ in the inbox and choose the Z-Wave binding then my assumption is that I should be able to include my Z-Wave sensor (by power up and press connect button) and see it in Openhab.
When doing so the Vision ZU1401-5 does not show any change in the LEDs visible. The sensor I use is a WADWAZ-1 an listed as compatible device. I repeated the whole inclusion process several times with different settings for the Z-Wave binding and different sensors without succes. I also do not get any error messages.

I managed to switch the log to debug mode and got that output when pressing the ‘+’ in the inbox:

2019-11-30 14:27:37.395 [arthome.event.BindingEvent] - org.openhab.binding.zwave.event.BindingEvent@361307

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

2019-11-30 14:27:37.398 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: notifyTransactionResponse TID:23 DONE

2019-11-30 14:27:37.401 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty

2019-11-30 14:27:37.403 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

2019-11-30 14:28:07.290 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - ZWave discovery: Stop zwave:serial_zstick:c1ac8adc

2019-11-30 14:28:07.292 [DEBUG] [al.protocol.ZWaveInclusionController] - ZWave controller stopping inclusion at IncludeStart

2019-11-30 14:28:07.294 [DEBUG] [ol.serialmessage.AddNodeMessageClass] - Ending INCLUSION mode.

2019-11-30 14:28:07.296 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Added 24 to queue - size 1

2019-11-30 14:28:07.298 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

2019-11-30 14:28:07.300 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 05 00 4A 05 11 A4

2019-11-30 14:28:07.302 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 05 00 4A 05 11 A4

2019-11-30 14:28:07.304 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT

2019-11-30 14:28:07.306 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 24: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 17

2019-11-30 14:28:07.307 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06

2019-11-30 14:28:07.311 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=

2019-11-30 14:28:07.314 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=

2019-11-30 14:28:07.315 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 24: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 17

2019-11-30 14:28:07.317 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK

2019-11-30 14:28:07.319 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty

2019-11-30 14:28:07.320 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

2019-11-30 14:28:07.357 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 4A 11 06 00 00 A5

2019-11-30 14:28:07.360 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=AddNodeToNetwork[74], type=Request[0], dest=6, callback=17, payload=11 06 00 00

2019-11-30 14:28:07.362 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=AddNodeToNetwork[74], type=Request[0], dest=6, callback=17, payload=11 06 00 00

2019-11-30 14:28:07.364 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 24: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 17

2019-11-30 14:28:07.366 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1

2019-11-30 14:28:07.368 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 24: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 17

2019-11-30 14:28:07.370 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 24: (Callback 17)

2019-11-30 14:28:07.372 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!

2019-11-30 14:28:07.374 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 24: callback 17

2019-11-30 14:28:07.376 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=AddNodeToNetwork[74], type=Request[0], dest=6, callback=17, payload=11 06 00 00

2019-11-30 14:28:07.378 [DEBUG] [ol.serialmessage.AddNodeMessageClass] - Add Node: Done.

2019-11-30 14:28:07.380 [DEBUG] [al.protocol.ZWaveInclusionController] - Inclusion event: Current state IncludeDone, new event IncludeDone

2019-11-30 14:28:07.382 [DEBUG] [ol.serialmessage.AddNodeMessageClass] - Ending INCLUSION mode.

2019-11-30 14:28:07.384 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Added 25 to queue - size 1

2019-11-30 14:28:07.387 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

2019-11-30 14:28:07.388 [DEBUG] [al.protocol.ZWaveInclusionController] - ZWave controller end exclusion

2019-11-30 14:28:07.391 [DEBUG] [ve.internal.protocol.ZWaveController] - ZWaveController include done

2019-11-30 14:28:07.392 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 24: Advanced to DONE

2019-11-30 14:28:07.395 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: Response processed after 88ms

2019-11-30 14:28:07.396 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: TID 24: Transaction completed

2019-11-30 14:28:07.398 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: notifyTransactionResponse TID:24 DONE

2019-11-30 14:28:07.401 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty

2019-11-30 14:28:07.404 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

2019-11-30 14:28:07.406 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 05 00 4A 05 00 B5

2019-11-30 14:28:07.409 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 255: Sending REQUEST Message = 01 05 00 4A 05 00 B5

2019-11-30 14:28:07.411 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT

2019-11-30 14:28:07.412 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06

2019-11-30 14:28:07.413 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 25: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 0

2019-11-30 14:28:07.415 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=

2019-11-30 14:28:07.418 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=

2019-11-30 14:28:07.419 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 25: [WAIT_REQUEST] priority=Controller, requiresResponse=true, callback: 0

2019-11-30 14:28:07.421 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK

2019-11-30 14:28:07.423 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty

2019-11-30 14:28:07.425 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.

2019-11-30 14:28:12.415 [DEBUG] [sactionManager$ZWaveTransactionTimer] - NODE 255: TID 25: Timeout at state WAIT_REQUEST. 3 retries remaining.

2019-11-30 14:28:12.417 [DEBUG] [sactionManager$ZWaveTransactionTimer] - TID 25: Transaction is current transaction, so clearing!!!

2019-11-30 14:28:12.419 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 25: Transaction CANCELLED

2019-11-30 14:28:12.421 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 255: notifyTransactionResponse TID:25 CANCELLED

2019-11-30 14:28:12.423 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.

2019-11-30 14:28:51.287 [DEBUG] [al.protocol.ZWaveInclusionController] - ZWave inclusion controller finalised`

Please use the code fences
I also added the z-wave tag
and changed the category

Hi Vincent
Thanks for correcting, I tried but looks like I failed to create an appropriate post, I apologize. I added the code start/stop tags.

Regards,
Andreas