Everything was working fine. Then one morning, my automation stopped working. I am now not even able to toggle my switches from HA dashboard.
My Setup:
HA running on a VM through Oracle Virtual Box
SONOFF Zigbee 3.0 dongle-E used as gateway
Add-Ons involved: Zigbee2MQTT
, Mosquitto broker
Zigbee2MQTT (V 1.39.1-1) Configuration:
data_path: /config/zigbee2mqtt
socat:
enabled: false
master: pty,raw,echo=0,link=/tmp/ttyZ2M,mode=777
slave: tcp-listen:8485,keepalive,nodelay,reuseaddr,keepidle=1,keepintvl=1,keepcnt=5
options: "-d -d"
log: false
mqtt:
server: mqtt://core-mosquitto:1883
user: mqttuser
password: Pakistan123
serial:
port: >-
/dev/serial/by-id/usb-ITEAD_SONOFF_Zigbee_3.0_USB_Dongle_Plus_V2_20240220093323-if00
adapter: ezsp
Zigbee2MQTT (V 1.39.1-1) Log:
[2024-08-18 21:38:19] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/bridge/state', payload '{"state":"offline"}'
[2024-08-18 21:38:19] info: z2m: Disconnecting from MQTT server
[2024-08-18 21:38:19] info: z2m: Stopping zigbee-herdsman...
[2024-08-18 21:38:19] error: z2m: MQTT error: read ECONNRESET
[2024-08-18 21:38:20] info: zh:controller: Wrote coordinator backup to '/config/zigbee2mqtt/coordinator_backup.json'
[2024-08-18 21:38:20] info: z2m: Stopped zigbee-herdsman
[2024-08-18 21:38:20] info: z2m: Stopped Zigbee2MQTT
[21:44:16] INFO: Preparing to start...
[21:44:21] INFO: Socat not enabled
[21:44:27] INFO: Starting Zigbee2MQTT...
Starting Zigbee2MQTT without watchdog.
[2024-08-18 21:45:03] info: z2m: Logging to console, file (filename: log.log)
[2024-08-18 21:45:03] info: z2m: Starting Zigbee2MQTT version 1.39.1 (commit #unknown)
[2024-08-18 21:45:03] info: z2m: Starting zigbee-herdsman (0.55.3)
[2024-08-18 21:45:07] warning: zh:ezsp: Deprecated driver 'ezsp' currently in use, 'ember' will become the officially supported EmberZNet driver in next release. If using Zigbee2MQTT see https://github.com/Koenkk/zigbee2mqtt/discussions/21462
[2024-08-18 21:45:15] error: zh:ezsp:uart: --> Error: Error: {"sequence":1} after 4000ms
[2024-08-18 21:45:15] error: zh:ezsp:uart: -!- break waiting (1)
[2024-08-18 21:45:15] error: zh:ezsp:uart: Can't send DATA frame (0,0,0): 00000004
[2024-08-18 21:45:20] error: zh:ezsp:uart: --> Error: Error: {"sequence":1} after 4000ms
[2024-08-18 21:45:20] error: zh:ezsp:uart: -!- break rewaiting (1)
[2024-08-18 21:45:20] error: zh:ezsp:uart: Can't resend DATA frame (0,0,1): 00000004
[2024-08-18 21:45:20] error: z2m: Error while starting zigbee-herdsman
[2024-08-18 21:45:20] error: z2m: Failed to start zigbee
[2024-08-18 21:45:20] error: z2m: Check https://www.zigbee2mqtt.io/guide/installation/20_zigbee2mqtt-fails-to-start.html for possible solutions
[2024-08-18 21:45:20] error: z2m: Exiting...
[2024-08-18 21:45:22] error: z2m: Error: Failure send version:{"type":"Buffer","data":[0,0,0,4]}
at /app/node_modules/zigbee-herdsman/src/adapter/ezsp/driver/ezsp.ts:675:23
at Queue.execute (/app/node_modules/zigbee-herdsman/src/utils/queue.ts:35:20)
at Ezsp.version (/app/node_modules/zigbee-herdsman/src/adapter/ezsp/driver/ezsp.ts:457:24)
at Driver.startup (/app/node_modules/zigbee-herdsman/src/adapter/ezsp/driver/driver.ts:185:9)
at Controller.start (/app/node_modules/zigbee-herdsman/src/controller/controller.ts:127:29)
at Zigbee.start (/app/lib/zigbee.ts:63:27)
at Controller.start (/app/lib/controller.ts:139:27)
at start (/app/index.js:154:5)
[21:45:37] INFO: Preparing to start...
[21:45:41] INFO: Socat not enabled
[21:45:49] INFO: Starting Zigbee2MQTT...
Starting Zigbee2MQTT without watchdog.
[2024-08-18 21:46:03] info: z2m: Logging to console, file (filename: log.log)
[2024-08-18 21:46:03] info: z2m: Starting Zigbee2MQTT version 1.39.1 (commit #unknown)
[2024-08-18 21:46:03] info: z2m: Starting zigbee-herdsman (0.55.3)
[2024-08-18 21:46:03] warning: zh:ezsp: Deprecated driver 'ezsp' currently in use, 'ember' will become the officially supported EmberZNet driver in next release. If using Zigbee2MQTT see https://github.com/Koenkk/zigbee2mqtt/discussions/21462
[2024-08-18 21:46:13] error: zh:ezsp:uart: --> Error: Error: {"sequence":-1} after 10000ms
[2024-08-18 21:46:14] error: zh:ezsp:ezsp: Connection attempt 1 error: Error: Failure to connect
at SerialDriver.resetForReconnect (/app/node_modules/zigbee-herdsman/src/adapter/ezsp/driver/ezsp.ts:341:19)
at SerialDriver.emit (node:events:517:28)
at /app/node_modules/zigbee-herdsman/src/adapter/ezsp/driver/uart.ts:344:22
at Queue.execute (/app/node_modules/zigbee-herdsman/src/utils/queue.ts:35:20)
at SerialDriver.openSerialPort (/app/node_modules/zigbee-herdsman/src/adapter/ezsp/driver/uart.ts:106:13)
at SerialDriver.connect (/app/node_modules/zigbee-herdsman/src/adapter/ezsp/driver/uart.ts:61:13)
at Ezsp.connect (/app/node_modules/zigbee-herdsman/src/adapter/ezsp/driver/ezsp.ts:347:17)
at Driver.startup (/app/node_modules/zigbee-herdsman/src/adapter/ezsp/driver/driver.ts:176:13)
at Controller.start (/app/node_modules/zigbee-herdsman/src/controller/controller.ts:127:29)
at Zigbee.start (/app/lib/zigbee.ts:63:27)
[2024-08-18 21:46:29] error: zh:ezsp:uart: --> Error: Error: {"sequence":-1} after 10000ms
[2024-08-18 21:46:29] error: zh:ezsp:ezsp: Connection attempt 2 error: Error: Failure to connect
at SerialDriver.resetForReconnect (/app/node_modules/zigbee-herdsman/src/adapter/ezsp/driver/ezsp.ts:341:19)
at SerialDriver.emit (node:events:517:28)
at /app/node_modules/zigbee-herdsman/src/adapter/ezsp/driver/uart.ts:344:22
at Queue.execute (/app/node_modules/zigbee-herdsman/src/utils/queue.ts:35:20)
at SerialDriver.openSerialPort (/app/node_modules/zigbee-herdsman/src/adapter/ezsp/driver/uart.ts:106:13)
at SerialDriver.connect (/app/node_modules/zigbee-herdsman/src/adapter/ezsp/driver/uart.ts:61:13)
at Ezsp.connect (/app/node_modules/zigbee-herdsman/src/adapter/ezsp/driver/ezsp.ts:347:17)
at Driver.startup (/app/node_modules/zigbee-herdsman/src/adapter/ezsp/driver/driver.ts:176:13)
at Controller.start (/app/node_modules/zigbee-herdsman/src/controller/controller.ts:127:29)
at Zigbee.start (/app/lib/zigbee.ts:63:27)
[2024-08-18 21:46:49] error: zh:ezsp:uart: --> Error: Error: {"sequence":-1} after 10000ms
[2024-08-18 21:46:49] error: zh:ezsp:ezsp: Connection attempt 3 error: Error: Failure to connect
at SerialDriver.resetForReconnect (/app/node_modules/zigbee-herdsman/src/adapter/ezsp/driver/ezsp.ts:341:19)
at SerialDriver.emit (node:events:517:28)
at /app/node_modules/zigbee-herdsman/src/adapter/ezsp/driver/uart.ts:344:22
at Queue.execute (/app/node_modules/zigbee-herdsman/src/utils/queue.ts:35:20)
at SerialDriver.openSerialPort (/app/node_modules/zigbee-herdsman/src/adapter/ezsp/driver/uart.ts:106:13)
at SerialDriver.connect (/app/node_modules/zigbee-herdsman/src/adapter/ezsp/driver/uart.ts:61:13)
at Ezsp.connect (/app/node_modules/zigbee-herdsman/src/adapter/ezsp/driver/ezsp.ts:347:17)
at Driver.startup (/app/node_modules/zigbee-herdsman/src/adapter/ezsp/driver/driver.ts:176:13)
at Controller.start (/app/node_modules/zigbee-herdsman/src/controller/controller.ts:127:29)
at Zigbee.start (/app/lib/zigbee.ts:63:27)
[2024-08-18 21:47:15] error: zh:ezsp:uart: --> Error: Error: {"sequence":5} after 4000ms
[2024-08-18 21:47:15] error: zh:ezsp:uart: -!- break waiting (5)
[2024-08-18 21:47:15] error: zh:ezsp:uart: Can't send DATA frame (4,4,0): 04000153001d3200
[2024-08-18 21:47:26] error: zh:ezsp:ezsp: setConfigurationValue(29, 50) error: Error: Failure send setConfigurationValue:{"type":"Buffer","data":[4,0,1,83,0,29,50,0]} Error: Failure send setConfigurationValue:{"type":"Buffer","data":[4,0,1,83,0,29,50,0]}
at /app/node_modules/zigbee-herdsman/src/adapter/ezsp/driver/ezsp.ts:675:23
at Queue.execute (/app/node_modules/zigbee-herdsman/src/utils/queue.ts:35:20)
at Ezsp.setConfigurationValue (/app/node_modules/zigbee-herdsman/src/adapter/ezsp/driver/ezsp.ts:511:21)
at Ezsp.updateConfig (/app/node_modules/zigbee-herdsman/src/adapter/ezsp/driver/ezsp.ts:608:17)
at Driver.startup (/app/node_modules/zigbee-herdsman/src/adapter/ezsp/driver/driver.ts:186:9)
at Controller.start (/app/node_modules/zigbee-herdsman/src/controller/controller.ts:127:29)
at Zigbee.start (/app/lib/zigbee.ts:63:27)
at Controller.start (/app/lib/controller.ts:139:27)
at start (/app/index.js:154:5)
[2024-08-18 21:47:30] error: zh:ezsp:uart: --> Error: Error: {"sequence":6} after 4000ms
[2024-08-18 21:47:30] error: zh:ezsp:uart: -!- break waiting (6)
[2024-08-18 21:47:30] error: zh:ezsp:uart: Can't send DATA frame (5,1,0): 0500010500
[2024-08-18 21:47:34] error: zh:ezsp:uart: --> Error: Error: {"sequence":6} after 4000ms
[2024-08-18 21:47:34] error: zh:ezsp:uart: -!- break rewaiting (6)
[2024-08-18 21:47:34] error: zh:ezsp:uart: Can't resend DATA frame (5,1,1): 0500010500
[2024-08-18 21:47:34] error: zh:ezsp:ezsp: Watchdog heartbeat timeout Error: Failure send nop:{"type":"Buffer","data":[5,0,1,5,0]}
at /app/node_modules/zigbee-herdsman/src/adapter/ezsp/driver/ezsp.ts:675:23
at Queue.execute (/app/node_modules/zigbee-herdsman/src/utils/queue.ts:35:20)
at Ezsp.watchdogHandler (/app/node_modules/zigbee-herdsman/src/adapter/ezsp/driver/ezsp.ts:781:13)
Mosquitto broker (V 6.4.1) Configuration:
logins: []
require_certificate: false
certfile: fullchain.pem
keyfile: privkey.pem
customize:
active: false
folder: mosquitto
Mosquitto broker (V 6.4.1) Log:
2024-08-18 21:21:16: New connection from 172.30.32.2:38820 on port 1883.
2024-08-18 21:21:16: Client <unknown> closed its connection.
2024-08-18 21:23:16: New connection from 172.30.32.2:59508 on port 1883.
2024-08-18 21:23:16: Client <unknown> closed its connection.
2024-08-18 21:25:16: New connection from 172.30.32.2:54166 on port 1883.
2024-08-18 21:25:16: Client <unknown> closed its connection.
2024-08-18 21:27:16: New connection from 172.30.32.2:40468 on port 1883.
2024-08-18 21:27:16: Client <unknown> closed its connection.
2024-08-18 21:29:16: New connection from 172.30.32.2:54942 on port 1883.
2024-08-18 21:29:16: Client <unknown> closed its connection.
2024-08-18 21:31:16: New connection from 172.30.32.2:57186 on port 1883.
2024-08-18 21:31:16: Client <unknown> closed its connection.
2024-08-18 21:33:16: New connection from 172.30.32.2:38404 on port 1883.
2024-08-18 21:33:16: Client <unknown> closed its connection.
2024-08-18 21:35:04: Saving in-memory database to /data//mosquitto.db.
2024-08-18 21:35:16: New connection from 172.30.32.2:47666 on port 1883.
2024-08-18 21:35:16: Client <unknown> closed its connection.
2024-08-18 21:37:16: New connection from 172.30.32.2:38710 on port 1883.
2024-08-18 21:37:16: Client <unknown> closed its connection.
s6-rc: info: service legacy-services: stopping
2024-08-18 21:38:19: mosquitto version 2.0.18 terminating
time="2024-08-18T21:38:19+05:00" level=error msg="POST error: Post \"http://127.0.0.1:80/superuser\": read tcp 127.0.0.1:54952->127.0.0.1:80: read: connection reset by peer"
time="2024-08-18T21:38:19+05:00" level=error msg="POST error: Post \"http://127.0.0.1:80/acl\": dial tcp 127.0.0.1:80: connect: connection refused"
time="2024-08-18T21:38:19+05:00" level=error msg="Post \"http://127.0.0.1:80/superuser\": read tcp 127.0.0.1:54952->127.0.0.1:80: read: connection reset by peer"
2024-08-18 21:38:19: Saving in-memory database to /data//mosquitto.db.
[16:38:20] INFO: Service restart after closing
[16:38:20] INFO: Service restart after closing
s6-rc: info: service legacy-services successfully stopped
s6-rc: info: service legacy-cont-init: stopping
s6-rc: info: service legacy-cont-init successfully stopped
s6-rc: info: service fix-attrs: stopping
s6-rc: info: service fix-attrs successfully stopped
s6-rc: info: service s6rc-oneshot-runner: stopping
s6-rc: info: service s6rc-oneshot-runner successfully stopped
s6-rc: info: service s6rc-oneshot-runner: starting
s6-rc: info: service s6rc-oneshot-runner successfully started
s6-rc: info: service fix-attrs: starting
s6-rc: info: service fix-attrs successfully started
s6-rc: info: service legacy-cont-init: starting
cont-init: info: running /etc/cont-init.d/mosquitto.sh
[21:42:51] INFO: SSL is not enabled
cont-init: info: /etc/cont-init.d/mosquitto.sh exited 0
cont-init: info: running /etc/cont-init.d/nginx.sh
cont-init: info: /etc/cont-init.d/nginx.sh exited 0
s6-rc: info: service legacy-cont-init successfully started
s6-rc: info: service legacy-services: starting
services-up: info: copying legacy longrun mosquitto (no readiness notification)
services-up: info: copying legacy longrun nginx (no readiness notification)
s6-rc: info: service legacy-services successfully started
[21:42:55] INFO: Starting NGINX for authentication handling...
[21:42:55] INFO: Starting mosquitto MQTT broker...
2024-08-18 21:42:55: Warning: Mosquitto should not be run as root/administrator.
2024-08-18 21:42:55: mosquitto version 2.0.18 starting
2024-08-18 21:42:55: Config loaded from /etc/mosquitto/mosquitto.conf.
2024-08-18 21:42:55: Loading plugin: /usr/share/mosquitto/go-auth.so
2024-08-18 21:42:55: ├── Username/password checking enabled.
2024-08-18 21:42:55: ├── TLS-PSK checking enabled.
2024-08-18 21:42:55: └── Extended authentication not enabled.
2024-08-18 21:42:55: Opening ipv4 listen socket on port 1883.
2024-08-18 21:42:55: Opening ipv6 listen socket on port 1883.
2024-08-18 21:42:55: Opening websockets listen socket on port 1884.
2024-08-18 21:42:55: mosquitto version 2.0.18 running
2024-08-18 21:42:58: New connection from ::1:34512 on port 1883.
2024-08-18 21:42:58: Client <unknown> disconnected due to protocol error.
[21:43:01] INFO: Successfully send discovery information to Home Assistant.
[21:43:03] INFO: Successfully send service information to the Supervisor.
2024-08-18 21:43:52: New connection from 172.30.32.1:54955 on port 1883.
2024-08-18 21:43:52: New client connected from 172.30.32.1:54955 as 2TFuRsshMFf4wTr2depG2M (p2, c1, k60, u'mqttuser').
2024-08-18 21:46:56: New connection from 172.30.32.2:58714 on port 1883.
2024-08-18 21:46:56: Client <unknown> closed its connection.
2024-08-18 21:48:56: New connection from 172.30.32.2:35176 on port 1883.
2024-08-18 21:48:56: Client <unknown> closed its connection.
2024-08-18 21:50:56: New connection from 172.30.32.2:42022 on port 1883.
2024-08-18 21:50:56: Client <unknown> closed its connection.
2024-08-18 21:52:56: New connection from 172.30.32.2:55656 on port 1883.
2024-08-18 21:52:56: Client <unknown> closed its connection.
2024-08-18 21:54:56: New connection from 172.30.32.2:55532 on port 1883.
2024-08-18 21:54:56: Client <unknown> closed its connection.
2024-08-18 21:56:56: New connection from 172.30.32.2:40526 on port 1883.
2024-08-18 21:56:56: Client <unknown> closed its connection.
2024-08-18 21:58:56: New connection from 172.30.32.2:46754 on port 1883.
2024-08-18 21:58:56: Client <unknown> closed its connection.
2024-08-18 22:00:56: New connection from 172.30.32.2:59006 on port 1883.
2024-08-18 22:00:56: Client <unknown> closed its connection.
2024-08-18 22:02:56: New connection from 172.30.32.2:56400 on port 1883.
2024-08-18 22:02:56: Client <unknown> closed its connection.
2024-08-18 22:04:56: New connection from 172.30.32.2:48954 on port 1883.
2024-08-18 22:04:56: Client <unknown> closed its connection.
2024-08-18 22:06:56: New connection from 172.30.32.2:37124 on port 1883.
2024-08-18 22:06:56: Client <unknown> closed its connection.
2024-08-18 22:08:56: New connection from 172.30.32.2:55694 on port 1883.
2024-08-18 22:08:56: Client <unknown> closed its connection.
2024-08-18 22:10:56: New connection from 172.30.32.2:49112 on port 1883.
2024-08-18 22:10:56: Client <unknown> closed its connection.
2024-08-18 22:12:56: New connection from 172.30.32.2:41690 on port 1883.
2024-08-18 22:12:56: Client <unknown> closed its connection.
2024-08-18 22:12:58: Saving in-memory database to /data//mosquitto.db.
2024-08-18 22:14:56: New connection from 172.30.32.2:57066 on port 1883.
2024-08-18 22:14:56: Client <unknown> closed its connection.
2024-08-18 22:16:56: New connection from 172.30.32.2:42998 on port 1883.
2024-08-18 22:16:56: Client <unknown> closed its connection.
HA Core Log:
2024-08-18 21:44:05.334 WARNING (MainThread) [zigpy.application] Zigbee channel 11 utilization is 96.64%!
2024-08-18 21:44:05.334 WARNING (MainThread) [zigpy.application] If you are having problems joining new devices, are missing sensor updates, or have issues keeping devices joined, ensure your coordinator is away from interference sources such as USB 3.0 devices, SSDs, WiFi routers, etc.
2024-08-18 21:45:11.545 WARNING (MainThread) [bellows.ezsp.protocol] Unknown application frame 0x0208 received: b'306a' (b'0080000802306a'). This is a bug!
2024-08-18 21:45:19.372 WARNING (MainThread) [bellows.zigbee.application] Watchdog heartbeat timeout: TimeoutError()
2024-08-18 21:45:22.277 ERROR (MainThread) [bellows.ezsp] NCP entered failed state. Requesting APP controller restart
2024-08-18 21:45:24.347 ERROR (MainThread) [homeassistant] Error doing job: Task exception was never retrieved (None)
Traceback (most recent call last):
File "/usr/local/lib/python3.12/site-packages/bellows/ash.py", line 631, in _send_data_frame
await ack_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.12/site-packages/bellows/ash.py", line 630, in _send_data_frame
async with asyncio_timeout(self._t_rx_ack):
File "/usr/local/lib/python3.12/asyncio/timeouts.py", line 115, in __aexit__
raise TimeoutError from exc_val
TimeoutError
2024-08-18 21:45:37.514 WARNING (MainThread) [zigpy.application] Zigbee channel 11 utilization is 97.39%!
2024-08-18 21:45:37.532 WARNING (MainThread) [zigpy.application] If you are having problems joining new devices, are missing sensor updates, or have issues keeping devices joined, ensure your coordinator is away from interference sources such as USB 3.0 devices, SSDs, WiFi routers, etc.
2024-08-18 21:46:05.080 WARNING (bellows.thread_0) [bellows.uart] Received an unexpected reset: <NcpResetCode.RESET_SOFTWARE: 11>
2024-08-18 21:46:09.081 WARNING (MainThread) [bellows.zigbee.application] Watchdog heartbeat timeout: InvalidCommandError('readCounters command is an invalidCommand, was sent under 106 sequence number: ERROR_VERSION_NOT_SET')
2024-08-18 21:46:19.104 WARNING (MainThread) [bellows.zigbee.application] Watchdog heartbeat timeout: InvalidCommandError('readCounters command is an invalidCommand, was sent under 107 sequence number: ERROR_VERSION_NOT_SET')
2024-08-18 21:46:20.770 WARNING (bellows.thread_0) [bellows.uart] Received an unexpected reset: <NcpResetCode.RESET_SOFTWARE: 11>
2024-08-18 21:46:29.124 WARNING (MainThread) [bellows.zigbee.application] Watchdog heartbeat timeout: InvalidCommandError('readCounters command is an invalidCommand, was sent under 108 sequence number: ERROR_VERSION_NOT_SET')
2024-08-18 21:46:39.139 WARNING (MainThread) [bellows.zigbee.application] Watchdog heartbeat timeout: InvalidCommandError('readCounters command is an invalidCommand, was sent under 109 sequence number: ERROR_VERSION_NOT_SET')
2024-08-18 21:46:40.829 WARNING (bellows.thread_0) [bellows.uart] Received an unexpected reset: <NcpResetCode.RESET_SOFTWARE: 11>
2024-08-18 21:46:49.161 WARNING (MainThread) [bellows.zigbee.application] Watchdog heartbeat timeout: InvalidCommandError('readCounters command is an invalidCommand, was sent under 110 sequence number: ERROR_VERSION_NOT_SET')
2024-08-18 21:46:49.161 WARNING (MainThread) [zigpy.application] Watchdog failure
Traceback (most recent call last):
File "/usr/local/lib/python3.12/site-packages/zigpy/application.py", line 665, in _watchdog_loop
await self.watchdog_feed()
File "/usr/local/lib/python3.12/site-packages/zigpy/application.py", line 651, in watchdog_feed
await self._watchdog_feed()
File "/usr/local/lib/python3.12/site-packages/bellows/zigbee/application.py", line 893, in _watchdog_feed
current_counters = await self._ezsp.read_counters()
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/local/lib/python3.12/site-packages/bellows/ezsp/v4/__init__.py", line 190, in read_counters
(res,) = await self.readCounters()
^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/local/lib/python3.12/site-packages/bellows/ezsp/protocol.py", line 76, in command
return await future
^^^^^^^^^^^^
bellows.exception.InvalidCommandError: readCounters command is an invalidCommand, was sent under 110 sequence number: ERROR_VERSION_NOT_SET
2024-08-18 21:46:58.710 WARNING (MainThread) [zigpy.application] Zigbee channel 11 utilization is 97.04%!
2024-08-18 21:46:58.711 WARNING (MainThread) [zigpy.application] If you are having problems joining new devices, are missing sensor updates, or have issues keeping devices joined, ensure your coordinator is away from interference sources such as USB 3.0 devices, SSDs, WiFi routers, etc.
2024-08-18 21:47:15.133 ERROR (MainThread) [bellows.ezsp] NCP entered failed state. Requesting APP controller restart
2024-08-18 21:47:19.262 ERROR (bellows.thread_0) [bellows.uart] Lost serial connection: SerialException('device reports readiness to read but returned no data (device disconnected or multiple access on port?)')
2024-08-18 21:47:19.291 ERROR (MainThread) [homeassistant.config_entries] Error setting up entry SONOFF Zigbee 3.0 USB Dongle Plus V2 for zha
Traceback (most recent call last):
File "/usr/src/homeassistant/homeassistant/config_entries.py", line 604, in async_setup
result = await component.async_setup_entry(hass, self)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/src/homeassistant/homeassistant/components/zha/__init__.py", line 151, in async_setup_entry
await zha_gateway.async_initialize()
File "/usr/local/lib/python3.12/site-packages/zha/application/gateway.py", line 273, in async_initialize
await self._async_initialize()
File "/usr/local/lib/python3.12/site-packages/zha/application/gateway.py", line 256, in _async_initialize
await self.application_controller.startup(auto_form=True)
File "/usr/local/lib/python3.12/site-packages/zigpy/application.py", line 233, in startup
await self.connect()
File "/usr/local/lib/python3.12/site-packages/bellows/zigbee/application.py", line 148, in connect
await ezsp.startup_reset()
File "/usr/local/lib/python3.12/site-packages/bellows/ezsp/__init__.py", line 128, in startup_reset
await self.version()
File "/usr/local/lib/python3.12/site-packages/bellows/ezsp/__init__.py", line 174, in version
ver, stack_type, stack_version = await self._command(
^^^^^^^^^^^^^^^^^^^^
File "/usr/local/lib/python3.12/site-packages/bellows/ezsp/__init__.py", line 221, in _command
return await command(*args, **kwargs)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/local/lib/python3.12/site-packages/bellows/ezsp/protocol.py", line 75, in command
await self._gw.send_data(data)
asyncio.exceptions.CancelledError