FHEM Forum

Hi, ich habe auf das Modul umgestellt.
Abends schalte ich über einen HM-Taster alle Dect200 Dosen aus.
Das funktioniert leider so nicht mehr, da entweder nicht alle Dosen, oder gar keine Dose geschaltet wird. Ich vermute, dass das Absetzen mehrerer Schaltbefehle kurz hintereinander (mit DOIF) nicht verkraftet wird. Per Telefon lassen sich die Dosen weiterhin schalten.
Ignoriere ich den Fehler und versuche einige Zeit später wieder, geht alles wieder, bis ich den Gute-Nacht-Schalter wieder benutze.
Verbose 5 FBAHAHTTP zeigt:

2016.06.17 14:43:07 1: fb2: Not connected, wont execute setswitchoff
2016.06.17 14:43:07 1: fb2: Not connected, wont execute setswitchon
2016.06.17 14:43:07 1: fb2: Not connected, wont execute setswitchoff
2016.06.17 14:43:27 1: fb2: Not connected, wont execute setswitchoff
2016.06.17 14:43:43 1: <devicelist version="1"><device identifier="08761 0087781" id="17" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>TV Licht vorne</name><switch><state>1</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>36970</power><energy>110969</energy></powermeter><temperature><celsius>210</celsius><offset>0</offset></temperature></device><device identifier="08761 0087783" id="18" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>TV Licht hinten</name><switch><state>1</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>18660</power><energy>79988</energy></powermeter><temperature><celsius>230</celsius><offset>-15</offset></temperature></device><device identifier="08761 0149529" id="24" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Stehlampe</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>3224</energy></powermeter><temperature><celsius>230</celsius><offset>-20</offset></temperature></device><device identifier="08761 0091342" id="22" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Kuehlschrank</name><switch><state>1</state><mode>manuell</mode><lock>1</lock></switch><powermeter><power>194470</power><energy>328659</energy></powermeter><temperature><celsius>230</celsius><offset>-5</offset></temperature></device><device identifier="08761 0101811" id="23" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Trockner</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>98817</energy></powermeter><temperature><celsius>240</celsius><offset>0</offset></temperature></device><device identifier="08761 0087573" id="20" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Luefter</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>5704</energy></powermeter><temperature><celsius>225</celsius><offset>0</offset></temperature></device><device identifier="08761 0002297" id="16" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>PC</name><switch><state>1</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>102490</power><energy>799191</energy></powermeter><temperature><celsius>275</celsius><offset>-5</offset></temperature></device><device identifier="08761 0172730" id="25" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>PC Kunlaya</name><switch><state>0</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>0</power><energy>30746</energy></powermeter><temperature><celsius>225</celsius><offset>-20</offset></temperature></device><device identifier="08761 0087570" id="26" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Lampe Korridor</name><switch><state>1</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>2860</power><energy>11182</energy></powermeter><temperature><celsius>230</celsius><offset>-15</offset></temperature></device><device identifier="08761 0243162" id="27" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>TV</name><switch><state>1</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>90760</power><energy>124265</energy></powermeter><temperature><celsius>235</celsius><offset>-5</offset></temperature></device><device identifier="08761 0245609" id="28" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Schreibtisch</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>629</energy></powermeter><temperature><celsius>235</celsius><offset>0</offset></temperature></device><device identifier="08761 0091219" id="29" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Led Kueche</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>27709</energy></powermeter><temperature><celsius>255</celsius><offset>0</offset></temperature></device></devicelist>

2016.06.17 14:43:43 5: fb2 dispatch <device identifier="08761 0087781" id="17" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>TV Licht vorne</name><switch><state>1</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>36970</power><energy>110969</energy></powermeter><temperature><celsius>210</celsius><offset>0</offset></temperature></device>
2016.06.17 14:43:43 5: fb2 dispatch <device identifier="08761 0087783" id="18" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>TV Licht hinten</name><switch><state>1</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>18660</power><energy>79988</energy></powermeter><temperature><celsius>230</celsius><offset>-15</offset></temperature></device>
2016.06.17 14:43:43 5: fb2 dispatch <device identifier="08761 0149529" id="24" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Stehlampe</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>3224</energy></powermeter><temperature><celsius>230</celsius><offset>-20</offset></temperature></device>
2016.06.17 14:43:43 5: fb2 dispatch <device identifier="08761 0091342" id="22" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Kuehlschrank</name><switch><state>1</state><mode>manuell</mode><lock>1</lock></switch><powermeter><power>194470</power><energy>328659</energy></powermeter><temperature><celsius>230</celsius><offset>-5</offset></temperature></device>
2016.06.17 14:43:43 5: fb2 dispatch <device identifier="08761 0101811" id="23" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Trockner</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>98817</energy></powermeter><temperature><celsius>240</celsius><offset>0</offset></temperature></device>
2016.06.17 14:43:43 5: fb2 dispatch <device identifier="08761 0087573" id="20" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Luefter</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>5704</energy></powermeter><temperature><celsius>225</celsius><offset>0</offset></temperature></device>
2016.06.17 14:43:43 5: fb2 dispatch <device identifier="08761 0002297" id="16" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>PC</name><switch><state>1</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>102490</power><energy>799191</energy></powermeter><temperature><celsius>275</celsius><offset>-5</offset></temperature></device>
2016.06.17 14:43:43 5: fb2 dispatch <device identifier="08761 0172730" id="25" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>PC Kunlaya</name><switch><state>0</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>0</power><energy>30746</energy></powermeter><temperature><celsius>225</celsius><offset>-20</offset></temperature></device>
2016.06.17 14:43:44 5: fb2 dispatch <device identifier="08761 0087570" id="26" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Lampe Korridor</name><switch><state>1</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>2860</power><energy>11182</energy></powermeter><temperature><celsius>230</celsius><offset>-15</offset></temperature></device>
2016.06.17 14:43:44 5: fb2 dispatch <device identifier="08761 0243162" id="27" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>TV</name><switch><state>1</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>90760</power><energy>124265</energy></powermeter><temperature><celsius>235</celsius><offset>-5</offset></temperature></device>
2016.06.17 14:43:44 5: fb2 dispatch <device identifier="08761 0245609" id="28" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Schreibtisch</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>629</energy></powermeter><temperature><celsius>235</celsius><offset>0</offset></temperature></device>
2016.06.17 14:43:44 5: fb2 dispatch <device identifier="08761 0091219" id="29" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Led Kueche</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>27709</energy></powermeter><temperature><celsius>255</celsius><offset>0</offset></temperature></device>
2016.06.17 14:44:28 2: IT set Uhr off
2016.06.17 14:44:29 2: IT set Links off
2016.06.17 14:44:29 2: IT set Rechts off
2016.06.17 14:44:30 2: IT set Wand off
2016.06.17 14:44:34 2: IT set LED_Blumen off
2016.06.17 14:44:35 3: fb2: connect to http://fritz.box:80 timed out
2016.06.17 14:44:35 3: fb2: connect to http://fritz.box:80 timed out
2016.06.17 14:45:00 1: fb2: Not connected, wont execute setswitchoff
2016.06.17 14:46:30 1: fb2: Not connected, wont execute setswitchoff
2016.06.17 14:46:30 1: fb2: Not connected, wont execute setswitchoff
2016.06.17 14:46:30 2: IT set Uhr off
2016.06.17 14:46:31 2: IT set Links off
2016.06.17 14:46:32 2: IT set Rechts off
2016.06.17 14:46:32 2: IT set Wand off
2016.06.17 14:46:36 1: fb2: Not connected, wont execute setswitchoff
2016.06.17 14:46:36 2: IT set LED_Blumen off
2016.06.17 14:46:37 1: fb2: Not connected, wont execute setswitchoff
2016.06.17 14:46:37 1: fb2: Not connected, wont execute setswitchon
2016.06.17 14:46:37 1: fb2: Not connected, wont execute setswitchoff
2016.06.17 14:46:57 1: fb2: Not connected, wont execute setswitchoff
2016.06.17 14:47:06 1: fb2: Not connected, wont execute setswitchon
2016.06.17 14:47:21 1: fb2: Not connected, wont execute setswitchon
2016.06.17 14:47:23 1: fb2: Not connected, wont execute setswitchoff
2016.06.17 14:47:27 1: fb2: Not connected, wont execute setswitchon
2016.06.17 14:47:28 1: fb2: Not connected, wont execute setswitchoff
2016.06.17 14:48:30 1: fb2: Not connected, wont execute setswitchoff



Hat ausser mir noch jemand solche Erfahrungen? Was kann ich versuchen, um das Problem zu lösen? Jede Dose wird vor dem Auftreten der Blockade EINZELN korrekt geschaltet.

Übrigens zeigt FHEM alle Geräte als ausgeschaltet an. Verstehe ich nicht ganz, da ja eine Rückmeldung der Dosen erfolgen sollte? Bin mir aber nicht sicher.

Danke im Voraus für Antworten und Ideen.

Aus eigener Erfahrung und evt als Ansatzpunkt: schau dir mal die Definitionen deiner DECT200 an. Meine altbelasteten Defs hatten zu ungewünschten Nebeneffekten geführt: https://forum.fhem.de/index.php/topic,53231.msg449248.html#msg449248

Danke für den Tipp.

Ich denke mich erinnern zu können, dass ich die Dosen neu über Autocreate anlegen lassen habe.
Ein List sieht z.B. so aus:

Internals:
   CFGFN
   DEF        fb2:08761_0002297 powerMeter,tempSensor,switch
   IODev      fb2
   LASTInputDev fb2
   MSGCNT     106
   NAME       PC
   NR         397
   STATE      on
   TYPE       FBDECT
   fb2_MSGCNT 106
   fb2_TIME   2016-06-17 17:44:00
   id         08761_0002297
   props      powerMeter,tempSensor,switch
   Readings:
     2016-06-17 17:44:00   AIN             08761 0002297
     2016-06-17 17:44:00   FBNAME          PC
     2016-06-17 17:44:00   FBPROP          powerMeter,tempSensor,switch
     2016-06-17 17:44:00   FBTYPE          FRITZ!DECT 200
     2016-06-17 17:44:00   ID              16
     2016-06-17 17:44:00   energy          799338 Wh
     2016-06-17 17:44:00   fwversion       03.59
     2016-06-17 17:44:00   locked          no
     2016-06-17 17:44:00   mode            auto
     2016-06-17 17:44:00   power           96.41 W
     2016-06-17 17:44:00   present         yes
     2016-06-17 17:44:00   state           on
     2016-06-17 17:44:00   tempadjust      -0.5 C
     2016-06-17 17:44:00   temperature     26.5 C (measured)
Attributes:
   IODev      fb2
   devStateIcon .*on:light_light_dim_100@lightgreen .*off:light_light_dim_00@red
   event-min-interval power:120
   event-on-change-reading state,power
   model      Dect200
   room       FBDECT,Multimedia,Wohnzimmer
   webCmd     :


Wenn sich herausstellt, dass keiner weitere Ideen hat, werde ich die Dosen noch einmal löschen und per Autocreate nochmals anlegen lassen.

Ich habe zum Vergleich noch einal eine einzelne Dose mit Autocreate neu erstellt.
Ich erkenne keinen Unterschied.
Internals:
   CFGFN
   DEF        fb2:08761_0087573 powerMeter,tempSensor,switch
   IODev      fb2
   LASTInputDev fb2
   MSGCNT     1
   NAME       FBDECT_fb2_08761_0087573
   NR         506
   STATE      off
   TYPE       FBDECT
   fb2_MSGCNT 1
   fb2_TIME   2016-06-17 21:51:40
   id         08761_0087573
   props      powerMeter,tempSensor,switch
   Readings:
     2016-06-17 21:51:40   AIN             08761 0087573
     2016-06-17 21:51:40   FBNAME          Luefter
     2016-06-17 21:51:40   FBPROP          powerMeter,tempSensor,switch
     2016-06-17 21:51:40   FBTYPE          FRITZ!DECT 200
     2016-06-17 21:51:40   ID              20
     2016-06-17 21:51:40   energy          5704 Wh
     2016-06-17 21:51:40   fwversion       03.59
     2016-06-17 21:51:40   locked          no
     2016-06-17 21:51:40   mode            manuell
     2016-06-17 21:51:40   power           0.00 W
     2016-06-17 21:51:40   present         yes
     2016-06-17 21:52:20   state           off
     2016-06-17 21:51:40   tempadjust      0.0 C
     2016-06-17 21:51:40   temperature     21.0 C (measured)
Attributes:
   IODev      fb2
   event-min-interval power:120
   room       FBDECT

Hi,
also bei mir hat nach der Umstellung auch das meiste nicht mehr zuverlässig funktioniert. Hatte aber mit den alten devices gearbeitet trotz dass ich die gleich wie die neuen devices eingestellt hatte.

Am Ende hat ein autocreate alles Geräte die Probleme einwandfrei gelöst.
Da sowas ja eher nur einmalig vorkommt, dachte ich mir es ist nicht wichtig so ein ggf. Falsches Verhalten des Moduls weiter zu verfolgen.

Lg Christian

P.S.: Danke für das modul (falls der Modul Autor hier mitliest, ich bin sehr zufrieden)

Danke für die Antwort. Ich werde also erst einmal alles noch einmal mit Autocreate neu anlegen. Sollte das  nichts bringen, melde ich mich noch einmal.

Das nach einem "connect timed out" die "wont execute" Meldungen kommen, ist "normal", weil das Modul nach einem Verbindungsfehler das SID (Session-ID) zuruecksetzt. Die "connect to ... timed out" Meldungen sind definitiv nicht vom autocreate abhaengig, das Modul versucht nur die Seite
http://fritz.box/webservices/homeautoswitch.lua?sid=$SID&switchcmd=getdevicelistinfos
abzuholen, und das ist unabhaengig davon, was in FHEM definiert ist. Es gibt hier auch anderweitig Meldungen, dass diese Seite manchmal auch mit dem Browser nicht abholbar ist, ich wuesste nicht, was das Modul in so einem Fall anders machen sollte, und vermute ein Problem in FRITZ!OS, was AVM loesen muss.

Da könntest du durchaus Recht haben.
Ich habe fhem komplett neu aufgesetzt auf einer anderen Karte und mit Jessie. Das Verhalten hat sich leider nicht geändert.
Leider bin ich fachlich nicht in der Lage, das Ganze mit AVM auszudiskutieren.
Ich muss also leider wohl bis zur Abschaltung der alten Methode wieder auf diese wechseln.
Mir ist schon ganz schlecht, wenn ich daran denke, was danach kommt.
Vielleicht setze ich die Fritzbox mal als ultimativen Test mit einem Recover neu auf.

Trotzdem vielen Dank für die Hilfe.

Ich habe die Fritzbox nun noch einmal neu recovert.
Eine Besserung ist leider nicht eingetreten.
Schalte ich die Dosen einzeln, funktioniert alle beliebig oft einwandfrei. Schalte ich mehrere Dosen über ein DOIF, geht es nicht oder nur unzuverlässig, also teilweise.
Am DOIF kann es nicht liegen, denke ich, weil die IT-Dosen einwandfrei geschaltet werden.
Im Fehlerfall lassen sich die DECT200 für etwa 3-5 Minuten auch nicht mehr einzeln schalten.
Danach geht alles wieder (Einzelschaltung).
Leider wird der korrekte Zustand der Dosen nicht gemeldet, wenn die Schaltung fehlschlägt.
Wenn ich die Dosen einzeln schalte, kann ich beliebig oft und schnell schalten. Es funktioniert dann alles einwandfrei. Nur der erste Schaltbefehl benötigt etwas länger.
Mir fällt nun nicht mehr ein, was ich noch machen könnte. Ich kann noch wait in die DOIFs einbauen um zu sehen, ob es an der zu schnellen Befehlsfolge liegt.

Hier noch einmal ein Ausschnitt aus dem Log.

2016.06.20 12:16:17 1: Logfile gelöscht
2016.06.20 12:16:26 2: IT set Uhr off
2016.06.20 12:16:27 2: IT set Links off
2016.06.20 12:16:28 2: IT set Rechts off
2016.06.20 12:16:28 2: IT set Wand off
2016.06.20 12:16:32 2: IT set LED_Blumen off
2016.06.20 12:16:33 3: fb2: connect to http://fritz.box:80 timed out
2016.06.20 12:16:33 3: fb2: connect to http://fritz.box:80 timed out
2016.06.20 12:16:53 1: fb2: Not connected, wont execute setswitchoff
2016.06.20 12:16:56 5: fb2 dispatch <device identifier="08761 0087783" id="18" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>TV Licht hinten</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>80221</energy></powermeter><temperature><celsius>240</celsius><offset>-15</offset></temperature></device>
2016.06.20 12:16:56 5: fb2 dispatch <device identifier="08761 0149529" id="24" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Stehlampe</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>3224</energy></powermeter><temperature><celsius>225</celsius><offset>-20</offset></temperature></device>
2016.06.20 12:16:56 5: fb2 dispatch <device identifier="08761 0091342" id="22" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Kuehlschrank</name><switch><state>1</state><mode>manuell</mode><lock>1</lock></switch><powermeter><power>46920</power><energy>330370</energy></powermeter><temperature><celsius>245</celsius><offset>-5</offset></temperature></device>
2016.06.20 12:16:56 5: fb2 dispatch <device identifier="08761 0101811" id="23" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Trockner</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>98817</energy></powermeter><temperature><celsius>240</celsius><offset>0</offset></temperature></device>
2016.06.20 12:16:56 5: fb2 dispatch <device identifier="08761 0087573" id="20" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Luefter</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>5705</energy></powermeter><temperature><celsius>230</celsius><offset>0</offset></temperature></device>
2016.06.20 12:16:56 5: fb2 dispatch <device identifier="08761 0002297" id="16" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>PC</name><switch><state>1</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>97130</power><energy>801674</energy></powermeter><temperature><celsius>260</celsius><offset>-5</offset></temperature></device>
2016.06.20 12:16:56 5: fb2 dispatch <device identifier="08761 0172730" id="25" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>PC Kunlaya</name><switch><state>0</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>0</power><energy>30871</energy></powermeter><temperature><celsius>225</celsius><offset>-20</offset></temperature></device>
2016.06.20 12:16:56 5: fb2 dispatch <device identifier="08761 0087570" id="26" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Lampe Korridor</name><switch><state>1</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>3000</power><energy>11228</energy></powermeter><temperature><celsius>240</celsius><offset>-15</offset></temperature></device>
2016.06.20 12:16:56 5: fb2 dispatch <device identifier="08761 0243162" id="27" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>TV</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>127250</energy></powermeter><temperature><celsius>230</celsius><offset>-5</offset></temperature></device>
2016.06.20 12:16:56 5: fb2 dispatch <device identifier="08761 0245609" id="28" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Schreibtisch</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>629</energy></powermeter><temperature><celsius>240</celsius><offset>0</offset></temperature></device>
2016.06.20 12:16:56 5: fb2 dispatch <device identifier="08761 0091219" id="29" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Led Kueche</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>27722</energy></powermeter><temperature><celsius>270</celsius><offset>0</offset></temperature></device>
2016.06.20 12:16:56 5: fb2 dispatch <device identifier="08761 0087781" id="30" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>FRITZ!DECT 200 #15</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>111246</energy></powermeter><temperature><celsius>225</celsius><offset>0</offset></temperature></device>
2016.06.20 12:17:55 2: IT set LED_Blumen on
2016.06.20 12:17:56 2: IT set Uhr on
2016.06.20 12:17:57 2: IT set LED_Blumen on
2016.06.20 12:17:57 2: IT set Uhr on
2016.06.20 12:17:58 2: IT set LED_Blumen on
2016.06.20 12:17:59 2: IT set Uhr on
2016.06.20 12:18:00 2: IT set LED_Blumen on
2016.06.20 12:18:00 2: IT set Uhr on
2016.06.20 12:18:01 3: fb2: write to http://fritz.box:80 timed out
2016.06.20 12:18:01 3: fb2: write to http://fritz.box:80 timed out
2016.06.20 12:18:01 3: fb2: write to http://fritz.box:80 timed out
2016.06.20 12:18:01 3: fb2: connect to http://fritz.box:80 timed out
2016.06.20 12:18:01 3: fb2: connect to http://fritz.box:80 timed out
2016.06.20 12:18:01 3: fb2: connect to http://fritz.box:80 timed out
2016.06.20 12:18:39 1: fb2: Not connected, wont execute setswitchoff
2016.06.20 12:18:39 1: fb2: Not connected, wont execute setswitchoff
2016.06.20 12:18:39 2: IT set Uhr off
2016.06.20 12:18:40 2: IT set Links off
2016.06.20 12:18:40 2: IT set Rechts off
2016.06.20 12:18:41 2: IT set Wand off
2016.06.20 12:18:45 1: fb2: Not connected, wont execute setswitchoff
2016.06.20 12:18:45 2: IT set LED_Blumen off
2016.06.20 12:18:45 1: fb2: Not connected, wont execute setswitchoff
2016.06.20 12:18:46 1: fb2: Not connected, wont execute setswitchon
2016.06.20 12:18:46 1: fb2: Not connected, wont execute setswitchoff


