Twilight Weather timeouts

[HolyMoly]

Hallo,

seit den Änderungen an Twilight am 2014.12.18 bekomme ich ständige timeouts:

Code Auswählen Erweitern

TwilightDevice get weather result connect to http://weather.yahooapis.com:80 timed out
Das weather Modul welches ja auch mit der yahoo api läuft hat keine Probleme.
Tritt das Problem sonst noch bei jemandem auf? Lässt sich da was machen?

[Dietmar63]

Es wurde durch mich auf hermannj Vorschlag hin auf HTTP NON Blocking() umgestellt. Bei mir läuft es seit Tagen problemlos.

[herrmannj]

Hi,

und ich hab auch versprochen das ich den Kopf dafür hinhalte 

Wie oft ist ständig?
Magst Du bitte mal kurz die Zeitpunkte der letzten 24(48)h rein stellen ? (oder wenn Du Dir die Arbeit sparen möchtest kurz log aus dem Zeitraum an hängen, geht per grep fix.)

Danke und Grüße
Jörg

[herrmannj]

btw, das kann auch yahoo selber sein. Ich bin vorhin laaaange Zeit nicht in das developer network gekommen: immer "internal error sonstwas" von denen (!)

vg
jörg

[HolyMoly]

Anbei die gewünschten Logs. Jetzt fällt mir auf dass das time out immer dann auftritt wenn fhem frisch gestartet wurde z.B. bei mir um 8 h nach dem Update. Wie man sieht gönnt sich HTTPMOD auch öfter mal ein timeout, die scheinen aber oft einfach überlastet zu sein. Das ganze läuft auf einem Quadcore ARM9 direkt an einer 50 mbit Vdsl2 Leitung.

---
2014.12.12 19:01:26 3: HTTPMOD got error in callback: connect to http://www.clever-tanken.de:80 timed out
2014.12.12 20:01:28 3: HTTPMOD got error in callback: read from http://www.clever-tanken.de:80 timed out
Error read from http://www.clever-tanken.de:80 timed out
Error read from http://www.clever-tanken.de:80 timed out
Error connect to http://www.clever-tanken.de:80 timed out
Error read from http://www.clever-tanken.de:80 timed out
2014.12.18 08:00:26 2: Wohnzimmer.twilight get weather result connect to http://weather.yahooapis.com:80 timed out
2014.12.19 08:00:41 2: Wohnzimmer.twilight get weather result connect to http://weather.yahooapis.com:80 timed out
2014.12.20 08:00:48 2: Wohnzimmer.twilight get weather result connect to http://weather.yahooapis.com:80 timed out
2014.12.20 11:57:47 2: Wohnzimmer.twilight get weather result connect to http://weather.yahooapis.com:80 timed out
2014.12.21 08:00:37 2: Wohnzimmer.twilight get weather result connect to http://weather.yahooapis.com:80 timed out
2014.12.21 10:01:36 2: Wohnzimmer.twilight get weather result connect to http://weather.yahooapis.com:80 timed out
2014.12.21 10:53:30 2: Wohnzimmer.twilight get weather result connect to http://weather.yahooapis.com:80 timed out
2014.12.21 10:55:47 2: Wohnzimmer.twilight get weather result connect to http://weather.yahooapis.com:80 timed out
2014.12.21 10:56:18 2: Wohnzimmer.twilight get weather result connect to http://weather.yahooapis.com:80 timed out
2014.12.21 10:56:37 2: Wohnzimmer.twilight get weather result connect to http://weather.yahooapis.com:80 timed out
2014.12.21 10:59:24 2: Wohnzimmer.twilight get weather result connect to http://weather.yahooapis.com:80 timed out
2014.12.21 11:06:54 2: Wohnzimmer.twilight get weather result connect to http://weather.yahooapis.com:80 timed out
2014.12.21 14:31:44 2: Wohnzimmer.twilight get weather result connect to http://weather.yahooapis.com:80 timed out
2014.12.22 08:00:34 2: Wohnzimmer.twilight get weather result connect to http://weather.yahooapis.com:80 timed out
2014.12.22 10:41:12 2: Wohnzimmer.twilight get weather result connect to http://weather.yahooapis.com:80 timed out
Error connect to http://www.clever-tanken.de:80 timed out
2014.12.22 11:18:31 2: Wohnzimmer.twilight get weather result connect to http://weather.yahooapis.com:80 timed out
Error connect to http://www.clever-tanken.de:80 timed out
Error connect to http://www.clever-tanken.de:80 timed out
2014.12.22 12:38:50 2: Wohnzimmer.twilight get weather result connect to http://weather.yahooapis.com:80 timed out
Error connect to http://www.clever-tanken.de:80 timed out
Error read from http://www.clever-tanken.de:80 timed out
Error read from http://www.clever-tanken.de:80 timed out
2014.12.22 17:41:35 2: Wohnzimmer.twilight get weather result connect to http://weather.yahooapis.com:80 timed out
2014.12.22 20:07:14 2: Wohnzimmer.twilight get weather result connect to http://weather.yahooapis.com:80 timed out
Error connect to http://www.clever-tanken.de:80 timed out
Error read from http://www.clever-tanken.de:80 timed out
2014.12.23 09:44:07 2: Wohnzimmer.twilight get weather result connect to http://weather.yahooapis.com:80 timed out
Error read from http://www.clever-tanken.de:80 timed out
2014.12.23 14:00:35 2: Wohnzimmer.twilight get weather result connect to http://weather.yahooapis.com:80 timed out
Error read from http://www.clever-tanken.de:80 timed out
2014.12.24 08:00:32 2: Wohnzimmer.twilight get weather result connect to http://weather.yahooapis.com:80 timed out
2014.12.24 11:41:53 2: Wohnzimmer.twilight get weather result connect to http://weather.yahooapis.com:80 timed out
2014.12.25 08:00:28 2: Wohnzimmer.twilight get weather result connect to http://weather.yahooapis.com:80 timed out
2014.12.26 08:00:37 2: Wohnzimmer.twilight get weather result connect to http://weather.yahooapis.com:80 timed out
2014.12.26 17:23:32 2: Wohnzimmer.twilight get weather result connect to http://weather.yahooapis.com:80 timed out
Error read from http://www.clever-tanken.de:80 timed out
Error read from http://www.clever-tanken.de:80 timed out
2014.12.27 08:00:49 2: Wohnzimmer.twilight get weather result connect to http://weather.yahooapis.com:80 timed out
Error read from http://www.clever-tanken.de:80 timed out

