Старая версия Node.js

Переключился с тестовой ветки на стабильную. Перестал подниматься zigbee2mqtt

npm[1577]: > zigbee2mqtt@1.35.1 start
npm[1577]: > node index.js
npm[4854]:                 Zigbee2MQTT requires node version ^18 || ^20 || ^21, you are running v16.18.1!
# apt policy nodejs
nodejs:
  Installed: 16.18.1-deb-1nodesource1
  Candidate: 16.18.1-deb-1nodesource1
  Version table:
     16.20.2-deb-1nodesource1 500
        500 https://deb.nodesource.com/node_16.x bullseye/main armhf Packages
 *** 16.18.1-deb-1nodesource1 990
        990 http://deb.wirenboard.com/wb7/bullseye stable/main armhf Packages
        100 /var/lib/dpkg/status
     12.22.12~dfsg-1~deb11u4 500
        500 http://debian-mirror.wirenboard.com/debian bullseye/main armhf Packages
        500 http://debian-mirror.wirenboard.com/debian-security bullseye-security/main armhf Packages

Подскажите, пожалуйста, официальный метод решения проблемы?

Добрый день.
Это не мешает работать:

Jan 30 10:21:01 wirenboard-AQASN7R6 npm[29542]: > zigbee2mqtt@1.35.1 start
Jan 30 10:21:01 wirenboard-AQASN7R6 npm[29542]: > node index.js
Jan 30 10:21:03 wirenboard-AQASN7R6 npm[29600]:                 Zigbee2MQTT requires node version ^18 || ^20 || ^21, you are running v16.18.1!
Jan 30 10:46:57 wirenboard-AQASN7R6 npm[29600]: Zigbee2MQTT:error 2024-01-30 10:46:57: Request 'zigbee2mqtt/bridge/request/permit_join' failed with error: 'SRSP - ZDO - mgmtPermitJoinReq after 6000ms'
Jan 30 10:47:03 wirenboard-AQASN7R6 npm[29600]: Zigbee2MQTT:error 2024-01-30 10:47:03: Request 'zigbee2mqtt/bridge/request/permit_join' failed with error: 'SRSP - AF - dataRequestExt after 6000ms'
Jan 30 10:47:09 wirenboard-AQASN7R6 npm[29600]: Zigbee2MQTT:error 2024-01-30 10:47:09: Request 'zigbee2mqtt/bridge/request/permit_join' failed with error: 'SRSP - ZDO - mgmtPermitJoinReq after 6000ms'
Jan 30 10:47:15 wirenboard-AQASN7R6 npm[29600]: Zigbee2MQTT:error 2024-01-30 10:47:15: Request 'zigbee2mqtt/bridge/request/permit_join' failed with error: 'SRSP - AF - dataRequestExt after 6000ms'
Jan 30 10:49:12 wirenboard-AQASN7R6 npm[29600]: Zigbee2MQTT:error 2024-01-30 10:49:12: Update of 'WB-MSW_2floor' failed (OTA: Timeout, device did not request any image blocks)
Jan 30 10:49:21 wirenboard-AQASN7R6 npm[29600]: Zigbee2MQTT:error 2024-01-30 10:49:21: Update of 'WB-MSW_Basement' failed (OTA: Timeout, device did not request any image blocks)
Jan 30 11:35:21 wirenboard-AQASN7R6 npm[29600]: Zigbee2MQTT:error 2024-01-30 11:35:21: Failed to check if update available for 'WB-MSW_Basement' (OTA: Device didn't respond to OTA request)

Да, в итоге после первоначальной задержки загрузилось.
Только теперь все zigbee-девайсы падают в оффлайн несколько раз в день. Решается рестартом сервиса, через некоторое время всё повторяется.
Добавил стабильности, блин.
Я бы предложил делать переключение между ветками через механизм отложенных обновлений, а не даунгрейдом.

А что при этом в логе самого zigbee2mqtt?

Не совсем понятно, у нас разве какие-то пакеты при обновлении меняются старыми?

Вот сегодняшнее утро, когда я не смог голосом открыть шторы и включить свет)
Зашёл в веб-интерфейс, в настройках Z2M нажал кнопку перезагрузки.

