operating-system: CH340 based devices (like POPP ZB-Stick) stopped working in Home Assistant OS 6.3

Hardware Environment

  • Raspberry Pi [1/2/3/4]
  • ODROID [C2/C4/N2(+)/XU4]
  • ASUS Tinker [S]
  • Generic x86-64 (like Intel NUC)
  • OVA (Proxmox and virtual box)
  • Khadas VIM3

Home Assistant OS release:

  • Fresh installation of release 6.3
  • Updated from version 6.2
  • Additional information (if accessible):

System Health

version core-2021.9.3
installation_type Home Assistant OS
dev false
hassio true
docker true
user root
virtualenv false
python_version 3.9.6
os_name Linux
os_version 5.10.61
arch x86_64
timezone UTC
Home Assistant Cloud
logged_in false
can_reach_cert_server ok
can_reach_cloud_auth ok
can_reach_cloud ok
Home Assistant Supervisor
host_os Home Assistant OS 6.3
update_channel stable
supervisor_version supervisor-2021.09.0
docker_version 20.10.7
disk_total 30.8 GB
disk_used 2.7 GB
healthy true
supported true
board ova
supervisor_api ok
version_api ok
installed_addons Visual Studio Code (3.6.2), Log Viewer (0.11.1)
Lovelace
dashboards 1
resources 0
mode auto-gen

Supervisor logs:

