Fehlende trigger-readings und gut verstecktes powerOn-reading

frank · 07 Juli 2015, 21:49:53

hallo martin,

im januar gab es bei HM-LC-Sw1-FM und HM-LC-Dim1T-FM noch die readings "trigLast" und "trig_<device>". jetzt tut sich nichts mehr. wahrscheinlich wurden die trigger readings vom device in die channel verlegt, wie ich an einem virtuellen aktor beobachten konnte. dadurch sind dann wohl die readings bei devices ohne expliziten channel verschwunden. ähnliches las ich über aes-trigger. könntest du diese wieder reannimieren?

Code Auswählen

Internals: 
   .triggerUsed 1 
   DEF        285A54 
   IODev      hmusb1 
   LASTInputDev hmusb1 
   MSGCNT     180 
   NAME       SwitchUP01 
   NR         459 
   NTFY_ORDER 50-SwitchUP01 
   STATE      off 
   TYPE       CUL_HM 
   hmlan1_MSGCNT 77 
   hmlan1_RAWMSG E285A54,0000,08C26E24,FF,FFAE,148410285A5400000006010000 
   hmlan1_RSSI -82 
   hmlan1_TIME 2015-07-07 19:58:21 
   hmusb1_MSGCNT 103 
   hmusb1_RAWMSG E285A54,0000,00250822,FF,FFBA,148410285A5400000006010000 
   hmusb1_RSSI -70 
   hmusb1_TIME 2015-07-07 19:58:21 
   lastMsg    No:14 - t:10 s:285A54 d:000000 06010000 
   peerList   SwitchES01_SenI,self01, 
   protLastRcv 2015-07-07 19:58:21 
   protSnd    95 last_at:2015-07-07 19:40:16 
   protState  CMDs_done 
   rssi_SwitchES01 avg:-104.5 min:-105 max:-104 lst:-105 cnt:4 
   rssi_at_hmlan1 avg:-80.36 min:-87 max:-78 lst:-82 cnt:77 
   rssi_at_hmusb1 avg:-69.81 min:-71 max:-67 lst:-70 cnt:103 
   rssi_hmusb1 avg:-71 min:-71 max:-71 lst:-71 cnt:1 
   Readings: 
     2015-07-07 19:58:21   .protLastRcv    2015-07-07 19:58:21 
     2015-07-07 19:19:48   Activity        alive 
     2015-07-07 19:55:18   CommandAccepted yes 
     2014-11-02 11:11:49   D-firmware      1.12 
     2014-11-02 11:11:49   D-serialNr      LEQ0130409 
     2015-07-07 19:40:13   PairedTo        0x1ACE1F 
     2015-07-07 19:13:34   R-SwitchES01_SenI-lgActionType jmpToTarget 
     2015-07-07 19:13:34   R-SwitchES01_SenI-lgCtDlyOff geLo 
     2015-07-07 19:13:34   R-SwitchES01_SenI-lgCtDlyOn geLo 
     2015-07-07 19:13:34   R-SwitchES01_SenI-lgCtOff geLo 
     2015-07-07 19:13:34   R-SwitchES01_SenI-lgCtOn geLo 
     2015-07-07 19:13:34   R-SwitchES01_SenI-lgCtValHi 100 
     2015-07-07 19:13:34   R-SwitchES01_SenI-lgCtValLo 50 
     2015-07-07 19:13:34   R-SwitchES01_SenI-lgMultiExec on 
     2015-07-07 19:13:34   R-SwitchES01_SenI-lgOffDly 0 s 
     2015-07-07 19:13:34   R-SwitchES01_SenI-lgOffTime unused 
     2015-07-07 19:13:34   R-SwitchES01_SenI-lgOffTimeMode absolut 
     2015-07-07 19:13:34   R-SwitchES01_SenI-lgOnDly 0 s 
     2015-07-07 19:13:34   R-SwitchES01_SenI-lgOnTime unused 
     2015-07-07 19:13:34   R-SwitchES01_SenI-lgOnTimeMode absolut 
     2015-07-07 19:13:34   R-SwitchES01_SenI-lgSwJtDlyOff off 
     2015-07-07 19:13:34   R-SwitchES01_SenI-lgSwJtDlyOn on 
     2015-07-07 19:13:34   R-SwitchES01_SenI-lgSwJtOff dlyOn 
     2015-07-07 19:13:34   R-SwitchES01_SenI-lgSwJtOn dlyOff 
     2015-07-07 19:13:34   R-SwitchES01_SenI-shActionType jmpToTarget 
     2015-07-07 19:13:34   R-SwitchES01_SenI-shCtDlyOff geLo 
     2015-07-07 19:13:34   R-SwitchES01_SenI-shCtDlyOn geLo 
     2015-07-07 19:13:34   R-SwitchES01_SenI-shCtOff geLo 
     2015-07-07 19:13:34   R-SwitchES01_SenI-shCtOn geLo 
     2015-07-07 19:13:34   R-SwitchES01_SenI-shCtValHi 100 
     2015-07-07 19:13:34   R-SwitchES01_SenI-shCtValLo 50 
     2015-07-07 19:40:15   R-SwitchES01_SenI-shOffDly 180 s 
     2015-07-07 19:13:34   R-SwitchES01_SenI-shOffTime unused 
     2015-07-07 19:13:34   R-SwitchES01_SenI-shOffTimeMode absolut 
     2015-07-07 19:13:34   R-SwitchES01_SenI-shOnDly 0 s 
     2015-07-07 19:13:34   R-SwitchES01_SenI-shOnTime unused 
     2015-07-07 19:13:34   R-SwitchES01_SenI-shOnTimeMode absolut 
     2015-07-07 19:33:39   R-SwitchES01_SenI-shSwJtDlyOff dlyOff 
     2015-07-07 19:33:39   R-SwitchES01_SenI-shSwJtDlyOn on 
     2015-07-07 19:32:53   R-SwitchES01_SenI-shSwJtOff dlyOff 
     2015-07-07 19:32:53   R-SwitchES01_SenI-shSwJtOn dlyOff 
     2014-12-23 15:47:12   R-intKeyVisib   visib 
     2014-12-23 15:47:12   R-pairCentral   0x1ACE1F 
     2014-12-23 15:47:20   R-self01-lgActionType jmpToTarget 
     2014-12-23 15:47:20   R-self01-lgCtDlyOff geLo 
     2014-12-23 15:47:20   R-self01-lgCtDlyOn geLo 
     2014-12-23 15:47:20   R-self01-lgCtOff geLo 
     2014-12-23 15:47:20   R-self01-lgCtOn geLo 
     2014-12-23 15:47:20   R-self01-lgCtValHi 100 
     2014-12-23 15:47:20   R-self01-lgCtValLo 50 
     2014-12-23 15:47:20   R-self01-lgMultiExec on 
     2014-11-02 20:52:50   R-self01-lgOffDly 0 s 
     2014-11-02 20:52:50   R-self01-lgOffTime unused 
     2014-12-23 15:47:20   R-self01-lgOffTimeMode absolut 
     2014-11-02 20:52:50   R-self01-lgOnDly 0 s 
     2014-11-02 20:52:50   R-self01-lgOnTime 300 s 
     2014-12-23 15:47:20   R-self01-lgOnTimeMode absolut 
     2014-12-23 15:47:20   R-self01-lgSwJtDlyOff off 
     2014-12-23 15:47:20   R-self01-lgSwJtDlyOn on 
     2014-12-23 15:47:20   R-self01-lgSwJtOff dlyOn 
     2014-12-23 15:47:20   R-self01-lgSwJtOn dlyOff 
     2014-12-23 15:47:20   R-self01-shActionType jmpToTarget 
     2014-12-23 15:47:20   R-self01-shCtDlyOff geLo 
     2014-12-23 15:47:20   R-self01-shCtDlyOn geLo 
     2014-12-23 15:47:20   R-self01-shCtOff geLo 
     2014-12-23 15:47:20   R-self01-shCtOn geLo 
     2014-12-23 15:47:20   R-self01-shCtValHi 100 
     2014-12-23 15:47:20   R-self01-shCtValLo 50 
     2014-11-02 20:52:50   R-self01-shOffDly 0 s 
     2014-11-02 20:52:50   R-self01-shOffTime unused 
     2014-12-23 15:47:20   R-self01-shOffTimeMode absolut 
     2014-11-02 20:52:50   R-self01-shOnDly 0 s 
     2014-11-02 20:52:50   R-self01-shOnTime 300 s 
     2014-12-23 15:47:20   R-self01-shOnTimeMode absolut 
     2014-12-23 15:47:20   R-self01-shSwJtDlyOff off 
     2014-12-23 15:47:20   R-self01-shSwJtDlyOn on 
     2014-12-23 15:47:20   R-self01-shSwJtOff dlyOn 
     2014-12-23 15:47:20   R-self01-shSwJtOn dlyOff 
     2014-12-23 15:47:12   R-sign          off 
     2015-07-07 19:40:12   RegL_00:         02:81 03:00 04:00 05:00 06:00 07:00 08:00 09:00 0A:1A 0B:CE 0C:1F 00:00 
     2015-07-07 19:40:13   RegL_01:         08:00 00:00 
     2015-07-07 19:40:15   RegL_03:SwitchES01_SenI  02:00 03:00 04:32 05:64 06:00 07:FF 08:72 09:FF 0A:01 0B:44 0C:43 82:00 83:00 84:32 85:64 86:00 87:FF 88:00 89:FF 8A:21 8B:14 8C:63 00:00 
     2015-07-07 19:40:16   RegL_03:self01   02:00 03:00 04:32 05:64 06:00 07:7E 08:00 09:FF 0A:01 0B:14 0C:63 82:00 83:00 84:32 85:64 86:00 87:7E 88:00 89:FF 8A:21 8B:14 8C:63 00:00 
     2015-07-07 19:58:21   deviceMsg       off (to broadcast) 
     2015-07-07 19:58:21   level           0 
     2015-06-17 23:54:45   levelMissed     desired:0 
     2015-07-07 19:58:21   pct             0 
     2015-07-07 19:40:14   peerList        SwitchES01_SenI,self01, 
     2015-07-07 19:58:21   recentStateType info 
     2015-06-08 13:59:21   sabotageAttack  ErrIoAttack cnt:1 
     2015-07-07 19:58:21   state           off 
     2015-07-07 19:58:21   timedOn         off 
     2015-01-11 03:05:11   trigLast        SwitchES01_SenI :0 
     2015-01-11 03:05:11   trig_SwitchES01_SenI 0 
   Helper: 
     HM_CMDNR   20 
     cSnd       011ACE1F285A54010424AF1D0403,011ACE1F285A540104285A540103 
     mId        0004 
     peerIDsRaw ,285A5401,24AF1D04,00000000 
     rxType     1 
     Bm: 
       Cul_hm_get: 
         cnt        8 
         dmx        0 
         max        2 
         tot        9 
         mAr: 
           HASH(0x1608cd0) 
           SwitchUP01 
           ? 
       Cul_hm_set: 
         cnt        40 
         dmx        0 
         max        239 
         tot        1116 
         mAr: 
           HASH(0x1608cd0) 
           SwitchUP01 
           regSet 
           shSwJtOff 
           dlyOff 
           SwitchES01_SenI 
     Io: 
       newChn     +285A54,00,00,00 
       nextSend   1436291901.74507 
       rxt        0 
       vccu       ccu 
       p: 
         285A54 
         00 
         00 
         00 
       prefIO: 
         hmusb1 
     Mrssi: 
       mNo        14 
       Io: 
         hmlan1     -82 
         hmusb1     -68 
     Prt: 
       bErr       0 
       sProc      0 
       Rspwait: 
     Q: 
       qReqConf 
       qReqStat 
     Role: 
       chn        1 
       dev        1 
       prs        1 
     Rssi: 
       Switches01: 
         avg        -104.5 
         cnt        4 
         lst        -105 
         max        -104 
         min        -105 
       At_hmlan1: 
         avg        -80.3636363636364 
         cnt        77 
         lst        -82 
         max        -78 
         min        -87 
       At_hmusb1: 
         avg        -69.8155339805825 
         cnt        103 
         lst        -70 
         max        -67 
         min        -71 
       Hmusb1: 
         avg        -71 
         cnt        1 
         lst        -71 
         max        -71 
         min        -71 
     Shadowreg: 
Attributes: 
   IODev      hmusb1 
   IOgrp      ccu:hmusb1 
   actCycle   024:00 
   actStatus  alive 
   autoReadReg 5_readMissing 
   event-on-change-reading .* 
   expert     2_full 
   firmware   1.12 
   group      Beleuchtung 
   model      HM-LC-SW1-FM 
   peerIDs    00000000,24AF1D04,285A5401, 
   room       65_Flur.OG 
   serialNr   LEQ0130409 
   subType    switch 
   webCmd     statusRequest:toggle:on:off

2. desweiteren ist mir dann aufgefallen, dass es bei push buttons ebenfalls trigger readings gibt (trigger, trigger_cnt). wäre es möglich diese auch für die sensor-channel des HM-ES-PMSw1-Pl zu integrieren?

3. nebenbei fand ich dann noch ein powerOn reading eines HM-LC-Dim1TPBU-FM im chn03 (Sw_V02). wäre das nicht besser im device aufgehoben?

gruss frank

martinp876 · 08 Juli 2015, 20:50:07

alles drin... fast. trigger_cnt sollte drin sein. Kannst du ein List des Device und die message schicken? Beachte dass auch ein Trigger kommen muss, nicht nur ein Event.

frank · 08 Juli 2015, 23:50:16

prima, alles drin, danke.

bis auf den "trigger" im sensor channel. ich meine "C8->200", wie in den readings im gepeerten aktor.

Code Auswählen

     2015-07-08 22:32:14   trigLast        SwitchES01_SenI:200 
     2015-07-08 22:32:14   trig_SwitchES01_SenI 200

da man hier 2 frei einstellbare "trigger/events" (0-255) auslösen lassen kann, wäre es schön zu sehen, wann welcher "trigger/event" kommt. aber ich vermute mal, dass du als trigger ein zusätzliches short/long meinst.

Code Auswählen

2015.07.07 19:55:17.897 0: HMLAN_Parse: hmlan1 R:E24AF1D   stat:0000 t:08BFA11F d:FF r:FFA5     m:13 A441 24AF1D 285A54 0405C8
2015.07.07 19:55:18.026 0: HMLAN_Parse: hmlan1 R:E285A54   stat:0000 t:08BFA19E d:FF r:FFAE     m:13 8002 285A54 24AF1D 0101C84069

Code Auswählen

Internals: 
   DEF        24AF1D 
   IODev      hmlan1 
   LASTInputDev hmlan1 
   MSGCNT     62 
   NAME       SwitchES01 
   NR         408 
   NTFY_ORDER 50-SwitchES01 
   STATE      CMDs_done 
   TYPE       CUL_HM 
   channel_01 SwitchES01_Sw 
   channel_02 SwitchES01_Pwr 
   channel_03 SwitchES01_SenPwr 
   channel_04 SwitchES01_SenI 
   channel_05 SwitchES01_SenU 
   channel_06 SwitchES01_SenF 
   hmlan1_MSGCNT 62 
   hmlan1_RAWMSG E24AF1D,0000,0267D3D0,FF,FFAB,3AA45F24AF1D1ACE1F80036200000000000942FE 
   hmlan1_RSSI -85 
   hmlan1_TIME 2015-07-08 22:33:07 
   lastMsg    No:18 - t:5E s:24AF1D d:000000 8003620000000000093AFF 
   protLastRcv 2015-07-08 23:08:10 
   protSnd    52 last_at:2015-07-08 22:33:07 
   protState  CMDs_done 
   rssi_at_hmlan1 avg:-85.65 min:-93 max:-83 lst:-87 cnt:79 
   rssi_hmlan1 avg:-83.5 min:-85 max:-82 lst:-85 cnt:2 
   Readings: 
     2015-07-07 22:05:13   .D-devInfo      3FFFFF 
     2015-07-07 22:05:13   .D-stc          51 
     2015-07-08 23:08:10   .protLastRcv    2015-07-08 23:08:10 
     2015-07-08 22:41:12   Activity        alive 
     2015-07-07 22:05:12   CommandAccepted yes 
     2015-07-07 22:05:13   D-firmware      2.5 
     2015-07-07 22:05:13   D-serialNr      KEQ0967103 
     2015-07-07 19:30:03   PairedTo        0x1ACE1F 
     2015-06-01 11:08:40   R-intKeyVisib   visib 
     2015-06-01 11:08:40   R-localResDis   off 
     2015-06-01 11:08:40   R-pairCentral   0x1ACE1F 
     2015-07-07 19:30:03   RegL_00:        02:81 0A:1A 0B:CE 0C:1F 15:FF 18:00 00:00 
     2015-07-08 11:25:11   powerOn         2015-07-08 11:25:11 
     2015-06-09 06:15:05   sabotageAttack  ErrIoAttack cnt:22 
     2015-07-08 22:33:07   state           CMDs_done 
   Helper: 
     HM_CMDNR   24 
     cSnd       011ACE1F24AF1D010E,111ACE1F24AF1D0201000000 
     mId        00AC 
     rxType     1 
     Bm: 
       Cul_hm_get: 
         cnt        1 
         dmx        0 
         max        1 
         tot        1 
         mAr: 
           HASH(0x1587760) 
           SwitchES01 
           ? 
       Cul_hm_set: 
         cnt        6 
         dmx        0 
         max        5 
         tot        22 
         mAr: 
           HASH(0x1587760) 
           SwitchES01 
           ? 
     Io: 
       newChn     +24AF1D,00,00,00 
       nextSend   1436389690.90724 
       rxt        0 
       vccu       ccu 
       p: 
         24AF1D 
         00 
         00 
         00 
     Mrssi: 
       mNo        18 
       Io: 
         hmlan1     -85 
     Prt: 
       bErr       0 
       sProc      0 
       Rspwait: 
     Q: 
       qReqConf 
       qReqStat   02,03,04,05,06 
     Role: 
       dev        1 
     Rssi: 
       At_hmlan1: 
         avg        -85.6582278481012 
         cnt        79 
         lst        -87 
         max        -83 
         min        -93 
       Hmlan1: 
         avg        -83.5 
         cnt        2 
         lst        -85 
         max        -82 
         min        -85 