Warum auf der neu aufgesetzten Box dieser Fehler kommt, kann ich mir auch nicht erklären.
Pi, HMLAN und PC hängen direkt am Router per Kabel.
Die Kabel habe ich bereits ausgetauscht.

Ich habe also folgendes gemacht:

Pi und fhewm auf anderer Karte neu installiert
Fritzbox recovert
Netzwerkkabel getauscht

Nun fällt mir nichts mehr ein.
Da der angezeigte Schaltzustand nicht mehr immer dem wirklichen Scahltzustand der Dosen entspricht, ist eine sinnvolle Kontrolle per VPN nicht mehr möglich.

Hat noch jemand eine Idee?

Kannst du bitte zwischen den einzelnen Schaltvorgaengen sleeps (am besten FHEM-sleep, nicht Perl-sleep) einbauen?
Fang mal mit 1 Sekunde an, und jenachdem, ob es klappt, erhoehen oder verkleinern (0.5, 0.2, 0.1 usw). Und bitte "attr global mseclog" setzen, damit wir im Log genauere Zeitstempel sehen. Habe ich noch richtig in Erinnerung, dass das gleiche Schalten mit der FBAHA Interface keine Probleme verursacht hat?

Ich bin nun runter bis auf 0.1 Sekunden. Es scheint so, als würde zuverlässig geschaltet werden.
Wenn allerdings eine Blockade erzeugt wird (z.B. durch DOIF ohne Pausen) dann wird auch hier nicht geschaltet.
Es kommt mir so vor, als würde die Fritzbox sich abschotten, weil ich durch die vielen Schaltversuche den Anschein eines Angriffes erwecke? Durch die Minipausen erfolgt diese Fehlinterpretation nicht.

Hier nochmals Log.
2016.06.20 16:04:56.069 5: fb2 dispatch <device identifier="08761 0087783" id="18" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>TV Licht hinten</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>80238</energy></powermeter><temperature><celsius>255</celsius><offset>-15</offset></temperature></device>
2016.06.20 16:04:56.109 5: fb2 dispatch <device identifier="08761 0149529" id="24" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Stehlampe</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>3224</energy></powermeter><temperature><celsius>225</celsius><offset>-20</offset></temperature></device>
2016.06.20 16:04:56.142 5: fb2 dispatch <device identifier="08761 0091342" id="22" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Kuehlschrank</name><switch><state>1</state><mode>manuell</mode><lock>1</lock></switch><powermeter><power>1780</power><energy>330448</energy></powermeter><temperature><celsius>240</celsius><offset>-5</offset></temperature></device>
2016.06.20 16:04:56.187 5: fb2 dispatch <device identifier="08761 0101811" id="23" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Trockner</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>98817</energy></powermeter><temperature><celsius>245</celsius><offset>0</offset></temperature></device>
2016.06.20 16:04:56.237 5: fb2 dispatch <device identifier="08761 0087573" id="20" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Luefter</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>5705</energy></powermeter><temperature><celsius>245</celsius><offset>0</offset></temperature></device>
2016.06.20 16:04:56.286 5: fb2 dispatch <device identifier="08761 0002297" id="16" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>PC</name><switch><state>1</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>101200</power><energy>801913</energy></powermeter><temperature><celsius>275</celsius><offset>-5</offset></temperature></device>
2016.06.20 16:04:56.317 5: fb2 dispatch <device identifier="08761 0172730" id="25" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>PC Kunlaya</name><switch><state>0</state><mode>auto</mode><lock>0</lock></switch><powermeter><power>0</power><energy>30871</energy></powermeter><temperature><celsius>240</celsius><offset>-20</offset></temperature></device>
2016.06.20 16:04:56.348 5: fb2 dispatch <device identifier="08761 0087570" id="26" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Lampe Korridor</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>11231</energy></powermeter><temperature><celsius>250</celsius><offset>-15</offset></temperature></device>
2016.06.20 16:04:56.386 5: fb2 dispatch <device identifier="08761 0243162" id="27" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>TV</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>127358</energy></powermeter><temperature><celsius>245</celsius><offset>-5</offset></temperature></device>
2016.06.20 16:04:56.430 5: fb2 dispatch <device identifier="08761 0245609" id="28" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Schreibtisch</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>635</energy></powermeter><temperature><celsius>270</celsius><offset>0</offset></temperature></device>
2016.06.20 16:04:56.475 5: fb2 dispatch <device identifier="08761 0091219" id="29" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>Led Kueche</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>27722</energy></powermeter><temperature><celsius>265</celsius><offset>0</offset></temperature></device>
2016.06.20 16:04:56.511 5: fb2 dispatch <device identifier="08761 0087781" id="30" functionbitmask="896" fwversion="03.59" manufacturer="AVM" productname="FRITZ!DECT 200"><present>1</present><name>TV Licht vorne</name><switch><state>0</state><mode>manuell</mode><lock>0</lock></switch><powermeter><power>0</power><energy>111278</energy></powermeter><temperature><celsius>245</celsius><offset>0</offset></temperature></device>


Ich danke dir für die Hilfe.

Ich habe eine neue Version eingecheckt, was die Befehle serialisiert: ein Befehl wird erst dann an den AHA Server gesendet, wenn der vorherige beantwortet wurde. Das bedeutet, dass zwischen einzelnen Befehlen jetzt ca 0.2 Sekunden vergehen.
Interessanterweise reicht das noch nicht aus, damit ein "set X on; set X off" richtig ausgefuehrt wird, dazu muss ich ein sleep von 0.3s einfuegen (0.25 reicht nicht), sonst wird der off zwar bestaetigt, aber nicht ausgefuehrt.

Da ich nur ein Geraet zum testen habe: kannst du bitte dein Szenario durchspielen und hier berichten?

Ja, danke. Das mache ich gerne. Ich habe extra vorausschauend mein altes DOIF aufgehoben.
Vielen Dank für deine Mühe. Ich werde berichten.

Ich habe das Modul getestet.
Nach heutigem Update lief leider gar nichts mehr richtig. Fhem startete sehr langsam und auch der Aufruf der Räume dauerte ewig.
Ich habe daraufhin deine Module umbenannt und restore gemacht.
Nach dem Restore ging alles wie früher, musste ja auch.
Nun habe ich deine Module (die alten) gelöscht und die umbenannten wieder zurück benannt.
Nach Neustart konnte ich nicht schalten. Auch Einzelschaltungen gehen bei mir damit fast nie.

Beim alten Modul konnte ich noch beobachten, dass die erste Schaltung erst nach Ablauf der Pollzeit von 5 Minuten erfolgreich verläuft.
Um das zu testen, habe ich die Pollzeit auf 1 Minute geändert. Nach Neustart konnte ich dann nach einer Minute schalten.
Ist das Absicht, oder ein Bug?

Fazit:
Ich muss mit dem Stand von gestern weiter arbeiten.
Sollten ausser den Modulen FBAHA* weitere Module an der Nutzung beteiligt sein, würde ich noch einmal testen und bitte um entsprechende Mitteilung.

Obwohl ich versucht habe, mich klar auszudrücken, bin ich mir nicht sicher, ob es in diesem Fall gelungen ist. Bitte bei Bedarf noch einmal nachfragen.

Dankeschön

Bitte update wiederholen, und erneut versuchen, siehe https://forum.fhem.de/index.php?topic=54833

Leider funktioniert das Schalten mit beiden DOIF-Versionen nicht, oder nicht richtig.
Die Schaltzustände werden aber korrekt angezeigt, leider erst sehr spät nach dem Schalten.

Ich klicke auf off, die Anzeige geht auch auf off, der Dect200 bleibt aber an. Nach einer Weile geht auch die Anzeige wieder auf on. Ich vermute, das hat auch mit der Pollzeit zu tun. Hab ich aber noch nicht gemessen, nur geschätzt. Bei mir ist ja zur Zeit eine Minute eingetragen.
Auch die Verzögerung nach fhem-Start besteht noch immer.
2016.06.21 15:48:56.817 3: fb2: connect to http://fritz.box:80 timed out
2016.06.21 15:49:13.803 1: fb2: Not connected, wont execute setswitchoff
2016.06.21 15:49:16.402 1: fb2: Not connected, wont execute setswitchoff


Verbose 5 kann ich auf Wunsch wieder einscahlten.
FHEM läuft hingegen wieder normal seit dem Update, zumindest soweit ich das beurteilen kann.

Ich habe jetzt ein async_delay Attribut (default 0.2 Sekunden) eingefuehrt.
Wuerde mich ueber Feedback freuen.

Vielen Dank, gerne.
Aber wo finde ich die Datei?

Im SVN (sourceforge), und ab morgen um 8 im update.

Ich habe getestet und teilweise gute Nachrichten.
Das Schalten mehrerer Dosen mit einer Pause dazwischen funktioniert mit der neuen Version von heute.
Das Schalten ohne Pausen, also mein normales DOIF, welches nachts alles ausschaltet, geht leider noch immer nicht.
Ich habe mal nach einem Neustart mit global verbose 5 geloggt.
Kürzer ist leider nicht möglich.

2016.06.23 09:07:44.696 5: Triggering DI_Test1 (1 changes)
2016.06.23 09:07:44.697 5: Starting notify loop for DI_Test1, first event wait_timer: no timer
2016.06.23 09:07:44.720 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:44.731 5: Cmd: >set DU_Nachtzeit on<
2016.06.23 09:07:44.733 4: dummy set DU_Nachtzeit on
2016.06.23 09:07:44.734 5: Triggering DU_Nachtzeit (1 changes)
2016.06.23 09:07:44.734 5: Starting notify loop for DU_Nachtzeit, first event on
2016.06.23 09:07:44.753 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:44.759 5: Triggering DI_Test1 (5 changes)
2016.06.23 09:07:44.760 5: Starting notify loop for DI_Test1, first event cmd_nr: 1
2016.06.23 09:07:44.781 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:44.794 5: Triggering DI_Test1 (1 changes)
2016.06.23 09:07:44.794 5: Starting notify loop for DI_Test1, first event wait_timer: 23.06.2016 09:07:44 cmd_1_4 DU_DI_gute_Nacht_Trigger
2016.06.23 09:07:44.812 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:44.825 4: HttpUtils url=http://fritz.box/webservices/homeautoswitch.lua?sid=5520788b195101b5&ain=08761 0087783&switchcmd=setswitchoff
2016.06.23 09:07:44.997 5: Triggering DI_Test1 (1 changes)
2016.06.23 09:07:44.998 5: Starting notify loop for DI_Test1, first event wait_timer: no timer
2016.06.23 09:07:45.016 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:45.024 5: Cmd: >set PC_Kunlaya off<
2016.06.23 09:07:45.027 5: Triggering DI_Test1 (5 changes)
2016.06.23 09:07:45.027 5: Starting notify loop for DI_Test1, first event cmd_nr: 1
2016.06.23 09:07:45.048 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:45.060 5: Triggering DI_Test1 (1 changes)
2016.06.23 09:07:45.061 5: Starting notify loop for DI_Test1, first event wait_timer: 23.06.2016 09:07:45 cmd_1_5 DU_DI_gute_Nacht_Trigger
2016.06.23 09:07:45.079 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:45.093 4: http://fritz.box/webservices/homeautoswitch.lua?sid=5520788b195101b5&ain=08761 0087783&switchcmd=setswitchoff: HTTP response code 200
2016.06.23 09:07:45.094 4: HttpUtils http://fritz.box/webservices/homeautoswitch.lua?sid=5520788b195101b5&ain=08761 0087783&switchcmd=setswitchoff: Got data, length: 2
2016.06.23 09:07:45.094 5: FBAHAHTTP_Write reply for fb2: 0
2016.06.23 09:07:45.264 5: Triggering DI_Test1 (1 changes)
2016.06.23 09:07:45.264 5: Starting notify loop for DI_Test1, first event wait_timer: no timer
2016.06.23 09:07:45.282 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:45.290 5: Cmd: >set Schreibtisch off<
2016.06.23 09:07:45.292 5: Triggering Schreibtisch (1 changes)
2016.06.23 09:07:45.292 5: Starting notify loop for Schreibtisch, first event off
2016.06.23 09:07:45.310 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:45.311 5: rg_Stromverbrauch: not on any display, ignoring notify
2016.06.23 09:07:45.317 5: Triggering DI_Test1 (5 changes)
2016.06.23 09:07:45.318 5: Starting notify loop for DI_Test1, first event cmd_nr: 1
2016.06.23 09:07:45.338 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:45.350 5: Triggering DI_Test1 (1 changes)
2016.06.23 09:07:45.350 5: Starting notify loop for DI_Test1, first event wait_timer: 23.06.2016 09:07:45 cmd_1_6 DU_DI_gute_Nacht_Trigger
2016.06.23 09:07:45.368 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:45.381 4: HttpUtils url=http://fritz.box/webservices/homeautoswitch.lua?sid=5520788b195101b5&ain=08761 0087783&switchcmd=setswitchoff
2016.06.23 09:07:45.553 5: Triggering DI_Test1 (1 changes)
2016.06.23 09:07:45.554 5: Starting notify loop for DI_Test1, first event wait_timer: no timer
2016.06.23 09:07:45.572 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:45.579 5: Cmd: >set Lampe_Korridor on-for-timer 20<
2016.06.23 09:07:45.583 5: Triggering Lampe_Korridor (1 changes)
2016.06.23 09:07:45.583 5: Starting notify loop for Lampe_Korridor, first event on
2016.06.23 09:07:45.608 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:45.609 5: rg_Stromverbrauch: not on any display, ignoring notify
2016.06.23 09:07:45.615 5: Triggering DI_Test1 (5 changes)
2016.06.23 09:07:45.616 5: Starting notify loop for DI_Test1, first event cmd_nr: 1
2016.06.23 09:07:45.636 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:45.648 5: Triggering DI_Test1 (1 changes)
2016.06.23 09:07:45.649 5: Starting notify loop for DI_Test1, first event wait_timer: 23.06.2016 09:07:45 cmd_1_7 DU_DI_gute_Nacht_Trigger
2016.06.23 09:07:45.667 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:45.680 4: http://fritz.box/webservices/homeautoswitch.lua?sid=5520788b195101b5&ain=08761 0087783&switchcmd=setswitchoff: HTTP response code 200
2016.06.23 09:07:45.681 4: HttpUtils http://fritz.box/webservices/homeautoswitch.lua?sid=5520788b195101b5&ain=08761 0087783&switchcmd=setswitchoff: Got data, length: 2
2016.06.23 09:07:45.681 5: FBAHAHTTP_Write reply for fb2: 0
2016.06.23 09:07:45.852 5: Triggering DI_Test1 (1 changes)
2016.06.23 09:07:45.852 5: Starting notify loop for DI_Test1, first event wait_timer: no timer
2016.06.23 09:07:45.870 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:45.878 5: Cmd: >set Uhr off<
2016.06.23 09:07:45.891 5: Triggering CUL_1 (1 changes)
2016.06.23 09:07:45.892 5: Starting notify loop for CUL_1, first event raw: 10
2016.06.23 09:07:45.910 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:45.910 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 09:07:45.916 4: IT set ITrepetition: isr10 for CUL_1
2016.06.23 09:07:45.916 2: IT set Uhr off
2016.06.23 09:07:46.468 5: Triggering CUL_1 (1 changes)
2016.06.23 09:07:46.468 5: Starting notify loop for CUL_1, first event raw: isF00000000FF0
2016.06.23 09:07:46.486 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:46.487 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 09:07:46.492 4: Answer from CUL_1:   raw => isF00000000FF0
2016.06.23 09:07:46.504 5: Triggering CUL_1 (1 changes)
2016.06.23 09:07:46.504 5: Starting notify loop for CUL_1, first event raw: 6
2016.06.23 09:07:46.522 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:46.523 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 09:07:46.528 4: IT set ITrepetition back: isr6 for CUL_1
2016.06.23 09:07:46.529 5: Triggering Uhr (1 changes)
2016.06.23 09:07:46.529 5: Starting notify loop for Uhr, first event off
2016.06.23 09:07:46.546 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:46.553 5: Triggering DI_Test1 (5 changes)
2016.06.23 09:07:46.553 5: Starting notify loop for DI_Test1, first event cmd_nr: 1
2016.06.23 09:07:46.573 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:46.584 5: Triggering DI_Test1 (1 changes)
2016.06.23 09:07:46.584 5: Starting notify loop for DI_Test1, first event wait_timer: 23.06.2016 09:07:46 cmd_1_8 DU_DI_gute_Nacht_Trigger
2016.06.23 09:07:46.602 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:46.614 4: HttpUtils url=http://fritz.box/webservices/homeautoswitch.lua?sid=5520788b195101b5&ain=08761 0087783&switchcmd=setswitchoff
2016.06.23 09:07:46.788 5: Triggering DI_Test1 (1 changes)
2016.06.23 09:07:46.788 5: Starting notify loop for DI_Test1, first event wait_timer: no timer
2016.06.23 09:07:46.806 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:46.814 5: Cmd: >set LED_Blumen off<
2016.06.23 09:07:46.826 5: Triggering CUL_1 (1 changes)
2016.06.23 09:07:46.826 5: Starting notify loop for CUL_1, first event raw: 10
2016.06.23 09:07:46.844 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:46.845 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 09:07:46.850 4: IT set ITrepetition: isr10 for CUL_1
2016.06.23 09:07:46.851 2: IT set LED_Blumen off
2016.06.23 09:07:47.402 5: Triggering CUL_1 (1 changes)
2016.06.23 09:07:47.403 5: Starting notify loop for CUL_1, first event raw: is00000F000FF0
2016.06.23 09:07:47.421 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:47.421 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 09:07:47.426 4: Answer from CUL_1:   raw => is00000F000FF0
2016.06.23 09:07:47.438 5: Triggering CUL_1 (1 changes)
2016.06.23 09:07:47.438 5: Starting notify loop for CUL_1, first event raw: 6
2016.06.23 09:07:47.456 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:47.457 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 09:07:47.462 4: IT set ITrepetition back: isr6 for CUL_1
2016.06.23 09:07:47.463 5: Triggering LED_Blumen (1 changes)
2016.06.23 09:07:47.463 5: Starting notify loop for LED_Blumen, first event off
2016.06.23 09:07:47.484 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:47.491 5: Triggering DI_Test1 (5 changes)
2016.06.23 09:07:47.491 5: Starting notify loop for DI_Test1, first event cmd_nr: 1
2016.06.23 09:07:47.512 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:47.524 5: Triggering DI_Test1 (1 changes)
2016.06.23 09:07:47.525 5: Starting notify loop for DI_Test1, first event wait_timer: 23.06.2016 09:07:47 cmd_1_9 DU_DI_gute_Nacht_Trigger
2016.06.23 09:07:47.543 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:47.555 5: PRESENCE (s7) - stopping timer
2016.06.23 09:07:47.556 5: PRESENCE (s7) - starting blocking call for mode lan-ping
2016.06.23 09:07:47.572 4: BlockingCall (PRESENCE_DoLocalPingScan): created child (7378), uses telnetPort to connect back
2016.06.23 09:07:47.584 4: http://fritz.box/webservices/homeautoswitch.lua?sid=5520788b195101b5&ain=08761 0087783&switchcmd=setswitchoff: HTTP response code 200
2016.06.23 09:07:47.585 4: HttpUtils http://fritz.box/webservices/homeautoswitch.lua?sid=5520788b195101b5&ain=08761 0087783&switchcmd=setswitchoff: Got data, length: 2
2016.06.23 09:07:47.586 5: FBAHAHTTP_Write reply for fb2: 0
2016.06.23 09:07:47.594 5: PRESENCE (s7) - starting ping scan: s7|192.168.178.20|0|4
2016.06.23 09:07:47.686 5: PRESENCE (s5) - ping command returned with output:
PING 192.168.178.39 (192.168.178.39) 56(84) bytes of data.
64 bytes from 192.168.178.39: icmp_req=1 ttl=64 time=110 ms
64 bytes from 192.168.178.39: icmp_req=2 ttl=64 time=138 ms
64 bytes from 192.168.178.39: icmp_req=3 ttl=64 time=73.6 ms
64 bytes from 192.168.178.39: icmp_req=4 ttl=64 time=8.21 ms

