Nur Text | Text mit Bildern

FHEM Forum

FHEM => Anfängerfragen => Thema gestartet von: ThiemoSt am 14 Juli 2017, 13:07:22

Titel: Mehrfache Freeze am Tag
Beitrag von: ThiemoSt am 14 Juli 2017, 13:07:22
Hallo Zusammen,

ich habe ab und zu den Fall das meine DOIF's nicht ausgeführt werden. Sobald ich dann das eigentlich auslösende Event nochmal triggere wird das jeweilige DOIF ausgelöst.
Daher bin ich auf den Gedanken gekommen das FHEM in der Zeit des Events einfach nicht reagiert.
Mit Perfmon habe ich dann auch einige Freeze festgestellt. Hier jetzt mal ein Ausschnitt von denen welche heute morgen waren (mit verbose 4):

Code Auswählen
2017.07.14 01:13:43.091 4: HttpUtils url=https://query.yahooapis.com/v1/public/yql?q=select%20*%20from%20weather.forecast%20where%20woeid=12834409%20and%20u=%27c%27&format=json&env=store%3A%2F%2Fdatatables.org%2Falltableswithkeys
2017.07.14 01:13:48.239 4: ESPEasy ESPEasy_Wemos_Garage_Switch: set statusRequest
2017.07.14 01:13:48.246 4: ESPEasy ESPEasy_Wemos_Garage_Switch: presence: absent
2017.07.14 01:13:48.254 1: Perfmon: possible freeze starting at 01:13:44, delay is 4.253


Code Auswählen
2017.07.14 02:07:59.122 4: HttpUtils url=https://api.netatmo.com/oauth2/token
2017.07.14 02:07:59.124 4: HttpUtils url=https://api.netatmo.com/api/getmeasure
2017.07.14 02:07:59.127 4: HttpUtils url=https://api.netatmo.com/oauth2/token
2017.07.14 02:07:59.129 4: HttpUtils url=https://api.netatmo.com/api/getmeasure
2017.07.14 02:07:59.132 4: HttpUtils url=https://api.netatmo.com/oauth2/token
2017.07.14 02:07:59.134 4: HttpUtils url=https://api.netatmo.com/api/getmeasure
2017.07.14 02:07:59.137 4: HttpUtils url=https://api.netatmo.com/oauth2/token
2017.07.14 02:07:59.139 4: HttpUtils url=https://api.netatmo.com/api/getmeasure
2017.07.14 02:07:59.896 4: https://api.netatmo.com/oauth2/token: HTTP response code 200
2017.07.14 02:07:59.896 4: HttpUtils https://api.netatmo.com/oauth2/token: Got data, length: 364
2017.07.14 02:07:59.948 4: https://api.netatmo.com/api/getmeasure: HTTP response code 200
2017.07.14 02:07:59.949 4: HttpUtils https://api.netatmo.com/api/getmeasure: Got data, length: 253
2017.07.14 02:08:02.106 1: Perfmon: possible freeze starting at 02:08:01, delay is 1.105



