Aeotec Z-Stick Gen 7 - unhandled command ZW_APPLICATION_COMMAND_HANLDER_BRIDGE

Begonnen von th0nix, 18 Juni 2023, 13:25:42

Vorheriges Thema - Nächstes Thema

th0nix

Hallo zusammen,

nach einem Ausflug zu Home Assistant bin ich zum entschluss gekommen das FHEM einfach die flexibelere und beherschbare Platform ist, wenn man zu einer gewissen größe und Komplexität kommt.

Heute habe ich daher meinen ZWave Dongel von Aeotec Z-Stick Gen 7 umgezogen und kämpfe mit der inklusion des ersten Gerätes. Eine DEVOLO Home Control Metering Plug MT02646 die in der Vergangenheit immer getan haben.
Senden scheint zu gehen. Ein und Ausschalten des Geräts funktioniert, ich bekomme jedoch keien Informationen wie Meterring oder Version von der Steckdose ausgelesen.

Aufgrund der Nutzung von Home Assitant musste ich den USB Dongel auf eine gewisse Version flaschen, was vemutlich Ursache meines Problems ist ?

Hat jemand einen Tip für mich?

Logfile:

fhem  | 2023.06.18 13:03:18.034 4: ZWDongle *** set ZWave1 addNode on
fhem  | 2023.06.18 13:03:18.035 5: ZWDongle_Write 004a810d ()
fhem  | 2023.06.18 13:03:18.035 5: DevIo_SimpleWrite ZWave1: 0105004a810d3c
fhem  | 2023.06.18 13:03:18.042 5: ACK received, removing 0105004a810d3c from dongle sendstack
fhem  | 2023.06.18 13:03:18.042 4: ZWDongle_Read ZWave1: rcvd 004a0d010000 (request ZW_ADD_NODE_TO_NETWORK), sending ACK
fhem  | 2023.06.18 13:03:18.042 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:03:18.043 5: ZWave1: dispatch 004a0d010000
fhem  | 2023.06.18 13:03:18.043 4: CMD:ZW_ADD_NODE_TO_NETWORK ID:01 ARG:0000 CB:0d
fhem  | 2023.06.18 13:03:18.044 4: ZWave1 ZW_ADD_NODE_TO_NETWORK learnReady
fhem  | 2023.06.18 13:05:07.870 4: ZWDongle_Read ZWave1: rcvd 004a0d020000 (request ZW_ADD_NODE_TO_NETWORK), sending ACK
fhem  | 2023.06.18 13:05:07.871 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:07.872 5: ZWave1: dispatch 004a0d020000
fhem  | 2023.06.18 13:05:07.873 4: CMD:ZW_ADD_NODE_TO_NETWORK ID:02 ARG:0000 CB:0d
fhem  | 2023.06.18 13:05:07.875 4: ZWave1 ZW_ADD_NODE_TO_NETWORK nodeFound
fhem  | 2023.06.18 13:05:08.101 4: ZWDongle_Read ZWave1: rcvd 004a0d0315130410015e8672985a855973252027327071757a (request ZW_ADD_NODE_TO_NETWORK), sen
ding ACK
fhem  | 2023.06.18 13:05:08.101 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:08.102 5: ZWave1: dispatch 004a0d0315130410015e8672985a855973252027327071757a
fhem  | 2023.06.18 13:05:08.103 4: CMD:ZW_ADD_NODE_TO_NETWORK ID:03 ARG:15130410015e8672985a855973252027327071757a CB:0d
fhem  | 2023.06.18 13:05:08.104 2: autocreate: define ZWave_SWITCH_BINARY_21 ZWave f7e25c4b 21 5e8672985a855973252027327071757a
fhem  | 2023.06.18 13:05:08.108 2: autocreate: define FileLog_ZWave_SWITCH_BINARY_21 FileLog ./log/ZWave_SWITCH_BINARY_21-%Y.log ZWave_SWITCH_BINARY_2
1
fhem  | 2023.06.18 13:05:23.535 4: ZWDongle_Read ZWave1: rcvd 004a0d051500 (request ZW_ADD_NODE_TO_NETWORK), sending ACK
fhem  | 2023.06.18 13:05:23.535 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:23.538 5: ZWave1: dispatch 004a0d051500
fhem  | 2023.06.18 13:05:23.547 4: CMD:ZW_ADD_NODE_TO_NETWORK ID:05 ARG:1500 CB:0d
fhem  | 2023.06.18 13:05:23.547 4: ZWDongle *** set ZWave1 addNode off
fhem  | 2023.06.18 13:05:23.548 5: ZWDongle_Write 004a050e ()
fhem  | 2023.06.18 13:05:23.548 5: DevIo_SimpleWrite ZWave1: 0105004a050ebb
fhem  | 2023.06.18 13:05:23.558 3: ZWave get ZWave_SWITCH_BINARY_21 model
fhem  | 2023.06.18 13:05:23.559 5: ZWDongle_Write 0013150272042549 (f7e25c4b)
fhem  | 2023.06.18 13:05:23.560 3: ZWave get ZWave_SWITCH_BINARY_21 versionClass ALARM
fhem  | 2023.06.18 13:05:23.561 3: ZWave get ZWave_SWITCH_BINARY_21 versionClass ASSOCIATION
fhem  | 2023.06.18 13:05:23.561 3: ZWave get ZWave_SWITCH_BINARY_21 versionClass ASSOCIATION_GRP_INFO
fhem  | 2023.06.18 13:05:23.562 3: ZWave get ZWave_SWITCH_BINARY_21 versionClass BASIC
fhem  | 2023.06.18 13:05:23.562 3: ZWave get ZWave_SWITCH_BINARY_21 versionClass CONFIGURATION
fhem  | 2023.06.18 13:05:23.563 3: ZWave get ZWave_SWITCH_BINARY_21 versionClass DEVICE_RESET_LOCALLY
fhem  | 2023.06.18 13:05:23.563 3: ZWave get ZWave_SWITCH_BINARY_21 versionClass FIRMWARE_UPDATE_MD
fhem  | 2023.06.18 13:05:23.564 3: ZWave get ZWave_SWITCH_BINARY_21 versionClass MANUFACTURER_SPECIFIC
fhem  | 2023.06.18 13:05:23.564 3: ZWave get ZWave_SWITCH_BINARY_21 versionClass METER
fhem  | 2023.06.18 13:05:23.565 3: ZWave get ZWave_SWITCH_BINARY_21 versionClass POWERLEVEL
fhem  | 2023.06.18 13:05:23.565 3: ZWave get ZWave_SWITCH_BINARY_21 versionClass PROTECTION
fhem  | 2023.06.18 13:05:23.566 3: ZWave get ZWave_SWITCH_BINARY_21 versionClass SECURITY
fhem  | 2023.06.18 13:05:23.566 3: ZWave get ZWave_SWITCH_BINARY_21 versionClass SWITCH_ALL
fhem  | 2023.06.18 13:05:23.566 3: ZWave get ZWave_SWITCH_BINARY_21 versionClass SWITCH_BINARY
fhem  | 2023.06.18 13:05:23.567 3: ZWave get ZWave_SWITCH_BINARY_21 versionClass VERSION
fhem  | 2023.06.18 13:05:23.567 3: ZWave get ZWave_SWITCH_BINARY_21 versionClass ZWAVEPLUS_INFO
fhem  | 2023.06.18 13:05:23.568 1: ZWAVE INIT: get ZWave_SWITCH_BINARY_21 versionClassAll: working in the background, check the vclasses attribute
fhem  | 2023.06.18 13:05:23.569 3: ZWave set ZWave_SWITCH_BINARY_21 associationAdd 1 1
fhem  | 2023.06.18 13:05:23.569 3: ZWave get ZWave_SWITCH_BINARY_21 zwavePlusInfo
fhem  | 2023.06.18 13:05:23.570 5: ACK received, removing 0105004a050ebb from dongle sendstack
fhem  | 2023.06.18 13:05:23.571 4: ZWDongle_Read ZWave1: rcvd 004a0e061500 (request ZW_ADD_NODE_TO_NETWORK), sending ACK
fhem  | 2023.06.18 13:05:23.571 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:23.572 5: ZWave1: dispatch 004a0e061500
fhem  | 2023.06.18 13:05:23.572 4: CMD:ZW_ADD_NODE_TO_NETWORK ID:06 ARG:1500 CB:0e
fhem  | 2023.06.18 13:05:23.574 4: ZWave1 ZW_ADD_NODE_TO_NETWORK done
fhem  | 2023.06.18 13:05:23.574 5: DevIo_SimpleWrite ZWave1: 01090013150272042549e8
fhem  | 2023.06.18 13:05:23.581 5: ACK received, WaitForAck=>2 for 01090013150272042549e8
fhem  | 2023.06.18 13:05:23.581 4: ZWDongle_Read ZWave1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
fhem  | 2023.06.18 13:05:23.581 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:23.582 5: ZWave1: dispatch 011301
fhem  | 2023.06.18 13:05:23.684 4: ZWDongle_Read ZWave1: rcvd 00134900000900a07f7f7f7f01010400000000020300007f7f7f7f7f (request ZW_SEND_DATA), sending ACK
fhem  | 2023.06.18 13:05:23.685 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:23.686 5: device ack reveived, removing 01090013150272042549e8 from dongle sendstack
fhem  | 2023.06.18 13:05:23.686 5: ZWave1: dispatch 00134900000900a07f7f7f7f01010400000000020300007f7f7f7f7f
fhem  | 2023.06.18 13:05:23.686 4: CMD:ZW_SEND_DATA ID:00 ARG:000900a07f7f7f7f01010400000000020300007f7f7f7f7f CB:49
fhem  | 2023.06.18 13:05:23.686 4: ZWave1 transmit OK for CB 49, target ZWave_SWITCH_BINARY_21
fhem  | 2023.06.18 13:05:23.703 4: ZWDongle_Read ZWave1: rcvd 00a800011508720501750001001100a0 (request ZW_APPLICATION_COMMAND_HANLDER_BRIDGE), sending ACK
fhem  | 2023.06.18 13:05:23.703 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:23.705 5: ZWave1: dispatch 00a800011508720501750001001100a0
fhem  | 2023.06.18 13:05:23.705 4: CMD:ZW_APPLICATION_COMMAND_HANLDER_BRIDGE ID:01 ARG:1508720501750001001100a0 CB:00
fhem  | 2023.06.18 13:05:23.705 4: ZWave1 unhandled command ZW_APPLICATION_COMMAND_HANLDER_BRIDGE
fhem  | 2023.06.18 13:05:24.303 4: ZWDongle_Read ZWave1: rcvd 00a80001080326030000a3 (request ZW_APPLICATION_COMMAND_HANLDER_BRIDGE), sending ACK
fhem  | 2023.06.18 13:05:24.303 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:24.304 5: ZWave1: dispatch 00a80001080326030000a3
fhem  | 2023.06.18 13:05:24.305 4: CMD:ZW_APPLICATION_COMMAND_HANLDER_BRIDGE ID:01 ARG:080326030000a3 CB:00
fhem  | 2023.06.18 13:05:24.305 4: ZWave1 unhandled command ZW_APPLICATION_COMMAND_HANLDER_BRIDGE
fhem  | 2023.06.18 13:05:28.581 2: ZWave: No ACK from ZWave_SWITCH_BINARY_21 after 5s for sentackget:13150272042549
fhem  | 2023.06.18 13:05:28.582 5: ZWDongle_Write 00131503861371254a (f7e25c4b)
fhem  | 2023.06.18 13:05:28.582 5: DevIo_SimpleWrite ZWave1: 010a00131503861371254a7b
fhem  | 2023.06.18 13:05:28.590 5: ACK received, WaitForAck=>2 for 010a00131503861371254a7b
fhem  | 2023.06.18 13:05:28.590 4: ZWDongle_Read ZWave1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
fhem  | 2023.06.18 13:05:28.590 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:28.592 5: ZWave1: dispatch 011301
fhem  | 2023.06.18 13:05:28.606 4: ZWDongle_Read ZWave1: rcvd 00134a00000100a17f7f7f7f00000400000000030100007f7f7f7f7f (request ZW_SEND_DATA), sending ACK
fhem  | 2023.06.18 13:05:28.606 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:28.607 5: device ack reveived, removing 010a00131503861371254a7b from dongle sendstack
fhem  | 2023.06.18 13:05:28.608 5: ZWave1: dispatch 00134a00000100a17f7f7f7f00000400000000030100007f7f7f7f7f
fhem  | 2023.06.18 13:05:28.608 4: CMD:ZW_SEND_DATA ID:00 ARG:000100a17f7f7f7f00000400000000030100007f7f7f7f7f CB:4a
fhem  | 2023.06.18 13:05:28.608 4: ZWave1 transmit OK for CB 4a, target ZWave_SWITCH_BINARY_21
fhem  | 2023.06.18 13:05:28.647 4: ZWDongle_Read ZWave1: rcvd 00a8000115048614710100a2 (request ZW_APPLICATION_COMMAND_HANLDER_BRIDGE), sending ACK
fhem  | 2023.06.18 13:05:28.647 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:28.649 5: ZWave1: dispatch 00a8000115048614710100a2
fhem  | 2023.06.18 13:05:28.649 4: CMD:ZW_APPLICATION_COMMAND_HANLDER_BRIDGE ID:01 ARG:15048614710100a2 CB:00
fhem  | 2023.06.18 13:05:28.649 4: ZWave1 unhandled command ZW_APPLICATION_COMMAND_HANLDER_BRIDGE
fhem  | 2023.06.18 13:05:33.583 2: ZWave: No ACK from ZWave_SWITCH_BINARY_21 after 5s for sentackget:131503861371254a
fhem  | 2023.06.18 13:05:33.584 5: ZWDongle_Write 00131503861385254b (f7e25c4b)
fhem  | 2023.06.18 13:05:33.584 5: DevIo_SimpleWrite ZWave1: 010a00131503861385254b8e
fhem  | 2023.06.18 13:05:33.591 5: ACK received, WaitForAck=>2 for 010a00131503861385254b8e
fhem  | 2023.06.18 13:05:33.591 4: ZWDongle_Read ZWave1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
fhem  | 2023.06.18 13:05:33.592 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:33.593 5: ZWave1: dispatch 011301
fhem  | 2023.06.18 13:05:33.607 4: ZWDongle_Read ZWave1: rcvd 00134b00000100a07f7f7f7f00000300000000030100007f7f7f7f7f (request ZW_SEND_DATA), sending ACK
fhem  | 2023.06.18 13:05:33.607 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:33.610 5: device ack reveived, removing 010a00131503861385254b8e from dongle sendstack
fhem  | 2023.06.18 13:05:33.610 5: ZWave1: dispatch 00134b00000100a07f7f7f7f00000300000000030100007f7f7f7f7f
fhem  | 2023.06.18 13:05:33.610 4: CMD:ZW_SEND_DATA ID:00 ARG:000100a07f7f7f7f00000300000000030100007f7f7f7f7f CB:4b
fhem  | 2023.06.18 13:05:33.610 4: ZWave1 transmit OK for CB 4b, target ZWave_SWITCH_BINARY_21
fhem  | 2023.06.18 13:05:33.734 4: ZWDongle_Read ZWave1: rcvd 00a8000115048614850200a1 (request ZW_APPLICATION_COMMAND_HANLDER_BRIDGE), sending ACK
fhem  | 2023.06.18 13:05:33.734 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:33.736 5: ZWave1: dispatch 00a8000115048614850200a1
fhem  | 2023.06.18 13:05:33.736 4: CMD:ZW_APPLICATION_COMMAND_HANLDER_BRIDGE ID:01 ARG:15048614850200a1 CB:00
fhem  | 2023.06.18 13:05:33.736 4: ZWave1 unhandled command ZW_APPLICATION_COMMAND_HANLDER_BRIDGE
fhem  | 2023.06.18 13:05:38.584 2: ZWave: No ACK from ZWave_SWITCH_BINARY_21 after 5s for sentackget:131503861385254b
fhem  | 2023.06.18 13:05:38.585 5: ZWDongle_Write 00131503861359254c (f7e25c4b)
fhem  | 2023.06.18 13:05:38.585 5: DevIo_SimpleWrite ZWave1: 010a00131503861359254c55
fhem  | 2023.06.18 13:05:38.593 5: ACK received, WaitForAck=>2 for 010a00131503861359254c55
fhem  | 2023.06.18 13:05:38.593 4: ZWDongle_Read ZWave1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
fhem  | 2023.06.18 13:05:38.593 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:38.595 5: ZWave1: dispatch 011301
fhem  | 2023.06.18 13:05:38.609 4: ZWDongle_Read ZWave1: rcvd 00134c00000100a07f7f7f7f00000300000000030100007f7f7f7f7f (request ZW_SEND_DATA), sending ACK
fhem  | 2023.06.18 13:05:38.609 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:38.610 5: device ack reveived, removing 010a00131503861359254c55 from dongle sendstack
fhem  | 2023.06.18 13:05:38.610 5: ZWave1: dispatch 00134c00000100a07f7f7f7f00000300000000030100007f7f7f7f7f
fhem  | 2023.06.18 13:05:38.610 4: CMD:ZW_SEND_DATA ID:00 ARG:000100a07f7f7f7f00000300000000030100007f7f7f7f7f CB:4c
fhem  | 2023.06.18 13:05:38.611 4: ZWave1 transmit OK for CB 4c, target ZWave_SWITCH_BINARY_21
fhem  | 2023.06.18 13:05:38.629 4: ZWDongle_Read ZWave1: rcvd 00a8000115048614590100a1 (request ZW_APPLICATION_COMMAND_HANLDER_BRIDGE), sending ACK
fhem  | 2023.06.18 13:05:38.629 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:38.630 5: ZWave1: dispatch 00a8000115048614590100a1
fhem  | 2023.06.18 13:05:38.631 4: CMD:ZW_APPLICATION_COMMAND_HANLDER_BRIDGE ID:01 ARG:15048614590100a1 CB:00
fhem  | 2023.06.18 13:05:38.631 4: ZWave1 unhandled command ZW_APPLICATION_COMMAND_HANLDER_BRIDGE
fhem  | 2023.06.18 13:05:43.585 2: ZWave: No ACK from ZWave_SWITCH_BINARY_21 after 5s for sentackget:131503861359254c
fhem  | 2023.06.18 13:05:43.586 5: ZWDongle_Write 00131503861320254d (f7e25c4b)
fhem  | 2023.06.18 13:05:43.586 5: DevIo_SimpleWrite ZWave1: 010a00131503861320254d2d
fhem  | 2023.06.18 13:05:43.594 5: ACK received, WaitForAck=>2 for 010a00131503861320254d2d
fhem  | 2023.06.18 13:05:43.594 4: ZWDongle_Read ZWave1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
fhem  | 2023.06.18 13:05:43.594 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:43.596 5: ZWave1: dispatch 011301
fhem  | 2023.06.18 13:05:43.612 4: ZWDongle_Read ZWave1: rcvd 00134d00000100a17f7f7f7f00000300000000030100007f7f7f7f7f (request ZW_SEND_DATA), sending ACK
fhem  | 2023.06.18 13:05:43.612 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:43.614 5: device ack reveived, removing 010a00131503861320254d2d from dongle sendstack
fhem  | 2023.06.18 13:05:43.615 5: ZWave1: dispatch 00134d00000100a17f7f7f7f00000300000000030100007f7f7f7f7f
fhem  | 2023.06.18 13:05:43.615 4: CMD:ZW_SEND_DATA ID:00 ARG:000100a17f7f7f7f00000300000000030100007f7f7f7f7f CB:4d
fhem  | 2023.06.18 13:05:43.615 4: ZWave1 transmit OK for CB 4d, target ZWave_SWITCH_BINARY_21
fhem  | 2023.06.18 13:05:43.696 4: ZWDongle_Read ZWave1: rcvd 00a8000115048614200100a2 (request ZW_APPLICATION_COMMAND_HANLDER_BRIDGE), sending ACK
fhem  | 2023.06.18 13:05:43.696 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:43.697 5: ZWave1: dispatch 00a8000115048614200100a2
fhem  | 2023.06.18 13:05:43.698 4: CMD:ZW_APPLICATION_COMMAND_HANLDER_BRIDGE ID:01 ARG:15048614200100a2 CB:00
fhem  | 2023.06.18 13:05:43.698 4: ZWave1 unhandled command ZW_APPLICATION_COMMAND_HANLDER_BRIDGE
fhem  | 2023.06.18 13:05:48.586 2: ZWave: No ACK from ZWave_SWITCH_BINARY_21 after 5s for sentackget:131503861320254d
fhem  | 2023.06.18 13:05:48.590 5: ZWDongle_Write 00131503861370254e (f7e25c4b)
fhem  | 2023.06.18 13:05:48.591 5: DevIo_SimpleWrite ZWave1: 010a00131503861370254e7e
fhem  | 2023.06.18 13:05:48.605 5: ACK received, WaitForAck=>2 for 010a00131503861370254e7e
fhem  | 2023.06.18 13:05:48.606 4: ZWDongle_Read ZWave1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
fhem  | 2023.06.18 13:05:48.606 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:48.612 5: ZWave1: dispatch 011301
fhem  | 2023.06.18 13:05:48.676 4: ZWDongle_Read ZWave1: rcvd 00134e00000700a17f7f7f7f01010300000000020300007f7f7f7f7f (request ZW_SEND_DATA), sending ACK
fhem  | 2023.06.18 13:05:48.676 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:48.677 5: device ack reveived, removing 010a00131503861370254e7e from dongle sendstack
fhem  | 2023.06.18 13:05:48.678 5: ZWave1: dispatch 00134e00000700a17f7f7f7f01010300000000020300007f7f7f7f7f
fhem  | 2023.06.18 13:05:48.678 4: CMD:ZW_SEND_DATA ID:00 ARG:000700a17f7f7f7f01010300000000020300007f7f7f7f7f CB:4e
fhem  | 2023.06.18 13:05:48.678 4: ZWave1 transmit OK for CB 4e, target ZWave_SWITCH_BINARY_21
fhem  | 2023.06.18 13:05:48.764 4: ZWDongle_Read ZWave1: rcvd 00a8000115048614700100a1 (request ZW_APPLICATION_COMMAND_HANLDER_BRIDGE), sending ACK
fhem  | 2023.06.18 13:05:48.764 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:48.765 5: ZWave1: dispatch 00a8000115048614700100a1
fhem  | 2023.06.18 13:05:48.766 4: CMD:ZW_APPLICATION_COMMAND_HANLDER_BRIDGE ID:01 ARG:15048614700100a1 CB:00
fhem  | 2023.06.18 13:05:48.766 4: ZWave1 unhandled command ZW_APPLICATION_COMMAND_HANLDER_BRIDGE
fhem  | 2023.06.18 13:05:48.796 4: ZWDongle_Read ZWave1: rcvd 00a8000115048614700100a0 (request ZW_APPLICATION_COMMAND_HANLDER_BRIDGE), sending ACK
fhem  | 2023.06.18 13:05:48.797 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:48.802 5: ZWave1: dispatch 00a8000115048614700100a0
fhem  | 2023.06.18 13:05:48.802 4: CMD:ZW_APPLICATION_COMMAND_HANLDER_BRIDGE ID:01 ARG:15048614700100a0 CB:00
fhem  | 2023.06.18 13:05:48.802 4: ZWave1 unhandled command ZW_APPLICATION_COMMAND_HANLDER_BRIDGE
fhem  | 2023.06.18 13:05:53.590 2: ZWave: No ACK from ZWave_SWITCH_BINARY_21 after 5s for sentackget:131503861370254e
fhem  | 2023.06.18 13:05:53.591 5: ZWDongle_Write 0013150386135a254f (f7e25c4b)
fhem  | 2023.06.18 13:05:53.591 5: DevIo_SimpleWrite ZWave1: 010a0013150386135a254f55
fhem  | 2023.06.18 13:05:53.599 5: ACK received, WaitForAck=>2 for 010a0013150386135a254f55
fhem  | 2023.06.18 13:05:53.599 4: ZWDongle_Read ZWave1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
fhem  | 2023.06.18 13:05:53.599 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:53.601 5: ZWave1: dispatch 011301
fhem  | 2023.06.18 13:05:53.654 4: ZWDongle_Read ZWave1: rcvd 00134f00000500a17f7f7f7f00000300000000030200007f7f7f7f7f (request ZW_SEND_DATA), sending ACK
fhem  | 2023.06.18 13:05:53.654 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:53.656 5: device ack reveived, removing 010a0013150386135a254f55 from dongle sendstack
fhem  | 2023.06.18 13:05:53.656 5: ZWave1: dispatch 00134f00000500a17f7f7f7f00000300000000030200007f7f7f7f7f
fhem  | 2023.06.18 13:05:53.656 4: CMD:ZW_SEND_DATA ID:00 ARG:000500a17f7f7f7f00000300000000030200007f7f7f7f7f CB:4f
fhem  | 2023.06.18 13:05:53.656 4: ZWave1 transmit OK for CB 4f, target ZWave_SWITCH_BINARY_21
fhem  | 2023.06.18 13:05:53.711 4: ZWDongle_Read ZWave1: rcvd 00a80001150486145a0100a0 (request ZW_APPLICATION_COMMAND_HANLDER_BRIDGE), sending ACK
fhem  | 2023.06.18 13:05:53.712 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:53.713 5: ZWave1: dispatch 00a80001150486145a0100a0
fhem  | 2023.06.18 13:05:53.713 4: CMD:ZW_APPLICATION_COMMAND_HANLDER_BRIDGE ID:01 ARG:150486145a0100a0 CB:00
fhem  | 2023.06.18 13:05:53.713 4: ZWave1 unhandled command ZW_APPLICATION_COMMAND_HANLDER_BRIDGE
fhem  | 2023.06.18 13:05:58.591 2: ZWave: No ACK from ZWave_SWITCH_BINARY_21 after 5s for sentackget:13150386135a254f
fhem  | 2023.06.18 13:05:58.592 5: ZWDongle_Write 0013150386137a2550 (f7e25c4b)
fhem  | 2023.06.18 13:05:58.592 5: DevIo_SimpleWrite ZWave1: 010a0013150386137a25506a
fhem  | 2023.06.18 13:05:58.599 5: ACK received, WaitForAck=>2 for 010a0013150386137a25506a
fhem  | 2023.06.18 13:05:58.600 4: ZWDongle_Read ZWave1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
fhem  | 2023.06.18 13:05:58.600 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:58.601 5: ZWave1: dispatch 011301
fhem  | 2023.06.18 13:05:58.615 4: ZWDongle_Read ZWave1: rcvd 00135000000100a07f7f7f7f00000300000000030100007f7f7f7f7f (request ZW_SEND_DATA), sending ACK
fhem  | 2023.06.18 13:05:58.615 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:58.616 5: device ack reveived, removing 010a0013150386137a25506a from dongle sendstack
fhem  | 2023.06.18 13:05:58.617 5: ZWave1: dispatch 00135000000100a07f7f7f7f00000300000000030100007f7f7f7f7f
fhem  | 2023.06.18 13:05:58.617 4: CMD:ZW_SEND_DATA ID:00 ARG:000100a07f7f7f7f00000300000000030100007f7f7f7f7f CB:50
fhem  | 2023.06.18 13:05:58.617 4: ZWave1 transmit OK for CB 50, target ZWave_SWITCH_BINARY_21
fhem  | 2023.06.18 13:05:58.635 4: ZWDongle_Read ZWave1: rcvd 00a80001150486147a0200a1 (request ZW_APPLICATION_COMMAND_HANLDER_BRIDGE), sending ACK
fhem  | 2023.06.18 13:05:58.635 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:05:58.637 5: ZWave1: dispatch 00a80001150486147a0200a1
fhem  | 2023.06.18 13:05:58.637 4: CMD:ZW_APPLICATION_COMMAND_HANLDER_BRIDGE ID:01 ARG:150486147a0200a1 CB:00
fhem  | 2023.06.18 13:05:58.637 4: ZWave1 unhandled command ZW_APPLICATION_COMMAND_HANLDER_BRIDGE
fhem  | 2023.06.18 13:06:03.592 2: ZWave: No ACK from ZWave_SWITCH_BINARY_21 after 5s for sentackget:13150386137a2550
fhem  | 2023.06.18 13:06:03.593 5: ZWDongle_Write 001315038613722551 (f7e25c4b)
fhem  | 2023.06.18 13:06:03.593 5: DevIo_SimpleWrite ZWave1: 010a00131503861372255163
fhem  | 2023.06.18 13:06:03.601 5: ACK received, WaitForAck=>2 for 010a00131503861372255163
fhem  | 2023.06.18 13:06:03.602 4: ZWDongle_Read ZWave1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
fhem  | 2023.06.18 13:06:03.602 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 13:06:03.603 5: ZWave1: dispatch 011301
fhem  | 2023.06.18 13:06:03.666 4: ZWDongle_Read ZWave1: rcvd 00135100000600a17f7f7f7f01010300000000020300007f7f7f7f7f (request ZW_SEND_DATA), sending ACK

