FBAHAHTTP - keine Reaktion auf Befehle, obwohl connected

[snoopy]

Hallo zusammen,

am 21.09. habe ich meine FHEM-Installation per Update-Befehl aktualisiert und das FBAHAHTTP-Modul erstmals erhalten und sofort eingerichtet.
Soweit so gut... es lief direkt nach 5 Minuten und ich war begeistert, jetzt auch meine DECT200 steuern zu können.
Nun folgendes Problem: nach einem Tag reagieren die DECT200 einfach nicht mehr auf die Schaltbefehle. Der Status wechselt sofort auf ON, aber der Befehl kommt nicht an, spricht der Schalter bleibt einfach aus. Ich kann munter zwischen ON/OFF hin- und herschalten, ohne dass ein Befehl ankommt. Der Status des fbahahttp-Device bleibt immer auf connected.

Das Device habe ich wie folgt definiert:

define fbahahttp FBAHAHTTP 192.168.188.1
attr fbahahttp disabledForIntervals 00:00-06:00
attr fbahahttp fritzbox-user fhem
attr fbahahttp polltime 180


Ich muss nur einmal die fhem.cfg (ohne Änderungen!) speichern, danach funktioniert das Schalten der DECT200 wieder einwandfrei.
Was kann das sein?? Wacht das Device evtl. nach dem disable-Interval nicht wieder richtig auf?

Fritz!Box 7490 mit OS 6.60
fhem.pl 12191 2016-09-21 19:02:22Z rudolfkoenig
00_FBAHAHTTP.pm   12027 2016-08-21 12:05:23Z rudolfkoenig

Danke vorab und viele Grüße
Marco

[rudolfkoenig]

Code Auswählen Erweitern

Ich muss nur einmal die fhem.cfg (ohne Änderungen!) speichern, danach funktioniert das Schalten der DECT200 wieder einwandfrei.

Was genau meinst du damit? "Save" oben links klicken, oder fhem.cfg in FHEMWEB editieren (Tststs...) und da "Save fhem.cfg" klicken? Beim Letzteren wird de-facto FHEM neu gestartet, einer der Gruende, warum das fuer Anfaenger nicht empfohlen wird.

Kann man in so einem Fall direkt am Fritzbox verzoegerungsfrei schalten?
Kannst du bitte fuer die FBAHAHTTP Instanz verbose auf 5 setzen, und ein Log-Ausschnitt im Problemfall melden?

Ich habe am 19.6. AVM bereits zwei aehnliche Probleme gemeldet
   https://forum.fhem.de/index.php/topic,54741
   https://forum.fhem.de/index.php?topic=54697
bisher leider ohne Reaktion von AVM.

[snoopy]

Hallo Rudolf,

du hast Recht, ich habe bei Edit Files --> fhem.cfg editiert und gespeichert  Das mit dem Restart von FHEM nach dem Speichern hatte ich schon vermutet... sieht man ja im Logfile, dass alles neu initialisiert wird

Hier die Ausgabe im Logfile im Fehlerfall (Schalten über Fritzbox funktioniert auch dann ohne Probleme):
2016.10.04 23:01:04 3: FBDECT set Lampe_Wohnzimmer on
2016.10.04 23:01:04 5: FBAHAHTTP_Write reply for fbahahttp:
2016.10.04 23:04:11 3: FBDECT set Lampe_Wohnzimmer on
2016.10.04 23:04:11 5: FBAHAHTTP_Write reply for fbahahttp:
2016.10.04 23:04:17 3: FBDECT set Lampe_Wohnzimmer off
2016.10.04 23:04:17 5: FBAHAHTTP_Write reply for fbahahttp:

wenn es läuft (z.B. nach Restart von FHEM)
2016.10.04 23:04:49 3: FBDECT set Lampe_Wohnzimmer on
2016.10.04 23:04:49 5: FBAHAHTTP_Write reply for fbahahttp: 1
2016.10.04 23:05:57 3: FBDECT set Lampe_Wohnzimmer off
2016.10.04 23:05:57 5: FBAHAHTTP_Write reply for fbahahttp: 0


Gruß
Marco

[rudolfkoenig]

Kannst du bitte dann, wenn das Problem auftritt (bzw. Write roply leer ist) folgendes ausfuehren:

set FBAHAHTTP password <password>

Dieses Befehl loescht das Session-Id, und holt es neu.
Falls das hilft, dann laeuft session id ab, und muss erneuert werden, das kann ich dann automatisieren.

[Brice]

Das Verhalten tritt hier auch unregelmaßig auf

Code Auswählen Erweitern

2016.10.08 09:05:23 3: FBDECT set MediaCenter on
2016.10.08 09:05:27 3: JollyBeach: read from http://fritz.box:80 timed out
2016.10.08 09:05:32 3: FBDECT set MediaCenter on
2016.10.08 09:05:32 1: JollyBeach: Not connected, wont execute setswitchon
2016.10.08 09:05:35 3: FBDECT set MediaCenter on
2016.10.08 09:05:35 1: JollyBeach: Not connected, wont execute setswitchon

Nach einem

Code Auswählen Erweitern

set JollyBeach password <password> funktioniert es wieder.

[rudolfkoenig]

Ich habe jetzt bei set und beim regelmaessigen Poll ein reconnect eingebaut.

Da ich sie Aenderung nicht direkt testen kann, kann sein, dass sie im Ernstfall nicht das tut, was sie soll, deswegen bitte beobachten.

[Brice]

Danke.
Ich werde es beobachten und melde mich ggfls.

[snoopy]

bei mir funktioniert es ebenfalls nach einem

Code Auswählen Erweitern


set fbahahttp password ...


[rudolfkoenig]

Na hoffentlich nach dem heutigen update braucht man das nicht mehr.

[snoopy]

ich habe das Modul 00_FBAHATTP gestern aktualisiert. Leider war der Fehler heute morgen wieder genauso vorhanden
Die Ausgabe im Logfile ist wieder identisch (siehe mein Post vom 04.10.)

Irgendwie habe ich das Gefühl, es könnte was damit zu tun haben

Code Auswählen Erweitern

attr fbahahttp disabledForIntervals 00:00-06:00

Ich werde heute Abend mal den Parameter entfernen und schauen, ob es morgen früh dann funktioniert.

Grüße

[rudolfkoenig]

Disabled darf nicht die Ursache sein.
Kannst du bitte ein Log mit "attr fbahahttp verbose 5" hier anhaengen?

[snoopy]

Hi,

ich hatte das Attribut disabledForIntervals entfernt und das Problem trat dann kommenden Morgen nicht auf.
Jetzt habe ich das Attribut wieder gesetzt und der Fehler war am nächsten Morgen wieder vorhanden.

Hier der Auszug aus dem FHEM log.
Um 23:04 hat der Schaltvorgang noch funktioniert. Bis Mitternacht sieht man noch die regelmäßigen Poll Request.
Ab Mitternacht bis 6 Uhr morgens lief mein disabledForInterval. Die Schaltbefehle um 7:45 blieben dann ohne Reaktion.

Code Auswählen Erweitern

