HM-PB-2-FM und AES unzuverlässig, komische Reihenfolge in Events

Ralli · 12 September 2015, 07:48:10

Hallo zusammen,

ich beobachte folgende komischen Events eines HM-PB-2-FM, dessen Kanäle mit zwei virtuellen Buttons meiner vCCU gepeered sind:

Einmal mit HMLAN als IO:

Code Auswählen


2015-09-12 07:28:36 CUL_HM GEN_Rollo_Zentral_Device aesCommToDev: pending
2015-09-12 07:28:36 CUL_HM GEN_Rollo_Zentral_Device aesCommToDev: pending
2015-09-12 07:28:36 CUL_HM CCU_Btn8 trig_aes_GEN_Rollo_Zentral_Hoch: ok:73
2015-09-12 07:28:36 CUL_HM CCU_Btn8 trig_aes_GEN_Rollo_Zentral_Hoch: fail:74
2015-09-12 07:28:37 CUL_HM GEN_Rollo_Zentral_Device aesCommToDev: fail
2015-09-12 07:28:37 CUL_HM GEN_Rollo_Zentral_Hoch trig_aes_CCU: ok:73
2015-09-12 07:28:37 CUL_HM GEN_Rollo_Zentral_Hoch trig_aes_CCU: fail:74
2015-09-12 07:28:37 CUL_HM CCU_Btn8 trigLast: GEN_Rollo_Zentral_Hoch:short
2015-09-12 07:28:37 CUL_HM CCU_Btn8 trig_GEN_Rollo_Zentral_Hoch: short
2015-09-12 07:28:37 CUL_HM GEN_Rollo_Zentral_Device battery: ok
2015-09-12 07:28:37 CUL_HM GEN_Rollo_Zentral_Device CMDs_done
2015-09-12 07:28:37 CUL_HM GEN_Rollo_Zentral_Device GEN_Rollo_Zentral_Hoch Short
2015-09-12 07:28:38 CUL_HM GEN_Rollo_Zentral_Hoch Short (to GEN_Rollo_Zentral_Device)
2015-09-12 07:28:38 CUL_HM GEN_Rollo_Zentral_Hoch trigger: Short_74
2015-09-12 07:28:38 CUL_HM GEN_Rollo_Zentral_Hoch trigger_cnt: 74
2015-09-12 07:28:38 CUL_HM GEN_Rollo_Zentral_Device aesCommToDev: ok
2015-09-12 07:31:45 CUL_HM GEN_Rollo_Zentral_Device aesCommToDev: pending
2015-09-12 07:31:45 CUL_HM CCU_Btn8 trig_aes_GEN_Rollo_Zentral_Hoch: ok:74
2015-09-12 07:31:45 CUL_HM CCU_Btn8 trigLast: GEN_Rollo_Zentral_Hoch:short
2015-09-12 07:31:45 CUL_HM CCU_Btn8 trig_GEN_Rollo_Zentral_Hoch: short
2015-09-12 07:31:46 CUL_HM GEN_Rollo_Zentral_Device battery: ok
2015-09-12 07:31:46 CUL_HM GEN_Rollo_Zentral_Device CMDs_done
2015-09-12 07:31:46 CUL_HM GEN_Rollo_Zentral_Device GEN_Rollo_Zentral_Hoch Short
2015-09-12 07:31:46 CUL_HM GEN_Rollo_Zentral_Hoch trig_aes_CCU: ok:74
2015-09-12 07:31:46 CUL_HM GEN_Rollo_Zentral_Hoch Short (to GEN_Rollo_Zentral_Device)
2015-09-12 07:31:46 CUL_HM GEN_Rollo_Zentral_Hoch trigger: Short_75
2015-09-12 07:31:46 CUL_HM GEN_Rollo_Zentral_Hoch trigger_cnt: 75
2015-09-12 07:31:47 CUL_HM GEN_Rollo_Zentral_Device aesCommToDev: pending
2015-09-12 07:31:47 CUL_HM CCU_Btn8 trig_aes_GEN_Rollo_Zentral_Hoch: fail:75
2015-09-12 07:31:47 CUL_HM GEN_Rollo_Zentral_Device aesCommToDev: fail
2015-09-12 07:31:47 CUL_HM GEN_Rollo_Zentral_Hoch trig_aes_CCU: fail:75
2015-09-12 07:31:48 CUL_HM GEN_Rollo_Zentral_Device aesCommToDev: ok
2015-09-12 07:33:46 CUL_HM GEN_Rollo_Zentral_Device aesCommToDev: pending
2015-09-12 07:33:46 CUL_HM CCU_Btn8 trig_aes_GEN_Rollo_Zentral_Hoch: ok:75
2015-09-12 07:33:46 CUL_HM CCU_Btn8 trigLast: GEN_Rollo_Zentral_Hoch:short
2015-09-12 07:33:46 CUL_HM CCU_Btn8 trig_GEN_Rollo_Zentral_Hoch: short
2015-09-12 07:33:46 CUL_HM GEN_Rollo_Zentral_Device battery: ok
2015-09-12 07:33:46 CUL_HM GEN_Rollo_Zentral_Device CMDs_done
2015-09-12 07:33:46 CUL_HM GEN_Rollo_Zentral_Device GEN_Rollo_Zentral_Hoch Short
2015-09-12 07:33:47 CUL_HM GEN_Rollo_Zentral_Hoch trig_aes_CCU: ok:75
2015-09-12 07:33:47 CUL_HM GEN_Rollo_Zentral_Hoch Short (to GEN_Rollo_Zentral_Device)
2015-09-12 07:33:47 CUL_HM GEN_Rollo_Zentral_Hoch trigger: Short_76
2015-09-12 07:33:47 CUL_HM GEN_Rollo_Zentral_Hoch trigger_cnt: 76
2015-09-12 07:33:47 CUL_HM GEN_Rollo_Zentral_Device aesCommToDev: pending
2015-09-12 07:33:47 CUL_HM GEN_Rollo_Zentral_Device aesCommToDev: ok
2015-09-12 07:33:48 CUL_HM CCU_Btn8 trig_aes_GEN_Rollo_Zentral_Hoch: ok:76
2015-09-12 07:33:48 CUL_HM CCU_Btn8 trig_aes_GEN_Rollo_Zentral_Hoch: fail:76
2015-09-12 07:33:48 CUL_HM GEN_Rollo_Zentral_Device aesCommToDev: fail
2015-09-12 07:33:48 CUL_HM GEN_Rollo_Zentral_Hoch trig_aes_CCU: ok:76
2015-09-12 07:33:48 CUL_HM GEN_Rollo_Zentral_Hoch trig_aes_CCU: fail:76

