[Resolved] HUSBZB-1 not detected properly (Shows as ttyACM0 only instead of ttyUSB0 and ttyUSB1)

sayboltm · April 28, 2018, 10:46pm

I’m running raspbian + Home Assistant in python virtual environment. This is extremely familiar to me as I program in Python a lot, and love python virtual environments.

My HUSBZB-1 is showing up as /dev/ttyACM0 instead of ttyUSB0 and ttyUSB1. Anyone have any ideas? I don’t want to blame the hardware but been banging my head for hours with this stick and I’m beginning to wonder.

Are there udev permissions I need to set up? Every other linux dev I have done has required this but I can’t seem to find anything on the forums about it besides mapping the USB0/1 to /dev/zwave or /dev/zigbee.

I previously set up an Aeotec Z-stick and it worked well with hass.io, but I want to use zigbee so I moved to the HUSBZB-1. I assume the udev permissions were set somewhere in the docker image, or it is running as root within the docker image and doesn’t need them.

Since only one device shows up when plugged in checking with both ls /dev/tty* and dmesg | grep tty, I assumed it’s the zwave part of the stick so I put in my configuration.yml:

zwave:
  usb_path: /dev/ttyACM0

And in the web interface it shows a Sigma Designs UZB Z-Wave USB adapter as ‘ready’ but I cannot seem to pair my devices as I cannot get a lock on the serial port according to the printout after starting hass process.

2018-04-28 22:54:59 INFO (Thread-17)     [homeassistant.components.zwave] Z-Wave add_node have been initialized
2018-04-28 22:54:59 WARNING (Thread-17) [openzwave] Can't lock controller for command : add_node
2018-04-28 22:54:59 INFO (MainThread) [homeassistant.core] Bus:Handling <Event system_log_event[L]: level=WARNING, exception=, message=Can't lock controller for command : add_node, timestamp=1524956099.046079, source=components/zwave/__init__.py>
2018-04-28 22:54:59 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_executed[L]: service_call_id=1975810992-9>

Seems worth noting that when using hass.io with my aeotec zstick, ls /dev/tty* only showed tty, but I put /dev/ttyACM0 in my config and it worked despite it not showing up there. I blamed the moving parts of docker and moved on because it worked, and is one of the reasons I moved to raspbian + Home Assistant in venv.

wakeskate · April 28, 2018, 10:58pm

Running on a Raspberry pi not virtual environment but here is my
configuration.yaml entry that works.
Running Hassio.

#-------------------------------------
#---- Setup Z-Wave Zigbee USB Adapter
#-------------------------------------

#Nortek/GoControl Z-Wave & Zigbee USB Adapter HUSBZB-1
zha:
  usb_path: /dev/ttyUSB1
  database_path: /config/zigbee.db

zwave:
  usb_path: /dev/ttyUSB0

sayboltm · April 28, 2018, 11:34pm

So, since setting my Aeotec stick as /dev/ttyACM0 worked in hass.io without it showing up in /dev/tty*, I tried your style config since that’s what everyone seems to be using, and it has a problem because there is no /dev/ttyUSB0 or 1 (it shows up as /dev/ttyACM0 as previously stated). Here is the full output from starting hass (I don’t think I left any sensitive information in it besides crappy general gps coords). I even made a /config/zigbee and changed ownership to homeassistant so my config matches what you posted exactly, but the error is the same (my HUSBZB-1 is not found on ttyUSB0)

