gelöst: (Jubel!) Nach Stromausfall MISSING ACK bei vielen Homematic-Devices

[synaps-o-dan]

Liebe Homematic-Experten,
ein Stromausfall hat bei mir einen ziemlichen Kahlschlag eingerichtet. Die NAS ist im Nirvana, und einige HM-devices sind im Status MISSING ACK. Zum Beispiel ein HM-LC-Sw1-Pl-DN-R1 Schaltaktor. Hier ein listing des device:

Code Auswählen Erweitern

Internals:
   CFGFN     
   DEF        5E653A
   HMLANGW_MSGCNT 26
   HMLANGW_RAWMSG 050000451784005E653A0000002600D84F45513037313235383010010100
   HMLANGW_RSSI -69
   HMLANGW_TIME 2018-06-27 20:11:38
   IODev      HMLANGW
   LASTInputDev hmusb
   MSGCNT     54
   NAME       HM_5E653A
   NOTIFYDEV  global
   NR         749
   STATE      RESPONSE TIMEOUT:RegisterRead
   TYPE       CUL_HM
   hmPairSerial OEQ0712580
   hmusb_MSGCNT 28
   hmusb_RAWMSG E5E653A,0000,001C8043,FF,FFCC,1784005E653A0000002600D84F45513037313235383010010100
   hmusb_RSSI -52
   hmusb_TIME 2018-06-27 20:11:38
   lastMsg    No:17 - t:00 s:5E653A d:000000 2600D84F45513037313235383010010100
   protCmdDel 11
   protLastRcv 2018-06-27 20:11:38
   protResnd  22 last_at:2018-06-27 20:12:16
   protResndFail 7 last_at:2018-06-27 20:12:22
   protSnd    14 last_at:2018-06-27 20:11:59
   protState  CMDs_done_Errors:1
   rssi_at_HMLANGW cnt:26 min:-75 max:-63 avg:-68.03 lst:-69
   rssi_at_hmusb cnt:28 min:-62 max:-47 avg:-53.35 lst:-52
   READINGS:
     2018-06-27 20:11:38   D-firmware      2.6
     2018-06-27 20:11:38   D-serialNr      OEQ0712580
     2018-06-27 20:11:26   R-pairCentral   set_0x000000
     2018-06-27 19:56:45   deviceMsg       off (to broadcast)
     2018-06-27 19:56:45   level           0
     2018-06-27 19:56:45   pct             0
     2018-06-27 19:49:48   powerOn         2018-06-27 19:49:48
     2018-06-27 19:56:45   recentStateType info
     2018-06-27 20:12:22   state           RESPONSE TIMEOUT:RegisterRead
     2018-06-27 19:56:45   timedOn         off
     RegL_00.:
       VAL       
   helper:
     HM_CMDNR   63
     PONtest    0
     cSnd       011365AB5E653A000802010A000B000C00,011365AB5E653A00040000000000
     dlvl       C8
     dlvlCmd    ++A0111365AB5E653A0201C80000
     getCfgList all
     getCfgListNo ,3
     mId        00D8
     regLst     ,0,1,3p
     rxType     1
     supp_Pair_Rep 1
     expert:
       def        1
       det        0
       raw        1
       tpl        0
     io:
       newChn     +5E653A,00,00,00
       nextSend   1530123098.86483
       prefIO     
       rxt        0
       vccu       
       p:
         5E653A
         00
         00
         00
     mRssi:
       mNo        17
       io:
         HMLANGW:
           -65
           -65
         hmusb:
           -52
           -52
     prt:
       bErr       0
       sProc      0
     q:
       qReqConf   
       qReqStat   
     role:
       chn        1
       dev        1
       prs        1
     rssi:
       at_HMLANGW:
         avg        -68.0384615384615
         cnt        26
         lst        -69
         max        -63
         min        -75
       at_hmusb:
         avg        -53.3571428571429
         cnt        28
         lst        -52
         max        -47
         min        -62
     shadowReg:
       RegL_00.    02:01 0A:00 0B:00 0C:00
     tmpl:
Attributes:
   IODev      HMLANGW
   IOgrp      VCCU:HMLANGW
   autoReadReg 4_reqStatus
   expert     2_raw
   firmware   2.6
   model      HM-LC-Sw1-Pl-DN-R1
   room       CUL_HM
   serialNr   OEQ0712580
   subType    switch
   webCmd     statusRequest:toggle:on:off

Ich habe es bereits mit set <device> pair versucht, wie in diesem Thread beschrieben: https://forum.fhem.de/index.php/topic,79657.msg716759.html#msg716759
Hat nur nix genützt.
Ich wäre für Unterstützung unendlich dankbar.
Liebe Grüße,
Daniel

[synaps-o-dan]

Noch eine Info: ich kann das device pairen, es wird auch korrekt angelegt. Aber dann geht nichts mehr, es kommt nur noch MISSING ACK.

[martinp876]

Angelegt wird es quasi immer. Pairen ist aber, wennn das devie auch reagiert.  Das kann ich nicht erkennen.
Die pair Adresse steht auf set 000000. Warum sollte 0 gesetzt werden? Das ist wie löschen.

Wie ist die id der zentrale?

[Otto123]

Ich würde immer erstmal so pairen -> https://wiki.fhem.de/wiki/HomeMatic_Devices_pairen

[synaps-o-dan]

Ups, das mit dem R-pairCentral hätte man sehen können...
Ich habe versucht, das device mit hmPairSerial zu paaren. R-pairCentral steht jetzt nicht mehr auf 00000000, aber das Pairing wird nicht abgeschlossen:

Code Auswählen Erweitern

Internals:
   CFGFN     
   DEF        5E653A
   HMLANGW_MSGCNT 5
   HMLANGW_RAWMSG 050000430784005E653A0000002600D84F45513037313235383010010100
   HMLANGW_RSSI -67
   HMLANGW_TIME 2018-06-27 22:01:42
   IODev      hmusb
   LASTInputDev hmusb
   MSGCNT     18
   NAME       HM_5E653A
   NOTIFYDEV  global
   NR         1861
   STATE      off
   TYPE       CUL_HM
   hmusb_MSGCNT 13
   hmusb_RAWMSG E5E653A,0000,0082962B,FF,FFCD,0D84105E653A00000006010000
   hmusb_RSSI -51
   hmusb_TIME 2018-06-27 22:03:09
   lastMsg    No:0D - t:10 s:5E653A d:000000 06010000
   protCmdDel 9
   protLastRcv 2018-06-27 22:03:09
   protResnd  9 last_at:2018-06-27 22:02:48
   protResndFail 3 last_at:2018-06-27 22:02:54
   protSnd    4 last_at:2018-06-27 22:02:34
   protState  CMDs_done_Errors:1
   rssi_at_HMLANGW cnt:5 min:-70 max:-67 avg:-67.59 lst:-67
   rssi_at_hmusb cnt:13 min:-54 max:-47 avg:-51.23 lst:-51
   READINGS:
     2018-06-27 22:01:42   D-firmware      2.6
     2018-06-27 22:01:42   D-serialNr      OEQ0712580
     2018-06-27 22:01:32   R-pairCentral   set_0x136AAB
     2018-06-27 22:03:09   deviceMsg       off (to broadcast)
     2018-06-27 22:03:09   level           0
     2018-06-27 22:03:09   pct             0
     2018-06-27 22:03:09   recentStateType info
     2018-06-27 22:03:09   state           off
     2018-06-27 22:03:09   timedOn         off
     RegL_00.:
       VAL       
   helper:
     HM_CMDNR   13
     cSnd       01136AAB5E653A00040000000000,01136AAB5E653A00040000000000
     getCfgList all
     getCfgListNo ,3
     mId        00D8
     regLst     ,0,1,3p
     rxType     1
     supp_Pair_Rep 0
     expert:
       def        1
       det        0
       raw        1
       tpl        0
     io:
       newChn     +5E653A,00,00,00
       nextSend   1530129789.20531
       prefIO     
       rxt        0
       vccu       
       p:
         5E653A
         00
         00
         00
     mRssi:
       mNo        0D
       io:
         HMLANGW:
         hmusb:
           -45
           -45
     prt:
       bErr       0
       sProc      0
     q:
       qReqConf   
       qReqStat   
     role:
       chn        1
       dev        1
       prs        1
     rssi:
       at_HMLANGW:
         avg        -67.6
         cnt        5
         lst        -67
         max        -67
         min        -70
       at_hmusb:
         avg        -51.2307692307692
         cnt        13
         lst        -51
         max        -47
         min        -54
     shadowReg:
       RegL_00.    02:01 0A:13 0B:65 0C:AB
     tmpl:
Attributes:
   IODev      hmusb
   IOgrp      VCCU:hmusb
   autoReadReg 4_reqStatus
   expert     2_raw
   firmware   2.6
   model      HM-LC-Sw1-Pl-DN-R1
   room       CUL_HM
   serialNr   OEQ0712580
   subType    switch
   webCmd     statusRequest:toggle:on:off

[Otto123]

Ohne irgendwas anderes zu tun einfach nochmal und nochmal

Also dreimal  hmPairSerial  OHNE löschen oder irgendetwas!

[synaps-o-dan]

hminfo configCheck liefert zu dem betroffenen device:

Code Auswählen Erweitern

missing register list
    HM_5E653A: RegL_00.,RegL_01.
Register changes pending
    HM_5E653A


[synaps-o-dan]

Ohne irgendwas anderes zu tun einfach nochmal und nochmal

Also dreimal  hmPairSerial  OHNE löschen oder irgendetwas!

OK ich denke auch, ich muss hier einfach hartnäckig bleiben und mehrmals probieren. Danke für die fixe Hilfe!!!

[Otto123]

notfalls hilft  auch mal ein clear msgEvents um die Fehler in der Kommandostrecke  weg zubekommen.

[frank]

zeig mal je ein list von vccu, hmusb und HMLANGW.

[synaps-o-dan]

VCCU:

Code Auswählen Erweitern

Internals:
   DEF        1365AB
   HMLANGW_MSGCNT 49
   HMLANGW_RAWMSG 0500003F9380021365AB33C4FD00
   HMLANGW_RSSI -63
   HMLANGW_TIME 2018-06-28 17:00:01
   IODev      HMLANGW
   LASTInputDev hmusb
   MSGCNT     201
   NAME       VCCU
   NOTIFYDEV  global
   NR         367
   NTFY_ORDER 50-VCCU
   STATE      CMDs_done
   TYPE       CUL_HM
   assignedIOs HMLANGW,hmusb
   channel_01 VCCU_Btn1
   hmusb_MSGCNT 152
   hmusb_RAWMSG E1365AB,0000,010F7788,FF,FFC2,96A0011365AB5E653A00040000000000
   hmusb_RSSI -62
   hmusb_TIME 2018-06-28 17:07:55
   lastMsg    No:96 - t:01 s:1365AB d:5E653A 00040000000000
   protLastRcv 2018-06-28 17:07:55
   protSnd    1 last_at:2018-06-28 17:07:14
   protState  CMDs_done
   rssi_at_HMLANGW cnt:49 min:-65 max:-61 avg:-62.24 lst:-63
   rssi_at_hmusb cnt:152 min:-63 max:-61 avg:-62.41 lst:-62
   READINGS:
     2018-06-28 17:00:01   CommandAccepted yes
     2018-06-28 17:07:14   state           CMDs_done
     2018-04-07 10:42:34   unknown_3082FD  received
     2018-06-24 03:29:00   unknown_3D4D44  received
     2018-04-29 21:11:51   unknown_541E9D  received
   helper:
     HM_CMDNR   150
     mId        FFF0
     regLst     ,0
     rxType     1
     supp_Pair_Rep 0
     ack:
     expert:
       def        1
       det        0
       raw        1
       tpl        0
     io:
       nextSend   1530198475.8734
       prefIO     
       vccu       VCCU
       ioList:
         hmusb
         HMLANGW
     mRssi:
       mNo        96
       io:
         HMLANGW:
         hmusb:
           -62
           -62
     prt:
       bErr       0
       sProc      0
       rspWait:
     q:
       qReqConf   
       qReqStat   
     role:
       dev        1
       vrt        1
     rssi:
       at_HMLANGW:
         avg        -62.2448979591837
         cnt        49
         lst        -63
         max        -61
         min        -65
       at_hmusb:
         avg        -62.4144736842105
         cnt        152
         lst        -62
         max        -61
         min        -63
Attributes:
   IODev      HMLANGW
   IOList     hmusb,HMLANGW
   IOgrp      VCCU
   expert     2_raw
   model      CCU-FHEM
   subType    virtual
   webCmd     virtual:update

hmusb:

Code Auswählen Erweitern

Internals:
   DEF        127.0.0.1:1365
   DeviceName 127.0.0.1:1365
   FD         9
   IFmodel    USB
   NAME       hmusb
   NR         54
   NTFY_ORDER 50-hmusb
   PARTIAL   
   RAWMSG     E52C9DA,0000,01104794,FF,FFE6,95845E52C9DA0000008000000000000000091EFD
   RSSI       -26
   STATE      opened
   TYPE       HMLAN
   XmitOpen   1
   assignedIDsCnt 21
   hmusb_MSGCNT 1091
   hmusb_TIME 2018-06-28 17:08:49
   msgKeepAlive dlyMax:3271.935 bufferMin:-3266
   msgLoadCurrent 1
   msgLoadHistoryAbs 5min steps: 1/1/1/0/0/0/0/0/0/0/0/0
   msgParseDly min:-2 max:19166 last:118 cnt:996
   owner      1365AB
   owner_CCU  VCCU
   uptime     000 04:57:24.116
   READINGS:
     2018-06-28 12:12:28   D-HMIdAssigned  1365AB
     2018-06-28 12:12:28   D-HMIdOriginal  37334E
     2018-06-28 12:12:28   D-firmware      0.967
     2018-06-28 12:12:28   D-serialNr      MEQ0231240
     2018-06-28 12:12:28   Xmit-Events     disconnected:1 ok:1 init:1
     2018-06-28 12:12:28   cond            ok
     2018-06-28 17:08:40   loadLvl         low
     2017-07-15 22:22:54   prot_ERROR-Overload last
     2017-10-16 21:30:58   prot_Warning-HighLoad last
     2018-06-28 11:17:27   prot_disconnected last
     2018-06-28 11:17:27   prot_init       last
     2018-06-28 12:12:28   prot_ok         last
     2018-06-28 11:17:27   state           opened
   helper:
     assIdCnt   21
     assIdRep   21
     info       03C7,MEQ0231240,37334E,1365AB
     setTime    46697
     cnd:
       0          1
       253        1
       255        1
     dly:
       cnt        996
       lst        118
       max        19166
       min        -2
     ids:
       1A52FD:
         cfg        +1A52FD,00,00,00
         name       Bewegungsmelder_Kellertreppe
       1A530D:
         cfg        +1A530D,00,00,00
         name       Bewegungsmelder_Vorratskeller
       1A6D8D:
         cfg        +1A6D8D,00,00,00
         chn        03
         flg        0
         msg       
         name       Schaltaktor_Tobekeller
         to         1530180782.58942
       1C2DF6:
         cfg        +1C2DF6,00,00,00
         chn        01
         flg        0
         msg       
         name       Rauchmelder_K2
         to         1530180765.15692
       1C2E1A:
         cfg        +1C2E1A,00,00,00
         chn        01
         flg        0
         msg       
         name       Rauchmelder_Tobekeller
         to         1530180766.36604
       1D32D1:
         cfg        +1D32D1,00,00,00
         name       Lichtschalter_Tobekeller
       1EDF39:
         cfg        +1EDF39,00,00,00
         name       Schalter_WLAN
       207C10:
         cfg        +207C10,00,00,00
         chn        01
         flg        0
         msg       
         name       Licht_Vorratskeller
         to         1530180760.21993
       207C46:
         cfg        +207C46,00,00,00
         chn        01
         flg        0
         msg       
         name       Kellerluefter
         to         1530180754.58336
       250778:
         cfg        +250778,00,00,00
         chn        01
         flg        0
         msg       
         name       Licht_Kellertreppe
         to         1530180758.20821
       251AAE:
         cfg        +251AAE,00,00,00
         chn        01
         flg        0
         msg       
         name       Schaltaktor_Kueche
         to         1530180777.3393
       2A5BE5:
         cfg        +2A5BE5,00,00,00
         chn        02
         flg        0
         msg       
         name       Licht_Werkbank
         to         1530186058.71961
       33C4FD:
         cfg        +33C4FD,00,00,00
         chn        02
         flg        0
         msg       
         name       Schaltaktor_Zirkulation
         to         1530198002.03957
       409BE9:
         cfg        +409BE9,00,00,00
         chn        01
         flg        0
         msg       
         name       Licht_Treppenaufgang
         to         1530180759.61948
       48D23C:
         cfg        +48D23C,00,00,00
         chn        01
         flg        0
         msg       
         name       Licht_Dachboden
         to         1530180755.04314
       4B2F76:
         cfg        +4B2F76,00,00,00
         chn        02
         flg        0
         msg       
         name       Schaltaktor_Werkstatt
         to         1530186068.56602
       4B2F78:
         cfg        +4B2F78,00,00,00
         chn        01
         flg        0
         msg       
         name       Schaltaktor_Bayernluefter
         to         1530180767.17442
       4D2843:
         cfg        +4D2843,00,00,00
         name       Tuerkontakt_Kellertreppe
       4DF9EB:
         cfg        +4DF9EB,00,00,00
         chn        02
         flg        0
         msg       
         name       Licht_Garage
         to         1530180757.284
       52C9DA:
         cfg        +52C9DA,00,00,00
         chn        01
         flg        0
         msg       
         name       Schaltaktor_Kellerkuehlschrank
         to         1530180776.31783
       52CA47:
         cfg        +52CA47,00,00,00
         chn        01
         flg        0
         msg       
         name       Schaltaktor_TV
         to         1530180779.3873
       5E653A:
         flg        0
     k:
       BufMin     -3266
       DlyMax     3271.935
       Next       1530198545.63728
       Start      1530198520.63728
     loadLvl:
       bl         40
       a:
         99
         90
         40
         0
       h:
         0          low
         40         batchLevel
         90         high
         99         suspended
     log:
       all        0
       sys        0
       ids:
         ARRAY(0x36d49f0)
     q:
       HMcndN     0
       answerPend 0
       hmLanQlen  1
       keepAliveRec 1
       keepAliveRpt 0
       loadLastMax 1
       loadNo     1
       scnt       1
       ald:
         1
         1
         1
         0
         0
         0
         0
         0
         0
         0
         0
         0
       apIDs:
     ref:
       drft       -0.000360100828231905
       hmtL       17835718
       kTs        0
       offL       1530180684928
       sysL       1530198444637
Attributes:
   addvaltrigger 1
   hmId       1365AB
   hmLanQlen  1_min
   icon       cul_usb
   loadLevel  0:low,40:batchLevel,90:high,99:suspended

HMLANGW:

Code Auswählen Erweitern

Internals:
   AssignedPeerCnt 7
   CNT        164
   Clients    :CUL_HM:
   DEF        192.168.0.33
   DEVCNT     164
   DevState   99
   DevType    LGW
   DeviceName 192.168.0.33:2000
   FD         52
   LastOpen   1530184940.50907
   NAME       HMLANGW
   NR         397
   PARTIAL   
   RAWMSG     040202
   RSSI       -57
   STATE      opened
   TYPE       HMUARTLGW
   XmitOpen   1
   model      eQ3-HM-LGW
   msgLoadCurrent 1
   msgLoadHistory 0/0/0/0/0/0/0/0/0/0/0/0
   msgLoadHistoryAbs 1/1/1/1/1/1/1/1/1/1/1/1/1
   owner      1365AB
   owner_CCU  VCCU
   Helper:
     CreditTimer 911
     FW         66561
     Initialized 1
     SendCnt    33
     AckPending:
     LastSendLen:
       3
       3
     Log:
       IDs:
     PeerQueue:
     PendingCMD:
     RoundTrip:
       Delay      0.00411415100097656
     loadLvl:
       lastHistory 1530198745.70253
   MatchList:
     1:CUL_HM   ^A......................
   Peers:
     4C5457     +4C5457,00,00,00
     4E44E0     +4E44E0,00,00,00
     50F98A     +50F98A,00,00,00
     52D086     +52D086,00,00,00
     541E9D     +541E9D,00,00,00
     55EFDD     +55EFDD,00,00,00
     5E653A     +5E653A,00,00,00
   READINGS:
     2018-06-28 13:22:25   D-HMIdAssigned  1365AB
     2018-06-28 13:22:25   D-HMIdOriginal  FFFFFF
     2018-06-28 13:22:20   D-LANfirmware   1.1.5
     2018-06-28 13:22:25   D-firmware      1.4.1
     2018-06-28 13:22:20   D-serialNr      OEQ0107009
     2018-06-28 13:22:20   D-type          eQ3-HM-LGW
     2018-06-28 13:22:25   cond            ok
     2018-06-28 17:12:37   load            1
     2018-06-28 13:22:25   loadLvl         low
     2018-06-28 13:22:20   state           opened
   helper:
   keepAlive:
     DevType    LGW-KeepAlive
     DeviceName 192.168.0.33:2001
     NAME       HMLANGW:keepAlive
     NEXT_OPEN  1530185003.5134
     NR         1137
     PARTIAL   
     STATE      disconnected
     TEMPORARY  1
     TYPE       HMUARTLGW
     READINGS:
       2018-06-28 13:22:23   state           disconnected
Attributes:
   hmId       1365AB
   lgwPw      d7%!6J2*FM

[synaps-o-dan]

(Und schon mal vielen Dank für die vielen Tipps!)

[frank]

das state reading der vccu sieht seltsam aus.
wie sieht state aus, nachdem du "set VCCU update" gemacht hast?

ausserdem lösche mal beim hmusb das attr addvaltrigger.

[synaps-o-dan]

Und plötzlich funktioniert es dann wieder. Herrliches Geräusch, wenn das Relais im HM-LC-Sw1-Pl-DN-R1 wieder fröhlich klickt, wenn man es in fhem toggelt. Danke für die Tips, letztendlich scheint ein Stakkato aus hmPairSerial-Befehlen den Durchbruch geschafft zu haben. Vielen lieben Dank nochmals für die entsprechenden Tips. Ich bin ganz baff, wie schnell & freundlich im Homematic-Unterforum geholfen wird.
Falls jemand mit ähnlichen Problemen über diesen Thrad stolpert, das hat in meiner Situation geholfen:

• Symptom: ein Homematic-Device ist zwar gepairt, lässt sich aber nicht ansprechen. Im state stehen unterschiedliche Fehlermeldungen, nach einigen Sekunden erscheint "MISSING ACK" im state.
• im Internal R-pairCentral steht set_0x<hmID des IODev>
• Abhilfe: das device in den Anlernmodus bringen (Geräte mit Anlerntaste: diese für 4 Sekunden gedrückt halten)
• Mehrmals set <IODev> hmPairSerial <serial> senden. Das hat bei mir erst funktioniert, als ich während eines Anlernvorgangs den hmPairSerial-Befehl so schnell wie möglich mehrere Male hintereinander abgesetzt hatt. Also nicht pro Anlernvorgang einmal hmPairSerial absetzen.
• <serial>: steht im Attribut serialNr des hm Device
• Irgendwann klappte es dann.
• Bei mir hat es drei Tage gedauert, bis es plötzlich wieder ging.
• Also: hartnäckig bleiben!

Weitere hilfreiche Infos wie immer im Wiki: https://wiki.fhem.de/wiki/HomeMatic_Devices_pairen

LG,
Daniel