Autor Thema: MQTT: disconnected, waiting to reappear  (Gelesen 101 mal)

Offline PatrickR

  • Developer
  • Sr. Member
  • ****
  • Beiträge: 629
MQTT: disconnected, waiting to reappear
« am: 14 Februar 2019, 20:57:29 »
Mahlzeit!

In letzter Zeit habe ich gehäuft folgendes Problem:
2019.02.13 22:10:05.276 3: Opening MQTTBroker device proliantg8:1883
2019.02.13 22:10:05.284 3: MQTTBroker device opened
2019.02.13 22:10:06.074 1: proliantg8:1883 disconnected, waiting to reappear (MQTTBroker)
2019.02.13 22:10:06.279 1: proliantg8:1883 reappeared (MQTTBroker)
2019.02.13 22:10:07.957 1: proliantg8:1883 disconnected, waiting to reappear (MQTTBroker)
2019.02.13 22:10:08.009 1: proliantg8:1883 reappeared (MQTTBroker)
2019.02.13 22:10:09.052 1: proliantg8:1883 disconnected, waiting to reappear (MQTTBroker)
2019.02.13 22:10:09.075 1: proliantg8:1883 reappeared (MQTTBroker)
Das Problem tritt häufig aber nicht reproduzierbar beim Start von FHEM auf und lässt sich durch set disconnect; set connect nicht beheben. Nur shutdown restart hilft. Diverse andere MQTT-Clients (nodered, ESPs etc.) haben eine stabile Verbindung zu mosquitto. Auf Logleveln <= 4 schweigt sich MQTT bis auf die obigen Meldungen aus, auf verbose 5 ergibt sich folgendes Bild:

2019.02.13 22:21:00.042 1: proliantg8:1883 disconnected, waiting to reappear (MQTTBroker)
2019.02.13 22:21:00.055 5: MQTT MQTTBroker message sent: Connect/at-most-once MQIsdp/3/Net::MQTT::Message[15] user=fhem pass=nix will=services/fhem/fhem/status,"disconnected",1,at-most-once
2019.02.13 22:21:00.060 5: MQTT MQTTBroker message sent: PingReq/at-most-once
2019.02.13 22:21:00.061 1: proliantg8:1883 reappeared (MQTTBroker)
2019.02.13 22:21:00.069 5: MQTT MQTTBroker message sent: Publish/at-most-once,retain services/fhem/fhem/status
2019.02.13 22:21:00.071 5: MQTT MQTTBroker message sent: Subscribe/at-least-once 2577 house/garage/garagedoor/+/at-most-once,house/garage/garagedoor/button/at-most-once,house/garage/garagedoor/esp-resetexccause/at-most-once,house/garage/garagedoor/esp-resetreason/at-most-once,house/garage/garagedoor/esp-state/at-most-once,house/garage/garagedoor/esp-version/at-most-once
2019.02.13 22:21:00.078 5: MQTT MQTTBroker message sent: Subscribe/at-least-once 2578 house/vr100-2/+/at-most-once,house/vr100-2/R-C-BatteryFailure/at-most-once,house/vr100-2/R-C-BatteryOverTemp/at-most-once,house/vr100-2/R-C-Charger_mAH/at-most-once,house/vr100-2/R-C-ChargingActive/at-most-once,house/vr100-2/R-C-ConfidentOnFuel/at-most-once,house/vr100-2/R-C-EmptyFuel/at-most-once,house/vr100-2/R-C-ExtPwrPresent/at-most-once,house/vr100-2/R-C-FuelPercent/at-most-once,house/vr100-2/R-C-LithiumChargeDone/at-most-once,house/vr100-2/R-C-LithiumChargeEnabled/at-most-once,house/vr100-2/R-C-OnReserveFuel/at-most-once,house/vr100-2/R-C-VBattV/at-most-once,house/vr100-2/R-E-Error/at-most-once,house/vr100-2/R-M-Brush_RPM/at-most-once,house/vr100-2/R-M-Laser_RPM/at-most-once,house/vr100-2/R-M-LeftWheel_RPM/at-most-once,house/vr100-2/R-M-RightWheel_RPM/at-most-once,house/vr100-2/R-M-Vacuum_RPM/at-most-once,house/vr100-2/R-X-RobotState/at-most-once,house/vr100-2/command/at-most-once,house/vr100-2/esp-boottime/at-most-once,house/vr100-2/esp-command/at-most-once,house/vr100-2/esp-connecttime/at-most-once,house/vr100-2/esp-debug/at-most-once,house/vr100-2/esp-resetexccause/at-most-once,house/vr100-2/esp-resetreason/at-most-once,house/vr100-2/esp-state/at-most-once,house/vr100-2/esp-version/at-most-once,house/vr100-2/rawcommand/at-most-once
2019.02.13 22:21:00.084 5: MQTT MQTTBroker message sent: Subscribe/at-least-once 2579 house/vr100/+/at-most-once,house/vr100/R-C-BatteryFailure/at-most-once,house/vr100/R-C-BatteryOverTemp/at-most-once,house/vr100/R-C-Charger_mAH/at-most-once,house/vr100/R-C-ChargingActive/at-most-once,house/vr100/R-C-ConfidentOnFuel/at-most-once,house/vr100/R-C-EmptyFuel/at-most-once,house/vr100/R-C-ExtPwrPresent/at-most-once,house/vr100/R-C-FuelPercent/at-most-once,/at-most-once,house/vr100/R-C-LithiumChargeDone/at-most-once,house/vr100/R-C-LithiumChargeEnabled/at-most-once,house/vr100/R-C-OnReserveFuel/at-most-once,house/vr100/R-C-VBattV/at-most-once,house/vr100/R-E-Error/at-most-once,house/vr100/R-M-Brush_RPM/at-most-once,house/vr100/R-M-Laser_RPM/at-most-once,house/vr100/R-M-LeftWheel_RPM/at-most-once,house/vr100/R-M-RightWheel_RPM/at-most-once,house/vr100/R-M-Vacuum_RPM/at-most-once,house/vr100/R-X-RobotState/at-most-once,house/vr100/command/at-most-once,house/vr100/esp-boottime/at-most-once,house/vr100/esp-command/at-most-once,house/vr100/esp-connecttime/at-most-once,house/vr100/esp-debug/at-most-once,house/vr100/esp-resetexccause/at-most-once,house/vr100/esp-resetreason/at-most-once,house/vr100/esp-state/at-most-once,house/vr100/esp-version/at-most-once,house/vr100/rawcommand/at-most-once
2019.02.13 22:21:00.090 5: MQTT MQTTBroker message sent: Subscribe/at-least-once 2580 house/cellar/gamingpc/+/at-most-once,house/cellar/gamingpc/button/at-most-once,house/cellar/gamingpc/esp-resetexccause/at-most-once,house/cellar/gamingpc/esp-resetreason/at-most-once,house/cellar/gamingpc/esp-state/at-most-once,house/cellar/gamingpc/esp-version/at-most-once,house/cellar/gamingpc/led/at-most-once
2019.02.13 22:21:00.878 5: MQTT MQTTBroker message sent: Publish/at-most-once,retain services/fhem/UG.FL.Thermostat/0.RSSI_DEVICE
2019.02.13 22:21:01.002 1: proliantg8:1883 disconnected, waiting to reappear (MQTTBroker)
Die SW-Einträge habe ich der Übersichtlichkeit halber rausgefiltert.

Patrick
lepresenced - Tracking von Bluetooth-LE-Tags (Gigaset G-Tag) mittels PRESENCE

"Programming today is a race between software engineers striving to build bigger and better idiot-proof programs, and the universe trying to produce bigger and better idiots. So far, the universe is winning." - Rich Cook

 

decade-submarginal