Dongel Conifg:

define ZWave1 ZWDongle /dev/ttyUSB2@115200
attr ZWave1 homeId xxxx
attr ZWave1 networkKey xxxxxxxx
attr ZWave1 room ZWave
attr ZWave1 verbose 5
#   CFGFN     
#   CallbackNr 14
#   Clients    :ZWave:
#   DEF        /dev/ttyUSB2@115200
#   DeviceName /dev/ttyUSB2@115200
#   FD         50
#   FUUID      648ecd60-f33f-8ce7-9943-03907ac7030accd4
#   MaxSendRetries 3
#   NAME       ZWave1
#   NR         268
#   PARTIAL   
#   RAWMSG     00a80001080326030000a3
#   ReadTime   1687087044.28349
#   STATE      Initialized
#   SendRetries 0
#   SendTime   1687086408.72202
#   TYPE       ZWDongle
#   WaitForAck 0
#   ZWave1_MSGCNT 404
#   ZWave1_TIME 2023-06-18 13:17:24
#   devioNoSTATE 1
#   eventCount 46
#   homeId     f7e25c4b
#   nodeIdHex  01
#   nrNAck     0
#   secInitName ZWave_SWITCH_BINARY_19
#   Helper:
#     DBLOG:
#       state:
#         logdb:
#           TIME       1687086323.57325
#           VALUE      ZW_ADD_NODE_TO_NETWORK done
#   MatchList:
#     1:ZWave    .*
#   READINGS:
#     2023-06-18 11:24:50   caps            Vers:7 Rev:18 ManufID:0000 ProductType:0004 ProductID:0004 SERIAL_API_GET_INIT_DATA SERIAL_API_APPL_NODE_INFORMATION ZW_GET_CONTROLLER_CAPABILITIES SERIAL_API_SET_TIMEOUTS SERIAL_API_GET_CAPABILITIES SERIAL_API_SOFT_RESET UNKNOWN_09 UNKNOWN_0a SERIAL_API_SETUP ZW_SET_R_F_RECEIVE_MODE ZW_SEND_NODE_INFORMATION ZW_SEND_DATA ZW_SEND_DATA_MULTI ZW_GET_VERSION ZW_SEND_DATA_ABORT ZW_GET_RANDOM MEMORY_GET_ID MEMORY_GET_BYTE MEMORY_PUT_BYTE MEMORY_GET_BUFFER MEMORY_PUT_BUFFER FLASH_AUTO_PROG_SET ZW_NVR_GET_VALUE NVM_GET_ID NVM_EXT_READ_LONG_BUFFER NVM_EXT_READ_LONG_BYTE UNKNOWN_2e ZW_CLEAR_TX_TIMERS ZW_GET_TX_TIMERS CLEAR_NETWORK_STATS GET_NETWORK_STATS GET_BACKGROUND_RSSI UNKNOWN_3c REMOVE_NODEID_FROM_NETWORK ZW_GET_NODE_PROTOCOL_INFO ZW_SET_DEFAULT ZW_REPLICATION_COMMAND_COMPLETE ZW_REPLICATION_SEND_DATA ZW_ASSIGN_RETURN_ROUTE ZW_DELETE_RETURN_ROUTE ZW_REQUEST_NODE_NEIGHBOR_UPDATE ZW_APPLICATION_UPDATE ZW_ADD_NODE_TO_NETWORK ZW_REMOVE_NODE_FROM_NETWORK ZW_CONTROLLER_CHANGE ZW_ASSIGN_PRIORITY_RETURN_ROUTE ZW_SET_LEARN_MODE ZW_ASSIGN_SUC_RETURN_ROUTE ZW_REQUEST_NETWORK_UPDATE ZW_SET_SUC_NODE_ID ZW_DELETE_SUC_RETURN_ROUTE ZW_GET_SUC_NODE_ID ZW_SEND_SUC_ID ZW_ASSIGN_PRIORITY_SUC_RETURN_ROUTE ZW_EXPLORE_REQUEST_INCLUSION ZW_EXPLORE_REQUEST_EXCLUSION ZW_REQUEST_NODE_INFO ZW_REMOVE_FAILED_NODE_ID ZW_IS_FAILED_NODE ZW_REPLACE_FAILED_NODE UNKNOWN_65 GET_ROUTING_TABLE_LINE LOCK_ROUTE_RESPONSE ZW_GET_PRIORITY_ROUTE ZW_SET_PRIORITY_ROUTE UNKNOWN_98 SERIAL_API_SLAVE_NODE_INFO ZW_SEND_SLAVE_NODE_INFO ZW_SET_SLAVE_LEARN_MODE ZW_GET_VIRTUAL_NODES ZW_IS_VIRTUAL_NODE ZW_APPLICATION_COMMAND_HANLDER_BRIDGE ZW_SEND_DATA_BRIDGE ZW_SEND_DATA_MULTI_BRIDGE ZW_TYPE_LIBRARY ZW_SEND_TEST_FRAME ZW_GET_PROTOCOL_STATUS WATCHDOG_START WATCHDOG_STOP ZW_SET_ROUTING_MAX UNKNOWN_d6 UNKNOWN_d7 UNKNOWN_d8 UNKNOWN_d9 UNKNOWN_da UNKNOWN_db UNKNOWN_dc UNKNOWN_dd UNKNOWN_de UNKNOWN_df UNKNOWN_e7 UNKNOWN_e8
#     2023-06-18 11:24:50   ctrlCaps        MEMBER PRIMARY SUC
#     2023-06-18 11:25:59   homeId          HomeId:f7e25c4b CtrlNodeIdHex:01
#     2023-06-18 11:32:09   nodeInfo_15     ProtocolVers:SDK4.5x+6.0x sleeping routing maxBaud:40kbps SpecificDev RoutingSlave BeamCap FrequentListen1000ms OptFunc SpeedExt:100kbps RoleType:N/A BasicDevClass:ROUTING_SLAVE GenericDevClass:THERMOSTAT SpecificDevClass:06
#     2023-06-18 11:31:54   nodeInfo_16     ProtocolVers:SDK4.5x+6.0x sleeping routing maxBaud:40kbps SpecificDev RoutingSlave BeamCap OptFunc SpeedExt:100kbps RoleType:N/A BasicDevClass:ROUTING_SLAVE GenericDevClass:SENSOR_NOTIFICATION SpecificDevClass:01
#     2023-06-18 13:00:22   nodeList        ZWave1 UNKNOWN_3 UNKNOWN_4 UNKNOWN_5 UNKNOWN_6 UNKNOWN_7 UNKNOWN_8 UNKNOWN_9 UNKNOWN_10 ZWave_SWITCH_BINARY_11 UNKNOWN_12 UNKNOWN_15 UNKNOWN_16 ZWave_SWITCH_BINARY_20
#     2023-06-18 11:24:50   random          9db91356a44c146fc84b8913b30964886ca97749a1c4ecc5182f7403db9d2980
#     2023-06-18 11:24:50   state           Initialized
#     2023-06-18 11:34:39   statistics      Transmitted:59541 BackOffs:0 ReceivedNoErrors:33785
#                    ChecksumErrors:0 CRC16Errors:0 ForeignHomeId:76
#     2023-06-18 11:24:50   sucNodeId       1
#     2023-06-18 11:34:49   version         Z-Wave 7.18
[/sub]


