Missing "MQTT" info

B0B · July 16, 2023, 2:56pm

Hi,
I’m trying to get my usb-ITEAD_SONOFF_Zigbee_3.0_USB_Dongle_Plus to boot up with Zigbee2MQTT. I’ve looked thread all the posting but, all the mentioned solutions don’t see to work for my issue. I’ve provided the screen shots below.

Zigbee2MQTT - config

Zigbee2MQTT - log

[10:44:17] INFO: Preparing to start…
[10:44:19] INFO: Socat not enabled
[10:44:23] ERROR: Got unexpected response from the API: Service not enabled
[10:44:23] INFO: Starting Zigbee2MQTT…
!!!
READ THIS CAREFULLY
Refusing to start because configuration is not valid, found the following errors:

must have required property ‘mqtt’
If you don’t know how to solve this, read Configuration | Zigbee2MQTT
!!!

B0B · July 16, 2023, 4:45pm

Update: I uninstalled and reinstalled the app again. But now getting the following issue.

Log:
[12:33:45] INFO: Preparing to start…
[12:33:47] INFO: Socat not enabled
[12:33:53] INFO: Starting Zigbee2MQTT…
Zigbee2MQTT:info 2023-07-16 12:34:08: Logging to console and directory: ‘/config/zigbee2mqtt/log/2023-07-16.12-34-08’ filename: log.txt
Zigbee2MQTT:info 2023-07-16 12:34:08: Starting Zigbee2MQTT version 1.32.1 (commit #unknown)
Zigbee2MQTT:info 2023-07-16 12:34:08: Starting zigbee-herdsman (0.16.0)
Zigbee2MQTT:error 2023-07-16 12:34:30: Error while starting zigbee-herdsman
Zigbee2MQTT:error 2023-07-16 12:34:30: Failed to start zigbee
Zigbee2MQTT:error 2023-07-16 12:34:30: Check Zigbee2MQTT fails to start | Zigbee2MQTT for possible solutions
Zigbee2MQTT:error 2023-07-16 12:34:30: Exiting…
Zigbee2MQTT:error 2023-07-16 12:34:30: Error: Failed to connect to the adapter (Error: SRSP - SYS - ping after 6000ms)
at ZStackAdapter.start (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/adapter/zStackAdapter.ts:103:27)
at Controller.start (/app/node_modules/zigbee-herdsman/src/controller/controller.ts:132:29)
at Zigbee.start (/app/lib/zigbee.ts:58:27)
at Controller.start (/app/lib/controller.ts:101:27)
at start (/app/index.js:107:5)

Config:

onlize · July 18, 2023, 12:40am

Hi, I have the same error. How did you fix it?

B0B · July 19, 2023, 12:30am

I am still trying to fix the issue.

onlize · July 19, 2023, 2:00am

I found the fix. Adding adapter for Sonoff USB fixed my problem. Also, it is not recommended to use /dev/ttyACM0.

B0B · July 19, 2023, 10:42pm

Ah nice. I added the adapter flag but now a new error message about the firm ware and something wrong in with server info. What did you enter the in the mqtt and socat box?

[22:44:14] INFO: Preparing to start…
[22:44:15] INFO: Socat not enabled
[22:44:21] ERROR: Got unexpected response from the API: Service not enabled
[22:44:21] INFO: Starting Zigbee2MQTT…
Zigbee2MQTT:info 2023-07-18 22:44:34: Logging to console and directory: ‘/config/zigbee2mqtt/log/2023-07-18.22-44-34’ filename: log.txt
Zigbee2MQTT:info 2023-07-18 22:44:34: Starting Zigbee2MQTT version 1.32.1 (commit #unknown)
Zigbee2MQTT:info 2023-07-18 22:44:34: Starting zigbee-herdsman (0.16.0)
Zigbee2MQTT:info 2023-07-18 22:44:38: zigbee-herdsman started (resumed)
Zigbee2MQTT:info 2023-07-18 22:44:38: Coordinator firmware version: ‘{“meta”:{“maintrel”:"3 ",“majorrel”:“6”,“minorrel”:“10”,“product”:8,“revision”:“6.10.3.0 build 297”},“type”:“EZSP v8”}’
Zigbee2MQTT:info 2023-07-18 22:44:38: Currently 0 devices are joined:
Zigbee2MQTT:info 2023-07-18 22:44:38: Zigbee: disabling joining new devices.
Zigbee2MQTT:info 2023-07-18 22:44:38: Connecting to MQTT server at mqtt://localhost:1883
Zigbee2MQTT:error 2023-07-18 22:44:39: MQTT error: connect ECONNREFUSED 127.0.0.1:1883
Zigbee2MQTT:error 2023-07-18 22:44:39: MQTT failed to connect, exiting…
Zigbee2MQTT:info 2023-07-18 22:44:39: Stopping zigbee-herdsman…
Zigbee2MQTT:info 2023-07-18 22:44:39: Stopped zigbee-herdsman

Update:
I think it started to run but, hit another wall.

2023-07-20T00:00:40.756Z zigbee-herdsman:adapter:ezsp:uart ← [8610be7e3677a1a96c2a15f999cb7e]
2023-07-20T00:00:40.757Z zigbee-herdsman:adapter:ezsp:uart ← ACK (6): 8610be7e
2023-07-20T00:00:40.758Z zigbee-herdsman:adapter:ezsp:uart ← DATA (3,6,0): 3677a1a96c2a15f999cb7e
2023-07-20T00:00:40.758Z zigbee-herdsman:adapter:ezsp:uart → ACK (4)
2023-07-20T00:00:40.759Z zigbee-herdsman:adapter:ezsp:uart → [8430fc7e]
2023-07-20T00:00:40.761Z zigbee-herdsman:adapter:ezsp:ezsp <== Frame: 3580013800004b
2023-07-20T00:00:40.762Z zigbee-herdsman:adapter:ezsp:ezsp <== 0x38: {“cls”:“sendMulticast”,“id”:56,“isRequest”:false,“status”:0,“sequence”:75}
2023-07-20T00:00:40.763Z zigbee-herdsman:adapter:ezsp:uart -± rewaiting (6) success
2023-07-20T00:00:40.764Z zigbee-herdsman:adapter:ezsp:uart -± waiting (6) success
2023-07-20T00:00:40.767Z zigbee-herdsman:adapter:ezsp:uart ← [4677b1a97d312a1652f8b54ad7555593b46305d8abedce9874fbdf608bf67d5e3f92687e]
2023-07-20T00:00:40.768Z zigbee-herdsman:adapter:ezsp:uart ← DATA (4,6,0): 4677b1a9112a1652f8b54ad7555593b46305d8abedce9874fbdf608bf67e3f92687e
2023-07-20T00:00:40.768Z zigbee-herdsman:adapter:ezsp:uart → ACK (5)
2023-07-20T00:00:40.769Z zigbee-herdsman:adapter:ezsp:uart → [8520dd7e]
2023-07-20T00:00:40.771Z zigbee-herdsman:adapter:ezsp:ezsp <== Frame: 359001450003e0a12100f2ff0001fdff4bff000000ffff061903020a0000
2023-07-20T00:00:40.772Z zigbee-herdsman:adapter:ezsp:ezsp <== 0x45: {“cls”:“incomingMessageHandler”,“id”:69,“isRequest”:false,“type”:3,“apsFrame”:{“profileId”:41440,“clusterId”:33,“sourceEndpoint”:242,“destinationEndpoint”:255,“options”:256,“groupId”:65533,“sequence”:75},“lastHopLqi”:255,“lastHopRssi”:0,“sender”:0,“bindingIndex”:255,“addressIndex”:255,“message”:{“type”:“Buffer”,“data”:[25,3,2,10,0,0]}}
2023-07-20T00:00:40.773Z zigbee-herdsman:adapter:ezsp:debg processMessage: {“messageType”:3,“apsFrame”:{“profileId”:41440,“clusterId”:33,“sourceEndpoint”:242,“destinationEndpoint”:255,“options”:256,“groupId”:65533,“sequence”:75},“lqi”:255,“rssi”:0,“sender”:0,“bindingIndex”:255,“addressIndex”:255,“message”:{“type”:“Buffer”,“data”:[25,3,2,10,0,0]}}
2023-07-20T00:00:40.967Z zigbee-herdsman:adapter:ezsp:ezsp ==> permitJoining: {“duration”:0}
2023-07-20T00:00:40.968Z zigbee-herdsman:adapter:ezsp:ezsp ==> {“cls”:“permitJoining”,“id”:34,“isRequest”:true,“duration”:0}
2023-07-20T00:00:40.969Z zigbee-herdsman:adapter:ezsp:uart → DATA (6,5,0): 360001220000
2023-07-20T00:00:40.970Z zigbee-herdsman:adapter:ezsp:uart → [657421a9762a1502bb7e]
2023-07-20T00:00:40.971Z zigbee-herdsman:adapter:ezsp:uart -?- waiting (7)
2023-07-20T00:00:40.977Z zigbee-herdsman:adapter:ezsp:uart ← [5774a1a9762a1519057e]
2023-07-20T00:00:40.978Z zigbee-herdsman:adapter:ezsp:uart ← DATA (5,7,0): 5774a1a9762a1519057e
2023-07-20T00:00:40.978Z zigbee-herdsman:adapter:ezsp:uart → ACK (6)
2023-07-20T00:00:40.979Z zigbee-herdsman:adapter:ezsp:uart → [8610be7e]
2023-07-20T00:00:40.980Z zigbee-herdsman:adapter:ezsp:ezsp <== Frame: 368001220000
2023-07-20T00:00:40.981Z zigbee-herdsman:adapter:ezsp:ezsp <== 0x22: {“cls”:“permitJoining”,“id”:34,“isRequest”:false,“status”:0}
2023-07-20T00:00:40.981Z zigbee-herdsman:adapter:ezsp:uart -± waiting (7) success
2023-07-20T00:00:40.984Z zigbee-herdsman:controller:database:log Writing database to ‘/config/zigbee2mqtt/database.db’
2023-07-20T00:00:40.994Z zigbee-herdsman:controller:log Creating coordinator backup
2023-07-20T00:00:40.995Z zigbee-herdsman:adapter:ezsp:backup creating backup
2023-07-20T00:00:40.996Z zigbee-herdsman:adapter:ezsp:ezsp ==> version: {“desiredProtocolVersion”:8}
2023-07-20T00:00:40.997Z zigbee-herdsman:adapter:ezsp:ezsp ==> {“cls”:“version”,“id”:0,“isRequest”:true,“desiredProtocolVersion”:8}
2023-07-20T00:00:40.998Z zigbee-herdsman:adapter:ezsp:uart → DATA (7,6,0): 370001000008
2023-07-20T00:00:40.999Z zigbee-herdsman:adapter:ezsp:uart → [767521a9542a1dc14c7e]
2023-07-20T00:00:40.999Z zigbee-herdsman:adapter:ezsp:uart -?- waiting (0)
2023-07-20T00:00:41.008Z zigbee-herdsman:adapter:ezsp:uart ← [6075a1a9542a1db069fe02527e]
2023-07-20T00:00:41.008Z zigbee-herdsman:adapter:ezsp:uart ← DATA (6,0,0): 6075a1a9542a1db069fe02527e
2023-07-20T00:00:41.009Z zigbee-herdsman:adapter:ezsp:uart → ACK (7)
2023-07-20T00:00:41.009Z zigbee-herdsman:adapter:ezsp:uart → [87009f7e]
2023-07-20T00:00:41.011Z zigbee-herdsman:adapter:ezsp:ezsp <== Frame: 37800100000802306a
2023-07-20T00:00:41.012Z zigbee-herdsman:adapter:ezsp:ezsp <== 0x0: {“cls”:“version”,“id”:0,“isRequest”:false,“protocolVersion”:8,“stackType”:2,“stackVersion”:27184}
2023-07-20T00:00:41.012Z zigbee-herdsman:adapter:ezsp:uart -± waiting (0) success
2023-07-20T00:00:41.013Z zigbee-herdsman:adapter:ezsp:ezsp ==> getKey: {“keyType”:1}
2023-07-20T00:00:41.014Z zigbee-herdsman:adapter:ezsp:ezsp ==> {“cls”:“getKey”,“id”:106,“isRequest”:true,“keyType”:1}
2023-07-20T00:00:41.015Z zigbee-herdsman:adapter:ezsp:uart → DATA (0,7,0): 3800016a0001
2023-07-20T00:00:41.016Z zigbee-herdsman:adapter:ezsp:uart → [077a21a93e2a14f5cc7e]
2023-07-20T00:00:41.016Z zigbee-herdsman:adapter:ezsp:uart -?- waiting (1)
2023-07-20T00:00:41.029Z zigbee-herdsman:adapter:ezsp:uart ← [717aa1a93e2a15a85995506b40f7595d99b7b0c0230e77db56436389fc7d5e3fa7ebcdde636e01392458ab8972067e]
2023-07-20T00:00:41.030Z zigbee-herdsman:adapter:ezsp:uart ← DATA (7,1,0): 717aa1a93e2a15a85995506b40f7595d99b7b0c0230e77db56436389fc7e3fa7ebcdde636e01392458ab8972067e
2023-07-20T00:00:41.030Z zigbee-herdsman:adapter:ezsp:uart → ACK (0)
2023-07-20T00:00:41.031Z zigbee-herdsman:adapter:ezsp:uart → [8070787e]
2023-07-20T00:00:41.033Z zigbee-herdsman:adapter:ezsp:ezsp <== Frame: 3880016a00001a00011a4eeaa2cb1405f9976bcec01050ab850000000000000000000ce1fefeff8d79e0
2023-07-20T00:00:41.034Z zigbee-herdsman:adapter:ezsp:ezsp <== 0x6a: {“cls”:“getKey”,“id”:106,“isRequest”:false,“status”:0,“keyStruct”:{“bitmask”:26,“type”:1,“key”:{“contents”:[26,78,234,162,203,20,5,249,151,107,206,192,16,80,171,133]},“outgoingFrameCounter”:0,“incomingFrameCounter”:0,“sequenceNumber”:0,“partnerEUI64”:{“type”:“Buffer”,“data”:[224,121,141,255,254,254,225,12]}}}
2023-07-20T00:00:41.035Z zigbee-herdsman:adapter:ezsp:uart -± waiting (1) success
2023-07-20T00:00:41.036Z zigbee-herdsman:adapter:ezsp:ezsp ==> getNetworkParameters: null
2023-07-20T00:00:41.036Z zigbee-herdsman:adapter:ezsp:ezsp ==> {“cls”:“getNetworkParameters”,“id”:40,“isRequest”:true}
2023-07-20T00:00:41.037Z zigbee-herdsman:adapter:ezsp:uart → DATA (1,0,0): 3900012800
2023-07-20T00:00:41.038Z zigbee-herdsman:adapter:ezsp:uart → [107b21a97c2a4f067e]
2023-07-20T00:00:41.039Z zigbee-herdsman:adapter:ezsp:uart -?- waiting (2)
2023-07-20T00:00:41.049Z zigbee-herdsman:adapter:ezsp:uart ← [027ba1a97c2a15b3844997f877884f94fe5422a0edce678bfd3e9c8e30647e]
2023-07-20T00:00:41.050Z zigbee-herdsman:adapter:ezsp:uart ← DATA (0,2,0): 027ba1a97c2a15b3844997f877884f94fe5422a0edce678bfd3e9c8e30647e
2023-07-20T00:00:41.050Z zigbee-herdsman:adapter:ezsp:uart → ACK (1)
2023-07-20T00:00:41.051Z zigbee-herdsman:adapter:ezsp:uart → [8160597e]
2023-07-20T00:00:41.053Z zigbee-herdsman:adapter:ezsp:ezsp <== Frame: 39800128000001dddddddddddddddd621a050b0000000000f8ff07
2023-07-20T00:00:41.054Z zigbee-herdsman:adapter:ezsp:ezsp <== 0x28: {“cls”:“getNetworkParameters”,“id”:40,“isRequest”:false,“status”:0,“nodeType”:1,“parameters”:{“extendedPanId”:[221,221,221,221,221,221,221,221],“panId”:6754,“radioTxPower”:5,“radioChannel”:11,“joinMethod”:0,“nwkManagerId”:0,“nwkUpdateId”:0,“channels”:134215680}}
2023-07-20T00:00:41.056Z zigbee-herdsman:adapter:ezsp:uart -± waiting (2) success
2023-07-20T00:00:41.057Z zigbee-herdsman:adapter:ezsp:ezsp ==> getKey: {“keyType”:3}
2023-07-20T00:00:41.059Z zigbee-herdsman:adapter:ezsp:ezsp ==> {“cls”:“getKey”,“id”:106,“isRequest”:true,“keyType”:3}
2023-07-20T00:00:41.060Z zigbee-herdsman:adapter:ezsp:uart → DATA (2,1,0): 3a00016a0003
2023-07-20T00:00:41.061Z zigbee-herdsman:adapter:ezsp:uart → [217821a93e2a16911d7e]
2023-07-20T00:00:41.061Z zigbee-herdsman:adapter:ezsp:uart -?- waiting (3)
2023-07-20T00:00:41.109Z zigbee-herdsman:adapter:ezsp:uart ← [7d3378a1a93e2a15b159974b26af529b42914127a9e9c86f81f1cb64b9fd7d5e3fa7ebcdde6f8fffc7dbd5d2698cfd7e]
2023-07-20T00:00:41.110Z zigbee-herdsman:adapter:ezsp:uart ← DATA (1,3,0): 1378a1a93e2a15b159974b26af529b42914127a9e9c86f81f1cb64b9fd7e3fa7ebcdde6f8fffc7dbd5d2698cfd7e
2023-07-20T00:00:41.110Z zigbee-herdsman:adapter:ezsp:uart → ACK (2)
2023-07-20T00:00:41.111Z zigbee-herdsman:adapter:ezsp:uart → [82503a7e]
2023-07-20T00:00:41.113Z zigbee-herdsman:adapter:ezsp:ezsp <== Frame: 3a80016a000003000301030507090b0d0f00020406080a0c0d0730010000000000000000000000000000
2023-07-20T00:00:41.114Z zigbee-herdsman:adapter:ezsp:ezsp <== 0x6a: {“cls”:“getKey”,“id”:106,“isRequest”:false,“status”:0,“keyStruct”:{“bitmask”:3,“type”:3,“key”:{“contents”:[1,3,5,7,9,11,13,15,0,2,4,6,8,10,12,13]},“outgoingFrameCounter”:77831,“incomingFrameCounter”:0,“sequenceNumber”:0,“partnerEUI64”:{“type”:“Buffer”,“data”:[0,0,0,0,0,0,0,0]}}}
2023-07-20T00:00:41.115Z zigbee-herdsman:adapter:ezsp:uart -± waiting (3) success
2023-07-20T00:00:41.116Z zigbee-herdsman:adapter:ezsp:ezsp ==> getEui64: null
2023-07-20T00:00:41.116Z zigbee-herdsman:adapter:ezsp:ezsp ==> {“cls”:“getEui64”,“id”:38,“isRequest”:true}
2023-07-20T00:00:41.117Z zigbee-herdsman:adapter:ezsp:uart → DATA (3,2,0): 3b00012600
2023-07-20T00:00:41.118Z zigbee-herdsman:adapter:ezsp:uart → [327921a9722a96c27e]
2023-07-20T00:00:41.119Z zigbee-herdsman:adapter:ezsp:uart -?- waiting (4)
2023-07-20T00:00:41.127Z zigbee-herdsman:adapter:ezsp:uart ← [2479a1a9722a1953a76ab5a8d3b5ff297e]
2023-07-20T00:00:41.128Z zigbee-herdsman:adapter:ezsp:uart ← DATA (2,4,0): 2479a1a9722a1953a76ab5a8d3b5ff297e
2023-07-20T00:00:41.128Z zigbee-herdsman:adapter:ezsp:uart → ACK (3)
2023-07-20T00:00:41.128Z zigbee-herdsman:adapter:ezsp:uart → [83401b7e]
2023-07-20T00:00:41.130Z zigbee-herdsman:adapter:ezsp:ezsp <== Frame: 3b800126000ce1fefeff8d79e0
2023-07-20T00:00:41.131Z zigbee-herdsman:adapter:ezsp:ezsp <== 0x26: {“cls”:“getEui64”,“id”:38,“isRequest”:false,“eui64”:{“type”:“Buffer”,“data”:[224,121,141,255,254,254,225,12]}}
2023-07-20T00:00:41.132Z zigbee-herdsman:adapter:ezsp:uart -± waiting (4) success
2023-07-20T00:00:41.150Z zigbee-herdsman:controller:log Wrote coordinator backup to ‘/config/zigbee2mqtt/coordinator_backup.json’
2023-07-20T00:00:41.152Z zigbee-herdsman:adapter:ezsp:driv Stop driver
2023-07-20T00:00:41.153Z zigbee-herdsman:adapter:ezsp:ezsp Stop ezsp
2023-07-20T00:00:41.162Z zigbee-herdsman:adapter:ezsp:uart Port closed
2023-07-20T00:00:41.163Z zigbee-herdsman:adapter:ezsp:ezsp Close ezsp
2023-07-20T00:00:41.164Z zigbee-herdsman:adapter:ezsp:driv Close driver
2023-07-20T00:00:41.165Z zigbee-herdsman:adapter:ezsp:ezsp Close ezsp
2023-07-20T00:00:41.165Z zigbee-herdsman:adapter:ezsp:driv Close driver
Zigbee2MQTT:info 2023-07-19 20:00:41: Stopped zigbee-herdsman

bennettTBCASoft · July 20, 2023, 7:54am

Is the MQTT Broker open?

onlize · July 20, 2023, 1:52pm

I specified mqtt topic, mqtt user name, and mqtt password in my configuration.

B0B · July 20, 2023, 11:23pm

@onlize oh ok cool

@bennettTBCASoft I just installed it but, I think still have the same issue.

Mosquitto broker log: seem to be working with no issues
s6-rc: info: service s6rc-oneshot-runner: starting
s6-rc: info: service s6rc-oneshot-runner successfully started
s6-rc: info: service fix-attrs: starting
s6-rc: info: service fix-attrs successfully started
s6-rc: info: service legacy-cont-init: starting
cont-init: info: running /etc/cont-init.d/mosquitto.sh
[18:56:05] INFO: SSL is not enabled
cont-init: info: /etc/cont-init.d/mosquitto.sh exited 0
cont-init: info: running /etc/cont-init.d/nginx.sh
cont-init: info: /etc/cont-init.d/nginx.sh exited 0
s6-rc: info: service legacy-cont-init successfully started
s6-rc: info: service legacy-services: starting
services-up: info: copying legacy longrun mosquitto (no readiness notification)
services-up: info: copying legacy longrun nginx (no readiness notification)
s6-rc: info: service legacy-services successfully started
[18:56:07] INFO: Starting NGINX for authentication handling…
[18:56:08] INFO: Starting mosquitto MQTT broker…
2023-07-20 18:56:08: Warning: Mosquitto should not be run as root/administrator.
[18:56:10] INFO: Successfully send discovery information to Home Assistant.
[18:56:11] INFO: Successfully send service information to the Supervisor.

Zigbee2MQTT Log:
[19:24:51] INFO: Zigbee Herdsman debug logging enabled
[19:24:56] INFO: Starting Zigbee2MQTT…
Zigbee2MQTT:debug 2023-07-20 19:25:10: Loaded state from file /config/zigbee2mqtt/state.json
Zigbee2MQTT:info 2023-07-20 19:25:10: Logging to console and directory: ‘/config/zigbee2mqtt/log/2023-07-20.19-25-09’ filename: log.txt
Zigbee2MQTT:debug 2023-07-20 19:25:10: Removing old log directory ‘/config/zigbee2mqtt/log/2023-07-19.19-52-51’
Zigbee2MQTT:info 2023-07-20 19:25:10: Starting Zigbee2MQTT version 1.32.1 (commit #unknown)
Zigbee2MQTT:info 2023-07-20 19:25:10: Starting zigbee-herdsman (0.16.0)
Zigbee2MQTT:debug 2023-07-20 19:25:10: Using zigbee-herdsman with settings: ‘{“adapter”:{“concurrent”:null,“delay”:null,“disableLED”:false},“backupPath”:"/config/zigbee2mqtt/coordinator_backup.json",“databaseBackupPath”:"/config/zigbee2mqtt/database.db.backup",“databasePath”:"/config/zigbee2mqtt/database.db",“network”:{“channelList”:[11],“extendedPanID”:[221,221,221,221,221,221,221,221],“networkKey”:“HIDDEN”,“panID”:6754},“serialPort”:{“adapter”:“ezsp”,“path”:"/dev/serial/by-id/usb-ITEAD_SONOFF_Zigbee_3.0_USB_Dongle_Plus_V2_20230220201356-if00"}}’
2023-07-20T23:25:11.364Z zigbee-herdsman:adapter Failed to validate path: ‘Error: spawn udevadm ENOENT’
2023-07-20T23:25:11.372Z 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/serial/by-id/usb-ITEAD_SONOFF_Zigbee_3.0_USB_Dongle_Plus_V2_20230220201356-if00",“adapter”:“ezsp”},“databasePath”:"/config/zigbee2mqtt/database.db",“databaseBackupPath”:"/config/zigbee2mqtt/database.db.backup",“backupPath”:"/config/zigbee2mqtt/coordinator_backup.json",“adapter”:{“disableLED”:false,“concurrent”:null,“delay”:null}}’
2023-07-20T23:25:11.381Z zigbee-herdsman:adapter:ezsp:uart Opening SerialPort with {“path”:"/dev/serial/by-id/usb-ITEAD_SONOFF_Zigbee_3.0_USB_Dongle_Plus_V2_20230220201356-if00",“baudRate”:115200,“rtscts”:false,“autoOpen”:false}
2023-07-20T23:25:11.488Z zigbee-herdsman:adapter:ezsp:uart Serialport opened
2023-07-20T23:25:11.491Z zigbee-herdsman:adapter:ezsp:uart Uart reseting
2023-07-20T23:25:11.508Z zigbee-herdsman:adapter:ezsp:uart → Write reset
2023-07-20T23:25:11.523Z zigbee-herdsman:adapter:ezsp:uart → [1ac038bc7e]
2023-07-20T23:25:11.530Z zigbee-herdsman:adapter:ezsp:uart -?- waiting reset
2023-07-20T23:25:11.594Z zigbee-herdsman:adapter:ezsp:uart ← [2c79b1a96b2a164fa674eb04aaa76d499db3d801e5ce6773f87e2c79b1a96b2a164fa674eb04aaa76d499db3d801e5ce6773f87e2c79b1a96b2a164fa674eb04aaa76d499db3d801e5ce6773f87ec20251a8bd7e]
2023-07-20T23:25:11.602Z zigbee-herdsman:adapter:ezsp:uart ← DATA (2,4,1): 2c79b1a96b2a164fa674eb04aaa76d499db3d801e5ce6773f87e
2023-07-20T23:25:11.604Z zigbee-herdsman:adapter:ezsp:uart → ACK (3)
2023-07-20T23:25:11.608Z zigbee-herdsman:adapter:ezsp:uart → [83401b7e]
2023-07-20T23:25:11.613Z zigbee-herdsman:adapter:ezsp:uart Unexpected packet sequence 4 | 0
2023-07-20T23:25:11.614Z zigbee-herdsman:adapter:ezsp:uart Skipping the packet as repeated (3)
2023-07-20T23:25:11.615Z zigbee-herdsman:adapter:ezsp:uart ← DATA (2,4,1): 2c79b1a96b2a164fa674eb04aaa76d499db3d801e5ce6773f87e
2023-07-20T23:25:11.616Z zigbee-herdsman:adapter:ezsp:uart → ACK (3)
2023-07-20T23:25:11.618Z zigbee-herdsman:adapter:ezsp:uart → [83401b7e]
2023-07-20T23:25:11.619Z zigbee-herdsman:adapter:ezsp:uart Unexpected packet sequence 4 | 0
2023-07-20T23:25:11.622Z zigbee-herdsman:adapter:ezsp:uart Skipping the packet as repeated (3)
2023-07-20T23:25:11.626Z zigbee-herdsman:adapter:ezsp:uart ← DATA (2,4,1): 2c79b1a96b2a164fa674eb04aaa76d499db3d801e5ce6773f87e
2023-07-20T23:25:11.627Z zigbee-herdsman:adapter:ezsp:uart → ACK (3)
2023-07-20T23:25:11.628Z zigbee-herdsman:adapter:ezsp:uart → [83401b7e]
2023-07-20T23:25:11.628Z zigbee-herdsman:adapter:ezsp:uart Unexpected packet sequence 4 | 0
2023-07-20T23:25:11.629Z zigbee-herdsman:adapter:ezsp:uart Skipping the packet as repeated (3)
2023-07-20T23:25:11.631Z zigbee-herdsman:adapter:ezsp:uart ← Error: c20251a8bd7e
2023-07-20T23:25:11.632Z zigbee-herdsman:adapter:ezsp:uart Uart reseting
2023-07-20T23:25:11.632Z zigbee-herdsman:adapter:ezsp:uart → Write reset
2023-07-20T23:25:11.634Z zigbee-herdsman:adapter:ezsp:uart → [1ac038bc7e]
2023-07-20T23:25:11.634Z zigbee-herdsman:adapter:ezsp:uart -?- waiting reset
2023-07-20T23:25:11.687Z zigbee-herdsman:adapter:ezsp:uart ← [11]
2023-07-20T23:25:12.643Z zigbee-herdsman:adapter:ezsp:uart ← [c1020b0a527e]
2023-07-20T23:25:12.645Z zigbee-herdsman:adapter:ezsp:uart ← RSTACK: c1020b0a527e
2023-07-20T23:25:12.648Z zigbee-herdsman:adapter:ezsp:uart RSTACK Version: 2 Reason: RESET_SOFTWARE frame: c1020b0a527e
2023-07-20T23:25:12.655Z zigbee-herdsman:adapter:ezsp:uart -± waiting reset success
2023-07-20T23:25:12.655Z zigbee-herdsman:adapter:ezsp:uart -± waiting reset success
2023-07-20T23:25:12.658Z zigbee-herdsman:adapter:ezsp:ezsp ==> version: {“desiredProtocolVersion”:4}
2023-07-20T23:25:12.662Z zigbee-herdsman:adapter:ezsp:ezsp ==> {“cls”:“version”,“id”:0,“isRequest”:true,“desiredProtocolVersion”:4}
2023-07-20T23:25:12.666Z zigbee-herdsman:adapter:ezsp:uart → DATA (0,0,0): 00000004
2023-07-20T23:25:12.671Z zigbee-herdsman:adapter:ezsp:uart → [004221a850ed2c7e]
2023-07-20T23:25:12.672Z zigbee-herdsman:adapter:ezsp:uart -?- waiting (1)
2023-07-20T23:25:12.755Z zigbee-herdsman:adapter:ezsp:uart ← [11]
2023-07-20T23:25:13.756Z zigbee-herdsman:adapter:ezsp:uart ← [c1020b0a527e]
2023-07-20T23:25:13.758Z zigbee-herdsman:adapter:ezsp:uart ← RSTACK: c1020b0a527e
2023-07-20T23:25:13.759Z zigbee-herdsman:adapter:ezsp:uart RSTACK Version: 2 Reason: RESET_SOFTWARE frame: c1020b0a527e
2023-07-20T23:25:14.676Z zigbee-herdsman:adapter:ezsp:uart → Error: Error: {“sequence”:1} after 2000ms
2023-07-20T23:25:14.677Z zigbee-herdsman:adapter:ezsp:uart -!- break waiting (1)
2023-07-20T23:25:14.677Z zigbee-herdsman:adapter:ezsp:uart Can’t send DATA frame (0,0,0): 00000004
2023-07-20T23:25:15.180Z zigbee-herdsman:adapter:ezsp:uart ->> DATA (0,0,1): 00000004
2023-07-20T23:25:15.183Z zigbee-herdsman:adapter:ezsp:uart → [084221a850ef017e]
2023-07-20T23:25:15.185Z zigbee-herdsman:adapter:ezsp:uart -?- rewaiting (1)
2023-07-20T23:25:15.191Z zigbee-herdsman:adapter:ezsp:uart ← [8160597e0142a1a85c2825d8e12b7e]
2023-07-20T23:25:15.192Z zigbee-herdsman:adapter:ezsp:uart ← ACK (1): 8160597e
2023-07-20T23:25:15.193Z zigbee-herdsman:adapter:ezsp:uart ← DATA (0,1,0): 0142a1a85c2825d8e12b7e
2023-07-20T23:25:15.194Z zigbee-herdsman:adapter:ezsp:uart → ACK (1)
2023-07-20T23:25:15.195Z zigbee-herdsman:adapter:ezsp:uart → [8160597e]
2023-07-20T23:25:15.196Z zigbee-herdsman:adapter:ezsp:uart Unexpected packet sequence 1 | 0
2023-07-20T23:25:15.198Z zigbee-herdsman:adapter:ezsp:ezsp <== Frame: 0080000802306a
2023-07-20T23:25:15.203Z zigbee-herdsman:adapter:ezsp:ezsp <== 0x0: {“cls”:“version”,“id”:0,“isRequest”:false,“protocolVersion”:8,“stackType”:2,“stackVersion”:27184}
2023-07-20T23:25:15.205Z zigbee-herdsman:adapter:ezsp:uart -± rewaiting (1) success
2023-07-20T23:25:15.206Z zigbee-herdsman:adapter:ezsp:uart -± waiting (1) success
2023-07-20T23:25:15.207Z zigbee-herdsman:adapter:ezsp:ezsp Switching to eszp version 8
2023-07-20T23:25:15.208Z zigbee-herdsman:adapter:ezsp:ezsp ==> version: {“desiredProtocolVersion”:8}
2023-07-20T23:25:15.209Z zigbee-herdsman:adapter:ezsp:ezsp ==> {“cls”:“version”,“id”:0,“isRequest”:true,“desiredProtocolVersion”:8}
2023-07-20T23:25:15.212Z zigbee-herdsman:adapter:ezsp:uart → DATA (0,1,0): 010001000008
2023-07-20T23:25:15.214Z zigbee-herdsman:adapter:ezsp:uart → [014321a9542a1dfe047e]
2023-07-20T23:25:15.215Z zigbee-herdsman:adapter:ezsp:uart -?- waiting (1)
2023-07-20T23:25:15.221Z zigbee-herdsman:adapter:ezsp:uart ← [a1443b7e]
2023-07-20T23:25:15.222Z zigbee-herdsman:adapter:ezsp:uart ← NAK (1): a1443b7e
2023-07-20T23:25:15.224Z zigbee-herdsman:adapter:ezsp:uart NAK Expected packet sequence 1
2023-07-20T23:25:15.225Z zigbee-herdsman:adapter:ezsp:uart → Error: Error: Recv NAK frame
2023-07-20T23:25:15.225Z zigbee-herdsman:adapter:ezsp:uart -!- break waiting (1)
2023-07-20T23:25:15.225Z zigbee-herdsman:adapter:ezsp:uart Can’t send DATA frame (0,1,0): 010001000008
2023-07-20T23:25:15.728Z zigbee-herdsman:adapter:ezsp:uart ->> DATA (0,1,1): 010001000008
2023-07-20T23:25:15.731Z zigbee-herdsman:adapter:ezsp:uart → [094321a9542a1d6da97e]
2023-07-20T23:25:15.733Z zigbee-herdsman:adapter:ezsp:uart -?- rewaiting (1)
2023-07-20T23:25:15.737Z zigbee-herdsman:adapter:ezsp:uart ← [8160597e]
2023-07-20T23:25:15.739Z zigbee-herdsman:adapter:ezsp:uart ← ACK (1): 8160597e
2023-07-20T23:25:15.742Z zigbee-herdsman:adapter:ezsp:uart -± rewaiting (1) success
2023-07-20T23:25:15.742Z zigbee-herdsman:adapter:ezsp:uart -± waiting (1) success
2023-07-20T23:25:22.662Z zigbee-herdsman:adapter:ezsp:ezsp Time to watchdog … 0
2023-07-20T23:25:22.663Z zigbee-herdsman:adapter:ezsp:ezsp ==> nop: null
2023-07-20T23:25:25.750Z zigbee-herdsman:adapter:ezsp:ezsp ==> {“cls”:“nop”,“id”:5,“isRequest”:true}
2023-07-20T23:25:25.752Z zigbee-herdsman:adapter:ezsp:uart → DATA (1,1,0): 0200010500
2023-07-20T23:25:25.756Z zigbee-herdsman:adapter:ezsp:uart → [7d314021a9512a9a0d7e]
2023-07-20T23:25:25.757Z zigbee-herdsman:adapter:ezsp:uart -?- waiting (2)
Zigbee2MQTT:error 2023-07-20 19:25:25: Error while starting zigbee-herdsman
Zigbee2MQTT:error 2023-07-20 19:25:25: Failed to start zigbee
Zigbee2MQTT:error 2023-07-20 19:25:25: Check Zigbee2MQTT fails to start | Zigbee2MQTT for possible solutions
Zigbee2MQTT:error 2023-07-20 19:25:25: Exiting…
Zigbee2MQTT:error 2023-07-20 19:25:26: Error: Failure send version:{“type”:“Buffer”,“data”:[1,0,1,0,0,8]}
at /app/node_modules/zigbee-herdsman/src/adapter/ezsp/driver/ezsp.ts:562:23
at Queue.executeNext (/app/node_modules/zigbee-herdsman/src/utils/queue.ts:32:32)

B0B · July 21, 2023, 1:13am

Update:
So out of curiosity I reset to default in the zigg2mqtt options and it booted up without any issue. Going to have to test if I’m actually able to add my IoT devices now. Hopefully no more issue and smooth sailing.