Readings von Aktoren werden diversen Wakeup Devices zugeordnet

[krusi]

Hallo zusammen,
seit längerer Zeit beobachte ich, dass regelmäßig Readings in meinen Devices auftauchen bei denen entweder der Wert nicht plausibel ist oder das Gerät die Eigenschaft gar nicht unterstützt.
Bisher konnte ich dies nicht richtig eingrenzen, in Verbindung mit der Ansteuerung eines Fibaro FGD212 Dimmer 2 wurde es jetzt aber offensichtlich und nachvollziehbar:
Die Beleuchtung wird bei Bewegungserkennung immer mit dim 60 eingeschaltet. Zum Test wurden nun zuerst bei allen Devices die falschen Readings bereinigt und die dim Vorgabe im Code auf einen Wert (57) gesetzt welcher gleich auffällt.
Nach der ersten Ansteuerung durch FHEM zeigt das entsprechende Device EG_EZ_DI_1 den richtigen Wert (beim zweiten Dimmer wurde die Ansteuerung durch FHEM temporär deaktiviert)

Code Auswählen Erweitern

2021-11-29_11:14:00 List .* dim
EG_EZ_DI_1           2021-11-29 11:12:19    57
EG_WZ_DR_1           2021-11-28 20:35:12    60

Code Auswählen Erweitern


Log EG_EZ_DI_1
2021-11-29_11:12:19 EG_EZ_DI_1 set_dim 57
2021-11-29_11:12:19 EG_EZ_DI_1 dim 57
2021-11-29_11:12:19 EG_EZ_DI_1 dim: 57
2021-11-29_11:12:20 EG_EZ_DI_1 power: 1.9 W
2021-11-29_11:12:20 EG_EZ_DI_1 dim 57
2021-11-29_11:12:20 EG_EZ_DI_1 reportedState: dim 57
2021-11-29_11:12:26 EG_EZ_DI_1 power: 15.8 W
Nach 1-2 Stunden erscheinen dann nach und nach immer mehr Readings dim 57 bei WakeUp Devices welche überhaupt nicht in Verbindung mit dem Dimmer stehen und auch keine dim Eigenschaft unterstützen. Wartet man mehrere Tage ab besitzen zuletzt ALLE WakeUp Devices dieses Reading. Zur genannten Zeit ist im Log des Devices von dem dieses Reading stammt allerdings keine Antwort mit dim Reading gelistet.

Code Auswählen Erweitern

============================================================
2021-11-30_01:00:00 List .* dim
EG_EZ_DI_1           2021-11-30 00:57:15    57 <= korrekt
EG_EZ_HR_1           2021-11-30 00:22:55    57
EG_EZ_MS_1           2021-11-29 13:31:34    57
EG_KB_HR_1           2021-11-29 21:25:34    57
EG_KB_MS_1           2021-11-29 22:27:44    57
EG_KF_MS_1           2021-11-29 18:54:00    57
EG_WZ_DR_1           2021-11-28 20:35:12    60 <= korrekt
EG_WZ_HR_1           2021-11-29 22:51:13    57
OG_FL_TK_1           2021-11-29 19:59:59    57
OG_KB_HR_1           2021-11-29 20:01:18    57
UG_BU_TK_1           2021-11-29 21:19:09    57
============================================================
2021-12-01_20:00:00 List .* dim
EG_BA_MS_1           2021-11-30 12:32:15    57
EG_EZ_DI_1           2021-12-01 18:14:05    57 <= korrekt
EG_EZ_HR_1           2021-12-01 17:53:31    57
EG_EZ_MS_1           2021-12-01 07:45:04    57
EG_FL_MS_1           2021-12-01 03:37:10    57
EG_FL_TK_1           2021-12-01 00:30:23    57
EG_KB_HR_1           2021-12-01 18:59:17    57
EG_KB_MS_1           2021-11-30 23:03:17    57
EG_KF_MS_1           2021-11-29 18:54:00    57
EG_KU_MS_1           2021-12-01 15:22:10    57
EG_SZ_MS_1           2021-11-30 13:49:21    57
EG_WZ_DR_1           2021-11-28 20:35:12    60 <= korrekt
EG_WZ_HR_1           2021-12-01 15:27:51    57
EG_WZ_MS_1           2021-12-01 18:00:27    57
OG_FL_TK_1           2021-12-01 06:46:01    57
OG_KB_HR_1           2021-12-01 10:14:23    57
OG_WZ_HR_1           2021-12-01 05:19:59    57
UG_BU_TK_1           2021-12-01 08:07:22    57
Außer den beiden Dimmern sind dies alles Fibaro-Motionsensoren, Türkontakte und Heizungsregler verschiedener Hersteller.
Aktiviert man auch beim zweiten Dimmer die Ansteuerung über FHEM ergibt sich eine Mischung aus beiden dim Werten.
Folglich wird es bei anderen Readings zu Eigenschaften welche viele Geräte besitzen oft schwer nachvollziehbar, da die Werte von ganz unterschiedlichen Devices stammen können und die Quelle immer wieder wechselt.
An dieser Stelle sollte ich auch anmerken, dass folgende globale Attribute gesetzt sind nachdem es früher immer wieder Probleme mit der Aktualisierung der Ist-Zustände von Aktoren gab:

Code Auswählen Erweitern

setReadingOnAck = 1
showSetInState = 1
Ich habe hier den leisen Verdacht, dass in der Queue Antworten zu falschen Devices zugeordnet werden.
Falls jemand ähnliche Beobachtungen gemacht hat, bereits die Ursache oder ein Workaround kennt, bitte Bescheid geben.
Ansonsten wäre ich dankbar für Tipps wie man die Sache noch genauer analysieren könnte.

[rudolfkoenig]

Ich habe hier den leisen Verdacht, dass in der Queue Antworten zu falschen Devices zugeordnet werden.

Moeglich aber unwahrscheinlich.
Wenn man das mir mit RAW Nachrichten (attr IODev verbose 5) nachweist, dann werde ich das fixen.

Wahrscheinicher ist ein Fehler bei der Funkuebertragung, die bei 19.6+40k Datenrate nur mit einem Byte abgesichert ist.

Es gibt mehrere Moeglichkeiten, die Pruefsumme zu verbessern:
- Sicherstellen, dass fuer die Kommunikation die 100k Datenrate verwendet wird (durch besseren Funkkontakt bzw. modernere Chipsets), hier wird ein 16-bit CRC verwendet.
- durch Setzen des Attributes useCRC16, hier fuegt FHEM bzw. das Geraet zusaetzlich zum "Hardware-Checksum" eine Weitere hinzu. Das Geraet muss das aber unterstuetzen, d.h. classes muss CRC_16_ENCAP enthalten. Beim aktivierten SECURITY wird automatisch ein CRC16 hinzugefuegt.

[krusi]

Vielen Dank für die Hinweise.

Kommunikation mit dem genannten Device sollte bereits mit 100kbps erfolgen:

Code Auswählen Erweitern

routeFor_EG_EZ_DI_1
last at 100kbps 2021-12-05 14:11:36
CRC_16_ENCAP wird unterstützt und wurde jetzt testweise aktiviert:

Code Auswählen Erweitern

Attributes:
   classes    ZWAVEPLUS_INFO BASIC VERSION MANUFACTURER_SPECIFIC SWITCH_MULTILEVEL DEVICE_RESET_LOCALLY ASSOCIATION_GRP_INFO ASSOCIATION POWERLEVEL SECURITY
                 FIRMWARE_UPDATE_MD CRC_16_ENCAP CONFIGURATION SENSOR_MULTILEVEL METER MULTI_CHANNEL_ASSOCIATION MULTI_CHANNEL PROTECTION ALARM SWITCH_ALL
                 APPLICATION_STATUS MARK SCENE_ACTIVATION

   useCRC16   1

Es folgt cleanup und erneuter Test, werde dann versuchen auch gleich die RAW-Nachrichten zu loggen.

[krusi]

Ergebnisse der Tests

Ausgangszustand:

Code Auswählen Erweitern

===============================
deletereading .* dim
set EG_EZ_DI_1 dim 55
set EG_WZ_DR_1 dim 56
==============================
List .* dim
EG_EZ_DI_1           2021-12-05 14:42:35    55
EG_WZ_DR_1           2021-12-05 14:43:47    56
==============================

Nach 3 Stunden:

