Verlust der MQTT-Verbindung - kein Reconnect

[Krystman]

Hi, 

ich bins mal wieder. ;-)

Habe festgestellt, dass die Box irgendwann die Kommunikation via MQTT einstellt und sich nicht wieder verbindet. 

23              **** TINKERFORGE WARP2 Charger V1.0.2-615ea785 ****
24                   352K RAM SYSTEM   272991 HEAP BYTES FREE
24          READY.
708         WARP2 Charger SPIFFS version 1.0.1-613f0f54
2147        Error setting up mDNS responder!
5370        Ethernet started
5371        Ethernet connected
5375        Ethernet MAC: A8:03:2A:31:42:57, IPv4: 192.168.1.60, Full Duplex, 100 Mbps
5376        Ethernet got IP address: 192.168.1.60.
8053        Connecting to MQTT broker
8062        Connected to MQTT session=0 max payload size=30714
33918830    Disconnected from MQTT: Connection aborted (ERR_ABRT) (-13)

Was könnte das Problem sein? Die restlichen Geräte laufen ohne Probleme mit dem Broker.

Grüße

Christoph

Edited October 21, 2021 at 11:56 AM by Krystman
Rechtschreibung

[rtrbt]

Moin,

Kam danach keine Ausgabe mehr oder hast du die Box dann sofort neugestartet o.Ä.?

[Krystman]

vor 13 Minuten schrieb rtrbt:

Moin,

Kam danach keine Ausgabe mehr oder hast du die Box dann sofort neugestartet o.Ä.?

Habe die Box bisher nicht neu gestartet. Im MQTT-Explorer kommen auch keine Nachrichten des Chargers mehr an. 

Log sieht jetzt so aus:

23              **** TINKERFORGE WARP2 Charger V1.0.2-615ea785 ****
24                   352K RAM SYSTEM   272991 HEAP BYTES FREE
24          READY.
708         WARP2 Charger SPIFFS version 1.0.1-613f0f54
2147        Error setting up mDNS responder!
5370        Ethernet started
5371        Ethernet connected
5375        Ethernet MAC: A8:03:2A:31:42:57, IPv4: 192.168.1.60, Full Duplex, 100 Mbps
5376        Ethernet got IP address: 192.168.1.60.
8053        Connecting to MQTT broker
8062        Connected to MQTT session=0 max payload size=30714
33918830    Disconnected from MQTT: Connection aborted (ERR_ABRT) (-13)
63923076    httpd_ws_recv_frame failed to get frame len with 259

 

[rtrbt]

Schick mal auch einen Debug-Report, eventuell steht da noch etwas interessantes drin. Mich wundert, dass keine Ausgaben vom Reconnect kommen.

Edit: Noch eine Frage: passiert das Reproduzierbar oder bisher nur das eine Mal?

[rtrbt]

Falls du das reproduzieren kannst, teste mal bitte mit der angehangenen Firmware. Ich habe kurz die MQTT-Bibliothek aufgebohrt um die Logausgaben von der seriellen Konsole auf das Ereignislog umzubiegen.

Edit: Alte Firmware entfernt.

 

[Krystman]

vor 51 Minuten schrieb rtrbt:

Edit: Noch eine Frage: passiert das Reproduzierbar oder bisher nur das eine Mal?

Das ist bisher schon ein paar Mal passiert. Kann da aber bisher kein Muster erkennen.

Anbei noch das gewünschte LOG.

debug-report-2021-10-21T11-46-42-231Z.json

[Krystman]

Habe versucht die Firmware aufzuspielen. Es wird geschrieben, dass neu gestartet wird. Wird es aber nicht. 

Habe die Box bewusst bisher noch nicht vom Strom genommen. Anbei noch mal ein Log.

23              **** TINKERFORGE WARP2 Charger V1.0.2-615ea785 ****
24                   352K RAM SYSTEM   272991 HEAP BYTES FREE
24          READY.
708         WARP2 Charger SPIFFS version 1.0.1-613f0f54
2147        Error setting up mDNS responder!
5370        Ethernet started
5371        Ethernet connected
5375        Ethernet MAC: A8:03:2A:31:42:57, IPv4: 192.168.1.60, Full Duplex, 100 Mbps
5376        Ethernet got IP address: 192.168.1.60.
8053        Connecting to MQTT broker
8062        Connected to MQTT session=0 max payload size=30714
33918830    Disconnected from MQTT: Connection aborted (ERR_ABRT) (-13)
63923076    httpd_ws_recv_frame failed to get frame len with 259
64778073    httpd_ws_recv_frame failed to get frame len with 259
68194412    httpd_ws_recv_frame failed to get frame len with 259
68550403    httpd_ws_recv_frame failed with -1
68763399    httpd_ws_recv_frame failed with -1
68789407    httpd_ws_recv_frame failed to get frame len with 259
69860399    httpd_ws_recv_frame failed with -1
69942771    chunk index 48824 data 0x3ffb9500 len 1436
69942772    crc of chunk starting at 0x3ffb9648 with len 1108
69942773    chunk index 50260 data 0x3ffb9500 len 1436
69942784    crc of chunk starting at 0x3ffb9500 with len 1436
69942785    chunk index 51696 data 0x3ffb9500 len 4096
69942796    crc of chunk starting at 0x3ffb9500 with len 1548
70049172    chunk index 48824 data 0x3ffb9500 len 1436
70049173    crc of chunk starting at 0x3ffb9648 with len 1108
70049175    chunk index 50260 data 0x3ffb9500 len 4096
70049185    crc of chunk starting at 0x3ffb9500 with len 2984

 

debug-report-2021-10-21T14-17-00-581Z.json

[Krystman]

Hi, 

heute ist es wieder aufgetreten. Die Box hat sich allerdings wieder neu verbunden.

Hatte die Box allerdings bereits gestern Abend einmal rebootet.

Grüße

Christoph

 

debug-report-2021-10-22T06-38-34-433Z.json event-log-2021-10-22T06-38-33-185Z.txt

Edited October 22, 2021 at 06:41 AM by Krystman

[rtrbt]

Moin,

Sorry für die späte Rückmeldung, ich hatte am Freitag einen Blick in die Logs geworfen und dem Problem kurz nachgegangen, hatte aber noch nichts hilfreiches herausgefunden.

Ich gebe dir im Laufe der kommenden Woche nochmal eine Firmware zum Testen, in der Hoffnung, dass wir dann mehr sehen.