Help me understand why Z2M Addon Crashes

Hi all,

I’m having issues where my Zigbee2MQTT addon crashes and therefore means my whole Zigbee network dies. I think it is down to a particular device causing issues, but I don’t know enough to determine anything.

The logs don’t reveal much to me, however, I do find that when the addon restarts, the only device that doesn’t work is one of my Aqara C1 Pet Feeders (I have 2 of these, and they’re right next to each other, literally opposite my co-ordinator).

Home Assistant is running on Proxmox in a VM using the Z2M addon from the addon store.

Below are my various files and logs, as I’m hoping someone might be able to help me understand what’s going on.

configuration.yaml file - I’ve typed blank for sensitive information.

homeassistant: true
mqtt:
  server: mqtt://core-mosquitto:blank
  password: blank
  user: addons
serial:
  port: >-
    /dev/serial/by-id/usb-Silicon_Labs_Sonoff_Zigbee_3.0_USB_Dongle_Plus_0001-if00-port0
frontend:
  port: blank
advanced:
  homeassistant_legacy_entity_attributes: false
  legacy_api: false
  legacy_availability_payload: false
  log_level: debug
  log_syslog:
    app_name: Zigbee2MQTT
    eol: /n
    host: localhost
    localhost: localhost
    path: /dev/log
    pid: process.pid
    port: 514
    protocol: udp4
    type: '5424'
  channel: 25
device_options:
  legacy: false
devices:
  '0xdc8e95fffe357119':
    friendly_name: Living Room Light Switch
  '0x00158d00091e9308':
    friendly_name: Patio Door Sensor
  '0x70b3d52b60020be6':
    friendly_name: Aquarium
  '0x84b4dbfffe089e28':
    friendly_name: Jake's Room Light Switch
  '0x00158d00097788dd':
    friendly_name: Emma's Room Temp Sensor
  '0x00158d0009cf91aa':
    friendly_name: Living Room Temp Sensor
  '0x70b3d52b60023b42':
    friendly_name: Jake’s Bedroom Fan
  '0x001788010cd58d20':
    friendly_name: Hallway Motion Sensor
  '0x00158d0009c8b229':
    friendly_name: Living Room Window
  '0x00158d0009c8b2b1':
    friendly_name: Emma's Room Window
  '0x00158d0009c8b29f':
    friendly_name: Jake's Room Window
  '0x00158d00093e3610':
    friendly_name: Back Door Sensor
  '0x00158d0009c864b0':
    friendly_name: Dining Room Temperature Sensor
  '0x94deb8fffe483239':
    friendly_name: Office Light Switch
  '0x00158d0009ef65be':
    friendly_name: Office Temperature Sensor
  '0x70b3d52b60020d69':
    friendly_name: Air Freshener
  '0x70b3d52b60020cfe':
    friendly_name: Media Centre
  '0x00158d0009c8b2d2':
    friendly_name: Office Window
  '0x70b3d52b600305b1':
    friendly_name: Projector
  '0x00158d0009ef619d':
    friendly_name: Porch Temperature Sensor
  '0x001788010cd85fad':
    friendly_name: Kitchen Motion Sensor
  '0x70b3d52b60020c85':
    friendly_name: Junimo
  '0x00158d0009c8b1b2':
    friendly_name: Front Door Sensor
  '0x6c5cb1fffe61e5f4':
    friendly_name: Porch Light
  '0x94deb8fffe5a054b':
    friendly_name: Dining Room Light Switch
  '0x001788010cd7e851':
    friendly_name: Landing Motion Sensor
  '0x00158d0009e7b05b':
    friendly_name: Kitchen Window
  '0xf4b3b1fffeacd113':
    friendly_name: Upstairs Hallway Sensor
    occupancy_timeout: 10
  '0x00158d0009ea0a95':
    friendly_name: Garage Side Door
  '0xdc8e95fffe256317':
    friendly_name: Emma’s Room Light Switch
  '0x70ac08fffe971134':
    friendly_name: Porch Motion Sensor
    occupancy_timeout: 10
  '0x00158d000705142c':
    friendly_name: Button
  '0x001788010bced407':
    friendly_name: Bathroom Sensor
  '0x6c5cb1fffe9a55f3':
    friendly_name: Emma's Button
  '0x70ac08fffe67f8fc':
    friendly_name: Downstairs Landing Sensor
    occupancy_timeout: 10
  '0x00158d0009d0e02d':
    friendly_name: Jake's Room Temp Sensor
  '0x70b3d52b60028d5d':
    friendly_name: Animal Planet
  '0x00158d000acaeed6':
    friendly_name: Emma's Bedroom Button
  '0x00158d000acb0a77':
    friendly_name: Hallway Button
  '0x00158d0009ea0a1f':
    friendly_name: Jake’s Room Door Sensor
  '0x7cb94c779c510000':
    friendly_name: Xmas Tree
  '0x54ef44100060fc60':
    friendly_name: Kitchen Light Switch
  '0x54ef441000711cd0':
    friendly_name: Cat Feeder 1
  '0x00158d000ab7931b':
    friendly_name: Fish Tank
  '0x00158d000abda977':
    friendly_name: Kitchen Sink
  '0x00158d000a838e5a':
    friendly_name: Kitchen Temp Sensor
  '0x00158d000a8389c8':
    friendly_name: Hallway Temp Sensor
  '0x00158d000ab621bb':
    friendly_name: Bathroom Leak
  '0x00158d000a834e26':
    friendly_name: Bathroom Temp Sensor
  '0x00158d000a838998':
    friendly_name: Landing Temp Sensor
  '0x54ef44100070ea46':
    friendly_name: Cat Feeder 2
