Homematic Keymatic MISSING ACK

[computerkoenig]

Hallo,

ich habe aktuell große Probleme mit dem KeyMatic Türschlossantrieb HM-Sec-Key-S. Bis vor ein paar Tagen ging noch alles Problemlos.
Seit dem komme ich nun immer als Status "MISSING ACK". Ich habe das Device schon mehrfach neu gepaired. Der Fehler besteht weiterhin.
Langsam bin ich ratlos und durch den Fehler lässt sich der Antrieb praktisch nicht mehr benutzen, weil kein Verlass darauf ist.

Habt ihr eine Idee für mich oder wo ich einen genaueren Fehlergrund finden kann? (Screenshot anbei)

Danke
Michael

[CoolTux]

Das Device ist nicht gepaired. Mach mal bitte ein getConfig und drücke den Anlernknopf an der Keymatic

[computerkoenig]

Habe zuerst probiert ein getConfig zu starten und dann den Anlernknopf zu drücken und dann andersrum. Erst Anlernknopf und dann getConfig.
Beides läuft auf den selben Fehler raus: RESPONSE TIMEOUT:RegisterRead

Siehe Screenshot

[CoolTux]

Ok dann zwei Sachen. Erstens, bitte verschiebe Deinen Thread nach Homematic. Zweitens, inforniere Dich im Wiki bitte über hometaic raw sniffen.
Ich denke mit nem anständigen sniff kommt man weiter. Und verbose 5 bitte setzen


Grüße

[LuckyDay]

du hast keine hmid an deinem System vergeben, so wird das nichts

[computerkoenig]

Unpair gemacht, hmid zugewiesen, device gelöscht und alles neu.
Diesmal ist sogar der HMLAN in den Overload gelaufen. Siehe Screenshots.

Wenn ich den IO Error ignoriere und trotzdem einen Befehl sende kommt natürlich wieder ein "MISSING ACK".


Ich suche gerade noch wie ich ein Thema verschiebe....

[LuckyDay]

Ich blick bei dir nicht durch
einmal hast keine hmid 000000
dann 0A0A00
und jetzt mit 4B8842

du musst dich schon mal entscheiden, nebenbei mit welcher hmid hast denn die Keymatic ursprünglich angelernt? als es noch tat,
einfach unpair schicken funktioniert so nicht

[computerkoenig]

Als es noch tat habe ich es mit "0A0A00" angelernt. keine hmId hatte ich eigentlich nie, da ich die gleich am Anfang angelegt hatte. Wie das zu stande kam weiß ich nicht.

Wie trenne ich das Gerät den richtig?

EDIT:
Habe wieder die alte hmID 0A0A00 gesetzt und erneut getestet. ob ich das Gerät richtig lösche weiß ich halt nicht.
HMLan geht auf Overload, KeyMatic in FHEM auf IOerr und danach auf MISSING ACK

Hier die Logs nur vom Zeitraum des Verbindens:

Code Auswählen Erweitern

2016.06.08 15:21:51.150 0: HMLAN_Send:  HMLAN1 I:K
2016.06.08 15:21:51.153 0: HMLAN_Parse: HMLAN1 V:03C5 sNo:LEQ0579579 d:2BABE5 O:0A0A00 t:09E1E5A3 IDcnt:0011 L:75 %
2016.06.08 15:22:16.153 0: HMLAN_Send:  HMLAN1 I:K
2016.06.08 15:22:16.156 0: HMLAN_Parse: HMLAN1 V:03C5 sNo:LEQ0579579 d:2BABE5 O:0A0A00 t:09E24753 IDcnt:0011 L:75 %
2016.06.08 15:22:22.025 0: HMLAN_Parse: HMLAN1 R:E3CE85E   stat:0000 t:09E25E37 d:FF r:FFBD     m:4B 8610 3CE85E 000000 0A88F7100000
2016.06.08 15:22:29.219 1: SB_PLAYER_Alarms(SB_PLAYER_0004202a0ad2): Unknown data (fade:20)
2016.06.08 15:22:41.155 0: HMLAN_Send:  HMLAN1 I:K
2016.06.08 15:22:41.158 0: HMLAN_Parse: HMLAN1 V:03C5 sNo:LEQ0579579 d:2BABE5 O:0A0A00 t:09E2A901 IDcnt:0011 L:75 %
2016.06.08 15:23:06.159 0: HMLAN_Send:  HMLAN1 I:K
2016.06.08 15:23:06.162 0: HMLAN_Parse: HMLAN1 V:03C5 sNo:LEQ0579579 d:2BABE5 O:0A0A00 t:09E30AB2 IDcnt:0011 L:69 %
2016.06.08 15:23:32.159 0: HMLAN_Send:  HMLAN1 I:K
2016.06.08 15:23:32.165 1: PERL WARNING: Argument "0.00 W" isn't numeric in numeric ge (>=) at (eval 7518) line 1.
2016.06.08 15:23:32.167 1: PERL WARNING: Argument "0.00 W" isn't numeric in numeric gt (>) at (eval 7519) line 1.
2016.06.08 15:23:32.169 1: PERL WARNING: Argument "0.00 W" isn't numeric in numeric le (<=) at (eval 7520) line 1.
2016.06.08 15:23:32.251 1: PERL WARNING: Argument "0.00 W" isn't numeric in numeric ge (>=) at (eval 7533) line 1.
2016.06.08 15:23:32.252 1: PERL WARNING: Argument "0.00 W" isn't numeric in numeric gt (>) at (eval 7534) line 1.
2016.06.08 15:23:32.254 1: PERL WARNING: Argument "0.00 W" isn't numeric in numeric le (<=) at (eval 7535) line 1.
2016.06.08 15:23:32.267 0: HMLAN_Parse: HMLAN1 V:03C5 sNo:LEQ0579579 d:2BABE5 O:0A0A00 t:09E37046 IDcnt:0011 L:69 %
2016.06.08 15:23:57.162 0: HMLAN_Send:  HMLAN1 I:K
2016.06.08 15:23:57.165 0: HMLAN_Parse: HMLAN1 V:03C5 sNo:LEQ0579579 d:2BABE5 O:0A0A00 t:09E3D1F5 IDcnt:0011 L:69 %
2016.06.08 15:23:58.707 0: HMLAN_Parse: HMLAN1 R:E37F85D   stat:0000 t:09E3D7F1 d:FF r:FFB4     m:C5 8610 37F85D 000000 0A810D0C0040
2016.06.08 15:24:01.617 0: HMLAN_Send:  HMLAN1 S:S302F1D26 stat:  00 t:00000000 d:01 r:302F1D26 m:70 B001 0A0A00 3F5408 00050000000000
2016.06.08 15:24:03.423 0: HMLAN_Parse: HMLAN1 R:R302F1D26 stat:0008 t:00000000 d:FF r:7FFF     m:70 B001 0A0A00 3F5408 00050000000000
2016.06.08 15:24:03.424 0: HMLAN_Parse: HMLAN1 no ACK from 3F5408
2016.06.08 15:24:04.716 0: HMLAN_Send:  HMLAN1 S:S302F2941 stat:  00 t:00000000 d:01 r:302F2941 m:01 B001 0A0A00 3F5408 00050000000000
2016.06.08 15:24:06.522 0: HMLAN_Parse: HMLAN1 R:R302F2941 stat:0008 t:00000000 d:FF r:7FFF     m:01 B001 0A0A00 3F5408 00050000000000
2016.06.08 15:24:06.522 0: HMLAN_Parse: HMLAN1 no ACK from 3F5408
2016.06.08 15:24:22.164 0: HMLAN_Send:  HMLAN1 I:K
2016.06.08 15:24:22.167 0: HMLAN_Parse: HMLAN1 V:03C5 sNo:LEQ0579579 d:2BABE5 O:0A0A00 t:09E433A3 IDcnt:0011 L:75 %
2016.06.08 15:24:47.169 0: HMLAN_Send:  HMLAN1 I:K
2016.06.08 15:24:47.172 0: HMLAN_Parse: HMLAN1 V:03C5 sNo:LEQ0579579 d:2BABE5 O:0A0A00 t:09E49555 IDcnt:0011 L:75 %
2016.06.08 15:25:05.270 0: HMLAN_Parse: HMLAN1 R:E3CE85E   stat:0000 t:09E4DBFF d:FF r:FFBE     m:4C 8610 3CE85E 000000 0A88F7100000
2016.06.08 15:25:12.171 0: HMLAN_Send:  HMLAN1 I:K
2016.06.08 15:25:12.175 0: HMLAN_Parse: HMLAN1 V:03C5 sNo:LEQ0579579 d:2BABE5 O:0A0A00 t:09E4F703 IDcnt:0011 L:75 %
2016.06.08 15:25:15.790 0: HMLAN_Parse: HMLAN1 R:E43B950   stat:0000 t:09E50519 d:FF r:FFA8     m:B5 A641 43B950 0A0A00 01EC00
2016.06.08 15:25:15.882 0: HMLAN_Send:  HMLAN1 S:S30303EE6 stat:  00 t:00000000 d:01 r:30303EE6 m:B5 8002 0A0A00 43B950 0101C800
2016.06.08 15:25:16.178 0: HMLAN_Parse: HMLAN1 R:R30303EE6 stat:0002 t:00000000 d:FF r:7FFF     m:B5 8002 0A0A00 43B950 0101C800
2016.06.08 15:25:21.013 0: HMLAN_Parse: HMLAN1 R:E3F5408   stat:0000 t:09E51981 d:FF r:FFB0     m:68 8400 3F5408 000000 2500264D455130383338303133C0010100
2016.06.08 15:25:21.169 0: HMLAN_Send:  HMLAN1 S:S30305393 stat:  00 t:00000000 d:01 r:30305393 m:69 A001 0A0A00 3F5408 00050000000000
2016.06.08 15:25:21.775 0: HMLAN_Parse: HMLAN1 R:R30305393 stat:0008 t:00000000 d:FF r:7FFF     m:69 A001 0A0A00 3F5408 00050000000000
2016.06.08 15:25:21.775 0: HMLAN_Parse: HMLAN1 no ACK from 3F5408
2016.06.08 15:25:25.748 0: HMLAN_Send:  HMLAN1 S:S303065C9 stat:  00 t:00000000 d:01 r:303065C9 m:01 B001 0A0A00 3F5408 00050000000000
2016.06.08 15:25:25.748 0: HMLAN_Send:  HMLAN1 I:K
2016.06.08 15:25:25.753 0: HMLAN_Parse: HMLAN1 V:03C5 sNo:LEQ0579579 d:2BABE5 O:0A0A00 t:09E52C10 IDcnt:0011 L:77 %
2016.06.08 15:25:26.025 0: HMLAN_Send:  HMLAN1 I:+3F5408,00,01,00
2016.06.08 15:25:27.554 0: HMLAN_Parse: HMLAN1 R:R303065C9 stat:0008 t:00000000 d:FF r:7FFF     m:01 B001 0A0A00 3F5408 00050000000000
2016.06.08 15:25:27.554 0: HMLAN_Parse: HMLAN1 no ACK from 3F5408
2016.06.08 15:25:27.626 0: HMLAN_Send:  HMLAN1 S:S30306D1F stat:  00 t:00000000 d:01 r:30306D1F m:01 B001 0A0A00 3F5408 00050000000000
2016.06.08 15:25:29.604 0: HMLAN_Parse: HMLAN1 R:R30306D1F stat:0008 t:00000000 d:FF r:7FFF     m:01 B001 0A0A00 3F5408 00050000000000
2016.06.08 15:25:29.604 0: HMLAN_Parse: HMLAN1 no ACK from 3F5408
2016.06.08 15:25:30.197 1: PERL WARNING: Argument "0.00 W" isn't numeric in numeric ge (>=) at (eval 7600) line 1.
2016.06.08 15:25:30.198 1: PERL WARNING: Argument "0.00 W" isn't numeric in numeric gt (>) at (eval 7601) line 1.
2016.06.08 15:25:30.200 1: PERL WARNING: Argument "0.00 W" isn't numeric in numeric le (<=) at (eval 7602) line 1.
2016.06.08 15:25:30.453 0: HMLAN_Send:  HMLAN1 S:S3030782A stat:  00 t:00000000 d:01 r:3030782A m:01 B001 0A0A00 3F5408 00050000000000
2016.06.08 15:25:31.238 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:32.259 0: HMLAN_Parse: HMLAN1 R:R3030782A stat:0008 t:00000000 d:FF r:7FFF     m:01 B001 0A0A00 3F5408 00050000000000
2016.06.08 15:25:32.260 0: HMLAN_Parse: HMLAN1 no ACK from 3F5408
2016.06.08 15:25:32.638 0: HMLAN_Send:  HMLAN1 S:S303080B3 stat:  00 t:00000000 d:01 r:303080B3 m:01 B001 0A0A00 3F5408 00050000000000
2016.06.08 15:25:32.714 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:34.444 0: HMLAN_Parse: HMLAN1 R:R303080B3 stat:0008 t:00000000 d:FF r:7FFF     m:01 B001 0A0A00 3F5408 00050000000000
2016.06.08 15:25:34.444 0: HMLAN_Parse: HMLAN1 no ACK from 3F5408
2016.06.08 15:25:34.736 0: HMLAN_Send:  HMLAN1 S:S303088E5 stat:  00 t:00000000 d:01 r:303088E5 m:01 B001 0A0A00 3F5408 00050000000000
2016.06.08 15:25:34.866 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:38.072 0: HMLAN_Send:  HMLAN1 S:S303095ED stat:  00 t:00000000 d:01 r:303095ED m:01 B001 0A0A00 3F5408 00050000000000
2016.06.08 15:25:38.073 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:38.074 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:38.075 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:38.076 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:38.078 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:38.080 0: HMLAN_Parse: HMLAN1 R:R303088E5 stat:0208 t:00000000 d:FF r:7FFF     m:01 B001 0A0A00 3F5408 00050000000000
2016.06.08 15:25:38.081 1: HMLAN_Parse: HMLAN1 new condition Warning-HighLoad
2016.06.08 15:25:38.088 0: HMLAN_Parse: HMLAN1 no ACK from 3F5408
2016.06.08 15:25:38.216 0: HMLAN_Send:  HMLAN1 S:S3030967C stat:  00 t:00000000 d:01 r:3030967C m:01 B001 0A0A00 3F5408 00050000000000
2016.06.08 15:25:39.024 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:39.476 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:39.477 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:40.369 0: HMLAN_Parse: HMLAN1 R:R303095ED stat:0208 t:00000000 d:FF r:7FFF     m:01 B001 0A0A00 3F5408 00050000000000
2016.06.08 15:25:40.369 0: HMLAN_Parse: HMLAN1 no ACK from 3F5408
2016.06.08 15:25:40.587 0: HMLAN_Parse: HMLAN1 R:R3030967C stat:0208 t:00000000 d:FF r:7FFF     m:01 B001 0A0A00 3F5408 00050000000000
2016.06.08 15:25:40.587 0: HMLAN_Parse: HMLAN1 no ACK from 3F5408
2016.06.08 15:25:41.498 0: HMLAN_Send:  HMLAN1 S:S3030A34F stat:  00 t:00000000 d:01 r:3030A34F m:01 B001 0A0A00 3F5408 00050000000000
2016.06.08 15:25:41.648 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:41.674 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:41.876 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:41.961 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:42.220 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:42.662 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:43.305 0: HMLAN_Parse: HMLAN1 R:R3030A34F stat:0208 t:00000000 d:FF r:7FFF     m:01 B001 0A0A00 3F5408 00050000000000
2016.06.08 15:25:43.305 0: HMLAN_Parse: HMLAN1 no ACK from 3F5408
2016.06.08 15:25:43.333 0: HMLAN_Send:  HMLAN1 S:S3030AA7A stat:  00 t:00000000 d:01 r:3030AA7A m:01 B001 0A0A00 3F5408 00050000000000
2016.06.08 15:25:43.405 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:43.444 0: HMLAN_Send:  HMLAN1 S:S3030AAE9 stat:  00 t:00000000 d:01 r:3030AAE9 m:13 B001 0A0A00 44760A 010E
2016.06.08 15:25:43.531 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:43.545 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:43.593 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:43.611 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:43.734 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:43.771 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:43.910 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:43.926 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:43.945 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:44.041 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:44.214 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:44.574 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:44.752 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:44.923 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:44.924 0: HMLAN_Delay: HMLAN1 44760A
2016.06.08 15:25:45.014 0: HMLAN_Delay: HMLAN1 3F5408
2016.06.08 15:25:45.251 0: HMLAN_Parse: HMLAN1 R:R3030AAE9 stat:0408 t:00000000 d:FF r:7FFF     m:13 B001 0A0A00 44760A 010E
2016.06.08 15:25:45.251 1: HMLAN_Parse: HMLAN1 new condition ERROR-Overload
2016.06.08 15:25:45.261 0: HMLAN_Parse: HMLAN1 no ACK from 44760A
2016.06.08 15:25:45.354 0: HMLAN_Parse: HMLAN1 R:R3030AA7A stat:0408 t:00000000 d:FF r:7FFF     m:01 B001 0A0A00 3F5408 00050000000000
2016.06.08 15:25:45.355 0: HMLAN_Parse: HMLAN1 no ACK from 3F5408
2016.06.08 15:25:50.750 0: HMLAN_Send:  HMLAN1 I:K
2016.06.08 15:25:50.754 0: HMLAN_Parse: HMLAN1 V:03C5 sNo:LEQ0579579 d:2BABE5 O:0A0A00 t:09E58DBD IDcnt:0011 L:100 %

[computerkoenig]

Hallo,

ich habe den KeyMatic nun komplett gelöscht und auf Werkseinstellungen zurück gesetzt.

Seit dem tritt der Fehler "MISSING ACK" nur noch deutlich selterner auf, aber leider ist es noch immer zu unzuverlässig.

Hat noch jemand eine Idee? Kann ich das in den Logs erkennen? (Habe leider nichts gefunden.)

[computerkoenig]

Möglicherweise hängt es auch daran, dass mir der HMLAN regelmäßig weg bricht. Ich verstehe nur nicht warum:

Code Auswählen Erweitern

2016.09.21 10:38:25 1: 192.168.0.31:1000 disconnected, waiting to reappear (HMLAN1)
2016.09.21 10:38:25 1: HMLAN_Parse: HMLAN1 new condition disconnected
2016.09.21 10:38:26 1: HMLAN_Parse: HMLAN1 new condition init
2016.09.21 10:38:26 1: 192.168.0.31:1000 reappeared (HMLAN1)
2016.09.21 10:38:26 1: HMLAN_Parse: HMLAN1 new condition ok

[Mitch]

Kann daran schon sehr gut liegen.

Hatte das auch und bei mir war es einmal eine schlechte LAN Verbindung und einmal ein Task, der FHEM immer mal wieder blockiert hatte und dadurch der HMLAN in den Timeout gelaufen ist.