Attributes: 
   IODev      hmlan1 
   IOgrp      ccu 
   actCycle   000:10 
   actStatus  alive 
   autoReadReg 5_readMissing 
   event-on-change-reading .* 
   expert     2_full 
   firmware   2.5 
   group      Messstecker 
   model      HM-ES-PMSw1-Pl 
   room       901_Messtechnik 
   serialNr   KEQ0967103 
   subType    powerMeter 
   webCmd     getConfig:clear msgEvents

noch mal eine frage zu den powerOn im dimmer. wie werden die genau erzeugt? unterscheiden sich HM-LC-Dim1T-FM und HM-LC-Dim1TPBU-FM in der "generierung"? ich wollte damit versuchen netzausfälle zu detektieren, aber irgendwie haben nicht immer alle powerOn die gleiche zeit (zumindestens ungefähr). manche scheinen bestimmte ausfälle nicht zu bemerken. vielleicht hängen die nicht alle an der selben phase, mal schauen. wenn, dann sind doch wahrscheinlich alle phasen weg, oder? oder bekommt fhem, das ebenfalls abschmiert, manchmal bei restart vom dimmer keine meldung, da der ja bestimmt früher wieder on ist.

gruss frank

martinp876 · 09 Juli 2015, 22:05:15

Logge einmal wenn du die sicherung einschaltest. Und schicke ein get hm param -d DEF model

frank · 10 Juli 2015, 18:49:40

ein manuelles ausschalten der sicherungen hat nun natürlich bei meinen 3 poweron kanditaten, die am 230 volt netz hängen, gut funktioniert. alle 3 etwa zur gleichen zeit. von HM-LC-Dim1TPBU-FM und HM-ES-PMSw1-Pl habe ich auch die eventlogs angefügt. ist das eigentlich so gewollt, dass poweron immer mehrfach ausgelöst wird? aus älteren aufzeichnungen ist zu erkennen, dass es zwischen 1-4 mal ausgelöst wird. in der regel 3 fach.

Code Auswählen

param done: 
 param list 
    entity              	: DEF                  	|model                	|powerOn              	| 
    DimPBU01            	: 266A86         	|HM-LC-Dim1TPBU-FM	|2015-07-10 10:54:21 
    DimUP01             	: 1F64D8         	|HM-LC-DIM1T-FM 	|2015-07-10 10:54:19 
    Fenster.Bad         	: 1C1BE3         	|HM-SEC-RHS     	| - 
    SD.AZ               	: 52C4DF         	|HM-SEC-SD      	| - 
    SD.SZ               	: 52BB90         	|HM-SEC-SD      	| - 
    SD.WZ               	: 52BB9D         	|HM-SEC-SD      	| - 
    SDTeam              	: AAAAAA         	|virtual_1      	| - 
    SwitchES01          	: 24AF1D         	|HM-ES-PMSw1-Pl 	|2015-07-10 10:56:08 
    SwitchPBU01         	: 266EA5         	|HM-LC-Sw1PBU-FM-CustomFW	| - 
    SwitchPBU02         	: 266E75         	|HM-LC-Sw1PBU-FM-CustomFW	| - 
    SwitchUP01          	: 285A54         	|HM-LC-SW1-FM   	| - 
    SwitchUP02          	: 285A44         	|HM-LC-SW1-FM   	| - 
    Thermostat.AZ       	: 206278         	|HM-CC-TC       	|2015-07-06 08:19:33 
    Thermostat.Bad      	: 1936FF         	|HM-CC-TC       	| - 
    Thermostat.Bad.OG   	: 206487         	|HM-CC-TC       	| - 
    Thermostat.GZ       	: 2064CB         	|HM-CC-TC       	| - 
    Thermostat.Keller   	: 206219         	|HM-CC-TC       	| - 
    Thermostat.Kueche   	: 1D252E         	|HM-CC-TC       	|2015-01-12 14:04:14 
    Thermostat.OZ       	: 20DFE1         	|HM-CC-TC       	| - 
    Thermostat.SZ       	: 1DFDA5         	|HM-CC-TC       	|2015-01-02 19:55:01 
    Thermostat.WZ       	: 1BF81B         	|HM-CC-TC       	|2015-07-06 10:50:47 
    Tuer.SZ             	: 1DE620         	|HM-SEC-SC      	| - 
    Tuer.WZ.Terrasse    	: 1DF7C6         	|HM-SEC-SC      	| - 
    Ventil.AZ.Nord      	: 1C4E25         	|HM-CC-VD       	|2015-06-28 19:03:42 
    Ventil.Bad          	: 193A9A         	|HM-CC-VD       	|2015-06-28 17:37:14 
    Ventil.Kueche       	: 1BFC52         	|HM-CC-VD       	|2015-06-28 18:01:42 
    Ventil.Reserve      	: 1F91AA         	|HM-CC-VD       	|2015-06-28 19:06:11 
    Ventil.SZ           	: 1DFC2F         	|HM-CC-VD       	|2015-06-27 22:02:17 
    Ventil.WZ           	: 1CE9F5         	|HM-CC-VD       	|2015-06-28 17:10:32 
    VentilControler.AZ.Nord	: B5B5B5         	|virtual_1      	| - 
    VentilControler.Bad 	: B3B3B3         	|virtual_1      	| - 
    VentilControler.Kueche	: B1B1B1         	|virtual_1      	| - 
    VentilControler.SZ  	: B2B2B2         	|virtual_1      	| - 
    VentilControler.WZ  	: B4B4B4         	|virtual_1      	| - 
    Wetter.Nord         	: 83765A         	|HB-UW-Sen-THPL-I	| - 
    Wetter.Sued         	: 6869B6         	|HB-UW-Sen-THPL-I	| - 
    ccu                 	: 1ACE1F         	|CCU-FHEM       	| - 
    virtAktorAlarmOff   	: AA00AA         	|virtual_1      	| - 

##################################### eventlog ###############################################

2015-07-10_10:54:19 DimPBU01 powerOn: 2015-07-10 10:54:19
2015-07-10_10:54:20 DimPBU01 chn:???  phys:0
2015-07-10_10:54:20 DimPBU01 powerOn: 2015-07-10 10:54:20
2015-07-10_10:54:21 DimPBU01 chn:???  phys:0
2015-07-10_10:54:21 DimPBU01 powerOn: 2015-07-10 10:54:21

2015-07-10_10:54:21 SwitchES01 powerOn: 2015-07-10 10:54:21
2015-07-10_10:54:21 SwitchES01_Pwr eState: E: 0 P: 0 I: 0 U: 238.7 f: 49.98
2015-07-10_10:54:21 SwitchES01_Pwr frequency: 49.98
2015-07-10_10:54:21 SwitchES01_Pwr voltage: 238.7
2015-07-10_10:54:21 SwitchES01_SenF 49.98
2015-07-10_10:54:22 SwitchES01_SenU 238.7
2015-07-10_10:54:27 SwitchES01 powerOn: 2015-07-10 10:54:27
2015-07-10_10:54:27 SwitchES01_Pwr eState: E: 0 P: 0 I: 0 U: 237.1 f: 50.01
2015-07-10_10:54:27 SwitchES01_Pwr frequency: 50.01
2015-07-10_10:54:27 SwitchES01_Pwr voltage: 237.1
2015-07-10_10:54:28 SwitchES01_SenF 50.01
2015-07-10_10:54:28 SwitchES01_SenU 237.1
2015-07-10_10:56:08 SwitchES01 powerOn: 2015-07-10 10:56:08
	
##################################### fhemlog ###############################################