Code Auswählen Erweitern

===============================
List .* dim
EG_EZ_DI_1           2021-12-05 14:50:43    55
EG_WZ_DR_1           2021-12-05 14:43:47    56
EG_WZ_HR_1           2021-12-05 17:24:31    56 <= falsch, Wert von EG_WZ_DR_1
===============================

Nach 5 Stunden:

Code Auswählen Erweitern

===============================
List .* dim

EG_EZ_DI_1           2021-12-05 20:45:06    55
EG_EZ_MS_1           2021-12-05 19:47:29    55 <= falsch, Wert von EG_EZ_DI_1
EG_WZ_DR_1           2021-12-05 14:43:47    56
EG_WZ_HR_1           2021-12-05 17:24:31    56 <= falsch, Wert von EG_WZ_DR_1
===============================

Auszug RAW Werte zum Event 17:24:31 Uhr

Code Auswählen Erweitern

2021.12.05 17:23:36 3: Notify n_Licht_EZ Event: MSaddN
2021.12.05 17:23:36 3: Watchdog Licht_EZ Set: additional 10min (Motion)
2021.12.05 17:23:47 4: ZWDongle_Read ZWAVE1: rcvd 0004001f06310504220023 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.05 17:23:47 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 17:23:47 5: ZWAVE1: dispatch 0004001f06310504220023
2021.12.05 17:23:47 4: CMD:APPLICATION_COMMAND_HANDLER ID:1f ARG:06310504220023 CB:00
2021.12.05 17:23:47 4: ZWDongle_Read ZWAVE1: rcvd 0004001f03260363 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.05 17:23:47 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 17:23:47 5: ZWAVE1: dispatch 0004001f03260363
2021.12.05 17:23:47 4: CMD:APPLICATION_COMMAND_HANDLER ID:1f ARG:03260363 CB:00
2021.12.05 17:23:49 4: ZWDongle_Read ZWAVE1: rcvd 0004002b0a32022144000000580000 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.05 17:23:49 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 17:23:49 5: ZWAVE1: dispatch 0004002b0a32022144000000580000
2021.12.05 17:23:49 4: CMD:APPLICATION_COMMAND_HANDLER ID:2b ARG:0a32022144000000580000 CB:00
2021.12.05 17:23:53 4: ZWDongle_Read ZWAVE1: rcvd 0004001f063105042200a3 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.05 17:23:53 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 17:23:53 5: ZWAVE1: dispatch 0004001f063105042200a3
2021.12.05 17:23:53 4: CMD:APPLICATION_COMMAND_HANDLER ID:1f ARG:063105042200a3 CB:00
2021.12.05 17:24:04 4: ZWDongle_Read ZWAVE1: rcvd 0004002703300300 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.05 17:24:04 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 17:24:04 5: ZWAVE1: dispatch 0004002703300300
2021.12.05 17:24:04 4: CMD:APPLICATION_COMMAND_HANDLER ID:27 ARG:03300300 CB:00
2021.12.05 17:24:28 4: ZWDongle_Read ZWAVE1: rcvd 0004001b028407 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.05 17:24:28 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 17:24:28 5: ZWAVE1: dispatch 0004001b028407
2021.12.05 17:24:28 4: CMD:APPLICATION_COMMAND_HANDLER ID:1b ARG:028407 CB:00
2021.12.05 17:24:29 3: Wake-Up Event EG_WZ_HR_1 (get Setpoint)
2021.12.05 17:24:29 3: ZWave get EG_WZ_HR_1 setpoint 1
2021.12.05 17:24:29 5: ZWDongle_Write 00131b03430201250f (e6845561)
2021.12.05 17:24:29 5: DevIo_SimpleWrite ZWAVE1: 010a00131b03430201250f94
2021.12.05 17:24:29 5: ACK received, WaitForAck=>2 for 010a00131b03430201250f94
2021.12.05 17:24:29 4: ZWDongle_Read ZWAVE1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
2021.12.05 17:24:29 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 17:24:29 5: ZWAVE1: dispatch 011301
2021.12.05 17:24:29 4: ZWDongle_Read ZWAVE1: rcvd 00130f00000b (request ZW_SEND_DATA), sending ACK
2021.12.05 17:24:29 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 17:24:29 5: device ack reveived, removing 010a00131b03430201250f94 from dongle sendstack
2021.12.05 17:24:29 5: ZWAVE1: dispatch 00130f00000b
2021.12.05 17:24:29 4: CMD:ZW_SEND_DATA ID:00 ARG:000b CB:0f
2021.12.05 17:24:29 4: ZWAVE1 transmit OK for CB 0f, target EG_WZ_HR_1
2021.12.05 17:24:29 4: ZWDongle_Read ZWAVE1: rcvd 0004001b064303012200d2 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.05 17:24:29 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 17:24:29 5: ZWAVE1: dispatch 0004001b064303012200d2
2021.12.05 17:24:29 4: CMD:APPLICATION_COMMAND_HANDLER ID:1b ARG:064303012200d2 CB:00
*2021.12.05 17:24:31 5: ZWDongle_Write 00131b0284082510 (e6845561)
2021.12.05 17:24:31 5: DevIo_SimpleWrite ZWAVE1: 010900131b028408251045
2021.12.05 17:24:31 5: ACK received, WaitForAck=>2 for 010900131b028408251045
2021.12.05 17:24:31 4: ZWDongle_Read ZWAVE1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
2021.12.05 17:24:31 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 17:24:31 5: ZWAVE1: dispatch 011301
2021.12.05 17:24:31 4: ZWDongle_Read ZWAVE1: rcvd 001310000008 (request ZW_SEND_DATA), sending ACK
2021.12.05 17:24:31 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 17:24:31 5: device ack reveived, removing 010900131b028408251045 from dongle sendstack
2021.12.05 17:24:31 5: ZWAVE1: dispatch 001310000008
2021.12.05 17:24:31 4: CMD:ZW_SEND_DATA ID:00 ARG:0008 CB:10
2021.12.05 17:24:31 4: ZWAVE1 transmit OK for CB 10, target EG_WZ_HR_1
2021.12.05 17:24:40 4: ZWDongle_Read ZWAVE1: rcvd 00040016063105030a0000 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.05 17:24:40 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 17:24:40 5: ZWAVE1: dispatch 00040016063105030a0000
2021.12.05 17:24:40 4: CMD:APPLICATION_COMMAND_HANDLER ID:16 ARG:063105030a0000 CB:00
2021.12.05 17:24:45 4: ZWDongle_Read ZWAVE1: rcvd 0004000e03300300 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.05 17:24:45 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 17:24:45 5: ZWAVE1: dispatch 0004000e03300300
2021.12.05 17:24:45 4: CMD:APPLICATION_COMMAND_HANDLER ID:0e ARG:03300300 CB:00
2021.12.05 17:24:47 4: ZWDongle_Read ZWAVE1: rcvd 00040011063105012200c1 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.05 17:24:47 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 17:24:47 5: ZWAVE1: dispatch 00040011063105012200c1
2021.12.05 17:24:47 4: CMD:APPLICATION_COMMAND_HANDLER ID:11 ARG:063105012200c1 CB:00
2021.12.05 17:24:48 4: ZWDongle_Read ZWAVE1: rcvd 0004001303300300 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.05 17:24:48 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 17:24:48 5: ZWAVE1: dispatch 0004001303300300
2021.12.05 17:24:48 4: CMD:APPLICATION_COMMAND_HANDLER ID:13 ARG:03300300 CB:00
2021.12.05 17:24:49 4: ZWDongle_Read ZWAVE1: rcvd 00040011063105030a0000 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.05 17:24:49 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 17:24:49 5: ZWAVE1: dispatch 00040011063105030a0000
2021.12.05 17:24:49 4: CMD:APPLICATION_COMMAND_HANDLER ID:11 ARG:063105030a0000 CB:00
2021.12.05 17:24:51 4: ZWDongle_Read ZWAVE1: rcvd 00040027028407 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.05 17:24:51 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 17:24:51 5: ZWAVE1: dispatch 00040027028407
2021.12.05 17:24:51 4: CMD:APPLICATION_COMMAND_HANDLER ID:27 ARG:028407 CB:00
2021.12.05 17:24:53 5: ZWDongle_Write 0013270284082511 (e6845561,28)
2021.12.05 17:24:53 5: DevIo_SimpleWrite ZWAVE1: 0109001327028408251178
2021.12.05 17:24:53 5: ACK received, WaitForAck=>2 for 0109001327028408251178
2021.12.05 17:24:53 4: ZWDongle_Read ZWAVE1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
2021.12.05 17:24:53 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 17:24:53 5: ZWAVE1: dispatch 011301
2021.12.05 17:24:53 4: ZWDongle_Read ZWAVE1: rcvd 001311000002 (request ZW_SEND_DATA), sending ACK
2021.12.05 17:24:53 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 17:24:53 5: device ack reveived, removing 0109001327028408251178 from dongle sendstack
2021.12.05 17:24:53 5: ZWAVE1: dispatch 001311000002
2021.12.05 17:24:53 4: CMD:ZW_SEND_DATA ID:00 ARG:0002 CB:11
2021.12.05 17:24:53 4: ZWAVE1 transmit OK for CB 11, target EG_KB_MS_1
2021.12.05 17:24:54 4: ZWDongle_Read ZWAVE1: rcvd 00040027063105012200d5 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.05 17:24:54 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 17:24:54 5: ZWAVE1: dispatch 00040027063105012200d5
2021.12.05 17:24:54 4: CMD:APPLICATION_COMMAND_HANDLER ID:27 ARG:063105012200d5 CB:00
2021.12.05 17:24:54 4: ZWDongle_Read ZWAVE1: rcvd 00040027063105012200d5 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.05 17:24:54 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 17:24:54 5: ZWAVE1: dispatch 00040027063105012200d5
2021.12.05 17:24:54 4: CMD:APPLICATION_COMMAND_HANDLER ID:27 ARG:063105012200d5 CB:00
2021.12.05 17:25:30 4: ZWDongle_Read ZWAVE1: rcvd 0004001c028407 (request APPLICATION_COMMAND_HANDLER), sending ACK