Und einmal mit HMUSB mit IO:

Code Auswählen


2015-09-12 07:49:07 CUL_HM GEN_Rollo_Zentral_Device aesCommToDev: pending
2015-09-12 07:49:07 CUL_HM GEN_Rollo_Zentral_Device aesCommToDev: pending
2015-09-12 07:49:07 CUL_HM CCU_Btn8 trigLast: GEN_Rollo_Zentral_Hoch:short
2015-09-12 07:49:07 CUL_HM CCU_Btn8 trig_GEN_Rollo_Zentral_Hoch: short
2015-09-12 07:49:07 CUL_HM GEN_Rollo_Zentral_Device battery: ok
2015-09-12 07:49:07 CUL_HM GEN_Rollo_Zentral_Device CMDs_done
2015-09-12 07:49:07 CUL_HM GEN_Rollo_Zentral_Device GEN_Rollo_Zentral_Hoch Short
2015-09-12 07:49:08 CUL_HM GEN_Rollo_Zentral_Hoch Short (to GEN_Rollo_Zentral_Device)
2015-09-12 07:49:08 CUL_HM GEN_Rollo_Zentral_Hoch trigger: Short_77
2015-09-12 07:49:08 CUL_HM GEN_Rollo_Zentral_Hoch trigger_cnt: 77
2015-09-12 07:49:08 CUL_HM CCU_Btn8 trig_aes_GEN_Rollo_Zentral_Hoch: fail:77
2015-09-12 07:49:08 CUL_HM GEN_Rollo_Zentral_Device aesCommToDev: fail
2015-09-12 07:49:08 CUL_HM GEN_Rollo_Zentral_Hoch trig_aes_CCU: fail:77
2015-09-12 07:49:09 CUL_HM GEN_Rollo_Zentral_Device aesCommToDev: ok
2015-09-12 07:50:24 CUL_HM GEN_Rollo_Zentral_Device aesCommToDev: pending
2015-09-12 07:50:25 CUL_HM GEN_Rollo_Zentral_Device aesCommToDev: pending
2015-09-12 07:50:25 CUL_HM CCU_Btn8 trig_aes_GEN_Rollo_Zentral_Hoch: ok:77
2015-09-12 07:50:25 CUL_HM CCU_Btn8 trigLast: GEN_Rollo_Zentral_Hoch:short
2015-09-12 07:50:25 CUL_HM CCU_Btn8 trig_GEN_Rollo_Zentral_Hoch: short
2015-09-12 07:50:25 CUL_HM GEN_Rollo_Zentral_Device battery: ok
2015-09-12 07:50:25 CUL_HM GEN_Rollo_Zentral_Device CMDs_done
2015-09-12 07:50:25 CUL_HM GEN_Rollo_Zentral_Device GEN_Rollo_Zentral_Hoch Short
2015-09-12 07:50:26 CUL_HM GEN_Rollo_Zentral_Hoch trig_aes_CCU: ok:77
2015-09-12 07:50:26 CUL_HM GEN_Rollo_Zentral_Hoch Short (to GEN_Rollo_Zentral_Device)
2015-09-12 07:50:26 CUL_HM GEN_Rollo_Zentral_Hoch trigger: Short_78
2015-09-12 07:50:26 CUL_HM GEN_Rollo_Zentral_Hoch trigger_cnt: 78
2015-09-12 07:50:26 CUL_HM GEN_Rollo_Zentral_Device aesCommToDev: ok
2015-09-12 07:50:26 CUL_HM CCU_Btn8 trig_aes_GEN_Rollo_Zentral_Hoch: ok:78
2015-09-12 07:50:26 CUL_HM CCU_Btn8 trig_aes_GEN_Rollo_Zentral_Hoch: fail:78
2015-09-12 07:50:27 CUL_HM GEN_Rollo_Zentral_Device aesCommToDev: fail
2015-09-12 07:50:27 CUL_HM GEN_Rollo_Zentral_Hoch trig_aes_CCU: ok:78
2015-09-12 07:50:27 CUL_HM GEN_Rollo_Zentral_Hoch trig_aes_CCU: fail:78
2015-09-12 07:51:36 CUL_HM GEN_Rollo_Zentral_Device aesCommToDev: pending
2015-09-12 07:51:37 CUL_HM GEN_Rollo_Zentral_Device aesCommToDev: pending
2015-09-12 07:51:37 CUL_HM CCU_Btn8 trigLast: GEN_Rollo_Zentral_Hoch:short
2015-09-12 07:51:37 CUL_HM CCU_Btn8 trig_GEN_Rollo_Zentral_Hoch: short
2015-09-12 07:51:37 CUL_HM GEN_Rollo_Zentral_Device battery: ok
2015-09-12 07:51:37 CUL_HM GEN_Rollo_Zentral_Device CMDs_done
2015-09-12 07:51:37 CUL_HM GEN_Rollo_Zentral_Device GEN_Rollo_Zentral_Hoch Short
2015-09-12 07:51:38 CUL_HM GEN_Rollo_Zentral_Hoch Short (to GEN_Rollo_Zentral_Device)
2015-09-12 07:51:38 CUL_HM GEN_Rollo_Zentral_Hoch trigger: Short_79
2015-09-12 07:51:38 CUL_HM GEN_Rollo_Zentral_Hoch trigger_cnt: 79
2015-09-12 07:51:38 CUL_HM CCU_Btn8 trigLast: GEN_Rollo_Zentral_Hoch:short
2015-09-12 07:51:38 CUL_HM CCU_Btn8 trig_GEN_Rollo_Zentral_Hoch: short
2015-09-12 07:51:38 CUL_HM GEN_Rollo_Zentral_Device battery: ok
2015-09-12 07:51:38 CUL_HM GEN_Rollo_Zentral_Device CMDs_done
2015-09-12 07:51:38 CUL_HM GEN_Rollo_Zentral_Device GEN_Rollo_Zentral_Hoch Short
2015-09-12 07:51:39 CUL_HM GEN_Rollo_Zentral_Hoch Short (to GEN_Rollo_Zentral_Device)
2015-09-12 07:51:39 CUL_HM GEN_Rollo_Zentral_Hoch trigger: Short_79
2015-09-12 07:51:39 CUL_HM GEN_Rollo_Zentral_Hoch trigger_cnt: 79
2015-09-12 07:51:39 CUL_HM CCU_Btn8 trigLast: GEN_Rollo_Zentral_Hoch:short
2015-09-12 07:51:39 CUL_HM CCU_Btn8 trig_GEN_Rollo_Zentral_Hoch: short
2015-09-12 07:51:39 CUL_HM GEN_Rollo_Zentral_Device battery: ok
2015-09-12 07:51:39 CUL_HM GEN_Rollo_Zentral_Device CMDs_done
2015-09-12 07:51:39 CUL_HM GEN_Rollo_Zentral_Device GEN_Rollo_Zentral_Hoch Short
2015-09-12 07:51:39 CUL_HM GEN_Rollo_Zentral_Hoch Short (to GEN_Rollo_Zentral_Device)
2015-09-12 07:51:39 CUL_HM GEN_Rollo_Zentral_Hoch trigger: Short_79
2015-09-12 07:51:39 CUL_HM GEN_Rollo_Zentral_Hoch trigger_cnt: 79
2015-09-12 07:51:40 CUL_HM CCU_Btn8 trigLast: GEN_Rollo_Zentral_Hoch:short
2015-09-12 07:51:40 CUL_HM CCU_Btn8 trig_GEN_Rollo_Zentral_Hoch: short
2015-09-12 07:51:40 CUL_HM GEN_Rollo_Zentral_Device battery: ok
2015-09-12 07:51:40 CUL_HM GEN_Rollo_Zentral_Device CMDs_done
2015-09-12 07:51:40 CUL_HM GEN_Rollo_Zentral_Device GEN_Rollo_Zentral_Hoch Short
2015-09-12 07:51:40 CUL_HM GEN_Rollo_Zentral_Hoch Short (to GEN_Rollo_Zentral_Device)
2015-09-12 07:51:40 CUL_HM GEN_Rollo_Zentral_Hoch trigger: Short_79
2015-09-12 07:51:40 CUL_HM GEN_Rollo_Zentral_Hoch trigger_cnt: 79
2015-09-12 07:51:41 CUL_HM CCU_Btn8 trigLast: GEN_Rollo_Zentral_Hoch:short
2015-09-12 07:51:41 CUL_HM CCU_Btn8 trig_GEN_Rollo_Zentral_Hoch: short
2015-09-12 07:51:41 CUL_HM GEN_Rollo_Zentral_Device battery: ok
2015-09-12 07:51:41 CUL_HM GEN_Rollo_Zentral_Device CMDs_done
2015-09-12 07:51:41 CUL_HM GEN_Rollo_Zentral_Device GEN_Rollo_Zentral_Hoch Short
2015-09-12 07:51:41 CUL_HM GEN_Rollo_Zentral_Hoch Short (to GEN_Rollo_Zentral_Device)
2015-09-12 07:51:41 CUL_HM GEN_Rollo_Zentral_Hoch trigger: Short_79
2015-09-12 07:51:41 CUL_HM GEN_Rollo_Zentral_Hoch trigger_cnt: 79
2015-09-12 07:51:42 CUL_HM CCU_Btn8 trigLast: GEN_Rollo_Zentral_Hoch:short
2015-09-12 07:51:42 CUL_HM CCU_Btn8 trig_GEN_Rollo_Zentral_Hoch: short
2015-09-12 07:51:42 CUL_HM GEN_Rollo_Zentral_Device battery: ok
2015-09-12 07:51:42 CUL_HM GEN_Rollo_Zentral_Device CMDs_done
2015-09-12 07:51:42 CUL_HM GEN_Rollo_Zentral_Device GEN_Rollo_Zentral_Hoch Short
2015-09-12 07:51:42 CUL_HM GEN_Rollo_Zentral_Hoch Short (to GEN_Rollo_Zentral_Device)
2015-09-12 07:51:42 CUL_HM GEN_Rollo_Zentral_Hoch trigger: Short_79
2015-09-12 07:51:42 CUL_HM GEN_Rollo_Zentral_Hoch trigger_cnt: 79
2015-09-12 07:51:43 CUL_HM CCU_Btn8 trig_aes_GEN_Rollo_Zentral_Hoch: fail:79
2015-09-12 07:51:43 CUL_HM GEN_Rollo_Zentral_Device aesCommToDev: fail
2015-09-12 07:51:43 CUL_HM GEN_Rollo_Zentral_Hoch trig_aes_CCU: fail:79
2015-09-12 07:51:43 CUL_HM GEN_Rollo_Zentral_Device aesCommToDev: ok
2015-09-12 07:51:44 CUL_HM CCU_Btn8 trig_aes_GEN_Rollo_Zentral_Hoch: ok:79
2015-09-12 07:51:44 CUL_HM CCU_Btn8 trig_aes_GEN_Rollo_Zentral_Hoch: fail:79
2015-09-12 07:51:44 CUL_HM GEN_Rollo_Zentral_Device aesCommToDev: fail
2015-09-12 07:51:44 CUL_HM GEN_Rollo_Zentral_Hoch trig_aes_CCU: ok:79
2015-09-12 07:51:44 CUL_HM GEN_Rollo_Zentral_Hoch trig_aes_CCU: fail:79
2015-09-12 07:51:44 CUL_HM CCU_Btn8 trig_aes_GEN_Rollo_Zentral_Hoch: fail:79
2015-09-12 07:51:44 CUL_HM GEN_Rollo_Zentral_Device aesCommToDev: fail
2015-09-12 07:51:44 CUL_HM GEN_Rollo_Zentral_Hoch trig_aes_CCU: fail:79