[inserted code] (the full output is 44k chars, and this form allows 32k chars max. Am posting below in 2 posts.

Also my zigbee.db has a bunch of weird crap in it starting with:
SQLite format 3 ^@^@^A^@

if someone could post their zigbee.db, I am curious what it looks like.

I am thrilled this is written in Python, and would like to help debug/dev (hopefully).

sayboltm · April 28, 2018, 11:35pm

(homeassistant) homeassistant@raspberrypi:~/.homeassistant $ hass
Config directory: /home/homeassistant/.homeassistant
2018-04-28 23:27:56 INFO (MainThread) [homeassistant.core] Bus:Handling <Event s                                                                       ervice_registered[L]: domain=homeassistant, service=turn_off>
2018-04-28 23:27:56 INFO (MainThread) [homeassistant.core] Bus:Handling <Event s                                                                       ervice_registered[L]: domain=homeassistant, service=turn_on>
2018-04-28 23:27:56 INFO (MainThread) [homeassistant.core] Bus:Handling <Event s                                                                       ervice_registered[L]: domain=homeassistant, service=toggle>
2018-04-28 23:27:56 INFO (MainThread) [homeassistant.core] Bus:Handling <Event s                                                                       ervice_registered[L]: domain=homeassistant, service=stop>
2018-04-28 23:27:56 INFO (MainThread) [homeassistant.core] Bus:Handling <Event s                                                                       ervice_registered[L]: domain=homeassistant, service=restart>
2018-04-28 23:27:56 INFO (MainThread) [homeassistant.core] Bus:Handling <Event s                                                                       ervice_registered[L]: domain=homeassistant, service=check_config>
2018-04-28 23:27:56 INFO (MainThread) [homeassistant.core] Bus:Handling <Event s                                                                       ervice_registered[L]: domain=homeassistant, service=reload_core_config>
2018-04-28 23:27:56 INFO (MainThread) [homeassistant.core] Bus:Handling <Event s                                                                       ervice_registered[L]: domain=persistent_notification, service=create>
2018-04-28 23:27:56 INFO (MainThread) [homeassistant.core] Bus:Handling <Event s                                                                       ervice_registered[L]: domain=persistent_notification, service=dismiss>
2018-04-28 23:27:56 INFO (MainThread) [homeassistant.bootstrap] Home Assistant c                                                                       ore initialized
2018-04-28 23:27:56 INFO (MainThread) [homeassistant.loader] Loaded introduction                                                                        from homeassistant.components.introduction
2018-04-28 23:27:56 INFO (MainThread) [homeassistant.setup] Setting up introduct                                                                       ion
2018-04-28 23:27:56 INFO (MainThread) [homeassistant.components.introduction]

    ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~

        Hello, and welcome to Home Assistant!

        We'll hope that we can make all your dreams come true.

        Here are some resources to get started:

         - Configuring Home Assistant:
           https://home-assistant.io/getting-started/configuration/

         - Available components:
           https://home-assistant.io/components/

         - Troubleshooting your configuration:
           https://home-assistant.io/getting-started/troubleshooting-configurati                                                                       on/

         - Getting help:
           https://home-assistant.io/help/

        This message is generated by the introduction component. You can
        disable it in configuration.yaml.

    ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~

2018-04-28 23:27:56 INFO (MainThread) [homeassistant.loader] Loaded persistent_n                                                                       otification from homeassistant.components.persistent_notification
2018-04-28 23:27:56 INFO (MainThread) [homeassistant.setup] Setup of domain intr                                                                       oduction took 0.0 seconds.
2018-04-28 23:27:56 INFO (MainThread) [homeassistant.core] Bus:Handling <Event c                                                                       omponent_loaded[L]: component=introduction>
2018-04-28 23:27:57 INFO (MainThread) [homeassistant.loader] Loaded history from                                                                        homeassistant.components.history
2018-04-28 23:27:57 INFO (MainThread) [homeassistant.loader] Loaded recorder fro                                                                       m homeassistant.components.recorder
2018-04-28 23:27:57 INFO (MainThread) [homeassistant.loader] Loaded http from ho                                                                       meassistant.components.http
2018-04-28 23:27:57 INFO (MainThread) [homeassistant.loader] Loaded frontend fro                                                                       m homeassistant.components.frontend
2018-04-28 23:27:57 INFO (MainThread) [homeassistant.loader] Loaded api from hom                                                                       eassistant.components.api
2018-04-28 23:27:57 INFO (MainThread) [homeassistant.loader] Loaded websocket_ap                                                                       i from homeassistant.components.websocket_api
2018-04-28 23:27:58 INFO (MainThread) [homeassistant.loader] Loaded system_log f                                                                       rom homeassistant.components.system_log
2018-04-28 23:27:58 INFO (MainThread) [homeassistant.core] Bus:Handling <Event c                                                                       all_service[L]: domain=persistent_notification, service_call_id=1976282032-1, se                                                                       rvice=create, service_data=message=
Here are some resources to get started:

 - [Configuring Home Assistant](https://home-assistant.io/getting-started/config                                                                       uration/)
 - [Available components](https://home-assistant.io/components/)
 - [Troubleshooting your configuration](https://home-assistant.io/docs/configura                                                                       tion/troubleshooting/)
 - [Getting help](https://home-assistant.io/help/)

To not see this card popup in the future, edit your config in
`configuration.yaml` and disable the `introduction` component.
, title=Welcome Home!>
2018-04-28 23:27:58 INFO (MainThread) [homeassistant.core] Bus:Handling <Event s                                                                       tate_changed[L]: new_state=<state persistent_notification.notification=notifying                                                                       ; message=Here are some resources to get started:

 - [Configuring Home Assistant](https://home-assistant.io/getting-started/config                                                                       uration/)
 - [Available components](https://home-assistant.io/components/)
 - [Troubleshooting your configuration](https://home-assistant.io/docs/configura                                                                       tion/troubleshooting/)
 - [Getting help](https://home-assistant.io/help/)

To not see this card popup in the future, edit your config in
`configuration.yaml` and disable the `introduction` component., title=Welcome Ho                                                                       me! @ 2018-04-28T19:27:58.201912-04:00>, entity_id=persistent_notification.notif                                                                       ication, old_state=None>
2018-04-28 23:27:58 INFO (MainThread) [homeassistant.core] Bus:Handling <Event s                                                                       ervice_executed[L]: service_call_id=1976282032-1>
2018-04-28 23:27:58 INFO (MainThread) [homeassistant.setup] Setting up http
2018-04-28 23:27:58 INFO (MainThread) [homeassistant.setup] Setup of domain http took 0.0 seconds.
2018-04-28 23:27:58 INFO (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=http>
2018-04-28 23:27:58 INFO (MainThread) [homeassistant.setup] Setting up api
2018-04-28 23:27:58 INFO (MainThread) [homeassistant.setup] Setting up system_log
2018-04-28 23:27:58 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=system_log, service=clear>
2018-04-28 23:27:58 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=system_log, service=write>
2018-04-28 23:27:58 INFO (MainThread) [homeassistant.setup] Setup of domain system_log took 0.0 seconds.
2018-04-28 23:27:58 INFO (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=system_log>
2018-04-28 23:27:58 INFO (MainThread) [homeassistant.setup] Setting up websocket_api
2018-04-28 23:27:58 INFO (MainThread) [homeassistant.setup] Setup of domain websocket_api took 0.0 seconds.
2018-04-28 23:27:58 INFO (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=websocket_api>
2018-04-28 23:27:58 INFO (MainThread) [homeassistant.setup] Setup of domain api took 0.0 seconds.
2018-04-28 23:27:58 INFO (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=api>
2018-04-28 23:27:58 INFO (MainThread) [homeassistant.setup] Setting up recorder
2018-04-28 23:27:58 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=recorder, service=purge>
2018-04-28 23:27:58 INFO (MainThread) [homeassistant.setup] Setting up frontend
2018-04-28 23:28:00 INFO (MainThread) [homeassistant.setup] Setup of domain frontend took 2.3 seconds.
2018-04-28 23:28:00 INFO (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=frontend>
2018-04-28 23:28:01 WARNING (Recorder) [homeassistant.components.recorder] Ended unfinished session (id=9 from 2018-04-28 23:01:53.059097)
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.core] Bus:Handling <Event system_log_event[L]: exception=, level=WARNING, timestamp=1524958081.56794, message=Ended unfinished session (id=9 from 2018-04-28 23:01:53.059097), source=components/recorder/__init__.py>
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.setup] Setup of domain recorder took 3.2 seconds.
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=recorder>
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.setup] Setting up history
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.setup] Setup of domain history took 0.0 seconds.
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=history>
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.loader] Loaded sensor from homeassistant.components.sensor
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.loader] Loaded sensor.yr from homeassistant.components.sensor.yr
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.setup] Setting up sensor
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.loader] Loaded conversation from homeassistant.components.conversation
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.loader] Loaded group from homeassistant.components.group
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.setup] Setting up group
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=group, service=reload>
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=group, service=set>
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=group, service=remove>
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=group, service=set_visibility>
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.setup] Setup of domain group took 0.0 seconds.
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=group>
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.loader] Loaded config from homeassistant.components.config
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.loader] Loaded map from homeassistant.components.map
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.setup] Setting up map
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.setup] Setup of domain map took 0.0 seconds.
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=map>
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.loader] Loaded discovery from homeassistant.components.discovery
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.loader] Loaded tts from homeassistant.components.tts
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.loader] Loaded tts.google from homeassistant.components.tts.google
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.loader] Loaded zwave from homeassistant.components.zwave
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.loader] Loaded automation from homeassistant.components.automation
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.loader] Loaded script from homeassistant.components.script
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.loader] Loaded zha from homeassistant.components.zha
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.loader] Loaded logbook from homeassistant.components.logbook
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.loader] Loaded sun from homeassistant.components.sun
2018-04-28 23:28:01 INFO (MainThread) [homeassistant.setup] Setting up sun
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.setup] Setup of domain sun took 0.1 seconds.
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=sun>
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.loader] Loaded updater from homeassistant.components.updater
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.loader] Loaded cloud from homeassistant.components.cloud
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: new_state=<state sun.sun=above_horizon; next_dawn=2018-04-29T10:00:15+00:00, next_dusk=2018-04-29T00:59:11+00:00, friendly_name=Sun, elevation=10.37, next_setting=2018-04-29T00:28:42+00:00, azimuth=280.54, next_rising=2018-04-29T10:30:51+00:00, next_midnight=2018-04-29T05:30:15+00:00, next_noon=2018-04-29T17:30:21+00:00 @ 2018-04-28T19:28:02.297199-04:00>, entity_id=sun.sun, old_state=None>
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.setup] Setting up discovery
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.setup] Setup of domain discovery took 0.1 seconds.
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=discovery>
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.setup] Setting up conversation
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=conversation, service=process>
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.setup] Setup of domain conversation took 0.0 seconds.
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=conversation>
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.setup] Setting up config
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.setup] Setting up automation
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=automation, service=trigger>
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=automation, service=reload>
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=automation, service=toggle>
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=automation, service=turn_on>
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=automation, service=turn_off>
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.setup] Setup of domain automation took 0.0 seconds.
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=automation>
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.setup] Setting up script
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=script, service=reload>
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=script, service=turn_on>
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=script, service=turn_off>
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=script, service=toggle>
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.setup] Setup of domain script took 0.0 seconds.
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=script>
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.setup] Setting up logbook
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.loader] Loaded config.customize from homeassistant.components.config.customize
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=config.customize>
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.loader] Loaded config.config_entries from homeassistant.components.config.config_entries
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.loader] Loaded config.core from homeassistant.components.config.core
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=config.core>
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.loader] Loaded config.script from homeassistant.components.config.script
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=config.script>
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.loader] Loaded config.hassbian from homeassistant.components.config.hassbian
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.loader] Loaded config.entity_registry from homeassistant.components.config.entity_registry
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=config.entity_registry>
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.loader] Loaded config.automation from homeassistant.components.config.automation
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=config.automation>
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.loader] Loaded config.group from homeassistant.components.config.group
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=config.group>
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=logbook, service=log>
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.setup] Setup of domain logbook took 0.1 seconds.
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=logbook>
2018-04-28 23:28:02 INFO (MainThread) [homeassistant.setup] Setting up zwave
2018-04-28 23:28:03 INFO (MainThread) [homeassistant.setup] Setting up zha
2018-04-28 23:28:04 ERROR (MainThread) [homeassistant.setup] Error during setup of component zha
Traceback (most recent call last):
  File "/srv/homeassistant/lib/python3.5/site-packages/serial/serialposix.py", line 265, in open
    self.fd = os.open(self.portstr, os.O_RDWR | os.O_NOCTTY | os.O_NONBLOCK)
