Hallo zusammen,
eigentlich soll meine neue Winmatic um 04:45 die Balkontür schließen. Macht sie auch meistens, manchmal aber auch einfach nicht, und ich habe keinen Plan, weshalb.
Wenn es klappt, steht das im Winmatic-Log:
2017-03-29_04:45:00 HM_3AE272 CMDs_pending
2017-03-29_04:45:00 HM_3AE272 aesCommToDev: pending
2017-03-29_04:45:00 HM_3AE272 aesKeyNbr: 00
2017-03-29_04:45:00 HM_3AE272 aesCommToDev: ok
2017-03-29_04:45:00 HM_3AE272 CMDs_done
2017-03-29_04:45:08 HM_3AE272 CMDs_done
Wenn es nicht klappt, steht das im Log:
2017-03-30_04:45:00 HM_3AE272 CMDs_pending
2017-03-30_04:45:00 HM_3AE272 aesCommToDev: pending
2017-03-30_04:45:00 HM_3AE272 aesKeyNbr: 00
2017-03-30_04:45:00 HM_3AE272 aesCommToDev: ok
2017-03-30_04:45:00 HM_3AE272 CMDs_done_Errors:1
2017-03-30_04:45:00 HM_3AE272 NACK
2017-03-30_04:45:00 HM_3AE272 Nack
im fhem Log steht lapidar:
2017.03.30 04:45:00 3: CUL_HM set Winmatic_SZ level 0 0 10
Habt Ihr irgendeinen Tipp, worauf sich die beiden NACK (einmal NACK, einmal Nack) beziehen können bzw. was kann bei einem HM-Gerät ein NACK auslösen? Kann das an zu großer Entfernung zum Sender liegen (hmusb_RSSI -51)? Oder wie kann ich das - dem WAF zuliebe - am Besten einkreisen? Ist ja leider nicht beliebig reproduzierbar.
Danke & Grüße
Martin
Guten Morgen,
Heute noch eine neue Variante: Keine Fehler im Log, Tür wurde aber dennoch nicht geschlossen:
2017-03-31_04:45:00 HM_3AE272 CMDs_pending
2017-03-31_04:45:00 HM_3AE272 aesCommToDev: pending
2017-03-31_04:45:00 HM_3AE272 aesKeyNbr: 00
2017-03-31_04:45:00 HM_3AE272 aesCommToDev: ok
2017-03-31_04:45:00 HM_3AE272 CMDs_done
2017-03-31_04:45:08 HM_3AE272 CMDs_done
Welchen Reim könnte man sich darauf machen?
Grüße
Martin
wenn es grundsätzlich funktioniert, nur manchmal nicht, tippe ich auf timingprobleme. eventuell sogar ein cul am werk?
deine infos sind allerdings sehr sparsam.
welche io's? vccu? wie eingebunden? list's aller beteiligten komponenten posten. fhem aktuell?
sniffen des vorgangs, wie im wiki beschrieben.
Zitat von: frank am 31 März 2017, 09:50:26
deine infos sind allerdings sehr sparsam.
Du hast völlig recht, sorry. Dachte bloß, dass es vielleicht etwas ganz Offensichtliches wäre.
Was ich im List heute sehe ist dass motorErr auf TiltError steht. Dazu konnte ich mir aber nichts ergooglen.
Die Details:
fhem 5.8fhem.pl 13840 2017-03-29 07:52:29Z rudolfkoenigDefinition der Winmaticdefine HM_3AE272 CUL_HM 3AE272
attr HM_3AE272 IODev hmusb
attr HM_3AE272 autoReadReg 4_reqStatus
attr HM_3AE272 expert 2_raw
attr HM_3AE272 firmware 1.6
attr HM_3AE272 model HM-SEC-WIN
attr HM_3AE272 msgRepeat 1
attr HM_3AE272 room CUL_HM,Schlafzimmer
attr HM_3AE272 serialNr MEQ046426
attr HM_3AE272 subType winMatic
attr HM_3AE272 webCmd getConfig:clear msgEvents
define FileLog_HM_3AE272 FileLog ./log/HM_3AE272-%Y.log HM_3AE272
attr FileLog_HM_3AE272 logtype text
attr FileLog_HM_3AE272 room CUL_HM
define Winmatic_SZ CUL_HM 3AE27201
attr Winmatic_SZ model HM-SEC-WIN
attr Winmatic_SZ peerIDs 00000000,
attr Winmatic_SZ room Schlafzimmer
define Winmatic_SZ_Akku CUL_HM 3AE27202
attr Winmatic_SZ_Akku model HM-SEC-WIN
attr Winmatic_SZ_Akku room Schlafzimmerlist Winmatic_SZ::
Internals:
DEF 3AE27201
NAME Winmatic_SZ
NOTIFYDEV global
NR 1215
NTFY_ORDER 50-Winmatic_SZ
STATE 72.5
TYPE CUL_HM
chanNo 01
device HM_3AE272
Readings:
2017-03-31 04:45:00 CommandAccepted yes
2017-03-18 15:47:44 R-pullForce 50 %
2017-03-18 15:47:44 R-pushForce 50 %
2017-03-18 15:47:44 R-tiltMax 255
2017-03-20 23:38:45 RegL_01. 16:01 1C:64 1D:64 1E:FF 00:00
2017-03-31 04:45:08 direction undefined
2017-03-30 09:21:28 level 70
2017-03-31 04:45:08 lock unlocked
2017-03-31 04:45:08 motorErr TiltError
2017-03-31 04:45:08 recentStateType info
2017-03-31 04:45:08 state 72.5
Helper:
Expert:
def 1
det 0
raw 1
tpl 0
Role:
chn 1
Tmpl:
Attributes:
model HM-SEC-WIN
peerIDs 00000000,
room Schlafzimmer HMLAN: list hmusb
Internals:
DEF 127.0.0.1:1234
DeviceName 127.0.0.1:1234
FD 10
IFmodel USB
NAME hmusb
NR 46
NTFY_ORDER 50-hmusb
PARTIAL
RAWMSG E38EB2E,0000,5589CDA5,FF,FFC0,EB861038EB2E0000000A78D50D0000
RSSI -64
STATE opened
TYPE HMLAN
XmitOpen 1
assignedIDsCnt 30
hmusb_MSGCNT 4224
hmusb_TIME 2017-03-31 10:16:01
msgKeepAlive dlyMax:4.398 bufferMin:0
msgLoadCurrent 2
msgLoadHistoryAbs 5min steps: 2/2/3/3/3/3/2/3/3/2/2/2
msgParseDly min:-12 max:4415 last:10 cnt:4164
owner 424242
uptime 016 398:38:17.239
Readings:
2017-03-30 22:56:11 D-HMIdAssigned 424242
2017-03-30 22:56:11 D-HMIdOriginal 1EBD70
2017-03-30 22:56:11 D-firmware 0.967
2017-03-30 22:56:11 D-serialNr JEQ0700605
2017-03-30 22:56:11 Xmit-Events ok:1 init:1 disconnected:1
2017-03-30 22:56:11 cond ok
2017-03-31 10:16:04 loadLvl low
2017-02-01 20:25:45 prot_ERROR-Overload last
2017-02-01 20:30:03 prot_Warning-HighLoad last
2017-03-30 22:56:00 prot_disconnected last
2017-03-30 22:56:00 prot_init last
2017-03-30 22:56:11 prot_ok last
2017-03-30 22:56:00 state opened
Helper:
assIdCnt 30
assIdRep 30
info 03C7,JEQ0700605,1EBD70,424242
setTime 45500
Cnd:
0 1
253 1
255 1
Dly:
cnt 4164
lst 10
max 4415
min -12
Ids:
107841:
cfg +107841,00,01,00
name RC19
1269dd:
cfg +1269DD,00,01,00
name HM_1269DD
24e2f3:
cfg +24E2F3,00,01,00
name Regensensor
299a2f:
cfg +299A2F,00,01,00
chn 01
flg 0
msg
name SD01
to 1490907382.27712
2f45f8:
cfg +2F45F8,00,01,00
name keyremote_1
3037dc:
cfg +3037DC,00,01,00
name HM_3037DC
303933:
cfg +303933,00,01,00
name HM_303933
315940:
cfg +315940,00,01,00
chn 02
flg 0
msg
name HT_KUE_RE
to 1490930400.80847
353dc1:
cfg +353DC1,00,01,00
chn 02
flg 0
msg
name HM_353DC1
to 1490939236.66189
36716c:
cfg +36716C,00,01,00
name THERMOSTAT_Bad
3679e4:
cfg +3679E4,00,01,00
chn 02
flg 0
msg
name THERMOSTAT_Kueche
to 1490941327.00176
37f824:
cfg +37F824,00,01,00
chn 02
flg 0
msg
name HT_KUE_LI
to 1490930053.43883
37f82c:
cfg +37F82C,00,01,00
chn 02
flg 0
msg
name HT_AZ
to 1490932603.99429
389eda:
cfg +389EDA,00,01,00
name reedcontrol
38e037:
cfg +38E037,00,01,00
name HT_WZ_LI
38e057:
cfg +38E057,00,01,00
name HT_WC
38e49b:
cfg +38E49B,00,01,00
name HM_38E49B
38eb2e:
cfg +38EB2E,00,01,00
name HT_BAD_FEN
38ec14:
cfg +38EC14,00,01,00
chn 02
flg 0
msg
name HT_WZ_RE
to 1490912557.12375
38ee12:
cfg +38EE12,00,01,00
name HM_38EE12
391c84:
cfg +391C84,00,01,00
name THERMOSTAT_WZ
3ae272:
cfg +3AE272,00,01,00
chn 81
flg 0
msg
name HM_3AE272
to 1490928302.04297
3ffee0:
cfg +3FFEE0,00,01,00
chn 01
flg 0
msg
name HM_3FFEE0
to 1490907373.58136
3ffefe:
cfg +3FFEFE,00,01,00
chn 02
flg 0
msg
name HM_3FFEFE
to 1490939238.71789
40bb46:
cfg +40BB46,00,01,00
chn 02
flg 0
msg
name HM_40BB46
to 1490939244.89128
40bb9c:
cfg +40BB9C,00,01,00
chn 02
flg 0
msg
name HM_40BB9C
to 1490939245.27052
40d63f:
cfg +40D63F,00,01,00
chn 01
flg 0
msg
name LI.FLU.STRAHLER
to 1490907381.17916
43dca6:
cfg +43DCA6,00,01,00
chn 02
flg 0
msg
name schaltaktor_portal
to 1490946624.4677
4a1d21:
cfg +4A1D21,00,01,00
chn 01
flg 0
msg
name motion_portal
to 1490946635.02339
4b118e:
cfg +4B118E,00,01,00
chn 03
flg 0
msg
name HM_4B118E
to 1490907380.06534
K:
BufMin 0
DlyMax 4.398
Next 1490948189.43206
Start 1490948164.43206
Loadlvl:
bl 40
a:
99
90
40
0
H:
0 low
40 batchLevel
90 high
99 suspended
Log:
all 0
sys 0
ids:
ARRAY(0x1347960)
Q:
HMcndN 0
answerPend 0
hmLanQlen 1
keepAliveRec 1
keepAliveRpt 0
loadLastMax 2
loadNo 3
scnt 4
ald:
2
2
3
3
3
3
2
3
3
2
2
2
apIDs:
Ref:
drft -0.00024004800960192
hmtL 1435097239
kTs 0
offL 1489513067201
sysL 1490948164440
Attributes:
hmId 424242
hmKey 01:7a89cc18e82474af4f2720a0fe18527a
hmLanQlen 1_min
loadLevel 0:low,40:batchLevel,90:high,99:suspendedSniffenHabe mal aus der Ferne einen Schließen und einen Öffnen-Vorgang gesniffed, aber wahrscheinlich müsste man ja sniffen, wenn es gerade mal *nicht* funktiniert:
2017.03.31 10:56:26.949 0: HMLAN_Parse: hmusb R:E36716C stat:0000 t:55AECF78 d:FF r:FFB8 m:D5 8470 36716C 000000 00D430
2017.03.31 10:56:30.252 0: HMLAN_Send: hmusb I:K
2017.03.31 10:56:30.277 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700605 d:1EBD70 O:424242 t:55AEDC82 IDcnt:001E L:0 %
2017.03.31 10:56:32.197 0: HMLAN_Parse: hmusb R:E38EB2E stat:0000 t:55AEE3F2 d:FF r:FFC0 m:FB 8610 38EB2E 000000 0A78D40D0000
2017.03.31 10:56:34.085 0: HMLAN_Parse: hmusb R:E3679E4 stat:0000 t:55AEEB69 d:FF r:FFC7 m:26 8470 3679E4 000000 00D729
2017.03.31 10:56:44.769 0: HMLAN_Send: hmusb S:S2394C93B stat: 00 t:00000000 d:01 r:2394C93B m:45 B011 424242 3AE272 81018CFFC8
2017.03.31 10:56:45.319 0: HMLAN_Parse: hmusb R:E3AE272 stat:0100 t:55AF1731 d:FF r:FFCD m:45 A002 3AE272 424242 04E2FF79C8F3A100
2017.03.31 10:56:45.543 0: HMLAN_Parse: hmusb R:R2394C93B stat:0021 t:55AF1736 d:00 r:FFCD m:45 8002 3AE272 424242 807CEAC6EC
2017.03.31 10:56:55.253 0: HMLAN_Send: hmusb I:K
2017.03.31 10:56:55.272 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700605 d:1EBD70 O:424242 t:55AF3E2A IDcnt:001E L:2 %
2017.03.31 10:57:05.482 0: HMLAN_Parse: hmusb R:E37F824 stat:0000 t:55AF6610 d:FF r:FFBE m:CC 8610 37F824 000000 0AA8D70B0000
2017.03.31 10:57:06.601 0: HMLAN_Parse: hmusb R:E38E057 stat:0000 t:55AF6A5B d:FF r:FFC3 m:97 8610 38E057 000000 0A50CA0C0040
2017.03.31 10:57:20.255 0: HMLAN_Send: hmusb I:K
2017.03.31 10:57:20.267 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700605 d:1EBD70 O:424242 t:55AF9FD5 IDcnt:001E L:2 %
2017.03.31 10:57:20.811 0: HMLAN_Parse: hmusb R:E38EC14 stat:0000 t:55AFA1F0 d:FF r:FFCD m:2F 8610 38EC14 000000 0A78E40A0000
2017.03.31 10:57:32.943 1: Perfmon: possible freeze starting at 10:57:31, delay is 1.943
2017.03.31 10:57:45.256 0: HMLAN_Send: hmusb I:K
2017.03.31 10:57:45.262 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700605 d:1EBD70 O:424242 t:55B0017E IDcnt:001E L:2 %
2017.03.31 10:58:02.929 0: HMLAN_Send: hmusb S:S2395FA8B stat: 00 t:00000000 d:01 r:2395FA8B m:46 B011 424242 3AE272 81010000C8
2017.03.31 10:58:03.472 0: HMLAN_Parse: hmusb R:E3AE272 stat:0100 t:55B04881 d:FF r:FFCD m:46 A002 3AE272 424242 04179A9CB675A000
2017.03.31 10:58:03.728 0: HMLAN_Parse: hmusb R:R2395FA8B stat:0021 t:55B04886 d:00 r:FFCD m:46 8002 3AE272 424242 80D2C0B427
2017.03.31 10:58:10.258 0: HMLAN_Send: hmusb I:K
2017.03.31 10:58:10.302 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700605 d:1EBD70 O:424242 t:55B06327 IDcnt:001E L:3 %
2017.03.31 10:58:12.946 0: HMLAN_Parse: hmusb R:E38E037 stat:0000 t:55B06D8E d:FF r:FFD7 m:A8 8610 38E037 000000 0A78E40F0000
2017.03.31 10:58:13.234 0: HMLAN_Parse: hmusb R:E37F82C stat:0000 t:55B06EB5 d:FF r:FFBD m:65 8610 37F82C 000000 0A44CD090040
2017.03.31 10:58:19.443 0: HMLAN_Parse: hmusb R:E36716C stat:0000 t:55B086ED d:FF r:FFB3 m:D6 865A 36716C 000000 78D430
2017.03.31 10:58:35.259 0: HMLAN_Send: hmusb I:K
2017.03.31 10:58:35.284 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700605 d:1EBD70 O:424242 t:55B0C4D0 IDcnt:001E L:3 %
2017.03.31 10:58:37.173 0: HMLAN_Parse: hmusb R:E315940 stat:0000 t:55B0CC20 d:FF r:FFBF m:52 8610 315940 000000 0AA8D70A0000
2017.03.31 10:58:37.684 0: HMLAN_Parse: hmusb R:E391C84 stat:0000 t:55B0CE2B d:FF r:FFBB m:03 865A 391C84 000000 78E429
2017.03.31 10:58:39.445 0: HMLAN_Parse: hmusb R:E36716C stat:0000 t:55B0D50D d:FF r:FFB4 m:D6 8470 36716C 000000 00D430
2017.03.31 10:58:43.828 1: Perfmon: possible freeze starting at 10:58:42, delay is 1.828
2017.03.31 10:58:43.831 0: HMLAN_Parse: hmusb R:E38EE12 stat:0000 t:55B0E56F d:FF r:FFC6 m:8A 8610 38EE12 000000 0A78D40A0000
2017.03.31 10:58:57.687 0: HMLAN_Parse: hmusb R:E391C84 stat:0000 t:55B11C4B d:FF r:FFBB m:03 8470 391C84 000000 00E429
2017.03.31 10:59:00.260 0: HMLAN_Send: hmusb I:K
2017.03.31 10:59:00.279 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700605 d:1EBD70 O:424242 t:55B12679 IDcnt:001E L:3 %
2017.03.31 10:59:05.016 0: HMLAN_Parse: hmusb R:E38E49B stat:0000 t:55B138F7 d:FF r:FFCA m:04 8610 38E49B 000000 0A24D00F0040
2017.03.31 10:59:05.336 0: HMLAN_Parse: hmusb R:E3679E4 stat:0000 t:55B13A3C d:FF r:FFC7 m:27 865A 3679E4 000000 A8D729
2017.03.31 10:59:11.317 1: Perfmon: possible freeze starting at 10:59:09, delay is 2.317
2017.03.31 10:59:11.323 0: HMLAN_Parse: hmusb R:E38EB2E stat:0000 t:55B14A34 d:FF r:FFBF m:FC 8610 38EB2E 000000 0A78D40D0000
2017.03.31 10:59:22.074 0: HMLAN_Parse: hmusb R:E38EC14 stat:0000 t:55B17B92 d:FF r:FFCD m:30 8610 38EC14 000000 0A78E40A0000
2017.03.31 10:59:25.262 0: HMLAN_Send: hmusb I:K
2017.03.31 10:59:25.275 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700605 d:1EBD70 O:424242 t:55B18823 IDcnt:001E L:3 %
2017.03.31 10:59:25.338 0: HMLAN_Parse: hmusb R:E3679E4 stat:0000 t:55B1885C d:FF r:FFC6 m:27 8470 3679E4 000000 00D729
2017.03.31 10:59:28.347 1: Perfmon: possible freeze starting at 10:59:26, delay is 2.347
2017.03.31 10:59:47.005 0: HMLAN_Parse: hmusb R:E37F824 stat:0000 t:55B1DCEA d:FF r:FFBF m:CD 8610 37F824 000000 0AA8D70B0000
2017.03.31 10:59:50.264 0: HMLAN_Send: hmusb I:K
2017.03.31 10:59:50.302 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700605 d:1EBD70 O:424242 t:55B1E9D0 IDcnt:001E L:3 %
2017.03.31 11:00:10.336 0: HMLAN_Parse: hmusb R:E38E057 stat:0000 t:55B23825 d:FF r:FFC3 m:98 8610 38E057 000000 0A50CA0C0040
2017.03.31 11:00:15.266 0: HMLAN_Send: hmusb I:K
2017.03.31 11:00:15.297 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700605 d:1EBD70 O:424242 t:55B24B79 IDcnt:001E L:3 %
2017.03.31 11:00:32.995 0: HMLAN_Parse: hmusb R:E37F82C stat:0000 t:55B2909E d:FF r:FFBD m:66 8610 37F82C 000000 0A44CD090040
2017.03.31 11:00:36.195 0: HMLAN_Parse: hmusb R:E38E037 stat:0000 t:55B29D24 d:FF r:FFD7 m:A9 8610 38E037 000000 0A78E40F0000
2017.03.31 11:00:38.404 0: HMLAN_Parse: hmusb R:E315940 stat:0000 t:55B2A5C4 d:FF r:FFBF m:53 8610 315940 000000 0AA8D70A0000
2017.03.31 11:00:40.267 0: HMLAN_Send: hmusb I:K
2017.03.31 11:00:40.292 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700605 d:1EBD70 O:424242 t:55B2AD22 IDcnt:001E L:3 %
2017.03.31 11:01:05.269 0: HMLAN_Send: hmusb I:K
2017.03.31 11:01:05.287 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700605 d:1EBD70 O:424242 t:55B30ECC IDcnt:001E L:3 %
2017.03.31 11:01:20.485 1: Perfmon: possible freeze starting at 11:01:19, delay is 1.485
2017.03.31 11:01:21.448 0: HMLAN_Parse: hmusb R:E391C84 stat:0000 t:55B34DD5 d:FF r:FFBB m:04 865A 391C84 000000 78E529
2017.03.31 11:01:30.271 0: HMLAN_Send: hmusb I:K
2017.03.31 11:01:30.282 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700605 d:1EBD70 O:424242 t:55B37078 IDcnt:001E L:3 %
2017.03.31 11:01:31.434 0: HMLAN_Parse: hmusb R:E391C84 stat:0000 t:55B374E7 d:FF r:FFBB m:5D 8410 391C84 000000 0B78E50C00
2017.03.31 11:01:31.626 0: HMLAN_Parse: hmusb R:E38EE12 stat:0000 t:55B375B4 d:FF r:FFC6 m:8B 8610 38EE12 000000 0A78D40A0000
2017.03.31 11:01:32.202 0: HMLAN_Parse: hmusb R:E38EB2E stat:0000 t:55B377D7 d:FF r:FFC0 m:FD 8610 38EB2E 000000 0A78D40D0000
2017.03.31 11:01:41.420 0: HMLAN_Parse: hmusb R:E391C84 stat:0000 t:55B39BF5 d:FF r:FFBB m:04 8470 391C84 000000 00E529
2017.03.31 11:01:42.347 0: HMLAN_Parse: hmusb R:E3679E4 stat:0000 t:55B39F89 d:FF r:FFC7 m:28 865A 3679E4 000000 A8D729
2017.03.31 11:01:47.276 0: HMLAN_Parse: hmusb R:E38E49B stat:0000 t:55B3B2C5 d:FF r:FFCA m:05 8610 38E49B 000000 0A24D00F0040
2017.03.31 11:01:55.273 0: HMLAN_Send: hmusb I:K
2017.03.31 11:01:55.277 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700605 d:1EBD70 O:424242 t:55B3D221 IDcnt:001E L:3 %
2017.03.31 11:02:02.350 0: HMLAN_Parse: hmusb R:E3679E4 stat:0000 t:55B3EDA9 d:FF r:FFC7 m:28 8470 3679E4 000000 00D729
2017.03.31 11:02:12.821 0: HMLAN_Parse: hmusb R:E38EC14 stat:0000 t:55B41693 d:FF r:FFCD m:31 8610 38EC14 000000 0A78E50A0000
2017.03.31 11:02:13.999 0: HMLAN_Parse: hmusb R:E37F824 stat:0000 t:55B41B24 d:FF r:FFBE m:CE 8610 37F824 000000 0AA8D70B0000
2017.03.31 11:02:20.275 0: HMLAN_Send: hmusb I:K
2017.03.31 11:02:20.304 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700605 d:1EBD70 O:424242 t:55B433CA IDcnt:001E L:3 %
2017.03.31 11:02:38.482 0: HMLAN_Parse: hmusb R:E37F82C stat:0000 t:55B47ADB d:FF r:FFBD m:67 8610 37F82C 000000 0A44CD090040
2017.03.31 11:02:44.947 0: HMLAN_Parse: hmusb R:E38E037 stat:0000 t:55B49414 d:FF r:FFD7 m:AA 8610 38E037 000000 0A78E50F0000
2017.03.31 11:02:45.276 0: HMLAN_Send: hmusb I:K
2017.03.31 11:02:45.299 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700605 d:1EBD70 O:424242 t:55B49574 IDcnt:001E L:3 %
2017.03.31 11:02:59.605 0: HMLAN_Parse: hmusb R:E38E057 stat:0000 t:55B4CD4B d:FF r:FFC3 m:99 8610 38E057 000000 0A50CA0C0040
2017.03.31 11:03:10.277 0: HMLAN_Send: hmusb I:K
2017.03.31 11:03:10.294 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700605 d:1EBD70 O:424242 t:55B4F71D IDcnt:001E L:3 %
2017.03.31 11:03:29.144 0: HMLAN_Parse: hmusb R:E315940 stat:0000 t:55B540C2 d:FF r:FFBF m:54 8610 315940 000000 0AA8D70A0000
2017.03.31 11:03:35.279 0: HMLAN_Send: hmusb I:K
2017.03.31 11:03:35.289 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700605 d:1EBD70 O:424242 t:55B558C6 IDcnt:001E L:3 %
2017.03.31 11:03:40 0: HMLAN_Parse: hmusb R:E38EB2E stat:0000 t:55B56DCC d:FF r:FFBF m:FE 8610 38EB2E 000000 0A78D40D0000
2017.03.31 11:03:50 0: HMLAN_Parse: hmusb R:E391C84 stat:0000 t:55B594D6 d:FF r:FFBB m:05 865A 391C84 000000 78E529
2017.03.31 11:04:00 0: HMLAN_Send: hmusb I:K
2017.03.31 11:04:00 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700605 d:1EBD70 O:424242 t:55B5BA70 IDcnt:001E L:3 %
2017.03.31 11:04:04 0: HMLAN_Parse: hmusb R:E3679E4 stat:0000 t:55B5CC2E d:FF r:FFC7 m:29 865A 3679E4 000000 A8D729
2017.03.31 11:04:05 0: HMLAN_Parse: hmusb R:E38EE12 stat:0000 t:55B5CD4F d:FF r:FFC7 m:8C 8610 38EE12 000000 0A78D40A0000
2017.03.31 11:04:09 0: HMLAN_Parse: hmusb R:E36716C stat:0000 t:55B5DD28 d:FF r:FFB8 m:D8 865A 36716C 000000 78D430
2017.03.31 11:04:10 0: HMLAN_Parse: hmusb R:E391C84 stat:0000 t:55B5E2F6 d:FF r:FFBB m:05 8470 391C84 000000 00E529
2017.03.31 11:04:15 0: HMLAN_Parse: hmusb R:E38E49B stat:0000 t:55B5F3E9 d:FF r:FFCA m:06 8610 38E49B 000000 0A24D00F0040
2017.03.31 11:04:24 0: HMLAN_Parse: hmusb R:E3679E4 stat:0000 t:55B61A4E d:FF r:FFC7 m:29 8470 3679E4 000000 00D729
2017.03.31 11:04:25 0: HMLAN_Send: hmusb I:K
2017.03.31 11:04:25 0: HMLAN_Parse: hmusb V:03C7 sNo:JEQ0700605 d:1EBD70 O:424242 t:55B61C18 IDcnt:001E L:3 %
2017.03.31 11:04:26 0: HMLAN_Parse: hmusb R:E37F824 stat:0000 t:55B620B7 d:FF r:FFBF m:CF 8610 37F824 000000 0AA8D70B0000
2017.03.31 11:04:29 0: HMLAN_Parse: hmusb R:E36716C stat:0000 t:55B62B48 d:FF r:FFB5 m:D8 8470 36716C 000000 00D430
besser im List vom HMUSB den hmKey unkenntlich machen...
der Winmatic nutzt noch den Original hmKey und nicht den von dir am hmUSB eingesetellten. daran zu erkennen:
2017-03-31_04:45:00 HM_3AE272 aesKeyNbr: 00
da müsste '02' stehen
Dann ist da noch ein:
2017-03-31 04:45:08 motorErr TiltError
im list vom Winmatic. Das dürfte die erklärung dafür sein, dass das Fenster trotz richtiger Kommunikation nicht geschlossen war. Also ein 'Hardwarefehler' - Fenster schwergängig - Einbrecher hatte grad den Arm durchs gekippte Fenster gesteckt... - oder oder oder
das list vom winmatic hauptdevice wäre noch interessant.
beim sniffen reicht auch erst einmal statt logIds=sys,all nur das device einzutragen, um das log zu "schonen" bis der fehler mal wieder auftaucht. die millisekunden aber wieder einschalten.
bei einem nack wird eigentlich immer etwas abgelehnt.
der akku ist noch tip-top?
Zitat von: automatisierer am 31 März 2017, 11:52:42
besser im List vom HMUSB den hmKey unkenntlich machen...
Ist schon ein anderer als der tatsächliche ;)
Zitatder Winmatic nutzt noch den Original hmKey und nicht den von dir am hmUSB eingesetellten. daran zu erkennen:
2017-03-31_04:45:00 HM_3AE272 aesKeyNbr: 00
da müsste '02' stehen
Aber dann dürfte die Winmatic doch eigentlich nie funktionieren bzw. funktioniert haben, was sie aber tat/tut, oder? Im Log wird sie immer nur mit dem 00er key angesprochen, und das wir d ja auch immer mit aesCommToDev: ok quittiert, oder hat das nichts zu sagen?
Zitat
Dann ist da noch ein:
2017-03-31 04:45:08 motorErr TiltError
im list vom Winmatic. Das dürfte die erklärung dafür sein, dass das Fenster trotz richtiger Kommunikation nicht geschlossen war. Also ein 'Hardwarefehler' - Fenster schwergängig - Einbrecher hatte grad den Arm durchs gekippte Fenster gesteckt... - oder oder oder
Jo, das schrieb ich ja eingangs. Konnte allerdings keine Infow zu TiltError finden und auch keinen mechanischen Hinderungsgrund für das Schließen...
Beim Öffnen/Schließen vorhin gab es BTW wieder die NACKs:
2017-03-31_10:56:44 HM_3AE272 CMDs_pending
2017-03-31_10:56:45 HM_3AE272 aesCommToDev: pending
2017-03-31_10:56:45 HM_3AE272 aesKeyNbr: 00
2017-03-31_10:56:45 HM_3AE272 aesCommToDev: ok
2017-03-31_10:56:45 HM_3AE272 CMDs_done_Errors:1
2017-03-31_10:56:45 HM_3AE272 NACK
2017-03-31_10:56:45 HM_3AE272 Nack
2017-03-31_10:58:02 HM_3AE272 CMDs_pending
2017-03-31_10:58:03 HM_3AE272 aesCommToDev: pending
2017-03-31_10:58:03 HM_3AE272 aesKeyNbr: 00
2017-03-31_10:58:03 HM_3AE272 aesCommToDev: ok
2017-03-31_10:58:03 HM_3AE272 CMDs_done_Errors:1
2017-03-31_10:58:03 HM_3AE272 NACK
2017-03-31_10:58:03 HM_3AE272 NackGrüße
Martin
Zitat von: frank am 31 März 2017, 12:11:35
das list vom winmatic hauptdevice wäre noch interessant.
Internals:
DEF 3AE272
IODev hmusb
LASTInputDev hmusb
MSGCNT 12
NAME HM_3AE272
NOTIFYDEV global
NR 1213
NTFY_ORDER 50-HM_3AE272
STATE Nack
TYPE CUL_HM
channel_01 Winmatic_SZ
channel_02 Winmatic_SZ_Akku
hmusb_MSGCNT 12
hmusb_RAWMSG R2395FA8B,0021,55B04886,00,FFCD,4680023AE27242424280D2C0B427
hmusb_RSSI -51
hmusb_TIME 2017-03-31 10:58:03
lastMsg No:46 - t:02 s:3AE272 d:424242 80D2C0B427
protCmdDel 2
protEvt_AESCom-ok 3 last_at:2017-03-31 10:58:03
protLastRcv 2017-03-31 10:58:03
protNack 2 last_at:2017-03-31 10:58:03
protSnd 6 last_at:2017-03-31 10:58:02
protState CMDs_done_Errors:1
rssi_at_hmusb lst:-51 avg:-51.5 cnt:6 min:-52 max:-51
rssi_hmusb max:-53 min:-53 avg:-53 cnt:1 lst:-53
Readings:
2017-03-31 10:58:03 CommandAccepted no
2017-03-18 15:47:39 D-firmware 1.6
2017-03-18 15:47:39 D-serialNr MEQ0464267
2017-03-20 23:36:09 PairedTo 0x424242
2017-03-18 15:47:44 R-pairCentral 0x424242
2017-03-20 23:36:09 RegL_00. 02:01 03:19 0A:42 0B:42 0C:42 00:00
2017-03-31 10:58:03 aesCommToDev ok
2017-03-31 10:58:03 aesKeyNbr 00
2017-03-19 05:52:46 powerOn 2017-03-19 05:52:46
2017-03-31 10:58:03 state Nack
Helper:
HM_CMDNR 70
cSnd 114242423AE27281018CFFC8,114242423AE27281010000C8
mId 0028
rxType 2
supp_Pair_Rep 0
Expert:
def 1
det 0
raw 1
tpl 0
Io:
newChn +3AE272,00,01,00
nextSend 1490950683.53793
prefIO
rxt 0
vccu
p:
3AE272
00
01
00
Mrssi:
mNo 46
Io:
hmusb -49
Prt:
bErr 0
sProc 0
Rspwait:
Q:
qReqConf
qReqStat
Role:
dev 1
prs 1
Rssi:
At_hmusb:
avg -51.5
cnt 6
lst -51
max -51
min -52
Hmusb:
avg -53
cnt 1
lst -53
max -53
min -53
Tmpl:
Attributes:
IODev hmusb
autoReadReg 4_reqStatus
expert 2_raw
firmware 1.6
model HM-SEC-WIN
msgRepeat 1
room CUL_HM,Schlafzimmer
serialNr MEQ0464267
subType winMatic
webCmd getConfig:clear msgEvents Zitatder akku ist noch tip-top?
Ja, das Teil ist nagelneu, der Akku aktuell bei 75%
2017.03.31 10:56:44.769 0: HMLAN_Send: hmusb S:S2394C93B stat: 00 t:00000000 d:01 r:2394C93B m:45 B011 424242 3AE272 81018CFFC8
2017.03.31 10:56:45.319 0: HMLAN_Parse: hmusb R:E3AE272 stat:0100 t:55AF1731 d:FF r:FFCD m:45 A002 3AE272 424242 04E2FF79C8F3A100
2017.03.31 10:56:45.543 0: HMLAN_Parse: hmusb R:R2394C93B stat:0021 t:55AF1736 d:00 r:FFCD m:45 8002 3AE272 424242 807CEAC6EC
---
2017.03.31 10:58:02.929 0: HMLAN_Send: hmusb S:S2395FA8B stat: 00 t:00000000 d:01 r:2395FA8B m:46 B011 424242 3AE272 81010000C8
2017.03.31 10:58:03.472 0: HMLAN_Parse: hmusb R:E3AE272 stat:0100 t:55B04881 d:FF r:FFCD m:46 A002 3AE272 424242 04179A9CB675A000
2017.03.31 10:58:03.728 0: HMLAN_Parse: hmusb R:R2395FA8B stat:0021 t:55B04886 d:00 r:FFCD m:46 8002 3AE272 424242 80D2C0B427
das sind die 2 sequenzen, die von der winmatic jeweils mit nack beantwortet werden.
hier fehlt jeweils als dritte message die signing response vom hmusb zum device. siehe zb hier https://git.zerfleddert.de/hmcfgusb/AES/ (https://git.zerfleddert.de/hmcfgusb/AES/)
das könnte allerdings normal sein, falls der hmusb die antwort selber generiert und fhem davon nichts mitteilt, wie auch bei ack ohne aes. mit einem sniffenden 2. io würde man es ggf sehen können. da aesCommToDev=ok gemeldet wird, würde ich erstmal meinen, dass die kommunikation funktioniert. dann bliebe die frage, warum die aktion abgelehnt wird.
vielleicht liegt es an dem motorerror, der vorher aufgetreten ist.
Vielen Dank Frank,
Zitat von: frank am 01 April 2017, 09:58:34
da aesCommToDev=ok gemeldet wird, würde ich erstmal meinen, dass die kommunikation funktioniert. dann bliebe die frage, warum die aktion abgelehnt wird.
vielleicht liegt es an dem motorerror, der vorher aufgetreten ist.
Über den Tilterror finde ich leider nichts an Info, und standardmäßig erscheint er ja nicht im Winmatic-Log (meine mich zu erinnern, dass man das aber von Hand konfigurieren kann...). Aber was Du sagst, scheint sehr plausibel. Es handelt sich um eine Art Balkontür, ziemlich groß und nicht eben leicht, aber neu und leichtgängig. Die Zugkraft der Winmatic habe ich auf 50% stehen, und bei manuellem Auslösen läuft das auch ganz smooth durch beim Schließen. Wenn ich mir jetzt aber vorstelle, dass es beim frühmorgentlichen Schließprozess vielleicht mal eine Windlast auf den immerhin fast 3m2 gibt, so kann das natürlich alles in Frage stellen.
Heute Nacht hat alles bestens funktioniert. Werde jetzt mal die Zugkraft erhöhen und weiter beobachten.
Schönes Wochenende & nochmals vielen Dank für die Hilfe
Martin
Bei der Einstellung der Parameter am Device habe ich im Kleingedruckten gelesen:
ZitatWird ein mechanischer Fehler (Verklemmen oder ähnliches) detektiert ertönt ein-malig ein Piepton. Über angelernte Bedienelemente ist dann kein Bedienen mehr möglich (Fernbedienungen und Taster signalisieren dies durch eine Fehlermeldung: ,,Befehl konnte nicht ausgeführt werden.") Sie können diesen Zustand durch einmaliges Bedienen direkt an der WinMatic zu-rücksetzen.
D.h. für mich, dass das Teil nach einem Fehler auch keine Befehle von fhem mehr annimmt, bevor man sich nicht physikalisch vor Ort begibt und die Lage checkt. Das dürfte zumindest die NACKs nach einem Motorerror (von dem ich allerdings nach wie vor nicht weiß, ober er wirklich vor jedem Nack aufgetreten ist) erklären.
BTW und etwas OT: Die Konfiguration der wenigen Winmatic-Einstellungen am Device ist ja wirklich ein Horror, da man lt. Handbuch jedesmal den kompletten Prozess (inkl. Ausklinken der Zahnstange und Ausbau des Vierkants!) durchlaufen muss, auch wenn man nur z.B die Zugkraft eine Stufe höher setzen will.
Könnte man das nicht via fhem konfigurieren?
Grüße
Martin
Zitat von: dadoc am 02 April 2017, 10:44:01wenn man nur z.B die Zugkraft eine Stufe höher setzen will.
Könnte man das nicht via fhem konfigurieren?
Geht das inzwischen?
Nicht soweit ich das sehen könnte.
Bei mir ist das o.g. Problem seit dem Hochsetzen der Zugkraft BTW nie mehr aufgetreten, so dass es wirklich daran gelegen haben dürfte.