Auszug RAW Werte zum Event 19:47:29 Uhr

Code Auswählen Erweitern

2021.12.05 19:46:49 4: CMD:APPLICATION_COMMAND_HANDLER ID:2e ARG:063105012200b5 CB:00
2021.12.05 19:47:14 4: ZWDongle_Read ZWAVE1: rcvd 0004001c028407 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.05 19:47:14 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 19:47:14 5: ZWAVE1: dispatch 0004001c028407
2021.12.05 19:47:14 4: CMD:APPLICATION_COMMAND_HANDLER ID:1c ARG:028407 CB:00
2021.12.05 19:47:14 5: ZWDongle_Write 00131c0231042506 (e6845561,08)
2021.12.05 19:47:14 5: DevIo_SimpleWrite ZWAVE1: 010900131c0231042506ed
2021.12.05 19:47:14 5: ACK received, WaitForAck=>2 for 010900131c0231042506ed
2021.12.05 19:47:14 4: ZWDongle_Read ZWAVE1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
2021.12.05 19:47:14 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 19:47:14 5: ZWAVE1: dispatch 011301
2021.12.05 19:47:14 4: ZWDongle_Read ZWAVE1: rcvd 00130600000b (request ZW_SEND_DATA), sending ACK
2021.12.05 19:47:14 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 19:47:14 5: device ack reveived, removing 010900131c0231042506ed from dongle sendstack
2021.12.05 19:47:14 5: ZWAVE1: dispatch 00130600000b
2021.12.05 19:47:14 4: CMD:ZW_SEND_DATA ID:00 ARG:000b CB:06
2021.12.05 19:47:14 4: ZWAVE1 transmit OK for CB 06, target EG_EZ_HR_1
2021.12.05 19:47:14 4: ZWDongle_Read ZWAVE1: rcvd 0004001c063105012200d7 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.05 19:47:14 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 19:47:14 5: ZWAVE1: dispatch 0004001c063105012200d7
2021.12.05 19:47:14 4: CMD:APPLICATION_COMMAND_HANDLER ID:1c ARG:063105012200d7 CB:00
2021.12.05 19:47:16 5: ZWDongle_Write 00131c028408250b (e6845561,08)
2021.12.05 19:47:16 5: DevIo_SimpleWrite ZWAVE1: 010900131c028408250b59
2021.12.05 19:47:16 5: ACK received, WaitForAck=>2 for 010900131c028408250b59
2021.12.05 19:47:16 4: ZWDongle_Read ZWAVE1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
2021.12.05 19:47:16 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 19:47:16 5: ZWAVE1: dispatch 011301
2021.12.05 19:47:16 4: ZWDongle_Read ZWAVE1: rcvd 00130b000005 (request ZW_SEND_DATA), sending ACK
2021.12.05 19:47:16 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 19:47:16 5: device ack reveived, removing 010900131c028408250b59 from dongle sendstack
2021.12.05 19:47:16 5: ZWAVE1: dispatch 00130b000005
2021.12.05 19:47:16 4: CMD:ZW_SEND_DATA ID:00 ARG:0005 CB:0b
2021.12.05 19:47:16 4: ZWAVE1 transmit OK for CB 0b, target EG_EZ_HR_1
2021.12.05 19:47:18 4: ZWDongle_Read ZWAVE1: rcvd 0004002703300300 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.05 19:47:18 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 19:47:18 5: ZWAVE1: dispatch 0004002703300300
2021.12.05 19:47:18 4: CMD:APPLICATION_COMMAND_HANDLER ID:27 ARG:03300300 CB:00
2021.12.05 19:47:27 4: ZWDongle_Read ZWAVE1: rcvd 0004000e028407 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.05 19:47:27 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 19:47:27 5: ZWAVE1: dispatch 0004000e028407
2021.12.05 19:47:27 4: CMD:APPLICATION_COMMAND_HANDLER ID:0e ARG:028407 CB:00
2021.12.05 19:47:29 5: ZWDongle_Write 00130e028408250c (e6845561)
2021.12.05 19:47:29 5: DevIo_SimpleWrite ZWAVE1: 010900130e028408250c4c
2021.12.05 19:47:29 5: ACK received, WaitForAck=>2 for 010900130e028408250c4c
2021.12.05 19:47:29 4: ZWDongle_Read ZWAVE1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
2021.12.05 19:47:29 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 19:47:29 5: ZWAVE1: dispatch 011301
2021.12.05 19:47:29 4: ZWDongle_Read ZWAVE1: rcvd 00130c000002 (request ZW_SEND_DATA), sending ACK
2021.12.05 19:47:29 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.05 19:47:29 5: device ack reveived, removing 010900130e028408250c4c from dongle sendstack
2021.12.05 19:47:29 5: ZWAVE1: dispatch 00130c000002
2021.12.05 19:47:29 4: CMD:ZW_SEND_DATA ID:00 ARG:0002 CB:0c
2021.12.05 19:47:29 4: ZWAVE1 transmit OK for CB 0c, target EG_EZ_MS_1

[rudolfkoenig]

Soweit ich sehe, kann dim nur per SWITCH_MULTILEVEL (Hex 26) erzeugt werden.

Im 17-er Log finde ich nur einen Eintrag dafuer (0004001f03260363): das Geraet mit hexId 1f meldet den Wert Hex 63, dezimal 99.
Im 19-er Log finde ich gar kein 26.

Vermutlich uebersehe ich was.

[krusi]

Soweit ich sehe, kann dim nur per SWITCH_MULTILEVEL (Hex 26) erzeugt werden.

Sehe ich auch so.

Vermutlich uebersehe ich was.