FileNotFoundError: [Errno 2] No such file or directory: '/dev/ttyUSB1'

sayboltm · April 28, 2018, 11:36pm

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "/srv/homeassistant/lib/python3.5/site-packages/homeassistant/setup.py", line 142, in _async_setup_component
    result = await component.async_setup(hass, processed_config)
  File "/srv/homeassistant/lib/python3.5/site-packages/homeassistant/components/zha/__init__.py", line 101, in async_setup
    await radio.connect(usb_path, baudrate)
  File "/srv/homeassistant/lib/python3.5/site-packages/bellows/ezsp.py", line 30, in connect
    self._gw = yield from uart.connect(device, baudrate, self)
  File "/srv/homeassistant/lib/python3.5/site-packages/bellows/uart.py", line 269, in connect
    xonxoff=True,
  File "/usr/lib/python3.5/asyncio/coroutines.py", line 210, in coro
    res = func(*args, **kw)
  File "/srv/homeassistant/lib/python3.5/site-packages/serial_asyncio/__init__.py", line 410, in create_serial_connection
    ser = serial.serial_for_url(*args, **kwargs)
  File "/srv/homeassistant/lib/python3.5/site-packages/serial/__init__.py", line 88, in serial_for_url
    instance.open()
  File "/srv/homeassistant/lib/python3.5/site-packages/serial/serialposix.py", line 268, in open
    raise SerialException(msg.errno, "could not open port {}: {}".format(self._port, msg))