2015.07.10 10:53:21.223 1: Including fhem.cfg
2015.07.10 10:53:26.152 1: HMLAN_Parse: hmusb1 new condition disconnected
2015.07.10 10:53:26.254 1: HMLAN_Parse: hmusb1 new condition init
2015.07.10 10:53:26.288 1: HMLAN_Parse: hmlan1 new condition disconnected
2015.07.10 10:53:26.311 1: HMLAN_Parse: hmlan1 new condition init
2015.07.10 10:53:49.971 0: HourCounter Pumpe.Garten.Brunnen.Cnt Define.228 parameters: Pumpe.Garten.Brunnen.Cnt HourCounter SwitchES01_Pwr:current:\s[0-9]{4,}$ SwitchES01_Pwr:current:\s[0-9]{1,2}$
2015.07.10 10:53:50.499 0: HourCounter hc_system_attak Define.228 parameters: hc_system_attak HourCounter ccu:system_attack:.on ccu:system_attack:.off
2015.07.10 10:53:50.675 1: Including ./log/fhem.save
2015.07.10 10:54:00.100 1: PERL WARNING: Use of uninitialized value $n in hash element at fhem.pl line 3454.
2015.07.10 10:54:00.146 1: PERL WARNING: Use of uninitialized value $n in hash element at fhem.pl line 3454.
2015.07.10 10:54:00.191 1: PERL WARNING: Use of uninitialized value $n in hash element at fhem.pl line 3454.
2015.07.10 10:54:00.234 1: PERL WARNING: Use of uninitialized value $n in hash element at fhem.pl line 3454.
2015.07.10 10:54:00.275 1: PERL WARNING: Use of uninitialized value $n in hash element at fhem.pl line 3454.
2015.07.10 10:54:07.552 1: HCS BROETJE monitoring of devices started
2015.07.10 10:54:11.082 1: PERL WARNING: Subroutine HandleTimeout redefined at ./FHEM/98_apptime.pm line 24.
2015.07.10 10:54:11.089 1: PERL WARNING: Subroutine CallFn redefined at ./FHEM/98_apptime.pm line 58.
2015.07.10 10:54:14.859 0: Server started with 320 defined entities (version $Id: fhem.pl 8574 2015-05-14 07:59:32Z rudolfkoenig $, os linux, user root, pid 1837)
2015.07.10 10:54:14.866 1: Perfmon: possible freeze starting at 01:01:27, delay is 1436518367.865
2015.07.10 10:54:18.162 0: HMLAN_Send:  hmusb1 I:K
2015.07.10 10:54:18.171 0: HMLAN_Send:  hmlan1 I:K
2015.07.10 10:54:18.341 0: HourCounter Pumpe.Garten.Brunnen.Cnt Run.598 first run done countsOverall:153
2015.07.10 10:54:18.483 0: HourCounter hc_system_attak Run.598 first run done countsOverall:23
2015.07.10 10:54:18.988 0: HMLAN_Send:  hmusb1 I:+266A86,00,00,00
2015.07.10 10:54:18.995 0: HMLAN_Send:  hmusb1 I:+1F64D8,00,00,00
2015.07.10 10:54:19.000 0: HMLAN_Send:  hmlan1 I:+1C1BE3,00,00,00
2015.07.10 10:54:19.005 0: HMLAN_Send:  hmusb1 I:+52C4DF,00,00,00
2015.07.10 10:54:19.010 0: HMLAN_Send:  hmusb1 I:+52BB90,00,00,00
2015.07.10 10:54:19.014 0: HMLAN_Send:  hmusb1 I:+52BB9D,00,00,00
2015.07.10 10:54:19.019 0: HMLAN_Send:  hmlan1 I:+24AF1D,00,00,00
2015.07.10 10:54:19.027 0: HMLAN_Send:  hmusb1 I:+266EA5,00,00,00
2015.07.10 10:54:19.036 0: HMLAN_Send:  hmusb1 I:+266E75,00,00,00
2015.07.10 10:54:19.046 0: HMLAN_Send:  hmusb1 I:+285A54,00,00,00
2015.07.10 10:54:19.050 0: HMLAN_Send:  hmlan1 I:+285A44,00,00,00
2015.07.10 10:54:19.055 0: HMLAN_Send:  hmusb1 I:+206278,00,00,00
2015.07.10 10:54:19.060 0: HMLAN_Send:  hmusb1 I:+1936FF,00,00,00
2015.07.10 10:54:19.067 0: HMLAN_Send:  hmusb1 I:+206487,00,00,00
2015.07.10 10:54:19.072 0: HMLAN_Send:  hmusb1 I:+2064CB,00,00,00
2015.07.10 10:54:19.077 0: HMLAN_Send:  hmusb1 I:+206219,00,00,00
2015.07.10 10:54:19.082 0: HMLAN_Send:  hmusb1 I:+1D252E,00,00,00
2015.07.10 10:54:19.087 0: HMLAN_Send:  hmusb1 I:+20DFE1,00,00,00
2015.07.10 10:54:19.092 0: HMLAN_Send:  hmusb1 I:+1DFDA5,00,00,00
2015.07.10 10:54:19.098 0: HMLAN_Send:  hmusb1 I:+1BF81B,00,00,00
2015.07.10 10:54:19.102 0: HMLAN_Send:  hmusb1 I:+1DE620,00,00,00
2015.07.10 10:54:19.107 0: HMLAN_Send:  hmusb1 I:+1DF7C6,00,00,00
2015.07.10 10:54:19.111 0: HMLAN_Send:  hmlan1 I:+1C4E25,00,00,00
2015.07.10 10:54:19.116 0: HMLAN_Send:  hmlan1 I:+193A9A,00,00,00
2015.07.10 10:54:19.121 0: HMLAN_Send:  hmlan1 I:+1BFC52,00,00,00
2015.07.10 10:54:19.126 0: HMLAN_Send:  hmlan1 I:+1F91AA,00,00,00
2015.07.10 10:54:19.132 0: HMLAN_Send:  hmlan1 I:+1DFC2F,00,00,00
2015.07.10 10:54:19.137 0: HMLAN_Send:  hmlan1 I:+1CE9F5,00,00,00
2015.07.10 10:54:19.142 0: HMLAN_Send:  hmusb1 I:+83765A,00,00,00
2015.07.10 10:54:19.148 0: HMLAN_Send:  hmusb1 I:+6869B6,00,00,00
2015.07.10 10:54:19.174 0: HMLAN_Parse: hmlan1 V:03C4 sNo:JEQ0315335 d:1C671E O:1ACE1F t:0001A205 IDcnt:0000 L:0 %
2015.07.10 10:54:19.301 0: HMLAN_Parse: hmlan1 R:E266A86   stat:0000 t:0000122C d:FF r:FFC5     m:02 A410 266A86 1ACE1F 060300008000
2015.07.10 10:54:19.484 0: HMLAN_Send:  hmusb1 S:+266A86,00,00,00
2015.07.10 10:54:19.485 0: HMLAN_Send:  hmusb1 S:S772C29A8 stat:  00 t:00000000 d:01 r:772C29A8 m:02 8002 1ACE1F 266A86 00
2015.07.10 10:54:19.635 0: HMLAN_Parse: hmlan1 R:E2064CB   stat:0000 t:000015D8 d:FF r:FFBB     m:9B 8670 2064CB 000000 00B03C
2015.07.10 10:54:19.654 0: HMLAN_Send:  hmusb1 I:+2064CB,02,00,00
2015.07.10 10:54:19.691 0: HMLAN_Parse: hmlan1 R:E1F64D8   stat:0000 t:000018AE d:FF r:FFBD     m:00 A410 1F64D8 1ACE1F 06010000
2015.07.10 10:54:19.704 1: PERL WARNING: Use of uninitialized value in numeric lt (<) at ./FHEM/10_CUL_HM.pm line 2953.
2015.07.10 10:54:19.794 0: HMLAN_Send:  hmusb1 S:+1F64D8,00,00,00
2015.07.10 10:54:19.796 0: HMLAN_Send:  hmusb1 S:S772C2A9B stat:  00 t:00000000 d:01 r:772C2A9B m:00 8002 1ACE1F 1F64D8 00
2015.07.10 10:54:20.063 0: HMLAN_Parse: hmlan1 R:E266A86   stat:0000 t:000027C2 d:FF r:FFC5     m:02 A410 266A86 1ACE1F 060100008000
2015.07.10 10:54:20.167 0: HMLAN_Send:  hmusb1 S:S772C2C02 stat:  00 t:00000000 d:01 r:772C2C02 m:02 8002 1ACE1F 266A86 00
2015.07.10 10:54:20.320 0: HMLAN_Parse: hmlan1 R:E266A86   stat:0000 t:000029B6 d:FF r:FFC5     m:02 A410 266A86 1ACE1F 060200008000
2015.07.10 10:54:20.423 0: HMLAN_Send:  hmusb1 S:S772C2D04 stat:  00 t:00000000 d:01 r:772C2D04 m:02 8002 1ACE1F 266A86 00
2015.07.10 10:54:20.452 0: HMLAN_Parse: hmlan1 R:E266A86   stat:0000 t:00002D9D d:FF r:FFC5     m:02 A410 266A86 1ACE1F 060300008000
2015.07.10 10:54:20.556 0: HMLAN_Send:  hmusb1 S:S772C2D86 stat:  00 t:00000000 d:01 r:772C2D86 m:02 8002 1ACE1F 266A86 00
2015.07.10 10:54:20.699 0: HMLAN_Parse: hmlan1 R:E1F64D8   stat:0000 t:00002F05 d:FF r:FFBC     m:00 A410 1F64D8 1ACE1F 06010000
2015.07.10 10:54:20.802 0: HMLAN_Send:  hmusb1 S:S772C2E75 stat:  00 t:00000000 d:01 r:772C2E75 m:00 8002 1ACE1F 1F64D8 00
2015.07.10 10:54:20.810 0: HMLAN_Parse: hmlan1 R:E24AF1D   stat:0000 t:0000306B d:FF r:FFCC     m:01 A410 24AF1D 1ACE1F 06010000
2015.07.10 10:54:20.847 0: HMLAN_Parse: hmlan1 R:E266EA5   stat:0000 t:00004340 d:FF r:FFCA     m:02 805E 266EA5 1ACE1F 0000000000000004000000
2015.07.10 10:54:20.976 0: HMLAN_Parse: hmlan1 R:E266A86   stat:0000 t:000050C1 d:FF r:FFC5     m:02 A410 266A86 1ACE1F 060100008000
2015.07.10 10:54:21.079 0: HMLAN_Send:  hmusb1 S:S772C2F92 stat:  00 t:00000000 d:01 r:772C2F92 m:02 8002 1ACE1F 266A86 00
2015.07.10 10:54:21.223 0: HMLAN_Parse: hmlan1 R:E266A86   stat:0000 t:00005206 d:FF r:FFC5     m:02 A410 266A86 1ACE1F 060200008000
2015.07.10 10:54:21.326 0: HMLAN_Send:  hmusb1 S:S772C3088 stat:  00 t:00000000 d:01 r:772C3088 m:02 8002 1ACE1F 266A86 00
2015.07.10 10:54:21.352 0: HMLAN_Parse: hmlan1 R:E1F64D8   stat:0000 t:00005407 d:FF r:FFBA     m:00 A410 1F64D8 1ACE1F 06010000
2015.07.10 10:54:21.455 0: HMLAN_Send:  hmusb1 S:S772C3101 stat:  00 t:00000000 d:01 r:772C3101 m:00 8002 1ACE1F 1F64D8 00
2015.07.10 10:54:21.458 0: HMLAN_Send:  hmusb1 I:K
2015.07.10 10:54:21.468 0: HMLAN_Parse: hmlan1 R:E266A86   stat:0000 t:0000563D d:FF r:FFC5     m:02 A410 266A86 1ACE1F 060300008000
2015.07.10 10:54:21.571 0: HMLAN_Send:  hmusb1 S:S772C317D stat:  00 t:00000000 d:01 r:772C317D m:02 8002 1ACE1F 266A86 00
2015.07.10 10:54:21.710 0: HMLAN_Parse: hmlan1 R:E24AF1D   stat:0000 t:00005F66 d:FF r:FFCC     m:02 A45F 24AF1D 1ACE1F 80000000000000000953FE
2015.07.10 10:54:22.205 0: HMLAN_Parse: hmlan1 R:E24AF1D   stat:0000 t:0000624B d:FF r:FFCC     m:02 A45F 24AF1D 1ACE1F 80000000000000000953FE
2015.07.10 10:54:22.225 0: HMLAN_Parse: hmlan1 R:E24AF1D   stat:0000 t:00006827 d:FF r:FFCC     m:02 A45F 24AF1D 1ACE1F 80000000000000000953FE
2015.07.10 10:54:22.238 0: HMLAN_Parse: hmlan1 R:E24AF1D   stat:0000 t:000072DB d:FF r:FFCA     m:02 A45F 24AF1D 1ACE1F 80000000000000000953FE
2015.07.10 10:54:22.251 0: HMLAN_Parse: hmlan1 R:E206219   stat:0000 t:00007C9E d:FF r:FFAF     m:CC 8670 206219 000000 009D50
2015.07.10 10:54:22.268 0: HMLAN_Send:  hmusb1 I:+206219,02,00,00
2015.07.10 10:54:22.580 0: HMLAN_Parse: hmlan1 R:E24AF1D   stat:0000 t:00008664 d:FF r:FFCB     m:02 A45F 24AF1D 1ACE1F 80000000000000000953FE
2015.07.10 10:54:22.601 0: HMLAN_Parse: hmlan1 R:E1BF81B   stat:0000 t:000086FF d:FF r:FFD3     m:E6 8670 1BF81B 000000 00AF3E
2015.07.10 10:54:22.617 0: HMLAN_Send:  hmusb1 I:+1BF81B,02,00,00
2015.07.10 10:54:22.653 0: HMLAN_Parse: hmlan1 R:E266EA5   stat:0000 t:00008CFB d:FF r:FFCC     m:03 805E 266EA5 1ACE1F 0000000000000001000000
2015.07.10 10:54:22.778 0: HMLAN_Parse: hmlan1 R:E24AF1D   stat:0000 t:0000A6A9 d:FF r:FFCC     m:02 A45F 24AF1D 1ACE1F 80000000000000000953FE
2015.07.10 10:54:22.793 0: HMLAN_Parse: hmlan1 R:E266EA5   stat:0000 t:0000D6B4 d:FF r:FFC9     m:04 805E 266EA5 1ACE1F 0000000000000001000000
2015.07.10 10:54:22.919 0: HMLAN_Parse: hmlan1 R:E83765A   stat:0000 t:0000DE7E d:FF r:FFB0     m:1A A270 83765A 1ACE1F 00903E27D2000056A407D0
2015.07.10 10:54:23.022 0: HMLAN_Send:  hmusb1 S:+83765A,00,00,00
2015.07.10 10:54:23.024 0: HMLAN_Send:  hmusb1 S:S772C3725 stat:  00 t:00000000 d:01 r:772C3725 m:1A 8002 1ACE1F 83765A 00
2015.07.10 10:54:23.271 0: IT set IT03 off
2015.07.10 10:54:23.887 0: IT set IT08 off
2015.07.10 10:54:24.812 0: HMLAN_Parse: hmlan1 R:E83765A   stat:0000 t:0000E145 d:FF r:FFAF     m:1A A270 83765A 1ACE1F 00903E27D2000056A407D0
2015.07.10 10:54:24.917 0: HMLAN_Send:  hmusb1 S:S772C3E88 stat:  00 t:00000000 d:01 r:772C3E88 m:1A 8002 1ACE1F 83765A 00
2015.07.10 10:54:25.043 0: HMLAN_Parse: hmlan1 R:E83765A   stat:0000 t:0000E40C d:FF r:FFB0     m:1A A270 83765A 1ACE1F 00903E27D2000056A407D0
2015.07.10 10:54:25.176 0: HMLAN_Parse: hmlan1 R:E20DFE1   stat:0000 t:00011D0D d:FF r:FFD3     m:17 8670 20DFE1 000000 00A343
2015.07.10 10:54:25.194 0: HMLAN_Send:  hmusb1 I:+20DFE1,02,00,00
2015.07.10 10:54:25.231 0: HMLAN_Parse: hmlan1 R:E266EA5   stat:0000 t:0001206D d:FF r:FFCC     m:05 805E 266EA5 1ACE1F 0000000000000001000000
2015.07.10 10:54:25.355 0: HMLAN_Parse: hmlan1 R:E206487   stat:0000 t:00015F21 d:FF r:FFB7     m:95 8670 206487 000000 00AE3A
2015.07.10 10:54:25.371 0: HMLAN_Send:  hmusb1 I:+206487,02,00,00
2015.07.10 10:54:25.654 0: HMLAN_Parse: hmlan1 R:E266EA5   stat:0000 t:00016A26 d:FF r:FFCC     m:06 805E 266EA5 1ACE1F 0000000000000001000000
2015.07.10 10:54:25.781 0: HMLAN_Parse: hmlan1 R:R772B59FA stat:0002 t:00000000 d:FF r:7FFF     m:99 8112 999999 000000 
2015.07.10 10:54:25.783 1: HMLAN_Parse: hmlan1 new condition ok
2015.07.10 10:54:26.054 0: HMLAN_Parse: hmlan1 R:E999999   stat:0000 t:0001A388 d:FF r:FFD8     m:99 8112 999999 000000 
2015.07.10 10:54:26.057 0: HMLAN_Parse: hmlan1 R:E1DFDA5   stat:0000 t:0001A77F d:FF r:FFC5     m:18 8670 1DFDA5 000000 00A83A
2015.07.10 10:54:26.074 0: HMLAN_Send:  hmusb1 I:+1DFDA5,02,00,00
2015.07.10 10:54:26.080 0: HMLAN_Send:  hmusb1 I:-1DFDA5
2015.07.10 10:54:26.083 0: HMLAN_Send:  hmlan1 I:+1DFDA5,00,00,
2015.07.10 10:54:26.162 0: HMLAN_Send:  hmlan1 S:S772C4373 stat:  00 t:00000000 d:01 r:772C4373 m:01 A112 1ACE1F 1DFDA5 
2015.07.10 10:54:26.570 0: HMLAN_Parse: hmlan1 R:E266EA5   stat:0000 t:0001B3DE d:FF r:FFCD     m:07 805E 266EA5 1ACE1F 0000000000000001000000
2015.07.10 10:54:26.714 0: HMLAN_Parse: hmlan1 R:E1936FF   stat:0000 t:0001CA71 d:FF r:FFC7     m:D1 8670 1936FF 000000 00AE42
2015.07.10 10:54:26.730 0: HMLAN_Send:  hmusb1 I:+1936FF,02,00,00
2015.07.10 10:54:26.736 0: HMLAN_Send:  hmusb1 I:-1936FF
2015.07.10 10:54:26.768 0: HMLAN_Parse: hmlan1 R:E206278   stat:0000 t:0001D635 d:FF r:FFB5     m:24 8670 206278 000000 00AE46
2015.07.10 10:54:26.786 0: HMLAN_Send:  hmusb1 I:+206278,02,00,00
2015.07.10 10:54:26.793 0: HMLAN_Send:  hmusb1 I:-206278
2015.07.10 10:54:27.202 0: HMLAN_Parse: hmlan1 R:E1D252E   stat:0000 t:0001E107 d:FF r:FFC6     m:D7 8670 1D252E 000000 00B23C
2015.07.10 10:54:27.218 0: HMLAN_Send:  hmusb1 I:+1D252E,02,00,00
2015.07.10 10:54:27.224 0: HMLAN_Send:  hmusb1 I:-1D252E
2015.07.10 10:54:27.256 0: HMLAN_Parse: hmlan1 R:E266EA5   stat:0000 t:0001FD96 d:FF r:FFCB     m:08 805E 266EA5 1ACE1F 0000000000000001000000
2015.07.10 10:54:27.383 0: HMLAN_Parse: hmlan1 R:E6869B6   stat:0000 t:00021336 d:FF r:FFBC     m:3B A270 6869B6 1ACE1F 00B73127E5000000DD07D0
2015.07.10 10:54:27.398 0: HMLAN_Send:  hmusb1 I:-6869B6
2015.07.10 10:54:27.402 0: HMLAN_Send:  hmlan1 I:+6869B6,00,00,
2015.07.10 10:54:27.486 0: HMLAN_Send:  hmlan1 S:+6869B6,00,00,00
2015.07.10 10:54:27.488 0: HMLAN_Send:  hmlan1 S:S772C489A stat:  00 t:00000000 d:01 r:772C489A m:3B 8002 1ACE1F 6869B6 00
2015.07.10 10:54:27.692 0: HMLAN_Parse: hmlan1 R:E6869B6   stat:0000 t:000215F5 d:FF r:FFBC     m:3B A270 6869B6 1ACE1F 00B73127E5000000DD07D0
2015.07.10 10:54:27.716 0: HMLAN_Parse: hmlan1 R:E6869B6   stat:0000 t:000218B5 d:FF r:FFBE     m:3B A270 6869B6 1ACE1F 00B73127E5000000DD07D0
2015.07.10 10:54:27.842 0: HMLAN_Parse: hmlan1 R:E24AF1D   stat:0000 t:00021B18 d:FF r:FFCB     m:01 845E 24AF1D 000000 8000000000000000094301
2015.07.10 10:54:28.334 0: HMLAN_Parse: hmlan1 R:E266EA5   stat:0000 t:0002474E d:FF r:FFCA     m:09 805E 266EA5 1ACE1F 0000000000000000000000
2015.07.10 10:54:28.460 0: HMLAN_Parse: hmlan1 R:E1BF81B   stat:0000 t:000263A3 d:FF r:FFD3     m:E7 8670 1BF81B 000000 00AE3E
2015.07.10 10:54:28.474 0: HMLAN_Send:  hmusb1 I:-1BF81B
2015.07.10 10:54:28.820 0: HMLAN_Parse: hmlan1 V:03C4 sNo:JEQ0315335 d:1C671E O:1ACE1F t:00026CA1 IDcnt:0009 L:1 %
2015.07.10 10:54:28.957 0: HMLAN_Parse: hmusb1 V:03C7 sNo:KEQ1111271 d:263408 O:1ACE1F t:0000EBA7 IDcnt:0000 L:0 %
2015.07.10 10:54:29.083 0: HMLAN_Parse: hmusb1 R:E266EA5   stat:0000 t:0000206F d:FF r:FFC6     m:04 805E 266EA5 1ACE1F 0000000000000001000000
2015.07.10 10:54:29.396 0: HMLAN_Parse: hmusb1 R:E266EA5   stat:0000 t:0000206F d:FF r:FFC6     m:04 805E 266EA5 1ACE1F 0000000000000001000000
2015.07.10 10:54:29.409 0: HMLAN_Parse: hmusb1 R:E83765A   stat:0000 t:00002838 d:FF r:FFB0     m:1A A270 83765A 1ACE1F 00903E27D2000056A407D0
2015.07.10 10:54:29.579 0: HMLAN_Parse: hmusb1 R:E83765A   stat:0000 t:00002838 d:FF r:FFB0     m:1A A270 83765A 1ACE1F 00903E27D2000056A407D0
2015.07.10 10:54:29.597 0: HMLAN_Parse: hmusb1 R:E83765A   stat:0000 t:00002838 d:FF r:FFB0     m:1A A270 83765A 1ACE1F 00903E27D2000056A407D0
2015.07.10 10:54:29.614 0: HMLAN_Parse: hmusb1 R:E83765A   stat:0000 t:00002AFF d:FF r:FFAF     m:1A A270 83765A 1ACE1F 00903E27D2000056A407D0
2015.07.10 10:54:29.744 0: HMLAN_Parse: hmusb1 R:E83765A   stat:0000 t:00002DC6 d:FF r:FFB0     m:1A A270 83765A 1ACE1F 00903E27D2000056A407D0
2015.07.10 10:54:29.870 0: HMLAN_Parse: hmusb1 R:E83765A   stat:0000 t:00002DC6 d:FF r:FFB0     m:1A A270 83765A 1ACE1F 00903E27D2000056A407D0
2015.07.10 10:54:29.887 0: HMLAN_Parse: hmusb1 R:E20DFE1   stat:0000 t:000066C5 d:FF r:FFC6     m:17 8670 20DFE1 000000 00A343
2015.07.10 10:54:29.903 0: HMLAN_Parse: hmusb1 R:E20DFE1   stat:0000 t:000066C5 d:FF r:FFC6     m:17 8670 20DFE1 000000 00A343
2015.07.10 10:54:29.918 0: HMLAN_Parse: hmusb1 R:E266EA5   stat:0000 t:00006A25 d:FF r:FFC6     m:05 805E 266EA5 1ACE1F 0000000000000001000000
2015.07.10 10:54:30.042 0: HMLAN_Parse: hmusb1 R:E266EA5   stat:0000 t:00006A25 d:FF r:FFC6     m:05 805E 266EA5 1ACE1F 0000000000000001000000
2015.07.10 10:54:30.056 0: HMLAN_Parse: hmusb1 R:E206487   stat:0000 t:0000A8D6 d:FF r:FFB2     m:95 8670 206487 000000 00AE3A
2015.07.10 10:54:30.074 0: HMLAN_Parse: hmusb1 R:E266EA5   stat:0000 t:0000B3DB d:FF r:FFC7     m:06 805E 266EA5 1ACE1F 0000000000000001000000
2015.07.10 10:54:30.204 0: HMLAN_Parse: hmusb1 V:03C7 sNo:KEQ1111271 d:263408 O:1ACE1F t:0000EBA7 IDcnt:0000 L:0 %
2015.07.10 10:54:30.210 0: HMLAN_Parse: hmusb1 R:E999999   stat:0000 t:0000EBD7 d:FF r:FFD6     m:99 8112 999999 000000 
2015.07.10 10:54:30.215 0: HMLAN_Parse: hmusb1 R:R772B59C2 stat:0002 t:00000000 d:FF r:7FFF     m:99 8112 999999 000000 
2015.07.10 10:54:30.216 1: HMLAN_Parse: hmusb1 new condition ok
2015.07.10 10:54:30.502 0: HMLAN_Parse: hmusb1 R:E1DFDA5   stat:0000 t:0000F132 d:FF r:FFBE     m:18 8670 1DFDA5 000000 00A83A
2015.07.10 10:54:30.523 0: HMLAN_Send:  hmusb1 S:+266A86,00,00,00
2015.07.10 10:54:30.526 0: HMLAN_Send:  hmusb1 S:S772C54C6 stat:  00 t:00000000 d:01 r:772C54C6 m:03 A001 1ACE1F 266A86 010E
2015.07.10 10:54:30.535 0: HMLAN_Parse: hmusb1 R:E266EA5   stat:0000 t:0000FD91 d:FF r:FFC6     m:07 805E 266EA5 1ACE1F 0000000000000001000000
2015.07.10 10:54:30.678 0: HMLAN_Parse: hmusb1 R:E1936FF   stat:0000 t:00011423 d:FF r:FFB6     m:D1 8670 1936FF 000000 00AE42
2015.07.10 10:54:30.695 0: HMLAN_Parse: hmusb1 R:E1D252E   stat:0000 t:00012AB9 d:FF r:FFBA     m:D7 8670 1D252E 000000 00B23C
2015.07.10 10:54:30.711 0: HMLAN_Parse: hmusb1 R:E266EA5   stat:0000 t:00014746 d:FF r:FFC6     m:08 805E 266EA5 1ACE1F 0000000000000001000000
2015.07.10 10:54:30.843 0: HMLAN_Parse: hmusb1 R:E6869B6   stat:0000 t:00015CE5 d:FF r:FFBE     m:3B A270 6869B6 1ACE1F 00B73127E5000000DD07D0
2015.07.10 10:54:31.033 0: HMLAN_Parse: hmusb1 R:E6869B6   stat:0000 t:00015FA4 d:FF r:FFBE     m:3B A270 6869B6 1ACE1F 00B73127E5000000DD07D0
2015.07.10 10:54:31.063 0: HMLAN_Parse: hmusb1 R:E6869B6   stat:0000 t:00016264 d:FF r:FFBD     m:3B A270 6869B6 1ACE1F 00B73127E5000000DD07D0
2015.07.10 10:54:31.295 0: HMLAN_Parse: hmusb1 R:E24AF1D   stat:0000 t:000164C7 d:FF r:FFC2     m:01 845E 24AF1D 000000 8000000000000000094301
2015.07.10 10:54:31.310 0: HMLAN_Parse: hmusb1 R:E266EA5   stat:0000 t:000190FB d:FF r:FFC5     m:09 805E 266EA5 1ACE1F 0000000000000000000000
2015.07.10 10:54:31.435 0: HMLAN_Parse: hmusb1 R:E1BF81B   stat:0000 t:0001AD4F d:FF r:FFB9     m:E7 8670 1BF81B 000000 00AE3E
2015.07.10 10:54:31.450 0: HMLAN_Parse: hmusb1 V:03C7 sNo:KEQ1111271 d:263408 O:1ACE1F t:0001B666 IDcnt:0015 L:1 %
2015.07.10 10:54:31.574 0: HMLAN_Parse: hmusb1 R:R772C29A8 stat:0002 t:00000000 d:FF r:7FFF     m:02 8002 1ACE1F 266A86 00
2015.07.10 10:54:31.577 0: HMLAN_Parse: hmusb1 R:R772C2A9B stat:0002 t:00000000 d:FF r:7FFF     m:00 8002 1ACE1F 1F64D8 00
2015.07.10 10:54:31.579 0: HMLAN_Parse: hmusb1 R:R772C2C02 stat:0002 t:00000000 d:FF r:7FFF     m:02 8002 1ACE1F 266A86 00
2015.07.10 10:54:31.581 0: HMLAN_Parse: hmusb1 R:R772C2D04 stat:0002 t:00000000 d:FF r:7FFF     m:02 8002 1ACE1F 266A86 00
2015.07.10 10:54:31.583 0: HMLAN_Parse: hmusb1 R:R772C2D86 stat:0002 t:00000000 d:FF r:7FFF     m:02 8002 1ACE1F 266A86 00
2015.07.10 10:54:31.586 0: HMLAN_Parse: hmusb1 R:R772C2E75 stat:0002 t:00000000 d:FF r:7FFF     m:00 8002 1ACE1F 1F64D8 00
2015.07.10 10:54:31.588 0: HMLAN_Parse: hmusb1 R:R772C2F92 stat:0002 t:00000000 d:FF r:7FFF     m:02 8002 1ACE1F 266A86 00
2015.07.10 10:54:31.591 0: HMLAN_Parse: hmusb1 R:R772C3088 stat:0002 t:00000000 d:FF r:7FFF     m:02 8002 1ACE1F 266A86 00
2015.07.10 10:54:31.593 0: HMLAN_Parse: hmusb1 R:R772C3101 stat:0002 t:00000000 d:FF r:7FFF     m:00 8002 1ACE1F 1F64D8 00
2015.07.10 10:54:31.596 0: HMLAN_Parse: hmusb1 V:03C7 sNo:KEQ1111271 d:263408 O:1ACE1F t:0001C366 IDcnt:0015 L:1 %
2015.07.10 10:54:31.602 0: HMLAN_Parse: hmusb1 R:R772C317D stat:0002 t:00000000 d:FF r:7FFF     m:02 8002 1ACE1F 266A86 00
2015.07.10 10:54:31.604 0: HMLAN_Parse: hmusb1 R:R772C3725 stat:0002 t:00000000 d:FF r:7FFF     m:1A 8002 1ACE1F 83765A 00
2015.07.10 10:54:31.606 0: HMLAN_Parse: hmusb1 R:R772C3E88 stat:0002 t:00000000 d:FF r:7FFF     m:1A 8002 1ACE1F 83765A 00
2015.07.10 10:54:31.609 0: HMLAN_Parse: hmusb1 R:E1ACE1F   stat:0000 t:0001D595 d:FF r:FFD6     m:01 A112 1ACE1F 1DFDA5 
2015.07.10 10:54:31.624 0: HMLAN_Parse: hmusb1 R:E1ACE1F   stat:0000 t:0001D65E d:FF r:FFD6     m:01 A112 1ACE1F 1DFDA5 
2015.07.10 10:54:31.638 0: HMLAN_Parse: hmusb1 R:E1ACE1F   stat:0000 t:0001D726 d:FF r:FFD6     m:01 A112 1ACE1F 1DFDA5 
2015.07.10 10:54:31.651 0: HMLAN_Parse: hmusb1 R:E266EA5   stat:0000 t:0001DAB0 d:FF r:FFC6     m:0A 805E 266EA5 1ACE1F 0000000000000000000000
2015.07.10 10:54:31.779 0: HMLAN_Parse: hmusb1 R:E1ACE1F   stat:0000 t:0001DACD d:FF r:FFD6     m:3B 8002 1ACE1F 6869B6 00
2015.07.10 10:54:31.803 1: Perfmon: possible freeze starting at 10:54:15, delay is 16.803
2015.07.10 10:54:31.875 0: HMLAN_Send:  hmusb1 I:-52C4DF
2015.07.10 10:54:33.540 0: HMLAN_Send:  hmusb1 S:S772C608E stat:  00 t:00000000 d:01 r:772C608E m:03 A001 1ACE1F 266A86 010E
2015.07.10 10:54:33.657 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0002756F d:FF r:FFD8     m:02 8002 1ACE1F 266A86 00
2015.07.10 10:54:33.687 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0002762F d:FF r:FFD8     m:00 8002 1ACE1F 1F64D8 00
2015.07.10 10:54:33.706 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0002766F d:FF r:FFD9     m:02 8002 1ACE1F 266A86 00
2015.07.10 10:54:33.728 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:000276AF d:FF r:FFD8     m:02 8002 1ACE1F 266A86 00
2015.07.10 10:54:33.741 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:000276EF d:FF r:FFD8     m:02 8002 1ACE1F 266A86 00
2015.07.10 10:54:33.758 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0002772F d:FF r:FFD8     m:00 8002 1ACE1F 1F64D8 00
2015.07.10 10:54:33.776 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0002782F d:FF r:FFD8     m:02 8002 1ACE1F 266A86 00
2015.07.10 10:54:33.794 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0002790F d:FF r:FFD8     m:02 8002 1ACE1F 266A86 00
2015.07.10 10:54:33.811 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0002798F d:FF r:FFD8     m:00 8002 1ACE1F 1F64D8 00
2015.07.10 10:54:33.831 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:00027A0F d:FF r:FFD8     m:02 8002 1ACE1F 266A86 00
2015.07.10 10:54:33.857 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:00027FEF d:FF r:FFD8     m:1A 8002 1ACE1F 83765A 00
2015.07.10 10:54:33.876 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:00028730 d:FF r:FFD8     m:1A 8002 1ACE1F 83765A 00
2015.07.10 10:54:33.893 0: HMLAN_Parse: hmlan1 R:R772C4373 stat:0008 t:00000000 d:FF r:7FFF     m:01 A112 1ACE1F 1DFDA5 
2015.07.10 10:54:33.895 0: HMLAN_Parse: hmlan1 no ACK from 1DFDA5
2015.07.10 10:54:33.898 0: HMLAN_Parse: hmlan1 R:E266EA5   stat:0000 t:00029105 d:FF r:FFCB     m:0A 805E 266EA5 1ACE1F 0000000000000000000000
2015.07.10 10:54:33.912 0: HMLAN_Send:  hmlan1 I:+52C4DF,00,00,
2015.07.10 10:54:33.917 0: HMLAN_Send:  hmlan1 S:+52C4DF,00,00,00
2015.07.10 10:54:33.919 0: HMLAN_Send:  hmlan1 S:S772C6208 stat:  00 t:00000000 d:01 r:772C6208 m:01 B001 1ACE1F 52C4DF 010E
2015.07.10 10:54:33.932 0: HMLAN_Parse: hmlan1 R:R772C489A stat:0002 t:00000000 d:FF r:7FFF     m:3B 8002 1ACE1F 6869B6 00
2015.07.10 10:54:33.935 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:00029D51 d:FF r:FFD8     m:03 A001 1ACE1F 266A86 010E
2015.07.10 10:54:33.952 0: HMLAN_Parse: hmlan1 R:E266A86   stat:0000 t:00029DD1 d:FF r:FFC5     m:03 A410 266A86 1ACE1F 060100003F00
2015.07.10 10:54:34.145 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:00029E4E d:FF r:FFD8     m:03 8002 1ACE1F 266A86 00
2015.07.10 10:54:34.165 0: HMLAN_Parse: hmusb1 R:E266A86   stat:0000 t:0001E77B d:FF r:FFC2     m:03 A410 266A86 1ACE1F 060100003F00
2015.07.10 10:54:34.182 0: HMLAN_Parse: hmusb1 R:R772C54C6 stat:0001 t:0001E780 d:FF r:FFC2     m:03 A410 266A86 1ACE1F 060100003F00
2015.07.10 10:54:34.198 0: HMLAN_Parse: hmusb1 R:E266A86   stat:0000 t:0001F35B d:FF r:FFC2     m:03 A410 266A86 1ACE1F 060100003F00
2015.07.10 10:54:34.212 0: HMLAN_Parse: hmusb1 R:R772C608E stat:0001 t:0001F360 d:FF r:FFC2     m:03 A410 266A86 1ACE1F 060100003F00
2015.07.10 10:54:34.232 0: HMLAN_Send:  hmusb1 S:+1F64D8,00,00,00
2015.07.10 10:54:34.237 0: HMLAN_Send:  hmusb1 S:S772C6344 stat:  00 t:00000000 d:01 r:772C6344 m:01 A011 1ACE1F 1F64D8 0101
2015.07.10 10:54:34.257 1: Perfmon: possible freeze starting at 10:54:32, delay is 2.256
2015.07.10 10:54:34.261 0: HMLAN_Send:  hmusb1 I:-52BB90
2015.07.10 10:54:34.310 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0002A932 d:FF r:FFD8     m:03 A001 1ACE1F 266A86 010E
2015.07.10 10:54:34.326 0: HMLAN_Parse: hmlan1 R:E266A86   stat:0000 t:0002A9B2 d:FF r:FFC5     m:03 A410 266A86 1ACE1F 060100003F00
2015.07.10 10:54:34.491 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0002ABD1 d:FF r:FFD8     m:01 A011 1ACE1F 1F64D8 0101
2015.07.10 10:54:34.508 0: HMLAN_Parse: hmlan1 R:E52C4DF   stat:0000 t:0002AC27 d:FF r:FFC6     m:01 A010 52C4DF 1ACE1F 0601010038
2015.07.10 10:54:34.675 0: HMLAN_Parse: hmlan1 R:E1F64D8   stat:0000 t:0002AC50 d:FF r:FFBA     m:01 8002 1F64D8 1ACE1F 0101000041
2015.07.10 10:54:34.838 0: HMLAN_Parse: hmusb1 R:E1ACE1F   stat:0000 t:0001F546 d:FF r:FFD5     m:01 B001 1ACE1F 52C4DF 010E
2015.07.10 10:54:34.862 0: HMLAN_Parse: hmusb1 R:E52C4DF   stat:0000 t:0001F5D0 d:FF r:FFC1     m:01 A010 52C4DF 1ACE1F 0601010038
2015.07.10 10:54:34.875 0: HMLAN_Parse: hmusb1 R:R772C6344 stat:0001 t:0001F5FE d:FF r:FFBF     m:01 8002 1F64D8 1ACE1F 0101000041
2015.07.10 10:54:34.981 0: HMLAN_Send:  hmusb1 S:+1F64D8,00,00,00
2015.07.10 10:54:34.983 0: HMLAN_Send:  hmusb1 S:S772C65D7 stat:  00 t:00000000 d:01 r:772C65D7 m:02 A011 1ACE1F 1F64D8 0201000000
2015.07.10 10:54:34.991 0: HMLAN_Parse: hmusb1 R:E1ACE1F   stat:0000 t:0001F64E d:FF r:FFD6     m:01 8002 1ACE1F 52C4DF 00
2015.07.10 10:54:35.026 0: HMLAN_Parse: hmlan1 R:R772C6208 stat:0001 t:0002AC2C d:FF r:FFC6     m:01 A010 52C4DF 1ACE1F 0601010038
2015.07.10 10:54:35.046 0: HMLAN_Send:  hmlan1 I:+52BB90,00,00,
2015.07.10 10:54:35.055 0: HMLAN_Send:  hmlan1 S:+52BB90,00,00,00
2015.07.10 10:54:35.057 0: HMLAN_Send:  hmlan1 S:S772C6676 stat:  00 t:00000000 d:01 r:772C6676 m:01 B001 1ACE1F 52BB90 010E
2015.07.10 10:54:35.405 0: HMLAN_Send:  hmusb1 I:-52BB9D
2015.07.10 10:54:35.480 0: HMLAN_Parse: hmusb1 R:E1ACE1F   stat:0000 t:0001F9B8 d:FF r:FFD5     m:01 B001 1ACE1F 52BB90 010E
2015.07.10 10:54:35.503 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0002B044 d:FF r:FFD8     m:02 A011 1ACE1F 1F64D8 0201000000
2015.07.10 10:54:35.588 0: HMLAN_Parse: hmlan1 R:E52BB90   stat:0000 t:0002B099 d:FF r:FFD2     m:01 A010 52BB90 1ACE1F 060101002F
2015.07.10 10:54:35.922 0: HMLAN_Parse: hmlan1 R:E1F64D8   stat:0000 t:0002B0C1 d:FF r:FFBA     m:02 8002 1F64D8 1ACE1F 0101000040
2015.07.10 10:54:35.963 0: HMLAN_Parse: hmlan1 R:R772C6676 stat:0001 t:0002B09E d:FF r:FFD2     m:01 A010 52BB90 1ACE1F 060101002F
2015.07.10 10:54:35.982 0: HMLAN_Send:  hmlan1 I:+52BB9D,00,00,
2015.07.10 10:54:35.987 0: HMLAN_Send:  hmlan1 S:+52BB9D,00,00,00
2015.07.10 10:54:35.989 0: HMLAN_Send:  hmlan1 S:S772C6A1E stat:  00 t:00000000 d:01 r:772C6A1E m:01 B001 1ACE1F 52BB9D 010E
2015.07.10 10:54:36.003 0: HMLAN_Parse: hmusb1 R:E52BB90   stat:0000 t:0001FA42 d:FF r:FFC9     m:01 A010 52BB90 1ACE1F 060101002F
2015.07.10 10:54:36.015 0: HMLAN_Parse: hmusb1 R:R772C65D7 stat:0001 t:0001FA6F d:FF r:FFBE     m:02 8002 1F64D8 1ACE1F 0101000040
2015.07.10 10:54:36.032 0: HMLAN_Send:  hmusb1 S:S772C6A4B stat:  00 t:00000000 d:01 r:772C6A4B m:96 A112 1ACE1F 206487 
2015.07.10 10:54:36.045 0: HMLAN_Parse: hmusb1 R:E1ACE1F   stat:0000 t:0001FABF d:FF r:FFD5     m:01 8002 1ACE1F 52BB90 00
2015.07.10 10:54:36.408 0: HMLAN_Parse: hmusb1 R:E1ACE1F   stat:0000 t:0001FD5D d:FF r:FFD6     m:01 B001 1ACE1F 52BB9D 010E
2015.07.10 10:54:36.492 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0002B421 d:FF r:FFD8     m:96 A112 1ACE1F 206487 
2015.07.10 10:54:36.665 0: HMLAN_Parse: hmusb1 R:R772C6A4B stat:0008 t:00000000 d:FF r:7FFF     m:96 A112 1ACE1F 206487 
2015.07.10 10:54:36.672 0: HMLAN_Parse: hmusb1 no ACK from 206487
2015.07.10 10:54:36.842 0: HMLAN_Send:  hmusb1 S:+285A54,00,00,00
2015.07.10 10:54:36.844 0: HMLAN_Send:  hmusb1 S:S772C6D75 stat:  00 t:00000000 d:01 r:772C6D75 m:01 A001 1ACE1F 285A54 010E
2015.07.10 10:54:36.984 0: HMLAN_Parse: hmusb1 R:E1ACE1F   stat:0000 t:0001FFB4 d:FF r:FFD6     m:01 B001 1ACE1F 52BB9D 010E
2015.07.10 10:54:37.084 0: HMLAN_Parse: hmlan1 R:E285A54   stat:0000 t:0002B671 d:FF r:FFB3     m:01 A410 285A54 1ACE1F 0601000043
2015.07.10 10:54:37.142 0: HMLAN_Parse: hmusb1 R:E285A54   stat:0000 t:0002001A d:FF r:FFBE     m:01 A410 285A54 1ACE1F 0601000043
2015.07.10 10:54:37.210 0: HMLAN_Parse: hmusb1 R:R772C6D75 stat:0001 t:0002001F d:FF r:FFBE     m:01 A410 285A54 1ACE1F 0601000043
2015.07.10 10:54:37.230 0: HMLAN_Send:  hmusb1 S:S772C6EF5 stat:  00 t:00000000 d:01 r:772C6EF5 m:9C A112 1ACE1F 2064CB 
2015.07.10 10:54:37.233 0: HMLAN_Send:  hmusb1 I:K
2015.07.10 10:54:37.337 0: HMLAN_Parse: hmusb1 V:03C7 sNo:KEQ1111271 d:263408 O:1ACE1F t:00020106 IDcnt:000C L:2 %
2015.07.10 10:54:37.453 0: HMLAN_Send:  hmlan1 I:-285A44
2015.07.10 10:54:37.592 0: HMLAN_Parse: hmusb1 R:E1ACE1F   stat:0000 t:0002020C d:FF r:FFD6     m:01 B001 1ACE1F 52BB9D 010E
2015.07.10 10:54:37.675 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0002B8C1 d:FF r:FFD9     m:9C A112 1ACE1F 2064CB 
2015.07.10 10:54:37.798 0: HMLAN_Parse: hmlan1 R:R772C6A1E stat:0008 t:00000000 d:FF r:7FFF     m:01 B001 1ACE1F 52BB9D 010E
2015.07.10 10:54:37.800 0: HMLAN_Parse: hmlan1 no ACK from 52BB9D
2015.07.10 10:54:37.848 0: HMLAN_Parse: hmusb1 R:R772C6EF5 stat:0008 t:00000000 d:FF r:7FFF     m:9C A112 1ACE1F 2064CB 
2015.07.10 10:54:37.850 0: HMLAN_Parse: hmusb1 no ACK from 2064CB
2015.07.10 10:54:37.899 0: HMLAN_Send:  hmlan1 I:-206278
2015.07.10 10:54:38.011 0: HMLAN_Send:  hmusb1 I:+285A44,00,00,
2015.07.10 10:54:38.016 0: HMLAN_Send:  hmusb1 S:+285A44,00,00,00
2015.07.10 10:54:38.018 0: HMLAN_Send:  hmusb1 S:S772C720C stat:  00 t:00000000 d:01 r:772C720C m:01 A001 1ACE1F 285A44 010E
2015.07.10 10:54:38.049 0: HMLAN_Send:  hmlan1 S:S772C722C stat:  00 t:00000000 d:01 r:772C722C m:01 B001 1ACE1F 52BB9D 010E
2015.07.10 10:54:38.520 0: HMLAN_Parse: hmusb1 R:E1ACE1F   stat:0000 t:00020568 d:FF r:FFD6     m:01 B001 1ACE1F 52BB9D 010E
2015.07.10 10:54:38.604 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0002BC62 d:FF r:FFD8     m:01 A001 1ACE1F 285A44 010E
2015.07.10 10:54:38.776 0: HMLAN_Parse: hmusb1 R:R772C720C stat:0008 t:00000000 d:FF r:7FFF     m:01 A001 1ACE1F 285A44 010E
2015.07.10 10:54:38.779 0: HMLAN_Parse: hmusb1 no ACK from 285A44
2015.07.10 10:54:38.957 0: HMLAN_Send:  hmusb1 I:+206278,00,00,
2015.07.10 10:54:38.962 0: HMLAN_Send:  hmusb1 S:S772C75BD stat:  00 t:00000000 d:01 r:772C75BD m:25 A112 1ACE1F 206278 
2015.07.10 10:54:39.065 0: HMLAN_Parse: hmusb1 R:E1ACE1F   stat:0000 t:000207C0 d:FF r:FFD6     m:01 B001 1ACE1F 52BB9D 010E
2015.07.10 10:54:39.084 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0002BE34 d:FF r:FFD8     m:25 A112 1ACE1F 206278 
2015.07.10 10:54:39.179 0: HMLAN_Parse: hmlan1 R:E52BB9D   stat:0000 t:0002BEA0 d:FF r:FFD8     m:01 A010 52BB9D 1ACE1F 0601010028
2015.07.10 10:54:39.339 0: HMLAN_Send:  hmusb1 S:S772C7736 stat:  00 t:00000000 d:01 r:772C7736 m:01 A001 1ACE1F 285A44 010E
2015.07.10 10:54:39.347 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0002BEFC d:FF r:FFD8     m:25 A112 1ACE1F 206278 
2015.07.10 10:54:39.361 0: HMLAN_Parse: hmlan1 R:R772C722C stat:0001 t:0002BEA5 d:FF r:FFD8     m:01 A010 52BB9D 1ACE1F 0601010028
2015.07.10 10:54:39.375 0: HMLAN_Send:  hmlan1 I:-1936FF
2015.07.10 10:54:39.385 0: HMLAN_Parse: hmusb1 R:E52BB9D   stat:0000 t:00020849 d:FF r:FFD9     m:01 A010 52BB9D 1ACE1F 0601010028
2015.07.10 10:54:39.398 0: HMLAN_Parse: hmusb1 R:E1ACE1F   stat:0000 t:000208C6 d:FF r:FFD6     m:01 8002 1ACE1F 52BB9D 00
2015.07.10 10:54:39.426 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0002BF72 d:FF r:FFD8     m:01 A001 1ACE1F 285A44 010E
2015.07.10 10:54:39.440 0: HMLAN_Send:  hmlan1 I:-1D252E
2015.07.10 10:54:39.470 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0002BFC4 d:FF r:FFD8     m:25 A112 1ACE1F 206278 
2015.07.10 10:54:39.484 0: HMLAN_Send:  hmlan1 I:-1BF81B
2015.07.10 10:54:39.592 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0002C03B d:FF r:FFD8     m:01 A001 1ACE1F 285A44 010E
2015.07.10 10:54:39.607 0: HMLAN_Send:  hmlan1 S:+1C4E25,00,00,00
2015.07.10 10:54:39.609 0: HMLAN_Send:  hmlan1 S:S772C7844 stat:  00 t:00000000 d:01 r:772C7844 m:AA A258 B5B5B5 1C4E25 0300
2015.07.10 10:54:39.615 0: HMLAN_Send:  hmlan1 I:+1C4E25,02,00,00
2015.07.10 10:54:39.672 0: HMLAN_Parse: hmusb1 R:EB5B5B5   stat:0000 t:00020A1E d:FF r:FFD6     m:AA A258 B5B5B5 1C4E25 0300
2015.07.10 10:54:39.712 0: HMLAN_Parse: hmusb1 R:EB5B5B5   stat:0000 t:00020A1E d:FF r:FFD6     m:AA A258 B5B5B5 1C4E25 0300
2015.07.10 10:54:39.736 0: HMLAN_Parse: hmusb1 R:R772C75BD stat:0008 t:00000000 d:FF r:7FFF     m:25 A112 1ACE1F 206278 
2015.07.10 10:54:39.739 0: HMLAN_Parse: hmusb1 no ACK from 206278
2015.07.10 10:54:39.792 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0002C103 d:FF r:FFD8     m:01 A001 1ACE1F 285A44 010E
2015.07.10 10:54:39.864 0: HMLAN_Parse: hmusb1 R:EB5B5B5   stat:0000 t:00020AE7 d:FF r:FFD6     m:AA A258 B5B5B5 1C4E25 0300
2015.07.10 10:54:39.961 0: HMLAN_Parse: hmusb1 R:R772C7736 stat:0008 t:00000000 d:FF r:7FFF     m:01 A001 1ACE1F 285A44 010E
2015.07.10 10:54:39.965 0: HMLAN_Parse: hmusb1 no ACK from 285A44
2015.07.10 10:54:40.056 0: HMLAN_Parse: hmusb1 R:EB5B5B5   stat:0000 t:00020BAF d:FF r:FFD6     m:AA A258 B5B5B5 1C4E25 0300
2015.07.10 10:54:40.078 0: HMLAN_Send:  hmusb1 I:+1936FF,00,00,
2015.07.10 10:54:40.091 0: HMLAN_Send:  hmusb1 S:S772C7A23 stat:  00 t:00000000 d:01 r:772C7A23 m:D2 A112 1ACE1F 1936FF 
2015.07.10 10:54:40.187 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0002C290 d:FF r:FFD8     m:D2 A112 1ACE1F 1936FF 
2015.07.10 10:54:40.234 0: HMLAN_Parse: hmlan1 R:R772C7844 stat:0008 t:00000000 d:FF r:7FFF     m:AA A258 B5B5B5 1C4E25 0300
2015.07.10 10:54:40.236 0: HMLAN_Parse: hmlan1 no ACK from 1C4E25
2015.07.10 10:54:40.388 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0002C359 d:FF r:FFD8     m:D2 A112 1ACE1F 1936FF 
2015.07.10 10:54:40.587 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0002C421 d:FF r:FFD8     m:D2 A112 1ACE1F 1936FF 
2015.07.10 10:54:40.760 0: HMLAN_Parse: hmusb1 R:R772C7A23 stat:0008 t:00000000 d:FF r:7FFF     m:D2 A112 1ACE1F 1936FF 
2015.07.10 10:54:40.763 0: HMLAN_Parse: hmusb1 no ACK from 1936FF
2015.07.10 10:54:40.939 0: HMLAN_Send:  hmusb1 S:S772C7D75 stat:  00 t:00000000 d:01 r:772C7D75 m:CD A112 1ACE1F 206219 
2015.07.10 10:54:40.986 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0002C5B0 d:FF r:FFD8     m:CD A112 1ACE1F 206219 
2015.07.10 10:54:41.187 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0002C679 d:FF r:FFD8     m:CD A112 1ACE1F 206219 
2015.07.10 10:55:17.661 0: HMLAN_Send:  hmlan1 I:K
2015.07.10 10:55:17.671 0: HMLAN_Parse: hmlan1 V:03C4 sNo:JEQ0315335 d:1C671E O:1ACE1F t:0003550D IDcnt:000D L:8 %
2015.07.10 10:55:22.115 0: HMLAN_Send:  hmusb1 I:K
2015.07.10 10:55:22.169 0: HMLAN_Parse: hmusb1 V:03C7 sNo:KEQ1111271 d:263408 O:1ACE1F t:0002B025 IDcnt:0011 L:7 %
2015.07.10 10:55:24.056 1: ----- ARDUINO-FEHLER ----- Broetje refTist: 17.4 CTR5
2015.07.10 10:55:27.219 1: Perfmon: possible freeze starting at 10:55:24, delay is 3.219
2015.07.10 10:55:27.227 0: HMLAN_Parse: hmlan1 R:E266EA5   stat:0000 t:00036E2F d:FF r:FFCC     m:0D 805E 266EA5 1ACE1F 0000000000000001000000
2015.07.10 10:55:27.362 0: HMLAN_Parse: hmusb1 R:E266EA5   stat:0000 t:0002B7CD d:FF r:FFC6     m:0D 805E 266EA5 1ACE1F 0000000000000001000000
2015.07.10 10:55:28.419 0: HMLAN_Send:  hmlan1 I:-1DFC2F
2015.07.10 10:55:28.423 0: HMLAN_Send:  hmusb1 I:+1DFC2F,00,00,
2015.07.10 10:55:28.427 0: HMLAN_Send:  hmusb1 S:+1DFC2F,00,00,00
2015.07.10 10:55:28.429 0: HMLAN_Send:  hmusb1 S:S772D36F8 stat:  00 t:00000000 d:01 r:772D36F8 m:33 A258 B2B2B2 1DFC2F 0300
2015.07.10 10:55:28.603 0: HMLAN_Parse: hmlan1 R:EB2B2B2   stat:0000 t:00037FBB d:FF r:FFD8     m:33 A258 B2B2B2 1DFC2F 0300
2015.07.10 10:55:28.735 0: HMLAN_Parse: hmlan1 R:E1DFC2F   stat:0000 t:0003803E d:FF r:FFCF     m:33 8202 1DFC2F B2B2B2 010100002F
2015.07.10 10:55:28.879 0: HMLAN_Parse: hmlan1 R:EB2B2B2   stat:0000 t:0003805B d:FF r:FFD8     m:33 A258 B2B2B2 1DFC2F 0300
2015.07.10 10:55:28.893 0: HMLAN_Parse: hmusb1 R:E1DFC2F   stat:0000 t:0002C9DC d:FF r:FFCB     m:33 8202 1DFC2F B2B2B2 010100002F
2015.07.10 10:55:28.965 0: HMLAN_Parse: hmlan1 R:EB2B2B2   stat:0000 t:00038124 d:FF r:FFD8     m:33 A258 B2B2B2 1DFC2F 0300
2015.07.10 10:55:29.144 0: HMLAN_Parse: hmusb1 R:R772D36F8 stat:0008 t:00000000 d:FF r:7FFF     m:33 A258 B2B2B2 1DFC2F 0300
2015.07.10 10:55:29.146 0: HMLAN_Parse: hmusb1 no ACK from 1DFC2F
2015.07.10 10:55:32.281 0: HMLAN_Parse: hmlan1 R:E206487   stat:0000 t:00038CD9 d:FF r:FFB8     m:96 8670 206487 000000 00AE3A
2015.07.10 10:55:32.387 0: HMLAN_Send:  hmusb1 S:S772D4616 stat:  00 t:00000000 d:01 r:772D4616 m:97 A112 1ACE1F 206487 
2015.07.10 10:55:32.390 0: HMLAN_Send:  hmusb1 I:K
2015.07.10 10:55:32.418 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:00038D52 d:FF r:FFD8     m:96 A112 1ACE1F 206487 
2015.07.10 10:55:32.432 0: HMLAN_Parse: hmlan1 R:E206487   stat:0000 t:00038DD5 d:FF r:FFB8     m:96 8002 206487 1ACE1F 00
2015.07.10 10:55:32.455 0: HMLAN_Parse: hmusb1 R:E206487   stat:0000 t:0002D676 d:FF r:FFB1     m:96 8670 206487 000000 00AE3A
2015.07.10 10:55:32.498 0: HMLAN_Parse: hmusb1 R:R772D36F8 stat:0081 t:0002D777 d:FF r:FFB0     m:96 8002 206487 1ACE1F 00
2015.07.10 10:55:32.603 0: HMLAN_Send:  hmusb1 S:S772D46F9 stat:  00 t:00000000 d:01 r:772D46F9 m:97 A112 1ACE1F 206487 
2015.07.10 10:55:32.632 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:00038EBA d:FF r:FFD8     m:97 A112 1ACE1F 206487 
2015.07.10 10:55:32.647 0: HMLAN_Parse: hmlan1 R:E206487   stat:0000 t:00038F3C d:FF r:FFB8     m:97 8002 206487 1ACE1F 00
2015.07.10 10:55:32.677 0: HMLAN_Parse: hmusb1 V:03C7 sNo:KEQ1111271 d:263408 O:1ACE1F t:0002D884 IDcnt:0012 L:7 %
2015.07.10 10:55:32.683 0: HMLAN_Parse: hmusb1 R:R772D4616 stat:0001 t:0002D8E0 d:FF r:FFB1     m:97 8002 206487 1ACE1F 00
2015.07.10 10:55:32.788 0: HMLAN_Send:  hmusb1 S:+206487,02,00,00
2015.07.10 10:55:32.790 0: HMLAN_Send:  hmusb1 S:S772D47A7 stat:  00 t:00000000 d:01 r:772D47A7 m:98 A001 1ACE1F 206487 010E
2015.07.10 10:55:32.802 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:00038F9A d:FF r:FFD9     m:97 A112 1ACE1F 206487 
2015.07.10 10:55:32.815 0: HMLAN_Parse: hmlan1 R:E206487   stat:0000 t:0003901D d:FF r:FFB7     m:97 8002 206487 1ACE1F 00
2015.07.10 10:55:32.834 0: HMLAN_Parse: hmusb1 R:R772D46F9 stat:0001 t:0002D9C1 d:FF r:FFB0     m:97 8002 206487 1ACE1F 00
2015.07.10 10:55:32.892 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0003907C d:FF r:FFD8     m:98 A001 1ACE1F 206487 010E
2015.07.10 10:55:33.024 0: HMLAN_Parse: hmlan1 R:E206487   stat:0000 t:00039100 d:FF r:FFB8     m:98 8002 206487 1ACE1F 01020C004E
2015.07.10 10:55:33.128 0: HMLAN_Send:  hmusb1 S:+206487,02,00,00
2015.07.10 10:55:33.131 0: HMLAN_Send:  hmusb1 S:S772D4900 stat:  00 t:00000000 d:01 r:772D4900 m:99 A001 1ACE1F 206487 020E
2015.07.10 10:55:33.157 0: HMLAN_Parse: hmusb1 R:R772D47A7 stat:0001 t:0002DAA4 d:FF r:FFB1     m:98 8002 206487 1ACE1F 01020C004E
2015.07.10 10:55:33.244 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:000391DC d:FF r:FFD8     m:99 A001 1ACE1F 206487 020E
2015.07.10 10:55:33.376 0: HMLAN_Parse: hmlan1 R:E206487   stat:0000 t:00039260 d:FF r:FFB6     m:99 8002 206487 1ACE1F 01020C004D
2015.07.10 10:55:33.481 0: HMLAN_Send:  hmusb1 S:+206487,02,00,00
2015.07.10 10:55:33.483 0: HMLAN_Send:  hmusb1 S:S772D4A61 stat:  00 t:00000000 d:01 r:772D4A61 m:9A A001 1ACE1F 206487 030E
2015.07.10 10:55:33.517 0: HMLAN_Parse: hmusb1 R:R772D4900 stat:0001 t:0002DC04 d:FF r:FFB1     m:99 8002 206487 1ACE1F 01020C004D
2015.07.10 10:55:33.596 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0003933C d:FF r:FFD8     m:9A A001 1ACE1F 206487 030E
2015.07.10 10:55:33.727 0: HMLAN_Parse: hmlan1 R:E206487   stat:0000 t:000393BF d:FF r:FFB8     m:9A 8002 206487 1ACE1F 01020C004D
2015.07.10 10:55:33.745 0: HMLAN_Send:  hmusb1 I:+206487,00,00,00
2015.07.10 10:55:33.770 0: HMLAN_Parse: hmusb1 R:R772D4A61 stat:0001 t:0002DD65 d:FF r:FFB0     m:9A 8002 206487 1ACE1F 01020C004D
2015.07.10 10:55:36.803 0: HMLAN_Parse: hmlan1 R:E20DFE1   stat:0000 t:00039FC1 d:FF r:FFD2     m:18 8670 20DFE1 000000 00A343
2015.07.10 10:55:36.911 0: HMLAN_Send:  hmusb1 S:S772D57D6 stat:  00 t:00000000 d:01 r:772D57D6 m:19 A112 1ACE1F 20DFE1 
2015.07.10 10:55:36.943 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0003A03A d:FF r:FFD8     m:18 A112 1ACE1F 20DFE1 
2015.07.10 10:55:36.961 0: HMLAN_Parse: hmusb1 R:E20DFE1   stat:0000 t:0002E961 d:FF r:FFC6     m:18 8670 20DFE1 000000 00A343
2015.07.10 10:55:37.050 0: HMLAN_Parse: hmlan1 R:E20DFE1   stat:0000 t:0003A0BA d:FF r:FFD2     m:18 8002 20DFE1 1ACE1F 00
2015.07.10 10:55:37.080 0: HMLAN_Parse: hmusb1 R:R772D4A61 stat:0081 t:0002EA60 d:FF r:FFC6     m:18 8002 20DFE1 1ACE1F 00
2015.07.10 10:55:37.105 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0003A0F1 d:FF r:FFD9     m:19 A112 1ACE1F 20DFE1 
2015.07.10 10:55:37.178 0: HMLAN_Parse: hmlan1 R:E1936FF   stat:0000 t:0003A13B d:FF r:FFC5     m:D2 8670 1936FF 000000 00AE42
2015.07.10 10:55:37.283 0: HMLAN_Send:  hmusb1 S:S772D5937 stat:  00 t:00000000 d:01 r:772D5937 m:D3 A112 1ACE1F 1936FF 
2015.07.10 10:55:37.309 0: HMLAN_Parse: hmlan1 R:E20DFE1   stat:0000 t:0003A170 d:FF r:FFD2     m:19 8002 20DFE1 1ACE1F 00
2015.07.10 10:55:37.339 0: HMLAN_Parse: hmusb1 R:E1936FF   stat:0000 t:0002EADC d:FF r:FFB2     m:D2 8670 1936FF 000000 00AE42
2015.07.10 10:55:37.354 0: HMLAN_Parse: hmusb1 R:R772D57D6 stat:0001 t:0002EB17 d:FF r:FFC6     m:19 8002 20DFE1 1ACE1F 00
2015.07.10 10:55:37.459 0: HMLAN_Send:  hmusb1 S:+20DFE1,02,00,00
2015.07.10 10:55:37.462 0: HMLAN_Send:  hmusb1 S:S772D59E7 stat:  00 t:00000000 d:01 r:772D59E7 m:1A A001 1ACE1F 20DFE1 010E
2015.07.10 10:55:37.473 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0003A1DB d:FF r:FFD8     m:D3 A112 1ACE1F 1936FF 
2015.07.10 10:55:37.488 0: HMLAN_Parse: hmlan1 R:E1936FF   stat:0000 t:0003A25E d:FF r:FFC6     m:D3 8002 1936FF 1ACE1F 00
2015.07.10 10:55:37.520 0: HMLAN_Parse: hmusb1 R:R772D5937 stat:0001 t:0002EC04 d:FF r:FFB3     m:D3 8002 1936FF 1ACE1F 00
2015.07.10 10:55:37.626 0: HMLAN_Send:  hmusb1 S:+1936FF,02,00,00
2015.07.10 10:55:37.628 0: HMLAN_Send:  hmusb1 S:S772D5A8D stat:  00 t:00000000 d:01 r:772D5A8D m:D4 A001 1ACE1F 1936FF 010E
2015.07.10 10:55:37.643 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0003A2BE d:FF r:FFD8     m:1A A001 1ACE1F 20DFE1 010E
2015.07.10 10:55:37.694 0: HMLAN_Parse: hmlan1 R:E20DFE1   stat:0000 t:0003A33F d:FF r:FFD2     m:1A 8002 20DFE1 1ACE1F 01020C003E
2015.07.10 10:55:37.738 0: HMLAN_Parse: hmusb1 R:R772D59E7 stat:0001 t:0002ECE4 d:FF r:FFC6     m:1A 8002 20DFE1 1ACE1F 01020C003E
2015.07.10 10:55:37.842 0: HMLAN_Send:  hmusb1 S:+20DFE1,02,00,00
2015.07.10 10:55:37.845 0: HMLAN_Send:  hmusb1 S:S772D5B66 stat:  00 t:00000000 d:01 r:772D5B66 m:1B A001 1ACE1F 20DFE1 020E
2015.07.10 10:55:37.855 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0003A37E d:FF r:FFD8     m:D4 A001 1ACE1F 1936FF 010E
2015.07.10 10:55:37.890 0: HMLAN_Parse: hmlan1 R:E1936FF   stat:0000 t:0003A403 d:FF r:FFC7     m:D4 8002 1936FF 1ACE1F 01020C0051
2015.07.10 10:55:37.941 0: HMLAN_Parse: hmusb1 R:R772D5A8D stat:0001 t:0002EDA8 d:FF r:FFB1     m:D4 8002 1936FF 1ACE1F 01020C0051
2015.07.10 10:55:38.046 0: HMLAN_Send:  hmusb1 S:+1936FF,02,00,00
2015.07.10 10:55:38.049 0: HMLAN_Send:  hmusb1 S:S772D5C32 stat:  00 t:00000000 d:01 r:772D5C32 m:D5 A001 1ACE1F 1936FF 020E
2015.07.10 10:55:38.051 0: HMLAN_Send:  hmusb1 I:K
2015.07.10 10:55:38.071 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0003A43E d:FF r:FFD9     m:1B A001 1ACE1F 20DFE1 020E
2015.07.10 10:55:38.091 0: HMLAN_Parse: hmlan1 R:E20DFE1   stat:0000 t:0003A4BE d:FF r:FFD2     m:1B 8002 20DFE1 1ACE1F 01020C003E
2015.07.10 10:55:38.137 0: HMLAN_Parse: hmusb1 R:R772D5B66 stat:0001 t:0002EE64 d:FF r:FFC5     m:1B 8002 20DFE1 1ACE1F 01020C003E
2015.07.10 10:55:38.242 0: HMLAN_Send:  hmusb1 S:+20DFE1,02,00,00
2015.07.10 10:55:38.244 0: HMLAN_Send:  hmusb1 S:S772D5CF5 stat:  00 t:00000000 d:01 r:772D5CF5 m:1C A001 1ACE1F 20DFE1 030E
2015.07.10 10:55:38.254 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0003A51F d:FF r:FFD8     m:D5 A001 1ACE1F 1936FF 020E
2015.07.10 10:55:38.275 0: HMLAN_Parse: hmusb1 V:03C7 sNo:KEQ1111271 d:263408 O:1ACE1F t:0002EEE9 IDcnt:0012 L:7 %
2015.07.10 10:55:38.306 0: HMLAN_Parse: hmlan1 R:E1936FF   stat:0000 t:0003A5A4 d:FF r:FFC7     m:D5 8002 1936FF 1ACE1F 01020C004B
2015.07.10 10:55:38.354 0: HMLAN_Parse: hmusb1 R:R772D5C32 stat:0001 t:0002EF48 d:FF r:FFB8     m:D5 8002 1936FF 1ACE1F 01020C004B
2015.07.10 10:55:38.459 0: HMLAN_Send:  hmusb1 S:+1936FF,02,00,00
2015.07.10 10:55:38.461 0: HMLAN_Send:  hmusb1 S:S772D5DD0 stat:  00 t:00000000 d:01 r:772D5DD0 m:D6 A001 1ACE1F 1936FF 030E
2015.07.10 10:55:38.672 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0003A5DF d:FF r:FFD8     m:1C A001 1ACE1F 20DFE1 030E
2015.07.10 10:55:38.689 0: HMLAN_Parse: hmlan1 R:E20DFE1   stat:0000 t:0003A65F d:FF r:FFD2     m:1C 8002 20DFE1 1ACE1F 01020C003E
2015.07.10 10:55:38.707 0: HMLAN_Send:  hmusb1 I:+20DFE1,00,00,00
2015.07.10 10:55:38.728 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0003A6BF d:FF r:FFD9     m:D6 A001 1ACE1F 1936FF 030E
2015.07.10 10:55:38.747 0: HMLAN_Parse: hmusb1 R:R772D5CF5 stat:0001 t:0002F004 d:FF r:FFC6     m:1C 8002 20DFE1 1ACE1F 01020C003E
2015.07.10 10:55:38.762 0: HMLAN_Parse: hmusb1 R:R772D5DD0 stat:0001 t:0002F0E8 d:FF r:FFB4     m:D6 8002 1936FF 1ACE1F 01020C004A
2015.07.10 10:55:38.781 0: HMLAN_Send:  hmusb1 I:+1936FF,00,00,00
2015.07.10 10:55:38.803 0: HMLAN_Parse: hmlan1 R:E1936FF   stat:0000 t:0003A744 d:FF r:FFC6     m:D6 8002 1936FF 1ACE1F 01020C004A
2015.07.10 10:55:42.667 0: HMLAN_Send:  hmlan1 I:K
2015.07.10 10:55:42.677 0: HMLAN_Parse: hmlan1 V:03C4 sNo:JEQ0315335 d:1C671E O:1ACE1F t:0003B6C1 IDcnt:000C L:8 %
2015.07.10 10:55:42.982 0: HMLAN_Parse: hmlan1 R:E266EA5   stat:0000 t:0003B7E8 d:FF r:FFCA     m:0E 805E 266EA5 1ACE1F 0000000000000000000000
2015.07.10 10:55:43.124 0: HMLAN_Parse: hmusb1 R:E266EA5   stat:0000 t:00030186 d:FF r:FFC7     m:0E 805E 266EA5 1ACE1F 0000000000000000000000
2015.07.10 10:56:01.848 0: HMLAN_Parse: hmusb1 R:E266EA5   stat:0000 t:00034B3A d:FF r:FFC7     m:0F 805E 266EA5 1ACE1F 0000000000000000000000
2015.07.10 10:56:01.978 0: HMLAN_Parse: hmlan1 R:E266EA5   stat:0000 t:0004019E d:FF r:FFCC     m:0F 805E 266EA5 1ACE1F 0000000000000000000000
2015.07.10 10:56:03.057 0: HMLAN_Send:  hmusb1 I:K
2015.07.10 10:56:03.097 0: HMLAN_Parse: hmusb1 V:03C7 sNo:KEQ1111271 d:263408 O:1ACE1F t:00035008 IDcnt:0012 L:7 %
2015.07.10 10:56:03.693 0: HMLAN_Parse: hmlan1 R:E206278   stat:0000 t:000408D2 d:FF r:FFB5     m:25 8670 206278 000000 00AE46
2015.07.10 10:56:03.783 0: HMLAN_Send:  hmusb1 S:S772DC0C9 stat:  00 t:00000000 d:01 r:772DC0C9 m:26 A112 1ACE1F 206278 
2015.07.10 10:56:03.834 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:00040960 d:FF r:FFD9     m:26 A112 1ACE1F 206278 
2015.07.10 10:56:03.964 0: HMLAN_Parse: hmlan1 R:E206278   stat:0000 t:000409E2 d:FF r:FFB4     m:26 8002 206278 1ACE1F 00
2015.07.10 10:56:04.034 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:00040A28 d:FF r:FFD9     m:26 A112 1ACE1F 206278 
2015.07.10 10:56:04.234 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:00040AF0 d:FF r:FFD9     m:26 A112 1ACE1F 206278 
2015.07.10 10:56:04.364 0: HMLAN_Parse: hmlan1 R:E206278   stat:0000 t:00040B72 d:FF r:FFB2     m:26 8002 206278 1ACE1F 00
2015.07.10 10:56:04.408 0: HMLAN_Parse: hmusb1 R:R772DC0C9 stat:0008 t:00000000 d:FF r:7FFF     m:26 A112 1ACE1F 206278 
2015.07.10 10:56:04.410 0: HMLAN_Parse: hmusb1 no ACK from 206278
2015.07.10 10:56:04.610 0: HMLAN_Send:  hmusb1 S:+206278,02,00,00
2015.07.10 10:56:04.612 0: HMLAN_Send:  hmusb1 S:S772DC44D stat:  00 t:00000000 d:01 r:772DC44D m:27 A001 1ACE1F 206278 010E
2015.07.10 10:56:04.732 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:00040CE2 d:FF r:FFD9     m:27 A001 1ACE1F 206278 010E
2015.07.10 10:56:04.863 0: HMLAN_Parse: hmlan1 R:E206278   stat:0000 t:00040D65 d:FF r:FFB2     m:27 8002 206278 1ACE1F 01020C0063
2015.07.10 10:56:04.932 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:00040DAA d:FF r:FFD9     m:27 A001 1ACE1F 206278 010E
2015.07.10 10:56:05.064 0: HMLAN_Parse: hmlan1 R:E206278   stat:0000 t:00040E2E d:FF r:FFB3     m:27 8002 206278 1ACE1F 01020C0060
2015.07.10 10:56:05.133 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:00040E72 d:FF r:FFD9     m:27 A001 1ACE1F 206278 010E
2015.07.10 10:56:05.263 0: HMLAN_Parse: hmlan1 R:E206278   stat:0000 t:00040EF5 d:FF r:FFB3     m:27 8002 206278 1ACE1F 01020C005E
2015.07.10 10:56:05.309 0: HMLAN_Parse: hmusb1 R:R772DC44D stat:0008 t:00000000 d:FF r:7FFF     m:27 A001 1ACE1F 206278 010E
2015.07.10 10:56:05.311 0: HMLAN_Parse: hmusb1 no ACK from 206278
2015.07.10 10:56:05.354 0: HMLAN_Send:  hmusb1 S:+206278,02,00,00
2015.07.10 10:56:05.357 0: HMLAN_Send:  hmusb1 S:S772DC716 stat:  00 t:00000000 d:01 r:772DC716 m:28 A001 1ACE1F 206278 020E
2015.07.10 10:56:05.468 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:00040FC2 d:FF r:FFD8     m:28 A001 1ACE1F 206278 020E
2015.07.10 10:56:05.599 0: HMLAN_Parse: hmlan1 R:E206278   stat:0000 t:00041045 d:FF r:FFB3     m:28 8002 206278 1ACE1F 01020C0062
2015.07.10 10:56:05.668 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0004108A d:FF r:FFD8     m:28 A001 1ACE1F 206278 020E
2015.07.10 10:56:05.800 0: HMLAN_Parse: hmlan1 R:E206278   stat:0000 t:0004110E d:FF r:FFB5     m:28 8002 206278 1ACE1F 01020C0063
2015.07.10 10:56:05.869 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:00041153 d:FF r:FFD8     m:28 A001 1ACE1F 206278 020E
2015.07.10 10:56:06.001 0: HMLAN_Parse: hmlan1 R:E206278   stat:0000 t:000411D6 d:FF r:FFB4     m:28 8002 206278 1ACE1F 01020C005D
2015.07.10 10:56:06.072 0: HMLAN_Parse: hmusb1 R:R772DC716 stat:0008 t:00000000 d:FF r:7FFF     m:28 A001 1ACE1F 206278 020E
2015.07.10 10:56:06.074 0: HMLAN_Parse: hmusb1 no ACK from 206278
2015.07.10 10:56:06.257 0: HMLAN_Send:  hmusb1 S:+206278,02,00,00
2015.07.10 10:56:06.259 0: HMLAN_Send:  hmusb1 S:S772DCABC stat:  00 t:00000000 d:01 r:772DCABC m:29 A001 1ACE1F 206278 030E
2015.07.10 10:56:06.364 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:00041342 d:FF r:FFD8     m:29 A001 1ACE1F 206278 030E
2015.07.10 10:56:06.496 0: HMLAN_Parse: hmlan1 R:E206278   stat:0000 t:000413C5 d:FF r:FFB4     m:29 8002 206278 1ACE1F 01020C0060
2015.07.10 10:56:06.515 0: HMLAN_Send:  hmusb1 I:+206278,00,00,00
2015.07.10 10:56:06.567 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0004140B d:FF r:FFD8     m:29 A001 1ACE1F 206278 030E
2015.07.10 10:56:06.697 0: HMLAN_Parse: hmlan1 R:E206278   stat:0000 t:0004148F d:FF r:FFB4     m:29 8002 206278 1ACE1F 01020C005F
2015.07.10 10:56:06.766 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:000414D4 d:FF r:FFD8     m:29 A001 1ACE1F 206278 030E
2015.07.10 10:56:06.897 0: HMLAN_Parse: hmlan1 R:E206278   stat:0000 t:00041557 d:FF r:FFB4     m:29 8002 206278 1ACE1F 01020C005F
2015.07.10 10:56:06.968 0: HMLAN_Parse: hmusb1 R:R772DCABC stat:0008 t:00000000 d:FF r:7FFF     m:29 A001 1ACE1F 206278 030E
2015.07.10 10:56:06.970 0: HMLAN_Parse: hmusb1 no ACK from 206278
2015.07.10 10:56:07.463 0: HMLAN_Parse: hmlan1 R:E1D252E   stat:0000 t:0004178D d:FF r:FFC7     m:D8 8670 1D252E 000000 00B13C
2015.07.10 10:56:07.553 0: HMLAN_Send:  hmusb1 S:S772DCF85 stat:  00 t:00000000 d:01 r:772DCF85 m:D9 A112 1ACE1F 1D252E