[services.d] done.
[15:11:34] INFO: Starting local supervisor watchdog...
21-09-05 15:11:35 INFO (MainThread) [__main__] Initializing Supervisor setup
21-09-05 15:11:36 INFO (MainThread) [supervisor.bootstrap] Initializing Supervisor Sentry
21-09-05 18:11:36 INFO (MainThread) [supervisor.bootstrap] Seting up coresys for machine: qemux86-64
21-09-05 18:11:36 INFO (SyncWorker_0) [supervisor.docker.supervisor] Attaching to Supervisor homeassistant/amd64-hassio-supervisor with version 2021.09.0
21-09-05 18:11:36 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.INITIALIZE
21-09-05 18:11:36 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
21-09-05 18:11:36 INFO (MainThread) [__main__] Setting up Supervisor
21-09-05 18:11:36 INFO (MainThread) [supervisor.api] Starting API on 172.30.32.2
21-09-05 18:11:36 INFO (MainThread) [supervisor.hardware.monitor] Started Supervisor hardware monitor
21-09-05 18:11:36 INFO (MainThread) [supervisor.dbus.manager] Load dbus interface io.hass.os
21-09-05 18:11:36 INFO (MainThread) [supervisor.dbus.manager] Load dbus interface org.freedesktop.systemd1
21-09-05 18:11:36 INFO (MainThread) [supervisor.dbus.manager] Load dbus interface org.freedesktop.login1
21-09-05 18:11:36 INFO (MainThread) [supervisor.dbus.manager] Load dbus interface org.freedesktop.hostname1
21-09-05 18:11:36 INFO (MainThread) [supervisor.dbus.manager] Load dbus interface org.freedesktop.timedate1
21-09-05 18:11:36 INFO (MainThread) [supervisor.dbus.manager] Load dbus interface org.freedesktop.NetworkManager
21-09-05 18:11:36 INFO (MainThread) [supervisor.dbus.manager] Load dbus interface de.pengutronix.rauc
21-09-05 18:11:36 INFO (MainThread) [supervisor.host.info] Updating local host information
21-09-05 18:11:36 INFO (MainThread) [supervisor.host.services] Updating service information
21-09-05 18:11:36 INFO (MainThread) [supervisor.host.network] Updating local network information
21-09-05 18:11:37 INFO (MainThread) [supervisor.host.sound] Updating PulseAudio information
21-09-05 18:11:37 INFO (MainThread) [supervisor.host.manager] Host information reload completed
21-09-05 18:11:37 INFO (MainThread) [supervisor.host.apparmor] Loading AppArmor Profiles: {'hassio-supervisor'}
21-09-05 18:11:37 INFO (MainThread) [supervisor.host.services] Reloading local service hassos-apparmor.service
21-09-05 18:11:37 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to ghcr.io/home-assistant/amd64-hassio-dns with version 2021.06.0
21-09-05 18:11:37 INFO (MainThread) [supervisor.plugins.dns] Starting CoreDNS plugin
21-09-05 18:11:37 INFO (SyncWorker_0) [supervisor.docker.dns] Starting DNS ghcr.io/home-assistant/amd64-hassio-dns with version 2021.06.0 - 172.30.32.3
21-09-05 18:11:37 INFO (MainThread) [supervisor.plugins.dns] Updated /etc/resolv.conf
21-09-05 18:11:38 INFO (SyncWorker_1) [supervisor.docker.interface] Attaching to ghcr.io/home-assistant/amd64-hassio-audio with version 2021.07.0
21-09-05 18:11:38 INFO (MainThread) [supervisor.plugins.audio] Starting Audio plugin
21-09-05 18:11:38 INFO (SyncWorker_1) [supervisor.docker.audio] Starting Audio ghcr.io/home-assistant/amd64-hassio-audio with version 2021.07.0 - 172.30.32.4
21-09-05 18:11:38 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to ghcr.io/home-assistant/amd64-hassio-cli with version 2021.08.1
21-09-05 18:11:38 INFO (MainThread) [supervisor.plugins.cli] Starting CLI plugin
21-09-05 18:11:39 INFO (SyncWorker_0) [supervisor.docker.cli] Starting CLI ghcr.io/home-assistant/amd64-hassio-cli with version 2021.08.1 - 172.30.32.5
21-09-05 18:11:39 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to ghcr.io/home-assistant/amd64-hassio-observer with version 2021.06.0
21-09-05 18:11:39 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to ghcr.io/home-assistant/amd64-hassio-multicast with version 2021.04.0
21-09-05 18:11:39 INFO (MainThread) [supervisor.plugins.multicast] Starting Multicast plugin
21-09-05 18:11:39 INFO (SyncWorker_1) [supervisor.docker.multicast] Starting Multicast ghcr.io/home-assistant/amd64-hassio-multicast with version 2021.04.0 - Host
21-09-05 18:11:39 INFO (MainThread) [supervisor.updater] Fetching update data from https://version.home-assistant.io/stable.json
21-09-05 18:11:41 INFO (MainThread) [supervisor.homeassistant.secrets] Loaded 1 Home Assistant secrets
21-09-05 18:11:41 INFO (SyncWorker_2) [supervisor.docker.interface] Attaching to ghcr.io/home-assistant/qemux86-64-homeassistant with version 2021.9.3
21-09-05 18:11:42 INFO (MainThread) [supervisor.hassos] Detect Home Assistant Operating System 6.3 / BootSlot B
21-09-05 18:11:42 WARNING (MainThread) [supervisor.addons.validate] Add-on config 'snapshot_exclude' is deprecated, 'backup_exclude' should be used instead. Please report this to the maintainer of AdGuard Home
21-09-05 18:11:42 WARNING (MainThread) [supervisor.addons.validate] Add-on config 'snapshot_exclude' is deprecated, 'backup_exclude' should be used instead. Please report this to the maintainer of ESPHome
21-09-05 18:11:42 WARNING (MainThread) [supervisor.addons.validate] Add-on config 'snapshot' is deprecated, 'backup' should be used instead. Please report this to the maintainer of UniFi Controller
21-09-05 18:11:42 INFO (MainThread) [supervisor.store.git] Loading add-on /data/addons/git/a0d7b954 repository
21-09-05 18:11:42 INFO (MainThread) [supervisor.store.git] Loading add-on /data/addons/core repository
21-09-05 18:11:42 WARNING (MainThread) [supervisor.addons.validate] Add-on config 'snapshot_exclude' is deprecated, 'backup_exclude' should be used instead. Please report this to the maintainer of AdGuard Home
21-09-05 18:11:42 WARNING (MainThread) [supervisor.addons.validate] Add-on config 'snapshot_exclude' is deprecated, 'backup_exclude' should be used instead. Please report this to the maintainer of ESPHome
21-09-05 18:11:42 WARNING (MainThread) [supervisor.addons.validate] Add-on config 'snapshot' is deprecated, 'backup' should be used instead. Please report this to the maintainer of UniFi Controller
21-09-05 18:11:42 INFO (MainThread) [supervisor.store] Loading add-ons from store: 63 all - 63 new - 0 remove
21-09-05 18:11:42 INFO (MainThread) [supervisor.addons] Found 2 installed add-ons
21-09-05 18:11:42 INFO (SyncWorker_2) [supervisor.docker.interface] Attaching to ghcr.io/hassio-addons/log-viewer/amd64 with version 0.11.1
21-09-05 18:11:42 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to ghcr.io/hassio-addons/vscode/amd64 with version 3.6.2
21-09-05 18:11:42 INFO (MainThread) [supervisor.backups.manager] Found 0 backup files
21-09-05 18:11:42 INFO (MainThread) [supervisor.discovery] Loaded 0 messages
21-09-05 18:11:42 INFO (MainThread) [supervisor.ingress] Loaded 0 ingress sessions
21-09-05 18:11:42 INFO (MainThread) [supervisor.resolution.check] Starting system checks with state CoreState.SETUP
21-09-05 18:11:42 INFO (MainThread) [supervisor.resolution.check] System checks complete
21-09-05 18:11:42 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.SETUP
21-09-05 18:11:42 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
21-09-05 18:11:42 INFO (MainThread) [supervisor.jobs] 'ResolutionFixup.run_autofix' blocked from execution, system is not running - CoreState.SETUP
21-09-05 18:11:42 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.SETUP
21-09-05 18:11:42 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
21-09-05 18:11:42 INFO (MainThread) [__main__] Running Supervisor
21-09-05 18:11:42 INFO (MainThread) [supervisor.hassos] Rauc: B - marked slot kernel.1 as good
21-09-05 18:11:42 INFO (MainThread) [supervisor.addons] Phase 'AddonStartup.INITIALIZE' starting 0 add-ons
21-09-05 18:11:42 INFO (MainThread) [supervisor.addons] Phase 'AddonStartup.SYSTEM' starting 0 add-ons
21-09-05 18:11:42 INFO (MainThread) [supervisor.addons] Phase 'AddonStartup.SERVICES' starting 1 add-ons
21-09-05 18:11:43 INFO (SyncWorker_0) [supervisor.docker.addon] Starting Docker add-on ghcr.io/hassio-addons/vscode/amd64 with version 3.6.2
21-09-05 18:11:48 INFO (MainThread) [supervisor.core] Start Home Assistant Core
21-09-05 18:11:48 INFO (SyncWorker_2) [supervisor.docker.interface] Starting homeassistant
21-09-05 18:11:48 INFO (MainThread) [supervisor.homeassistant.core] Wait until Home Assistant is ready
21-09-05 18:11:52 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.STARTUP
21-09-05 18:11:52 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
21-09-05 18:11:53 INFO (MainThread) [supervisor.homeassistant.api] Updated Home Assistant API token
21-09-05 18:12:03 INFO (MainThread) [supervisor.homeassistant.core] Detect a running Home Assistant instance
21-09-05 18:12:03 INFO (MainThread) [supervisor.addons] Phase 'AddonStartup.APPLICATION' starting 1 add-ons
21-09-05 18:12:04 INFO (SyncWorker_0) [supervisor.docker.addon] Starting Docker add-on ghcr.io/hassio-addons/log-viewer/amd64 with version 0.11.1
21-09-05 18:12:09 INFO (MainThread) [supervisor.misc.tasks] All core tasks are scheduled
21-09-05 18:12:09 INFO (MainThread) [supervisor.core] Supervisor is up and running
21-09-05 18:12:09 INFO (MainThread) [supervisor.host.info] Updating local host information
21-09-05 18:12:09 INFO (MainThread) [supervisor.resolution.check] Starting system checks with state CoreState.RUNNING
21-09-05 18:12:09 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.TRUST/ContextType.CORE
21-09-05 18:12:09 INFO (MainThread) [supervisor.host.services] Updating service information
21-09-05 18:12:09 INFO (MainThread) [supervisor.host.network] Updating local network information
21-09-05 18:12:10 INFO (MainThread) [supervisor.host.sound] Updating PulseAudio information
21-09-05 18:12:10 INFO (MainThread) [supervisor.host.manager] Host information reload completed
21-09-05 18:12:11 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.FREE_SPACE/ContextType.SYSTEM
21-09-05 18:12:11 INFO (MainThread) [supervisor.resolution.module] Create new suggestion SuggestionType.CREATE_FULL_BACKUP - ContextType.SYSTEM / None
21-09-05 18:12:11 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.TRUST/ContextType.SUPERVISOR
21-09-05 18:12:12 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.PWNED/ContextType.ADDON
21-09-05 18:12:12 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.TRUST/ContextType.PLUGIN
21-09-05 18:12:21 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.SECURITY/ContextType.CORE
21-09-05 18:12:21 INFO (MainThread) [supervisor.resolution.check] System checks complete
21-09-05 18:12:21 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.RUNNING
21-09-05 18:12:23 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
21-09-05 18:12:23 INFO (MainThread) [supervisor.resolution.fixup] Starting system autofix at state CoreState.RUNNING
21-09-05 18:12:23 INFO (MainThread) [supervisor.resolution.fixup] System autofix complete

