[cul_hm] HM-CC-VD/virt_TC: probleme beim konfigurieren des vd

Begonnen von frank, 18 Mai 2021, 11:18:43

Vorheriges Thema - Nächstes Thema

frank

hallo ansgar,

mit deiner aktuellen cul_hm version gibt es probleme beim vd.
im sniff ist ein regset mit automatischem getconfig zu sehen, wobei das preferedIO des vd, ein hmuart, gecrasht ist.

- zunächst der letzte zyklus vor dem regset => alles normal.
- dann regset abgesetzt => doppeltes präparieren des io vom vd, nicht schön aber schon bekannt.

- im folgenden zyklus beginnen die probleme:
1. auf 8202 vom vd müsste eigentlich fhem zunächst A112 senden, was nicht geschieht.
trotzdem ist der vd eine zeitlang wach, wodurch wenigstens das register gesetzt wird.
2. zum abschluss des zyklus wird der hmuart das 3. mal auf wakeup präpariert.

- im nächsten zyklus wird das getconfig wiederholt und das chaos beginnt:
3. der vd antwortet nun nicht mit 8202 auf A258 vom virtuellen tc, sondern mit 8102.
er will also seinen peer wach halten und ihm was erzählen!
2021.05.17 17:07:53.026 4: CUL_Parse: cul868 A 16 D5 A410 1C4E25 B5B5B5 0400000000000509000A0A0000 -88
das sieht aus wie ein zusammengesetzter cmd readList5+aktuelleRegisterWerte
4. in diese kommunikation zwischen vd und vtc haut jetzt fhem mit dem getconfig rein!
das bleibt aber völlig unbeachtet.
5. nun wird auch noch der hmlan präpariert!! der ist preferedIO vom vtc
das sieht völlig schräg aus und führt im weiteren verlauf dazu, dass er seit dem ständig A112 sendet, sobald der vd seine 8202 msg sendet. hmuart und hmlan sind jetzt beide mit dem vd assignt.
diese doppelte zuweisung bekomme ich nicht mehr weg. set hmlan reassign hat nur dazu geführt, dass der hmlan nun nicht mehr auf wakeup für den vd präpariert ist, sodass es nun keine A112 mehr gibt.
6. zum abschluss dieses zyklus crasht der hmuart beim versuch ihn erneut zu präparieren (eventuell auch kurz vorher), wird aber erfolgreich wiederbelebt.

- später wird das getconfig noch erfolgreich übertragen, aber auch ohne A112.
- der vd bleibt auf dauer doppelt assignt.

2021.05.17 16:53:10.802 0: HMUARTLGW hmuart1 send: 01 02 00 00 00 msg: CD A2 58 B5B5B5 1C4E25 0000
2021.05.17 16:53:10.842 0: HMLAN_Parse: hmlan1 R:EB5B5B5   stat:0000 t:0493AB84 d:FF r:FFCF     m:CD A258 B5B5B5 1C4E25 0000
2021.05.17 16:53:10.847 4: CUL_Parse: cul868 A 0B CD A258 B5B5B5 1C4E25 0000 -22.5
2021.05.17 16:53:10.958 4: CUL_Parse: cul868 A 0E CD 8202 1C4E25 B5B5B5 0101000049 -90
2021.05.17 16:53:10.991 0: HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:0493AC05 d:FF r:FFC0     m:CD 8202 1C4E25 B5B5B5 0101000049
2021.05.17 16:53:10.997 0: HMUARTLGW hmuart1 recv: 01 04 03 00 45 msg: CD 82 02 1C4E25 B5B5B5 0101000049


2021.05.17 16:58:39.404 3: CUL_HM set Ventil.AZ.Nord regSet exec valveErrorPos 10
2021.05.17 16:58:39.462 2: HMinfo hminfo get:configCheck :-f,^(Ventil.AZ.Nord|Ventil.AZ.Nord)$
2021.05.17 16:58:39.557 0: HMUARTLGW hmuart1 send: 01 061C4E25000100
2021.05.17 16:58:39.565 0: HMUARTLGW hmuart1 recv: 01 040701010007FFFFFFFFFFFFFFFF, state 90
2021.05.17 16:58:39.567 0: HMUARTLGW hmuart1 GetSet Ack: 07, state 90
2021.05.17 16:58:39.567 0: HMUARTLGW hmuart1 added peer: 1C4E25, aesChannels: FFFFFFFFFFFFFFFF
2021.05.17 16:58:39.570 0: HMUARTLGW hmuart1 send: 01 061C4E25000100
2021.05.17 16:58:39.577 0: HMUARTLGW hmuart1 recv: 01 040701010007FFFFFFFFFFFFFFFF, state 93
2021.05.17 16:58:39.578 0: HMUARTLGW hmuart1 GetSet Ack: 07, state 93
2021.05.17 16:58:39.579 0: HMUARTLGW hmuart1 added peer: 1C4E25, aesChannels: FFFFFFFFFFFFFFFF
2021.05.17 16:58:39.579 0: HMUARTLGW hmuart1 send: 01 061C4E25000100
2021.05.17 16:58:39.588 0: HMUARTLGW hmuart1 recv: 01 040701010007FFFFFFFFFFFFFFFF, state 90
2021.05.17 16:58:39.590 0: HMUARTLGW hmuart1 GetSet Ack: 07, state 90
2021.05.17 16:58:39.590 0: HMUARTLGW hmuart1 added peer: 1C4E25, aesChannels: FFFFFFFFFFFFFFFF
2021.05.17 16:58:39.593 0: HMUARTLGW hmuart1 send: 01 061C4E25000100
2021.05.17 16:58:39.599 0: HMUARTLGW hmuart1 recv: 01 040701010007FFFFFFFFFFFFFFFF, state 93
2021.05.17 16:58:39.601 0: HMUARTLGW hmuart1 GetSet Ack: 07, state 93
2021.05.17 16:58:39.601 0: HMUARTLGW hmuart1 added peer: 1C4E25, aesChannels: FFFFFFFFFFFFFFFF


2021.05.17 17:00:32.652 0: HMUARTLGW hmuart1 send: 01 02 00 00 00 msg: D0 A2 58 B5B5B5 1C4E25 0000
2021.05.17 17:00:32.686 4: CUL_Parse: cul868 A 0B D0 A258 B5B5B5 1C4E25 0000 -22.5
2021.05.17 17:00:32.691 0: HMLAN_Parse: hmlan1 R:EB5B5B5   stat:0000 t:049A69BB d:FF r:FFCF     m:D0 A258 B5B5B5 1C4E25 0000
2021.05.17 17:00:32.809 4: CUL_Parse: cul868 A 0E D0 8202 1C4E25 B5B5B5 0101000049 -91
2021.05.17 17:00:32.813 3: CUL_HM set Ventil.AZ.Nord getConfig noArg
2021.05.17 17:00:32.852 0: HMUARTLGW hmuart1 recv: 01 04 03 00 45 msg: D0 82 02 1C4E25 B5B5B5 0101000049
2021.05.17 17:00:32.855 0: HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:049A6A3C d:FF r:FFC0     m:D0 8202 1C4E25 B5B5B5 0101000049
2021.05.17 17:00:32.949 0: HMUARTLGW hmuart1 send: 01 02 00 00 00 msg: D1 A0 01 1ACE1F 1C4E25 01050000000005
2021.05.17 17:00:32.980 4: CUL_Parse: cul868 A 10 D1 A001 1ACE1F 1C4E25 01050000000005 -22.5
2021.05.17 17:00:32.991 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:049A6AE8 d:FF r:FFD0     m:D1 A001 1ACE1F 1C4E25 01050000000005
2021.05.17 17:00:33.099 4: CUL_Parse: cul868 A 0A D1 8002 1C4E25 1ACE1F 00 -90.5
2021.05.17 17:00:33.108 0: HMUARTLGW hmuart1 recv: 01 04 03 00 45 msg: D1 80 02 1C4E25 1ACE1F 00
2021.05.17 17:00:33.113 0: HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:049A6B60 d:FF r:FFC0     m:D1 8002 1C4E25 1ACE1F 00
2021.05.17 17:00:33.205 0: HMUARTLGW hmuart1 send: 01 02 00 00 00 msg: D2 A0 01 1ACE1F 1C4E25 01080A0A
2021.05.17 17:00:33.241 4: CUL_Parse: cul868 A 0D D2 A001 1ACE1F 1C4E25 01080A0A -22.5
2021.05.17 17:00:33.252 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:049A6BED d:FF r:FFD0     m:D2 A001 1ACE1F 1C4E25 01080A0A
2021.05.17 17:00:33.364 4: CUL_Parse: cul868 A 0A D2 8002 1C4E25 1ACE1F 00 -87.5
2021.05.17 17:00:33.373 0: HMUARTLGW hmuart1 recv: 01 04 03 00 45 msg: D2 80 02 1C4E25 1ACE1F 00
2021.05.17 17:00:33.378 0: HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:049A6C66 d:FF r:FFC0     m:D2 8002 1C4E25 1ACE1F 00
2021.05.17 17:00:33.471 0: HMUARTLGW hmuart1 send: 01 02 00 00 00 msg: D3 A0 01 1ACE1F 1C4E25 0106
2021.05.17 17:00:33.504 4: CUL_Parse: cul868 A 0B D3 A001 1ACE1F 1C4E25 0106 -22.5
2021.05.17 17:00:33.514 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:049A6CF3 d:FF r:FFD0     m:D3 A001 1ACE1F 1C4E25 0106
2021.05.17 17:00:33.626 4: CUL_Parse: cul868 A 0A D3 8002 1C4E25 1ACE1F 00 -88
2021.05.17 17:00:33.635 0: HMUARTLGW hmuart1 recv: 01 04 03 00 45 msg: D3 80 02 1C4E25 1ACE1F 00
2021.05.17 17:00:33.639 0: HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:049A6D6E d:FF r:FFC0     m:D3 8002 1C4E25 1ACE1F 00
2021.05.17 17:00:33.733 0: HMUARTLGW hmuart1 send: 01 02 00 00 00 msg: D4 A0 01 1ACE1F 1C4E25 00040000000000
2021.05.17 17:00:33.771 4: CUL_Parse: cul868 A 10 D4 A001 1ACE1F 1C4E25 00040000000000 -22.5
2021.05.17 17:00:33.781 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:049A6DFE d:FF r:FFCF     m:D4 A001 1ACE1F 1C4E25 00040000000000
2021.05.17 17:00:34.048 4: CUL_Parse: cul868 A 10 D4 A001 1ACE1F 1C4E25 00040000000000 -22.5
2021.05.17 17:00:34.058 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:049A6F13 d:FF r:FFCF     m:D4 A001 1ACE1F 1C4E25 00040000000000
2021.05.17 17:00:34.329 4: CUL_Parse: cul868 A 10 D4 A001 1ACE1F 1C4E25 00040000000000 -22.5
2021.05.17 17:00:34.340 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:049A702D d:FF r:FFCF     m:D4 A001 1ACE1F 1C4E25 00040000000000
2021.05.17 17:00:34.578 0: HMUARTLGW hmuart1 recv: 01 0404, state 100
2021.05.17 17:00:34.579 0: HMUARTLGW hmuart1 can't send due to unknown problem (no response?)
2021.05.17 17:00:37.356 4: CUL_Parse: cul868 A 14 4C 805E 266EA5 1ACE1F 0000000000000000000000 -59
2021.05.17 17:00:37.366 0: HMLAN_Parse: hmlan1 R:E266EA5   stat:0000 t:049A7BFE d:FF r:FFCF     m:4C 805E 266EA5 1ACE1F 0000000000000000000000
2021.05.17 17:00:37.372 0: HMUARTLGW hmuart1 recv: 01 05 00 00 32 msg: 4C 80 5E 266EA5 1ACE1F 0000000000000000000000
2021.05.17 17:00:37.806 0: HMUARTLGW hmuart1 send: 00 08
2021.05.17 17:00:37.811 0: HMUARTLGW hmuart1 recv: 00 040205, state 98
2021.05.17 17:00:37.813 0: HMUARTLGW hmuart1 GetSet Ack: 02, state 98
2021.05.17 17:00:37.813 0: HMUARTLGW hmuart1 roundtrip delay: 0.0036
2021.05.17 17:00:39.176 0: HMUARTLGW hmuart1 send: 01 061C4E25000100
2021.05.17 17:00:39.183 0: HMUARTLGW hmuart1 recv: 01 040701010007FFFFFFFFFFFFFFFF, state 90
2021.05.17 17:00:39.184 0: HMUARTLGW hmuart1 GetSet Ack: 07, state 90
2021.05.17 17:00:39.185 0: HMUARTLGW hmuart1 added peer: 1C4E25, aesChannels: FFFFFFFFFFFFFFFF
2021.05.17 17:00:39.187 0: HMUARTLGW hmuart1 send: 01 061C4E25000100
2021.05.17 17:00:39.194 0: HMUARTLGW hmuart1 recv: 01 040701010007FFFFFFFFFFFFFFFF, state 93
2021.05.17 17:00:39.195 0: HMUARTLGW hmuart1 GetSet Ack: 07, state 93
2021.05.17 17:00:39.196 0: HMUARTLGW hmuart1 added peer: 1C4E25, aesChannels: FFFFFFFFFFFFFFFF