Nachtrag: ich denke nicht dass es Yahoo selber ist, denn dann käme es nicht immer direkt nach nem Serverneustart und wäre vor dem 18 wohl auch schon so gewesen.

[herrmannj]

Ah cool Danke, 

gehst Du mit wenn ich sage das wir uns die Sache mit dem timeout nach Neustart anschauen , der Rest sind echte timeouts ?

vg
jörg

[HolyMoly]

Bin ich ganz deiner Meinung 

[Dietmar63]

Warum führst du ständig Neustarts durch.
Dass an Yahoo liegt bezweifle ich, clever-tanken ist auch betroffen.

Wie führst du den Neustart durch? Vielleicht steht deine Internetverbindung dann nicht richtig.

[Dietmar63]

Twilight greift nur 3 mal am Tag auf Yahoo zu.

Gegen Mitternacht, und jeweils eine Stunde vor den berechneten ss, sr.

[herrmannj]

Hi Dietmar,

ich hatte doch vor einigen Tagen auch einen timeout - der war auch direkt nach Neustart. Ich schau da gern rein, vlt hilft es den Timeout hoch zusetzen (evtl so wie Du sagst Netz noch nich da oder fhem trötelt ein wenig, who knows ..). Ist ja unkritisch, das Wetter wird ja geladen, aber isch guck ma


vg
jörg

[HolyMoly]

Naja einmal täglich nach dem Update ist Neustart ja quasi Pflicht. Ausserdem kann es durchaus mal passieren dass der kleine Server aus anderen Gründen neu gestartet wird... 
Das Internet wird per Kabel stabil von meiner Fritzbox 7490 bereitgestellt auf der sonst gar nichts mehr läuft. Neustarts mache ich in fhem per "shutdown restart", in der shell mit "reboot" oder ganz brachial "mit Stecker raus" ^^. Ich denke das twilight Modul versucht nach dem restart zu früh die http Funktionen von fhem zu nutzen. Vielleicht müssten man auf eine Art httpInitialized oder so warten...

[Dietmar63]

Aber da sehe ich keinen großen Unterschied zur vorherigen Version. Es wird nur eine andere Methode des Zugriffs verwendet. Der timeout scheint mir bei der jetzigen Version von TW noch etwas länger eingestellt zu sein.

Mysteriös!
Vielleicht wird fhem bei dir so früh ausgeführt dass das Netzwerk noch nicht steht.

Auf meiner FB kein Problem. Restarts führe ich praktisch nie durch.

[HolyMoly]

Vielleicht wird fhem bei dir so früh ausgeführt dass das Netzwerk noch nicht steht.

Naja, bei einem "shutdown restart" wird ja die Netzwerkverbindung nicht wirklich unterbrochen. Ich schätze Twilight fragt Daten an bevor HTTP NON Blocking korrekt initialisiert ist.

[Dietmar63]

Ich habe den Fehler teilweise heute auch beim restart bekommen.

Ich glaube es liegt daran, dass TW früh beim Hochfahren von fhem aktiviert wird.
Da der http-Zugriff nicht mehr blockt geht es gleich weiter - mit der Definition anderer Geräte.

Dafür reicht die Hardware beim restart nicht, so dass es  beim WEB-Zugriff zu Verzögerungen kommt.
Man müsste also den timeout in  der Restartphase hochsetzen, dann sollte es weniger Probleme geben.
Mal sehen, ob ich da was machen kann.

Die neueste Version von HttpUtils vermeidet das Problem schon weitestgehend  - also mal mit einem update versuchen.

Das dürfte für alle Web-Zugriffe in der Startphase gelten, sofern sie Non-Blocking  erfolgen.

[HolyMoly]

Grad eben wieder:
2014.12.30 17:36:14 2: Wohnzimmer.twilight get weather result connect to http://weather.yahooapis.com:80 timed out