martinp876 · 11 Juli 2015, 07:30:49

Der dimmer sendet unaufgefordert seinen status und hat den messagezaehler auf 2. Daran kann man einen neustart erkennen... eigentlich sehr gut. Warum das gesendet wird, autonom, ist mir nicht klar.
Passiert dies immer bei fhemrestart ?

frank · 11 Juli 2015, 20:33:33

ZitatPassiert dies immer bei fhemrestart ?

nein.

wahrscheinlich nur bei poweron. obwohl ich nun in den logs von einem dimmer 2-3 mal einen poweron gefunden habe, die mich ein wenig stutzig machen, ob da überhaupt ein netzausfall gewesen ist. ich werde das nun weiter beobachten.

ZitatDer dimmer sendet unaufgefordert seinen status und hat den messagezaehler auf 2.

ok, und bei dem anderen dimmer immer msgnummer 0. ich hatte mich nur gewundert, dass ein poweron immer 3x hintereinander kommt. das ist nun klar.

ZitatWarum das gesendet wird, autonom, ist mir nicht klar.

da mit dem netzausfall auch fhem auf der fritzbox abgeschmiert ist, und ein neustart 1-2 min dauert, müssen die dimmer wohl auch so lange ihre autonomen messages senden. ich hatte schon den verdacht, dass die infos über einen poweron durch den langen restart von fhem verloren gehen könnten.

