Servus
Ich habe vor einiger Zeit festgestellt dass ab und zu manche Aktionen etwas zeitversetzt ausgeführt wurden, da es aber Anfangs nur recht sporadisch war hab ich der Sache keine große Beachtung geschenkt. Mittlerweile nehmen die Freezes aber immer mehr zu. Bei der Ursachensuche komme ich leider alleine auf keinen grünen Zweig.
Fhem läuft auf einem Raspberry 3B, daneben noch PiHole und der Unifi Controller. Die CPU-Auslastung liegt immer so zwischen 15-20%.
Apptime liefert eine ganze Menge auffälliger Zeiten:
active-timers: 188; max-active timers: 233; max-timer-load: 236 min-tmrHandlingTm: 0.0ms; max-tmrHandlingTm: 113338.9ms; totAvgDly: 156.4ms
name function max count total average maxDly avgDly TS Max call param Max call
HMLANOG HMLAN_Read 119916 29576 276976.46 9.36 0.00 0.00 22.12. 08:42:20 HASH(HMLANOG)
HMLANGarage HMUARTLGW_Read 102965 31661 308584.59 9.75 0.00 0.00 22.12. 08:45:23 HASH(HMLANGarage)
tmr-MQTT2_SERVER_keepaliveChecker HASH(0x733d4f8) 90131 13830 102423.14 7.41 685059.60 208.70 22.12. 08:40:19 HASH(MQTT2_FHEM_Server)
HMLANEG HMUARTLGW_Read 76743 33336 674931.05 20.25 0.00 0.00 22.12. 08:46:40 HASH(HMLANEG)
WEB_127.0.0.1_60606 FW_Notify 39461 33745 176795.43 5.24 0.00 0.00 22.12. 08:45:01 HASH(WEB_127.0.0.1_60606); HASH(SchlafzimmerOG.Thermostat_Climate)
SchlafzimmerOG.Heizungssteuerung DOIF_Notify 29089 130 31670.53 243.62 0.00 0.00 22.12. 08:41:52 HASH(SchlafzimmerOG.Heizungssteuerung); HASH(SchlafzimmerOG.Thermostat_SwitchTr)
SchlafzimmerOG.Heizungsaktor CUL_HM_Set 26926 196 28666.79 146.26 0.00 0.00 22.12. 08:41:52 HASH(SchlafzimmerOG.Heizungsaktor); SchlafzimmerOG.Heizungsaktor; off
MQTT2_FHEM_Server MQTT2_SERVER_Read 18770 97 37017.46 381.62 0.00 0.00 22.12. 08:43:39 HASH(MQTT2_FHEM_Server)
MQTT2_FHEM_Server_192.168.1.53_61490 MQTT2_SERVER_Read 16635 8221 93453.01 11.37 0.00 0.00 22.12. 08:42:37 HASH(MQTT2_FHEM_Server_192.168.1.53_61490)
tmr-LGTV_WebOS_TimerStatusRequest HASH(0x610a1f0) 15349 13797 1714579.86 124.27 692607.20 85.56 22.12. 08:38:41 HASH(LG_TV)
tmr-echodevice_LoginStart HASH(0x5925b90) 12765 2338 20361.12 8.71 707620.01 361.88 21.12. 03:20:33 HASH(Echo)
tmr-HMUARTLGW_CheckCmdResp HASH(0xaf814b0) 11120 1 11120.69 11120.69 10870.18 10870.18 21.12. 06:33:59 HASH(HMLANGarage:keepAlive)
Denon DENON_AVR_Ready 11034 695380 229813.62 0.33 0.00 0.00 22.12. 08:50:14 HASH(Denon)
myASControl CODE(0x7596790) 10469 3837 417144.93 108.72 0.00 0.00 22.12. 08:46:21 HASH(myASControl); HASH(Lichtsensor_Sued)
tmr-BlockingKill HASH_unnamed 10273 13739 18076.74 1.32 709287.65 85.37 21.12. 03:20:59 HASH(0xb0911f0)
tmr-FHEM::Astro::Update HASH(0x72db848) 9935 2345 442454.59 188.68 709616.95 350.32 21.12. 06:33:47 HASH(Astro)
BadOG.Lueften.nf notify_Exec 9904 33745 51480.91 1.53 0.00 0.00 22.12. 08:41:06 HASH(BadOG.Lueften.nf); HASH(KuecheEG.Thermostat_Weather)
SchlafzimmerOG.Thermostat_Climate CUL_HM_Set 9828 996 13229.55 13.28 0.00 0.00 22.12. 08:44:31 HASH(SchlafzimmerOG.Thermostat_Climate); SchlafzimmerOG.Thermostat_Climate; ?
tmr-HMUARTLGW_SendKeepAlive HASH(0xaf814b0) 8913 1134 14826.58 13.07 10541.91 151.94 21.12. 06:33:34 HASH(HMLANGarage:keepAlive)
tmr-echodevice_GetSettings HASH(0x6688008) 7699 2339 24505.11 10.48 673396.20 344.85 21.12. 06:37:08 HASH(ECHO_G2A14R03934302F5)
WEB_127.0.0.1_40146 FW_Notify 6925 15882 74512.84 4.69 0.00 0.00 22.12. 08:41:20 HASH(WEB_127.0.0.1_40146); HASH(KuecheEG.Thermostat_Weather)
KuecheEG.Thermostat_Weather CUL_HM_Set 6507 430 6966.05 16.20 0.00 0.00 22.12. 08:41:20 HASH(KuecheEG.Thermostat_Weather); KuecheEG.Thermostat_Weather; ?
tmr-DENON_AVR_ConnectionCheck HASH(0x59cd9e0) 6329 1297 92885.69 71.62 1425.60 20.57 21.12. 16:44:02 HASH(Denon)
TV.Beleuchtung_Steuerung DOIF_Notify 5898 680 10440.27 15.35 0.00 0.00 22.12. 08:45:59 HASH(TV.Beleuchtung_Steuerung); HASH(Lichtsensor_Sued)
tmr-Calendar_Wakeup HASH(0x7206ee8) 5790 43 10036.77 233.41 5910.71 194.70 22.12. 09:20:20 HASH(DP_Chrissi)
alexa alexa_Read 5661 4135 41622.84 10.07 0.00 0.00 21.12. 01:00:10 HASH(alexa)
FileLog_Krypto FileLog_Log 5621 33745 38748.29 1.15 0.00 0.00 22.12. 08:40:06 HASH(FileLog_Krypto); HASH(MQTT2_FHEM_Server)
FileLog_EsszimmerEG.Thermostat FileLog_Log 5430 147 6066.34 41.27 0.00 0.00 21.12. 07:35:09 HASH(FileLog_EsszimmerEG.Thermostat); HASH(EsszimmerEG.Thermostat)
tmr-__ANON__ HASH(0x8f3df98) 5261 56616 502000.58 8.87 0.00 0.00 20.12. 23:10:07 HASH(MQTT2_FHEM_Server_192.168.1.58_57891)
FileLog_Wohnzimmerlampe.Tisch FileLog_Log 5213 1699 17413.46 10.25 0.00 0.00 20.12. 23:10:07 HASH(FileLog_Wohnzimmerlampe.Tisch); HASH(Wohnzimmerlampe_Tisch)
BadOG_Heizprofil_Automatik weekprofile_Notify 5001 33745 10034.24 0.30 0.00 0.00 22.12. 08:45:52 HASH(BadOG_Heizprofil_Automatik); HASH(BadOG.Thermostat_Climate)
Terrassenlicht_Steuerung DOIF_Notify 4996 1731 7800.66 4.51 0.00 0.00 22.12. 08:46:04 HASH(Terrassenlicht_Steuerung); HASH(Lichtsensor_Sued)
FileLog_EGGang.Bewegungsmelder FileLog_Log 4442 432 6026.18 13.95 0.00 0.00 21.12. 17:15:07 HASH(FileLog_EGGang.Bewegungsmelder); HASH(EGGang.Bewegungsmelder)
HMLANGarage HMUARTLGW_Set 4361 64 4368.35 68.26 0.00 0.00 21.12. 06:33:58 HASH(HMLANGarage); HMLANGarage; ?
tmr-SunRiseShuttersAfterTimerFn HASH_unnamed 3768 14 4619.16 329.94 756.36 376.39 22.12. 09:00:04 HASH(0xccd2620)
FileLog_Edelmetall FileLog_Log 3757 33745 47064.36 1.39 0.00 0.00 22.12. 08:39:57 HASH(FileLog_Edelmetall); HASH(MQTT2_FHEM_Server)
Wohnzimmerlicht_Steuerung DOIF_Notify 3712 680 7918.08 11.64 0.00 0.00 22.12. 08:46:08 HASH(Wohnzimmerlicht_Steuerung); HASH(Lichtsensor_Sued)
tmr-FHEM::AptToDate::PollChild HASH(0x5e3c8a8) 3666 48 4808.56 100.18 14279.22 1195.09 22.12. 03:20:13 HASH(meinFHEMserver)
FileLog_SchlafzimmerOG.Thermostat FileLog_Log 3612 416 9572.45 23.01 0.00 0.00 22.12. 03:20:20 HASH(FileLog_SchlafzimmerOG.Thermostat); HASH(SchlafzimmerOG.Thermostat)
FileLog_Lichtsensor_West FileLog_Log 3597 321 6716.92 20.92 0.00 0.00 21.12. 09:30:11 HASH(FileLog_Lichtsensor_West); HASH(Lichtsensor_West)
FileLog_SchlafzimmerOG.Thermostat_Weather FileLog_Log 3116 270 6282.22 23.27 0.00 0.00 22.12. 03:20:23 HASH(FileLog_SchlafzimmerOG.Thermostat_Weather); HASH(SchlafzimmerOG.Thermostat_Weather)
Freezemon liefert natürlich auch genügend Einträge, aber hier weiß ich nicht wo ich am besten anfangen soll. Es werden immer verschiedene Auslöser angezeigt.
2020.12.22 04:25:07 1: [Freezemon] myFreezemon: possible freeze starting at 04:25:05, delay is 2.546 possibly caused by: tmr-LGTV_WebOS_TimerStatusRequest(LG_TV) tmr-MQTT2_SERVER_keepaliveChecker(MQTT2_FHEM_Server) tmr-Unifi_DoUpdate(Unifi_Controller)
2020.12.22 06:15:22 1: [Freezemon] myFreezemon: possible freeze starting at 06:15:21, delay is 1.125 possibly caused by: tmr-echodevice_GetSettings(Echo) tmr-RESIDENTStk_DurationTimer(rg_Ann_DurationTimer) tmr-RESIDENTStk_DurationTimer(rg_Flo_DurationTimer) tmr-RESIDENTStk_DurationTimer(rg_Claudia_DurationTimer) tmr-RESIDENTStk_DurationTimer(rg_Peter_Arbeit_DurationTimer) tmr-HMUARTLGW_CheckCredits(HMLANGarage)
2020.12.22 06:40:22 1: [Freezemon] myFreezemon: possible freeze starting at 06:40:21, delay is 1.184 possibly caused by: tmr-Unifi_DoUpdate(Unifi_Controller) tmr-echodevice_GetSettings(Echo) tmr-RESIDENTStk_DurationTimer(rg_Ann_DurationTimer) tmr-RESIDENTStk_DurationTimer(rg_Flo_DurationTimer) tmr-RESIDENTStk_DurationTimer(rg_Claudia_DurationTimer) tmr-RESIDENTStk_DurationTimer(rg_Peter_Arbeit_DurationTimer)
2020.12.22 07:20:32 1: [Freezemon] myFreezemon: possible freeze starting at 07:20:30, delay is 2.398 possibly caused by: cmd-apptime max(WEB) tmr-HMUARTLGW_CheckCredits(HMLANEG) tmr-Calendar_PollChild(DP_Andy)
2020.12.22 08:28:23 1: [Freezemon] myFreezemon: possible freeze starting at 08:28:22, delay is 1.236 possibly caused by: cmd-update check(WEB) tmr-Unifi_DoUpdate(Unifi_Controller)
2020.12.22 10:00:01 1: [Freezemon] myFreezemon: possible freeze starting at 10:00:00, delay is 1.341 possibly caused by: tmr-echodevice_GetSettings(ECHO_d3b98a0809824256ab279c32b326d13f) tmr-Unifi_DoUpdate(Unifi_Controller) tmr-DOIF_TimerTrigger(BadOG_Temperatureinstellungen) tmr-DOIF_TimerTrigger(SchlafzimmerOG_Temperatureinstellungen) tmr-DOIF_TimerTrigger(CO2Steuerung) tmr-DOIF_TimerTrigger(HeuteRegen)
In den Logs von Freezemon kann ich irgendwie auch keine regelmäßigen Auslöser finden.
Gibt es eine Möglichkeit das Ganze irgendwie einzugrenzen? Ich hatte auch schon testweise ein paar der aufgeführten Module deaktivert, geändert hat sich leider nichts.
Grüße
Andy
Hast Du eine SSD, mit einem nicht ganz kompatiblen Controller?
Ist Deine SD Card am Ende?
Gruß
Christian
Danke erst mal für deine Antwort :)
Nee, SSD hab ich nicht dran, ganz normal über die SD Karte.
Hmm, die SD ist eigtl erst seit knapp 1 Jahr drin, aber ich werd des gleich mal testen. Kann ich einfach schnellvon der jetzigen SD ein Image erstellen oder kopiert man dadurch irgendwelche defekten Teile mit?
Hi Andy
ZitatGibt es eine Möglichkeit das Ganze irgendwie einzugrenzen?
Du kannst freezemon ein file loggen lassen. Das ist dann quasi "global verbose=5) zum Zeitpunkt des freezes. Da sieht man dann schon eher, was das Ganze blockiert.
Zitat
oder kopiert man dadurch irgendwelche defekten Teile mit?
Klar. Ist ja eine 1:1 Kopie. Besser daher vorher ein zusätzliches backup von FHEM zu machen.(ich glaub aber eher nicht, dass es an der SD liegt)
Grüße Markus
Hallo Markus
Ein täglich aktuelles Fhem Backup habe ich, der Stand der Reserve-SD ist nur schon etwas älter bezüglich Unifi, da wäre ein Image einfach einfacher gewesen ;)
Die freezemon Logfiles habe ich mir schon angeschaut, bin da aber auch nicht schlau drauß geworden, hier mal ein paar Beispiele, vielleicht fällt dir was auf:
=========================================================
[Freezemon] myFreezemon: possible freeze starting at 13:10:16, delay is 1.235 possibly caused by: no bad guy found :-(
2020.12.23 13:10:15.650 5: HMUARTLGW HMLANEG read raw (26): fd001501de0500004a2386536abd4e00000000c1000723e6d77a
2020.12.23 13:10:15.650 5: HMUARTLGW HMLANEG read (25): fd001501de0500004a2386536abd4e00000000c1000723e6d77a crc OK
2020.12.23 13:10:15.651 5: HMUARTLGW HMLANEG recv: 01 05 00 00 4A msg: 23 86 53 6ABD4E 000000 00C1000723E6
2020.12.23 13:10:15.651 5: HMUARTLGW HMLANEG Dispatch: A0F2386536ABD4E00000000C1000723E6::-74:HMLANEG
--- log skips 1.507 secs.
2020.12.23 13:10:17.158 4: AutoShuttersControl (myASControl) - Devname: Lichtsensor_Sued Name: myASControl Notify: $VAR1 = [
'brightness: 4679.42',
'state: B: 4679.42'
];
2020.12.23 13:10:17.162 4: AutoShuttersControl (Wz.Rollo.klein) - EventProcessingShadingBrightness
2020.12.23 13:10:17.162 4: AutoShuttersControl (Wz.Rollo.klein) - EventProcessingShadingBrightness
Brightness: 4679.42
2020.12.23 13:10:17.164 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 13:10:17.168 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 13:10:17.172 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 13:10:17.175 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 13:10:17.179 4: AutoShuttersControl (myASControl) - Shading Processing, Rollladen: Wz.Rollo.klein Azimuth: 193.8 Elevation: 16 Brightness: 4204 OutTemp: 11.2
2020.12.23 13:10:17.179 4: AutoShuttersControl (myASControl) - Shading Processing, Rollladen: Wz.Rollo.klein Nach dem return
2020.12.23 13:10:17.180 4: AutoShuttersControl (myASControl) - Shading Processing, Rollladen: Wz.Rollo.klein In der Out Abfrage, Shadingwert: out, Zeitstempel: 1608640267
2020.12.23 13:10:17.180 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 13:10:17.182 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 13:10:17.184 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 13:10:17.186 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 13:10:17.188 4: AutoShuttersControl (myASControl) - Shading Processing - In der Routine zum fahren der Rolll�den, Shading Wert: out
2020.12.23 13:10:17.191 4: AutoShuttersControl (Esszimmer.Rollo.Garten) - EventProcessingShadingBrightness
2020.12.23 13:10:17.191 4: AutoShuttersControl (Esszimmer.Rollo.Garten) - EventProcessingShadingBrightness
Brightness: 4679.42
2020.12.23 13:10:17.192 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 13:10:17.194 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 13:10:17.196 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 13:10:17.197 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 13:10:17.199 4: AutoShuttersControl (myASControl) - Shading Processing, Rollladen: Esszimmer.Rollo.Garten Azimuth: 193.8 Elevation: 16 Brightness: 4204 OutTemp: 11.2
2020.12.23 13:10:17.199 4: AutoShuttersControl (myASControl) - Shading Processing, Rollladen: Esszimmer.Rollo.Garten Nach dem return
2020.12.23 13:10:17.200 4: AutoShuttersControl (myASControl) - Shading Processing, Rollladen: Esszimmer.Rollo.Garten In der Out Abfrage, Shadingwert: out, Zeitstempel: 1608640267
2020.12.23 13:10:17.200 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 13:10:17.202 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 13:10:17.204 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 13:10:17.206 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 13:10:17.209 4: AutoShuttersControl (myASControl) - Shading Processing - In der Routine zum fahren der Rolll�den, Shading Wert: out
2020.12.23 13:10:17.211 4: AutoShuttersControl (Wz.Rollo.gross) - EventProcessingShadingBrightness
2020.12.23 13:10:17.211 4: AutoShuttersControl (Wz.Rollo.gross) - EventProcessingShadingBrightness
Brightness: 4679.42
2020.12.23 13:10:17.212 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 13:10:17.214 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 13:10:17.216 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 13:10:17.217 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 13:10:17.219 4: AutoShuttersControl (myASControl) - Shading Processing, Rollladen: Wz.Rollo.gross Azimuth: 193.8 Elevation: 16 Brightness: 4204 OutTemp: 11.2
2020.12.23 13:10:17.219 4: AutoShuttersControl (myASControl) - Shading Processing, Rollladen: Wz.Rollo.gross Nach dem return
2020.12.23 13:10:17.220 4: AutoShuttersControl (myASControl) - Shading Processing, Rollladen: Wz.Rollo.gross In der Out Abfrage, Shadingwert: out, Zeitstempel: 1608640267
2020.12.23 13:10:17.220 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 13:10:17.222 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 13:10:17.224 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 13:10:17.226 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 13:10:17.228 4: AutoShuttersControl (myASControl) - Shading Processing - In der Routine zum fahren der Rolll�den, Shading Wert: out
2020.12.23 13:10:17.231 5: CUL_HM set Lichtsensor_Sued ?
2020.12.23 13:10:17.233 5: CUL_HM set Lichtsensor_Sued ?
2020.12.23 13:10:17.234 5: End notify loop for Lichtsensor_Sued
2020.12.23 13:10:17.235 5: [Freezemon] myFreezemon: ----------- Starting Freeze handling at 2020.12.23 13:10:17.235 ---------------------
[Freezemon] myFreezemon: possible freeze starting at 13:10:16, delay is 1.235 possibly caused by: no bad guy found :-(
jump to the top
=========================================================
[Freezemon] myFreezemon: possible freeze starting at 16:10:07, delay is 1.389 possibly caused by: tmr-RESIDENTStk_DurationTimer(Gaeste_DurationTimer)
2020.12.23 16:10:06.512 4: MQTT2_FHEM_Server_192.168.1.20_53026 shellyplug-s-020793 PUBLISH shellies/shellyplug-s-020793/relay/0/power:1.98
2020.12.23 16:10:06.523 4: MQTT2_DEVICE_Parse: Shelly_Plug_1 shellies/shellyplug-s-020793/relay/0/power => { my $compare = $EVTPART0 < 100 ? "off":"on"; ReadingsVal($NAME,"loadState","off") ne $compare ? { 'loadState' => $compare } : return }
2020.12.23 16:10:06.525 4: MQTT2_DEVICE_Parse: Shelly_Plug_1 shellies/shellyplug-s-020793/relay/0/power => relay_0_power
2020.12.23 16:10:06.527 4: MQTT2_FHEM_Server_192.168.1.20_53026 shellyplug-s-020793 PUBLISH shellies/shellyplug-s-020793/relay/0/energy:645
2020.12.23 16:10:06.538 4: MQTT2_DEVICE_Parse: Shelly_Plug_1 shellies/shellyplug-s-020793/relay/0/energy => relay_0_energy
2020.12.23 16:10:06.538 4: MQTT2_DEVICE_Parse: Shelly_Plug_1 shellies/shellyplug-s-020793/relay/0/energy => {'relay_0_kWh' => sprintf("%.2f",$EVENT/60/1000)}
2020.12.23 16:10:06.767 5: HMUARTLGW HMLANEG read raw (26): fd0015013e05000043b486536abdaf00000000c1000032465030
2020.12.23 16:10:06.768 5: HMUARTLGW HMLANEG read (25): fd0015013e05000043b486536abdaf00000000c1000032465030 crc OK
2020.12.23 16:10:06.768 5: HMUARTLGW HMLANEG recv: 01 05 00 00 43 msg: B4 86 53 6ABDAF 000000 00C100003246
2020.12.23 16:10:06.768 5: HMUARTLGW HMLANEG Dispatch: A0FB486536ABDAF00000000C100003246::-67:HMLANEG
--- log skips 1.526 secs.
2020.12.23 16:10:08.294 4: AutoShuttersControl (myASControl) - Devname: Lichtsensor_Ost Name: myASControl Notify: $VAR1 = [
'brightness: 128.7',
'state: B: 128.7'
];
2020.12.23 16:10:08.299 4: AutoShuttersControl (Kueche.Rollo.Strasse) - EventProcessingShadingBrightness
2020.12.23 16:10:08.299 4: AutoShuttersControl (Kueche.Rollo.Strasse) - EventProcessingShadingBrightness
Brightness: 128.7
2020.12.23 16:10:08.301 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 16:10:08.306 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 16:10:08.310 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 16:10:08.315 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 16:10:08.319 4: AutoShuttersControl (myASControl) - Shading Processing, Rollladen: Kueche.Rollo.Strasse Azimuth: 232.2 Elevation: 0.5 Brightness: 184 OutTemp: 10.9
2020.12.23 16:10:08.319 4: AutoShuttersControl (myASControl) - Shading Processing, Rollladen: Kueche.Rollo.Strasse Nach dem return
2020.12.23 16:10:08.321 4: AutoShuttersControl (myASControl) - Shading Processing, Rollladen: Kueche.Rollo.Strasse In der Out Abfrage, Shadingwert: out, Zeitstempel: 1608640267
2020.12.23 16:10:08.321 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 16:10:08.326 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 16:10:08.329 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 16:10:08.334 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 16:10:08.339 4: AutoShuttersControl (myASControl) - Shading Processing - In der Routine zum fahren der Rolll�den, Shading Wert: out
2020.12.23 16:10:08.346 4: AutoShuttersControl (Esszimmer.Rollo.Strasse) - EventProcessingShadingBrightness
2020.12.23 16:10:08.346 4: AutoShuttersControl (Esszimmer.Rollo.Strasse) - EventProcessingShadingBrightness
Brightness: 128.7
2020.12.23 16:10:08.348 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 16:10:08.352 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 16:10:08.356 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 16:10:08.360 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 16:10:08.364 4: AutoShuttersControl (myASControl) - Shading Processing, Rollladen: Esszimmer.Rollo.Strasse Azimuth: 232.2 Elevation: 0.5 Brightness: 184 OutTemp: 10.9
2020.12.23 16:10:08.364 4: AutoShuttersControl (myASControl) - Shading Processing, Rollladen: Esszimmer.Rollo.Strasse Nach dem return
2020.12.23 16:10:08.365 4: AutoShuttersControl (myASControl) - Shading Processing, Rollladen: Esszimmer.Rollo.Strasse In der Out Abfrage, Shadingwert: out, Zeitstempel: 1608640267
2020.12.23 16:10:08.365 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 16:10:08.369 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 16:10:08.374 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 16:10:08.379 5: Compute sunrise/sunset for latitude 49.476096 , longitude 11.802709
2020.12.23 16:10:08.382 4: AutoShuttersControl (myASControl) - Shading Processing - In der Routine zum fahren der Rolll�den, Shading Wert: out
2020.12.23 16:10:08.385 5: CUL_HM set Lichtsensor_Ost ?
2020.12.23 16:10:08.387 5: CUL_HM set Lichtsensor_Ost ?
2020.12.23 16:10:08.388 5: End notify loop for Lichtsensor_Ost
2020.12.23 16:10:08.389 5: [Freezemon] myFreezemon: ----------- Starting Freeze handling at 2020.12.23 16:10:08.389 ---------------------
[Freezemon] myFreezemon: possible freeze starting at 16:10:07, delay is 1.389 possibly caused by: tmr-RESIDENTStk_DurationTimer(Gaeste_DurationTimer)
jump to the to
=========================================================
[Freezemon] myFreezemon: possible freeze starting at 07:55:11, delay is 2.566 possibly caused by: no bad guy found :-(
2020.12.23 07:55:10.222 4: MQTT2_FHEM_Server_192.168.1.55_64335 shelly1-98F4ABF3303C PUBLISH shellies/shelly1-98F4ABF3303C/relay/0:off
2020.12.23 07:55:10.228 4: MQTT2_DEVICE_Parse: KuecheEG.Heizungsaktor shellies/shelly1-98F4ABF3303C/relay/0 => relay0
2020.12.23 07:55:10.228 4: MQTT2_DEVICE_Parse: KuecheEG.Heizungsaktor shellies/shelly1-98F4ABF3303C/relay/0 => state
2020.12.23 07:55:10.230 4: MQTT2_FHEM_Server_192.168.1.55_64335 shelly1-98F4ABF3303C PUBLISH shellies/shelly1-98F4ABF3303C/input/0:1
2020.12.23 07:55:10.236 4: MQTT2_DEVICE_Parse: KuecheEG.Heizungsaktor shellies/shelly1-98F4ABF3303C/input/0 => input0
2020.12.23 07:55:10.237 4: MQTT2_FHEM_Server_192.168.1.55_64335 shelly1-98F4ABF3303C PUBLISH shellies/shelly1-98F4ABF3303C/input_event/0:{"event":"L","event_cnt":1}
2020.12.23 07:55:10.244 4: MQTT2_DEVICE_Parse: KuecheEG.Heizungsaktor shellies/shelly1-98F4ABF3303C/input_event/0 => { json2nameValue($EVENT) }
2020.12.23 07:55:10.253 4: MQTT2_FHEM_Server_192.168.1.61_64152 DVES_C6C1A9 PINGREQ
2020.12.23 07:55:10.255 5: https://192.168.1.2:8443/api/s/default/list/alarm: HTTP response code 200
2020.12.23 07:55:10.257 5: [Freezemon] myFreezemon: Calling original sub CODE(0x5939ef0)
2020.12.23 07:55:10.257 5: Unifi_Controller (Unifi_GetUnarchivedAlerts_Receive) - executed.
2020.12.23 07:55:10.263 5: Unifi_Controller (Unifi_GetUnarchivedAlerts_Receive) - state:'ok'
2020.12.23 07:55:10.266 5: Unifi_Controller (Unifi_GetEvents_Send) - executed.
2020.12.23 07:55:10.266 5: [Freezemon] myFreezemon: switching callback from CODE(0x5939f80) to CODE(0x7b36068)
2020.12.23 07:55:10.267 5: IP: 192.168.1.2 -> 192.168.1.2
2020.12.23 07:55:10.648 4: MQTT2_FHEM_Server_192.168.1.67_60608 DVES_14E426 PINGREQ
2020.12.23 07:55:10.737 5: https://192.168.1.2:8443/api/s/default/stat/event: HTTP response code 200
2020.12.23 07:55:10.740 5: [Freezemon] myFreezemon: Calling original sub CODE(0x5939f80)
2020.12.23 07:55:10.741 5: Unifi_Controller (Unifi_GetEvents_Receive) - executed.
2020.12.23 07:55:10.754 5: Unifi_Controller (Unifi_GetEvents_Receive) - state:'ok'
2020.12.23 07:55:10.760 5: Unifi_Controller (Unifi_GetHealth_Send) - executed.
2020.12.23 07:55:10.761 5: [Freezemon] myFreezemon: switching callback from CODE(0x593a010) to CODE(0x7b36068)
2020.12.23 07:55:10.762 5: IP: 192.168.1.2 -> 192.168.1.2
--- log skips 2.804 secs.
2020.12.23 07:55:13.566 5: [Freezemon] myFreezemon: ----------- Starting Freeze handling at 2020.12.23 07:55:13.566 ---------------------
[Freezemon] myFreezemon: possible freeze starting at 07:55:11, delay is 2.566 possibly caused by: no bad guy found :-(
jump to the top
Mal das Unifi-Modul, mal das Denon-Modul, mal das HM Lan-Gateway, dann mal ein HM Bewegungsmelder...
Grüße
Andy
Achte auf die Zeilen
Zitat--- log skips x secs.
In der Regel ist das device davor der Bösewicht. In den ersten beiden Beispielen HMUART ? = USB ?
Hast Du global dnsserver gesetzt ? Das verhindert freezes bei Problemen mit dem DNS(wenn ich es richtig im Kopf hab ::))
Grüße Markus
Nein, ich habe 2x HM-LGW-O-TW-W-EU2 und 1x HM-CFG-LAN, alle 3 aber über LAN angeschlossen.
att global dnsserver ist auch gesetzt.
2020.12.23 11:48:26.644 5: CUL_HM Steckdose2 protEvent:CMDs_done
2020.12.23 11:48:26.644 5: CUL_HM Steckdose2 sent ACK:2
2020.12.23 11:48:26.675 5: CUL_HM set Steckdose2 ?
2020.12.23 11:48:26.678 5: CUL_HM set Steckdose2 ?
2020.12.23 11:48:26.680 5: End notify loop for Steckdose2
--- log skips 2.418 secs.
2020.12.23 16:25:56.409 5: HttpUtils request header:
GET /api/devices-v2/device?cached=true&_=1608737154 HTTP/1.1
Host: layla.amazon.de
Accept-Encoding: gzip,deflate
User-Agent: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:62.0) Gecko/20100101 Firefox/62.0
Accept-Language: de,en-US;q=0.7,en;q=0.3
DNT: 1
Connection: keep-alive
Upgrade-Insecure-Requests: 1
Cookie:session-id=261-8880306-5445651; session-id-time=2239455421l; ubid-acbde=259-0361743-2947047; x-acbde=IYxuzPvI0e?7a81U5lJ?@fK3rUwMC923; at-acbde=Atza|IwEBIAM0rkO1O-Emdo4G5bb3MtsSkiEe-FwaM2qPhafYXgpgiok2OQK4WYkhZR7x4oGsgm72TaihdYOFZ8mKtHNtFpe0Pcx6nGFpTQpcsYogQV-q4OL2O_BKW85rluFpQY19px7W3rIsStaYFkZ_XEc5hSyN_Yowz-wjmk_lt3X61LM6s_cAYo1k2w3ChCPbuKUclEIYls-n6KASY2wHyJNu4GdaWnRPkf3LX7MqZV1Qb6DA5lGWfe5IXUQhLv_-Q5orbG-oHpdykgfjq1EjSr3D196PWZiA-xoeklpDY5yPaLqp0xujPlPNFw2yBS9Ysa-0lSw; sess-at-acbde=lpRkVpyCxRZg2Ybg0PkE/kgatcta7aEb4DTQDVnVnNo=; csrf=1270636260
csrf: 1270636260
Content-Type: application/json; charset=UTF-8
2020.12.23 16:25:56.569 5: JeeLink/RAW: /OK 9 49 130 4 160 125
--- log skips 6.680 secs.
Beim ersten war es dann eine Homematic HM-ES-PMSW1-PL-DN-R1 Steckdose und beim zweiten ein JeeLink
Grüße Andy
Musst Du Dir dann mal "statistisch" angucken. Den Jeelink halte ich für unkritisch. Was macht der unifi-controller ? Ich hab auch pi-hole u. musste feststellen, dass es katastrophal wird, wenn ich den pi mit einem update "belaste". Will sagen: könnte es auch eine nicht-FHEM-Anwendung sein ?
Grüße Markus
Ich habe jetzt mal pi-hole und unifi deaktivert und auch die zugehörigen Module disabled.
Hab dann einfach auf der Weboberfläche verschiedene Räume geöffnet, Ergebnis war ein 293-sekündiger freeze :o
2020.12.23 17:03:04 3: LGTV_WebOS (LG_TV) - Sucessfull WS connection to 192.168.1.26
2020.12.23 17:05:58 1: [Freezemon] myFreezemon: possible freeze starting at 17:05:57, delay is 1.184 possibly caused by: cmd-update check(WEB) tmr-echodevice_GetSettings(ECHO_G090U50991764CW9) tmr-echodevice_GetSettings(ECHO_G090XG0793052NSQ) tmr-echodevice_GetSettings(ECHO_G070L80875140X87) tmr-echodevice_GetSettings(ECHO_G2A14S03937203EE) tmr-echodevice_GetSettings(ECHO_G2A14S0393620C12) tmr-echodevice_GetSettings(ECHO_G2A14S0393620AXH) tmr-echodevice_GetSettings(ECHO_G2A14Q0493670BEL) tmr-echodevice_GetSettings(ECHO_G2A14R0393530A2M) tmr-echodevice_GetSettings(ECHO_G2A14R03934302F5) tmr-echodevice_GetSettings(ECHO_8a27c93a556f412eb79a28c4f53e3567) tmr-RESIDENTStk_DurationTimer(Heidi_DurationTimer) tmr-RESIDENTStk_DurationTimer(Nicole_DurationTimer) tmr-echodevice_GetSettings(Echo) tmr-RESIDENTStk_DurationTimer(rg_Peter_DurationTimer) tmr-RESIDENTStk_DurationTimer(rg_Claudia_DurationTimer) tmr-RESIDENTStk_DurationTimer(rg_Peter_Arbeit_DurationTimer) tmr-echodevice_LoginStart(Echo) tmr-SamsungAV_Init(SchlafzimmerTV) tmr-echodevice_GetSettings(ECHO_d3b98a0809824256ab279c32b326d13f)
2020.12.23 17:08:48 1: [Freezemon] myFreezemon: possible freeze starting at 17:08:46, delay is 2.332 possibly caused by: tmr-DENON_AVR_ConnectionCheck(Denon)
2020.12.23 17:08:50 1: [Freezemon] myFreezemon: possible freeze starting at 17:08:49, delay is 1.744 possibly caused by: tmr-LGTV_WebOS_TimerStatusRequest(LG_TV) tmr-MQTT2_SERVER_keepaliveChecker(MQTT2_FHEM_Server) tmr-HomeConnect_Timer(LC97FMR60) tmr-HomeConnect_Timer(TI909701HC) tmr-HMUARTLGW_SendKeepAlive(HMLANGarage) tmr-HMUARTLGW_SendKeepAlive(HMLANEG)
2020.12.23 17:10:02 1: [Freezemon] myFreezemon: possible freeze starting at 17:10:01, delay is 1.39 possibly caused by: tmr-Unifi_DoUpdate(Unifi_Controller) tmr-LGTV_WebOS_GetCurrentChannel(LG_TV)
2020.12.23 17:11:02 1: [Freezemon] myFreezemon: possible freeze starting at 17:11:01, delay is 1.623 possibly caused by: no bad guy found :-(
2020.12.23 17:17:05 1: [Freezemon] myFreezemon: possible freeze starting at 17:16:41, delay is 24.16 possibly caused by: no bad guy found :-(
2020.12.23 17:18:55 3: MQTT2_FHEM_Server: MQTT2_FHEM_Server_192.168.1.69_52645/DVES_148E6C left us (keepalive check)
2020.12.23 17:18:55 3: MQTT2_FHEM_Server: MQTT2_FHEM_Server_192.168.1.70_57220/DVES_1539B2 left us (keepalive check)
2020.12.23 17:18:55 3: MQTT2_FHEM_Server: MQTT2_FHEM_Server_192.168.1.20_53026/shellyplug-s-020793 left us (keepalive check)
2020.12.23 17:18:56 3: MQTT2_FHEM_Server: MQTT2_FHEM_Server_192.168.1.52_57736/shellyswitch25-98F4ABF30DAC left us (keepalive check)
2020.12.23 17:18:56 3: MQTT2_FHEM_Server: MQTT2_FHEM_Server_192.168.1.51_53760/shellyswitch25-10BD77 left us (keepalive check)
2020.12.23 17:18:56 3: MQTT2_FHEM_Server: MQTT2_FHEM_Server_192.168.1.62_62625/DVES_C63824 left us (keepalive check)
2020.12.23 17:18:56 3: MQTT2_FHEM_Server: MQTT2_FHEM_Server_192.168.1.63_64736/DVES_542B98 left us (keepalive check)
2020.12.23 17:18:56 3: MQTT2_FHEM_Server: MQTT2_FHEM_Server_192.168.1.60_55393/DVES_CBC9B4 left us (keepalive check)
2020.12.23 17:18:57 3: MQTT2_FHEM_Server: MQTT2_FHEM_Server_192.168.1.57_50724/shellyswitch25-E098068D42E0 left us (keepalive check)
2020.12.23 17:18:57 3: MQTT2_FHEM_Server: MQTT2_FHEM_Server_192.168.1.61_52900/DVES_C6C1A9 left us (keepalive check)
2020.12.23 17:18:57 3: MQTT2_FHEM_Server: MQTT2_FHEM_Server_192.168.1.65_52203/DVES_C64192 left us (keepalive check)
2020.12.23 17:18:57 3: MQTT2_FHEM_Server: MQTT2_FHEM_Server_192.168.1.68_60359/DVES_152927 left us (keepalive check)
2020.12.23 17:18:57 3: MQTT2_FHEM_Server: MQTT2_FHEM_Server_192.168.1.53_62129/shellyswitch25-F37156 left us (keepalive check)
2020.12.23 17:18:57 3: MQTT2_FHEM_Server: MQTT2_FHEM_Server_192.168.1.66_62750/DVES_C634FE left us (keepalive check)
2020.12.23 17:18:57 3: MQTT2_FHEM_Server: MQTT2_FHEM_Server_192.168.1.54_54137/shellyswitch25-F3588F left us (keepalive check)
2020.12.23 17:18:57 3: MQTT2_FHEM_Server: MQTT2_FHEM_Server_192.168.1.67_50914/DVES_14E426 left us (keepalive check)
2020.12.23 17:18:57 3: MQTT2_FHEM_Server: MQTT2_FHEM_Server_192.168.1.58_49638/shellydimmer2-D8BFC01A01AD left us (keepalive check)
2020.12.23 17:18:58 3: MQTT2_FHEM_Server: MQTT2_FHEM_Server_192.168.1.56_53765/shelly1-98F4ABF2445F left us (keepalive check)
2020.12.23 17:18:58 3: MQTT2_FHEM_Server: MQTT2_FHEM_Server_192.168.1.64_57682/DVES_C6C1C4 left us (keepalive check)
2020.12.23 17:19:36 3: MQTT2_FHEM_Server: MQTT2_FHEM_Server_192.168.1.50_52535/shellyswitch25-10F924 left us (keepalive check)
2020.12.23 17:19:38 3: MQTT2_FHEM_Server: MQTT2_FHEM_Server_192.168.1.55_64335/shelly1-98F4ABF3303C left us (keepalive check)
2020.12.23 17:19:38 2: LC97FMR60 event channel timeout, two keep alive messages missing
2020.12.23 17:19:39 2: TI909701HC event channel timeout, two keep alive messages missing
2020.12.23 17:19:41 1: HMUARTLGW HMLANGarage:keepAlive KeepAlive sent 179.949s too late, this might cause a disconnect!
2020.12.23 17:19:41 1: HMUARTLGW HMLANEG:keepAlive KeepAlive sent 179.965s too late, this might cause a disconnect!
2020.12.23 17:20:51 1: 192.168.1.7:2001 disconnected, waiting to reappear (HMLANGarage:keepAlive)
2020.12.23 17:21:58 1: 192.168.1.3:2001 disconnected, waiting to reappear (HMLANEG:keepAlive)
2020.12.23 17:21:59 1: [Freezemon] myFreezemon: possible freeze starting at 17:17:06, delay is 293.565 possibly caused by: tmr-LGTV_WebOS_TimerStatusRequest(LG_TV) tmr-MQTT2_SERVER_keepaliveChecker(MQTT2_FHEM_Server) tmr-HomeConnect_Timer(LC97FMR60) tmr-HomeConnect_Timer(TI909701HC) tmr-HMUARTLGW_SendKeepAlive(HMLANGarage) tmr-HMUARTLGW_SendKeepAlive(HMLANEG) tmr-HMUARTLGW_CheckCredits(HMLANGarage) tmr-HMUARTLGW_CheckCredits(HMLANEG) tmr-DENON_AVR_ConnectionCheck(Denon) tmr-FBAHAHTTP_Poll(Fritzbox) tmr-CODE(0x5578b08)(GetUpdate) tmr-RESIDENTStk_DurationTimer(rg_Ann_DurationTimer) tmr-RESIDENTStk_DurationTimer(rg_Flo_DurationTimer) tmr-RESIDENTStk_DurationTimer(Gaeste_DurationTimer) tmr-RESIDENTStk_DurationTimer(Chrissi_DurationTimer) tmr-echodevice_GetSettings(ECHO_G090XG0793052QF3) tmr-FHEM::Buienradar::Timer(myBuienRadar) tmr-FW_closeInactiveClients(N/A) tmr-FHEM::Astro::Update(Astro) tmr-echodevice_GetSettings(ECHO_G0911B0592620ERG) tmr-echodevice_GetSettings(ECHO_90c8d0da33ad4bbeb80fdf6449fb8d9f) tmr-echodevice_GetSettings(ECHO_G090U50991764CW9) tmr-echodevice_GetSettings(ECHO_G090XG0793052NSQ) tmr-echodevice_GetSettings(ECHO_G070L80875140X87) tmr-echodevice_GetSettings(ECHO_G2A14S03937203EE) tmr-echodevice_GetSettings(ECHO_G2A14S0393620C12) tmr-echodevice_GetSettings(ECHO_G2A14S0393620AXH) tmr-echodevice_GetSettings(ECHO_G2A14Q0493670BEL) tmr-echodevice_GetSettings(ECHO_G2A14R0393530A2M) tmr-echodevice_GetSettings(ECHO_G2A14R03934302F5) tmr-echodevice_GetSettings(ECHO_8a27c93a556f412eb79a28c4f53e3567) tmr-RESIDENTStk_DurationTimer(Heidi_DurationTimer) tmr-RESIDENTStk_DurationTimer(Nicole_DurationTimer) tmr-echodevice_GetSettings(Echo) tmr-RESIDENTStk_DurationTimer(rg_Peter_DurationTimer) tmr-RESIDENTStk_DurationTimer(rg_Claudia_DurationTimer) tmr-RESIDENTStk_DurationTimer(rg_Peter_Arbeit_DurationTimer) tmr-echodevice_LoginStart(Echo) tmr-SamsungAV_Init(SchlafzimmerTV) tmr-echodevice_GetSettings(ECHO_d3b98a0809824256ab279c32b326d13f) tmr-HMLAN_KeepAlive(HMLANOG)
2020.12.23 17:21:59 1: Timeout for LGTV_WebOS_PresenceRun reached, terminated process 6857
2020.12.23 17:22:02 3: MQTT2_DEVICE set Wohnzimmerlampe_Tisch pct 50
2020.12.23 17:22:04 1: HMUARTLGW HMLANGarage:keepAlive did not respond after all, reopening
2020.12.23 17:22:04 3: HMLANGarage device closed
2020.12.23 17:22:04 1: HMUARTLGW HMLANEG:keepAlive did not respond after all, reopening
2020.12.23 17:22:04 3: HMLANEG device closed
2020.12.23 17:22:07 3: Opening HMLANGarage:keepAlive device 192.168.1.7:2001
2020.12.23 17:22:07 1: 192.168.1.7:2000 reappeared (HMLANGarage)
2020.12.23 17:22:13 3: Opening HMLANEG:keepAlive device 192.168.1.3:2001
2020.12.23 17:22:13 1: 192.168.1.3:2000 reappeared (HMLANEG)
2020.12.23 17:22:13 3: MQTT2_DEVICE set Wohnzimmerlampe_Tisch pct 50
2020.12.23 17:22:14 1: [Freezemon] myFreezemon: possible freeze starting at 17:22:00, delay is 14.31 possibly caused by: cmd-set Denon off(N/A) tmr-RESIDENTStk_DurationTimer(rr_Andy_DurationTimer) tmr-RESIDENTStk_DurationTimer(Bewohner_DurationTimer) tmr-LGTV_WebOS_GetCurrentChannel(LG_TV) tmr-LGTV_WebOS_GetForgroundAppInfo(LG_TV) tmr-BlockingKill(N/A) tmr-LGTV_WebOS_Get3DStatus(LG_TV) tmr-LGTV_WebOS_GetExternalInputList(LG_TV) tmr-LGTV_WebOS_TimerStatusRequest(LG_TV) tmr-MQTT2_SERVER_keepaliveChecker(MQTT2_FHEM_Server) tmr-HMUARTLGW_CheckCmdResp(HMLANGarage) tmr-HMUARTLGW_CheckCmdResp(HMLANEG) tmr-HMUARTLGW_CheckCmdResp(HMLANGarage) tmr-HMUARTLGW_CheckCmdResp(HMLANEG) tmr-HomeConnect_Timer(LC97FMR60) tmr-HomeConnect_Timer(TI909701HC) tmr-HMUARTLGW_CheckCredits(HMLANGarage) tmr-HMUARTLGW_CheckCredits(HMLANEG) tmr-DOIF_TimerTrigger(HeuteRegen) tmr-DENON_AVR_ConnectionCheck(Denon) tmr-echodevice_GetSettings(ECHO_G090XG0793052QF3) tmr-CUL_HM_ActCheck(N/A) tmr-netatmo_poll(Netatmo_Poppenricht) tmr-RESIDENTStk_DurationTimer(rg_Ann_DurationTimer) tmr-FW_closeInactiveClients(N/A) tmr-RESIDENTStk_DurationTimer(rg_Flo_DurationTimer) tmr-RESIDENTStk_DurationTimer(Gaeste_DurationTimer) tmr-RESIDENTStk_DurationTimer(Chrissi_DurationTimer) tmr-FHEM::Astro::Update(Astro) tmr-CODE(0x25ee540)(dnsQuery) tmr-HMLAN_KeepAliveCheck(HMLANOG) tmr-echodevice_GetSettings(ECHO_G0911B0592620ERG) tmr-echodevice_GetSettings(ECHO_90c8d0da33ad4bbeb80fdf6449fb8d9f) tmr-echodevice_GetSettings(ECHO_G090U50991764CW9) tmr-echodevice_GetSettings(ECHO_G090XG0793052NSQ) tmr-echodevice_GetSettings(ECHO_G070L80875140X87) tmr-echodevice_GetSettings(ECHO_G2A14S03937203EE) tmr-echodevice_GetSettings(ECHO_G2A14S0393620C12) tmr-HttpUtils_Err(N/A) tmr-HttpUtils_Err(N/A) tmr-echodevice_GetSettings(ECHO_G2A14S0393620AXH) tmr-CODE(0x5578b08)(GetUpdate) tmr-CODE(0x5578b08)(GetUpdate) tmr-CODE(0x5578b08)(GetUpdate) tmr-CODE(0x5578b08)(GetUpdate) tmr-CODE(0x5578b08)(GetUpdate) tmr-HMLAN_KeepAlive(HMLANOG) tmr-echodevice_GetSettings(ECHO_d3b98a0809824256ab279c32b326d13f) tmr-MQTT2_CLIENT_keepalive(MQTT_Worx_Poppenricht) tmr-MQTT2_CLIENT_keepalive(MQTT_Worx_Ammersricht) tmr-echodevice_GetSettings(ECHO_G2A14Q0493670BEL) tmr-FHEM::Buienradar::Timer(myBuienRadar) tmr-echodevice_GetSettings(ECHO_G2A14R0393530A2M) tmr-echodevice_GetSettings(ECHO_G2A14R03934302F5) tmr-echodevice_GetSettings(ECHO_8a27c93a556f412eb79a28c4f53e3567) tmr-RESIDENTStk_DurationTimer(Heidi_DurationTimer) tmr-RESIDENTStk_DurationTimer(Nicole_DurationTimer) tmr-echodevice_GetSettings(Echo) tmr-RESIDENTStk_DurationTimer(rg_Peter_DurationTimer) tmr-RESIDENTStk_DurationTimer(rg_Claudia_DurationTimer) tmr-RESIDENTStk_DurationTimer(rg_Peter_Arbeit_DurationTimer) tmr-echodevice_LoginStart(Echo) tmr-SamsungAV_Init(SchlafzimmerTV) tmr-CODE(0x25ee540)(dnsQuery) tmr-HttpUtils_Err(N/A) tmr-HttpUtils_Err(N/A) tmr-HttpUtils_Err(N/A) tmr-HttpUtils_Err(N/A) tmr-HttpUtils_Err(N/A) tmr-HttpUtils_Err(N/A) tmr-HttpUtils_Err(N/A) tmr-HttpUtils_Err(N/A) tmr-HttpUtils_Err(N/A) tmr-HttpUtils_Err(N/A) tmr-HttpUtils_Err(N/A) tmr-HttpUtils_Err(N/A)
2020.12.23 17:22:14 1: Timeout for LGTV_WebOS_PresenceRun reached, terminated process 6891
2020.12.23 17:22:14 3: Fritzbox: http://192.168.178.1/webservices/homeautoswitch.lua?sid=28079b4c5d2b7095&switchcmd=getdevicelistinfos: empty answer received
2020.12.23 17:22:14 3: HMLANEG:keepAlive device opened
2020.12.23 17:22:15 3: HMLANGarage:keepAlive device opened
2020.12.23 17:22:16 3: HMUARTLGW HMLANEG BidCoS-port opened
2020.12.23 17:22:16 3: HMUARTLGW HMLANGarage BidCoS-port opened
2020.12.23 17:22:17 3: HMUARTLGW HMLANGarage:keepAlive KeepAlive-port opened
2020.12.23 17:22:17 3: HMUARTLGW HMLANEG:keepAlive KeepAlive-port opened
2020.12.23 17:22:20 1: [Freezemon] myFreezemon: possible freeze starting at 17:22:18, delay is 2.149 possibly caused by: cb-ParseHttpResponse(myBuienRadar) tmr-HMUARTLGW_StartInit(HMLANGarage) tmr-LGTV_WebOS_GetCurrentChannel(LG_TV) tmr-HttpUtils_Err(N/A)
2020.12.23 17:22:21 1: Timeout for LGTV_WebOS_PresenceRun reached, terminated process 6896
Der Log von freezemon, ist noch viel länger mit immer weiteren freezes:
[Freezemon] myFreezemon: possible freeze starting at 17:17:06, delay is 293.565 possibly caused by: tmr-LGTV_WebOS_TimerStatusRequest(LG_TV) tmr-MQTT2_SERVER_keepaliveChecker(MQTT2_FHEM_Server) tmr-HomeConnect_Timer(LC97FMR60) tmr-HomeConnect_Timer(TI909701HC) tmr-HMUARTLGW_SendKeepAlive(HMLANGarage) tmr-HMUARTLGW_SendKeepAlive(HMLANEG) tmr-HMUARTLGW_CheckCredits(HMLANGarage) tmr-HMUARTLGW_CheckCredits(HMLANEG) tmr-DENON_AVR_ConnectionCheck(Denon) tmr-FBAHAHTTP_Poll(Fritzbox) tmr-CODE(0x5578b08)(GetUpdate) tmr-RESIDENTStk_DurationTimer(rg_Ann_DurationTimer) tmr-RESIDENTStk_DurationTimer(rg_Flo_DurationTimer) tmr-RESIDENTStk_DurationTimer(Gaeste_DurationTimer) tmr-RESIDENTStk_DurationTimer(Chrissi_DurationTimer) tmr-echodevice_GetSettings(ECHO_G090XG0793052QF3) tmr-FHEM::Buienradar::Timer(myBuienRadar) tmr-FW_closeInactiveClients(N/A) tmr-FHEM::Astro::Update(Astro) tmr-echodevice_GetSettings(ECHO_G0911B0592620ERG) tmr-echodevice_GetSettings(ECHO_90c8d0da33ad4bbeb80fdf6449fb8d9f) tmr-echodevice_GetSettings(ECHO_G090U50991764CW9) tmr-echodevice_GetSettings(ECHO_G090XG0793052NSQ) tmr-echodevice_GetSettings(ECHO_G070L80875140X87) tmr-echodevice_GetSettings(ECHO_G2A14S03937203EE) tmr-echodevice_GetSettings(ECHO_G2A14S0393620C12) tmr-echodevice_GetSettings(ECHO_G2A14S0393620AXH) tmr-echodevice_GetSettings(ECHO_G2A14Q0493670BEL) tmr-echodevice_GetSettings(ECHO_G2A14R0393530A2M) tmr-echodevice_GetSettings(ECHO_G2A14R03934302F5) tmr-echodevice_GetSettings(ECHO_8a27c93a556f412eb79a28c4f53e3567) tmr-RESIDENTStk_DurationTimer(Heidi_DurationTimer) tmr-RESIDENTStk_DurationTimer(Nicole_DurationTimer) tmr-echodevice_GetSettings(Echo) tmr-RESIDENTStk_DurationTimer(rg_Peter_DurationTimer) tmr-RESIDENTStk_DurationTimer(rg_Claudia_DurationTimer) tmr-RESIDENTStk_DurationTimer(rg_Peter_Arbeit_DurationTimer) tmr-echodevice_LoginStart(Echo) tmr-SamsungAV_Init(SchlafzimmerTV) tmr-echodevice_GetSettings(ECHO_d3b98a0809824256ab279c32b326d13f) tmr-HMLAN_KeepAlive(HMLANOG)
2020.12.23 17:18:32.119 4: LGTV_WebOS (LG_TV) - run get functions
--- log skips 2.595 secs.
2020.12.23 17:18:34.713 4: BlockingCall (LGTV_WebOS_PresenceRun): created child (6857), uses telnetPort to connect back
2020.12.23 17:18:34.947 4: LGTV_WebOS (LG_TV) - LGTV_WebOS_GetAudioStatus: 0
2020.12.23 17:18:34.965 5: LGTV_WebOS (LG_TV) - Sending command: {"client-key":"48f073a5e3e811c381adaeb30db1f904","uri":["ssap://audio/getStatus"],"type":"request","id":"request_1608740314.94795"}
2020.12.23 17:18:34.967 4: LGTV_WebOS (LG_TV) - WriteFn called
2020.12.23 17:18:34.968 4: LGTV_WebOS (LG_TV) - ���2K{;Q'i|\?-rW2"#8|3x.3|
z1zs1xV*e{{d{-9)i,;G9i;"jA*p# dalV"o6U.tJF*tlAi]5?yiWi:;@.qlW8t; ii}q"kW:u|A?_({8.{3(e9-r5;O
--- log skips 18.141 secs.
2020.12.23 17:18:53.109 5: End notify loop for MQTT2_FHEM_Server
--- log skips 2.062 secs.
Grüße Andy
ZitatIch habe jetzt mal pi-hole und unifi deaktivert und auch die zugehörigen Module disabled.
Und damit selber ins Knie geschossen ? pi-hole in pi-hole "disabled" ?(bedeutet ja nur, dass alle dns-requests zugelassen sind) Oder "abgeschaltet" u. Du hast alles lahmgelegt, mangels verfügbarem dns ? Sieht mir nach letzterem aus. Du müsstest daher für einen Test die Fritte wieder umkonfigurieren(wieder zum DNS machen).
Grüße Markus
Da ich gerade 2x selber damit auf "die Schnauze" gefallen bin:
- Hast Du pi-hole "nativ" oder im Docker laufen?
- wenn Du pi-hole deaktivierst, funktioniert dann noch die Namensauflösung? (z.B. auf dem FHEm-Rechner (Konsolte) ein "host www.nasa.gov") *)
- Nach der Deaktivierung von pi-hole/unifi auch die entsprechenden Devices in fhem deaktiviert (glaube ich laut Log nicht)
- hast Du ansonsten ein Sauberes Netzwerk?
Zitat von: KölnSolar am 23 Dezember 2020, 18:26:41
Und damit selber ins Knie geschossen ?
Das kommt davon wenn mans noch auf die schnelle testen will obwohl die Regierung schon wartend neben einen steht ;D Jetzt ist aber der richtige DNS eingetragen...
Zitat von: Wernieman am 23 Dezember 2020, 20:27:37
- Hast Du pi-hole "nativ" oder im Docker laufen?
- wenn Du pi-hole deaktivierst, funktioniert dann noch die Namensauflösung? (z.B. auf dem FHEm-Rechner (Konsolte) ein "host www.nasa.gov") *)
- Nach der Deaktivierung von pi-hole/unifi auch die entsprechenden Devices in fhem deaktiviert (glaube ich laut Log nicht)
- hast Du ansonsten ein Sauberes Netzwerk?
- pi-hole läuft ganz normal auf dem Raspberry
- ja, das klappt einwandfrei
- ja, die beiden Devices sind beide disabled. Wieso trotzdem tmr-Unifi_DoUpdate(Unifi_Controller) im Log auftaucht habe ich mich auch schon gefragt.
- Davon bin ich bis jetzt zumindest immer ausgegangen ;D
Mit gestoppten pi-hole, unificontroller und deaktivierten fhemdevices kommt es leider trotzdem weiterhin zum freeze:
jump to the end
=========================================================
[Freezemon] myFreezemon: possible freeze starting at 22:07:59, delay is 6.586 possibly caused by: tmr-HomeConnect_Timer(LC97FMR60) tmr-HomeConnect_Timer(TI909701HC) tmr-HMUARTLGW_SendKeepAlive(HMLANEG) tmr-HMUARTLGW_SendKeepAlive(HMLANGarage) tmr-DENON_AVR_ConnectionCheck(Denon)
2020.12.23 22:07:58.169 4: Connection accepted from telnetPort_127.0.0.1_46940
2020.12.23 22:07:58.171 4: MQTT2_FHEM_Server_192.168.1.67_62550 DVES_14E426 PINGREQ
2020.12.23 22:07:58.172 5: LC97FMR60 event channel searching for data, fileno:"24", nfound:"0", loopCounter:"1"
2020.12.23 22:07:58.172 5: LC97FMR60 event channel received no more data
2020.12.23 22:07:58.173 5: TI909701HC event channel searching for data, fileno:"107", nfound:"1", loopCounter:"1"
2020.12.23 22:07:58.173 5: TI909701HC event channel len:"65", received:"3b
data:
event:KEEP-ALIVE
id:SIEMENS-TI909701HC-68A40E15C2B9
"
2020.12.23 22:07:58.174 5: TI909701HC event channel received 3b
data:
event:KEEP-ALIVE
id:SIEMENS-TI909701HC-68A40E15C2B9
2020.12.23 22:07:58.174 5: TI909701HC event channel searching for data, fileno:"107", nfound:"0", loopCounter:"2"
2020.12.23 22:07:58.174 5: TI909701HC event channel received no more data
2020.12.23 22:07:58.178 5: HMUARTLGW HMLANEG:keepAlive send (3): K8e
2020.12.23 22:07:58.178 5: SW: 64d7b6dc83
2020.12.23 22:07:58.181 5: HMUARTLGW HMLANGarage:keepAlive send (3): K61
2020.12.23 22:07:58.181 5: SW: dae6687b51
2020.12.23 22:07:58.184 5: HMUARTLGW HMLANEG:keepAlive read raw (6): 3e4b38650d0a
2020.12.23 22:07:58.185 5: HMUARTLGW HMLANEG:keepAlive read (4): >K8e
2020.12.23 22:07:58.187 5: Cmd: >{BlockingRegisterTelnet($cl,11620)}<
2020.12.23 22:07:58.191 5: HMUARTLGW HMLANGarage:keepAlive read raw (6): 3e4b36310d0a
2020.12.23 22:07:58.192 5: HMUARTLGW HMLANGarage:keepAlive read (4): >K61
2020.12.23 22:07:58.565 4: MQTT2_FHEM_Server_192.168.1.61_49483 DVES_C6C1A9 PINGREQ
2020.12.23 22:07:58.631 4: MQTT2_FHEM_Server_192.168.1.70_50739 DVES_1539B2 PINGREQ
2020.12.23 22:07:58.725 5: DENON_AVR Denon: called ConnectionCheck.
2020.12.23 22:07:58.727 5: SW: 50573f0d
--- log skips 3.020 secs.
2020.12.23 22:08:01.747 5: Cmd: >set HUEDevice65579 off<=========================================================
[Freezemon] myFreezemon: possible freeze starting at 22:00:00, delay is 2.276 possibly caused by: tmr-LGTV_WebOS_Get3DStatus(LG_TV) tmr-DOIF_TimerTrigger(BadOG_Temperatureinstellungen) tmr-Calendar_Wakeup(DP_Andy) tmr-DOIF_TimerTrigger(HeuteRegen)
2020.12.23 21:59:59.099 4: LGTV_WebOS (LG_TV) - LGTV_WebOS_Get3DStatus: 0
2020.12.23 21:59:59.099 5: LGTV_WebOS (LG_TV) - Sending command: {"id":"request_1608757199.09961","type":"request","client-key":"48f073a5e3e811c381adaeb30db1f904","uri":["ssap://com.webos.service.tv.display/get3DStatus"]}
2020.12.23 21:59:59.100 4: LGTV_WebOS (LG_TV) - WriteFn called
2020.12.23 21:59:59.100 4: LGTV_WebOS (LG_TV) - ���2K{;[/"#9ehG.smmz6)
|5.r97r9/i,;F2p|q"kW:u|A?"5(lpW%t4Y.y;i4!T{7*S~e*Ws1(Qx8(S/a|Px0}Pzf "5>rpq[;A8aid/z]&.nW)oj 8ekD"c| ?v7V"si^*y6U.t*vtxF>s;o6
2020.12.23 21:59:59.108 4: LGTV_WebOS (LG_TV) - ReadFn started
2020.12.23 21:59:59.108 4: LGTV_WebOS (LG_TV) - received correct JSON string, start response processing: {"type":"response","id":"request_1608757199.09961","payload":{"returnValue":true,"status3D":{"status":false,"pattern":"2d"}}}
2020.12.23 21:59:59.108 4: LGTV_WebOS (LG_TV) - JSON detected, run LGTV_WebOS_WriteReadings
2020.12.23 21:59:59.108 4: LGTV_WebOS (LG_TV) - Corrected JSON String: {"type":"response","id":"request_1608757199.09961","payload":{"returnValue":true,"status3D":{"status":false,"pattern":"2d"}}}
2020.12.23 21:59:59.108 4: LGTV_WebOS (LG_TV) - Beginn Readings writing
2020.12.23 21:59:59.193 5: JeeLink/RAW: /OK 9 49 1 4 166 106
2020.12.23 21:59:59.523 4: MQTT2_FHEM_Server_192.168.1.20_51198 shellyplug-s-020793 PUBLISH shellies/shellyplug-s-020793/relay/0/energy:1308
2020.12.23 21:59:59.534 4: MQTT2_DEVICE_Parse: Shelly_Plug_1 shellies/shellyplug-s-020793/relay/0/energy => relay_0_energy
2020.12.23 21:59:59.535 4: MQTT2_DEVICE_Parse: Shelly_Plug_1 shellies/shellyplug-s-020793/relay/0/energy => {'relay_0_kWh' => sprintf("%.2f",$EVENT/60/1000)}
--- log skips 2.595 secs.
2020.12.23 22:00:02.130 4: Calendar DP_Andy: Wakeup=========================================================
[Freezemon] myFreezemon: possible freeze starting at 21:20:17, delay is 1.264 possibly caused by: tmr-LGTV_WebOS_Get3DStatus(LG_TV) tmr-CODE(0x25ee540)(dnsQuery) tmr-RESIDENTStk_DurationTimer(rg_Peter_Arbeit_DurationTimer) tmr-echodevice_LoginStart(Echo) tmr-SamsungAV_Init(SchlafzimmerTV)
2020.12.23 21:20:16.028 5: DNS ANSWER 158:707281800001000400000000056c61796c6106616d617a6f6e0264650000010001c00c000500010000031c0012056c61796c6106616d617a6f6e03636f6d00c02d000500010000035b0018027470123739396334333333372d66726f6e74696572c033c04b000500010000003b001f0e64337273717570337463786a31610a636c6f756466726f6e74036e657400c06f000100010000003b0004635601ad
2020.12.23 21:20:16.028 4: DNS result for layla.amazon.de: 99.86.1.173, ttl:59
2020.12.23 21:20:16.028 4: IP: layla.amazon.de -> 99.86.1.173
--- log skips 2.219 secs.
2020.12.23 21:20:18.247 5: HttpUtils request header:
GET /api/bootstrap HTTP/1.1
Host: layla.amazon.de
User-Agent: fhem
Accept-Encoding: gzip,deflate
Connection: keep-alive
Cookie: session-id=259-5433910-0766740; session-id-time=2239473564l; ubid-acbde=260-8657070-6277134; x-acbde=NQ@kqD8MzN?sw6fIjHpAaRA7RnYJANTk; at-acbde=Atza|IwEBIGQbAj27uRMHvT-M1aFu-nG0N6oyqDx_qKxMSMwHB91NqtRZA9ax-bh5WbL3eXUwebPajm-W-3eLJDVrXB7I5Xb98LryasXxCQTe8UtldOPCd7slZKA6LzpIhGacioTBTpbPA6xBYSN53sZIKavwe0Dgxw5NfZmIr1iNxFGua9TN051ozPipMqmrJLbkSdIkI_74yCrcziCdlcspyJ4A_TPJrHuF9RAMchD8LhqfZm4XvytDKQMypXwkPHDTZGLcVEeNaiK2KBCqtjc8q6smqdURbVqKOXAdNE-W8H2bv3TsnNllAfAqzkVFyabwvqbFbbI; sess-at-acbde=ft6//iRkJVlgKn2d5UuDHqXdm156GUyrQ6UuTobPA7o=; csrf=-1229342391
2020.12.23 21:20:18.251 4: LGTV_WebOS (LG_TV) - LGTV_WebOS_Get3DStatus: 0
2020.12.23 21:20:18.251 5: LGTV_WebOS (LG_TV) - Sending command: {"id":"request_1608754818.25162","type":"request","uri":["ssap://com.webos.service.tv.display/get3DStatus"],"client-key":"48f073a5e3e811c381adaeb30db1f904"}
2020.12.23 21:20:18.252 4: LGTV_WebOS (LG_TV) - WriteFn called
2020.12.23 21:20:18.252 4: LGTV_WebOS (LG_TV) - ���2K{;[/"#9ehG.smmz6)
|5-
z87~1/i,;F2p|q"kW:u|A?"5>rpq[;A8aid/z]&.nW)oj 8ekD"c| ?v7V"si^*y6U.t*vtxF>s;og"z^"ewFfk|Ki:;sf)xa,Wxe!zc*
za}S.b*/b(Tr0-6
2020.12.23 21:20:18.259 4: [Echo] [echodevice_LoginStart] Alter COOKIE=1252/6000
2020.12.23 21:20:18.259 4: [Echo] [echodevice_LoginStart] [enable] set next internal timer start in 60 seconds.
2020.12.23 21:20:18.260 5: [Freezemon] myFreezemon: switching callback from CODE(0x71b7550) to CODE(0x7b36068)
2020.12.23 21:20:18.260 5: HttpUtils url=http://192.168.1.17:55000/
2020.12.23 21:20:18.261 4: IP: 192.168.1.17 -> 192.168.1.17
2020.12.23 21:20:18.265 5: [Freezemon] myFreezemon: ----------- Starting Freeze handling at 2020.12.23 21:20:18.265 ---------------------Grüße Andy
irgendwie immer Netzwerk... :-\ Und WLAN ?
FHEM halbwegs aktuell ? Ich frage wegen echodevice. Ist zwar schon lange her, aber da gab es blocking Probleme....
Grüße Markus
Wie meinst du "und WLAN"?
Jep, Update erst heute Früh gemacht.
Internals:
DEF xxx@xxx.xx xxx
FUUID 5d30fa56-f33f-6a35-b4e0-a57a568a87330707
FVERSION 37_echodevice.pm:v5.0.0-s23325/2020-12-11
IODev
LOGINMODE NPM
NAME Echo
NR 504
NTFY_ORDER 50-Echo
STATE connected
TYPE echodevice
model ACCOUNT
Dass es drahtlose Anbindungen sind und nicht per Kabel. Bei WLAN kann man ja nicht immer von stabilen Verbindungen ausgehen.
Wenn ich mich recht entsinne, dann gibt es blockierendes Verhalten(trotz Anwendung sämtlicher Verfahren, die das verhindern/umgehen... sollen) bei der DNS-Abfrage bei TLS(https)-Verbindungen. Im echodevice wurde dann als Lösung die Zugriffsanzahl reduziert u. ich glaube die IPs gecashed.
Oder einfach mal in den Devices anstelle des DNS die IP verwenden ... DNS finde ich zwar persönlich auch besser, aber mal zum Testen ...
Sorry für die späte Rückmeldung.
Zitat von: ch.eick am 23 Dezember 2020, 12:59:27
Ist Deine SD Card am Ende?
Du hattest Recht, die SD-Karte war das Problem. Ich hatte eine Ersatzkarte mit Fhem vorbereitet, Sicherungen kopiert und siehe da, alles läuft problemlos.
Trotzdem danke an alle :)
Andy