List vom Taster:

Code Auswählen


Internals: 
   DEF        38CA3E 
   HMLAN0_MSGCNT 11 
   HMLAN0_RAWMSG E38CA3E,0000,0B49F85A,FF,FFB2,DBA64038CA3EAAA000024C 
   HMLAN0_RSSI -78 
   HMLAN0_TIME 2015-09-12 07:33:48 
   HMLAN1_MSGCNT 11 
   HMLAN1_RAWMSG E38CA3E,0000,22F08155,FF,FFC1,DBA64038CA3EAAA000024C 
   HMLAN1_RSSI -63 
   HMLAN1_TIME 2015-09-12 07:33:47 
   HMLAN2_MSGCNT 37 
   HMLAN2_RAWMSG E38CA3E,0050,0FA7D0D9,01,FFC3,DBA64038CA3EAAA000024C 
   HMLAN2_RSSI -61 
   HMLAN2_TIME 2015-09-12 07:33:48 
   HMUSB0_MSGCNT 28 
   HMUSB0_RAWMSG E38CA3E,0040,22A88E3F,01,FFC6,DBA64038CA3EAAA000024C 
   HMUSB0_RSSI -58 
   HMUSB0_TIME 2015-09-12 07:33:47 
   HMUSB1_MSGCNT 11 
   HMUSB1_RAWMSG E38CA3E,0000,8AF333CD,FF,FFB4,DBA64038CA3EAAA000024C 
   HMUSB1_RSSI -76 
   HMUSB1_TIME 2015-09-12 07:33:46 
   IODev      HMLAN2 
   LASTInputDev HMLAN0 
   MSGCNT     98 
   NAME       GEN_Rollo_Zentral_Device 
   NR         487 
   NTFY_ORDER 50-GEN_Rollo_Zentral_Device 
   STATE      GEN_Rollo_Zentral_Hoch Short 
   TYPE       CUL_HM 
   channel_01 GEN_Rollo_Zentral_Runter 
   channel_02 GEN_Rollo_Zentral_Hoch 
   lastMsg    No:DB - t:40 s:38CA3E d:AAA000 024C 
   protEvt_AESCom-ok 10 last_at:2015-09-12 07:33:47 
   protLastRcv 2015-09-12 07:33:48 
   protSnd    20 last_at:2015-09-12 07:33:46 
   protState  CMDs_done 
   rssi_at_HMLAN0 avg:-74.27 min:-78 max:-71 lst:-78 cnt:11 
   rssi_at_HMLAN1 avg:-64.18 min:-65 max:-63 lst:-63 cnt:11 
   rssi_at_HMLAN2 avg:-57.8 min:-64 max:-55 lst:-57 cnt:5 
   rssi_at_HMUSB0 avg:-65.62 min:-77 max:-58 lst:-58 cnt:8 
   rssi_at_HMUSB1 avg:-73.09 min:-76 max:-70 lst:-76 cnt:11 
   CHANGETIME: 
   Helper: 
     Dblog: 
       Aescommtodev: 
         Eventlog: 
           TIME       1442036028.01217 
           VALUE      fail 
       Battery: 
         Eventlog: 
           TIME       1442036026.60335 
           VALUE      ok 
       State: 
         Eventlog: 
           TIME       1442036026.60335 
           VALUE      GEN_Rollo_Zentral_Hoch Short 
   Readings: 
     2015-05-05 16:09:03   CommandAccepted yes 
     2015-05-05 16:09:03   D-firmware      1.1 
     2015-05-05 16:09:03   D-serialNr      MEQ0164945 
     2015-05-05 15:16:46   PairedTo        0xAAA000 
     2015-05-05 15:06:20   R-pairCentral   0xAAA000
     2015-05-05 15:16:46   RegL_00:        02:01 05:00 0A:AA 0B:F0 0C:07 14:03 18:00 00:00 
     2015-09-12 07:33:47   aesCommToDev    fail 
     2015-05-05 16:09:03   aesKeyNbr       02 
     2015-05-05 16:21:51   aesReqTo        CCU 
     2015-09-12 07:33:46   battery         ok 
     2015-05-05 16:07:20   sabotageAttack  ErrIoAttack cnt:36 
     2015-09-12 07:33:46   state           GEN_Rollo_Zentral_Hoch Short 
   Helper: 
     HM_CMDNR   219 
     mId        00BF 
     rxType     20 
     Io: 
       newChn     +38CA3E,01,01,06 
       nextSend   1442036026.36262 
       rxt        2 
       vccu       CCU 
       p: 
         38CA3E 
         01 
         01 
         06 
       prefIO: 
         HMLAN2 
         HMLAN0 
         HMLAN1 
         HMUSB0 
         HMUSB1 
     Mrssi: 
       mNo        DB 
       Io: 
         HMLAN0     -78 
         HMLAN1     -63 
         HMUSB0     -58 
         HMUSB1     -76 
     Prt: 
       bErr       0 
       sProc      0 
       Rspwait: 
     Q: 
       qReqConf 
       qReqStat 
     Role: 
       dev        1 
     Rpt: 
       IO         HMUSB1 
       flg        A 
       ts         1442036026.26815 
       ack: 
         HASH(0x3b433e8) 
         DB8002AAA00038CA3E00 
     Rssi: 
       At_hmlan0: 
         avg        -74.2727272727273 
         cnt        11 
         lst        -78 
         max        -71 
         min        -78 
       At_hmlan1: 
         avg        -64.1818181818182 
         cnt        11 
         lst        -63 
         max        -63 
         min        -65 
       At_hmlan2: 
         avg        -57.8 
         cnt        5 
         lst        -57 
         max        -55 
         min        -64 
       At_hmusb0: 
         avg        -65.625 
         cnt        8 
         lst        -58 
         max        -58 
         min        -77 
       At_hmusb1: 
         avg        -73.0909090909091 
         cnt        11 
         lst        -76 
         max        -70 
         min        -76 
   Role: 
