FHEM Forum

FHEM - Hausautomations-Systeme => Homematic => Thema gestartet von: evoyager am 21 Januar 2015, 22:32:08

Titel: HM-RC-Key3-B an Keymatic: erster Befehl wird immer negativ quittiert
Beitrag von: evoyager am 21 Januar 2015, 22:32:08
Hallo zusammen,

ich habe efolgendes Problem, bei dem ich Euch um Unterstützung bitte:

Ausgangssituation:
- Keymatic habe ich über die Windows "HomeMatic Konfigurator" mit HMLAN gepaired und eine "direkte Geräteverknüpfung" zu der HM-RC-Key3-B erstellt
- Keymatic ist ebenfalls in FHEM angelernt (Device: Tuerschloss)
- die zwei Buttons meiner Fernbedienung (ID: 1F00C8 )erscheinen als Peers (1F00C801 und 1F00C802) bei meinem KeyMatic-Device "Tuerschloss"
- Die Fernbedienung HM-RC-Key3-B selbst ist NICHT als Device in FHEM angelegt
--> FHEM bekommt alles Statusänderungen mit, die über die Fernbedienung erfolgen.

Ich kann das Tuerschloss sowohl über FHEM, als auch über die Fernbedienung steuern. ABER: wenn ich das erste Mal an einem Tag die Tür über die Fernbedienung öffne (bei mir: langer Tastendruck auf die Öffnen-Taste), dann gibt die Fernbedienung eine negative Rückmeldung: erstmal lang rot, dann 2x kurz 1x lang 2x kurz rot) und KeyMatic reagiert nicht. Alle danach gesendeten Befehle von der Fernbedienung funktionieren ohne Probleme! Am nächsten Tag dann wieder das gleiche....

Das habe ich versucht:
- FHEM habe ich gerade eben auf die aktuelle Version aktualisiert (vor dem ersten Türöffnen heute) und das Problem existiert weiter wie beschrieben.
- Ich habe eine vccu definiert --> dort erscheint meine Fernbedienung als unknown device (klar, ist auch nicht definiert; muss aber nach meinem bisherigen Stand auch nicht so sein, oder ist das schon das Problem??)

- Hier die erweiterte Logausgabe; nach dem Update und Neustart von FHEM habe ich um ca. 20:59:xx versucht die Tür zu öffnen (--> Fehler wie beschrieben), dann um 21:00:45 nochmal (--> Tür öffnet sich, alles OK!)

