Hi
ich habe nun schon seit einer Zeit dass mein HMLAN sich permanent disconnected und connected. Ich habe dann gestern mal die neuste Firmware draufgemacht , aber trotzdem bleibt es. Hier mal das Log :
2015.09.24 20:58:05.898 1: 192.168.1.56:1000 disconnected, waiting to reappear (HMLAN1)
2015.09.24 20:58:05.900 1: HMLAN_Parse: HMLAN1 new condition disconnected
2015.09.24 20:59:06.913 1: 192.168.1.56:1000 reappeared (HMLAN1)
2015.09.24 20:59:06.914 1: HMLAN_Parse: HMLAN1 new condition init
2015.09.24 20:59:09.979 1: HMLAN_Parse: HMLAN1 new condition ok
2015.09.24 21:01:16.382 1: 192.168.1.56:1000 disconnected, waiting to reappear (HMLAN1)
2015.09.24 21:01:16.383 1: HMLAN_Parse: HMLAN1 new condition disconnected
2015.09.24 21:01:19.396 1: 192.168.1.56:1000 reappeared (HMLAN1)
2015.09.24 21:01:19.398 1: HMLAN_Parse: HMLAN1 new condition init
2015.09.24 21:01:19.704 1: HMLAN_Parse: HMLAN1 new condition ok
2015.09.24 21:05:40.054 1: 192.168.1.56:1000 disconnected, waiting to reappear (HMLAN1)
2015.09.24 21:05:40.055 1: HMLAN_Parse: HMLAN1 new condition disconnected
2015.09.24 21:06:41.073 1: 192.168.1.56:1000 reappeared (HMLAN1)
2015.09.24 21:06:41.075 1: HMLAN_Parse: HMLAN1 new condition init
2015.09.24 21:06:44.102 1: HMLAN_Parse: HMLAN1 new condition ok
2015.09.24 21:26:07.289 1: 192.168.1.56:1000 disconnected, waiting to reappear (HMLAN1)
2015.09.24 21:26:07.289 1: HMLAN_Parse: HMLAN1 new condition disconnected
2015.09.24 21:27:11.310 1: 192.168.1.56:1000 reappeared (HMLAN1)
2015.09.24 21:27:11.311 1: HMLAN_Parse: HMLAN1 new condition init
2015.09.24 21:27:11.385 1: HMLAN_Parse: HMLAN1 new condition ok
2015.09.24 21:37:53.213 1: 192.168.1.96:9090 reappeared (NUC)
und hier die Internals.
Was könnte das sein ?
Du hast die Firm 0.964 auf dem hmlan, ist dein fhem ist auf dem neusten Stand oder schon länger keinen update gemacht?
VG
Frank
update von FHEM ist von gestern. 0.964 ist auch auf dem HMLAN.
Ja, Firm hab ich gerade im Screenshot gesehen, du könntest mal Rohmessages loggen um zu sehen was da los ist.
VG
Frank
uuhm *duck* wie mach ich das mit den rohmessages ?
Rohmessages sniffen im wiki ;)
:-D
ok ... soll ich sys oder all ?
Must du warten, bin gerade am Tablet
attr global verbose 1
attr global mseclog 1
attr <hmlan> logIDs all,sys
all,sys
So wie es da steht
ooh , ok .
nur verbose 1 ? ich hab's gerade auf 3 stehen , soll ich runter setzen ?
wo genau kommt denn das Log vom HMLAN ? weil im Log Folder seh ich nix.
Hast du den wiki Artikel mal gelesen?? Wenn du das über die Komandozeile eingibst, funktioniert das sofort, wenn du direkt die fhem.cfg bearbeiten solltest, dann must du rereadcfg oder shutdown restart machen, sonst wirken die Änderungen nicht! verbose global auf 1 stellen, der Log steht da wo du deinen fhem log hast.
ja ja , hab ich schon gelesen.
rereadcfg hab ich gemacht, komischerweise sind im fhem.log nicht mehr meldungen als sonst auch , trotz den sys,all
2015.09.24 22:53:55.494 1: in REREADCFG
2015.09.24 22:53:55.494 1: in REREADCFG
2015.09.24 22:53:56.073 1: in REREADCFG
2015.09.24 22:53:58.027 1: in REREADCFG
2015.09.24 22:53:58.269 1: in FILEWRITE
2015.09.24 22:53:58.269 1: in FILEWRITE
2015.09.24 22:53:58.269 1: in FILEWRITE
2015.09.24 22:53:58.270 1: in FILEWRITE
2015.09.24 22:53:58.283 1: 192.168.1.96:9090 reappeared (NUC)
2015.09.24 22:54:04.306 1: Perfmon: possible freeze starting at 22:53:47, delay is 17.306
2015.09.24 22:54:04.732 1: HMLAN_Parse: HMLAN1 new condition ok
2015.09.24 22:55:08.001 1: Perfmon: possible freeze starting at 22:55:02, delay is 6.001
2015.09.24 22:55:30.226 1: Perfmon: possible freeze starting at 22:55:29, delay is 1.226
2015.09.24 22:55:49.505 1: Including fhem.cfg
2015.09.24 22:55:49.604 1: HMLAN_Parse: HMLAN1 new condition disconnected
2015.09.24 22:55:49.610 1: HMLAN_Parse: HMLAN1 new condition init
2015.09.24 22:55:54.966 1: Including ./log/fhem.save
2015.09.24 22:55:58.076 1: in REREADCFG
2015.09.24 22:55:58.077 1: in REREADCFG
2015.09.24 22:55:58.633 1: in REREADCFG
2015.09.24 22:55:58.787 1: in REREADCFG
2015.09.24 22:56:05.021 1: 192.168.1.96:9090 reappeared (NUC)
2015.09.24 22:56:05.047 1: Perfmon: possible freeze starting at 22:55:50, delay is 15.047
2015.09.24 22:56:05.253 1: HMLAN_Parse: HMLAN1 new condition ok
P.S. Um zu sehen was dein fhem so ausbremst, kannst du auch mal apptime laufen lassen. Erklärung findest du im Forum genug, zu apptime.
VG
Frank
Irgendein Modul dein fhem soweit ausbremst, dass der hmlan disconnectet. Das kannst du mit apptime max sehen. Ich bin erstmal weg
VG
Frank
danke dir !!!
ich poste nachher das log von apptime
hier mal was apptime bis jetzt rausgespuckt hat :
name function max count total average maxDly
ZBOX XBMC_Ready 2999 1060 11996 11.32 0 HASH(ZBOX)
GIADA XBMC_Ready 2998 1060 11991 11.31 0 HASH(GIADA)
Kanner ENIGMA2_Define 2003 1 2003 2003.00 0 HASH(Kanner); Kanner ENIGMA2 192.168.1.47 80 20
Solo2 ENIGMA2_Define 2002 1 2002 2002.00 0 HASH(Solo2); Solo2 ENIGMA2 192.168.1.20 80 20
FHEMWEB:192.168.1.6:50326 FW_Read 1580 12 1581 131.75 0 HASH(FHEMWEB:192.168.1.6:50326)
FHEMWEB:192.168.1.6:50325 FW_Read 1552 13 1554 119.54 0 HASH(FHEMWEB:192.168.1.6:50325)
HUE HUEBridge_Notify 1460 2 1460 730.00 0 HASH(HUE); HASH(global)
DENON DENON_AVR_Define 994 1 994 994.00 0 HASH(DENON); DENON DENON_AVR 192.168.1.71:23
hub harmony_Notify 719 2 719 359.50 0 HASH(hub); HASH(global)
Withings_G withings_Notify 505 214 505 2.36 0 HASH(Withings_G); HASH(global)
HMLAN1 HMLAN_Read 26 66 404 6.12 0 HASH(HMLAN1)
FileLog_Heizung_Kichen_Clima FileLog_Get 130 3 377 125.67 0 HASH(FileLog_Heizung_Kichen_Clima); FileLog_Heizung_Kichen_Clima; CURRENT; INT; 2015-09-24_00:00:00; 2015-09-25_00:00:01; 4:Heizung_Kichen_Clima.desired-temp\x3a::; 4:Heizung_Kichen_Clima.measured-temp\x3a::; 4:Heizung_Kichen_Clima.ValvePosition\x3a::
withings_D51877 withings_Notify 292 214 292 1.36 0 HASH(withings_D51877); HASH(global)
DORIAN withings_Notify 201 214 201 0.94 0 HASH(DORIAN); HASH(global)
YANNICK withings_Notify 200 214 200 0.93 0 HASH(YANNICK); HASH(global)
FileLog_Heizung_Stuff2 FileLog_Get 74 3 175 58.33 0 HASH(FileLog_Heizung_Stuff2); FileLog_Heizung_Stuff2; CURRENT; INT; 2015-09-24_00:00:00; 2015-09-25_00:00:01; 4:Heizung_Stuff2.measured-temp\x3a::; 4:Heizung_Stuff2.desired-temp\x3a::; 4:Heizung_Stuff2.actuator\x3a::
netatmo_D70:ee:50:03:69:6a netatmo_Notify 164 2 164 82.00 0 HASH(netatmo_D70:ee:50:03:69:6a); HASH(global)
FHEMWEB:192.168.1.6:50313 FW_Read 148 6 158 26.33 0 HASH(FHEMWEB:192.168.1.6:50313)
FileLog_Heizung_Stuff1 FileLog_Get 52 3 153 51.00 0 HASH(FileLog_Heizung_Stuff1); FileLog_Heizung_Stuff1; CURRENT; INT; 2015-09-24_00:00:00; 2015-09-25_00:00:01; 4:Heizung_Stuff1.measured-temp\x3a::; 4:Heizung_Stuff1.desired-temp\x3a::; 4:Heizung_Stuff1.actuator\x3a::
Wetter netatmo_Notify 153 2 153 76.50 0 HASH(Wetter); HASH(global)
GERMAIN withings_Notify 151 214 151 0.71 0 HASH(GERMAIN); HASH(global)
könnte gut gehen. 3 sec delay hie und da. 5 sec puffer sind eingeplant. falls nicht 2 mal 3 sec zusammen kommen ist das ok.
was sagt HMLAN selbst?
msgKeepAlive dlyMax:.... bufferMin:....
msgParseDly min:... max:.... .....
msgKeepAlive dlyMax:6.004 bufferMin:8
msgLoadHistory 5min steps: 0/0/-1/0/0/-2/0/-1/-2/-2/0/0
msgParseDly min:-6348 max:8113 last:-3 cnt:908
Hast du zufällig Telekom Entertain mit ner Enterainbox im Netzwerk? Oder irgendein anderes Gerät im Netzwerk?? Schau mal hier:
http://forum.fhem.de/index.php/topic,20776.msg334189.html#msg334189
nein , hab ich nicht. Ich bin nicht aus Deutschland. Ich habe auch nichts ähnliches.
Ohne mich weit aus dem Fenster zu lehnen , aber ich denke nicht dass es das Netzwerk ist , oder die Anbindung zum Internet. Der HMLAN hängt an der Fritz, und der Server mit FHEM auch. Und zwar direkt, ohne übergänge, von draussen kommt ne 200Mbit Glasfaser rein , das würd mich auch wundern wenn von da eine Störung kommen würde.
Zitat von: Amenophis86 am 25 September 2015, 18:25:10
Hast du zufällig Telekom Entertain mit ner Enterainbox im Netzwerk? Oder irgendein anderes Gerät im Netzwerk?? Schau mal hier:
http://forum.fhem.de/index.php/topic,20776.msg334189.html#msg334189
Na, ja muss nicht Entertain sein ... mein Verdacht richtet sich eher gegen Multicast-Pakete ... aber das sieht man sehr schön wenn die Disconnects immer im Zusammenhang mit reboots des HMLAN stehen ...und da sahen für mich die oben gepostetetn Information erst mal nicht nach aus
Also 6 s hat er min einmal gewartet. Das ist ein disconnect. Hast du die Periode geändert? Die 8s buffer verstehe ich sonst nicht.
Ggf. Einmal die sys msgs loggen. Sollte es einen anderen Grund haben nutzt das timing prüfen natürlich nichts.
ja , ich habe gestern abend den wdtimer auf 15 gesetzt zum testen . Es sind in der tat weniger bis quasi keine disconnects mehr zusehen.
Ob das nun des Rätsels Lösung ist weiss ich nicht.
Dann stimmt die Rechnung im hmlan. Bei dir gibt es mit unter 6s delay. Wenn das genau den keepalive trifft ist das ein disconnect. Wenn du 15 einstellst hast du alle 15s ein keepalive und 30 -15=15s Puffer.
Das klappt dann so und du kannst es vergessen. Ich würde es dennoch nicht denn 6s warten, und das immer mal wieder ist keine Option. Das stört auch beim schalten.... nee.