Code Auswählen
017.07.14 05:49:04.082 4: using HttpUtils_NonblockingGet: PUT lights/1/state
2017.07.14 05:49:04.083 4: HttpUtils url=http://192.168.0.194/api/yTHYhqwp-wOvSCeLMZd0AP5OaJ4PYmyjGJsTZAC9/lights/1/state
2017.07.14 05:49:06.101 4: http://192.168.0.194/api/yTHYhqwp-wOvSCeLMZd0AP5OaJ4PYmyjGJsTZAC9/lights/1/state: HTTP response code 200
2017.07.14 05:49:06.102 4: HttpUtils http://192.168.0.194/api/yTHYhqwp-wOvSCeLMZd0AP5OaJ4PYmyjGJsTZAC9/lights/1/state: Got data, length: 172
2017.07.14 05:49:06.890 4: DENON_AVR OG.wz.HE.Denon: parsing <NSE0Online Music> to <set readings to '-'>.
2017.07.14 05:49:06.890 4: DENON_AVR OG.wz.HE.Denon: parsing <NSE1 Favorites> to <unknown>.
2017.07.14 05:49:06.890 4: DENON_AVR OG.wz.HE.Denon: parsing <NSE2Internet Radio> to <unknown>.
2017.07.14 05:49:06.890 4: DENON_AVR OG.wz.HE.Denon: parsing <NSE3Flickr> to <unknown>.
2017.07.14 05:49:06.891 4: DENON_AVR OG.wz.HE.Denon: parsing <NSE4Media Server> to <unknown>.
2017.07.14 05:49:06.891 4: DENON_AVR OG.wz.HE.Denon: parsing <NSE5> to <unknown message - NSE5>.
2017.07.14 05:49:06.891 4: DENON_AVR OG.wz.HE.Denon: parsing <NSE6> to <unknown message - NSE6>.
2017.07.14 05:49:06.891 4: DENON_AVR OG.wz.HE.Denon: parsing <NSE7> to <unknown message - NSE7>.
2017.07.14 05:49:06.891 4: DENON_AVR OG.wz.HE.Denon: parsing <NSE8 [ 0/4 ]> to <unknown>.
2017.07.14 05:49:11.840 1: Perfmon: possible freeze starting at 05:49:07, delay is 4.84
2017.07.14 05:49:11.841 4: using HttpUtils_NonblockingGet: GET lights/1
2017.07.14 05:49:11.841 4: HttpUtils url=http://192.168.0.194/api/yTHYhqwp-wOvSCeLMZd0AP5OaJ4PYmyjGJsTZAC9/lights/1
2017.07.14 05:49:16.286 1: Perfmon: possible freeze starting at 05:49:12, delay is 4.286


Code Auswählen
2017.07.14 06:04:01.730 4: http://192.168.0.194/api/yTHYhqwp-wOvSCeLMZd0AP5OaJ4PYmyjGJsTZAC9/lights/2/state: HTTP response code 200
2017.07.14 06:04:01.730 4: HttpUtils http://192.168.0.194/api/yTHYhqwp-wOvSCeLMZd0AP5OaJ4PYmyjGJsTZAC9/lights/2/state: Got data, length: 167
2017.07.14 06:04:02.872 4: using HttpUtils_NonblockingGet: GET lights/2
2017.07.14 06:04:02.872 4: HttpUtils url=http://192.168.0.194/api/yTHYhqwp-wOvSCeLMZd0AP5OaJ4PYmyjGJsTZAC9/lights/2
2017.07.14 06:04:04.160 1: Perfmon: possible freeze starting at 06:04:03, delay is 1.159


Code Auswählen
2017.07.14 06:15:30.017 4: HttpUtils url=https://api.netatmo.com/api/getmeasure
2017.07.14 06:15:30.019 4: HttpUtils url=https://api.netatmo.com/api/getmeasure
2017.07.14 06:15:30.022 4: HttpUtils url=https://api.netatmo.com/api/getmeasure
2017.07.14 06:15:30.024 4: HttpUtils url=https://api.netatmo.com/api/getmeasure
2017.07.14 06:15:33.354 1: Perfmon: possible freeze starting at 06:15:31, delay is 2.354


Es gibt auch Zeiten wo ich über Minuten keinen Zugriff per Web habe. Aktuell war auch gerade wieder so ein Fall. Im Log ist aber kein Freeze erkennbar.
FHEM arbeitet aber in dieser Zeit weiter. Ich habe einen externen Server welcher minütlich einen Heartbeat abgibt, bleibt dieser aus bekomme ich eine Nachricht per Pushover. Diese wird zugestellt in der Zeit wo ich keinen Zugriff per Web habe.


Kann es sein das dieses Verhalten durch die Freeze kommt? Und kann ich etwas dagegen tun?

Gruß Thiemo
Titel: Antw:Mehrfache Freeze am Tag
Beitrag von: Morgennebel am 14 Juli 2017, 16:59:12
Da perfmon den Freeze meldet, exakt nachdem der Denon abgefragt wird - deaktivere den doch mal und schau mal, ob der Fehler wandert oder weg ist...

Ciao, -MN
Nur Text | Text mit Bildern