Nur Text | Text mit Bildern

FHEM Forum

FHEM - Hausautomations-Systeme => Homematic => Thema gestartet von: markus_e am 26 September 2018, 02:57:24

Titel: HM-LGW reconnected nicht automatisch nach Stromausfall
Beitrag von: markus_e am 26 September 2018, 02:57:24
Ich benutze ein HMLan gateway (HM-LGW) mit dem Modul HMUARTLGW in fhem.
Immer wenn das HM-LGW neu startet, z.b. nach Stromausfall, (der fhem raspi dagegen ist USV-gepuffert), dann verbindet sich fhem  nicht automatisch neu zum Lan Gateway, sondern das HM-LGW bleibt in fhem auf status "disconnected". Wenn ich dann manuell im fhem beim HM-LGW auf "reopen" klicke, verbindet sich fhem sofort wieder.
Ich habe mal irgendwo gelesen dass es daran liegt, dass beim Neustart des HM-LGW die TCP Verbindungen verlorengehen und neu geöffnet werden müssen. Jetzt die Frage: wie kann man das am einfachsten automatisch machen, so daß z.B. wenn das reading "cond" nicht auf "ok" steht, alle 5 Minuten ein reopen versucht wird?

danke euch im voraus! grüße
Titel: Antw:HM-LGW reconnected nicht automatisch nach Stromausfall
Beitrag von: pc1246 am 26 September 2018, 09:44:46
Moin
Und herzlich willkommen im Forum. Du solltest das in den Anfaengerbereich verschieben, da kein HM-Problem! Als Loesung empfehle ich dir at, notify oder DOIF. Wobei keine Wertung in der Reihenfolge liegt!
Gruss Christoph
Titel: Antw:HM-LGW reconnected nicht automatisch nach Stromausfall
Beitrag von: Beta-User am 26 September 2018, 10:31:05
Auch von mir ein Willkommen im Forum.

Ist das die aktuelle Version von HMUARTLGW?

(Ich meine mich erinnern zu können, dass da evtl. was geändert worden ist die letzten Monate, oder auch an einem anderen HM-Modul).

An sich halte ich das nicht-Reopen für eine Sache, die man innerhalb des Moduls lösen sollte, daher bin ich nicht sicher, ob das mit dem Verschieben eine gute Idee ist.

Das mit dem at usw. ist m.E. nur ein Workaround um ein generelles Problem (so es noch besteht).

Just my2ct.

Beta-User
Titel: Antw:HM-LGW reconnected nicht automatisch nach Stromausfall
Beitrag von: frank am 26 September 2018, 11:27:01
sind denn die beiden fw des hmlgw korrekt?
Titel: Antw:HM-LGW reconnected nicht automatisch nach Stromausfall
Beitrag von: markus_e am 26 September 2018, 14:14:46
erstmal danke für Eure Antworten!
ein update von fhem hatte ich vor ein paar tagen erst gemacht.
Die HMUARTLGW version ist: 00_HMUARTLGW.pm 16166 2018-02-13 19:52:08

Die HM LGW firmwares sind:

LANfirmware   1.1.5
firmware  1.4.1

Es fällt auf, daß nach 20:07 Uhr, als der Stromausfall schon  vorbei war, die Verbindung zum LGW wieder kam, aber immer wieder abgebrochen und neu aufgebaut wurde, und um 20:51 die Versuche scheinbar aufgegeben wurden. Es wurden zwischen 20:07 und 20:51 auch einige Daten korrekt per funk empfangen.

Hier mal die Log Einträge von Sonntag als der Sturm über unseren Ort hereinbrach:
Code Auswählen

2018.09.23 18:10:49 1: HMUARTLGW HMLAN1:keepAlive did not respond after all, reopening
2018.09.23 18:10:49 3: HMLAN1 device closed
2018.09.23 18:10:49 3: Opening HMLAN1:keepAlive device 192.168.4.6:2001
2018.09.23 18:10:49 1: 192.168.4.6:2000 reappeared (HMLAN1)
2018.09.23 18:10:49 3: HMUARTLGW HMLAN1 BidCoS-port opened
2018.09.23 18:10:50 3: HMLAN1:keepAlive device opened
2018.09.23 18:10:50 3: HMUARTLGW HMLAN1:keepAlive KeepAlive-port opened
2018.09.23 18:16:44 1: HMUARTLGW HMLAN1:keepAlive did not respond after all, reopening
2018.09.23 18:16:44 3: HMLAN1 device closed


danach keine Einträge mehr vom LGW, bis der Strom wieder kam:

Code Auswählen

2018.09.23 20:07:28 3: Opening HMLAN1:keepAlive device 192.168.4.6:2001
2018.09.23 20:07:28 1: 192.168.4.6:2000 reappeared (HMLAN1)
2018.09.23 20:07:28 3: HMUARTLGW HMLAN1 BidCoS-port opened
2018.09.23 20:07:28 3: HMLAN1:keepAlive device opened
2018.09.23 20:07:28 3: HMUARTLGW HMLAN1:keepAlive KeepAlive-port opened
2018.09.23 20:13:27 1: HMUARTLGW HMLAN1:keepAlive KeepAlive sent 37.179s too late, this might cause a disconnect!
2018.09.23 20:13:27 1: 192.168.4.6:2000 disconnected, waiting to reappear (HMLAN1)
2018.09.23 20:13:27 1: 192.168.4.6:2001 disconnected, waiting to reappear (HMLAN1:keepAlive)
2018.09.23 20:13:27 3: Opening HMLAN1:keepAlive device 192.168.4.6:2001
2018.09.23 20:13:27 1: 192.168.4.6:2000 reappeared (HMLAN1)
2018.09.23 20:13:27 3: HMUARTLGW HMLAN1 BidCoS-port opened
2018.09.23 20:13:27 3: HMLAN1:keepAlive device opened
2018.09.23 20:13:27 3: HMUARTLGW HMLAN1:keepAlive KeepAlive-port opened
2018.09.23 20:14:13 1: HMUARTLGW HMLAN1:keepAlive KeepAlive sent 34.905s too late, this might cause a disconnect!
2018.09.23 20:14:13 1: 192.168.4.6:2001 disconnected, waiting to reappear (HMLAN1:keepAlive)
2018.09.23 20:14:13 1: 192.168.4.6:2000 disconnected, waiting to reappear (HMLAN1)
2018.09.23 20:14:13 3: Opening HMLAN1:keepAlive device 192.168.4.6:2001
2018.09.23 20:14:13 1: 192.168.4.6:2000 reappeared (HMLAN1)
2018.09.23 20:14:13 3: HMLAN1:keepAlive device opened
2018.09.23 20:14:13 3: HMUARTLGW HMLAN1 BidCoS-port opened
2018.09.23 20:14:13 3: HMUARTLGW HMLAN1:keepAlive KeepAlive-port opened
2018.09.23 20:17:11 1: HMUARTLGW HMLAN1:keepAlive KeepAlive sent 36.862s too late, this might cause a disconnect!
2018.09.23 20:17:11 1: 192.168.4.6:2001 disconnected, waiting to reappear (HMLAN1:keepAlive)
2018.09.23 20:17:11 1: 192.168.4.6:2000 disconnected, waiting to reappear (HMLAN1)
2018.09.23 20:17:11 3: Opening HMLAN1:keepAlive device 192.168.4.6:2001
2018.09.23 20:17:11 1: 192.168.4.6:2000 reappeared (HMLAN1)
2018.09.23 20:17:11 3: HMUARTLGW HMLAN1 BidCoS-port opened
2018.09.23 20:17:11 3: HMLAN1:keepAlive device opened
2018.09.23 20:17:11 3: HMUARTLGW HMLAN1:keepAlive KeepAlive-port opened
2018.09.23 20:17:57 1: HMUARTLGW HMLAN1:keepAlive KeepAlive sent 34.354s too late, this might cause a disconnect!
2018.09.23 20:17:57 1: 192.168.4.6:2000 disconnected, waiting to reappear (HMLAN1)
2018.09.23 20:17:57 1: 192.168.4.6:2001 disconnected, waiting to reappear (HMLAN1:keepAlive)
2018.09.23 20:17:57 3: Opening HMLAN1:keepAlive device 192.168.4.6:2001
2018.09.23 20:17:57 1: 192.168.4.6:2000 reappeared (HMLAN1)
2018.09.23 20:17:57 3: HMUARTLGW HMLAN1 BidCoS-port opened
2018.09.23 20:17:57 3: HMLAN1:keepAlive device opened
2018.09.23 20:17:57 3: HMUARTLGW HMLAN1:keepAlive KeepAlive-port opened
2018.09.23 20:23:37 1: 192.168.4.6:2001 disconnected, waiting to reappear (HMLAN1:keepAlive)
2018.09.23 20:23:37 1: HMUARTLGW HMLAN1:keepAlive KeepAlive sent 38.697s too late, this might cause a disconnect!
2018.09.23 20:23:37 1: 192.168.4.6:2000 disconnected, waiting to reappear (HMLAN1)
2018.09.23 20:23:37 3: Opening HMLAN1:keepAlive device 192.168.4.6:2001
2018.09.23 20:23:37 1: 192.168.4.6:2000 reappeared (HMLAN1)
2018.09.23 20:23:37 3: HMLAN1:keepAlive device opened
2018.09.23 20:23:37 3: HMUARTLGW HMLAN1 BidCoS-port opened
2018.09.23 20:23:37 3: HMUARTLGW HMLAN1:keepAlive KeepAlive-port opened
2018.09.23 20:24:52 1: HMUARTLGW HMLAN1:keepAlive KeepAlive sent 33.904s too late, this might cause a disconnect!
2018.09.23 20:24:52 1: 192.168.4.6:2001 disconnected, waiting to reappear (HMLAN1:keepAlive)
2018.09.23 20:24:52 1: 192.168.4.6:2000 disconnected, waiting to reappear (HMLAN1)
2018.09.23 20:24:52 3: Opening HMLAN1:keepAlive device 192.168.4.6:2001
2018.09.23 20:24:52 1: 192.168.4.6:2000 reappeared (HMLAN1)
2018.09.23 20:24:52 3: HMUARTLGW HMLAN1 BidCoS-port opened
2018.09.23 20:24:52 3: HMLAN1:keepAlive device opened
2018.09.23 20:24:52 3: HMUARTLGW HMLAN1:keepAlive KeepAlive-port opened
2018.09.23 20:27:28 1: 192.168.4.6:2000 disconnected, waiting to reappear (HMLAN1)
2018.09.23 20:27:28 1: 192.168.4.6:2001 disconnected, waiting to reappear (HMLAN1:keepAlive)
2018.09.23 20:27:28 3: Opening HMLAN1:keepAlive device 192.168.4.6:2001
2018.09.23 20:27:28 1: 192.168.4.6:2000 reappeared (HMLAN1)
2018.09.23 20:27:28 3: HMLAN1:keepAlive device opened
2018.09.23 20:27:28 3: HMUARTLGW HMLAN1 BidCoS-port opened
2018.09.23 20:27:28 3: HMUARTLGW HMLAN1:keepAlive KeepAlive-port opened
2018.09.23 20:30:32 1: 192.168.4.6:2001 disconnected, waiting to reappear (HMLAN1:keepAlive)
2018.09.23 20:30:32 1: 192.168.4.6:2000 disconnected, waiting to reappear (HMLAN1)
2018.09.23 20:30:32 3: Opening HMLAN1:keepAlive device 192.168.4.6:2001
2018.09.23 20:30:32 1: 192.168.4.6:2000 reappeared (HMLAN1)
2018.09.23 20:30:32 3: HMLAN1:keepAlive device opened
2018.09.23 20:30:32 3: HMUARTLGW HMLAN1 BidCoS-port opened
2018.09.23 20:30:32 3: HMUARTLGW HMLAN1:keepAlive KeepAlive-port opened
2018.09.23 20:33:08 1: 192.168.4.6:2001 disconnected, waiting to reappear (HMLAN1:keepAlive)
2018.09.23 20:33:08 1: HMUARTLGW HMLAN1:keepAlive KeepAlive sent 34.873s too late, this might cause a disconnect!
2018.09.23 20:33:08 1: 192.168.4.6:2000 disconnected, waiting to reappear (HMLAN1)
2018.09.23 20:33:08 3: Opening HMLAN1:keepAlive device 192.168.4.6:2001
2018.09.23 20:33:08 1: 192.168.4.6:2000 reappeared (HMLAN1)
2018.09.23 20:33:08 3: HMUARTLGW HMLAN1 BidCoS-port opened
2018.09.23 20:33:08 3: HMLAN1:keepAlive device opened
2018.09.23 20:33:08 3: HMUARTLGW HMLAN1:keepAlive KeepAlive-port opened
2018.09.23 20:38:34 1: HMUARTLGW HMLAN1:keepAlive KeepAlive sent 35.260s too late, this might cause a disconnect!
2018.09.23 20:39:12 1: 192.168.4.6:2001 disconnected, waiting to reappear (HMLAN1:keepAlive)
2018.09.23 20:39:12 1: 192.168.4.6:2000 disconnected, waiting to reappear (HMLAN1)
2018.09.23 20:39:12 3: Opening HMLAN1:keepAlive device 192.168.4.6:2001
2018.09.23 20:39:12 1: 192.168.4.6:2000 reappeared (HMLAN1)
2018.09.23 20:39:12 3: HMUARTLGW HMLAN1 BidCoS-port opened
2018.09.23 20:39:12 3: HMLAN1:keepAlive device opened
2018.09.23 20:39:12 3: HMUARTLGW HMLAN1:keepAlive KeepAlive-port opened
2018.09.23 20:42:54 1: HMUARTLGW HMLAN1:keepAlive KeepAlive sent 9.889s too late, this might cause a disconnect!
2018.09.23 20:42:54 1: 192.168.4.6:2001 disconnected, waiting to reappear (HMLAN1:keepAlive)
2018.09.23 20:42:54 1: 192.168.4.6:2000 disconnected, waiting to reappear (HMLAN1)
2018.09.23 20:42:54 3: Opening HMLAN1:keepAlive device 192.168.4.6:2001
2018.09.23 20:42:54 1: 192.168.4.6:2000 reappeared (HMLAN1)
2018.09.23 20:42:54 3: HMLAN1:keepAlive device opened
2018.09.23 20:42:54 3: HMUARTLGW HMLAN1 BidCoS-port opened
2018.09.23 20:42:54 3: HMUARTLGW HMLAN1:keepAlive KeepAlive-port opened
2018.09.23 20:44:29 1: 192.168.4.6:2001 disconnected, waiting to reappear (HMLAN1:keepAlive)
2018.09.23 20:44:29 1: HMUARTLGW HMLAN1:keepAlive KeepAlive sent 13.794s too late, this might cause a disconnect!
2018.09.23 20:44:29 1: 192.168.4.6:2000 disconnected, waiting to reappear (HMLAN1)
2018.09.23 20:44:29 3: Opening HMLAN1:keepAlive device 192.168.4.6:2001
2018.09.23 20:44:29 1: 192.168.4.6:2000 reappeared (HMLAN1)
2018.09.23 20:44:29 3: HMUARTLGW HMLAN1 BidCoS-port opened
2018.09.23 20:44:29 3: HMLAN1:keepAlive device opened
2018.09.23 20:44:29 3: HMUARTLGW HMLAN1:keepAlive KeepAlive-port opened
2018.09.23 20:48:34 1: 192.168.4.6:2001 disconnected, waiting to reappear (HMLAN1:keepAlive)
2018.09.23 20:48:34 1: 192.168.4.6:2000 disconnected, waiting to reappear (HMLAN1)
2018.09.23 20:48:34 3: Opening HMLAN1:keepAlive device 192.168.4.6:2001
2018.09.23 20:48:34 1: 192.168.4.6:2000 reappeared (HMLAN1)
2018.09.23 20:48:34 3: HMUARTLGW HMLAN1 BidCoS-port opened
2018.09.23 20:48:34 3: HMLAN1:keepAlive device opened
2018.09.23 20:48:34 3: HMUARTLGW HMLAN1:keepAlive KeepAlive-port opened
2018.09.23 20:50:09 1: 192.168.4.6:2001 disconnected, waiting to reappear (HMLAN1:keepAlive)
2018.09.23 20:50:09 1: 192.168.4.6:2000 disconnected, waiting to reappear (HMLAN1)
2018.09.23 20:50:09 1: HMUARTLGW HMLAN1:keepAlive KeepAlive sent 33.822s too late, this might cause a disconnect!
2018.09.23 20:50:09 3: Opening HMLAN1:keepAlive device 192.168.4.6:2001
2018.09.23 20:50:09 1: 192.168.4.6:2000 reappeared (HMLAN1)
2018.09.23 20:50:09 3: HMUARTLGW HMLAN1 BidCoS-port opened
2018.09.23 20:50:09 3: HMLAN1:keepAlive device opened
2018.09.23 20:50:09 3: HMUARTLGW HMLAN1:keepAlive KeepAlive-port opened
2018.09.23 20:51:19 1: HMUARTLGW HMLAN1:keepAlive KeepAlive sent 28.904s too late, this might cause a disconnect!
2018.09.23 20:51:19 1: 192.168.4.6:2001 disconnected, waiting to reappear (HMLAN1:keepAlive)
2018.09.23 20:51:59 1: 192.168.4.6:2000 disconnected, waiting to reappear (HMLAN1)
2018.09.23 20:51:59 1: HMUARTLGW HMLAN1:keepAlive did not respond after all, reopening
2018.09.23 20:51:59 3: HMLAN1 device closed


