Help my Z-Wave has failed!

jriker1 · April 1, 2020, 1:00pm

OK here’s the deal, Latest version of HA running on Ubuntu 16 in a VMWare Workstation instance on Windows 7 host. Have the Z-Wave stick plugged into the main unit obviously and has been working great. Due to other reasons I upgraded my host to Windows 10. Not overly happy with it in general so far but for HA Z-Wave was working fine. So I tried doing some other things and Windows 10 crashed. Brought HA back up and kept complaining about my mariadb trying to fallback over and over. Z-Wave wouldn’t come up either. So I rolled back to the 28th, Saturday, with a backup and it’s coming up, but Z-Wave still won’t work. Between the 28th and today I didn’t change anything in HA. So basically:

Shows it sees the stick:
homeassistant@homeassistant:/usr/share/hassio/homeassistant$ dmesg | grep cdc
[ 29.936726] cdc_acm 2-2.1:1.0: ttyACM0: USB ACM device
[ 31.385844] usbcore: registered new interface driver cdc_acm
[ 31.385847] cdc_acm: USB Abstract Control Model driver for USB modems and ISDN adapters

So it is there. The stick itself is showing solid red which I know ain’t good.

Here are the OZW_Log.txt logs:

2020-04-01 07:15:11.505 Always, OpenZwave Version 1.4.3469 Starting Up
2020-04-01 07:15:42.379 Info, Setting Up Provided Network Key for Secure Communications
2020-04-01 07:15:42.380 Info, mgr,     Added driver for controller /dev/ttyACM0
2020-04-01 07:15:42.380 Info,   Opening controller /dev/ttyACM0
2020-04-01 07:15:42.382 Info, Trying to open serial port /dev/ttyACM0 (attempt 1)
2020-04-01 07:15:42.577 Info, Serial port /dev/ttyACM0 opened (attempt 1)
2020-04-01 07:15:42.587 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_VERSION: 0x01, 0x03, 0x00, 0x15, 0xe9
2020-04-01 07:15:42.588 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_MEMORY_GET_ID: 0x01, 0x03, 0x00, 0x20, 0xdc
2020-04-01 07:15:42.588 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_CONTROLLER_CAPABILITIES: 0x01, 0x03, 0x00, 0x05, 0xf9
2020-04-01 07:15:42.588 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_GET_CAPABILITIES: 0x01, 0x03, 0x00, 0x07, 0xfb
2020-04-01 07:15:42.588 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_SUC_NODE_ID: 0x01, 0x03, 0x00, 0x56, 0xaa
2020-04-01 07:15:42.605 Detail, Node006,   Received: 0x01, 0x10, 0x00, 0x04, 0x00, 0x06, 0x0a, 0x32, 0x02, 0x21, 0x74, 0x00, 0x00, 0x03, 0x35, 0x00, 0x00, 0xb4
2020-04-01 07:15:42.605 Detail,
2020-04-01 07:15:42.605 Detail,
2020-04-01 07:15:42.605 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x15) - FUNC_ID_ZW_GET_VERSION: 0x01, 0x03, 0x00, 0x15, 0xe9
2020-04-01 07:15:42.608 Detail, Unsolicited message received while waiting for ACK.
2020-04-01 07:15:42.627 Detail, Node005,   Received: 0x01, 0x10, 0x00, 0x04, 0x00, 0x05, 0x0a, 0x32, 0x02, 0x21, 0x74, 0x00, 0x00, 0x03, 0x0f, 0x00, 0x00, 0x8d
2020-04-01 07:15:42.627 Detail,
2020-04-01 07:15:42.631 Detail, contrlr, CAN received...triggering resend
2020-04-01 07:15:42.631 Detail,
2020-04-01 07:15:42.631 Info, contrlr, Sending (Command) message (Attempt 2, Callback ID=0x00, Expected Reply=0x15) - FUNC_ID_ZW_GET_VERSION: 0x01, 0x03, 0x00, 0x15, 0xe9
2020-04-01 07:15:42.667 Detail, contrlr,   Received: 0x01, 0x10, 0x01, 0x15, 0x5a, 0x2d, 0x57, 0x61, 0x76, 0x65, 0x20, 0x34, 0x2e, 0x35, 0x34, 0x00, 0x01, 0x93
2020-04-01 07:15:42.667 Detail,
2020-04-01 07:15:42.667 Info, contrlr, Received reply to FUNC_ID_ZW_GET_VERSION:
2020-04-01 07:15:42.667 Info, contrlr,     Static Controller library, version Z-Wave 4.54
2020-04-01 07:15:42.667 Detail, Node045,   Expected reply was received
2020-04-01 07:15:42.667 Detail, Node045,   Message transaction complete
2020-04-01 07:15:42.667 Detail,
2020-04-01 07:15:42.667 Detail, contrlr, Removing current message
2020-04-01 07:15:42.667 Detail,
2020-04-01 07:15:42.667 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x20) - FUNC_ID_ZW_MEMORY_GET_ID: 0x01, 0x03, 0x00, 0x20, 0xdc
2020-04-01 07:15:42.689 Detail, contrlr,   Received: 0x01, 0x08, 0x01, 0x20, 0xd3, 0xdd, 0xaf, 0x9a, 0x01, 0xec
2020-04-01 07:15:42.689 Detail,
2020-04-01 07:15:42.689 Info, contrlr, Received reply to FUNC_ID_ZW_MEMORY_GET_ID. Home ID = 0xd3ddaf9a.  Our node ID = 1
2020-04-01 07:15:42.689 Detail, Node221,   Expected reply was received
2020-04-01 07:15:42.689 Detail, Node221,   Message transaction complete
2020-04-01 07:15:42.689 Detail,
2020-04-01 07:15:42.690 Detail, contrlr, Removing current message
2020-04-01 07:15:42.690 Detail,
2020-04-01 07:15:42.690 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x05) - FUNC_ID_ZW_GET_CONTROLLER_CAPABILITIES: 0x01, 0x03, 0x00, 0x05, 0xf9
2020-04-01 07:15:42.697 Detail, contrlr,   Received: 0x01, 0x04, 0x01, 0x05, 0x08, 0xf7
2020-04-01 07:15:42.697 Detail,
2020-04-01 07:15:42.697 Info, contrlr, Received reply to FUNC_ID_ZW_GET_CONTROLLER_CAPABILITIES:
2020-04-01 07:15:42.697 Info, contrlr,     There is no SUC ID Server (SIS) in this network.
2020-04-01 07:15:42.697 Info, contrlr,     The PC controller is a primary controller.
2020-04-01 07:15:42.697 Detail, Node247,   Expected reply was received
2020-04-01 07:15:42.697 Detail, Node247,   Message transaction complete
2020-04-01 07:15:42.697 Detail,
2020-04-01 07:15:42.697 Detail, contrlr, Removing current message
2020-04-01 07:15:42.697 Detail,
2020-04-01 07:15:42.697 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x07) - FUNC_ID_SERIAL_API_GET_CAPABILITIES: 0x01, 0x03, 0x00, 0x07, 0xfb
2020-04-01 07:15:42.733 Detail, contrlr,   Received: 0x01, 0x2b, 0x01, 0x07, 0x01, 0x01, 0x00, 0x86, 0x01, 0x01, 0x00, 0x5a, 0xfe, 0x81, 0xff, 0x88, 0x4f, 0x1f, 0x00, 0x00, 0xfb, 0x9f, 0x7d, 0xa0, 0x67, 0x00, 0x00, 0x80, 0x00, 0x80, 0x86, 0x00, 0x00, 0x00, 0xe8, 0x73, 0x00, 0x00, 0x0e, 0x00, 0x00, 0x60, 0x00, 0x00, 0xfb
2020-04-01 07:15:42.733 Detail,
2020-04-01 07:15:42.733 Info, contrlr,  Received reply to FUNC_ID_SERIAL_API_GET_CAPABILITIES
2020-04-01 07:15:42.733 Info, contrlr,     Serial API Version:   1.1
2020-04-01 07:15:42.733 Info, contrlr,     Manufacturer ID:      0x0086
2020-04-01 07:15:42.733 Info, contrlr,     Product Type:         0x0101
2020-04-01 07:15:42.733 Info, contrlr,     Product ID:           0x005a
2020-04-01 07:15:42.733 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_RANDOM: 0x01, 0x04, 0x00, 0x1c, 0x20, 0xc7
2020-04-01 07:15:42.733 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_GET_INIT_DATA: 0x01, 0x03, 0x00, 0x02, 0xfe
2020-04-01 07:15:42.733 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_SET_TIMEOUTS: 0x01, 0x05, 0x00, 0x06, 0x64, 0x0f, 0x97
2020-04-01 07:15:42.734 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_APPL_NODE_INFORMATION: 0x01, 0x07, 0x00, 0x03, 0x01, 0x02, 0x01, 0x00, 0xf9
2020-04-01 07:15:42.734 Detail, Node001,   Expected reply was received
2020-04-01 07:15:42.734 Detail, Node001,   Message transaction complete
2020-04-01 07:15:42.734 Detail,
2020-04-01 07:15:42.734 Detail, contrlr, Removing current message
2020-04-01 07:15:42.734 Detail,
2020-04-01 07:15:42.734 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x56) - FUNC_ID_ZW_GET_SUC_NODE_ID: 0x01, 0x03, 0x00, 0x56, 0xaa
2020-04-01 07:15:42.745 Detail, contrlr,   Received: 0x01, 0x04, 0x01, 0x56, 0x00, 0xac
2020-04-01 07:15:42.745 Detail,
2020-04-01 07:15:42.745 Info, contrlr, Received reply to GET_SUC_NODE_ID.  Node ID = 0
2020-04-01 07:15:42.746 Info, Controller Does not Support SUC - Cannot Setup Controller as SUC Node
2020-04-01 07:15:42.746 Detail, Node172,   Expected reply was received
2020-04-01 07:15:42.746 Detail, Node172,   Message transaction complete
2020-04-01 07:15:42.746 Detail,
2020-04-01 07:15:42.746 Detail, contrlr, Removing current message
2020-04-01 07:15:42.746 Detail,
2020-04-01 07:15:42.747 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x1c) - FUNC_ID_ZW_GET_RANDOM: 0x01, 0x04, 0x00, 0x1c, 0x20, 0xc7
2020-04-01 07:15:52.747 Error, contrlr, ERROR: Dropping command, expected response not received after 1 attempt(s)
2020-04-01 07:15:52.748 Detail, contrlr, Removing current message
2020-04-01 07:15:52.748 Detail, contrlr, Notification: Notification - TimeOut
2020-04-01 07:15:52.751 Detail,
2020-04-01 07:15:52.751 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x02) - FUNC_ID_SERIAL_API_GET_INIT_DATA: 0x01, 0x03, 0x00, 0x02, 0xfe
2020-04-01 07:15:53.752 Error, contrlr, ERROR: Dropping command, expected response not received after 1 attempt(s)
2020-04-01 07:15:53.752 Detail, contrlr, Removing current message
2020-04-01 07:15:53.752 Detail, contrlr, Notification: Notification - TimeOut
2020-04-01 07:15:53.756 Detail,
2020-04-01 07:15:53.756 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x06) - FUNC_ID_SERIAL_API_SET_TIMEOUTS: 0x01, 0x05, 0x00, 0x06, 0x64, 0x0f, 0x97
2020-04-01 07:15:54.756 Error, contrlr, ERROR: Dropping command, expected response not received after 1 attempt(s)
2020-04-01 07:15:54.756 Detail, contrlr, Removing current message
2020-04-01 07:15:54.756 Detail, contrlr, Notification: Notification - TimeOut
2020-04-01 07:15:54.757 Detail,
2020-04-01 07:15:54.757 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x00) - FUNC_ID_SERIAL_API_APPL_NODE_INFORMATION: 0x01, 0x07, 0x00, 0x03, 0x01, 0x02, 0x01, 0x00, 0xf9
2020-04-01 07:15:55.759 Error, contrlr, ERROR: Dropping command, expected response not received after 1 attempt(s)
2020-04-01 07:15:55.759 Detail, contrlr, Removing current message
2020-04-01 07:15:55.759 Detail, contrlr, Notification: Notification - TimeOut

And note this is a Aeon Z-Stick Gen5.

Any help would be appreciated

Thanks.

JR

finity · April 1, 2020, 9:23pm

Maybe the windows crash corrupted the db/files on the z stick.

Do you have a backup of the z stick itself?

jriker1 · April 2, 2020, 12:52pm

Nope. Never could figure out how to do that. I was just now able to fix it but it was weird. So I reverted back to a snapshot from a week ago. Some of my Z-Wave devices came back on but there were massive errors. Then went back to the current version I had during the crash, and things started loading again. Some errors but after a couple reboots it all came back. Now it wasn’t this simple. I reloaded many times and tried a few other things but essential the above is what seemed to have fixed it which makes little sense especially when I reverted and it worked and then went back to the current version and it kept.

finity · April 2, 2020, 2:06pm

the backup software can be downloaded from the aeotec website.

after that it’s fairly straightforward.

jriker1 · April 2, 2020, 2:49pm

OK thanks, though that’s not what apparently my problem ended up being, and not sure what it was in HA that was broke as part of this, but always good to back things up. Without all my HA backups, whatever it was, wouldn’t have been able to fix this. Would have then proceeded to cry and decide if I want to redo all my Z-Wave things.