Guten Morgen,
ich habe bis gestern für Homematic eine Kombination aus NanoCUL mit TSCUL-Firmware und HMUARTLGW, angebunden über LAN, benutzt, hat etwa 2 Jahre wunderbar funktioniert. Gestern habe ich den NanoCUL gegen einen weiteren HMUARTLGW, angebunden über USB, ausgetauscht. Seitdem habe ich das Problem, dass die Kommunikation der Sensoren mit aktivierter AES-Signierung, also aesCommReq = 1, nicht klappt.
2019-03-04 09:50:37 CUL_HM FlEG_Eingang aesCommToDev: pending
2019-03-04 09:50:37 CUL_HM FlEG_Eingang aesCommToDev: fail
2019-03-04 09:50:37 CUL_HM FlEG_Eingang trig_aes_VCCU: fail:62
2019-03-04 09:50:38 CUL_HM FlEG_Eingang aesCommToDev: pending
2019-03-04 09:50:38 CUL_HM FlEG_Eingang aesCommToDev: fail
2019-03-04 09:50:38 CUL_HM FlEG_Eingang trig_aes_VCCU: fail:62
2019-03-04 09:50:39 CUL_HM FlEG_Eingang aesCommToDev: pending
2019-03-04 09:50:39 CUL_HM FlEG_Eingang aesCommToDev: fail
2019-03-04 09:50:39 CUL_HM FlEG_Eingang trig_aes_VCCU: fail:62
2019-03-04 09:50:41 CUL_HM FlEG_Eingang aesCommToDev: pending
2019-03-04 09:50:41 CUL_HM FlEG_Eingang aesCommToDev: fail
2019-03-04 09:50:41 CUL_HM FlEG_Eingang trig_aes_VCCU: fail:62
2019-03-04 09:50:43 CUL_HM FlEG_Eingang aesCommToDev: pending
2019-03-04 09:50:43 CUL_HM FlEG_Eingang aesCommToDev: fail
2019-03-04 09:50:43 CUL_HM FlEG_Eingang trig_aes_VCCU: fail:62
Ich habe mittlerweile FHEM mehrfach neugestartet, auch die HMUARTLGW abwechselnd abgeklemmt, trotzdem das gleiche Problem. Die Aktoren, die eine Signatur der Zentrale anfordern, funktionieren im Übrigen ohne Probleme:
2019-03-04 09:49:43 CUL_HM Keymatic aesCommToDev: pending
2019-03-04 09:49:43 CUL_HM Keymatic aesKeyNbr: 04
2019-03-04 09:49:43 CUL_HM Keymatic aesCommToDev: ok
Hat jemand eine Idee?
was sagt fhem.log?
wie sieht ein list vom neuen adapter und der vccu aus?
Hi,
hier ist die Kommunikation mit einer Fernbedienung:
2019.03.04 15:30:46.678 0: HMUARTLGW myHmUARTUSB recv: 01 05 00 00 46 msg: DA A6 40 400FE5 F3A460 027A
2019.03.04 15:30:46.683 0: HMUARTLGW myHmUARTLGW send: 01 06400FE5000000
2019.03.04 15:30:46.689 0: HMUARTLGW myHmUARTUSB send: 01 06400FE5000000
2019.03.04 15:30:46.700 0: HMUARTLGW myHmUARTLGW recv: 01 05 00 00 35 msg: DA A6 40 400FE5 F3A460 027A
2019.03.04 15:30:46.707 0: HMUARTLGW myHmUARTLGW recv: 01 040701010038FFFFFFFFFFFFFFF9, state 90
2019.03.04 15:30:46.709 0: HMUARTLGW myHmUARTLGW GetSet Ack: 07, state 90
2019.03.04 15:30:46.710 0: HMUARTLGW myHmUARTLGW added peer: 400FE5, aesChannels: FFFFFFFFFFFFFFF9
2019.03.04 15:30:46.712 0: HMUARTLGW myHmUARTLGW send: 01 0A400FE50102
2019.03.04 15:30:46.717 0: HMUARTLGW myHmUARTUSB recv: 01 040701010006FFFFFFFFFFFFFFF9, state 90
2019.03.04 15:30:46.719 0: HMUARTLGW myHmUARTUSB GetSet Ack: 07, state 90
2019.03.04 15:30:46.720 0: HMUARTLGW myHmUARTUSB added peer: 400FE5, aesChannels: FFFFFFFFFFFFFFF9
2019.03.04 15:30:46.721 0: HMUARTLGW myHmUARTUSB send: 01 0A400FE50102
2019.03.04 15:30:46.839 0: HMUARTLGW myHmUARTLGW recv: 01 0401, state 91
2019.03.04 15:30:46.840 0: HMUARTLGW myHmUARTLGW GetSet Ack: 01, state 91
2019.03.04 15:30:46.842 0: HMUARTLGW myHmUARTLGW send: 01 09400FE50102
2019.03.04 15:30:46.851 0: HMUARTLGW myHmUARTLGW recv: 01 0401, state 92
2019.03.04 15:30:46.852 0: HMUARTLGW myHmUARTLGW GetSet Ack: 01, state 92
2019.03.04 15:30:46.853 0: HMUARTLGW myHmUARTLGW send: 01 06400FE5000000
2019.03.04 15:30:46.857 0: HMUARTLGW myHmUARTUSB recv: 01 0401, state 91
2019.03.04 15:30:46.858 0: HMUARTLGW myHmUARTUSB GetSet Ack: 01, state 91
2019.03.04 15:30:46.859 0: HMUARTLGW myHmUARTUSB send: 01 09400FE50102
2019.03.04 15:30:46.864 0: HMUARTLGW myHmUARTLGW recv: 01 040701010038FFFFFFFFFFFFFFF9, state 93
2019.03.04 15:30:46.865 0: HMUARTLGW myHmUARTLGW GetSet Ack: 07, state 93
2019.03.04 15:30:46.866 0: HMUARTLGW myHmUARTLGW added peer: 400FE5, aesChannels: FFFFFFFFFFFFFFF9
2019.03.04 15:30:46.866 0: HMUARTLGW myHmUARTLGW send: 01 07400FE5
2019.03.04 15:30:46.872 0: HMUARTLGW myHmUARTUSB recv: 01 0401, state 92
2019.03.04 15:30:46.872 0: HMUARTLGW myHmUARTUSB GetSet Ack: 01, state 92
2019.03.04 15:30:46.873 0: HMUARTLGW myHmUARTUSB send: 01 06400FE5000000
2019.03.04 15:30:46.879 0: HMUARTLGW myHmUARTLGW recv: 01 040701010037, state 90
2019.03.04 15:30:46.880 0: HMUARTLGW myHmUARTLGW GetSet Ack: 07, state 90
2019.03.04 15:30:46.880 0: HMUARTLGW myHmUARTLGW remove peer: 400FE5
2019.03.04 15:30:46.881 0: HMUARTLGW myHmUARTLGW send: 01 06400FE5000000
2019.03.04 15:30:46.886 0: HMUARTLGW myHmUARTUSB recv: 01 040701010006FFFFFFFFFFFFFFF9, state 93
2019.03.04 15:30:46.887 0: HMUARTLGW myHmUARTUSB GetSet Ack: 07, state 93
2019.03.04 15:30:46.888 0: HMUARTLGW myHmUARTUSB added peer: 400FE5, aesChannels: FFFFFFFFFFFFFFF9
2019.03.04 15:30:46.888 0: HMUARTLGW myHmUARTUSB send: 01 07400FE5
2019.03.04 15:30:46.894 0: HMUARTLGW myHmUARTLGW recv: 01 040701010038FFFFFFFFFFFFFFF9, state 90
2019.03.04 15:30:46.895 0: HMUARTLGW myHmUARTLGW GetSet Ack: 07, state 90
2019.03.04 15:30:46.895 0: HMUARTLGW myHmUARTLGW added peer: 400FE5, aesChannels: FFFFFFFFFFFFFFF9
2019.03.04 15:30:46.897 0: HMUARTLGW myHmUARTLGW send: 01 0A400FE50102
2019.03.04 15:30:46.902 0: HMUARTLGW myHmUARTUSB recv: 01 040701010005, state 90
2019.03.04 15:30:46.903 0: HMUARTLGW myHmUARTUSB GetSet Ack: 07, state 90
2019.03.04 15:30:46.903 0: HMUARTLGW myHmUARTUSB remove peer: 400FE5
2019.03.04 15:30:47.027 0: HMUARTLGW myHmUARTLGW recv: 01 0401, state 91
2019.03.04 15:30:47.028 0: HMUARTLGW myHmUARTLGW GetSet Ack: 01, state 91
2019.03.04 15:30:47.030 0: HMUARTLGW myHmUARTLGW send: 01 09400FE50102
2019.03.04 15:30:47.038 0: HMUARTLGW myHmUARTLGW recv: 01 0401, state 92
2019.03.04 15:30:47.040 0: HMUARTLGW myHmUARTLGW GetSet Ack: 01, state 92
2019.03.04 15:30:47.041 0: HMUARTLGW myHmUARTLGW send: 01 06400FE5000000
2019.03.04 15:30:47.057 0: HMUARTLGW myHmUARTLGW recv: 01 040701010038FFFFFFFFFFFFFFF9, state 93
2019.03.04 15:30:47.058 0: HMUARTLGW myHmUARTLGW GetSet Ack: 07, state 93
2019.03.04 15:30:47.059 0: HMUARTLGW myHmUARTLGW added peer: 400FE5, aesChannels: FFFFFFFFFFFFFFF9
2019.03.04 15:30:47.178 0: HMUARTLGW myHmUARTUSB recv: 01 05 00 00 47 msg: DC A2 40 400FE5 F3A460 027A
2019.03.04 15:30:47.309 0: HMUARTLGW myHmUARTUSB recv: 01 05 00 00 40 msg: DC A0 02 F3A460 400FE5 04495A00005A1600
2019.03.04 15:30:47.443 0: HMUARTLGW myHmUARTUSB recv: 01 05 00 00 47 msg: DC A0 03 400FE5 F3A460 727E0615DCF3B19E2B48390829CA7105
2019.03.04 15:30:47.453 0: HMUARTLGW myHmUARTLGW recv: 01 05 03 00 35 msg: DC A2 40 400FE5 F3A460 027A
2019.03.04 15:30:56.525 0: HMUARTLGW myHmUARTUSB send: 00 08
2019.03.04 15:30:56.534 0: HMUARTLGW myHmUARTUSB recv: 00 040200, state 98
2019.03.04 15:30:56.536 0: HMUARTLGW myHmUARTUSB GetSet Ack: 02, state 98
2019.03.04 15:30:56.536 0: HMUARTLGW myHmUARTUSB roundtrip delay: 0.0067
2019.03.04 15:31:00.589 0: HMUARTLGW myHmUARTLGW send: 00 08
2019.03.04 15:31:00.597 0: HMUARTLGW myHmUARTLGW recv: 00 04020D, state 98
2019.03.04 15:31:00.599 0: HMUARTLGW myHmUARTLGW GetSet Ack: 02, state 98
2019.03.04 15:31:00.599 0: HMUARTLGW myHmUARTLGW roundtrip delay: 0.0056
2019.03.04 15:31:11.532 0: HMUARTLGW myHmUARTUSB send: 00 08
2019.03.04 15:31:11.539 0: HMUARTLGW myHmUARTUSB recv: 00 040200, state 98
2019.03.04 15:31:11.540 0: HMUARTLGW myHmUARTUSB GetSet Ack: 02, state 98
2019.03.04 15:31:11.541 0: HMUARTLGW myHmUARTUSB roundtrip delay: 0.0038
2019.03.04 15:31:15.596 0: HMUARTLGW myHmUARTLGW send: 00 08
2019.03.04 15:31:15.611 0: HMUARTLGW myHmUARTLGW recv: 00 04020D, state 98
2019.03.04 15:31:15.613 0: HMUARTLGW myHmUARTLGW GetSet Ack: 02, state 98
2019.03.04 15:31:15.613 0: HMUARTLGW myHmUARTLGW roundtrip delay: 0.0125
2019.03.04 15:31:26.539 0: HMUARTLGW myHmUARTUSB send: 00 08
2019.03.04 15:31:26.549 0: HMUARTLGW myHmUARTUSB recv: 00 040200, state 98
2019.03.04 15:31:26.550 0: HMUARTLGW myHmUARTUSB GetSet Ack: 02, state 98
2019.03.04 15:31:26.551 0: HMUARTLGW myHmUARTUSB roundtrip delay: 0.0067
Hier ist die Konfiguration der VCCU, bis auf die AES-Keys:
Internals:
DEF F3A460
FUUID 5c489f65-f33f-7a7c-523a-b93c1b2fca92609c
IODev myHmUARTLGW
LASTInputDev myHmUARTLGW
MSGCNT 153
NAME VCCU
NOTIFYDEV global
NR 78
NTFY_ORDER 50-VCCU
STATE HMLAN:UAS,myHmUARTLGW:ok,myHmUARTUSB:ok
TYPE CUL_HM
assignedIOs HMLAN,myHmUARTLGW,myHmUARTUSB
channel_01 VCCU_Btn1
lastMsg No:78 - t:02 s:F3A460 d:F2E1ED 00
myHmUARTLGW_MSGCNT 26
myHmUARTLGW_RAWMSG 05000043788002F3A460F2E1ED00
myHmUARTLGW_RSSI -67
myHmUARTLGW_TIME 2019-03-04 15:35:27
myHmUARTUSB_MSGCNT 127
myHmUARTUSB_RAWMSG 0500003F948102F3A460F07A7E00
myHmUARTUSB_RSSI -63
myHmUARTUSB_TIME 2019-03-04 15:34:29
protLastRcv 2019-03-04 15:35:25
protRcv 100 last_at:2019-03-04 15:35:25
protRcvB 3 last_at:2019-03-04 15:33:53
rssi_at_myHmUARTLGW cnt:26 min:-67 max:-66 avg:-66.69 lst:-67
rssi_at_myHmUARTUSB cnt:127 min:-67 max:-62 avg:-63.13 lst:-63
READINGS:
2019-03-04 15:35:25 CommandAccepted yes
2019-03-04 15:28:56 IOopen 2
2019-03-04 15:30:47 aesKeyNbr 00
2019-03-04 15:28:56 state HMLAN:UAS,myHmUARTLGW:ok,myHmUARTUSB:ok
2019-03-04 13:40:27 unknown_2BDEE8 received
helper:
HM_CMDNR 120
PONtest 1
mId FFF0
regLst ,0
rxType 1
supp_Pair_Rep 0
expert:
def 1
det 0
raw 0
tpl 0
io:
nextSend 1551710127.7376
prefIO
vccu VCCU
ioList:
myHmUARTLGW
myHmUARTUSB
mRssi:
mNo 78
io:
myHmUARTLGW:
-63
-63
myHmUARTUSB:
prt:
bErr 0
sProc 0
rspWait:
q:
qReqConf
qReqStat
role:
dev 1
vrt 1
rssi:
at_myHmUARTLGW:
avg -66.6923076923077
cnt 26
lst -67
max -66
min -67
at_myHmUARTUSB:
avg -63.1338582677165
cnt 127
lst -63
max -62
min -67
tmpl:
Attributes:
IODev myHmUARTLGW
IOList myHmUARTLGW,myHmUARTUSB
IOgrp VCCU
hmKey 01:XXX
hmKey2 02:YYY
model CCU-FHEM
room VCCU
subType virtual
webCmd virtual:update
Hier ist die Konfiguration von myHmUARTUSB:
Internals:
AssignedPeerCnt 5
CNT 73
Clients :CUL_HM:
DEF /dev/serial/by-id/usb-Silicon_Labs_CP2102_USB_to_UART_Bridge_Controller_0001-if00-port0@115200
DEVCNT 210
DevState 99
DevType UART
DeviceName /dev/serial/by-id/usb-Silicon_Labs_CP2102_USB_to_UART_Bridge_Controller_0001-if00-port0@115200
FD 118
FUUID 5c7cdc6e-f33f-7a7c-8996-1cec8932e8bdaa69
LastOpen 1551709717.86751
NAME myHmUARTUSB
NR 491
PARTIAL
RAWMSG 0501003F7AA25FF2E1EDF3A46001E81E000000000009D8000000
RSSI -63
STATE opened
TYPE HMUARTLGW
XmitOpen 1
model HM-MOD-UART
msgLoadCurrent 3
msgLoadHistory 2/-/-/-/-/-/-/-/-/-/-/-
msgLoadHistoryAbs 2/0/-/-/-/-/-/-/-/-/-/-/-
owner F3A460
owner_CCU VCCU
Helper:
CreditTimer 34
FW 66561
Initialized 1
SendCnt 3
AckPending:
LastSendLen:
3
3
Log:
IDs:
all
sys
PeerQueue:
PendingCMD:
RoundTrip:
Delay 0.00693202018737793
loadLvl:
lastHistory 1551710035.40642
MatchList:
1:CUL_HM ^A......................
Peers:
11D56B +11D56B,00,00,00
21DAB6 +21DAB6,00,00,00
469A98 +469A98,00,00,00
510308 +510308,00,00,00
F2E1ED +F2E1ED,00,00,00
READINGS:
2019-03-04 15:28:55 D-HMIdAssigned F3A460
2019-03-04 15:28:55 D-HMIdOriginal 4274FB
2019-03-04 15:28:55 D-firmware 1.4.1
2019-03-04 15:28:55 D-serialNr MEQ1541983
2019-03-04 15:28:37 D-type HM-MOD-UART
2019-03-04 15:28:55 cond ok
2019-03-04 15:36:26 load 3
2019-03-04 15:28:55 loadLvl low
2019-03-04 15:28:37 state opened
helper:
Attributes:
hmId F3A460
logIDs all,sys
room VCCU
Nachtrag:
Ändere ich bei einem der betroffenen Sensoren von "aesCommReq = 1" zu "aesCommReq = 0" lasse ihn auslösen und ändere dann zurück auf "aesCommReq = 1" funktioniert er von da an problemlos wieder mit AES. In der VCCU wird dann
aesKeyNbr 04
eingetragen.
Löst ein problematischer/noch nicht behandelter Sensor aus, gibt es wieder dasselbe Problem und in der VCCU wird dann
aesKeyNbr 00
eingetragen.
Es ist schön, einen Workaround zu haben, aber vielleicht kann man ja das eigentlich Problem lösen, damit ich nicht 20 Sensoren einzeln umstellen/auslösen/umstellen muss ;D
Guten Morgen,
hat wirklich niemand eine Idee?
Mir ist bei der Durchsicht meiner Konfigurationen was aufgefallen, was nicht unbedingt mit dem Problem zu tun hat, aber trotzdem so nicht sein sollte. Bei der VCCU steht nämlich:
assignedIOs HMLAN,myHmUARTLGW,myHmUARTUSB
In dem Attribut, in dem ich die IO-Devices angebe, steht aber:
IOList myHmUARTLGW,myHmUARTUSB
Wie kann ich HMLAN ent-assignen?
Moin,
war mir auch schon aufgefallen, aber ich denke das hat nichts mit deinem Problem zu tun.
STATE HMLAN:UAS,myHmUARTLGW:ok,myHmUARTUSB:ok
Das steht aber UAS was ev. unassigned heisst.
Bedeutet die VCCU sieht den IO mit der gleichen HMId, hat ihn aber selbst nicht in der config.
Also entweder rein oder raus. ;D
Gruß Otto
OK, verstehe...
Das Ding ist zwar schon lange nicht mehr angeschlossen, aber die Konfiguration ist noch aktiv, muss ich mal aufräumen.
Das AES-Problem wird dann wohl bestehen bleiben.