Nein, es kommt auch keine Nachricht über das IOdev (weder vom Dimmer selbst, noch von einem anderen Device mit fehlerhafter Übertragung.
Auch keine Nachricht welche das dim Reading Dec 58 also Hex 3a enthält.

Folglich muss der Wert aus anderen Gründen intern in FHEM einem der Wakeup-Devices zugeordnet werden nachdem ein Send/Receive-Vorgang mit völlig anderer Nachricht erfolgt.
Evtl. noch irgendwelche alten Relikte im Stack ?
Die einzige Node welche dim 58 senden kann ist EG_EZ_DI_1 mit Node-ID Hex 08.

Mittlerweile haben aber wieder so gut wie alle Wakeup-Devices dieses dim Reading:

Code Auswählen Erweitern

List .* dim
Device-Name ID(HEX) Date/Time       dim Comment
====================================================================================================
EG_BA_MS_1 1a      2021-12-06 00:13:10    58  wrong assignment (Motion sensor)
EG_EZ_DI_1 08      2021-12-06 22:23:08    58  OK (Dimmer) =set value
EG_EZ_HR_1 1c      2021-12-06 13:08:15    58  wrong assignment (Thermostat)
EG_EZ_MS_1 0e      2021-12-06 07:51:23    58  wrong assignment (Motion sensor)
EG_FL_MS_1 13      2021-12-06 18:53:17    58  wrong assignment (Motion sensor)
EG_FL_TK_1 19      2021-12-06 22:36:28    58  wrong assignment (Door Sensor)
EG_KB_HR_1 21      2021-12-06 06:47:17    58  wrong assignment (Thermostat)
EG_KB_MS_1 27      2021-12-06 14:28:57    58  wrong assignment (Motion sensor)
EG_KU_MS_1 11      2021-12-06 05:08:31    58  wrong assignment (Motion sensor)
EG_SZ_MS_1 17      2021-12-06 19:23:28    58  wrong assignment (Motion sensor)
EG_WZ_DR_1 1f      2021-12-05 14:43:47    56  OK (Dimmer) =set value
EG_WZ_HR_1 1b      2021-12-06 21:50:01    58  wrong assignment (Thermostat)
OG_FL_TK_1 2e      2021-12-06 20:13:54    58  wrong assignment (Door Sensor)
OG_KB_HR_1 2f      2021-12-06 08:48:58    58  wrong assignment (Thermostat)
OG_WZ_HR_1 30      2021-12-06 05:36:17    58  wrong assignment (Thermostat)
UG_BU_TK_1 2d      2021-12-06 01:36:09    58  wrong assignment (Door Sensor)
UG_FL_TK_1 25      2021-12-06 11:39:58    58  wrong assignment (Door Sensor)

Am Beispiel von EG_WZ_HR_1, Thermostatventil, Node-ID Hex 1b um 21:50:01

Code Auswählen Erweitern

2021.12.06 21:49:59 4: ZWDongle_Read ZWAVE1: rcvd 0004001b028407 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.06 21:49:59 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.06 21:49:59 5: ZWAVE1: dispatch 0004001b028407
2021.12.06 21:49:59 4: CMD:APPLICATION_COMMAND_HANDLER ID:1b ARG:028407 CB:00
2021.12.06 21:49:59 5: ZWDongle_Write 00131b023104253d (e6845561)
2021.12.06 21:49:59 5: DevIo_SimpleWrite ZWAVE1: 010900131b023104253dd1
2021.12.06 21:49:59 3: Wake-Up Event EG_WZ_HR_1 (get ThermostatMode)
2021.12.06 21:49:59 3: ZWave get EG_WZ_HR_1 thermostatMode
2021.12.06 21:49:59 5: ACK received, WaitForAck=>2 for 010900131b023104253dd1
2021.12.06 21:49:59 4: ZWDongle_Read ZWAVE1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
2021.12.06 21:49:59 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.06 21:49:59 5: ZWAVE1: dispatch 011301
2021.12.06 21:49:59 4: ZWDongle_Read ZWAVE1: rcvd 00133d000002 (request ZW_SEND_DATA), sending ACK
2021.12.06 21:49:59 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.06 21:49:59 5: device ack reveived, removing 010900131b023104253dd1 from dongle sendstack
2021.12.06 21:49:59 5: ZWAVE1: dispatch 00133d000002
2021.12.06 21:49:59 4: CMD:ZW_SEND_DATA ID:00 ARG:0002 CB:3d
2021.12.06 21:49:59 4: ZWAVE1 transmit OK for CB 3d, target EG_WZ_HR_1
2021.12.06 21:49:59 4: ZWDongle_Read ZWAVE1: rcvd 0004001b063105012200d2 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.06 21:49:59 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.06 21:49:59 5: ZWAVE1: dispatch 0004001b063105012200d2
2021.12.06 21:49:59 4: CMD:APPLICATION_COMMAND_HANDLER ID:1b ARG:063105012200d2 CB:00
2021.12.06 21:49:59 5: ZWDongle_Write 00131b0240022543 (e6845561)
2021.12.06 21:49:59 5: DevIo_SimpleWrite ZWAVE1: 010900131b0240022543d8
2021.12.06 21:49:59 5: ACK received, WaitForAck=>2 for 010900131b0240022543d8
2021.12.06 21:49:59 4: ZWDongle_Read ZWAVE1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
2021.12.06 21:49:59 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.06 21:49:59 5: ZWAVE1: dispatch 011301
2021.12.06 21:49:59 4: ZWDongle_Read ZWAVE1: rcvd 001343000001 (request ZW_SEND_DATA), sending ACK
2021.12.06 21:49:59 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.06 21:49:59 5: device ack reveived, removing 010900131b0240022543d8 from dongle sendstack
2021.12.06 21:49:59 5: ZWAVE1: dispatch 001343000001
2021.12.06 21:49:59 4: CMD:ZW_SEND_DATA ID:00 ARG:0001 CB:43
2021.12.06 21:49:59 4: ZWAVE1 transmit OK for CB 43, target EG_WZ_HR_1
2021.12.06 21:49:59 4: ZWDongle_Read ZWAVE1: rcvd 0004001b03400301 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.06 21:49:59 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.06 21:49:59 5: ZWAVE1: dispatch 0004001b03400301
2021.12.06 21:49:59 4: CMD:APPLICATION_COMMAND_HANDLER ID:1b ARG:03400301 CB:00
2021.12.06 21:50:01 5: ZWDongle_Write 00131b0284082544 (e6845561)
2021.12.06 21:50:01 5: DevIo_SimpleWrite ZWAVE1: 010900131b028408254411
2021.12.06 21:50:01 5: ACK received, WaitForAck=>2 for 010900131b028408254411
2021.12.06 21:50:01 4: ZWDongle_Read ZWAVE1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
2021.12.06 21:50:01 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.06 21:50:01 5: ZWAVE1: dispatch 011301
2021.12.06 21:50:01 4: ZWDongle_Read ZWAVE1: rcvd 001344000002 (request ZW_SEND_DATA), sending ACK
2021.12.06 21:50:01 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.06 21:50:01 5: device ack reveived, removing 010900131b028408254411 from dongle sendstack
2021.12.06 21:50:01 5: ZWAVE1: dispatch 001344000002
2021.12.06 21:50:01 4: CMD:ZW_SEND_DATA ID:00 ARG:0002 CB:44
2021.12.06 21:50:01 4: ZWAVE1 transmit OK for CB 44, target EG_WZ_HR_1
2021.12.06 21:50:08 4: ZWDongle_Read ZWAVE1: rcvd 0004000e03300300 (request APPLICATION_COMMAND_HANDLER), sending ACK

Die Zuordnung erfolgt immer dann, wenn eigentlich ein völlig anderes Reading einem Wakeup-Device zugeordnet werden müsste.
Im Fall oben kommt die Antwort auf ein "get thermostatMode". Dabei wird im gleichen Zuge das dim 58 reading zugeordnet.

Betrachtet man alle Readings eines anderes Wakeup-Devices (z.b. EG_FL_MS_1, ein Motion-Sensor mit Node-ID Hex 13) fällt auf:
Außer dem falschen dim Reading um 18:53:17 taucht für heute auch ein thermostatSetpointSet 17 Reading auf :

Code Auswählen Erweitern

READINGS:
     2021-12-06 18:53:17   dim             58
     2021-12-06 16:53:06   thermostatSetpointSet 17


Damit es noch etwas kurioser wird: 1,5min vor diesem falschen Reading wurde wirklich ein set dim 58 an EG_EZ_DI_1 mit Node-ID Hex 08 abgesetzt (aktiviert durch Motion detection)
Aber warum danach ein Reading auf diesem Device und dann auch noch thermostatSetpointSet 17 ? (17°C Soll kann auch nur zwischen 08:30 und 11:30 gesetzt sein, nicht um 16:53)
Und warum 2 Stunden später das Reading dim 58 ?

Code Auswählen Erweitern

2021.12.06 16:51:28 3: Watchdog Licht_EZ Set: initial 5min (Motion)
2021.12.06 16:51:28 3: ZWave set EG_EZ_DI_1 dim 58
2021.12.06 16:51:28 5: ZWDongle_Write 00130807560126013aCF83252e (e6845561)
2021.12.06 16:51:28 5: DevIo_SimpleWrite ZWAVE1: 010e00130807560126013aCF83252ee0
2021.12.06 16:51:28 5: ACK received, WaitForAck=>2 for 010e00130807560126013aCF83252ee0
2021.12.06 16:51:28 4: ZWDongle_Read ZWAVE1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
2021.12.06 16:51:28 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.06 16:51:28 5: ZWAVE1: dispatch 011301
2021.12.06 16:51:28 4: ZWDongle_Read ZWAVE1: rcvd 00132e000002 (request ZW_SEND_DATA), sending ACK
2021.12.06 16:51:28 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.06 16:51:28 5: device ack reveived, removing 010e00130807560126013aCF83252ee0 from dongle sendstack
2021.12.06 16:51:28 5: ZWAVE1: dispatch 00132e000002
2021.12.06 16:51:28 4: CMD:ZW_SEND_DATA ID:00 ARG:0002 CB:2e
2021.12.06 16:51:28 4: ZWAVE1 transmit OK for CB 2e, target EG_EZ_DI_1
2021.12.06 16:51:28 4: ZWDongle_Read ZWAVE1: rcvd 000400080326033a (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.06 16:51:28 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.06 16:51:28 5: ZWAVE1: dispatch 000400080326033a
2021.12.06 16:51:28 4: CMD:APPLICATION_COMMAND_HANDLER ID:08 ARG:0326033a CB:00
2021.12.06 16:51:28 4: ZWDongle_Read ZWAVE1: rcvd 0004000806310504220036 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.06 16:51:28 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.06 16:51:29 5: ZWAVE1: dispatch 0004000806310504220036
2021.12.06 16:51:29 4: CMD:APPLICATION_COMMAND_HANDLER ID:08 ARG:06310504220036 CB:00
2021.12.06 16:51:33 4: ZWDongle_Read ZWAVE1: rcvd 000400080631050422008c (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.06 16:51:33 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.06 16:51:33 5: ZWAVE1: dispatch 000400080631050422008c
2021.12.06 16:51:34 4: CMD:APPLICATION_COMMAND_HANDLER ID:08 ARG:0631050422008c CB:00
2021.12.06 16:51:34 3: Notify n_Licht_EZ Event: power: 14.0 W
2021.12.06 16:51:34 4: ZWDongle_Read ZWAVE1: rcvd 0004000d03300300 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.06 16:51:34 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.06 16:51:34 5: ZWAVE1: dispatch 0004000d03300300
2021.12.06 16:51:34 4: CMD:APPLICATION_COMMAND_HANDLER ID:0d ARG:03300300 CB:00
2021.12.06 16:51:34 4: ZWDongle_Read ZWAVE1: rcvd 0004000d033003ff (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.06 16:51:34 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.06 16:51:34 5: ZWAVE1: dispatch 0004000d033003ff
2021.12.06 16:51:34 4: CMD:APPLICATION_COMMAND_HANDLER ID:0d ARG:033003ff CB:00
2021.12.06 16:51:35 3: Notify n_Licht_WZ Event: MSaddN
2021.12.06 16:51:35 3: Watchdog Licht_WZ Set: additional 10min (Motion)
2021.12.06 16:51:49 4: ZWDongle_Read ZWAVE1: rcvd 00040011063105012200c3 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.06 16:51:49 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.06 16:51:49 5: ZWAVE1: dispatch 00040011063105012200c3
2021.12.06 16:51:49 4: CMD:APPLICATION_COMMAND_HANDLER ID:11 ARG:063105012200c3 CB:00
2021.12.06 16:51:53 4: ZWDongle_Read ZWAVE1: rcvd 00040011063105030a0000 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.06 16:51:53 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.06 16:51:53 5: ZWAVE1: dispatch 00040011063105030a0000
2021.12.06 16:51:53 4: CMD:APPLICATION_COMMAND_HANDLER ID:11 ARG:063105030a0000 CB:00
2021.12.06 16:52:12 4: ZWDongle_Read ZWAVE1: rcvd 0004000d063105030a0002 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.06 16:52:12 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.06 16:52:12 5: ZWAVE1: dispatch 0004000d063105030a0002
2021.12.06 16:52:12 4: CMD:APPLICATION_COMMAND_HANDLER ID:0d ARG:063105030a0002 CB:00
2021.12.06 16:52:28 4: ZWDongle_Read ZWAVE1: rcvd 0004000e03300300 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.06 16:52:28 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.06 16:52:28 5: ZWAVE1: dispatch 0004000e03300300
2021.12.06 16:52:28 4: CMD:APPLICATION_COMMAND_HANDLER ID:0e ARG:03300300 CB:00
2021.12.06 16:52:29 4: ZWDongle_Read ZWAVE1: rcvd 0004000e033003ff (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.06 16:52:29 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.06 16:52:29 5: ZWAVE1: dispatch 0004000e033003ff
2021.12.06 16:52:29 4: CMD:APPLICATION_COMMAND_HANDLER ID:0e ARG:033003ff CB:00
2021.12.06 16:52:29 3: Notify n_Licht_EZ Event: MSaddN
2021.12.06 16:52:29 3: Watchdog Licht_EZ Set: additional 10min (Motion)
2021.12.06 16:53:04 4: ZWDongle_Read ZWAVE1: rcvd 00040013028407 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.06 16:53:04 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.06 16:53:04 5: ZWAVE1: dispatch 00040013028407
2021.12.06 16:53:04 4: CMD:APPLICATION_COMMAND_HANDLER ID:13 ARG:028407 CB:00
2021.12.06 16:53:06 5: ZWDongle_Write 001313028408252f (e6845561)
2021.12.06 16:53:06 5: DevIo_SimpleWrite ZWAVE1: 0109001313028408252f72
2021.12.06 16:53:06 5: ACK received, WaitForAck=>2 for 0109001313028408252f72
2021.12.06 16:53:06 4: ZWDongle_Read ZWAVE1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
2021.12.06 16:53:06 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.06 16:53:06 5: ZWAVE1: dispatch 011301
2021.12.06 16:53:06 4: ZWDongle_Read ZWAVE1: rcvd 00132f000002 (request ZW_SEND_DATA), sending ACK
2021.12.06 16:53:06 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.06 16:53:06 5: device ack reveived, removing 0109001313028408252f72 from dongle sendstack
2021.12.06 16:53:06 5: ZWAVE1: dispatch 00132f000002
2021.12.06 16:53:06 4: CMD:ZW_SEND_DATA ID:00 ARG:0002 CB:2f
2021.12.06 16:53:06 4: ZWAVE1 transmit OK for CB 2f, target EG_FL_MS_1
2021.12.06 16:53:07 4: ZWDongle_Read ZWAVE1: rcvd 00040013063105012200da (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.06 16:53:07 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.06 16:53:07 5: ZWAVE1: dispatch 00040013063105012200da
2021.12.06 16:53:07 4: CMD:APPLICATION_COMMAND_HANDLER ID:13 ARG:063105012200da CB:00
2021.12.06 16:53:11 4: ZWDongle_Read ZWAVE1: rcvd 0004000f06310504220000 (request APPLICATION_COMMAND_HANDLER), sending ACK

[rudolfkoenig]

Evtl. noch irgendwelche alten Relikte im Stack ?

Unwahrscheinlich, dafuer muessten wir auch eine Log Meldung mit "CMD:APPLICATION_COMMAND_HANDLER" sehen.

Ich wuerde ein notify fuer die "falschen" Geraete aufsetzen, was ein stacktrace produziert, so in etwa:

Code Auswählen Erweitern

define nx notify *_MS_.*:dim.* { Log 1, "STACKTRACE for $NAME";; stacktrace() }

[krusi]

Ich wuerde ein notify fuer die "falschen" Geraete aufsetzen, was ein stacktrace produziert, so in etwa:

Danke für die Unterstützung, genau so eine Möglichkeit suche ich (bin leider einfach nicht tief genug drin).
Werde es sofort ausprobieren - wäre ja gelacht, wenn man der Sache nicht auf die Schliche kommt 

[krusi]

Werde leider nicht schlau aus der Sache.
Selbes Spiel: alle Readings bereinigt, IOdev Log an, Stacktrace bei dim auf Motion-Sensoren

Ausgangszustand: list .* dim

Code Auswählen Erweitern

list .* dim
EG_EZ_DI_1 (ID 08Hex) => dim 57
EZ_WZ_DR_1 (ID 01fHex) => dim 60

Einige Stunden später mit list .* dim

Code Auswählen Erweitern


EG_EZ_DI_1           2021-12-08 06:18:56    57
EG_WZ_DR_1           2021-12-07 23:53:32    60
EG_WZ_HR_1           2021-12-08 03:07:42    60
EG_WZ_MS_1           2021-12-08 07:09:24    57
EG_WZ_TK_1           2021-12-08 03:05:02    57
OG_KB_HR_1           2021-12-08 05:24:11    57

Diesmal der Log zu Motion-Sensor EG_WZ_MS_1 (ID 0dHex) zum Event um 07:09:24:

Code Auswählen Erweitern

2021.12.08 07:09:22 4: ZWDongle_Read ZWAVE1: rcvd 0004000d028407 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.08 07:09:22 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.08 07:09:22 5: ZWAVE1: dispatch 0004000d028407
2021.12.08 07:09:22 4: CMD:APPLICATION_COMMAND_HANDLER ID:0d ARG:028407 CB:00
2021.12.08 07:09:24 5: ZWDongle_Write 00130d0284082549 (e6845561)
2021.12.08 07:09:24 5: DevIo_SimpleWrite ZWAVE1: 010900130d02840825490a
2021.12.08 07:09:24 5: ACK received, WaitForAck=>2 for 010900130d02840825490a
2021.12.08 07:09:24 4: ZWDongle_Read ZWAVE1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
2021.12.08 07:09:24 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.08 07:09:24 5: ZWAVE1: dispatch 011301
2021.12.08 07:09:24 4: ZWDongle_Read ZWAVE1: rcvd 001349000002 (request ZW_SEND_DATA), sending ACK
2021.12.08 07:09:24 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.08 07:09:24 5: device ack reveived, removing 010900130d02840825490a from dongle sendstack
2021.12.08 07:09:24 5: ZWAVE1: dispatch 001349000002
2021.12.08 07:09:24 4: CMD:ZW_SEND_DATA ID:00 ARG:0002 CB:49
2021.12.08 07:09:24 4: ZWAVE1 transmit OK for CB 49, target EG_WZ_MS_1
2021.12.08 07:09:24 1: STACKTRACE for EG_WZ_MS_1
2021.12.08 07:09:24 1: stacktrace:
2021.12.08 07:09:24 1:     (eval)                              called by fhem.pl (1160)
2021.12.08 07:09:24 1:     main::AnalyzePerlCommand            called by fhem.pl (1189)
2021.12.08 07:09:24 1:     main::AnalyzeCommand                called by fhem.pl (1116)
2021.12.08 07:09:24 1:     main::AnalyzeCommandChain           called by ./FHEM/91_notify.pm (122)
2021.12.08 07:09:24 1:     main::notify_Exec                   called by fhem.pl (3895)
2021.12.08 07:09:24 1:     main::CallFn                        called by fhem.pl (3812)
2021.12.08 07:09:24 1:     main::DoTrigger                     called by fhem.pl (4192)
2021.12.08 07:09:24 1:     main::Dispatch                      called by ./FHEM/00_ZWDongle.pm (983)
2021.12.08 07:09:24 1:     main::ZWDongle_Parse                called by ./FHEM/00_ZWDongle.pm (878)
2021.12.08 07:09:24 1:     main::ZWDongle_Read                 called by fhem.pl (3895)
2021.12.08 07:09:24 1:     main::CallFn                        called by fhem.pl (773)

-Device meldet sich mit einem Wakeup-Event
-es liegt eine Nachricht in der Queue
-diese wird erfolgreich gesendet
-danach schlägt das notify für den dim an

[rudolfkoenig]

Ich meine die Ursache ist setReadingOnAck.

Das wird realisiert, indem man zum callbackId den Befehl merkt, und beim Eintreffen der ack mit diesem callbackid ein Event mit dem Befehl generiert. callbackid ist ein Byte, und wird beim Generieren des Befehls erzeugt, und nicht beim Versenden. Das ist beim Mix von WakeUp Geraeten und vielen Befehlen problematisch.

Ich hoffe das jetzt gefixt zu haben, bitte testen.

[krusi]

Code Auswählen Erweitern

Ich hoffe das jetzt gefixt zu haben, bitte testen.
Rückmeldung nach den ersten 20h Betrieb: leider noch keine große Veränderung zu beobachten.
-4 Wakeup-Devices erhalten das "dim" Reading des Dimmers
-7 Wakeup-Devices (Motionsensoren+Türkontakte) erhalten ein "thermostatSetpointSet" Reading von verschiedenen Thermostaten

Kann ich aktuell mit irgendwelchen Logs zur Abnalyse beitragen ?
Soll ich testweise das setReadingOnAck Attribut auf 0 setzen um sicherzugehen, dass das Verhalten bei dieser Kombination ausgelöst wird (im Normalbetrieb bräuchte ich später diese Funktion allerdings wieder dringend, sollte dann zudem wissen, ob der Test mit dem neuen oder mit dem ursprünglichen Code durchgeführt werden soll).

[rudolfkoenig]

Soll ich testweise das setReadingOnAck Attribut auf 0 setzen [...]

Das waere hilfreich. Da die Aenderung nur das aktivierte setReadingOnAck betrifft, ist es egal ob es mit dem neuen oder alten Code.

Wenn es ohne Attribut keine Probleme gibt, dann bitte Attribut aktivieren, und in ZWave.pm, Zeile 5237 Folgendes einbauen:

Code Auswählen Erweitern

              Log 1, "ACK: $lname $msg $callbackid => $ackCmd";


[krusi]

Hier die Ergebnisse der Tests:

Wird setReadingOnAck auf 0 gesetzt tauchen die fehlerhaften Zuordnungen bei den Wake-Up-Geräten wie vermutet nicht auf.
Dafür fehlen aber logischerweise Werte bei Aktoren, welche durch diese Funktion automatisch upgedated werden sollen.

Nach erneuter Aktivierung von setReadingOnAck und zusätzlichem Log in ZWave.pm ergibt sich nach einigen Stunden das bekannte Bild:

Code Auswählen Erweitern

list .* dim

=> OK (ist Dimmer):
EG_EZ_DI_1           2021-12-13 06:39:34    57 (OK)
EG_WZ_DR_1           2021-12-09 13:48:08    60 (OK)
====================================================
=> falsch (ist Motion-Sensor / Türkontakt / Thermostat):
EG_BA_MS_1           2021-12-12 23:00:37    57
EG_EZ_HR_1           2021-12-13 02:17:42    57
EG_EZ_MS_1           2021-12-12 10:00:29    57
EG_FL_MS_1           2021-12-12 03:06:54    57
EG_KF_MS_1           2021-12-13 06:28:01    57
EG_KU_MS_1           2021-12-12 04:47:45    57
EG_SZ_MS_1           2021-12-13 05:57:25    57
EG_WZ_HR_1           2021-12-13 04:58:23    57
EG_WZ_MS_1           2021-12-12 01:14:40    57
OG_FL_TK_1           2021-12-12 04:39:55    57
OG_KB_HR_1           2021-12-13 06:55:21    57
UG_FL_TK_1           2021-12-13 02:04:52    57

Code Auswählen Erweitern


list .* thermostatSetpointSet

=> OK (ist Thermostat)
EG_BA_HR_2           2021-12-13 05:30:01    25
EG_EZ_HR_1           2021-12-13 05:32:26    21
EG_KB_HR_1           2021-12-12 19:05:54    17
EG_KF_HR_1           2021-12-12 19:33:01    19
EG_WZ_HR_1           2021-12-13 06:35:19    21
OG_KB_HR_1           2021-12-12 19:39:37    17
OG_WZ_HR_1           2021-12-13 06:35:39    22
====================================================
=> falsch (ist Motion-Sensor / Türkontakt):
EG_FL_TK_1           2021-12-13 02:17:58    17
EG_KF_MS_1           2021-12-12 13:31:03    20
EG_SZ_MS_1           2021-12-13 01:58:02    18
EG_WZ_MS_1           2021-12-11 12:47:47    18
OG_FL_TK_1           2021-12-11 12:22:52    20
UG_BU_TK_1           2021-12-12 19:32:58    25

Zudem fällt z.B. auch auf, dass keiner der Motion-Sensoren mehr erfolgreich ein Neighborupdate durchführt:

Code Auswählen Erweitern

list .*_MS_1 neighborUpdate
EG_BA_MS_1           2021-12-13 06:01:40    failed
EG_EZ_MS_1           2021-12-13 06:35:46    failed
EG_FL_MS_1           2021-12-13 07:11:00    failed
EG_KB_MS_1           2021-12-13 05:27:32    failed
EG_KF_MS_1           2021-12-13 06:28:22    failed
EG_KU_MS_1           2021-12-13 06:44:06    failed
EG_SZ_MS_1           2021-12-13 06:27:50    failed
EG_WZ_MS_1           2021-12-13 05:38:23    failed

Beispiel Log für thermostatSetpointSet auf UG_BU_TK_1 um 2021-12-12 19:32:58
-der Wert kommt aus der letzten Kommunikation mit EG_WZ_HR_1
-danach kommt ein Wakeup-Event von UG_BU_TK_1
-bei dieser Kommunikation wird dann der thermostatSetpointSet auf den Türkontakt zugeordnet

Code Auswählen Erweitern

2021.12.12 19:32:34 5: ACK received, WaitForAck=>2 for 010900131b028408257b2e
2021.12.12 19:32:34 4: ZWDongle_Read ZWAVE1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
2021.12.12 19:32:34 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.12 19:32:34 5: ZWAVE1: dispatch 011301
2021.12.12 19:32:34 4: ZWDongle_Read ZWAVE1: rcvd 00137b000002 (request ZW_SEND_DATA), sending ACK
2021.12.12 19:32:34 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.12 19:32:34 5: device ack reveived, removing 010900131b028408257b2e from dongle sendstack
2021.12.12 19:32:34 5: ZWAVE1: dispatch 00137b000002
2021.12.12 19:32:34 4: CMD:ZW_SEND_DATA ID:00 ARG:0002 CB:7b
2021.12.12 19:32:34 4: ZWAVE1 transmit OK for CB 7b, target EG_WZ_HR_1
2021.12.12 19:32:34 1: ACK: EG_WZ_HR_1 00137b000002 7b => get thermostatMode
2021.12.12 19:32:55 4: ZWDongle_Read ZWAVE1: rcvd 0004001603300300 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.12 19:32:55 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.12 19:32:55 5: ZWAVE1: dispatch 0004001603300300
2021.12.12 19:32:55 4: CMD:APPLICATION_COMMAND_HANDLER ID:16 ARG:03300300 CB:00
2021.12.12 19:32:56 4: ZWDongle_Read ZWAVE1: rcvd 0004002d06310501220097 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.12 19:32:56 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.12 19:32:56 5: ZWAVE1: dispatch 0004002d06310501220097
2021.12.12 19:32:56 4: CMD:APPLICATION_COMMAND_HANDLER ID:2d ARG:06310501220097 CB:00
2021.12.12 19:32:56 3: Notify n_TK_BU Event: temperature: 15.1 C
2021.12.12 19:32:56 4: ZWDongle_Read ZWAVE1: rcvd 0004002d028407 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.12 19:32:56 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.12 19:32:56 5: ZWAVE1: dispatch 0004002d028407
2021.12.12 19:32:56 4: CMD:APPLICATION_COMMAND_HANDLER ID:2d ARG:028407 CB:00
2021.12.12 19:32:56 3: Notify n_TK_BU Event: wakeup: notification
2021.12.12 19:32:56 4: ZWDongle_Read ZWAVE1: rcvd 0004101603300300 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.12 19:32:56 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.12 19:32:56 5: ZWAVE1: dispatch 0004101603300300
2021.12.12 19:32:56 4: CMD:APPLICATION_COMMAND_HANDLER ID:16 ARG:03300300 CB:10
2021.12.12 19:32:57 4: ZWDongle_Read ZWAVE1: rcvd 0004101603300300 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.12 19:32:57 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.12 19:32:57 5: ZWAVE1: dispatch 0004101603300300
2021.12.12 19:32:57 4: CMD:APPLICATION_COMMAND_HANDLER ID:16 ARG:03300300 CB:10
2021.12.12 19:32:57 4: ZWDongle_Read ZWAVE1: rcvd 0004101603300300 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.12 19:32:57 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.12 19:32:57 5: ZWAVE1: dispatch 0004101603300300
2021.12.12 19:32:57 4: CMD:APPLICATION_COMMAND_HANDLER ID:16 ARG:03300300 CB:10
2021.12.12 19:32:57 4: ZWDongle_Read ZWAVE1: rcvd 0004101603300300 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.12 19:32:57 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.12 19:32:57 5: ZWAVE1: dispatch 0004101603300300
2021.12.12 19:32:57 4: CMD:APPLICATION_COMMAND_HANDLER ID:16 ARG:03300300 CB:10
2021.12.12 19:32:57 4: ZWDongle_Read ZWAVE1: rcvd 0004101603300300 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.12 19:32:57 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.12 19:32:57 5: ZWAVE1: dispatch 0004101603300300
2021.12.12 19:32:57 4: CMD:APPLICATION_COMMAND_HANDLER ID:16 ARG:03300300 CB:10
2021.12.12 19:32:57 4: ZWDongle_Read ZWAVE1: rcvd 0004101603300300 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.12 19:32:57 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.12 19:32:57 5: ZWAVE1: dispatch 0004101603300300
2021.12.12 19:32:57 4: CMD:APPLICATION_COMMAND_HANDLER ID:16 ARG:03300300 CB:10
2021.12.12 19:32:57 4: ZWDongle_Read ZWAVE1: rcvd 0004101603300300 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.12 19:32:57 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.12 19:32:57 5: ZWAVE1: dispatch 0004101603300300
2021.12.12 19:32:57 4: CMD:APPLICATION_COMMAND_HANDLER ID:16 ARG:03300300 CB:10
2021.12.12 19:32:57 4: ZWDongle_Read ZWAVE1: rcvd 0004101603300300 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.12 19:32:57 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.12 19:32:57 5: ZWAVE1: dispatch 0004101603300300
2021.12.12 19:32:57 4: CMD:APPLICATION_COMMAND_HANDLER ID:16 ARG:03300300 CB:10
2021.12.12 19:32:58 5: ZWDongle_Write 00132d028408257c (e6845561)
2021.12.12 19:32:58 5: DevIo_SimpleWrite ZWAVE1: 010900132d028408257c1f
2021.12.12 19:32:58 5: ACK received, WaitForAck=>2 for 010900132d028408257c1f
2021.12.12 19:32:58 4: ZWDongle_Read ZWAVE1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
2021.12.12 19:32:58 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.12 19:32:58 5: ZWAVE1: dispatch 011301
2021.12.12 19:32:58 4: ZWDongle_Read ZWAVE1: rcvd 00137c00000e (request ZW_SEND_DATA), sending ACK
2021.12.12 19:32:58 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.12 19:32:58 5: device ack reveived, removing 010900132d028408257c1f from dongle sendstack
2021.12.12 19:32:58 5: ZWAVE1: dispatch 00137c00000e
2021.12.12 19:32:58 4: CMD:ZW_SEND_DATA ID:00 ARG:000e CB:7c
2021.12.12 19:32:58 4: ZWAVE1 transmit OK for CB 7c, target UG_BU_TK_1
2021.12.12 19:32:58 1: ACK: UG_BU_TK_1 00137c00000e 7c => set thermostatSetpointSet 25
2021.12.12 19:32:58 3: Notify n_TK_BU Event: thermostatSetpointSet: 25

Beispiel für dim auf EG_BA_MS_1 2021-12-12 23:00:37
-voraus geht eine Motion-Detection welche ein set EG_EZ_DI_1 dim 57 zur Folge hat
-danach kommt ein Wake-Up-Event von EG_BA_MS_1
-bei dieser Kommunikation wird dann der letzte dim-Wert auf den Motionsensor zugeordnet

Code Auswählen Erweitern


2021.12.12 23:00:32 3: Notify n_Licht_EZ Event: MSon
2021.12.12 23:00:32 3: Watchdog Licht_EZ Set: initial 5min (Motion)
2021.12.12 23:00:32 3: ZWave set EG_EZ_DI_1 dim 57
2021.12.12 23:00:32 5: ZWDongle_Write 001308075601260139FFE025fe (e6845561)
2021.12.12 23:00:32 5: DevIo_SimpleWrite ZWAVE1: 010e001308075601260139FFE025fe60
2021.12.12 23:00:32 5: ACK received, WaitForAck=>2 for 010e001308075601260139FFE025fe60
2021.12.12 23:00:32 4: ZWDongle_Read ZWAVE1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
2021.12.12 23:00:32 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.12 23:00:32 5: ZWAVE1: dispatch 011301
2021.12.12 23:00:32 4: ZWDongle_Read ZWAVE1: rcvd 0013fe00000f (request ZW_SEND_DATA), sending ACK
2021.12.12 23:00:32 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.12 23:00:32 5: device ack reveived, removing 010e001308075601260139FFE025fe60 from dongle sendstack
2021.12.12 23:00:32 5: ZWAVE1: dispatch 0013fe00000f
2021.12.12 23:00:32 4: CMD:ZW_SEND_DATA ID:00 ARG:000f CB:fe
2021.12.12 23:00:32 4: ZWAVE1 transmit OK for CB fe, target EG_EZ_DI_1
2021.12.12 23:00:32 1: ACK: EG_EZ_DI_1 0013fe00000f fe => set dim 57
2021.12.12 23:00:33 4: ZWDongle_Read ZWAVE1: rcvd 0004000806310504220011 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.12 23:00:33 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.12 23:00:33 5: ZWAVE1: dispatch 0004000806310504220011
2021.12.12 23:00:33 4: CMD:APPLICATION_COMMAND_HANDLER ID:08 ARG:06310504220011 CB:00
2021.12.12 23:00:33 4: ZWDongle_Read ZWAVE1: rcvd 0004000803260339 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.12 23:00:33 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.12 23:00:33 5: ZWAVE1: dispatch 0004000803260339
2021.12.12 23:00:33 4: CMD:APPLICATION_COMMAND_HANDLER ID:08 ARG:03260339 CB:00
2021.12.12 23:00:35 4: ZWDongle_Read ZWAVE1: rcvd 0004001a028407 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.12 23:00:35 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.12 23:00:35 5: ZWAVE1: dispatch 0004001a028407
2021.12.12 23:00:35 4: CMD:APPLICATION_COMMAND_HANDLER ID:1a ARG:028407 CB:00
2021.12.12 23:00:37 5: ZWDongle_Write 00131a02840825ff (e6845561,28)
2021.12.12 23:00:37 5: DevIo_SimpleWrite ZWAVE1: 010900131a02840825ffab
2021.12.12 23:00:37 5: ACK received, WaitForAck=>2 for 010900131a02840825ffab
2021.12.12 23:00:37 4: ZWDongle_Read ZWAVE1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
2021.12.12 23:00:37 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.12 23:00:37 5: ZWAVE1: dispatch 011301
2021.12.12 23:00:37 4: ZWDongle_Read ZWAVE1: rcvd 0013ff000004 (request ZW_SEND_DATA), sending ACK
2021.12.12 23:00:37 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.12 23:00:37 5: device ack reveived, removing 010900131a02840825ffab from dongle sendstack
2021.12.12 23:00:37 5: ZWAVE1: dispatch 0013ff000004
2021.12.12 23:00:37 4: CMD:ZW_SEND_DATA ID:00 ARG:0004 CB:ff
2021.12.12 23:00:37 4: ZWAVE1 transmit OK for CB ff, target EG_BA_MS_1
2021.12.12 23:00:37 1: ACK: EG_BA_MS_1 0013ff000004 ff => set dim 57
2021.12.12 23:00:37 4: ZWDongle_Read ZWAVE1: rcvd 0004001a06310501220102 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.12 23:00:37 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.12 23:00:37 5: ZWAVE1: dispatch 0004001a06310501220102

Beispiel für NeighborUpdate an EG_KU_MS_1

Code Auswählen Erweitern

2021.12.13 06:43:57 3: Wake-Up Event EG_KU_MS_1 (set NU)
2021.12.13 06:43:57 3: ZWave set EG_KU_MS_1 neighborUpdate
2021.12.13 06:43:57 5: ZWDongle_Write 00481137 (e6845561)
2021.12.13 06:43:57 5: DevIo_SimpleWrite ZWAVE1: 01050048113794
2021.12.13 06:43:57 5: ACK received, removing 01050048113794 from dongle sendstack
2021.12.13 06:43:57 4: ZWDongle_Read ZWAVE1: rcvd 00483721 (request ZW_REQUEST_NODE_NEIGHBOR_UPDATE), sending ACK
2021.12.13 06:43:57 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.13 06:43:57 5: ZWAVE1: dispatch 00483721
2021.12.13 06:43:57 4: CMD:ZW_REQUEST_NODE_NEIGHBOR_UPDATE ID:21 ARG: CB:37
2021.12.13 06:43:59 5: ZWDongle_Write 0013110284082538 (e6845561)
2021.12.13 06:43:59 5: DevIo_SimpleWrite ZWAVE1: 0109001311028408253867
2021.12.13 06:43:59 5: ACK received, WaitForAck=>2 for 0109001311028408253867
2021.12.13 06:43:59 4: ZWDongle_Read ZWAVE1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
2021.12.13 06:43:59 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.13 06:43:59 5: ZWAVE1: dispatch 011301
2021.12.13 06:44:01 4: no response from device, removing 0109001311028408253867 from dongle sendstack
2021.12.13 06:44:02 4: ZWDongle_Read ZWAVE1: rcvd 00133801012b (request ZW_SEND_DATA), sending ACK
2021.12.13 06:44:02 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.13 06:44:02 5: ZWAVE1: dispatch 00133801012b
2021.12.13 06:44:02 4: CMD:ZW_SEND_DATA ID:01 ARG:012b CB:38
2021.12.13 06:44:02 2: ZWAVE1 transmit NO_ACK for CB 38, target EG_KU_MS_1
2021.12.13 06:44:03 4: ZWDongle_Read ZWAVE1: rcvd 00040011063105012200c5 (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.13 06:44:03 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.13 06:44:03 5: ZWAVE1: dispatch 00040011063105012200c5
2021.12.13 06:44:03 4: CMD:APPLICATION_COMMAND_HANDLER ID:11 ARG:063105012200c5 CB:00
2021.12.13 06:44:06 4: ZWDongle_Read ZWAVE1: rcvd 00483723 (request ZW_REQUEST_NODE_NEIGHBOR_UPDATE), sending ACK
2021.12.13 06:44:06 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.13 06:44:06 5: ZWAVE1: dispatch 00483723
2021.12.13 06:44:06 4: CMD:ZW_REQUEST_NODE_NEIGHBOR_UPDATE ID:23 ARG: CB:37
2021.12.13 06:44:36 4: ZWDongle_Read ZWAVE1: rcvd 00040016033003ff (request APPLICATION_COMMAND_HANDLER), sending ACK
2021.12.13 06:44:36 5: DevIo_SimpleWrite ZWAVE1: 06
2021.12.13 06:44:36 5: ZWAVE1: dispatch 00040016033003ff
2021.12.13 06:44:36 4: CMD:APPLICATION_COMMAND_HANDLER ID:16 ARG:033003ff CB:00
2021.12.13 06:44:36 3: Notify n_Licht_KF Event: MSadd

[rudolfkoenig]

Wird setReadingOnAck auf 0 gesetzt tauchen die fehlerhaften Zuordnungen bei den Wake-Up-Geräten wie vermutet nicht auf.

Na immerhin.
Aus den restlichen Logs bin ich nicht schlau geworden, ich kann z.Zt. das Problem nur mit dem alten Code erklaeren, was vmtl. doch nicht der Fall ist.

Ich habe jetzt eine neue Modulversion mit etwas besseren debugging eingebaut.
Kannst Du bitte mit dieser Version und "attr ZWAVE1 verbose 5" einen neuen Versuch starten, und wenn nachweislich ein Element falsche Readings hat, mir das ganze(!) Log zeigen.
Weiterhin brauche ich das "Raw definition" der beiden betroffenen Geraete.

[krusi]

Das mache ich doch gerne.
Werde also auf das aktuelle Release gehen, alle Einträge bereinigen, und dann das komplette Logfile (mit Loglevel 5 für ZWAVE1) hochladen nachdem wieder die ersten Readings gesetzt sind.