Als ersten Workaround würde ich mal das LAN checken und zweitens würde ich mal folgende Attribute testen:
respTime
Define max response time of the HMLAN adapter in seconds. Default is 1 sec.
Longer times may be used as workaround in slow/instable systems or LAN configurations.
wdTimer
Time in sec to trigger HMLAN. Values between 5 and 25 are allowed, 25 is default.
It is not recommended to change this timer. If problems are detected with
HLMLAN disconnection it is advisable to resolve the root-cause of the problem and not symptoms.

[computerkoenig]

Danke für deine Information!

An einem schlechten LAN wird es wahrscheinlich nicht liegen. Der HMLAN geht direkt mit einem Cat6 oder Cat7 (bin mir nicht sicher) Kabel in den Netgear JGS524E-200EUS und von dort direkt an den PC auf dem FHEM läuft.

Aber das bringt mich evtl auf eine Idee woran es liegen könnte.
Wenn ich per SSH auf dem PC bin (Debian), passiert es immer mal wieder, dass die komplette Konsole für ein paar Sekunden einfriert.
Ich dachte eigentlich, dass das ein Problem mit SSH ist und hatte noch keine Zeit mich darum zu kümmern.
Sollte aber der ganze PC so lange hängen, würde es das erklären.

[Jamo]

Zur Info:
Ich hatte jetzt aktuell auch das Problem, das mein KeyMatic Türschlossantrieb HM-Sec-Key-S als Status nur noch "MISSING ACK" ausgegeben hat.
Und zwar, nachdem das Schloss manuell bedient / von aussen mit dem Schlüssel aufgemacht wurde. Ich habe alles versucht, von IODev umstellen, bis Batterien austauschen, bis wiederholtes auf/zumachen etc.

Geholfen hat das aesCommReq attribut einmal auf 0 stellen, einen Statusrequest machen, und dann das attribut wieder auf 1 stellen, also:

Code Auswählen Erweitern

attr Tuerschloss aesCommReq 0 -> set Tuerschloss statusRequest -> attr Tuerschloss aesCommReq 1 -> set Tuerschloss statusRequest

Danach ist wieder alles OK. Falls jemand anderes auch mal so ein Problem hat.

[tndx]

Hi,

das kommt mir sehr bekannt vor, vielleicht kannst Du hier auch einen Blick drauf werfen:
https://forum.fhem.de/index.php/topic,100911.0.html

Ich habe seit der Erkenntnis, dass man das Attribut "IODev" tunlichst nicht anfassen sollte, keine Probleme mehr mit AES.