ERROR: [wbgo_mqtt] MQTT token wait timeout: *mqtt.SubscribeToken

1
27-11-2023 15:40:22.047 [wb-rules] ERROR: [wbgo_mqtt] MQTT token wait timeout: *mqtt.SubscribeToken (&{{{{0 0} 0 0 0 0} 0xd037e00 } [zigbee2mqtt/черный 2] map[] 43337})
27-11-2023 15:40:12.035 [wb-rules] ERROR: [wbgo_mqtt] MQTT token wait timeout: *mqtt.SubscribeToken (&{{{{0 0} 0 0 0 0} 0xd155480 } [zigbee2mqtt/черный 1] map[] 43336})

теперь такие ошибки с зигби устроиств

3

Добрый день.
Давайте попробуем разобраться с данной проблемой в отдельной теме.
Серийный номер контроллера: ALYNHADY.
Контроллер: rev. 7.3.3.
Пришлите диагностический архив. Укажите, какие zigbee-устройства у вас сконфигурированы.

4

configuration_1.yml (1,9 КБ)
zigbee файл конфигурации прикладываю

приложен диагностический архив, доступен только сотрудникам поддержки
(284,7 КБ)

и диагностический архив

6

все началось с подключения датчика пристутствия который шлет информацию ежесекундно.
была создана соответствующая тема.
посоветовали настроить логи только по ошибкам - настроил
начали валится переполнения в /etc/wb-mqtt-db.conf поставил 1 000 000 вместо 100 000.

какие то нехватки памяти начались

7

Пришлите лог zigbee2mqtt.service

8

а где его искать?

9

Думаю можно из веб-интерфейса с помощью инструмента “Системный журнал”.

10

Снова баг переформулирую.

Предусловие:
WB на 1 порт 485 навешано все что можно
на второй порт один электрощетчик Меркурий который шлет
в Канал свою информацию “/devices/mercury230ar02_tariff_60/controls/Всего потреблено” к примеру

Шаги воспроизведения:
перегрузить WB
подождать пару дней.

меркурий будет продолжать слать свои данные, а вот с зигби устройства начнут притормаживать или в WB интерфейсах данные отсутствуют (пример панель dashboards/svg). причем в интерфейсе Zigbee2MQTT все бегает хорошо.(Версия Zigbee2MQTT 1.34.0 свежая)

идем в логи:
видим кучу сообщений с типом " token wait timeout"
10-12-2023 00:03:39.822 [wb-rules] ERROR: [wbgo_mqtt] MQTT token wait timeout: *mqtt.SubscribeToken (&{{{{0 0} 0 0 0 0} 0x12ec43c0 } [zigbee2mqtt/Датчик движения] map[] 609})

помогает рестарт правил service wb-rules restart и снова датчики значения начинают присылать

diag_output_ALYNHADY_2023-12-10-00.17.18.zip (360,3 КБ)
.

