Zigbee2mqtt CPU >100% and 502 Bad Gateway Frontend

Configuration Zigbee
1

Hi, I’m pretty new to Home Assistant, but I had everything I wanted working just fine. Last night all of a sudden I could not turn of my lights using my Ikea on/off buttons and I found out that Zigbee2mqtt was not working anymore.

The frontend page is not loading, showing 502 Bad Gateway and the CPU of the add-on is going through the roof, always over 100% and up to 4000%. I restarted Zigbee2mqtt, no effect, restarted HA completely but this also was no solution.

Based on the log entry below it seems that it cannot find the CC2531 USB?

Zigbee2MQTT:error 2022-04-01 07:53:51: Error: Error while opening serialport 'Error: Error: No such file or directory, cannot open /dev/ttyACM0'

Hopefully you can help me out with this!

Thanks in advance,
Matthijs

Complete Log:

> [email protected] start /app
> node index.js
Zigbee2MQTT:error 2022-04-01 07:53:08: Error while starting zigbee-herdsman
Zigbee2MQTT:error 2022-04-01 07:53:08: Failed to start zigbee
Zigbee2MQTT:error 2022-04-01 07:53:08: Exiting...
2022-04-01T05:53:08.385Z zigbee-herdsman:adapter:zStack:znp:error Failed to determine if path is valid: 'Error: ENOENT: no such file or directory, lstat '/dev/ttyACM0''
2022-04-01T05:53:08.468Z zigbee-herdsman:adapter Failed to validate path: 'Error: spawn udevadm ENOENT'
2022-04-01T05:53:08.469Z zigbee-herdsman:controller:log Starting with options '{"network":{"networkKeyDistribute":false,"networkKey":[1,3,5,7,9,11,13,15,0,2,4,6,8,10,12,13],"panID":6754,"extendedPanID":[221,221,221,221,221,221,221,221],"channelList":[11]},"serialPort":{"path":"/dev/ttyACM0"},"databasePath":"/config/zigbee2mqtt/database.db","databaseBackupPath":"/config/zigbee2mqtt/database.db.backup","backupPath":"/config/zigbee2mqtt/coordinator_backup.json","adapter":{"concurrent":null,"delay":null}}'
2022-04-01T05:53:08.471Z zigbee-herdsman:adapter:zStack:znp:log Opening SerialPort with /dev/ttyACM0 and {"baudRate":115200,"rtscts":false,"autoOpen":false}
Zigbee2MQTT:error 2022-04-01 07:53:08: Error: Error while opening serialport 'Error: Error: No such file or directory, cannot open /dev/ttyACM0'
    at Znp.<anonymous> (/app/node_modules/zigbee-herdsman/dist/adapter/z-stack/znp/znp.js:136:32)
    at Generator.next (<anonymous>)
    at /app/node_modules/zigbee-herdsman/dist/adapter/z-stack/znp/znp.js:27:71
    at new Promise (<anonymous>)
    at __awaiter (/app/node_modules/zigbee-herdsman/dist/adapter/z-stack/znp/znp.js:23:12)
    at SerialPort.<anonymous> (/app/node_modules/zigbee-herdsman/dist/adapter/z-stack/znp/znp.js:134:49)
    at SerialPort._error (/app/node_modules/zigbee-herdsman/node_modules/@serialport/stream/lib/index.js:198:14)
    at /app/node_modules/zigbee-herdsman/node_modules/@serialport/stream/lib/index.js:242:12
