Unable to start Open ZWave (beta) - OZWDaemon offline/Driver removed

Configuration Z-Wave
1

Started a fresh HA install on a Raspberry Pi 3B+ with USB SSD as boot. The controller I’m using is a RaZberry2 Controller 2016 ZWave+.
As it was a fresh installation, I thought it was time to switch to the new Open Zwave (beta) integration.
Problem: the Zwave controller isn’t starting, it removes driver for controller.
Prefered outcome: ZWave controller is running with the old network key.

I have read several posts on his forum (including Get OpenZWave Beta working) and youtube instructions.

Here’s what I’ve done:

  • Installed Mosquitto Broker from Supervisor-Addon Store-Official Addons.
  • Created a user for the broker.
  • Installed MQTT integration from Configuration-Integrations.
  • Started Mosquitto Broker. Log:
[20:47:05] INFO: Setup mosquitto configuration
[20:47:05] WARNING: SSL not enabled - No valid certs found!
[20:47:05] INFO: Found local users inside config
[20:47:05] INFO: Initialize Hass.io Add-on services
[20:47:05] INFO: Initialize Home Assistant discovery
[20:47:05] INFO: Start Mosquitto daemon
1608583625: mosquitto version 1.6.3 starting
1608583625: Config loaded from /etc/mosquitto.conf.
1608583625: Loading plugin: /usr/share/mosquitto/auth-plug.so
1608583625: |-- *** auth-plug: startup
1608583625:  ├── Username/password checking enabled.
1608583625:  ├── TLS-PSK checking enabled.
1608583625:  └── Extended authentication not enabled.
1608583625: Opening ipv4 listen socket on port 1883.
1608583625: Opening ipv6 listen socket on port 1883.
1608583625: Opening websockets listen socket on port 1884.
1608583625: Warning: Mosquitto should not be run as root/administrator.
1608583649: New connection from 172.30.32.1 on port 1883.
[INFO] found homeassistant on local database
1608583650: New client connected from 172.30.32.1 as auto-30C53973-E986-0D3C-DDE3-50D81481037B (p2, c1, k60, u'homeassistant').
1608583650: Client auto-30C53973-E986-0D3C-DDE3-50D81481037B disconnected.
1608583650: New connection from 172.30.32.1 on port 1883.
1608583650: New client connected from 172.30.32.1 as 5gg44hsoGLi7Foyv4QYQn6 (p2, c1, k60, u'homeassistant').
1608584220: New connection from 172.30.33.1 on port 1883.
[INFO] found addons on local database
1608584221: New client connected from 172.30.33.1 as qt-openzwave-1 (p2, c1, k60, u'addons').
1608584226: Client qt-openzwave-1 disconnected.
  • Installed the Open Z-Wave Daemon from this repository (https://github.com/marcelveldt/hassio-addons-repo).
  • Added zwave_device: /dev/ttyAMA0 & copied my network key from my old secrets.yaml.
  • Disabled 1983/tcp in it’s config.
  • Started Open Z-Wave Daemon. Log:
[20201221 20:57:01.903 UTC] [ozw.mqtt.commands] [debug]: Creating Subscription for  "testnetworknode" 
[20201221 20:57:01.903 UTC] [ozw.mqtt.commands] [debug]: Subscription Setup for  QMqttTopicFilter("OpenZWave/1/command/testnetworknode/") 
[20201221 20:57:02.239 UTC] [ozw.library] [info]: Info - Node: 0 Queuing download for http://download.db.openzwave.com/images/shenzen_neo/ls03ch.jpg (Node 0) 
[20201221 20:57:02.242 UTC] [ozw.library] [info]: Info - Node: 0 Missing Picture /data/images/shenzen_neo/ls03ch.jpg - Starting Download 
[20201221 20:57:02.243 UTC] [ozw.library] [debug]: Debug - Node: 0 Download Starting for http://download.db.openzwave.com/images/shenzen_neo/ls03ch.jpg (/data/images/shenzen_neo/ls03ch.jpg) 
[20201221 20:57:02.509 UTC] [ozw.library] [info]: Info - Node: 0 Queuing download for http://download.db.openzwave.com/images/abus/SHRM10000.jpg (Node 0) 
[20201221 20:57:02.511 UTC] [ozw.library] [info]: Info - Node: 0 Missing Picture /data/images/abus/SHRM10000.jpg - Starting Download 
[20201221 20:57:02.511 UTC] [ozw.library] [debug]: Debug - Node: 0 Download Starting for http://download.db.openzwave.com/images/abus/SHRM10000.jpg (/data/images/abus/SHRM10000.jpg) 
[20201221 20:57:02.514 UTC] [ozw.library] [info]: Info - Node: 0 Queuing download for http://download.db.openzwave.com/images/ecodim/0.7.jpg (Node 0) 
[20201221 20:57:02.516 UTC] [ozw.library] [info]: Info - Node: 0 Missing Picture /data/images/ecodim/0.7.jpg - Starting Download 
[20201221 20:57:02.567 UTC] [ozw.library] [debug]: Debug - Node: 0 Downloads Remaining: 4 
[20201221 20:57:02.568 UTC] [ozw.library] [info]: Info - Node: 0 Download Finished: /data/images/kwikset/916.jpg (Node: 0) 
[20201221 20:57:02.568 UTC] [ozw.library] [debug]: Debug - Node: 0 Downloads Remaining: 3 
[20201221 20:57:02.569 UTC] [ozw.library] [info]: Info - Node: 0 Download Finished: /data/images/shenzen_neo/ls03ch.jpg (Node: 0) 
[20201221 20:57:02.569 UTC] [ozw.library] [debug]: Debug - Node: 0 Downloads Remaining: 2 
[20201221 20:57:02.585 UTC] [ozw.library] [debug]: Debug - Node: 0 Download Starting for http://download.db.openzwave.com/images/ecodim/0.7.jpg (/data/images/ecodim/0.7.jpg) 
[20201221 20:57:02.586 UTC] [ozw.library] [info]: Info - Node: 0 Download Finished: /data/images/abus/SHRM10000.jpg (Node: 0) 
[20201221 20:57:02.587 UTC] [ozw.library] [debug]: Debug - Node: 0 Downloads Remaining: 1 
[20201221 20:57:02.711 UTC] [ozw.library] [info]: Info - Node: 0 Download Finished: /data/images/ecodim/0.7.jpg (Node: 0) 
[20201221 20:57:02.712 UTC] [ozw.library] [debug]: Debug - Node: 0 Downloads Remaining: 0 
[20201221 20:57:02.713 UTC] [ozw.library] [info]: Info - Node: 0 ManufacturerSpecificDB Initialized 
[20201221 20:57:02.715 UTC] [ozw.library] [debug]: Detail - Node: 0 Notification: ManufacturerSpecificDB Ready 
[20201221 20:57:02.717 UTC] [ozw.notifications] [debug]: Notification pvt_manufacturerSpecificDBReady Thread:  0x73cbd010 
[20201221 20:57:02.717 UTC] [ozw.mqtt.publisher] [debug]: Publishing Event manufacturerSpecificDBReady 
[20201221 20:57:02.719 UTC] [ozw.library] [info]: Info - Node: 255 Sending (Command) message (Callback ID=0x00, Expected Reply=0x15) - FUNC_ID_ZW_GET_VERSION: 0x01, 0x03, 0x00, 0x15, 0xe9 
[20201221 20:57:02.720 UTC] [ozw.library] [info]: Info - Node: 255 Encrypted Flag is 0 
[20201221 20:57:02.721 UTC] [ozw.library] [debug]: Detail - Node: 255 Notification: DriverFailed: /dev/ttyAMA0 
[20201221 20:57:02.722 UTC] [ozw.notifications] [debug]: Notification pvt_driverFailed  0 Thread:  0x73cbd010 
[20201221 20:57:02.722 UTC] [ozw.mqtt.publisher] [debug]: Publishing Event stopped 
[20201221 20:57:02.723 UTC] [ozw.mqtt.publisher] [debug]: Publishing Event driverFailed: 0 
[20201221 20:57:02.723 UTC] [ozw.mqtt.publisher] [warning]: Exiting on Failure 
[20201221 20:57:02.724 UTC] [ozw.library] [debug]: Detail - Node: 0 Notification: DriverRemoved 
[20201221 20:57:02.725 UTC] [ozw.notifications] [debug]: Notification pvt_driverRemoved  0 Thread:  0x73cbd010 
[20201221 20:57:02.725 UTC] [ozw.mqtt.publisher] [debug]: Publishing Event stopped 
[20201221 20:57:02.725 UTC] [ozw.mqtt.publisher] [debug]: Publishing Event driverRemoved: 0 
[20201221 20:57:02.726 UTC] [ozw.library] [debug]: Always - Node: 0 *************************************************************************** 
[20201221 20:57:02.726 UTC] [ozw.library] [debug]: Always - Node: 0 *********************  Cumulative Network Statistics  ********************* 
[20201221 20:57:02.726 UTC] [ozw.library] [debug]: Always - Node: 0 *** General 
[20201221 20:57:02.726 UTC] [ozw.library] [debug]: Always - Node: 0 Driver run time: . .  . 0 days, 0 hours, 0 minutes 
[20201221 20:57:02.726 UTC] [ozw.library] [debug]: Always - Node: 0 Frames processed: . . . . . . . . . . . . . . . . . . . . 0 
[20201221 20:57:02.726 UTC] [ozw.library] [debug]: Always - Node: 0 Total messages successfully received: . . . . . . . . . . 0 
[20201221 20:57:02.727 UTC] [ozw.library] [debug]: Always - Node: 0 Total Messages successfully sent: . . . . . . . . . . . . 0 
[20201221 20:57:02.727 UTC] [ozw.library] [debug]: Always - Node: 0 ACKs received from controller:  . . . . . . . . . . . . . 0 
[20201221 20:57:02.727 UTC] [ozw.library] [debug]: Always - Node: 0 *** Errors 
[20201221 20:57:02.727 UTC] [ozw.library] [debug]: Always - Node: 0 Unsolicited messages received while waiting for ACK:  . . 0 
[20201221 20:57:02.727 UTC] [ozw.library] [debug]: Always - Node: 0 Reads aborted due to timeouts:  . . . . . . . . . . . . . 0 
[20201221 20:57:02.727 UTC] [ozw.library] [debug]: Always - Node: 0 Bad checksum errors:  . . . . . . . . . . . . . . . . . . 0 
[20201221 20:57:02.727 UTC] [ozw.library] [debug]: Always - Node: 0 CANs received from controller:  . . . . . . . . . . . . . 0 
[20201221 20:57:02.727 UTC] [ozw.library] [debug]: Always - Node: 0 NAKs received from controller:  . . . . . . . . . . . . . 0 
[20201221 20:57:02.727 UTC] [ozw.library] [debug]: Always - Node: 0 Out of frame data flow errors:  . . . . . . . . . . . . . 0 
[20201221 20:57:02.727 UTC] [ozw.library] [debug]: Always - Node: 0 Messages retransmitted: . . . . . . . . . . . . . . . . . 0 
[20201221 20:57:02.727 UTC] [ozw.library] [debug]: Always - Node: 0 Messages dropped and not delivered: . . . . . . . . . . . 0 
[20201221 20:57:02.728 UTC] [ozw.library] [debug]: Always - Node: 0 *************************************************************************** 
[20201221 20:57:02.728 UTC] [ozw.library] [warning]: Warning - Node: 0 WARNING: Tried to write driver config with no home ID set 
[20201221 20:57:02.729 UTC] [ozw.library] [info]: Info - Node: 0 Stopping DNSThread 
[20201221 20:57:06.723 UTC] [ozw.library] [debug]: Detail - Node: 255 Removing current message 
[20201221 20:57:06.723 UTC] [ozw.library] [info]: Info - Node: 0 HttpThread Exiting. 
[20201221 20:57:06.725 UTC] [ozw.library] [info]: Info - Node: 0 mgr,     Driver for controller /dev/ttyAMA0 removed 
[20201221 20:57:06.725 UTC] [ozw.manager] [debug]: Driver Removed for  "/dev/ttyAMA0" 
[20201221 20:57:06.725 UTC] [ozw.manager] [debug]: OZW Serial Port Closed 
[20201221 20:57:06.725 UTC] [ozw.daemon] [info]: Shutting Down  "ozwdaemon"  Version:  "0.1.181" 
[20201221 20:57:06.726 UTC] [ozw.daemon] [info]: OpenZWave Version:  "1.6.1570" 
[20201221 20:57:06.726 UTC] [ozw.daemon] [info]: QT-OpenZWave Version:  "1.2.0" 
[20201221 20:57:06.726 UTC] [ozw.daemon] [info]: QT Version:  5.12.9 
[20201221 20:57:06.726 UTC] [ozw.daemon] [info]: Exit Reason:  EXIT_OZWFAILED 
[20201221 20:57:06.726 UTC] [ozw.daemon] [info]: Please consult log messages for specific error messages if any 
2020-12-21 20:57:06,763 INFO exited: ozwdaemon (exit status 252; not expected)
  • Installed the Openzwave (beta) addon from Supervisor-Addon Store-Official Addons.
  • Used same zwave_device and network key as used in the Open Z-Wave Daemon in configuration.
  • Added 1983 as owz-admin port in Network
  • Started Add-on. Log:
[20201221 21:14:26.448 UTC] [ozw.mqtt.commands] [debug]: Creating Subscription for  "syncronisenodeneighbors" 
[20201221 21:14:26.448 UTC] [ozw.mqtt.commands] [debug]: Subscription Setup for  QMqttTopicFilter("OpenZWave/1/command/syncronisenodeneighbors/") 
[20201221 21:14:26.448 UTC] [ozw.mqtt.commands] [debug]: Creating Subscription for  "testnetwork" 
[20201221 21:14:26.448 UTC] [ozw.mqtt.commands] [debug]: Subscription Setup for  QMqttTopicFilter("OpenZWave/1/command/testnetwork/") 
[20201221 21:14:26.448 UTC] [ozw.mqtt.commands] [debug]: Creating Subscription for  "testnetworknode" 
[20201221 21:14:26.448 UTC] [ozw.mqtt.commands] [debug]: Subscription Setup for  QMqttTopicFilter("OpenZWave/1/command/testnetworknode/") 
[20201221 21:14:26.449 UTC] [ozw.mqtt.publisher] [debug]: Topics:  "OpenZWave/1/status/" 
[20201221 21:14:26.980 UTC] [ozw.library] [info]: Info - Node: 0 Download Finished: /data/ozw/config/manufacturer_specific.xml (Node: 0) 
[20201221 21:14:27.051 UTC] [ozw.library] [info]: Info - Node: 0 Manufacturer_Specific.xml file Revision is 133 
[20201221 21:14:27.108 UTC] [ozw.library] [info]: Info - Node: 0 Unable to load config file /data/ozw/config/2gig/ct200.xml 
[20201221 21:14:27.109 UTC] [ozw.library] [info]: Info - Node: 0 Unable to load config file /data/ozw/config/2gig/ct200.xml 
[21:14:27] INFO: Starting ozw-admin...
QStandardPaths: XDG_RUNTIME_DIR not set, defaulting to '/tmp/runtime-root'
ozwadmin: Settings Path is at  "/root/.config/OpenZWave/ozw-admin.conf"
ozwadmin: Checking  "/data/ozw/config"  for manufacturer_specific.xml
ozwadmin: Checking  "/data/ozw/config"  for options.xml
ozwadmin: DBPath:  "/data/ozw/config/"
ozwadmin: userPath:  "/data/ozw/config/"
ozwadmin: Settings Path:  "/root/.config/OpenZWave/ozw-admin.conf"
ozwadmin: Using Saved Network Cache Size: 1000
QT_MESSAGE_PATTERN: %{backtrace} is not supported by this Qt build
[20201221 21:14:28.090 UTC] [ozwadmin] [info]: OZWCore Initilized QTOpenZwave(0xf1e9b0) QTOZWManager(0xf1f430) 
[20201221 21:14:28.183 UTC] [default] [warning]: QVncServer created on port 5900 
[20201221 21:14:28.449 UTC] [ozw.library] [info]: Info - Node: 0 Product name collision: SmartCode 910 type 1 id 1 manufacturerid 90, collides with Touchpad Electronic Deadbolt, type 1 id 1 manufacturerid 90 
WebSocket server settings:
  - Listen on :8099
  - Web server. Web root: /usr/share/novnc
  - No SSL/TLS support (no cert file)
  - proxying from :8099 to 127.0.0.1:5900
[20201221 21:14:29.104 UTC] [ozw.library] [info]: Info - Node: 0 Unable to load config file /data/ozw/config/zooz/zen34.xml 
[20201221 21:14:29.679 UTC] [ozw.library] [info]: Info - Node: 0 Queuing download for http://download.db.openzwave.com/images/kwikset/916.jpg (Node 0) 
[20201221 21:14:29.681 UTC] [ozw.library] [info]: Info - Node: 0 Missing Picture /data/ozw/config/images/kwikset/916.jpg - Starting Download 
[20201221 21:14:29.683 UTC] [ozw.library] [debug]: Debug - Node: 0 Download Starting for http://download.db.openzwave.com/images/kwikset/916.jpg (/data/ozw/config/images/kwikset/916.jpg) 
[20201221 21:14:29.777 UTC] [ozw.library] [warning]: Warning - Node: 0 Config File for Vivint Element Thermostat does not exist - /data/ozw/config/2gig/ct200.xml 
[20201221 21:14:29.777 UTC] [ozw.library] [info]: Info - Node: 0 Queuing download for http://download.db.openzwave.com/001d.c801.0098.xml (Node 0) 
[20201221 21:14:29.778 UTC] [ozw.library] [debug]: Debug - Node: 0 Config file for Vivint Element Thermostat already queued 
[20201221 21:14:29.803 UTC] [ozw.library] [debug]: Debug - Node: 0 Download Starting for http://download.db.openzwave.com/001d.c801.0098.xml (/data/ozw/config/2gig/ct200.xml) 
[20201221 21:14:30.656 UTC] [ozw.library] [info]: Info - Node: 0 Queuing download for http://download.db.openzwave.com/images/shenzen_neo/ls03ch.jpg (Node 0) 
[20201221 21:14:30.656 UTC] [ozw.library] [info]: Info - Node: 0 Missing Picture /data/ozw/config/images/shenzen_neo/ls03ch.jpg - Starting Download 
[20201221 21:14:30.657 UTC] [ozw.library] [debug]: Debug - Node: 0 Download Starting for http://download.db.openzwave.com/images/shenzen_neo/ls03ch.jpg (/data/ozw/config/images/shenzen_neo/ls03ch.jpg) 
[20201221 21:14:30.690 UTC] [ozw.library] [warning]: Warning - Node: 0 Config File for ZEN34 Remote Switch does not exist - /data/ozw/config/zooz/zen34.xml 
[20201221 21:14:30.690 UTC] [ozw.library] [info]: Info - Node: 0 Queuing download for http://download.db.openzwave.com/f001.0004.027a.xml (Node 0) 
[20201221 21:14:30.692 UTC] [ozw.library] [debug]: Debug - Node: 0 Download Starting for http://download.db.openzwave.com/f001.0004.027a.xml (/data/ozw/config/zooz/zen34.xml) 
[20201221 21:14:30.892 UTC] [ozw.library] [info]: Info - Node: 0 Queuing download for http://download.db.openzwave.com/images/abus/SHRM10000.jpg (Node 0) 
[20201221 21:14:30.893 UTC] [ozw.library] [info]: Info - Node: 0 Missing Picture /data/ozw/config/images/abus/SHRM10000.jpg - Starting Download 
[20201221 21:14:30.894 UTC] [ozw.library] [debug]: Debug - Node: 0 Download Starting for http://download.db.openzwave.com/images/abus/SHRM10000.jpg (/data/ozw/config/images/abus/SHRM10000.jpg) 
[20201221 21:14:30.895 UTC] [ozw.library] [info]: Info - Node: 0 Queuing download for http://download.db.openzwave.com/images/ecodim/0.7.jpg (Node 0) 
[20201221 21:14:30.895 UTC] [ozw.library] [info]: Info - Node: 0 Missing Picture /data/ozw/config/images/ecodim/0.7.jpg - Starting Download 
[20201221 21:14:30.936 UTC] [ozw.library] [debug]: Debug - Node: 0 Download Starting for http://download.db.openzwave.com/images/ecodim/0.7.jpg (/data/ozw/config/images/ecodim/0.7.jpg) 
[20201221 21:14:30.947 UTC] [ozw.library] [debug]: Debug - Node: 0 Downloads Remaining: 6 
[20201221 21:14:30.947 UTC] [ozw.library] [debug]: Debug - Node: 0 Downloads Remaining: 6 
[20201221 21:14:30.947 UTC] [ozw.library] [info]: Info - Node: 0 Download Finished: /data/ozw/config/images/kwikset/916.jpg (Node: 0) 
[20201221 21:14:30.947 UTC] [ozw.library] [debug]: Debug - Node: 0 Downloads Remaining: 5 
[20201221 21:14:30.947 UTC] [ozw.library] [info]: Info - Node: 0 Download Finished: /data/ozw/config/2gig/ct200.xml (Node: 0) 
[20201221 21:14:30.947 UTC] [ozw.library] [debug]: Debug - Node: 0 Downloads Remaining: 4 
[20201221 21:14:30.947 UTC] [ozw.library] [info]: Info - Node: 0 Download Finished: /data/ozw/config/images/shenzen_neo/ls03ch.jpg (Node: 0) 
[20201221 21:14:30.947 UTC] [ozw.library] [debug]: Debug - Node: 0 Downloads Remaining: 3 
[20201221 21:14:30.948 UTC] [ozw.library] [info]: Info - Node: 0 Download Finished: /data/ozw/config/zooz/zen34.xml (Node: 0) 
[20201221 21:14:30.948 UTC] [ozw.library] [debug]: Debug - Node: 0 Downloads Remaining: 2 
[20201221 21:14:30.948 UTC] [ozw.library] [info]: Info - Node: 0 Download Finished: /data/ozw/config/images/abus/SHRM10000.jpg (Node: 0) 
[20201221 21:14:30.948 UTC] [ozw.library] [debug]: Debug - Node: 0 Downloads Remaining: 1 
[20201221 21:14:31.020 UTC] [ozw.library] [info]: Info - Node: 0 Download Finished: /data/ozw/config/images/ecodim/0.7.jpg (Node: 0) 
[20201221 21:14:31.020 UTC] [ozw.library] [debug]: Debug - Node: 0 Downloads Remaining: 0 
[20201221 21:14:31.020 UTC] [ozw.library] [info]: Info - Node: 0 ManufacturerSpecificDB Initialized 
[20201221 21:14:31.020 UTC] [ozw.library] [debug]: Detail - Node: 0 Notification: ManufacturerSpecificDB Ready 
[20201221 21:14:31.020 UTC] [ozw.library] [info]: Info - Node: 255 Sending (Command) message (Callback ID=0x00, Expected Reply=0x15) - FUNC_ID_ZW_GET_VERSION: 0x01, 0x03, 0x00, 0x15, 0xe9 
[20201221 21:14:31.020 UTC] [ozw.library] [info]: Info - Node: 255 Encrypted Flag is 0 
[20201221 21:14:31.021 UTC] [ozw.library] [debug]: Detail - Node: 255 Notification: DriverFailed: /dev/ttyAMA0 
[20201221 21:14:31.021 UTC] [ozw.notifications] [debug]: Notification pvt_manufacturerSpecificDBReady Thread:  0x76f7c558 
[20201221 21:14:31.021 UTC] [ozw.mqtt.publisher] [debug]: Publishing Event manufacturerSpecificDBReady 
[20201221 21:14:31.021 UTC] [ozw.notifications] [debug]: Notification pvt_driverFailed  0 Thread:  0x76f7c558 
[20201221 21:14:31.022 UTC] [ozw.mqtt.publisher] [debug]: Publishing Event stopped 
[20201221 21:14:31.022 UTC] [ozw.mqtt.publisher] [debug]: Publishing Event driverFailed: 0 
[20201221 21:14:31.022 UTC] [ozw.mqtt.publisher] [warning]: Exiting on Failure 
[20201221 21:14:31.022 UTC] [ozw.library] [debug]: Detail - Node: 0 Notification: DriverRemoved 
[20201221 21:14:31.022 UTC] [ozw.notifications] [debug]: Notification pvt_driverRemoved  0 Thread:  0x76f7c558 
[20201221 21:14:31.022 UTC] [ozw.mqtt.publisher] [debug]: Publishing Event stopped 
[20201221 21:14:31.023 UTC] [ozw.mqtt.publisher] [debug]: Publishing Event driverRemoved: 0 
[20201221 21:14:31.023 UTC] [ozw.library] [debug]: Always - Node: 0 *************************************************************************** 
[20201221 21:14:31.023 UTC] [ozw.library] [debug]: Always - Node: 0 *********************  Cumulative Network Statistics  ********************* 
[20201221 21:14:31.023 UTC] [ozw.library] [debug]: Always - Node: 0 *** General 
[20201221 21:14:31.023 UTC] [ozw.library] [debug]: Always - Node: 0 Driver run time: . .  . 0 days, 0 hours, 0 minutes 
[20201221 21:14:31.023 UTC] [ozw.library] [debug]: Always - Node: 0 Frames processed: . . . . . . . . . . . . . . . . . . . . 0 
[20201221 21:14:31.024 UTC] [ozw.library] [debug]: Always - Node: 0 Total messages successfully received: . . . . . . . . . . 0 
[20201221 21:14:31.024 UTC] [ozw.library] [debug]: Always - Node: 0 Total Messages successfully sent: . . . . . . . . . . . . 0 
[20201221 21:14:31.024 UTC] [ozw.library] [debug]: Always - Node: 0 ACKs received from controller:  . . . . . . . . . . . . . 0 
[20201221 21:14:31.024 UTC] [ozw.library] [debug]: Always - Node: 0 *** Errors 
[20201221 21:14:31.024 UTC] [ozw.library] [debug]: Always - Node: 0 Unsolicited messages received while waiting for ACK:  . . 0 
[20201221 21:14:31.024 UTC] [ozw.library] [debug]: Always - Node: 0 Reads aborted due to timeouts:  . . . . . . . . . . . . . 0 
[20201221 21:14:31.024 UTC] [ozw.library] [debug]: Always - Node: 0 Bad checksum errors:  . . . . . . . . . . . . . . . . . . 0 
[20201221 21:14:31.024 UTC] [ozw.library] [debug]: Always - Node: 0 CANs received from controller:  . . . . . . . . . . . . . 0 
[20201221 21:14:31.024 UTC] [ozw.library] [debug]: Always - Node: 0 NAKs received from controller:  . . . . . . . . . . . . . 0 
[20201221 21:14:31.024 UTC] [ozw.library] [debug]: Always - Node: 0 Out of frame data flow errors:  . . . . . . . . . . . . . 0 
[20201221 21:14:31.024 UTC] [ozw.library] [debug]: Always - Node: 0 Messages retransmitted: . . . . . . . . . . . . . . . . . 0 
[20201221 21:14:31.024 UTC] [ozw.library] [debug]: Always - Node: 0 Messages dropped and not delivered: . . . . . . . . . . . 0 
[20201221 21:14:31.025 UTC] [ozw.library] [debug]: Always - Node: 0 *************************************************************************** 
[20201221 21:14:31.025 UTC] [ozw.library] [warning]: Warning - Node: 0 WARNING: Tried to write driver config with no home ID set 
[20201221 21:14:31.026 UTC] [ozw.library] [info]: Info - Node: 0 Stopping DNSThread 
[20201221 21:14:35.029 UTC] [ozw.library] [debug]: Detail - Node: 255 Removing current message 
[20201221 21:14:41.020 UTC] [ozw.library] [info]: Info - Node: 0 HttpThread Exiting. No Transfers in timeout period

Eventhough the log isn’t promissing:

  • Installed Open ZWave (beta) integration from Configuration-Integrations.
  • Opened Open ZWave from Configuration-Integrations: OZWDaemon offline

What am I missing?

Thanks!

2

OZW isn’t able to access the device for some reason. Check your hardware info in the supervisor.

3

Thanks the thing, they look OK to me.

serial:
  - /dev/ttyAMA0
input: []
disk: []
gpio:
  - gpiochip0
  - gpiochip504
usb:
  - /dev/bus/usb/001/001
  - /dev/bus/usb/001/002
  - /dev/bus/usb/001/003
  - /dev/bus/usb/001/005
  - /dev/bus/usb/001/004
4

Also added this in config.txt

dtoverlay=pi3-disable-bt
5

You can’t have two instances of ozwdaemon running at the same time. Pick one of those, preferably the official one.

Not to say that is your problem, but you definitely don’t want both installed at the same time, it wasn’t clear if you did that or uninstalled one of them.

6

Well, actually you can. I have the same setup.

I had trouble as well. It runs fine, and has been running fine for 4 weeks now. I will disable the daemon tomorrow to check if it still works.

I read somewhere, cannot recall where sorry, that it was needed. But perhaps I was wrong.

7

Sorry, but you cannot have multiple processes accessing a single USB stick at the same time, whether it’s native zwave, the OZW addon, or unofficial addons.

If you are referring to using two different controllers (e.g. usb sticks), that is a different story.

8

Well it worked. :slight_smile: You are right in the fact that it was useless and not adding anything. I do not know where in my process of trying to fix it I came across the daemon addon but it worked. Probaby due to something else I did.

I tested my network this morning with the extra daemon disabled and it still worked fine. So the daemon is useless.

9

Right, I managed to get it working over a month ago.
When I used a snapshot from 2 weeks ago, the Zwave isn’t working again.
Strange, as Zwave was working at the point the snapshot was created.

Raspberry Pi 3B+ and a SD card.
I have created a new image of HA assistante (32-bit).
Added 2 lines in config.txt (dtoverlay=pi3-disable-bt & enable_uart=1)

Snapshot contained:
addon OpenZwave (latest version)
addon Moquitto + created username
Configured integrations OpenZwave Beta & Moquitto (Configuration>integrations)

I stopped both addons, then first started Mosquitto, then OpenZwave Beta.

Log Mosquitto:

[12:48:05] INFO: Setup mosquitto configuration
[12:48:05] WARNING: SSL not enabled - No valid certs found!
[12:48:05] INFO: Found local users inside config
[12:48:05] INFO: Initialize Hass.io Add-on services
[12:48:05] INFO: Initialize Home Assistant discovery
[12:48:05] INFO: Start Mosquitto daemon
1612093685: mosquitto version 1.6.3 starting
1612093685: Config loaded from /etc/mosquitto.conf.
1612093685: Loading plugin: /usr/share/mosquitto/auth-plug.so
1612093685: |-- *** auth-plug: startup
1612093685:  ├── Username/password checking enabled.
1612093685:  ├── TLS-PSK checking enabled.
1612093685:  └── Extended authentication not enabled.
1612093685: Opening ipv4 listen socket on port 1883.
1612093685: Opening ipv6 listen socket on port 1883.
1612093685: Opening websockets listen socket on port 1884.
1612093686: Warning: Mosquitto should not be run as root/administrator.
1612093688: New connection from 172.30.32.1 on port 1883.
[INFO] found homeassistant on local database
1612093689: New client connected from 172.30.32.1 as 5tr9bBTfBShzISnl9LBRAI (p2, c1, k60, u'homeassistant').
1612093706: New connection from 172.30.33.1 on port 1883.
[INFO] found addons on local database
1612093707: New client connected from 172.30.33.1 as mosq-OI7cvXuioGEytWJ0Ke (p2, c1, k60, u'addons').
1612093707: Client mosq-OI7cvXuioGEytWJ0Ke disconnected.
1612093710: New connection from 172.30.33.1 on port 1883.
1612093710: New bridge connected from 172.30.33.1 as zwave (p2, c1, k60, u'addons').

  • Started Misquitto in Configuration-Integrations

  • Started Open Zwave
    Log Open Z-Wave:

[s6-init] making user provided files available at /var/run/s6/etc...exited 0.
[s6-init] ensuring user provided files have correct perms...exited 0.
[fix-attrs.d] applying ownership & permissions fixes...
[fix-attrs.d] done.
[cont-init.d] executing container initialization scripts...
[cont-init.d] auth.sh: executing... 
[12:33:12] INFO: Auth database exists
[cont-init.d] auth.sh: exited 0.
[cont-init.d] mqtt.sh: executing... 
[12:33:16] INFO: Connected to internal MQTT service
[cont-init.d] mqtt.sh: exited 0.
[cont-init.d] network_key.sh: executing... 
[cont-init.d] network_key.sh: exited 0.
[cont-init.d] novnc.sh: executing... 
[cont-init.d] novnc.sh: exited 0.
[cont-init.d] structure.sh: executing... 
[cont-init.d] structure.sh: exited 0.
[cont-init.d] done.
[services.d] starting services
[services.d] done.
[12:33:18] INFO: Starting internal MQTT broker...
1612092798: mosquitto version 1.6.8 starting
1612092798: Config loaded from /etc/mosquitto.conf.
1612092798: Opening ipv4 listen socket on port 1883.
1612092798: Opening ipv6 listen socket on port 1883.
1612092798: Warning: Mosquitto should not be run as root/administrator.
1612092798: Connecting bridge main-mqtt (core-mosquitto:1883)
[20210131 12:33:25.677 CET] [ozw.library] [info]: Info - Node: 0 Queuing download for http://download.db.openzwave.com/d00f.0200.0330.xml (Node 0) 
[20210131 12:33:25.678 CET] [ozw.library] [debug]: Debug - Node: 0 Download Starting for http://download.db.openzwave.com/d00f.0200.0330.xml (/data/ozw/config/sunricher/srzv9100aa.xml) 
[20210131 12:33:25.843 CET] [ozw.library] [warning]: Warning - Node: 0 Config File for Z-wave 4 Channel Remote does not exist - /data/ozw/config/namron/4512714.xml 
[20210131 12:33:25.844 CET] [ozw.library] [info]: Info - Node: 0 Queuing download for http://download.db.openzwave.com/a305.0300.0438.xml (Node 0) 
[20210131 12:33:25.846 CET] [ozw.library] [debug]: Debug - Node: 0 Download Starting for http://download.db.openzwave.com/a305.0300.0438.xml (/data/ozw/config/namron/4512714.xml) 
[20210131 12:33:25.901 CET] [ozw.library] [debug]: Debug - Node: 0 Downloads Remaining: 10 
[20210131 12:33:25.901 CET] [ozw.library] [warning]: Warning - Node: 0 Download of http://download.db.openzwave.com/0002.0037.001d.xml Failed (Node: 0) 
[20210131 12:33:25.902 CET] [ozw.library] [debug]: Debug - Node: 0 Downloads Remaining: 9 
[20210131 12:33:25.902 CET] [ozw.library] [debug]: Detail - Node: 0 Notification: A Config File Failed to download 
[20210131 12:33:25.902 CET] [ozw.notifications] [debug]: Notification pvt_ozwUserAlert NotificationTypes::Notification_User_ConfigFileDownloadFailed Thread:  0x76f14558 
[20210131 12:33:25.903 CET] [ozw.mqtt.publisher] [debug]: Publishing Event ozwUserAlert 
[20210131 12:33:25.903 CET] [ozw.library] [warning]: Warning - Node: 0 Download of http://download.db.openzwave.com/3137.4944.0063.xml Failed (Node: 0) 
[20210131 12:33:25.903 CET] [ozw.library] [debug]: Debug - Node: 0 Downloads Remaining: 8 
[20210131 12:33:25.904 CET] [ozw.library] [debug]: Detail - Node: 0 Notification: A Config File Failed to download 
[20210131 12:33:25.904 CET] [ozw.notifications] [debug]: Notification pvt_ozwUserAlert NotificationTypes::Notification_User_ConfigFileDownloadFailed Thread:  0x76f14558 
[20210131 12:33:25.904 CET] [ozw.mqtt.publisher] [debug]: Publishing Event ozwUserAlert 
[20210131 12:33:25.905 CET] [ozw.library] [warning]: Warning - Node: 0 Download of http://download.db.openzwave.com/4000.0404.010f.xml Failed (Node: 0) 
[20210131 12:33:25.905 CET] [ozw.library] [debug]: Debug - Node: 0 Downloads Remaining: 7 
[20210131 12:33:25.905 CET] [ozw.library] [debug]: Detail - Node: 0 Notification: A Config File Failed to download 
[20210131 12:33:25.905 CET] [ozw.notifications] [debug]: Notification pvt_ozwUserAlert NotificationTypes::Notification_User_ConfigFileDownloadFailed Thread:  0x76f14558 
[20210131 12:33:25.906 CET] [ozw.mqtt.publisher] [debug]: Publishing Event ozwUserAlert 
[20210131 12:33:25.906 CET] [ozw.library] [warning]: Warning - Node: 0 Download of http://download.db.openzwave.com/images/fibaro/fgwpb121.png Failed (Node: 0) 
[20210131 12:33:25.906 CET] [ozw.library] [debug]: Debug - Node: 0 Downloads Remaining: 6 
[20210131 12:33:25.906 CET] [ozw.library] [debug]: Detail - Node: 0 Notification: A Config File Failed to download 
[20210131 12:33:25.907 CET] [ozw.notifications] [debug]: Notification pvt_ozwUserAlert NotificationTypes::Notification_User_ConfigFileDownloadFailed Thread:  0x76f14558 
[20210131 12:33:25.907 CET] [ozw.mqtt.publisher] [debug]: Publishing Event ozwUserAlert 
[20210131 12:33:25.907 CET] [ozw.library] [warning]: Warning - Node: 0 Download of http://download.db.openzwave.com/0506.0311.0118.xml Failed (Node: 0) 
[20210131 12:33:25.908 CET] [ozw.library] [debug]: Debug - Node: 0 Downloads Remaining: 5 
[20210131 12:33:25.908 CET] [ozw.library] [debug]: Detail - Node: 0 Notification: A Config File Failed to download 
[20210131 12:33:25.908 CET] [ozw.notifications] [debug]: Notification pvt_ozwUserAlert NotificationTypes::Notification_User_ConfigFileDownloadFailed Thread:  0x76f14558 
[20210131 12:33:25.909 CET] [ozw.mqtt.publisher] [debug]: Publishing Event ozwUserAlert 
[20210131 12:33:25.909 CET] [ozw.library] [warning]: Warning - Node: 0 Download of http://download.db.openzwave.com/1252.2201.015f.xml Failed (Node: 0) 
[20210131 12:33:25.909 CET] [ozw.library] [debug]: Debug - Node: 0 Downloads Remaining: 4 
[20210131 12:33:25.910 CET] [ozw.library] [debug]: Detail - Node: 0 Notification: A Config File Failed to download 
[20210131 12:33:25.910 CET] [ozw.notifications] [debug]: Notification pvt_ozwUserAlert NotificationTypes::Notification_User_ConfigFileDownloadFailed Thread:  0x76f14558 
[20210131 12:33:25.910 CET] [ozw.mqtt.publisher] [debug]: Publishing Event ozwUserAlert 
[20210131 12:33:25.911 CET] [ozw.library] [warning]: Warning - Node: 0 Download of http://download.db.openzwave.com/0204.0004.019b.xml Failed (Node: 0) 
[20210131 12:33:25.911 CET] [ozw.library] [debug]: Debug - Node: 0 Downloads Remaining: 3 
[20210131 12:33:25.911 CET] [ozw.library] [debug]: Detail - Node: 0 Notification: A Config File Failed to download 
[20210131 12:33:25.911 CET] [ozw.notifications] [debug]: Notification pvt_ozwUserAlert NotificationTypes::Notification_User_ConfigFileDownloadFailed Thread:  0x76f14558 
[20210131 12:33:25.912 CET] [ozw.mqtt.publisher] [debug]: Publishing Event ozwUserAlert 
[20210131 12:33:25.915 CET] [ozw.library] [warning]: Warning - Node: 0 Download of http://download.db.openzwave.com/102c.0200.0258.xml Failed (Node: 0) 
[20210131 12:33:25.915 CET] [ozw.library] [debug]: Debug - Node: 0 Downloads Remaining: 2 
[20210131 12:33:25.915 CET] [ozw.library] [debug]: Detail - Node: 0 Notification: A Config File Failed to download 
[20210131 12:33:25.916 CET] [ozw.notifications] [debug]: Notification pvt_ozwUserAlert NotificationTypes::Notification_User_ConfigFileDownloadFailed Thread:  0x76f14558 
[20210131 12:33:25.916 CET] [ozw.mqtt.publisher] [debug]: Publishing Event ozwUserAlert 
[20210131 12:33:25.916 CET] [ozw.library] [warning]: Warning - Node: 0 Download of http://download.db.openzwave.com/d00f.0200.0330.xml Failed (Node: 0) 
[20210131 12:33:25.917 CET] [ozw.library] [debug]: Debug - Node: 0 Downloads Remaining: 1 
[20210131 12:33:25.917 CET] [ozw.library] [debug]: Detail - Node: 0 Notification: A Config File Failed to download 
[20210131 12:33:25.918 CET] [ozw.notifications] [debug]: Notification pvt_ozwUserAlert NotificationTypes::Notification_User_ConfigFileDownloadFailed Thread:  0x76f14558 
[20210131 12:33:25.918 CET] [ozw.mqtt.publisher] [debug]: Publishing Event ozwUserAlert 
[20210131 12:33:25.959 CET] [ozw.library] [warning]: Warning - Node: 0 Download of http://download.db.openzwave.com/a305.0300.0438.xml Failed (Node: 0) 
[20210131 12:33:25.967 CET] [ozw.library] [debug]: Debug - Node: 0 Downloads Remaining: 0 
[20210131 12:33:25.967 CET] [ozw.library] [info]: Info - Node: 0 ManufacturerSpecificDB Initialized 
[20210131 12:33:25.967 CET] [ozw.library] [debug]: Detail - Node: 0 Notification: A Config File Failed to download 
[20210131 12:33:25.967 CET] [ozw.library] [debug]: Detail - Node: 0 Notification: ManufacturerSpecificDB Ready 
[20210131 12:33:25.968 CET] [ozw.library] [info]: Info - Node: 255 Sending (Command) message (Callback ID=0x00, Expected Reply=0x15) - FUNC_ID_ZW_GET_VERSION: 0x01, 0x03, 0x00, 0x15, 0xe9 
[20210131 12:33:25.968 CET] [ozw.library] [info]: Info - Node: 255 Encrypted Flag is 0 
[20210131 12:33:25.968 CET] [ozw.library] [debug]: Detail - Node: 255 Notification: DriverFailed: /dev/ttyAMA0 
[20210131 12:33:25.969 CET] [ozw.notifications] [debug]: Notification pvt_ozwUserAlert NotificationTypes::Notification_User_ConfigFileDownloadFailed Thread:  0x76f14558 
[20210131 12:33:25.970 CET] [ozw.mqtt.publisher] [debug]: Publishing Event ozwUserAlert 
[20210131 12:33:25.970 CET] [ozw.notifications] [debug]: Notification pvt_manufacturerSpecificDBReady Thread:  0x76f14558 
[20210131 12:33:25.971 CET] [ozw.mqtt.publisher] [debug]: Publishing Event manufacturerSpecificDBReady 
[20210131 12:33:25.971 CET] [ozw.notifications] [debug]: Notification pvt_driverFailed  0 Thread:  0x76f14558 
[20210131 12:33:25.972 CET] [ozw.mqtt.publisher] [debug]: Publishing Event stopped 
[20210131 12:33:25.972 CET] [ozw.mqtt.publisher] [debug]: Publishing Event driverFailed: 0 
[20210131 12:33:25.972 CET] [ozw.mqtt.publisher] [warning]: Exiting on Failure 
[20210131 12:33:25.973 CET] [ozw.library] [debug]: Detail - Node: 0 Notification: DriverRemoved 
[20210131 12:33:25.973 CET] [ozw.notifications] [debug]: Notification pvt_driverRemoved  0 Thread:  0x76f14558 
[20210131 12:33:25.974 CET] [ozw.mqtt.publisher] [debug]: Publishing Event stopped 
[20210131 12:33:25.975 CET] [ozw.mqtt.publisher] [debug]: Publishing Event driverRemoved: 0 
[20210131 12:33:25.975 CET] [ozw.library] [debug]: Always - Node: 0 *************************************************************************** 
[20210131 12:33:25.975 CET] [ozw.library] [debug]: Always - Node: 0 *********************  Cumulative Network Statistics  ********************* 
[20210131 12:33:25.976 CET] [ozw.library] [debug]: Always - Node: 0 *** General 
[20210131 12:33:25.976 CET] [ozw.library] [debug]: Always - Node: 0 Driver run time: . .  . 0 days, 0 hours, 0 minutes 
[20210131 12:33:25.976 CET] [ozw.library] [debug]: Always - Node: 0 Frames processed: . . . . . . . . . . . . . . . . . . . . 0 
[20210131 12:33:25.976 CET] [ozw.library] [debug]: Always - Node: 0 Total messages successfully received: . . . . . . . . . . 0 
[20210131 12:33:25.976 CET] [ozw.library] [debug]: Always - Node: 0 Total Messages successfully sent: . . . . . . . . . . . . 0 
[20210131 12:33:25.976 CET] [ozw.library] [debug]: Always - Node: 0 ACKs received from controller:  . . . . . . . . . . . . . 0 
[20210131 12:33:25.976 CET] [ozw.library] [debug]: Always - Node: 0 *** Errors 
[20210131 12:33:25.976 CET] [ozw.library] [debug]: Always - Node: 0 Unsolicited messages received while waiting for ACK:  . . 0 
[20210131 12:33:25.976 CET] [ozw.library] [debug]: Always - Node: 0 Reads aborted due to timeouts:  . . . . . . . . . . . . . 0 
[20210131 12:33:25.976 CET] [ozw.library] [debug]: Always - Node: 0 Bad checksum errors:  . . . . . . . . . . . . . . . . . . 0 
[20210131 12:33:25.976 CET] [ozw.library] [debug]: Always - Node: 0 CANs received from controller:  . . . . . . . . . . . . . 0 
[20210131 12:33:25.977 CET] [ozw.library] [debug]: Always - Node: 0 NAKs received from controller:  . . . . . . . . . . . . . 0 
[20210131 12:33:25.977 CET] [ozw.library] [debug]: Always - Node: 0 Out of frame data flow errors:  . . . . . . . . . . . . . 0 
[20210131 12:33:25.977 CET] [ozw.library] [debug]: Always - Node: 0 Messages retransmitted: . . . . . . . . . . . . . . . . . 0 
[20210131 12:33:25.977 CET] [ozw.library] [debug]: Always - Node: 0 Messages dropped and not delivered: . . . . . . . . . . . 0 
[20210131 12:33:25.977 CET] [ozw.library] [debug]: Always - Node: 0 *************************************************************************** 
[20210131 12:33:25.977 CET] [ozw.library] [warning]: Warning - Node: 0 WARNING: Tried to write driver config with no home ID set 
[20210131 12:33:25.978 CET] [ozw.library] [info]: Info - Node: 0 Stopping DNSThread 
WebSocket server settings:
  - Listen on :8099
  - Web server. Web root: /usr/share/novnc
  - No SSL/TLS support (no cert file)
  - proxying from :8099 to 127.0.0.1:5900
1612092809: New connection from 172.30.32.1 on port 1883.
1612092809: New client connected from 172.30.32.1 as 1UY3N4XnPgeUgaDZsqomk8 (p2, c1, k60, u'homeassistant').
[20210131 12:33:29.980 CET] [ozw.library] [debug]: Detail - Node: 255 Removing current message 
[20210131 12:33:35.959 CET] [ozw.library] [info]: Info - Node: 0 HttpThread Exiting. No Transfers in timeout period
10

Using HassOS/Hass.io with a GPIO Zwave module? Something changed in the needed configuration file and specifically the order of the lines I believe, after updating OS version. There’s multiple reports on the forum (on my phone right now so hard to link a thread directly :))