blocklist: []
availability:
  active:
    timeout: 5
  passive:
    timeout: 1500
groups: {}
external_converters:
  - ext_converter.js
zigbee_herdsman_debug: true

My Z2M is quite big so here’s a pastebin link for it- https://pastebin.pl/view/34f5610a

The socat configuration in the addon itself is below;

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

This is causing a lot of frustration and I’m really not sure what’s going on, so any help would be appreciated.

I don’t see anything in there to suggest it crashed or stopped.

I know the system has crashed because I have new log files and folders at the time it has crashed, but no error messages anywhere that I can see.

image

I’ve tried enabling all the logging that I can find but I’m not having much luck.

@Tinkerer I managed to capture one error that appeared in my log when I disabled Watchdog.

Zigbee2MQTT:debug 2023-12-09 06:00:19: Received Zigbee message from 'Kitchen Motion Sensor', type 'attributeReport', cluster 'msOccupancySensing', data '{"occupancy":0}' from endpoint 2 with groupID 0
Zigbee2MQTT:info  2023-12-09 06:00:19: MQTT publish: topic 'zigbee2mqtt/Kitchen Motion Sensor', payload '{"battery":100,"illuminance":0,"illuminance_lux":0,"led_indication":null,"linkquality":40,"motion_sensitivity":"max","occupancy":false,"occupancy_timeout":10,"temperature":17.26}'
Zigbee2MQTT:debug 2023-12-09 06:00:21: Received Zigbee message from 'Aquarium', type 'attributeReport', cluster 'genBasic', data '{"appVersion":100}' from endpoint 1 with groupID 0
Zigbee2MQTT:debug 2023-12-09 06:00:23: Received Zigbee message from 'Hallway Motion Sensor', type 'attributeReport', cluster 'msOccupancySensing', data '{"occupancy":0}' from endpoint 2 with groupID 0
Zigbee2MQTT:info  2023-12-09 06:00:23: MQTT publish: topic 'zigbee2mqtt/Hallway Motion Sensor', payload '{"battery":100,"illuminance":0,"illuminance_lux":0,"led_indication":null,"linkquality":76,"motion_sensitivity":"max","occupancy":false,"occupancy_timeout":5,"temperature":17.77}'
Zigbee2MQTT:debug 2023-12-09 06:00:23: Received Zigbee message from 'Hallway Motion Sensor', type 'attributeReport', cluster 'msOccupancySensing', data '{"occupancy":0}' from endpoint 2 with groupID 0
Zigbee2MQTT:info  2023-12-09 06:00:23: MQTT publish: topic 'zigbee2mqtt/Hallway Motion Sensor', payload '{"battery":100,"illuminance":0,"illuminance_lux":0,"led_indication":null,"linkquality":80,"motion_sensitivity":"max","occupancy":false,"occupancy_timeout":5,"temperature":17.77}'
Error: Write 0x54ef44100070ea46/1 aqaraOpple({"65521":{"value":{"type":"Buffer","data":[0,2,11,4,21,0,85,1,1]},"type":65}}, {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"srcEndpoint":null,"reservedBits":0,"manufacturerCode":4447,"transactionSequenceNumber":null,"writeUndiv":false}) failed (Timeout - 27945 - 1 - 144 - 64704 - 4 after 10000ms)
    at Timeout._onTimeout (/app/node_modules/zigbee-herdsman/src/utils/waitress.ts:64:35)
    at listOnTimeout (node:internal/timers:559:17)
    at processTimers (node:internal/timers:502:7)

