Noretek HUSBZB Zwave stick and GE switch

HAmoron · December 3, 2018, 7:18pm

Hello everyone -

Thanks so much for all the awesome capabilities in Home Assistant.

I have been trying to figure out how to get my first Zwave device to work. I have a Nortek HUSBZB stick which shows up in home assistant.

After installing GE Switch (14292)

I go to Configuration -> Zwave
Click Add Node
Go to the switch and toggle the light on

But the switch never shows up in home assistant.

The log shows very little
2018-12-03 14:08:42 INFO (SyncWorker_2) [homeassistant.components.zwave] Z-Wave add_node have been initialized

The OZW_Log has a little more
2018-12-03 14:08:42.613 Detail, Queuing (Controller) Add Device
2018-12-03 14:08:42.614 Info, Add Device
2018-12-03 14:08:42.614 Detail, contrlr, Queuing (Command) ControllerCommand_AddDevice: 0x01, 0x05, 0x00, 0x4a, 0xc1, 0x0b, 0x7a
2018-12-03 14:08:42.614 Detail, Notification: ControllerCommand - Starting
2018-12-03 14:08:42.615 Detail,
2018-12-03 14:08:42.615 Info, contrlr, Sending (Command) message (Callback ID=0x0b, Expected Reply=0x4a) - ControllerCommand_AddDevice: 0x01, 0x05, 0x00, 0x4a, 0xc1, 0x0b, 0x7a
2018-12-03 14:08:42.620 Detail, contrlr, Received: 0x01, 0x07, 0x00, 0x4a, 0x0b, 0x01, 0x00, 0x00, 0xb8
2018-12-03 14:08:42.620 Detail,
2018-12-03 14:08:42.620 Info, contrlr, FUNC_ID_ZW_ADD_NODE_TO_NETWORK:
2018-12-03 14:08:42.620 Info, contrlr, ADD_NODE_STATUS_LEARN_READY
2018-12-03 14:08:42.620 Detail, Node001, Expected callbackId was received
2018-12-03 14:08:42.620 Detail, Node001, Expected reply was received
2018-12-03 14:08:42.620 Detail, Node001, Message transaction complete
2018-12-03 14:08:42.620 Detail,
2018-12-03 14:08:42.620 Detail, contrlr, Removing current message
2018-12-03 14:08:42.620 Detail, Notification: ControllerCommand - Waiting
2018-12-03 14:08:42.620 Info, WriteNextMsg Controller nothing to do

Any ideas on what’s going wrong? My Z-Wave stick is probably 60 feet from the switch, is that too far?

Thanks!

ptdalen · December 3, 2018, 7:22pm

So, you see it in zwave, but not in the devices.

Not under switch.GE_swith_name_here?

HAmoron · December 3, 2018, 7:29pm

When I configured the Zwave component, home assistant created a Z-Wave group. That group only contains the HUSBZB stick, nothing else.

The GE switch doesn’t show in the Z-Wave group, the States page, or anywhere else.

This is my first time installing a switch. Could I have wired something wrong? The switch works to manually toggle the light on and off.

ptdalen · December 3, 2018, 10:26pm

Yeah, something is wrong. Do you have any other zwave devices? It sounds like you did. but if that group only contains the stick, then you must not have any other zwave devices.

What does your configuration.yaml look like?

Did you add secure, or just add node? For a switch you should just be able to add node.

HAmoron · December 3, 2018, 11:19pm

I do have one more switch. I guess I could try and install it to see if I get the same behavior.

configuration.yaml has this
zwave:
usb_path: /dev/ttyUSB0
network_key: “0xCD, 0xA7, 0x65, 0x21, 0x38, 0x92, 0x8C, 0x5B, 0x2D, 0x85, 0xCC, 0x57, 0xEB, 0x59, 0x35, 0x18”

I don’t think I need the network key, I generated it following the instructions here https://www.home-assistant.io/docs/z-wave/installation

I’ve tried both “add” and “add secure”