--- 192.168.178.39 ping statistics ---
4 packets transmitted, 4 received, 0% packet loss, time 3003ms
rtt min/avg/max/mdev = 8.210/82.758/138.772/48.841 ms
2016.06.23 09:07:47.693 4: Connection accepted from telnetPort_127.0.0.1_60326
2016.06.23 09:07:47.696 5: Cmd: >{PRESENCE_ProcessLocalScan('s5|0|present')}<
2016.06.23 09:07:47.698 5: PRESENCE (s5) - blocking scan result: s5|0|present
2016.06.23 09:07:47.701 4: PRESENCE (s5) - rescheduling next check in 60 seconds
2016.06.23 09:07:47.727 5: Triggering DI_Test1 (1 changes)
2016.06.23 09:07:47.727 5: Starting notify loop for DI_Test1, first event wait_timer: no timer
2016.06.23 09:07:47.747 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:47.757 5: Cmd: >set Links off<
2016.06.23 09:07:47.770 5: Triggering CUL_1 (1 changes)
2016.06.23 09:07:47.771 5: Starting notify loop for CUL_1, first event raw: 10
2016.06.23 09:07:47.787 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:47.788 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 09:07:47.793 4: IT set ITrepetition: isr10 for CUL_1
2016.06.23 09:07:47.793 2: IT set Links off
2016.06.23 09:07:48.345 5: Triggering CUL_1 (1 changes)
2016.06.23 09:07:48.346 5: Starting notify loop for CUL_1, first event raw: is0000000F0FF0
2016.06.23 09:07:48.364 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:48.364 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 09:07:48.370 4: Answer from CUL_1:   raw => is0000000F0FF0
2016.06.23 09:07:48.381 5: Triggering CUL_1 (1 changes)
2016.06.23 09:07:48.382 5: Starting notify loop for CUL_1, first event raw: 6
2016.06.23 09:07:48.399 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:48.400 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 09:07:48.405 4: IT set ITrepetition back: isr6 for CUL_1
2016.06.23 09:07:48.406 5: Triggering Links (1 changes)
2016.06.23 09:07:48.406 5: Starting notify loop for Links, first event off
2016.06.23 09:07:48.428 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:48.435 5: Triggering DI_Test1 (5 changes)
2016.06.23 09:07:48.435 5: Starting notify loop for DI_Test1, first event cmd_nr: 1
2016.06.23 09:07:48.456 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:48.469 5: Triggering DI_Test1 (1 changes)
2016.06.23 09:07:48.469 5: Starting notify loop for DI_Test1, first event wait_timer: 23.06.2016 09:07:48 cmd_1_10 DU_DI_gute_Nacht_Trigger
2016.06.23 09:07:48.487 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:48.497 5: AMAD (AMADCommBridge) - Receive RAW Message in Debugging Mode: POST / HTTP/1.1
Content-Type: text/plain
User-Agent: Mozilla/5.0 (compatible; Automagic)
FHEMDEVICE: AMAD_TAB10
FHEMCMD: setreading
Host: 192.168.178.99:8090
Connection: Keep-Alive
Accept-Encoding: gzip
Content-Length: 33

flowsetVersionAtDevice@@2.2.3@@@@
2016.06.23 09:07:48.498 4: AMAD (AMADCommBridge) - AMAD_CommBridge: processing receive reading values - Device: AMAD_TAB10 Data: flowsetVersionAtDevice@@2.2.3@@@@
2016.06.23 09:07:48.499 5: AMAD (AMAD_TAB10) - Processing data: flowsetVersionAtDevice@@2.2.3@@@@
2016.06.23 09:07:48.500 5: Triggering AMAD_TAB10 (1 changes)
2016.06.23 09:07:48.500 5: Starting notify loop for AMAD_TAB10, first event active
2016.06.23 09:07:48.527 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:48.527 5: rg_Handys: not on any display, ignoring notify
2016.06.23 09:07:48.533 5: Triggering AMAD_TAB10 (2 changes)
2016.06.23 09:07:48.534 5: Starting notify loop for AMAD_TAB10, first event flowsetVersionAtDevice: 2.2.3
2016.06.23 09:07:48.559 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:48.560 5: rg_Handys: not on any display, ignoring notify
2016.06.23 09:07:48.566 5: AMAD (AMADCommBridge) - Receive RAW Message in Debugging Mode: POST / HTTP/1.1
Content-Type: text/plain
User-Agent: Mozilla/5.0 (compatible; Automagic)
FHEMDEVICE: AMAD_TAB10
FHEMCMD: setreading
Host: 192.168.178.99:8090
Connection: Keep-Alive
Accept-Encoding: gzip
Content-Length: 23

deviceState@@online@@@@
2016.06.23 09:07:48.567 4: AMAD (AMADCommBridge) - AMAD_CommBridge: processing receive reading values - Device: AMAD_TAB10 Data: deviceState@@online@@@@
2016.06.23 09:07:48.567 5: AMAD (AMAD_TAB10) - Processing data: deviceState@@online@@@@
2016.06.23 09:07:48.568 5: Triggering AMAD_TAB10 (1 changes)
2016.06.23 09:07:48.569 5: Starting notify loop for AMAD_TAB10, first event active
2016.06.23 09:07:48.594 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:48.594 5: rg_Handys: not on any display, ignoring notify
2016.06.23 09:07:48.600 5: Triggering AMAD_TAB10 (2 changes)
2016.06.23 09:07:48.601 5: Starting notify loop for AMAD_TAB10, first event deviceState: online
2016.06.23 09:07:48.626 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:48.627 5: rg_Handys: not on any display, ignoring notify
2016.06.23 09:07:48.636 4: HttpUtils url=http://fritz.box/webservices/homeautoswitch.lua?sid=5520788b195101b5&ain=08761 0087783&switchcmd=setswitchoff
2016.06.23 09:07:48.672 5: Triggering DI_Test1 (1 changes)
2016.06.23 09:07:48.673 5: Starting notify loop for DI_Test1, first event wait_timer: no timer
2016.06.23 09:07:48.691 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:48.699 5: Cmd: >set Rechts off<
2016.06.23 09:07:48.711 5: Triggering CUL_1 (1 changes)
2016.06.23 09:07:48.712 5: Starting notify loop for CUL_1, first event raw: 10
2016.06.23 09:07:48.730 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:48.730 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 09:07:48.735 4: IT set ITrepetition: isr10 for CUL_1
2016.06.23 09:07:48.736 2: IT set Rechts off
2016.06.23 09:07:49.288 5: Triggering CUL_1 (1 changes)
2016.06.23 09:07:49.289 5: Starting notify loop for CUL_1, first event raw: is0000FFF00FF0
2016.06.23 09:07:49.307 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:49.307 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 09:07:49.313 4: Answer from CUL_1:   raw => is0000FFF00FF0
2016.06.23 09:07:49.324 5: Triggering CUL_1 (1 changes)
2016.06.23 09:07:49.325 5: Starting notify loop for CUL_1, first event raw: 6
2016.06.23 09:07:49.342 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:49.343 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 09:07:49.348 4: IT set ITrepetition back: isr6 for CUL_1
2016.06.23 09:07:49.348 5: Triggering Rechts (1 changes)
2016.06.23 09:07:49.349 5: Starting notify loop for Rechts, first event off
2016.06.23 09:07:49.366 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:49.373 5: Triggering DI_Test1 (5 changes)
2016.06.23 09:07:49.373 5: Starting notify loop for DI_Test1, first event cmd_nr: 1
2016.06.23 09:07:49.393 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:49.405 5: Triggering DI_Test1 (1 changes)
2016.06.23 09:07:49.405 5: Starting notify loop for DI_Test1, first event wait_timer: 23.06.2016 09:07:49 cmd_1_11 DU_DI_gute_Nacht_Trigger
2016.06.23 09:07:49.423 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:49.433 5: AMAD (AMADCommBridge) - Receive RAW Message in Debugging Mode: POST / HTTP/1.1
Content-Type: text/plain
User-Agent: Mozilla/5.0 (compatible; Automagic)
FHEMDEVICE: AMAD_TAB10
FHEMCMD: setreading
Host: 192.168.178.99:8090
Connection: Keep-Alive
Accept-Encoding: gzip
Content-Length: 59

connectedBTdevices@@null@@@@connectedBTdevicesMAC@@null@@@@
2016.06.23 09:07:49.434 4: AMAD (AMADCommBridge) - AMAD_CommBridge: processing receive reading values - Device: AMAD_TAB10 Data: connectedBTdevices@@null@@@@connectedBTdevicesMAC@@null@@@@
2016.06.23 09:07:49.434 5: AMAD (AMAD_TAB10) - Processing data: connectedBTdevices@@null@@@@connectedBTdevicesMAC@@null@@@@
2016.06.23 09:07:49.435 5: Triggering AMAD_TAB10 (1 changes)
2016.06.23 09:07:49.435 5: Starting notify loop for AMAD_TAB10, first event active
2016.06.23 09:07:49.460 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:49.461 5: rg_Handys: not on any display, ignoring notify
2016.06.23 09:07:49.467 5: Triggering AMAD_TAB10 (3 changes)
2016.06.23 09:07:49.467 5: Starting notify loop for AMAD_TAB10, first event connectedBTdevicesMAC:
2016.06.23 09:07:49.493 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:49.494 5: rg_Handys: not on any display, ignoring notify
2016.06.23 09:07:49.501 5: AMAD (AMADCommBridge) - Receive RAW Message in Debugging Mode: POST / HTTP/1.1
Content-Type: text/plain
User-Agent: Mozilla/5.0 (compatible; Automagic)
FHEMDEVICE: AMAD_TAB10
FHEMCMD: setreading
Host: 192.168.178.99:8090
Connection: Keep-Alive
Accept-Encoding: gzip
Content-Length: 27

flow_SetCommands@@aktiv@@@@
2016.06.23 09:07:49.502 4: AMAD (AMADCommBridge) - AMAD_CommBridge: processing receive reading values - Device: AMAD_TAB10 Data: flow_SetCommands@@aktiv@@@@
2016.06.23 09:07:49.502 5: AMAD (AMAD_TAB10) - Processing data: flow_SetCommands@@aktiv@@@@
2016.06.23 09:07:49.503 5: Triggering AMAD_TAB10 (1 changes)
2016.06.23 09:07:49.503 5: Starting notify loop for AMAD_TAB10, first event active
2016.06.23 09:07:49.527 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:49.528 5: rg_Handys: not on any display, ignoring notify
2016.06.23 09:07:49.534 5: Triggering AMAD_TAB10 (2 changes)
2016.06.23 09:07:49.535 5: Starting notify loop for AMAD_TAB10, first event flow_SetCommands: aktiv
2016.06.23 09:07:49.560 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:49.560 5: rg_Handys: not on any display, ignoring notify
2016.06.23 09:07:49.570 4: http://fritz.box/webservices/homeautoswitch.lua?sid=5520788b195101b5&ain=08761 0087783&switchcmd=setswitchoff: HTTP response code 200
2016.06.23 09:07:49.570 4: HttpUtils http://fritz.box/webservices/homeautoswitch.lua?sid=5520788b195101b5&ain=08761 0087783&switchcmd=setswitchoff: Got data, length: 2
2016.06.23 09:07:49.571 5: FBAHAHTTP_Write reply for fb2: 0
2016.06.23 09:07:49.601 5: AMAD (AMADCommBridge) - Receive RAW Message in Debugging Mode: POST / HTTP/1.1
Content-Type: text/plain
User-Agent: Mozilla/5.0 (compatible; Automagic)
FHEMDEVICE: AMAD_TAB10
FHEMCMD: setreading
Host: 192.168.178.99:8090
Connection: Keep-Alive
Accept-Encoding: gzip
Content-Length: 22