frank · 20 Juli 2015, 18:55:30

hallo martin,

könntest du das powerOn beim HM-ES-PMSw1-Pl noch etwas entschärfen. bisher werden immer 3 poweron gemeldet. die letzten 2 könnte man wahrscheinlich gut rausfiltern, da sie, im gegensatz zum ersten, durch das cyclische powerevent "845E" generiert werden. dieses cyclische powerevent hat einen eigenen msgcounter, wie ich letztens schon einmal berichtet habe.

hier das log von 2 netzausfällen. jeweils die erste msg ist von vor dem blackout. die blackout meldungen wurden durch ein notify, welches auf powerOn triggert, ins log geschrieben. am ende habe ich noch die msg, die jeweils kein powerON mehr generiert.

Code Auswählen

2015.07.20 16:51:12.154 0: HMLAN_Parse: hmlan1 R:E24AF1D   stat:0000 t:33EF3C18 d:FF r:FFA8     m:28 845E 24AF1D 000000 801C220000000000094601
2015.07.20 16:56:42.371 0: HMLAN_Parse: hmlan1 R:E24AF1D   stat:0000 t:33F4462C d:FF r:FFA9     m:01 A410 24AF1D 1ACE1F 06010000
2015.07.20 16:56:42.516 0: HMLAN_Parse: hmusb1 R:E1ACE1F   stat:0000 t:063E32A2 d:FF r:FFD2     m:01 8002 1ACE1F 24AF1D 00
2015.07.20 16:56:45.111 0: HMLAN_Parse: hmlan1 R:E24AF1D   stat:0000 t:33F450E0 d:FF r:FFA9     m:01 A410 24AF1D 1ACE1F 06010000
2015.07.20 16:56:45.236 0: HMLAN_Parse: hmusb1 R:E1ACE1F   stat:0000 t:063E3D55 d:FF r:FFD2     m:01 8002 1ACE1F 24AF1D 00
2015.07.20 16:56:45.577 0: HMLAN_Parse: hmlan1 R:E24AF1D   stat:0000 t:33F452B2 d:FF r:FFA9     m:02 A45F 24AF1D 1ACE1F 80000000000000000935FE
2015.07.20 16:56:45.747 1: ----- BLACKOUT ----- SwitchES01 powerOn: 2015-07-20 16:56:45
2015.07.20 16:56:46.234 0: HMLAN_Parse: hmusb1 R:E1ACE1F   stat:0000 t:063E3F22 d:FF r:FFD2     m:02 8002 1ACE1F 24AF1D 00
2015.07.20 16:56:46.317 0: HMLAN_Parse: hmlan1 R:E24AF1D   stat:0000 t:33F45596 d:FF r:FFA8     m:02 A45F 24AF1D 1ACE1F 80000000000000000935FE
2015.07.20 16:56:46.455 0: HMLAN_Parse: hmusb1 R:E1ACE1F   stat:0000 t:063E4206 d:FF r:FFD2     m:02 8002 1ACE1F 24AF1D 00
2015.07.20 16:59:07.107 0: HMLAN_Parse: hmlan1 R:E24AF1D   stat:0000 t:33F67BA0 d:FF r:FFA9     m:01 845E 24AF1D 000000 8000000000000000092B02
2015.07.20 16:59:07.273 1: ----- BLACKOUT ----- SwitchES01 powerOn: 2015-07-20 16:59:07
2015.07.20 17:01:17.858 0: HMLAN_Parse: hmlan1 R:E24AF1D   stat:0000 t:33F87A70 d:FF r:FFA8     m:02 845E 24AF1D 000000 80000000000000000926FF
2015.07.20 17:01:18.024 1: ----- BLACKOUT ----- SwitchES01 powerOn: 2015-07-20 17:01:17
2015.07.20 17:04:18.359 0: HMLAN_Parse: hmlan1 R:E24AF1D   stat:0000 t:33FB3B9C d:FF r:FFAB     m:03 845E 24AF1D 000000 8000000000000000093701


