So I did all this and removed the integration and started over… now amazingly door sensors and motion sensors that previously had to be “manually” added with template sensors because they were unknown devices were recognized and automatically had the proper binary_sensors they needed… my garage door opener on the other hand is still being ridiculous… I think I’ve accepted that it’s possibly just dead… I just don’t understand how it paired immediately the first time with the cover entity and everything and now it’s being so difficult… but an embarrassing thing I just noticed in the process of bringing it in the house to pair it again is that the sticker on the back actually says it’s a GD00Z-5 not a 4… it was listed as a 4 in HA and I just assumed that’s actually what it was… so I don’t know if that’s been the source of my problem… is that 5 is the reason it’s not working? Thanks everyone for all the help… I am pretty happy my other devices are properly identified now… should I give up on the opener?
I would never give up 
Tinkering is the adventure.
Sorry if you mentioned before, but what are you using for a Z-wave controller?
One though just occurred to me, check the OZW_Log for the Command Class not being supported.
Yeah that’s in there
Unhandled Command Class 0x66
That tells me the wrong version of openzwave is in your system. Once that’s fixed you’ll have the cover again.
Did you apt-get purge <zwavepackages...> that @freshcoast recommended?
Yes I did… but not in the VENV correct ? Yes I removed libopenzwave1.5 and 1.5-dev (spelling maybe be wrong)
**Just ran list again… comes up blank
I had saw some of the old posts where you had mentioned the dev branch and the script to fix it but after trying to summarize the posts it seemed that was no longer necessary… also I have 2 Schlage locks and read something from @ptdalen saying it changed how it handled the user codes in the dev branch. Is this still the case (I had both working together at one point)
Try reinstalling the homeassistant-pyozw using the --no-cache pip flag
(homeassistant) homeassistant@hassnuc:~$ pip3 install homeassistant-pyozw --no-cache
Requirement already satisfied: homeassistant-pyozw in /srv/homeassistant/lib/python3.7/site-packages (0.1.4)
Requirement already satisfied: six in /srv/homeassistant/lib/python3.7/site-packages (from homeassistant-pyozw) (1.12.0)
Requirement already satisfied: PyDispatcher>=2.0.5 in /srv/homeassistant/lib/python3.7/site-packages (from homeassistant-pyozw) (2.0.5)
You are using pip version 19.0.3, however version 19.2.1 is available.
You should consider upgrading via the 'pip install --upgrade pip' command.Nah you gotta use this:
pip3 install --upgrade --force-reinstall --no-cache-dir homeassistant-pyozw
Ok that’s installing… (setup.py seems to take a minute…) is there anything I’ll need to do afterwards to “refresh” the device config?
just load HA up and cross your fingers you don’t get the Unhandled Command Class 0x66 
… and there is the missing cover entity!!! You are the best! Thanks guys for all your patience…
… now just gotta move it back outside and hope it works!
Edit: All good! Thanks again!!
@Bartem So just to explain what happened, the libopenzwave1.5-dev that was installed stopped the homeassistant-pyozw package from compiling the openzwave library it uses (which has the patches already applied for the GDO and a few various other fixes) because it had already seen the library existing it didn’t compile a new library.
After you removed the zwave packages via apt, a new library needed to be compiled, and that’s what we did via the pip command 
Thank you so much again!! It had really been frustrating the heck out of me… I dunno how I messed that up in the first place
If anyone could help that would be greatly appreciated!
I’ve read all through this thread and I still cant get the entities to show up. All I ever get is one binary sensor entity. I’ve tried what others have suggested. Removed device. Rebooted machine. Factory reset linear. Secure added. Refreshed. Healed node. Refreshed again. Still nothing.
I do have other devices on my zwave network that are working I currently have the linear controller about 3 feet away from the aeotec z-stick.
Any suggestions on where I can start looking?
This is the log from adding the device. Notice the “Network key not set”. But the network key IS set in my configuration.yaml.
2019-07-29 17:59:49.046 Info, contrlr, FUNC_ID_ZW_ADD_NODE_TO_NETWORK:
2019-07-29 17:59:49.046 Info, contrlr, ADD_NODE_STATUS_DONE
2019-07-29 17:59:49.046 Info, Node009, Network Key Not Set - Secure Option is required
2019-07-29 17:59:49.118 Info, Node009, Basic device class (0x04) - Routing Slave
2019-07-29 17:59:49.118 Info, Node009, Generic device Class (0x40) - Entry Control
2019-07-29 17:59:49.118 Info, Node009, Specific device class (0x07) - Secure Barrier AddOn
2019-07-29 17:59:49.118 Info, Node009, COMMAND_CLASS_BASIC is not mapped
2019-07-29 17:59:49.119 Info, Node009, Mandatory Command Classes for Node 9:
2019-07-29 17:59:49.119 Info, Node009, COMMAND_CLASS_BASIC
2019-07-29 17:59:49.119 Info, Node009, Mandatory Command Classes controlled by Node 9:
2019-07-29 17:59:49.119 Info, Node009, None
2019-07-29 17:59:49.119 Info, Node009, Optional command classes for node 9:
2019-07-29 17:59:49.119 Info, Node009, COMMAND_CLASS_ZWAVEPLUS_INFO
2019-07-29 17:59:49.119 Info, Node009, COMMAND_CLASS_DEVICE_RESET_LOCALLY
2019-07-29 17:59:49.119 Info, Node009, COMMAND_CLASS_MANUFACTURER_SPECIFIC
2019-07-29 17:59:49.119 Info, Node009, COMMAND_CLASS_POWERLEVEL
2019-07-29 17:59:49.119 Info, Node009, COMMAND_CLASS_SECURITY (Disabled - Network Key Not Set)
2019-07-29 17:59:49.119 Info, Node009, Initializing Node. New Node: true (true)
2019-07-29 17:59:49.120 Detail, Node006, Expected reply was received
2019-07-29 17:59:49.120 Detail, Node006, Message transaction complete
2019-07-29 17:59:49.120 Detail,
2019-07-29 17:59:49.120 Detail, contrlr, Removing current message
2019-07-29 17:59:49.120 Detail, Node009, Notification: NodeAdded
2019-07-29 17:59:49.124 Detail, Node009, Notification: NodeProtocolInfo
2019-07-29 17:59:49.125 Detail, Node009, Notification: ValueAdded
2019-07-29 17:59:49.126 Detail, Node009, Notification: ValueAdded
2019-07-29 17:59:49.128 Detail, Node009, Notification: ValueAdded
2019-07-29 17:59:49.129 Detail, Node009, Notification: ValueAdded
2019-07-29 17:59:49.130 Detail, Node009, Notification: ValueAdded
2019-07-29 17:59:49.132 Detail, Node009, Notification: ValueAdded
2019-07-29 17:59:49.133 Detail, Node009, Notification: ValueAdded
2019-07-29 17:59:49.134 Detail, Node009, Notification: ValueAdded
2019-07-29 17:59:49.136 Detail, Node009, Notification: ValueAdded
2019-07-29 17:59:49.137 Detail, Node009, Notification: ValueAdded
2019-07-29 17:59:49.138 Detail, Node009, Notification: ValueAdded
2019-07-29 17:59:49.140 Detail, Node009, Notification: ValueAdded
2019-07-29 17:59:49.141 Detail, Node009, Notification: ValueAdded
2019-07-29 17:59:49.142 Detail, Node009, Notification: ValueAdded
2019-07-29 17:59:49.144 Detail, Notification: ControllerCommand - Completed
Looks like I may have gotten it to work. I found another thread about the network key and how someone added it to the .storage/core.config_entries instead of the configuration.yaml file. Once I did that I was able to delete the node and then secure-add it again. This time without the security key warning. I now have the cover entity and several other sensor entities.
Now to actually hook it up and test it.
So, I’m having a similar issue as dfortier. I have the Node added just fine, but, I only see one “Binary sensor” under entities:
I’ve done many Heal Node, Refresh Node, Heal Network, reboots, etc. but I never get more than the one entity. Last night I completely removed the NGDZ00-4 and did another “Secure Add”.
Here’s the logs from my latest Refresh/Heal:
2019-08-01 12:22:50.241 Detail, Node010, AdvanceQueries queryPending=0 queryRetries=0 queryStage=ProtocolInfo live=1
2019-08-01 12:22:50.242 Detail, Node010, QueryStage_Probe
2019-08-01 12:22:50.242 Info, Node010, NoOperation::Set - Routing=true
2019-08-01 12:22:50.242 Detail, Node010, Queuing (NoOp) NoOperation_Set (Node=10): 0x01, 0x09, 0x00, 0x13, 0x0a, 0x02, 0x00, 0x00, 0x25, 0x35, 0xfd
2019-08-01 12:22:50.242 Detail, Node010, Queuing (Query) Query Stage Complete (Probe)
2019-08-01 12:22:50.242 Detail,
2019-08-01 12:22:50.242 Info, Node010, Sending (NoOp) message (Callback ID=0x35, Expected Reply=0x13) - NoOperation_Set (Node=10): 0x01, 0x09, 0x00, 0x13, 0x0a, 0x02, 0x00, 0x00, 0x25, 0x35, 0xfd
2019-08-01 12:22:50.250 Detail, Node010, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2019-08-01 12:22:50.251 Detail, Node010, ZW_SEND_DATA delivered to Z-Wave stack
2019-08-01 12:22:50.347 Detail, Node010, Received: 0x01, 0x07, 0x00, 0x13, 0x35, 0x00, 0x00, 0x0a, 0xd4
2019-08-01 12:22:50.347 Detail, Node010, ZW_SEND_DATA Request with callback ID 0x35 received (expected 0x35)
2019-08-01 12:22:50.347 Info, Node010, Request RTT 104 Average Request RTT 101
2019-08-01 12:22:50.347 Detail, Expected callbackId was received
2019-08-01 12:22:50.347 Detail, Expected reply was received
2019-08-01 12:22:50.347 Detail, Message transaction complete
2019-08-01 12:22:50.347 Detail,
2019-08-01 12:22:50.348 Detail, Node010, Removing current message
2019-08-01 12:22:50.348 Detail, Node010, Notification: Notification - NoOperation
2019-08-01 12:22:50.352 Detail, Node010, Query Stage Complete (Probe)
2019-08-01 12:22:50.352 Detail, Node010, AdvanceQueries queryPending=0 queryRetries=0 queryStage=WakeUp live=1
2019-08-01 12:22:50.352 Detail, Node010, QueryStage_WakeUp
2019-08-01 12:22:50.352 Detail, Node010, QueryStage_ManufacturerSpecific1
2019-08-01 12:22:50.353 Detail, Node010, Checking for ManufacturerSpecific CC and Requesting values if present on this node
2019-08-01 12:22:50.353 Detail, Node010, Queuing (Query) ManufacturerSpecificCmd_Get (Node=10): 0x01, 0x09, 0x00, 0x13, 0x0a, 0x02, 0x72, 0x04, 0x25, 0x36, 0x88
2019-08-01 12:22:50.353 Detail, Node010, Queuing (Query) Query Stage Complete (ManufacturerSpecific1)
2019-08-01 12:22:50.353 Detail,
2019-08-01 12:22:50.353 Info, Node010, Sending (Query) message (Callback ID=0x36, Expected Reply=0x04) - ManufacturerSpecificCmd_Get (Node=10): 0x01, 0x09, 0x00, 0x13, 0x0a, 0x02, 0x72, 0x04, 0x25, 0x36, 0x88
2019-08-01 12:22:50.361 Detail, Node010, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2019-08-01 12:22:50.361 Detail, Node010, ZW_SEND_DATA delivered to Z-Wave stack
2019-08-01 12:22:50.420 Detail, Node010, Received: 0x01, 0x07, 0x00, 0x13, 0x36, 0x00, 0x00, 0x06, 0xdb
2019-08-01 12:22:50.420 Detail, Node010, ZW_SEND_DATA Request with callback ID 0x36 received (expected 0x36)
2019-08-01 12:22:50.420 Info, Node010, Request RTT 67 Average Request RTT 84
2019-08-01 12:22:50.421 Detail, Expected callbackId was received
2019-08-01 12:22:50.507 Detail, Node010, Received: 0x01, 0x0e, 0x00, 0x04, 0x00, 0x0a, 0x08, 0x72, 0x05, 0x01, 0x4f, 0x47, 0x44, 0x35, 0x30, 0xc8
2019-08-01 12:22:50.507 Detail,
2019-08-01 12:22:50.507 Info, Node010, Response RTT 153 Average Response RTT 180
2019-08-01 12:22:50.612 Info, Product name collision: FGR223 Roller Shutter Controller 3 type 303 id 1000 manufacturerid 10f, collides with FGRM223 Roller Shutter Controller 3, type 303 id 1000 manufacturerid 10f
2019-08-01 12:22:50.624 Info, Node010, Received manufacturer specific report from node 10: Manufacturer=Linear (Nortek Security Control LLC), Product=GD00Z-4 Garage Door Opener Remote Controller
2019-08-01 12:22:50.624 Info, Node010, Node Identity Codes: 014f:4744:3530
2019-08-01 12:22:50.624 Detail, Node010, Expected reply and command class was received
2019-08-01 12:22:50.624 Detail, Node010, Message transaction complete
2019-08-01 12:22:50.625 Detail,
2019-08-01 12:22:50.625 Detail, Node010, Removing current message
2019-08-01 12:22:50.625 Detail, Node010, Notification: NodeNaming
2019-08-01 12:22:50.629 Detail, Node010, Query Stage Complete (ManufacturerSpecific1)
2019-08-01 12:22:50.629 Detail, Node010, AdvanceQueries queryPending=0 queryRetries=0 queryStage=NodeInfo live=1
2019-08-01 12:22:50.629 Detail, Node010, QueryStage_NodePlusInfo
2019-08-01 12:22:50.633 Detail, Node010, Queuing (Query) ZWavePlusInfoCmd_Get (Node=10): 0x01, 0x09, 0x00, 0x13, 0x0a, 0x02, 0x5e, 0x01, 0x25, 0x37, 0xa0
2019-08-01 12:22:50.633 Detail, Node010, Queuing (Query) Query Stage Complete (NodePlusInfo)
2019-08-01 12:22:50.633 Detail,
2019-08-01 12:22:50.633 Info, Node010, Sending (Query) message (Callback ID=0x37, Expected Reply=0x04) - ZWavePlusInfoCmd_Get (Node=10): 0x01, 0x09, 0x00, 0x13, 0x0a, 0x02, 0x5e, 0x01, 0x25, 0x37, 0xa0
2019-08-01 12:22:50.642 Detail, Node010, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2019-08-01 12:22:50.642 Detail, Node010, ZW_SEND_DATA delivered to Z-Wave stack
2019-08-01 12:22:50.696 Detail, Node010, Received: 0x01, 0x07, 0x00, 0x13, 0x37, 0x00, 0x00, 0x06, 0xda
2019-08-01 12:22:50.696 Detail, Node010, ZW_SEND_DATA Request with callback ID 0x37 received (expected 0x37)
2019-08-01 12:22:50.696 Info, Node010, Request RTT 62 Average Request RTT 73
2019-08-01 12:22:50.696 Detail, Expected callbackId was received
2019-08-01 12:22:50.777 Detail, Node010, Received: 0x01, 0x0f, 0x00, 0x04, 0x00, 0x0a, 0x09, 0x5e, 0x02, 0x01, 0x05, 0x00, 0x0c, 0x06, 0x0c, 0x06, 0xaf
2019-08-01 12:22:50.777 Detail,
2019-08-01 12:22:50.778 Info, Node010, Response RTT 144 Average Response RTT 162
2019-08-01 12:22:50.778 Detail, Node010, Initial read of value
2019-08-01 12:22:50.778 Detail, Node010, Initial read of value
2019-08-01 12:22:50.778 Detail, Node010, Initial read of value
2019-08-01 12:22:50.778 Detail, Node010, Expected reply and command class was received
2019-08-01 12:22:50.778 Detail, Node010, Message transaction complete
2019-08-01 12:22:50.778 Detail,
2019-08-01 12:22:50.778 Detail, Node010, Removing current message
2019-08-01 12:22:50.778 Detail, Node010, Notification: ValueChanged
2019-08-01 12:22:50.781 Detail, Node010, Notification: ValueChanged
2019-08-01 12:22:50.784 Detail, Node010, Notification: ValueChanged
2019-08-01 12:22:50.787 Detail, Node010, Query Stage Complete (NodePlusInfo)
2019-08-01 12:22:50.787 Detail, Node010, AdvanceQueries queryPending=0 queryRetries=0 queryStage=SecurityReport live=1
2019-08-01 12:22:50.787 Detail, Node010, QueryStage_SecurityReport
2019-08-01 12:22:50.787 Detail, Node010, QueryStage_Versions
2019-08-01 12:22:50.787 Info, Node010, Requesting Versions
2019-08-01 12:22:50.787 Info, Node010, Requesting Versions for COMMAND_CLASS_NO_OPERATION
2019-08-01 12:22:50.787 Info, Node010, Requesting Versions for COMMAND_CLASS_BASIC
2019-08-01 12:22:50.787 Info, Node010, Requesting Versions for COMMAND_CLASS_SENSOR_BINARY
2019-08-01 12:22:50.788 Info, Node010, Requesting Versions for COMMAND_CLASS_DEVICE_RESET_LOCALLY
2019-08-01 12:22:50.788 Info, Node010, Requesting Versions for COMMAND_CLASS_ZWAVEPLUS_INFO
2019-08-01 12:22:50.788 Info, Node010, Requesting Versions for COMMAND_CLASS_MANUFACTURER_SPECIFIC
2019-08-01 12:22:50.788 Info, Node010, Requesting Versions for COMMAND_CLASS_POWERLEVEL
2019-08-01 12:22:50.788 Info, Node010, Requesting Versions for COMMAND_CLASS_ASSOCIATION
2019-08-01 12:22:50.788 Info, Node010, Requesting Versions for COMMAND_CLASS_VERSION
2019-08-01 12:22:50.788 Detail, Node010, QueryStage_Instances
2019-08-01 12:22:50.788 Info, Node010, Essential node queries are complete
2019-08-01 12:22:50.788 Detail, Node010, QueryStage_Static
2019-08-01 12:22:50.788 Detail, Node010, Queuing (Query) AssociationCmd_GroupingsGet (Node=10): 0x01, 0x09, 0x00, 0x13, 0x0a, 0x02, 0x85, 0x05, 0x25, 0x38, 0x70
2019-08-01 12:22:50.788 Detail, Node010, Queuing (Query) VersionCmd_Get (Node=10): 0x01, 0x09, 0x00, 0x13, 0x0a, 0x02, 0x86, 0x11, 0x25, 0x39, 0x66
2019-08-01 12:22:50.788 Detail, Node010, Queuing (Query) Query Stage Complete (Static)
2019-08-01 12:22:50.788 Detail, Node010, Notification: EssentialNodeQueriesComplete
2019-08-01 12:22:50.788 Detail,
2019-08-01 12:22:50.788 Info, Node010, Sending (Query) message (Callback ID=0x38, Expected Reply=0x04) - AssociationCmd_GroupingsGet (Node=10): 0x01, 0x09, 0x00, 0x13, 0x0a, 0x02, 0x85, 0x05, 0x25, 0x38, 0x70
2019-08-01 12:22:50.796 Detail, Node010, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2019-08-01 12:22:50.796 Detail, Node010, ZW_SEND_DATA delivered to Z-Wave stack
2019-08-01 12:22:50.903 Detail, Node010, Received: 0x01, 0x07, 0x00, 0x13, 0x38, 0x00, 0x00, 0x0c, 0xdf
2019-08-01 12:22:50.903 Detail, Node010, ZW_SEND_DATA Request with callback ID 0x38 received (expected 0x38)
2019-08-01 12:22:50.903 Info, Node010, Request RTT 114 Average Request RTT 93
2019-08-01 12:22:50.903 Detail, Expected callbackId was received
2019-08-01 12:23:00.790 Error, Node010, ERROR: Dropping command, expected response not received after 1 attempt(s)
2019-08-01 12:23:00.790 Detail, Node010, Removing current message
2019-08-01 12:23:00.790 Detail, Node010, Notification: Notification - TimeOut
2019-08-01 12:23:00.794 Detail,
2019-08-01 12:23:00.794 Info, Node010, Sending (Query) message (Callback ID=0x39, Expected Reply=0x04) - VersionCmd_Get (Node=10): 0x01, 0x09, 0x00, 0x13, 0x0a, 0x02, 0x86, 0x11, 0x25, 0x39, 0x66
2019-08-01 12:23:00.802 Detail, Node010, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2019-08-01 12:23:00.802 Detail, Node010, ZW_SEND_DATA delivered to Z-Wave stack
2019-08-01 12:23:00.855 Detail, Node010, Received: 0x01, 0x07, 0x00, 0x13, 0x39, 0x00, 0x00, 0x06, 0xd4
2019-08-01 12:23:00.855 Detail, Node010, ZW_SEND_DATA Request with callback ID 0x39 received (expected 0x39)
2019-08-01 12:23:00.855 Info, Node010, Request RTT 60 Average Request RTT 76
2019-08-01 12:23:00.855 Detail, Expected callbackId was received
2019-08-01 12:23:10.795 Error, Node010, ERROR: Dropping command, expected response not received after 1 attempt(s)
2019-08-01 12:23:10.795 Detail, Node010, Removing current message
2019-08-01 12:23:10.796 Detail, Node010, Notification: Notification - TimeOut
2019-08-01 12:23:10.800 Detail, Node010, Query Stage Complete (Static)
2019-08-01 12:23:10.800 Detail, Node010, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Associations live=1
2019-08-01 12:23:10.800 Detail, Node010, QueryStage_Associations
2019-08-01 12:23:10.800 Info, Node010, Number of association groups reported for node 10 is 0.
2019-08-01 12:23:10.800 Info, Node010, Get Associations for group 1 of node 10
2019-08-01 12:23:10.800 Detail, Node010, Queuing (Send) AssociationCmd_Get (Node=10): 0x01, 0x0a, 0x00, 0x13, 0x0a, 0x03, 0x85, 0x02, 0x01, 0x25, 0x3a, 0x76
2019-08-01 12:23:10.800 Detail, Node010, Queuing (Query) Query Stage Complete (Associations)
2019-08-01 12:23:10.800 Detail,
2019-08-01 12:23:10.801 Info, Node010, Sending (Send) message (Callback ID=0x3a, Expected Reply=0x04) - AssociationCmd_Get (Node=10): 0x01, 0x0a, 0x00, 0x13, 0x0a, 0x03, 0x85, 0x02, 0x01, 0x25, 0x3a, 0x76
2019-08-01 12:23:10.808 Detail, Node010, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2019-08-01 12:23:10.809 Detail, Node010, ZW_SEND_DATA delivered to Z-Wave stack
2019-08-01 12:23:10.861 Detail, Node010, Received: 0x01, 0x07, 0x00, 0x13, 0x3a, 0x00, 0x00, 0x05, 0xd4
2019-08-01 12:23:10.861 Detail, Node010, ZW_SEND_DATA Request with callback ID 0x3a received (expected 0x3a)
2019-08-01 12:23:10.861 Info, Node010, Request RTT 60 Average Request RTT 68
2019-08-01 12:23:10.861 Detail, Expected callbackId was received
2019-08-01 12:23:20.802 Error, Node010, ERROR: Dropping command, expected response not received after 1 attempt(s)
2019-08-01 12:23:20.802 Detail, Node010, Removing current message
2019-08-01 12:23:20.802 Detail, Node010, Notification: Notification - TimeOut
2019-08-01 12:23:20.806 Detail, Node010, Query Stage Complete (Associations)
2019-08-01 12:23:20.806 Detail, Node010, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Neighbors live=1
2019-08-01 12:23:20.806 Detail, Node010, QueryStage_Neighbors
2019-08-01 12:23:20.806 Detail, Requesting routing info (neighbor list) for Node 10
2019-08-01 12:23:20.806 Detail, Node010, Queuing (Command) Get Routing Info (Node=10): 0x01, 0x07, 0x00, 0x80, 0x0a, 0x00, 0x00, 0x03, 0x71
2019-08-01 12:23:20.806 Detail, Node010, Queuing (Query) Query Stage Complete (Neighbors)
2019-08-01 12:23:20.807 Detail,
2019-08-01 12:23:20.807 Info, Node010, Sending (Command) message (Callback ID=0x00, Expected Reply=0x80) - Get Routing Info (Node=10): 0x01, 0x07, 0x00, 0x80, 0x0a, 0x00, 0x00, 0x03, 0x71
2019-08-01 12:23:20.811 Detail, Node010, Received: 0x01, 0x20, 0x01, 0x80, 0xe6, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0xb8
2019-08-01 12:23:20.812 Detail,
2019-08-01 12:23:20.812 Info, Node010, Received reply to FUNC_ID_ZW_GET_ROUTING_INFO
2019-08-01 12:23:20.812 Info, Node010, Neighbors of this node are:
2019-08-01 12:23:20.812 Info, Node010, Node 2
2019-08-01 12:23:20.812 Info, Node010, Node 3
2019-08-01 12:23:20.812 Info, Node010, Node 6
2019-08-01 12:23:20.812 Info, Node010, Node 7
2019-08-01 12:23:20.812 Info, Node010, Node 8
2019-08-01 12:23:20.812 Detail, Expected reply was received
2019-08-01 12:23:20.812 Detail, Message transaction complete
2019-08-01 12:23:20.812 Detail,
2019-08-01 12:23:20.812 Detail, Node010, Removing current message
2019-08-01 12:23:20.813 Detail, Node010, Query Stage Complete (Neighbors)
2019-08-01 12:23:20.813 Detail, Node010, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Session live=1
2019-08-01 12:23:20.813 Detail, Node010, QueryStage_Session
2019-08-01 12:23:20.813 Detail, Node010, Queuing (Query) PowerlevelCmd_Get (Node=10): 0x01, 0x09, 0x00, 0x13, 0x0a, 0x02, 0x73, 0x02, 0x25, 0x3b, 0x82
2019-08-01 12:23:20.813 Detail, Node010, Queuing (Query) Query Stage Complete (Session)
2019-08-01 12:23:20.813 Detail,
2019-08-01 12:23:20.813 Info, Node010, Sending (Query) message (Callback ID=0x3b, Expected Reply=0x04) - PowerlevelCmd_Get (Node=10): 0x01, 0x09, 0x00, 0x13, 0x0a, 0x02, 0x73, 0x02, 0x25, 0x3b, 0x82
2019-08-01 12:23:20.822 Detail, Node010, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2019-08-01 12:23:20.822 Detail, Node010, ZW_SEND_DATA delivered to Z-Wave stack
2019-08-01 12:23:20.876 Detail, Node010, Received: 0x01, 0x07, 0x00, 0x13, 0x3b, 0x00, 0x00, 0x06, 0xd6
2019-08-01 12:23:20.876 Detail, Node010, ZW_SEND_DATA Request with callback ID 0x3b received (expected 0x3b)
2019-08-01 12:23:20.876 Info, Node010, Request RTT 62 Average Request RTT 65
2019-08-01 12:23:20.876 Detail, Expected callbackId was received
2019-08-01 12:23:20.955 Detail, Node010, Received: 0x01, 0x0a, 0x00, 0x04, 0x00, 0x0a, 0x04, 0x73, 0x03, 0x00, 0x00, 0x8f
2019-08-01 12:23:20.955 Detail,
2019-08-01 12:23:20.955 Info, Node010, Response RTT 141 Average Response RTT 151
2019-08-01 12:23:20.955 Info, Node010, Received a PowerLevel report: PowerLevel=Normal, Timeout=0
2019-08-01 12:23:20.955 Detail, Node010, Refreshed Value: old value=0, new value=0, type=list
2019-08-01 12:23:20.955 Detail, Node010, Changes to this value are not verified
2019-08-01 12:23:20.955 Detail, Node010, Refreshed Value: old value=0, new value=0, type=byte
2019-08-01 12:23:20.955 Detail, Node010, Changes to this value are not verified
2019-08-01 12:23:20.956 Detail, Node010, Expected reply and command class was received
2019-08-01 12:23:20.956 Detail, Node010, Message transaction complete
2019-08-01 12:23:20.956 Detail,
2019-08-01 12:23:20.956 Detail, Node010, Removing current message
2019-08-01 12:23:20.956 Detail, Node010, Notification: ValueChanged
2019-08-01 12:23:20.962 Detail, Node010, Notification: ValueChanged
2019-08-01 12:23:20.968 Detail, Node010, Query Stage Complete (Session)
2019-08-01 12:23:20.968 Detail, Node010, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Dynamic live=1
2019-08-01 12:23:20.968 Detail, Node010, QueryStage_Dynamic
2019-08-01 12:23:20.968 Detail, Node010, Queuing (Send) BasicCmd_Get (Node=10): 0x01, 0x09, 0x00, 0x13, 0x0a, 0x02, 0x20, 0x02, 0x25, 0x3c, 0xd6
2019-08-01 12:23:20.968 Detail, Node010, Queuing (Send) SensorBinaryCmd_Get (Node=10): 0x01, 0x09, 0x00, 0x13, 0x0a, 0x02, 0x30, 0x02, 0x25, 0x3d, 0xc7
2019-08-01 12:23:20.968 Detail, Node010, Queuing (Query) Query Stage Complete (Dynamic)
2019-08-01 12:23:20.968 Detail,
2019-08-01 12:23:20.968 Info, Node010, Sending (Send) message (Callback ID=0x3c, Expected Reply=0x04) - BasicCmd_Get (Node=10): 0x01, 0x09, 0x00, 0x13, 0x0a, 0x02, 0x20, 0x02, 0x25, 0x3c, 0xd6
2019-08-01 12:23:20.977 Detail, Node010, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2019-08-01 12:23:20.978 Detail, Node010, ZW_SEND_DATA delivered to Z-Wave stack
2019-08-01 12:23:21.084 Detail, Node010, Received: 0x01, 0x07, 0x00, 0x13, 0x3c, 0x00, 0x00, 0x0c, 0xdb
2019-08-01 12:23:21.084 Detail, Node010, ZW_SEND_DATA Request with callback ID 0x3c received (expected 0x3c)
2019-08-01 12:23:21.084 Info, Node010, Request RTT 116 Average Request RTT 90
2019-08-01 12:23:21.084 Detail, Expected callbackId was received
2019-08-01 12:23:30.969 Error, Node010, ERROR: Dropping command, expected response not received after 1 attempt(s)
2019-08-01 12:23:30.969 Detail, Node010, Removing current message
2019-08-01 12:23:30.969 Detail, Node010, Notification: Notification - TimeOut
2019-08-01 12:23:30.973 Detail,
2019-08-01 12:23:30.973 Info, Node010, Sending (Send) message (Callback ID=0x3d, Expected Reply=0x04) - SensorBinaryCmd_Get (Node=10): 0x01, 0x09, 0x00, 0x13, 0x0a, 0x02, 0x30, 0x02, 0x25, 0x3d, 0xc7
2019-08-01 12:23:30.981 Detail, Node010, Received: 0x01, 0x04, 0x01, 0x13, 0x01, 0xe8
2019-08-01 12:23:30.982 Detail, Node010, ZW_SEND_DATA delivered to Z-Wave stack
2019-08-01 12:23:31.033 Detail, Node010, Received: 0x01, 0x07, 0x00, 0x13, 0x3d, 0x00, 0x00, 0x06, 0xd0
2019-08-01 12:23:31.033 Detail, Node010, ZW_SEND_DATA Request with callback ID 0x3d received (expected 0x3d)
2019-08-01 12:23:31.033 Info, Node010, Request RTT 60 Average Request RTT 75
2019-08-01 12:23:31.033 Detail, Expected callbackId was received
2019-08-01 12:23:40.973 Error, Node010, ERROR: Dropping command, expected response not received after 1 attempt(s)
2019-08-01 12:23:40.973 Detail, Node010, Removing current message
2019-08-01 12:23:40.973 Detail, Node010, Notification: Notification - TimeOut
2019-08-01 12:23:40.977 Detail, Node010, Query Stage Complete (Dynamic)
2019-08-01 12:23:40.977 Detail, Node010, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Configuration live=1
2019-08-01 12:23:40.977 Detail, Node010, QueryStage_Configuration
2019-08-01 12:23:40.977 Detail, Node010, QueryStage_Complete
2019-08-01 12:23:40.977 Warning, CheckCompletedNodeQueries m_allNodesQueried=1 m_awakeNodesQueried=1
2019-08-01 12:23:40.977 Detail, Node010, Notification: NodeQueriesComplete
2019-08-01 12:25:53.153 Detail, Node010, Queuing (Controller) Request Node Neighbor Update
2019-08-01 12:25:53.153 Detail, Node010, Queuing (Controller) Delete All Return Routes
2019-08-01 12:25:53.155 Info, Requesting Neighbor Update for node 10
2019-08-01 12:25:53.155 Detail, Node010, Queuing (Command) ControllerCommand_RequestNodeNeighborUpdate (Node=10): 0x01, 0x05, 0x00, 0x48, 0x0a, 0x3e, 0x86
2019-08-01 12:25:53.155 Detail, Notification: ControllerCommand - Starting
2019-08-01 12:25:53.157 Detail,
2019-08-01 12:25:53.158 Info, Node010, Sending (Command) message (Callback ID=0x3e, Expected Reply=0x48) - ControllerCommand_RequestNodeNeighborUpdate (Node=10): 0x01, 0x05, 0x00, 0x48, 0x0a, 0x3e, 0x86
2019-08-01 12:25:53.207 Detail, Node010, Received: 0x01, 0x05, 0x00, 0x48, 0x3e, 0x21, 0xad
2019-08-01 12:25:53.208 Detail,
2019-08-01 12:25:53.208 Info, Node010, REQUEST_NEIGHBOR_UPDATE_STARTED
2019-08-01 12:25:53.208 Detail, Node033, Expected callbackId was received
2019-08-01 12:25:53.208 Detail, Node033, Expected reply was received
2019-08-01 12:25:53.208 Detail, Node033, Message transaction complete
2019-08-01 12:25:53.208 Detail,
2019-08-01 12:25:53.208 Detail, Node010, Removing current message
2019-08-01 12:25:53.208 Detail, Notification: ControllerCommand - InProgress
2019-08-01 12:25:53.209 Info, WriteNextMsg Controller nothing to do
2019-08-01 12:25:53.671 Detail, Received: 0x01, 0x05, 0x00, 0x48, 0x3e, 0x21, 0xad
2019-08-01 12:25:53.672 Detail,
2019-08-01 12:25:53.672 Info, REQUEST_NEIGHBOR_UPDATE_STARTED
2019-08-01 12:25:53.672 Detail, Notification: ControllerCommand - InProgress
2019-08-01 12:25:54.597 Detail, Received: 0x01, 0x05, 0x00, 0x48, 0x3e, 0x22, 0xae
2019-08-01 12:25:54.597 Detail,
2019-08-01 12:25:54.597 Info, REQUEST_NEIGHBOR_UPDATE_DONE
2019-08-01 12:25:54.597 Detail, Requesting routing info (neighbor list) for Node 10
2019-08-01 12:25:54.597 Detail, Node010, Queuing (Command) Get Routing Info (Node=10): 0x01, 0x07, 0x00, 0x80, 0x0a, 0x00, 0x00, 0x03, 0x71
2019-08-01 12:25:54.597 Detail, Notification: ControllerCommand - Completed
2019-08-01 12:25:54.598 Detail,
2019-08-01 12:25:54.598 Info, Node010, Sending (Command) message (Callback ID=0x00, Expected Reply=0x80) - Get Routing Info (Node=10): 0x01, 0x07, 0x00, 0x80, 0x0a, 0x00, 0x00, 0x03, 0x71
2019-08-01 12:25:54.604 Detail, Node010, Received: 0x01, 0x20, 0x01, 0x80, 0xe6, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0x00, 0xb8
2019-08-01 12:25:54.604 Detail,
2019-08-01 12:25:54.604 Info, Node010, Received reply to FUNC_ID_ZW_GET_ROUTING_INFO
2019-08-01 12:25:54.604 Info, Node010, Neighbors of this node are:
2019-08-01 12:25:54.605 Info, Node010, Node 2
2019-08-01 12:25:54.605 Info, Node010, Node 3
2019-08-01 12:25:54.605 Info, Node010, Node 6
2019-08-01 12:25:54.605 Info, Node010, Node 7
2019-08-01 12:25:54.605 Info, Node010, Node 8
2019-08-01 12:25:54.605 Detail, Expected reply was received
2019-08-01 12:25:54.605 Detail, Message transaction complete
2019-08-01 12:25:54.605 Detail,
2019-08-01 12:25:54.605 Detail, Node010, Removing current message
2019-08-01 12:25:54.605 Info, Deleting all return routes from node 10
2019-08-01 12:25:54.605 Detail, Node010, Queuing (Command) ControllerCommand_DeleteAllReturnRoutess (Node=10): 0x01, 0x05, 0x00, 0x47, 0x0a, 0x3f, 0x88
2019-08-01 12:25:54.606 Detail, Notification: ControllerCommand - Starting
2019-08-01 12:25:54.606 Detail,
2019-08-01 12:25:54.606 Info, Node010, Sending (Command) message (Callback ID=0x3f, Expected Reply=0x47) - ControllerCommand_DeleteAllReturnRoutess (Node=10): 0x01, 0x05, 0x00, 0x47, 0x0a, 0x3f, 0x88
2019-08-01 12:25:55.243 Detail, Node010, Received: 0x01, 0x04, 0x01, 0x47, 0x01, 0xbc
2019-08-01 12:25:55.244 Detail,
2019-08-01 12:25:55.244 Info, Node010, Received reply to FUNC_ID_ZW_DELETE_RETURN_ROUTE - command in progress
2019-08-01 12:25:55.244 Detail, Notification: ControllerCommand - InProgress
2019-08-01 12:25:56.500 Detail, Node010, Received: 0x01, 0x05, 0x00, 0x47, 0x3f, 0x00, 0x82
2019-08-01 12:25:56.500 Detail,
2019-08-01 12:25:56.500 Info, Node010, Received reply to FUNC_ID_ZW_DELETE_RETURN_ROUTE for node 10 - SUCCESS
2019-08-01 12:25:56.500 Detail, Expected callbackId was received
2019-08-01 12:25:56.500 Detail, Expected reply was received
2019-08-01 12:25:56.500 Detail, Message transaction complete
2019-08-01 12:25:56.500 Detail,
2019-08-01 12:25:56.500 Detail, Node010, Removing current message
2019-08-01 12:25:56.501 Detail, Notification: ControllerCommand - Completed
It really doesn’t look like it should be failing, but, it is?
Post the first 5-10 lines of your OZW_Log.txt
Welllll there may be my issue:
2019-08-01 20:10:13.099 Always, OpenZwave Version 1.4.3440 Starting Up
2019-08-01 20:10:24.550 Info, Setting Up Provided Network Key for Secure Communications
2019-08-01 20:10:24.550 Warning, Failed - Network Key Not Set
2019-08-01 20:10:24.550 Info, mgr, Added driver for controller /dev/ttyACM0
2019-08-01 20:10:24.556 Info, Opening controller /dev/ttyACM0
2019-08-01 20:10:24.557 Info, Trying to open serial port /dev/ttyACM0 (attempt 1)
2019-08-01 20:10:24.558 Info, Serial port /dev/ttyACM0 opened (attempt 1)
2019-08-01 20:10:24.559 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_VERSION: 0x01, 0x03, 0x00, 0x15, 0xe9
2019-08-01 20:10:24.559 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_MEMORY_GET_ID: 0x01, 0x03, 0x00, 0x20, 0xdc
2019-08-01 20:10:24.559 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_CONTROLLER_CAPABILITIES: 0x01, 0x03, 0x00, 0x05, 0xf9
2019-08-01 20:10:24.559 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_GET_CAPABILITIES: 0x01, 0x03, 0x00, 0x07, 0xfb
2019-08-01 20:10:24.560 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_SUC_NODE_ID: 0x01, 0x03, 0x00, 0x56, 0xaa
However, basing off the solution @dfortier had, I do not have a .storage folder under ~/.homeassistant/. This is an install from 0.6x days that is now on 0.96.5. I’m tempted to just blow it all away and start over since some things seem missing.