checkActiveTask@@0@@@@
2016.06.23 09:07:49.602 4: AMAD (AMADCommBridge) - AMAD_CommBridge: processing receive reading values - Device: AMAD_TAB10 Data: checkActiveTask@@0@@@@
2016.06.23 09:07:49.602 5: AMAD (AMAD_TAB10) - Processing data: checkActiveTask@@0@@@@
2016.06.23 09:07:49.603 5: Triggering AMAD_TAB10 (1 changes)
2016.06.23 09:07:49.603 5: Starting notify loop for AMAD_TAB10, first event active
2016.06.23 09:07:49.627 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:49.628 5: rg_Handys: not on any display, ignoring notify
2016.06.23 09:07:49.634 5: Triggering AMAD_TAB10 (2 changes)
2016.06.23 09:07:49.634 5: Starting notify loop for AMAD_TAB10, first event checkActiveTask: 0
2016.06.23 09:07:49.659 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:49.660 5: rg_Handys: not on any display, ignoring notify
2016.06.23 09:07:49.669 5: Triggering DI_Test1 (1 changes)
2016.06.23 09:07:49.669 5: Starting notify loop for DI_Test1, first event wait_timer: no timer
2016.06.23 09:07:49.687 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:49.695 5: Cmd: >set Wand off<
2016.06.23 09:07:49.707 5: Triggering CUL_1 (1 changes)
2016.06.23 09:07:49.708 5: Starting notify loop for CUL_1, first event raw: 10
2016.06.23 09:07:49.725 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:49.726 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 09:07:49.731 4: IT set ITrepetition: isr10 for CUL_1
2016.06.23 09:07:49.731 2: IT set Wand off
2016.06.23 09:07:50.282 5: Triggering CUL_1 (1 changes)
2016.06.23 09:07:50.283 5: Starting notify loop for CUL_1, first event raw: is0000F00F0FF0
2016.06.23 09:07:50.301 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:50.301 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 09:07:50.306 4: Answer from CUL_1:   raw => is0000F00F0FF0
2016.06.23 09:07:50.318 5: Triggering CUL_1 (1 changes)
2016.06.23 09:07:50.318 5: Starting notify loop for CUL_1, first event raw: 6
2016.06.23 09:07:50.336 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:50.337 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 09:07:50.342 4: IT set ITrepetition back: isr6 for CUL_1
2016.06.23 09:07:50.342 5: Triggering Wand (1 changes)
2016.06.23 09:07:50.343 5: Starting notify loop for Wand, first event off
2016.06.23 09:07:50.360 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:50.367 5: Triggering DI_Test1 (5 changes)
2016.06.23 09:07:50.367 5: Starting notify loop for DI_Test1, first event cmd_nr: 1
2016.06.23 09:07:50.388 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:50.399 5: Triggering DI_Test1 (1 changes)
2016.06.23 09:07:50.400 5: Starting notify loop for DI_Test1, first event wait_timer: 23.06.2016 09:07:50 cmd_1_12 DU_DI_gute_Nacht_Trigger
2016.06.23 09:07:50.418 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:50.603 5: Triggering DI_Test1 (1 changes)
2016.06.23 09:07:50.603 5: Starting notify loop for DI_Test1, first event wait_timer: no timer
2016.06.23 09:07:50.621 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:50.629 5: Cmd: >set Webradio stop<
2016.06.23 09:07:50.676 5: Triggering Webradio (1 changes)
2016.06.23 09:07:50.676 5: Starting notify loop for Webradio, first event volume: 100
2016.06.23 09:07:50.694 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:50.700 5: Triggering Webradio (1 changes)
2016.06.23 09:07:50.701 5: Starting notify loop for Webradio, first event single: 0
2016.06.23 09:07:50.718 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:50.724 5: Triggering Webradio (1 changes)
2016.06.23 09:07:50.725 5: Starting notify loop for Webradio, first event consume: 0
2016.06.23 09:07:50.742 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:50.748 5: Triggering Webradio (1 changes)
2016.06.23 09:07:50.748 5: Starting notify loop for Webradio, first event playlist: 24015
2016.06.23 09:07:50.766 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:50.772 5: Triggering Webradio (1 changes)
2016.06.23 09:07:50.773 5: Starting notify loop for Webradio, first event playlistlength: 17
2016.06.23 09:07:50.790 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:50.797 5: Triggering Webradio (1 changes)
2016.06.23 09:07:50.797 5: Starting notify loop for Webradio, first event xfade: 0
2016.06.23 09:07:50.814 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:50.820 5: Triggering Webradio (1 changes)
2016.06.23 09:07:50.821 5: Starting notify loop for Webradio, first event mixrampdb: 0.000000
2016.06.23 09:07:50.838 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:50.844 5: Triggering Webradio (1 changes)
2016.06.23 09:07:50.845 5: Starting notify loop for Webradio, first event mixrampdelay: nan
2016.06.23 09:07:50.862 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:50.868 5: Triggering Webradio (1 changes)
2016.06.23 09:07:50.869 5: Starting notify loop for Webradio, first event songid: 1820
2016.06.23 09:07:50.886 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:50.892 5: Triggering Webradio (1 changes)
2016.06.23 09:07:50.893 5: Starting notify loop for Webradio, first event error: problems decoding "http://xapp2278162432c40000.f.l.i.lb.core-cdn.net/40000mb/live/app2278162432/w2288975872/live_de_128.mp3"
2016.06.23 09:07:50.911 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:50.917 5: Triggering Webradio (1 changes)
2016.06.23 09:07:50.917 5: Starting notify loop for Webradio, first event nextsong: 11
2016.06.23 09:07:50.935 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:50.941 5: Triggering Webradio (1 changes)
2016.06.23 09:07:50.941 5: Starting notify loop for Webradio, first event nextsongid: 1830
2016.06.23 09:07:50.958 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:50.966 5: Triggering DI_Test1 (5 changes)
2016.06.23 09:07:50.966 5: Starting notify loop for DI_Test1, first event cmd_nr: 1
2016.06.23 09:07:50.987 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:50.999 5: Triggering DI_Test1 (1 changes)
2016.06.23 09:07:50.999 5: Starting notify loop for DI_Test1, first event wait_timer: 23.06.2016 09:07:51 cmd_1_13 DU_DI_gute_Nacht_Trigger
2016.06.23 09:07:51.017 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:51.204 5: Triggering DI_Test1 (1 changes)
2016.06.23 09:07:51.205 5: Starting notify loop for DI_Test1, first event wait_timer: no timer
2016.06.23 09:07:51.231 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:51.243 5: Cmd: >set DU_DI_gute_Nacht_Trigger off<
2016.06.23 09:07:51.244 4: dummy set DU_DI_gute_Nacht_Trigger off
2016.06.23 09:07:51.245 5: Triggering DU_DI_gute_Nacht_Trigger (1 changes)
2016.06.23 09:07:51.246 5: Starting notify loop for DU_DI_gute_Nacht_Trigger, first event off
2016.06.23 09:07:51.273 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:51.287 5: Triggering DI_Test1 (5 changes)
2016.06.23 09:07:51.287 5: Starting notify loop for DI_Test1, first event cmd_nr: 1
2016.06.23 09:07:51.308 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 09:07:51.757 5: PRESENCE (s7) - ping command returned with output:
PING 192.168.178.20 (192.168.178.20) 56(84) bytes of data.
64 bytes from 192.168.178.20: icmp_req=1 ttl=64 time=658 ms
64 bytes from 192.168.178.20: icmp_req=2 ttl=64 time=784 ms
64 bytes from 192.168.178.20: icmp_req=3 ttl=64 time=528 ms
64 bytes from 192.168.178.20: icmp_req=4 ttl=64 time=1137 ms

--- 192.168.178.20 ping statistics ---
4 packets transmitted, 4 received, 0% packet loss, time 3000ms
rtt min/avg/max/mdev = 528.111/777.132/1137.403/226.885 ms
2016.06.23 09:07:51.761 4: Connection accepted from telnetPort_127.0.0.1_60330
2016.06.23 09:07:51.771 5: Cmd: >{PRESENCE_ProcessLocalScan('s7|0|present')}<
2016.06.23 09:07:51.773 5: PRESENCE (s7) - blocking scan result: s7|0|present
2016.06.23 09:07:51.774 4: PRESENCE (s7) - rescheduling next check in 60 seconds
2016.06.23 09:07:53.383 4: Connection closed for WEB_192.168.178.34_56593: EOF
2016.06.23 09:07:53.387 4: WEB_192.168.178.34_56608 POST /fhem&fw_id=507&room=Dosentest&cmd=sr; BUFLEN:0
2016.06.23 09:07:53.389 5: Cmd: >sr<
2016.06.23 09:07:53.390 5: Cmd: >shutdown restart<
2016.06.23 09:07:53.391 5: Triggering global (1 changes)
2016.06.23 09:07:53.391 5: Starting notify loop for global, first event SHUTDOWN
2016.06.23 09:07:53.417 5: rg_Batteriestatus: not on any display, ignoring notify


Ich sehe, dass das gleiche DECT Geraet innerhalb von 4 Sekunden 4-mal auf off geschaltet wird, wobei die Fritz!Box danach jeweils den Status von 0 (== off) meldet.

Wenn das stimmt: was genau erwartest du?

ich Verstehe nicht. Welche Stelle im Log und welches DECT meinst du genau, kannst du mir mal bitte auf die Sprünge helfen? Habe vergeblich gesucht und nach 15 Minuten aufgegeben. Liegt vielleicht an meinem schlechten Sehvermögen. Langes Suchen und gucken fällt mir halt gesundheitlich schwer.

Auch wenn die Fritzbox off meldet, ist die DECT trotzdem noch an. Umgekehrt genau so. Wird on gemeldet, ist sie halt aus.

Ich habe im Log gesucht nach Cmd: >set.
Da finde ich nur folgende Einträge betreffs DECT200:

Line 4: 2016.06.23 09:07:44.731 5: Cmd: >set DU_Nachtzeit on<
Line 19: 2016.06.23 09:07:45.024 5: Cmd: >set PC_Kunlaya off<
Line 32: 2016.06.23 09:07:45.290 5: Cmd: >set Schreibtisch off<
Line 47: 2016.06.23 09:07:45.579 5: Cmd: >set Lampe_Korridor on-for-timer 20<
Line 64: 2016.06.23 09:07:45.878 5: Cmd: >set Uhr off<
Line 94: 2016.06.23 09:07:46.814 5: Cmd: >set LED_Blumen off<
Line 144: 2016.06.23 09:07:47.757 5: Cmd: >set Links off<
Line 216: 2016.06.23 09:07:48.699 5: Cmd: >set Rechts off<
Line 311: 2016.06.23 09:07:49.695 5: Cmd: >set Wand off<
Line 340: 2016.06.23 09:07:50.629 5: Cmd: >set Webradio stop<
Line 386: 2016.06.23 09:07:51.243 5: Cmd: >set DU_DI_gute_Nacht_Trigger off<

Hier noch zugehöriges DOIF, die DECT habe ich mal eingerückt:
Internals:
   CFGFN
   DEF        ([Taster_oben] =~ "Short" or [DU_DI_gute_Nacht_Trigger] eq "on")
(set DU_DI_gute_Nacht_Trigger off)
(set DU_Nachtzeit on)
     (set TVLICHT_hinten off)
     (set TVLICHT_vorne off)
(set Uhr off)
(set Links off)
(set Rechts off)
(set Wand off)
(set SamsungTV POWEROFF)
     (set PC_Kunlaya off)
(set LED_Blumen off)
     (set Schreibtisch off)
     (set Lampe_Korridor on-for-timer 20)
     (set TV off)
(set Webradio stop)
(set Giga off)

   NAME       DI_gute_Nacht
   NR         103
   NTFY_ORDER 50-DI_gute_Nacht
   STATE      deactivated
   TYPE       DOIF
   Readings:
     2016-06-23 08:34:58   Device          DU_DI_gute_Nacht_Trigger
     2016-06-23 08:35:05   cmd             1.16
     2016-06-23 08:35:05   cmd_event       DU_DI_gute_Nacht_Trigger
     2016-06-23 08:35:05   cmd_nr          1
     2016-06-23 08:35:05   cmd_seqnr       16
     2016-06-23 08:34:58   e_DU_DI_gute_Nacht_Trigger_STATE on
     2016-06-23 18:19:56   state           deactivated
Attributes:
   disable    1
   do         always
   room       Dosentest,System


ZitatWelche Stelle im Log und welches DECT meinst du genau

Such in deinem Log nach fritz.box. Es sind jeweils 3 Zeilen, die zusammengehoeren: die Erste ist der Auftrag, die naechsten beiden die Antwort. Und direkt darunter steht das Ergebnis als "FBAHAHTTP_Write reply".
Es war immer ain=08761 0087783.

Danke, hab ich gefunden,
Das ist ja die einzige Dose, die geschaltet wurde.
Ich muss mal sehen, warum die anderen gar nicht angesprochen wurden.
Das DOIF lief bei mir schon seit Ewigkeiten ohne Probleme, vor der Umstellung.
Ich werde morgen noch einmal in Ruhe testen, jetzt  weiss ich ja, wohin ich gucken kann/muss.
Ich werde mich dann noch einmal mit dem Ergebnis melden.

Bis dahin danke ich dir erst einmal für deine Geduld und Hilfe.

Hat mir doch keine Ruhe gelassen. Ich habe sofort noch einmal probiert.
Es wird, soweit ich das sehe, nur ein DECT-Schaltbefehl von der Box quittiert.
Im DOIF werden aber mindestens 6 DECT angesprochen.
Dazwischen werden Dummys und ITs geschaltet, die auch funktionieren. Ich bin mit meinem Latein am Ende.

Bei TVLICHT_hinten sagt die Box, dass geschaltet wurde, die Dose bleibt aber an.
Bei allen anderen Dosen (z.B. TVLICHT_hinten vorne) sagt die Fritzbox aber gar nichts?


Hier noch einmal das Log:
[code]


2016.06.23 22:52:01.378 5: HMLAN_Send:  HMLAN1 I:K
2016.06.23 22:52:01.382 5: HMLAN/RAW: /HHM-LAN-IF,03C5,LEQ0050111,272DED,272E01,0CB1327B,000E,02

2016.06.23 22:52:01.383 5: HMLAN_Parse: HMLAN1 V:03C5 sNo:LEQ0050111 d:272DED O:272E01 t:0CB1327B IDcnt:000E L:2 %
2016.06.23 22:52:01.384 5: Triggering HMLAN1 (1 changes)
2016.06.23 22:52:01.384 5: Starting notify loop for HMLAN1, first event loadLvl: low
2016.06.23 22:52:01.405 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:01.406 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 22:52:01.550 5: PRESENCE (s5) - ping command returned with output:
PING 192.168.178.39 (192.168.178.39) 56(84) bytes of data.
64 bytes from 192.168.178.39: icmp_req=1 ttl=64 time=106 ms
64 bytes from 192.168.178.39: icmp_req=2 ttl=64 time=137 ms
64 bytes from 192.168.178.39: icmp_req=3 ttl=64 time=40.7 ms
64 bytes from 192.168.178.39: icmp_req=4 ttl=64 time=72.2 ms

--- 192.168.178.39 ping statistics ---
4 packets transmitted, 4 received, 0% packet loss, time 3004ms
rtt min/avg/max/mdev = 40.754/89.137/137.305/36.188 ms
2016.06.23 22:52:01.562 4: Connection accepted from telnetPort_127.0.0.1_44751
2016.06.23 22:52:01.565 5: Cmd: >{PRESENCE_ProcessLocalScan('s5|0|present')}<
2016.06.23 22:52:01.567 5: PRESENCE (s5) - blocking scan result: s5|0|present
2016.06.23 22:52:01.568 4: PRESENCE (s5) - rescheduling next check in 60 seconds
2016.06.23 22:52:01.653 4: WEB_192.168.178.34_49210 GET /fhem?XHR=1&inform=type=status;filter=;since=1466715119;fmt=JSON&fw_id=1752×tamp=1466715114249; BUFLEN:0
2016.06.23 22:52:03.199 5: AMAD (AMADCommBridge) - Receive RAW Message in Debugging Mode: POST / HTTP/1.1
Content-Type: text/plain
User-Agent: Mozilla/5.0 (compatible; Automagic)
FHEMDEVICE: AMAD_S3
FHEMCMD: setreading
Host: 192.168.178.99:8090
Connection: Keep-Alive
Accept-Encoding: gzip
Content-Length: 33

flowsetVersionAtDevice@@2.2.3@@@@
2016.06.23 22:52:03.205 4: AMAD (AMADCommBridge) - AMAD_CommBridge: processing receive reading values - Device: AMAD_S3 Data: flowsetVersionAtDevice@@2.2.3@@@@
2016.06.23 22:52:03.205 5: AMAD (AMAD_S3) - Processing data: flowsetVersionAtDevice@@2.2.3@@@@
2016.06.23 22:52:03.206 5: Triggering AMAD_S3 (1 changes)
2016.06.23 22:52:03.206 5: Starting notify loop for AMAD_S3, first event active
2016.06.23 22:52:03.267 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:03.267 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:03.273 5: Triggering AMAD_S3 (2 changes)
2016.06.23 22:52:03.273 5: Starting notify loop for AMAD_S3, first event flowsetVersionAtDevice: 2.2.3
2016.06.23 22:52:03.290 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:03.291 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:03.299 5: AMAD (AMADCommBridge) - Receive RAW Message in Debugging Mode: POST / HTTP/1.1
Content-Type: text/plain
User-Agent: Mozilla/5.0 (compatible; Automagic)
FHEMDEVICE: AMAD_S3
FHEMCMD: setreading
Host: 192.168.178.99:8090
Connection: Keep-Alive
Accept-Encoding: gzip
Content-Length: 23

deviceState@@online@@@@
2016.06.23 22:52:03.300 4: AMAD (AMADCommBridge) - AMAD_CommBridge: processing receive reading values - Device: AMAD_S3 Data: deviceState@@online@@@@
2016.06.23 22:52:03.300 5: AMAD (AMAD_S3) - Processing data: deviceState@@online@@@@
2016.06.23 22:52:03.301 5: Triggering AMAD_S3 (1 changes)
2016.06.23 22:52:03.301 5: Starting notify loop for AMAD_S3, first event active
2016.06.23 22:52:03.317 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:03.318 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:03.323 5: Triggering AMAD_S3 (2 changes)
2016.06.23 22:52:03.324 5: Starting notify loop for AMAD_S3, first event deviceState: online
2016.06.23 22:52:03.341 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:03.341 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:03.376 5: AMAD (AMADCommBridge) - Receive RAW Message in Debugging Mode: POST / HTTP/1.1
Content-Type: text/plain
User-Agent: Mozilla/5.0 (compatible; Automagic)
FHEMDEVICE: AMAD_S3
FHEMCMD: setreading
Host: 192.168.178.99:8090
Connection: Keep-Alive
Accept-Encoding: gzip
Content-Length: 27

flow_SetCommands@@aktiv@@@@
2016.06.23 22:52:03.377 4: AMAD (AMADCommBridge) - AMAD_CommBridge: processing receive reading values - Device: AMAD_S3 Data: flow_SetCommands@@aktiv@@@@
2016.06.23 22:52:03.377 5: AMAD (AMAD_S3) - Processing data: flow_SetCommands@@aktiv@@@@
2016.06.23 22:52:03.378 5: Triggering AMAD_S3 (1 changes)
2016.06.23 22:52:03.378 5: Starting notify loop for AMAD_S3, first event active
2016.06.23 22:52:03.394 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:03.395 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:03.400 5: Triggering AMAD_S3 (2 changes)
2016.06.23 22:52:03.401 5: Starting notify loop for AMAD_S3, first event flow_SetCommands: aktiv
2016.06.23 22:52:03.418 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:03.418 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:03.426 5: AMAD (AMADCommBridge) - Receive RAW Message in Debugging Mode: POST / HTTP/1.1
Content-Type: text/plain
User-Agent: Mozilla/5.0 (compatible; Automagic)
FHEMDEVICE: AMAD_S3
FHEMCMD: setreading
Host: 192.168.178.99:8090
Connection: Keep-Alive
Accept-Encoding: gzip
Content-Length: 59

connectedBTdevices@@null@@@@connectedBTdevicesMAC@@null@@@@
2016.06.23 22:52:03.427 4: AMAD (AMADCommBridge) - AMAD_CommBridge: processing receive reading values - Device: AMAD_S3 Data: connectedBTdevices@@null@@@@connectedBTdevicesMAC@@null@@@@
2016.06.23 22:52:03.427 5: AMAD (AMAD_S3) - Processing data: connectedBTdevices@@null@@@@connectedBTdevicesMAC@@null@@@@
2016.06.23 22:52:03.428 5: Triggering AMAD_S3 (1 changes)
2016.06.23 22:52:03.428 5: Starting notify loop for AMAD_S3, first event active
2016.06.23 22:52:03.444 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:03.445 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:03.451 5: Triggering AMAD_S3 (3 changes)
2016.06.23 22:52:03.451 5: Starting notify loop for AMAD_S3, first event connectedBTdevicesMAC:
2016.06.23 22:52:03.468 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:03.469 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:03.487 5: AMAD (AMADCommBridge) - Receive RAW Message in Debugging Mode: POST / HTTP/1.1
Content-Type: text/plain
User-Agent: Mozilla/5.0 (compatible; Automagic)
FHEMDEVICE: AMAD_TAB8
FHEMCMD: setreading
Host: 192.168.178.99:8090
Connection: Keep-Alive
Accept-Encoding: gzip
Content-Length: 33

flowsetVersionAtDevice@@2.2.3@@@@
2016.06.23 22:52:03.487 4: AMAD (AMADCommBridge) - AMAD_CommBridge: processing receive reading values - Device: AMAD_TAB8 Data: flowsetVersionAtDevice@@2.2.3@@@@
2016.06.23 22:52:03.488 5: AMAD (AMAD_TAB8) - Processing data: flowsetVersionAtDevice@@2.2.3@@@@
2016.06.23 22:52:03.488 5: Triggering AMAD_TAB8 (1 changes)
2016.06.23 22:52:03.489 5: Starting notify loop for AMAD_TAB8, first event active
2016.06.23 22:52:03.511 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:03.512 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:03.518 5: Triggering AMAD_TAB8 (2 changes)
2016.06.23 22:52:03.518 5: Starting notify loop for AMAD_TAB8, first event flowsetVersionAtDevice: 2.2.3
2016.06.23 22:52:03.541 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:03.542 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:03.549 5: AMAD (AMADCommBridge) - Receive RAW Message in Debugging Mode: POST / HTTP/1.1
Content-Type: text/plain
User-Agent: Mozilla/5.0 (compatible; Automagic)
FHEMDEVICE: AMAD_TAB8
FHEMCMD: setreading
Host: 192.168.178.99:8090
Connection: Keep-Alive
Accept-Encoding: gzip
Content-Length: 23

