Fehlermeldung, was ist das?

Hallo,

habe in letzter Zeit öfter solche Meldungen im Log:

Danach ist dann wieder ne ganze Weile nichts.
Ich glaube das kommt erst seit ich MQTT und das Tasmota Modul nutze.
Kann das daher kommen und was bedeutet es?
Ich habe momentan nur einen Zählerkopf mit ESP am laufen.

Hat keiner eine Idee dazu?

Habe gerade im Logfile gesehen, das da noch andere Meldungen sind.


25.12.2019 05:14:14 | 29047 | WARNING | Server Socket        | Fehler beim Lesen: Das Zeitlimit für die Semaphore wurde erreicht.
25.12.2019 05:26:53 | 29047 | MESSAGE | Server Socket        | Eingehende Verbindung...
25.12.2019 05:28:03 | 29047 | MESSAGE | Server Socket        | Eingehende Verbindung...
25.12.2019 05:33:10 | 29047 | MESSAGE | Server Socket        | Eingehende Verbindung...
25.12.2019 05:34:23 | 29047 | MESSAGE | Server Socket        | Schließe Verbindung...
25.12.2019 05:34:54 | 29047 | MESSAGE | Server Socket        | Eingehende Verbindung...
25.12.2019 05:35:11 | 29047 | MESSAGE | Server Socket        | Eingehende Verbindung...
25.12.2019 05:36:56 | 29047 | MESSAGE | Server Socket        | Eingehende Verbindung...
25.12.2019 05:45:41 | 29047 | WARNING | Server Socket        | Fehler beim Lesen: Das Zeitlimit für die Semaphore wurde erreicht.

Die Messages tauchen in der WebKonsole garnicht auf und die Spalte mit der ID ist da auch nicht.

die ID 29047 ist der Server Socket MQTT.

@ransi: Es gab hier schon ein ähnliches Thema: Server Socket | Fehler beim Lesen: Das Zeitlimit für die Semaphore wurde erreicht / Bisher jedoch mit keinem Ergebnis.

Kann ich das bei mir irgendwie nachstellen?

paresy

Ich wüsste nicht wie man das Nachstellen könnte. Das kommt ja sehr sporadisch.

dann erst wieder

Es fehlen auch Werte im Graphen, ob das zusammenhängt??

Hallo bei mir das selbe, werde mit den Meldungen am Tag tot geschmissen, aber halt sporadisch.
Bei mir sind nie Semaphore Meldungen dabei sondern „nur“:


Das sind jetzt nur 2, eben habe ich rund 40 Stück gelöscht die seid ca 09:00 Uhr heute morgen aufgetreten sind.

Ganz klar ist es der Server Socket vom MQTT Server IO-Instanz.

In derzeit wo ich hier schreibe hat sich die Anzahl schon auf 5 erhöht. Ich habe bedenken ob dadurch nicht auch Informationen die für den Betrieb erforderlich sind verloren gehen.

Gruß Achim

Hallo zusammen,

bei mir reißt die Verbindung auch ab z.T. mehrmals täglich. Da hilft dann nur ein kompletter symcon Service restart.
Ich hatte zuerst alles andere im Verdacht (WLAN, Fritzbox, etc.) aber vorhin hab ich in einem Log dann zum Zeitpunkt des Abbruchs diese Einträge gefunden:
18.02.2020 00:08:20 | 57005 | MESSAGE | Server Socket | Schließe Verbindung…
18.02.2020 00:08:20 | 44444 | MESSAGE | VariableManager | [ESP_STROMZ\status\LWT\Value] = Connection Lost
18.02.2020 00:08:20 | 57005 | MESSAGE | Server Socket | Eingehende Verbindung…
18.02.2020 00:08:20 | 57005 | MESSAGE | Server Socket | Schließe Verbindung…

Dann kommen aber komischerweise nochmal ein paar neue Werte

18.02.2020 00:08:21 | 26306 | MESSAGE | VariableManager | [ESP_STROMZ\Stromverbrauch EG\Verbrauch Tag] = 0,0120000000
18.02.2020 00:08:21 | 44135 | MESSAGE | VariableManager | [ESP_STROMZ\Stromverbrauch EG\Verbrauch aktuell] = 36,0327898388


18.02.2020 00:08:35 | 57005 | MESSAGE | Server Socket | Eingehende Verbindung…
18.02.2020 00:08:35 | 57005 | MESSAGE | Server Socket | Schließe Verbindung…

18.02.2020 00:08:35 | 57005 | MESSAGE | Server Socket | Eingehende Verbindung…
18.02.2020 00:08:35 | 57005 | MESSAGE | Server Socket | Schließe Verbindung…

und dann ist es vorbei mit dem Befallen der Variablen. Der Verbindungsaufbau und Abbau wird zwar alle 30 Sekunden wiederholt, aber keine Daten mehr übertragen.
18.02.2020 00:09:05 | 57005 | MESSAGE | Server Socket | Eingehende Verbindung…
18.02.2020 00:09:05 | 57005 | MESSAGE | Server Socket | Schließe Verbindung…
18.02.2020 00:09:05 | 57005 | MESSAGE | Server Socket | Eingehende Verbindung…
18.02.2020 00:09:05 | 57005 | MESSAGE | Server Socket | Schließe Verbindung…

Als Client läuft ein ESP8266 Modul das die Werte von ein paar S0-Stromzählern an Symcon übermittelt. D.h. insgesamt 12 Variablen die dann über Scripts als Verbrauchswerte umgerechnet und zum Teil als Graphen visualisiert werden.

Was mir noch aufgefallen ist:
Kurz vorher gab es eine Aufräumt-Aktion
18.02.2020 00:07:41 | 00000 | MESSAGE | Settings | Erstelle Backup der Einstellungen nach Mitternacht…
18.02.2020 00:07:41 | 00000 | MESSAGE | Settings | Aufräumen des Backup Ordners…

und kurz nach dem Abbruch hat sich der Connect-Control neu verbunden
18.02.2020 00:08:50 | 40925 | MESSAGE | Connect Control | [5] Neuer Kanal erstellt
18.02.2020 00:08:50 | 40925 | MESSAGE | Connect Control | [5] Verbinde mit 127.0.0.1:3777…
18.02.2020 00:08:50 | 40925 | MESSAGE | Connect Control | [5] Verbunden mit lokalen Server
18.02.2020 00:08:50 | 40925 | MESSAGE | Connect Control | [5] Lese entfernte Daten… 197 bytes

Mal sehen ob das beim nächsten Abbruch ähnlich abläuft, jetzt weiß ich zumindest wo ich gucken muss :slight_smile:

Viele Grüße
Chris