search

home-assistant / core

:house_with_garden: Open source home automation that puts local control and privacy first.
https://www.home-assistant.io
Apache License 2.0
72.13k stars 30.18k forks source link

ZHA unable to start after update to 2023.10.4 #102459

Closed TheGabeMan closed 11 months ago

TheGabeMan commented 11 months ago

The problem

After updating from 2023.10.3 to 10.4, I'm unable to start ZHA. I did a few restarts of HA and even did a complete shutdown and poweron of the VM, but ZHA can't start anymore. I have no serial connection to a stick for HA, I'm using Wifi to Sonoff Bridge.

I'm running HA in a VM and made a snapshot before upgrading. After I couldn't solve the ZHA problem, I reverted back to the snapshot (2023.10.3) and ZHA worked without issues.

What version of Home Assistant Core has the issue?

core-2023.10.4

What was the last working version of Home Assistant Core?

core-2023.10.3

What type of installation are you running?

Home Assistant OS

Integration causing the issue

ZHA

Link to integration documentation on our website

https://www.home-assistant.io/integrations/zha

Diagnostics information

No response

Example YAML snippet

No response

Anything in the logs that might be useful for us?

2023-10-21 15:17:32.963 ERROR (MainThread) [homeassistant] Error doing job: Fatal error: protocol.data_received() call failed.
Traceback (most recent call last):
File "/usr/local/lib/python3.11/asyncio/selector_events.py", line 1003, in _read_ready__data_received
self._protocol.data_received(data)
File "/usr/local/lib/python3.11/site-packages/bellows/uart.py", line 81, in data_received
self.frame_received(frame)
File "/usr/local/lib/python3.11/site-packages/bellows/uart.py", line 108, in frame_received
self.data_frame_received(data)
File "/usr/local/lib/python3.11/site-packages/bellows/uart.py", line 129, in data_frame_received
self._application.frame_received(self._randomize(data[1:-3]))
File "/usr/local/lib/python3.11/site-packages/bellows/ezsp/__init__.py", line 337, in frame_received
self._protocol(data)
File "/usr/local/lib/python3.11/site-packages/bellows/ezsp/protocol.py", line 119, in __call__
assert expected_id == frame_id
^^^^^^^^^^^^^^^^^^^^^^^
AssertionError
2023-10-21 15:17:32.966 ERROR (MainThread) [bellows.uart] Lost serial connection: AssertionError()
2023-10-21 15:17:32.966 INFO (MainThread) [bellows.ezsp] NCP entered failed state. No application handler registered, ignoring...
2023-10-21 15:17:34.199 WARNING (MainThread) [homeassistant.helpers.template] Template variable warning: 'dict object' has no attribute 'hum' when rendering '{{ value_json.hum }}'
2023-10-21 15:17:34.199 WARNING (MainThread) [homeassistant.helpers.template] Template variable warning: 'dict object' has no attribute 'temp' when rendering '{{ value_json.temp }}'
2023-10-21 15:17:37.893 ERROR (MainThread) [zigpy.application] Couldn't start application
Traceback (most recent call last):
File "/usr/local/lib/python3.11/site-packages/bellows/ezsp/protocol.py", line 68, in command
return await future
^^^^^^^^^^^^
asyncio.exceptions.CancelledError
The above exception was the direct cause of the following exception:
Traceback (most recent call last):
File "/usr/local/lib/python3.11/site-packages/zigpy/application.py", line 198, in startup
await self.initialize(auto_form=auto_form)
File "/usr/local/lib/python3.11/site-packages/zigpy/application.py", line 150, in initialize
await self.start_network()
File "/usr/local/lib/python3.11/site-packages/bellows/zigbee/application.py", line 184, in start_network
await self._reset()
File "/usr/local/lib/python3.11/site-packages/bellows/ezsp/protocol.py", line 67, in command
async with asyncio_timeout(EZSP_CMD_TIMEOUT):
File "/usr/local/lib/python3.11/asyncio/timeouts.py", line 111, in __aexit__
raise TimeoutError from exc_val
TimeoutError
2023-10-21 15:17:37.998 WARNING (MainThread) [homeassistant.components.zha.core.gateway] Couldn't start EZSP = Silicon Labs EmberZNet protocol: Elelabs, HUSBZB-1, Telegesis coordinator (attempt 1 of 3)
Traceback (most recent call last):
File "/usr/local/lib/python3.11/site-packages/bellows/ezsp/protocol.py", line 68, in command
return await future
^^^^^^^^^^^^
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 201, in async_initialize
await self.application_controller.startup(auto_form=True)
File "/usr/local/lib/python3.11/site-packages/zigpy/application.py", line 198, in startup
await self.initialize(auto_form=auto_form)
File "/usr/local/lib/python3.11/site-packages/zigpy/application.py", line 150, in initialize
await self.start_network()
File "/usr/local/lib/python3.11/site-packages/bellows/zigbee/application.py", line 184, in start_network
await self._reset()
File "/usr/local/lib/python3.11/site-packages/bellows/ezsp/protocol.py", line 67, in command
async with asyncio_timeout(EZSP_CMD_TIMEOUT):
File "/usr/local/lib/python3.11/asyncio/timeouts.py", line 111, in __aexit__
raise TimeoutError from exc_val
TimeoutError
2023-10-21 15:17:44.215 WARNING (MainThread) [homeassistant.helpers.template] Template variable warning: 'dict object' has no attribute 'hum' when rendering '{{ value_json.hum }}'
2023-10-21 15:17:44.215 WARNING (MainThread) [homeassistant.helpers.template] Template variable warning: 'dict object' has no attribute 'temp' when rendering '{{ value_json.temp }}'
2023-10-21 15:17:44.428 INFO (MainThread) [reolink_aio.api] Reolink reo01 ONVIF event channel 0, Motion: False
2023-10-21 15:17:44.428 INFO (MainThread) [reolink_aio.api] Reolink reo01 ONVIF event channel 0, FaceDetect: False
2023-10-21 15:17:44.428 INFO (MainThread) [reolink_aio.api] Reolink reo01 ONVIF event channel 0, PeopleDetect: False
2023-10-21 15:17:44.428 INFO (MainThread) [reolink_aio.api] Reolink reo01 ONVIF event channel 0, VehicleDetect: False
2023-10-21 15:17:44.428 INFO (MainThread) [reolink_aio.api] Reolink reo01 ONVIF event channel 0, DogCatDetect: False
2023-10-21 15:17:44.428 INFO (MainThread) [reolink_aio.api] Reolink reo01 ONVIF event channel 0, MotionAlarm: False
2023-10-21 15:17:44.442 INFO (MainThread) [reolink_aio.api] Reolink reo01 ONVIF event channel 0, Motion: False
2023-10-21 15:17:44.442 INFO (MainThread) [reolink_aio.api] Reolink reo01 ONVIF event channel 0, FaceDetect: False
2023-10-21 15:17:44.442 INFO (MainThread) [reolink_aio.api] Reolink reo01 ONVIF event channel 0, PeopleDetect: False
2023-10-21 15:17:44.442 INFO (MainThread) [reolink_aio.api] Reolink reo01 ONVIF event channel 0, VehicleDetect: False
2023-10-21 15:17:44.442 INFO (MainThread) [reolink_aio.api] Reolink reo01 ONVIF event channel 0, DogCatDetect: False
2023-10-21 15:17:44.442 INFO (MainThread) [reolink_aio.api] Reolink reo01 ONVIF event channel 0, MotionAlarm: False
2023-10-21 15:17:49.530 ERROR (MainThread) [homeassistant] Error doing job: Fatal error: protocol.data_received() call failed.
Traceback (most recent call last):
File "/usr/local/lib/python3.11/asyncio/selector_events.py", line 1003, in _read_ready__data_received
self._protocol.data_received(data)
File "/usr/local/lib/python3.11/site-packages/bellows/uart.py", line 81, in data_received
self.frame_received(frame)
File "/usr/local/lib/python3.11/site-packages/bellows/uart.py", line 108, in frame_received
self.data_frame_received(data)
File "/usr/local/lib/python3.11/site-packages/bellows/uart.py", line 129, in data_frame_received
self._application.frame_received(self._randomize(data[1:-3]))
File "/usr/local/lib/python3.11/site-packages/bellows/ezsp/__init__.py", line 337, in frame_received
self._protocol(data)
File "/usr/local/lib/python3.11/site-packages/bellows/ezsp/protocol.py", line 119, in __call__
assert expected_id == frame_id
^^^^^^^^^^^^^^^^^^^^^^^
AssertionError
2023-10-21 15:17:49.533 ERROR (MainThread) [bellows.uart] Lost serial connection: AssertionError()
2023-10-21 15:17:49.533 INFO (MainThread) [bellows.ezsp] NCP entered failed state. No application handler registered, ignoring...
2023-10-21 15:17:54.247 WARNING (MainThread) [homeassistant.helpers.template] Template variable warning: 'dict object' has no attribute 'hum' when rendering '{{ value_json.hum }}'
2023-10-21 15:17:54.247 WARNING (MainThread) [homeassistant.helpers.template] Template variable warning: 'dict object' has no attribute 'temp' when rendering '{{ value_json.temp }}'
2023-10-21 15:17:54.470 ERROR (MainThread) [zigpy.application] Couldn't start application
Traceback (most recent call last):
File "/usr/local/lib/python3.11/site-packages/bellows/ezsp/protocol.py", line 68, in command
return await future
^^^^^^^^^^^^
asyncio.exceptions.CancelledError
The above exception was the direct cause of the following exception:
Traceback (most recent call last):
File "/usr/local/lib/python3.11/site-packages/zigpy/application.py", line 198, in startup
await self.initialize(auto_form=auto_form)
File "/usr/local/lib/python3.11/site-packages/zigpy/application.py", line 150, in initialize
await self.start_network()
File "/usr/local/lib/python3.11/site-packages/bellows/zigbee/application.py", line 184, in start_network
await self._reset()
File "/usr/local/lib/python3.11/site-packages/bellows/ezsp/protocol.py", line 67, in command
async with asyncio_timeout(EZSP_CMD_TIMEOUT):
File "/usr/local/lib/python3.11/asyncio/timeouts.py", line 111, in __aexit__
raise TimeoutError from exc_val
TimeoutError
2023-10-21 15:17:54.474 WARNING (MainThread) [homeassistant.components.zha.core.gateway] Couldn't start EZSP = Silicon Labs EmberZNet protocol: Elelabs, HUSBZB-1, Telegesis coordinator (attempt 2 of 3)
Traceback (most recent call last):
File "/usr/local/lib/python3.11/site-packages/bellows/ezsp/protocol.py", line 68, in command
return await future
^^^^^^^^^^^^
asyncio.exceptions.CancelledError
The above exception was the direct cause of the following exception:
Traceback (most recent call last):
File "/usr/local/lib/python3.11/site-packages/zigpy/application.py", line 198, in startup
await self.initialize(auto_form=auto_form)
File "/usr/local/lib/python3.11/site-packages/zigpy/application.py", line 150, in initialize
await self.start_network()
File "/usr/local/lib/python3.11/site-packages/bellows/zigbee/application.py", line 184, in start_network
await self._reset()
File "/usr/local/lib/python3.11/site-packages/bellows/ezsp/protocol.py", line 67, in command
async with asyncio_timeout(EZSP_CMD_TIMEOUT):
File "/usr/local/lib/python3.11/asyncio/timeouts.py", line 111, in __aexit__
raise TimeoutError from exc_val
TimeoutError
During handling of the above exception, another exception occurred:
Traceback (most recent call last):
File "/usr/src/homeassistant/homeassistant/components/zha/core/gateway.py", line 201, in async_initialize
await self.application_controller.startup(auto_form=True)
File "/usr/local/lib/python3.11/site-packages/zigpy/application.py", line 201, in startup
await self.shutdown()
File "/usr/local/lib/python3.11/site-packages/zigpy/application.py", line 406, in shutdown
await self._dblistener.shutdown()
File "/usr/local/lib/python3.11/site-packages/zigpy/appdb.py", line 187, in shutdown
await self._set_isolation_level(None)
File "/usr/local/lib/python3.11/site-packages/zigpy/appdb.py", line 205, in _set_isolation_level
await self._db._execute(lambda: setattr(self._db, "isolation_level", level))
File "/usr/local/lib/python3.11/site-packages/aiosqlite/core.py", line 126, in _execute
raise ValueError("Connection closed")
ValueError: Connection closed
2023-10-21 15:18:01.506 WARNING (MainThread) [roborock.code_mappings] Missing RoborockMopIntensityS5Max code: 207 - defaulting to 200
2023-10-21 15:18:04.241 WARNING (MainThread) [homeassistant.helpers.template] Template variable warning: 'dict object' has no attribute 'hum' when rendering '{{ value_json.hum }}'
2023-10-21 15:18:04.242 WARNING (MainThread) [homeassistant.helpers.template] Template variable warning: 'dict object' has no attribute 'temp' when rendering '{{ value_json.temp }}'
2023-10-21 15:18:06.089 ERROR (MainThread) [homeassistant] Error doing job: Fatal error: protocol.data_received() call failed.
Traceback (most recent call last):
File "/usr/local/lib/python3.11/asyncio/selector_events.py", line 1003, in _read_ready__data_received
self._protocol.data_received(data)
File "/usr/local/lib/python3.11/site-packages/bellows/uart.py", line 81, in data_received
self.frame_received(frame)
File "/usr/local/lib/python3.11/site-packages/bellows/uart.py", line 108, in frame_received
self.data_frame_received(data)
File "/usr/local/lib/python3.11/site-packages/bellows/uart.py", line 129, in data_frame_received
self._application.frame_received(self._randomize(data[1:-3]))
File "/usr/local/lib/python3.11/site-packages/bellows/ezsp/__init__.py", line 337, in frame_received
self._protocol(data)
File "/usr/local/lib/python3.11/site-packages/bellows/ezsp/protocol.py", line 119, in __call__
assert expected_id == frame_id
^^^^^^^^^^^^^^^^^^^^^^^
AssertionError
2023-10-21 15:18:06.093 ERROR (MainThread) [bellows.uart] Lost serial connection: AssertionError()
2023-10-21 15:18:06.094 INFO (MainThread) [bellows.ezsp] NCP entered failed state. No application handler registered, ignoring...
2023-10-21 15:18:11.018 ERROR (MainThread) [zigpy.application] Couldn't start application
Traceback (most recent call last):
File "/usr/local/lib/python3.11/site-packages/bellows/ezsp/protocol.py", line 68, in command
return await future
^^^^^^^^^^^^
asyncio.exceptions.CancelledError
The above exception was the direct cause of the following exception:
Traceback (most recent call last):
File "/usr/local/lib/python3.11/site-packages/zigpy/application.py", line 198, in startup
await self.initialize(auto_form=auto_form)
File "/usr/local/lib/python3.11/site-packages/zigpy/application.py", line 150, in initialize
await self.start_network()
File "/usr/local/lib/python3.11/site-packages/bellows/zigbee/application.py", line 184, in start_network
await self._reset()
File "/usr/local/lib/python3.11/site-packages/bellows/ezsp/protocol.py", line 67, in command
async with asyncio_timeout(EZSP_CMD_TIMEOUT):
File "/usr/local/lib/python3.11/asyncio/timeouts.py", line 111, in __aexit__
raise TimeoutError from exc_val
TimeoutError
2023-10-21 15:18:11.021 WARNING (MainThread) [homeassistant.components.zha.core.gateway] Couldn't start EZSP = Silicon Labs EmberZNet protocol: Elelabs, HUSBZB-1, Telegesis coordinator (attempt 3 of 3)
Traceback (most recent call last):
File "/usr/local/lib/python3.11/site-packages/bellows/ezsp/protocol.py", line 68, in command
return await future
^^^^^^^^^^^^
asyncio.exceptions.CancelledError
The above exception was the direct cause of the following exception:
Traceback (most recent call last):
File "/usr/local/lib/python3.11/site-packages/zigpy/application.py", line 198, in startup
await self.initialize(auto_form=auto_form)
File "/usr/local/lib/python3.11/site-packages/zigpy/application.py", line 150, in initialize
await self.start_network()
File "/usr/local/lib/python3.11/site-packages/bellows/zigbee/application.py", line 184, in start_network
await self._reset()
File "/usr/local/lib/python3.11/site-packages/bellows/ezsp/protocol.py", line 67, in command
async with asyncio_timeout(EZSP_CMD_TIMEOUT):
File "/usr/local/lib/python3.11/asyncio/timeouts.py", line 111, in __aexit__
raise TimeoutError from exc_val
TimeoutError
During handling of the above exception, another exception occurred:
Traceback (most recent call last):
File "/usr/src/homeassistant/homeassistant/components/zha/core/gateway.py", line 201, in async_initialize
await self.application_controller.startup(auto_form=True)
File "/usr/local/lib/python3.11/site-packages/zigpy/application.py", line 201, in startup
await self.shutdown()
File "/usr/local/lib/python3.11/site-packages/zigpy/application.py", line 406, in shutdown
await self._dblistener.shutdown()
File "/usr/local/lib/python3.11/site-packages/zigpy/appdb.py", line 187, in shutdown
await self._set_isolation_level(None)
File "/usr/local/lib/python3.11/site-packages/zigpy/appdb.py", line 205, in _set_isolation_level
await self._db._execute(lambda: setattr(self._db, "isolation_level", level))
File "/usr/local/lib/python3.11/site-packages/aiosqlite/core.py", line 126, in _execute
raise ValueError("Connection closed")
ValueError: Connection closed
2023-10-21 15:18:11.024 ERROR (MainThread) [homeassistant.config_entries] Error setting up entry socket://192.168.0.95:8888 for zha
Traceback (most recent call last):
File "/usr/local/lib/python3.11/site-packages/bellows/ezsp/protocol.py", line 68, in command
return await future
^^^^^^^^^^^^
asyncio.exceptions.CancelledError
The above exception was the direct cause of the following exception:
Traceback (most recent call last):
File "/usr/local/lib/python3.11/site-packages/zigpy/application.py", line 198, in startup
await self.initialize(auto_form=auto_form)
File "/usr/local/lib/python3.11/site-packages/zigpy/application.py", line 150, in initialize
await self.start_network()
File "/usr/local/lib/python3.11/site-packages/bellows/zigbee/application.py", line 184, in start_network
await self._reset()
File "/usr/local/lib/python3.11/site-packages/bellows/ezsp/protocol.py", line 67, in command
async with asyncio_timeout(EZSP_CMD_TIMEOUT):
File "/usr/local/lib/python3.11/asyncio/timeouts.py", line 111, in __aexit__
raise TimeoutError from exc_val
TimeoutError
During handling of the above exception, another exception occurred:
Traceback (most recent call last):
File "/usr/src/homeassistant/homeassistant/config_entries.py", line 399, in async_setup
result = await component.async_setup_entry(hass, self)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/src/homeassistant/homeassistant/components/zha/__init__.py", line 172, in async_setup_entry
await zha_gateway.async_initialize()
File "/usr/src/homeassistant/homeassistant/components/zha/core/gateway.py", line 214, in async_initialize
raise exc
File "/usr/src/homeassistant/homeassistant/components/zha/core/gateway.py", line 201, in async_initialize
await self.application_controller.startup(auto_form=True)
File "/usr/local/lib/python3.11/site-packages/zigpy/application.py", line 201, in startup
await self.shutdown()
File "/usr/local/lib/python3.11/site-packages/zigpy/application.py", line 406, in shutdown
await self._dblistener.shutdown()
File "/usr/local/lib/python3.11/site-packages/zigpy/appdb.py", line 187, in shutdown
await self._set_isolation_level(None)
File "/usr/local/lib/python3.11/site-packages/zigpy/appdb.py", line 205, in _set_isolation_level
await self._db._execute(lambda: setattr(self._db, "isolation_level", level))
File "/usr/local/lib/python3.11/site-packages/aiosqlite/core.py", line 126, in _execute
raise ValueError("Connection closed")
ValueError: Connection closed