2015.07.20 17:11:53.109 0: HMLAN_Parse: hmlan1 R:E24AF1D   stat:0000 t:34022C36 d:FF r:FFA4     m:06 845E 24AF1D 000000 8000000000000000095E01
2015.07.20 17:13:56.973 0: HMLAN_Parse: hmlan1 R:E24AF1D   stat:0000 t:3404101E d:FF r:FFA9     m:01 A410 24AF1D 1ACE1F 06010000
2015.07.20 17:13:57.122 0: HMLAN_Parse: hmusb1 R:E1ACE1F   stat:0000 t:064DFBFE d:FF r:FFD1     m:01 8002 1ACE1F 24AF1D 00
2015.07.20 17:13:58.479 0: HMLAN_Parse: hmlan1 R:E24AF1D   stat:0000 t:34041600 d:FF r:FFA7     m:02 A45F 24AF1D 1ACE1F 8000000000000000096080
2015.07.20 17:13:58.650 1: ----- BLACKOUT ----- SwitchES01 powerOn: 2015-07-20 17:13:58
2015.07.20 17:13:59.242 0: HMLAN_Parse: hmusb1 R:E1ACE1F   stat:0000 t:064E01DB d:FF r:FFD1     m:02 8002 1ACE1F 24AF1D 00
2015.07.20 17:16:21.709 0: HMLAN_Parse: hmlan1 R:E24AF1D   stat:0000 t:34064591 d:FF r:FFA8     m:01 845E 24AF1D 000000 8000000000000000095802
2015.07.20 17:16:21.877 1: ----- BLACKOUT ----- SwitchES01 powerOn: 2015-07-20 17:16:21
2015.07.20 17:18:32.459 0: HMLAN_Parse: hmlan1 R:E24AF1D   stat:0000 t:34084460 d:FF r:FFA9     m:02 845E 24AF1D 000000 8000000000000000095FFE
2015.07.20 17:18:32.625 1: ----- BLACKOUT ----- SwitchES01 powerOn: 2015-07-20 17:18:32
2015.07.20 17:21:32.960 0: HMLAN_Parse: hmlan1 R:E24AF1D   stat:0000 t:340B058C d:FF r:FFA8     m:03 845E 24AF1D 000000 8000000000000000095EFE