2016.10.13 23:04:05 3: FBDECT set Lampe_Wohnzimmer off
2016.10.13 23:04:05 5: FBAHAHTTP_Write reply for fbahahttp: 0
2016.10.13 23:04:59 5: fbahahttp dispatch <device identifier="08761 0004497" id="16" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Router Arbeitszimmer</name><switch><state>0</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>0</power><energy>309607</energy></powermeter><temperature><celsius>185</celsius><offset>0</offset></temperature></device>
2016.10.13 23:04:59 5: fbahahttp dispatch <device identifier="08761 0130186" id="17" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Lampe Wohnzimmer</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>6948</energy></powermeter><temperature><celsius>235</celsius><offset>0</offset></temperature></device>
2016.10.13 23:07:59 5: fbahahttp dispatch <device identifier="08761 0004497" id="16" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Router Arbeitszimmer</name><switch><state>0</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>0</power><energy>309607</energy></powermeter><temperature><celsius>185</celsius><offset>0</offset></temperature></device>
2016.10.13 23:07:59 5: fbahahttp dispatch <device identifier="08761 0130186" id="17" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Lampe Wohnzimmer</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>6948</energy></powermeter><temperature><celsius>235</celsius><offset>0</offset></temperature></device>
2016.10.13 23:10:59 5: fbahahttp dispatch <device identifier="08761 0004497" id="16" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Router Arbeitszimmer</name><switch><state>0</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>0</power><energy>309607</energy></powermeter><temperature><celsius>185</celsius><offset>0</offset></temperature></device>
2016.10.13 23:10:59 5: fbahahttp dispatch <device identifier="08761 0130186" id="17" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Lampe Wohnzimmer</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>6948</energy></powermeter><temperature><celsius>235</celsius><offset>0</offset></temperature></device>
2016.10.13 23:13:59 5: fbahahttp dispatch <device identifier="08761 0004497" id="16" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Router Arbeitszimmer</name><switch><state>0</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>0</power><energy>309607</energy></powermeter><temperature><celsius>185</celsius><offset>0</offset></temperature></device>
2016.10.13 23:13:59 5: fbahahttp dispatch <device identifier="08761 0130186" id="17" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Lampe Wohnzimmer</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>6948</energy></powermeter><temperature><celsius>235</celsius><offset>0</offset></temperature></device>
2016.10.13 23:16:59 5: fbahahttp dispatch <device identifier="08761 0004497" id="16" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Router Arbeitszimmer</name><switch><state>0</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>0</power><energy>309607</energy></powermeter><temperature><celsius>185</celsius><offset>0</offset></temperature></device>
2016.10.13 23:16:59 5: fbahahttp dispatch <device identifier="08761 0130186" id="17" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Lampe Wohnzimmer</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>6948</energy></powermeter><temperature><celsius>235</celsius><offset>0</offset></temperature></device>
2016.10.13 23:19:59 5: fbahahttp dispatch <device identifier="08761 0004497" id="16" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Router Arbeitszimmer</name><switch><state>0</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>0</power><energy>309607</energy></powermeter><temperature><celsius>185</celsius><offset>0</offset></temperature></device>
2016.10.13 23:19:59 5: fbahahttp dispatch <device identifier="08761 0130186" id="17" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Lampe Wohnzimmer</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>6948</energy></powermeter><temperature><celsius>230</celsius><offset>0</offset></temperature></device>
2016.10.13 23:22:59 5: fbahahttp dispatch <device identifier="08761 0004497" id="16" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Router Arbeitszimmer</name><switch><state>0</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>0</power><energy>309607</energy></powermeter><temperature><celsius>185</celsius><offset>0</offset></temperature></device>
2016.10.13 23:22:59 5: fbahahttp dispatch <device identifier="08761 0130186" id="17" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Lampe Wohnzimmer</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>6948</energy></powermeter><temperature><celsius>235</celsius><offset>0</offset></temperature></device>
2016.10.13 23:25:59 5: fbahahttp dispatch <device identifier="08761 0004497" id="16" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Router Arbeitszimmer</name><switch><state>0</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>0</power><energy>309607</energy></powermeter><temperature><celsius>185</celsius><offset>0</offset></temperature></device>
2016.10.13 23:25:59 5: fbahahttp dispatch <device identifier="08761 0130186" id="17" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Lampe Wohnzimmer</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>6948</energy></powermeter><temperature><celsius>235</celsius><offset>0</offset></temperature></device>
2016.10.13 23:28:59 5: fbahahttp dispatch <device identifier="08761 0004497" id="16" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Router Arbeitszimmer</name><switch><state>0</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>0</power><energy>309607</energy></powermeter><temperature><celsius>185</celsius><offset>0</offset></temperature></device>
2016.10.13 23:28:59 5: fbahahttp dispatch <device identifier="08761 0130186" id="17" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Lampe Wohnzimmer</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>6948</energy></powermeter><temperature><celsius>240</celsius><offset>0</offset></temperature></device>
2016.10.13 23:31:59 5: fbahahttp dispatch <device identifier="08761 0004497" id="16" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Router Arbeitszimmer</name><switch><state>0</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>0</power><energy>309607</energy></powermeter><temperature><celsius>185</celsius><offset>0</offset></temperature></device>
2016.10.13 23:31:59 5: fbahahttp dispatch <device identifier="08761 0130186" id="17" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Lampe Wohnzimmer</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>6948</energy></powermeter><temperature><celsius>245</celsius><offset>0</offset></temperature></device>
2016.10.13 23:34:59 5: fbahahttp dispatch <device identifier="08761 0004497" id="16" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Router Arbeitszimmer</name><switch><state>0</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>0</power><energy>309607</energy></powermeter><temperature><celsius>185</celsius><offset>0</offset></temperature></device>
2016.10.13 23:34:59 5: fbahahttp dispatch <device identifier="08761 0130186" id="17" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Lampe Wohnzimmer</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>6948</energy></powermeter><temperature><celsius>245</celsius><offset>0</offset></temperature></device>
2016.10.13 23:37:59 5: fbahahttp dispatch <device identifier="08761 0004497" id="16" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Router Arbeitszimmer</name><switch><state>0</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>0</power><energy>309607</energy></powermeter><temperature><celsius>185</celsius><offset>0</offset></temperature></device>
2016.10.13 23:37:59 5: fbahahttp dispatch <device identifier="08761 0130186" id="17" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Lampe Wohnzimmer</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>6948</energy></powermeter><temperature><celsius>245</celsius><offset>0</offset></temperature></device>
2016.10.13 23:40:59 5: fbahahttp dispatch <device identifier="08761 0004497" id="16" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Router Arbeitszimmer</name><switch><state>0</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>0</power><energy>309607</energy></powermeter><temperature><celsius>185</celsius><offset>0</offset></temperature></device>
2016.10.13 23:40:59 5: fbahahttp dispatch <device identifier="08761 0130186" id="17" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Lampe Wohnzimmer</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>6948</energy></powermeter><temperature><celsius>245</celsius><offset>0</offset></temperature></device>
2016.10.13 23:43:59 5: fbahahttp dispatch <device identifier="08761 0004497" id="16" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Router Arbeitszimmer</name><switch><state>0</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>0</power><energy>309607</energy></powermeter><temperature><celsius>185</celsius><offset>0</offset></temperature></device>
2016.10.13 23:43:59 5: fbahahttp dispatch <device identifier="08761 0130186" id="17" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Lampe Wohnzimmer</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>6948</energy></powermeter><temperature><celsius>245</celsius><offset>0</offset></temperature></device>
2016.10.13 23:46:59 5: fbahahttp dispatch <device identifier="08761 0004497" id="16" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Router Arbeitszimmer</name><switch><state>0</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>0</power><energy>309607</energy></powermeter><temperature><celsius>185</celsius><offset>0</offset></temperature></device>
2016.10.13 23:46:59 5: fbahahttp dispatch <device identifier="08761 0130186" id="17" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Lampe Wohnzimmer</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>6948</energy></powermeter><temperature><celsius>245</celsius><offset>0</offset></temperature></device>
2016.10.13 23:49:59 5: fbahahttp dispatch <device identifier="08761 0004497" id="16" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Router Arbeitszimmer</name><switch><state>0</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>0</power><energy>309607</energy></powermeter><temperature><celsius>185</celsius><offset>0</offset></temperature></device>
2016.10.13 23:49:59 5: fbahahttp dispatch <device identifier="08761 0130186" id="17" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Lampe Wohnzimmer</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>6948</energy></powermeter><temperature><celsius>245</celsius><offset>0</offset></temperature></device>
2016.10.13 23:52:59 5: fbahahttp dispatch <device identifier="08761 0004497" id="16" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Router Arbeitszimmer</name><switch><state>0</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>0</power><energy>309607</energy></powermeter><temperature><celsius>190</celsius><offset>0</offset></temperature></device>
2016.10.13 23:52:59 5: fbahahttp dispatch <device identifier="08761 0130186" id="17" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Lampe Wohnzimmer</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>6948</energy></powermeter><temperature><celsius>245</celsius><offset>0</offset></temperature></device>
2016.10.13 23:55:59 5: fbahahttp dispatch <device identifier="08761 0004497" id="16" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Router Arbeitszimmer</name><switch><state>0</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>0</power><energy>309607</energy></powermeter><temperature><celsius>190</celsius><offset>0</offset></temperature></device>
2016.10.13 23:55:59 5: fbahahttp dispatch <device identifier="08761 0130186" id="17" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Lampe Wohnzimmer</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>6948</energy></powermeter><temperature><celsius>245</celsius><offset>0</offset></temperature></device>
2016.10.13 23:58:59 5: fbahahttp dispatch <device identifier="08761 0004497" id="16" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Router Arbeitszimmer</name><switch><state>0</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>0</power><energy>309607</energy></powermeter><temperature><celsius>190</celsius><offset>0</offset></temperature></device>
2016.10.13 23:58:59 5: fbahahttp dispatch <device identifier="08761 0130186" id="17" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Lampe Wohnzimmer</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>6948</energy></powermeter><temperature><celsius>245</celsius><offset>0</offset></temperature></device>
2016.10.14 07:45:01 3: FBDECT set Lampe_Wohnzimmer on
2016.10.14 07:45:01 5: FBAHAHTTP_Write reply for fbahahttp:
2016.10.14 07:45:02 5: FBAHAHTTP_Write reply for fbahahttp:
2016.10.14 07:45:02 5: FBAHAHTTP_Write reply for fbahahttp:
2016.10.14 07:45:03 5: FBAHAHTTP_Write reply for fbahahttp:
2016.10.14 07:45:03 5: FBAHAHTTP_Write reply for fbahahttp:
2016.10.14 07:45:04 3: FBDECT set Lampe_Wohnzimmer on
2016.10.14 07:45:04 5: FBAHAHTTP_Write reply for fbahahttp:
2016.10.14 07:45:04 5: FBAHAHTTP_Write reply for fbahahttp:
2016.10.14 07:45:05 5: FBAHAHTTP_Write reply for fbahahttp:
2016.10.14 07:45:05 5: FBAHAHTTP_Write reply for fbahahttp:
2016.10.14 07:45:06 5: FBAHAHTTP_Write reply for fbahahttp:
2016.10.14 07:45:06 5: FBAHAHTTP_Write reply for fbahahttp:
2016.10.14 07:45:07 5: FBAHAHTTP_Write reply for fbahahttp:
2016.10.14 07:45:07 5: FBAHAHTTP_Write reply for fbahahttp:
2016.10.14 07:45:08 5: FBAHAHTTP_Write reply for fbahahttp:
2016.10.14 07:45:08 5: FBAHAHTTP_Write reply for fbahahttp:
2016.10.14 07:45:08 3: FBDECT set Lampe_Wohnzimmer off
2016.10.14 07:45:08 5: FBAHAHTTP_Write reply for fbahahttp:
2016.10.14 07:45:09 5: FBAHAHTTP_Write reply for fbahahttp:
2016.10.14 07:45:09 5: FBAHAHTTP_Write reply for fbahahttp:
2016.10.14 07:45:10 5: FBAHAHTTP_Write reply for fbahahttp:
[...--> die Meldung 'FBAHAHTTP_Write reply for fbahahttp:' wiederholt sich im gleichen Rhythmus teilweise 3x pro Sekunde]

Im Event Log der Fritzbox habe ich folgendes gefunden, was vermutlich direkt mit dem Problem im Zusammenhang steht.

Code Auswählen Erweitern

14.10.16 13:12:46 Anmeldung des Benutzers fhem an der FRITZ!Box Benutzeroberfläche von IP-Adresse 192.168.188.40.
14.10.16 13:11:41 Die FRITZ!Box-Einstellungen wurden über die Benutzeroberfläche geändert.
14.10.16 13:11:40 Anmeldung an der FRITZ!Box Benutzeroberfläche von IP-Adresse 192.168.188.40 gescheitert (ungültige Sitzungskennung). Zur Sicherheit werden alle noch gültigen Sitzungen zur IP-Adresse 192.168.188.40 beendet.
14.10.16 13:11:39 Anmeldung des Benutzers fhem an der FRITZ!Box Benutzeroberfläche von IP-Adresse 192.168.188.40.
14.10.16 13:11:40 Anmeldung an der FRITZ!Box Benutzeroberfläche von IP-Adresse 192.168.188.40 gescheitert (ungültige Sitzungskennung). Zur Sicherheit werden alle noch gültigen Sitzungen zur IP-Adresse 192.168.188.40 beendet.
14.10.16 13:11:40 Anmeldung des Benutzers fhem an der FRITZ!Box Benutzeroberfläche von IP-Adresse 192.168.188.40.
14.10.16 13:11:40 Anmeldung an der FRITZ!Box Benutzeroberfläche von IP-Adresse 192.168.188.40 gescheitert (ungültige Sitzungskennung). Zur Sicherheit werden alle noch gültigen Sitzungen zur IP-Adresse 192.168.188.40 beendet.
14.10.16 13:11:40 Anmeldung des Benutzers fhem an der FRITZ!Box Benutzeroberfläche von IP-Adresse 192.168.188.40.
14.10.16 13:11:39 Anmeldung an der FRITZ!Box Benutzeroberfläche von IP-Adresse 192.168.188.40 gescheitert (ungültige Sitzungskennung). Zur Sicherheit werden alle noch gültigen Sitzungen zur IP-Adresse 192.168.188.40 beendet.
14.10.16 13:11:39 Anmeldung des Benutzers fhem an der FRITZ!Box Benutzeroberfläche von IP-Adresse 192.168.188.40.
14.10.16 13:11:39 Anmeldung an der FRITZ!Box Benutzeroberfläche von IP-Adresse 192.168.188.40 gescheitert (ungültige Sitzungskennung). Zur Sicherheit werden alle noch gültigen Sitzungen zur IP-Adresse 192.168.188.40 beendet.
14.10.16 13:11:38 Anmeldung des Benutzers fhem an der FRITZ!Box Benutzeroberfläche von IP-Adresse 192.168.188.40.
14.10.16 13:11:37 Anmeldung an der FRITZ!Box Benutzeroberfläche von IP-Adresse 192.168.188.40 gescheitert (ungültige Sitzungskennung). Zur Sicherheit werden alle noch gültigen Sitzungen zur IP-Adresse 192.168.188.40 beendet.
14.10.16 13:11:37 Anmeldung des Benutzers fhem an der FRITZ!Box Benutzeroberfläche von IP-Adresse 192.168.188.40.
14.10.16 13:11:37 Anmeldung an der FRITZ!Box Benutzeroberfläche von IP-Adresse 192.168.188.40 gescheitert (ungültige Sitzungskennung). Zur Sicherheit werden alle noch gültigen Sitzungen zur IP-Adresse 192.168.188.40 beendet.
14.10.16 13:11:37 Anmeldung des Benutzers fhem an der FRITZ!Box Benutzeroberfläche von IP-Adresse 192.168.188.40.
14.10.16 13:11:36 Anmeldung an der FRITZ!Box Benutzeroberfläche von IP-Adresse 192.168.188.40 gescheitert (ungültige Sitzungskennung). Zur Sicherheit werden alle noch gültigen Sitzungen zur IP-Adresse 192.168.188.40 beendet.