serial.serialutil.SerialException: [Errno 2] could not open port /dev/ttyUSB1: [Errno 2] No such file or directory: '/dev/ttyUSB1'
2018-04-28 23:28:04 INFO (MainThread) [homeassistant.core] Bus:Handling <Event system_log_event[L]: exception=Traceback (most recent call last):
  File "/srv/homeassistant/lib/python3.5/site-packages/serial/serialposix.py", line 265, in open
    self.fd = os.open(self.portstr, os.O_RDWR | os.O_NOCTTY | os.O_NONBLOCK)
FileNotFoundError: [Errno 2] No such file or directory: '/dev/ttyUSB1'

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "/srv/homeassistant/lib/python3.5/site-packages/homeassistant/setup.py", line 142, in _async_setup_component
    result = await component.async_setup(hass, processed_config)
  File "/srv/homeassistant/lib/python3.5/site-packages/homeassistant/components/zha/__init__.py", line 101, in async_setup
    await radio.connect(usb_path, baudrate)
  File "/srv/homeassistant/lib/python3.5/site-packages/bellows/ezsp.py", line 30, in connect
    self._gw = yield from uart.connect(device, baudrate, self)
  File "/srv/homeassistant/lib/python3.5/site-packages/bellows/uart.py", line 269, in connect
    xonxoff=True,
  File "/usr/lib/python3.5/asyncio/coroutines.py", line 210, in coro
    res = func(*args, **kw)
  File "/srv/homeassistant/lib/python3.5/site-packages/serial_asyncio/__init__.py", line 410, in create_serial_connection
    ser = serial.serial_for_url(*args, **kwargs)
  File "/srv/homeassistant/lib/python3.5/site-packages/serial/__init__.py", line 88, in serial_for_url
    instance.open()
  File "/srv/homeassistant/lib/python3.5/site-packages/serial/serialposix.py", line 268, in open
    raise SerialException(msg.errno, "could not open port {}: {}".format(self._port, msg))
