HM-LC-SW2-FM schaltet 'von selbst' (?)

[SVLoneStar]

Hallo,
ich habe ein Problem mit dem Schalten eines HM-LC-SW2-FM per notify.
Situation: Ein Bewegungsmelder triggert ein notify, per DOIF wird ein 'on-for-timer 0.25' an den HM-LC-SW2-FM gesendet, Licht geht an.
Im DOIF ist ein attr wait 0,60 gesetzt. Nach Ablauf der 60 Sekunden wird erneut ein on-for-timer 0.25 geschickt, Licht geht aus.
Klappt.
Allerdings geht das Licht nach ca. 6 Sekunden 'von selbst' wieder an....

Auszug aus dem Log:

Code Auswählen Erweitern


2016.05.26 12:52:06 3: CUL_HM set HM_38BA77_Sw_01 on-for-timer 0.25
2016.05.26 12:52:06 3: --- PIRI_OG_TREPPENHAUS: Treppenhaus_EIN_DOIF ausgelöst
2016.05.26 12:53:07 3: CUL_HM set HM_38BA77_Sw_01 on-for-timer 0.25
2016.05.26 12:53:07 3: FS20 set FS20_ab7f00 off
2016.05.26 12:53:07 3: FS20 set FS20_e63e00 off
2016.05.26 12:53:07 3: --- PIRI_OG_TREPPENHAUS: Treppenhaus_AUS_Timer ausgelöst

Danach kommt nix mehr, was mit dem DOIF (das sind die Kommentare mit führendem '---'), den Bewegungsmeldern (FS20_ab7f00, FS20_e63e00) oder dem HM-LC-SW2-FM (HM_38BA77) bzw. dessen Channels zu tun hat.

Auszug aus den Events (DOIF manuell gestartet mit 'trigger FS20_ab7f00 on'):

Code Auswählen Erweitern


2016-05-26 13:04:27 CUL_HM HM_38BA77 CMDs_pending
2016-05-26 13:04:27 CUL_HM HM_38BA77_Sw_01 set_on-for-timer 0.25
2016-05-26 13:04:27 dummy Licht_Flur_OG_dummy on
2016-05-26 13:04:27 DOIF Piri_Flur_OG_Dark2 cmd_nr: 1
2016-05-26 13:04:27 DOIF Piri_Flur_OG_Dark2 cmd_seqnr: 1
2016-05-26 13:04:27 DOIF Piri_Flur_OG_Dark2 cmd: 1.1
2016-05-26 13:04:27 DOIF Piri_Flur_OG_Dark2 cmd_event: FS20_ab7f00
2016-05-26 13:04:27 DOIF Piri_Flur_OG_Dark2 ON
2016-05-26 13:04:27 DOIF Piri_Flur_OG_Dark2 wait_timer: 26.05.2016 13:05:27 cmd_1_2 FS20_ab7f00
2016-05-26 13:04:27 FS20 FS20_ab7f00 on
2016-05-26 13:04:27 CUL_HM HM_38BA77 CMDs_done
2016-05-26 13:04:27 CUL_HM HM_38BA77_Sw_01 deviceMsg: on (to vccu)
2016-05-26 13:04:27 CUL_HM HM_38BA77_Sw_01 level: 100
2016-05-26 13:04:27 CUL_HM HM_38BA77_Sw_01 pct: 100
2016-05-26 13:04:27 CUL_HM HM_38BA77_Sw_01 on
2016-05-26 13:04:27 CUL_HM HM_38BA77_Sw_01 timedOn: running
2016-05-26 13:04:30 CUL_HM HM_38BA77 CMDs_done
2016-05-26 13:04:30 CUL_HM HM_38BA77_Sw_01 deviceMsg: off (to vccu)
2016-05-26 13:04:30 CUL_HM HM_38BA77_Sw_01 level: 0
2016-05-26 13:04:30 CUL_HM HM_38BA77_Sw_01 pct: 0
2016-05-26 13:04:30 CUL_HM HM_38BA77_Sw_01 off
2016-05-26 13:04:30 CUL_HM HM_38BA77_Sw_01 timedOn: off
...
2016-05-26 13:05:27 DOIF Piri_Flur_OG_Dark2 wait_timer: no timer
2016-05-26 13:05:27 CUL_HM HM_38BA77 CMDs_pending
2016-05-26 13:05:27 CUL_HM HM_38BA77_Sw_01 set_on-for-timer 0.25
2016-05-26 13:05:27 FS20 FS20_ab7f00 off
2016-05-26 13:05:27 FS20 FS20_e63e00 off
2016-05-26 13:05:27 dummy Licht_Flur_OG_dummy off
2016-05-26 13:05:27 DOIF Piri_Flur_OG_Dark2 cmd_nr: 1
2016-05-26 13:05:27 DOIF Piri_Flur_OG_Dark2 cmd_seqnr: 2
2016-05-26 13:05:27 DOIF Piri_Flur_OG_Dark2 cmd: 1.2
2016-05-26 13:05:27 DOIF Piri_Flur_OG_Dark2 cmd_event: FS20_ab7f00
2016-05-26 13:05:27 DOIF Piri_Flur_OG_Dark2 cmd_1
2016-05-26 13:05:29 CUL_HM HM_38BA77 NACK
2016-05-26 13:05:34 CUL_HM HM_38BA77_Sw_01 deviceMsg: on (to vccu)
2016-05-26 13:05:34 CUL_HM HM_38BA77_Sw_01 level: 100
2016-05-26 13:05:34 CUL_HM HM_38BA77_Sw_01 pct: 100
2016-05-26 13:05:34 CUL_HM HM_38BA77_Sw_01 on
2016-05-26 13:05:34 CUL_HM HM_38BA77_Sw_01 timedOn: running
2016-05-26 13:05:37 CUL_HM HM_38BA77_Sw_01 deviceMsg: off (to vccu)
2016-05-26 13:05:37 CUL_HM HM_38BA77_Sw_01 level: 0
2016-05-26 13:05:37 CUL_HM HM_38BA77_Sw_01 pct: 0
2016-05-26 13:05:37 CUL_HM HM_38BA77_Sw_01 off
2016-05-26 13:05:37 CUL_HM HM_38BA77_Sw_01 timedOn: off
2016-05-26 13:05:39 CUL_HM HM_38BA77 NACK