deviceState@@online@@@@
2016.06.23 22:52:03.550 4: AMAD (AMADCommBridge) - AMAD_CommBridge: processing receive reading values - Device: AMAD_TAB8 Data: deviceState@@online@@@@
2016.06.23 22:52:03.550 5: AMAD (AMAD_TAB8) - Processing data: deviceState@@online@@@@
2016.06.23 22:52:03.551 5: Triggering AMAD_TAB8 (1 changes)
2016.06.23 22:52:03.551 5: Starting notify loop for AMAD_TAB8, first event active
2016.06.23 22:52:03.574 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:03.574 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:03.580 5: Triggering AMAD_TAB8 (2 changes)
2016.06.23 22:52:03.580 5: Starting notify loop for AMAD_TAB8, first event deviceState: online
2016.06.23 22:52:03.603 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:03.604 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:03.610 5: AMAD (AMADCommBridge) - Receive RAW Message in Debugging Mode: POST / HTTP/1.1
Content-Type: text/plain
User-Agent: Mozilla/5.0 (compatible; Automagic)
FHEMDEVICE: AMAD_S3
FHEMCMD: setreading
Host: 192.168.178.99:8090
Connection: Keep-Alive
Accept-Encoding: gzip
Content-Length: 22

checkActiveTask@@0@@@@
2016.06.23 22:52:03.610 4: AMAD (AMADCommBridge) - AMAD_CommBridge: processing receive reading values - Device: AMAD_S3 Data: checkActiveTask@@0@@@@
2016.06.23 22:52:03.611 5: AMAD (AMAD_S3) - Processing data: checkActiveTask@@0@@@@
2016.06.23 22:52:03.611 5: Triggering AMAD_S3 (1 changes)
2016.06.23 22:52:03.612 5: Starting notify loop for AMAD_S3, first event active
2016.06.23 22:52:03.628 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:03.628 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:03.634 5: Triggering AMAD_S3 (2 changes)
2016.06.23 22:52:03.635 5: Starting notify loop for AMAD_S3, first event checkActiveTask: 0
2016.06.23 22:52:03.651 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:03.652 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:03.659 5: AMAD (AMADCommBridge) - Receive RAW Message in Debugging Mode: POST / HTTP/1.1
Content-Type: text/plain
User-Agent: Mozilla/5.0 (compatible; Automagic)
FHEMDEVICE: AMAD_TAB8
FHEMCMD: setreading
Host: 192.168.178.99:8090
Connection: Keep-Alive
Accept-Encoding: gzip
Content-Length: 27

flow_SetCommands@@aktiv@@@@
2016.06.23 22:52:03.660 4: AMAD (AMADCommBridge) - AMAD_CommBridge: processing receive reading values - Device: AMAD_TAB8 Data: flow_SetCommands@@aktiv@@@@
2016.06.23 22:52:03.661 5: AMAD (AMAD_TAB8) - Processing data: flow_SetCommands@@aktiv@@@@
2016.06.23 22:52:03.661 5: Triggering AMAD_TAB8 (1 changes)
2016.06.23 22:52:03.662 5: Starting notify loop for AMAD_TAB8, first event active
2016.06.23 22:52:03.684 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:03.685 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:03.690 5: Triggering AMAD_TAB8 (2 changes)
2016.06.23 22:52:03.691 5: Starting notify loop for AMAD_TAB8, first event flow_SetCommands: aktiv
2016.06.23 22:52:03.714 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:03.714 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:03.720 5: AMAD (AMADCommBridge) - Receive RAW Message in Debugging Mode: POST / HTTP/1.1
Content-Type: text/plain
User-Agent: Mozilla/5.0 (compatible; Automagic)
FHEMDEVICE: AMAD_TAB8
FHEMCMD: setreading
Host: 192.168.178.99:8090
Connection: Keep-Alive
Accept-Encoding: gzip
Content-Length: 59

connectedBTdevices@@null@@@@connectedBTdevicesMAC@@null@@@@
2016.06.23 22:52:03.721 4: AMAD (AMADCommBridge) - AMAD_CommBridge: processing receive reading values - Device: AMAD_TAB8 Data: connectedBTdevices@@null@@@@connectedBTdevicesMAC@@null@@@@
2016.06.23 22:52:03.721 5: AMAD (AMAD_TAB8) - Processing data: connectedBTdevices@@null@@@@connectedBTdevicesMAC@@null@@@@
2016.06.23 22:52:03.722 5: Triggering AMAD_TAB8 (1 changes)
2016.06.23 22:52:03.722 5: Starting notify loop for AMAD_TAB8, first event active
2016.06.23 22:52:03.745 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:03.745 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:03.751 5: Triggering AMAD_TAB8 (3 changes)
2016.06.23 22:52:03.751 5: Starting notify loop for AMAD_TAB8, first event connectedBTdevicesMAC:
2016.06.23 22:52:03.775 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:03.776 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:03.823 5: AMAD (AMADCommBridge) - Receive RAW Message in Debugging Mode: POST / HTTP/1.1
Content-Type: text/plain
User-Agent: Mozilla/5.0 (compatible; Automagic)
FHEMDEVICE: AMAD_TAB8
FHEMCMD: setreading
Host: 192.168.178.99:8090
Connection: Keep-Alive
Accept-Encoding: gzip
Content-Length: 22

checkActiveTask@@0@@@@
2016.06.23 22:52:03.824 4: AMAD (AMADCommBridge) - AMAD_CommBridge: processing receive reading values - Device: AMAD_TAB8 Data: checkActiveTask@@0@@@@
2016.06.23 22:52:03.824 5: AMAD (AMAD_TAB8) - Processing data: checkActiveTask@@0@@@@
2016.06.23 22:52:03.825 5: Triggering AMAD_TAB8 (1 changes)
2016.06.23 22:52:03.825 5: Starting notify loop for AMAD_TAB8, first event active
2016.06.23 22:52:03.848 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:03.848 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:03.854 5: Triggering AMAD_TAB8 (2 changes)
2016.06.23 22:52:03.854 5: Starting notify loop for AMAD_TAB8, first event checkActiveTask: 0
2016.06.23 22:52:03.877 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:03.878 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:05.009 5: HMLAN/RAW: /E52ACB5,0000,0CB1409D,FF,FFC9,87A24052ACB5272E0101B5

2016.06.23 22:52:05.010 5: HMLAN_Parse: HMLAN1 R:E52ACB5   stat:0000 t:0CB1409D d:FF r:FFC9     m:87 A240 52ACB5 272E01 01B5
2016.06.23 22:52:05.011 5: HMLAN1 dispatch A0B87A24052ACB5272E0101B5::-55:HMLAN1
2016.06.23 22:52:05.015 5: CUL_HM CUL_HM_HM_PB_2_WM55_2_52ACB5 prep ACK for 01
2016.06.23 22:52:05.016 5: HMLAN: Skip ACK
2016.06.23 22:52:05.016 5: CUL_HM CUL_HM_HM_PB_2_WM55_2_52ACB5 protEvent:CMDs_done
2016.06.23 22:52:05.017 5: CUL_HM CUL_HM_HM_PB_2_WM55_2_52ACB5 sent ACK:2
2016.06.23 22:52:05.020 5: Triggering CUL_HM_HM_PB_2_WM55_2_52ACB5 (3 changes)
2016.06.23 22:52:05.020 5: Starting notify loop for CUL_HM_HM_PB_2_WM55_2_52ACB5, first event battery: ok
2016.06.23 22:52:05.044 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:05.051 5: Triggering Taster_oben (4 changes)
2016.06.23 22:52:05.051 5: Starting notify loop for Taster_oben, first event Short (to vccu)
2016.06.23 22:52:05.065 5: Cmd: >set DU_DI_gute_Nacht_Trigger off<
2016.06.23 22:52:05.066 4: dummy set DU_DI_gute_Nacht_Trigger off
2016.06.23 22:52:05.067 5: Triggering DU_DI_gute_Nacht_Trigger (1 changes)
2016.06.23 22:52:05.067 5: Starting notify loop for DU_DI_gute_Nacht_Trigger, first event off
2016.06.23 22:52:05.084 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:05.090 5: Triggering DI_gute_Nacht (5 changes)
2016.06.23 22:52:05.091 5: Starting notify loop for DI_gute_Nacht, first event cmd_nr: 1
2016.06.23 22:52:05.109 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:05.118 5: Cmd: >set DU_Nachtzeit on<
2016.06.23 22:52:05.118 4: dummy set DU_Nachtzeit on
2016.06.23 22:52:05.119 5: Triggering DU_Nachtzeit (1 changes)
2016.06.23 22:52:05.119 5: Starting notify loop for DU_Nachtzeit, first event on
2016.06.23 22:52:05.136 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:05.142 5: Triggering DI_gute_Nacht (5 changes)
2016.06.23 22:52:05.143 5: Starting notify loop for DI_gute_Nacht, first event cmd_nr: 1
2016.06.23 22:52:05.161 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:05.170 5: Cmd: >set TVLICHT_hinten off<
2016.06.23 22:52:05.171 4: HttpUtils url=http://fritz.box/webservices/homeautoswitch.lua?sid=0927b05d1d7446fe&ain=08761 0087783&switchcmd=setswitchoff
2016.06.23 22:52:05.175 5: Triggering TVLICHT_hinten (1 changes)
2016.06.23 22:52:05.175 5: Starting notify loop for TVLICHT_hinten, first event off
2016.06.23 22:52:05.192 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:05.193 5: rg_Stromverbrauch: not on any display, ignoring notify
2016.06.23 22:52:05.199 5: Triggering DI_gute_Nacht (5 changes)
2016.06.23 22:52:05.199 5: Starting notify loop for DI_gute_Nacht, first event cmd_nr: 1
2016.06.23 22:52:05.218 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:05.226 5: Cmd: >set TVLICHT_vorne off<
2016.06.23 22:52:05.228 5: Triggering TVLICHT_vorne (1 changes)
2016.06.23 22:52:05.228 5: Starting notify loop for TVLICHT_vorne, first event off
2016.06.23 22:52:05.250 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:05.250 5: rg_Stromverbrauch: not on any display, ignoring notify
2016.06.23 22:52:05.256 5: Triggering DI_gute_Nacht (5 changes)
2016.06.23 22:52:05.257 5: Starting notify loop for DI_gute_Nacht, first event cmd_nr: 1
2016.06.23 22:52:05.275 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:05.284 5: Cmd: >set Uhr off<
2016.06.23 22:52:05.296 5: Triggering CUL_1 (1 changes)
2016.06.23 22:52:05.296 5: Starting notify loop for CUL_1, first event raw: 10
2016.06.23 22:52:05.313 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:05.313 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 22:52:05.318 4: IT set ITrepetition: isr10 for CUL_1
2016.06.23 22:52:05.318 2: IT set Uhr off
2016.06.23 22:52:05.870 5: Triggering CUL_1 (1 changes)
2016.06.23 22:52:05.870 5: Starting notify loop for CUL_1, first event raw: isF00000000FF0
2016.06.23 22:52:05.888 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:05.889 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 22:52:05.894 4: Answer from CUL_1:   raw => isF00000000FF0
2016.06.23 22:52:05.906 5: Triggering CUL_1 (1 changes)
2016.06.23 22:52:05.906 5: Starting notify loop for CUL_1, first event raw: 6
2016.06.23 22:52:05.924 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:05.924 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 22:52:05.930 4: IT set ITrepetition back: isr6 for CUL_1
2016.06.23 22:52:05.930 5: Triggering Uhr (1 changes)
2016.06.23 22:52:05.931 5: Starting notify loop for Uhr, first event off
2016.06.23 22:52:05.948 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:05.955 5: Triggering DI_gute_Nacht (5 changes)
2016.06.23 22:52:05.955 5: Starting notify loop for DI_gute_Nacht, first event cmd_nr: 1
2016.06.23 22:52:05.976 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:05.985 5: Cmd: >set Links off<
2016.06.23 22:52:05.997 5: Triggering CUL_1 (1 changes)
2016.06.23 22:52:05.998 5: Starting notify loop for CUL_1, first event raw: 10
2016.06.23 22:52:06.015 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:06.016 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 22:52:06.022 4: IT set ITrepetition: isr10 for CUL_1
2016.06.23 22:52:06.022 2: IT set Links off
2016.06.23 22:52:06.574 5: Triggering CUL_1 (1 changes)
2016.06.23 22:52:06.575 5: Starting notify loop for CUL_1, first event raw: is0000000F0FF0
2016.06.23 22:52:06.602 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:06.603 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 22:52:06.611 4: Answer from CUL_1:   raw => is0000000F0FF0
2016.06.23 22:52:06.623 5: Triggering CUL_1 (1 changes)
2016.06.23 22:52:06.624 5: Starting notify loop for CUL_1, first event raw: 6
2016.06.23 22:52:06.650 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:06.651 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 22:52:06.659 4: IT set ITrepetition back: isr6 for CUL_1
2016.06.23 22:52:06.660 5: Triggering Links (1 changes)
2016.06.23 22:52:06.661 5: Starting notify loop for Links, first event off
2016.06.23 22:52:06.687 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:06.694 5: Triggering DI_gute_Nacht (5 changes)
2016.06.23 22:52:06.694 5: Starting notify loop for DI_gute_Nacht, first event cmd_nr: 1
2016.06.23 22:52:06.715 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:06.724 5: Cmd: >set Rechts off<
2016.06.23 22:52:06.736 5: Triggering CUL_1 (1 changes)
2016.06.23 22:52:06.737 5: Starting notify loop for CUL_1, first event raw: 10
2016.06.23 22:52:06.755 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:06.755 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 22:52:06.761 4: IT set ITrepetition: isr10 for CUL_1
2016.06.23 22:52:06.761 2: IT set Rechts off
2016.06.23 22:52:07.313 5: Triggering CUL_1 (1 changes)
2016.06.23 22:52:07.314 5: Starting notify loop for CUL_1, first event raw: is0000FFF00FF0
2016.06.23 22:52:07.331 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:07.332 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 22:52:07.337 4: Answer from CUL_1:   raw => is0000FFF00FF0
2016.06.23 22:52:07.349 5: Triggering CUL_1 (1 changes)
2016.06.23 22:52:07.349 5: Starting notify loop for CUL_1, first event raw: 6
2016.06.23 22:52:07.367 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:07.368 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 22:52:07.373 4: IT set ITrepetition back: isr6 for CUL_1
2016.06.23 22:52:07.373 5: Triggering Rechts (1 changes)
2016.06.23 22:52:07.374 5: Starting notify loop for Rechts, first event off
2016.06.23 22:52:07.391 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:07.398 5: Triggering DI_gute_Nacht (5 changes)
2016.06.23 22:52:07.398 5: Starting notify loop for DI_gute_Nacht, first event cmd_nr: 1
2016.06.23 22:52:07.418 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:07.427 5: Cmd: >set Wand off<
2016.06.23 22:52:07.439 5: Triggering CUL_1 (1 changes)
2016.06.23 22:52:07.440 5: Starting notify loop for CUL_1, first event raw: 10
2016.06.23 22:52:07.457 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:07.458 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 22:52:07.463 4: IT set ITrepetition: isr10 for CUL_1
2016.06.23 22:52:07.463 2: IT set Wand off
2016.06.23 22:52:08.015 5: Triggering CUL_1 (1 changes)
2016.06.23 22:52:08.015 5: Starting notify loop for CUL_1, first event raw: is0000F00F0FF0
2016.06.23 22:52:08.033 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:08.034 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 22:52:08.039 4: Answer from CUL_1:   raw => is0000F00F0FF0
2016.06.23 22:52:08.051 5: Triggering CUL_1 (1 changes)
2016.06.23 22:52:08.051 5: Starting notify loop for CUL_1, first event raw: 6
2016.06.23 22:52:08.069 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:08.069 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 22:52:08.075 4: IT set ITrepetition back: isr6 for CUL_1
2016.06.23 22:52:08.075 5: Triggering Wand (1 changes)
2016.06.23 22:52:08.076 5: Starting notify loop for Wand, first event off
2016.06.23 22:52:08.093 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:08.100 5: Triggering DI_gute_Nacht (5 changes)
2016.06.23 22:52:08.101 5: Starting notify loop for DI_gute_Nacht, first event cmd_nr: 1
2016.06.23 22:52:08.121 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:08.130 5: Cmd: >set SamsungTV POWEROFF<
2016.06.23 22:52:08.131 5: [STV] opening socket with tvip: 192.168.178.23, cmd: POWEROFF
2016.06.23 22:52:11.131 5: Triggering SamsungTV (1 changes)
2016.06.23 22:52:11.132 5: Starting notify loop for SamsungTV, first event POWEROFF
2016.06.23 22:52:11.140 5: Triggering DI_AnsageTabletten (4 changes)
2016.06.23 22:52:11.140 5: Starting notify loop for DI_AnsageTabletten, first event cmd_nr: 4
2016.06.23 22:52:11.161 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:11.191 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:11.202 5: Triggering DI_gute_Nacht (5 changes)
2016.06.23 22:52:11.202 5: Starting notify loop for DI_gute_Nacht, first event cmd_nr: 1
2016.06.23 22:52:11.233 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:11.246 5: Cmd: >set PC_Kunlaya off<
2016.06.23 22:52:11.250 5: Triggering DI_gute_Nacht (5 changes)
2016.06.23 22:52:11.251 5: Starting notify loop for DI_gute_Nacht, first event cmd_nr: 1
2016.06.23 22:52:11.278 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:11.288 5: Cmd: >set LED_Blumen off<
2016.06.23 22:52:11.300 5: Triggering CUL_1 (1 changes)
2016.06.23 22:52:11.300 5: Starting notify loop for CUL_1, first event raw: 10
2016.06.23 22:52:11.318 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:11.319 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 22:52:11.324 4: IT set ITrepetition: isr10 for CUL_1
2016.06.23 22:52:11.325 2: IT set LED_Blumen off
2016.06.23 22:52:11.876 5: Triggering CUL_1 (1 changes)
2016.06.23 22:52:11.876 5: Starting notify loop for CUL_1, first event raw: is00000F000FF0
2016.06.23 22:52:11.894 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:11.895 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 22:52:11.900 4: Answer from CUL_1:   raw => is00000F000FF0
2016.06.23 22:52:11.912 5: Triggering CUL_1 (1 changes)
2016.06.23 22:52:11.912 5: Starting notify loop for CUL_1, first event raw: 6
2016.06.23 22:52:11.930 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:11.931 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 22:52:11.936 4: IT set ITrepetition back: isr6 for CUL_1
2016.06.23 22:52:11.936 5: Triggering LED_Blumen (1 changes)
2016.06.23 22:52:11.937 5: Starting notify loop for LED_Blumen, first event off
2016.06.23 22:52:11.957 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:11.964 5: Triggering DI_gute_Nacht (5 changes)
2016.06.23 22:52:11.965 5: Starting notify loop for DI_gute_Nacht, first event cmd_nr: 1
2016.06.23 22:52:11.985 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:11.994 5: Cmd: >set Schreibtisch off<
2016.06.23 22:52:11.996 5: Triggering Schreibtisch (1 changes)
2016.06.23 22:52:11.996 5: Starting notify loop for Schreibtisch, first event off
2016.06.23 22:52:12.014 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:12.015 5: rg_Stromverbrauch: not on any display, ignoring notify
2016.06.23 22:52:12.022 5: Triggering DI_gute_Nacht (5 changes)
2016.06.23 22:52:12.022 5: Starting notify loop for DI_gute_Nacht, first event cmd_nr: 1
2016.06.23 22:52:12.042 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:12.052 5: Cmd: >set Lampe_Korridor on-for-timer 20<
2016.06.23 22:52:12.055 5: Triggering DI_gute_Nacht (5 changes)
2016.06.23 22:52:12.056 5: Starting notify loop for DI_gute_Nacht, first event cmd_nr: 1
2016.06.23 22:52:12.076 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:12.086 5: Cmd: >set TV off<
2016.06.23 22:52:12.087 5: Triggering TV (1 changes)
2016.06.23 22:52:12.088 5: Starting notify loop for TV, first event off
2016.06.23 22:52:12.106 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:12.107 5: rg_Stromverbrauch: not on any display, ignoring notify
2016.06.23 22:52:12.113 5: Triggering DI_gute_Nacht (5 changes)
2016.06.23 22:52:12.113 5: Starting notify loop for DI_gute_Nacht, first event cmd_nr: 1
2016.06.23 22:52:12.134 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:12.143 5: Cmd: >set Webradio stop<
2016.06.23 22:52:12.234 5: Triggering Webradio (1 changes)
2016.06.23 22:52:12.234 5: Starting notify loop for Webradio, first event volume: 0
2016.06.23 22:52:12.252 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:12.259 5: Triggering Webradio (1 changes)
2016.06.23 22:52:12.259 5: Starting notify loop for Webradio, first event single: 0
2016.06.23 22:52:12.277 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:12.283 5: Triggering Webradio (1 changes)
2016.06.23 22:52:12.284 5: Starting notify loop for Webradio, first event consume: 0
2016.06.23 22:52:12.301 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:12.308 5: Triggering Webradio (1 changes)
2016.06.23 22:52:12.308 5: Starting notify loop for Webradio, first event playlist: 24221
2016.06.23 22:52:12.325 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:12.332 5: Triggering Webradio (1 changes)
2016.06.23 22:52:12.332 5: Starting notify loop for Webradio, first event playlistlength: 17
2016.06.23 22:52:12.350 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:12.356 5: Triggering Webradio (1 changes)
2016.06.23 22:52:12.356 5: Starting notify loop for Webradio, first event xfade: 0
2016.06.23 22:52:12.374 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:12.380 5: Triggering Webradio (1 changes)
2016.06.23 22:52:12.380 5: Starting notify loop for Webradio, first event mixrampdb: 0.000000
2016.06.23 22:52:12.398 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:12.404 5: Triggering Webradio (1 changes)
2016.06.23 22:52:12.405 5: Starting notify loop for Webradio, first event mixrampdelay: nan
2016.06.23 22:52:12.422 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:12.428 5: Triggering Webradio (1 changes)
2016.06.23 22:52:12.429 5: Starting notify loop for Webradio, first event stop
2016.06.23 22:52:12.446 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:12.453 5: Triggering Webradio (1 changes)
2016.06.23 22:52:12.453 5: Starting notify loop for Webradio, first event song: 3
2016.06.23 22:52:12.470 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:12.476 5: Triggering Webradio (1 changes)
2016.06.23 22:52:12.477 5: Starting notify loop for Webradio, first event songid: 1822
2016.06.23 22:52:12.495 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:12.501 5: Triggering Webradio (1 changes)
2016.06.23 22:52:12.501 5: Starting notify loop for Webradio, first event nextsong: 0
2016.06.23 22:52:12.519 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:12.525 5: Triggering Webradio (1 changes)
2016.06.23 22:52:12.526 5: Starting notify loop for Webradio, first event nextsongid: 1819
2016.06.23 22:52:12.543 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:12.550 5: Triggering DI_gute_Nacht (5 changes)
2016.06.23 22:52:12.551 5: Starting notify loop for DI_gute_Nacht, first event cmd_nr: 1
2016.06.23 22:52:12.572 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:12.581 5: Cmd: >set Giga off<
2016.06.23 22:52:12.582 5: ENIGMA2 Giga: called function ENIGMA2_Set()
2016.06.23 22:52:12.583 3: ENIGMA2 set Giga off
2016.06.23 22:52:12.583 5: ENIGMA2 Giga: called function ENIGMA2_SendCommand()
2016.06.23 22:52:12.584 5: ENIGMA2 Giga: using unencrypted connection via HTTP
2016.06.23 22:52:12.584 4: ENIGMA2 Giga: REQ powerstate/?newstate=5&
2016.06.23 22:52:12.584 5: ENIGMA2 Giga: GET http://192.168.178.26:80/web/powerstate?newstate=5& (noshutdown=1)
2016.06.23 22:52:12.584 4: HttpUtils url=http://192.168.178.26:80/web/powerstate?newstate=5&
2016.06.23 22:52:12.587 5: Triggering Giga (1 changes)
2016.06.23 22:52:12.587 5: Starting notify loop for Giga, first event off
2016.06.23 22:52:12.605 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:12.612 5: Triggering DI_gute_Nacht (5 changes)
2016.06.23 22:52:12.612 5: Starting notify loop for DI_gute_Nacht, first event cmd_nr: 1
2016.06.23 22:52:12.633 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:12.651 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:12.662 3: fb2: connect to http://fritz.box:80 timed out
2016.06.23 22:52:14.564 4: http://192.168.178.26:80/web/powerstate?newstate=5&: HTTP response code 200
2016.06.23 22:52:14.565 4: HttpUtils http://192.168.178.26:80/web/powerstate?newstate=5&: Got data, length: 106
2016.06.23 22:52:14.565 5: ENIGMA2 Giga: called function ENIGMA2_ReceiveCommand()
2016.06.23 22:52:14.566 4: ENIGMA2 Giga: RCV powerstate/?newstate=5&
2016.06.23 22:52:14.566 5: ENIGMA2 Giga: RES powerstate/?newstate=5&
<?xml version="1.0" encoding="UTF-8"?>
<e2powerstate>
   <e2instandby>
