Chris,
I have upgraded to OpenHAB 2.2 Snapshot and NZW37 2-Channel Dual Smart Plug is listed and works. Nice work. I’ll have to add the 1-Channel version from Inovelli. I purchased both the single and double outlet versions.
Glad it’s working. If you register on the site, drop me an email and I’ll update your access so you can add/edit.
Cheers
Chris
Ticket was created. I can send an email too.
Sully
I updated your access last night, so you should be good to go 
.
I see I’m late to the party in replying, but yes I got it to work and I did it by upgrading to the snapshot. It was an easier process than I expected. There was an option in the GUI.
Hi Chris,
I’d like to migrate to OpenHAB some day. I am testing OpenHAB 2.3.0 on A Raspberry Pi OpenHabian. I am using a Aeotec ZStick as Zwave controller whcih was discovered properly. However, my Inovelli NZW37 ZWave smart plug was not and displayed as undefined. The ZWave binding version 2.3.0 show that it is indeed supported. Would you be able to enlighten me?
I have downloaded the xml file from the manufacturer. I am not sure how to use it to config devices locally.
Thanks for the good work. Regards
I would suggest to update to a more recent version. 2.3 is now very old and if the device was added in the last 5 months, you need to use a newer version or it will not be detected by the binding.
Thanks for the update. Isn’t 2.3.0 the most recent version? Just discovered the problem was with the ZStick’s previous metwrol configs. After resetting it back to factory default, OpenHab discovered the plug and performed as expected.
It’s the most recent stable version. But that is pretty old related to @chris’s speed on developing the zwave binding. 
Take a look at the Milestone builds or even Snaphots.
I have new KeyWe Smart lock with Z-wave support and I wanted to add this my openHAB(Latest version 2.4.0).
Of course this was not described in database and it was reconized as “Unknown Device”
Also I have access to Z-wave database, but when I wanted to add new device I got “manufacturer error”.
So my question is, what should I do next to add this Smart lock to the database and use it in my openHAB?
The manufacturer error you got was because the device information has not been downloaded from the device. This could be because the device has not woken up (if it’s a battery device) or some other communication issue. If you can’t resolve this, then please get a debug log so we can see what is stopping the device initialising.
I got debug log and here it is:
2019-01-03 18:35:03.746 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: ZWaveCommandClassTransactionPayload - send to node
2019-01-03 18:35:03.747 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 16: SECURITY check internal
2019-01-03 18:35:03.749 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 16: Command Class COMMAND_CLASS_SECURITY is NOT required to be secured
2019-01-03 18:35:03.750 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: sendTransaction org.openhab.binding.zwave.internal.protocol.transaction.ZWaveCommandClassTransactionPayload@150437e
2019-01-03 18:35:03.752 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Bump transaction 201 priority from Immediate to Immediate
2019-01-03 18:35:03.754 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Adding to device queue
2019-01-03 18:35:03.755 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Added 201 to queue - size 6
2019-01-03 18:35:03.840 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 16: isNonceAvailable = null
2019-01-03 18:35:03.852 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 16: Sending REQUEST Message = 01 09 00 13 10 02 98 40 25 9B 91
2019-01-03 18:35:03.880 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 16: sentData successfully placed on stack.
2019-01-03 18:35:03.883 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: TID 202: Transaction not completed
2019-01-03 18:35:05.273 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 16: SendData Request. CallBack ID = 155, Status = Transmission complete and ACK received(0)
2019-01-03 18:35:05.278 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: TID 202: Transaction not completed
2019-01-03 18:35:05.645 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Application Command Request (ALIVE:SECURITY_REPORT)
2019-01-03 18:35:05.647 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 16: Incoming command class COMMAND_CLASS_SECURITY, endpoint 0
2019-01-03 18:35:05.648 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 16: SECURITY check internal
2019-01-03 18:35:05.650 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 16: Received COMMAND_CLASS_SECURITY V0 SECURITY_NONCE_REPORT
2019-01-03 18:35:05.654 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 16: NONCE Received start...
2019-01-03 18:35:05.656 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 16: NONCE Received start null
2019-01-03 18:35:05.658 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 16: NONCE Received ZWaveNonce [nonceBytes=(0A C2 D8 42 01 CC 2C 36 ), timer=711221, valid=true]
2019-01-03 18:35:05.660 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Commands processed 1.
2019-01-03 18:35:05.661 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@36c352.
2019-01-03 18:35:05.663 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@36c352.
2019-01-03 18:35:05.665 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: notifyTransactionResponse TID:202 DONE
2019-01-03 18:35:05.677 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 16: SECURITY_TXD 98 02
2019-01-03 18:35:05.684 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 16: Sending REQUEST Message = 01 1D 00 13 10 16 98 81 57 53 77 4F 6E 3B 37 14 B4 E7 27 0A 5C 13 9D 42 E7 6C 22 3F 25 9C 65
2019-01-03 18:35:05.717 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 16: sentData successfully placed on stack.
2019-01-03 18:35:05.720 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: TID 201: Transaction not completed
2019-01-03 18:35:05.725 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Application Command Request (ALIVE:SECURITY_REPORT)
2019-01-03 18:35:05.727 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 16: Incoming command class COMMAND_CLASS_SECURITY, endpoint 0
2019-01-03 18:35:05.729 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 16: SECURITY check internal
2019-01-03 18:35:05.731 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 16: Received COMMAND_CLASS_SECURITY V0 SECURITY_NONCE_REPORT
2019-01-03 18:35:05.732 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 16: NONCE Received start...
2019-01-03 18:35:05.734 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 16: NONCE Received start null
2019-01-03 18:35:05.735 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 16: NONCE Received and IGNORED, ID was same than the last one received
2019-01-03 18:35:05.737 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Commands processed 1.
2019-01-03 18:35:05.739 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@19540e5.
2019-01-03 18:35:06.970 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 16: SendData Request. CallBack ID = 156, Status = Transmission complete and ACK received(0)
2019-01-03 18:35:06.974 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: TID 201: Transaction not completed
2019-01-03 18:35:11.975 [DEBUG] [sactionManager$ZWaveTransactionTimer] - NODE 16: TID 201: Timeout at state WAIT_DATA. 3 retries remaining.
2019-01-03 18:35:11.981 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: notifyTransactionResponse TID:201 CANCELLED
2019-01-03 18:35:11.988 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node Init response (9) org.openhab.binding.zwave.internal.protocol.ZWaveTransactionResponse@1ad3555
2019-01-03 18:35:11.993 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: No data from device, but it was ACK'd. Possibly not supported? (Try 9)
2019-01-03 18:35:11.997 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node Init transaction retries exceeded
2019-01-03 18:35:11.999 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer - advancing to MANUFACTURER
2019-01-03 18:35:12.009 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer - advancing to APP_VERSION
2019-01-03 18:35:12.011 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer: APP_VERSION - VERSION not supported
2019-01-03 18:35:12.013 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer - advancing to DISCOVERY_COMPLETE
2019-01-03 18:35:12.015 [DEBUG] [wave.discovery.ZWaveDiscoveryService] - NODE 16: Device discovery completed
2019-01-03 18:35:12.026 [WARN ] [wave.discovery.ZWaveDiscoveryService] - NODE 16: Device discovery could not resolve to a thingType! Manufacturer data not known.
2019-01-03 18:35:12.035 [DEBUG] [l.initialization.ZWaveNodeSerializer] - NODE 16: Serialise aborted as static stages not complete
2019-01-03 18:35:12.039 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer - advancing to ENDPOINTS
2019-01-03 18:35:12.041 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer: ENDPOINTS - MultiInstance not supported.
2019-01-03 18:35:12.045 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer - advancing to UPDATE_DATABASE
2019-01-03 18:35:12.048 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer: UPDATE_DATABASE
2019-01-03 18:35:12.073 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer: UPDATE_DATABASE - thing is null!
2019-01-03 18:35:12.076 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer - advancing to STATIC_VALUES
2019-01-03 18:35:12.079 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer: STATIC_VALUES - checking COMMAND_CLASS_BASIC
2019-01-03 18:35:12.081 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer: STATIC_VALUES - checking COMMAND_CLASS_NO_OPERATION
2019-01-03 18:35:12.084 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer: STATIC_VALUES - checking COMMAND_CLASS_SECURITY
2019-01-03 18:35:12.086 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer: STATIC_VALUES - checking COMMAND_CLASS_ZWAVEPLUS_INFO
2019-01-03 18:35:12.089 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Found 1 instances of COMMAND_CLASS_ZWAVEPLUS_INFO for endpoint 0
2019-01-03 18:35:12.102 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 16: SECURITY NOT required on COMMAND_CLASS_ZWAVEPLUS_INFO
2019-01-03 18:35:12.104 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 16: Command Class COMMAND_CLASS_ZWAVEPLUS_INFO is NOT required to be secured
2019-01-03 18:35:12.107 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: ZWaveCommandClassTransactionPayload - send to node
2019-01-03 18:35:12.109 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 16: SECURITY NOT required on COMMAND_CLASS_ZWAVEPLUS_INFO
2019-01-03 18:35:12.111 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 16: Command Class COMMAND_CLASS_ZWAVEPLUS_INFO is NOT required to be secured
2019-01-03 18:35:12.113 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: sendTransaction org.openhab.binding.zwave.internal.protocol.transaction.ZWaveCommandClassTransactionPayload@89e529
2019-01-03 18:35:12.116 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Bump transaction 207 priority from Config to Immediate
2019-01-03 18:35:12.117 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Adding to device queue
2019-01-03 18:35:12.119 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Added 207 to queue - size 8
2019-01-03 18:35:12.139 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 16: Sending REQUEST Message = 01 09 00 13 10 02 5E 01 25 9E 13
2019-01-03 18:35:12.162 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 16: sentData successfully placed on stack.
2019-01-03 18:35:12.166 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: TID 207: Transaction not completed
2019-01-03 18:35:13.572 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 16: SendData Request. CallBack ID = 158, Status = Transmission complete and ACK received(0)
2019-01-03 18:35:13.576 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: TID 207: Transaction not completed
2019-01-03 18:35:17.020 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Application Command Request (ALIVE:STATIC_VALUES)
2019-01-03 18:35:17.022 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 16: Incoming command class COMMAND_CLASS_ZWAVEPLUS_INFO, endpoint 0
2019-01-03 18:35:17.024 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 16: SECURITY NOT required on COMMAND_CLASS_ZWAVEPLUS_INFO
2019-01-03 18:35:17.025 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 16: Received COMMAND_CLASS_ZWAVEPLUS_INFO V0 ZWAVEPLUS_INFO_REPORT
2019-01-03 18:35:17.028 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Commands processed 1.
2019-01-03 18:35:17.030 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@7c6fae.
2019-01-03 18:35:17.032 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@7c6fae.
2019-01-03 18:35:17.034 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: notifyTransactionResponse TID:207 DONE
2019-01-03 18:35:17.039 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node Init response (0) org.openhab.binding.zwave.internal.protocol.ZWaveTransactionResponse@b87330
2019-01-03 18:35:17.041 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node Init transaction completed with response COMPLETE
2019-01-03 18:35:17.043 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer - advancing to ASSOCIATIONS
2019-01-03 18:35:17.044 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer - advancing to SET_WAKEUP
2019-01-03 18:35:17.046 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer - advancing to SET_ASSOCIATION
2019-01-03 18:35:17.047 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer: SET_ASSOCIATION - ASSOCIATION class not supported
2019-01-03 18:35:17.048 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer - advancing to SET_LIFELINE
2019-01-03 18:35:17.050 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer: SET_LIFELINE - ASSOCIATION class not supported
2019-01-03 18:35:17.051 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer - advancing to GET_CONFIGURATION
2019-01-03 18:35:17.053 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer: GET_CONFIGURATION - CONFIGURATION class not supported
2019-01-03 18:35:17.054 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer - advancing to STATIC_END
2019-01-03 18:35:17.056 [DEBUG] [l.initialization.ZWaveNodeSerializer] - NODE 16: Serialise aborted as static stages not complete
2019-01-03 18:35:17.057 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer - advancing to DYNAMIC_VALUES
2019-01-03 18:35:17.059 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer: DYNAMIC_VALUES - checking COMMAND_CLASS_BASIC
2019-01-03 18:35:17.060 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer: DYNAMIC_VALUES - checking COMMAND_CLASS_NO_OPERATION
2019-01-03 18:35:17.061 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer: DYNAMIC_VALUES - checking COMMAND_CLASS_SECURITY
2019-01-03 18:35:17.062 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer: DYNAMIC_VALUES - checking COMMAND_CLASS_ZWAVEPLUS_INFO
2019-01-03 18:35:17.063 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer: Initialisation complete!
2019-01-03 18:35:17.065 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer - advancing to DYNAMIC_END
2019-01-03 18:35:17.067 [DEBUG] [l.initialization.ZWaveNodeSerializer] - NODE 16: Serializing to file /var/lib/openhab2/zwave/network_cb050a7a__node_16.xml
2019-01-03 18:35:17.089 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node advancer - advancing to DONE
2019-01-03 18:35:17.091 [DEBUG] [l.initialization.ZWaveNodeSerializer] - NODE 16: Serializing to file /var/lib/openhab2/zwave/network_cb050a7a__node_16.xml
2019-01-03 18:35:17.389 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Application Command Request (ALIVE:DONE)
2019-01-03 18:35:17.391 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 16: resetResendCount initComplete=true isDead=false
2019-01-03 18:35:17.392 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 16: Incoming command class COMMAND_CLASS_ZWAVEPLUS_INFO, endpoint 0
2019-01-03 18:35:17.393 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 16: SECURITY NOT required on COMMAND_CLASS_ZWAVEPLUS_INFO
2019-01-03 18:35:17.394 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 16: Received COMMAND_CLASS_ZWAVEPLUS_INFO V0 ZWAVEPLUS_INFO_REPORT
2019-01-03 18:35:17.396 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Commands processed 1.
2019-01-03 18:35:17.398 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@17120a7.
2019-01-03 18:35:17.480 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Application Command Request (ALIVE:DONE)
2019-01-03 18:35:17.481 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 16: resetResendCount initComplete=true isDead=false
2019-01-03 18:35:17.482 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 16: Incoming command class COMMAND_CLASS_ZWAVEPLUS_INFO, endpoint 0
2019-01-03 18:35:17.483 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 16: SECURITY NOT required on COMMAND_CLASS_ZWAVEPLUS_INFO
2019-01-03 18:35:17.484 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 16: Received COMMAND_CLASS_ZWAVEPLUS_INFO V0 ZWAVEPLUS_INFO_REPORT
2019-01-03 18:35:17.485 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Commands processed 1.
2019-01-03 18:35:17.486 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@404dea.
2019-01-03 18:35:18.104 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Application Command Request (ALIVE:DONE)
2019-01-03 18:35:18.106 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 16: resetResendCount initComplete=true isDead=false
2019-01-03 18:35:18.108 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 16: Incoming command class COMMAND_CLASS_ZWAVEPLUS_INFO, endpoint 0
2019-01-03 18:35:18.110 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 16: SECURITY NOT required on COMMAND_CLASS_ZWAVEPLUS_INFO
2019-01-03 18:35:18.111 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 16: Received COMMAND_CLASS_ZWAVEPLUS_INFO V0 ZWAVEPLUS_INFO_REPORT
2019-01-03 18:35:18.113 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Commands processed 1.
2019-01-03 18:35:18.114 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@6a425.
2019-01-03 18:35:18.116 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Command NOT verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@6a425.
2019-01-03 18:35:22.930 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 16: MANUFACTURER not set
2019-01-03 18:35:22.934 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 16: Controller status changed to ONLINE.
2019-01-03 18:35:22.935 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 16: Controller is ONLINE. Starting device initialisation.
2019-01-03 18:35:22.970 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 16: Updating node properties.
2019-01-03 18:35:22.997 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 16: Updating node properties. MAN=2147483647
2019-01-03 18:35:22.999 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 16: Properties synchronised
2019-01-03 18:35:23.025 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 16: Initialising Thing Node...
2019-01-03 18:35:23.026 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 16: Polling intialised at 1800 seconds - start in 1137600 milliseconds.
2019-01-03 18:35:23.028 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 16: Device initialisation complete.
So, can anyone get what may be wrong?
Not from this log. Firstly, please don’t filter the logs as it removes 50% of the required information. I think the log probably starts a bit late as well so I need to see a little earlier.
New log without filter and start little bit earlier
2019-01-03 18:18:20.939 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: ZWaveCommandClassTransactionPayload - send to node
2019-01-03 18:18:20.941 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 16: SECURITY check internal
2019-01-03 18:18:20.954 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 16: Command Class COMMAND_CLASS_SECURITY is NOT required to be secured
2019-01-03 18:18:20.956 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: sendTransaction org.openhab.binding.zwave.internal.protocol.transaction.ZWaveCommandClassTransactionPayload@150437e
2019-01-03 18:18:20.958 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Bump transaction 105 priority from Immediate to Immediate
2019-01-03 18:18:20.960 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Adding to device queue
2019-01-03 18:18:20.962 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Added 105 to queue - size 6
2019-01-03 18:18:20.965 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-01-03 18:18:20.969 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 16: isNonceAvailable = null
2019-01-03 18:18:20.971 [DEBUG] [andclass.impl.CommandClassSecurityV1] - Creating command message SECURITY_NONCE_GET version 1
2019-01-03 18:18:20.975 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 09 00 13 10 02 98 40 25 3E 34
2019-01-03 18:18:20.979 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 16: Sending REQUEST Message = 01 09 00 13 10 02 98 40 25 3E 34
2019-01-03 18:18:20.982 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2019-01-03 18:18:20.985 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2019-01-03 18:18:20.986 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2019-01-03 18:18:20.988 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2019-01-03 18:18:20.990 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-01-03 18:18:20.991 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2019-01-03 18:18:20.985 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 106: [WAIT_RESPONSE] priority=High, requiresResponse=true, callback: 62
2019-01-03 18:18:20.993 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-01-03 18:18:20.996 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8
2019-01-03 18:18:20.997 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2019-01-03 18:18:21.000 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2019-01-03 18:18:21.002 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2019-01-03 18:18:21.004 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 106: [WAIT_RESPONSE] priority=High, requiresResponse=true, callback: 62
2019-01-03 18:18:21.005 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2019-01-03 18:18:21.007 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 106: [WAIT_RESPONSE] priority=High, requiresResponse=true, callback: 62
2019-01-03 18:18:21.009 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2019-01-03 18:18:21.010 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 16: sentData successfully placed on stack.
2019-01-03 18:18:21.012 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 106: Advanced to WAIT_REQUEST
2019-01-03 18:18:21.014 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: TID 106: Transaction not completed
2019-01-03 18:18:21.015 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-01-03 18:18:21.017 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2019-01-03 18:18:22.241 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 3E 00 00 7E AB
2019-01-03 18:18:22.244 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=62, payload=3E 00 00 7E
2019-01-03 18:18:22.246 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=62, payload=3E 00 00 7E
2019-01-03 18:18:22.248 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 106: [WAIT_REQUEST] priority=High, requiresResponse=true, callback: 62
2019-01-03 18:18:22.250 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2019-01-03 18:18:22.252 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 106: [WAIT_REQUEST] priority=High, requiresResponse=true, callback: 62
2019-01-03 18:18:22.253 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 106: (Callback 62)
2019-01-03 18:18:22.255 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2019-01-03 18:18:22.257 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 106: callback 62
2019-01-03 18:18:22.259 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=62, payload=3E 00 00 7E
2019-01-03 18:18:22.264 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 10 00 04 00 10 0A 98 80 65 D0 13 20 69 34 24 8D 9B
2019-01-03 18:18:22.261 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 16: SendData Request. CallBack ID = 62, Status = Transmission complete and ACK received(0)
2019-01-03 18:18:22.266 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 106: Advanced to WAIT_DATA
2019-01-03 18:18:22.268 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=ApplicationCommandHandler[4], type=Request[0], dest=16, callback=0, payload=00 10 0A 98 80 65 D0 13 20 69 34 24 8D
2019-01-03 18:18:22.270 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: TID 106: Transaction not completed
2019-01-03 18:18:22.273 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=ApplicationCommandHandler[4], type=Request[0], dest=16, callback=0, payload=00 10 0A 98 80 65 D0 13 20 69 34 24 8D
2019-01-03 18:18:22.275 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction null
2019-01-03 18:18:22.278 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Application Command Request (ALIVE:SECURITY_REPORT)
2019-01-03 18:18:22.280 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 16: Incoming command class COMMAND_CLASS_SECURITY, endpoint 0
2019-01-03 18:18:22.282 [DEBUG] [ng.zwave.internal.protocol.ZWaveNode] - NODE 16: SECURITY check internal
2019-01-03 18:18:22.284 [DEBUG] [tocol.commandclass.ZWaveCommandClass] - NODE 16: Received COMMAND_CLASS_SECURITY V0 SECURITY_NONCE_REPORT
2019-01-03 18:18:22.286 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 16: NONCE Received start...
2019-01-03 18:18:22.288 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 16: NONCE Received start null
2019-01-03 18:18:22.291 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 16: NONCE Received ZWaveNonce [nonceBytes=(65 D0 13 20 69 34 24 8D ), timer=606251, valid=true]
2019-01-03 18:18:22.293 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Commands processed 1.
2019-01-03 18:18:22.295 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Checking command org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@19ee719.
2019-01-03 18:18:22.297 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: Command verified org.openhab.binding.zwave.internal.protocol.ZWaveCommandClassPayload@19ee719.
2019-01-03 18:18:22.300 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: notifyTransactionResponse TID:106 DONE
2019-01-03 18:18:22.302 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 16: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2019-01-03 18:18:22.305 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 1
2019-01-03 18:18:22.308 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction completed - outstandingTransactions 0
2019-01-03 18:18:22.311 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-01-03 18:18:22.312 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-01-03 18:18:22.315 [DEBUG] [andclass.impl.CommandClassSecurityV1] - Creating command message SECURITY_MESSAGE_ENCAPSULATION version 1
2019-01-03 18:18:22.320 [DEBUG] [mmandclass.ZWaveSecurityCommandClass] - NODE 16: SECURITY_TXD 98 02
2019-01-03 18:18:22.324 [DEBUG] [wave.internal.protocol.SerialMessage] - Assembled message buffer = 01 1D 00 13 10 16 98 81 7F FA D8 5A BC 00 92 DB 28 F5 4E 65 6A 68 E6 F4 82 57 E5 DE 25 3F 0E
2019-01-03 18:18:22.327 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - NODE 16: Sending REQUEST Message = 01 1D 00 13 10 16 98 81 7F FA D8 5A BC 00 92 DB 28 F5 4E 65 6A 68 E6 F4 82 57 E5 DE 25 3F 0E
2019-01-03 18:18:22.329 [DEBUG] [ing.zwave.handler.ZWaveSerialHandler] - Message SENT
2019-01-03 18:18:22.332 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage started: TID 105: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 63
2019-01-03 18:18:22.332 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 06
2019-01-03 18:18:22.334 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2019-01-03 18:18:22.336 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=null[0], type=ACK[2], dest=255, callback=0, payload=
2019-01-03 18:18:22.338 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 105: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 63
2019-01-03 18:18:22.341 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 04 01 13 01 E8
2019-01-03 18:18:22.341 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg: ACK
2019-01-03 18:18:22.343 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-01-03 18:18:22.345 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2019-01-03 18:18:22.345 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2019-01-03 18:18:22.347 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2019-01-03 18:18:22.349 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 105: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 63
2019-01-03 18:18:22.350 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2019-01-03 18:18:22.352 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 105: [WAIT_RESPONSE] priority=Immediate, requiresResponse=true, callback: 63
2019-01-03 18:18:22.354 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Response[1], dest=255, callback=0, payload=01
2019-01-03 18:18:22.356 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 16: sentData successfully placed on stack.
2019-01-03 18:18:22.357 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 105: Advanced to WAIT_REQUEST
2019-01-03 18:18:22.359 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: TID 105: Transaction not completed
2019-01-03 18:18:22.360 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-01-03 18:18:22.362 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2019-01-03 18:18:22.365 [DEBUG] [WaveSerialHandler$ZWaveReceiveThread] - Receive Message = 01 07 00 13 3F 00 00 03 D7
2019-01-03 18:18:22.369 [DEBUG] [nal.protocol.ZWaveTransactionManager] - processReceiveMessage input 0<>128 : Message: class=SendData[19], type=Request[0], dest=0, callback=63, payload=3F 00 00 03
2019-01-03 18:18:22.371 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Received msg (0): Message: class=SendData[19], type=Request[0], dest=0, callback=63, payload=3F 00 00 03
2019-01-03 18:18:22.374 [DEBUG] [nal.protocol.ZWaveTransactionManager] - lastTransaction TID 105: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 63
2019-01-03 18:18:22.375 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking outstanding transactions: 1
2019-01-03 18:18:22.377 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Last transaction: TID 105: [WAIT_REQUEST] priority=Immediate, requiresResponse=true, callback: 63
2019-01-03 18:18:22.379 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Checking TID 105: (Callback 63)
2019-01-03 18:18:22.381 [DEBUG] [.serialmessage.ZWaveCommandProcessor] - Callback match!
2019-01-03 18:18:22.382 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Correlated to TID 105: callback 63
2019-01-03 18:18:22.384 [DEBUG] [ve.internal.protocol.ZWaveController] - Incoming Message: Message: class=SendData[19], type=Request[0], dest=0, callback=63, payload=3F 00 00 03
2019-01-03 18:18:22.386 [DEBUG] [l.serialmessage.SendDataMessageClass] - NODE 16: SendData Request. CallBack ID = 63, Status = Transmission complete and ACK received(0)
2019-01-03 18:18:22.388 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 105: Advanced to WAIT_DATA
2019-01-03 18:18:22.389 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: TID 105: Transaction not completed
2019-01-03 18:18:22.391 [DEBUG] [nal.protocol.ZWaveTransactionManager] - ZWaveReceiveThread queue empty
2019-01-03 18:18:22.392 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 1 out at start. Holdoff false.
2019-01-03 18:18:27.389 [DEBUG] [sactionManager$ZWaveTransactionTimer] - NODE 16: TID 105: Timeout at state WAIT_DATA. 3 retries remaining.
2019-01-03 18:18:27.391 [DEBUG] [e.internal.protocol.ZWaveTransaction] - TID 105: Transaction CANCELLED
2019-01-03 18:18:27.393 [DEBUG] [ding.zwave.handler.ZWaveThingHandler] - NODE 16: Got an event from Z-Wave network: ZWaveTransactionCompletedEvent
2019-01-03 18:18:27.396 [DEBUG] [nal.protocol.ZWaveTransactionManager] - NODE 16: notifyTransactionResponse TID:105 CANCELLED
2019-01-03 18:18:27.398 [DEBUG] [nal.protocol.ZWaveTransactionManager] - Transaction SendNextMessage 0 out at start. Holdoff false.
2019-01-03 18:18:27.398 [DEBUG] [nal.protocol.ZWaveTransactionManager] - TID 105: Transaction event listener: DONE: CANCELLED ->
2019-01-03 18:18:27.402 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: Node Init response (4) org.openhab.binding.zwave.internal.protocol.ZWaveTransactionResponse@18bce28
2019-01-03 18:18:27.404 [DEBUG] [alization.ZWaveNodeInitStageAdvancer] - NODE 16: No data from device, but it was ACK'd. Possibly not supported? (Try 4)
The log is really just too short - there’s only a couple of seconds worth of logging and it’s really not easy to work out what is happening from a single message being sent.
Please provide a debug log that provides the full logging from the start of the device initialisation for a reasonable period of time (maybe a minute or so to be sure).
I tried also to exclude and include, now it is node 20.
And log about 8 minutes as a file.
log.txt (249.2 KB)
Ok, I had some time to work this problem again and now I found that openHAB received some data.
I understand that there are missing data for this door sensor (NODE 28: Unable to find thing type (037B:0002:0001:1.0)).
Now I tried to add a new device from xml file but got error
“Manufacturer 037B is not known! Please update the manufacturer database and try again”.
Can somebody help me to add this door lock to database?
Here is a xml. network_cb050a7a__node_28.xml (16.4 KB)
Sorry - just picked this up, but I think I added this already yesterday (I did a few new manufacturers yesterday - I guess it’s all those Christmas gifts 
).
Yep, it was added and the device was approved.
1 Like