2015.01.21 20:57:21 1: PERL WARNING: Use of uninitialized value in string eq at ./FHEM/10_CUL_HM.pm line 7011.
2015.01.21 20:57:21 0: SMLUSB: Undefined
2015.01.21 20:57:21.977 1: Including fhem.cfg
2015.01.21 20:57:22.224 1: HMLAN_Parse: HMLAN1 new condition disconnected
2015.01.21 20:57:22.238 1: HMLAN_Parse: HMLAN1 new condition init
2015.01.21 20:57:23.018 1: Including ./log/fhem.save
2015.01.21 20:57:25.109 1: HMLAN_Parse: HMLAN1 new condition ok
2015.01.21 20:58:33.914 0: SMLUSB: Undefined
2015.01.21 20:58:33.998 1: Including fhem.cfg
2015.01.21 20:58:34.268 1: HMLAN_Parse: HMLAN1 new condition disconnected
2015.01.21 20:58:34.285 1: HMLAN_Parse: HMLAN1 new condition init
2015.01.21 20:58:35.110 1: Including ./log/fhem.save
2015.01.21 20:58:36.695 1: HMLAN_Parse: HMLAN1 new condition ok
2015.01.21 20:58:44.946 0: Server shutdown
2015.01.21 20:58:48.869 1: Including fhem.cfg
2015.01.21 20:58:50.980 1: HMLAN_Parse: HMLAN1 new condition disconnected
2015.01.21 20:58:51.023 1: HMLAN_Parse: HMLAN1 new condition init
2015.01.21 20:58:55.354 1: Including ./log/fhem.save
2015.01.21 20:58:56.883 0: Server started with 65 defined entities (version $Id: fhem.pl 7609 2015-01-17 21:37:05Z rudolfkoenig $, os linux, user fhem, pid 29506)
2015.01.21 20:58:56.888 0: HMLAN_Parse: HMLAN1 V:03C1 sNo:JEQ0707174 d:1E9E33 O:1E9E33 t:09CDBE65 IDcnt:0004
2015.01.21 20:58:56.899 0: HMLAN_Parse: HMLAN1 R:R0E135D46 stat:0008 t:00000000 d:FF r:7FFF     m:01 A001 1E9E33 2184A7 010E
2015.01.21 20:58:56.901 1: HMLAN_Parse: HMLAN1 new condition ok
2015.01.21 20:58:56.913 0: HMLAN_Parse: HMLAN1 no ACK from 2184A7
2015.01.21 20:58:56.915 0: HMLAN_Parse: HMLAN1 R:R0E1375DE stat:0002 t:00000000 d:FF r:7FFF     m:99 8112 999999 000000
2015.01.21 20:59:03.232 0: HMLAN_Send:  HMLAN1 I:+2184A7,00,01,00
2015.01.21 20:59:03.257 0: HMLAN_Send:  HMLAN1 I:+226E5B,00,01,1E
2015.01.21 20:59:03.325 0: HMLAN_Send:  HMLAN1 I:+1989EF,00,01,00
2015.01.21 20:59:03.353 0: HMLAN_Send:  HMLAN1 I:+2184B3,00,01,00
2015.01.21 20:59:04.375 0: HMLAN_Send:  HMLAN1 S:+2184A7,00,01,00
2015.01.21 20:59:04.376 0: HMLAN_Send:  HMLAN1 S:S0E13AA01 stat:  00 t:00000000 d:01 r:0E13AA01 m:01 A001 1E9E33 2184A7 010E
2015.01.21 20:59:04.986 0: HMLAN_Parse: HMLAN1 R:R0E13AA01 stat:0008 t:00000000 d:FF r:7FFF     m:01 A001 1E9E33 2184A7 010E
2015.01.21 20:59:04.989 0: HMLAN_Parse: HMLAN1 no ACK from 2184A7
2015.01.21 20:59:05.958 0: HMLAN_Send:  HMLAN1 S:+1989EF,00,01,00
2015.01.21 20:59:05.959 0: HMLAN_Send:  HMLAN1 S:S0E13B02F stat:  00 t:00000000 d:01 r:0E13B02F m:02 B001 1E9E33 1989EF 010E
2015.01.21 20:59:06.735 0: HMLAN_Parse: HMLAN1 R:E1989EF   stat:0000 t:09CDFAD8 d:FF r:FFC0     m:02 A010 1989EF 1E9E33 0601010040
2015.01.21 20:59:06.881 0: HMLAN_Parse: HMLAN1 R:R0E13B02F stat:0001 t:09CDFADD d:FF r:FFC0     m:02 A010 1989EF 1E9E33 0601010040
2015.01.21 20:59:06.975 0: HMLAN_Send:  HMLAN1 S:+2184B3,00,01,00
2015.01.21 20:59:06.977 0: HMLAN_Send:  HMLAN1 S:S0E13B429 stat:  00 t:00000000 d:01 r:0E13B429 m:03 A001 1E9E33 2184B3 010E
2015.01.21 20:59:07.139 0: HMLAN_Parse: HMLAN1 R:E2184B3   stat:0000 t:09CDFD6F d:FF r:FFB1     m:03 A410 2184B3 1E9E33 0601000057
2015.01.21 20:59:07.259 0: HMLAN_Parse: HMLAN1 R:R0E13B429 stat:0001 t:09CDFD74 d:FF r:FFB1     m:03 A410 2184B3 1E9E33 0601000057
2015.01.21 20:59:09.722 0: HMLAN_Send:  HMLAN1 S:S0E13BEE3 stat:  00 t:00000000 d:01 r:0E13BEE3 m:01 A001 1E9E33 2184A7 010E
2015.01.21 20:59:10.328 0: HMLAN_Parse: HMLAN1 R:R0E13BEE3 stat:0008 t:00000000 d:FF r:7FFF     m:01 A001 1E9E33 2184A7 010E
2015.01.21 20:59:10.331 0: HMLAN_Parse: HMLAN1 no ACK from 2184A7
2015.01.21 20:59:14.493 0: HMLAN_Send:  HMLAN1 S:S0E13D186 stat:  00 t:00000000 d:01 r:0E13D186 m:01 A001 1E9E33 2184A7 010E
2015.01.21 20:59:16.574 0: HMLAN_Parse: HMLAN1 R:R0E13D186 stat:0008 t:00000000 d:FF r:7FFF     m:01 A001 1E9E33 2184A7 010E
2015.01.21 20:59:16.577 0: HMLAN_Parse: HMLAN1 no ACK from 2184A7
2015.01.21 20:59:16.580 0: HMLAN_Send:  HMLAN1 I:K
2015.01.21 20:59:16.588 0: HMLAN_Parse: HMLAN1 V:03C1 sNo:JEQ0707174 d:1E9E33 O:1E9E33 t:09CE225E IDcnt:0004
2015.01.21 20:59:19.703 0: HMLAN_Send:  HMLAN1 S:S0E13E5E1 stat:  00 t:00000000 d:01 r:0E13E5E1 m:01 A001 1E9E33 2184A7 010E
2015.01.21 20:59:20.311 0: HMLAN_Parse: HMLAN1 R:R0E13E5E1 stat:0008 t:00000000 d:FF r:7FFF     m:01 A001 1E9E33 2184A7 010E
2015.01.21 20:59:20.313 0: HMLAN_Parse: HMLAN1 no ACK from 2184A7
2015.01.21 20:59:41.583 0: HMLAN_Send:  HMLAN1 I:K
2015.01.21 20:59:41.590 0: HMLAN_Parse: HMLAN1 V:03C1 sNo:JEQ0707174 d:1E9E33 O:1E9E33 t:09CE840D IDcnt:0004
2015.01.21 21:00:06.588 0: HMLAN_Send:  HMLAN1 I:K
2015.01.21 21:00:06.608 0: HMLAN_Parse: HMLAN1 V:03C1 sNo:JEQ0707174 d:1E9E33 O:1E9E33 t:09CEE5BE IDcnt:0004
2015.01.21 21:00:31.592 0: HMLAN_Send:  HMLAN1 I:K
2015.01.21 21:00:31.598 0: HMLAN_Parse: HMLAN1 V:03C1 sNo:JEQ0707174 d:1E9E33 O:1E9E33 t:09CF476D IDcnt:0004
2015.01.21 21:00:45.195 0: HMLAN_Parse: HMLAN1 R:E1F00C8   stat:0000 t:09CF7C84 d:FF r:FFBA     m:00 B440 1F00C8 1989EF 4201
2015.01.21 21:00:45.323 0: HMLAN_Parse: HMLAN1 R:E1989EF   stat:0000 t:09CF7D07 d:FF r:FFBD     m:00 A002 1989EF 1F00C8 047B8204D1418902
2015.01.21 21:00:45.575 0: HMLAN_Parse: HMLAN1 R:E1989EF   stat:0000 t:09CF7E03 d:FF r:FFC0     m:00 8002 1989EF 1F00C8 0101010027A59C1B62
2015.01.21 21:00:56.594 0: HMLAN_Send:  HMLAN1 I:K
2015.01.21 21:00:56.603 0: HMLAN_Parse: HMLAN1 V:03C1 sNo:JEQ0707174 d:1E9E33 O:1E9E33 t:09CFA91B IDcnt:0004
2015.01.21 21:01:21.598 0: HMLAN_Send:  HMLAN1 I:K
2015.01.21 21:01:21.604 0: HMLAN_Parse: HMLAN1 V:03C1 sNo:JEQ0707174 d:1E9E33 O:1E9E33 t:09D00ACA IDcnt:0004