false   </e2instandby>
</e2powerstate>

2016.06.23 22:52:14.575 5: ENIGMA2 Giga: called function ENIGMA2_SendCommand()
2016.06.23 22:52:14.575 5: ENIGMA2 Giga: using unencrypted connection via HTTP
2016.06.23 22:52:14.575 4: ENIGMA2 Giga: REQ timerlist
2016.06.23 22:52:14.576 5: ENIGMA2 Giga: GET http://192.168.178.26:80/web/timerlist (noshutdown=1)
2016.06.23 22:52:14.576 4: HttpUtils url=http://192.168.178.26:80/web/timerlist
2016.06.23 22:52:14.583 5: Triggering Giga (50 changes)
2016.06.23 22:52:14.584 5: Starting notify loop for Giga, first event power: off
2016.06.23 22:52:14.627 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:14.712 4: http://192.168.178.26:80/web/timerlist: HTTP response code 200
2016.06.23 22:52:14.713 4: HttpUtils http://192.168.178.26:80/web/timerlist: Got data, length: 6884
2016.06.23 22:52:14.713 5: ENIGMA2 Giga: called function ENIGMA2_ReceiveCommand()
2016.06.23 22:52:14.714 4: ENIGMA2 Giga: RCV timerlist
2016.06.23 22:52:14.714 5: ENIGMA2 Giga: RES timerlist
<?xml version="1.0" encoding="UTF-8"?>
<e2timerlist>
   <e2timer>
      <e2servicereference>1:0:19:EF74:3F9:1:C00000:0:0:0:</e2servicereference>
      <e2servicename>SAT.1 HD</e2servicename>
      <e2eit>32257</e2eit>
      <e2name>Criminal Minds</e2name>
      <e2description>Spiegelzwillinge, Crime-Serie, USA 2005</e2description>
      <e2descriptionextended>N/A</e2descriptionextended>
      <e2disabled>0</e2disabled>
      <e2timebegin>1466383560</e2timebegin>
      <e2timeend>1466386500</e2timeend>
      <e2duration>2940</e2duration>
      <e2startprepare>1466383540</e2startprepare>
      <e2justplay>0</e2justplay>
      <e2afterevent>3</e2afterevent>
      <e2location>None</e2location>
      <e2tags></e2tags>
      <e2logentries>[(1466712136, 15, 'record time changed, start prepare is now: Mon Jun 20 02:45:40 2016')]</e2logentries>
      <e2filename></e2filename>
      <e2backoff>0</e2backoff>
      <e2nextactivation></e2nextactivation>
      <e2firsttryprepare>True</e2firsttryprepare>
      <e2state>3</e2state>
      <e2repeated>0</e2repeated>
      <e2dontsave>0</e2dontsave>
      <e2cancled>False</e2cancled>
      <e2toggledisabled>1</e2toggledisabled>
      <e2toggledisabledimg>off</e2toggledisabledimg>
      <e2alwayszap>0</e2alwayszap>
   </e2timer>
   <e2timer>
      <e2servicereference>1:0:19:EF78:3F9:1:C00000:0:0:0:</e2servicereference>
      <e2servicename>Pro7 MAXX HD</e2servicename>
      <e2eit>36353</e2eit>
      <e2name>Outer Limits - Die unbekannte Dimension</e2name>
      <e2description>Erinnerungen, Science-Fiction, CDN 1999</e2description>
      <e2descriptionextended>N/A</e2descriptionextended>
      <e2disabled>0</e2disabled>
      <e2timebegin>1466465220</e2timebegin>
      <e2timeend>1466468280</e2timeend>
      <e2duration>3060</e2duration>
      <e2startprepare>1466465200</e2startprepare>
      <e2justplay>0</e2justplay>
      <e2afterevent>3</e2afterevent>
      <e2location>None</e2location>
      <e2tags></e2tags>
      <e2logentries>[(1466712136, 15, 'record time changed, start prepare is now: Tue Jun 21 01:26:40 2016')]</e2logentries>
      <e2filename></e2filename>
      <e2backoff>0</e2backoff>
      <e2nextactivation></e2nextactivation>
      <e2firsttryprepare>True</e2firsttryprepare>
      <e2state>3</e2state>
      <e2repeated>0</e2repeated>
      <e2dontsave>0</e2dontsave>
      <e2cancled>False</e2cancled>
      <e2toggledisabled>1</e2toggledisabled>
      <e2toggledisabledimg>off</e2toggledisabledimg>
      <e2alwayszap>0</e2alwayszap>
   </e2timer>
   <e2timer>
      <e2servicereference>1:0:19:EF78:3F9:1:C00000:0:0:0:</e2servicereference>
      <e2servicename>Pro7 MAXX HD</e2servicename>
      <e2eit>36352</e2eit>
      <e2name>Outer Limits - Die unbekannte Dimension</e2name>
      <e2description>Das Böse in uns, Science-Fiction, CDN 1999</e2description>
      <e2descriptionextended>N/A</e2descriptionextended>
      <e2disabled>0</e2disabled>
      <e2timebegin>1466462640</e2timebegin>
      <e2timeend>1466465700</e2timeend>
      <e2duration>3060</e2duration>
      <e2startprepare>1466462620</e2startprepare>
      <e2justplay>0</e2justplay>
      <e2afterevent>3</e2afterevent>
      <e2location>None</e2location>
      <e2tags></e2tags>
      <e2logentries>[(1466712136, 15, 'record time changed, start prepare is now: Tue Jun 21 00:43:40 2016')]</e2logentries>
      <e2filename></e2filename>
      <e2backoff>0</e2backoff>
      <e2nextactivation></e2nextactivation>
      <e2firsttryprepare>True</e2firsttryprepare>
      <e2state>3</e2state>
      <e2repeated>0</e2repeated>
      <e2dontsave>0</e2dontsave>
      <e2cancled>False</e2cancled>
      <e2toggledisabled>1</e2toggledisabled>
      <e2toggledisabledimg>off</e2toggledisabledimg>
      <e2alwayszap>0</e2alwayszap>
   </e2timer>
   <e2timer>
      <e2servicereference>1:0:19:EF78:3F9:1:C00000:0:0:0:</e2servicereference>
      <e2servicename>Pro7 MAXX HD</e2servicename>
      <e2eit>36384</e2eit>
      <e2name>Unsichtbar - Zwischen zwei Welten</e2name>
      <e2description>Thriller, USA 2007</e2description>
      <e2descriptionextended>N/A</e2descriptionextended>
      <e2disabled>0</e2disabled>
      <e2timebegin>1466532682</e2timebegin>
      <e2timeend>1466540659</e2timeend>
      <e2duration>7977</e2duration>
      <e2startprepare>1466532662</e2startprepare>
      <e2justplay>1</e2justplay>
      <e2afterevent>3</e2afterevent>
      <e2location>None</e2location>
      <e2tags></e2tags>
      <e2logentries>[(1466712136, 15, 'record time changed, start prepare is now: Tue Jun 21 20:11:02 2016')]</e2logentries>
      <e2filename></e2filename>
      <e2backoff>0</e2backoff>
      <e2nextactivation></e2nextactivation>
      <e2firsttryprepare>True</e2firsttryprepare>
      <e2state>3</e2state>
      <e2repeated>0</e2repeated>
      <e2dontsave>0</e2dontsave>
      <e2cancled>False</e2cancled>
      <e2toggledisabled>1</e2toggledisabled>
      <e2toggledisabledimg>off</e2toggledisabledimg>
      <e2alwayszap>0</e2alwayszap>
   </e2timer>
   <e2timer>
      <e2servicereference>1:0:19:EF78:3F9:1:C00000:0:0:0:</e2servicereference>
      <e2servicename>Pro7 MAXX HD</e2servicename>
      <e2eit>36388</e2eit>
      <e2name>Outer Limits - Die unbekannte Dimension</e2name>
      <e2description>Das Böse in uns, Science-Fiction, CDN 1999</e2description>
      <e2descriptionextended>N/A</e2descriptionextended>
      <e2disabled>0</e2disabled>
      <e2timebegin>1466556540</e2timebegin>
      <e2timeend>1466559600</e2timeend>
      <e2duration>3060</e2duration>
      <e2startprepare>1466556520</e2startprepare>
      <e2justplay>0</e2justplay>
      <e2afterevent>3</e2afterevent>
      <e2location>None</e2location>
      <e2tags></e2tags>
      <e2logentries>[(1466712136, 15, 'record time changed, start prepare is now: Wed Jun 22 02:48:40 2016')]</e2logentries>
      <e2filename></e2filename>
      <e2backoff>0</e2backoff>
      <e2nextactivation></e2nextactivation>
      <e2firsttryprepare>True</e2firsttryprepare>
      <e2state>3</e2state>
      <e2repeated>0</e2repeated>
      <e2dontsave>0</e2dontsave>
      <e2cancled>False</e2cancled>
      <e2toggledisabled>1</e2toggledisabled>
      <e2toggledisabledimg>off</e2toggledisabledimg>
      <e2alwayszap>0</e2alwayszap>
   </e2timer>
   <e2timer>
      <e2servicereference>1:0:19:EF78:3F9:1:C00000:0:0:0:</e2servicereference>
      <e2servicename>Pro7 MAXX HD</e2servicename>
      <e2eit>36389</e2eit>
      <e2name>Outer Limits - Die unbekannte Dimension</e2name>
      <e2description>Erinnerungen, Science-Fiction, CDN 1999</e2description>
      <e2descriptionextended>N/A</e2descriptionextended>
      <e2disabled>0</e2disabled>
      <e2timebegin>1466559120</e2timebegin>
      <e2timeend>1466562180</e2timeend>
      <e2duration>3060</e2duration>
      <e2startprepare>1466559100</e2startprepare>
      <e2justplay>0</e2justplay>
      <e2afterevent>3</e2afterevent>
      <e2location>None</e2location>
      <e2tags></e2tags>
      <e2logentries>[(1466712136, 15, 'record time changed, start prepare is now: Wed Jun 22 03:31:40 2016')]</e2logentries>
      <e2filename></e2filename>
      <e2backoff>0</e2backoff>
      <e2nextactivation></e2nextactivation>
      <e2firsttryprepare>True</e2firsttryprepare>
      <e2state>3</e2state>
      <e2repeated>0</e2repeated>
      <e2dontsave>0</e2dontsave>
      <e2cancled>False</e2cancled>
      <e2toggledisabled>1</e2toggledisabled>
      <e2toggledisabledimg>off</e2toggledisabledimg>
      <e2alwayszap>0</e2alwayszap>
   </e2timer>
</e2timerlist>

2016.06.23 22:52:14.824 5: ENIGMA2 Giga: detected multiple events in timerlist
2016.06.23 22:52:18.598 5: AMAD (AMADCommBridge) - Receive RAW Message in Debugging Mode: POST / HTTP/1.1
Content-Type: text/plain
User-Agent: Mozilla/5.0 (compatible; Automagic)
FHEMDEVICE: AMAD_TAB10
FHEMCMD: setreading
Host: 192.168.178.99:8090
Connection: Keep-Alive
Accept-Encoding: gzip
Content-Length: 33

flowsetVersionAtDevice@@2.2.3@@@@
2016.06.23 22:52:18.599 4: AMAD (AMADCommBridge) - AMAD_CommBridge: processing receive reading values - Device: AMAD_TAB10 Data: flowsetVersionAtDevice@@2.2.3@@@@
2016.06.23 22:52:18.599 5: AMAD (AMAD_TAB10) - Processing data: flowsetVersionAtDevice@@2.2.3@@@@
2016.06.23 22:52:18.600 5: Triggering AMAD_TAB10 (1 changes)
2016.06.23 22:52:18.601 5: Starting notify loop for AMAD_TAB10, first event active
2016.06.23 22:52:18.638 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:18.639 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:18.648 5: Triggering AMAD_TAB10 (2 changes)
2016.06.23 22:52:18.649 5: Starting notify loop for AMAD_TAB10, first event flowsetVersionAtDevice: 2.2.3
2016.06.23 22:52:18.682 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:18.683 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:18.689 5: AMAD (AMADCommBridge) - Receive RAW Message in Debugging Mode: POST / HTTP/1.1
Content-Type: text/plain
User-Agent: Mozilla/5.0 (compatible; Automagic)
FHEMDEVICE: AMAD_TAB10
FHEMCMD: setreading
Host: 192.168.178.99:8090
Connection: Keep-Alive
Accept-Encoding: gzip
Content-Length: 23