Um ca. 13:11 hatte ich mich dann an der FritzBox mit einem anderen Account angemeldet, und direkt danach ist im FHEM Log erkennbar, dass sich der FHEM-Benutzer wieder erfolgreich anmelden konnte.

Hier das FHEM Log ab dem Zeitpunkt, an dem ich mich mit dem anderen Account an der Fritzbox angemeldet hatte:

Code Auswählen Erweitern

2016.10.14 13:11:44 2: fbahahttp error: cannot get SID, check connection/hostname/fritzbox-user/password
2016.10.14 13:12:44 3: fbahahttp: unexpected reply from device:
2016.10.14 13:12:47 3: fbahahttp: unexpected reply from device:
2016.10.14 13:12:47 3: fbahahttp: unexpected reply from device:
2016.10.14 13:12:47 3: fbahahttp: unexpected reply from device:
2016.10.14 13:12:47 3: fbahahttp: unexpected reply from device:
2016.10.14 13:12:47 3: fbahahttp: unexpected reply from device:
2016.10.14 13:12:47 3: fbahahttp: unexpected reply from device:
2016.10.14 13:12:47 3: fbahahttp: unexpected reply from device:
2016.10.14 13:12:47 3: fbahahttp: unexpected reply from device:
2016.10.14 13:12:47 3: fbahahttp: unexpected reply from device:
2016.10.14 13:12:47 3: fbahahttp: unexpected reply from device:
2016.10.14 13:12:47 3: fbahahttp: unexpected reply from device:
2016.10.14 13:12:47 3: fbahahttp: unexpected reply from device:
2016.10.14 13:12:47 5: fbahahttp dispatch <device identifier="08761 0004497" id="16" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Router Arbeitszimmer</name><switch><state>0</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>0</power><energy>309610</energy></powermeter><temperature><celsius>200</celsius><offset>0</offset></temperature></device>
2016.10.14 13:12:47 5: fbahahttp dispatch <device identifier="08761 0130186" id="17" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Lampe Wohnzimmer</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>6948</energy></powermeter><temperature><celsius>230</celsius><offset>0</offset></temperature></device>
2016.10.14 13:15:47 5: fbahahttp dispatch <device identifier="08761 0004497" id="16" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Router Arbeitszimmer</name><switch><state>0</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>0</power><energy>309610</energy></powermeter><temperature><celsius>200</celsius><offset>0</offset></temperature></device>
2016.10.14 13:15:47 5: fbahahttp dispatch <device identifier="08761 0130186" id="17" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Lampe Wohnzimmer</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>6948</energy></powermeter><temperature><celsius>230</celsius><offset>0</offset></temperature></device>
2016.10.14 13:18:47 5: fbahahttp dispatch <device identifier="08761 0004497" id="16" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Router Arbeitszimmer</name><switch><state>0</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>0</power><energy>309610</energy></powermeter><temperature><celsius>200</celsius><offset>0</offset></temperature></device>
2016.10.14 13:18:47 5: fbahahttp dispatch <device identifier="08761 0130186" id="17" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Lampe Wohnzimmer</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>6948</energy></powermeter><temperature><celsius>225</celsius><offset>0</offset></temperature></device>
2016.10.14 13:21:47 5: fbahahttp dispatch <device identifier="08761 0004497" id="16" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Router Arbeitszimmer</name><switch><state>0</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>0</power><energy>309610</energy></powermeter><temperature><celsius>200</celsius><offset>0</offset></temperature></device>
2016.10.14 13:21:47 5: fbahahttp dispatch <device identifier="08761 0130186" id="17" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Lampe Wohnzimmer</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>6948</energy></powermeter><temperature><celsius>230</celsius><offset>0</offset></temperature></device>
2016.10.14 13:24:47 5: fbahahttp dispatch <device identifier="08761 0004497" id="16" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Router Arbeitszimmer</name><switch><state>0</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>0</power><energy>309610</energy></powermeter><temperature><celsius>200</celsius><offset>0</offset></temperature></device>
2016.10.14 13:24:47 5: fbahahttp dispatch <device identifier="08761 0130186" id="17" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Lampe Wohnzimmer</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>6948</energy></powermeter><temperature><celsius>230</celsius><offset>0</offset></temperature></device>



Also irgendwas mit dem Session Handling im Zusammenhang mit dem disabledForInterval ist immernoch das Problem.

[rudolfkoenig]

2016.10.14 13:12:44 3: fbahahttp: unexpected reply from device:
2016.10.14 13:12:47 3: fbahahttp: unexpected reply from device:

Bist du sicher, dass du eine aktuelle Version von 00_FBAHAHTTP hast _und_ du seitdem FHEM neu gestartet hast?
Im aktuellen Code sollte diese Meldung eine Neu-Authentifizierung ausloesen, leider ohne extra Meldung imm Erfolgsfall.
Ich habe jetzt eine Meldung auf level 4 (attr fbahahttp verbose 4) eingebaut und eingecheckt.


Hilft in "deinem" Problemall auch ein "set fbahahttp password ..." (was unter anderem auch eine Authentifizierung bei der FB durchfuehrt)?
Wenn eine erneute Authentifizierung nicht helfen sollte, dann habe ich keine Idee, was hilft.

[snoopy]

ich hatte die Version vom 08.10. Hab gerade nochmal ein Update laufen und melde mich nach den nächsten Tests wieder

[rudolfkoenig]

"Freigegeben" wird es jeweils um ca 7:50. Der Prozess startet um 7:45, und dauert etliche Minuten.

[snoopy]

so, ich habe gestern nochmal aktualisiert und neu gestartet, FBAHAHTTP ist jetzt vom 17.10.
Meine Wohnzimmerlampe war zum Zeitpunkt des Updates (manuell) eingeschaltet, der Status in FHEM korrekt wiedergegeben.
Um 23:11 die Lampe per FHEM ausgeschaltet --> ohne Probleme
Heute morgen um 08:46 versucht einzuschalten/auszuschalten --> geht nicht
Folgendes steht jetzt im Logfile.

Code Auswählen Erweitern