Update: Habe gerade noch ein Update (Anleitung via WaveJS auf die letzte Version eingespielt 7.19.2. Leider genau das gleiche:

fhem  | 2023.06.18 14:55:57.973 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 14:55:57.975 5: ZWave1: dispatch 00a80001150e3202213400000bc200000000000000bb
fhem  | 2023.06.18 14:55:57.975 4: CMD:ZW_APPLICATION_COMMAND_HANLDER_BRIDGE ID:01 ARG:150e3202213400000bc200000000000000bb CB:00
fhem  | 2023.06.18 14:55:57.976 4: ZWave1 unhandled command ZW_APPLICATION_COMMAND_HANLDER_BRIDGE
fhem  | 2023.06.18 14:56:17.972 4: ZWDongle_Read ZWave1: rcvd 00a80001150e3202213400000c4e00000000000000bb (request ZW_APPLICATION_COMMAND_HANLDER_BRIDGE), sending ACK

rudolfkoenig

Ich habe was implementiert und eingecheckt, mangels passenden Hardware aber nicht getestet.

Wenn ich mich nicht irre, muesste FHEM weiterhin meckern, weil die Daten ohne CallbackID kommen, obwohl der Inhalt im gezeigten Log (bis auf ein Exemplar) die Antwort auf ein get ist (model, versionClass), und das Modul ohne CallbackID die Antwort (noch?) nicht zuordnen kann.

Die Doku in "Serial API Host Application Programming Guide" zu diesem Befehl ist mehr als mager, meine Implementation deckt hoechstens das, was ich hier gesehen habe.

Ich habe das Gefuehl, dass das ein Controller Bug ist, wo vergessen wurde die so gekapselten Daten zu dekodieren.

th0nix

Dank dir schon mal fürs drauf schauen!

Hm kann ich dir noch Daten liefern um noch was herauszufinden um ggf. eine Lösung zu finden ?

rudolfkoenig

ZitatHm kann ich dir noch Daten liefern um noch was herauszufinden um ggf. eine Lösung zu finden ?
Erstmal testen und berichten :)