Additional information

No response

home-assistant[bot] commented 11 months ago

Hey there @dmulcahey, @adminiuga, @puddly, mind taking a look at this issue as it has been labeled with an integration (zha) you are listed as a code owner for? Thanks!

Code owner commands Code owners of `zha` can trigger bot actions by commenting: - `@home-assistant close` Closes the issue. - `@home-assistant rename Awesome new title` Renames the issue. - `@home-assistant reopen` Reopen the issue. - `@home-assistant unassign zha` Removes the current integration label and assignees on the issue, add the integration domain after the command.

(message by CodeOwnersMention)

zha documentation zha source (message by IssueLinks)

peregrines2 commented 11 months ago

Same problem here :( Tried to reload/ restart. No success!

Kryoh-hash commented 11 months ago

Same here, did a post on the forum a few moments ago... i´ve only managed to make it "back alive" downgrading to 2023.10.3.

Tested on Zigbee Hub from Silvercrest and on another installation with a Sonoff Zigbee Hub with Tasmota.

Here´s my log :

Logger: homeassistant.components.zha.core.gateway
Source: components/zha/core/gateway.py:201
Integration: Zigbee Home Automation (documentation, issues)
First occurred: 14:43:03 (2 occurrences)
Last logged: 14:43:19

Couldn't start EZSP = Silicon Labs EmberZNet protocol: Elelabs, HUSBZB-1, Telegesis coordinator (attempt 2 of 3)
Couldn't start EZSP = Silicon Labs EmberZNet protocol: Elelabs, HUSBZB-1, Telegesis coordinator (attempt 3 of 3)
Traceback (most recent call last):
  File "/usr/local/lib/python3.11/site-packages/bellows/ezsp/protocol.py", line 68, in command
    return await future
           ^^^^^^^^^^^^
asyncio.exceptions.CancelledError

The above exception was the direct cause of the following exception:

Traceback (most recent call last):
  File "/usr/local/lib/python3.11/site-packages/zigpy/application.py", line 198, in startup
    await self.initialize(auto_form=auto_form)
  File "/usr/local/lib/python3.11/site-packages/zigpy/application.py", line 150, in initialize
    await self.start_network()
  File "/usr/local/lib/python3.11/site-packages/bellows/zigbee/application.py", line 184, in start_network
    await self._reset()
  File "/usr/local/lib/python3.11/site-packages/bellows/ezsp/protocol.py", line 67, in command
    async with asyncio_timeout(EZSP_CMD_TIMEOUT):
  File "/usr/local/lib/python3.11/asyncio/timeouts.py", line 111, in __aexit__
    raise TimeoutError from exc_val
TimeoutError

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "/usr/src/homeassistant/homeassistant/components/zha/core/gateway.py", line 201, in async_initialize
    await self.application_controller.startup(auto_form=True)
  File "/usr/local/lib/python3.11/site-packages/zigpy/application.py", line 201, in startup
    await self.shutdown()
  File "/usr/local/lib/python3.11/site-packages/zigpy/application.py", line 406, in shutdown
    await self._dblistener.shutdown()
  File "/usr/local/lib/python3.11/site-packages/zigpy/appdb.py", line 187, in shutdown
    await self._set_isolation_level(None)
  File "/usr/local/lib/python3.11/site-packages/zigpy/appdb.py", line 205, in _set_isolation_level
    await self._db._execute(lambda: setattr(self._db, "isolation_level", level))
  File "/usr/local/lib/python3.11/site-packages/aiosqlite/core.py", line 126, in _execute
    raise ValueError("Connection closed")
ValueError: Connection closed
dazz-evg-lab commented 11 months ago

Same issue here

thorrrr commented 11 months ago

Tanked my whole ZHA Zigbee system

https://paste.centos.org/view/a46f735b

bscheutjens commented 11 months ago

Same for me Edit: After restoring the backup that was auto created I'm back at 2023.10.3 and everything seems to work. But man, what was I sweating. Didn't know restoring took that long to complete.

Anc0dia commented 11 months ago

Killed my ZHA zigbee network too, even after rolling back to 10.3 I had to power cycle all my zigbee repeaters to get everything working again.

kdelios commented 11 months ago

Same here. Using tasmotized Sonoff bridge for ages, never had an issue. Revert back to 2023.10.4 and everything works properly.

Gigoo25 commented 11 months ago

Same issue here. Attempted to restart HA with no success. Using a "Silicon Labs HubZ Smart Home Controller"

Logs Below:

Logger: homeassistant.config_entries
Source: config_entries.py:399
First occurred: 10:31:59 AM (1 occurrences)
Last logged: 10:31:59 AM

Error setting up entry HubZ Smart Home Controller - /dev/serial/by-id/usb-Silicon_Labs_HubZ_Smart_Home_Controller_3140034F-if01-port0, s/n: 3140034F - Silicon Labs - 10C4:8A2A for zha
Traceback (most recent call last):
  File "/usr/local/lib/python3.11/site-packages/bellows/ezsp/protocol.py", line 68, in command
    return await future
           ^^^^^^^^^^^^
asyncio.exceptions.CancelledError

The above exception was the direct cause of the following exception:

Traceback (most recent call last):
  File "/usr/local/lib/python3.11/site-packages/zigpy/application.py", line 197, in startup
    await self.connect()
  File "/usr/local/lib/python3.11/site-packages/bellows/zigbee/application.py", line 142, in connect
    await ezsp.startup_reset()
  File "/usr/local/lib/python3.11/site-packages/bellows/ezsp/__init__.py", line 161, in startup_reset
    await self.version()
  File "/usr/local/lib/python3.11/site-packages/bellows/ezsp/__init__.py", line 205, in version
    await self._command("version", ver)
  File "/usr/local/lib/python3.11/site-packages/bellows/ezsp/protocol.py", line 67, in command
    async with asyncio_timeout(EZSP_CMD_TIMEOUT):
  File "/usr/local/lib/python3.11/asyncio/timeouts.py", line 111, in __aexit__
    raise TimeoutError from exc_val
TimeoutError

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "/usr/src/homeassistant/homeassistant/config_entries.py", line 399, in async_setup
    result = await component.async_setup_entry(hass, self)
             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/src/homeassistant/homeassistant/components/zha/__init__.py", line 172, in async_setup_entry
    await zha_gateway.async_initialize()
  File "/usr/src/homeassistant/homeassistant/components/zha/core/gateway.py", line 214, in async_initialize
    raise exc
  File "/usr/src/homeassistant/homeassistant/components/zha/core/gateway.py", line 201, in async_initialize
    await self.application_controller.startup(auto_form=True)
  File "/usr/local/lib/python3.11/site-packages/zigpy/application.py", line 201, in startup
    await self.shutdown()
  File "/usr/local/lib/python3.11/site-packages/zigpy/application.py", line 406, in shutdown
    await self._dblistener.shutdown()
  File "/usr/local/lib/python3.11/site-packages/zigpy/appdb.py", line 187, in shutdown
    await self._set_isolation_level(None)
  File "/usr/local/lib/python3.11/site-packages/zigpy/appdb.py", line 205, in _set_isolation_level
    await self._db._execute(lambda: setattr(self._db, "isolation_level", level))
  File "/usr/local/lib/python3.11/site-packages/aiosqlite/core.py", line 126, in _execute
    raise ValueError("Connection closed")
ValueError: Connection closed
Sullyphil commented 11 months ago

Same issue here, with Zigbee Hub from Silvercrest hacked for doing a local coordinator (see https://paulbanks.org) I even tried to delete it, and the configuration popup told me it was a success, but on the foreground the configuration is not anymore working (see attached the Shrodinger status). Coming back to 2023.10.3 allow me to success with the configuration, but I had problems and still have with this later version (each time I try to add a new zigbee appliance ,ZHA do an infinite loop to add again and again the Silvercrest coordinator). ZHA_2023-10-21_16-11-42

scoop643 commented 11 months ago

Here the same with 2023.10.4

bluechris commented 11 months ago

I see in Github that the previous ZHA version was merged to version 2023.10.5 ... do i wait for this or i also rollback to 2023.10.3?? I have lost mainly all my Zigbee Bulbs but i change my Shelly's in the switches from detached to switch so lights working again.. i can leave like this a bit.....

seanw18 commented 11 months ago

I see in Github that the previous ZHA version was merged to version 2023.10.5 ... do i wait for this or i also rollback to 2023.10.3?? I have lost mainly all my Zigbee Bulbs but i change my Shelly's in the switches from detached to switch so lights working again.. i can leave like this a bit.....

Use the terminal or SSH to reapply version 2023.10.3

$ ha core upgrade --version 2023.10.3

bluechris commented 11 months ago

I see in Github that the previous ZHA version was merged to version 2023.10.5 ... do i wait for this or i also rollback to 2023.10.3?? I have lost mainly all my Zigbee Bulbs but i change my Shelly's in the switches from detached to switch so lights working again.. i can leave like this a bit.....

Use the terminal or SSH to reapply version 2023.10.3

$ ha core upgrade --version 2023.10.3

Thank you, that did the trick

Hydro-guy commented 11 months ago

2023.10.4 killed my nortek HUSBZB-1 ZHA as well. Pi3+ . Downgraded to .3 all was well

puddly commented 11 months ago

@Hydro-guy Can you upload diagnostics JSON for the ZHA integration from 2023.10.3?

Hydro-guy commented 11 months ago

This is after upgrading to 10.5 – pi3+ with SSD and husbzb-1. No sonoff hub. Diagnostic logging for ZHA was enabled – not sure if it got overwritten – if you let me know how to grab it I will try. Husbzb is updated – both z-wave side and zigbee

John

From: puddly @.> Sent: October 22, 2023 1:05 PM To: home-assistant/core @.> Cc: Hydro-guy @.>; Mention @.> Subject: Re: [home-assistant/core] ZHA unable to start after update to 2023.10.4 (Issue #102459)

@Hydro-guy https://github.com/Hydro-guy Can you upload diagnostics JSON for the ZHA integration?

— Reply to this email directly, view it on GitHub https://github.com/home-assistant/core/issues/102459#issuecomment-1774146356 , or unsubscribe https://github.com/notifications/unsubscribe-auth/AGD2QFPZWD6HGT3HTMWTW63YAVG5DAVCNFSM6AAAAAA6KE5AS6VHI2DSMVQWIX3LMV43OSLTON2WKQ3PNVWWK3TUHMYTONZUGE2DMMZVGY . You are receiving this because you were mentioned. https://github.com/notifications/beacon/AGD2QFIXKLHH53H5GRSXOR3YAVG5DA5CNFSM6AAAAAA6KE5AS6WGG33NNVSW45C7OR4XAZNMJFZXG5LFINXW23LFNZ2KUY3PNVWWK3TUL5UWJTTJX5JTI.gif Message ID: @. @.> >

{ "home_assistant": { "installation_type": "Home Assistant OS", "version": "2023.10.5", "dev": false, "hassio": true, "virtualenv": false, "python_version": "3.11.5", "docker": true, "arch": "armv7l", "timezone": "America/Toronto", "os_name": "Linux", "os_version": "6.1.21-v7", "supervisor": "2023.10.0", "host_os": "Home Assistant OS 11.0", "docker_version": "24.0.6", "chassis": "embedded", "run_as_root": true }, "custom_components": { "hacs": { "version": "1.33.0", "requirements": [ "aiogithubapi>=22.10.1" ] }, "blitzortung": { "version": "1.0.1", "requirements": [ "paho-mqtt>=1.5.0" ] } }, "integration_manifest": { "domain": "zha", "name": "Zigbee Home Automation", "after_dependencies": [ "onboarding", "usb" ], "codeowners": [ @.", @.", @." ], "config_flow": true, "dependencies": [ "file_upload" ], "documentation": "https://www.home-assistant.io/integrations/zha", "iot_class": "local_polling", "loggers": [ "aiosqlite", "bellows", "crccheck", "pure_pcapy3", "zhaquirks", "zigpy", "zigpy_deconz", "zigpy_xbee", "zigpy_zigate", "zigpy_znp", "universal_silabs_flasher" ], "requirements": [ "bellows==0.36.5", "pyserial==3.5", "pyserial-asyncio==0.6", "zha-quirks==0.0.105", "zigpy-deconz==0.21.1", "zigpy==0.57.2", "zigpy-xbee==0.18.3", "zigpy-zigate==0.11.0", "zigpy-znp==0.11.6", "universal-silabs-flasher==0.0.14", "pyserial-asyncio-fast==0.11" ], "usb": [ { "vid": "10C4", "pid": "EA60", "description": "2652", "known_devices": [ "slae.sh cc2652rb stick" ] }, { "vid": "1A86", "pid": "55D4", "description": "sonoffplus", "known_devices": [ "sonoff zigbee dongle plus v2" ] }, { "vid": "10C4", "pid": "EA60", "description": "sonoffplus", "known_devices": [ "sonoff zigbee dongle plus" ] }, { "vid": "10C4", "pid": "EA60", "description": "tubeszb", "known_devices": [ "TubesZB Coordinator" ] }, { "vid": "1A86", "pid": "7523", "description": "tubeszb", "known_devices": [ "TubesZB Coordinator" ] }, { "vid": "1A86", "pid": "7523", "description": "zigstar", "known_devices": [ "ZigStar Coordinators" ] }, { "vid": "1CF1", "pid": "0030", "description": "conbee", "known_devices": [ "Conbee II" ] }, { "vid": "10C4", "pid": "8A2A", "description": "zigbee", "known_devices": [ "Nortek HUSBZB-1" ] }, { "vid": "0403", "pid": "6015", "description": "zigate", "known_devices": [ "ZiGate+" ] }, { "vid": "10C4", "pid": "EA60", "description": "zigate", "known_devices": [ "ZiGate" ] }, { "vid": "10C4", "pid": "8B34", "description": "bv 2010/10", "known_devices": [ "Bitron Video AV2010/10" ] } ], "zeroconf": [ { "type": "_esphomelib._tcp.local.", "name": "tube" }, { "type": "_zigate-zigbee-gateway._tcp.local.", "name": "zigate" }, { "type": "_zigstar_gw._tcp.local.", "name": "zigstar" }, { "type": "_uzg-01._tcp.local.", "name": "uzg-01" }, { "type": "_slzb-06._tcp.local.", "name": "slzb-06" } ], "is_built_in": true }, "data": { "config": {}, "config_entry": { "entry_id": "e8ba308ef3ab48a8ab627b59ec63f35c", "version": 3, "domain": "zha", "title": "/dev/serial/by-id/usb-Silicon_Labs_HubZ_Smart_Home_Controller_C0F003F0-if01-port0", "data": { "device": { "path": "/dev/serial/by-id/usb-Silicon_Labs_HubZ_Smart_Home_Controller_C0F003F0-if01-port0" }, "radio_type": "ezsp" }, "options": { "custom_configuration": { "zha_options": { "enable_identify_on_join": true, "default_light_transition": 0, "enhanced_light_transition": false, "light_transitioning_flag": true, "always_prefer_xy_color_mode": true, "consider_unavailable_mains": 7200, "consider_unavailable_battery": 21600, "group_members_assume_state": true } } }, "pref_disable_new_entities": false, "pref_disable_polling": false, "source": "user", "unique_id": null, "disabled_by": null }, "application_state": { "node_info": { "nwk": 0, "ieee": "REDACTED", "logical_type": 0 }, "network_info": { "extended_pan_id": "REDACTED", "pan_id": 47529, "nwk_update_id": 0, "nwk_manager_id": 0, "channel": 15, "channel_mask": 134215680, "security_level": 5, "network_key": "REDACTED", "tc_link_key": { "key": [ 90, 105, 103, 66, 101, 101, 65, 108, 108, 105, 97, 110, 99, 101, 48, 57 ], "tx_counter": 1134592, "rx_counter": 0, "seq": 0, "partner_ieee": "REDACTED" }, "key_table": [], "children": [], "nwk_addresses": {}, "stack_specific": {}, "metadata": { "ezsp": { "manufacturer": "HubZ ZigBee", "board": "HUSBZB-1", "version": "6.7.8.0 build 373", "stack_version": 8, "can_burn_userdata_custom_eui64": true, "can_rewrite_custom_eui64": false } }, "source": **@.***" }, "counters": { "controller_app_counters": { "unicast_rx": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='unicast_rx', _raw_value=1292, reset_count=0, _last_reset_value=0)" }, "unicast_tx_success": { "__type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='unicast_tx_success', _raw_value=878, reset_count=0, _last_reset_value=0)" }, "broadcast_tx_success_unexpected": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='broadcast_tx_success_unexpected', _raw_value=13, reset_count=0, _last_reset_value=0)" }, "unicast_tx_failure": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='unicast_tx_failure', _raw_value=379, reset_count=0, _last_reset_value=0)" }, "multicast_rx": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='multicast_rx', _raw_value=3, reset_count=0, _last_reset_value=0)" }, "multicast_tx_success_unexpected": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='multicast_tx_success_unexpected', _raw_value=3, reset_count=0, _last_reset_value=0)" }, "broadcast_rx": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='broadcast_rx', _raw_value=12, reset_count=0, _last_reset_value=0)" } }, "ezsp_counters": { "MAC_RX_BROADCAST": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='MAC_RX_BROADCAST', _raw_value=1383, reset_count=7, _last_reset_value=15256)" }, "MAC_TX_BROADCAST": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='MAC_TX_BROADCAST', _raw_value=223, reset_count=7, _last_reset_value=2359)" }, "MAC_RX_UNICAST": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='MAC_RX_UNICAST', _raw_value=338, reset_count=7, _last_reset_value=3069)" }, "MAC_TX_UNICAST_SUCCESS": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='MAC_TX_UNICAST_SUCCESS', _raw_value=205, reset_count=7, _last_reset_value=1945)" }, "MAC_TX_UNICAST_RETRY": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='MAC_TX_UNICAST_RETRY', _raw_value=33, reset_count=7, _last_reset_value=440)" }, "MAC_TX_UNICAST_FAILED": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='MAC_TX_UNICAST_FAILED', _raw_value=2, reset_count=7, _last_reset_value=58)" }, "APS_DATA_RX_BROADCAST": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='APS_DATA_RX_BROADCAST', _raw_value=0, reset_count=7, _last_reset_value=16)" }, "APS_DATA_TX_BROADCAST": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='APS_DATA_TX_BROADCAST', _raw_value=0, reset_count=7, _last_reset_value=16)" }, "APS_DATA_RX_UNICAST": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='APS_DATA_RX_UNICAST', _raw_value=125, reset_count=7, _last_reset_value=1167)" }, "APS_DATA_TX_UNICAST_SUCCESS": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='APS_DATA_TX_UNICAST_SUCCESS', _raw_value=88, reset_count=7, _last_reset_value=790)" }, "APS_DATA_TX_UNICAST_RETRY": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='APS_DATA_TX_UNICAST_RETRY', _raw_value=62, reset_count=7, _last_reset_value=721)" }, "APS_DATA_TX_UNICAST_FAILED": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='APS_DATA_TX_UNICAST_FAILED', _raw_value=30, reset_count=7, _last_reset_value=349)" }, "ROUTE_DISCOVERY_INITIATED": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='ROUTE_DISCOVERY_INITIATED', _raw_value=19, reset_count=7, _last_reset_value=223)" }, "NEIGHBOR_ADDED": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='NEIGHBOR_ADDED', _raw_value=0, reset_count=7, _last_reset_value=13)" }, "NEIGHBOR_REMOVED": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='NEIGHBOR_REMOVED', _raw_value=0, reset_count=7, _last_reset_value=0)" }, "NEIGHBOR_STALE": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='NEIGHBOR_STALE', _raw_value=3, reset_count=7, _last_reset_value=83)" }, "JOIN_INDICATION": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='JOIN_INDICATION', _raw_value=0, reset_count=7, _last_reset_value=0)" }, "CHILD_REMOVED": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='CHILD_REMOVED', _raw_value=0, reset_count=7, _last_reset_value=0)" }, "ASH_OVERFLOW_ERROR": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='ASH_OVERFLOW_ERROR', _raw_value=0, reset_count=7, _last_reset_value=0)" }, "ASH_FRAMING_ERROR": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='ASH_FRAMING_ERROR', _raw_value=0, reset_count=7, _last_reset_value=0)" }, "ASH_OVERRUN_ERROR": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='ASH_OVERRUN_ERROR', _raw_value=0, reset_count=7, _last_reset_value=0)" }, "NWK_FRAME_COUNTER_FAILURE": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='NWK_FRAME_COUNTER_FAILURE', _raw_value=0, reset_count=7, _last_reset_value=0)" }, "APS_FRAME_COUNTER_FAILURE": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='APS_FRAME_COUNTER_FAILURE', _raw_value=0, reset_count=7, _last_reset_value=0)" }, "UTILITY": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='UTILITY', _raw_value=0, reset_count=7, _last_reset_value=0)" }, "APS_LINK_KEY_NOT_AUTHORIZED": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='APS_LINK_KEY_NOT_AUTHORIZED', _raw_value=0, reset_count=7, _last_reset_value=0)" }, "NWK_DECRYPTION_FAILURE": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='NWK_DECRYPTION_FAILURE', _raw_value=0, reset_count=7, _last_reset_value=0)" }, "APS_DECRYPTION_FAILURE": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='APS_DECRYPTION_FAILURE', _raw_value=0, reset_count=7, _last_reset_value=0)" }, "ALLOCATE_PACKET_BUFFER_FAILURE": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='ALLOCATE_PACKET_BUFFER_FAILURE', _raw_value=0, reset_count=7, _last_reset_value=0)" }, "RELAYED_UNICAST": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='RELAYED_UNICAST', _raw_value=0, reset_count=7, _last_reset_value=0)" }, "PHY_TO_MAC_QUEUE_LIMIT_REACHED": { "__type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='PHY_TO_MAC_QUEUE_LIMIT_REACHED', _raw_value=0, reset_count=7, _last_reset_value=0)" }, "PACKET_VALIDATE_LIBRARY_DROPPED_COUNT": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='PACKET_VALIDATE_LIBRARY_DROPPED_COUNT', _raw_value=0, reset_count=7, _last_reset_value=0)" }, "TYPE_NWK_RETRY_OVERFLOW": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='TYPE_NWK_RETRY_OVERFLOW', _raw_value=0, reset_count=7, _last_reset_value=0)" }, "PHY_CCA_FAIL_COUNT": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='PHY_CCA_FAIL_COUNT', _raw_value=0, reset_count=7, _last_reset_value=3)" }, "BROADCAST_TABLE_FULL": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='BROADCAST_TABLE_FULL', _raw_value=0, reset_count=7, _last_reset_value=0)" }, "PTA_LO_PRI_REQUESTED": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='PTA_LO_PRI_REQUESTED', _raw_value=0, reset_count=7, _last_reset_value=0)" }, "PTA_HI_PRI_REQUESTED": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='PTA_HI_PRI_REQUESTED', _raw_value=0, reset_count=7, _last_reset_value=0)" }, "PTA_LO_PRI_DENIED": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='PTA_LO_PRI_DENIED', _raw_value=0, reset_count=7, _last_reset_value=0)" }, "PTA_HI_PRI_DENIED": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='PTA_HI_PRI_DENIED', _raw_value=0, reset_count=7, _last_reset_value=0)" }, "PTA_LO_PRI_TX_ABORTED": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='PTA_LO_PRI_TX_ABORTED', _raw_value=0, reset_count=7, _last_reset_value=0)" }, "PTA_HI_PRI_TX_ABORTED": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='PTA_HI_PRI_TX_ABORTED', _raw_value=0, reset_count=7, _last_reset_value=0)" }, "ADDRESS_CONFLICT_SENT": { "type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='ADDRESS_CONFLICT_SENT', _raw_value=0, reset_count=7, _last_reset_value=0)" }, "EZSP_FREE_BUFFERS": { "__type": "<class 'zigpy.state.Counter'>", "repr": "Counter(name='EZSP_FREE_BUFFERS', _raw_value=244, reset_count=7, _last_reset_value=0)" } } }, "broadcast_counters": {}, "device_counters": {}, "group_counters": {} }, "energy_scan": { "11": 46.26944564832987, "12": 70.89933442360993, "13": 84.164247274957, "14": 95.12234809209261, "15": 89.93931580241996, "16": 28.30261646762903, "17": 33.860880820104335, "18": 93.76433891498253, "19": 13.711043742539033, "20": 10.914542804728702, "21": 6.011489450827149, "22": 17.086630587133605, "23": 6.789392891308996, "24": 23.33483723001185, "25": 31.01324838787301, "26": 73.50699819621309 }, "versions": { "bellows": "0.36.5", "zigpy": "0.57.2", "zigpy_deconz": "0.21.1", "zigpy_xbee": "0.18.3", "zigpy_znp": "0.11.6", "zigpy_zigate": "0.11.0", "zhaquirks": "0.0.105" } } }