2016.10.18 23:11:26 3: FBDECT set Lampe_Wohnzimmer off
2016.10.19 08:46:12 3: FBDECT set Lampe_Wohnzimmer on
2016.10.19 08:46:13 4: FBAHAHTTP_connect fbahahttp: got SID 02e4fa524fd6719e
2016.10.19 08:46:13 4: FBAHAHTTP_connect fbahahttp: got SID 47e936ba57326af4
2016.10.19 08:46:13 4: FBAHAHTTP_connect fbahahttp: got SID cc8c81db2d0addac
2016.10.19 08:46:14 4: FBAHAHTTP_connect fbahahttp: got SID 8be25bf9aeea69ac
2016.10.19 08:46:14 4: FBAHAHTTP_connect fbahahttp: got SID 2f7759b516ddace1
2016.10.19 08:46:15 4: FBAHAHTTP_connect fbahahttp: got SID 46b4a82b8369ef18
2016.10.19 08:46:15 4: FBAHAHTTP_connect fbahahttp: got SID df8fc5bd5d9f27ee
2016.10.19 08:46:16 4: FBAHAHTTP_connect fbahahttp: got SID 99feb033d90623a3
2016.10.19 08:46:16 4: FBAHAHTTP_connect fbahahttp: got SID ac9c5292abe95a4c
2016.10.19 08:46:17 4: FBAHAHTTP_connect fbahahttp: got SID f749db17060f1c09
2016.10.19 08:46:17 4: FBAHAHTTP_connect fbahahttp: got SID 7374f4e4c9f01082
2016.10.19 08:46:17 3: FBDECT set Lampe_Wohnzimmer off
2016.10.19 08:46:18 4: FBAHAHTTP_connect fbahahttp: got SID efa7cc9a92a3d291
2016.10.19 08:46:18 4: FBAHAHTTP_connect fbahahttp: got SID f133f3528cc34f08
2016.10.19 08:46:19 4: FBAHAHTTP_connect fbahahttp: got SID a50fb4b27b1cd9b7
2016.10.19 08:46:19 4: FBAHAHTTP_connect fbahahttp: got SID bbca929b07301960
2016.10.19 08:46:20 4: FBAHAHTTP_connect fbahahttp: got SID e8b0294a72d0e0e1
2016.10.19 08:46:20 4: FBAHAHTTP_connect fbahahttp: got SID 4f7cbd25fa463916
2016.10.19 08:46:21 4: FBAHAHTTP_connect fbahahttp: got SID ee8da9ce8d2d40d1
2016.10.19 08:46:21 4: FBAHAHTTP_connect fbahahttp: got SID fde7637ef6992e36
2016.10.19 08:46:22 4: FBAHAHTTP_connect fbahahttp: got SID 998d57755f9d1f17
2016.10.19 08:46:22 4: FBAHAHTTP_connect fbahahttp: got SID a35ae919db8ee8b1
2016.10.19 08:46:23 4: FBAHAHTTP_connect fbahahttp: got SID 08b41184a8ef6fc3
2016.10.19 08:46:23 4: FBAHAHTTP_connect fbahahttp: got SID 63877c52d8a11500
2016.10.19 08:46:24 4: FBAHAHTTP_connect fbahahttp: got SID 0a70217b81864240
2016.10.19 08:46:24 4: FBAHAHTTP_connect fbahahttp: got SID 7b160f31aed69a5f
2016.10.19 08:46:25 4: FBAHAHTTP_connect fbahahttp: got SID 4dae8e57cd9d92d7
2016.10.19 08:46:25 4: FBAHAHTTP_connect fbahahttp: got SID de789c0e6e95aa11
2016.10.19 08:46:25 4: FBAHAHTTP_connect fbahahttp: got SID 184dc85652dbc39a
2016.10.19 08:46:26 4: FBAHAHTTP_connect fbahahttp: got SID dae13b02e3293b04
2016.10.19 08:46:26 4: FBAHAHTTP_connect fbahahttp: got SID 35d51c1c6f9aa137
2016.10.19 08:46:27 4: FBAHAHTTP_connect fbahahttp: got SID 6fc9db1972bb8182
2016.10.19 08:46:27 4: FBAHAHTTP_connect fbahahttp: got SID 936cba2aeebd4db0
2016.10.19 08:46:28 4: FBAHAHTTP_connect fbahahttp: got SID a10a0857889726bb
2016.10.19 08:46:28 4: FBAHAHTTP_connect fbahahttp: got SID 7a589e3301455b88
2016.10.19 08:46:29 4: FBAHAHTTP_connect fbahahttp: got SID 3db0d5a908d0ea4d
2016.10.19 08:46:29 4: FBAHAHTTP_connect fbahahttp: got SID b012ccda86ec578d
2016.10.19 08:46:30 4: FBAHAHTTP_connect fbahahttp: got SID 36e726f4f4e4aefc
2016.10.19 08:46:30 4: FBAHAHTTP_connect fbahahttp: got SID a5d8cc0fa418e537
2016.10.19 08:46:31 4: FBAHAHTTP_connect fbahahttp: got SID 5d4100cca56ae89d
2016.10.19 08:46:31 4: FBAHAHTTP_connect fbahahttp: got SID 1b92199e3fe155d3
2016.10.19 08:46:32 4: FBAHAHTTP_connect fbahahttp: got SID 9117455e2e4bf744
2016.10.19 08:46:32 4: FBAHAHTTP_connect fbahahttp: got SID 14c4b89112180bfd
2016.10.19 08:46:33 4: FBAHAHTTP_connect fbahahttp: got SID f6706caff80c9942
2016.10.19 08:46:33 4: FBAHAHTTP_connect fbahahttp: got SID 61b172a14a1696ec
2016.10.19 08:46:34 4: FBAHAHTTP_connect fbahahttp: got SID 75b78c923684df4b
2016.10.19 08:46:34 4: FBAHAHTTP_connect fbahahttp: got SID 087f391640258e0c
2016.10.19 08:46:34 4: FBAHAHTTP_connect fbahahttp: got SID 8f9eff6cf9c57a0f
2016.10.19 08:46:35 4: FBAHAHTTP_connect fbahahttp: got SID a31211273eff6ad3
2016.10.19 08:46:35 4: FBAHAHTTP_connect fbahahttp: got SID 8e6885a920487627
2016.10.19 08:46:36 4: FBAHAHTTP_connect fbahahttp: got SID 31cdd71e5cfd3bed
2016.10.19 08:46:36 4: FBAHAHTTP_connect fbahahttp: got SID 32b5c5a9b65fb235
2016.10.19 08:46:37 4: FBAHAHTTP_connect fbahahttp: got SID b0ceeb8ab6141ed7
2016.10.19 08:46:37 4: FBAHAHTTP_connect fbahahttp: got SID 9f97f943f5dc6a74
2016.10.19 08:46:38 4: FBAHAHTTP_connect fbahahttp: got SID 5579e7d5402a49f3
2016.10.19 08:46:38 4: FBAHAHTTP_connect fbahahttp: got SID 88ef9598abd89f87
2016.10.19 08:46:39 4: FBAHAHTTP_connect fbahahttp: got SID a08b3668cc3c37d9
2016.10.19 08:46:39 4: FBAHAHTTP_connect fbahahttp: got SID 0e10079513273e9e
2016.10.19 08:46:40 4: FBAHAHTTP_connect fbahahttp: got SID 23a4018a28d2e9da
2016.10.19 08:46:40 4: FBAHAHTTP_connect fbahahttp: got SID 8ee3d5a1d7d5ba04
2016.10.19 08:46:41 4: FBAHAHTTP_connect fbahahttp: got SID b1f7e99d8233c56c
2016.10.19 08:46:41 4: FBAHAHTTP_connect fbahahttp: got SID 270f4a5afe80417f
2016.10.19 08:46:42 4: FBAHAHTTP_connect fbahahttp: got SID 99d6f54ff413e466
2016.10.19 08:46:42 4: FBAHAHTTP_connect fbahahttp: got SID 137945892f93d2d9
2016.10.19 08:46:43 4: FBAHAHTTP_connect fbahahttp: got SID ed9afc3f49793568
2016.10.19 08:46:43 4: FBAHAHTTP_connect fbahahttp: got SID 90dd164d5b7da262
2016.10.19 08:46:43 4: FBAHAHTTP_connect fbahahttp: got SID f3a5a4202c136cbe
2016.10.19 08:46:44 4: FBAHAHTTP_connect fbahahttp: got SID a7e95a77ed91f029
2016.10.19 08:46:44 4: FBAHAHTTP_connect fbahahttp: got SID 1a3f4156a9bb2f44
2016.10.19 08:46:45 4: FBAHAHTTP_connect fbahahttp: got SID 7ca9a4a1e22d1af1
2016.10.19 08:46:45 4: FBAHAHTTP_connect fbahahttp: got SID f8bfcf32e9324c66
2016.10.19 08:46:46 4: FBAHAHTTP_connect fbahahttp: got SID ce3b25df91b05534
2016.10.19 08:46:46 4: FBAHAHTTP_connect fbahahttp: got SID cddd701744dd954c
2016.10.19 08:46:47 4: FBAHAHTTP_connect fbahahttp: got SID cd6f87f5537fe639
2016.10.19 08:46:47 4: FBAHAHTTP_connect fbahahttp: got SID e74b582a3f0d790b
2016.10.19 08:46:48 4: FBAHAHTTP_connect fbahahttp: got SID bcfd3ced29b24386
2016.10.19 08:46:48 4: FBAHAHTTP_connect fbahahttp: got SID 283a0f49a6b4712c
2016.10.19 08:46:49 4: FBAHAHTTP_connect fbahahttp: got SID a25428349e87b68b
2016.10.19 08:46:49 4: FBAHAHTTP_connect fbahahttp: got SID e4ff0e79138aefb5
2016.10.19 08:46:50 4: FBAHAHTTP_connect fbahahttp: got SID a038f2b0ec2ed978
2016.10.19 08:46:50 4: FBAHAHTTP_connect fbahahttp: got SID ebdee874e7f1f6b2
2016.10.19 08:46:51 4: FBAHAHTTP_connect fbahahttp: got SID f449ab1c6e772347
2016.10.19 08:46:51 4: FBAHAHTTP_connect fbahahttp: got SID 89b3f3d6e511be84
2016.10.19 08:46:52 4: FBAHAHTTP_connect fbahahttp: got SID 6755f526194044cb
2016.10.19 08:46:52 4: FBAHAHTTP_connect fbahahttp: got SID 9f9f40623d4a5359
2016.10.19 08:46:53 4: FBAHAHTTP_connect fbahahttp: got SID b28f41d03da5422d
2016.10.19 08:46:53 4: FBAHAHTTP_connect fbahahttp: got SID e378160f6ea55ab4
2016.10.19 08:46:54 4: FBAHAHTTP_connect fbahahttp: got SID d10e4b807bd3f6e5
2016.10.19 08:46:54 4: FBAHAHTTP_connect fbahahttp: got SID db66cf1e96d03494
2016.10.19 08:46:55 4: FBAHAHTTP_connect fbahahttp: got SID 6d2666d79976ebdc
2016.10.19 08:46:55 4: FBAHAHTTP_connect fbahahttp: got SID 2bba59bd80639cf9
2016.10.19 08:46:56 4: FBAHAHTTP_connect fbahahttp: got SID 2dda370d4c8f8cbe
2016.10.19 08:46:56 4: FBAHAHTTP_connect fbahahttp: got SID c45b4f5fb342ad09
2016.10.19 08:46:57 4: FBAHAHTTP_connect fbahahttp: got SID a118c91229063088
2016.10.19 08:46:57 4: FBAHAHTTP_connect fbahahttp: got SID 00d49c5181352adb
2016.10.19 08:46:58 4: FBAHAHTTP_connect fbahahttp: got SID 08fd26bf1ba93cdd
2016.10.19 08:46:58 4: FBAHAHTTP_connect fbahahttp: got SID 957c43f9f74bb3be
2016.10.19 08:46:59 4: FBAHAHTTP_connect fbahahttp: got SID b6279719b530d5e1
2016.10.19 08:47:00 4: FBAHAHTTP_connect fbahahttp: got SID 21caad1632cf2b92
2016.10.19 08:47:01 4: FBAHAHTTP_connect fbahahttp: got SID b67eacbc2d46f5a1
2016.10.19 08:47:01 4: FBAHAHTTP_connect fbahahttp: got SID a9bb9d3a8d2d6931
2016.10.19 08:47:02 4: FBAHAHTTP_connect fbahahttp: got SID 35bdf49fe4e17af2
2016.10.19 08:47:02 4: FBAHAHTTP_connect fbahahttp: got SID f96b1a4c114e14fc
2016.10.19 08:47:03 4: FBAHAHTTP_connect fbahahttp: got SID 0fbe9587a65ac976
2016.10.19 08:47:04 4: FBAHAHTTP_connect fbahahttp: got SID 0e0c34353421e024
2016.10.19 08:47:04 4: FBAHAHTTP_connect fbahahttp: got SID aa4c3b9c66808d24
2016.10.19 08:47:05 4: FBAHAHTTP_connect fbahahttp: got SID 3ae0d16baa5991e9
2016.10.19 08:47:05 4: FBAHAHTTP_connect fbahahttp: got SID 9200ca4633d8a235
2016.10.19 08:47:06 4: FBAHAHTTP_connect fbahahttp: got SID 35ade465f6f8fd1a
2016.10.19 08:47:06 4: FBAHAHTTP_connect fbahahttp: got SID 5de4e72c323b936f
2016.10.19 08:47:07 4: FBAHAHTTP_connect fbahahttp: got SID 038cdeb8acbf818a
2016.10.19 08:47:07 4: FBAHAHTTP_connect fbahahttp: got SID 22e332f18a3d8b4b
2016.10.19 08:47:08 4: FBAHAHTTP_connect fbahahttp: got SID 7f9b791d864208e9
2016.10.19 08:47:09 4: FBAHAHTTP_connect fbahahttp: got SID 25d38d0af7ede2af
2016.10.19 08:47:09 4: FBAHAHTTP_connect fbahahttp: got SID 787bec58793b1051
2016.10.19 08:47:10 4: FBAHAHTTP_connect fbahahttp: got SID ea434b93b02a5c41
2016.10.19 08:47:11 4: FBAHAHTTP_connect fbahahttp: got SID 90fc2dbbdbf9c205
2016.10.19 08:47:12 4: FBAHAHTTP_connect fbahahttp: got SID 32ab261188cf5cd4
2016.10.19 08:47:12 4: FBAHAHTTP_connect fbahahttp: got SID 37de2b9bf2b99d03
2016.10.19 08:47:13 4: FBAHAHTTP_connect fbahahttp: got SID 430359afec6f8737
2016.10.19 08:47:13 4: FBAHAHTTP_connect fbahahttp: got SID e37d992e398f2b9a
2016.10.19 08:47:14 4: FBAHAHTTP_connect fbahahttp: got SID aa9769ee9f8542a8
2016.10.19 08:47:14 4: FBAHAHTTP_connect fbahahttp: got SID 3b8c714e6de97c2c
2016.10.19 08:47:15 4: FBAHAHTTP_connect fbahahttp: got SID 5444ff3b031a43a9
2016.10.19 08:47:15 4: FBAHAHTTP_connect fbahahttp: got SID 3a2741f4f0f07064
2016.10.19 08:47:16 4: FBAHAHTTP_connect fbahahttp: got SID fd3a90954cbfacb1
2016.10.19 08:47:16 4: FBAHAHTTP_connect fbahahttp: got SID fadb7c9ac104184c
2016.10.19 08:47:17 4: FBAHAHTTP_connect fbahahttp: got SID 675dae33e4fdfdd9
2016.10.19 08:47:17 4: FBAHAHTTP_connect fbahahttp: got SID ea5ca90390a126f5
2016.10.19 08:47:18 4: FBAHAHTTP_connect fbahahttp: got SID 9f463768b66f7d8b
2016.10.19 08:47:18 4: FBAHAHTTP_connect fbahahttp: got SID c7c17b93e3450c07
2016.10.19 08:47:19 4: FBAHAHTTP_connect fbahahttp: got SID 41f9c112f8c3b39c
2016.10.19 08:47:19 4: FBAHAHTTP_connect fbahahttp: got SID 8e26eb1b5e560d20
2016.10.19 08:47:20 4: FBAHAHTTP_connect fbahahttp: got SID 0d443bd81547bc6f
2016.10.19 08:47:20 4: FBAHAHTTP_connect fbahahttp: got SID 193481aa1df119a4
2016.10.19 08:47:20 4: FBAHAHTTP_connect fbahahttp: got SID 370c0a064357a50b
2016.10.19 08:47:21 4: FBAHAHTTP_connect fbahahttp: got SID 0bd3fad30d8d9073
2016.10.19 08:47:21 4: FBAHAHTTP_connect fbahahttp: got SID d794d2faf1cfc5e8
2016.10.19 08:47:22 4: FBAHAHTTP_connect fbahahttp: got SID 5162a94552150812
2016.10.19 08:47:22 4: FBAHAHTTP_connect fbahahttp: got SID 650d67576d2eb65e
2016.10.19 08:47:23 4: FBAHAHTTP_connect fbahahttp: got SID 1018ae0865aba900
2016.10.19 08:47:24 4: FBAHAHTTP_connect fbahahttp: got SID 70f1e1b64982f3ee
2016.10.19 08:47:24 4: FBAHAHTTP_connect fbahahttp: got SID 858251a88b1a11fa
2016.10.19 08:47:24 4: FBAHAHTTP_connect fbahahttp: got SID d5ca152846a0d848
2016.10.19 08:47:25 4: FBAHAHTTP_connect fbahahttp: got SID 23023fe19f12430c
2016.10.19 08:47:25 4: FBAHAHTTP_connect fbahahttp: got SID 2616f747b49cb88f
2016.10.19 08:47:26 4: FBAHAHTTP_connect fbahahttp: got SID 62ca9ca29307581f
2016.10.19 08:47:26 4: FBAHAHTTP_connect fbahahttp: got SID 89d057d6732d4c60
2016.10.19 08:47:27 4: FBAHAHTTP_connect fbahahttp: got SID fe27b2fe55339e8c
2016.10.19 08:47:27 4: FBAHAHTTP_connect fbahahttp: got SID 5aa4a5258e8cf6cc
2016.10.19 08:47:28 4: FBAHAHTTP_connect fbahahttp: got SID 960a68d2cb2e8907
2016.10.19 08:47:28 4: FBAHAHTTP_connect fbahahttp: got SID aba5e18864d1c4ab
2016.10.19 08:47:29 4: FBAHAHTTP_connect fbahahttp: got SID a9e73508418d7cb6
2016.10.19 08:47:29 4: FBAHAHTTP_connect fbahahttp: got SID 2c3c2eb7f0f6cb1e
2016.10.19 08:47:30 4: FBAHAHTTP_connect fbahahttp: got SID 4f8a45626c086417
2016.10.19 08:47:30 4: FBAHAHTTP_connect fbahahttp: got SID 362ced522f51613a
2016.10.19 08:47:31 4: FBAHAHTTP_connect fbahahttp: got SID 079f3f89f3680277
2016.10.19 08:47:31 4: FBAHAHTTP_connect fbahahttp: got SID fafc45f0e790b847
2016.10.19 08:47:32 4: FBAHAHTTP_connect fbahahttp: got SID 566acaa4157da0ec
2016.10.19 08:47:32 4: FBAHAHTTP_connect fbahahttp: got SID 4868ae26353fc25f
2016.10.19 08:47:33 4: FBAHAHTTP_connect fbahahttp: got SID f1b84dbcba4604e9
2016.10.19 08:47:33 4: FBAHAHTTP_connect fbahahttp: got SID 7be0faa8ca209f93
2016.10.19 08:47:34 4: FBAHAHTTP_connect fbahahttp: got SID 5b0fcfcbb61a8b20
2016.10.19 08:47:34 4: FBAHAHTTP_connect fbahahttp: got SID e5626768d9897210
2016.10.19 08:47:35 4: FBAHAHTTP_connect fbahahttp: got SID 1832f77a76661753
2016.10.19 08:47:35 4: FBAHAHTTP_connect fbahahttp: got SID d86a6dd743929310
2016.10.19 08:47:36 4: FBAHAHTTP_connect fbahahttp: got SID 5833425a1a0e000c
2016.10.19 08:47:36 4: FBAHAHTTP_connect fbahahttp: got SID 8dfddd1d4d9a7696
2016.10.19 08:47:37 4: FBAHAHTTP_connect fbahahttp: got SID 0c23b277ded44a0e
2016.10.19 08:47:37 4: FBAHAHTTP_connect fbahahttp: got SID be86f922615574ea
2016.10.19 08:47:38 4: FBAHAHTTP_connect fbahahttp: got SID 413f8d229edac5bf
2016.10.19 08:47:38 4: FBAHAHTTP_connect fbahahttp: got SID c77a1c3d99d52c86
2016.10.19 08:47:39 4: FBAHAHTTP_connect fbahahttp: got SID 0e785935f2d70d8b
2016.10.19 08:47:39 4: FBAHAHTTP_connect fbahahttp: got SID 090b7c09e848edc8
2016.10.19 08:47:40 4: FBAHAHTTP_connect fbahahttp: got SID f36b2d49e83529ed
2016.10.19 08:47:40 4: FBAHAHTTP_connect fbahahttp: got SID 28005754fb50f705
2016.10.19 08:47:41 4: FBAHAHTTP_connect fbahahttp: got SID bae309086f22753a
2016.10.19 08:47:41 4: FBAHAHTTP_connect fbahahttp: got SID a08918cb1ef6e91b
2016.10.19 08:47:42 4: FBAHAHTTP_connect fbahahttp: got SID 9509205468357cd1
2016.10.19 08:47:42 4: FBAHAHTTP_connect fbahahttp: got SID 4821c1dea7dcdc82
2016.10.19 08:47:43 4: FBAHAHTTP_connect fbahahttp: got SID d50ef57440bea852
2016.10.19 08:47:43 4: FBAHAHTTP_connect fbahahttp: got SID 7a544f2338d9c6e0
2016.10.19 08:47:43 4: FBAHAHTTP_connect fbahahttp: got SID bb6ba813f9626224
2016.10.19 08:47:44 4: FBAHAHTTP_connect fbahahttp: got SID 32c42ae8815430e2
2016.10.19 08:47:45 4: FBAHAHTTP_connect fbahahttp: got SID c298ec6cf3ebdc9a
2016.10.19 08:47:45 4: FBAHAHTTP_connect fbahahttp: got SID 83d5ffb739c80a4e
2016.10.19 08:47:46 4: FBAHAHTTP_connect fbahahttp: got SID 4489474976c09683
2016.10.19 08:47:47 4: FBAHAHTTP_connect fbahahttp: got SID 843706a71695966c
2016.10.19 08:47:47 4: FBAHAHTTP_connect fbahahttp: got SID 82647f1d742e975f
2016.10.19 08:47:48 4: FBAHAHTTP_connect fbahahttp: got SID 8d8d648190ee4c07
2016.10.19 08:47:48 4: FBAHAHTTP_connect fbahahttp: got SID a9b729339e3f0211
2016.10.19 08:47:49 4: FBAHAHTTP_connect fbahahttp: got SID d6e80b7f580588d2
2016.10.19 08:47:49 4: FBAHAHTTP_connect fbahahttp: got SID a5b5fa8ac96f0d14
2016.10.19 08:47:50 4: FBAHAHTTP_connect fbahahttp: got SID e796a95627af7f19
2016.10.19 08:47:50 4: FBAHAHTTP_connect fbahahttp: got SID 1bc1f23086032299
2016.10.19 08:47:51 4: FBAHAHTTP_connect fbahahttp: got SID 866f5ca7dc3266c2
2016.10.19 08:47:51 4: FBAHAHTTP_connect fbahahttp: got SID d37d75a41316b1df
2016.10.19 08:47:52 4: FBAHAHTTP_connect fbahahttp: got SID c1521aaf3c03d3dc
2016.10.19 08:47:52 4: FBAHAHTTP_connect fbahahttp: got SID f47229c9453330de
2016.10.19 08:47:53 4: FBAHAHTTP_connect fbahahttp: got SID 1a33c6c4e97fb9c3
2016.10.19 08:47:53 4: FBAHAHTTP_connect fbahahttp: got SID dc918818b2799fa2
2016.10.19 08:47:54 4: FBAHAHTTP_connect fbahahttp: got SID 7a7562e0e0b158db
2016.10.19 08:47:54 4: FBAHAHTTP_connect fbahahttp: got SID 78bf1294fee861ae
2016.10.19 08:47:55 4: FBAHAHTTP_connect fbahahttp: got SID 74f9171764dc31c2
2016.10.19 08:47:55 4: FBAHAHTTP_connect fbahahttp: got SID bdb97d0fb816407d
2016.10.19 08:47:56 4: FBAHAHTTP_connect fbahahttp: got SID e9929754ba90a0f9
2016.10.19 08:47:57 4: FBAHAHTTP_connect fbahahttp: got SID f5c7e27edd18393a
2016.10.19 08:47:57 4: FBAHAHTTP_connect fbahahttp: got SID 929035aafe1cdfff
2016.10.19 08:47:58 4: FBAHAHTTP_connect fbahahttp: got SID 74d35eaf0a189fe8
2016.10.19 08:47:58 4: FBAHAHTTP_connect fbahahttp: got SID 8ac8b466bce0ad7f
2016.10.19 08:47:59 4: FBAHAHTTP_connect fbahahttp: got SID c248efeb4621f9e0
2016.10.19 08:47:59 4: FBAHAHTTP_connect fbahahttp: got SID 30c4655bd0667d23
2016.10.19 08:47:59 4: FBAHAHTTP_connect fbahahttp: got SID b726584017b2ce38
2016.10.19 08:48:00 4: FBAHAHTTP_connect fbahahttp: got SID 59902831c38be5f5
2016.10.19 08:48:00 4: FBAHAHTTP_connect fbahahttp: got SID 4581dcb775b96ef9
2016.10.19 08:48:01 4: FBAHAHTTP_connect fbahahttp: got SID 5ddfe26775c8c3f3
2016.10.19 08:48:01 4: FBAHAHTTP_connect fbahahttp: got SID 8262a2228ea3e4f6
2016.10.19 08:48:02 4: FBAHAHTTP_connect fbahahttp: got SID 60d2561ba77a834b
2016.10.19 08:48:02 4: FBAHAHTTP_connect fbahahttp: got SID 9aac32a8c04cc857
2016.10.19 08:48:03 4: FBAHAHTTP_connect fbahahttp: got SID 277c6d299a4ab810
2016.10.19 08:48:03 4: FBAHAHTTP_connect fbahahttp: got SID 4594f041393f07f9
2016.10.19 08:48:04 4: FBAHAHTTP_connect fbahahttp: got SID 449571adfc3666c3
2016.10.19 08:48:04 4: FBAHAHTTP_connect fbahahttp: got SID 12a247715a0652ca
2016.10.19 08:48:05 4: FBAHAHTTP_connect fbahahttp: got SID f9cc8bdef39814a9
2016.10.19 08:48:05 4: FBAHAHTTP_connect fbahahttp: got SID 3f8b2babf6a41c75
2016.10.19 08:48:06 4: FBAHAHTTP_connect fbahahttp: got SID ec9f3af3e824b247
2016.10.19 08:48:06 4: FBAHAHTTP_connect fbahahttp: got SID 5b36ff82283ef7f6
2016.10.19 08:48:07 4: FBAHAHTTP_connect fbahahttp: got SID bb43a046c22a79dc
2016.10.19 08:48:08 4: FBAHAHTTP_connect fbahahttp: got SID c423d9d8e9d66ed0
2016.10.19 08:48:08 4: FBAHAHTTP_connect fbahahttp: got SID b193329dd18d471c
2016.10.19 08:48:09 4: FBAHAHTTP_connect fbahahttp: got SID d105e2701573524b
2016.10.19 08:48:09 4: FBAHAHTTP_connect fbahahttp: got SID a9d654f549dab7b9
2016.10.19 08:48:10 4: FBAHAHTTP_connect fbahahttp: got SID 169ae2174411884a
2016.10.19 08:48:10 4: FBAHAHTTP_connect fbahahttp: got SID 62bc67e30b51306f
2016.10.19 08:48:11 4: FBAHAHTTP_connect fbahahttp: got SID 00ff3c295edfc6a2
2016.10.19 08:48:11 4: FBAHAHTTP_connect fbahahttp: got SID 493b0cf24de873a6
2016.10.19 08:48:12 4: FBAHAHTTP_connect fbahahttp: got SID d489447449c8e722
2016.10.19 08:48:12 4: FBAHAHTTP_connect fbahahttp: got SID 2997ff3d96931820
2016.10.19 08:48:13 4: FBAHAHTTP_connect fbahahttp: got SID 83d6376b3c12c360
2016.10.19 08:48:13 4: FBAHAHTTP_connect fbahahttp: got SID 7f500bcfb5d4abe2
2016.10.19 08:48:14 4: FBAHAHTTP_connect fbahahttp: got SID a078aa153531f9f6
2016.10.19 08:48:14 4: FBAHAHTTP_connect fbahahttp: got SID bf2de45b01d05ecd
2016.10.19 08:48:15 4: FBAHAHTTP_connect fbahahttp: got SID 9a18ff7a7b3059a8
2016.10.19 08:48:15 4: FBAHAHTTP_connect fbahahttp: got SID 515b31ac32e4d41a
2016.10.19 08:48:16 4: FBAHAHTTP_connect fbahahttp: got SID fb7f14fc7c834ba3
2016.10.19 08:48:16 4: FBAHAHTTP_connect fbahahttp: got SID 76e997698327ab46
2016.10.19 08:48:16 4: FBAHAHTTP_connect fbahahttp: got SID 59f21bbba988e162
2016.10.19 08:48:17 4: FBAHAHTTP_connect fbahahttp: got SID 4c8d33633da8f587
2016.10.19 08:48:17 4: FBAHAHTTP_connect fbahahttp: got SID 41d0075392774880
2016.10.19 08:48:18 4: FBAHAHTTP_connect fbahahttp: got SID 7885a137e7f9cee7
2016.10.19 08:48:19 4: FBAHAHTTP_connect fbahahttp: got SID 13cbd4f7eeff8f3f
2016.10.19 08:48:19 4: FBAHAHTTP_connect fbahahttp: got SID c5cb506900716cd8
2016.10.19 08:48:20 4: FBAHAHTTP_connect fbahahttp: got SID 0a2e0f65d044a9b2
2016.10.19 08:48:20 4: FBAHAHTTP_connect fbahahttp: got SID 01a44264cf1f0a73
2016.10.19 08:48:21 4: FBAHAHTTP_connect fbahahttp: got SID 6b2db0b476a94c8b
2016.10.19 08:48:21 4: FBAHAHTTP_connect fbahahttp: got SID 3189b5e6dd71dc69
2016.10.19 08:48:21 4: FBAHAHTTP_connect fbahahttp: got SID d02bd7fd6ca6e903
2016.10.19 08:48:22 4: FBAHAHTTP_connect fbahahttp: got SID 0789c75326451386
2016.10.19 08:48:22 4: FBAHAHTTP_connect fbahahttp: got SID 4de6397c2a35898d
2016.10.19 08:48:23 4: FBAHAHTTP_connect fbahahttp: got SID 7d6b44e22be553f2
2016.10.19 08:48:24 4: FBAHAHTTP_connect fbahahttp: got SID 8a50f36f37c20a26
2016.10.19 08:48:24 4: FBAHAHTTP_connect fbahahttp: got SID ca3e26f36c965dc5
2016.10.19 08:48:24 4: FBAHAHTTP_connect fbahahttp: got SID bbbf9467cfb03693
2016.10.19 08:48:25 4: FBAHAHTTP_connect fbahahttp: got SID 5c6e280434faa521
2016.10.19 08:48:25 4: FBAHAHTTP_connect fbahahttp: got SID edeec1e94d1c2c6d
2016.10.19 08:48:26 4: FBAHAHTTP_connect fbahahttp: got SID fd0fef4a1546d853
2016.10.19 08:48:26 4: FBAHAHTTP_connect fbahahttp: got SID 29fba28b9a771896
2016.10.19 08:48:27 4: FBAHAHTTP_connect fbahahttp: got SID 684e0814064cd7e6
2016.10.19 08:48:27 4: FBAHAHTTP_connect fbahahttp: got SID 2b5aa64319135763
2016.10.19 08:48:28 4: FBAHAHTTP_connect fbahahttp: got SID aebf6604bcb83279
2016.10.19 08:48:28 4: FBAHAHTTP_connect fbahahttp: got SID fe2a558c9430ced5
2016.10.19 08:48:29 4: FBAHAHTTP_connect fbahahttp: got SID 3374238b2b7b46f0
2016.10.19 08:48:29 4: FBAHAHTTP_connect fbahahttp: got SID 831215ae06da8d37
2016.10.19 08:48:30 4: FBAHAHTTP_connect fbahahttp: got SID 8fc881bedd01cb16
2016.10.19 08:48:30 4: FBAHAHTTP_connect fbahahttp: got SID d4c2e223bd804d5b
2016.10.19 08:48:31 4: FBAHAHTTP_connect fbahahttp: got SID 91894475d0a70b84
2016.10.19 08:48:31 4: FBAHAHTTP_connect fbahahttp: got SID 874f72fb468142e2
2016.10.19 08:48:32 4: FBAHAHTTP_connect fbahahttp: got SID 62402fbaf4953de8
2016.10.19 08:48:32 4: FBAHAHTTP_connect fbahahttp: got SID 3faf3a07192ec5a1
2016.10.19 08:48:33 4: FBAHAHTTP_connect fbahahttp: got SID 40758beda699e405
2016.10.19 08:48:33 4: FBAHAHTTP_connect fbahahttp: got SID 79baac34596d5447
2016.10.19 08:48:34 4: FBAHAHTTP_connect fbahahttp: got SID 894fca94bfa1e8ce
2016.10.19 08:48:34 4: FBAHAHTTP_connect fbahahttp: got SID 1025c0eefda1d435
2016.10.19 08:48:35 4: FBAHAHTTP_connect fbahahttp: got SID 5ebc597c0b072a4e
2016.10.19 08:48:35 4: FBAHAHTTP_connect fbahahttp: got SID efe087d5d06798e9
2016.10.19 08:48:36 4: FBAHAHTTP_connect fbahahttp: got SID ae34944435591781
2016.10.19 08:48:36 4: FBAHAHTTP_connect fbahahttp: got SID 7ade4ccefeca2bef
2016.10.19 08:48:37 4: FBAHAHTTP_connect fbahahttp: got SID e79cdcd1a043a66a
2016.10.19 08:48:37 4: FBAHAHTTP_connect fbahahttp: got SID ade5bdef33908c08
2016.10.19 08:48:38 4: FBAHAHTTP_connect fbahahttp: got SID 62a3e5373d8e617d
2016.10.19 08:48:38 4: FBAHAHTTP_connect fbahahttp: got SID 115ddbac533a4688
2016.10.19 08:48:39 4: FBAHAHTTP_connect fbahahttp: got SID 5af72584cdbedfd5
2016.10.19 08:48:39 4: FBAHAHTTP_connect fbahahttp: got SID 151a46a6e979b724
2016.10.19 08:48:54 3: fbahahttp: read from http://192.168.188.1:80 timed out