12 
10-12-2023 13:46:03.369	ERROR: [wbgo_mqtt] MQTT error: connection lost before Subscribe completed
10-12-2023 13:46:03.368	ERROR: [wbgo_mqtt] MQTT error: connection lost before Subscribe completed
10-12-2023 13:46:03.367	ERROR: [wbgo_mqtt] MQTT error: connection lost before Subscribe completed
10-12-2023 13:46:03.366	ERROR: [wbgo_mqtt] MQTT error: connection lost before Subscribe completed
10-12-2023 13:46:03.365	ERROR: [wbgo_mqtt] MQTT error: connection lost before Subscribe completed
10-12-2023 13:46:03.350	ERROR: [wbgo_mqtt] MQTT error: connection lost before Subscribe completed
10-12-2023 13:46:03.350	ERROR: [wbgo_mqtt] MQTT error: connection lost before Subscribe completed
10-12-2023 13:46:03.347	WARNING: [wbgo_mqtt] Cleaning up token queue
10-12-2023 13:46:03.344	WARNING: [wbgo_mqtt] MQTT connection lost: pingresp not received, disconnecting
10-12-2023 13:45:55.250	ERROR: [wbgo_mqtt] MQTT token wait timeout: *mqtt.SubscribeToken (&{{{{0 0} 0 0 0 0} 0x507d640 <nil>} [zigbee2mqtt/Кран] map[] 11634})
10-12-2023 13:45:45.249	ERROR: [wbgo_mqtt] MQTT token wait timeout: *mqtt.SubscribeToken (&{{{{0 0} 0 0 0 0} 0x507d3c0 <nil>} [zigbee2mqtt/Соноф 3] map[] 11633})
10-12-2023 13:45:35.224	ERROR: [wbgo_mqtt] MQTT token wait timeout: *mqtt.SubscribeToken (&{{{{0 0} 0 0 0 0} 0x507d140 <nil>} [zigbee2mqtt/Соноф 1] map[] 11632})
10-12-2023 13:45:25.223	ERROR: [wbgo_mqtt] MQTT token wait timeout: *mqtt.SubscribeToken (&{{{{0 0} 0 0 0 0} 0x507ccc0 <nil>} [zigbee2mqtt/Датчик движения] map[] 11631})
10-12-2023 13:45:15.222	ERROR: [wbgo_mqtt] MQTT token wait timeout: *mqtt.SubscribeToken (&{{{{0 0} 0 0 0 0} 0x507ca40 <nil>} [zigbee2mqtt/Темп и Влажность с Дисплеем] map[] 11630})
10-12-2023 13:45:05.219	ERROR: [wbgo_mqtt] MQTT token wait timeout: *mqtt.SubscribeToken (&{{{{0 0} 0 0 0 0} 0x507c640 <nil>} [zigbee2mqtt/Темп и влажность] map[] 11629})
10-12-2023 13:44:47.095	INFO: [wbgo_mqtt] wb-rules-engine-wirenboard-ALYNHADY-27903: MQTT connection established
10-12-2023 13:44:47.095	INFO: [wbgo_mqtt] wb-rules-engine-wirenboard-ALYNHADY-27903: MQTT connection established
10-12-2023 13:44:47.062	WARNING: [wbgo_mqtt] Cleaning up token queue
10-12-2023 13:44:47.059	WARNING: [wbgo_mqtt] MQTT connection lost: pingresp not received, disconnecting
10-12-2023 13:43:46.123	ERROR: [wbgo_mqtt] MQTT token wait timeout: *mqtt.SubscribeToken (&{{{{0 0} 0 0 0 0} 0x3d9c300 <nil>} [zigbee2mqtt/Темп и влажность] map[] 10961})
10-12-2023 13:43:34.484	INFO: [wbgo_mqtt] wb-rules-engine-wirenboard-ALYNHADY-27903: MQTT connection established
10-12-2023 13:43:34.474	WARNING: [wbgo_mqtt] Cleaning up token queue
10-12-2023 13:43:34.470	WARNING: [wbgo_mqtt] MQTT connection lost: pingresp not received, disconnecting
10-12-2023 13:42:22.336	WARNING: [wbgo_mqtt] Cleaning up token queue
10-12-2023 13:42:22.128	INFO: [wbgo_mqtt] wb-rules-engine-wirenboard-ALYNHADY-27903: MQTT connection established
10-12-2023 13:42:22.113	WARNING: [wbgo_mqtt] MQTT connection lost: pingresp not received, disconnecting
10-12-2023 13:42:22.113	WARNING: [wbgo_mqtt] MQTT connection lost: pingresp not received, disconnecting
10-12-2023 13:41:11.817	INFO: [wbgo_mqtt] wb-rules-engine-wirenboard-ALYNHADY-27903: MQTT connection established
10-12-2023 13:41:11.813	WARNING: [wbgo_mqtt] Cleaning up token queue
10-12-2023 13:41:11.801	WARNING: [wbgo_mqtt] MQTT connection lost: pingresp not received, disconnecting
10-12-2023 13:40:18.244	ERROR: [wbgo_mqtt] MQTT token wait timeout: *mqtt.SubscribeToken (&{{{{0 0} 0 0 0 0} 0x3a3dd40 <nil>} [zigbee2mqtt/Темп и влажность] map[] 9097})
10-12-2023 13:40:06.116	INFO: [wbgo_mqtt] wb-rules-engine-wirenboard-ALYNHADY-27903: MQTT connection established
10-12-2023 13:40:06.101	WARNING: [wbgo_mqtt] Cleaning up token queue
10-12-2023 13:40:06.098	WARNING: [wbgo_mqtt] MQTT connection lost: pingresp not received, disconnecting
10-12-2023 13:39:04.662	INFO: [wbgo_mqtt] wb-rules-engine-wirenboard-ALYNHADY-27903: MQTT connection established
10-12-2023 13:39:04.661	WARNING: [wbgo_mqtt] Cleaning up token queue
10-12-2023 13:39:04.661	WARNING: [wbgo_mqtt] Cleaning up token queue
10-12-2023 13:39:04.654	WARNING: [wbgo_mqtt] MQTT connection lost: pingresp not received, disconnecting
10-12-2023 13:38:06.494	INFO: [wbgo_mqtt] wb-rules-engine-wirenboard-ALYNHADY-27903: MQTT connection established
10-12-2023 13:38:06.486	WARNING: [wbgo_mqtt] Cleaning up token queue
13