npm ERR! code ELIFECYCLE
npm ERR! errno 1
npm ERR! [email protected] start: `node index.js`
npm ERR! Exit status 1
npm ERR! 
npm ERR! Failed at the [email protected] start script.
npm ERR! This is probably not a problem with npm. There is likely additional logging output above.
npm ERR! A complete log of this run can be found in:
npm ERR!     /root/.npm/_logs/2022-04-01T05_53_08_522Z-debug.log
[07:53:08] INFO: Zigbee Herdsman debug logging enabled
[07:53:08] INFO: Handing over control to Zigbee2mqtt Core ...
> [email protected] start /app
> node index.js
2022-04-01T05:53:11.725Z zigbee-herdsman:adapter:zStack:znp:error Failed to determine if path is valid: 'Error: ENOENT: no such file or directory, lstat '/dev/ttyACM0''
2022-04-01T05:53:11.750Z zigbee-herdsman:adapter Failed to validate path: 'Error: spawn udevadm ENOENT'
2022-04-01T05:53:11.756Z zigbee-herdsman:controller:log Starting with options '{"network":{"networkKeyDistribute":false,"networkKey":[1,3,5,7,9,11,13,15,0,2,4,6,8,10,12,13],"panID":6754,"extendedPanID":[221,221,221,221,221,221,221,221],"channelList":[11]},"serialPort":{"path":"/dev/ttyACM0"},"databasePath":"/config/zigbee2mqtt/database.db","databaseBackupPath":"/config/zigbee2mqtt/database.db.backup","backupPath":"/config/zigbee2mqtt/coordinator_backup.json","adapter":{"concurrent":null,"delay":null}}'
2022-04-01T05:53:11.760Z zigbee-herdsman:adapter:zStack:znp:log Opening SerialPort with /dev/ttyACM0 and {"baudRate":115200,"rtscts":false,"autoOpen":false}
Zigbee2MQTT:error 2022-04-01 07:53:11: Error while starting zigbee-herdsman
Zigbee2MQTT:error 2022-04-01 07:53:11: Failed to start zigbee
Zigbee2MQTT:error 2022-04-01 07:53:11: Exiting...
Zigbee2MQTT:error 2022-04-01 07:53:11: Error: Error while opening serialport 'Error: Error: No such file or directory, cannot open /dev/ttyACM0'
    at Znp.<anonymous> (/app/node_modules/zigbee-herdsman/dist/adapter/z-stack/znp/znp.js:136:32)
    at Generator.next (<anonymous>)
    at /app/node_modules/zigbee-herdsman/dist/adapter/z-stack/znp/znp.js:27:71
    at new Promise (<anonymous>)
    at __awaiter (/app/node_modules/zigbee-herdsman/dist/adapter/z-stack/znp/znp.js:23:12)
    at SerialPort.<anonymous> (/app/node_modules/zigbee-herdsman/dist/adapter/z-stack/znp/znp.js:134:49)
    at SerialPort._error (/app/node_modules/zigbee-herdsman/node_modules/@serialport/stream/lib/index.js:198:14)
    at /app/node_modules/zigbee-herdsman/node_modules/@serialport/stream/lib/index.js:242:12
npm ERR! code ELIFECYCLE
npm ERR! errno 1
npm ERR! [email protected] start: `node index.js`
npm ERR! Exit status 1
npm ERR! 
npm ERR! Failed at the [email protected] start script.
npm ERR! This is probably not a problem with npm. There is likely additional logging output above.
npm ERR! A complete log of this run can be found in:
npm ERR!     /root/.npm/_logs/2022-04-01T05_53_11_810Z-debug.log
[07:53:11] INFO: Zigbee Herdsman debug logging enabled
[07:53:11] INFO: Handing over control to Zigbee2mqtt Core ...
> [email protected] start /app
> node index.js
2022-04-01T05:53:16.399Z zigbee-herdsman:adapter:zStack:znp:error Failed to determine if path is valid: 'Error: ENOENT: no such file or directory, lstat '/dev/ttyACM0''
2022-04-01T05:53:16.413Z zigbee-herdsman:adapter Failed to validate path: 'Error: spawn udevadm ENOENT'
2022-04-01T05:53:16.414Z zigbee-herdsman:controller:log Starting with options '{"network":{"networkKeyDistribute":false,"networkKey":[1,3,5,7,9,11,13,15,0,2,4,6,8,10,12,13],"panID":6754,"extendedPanID":[221,221,221,221,221,221,221,221],"channelList":[11]},"serialPort":{"path":"/dev/ttyACM0"},"databasePath":"/config/zigbee2mqtt/database.db","databaseBackupPath":"/config/zigbee2mqtt/database.db.backup","backupPath":"/config/zigbee2mqtt/coordinator_backup.json","adapter":{"concurrent":null,"delay":null}}'
2022-04-01T05:53:16.417Z zigbee-herdsman:adapter:zStack:znp:log Opening SerialPort with /dev/ttyACM0 and {"baudRate":115200,"rtscts":false,"autoOpen":false}
Zigbee2MQTT:error 2022-04-01 07:53:16: Error while starting zigbee-herdsman
Zigbee2MQTT:error 2022-04-01 07:53:16: Failed to start zigbee
Zigbee2MQTT:error 2022-04-01 07:53:16: Exiting...
Zigbee2MQTT:error 2022-04-01 07:53:16: Error: Error while opening serialport 'Error: Error: No such file or directory, cannot open /dev/ttyACM0'
    at Znp.<anonymous> (/app/node_modules/zigbee-herdsman/dist/adapter/z-stack/znp/znp.js:136:32)
    at Generator.next (<anonymous>)
    at /app/node_modules/zigbee-herdsman/dist/adapter/z-stack/znp/znp.js:27:71
    at new Promise (<anonymous>)
    at __awaiter (/app/node_modules/zigbee-herdsman/dist/adapter/z-stack/znp/znp.js:23:12)
    at SerialPort.<anonymous> (/app/node_modules/zigbee-herdsman/dist/adapter/z-stack/znp/znp.js:134:49)
    at SerialPort._error (/app/node_modules/zigbee-herdsman/node_modules/@serialport/stream/lib/index.js:198:14)
    at /app/node_modules/zigbee-herdsman/node_modules/@serialport/stream/lib/index.js:242:12