Ab 08:48:54 kam erstmal keine Meldung mehr.
Um 08:56 habe ich es einfach nochmal versucht, dann hat es doch funktioniert.
Folgendes im Log:

Code Auswählen Erweitern

2016.10.19 08:56:23 3: FBDECT set Lampe_Wohnzimmer on
2016.10.19 08:56:24 4: FBAHAHTTP_connect fbahahttp: got SID b4606e9dff5e75bc
2016.10.19 08:56:37 3: FBDECT set Lampe_Wohnzimmer off

Im Ergebnis blieben also die ersten zwei Kommandos ohne Reaktion, nach ca. 2-3 Minuten ging es dann.
Ich hoffe, das Hilft bei der Fehlersuche weiter. Das Problem ist ja jetzt "fast schon" gelöst

[rudolfkoenig]

Ich bin bei weitem nicht so optimistisch, der Ausdruck "schockiert" trifft es eher. In deinem Log sieht man, dass FBAHA ueber 2 Minuten lang immer wieder neue SID's besorgt, scheinbar nur um ein Befehl absetzen zu koennen. Das sollte eigentlich nicht der Fall sein, ich versuche explizit eine Rekursion/Schleife zu vermeiden.
Nach etwas Ueber-Code-Gruebeln und selbst testen weiss ich leider nicht weiter.