2021.05.17 17:07:52.503 0: HMUARTLGW hmuart1 send: 01 02 00 00 00 msg: D3 A2 58 B5B5B5 1C4E25 0000
2021.05.17 17:07:52.541 0: HMLAN_Parse: hmlan1 R:EB5B5B5   stat:0000 t:04A12022 d:FF r:FFD0     m:D3 A258 B5B5B5 1C4E25 0000
2021.05.17 17:07:52.545 4: CUL_Parse: cul868 A 0B D3 A258 B5B5B5 1C4E25 0000 -22.5
2021.05.17 17:07:52.604 0: HMLAN_Send:  hmlan1 I:K
2021.05.17 17:07:52.608 0: HMLAN_Parse: hmlan1 V:03C5 sNo:JEQ0315335 d:1C671E O:1ACE1F t:04A12072 IDcnt:0017 L:2 %
2021.05.17 17:07:52.659 4: CUL_Parse: cul868 A 0E D3 8102 1C4E25 B5B5B5 0101000049 -89.5
2021.05.17 17:07:52.670 0: HMUARTLGW hmuart1 recv: 01 04 03 00 45 msg: D3 81 02 1C4E25 B5B5B5 0101000049
2021.05.17 17:07:52.674 0: HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:04A120A3 d:FF r:FFC0     m:D3 8102 1C4E25 B5B5B5 0101000049
2021.05.17 17:07:52.767 0: HMUARTLGW hmuart1 send: 01 02 00 00 00 msg: D4 A0 01 1ACE1F 1C4E25 00040000000000
2021.05.17 17:07:52.804 4: CUL_Parse: cul868 A 10 D4 A001 1ACE1F 1C4E25 00040000000000 -22.5
2021.05.17 17:07:52.814 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:04A12134 d:FF r:FFD0     m:D4 A001 1ACE1F 1C4E25 00040000000000
2021.05.17 17:07:53.026 4: CUL_Parse: cul868 A 16 D5 A410 1C4E25 B5B5B5 0400000000000509000A0A0000 -88
2021.05.17 17:07:53.030 0: HMLAN_Send:  hmlan1 I:+1C4E25,00,00,
2021.05.17 17:07:53.127 0: HMLAN_Send:  hmlan1 S:+1C4E25,02,00,00
2021.05.17 17:07:53.128 0: HMLAN_Send:  hmlan1 S:S7ADE82C0 stat:  00 t:00000000 d:01 r:7ADE82C0 m:D5 8002 B5B5B5 1C4E25 00
2021.05.17 17:07:53.169 0: HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:04A12212 d:FF r:FFC0     m:D5 A410 1C4E25 B5B5B5 0400000000000509000A0A0000
2021.05.17 17:07:53.172 0: HMLAN_Parse: hmlan1 R:R7ADE82C0 stat:0002 t:00000000 d:FF r:7FFF     m:D5 8002 B5B5B5 1C4E25 00
2021.05.17 17:07:53.467 4: CUL_Parse: cul868 A 10 D4 A001 1ACE1F 1C4E25 00040000000000 -22.5
2021.05.17 17:07:53.476 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:04A123CA d:FF r:FFCF     m:D4 A001 1ACE1F 1C4E25 00040000000000
2021.05.17 17:07:53.713 0: HMUARTLGW hmuart1 recv: 01 0404, state 100
2021.05.17 17:07:53.715 0: HMUARTLGW hmuart1 can't send due to unknown problem (no response?)
2021.05.17 17:07:54.342 0: HMUARTLGW hmuart1 send: 00 08
2021.05.17 17:07:54.347 0: HMUARTLGW hmuart1 recv: 00 040206, state 98
2021.05.17 17:07:54.349 0: HMUARTLGW hmuart1 GetSet Ack: 02, state 98
2021.05.17 17:07:54.349 0: HMUARTLGW hmuart1 roundtrip delay: 0.0037
2021.05.17 17:07:58.303 0: HMUARTLGW hmuart1 send: 01 061C4E25000000
2021.05.17 17:07:58.337 0: HMUARTLGW hmuart1 recv: 01 0408, state 90
2021.05.17 17:07:58.338 0: HMUARTLGW hmuart1 GetSet Ack: 08, state 90
2021.05.17 17:07:58.841 0: HMUARTLGW hmuart1 send: 01 061C4E25000000
2021.05.17 17:07:58.846 0: HMUARTLGW hmuart1 recv: 01 0408, state 90
2021.05.17 17:07:58.848 0: HMUARTLGW hmuart1 GetSet Ack: 08, state 90
2021.05.17 17:07:59.351 0: HMUARTLGW hmuart1 send: 01 061C4E25000000
2021.05.17 17:07:59.357 0: HMUARTLGW hmuart1 recv: 01 0408, state 90
2021.05.17 17:07:59.359 0: HMUARTLGW hmuart1 GetSet Ack: 08, state 90
2021.05.17 17:07:59.862 0: HMUARTLGW hmuart1 send: 01 061C4E25000000
2021.05.17 17:07:59.867 0: HMUARTLGW hmuart1 recv: 01 0408, state 90
2021.05.17 17:07:59.869 0: HMUARTLGW hmuart1 GetSet Ack: 08, state 90
2021.05.17 17:08:00.371 0: HMUARTLGW hmuart1 send: 01 061C4E25000000
2021.05.17 17:08:00.376 0: HMUARTLGW hmuart1 recv: 01 0408, state 90
2021.05.17 17:08:00.378 0: HMUARTLGW hmuart1 GetSet Ack: 08, state 90
2021.05.17 17:08:00.880 0: HMUARTLGW hmuart1 send: 01 061C4E25000000
2021.05.17 17:08:00.886 0: HMUARTLGW hmuart1 recv: 01 0408, state 90
2021.05.17 17:08:00.887 0: HMUARTLGW hmuart1 GetSet Ack: 08, state 90
2021.05.17 17:08:01.389 0: HMUARTLGW hmuart1 send: 01 061C4E25000000
2021.05.17 17:08:01.395 0: HMUARTLGW hmuart1 recv: 01 0408, state 90
2021.05.17 17:08:01.396 0: HMUARTLGW hmuart1 GetSet Ack: 08, state 90
2021.05.17 17:08:01.899 0: HMUARTLGW hmuart1 send: 01 061C4E25000000
2021.05.17 17:08:01.904 0: HMUARTLGW hmuart1 recv: 01 0408, state 90
2021.05.17 17:08:01.906 0: HMUARTLGW hmuart1 GetSet Ack: 08, state 90
2021.05.17 17:08:02.408 0: HMUARTLGW hmuart1 send: 01 061C4E25000000
2021.05.17 17:08:02.414 0: HMUARTLGW hmuart1 recv: 01 0408, state 90
2021.05.17 17:08:02.415 0: HMUARTLGW hmuart1 GetSet Ack: 08, state 90
2021.05.17 17:08:02.917 0: HMUARTLGW hmuart1 send: 01 061C4E25000000
2021.05.17 17:08:02.923 0: HMUARTLGW hmuart1 recv: 01 0408, state 90
2021.05.17 17:08:02.924 0: HMUARTLGW hmuart1 GetSet Ack: 08, state 90
2021.05.17 17:08:03.426 0: HMUARTLGW hmuart1 send: 01 061C4E25000000
2021.05.17 17:08:03.432 0: HMUARTLGW hmuart1 recv: 01 0408, state 90
2021.05.17 17:08:03.433 0: HMUARTLGW hmuart1 GetSet Ack: 08, state 90
2021.05.17 17:08:03.936 0: HMUARTLGW hmuart1 send: 01 061C4E25000000
2021.05.17 17:08:03.941 0: HMUARTLGW hmuart1 recv: 01 0408, state 90
2021.05.17 17:08:03.943 0: HMUARTLGW hmuart1 GetSet Ack: 08, state 90
2021.05.17 17:08:03.943 0: HMUARTLGW hmuart1 send: 00 03
2021.05.17 17:08:03.948 0: HMUARTLGW hmuart1 recv: 00 0401, state 90
2021.05.17 17:08:03.949 0: HMUARTLGW hmuart1 GetSet Ack: 01, state 90
2021.05.17 17:08:03.950 1: HMUARTLGW hmuart1 Adding peer 1C4E25 failed! You have probably forced an unknown aesKey for this device.
2021.05.17 17:08:04.977 0: HMUARTLGW hmuart1 recv: 00 00436F5F4350555F424C, state 99
2021.05.17 17:08:04.978 1: HMUARTLGW hmuart1 unexpected info about Co_CPU_BL received (module crashed?), reopening
2021.05.17 17:08:04.980 3: hmuart1 device closed


2021.05.17 17:08:07.805 0: HMUARTLGW hmuart1 send: 01 061C4E25000000
2021.05.17 17:08:07.811 0: HMUARTLGW hmuart1 recv: 01 040701010006FFFFFFFFFFFFFFFF, state 90
2021.05.17 17:08:07.813 0: HMUARTLGW hmuart1 GetSet Ack: 07, state 90
2021.05.17 17:08:07.813 0: HMUARTLGW hmuart1 added peer: 1C4E25, aesChannels: FFFFFFFFFFFFFFFF
2021.05.17 17:08:07.816 0: HMUARTLGW hmuart1 send: 01 061C4E25000000
2021.05.17 17:08:07.822 0: HMUARTLGW hmuart1 recv: 01 040701010006FFFFFFFFFFFFFFFF, state 93
2021.05.17 17:08:07.823 0: HMUARTLGW hmuart1 GetSet Ack: 07, state 93
2021.05.17 17:08:07.824 0: HMUARTLGW hmuart1 added peer: 1C4E25, aesChannels: FFFFFFFFFFFFFFFF

2021.05.17 17:08:39.588 2: HMinfo hminfo get:configCheck :-f,^(Ventil.AZ.Nord|Ventil.AZ.Nord)$

2021.05.17 17:16:14.605 0: HMUARTLGW hmuart1 send: 01 02 00 00 00 msg: D6 A2 58 B5B5B5 1C4E25 0000
2021.05.17 17:16:14.647 0: HMLAN_Parse: hmlan1 R:EB5B5B5   stat:0000 t:04A8C9BB d:FF r:FFCF     m:D6 A258 B5B5B5 1C4E25 0000
2021.05.17 17:16:14.652 4: CUL_Parse: cul868 A 0B D6 A258 B5B5B5 1C4E25 0000 -22.5
2021.05.17 17:16:14.763 4: CUL_Parse: cul868 A 0E D6 8202 1C4E25 B5B5B5 0101000049 -93.5
2021.05.17 17:16:14.829 0: HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:04A8CA3D d:FF r:FFC1     m:D6 8202 1C4E25 B5B5B5 0101000049
2021.05.17 17:16:14.835 0: HMUARTLGW hmuart1 recv: 01 04 03 00 45 msg: D6 82 02 1C4E25 B5B5B5 0101000049
2021.05.17 17:16:14.883 4: CUL_Parse: cul868 A 09 D6 A112 1ACE1F 1C4E25  -42
2021.05.17 17:16:14.888 0: HMUARTLGW hmuart1 recv: 01 05 00 00 2D msg: D6 A1 12 1ACE1F 1C4E25
2021.05.17 17:16:15.008 4: CUL_Parse: cul868 A 0A D6 8002 1C4E25 1ACE1F 00 -91
2021.05.17 17:16:15.014 0: HMUARTLGW hmuart1 recv: 01 05 01 00 45 msg: D6 80 02 1C4E25 1ACE1F 00
2021.05.17 17:16:15.018 0: HMLAN_Parse: hmlan1 R:R7ADE82C0 stat:0081 t:04A8CB37 d:FF r:FFC1     m:D6 8002 1C4E25 1ACE1F 00

2021.05.17 17:23:30.957 0: HMUARTLGW hmuart1 send: 01 02 00 00 00 msg: D9 A2 58 B5B5B5 1C4E25 0000
2021.05.17 17:23:30.994 4: CUL_Parse: cul868 A 0B D9 A258 B5B5B5 1C4E25 0000 -22.5
2021.05.17 17:23:30.999 0: HMLAN_Parse: hmlan1 R:EB5B5B5   stat:0000 t:04AF7273 d:FF r:FFD0     m:D9 A258 B5B5B5 1C4E25 0000
2021.05.17 17:23:31.112 4: CUL_Parse: cul868 A 0E D9 8202 1C4E25 B5B5B5 0101000048 -98
2021.05.17 17:23:31.151 0: HMUARTLGW hmuart1 recv: 01 04 03 00 45 msg: D9 82 02 1C4E25 B5B5B5 0101000048
2021.05.17 17:23:31.155 0: HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:04AF72F4 d:FF r:FFC0     m:D9 8202 1C4E25 B5B5B5 0101000048
2021.05.17 17:23:31.231 4: CUL_Parse: cul868 A 09 D9 A112 1ACE1F 1C4E25  -42
2021.05.17 17:23:31.236 0: HMUARTLGW hmuart1 recv: 01 05 00 00 2C msg: D9 A1 12 1ACE1F 1C4E25
2021.05.17 17:23:31.360 0: HMUARTLGW hmuart1 recv: 01 05 01 00 45 msg: D9 80 02 1C4E25 1ACE1F 00
2021.05.17 17:23:31.366 0: HMLAN_Parse: hmlan1 R:R7ADE82C0 stat:0081 t:04AF73EE d:FF r:FFC0     m:D9 8002 1C4E25 1ACE1F 00

2021.05.17 17:30:45.560 0: HMUARTLGW hmuart1 send: 01 02 00 00 00 msg: DC A2 58 B5B5B5 1C4E25 0000
2021.05.17 17:30:45.609 4: CUL_Parse: cul868 A 0B DC A258 B5B5B5 1C4E25 0000 -22.5
2021.05.17 17:30:45.616 0: HMLAN_Parse: hmlan1 R:EB5B5B5   stat:0000 t:04B61459 d:FF r:FFD0     m:DC A258 B5B5B5 1C4E25 0000
2021.05.17 17:30:45.722 0: HMUARTLGW hmuart1 recv: 01 04 03 00 45 msg: DC 82 02 1C4E25 B5B5B5 0101000048
2021.05.17 17:30:45.761 0: HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:04B614DA d:FF r:FFC0     m:DC 8202 1C4E25 B5B5B5 0101000048
2021.05.17 17:30:45.837 4: CUL_Parse: cul868 A 09 DC A112 1ACE1F 1C4E25  -42
2021.05.17 17:30:45.843 0: HMUARTLGW hmuart1 recv: 01 05 00 00 2C msg: DC A1 12 1ACE1F 1C4E25
2021.05.17 17:30:45.962 4: CUL_Parse: cul868 A 0A DC 8002 1C4E25 1ACE1F 00 -99
2021.05.17 17:30:45.968 0: HMUARTLGW hmuart1 recv: 01 05 01 00 45 msg: DC 80 02 1C4E25 1ACE1F 00
2021.05.17 17:30:45.971 0: HMLAN_Parse: hmlan1 R:R7ADE82C0 stat:0081 t:04B615D4 d:FF r:FFC0     m:DC 8002 1C4E25 1ACE1F 00

2021.05.17 17:33:45.509 0: HMUARTLGW hmuart1 send: 01 02 00 00 00 msg: DD A2 58 B5B5B5 1C4E25 0300
2021.05.17 17:33:45.542 4: CUL_Parse: cul868 A 0B DD A258 B5B5B5 1C4E25 0300 -22.5
2021.05.17 17:33:45.546 0: HMLAN_Parse: hmlan1 R:EB5B5B5   stat:0000 t:04B8D35C d:FF r:FFD0     m:DD A258 B5B5B5 1C4E25 0300
2021.05.17 17:33:45.665 4: CUL_Parse: cul868 A 0E DD 8202 1C4E25 B5B5B5 0101000048 -99
2021.05.17 17:33:45.705 0: HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:04B8D3DD d:FF r:FFC0     m:DD 8202 1C4E25 B5B5B5 0101000048
2021.05.17 17:33:45.709 0: HMUARTLGW hmuart1 recv: 01 04 03 00 45 msg: DD 82 02 1C4E25 B5B5B5 0101000048
2021.05.17 17:33:45.784 4: CUL_Parse: cul868 A 09 DD A112 1ACE1F 1C4E25  -42
2021.05.17 17:33:45.789 0: HMUARTLGW hmuart1 recv: 01 05 00 00 2C msg: DD A1 12 1ACE1F 1C4E25
2021.05.17 17:33:45.909 4: CUL_Parse: cul868 A 0A DD 8002 1C4E25 1ACE1F 00 -95.5
2021.05.17 17:33:45.915 0: HMUARTLGW hmuart1 recv: 01 05 01 00 44 msg: DD 80 02 1C4E25 1ACE1F 00
2021.05.17 17:33:45.918 0: HMLAN_Parse: hmlan1 R:R7ADE82C0 stat:0081 t:04B8D4D7 d:FF r:FFC1     m:DD 8002 1C4E25 1ACE1F 00