Feb 07 07:08:42 wirenboard-AVZTYW4Z npm[6995]: Zigbee2MQTT:warn  2024-02-07 07:08:42: Failed to ping 'Диммер' (attempt 1/1, Read 0xa4c138ded54d0139/1 genBasic(["zclVersion"], {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"disableRecovery":tr>
Feb 07 07:08:54 wirenboard-AVZTYW4Z npm[6995]: Zigbee2MQTT:warn  2024-02-07 07:08:54: Failed to ping 'Хозкомната Стеллаж' (attempt 1/1, Read 0xa4c1387155925fff/1 genBasic(["zclVersion"], {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"disable>
Feb 07 07:09:06 wirenboard-AVZTYW4Z npm[6995]: Zigbee2MQTT:warn  2024-02-07 07:09:06: Failed to ping 'Кухня Шторы' (attempt 1/1, Read 0x00158d0007998950/1 genBasic(["zclVersion"], {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"disableRecover>
Feb 07 07:09:18 wirenboard-AVZTYW4Z npm[6995]: Zigbee2MQTT:warn  2024-02-07 07:09:18: Failed to ping 'Серверная Стеллаж' (attempt 1/1, Read 0xa4c13871d1a606ac/1 genBasic(["zclVersion"], {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"disableR>
Feb 07 07:09:30 wirenboard-AVZTYW4Z npm[6995]: Zigbee2MQTT:warn  2024-02-07 07:09:30: Failed to ping 'Прихожая Тёплый пол' (attempt 1/1, Read 0xa4c138989e347148/1 genBasic(["zclVersion"], {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"disabl>
Feb 07 07:09:42 wirenboard-AVZTYW4Z npm[6995]: Zigbee2MQTT:warn  2024-02-07 07:09:42: Failed to ping 'Спальня Тёплый пол' (attempt 1/1, Read 0xa4c138da74a4f6ad/1 genBasic(["zclVersion"], {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"disable>
Feb 07 07:09:54 wirenboard-AVZTYW4Z npm[6995]: Zigbee2MQTT:warn  2024-02-07 07:09:54: Failed to ping 'Ванная Тёплый пол' (attempt 1/1, Read 0xa4c138d240e22e63/1 genBasic(["zclVersion"], {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"disableR>
Feb 07 07:12:35 wirenboard-AVZTYW4Z npm[6995]: Zigbee2MQTT:error 2024-02-07 07:12:35: Failed to stop Zigbee2MQTT
Feb 07 07:12:35 wirenboard-AVZTYW4Z npm[6995]:                 Zigbee2MQTT requires node version ^18 || ^20 || ^21, you are running v16.18.1!
Feb 07 07:12:38 wirenboard-AVZTYW4Z npm[6995]: Zigbee2MQTT:error 2024-02-07 07:12:38: Error while starting zigbee-herdsman
Feb 07 07:12:38 wirenboard-AVZTYW4Z npm[6995]: Zigbee2MQTT:error 2024-02-07 07:12:38: Failed to start zigbee
Feb 07 07:12:38 wirenboard-AVZTYW4Z npm[6995]: Zigbee2MQTT:error 2024-02-07 07:12:38: Check https://www.zigbee2mqtt.io/guide/installation/20_zigbee2mqtt-fails-to-start.html for possible solutions
Feb 07 07:12:38 wirenboard-AVZTYW4Z npm[6995]: Zigbee2MQTT:error 2024-02-07 07:12:38: Exiting...
Feb 07 07:12:38 wirenboard-AVZTYW4Z npm[6995]: Zigbee2MQTT:error 2024-02-07 07:12:38: Error: Error while opening serialport 'Error: Error Resource temporarily unavailable Cannot lock port'
Feb 07 07:12:38 wirenboard-AVZTYW4Z npm[6995]:     at SerialPort.<anonymous> (/mnt/data/root/zigbee2mqtt/node_modules/zigbee-herdsman/src/adapter/z-stack/znp/znp.ts:146:28)
Feb 07 07:12:38 wirenboard-AVZTYW4Z npm[6995]:     at SerialPort._error (/mnt/data/root/zigbee2mqtt/node_modules/@serialport/stream/dist/index.js:82:22)
Feb 07 07:12:38 wirenboard-AVZTYW4Z npm[6995]:     at /mnt/data/root/zigbee2mqtt/node_modules/@serialport/stream/dist/index.js:118:18
Feb 07 07:12:39 wirenboard-AVZTYW4Z systemd[1]: zigbee2mqtt.service: Main process exited, code=exited, status=1/FAILURE
Feb 07 07:12:39 wirenboard-AVZTYW4Z systemd[1]: zigbee2mqtt.service: Failed with result 'exit-code'.
Feb 07 07:12:39 wirenboard-AVZTYW4Z systemd[1]: zigbee2mqtt.service: Consumed 5h 47min 48.307s CPU time.
Feb 07 07:14:09 wirenboard-AVZTYW4Z systemd[1]: zigbee2mqtt.service: Scheduled restart job, restart counter is at 2.
Feb 07 07:14:09 wirenboard-AVZTYW4Z systemd[1]: Stopped zigbee2mqtt.
Feb 07 07:14:09 wirenboard-AVZTYW4Z systemd[1]: zigbee2mqtt.service: Consumed 5h 47min 48.307s CPU time.
Feb 07 07:14:09 wirenboard-AVZTYW4Z systemd[1]: Started zigbee2mqtt.
Feb 07 07:14:13 wirenboard-AVZTYW4Z npm[18452]: > zigbee2mqtt@1.35.1 start
Feb 07 07:14:13 wirenboard-AVZTYW4Z npm[18452]: > node index.js
Feb 07 07:14:16 wirenboard-AVZTYW4Z npm[18490]:                 Zigbee2MQTT requires node version ^18 || ^20 || ^21, you are running v16.18.1!
Feb 07 07:14:53 wirenboard-AVZTYW4Z npm[18490]: Zigbee2MQTT:error 2024-02-07 07:14:53: Cannot find '0x70ac08fffe15f271/1' of group 'Кухня'
Feb 07 07:14:53 wirenboard-AVZTYW4Z npm[18490]: Zigbee2MQTT:error 2024-02-07 07:14:53: Cannot find '0x00178801026eeba1/11' of group 'Гостиная'
Feb 07 07:14:53 wirenboard-AVZTYW4Z npm[18490]: Zigbee2MQTT:error 2024-02-07 07:14:53: Cannot find '0x0017880103f668ec/11' of group 'Гостиная'
Feb 07 07:15:02 wirenboard-AVZTYW4Z npm[18490]: Zigbee2MQTT:warn  2024-02-07 07:15:02: Failed to ping 'Висюлька 2' (attempt 1/1, Read 0x0017880104a20e26/11 genBasic(["zclVersion"], {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"disableRecove>
Feb 07 07:15:16 wirenboard-AVZTYW4Z npm[18490]: Zigbee2MQTT:warn  2024-02-07 07:15:16: Failed to ping 'Лоджия кабинета Спот 3' (attempt 1/1, Read 0x0017880103528351/11 genBasic(["zclVersion"], {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"d>
Feb 07 07:15:28 wirenboard-AVZTYW4Z npm[18490]: Zigbee2MQTT:error 2024-02-07 07:15:28: Failed to read state of 'Кошкин горшок' after reconnect (Read 0x00124b000e250f96/1 genOnOff(["onOff"], {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"disa>
Feb 07 07:15:31 wirenboard-AVZTYW4Z npm[18490]: Zigbee2MQTT:error 2024-02-07 07:15:31: Failed to read state of 'Гостиная Гриль 6' after reconnect (Read 0xa4c1388d3c7aaf23/1 genOnOff(["onOff"], {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"d>
Feb 07 07:15:43 wirenboard-AVZTYW4Z npm[18490]:                 Zigbee2MQTT requires node version ^18 || ^20 || ^21, you are running v16.18.1!
Feb 07 07:15:50 wirenboard-AVZTYW4Z npm[18490]: Zigbee2MQTT:error 2024-02-07 07:15:50: Cannot find '0x70ac08fffe15f271/1' of group 'Кухня'
Feb 07 07:15:50 wirenboard-AVZTYW4Z npm[18490]: Zigbee2MQTT:error 2024-02-07 07:15:50: Cannot find '0x00178801026eeba1/11' of group 'Гостиная'
Feb 07 07:15:50 wirenboard-AVZTYW4Z npm[18490]: Zigbee2MQTT:error 2024-02-07 07:15:50: Cannot find '0x0017880103f668ec/11' of group 'Гостиная'
Feb 07 07:15:59 wirenboard-AVZTYW4Z npm[18490]: Zigbee2MQTT:warn  2024-02-07 07:15:59: Failed to ping 'Лоджия кабинета Спот 3' (attempt 1/1, Read 0x0017880103528351/11 genBasic(["zclVersion"], {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"d>
Feb 07 07:16:39 wirenboard-AVZTYW4Z npm[18490]: Zigbee2MQTT:warn  2024-02-07 07:16:39: Failed to ping 'Кухня Спот 2' (attempt 1/1, Read 0x0017880109e07d67/11 genBasic(["zclVersion"], {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"disableReco>
Feb 07 07:16:58 wirenboard-AVZTYW4Z npm[18490]: Zigbee2MQTT:warn  2024-02-07 07:16:58: Failed to ping 'Кухня Спот 1' (attempt 1/1, Read 0x0017880109d85c1c/11 genBasic(["zclVersion"], {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"disableReco>

Вот так выглядит текущий статус

systemctl status zigbee2mqtt

zigbee2mqtt.service - zigbee2mqtt
Loaded: loaded (/lib/systemd/system/zigbee2mqtt.service; enabled; vendor preset: enabled)
Active: active (running) since Wed 2024-02-07 07:14:09 UTC; 4h 40min ago
Main PID: 18452 (npm start)
Tasks: 23 (limit: 4790)
Memory: 105.7M
CPU: 1h 13min 3.968s
CGroup: /system.slice/zigbee2mqtt.service
├─18452 npm start
├─18488 sh -c – node index.js
└─18490 node index.js

Feb 07 11:46:15 wirenboard-AVZTYW4Z npm[18490]: Zigbee2MQTT:error 2024-02-07 11:46:15: Publish 'set' 'state' to 'Прихожая Гриль 1' failed: 'Error: Command 0xa4c1387e196915ea/1 genOnOff.off({}, {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"d>
Feb 07 11:47:17 wirenboard-AVZTYW4Z npm[18490]: Zigbee2MQTT:warn  2024-02-07 11:47:17: Failed to ping 'Спальня Шторы' (attempt 1/1, Read 0x00158d00079b85fc/1 genBasic(["zclVersion"], {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"disableReco>
Feb 07 11:48:51 wirenboard-AVZTYW4Z npm[18490]: Zigbee2MQTT:error 2024-02-07 11:48:51: Not connected to MQTT server!
Feb 07 11:48:51 wirenboard-AVZTYW4Z npm[18490]: Zigbee2MQTT:error 2024-02-07 11:48:51: Cannot send message: topic: 'zigbee2mqtt/Ванная Тёплый пол', payload: '{"current":0.02,"energy":207.33,"linkquality":138,"power":0,"power_on_behavior":"off","power_outage_m>
Feb 07 11:48:51 wirenboard-AVZTYW4Z npm[18490]: Zigbee2MQTT:error 2024-02-07 11:48:51: Not connected to MQTT server!
Feb 07 11:48:51 wirenboard-AVZTYW4Z npm[18490]: Zigbee2MQTT:error 2024-02-07 11:48:51: Cannot send message: topic: 'zigbee2mqtt/Ванная Тёплый пол', payload: '{"current":0.02,"energy":207.33,"linkquality":142,"power":0,"power_on_behavior":"off","power_outage_m>
Feb 07 11:51:28 wirenboard-AVZTYW4Z npm[18490]: Zigbee2MQTT:warn  2024-02-07 11:51:28: Failed to ping 'Лоджия кабинета Спот 3' (attempt 1/1, Read 0x0017880103528351/11 genBasic(["zclVersion"], {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"d>
Feb 07 11:51:48 wirenboard-AVZTYW4Z npm[18490]: Zigbee2MQTT:warn  2024-02-07 11:51:48: Failed to ping 'Кухня Спот 2' (attempt 1/1, Read 0x0017880109e07d67/11 genBasic(["zclVersion"], {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"disableReco>
Feb 07 11:51:55 wirenboard-AVZTYW4Z npm[18490]: Zigbee2MQTT:warn  2024-02-07 11:51:55: Failed to ping 'Кухня Спот 1' (attempt 1/1, Read 0x0017880109d85c1c/11 genBasic(["zclVersion"], {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"disableReco>
Feb 07 11:54:35 wirenboard-AVZTYW4Z npm[18490]: Zigbee2MQTT:warn  2024-02-07 11:54:35: Failed to ping 'Гостиная Гриль 1' (attempt 1/1, Read 0xa4c138838c2029c4/1 genBasic(["zclVersion"], {"sendWhen":"immediate","timeout":10000,"disableResponse":false,"disableR>

При переходе из тестовой в стабильную ветку

Start-Date: 2024-02-02  10:54:21
Commandline: apt-get -q dist-upgrade -o Dpkg::Options::=--force-confdef -o Dpkg::Options::=--force-confold --allow-downgrades --yes
Downgrade: python3-mqttrpc:armhf (1.2.4, 1.2.2), wb-mqtt-confed:armhf (1.14.4, 1.14.0), libmm-glib0:armhf (1.20.0-1~bpo11+1-wb107, 1.20.0-1~bpo11+1-wb106), wb-mqtt-homeui:armhf (2.78.9, 2.78.3), wb-mqtt-metrics:armhf (0.3.2, 0.3.1), wb-nm-helper:armhf (1.32.2>
End-Date: 2024-02-02  10:57:02

А чем был занят порт? Такое впечатление что есть какой-то процесс который пытается его использовать.

А это уже интересней. Сам mosquitto работает, в лог свой ничего странного не пишет?
Если подписаться на топик zigbee2mqtt - туда что-то публикуется?
И, кстати, в брокере в /etc/mosquitto/mosquitto.conf отключен persistence?

Возможно предыдущим процессом, который не хотел нормально убиваться? Сегодня была такая же история. Кнопку рестарта нужно нажимать дважды.

Вот момент падения, видны два подключения от mqttjs.
Сообщениями от rules забит весь лог.

Feb 08 07:11:50 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376310: New client connected from /var/run/mosquitto/mosquitto.sock:0 as rules-wirenboard-AVZTYW4Z-24034 (p2, c1, k30).
Feb 08 07:12:40 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376360: Client rules-wirenboard-AVZTYW4Z-24034 closed its connection.
Feb 08 07:12:40 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376360: New connection from /var/run/mosquitto/mosquitto.sock:0 on port 0.
Feb 08 07:12:40 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376360: New client connected from /var/run/mosquitto/mosquitto.sock:0 as rules-wirenboard-AVZTYW4Z-24034 (p2, c1, k30).
Feb 08 07:13:30 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376410: Client rules-wirenboard-AVZTYW4Z-24034 closed its connection.
Feb 08 07:13:30 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376410: New connection from /var/run/mosquitto/mosquitto.sock:0 on port 0.
Feb 08 07:13:30 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376410: New client connected from /var/run/mosquitto/mosquitto.sock:0 as rules-wirenboard-AVZTYW4Z-24034 (p2, c1, k30).
Feb 08 07:13:44 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376424: Client mqttjs_dbe191d3 disconnected.
Feb 08 07:14:20 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376460: Client rules-wirenboard-AVZTYW4Z-24034 closed its connection.
Feb 08 07:14:20 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376460: New connection from /var/run/mosquitto/mosquitto.sock:0 on port 0.
Feb 08 07:14:20 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376460: New client connected from /var/run/mosquitto/mosquitto.sock:0 as rules-wirenboard-AVZTYW4Z-24034 (p2, c1, k30).
Feb 08 07:15:05 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376505: Client rules-wirenboard-AVZTYW4Z-24034 closed its connection.
Feb 08 07:15:05 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376505: New connection from /var/run/mosquitto/mosquitto.sock:0 on port 0.
Feb 08 07:15:05 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376505: New client connected from /var/run/mosquitto/mosquitto.sock:0 as rules-wirenboard-AVZTYW4Z-24034 (p2, c1, k30).
Feb 08 07:15:50 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376550: Client rules-wirenboard-AVZTYW4Z-24034 closed its connection.
Feb 08 07:15:50 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376550: New connection from /var/run/mosquitto/mosquitto.sock:0 on port 0.
Feb 08 07:15:50 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376550: New client connected from /var/run/mosquitto/mosquitto.sock:0 as rules-wirenboard-AVZTYW4Z-24034 (p2, c1, k30).
Feb 08 07:16:40 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376600: Client rules-wirenboard-AVZTYW4Z-24034 closed its connection.
Feb 08 07:16:40 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376600: New connection from /var/run/mosquitto/mosquitto.sock:0 on port 0.
Feb 08 07:16:40 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376600: New client connected from /var/run/mosquitto/mosquitto.sock:0 as rules-wirenboard-AVZTYW4Z-24034 (p2, c1, k30).
Feb 08 07:17:30 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376650: Client rules-wirenboard-AVZTYW4Z-24034 closed its connection.
Feb 08 07:17:30 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376650: New connection from /var/run/mosquitto/mosquitto.sock:0 on port 0.
Feb 08 07:17:30 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376650: New client connected from /var/run/mosquitto/mosquitto.sock:0 as rules-wirenboard-AVZTYW4Z-24034 (p2, c1, k30).
Feb 08 07:18:15 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376695: Client rules-wirenboard-AVZTYW4Z-24034 disconnected: Broken pipe.
Feb 08 07:18:16 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376696: New connection from /var/run/mosquitto/mosquitto.sock:0 on port 0.
Feb 08 07:18:16 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376696: New client connected from /var/run/mosquitto/mosquitto.sock:0 as rules-wirenboard-AVZTYW4Z-24034 (p2, c1, k30).
Feb 08 07:18:52 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376732: New connection from 127.0.0.1:44590 on port 1883.
Feb 08 07:18:53 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376733: New client connected from 127.0.0.1:44590 as mqttjs_28dc14b6 (p2, c1, k60).
Feb 08 07:19:06 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376746: Client rules-wirenboard-AVZTYW4Z-24034 closed its connection.
Feb 08 07:19:06 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376746: New connection from /var/run/mosquitto/mosquitto.sock:0 on port 0.
Feb 08 07:19:06 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376746: New client connected from /var/run/mosquitto/mosquitto.sock:0 as rules-wirenboard-AVZTYW4Z-24034 (p2, c1, k30).
Feb 08 07:19:21 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376761: Client mqttjs_28dc14b6 disconnected.
Feb 08 07:19:46 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376786: New connection from 127.0.0.1:44598 on port 1883.
Feb 08 07:19:46 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376786: New client connected from 127.0.0.1:44598 as mqttjs_25b74509 (p2, c1, k60).
Feb 08 07:19:51 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376791: Client rules-wirenboard-AVZTYW4Z-24034 disconnected: Broken pipe.
Feb 08 07:19:51 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376791: New connection from /var/run/mosquitto/mosquitto.sock:0 on port 0.
Feb 08 07:19:51 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376791: New client connected from /var/run/mosquitto/mosquitto.sock:0 as rules-wirenboard-AVZTYW4Z-24034 (p2, c1, k30).
Feb 08 07:20:36 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376836: Client rules-wirenboard-AVZTYW4Z-24034 closed its connection.
Feb 08 07:20:36 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376836: New connection from /var/run/mosquitto/mosquitto.sock:0 on port 0.
Feb 08 07:20:36 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376836: New client connected from /var/run/mosquitto/mosquitto.sock:0 as rules-wirenboard-AVZTYW4Z-24034 (p2, c1, k30).
Feb 08 07:21:26 wirenboard-AVZTYW4Z mosquitto[19175]: 1707376886: Client rules-wirenboard-AVZTYW4Z-24034 closed its connection.

В топиках всех устройств по одному сообщению про offline.
В топике bridge немногие оставшиеся устройства и редкие обновления.
Больше жизни нет.

Нет, стоит true. На что это влияет?

Пока писал опять отвалились устройства. В логах всё похожее. Если нужно что-то проверить - могу по горячим следам.

Целесообразно результаты fuser порт глянуть - ну и определить что ж за процесс.
Ну и сразу ж диагностический архив сделать.

Если еще не перезапускался - то вообще хорошо.

Это процесс z2m. В этот раз в логе нет ничего про MQTT, только “failed to ping”.

# fuser /dev/ttyUSB0
/dev/ttyUSB0:         9780
# ps 9780
  PID TTY      STAT   TIME COMMAND
 9780 ?        Sl    19:17 node index.js

Вот такое ещё замечено, лог чистый.

# systemctl status wb-watch-update.service
● wb-watch-update.service - Wiren Board firmware update service
     Loaded: loaded (/lib/systemd/system/wb-watch-update.service; enabled; vendor preset: enabled)
     Active: active (running) since Mon 2024-02-05 19:51:34 UTC; 2 days ago
   Main PID: 2320 (wb-watch-update)
      Tasks: 3 (limit: 4790)
     Memory: 1.2M
        CPU: 488ms
     CGroup: /system.slice/wb-watch-update.service
             ├─2320 /bin/bash /usr/bin/wb-watch-update
             ├─2992 inotifywait -m -r --exclude (/var/www/uploads/state/|/mnt/data/.wb-update/state/) --event close_write /var/www/uploads/ /mnt/data/.wb-update/
             └─2993 /bin/bash /usr/bin/wb-watch-update

Feb 05 19:51:34 wirenboard-AVZTYW4Z systemd[1]: Started Wiren Board firmware update service.

Диагностический архив собрать не получается.
image

Скорее всего аналогично Задержка обработки событий zigbee2mqtt - #64 от пользователя BrainRoot
Если удалить/отключить сам wb-zigbee2mqtt - как себя ведет?

То есть сам процесс - работает. Судя по тому что после перезапуска процесса - начинает работать - mosquitto внимания не требует, предположительно.

На какой-то из версий прошивок координатора, из старых было такое. Решилось обновлением прошивки.

Можно и из консоли: Создание архива описано в документации.

Сейчас стоит последняя Release Z-Stack_3.x.0_coordinator_20230507 · Koenkk/Z-Stack-firmware · GitHub

Я смутно вспоминаю, что были нарекания на стабильность в z2m 1.35.0 и 1.35.1, но не могу найти подтверждений в чатиках (будь неладен телеграм). На 1.35.2 у меня проблем не было, началось всё после даунгрэйда.

Удалил. Вечер проработало, утром опять все zigbee-устройства недоступны. Load average сильно снизился, 1-2 теперь.

diag_AVZTYW4Z_2024-02-09-15.57.18.zip (244,7 КБ) После удаления и перезапуска.
diag_AVZTYW4Z_2024-02-10-08.58.41.zip (244,9 КБ) Утром.

Ради пробы отключил в z2m Availability. Утром всё равно девайсы недоступны.
diag_AVZTYW4Z_2024-02-11-08.28.08.zip (251,4 КБ)

Нет предположений. Выглядит так как будто координатор перестает отвечать, при этом не пропадая из устройств.

Я вернулся на testing, ничего не изменилось. Видимо просто так совпала проблема с моментом перехода. Простите за беспокойство.

Выключил в z2m и физически примерно 23 устройства. Сеть прожила уже сутки, утром шторы открылись)
Похоже, баг в прошивках после 202312, через какое-то время падают роутеры и сеть рассыпается. Z-Stack_3.x.0 coordinator 20230507 feedback · Issue #439 · Koenkk/Z-Stack-firmware · GitHub

Можете дать wb-cc2652p-flasher возможность прошивки USB-стиков?

wb-cc2652p-flasher — это скрипт, которые делает прошивку модуля удобным, он основан на cc2538-bsl с помощью которого можно шить любые стики.

Я знаю. Но поставить пакет из репы или развлекаться с гитом и питоном - разные вещи по удобству.

Сам файл уже в пакете GitHub - wirenboard/wb-cc2652p-flasher: Python cross-platform script to upload firmware via the serial boot loader onto the CC13xx, CC2538 and CC26xx SoC.

1 Like