Journal logs:

Kernel logs:

Description of problem:

Hello

With POPP ZA-STICK I created 4 installs of HAOS 2 on Proxmox with versions 6.2 and 6.3 2 on VM box under window with versions 6.2 and 6.3

When I try to add the integration using this turorial in both 6.2 versions ( under Proxmox and VM box) it worked perfectly fine

After trying the same in version 6.3 the integration does not work.

Furthermore I updated both 6.2 VMs to 6.3 and the integration stopped working.

Also I tried to downgrade both 6.3 to 6.2 and guess what - the integration started working again.

Log Provider Core:

 File "/usr/local/lib/python3.9/site-packages/bellows/zigbee/application.py", line 151, in startup
    status, node_type, nwk_params = await ezsp.getNetworkParameters()
  File "/usr/local/lib/python3.9/asyncio/tasks.py", line 494, in wait_for
    raise exceptions.TimeoutError() from exc
asyncio.exceptions.TimeoutError
2021-09-05 18:16:29 ERROR (MainThread) [zigpy.application] Couldn't start application
2021-09-05 18:16:29 ERROR (MainThread) [homeassistant.components.zha.core.gateway] Couldn't start EZSP = Silicon Labs EmberZNet protocol: Elelabs, HUSBZB-1, Telegesis coordinator
Traceback (most recent call last):
  File "/usr/local/lib/python3.9/asyncio/tasks.py", line 492, in wait_for
    fut.result()