Hier ein Auszug der Devices aus der Config:

define HMLAN1 HMLAN 192.168.188.200:1000
attr HMLAN1 hmId 1E9E33
attr HMLAN1 hmKey 01:...xyz4711....
attr HMLAN1 hmLanQlen 1_min

define vccu CUL_HM 1E9E33
attr vccu IODev HMLAN1
attr vccu IOList HMLAN1
attr vccu model CCU-FHEM
attr vccu subType virtual
attr vccu webCmd virtual:update

define hm HMinfo
attr hm sumERROR battery:ok,sabotageError:off,powerError:ok,overload:off,overheat:off,reduced:off,motorError:no,error:none,uncertain:yes,smoke_detect:none,cover:closed
attr hm sumStatus battery,sabotageError,powerError,motor
attr hm webCmd update:protoEvents short:rssi:peerXref:configCheck:models

define Tuerschloss CUL_HM 1989EF
attr Tuerschloss .devInfo 010100
attr Tuerschloss .stc C0
attr Tuerschloss IODev HMLAN1
attr Tuerschloss IOgrp vccu:HMLAN1
attr Tuerschloss autoReadReg 4_reqStatus
attr Tuerschloss expert 2_full
attr Tuerschloss firmware 2.4
attr Tuerschloss model HM-SEC-KEY-S
attr Tuerschloss msgRepeat 1
attr Tuerschloss peerIDs 00000000,1F00C801,1F00C802,
attr Tuerschloss room Homematic
attr Tuerschloss serialNr JEQ0657945
attr Tuerschloss subType keyMatic
attr Tuerschloss webCmd lock:unlock:open
define FileLog_Tuerschloss FileLog ./log/Tuerschloss-%Y.log Tuerschloss
attr FileLog_Tuerschloss logtype text
attr FileLog_Tuerschloss room Homematic
define weblink_Tuerschloss SVG FileLog_Tuerschloss:fs20:CURRENT
attr weblink_Tuerschloss label "Tuerschloss Min $data{min1}, Max $data{max1}, Last $data{currval1}"
attr weblink_Tuerschloss room Plots