deviceState@@online@@@@
2016.06.23 22:52:18.690 4: AMAD (AMADCommBridge) - AMAD_CommBridge: processing receive reading values - Device: AMAD_TAB10 Data: deviceState@@online@@@@
2016.06.23 22:52:18.690 5: AMAD (AMAD_TAB10) - Processing data: deviceState@@online@@@@
2016.06.23 22:52:18.691 5: Triggering AMAD_TAB10 (1 changes)
2016.06.23 22:52:18.691 5: Starting notify loop for AMAD_TAB10, first event active
2016.06.23 22:52:18.717 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:18.717 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:18.724 5: Triggering AMAD_TAB10 (2 changes)
2016.06.23 22:52:18.724 5: Starting notify loop for AMAD_TAB10, first event deviceState: online
2016.06.23 22:52:18.749 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:18.750 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:18.814 5: AMAD (AMADCommBridge) - Receive RAW Message in Debugging Mode: POST / HTTP/1.1
Content-Type: text/plain
User-Agent: Mozilla/5.0 (compatible; Automagic)
FHEMDEVICE: AMAD_TAB10
FHEMCMD: setreading
Host: 192.168.178.99:8090
Connection: Keep-Alive
Accept-Encoding: gzip
Content-Length: 27

flow_SetCommands@@aktiv@@@@
2016.06.23 22:52:18.815 4: AMAD (AMADCommBridge) - AMAD_CommBridge: processing receive reading values - Device: AMAD_TAB10 Data: flow_SetCommands@@aktiv@@@@
2016.06.23 22:52:18.815 5: AMAD (AMAD_TAB10) - Processing data: flow_SetCommands@@aktiv@@@@
2016.06.23 22:52:18.816 5: Triggering AMAD_TAB10 (1 changes)
2016.06.23 22:52:18.816 5: Starting notify loop for AMAD_TAB10, first event active
2016.06.23 22:52:18.841 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:18.841 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:18.848 5: Triggering AMAD_TAB10 (2 changes)
2016.06.23 22:52:18.848 5: Starting notify loop for AMAD_TAB10, first event flow_SetCommands: aktiv
2016.06.23 22:52:18.873 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:18.874 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:18.883 5: AMAD (AMADCommBridge) - Receive RAW Message in Debugging Mode: POST / HTTP/1.1
Content-Type: text/plain
User-Agent: Mozilla/5.0 (compatible; Automagic)
FHEMDEVICE: AMAD_TAB10
FHEMCMD: setreading
Host: 192.168.178.99:8090
Connection: Keep-Alive
Accept-Encoding: gzip
Content-Length: 59

connectedBTdevices@@null@@@@connectedBTdevicesMAC@@null@@@@
2016.06.23 22:52:18.884 4: AMAD (AMADCommBridge) - AMAD_CommBridge: processing receive reading values - Device: AMAD_TAB10 Data: connectedBTdevices@@null@@@@connectedBTdevicesMAC@@null@@@@
2016.06.23 22:52:18.884 5: AMAD (AMAD_TAB10) - Processing data: connectedBTdevices@@null@@@@connectedBTdevicesMAC@@null@@@@
2016.06.23 22:52:18.885 5: Triggering AMAD_TAB10 (1 changes)
2016.06.23 22:52:18.885 5: Starting notify loop for AMAD_TAB10, first event active
2016.06.23 22:52:18.909 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:18.910 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:18.916 5: Triggering AMAD_TAB10 (3 changes)
2016.06.23 22:52:18.917 5: Starting notify loop for AMAD_TAB10, first event connectedBTdevicesMAC:
2016.06.23 22:52:18.943 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:18.943 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:19.204 5: AMAD (AMADCommBridge) - Receive RAW Message in Debugging Mode: POST / HTTP/1.1
Content-Type: text/plain
User-Agent: Mozilla/5.0 (compatible; Automagic)
FHEMDEVICE: AMAD_TAB10
FHEMCMD: setreading
Host: 192.168.178.99:8090
Connection: Keep-Alive
Accept-Encoding: gzip
Content-Length: 22

checkActiveTask@@0@@@@
2016.06.23 22:52:19.205 4: AMAD (AMADCommBridge) - AMAD_CommBridge: processing receive reading values - Device: AMAD_TAB10 Data: checkActiveTask@@0@@@@
2016.06.23 22:52:19.205 5: AMAD (AMAD_TAB10) - Processing data: checkActiveTask@@0@@@@
2016.06.23 22:52:19.206 5: Triggering AMAD_TAB10 (1 changes)
2016.06.23 22:52:19.206 5: Starting notify loop for AMAD_TAB10, first event active
2016.06.23 22:52:19.231 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:19.231 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:19.237 5: Triggering AMAD_TAB10 (2 changes)
2016.06.23 22:52:19.238 5: Starting notify loop for AMAD_TAB10, first event checkActiveTask: 0
2016.06.23 22:52:19.263 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:19.264 5: rg_Handys: not on any display, ignoring notify
2016.06.23 22:52:21.731 4: FHT FHT_305f actuator: 0%
2016.06.23 22:52:21.732 5: Triggering FHT_305f (1 changes)
2016.06.23 22:52:21.733 5: Starting notify loop for FHT_305f, first event actuator: 0%
2016.06.23 22:52:21.761 5: Heizungswerte3: not on any display, ignoring notify
2016.06.23 22:52:21.765 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:24.289 4: CUL_TX TMP_Bad 32 (XA04075875E)
2016.06.23 22:52:24.290 4: CUL_TX temperature TMP_Bad 32 T: 25.8 UnknownFlag: 0
2016.06.23 22:52:24.292 5: Triggering TMP_Bad (2 changes)
2016.06.23 22:52:24.292 5: Starting notify loop for TMP_Bad, first event T: 25.8 H: 61.0
2016.06.23 22:52:24.325 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:24.327 5: rg_Temperaturen: not on any display, ignoring notify
2016.06.23 22:52:24.738 4: CUL_TX TMP_Bad 32 (XAE4161061A)
2016.06.23 22:52:24.738 4: CUL_TX humidity TMP_Bad 32 H: 61.0 UnknownFlag: 1
2016.06.23 22:52:24.740 5: Triggering TMP_Bad (2 changes)
2016.06.23 22:52:24.740 5: Starting notify loop for TMP_Bad, first event T: 25.8 H: 61.0
2016.06.23 22:52:24.770 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:24.772 5: rg_Temperaturen: not on any display, ignoring notify
2016.06.23 22:52:26.385 5: HMLAN_Send:  HMLAN1 I:K
2016.06.23 22:52:26.391 5: HMLAN/RAW: /HHM-LAN-IF,03C5,LEQ0050111,272DED,272E01,0CB1942E,000E,02

2016.06.23 22:52:26.392 5: HMLAN_Parse: HMLAN1 V:03C5 sNo:LEQ0050111 d:272DED O:272E01 t:0CB1942E IDcnt:000E L:2 %
2016.06.23 22:52:26.393 5: Triggering HMLAN1 (1 changes)
2016.06.23 22:52:26.394 5: Starting notify loop for HMLAN1, first event loadLvl: low
2016.06.23 22:52:26.424 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:26.425 5: rg_Sicherheit: not on any display, ignoring notify
2016.06.23 22:52:28.275 5: PRESENCE (s7) - stopping timer
2016.06.23 22:52:28.276 5: PRESENCE (s7) - starting blocking call for mode lan-ping
2016.06.23 22:52:28.298 4: BlockingCall (PRESENCE_DoLocalPingScan): created child (13128), uses telnetPort to connect back
2016.06.23 22:52:28.327 5: PRESENCE (s7) - starting ping scan: s7|192.168.178.20|0|4
2016.06.23 22:52:29.189 4: CUL_TX TMP_SZ 38 (XA04C740740)
2016.06.23 22:52:29.190 4: CUL_TX temperature TMP_SZ 38 T: 24.0 UnknownFlag: 0
2016.06.23 22:52:29.192 5: Triggering TMP_SZ (2 changes)
2016.06.23 22:52:29.192 5: Starting notify loop for TMP_SZ, first event T: 24.0 H: 60.0
2016.06.23 22:52:29.222 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:29.223 5: rg_Temperaturen: not on any display, ignoring notify
2016.06.23 22:52:29.698 4: CUL_TX TMP_SZ 38 (XAE4C600604)
2016.06.23 22:52:29.704 4: CUL_TX humidity TMP_SZ 38 H: 60.0 UnknownFlag: 0
2016.06.23 22:52:29.706 5: Triggering TMP_SZ (2 changes)
2016.06.23 22:52:29.706 5: Starting notify loop for TMP_SZ, first event T: 24.0 H: 60.0
2016.06.23 22:52:29.725 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:29.727 5: rg_Temperaturen: not on any display, ignoring notify
2016.06.23 22:52:31.850 5: PRESENCE (s7) - ping command returned with output:
PING 192.168.178.20 (192.168.178.20) 56(84) bytes of data.
64 bytes from 192.168.178.20: icmp_req=1 ttl=64 time=1226 ms
64 bytes from 192.168.178.20: icmp_req=2 ttl=64 time=217 ms
64 bytes from 192.168.178.20: icmp_req=3 ttl=64 time=34.3 ms
64 bytes from 192.168.178.20: icmp_req=4 ttl=64 time=476 ms

--- 192.168.178.20 ping statistics ---
4 packets transmitted, 4 received, 0% packet loss, time 3010ms
rtt min/avg/max/mdev = 34.306/488.606/1226.185/453.848 ms, pipe 2
2016.06.23 22:52:31.863 4: Connection accepted from telnetPort_127.0.0.1_44759
2016.06.23 22:52:31.868 5: Cmd: >{PRESENCE_ProcessLocalScan('s7|0|present')}<
2016.06.23 22:52:31.869 5: PRESENCE (s7) - blocking scan result: s7|0|present
2016.06.23 22:52:31.881 4: PRESENCE (s7) - rescheduling next check in 60 seconds
2016.06.23 22:52:32.058 1: fb2: Not connected, wont execute setswitchoff
2016.06.23 22:52:32.060 5: Triggering Lampe_Korridor (1 changes)
2016.06.23 22:52:32.060 5: Starting notify loop for Lampe_Korridor, first event off
2016.06.23 22:52:32.082 5: rg_Batteriestatus: not on any display, ignoring notify
2016.06.23 22:52:32.083 5: rg_Stromverbrauch: not on any display, ignoring notify
2016.06.23 22:52:32.379 5: ENIGMA2 Giga: called function ENIGMA2_GetStatus()
2016.06.23 22:52:32.380 5: ENIGMA2 Giga: called function ENIGMA2_SendCommand()
2016.06.23 22:52:32.380 5: ENIGMA2 Giga: using unencrypted connection via HTTP
2016.06.23 22:52:32.381 4: ENIGMA2 Giga: REQ powerstate
2016.06.23 22:52:32.381 5: ENIGMA2 Giga: GET http://192.168.178.26:80/web/powerstate (noshutdown=1)
2016.06.23 22:52:32.381 4: HttpUtils url=http://192.168.178.26:80/web/powerstate
2016.06.23 22:52:32.421 4: http://192.168.178.26:80/web/powerstate: HTTP response code 200
2016.06.23 22:52:32.421 4: HttpUtils http://192.168.178.26:80/web/powerstate: Got data, length: 105
2016.06.23 22:52:32.421 5: ENIGMA2 Giga: called function ENIGMA2_ReceiveCommand()
2016.06.23 22:52:32.422 4: ENIGMA2 Giga: RCV powerstate
2016.06.23 22:52:32.422 5: ENIGMA2 Giga: RES powerstate
<?xml version="1.0" encoding="UTF-8"?>
<e2powerstate>
   <e2instandby>
true   </e2instandby>
</e2powerstate>

2016.06.23 22:52:32.430 5: ENIGMA2 Giga: called function ENIGMA2_SendCommand()
2016.06.23 22:52:32.430 5: ENIGMA2 Giga: using unencrypted connection via HTTP
2016.06.23 22:52:32.431 4: ENIGMA2 Giga: REQ timerlist
2016.06.23 22:52:32.431 5: ENIGMA2 Giga: GET http://192.168.178.26:80/web/timerlist (noshutdown=1)
2016.06.23 22:52:32.431 4: HttpUtils url=http://192.168.178.26:80/web/timerlist
2016.06.23 22:52:32.484 4: http://192.168.178.26:80/web/timerlist: HTTP response code 200
2016.06.23 22:52:32.485 4: HttpUtils http://192.168.178.26:80/web/timerlist: Got data, length: 6884
2016.06.23 22:52:32.485 5: ENIGMA2 Giga: called function ENIGMA2_ReceiveCommand()
2016.06.23 22:52:32.486 4: ENIGMA2 Giga: RCV timerlist
2016.06.23 22:52:32.486 5: ENIGMA2 Giga: RES timerlist
<?xml version="1.0" encoding="UTF-8"?>
<e2timerlist>
   <e2timer>
      <e2servicereference>1:0:19:EF74:3F9:1:C00000:0:0:0:</e2servicereference>
      <e2servicename>SAT.1 HD</e2servicename>
      <e2eit>32257</e2eit>
      <e2name>Criminal Minds</e2name>
      <e2description>Spiegelzwillinge, Crime-Serie, USA 2005</e2description>
      <e2descriptionextended>N/A</e2descriptionextended>
      <e2disabled>0</e2disabled>
      <e2timebegin>1466383560</e2timebegin>
      <e2timeend>1466386500</e2timeend>
      <e2duration>2940</e2duration>
      <e2startprepare>1466383540</e2startprepare>
      <e2justplay>0</e2justplay>
      <e2afterevent>3</e2afterevent>
      <e2location>None</e2location>
      <e2tags></e2tags>
      <e2logentries>[(1466712136, 15, 'record time changed, start prepare is now: Mon Jun 20 02:45:40 2016')]</e2logentries>
      <e2filename></e2filename>
      <e2backoff>0</e2backoff>
      <e2nextactivation></e2nextactivation>
      <e2firsttryprepare>True</e2firsttryprepare>
      <e2state>3</e2state>
      <e2repeated>0</e2repeated>
      <e2dontsave>0</e2dontsave>
      <e2cancled>False</e2cancled>
      <e2toggledisabled>1</e2toggledisabled>
      <e2toggledisabledimg>off</e2toggledisabledimg>
      <e2alwayszap>0</e2alwayszap>
   </e2timer>
   <e2timer>
      <e2servicereference>1:0:19:EF78:3F9:1:C00000:0:0:0:</e2servicereference>
      <e2servicename>Pro7 MAXX HD</e2servicename>
      <e2eit>36353</e2eit>
      <e2name>Outer Limits - Die unbekannte Dimension</e2name>
      <e2description>Erinnerungen, Science-Fiction, CDN 1999</e2description>
      <e2descriptionextended>N/A</e2descriptionextended>
      <e2disabled>0</e2disabled>
      <e2timebegin>1466465220</e2timebegin>
      <e2timeend>1466468280</e2timeend>
      <e2duration>3060</e2duration>
      <e2startprepare>1466465200</e2startprepare>
      <e2justplay>0</e2justplay>
      <e2afterevent>3</e2afterevent>
      <e2location>None</e2location>
      <e2tags></e2tags>
      <e2logentries>[(1466712136, 15, 'record time changed, start prepare is now: Tue Jun 21 01:26:40 2016')]</e2logentries>
      <e2filename></e2filename>
      <e2backoff>0</e2backoff>
      <e2nextactivation></e2nextactivation>
      <e2firsttryprepare>True</e2firsttryprepare>
      <e2state>3</e2state>
      <e2repeated>0</e2repeated>
      <e2dontsave>0</e2dontsave>
      <e2cancled>False</e2cancled>
      <e2toggledisabled>1</e2toggledisabled>
      <e2toggledisabledimg>off</e2toggledisabledimg>
      <e2alwayszap>0</e2alwayszap>
   </e2timer>
   <e2timer>
      <e2servicereference>1:0:19:EF78:3F9:1:C00000:0:0:0:</e2servicereference>
      <e2servicename>Pro7 MAXX HD</e2servicename>
      <e2eit>36352</e2eit>
      <e2name>Outer Limits - Die unbekannte Dimension</e2name>
      <e2description>Das Böse in uns, Science-Fiction, CDN 1999</e2description>
      <e2descriptionextended>N/A</e2descriptionextended>
      <e2disabled>0</e2disabled>
      <e2timebegin>1466462640</e2timebegin>
      <e2timeend>1466465700</e2timeend>
      <e2duration>3060</e2duration>
      <e2startprepare>1466462620</e2startprepare>
      <e2justplay>0</e2justplay>
      <e2afterevent>3</e2afterevent>
      <e2location>None</e2location>
      <e2tags></e2tags>
      <e2logentries>[(1466712136, 15, 'record time changed, start prepare is now: Tue Jun 21 00:43:40 2016')]</e2logentries>
      <e2filename></e2filename>
      <e2backoff>0</e2backoff>
      <e2nextactivation></e2nextactivation>
      <e2firsttryprepare>True</e2firsttryprepare>
      <e2state>3</e2state>
      <e2repeated>0</e2repeated>
      <e2dontsave>0</e2dontsave>
      <e2cancled>False</e2cancled>
      <e2toggledisabled>1</e2toggledisabled>
      <e2toggledisabledimg>off</e2toggledisabledimg>
      <e2alwayszap>0</e2alwayszap>

Da ich nicht weiss, welche die FBDECT Geraete sind, habe ich Probleme dein Log zu analysieren. Dabei ist mir aufgefallen, dass gegen meine eigenen Richtlinien das FBDECT Modul das Set/Get nicht per verbose 3 im Log protokolliert. Das habe ich nachgeholt (per update ab morgen verfuegbar).

Achtung: so grosse Logs lieber als Anhang hinzufuegen, dieser ist vmtl. gekuerzt und nicht vollstaendig.

Die DECT hatte ich weiter oben bereits erläutert. Aber kein Problem, hier noch   detailliert:

Lampe_Korridor 08761_0087570
PC_Kunlaya       08761_0172730
Schreibtisch       08761_0245609
TV                    08761_0243162
TVLICHT_hinten 08761_0087783
TVLICHT_vorne  08761_0087781

DU_Nachtzeit ist ein Dummy.
Uhr, Links, Recht, Wand, LED_Blumen sind Intertechno.
SamsungTV, Webradio und Giga sind mein Samsung Fernseher, Webradioinstallation auf einem anderen Pi und mein Gigablue Quad Pro, also keine Steckdosen.

