OpenZWave not working after update

Thanks, I will post in that issue!

I have just 1 week ago migrated from Domoticz to hass.io and I’m super happy, there are differences but the setup was super easy (running on VMware ESX) and it has been fairly easy to adjust.

I do have the problem that my Z-Wave (AEOTEC Z-Stick gen 5) is not working after reboot. So day 2 of me using HA I created a new virtual machine with the provided vmdk-file and everything was working great, I didn’t dare to reboot but just restarting HA-service works fine.

Yesterday I was fiddling around and I remember that there was an upgrade to downgrade some modules? I thought it might have been related to the issue with ZWave so I rebooted just to test. Unfortunately the problem occurred again… I get some different error messages but they are basically the same as already mentioned.

I tried the suggestion to remove the mosquitto.db (mine was at /mnt/data/supervisor/addons/data/core_zwave/mosquitto.db as mentioned by kmpm in the bug report comments).

at the same time, I also removed all the messages with MQTT Explorer.

after that I rebooted the system completely and then I got the familiar error messages in the logs:

[20200719 13:58:24.968 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.968 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.968 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.968 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.968 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.968 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.968 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.968 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.968 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.968 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.968 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.968 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.968 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.968 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.968 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.968 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.968 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.968 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.968 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.968 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.969 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.969 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.969 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.969 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.969 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.969 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.969 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.969 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.969 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.969 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.969 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.969 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.969 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.969 CEST] [ozw.library] [debug]: Debug - Node: 0 Value Deleted 
[20200719 13:58:24.969 CEST] [ozw.library] [info]: Info - Node: 0 mgr,     Driver for controller /dev/serial/by-id/usb-0658_0200-if00 removed 
[20200719 13:58:24.969 CEST] [ozw.manager] [debug]: Driver Removed for  "/dev/serial/by-id/usb-0658_0200-if00" 
[20200719 13:58:24.969 CEST] [ozw.manager] [debug]: OZW Serial Port Closed 
[20200719 13:58:24.969 CEST] [ozw.daemon] [info]: Shutting Down  "ozwdaemon"  Version:  "0.1.0" 
[20200719 13:58:24.969 CEST] [ozw.daemon] [info]: OpenZWave Version:  "1.6.1198" 
[20200719 13:58:24.969 CEST] [ozw.daemon] [info]: QT-OpenZWave Version:  "1.2.0" 
[20200719 13:58:24.969 CEST] [ozw.daemon] [info]: QT Version:  5.12.5 
[20200719 13:58:24.980 CEST] [ozw.manager] [info]: New Client WebSocket Connection QHostAddress("::ffff:127.0.0.1") 
[20200719 13:58:24.980 CEST] [ozw.notifications] [debug]: Notification pvt_ozwNotification NotificationTypes::Notification_Code_NoOperation Thread:  0x7f18ca6cdd48 
[20200719 13:58:24.980 CEST] [ozw.notifications] [debug]: Notification pvt_nodeProtocolInfo  21 Thread:  0x7f18ca6cdd48 
[20200719 13:58:24.980 CEST] [ozw.library] [critical]: Error - Node: 0 mgr,     Manager::GetDriver failed - Home ID 0x00000000 is unknown 
[20200719 13:58:24.980 CEST] [ozw.library] [warning]: Warning - Node: 0 Exception: Manager.cpp:410 - 100 - Invalid HomeId passed to GetDriver 
[20200719 13:58:24.981 CEST] [ozw.notifications] [warning]: OZW Exception:  Invalid HomeId passed to GetDriver  at  /usr/src/ozw/cpp/src/Manager.cpp : 410 
[20200719 13:58:24.983 CEST] [ozw.manager] [warning]: WebSocket Client Error  QAbstractSocket::RemoteHostClosedError 
[20200719 13:58:24.983 CEST] [ozwadmin] [debug]: Remote Connection Status:  QTOZWManager::ConnectionErrorState QAbstractSocket::RemoteHostClosedError 
In exit
Terminating child 497
1595159905: mosquitto version 1.6.8 terminating
1595159905: Saving in-memory database to /data/mosquitto.db.
[cont-finish.d] executing container finish scripts...
[cont-finish.d] done.
[s6-finish] waiting for services.
Process Process-1:
Traceback (most recent call last):
  File "/usr/lib/python3.8/multiprocessing/process.py", line 315, in _bootstrap
    self.run()
  File "/usr/lib/python3.8/multiprocessing/process.py", line 108, in run
    self._target(*self._args, **self._kwargs)
  File "/usr/lib/python3.8/site-packages/websockify/websockifyserver.py", line 691, in top_new_client
    client = self.do_handshake(startsock, address)
  File "/usr/lib/python3.8/site-packages/websockify/websockifyserver.py", line 619, in do_handshake
    self.RequestHandlerClass(retsock, address, self)
  File "/usr/lib/python3.8/site-packages/websockify/websockifyserver.py", line 99, in __init__
    SimpleHTTPRequestHandler.__init__(self, req, addr, server)
  File "/usr/lib/python3.8/http/server.py", line 647, in __init__
    super().__init__(*args, **kwargs)
  File "/usr/lib/python3.8/socketserver.py", line 720, in __init__
    self.handle()
  File "/usr/lib/python3.8/site-packages/websockify/websockifyserver.py", line 315, in handle
    SimpleHTTPRequestHandler.handle(self)
  File "/usr/lib/python3.8/http/server.py", line 429, in handle
    self.handle_one_request()
  File "/usr/lib/python3.8/site-packages/websockify/websocketserver.py", line 47, in handle_one_request
    super(WebSocketRequestHandlerMixIn, self).handle_one_request()
  File "/usr/lib/python3.8/http/server.py", line 415, in handle_one_request
    method()
  File "/usr/lib/python3.8/site-packages/websockify/websocketserver.py", line 60, in _websocket_do_GET
    self.handle_upgrade()
  File "/usr/lib/python3.8/site-packages/websockify/websockifyserver.py", line 221, in handle_upgrade
    WebSocketRequestHandlerMixIn.handle_upgrade(self)
  File "/usr/lib/python3.8/site-packages/websockify/websocketserver.py", line 87, in handle_upgrade
    self.handle_websocket()
  File "/usr/lib/python3.8/site-packages/websockify/websockifyserver.py", line 259, in handle_websocket
    self.new_websocket_client()
  File "/usr/lib/python3.8/site-packages/websockify/websocketproxy.py", line 134, in new_websocket_client
    self.do_proxy(tsock)
  File "/usr/lib/python3.8/site-packages/websockify/websocketproxy.py", line 209, in do_proxy
    ins, outs, excepts = select.select(rlist, wlist, [], 1)
  File "/usr/lib/python3.8/site-packages/websockify/websockifyserver.py", line 683, in do_SIGTERM
    self.terminate()
  File "/usr/lib/python3.8/site-packages/websockify/websockifyserver.py", line 656, in terminate
    raise self.Terminate()
