57_Calendar - blockiert FHEM

[CoolTux]

Siehe Post vom 26. Mai 2018. Da hat der Kalender 2 Sekunden gebraucht.

Naja da war das Parsen noch mit drin. Ich bilde mir ein das die Anforderung zum holen bis zum erhalt schon so lange dauert. Aber machen wir erstmal bei den anderen Daten weiter.

[Mave]

Ich kann auch ohne Calview für ca. 18 Sekunden in FHEM nichts machen. Und nichts heißt nichts.

[KernSani]

Als alter Freeze-Experte hüpfe ich da mal mit rein... Kannst du mal noch die "Catch"-Attribute bei Freezemon aktivieren?
Bei meinem Kalender fällt da folgendes auf:

Code Auswählen Erweitern


2019.01.21 18:08:23.763 5: CALVIEW AbfallKalView - CALENDAR:AbfallKal successfully got all updates for CALVIEW AbfallKalView (CALVIEW_Notify). Now process updates...
2019.01.21 18:08:23.763 4: [Freezemon] freezemon: Long function call detected NotifyFn:AbfallKalView - 0.625849 seconds

(gut, sind keine 20 Sekunden, aber insgesamt kommt dann doch 1 Sekunde für Kalender update raus, allerdings mit < 100 Einträgen)

[Dr. Boris Neubert]

Ich kann auch ohne Calview für ca. 18 Sekunden in FHEM nichts machen. Und nichts heißt nichts.

Die Wahrheit liegt im Log. Bitte Log zeigen mit drei Einträgen vor und nach dem, was das Calendar-Modul Dir bei einem get ... update schreibt.

[Mave]

Danke KernSani.

Ich habe beide Cache Attribute auf 5 gestellt. Hat sich aber am Log nichts geändert.

[Mave]

Oh Mist.

Was ist das?

Code Auswählen Erweitern

2019.01.21 21:28:59 4: Calendar Kalender_Alexa: Updating...
2019.01.21 21:28:59 4: Calendar Kalender_Alexa: Getting data from URL <hidden>
2019.01.21 21:29:00 5: Calendar Kalender_Alexa: HTTP response code 200
2019.01.21 21:29:00 4: Calendar Kalender_Alexa: parsing data asynchronously (PID= 23428)
2019.01.21 21:29:00 5: Calendar Kalender_Alexa: control passed back to main loop.
2019.01.21 21:29:01 4: Calendar Kalender_Alexa: got result from asynchronous parsing.
2019.01.21 21:29:01 4: Calendar Kalender_Alexa: asynchronous parsing finished.
2019.01.21 21:29:01 4: Calendar Kalender_Alexa: merging data
2019.01.21 21:29:01 4: Calendar Kalender_Alexa: 757 records processed, 0 new, 757 known, 0 modified, 0 changed.
2019.01.21 21:29:01 4: Calendar Kalender_Alexa: creating calendar events
2019.01.21 21:29:02 4: Calendar Kalender_Alexa: Checking times...
2019.01.21 21:29:19 0: [Freezemon] myFreezemon: Long function call detected NotifyFn:LBatt.notify - 16.853519 seconds
2019.01.21 21:29:19 4: Calendar Kalender_Alexa: process ended.

[Mave]

LBatt.notify

Code Auswählen Erweitern

Internals:
   DEF        .*:0.LOW_BAT:.*|.*:0.LOWBAT:.*|.*:[Bb]attery:.*|.*:batteryState:.* { if ($EVENT !~ m/ok/) { fhem "set LBatt.warn $NAME";;Log 3, "$NAME : Batteriewarnung $EVENT" } }
   FUUID      5c4312f0-f33f-fef7-b696-80c893d8428d838c
   NAME       LBatt.notify
   NR         208
   NTFY_ORDER 50-LBatt.notify
   REGEXP     .*:0.LOW_BAT:.*|.*:0.LOWBAT:.*|.*:[Bb]attery:.*|.*:batteryState:.*
   STATE      2019-01-21 21:36:45
   TRIGGERTIME 1548103005.53818
   TYPE       notify
   READINGS:
     2019-01-21 20:44:44   state           active
Attributes:
   group      deviceDetector
   room       Alarm

[Mave]

LBatt.notify disabled. 

Code Auswählen Erweitern

2019.01.21 21:40:58 4: Calendar Kalender_Alexa: Updating...
2019.01.21 21:40:58 4: Calendar Kalender_Alexa: Getting data from URL <hidden>
2019.01.21 21:40:59 5: Calendar Kalender_Alexa: HTTP response code 200
2019.01.21 21:40:59 4: Calendar Kalender_Alexa: parsing data asynchronously (PID= 23882)
2019.01.21 21:40:59 5: Calendar Kalender_Alexa: control passed back to main loop.
2019.01.21 21:41:00 4: Calendar Kalender_Alexa: got result from asynchronous parsing.
2019.01.21 21:41:00 4: Calendar Kalender_Alexa: asynchronous parsing finished.
2019.01.21 21:41:00 4: Calendar Kalender_Alexa: merging data
2019.01.21 21:41:01 4: Calendar Kalender_Alexa: 757 records processed, 0 new, 757 known, 0 modified, 0 changed.
2019.01.21 21:41:01 4: Calendar Kalender_Alexa: creating calendar events
2019.01.21 21:41:02 4: Calendar Kalender_Alexa: Checking times...
2019.01.21 21:41:02 4: Calendar Kalender_Alexa: process ended.

[Mave]

LBatt.notify war schuld am Freeze.....

Wenn mir das jemand erklären kann, ist er mein Held. 

[KernSani]

Wie Boris schon sagte... die Wahrheit liegt im Log . Nur, wieso springt das notify an?

[Mave]

Wie Boris schon sagte... die Wahrheit liegt im Log . Nur, wieso springt das notify an?

Das hätten wir ohne den Cache von Freezemon nie herausgefunden. Vielen Dank dafür.

Aber ich bin echt überfragt, was LBatt.notify da macht.
Es muss mit der Anzahl der Termine zusammenhängen, denn der Abfallkalender mit 100 Terminen wurde nur 3 Sekunden geblockt.

[Mave]

Vielen Dank an alle Helfer. Ihr seid spitze.

[Otto123]

LBatt.notify war schuld am Freeze.....

Wenn mir das jemand erklären kann, ist er mein Held. 

Ich würde da parallel in den Eventmonitor schauen.

Ich hätte den Verdacht, dass das notify auf einen Eintrag im Kalender anspringt und dann auch noch heiß läuft.
So - mit allem was im Event kommt - wieder irgendwo hinschreiben. Schleifenverdächtig

Gruß Otto

[KernSani]

... habe dann auch mal Logs durchgeschaut (habe den Kalender täglich mit einem 1-Sekunden Freeze im Log... habe mich nie wirklich darum gekümmert) und siehe da:

Code Auswählen Erweitern


2019.01.21 18:08:23.732 5: rg_battery: not on any display, ignoring notify


Die readingsGroup hört auf

Code Auswählen Erweitern

.*:battery

Jetzt werde ich neugierig...

[Mave]

Ich werde heute Abend .*:battery aus LBatt.notify entfernen und nochmal testen.

Unfassbar das Ganze....