npm ERR! code ELIFECYCLE
npm ERR! errno 1
npm ERR! [email protected] start: `node index.js`
npm ERR! Exit status 1
npm ERR! 
npm ERR! Failed at the [email protected] start script.
npm ERR! This is probably not a problem with npm. There is likely additional logging output above.
npm ERR! A complete log of this run can be found in:
npm ERR!     /root/.npm/_logs/2022-04-01T05_53_16_455Z-debug.log
[07:53:16] INFO: Zigbee Herdsman debug logging enabled
[07:53:16] INFO: Handing over control to Zigbee2mqtt Core ...
> [email protected] start /app
> node index.js

Screenshot CPU:

Zigbee2mqtt screenshot
Zigbee2mqtt screenshot1027×561 36.9 KB

2

Correct. This has likely changed:

'/dev/ttyACM0'

You should use /dev/serial/by-id/ instead. This won’t change.

3

Something like this?

serial:
  port: >-
    /dev/serial/by-id/usb-Texas_Instruments_TI_CC2531_USB_CDC___0X00124B001CDD431F-if00

This doesn’t seem to work.

4

Is your adaptor dead?

I’m not sure how you would test it.

Windows software perhaps?

5

I do see the USB in hardware in HA: ID is the same, light of the CC2531 is also on when inserting.

image
image502×716 26 KB

6

My log is also strange now, I restarted several times, same log entries. CPU is now at 0%.

I unplugged en replugged the CC2531, see below the entries in the log of the hardware in HA:

22-04-01 09:40:40 INFO (MainThread) [supervisor.hardware.monitor] Detecting HardwareAction.REMOVE hardware /dev/ttyACM0 - /dev/serial/by-id/usb-Texas_Instruments_TI_CC2531_USB_CDC___0X00124B001CDD431F-if00
22-04-01 09:40:40 INFO (MainThread) [supervisor.hardware.monitor] Detecting HardwareAction.REMOVE hardware /dev/bus/usb/002/003 - None
22-04-01 09:40:49 INFO (MainThread) [supervisor.hardware.monitor] Detecting HardwareAction.ADD hardware /dev/bus/usb/002/004 - None
22-04-01 09:40:49 INFO (MainThread) [supervisor.hardware.monitor] Detecting HardwareAction.ADD hardware /dev/ttyACM0 - /dev/serial/by-id/usb-Texas_Instruments_TI_CC2531_USB_CDC___0X00124B001CDD431F-if00

Log of Zigbee2mqtt

2022-04-01T07:42:20.865Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,25,68,129,0,0,6,0,178,16,1,1,0,39,0,58,243,3,0,0,5,8,10,11,1,0,178,16,29,39]
2022-04-01T07:42:20.866Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,25,68,129,0,0,6,0,178,16,1,1,0,39,0,58,243,3,0,0,5,8,10,11,1,0,178,16,29,39]
2022-04-01T07:42:20.866Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 25 - 2 - 4 - 129 - [0,0,6,0,178,16,1,1,0,39,0,58,243,3,0,0,5,8,10,11,1,0,178,16,29] - 39
2022-04-01T07:42:20.866Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- AF - incomingMsg - {"groupid":0,"clusterid":6,"srcaddr":4274,"srcendpoint":1,"dstendpoint":1,"wasbroadcast":0,"linkquality":39,"securityuse":0,"timestamp":258874,"transseqnumber":0,"len":5,"data":{"type":"Buffer","data":[8,10,11,1,0]}}
2022-04-01T07:42:20.867Z zigbee-herdsman:controller:log Received 'zcl' data '{"frame":{"Header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":false,"reservedBits":0},"transactionSequenceNumber":10,"manufacturerCode":null,"commandIdentifier":11},"Payload":{"cmdId":1,"statusCode":0},"Command":{"ID":11,"name":"defaultRsp","parameters":[{"name":"cmdId","type":32},{"name":"statusCode","type":32}]}},"address":4274,"endpoint":1,"linkquality":39,"groupID":0}'
2022-04-01T07:42:20.868Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2022-04-01T07:42:20.869Z zigbee-herdsman:adapter:zStack:adapter sendZclFrameToEndpointInternal 0xbc33acfffe0e814a:21492/1 (0,0,5)
2022-04-01T07:42:20.870Z zigbee-herdsman:adapter:zStack:znp:SREQ --> AF - dataRequest - {"dstaddr":21492,"destendpoint":1,"srcendpoint":1,"clusterid":6,"transid":11,"options":0,"radius":30,"len":3,"data":{"type":"Buffer","data":[1,12,1]}}
2022-04-01T07:42:20.870Z zigbee-herdsman:adapter:zStack:unpi:writer --> frame [254,13,36,1,244,83,1,1,6,0,11,0,30,3,1,12,1,147]
2022-04-01T07:42:20.889Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,1,100,1,0,100]
2022-04-01T07:42:20.889Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,1,100,1,0,100]
2022-04-01T07:42:20.889Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 1 - 3 - 4 - 1 - [0] - 100
2022-04-01T07:42:20.890Z zigbee-herdsman:adapter:zStack:znp:SRSP <-- AF - dataRequest - {"status":0}
2022-04-01T07:42:20.890Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2022-04-01T07:42:20.906Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,3,68,128,0,1,11,205]
2022-04-01T07:42:20.906Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,3,68,128,0,1,11,205]
2022-04-01T07:42:20.907Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 3 - 2 - 4 - 128 - [0,1,11] - 205
2022-04-01T07:42:20.907Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- AF - dataConfirm - {"status":0,"endpoint":1,"transid":11}
2022-04-01T07:42:20.907Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2022-04-01T07:42:20.924Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,3,69,196,244,83,0,37]
2022-04-01T07:42:20.924Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,3,69,196,244,83,0,37]
2022-04-01T07:42:20.924Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 3 - 2 - 5 - 196 - [244,83,0] - 37
2022-04-01T07:42:20.924Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- ZDO - srcRtgInd - {"dstaddr":21492,"relaycount":0,"relaylist":[]}
2022-04-01T07:42:20.924Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2022-04-01T07:42:20.928Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,25,68,129,0,0,6,0,75,160,1,1,0,42,0,174,243,3,0,0,5,8,11,11,1,0,75,160,29,191]
2022-04-01T07:42:20.928Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,25,68,129,0,0,6,0,75,160,1,1,0,42,0,174,243,3,0,0,5,8,11,11,1,0,75,160,29,191]
2022-04-01T07:42:20.928Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 25 - 2 - 4 - 129 - [0,0,6,0,75,160,1,1,0,42,0,174,243,3,0,0,5,8,11,11,1,0,75,160,29] - 191
2022-04-01T07:42:20.929Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- AF - incomingMsg - {"groupid":0,"clusterid":6,"srcaddr":41035,"srcendpoint":1,"dstendpoint":1,"wasbroadcast":0,"linkquality":42,"securityuse":0,"timestamp":258990,"transseqnumber":0,"len":5,"data":{"type":"Buffer","data":[8,11,11,1,0]}}
2022-04-01T07:42:20.930Z zigbee-herdsman:controller:log Received 'zcl' data '{"frame":{"Header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":false,"reservedBits":0},"transactionSequenceNumber":11,"manufacturerCode":null,"commandIdentifier":11},"Payload":{"cmdId":1,"statusCode":0},"Command":{"ID":11,"name":"defaultRsp","parameters":[{"name":"cmdId","type":32},{"name":"statusCode","type":32}]}},"address":41035,"endpoint":1,"linkquality":42,"groupID":0}'
2022-04-01T07:42:20.930Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2022-04-01T07:42:20.930Z zigbee-herdsman:adapter:zStack:adapter sendZclFrameToEndpointInternal 0x14b457fffe739726:32865/1 (0,0,4)
2022-04-01T07:42:20.930Z zigbee-herdsman:adapter:zStack:znp:SREQ --> AF - dataRequest - {"dstaddr":32865,"destendpoint":1,"srcendpoint":1,"clusterid":6,"transid":12,"options":0,"radius":30,"len":3,"data":{"type":"Buffer","data":[1,13,0]}}
2022-04-01T07:42:20.930Z zigbee-herdsman:adapter:zStack:unpi:writer --> frame [254,13,36,1,97,128,1,1,6,0,12,0,30,3,1,13,0,210]
2022-04-01T07:42:20.959Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,1,100,1,0,100]
2022-04-01T07:42:20.959Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,1,100,1,0,100]
2022-04-01T07:42:20.959Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 1 - 3 - 4 - 1 - [0] - 100
2022-04-01T07:42:20.959Z zigbee-herdsman:adapter:zStack:znp:SRSP <-- AF - dataRequest - {"status":0}
2022-04-01T07:42:20.959Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2022-04-01T07:42:20.991Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,3,68,128,0,1,12,202]
2022-04-01T07:42:20.991Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,3,68,128,0,1,12,202]
2022-04-01T07:42:20.991Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 3 - 2 - 4 - 128 - [0,1,12] - 202
2022-04-01T07:42:20.991Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- AF - dataConfirm - {"status":0,"endpoint":1,"transid":12}
2022-04-01T07:42:20.991Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2022-04-01T07:42:20.998Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,25,68,129,0,0,6,0,244,83,1,1,0,47,0,117,244,3,0,0,5,8,12,11,1,0,244,83,29,97,254,3,69,196,97,128,0,99]
2022-04-01T07:42:20.998Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,25,68,129,0,0,6,0,244,83,1,1,0,47,0,117,244,3,0,0,5,8,12,11,1,0,244,83,29,97,254,3,69,196,97,128,0,99]
2022-04-01T07:42:20.998Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 25 - 2 - 4 - 129 - [0,0,6,0,244,83,1,1,0,47,0,117,244,3,0,0,5,8,12,11,1,0,244,83,29] - 97
2022-04-01T07:42:20.999Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- AF - incomingMsg - {"groupid":0,"clusterid":6,"srcaddr":21492,"srcendpoint":1,"dstendpoint":1,"wasbroadcast":0,"linkquality":47,"securityuse":0,"timestamp":259189,"transseqnumber":0,"len":5,"data":{"type":"Buffer","data":[8,12,11,1,0]}}
2022-04-01T07:42:20.999Z zigbee-herdsman:controller:log Received 'zcl' data '{"frame":{"Header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":false,"reservedBits":0},"transactionSequenceNumber":12,"manufacturerCode":null,"commandIdentifier":11},"Payload":{"cmdId":1,"statusCode":0},"Command":{"ID":11,"name":"defaultRsp","parameters":[{"name":"cmdId","type":32},{"name":"statusCode","type":32}]}},"address":21492,"endpoint":1,"linkquality":47,"groupID":0}'
2022-04-01T07:42:20.999Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,3,69,196,97,128,0,99]
2022-04-01T07:42:20.999Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 3 - 2 - 5 - 196 - [97,128,0] - 99
2022-04-01T07:42:20.999Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- ZDO - srcRtgInd - {"dstaddr":32865,"relaycount":0,"relaylist":[]}
2022-04-01T07:42:20.999Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2022-04-01T07:42:21.000Z zigbee-herdsman:adapter:zStack:adapter sendZclFrameToEndpointInternal 0x14b457fffe27842f:20222/1 (0,0,3)
2022-04-01T07:42:21.000Z zigbee-herdsman:adapter:zStack:znp:SREQ --> AF - dataRequest - {"dstaddr":20222,"destendpoint":1,"srcendpoint":1,"clusterid":6,"transid":13,"options":0,"radius":30,"len":3,"data":{"type":"Buffer","data":[1,14,0]}}
2022-04-01T07:42:21.000Z zigbee-herdsman:adapter:zStack:unpi:writer --> frame [254,13,36,1,254,78,1,1,6,0,13,0,30,3,1,14,0,129]
2022-04-01T07:42:21.105Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,1,100,1,0,100,254,3,68,128,0,1,13,203,254,25,68,129,0,0,6,0,97,128,1,1,0,73,0,51,245,3,0,0,5,8,13,11,0,0,97,128,29,64,254,5,69,196,254,78,1,43,43,53]
2022-04-01T07:42:21.105Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,1,100,1,0,100,254,3,68,128,0,1,13,203,254,25,68,129,0,0,6,0,97,128,1,1,0,73,0,51,245,3,0,0,5,8,13,11,0,0,97,128,29,64,254,5,69,196,254,78,1,43,43,53]
2022-04-01T07:42:21.105Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 1 - 3 - 4 - 1 - [0] - 100
2022-04-01T07:42:21.105Z zigbee-herdsman:adapter:zStack:znp:SRSP <-- AF - dataRequest - {"status":0}
2022-04-01T07:42:21.105Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,3,68,128,0,1,13,203,254,25,68,129,0,0,6,0,97,128,1,1,0,73,0,51,245,3,0,0,5,8,13,11,0,0,97,128,29,64,254,5,69,196,254,78,1,43,43,53]
2022-04-01T07:42:21.105Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 3 - 2 - 4 - 128 - [0,1,13] - 203
2022-04-01T07:42:21.105Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- AF - dataConfirm - {"status":0,"endpoint":1,"transid":13}
2022-04-01T07:42:21.106Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,25,68,129,0,0,6,0,97,128,1,1,0,73,0,51,245,3,0,0,5,8,13,11,0,0,97,128,29,64,254,5,69,196,254,78,1,43,43,53]
2022-04-01T07:42:21.106Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 25 - 2 - 4 - 129 - [0,0,6,0,97,128,1,1,0,73,0,51,245,3,0,0,5,8,13,11,0,0,97,128,29] - 64
2022-04-01T07:42:21.106Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- AF - incomingMsg - {"groupid":0,"clusterid":6,"srcaddr":32865,"srcendpoint":1,"dstendpoint":1,"wasbroadcast":0,"linkquality":73,"securityuse":0,"timestamp":259379,"transseqnumber":0,"len":5,"data":{"type":"Buffer","data":[8,13,11,0,0]}}
2022-04-01T07:42:21.106Z zigbee-herdsman:controller:log Received 'zcl' data '{"frame":{"Header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":false,"reservedBits":0},"transactionSequenceNumber":13,"manufacturerCode":null,"commandIdentifier":11},"Payload":{"cmdId":0,"statusCode":0},"Command":{"ID":11,"name":"defaultRsp","parameters":[{"name":"cmdId","type":32},{"name":"statusCode","type":32}]}},"address":32865,"endpoint":1,"linkquality":73,"groupID":0}'
2022-04-01T07:42:21.106Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,5,69,196,254,78,1,43,43,53]
2022-04-01T07:42:21.106Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 5 - 2 - 5 - 196 - [254,78,1,43,43] - 53
2022-04-01T07:42:21.106Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- ZDO - srcRtgInd - {"dstaddr":20222,"relaycount":1,"relaylist":[11051]}
2022-04-01T07:42:21.106Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2022-04-01T07:42:21.107Z zigbee-herdsman:adapter:zStack:adapter sendZclFrameToEndpointInternal 0x14b457fffe429017:4974/1 (0,0,2)
2022-04-01T07:42:21.107Z zigbee-herdsman:adapter:zStack:znp:SREQ --> AF - dataRequest - {"dstaddr":4974,"destendpoint":1,"srcendpoint":1,"clusterid":6,"transid":14,"options":0,"radius":30,"len":3,"data":{"type":"Buffer","data":[1,15,0]}}
2022-04-01T07:42:21.107Z zigbee-herdsman:adapter:zStack:unpi:writer --> frame [254,13,36,1,110,19,1,1,6,0,14,0,30,3,1,15,0,78]
2022-04-01T07:42:21.119Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,25,68,129,0,0,6,0,254,78,1,1,0,60,0,37,246,3,0,0,5,8,14,11,0,0,43,43,28,146]
2022-04-01T07:42:21.119Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,25,68,129,0,0,6,0,254,78,1,1,0,60,0,37,246,3,0,0,5,8,14,11,0,0,43,43,28,146]
2022-04-01T07:42:21.119Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 25 - 2 - 4 - 129 - [0,0,6,0,254,78,1,1,0,60,0,37,246,3,0,0,5,8,14,11,0,0,43,43,28] - 146
2022-04-01T07:42:21.119Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- AF - incomingMsg - {"groupid":0,"clusterid":6,"srcaddr":20222,"srcendpoint":1,"dstendpoint":1,"wasbroadcast":0,"linkquality":60,"securityuse":0,"timestamp":259621,"transseqnumber":0,"len":5,"data":{"type":"Buffer","data":[8,14,11,0,0]}}
2022-04-01T07:42:21.120Z zigbee-herdsman:controller:log Received 'zcl' data '{"frame":{"Header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":false,"reservedBits":0},"transactionSequenceNumber":14,"manufacturerCode":null,"commandIdentifier":11},"Payload":{"cmdId":0,"statusCode":0},"Command":{"ID":11,"name":"defaultRsp","parameters":[{"name":"cmdId","type":32},{"name":"statusCode","type":32}]}},"address":20222,"endpoint":1,"linkquality":60,"groupID":0}'
2022-04-01T07:42:21.120Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2022-04-01T07:42:21.161Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,1,100,1,0,100]
2022-04-01T07:42:21.161Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,1,100,1,0,100]
2022-04-01T07:42:21.161Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 1 - 3 - 4 - 1 - [0] - 100
2022-04-01T07:42:21.161Z zigbee-herdsman:adapter:zStack:znp:SRSP <-- AF - dataRequest - {"status":0}
2022-04-01T07:42:21.162Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2022-04-01T07:42:21.165Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,5,69,196,110,19,1,180,97,45]
2022-04-01T07:42:21.165Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,5,69,196,110,19,1,180,97,45]
2022-04-01T07:42:21.165Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 5 - 2 - 5 - 196 - [110,19,1,180,97] - 45
2022-04-01T07:42:21.165Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- ZDO - srcRtgInd - {"dstaddr":4974,"relaycount":1,"relaylist":[25012]}
2022-04-01T07:42:21.165Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2022-04-01T07:42:21.172Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,3,68,128,0,1,14,200]
2022-04-01T07:42:21.173Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,3,68,128,0,1,14,200]
2022-04-01T07:42:21.173Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 3 - 2 - 4 - 128 - [0,1,14] - 200
2022-04-01T07:42:21.173Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- AF - dataConfirm - {"status":0,"endpoint":1,"transid":14}
2022-04-01T07:42:21.173Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
2022-04-01T07:42:21.224Z zigbee-herdsman:adapter:zStack:unpi:parser <-- [254,25,68,129,0,0,6,0,110,19,1,1,0,55,0,83,247,3,0,0,5,8,15,11,0,0,180,97,28,247]
2022-04-01T07:42:21.224Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext [254,25,68,129,0,0,6,0,110,19,1,1,0,55,0,83,247,3,0,0,5,8,15,11,0,0,180,97,28,247]
2022-04-01T07:42:21.225Z zigbee-herdsman:adapter:zStack:unpi:parser --> parsed 25 - 2 - 4 - 129 - [0,0,6,0,110,19,1,1,0,55,0,83,247,3,0,0,5,8,15,11,0,0,180,97,28] - 247
2022-04-01T07:42:21.225Z zigbee-herdsman:adapter:zStack:znp:AREQ <-- AF - incomingMsg - {"groupid":0,"clusterid":6,"srcaddr":4974,"srcendpoint":1,"dstendpoint":1,"wasbroadcast":0,"linkquality":55,"securityuse":0,"timestamp":259923,"transseqnumber":0,"len":5,"data":{"type":"Buffer","data":[8,15,11,0,0]}}
2022-04-01T07:42:21.225Z zigbee-herdsman:controller:log Received 'zcl' data '{"frame":{"Header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":false,"reservedBits":0},"transactionSequenceNumber":15,"manufacturerCode":null,"commandIdentifier":11},"Payload":{"cmdId":0,"statusCode":0},"Command":{"ID":11,"name":"defaultRsp","parameters":[{"name":"cmdId","type":32},{"name":"statusCode","type":32}]}},"address":4974,"endpoint":1,"linkquality":55,"groupID":0}'
2022-04-01T07:42:21.226Z zigbee-herdsman:adapter:zStack:unpi:parser --- parseNext []
7