websockify.websockifyserver.WebSockifyServer.Terminate
s6-svwait: fatal: supervisor died
[s6-finish] sending all processes the TERM signal.
[s6-finish] sending all processes the KILL signal and exiting.

so, unfortunately, it didn’t work. I have also tried the same procedure and just start the openszwave service.

any comments or suggestions are more than welcome! I really do like HA, as long as it works! :smiley:

Installed the Mosquitto broker thru Supervisor, bridged to my local Mosquitto server, and updated OpenZwave to 0.5.2, and now all my devices are showing up :slight_smile:

Changelog:

0.5.2
* Fix startup failure due to stray OZW Daemon status retained in MQTT
* Propagate shutdown OZW Daemon status to upstream MQTT on shutdown
* Update OpenZWave to 6cf3729

I’ve been noticing a lot of lag since updating to 0.5.2. For example, I set a light to 50%, it’ll take 5-10 minutes to dim up to that level and vice versa when turning off. Has anyone else been experiencing the same?

that’s not lag, the default transition time was changed.

Thanks for that clarification, I was driving myself crazy. Hopefully an update is released soon!

Does anyone know when this update will be released? I’m having the issue with all of my NZW30T and NZW31T Inovelli switches.

Slated for 0.114 from what I understand but in the meantime check my post here to use that piping fresh code.

1 Like

Hi all, I have an issue after the last update and I am not able to start the add-on anymore. Maybe some one can turn on a light at the end of the tunnel for me. :blush:
This is the output of the add-on. But it is beyond my knowledge and I don’t know where to start the troubleshooting. Can you please take a look?

[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... 
[14:35:51] INFO: Auth database exists
[cont-init.d] auth.sh: exited 0.
[cont-init.d] mqtt.sh: executing... 
[14:35:54] 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... 
[14:35:55] 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.

Thank you

see here…

10x sender

My supervisor is reporting this after I tried updating:

20-09-17 13:39:42 INFO (SyncWorker_2) [supervisor.docker.interface] Clean addon_core_zwave application
20-09-17 13:39:45 INFO (SyncWorker_2) [supervisor.docker.addon] Start Docker add-on homeassistant/armv7-addon-zwave with version 0.6.0
20-09-17 13:40:15 WARNING (MainThread) [supervisor.misc.tasks] Watchdog found a problem with core_zwave!

And OZW reports:

[15:42:01] 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.

Then trying again

I believe a fix was just pushed for the VNC issue as 0.60, I tried to update, but then failed and 0.60 no longer showing up. However looks like fix is inbound.

after all the tries to get OZW 0.6.0 to work, i gave up and reloaded OZW 0.5.2 from the add-on store and all my devices started working again except the VNC OZW-admin GUI. Starting it opens the background screen with the word “loading” at the top. tried restarting many different ways and times to no avail. Then i hoped the upgrade of HA to 115 would work a miricle. No such luck. Still says “loading”. The web version of OZW-admin works fine just not the embedded GUI . any ideas?