Can’t tell what went wrong in the first place since these aren’t the complete logs. From what is shown, that last logs show there might have been problems talking to the USB stick.
[20200710 13:38:23.533 EDT] [ozw.library] [critical]: Error - Node: 255 ERROR: Dropping command, expected response not received after 1 attempt(s). Command: "FUNC_ID_ZW_GET_VERSION: 0x01, 0x03, 0x00, 0x15, 0xe9"
If you go and look att the mqtt log there is this rows every time you try to start the addon.
1594669113: New connection from 172.30.33.4 on port 1883.
1594669113: New bridge connected from 172.30.33.4 as core-zwave.main-mqtt (p2, c0, k60, u’addons’).
1594669121: Socket error on client core-zwave.main-mqtt, disconnecting.
@freshcoast @ToxicSmasher Checking my MQTT server log, I don’t even see and any core-zwave.main-mqtt attempts. I even in the MQTT integration set it to 1883 and disabled the password requirements on the server. Is it possible the Supervisor installed OpenZwave container can’t connect to a remote MQTT server?
The Zwave Addon talks to an embedded mqtt broker, which is bridged to the MQTT Addon broker.
I think he’s implying he’s not using the MQTT Addon.
Correct, I have another broker not in a container on my HA box, I thought I read that was supported, but I may have misunderstood? I’ve been running an external broker for years, before I had HA so had no reason to move it into HA as a container when I started using HA. I use the MQTT integration to connect to the external broker, maybe that’s where I am failing here?
I don’t use the addon, but at this moment the docs say:
This add-on currently requires to have the Mosquitto add-on installed. Please make sure to install and set up that add-on before continuing.
I had initially started with Get OpenZWave Beta working then looks like very much misread the doc after and took that as the MQTT Integration == the MQTT Addon when I read that, likely my issue, thank you @freshcoast!
You could try installing the Mosquitto Addon, setting HA to use that, and bridge it with your external broker. I think someone posted an example in one of the other OZW threads. Otherwise, standalone Docker is the way to go.
Exactly what I was just thinking, I’ve connected brokers before as bridge to TTN and a couple others, thank you for the help!
This is so strange.
Now in the morning the addon started up without any problems. And i have not made a single change. All settings are as they where when i went to sleep.
This would lead me to believe that there is a scheduled task, whether it’s time based or based on some threshold being met, I don’t know. But some kind of cleanup / garbage collection probably fixed things this time around. It has for me as well. Unfortunately you can’t rely on this fixing your network daily.
I am on the same boat with you guys. Had the OpenZWave Addon running for a good while (even with 0.112.4), but had to reboot my Pi box (due to electricity work) and since the restart the addon has refused to start. Error messages are exactly the same as reported above for both OZW addon as well as the MQTT broker.
Has anyone found a reliable workaround? I can see the now-pulled 0.112.5 contains MQTT fixes, but I would assume these are not related (as this does not seem to be related to Core).
I’m in the same boat the where openzwave addon would constantly quit immediately after starting up. I believe it’s because it’s running a internal mqtt broker and it’s not cleaning the topics up itself. I don’t know enough how to manipulate the internal mqtt broker inside the container.
I just modified the docker-compose file from get opzwave beta working and ran the openzwave container and not use the addon. I just switched to a supervised build of ubuntu so I can run my own docker apps outside of haasio I was using previously
So far so good, openzwave 1.6 container seems to be working well, and home assistant sees all my zwave devices without any issues. I do have to download the ozw-admin on my windows box and run it separately but it actually seems to work better than the vnc plugin.
Unfortunately I might have to go this route as well; I’m using a supervised install on ubuntu and when I use the openzwave and mosquitto addons openzwave will start the first time after install but after I restart it even once it won’t start again unless I uninstall both the openzwave and mosquitto addons and start over. I see Socket error on client core-zwave.main-mqtt from the mosquitto logs and s6-svwait: fatal: supervisor died from the openzwave log (amonst other things). I slapped my openzwave logs below in case someone has another thought on what’s going on here, I knew this was beta so it has some issues; luckily I just moved and haven’t built my zwave network back (that was why I’m testing this)
[20200717 12:00:54.052 MDT] [ozw.mqtt.publisher] [warning]: "{\n \"OpenZWave_Version\": \"1.6.1198\",\n \"OZWDaemon_Version\": \"0.1.0\",\n \"QTOpenZWave_Version\": \"1.2.0\",\n \"QT_Version\": \"5.12.5\",\n \"Status\": \"driverAllNodesQueriedSomeDead\",\n \"TimeStamp\": 1595008562,\n \"ManufacturerSpecificDBReady\": true,\n \"homeID\": 3597181125,\n \"getControllerNodeId\": 1,\n \"getSUCNodeId\": 0,\n \"isPrimaryController\": false,\n \"isBridgeController\": false,\n \"hasExtendedTXStatistics\": false,\n \"getControllerLibraryVersion\": \"Z-Wave 4.54\",\n \"getControllerLibraryType\": \"Static Controller\",\n \"getControllerPath\": \"/dev/serial/by-id/usb-0658_0200-if00\"\n}"
[20200717 12:00:54.053 MDT] [ozw.library] [debug]: Detail - Node: 0 Notification: DriverRemoved
[20200717 12:00:54.053 MDT] [ozw.notifications] [debug]: Notification pvt_driverRemoved 0 Thread: 0x7fe126e37d48
[20200717 12:00:54.053 MDT] [ozw.mqtt.publisher] [debug]: Publishing Event stopped
[20200717 12:00:54.053 MDT] [ozw.mqtt.publisher] [debug]: Publishing Event driverRemoved: 0
[20200717 12:00:54.053 MDT] [ozw.mqtt.publisher] [debug]: Topics: "OpenZWave/1/node/1/"
[20200717 12:00:54.053 MDT] [ozw.mqtt.publisher] [debug]: Removing Stale Topic/Msg: "OpenZWave/1/node/1/"
[20200717 12:00:54.053 MDT] [ozw.mqtt.publisher] [debug]: Topics: "OpenZWave/1/node/1/instance/1/"
[20200717 12:00:54.053 MDT] [ozw.mqtt.publisher] [debug]: Removing Stale Topic/Msg: "OpenZWave/1/node/1/instance/1/"
[20200717 12:00:54.053 MDT] [ozw.mqtt.publisher] [debug]: Topics: "OpenZWave/1/node/1/instance/1/commandclass/112/"
[20200717 12:00:54.053 MDT] [ozw.mqtt.publisher] [debug]: Removing Stale Topic/Msg: "OpenZWave/1/node/1/instance/1/commandclass/112/"
[20200717 12:00:54.053 MDT] [ozw.mqtt.publisher] [debug]: Topics: "OpenZWave/1/node/1/instance/1/commandclass/112/value/22799473140563988/"
[20200717 12:00:54.053 MDT] [ozw.mqtt.publisher] [debug]: Removing Stale Topic/Msg: "OpenZWave/1/node/1/instance/1/commandclass/112/value/22799473140563988/"
[20200717 12:00:54.054 MDT] [ozw.mqtt.publisher] [debug]: Topics: "OpenZWave/1/node/1/instance/1/commandclass/112/value/61924494903345172/"
[20200717 12:00:54.054 MDT] [ozw.mqtt.publisher] [debug]: Removing Stale Topic/Msg: "OpenZWave/1/node/1/instance/1/commandclass/112/value/61924494903345172/"
[20200717 12:00:54.054 MDT] [ozw.mqtt.publisher] [debug]: Topics: "OpenZWave/1/node/1/instance/1/commandclass/112/value/68116944390979604/"
[20200717 12:00:54.054 MDT] [ozw.mqtt.publisher] [debug]: Removing Stale Topic/Msg: "OpenZWave/1/node/1/instance/1/commandclass/112/value/68116944390979604/"
[20200717 12:00:54.054 MDT] [ozw.mqtt.publisher] [debug]: Topics: "OpenZWave/1/node/1/instance/1/commandclass/112/value/68398419367690259/"
[20200717 12:00:54.054 MDT] [ozw.mqtt.publisher] [debug]: Removing Stale Topic/Msg: "OpenZWave/1/node/1/instance/1/commandclass/112/value/68398419367690259/"
[20200717 12:00:54.054 MDT] [ozw.mqtt.publisher] [debug]: Topics: "OpenZWave/1/node/1/instance/1/commandclass/112/value/70931694158086164/"
[20200717 12:00:54.054 MDT] [ozw.mqtt.publisher] [debug]: Removing Stale Topic/Msg: "OpenZWave/1/node/1/instance/1/commandclass/112/value/70931694158086164/"
[20200717 12:00:54.054 MDT] [ozw.mqtt.publisher] [debug]: Topics: "OpenZWave/1/node/1/instance/1/commandclass/112/value/71776119088218131/"
[20200717 12:00:54.054 MDT] [ozw.mqtt.publisher] [debug]: Removing Stale Topic/Msg: "OpenZWave/1/node/1/instance/1/commandclass/112/value/71776119088218131/"
[20200717 12:00:54.054 MDT] [ozw.mqtt.publisher] [debug]: Topics: "OpenZWave/1/node/1/instance/1/commandclass/32/"
[20200717 12:00:54.054 MDT] [ozw.mqtt.publisher] [debug]: Removing Stale Topic/Msg: "OpenZWave/1/node/1/instance/1/commandclass/32/"
[20200717 12:00:54.054 MDT] [ozw.mqtt.publisher] [debug]: Topics: "OpenZWave/1/node/1/instance/1/commandclass/32/value/17301521/"
[20200717 12:00:54.054 MDT] [ozw.mqtt.publisher] [debug]: Removing Stale Topic/Msg: "OpenZWave/1/node/1/instance/1/commandclass/32/value/17301521/"
[20200717 12:00:54.055 MDT] [ozw.mqtt.publisher] [debug]: Topics: "OpenZWave/1/node/1/instance/1/commandclass/32/value/281474994012177/"
[20200717 12:00:54.055 MDT] [ozw.mqtt.publisher] [debug]: Removing Stale Topic/Msg: "OpenZWave/1/node/1/instance/1/commandclass/32/value/281474994012177/"
[20200717 12:00:54.055 MDT] [ozw.mqtt.publisher] [debug]: Topics: "OpenZWave/1/node/1/instance/1/commandclass/32/value/562949970722835/"
[20200717 12:00:54.055 MDT] [ozw.mqtt.publisher] [debug]: Removing Stale Topic/Msg: "OpenZWave/1/node/1/instance/1/commandclass/32/value/562949970722835/"
[20200717 12:00:54.055 MDT] [ozw.library] [debug]: Always - Node: 0 ***************************************************************************
[20200717 12:00:54.055 MDT] [ozw.library] [debug]: Always - Node: 0 ********************* Cumulative Network Statistics *********************
[20200717 12:00:54.055 MDT] [ozw.library] [debug]: Always - Node: 0 *** General
[20200717 12:00:54.055 MDT] [ozw.library] [debug]: Always - Node: 0 Driver run time: . . . 0 days, 0 hours, 0 minutes
[20200717 12:00:54.055 MDT] [ozw.library] [debug]: Always - Node: 0 Frames processed: . . . . . . . . . . . . . . . . . . . . 0
[20200717 12:00:54.055 MDT] [ozw.library] [debug]: Always - Node: 0 Total messages successfully received: . . . . . . . . . . 0
[20200717 12:00:54.055 MDT] [ozw.library] [debug]: Always - Node: 0 Total Messages successfully sent: . . . . . . . . . . . . 0
[20200717 12:00:54.055 MDT] [ozw.library] [debug]: Always - Node: 0 ACKs received from controller: . . . . . . . . . . . . . 0
[20200717 12:00:54.055 MDT] [ozw.library] [debug]: Always - Node: 0 *** Errors
[20200717 12:00:54.055 MDT] [ozw.library] [debug]: Always - Node: 0 Unsolicited messages received while waiting for ACK: . . 0
[20200717 12:00:54.055 MDT] [ozw.library] [debug]: Always - Node: 0 Reads aborted due to timeouts: . . . . . . . . . . . . . 0
[20200717 12:00:54.055 MDT] [ozw.library] [debug]: Always - Node: 0 Bad checksum errors: . . . . . . . . . . . . . . . . . . 0
[20200717 12:00:54.056 MDT] [ozw.library] [debug]: Always - Node: 0 CANs received from controller: . . . . . . . . . . . . . 0
[20200717 12:00:54.056 MDT] [ozw.library] [debug]: Always - Node: 0 NAKs received from controller: . . . . . . . . . . . . . 0
[20200717 12:00:54.056 MDT] [ozw.library] [debug]: Always - Node: 0 Out of frame data flow errors: . . . . . . . . . . . . . 0
[20200717 12:00:54.056 MDT] [ozw.library] [debug]: Always - Node: 0 Messages retransmitted: . . . . . . . . . . . . . . . . . 0
[20200717 12:00:54.056 MDT] [ozw.library] [debug]: Always - Node: 0 Messages dropped and not delivered: . . . . . . . . . . . 0
[20200717 12:00:54.056 MDT] [ozw.library] [debug]: Always - Node: 0 ***************************************************************************
[20200717 12:00:54.056 MDT] [ozw.library] [warning]: Warning - Node: 0 WARNING: Tried to write driver config with no home ID set
[20200717 12:00:54.057 MDT] [ozw.library] [debug]: Detail - Node: 0 WriteMsg Wait Timeout m_currentMsg=00000000
[20200717 12:00:54.074 MDT] [ozw.library] [info]: Info - Node: 0 Lookup for mfs.db.openzwave.com returned 109
[20200717 12:00:54.074 MDT] [ozw.library] [info]: Info - Node: 0 Stopping DNSThread
[12:00:54] INFO: Starting websockify...
[12:00:54] 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
[20200717 12:00:54.688 MDT] [ozwadmin] [info]: OZWCore Initilized QTOpenZwave(0x7f647f63a720) QTOZWManager(0x5637892c55c0)
[20200717 12:00:54.719 MDT] [default] [warning]: QVncServer created on port 5900
[20200717 12:00:54.777 MDT] [ozw.library] [debug]: Debug - Node: 0 Downloads Remaining: 0
[20200717 12:00:54.778 MDT] [ozw.library] [info]: Info - Node: 0 ManufacturerSpecificDB Initialized
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
[20200717 12:00:56.780 MDT] [ozw.library] [info]: Info - Node: 0 mgr, Driver for controller /dev/serial/by-id/usb-0658_0200-if00 removed
[20200717 12:00:56.780 MDT] [ozw.manager] [debug]: Driver Removed for "/dev/serial/by-id/usb-0658_0200-if00"
[20200717 12:00:56.780 MDT] [ozw.manager] [debug]: OZW Serial Port Closed
[20200717 12:00:56.780 MDT] [ozw.daemon] [info]: Shutting Down "ozwdaemon" Version: "0.1.0"
[20200717 12:00:56.780 MDT] [ozw.daemon] [info]: OpenZWave Version: "1.6.1198"
[20200717 12:00:56.780 MDT] [ozw.daemon] [info]: QT-OpenZWave Version: "1.2.0"
[20200717 12:00:56.780 MDT] [ozw.daemon] [info]: QT Version: 5.12.5
[20200717 12:00:56.781 MDT] [ozw.mqtt.publisher] [debug]: Topics: "OpenZWave/1/node/1/instance/1/commandclass/114/"
[20200717 12:00:56.781 MDT] [ozw.mqtt.publisher] [debug]: Removing Stale Topic/Msg: "OpenZWave/1/node/1/instance/1/commandclass/114/"
[20200717 12:00:56.781 MDT] [ozw.mqtt.publisher] [debug]: Topics: "OpenZWave/1/node/1/instance/1/commandclass/114/value/31227923/"
[20200717 12:00:56.781 MDT] [ozw.mqtt.publisher] [debug]: Removing Stale Topic/Msg: "OpenZWave/1/node/1/instance/1/commandclass/114/value/31227923/"
[20200717 12:00:56.782 MDT] [ozw.mqtt.publisher] [debug]: Topics: "OpenZWave/1/node/1/instance/1/commandclass/114/value/281475007938579/"
[20200717 12:00:56.782 MDT] [ozw.mqtt.publisher] [debug]: Removing Stale Topic/Msg: "OpenZWave/1/node/1/instance/1/commandclass/114/value/281475007938579/"
[20200717 12:00:56.782 MDT] [ozw.mqtt.publisher] [debug]: Topics: "OpenZWave/1/node/1/instance/1/commandclass/114/value/562949984649235/"
[20200717 12:00:56.782 MDT] [ozw.mqtt.publisher] [debug]: Removing Stale Topic/Msg: "OpenZWave/1/node/1/instance/1/commandclass/114/value/562949984649235/"
[20200717 12:00:56.782 MDT] [ozw.mqtt.publisher] [debug]: Topics: "OpenZWave/1/node/4/"
[20200717 12:00:56.782 MDT] [ozw.mqtt.publisher] [debug]: Removing Stale Topic/Msg: "OpenZWave/1/node/4/"
1595008856: Client qt-openzwave-1 disconnected.
In exit
[cont-finish.d] executing container finish scripts...
[cont-finish.d] done.
[s6-finish] waiting for services.
s6-svwait: fatal: supervisor died
1595008856: mosquitto version 1.6.8 terminating
1595008856: Saving in-memory database to /data/mosquitto.db.
[s6-finish] sending all processes the TERM signal.
[s6-finish] sending all processes the KILL signal and exiting.
I have the same issue and it is driving me crazy. I get the another ozwdaemon is running error. If I restart the broker, I get the error. I followed one of the post and looked at it in MQTT Explorer. There was a status message hanging out there for Instance 1. I removed it and restart OpenZwave and every came back up.
That screenshot was after restart, but before restart there was just a 1 node and a status.
I’ve tried removing the openzwave status message in my MQTT server and it didn’t matter.
I’m also uploading my full logs. Full logs were obtained by running
docker logs addon_core_zwave > addon_core_zwave.log 2>&1
As you can see it launches an internal MQTT broker.
[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...
[23:04:29] INFO: e[32mAuth database existse[0m
[cont-init.d] auth.sh: exited 0.
[cont-init.d] mqtt.sh: executing...
[23:04:29] INFO: e[32mConnect to internal MqTT servicee[0m
[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.
[23:04:30] INFO: e[32mStarting internal MQTT broker...e[0m
1594965870: mosquitto version 1.6.8 starting
1594965870: Config loaded from /etc/mosquitto.conf.
1594965870: Opening ipv4 listen socket on port 1883.
1594965870: Opening ipv6 listen socket on port 1883.
1594965870: Warning: Mosquitto should not be run as root/administrator.
1594965870: Connecting bridge main-mqtt (core-mosquitto:1883)
[23:04:30] INFO: e[32mStarting OpenZWave...e[0m
1594965870: New connection from 127.0.0.1 on port 1883.
1594965870: Socket error on client <unknown>, disconnecting.
ozw.daemon: Checking "/data/ozw/config" for manufacturer_specific.xml
ozw.daemon: Checking "/data/ozw/config" for options.xml
ozw.daemon: DBPath: "/data/ozw/config/"
ozw.daemon: userPath: "/data/ozw/config/"
ozw.daemon: Network Key Specified in Enviroment is Valid
ozw.daemon: Didn't Find Network Key File. Skipping
ozw.daemon: We Have what appears to be a valid Network Key - Passing to OZW
ozw.daemon: Didn't Find Auth Key File. Skipping
QT_MESSAGE_PATTERN: %{backtrace} is not supported by this Qt build
[20200716 23:04:30.343 PDT] [ozw.manager] [debug]: Database Path: "/data/ozw/config/" User Path "/data/ozw/config/"
[20200716 23:04:30.344 PDT] [ozw.manager] [debug]: Models Created
[20200716 23:04:30.346 PDT] [qt.remoteobjects] [warning]: Tried to register QRemoteObjectRootSource twice "QTOZWLog"
[20200716 23:04:30.346 PDT] [ozw.manager] [debug]: QTOZWManager Ready!
[20200716 23:04:30.346 PDT] [ozw.daemon] [debug]: Ready
[20200716 23:04:30.346 PDT] [ozw.manager] [debug]: QTOZWLog Ready!
[20200716 23:04:30.346 PDT] [ozw.manager] [debug]: QTOZWOptions Ready!
[20200716 23:04:30.346 PDT] [ozw.daemon] [info]: Staring "ozwdaemon" Version: "0.1.0"
[20200716 23:04:30.346 PDT] [ozw.daemon] [info]: OpenZWave Version: "1.6.1198"
[20200716 23:04:30.346 PDT] [ozw.daemon] [info]: QT-OpenZWave Version: "1.2.0"
[20200716 23:04:30.346 PDT] [ozw.daemon] [info]: QT Version: 5.12.5
[20200716 23:04:30.346 PDT] [default] [info]: Docker MQTT_PASSWORD Secret Missing....
[20200716 23:04:30.347 PDT] [default] [info]: Using MQTT_PASSWORD from Enviroment
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "ping"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "open"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "close"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "refreshnodeinfo"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "requestnodestate"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "requestnodedynamic"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "requestconfigparam"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "requestallconfigparam"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "softresetcontroller"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "hardresetcontroller"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "cancelcontrollercommand"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "testnetworknode"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "testnetwork"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "healnetworknode"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "healnetwork"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "addnode"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "removenode"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "removefailednode"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "hasnodefailed"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "requestnodeneighborupdate"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "assignreturnroute"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "deleteallreturnroute"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "sendnodeinformation"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "replacefailednode"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "requestnetworkupdate"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "isnodefailed"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "checklatestconfigfilerevision"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "checklatestmfsrevision"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "downloadlatestconfigfilerevision"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "downloadlatestmfsrevision"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "setvalue"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "getpollinterval"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "setpollinterval"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "syncronisenodeneighbors"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "enablepoll"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "disablepoll"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "refreshvalue"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "addassociation"
[20200716 23:04:30.347 PDT] [ozw.mqtt.commands] [debug]: Registering Command "removeassociation"
[20200716 23:04:30.347 PDT] [ozw.mqtt.publisher] [debug]: MQTT State Change "Connecting"
[20200716 23:04:30.347 PDT] [ozw.mqtt.publisher] [info]: MQTT Client Connecting
1594965870: New connection from 127.0.0.1 on port 1883.
[20200716 23:04:30.349 PDT] [ozw.library] [debug]: Always - Node: 0 OpenZwave Version 1.6-1198-g6c2ca613 Starting Up
[20200716 23:04:30.355 PDT] [ozw.library] [info]: Info - Node: 0 Loading Localization File /data/ozw/config/Localization.xml
[20200716 23:04:30.356 PDT] [ozw.library] [info]: Info - Node: 0 Loaded /data/ozw/config/Localization.xml With Revision 10
[20200716 23:04:30.356 PDT] [ozw.library] [debug]: Always - Node: 0 Using Language Localization
[20200716 23:04:30.358 PDT] [ozw.library] [info]: Info - Node: 0 Loading NotificationCCTypes File /data/ozw/config/NotificationCCTypes.xml
[20200716 23:04:30.358 PDT] [ozw.library] [info]: Info - Node: 0 Loaded /data/ozw/config/NotificationCCTypes.xml With Revision 11
[20200716 23:04:30.359 PDT] [ozw.library] [info]: Info - Node: 0 Loading SensorMultiLevelCCTypes File /data/ozw/config/SensorMultiLevelCCTypes.xml
[20200716 23:04:30.359 PDT] [ozw.library] [info]: Info - Node: 0 Loaded /data/ozw/config/SensorMultiLevelCCTypes.xml With Revision 4
[20200716 23:04:30.359 PDT] [ozw.manager] [debug]: OpenZWave Manager Instance Created
[20200716 23:04:30.359 PDT] [ozw.manager] [debug]: OpenZWave Watcher Registered
[20200716 23:04:30.359 PDT] [ozw.manager] [debug]: Notification Signals Setup
[20200716 23:04:30.359 PDT] [ozw.library] [info]: Info - Node: 0 Setting Up Provided Network Key for Secure Communications
[20200716 23:04:30.368 PDT] [ozw.library] [info]: Info - Node: 0 Manufacturer_Specific.xml file Revision is 109
[23:04:30] INFO: e[32mSuccessfully send discovery information to Home Assistant.e[0m
[23:04:30] INFO: e[32mStarting ozw-admin...e[0m
[20200716 23:04:30.667 PDT] [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
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
[20200716 23:04:30.899 PDT] [ozwadmin] [info]: OZWCore Initilized QTOpenZwave(0x5593fc857680) QTOZWManager(0x5593fc858f20)
[20200716 23:04:30.925 PDT] [ozw.library] [info]: Info - Node: 0 Queuing Lookup on mfs.db.openzwave.com for Node 0
[20200716 23:04:30.926 PDT] [ozw.library] [info]: Info - Node: 0 Opening controller /dev/ttyUSB0
[20200716 23:04:30.926 PDT] [ozw.library] [info]: Info - Node: 0 Trying to open serial port /dev/ttyUSB0 (attempt 1)
[20200716 23:04:30.926 PDT] [ozw.library] [info]: Info - Node: 0 Starting DNSThread
[20200716 23:04:30.926 PDT] [ozw.library] [info]: Info - Node: 0 Timer: thread starting
[20200716 23:04:30.926 PDT] [ozw.library] [debug]: Detail - Node: 0 Timer: waiting with timeout -1 ms
[20200716 23:04:30.926 PDT] [ozw.library] [info]: Info - Node: 0 mgr, Added driver for controller /dev/ttyUSB0
[20200716 23:04:30.926 PDT] [ozw.manager] [debug]: AddDriver Completed
[20200716 23:04:30.926 PDT] [ozw.library] [info]: Info - Node: 0 LookupTxT Checking mfs.db.openzwave.com
[20200716 23:04:30.927 PDT] [ozw.library] [info]: Info - Node: 0 Serial port /dev/ttyUSB0 opened (attempt 1)
[20200716 23:04:30.927 PDT] [ozw.library] [debug]: Detail - Node: 255 Queuing (Command) FUNC_ID_ZW_GET_VERSION: 0x01, 0x03, 0x00, 0x15, 0xe9
1594965870: New client connected from 127.0.0.1 as qt-openzwave-1 (p2, c1, k60, u'ozw').
[20200716 23:04:30.938 PDT] [ozw.mqtt.publisher] [debug]: MQTT State Change "Connected"
[20200716 23:04:30.938 PDT] [ozw.mqtt.publisher] [info]: MQTT Client Connected
[20200716 23:04:30.938 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "addassociation"
[20200716 23:04:30.938 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/addassociation/")
[20200716 23:04:30.938 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "addnode"
[20200716 23:04:30.938 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/addnode/")
[20200716 23:04:30.938 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "assignreturnroute"
[20200716 23:04:30.938 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/assignreturnroute/")
[20200716 23:04:30.938 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "cancelcontrollercommand"
[20200716 23:04:30.938 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/cancelcontrollercommand/")
[20200716 23:04:30.938 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "checklatestconfigfilerevision"
[20200716 23:04:30.938 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/checklatestconfigfilerevision/")
[20200716 23:04:30.938 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "checklatestmfsrevision"
[20200716 23:04:30.938 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/checklatestmfsrevision/")
[20200716 23:04:30.938 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "close"
[20200716 23:04:30.938 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/close/")
[20200716 23:04:30.938 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "deleteallreturnroute"
[20200716 23:04:30.938 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/deleteallreturnroute/")
[20200716 23:04:30.938 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "disablepoll"
[20200716 23:04:30.938 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/disablepoll/")
[20200716 23:04:30.938 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "downloadlatestconfigfilerevision"
[20200716 23:04:30.938 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/downloadlatestconfigfilerevision/")
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "downloadlatestmfsrevision"
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/downloadlatestmfsrevision/")
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "enablepoll"
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/enablepoll/")
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "getpollinterval"
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/getpollinterval/")
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "hardresetcontroller"
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/hardresetcontroller/")
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "hasnodefailed"
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/hasnodefailed/")
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "healnetwork"
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/healnetwork/")
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "healnetworknode"
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/healnetworknode/")
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "isnodefailed"
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/isnodefailed/")
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "open"
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/open/")
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "ping"
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/ping/")
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "refreshnodeinfo"
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/refreshnodeinfo/")
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "refreshvalue"
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/refreshvalue/")
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "removeassociation"
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/removeassociation/")
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "removefailednode"
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/removefailednode/")
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "removenode"
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/removenode/")
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "replacefailednode"
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/replacefailednode/")
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "requestallconfigparam"
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/requestallconfigparam/")
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "requestconfigparam"
[20200716 23:04:30.939 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/requestconfigparam/")
[20200716 23:04:30.940 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "requestnetworkupdate"
[20200716 23:04:30.940 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/requestnetworkupdate/")
[20200716 23:04:30.940 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "requestnodedynamic"
[20200716 23:04:30.940 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/requestnodedynamic/")
[20200716 23:04:30.940 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "requestnodeneighborupdate"
[20200716 23:04:30.940 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/requestnodeneighborupdate/")
[20200716 23:04:30.940 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "requestnodestate"
[20200716 23:04:30.940 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/requestnodestate/")
[20200716 23:04:30.940 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "sendnodeinformation"
[20200716 23:04:30.940 PDT] [ozw.library] [info]: Info - Node: 0 Lookup for mfs.db.openzwave.com returned 109
[20200716 23:04:30.940 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/sendnodeinformation/")
[20200716 23:04:30.940 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "setpollinterval"
[20200716 23:04:30.940 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/setpollinterval/")
[20200716 23:04:30.940 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "setvalue"
[20200716 23:04:30.940 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/setvalue/")
[20200716 23:04:30.940 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "softresetcontroller"
[20200716 23:04:30.940 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/softresetcontroller/")
[20200716 23:04:30.940 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "syncronisenodeneighbors"
[20200716 23:04:30.940 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/syncronisenodeneighbors/")
[20200716 23:04:30.940 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "testnetwork"
[20200716 23:04:30.940 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/testnetwork/")
[20200716 23:04:30.940 PDT] [ozw.mqtt.commands] [debug]: Creating Subscription for "testnetworknode"
[20200716 23:04:30.940 PDT] [ozw.mqtt.commands] [debug]: Subscription Setup for QMqttTopicFilter("OpenZWave/1/command/testnetworknode/")
[20200716 23:04:30.955 PDT] [default] [warning]: QVncServer created on port 5900
[20200716 23:04:30.984 PDT] [ozw.mqtt.publisher] [debug]: Topics: "OpenZWave/1/status/"
[20200716 23:04:30.984 PDT] [ozw.mqtt.publisher] [warning]: Another ozwdaemon is running for Instance 1
[20200716 23:04:30.984 PDT] [ozw.mqtt.publisher] [warning]: If not, please clean up the MQTT Topic: "OpenZWave/1/status/"
[20200716 23:04:30.984 PDT] [ozw.mqtt.publisher] [warning]: "{\n \"OpenZWave_Version\": \"1.6.1198\",\n \"OZWDaemon_Version\": \"0.1.0\",\n \"QTOpenZWave_Version\": \"1.2.0\",\n \"QT_Version\": \"5.12.5\",\n \"Status\": \"driverRemoved\",\n \"TimeStamp\": 1594965721,\n \"homeID\": 0\n}"
[20200716 23:04:30.984 PDT] [ozw.library] [debug]: Detail - Node: 0 Notification: DriverRemoved
[20200716 23:04:30.985 PDT] [ozw.notifications] [debug]: Notification pvt_driverRemoved 0 Thread: 0x7f3e855a7d48
[20200716 23:04:30.985 PDT] [ozw.mqtt.publisher] [debug]: Publishing Event stopped
[20200716 23:04:30.985 PDT] [ozw.mqtt.publisher] [debug]: Publishing Event driverRemoved: 0
[20200716 23:04:30.985 PDT] [ozw.library] [debug]: Always - Node: 0 ***************************************************************************
[20200716 23:04:30.985 PDT] [ozw.library] [debug]: Always - Node: 0 ********************* Cumulative Network Statistics *********************
[20200716 23:04:30.985 PDT] [ozw.library] [debug]: Always - Node: 0 *** General
[20200716 23:04:30.985 PDT] [ozw.library] [debug]: Always - Node: 0 Driver run time: . . . 0 days, 0 hours, 0 minutes
[20200716 23:04:30.985 PDT] [ozw.library] [debug]: Always - Node: 0 Frames processed: . . . . . . . . . . . . . . . . . . . . 0
[20200716 23:04:30.985 PDT] [ozw.library] [debug]: Always - Node: 0 Total messages successfully received: . . . . . . . . . . 0
[20200716 23:04:30.985 PDT] [ozw.library] [debug]: Always - Node: 0 Total Messages successfully sent: . . . . . . . . . . . . 0
[20200716 23:04:30.985 PDT] [ozw.library] [debug]: Always - Node: 0 ACKs received from controller: . . . . . . . . . . . . . 0
[20200716 23:04:30.985 PDT] [ozw.library] [debug]: Always - Node: 0 *** Errors
[20200716 23:04:30.985 PDT] [ozw.library] [debug]: Always - Node: 0 Unsolicited messages received while waiting for ACK: . . 0
[20200716 23:04:30.985 PDT] [ozw.library] [debug]: Always - Node: 0 Reads aborted due to timeouts: . . . . . . . . . . . . . 0
[20200716 23:04:30.985 PDT] [ozw.library] [debug]: Always - Node: 0 Bad checksum errors: . . . . . . . . . . . . . . . . . . 0
[20200716 23:04:30.985 PDT] [ozw.library] [debug]: Always - Node: 0 CANs received from controller: . . . . . . . . . . . . . 0
[20200716 23:04:30.985 PDT] [ozw.library] [debug]: Always - Node: 0 NAKs received from controller: . . . . . . . . . . . . . 0
[20200716 23:04:30.985 PDT] [ozw.library] [debug]: Always - Node: 0 Out of frame data flow errors: . . . . . . . . . . . . . 0
[20200716 23:04:30.985 PDT] [ozw.library] [debug]: Always - Node: 0 Messages retransmitted: . . . . . . . . . . . . . . . . . 0
[20200716 23:04:30.985 PDT] [ozw.library] [debug]: Always - Node: 0 Messages dropped and not delivered: . . . . . . . . . . . 0
[20200716 23:04:30.985 PDT] [ozw.library] [debug]: Always - Node: 0 ***************************************************************************
[20200716 23:04:30.985 PDT] [ozw.library] [warning]: Warning - Node: 0 WARNING: Tried to write driver config with no home ID set
[20200716 23:04:30.986 PDT] [ozw.library] [info]: Info - Node: 0 Stopping DNSThread
[23:04:31] INFO: e[32mStarting websockify...e[0m
[23:04:31] INFO: e[32mStarting ozw-admin...e[0m
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/"
[20200716 23:04:31.394 PDT] [ozw.library] [debug]: Debug - Node: 0 Downloads Remaining: 0
[20200716 23:04:31.394 PDT] [ozw.library] [info]: Info - Node: 0 ManufacturerSpecificDB Initialized
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
[20200716 23:04:31.402 PDT] [ozwadmin] [info]: OZWCore Initilized QTOpenZwave(0x55e0001f37c0) QTOZWManager(0x55e0001f4f20)
[20200716 23:04:31.424 PDT] [default] [warning]: QVncServer created on port 5900
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
[20200716 23:04:33.396 PDT] [ozw.library] [info]: Info - Node: 0 mgr, Driver for controller /dev/ttyUSB0 removed
[20200716 23:04:33.396 PDT] [ozw.manager] [debug]: Driver Removed for "/dev/ttyUSB0"
[20200716 23:04:33.396 PDT] [ozw.manager] [debug]: OZW Serial Port Closed
[20200716 23:04:33.396 PDT] [ozw.daemon] [info]: Shutting Down "ozwdaemon" Version: "0.1.0"
[20200716 23:04:33.396 PDT] [ozw.daemon] [info]: OpenZWave Version: "1.6.1198"
[20200716 23:04:33.396 PDT] [ozw.daemon] [info]: QT-OpenZWave Version: "1.2.0"
[20200716 23:04:33.397 PDT] [ozw.daemon] [info]: QT Version: 5.12.5
1594965873: Client qt-openzwave-1 disconnected.
In exit
[cont-finish.d] executing container finish scripts...
[cont-finish.d] done.
[s6-finish] waiting for services.
s6-svwait: fatal: supervisor died
1594965873: mosquitto version 1.6.8 terminating
1594965873: Saving in-memory database to /data/mosquitto.db.
[s6-finish] sending all processes the TERM signal.
[s6-finish] sending all processes the KILL signal and exiting.
I also tried using MQTT explorer to clear the status, it helped insofar as I don’t have to reinstall mosquitto but it didn’t work to get openzwave working again without reinstalling that so I’m with you on that one. My status would say “driverRemoved” instead of driverReady though too
I think I just fixed the hass openzwave addon for at least my case.
There are two MQTT servers that you need to fix. The first is your MQTT server which is my mosquitto addon. I use MQTT explorer and delete the entire openzwave\1 topic.
The second MQTT server is the internal one in the openzwave container. Since I’m using ubuntu supervised, my open zwave container is located in /usr/share/hassio/addons/data/core_zwave
I just delete the mosquitto.db file using
sudo rm /usr/share/hassio/addons/data/core_zwave/mosquitto.db
Restart the addon and voila it’s working again! There is a bug where it’s not cleaning up the internal mqtt server when the container is shut down.
There’s an issue already filed, you might want to comment on the problem and your workaround there.