I think you may have to re-flash your stick.

Have a read of this topic:

8

Ok, it’s getting weird now. Now all of a sudden I can control all my lights in HA and my buttons are also working again. I don’t have access to the Zigbee2mqtt UI though and CPU is also on 0%, nothing has changed in the z2m log too. CC2531 seems to be working then?

Any suggestions on how to proceed?

image
image486×542 12 KB

9

Solved! Not sure why it occured but this is what I had to do:

This line was in my System Log:

22-04-01 11:44:45 ERROR (MainThread) [supervisor.api.ingress] Ingress error: Cannot connect to host 172.30.33.4:8099 ssl:default [Connect call failed ('172.30.33.4', 8099)]

My configuration in Zigbee2mqtt was on another port, after changing the frontend port to 8099 I could reach the UI.

frontend:
  port: 8099

Thanks to https://github.com/zigbee2mqtt/hassio-zigbee2mqtt/issues/81#issuecomment-819387905

10

Goodmorning,

Unfortunatly this was not solved as I thought. Zigbee2mqtt keeps losing connection to my CC2531. I think it’s most likely that it is broken, but I just want to make sure this is the case. My CC2531 is only a few weeks old. I did order a SONOFF ZigBee 3.0 USB Dongle Plus in the mean time to have a backup plan.