Attributes: 
   IODev      HMLAN2 
   IOgrp      CCU:HMLAN2,HMLAN0,HMLAN1,HMUSB0,HMUSB1 
   aesCommReq 1 
   autoReadReg 4_reqStatus 
   expert     2_full 
   firmware   1.1 
   model      HM-PB-2-FM 
   serialNr   MEQ0164945 
   subType    pushButton 
   webCmd     getConfig:clear msgEvents

List vom Hoch-Kanal:

Code Auswählen


Internals: 
   DEF        38CA3E02 
   HMLAN2_MSGCNT 6 
   HMLAN2_RAWMSG E38CA3E,0050,0FA7D0D9,01,FFC3,DBA64038CA3EAAA000024C 
   HMLAN2_RSSI -61 
   HMLAN2_TIME 2015-09-12 07:33:48 
   HMUSB0_MSGCNT 3 
   HMUSB0_RAWMSG E38CA3E,0050,22A3D49E,01,FFC4,D9A64038CA3EAAA000024A 
   HMUSB0_RSSI -60 
   HMUSB0_TIME 2015-09-12 07:28:37 
   LASTInputDev HMLAN2 
   MSGCNT     9 
   NAME       GEN_Rollo_Zentral_Hoch 
   NR         490 
   NTFY_ORDER 50-GEN_Rollo_Zentral_Hoch 
   STATE      Short (to GEN_Rollo_Zentral_Device) 
   TYPE       CUL_HM 
   chanNo     02 
   device     GEN_Rollo_Zentral_Device 
   peerList   CCU_Btn8, 
   CHANGETIME: 
   Helper: 
     Dblog: 
       State: 
         Eventlog: 
           TIME       1442036026.92982 
           VALUE      Short (to GEN_Rollo_Zentral_Device) 
       Trig_aes_ccu: 
         Eventlog: 
           TIME       1442036028.14014 
           VALUE      fail:76 
       Trigger: 
         Eventlog: 
           TIME       1442036026.92982 
           VALUE      Short_76 
       Trigger_cnt: 
         Eventlog: 
           TIME       1442036026.92982 
           VALUE      76 
   Readings: 
     2015-05-05 15:57:58   CommandAccepted yes 
     2015-05-05 16:07:23   R-CCU_Btn8-expectAES off 
     2015-05-05 16:07:23   R-CCU_Btn8-peerNeedsBurst off 
     2015-05-05 15:06:21   R-longPress     0.4 s 
     2015-05-05 15:16:48   R-sign          on 
     2015-05-05 16:09:04   RegL_01:        04:10 08:01 30:03 00:00 
     2015-05-05 16:09:05   RegL_04:CCU_Btn8 01:00 00:00 
     2015-09-09 06:32:57   peerList        CCU_Btn8, 
     2015-09-12 07:33:46   state           Short (to GEN_Rollo_Zentral_Device) 
     2015-09-12 07:33:47   trig_aes_CCU    fail:76 
     2015-09-12 07:33:46   trigger         Short_76 
     2015-09-12 07:33:46   trigger_cnt     76 
   Helper: 
     BNO        76 
     BNOCNT     1 
     Role: 
       chn        1 
   Role: 
Attributes: 
   aesCommReq 1 
   model      HM-PB-2-FM 
   peerIDs    00000000,AAA00008,

Es wechseln sich die aes:ok und aes:fail (zumindest in den Events) ab, und man beachte vor allem die ersten Events mit der Hochzählung nach einem erneuten Betätigen des Tasters. Hier kommt z.B.

2015-09-12 07:31:45 CUL_HM CCU_Btn8 trig_aes_GEN_Rollo_Zentral_Hoch: ok:74

obwohl vorher bereits

2015-09-12 07:28:38 CUL_HM GEN_Rollo_Zentral_Hoch trigger: Short_74
2015-09-12 07:28:38 CUL_HM GEN_Rollo_Zentral_Hoch trigger_cnt: 74

Die Folge davon ist, dass der Schalter nicht so zuverlässig funktioniert. Insbesondere nach längerer Sendepause (also gestern morgen gedrückt und dann heute morgen wieder) führt das dazu, dass ich regelmäßig zwei mal drücken muss, beim ersten mal geht der AES-Request meist in die Hose.[/code]

mgernoth · 12 September 2015, 12:58:22

Hallo,

Zitat von: Ralli am 12 September 2015, 07:48:10
Code Auswählen Erweitern
2015-09-12 07:33:48 CUL_HM GEN_Rollo_Zentral_Hoch trig_aes_CCU: ok:76 2015-09-12 07:33:48 CUL_HM GEN_Rollo_Zentral_Hoch trig_aes_CCU: fail:76

Ich habe den Verdacht, dass hier beide IOs AES versuchen und das dann bei einem natürlich fehlschlägt, da der Schalter nur eine Challenge beantwortet. Das zu debuggen ist leider unschön, da HMLAN/HMCFGUSB teilweise die AES-Pakete nicht weiterleiten. Du müsstest, wenn möglich, mit einem culfw-Gerät parallel sniffen und schauen, ob zwei Challenges und nur eine Response kommt. Ich hab mal meinen CUL bidcos-sniffer angehängt.

Viele Grüße
Michael

Ralli · 12 September 2015, 18:59:01

Ok $:-\$ .

Danke - das dauert aber jetzt ein paar Tage, bis ich den entsprechenden "Laboraufbau" fertig habe.

Eigentlich sollte das ja nicht passieren, da der Taster mit der vCCU gepaired ist und das alles über die laufen sollte.

martinp876 · 12 September 2015, 23:37:13

Haette ich auch nicht erwartet. Die aesmessages werden m,e, nur vom sendenden io nicht weitergeleotet. Logge einfach einmal die rohmessages. Auswerten kann ich erst in 2 bis3 wochen

Ralli · 13 September 2015, 08:46:22

Ok - reicht hier ein

attr global mseclog 1
attr GEN_Rollo_Zentral_Device verbose 1
attr <alle hmlans und hmusbs> logIDs GEN_Rollo_Zentral_Device

?

Oder muss da noch das logIDs sys dazu und ein attr vCCU verbose 1 ?

martinp876 · 13 September 2015, 09:47:08

Sysmuss nicht in die idlogs.
Verbose wird eingestellt um unnötige logs zu verhindern. Passt also so

rainer1962 · 16 Oktober 2015, 08:54:33

Hallo Martin,
hatte gestern auch ein fehlverhalten mit den rollos.
ein rollo wurde nicht ordnungsgemäß runtergefahren. eine knappe stunde später habe es gemerkt und direkt mit dem taster heruntergefahren:
es fällt auf dass aesCommToDev auf pending stehengeblieben ist.

Code Auswählen


2015-10-15_17:36:56 Motor_Jalousie_SW_rechts set_off
2015-10-15_17:36:56 Motor_Jalousie_SW_rechts aesCommToDev: pending
2015-10-15_17:36:56 Motor_Jalousie_SW_rechts aesKeyNbr: 08
2015-10-15_17:36:57 Motor_Jalousie_SW_rechts aesKeyNbr: 08
2015-10-15_18:20:03 Motor_Jalousie_SW_rechts trigLast: Taster_Jalousien_SZ_Btn_06:short
2015-10-15_18:20:03 Motor_Jalousie_SW_rechts trig_Taster_Jalousien_SZ_Btn_06: short
2015-10-15_18:20:04 Motor_Jalousie_SW_rechts aesKeyNbr: 08
2015-10-15_18:20:04 Motor_Jalousie_SW_rechts deviceMsg: 99.5 (to Taster_Jalousien_SZ)
2015-10-15_18:20:04 Motor_Jalousie_SW_rechts level: 99.5
2015-10-15_18:20:04 Motor_Jalousie_SW_rechts motor: down:99.5
2015-10-15_18:20:04 Motor_Jalousie_SW_rechts pct: 99.5
2015-10-15_18:20:04 Motor_Jalousie_SW_rechts 99.5
2015-10-15_18:20:04 Motor_Jalousie_SW_rechts timedOn: off
2015-10-15_18:20:27 Motor_Jalousie_SW_rechts deviceMsg: off (to broadcast)
2015-10-15_18:20:27 Motor_Jalousie_SW_rechts level: 0
2015-10-15_18:20:27 Motor_Jalousie_SW_rechts motor: stop:off
2015-10-15_18:20:27 Motor_Jalousie_SW_rechts pct: 0
2015-10-15_18:20:27 Motor_Jalousie_SW_rechts off
2015-10-15_18:20:27 Motor_Jalousie_SW_rechts timedOn: off

kansst du das nachvolziehen?

LG Rainer

martinp876 · 16 Oktober 2015, 20:00:17

Aus diesen events wohl nicht. Es gibt ein wiederholen, wenn der status nicht kommt. Aber nur einmal.

rainer1962 · 16 Oktober 2015, 20:40:52

woran sieht man das wiederholen

im Log konnnte ich nichts sehen

LG Rainer

automatisierer · 21 Oktober 2016, 21:19:25

Hallo,
ich wärme dieses Thema nochmal auf.
Ich habe die gleichen Probleme wie hier beschrieben. Ich möchte eine HM-RC-Key4-2 zum öffnen meiner Haustür und eines Garagentores mit AES absichern. Bisher hatte ich AES auch eingeschaltet, da das DOIF allerdings auf 'Flur_fs_Hand_Btn_02_lock Short' reagiert, bringt AES da ja nix, da das 'Short' ja nunmal auf jeden Fall gesendet wird, egal ob AES ok oder fail ergibt. Daher habe ich die Channels der Fernbedienung mit einem Virtuellen Channel der vccu gepeert und triggere das DOIF nun mit 'trig_aes_Flur_fs_Hand_Btn_01_unlock: ok'.

Die vccu hat im Moment drei IO's (2 HMLAN und 1 HMLGW). Die Fernbedienung hat keinen prefIO. Wenn der IOdev der Fernbedienung einer der HMLAN ist, leuchtet die Fernbedienung fast zu 100% grün - AES ist ok. Wenn der HMLGW als IOdev eingetragen ist habe ich 100% AES fail.

Habe mal Rohmessages von ein paar Tastendrücken aufgezeichnet:

Code Auswählen