gruss frank

martinp876 · 21 Juli 2015, 19:49:52

Schau ich mir an.

frank · 23 Juli 2015, 14:23:40

Zitat von: martinp876 am 21 Juli 2015, 19:49:52
Schau ich mir an.

prima.

wenn du dann dabei bist, schau auch gleich noch beim poweron für die hm-lc-sw1-fm nach. die poweron message vom aktor kommt regelmässig, aber fhem generiert (fast) kein poweron. anbei logausschnitte von 3x netzspannungszufuhr. das poweron wird nur beim 2ten mal generiert. wahrscheinlich kein zufall, dass genau bei diesem funktionierenden fall ein "aktives ack" gesendet wird.

Code Auswählen

2015.07.23 10:40:25.018 0: HMLAN_Parse: hmlan1 R:E285A44   stat:0000 t:0944C386 d:FF r:FFC4     m:00 A410 285A44 1ACE1F 06000000
2015.07.23 10:40:25.047 0: HMLAN_Parse: hmusb1 R:E285A44   stat:0000 t:0943B15C d:FF r:FFC0     m:00 A410 285A44 1ACE1F 06000000
2015.07.23 10:40:25.139 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0944C400 d:FF r:FFD2     m:00 8002 1ACE1F 285A44 00

2015.07.23 13:06:21.543 0: HMLAN_Parse: hmlan1 R:E285A44   stat:0000 t:00217038 d:FF r:FFC5     m:00 A410 285A44 1ACE1F 06000000
2015.07.23 13:06:21.576 0: HMLAN_Send:  hmlan1 I:-285A44
2015.07.23 13:06:21.579 0: HMLAN_Send:  hmusb1 I:+285A44,00,00,
2015.07.23 13:06:21.635 0: HMLAN_Send:  hmusb1 S:+285A44,00,00,00
2015.07.23 13:06:21.637 0: HMLAN_Send:  hmusb1 S:SBA97B75C stat:  00 t:00000000 d:01 r:BA97B75C m:00 8002 1ACE1F 285A44 00
2015.07.23 13:06:22.048 1: ----- BLACKOUT ----- SwitchUP02 -> L:3 FI:2 LS:7 NAME:Garage_KL
2015.07.23 13:06:22.262 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:0021711D d:FF r:FFD1     m:00 8002 1ACE1F 285A44 00
2015.07.23 13:06:22.282 0: HMLAN_Parse: hmusb1 R:E285A44   stat:0000 t:00246A16 d:FF r:FFC2     m:00 A410 285A44 1ACE1F 06000000
2015.07.23 13:06:22.294 0: HMLAN_Parse: hmusb1 R:E1ACE1F   stat:0000 t:00246A8F d:FF r:FFCF     m:00 8002 1ACE1F 285A44 00
2015.07.23 13:06:22.323 0: HMLAN_Parse: hmusb1 R:RBA97B75C stat:0002 t:00000000 d:FF r:7FFF     m:00 8002 1ACE1F 285A44 00

2015.07.23 13:08:36.091 0: HMLAN_Parse: hmlan1 R:E285A44   stat:0000 t:00237DDD d:FF r:FFC4     m:00 A410 285A44 1ACE1F 06000000
2015.07.23 13:08:36.114 0: HMLAN_Parse: hmusb1 R:E285A44   stat:0000 t:002677A5 d:FF r:FFC3     m:00 A410 285A44 1ACE1F 06000000
2015.07.23 13:08:36.211 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:00237E56 d:FF r:FFD2     m:00 8002 1ACE1F 285A44 00

gruss frank

frank · 30 Juli 2015, 20:00:14

das seltsame verhalten der hm-lc-sw1-fm bei poweron ist einigermassen geklärt.
wenn dieser aktor selten benutzt wird und autoreadreg=0 gesetzt ist, werden die poweron messages des schalters normalerweise als duplicates verworfen. nur wenn nach restart von fhem "$devH->{lastMsg}" nicht definiert ist, gelangt die message nach CUL_HM_CommonParse und wird als poweron registriert.

Code Auswählen

  # +++++ check for duplicate or repeat ++++
  my $msgX = "No:$mNo - t:$mTp s:$src d:$dst ".($p?$p:"");
########## frank ##############
  if($src ~~ ["285A44","285A54","24AF1D","1F64D8","266A86"]) {
    Log(1,"----- CUL_HM ----- msgL:".(($devH->{lastMsg})?$devH->{lastMsg}:"not defined")." msg:$msgX");
  }