Was helfen kann:
- Open-Source Loesungen, die das Problem nicht haben. Ich habe vorhin 'ne Weile die openHab ZWave Implementierung studiert, habe aber den Eindruck, dass sie diese Pakete nicht dekodieren.
- eine Doku, wo beschriebn wird, was man mit diesen Paketen machen soll, und wozu sie gut sind. Ich habe nur die o.g. gefunden, da steht aber nur Syntax, keine Semantik.

th0nix

Bin mir nicht sicher was du mit testen meintest.
Habe ein Update ausgeführt und fhem neu gestartet. Leider noch der Fehler: unhandled command ZW_APPLICATION_COMMAND_HANLDER_BRIDGE

fhem  | 2023.06.18 20:53:26.521 4: ZWDongle_Read ZWave1: rcvd 00a80001080326030000a7 (request ZW_APPLICATION_COMMAND_HANLDER_BRIDGE), sending ACK
fhem  | 2023.06.18 20:53:26.521 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 20:53:26.525 5: ZWave1: dispatch 00a80001080326030000a7
fhem  | 2023.06.18 20:53:26.532 4: CMD:ZW_APPLICATION_COMMAND_HANLDER_BRIDGE ID:01 ARG:080326030000a7 CB:00
fhem  | 2023.06.18 20:53:26.533 4: ZWave1 unhandled command ZW_APPLICATION_COMMAND_HANLDER_BRIDGE
fhem  | 2023.06.18 20:53:26.533 4: ZWDongle_Read ZWave1: rcvd 00a80001080326030000a7 (request ZW_APPLICATION_COMMAND_HANLDER_BRIDGE), sending ACK
fhem  | 2023.06.18 20:53:26.533 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.18 20:53:26.537 5: ZWave1: dispatch 00a80001080326030000a7
fhem  | 2023.06.18 20:53:26.538 4: CMD:ZW_APPLICATION_COMMAND_HANLDER_BRIDGE ID:01 ARG:080326030000a7 CB:00
fhem  | 2023.06.18 20:53:26.538 4: ZWave1 unhandled command ZW_APPLICATION_COMMAND_HANLDER_BRIDGE