Ein List des HM-LC-SW2-FM:

Code Auswählen Erweitern


Internals:
   DEF        38BA77
   IODev      hmusb
   LASTInputDev hmusb
   MSGCNT     22
   NAME       HM_38BA77
   NR         2528
   NTFY_ORDER 50-HM_38BA77
   STATE      CMDs_done
   TYPE       CUL_HM
   channel_01 HM_38BA77_Sw_01
   channel_02 HM_38BA77_Sw_02
   hmusb_MSGCNT 22
   hmusb_RAWMSG E38BA77,0000,195FC81C,FF,FFB6,13A41038BA77AB42FE06010000
   hmusb_RSSI -74
   hmusb_TIME 2016-05-26 13:13:16
   lastMsg    No:13 - t:10 s:38BA77 d:AB42FE 06010000
   protCmdDel 1
   protLastRcv 2016-05-26 13:13:16
   protResnd  3 last_at:2016-05-26 13:05:39
   protResndFail 1 last_at:2016-05-26 13:05:44
   protSnd    20 last_at:2016-05-26 13:13:16
   protState  CMDs_done
   protTimedOn 2 last_at:2016-05-26 13:05:39
   rssi_at_hmusb lst:-74 max:-73 min:-80 avg:-76.36 cnt:22
   rssi_hmusb avg:-83.08 max:-79 min:-86 cnt:12 lst:-86
   Readings:
     2016-05-25 22:19:03   CommandAccepted yes
     2016-05-24 17:30:20   D-firmware      2.5
     2016-05-25 22:08:34   D-serialNr      MEQ0176224
     2016-05-25 22:19:25   PairedTo        0xAB42FE
     2016-05-24 17:30:25   R-pairCentral   0xAB42FE
     2016-05-25 22:19:25   RegL_00.        02:01 0A:AB 0B:42 0C:FE 15:FF 18:00 00:00
     2016-05-24 17:44:55   powerOn         2016-05-24 17:44:55
     2016-05-26 13:13:16   state           CMDs_done
   Helper:
     HM_CMDNR   19
     cSnd       11AB42FE38BA770201C800000040,11AB42FE38BA770201C800000040
     mId        0009
     rxType     1
     Expert:
       def        1
       det        0
       raw        1
       tpl        0
     Io:
       newChn     +38BA77,00,00,00
       nextSend   1464261196.32084
       rxt        0
       vccu       vccu
       p:
         38BA77
         00
         00
         00
       prefIO:
         hmusb
     Mrssi:
       mNo        13
       Io:
         hmusb      -72
     Prt:
       bErr       0
       sProc      0
       Rspwait:
     Q:
       qReqConf
       qReqStat
     Role:
       dev        1
       prs        1
     Rpt:
       IO         hmusb
       flg        A
       ts         1464261196.22883
       ack:
         HASH(0x3d655a0)
         138002AB42FE38BA7700
     Rssi:
       At_hmusb:
         avg        -76.3636363636364
         cnt        22
         lst        -74
         max        -73
         min        -80
       Hmusb:
         avg        -83.0833333333333
         cnt        12
         lst        -86
         max        -79
         min        -86
     Shadowreg:
     Tmpl:
Attributes:
   IODev      hmusb
   IOgrp      vccu:hmusb
   alias      HM-LC-SW2-FM Treppenhaus
   autoReadReg 4_reqStatus
   expert     2_raw
   firmware   2.5
   group      HM-LC-SW2-FM
   icon       people_sensor
   model      HM-LC-SW2-FM
   room       4 - UG Flur,9 - HM Devices
   serialNr   MEQ0176224
   subType    switch
   webCmd     getConfig:clear msgEvents
 

Und ein list des Channels1:

Code Auswählen Erweitern


Internals:
   DEF        38BA7701
   NAME       HM_38BA77_Sw_01
   NR         2530
   NTFY_ORDER 50-HM_38BA77_Sw_01
   STATE      off
   TYPE       CUL_HM
   chanNo     01
   device     HM_38BA77
   peerList   virtueller_Aktor_Btn3,
   Readings:
     2016-05-26 13:13:13   CommandAccepted yes
     2016-05-25 22:03:55   R-powerUpAction off
     2016-05-25 22:03:55   R-sign          off
     2016-05-25 22:12:21   R-virtueller_Aktor_Btn3-lgActionType jmpToTarget
     2016-05-25 22:12:21   R-virtueller_Aktor_Btn3-shActionType jmpToTarget
     2016-05-25 22:19:33   RegL_01.        08:00  30:06 57:24 56:00 00:00
     2016-05-25 22:19:40   RegL_03.virtueller_Aktor_Btn3 02:00 03:00 04:32 05:64 06:00 07:FF 08:00 09:FF 0A:01 0B:14 0C:63 82:00 83:00 84:32 85:64 86:00 87:FF 88:00 89:FF 8A:21 8B:14 8C:63 00:00
     2016-05-26 13:13:16   deviceMsg       off (to vccu)
     2016-05-26 13:13:16   level           0
     2016-05-26 13:13:16   pct             0
     2016-05-26 13:03:24   peerList        virtueller_Aktor_Btn3,
     2016-05-26 13:13:16   recentStateType info
     2016-05-26 13:13:16   state           off
     2016-05-26 13:13:16   timedOn         off
   Helper:
     Expert:
       def        1
       det        0
       raw        1
       tpl        0
     Role:
       chn        1
     Shadowreg:
     Tmpl:
Attributes:
   alias      HM-LC-SW2-FM Treppenhaus Btn1
   group      HM-LC-SW2-FM
   icon       toggle
   model      HM-LC-SW2-FM
   peerIDs    00000000,22222203,
   room       4 - UG Flur,9 - HM Devices
   webCmd     statusRequest:toggle:on:off


Die RSSI-Werte sind nicht wirklich super, aber m. E. auch nicht superkritisch...?

Interessante Zusatzinfos:
Wenn ich per 'HM_38BA77_Sw_01 on-for-timer 0.25' das Schalten manuell auslöse, klappt das Ganze wunderbar (ohne 'magisches Doppel-Schalten') - hier die Events dazu:

Code Auswählen Erweitern


2016-05-26 13:12:58 CUL_HM HM_38BA77 CMDs_pending
2016-05-26 13:12:58 CUL_HM HM_38BA77_Sw_01 set_on-for-timer 0.25
2016-05-26 13:12:58 CUL_HM HM_38BA77 CMDs_done
2016-05-26 13:12:58 CUL_HM HM_38BA77_Sw_01 deviceMsg: on (to vccu)
2016-05-26 13:12:58 CUL_HM HM_38BA77_Sw_01 level: 100
2016-05-26 13:12:58 CUL_HM HM_38BA77_Sw_01 pct: 100
2016-05-26 13:12:58 CUL_HM HM_38BA77_Sw_01 on
2016-05-26 13:12:58 CUL_HM HM_38BA77_Sw_01 timedOn: running
2016-05-26 13:13:01 CUL_HM HM_38BA77 CMDs_done
2016-05-26 13:13:01 CUL_HM HM_38BA77_Sw_01 deviceMsg: off (to vccu)
2016-05-26 13:13:01 CUL_HM HM_38BA77_Sw_01 level: 0
2016-05-26 13:13:01 CUL_HM HM_38BA77_Sw_01 pct: 0
2016-05-26 13:13:01 CUL_HM HM_38BA77_Sw_01 off
2016-05-26 13:13:01 CUL_HM HM_38BA77_Sw_01 timedOn: off
...
2016-05-26 13:13:14 CUL_HM HM_38BA77 CMDs_done
2016-05-26 13:13:14 CUL_HM HM_38BA77_Sw_01 deviceMsg: on (to vccu)
2016-05-26 13:13:14 CUL_HM HM_38BA77_Sw_01 level: 100
2016-05-26 13:13:14 CUL_HM HM_38BA77_Sw_01 pct: 100
2016-05-26 13:13:14 CUL_HM HM_38BA77_Sw_01 on
2016-05-26 13:13:14 CUL_HM HM_38BA77_Sw_01 timedOn: running
2016-05-26 13:13:16 CUL_HM HM_38BA77 CMDs_done
2016-05-26 13:13:16 CUL_HM HM_38BA77_Sw_01 deviceMsg: off (to vccu)
2016-05-26 13:13:16 CUL_HM HM_38BA77_Sw_01 level: 0
2016-05-26 13:13:16 CUL_HM HM_38BA77_Sw_01 pct: 0
2016-05-26 13:13:16 CUL_HM HM_38BA77_Sw_01 off
2016-05-26 13:13:16 CUL_HM HM_38BA77_Sw_01 timedOn: off

Danach keine Meldungen mehr zum HM_38BA77.
Je nachdem, wie das 'on for timer' geschickt wird, hat der STATE des HM_38BA77 danach unterschiedliche Werte:

• Manuell per set HM_38BA77_Sw_01 on-for-timer 0.25: state = CMDs_done
• Per DOIF (ausgelöst durch trigger FS20_ab7f00 on): state = NACK, einige Sekunden später (nach dem 'magischen Selbstschalten'?) state = MISSING ACK

Aber wie gesagt - manuelles Schalten klappt immer wunderbar.

Der HM_38BA77 ist mit einem virtual actor gepeert.
Dazu noch eine Anmerkung:
In http://www.fhemwiki.de/wiki/HM-PB-2-WM55_2fach-Funk-Wandtaster wird beschrieben, wie man den dort beschriebenen Funk-Wandtaster mit einem virtuellen Aktor peert.
Ein

Code Auswählen Erweitern

set HM_38BA77 peerChan 1 virtueller_Aktor_Btn3 single set
oder

Code Auswählen Erweitern

set HM_38BA77_Sw_01 peerChan 0 virtueller_Aktor_Btn3 single set
produziert aber Fehler, peerChan gibt's nicht. Andersherum gehts:

Code Auswählen Erweitern

set virtueller_Aktor_Btn3 peerChan 0 HM_38BA77_Sw_01 single set
Ist das Wiki an der angegebenen Stelle falsch? Bei meinem HM-PB-2-WM55 jedoch hat das Peeren genau so geklappt wie im Wiki beschrieben, also in der falschen (?) Reihenfolge der Befehle...?

Nochwas:

• In https://forum.fhem.de/index.php/topic,53670.0.html habe ich gelesen, daß es Probleme beim ack resend gibt/gab und habe daher die tagesaktuelle Version des 10_CUL_HM aus dem SVN laufen - keine Änderung.
• Ich habe vor 2 Tagen einen bis dahin verbauten FS20 SU-3 gegen den HM-LC-SW2-FM getauscht...bei FS20 hat das on-for-timer 0.25`zum Ein- und Ausschalten funktioniert, Problem tritt seit Verwendung des HomeMatic-Aktor auf.
  

Hat irgendwer eine Idee, was da falsch läuft bzw. warum der UP-Aktor beim DOIF ein NACK wirft und per direkten set nicht?

Besten Dank,
Stefan

[martinp876]

Das Problem scheint das Ausbleiben des ack zu sein. Fhem startet einen weiteren Versuch.
Warum geht das senden schief? Schon einmal gesnifft?

[SVLoneStar]

Nein - lese mich schlau und poste wieder. Danke!!


Sent from my iPhone using Tapatalk

[SVLoneStar]

Hallo Martin,
so, da isser wieder...

Hier der Inhalt des Log nach dem Setzen der erforderlichen Attribute und dem Auslösen des Bewegungsmelders per 'trigger':

Code Auswählen Erweitern


2016.05.26 16:48:22 3: CUL_HM set HM_38BA77_Sw_01 on-for-timer 0.25
2016.05.26 16:48:22 3: --- PIRI_OG_TREPPENHAUS: Treppenhaus_EIN_DOIF ausgelöst
2016.05.26 16:49:22 3: CUL_HM set HM_38BA77_Sw_01 on-for-timer 0.25
2016.05.26 16:49:22 3: FS20 set FS20_ab7f00 off
2016.05.26 16:49:22 3: FS20 set FS20_e63e00 off
2016.05.26 16:49:22 3: --- PIRI_OG_TREPPENHAUS: Treppenhaus_AUS_Timer ausgelöst
2016.05.26 16:54:51.332 0: HMLAN_Parse: hmusb R:E43F6BF   stat:0000 t:1A2AA54E d:FF r:FFC3     m:BA 8610 43F6BF 000000 0A90EB0F0000
2016.05.26 16:55:00.534 0: HMLAN_Parse: hmusb R:E26CCB4   stat:0000 t:1A2AC94B d:FF r:FFC8     m:18 8610 26CCB4 000000 0A88EC0B0000
2016.05.26 16:55:02.358 0: HMLAN_Send:  hmusb I:K
2016.05.26 16:55:02.422 0: HMLAN_Parse: hmusb V:03C7 sNo:LEQ1517406 d:34F292 O:AB42FE t:1A2AD0A1 IDcnt:0018 L:6 %
2016.05.26 16:55:27.363 0: HMLAN_Send:  hmusb I:K
2016.05.26 16:55:27.414 0: HMLAN_Parse: hmusb V:03C7 sNo:LEQ1517406 d:34F292 O:AB42FE t:1A2B3240 IDcnt:0018 L:6 %
2016.05.26 16:55:34.177 0: HMLAN_Send:  hmusb S:SED904073 stat:  00 t:00000000 d:01 r:ED904073 m:1D A011 AB42FE 38BA77 0201C800000040
2016.05.26 16:55:34.396 0: HMLAN_Parse: hmusb R:RED904073 stat:0001 t:1A2B4D7A d:FF r:FFC0     m:1D 8002 38BA77 AB42FE 0101C84046
2016.05.26 16:55:36.469 0: HMLAN_Parse: hmusb R:E38BA77   stat:0000 t:1A2B558C d:FF r:FFBE     m:1E A410 38BA77 AB42FE 06010000
2016.05.26 16:55:50.487 0: HMLAN_Parse: hmusb R:E38D715   stat:0000 t:1A2B8C53 d:FF r:FFC5     m:72 845E 38D715 000000 80000000000000000926FF
2016.05.26 16:55:52.368 0: HMLAN_Send:  hmusb I:K
2016.05.26 16:55:52.407 0: HMLAN_Parse: hmusb V:03C7 sNo:LEQ1517406 d:34F292 O:AB42FE t:1A2B93E0 IDcnt:0018 L:6 %
2016.05.26 16:55:53.334 0: HMLAN_Parse: hmusb R:E43F6B0   stat:0000 t:1A2B9782 d:FF r:FFC2     m:40 8610 43F6B0 000000 0A90EB0F0000
2016.05.26 16:55:54.071 0: HMLAN_Parse: hmusb R:E42EBDF   stat:0000 t:1A2B9A55 d:FF r:FFC2     m:8F 865A 42EBDF 000000 90EB31
2016.05.26 16:56:08.503 0: HMLAN_Parse: hmusb R:E26E399   stat:0000 t:1A2BD2B9 d:FF r:FFCA     m:1C 8610 26E399 000000 0A88ED090000
2016.05.26 16:56:14.071 0: HMLAN_Parse: hmusb R:E42EBDF   stat:0000 t:1A2BE875 d:FF r:FFC5     m:8F 8470 42EBDF 000000 00EB31
2016.05.26 16:56:17.373 0: HMLAN_Send:  hmusb I:K
2016.05.26 16:56:17.431 0: HMLAN_Parse: hmusb V:03C7 sNo:LEQ1517406 d:34F292 O:AB42FE t:1A2BF5A0 IDcnt:0018 L:6 %
2016.05.26 16:56:34.401 0: HMLAN_Send:  hmusb S:SED912BB3 stat:  00 t:00000000 d:01 r:ED912BB3 m:1F A011 AB42FE 38BA77 0201C800000040
2016.05.26 16:56:35.055 0: HMLAN_Parse: hmusb R:RED912BB3 stat:0008 t:00000000 d:FF r:7FFF     m:1F A011 AB42FE 38BA77 0201C800000040
2016.05.26 16:56:35.056 0: HMLAN_Parse: hmusb no ACK from 38BA77
2016.05.26 16:56:36.799 0: HMLAN_Send:  hmusb S:SED913511 stat:  00 t:00000000 d:01 r:ED913511 m:1F A011 AB42FE 38BA77 0201C800000040
2016.05.26 16:56:37.017 0: HMLAN_Parse: hmusb R:RED913511 stat:0001 t:1A2C421A d:FF r:FFBB     m:1F 8002 38BA77 AB42FE 0101000048
2016.05.26 16:56:41.805 0: HMLAN_Send:  hmusb S:SED91489F stat:  00 t:00000000 d:01 r:ED91489F m:20 A011 AB42FE 38BA77 0201C800000040
2016.05.26 16:56:42.007 0: HMLAN_Parse: hmusb R:RED91489F stat:0001 t:1A2C559A d:FF r:FFC0     m:20 8002 38BA77 AB42FE 0101C84047
2016.05.26 16:56:42.379 0: HMLAN_Send:  hmusb I:K
2016.05.26 16:56:42.423 0: HMLAN_Parse: hmusb V:03C7 sNo:LEQ1517406 d:34F292 O:AB42FE t:1A2C5740 IDcnt:0018 L:6 %
2016.05.26 16:56:44.670 0: HMLAN_Parse: hmusb R:E38BA77   stat:0000 t:1A2C6011 d:FF r:FFBD     m:21 A410 38BA77 AB42FE 06010000
2016.05.26 16:56:47.384 0: HMLAN_Send:  hmusb S:SED915E6A stat:  00 t:00000000 d:01 r:ED915E6A m:20 A011 AB42FE 38BA77 0201C800000040
2016.05.26 16:56:47.606 0: HMLAN_Parse: hmusb R:RED915E6A stat:0001 t:1A2C6B79 d:FF r:FFBD     m:20 8002 38BA77 AB42FE 0101000047
2016.05.26 16:57:07.381 0: HMLAN_Send:  hmusb I:K
2016.05.26 16:57:07.460 0: HMLAN_Parse: hmusb V:03C7 sNo:LEQ1517406 d:34F292 O:AB42FE t:1A2CB8FF IDcnt:0018 L:6 %
2016.05.26 16:57:13.076 0: HMLAN_Parse: hmusb R:E43F6BF   stat:0000 t:1A2CCE0A d:FF r:FFC4     m:BB 8610 43F6BF 000000 0A90EB0F0000
2016.05.26 16:57:32 0: HMLAN_Send:  hmusb I:K
2016.05.26 16:57:32 0: HMLAN_Parse: hmusb V:03C7 sNo:LEQ1517406 d:34F292 O:AB42FE t:1A2D1A9F IDcnt:0018 L:6 %
2016.05.26 16:57:38 0: HMLAN_Parse: hmusb R:E26CCB4   stat:0000 t:1A2D3278 d:FF r:FFC8     m:19 8610 26CCB4 000000 0A88EB0B0000
2016.05.26 16:57:40 0: HMLAN_Parse: hmusb R:E26D621   stat:0000 t:1A2D3AA2 d:FF r:FFBE     m:1B 8610 26D621 000000 0A88EB0C0000


Mich wundern etwas die Einträge um 16:48...bzw. die Tatsache, daß diese Einträge für ~16:54 nicht auftauchen...paßt das so?

Beim nochmaligen Testen VOR dem Setzen der Sniffing-Attribute (hatte die Antenne des Aktors aus dem Gehäuse befreit, um die RSSI-Werte zu verbessern) hatte ich ein zweimaliges Schalten 'von selbst', also in Summe drei Schaltvorgänge: Licht aus (soll so sein) - Licht an (wegen fehlendem ACK?) - Licht aus (da scheint das ACK dann angekommen zu sein).
Endergebnis: Licht aus, paßt. )

RSSI schaut jetzt aber besser aus (sollten auch die Werte aus dem Log oben sein):

Code Auswählen Erweitern


    HM_38BA77       HM_38BA77       hmusb            -71.0  -78.4  -87.0< -69.0    29
    HM_38BA77       hmusb           HM_38BA77        -67.0  -70.6  -82.0< -63.0    75


Beinhaltet das Log das, was Du brauchst, oder hab' ich was falsch gemacht?

Danke & Gruß,
Stefan

[martinp876]

ich kann dir folgendes Sagen:
start: Licht an für 250ms => ack, alles ok
nach 200ms_ Licht an für 250ms => kein ACK - könnte einProblem des Device sind - so schnell  2-mal schalten.
nach 2400ms wiederholt FHEM das nicht erfolgreiche Kommando - jetzt klappts.
4 sec später noch einmal an für 250ms , ack alles ok.
das letzte Kommando wird noch einmal wiederholt - das scheint ein Fehle, da ein ACK gekommen ist. Ah - liegt daran, dass Licht an gefordert war aber das Licht bei der Prüfung schon wieder aus ist.
Das mus sich mir ansehen.

Warum quälst du dein Device am Anfang so?

[SVLoneStar]

Hallo Martin,
ich quäl' nix und niemanden... 
Ich habe noch zweimal gesnifft...

Das hier müsste ein Auslösen des DOIF beinhalten - wieder mit 'EIN' am Anfang, und 'AUS'-'EIN'-'AUS' am Ende:

Code Auswählen Erweitern


2016.05.26 20:46:01.059 0: HMLAN_Send:  hmusb I:K
2016.05.26 20:46:01.105 0: HMLAN_Parse: hmusb V:03C7 sNo:LEQ1517406 d:34F292 O:AB42FE t:1AFE473F IDcnt:0018 L:5 %
2016.05.26 20:46:22.066 0: HMLAN_Parse: hmusb R:E42EBDF   stat:0000 t:1AFE992E d:FF r:FFC1     m:EA 865A 42EBDF 000000 BCF131
2016.05.26 20:46:26.065 0: HMLAN_Send:  hmusb I:K
2016.05.26 20:46:26.130 0: HMLAN_Parse: hmusb V:03C7 sNo:LEQ1517406 d:34F292 O:AB42FE t:1AFEA8FF IDcnt:0018 L:5 %
2016.05.26 20:46:28.146 0: HMLAN_Parse: hmusb R:E43F6B0   stat:0000 t:1AFEB0D2 d:FF r:FFC2     m:9B 8610 43F6B0 000000 0ABCF10F0000
2016.05.26 20:46:32.081 0: HMLAN_Parse: hmusb R:E42EBDF   stat:0000 t:1AFEC040 d:FF r:FFC1     m:25 8410 42EBDF 000000 0BBCF10F00
2016.05.26 20:46:38.610 0: HMLAN_Parse: hmusb R:E26E399   stat:0000 t:1AFED9C9 d:FF r:FFC5     m:77 8610 26E399 000000 0A88F8090000
2016.05.26 20:46:42.066 0: HMLAN_Parse: hmusb R:E42EBDF   stat:0000 t:1AFEE74E d:FF r:FFC2     m:EA 8470 42EBDF 000000 00F131
2016.05.26 20:46:48.433 0: HMLAN_Send:  hmusb S:SEE63F4C4 stat:  00 t:00000000 d:01 r:EE63F4C4 m:2A A011 AB42FE 38BA77 0201C800000040
2016.05.26 20:46:48.658 0: HMLAN_Parse: hmusb R:REE63F4C4 stat:0001 t:1AFF00F8 d:FF r:FFBF     m:2A 8002 38BA77 AB42FE 0101C84047
2016.05.26 20:46:50.738 0: HMLAN_Parse: hmusb R:E38BA77   stat:0000 t:1AFF091E d:FF r:FFBC     m:2B A410 38BA77 AB42FE 06010000
2016.05.26 20:46:51.070 0: HMLAN_Send:  hmusb I:K
2016.05.26 20:46:51.122 0: HMLAN_Parse: hmusb V:03C7 sNo:LEQ1517406 d:34F292 O:AB42FE t:1AFF0A9E IDcnt:0018 L:5 %
2016.05.26 20:47:09.010 0: HMLAN_Parse: hmusb R:E26CCB4   stat:0000 t:1AFF5078 d:FF r:FFCA     m:74 8610 26CCB4 000000 0A88F60B0000
2016.05.26 20:47:16.077 0: HMLAN_Send:  hmusb I:K
2016.05.26 20:47:16.114 0: HMLAN_Parse: hmusb V:03C7 sNo:LEQ1517406 d:34F292 O:AB42FE t:1AFF6C3E IDcnt:0018 L:5 %
2016.05.26 20:47:31.057 0: HMLAN_Parse: hmusb R:E38D715   stat:0000 t:1AFFA693 d:FF r:FFC6     m:CE 845E 38D715 000000 800000000000000008D3FD
2016.05.26 20:47:36.273 0: HMLAN_Parse: hmusb R:E26D621   stat:0000 t:1AFFBAFB d:FF r:FFC8     m:76 8610 26D621 000000 0A88F50C0000
2016.05.26 20:47:41.082 0: HMLAN_Send:  hmusb I:K
2016.05.26 20:47:41.137 0: HMLAN_Parse: hmusb V:03C7 sNo:LEQ1517406 d:34F292 O:AB42FE t:1AFFCDFE IDcnt:0018 L:5 %
2016.05.26 20:47:41.777 0: HMLAN_Parse: hmusb R:E43F6BF   stat:0000 t:1AFFD07C d:FF r:FFC5     m:16 8610 43F6BF 000000 0ABCF10F0000
2016.05.26 20:47:48.634 0: HMLAN_Send:  hmusb S:SEE64DFEC stat:  00 t:00000000 d:01 r:EE64DFEC m:2C A011 AB42FE 38BA77 0201C800000040
2016.05.26 20:47:49.233 0: HMLAN_Parse: hmusb R:REE64DFEC stat:0001 t:1AFFEDA8 d:FF r:FFBC     m:2C 8002 38BA77 AB42FE 0101000048
2016.05.26 20:47:51.786 0: HMLAN_Send:  hmusb S:SEE64EC3D stat:  00 t:00000000 d:01 r:EE64EC3D m:2D A011 AB42FE 38BA77 0201C800000040
2016.05.26 20:47:51.985 0: HMLAN_Parse: hmusb R:REE64EC3D stat:0001 t:1AFFF858 d:FF r:FFBF     m:2D 8002 38BA77 AB42FE 0101C84048
2016.05.26 20:47:54.641 0: HMLAN_Parse: hmusb R:E38BA77   stat:0000 t:1B0002CE d:FF r:FFBC     m:2E A410 38BA77 AB42FE 06010000
2016.05.26 20:47:56.079 0: HMLAN_Send:  hmusb S:SEE64FD01 stat:  00 t:00000000 d:01 r:EE64FD01 m:2D A011 AB42FE 38BA77 0201C800000040
2016.05.26 20:47:56.465 0: HMLAN_Parse: hmusb R:REE64FD01 stat:0001 t:1B0009E0 d:FF r:FFBC     m:2D 8002 38BA77 AB42FE 0101000047
2016.05.26 20:48:01.059 0: HMLAN_Send:  hmusb S:SEE651075 stat:  00 t:00000000 d:01 r:EE651075 m:2E A011 AB42FE 38BA77 0201C800000040
2016.05.26 20:48:01.265 0: HMLAN_Parse: hmusb R:REE651075 stat:0001 t:1B001C98 d:FF r:FFBC     m:2E 8002 38BA77 AB42FE 0101C84047
2016.05.26 20:48:03.473 0: HMLAN_Parse: hmusb R:E38BA77   stat:0000 t:1B00253F d:FF r:FFBC     m:2F A410 38BA77 AB42FE 06010000
2016.05.26 20:48:06.087 0: HMLAN_Send:  hmusb I:K
2016.05.26 20:48:06.140 0: HMLAN_Parse: hmusb V:03C7 sNo:LEQ1517406 d:34F292 O:AB42FE t:1B002F9E IDcnt:0018 L:5 %
2016.05.26 20:48:21.752 3: ENDE2


Und das hier müsste ein manuelles on-for-timer 0.25 sein zum Einschalten, und ca. 15 Sek. später das gleiche nochmal zum Ausschalten:

Code Auswählen Erweitern


2016.05.26 20:39:46.316 3: MANUELL
2016.05.26 20:40:09.490 0: HMLAN_Parse: hmusb R:E26CCB4   stat:0000 t:1AF8E9D4 d:FF r:FFC6     m:71 8610 26CCB4 000000 0A88F70B0000
2016.05.26 20:40:10.900 0: HMLAN_Send:  hmusb I:K
2016.05.26 20:40:10.962 0: HMLAN_Parse: hmusb V:03C7 sNo:LEQ1517406 d:34F292 O:AB42FE t:1AF8EF84 IDcnt:0018 L:4 %
2016.05.26 20:40:16.274 0: HMLAN_Parse: hmusb R:E26D621   stat:0000 t:1AF9043D d:FF r:FFB7     m:73 8610 26D621 000000 0A88F60C0000
2016.05.26 20:40:27.058 0: HMLAN_Parse: hmusb R:E38D715   stat:0000 t:1AF92E57 d:FF r:FFC4     m:CB 845E 38D715 000000 800000000000000008E0FD
2016.05.26 20:40:29.731 3: CUL_HM set HM_38BA77_Sw_01 on-for-timer 0.25
2016.05.26 20:40:29.734 0: HMLAN_Send:  hmusb S:SEE5E2D78 stat:  00 t:00000000 d:01 r:EE5E2D78 m:26 A011 AB42FE 38BA77 0201C800000040
2016.05.26 20:40:29.937 0: HMLAN_Parse: hmusb R:REE5E2D78 stat:0001 t:1AF9399D d:FF r:FFBF     m:26 8002 38BA77 AB42FE 0101C84047
2016.05.26 20:40:30.690 3: FS20 set FS20_006000 off
2016.05.26 20:40:32.818 0: HMLAN_Parse: hmusb R:E38BA77   stat:0000 t:1AF944EB d:FF r:FFBC     m:27 A410 38BA77 AB42FE 06010000
2016.05.26 20:40:35.906 0: HMLAN_Send:  hmusb I:K
2016.05.26 20:40:35.954 0: HMLAN_Parse: hmusb V:03C7 sNo:LEQ1517406 d:34F292 O:AB42FE t:1AF95123 IDcnt:0018 L:4 %
2016.05.26 20:40:45.902 3: CUL_HM set HM_38BA77_Sw_01 on-for-timer 0.25
2016.05.26 20:40:45.905 0: HMLAN_Send:  hmusb S:SEE5E6CA3 stat:  00 t:00000000 d:01 r:EE5E6CA3 m:28 A011 AB42FE 38BA77 0201C800000040
2016.05.26 20:40:46.133 0: HMLAN_Parse: hmusb R:REE5E6CA3 stat:0001 t:1AF978DD d:FF r:FFBD     m:28 8002 38BA77 AB42FE 0101C84047
2016.05.26 20:40:46.760 3: FS20 set FS20_006001 off
2016.05.26 20:40:48.849 0: HMLAN_Parse: hmusb R:E38BA77   stat:0000 t:1AF98388 d:FF r:FFBC     m:29 A410 38BA77 AB42FE 06010000
2016.05.26 20:40:55.582 3: ENDE


Der FS20_006000/FS20_006001, der da auftaucht, ist ein FS20 LS, der merkt, dass es um ihn herum hell (bzw. dunkel) wird.

Der Aktor ist in einem Sicherungskasten und ergänzt eine Stromstoßschaltung.
Der DEF des DOIF dazu:

Code Auswählen Erweitern


(["FS20_ab7f00:on"] or ["FS20_e63e00:on"])
    (set MYSENSOR_10 status9 on, set HM_38BA77_Sw_01 on-for-timer 0.25, {Log 3, "--- PIRI_OG_TREPPENHAUS: Treppenhaus_EIN_DOIF ausgelöst"}, set MYSENSOR_10 status9 on, set Licht_Flur_OG_dummy on)
(set HM_38BA77_Sw_01 on-for-timer 0.25, set FS20_ab7f00 off, set FS20_e63e00 off, {Log 3, "--- PIRI_OG_TREPPENHAUS: Treppenhaus_AUS_Timer ausgelöst"}, set MYSENSOR_10 status9 on, set Licht_Flur_OG_dummy off)


Zum 'hörbaren Debuggen' schicke ich zwischendrin an ein mySensor-Device ein 'on' - das piepst dann. Hmmm, das könnte das 'Quälen' am Anfang sein...

Danke & Gruß,
Stefan

Edit: Habe das triggern des mySensor-Piepsers mal ausgebaut, keine Änderung

[martinp876]

Du Sendest im Abstand von 300ms 2 mal onfortimer. Ist das ein Bug?
Bekomme das unter Kontrolle! Ich vermute ein Problem im notify. Prüfe das.

[Puschel74]

Ich habe vor 2 Tagen einen bis dahin verbauten FS20 SU-3 gegen den HM-LC-SW2-FM getauscht...bei FS20 hat das on-for-timer 0.25`zum Ein- und Ausschalten funktioniert, Problem tritt seit Verwendung des HomeMatic-Aktor auf.

