search

Koenkk / zigbee2mqtt

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

Zigbee2MQTT crashes every few days #22329

Closed xcomputerman closed 1 month ago

xcomputerman commented 6 months ago

What happened?

I've been getting periodic crashes. This happened when I was using ezsp and is still happening after switching to ember. I'm using a SLZB-06M coordinator over TCP. Log attached.

What did you expect to happen?

No response

How to reproduce it (minimal and precise)

No response

Zigbee2MQTT version

1.36.1

Adapter firmware version

7.4.1 [GA]

Adapter

SMLight SLZB-06M

Setup

Home Assistant add-on, about 38 devices

Debug log

zigbeelog.txt

xcomputerman commented 6 months ago

Latest crash log. zigbeelog2.txt

Nerivec commented 5 months ago

Can you confirm this still happens with latest core firmware from SMLight (2.2.x, with latest emberznet firmware too)?

Loic691 commented 5 months ago

I have the same behaviour after swtch from Sonoff E to SMLight SLZB-06M. For me all is up to date with the last core and zigbee firmware (wich is known as 7.4.1 GA in Z2M)

xcomputerman commented 5 months ago

I updated my SLZB-06M ESP firmware to the latest beta. I have had only one crash since then, but that is much better than before which was literally every few days. I think I have now gone at least two weeks without a crash. Keeping an eye on it.