serial.serialutil.SerialException: [Errno 2] could not open port /dev/ttyUSB1: [Errno 2] No such file or directory: '/dev/ttyUSB1'
, level=ERROR, timestamp=1524958084.8427458, message=Error during setup of component zha, source=components/zha/__init__.py>
2018-04-28 23:28:04 INFO (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: domain=persistent_notification, service_call_id=1976282032-2, service=create, service_data=notification_id=invalid_config, message=The following components and platforms could not be set up:

 - [zha](https://home-assistant.io/components/zha/)

Please check your config., title=Invalid config>
2018-04-28 23:28:04 ERROR (MainThread) [homeassistant.setup] Error during setup of component zwave
Traceback (most recent call last):
  File "/srv/homeassistant/lib/python3.5/site-packages/openzwave/option.py", line 78, in __init__
    raise ZWaveException(u"Can't find device %s : %s" % (device, traceback.format_exception(*sys.exc_info())))
openzwave.object.ZWaveException: "Zwave Generic Exception : Can't find device /dev/ttyUSB0 : ['NoneType: None\\n']"

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "/srv/homeassistant/lib/python3.5/site-packages/homeassistant/setup.py", line 145, in _async_setup_component
    component.setup, hass, processed_config)
  File "/usr/lib/python3.5/asyncio/futures.py", line 380, in __iter__
    yield self  # This tells Task to wait for completion.
  File "/usr/lib/python3.5/asyncio/tasks.py", line 304, in _wakeup
    future.result()
  File "/usr/lib/python3.5/asyncio/futures.py", line 293, in result
    raise self._exception
  File "/usr/lib/python3.5/concurrent/futures/thread.py", line 55, in run
    result = self.fn(*self.args, **self.kwargs)
  File "/srv/homeassistant/lib/python3.5/site-packages/homeassistant/components/zwave/__init__.py", line 243, in setup
    config_path=config[DOMAIN].get(CONF_CONFIG_PATH))
  File "/srv/homeassistant/lib/python3.5/site-packages/openzwave/option.py", line 81, in __init__
    raise ZWaveException(u"Error when retrieving device %s : %s" % (device, traceback.format_exception(*sys.exc_info())))
openzwave.object.ZWaveException: 'Zwave Generic Exception : Error when retrieving device /dev/ttyUSB0 : [\'Traceback (most recent call last):\\n\', \'  File "/srv/homeassistant/lib/python3.5/site-packages/openzwave/option.py", line 78, in __init__\\n    raise ZWaveException(u"Can\\\'t find device %s : %s" % (device, traceback.format_exception(*sys.exc_info())))\\n\', \'openzwave.object.ZWaveException: "Zwave Generic Exception : Can\\\'t find device /dev/ttyUSB0 : [\\\'NoneType: None\\\\\\\\n\\\']"\\n\']'
2018-04-28 23:28:04 INFO (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: new_state=<state persistent_notification.invalid_config=notifying; message=The following components and platforms could not be set up:

 - [zha](https://home-assistant.io/components/zha/)

Please check your config., title=Invalid config @ 2018-04-28T19:28:04.945772-04:00>, entity_id=persistent_notification.invalid_config, old_state=None>
2018-04-28 23:28:04 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_executed[L]: service_call_id=1976282032-2>
2018-04-28 23:28:04 INFO (MainThread) [homeassistant.core] Bus:Handling <Event system_log_event[L]: exception=Traceback (most recent call last):
  File "/srv/homeassistant/lib/python3.5/site-packages/openzwave/option.py", line 78, in __init__
    raise ZWaveException(u"Can't find device %s : %s" % (device, traceback.format_exception(*sys.exc_info())))
openzwave.object.ZWaveException: "Zwave Generic Exception : Can't find device /dev/ttyUSB0 : ['NoneType: None\\n']"

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "/srv/homeassistant/lib/python3.5/site-packages/homeassistant/setup.py", line 145, in _async_setup_component
    component.setup, hass, processed_config)
  File "/usr/lib/python3.5/asyncio/futures.py", line 380, in __iter__
    yield self  # This tells Task to wait for completion.
  File "/usr/lib/python3.5/asyncio/tasks.py", line 304, in _wakeup
    future.result()
  File "/usr/lib/python3.5/asyncio/futures.py", line 293, in result
    raise self._exception
  File "/usr/lib/python3.5/concurrent/futures/thread.py", line 55, in run
    result = self.fn(*self.args, **self.kwargs)
  File "/srv/homeassistant/lib/python3.5/site-packages/homeassistant/components/zwave/__init__.py", line 243, in setup
    config_path=config[DOMAIN].get(CONF_CONFIG_PATH))
  File "/srv/homeassistant/lib/python3.5/site-packages/openzwave/option.py", line 81, in __init__
    raise ZWaveException(u"Error when retrieving device %s : %s" % (device, traceback.format_exception(*sys.exc_info())))
