Zigbee2MQTT 1.42.0-2 - alle Devices weg

Add-ons
1

Ich sitze hier im Dunkeln :slight_smile: Bei meinem Setup mit zwei SLZB-06 (im Moment wird nur einer wirklich genutzt) sind seit heute 13:15:27 sind alle Geräte weg. Gemerkt habe ich da aber erst vorhin, als die Automation nichts eingeschaltet hat. Im Log sieht das so aus:

[2024-12-16 01:31:36] info: 	z2m:mqtt: MQTT publish: topic 'zigbee2mqtt-A/Wohnzimmer MH TV Leuchte', payload '{"brightness":97,"color_mode":"color_temp","color_temp":359,"linkquality":94,"power_on_behavior":null,"state":"OFF","update":{"installed_version":16786690,"latest_version":16786690,"state":"idle"},"update_available":null}'
[2024-12-16 13:15:27] error: 	zh:zstack:znp: Socket error Error: read ETIMEDOUT
[2024-12-16 13:15:27] info: 	zh:zstack:znp: Port closed
[2024-12-16 13:15:27] info: 	zh:zstack:znp: closing
[2024-12-16 13:15:27] error: 	z2m: Adapter disconnected, stopping
[2024-12-16 13:15:27] info: 	z2m:mqtt: MQTT publish: topic 'zigbee2mqtt-A/bridge/state', payload '{"state":"offline"}'
[2024-12-16 13:15:27] info: 	z2m: Disconnecting from MQTT server
[2024-12-16 13:15:27] info: 	z2m: Stopping zigbee-herdsman...
[2024-12-16 13:15:27] info: 	z2m: Stopped zigbee-herdsman
[2024-12-16 13:15:27] info: 	z2m: Stopped Zigbee2MQTT
[13:15:27] INFO: Preparing to start...
[13:15:27] INFO: Socat not enabled
[13:15:27] INFO: Starting Zigbee2MQTT...
Starting Zigbee2MQTT without watchdog.
[2024-12-16 13:15:28] info: 	z2m: Logging to console, file (filename: log.log)
[2024-12-16 13:15:28] info: 	z2m: Starting Zigbee2MQTT version 1.42.0 (commit #unknown)
[2024-12-16 13:15:28] info: 	z2m: Starting zigbee-herdsman (2.1.9)
[2024-12-16 13:15:28] info: 	zh:zstack:znp: Opening TCP socket with 192.168.204.240:6638
[2024-12-16 13:15:51] error: 	zh:zstack:znp: Socket error Error: connect EHOSTUNREACH 192.168.204.240:6638
[2024-12-16 13:15:51] error: 	z2m: Error while starting zigbee-herdsman
[2024-12-16 13:15:51] error: 	z2m: Failed to start zigbee
[2024-12-16 13:15:51] error: 	z2m: Check https://www.zigbee2mqtt.io/guide/installation/20_zigbee2mqtt-fails-to-start.html for possible solutions
[2024-12-16 13:15:51] error: 	z2m: Exiting...
[2024-12-16 13:15:51] error: 	z2m: Error: Error while opening socket
    at Socket.<anonymous> (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/znp/znp.ts:166:24)
    at Socket.emit (node:events:531:35)
    at emitErrorNT (node:internal/streams/destroy:169:8)
    at emitErrorCloseNT (node:internal/streams/destroy:128:3)
    at processTicksAndRejections (node:internal/process/task_queues:82:21)
/app/node_modules/winston/node_modules/readable-stream/lib/_stream_writable.js:264
  var er = new ERR_STREAM_WRITE_AFTER_END();
           ^
Error: write after end
    at writeAfterEnd (/app/node_modules/winston/node_modules/readable-stream/lib/_stream_writable.js:264:12)
    at DerivedLogger.Writable.write (/app/node_modules/winston/node_modules/readable-stream/lib/_stream_writable.js:300:21)
    at DerivedLogger.log (/app/node_modules/winston/lib/winston/logger.js:231:12)
    at Logger.log (/app/lib/util/logger.ts:198:25)
    at Logger.info (/app/lib/util/logger.ts:211:14)
    at Znp.onPortClose (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/znp/znp.ts:96:16)
    at Object.onceWrapper (node:events:634:26)
    at Socket.emit (node:events:519:28)
    at TCP.<anonymous> (node:net:338:12)
[13:15:52] INFO: Preparing to start...
[13:15:52] INFO: Socat not enabled
[13:15:52] INFO: Starting Zigbee2MQTT...

Jetzt beim Start so:

[2024-12-16 20:20:27] info: 	zh:zstack:znp: closing
[2024-12-16 20:20:27] info: 	z2m: Stopped zigbee-herdsman
[2024-12-16 20:20:27] info: 	z2m: Stopped Zigbee2MQTT
/app/node_modules/winston/node_modules/readable-stream/lib/_stream_writable.js:264
  var er = new ERR_STREAM_WRITE_AFTER_END();
           ^
Error: write after end
    at writeAfterEnd (/app/node_modules/winston/node_modules/readable-stream/lib/_stream_writable.js:264:12)
    at DerivedLogger.Writable.write (/app/node_modules/winston/node_modules/readable-stream/lib/_stream_writable.js:300:21)
    at DerivedLogger.log (/app/node_modules/winston/lib/winston/logger.js:231:12)
    at Logger.log (/app/lib/util/logger.ts:198:25)
    at Logger.info (/app/lib/util/logger.ts:211:14)
    at Znp.onPortClose (/app/node_modules/zigbee-herdsman/src/adapter/z-stack/znp/znp.ts:96:16)
    at Object.onceWrapper (node:events:634:26)
    at Socket.emit (node:events:531:35)
    at TCP.<anonymous> (node:net:338:12)
[20:24:29] INFO: Preparing to start...
[20:24:29] INFO: Socat not enabled
[20:24:29] INFO: Starting Zigbee2MQTT...
Starting Zigbee2MQTT without watchdog.
[2024-12-16 20:24:29] info: 	z2m: Logging to console, file (filename: log.log)
[2024-12-16 20:24:29] info: 	z2m: Starting Zigbee2MQTT version 1.42.0 (commit #unknown)
[2024-12-16 20:24:29] info: 	z2m: Starting zigbee-herdsman (2.1.9)
[2024-12-16 20:24:30] info: 	zh:zstack:znp: Opening TCP socket with 192.168.204.240:6638
[2024-12-16 20:24:30] info: 	zh:zstack:znp: Socket connected
[2024-12-16 20:24:30] info: 	zh:zstack:znp: Socket ready
[2024-12-16 20:24:30] info: 	zh:zstack:znp: Writing CC2530/CC2531 skip bootloader payload
[2024-12-16 20:24:31] info: 	zh:zstack:znp: Skip bootloader for CC2652/CC1352
[2024-12-16 20:24:31] info: 	z2m: zigbee-herdsman started (resumed)
[2024-12-16 20:24:31] info: 	z2m: Coordinator firmware version: '{"meta":{"maintrel":1,"majorrel":2,"minorrel":7,"product":1,"revision":20240710,"transportrev":2},"type":"zStack3x0"}'
[2024-12-16 20:24:31] info: 	z2m: Currently 0 devices are joined.
[2024-12-16 20:24:31] info: 	z2m: Zigbee: disabling joining new devices.
[2024-12-16 20:24:31] info: 	z2m: Connecting to MQTT server at mqtt://ha.mhc.loc:1883
[2024-12-16 20:24:31] info: 	z2m: Connected to MQTT server
[2024-12-16 20:24:31] info: 	z2m:mqtt: MQTT publish: topic 'zigbee2mqtt-A/bridge/state', payload '{"state":"online"}'
[2024-12-16 20:24:31] info: 	z2m:mqtt: MQTT publish: topic 'zigbee2mqtt-A/Wohnzimmer_MH_Lampen/availability', payload '{"state":"online"}'
[2024-12-16 20:24:31] info: 	z2m: Started frontend on port 8099
[2024-12-16 20:24:31] info: 	z2m:mqtt: MQTT publish: topic 'zigbee2mqtt-A/bridge/state', payload '{"state":"online"}'
[2024-12-16 20:24:31] info: 	z2m:mqtt: MQTT publish: topic 'zigbee2mqtt-A/Wohnzimmer_MH_Lampen', payload '{"brightness":94,"color_mode":"color_temp","color_temp":388,"state":"OFF"}'
[2024-12-16 20:24:31] info: 	z2m: Zigbee2MQTT started!
[2024-12-16 20:24:36] info: 	z2m:mqtt: MQTT publish: topic 'homeassistant/binary_sensor/12210510398101101501091131161164565_0x00124b0031dd0458/connection_state/config', payload '{"device":{"hw_version":"zStack3x0 20240710","identifiers":["zigbee2mqtt_bridge_0x00124b0031dd0458"],"manufacturer":"Zigbee2MQTT","model":"Bridge","name":"Zigbee2MQTT Bridge","sw_version":"1.42.0"},"device_class":"connectivity","entity_category":"diagnostic","name":"Connection state","object_id":"zigbee2mqtt_bridge_connection_state","origin":{"name":"Zigbee2MQTT","sw":"1.42.0","url":"https://www.zigbee2mqtt.io"},"payload_off":"offline","payload_on":"online","state_topic":"zigbee2mqtt-A/bridge/state","unique_id":"bridge_0x00124b0031dd0458_connection_state_zigbee2mqtt-A","value_template":"{{ value_json.state }}"}'
 Live

In der zigbee2mqtt/configuration.yaml stehen aber noch alle Devices drin und der SLZB-06 meldet auch “connected”. Restart, zurück zum Backup vom Wochenende … hat alles nichts gebracht.

Weiss jemand Rat?

2

Lies mal das und das drunter.

3

Danke, ich bastle.

Kannst du mir dazu ein wenig Background geben? Was ist mutmasslich das Problem und wichtiger: was verursacht das spontan?

[2024-12-16 13:15:27] error: 	zh:zstack:znp: Socket error Error: read ETIMEDOUT
[2024-12-16 13:15:27] info: 	zh:zstack:znp: Port closed
[2024-12-16 13:15:27] info: 	zh:zstack:znp: closing
4

Was hast Du denn zuletzt an Z2M gemacht und wann hast Du Z2M oder das komplette System zuletzt neu gestartet? Und hast Du das ganze Backup vom Wochenende zurückgespielt oder nur Z2M?

5

Das vom Wochenende ich ein Snapshot der VM, also ein Mal alles.

Am Z2M habe ich die vergangen 8 Tage nichts gemacht, abgesehen von Updates, falls da welche waren.

Ich habe jetzt mal zum Test die komplette Z2M Config weggeworfen. Wenn ich jetzt das Anlernen starte sieht er nichts.

Ausserdem hab ich auf die zigbee.db mal einen diff mit einer von vor 2 Wochen gemacht, der sieht keinen Unterschied.

6

Leg doch mal fix eine neue VM an mit Z2M und versuch es damit.

7

Ich hatte kürzlich einen ähnlichen Fall. Auch Backup der ganzen VM eingespielt, hat nicht funktioniert.
Erst als ich die ganze Hardware neu gestartet hatte, also den Proxmox Server in meinem Fall, lief wieder alles korrekt

8

Factory-Reset der Lampen hat geholfen. Witziger Weise ist damit jetzt auch mein Problem mit dem Umbenennen der Geräte und dem Umbenennen der Entitäten gelöst. Geht jetzt auch.

Mich würde jetzt nur noch interessieren wie das spontan passieren kann.

Wobei, wenn ich mir er recht überlege könnte das an dem Setup mit den zwei SLZB-06 liegen. Ich hatte mich schon immer bei den Anleitungen gewundert warum die den data_path: nicht auch mit anpassen und doppeln. Jetzt sieht das bei mir so aus:

A

data_path: /config/zigbee2mqtt-A
socat:
  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
mqtt:
  server: mqtt://ha.domain.loc:1883
  base_topic: zigbee2mqtt-A
  user: zigbee1
  password: zigbee1
serial:
  port: tcp://192.168.204.240:6638
  baudrate: 115200
  adapter: zstack
advanced:
  transmit_power: 20

B

data_path: /config/zigbee2mqtt-B
socat:
  enabled: false
  master: pty,raw,echo=0,link=/tmp/ttyZ2M,mode=777
  slave: tcp-listen:8486,keepalive,nodelay,reuseaddr,keepidle=1,keepintvl=1,keepcnt=5
  options: "-d -d"
  log: false
mqtt:
  server: mqtt://ha.domain.loc:1883
  base_topic: zigbee2mqtt-B
  user: zigbee2
  password: zigbee2
serial:
  port: tcp://192.168.204.241:6638
  baudrate: 115200
  adapter: zstack
advanced:
  transmit_power: 20

Alles meiner Meinung nach wichtige (Name, User, IPs, Ports) ist jetzt getaggt bzw. unterschiedlich und kommt sich so sicher nirgends nicht in die Quere.

9

Wenn ein Reboot der VM nicht reicht verstehe ich das nicht. Was soll da sein? Nach dem Reinstall geht es ja jetzt, sogar besser als vorher …

10

In meinem Fall war die Ursache das ich den Sonoff Dongle rausgerissen hatte. Wieder anstecken hatte nicht gereicht, vermutlich wurde er nicht mehr sauber an die VM durchgereicht. Hätte man sicher, auch ohne Hardwarereboot hinbekommen. Ist halt meist das erste was man versucht

11

Verstehe ich, aber nicht in einem PVE-Cluster mit 22 VMs :slight_smile:

12

Verstehe ich auch :sweat_smile: