HM-CC-RT-DN & HM-TC-IT-WM-W-EU nach Firmware Update reading fwUpdate fail:....

Burny4600 · 02 Februar 2020, 11:47:47

Ich habe bei einigen Raum Thermostaten HM-CC-RT-DN nach dem Firmware Update 1.4 auf hm_cc_rt_dn_update_V1_5_003_171004.eq3 den Reading Eintrag fwUpdate fail:.. anstatt fwupdate:done.

ZitatfwUpdate fail:Block4
fwUpdate fail:Block7
fwUpdate fail:Block61
fwUpdate fail:Block84
fwUpdate fail:notInBootLoader

Auch ein neuerliches Update hilft nicht das die Firmware vollständig übertragen wurde.
Die Raum Thermostate funktionieren aber noch.
Wie ist in diesem Fall vorzugehen?

frank · 02 Februar 2020, 12:18:31

analysiere, warum es probleme gibt.

funk verbessern, auf genügend credits achten, ein "gutes" prefered io nutzen, fhem freezes verringern, ...

zeig mal ein list.

Burny4600 · 02 Februar 2020, 13:49:18

Ich denke ich habe den Fehler gefunden.
Es sind 5 Stk HM-MOD-UART entsprechend aufgeteilt vorhanden.
Für die Firmware Updates wird aber nur eine Schnittstelle verwendet die aber zb. bei diesem Thermostat nicht definiert ist.

list EG_BA_HZG_RT

Code Auswählen

Internals:
   CFGFN      /media/hdd/fhem/mycfg/HM/hm_rasp01.cfg
   CHANGED    
   DEF        5FA4CA
   FUUID      5c45b04d-f33f-f4d2-55ca-cc6a34a68267cb9b
   HmUART_AB_GTO_MSGCNT 30
   HmUART_AB_GTO_RAWMSG 050000490686105FA4CA0000000AA8F80F0000
   HmUART_AB_GTO_RSSI -73
   HmUART_AB_GTO_TIME 2020-02-02 13:22:20
   HmUART_EG_MSGCNT 31
   HmUART_EG_RAWMSG 050000390686105FA4CA0000000AA8F80F0000
   HmUART_EG_RSSI -57
   HmUART_EG_TIME 2020-02-02 13:22:18
   HmUART_OG1_MSGCNT 31
   HmUART_OG1_RAWMSG 050000470686105FA4CA0000000AA8F80F0000
   HmUART_OG1_RSSI -71
   HmUART_OG1_TIME 2020-02-02 13:22:13
   HmUART_OG2_MSGCNT 30
   HmUART_OG2_RAWMSG 050000440686105FA4CA0000000AA8F80F0000
   HmUART_OG2_RSSI -68
   HmUART_OG2_TIME 2020-02-02 13:22:21
   IODev      HmUART_OG1
   LASTInputDev HmUART_OG2
   MSGCNT     122
   NAME       EG_BA_HZG_RT
   NOTIFYDEV  global
   NR         3315
   NTFY_ORDER 50-EG_BA_HZG_RT
   STATE      CMDs_done
   TYPE       CUL_HM
   channel_01 EG_BA_HZG_RT_Weather
   channel_02 EG_BA_HZG_RT_Climate
   channel_03 EG_BA_HZG_RT_WindowRec
   channel_04 EG_BA_HZG_RT_Clima
   channel_05 EG_BA_HZG_RT_ClimaTeam
   channel_06 EG_BA_HZG_RT_remote
   lastMsg    No:06 - t:10 s:5FA4CA d:000000 0AA8F80F0000
   protCondBurst off
   protErrIoAttack 2 last_at:2020-02-02 13:09:35
   protLastRcv 2020-02-02 13:22:13
   protRcv    41 last_at:2020-02-02 13:22:13
   protResnd  2 last_at:2020-02-02 13:09:07
   protSnd    21 last_at:2020-02-02 13:09:57
   protSndB   5 last_at:2020-02-02 13:09:10
   protState  CMDs_done
   rssi_at_HmUART_AB_GTO cnt:30 min:-75 max:-70 avg:-73.73 lst:-73 
   rssi_at_HmUART_EG cnt:31 min:-58 max:-57 avg:-57.96 lst:-57 
   rssi_at_HmUART_OG1 cnt:31 min:-76 max:-70 avg:-73.51 lst:-71 
   rssi_at_HmUART_OG2 cnt:30 min:-68 max:-66 avg:-67.49 lst:-68 
   READINGS:
     2020-02-02 12:44:58   Activity        alive
     2020-02-02 13:10:21   CommandAccepted yes
     2019-01-21 12:43:22   D-firmware      1.4
     2020-02-02 13:09:56   D-serialNr      OEQ1695245
     2020-02-02 13:08:18   PairedTo        0xF12347
     2019-01-21 12:46:17   R-backOnTime    10 s
     2019-07-07 14:53:42   R-btnLock       on
     2019-05-23 10:49:39   R-burstRx       on
     2019-01-21 12:46:17   R-cyclicInfoMsg on
     2019-01-21 12:46:17   R-cyclicInfoMsgDis 0
     2019-01-21 12:46:17   R-globalBtnLock off
     2019-01-21 12:46:17   R-localResDis   off
     2019-01-21 12:46:17   R-lowBatLimitRT 2.1 V
     2019-01-21 12:46:17   R-modusBtnLock  off
     2019-01-21 12:46:17   R-pairCentral   0xF12347
     2020-02-02 13:08:18   RegL_00.         00:00 01:01 02:01 09:01 0A:F1 0B:23 0C:47 0E:0A 0F:01 11:00 12:15 16:01 18:00 19:00 1A:00
     2020-02-02 13:22:13   actuator        0
     2020-02-02 13:22:13   battery         ok
     2020-02-02 13:22:13   batteryLevel    3
     2020-02-02 13:22:13   desired-temp    21.0
     2020-02-02 13:09:29   fwUpdate        fail:notInBootLoader
     2020-02-02 13:22:13   measured-temp   24.8
     2020-02-02 13:22:13   motorErr        ok
     2020-02-02 13:09:57   powerOn         2020-02-02 13:09:57
     2020-02-02 13:09:57   recentStateType info
     2019-12-31 22:00:43   rssi_HmUART_AB_GTO -71
     2020-02-02 06:31:32   rssi_HmUART_EG  -62
     2019-11-05 06:27:55   rssi_HmUART_OG1 -75
     2020-01-04 06:52:01   rssi_HmUART_OG2 -78
     2020-02-02 13:22:20   rssi_at_HmUART_AB_GTO -73
     2020-02-02 13:22:18   rssi_at_HmUART_EG -57
     2020-02-02 13:22:13   rssi_at_HmUART_OG1 -71
     2020-02-02 13:22:21   rssi_at_HmUART_OG2 -68
     2020-02-01 14:16:48   sabotageAttack_ErrIoAttack cnt 1
     2020-02-02 13:09:35   sabotageAttack_ErrIoAttack cnt 2
     2020-02-02 13:09:57   state           CMDs_done
     2020-02-02 13:09:57   time-request    -
   helper:
     HM_CMDNR   6
     PONtest    1
     cSnd       01F123475FA4CA0303,01F123475FA4CA03040000000001
     mId        0095
     peerFriend 
     peerOpt    -:thermostat
     regLst     0
     rxType     140
     supp_Pair_Rep 0
     ack:
     expert:
       def        1
       det        1
       raw        1
       tpl        1
     io:
       newChn     +5FA4CA,00,03,00
       nextSend   1580646141.40945
       prefIO     
       rxt        2
       vccu       VCCU
       p:
         5FA4CA
         00
         03
         00
     mRssi:
       mNo        06
       io:
         HmUART_AB_FR:
         HmUART_AB_GTO:
           -73
           -73
         HmUART_EG:
           -57
           -57
         HmUART_OG1:
           -69
           -69
         HmUART_OG2:
           -68
           -68
     prt:
       awake      0
       bErr       0
       brstWu     0
       sProc      0
       sleeping   1
       rspWait:
       rspWaitSec:
         Pending    RegisterRead
         cmd        As103CA001F123475FA4CA03040000000001
         forChn     03
         forList    01
         forPeer    
         mNo        60
         nAddr      0
         reSent     3
     q:
       qReqConf   00
       qReqStat   
     regCollect:
     role:
       dev        1
       prs        1
     rssi:
       at_HmUART_AB_GTO:
         avg        -73.7333333333333
         cnt        30
         lst        -73
         max        -70
         min        -75
       at_HmUART_EG:
         avg        -57.9677419354839
         cnt        31
         lst        -57
         max        -57
         min        -58
       at_HmUART_OG1:
         avg        -73.5161290322581
         cnt        31
         lst        -71
         max        -70
         min        -76
       at_HmUART_OG2:
         avg        -67.5
         cnt        30
         lst        -68
         max        -66
         min        -68
     shRegW:
       07         04
     shadowReg:
     tmpl:
Attributes:
   IODev      HmUART_EG
   IOgrp      VCCU
   actCycle   000:10
   actStatus  alive
   alias      EG Bad - Heizung - Raumthermostat
   autoReadReg 4_reqStatus
   burstAccess 1_auto
   devStateStyle style="text-align:left;;font-weight:bold;;"
   event-on-change-reading .*
   expert     251_anything
   firmware   1.4
   group      EG Bad - Heizung
   icon       hc_wht_regler
   model      HM-CC-RT-DN
   room       Heizung,_HM,EG-Bad
   rssiLog    1
   serialNr   OEQ1695245
   sortby     05.01
   subType    thermostat
   userattr   Heizung Heizung_map structexclude
   webCmd     getConfig:clear msgEvents:burstXmit

Darum kommt es zur Überlastung an der einen Schnittstelle, trotz das zwischen den Updates der einzelnen HomeMatic Geräten immer mindestens 10 Minuten liegen.
Die VCCU ignorriert das definierten Attribute IODev und verwendet immer den gleichen HM-MOD-UART.

list VCCU

Code Auswählen

Internals:
   CFGFN      /media/hdd/fhem/mycfg/HM/hm_rasp01.cfg
   CHANGED    
   DEF        F12347
   FUUID      5c45b04c-f33f-f4d2-4334-8937b207a433d26e
   HmUART_AB_GTO_MSGCNT 256
   HmUART_AB_GTO_RAWMSG 0500004D8F8002F1234768CEFE00
   HmUART_AB_GTO_RSSI -77
   HmUART_AB_GTO_TIME 2020-02-02 13:47:56
   HmUART_EG_MSGCNT 277
   HmUART_EG_RAWMSG 050000418F8002F1234768CEFE00
   HmUART_EG_RSSI -65
   HmUART_EG_TIME 2020-02-02 13:47:54
   HmUART_OG1_MSGCNT 286
   HmUART_OG1_RAWMSG 050000410A3011F123475FA4CACA
   HmUART_OG1_RSSI -65
   HmUART_OG1_TIME 2020-02-02 13:47:57
   HmUART_OG2_MSGCNT 406
   HmUART_OG2_RAWMSG 0500005601803FF123475FA4CA020225C981AA
   HmUART_OG2_RSSI -86
   HmUART_OG2_TIME 2020-02-02 13:48:14
   IODev      HmUART_OG2
   LASTInputDev HmUART_OG2
   MSGCNT     1225
   NAME       VCCU
   NOTIFYDEV  global
   NR         2677
   NTFY_ORDER 50-VCCU
   STATE      HmUART_OG1:ERROR-Overload,HmUART_EG:Warning-HighLoad,HmUART_OG2:ok,HmUART_AB_GTO:ok,HmUART_AB_FR:ok
   TYPE       CUL_HM
   assignedIOs HmUART_AB_FR,HmUART_AB_GTO,HmUART_EG,HmUART_OG1,HmUART_OG2
   channel_01 VCCU_Btn1
   channel_02 VCCU_Btn2
   channel_03 VCCU_Btn3
   channel_04 VCCU_Btn4
   channel_05 VCCU_Btn5
   channel_06 VCCU_Btn6
   channel_07 VCCU_Btn7
   channel_08 VCCU_Btn8
   channel_09 VCCU_Btn9
   channel_0A VCCU_Btn10
   channel_0B VCCU_Btn11
   channel_0C VCCU_Btn12
   lastMsg    No:01 - t:3F s:F12347 d:5FA4CA 020225C981AA
   protLastRcv 2020-02-02 13:48:14
   protRcv    564 last_at:2020-02-02 13:48:14
   protRcvB   194 last_at:2020-02-02 13:47:58
   rssi_at_HmUART_AB_GTO cnt:256 min:-85 max:-51 avg:-72.03 lst:-77 
   rssi_at_HmUART_EG cnt:277 min:-90 max:-65 avg:-71.63 lst:-65 
   rssi_at_HmUART_OG1 cnt:286 min:-87 max:-62 avg:-67.33 lst:-65 
   rssi_at_HmUART_OG2 cnt:406 min:-88 max:-49 avg:-72.06 lst:-86 
   READINGS:
     2020-02-02 13:48:14   CommandAccepted yes
     2020-02-02 13:47:58   IOopen          4
     2020-02-02 06:33:53   aesReqTo        OG1_WZ_HZG_RT
     2020-02-02 13:47:56   rssi_at_HmUART_AB_GTO -77
     2020-02-02 13:47:54   rssi_at_HmUART_EG -65
     2020-02-02 13:47:57   rssi_at_HmUART_OG1 -65
     2020-02-02 13:48:14   rssi_at_HmUART_OG2 -86
     2020-02-02 13:47:58   state           HmUART_OG1:ERROR-Overload,HmUART_EG:Warning-HighLoad,HmUART_OG2:ok,HmUART_AB_GTO:ok,HmUART_AB_FR:ok
     2019-11-19 09:25:14   unknown_4434E6  received
     2019-08-29 15:27:06   unknown_5881F2  received
     2019-08-29 13:56:52   unknown_5A1CBD  received
     2019-11-18 10:34:20   unknown_5F0196  received
     2019-11-08 14:36:34   unknown_5FFB9D  received
     2019-09-24 17:25:08   unknown_634296  received
     2019-08-28 20:37:11   unknown_63429B  received
     2019-09-04 18:11:07   unknown_673948  received
     2019-12-10 10:08:35   unknown_6873E1  received
     2019-11-22 16:37:53   unknown_687A5A  received
     2019-10-04 15:35:36   unknown_69547E  received
     2019-09-24 19:24:05   unknown_6A53A9  received
     2019-09-24 20:15:42   unknown_6A53C7  received
     2019-07-28 10:53:11   unknown_6A783B  received
     2019-12-10 10:41:42   unknown_6B4031  received
     2020-01-06 17:48:31   unknown_8364BA  received
     2019-10-29 19:35:59   unknown_BA3003  received
   helper:
     HM_CMDNR   1
     PONtest    1
     mId        FFF0
     peerFriend peerSens,peerAct
     peerOpt    -:virtual
     regLst     0
     rxType     1
     supp_Pair_Rep 0
     ack:
     expert:
       def        1
       det        0
       raw        0
       tpl        0
     io:
       nextSend   1580647693.91011
       prefIO     
       vccu       VCCU
       ioList:
         HmUART_OG1
         HmUART_EG
         HmUART_OG2
         HmUART_AB_GTO
         HmUART_AB_FR
     mRssi:
       mNo        01
       io:
         HmUART_AB_GTO:
         HmUART_EG:
         HmUART_OG1:
         HmUART_OG2:
           -84
           -84
     prt:
       bErr       0
       sProc      0
       rspWait:
     q:
       qReqConf   
       qReqStat   
     role:
       dev        1
       vrt        1
     rssi:
       at_HmUART_AB_GTO:
         avg        -72.0390625
         cnt        256
         lst        -77
         max        -51
         min        -85
       at_HmUART_EG:
         avg        -71.6353790613718
         cnt        277
         lst        -65
         max        -65
         min        -90
       at_HmUART_OG1:
         avg        -67.3391608391608
         cnt        286
         lst        -65
         max        -62
         min        -87
       at_HmUART_OG2:
         avg        -72.0689655172414
         cnt        406
         lst        -86
         max        -49
         min        -88
     tmpl:
   role:
Attributes:
   IODev      HmUART_OG2
   IOList     HmUART_OG1,HmUART_EG,HmUART_OG2,HmUART_AB_GTO,HmUART_AB_FR
   IOgrp      VCCU
   aesCommReq 0
   alias      HomeMatic Virtuelle CCU
   event-on-change-reading .*
   group      .HomeMatic VCCU
   hmKey      01:e1fa95c5613ea3c257a6862a2fdc6bf9
   hmKey2     02:eb6e444f34df0e509c3a82a0a079772c
   hmKey3     03:ee955645ccc18dc0ebb5a137bf7c9e70
   icon       hm_ccu
   model      CCU-FHEM
   room       _HM,_Kontaktsensoren,_RxTx
   rssiLog    1
   subType    virtual
   verbose    0
   webCmd     virtual:update

Nur warum wird die Konfiguration ignoriert?

frank · 02 Februar 2020, 14:27:49

ZitatDarum kommt es zur Überlastung an der einen Schnittstelle, trotz das zwischen den Updates der einzelnen HomeMatic Geräten immer mindestens 10 Minuten liegen.
Die VCCU ignorriert das definierten Attribute IODev und verwendet immer den gleichen HM-MOD-UART.

das ist falsch.

1. 10 min warten bringt nicht viel. schau dir msgloadhistory im io an. hmuart hat auch ein attribut um den dutycycle aus zu schalten.

2. am device hast du kein prefered io gesetzt (IOgrp), die vccu sucht sich eins aus. eg und og1 zeigen fehler, vccu wählt og2, was im internal IODev sichtbar ist.

3. ein "optimales" io ist nicht über wlan angebunden.

4. beim error "not in bootloader" musst du wahrscheinlich das device manuell in den bootloader setzen und vorher den cmd set fwupdate mit optionaler "waittime" aufrufen.

Burny4600 · 02 Februar 2020, 14:47:32

zu 1.

Zitatattribut um den dutycycle aus zu schalten.

Ist grundsätzlich für lokalem Standort nicht gestattet auszuschalten.

list HmUART_OG2

Code Auswählen

Internals:
   AssignedPeerCnt 32
   CFGFN      /media/hdd/fhem/mycfg/schnittstellen_rasp01.cfg
   CNT        227
   Clients    :CUL_HM:
   DEF        /dev/ttyAMA0
   DEVCNT     172
   DevState   99
   DevType    UART
   DeviceName /dev/ttyAMA0@115200
   FD         236
   FUUID      5c45b01a-f33f-f4d2-8d3f-2afd62f7e9d7ecdc
   LastOpen   1580642733.27259
   NAME       HmUART_OG2
   NOTIFYDEV  global
   NR         252
   NTFY_ORDER 50-HmUART_OG2
   PARTIAL    
   RAWMSG     05000056DA865A69547E000000B0E13A
   RSSI       -86
   STATE      opened
   TYPE       HMUARTLGW
   XmitOpen   1
   model      HM-MOD-UART
   msgLoadCurrent 2
   msgLoadHistory 0/0/0/0/0/0/0/0/-3/0/0/-3
   msgLoadHistoryAbs 3/3/3/3/3/3/3/3/3/6/6/6/9
   owner      F12347
   owner_CCU  VCCU
   Helper:
     CreditTimer 278
     FW         66561
     Initialized 1
     SendCnt    66
     AckPending:
     LastSendLen:
       3
       3
     Log:
       IDs:
     PendingCMD:
     RoundTrip:
       Delay      0.00400519371032715
     loadLvl:
       lastHistory 1580651278.58773
   MatchList:
     1:CUL_HM   ^A......................
   Peers:
     43E7D8     +43E7D8,00,03,00
     4B52A1     +4B52A1,00,03,00
     4C1DAB     +4C1DAB,00,03,00
     4C1E47     +4C1E47,00,03,00
     4C1E60     +4C1E60,00,03,00
     4C1E8B     +4C1E8B,00,03,00
     4C218B     +4C218B,00,03,00
     4C21C5     +4C21C5,00,03,00
     4C23A3     +4C23A3,00,03,00
     4C2435     +4C2435,00,03,00
     4DEBC0     +4DEBC0,00,03,00
     544FEE     +544FEE,00,03,00
     5555EE     +5555EE,00,03,00
     568911     +568911,00,03,00
     568BB9     +568BB9,00,03,00
     568BBB     +568BBB,00,03,00
     5781A2     +5781A2,00,03,00
     5A1C9D     +5A1C9D,00,03,00
     5A1CAC     +5A1CAC,02,03,00
     5C1ED3     +5C1ED3,00,03,00
     5D014C     +5D014C,00,03,00
     5D015F     +5D015F,00,03,00
     5D0180     +5D0180,00,03,00
     5D0196     +5D0196,00,03,00
     5E59A8     +5E59A8,00,03,00
     5FA4C0     +5FA4C0,00,03,00
     6181EC     +6181EC,00,03,00
     634286     +634286,00,03,00
     647C0D     +647C0D,00,03,00
     69EEF8     +69EEF8,00,03,00
     69F0C5     +69F0C5,00,03,00
     6B4031     +6B4031,00,03,00
   READINGS:
     2020-02-02 12:37:55   D-HMIdAssigned  F12347
     2020-02-02 12:37:56   D-HMIdOriginal  4C3DB2
     2020-02-02 12:37:57   D-firmware      1.4.1
     2020-02-02 12:37:57   D-serialNr      NEQ0605280
     2020-02-02 12:22:14   D-type          HM-MOD-UART
     2020-02-02 12:38:22   cond            ok
     2020-02-02 14:49:53   load            2
     2020-02-02 12:38:22   loadLvl         low
     2020-02-02 12:25:33   state           opened
   helper:
Attributes:
   alias      HomeMatic Gateway - OG2 EDV Raum
   devStateIcon init:hm_lan@orange opened:hm_lan@0CFB0C
   dutyCycle  1
   group      Schnittstellen HomeMatic
   hmId       F12347
   icon       hm_lan
   qLen       60
   room       Brandmeldeanlage,_HM,_RxTx
   verbose    0

zu 2.

Zitatam device hast du kein prefered io gesetzt (IOgrp),

Mir wurde geraten die Konfiguration immer so auszuführen.
Primär ist das IODev zu definieren welches das Gerät verwendet. Fällt diese Schnittstelle aus teilt die VCCU die nächst bessere zu.
Darum ist unter IOgrp nur die VCCU.
Was stimmt jetzt wirklich bei Verwendung mehrer Schnittstellen?

zu 3.

Zitatio ist nicht über wlan angebunden.

Bei mir gibt es keine WLAN Verbindung für HomeMatic. Alles was mit HomeMatic zu tun hat ist über LAN verbunden.

zu 4.

Zitatbeim error "not in bootloader" musst du wahrscheinlich das device manuell in den bootloader setzen und vorher den cmd set fwupdate mit optionaler "waittime" aufrufen.

Gibt es dafür ein Wiki?

frank · 02 Februar 2020, 15:22:26

1. richtig.
wenn es niemanden in reichweite stören kann, könnte man es sicher ausnahmweise mal ausschalten.
ein haufen io installieren, um ein grundsätzlich zu hohes sendekontingent dauerhaft und regelkonform "auszuhebeln" finde ich fragwürdiger.
besser ist in jedem fall genügend lange zu warten.

2. berater wechseln.

3. prima.

4. keine ahnung.

Burny4600 · 02 Februar 2020, 16:49:32

Zitatein haufen io installieren, um ein grundsätzlich zu hohes sendekontingent dauerhaft und regelkonform "auszuhebeln" finde ich fragwürdiger.

Ich brauche die IOs um alle HM Geräte ordentlich erreichen zu können.
Das sind in meinem Fall 100 HM Geräte verteilt über 3 Stockwerke und die Aussenanlagen.

Also ist für die HM Geräte sowohl die IODev und die IOgrp mit dem gleichen IO zu definieren um dieses IO primär zu verwenden.
list Auszug

Code Auswählen

Attributes:
   IODev      HmUART_EG
   IOgrp      VCCU:HmUART_EG

Wird dann bei Ausfall dieses IO HmUART_EG auf ein IO in der VCCU IOList zurückgegriffen welches den Besten Empfang hat?

frank · 02 Februar 2020, 17:02:00

attr iodev "verwaltet" deine vccu, du "fasst" es nicht mehr an. es muss nur vorhanden sein.

das prefered io in iogrp wird natürlich gewechselt, wenn es nicht verfügbar ist. du kannst auch eine liste von prefered ios angeben, die bei problemen der reihe nach genutzt werden sollen.

Burny4600 · 02 Februar 2020, 19:52:35

Entweder verstehe ich immer noch etwas nicht, denn unter https://wiki.fhem.de/wiki/Virtueller_Controller_VCCU wird für Device sehrwohl die Konfiguration

Code Auswählen

attr <device> IOgrp VCCU
für die Zuteilung nach RSSI angeführt. Das wiederspricht sich mit deiner Angabe. Oder?

Nur was ist jetzt grundsätzlich die bessere Lösung.
attr <device> IOgrp VCCU => es wird von der VCCU nach RSSI das IO zugeteilt und in der VCCU ist das attr <VCCU> IOList IO1,IO2,IOx definiert, oder
attr <device> IOgrp VCCU:IO1,IO2,IOx => das Device selbst greift bei Ausfall eines IOs auf das nächste zu.

Bei der VCCU wurde ein IODev bei der Einrichtung angelegt. Dann ist auch hier keine Änderung notwendig weil auch die VCCU dieses Attribut nicht interessiert.
Habe ich das richtig verstanden.
Nur für was ist diese Attribut bei der VCCU überhaupt nützlich?
Bei den Devices verstehe ich es, weil diese auch ohne VCCU betrieben werden können.

Aber wir driften hier vom Firmware Update Fehlerfall ab.
Mittlerweile habe ich einige Update Tests ausgeführt und bei den meisten fail unter fwUpdate trotz das das Update mit CMDs_done_FWupdate fertiggestellt wurde.

frank · 03 Februar 2020, 12:45:03

ZitatNur was ist jetzt grundsätzlich die bessere Lösung.

das kann man natürlich nicht pauschal beantworten.
je nach device und verfügbaren io sehr unterschiedlich.

es macht jedenfalls (fast) keinen sinn, stationären devices "ständig" ein anderes io, je nach rssi, zu zu weisen. der rssi schwankt zwar ein wenig, aber grundsätzlich sollte immer ein bestimmtes io den "besten" empfang haben.

bei "beweglichen" fernbedienungen sieht es wieder ganz anders aus.

auch sollte man die credit verteilung im auge haben, damit nicht einzelne io "überlastet" werden, nur weil sie zufällig die besten rssi haben.

andere kriterien könnten unterschiedliche io fähigkeiten sein: aes, timing, ota, ...

Burny4600 · 03 Februar 2020, 18:35:16

Ich werden jetzt fürs erste Anpassungen machen, die nicht auf RSSI Verteilung der VCCU achten, sondern am Device selbst die IO Verteilung machen.
Das dürfte die bessere Lösung sein.
Dann werde ich nochmals mit den Firmware Update beginnen.

Burny4600 · 04 Februar 2020, 11:06:13

Ich habe jetzt gezielt nur bei einem Geräte das Firmwareupdate ausgeführt.
Beim ersten Update gab es zum Schluß das Reading fwUpdate fail:notInBootLoader bzw. CMDs_done_FWupdate als Abschluß.
Funktion des HM-TC-IT-WM-W-EU ist fehlerhaft.
Nach einiger Zeit habe ich nochmals einen Update Versuch mit Verbose 5 gestartet. Und wieder steht im Reading fwUpdate fail:Block3 anstatt fwUpdate done.

Log des Firmware Updates des HM-TC-IT-WM-W-EU.

Code Auswählen

2020.02.04 09:18:59.082 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:19:05.279 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:19:05.313 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:19:06.565 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_done
2020.02.04 09:19:06.566 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 09:19:06.719 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_done
2020.02.04 09:19:06.720 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 09:19:09.476 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_done
2020.02.04 09:19:09.476 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 09:19:09.593 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_done
2020.02.04 09:19:09.593 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 09:19:09.691 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_done
2020.02.04 09:19:09.692 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 09:19:09.833 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_done
2020.02.04 09:19:09.833 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 09:19:09.933 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_done
2020.02.04 09:19:09.933 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 09:19:10.032 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_done
2020.02.04 09:19:10.032 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 09:19:14.273 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_pending pending:1
2020.02.04 09:19:14.274 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_pending pending:2
2020.02.04 09:19:14.274 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_pending pending:3
2020.02.04 09:19:14.275 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_pending pending:4
2020.02.04 09:19:14.276 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_pending pending:5
2020.02.04 09:19:14.276 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_pending pending:6
2020.02.04 09:19:14.276 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_pending pending:7
2020.02.04 09:19:14.277 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_pending pending:8
2020.02.04 09:19:14.277 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_pending pending:9
2020.02.04 09:19:14.278 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_pending pending:10
2020.02.04 09:19:14.278 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_pending pending:11
2020.02.04 09:19:14.278 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_pending pending:12
2020.02.04 09:19:14.279 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_pending pending:13
2020.02.04 09:19:14.279 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_pending pending:14
2020.02.04 09:19:14.279 3: CUL_HM set OG1_WZ_HZG_TC getConfig
2020.02.04 09:19:14.284 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:14
2020.02.04 09:19:15.548 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:13
2020.02.04 09:19:15.585 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:19:15.606 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:19:16.673 3: CUL_HM set RGB_AB_FR_Dim statusRequest
2020.02.04 09:19:17.834 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:13
2020.02.04 09:19:17.834 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 09:19:17.848 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:12
2020.02.04 09:19:18.957 1: waiting for: PeerList, got:RegisterRead # await msgNo:6, rec:4
2020.02.04 09:19:18.958 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:12
2020.02.04 09:19:18.959 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 09:19:18.981 1: waiting for: PeerList, got:RegisterRead # await msgNo:6, rec:5
2020.02.04 09:19:18.997 1: waiting for: PeerList, got:RegisterRead # await msgNo:6, rec:4
2020.02.04 09:19:18.998 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:12
2020.02.04 09:19:18.999 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 09:19:19.008 1: waiting for: PeerList, got:RegisterRead # await msgNo:6, rec:5
2020.02.04 09:19:20.175 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:11
2020.02.04 09:19:20.196 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:19:21.247 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:19:22.591 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:10
2020.02.04 09:19:23.746 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_FWupdate pending:10
2020.02.04 09:19:23.746 2: CUL_HM fwUpdate started for OG1_WZ_HZG_TC
2020.02.04 09:19:23.760 3: CUL_HM set OG1_WZ_HZG_TC fwUpdate FHEM/homematic/firmware/hm_tc_it_wm_w_eu/hm_tc_it_wm_w_eu_update_V1_4_002_170213.eq3 60
2020.02.04 09:19:24.172 3: set OG1_WC_HZG_TC_Weather_vT_S virtTemp 20.5 : FW update in progress - please wait
2020.02.04 09:19:24.173 3: OG1_WC_HZG_TC_Weather_vt_at: FW update in progress - please wait
2020.02.04 09:19:47.569 4: CUL_HM_Resend: OG1_WZ_HZG_TC nr 2
2020.02.04 09:19:47.584 2: CUL_HM fwUpdate OG1_WZ_HZG_TC entered mode. IO-speed: fast
2020.02.04 09:19:47.669 5: CUL_HM fwUpdate write block 1 of 213: 10 messages
2020.02.04 09:19:47.692 5: CUL_HM fwUpdate write block 2 of 213: 10 messages
2020.02.04 09:19:47.714 5: CUL_HM fwUpdate write block 3 of 213: 10 messages
2020.02.04 09:19:52.925 5: CUL_HM fwUpdate write block 3 of 213: 10 messages
2020.02.04 09:19:58.239 5: CUL_HM fwUpdate write block 3 of 213: 10 messages
2020.02.04 09:20:03.867 5: CUL_HM fwUpdate write block 3 of 213: 10 messages
2020.02.04 09:20:11.965 5: CUL_HM fwUpdate write block 3 of 213: 10 messages
2020.02.04 09:20:17.743 5: CUL_HM fwUpdate write block 3 of 213: 10 messages
2020.02.04 09:20:22.785 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_done_FWupdate
2020.02.04 09:20:22.786 2: CUL_HM fwUpdate OG1_WZ_HZG_TC end. IO-speed: normal
2020.02.04 09:25:47.561 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:27:47.965 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:27:58.043 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:28:23.513 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:28:24.948 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:29:56.672 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:29:56.706 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:30:27.319 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:30:33.480 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:30:33.637 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:32:54.262 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:32:54.369 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:32:54.428 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:33:14.324 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:33:14.432 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:33:14.440 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:35:49.051 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:35:49.224 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:35:50.575 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:36:37.659 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:36:37.990 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:36:40.677 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:38:23.320 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:38:24.765 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:38:25.143 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:38:32.712 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:38:33.842 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:38:33.846 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:40:29.935 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:40:29.939 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:40:29.945 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:40:58.911 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:40:59.169 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:40:59.344 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:43:01.188 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:43:06.410 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:43:06.745 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:45:37.905 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:45:39.186 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:45:39.301 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:46:03.584 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:46:03.743 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:46:03.926 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:48:15.118 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:48:39.379 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:50:28.297 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:50:28.403 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:50:28.407 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:50:53.716 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:51:17.225 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:51:17.435 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:52:55.703 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:52:56.128 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:52:57.397 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:52:57.517 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:52:58.678 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:55:35.516 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:55:35.522 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:55:35.561 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:56:09.955 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:56:10.038 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:56:10.154 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:58:19.794 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:58:19.900 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:58:20.006 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:58:39.791 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:58:39.797 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 09:58:39.902 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:01:06.916 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:01:07.375 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:01:23.809 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:03:15.181 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:03:21.860 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:05:08.476 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:05:08.598 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:05:42.762 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:05:58.072 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:07:57.299 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:07:57.304 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:08:07.304 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:08:07.409 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:08:17.196 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:08:17.302 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:10:33.545 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:10:33.551 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:11:06.650 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:11:10.778 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:12:55.546 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:12:55.653 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:13:11.374 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:13:16.682 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:13:20.571 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:13:20.619 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:15:02.912 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:15:03.017 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:15:22.950 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:15:23.056 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:17:59.945 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:18:00.053 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:18:19.944 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:18:19.950 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:20:42.800 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:20:42.906 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:20:52.803 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:20:52.808 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:21:02.794 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:21:02.901 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:23:11.046 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:23:11.053 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:23:31.641 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:23:31.645 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:25:24.593 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:25:24.698 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:25:44.598 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:25:44.604 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:28:28.175 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:28:47.952 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:31:18.254 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:31:27.379 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:31:37.367 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:33:51.783 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:34:11.449 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:36:11.579 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:08.724 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_pending pending:1
2020.02.04 10:38:08.725 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_pending pending:2
2020.02.04 10:38:08.726 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_pending pending:3
2020.02.04 10:38:08.726 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_pending pending:4
2020.02.04 10:38:08.727 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_pending pending:5
2020.02.04 10:38:08.727 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_pending pending:6
2020.02.04 10:38:08.728 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_pending pending:7
2020.02.04 10:38:08.728 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_pending pending:8
2020.02.04 10:38:08.729 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_pending pending:9
2020.02.04 10:38:08.729 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_pending pending:10
2020.02.04 10:38:08.729 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_pending pending:11
2020.02.04 10:38:08.730 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_pending pending:12
2020.02.04 10:38:08.730 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_pending pending:13
2020.02.04 10:38:08.731 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_pending pending:14
2020.02.04 10:38:08.731 3: CUL_HM set OG1_WZ_HZG_TC getConfig
2020.02.04 10:38:08.736 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:14
2020.02.04 10:38:09.261 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:13
2020.02.04 10:38:09.269 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:11.343 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:13
2020.02.04 10:38:11.344 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:11.462 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:12
2020.02.04 10:38:11.499 1: waiting for: PeerList, got:RegisterRead # await msgNo:36, rec:34
2020.02.04 10:38:11.500 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:12
2020.02.04 10:38:11.501 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:11.510 1: waiting for: PeerList, got:RegisterRead # await msgNo:36, rec:35
2020.02.04 10:38:11.918 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:11
2020.02.04 10:38:11.927 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:12.212 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:10
2020.02.04 10:38:12.249 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:12.497 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:9
2020.02.04 10:38:12.510 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:12.773 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:8
2020.02.04 10:38:12.792 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:13.086 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:8
2020.02.04 10:38:13.086 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:13.093 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:13.339 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:8
2020.02.04 10:38:13.340 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:13.350 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:13.597 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:8
2020.02.04 10:38:13.598 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:13.714 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:13.860 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:8
2020.02.04 10:38:13.860 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:13.871 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:14.114 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:8
2020.02.04 10:38:14.114 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:14.119 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:14.371 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:8
2020.02.04 10:38:14.372 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:14.388 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:14.627 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:8
2020.02.04 10:38:14.628 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:14.632 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:14.885 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:8
2020.02.04 10:38:14.885 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:14.897 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:14.917 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:15.146 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:8
2020.02.04 10:38:15.146 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:15.151 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:15.403 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:8
2020.02.04 10:38:15.403 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:15.408 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:15.658 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:8
2020.02.04 10:38:15.659 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:15.669 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:15.918 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:8
2020.02.04 10:38:15.918 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:16.036 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:16.174 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:8
2020.02.04 10:38:16.175 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:16.186 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:16.424 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:8
2020.02.04 10:38:16.424 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:16.435 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:16.685 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:7
2020.02.04 10:38:16.810 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:16.824 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:17.016 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:7
2020.02.04 10:38:17.016 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:17.135 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:17.273 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:7
2020.02.04 10:38:17.273 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:17.278 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:17.529 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:7
2020.02.04 10:38:17.530 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:17.635 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:18.673 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:7
2020.02.04 10:38:18.674 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:18.800 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:7
2020.02.04 10:38:18.800 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:18.927 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:7
2020.02.04 10:38:18.927 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:18.939 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:7
2020.02.04 10:38:18.940 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:19.051 1: waiting for: RegisterRead, got:RegisterRead # await msgNo:61, rec:58
2020.02.04 10:38:19.052 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:7
2020.02.04 10:38:19.052 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:19.057 1: waiting for: RegisterRead, got:RegisterRead # await msgNo:61, rec:59
2020.02.04 10:38:19.058 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:7
2020.02.04 10:38:19.059 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:19.063 1: waiting for: RegisterRead, got:RegisterRead # await msgNo:61, rec:60
2020.02.04 10:38:19.065 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:7
2020.02.04 10:38:19.065 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:19.174 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:7
2020.02.04 10:38:19.175 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:19.283 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:7
2020.02.04 10:38:19.284 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:19.340 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:19.352 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:7
2020.02.04 10:38:19.352 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:19.364 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:7
2020.02.04 10:38:19.365 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:19.472 1: waiting for: RegisterRead, got:RegisterRead # await msgNo:64, rec:63
2020.02.04 10:38:19.474 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:7
2020.02.04 10:38:19.474 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:19.482 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:7
2020.02.04 10:38:19.482 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:19.586 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:7
2020.02.04 10:38:19.587 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:19.716 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:20.754 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:7
2020.02.04 10:38:20.755 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:20.867 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:7
2020.02.04 10:38:20.868 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:20.981 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:7
2020.02.04 10:38:20.981 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:21.004 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:6
2020.02.04 10:38:21.030 1: waiting for: RegisterRead, got:RegisterRead # await msgNo:70, rec:66
2020.02.04 10:38:21.031 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:6
2020.02.04 10:38:21.031 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:21.036 1: waiting for: RegisterRead, got:RegisterRead # await msgNo:70, rec:67
2020.02.04 10:38:21.037 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:6
2020.02.04 10:38:21.038 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:21.042 1: waiting for: RegisterRead, got:RegisterRead # await msgNo:70, rec:68
2020.02.04 10:38:21.044 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:6
2020.02.04 10:38:21.044 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:21.049 1: waiting for: RegisterRead, got:RegisterRead # await msgNo:70, rec:69
2020.02.04 10:38:21.159 1: waiting for: RegisterRead, got:RegisterRead # await msgNo:70, rec:66
2020.02.04 10:38:21.160 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:6
2020.02.04 10:38:21.160 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:21.221 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:6
2020.02.04 10:38:21.221 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:21.228 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:21.462 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:6
2020.02.04 10:38:21.463 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:21.474 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:21.715 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:6
2020.02.04 10:38:21.715 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:21.725 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:21.976 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:6
2020.02.04 10:38:21.976 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:21.987 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:22.231 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:6
2020.02.04 10:38:22.232 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:22.237 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:22.487 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:6
2020.02.04 10:38:22.487 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:22.504 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:22.748 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:6
2020.02.04 10:38:22.748 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:22.854 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:23.003 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:6
2020.02.04 10:38:23.004 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:23.110 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:23.262 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:6
2020.02.04 10:38:23.262 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:23.272 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:23.515 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:6
2020.02.04 10:38:23.515 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:23.525 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:23.771 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:6
2020.02.04 10:38:23.772 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:23.907 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:24.033 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:6
2020.02.04 10:38:24.033 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:24.139 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:24.287 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:6
2020.02.04 10:38:24.288 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:24.293 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:24.540 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:6
2020.02.04 10:38:24.540 5: CUL_HM OG1_WZ_HZG_TC sent ACK:2
2020.02.04 10:38:24.551 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:24.796 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:5
2020.02.04 10:38:24.821 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:25.081 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:8
2020.02.04 10:38:25.188 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:25.467 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:7
2020.02.04 10:38:25.591 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:25.758 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:6
2020.02.04 10:38:25.771 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:26.044 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:5
2020.02.04 10:38:26.063 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:26.328 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:4
2020.02.04 10:38:26.443 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:26.628 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:3
2020.02.04 10:38:26.733 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:26.977 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:27.128 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:2
2020.02.04 10:38:27.256 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:27.432 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:1
2020.02.04 10:38:27.455 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:28.663 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_processing... pending:0
2020.02.04 10:38:28.687 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:28.886 5: CUL_HM OG1_WZ_HZG_TC protEvent:CMDs_done
2020.02.04 10:38:29.011 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:36.973 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process
2020.02.04 10:38:37.078 4: CUL_HM OG1_WZ_HZG_TC dupe: dont process

Wenn ich das gleiche Gerät über die Shell Update, funktioniert das Update nicht (FHEM und andere zugehörigen Dienste für FHEM wurden vorher abgeschaltet.

Code Auswählen

sudo ./flash-ota -c /dev/ttyAMA0 -f hm_tc_it_wm_w_eu_update_V1_4_002_170213.eq3 -s 5883F0

Code Auswählen


pi@ccs-ht-rasp01:/usr/src/hmcfgusb $ sudo ./flash-ota -c /dev/ttyAMA0 -f  hm_tc_it_wm_w_eu_update_V1_4_002_170213.eq3 -s 5883F0
HomeMatic OTA flasher version 0.103-git

Reading firmware from hm_tc_it_wm_w_eu_update_V1_4_002_170213.eq3...
Firmware with 213 blocks successfully read.
Opening culfw-device at path /dev/ttyAMA0 with speed 38400
Requesting firmware version

Das Update bleibt bei Requesting firmware version stehen.
Irgendwo habe ich noch einen Fehler.

frank · 04 Februar 2020, 11:30:29

poste mal ein aktuelles list vom tc.

grundsätzlich kann jeder sender (auch ein tc) overload probleme bekommen. allerdings hat der tc eigentlich nicht viel zu senden beim update.

keine ahnung was der flasher im einzelnen tut, aber eventuell wartet er auch auf eine "reaktion" vom tc.

Morgennebel · 04 Februar 2020, 12:01:51

Ich flashe die zickigen TCs und EUs mit Hilfe des USB-HM-Sticks und dem Commandline-Tool. Das klappt immer super, alles, was vorher 10+ mal zickte, läuft mit dem USB-Stick beim 1. Versuch.

Hab einfach einen alten PI mit dem USB-Stick und WiFi im Schrank, lege den in die Nähe des Zieles und starte das Update von dort über die Seriennummer...

Ciao, -MN

Burny4600 · 04 Februar 2020, 19:15:50

Hier das list des getesteten HM-TC-IT-WM-W-EU
OG1_WZ_HZG_TC

Code Auswählen

Internals:
   CFGFN      /media/hdd/fhem/mycfg/HM/hm_rasp01.cfg
   CHANGED    
   DEF        5883F0
   FUUID      5c45b04e-f33f-f4d2-df7f-7cb2390001db68c5
   HmUART_AB_GTO_MSGCNT 17
   HmUART_AB_GTO_RAWMSG 0500004A1684705883F000000000F22E
   HmUART_AB_GTO_RSSI -74
   HmUART_AB_GTO_TIME 2020-02-04 18:55:25
   HmUART_EG_MSGCNT 9
   HmUART_EG_RAWMSG 0500015B1584705883F000000000F22E
   HmUART_EG_RSSI -91
   HmUART_EG_TIME 2020-02-04 18:52:50
   HmUART_OG1_MSGCNT 15
   HmUART_OG1_RAWMSG 050000471684705883F000000000F22E
   HmUART_OG1_RSSI -71
   HmUART_OG1_TIME 2020-02-04 18:55:26
   HmUART_OG2_MSGCNT 16
   HmUART_OG2_RAWMSG 050000481684705883F000000000F22E
   HmUART_OG2_RSSI -72
   HmUART_OG2_TIME 2020-02-04 18:55:25
   IODev      HmUART_OG1
   LASTInputDev HmUART_OG1
   MSGCNT     57
   NAME       OG1_WZ_HZG_TC
   NOTIFYDEV  global
   NR         3760
   NTFY_ORDER 50-OG1_WZ_HZG_TC
   STATE      CMDs_done
   TYPE       CUL_HM
   channel_01 OG1_WZ_HZG_TC_Weather
   channel_02 OG1_WZ_HZG_TC_Climate
   channel_03 OG1_WZ_HZG_TC_WindowRec
   channel_06 OG1_WZ_HZG_TC_remote
   channel_07 OG1_WZ_HZG_TC_SwitchTr
   lastMsg    No:16 - t:70 s:5883F0 d:000000 00F22E
   protCondBurst unknown
   protLastRcv 2020-02-04 18:55:25
   protRcv    17 last_at:2020-02-04 18:55:25
   rssi_at_HmUART_AB_GTO cnt:17 min:-74 max:-69 avg:-70 lst:-74 
   rssi_at_HmUART_EG cnt:9 min:-95 max:-91 avg:-93.11 lst:-91 
   rssi_at_HmUART_OG1 cnt:15 min:-77 max:-71 avg:-75.2 lst:-71 
   rssi_at_HmUART_OG2 cnt:16 min:-75 max:-72 avg:-73.31 lst:-72 
   READINGS:
     2020-02-04 18:44:07   Activity        alive
     2020-02-04 10:38:09   CommandAccepted yes
     2019-01-21 12:43:34   D-firmware      1.3
     2020-02-04 09:18:57   D-serialNr      OEQ0299977
     2020-02-04 10:38:11   PairedTo        0xF12347
     2019-01-21 13:31:00   R-btnLock       on
     2019-01-21 13:31:00   R-burstRx       on
     2019-01-21 13:31:00   R-cyclicInfoMsg on
     2019-01-21 13:31:00   R-cyclicInfoMsgDis 0
     2019-01-21 13:31:00   R-globalBtnLock off
     2019-01-21 13:31:00   R-localResDis   off
     2019-01-21 13:31:00   R-lowBatLimitRT 2.2 V
     2019-01-21 13:31:00   R-modusBtnLock  off
     2019-01-21 13:31:00   R-pairCentral   0xF12347
     2020-02-04 10:38:11   RegL_00.        00:00 01:01 02:01 09:01 0A:F1 0B:23 0C:47 0F:01 11:00 12:16 16:01 18:00 19:00 1A:00
     2020-02-04 11:03:39   RegL_07.        
     2020-02-02 16:56:37   aesCommToDev    ok
     2020-02-02 16:56:37   aesKeyNbr       00
     2020-02-04 18:40:16   battery         ok
     2020-02-04 18:40:16   batteryLevel    3.5
     2020-02-04 18:40:16   desired-temp    22.0
     2020-02-04 09:20:22   fwUpdate        fail:Block3
     2020-02-04 18:40:16   measured-temp   24.2
     2020-02-04 09:19:10   powerOn         2020-02-04 09:19:09
     2020-02-04 09:19:10   recentStateType info
     2020-01-06 01:19:43   rssi_HmUART_AB_GTO -60
     2020-02-02 06:31:03   rssi_HmUART_OG1 -72
     2020-01-29 06:12:59   rssi_HmUART_OG2 -66
     2020-02-04 18:55:25   rssi_at_HmUART_AB_GTO -74
     2020-02-04 18:52:50   rssi_at_HmUART_EG -91
     2020-02-04 18:55:26   rssi_at_HmUART_OG1 -71
     2020-02-04 18:55:25   rssi_at_HmUART_OG2 -72
     2020-02-04 10:38:28   state           CMDs_done
     2020-02-03 19:58:24   time-request    -
   helper:
     HM_CMDNR   22
     mId        00AD
     peerFriend 
     peerOpt    -:thermostat
     regLst     0
     rxType     6
     supp_Pair_Rep 0
     expert:
       def        1
       det        1
       raw        1
       tpl        1
     io:
       newChn     +5883F0,00,03,00
       nextSend   1580838926.07454
       rxt        0
       vccu       VCCU
       p:
         5883F0
         00
         03
         00
       prefIO:
         HmUART_OG1
         HmUART_OG2
         HmUART_AB_GTO
     mRssi:
       mNo        16
       io:
         HmUART_AB_GTO:
           -74
           -74
         HmUART_EG:
           -91
         HmUART_OG1:
           -69
           -69
         HmUART_OG2:
           -72
           -72
     prt:
       bErr       0
       sProc      0
     q:
       qReqConf   
       qReqStat   
     role:
       dev        1
       prs        1
     rssi:
       at_HmUART_AB_GTO:
         avg        -70
         cnt        17
         lst        -74
         max        -69
         min        -74
       at_HmUART_EG:
         avg        -93.1111111111111
         cnt        9
         lst        -91
         max        -91
         min        -95
       at_HmUART_OG1:
         avg        -75.2
         cnt        15
         lst        -71
         max        -71
         min        -77
       at_HmUART_OG2:
         avg        -73.3125
         cnt        16
         lst        -72
         max        -72
         min        -75
     shRegW:
       07         02
     tmpl:
Attributes:
   IODev      HmUART_OG1
   IOgrp      VCCU:HmUART_OG1,HmUART_OG2,HmUART_AB_GTO
   actCycle   000:10
   actStatus  alive
   alias      OG1 Wohnzimmer - Heizung - Temperaturcontroller
   autoReadReg 4_reqStatus
   burstAccess 1_auto
   devStateStyle style="text-align:left;;font-weight:bold;;"
   event-on-change-reading .*
   expert     251_anything
   firmware   1.3
   group      OG1 Wohnzimmer - Heizung
   icon       hm-tc-it-wm-w-eu
   model      HM-TC-IT-WM-W-EU
   msgRepeat  1
   room       Heizung,_HM,OG1-Wohnzimmer
   rssiLog    1
   serialNr   OEQ0299977
   sortby     04.01
   subType    thermostat
   webCmd     getConfig:clear msgEvents

Den USB-HM-Sticks gibt es bei ELV nicht mehr, aber grundsätzlich sollte auf der Konsole es kein Problem sein wenn ich den HM-MOD-UART verwende.

frank · 05 Februar 2020, 12:41:56

im list finde sehe ich nichts ungewöhnliches.

wie sieht denn die msgload beim gateway og1 aus, wenn es zum abbruch kommt.
was sagt dann fhem.log? eventuell verbose am hmuart erhöhen.

vielleicht mal prefered io1 mit prefered io2 tauschen.
und sicherstellen, dass das richtige io genutzt wird. zb ein statusrequest senden und anschliessend das internal iodev prüfen.

eventuell sniffen.

Burny4600 · 06 Februar 2020, 17:16:49

@frank
Ich habe beide Vorschläge getestet.
Siehe Anhang.

Ich habe mir einen Test Rasp 3+ mit dem einen HM-MOD-UART bestückt, und nur auf die notwendige Installation beschränkt, welche für den HM-MOD-UART benötigt wird.
Auch hier erreiche ich auf der Konsole mit sudo ./flash-ota -c /dev/ttyAMA0 -f hm_tc_it_wm_w_eu_update_V1_4_002_170213.eq3 60 -s 5883F0 nichts.
Der Test Rasp war zu dem nicht einmal 2m vom gleichem HM-TC-IT-WM-W-EU entfernt.

Code Auswählen

:/usr/src/hmcfgusb $ sudo ./flash-ota -c /dev/ttyAMA0 -f  hm_tc_it_wm_w_eu_update_V1_4_002_170213.eq3 60 -s 5883F0
HomeMatic OTA flasher version 0.103-git

Reading firmware from hm_tc_it_wm_w_eu_update_V1_4_002_170213.eq3...
Firmware with 213 blocks successfully read.
Opening culfw-device at path /dev/ttyAMA0 with speed 38400
Requesting firmware version

Auch über die Konsole des vorhanden Rasp mit vollständiger FHEM Installation, wird das Update über den HmUART_OG2 ausgeführt und sieht genauso aus wie beim Test Rasp.

Jetzt weiß ich nicht mehr weiter woran es liegen kann.

frank · 06 Februar 2020, 19:10:38

Zitat@frank
Ich habe beide Vorschläge getestet.
Siehe Anhang.

ich meinte eigentlich updates über fhem mit deinem produktiven system.

mgernoth · 07 Februar 2020, 16:04:23

Hallo,

Zitat von: Burny4600 am 06 Februar 2020, 17:16:49
Auch hier erreiche ich auf der Konsole mit sudo ./flash-ota -c /dev/ttyAMA0 -f hm_tc_it_wm_w_eu_update_V1_4_002_170213.eq3 60 -s 5883F0 nichts.

Das ist zu erwarten, da der HM-MOD-UART kein CUL ist...

Du brauchst -U, siehe Doku.

Viele Grüße
Michael

Burny4600 · 07 Februar 2020, 16:55:53

@frank

Zitatich meinte eigentlich updates über fhem mit deinem produktiven system.

Das angehängte OG1_WZ_HZG_TC.log ist aus dem produktiven FHEM System.

@mgernoth
Danke für den Tipp. Das sieht jetzt schon anders aus, nur da dürfte am Gerät selbst noch eine Eingabe notwendig sein.

Code Auswählen

:/usr/src/hmcfgusb $ sudo ./flash-ota -U /dev/ttyAMA0 -f  hm_tc_it_wm_w_eu_update_V1_4_002_170213.eq3 60 -s 5883F0                            HomeMatic OTA flasher version 0.103-git

Reading firmware from hm_tc_it_wm_w_eu_update_V1_4_002_170213.eq3...
Firmware with 213 blocks successfully read.
Waiting for application to settle...
HM-MOD-UART firmware version: 1.4.1, used credits: 0%

HM-MOD-UART opened

Entering 10k-mode
Waiting for device with serial 5883F0

Da geht nichts mehr weiter. Das Gerät selbst zeigt CrC bzw. FUP an, wenn ich auf die Boost Taste drücke.

Ich habe noch einen Testaufbau mit einem FTDI232 an das HM-MOD-RPI-PCB Modul erstellt.
Nur da wird zwar der TTL Vorsatz erkannt, aber das HM Modul nicht.

Code Auswählen

/usr/src/hmcfgusb $ sudo ./flash-ota -f hm_tc_it_wm_w_eu_update_V1_4_002_170213.eq3 60 -s 5883F0
HomeMatic OTA flasher version 0.103-git

Reading firmware from hm_tc_it_wm_w_eu_update_V1_4_002_170213.eq3...
Firmware with 213 blocks successfully read.
Can't find/open HM-CFG-USB!
Can't initialize HM-CFG-USB

Da muss ich auch noch etwas übersehen haben.
Jedenfalls die Hardware wurde richtig zusammengebaut. Der HM-MOD-RPI-PCB bekommt genug Strom, denn dieser wird mit einem eigenen Festspannungsregler mit 3,3V versorgt.

Mittlerweile habe ich bei zwei Geräten CrC im Display stehen. Drücke ich die Boost Taste wird FUP angezeigt.
Nur warum startet das Firmwareupdate auf der Konsole nicht wenn FHEM fwUpdate fail:notInBootLoader oder fail:Block3 meldet.
Unter FHEM wird jedenfalls kein Update fertig. Es stehen unterschiedliche fwUpdate Meldungen. Gelegentlich wird dann doch wieder einmal ein Gerät ordnungsgemäß mit dem Firmware Update fertig (fwUpdate done).

Burny4600 · 08 Februar 2020, 10:07:57

Mittlerweile habe ich herausgefunden wie das Firmware Update auf der Konsole funktioniert.
Es spielt auch keine Rolle ob das Display die gewöhnliche Funktion anzeigt oder CrC bzw. FUP.
Die Batterien sind aus dem Gerät zu entfernen.
Auf der Konsole wird folgendes für den Firmware Start eingegeben.

Code Auswählen

:/usr/src/hmcfgusb $ sudo ./flash-ota -U /dev/ttyAMA0 -f hm_tc_it_wm_w_eu_update_V1_4_002_170213.eq3 60 -s PEQ1259473
Diese Eingabe ist entsprechend des verwendeten Geräts oder Speicherortes der Firmware anzupassen, wenn ihr das Update auf der Konsole ausführt.
Am Gerät RT oder TC sind die beiden äußeren Tasten festzuhalten und es werden die Batterien eingelegt.
Dies sollte eigentlich nur bei älteren Firmware Versionen notwendig sein, was aber auf der Konsole immer notwendig war.
Erst wenn im Display FUP angezeigt oder auf der Konsole das Firmware Update läuft können die Tasten losgelassen werden.

Grundsätzlich wäre das unter FHEM nicht notwendig, sofern die Geräte unter FHEM normal vor dem Firmware Update funktionieren.
Erst wenn das Reading fwUpdate fail:notInBootLoader anzeigt hilf nur mehr Batterien raus und mit den beiden äußeren Tasten gedrückt das Firmware Update starten.
So hat es jedenfalls bei mir funktioniert, die Geräte die sich nicht mehr in Betrieb nehmen zu lassen, wieder mit der aktuellen Firmware zum Leben zu erwecken.

Anbei noch ein FHEM Log Auszug mit dem Firmware Update und dem Konsolen Update.
In beiden Fällen wurde der Firmwarestart mit den gedrückten äußeren Tasten gestartet.

Somit ist bei allen Geräten das Firmware Update durchgeführt worden.