Koenntest bitte das Experiment mit "attr global verbose 4" wiederholen?

[snoopy]

Hi, ich hab gestern Abend mal das attr global verbose 4 gesetzt, heute morgen war dann mein FHEM.log > 200MB 
Eben habe ich mal versucht zu schalten, die zwei/drei Versuche blieben ohne Reaktion.
Ich hab mal versucht, den passenden Schnippsel aus dem Log zu schneiden.

Code Auswählen Erweitern

2016.10.20 21:08:16 4: Connection accepted from WEB_192.168.188.58_50382
2016.10.20 21:08:16 4: parsing....
2016.10.20 21:08:16 4: parsing....
2016.10.20 21:08:16 4: WEB_192.168.188.58_50382 GET /fhem?cmd=%7BReadingsVal%28%22Lampe_Wohnzimmer%22%2C%22state%22%2C%22%22%29%7D&XHR=1; BUFLEN:0
2016.10.20 21:08:16 4: name: /fhem?cmd=%7BReadingsVal%28%22Lampe_Wohnzimmer%22%2C%22state%22%2C%22%22%29%7D&XHR=1 / RL:23 / text/plain; charset=UTF-8 / Content-Encoding: gzip
/
2016.10.20 21:08:16 4: parsing....
2016.10.20 21:08:16 4: parsing....
2016.10.20 21:08:16 4: parsing....
2016.10.20 21:08:16 4: parsing....
2016.10.20 21:08:16 4: parsing....
2016.10.20 21:08:16 4: parsing....
2016.10.20 21:08:16 4: parsing....
2016.10.20 21:08:16 4: parsing....
2016.10.20 21:08:16 4: parsing....
2016.10.20 21:08:16 4: parsing....
2016.10.20 21:08:16 4: parsing....
2016.10.20 21:08:16 4: parsing....
2016.10.20 21:08:16 4: parsing....
2016.10.20 21:08:16 4: parsing....
2016.10.20 21:08:16 4: parsing....
2016.10.20 21:08:16 4: parsing....
2016.10.20 21:08:16 4: parsing....
2016.10.20 21:08:16 4: parsing....
2016.10.20 21:08:16 4: parsing....
2016.10.20 21:08:16 4: parsing....
2016.10.20 21:08:16 4: parsing....
2016.10.20 21:08:16 4: parsing....
2016.10.20 21:08:16 4: parsing....
2016.10.20 21:08:16 4: parsing....
2016.10.20 21:08:16 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:16 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:16 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:16 4:   Connection: close
2016.10.20 21:08:16 4:   Content-Length: 0
2016.10.20 21:08:16 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:16 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:17 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:17 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:17 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:17 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:17 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:17 4: FBAHAHTTP_connect fbahahttp: got SID e6bea97d6726720d
2016.10.20 21:08:17 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:17 4: parsing....
2016.10.20 21:08:17 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:17 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:17 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:17 4:   Connection: close
2016.10.20 21:08:17 4:   Content-Length: 0
2016.10.20 21:08:17 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:17 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:18 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:18 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:18 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:18 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:18 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:18 4: FBAHAHTTP_connect fbahahttp: got SID 653dd2669386adfc
2016.10.20 21:08:18 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: parsing....
2016.10.20 21:08:18 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:18 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:18 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:18 4:   Connection: close
2016.10.20 21:08:18 4:   Content-Length: 0
2016.10.20 21:08:18 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:18 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:18 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:18 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:18 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:19 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:19 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:19 4: FBAHAHTTP_connect fbahahttp: got SID 0eaa4b37ab7df01a
2016.10.20 21:08:19 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:19 4: parsing....
2016.10.20 21:08:19 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:19 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:19 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:19 4:   Connection: close
2016.10.20 21:08:19 4:   Content-Length: 0
2016.10.20 21:08:19 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:19 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:19 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:19 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:19 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:19 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:19 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:19 4: FBAHAHTTP_connect fbahahttp: got SID a93002ba95860913
2016.10.20 21:08:19 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:20 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:20 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:20 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:20 4:   Connection: close
2016.10.20 21:08:20 4:   Content-Length: 0
2016.10.20 21:08:20 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:20 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:20 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:20 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:20 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:20 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:20 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:20 4: FBAHAHTTP_connect fbahahttp: got SID 1af42419e4400318
2016.10.20 21:08:20 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: parsing....
2016.10.20 21:08:20 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:20 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:20 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:20 4:   Connection: close
2016.10.20 21:08:20 4:   Content-Length: 0
2016.10.20 21:08:20 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:20 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:20 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:20 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:20 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:21 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:21 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:21 4: FBAHAHTTP_connect fbahahttp: got SID b187c7e2eaf1325a
2016.10.20 21:08:21 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:21 4: parsing....
2016.10.20 21:08:21 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:21 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:21 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:21 4:   Connection: close
2016.10.20 21:08:21 4:   Content-Length: 0
2016.10.20 21:08:21 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:21 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:21 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:21 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:21 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:21 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:21 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:21 4: FBAHAHTTP_connect fbahahttp: got SID 37fad39038140916
2016.10.20 21:08:21 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:21 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:21 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:21 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:21 4:   Connection: close
2016.10.20 21:08:21 4:   Content-Length: 0
2016.10.20 21:08:21 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:21 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:21 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:21 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:21 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:22 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:22 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:22 4: FBAHAHTTP_connect fbahahttp: got SID f21b8bf47cbf02a4
2016.10.20 21:08:22 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:22 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:22 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:22 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:22 4:   Connection: close
2016.10.20 21:08:22 4:   Content-Length: 0
2016.10.20 21:08:22 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:22 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:22 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:22 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:22 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:22 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:22 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:22 4: FBAHAHTTP_connect fbahahttp: got SID 58241a67c0a08b9c
2016.10.20 21:08:22 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: parsing....
2016.10.20 21:08:22 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:22 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:22 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:22 4:   Connection: close
2016.10.20 21:08:22 4:   Content-Length: 0
2016.10.20 21:08:22 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:22 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:22 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:22 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:22 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:23 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:23 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:23 4: FBAHAHTTP_connect fbahahttp: got SID 62145240757523d9
2016.10.20 21:08:23 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:23 4: parsing....
2016.10.20 21:08:23 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:23 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:23 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:23 4:   Connection: close
2016.10.20 21:08:23 4:   Content-Length: 0
2016.10.20 21:08:23 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:23 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:23 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:23 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:23 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:23 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:23 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:23 4: FBAHAHTTP_connect fbahahttp: got SID 312a9b461d5616b3
2016.10.20 21:08:23 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:23 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:23 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:23 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:23 4:   Connection: close
2016.10.20 21:08:23 4:   Content-Length: 0
2016.10.20 21:08:23 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:23 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:23 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:23 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:23 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:24 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:24 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:24 4: FBAHAHTTP_connect fbahahttp: got SID ea315e5426fdf10b
2016.10.20 21:08:24 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:24 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:24 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:24 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:24 4:   Connection: close
2016.10.20 21:08:24 4:   Content-Length: 0
2016.10.20 21:08:24 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:24 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:24 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:24 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:24 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:24 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:24 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:24 4: FBAHAHTTP_connect fbahahttp: got SID 143db45ecbd09178
2016.10.20 21:08:24 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: parsing....
2016.10.20 21:08:24 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:24 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:24 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:24 4:   Connection: close
2016.10.20 21:08:24 4:   Content-Length: 0
2016.10.20 21:08:24 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:24 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:24 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:24 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:24 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:25 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:25 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:25 4: FBAHAHTTP_connect fbahahttp: got SID 065033555ef97c4c
2016.10.20 21:08:25 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:25 4: parsing....
2016.10.20 21:08:25 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:25 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:25 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:25 4:   Connection: close
2016.10.20 21:08:25 4:   Content-Length: 0
2016.10.20 21:08:25 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:25 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:25 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:25 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:25 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:25 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:25 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:25 4: FBAHAHTTP_connect fbahahttp: got SID f243ab4cc8b3646e
2016.10.20 21:08:25 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:25 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:25 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:25 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:25 4:   Connection: close
2016.10.20 21:08:25 4:   Content-Length: 0
2016.10.20 21:08:25 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:25 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:25 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:25 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:25 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:25 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:25 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:25 4: FBAHAHTTP_connect fbahahttp: got SID 62399805f7474550
2016.10.20 21:08:25 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:26 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:26 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:26 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:26 4:   Connection: close
2016.10.20 21:08:26 4:   Content-Length: 0
2016.10.20 21:08:26 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:26 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:26 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:26 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:26 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:26 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:26 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:26 4: FBAHAHTTP_connect fbahahttp: got SID 009a70c89ec53279
2016.10.20 21:08:26 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:26 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:26 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:26 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:26 4:   Connection: close
2016.10.20 21:08:26 4:   Content-Length: 0
2016.10.20 21:08:26 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:26 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:26 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:26 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:26 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:26 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:26 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:26 4: FBAHAHTTP_connect fbahahttp: got SID 8e3f714be712f1f8
2016.10.20 21:08:26 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:26 4: parsing....
2016.10.20 21:08:27 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:27 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:27 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:27 4:   Connection: close
2016.10.20 21:08:27 4:   Content-Length: 0
2016.10.20 21:08:27 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:27 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:27 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:27 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:27 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:27 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:27 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:27 4: FBAHAHTTP_connect fbahahttp: got SID 43b73337f396c6f9
2016.10.20 21:08:27 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:27 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:27 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:27 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:27 4:   Connection: close
2016.10.20 21:08:27 4:   Content-Length: 0
2016.10.20 21:08:27 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:27 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:27 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:27 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:27 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:27 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:28 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:28 4: FBAHAHTTP_connect fbahahttp: got SID 92a421ab39d38474
2016.10.20 21:08:28 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:28 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:28 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:28 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:28 4:   Connection: close
2016.10.20 21:08:28 4:   Content-Length: 0
2016.10.20 21:08:28 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:28 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:28 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:28 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:28 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:28 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:28 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:28 4: FBAHAHTTP_connect fbahahttp: got SID 3018dc818ccef5e6
2016.10.20 21:08:28 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: parsing....
2016.10.20 21:08:28 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:28 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:28 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:28 4:   Connection: close
2016.10.20 21:08:28 4:   Content-Length: 0
2016.10.20 21:08:28 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:28 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:28 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:28 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:28 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:29 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:29 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:29 4: FBAHAHTTP_connect fbahahttp: got SID 2fd67177bfc8e588
2016.10.20 21:08:29 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:29 4: parsing....
2016.10.20 21:08:29 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:29 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:29 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:29 4:   Connection: close
2016.10.20 21:08:29 4:   Content-Length: 0
2016.10.20 21:08:29 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:29 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:29 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:29 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:29 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:29 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:29 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:29 4: FBAHAHTTP_connect fbahahttp: got SID 86e75d90ee554b56
2016.10.20 21:08:29 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:29 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:29 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:29 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:29 4:   Connection: close
2016.10.20 21:08:29 4:   Content-Length: 0
2016.10.20 21:08:29 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:29 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:29 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:29 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:29 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:29 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:29 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:30 4: FBAHAHTTP_connect fbahahttp: got SID c2483e6ac1bab303
2016.10.20 21:08:30 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:30 4: <hidden>: HTTP response code 200
2016.10.20 21:08:30 4: HttpUtils <hidden>: Got data, length: 23
2016.10.20 21:08:30 4: TelegramBot_UpdatePoll teleBot: initiate polling with nonblockingGet with 120s
2016.10.20 21:08:30 4: HttpUtils url=<hidden>
2016.10.20 21:08:30 4: TelegramBot_Callback teleBot: resulted in :SUCCESS: from Polling
2016.10.20 21:08:30 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:30 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:30 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:30 4:   Connection: close
2016.10.20 21:08:30 4:   Content-Length: 0
2016.10.20 21:08:30 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:30 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:30 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:30 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:30 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:30 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:30 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:30 4: FBAHAHTTP_connect fbahahttp: got SID 5eab4221c81d0876
2016.10.20 21:08:30 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: parsing....
2016.10.20 21:08:30 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:30 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:30 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:30 4:   Connection: close
2016.10.20 21:08:30 4:   Content-Length: 0
2016.10.20 21:08:30 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:30 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:30 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:30 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:30 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:31 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:31 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:31 4: FBAHAHTTP_connect fbahahttp: got SID 19c5ae488b8ca7d3
2016.10.20 21:08:31 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:31 4: parsing....
2016.10.20 21:08:31 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:31 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:31 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:31 4:   Connection: close
2016.10.20 21:08:31 4:   Content-Length: 0
2016.10.20 21:08:31 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:31 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:31 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:31 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:31 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:31 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:31 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:31 4: FBAHAHTTP_connect fbahahttp: got SID f377a5fd4d67d84d
2016.10.20 21:08:31 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:31 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:31 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:31 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:31 4:   Connection: close
2016.10.20 21:08:31 4:   Content-Length: 0
2016.10.20 21:08:31 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:31 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:31 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:31 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:31 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:31 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:31 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:31 4: FBAHAHTTP_connect fbahahttp: got SID db81433a3beca98b
2016.10.20 21:08:31 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:32 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:32 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:32 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:32 4:   Connection: close
2016.10.20 21:08:32 4:   Content-Length: 0
2016.10.20 21:08:32 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:32 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:32 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:32 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:32 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:32 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:32 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:32 4: FBAHAHTTP_connect fbahahttp: got SID 8613f9b528dad67d
2016.10.20 21:08:32 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: parsing....
2016.10.20 21:08:32 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:32 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:32 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:32 4:   Connection: close
2016.10.20 21:08:32 4:   Content-Length: 0
2016.10.20 21:08:32 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:32 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:32 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:32 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:32 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:32 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:32 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:32 4: FBAHAHTTP_connect fbahahttp: got SID d1b32e4defa4ea5d
2016.10.20 21:08:32 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:33 4: parsing....
2016.10.20 21:08:33 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:33 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:33 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:33 4:   Connection: close
2016.10.20 21:08:33 4:   Content-Length: 0
2016.10.20 21:08:33 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:33 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:33 4: http://192.168.188.1/login_sid.lua: HTTP response code 200
2016.10.20 21:08:33 4: HttpUtils http://192.168.188.1/login_sid.lua: Got data, length: 165
2016.10.20 21:08:33 4: HttpUtils url=http://192.168.188.1/login_sid.lua?username=fhem
2016.10.20 21:08:33 4: http://192.168.188.1/login_sid.lua?username=fhem: HTTP response code 200
2016.10.20 21:08:33 4: HttpUtils http://192.168.188.1/login_sid.lua?username=fhem: Got data, length: 204
2016.10.20 21:08:33 4: FBAHAHTTP_connect fbahahttp: got SID 28515d2e146d0251
2016.10.20 21:08:33 4: HttpUtils url=http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon
2016.10.20 21:08:33 4: http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: HTTP response code 403
2016.10.20 21:08:33 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Got data, length: 0
2016.10.20 21:08:33 4: HttpUtils http://192.168.188.1/webservices/homeautoswitch.lua?sid=0e6c70fc3f6fb062&ain=08761 0130186&switchcmd=setswitchon: Zero length data, header follows:
2016.10.20 21:08:33 4:   Connection: close
2016.10.20 21:08:33 4:   Content-Length: 0
2016.10.20 21:08:33 4:   Content-Type: text/plain; charset=utf-8
2016.10.20 21:08:33 4: HttpUtils url=http://192.168.188.1/login_sid.lua
2016.10.20 21:08:33 4: http://192.168.188.1/login_sid.lua: HTTP response code 200

