z2b crashes

[jesperrula]

I excuse for the bad title, but I really don't know how to explain this shortly.

I have just started using z2b. I want to investigate its potential for a use case. My use case is that I have up to 20 buttons (this one https://www.zigbee2mqtt.io/devices/3RSB22BZ.html). I have set up a Sonoff ZBDongle-E as configurator. Installed z2b and mosquitto on a Windows 10 machine.

Each of the buttons must be able to deliver clicks as quickly as one per second. With minimum delay and without any lost packages.

However, what I see with even just one device is that the adapter driver crashes as soon as I click 3-4 times within for example 10 seconds. I tried ezsp and ember drivers. Both have similar behavior so maybe z2b isnt just a good use case or there is some configuration I need to make for this to run.

An example log output looks like this (hitting a button 4 times):

[2024-08-08 22:41:21] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/unit1', payload '{"battery":95,"linkquality":172,"update":{"installed_version":28,"latest_version":28,"state":"idle"},"voltage":3100}'
[2024-08-08 22:41:21] info: z2m: Zigbee2MQTT started!
[2024-08-08 22:41:22] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/unit1', payload '{"action":"single","battery":95,"linkquality":220,"update":{"installed_version":28,"latest_version":28,"state":"idle"},"voltage":3100}'
[2024-08-08 22:41:31] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/unit1', payload '{"action":"single","battery":95,"linkquality":144,"update":{"installed_version":28,"latest_version":28,"state":"idle"},"voltage":3100}'
[2024-08-08 22:41:35] error: zh:ezsp:uart: --> Error: Error: {"sequence":5} after 4000ms
[2024-08-08 22:41:35] error: zh:ezsp:uart: -!- break waiting (5)
[2024-08-08 22:41:35] error: zh:ezsp:uart: Can't send DATA frame (4,1,0): 34000134000053b204010600010100010000090a0518610b0100
[2024-08-08 22:41:39] error: zh:ezsp:uart: --> Error: Error: {"sequence":5} after 4000ms
[2024-08-08 22:41:39] error: zh:ezsp:uart: -!- break rewaiting (5)
[2024-08-08 22:41:39] error: zh:ezsp:uart: Can't resend DATA frame (4,1,1): 34000134000053b204010600010100010000090a0518610b0100
[2024-08-08 22:41:39] error: zh:ezsp:uart: Port error: Error: Writing to COM port (GetOverlappedResult): Operation aborted
[2024-08-08 22:41:45] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/unit1', payload '{"action":"single","battery":95,"linkquality":104,"update":{"installed_version":28,"latest_version":28,"state":"idle"},"voltage":3100}'
[2024-08-08 22:41:47] error: zh:ezsp:uart: --> Error: Error: {"sequence":-1} after 10000ms
[2024-08-08 22:41:47] error: zh:ezsp:uart: Failed to reset on Error Frame: Error: Reset error: Error: {"sequence":-1} after 10000ms
[2024-08-08 22:41:47] error: zh:ezsp:uart: Port error: Error: Writing to COM port (GetOverlappedResult): Operation aborted
[2024-08-08 22:41:47] error: z2m: Adapter disconnected, stopping
[2024-08-08 22:41:47] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/bridge/state', payload '{"state":"offline"}'
[2024-08-08 22:41:47] info: z2m: Disconnecting from MQTT server
[2024-08-08 22:41:47] info: z2m: Stopping zigbee-herdsman...
[2024-08-08 22:41:47] info: z2m: Stopped zigbee-herdsman
[2024-08-08 22:41:47] info: z2m: Stopped Zigbee2MQTT

I hope I can find some help in this forum. Thank you.

br
Jesper

[jesperrula]

Here is log output when using ember.
The only thing I am doing here is to start z2m and then hit the button on the device every 1-2 seconds. After 4 hits, z2m crashes. What is happening?

[2024-08-09 08:06:07] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/unit1', payload '{"action":"single","battery":95,"linkquality":188,"update":{"installed_version":28,"latest_version":28,"state":"idle"},"voltage":3100}'
[2024-08-09 08:06:08] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/unit1', payload '{"action":"single","battery":95,"linkquality":204,"update":{"installed_version":28,"latest_version":28,"state":"idle"},"voltage":3100}'
[2024-08-09 08:06:09] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/unit1', payload '{"action":"single","battery":95,"linkquality":204,"update":{"installed_version":28,"latest_version":28,"state":"idle"},"voltage":3100}'
[2024-08-09 08:06:10] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/unit1', payload '{"action":"single","battery":95,"linkquality":204,"update":{"installed_version":28,"latest_version":28,"state":"idle"},"voltage":3100}'
[2024-08-09 08:06:14] error: zh:ember:uart:ash: Received ERROR from adapter, with code=ERROR_EXCEEDED_MAXIMUM_ACK_TIMEOUT_COUNT.
[2024-08-09 08:06:14] error: zh:ember:uart:ash: ASH disconnected | Adapter status: ASH_NCP_FATAL_ERROR
[2024-08-09 08:06:14] error: zh:ember:uart:ash: Error while parsing received frame, status=ASH_NCP_FATAL_ERROR.
[2024-08-09 08:06:14] error: zh:ember: !!! ADAPTER FATAL ERROR reason=HOST_FATAL_ERROR. !!!
[2024-08-09 08:06:14] info: zh:ember: Request queue is high (6), triggering full restart to prevent stressing the adapter.
[2024-08-09 08:06:14] info: zh:ember:uart:ash: ASH COUNTERS since last clear:
[2024-08-09 08:06:14] info: zh:ember:uart:ash: Total frames: RX=63, TX=104
[2024-08-09 08:06:14] info: zh:ember:uart:ash: Cancelled : RX=0, TX=0
[2024-08-09 08:06:14] info: zh:ember:uart:ash: DATA frames : RX=52, TX=41
[2024-08-09 08:06:14] info: zh:ember:uart:ash: DATA bytes : RX=647, TX=482
[2024-08-09 08:06:14] info: zh:ember:uart:ash: Retry frames: RX=9, TX=3
[2024-08-09 08:06:14] info: zh:ember:uart:ash: ACK frames : RX=0, TX=59
[2024-08-09 08:06:14] info: zh:ember:uart:ash: NAK frames : RX=0, TX=0
[2024-08-09 08:06:14] info: zh:ember:uart:ash: nRdy frames : RX=0, TX=0
[2024-08-09 08:06:14] info: zh:ember:uart:ash: CRC errors : RX=0
[2024-08-09 08:06:14] info: zh:ember:uart:ash: Comm errors : RX=0
[2024-08-09 08:06:14] info: zh:ember:uart:ash: Length < minimum: RX=0
[2024-08-09 08:06:14] info: zh:ember:uart:ash: Length > maximum: RX=0
[2024-08-09 08:06:14] info: zh:ember:uart:ash: Bad controls : RX=0
[2024-08-09 08:06:14] info: zh:ember:uart:ash: Bad lengths : RX=0
[2024-08-09 08:06:14] info: zh:ember:uart:ash: Bad ACK numbers : RX=0
[2024-08-09 08:06:14] info: zh:ember:uart:ash: Out of buffers : RX=0
[2024-08-09 08:06:14] info: zh:ember:uart:ash: Retry dupes : RX=9
[2024-08-09 08:06:14] info: zh:ember:uart:ash: Out of sequence : RX=0
[2024-08-09 08:06:14] info: zh:ember:uart:ash: ACK timeouts : RX=3
[2024-08-09 08:06:14] error: zh:ember:uart:ash: ASH disconnected: ASH_ERROR_RESET_FAIL | Adapter status: ASH_NCP_FATAL_ERROR
[2024-08-09 08:06:14] info: zh:ember:uart:ash: Port Error: Writing to COM port (GetOverlappedResult): Operation aborted
[2024-08-09 08:06:14] info: zh:ember:uart:ash: Port closed.
[2024-08-09 08:06:14] info: zh:ember:uart:ash: ======== ASH stopped ========
[2024-08-09 08:06:14] info: zh:ember:ezsp: ======== EZSP stopped ========
[2024-08-09 08:06:14] info: zh:ember: ======== Ember Adapter Stopped ========
[2024-08-09 08:06:14] error: z2m: Adapter disconnected, stopping
[2024-08-09 08:06:14] info: z2m:mqtt: MQTT publish: topic 'zigbee2mqtt/bridge/state', payload '{"state":"offline"}'
[2024-08-09 08:06:14] info: z2m: Disconnecting from MQTT server
[2024-08-09 08:06:14] info: z2m: Stopping zigbee-herdsman...
[2024-08-09 08:06:14] info: z2m: Stopped zigbee-herdsman
[2024-08-09 08:06:14] info: z2m: Stopped Zigbee2MQTT

[jesperrula]

Problem was immediately solved when I downgraded the firmware of the adapter to 7.4.2.0. Specifically this one: https://github.com/darkxst/silabs-firmware-builder/blob/main/firmware_builds/zbdonglee/ncp-uart-hw-v7.4.2.0-zbdonglee-115200.gbl