After this Z2M crashed and it’s not restarted. Any ideas?

@Tinkerer Got some more logs now, maybe something more meaningful.

Zigbee2MQTT:info  2023-12-09 17:07:10: MQTT publish: topic 'zigbee2mqtt/Living Room Light Switch', payload '{"brightness":63,"linkquality":83,"power_on_behavior":null,"state":"ON"}'
2023-12-09T17:07:10.364Z zigbee-herdsman:adapter:zStack:adapter sendZclFrameToEndpointInternal 0xdc8e95fffe357119:6889/1 (0,0,18)
2023-12-09T17:07:10.365Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,13,69,193,143,220,143,220,40,158,8,254,255,219,180,132,142,83,254,1,100,1,0,100,254,3,68,128,0,1,229,35]
2023-12-09T17:07:10.365Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,13,69,193,143,220,143,220,40,158,8,254,255,219,180,132,142,83,254,1,100,1,0,100,254,3,68,128,0,1,229,35]
2023-12-09T17:07:10.365Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 13 - 2 - 5 - 193 - [143,220,143,220,40,158,8,254,255,219,180,132,142] - 83
2023-12-09T17:07:10.366Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- ZDO - endDeviceAnnceInd - {"srcaddr":56463,"nwkaddr":56463,"ieeeaddr":"0x84b4dbfffe089e28","capabilities":142}
2023-12-09T17:07:10.366Z zigbee-herdsman:controller:log Device announce '0x84b4dbfffe089e28'
Zigbee2MQTT:debug 2023-12-09 17:07:10: Device 'Jake's Room Light Switch' announced itself
2023-12-09T17:07:10.420Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,1,100,1,0,100,254,3,68,128,0,1,229,35]
2023-12-09T17:07:10.420Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 1 - 3 - 4 - 1 - [0] - 100
2023-12-09T17:07:10.420Z zigbee-herdsman:adapter:zStack:znp:SRSP <-- AF - dataRequest - {"status":0}
2023-12-09T17:07:10.420Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,3,68,128,0,1,229,35]
2023-12-09T17:07:10.420Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 3 - 2 - 4 - 128 - [0,1,229] - 35
2023-12-09T17:07:10.420Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- AF - dataConfirm - {"status":0,"endpoint":1,"transid":229}
2023-12-09T17:07:10.420Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2023-12-09T17:07:10.420Z zigbee-herdsman:adapter:zStack:znp:SREQ --> AF - dataRequestExt - {"dstaddrmode":2,"dstaddr":"0x000000000000fffd","destendpoint":242,"dstpanid":0,"srcendpoint":242,"clusterid":33,"transid":230,"options":0,"radius":30,"len":6,"data":{"type":"Buffer","data":[25,12,2,11,254,0]}}
2023-12-09T17:07:10.421Z zigbee-herdsman:adapter:zStack:unpi:writer --> frame [254,26,36,2,2,253,255,0,0,0,0,0,0,242,0,0,242,33,0,230,0,30,6,0,25,12,2,11,254,0,1]
2023-12-09T17:07:10.421Z zigbee-herdsman:adapter:zStack:adapter sendZclFrameToEndpointInternal 0x84b4dbfffe089e28:56463/1 (0,0,17)
Zigbee2MQTT:info  2023-12-09 17:07:10: MQTT publish: topic 'zigbee2mqtt/bridge/event', payload '{"data":{"friendly_name":"Jake's Room Light Switch","ieee_address":"0x84b4dbfffe089e28"},"type":"device_announce"}'
2023-12-09T17:07:10.427Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,1,100,2,17,118]
2023-12-09T17:07:10.427Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,1,100,2,17,118]
2023-12-09T17:07:10.427Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 1 - 3 - 4 - 2 - [17] - 118
2023-12-09T17:07:10.427Z zigbee-herdsman:adapter:zStack:znp:SRSP <-- AF - dataRequestExt - {"status":17}
2023-12-09T17:07:10.427Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2023-12-09T17:07:10.427Z zigbee-herdsman:adapter:zStack:znp:SREQ --> AF - dataRequest - {"dstaddr":11397,"destendpoint":1,"srcendpoint":1,"clusterid":2820,"transid":231,"options":0,"radius":30,"len":9,"data":{"type":"Buffer","data":[16,13,0,5,5,8,5,11,5]}}
2023-12-09T17:07:10.427Z zigbee-herdsman:adapter:zStack:unpi:writer --> frame [254,19,36,1,133,44,1,1,4,11,231,0,30,9,16,13,0,5,5,8,5,11,5,126]
Error: SREQ '--> AF - dataRequestExt - {"dstaddrmode":2,"dstaddr":"0x000000000000fffd","destendpoint":242,"dstpanid":0,"srcendpoint":242,"clusterid":33,"transid":230,"options":0,"radius":30,"len":6,"data":{"type":"Buffer","data":[25,12,2,11,254,0]}}' failed with status '(0x11: BUFFER_FULL)' (expected '(0x00: SUCCESS)')
    at Object.func (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/znp/znp.ts:322:27)
    at Queue.executeNext (/app/node_modules/zigbee-herdsman/src/utils/queue.ts:32:32)

