Cant connect to Zigbee2MQTT

Hello,
after a reboot i cant connect to Zigbee2MQTT anymore. Perhaps anyone can help.

LOG:

[20:08:10] INFO: Preparing to start...
[20:08:11] INFO: Socat not enabled
[20:08:13] INFO: Starting Zigbee2MQTT...
Zigbee2MQTT:warn  2022-10-04 20:08:19: `permit_join` set to  `true` in configuration.yaml.
Zigbee2MQTT:warn  2022-10-04 20:08:19: Allowing new devices to join.
Zigbee2MQTT:warn  2022-10-04 20:08:19: Set `permit_join` to `false` once you joined all devices.
Zigbee2MQTT:error 2022-10-04 20:08:20: MQTT error: Connection refused: Not authorized
Zigbee2MQTT:error 2022-10-04 20:08:20: MQTT failed to connect, exiting...
Zigbee2MQTT:error 2022-10-04 20:08:21: MQTT error: Connection refused: Not authorized

before the reboot it ran without problems

MQTT not working:-)

You setup, is it using the MQTT add-on, or a separate MQTT broker?

If the add-on, might never worked correctly, as the server should then be :

  server: mqtt://core-mosquitto:1883
2 Likes

hm, thx. will not working. perhaps a bug in HA or a Addon?

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
[21:56:11] INFO: Setting up user mqtt_user
[21:56:13] INFO: Certificates found: SSL is available
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
[21:56:14] INFO: Starting NGINX for authentication handling...
[21:56:15] INFO: Starting mosquitto MQTT broker...
2022-10-04 21:56:15: Warning: Mosquitto should not be run as root/administrator.
[21:56:16] INFO: Successfully send discovery information to Home Assistant.
[21:56:16] INFO: Successfully send service information to the Supervisor.
2022-10-04 21:56:15: mosquitto version 2.0.11 starting
2022-10-04 21:56:15: Config loaded from /etc/mosquitto/mosquitto.conf.
2022-10-04 21:56:15: Loading plugin: /usr/share/mosquitto/go-auth.so
2022-10-04 21:56:15:  ├── Username/password checking enabled.
2022-10-04 21:56:15:  ├── TLS-PSK checking enabled.
2022-10-04 21:56:15:  └── Extended authentication not enabled.
2022-10-04 21:56:15: Opening ipv4 listen socket on port 1883.
2022-10-04 21:56:15: Opening ipv6 listen socket on port 1883.
2022-10-04 21:56:15: Opening websockets listen socket on port 1884.
2022-10-04 21:56:15: Opening ipv4 listen socket on port 8883.
2022-10-04 21:56:15: Opening ipv6 listen socket on port 8883.
2022-10-04 21:56:15: Opening websockets listen socket on port 8884.
2022-10-04 21:56:15: mosquitto version 2.0.11 running
2022-10-04 21:56:15: New connection from 172.30.32.1:51270 on port 1883.
2022-10-04 21:56:15: New client connected from 172.30.32.1:51270 as mqttjs_b7e4fa50 (p2, c1, k60, u'mqtt_user').
2022-10-04 21:56:16: New connection from 127.0.0.1:37852 on port 1883.
2022-10-04 21:56:16: Client <unknown> closed its connection.
2022-10-04 21:56:33: New connection from 172.30.32.2:41536 on port 1883.
2022-10-04 21:56:33: Client <unknown> closed its connection.
2022-10-04 21:57:07: New connection from 172.30.32.1:33658 on port 1883.
error: received null username or password for unpwd check
2022-10-04 21:57:07: Client <unknown> disconnected, not authorised.
2022-10-04 21:58:22: New connection from 172.30.32.1:50082 on port 1883.
error: received null username or password for unpwd check
2022-10-04 21:58:22: Client <unknown> disconnected, not authorised.
2022-10-04 21:58:23: New connection from 172.30.32.1:36668 on port 1883.
error: received null username or password for unpwd check
2022-10-04 21:58:23: Client <unknown> disconnected, not authorised.
2022-10-04 21:58:25: New connection from 172.30.32.1:36672 on port 1883.
error: received null username or password for unpwd check
2022-10-04 21:58:25: Client <unknown> disconnected, not authorised.
2022-10-04 21:58:29: New connection from 172.30.32.1:36680 on port 1883.
error: received null username or password for unpwd check
2022-10-04 21:58:29: Client <unknown> disconnected, not authorised.
2022-10-04 21:58:33: New connection from 172.30.32.2:55144 on port 1883.
2022-10-04 21:58:33: Client <unknown> closed its connection.
2022-10-04 21:58:37: New connection from 172.30.32.1:36044 on port 1883.
error: received null username or password for unpwd check
2022-10-04 21:58:37: Client <unknown> disconnected, not authorised.
2022-10-04 21:58:53: New connection from 172.30.32.1:37588 on port 1883.
error: received null username or password for unpwd check
2022-10-04 21:58:53: Client <unknown> disconnected, not authorised.
2022-10-04 21:59:25: New connection from 172.30.32.1:35626 on port 1883.
error: received null username or password for unpwd check