asyncio.exceptions.CancelledError
The above exception was the direct cause of the following exception:
Traceback (most recent call last):
  File "/usr/src/homeassistant/homeassistant/components/zha/core/gateway.py", line 152, in async_initialize
    self.application_controller = await app_controller_cls.new(
  File "/usr/local/lib/python3.9/site-packages/zigpy/application.py", line 69, in new
    await app.startup(auto_form)
  File "/usr/local/lib/python3.9/site-packages/bellows/zigbee/application.py", line 151, in startup
    status, node_type, nwk_params = await ezsp.getNetworkParameters()
  File "/usr/local/lib/python3.9/asyncio/tasks.py", line 494, in wait_for
    raise exceptions.TimeoutError() from exc
asyncio.exceptions.TimeoutError
......

About this issue

  • Original URL
  • State: closed
  • Created 3 years ago
  • Comments: 18 (7 by maintainers)

Most upvoted comments

I can confirm that after upgrading to HASS OS 6.4, the integration started working.

Kernel update is the reason for this problem, as described here: https://github.com/Koenkk/zigbee2mqtt/issues/8623#issuecomment-913202614

I experienced this issue myself with zigbee2mqtt and managed to confirm that previous kernels are working fine, but 5.10 and above can repro the problem with some Aqara devices (such as the door contact sensor)

For now, if you experience issues with CH340 devices, please revert back to 6.2 until 6.4 is out:

ha os update --version 6.2