Ich würde kein on-for-timer 0.25 senden sondern ein on-for-timer 60 wenn das Licht für 60 Sekunden leuchten soll.
FS20 kann man nicht 1:1 auf HM übertragen.
Wobei ich mich frage was das mit dem on-for-timer 0.25 auf sich hat - das habe ich bei meinen FS20-Geräten nie gebraucht - on-for-timer <ZeitinSekunden> hat immer gereicht.

Aber auch hier

Situation: Ein Bewegungsmelder triggert ein notify, per DOIF wird ein 'on-for-timer 0.25' an den HM-LC-SW2-FM gesendet, Licht geht an.

Wozu notify und DOIF 
Was macht das notify was im DOIF (oder umgekehrt) nicht geht?

[SVLoneStar]

Hallo Martin, Puschel74,
sorry - Korrektur: Es gibt kein notify, nur das DOIF. Ich hatte das heute Vormittag von einem notify auf ein DOIF umgestellt.
Das oben angegebene DOIF ist alles, was ausgeführt wird. Tut mir Leid, war nicht hilfreich. 

Zum Sinn des on-for-timer 0.25: Wie oben geschrieben, sitzt der Aktor in einem Sicherungskasten und ist Teil einer Stromstoss-Schaltung. Sprich, ein kurzes Tasten läßt ein Relais im Sicherungskasten anziehen oder abfallen. Würde ich on-for-timer 60 verwenden, würde das Schalt-Relais 60 Sekunden lang anziehen (=brummen). Der HM-Aktor dient quasi als dritter Taster in einer vorhandenen Stromstoss-Schaltung mit zwei (dummen) Wand-Tastern. Und das Tasten soll eben durch ein on-for-timer 0.25 geschehen.