2021.05.17 17:38:39.625 0: HMUARTLGW hmuart1 send: 01 061C4E25000100
2021.05.17 17:38:39.631 0: HMUARTLGW hmuart1 recv: 01 040701010007FFFFFFFFFFFFFFFF, state 90
2021.05.17 17:38:39.633 0: HMUARTLGW hmuart1 GetSet Ack: 07, state 90
2021.05.17 17:38:39.633 0: HMUARTLGW hmuart1 added peer: 1C4E25, aesChannels: FFFFFFFFFFFFFFFF
2021.05.17 17:38:39.636 0: HMUARTLGW hmuart1 send: 01 061C4E25000100
2021.05.17 17:38:39.642 0: HMUARTLGW hmuart1 recv: 01 040701010007FFFFFFFFFFFFFFFF, state 93
2021.05.17 17:38:39.643 0: HMUARTLGW hmuart1 GetSet Ack: 07, state 93
2021.05.17 17:38:39.644 0: HMUARTLGW hmuart1 added peer: 1C4E25, aesChannels: FFFFFFFFFFFFFFFF

2021.05.17 17:41:18.864 0: HMUARTLGW hmuart1 send: 01 02 00 00 00 msg: E0 A2 58 B5B5B5 1C4E25 0000
2021.05.17 17:41:18.916 0: HMLAN_Parse: hmlan1 R:EB5B5B5   stat:0000 t:04BFBE86 d:FF r:FFD0     m:E0 A258 B5B5B5 1C4E25 0000
2021.05.17 17:41:18.922 4: CUL_Parse: cul868 A 0B E0 A258 B5B5B5 1C4E25 0000 -22.5
2021.05.17 17:41:19.021 4: CUL_Parse: cul868 A 0E E0 8202 1C4E25 B5B5B5 0101000049 -96
2021.05.17 17:41:19.025 3: CUL_HM set Ventil.AZ.Nord getConfig noArg
2021.05.17 17:41:19.067 0: HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:04BFBF07 d:FF r:FFC1     m:E0 8202 1C4E25 B5B5B5 0101000049
2021.05.17 17:41:19.072 0: HMUARTLGW hmuart1 recv: 01 04 03 00 46 msg: E0 82 02 1C4E25 B5B5B5 0101000049
2021.05.17 17:41:19.075 0: HMUARTLGW hmuart1 send: 01 061C4E25000000
2021.05.17 17:41:19.081 0: HMUARTLGW hmuart1 recv: 01 040701010007FFFFFFFFFFFFFFFF, state 90
2021.05.17 17:41:19.083 0: HMUARTLGW hmuart1 GetSet Ack: 07, state 90
2021.05.17 17:41:19.083 0: HMUARTLGW hmuart1 added peer: 1C4E25, aesChannels: FFFFFFFFFFFFFFFF
2021.05.17 17:41:19.086 0: HMUARTLGW hmuart1 send: 01 061C4E25000000
2021.05.17 17:41:19.093 0: HMUARTLGW hmuart1 recv: 01 040701010007FFFFFFFFFFFFFFFF, state 93
2021.05.17 17:41:19.094 0: HMUARTLGW hmuart1 GetSet Ack: 07, state 93
2021.05.17 17:41:19.095 0: HMUARTLGW hmuart1 added peer: 1C4E25, aesChannels: FFFFFFFFFFFFFFFF
2021.05.17 17:41:19.140 4: CUL_Parse: cul868 A 09 E0 A112 1ACE1F 1C4E25  -41.5
2021.05.17 17:41:19.146 0: HMUARTLGW hmuart1 recv: 01 05 00 00 2C msg: E0 A1 12 1ACE1F 1C4E25
2021.05.17 17:41:19.169 0: HMUARTLGW hmuart1 send: 01 02 00 00 00 msg: E1 A0 01 1ACE1F 1C4E25 00040000000000
2021.05.17 17:41:19.266 4: CUL_Parse: cul868 A 0A E0 8002 1C4E25 1ACE1F 00 -95.5
2021.05.17 17:41:19.272 0: HMUARTLGW hmuart1 recv: 01 05 01 00 46 msg: E0 80 02 1C4E25 1ACE1F 00
2021.05.17 17:41:19.276 0: HMLAN_Parse: hmlan1 R:R7AF6D4B4 stat:0081 t:04BFC001 d:FF r:FFC1     m:E0 8002 1C4E25 1ACE1F 00
2021.05.17 17:41:19.293 4: CUL_Parse: cul868 A 10 E1 A001 1ACE1F 1C4E25 00040000000000 -22.5
2021.05.17 17:41:19.421 4: CUL_Parse: cul868 A 14 E1 8010 1C4E25 1ACE1F 0202010A1A0BCE0C1F0000 -92.5
2021.05.17 17:41:19.432 0: HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:04BFC096 d:FF r:FFC1     m:E1 8010 1C4E25 1ACE1F 0202010A1A0BCE0C1F0000
2021.05.17 17:41:19.436 0: HMUARTLGW hmuart1 recv: 01 0402, state 100
2021.05.17 17:41:19.437 0: HMUARTLGW hmuart1 Ack: 02
2021.05.17 17:41:19.439 0: HMUARTLGW hmuart1 recv: 01 05 01 00 46 msg: E1 80 10 1C4E25 1ACE1F 0202010A1A0BCE0C1F0000
2021.05.17 17:41:19.522 0: HMUARTLGW hmuart1 send: 01 02 00 00 00 msg: F1 A0 01 1ACE1F 1C4E25 0103
2021.05.17 17:41:19.566 4: CUL_Parse: cul868 A 0B F1 A001 1ACE1F 1C4E25 0103 -22.5
2021.05.17 17:41:19.576 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:04BFC128 d:FF r:FFD0     m:F1 A001 1ACE1F 1C4E25 0103
2021.05.17 17:41:19.697 4: CUL_Parse: cul868 A 13 F1 8010 1C4E25 1ACE1F 01B5B5B501000000005C -95
2021.05.17 17:41:19.711 0: HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:04BFC1AA d:FF r:FFC1     m:F1 8010 1C4E25 1ACE1F 01B5B5B501000000005C
2021.05.17 17:41:19.714 0: HMUARTLGW hmuart1 recv: 01 0402, state 100
2021.05.17 17:41:19.715 0: HMUARTLGW hmuart1 Ack: 02
2021.05.17 17:41:19.716 0: HMUARTLGW hmuart1 send: 00 08
2021.05.17 17:41:19.719 0: HMUARTLGW hmuart1 recv: 01 05 01 00 46 msg: F1 80 10 1C4E25 1ACE1F 01B5B5B501000000005C
2021.05.17 17:41:19.723 0: HMUARTLGW hmuart1 recv: 00 040205, state 98
2021.05.17 17:41:19.724 0: HMUARTLGW hmuart1 GetSet Ack: 02, state 98
2021.05.17 17:41:19.812 0: HMUARTLGW hmuart1 send: 01 02 00 00 00 msg: 01 A0 01 1ACE1F 1C4E25 01040000000005
2021.05.17 17:41:19.847 4: CUL_Parse: cul868 A 10 01 A001 1ACE1F 1C4E25 01040000000005 -22.5
2021.05.17 17:41:19.858 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:04BFC242 d:FF r:FFD0     m:01 A001 1ACE1F 1C4E25 01040000000005
2021.05.17 17:41:19.972 4: CUL_Parse: cul868 A 10 01 8010 1C4E25 1ACE1F 0209000A0A0000 -97
2021.05.17 17:41:20.018 0: HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:04BFC2BE d:FF r:FFC0     m:01 8010 1C4E25 1ACE1F 0209000A0A0000
2021.05.17 17:41:20.022 0: HMUARTLGW hmuart1 recv: 01 0402, state 100
2021.05.17 17:41:20.023 0: HMUARTLGW hmuart1 Ack: 02
2021.05.17 17:41:20.024 0: HMUARTLGW hmuart1 recv: 01 05 01 00 46 msg: 01 80 10 1C4E25 1ACE1F 0209000A0A0000

2021.05.17 17:42:19.989 2: HMinfo hminfo get:configCheck :-f,^(Ventil.AZ.Nord|Ventil.AZ.Nord)$

2021.05.17 17:48:50.465 0: HMUARTLGW hmuart1 send: 01 02 00 00 00 msg: E3 A2 58 B5B5B5 1C4E25 0000
2021.05.17 17:48:50.514 0: HMLAN_Parse: hmlan1 R:EB5B5B5   stat:0000 t:04C6A2D3 d:FF r:FFD0     m:E3 A258 B5B5B5 1C4E25 0000
2021.05.17 17:48:50.798 4: CUL_Parse: cul868 A 0B E3 A258 B5B5B5 1C4E25 0000 -22.5
2021.05.17 17:48:50.801 4: CUL_Parse: cul868 A 0E E3 8202 1C4E25 B5B5B5 0101000049 -97
2021.05.17 17:48:50.837 4: CUL_Parse: cul868 A 09 E3 A112 1ACE1F 1C4E25  -42
2021.05.17 17:48:50.842 0: HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:04C6A355 d:FF r:FFC0     m:E3 8202 1C4E25 B5B5B5 0101000049
2021.05.17 17:48:50.846 0: HMUARTLGW hmuart1 recv: 01 04 03 00 46 msg: E3 82 02 1C4E25 B5B5B5 0101000049
2021.05.17 17:48:50.850 0: HMUARTLGW hmuart1 recv: 01 05 00 00 2C msg: E3 A1 12 1ACE1F 1C4E25
2021.05.17 17:48:50.867 4: CUL_Parse: cul868 A 0A E3 8002 1C4E25 1ACE1F 00 -95
2021.05.17 17:48:50.873 0: HMUARTLGW hmuart1 recv: 01 05 01 00 46 msg: E3 80 02 1C4E25 1ACE1F 00
2021.05.17 17:48:50.876 0: HMLAN_Parse: hmlan1 R:R7AF6D4B4 stat:0081 t:04C6A44E d:FF r:FFC0     m:E3 8002 1C4E25 1ACE1F 00


Internals:
   DEF        1C4E25
   FUUID      5c4ce2e9-f33f-09c4-f092-82004d6255d7f361
   IODev      hmuart1
   LASTInputDev hmlan1
   MSGCNT     405
   NAME       Ventil.AZ.Nord
   NOTIFYDEV  global
   NR         281
   NTFY_ORDER 50-Ventil.AZ.Nord
   STATE      Vsoll:76 %, Vist:76, Status:76, Operation:onTarget, OpErr:1, Mot:stop, MotErr:ok, Bat:ok, Verr:10 %, Voff:0 %
   TYPE       CUL_HM
   chanNo     01
   cul868_MSGCNT 131
   cul868_RAWMSG A0A3380021C4E251ACE1F00::-87:cul868
   cul868_RSSI -87
   cul868_TIME 2021-05-18 09:52:24
   hmlan1_MSGCNT 137
   hmlan1_RAWMSG R7E50B588,0081,0838EA51,FF,FFC0,3380021C4E251ACE1F00
   hmlan1_RSSI -64
   hmlan1_TIME 2021-05-18 09:52:24
   hmuart1_MSGCNT 137
   hmuart1_RAWMSG 050100453380021C4E251ACE1F00
   hmuart1_RSSI -69
   hmuart1_TIME 2021-05-18 09:52:24
   lastMsg    No:33 - t:02 s:1C4E25 d:1ACE1F 00
   peerList   VentilControler.AZ.Nord_Btn1
   protCmdDel 0
   protLastRcv 2021-05-18 09:52:24
   protRcv    137 last_at:2021-05-18 09:52:24
   protResndFail 28 last_at:2021-05-18 09:11:55
   protSnd    97 last_at:2021-05-18 09:52:23
   protState  CMDs_done
   rssi_at_cul868 cnt:131 min:-94 max:-81.5 avg:-84.59 lst:-87
   rssi_at_hmlan1 cnt:137 min:-65 max:-63 avg:-63.77 lst:-64
   rssi_at_hmuart1 cnt:137 min:-72 max:-67 avg:-68.67 lst:-69
   rssi_hmuart1 cnt:69 min:-75 max:-71 avg:-72.28 lst:-73
   .attraggr:
   .attreocr:
     .*
   .attrminint:
   .attrtocr:
     battery
     motorErr
   CL:
     Authenticated 0
     BUF       
     FD         90
     FW_ID      8001
     LASTACCESS 1621324368
     NAME       WEB_192.168.1.31_49614
     NR         8005
     PEER       192.168.1.31
     PORT       49614
     SNAME      WEB
     SSL       
     STATE      Connected
     TEMPORARY  1
     TYPE       FHEMWEB
     canAsyncOutput 1
     .attraggr:
     .attrminint:
     READINGS:
       2021-05-18 09:52:43   state           Connected
   READINGS:
     from archivexx        .D-devInfo      010100
     from archivexx        .D-stc          58
     2021-05-17 23:17:33   .associatedWith Ventil.AZ.Nord,Ventil.AZ.Nord,VentilControler.AZ.Nord_Btn1
     2021-05-17 17:41:19   .peerListRDate  2021-05-17 17:41:19
     2021-05-18 09:52:24   .protLastRcv    20210518095224
     2021-05-18 02:53:44   Activity        alive
     2021-05-18 09:52:24   CommandAccepted yes
     from archivexx        D-firmware      2.0
     from archivexx        D-serialNr      JEQ0312631
     2021-05-17 23:17:33   IODev           hmuart1
     2021-05-17 17:41:19   PairedTo        0x1ACE1F
     2021-05-17 13:06:09   R-pairCentral   0x1ACE1F
     2021-05-17 17:41:19   R-valveErrorPos 10 %
     2021-05-17 13:06:09   R-valveOffset   0 %
     2021-05-17 17:41:19   RegL_00.        00:00 02:01 0A:1A 0B:CE 0C:1F
     2021-05-17 17:41:19   RegL_05.        00:00 09:00 0A:0A
     2021-05-18 09:51:30   ValveDesired    76 %
     2021-05-18 09:52:23   ValvePosition   76
     2021-05-13 17:53:25   battery         ok
     2021-05-17 23:17:40   cfgState        ok
     2021-05-18 09:52:23   commState       CMDs_done
     2021-05-18 09:52:23   motor           stop
     2021-05-13 17:53:25   motorErr        ok
     2021-05-18 09:52:23   operState       onTarget
     2021-05-18 02:52:53   operStateErrCnt 1
     2021-05-17 23:17:33   peerList        VentilControler.AZ.Nord_Btn1
     2021-05-18 09:52:23   recentStateType ack
     2021-05-18 09:52:23   state           76
   helper:
     HM_CMDNR   51
     lastMsgTm  1621324344.21199
     mId        003A
     oldDes     76
     peerFriend
     peerIDsState complete
     peerOpt    p:thermostat
     regLst     0,5
     rxType     12
     supp_Pair_Rep 0
     tmplChg    0
     cmds:
       TmplKey    VentilControler.AZ.Nord_Btn1:1621286258.89639:1621286259.22754
       TmplTs     1621286259.22754
       cmdKey     1:1:0::Ventil.AZ.Nord:003A:01:VentilControler.AZ.Nord_Btn1
       cmdLst:
         assignHmKey noArg
         clear      [(readings|trigger|register|oldRegs|rssi|msgEvents|{msgErrors}|attack|all)]
         deviceRename -newName-
         fwUpdate   -filename- [-bootTime-]
         getConfig  noArg
         getDevInfo noArg
         getRegRaw  (List0|List1|List2|List3|List4|List5|List6|List7) [-peerChn-]
         peerBulk   -peer1,peer2,...- [({set}|unset)]
         peerSmart  -peerOpt-
         raw        -data- [...]
         regBulk    -list-.-peerChn- -addr1:data1- -addr2:data2-...
         regSet     [(prep|{exec})] -regName- -value- [-peerChn-]
         reset      noArg
         tplDel     -tplDel-
         tplSet_0   -tplChan-
         tplSet_VentilControler.AZ.Nord_Btn1 -tplPeer-
         unpair     noArg
         valvePos   [({off}|0.0..99.0;0.5)]
       lst:
         condition  slider,0,1,255
         peer       VentilControler.AZ.Nord_Btn1
         peerOpt    remove_VentilControler.AZ.Nord_Btn1
         tplChan   
         tplDel     
         tplPeer   
       rtrvLst:
         cmdList    [({short}|long)]
         deviceInfo [({short}|long)]
         list       [({normal}|full)]
         param      -param-
         reg        -addr- -list- [-peerChn-]
         regList    noArg
         regTable   noArg
         regVal     -addr- -list- [-peerChn-]
         saveConfig [-filename-]
         tplInfo    noArg
     expert:
       def        1
       det        1
       raw        1
       tpl        1
     io:
       flgs       0
       newChn     +1C4E25,00,00,00
       nextSend   1621324344.31562
       rxt        2
       vccu       ccu
       p:
         1C4E25
         00
         00
         00
       prefIO:
         hmuart1
     mRssi:
       mNo        33
       io:
         cul868:
           -87
           -87
         hmlan1:
           -64
           -64
         hmuart1:
           -65
           -65
         hmusb1:
     peerIDsH:
       00000000   broadcast
       B5B5B501   VentilControler.AZ.Nord_Btn1
     prt:
       bErr       0
       sProc      0
       rspWait:
     q:
       qReqConf   
       qReqStat   
     role:
       chn        1
       dev        1
     rssi:
       at_cul868:
         avg        -84.5954198473282
         cnt        131
         lst        -87
         max        -81.5
         min        -94
       at_hmlan1:
         avg        -63.7737226277372
         cnt        137
         lst        -64
         max        -63
         min        -65
       at_hmuart1:
         avg        -68.6715328467154
         cnt        137
         lst        -69
         max        -67
         min        -72
       hmuart1:
         avg        -72.2898550724638
         cnt        69
         lst        -73
         max        -71
         min        -75
     shadowReg:
     tmpl:
Attributes:
   .mId       003A
   IODev      hmuart1
   IOgrp      ccu:hmuart1
   actCycle   001:30
   actStatus  alive
   alias      40. Ventil.AZ.Nord
   autoReadReg 5_readMissing
   comment    batChange: 2021-03-03 09:28:25 critical (oldBat: low since 2020-12-18 16:26:27)
   event-on-change-reading .*
   expert     defReg,allReg,rawReg,templ
   firmware   2.0
   group      Heizung.AZ
   model      HM-CC-VD
   msgRepeat  0
   peerIDs    00000000,B5B5B501
   room       20_AZ,98_Ventile
   serialNr   JEQ0312631
   stateFormat Vsoll:ValveDesired, Vist:ValvePosition, Status:state, Operation:operState, OpErr:operStateErrCnt, Mot:motor, MotErr:motorErr, Bat:battery, Verr:R-valveErrorPos, Voff:R-valveOffset
   subType    thermostat
   timestamp-on-change-reading battery,motorErr
   webCmd     getConfig


Internals:
   DEF        B5B5B5
   FUUID      5c4ce2e9-f33f-09c4-41e8-f94c9a0ee1c747e2
   IODev      hmlan1
   LASTInputDev cul868
   MSGCNT     320
   NAME       VentilControler.AZ.Nord
   NOTIFYDEV  global
   NR         282
   NTFY_ORDER 50-VentilControler.AZ.Nord
   STATE      CMDs_done
   TYPE       CUL_HM
   channel_01 VentilControler.AZ.Nord_Btn1
   cul868_MSGCNT 160
   cul868_RAWMSG A0B41A258B5B5B51C4E2503C5::-22.5:cul868
   cul868_RSSI -22.5
   cul868_TIME 2021-05-18 10:27:41
   hmlan1_MSGCNT 160
   hmlan1_RAWMSG EB5B5B5,0000,085937E6,FF,FFD1,41A258B5B5B51C4E2503C5
   hmlan1_RSSI -47
   hmlan1_TIME 2021-05-18 10:27:41
   lastMsg    No:41 - t:58 s:B5B5B5 d:1C4E25 03C5
   protLastRcv 2021-05-18 10:27:41
   protRcv    104 last_at:2021-05-18 10:27:41
   rssi_at_cul868 cnt:160 min:-22.5 max:-22.5 avg:-22.5 lst:-22.5
   rssi_at_hmlan1 cnt:160 min:-48 max:-46 avg:-46.89 lst:-47
   .attreour:
     state
   .attrminint:
   CL:
     Authenticated 0
     BUF       
     FD         85
     FW_ID      8471
     LASTACCESS 1621326466
     NAME       WEB_192.168.1.31_49742
     NR         8471
     PEER       192.168.1.31
     PORT       49742
     SNAME      WEB
     SSL       
     STATE      Connected
     TEMPORARY  1
     TYPE       FHEMWEB
     canAsyncOutput 1
     .attraggr:
     .attrminint:
     READINGS:
       2021-05-18 10:26:01   state           Connected
   READINGS:
     2021-05-18 10:27:41   .protLastRcv    20210518102741
     2021-05-17 23:17:29   IODev           hmlan1
     2021-05-17 23:17:40   cfgState        ok
     2021-05-17 17:07:53   commState       CMDs_done
     2021-05-17 17:07:53   state           CMDs_done
   helper:
     HM_CMDNR   65
     lastMsgTm  1621326461.0193
     mId        FFF1
     peerFriend -
     peerOpt    -:virtual
     regLst     0
     rxType     1
     supp_Pair_Rep 0
     ack:
     cmds:
       TmplKey    :1621286258.89639:1621286259.22783
       TmplTs     1621286259.22783
       cmdKey     0:1:1::VentilControler.AZ.Nord:FFF1:00:
       cmdLst:
         assignHmKey noArg
         clear      [(readings|rssi|msgEvents|attack|{msgErrors}|unknownDev)]
         deviceRename -newName-
         fwUpdate   -filename- [-bootTime-]
         getDevInfo noArg
         raw        -data- [...]
         reset      noArg
         unpair     noArg
         virtual    [(1..50;1|{1})]
       lst:
         condition  slider,0,1,255
         peer       
         peerOpt   
         tplChan   
         tplDel     
         tplPeer   
       rtrvLst:
         cmdList    [({short}|long)]
         deviceInfo [({short}|long)]
         list       [({normal}|full)]
         param      -param-
     expert:
       def        1
       det        0
       raw        1
       tpl        0
     io:
       nextSend   1621326461.12392
       vccu       ccu
       prefIO:
         hmlan1
     mRssi:
       mNo        41
       io:
         cul868:
           -22.5
           -22.5
         hmlan1:
           -39
           -39
     peerIDsH:
     prt:
       bErr       0
       sProc      0
       rspWait:
     q:
       qReqConf   
       qReqStat   
     role:
       dev        1
       vrt        1
     rssi:
       at_cul868:
         avg        -22.5
         cnt        160
         lst        -22.5
         max        -22.5
         min        -22.5
       at_hmlan1:
         avg        -46.89375
         cnt        160
         lst        -47
         max        -46
         min        -48
     shadowReg:
     tmpl:
Attributes:
   .mId       FFF1
   IODev      hmlan1
   IOgrp      ccu:hmlan1
   event-on-update-reading state
   expert     defReg,rawReg
   group      Heizung.AZ
   model      VIRTUAL
   msgRepeat  0
   room       20_AZ
   subType    virtual
   webCmd     press short:press long


Internals:
   .triggerUsed 1
   DEF        B5B5B501
   FUUID      5c4ce2e9-f33f-09c4-f9b9-f192af5a6a6260d0
   NAME       VentilControler.AZ.Nord_Btn1
   NOTIFYDEV  global
   NR         283
   NTFY_ORDER 50-VentilControler.AZ.Nord_Btn1
   STATE      Vsoll: 78 %, Status: ValveAdjust:78 %, Kommunikation: ok, Error (tot/lost/avg): 19 / 1 / 4.0, Modus: msgReduce:2
   TYPE       CUL_HM
   chanNo     01
   device     VentilControler.AZ.Nord
   peerList   Ventil.AZ.Nord
   .attraggr:
   .attreocr:
     .*
   .attreour:
     state
     valvePosTC
   .attrminint:
   .userReadings:
     HASH(0x4ab0020)
     HASH(0x4ac22c8)
   CL:
     Authenticated 0
     BUF       
     FD         85
     FW_ID      8470
     LASTACCESS 1621326370
     NAME       WEB_192.168.1.31_49742
     NR         8471
     PEER       192.168.1.31
     PORT       49742
     SNAME      WEB
     SSL       
     STATE      Connected
     TEMPORARY  1
     TYPE       FHEMWEB
     canAsyncOutput 1
     .attraggr:
     .attrminint:
     READINGS:
       2021-05-18 10:26:01   state           Connected
   READINGS:
     2021-05-17 23:17:33   .associatedWith VentilControler.AZ.Nord,VentilControler.AZ.Nord_Btn1,VentilControler.AZ.Nord,Ventil.AZ.Nord
     2021-05-18 10:25:44   .next           64;1621326460.86482
     2021-05-17 23:17:40   cfgState        ok
     2021-05-17 17:07:53   commState       CMDs_done
     2021-05-13 17:53:25   ctrStart        2021-05-13 17:53:25
     2021-05-18 10:17:32   errorAvg        4.0
     2021-05-18 09:11:59   errorCtr        19
     2021-05-18 09:17:05   errorState      ok
     2021-05-18 01:56:58   lostCtr         1
     2021-05-18 10:17:32   msgReduce       msgReduce:2
     2021-05-17 23:17:33   peerList        Ventil.AZ.Nord
     2021-05-18 10:17:32   state           ValveAdjust:78 %
     2021-05-18 09:17:05   valveCtrl       ok
     2021-05-18 09:17:05   valveCtrlRam    ok
     2021-05-18 10:17:32   valvePosTC      78 %
   helper:
     fkt        vdCtrl
     peerFriend peerSD,peerSens,peerAct
     peerIDsState incomplete
     peerOpt    -:virtual
     regLst     
     virtTC     00
     cmds:
       TmplKey    Ventil.AZ.Nord:1621286258.89639:1621286259.22786
       TmplTs     1621286259.22786
       cmdKey     1:0:1:vdCtrl:VentilControler.AZ.Nord:FFF1:01:Ventil.AZ.Nord
       cmdLst:
         peerChan   -btnNumber- -actChn- [({single}|dual|reverse)] [({set}|unset)] [(actor|remote|{both})]
         peerSmart  -peerOpt-
         postEvent  -condition-
         press      [(long|{short})] [(-peer-|{all})] [(noBurst|{Burst})] [(-repCount-|{0})] [(-repDelay-|{0.25})]
         pressL     [(-peer-|{all})]
         pressS     [(-peer-|{all})]
         tplSet_0   -tplChan-
         tplSet_Ventil.AZ.Nord -tplPeer-
         valvePos   (off|0.0..99.0;0.1)
       lst:
         condition  slider,0,1,255
         peer       Ventil.AZ.Nord
         peerOpt    DimPBU01_Dim,DimPBU01_Dim_V_01,DimPBU01_Dim_V_02,DimUP01,Fenster.Bad,SD.AZ,SD.SZ,SD.WZ,SDTeam_Btn1,SwitchES01_SenF,SwitchES01_SenI,SwitchES01_SenPwr,SwitchES01_SenU,SwitchES01_Sw,SwitchPBU01_Btn_01,SwitchPBU01_Btn_02,SwitchPBU01_Sw_01,SwitchPBU01_Sw_02,SwitchPBU02_Btn_01,SwitchPBU02_Btn_02,SwitchPBU02_Sw_01,SwitchPBU02_Sw_02,SwitchPBU03,SwitchPBU05,SwitchPBU06,SwitchUP01,SwitchUP02,Tuer.SZ,Tuer.WZ.Terrasse,VentilControler.AZ.West_Btn1,VentilControler.Bad_Btn1,VentilControler.Kueche_Btn1,VentilControler.SZ_Btn1,VentilControler.WZ_Btn1,ccu_Btn1,rssi_hmuart_Btn1,virtAktorAlarmOff_Btn1
         tplChan   
         tplDel     
         tplPeer   
       rtrvLst:
         cmdList    [({short}|long)]
         deviceInfo [({short}|long)]
         list       [({normal}|full)]
         param      -param-
     expert:
       def        1
       det        0
       raw        1
       tpl        0
     peerIDsH:
       1C4E2501   Ventil.AZ.Nord_chn-01
     role:
       chn        1
       vrt        1
     shadowReg:
     tmpl:
     vd:
       ackT       2021-05-18 10:25:35
       cmd        A258B5B5B51C4E25
       id         1C4E25
       idh        3633937
       idl        46336
       miss       0
       msgCnt     64
       msgRed     2
       msgSent    0
       nDev       Ventil.AZ.Nord
       next       1621326460.86482
       nextM      1621326460.86482
       typ        1
       val        C7
       vin        78
       virtTC     00