2016.10.21 21:06:04.182 0: HMLAN_Parse: HMLANingo1 R:E355867   stat:0000 t:00152203 d:FF r:FFC2     m:CA 8002 355867 24C003 00
2016.10.21 21:06:04.153 0: HMLAN_Parse: HMLANingo1 R:E24C003   stat:0000 t:00152187 d:FF r:FFBE     m:CA A240 24C003 355867 0278
2016.10.21 21:06:04.051 0: HMUARTLGW HMLGW_1 recv: 01 05 01 00 4A msg: CA A2 40 24C003 355867 0278
2016.10.21 21:06:03.931 0: HMLAN_Parse: HMLANingo1 R:E355867   stat:0000 t:00152108 d:FF r:FFC1     m:C9 8002 355867 24C003 00
2016.10.21 21:06:03.903 0: HMLAN_Parse: HMLANingo1 R:E24C003   stat:0000 t:0015208C d:FF r:FFBE     m:C9 A240 24C003 355867 0278
2016.10.21 21:06:03.801 0: HMUARTLGW HMLGW_1 recv: 01 05 01 00 4A msg: C9 A2 40 24C003 355867 0278
2016.10.21 21:06:03.697 0: HMLAN_Parse: HMLANingo1 R:E355867   stat:0000 t:0015200E d:FF r:FFC2     m:C8 8002 355867 24C003 00
2016.10.21 21:06:03.692 0: HMLAN_Parse: HMLANingo1 R:E24C003   stat:0000 t:00151F92 d:FF r:FFBE     m:C8 A640 24C003 355867 0278
2016.10.21 21:06:03.551 0: HMUARTLGW HMLGW_1 recv: 01 05 01 00 4A msg: C8 A6 40 24C003 355867 0278
2016.10.21 21:06:00.192 0: HMLAN_Parse: HMLANingo1 R:E355867   stat:0000 t:0015126D d:FF r:FFC1     m:C5 8002 355867 24C003 00
2016.10.21 21:06:00.156 0: HMUARTLGW HMLGW_1 send: 01 02 00 00 00 msg: C5 80 02 355867 24C003 00
2016.10.21 21:05:59.988 0: HMLAN_Parse: HMLANingo1 R:E355867   stat:0000 t:001511A0 d:FF r:FFC2     m:C7 8002 355867 24C003 00
2016.10.21 21:05:59.967 0: HMLAN_Parse: HMLANingo1 R:E24C003   stat:0000 t:00151124 d:FF r:FFBE     m:C7 A240 24C003 355867 0277
2016.10.21 21:05:59.961 0: HMUARTLGW HMLGW_1 send: 01 02 00 00 00 msg: C5 80 02 355867 24C003 00
2016.10.21 21:05:59.857 0: HMUARTLGW HMLGW_1 recv: 01 05 01 00 4A msg: C7 A2 40 24C003 355867 0277
2016.10.21 21:05:59.737 0: HMLAN_Parse: HMLANingo1 R:E355867   stat:0000 t:001510A5 d:FF r:FFC1     m:C6 8002 355867 24C003 00
2016.10.21 21:05:59.717 0: HMLAN_Parse: HMLANingo1 R:E24C003   stat:0000 t:00151029 d:FF r:FFBE     m:C6 A240 24C003 355867 0277
2016.10.21 21:05:59.710 0: HMUARTLGW HMLGW_1 send: 01 02 00 00 00 msg: C5 80 02 355867 24C003 00
2016.10.21 21:05:59.607 0: HMUARTLGW HMLGW_1 recv: 01 05 01 00 4A msg: C6 A2 40 24C003 355867 0277
2016.10.21 21:05:59.503 0: HMLAN_Parse: HMLANingo1 R:E24C003   stat:0000 t:00150F2F d:FF r:FFBE     m:C5 A640 24C003 355867 0277
2016.10.21 21:05:59.356 0: HMUARTLGW HMLGW_1 recv: 01 05 00 00 4A msg: C5 A6 40 24C003 355867 0277
2016.10.21 21:05:39.705 0: HMLAN_Parse: HMLANingo1 R:E355867   stat:0000 t:0014C116 d:FF r:FFC2     m:C4 8002 355867 24C003 00
2016.10.21 21:05:39.694 0: HMUARTLGW HMLGW_1 recv: 01 05 00 00 3D msg: C4 80 02 355867 24C003 00
2016.10.21 21:05:39.685 0: HMLAN_Parse: HMLANingo3 R:E355867   stat:0000 t:001386E6 d:FF r:FFC8     m:C4 8002 355867 24C003 00
2016.10.21 21:05:39.365 0: HMLAN_Send:  HMLANingo3 S:SE8A26617 stat:  00 t:00000000 d:01 r:E8A26617 m:C4 8002 355867 24C003 00
2016.10.21 21:05:39.365 0: HMLAN_Send:  HMLANingo3 S:+24C003,01,02,1E
2016.10.21 21:05:39.255 0: HMLAN_Parse: HMLANingo3 R:E24C003   stat:0040 t:0013854E d:02 r:FFC7     m:C4 A240 24C003 355867 0276
2016.10.21 21:05:39.253 0: HMLAN_Parse: HMLANingo1 R:RE8A26568 stat:0002 t:00000000 d:FF r:7FFF     m:C4 8002 355867 24C003 00
2016.10.21 21:05:39.246 0: HMLAN_Parse: HMLANingo1 R:E355867   stat:0000 t:0014C06D d:FF r:FFCE     m:C4 8002 355867 24C003 00BC07592C
2016.10.21 21:05:39.240 0: HMUARTLGW HMLGW_1 send: 01 02 00 00 00 msg: C4 80 02 355867 24C003 00
2016.10.21 21:05:39.190 0: HMLAN_Send:  HMLANingo1 S:SE8A26568 stat:  00 t:00000000 d:01 r:E8A26568 m:C4 8002 355867 24C003 00
2016.10.21 21:05:39.190 0: HMLAN_Send:  HMLANingo1 S:+24C003,01,02,1E
2016.10.21 21:05:39.080 0: HMUARTLGW HMLGW_1 recv: 01 05 01 00 4A msg: C4 A0 03 24C003 355867 7952BCE70E5CD9565A268EB1C6E23D97
2016.10.21 21:05:38.996 0: HMLAN_Parse: HMLANingo1 R:E355867   stat:0000 t:0014BF73 d:FF r:FFCF     m:C4 A002 355867 24C003 042BBD1B55340904
2016.10.21 21:05:38.987 0: HMUARTLGW HMLGW_1 recv: 01 05 00 00 43 msg: C4 A0 02 355867 24C003 042BBD1B55340904
2016.10.21 21:05:38.930 0: HMLAN_Parse: HMLANingo3 R:E24C003   stat:0100 t:0013854E d:FF r:FFC7     m:C4 A240 24C003 355867 0276
2016.10.21 21:05:38.924 0: HMLAN_Parse: HMLANingo1 R:E24C003   stat:0000 t:0014BEF2 d:FF r:FFBC     m:C4 A240 24C003 355867 0276
2016.10.21 21:05:38.818 0: HMUARTLGW HMLGW_1 recv: 01 05 00 00 49 msg: C4 A2 40 24C003 355867 0276
2016.10.21 21:05:38.733 0: HMLAN_Parse: HMLANingo3 R:RE8A2633B stat:0002 t:00000000 d:FF r:7FFF     m:C2 8002 355867 24C003 00
2016.10.21 21:05:38.726 0: HMLAN_Parse: HMLANingo1 R:E355867   stat:0000 t:0014BDF3 d:FF r:FFCE     m:C2 8002 355867 24C003 00
2016.10.21 21:05:38.721 0: HMLAN_Parse: HMLANingo1 R:E355867   stat:0000 t:0014BD79 d:FF r:FFC2     m:C2 8002 355867 24C003 00
2016.10.21 21:05:38.715 0: HMLAN_Parse: HMLANingo1 R:E24C003   stat:0000 t:0014BCFD d:FF r:FFBD     m:C2 A640 24C003 355867 0276
2016.10.21 21:05:38.700 0: HMUARTLGW HMLGW_1 recv: 01 05 00 00 43 msg: C2 80 02 355867 24C003 00
2016.10.21 21:05:38.693 0: HMUARTLGW HMLGW_1 recv: 01 05 01 00 49 msg: C2 A6 40 24C003 355867 0276
2016.10.21 21:05:38.666 0: HMLAN_Parse: HMLANingo3 R:E355867   stat:0000 t:001383D5 d:FF r:FFB6     m:C2 8002 355867 24C003 00
2016.10.21 21:05:38.533 0: HMLAN_Send:  HMLANingo3 S:SE8A2633B stat:  00 t:00000000 d:01 r:E8A2633B m:C2 8002 355867 24C003 00
2016.10.21 21:05:38.532 0: HMLAN_Send:  HMLANingo3 S:+24C003,01,02,1E
2016.10.21 21:05:38.524 0: HMLAN_Parse: HMLANingo3 R:E24C003   stat:0000 t:00138359 d:FF r:FFC7     m:C2 A640 24C003 355867 0276
2016.10.21 21:05:29.087 0: HMLAN_Parse: HMLANingo3 R:E355867   stat:0000 t:00135E6B d:FF r:FFB6     m:C1 8002 355867 24C003 00
2016.10.21 21:05:29.080 0: HMLAN_Parse: HMLANingo1 R:E355867   stat:0000 t:0014980F d:FF r:FFC2     m:C1 8002 355867 24C003 00
2016.10.21 21:05:28.834 0: HMUARTLGW HMLGW_1 send: 01 02 00 00 00 msg: C1 80 02 355867 24C003 00
2016.10.21 21:05:28.420 0: HMLAN_Parse: HMLANingo3 R:E355867   stat:0000 t:00135CA1 d:FF r:FFB6     m:C0 8002 355867 24C003 00
2016.10.21 21:05:28.413 0: HMLAN_Parse: HMLANingo1 R:E355867   stat:0000 t:00149645 d:FF r:FFC2     m:C0 8002 355867 24C003 00
2016.10.21 21:05:28.376 0: HMUARTLGW HMLGW_1 send: 01 02 00 00 00 msg: C0 80 02 355867 24C003 00
2016.10.21 21:05:28.114 0: HMLAN_Parse: HMLANingo3 R:E355867   stat:0000 t:00135B70 d:FF r:FFB6     m:BF 8002 355867 24C003 00
2016.10.21 21:05:28.108 0: HMLAN_Parse: HMLANingo1 R:E355867   stat:0000 t:00149514 d:FF r:FFC2     m:BF 8002 355867 24C003 00
2016.10.21 21:05:28.071 0: HMUARTLGW HMLGW_1 send: 01 02 00 00 00 msg: BF 80 02 355867 24C003 00
2016.10.21 21:05:27.872 0: HMLAN_Parse: HMLANingo3 R:RE8A2357D stat:0002 t:00000000 d:FF r:7FFF     m:BF 8002 355867 24C003 00
2016.10.21 21:05:27.850 0: HMLAN_Parse: HMLANingo1 R:E355867   stat:0000 t:00149034 d:FF r:FFCF     m:BF 8002 355867 24C003 00
2016.10.21 21:05:27.848 0: HMLAN_Parse: HMLANingo1 R:RE8A23297 stat:0002 t:00000000 d:FF r:7FFF     m:BF 8002 355867 24C003 00
2016.10.21 21:05:27.565 0: HMUARTLGW HMLGW_1 recv: 01 05 00 00 44 msg: BF 80 02 355867 24C003 00
2016.10.21 21:05:27.550 0: HMUARTLGW HMLGW_1 recv: 01 05 00 00 3D msg: BF 80 02 355867 24C003 00
2016.10.21 21:05:27.428 0: HMUARTLGW HMLGW_1 recv: 01 05 01 00 46 msg: C1 A2 40 24C003 355867 0275
2016.10.21 21:05:27.319 0: HMUARTLGW HMLGW_1 recv: 01 05 01 00 46 msg: C0 A2 40 24C003 355867 0275
2016.10.21 21:05:27.217 0: HMUARTLGW HMLGW_1 recv: 01 05 01 00 46 msg: BF A6 40 24C003 355867 0275
2016.10.21 21:05:27.201 0: HMLAN_Parse: HMLANingo3 R:E355867   stat:0000 t:001353AA d:FF r:FFC8     m:BF 8002 355867 24C003 00
2016.10.21 21:05:27.176 0: HMLAN_Parse: HMLANingo3 R:E355867   stat:0000 t:00134AB8 d:FF r:FFB5     m:C1 8002 355867 24C003 00
2016.10.21 21:05:27.054 0: HMLAN_Parse: HMLANingo3 R:E24C003   stat:0000 t:00134A3C d:FF r:FFC1     m:C1 A240 24C003 355867 0275
2016.10.21 21:05:27.041 0: HMLAN_Parse: HMLANingo3 R:E355867   stat:0000 t:001349BD d:FF r:FFB6     m:C0 8002 355867 24C003 00
2016.10.21 21:05:26.927 0: HMLAN_Parse: HMLANingo3 R:E24C003   stat:0000 t:00134941 d:FF r:FFC1     m:C0 A240 24C003 355867 0275
2016.10.21 21:05:26.919 0: HMLAN_Parse: HMLANingo3 R:E355867   stat:0000 t:001348C3 d:FF r:FFB6     m:BF 8002 355867 24C003 00
2016.10.21 21:05:26.824 0: HMLAN_Send:  HMLANingo3 S:SE8A2357D stat:  00 t:00000000 d:01 r:E8A2357D m:BF 8002 355867 24C003 00
2016.10.21 21:05:26.823 0: HMLAN_Send:  HMLANingo3 S:+24C003,01,02,1E
2016.10.21 21:05:26.814 0: HMLAN_Parse: HMLANingo3 R:E24C003   stat:0000 t:00134847 d:FF r:FFC1     m:BF A640 24C003 355867 0275
2016.10.21 21:05:26.455 0: HMLAN_Parse: HMLANingo1 R:E355867   stat:0000 t:0014845C d:FF r:FFC1     m:C1 8002 355867 24C003 00
2016.10.21 21:05:26.355 0: HMLAN_Parse: HMLANingo1 R:E24C003   stat:0000 t:001483E0 d:FF r:FFB2     m:C1 A240 24C003 355867 0275
2016.10.21 21:05:26.334 0: HMLAN_Parse: HMLANingo1 R:E355867   stat:0000 t:00148361 d:FF r:FFC2     m:C0 8002 355867 24C003 00
2016.10.21 21:05:26.232 0: HMLAN_Parse: HMLANingo1 R:E24C003   stat:0000 t:001482E5 d:FF r:FFB2     m:C0 A240 24C003 355867 0275
2016.10.21 21:05:26.224 0: HMLAN_Parse: HMLANingo1 R:E355867   stat:0000 t:00148267 d:FF r:FFC2     m:BF 8002 355867 24C003 00
2016.10.21 21:05:26.082 0: HMLAN_Send:  HMLANingo1 S:SE8A23297 stat:  00 t:00000000 d:01 r:E8A23297 m:BF 8002 355867 24C003 00
2016.10.21 21:05:26.081 0: HMLAN_Send:  HMLANingo1 S:+24C003,01,02,1E
2016.10.21 21:05:26.064 0: HMLAN_Parse: HMLANingo1 R:E24C003   stat:0000 t:001481EB d:FF r:FFB2     m:BF A640 24C003 355867 0275