###############################															 
  if($devH->{lastMsg} && $devH->{lastMsg} eq $msgX) { #duplicate -lost 'ack'?
           
    if(   $devH->{helper}{rpt}                           #was responded
       && $devH->{helper}{rpt}{IO}  eq $ioName           #from same IO
       && $devH->{helper}{rpt}{flg} eq substr($msg,5,1)  #not from repeater
       && $devH->{helper}{rpt}{ts}  < gettimeofday()-0.24 # again if older then 240ms (typ repeat time)
                                                          #todo: hack since HMLAN sends duplicate status messages
       ){
      my $ack = $devH->{helper}{rpt}{ack};#shorthand
      my $i=0;
      $devH->{helper}{rpt}{ts} = gettimeofday();
      CUL_HM_SndCmd(${$ack}[$i++],${$ack}[$i++]) while ($i<@{$ack});
      Log3 $name,4,"CUL_HM $name dupe: repeat ".scalar(@{$ack})." ack, dont process";
    }
    else{
      Log3 $name,4,"CUL_HM $name dupe: dont process";
    }
    CUL_HM_pushEvnts();
    $defs{$_}{".noDispatchVars"} = 1 foreach (grep !/^$devH->{NAME}$/,@entities);
    CUL_HM_sndIfOpen("x:$ioName");
########## frank ##############
  if($src ~~ ["285A44","285A54","24AF1D","1F64D8","266A86"]) {
    Log(1,"----- CUL_HM ----- ioH:".(($devH->{helper}{rpt}{IO})?$devH->{helper}{rpt}{IO}:"not defined")." io:$ioName flH:".(($devH->{helper}{rpt}{flg})?$devH->{helper}{rpt}{flg}:"not defined")." fl:".(substr($msg,5,1))." tH:".(($devH->{helper}{rpt}{ts})?$devH->{helper}{rpt}{ts}:"not defined")." t:".(gettimeofday()-0.24));
  }
###############################															 
    return (CUL_HM_pushEvnts(),$name,@entities); #return something to please dispatcher
  }

mit den eingebauten logzeilen und verbose=5 ergeben sich folgende logs

Code Auswählen

### 1. poweron nach restart #####

2015.07.30 12:14:36.829 0: HMLAN_Parse: hmlan1 R:E285A44   stat:0000 t:000CE257 d:FF r:FFBB     m:00 A410 285A44 1ACE1F 06000000
2015.07.30 12:14:36.840 1: ----- CUL_HM ----- msgL:not defined msg:No:00 - t:10 s:285A44 d:1ACE1F 06000000
2015.07.30 12:14:36.852 1: ----- CUL_HM ----- p:powerOn
2015.07.30 12:14:36.859 0: HMLAN_Send:  hmlan1 I:-285A44
2015.07.30 12:14:36.862 0: HMLAN_Send:  hmusb1 I:+285A44,00,00,
2015.07.30 12:14:36.925 0: HMLAN_Send:  hmusb1 S:+285A44,00,00,00
2015.07.30 12:14:36.927 0: HMLAN_Send:  hmusb1 S:SDE74DB8F stat:  00 t:00000000 d:01 r:DE74DB8F m:00 8002 1ACE1F 285A44 00
2015.07.30 12:14:36.931 5: CUL_HM SwitchUP02 protEvent:CMDs_done
2015.07.30 12:14:36.933 5: CUL_HM SwitchUP02 sent ACK:2
2015.07.30 12:14:37.424 1: ----- BLACKOUT ----- SwitchUP02(285A44) -> SwitchUP02
2015.07.30 12:14:37.486 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:000CE328 d:FF r:FFD7     m:00 8002 1ACE1F 285A44 00
2015.07.30 12:14:37.514 0: HMLAN_Parse: hmusb1 R:E285A44   stat:0000 t:02CB1953 d:FF r:FFBD     m:00 A410 285A44 1ACE1F 06000000
2015.07.30 12:14:37.525 1: ----- CUL_HM ----- msgL:No:00 - t:10 s:285A44 d:1ACE1F 06000000 msg:No:00 - t:10 s:285A44 d:1ACE1F 06000000
2015.07.30 12:14:37.527 4: CUL_HM SwitchUP02 dupe: dont process
2015.07.30 12:14:37.530 1: ----- CUL_HM ----- ioH:hmlan1 io:hmusb1 flH:A fl:A tH:1438251276.85735 t:1438251277.29052
2015.07.30 12:14:37.534 0: HMLAN_Parse: hmusb1 R:E1ACE1F   stat:0000 t:02CB19CC d:FF r:FFD4     m:00 8002 1ACE1F 285A44 00
2015.07.30 12:14:37.547 0: HMLAN_Parse: hmusb1 R:RDE74DB8F stat:0002 t:00000000 d:FF r:7FFF     m:00 8002 1ACE1F 285A44 00

### jeder weitere poweron #####

2015.07.30 13:05:53.921 0: HMLAN_Parse: hmlan1 R:E285A44   stat:0000 t:003BD7DD d:FF r:FFBD     m:00 A410 285A44 1ACE1F 06000000
2015.07.30 13:05:53.931 1: ----- CUL_HM ----- msgL:No:00 - t:10 s:285A44 d:1ACE1F 06000000 msg:No:00 - t:10 s:285A44 d:1ACE1F 06000000
2015.07.30 13:05:53.936 5: CUL_HM SwitchUP02 protEvent:CMDs_done
2015.07.30 13:05:53.938 4: CUL_HM SwitchUP02 dupe: repeat 2 ack, dont process
2015.07.30 13:05:53.943 1: ----- CUL_HM ----- ioH:hmlan1 io:hmlan1 flH:A fl:A tH:1438254353.93308 t:1438254353.70352
2015.07.30 13:05:53.950 0: HMLAN_Parse: hmusb1 R:E285A44   stat:0000 t:02FA0D05 d:FF r:FFBC     m:00 A410 285A44 1ACE1F 06000000
2015.07.30 13:05:53.959 1: ----- CUL_HM ----- msgL:No:00 - t:10 s:285A44 d:1ACE1F 06000000 msg:No:00 - t:10 s:285A44 d:1ACE1F 06000000
2015.07.30 13:05:53.960 4: CUL_HM SwitchUP02 dupe: dont process
2015.07.30 13:05:53.963 1: ----- CUL_HM ----- ioH:hmlan1 io:hmusb1 flH:A fl:A tH:1438254353.93308 t:1438254353.72319
2015.07.30 13:05:54.042 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:003BD856 d:FF r:FFD6     m:00 8002 1ACE1F 285A44 00

ich habe jetzt erstmal autoreadreg > 0 gesetzt. aber vielleicht könnte man ja auch den einstieg in die duplicate-prüfung anpassen.

gruss frank

martinp876 · 31 Juli 2015, 21:43:59

klar soweit.
Duplicate bei mehreren IOs ist ein Problem, da es zu langen Verzögerungen kommen kann.
ist eine kritische Sache, da poweron auch schnell hintereinander kommen kann.
Ich werden einmal schauen - wirklich Problematisch ist es eher nicht, meine ich. Es kommt ja nicht irgendwann sondern kurz nach PON, also im Zusammenhang

frank · 01 August 2015, 12:58:16

ZitatIch werden einmal schauen - wirklich Problematisch ist es eher nicht, meine ich. Es kommt ja nicht irgendwann sondern kurz nach PON, also im Zusammenhang

jetzt habe ich ein verständnis problem. vielleicht nochmal. das "problem" ist, dass die powerOn message verworfen wird (duplicate), wenn zwischen 2 powerOn ereignissen keine weitere message vom schalter empfangen wird. man kann dieses verhalten mit autoreadreg!=0 umgehen, da in diesem fall automatisch eine weitere message (zb statusrequest) erzwungen wird. man muss es nur wissen.

hier aber noch ein fehlverhalten von einem Dim1TPBU-FM bei restart von fhem. der automatische statusrequest auf chn3 erzeugt regelmässig ein powerOn event, obwohl kein poweron erfolgt ist:

Code Auswählen

2015.07.30 20:10:14.979 0: Server started with 325 defined entities (version $Id: fhem.pl 8574 2015-05-14 07:59:32Z rudolfkoenig $, os linux, user root, pid 1849)
2015.07.30 20:10:15.061 0: HMLAN_Send:  hmusb1 I:+266A86,00,00,00
2015.07.30 20:10:31.229 0: HMLAN_Send:  hmusb1 S:+266A86,00,00,00
2015.07.30 20:10:31.231 0: HMLAN_Send:  hmusb1 S:SE0289008 stat:  00 t:00000000 d:01 r:E0289008 m:02 A001 1ACE1F 266A86 010E
2015.07.30 20:10:35.393 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:01C0A673 d:FF r:FFD6     m:02 A001 1ACE1F 266A86 010E
2015.07.30 20:10:35.464 0: HMLAN_Parse: hmlan1 R:E266A86   stat:0000 t:01C0A6F3 d:FF r:FFBF     m:02 A410 266A86 1ACE1F 060100003A00
2015.07.30 20:10:35.473 1: ----- CUL_HM ----- msgL:not defined msg:No:02 - t:10 s:266A86 d:1ACE1F 060100003A00
2015.07.30 20:10:35.482 1: ----- CUL_HM ----- p:
2015.07.30 20:10:36.028 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:01C0A770 d:FF r:FFD6     m:02 8002 1ACE1F 266A86 00
2015.07.30 20:10:36.228 0: HMLAN_Parse: hmusb1 R:E266A86   stat:0000 t:00022B51 d:FF r:FFC6     m:02 A410 266A86 1ACE1F 060100003A00
2015.07.30 20:10:36.237 1: ----- CUL_HM ----- msgL:No:02 - t:10 s:266A86 d:1ACE1F 060100003A00 msg:No:02 - t:10 s:266A86 d:1ACE1F 060100003A00
2015.07.30 20:10:36.242 1: ----- CUL_HM ----- ioH:hmlan1 io:hmusb1 flH:A fl:A tH:1438279835.50478 t:1438279836.00187
2015.07.30 20:10:36.245 0: HMLAN_Parse: hmusb1 R:RE0289008 stat:0001 t:00022B56 d:FF r:FFC6     m:02 A410 266A86 1ACE1F 060100003A00
2015.07.30 20:10:36.259 1: ----- CUL_HM ----- msgL:No:02 - t:10 s:266A86 d:1ACE1F 060100003A00 msg:No:02 - t:10 s:266A86 d:1ACE1F 060100003A00
2015.07.30 20:10:36.355 0: HMLAN_Send:  hmusb1 S:+266A86,00,00,00
2015.07.30 20:10:36.357 0: HMLAN_Send:  hmusb1 S:SE028A3B6 stat:  00 t:00000000 d:01 r:E028A3B6 m:03 A001 1ACE1F 266A86 020E
2015.07.30 20:10:36.365 1: ----- CUL_HM ----- ioH:hmlan1 io:hmusb1 flH:A fl:A tH:1438279835.50478 t:1438279836.12527
2015.07.30 20:10:38.165 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:01C0BA94 d:FF r:FFD5     m:03 A001 1ACE1F 266A86 020E
2015.07.30 20:10:38.186 0: HMLAN_Parse: hmlan1 R:E266A86   stat:0000 t:01C0BB14 d:FF r:FFBE     m:03 A410 266A86 1ACE1F 060200003A00
2015.07.30 20:10:38.195 1: ----- CUL_HM ----- msgL:No:02 - t:10 s:266A86 d:1ACE1F 060100003A00 msg:No:03 - t:10 s:266A86 d:1ACE1F 060200003A00
2015.07.30 20:10:38.203 1: ----- CUL_HM ----- p:
2015.07.30 20:10:38.375 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:01C0BB91 d:FF r:FFD5     m:03 8002 1ACE1F 266A86 00
2015.07.30 20:10:38.509 0: HMLAN_Parse: hmusb1 R:E266A86   stat:0000 t:00023F71 d:FF r:FFC6     m:03 A410 266A86 1ACE1F 060200003A00
2015.07.30 20:10:38.519 1: ----- CUL_HM ----- msgL:No:03 - t:10 s:266A86 d:1ACE1F 060200003A00 msg:No:03 - t:10 s:266A86 d:1ACE1F 060200003A00
2015.07.30 20:10:38.525 1: ----- CUL_HM ----- ioH:hmlan1 io:hmusb1 flH:A fl:A tH:1438279838.21052 t:1438279838.28538
2015.07.30 20:10:38.529 0: HMLAN_Parse: hmusb1 R:RE028A3B6 stat:0001 t:00023F76 d:FF r:FFC6     m:03 A410 266A86 1ACE1F 060200003A00
2015.07.30 20:10:38.539 1: ----- CUL_HM ----- msgL:No:03 - t:10 s:266A86 d:1ACE1F 060200003A00 msg:No:03 - t:10 s:266A86 d:1ACE1F 060200003A00
2015.07.30 20:10:38.635 0: HMLAN_Send:  hmusb1 S:+266A86,00,00,00
2015.07.30 20:10:38.637 0: HMLAN_Send:  hmusb1 S:SE028AC9E stat:  00 t:00000000 d:01 r:E028AC9E m:04 A001 1ACE1F 266A86 030E
2015.07.30 20:10:38.644 1: ----- CUL_HM ----- ioH:hmlan1 io:hmusb1 flH:A fl:A tH:1438279838.21052 t:1438279838.40471
2015.07.30 20:10:39.488 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:01C0C375 d:FF r:FFD5     m:04 A001 1ACE1F 266A86 030E
2015.07.30 20:10:39.537 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:01C0C43E d:FF r:FFD6     m:04 A001 1ACE1F 266A86 030E
2015.07.30 20:10:39.906 0: HMLAN_Parse: hmusb1 R:E266A86   stat:0000 t:0002491B d:FF r:FFC6     m:04 A410 266A86 1ACE1F 060300003A00
2015.07.30 20:10:39.916 1: ----- CUL_HM ----- msgL:No:03 - t:10 s:266A86 d:1ACE1F 060200003A00 msg:No:04 - t:10 s:266A86 d:1ACE1F 060300003A00
2015.07.30 20:10:39.924 1: ----- CUL_HM ----- p:
2015.07.30 20:10:40.569 1: ----- BLACKOUT ----- DimPBU01(266A86) -> DimPBU01
2015.07.30 20:10:40.626 0: HMLAN_Parse: hmusb1 R:RE028AC9E stat:0001 t:00024920 d:FF r:FFC6     m:04 A410 266A86 1ACE1F 060300003A00
2015.07.30 20:10:40.644 1: ----- CUL_HM ----- msgL:No:04 - t:10 s:266A86 d:1ACE1F 060300003A00 msg:No:04 - t:10 s:266A86 d:1ACE1F 060300003A00
2015.07.30 20:10:40.682 1: ----- CUL_HM ----- ioH:hmusb1 io:hmusb1 flH:A fl:A tH:1438279840.64616 t:1438279840.44168
2015.07.30 20:10:40.890 0: HMLAN_Parse: hmlan1 R:E266A86   stat:0000 t:01C0C4BE d:FF r:FFBD     m:04 A410 266A86 1ACE1F 060300003A00
2015.07.30 20:10:40.903 1: ----- CUL_HM ----- msgL:No:04 - t:10 s:266A86 d:1ACE1F 060300003A00 msg:No:04 - t:10 s:266A86 d:1ACE1F 060300003A00
2015.07.30 20:10:40.915 1: ----- CUL_HM ----- ioH:hmusb1 io:hmlan1 flH:A fl:A tH:1438279840.64616 t:1438279840.67492
2015.07.30 20:10:40.918 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:01C0C53D d:FF r:FFD5     m:04 8002 1ACE1F 266A86 00

generiert durch diesen code:

Code Auswählen

      if ($st eq "dimmer"){
        push @evtEt,[$shash,1,"overload:".(($err&0x02)?"on":"off")];
        push @evtEt,[$shash,1,"overheat:".(($err&0x04)?"on":"off")];
        push @evtEt,[$shash,1,"reduced:" .(($err&0x08)?"on":"off")];
         #hack for blind  - other then behaved devices blind does not send
         #        a status info for chan 0 at power on
         #        chn3 (virtual chan) and not used up to now
         #        info from it is likely a power on!
        push @evtEt,[$devH,1,"powerOn:$tn"]   if($chn eq "03");
      }

hier noch das event-log. ausserdem erzeugen die channel unnötigerweise unreachable:

Code Auswählen

2015-07-30_20:10:19 DimPBU01 CMDs_pending
2015-07-30_20:10:34 DimPBU01_chn01 unreachable
2015-07-30_20:10:35 DimPBU01 chn:???  phys:0
2015-07-30_20:10:35 DimPBU01_chn01 off
2015-07-30_20:10:37 DimPBU01_Sw1_V01 unreachable
2015-07-30_20:10:38 DimPBU01_Sw1_V01 off
2015-07-30_20:10:39 DimUP01 off
2015-07-30_20:10:39 DimPBU01 powerOn: 2015-07-30 20:10:39
2015-07-30_20:10:39 DimPBU01 CMDs_done

gruss frank

martinp876 · 02 August 2015, 09:30:54

werde es "systematisch" machen - sollte man immer