I don’t know if this means anything, but I restarted home assistant and I noticed it mentions several other nodes (45, 159, 215). Is that part of the normal initialization? Or is it indicating that there is communication on the Zwave net to another node?
2018-12-03 16:28:47.557 Always, OpenZwave Version 1.4.3254 Starting Up
2018-12-03 16:28:48.790 Info, Setting Up Provided Network Key for Secure Communications
2018-12-03 16:28:48.790 Warning, Failed - Network Key Not Set
2018-12-03 16:28:48.790 Info, mgr, Added driver for controller /dev/ttyUSB0
2018-12-03 16:28:48.790 Info, Opening controller /dev/ttyUSB0
2018-12-03 16:28:48.791 Info, Trying to open serial port /dev/ttyUSB0 (attempt 1)
2018-12-03 16:28:48.798 Info, Serial port /dev/ttyUSB0 opened (attempt 1)
2018-12-03 16:28:48.799 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_VERSION: 0x01, 0x03, 0x00, 0x15, 0xe9
2018-12-03 16:28:48.799 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_MEMORY_GET_ID: 0x01, 0x03, 0x00, 0x20, 0xdc
2018-12-03 16:28:48.799 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_CONTROLLER_CAPABILITIES: 0x01, 0x03, 0x00, 0x05, 0xf9
2018-12-03 16:28:48.799 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_GET_CAPABILITIES: 0x01, 0x03, 0x00, 0x07, 0xfb
2018-12-03 16:28:48.799 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_SUC_NODE_ID: 0x01, 0x03, 0x00, 0x56, 0xaa
2018-12-03 16:28:48.799 Detail,
2018-12-03 16:28:48.799 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x15) - FUNC_ID_ZW_GET_VERSION: 0x01, 0x03, 0x00, 0x15, 0xe9
2018-12-03 16:28:48.803 Detail, contrlr, Received: 0x01, 0x10, 0x01, 0x15, 0x5a, 0x2d, 0x57, 0x61, 0x76, 0x65, 0x20, 0x34, 0x2e, 0x30, 0x35, 0x00, 0x01, 0x97
2018-12-03 16:28:48.804 Detail,
2018-12-03 16:28:48.804 Info, contrlr, Received reply to FUNC_ID_ZW_GET_VERSION:
2018-12-03 16:28:48.804 Info, contrlr, Static Controller library, version Z-Wave 4.05
2018-12-03 16:28:48.804 Detail, Node045, Expected reply was received
2018-12-03 16:28:48.804 Detail, Node045, Message transaction complete
2018-12-03 16:28:48.804 Detail,
2018-12-03 16:28:48.804 Detail, contrlr, Removing current message
2018-12-03 16:28:48.804 Detail,
2018-12-03 16:28:48.804 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x20) - FUNC_ID_ZW_MEMORY_GET_ID: 0x01, 0x03, 0x00, 0x20, 0xdc
2018-12-03 16:28:48.807 Detail, contrlr, Received: 0x01, 0x08, 0x01, 0x20, 0xe4, 0x9f, 0xc3, 0x28, 0x01, 0x47
2018-12-03 16:28:48.807 Detail,
2018-12-03 16:28:48.807 Info, contrlr, Received reply to FUNC_ID_ZW_MEMORY_GET_ID. Home ID = 0xe49fc328. Our node ID = 1
2018-12-03 16:28:48.807 Detail, Node159, Expected reply was received
2018-12-03 16:28:48.807 Detail, Node159, Message transaction complete
2018-12-03 16:28:48.807 Detail,
2018-12-03 16:28:48.807 Detail, contrlr, Removing current message
2018-12-03 16:28:48.808 Detail,
2018-12-03 16:28:48.808 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x05) - FUNC_ID_ZW_GET_CONTROLLER_CAPABILITIES: 0x01, 0x03, 0x00, 0x05, 0xf9
2018-12-03 16:28:48.810 Detail, contrlr, Received: 0x01, 0x04, 0x01, 0x05, 0x28, 0xd7
2018-12-03 16:28:48.810 Detail,
2018-12-03 16:28:48.810 Info, contrlr, Received reply to FUNC_ID_ZW_GET_CONTROLLER_CAPABILITIES:
2018-12-03 16:28:48.810 Info, contrlr, There is no SUC ID Server (SIS) in this network.
2018-12-03 16:28:48.810 Info, contrlr, The PC controller is a primary controller.
2018-12-03 16:28:48.810 Detail, Node215, Expected reply was received
2018-12-03 16:28:48.810 Detail, Node215, Message transaction complete
2018-12-03 16:28:48.811 Detail,
2018-12-03 16:28:48.811 Detail, contrlr, Removing current message
2018-12-03 16:28:48.811 Detail,
2018-12-03 16:28:48.811 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x07) - FUNC_ID_SERIAL_API_GET_CAPABILITIES: 0x01, 0x03, 0x00, 0x07, 0xfb
2018-12-03 16:28:48.816 Detail, contrlr, Received: 0x01, 0x2b, 0x01, 0x07, 0x04, 0x20, 0x00, 0x00, 0x00, 0x01, 0x00, 0x01, 0xfe, 0x81, 0xff, 0x88, 0xcf, 0x1f, 0x00, 0x00, 0xfb, 0x9f, 0x7d, 0xa0, 0x67, 0x00, 0x80, 0x80, 0x00, 0x80, 0x86, 0x00, 0x00, 0x00, 0xe8, 0x73, 0x00, 0x00, 0x0e, 0x00, 0x00, 0x60, 0x00, 0x00, 0x03
2018-12-03 16:28:48.816 Detail,
2018-12-03 16:28:48.816 Info, contrlr, Received reply to FUNC_ID_SERIAL_API_GET_CAPABILITIES
2018-12-03 16:28:48.817 Info, contrlr, Serial API Version: 4.32
2018-12-03 16:28:48.817 Info, contrlr, Manufacturer ID: 0x0000
2018-12-03 16:28:48.817 Info, contrlr, Product Type: 0x0001
2018-12-03 16:28:48.817 Info, contrlr, Product ID: 0x0001
2018-12-03 16:28:48.817 Detail, contrlr, Queuing (Command) FUNC_ID_ZW_GET_RANDOM: 0x01, 0x04, 0x00, 0x1c, 0x20, 0xc7
2018-12-03 16:28:48.817 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_GET_INIT_DATA: 0x01, 0x03, 0x00, 0x02, 0xfe
2018-12-03 16:28:48.817 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_SET_TIMEOUTS: 0x01, 0x05, 0x00, 0x06, 0x64, 0x0f, 0x97
2018-12-03 16:28:48.817 Detail, contrlr, Queuing (Command) FUNC_ID_SERIAL_API_APPL_NODE_INFORMATION: 0x01, 0x07, 0x00, 0x03, 0x01, 0x02, 0x01, 0x00, 0xf9
2018-12-03 16:28:48.817 Detail, Node032, Expected reply was received
2018-12-03 16:28:48.817 Detail, Node032, Message transaction complete
2018-12-03 16:28:48.817 Detail,
2018-12-03 16:28:48.817 Detail, contrlr, Removing current message
2018-12-03 16:28:48.817 Detail,
2018-12-03 16:28:48.817 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x56) - FUNC_ID_ZW_GET_SUC_NODE_ID: 0x01, 0x03, 0x00, 0x56, 0xaa
2018-12-03 16:28:48.819 Detail, contrlr, Received: 0x01, 0x04, 0x01, 0x56, 0x00, 0xac
2018-12-03 16:28:48.819 Detail,
2018-12-03 16:28:48.819 Info, contrlr, Received reply to GET_SUC_NODE_ID. Node ID = 0
2018-12-03 16:28:48.820 Info, Controller Does not Support SUC - Cannot Setup Controller as SUC Node
2018-12-03 16:28:48.820 Detail, Node172, Expected reply was received
2018-12-03 16:28:48.820 Detail, Node172, Message transaction complete
2018-12-03 16:28:48.820 Detail,
2018-12-03 16:28:48.820 Detail, contrlr, Removing current message
2018-12-03 16:28:48.820 Detail,
2018-12-03 16:28:48.820 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x1c) - FUNC_ID_ZW_GET_RANDOM: 0x01, 0x04, 0x00, 0x1c, 0x20, 0xc7
2018-12-03 16:28:48.874 Detail, contrlr, Received: 0x01, 0x25, 0x01, 0x1c, 0x01, 0x20, 0x09, 0x65, 0x65, 0x75, 0x85, 0x5f, 0xca, 0x39, 0x6c, 0xc2, 0x81, 0x95, 0x69, 0x07, 0x8c, 0x1f, 0x69, 0x72, 0x6d, 0x55, 0xde, 0x21, 0x15, 0xd6, 0x91, 0xcc, 0xe0, 0xbc, 0x15, 0x7d, 0xa6, 0x6d, 0x49
2018-12-03 16:28:48.875 Detail,
2018-12-03 16:28:48.875 Info, contrlr, Received reply to FUNC_ID_ZW_GET_RANDOM: true
2018-12-03 16:28:48.875 Detail, Node032, Expected reply was received
2018-12-03 16:28:48.875 Detail, Node032, Message transaction complete
2018-12-03 16:28:48.875 Detail,
2018-12-03 16:28:48.875 Detail, contrlr, Removing current message
2018-12-03 16:28:48.875 Detail,
2018-12-03 16:28:48.875 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x02) - FUNC_ID_SERIAL_API_GET_INIT_DATA: 0x01, 0x03, 0x00, 0x02, 0xfe
2018-12-03 16:28:48.931 Detail, contrlr, Received: 0x01, 0x25, 0x01, 0x02, 0x05, 0x00, 0x1d, 0x01, 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, 0x05, 0x00, 0xc5
2018-12-03 16:28:48.932 Detail,
2018-12-03 16:28:48.932 Info, mgr, Driver with Home ID of 0xe49fc328 is now ready.
2018-12-03 16:28:48.932 Info,
2018-12-03 16:28:48.932 Info, contrlr, Received reply to FUNC_ID_SERIAL_API_GET_INIT_DATA:
2018-12-03 16:28:48.932 Info, contrlr, Node 001 - Known
2018-12-03 16:28:48.932 Detail, Node001, AdvanceQueries queryPending=0 queryRetries=0 queryStage=CacheLoad live=1
2018-12-03 16:28:48.932 Detail, Node001, QueryStage_CacheLoad
2018-12-03 16:28:48.933 Info, Node001, Node Identity Codes: 0000:0001:0001
2018-12-03 16:28:48.933 Detail, Node001, QueryStage_Associations
2018-12-03 16:28:48.933 Detail, Node001, QueryStage_Neighbors
2018-12-03 16:28:48.933 Detail, contrlr, Requesting routing info (neighbor list) for Node 1
2018-12-03 16:28:48.933 Detail, Node001, Queuing (Command) Get Routing Info (Node=1): 0x01, 0x07, 0x00, 0x80, 0x01, 0x00, 0x00, 0x03, 0x7a
2018-12-03 16:28:48.933 Detail, Node001, Queuing (Query) Query Stage Complete (Neighbors)
2018-12-03 16:28:48.933 Detail, Expected reply was received
2018-12-03 16:28:48.933 Detail, Message transaction complete
2018-12-03 16:28:48.933 Detail,
2018-12-03 16:28:48.933 Detail, contrlr, Removing current message
2018-12-03 16:28:48.933 Detail, Node001, Notification: DriverReady
2018-12-03 16:28:48.936 Detail, Node001, Notification: NodeAdded
2018-12-03 16:28:48.940 Detail, Node001, Notification: NodeProtocolInfo
2018-12-03 16:28:48.941 Detail, Node001, Notification: EssentialNodeQueriesComplete
2018-12-03 16:28:48.942 Detail, Node001, Notification: ValueAdded
2018-12-03 16:28:48.942 Detail,
2018-12-03 16:28:48.942 Info, contrlr, Sending (Command) message (Callback ID=0x00, Expected Reply=0x06) - FUNC_ID_SERIAL_API_SET_TIMEOUTS: 0x01, 0x05, 0x00, 0x06, 0x64, 0x0f, 0x97
2018-12-03 16:28:48.945 Detail, contrlr, Received: 0x01, 0x05, 0x01, 0x06, 0x96, 0x0f, 0x64
2018-12-03 16:28:48.945 Detail,
2018-12-03 16:28:48.945 Info, contrlr, Received reply to FUNC_ID_SERIAL_API_SET_TIMEOUTS
2018-12-03 16:28:48.946 Detail, Node015, Expected reply was received
2018-12-03 16:28:48.946 Detail, Node015, Message transaction complete
2018-12-03 16:28:48.946 Detail,
2018-12-03 16:28:48.946 Detail, contrlr, Removing current message
2018-12-03 16:28:48.946 Detail,
2018-12-03 16:28:48.946 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
2018-12-03 16:28:48.948 Detail, contrlr, Removing current message
2018-12-03 16:28:48.948 Detail,
2018-12-03 16:28:48.948 Info, Node001, Sending (Command) message (Callback ID=0x00, Expected Reply=0x80) - Get Routing Info (Node=1): 0x01, 0x07, 0x00, 0x80, 0x01, 0x00, 0x00, 0x03, 0x7a
2018-12-03 16:28:48.955 Detail, Node001, Received: 0x01, 0x20, 0x01, 0x80, 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, 0x00, 0x5e
2018-12-03 16:28:48.955 Detail,
2018-12-03 16:28:48.955 Info, Node001, Received reply to FUNC_ID_ZW_GET_ROUTING_INFO
2018-12-03 16:28:48.955 Info, Node001, Neighbors of this node are:
2018-12-03 16:28:48.955 Info, Node001, (none reported)
2018-12-03 16:28:48.955 Detail, Expected reply was received
2018-12-03 16:28:48.955 Detail, Message transaction complete
2018-12-03 16:28:48.955 Detail,
2018-12-03 16:28:48.955 Detail, Node001, Removing current message
2018-12-03 16:28:48.955 Detail, Node001, Query Stage Complete (Neighbors)
2018-12-03 16:28:48.955 Detail, Node001, AdvanceQueries queryPending=0 queryRetries=0 queryStage=Session live=1
2018-12-03 16:28:48.955 Detail, Node001, QueryStage_Session
2018-12-03 16:28:48.956 Detail, Node001, QueryStage_Dynamic
2018-12-03 16:28:48.956 Detail, Node001, QueryStage_Configuration
2018-12-03 16:28:48.956 Detail, Node001, QueryStage_Complete
2018-12-03 16:28:48.956 Warning, CheckCompletedNodeQueries m_allNodesQueried=0 m_awakeNodesQueried=0
2018-12-03 16:28:48.956 Warning, CheckCompletedNodeQueries all=1, deadFound=0 sleepingOnly=1
2018-12-03 16:28:48.956 Info, Node query processing complete.
2018-12-03 16:28:48.956 Detail, Node001, Notification: NodeQueriesComplete
2018-12-03 16:28:48.957 Detail, contrlr, Notification: AllNodesQueried