апну тему

16

Покажите пожалуйста - как воспроизвести.

17

в том то и дело что нет шагов воспроизведения. перегружаешь контроллер и через сутки получаешь зависшие правила

image

в разделе правил нет ничего когда он правила зависает.

по факту в правилах только телега. остальные в тексте скрипты /* как примечания */ закрыты

остался один почти стандартный скрипт с телегой. GitHub - aadegtyarev/telegram2wb: Телеграм-бот на wb-rules

слегка доработанный на вывод температуры. он вполне работает когда правила перегрузить.

18

Я кажется воспроизвел.
Отдам программистам.

19
29-12-2023 12:31:48.034 [wb-rules] WARNING: [wbgo_mqtt] Cleaning up token queue
29-12-2023 12:31:48.030 [wb-rules] WARNING: [wbgo_mqtt] MQTT connection lost: pingresp not received, disconnecting
29-12-2023 12:34:30.388 [wb-rules] WARNING: [wbgo_mqtt] Cleaning up token queue
29-12-2023 12:34:30.387 [wb-rules] INFO: [wbgo_mqtt] wb-rules-engine-wirenboard-ALYNHADY-1966: MQTT connection established
29-12-2023 12:34:30.386 [mosquitto] 1703842470: New client connected from /var/run/mosquitto/mosquitto.sock:0 as wb-rules-engine-wirenboard-ALYNHADY-1966 (p2, c1, k30).
29-12-2023 12:34:30.382 [mosquitto] 1703842470: New connection from /var/run/mosquitto/mosquitto.sock:0 on port 0.
29-12-2023 12:34:30.378 [wb-rules] WARNING: [wbgo_mqtt] MQTT connection lost: pingresp not received, disconnecting

проблемы продолжаются.

20

Добрый день.
По данной проблеме оформлен багрепорт. Программисты занимаются. Есть определенные проблемы при работе с zigbee2mqtt. Как сказал коллега в одной из схожих тем: “скорее всего починка сведется к переписыванию wb-zigbee2mqtt с нуля”.

21

я думал я один такой и это связано с датчиками присутствия. Спасибо ждем решения проблемы

22

А еще - совершенно аналогочное выводится при потере связи с брокером:

Dec 29 13:14:48 wirenboard-AWWCDXFH wb-rules[2549]: ERROR: [wbgo_mqtt] MQTT token wait timeout: *mqtt.PublishToken (&{{{{0 0} 0 0 0 0} 0xa86040 <nil>} 1640})
Dec 29 13:14:58 wirenboard-AWWCDXFH wb-rules[2549]: ERROR: [wbgo_mqtt] MQTT token wait timeout: *mqtt.PublishToken (&{{{{0 0} 0 0 0 0} 0xa86480 <nil>} 1641})
1 лайк
23
29-12-2023 16:27:29.602 [wb-rules] ERROR: [wbgo_mqtt] MQTT token wait timeout: *mqtt.SubscribeToken (&{{{{0 0} 0 0 0 0} 0x2297240 } [zigbee2mqtt/черный 1] map[] 7952})
29-12-2023 16:27:19.600 [wb-rules] ERROR: [wbgo_mqtt] MQTT token wait timeout: *mqtt.SubscribeToken (&{{{{0 0} 0 0 0 0} 0x2297200 } [zigbee2mqtt/черный 1] map[] 7951})
29-12-2023 16:27:06.073 [wb-rules] ERROR: [wbgo_mqtt] MQTT token wait timeout: *mqtt.SubscribeToken (&{{{{0 0} 0 0 0 0} 0x7aa7b80 } [zigbee2mqtt/Aubess 1] map[] 7368})

есть и такие да

24

проблема остается

25

Какая версия wb-zigbee2mqtt?