At the time, I was trying to repair a Tuya BSD29 smart plug.

More errors and another crash;

2023-12-09T21:00:27.618Z zigbee-herdsman:adapter:zStack:unpi:writer --> frame [254,15,36,1,130,8,1,1,6,0,187,0,30,5,24,1,11,10,0,30]
2023-12-09T21:00:27.618Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
Zigbee2MQTT:info  2023-12-09 21:00:27: MQTT publish: topic 'zigbee2mqtt/Emma's Room Light Switch', payload '{"brightness":238,"linkquality":102,"power_on_behavior":null,"state":"ON"}'
2023-12-09T21:00:27.627Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,1,100,1,0,100]
2023-12-09T21:00:27.627Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,1,100,1,0,100]
2023-12-09T21:00:27.627Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 1 - 3 - 4 - 1 - [0] - 100
2023-12-09T21:00:27.627Z zigbee-herdsman:adapter:zStack:znp:SRSP <-- AF - dataRequest - {"status":0}
2023-12-09T21:00:27.627Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2023-12-09T21:00:27.632Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,3,68,128,0,1,187,125]
2023-12-09T21:00:27.632Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,3,68,128,0,1,187,125]
2023-12-09T21:00:27.632Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 3 - 2 - 4 - 128 - [0,1,187] - 125
2023-12-09T21:00:27.632Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- AF - dataConfirm - {"status":0,"endpoint":1,"transid":187}
2023-12-09T21:00:27.632Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2023-12-09T21:00:27.689Z zigbee-herdsman:adapter:zStack:adapter Response timeout (0x54ef441000711cd0:34757,1)
2023-12-09T21:00:27.689Z zigbee-herdsman:controller:endpoint Write 0x54ef441000711cd0/1 aqaraOpple({"65521":{"value":{"type":"Buffer","data":[0,2,5,4,21,0,85,1,1]},"type":65}}, {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"srcEndpoint":null,"reservedBits":0,"manufacturerCode":4447,"transactionSequenceNumber":null,"writeUndiv":false}) failed (Timeout - 34757 - 1 - 247 - 64704 - 4 after 10000ms)
Error: Write 0x54ef441000711cd0/1 aqaraOpple({"65521":{"value":{"type":"Buffer","data":[0,2,5,4,21,0,85,1,1]},"type":65}}, {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"srcEndpoint":null,"reservedBits":0,"manufacturerCode":4447,"transactionSequenceNumber":null,"writeUndiv":false}) failed (Timeout - 34757 - 1 - 247 - 64704 - 4 after 10000ms)
    at Timeout._onTimeout (/app/node_modules/zigbee-herdsman/src/utils/waitress.ts:64:35)
    at listOnTimeout (node:internal/timers:559:17)
    at processTimers (node:internal/timers:502:7)