ptdalen · December 3, 2018, 11:44pm

So, it looks to me like you have several zwave devices already on this zwave stick. I see node 15, 32, 172, 215, 159, etc

So, lets start over. Are you setting up zwave for the 1st time? Is this a brand new zwave controller? When I was asking about other zwave devices, I meant zwave devices already working in HA.

Also it does look like something is wrong with your network key based on the log. I’d remove it for now.

HAmoron · December 4, 2018, 1:20am

As far as I know, there are only 2 zwave devices in the house - the USB stick, and the GE switch.

The USB stick was ordered new from Amazon about 3 weeks ago. It was supposed to be new, packaging seemed like a new device.

I removed the network key, still behaves the same way.

Is there some way for me to clean out those other nodes?

ptdalen · December 4, 2018, 1:27am

Before i send you down a rabbit hole, hopefully someone else will jump in. I feel pretty comfortable with zwave but I could be wrong. Maybe those other nodes showing up are something I’m misunderstanding.

HAmoron · December 4, 2018, 3:27am

OK. Thanks for the help.

Maybe another good samaritan will have some ideas to try.

HAmoron · December 5, 2018, 8:50pm

Hey ptdalen -

Thanks for all the help. I decided to go re-check my wiring, and it looks like the neutral wire was somewhat loose. I gotta go find some bigger wire nuts.

Seems to be working now!