danach nichts mehr vom HMUARTLGW im log.


manuelles REOPEN:

Code Auswählen

2018.09.24 15:09:36 3: HMLAN1 device closed
2018.09.24 15:09:36 3: Opening HMLAN1:keepAlive device 192.168.4.6:2001
2018.09.24 15:09:36 1: 192.168.4.6:2000 reappeared (HMLAN1)
2018.09.24 15:09:36 3: HMUARTLGW HMLAN1 BidCoS-port opened
2018.09.24 15:09:36 3: HMLAN1:keepAlive device opened
2018.09.24 15:09:36 3: HMUARTLGW HMLAN1:keepAlive KeepAlive-port opened
Titel: Antw:HM-LGW reconnected nicht automatisch nach Stromausfall
Beitrag von: Beta-User am 26 September 2018, 14:19:54
Kannst du bitte code-tags verwenden? (der #-Button oberhalb des Editor-Fensters)

Ist da irgendwas dazwischen, was Netzwerkprobleme verursachen könnte?
Besonders verdächtig: PI+Fritzbox über WLAN, PowerLAN-Verbindungen.

Ansonsten sieht das m.E. ok aus (das Modul versucht ja scheinbar reconnects, die gehen nur schief, die fw. dürfte auch aktuell zu sein).
Titel: Antw:HM-LGW reconnected nicht automatisch nach Stromausfall
Beitrag von: pc1246 am 26 September 2018, 14:30:11
Moin
Und bitte auch nachtraeglich die Codetags anwenden!
Danke und Gruss
Christoph
Titel: Antw:HM-LGW reconnected nicht automatisch nach Stromausfall
Beitrag von: frank am 26 September 2018, 14:58:06
Zitat2018.09.23 20:51:19 1: HMUARTLGW HMLAN1:keepAlive KeepAlive sent 28.904s too late, this might cause a disconnect!
hast du schon mal dein fhem auf freezes untersucht?
schau mal nach dem modul freezemon.
Titel: Antw:HM-LGW reconnected nicht automatisch nach Stromausfall
Beitrag von: markus_e am 01 Oktober 2018, 17:14:11
die freezemon ausgabe lautet:

Code Auswählen
fcDay 1         2018-10-01 17:10:17
fcDayLast 0     2018-10-01 00:00:34
freezeDevice     no bad guy found :-(   2018-10-01 17:10:17
freezeTime 4.627      2018-10-01 17:10:17
ftDay 4.627     2018-10-01 17:10:17
ftDayLast 0    2018-10-01 00:00:34
state     s:17:10:13 e:17:10:17 f:4.627 d:no bad guy found :-(     2018-10-01 17:10:17

und der Timestamp des 4.6 sek freezes war gerade im Moment als ich im browser auf "everything" geklickt habe um die freezemon Werte anzusehen
Titel: Antw:HM-LGW reconnected nicht automatisch nach Stromausfall
Beitrag von: Klaus.A am 01 Oktober 2018, 21:28:46
Das kenne ich ... im Web UI auf "everything" und FHEM blockiert, dann fliegen die HM-LGW's raus weil dort der Timeout extrem kurz gesetzt ist.

Es gibt ein paar Funktionen in FHEM die brutal blockieren, meist wenn lange Listen aufgebaut werden.  Ob das jemals zu beheben ist bezweifle ich - es scheint ein Architekturproblem in FHEM zu sein (?)

Gruß, Klaus


Titel: Antw:HM-LGW reconnected nicht automatisch nach Stromausfall
Beitrag von: mgernoth am 02 Oktober 2018, 09:12:58
Hallo,

Zitat von: markus_e am 26 September 2018, 14:14:46
Code Auswählen

2018.09.23 20:13:27 1: HMUARTLGW HMLAN1:keepAlive KeepAlive sent 37.179s too late, this might cause a disconnect!


Ich habe den Verdacht, dass da nach dem Stromausfall noch was anderes in Fhem Amokgelaufen ist, was die Freezes erzeugt hat. Das war dann am nächsten Tag weg.

Code Auswählen

2018.09.23 20:51:59 1: HMUARTLGW HMLAN1:keepAlive did not respond after all, reopening
2018.09.23 20:51:59 3: HMLAN1 device closed


HMUARTLGW sollte nie an dieser Stelle hängenbleiben, ich versuche das mal morgen zu reproduzieren. An dieser Stelle übernimmt eigentlich das Fhem-DevIO-Modul um die Verbindung wiederherzustellen.

An der Stelle passiert übrigens genau das gleiche wie bei einem Klick auf "reopen"...

Viele Grüße
  Michael
Nur Text | Text mit Bildern