Nochmal sorry für meine Falschaussage mit einem notify - das gibt's nicht, nur das DOIF.
However - wenn da mehrere on-for-timer schnell hinereinander gesendet werden, muss es was mit dem DOIF bzw. den Bewegungsmeldern sein - das manuelle Senden eines on-for-timer funktioniert ja fehlerfrei.

@Martin: Ist das hier ein on-for-timer 0.25:

Code Auswählen Erweitern


2016.05.26 20:46:48.433 0: HMLAN_Send:  hmusb S:SEE63F4C4 stat:  00 t:00000000 d:01 r:EE63F4C4 m:2A A011 AB42FE 38BA77 0201C800000040

Falls ja, sehe ich den in meinem Log-Auszug insgesamt fünfmal - einmal bei 20:46:48.433, das ist das Einschalten.
Dann - nach 1 Minute 'Licht' - noch dreimal beim Ausschalten:
Bei 20:47:48.634, bei 20:47:51.786, bei 20:47:56.079 und bei 20:48:01.059
Abstände wären dann ~3 Sekunden, ~4.5 Sekunden, ~5 Sekunden.
Wo finde ich die 2 onfortimer innerhalb von 300ms?

Danke für Eure Hilfe,
Stefan

[SVLoneStar]

Nochmal Hallo,
ich habe das DOIF wie folgt abgespeckt:

Code Auswählen Erweitern


## (["FS20_ab7f00:on"] or ["FS20_e63e00:on"])
(["FS20_e63e00:on"])
    ## (set HM_38BA77_Sw_01 on-for-timer 0.25, {Log 3, "--- PIRI_OG_TREPPENHAUS: Treppenhaus_EIN_DOIF ausgelöst"}, set Licht_Flur_OG_dummy on)
(set HM_38BA77_Sw_01 on-for-timer 0.25)
## (set HM_38BA77_Sw_01 on-for-timer 0.25, set FS20_ab7f00 off, set FS20_e63e00 off, {Log 3, "--- PIRI_OG_TREPPENHAUS: Treppenhaus_AUS_Timer ausgelöst"}, set Licht_Flur_OG_dummy off)
(set HM_38BA77_Sw_01 on-for-timer 0.25)

So scheint's zu funktionieren, kein mehrfaches Schalten (bei 5 Tests, davor ging's bei jedem Test schief).
Also: Trigger nur durch einen FS20 PIRI, kein Dummy setzen, kein Log-Eintrag, kein Reset der Status der Bewegungsmelder beim Ausschalten.
Laut fhemweb kommt damit beim Aktor auch sofort nach dem onfortimer ein CMDs_done, kein NACK zu sehen.