Es wird alles ordentlich geschltet, ausser DECT.


Das Log war nicht gekürzt.
Ich hatte das Logfile geleert, dann global verbose 5 gesetzt und den zu protokollierenden Schaltvorgang ausgelöst. Dann habe ich fhem Neustart gemacht.
Alles zwischen verbose 5 und Neustart hatte ich hier gezeigt.

Gerne komme ich deinem Wunsch nach und sende die Logs zukünftig als Anhang. Irgendwer hatte mal geschrieben, wer helfen soll, hat nicht noch Lust irgendwas runterzuladen und zu öffnen. Das war der Grund, warum ich keinen Anhang genutzt hatte.

Ich werde nach morgigem Update noch einmal loggen und mich dann mit dem Logfile noch einmal hier melden.
Bis dahin vielen Dank.

Hallo Herr König,

nach meinem update von gestern läuft bei mir FBAHA wieder einwandfrei. Danke.

Gruß Bernhard-IN

Bei mir sieht es leider noch immer schlecht aus.
Das Verhalten hat sich nicht positiv verändert.
Logfile anbei.

ZitatBei mir sieht es leider noch immer schlecht aus.

Das waere jetzt auch ein Wunder, ich habe schliesslich nur bei set eine Ausgabe hinzugefuegt.
Btw. Bernhard-IN redet von FBAHA (alt) und nicht von FBAHAHTTP (neu, hier thematisiert).

Wenn ich dein Log richtig verstehe, werden bei "set DU_DI_gute_Nacht_Trigger on" sehr viele Aktionen angestossen (ueber FBHAHAHTTP, IT/CUL, STV, ENIGMA2,  etc), von denen einige blockierend arbeiten, und insg. ca. 10 Sekunden benoetigen, was gleichzeitig bedeutet, das FHEM fuer 10 Sekunden fuer allerlei Input/Netzwerk/Timeout/etc taub ist. Kannst du diese Theorie bitte bestaetigen? Da FBAHAHTTP mit einem Timeout von 4 Sekunden arbeitet, wird es, sobald wieder "Luft ist", mit der Timeout Nachricht aufgerufen, und ab hier laeuft bis zum naechsten FBAHAHTTP Status-Holen nichts mehr.

Ich habe z.Zt. folgende Ideen, um das Problem zu beheben:
- FBAHA generell auf Blocking umstellen. Bedeutet 0.3-0.5s blockieren pro geschaltetes Geraet.
- Per Attribut auf Blocking stellen: das muesstest du dann aktivieren.
- FBDECT muesste irgendwie rauskriegen, dass der Timeout wg. "lokaler Unfaehigkeit" eingetreten ist, und das entsprechend behandeln.

Variante 3 waere mir am liebsten, ich muss aber noch ueber die Details nachdenken.

Ich setze gerade aus Verzweiflung noch einmal das System auf einer Ersatzkarte auf.
Ich werde dann testen.
Es wäre mir nämlich furchtbar unangenehm, wenn sich herausstellen sollte, dass das Problem in meiner Konfiguration liegt.

Ich kann bestätigen, dass ich allesa durcheinander schalte. Das hatte aber seit mindestens einem Jahr mit FBAHA und dem DOIF in dieser Form funktioniert. Daher hatte ich keine Nachteile erwartet.

Würde/sollte es das Problem beseitigen, wenn ich die Schaltungen sortiere (also zuerst DECT, dann IT, dann Dummy usw)?

Ich werde mich in ein bis 2 Tagen zu dem Thema noch einmal melden, wenn ich mehr getestet habe.

Bis dahin erst einmal vielen Dank für die Hilfe.

ZitatWürde/sollte es das Problem beseitigen, wenn ich die Schaltungen sortiere (also zuerst DECT, dann IT, dann Dummy usw)?

Wenn meine Theorie stimmt, dann wuerde es helfen, alle FBDECT Geraete als _letzter_ zur starten.

Ich habe jetzt eine Variante eingecheckt, der hoffentlich dein DOIF/FBDECT Problem loest. Dass dein FHEM 10s lang "tot" ist, bleibt natuerlich. Das Problem war einfach zu reproduzieren mit
set FBDECT_Device on; sleep 6

Ich habe noch einmal mit meiner neuen Installation getestet.
Ich habe zuerst das DOIF so umgebaut, dass zuerst alle anderen Geräte und zuletzt die DECT geschaltet werden.
Danach habe ich dann einmal OHNE Verzögerungen probiert. Da läuft nichts mit den DECT.
Dann habe ich mit Verzögerung, aber nur für die DECT probiert, für andere Geräte auf 0.
Das funktioniert ebenfalls nicht. IT geht, DECT nicht.
Nur wenn ich vor alle Geräte eine Verzögerung setze von 0.5 Sekunden wird alles sicher geschaltet.

Ich probiere selbiges morgen noch einmal, mit deiner neuen Version.

Beim Update ist keine neue Version von FBAHAHTTP aufgeschlagen.
Habe ich was übersehen?

Nein, die Aenderungen sind in HttpUtils.pm.

Ah, das hatte ich nciht verstanden.
So, ich habe neu getestet und habe wieder keinen Erfolg.
Ohne eingefügte Pausen wird nicht geschaltet.
Mit Pausen funktioniert es.

Gebe ich in die Kommandozeile
set Uhr,LED_Blumen,Links,Rechts,Wand,TVLICHT_hinten,TVLICHT_vorne,TV,PC_Kunlaya,Schreibtisch,DU_DI_gute_Nacht_Trigger off

ein, wird ebenfalls nicht geschaltet, somit kann ich das DOIF als Fehlerquelle ausschliessen.
Auch eine reine Mischschaltung als Fehlerquelle kommt somit nicht infrage.
Das einzige Mischelement ist hier DU_DI_gute_Nacht_Trigger, der aber zeitlich unauffällig sein sollte.

Ich werde nun einfach mit Pausen schalten. Es scheint ja so zu sein, dass ausser mir keiner das Problem hat.
Falls doch, wäre eine Mitteilung darüber schön.
Auj jeden Fall danke ich dir nochmals für die Hilfe.
Die Logfiles habe ich hier noch einmal zur Ansicht angehängt, falls du sie möchtest.

Zitat von: Invers am 26 Juni 2016, 10:34:58
Ich werde nun einfach mit Pausen schalten. Es scheint ja so zu sein, dass ausser mir keiner das Problem hat.
Falls doch, wäre eine Mitteilung darüber schön.

Wenn das nächste Update der Fritzbox kommt, muss ich wohl leider auch umstellen, nur bis dahin verwende ich das alte FBAHA.
Mir graut vor dem Tag an dem ich die Umstellung vornehmen muss.  :-\

Mit der aktuellen Beta läuft es noch auf der Fritzbox. Du kannst das Update also überleben.
Ich habe nur vorsorglich umgestellt, weil man ja nie Zeit hat, wenn es ernst wird. Und wie man sieht, war es eine kluge Entscheidung. Es ist immer gut, wenn man Ecken und Kanten so früh wie möglich bemerkt.

Zitat von: rudolfkoenig am 25 Juni 2016, 13:32:30

Ich habe z.Zt. folgende Ideen, um das Problem zu beheben:
- FBAHA generell auf Blocking umstellen. Bedeutet 0.3-0.5s blockieren pro geschaltetes Geraet.
- Per Attribut auf Blocking stellen: das muesstest du dann aktivieren.
- FBDECT muesste irgendwie rauskriegen, dass der Timeout wg. "lokaler Unfaehigkeit" eingetreten ist, und das entsprechend behandeln.

Variante 3 waere mir am liebsten, ich muss aber noch ueber die Details nachdenken.

Hi, ich muss mich leider doch noch einmal zu diesem Thema melden.
Ich habe nun alle Aufrufe mit Pausen von 0.5 Sekunden versehen.
Leider kann ich damit noch immer nicht alles korrekt schalten.
Wenn ich zum Beispiel AMAD verwende,  kann ich mit "und" mehrere Schaltbefehle per Sprachsteuerung absetzen.
Dann erfolgt bereits bei 2 Schaltbefehlen keine Schaltung mehr. Die erste Dect wird noch geschaltet, dann geht nichts mehr.
Auch bei mehreren Schaltbefehlen in einer sub geht leider gar nichts mehr. Auch hier, wenn überhaupt, nur der erste Schaltbefehl.

Es ist schwer, den Überblick zu behalten.
Ich möchte dich daher bitten, die vorgeschlagene Variante mit der Steuerung einer Verzögerung per Attribut umzusetzen, wenn du die Möglichkeit dazu siehst und es nicht zu viel Mühe macht. Vielleicht kann man ja dort die Verzögerung sogar einstellbar machen.

Leider kann ich ja immernoch nicht sagen, ob ich der einzige Betroffene bin. Wir haben ja leider weder positive, noch negative Erfahrungen mitgeteilt bekommen.

Besten Dank im Voraus für die Antwort.

Ich gehe davon aus, dass du meinen Beitrag
  https://forum.fhem.de/index.php/topic,54697.msg464532.html#msg464532
uebersehen/vergessen/nicht genau gelesen hast, jedenfalls habe ich noch keine Reaktion gehoert.
Vermutlich muss dieser Wert bei dir erhoeht werden.

Evtl. liegt das Problem aber auch daran, dass DECT und IT parallel geschaltet werden, und die Funkwellen sich gegenseitig stoeren. Wenn das stimmt, dann brauchen wir eine andere Loesung. Aber zunaechst haette ich gerne, das du das async_delay Attribut testest.

Entschuldige bitte, ich habe hier tatsächlich vergessen, zu berichten.
Also ich habe das Attribut ausprobiert, hatte aber auch damit keinen Erfolg.
Ich habe extra ohne Mischung gearbeitet, also nur mit DECT. Es wird immer nur er erste Schaltbefehl einer Kette ausgeführt, obwohl alle als ausgeführt protokolliert werden.
Ich habe mit Attributwerten  0, 1 und 10 getestet.
Das Log ist schon gelöscht, aber wenn du möchtest, erstelle ich es noch einmal neu.

Nochmals sorry für meinen Fehler. Die Ereignisse hatten sich zu der Zeit bei mir ziemlich überschlagen.

Nachtrag:
Das Delay scheint prinzipiell nicht zu greifen. Ich habe 5 eingestellt, trotzdem wird meine WAIT-Pause des DOIF von 1 s eingehalten.
Alle Devices schalten dann mit dem DOIF einwandfrei. Nur das Delay wird halt ignoriert.

Hmm. Wenn das selbst mit 10 Sekunden Verzoegerug nicht funktioniert, dann bin ich erstmal ratlos. Ja, ich haette gerne ein Log, am besten mit asnyc_delay auf 1 und 10 Sekunden. Und bitte mit "attr global verbose 5", damit ich den Einfluss anderer Module sehen kann.

Ich habe das Log erstellt.

Hoffentlich kannst du was entdecken. Wie gesagt, der erste Schaltbefehl wird immer ausgeführt, die folgenden Befehle nicht.


Zur Vorsicht noch einmal das zugehörige DOIF:
Internals:
   CFGFN
   DEF        ([Dummy_Test] eq "on")
(set Lampe_Korridor on)
(set Schreibtisch on)
(set TVLICHT_hinten on)
(set TVLICHT_vorne on)
DOELSEIF ([Dummy_Test] eq "off")
(set Lampe_Korridor off)
(set Schreibtisch off)
(set TVLICHT_hinten off)
(set TVLICHT_vorne off)
   NAME       DI_Dosentest
   NR         125
   NTFY_ORDER 50-DI_Dosentest
   STATE      cmd_1
   TYPE       DOIF
   Readings:
     2016-07-01 15:37:18   Device          Dummy_Test
     2016-07-01 15:37:18   cmd             1.4
     2016-07-01 15:37:18   cmd_event       Dummy_Test
     2016-07-01 15:37:18   cmd_nr          1
     2016-07-01 15:37:18   cmd_seqnr       4
     2016-07-01 15:37:18   e_Dummy_Test_STATE on
     2016-07-01 15:37:18   state           cmd_1
     2016-07-01 12:25:40   wait_timer      no timer
   Condition:
     0          InternalDoIf($hash,'Dummy_Test','STATE','','',AttrVal($hash->{NAME},'notexist',undef)) eq "on"
     1          InternalDoIf($hash,'Dummy_Test','STATE','','',AttrVal($hash->{NAME},'notexist',undef)) eq "off"
   Devices:
     0           Dummy_Test
     1           Dummy_Test
     all         Dummy_Test
   Do:
     0:
       0          set Lampe_Korridor on
       1          set Schreibtisch on
       2          set TVLICHT_hinten on
       3          set TVLICHT_vorne on
     1:
       0          set Lampe_Korridor off
       1          set Schreibtisch off
       2          set TVLICHT_hinten off
       3          set TVLICHT_vorne off
   Helper:
     event      on
     globalinit 1
     last_timer 0
     sleeptimer -1
     timerdev   Dummy_Test
     timerevent on
     triggerDev Dummy_Test
     timerevents:
       on
     timereventsState:
       state: on
     triggerEvents:
       on
     triggerEventsState:
       state: on
   Internals:
     0           Dummy_Test:STATE
     1           Dummy_Test:STATE
     all         Dummy_Test:STATE
   Itimer:
   Readings:
   Regexp:
     0:
     1:
     All:
   State:
   Trigger:
Attributes:
   comment    Das ist ein  Test
   do         always
   room       1,Dosentest

Das Log so ist leider wertlos: "attr global verbose 5" war nicht gesetzt.

Sorry, hier noch einmal, diesmal kontrolliert. :-)

Was ich im log sehe:
- Es werden immer 4 DECT Geraete auf einmal geschaltet, in der gleichen Reihenfolge
- Es wurde 4-mal geschaltet: aus, an, aus, an
- du hast async_delay fuer die ersten 3 Operationen auf 1s gesetzt, die 4. war mit 10s.
- das Fritzbox hat fuer alle diese Operationen jeweils Erfolg gemeldet: nach aus 0, nach an 1.

-> Ich sehe weder mit 1s noch mit 10s irgendwelche Anzeichen fuer Probleme.

Falls es bei dir immer noch nicht funktioniert, dann koenntest versuchen in der FritzBox eine Gruppe anzulegen, und diese zu schalten. Leider ist die Unterstuetzung der Gruppe in FHEM noch nicht perfekt: die Mitglieder werden erst beim naechsten "Refresh" aktualisiert, und Events werden auch erst spaeter generiert.

Ich habe AVM etwa vor zwei Wochen um Hilfe gebeten, entweder sind die Leute in Urlaub, oder ich bin in Ungnade gefallen, da keine Antwort.

Ja, das siehst du richtig.

Zitatdas Fritzbox hat fuer alle diese Operationen jeweils Erfolg gemeldet: nach aus 0, nach an 1.

Warum das so ist, kann ich nicht nachvollziehen. Die Box lügt einfach. :-)
Ich verstehe das Delayattribut so, dass eigentlich nach jedem Schaltbefehl einer Serie eine Pause von x,x Sekunden erfolgen soll. Genau diese Pausen sind aber nicht wirksam. Sie existieren nach aussen schlicht weg gar nicht.
Nehmen wir an, ich setze zu dem Delay noch eine Verzögerung über ein Wait von 0.5 Sekunden im DOIF, dann dann wird im Abstand von 0.5 Sekunden geschaltet, was auch funktioniert. Die Delays des Attributes hingegen müssten ja 10 Sekunden Pause produzieren, was aber nicht funktioniert.
Vielleicht hat ja AVM da so eine Art Spamschutz eingebaut, dass man zwischen den Befehlen halt Pausen haben muss.
Es kann natürlich sein, dass dein Delay nicht greift, weil die Box durch meine Pausen nicht mehr der Meinung ist, aufeinanderfgolgende Befehle abzuarbeiten, sondern einzelne, getrennte.

Vielleicht ist es eine brauchbare Idee, nach JEDEM Schaltbefehl ein Delay einzufügen. Das sollte ja keinen Schaden anrichten.

Die Idee mit den Gruppen hatte ich bereits überlegt, geht aber nicht,  weil die ja nicht variabel sind.
Wenn ich über Sprachsteuerung mit UND verschiedene Befehle ausführe, dann ist das halt mit Gruppen nicht machbar.

Ich würde ja AVM selber mal befragen. Zeit und Lust hätte ich genug, aber ich kann die Fragen nicht fachlich stellen.
Ich wäre da kein ebenbürtiger Diskussionspartner.
Es könnte sich ja durchaus auch um einen Bug in der FB Firmware handeln. Der wäre dann auch in der Folgeversion drinnen, da ich mit der aktuellen Labor arbeite. Aber auch mit der aktuellen Version der Firmware taucht dieser Fehler auf. Ich denke, dass der immer weiter mitgeschleppt wird, weil er noch nicht bekannt ist (falls es denn ein Fehler ist).

Anja. Schade, aber nicht zu ändern.
Auf alle Fälle sei dir herzlich für die Mühen und die Unterstützung gedankt.

Ich habe das gleiche Problem wenn ich mehrere DECT200 Steckdosen gleichzeitig schalte. Ich muss die Steckdosen mit einem sleep von 2 Sekunden nacheinander schalten.
Gruß Christian

Das ist natürlich schlecht für dich.
Ich dagegen bin froh zu sehen, nicht der einzig Betroffene zu sein.

Ich habe jetzt 3 DECT Geraete zum testen aufgetrieben, und konnte "euer" Problem nachstellen. Habe auch einen Bug gefunden, gefixt und eingecheckt, jetzt kann ich das Problem nicht mehr reproduzieren. Ich habe dabei die async_delay Voreinstellung auf 0 gesetzt, da es mAn nicht noetig ist.

Donnerwetter! Gratuliere!
Die Schaltung beliebig vieler DECT geht nun sogar wesentlich schneller, als mit FBAHA.
Auch wenn ich nicht so viel Ahnung habe, würde mich interessieren, wo der Hase im Pfeffer lag.
Ich danke dir auf jeden Fall, dass du dich so intensiv um "unser" Problem gekümmert und es beseitigt hast.

Also nochmals vielen Dank.

Super! Danke! Bei mir funktioniert es jetzt auch.

ZitatAuch wenn ich nicht so viel Ahnung habe, würde mich interessieren, wo der Hase im Pfeffer lag.

Nichts, womit man angeben kann: In der Schlangenverarbeitung wurde zwar das vordere Element gesendet, aber danach die Schlange von hinten gekuerzt.

Hm. Die Fritzbox hat ja trotzdem das korrekte Schalten gemeldet. Komisch. Aber egal, ich habe verstanden. Danke für die Info.
Fritzbox erinnert mich an Handwerker. Wenn die "fertig" rufen, liegt auch noch die halbe Arbeit rum. LOL