QT-Openzwave addon crashing

Configuration Z-Wave
,
1

Hi All,

I’ve been running the new QT-Openzwave addon and beta Z-Wave Integrations with Mosquitto broker
Current (Ver: 5.1) for over a month, with only the dimming issue, which was fixed in 0.114. Suddenly, without any updates or changes, I’ve lost all my node devices / entities; the addon is now crashing and I can’t connect OZWAdmin (Ver: 0.1.74).

I’m confirmed:

  • The dongle is still working, via the Simplicity Studio Z-Wave controller;
  • HA can still see the dongle port and;
  • HA still includes the device and entities for the dongle.

I’ve tried removing the addon and integration, restarting HA and reinstalled them, but the addon still crashes. I’ve also tried going back to a earlier snapshot prior to the issue, and the addon still crashes.

I’ve included the addon logs from a fresh host restart below.

Any fixes, tips or ideas would be appriciated?

HA: 0.114.4
Installation Type: Home Assistant Supervised
Supervisor: 243
Host: Ubuntu 20.04.1 LTS - unsupported.
Docker: 19.03.12
USB/Z-wave Dongle: AeoTec ZW090-C

Thanks in advance.

Neil

‘’’
[20200913 21:55:11.073 BST] [ozw.nodes] [debug]: Removing Node QVariant(int, 41) 0
[20200913 21:55:11.073 BST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 42 Thread: 0x7fec4754bd48
[20200913 21:55:11.073 BST] [ozw.nodes] [debug]: Removing Node QVariant(int, 42) 0
[20200913 21:55:11.073 BST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 43 Thread: 0x7fec4754bd48
[20200913 21:55:11.073 BST] [ozw.nodes] [debug]: Removing Node QVariant(int, 43) 0
[20200913 21:55:11.073 BST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 44 Thread: 0x7fec4754bd48
[20200913 21:55:11.073 BST] [ozw.nodes] [debug]: Removing Node QVariant(int, 44) 0
[20200913 21:55:11.073 BST] [ozw.notifications] [debug]: Notification pvt_nodeRemoved 45 Thread: 0x7fec4754bd48
[20200913 21:55:11.073 BST] [ozw.nodes] [debug]: Removing Node QVariant(int, 45) 0
[20200913 21:55:11.074 BST] [ozw.library] [debug]: Always - Node: 0 ***************************************************************************
[20200913 21:55:11.074 BST] [ozw.library] [debug]: Always - Node: 0 ********************* Cumulative Network Statistics *********************
[20200913 21:55:11.074 BST] [ozw.library] [debug]: Always - Node: 0 *** General
[20200913 21:55:11.074 BST] [ozw.library] [debug]: Always - Node: 0 Driver run time: . . . 0 days, 0 hours, 9 minutes
[20200913 21:55:11.074 BST] [ozw.library] [debug]: Always - Node: 0 Frames processed: . . . . . . . . . . . . . . . . . . . . 91
[20200913 21:55:11.074 BST] [ozw.library] [debug]: Always - Node: 0 Total messages successfully received: . . . . . . . . . . 91
[20200913 21:55:11.074 BST] [ozw.library] [debug]: Always - Node: 0 Total Messages successfully sent: . . . . . . . . . . . . 111
[20200913 21:55:11.074 BST] [ozw.library] [debug]: Always - Node: 0 ACKs received from controller: . . . . . . . . . . . . . 66
[20200913 21:55:11.074 BST] [ozw.library] [debug]: Always - Node: 0 *** Errors
[20200913 21:55:11.074 BST] [ozw.library] [debug]: Always - Node: 0 Unsolicited messages received while waiting for ACK: . . 0
[20200913 21:55:11.074 BST] [ozw.library] [debug]: Always - Node: 0 Reads aborted due to timeouts: . . . . . . . . . . . . . 0
[20200913 21:55:11.074 BST] [ozw.library] [debug]: Always - Node: 0 Bad checksum errors: . . . . . . . . . . . . . . . . . . 0
[20200913 21:55:11.074 BST] [ozw.library] [debug]: Always - Node: 0 CANs received from controller: . . . . . . . . . . . . . 45
[20200913 21:55:11.074 BST] [ozw.library] [debug]: Always - Node: 0 NAKs received from controller: . . . . . . . . . . . . . 0
[20200913 21:55:11.074 BST] [ozw.library] [debug]: Always - Node: 0 Out of frame data flow errors: . . . . . . . . . . . . . 0
[20200913 21:55:11.074 BST] [ozw.library] [debug]: Always - Node: 0 Messages retransmitted: . . . . . . . . . . . . . . . . . 5
[20200913 21:55:11.074 BST] [ozw.library] [debug]: Always - Node: 0 Messages dropped and not delivered: . . . . . . . . . . . 42
[20200913 21:55:11.074 BST] [ozw.library] [debug]: Always - Node: 0 ***************************************************************************
[20200913 21:55:11.074 BST] [ozw.library] [info]: Info - Node: 0 Saving Cache
[20200913 21:55:11.075 BST] [ozw.library] [info]: Info - Node: 1 Cache Save for Node 1 as its QueryStage_CacheLoad
[20200913 21:55:11.075 BST] [ozw.library] [info]: Info - Node: 2 Skipping Cache Save for Node 2 as its not past QueryStage_CacheLoad
[20200913 21:55:11.075 BST] [ozw.library] [info]: Info - Node: 3 Skipping Cache Save for Node 3 as its not past QueryStage_CacheLoad
[20200913 21:55:11.075 BST] [ozw.library] [info]: Info - Node: 4 Skipping Cache Save for Node 4 as its not past QueryStage_CacheLoad
[20200913 21:55:11.075 BST] [ozw.library] [info]: Info - Node: 5 Skipping Cache Save for Node 5 as its not past QueryStage_CacheLoad
[20200913 21:55:11.075 BST] [ozw.library] [info]: Info - Node: 6 Skipping Cache Save for Node 6 as its not past QueryStage_CacheLoad
[20200913 21:55:11.075 BST] [ozw.library] [info]: Info - Node: 7 Skipping Cache Save for Node 7 as its not past QueryStage_CacheLoad
[20200913 21:55:11.075 BST] [ozw.library] [info]: Info - Node: 8 Skipping Cache Save for Node 8 as its not past QueryStage_CacheLoad
[20200913 21:55:11.075 BST] [ozw.library] [info]: Info - Node: 9 Skipping Cache Save for Node 9 as its not past QueryStage_CacheLoad
[20200913 21:55:11.075 BST] [ozw.library] [info]: Info - Node: 10 Skipping Cache Save for Node 10 as its not past QueryStage_CacheLoad
[20200913 21:55:11.075 BST] [ozw.library] [info]: Info - Node: 11 Skipping Cache Save for Node 11 as its not past QueryStage_CacheLoad
[20200913 21:55:11.075 BST] [ozw.library] [info]: Info - Node: 12 Skipping Cache Save for Node 12 as its not past QueryStage_CacheLoad
[20200913 21:55:11.075 BST] [ozw.library] [info]: Info - Node: 13 Skipping Cache Save for Node 13 as its not past QueryStage_CacheLoad
[20200913 21:55:11.076 BST] [ozw.library] [info]: Info - Node: 14 Skipping Cache Save for Node 14 as its not past QueryStage_CacheLoad
[20200913 21:55:11.076 BST] [ozw.library] [info]: Info - Node: 15 Skipping Cache Save for Node 15 as its not past QueryStage_CacheLoad
[20200913 21:55:11.076 BST] [ozw.library] [info]: Info - Node: 16 Skipping Cache Save for Node 16 as its not past QueryStage_CacheLoad
[20200913 21:55:11.076 BST] [ozw.library] [info]: Info - Node: 17 Skipping Cache Save for Node 17 as its not past QueryStage_CacheLoad
[20200913 21:55:11.076 BST] [ozw.library] [info]: Info - Node: 18 Skipping Cache Save for Node 18 as its not past QueryStage_CacheLoad
[20200913 21:55:11.076 BST] [ozw.library] [info]: Info - Node: 19 Skipping Cache Save for Node 19 as its not past QueryStage_CacheLoad
[20200913 21:55:11.076 BST] [ozw.library] [info]: Info - Node: 20 Skipping Cache Save for Node 20 as its not past QueryStage_CacheLoad
[20200913 21:55:11.076 BST] [ozw.library] [info]: Info - Node: 21 Skipping Cache Save for Node 21 as its not past QueryStage_CacheLoad
[20200913 21:55:11.076 BST] [ozw.library] [info]: Info - Node: 23 Skipping Cache Save for Node 23 as its not past QueryStage_CacheLoad
[20200913 21:55:11.076 BST] [ozw.library] [info]: Info - Node: 24 Skipping Cache Save for Node 24 as its not past QueryStage_CacheLoad
[20200913 21:55:11.076 BST] [ozw.library] [info]: Info - Node: 25 Skipping Cache Save for Node 25 as its not past QueryStage_CacheLoad
[20200913 21:55:11.076 BST] [ozw.library] [info]: Info - Node: 27 Skipping Cache Save for Node 27 as its not past QueryStage_CacheLoad
[20200913 21:55:11.076 BST] [ozw.library] [info]: Info - Node: 28 Skipping Cache Save for Node 28 as its not past QueryStage_CacheLoad
[20200913 21:55:11.076 BST] [ozw.library] [info]: Info - Node: 29 Skipping Cache Save for Node 29 as its not past QueryStage_CacheLoad
[20200913 21:55:11.076 BST] [ozw.library] [info]: Info - Node: 30 Skipping Cache Save for Node 30 as its not past QueryStage_CacheLoad
[20200913 21:55:11.076 BST] [ozw.library] [info]: Info - Node: 31 Skipping Cache Save for Node 31 as its not past QueryStage_CacheLoad
[20200913 21:55:11.076 BST] [ozw.library] [info]: Info - Node: 32 Skipping Cache Save for Node 32 as its not past QueryStage_CacheLoad
[20200913 21:55:11.076 BST] [ozw.library] [info]: Info - Node: 33 Skipping Cache Save for Node 33 as its not past QueryStage_CacheLoad
[20200913 21:55:11.076 BST] [ozw.library] [info]: Info - Node: 36 Skipping Cache Save for Node 36 as its not past QueryStage_CacheLoad
[20200913 21:55:11.077 BST] [ozw.library] [info]: Info - Node: 38 Skipping Cache Save for Node 38 as its not past QueryStage_CacheLoad
[20200913 21:55:11.077 BST] [ozw.library] [info]: Info - Node: 39 Skipping Cache Save for Node 39 as its not past QueryStage_CacheLoad
[20200913 21:55:11.077 BST] [ozw.library] [info]: Info - Node: 40 Skipping Cache Save for Node 40 as its not past QueryStage_CacheLoad
[20200913 21:55:11.077 BST] [ozw.library] [info]: Info - Node: 41 Skipping Cache Save for Node 41 as its not past QueryStage_CacheLoad
[20200913 21:55:11.077 BST] [ozw.library] [info]: Info - Node: 42 Skipping Cache Save for Node 42 as its not past QueryStage_CacheLoad
[20200913 21:55:11.077 BST] [ozw.library] [info]: Info - Node: 43 Skipping Cache Save for Node 43 as its not past QueryStage_CacheLoad
[20200913 21:55:11.077 BST] [ozw.library] [info]: Info - Node: 44 Skipping Cache Save for Node 44 as its not past QueryStage_CacheLoad
[20200913 21:55:11.077 BST] [ozw.library] [info]: Info - Node: 45 Skipping Cache Save for Node 45 as its not past QueryStage_CacheLoad
[20200913 21:55:11.079 BST] [ozw.library] [info]: Info - Node: 0 Stopping DNSThread
[20200913 21:55:11.208 BST] [ozw.library] [debug]: Detail - Node: 19 Removing current message
[20200913 21:55:11.208 BST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted
[20200913 21:55:11.208 BST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted
[20200913 21:55:11.208 BST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted
[20200913 21:55:11.208 BST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted
[20200913 21:55:11.208 BST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted
[20200913 21:55:11.209 BST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted
[20200913 21:55:11.209 BST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted
[20200913 21:55:11.209 BST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted
[20200913 21:55:11.209 BST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted
[20200913 21:55:11.209 BST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted
[20200913 21:55:11.209 BST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted
[20200913 21:55:11.209 BST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted
[20200913 21:55:11.211 BST] [ozw.library] [info]: Info - Node: 0 mgr, Driver for controller /dev/serial/by-id/usb-0658_0200-if00 removed
[20200913 21:55:11.211 BST] [ozw.manager] [debug]: Driver Removed for “/dev/serial/by-id/usb-0658_0200-if00”
[20200913 21:55:11.211 BST] [ozw.manager] [debug]: OZW Serial Port Closed
[20200913 21:55:11.211 BST] [ozw.daemon] [info]: Shutting Down “ozwdaemon” Version: “0.1.0”
[20200913 21:55:11.212 BST] [ozw.daemon] [info]: OpenZWave Version: “1.6.1210”
[20200913 21:55:11.212 BST] [ozw.daemon] [info]: QT-OpenZWave Version: “1.2.0”
[20200913 21:55:11.212 BST] [ozw.daemon] [info]: QT Version: 5.12.5
In exit
[cont-finish.d] executing container finish scripts…
[cont-finish.d] mqtt.sh: executing…
1600030511: mosquitto version 1.6.8 terminating
1600030511: Saving in-memory database to /data/mosquitto.db.
[21:55:11] INFO: Ensure upstream MQTT server has the correct OZW status
[cont-finish.d] mqtt.sh: exited 0.
[cont-finish.d] done.
[s6-finish] waiting for services.
[s6-finish] sending all processes the TERM signal.
[s6-finish] sending all processes the KILL signal and exiting.
‘’’

1 Like
2

Are you 100% sure that the MQTT addon (Mosquitto broker) is also started successfully?

3

Hi Sender,

Think so, but here’s the MQTT addon logs.

[23:10:28] INFO: Setup mosquitto configuration
[23:10:28] WARNING: SSL not enabled - No valid certs found!
[23:10:28] INFO: Found local users inside config
[23:10:28] INFO: Initialize Hass.io Add-on services
[23:10:28] INFO: Initialize Home Assistant discovery
[23:10:28] INFO: Start Mosquitto daemon
1600035028: mosquitto version 1.6.3 starting
1600035028: Config loaded from /etc/mosquitto.conf.
1600035028: Loading plugin: /usr/share/mosquitto/auth-plug.so
1600035028:  ├── Username/password checking enabled.
1600035028:  ├── TLS-PSK checking enabled.
1600035028:  └── Extended authentication not enabled.
1600035028: |-- *** auth-plug: startup
1600035028: Opening ipv4 listen socket on port 1883.
1600035028: Opening ipv6 listen socket on port 1883.
1600035028: Opening websockets listen socket on port 1884.
1600035028: Warning: Mosquitto should not be run as root/administrator.
1600035047: New connection from 172.30.32.1 on port 1883.
[INFO] found homeassistant on local database
1600035047: New client connected from 172.30.32.1 as auto-6D0ED00E-2655-3C5E-08BB-FF004869AEDF (p2, c1, k60, u'homeassistant').
1600036828: Saving in-memory database to /data/mosquitto.db.
1600038629: Saving in-memory database to /data/mosquitto.db.
1600040430: Saving in-memory database to /data/mosquitto.db.
1600042231: Saving in-memory database to /data/mosquitto.db.
1600044032: Saving in-memory database to /data/mosquitto.db.
1600045833: Saving in-memory database to /data/mosquitto.db.
1600047634: Saving in-memory database to /data/mosquitto.db.
1600049435: Saving in-memory database to /data/mosquitto.db.
1600051236: Saving in-memory database to /data/mosquitto.db.
1600053037: Saving in-memory database to /data/mosquitto.db.
1600054838: Saving in-memory database to /data/mosquitto.db.
1600056639: Saving in-memory database to /data/mosquitto.db.
1600058440: Saving in-memory database to /data/mosquitto.db.
1600060241: Saving in-memory database to /data/mosquitto.db.
1600062042: Saving in-memory database to /data/mosquitto.db.
1600063843: Saving in-memory database to /data/mosquitto.db.
1600065644: Saving in-memory database to /data/mosquitto.db.
1600067445: Saving in-memory database to /data/mosquitto.db.
1600069246: Saving in-memory database to /data/mosquitto.db.
1600071047: Saving in-memory database to /data/mosquitto.db.
1600072848: Saving in-memory database to /data/mosquitto.db.
1600074649: Saving in-memory database to /data/mosquitto.db.
1600076450: Saving in-memory database to /data/mosquitto.db.
1600078251: Saving in-memory database to /data/mosquitto.db.
1600080052: Saving in-memory database to /data/mosquitto.db.
1600081853: Saving in-memory database to /data/mosquitto.db.
1600083654: Saving in-memory database to /data/mosquitto.db.
1600085455: Saving in-memory database to /data/mosquitto.db.
1600087256: Saving in-memory database to /data/mosquitto.db.
1600089057: Saving in-memory database to /data/mosquitto.db.
4

Are you maybe facing this:

1 Like
5

Try connecting to MQTT with a client like MQTT-Explorer, and delete the OpenZWave topic. Then start the ozwdaemon container.

6

Oh FFS, I updated to 0.6.0 and now I have the same!

[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…
[22:48:06] INFO: Auth database exists
[cont-init.d] auth.sh: exited 0.
[cont-init.d] mqtt.sh: executing…
[22:48:09] 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…
sed: /usr/share/novnc/vnc_lite.html: No such file or directory
[cont-init.d] novnc.sh: exited 1.
[cont-finish.d] executing container finish scripts…
[cont-finish.d] mqtt.sh: executing…
[22:48:10] INFO: Ensure upstream MQTT server has the correct OZW status
[cont-finish.d] mqtt.sh: exited 0.
[cont-finish.d] done.
[s6-finish] waiting for services.
[s6-finish] sending all processes the TERM signal.
[s6-finish] sending all processes the KILL signal and exiting.

And deleting the openzwave topic no difference.

7

Having the same issue after updating to 0.6.0 here.

8

I should have checked this topic first! :frowning:
I have just updated to 0.6.0 and now I have the same problem.
I tried to delete the openzwave topic with MQTT explorer but no results. I also tried to uninstall/reinstall the addon.

9

Same issues after upgrading to 0.6.0. Also tried the same remedies.

10

Getting the same result even after a complete restart of HA. Restarted MQTT and OZW. Same result. Even reinstalled OZW 6.0. Dead in the water here.

11

Also getting the same result. I have restart HA, Mosquitto broker, and OZW. I uninstalled both Mosquitto broker and OZW and still have the same result.

Is there a way to downgrade?

Home Assistant 0.114.4
Mosquitto broker 5.1
OZW 0.6.0

12

As far as I know the only way to downgrade is to partially restore a snapshot, by checking only the option ‘openzwave’ and click on ‘restore selected’. I would also suggest to delete the Openzwave topic with MQTT explorer. I did it and I am now back to 0.5.2 - working ok.

13

Did you do a restore selected for only the OZW addon to the previous version from snapshot or wipe and restore for it?

Also using MQTT Explorer, I assume you deleted the OpenZWave topic including all sub-topics before doing the restore?

14

Yes, I have just selected OZW and clicked on ‘Restore Selected’.

Yes, I deleted the ‘OpenZWave’ topic and all the subtopics were deleted too (MQTT does it automatically).

Hope this helps!

15

Back up and running on 0.5.2. Thanks for the help!

16

Great! :+1:

17

Back up and running on 0.5.4. Thanks.

18

Thanks for the tip. I did the same. Seems like 0.6.0 was a bust. Nothing like hitting upgrade then not being able to turn your lights on/ off. Glad I have good snapshot records!

19

Hit the same issue with 0.6.0 , downgraded to 0.5.4 didn’t help, then downgraded to 0.5.2 it did the job. Cleared related mqtt after seeing that post, just to make sure, everything is ok

20

It seems an issue was created… wait for update…