Keine Ahnung, an welchem Kommando das mehrfach-onfortimer beim 'Ausschalten' liegt - ich werde das jetzt Kommando für Kommando wieder reinnehmen und testen...

Gruß,
Stefan

[martinp876]

Code Auswählen Erweitern

20:46:48.433 Send:   stat:  00  m:2A A011 AB42FE 38BA77 0201C800000040
20:46:48.658 Parse:  stat:0001  m:2A 8002 38BA77 AB42FE 0101C84047
20:46:50.738 Parse:  stat:0000  m:2B A410 38BA77 AB42FE 06010000
20:47:48.634 Send:   stat:  00  m:2C A011 AB42FE 38BA77 0201C800000040  << ONforTIMER
20:47:49.233 Parse:  stat:0001  m:2C 8002 38BA77 AB42FE 0101000048
20:47:51.786 Send:   stat:  00  m:2D A011 AB42FE 38BA77 0201C800000040 << ONforTIMER
20:47:51.985 Parse:  stat:0001  m:2D 8002 38BA77 AB42FE 0101C84048
20:47:54.641 Parse:  stat:0000  m:2E A410 38BA77 AB42FE 06010000
20:47:56.079 Send:   stat:  00  m:2D A011 AB42FE 38BA77 0201C800000040 << ONforTIMER
20:47:56.465 Parse:  stat:0001  m:2D 8002 38BA77 AB42FE 0101000047
20:48:01.059 Send:   stat:  00  m:2E A011 AB42FE 38BA77 0201C800000040 << ONforTIMER
20:48:01.265 Parse:  stat:0001  m:2E 8002 38BA77 AB42FE 0101C84047
20:48:03.473 Parse:  stat:0000  m:2F A410 38BA77 AB42FE 06010000

der 3. ist eine Wiederholung des 2.. Der 2. kommt SEHR schnell nach dem Ersten.

[frank]

Zum Sinn des on-for-timer 0.25: Wie oben geschrieben, sitzt der Aktor in einem Sicherungskasten und ist Teil einer Stromstoss-Schaltung. Sprich, ein kurzes Tasten läßt ein Relais im Sicherungskasten anziehen oder abfallen. Würde ich on-for-timer 60 verwenden, würde das Schalt-Relais 60 Sekunden lang anziehen (=brummen). Der HM-Aktor dient quasi als dritter Taster in einer vorhandenen Stromstoss-Schaltung mit zwei (dummen) Wand-Tastern. Und das Tasten soll eben durch ein on-for-timer 0.25 geschehen.

der sw2-fm ist doch quasi ein doppeltes stromstossrelais. warum entfernst du nicht dein bisheriges stromstossrelais und baust dafür die eine hälfte des aktors ein?