What version of z2m?

Heya,

My version of MQTT is 1.34.0, with my firmware on 20230507 on a Sonoff Zigbee 3.0 USB Dongle Plus.

I hope this helps.

Thanks

I wonder if it is to do with passing the usb device into proxmox. There seem to be timeouts on each crash.

Interesting idea, and tbh, one that I hadn’t thought of. I had tried changing the USB slot that the co-ordinator is plugged into, and I am using an USB extension cable.

This is my proxmox hardware configuration for the USB device. Any suggestions of what I could do to improve or change this?

EDIT; When I go and check the USB device itself, it does state that it’s using USB 1.0? Whereas my other USB devices I have state at least USB 2.0. I’m not really sure what I would need to do to change this. If anyone can provide step-by-step idiot proof instructions if this is the root cause, that would be amazing

That’s fine, and normal. The stick doesn’t even use enough bandwidth to need USB 1.0 speeds.

As for the stick, is that the Plus P or the Plus E?

Ah okay, I’m glad it’s nothing to worry about. It’s the Plus P. (I got it off Amazon here: Amazon.co.uk)

Had it happen again, and this happen quite literally after my automation for the Aqara Pet Feeders to go off. I have it set up to feed every 3 hours. So 6am, 9am, 12pm, 3pm, 6pm, 9pm. I am now thinking more and more that it is link to this.

2023-12-10T12:00:20.025Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2023-12-10T12:00:20.912Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,32,68,129,0,0,25,0,28,190,1,13,0,65,0,236,72,119,0,0,12,1,4,6,0,11,16,232,3,3,0,0,0,28,190,29,131]
2023-12-10T12:00:20.912Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,32,68,129,0,0,25,0,28,190,1,13,0,65,0,236,72,119,0,0,12,1,4,6,0,11,16,232,3,3,0,0,0,28,190,29,131]
2023-12-10T12:00:20.912Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 32 - 2 - 4 - 129 - [0,0,25,0,28,190,1,13,0,65,0,236,72,119,0,0,12,1,4,6,0,11,16,232,3,3,0,0,0,28,190,29] - 131
2023-12-10T12:00:20.912Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- AF - incomingMsg - {"groupid":0,"clusterid":25,"srcaddr":48668,"srcendpoint":1,"dstendpoint":13,"wasbroadcast":0,"linkquality":65,"securityuse":0,"timestamp":7817452,"transseqnumber":0,"len":12,"data":{"type":"Buffer","data":[1,4,6,0,11,16,232,3,3,0,0,0]}}
2023-12-10T12:00:20.912Z zigbee-herdsman:controller:log Received 'zcl' data '{"frame":{"Header":{"frameControl":{"frameType":1,"manufacturerSpecific":false,"direction":0,"disableDefaultResponse":false,"reservedBits":0},"transactionSequenceNumber":4,"manufacturerCode":null,"commandIdentifier":6},"Payload":{"status":0,"manufacturerCode":4107,"imageType":1000,"fileVersion":3},"Command":{"ID":6,"response":7,"parameters":[{"name":"status","type":32},{"name":"manufacturerCode","type":33},{"name":"imageType","type":33},{"name":"fileVersion","type":35}],"name":"upgradeEndRequest"}},"address":48668,"endpoint":1,"linkquality":65,"groupID":0,"wasBroadcast":false,"destinationEndpoint":13}'
2023-12-10T12:00:20.913Z zigbee-herdsman:controller:log Skipping command 'upgradeEndRequest' because it is missing from the lookup
2023-12-10T12:00:20.913Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2023-12-10T12:00:23.355Z zigbee-herdsman:adapter:zStack:adapter Response timeout (0x54ef44100070ea46:40657,1)
2023-12-10T12:00:23.355Z zigbee-herdsman:adapter:zStack:adapter sendZclFrameToEndpointInternal 0x54ef44100070ea46:40657/1 (0,0,2)
2023-12-10T12:00:23.355Z zigbee-herdsman:adapter:zStack:znp:SREQ --> AF - dataRequest - {"dstaddr":40657,"destendpoint":1,"srcendpoint":1,"clusterid":10,"transid":190,"options":0,"radius":30,"len":11,"data":{"type":"Buffer","data":[24,82,1,0,0,0,226,195,100,8,45]}}
2023-12-10T12:00:23.355Z zigbee-herdsman:adapter:zStack:unpi:writer --> frame [254,21,36,1,209,158,1,1,10,0,190,0,30,11,24,82,1,0,0,0,226,195,100,8,45,245]
2023-12-10T12:00:23.356Z zigbee-herdsman:controller:endpoint Write 0x54ef44100070ea46/1 aqaraOpple({"65521":{"value":{"type":"Buffer","data":[0,2,1,4,21,0,85,1,1]},"type":65}}, {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"srcEndpoint":null,"reservedBits":0,"manufacturerCode":4447,"transactionSequenceNumber":null,"writeUndiv":false}) failed (Timeout - 40657 - 1 - 110 - 64704 - 4 after 10000ms)
Error: Write 0x54ef44100070ea46/1 aqaraOpple({"65521":{"value":{"type":"Buffer","data":[0,2,1,4,21,0,85,1,1]},"type":65}}, {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"srcEndpoint":null,"reservedBits":0,"manufacturerCode":4447,"transactionSequenceNumber":null,"writeUndiv":false}) failed (Timeout - 40657 - 1 - 110 - 64704 - 4 after 10000ms)
    at Timeout._onTimeout (/app/node_modules/zigbee-herdsman/src/utils/waitress.ts:64:35)
    at listOnTimeout (node:internal/timers:559:17)
    at processTimers (node:internal/timers:502:7)