2022-10-04T20:04:44.961Z zigbee-herdsman:deconz:driver networkstate: 2 apsDataConfirm: 0 apsDataIndication: 0 configChanged: 0 apsRequestFreeSlots: 1
2022-10-04T20:04:44.961Z zigbee-herdsman:deconz:frameParser DATA_REQUEST RESPONSE - request id: 45 status: 0
2022-10-04T20:04:44.962Z zigbee-herdsman:deconz:driver networkstate: 2 apsDataConfirm: 0 apsDataIndication: 0 configChanged: 0 apsRequestFreeSlots: 1
2022-10-04T20:04:44.971Z zigbee-herdsman:deconz:frameParser DEVICE_STATE changed: 10100110
2022-10-04T20:04:44.971Z zigbee-herdsman:deconz:driver networkstate: 2 apsDataConfirm: 1 apsDataIndication: 0 configChanged: 0 apsRequestFreeSlots: 1
2022-10-04T20:04:44.974Z zigbee-herdsman:deconz:driver query aps data confirm
2022-10-04T20:04:44.980Z zigbee-herdsman:deconz:driver DATA_CONFIRM - sending data state request - SeqNr. 201
2022-10-04T20:04:44.981Z zigbee-herdsman:deconz:frameParser DATA_CONFIRM RESPONSE - destAddr: 0x8dd7 request id: 45 confirm status: 0
2022-10-04T20:04:44.982Z zigbee-herdsman:deconz:driver networkstate: 2 apsDataConfirm: 0 apsDataIndication: 0 configChanged: 0 apsRequestFreeSlots: 1
2022-10-04T20:04:44.982Z zigbee-herdsman:deconz:adapter sendZclFrameToEndpoint - message send with transSeq Nr.: 28
2022-10-04T20:04:44.982Z zigbee-herdsman:deconz:adapter true, true, false
2022-10-04T20:04:44.982Z zigbee-herdsman:deconz:adapter resolve request
2022-10-04T20:04:45.083Z zigbee-herdsman:deconz:frameParser DEVICE_STATE changed: 10101010
2022-10-04T20:04:45.083Z zigbee-herdsman:deconz:driver networkstate: 2 apsDataConfirm: 0 apsDataIndication: 1 configChanged: 0 apsRequestFreeSlots: 1
2022-10-04T20:04:45.084Z zigbee-herdsman:deconz:driver query aps data indication
2022-10-04T20:04:45.089Z zigbee-herdsman:deconz:driver DATA_INDICATION - sending read data request - SeqNr. 202
2022-10-04T20:04:45.091Z zigbee-herdsman:deconz:frameParser DATA_INDICATION RESPONSE - seqNr. 202 srcAddr: 0x8dd7 destAddr: 0x0 profile id: 0x104 cluster id: 0xb04 lqi: 255
2022-10-04T20:04:45.091Z zigbee-herdsman:deconz:frameParser response payload: 24,28,1,5,5,0,33,230,0,8,5,0,33,0,0,11,5,0,41,0,0
2022-10-04T20:04:45.095Z zigbee-herdsman:deconz:adapter resolve data request with transSeq Nr.: 28
2022-10-04T20:04:45.100Z zigbee-herdsman:controller:log Received 'zcl' data '{"frame":{"Header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":28,"manufacturerCode":null,"commandIdentifier":1},"Payload":[{"attrId":1285,"status":0,"dataType":33,"attrData":230},{"attrId":1288,"status":0,"dataType":33,"attrData":0},{"attrId":1291,"status":0,"dataType":41,"attrData":0}],"Command":{"ID":1,"name":"readRsp","parameters":[{"name":"attrId","type":33},{"name":"status","type":32},{"name":"dataType","type":32,"conditions":[{"type":"statusEquals","value":0}]},{"name":"attrData","type":1000,"conditions":[{"type":"statusEquals","value":0}]}]}},"address":36311,"endpoint":1,"linkquality":255,"groupID":null,"wasBroadcast":false,"destinationEndpoint":1}'
2022-10-04T20:04:45.120Z zigbee-herdsman:deconz:driver networkstate: 2 apsDataConfirm: 0 apsDataIndication: 0 configChanged: 0 apsRequestFreeSlots: 1
2022-10-04T20:04:45.123Z zigbee-herdsman:deconz:adapter response received
2022-10-04T20:04:45.126Z zigbee-herdsman:controller:endpoint Read 0x60a423fffe620f5b/1 haElectricalMeasurement(["rmsVoltage","rmsCurrent","activePower"], {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":0,"srcEndpoint":null,"reservedBits":0,"manufacturerCode":null,"transactionSequenceNumber":null,"writeUndiv":false}) failed (no response received)
2022-10-04T20:04:52.563Z zigbee-herdsman:deconz:driver send read device state from queue. seqNr: 203
2022-10-04T20:04:52.566Z zigbee-herdsman:deconz:frameParser device state: 10100010
2022-10-04T20:04:52.567Z zigbee-herdsman:deconz:driver networkstate: 2 apsDataConfirm: 0 apsDataIndication: 0 configChanged: 0 apsRequestFreeSlots: 1
2022-10-04T20:04:54.856Z zigbee-herdsman:deconz:frameParser DEVICE_STATE changed: 10100110
2022-10-04T20:04:54.857Z zigbee-herdsman:deconz:driver networkstate: 2 apsDataConfirm: 1 apsDataIndication: 0 configChanged: 0 apsRequestFreeSlots: 1
2022-10-04T20:04:54.859Z zigbee-herdsman:deconz:driver query aps data confirm
2022-10-04T20:04:54.865Z zigbee-herdsman:deconz:driver DATA_CONFIRM - sending data state request - SeqNr. 204
2022-10-04T20:04:54.867Z zigbee-herdsman:deconz:frameParser DATA_CONFIRM RESPONSE - destAddr: 0x8701 request id: 44 confirm status: 0
2022-10-04T20:04:54.868Z zigbee-herdsman:deconz:driver networkstate: 2 apsDataConfirm: 0 apsDataIndication: 0 configChanged: 0 apsRequestFreeSlots: 1
2022-10-04T20:04:54.868Z zigbee-herdsman:deconz:adapter sendZclFrameToEndpoint - message send with transSeq Nr.: 27
2022-10-04T20:04:54.868Z zigbee-herdsman:deconz:adapter true, true, false
2022-10-04T20:04:54.869Z zigbee-herdsman:deconz:adapter resolve request
2022-10-04T20:05:02.563Z zigbee-herdsman:deconz:driver send read device state from queue. seqNr: 205
2022-10-04T20:05:02.565Z zigbee-herdsman:deconz:frameParser device state: 10100010
2022-10-04T20:05:02.565Z zigbee-herdsman:deconz:driver networkstate: 2 apsDataConfirm: 0 apsDataIndication: 0 configChanged: 0 apsRequestFreeSlots: 1
2022-10-04T20:05:12.562Z zigbee-herdsman:deconz:driver send read device state from queue. seqNr: 206
2022-10-04T20:05:12.564Z zigbee-herdsman:deconz:frameParser device state: 10100010
2022-10-04T20:05:12.565Z zigbee-herdsman:deconz:driver networkstate: 2 apsDataConfirm: 0 apsDataIndication: 0 configChanged: 0 apsRequestFreeSlots: 1
2022-10-04T20:05:22.562Z zigbee-herdsman:deconz:driver send read device state from queue. seqNr: 207
2022-10-04T20:05:22.566Z zigbee-herdsman:deconz:frameParser device state: 10100010
2022-10-04T20:05:22.566Z zigbee-herdsman:deconz:driver networkstate: 2 apsDataConfirm: 0 apsDataIndication: 0 configChanged: 0 apsRequestFreeSlots: 1
2022-10-04T20:05:29.723Z zigbee-herdsman:deconz:frameParser DEVICE_STATE changed: 10101010
2022-10-04T20:05:29.723Z zigbee-herdsman:deconz:driver networkstate: 2 apsDataConfirm: 0 apsDataIndication: 1 configChanged: 0 apsRequestFreeSlots: 1
2022-10-04T20:05:29.724Z zigbee-herdsman:deconz:driver query aps data indication
2022-10-04T20:05:29.730Z zigbee-herdsman:deconz:driver DATA_INDICATION - sending read data request - SeqNr. 208
2022-10-04T20:05:29.733Z zigbee-herdsman:deconz:frameParser DATA_INDICATION RESPONSE - seqNr. 208 srcAddr: 0xe38d destAddr: 0x0 profile id: 0x104 cluster id: 0x6 lqi: 255
2022-10-04T20:05:29.734Z zigbee-herdsman:deconz:frameParser response payload: 8,3,10,0,0,40,0
2022-10-04T20:05:29.738Z zigbee-herdsman:controller:log Received 'zcl' data '{"frame":{"Header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":false,"reservedBits":0},"transactionSequenceNumber":3,"manufacturerCode":null,"commandIdentifier":10},"Payload":[{"attrId":0,"dataType":40,"attrData":0}],"Command":{"ID":10,"name":"report","parameters":[{"name":"attrId","type":33},{"name":"dataType","type":32},{"name":"attrData","type":1000}]}},"address":58253,"endpoint":1,"linkquality":255,"groupID":null,"wasBroadcast":false,"destinationEndpoint":1}'
2022-10-04T20:05:29.741Z zigbee-herdsman:controller:endpoint DefaultResponse 0x804b50fffeb56893/1 6(10, {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":true,"direction":1,"srcEndpoint":null,"reservedBits":0,"manufacturerCode":null,"transactionSequenceNumber":null,"writeUndiv":false})
2022-10-04T20:05:29.742Z zigbee-herdsman:deconz:adapter no response expected
2022-10-04T20:05:29.742Z zigbee-herdsman:deconz:driver networkstate: 2 apsDataConfirm: 0 apsDataIndication: 0 configChanged: 0 apsRequestFreeSlots: 1
2022-10-04T20:05:29.751Z zigbee-herdsman:deconz:driver DATA_REQUEST - destAddr: 0xe38d EP:1 SeqNr. 209 request id: 46
2022-10-04T20:05:29.754Z zigbee-herdsman:deconz:frameParser DATA_REQUEST RESPONSE - request id: 46 status: 0
2022-10-04T20:05:29.754Z zigbee-herdsman:deconz:driver networkstate: 2 apsDataConfirm: 0 apsDataIndication: 0 configChanged: 0 apsRequestFreeSlots: 1
2022-10-04T20:05:29.774Z zigbee-herdsman:deconz:frameParser DEVICE_STATE changed: 10100110
2022-10-04T20:05:29.774Z zigbee-herdsman:deconz:driver networkstate: 2 apsDataConfirm: 1 apsDataIndication: 0 configChanged: 0 apsRequestFreeSlots: 1
2022-10-04T20:05:29.777Z zigbee-herdsman:deconz:driver query aps data confirm
2022-10-04T20:05:29.781Z zigbee-herdsman:deconz:driver DATA_CONFIRM - sending data state request - SeqNr. 210
2022-10-04T20:05:29.784Z zigbee-herdsman:deconz:frameParser DATA_CONFIRM RESPONSE - destAddr: 0xe38d request id: 46 confirm status: 0
2022-10-04T20:05:29.784Z zigbee-herdsman:deconz:driver networkstate: 2 apsDataConfirm: 0 apsDataIndication: 0 configChanged: 0 apsRequestFreeSlots: 1
2022-10-04T20:05:29.784Z zigbee-herdsman:deconz:adapter sendZclFrameToEndpoint - message send with transSeq Nr.: 3
2022-10-04T20:05:29.784Z zigbee-herdsman:deconz:adapter false, true, false
2022-10-04T20:05:29.784Z zigbee-herdsman:deconz:adapter resolve request
2022-10-04T20:05:32.564Z zigbee-herdsman:deconz:driver send read device state from queue. seqNr: 211
2022-10-04T20:05:32.567Z zigbee-herdsman:deconz:frameParser device state: 10100010
2022-10-04T20:05:32.568Z zigbee-herdsman:deconz:driver networkstate: 2 apsDataConfirm: 0 apsDataIndication: 0 configChanged: 0 apsRequestFreeSlots: 1
2022-10-04T20:05:38.960Z zigbee-herdsman:deconz:frameParser DEVICE_STATE changed: 10101010
2022-10-04T20:05:38.961Z zigbee-herdsman:deconz:driver networkstate: 2 apsDataConfirm: 0 apsDataIndication: 1 configChanged: 0 apsRequestFreeSlots: 1
2022-10-04T20:05:38.965Z zigbee-herdsman:deconz:driver query aps data indication
2022-10-04T20:05:38.970Z zigbee-herdsman:deconz:driver DATA_INDICATION - sending read data request - SeqNr. 212
2022-10-04T20:05:38.973Z zigbee-herdsman:deconz:frameParser DATA_INDICATION RESPONSE - seqNr. 212 srcAddr: 0xc7cd destAddr: 0x0 profile id: 0x104 cluster id: 0xef00 lqi: 255
2022-10-04T20:05:38.974Z zigbee-herdsman:deconz:frameParser response payload: 25,80,36,1,131
2022-10-04T20:05:38.980Z zigbee-herdsman:controller:log Received 'zcl' data '{"frame":{"Header":{"frameControl":{"frameType":1,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":true,"reservedBits":0},"transactionSequenceNumber":80,"manufacturerCode":null,"commandIdentifier":36},"Payload":{"payloadSize":33537},"Command":{"ID":36,"parameters":[{"name":"payloadSize","type":33}],"name":"mcuSyncTime"}},"address":51149,"endpoint":1,"linkquality":255,"groupID":null,"wasBroadcast":false,"destinationEndpoint":1}'
2022-10-04T20:05:38.983Z zigbee-herdsman:controller:endpoint Command 0x847127fffec7d184/1 manuSpecificTuya.mcuSyncTime({"payloadSize":8,"payload":[99,60,146,19,99,60,174,51]}, {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"disableRecovery":false,"disableDefaultResponse":false,"direction":0,"srcEndpoint":null,"reservedBits":0,"manufacturerCode":null,"transactionSequenceNumber":null,"writeUndiv":false})
2022-10-04T20:05:38.984Z zigbee-herdsman:deconz:driver networkstate: 2 apsDataConfirm: 0 apsDataIndication: 0 configChanged: 0 apsRequestFreeSlots: 1
2022-10-04T20:05:38.985Z zigbee-herdsman:deconz:driver DATA_REQUEST - destAddr: 0xc7cd EP:1 SeqNr. 213 request id: 47
2022-10-04T20:05:38.990Z zigbee-herdsman:deconz:frameParser DATA_REQUEST RESPONSE - request id: 47 status: 0
2022-10-04T20:05:38.990Z zigbee-herdsman:deconz:driver networkstate: 2 apsDataConfirm: 0 apsDataIndication: 0 configChanged: 0 apsRequestFreeSlots: 1
2022-10-04T20:05:38.999Z zigbee-herdsman:deconz:frameParser DEVICE_STATE changed: 10100110
2022-10-04T20:05:38.999Z zigbee-herdsman:deconz:driver networkstate: 2 apsDataConfirm: 1 apsDataIndication: 0 configChanged: 0 apsRequestFreeSlots: 1
2022-10-04T20:05:39.002Z zigbee-herdsman:deconz:driver query aps data confirm
2022-10-04T20:05:39.007Z zigbee-herdsman:deconz:driver DATA_CONFIRM - sending data state request - SeqNr. 214
2022-10-04T20:05:39.009Z zigbee-herdsman:deconz:frameParser DATA_CONFIRM RESPONSE - destAddr: 0xc7cd request id: 47 confirm status: 0
2022-10-04T20:05:39.009Z zigbee-herdsman:deconz:driver networkstate: 2 apsDataConfirm: 0 apsDataIndication: 0 configChanged: 0 apsRequestFreeSlots: 1
2022-10-04T20:05:39.009Z zigbee-herdsman:deconz:adapter sendZclFrameToEndpoint - message send with transSeq Nr.: 29
2022-10-04T20:05:39.009Z zigbee-herdsman:deconz:adapter false, false, false
2022-10-04T20:05:39.009Z zigbee-herdsman:deconz:adapter resolve request
2022-10-04T20:05:39.040Z zigbee-herdsman:deconz:frameParser DEVICE_STATE changed: 10101010
2022-10-04T20:05:39.040Z zigbee-herdsman:deconz:driver networkstate: 2 apsDataConfirm: 0 apsDataIndication: 1 configChanged: 0 apsRequestFreeSlots: 1
2022-10-04T20:05:39.043Z zigbee-herdsman:deconz:driver query aps data indication
2022-10-04T20:05:39.049Z zigbee-herdsman:deconz:driver DATA_INDICATION - sending read data request - SeqNr. 215
2022-10-04T20:05:39.051Z zigbee-herdsman:deconz:frameParser DATA_INDICATION RESPONSE - seqNr. 215 srcAddr: 0xc7cd destAddr: 0x0 profile id: 0x104 cluster id: 0xef00 lqi: 255
2022-10-04T20:05:39.051Z zigbee-herdsman:deconz:frameParser response payload: 8,29,11,36,0
2022-10-04T20:05:39.052Z zigbee-herdsman:deconz:adapter resolve data request with transSeq Nr.: 29
2022-10-04T20:05:39.054Z zigbee-herdsman:controller:log Received 'zcl' data '{"frame":{"Header":{"frameControl":{"frameType":0,"manufacturerSpecific":false,"direction":1,"disableDefaultResponse":false,"reservedBits":0},"transactionSequenceNumber":29,"manufacturerCode":null,"commandIdentifier":11},"Payload":{"cmdId":36,"statusCode":0},"Command":{"ID":11,"name":"defaultRsp","parameters":[{"name":"cmdId","type":32},{"name":"statusCode","type":32}]}},"address":51149,"endpoint":1,"linkquality":255,"groupID":null,"wasBroadcast":false,"destinationEndpoint":1}'
2022-10-04T20:05:39.055Z zigbee-herdsman:deconz:driver networkstate: 2 apsDataConfirm: 0 apsDataIndication: 0 configChanged: 0 apsRequestFreeSlots: 1
2022-10-04T20:05:39.056Z zigbee-herdsman:deconz:adapter response received