Attributes:
   alias      30. Controler.AZ.Nord
   event-on-change-reading .*
   event-on-update-reading state,valvePosTC
   group      Heizung.AZ
   model      VIRTUAL
   param      msgReduce:2
   peerIDs    1C4E2501
   room       20_AZ,98_Ventile
   stateFormat Vsoll: valvePosTC, Status: state, Kommunikation: valveCtrl, Error (tot/lost/avg): errorCtr / lostCtr / errorAvg, Modus: msgReduce
   userReadings msgReduce:valvePosTC.* {AttrVal($name,"param","???")},
errorAvg:(valvePosTC|errorCtr).* {
my $tsStart = ReadingsVal($name,"ctrStart",undef);
my $days = ((defined($tsStart))?sprintf("%.1f",(time() - time_str2num($tsStart)) / (24*60*60)):0);
return sprintf("%.1f",ReadingsVal($name,"errorCtr",0) / (($days < 0.1)?0.1:$days));
}
   verbose    2
   webCmd     press short:press long



gruss frank
FHEM: 6.0(SVN) => Pi3(buster)
IO: CUL433|CUL868|HMLAN|HMUSB2|HMUART
CUL_HM: CC-TC|CC-VD|SEC-SD|SEC-SC|SEC-RHS|Sw1PBU-FM|Sw1-FM|Dim1TPBU-FM|Dim1T-FM|ES-PMSw1-Pl
IT: ITZ500|ITT1500|ITR1500|GRR3500
WebUI [HMdeviceTools.js (hm.js)]: https://forum.fhem.de/index.php/topic,106959.0.html

noansi

Hallo Frank,

als erstes musst Du mal ein paar Schritte zurück, damit ich überhaupt verstehe, was Du machen wolltest und abgesetzt hast, bevor es zu diesen Problemen kam.

Zitatwobei das preferedIO des vd, ein hmuart, gecrasht ist.
??? geht das denn mit dem hmuart? Ich bilde mir ein, kürzlich in einem alten Thread gelesen zu haben, dass der dabei Probleme mit dem Senden von Acks bekommt, wenn er für eine "fremde" IDs senden soll.

Vielleicht hast Du damit schon einen Teil des Chaos ausgelöst?

Gruß, Ansgar.

frank

da ansteuern über vtc hat keine probleme.
auch mit hmuart läuft es seit jahren perfekt und unauffällig. null fehlermeldungen, gar nichts.
ein crash vom hmuart sehe ich zum ersten mal.

ich wollte einfach mal regset testen.

auf jeden fall fehlt A112, im jannuar hab ich es im log noch gefunden.
FHEM: 6.0(SVN) => Pi3(buster)
IO: CUL433|CUL868|HMLAN|HMUSB2|HMUART
CUL_HM: CC-TC|CC-VD|SEC-SD|SEC-SC|SEC-RHS|Sw1PBU-FM|Sw1-FM|Dim1TPBU-FM|Dim1T-FM|ES-PMSw1-Pl
IT: ITZ500|ITT1500|ITR1500|GRR3500
WebUI [HMdeviceTools.js (hm.js)]: https://forum.fhem.de/index.php/topic,106959.0.html

frank

die "weitergabe" der liste5 vom vd an den tc ist wohl auch "normal".
allerdings darf da nicht die zentrale "zwischenquatschen". es gab auch keine "einladung" über 8202.
FHEM: 6.0(SVN) => Pi3(buster)
IO: CUL433|CUL868|HMLAN|HMUSB2|HMUART
CUL_HM: CC-TC|CC-VD|SEC-SD|SEC-SC|SEC-RHS|Sw1PBU-FM|Sw1-FM|Dim1TPBU-FM|Dim1T-FM|ES-PMSw1-Pl
IT: ITZ500|ITT1500|ITR1500|GRR3500
WebUI [HMdeviceTools.js (hm.js)]: https://forum.fhem.de/index.php/topic,106959.0.html

noansi

Hallo Frank,

mein Einbildung bezog sich hierauf: https://forum.fhem.de/index.php/topic,54511.msg498069/topicseen.html#msg498069

Und so crashes habe ich mal erzeugt:
2021.05.13 09:37:10.707 1: HMUARTLGW SCC_HM868 unexpected info about Co_CPU_BL received (module crashed?), reopening
2021.05.13 09:37:10.818 1: /dev/ttyAMA0 reappeared (SCC_HM868)
2021.05.13 09:38:06.095 1: HMUARTLGW SCC_HM868 Adding peer 519E29 failed! You have probably forced an unknown aesKey for this device.
2021.05.13 09:38:07.117 1: HMUARTLGW SCC_HM868 unexpected info about Co_CPU_BL received (module crashed?), reopening
2021.05.13 09:38:07.224 1: /dev/ttyAMA0 reappeared (SCC_HM868)

Der 519E29 ist ein HM-CC-RT-DN und den habe ich mit einem virtuellen Fensterkontakt und einem virtuellen TH Sensor gepeert.
Seit ich das virtuelle Gedöns via IOgrp von dem HMUARTLGW fern halte sind diese Meldungen auch nicht mehr aufgetaucht.
Vielleicht gibt es ja Zusammenhänge zu Deinem Problemfall?

Allerdings, als der SCC_HM noch SCC mit tsculfw war, gab es keine Probleme mit dem virtuellen. Ist auch nur ein temporärer Tausch...

Gruß, Ansgar.

noansi

Hallo Frank,

Zitatauf jeden fall fehlt A112, im jannuar hab ich es im log noch gefunden.
Und welches IO hat das gesendet?

Gruß, Ansgar.

frank

das fehlende A112 soll doch im namen der zentrale kommen. die zentrale soll das regset beim realen vd durch führen. also ein ganz normaler vorgang.

die beispiele muss ich später raussuchen.
eventuell war zu der zeit der hmuart auf urlaub in der debmatic.
FHEM: 6.0(SVN) => Pi3(buster)
IO: CUL433|CUL868|HMLAN|HMUSB2|HMUART
CUL_HM: CC-TC|CC-VD|SEC-SD|SEC-SC|SEC-RHS|Sw1PBU-FM|Sw1-FM|Dim1TPBU-FM|Dim1T-FM|ES-PMSw1-Pl
IT: ITZ500|ITT1500|ITR1500|GRR3500
WebUI [HMdeviceTools.js (hm.js)]: https://forum.fhem.de/index.php/topic,106959.0.html

frank

was ist denn der SCC_HM für eine hw?
ist das dieses homematic modul https://wiki.fhem.de/wiki/HM-MOD-RPI-PCB_HomeMatic_Funkmodul_f%C3%BCr_Raspberry_Pi?

damit kannst du doch eine ccu zum testen von lazyconfig bauen.  8)
FHEM: 6.0(SVN) => Pi3(buster)
IO: CUL433|CUL868|HMLAN|HMUSB2|HMUART
CUL_HM: CC-TC|CC-VD|SEC-SD|SEC-SC|SEC-RHS|Sw1PBU-FM|Sw1-FM|Dim1TPBU-FM|Dim1T-FM|ES-PMSw1-Pl
IT: ITZ500|ITT1500|ITR1500|GRR3500
WebUI [HMdeviceTools.js (hm.js)]: https://forum.fhem.de/index.php/topic,106959.0.html

noansi

Hallo Frank,

wie Du Dich vielleicht erinnerst, hatte ich ich mit Jörg schon am VD rumgeschraubt aber der Meistertester hat dankenswerterweise nur mit Hinweisen weitergeholfen https://forum.fhem.de/index.php/topic,24436.msg1118175.html#msg1118175.
Wenn ich Dich schon nicht zum Test der tsculfw animieren kann  ;), dann vielleicht zum Test meiner Sonder-HM Module, ob es damit auch teilweise oder genau so auftritt.

Zitatdamit kannst du doch eine ccu zum testen von lazyconfig bauen.
Leider erfülle ich nicht die Pi Hardwarevorraussetzungen. Oder möchtest Du mich zum Kauf eines passenden Pi animieren. ;)

Gruß, Ansgar.

frank

hallo ansgar,

ich glaube wir fangen jetzt mal ganz von hinten an.

immer wenn die probleme zu gross werden, hole ich meinen raketen-cul mit apollo11 fw raus, um zu sehen, was wirklich möglich ist. auch hier überzeugt er mal wieder durch geradlinige und schnörkellose kommunikation. ein regset mit automatischem getconfig wie aus dem bilderbuch:
2021.05.21 10:01:08.481 3: CUL_HM set Ventil.AZ.Nord regSet exec valveErrorPos 11
2021.05.21 10:01:08.522 2: HMinfo hminfo get:configCheck :-f,^(Ventil.AZ.Nord|Ventil.AZ.Nord)$

2021.05.21 10:01:55.557 4: CUL sent: cul868 As 0B 8A A258 B5B5B5 1C4E25 0000
2021.05.21 10:01:55.602 0: HMLAN_Parse: hmlan1 R:EB5B5B5   stat:0000 t:17B53EFF d:FF r:FFD9     m:8A A258 B5B5B5 1C4E25 0000
2021.05.21 10:01:55.607 0: HMUARTLGW hmuart1 recv: 01 05 00 00 0E msg: 8A A2 58 B5B5B5 1C4E25 0000
2021.05.21 10:01:55.714 4: CUL_Parse: cul868 A 0E 8A 8202 1C4E25 B5B5B5 010100004C -81.5
2021.05.21 10:01:55.718 3: CUL_HM set Ventil.AZ.Nord getConfig noArg
2021.05.21 10:01:55.816 4: CUL sent: cul868 As 09 8B A112 1ACE1F 1C4E25
2021.05.21 10:01:55.851 0: HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:17B53F80 d:FF r:FFC2     m:8A 8202 1C4E25 B5B5B5 010100004C
2021.05.21 10:01:55.855 0: HMUARTLGW hmuart1 recv: 01 05 00 00 45 msg: 8A 82 02 1C4E25 B5B5B5 010100004C
2021.05.21 10:01:55.858 0: HMUARTLGW hmuart1 recv: 01 05 00 00 0E msg: 8B A1 12 1ACE1F 1C4E25
2021.05.21 10:01:55.862 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:17B54000 d:FF r:FFD9     m:8B A112 1ACE1F 1C4E25
2021.05.21 10:01:55.966 4: CUL_Parse: cul868 A 0A 8B 8002 1C4E25 1ACE1F 00 -79.5
2021.05.21 10:01:56.069 4: CUL sent: cul868 As 10 8C A001 1ACE1F 1C4E25 01050000000005
2021.05.21 10:01:56.074 0: HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:17B5407D d:FF r:FFC0     m:8B 8002 1C4E25 1ACE1F 00
2021.05.21 10:01:56.077 0: HMUARTLGW hmuart1 recv: 01 05 00 00 46 msg: 8B 80 02 1C4E25 1ACE1F 00
2021.05.21 10:01:56.105 0: HMUARTLGW hmuart1 recv: 01 05 00 00 0E msg: 8C A0 01 1ACE1F 1C4E25 01050000000005
2021.05.21 10:01:56.111 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:17B54103 d:FF r:FFD9     m:8C A001 1ACE1F 1C4E25 01050000000005
2021.05.21 10:01:56.220 4: CUL_Parse: cul868 A 0A 8C 8002 1C4E25 1ACE1F 00 -79.5
2021.05.21 10:01:56.323 4: CUL sent: cul868 As 0D 8D A001 1ACE1F 1C4E25 01080A0B
2021.05.21 10:01:56.327 0: HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:17B5417A d:FF r:FFC2     m:8C 8002 1C4E25 1ACE1F 00
2021.05.21 10:01:56.330 0: HMUARTLGW hmuart1 recv: 01 05 00 00 46 msg: 8C 80 02 1C4E25 1ACE1F 00
2021.05.21 10:01:56.355 0: HMUARTLGW hmuart1 recv: 01 05 00 00 0E msg: 8D A0 01 1ACE1F 1C4E25 01080A0B
2021.05.21 10:01:56.363 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:17B541FF d:FF r:FFD9     m:8D A001 1ACE1F 1C4E25 01080A0B
2021.05.21 10:01:56.473 4: CUL_Parse: cul868 A 0A 8D 8002 1C4E25 1ACE1F 00 -81
2021.05.21 10:01:56.575 4: CUL sent: cul868 As 0B 8E A001 1ACE1F 1C4E25 0106
2021.05.21 10:01:56.579 0: HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:17B54278 d:FF r:FFC2     m:8D 8002 1C4E25 1ACE1F 00
2021.05.21 10:01:56.583 0: HMUARTLGW hmuart1 recv: 01 05 00 00 45 msg: 8D 80 02 1C4E25 1ACE1F 00
2021.05.21 10:01:56.606 0: HMUARTLGW hmuart1 recv: 01 05 00 00 0E msg: 8E A0 01 1ACE1F 1C4E25 0106
2021.05.21 10:01:56.613 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:17B542F9 d:FF r:FFD9     m:8E A001 1ACE1F 1C4E25 0106
2021.05.21 10:01:56.725 4: CUL_Parse: cul868 A 0A 8E 8002 1C4E25 1ACE1F 00 -82
2021.05.21 10:01:56.828 4: CUL sent: cul868 As 10 8F A001 1ACE1F 1C4E25 00040000000000
2021.05.21 10:01:56.832 0: HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:17B54374 d:FF r:FFC2     m:8E 8002 1C4E25 1ACE1F 00
2021.05.21 10:01:56.836 0: HMUARTLGW hmuart1 recv: 01 05 00 00 45 msg: 8E 80 02 1C4E25 1ACE1F 00
2021.05.21 10:01:56.863 0: HMUARTLGW hmuart1 recv: 01 05 00 00 0E msg: 8F A0 01 1ACE1F 1C4E25 00040000000000
2021.05.21 10:01:56.870 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:17B543FA d:FF r:FFD9     m:8F A001 1ACE1F 1C4E25 00040000000000
2021.05.21 10:01:56.988 4: CUL_Parse: cul868 A 14 8F 8010 1C4E25 1ACE1F 0202010A1A0BCE0C1F0000 -80.5
2021.05.21 10:01:57.091 4: CUL sent: cul868 As 0B 9F A001 1ACE1F 1C4E25 0103
2021.05.21 10:01:57.096 0: HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:17B5447A d:FF r:FFC2     m:8F 8010 1C4E25 1ACE1F 0202010A1A0BCE0C1F0000
2021.05.21 10:01:57.099 0: HMUARTLGW hmuart1 recv: 01 05 00 00 45 msg: 8F 80 10 1C4E25 1ACE1F 0202010A1A0BCE0C1F0000
2021.05.21 10:01:57.121 0: HMUARTLGW hmuart1 recv: 01 05 00 00 0E msg: 9F A0 01 1ACE1F 1C4E25 0103
2021.05.21 10:01:57.129 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:17B544FD d:FF r:FFD9     m:9F A001 1ACE1F 1C4E25 0103
2021.05.21 10:01:57.250 4: CUL_Parse: cul868 A 13 9F 8010 1C4E25 1ACE1F 01B5B5B5010000000032 -80.5
2021.05.21 10:01:57.352 4: CUL sent: cul868 As 10 AF A001 1ACE1F 1C4E25 01040000000005
2021.05.21 10:01:57.357 0: HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:17B5457F d:FF r:FFC2     m:9F 8010 1C4E25 1ACE1F 01B5B5B5010000000032
2021.05.21 10:01:57.363 0: HMUARTLGW hmuart1 recv: 01 05 00 00 45 msg: 9F 80 10 1C4E25 1ACE1F 01B5B5B5010000000032
2021.05.21 10:01:57.487 0: HMUARTLGW hmuart1 recv: 01 05 00 00 0E msg: AF A0 01 1ACE1F 1C4E25 01040000000005
2021.05.21 10:01:57.492 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:17B54607 d:FF r:FFD9     m:AF A001 1ACE1F 1C4E25 01040000000005
2021.05.21 10:01:57.508 4: CUL_Parse: cul868 A 10 AF 8010 1C4E25 1ACE1F 0209000A0B0000 -79
2021.05.21 10:01:57.547 0: HMUARTLGW hmuart1 recv: 01 05 00 00 45 msg: AF 80 10 1C4E25 1ACE1F 0209000A0B0000
2021.05.21 10:01:57.550 0: HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:17B54682 d:FF r:FFC2     m:AF 8010 1C4E25 1ACE1F 0209000A0B0000