[rudolfkoenig]

Danke! Habe meinen Denkfehler gefunden, damit sollte es keine Endlosschleife mehr geben: FBAHAHTTP gibt nach 2 Versuchen jetzt auf.
Die schlechte Nachricht fuer Dich: damit funktioniert das Schalten bei Dir auch nicht.

Offensichtlich ist der AHA Server auf dem FritzBox fehlerhaft: FHEM kann zwar einen gueltigen SID besorgen, aber das Schalten mit dieser SID wird vom AHA Server nicht durchgefuehrt, und mit einer leeren Antwort quittiert.
Im Deinem Beispiel von 19.10 was das erste Schalten nach 11 Versuchen erfolgreich(?), das Zweite nach 280 nicht.
Ich habe (das gleiche?) Problem AVM schon zweimal gemeldet (vor 6 Monaten und vor einem), ohne eine Antwort, vielleicht hast du mehr Glueck. Oder du stellst auf FBAHA zurueck, und hoffst, dass das Problem da nicht eintritt, und dass AVM nicht Wort haelt, und FBAHA behaelt. Ich gehe davon aus, dass es kein generelles Problem mit FBAHAHTTP ist, sonst haette ich mehr Beschwerden.

P.S.: vollstaendigkeitshalber wuesste ich noch gerne, ob es in einem Problemfall das Schalten aus der FritzBox Oberflaeche funktioniert.