openzwave.object.ZWaveException: 'Zwave Generic Exception : Error when retrieving device /dev/ttyUSB0 : [\'Traceback (most recent call last):\\n\', \'  File "/srv/homeassistant/lib/python3.5/site-packages/openzwave/option.py", line 78, in __init__\\n    raise ZWaveException(u"Can\\\'t find device %s : %s" % (device, traceback.format_exception(*sys.exc_info())))\\n\', \'openzwave.object.ZWaveException: "Zwave Generic Exception : Can\\\'t find device /dev/ttyUSB0 : [\\\'NoneType: None\\\\\\\\n\\\']"\\n\']'
, level=ERROR, timestamp=1524958084.8769052, message=Error during setup of component zwave, source=components/zwave/__init__.py>
2018-04-28 23:28:04 INFO (MainThread) [homeassistant.core] Bus:Handling <Event call_service[L]: domain=persistent_notification, service_call_id=1976282032-3, service=create, service_data=notification_id=invalid_config, message=The following components and platforms could not be set up:

 - [zwave](https://home-assistant.io/components/zwave/)
 - [zha](https://home-assistant.io/components/zha/)

Please check your config., title=Invalid config>
2018-04-28 23:28:04 INFO (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: new_state=<state persistent_notification.invalid_config=notifying; message=The following components and platforms could not be set up:

 - [zwave](https://home-assistant.io/components/zwave/)
 - [zha](https://home-assistant.io/components/zha/)

Please check your config., title=Invalid config @ 2018-04-28T19:28:04.945772-04:00>, entity_id=persistent_notification.invalid_config, old_state=<state persistent_notification.invalid_config=notifying; message=The following components and platforms could not be set up:

 - [zha](https://home-assistant.io/components/zha/)

Please check your config., title=Invalid config @ 2018-04-28T19:28:04.945772-04:00>>
2018-04-28 23:28:04 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_executed[L]: service_call_id=1976282032-3>
2018-04-28 23:28:05 INFO (MainThread) [homeassistant.setup] Setting up updater
2018-04-28 23:28:05 INFO (MainThread) [homeassistant.setup] Setup of domain updater took 0.0 seconds.
2018-04-28 23:28:05 INFO (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=updater>
2018-04-28 23:28:05 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.yr
2018-04-28 23:28:05 INFO (MainThread) [homeassistant.setup] Setting up tts
2018-04-28 23:28:05 INFO (MainThread) [homeassistant.setup] Setting up cloud
2018-04-28 23:28:05 INFO (MainThread) [homeassistant.setup] Setup of domain cloud took 0.0 seconds.
2018-04-28 23:28:05 INFO (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=cloud>
2018-04-28 23:28:05 INFO (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: new_state=<state sensor.yr_symbol=unknown; entity_picture=https://api.met.no/weatherapi/weathericon/1.1/?symbol=None;content_type=image/png, friendly_name=yr Symbol, attribution=Weather forecast from met.no, delivered by the Norwegian Meteorological Institute. @ 2018-04-28T19:28:05.644587-04:00>, entity_id=sensor.yr_symbol, old_state=None>
2018-04-28 23:28:05 INFO (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=config.config_entries>
2018-04-28 23:28:05 INFO (MainThread) [homeassistant.setup] Setup of domain config took 3.3 seconds.
2018-04-28 23:28:05 INFO (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=config>
2018-04-28 23:28:05 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=tts, service=google_say>
2018-04-28 23:28:05 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=tts, service=clear_cache>
2018-04-28 23:28:05 INFO (MainThread) [homeassistant.setup] Setup of domain tts took 0.3 seconds.
2018-04-28 23:28:05 INFO (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=tts>
2018-04-28 23:28:07 INFO (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: new_state=<state sensor.yr_symbol=1; entity_picture=https://api.met.no/weatherapi/weathericon/1.1/?symbol=1;content_type=image/png, friendly_name=yr Symbol, attribution=Weather forecast from met.no, delivered by the Norwegian Meteorological Institute. @ 2018-04-28T19:28:07.081712-04:00>, entity_id=sensor.yr_symbol, old_state=<state sensor.yr_symbol=unknown; entity_picture=https://api.met.no/weatherapi/weathericon/1.1/?symbol=None;content_type=image/png, friendly_name=yr Symbol, attribution=Weather forecast from met.no, delivered by the Norwegian Meteorological Institute. @ 2018-04-28T19:28:05.644587-04:00>>
2018-04-28 23:28:07 INFO (MainThread) [homeassistant.setup] Setup of domain sensor took 5.3 seconds.
2018-04-28 23:28:07 INFO (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=sensor>
2018-04-28 23:28:07 INFO (MainThread) [homeassistant.bootstrap] Home Assistant initialized in 11.15s
2018-04-28 23:28:07 INFO (MainThread) [homeassistant.core] Starting Home Assistant core loop
2018-04-28 23:28:07 INFO (MainThread) [homeassistant.core] Starting Home Assistant
2018-04-28 23:28:07 INFO (MainThread) [homeassistant.core] Bus:Handling <Event homeassistant_start[L]>
2018-04-28 23:28:07 INFO (MainThread) [homeassistant.core] Timer:starting
2018-04-28 23:28:10 INFO (MainThread) [homeassistant.components.http.view] Serving /api/websocket to 10.0.0.209 (auth: True)
2018-04-28 23:28:10 INFO (MainThread) [homeassistant.components.http.view] Serving /api/translations/en to 10.0.0.209 (auth: True)
2018-04-28 23:28:11 INFO (MainThread) [homeassistant.loader] Loaded deconz from homeassistant.components.deconz
2018-04-28 23:28:11 INFO (MainThread) [homeassistant.loader] Loaded hue from homeassistant.components.hue
2018-04-28 23:28:19 INFO (MainThread) [homeassistant.components.discovery] Unknown service discovered: webos_tv {'model_name': 'LG Smart TV', 'model_number': '65LF6350-UA', 'serial': None, 'udn': 'uuid:6e454a21-226c-01c0-6498-beb382e2ef25', 'host': '10.0.0.177', 'port': 1813, 'name': '[LG] webOS TV LF6350', 'ssdp_description': 'http://10.0.0.177:1813/', 'manufacturer': 'LG Electronics'}
2018-04-28 23:28:19 INFO (MainThread) [homeassistant.components.discovery] Unknown service discovered: spotify_connect {'properties': {'CPath': '/spConn'}, 'hostname': 'PS4-060158.local.', 'host': '10.0.0.228', 'port': 41800}
2018-04-28 23:28:19 INFO (MainThread) [homeassistant.components.discovery] Found new service: google_cast {'properties': {'rs': False, 'id': '1f8f827e7b2a2da179d9ca381ef96871', 'md': 'Chromecast', 'bs': 'FA8FCA3A9C24', 'cd': '562776587E41750291172FA7AD0C2B5C', 'fn': 'Basement Dweller', 'nf': '1', 'ic': '/setup/icon.png', 'st': '0', 'ca': '4101', 've': '05', 'rm': False}, 'hostname': '1f8f827e-7b2a-2da1-79d9-ca381ef96871.local.', 'host': '10.0.0.193', 'port': 8009}
2018-04-28 23:28:19 INFO (MainThread) [homeassistant.loader] Loaded media_player from homeassistant.components.media_player
2018-04-28 23:28:19 INFO (MainThread) [homeassistant.setup] Setting up media_player
2018-04-28 23:28:19 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=play_media>
2018-04-28 23:28:19 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=select_source>
2018-04-28 23:28:19 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=turn_off>
2018-04-28 23:28:19 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=volume_set>
2018-04-28 23:28:19 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=media_previous_track>
2018-04-28 23:28:19 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=volume_down>
2018-04-28 23:28:19 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=media_pause>
2018-04-28 23:28:19 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=media_stop>
2018-04-28 23:28:19 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=shuffle_set>
2018-04-28 23:28:19 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=media_play>
2018-04-28 23:28:19 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=toggle>
2018-04-28 23:28:19 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=turn_on>
2018-04-28 23:28:19 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=clear_playlist>
2018-04-28 23:28:19 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=media_next_track>
2018-04-28 23:28:19 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=volume_mute>
2018-04-28 23:28:19 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=volume_up>
2018-04-28 23:28:19 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=media_play_pause>
2018-04-28 23:28:19 INFO (MainThread) [homeassistant.core] Bus:Handling <Event service_registered[L]: domain=media_player, service=media_seek>
2018-04-28 23:28:19 INFO (MainThread) [homeassistant.setup] Setup of domain media_player took 0.0 seconds.
2018-04-28 23:28:19 INFO (MainThread) [homeassistant.core] Bus:Handling <Event component_loaded[L]: component=media_player>
2018-04-28 23:28:19 INFO (MainThread) [homeassistant.core] Bus:Handling <Event platform_discovered[L]: discovered=properties=rs=False, id=1f8f827e7b2a2da179d9ca381ef96871, md=Chromecast, bs=FA8FCA3A9C24, cd=562776587E41750291172FA7AD0C2B5C, fn=Basement Dweller, nf=1, ic=/setup/icon.png, st=0, ca=4101, ve=05, rm=False, hostname=1f8f827e-7b2a-2da1-79d9-ca381ef96871.local., host=10.0.0.193, port=8009, platform=cast, service=load_platform.media_player>
2018-04-28 23:28:20 INFO (MainThread) [homeassistant.loader] Loaded media_player.cast from homeassistant.components.media_player.cast
2018-04-28 23:28:20 INFO (MainThread) [homeassistant.components.media_player] Setting up media_player.cast
2018-04-28 23:28:20 INFO (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: new_state=<state media_player.basement_dweller=unavailable; friendly_name=Basement Dweller, supported_features=21437 @ 2018-04-28T19:28:20.512778-04:00>, entity_id=media_player.basement_dweller, old_state=None>
2018-04-28 23:28:20 INFO (Thread-19) [pychromecast] Querying device status
2018-04-28 23:28:20 INFO (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: new_state=<state media_player.basement_dweller=off; friendly_name=Basement Dweller, supported_features=21437 @ 2018-04-28T19:28:20.600501-04:00>, entity_id=media_player.basement_dweller, old_state=<state media_player.basement_dweller=unavailable; friendly_name=Basement Dweller, supported_features=21437 @ 2018-04-28T19:28:20.512778-04:00>>
2018-04-28 23:28:30 INFO (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: new_state=<state sun.sun=above_horizon; next_dawn=2018-04-29T10:00:15+00:00, next_dusk=2018-04-29T00:59:11+00:00, friendly_name=Sun, elevation=10.28, next_setting=2018-04-29T00:28:42+00:00, azimuth=280.62, next_rising=2018-04-29T10:30:51+00:00, next_midnight=2018-04-29T05:30:15+00:00, next_noon=2018-04-29T17:30:21+00:00 @ 2018-04-28T19:28:02.297199-04:00>, entity_id=sun.sun, old_state=<state sun.sun=above_horizon; next_dawn=2018-04-29T10:00:15+00:00, next_dusk=2018-04-29T00:59:11+00:00, friendly_name=Sun, elevation=10.37, next_setting=2018-04-29T00:28:42+00:00, azimuth=280.54, next_rising=2018-04-29T10:30:51+00:00, next_midnight=2018-04-29T05:30:15+00:00, next_noon=2018-04-29T17:30:21+00:00 @ 2018-04-28T19:28:02.297199-04:00>>
2018-04-28 23:29:30 INFO (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: new_state=<state sun.sun=above_horizon; next_dawn=2018-04-29T10:00:15+00:00, next_dusk=2018-04-29T00:59:11+00:00, friendly_name=Sun, elevation=10.1, next_setting=2018-04-29T00:28:42+00:00, azimuth=280.78, next_rising=2018-04-29T10:30:51+00:00, next_midnight=2018-04-29T05:30:15+00:00, next_noon=2018-04-29T17:30:21+00:00 @ 2018-04-28T19:28:02.297199-04:00>, entity_id=sun.sun, old_state=<state sun.sun=above_horizon; next_dawn=2018-04-29T10:00:15+00:00, next_dusk=2018-04-29T00:59:11+00:00, friendly_name=Sun, elevation=10.28, next_setting=2018-04-29T00:28:42+00:00, azimuth=280.62, next_rising=2018-04-29T10:30:51+00:00, next_midnight=2018-04-29T05:30:15+00:00, next_noon=2018-04-29T17:30:21+00:00 @ 2018-04-28T19:28:02.297199-04:00>>

I realize there are bloated state changes in here, sorry. If you look at these enough (i.e. you’re a dev), I figure you can filter out the crap… I have begun to from pouring over this stuff

ZStanard · May 18, 2018, 11:28pm

@sayboltm Did you ever get this working?

NotoriousBDG · May 19, 2018, 8:17pm

I had a similar issue. It turned out that I received a HUSBZ-1 instead of the HUSBZB-1 that I had ordered. The former is z-wave only and the latter supports both z-wave and zigbee.

sayboltm · May 21, 2018, 2:27am

@ZStanard No, but I got busy with other projects and didn’t do my due diligence and poke around with the stick plugged into my linux box. I hope to allocate some time to home automation again soon as this is a wonderful open source project/community I really want to be a part of.

@NotoriousBDG that would explain everything! I’ll have to pull some hardware IDs and verify this… or just read the label carefully? How did you find out? (I don’t have mine in front of me, out of state for the next week) Wish I didn’t sit on this for so long, I probably lost out on the refund

sayboltm · May 21, 2018, 2:31am

@NotoriousBDG That’s it. Must have been a late night. It’s not even the vendors fault, but my own overlooking of one letter and the image of the product. I looked everywhere for the HUSBZB-1 and when I finally found what I thought was one (but is actually a HUSBZ-1) I ordered it. Seemed too easy. Maybe more suppliers will have the HUSBZB-1 in stock now, but someone told me Nortek discontinued it so what’s out there is all that is left.

Closing the thread.

On a side note, I found (am now still finding) it incredibly difficult to find a good zigbee stick. The zigbee bulbs are less than half the price of zwave and everywhere. Maybe I’ll start a new thread about development direction.

sayboltm · July 2, 2018, 4:31pm

I would just like to add that a vendor did indeed send me an HUSBZ-1 mistakenly, but I also ordered an HUSBZ-1 as well (I had two of them). Double check. Sometimes it’s the simple things.

amacomber · August 25, 2022, 10:44pm

This is exactly the correct thread to be in. I just had the exact same issue and this thread helped me identify that I had purchased the wrong adapter.