Vielen Dank schonmal vorab!
Grüße
Marco
Titel: Antw:HM-RC-Key3-B an Keymatic: erster Befehl wird immer negativ quittiert
Beitrag von: martinp876 am 24 Januar 2015, 15:30:53
wenn 1F00C8 die remote und  1989EF die Tür ist dann wird ein trigger gesendet, die tür fragt nach dem key, die remote antwortet und die tür antwortet nicht mehr.
entweder ist der key falsch oder die Tür hat einen bug.
Titel: Antw:HM-RC-Key3-B an Keymatic: erster Befehl wird immer negativ quittiert
Beitrag von: evoyager am 28 Januar 2015, 21:54:25
hm, ok... also ein Konfig-Problem scheint ausgeschlossen? Dann werde ich mal nach einer neuen Firmware für die Keymatic foschen. Der Fehler ist ja nach dem ersten fehlgeschlagenen Kommando erstmal "weg". Nach ein paar Stunden ohne Befehle ist er dann wieder zurück. Scheint auch mit meiner anderen FB (Typ: HM-RC-Key4-2) aufzutreten. muss aber nochmal beobachten. Kann ich noch weitere Logfiles bereitstellen oder gibts an der Stelle bereits nichts mehr weiter zu analysieren?
Gruß, Marco
Titel: Antw:HM-RC-Key3-B an Keymatic: erster Befehl wird immer negativ quittiert
Beitrag von: martinp876 am 31 Januar 2015, 14:24:42
nachdem das Device nicht antwortet könnte es etwas mit AES zu tun haben. die keys stimmen nicht?
ggf gibt es bei gebern das Register expectAES. das sollte am Sender on sein.