[snoopy]

Ebenfalls Danke für die Nachforschungen in dieser Angelegenheit!

Bei meinem Mitschnitt war eigentlich keiner der Schaltvorgänge erfolgreich... ich hatte es dann einfach 10 Minuten danach nochmal versucht, dann ging es wieder. Im Fehlerfall war das direkte Schalten über die Fritzbox aber bisher immer möglich.

Ich werde ggf. mal die Tage das FBAHA ausprobieren. AVM wird wohl in den nächsten Wochen auch die finale Version des nächsten Release rausbringen, vielleicht tut sich ja dann auch was bzgl. des Fehlers in dem AHA Server.

[Wzut]

Erst einmal sorry das hier so ein alte Leiche ausgrabe, aber ich habe die letzten Tage auch einige Probleme mit nicht schaltenden Dosen gehabt und mich etwas mit dem FBAHAHTTP Modul beschäftigt.

Danke! Habe meinen Denkfehler gefunden, damit sollte es keine Endlosschleife mehr geben: FBAHAHTTP gibt nach 2 Versuchen jetzt auf.

Mit aufgeben meinst du den Abschnit :

Code Auswählen Erweitern

if(!defined($_[2]) || $_[2] eq "") {
        if($hash->{RetriedCmd}) {
          Log3 $name, 1, "No sensible respone after reconnect, giving up";
          return;
        }
Ja hier wird zwar die Schleife von FBAHAHTTP_ProcessStack abgebrochen, der nicht ausgeführte Schaltbefehl in CmdStack bleibt aber erhalten.
Beim nächsten Write wird wieder ein Eintrag zum CmdStack hinzugefügt, aber ProcessStack wird IMHO nie mehr aufgerufen da Write endet mit :

Code Auswählen Erweitern

FBAHAHTTP_ProcessStack($hash) if(@{$hash->{CmdStack}} == 1);
D.h. der CmdStack wird mit jedem weiteren Write immer größer ohne das es eine Chance gibt ihn abzuarbeiten.
Was spricht dagegen im zitierten Abbruch Block den Stack mit $hash->{CmdStack} = (); genauso zu löschen wie ein paar Zeilen darüber wenn $_[1] wahr ist ?

[rudolfkoenig]

Danke fuer den Hinweis, ich habe die Zeile hinzugefuegt.

[Wzut]

Danke auch. Was ich jetzt nicht geschrieben habe war warum ich (noch) auf der Suche nach Fehlern bin.
Bei mir liefen 5 Dosen seit Jahren zu 100% zuverlässig. Anfang Oktober kamen noch 4 dazu. Ab diesem Zeitpunkt fingen die Probleme an das Dosen die bisher zuverlässig geschaltet hatten dies jetzt nicht mehr taten.
Bei der Fehlersuche ist mir zuerst CmdStack aufgefallen das der immer größer wurde. Blöderweise lief meine Überwachung der Dosen via ihren Readings und da war nichts festzustellen, da FBAHAHTTP_Poll weiterhin fehlerfrei funktionierte. Ich habe dann mehr Log Ausgaben ins Modul gebaut und zusätzliche Readings um den Fehler besser eingrenzen zu können. Heute um Mitternacht war es dann wieder soweit, keine Schaltung und CmdStack wuchs an
trotz der zusätzlichen Löschung. Allerdings ist Mitternacht bei mir ein Sonderfall, da nur dann zwei Dosen mit einem Befehl gleichzeitig geschaltet werden und async_delay mit ins Spiel kommt (steht bei mir auf 3)
Ich teste auf jeden Fall weiter und werde nach meinem Urlaub wieder berichten.

[noansi]

Hallo Rudolf,

Offensichtlich ist der AHA Server auf dem FritzBox fehlerhaft: FHEM kann zwar einen gueltigen SID besorgen, aber das Schalten mit dieser SID wird vom AHA Server nicht durchgefuehrt, und mit einer leeren Antwort quittiert.

Vielleicht ist auch eher das Problem, dass in FBAHAHTTP_Write($$$) die zum Zeitpunkt des Schreibens gültige SID in das Kommando geschrieben wird. Kommt es zu einem Reconnect bevor das Kommando abgesetzt werden konnte, wird diese SID wohl ungültig, da eine neue bezogen wird. Somit würde dann nicht mit einer gültigen SID geschaltet.

Also in FBAHAHTTP_Write($$$)

Code Auswählen Erweitern

  push(@{$hash->{CmdStack}}, "sid=$sid&ain=$fn&switchcmd=$msg");
ändern in

Code Auswählen Erweitern

  push(@{$hash->{CmdStack}}, "&ain=$fn&switchcmd=$msg");

und in FBAHAHTTP_ProcessStack($)

Code Auswählen Erweitern

    url=>"$host/webservices/homeautoswitch.lua?$msg",
ändern in

Code Auswählen Erweitern

    url=>"$host/webservices/homeautoswitch.lua?sid=".$hash->{".SID"}.$msg,
Dann fehlt noch die saubere Behandlung einer nicht verfügbaren $hash->{".SID"} vor dem Absetzen des Kommandos.

Ebenso, wie Poll könnte natürlich auch FBAHAHTTP_ProcessStack nach einem Reconnect wieder angeworfen werden, statt alle Schaltbefehle wegzuwerfen. Wenn ein Schaltbefehl nicht ausgeführt werden kann, dann kann auch nur der, statt aller, nach Wiederholversuch weggeworfen werden, wenn der Timer neu aktiviert wird.

Gruß, Ansgar.

PS: mit dem Update meiner 7390 auf FRITZ!OS 06.85 klappt anscheinend leider der Config Request nicht mehr mit FBAHA, damit wurde der Umstieg auf FBAHAHTTP für die 7390 zwingend. Schade, denn leider hat AVM das Voltage Reading für Fritz!Dect 200 nicht bei der 7390 in HTTP Variante implementiert...

[rudolfkoenig]

Danke fuer den Vorschlag, habs eingecheckt, der Stack wird aber weiterhin geloescht.
Falls jemand eine Version ohne Loeschen baut und testet, kann ich es auch gerne einchecken.