I’m running HA via virtualbox on a laptop I have permanently running. I have added the CC2531 in the USB setting of the virtual machine and as you can see in the screenshot below it is recognized. I don’t have any issue reflashing the CC2531, it is recognized straight away. Still my zigbee2mqtt keeps on crashing because after a few hours it cannot find the CC2531.

image
image1290×442 33.8 KB

Is there any other way to see if the issue is with the CC2531 or that maybe virtualbox or some other setting causes the issue?

11

Could be a noise issue.

12

Ok, I have added a USB extention. Funny thing was that when I added the CC2531 again via the USB extention, it was immidiatly recognized and Zigbee2mqtt is running again. Let’s see for how long…

I also updated the USB settings on my virtualbox so that it allows all USB’s to pass through.

image
image696×616 25.9 KB

13

Unfortunately it didn’t last long, connection was just lost again. I also noticed that my wifi is very slow at the same moment (both 2.4Ghz and 5Ghz). Not sure what’s causing that, maybe something with my router.

Could it be that HA lost internet connection and that this is causing it to also lose connection to the CC2531?

14

Just an idea:
If this is windows, check the device manager around your usb stick - Windows (the OS) could/would put some USB devices to auto-sleep / hibernate mode sometimes.
image

EDIT: Just to be clear - the input device above image is NOT a USB stick, but to showcase that there’s a power management setting you can play with. Also, the idea here is to uncheck the checkbox.
This obviously depends on your USB device. So YMMV.

15

Hi, thanks for sharing this. Let’s see if this works!

16

Ok, it all worked fine and I really hoped it was fixed, but this morning the connection to the CC2531 was lost again. Again it seems to happen after a wifi connection problem. Today the SONOFF ZigBee 3.0 USB Dongle Plus is arriving, let’s see if I can get it working with that.

Any other suggestion on the cause is ofcourse still welcome!