HMUARTLGW HmLGW: KeepAlive sent 28.446s too late, this might / disconnect

Begonnen von luftdieb, 16 April 2019, 22:01:02

Vorheriges Thema - Nächstes Thema

luftdieb

Moin,
leider habe ich ca. seit dem 09.04. Probleme mit meinem Homematic LAN Gateway. Eine CCU habe ich nicht als externe Hardware und wird vom FHEM bereitgestellt.
Leider habe ich seit diesem Update alle paar Stunden einen Verbindungsabriss, welcher sich wie folgt im Logbuch äußert:
2019.04.16 17:58:14.811 3: Opening HmLGW device 192.192.178.8:2000
2019.04.16 17:58:17.817 1: HmLGW: Can't connect to 192.192.178.8:2000: Datei oder Verzeichnis nicht gefunden
2019.04.16 17:58:17.867 1: HmLGW: Can't connect to 192.192.178.8:2000: connect to http://192.192.178.8:2000 timed out
2019.04.16 17:58:17.867 3: HMUARTLGW HmLGW: connect to http://192.192.178.8:2000 timed out, retrying in 60.00s
2019.04.16 17:58:36.071 3: Opening HmLGW device 192.192.178.8:2000
2019.04.16 17:58:53.003 3: HMUARTLGW HmLGW: connect to http://192.192.178.8:2000 timed out, retrying in 60.00s
2019.04.16 17:59:50.598 3: Opening HmLGW device 192.168.178.8:2000
2019.04.16 17:59:50.771 3: Opening HmLGW:keepAlive device 192.168.178.8:2001
2019.04.16 17:59:50.775 3: HmLGW device opened
2019.04.16 17:59:50.848 3: HmLGW:keepAlive device opened
2019.04.16 17:59:51.035 3: HMUARTLGW HmLGW BidCoS-port opened
2019.04.16 17:59:51.356 3: HMUARTLGW HmLGW:keepAlive KeepAlive-port opened
2019.04.16 18:00:42.041 1: HMUARTLGW HmLGW:keepAlive KeepAlive sent 28.446s too late, this might cause a disconnect!
2019.04.16 18:00:47.102 1: 192.168.178.8:2000 disconnected, waiting to reappear (HmLGW)
2019.04.16 18:00:47.229 1: 192.168.178.8:2001 disconnected, waiting to reappear (HmLGW:keepAlive)
2019.04.16 18:00:48.383 3: Opening HmLGW:keepAlive device 192.168.178.8:2001
2019.04.16 18:00:48.387 1: 192.168.178.8:2000 reappeared (HmLGW)
2019.04.16 18:00:48.485 3: HmLGW:keepAlive device opened
2019.04.16 18:00:49.068 3: HMUARTLGW HmLGW BidCoS-port opened
2019.04.16 18:00:49.153 3: HMUARTLGW HmLGW:keepAlive KeepAlive-port opened
2019.04.16 18:31:11.324 1: HMUARTLGW HmLGW:keepAlive KeepAlive sent 18.597s too late, this might cause a disconnect!
2019.04.16 18:31:11.645 1: 192.168.178.8:2001 disconnected, waiting to reappear (HmLGW:keepAlive)
2019.04.16 18:31:15.703 1: 192.168.178.8:2000 disconnected, waiting to reappear (HmLGW)
2019.04.16 18:31:15.756 1: HMUARTLGW HmLGW:keepAlive did not respond after all, reopening
2019.04.16 18:49:00.640 3: Opening HmLGW device 192.168.178.8:2000
2019.04.16 18:49:00.765 3: Opening HmLGW:keepAlive device 192.168.178.8:2001
2019.04.16 18:49:00.769 3: HmLGW device opened
2019.04.16 18:49:00.856 3: HmLGW:keepAlive device opened
2019.04.16 18:49:01.381 3: HMUARTLGW HmLGW BidCoS-port opened
2019.04.16 18:49:01.435 3: HMUARTLGW HmLGW:keepAlive KeepAlive-port opened
2019.04.16 18:52:12.393 1: HMUARTLGW HmLGW:keepAlive KeepAlive sent 46.699s too late, this might cause a disconnect!
2019.04.16 18:52:14.703 1: 192.168.178.8:2001 disconnected, waiting to reappear (HmLGW:keepAlive)
2019.04.16 18:52:17.651 1: Timeout for WOL_Ping reached, terminated process 23840
2019.04.16 18:52:17.652 3: BlockingCall for WOL_HAR_NAS was aborted
2019.04.16 18:52:17.666 1: HMUARTLGW HmLGW:keepAlive did not respond after all, reopening
2019.04.16 18:52:17.674 3: HmLGW device closed
2019.04.16 18:52:17.919 3: Opening HmLGW:keepAlive device 192.168.178.8:2001
2019.04.16 18:52:17.923 1: 192.168.178.8:2000 reappeared (HmLGW)
2019.04.16 18:52:18.551 1: Timeout for WOL_Ping reached, terminated process 23867
2019.04.16 18:52:18.552 3: BlockingCall for WOL_PC_Samsung_TV was aborted
2019.04.16 18:52:18.561 1: Timeout for WOL_Ping reached, terminated process 23868
2019.04.16 18:52:18.566 3: BlockingCall for WOL_WII was aborted
2019.04.16 18:52:19.048 3: HmLGW:keepAlive device opened
2019.04.16 18:52:19.154 3: HMUARTLGW HmLGW BidCoS-port opened
2019.04.16 18:52:20.803 3: HMUARTLGW HmLGW:keepAlive KeepAlive-port opened
2019.04.16 18:59:55.030 1: rain_notify: no values for calculation found!
2019.04.16 19:01:37.172 1: HMUARTLGW HmLGW:keepAlive KeepAlive sent 21.275s too late, this might cause a disconnect!
2019.04.16 19:01:39.820 1: 192.168.178.8:2001 disconnected, waiting to reappear (HmLGW:keepAlive)
2019.04.16 19:01:42.378 1: HMUARTLGW HmLGW:keepAlive did not respond after all, reopening
2019.04.16 19:01:42.385 3: HmLGW device closed
2019.04.16 19:01:42.696 3: Opening HmLGW:keepAlive device 192.168.178.8:2001
2019.04.16 19:01:42.703 1: 192.168.178.8:2000 reappeared (HmLGW)
2019.04.16 19:01:42.799 3: HmLGW:keepAlive device opened
2019.04.16 19:01:43.690 3: HMUARTLGW HmLGW BidCoS-port opened
2019.04.16 19:01:44.251 3: HMUARTLGW HmLGW:keepAlive KeepAlive-port opened
2019.04.16 19:07:40.572 1: Timeout for WOL_Ping reached, terminated process 24772
2019.04.16 19:07:40.574 3: BlockingCall for WOL_Janek_PC was aborted
2019.04.16 19:31:58.763 1: HMUARTLGW HmLGW:keepAlive KeepAlive sent 14.373s too late, this might cause a disconnect!
2019.04.16 19:32:04.318 1: 192.168.178.8:2001 disconnected, waiting to reappear (HmLGW:keepAlive)
2019.04.16 19:32:04.565 1: 192.168.178.8:2000 disconnected, waiting to reappear (HmLGW)
2019.04.16 19:32:04.772 1: HMUARTLGW HmLGW:keepAlive did not respond after all, reopening