Wie es aussieht hat das direkt was mit dem Empfangen von Nachtichten zu tun.
Ich bekomme aktell keine Infos zum zu den Devices. Kommunizieren mit dem Controller klappt.

rudolfkoenig

ZitatHabe ein Update ausgeführt und fhem neu gestartet.
Eingecheckte Daten stehen fuer ein FHEM update erst am naechsten Tag ab ca 8:00 bereit.
Wer vorher testen will, muss die Daten per SVN auschecken, oder von hier: https://svn.fhem.de/trac/browser/trunk/fhem/FHEM/10_ZWave.pm?format=txt
herunterladen.

th0nix

Danke für den Hinweis! Neue Version ist jetzt drauf  :)

Anfragen kommen nun bei einem get zurück. Auch kommen die Updates automatisch an.
Lediglich kommt bei einem get via UI kein Wert sondern ein Timeout. (Timeout reading answer for ....)
Im Log sieht man dazu aber nichts...

fhem  | 2023.06.19 20:52:29.887 3: ZWave get ZWave_SWITCH_BINARY_20 version
fhem  | 2023.06.19 20:52:29.889 5: ZWDongle_Write 0013140286112501 (f7e25c4b)
fhem  | 2023.06.19 20:52:29.889 5: DevIo_SimpleWrite ZWave1: 0109001314028611250140
fhem  | 2023.06.19 20:52:29.896 5: ACK received, WaitForAck=>2 for 0109001314028611250140
fhem  | 2023.06.19 20:52:29.896 4: ZWDongle_Read ZWave1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
fhem  | 2023.06.19 20:52:29.896 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.19 20:52:29.898 5: ZWave1: dispatch 011301
fhem  | 2023.06.19 20:52:29.912 4: ZWDongle_Read ZWave1: rcvd 00130100000100b77f7f7f7f00000300000000030100007f7f7f7f7f (request ZW_SEND_DATA), sending ACK
fhem  | 2023.06.19 20:52:29.912 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.19 20:52:29.913 5: device ack reveived, removing 0109001314028611250140 from dongle sendstack
fhem  | 2023.06.19 20:52:29.914 5: ZWave1: dispatch 00130100000100b77f7f7f7f00000300000000030100007f7f7f7f7f
fhem  | 2023.06.19 20:52:29.914 4: CMD:ZW_SEND_DATA ID:00 ARG:000100b77f7f7f7f00000300000000030100007f7f7f7f7f CB:01
fhem  | 2023.06.19 20:52:29.914 4: ZWave1 transmit OK for CB 01, target ZWave_SWITCH_BINARY_20
fhem  | 2023.06.19 20:52:29.919 4: ZWDongle_Read ZWave1: rcvd 00a80001140b8612030353010a0100010a00b7 (request ZW_APPLICATION_COMMAND_HANLDER_BRIDGE), sending ACK
fhem  | 2023.06.19 20:52:29.919 5: DevIo_SimpleWrite ZWave1: 06
fhem  | 2023.06.19 20:52:29.920 5: ZWave1: dispatch 00a80001140b8612030353010a0100010a00b7
fhem  | 2023.06.19 20:52:29.920 4: CMD:ZW_APPLICATION_COMMAND_HANLDER_BRIDGE ID:01 ARG:140b8612030353010a0100010a00b7 CB:00

rudolfkoenig

ZitatLediglich kommt bei einem get via UI kein Wert sondern ein Timeout.
Wie ich geschrieben habe: das Modul kann die Meldungen (noch?) nicht den Anfragen zuordnen, weil in diesem Fall kein CallbackId zurueckgeliefert wird.

rudolfkoenig

...aber die Antwort auf das get wird verarbeitet, d.h Reading und Event gibt es trotzdem.