11

Yes, I am using a Razberry zwave.me 2 board.

Configuration.yaml or config.txt?

12

Can someone pointme in the right directions?
I am unable to find the reports on the forum.

13

Just a thought:
I never ran a firmware update for my Razberry board. I am using it for 3 years or so.
Should it matter? If so, are you able to see the firmware version in HA/can you upgrade it while running HA?

14

Make sure your boot file is correct to disable Bluetooth. I’ve seen reports of lines being removed after updating OS versions.

15

I am using these lines in config.txt:

dtoverlay=disable-bt
enable_uart=1

This setting was valid before I restored the snapshot.

16

In your previous post you mentioned “pi3-disable-bt” and in the latest one it’s the same without “pi3-”
Which one are your actually using and does “the other one” help at all?
What versions of HassOS / Supervisor are you using?

Any luck with the following post?

17

Sorry, I used these lines, pi3 not included.

Raspberry 3B+
It’s running core-2021.1.5 and supervisor-2021.01.7
OpenZwave (beta) 0.9.0, Mosquitto broker 5.1

I manged to fix it. I changed device to /dev/ttyS0. Strange solution.

1 Like
18

I never got it to work on my Raspberry 3+ or 4 with the Razberry. Bought the UZB1 instead and everything worked directly. Could have been a faulty Razberry but I think I tried almost all settings and got it to work once but even then it was extremely slow and stopped working after 30 min…

19

Ran into this issue today after a restart. Tried a few of the suggestions listed here without any luck.

I was able to get all OpenZWave entities back online after rebooting the host (Supervisor > System > Reboot Host).

HassOS 5.10 on a Raspberry Pi 4 / SSD + HUSBZB-1