Koenkk / zigbee2mqtt

Zigbee 🐝 to MQTT bridge 🌉, get rid of your proprietary Zigbee bridges 🔨
https://www.zigbee2mqtt.io
GNU General Public License v3.0
11.5k stars 1.63k forks source link

Zigbee not loading after update to the latest release #19976

Closed Trebor87 closed 1 week ago

Trebor87 commented 7 months ago

What happened?

I updated to 1.34.0 and after update it refused to start

I run my Zigbee using Channel 25, so I had to modify the channel back to 11 using /homeassistant/zigbee2mqtt/configuration.yaml for it to start correctly

Is it me having a wrong setting somewhere or a bug ?

I normally change the channel settings in the Zigbee / advanced page or via the Yaml page

What did you expect to happen?

No response

How to reproduce it (minimal and precise)

install update when not in channel 11

Zigbee2MQTT version

1.34.0

Adapter firmware version

20231030.2

Adapter

sonoff D

Debug log

No response

Trebor87 commented 7 months ago

managed to get the log if it helps

info 2023-12-01 23:04:02: Logging to console and directory: '/config/zigbee2mqtt/log/2023-12-01.23-04-02' filename: log.txt info 2023-12-01 23:04:02: Starting Zigbee2MQTT version 1.34.0 (commit #unknown) info 2023-12-01 23:04:02: Starting zigbee-herdsman (0.25.0) error 2023-12-01 23:04:02: Configuration is not consistent with adapter state/backup! error 2023-12-01 23:04:02: - PAN ID: configured=63585, adapter=63585 error 2023-12-01 23:04:02: - Extended PAN ID: configured=5228b8c2e1d20545, adapter=5228b8c2e1d20545 error 2023-12-01 23:04:02: - Network Key: configured=076b4cb260950782fff573a1ee92bfc5, adapter=076b4cb260950782fff573a1ee92bfc5 error 2023-12-01 23:04:02: - Channel List: configured=25, adapter=11 error 2023-12-01 23:04:02: Please update configuration to prevent further issues. error 2023-12-01 23:04:02: If you wish to re-commission your network, please remove coordinator backup at /config/zigbee2mqtt/coordinator_backup.json. error 2023-12-01 23:04:02: Re-commissioning your network will require re-pairing of all devices! error 2023-12-01 23:04:02: Error while starting zigbee-herdsman error 2023-12-01 23:04:02: Failed to start zigbee error 2023-12-01 23:04:02: Check https://www.zigbee2mqtt.io/guide/installation/20_zigbee2mqtt-fails-to-start.html for possible solutions error 2023-12-01 23:04:02: Exiting... error 2023-12-01 23:04:02: Error: startup failed - configuration-adapter mismatch - see logs above for more information at ZnpAdapterManager.determineStrategy (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/adapter/manager.ts:229:35) at ZnpAdapterManager.start (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/adapter/manager.ts:63:26) at Controller.start (/app/node_modules/zigbee-herdsman/src/controller/controller.ts:132:29) at Zigbee.start (/app/lib/zigbee.ts:60:27) at Controller.start (/app/lib/controller.ts:101:27) at start (/app/index.js:107:5)

vwtune commented 7 months ago

I have a similair problem after updating to latest release. I tried to restore de database of the older version, but didn't helped me out. So now Zigbee2mqtt isn't starting anymore:

[15:08:17] INFO: Preparing to start... [15:08:18] INFO: Socat not enabled [15:08:20] INFO: Starting Zigbee2MQTT... Zigbee2MQTT:info 2023-12-02 15:08:26: Logging to console and directory: '/config/zigbee2mqtt/log/2023-12-02.15-08-26' filename: log.txt Zigbee2MQTT:info 2023-12-02 15:08:26: Starting Zigbee2MQTT version 1.33.2 (commit #unknown) Zigbee2MQTT:info 2023-12-02 15:08:26: Starting zigbee-herdsman (0.21.0) Zigbee2MQTT:error 2023-12-02 15:08:27: Error while starting zigbee-herdsman Zigbee2MQTT:error 2023-12-02 15:08:27: Failed to start zigbee Zigbee2MQTT:error 2023-12-02 15:08:27: Check https://www.zigbee2mqtt.io/guide/installation/20_zigbee2mqtt-fails-to-start.html for possible solutions Zigbee2MQTT:error 2023-12-02 15:08:27: Exiting... Zigbee2MQTT:error 2023-12-02 15:08:27: Error: Error while opening serialport 'Error: Error: No such file or directory, cannot open /dev/ttyACM0' at SerialPort. (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/znp/znp.ts:146:28) at SerialPort._error (/app/node_modules/@serialport/stream/dist/index.js:82:22) at /app/node_modules/@serialport/stream/dist/index.js:118:18

andrejsoucek commented 7 months ago

Might be connected to a wrong version displayed in update information. Latest version is shown as: 1.99.0-1 Updated Zigbee2MQTT to version ``

KennoPa commented 7 months ago

Same issue, trying on my vm test machine, same coordinator as my main (sonoff dongle-p) I am not upgrading at my main setup On my vm: setting up z2m latest works out of the box, starts and runs normally, when switching channel from default 11 to 15, it won't start. Changing channel back in yaml to 11, then starting and it starts okay again, stopping and changing back to 15 in yaml results again error noticed on error log this:

Zigbee2MQTT:error 2023-12-03 13:19:20: - Channel List: configured=15, adapter=11

Please fix!

OK log (ch 11):

[13:26:06] INFO: Preparing to start... [13:26:06] INFO: Socat not enabled [13:26:06] INFO: Starting Zigbee2MQTT... Zigbee2MQTT:info 2023-12-03 13:26:08: Logging to console and directory: '/config/zigbee2mqtt/log/2023-12-03.13-26-08' filename: log.txt Zigbee2MQTT:info 2023-12-03 13:26:08: Starting Zigbee2MQTT version 1.34.0 (commit #unknown) Zigbee2MQTT:info 2023-12-03 13:26:08: Starting zigbee-herdsman (0.25.0) Zigbee2MQTT:info 2023-12-03 13:26:08: zigbee-herdsman started (resumed) Zigbee2MQTT:info 2023-12-03 13:26:08: Coordinator firmware version: '{"meta":{"maintrel":1,"majorrel":2,"minorrel":7,"product":1,"revision":20221226,"transportrev":2},"type":"zStack3x0"}' Zigbee2MQTT:info 2023-12-03 13:26:08: Currently 0 devices are joined: Zigbee2MQTT:info 2023-12-03 13:26:08: Zigbee: disabling joining new devices. Zigbee2MQTT:info 2023-12-03 13:26:08: Connecting to MQTT server at mqtt://core-mosquitto:1883 Zigbee2MQTT:info 2023-12-03 13:26:09: Connected to MQTT server Zigbee2MQTT:info 2023-12-03 13:26:09: MQTT publish: topic 'zigbee2mqtt/bridge/state', payload '{"state":"online"}' Zigbee2MQTT:info 2023-12-03 13:26:09: Started frontend on port 8099 Zigbee2MQTT:info 2023-12-03 13:26:09: MQTT publish: topic 'zigbee2mqtt/bridge/state', payload '{"state":"online"}' Zigbee2MQTT:info 2023-12-03 13:26:09: Zigbee2MQTT started!

ERROR log (ch 15):

[13:19:18] INFO: Preparing to start... [13:19:18] INFO: Socat not enabled [13:19:19] INFO: Starting Zigbee2MQTT... Zigbee2MQTT:info 2023-12-03 13:19:20: Logging to console and directory: '/config/zigbee2mqtt/log/2023-12-03.13-19-20' filename: log.txt Zigbee2MQTT:info 2023-12-03 13:19:20: Starting Zigbee2MQTT version 1.34.0 (commit #unknown) Zigbee2MQTT:info 2023-12-03 13:19:20: Starting zigbee-herdsman (0.25.0) Zigbee2MQTT:error 2023-12-03 13:19:20: Configuration is not consistent with adapter state/backup! Zigbee2MQTT:error 2023-12-03 13:19:20: - PAN ID: configured=30142, adapter=30142 Zigbee2MQTT:error 2023-12-03 13:19:20: - Extended PAN ID: configured=272f76d524aeaa0a, adapter=272f76d524aeaa0a Zigbee2MQTT:error 2023-12-03 13:19:20: - Network Key: configured=a9afee9e624e82a7aa5683dcb2f0bd2f, adapter=a9afee9e624e82a7aa5683dcb2f0bd2f Zigbee2MQTT:error 2023-12-03 13:19:20: - Channel List: configured=15, adapter=11 Zigbee2MQTT:error 2023-12-03 13:19:20: Please update configuration to prevent further issues. Zigbee2MQTT:error 2023-12-03 13:19:20: If you wish to re-commission your network, please remove coordinator backup at /config/zigbee2mqtt/coordinator_backup.json. Zigbee2MQTT:error 2023-12-03 13:19:20: Re-commissioning your network will require re-pairing of all devices! Zigbee2MQTT:error 2023-12-03 13:19:20: Error while starting zigbee-herdsman Zigbee2MQTT:error 2023-12-03 13:19:20: Failed to start zigbee Zigbee2MQTT:error 2023-12-03 13:19:20: Check https://www.zigbee2mqtt.io/guide/installation/20_zigbee2mqtt-fails-to-start.html for possible solutions Zigbee2MQTT:error 2023-12-03 13:19:20: Exiting... Zigbee2MQTT:error 2023-12-03 13:19:20: Error: startup failed - configuration-adapter mismatch - see logs above for more information at ZnpAdapterManager.determineStrategy (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/adapter/manager.ts:229:35) at ZnpAdapterManager.start (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/adapter/manager.ts:63:26) at Controller.start (/app/node_modules/zigbee-herdsman/src/controller/controller.ts:132:29) at Zigbee.start (/app/lib/zigbee.ts:60:27) at Controller.start (/app/lib/controller.ts:101:27) at start (/app/index.js:107:5)

DubhAd commented 7 months ago

error 2023-12-01 23:04:02: - Channel List: configured=25, adapter=11

When you changed the channel you didn't restart Z2M, so it was still using channel 11. Now you've restarted it's throwing an error as a result.

Trebor87 commented 7 months ago

So do you mean that after changing the channel to x you need to restart the dongle using the red restart as shown in the image? Screenshot_20231203-195514.png

KennoPa commented 7 months ago

error 2023-12-01 23:04:02: - Channel List: configured=25, adapter=11

When you changed the channel you didn't restart Z2M, so it was still using channel 11. Now you've restarted it's throwing an error as a result.

Actually I did. I run Z2M with default, changed channel in ui, restarted and got this error. Then went to yaml, changed value back to 11, started Z2M and all started well. Then did stop Z2M and changed channel in yaml to 15, started and got the error again. Then changed back to 11, started and again all okay.

Where did I made mistake?

KennoPa commented 7 months ago

So do you mean that after changing the channel to x you need to restart the dongle using the red restart as shown in the image? Screenshot_20231203-195514.png

Did that yes

ucsbricks commented 7 months ago

My instance fails to start too, since updating to the latest version. Please fix ASAP, this is a serious issue.

DubhAd commented 7 months ago

My instance fails to start too, since updating to the latest version. Please fix ASAP, this is a serious issue.

What's in your log about the problem? This thread was opened by somebody who's adapter was set to a different channel than in their config.

KennoPa commented 7 months ago

Okay, found a post about this, seems that channel change requires some hw steps as well: https://community.home-assistant.io/t/how-to-change-channel-of-zigbee2mqtt-addon/540435/6

My main setup did not broke with update as channel was not changed, will play around with vm later

github-actions[bot] commented 1 month ago

This issue is stale because it has been open 180 days with no activity. Remove stale label or comment or this will be closed in 30 days