2021.05.21 10:02:57.531 2: HMinfo hminfo get:configCheck :-f,^(Ventil.AZ.Nord|Ventil.AZ.Nord)$

2021.05.21 10:04:22.259 4: CUL sent: cul868 As 0B 8B A258 B5B5B5 1C4E25 0000
2021.05.21 10:04:22.310 0: HMUARTLGW hmuart1 recv: 01 05 00 00 0E msg: 8B A2 58 B5B5B5 1C4E25 0000
2021.05.21 10:04:22.317 0: HMLAN_Parse: hmlan1 R:EB5B5B5   stat:0000 t:17B77C23 d:FF r:FFD9     m:8B A258 B5B5B5 1C4E25 0000
2021.05.21 10:04:22.415 4: CUL_Parse: cul868 A 0E 8B 8102 1C4E25 B5B5B5 010100004C -80
2021.05.21 10:04:22.454 0: HMUARTLGW hmuart1 recv: 01 05 00 00 45 msg: 8B 81 02 1C4E25 B5B5B5 010100004C
2021.05.21 10:04:22.457 0: HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:17B77CA4 d:FF r:FFC1     m:8B 8102 1C4E25 B5B5B5 010100004C
2021.05.21 10:04:22.782 4: CUL_Parse: cul868 A 16 8D A410 1C4E25 B5B5B5 0400000000000509000A0B0000 -79.5
2021.05.21 10:04:22.884 4: CUL sent: cul868 As 0A 8D 8002 B5B5B5 1C4E25 00
2021.05.21 10:04:22.908 0: HMUARTLGW hmuart1 recv: 01 05 00 00 45 msg: 8D A4 10 1C4E25 B5B5B5 0400000000000509000A0B0000
2021.05.21 10:04:22.911 0: HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:17B77E12 d:FF r:FFC1     m:8D A410 1C4E25 B5B5B5 0400000000000509000A0B0000
2021.05.21 10:04:22.915 0: HMUARTLGW hmuart1 recv: 01 05 00 00 0E msg: 8D 80 02 B5B5B5 1C4E25 00
2021.05.21 10:04:22.922 0: HMLAN_Parse: hmlan1 R:EB5B5B5   stat:0000 t:17B77E94 d:FF r:FFD9     m:8D 8002 B5B5B5 1C4E25 00


zu sehen sind 2 aufeinanderfolgende meetings mit dem realen vd.
das setzen des registers plus zurücklesen der register durch automatisches getconfig erfolgt alles in einem rutsch während des ersten meetings.
interessant wird im folgenden das zweite meeting am ende vom sniff.
hier sendet der vd, bei einem zuvor erfolgreichen setzen der register, seinem gepeerten tc die geänderte registerliste.



einleitung:
an einer kommunikation mit dem vd können prinzipiell 3 teilnehmer beteiligt sein. realer vd, virtueller tc und die zentrale, alle mit eigener hmid. die messages zum vd können dabei von 2 unterschiedlichen io gesendet werden, die in den 2 fhem devices von vd und vTc festgelegt sind.

nun wird es kompliziert.
1. messages von der zentrale an den vd werden immer vom io im vd device gesendet => ganz normal.
2. messages vom vTC an den vd werden aber von beiden io gesendet.
a) die keepalive msgs im namen des vTc sendet immer das io im vd device.
b) die ACKs im namen des vTc an den vd werden aber vom io im vTc device gesendet.


2a) keepalive (A258) vom vTc an den vd:
ein normales meeting zwischen vtc und vd, das nur als keepalive inklusive setzen der valveposition dient, sieht folgendermassen aus. der vd antwortet mit 8202, um anderen die möglichkeit zu bieten, ggf eine kommunikation zu starten:
2021.05.21 10:06:34.461 4: CUL sent: cul868 As 0B 8C A258 B5B5B5 1C4E25 0000   # io vd
2021.05.21 10:06:34.618 4: CUL_Parse: cul868 A 0E 8C 8202 1C4E25 B5B5B5 010100004C -80



2b) mitteilung vom vd (A410) an den vTc:
wenn der vd dem vTc etwas mitteilen will, antwortet der vd nicht mit 8202, sondern mit 8102, um den vTc wach zu halten.
2021.05.21 10:04:22.259 4: CUL sent: cul868 As 0B 8B A258 B5B5B5 1C4E25 0000   # io vd
2021.05.21 10:04:22.415 4: CUL_Parse: cul868 A 0E 8B 8102 1C4E25 B5B5B5 010100004C -80
2021.05.21 10:04:22.782 4: CUL_Parse: cul868 A 16 8D A410 1C4E25 B5B5B5 0400000000000509000A0B0000 -79.5
2021.05.21 10:04:22.884 4: CUL sent: cul868 As 0A 8D 8002 B5B5B5 1C4E25 00     # io vTc



aktuelle probleme bei 2b):
nun gibt es ggf probleme, da die zentrale in die kommunikation zwischen vd und vTc reingrätscht.

in diesem fall wurde im meeting zuvor erfolgreich ein register geändert, aber im automatischen getconfig wurde der letzte cmd zum auslesen von liste 5 nicht beantwortet. es gibt keine aufforderung vom vd, dass die zentrale eine kommunikation starten könnte.
einerseits wird hier auch richtigerweise kein A112 gesendet, trotzdem haut die zentrale einfach den pending cmd raus:
2021.05.20 16:46:57.453 4: CUL sent: cul868 As 0B 48 A258 B5B5B5 1C4E25 0000
2021.05.20 16:46:57.491 0: HMUARTLGW hmuart1 recv: 01 05 00 00 0E msg: 48 A2 58 B5B5B5 1C4E25 0000
2021.05.20 16:46:57.498 0: HMLAN_Parse: hmlan1 R:EB5B5B5   stat:0000 t:1401A2F5 d:FF r:FFD9     m:48 A258 B5B5B5 1C4E25 0000
2021.05.20 16:46:57.611 4: CUL_Parse: cul868 A 0E 48 8102 1C4E25 B5B5B5 010100004E -82.5
2021.05.20 16:46:57.714 4: CUL sent: cul868 As 10 49 A001 1ACE1F 1C4E25 01040000000005
2021.05.20 16:46:57.720 0: HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:1401A376 d:FF r:FFC1     m:48 8102 1C4E25 B5B5B5 010100004E
2021.05.20 16:46:57.724 0: HMUARTLGW hmuart1 recv: 01 05 00 00 46 msg: 48 81 02 1C4E25 B5B5B5 010100004E
2021.05.20 16:46:57.852 0: HMUARTLGW hmuart1 recv: 01 05 00 00 0E msg: 49 A0 01 1ACE1F 1C4E25 01040000000005
2021.05.20 16:46:57.859 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:1401A464 d:FF r:FFD9     m:49 A001 1ACE1F 1C4E25 01040000000005
2021.05.20 16:46:57.977 4: CUL_Parse: cul868 A 16 4A A410 1C4E25 B5B5B5 0400000000000509000A0A0000 -82.5
2021.05.20 16:46:58.079 4: CUL sent: cul868 As 0A 4A 8002 B5B5B5 1C4E25 00
2021.05.20 16:46:58.111 0: HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:1401A4E4 d:FF r:FFC1     m:4A A410 1C4E25 B5B5B5 0400000000000509000A0A0000
2021.05.20 16:46:58.115 0: HMUARTLGW hmuart1 recv: 01 05 00 00 46 msg: 4A A4 10 1C4E25 B5B5B5 0400000000000509000A0A0000
2021.05.20 16:46:58.119 0: HMUARTLGW hmuart1 recv: 01 05 00 00 0E msg: 4A 80 02 B5B5B5 1C4E25 00
2021.05.20 16:46:58.135 0: HMLAN_Parse: hmlan1 R:EB5B5B5   stat:0000 t:1401A566 d:FF r:FFD9     m:4A 8002 B5B5B5 1C4E25 00



gruss frank
FHEM: 6.0(SVN) => Pi3(buster)
IO: CUL433|CUL868|HMLAN|HMUSB2|HMUART
CUL_HM: CC-TC|CC-VD|SEC-SD|SEC-SC|SEC-RHS|Sw1PBU-FM|Sw1-FM|Dim1TPBU-FM|Dim1T-FM|ES-PMSw1-Pl
IT: ITZ500|ITT1500|ITR1500|GRR3500
WebUI [HMdeviceTools.js (hm.js)]: https://forum.fhem.de/index.php/topic,106959.0.html

frank

#10
hi ansgar,

bei virtuellen devices funktioniert das umswitchen der io nicht richtig, zumindestens anders als bei normalen devices.
beim ändern von IOgrp wird das attr IODev nicht entsprechend geändert.

allerdings frage ich mich gerade, was denn nun eigentlich richtig wäre, da doch nun das attr nicht mehr geändert werden sollte, sondern das reading.
oder wie oder was???

ich glaube da blick ich nicht mehr durch.


ausserdem gibt es beim virtuellen device keine rssiwerte für "at_cul" in den internals.
so ganz stimmt die aussage nicht, denn nach dem ändern von IOgrp wurden plötzlich 17 werte angezeigt.
seltsam.
da gibt es sicherlich einen zusammenhang mit der nutzung der hmid durch 2 io.


gruss frank
FHEM: 6.0(SVN) => Pi3(buster)
IO: CUL433|CUL868|HMLAN|HMUSB2|HMUART
CUL_HM: CC-TC|CC-VD|SEC-SD|SEC-SC|SEC-RHS|Sw1PBU-FM|Sw1-FM|Dim1TPBU-FM|Dim1T-FM|ES-PMSw1-Pl
IT: ITZ500|ITT1500|ITR1500|GRR3500
WebUI [HMdeviceTools.js (hm.js)]: https://forum.fhem.de/index.php/topic,106959.0.html

noansi

#11
Hallo Frank,

wie Du weißt, habe ich die Hardware (VD,HMLAN) nicht und kann von daher nur mutmaßen und auf einem Bit mitdenken.

1. Frage. Warum sollen VD und vTC unterschiedliche IOs haben? Mit nur CUL für beide scheint es auf den ersten Blick ja grundsätzlich zu gehen.
2. Frage. Hast Du es mal mit HMLAN für beide und dann mal mit HMUARTLGW für beide probiert?

- Der HMUARTLGW scheint die A112 nicht zu senden, weil die message nicht fuer seine ID ist. Im Anhang mal eine eine Änderung, so dass die auch von FHEM gesendet würde, wie bei CUL. Das war früher für eine 8202 Wakeup message anders. Da wurde die A112 für alle IOs gesendet. Wenn das IO es selbst macht, ist es unnötig, daher hatte ich es geändert.
- Die in der Folge sind wohl vom HMLAN gekommen, das vermutlich vorbereitet wurde, als HMUARTLGW seine erste "Todesnachricht" geschickt hat.
- Anscheinend ist beim IO-Wechsel aber der ":remove" IOWrite vom HMUARTLGW in "Todesverachtung" nicht verarbeitet worden, vermute ich, denn nach seiner Wiederbelebung macht er sich anscheinend selbständig wieder zuständig. Ich denke, da muss Michael nochmal dazu.
Respektive wiederhol bitte die Aktion von #1 nochmal mit maximalen Log für HMUARTLGW, damit hoffentlich auch die :init und :remove auch sichtbar werden.

Danach erst Test mit dem Anhang, ob die A112 kommt.

Gruß, Ansgar.

PS:
Zitatallerdings frage ich mich gerade, was denn nun eigentlich richtig wäre, da doch nun das attr nicht mehr geändert werden sollte, sondern das reading.
oder wie oder was???

ich glaube da blick ich nicht mehr durch
Jetzt gib Dir mal ein bisschen Mühe, denn Du bist als User verantwortlich für das richtige Setzen der Attribute und auch klüger als Code, der Dir dabei helfen könnte.  ;)

Das Internal IODev ist das was tatsächlich zum Senden verwendet wird.

Die virtuellen devices sind speziell.
Sie empfangen keine realen devices, sondern das, was über IOs in Multi-IO Umgebung gesendet wird. RSSIs machen bei diesen also keinen Sinn für eine IO-Wahl.
D.h. der User muss was sinnvolles setzen.
Dazu hat er zwei Möglichkeiten: Attribut IODev oder Attribut IOgrp bei VCCU Nutzung
Die müssen auch bei einem Neustart noch funktionieren, wie eingestellt.