From: Loic69 @.> Sent: Monday, May 27, 2024 2:29 PM To: Koenkk/zigbee2mqtt @.> Cc: Ibukun Olumuyiwa @.>; Author @.> Subject: Re: [Koenkk/zigbee2mqtt] Zigbee2MQTT crashes every few days (Issue #22329)

I have the same behaviour after swtch from Sonoff E to SMLight SLZB-06M. For me all is up to date with the last core and zigbee firmware (wich is known as 7.4.1 GA in Z2M)

— Reply to this email directly, view it on GitHubhttps://github.com/Koenkk/zigbee2mqtt/issues/22329#issuecomment-2133968324, or unsubscribehttps://github.com/notifications/unsubscribe-auth/AC2BI3A3Q3Z2Q7DWJ6K6IZLZEOCRNAVCNFSM6AAAAABG4VAHDCVHI2DSMVQWIX3LMV43OSLTON2WKQ3PNVWWK3TUHMZDCMZTHE3DQMZSGQ. You are receiving this because you authored the thread.Message ID: @.***>

Loic691 commented 5 months ago

I updated my SLZB-06M ESP firmware to the latest beta. I have had only one crash since then, but that is much better than before which was literally every few days. I think I have now gone at least two weeks without a crash. Keeping an eye on it. …

Thx. I will try. I have too another problem wirh this dongle. If I restart whole HA OS, the z2m don't stary correctly. I have after restart to stop Z2m add on. Cycle PoE and qo restart again s2m.

Do you have this same bahaviour ?

Loic691 commented 5 months ago

You talk about core firmware 2.2.8.dev ? My zigbee firmware on it was the last one (20240510) wich is 7.4.1 GA of EFR32 chip

Loic691 commented 5 months ago

@Nerivec Can we use firmware_builds/slzb-06m on the dongle with OTA update from the core firmware GUI ? What's is the best or official firmware ? I'm confused with all this test and firmware...

Nerivec commented 5 months ago

You should stay on the one recommended by smlight. Can you elaborate on what you mean by "z2m doesn't start correctly"?

@darkxst Can you take a look at this once we have some more details?

darkxst commented 5 months ago

If I restart whole HA OS, the z2m don't stary correctly. I have after restart to stop Z2m add on. Cycle PoE and qo restart again s2m.

If possible can you get logs from serial console attached to USB (/dev/ttyUSB0 or COM#) on SLZB-06M

xcomputerman commented 5 months ago

New crash today. Log is attached!

On Mon, May 27, 2024, 6:26 PM Ibukun Olumuyiwa @.***> wrote:

I updated my SLZB-06M ESP firmware to the latest beta. I have had only one crash since then, but that is much better than before which was literally every few days. I think I have now gone at least two weeks without a crash. Keeping an eye on it.

From: Loic69 @.> Sent: Monday, May 27, 2024 2:29 PM To: Koenkk/zigbee2mqtt @.> Cc: Ibukun Olumuyiwa @.>; Author < @.> Subject: Re: [Koenkk/zigbee2mqtt] Zigbee2MQTT crashes every few days (Issue #22329)

I have the same behaviour after swtch from Sonoff E to SMLight SLZB-06M. For me all is up to date with the last core and zigbee firmware (wich is known as 7.4.1 GA in Z2M)

— Reply to this email directly, view it on GitHub https://github.com/Koenkk/zigbee2mqtt/issues/22329#issuecomment-2133968324, or unsubscribe https://github.com/notifications/unsubscribe-auth/AC2BI3A3Q3Z2Q7DWJ6K6IZLZEOCRNAVCNFSM6AAAAABG4VAHDCVHI2DSMVQWIX3LMV43OSLTON2WKQ3PNVWWK3TUHMZDCMZTHE3DQMZSGQ . You are receiving this because you authored the thread.Message ID: @.***>

[2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7 frmNum=6] Added to rxQueue [2024-05-29 09:16:10] debug: zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=7] [2024-05-29 09:16:10] debug: zh:ember:ezsp: <=== [FRAME: ID=21:"SET_MANUFACTURER_CODE" Seq=14 Len=5] [2024-05-29 09:16:10] debug: zh:ember:ezsp: ===> [FRAME: ID=83:"SET_CONFIGURATION_VALUE" Seq=15 Len=8] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=7 frmRx=7] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0 frmNum=7] Added to rxQueue [2024-05-29 09:16:10] debug: zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=0] [2024-05-29 09:16:10] debug: zh:ember:ezsp: <=== [FRAME: ID=83:"SET_CONFIGURATION_VALUE" Seq=15 Len=6] [2024-05-29 09:16:10] debug: zh:ember: [EzspConfigId] SET "STACK_PROFILE" TO "2" with status=SUCCESS. [2024-05-29 09:16:10] debug: zh:ember:ezsp: ===> [FRAME: ID=83:"SET_CONFIGURATION_VALUE" Seq=16 Len=8] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=0 frmRx=0] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1 frmNum=0] Added to rxQueue [2024-05-29 09:16:10] debug: zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=1] [2024-05-29 09:16:10] debug: zh:ember:ezsp: <=== [FRAME: ID=83:"SET_CONFIGURATION_VALUE" Seq=16 Len=6] [2024-05-29 09:16:10] debug: zh:ember: [EzspConfigId] SET "SECURITY_LEVEL" TO "5" with status=SUCCESS. [2024-05-29 09:16:10] debug: zh:ember:ezsp: ===> [FRAME: ID=82:"GET_CONFIGURATION_VALUE" Seq=17 Len=6] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=1 frmRx=1] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2 frmNum=1] Added to rxQueue [2024-05-29 09:16:10] debug: zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=2] [2024-05-29 09:16:10] debug: zh:ember:ezsp: <=== [FRAME: ID=82:"GET_CONFIGURATION_VALUE" Seq=17 Len=8] [2024-05-29 09:16:10] debug: zh:ember:ezsp: ===> [FRAME: ID=83:"SET_CONFIGURATION_VALUE" Seq=18 Len=8] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=2 frmRx=2] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3 frmNum=2] Added to rxQueue [2024-05-29 09:16:10] debug: zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=3] [2024-05-29 09:16:10] debug: zh:ember:ezsp: <=== [FRAME: ID=83:"SET_CONFIGURATION_VALUE" Seq=18 Len=6] [2024-05-29 09:16:10] debug: zh:ember: [EzspConfigId] SET "BINDING_TABLE_SIZE" TO "32" with status=SUCCESS. [2024-05-29 09:16:10] debug: zh:ember:ezsp: ===> [FRAME: ID=83:"SET_CONFIGURATION_VALUE" Seq=19 Len=8] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=3 frmRx=3] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=4 frmNum=3] Added to rxQueue [2024-05-29 09:16:10] debug: zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=4] [2024-05-29 09:16:10] debug: zh:ember:ezsp: <=== [FRAME: ID=83:"SET_CONFIGURATION_VALUE" Seq=19 Len=6] [2024-05-29 09:16:10] debug: zh:ember: [EzspConfigId] SET "KEY_TABLE_SIZE" TO "0" with status=SUCCESS. [2024-05-29 09:16:10] debug: zh:ember:ezsp: ===> [FRAME: ID=83:"SET_CONFIGURATION_VALUE" Seq=20 Len=8] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=4 frmRx=4] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=5 frmNum=4] Added to rxQueue [2024-05-29 09:16:10] debug: zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=5] [2024-05-29 09:16:10] debug: zh:ember:ezsp: <=== [FRAME: ID=83:"SET_CONFIGURATION_VALUE" Seq=20 Len=6] [2024-05-29 09:16:10] debug: zh:ember: [EzspConfigId] SET "MAX_END_DEVICE_CHILDREN" TO "32" with status=SUCCESS. [2024-05-29 09:16:10] debug: zh:ember:ezsp: ===> [FRAME: ID=83:"SET_CONFIGURATION_VALUE" Seq=21 Len=8] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=5 frmRx=5] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=6 frmNum=5] Added to rxQueue [2024-05-29 09:16:10] debug: zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=6] [2024-05-29 09:16:10] debug: zh:ember:ezsp: <=== [FRAME: ID=83:"SET_CONFIGURATION_VALUE" Seq=21 Len=6] [2024-05-29 09:16:10] debug: zh:ember: [EzspConfigId] SET "APS_UNICAST_MESSAGE_COUNT" TO "32" with status=ERROR_OUT_OF_MEMORY. [2024-05-29 09:16:10] warning: zh:ember: [EzspConfigId] Failed to SET "APS_UNICAST_MESSAGE_COUNT" TO "32" with status=ERROR_OUT_OF_MEMORY. Firmware value will be used instead. [2024-05-29 09:16:10] debug: zh:ember:ezsp: ===> [FRAME: ID=83:"SET_CONFIGURATION_VALUE" Seq=22 Len=8] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=6 frmRx=6] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=7 frmNum=6] Added to rxQueue [2024-05-29 09:16:10] debug: zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=7] [2024-05-29 09:16:10] debug: zh:ember:ezsp: <=== [FRAME: ID=83:"SET_CONFIGURATION_VALUE" Seq=22 Len=6] [2024-05-29 09:16:10] debug: zh:ember: [EzspConfigId] SET "BROADCAST_TABLE_SIZE" TO "15" with status=SUCCESS. [2024-05-29 09:16:10] debug: zh:ember:ezsp: ===> [FRAME: ID=83:"SET_CONFIGURATION_VALUE" Seq=23 Len=8] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=7 frmRx=7] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=0 frmNum=7] Added to rxQueue [2024-05-29 09:16:10] debug: zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=0] [2024-05-29 09:16:10] debug: zh:ember:ezsp: <=== [FRAME: ID=83:"SET_CONFIGURATION_VALUE" Seq=23 Len=6] [2024-05-29 09:16:10] debug: zh:ember: [EzspConfigId] SET "NEIGHBOR_TABLE_SIZE" TO "26" with status=ERROR_OUT_OF_MEMORY. [2024-05-29 09:16:10] warning: zh:ember: [EzspConfigId] Failed to SET "NEIGHBOR_TABLE_SIZE" TO "26" with status=ERROR_OUT_OF_MEMORY. Firmware value will be used instead. [2024-05-29 09:16:10] debug: zh:ember:ezsp: ===> [FRAME: ID=83:"SET_CONFIGURATION_VALUE" Seq=24 Len=8] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=0 frmRx=0] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=1 frmNum=0] Added to rxQueue [2024-05-29 09:16:10] debug: zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=1] [2024-05-29 09:16:10] debug: zh:ember:ezsp: <=== [FRAME: ID=83:"SET_CONFIGURATION_VALUE" Seq=24 Len=6] [2024-05-29 09:16:10] debug: zh:ember: [EzspConfigId] SET "END_DEVICE_POLL_TIMEOUT" TO "8" with status=SUCCESS. [2024-05-29 09:16:10] debug: zh:ember:ezsp: ===> [FRAME: ID=83:"SET_CONFIGURATION_VALUE" Seq=25 Len=8] [2024-05-29 09:16:10] debug: zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=1 frmRx=1] [2024-05-29 09:16:11] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-05-29 09:16:11] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2] [2024-05-29 09:16:11] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=2 frmNum=1] Added to rxQueue [2024-05-29 09:16:11] debug: zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=2] [2024-05-29 09:16:11] debug: zh:ember:ezsp: <=== [FRAME: ID=83:"SET_CONFIGURATION_VALUE" Seq=25 Len=6] [2024-05-29 09:16:11] debug: zh:ember: [EzspConfigId] SET "TRANSIENT_KEY_TIMEOUT_S" TO "300" with status=SUCCESS. [2024-05-29 09:16:11] debug: zh:ember:ezsp: ===> [FRAME: ID=83:"SET_CONFIGURATION_VALUE" Seq=26 Len=8] [2024-05-29 09:16:11] debug: zh:ember:uart:ash: ---> [FRAME type=DATA frmTx=2 frmRx=2] [2024-05-29 09:16:11] debug: zh:ember:uart:ash: <--- [FRAME type=DATA] [2024-05-29 09:16:12] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3] [2024-05-29 09:16:12] debug: zh:ember:uart:ash: <--- [FRAME type=DATA ackNum=3 frmNum=2] Added to rxQueue [2024-05-29 09:16:12] debug: zh:ember:uart:ash: ---> [FRAME type=ACK frmRx=3] [2024-05-29 09:16:13] debug: zh:ember:ezsp: <=== [FRAME: ID=83:"SET_CONFIGURATION_VALUE" Seq=26 Len=6] [2024-05-29 09:16:15] debug: zh:ember: [EzspConfigId] SET "RETRY_QUEUE_SIZE" TO "16" with status=SUCCESS.