According to a comment in zigbee-herdsman code for zStack adapter, the BUFFER_FULL error is actually

When many commands are executed at once the buffer can get full, wait some time and retry.

I don’t think that would crash Z2M (unless maybe it happens too often, too quickly).

As for the timeout error, I assume you saw issue #17148, seems the pet feeder’s support needs some work…

Have you tried simply removing the pet feeders from the Zigbee network, and see if it still crashes?

Thanks for the reply. Removing them completely will be the last option. I can see the various things that are being reported as part of that issue, and I have similar errors to what has been reported when pairing so I definitely now think it’s linked.

I’ve updated my script to the below in the hopes it might help. I have an automation that calls this script.

Well one option is to turn the automation off for a few hours.

So, after updating my script to match what was reported in the Github issue, my network hasn’t crashed over the past 2/3 days.

So it was the pet feeders that was causing issues. So now, I set the pet feeding size, the weight, and then setting it to feed.

Thanks @nickrout and @Nerivec for your input and pointing me in the right direction :slight_smile: You’ve earned brownie points from me

1 Like

I spoke too soon. This time, it doesn’t look like it’s related to the pet feeders but I’m not sure?

Zigbee2MQTT:info  2023-12-12 21:00:18: MQTT publish: topic 'zigbee2mqtt/Bathroom Motion Sensor', payload '{"battery":100,"illuminance":13344,"illuminance_lux":22,"led_indication":null,"linkquality":65,"motion_sensitivity":"max","occupancy":true,"occupancy_timeout":120,"temperature":15.75}'
2023-12-12T21:00:18.650Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,1,100,1,0,100]
2023-12-12T21:00:18.650Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,1,100,1,0,100]
2023-12-12T21:00:18.650Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 1 - 3 - 4 - 1 - [0] - 100
2023-12-12T21:00:18.650Z zigbee-herdsman:adapter:zStack:znp:SRSP <-- AF - dataRequest - {"status":0}
2023-12-12T21:00:18.650Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2023-12-12T21:00:19.554Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,5,69,196,233,26,1,9,35,92]
2023-12-12T21:00:19.554Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,5,69,196,233,26,1,9,35,92]
2023-12-12T21:00:19.554Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 5 - 2 - 5 - 196 - [233,26,1,9,35] - 92
2023-12-12T21:00:19.554Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- ZDO - srcRtgInd - {"dstaddr":6889,"relaycount":1,"relaylist":[8969]}
2023-12-12T21:00:19.554Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2023-12-12T21:00:20.135Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,3,68,128,0,1,197,3]
2023-12-12T21:00:20.135Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,3,68,128,0,1,197,3]
2023-12-12T21:00:20.135Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 3 - 2 - 4 - 128 - [0,1,197] - 3
2023-12-12T21:00:20.135Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- AF - dataConfirm - {"status":0,"endpoint":1,"transid":197}
2023-12-12T21:00:20.136Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2023-12-12T21:00:20.861Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,27,68,129,0,0,0,0,232,195,1,1,0,102,0,19,41,200,0,0,7,24,114,10,1,0,32,100,134,225,28,56]
2023-12-12T21:00:20.861Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,27,68,129,0,0,0,0,232,195,1,1,0,102,0,19,41,200,0,0,7,24,114,10,1,0,32,100,134,225,28,56]
2023-12-12T21:00:20.861Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 27 - 2 - 4 - 129 - [0,0,0,0,232,195,1,1,0,102,0,19,41,200,0,0,7,24,114,10,1,0,32,100,134,225,28] - 56
2023-12-12T21:00:20.861Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- AF - incomingMsg - {"groupid":0,"clusterid":0,"srcaddr":50152,"srcendpoint":1,"dstendpoint":1,"wasbroadcast":0,"linkquality":102,"securityuse":0,"timestamp":13117715,"transseqnumber":0,"len":7,"data":{"type":"Buffer","data":[24,114,10,1,0,32,100]}}
2023-12-12T21:00:20.862Z zigbee-herdsman:controller:log Received 'zcl' data '{"frame":{"Header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":114,"manufacturerCode":null,"commandIdentifier":10},"Payload":[{"attrId":1,"dataType":32,"attrData":100}],"Command":{"ID":10,"name":"report","parameters":[{"name":"attrId","type":33},{"name":"dataType","type":32},{"name":"attrData","type":1000}]}},"address":50152,"endpoint":1,"linkquality":102,"groupID":0,"wasBroadcast":false,"destinationEndpoint":1}'
2023-12-12T21:00:20.862Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2023-12-12T21:00:23.475Z zigbee-herdsman:adapter:zStack:adapter Response timeout (0x54ef441000711cd0:4187,1)
2023-12-12T21:00:23.476Z zigbee-herdsman:adapter:zStack:adapter sendZclFrameToEndpointInternal 0x54ef441000711cd0:4187/1 (0,0,1)
2023-12-12T21:00:23.476Z zigbee-herdsman:adapter:zStack:znp:SREQ --> AF - dataRequest - {"dstaddr":4187,"destendpoint":1,"srcendpoint":1,"clusterid":64704,"transid":198,"options":0,"radius":30,"len":18,"data":{"type":"Buffer","data":[20,95,17,210,2,241,255,65,9,0,2,3,4,21,0,85,1,1]}}
2023-12-12T21:00:23.476Z zigbee-herdsman:adapter:zStack:unpi:writer --> frame [254,28,36,1,91,16,1,1,192,252,198,0,30,18,20,95,17,210,2,241,255,65,9,0,2,3,4,21,0,85,1,1,13]
2023-12-12T21:00:23.476Z zigbee-herdsman:controller:endpoint Write 0x54ef441000711cd0/1 aqaraOpple({"65521":{"value":{"type":"Buffer","data":[0,2,1,14,92,0,85,4,0,0,0,1]},"type":65}}, {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"srcEndpoint":null,"reservedBits":0,"manufacturerCode":4447,"transactionSequenceNumber":null,"writeUndiv":false}) failed (Timeout - 4187 - 1 - 208 - 64704 - 4 after 10000ms)
Error: Write 0x54ef441000711cd0/1 aqaraOpple({"65521":{"value":{"type":"Buffer","data":[0,2,1,14,92,0,85,4,0,0,0,1]},"type":65}}, {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"srcEndpoint":null,"reservedBits":0,"manufacturerCode":4447,"transactionSequenceNumber":null,"writeUndiv":false}) failed (Timeout - 4187 - 1 - 208 - 64704 - 4 after 10000ms)
    at Timeout._onTimeout (/app/node_modules/zigbee-herdsman/src/utils/waitress.ts:64:35)
    at listOnTimeout (node:internal/timers:559:17)
    at processTimers (node:internal/timers:502:7)