OpenZWave stuck on "network starting" all nodes "unavailable"

Configuration
1

I’m at a bit of a loss here, I am running the latest HassOS with the beta OZW integration loaded. It was working for most devices until a couple of hours ago when everything just stopped. All ZWave devices in Hass show “unavailable” in the frontend. When I try to “configure” the integration, all the nodes show, but on the “network” tab it shows “Network Starting Initializing the Z-Wave controller” and nothing is working.

I checked the OZW Add-on, and everything looks normal there. I looked in MQTT and am seeing all the usual traffic. I don’t see any errors in the logs at all.

It’s like the OZW add-on is working properly, but the Integration refuses to fully connect to it.

I have tried:

  • restarting Hass (many many times)
  • restarting the add-on (several times)
  • reloading the integration (a couple of times)
  • rebooting the server (multiple times)
  • deleting the integration and re-adding it (twice)

Nothing is bringing this zwave network back to life.

Ideas??

2

I created an account to say that I have the same problem. my problems started when I upgraded to the latest release (115.2). this sucks. I’m using an aeotec gen 5 dongle. I hope someone can help us out soon!

3

Logs? (I think both of you could benefit from this How to help us help you - or How to ask a good question)

4

have you tried re-installing the zwave addon?

5

@aceindy As I stated in my first post, I re-installed the integration. The add-on is still pumping things out on the MQTT so it seems to be working properly.

@nickrout As I stated in my first post, there are no errors at all in the logs.
If you must see them, here they are:
OpenZWave Add-on log:

[20200922 0:24:44.672 MDT] [ozw.library] [debug]: Detail - Node: 21 Notification: ValueRefreshed CC: COMMAND_CLASS_METER Instance: 2 Index: 2 
[20200922 0:24:44.672 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:44.672 MDT] [ozw.library] [debug]: Detail - Node: 21 Notification: ValueRefreshed CC: COMMAND_CLASS_METER Instance: 2 Index: 256 
[20200922 0:24:44.672 MDT] [ozw.notifications] [debug]: Notification pvt_valueRefreshed:  562950310756386 Thread:  0x7f33ebe4ed48 
[20200922 0:24:44.672 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:44.672 MDT] [ozw.mqtt.publisher] [debug]: Publishing Event valueRefreshed: 562950310756386 
[20200922 0:24:44.673 MDT] [ozw.notifications] [debug]: Notification pvt_valueRefreshed:  72057594395263008 Thread:  0x7f33ebe4ed48 
[20200922 0:24:44.673 MDT] [ozw.mqtt.publisher] [debug]: Publishing Event valueRefreshed: 72057594395263008 
[20200922 0:24:44.765 MDT] [ozw.library] [debug]: Detail - Node: 21   Received: 0x01, 0x18, 0x00, 0x04, 0x00, 0x15, 0x12, 0x60, 0x0d, 0x02, 0x00, 0x32, 0x02, 0x21, 0x74, 0x00, 0x00, 0x0c, 0x08, 0x00, 0x00, 0x00, 0x03, 0x7a, 0xd8, 0x4b 
[20200922 0:24:44.766 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:44.766 MDT] [ozw.library] [info]: Info - Node: 21 Received a MultiChannelEncap from node 21, endpoint 2 for Command Class COMMAND_CLASS_METER 
[20200922 0:24:44.766 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:44.767 MDT] [ozw.library] [info]: Info - Node: 21 Received Meter Report for Electric - W (1) with Units W (2) on Index 2: 3.080 
[20200922 0:24:44.767 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:44.768 MDT] [ozw.library] [debug]: Detail - Node: 21 Value Updated: old value=3.080, new value=3.080, type=decimal 
[20200922 0:24:44.768 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:44.769 MDT] [ozw.library] [debug]: Detail - Node: 21 Changes to this value are not verified 
[20200922 0:24:44.769 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:44.770 MDT] [ozw.library] [debug]: Detail - Node: 21 Value Updated: old value=false, new value=false, type=bool 
[20200922 0:24:44.770 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:44.770 MDT] [ozw.library] [debug]: Detail - Node: 21 Changes to this value are not verified 
[20200922 0:24:44.770 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:44.771 MDT] [ozw.library] [debug]: Detail - Node: 21 Notification: ValueRefreshed CC: COMMAND_CLASS_METER Instance: 3 Index: 2 
[20200922 0:24:44.771 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:44.771 MDT] [ozw.library] [debug]: Detail - Node: 21 Notification: ValueRefreshed CC: COMMAND_CLASS_METER Instance: 3 Index: 256 
[20200922 0:24:44.771 MDT] [ozw.notifications] [debug]: Notification pvt_valueRefreshed:  562950310756402 Thread:  0x7f33ebe4ed48 
[20200922 0:24:44.771 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:44.772 MDT] [ozw.mqtt.publisher] [debug]: Publishing Event valueRefreshed: 562950310756402 
[20200922 0:24:44.772 MDT] [ozw.notifications] [debug]: Notification pvt_valueRefreshed:  72057594395263024 Thread:  0x7f33ebe4ed48 
[20200922 0:24:44.773 MDT] [ozw.mqtt.publisher] [debug]: Publishing Event valueRefreshed: 72057594395263024 
[20200922 0:24:44.879 MDT] [ozw.library] [debug]: Detail - Node: 49   Received: 0x01, 0x07, 0x00, 0x13, 0x15, 0x00, 0x00, 0x19, 0xe7 
[20200922 0:24:44.880 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:44.880 MDT] [ozw.library] [debug]: Detail - Node: 49   ZW_SEND_DATA Request with callback ID 0x15 received (expected 0x15) 
[20200922 0:24:44.880 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:44.881 MDT] [ozw.library] [info]: Info - Node: 49 Request RTT 248 Average Request RTT 188 
[20200922 0:24:44.881 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:44.882 MDT] [ozw.library] [debug]: Detail - Node: 49   Expected callbackId was received 
[20200922 0:24:44.882 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:44.958 MDT] [ozw.library] [debug]: Detail - Node: 49   Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x31, 0x03, 0x25, 0x03, 0x00, 0xe6 
[20200922 0:24:44.958 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:44.959 MDT] [ozw.library] [info]: Info - Node: 49 Response RTT 325 Average Response RTT 283 
[20200922 0:24:44.960 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:44.960 MDT] [ozw.library] [info]: Info - Node: 49 Received SwitchBinary report from node 49: level=Off 
[20200922 0:24:44.960 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:44.961 MDT] [ozw.library] [debug]: Detail - Node: 49 Value Updated: old value=false, new value=false, type=bool 
[20200922 0:24:44.961 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:44.961 MDT] [ozw.library] [debug]: Detail - Node: 49 Changes to this value are not verified 
[20200922 0:24:44.961 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:44.962 MDT] [ozw.library] [debug]: Detail - Node: 49   Expected reply and command class was received 
[20200922 0:24:44.962 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:44.962 MDT] [ozw.library] [debug]: Detail - Node: 49   Message transaction complete 
[20200922 0:24:44.962 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:44.963 MDT] [ozw.library] [debug]: Detail - Node: 49 Removing current message 
[20200922 0:24:44.963 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:44.964 MDT] [ozw.library] [debug]: Detail - Node: 49 Notification: ValueRefreshed CC: COMMAND_CLASS_SWITCH_BINARY Instance: 1 Index: 0 
[20200922 0:24:44.964 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:44.965 MDT] [ozw.notifications] [debug]: Notification pvt_valueRefreshed:  826884112 Thread:  0x7f33ebe4ed48 
[20200922 0:24:44.965 MDT] [ozw.mqtt.publisher] [debug]: Publishing Event valueRefreshed: 826884112 
[20200922 0:24:46.364 MDT] [ozw.mqtt.commands] [debug]: Got  "OpenZWave/1/command/refreshvalue/"  Message:  "{\"ValueIDKey\":575225872}" 
[20200922 0:24:46.364 MDT] [ozw.library] [info]: Info - Node: 0 mgr,     Refreshing node 34: COMMAND_CLASS_SWITCH_BINARY index = 0 instance = 1 (to confirm a reported change) 
[20200922 0:24:46.365 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:46.366 MDT] [ozw.library] [debug]: Detail - Node: 34 Queuing (Send) SwitchBinaryCmd_Get (Node=34): 0x01, 0x09, 0x00, 0x13, 0x22, 0x02, 0x25, 0x02, 0x25, 0x16, 0xd1 
[20200922 0:24:46.366 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:46.366 MDT] [ozw.library] [info]: Info - Node: 34 Sending (Send) message (Callback ID=0x16, Expected Reply=0x04) - SwitchBinaryCmd_Get (Node=34): 0x01, 0x09, 0x00, 0x13, 0x22, 0x02, 0x25, 0x02, 0x25, 0x16, 0xd1 
[20200922 0:24:46.366 MDT] [ozw.mqtt.commands] [info]: Processed Message for  "refreshvalue" :  "{\"ValueIDKey\":575225872}" 
[20200922 0:24:46.366 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:46.367 MDT] [ozw.library] [info]: Info - Node: 34 Encrypted Flag is 0 
[20200922 0:24:46.367 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:46.373 MDT] [ozw.library] [debug]: Detail - Node: 34   Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8 
[20200922 0:24:46.373 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:46.373 MDT] [ozw.library] [debug]: Detail - Node: 34   ZW_SEND_DATA delivered to Z-Wave stack 
[20200922 0:24:46.374 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:46.395 MDT] [ozw.library] [debug]: Detail - Node: 34   Received: 0x01, 0x07, 0x00, 0x13, 0x16, 0x00, 0x00, 0x02, 0xff 
[20200922 0:24:46.395 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:46.396 MDT] [ozw.library] [debug]: Detail - Node: 34   ZW_SEND_DATA Request with callback ID 0x16 received (expected 0x16) 
[20200922 0:24:46.396 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:46.397 MDT] [ozw.library] [info]: Info - Node: 34 Request RTT 28 Average Request RTT 28 
[20200922 0:24:46.397 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:46.397 MDT] [ozw.library] [debug]: Detail - Node: 34   Expected callbackId was received 
[20200922 0:24:46.397 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:46.410 MDT] [ozw.library] [debug]: Detail - Node: 34   Received: 0x01, 0x09, 0x00, 0x04, 0x00, 0x22, 0x03, 0x25, 0x03, 0x00, 0xf5 
[20200922 0:24:46.411 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:46.411 MDT] [ozw.library] [info]: Info - Node: 34 Response RTT 43 Average Response RTT 42 
[20200922 0:24:46.411 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:46.412 MDT] [ozw.library] [info]: Info - Node: 34 Received SwitchBinary report from node 34: level=Off 
[20200922 0:24:46.412 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:46.413 MDT] [ozw.library] [debug]: Detail - Node: 34 Value Updated: old value=false, new value=false, type=bool 
[20200922 0:24:46.413 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:46.413 MDT] [ozw.library] [debug]: Detail - Node: 34 Changes to this value are not verified 
[20200922 0:24:46.413 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:46.414 MDT] [ozw.library] [debug]: Detail - Node: 34   Expected reply and command class was received 
[20200922 0:24:46.414 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:46.415 MDT] [ozw.library] [debug]: Detail - Node: 34   Message transaction complete 
[20200922 0:24:46.415 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:46.415 MDT] [ozw.library] [debug]: Detail - Node: 34 Removing current message 
[20200922 0:24:46.415 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:46.416 MDT] [ozw.library] [debug]: Detail - Node: 34 Notification: ValueRefreshed CC: COMMAND_CLASS_SWITCH_BINARY Instance: 1 Index: 0 
[20200922 0:24:46.416 MDT] [ozw.logging] [debug]: popping Log Mesages 
[20200922 0:24:46.416 MDT] [ozw.notifications] [debug]: Notification pvt_valueRefreshed:  575225872 Thread:  0x7f33ebe4ed48 
[20200922 0:24:46.416 MDT] [ozw.mqtt.publisher] [debug]: Publishing Event valueRefreshed: 575225872

Home Assistant Log

2020-09-21 20:02:01 WARNING (MainThread) [homeassistant.loader] You are using a custom integration for nodered which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant.

No errors. All looks the same as it did when it was working.

6

Suggest you post an issue on github.

7

@ve6rah Sorry, I missed that…