Attribut IODev ist das, was fhem.pl beim Neustart einstellt. Ist das nicht vorhanden, wird das Reading IODev eingestellt, ist auch das nicht vorhanden, wird das letzte IO eingestellt, dass behauptet CUL_HM zu unterstützen. Nur bei diesem Vorgang ist das Reading interessant zur Wiederherstellung des Zustands vor einem (ordentlichen) FHEM Restarts, aber eben nur für reale HM-devices.

Danach startet die Initialisierung von CUL_HM, wenn es das INITIALIZED event sieht.
Dabei wird das Attribut IOgrp entsprechend seiner Einstellung (und Vorhandensein) aus der config erneut gesetzt und darüber die VCCU und die Liste der präferierten IOs eingestellt. Ein Autoassign wird jedoch nicht ausgeführt, wie im voll initialisierten Zustand.

IOgrp ist für virtuelle devices eigentlich eine IO Liste, die im Sinne einer Ersatz IO Liste in Reihenfolge zu verstehen und nutzen ist, mit dem ersten VorzugsIO als Haupt-IO. Im regulären Betrieb wird es für die IO-Wahl (normalerweise vor dem Senden) genutzt, sofern eine VCCU vorhanden ist.
D.h. nach einem Neustart muss auch das erste IO aus der Liste vorzugsweise für das Senden gewählt werden. Daher wird für model VIRTUAL und CCU-FHEM beim Autoassign auch nur das Internal IODev gesetzt, nicht aber Attribut IODev und Reading IODev, eine Wiederherstellung beim fhem Start macht keinen Sinn bei diesen virtuellen devices (ok, das Reading IODev könnte man noch setzen weil es schöner aussieht, ich hab's im Anhang mal so geändert).

frank

#12
moin.


Zitat1. Frage. Warum sollen VD und vTC unterschiedliche IOs haben? Mit nur CUL für beide scheint es auf den ersten Blick ja grundsätzlich zu gehen.
muss nicht unterschiedlich sein. das hat sich im laufe der jahre so ergeben.
bisher hatte ich keine ahnung, dass das io vom vTc überhaupt zum einsatz kommt. meine erinnerung meint, dass das io im vtc nur aus "kompatibilitätsgründen" vorhanden sein sollte. gab es überhaupt schon eine vccu?
warum werden überhaupt 2 io aus verschiedenen devices für den selben absender benutzt?

das falsche reingretschen im 2. meeting macht der cul ebenso. das ist ein grundsätzliches problem.


Zitat2. Frage. Hast Du es mal mit HMLAN für beide und dann mal mit HMUARTLGW für beide probiert?
das A112 kommt zwar, aber wird immer unnötig 2x wiederholt:
2021.05.20 11:14:36.695 3 : CUL_HM set Ventil.AZ.Nord regSet exec valveErrorPos 15
2021.05.20 11:14:36.747 2 : HMinfo hminfo get:configCheck :-f,^(Ventil.AZ.Nord|Ventil.AZ.Nord)$
2021.05.20 11:14:36.836 0 : HMLAN_Send:  hmlan1 I:+1C4E25,02,00,00
2021.05.20 11:14:36.840 0 : HMLAN_Send:  hmlan1 I:+1C4E25,02,00,00


2021.05.20 11:14:48.315 0 : HMLAN_Send:  hmlan1 S:S890E55F3 stat:  00 t:00000000 d:01 r:890E55F3 m:C5 A258 B5B5B5 1C4E25 0000
2021.05.20 11:14:48.349 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 2A msg: C5 A2 58 B5B5B5 1C4E25 0000
2021.05.20 11:14:48.353 4 : CUL_Parse: cul868 A 0B C5 A258 B5B5B5 1C4E25 0000 -42.5
2021.05.20 11:14:48.470 4 : CUL_Parse: cul868 A 0E C5 8202 1C4E25 B5B5B5 010100003E -82.5
2021.05.20 11:14:48.473 3 : CUL_HM set Ventil.AZ.Nord getConfig noArg
2021.05.20 11:14:48.572 0 : HMLAN_Send:  hmlan1 S:S890E5697 stat:  00 t:00000000 d:01 r:890E5697 m:C6 A001 1ACE1F 1C4E25 01050000000005
2021.05.20 11:14:48.607 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 46 msg: C5 82 02 1C4E25 B5B5B5 010100003E
2021.05.20 11:14:48.611 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 2A msg: C5 A1 12 1ACE1F 1C4E25
2021.05.20 11:14:48.614 4 : CUL_Parse: cul868 A 09 C5 A112 1ACE1F 1C4E25  -42.5
2021.05.20 11:14:48.617 0 : HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:12D17F2E d:FF r:FFC2     m:C5 8202 1C4E25 B5B5B5 010100003E
2021.05.20 11:14:48.715 4 : CUL_Parse: cul868 A 0A C5 8002 1C4E25 1ACE1F 00 -81.5
2021.05.20 11:14:48.721 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 46 msg: C5 80 02 1C4E25 1ACE1F 00
2021.05.20 11:14:48.725 0 : HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:12D18023 d:FF r:FFC1     m:C5 8002 1C4E25 1ACE1F 00
2021.05.20 11:14:48.968 0 : HMUARTLGW hmuart1 send: 00 08
2021.05.20 11:14:48.973 0 : HMUARTLGW hmuart1 recv: 00 040204, state 98
2021.05.20 11:14:48.974 0 : HMUARTLGW hmuart1 GetSet Ack: 02, state 98
2021.05.20 11:14:48.975 0 : HMUARTLGW hmuart1 roundtrip delay: 0.0032
2021.05.20 11:14:49.016 0 : HMLAN_Parse: hmlan1 R:R83E33EC8 stat:0008 t:00000000 d:FF r:7FFF     m:C5 A112 1ACE1F 1C4E25
2021.05.20 11:14:49.017 0 : HMLAN_Parse: hmlan1 no ACK from 1C4E25
2021.05.20 11:14:49.038 4 : CUL_Parse: cul868 A 0B C5 A258 B5B5B5 1C4E25 0000 -42.5
2021.05.20 11:14:49.042 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 29 msg: C5 A2 58 B5B5B5 1C4E25 0000
2021.05.20 11:14:49.064 4 : CUL_Parse: cul868 A 10 C6 A001 1ACE1F 1C4E25 01050000000005 -42.5
2021.05.20 11:14:49.070 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 2A msg: C6 A0 01 1ACE1F 1C4E25 01050000000005
2021.05.20 11:14:49.167 4 : CUL_Parse: cul868 A 0E C5 8202 1C4E25 B5B5B5 010100003E -81.5
2021.05.20 11:14:49.175 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 45 msg: C5 82 02 1C4E25 B5B5B5 010100003E
2021.05.20 11:14:49.179 0 : HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:12D181E7 d:FF r:FFC1     m:C5 8202 1C4E25 B5B5B5 010100003E
2021.05.20 11:14:49.287 4 : CUL_Parse: cul868 A 09 C5 A112 1ACE1F 1C4E25  -42.5
2021.05.20 11:14:49.292 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 2B msg: C5 A1 12 1ACE1F 1C4E25
2021.05.20 11:14:49.411 4 : CUL_Parse: cul868 A 0A C5 8002 1C4E25 1ACE1F 00 -81.5
2021.05.20 11:14:49.417 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 46 msg: C5 80 02 1C4E25 1ACE1F 00
2021.05.20 11:14:49.420 0 : HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:12D182DB d:FF r:FFC1     m:C5 8002 1C4E25 1ACE1F 00
2021.05.20 11:14:49.713 0 : HMLAN_Parse: hmlan1 R:R83E33EC8 stat:0008 t:00000000 d:FF r:7FFF     m:C5 A112 1ACE1F 1C4E25
2021.05.20 11:14:49.714 0 : HMLAN_Parse: hmlan1 no ACK from 1C4E25
2021.05.20 11:14:49.735 4 : CUL_Parse: cul868 A 0B C5 A258 B5B5B5 1C4E25 0000 -42.5
2021.05.20 11:14:49.739 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 2A msg: C5 A2 58 B5B5B5 1C4E25 0000
2021.05.20 11:14:49.761 4 : CUL_Parse: cul868 A 10 C6 A001 1ACE1F 1C4E25 01050000000005 -42.5
2021.05.20 11:14:49.766 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 2A msg: C6 A0 01 1ACE1F 1C4E25 01050000000005
2021.05.20 11:14:49.865 4 : CUL_Parse: cul868 A 0E C5 8202 1C4E25 B5B5B5 010100003E -81.5
2021.05.20 11:14:49.873 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 46 msg: C5 82 02 1C4E25 B5B5B5 010100003E
2021.05.20 11:14:49.877 0 : HMLAN_Parse: hmlan1 R:R890E55F3 stat:0008 t:00000000 d:FF r:7FFF     m:C5 A258 B5B5B5 1C4E25 0000
2021.05.20 11:14:49.878 0 : HMLAN_Parse: hmlan1 no ACK from 1C4E25
2021.05.20 11:14:49.879 0 : HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:12D184A1 d:FF r:FFC2     m:C5 8202 1C4E25 B5B5B5 010100003E
2021.05.20 11:14:49.984 4 : CUL_Parse: cul868 A 09 C5 A112 1ACE1F 1C4E25  -42.5
2021.05.20 11:14:49.989 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 2A msg: C5 A1 12 1ACE1F 1C4E25
2021.05.20 11:14:50.109 4 : CUL_Parse: cul868 A 0A C5 8002 1C4E25 1ACE1F 00 -82
2021.05.20 11:14:50.115 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 46 msg: C5 80 02 1C4E25 1ACE1F 00
2021.05.20 11:14:50.118 0 : HMLAN_Parse: hmlan1 R:R7CB708DC stat:0081 t:12D1859A d:FF r:FFC1     m:C5 8002 1C4E25 1ACE1F 00
2021.05.20 11:14:50.388 4 : CUL_Parse: cul868 A 10 C6 A001 1ACE1F 1C4E25 01050000000005 -42.5
2021.05.20 11:14:50.393 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 2A msg: C6 A0 01 1ACE1F 1C4E25 01050000000005
2021.05.20 11:14:50.507 4 : CUL_Parse: cul868 A 0A C6 8002 1C4E25 1ACE1F 00 -82.5
2021.05.20 11:14:50.608 0 : HMLAN_Send:  hmlan1 S:S890E5E88 stat:  00 t:00000000 d:01 r:890E5E88 m:C7 A001 1ACE1F 1C4E25 01080A0F
2021.05.20 11:14:50.613 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 45 msg: C6 80 02 1C4E25 1ACE1F 00
2021.05.20 11:14:50.616 0 : HMLAN_Parse: hmlan1 R:R890E5697 stat:0001 t:12D18728 d:FF r:FFC2     m:C6 8002 1C4E25 1ACE1F 00
2021.05.20 11:14:50.785 4 : CUL_Parse: cul868 A 0D C7 A001 1ACE1F 1C4E25 01080A0F -42.5
2021.05.20 11:14:50.791 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 2A msg: C7 A0 01 1ACE1F 1C4E25 01080A0F
2021.05.20 11:14:50.908 4 : CUL_Parse: cul868 A 0A C7 8002 1C4E25 1ACE1F 00 -82.5
2021.05.20 11:14:51.010 0 : HMLAN_Send:  hmlan1 S:S890E6019 stat:  00 t:00000000 d:01 r:890E6019 m:C8 A001 1ACE1F 1C4E25 0106
2021.05.20 11:14:51.016 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 46 msg: C7 80 02 1C4E25 1ACE1F 00
2021.05.20 11:14:51.019 0 : HMLAN_Parse: hmlan1 R:R890E5E88 stat:0001 t:12D188B9 d:FF r:FFC1     m:C7 8002 1C4E25 1ACE1F 00
2021.05.20 11:14:51.111 0 : HMLAN_Send:  hmlan1 I:K
2021.05.20 11:14:51.116 0 : HMLAN_Parse: hmlan1 V:03C5 sNo:JEQ0315335 d:1C671E O:1ACE1F t:12D18985 IDcnt:0018 L:2 %
2021.05.20 11:14:51.184 4 : CUL_Parse: cul868 A 0B C8 A001 1ACE1F 1C4E25 0106 -42.5
2021.05.20 11:14:51.190 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 2A msg: C8 A0 01 1ACE1F 1C4E25 0106
2021.05.20 11:14:51.308 4 : CUL_Parse: cul868 A 0A C8 8002 1C4E25 1ACE1F 00 -82.5
2021.05.20 11:14:51.410 0 : HMLAN_Send:  hmlan1 S:S890E61A9 stat:  00 t:00000000 d:01 r:890E61A9 m:C9 A001 1ACE1F 1C4E25 00040000000000
2021.05.20 11:14:51.415 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 46 msg: C8 80 02 1C4E25 1ACE1F 00
2021.05.20 11:14:51.418 0 : HMLAN_Parse: hmlan1 R:R890E6019 stat:0001 t:12D18A4A d:FF r:FFC1     m:C8 8002 1C4E25 1ACE1F 00
2021.05.20 11:14:51.685 4 : CUL_Parse: cul868 A 10 C9 A001 1ACE1F 1C4E25 00040000000000 -42.5
2021.05.20 11:14:51.690 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 2A msg: C9 A0 01 1ACE1F 1C4E25 00040000000000
2021.05.20 11:14:51.717 4 : CUL_Parse: cul868 A 14 C9 8010 1C4E25 1ACE1F 0202010A1A0BCE0C1F0000 -82
2021.05.20 11:14:51.819 0 : HMLAN_Send:  hmlan1 S:S890E6344 stat:  00 t:00000000 d:01 r:890E6344 m:D9 A001 1ACE1F 1C4E25 0103
2021.05.20 11:14:51.824 0 : HMLAN_Parse: hmlan1 R:R890E61A9 stat:0001 t:12D18BE3 d:FF r:FFC1     m:C9 8010 1C4E25 1ACE1F 0202010A1A0BCE0C1F0000
2021.05.20 11:14:51.827 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 46 msg: C9 80 10 1C4E25 1ACE1F 0202010A1A0BCE0C1F0000
2021.05.20 11:14:51.995 4 : CUL_Parse: cul868 A 0B D9 A001 1ACE1F 1C4E25 0103 -42.5
2021.05.20 11:14:52.000 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 2A msg: D9 A0 01 1ACE1F 1C4E25 0103
2021.05.20 11:14:52.126 4 : CUL_Parse: cul868 A 13 D9 8010 1C4E25 1ACE1F 01B5B5B5010000000034 -82
2021.05.20 11:14:52.228 0 : HMLAN_Send:  hmlan1 S:S890E64DF stat:  00 t:00000000 d:01 r:890E64DF m:E9 A001 1ACE1F 1C4E25 01040000000005
2021.05.20 11:14:52.232 0 : HMLAN_Parse: hmlan1 R:R890E6344 stat:0001 t:12D18D7B d:FF r:FFC2     m:D9 8010 1C4E25 1ACE1F 01B5B5B5010000000034
2021.05.20 11:14:52.236 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 46 msg: D9 80 10 1C4E25 1ACE1F 01B5B5B5010000000034
2021.05.20 11:14:52.407 4 : CUL_Parse: cul868 A 10 E9 A001 1ACE1F 1C4E25 01040000000005 -42
2021.05.20 11:14:52.412 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 2A msg: E9 A0 01 1ACE1F 1C4E25 01040000000005
2021.05.20 11:14:52.532 4 : CUL_Parse: cul868 A 10 E9 8010 1C4E25 1ACE1F 0209000A0F0000 -82.5
2021.05.20 11:14:52.537 0 : HMLAN_Send:  hmlan1 I:+1C4E25,00,00,00
2021.05.20 11:14:52.572 0 : HMLAN_Parse: hmlan1 R:R890E64DF stat:0001 t:12D18F10 d:FF r:FFC1     m:E9 8010 1C4E25 1ACE1F 0209000A0F0000
2021.05.20 11:14:52.576 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 46 msg: E9 80 10 1C4E25 1ACE1F 0209000A0F0000

2021.05.20 11:22:36.165 0 : HMLAN_Send:  hmlan1 S:S8915797E stat:  00 t:00000000 d:01 r:8915797E m:C8 A258 B5B5B5 1C4E25 0000
2021.05.20 11:22:36.193 4 : CUL_Parse: cul868 A 0B C8 A258 B5B5B5 1C4E25 0000 -42.5
2021.05.20 11:22:36.198 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 2A msg: C8 A2 58 B5B5B5 1C4E25 0000
2021.05.20 11:22:36.392 4 : CUL_Parse: cul868 A 0B C8 A258 B5B5B5 1C4E25 0000 -42.5
2021.05.20 11:22:36.397 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 2A msg: C8 A2 58 B5B5B5 1C4E25 0000
2021.05.20 11:22:36.593 4 : CUL_Parse: cul868 A 0B C8 A258 B5B5B5 1C4E25 0000 -42.5
2021.05.20 11:22:36.597 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 2A msg: C8 A2 58 B5B5B5 1C4E25 0000
2021.05.20 11:22:36.721 4 : CUL_Parse: cul868 A 0E C8 8102 1C4E25 B5B5B5 010100003E -82.5
2021.05.20 11:22:36.755 0 : HMLAN_Parse: hmlan1 R:R8915797E stat:0008 t:00000000 d:FF r:7FFF     m:C8 A258 B5B5B5 1C4E25 0000
2021.05.20 11:22:36.756 0 : HMLAN_Parse: hmlan1 no ACK from 1C4E25
2021.05.20 11:22:36.757 0 : HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:12D8A493 d:FF r:FFC1     m:C8 8102 1C4E25 B5B5B5 010100003E
2021.05.20 11:22:36.760 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 45 msg: C8 81 02 1C4E25 B5B5B5 010100003E
2021.05.20 11:22:37.088 4 : CUL_Parse: cul868 A 16 CA A410 1C4E25 B5B5B5 0400000000000509000A0F0000 -82.5
2021.05.20 11:22:37.189 0 : HMLAN_Send:  hmlan1 S:S89157D1E stat:  00 t:00000000 d:01 r:89157D1E m:CA 8002 B5B5B5 1C4E25 00
2021.05.20 11:22:37.217 4 : CUL_Parse: cul868 A 0A CA 8002 B5B5B5 1C4E25 00 -42
2021.05.20 11:22:37.222 0 : HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:12D8A601 d:FF r:FFC1     m:CA A410 1C4E25 B5B5B5 0400000000000509000A0F0000
2021.05.20 11:22:37.225 0 : HMLAN_Parse: hmlan1 R:R89157D1E stat:0002 t:00000000 d:FF r:7FFF     m:CA 8002 B5B5B5 1C4E25 00
2021.05.20 11:22:37.226 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 46 msg: CA A4 10 1C4E25 B5B5B5 0400000000000509000A0F0000
2021.05.20 11:22:37.229 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 2A msg: CA 80 02 B5B5B5 1C4E25 00

2021.05.20 11:30:22.268 0 : HMLAN_Send:  hmlan1 S:S891C9634 stat:  00 t:00000000 d:01 r:891C9634 m:CB A258 B5B5B5 1C4E25 0000
2021.05.20 11:30:22.323 4 : CUL_Parse: cul868 A 0B CB A258 B5B5B5 1C4E25 0000 -42
2021.05.20 11:30:22.331 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 2A msg: CB A2 58 B5B5B5 1C4E25 0000
2021.05.20 11:30:22.425 4 : CUL_Parse: cul868 A 0E CB 8202 1C4E25 B5B5B5 010100003E -82.5
2021.05.20 11:30:22.461 0 : HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:12DFC000 d:FF r:FFC1     m:CB 8202 1C4E25 B5B5B5 010100003E
2021.05.20 11:30:22.465 4 : CUL_Parse: cul868 A 0B CB A258 B5B5B5 1C4E25 0000 -42
2021.05.20 11:30:22.469 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 46 msg: CB 82 02 1C4E25 B5B5B5 010100003E
2021.05.20 11:30:22.472 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 2A msg: CB A2 58 B5B5B5 1C4E25 0000
2021.05.20 11:30:22.654 4 : CUL_Parse: cul868 A 0B CB A258 B5B5B5 1C4E25 0000 -42
2021.05.20 11:30:22.658 0 : HMUARTLGW hmuart1 recv: 01 05 00 00 2A msg: CB A2 58 B5B5B5 1C4E25 0000
2021.05.20 11:30:22.834 0 : HMLAN_Parse: hmlan1 R:R891C9634 stat:0008 t:00000000 d:FF r:7FFF     m:CB A258 B5B5B5 1C4E25 0000
2021.05.20 11:30:22.835 0 : HMLAN_Parse: hmlan1 no ACK from 1C4E25



Zitat- Der HMUARTLGW scheint die A112 nicht zu senden, weil die message nicht fuer seine ID ist. Im Anhang mal eine eine Änderung, so dass die auch von FHEM gesendet würde, wie bei CUL. Das war früher für eine 8202 Wakeup message anders. Da wurde die A112 für alle IOs gesendet. Wenn das IO es selbst macht, ist es unnötig, daher hatte ich es geändert.
genau, im august 2020 hatte ich ein getconfig vom hmlan gefunden:
2020.08.10 12:56:18.032 0: HMLAN_Send:  hmlan1 S:SD8038DE3 stat:  00 t:00000000 d:01 r:D8038DE3 m:19 A258 B4B4B4 1CE9F5 00FD
2020.08.10 12:56:18.194 3: CUL_HM set Ventil.WZ getConfig
2020.08.10 12:56:18.290 0: HMLAN_Send:  hmlan1 S:SD8038E86 stat:  00 t:00000000 d:01 r:D8038E86 m:1A A112 1ACE1F 1CE9F5
2020.08.10 12:56:18.296 0: HMLAN_Parse: hmlan1 R:E1CE9F5   stat:0000 t:789B2F81 d:FF r:FFD4     m:19 8202 1CE9F5 B4B4B4 0101C6002C
2020.08.10 12:56:18.555 0: HMLAN_Parse: hmlan1 R:RD8038DE3 stat:0001 t:789B3083 d:FF r:FFD4     m:1A 8002 1CE9F5 1ACE1F 00
2020.08.10 12:56:18.625 0: HMLAN_Send:  hmlan1 S:SD8038FF1 stat:  00 t:00000000 d:01 r:D8038FF1 m:1B A001 1ACE1F 1CE9F5 00040000000000
2020.08.10 12:56:18.628 0: HMLAN_Send:  hmlan1 I:+1CE9F5,02,00,00
2020.08.10 12:56:18.884 0: HMLAN_Parse: hmlan1 R:RD8038FF1 stat:0001 t:789B3220 d:FF r:FFD4     m:1B 8010 1CE9F5 1ACE1F 0202010A1A0BCE0C1F0000
2020.08.10 12:56:18.958 0: HMLAN_Send:  hmlan1 S:SD803913A stat:  00 t:00000000 d:01 r:D803913A m:1C A001 1ACE1F 1CE9F5 0103
2020.08.10 12:56:19.318 0: HMLAN_Parse: hmlan1 R:RD803913A stat:0001 t:789B33BA d:FF r:FFD4     m:1C 8010 1CE9F5 1ACE1F 01B4B4B40100000000F1
2020.08.10 12:56:19.368 0: HMLAN_Send:  hmlan1 S:SD80392EC stat:  00 t:00000000 d:01 r:D80392EC m:1D A001 1ACE1F 1CE9F5 01040000000005
2020.08.10 12:56:19.391 0: HMLAN_Parse: hmlan1 R:RD8038E86 stat:0008 t:00000000 d:FF r:7FFF     m:1A A112 1ACE1F 1CE9F5
2020.08.10 12:56:19.392 0: HMLAN_Parse: hmlan1 no ACK from 1CE9F5
2020.08.10 12:56:19.785 0: HMLAN_Send:  hmlan1 I:+1CE9F5,00,00,00
2020.08.10 12:56:19.810 0: HMLAN_Parse: hmlan1 R:RD80392EC stat:0001 t:789B3590 d:FF r:FFD4     m:1D 8010 1CE9F5 1ACE1F 0209000A0F0000



Zitat- Anscheinend ist beim IO-Wechsel aber der ":remove" IOWrite vom HMUARTLGW in "Todesverachtung" nicht verarbeitet worden, vermute ich, denn nach seiner Wiederbelebung macht er sich anscheinend selbständig wieder zuständig. Ich denke, da muss Michael nochmal dazu.
so wie ich das im sniff vom ersten post sehe, macht hmuartlgw ein reopen. der neue sniff mit verbose5 sieht da etwas anders aus: hier scheint es ein restar des hmuart zu sein.
ein manuelles "set hmuart reopen" erzeugt ebenfalls die "crash" meldung.


ZitatRespektive wiederhol bitte die Aktion von #1 nochmal mit maximalen Log für HMUARTLGW, damit hoffentlich auch die :init und :remove auch sichtbar werden.
hatte ich schon mal gemacht: siehe anhang.


gruss frank
FHEM: 6.0(SVN) => Pi3(buster)
IO: CUL433|CUL868|HMLAN|HMUSB2|HMUART
CUL_HM: CC-TC|CC-VD|SEC-SD|SEC-SC|SEC-RHS|Sw1PBU-FM|Sw1-FM|Dim1TPBU-FM|Dim1T-FM|ES-PMSw1-Pl
IT: ITZ500|ITT1500|ITR1500|GRR3500
WebUI [HMdeviceTools.js (hm.js)]: https://forum.fhem.de/index.php/topic,106959.0.html

frank

eventuell noch interessant:
im meeting 2, beim hmuart sterben, hört der cul nicht das Ack vom hmlan.
ich vermute, dass eventuell hmuart und hmlan beide das Ack senden.
vielleicht ist das ein problem für den hmuart?

2021.05.20 15:25:33.099 4: CUL_Parse: cul868 A 10 29 A001 1ACE1F 1C4E25 00040000000000 -22.5
2021.05.20 15:25:33.109 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:13B71860 d:FF r:FFD1     m:29 A001 1ACE1F 1C4E25 00040000000000
2021.05.20 15:25:33.310 4: CUL_Parse: cul868 A 16 2A A410 1C4E25 B5B5B5 0400000000000509000A0A0000 -85.5
2021.05.20 15:25:33.314 0: HMLAN_Send:  hmlan1 I:+1C4E25,00,00,
2021.05.20 15:25:33.411 0: HMLAN_Send:  hmlan1 S:+1C4E25,02,00,00
2021.05.20 15:25:33.412 0: HMLAN_Send:  hmlan1 S:S89F3E77B stat:  00 t:00000000 d:01 r:89F3E77B m:2A 8002 B5B5B5 1C4E25 00
2021.05.20 15:25:33.439 0: HMLAN_Parse: hmlan1 R:E1C4E25   stat:0000 t:13B71933 d:FF r:FFC2     m:2A A410 1C4E25 B5B5B5 0400000000000509000A0A0000
2021.05.20 15:25:33.443 4: CUL_Parse: cul868 A 10 29 A001 1ACE1F 1C4E25 00040000000000 -22.5
2021.05.20 15:25:33.446 0: HMLAN_Parse: hmlan1 R:R89F3E77B stat:0002 t:00000000 d:FF r:7FFF     m:2A 8002 B5B5B5 1C4E25 00
2021.05.20 15:25:33.738 4: CUL_Parse: cul868 A 10 29 A001 1ACE1F 1C4E25 00040000000000 -22.5
2021.05.20 15:25:33.748 0: HMLAN_Parse: hmlan1 R:E1ACE1F   stat:0000 t:13B71AE0 d:FF r:FFD2     m:29 A001 1ACE1F 1C4E25 00040000000000
FHEM: 6.0(SVN) => Pi3(buster)
IO: CUL433|CUL868|HMLAN|HMUSB2|HMUART
CUL_HM: CC-TC|CC-VD|SEC-SD|SEC-SC|SEC-RHS|Sw1PBU-FM|Sw1-FM|Dim1TPBU-FM|Dim1T-FM|ES-PMSw1-Pl
IT: ITZ500|ITT1500|ITR1500|GRR3500
WebUI [HMdeviceTools.js (hm.js)]: https://forum.fhem.de/index.php/topic,106959.0.html

noansi

#14
Hallo Frank,

Zitatb) die ACKs im namen des vTc an den vd werden aber vom io im vTc device gesendet.
Zitatwarum werden überhaupt 2 io aus verschiedenen devices für den selben absender benutzt?
Das liegt daran, wie ACks gehandhabt werden. Es ist einfach nur der nomale Ablauf, wie mit anderen devices auch. Eine Sonderbehandlung wäre auch hier sinnvoll, denke ich.
Denn
Zitata) die keepalive msgs im namen des vTc sendet immer das io im vd device.
das Senden der keepalive msgs geschieht über die Queue des den VD. Das hat dann den Vorteil, dass das IO Assignments richtig nach RSSI greifen kann und die Kommandos an den VD serialisiert werden.

Zitatgenau, im august 2020 hatte ich ein getconfig vom hmlan gefunden:
Da ist auch eine Merkwürdigkeit:
2020.08.10 12:56:19.391 0: HMLAN_Parse: hmlan1 R:RD8038E86 stat:0008 t:00000000 d:FF r:7FFF     m:1A A112 1ACE1F 1CE9F5
Wer hat den gesendet? Oder will HMLAN damit nur sagen, dass es den gesendet hatte?

Gruß, Ansgar.