Das HMLANGW hat folgende Firmwarestände, die ich die letzten Monate nicht geändert habe (neuere habe ich auch keine gefunden):
D-LANfirmware 1.1.5
D-firmware 1.4.1

Aktuell prüfe ich alle 5 Minuten (doif), ob "Device State ne opened" ist und mache einfach ein Device open und die Verbindung steht wieder.

HMLANGW habe ich schon resettet, sowie auch den FHEM. Hat jemand zufällig eine Idee?


Gruß
luftdieb

Beetle2003

Hallo,

ich habe das gleiche Problem mit meinmem HM LGW.
Da ich es erst neu gekauft habe, dachte ich es liegt an meiner Konfiguration.
Ich habe das Verbindungsproblem mit einem DOIF gelöst, welche auf disconnect prüft.

Macht mich so nicht glücklich.

Würde mich über einen Hinweis zur Lösung freuen.

luftdieb

Hallo Beetle2003,
folgender Artikel hat es bei mir zumindest verbessert:
https://blog.chanoa.de/fhem-performance
Hauptursache bei mir war ein zu kurzer Intervall für das Auslesen des Stromzählers, was die CPU auf ~70% hielt. (in der Zeile oben 2x apptime eingeben und schauen, welche Instanz lange Laufzeiten aufweist.
Weiterhin hatte ich noch WakeOnLAN Aufrufe, welche dies mit ping prüfen. Das hatte auch einigemale timeouts erzeugt. Das habe ich umgestellt auf presence via Fritzbox mac.
Dann habe ich noch logdb mit MySQL, welche mittlerweile auch auf 1,5GB angewachsen ist. Zumindest der tägliche mysqldump lässt die CPU für die Zeit auch ganz schön schwitzen.

Ich hoffe dir hilft das erst mal zumindest für weitere Optimierung.

Gruß
luftdieb