Abarbeitung des WakeUp-Sendstacks wird in Einzelfällen unterbrochen

Begonnen von krikan, 01 März 2016, 21:56:44

Vorheriges Thema - Nächstes Thema

krikan

Zum eigenlichen Topic eine positive Info: Habe gestern abend noch einmal intensiv die WakeUp-Sendstack-Abarbeitung mit dem PST02 ohne Router (Direktverbindung Controller/PST02) getestet. Eine Unterbrechung der Wakeup-Sendstack-Abarbeitung habe ich nur noch einmal erzeugen können, als ich ca. 80(!) Befehle auf den Stack gelegt habe. Ansonsten lief es immer problemlos durch.

rudolfkoenig

Habe die beiden Sendstacks (ZWave/ZWDongle) angepasst:
- doppeltes ACK Bug vermutlich gefixt. Kann nicht testen, da ich die doppelten Acks nicht reproduzieren kann.
- bei 011300 (transmit queue overflow) Retry eingebaut. Das kann theoretisch zu Endlosschleife fuehren, wenn der Dongle nichts anderes antwortet, hoffentlich kommt das aber nicht vor. Wenn doch, dann bauen wir einen Zaehler ein :)
- das Retry-Verhalten bei CAN angepasst.

Ich kann damit beim KFOB ein halbwegs sauberes get versionClassAll verarbeiten. Deswegen halbwegs, weil der KFOB direkt nach Application-Update WUN und battery-report schickt, und da FHEM direkt nach Application-Update die erste Get Frage losschickt, kommt vom Dongle direkt ein CAN, weil WUN/battery gerade empfangen wird. Habe aber keine Idee, woran ich erkennen soll, dass ich erst spaeter senden darf. Bis auf diesem CAN (mAn Schoenheitsfehler) laeuft aber die komplette Abfrage schnell und fehlerfrei durch.

9zehn75

Zitat von: krikan am 10 März 2016, 10:38:58
Nein.
APPLICATION_UPDATE führte nur bei einer 10_ZWave.pm, die ca. (ca. weil sorceforge streikt) vom 07.03.16-09.03.16 per update verteilt wurde, nicht zur Abarbeitung des Sendstacks. Vorher und aktuell ist alles in Ordnung.

Aber das war doch auch gar nicht mein Problem. Mein Problem war (und ist), dass meine Fibaro Fenstersensoren kein WUN senden, wenn ich sie manuell aufwecke. Der Sendstack wird aber scheinbar trotzdem abgearbeitet (was ich aber nicht bemerkte, weil ich immer auf eine WUN wartete).
VG, 9zehn75

FHEM seit 02.02.2016: Raspberry Pi 2, ZME_UZB1, Fibaro WallPlugs, Fibaro Fenstersensoren, Aeon Indoor Sirene, Greenwave WallPlugs, Qubino Dimmer

krikan

Zitat von: 9zehn75 am 10 März 2016, 12:56:41
Aber das war doch auch gar nicht mein Problem. Mein Problem war (und ist), dass meine Fibaro Fenstersensoren kein WUN senden, wenn ich sie manuell aufwecke. Der Sendstack wird aber scheinbar trotzdem abgearbeitet (was ich aber nicht bemerkte, weil ich immer auf eine WUN wartete).
Dann mißverstehe ich Dich. Willst Du wissen, ob APPLICATION_UPDATE einer WUN entspricht? Ja, so vermuten wir das. FHEM behandelt APPLICATION_UPDATE deshalb seit langem (mit der 3tägigen Unterbrechung) wie wakeup notification. Genauen Unterschied kennen wir nicht.

@Rudi: Danke

9zehn75

Zitat von: krikan am 10 März 2016, 13:11:57
Dann mißverstehe ich Dich. Willst Du wissen, ob APPLICATION_UPDATE einer WUN entspricht? Ja, so vermuten wir das. FHEM behandelt APPLICATION_UPDATE deshalb seit langem (mit der 3tägigen Unterbrechung) wie wakeup notification. Genauen Unterschied kennen wir nicht.

Ja, genau das war mein Problem. Ich habe stundenlang versucht, bei meinen Fenstersensoren per manuellem Wakeup eine WUN hinzubekommen. Meine damalige Schlussfolgerung war, dass ich sie nicht aufgeweckt bekomme (, weil ich nicht wusste, dass APPLICATION_UPDATE einer WUN entspricht.

Daher hatte ich in oben in Bezug genommenen Beitrag geschrieben:

ZitatIch habe alle Repeater aus meinem Netz geworfen und die Devices in fhem gelöscht. Nun gibt es nur noch einen Controller. Dann habe ich einen Fenstersensor abgebaut und sitze nun seit einer Stunde hier und teste. Wannimmer ich versuche ihn manuell zu wecken, erscheint in seinem Log eine Meldung wie die Folgende:

2016-02-23_21:01:49 Fenster_Keller_Waesche CMD: ZW_APPLICATION_UPDATE

Jetzt bin ich froh, dass scheinbar das WU klappt, nur eben nicht per WUN quittiert wird.

Ich versuche, mich nächstes Mal klarer auszudrücken...
VG, 9zehn75

FHEM seit 02.02.2016: Raspberry Pi 2, ZME_UZB1, Fibaro WallPlugs, Fibaro Fenstersensoren, Aeon Indoor Sirene, Greenwave WallPlugs, Qubino Dimmer

krikan

Zitat von: 9zehn75 am 10 März 2016, 16:55:05
Ich versuche, mich nächstes Mal klarer auszudrücken...
Und ich aufmerksamer zu lesen...

Btw.: Öffne am Besten in einem 2. Fenster einen Event Monitor bei solchen Arbeiten. Im "list" erkennst Du auch, ob im Wakeup-Sendstack noch was offen ist. Aber vermutlich ist Dir das jetzt auch schon alles bekannt.

krikan

Vorweg: In meinem Tests haben sich die neuen Modul-Fassungen als sehr, sehr stabil erwiesen. Auch wenn ich mich wieder einmal mit den Extremen auseinandersetze.  :)

Zitat von: rudolfkoenig am 10 März 2016, 11:42:21
- bei 011300 (transmit queue overflow) Retry eingebaut.
011300 habe ich in 1,5 Stunden Dauerlast kein einziges mehr bekommen. Mit der "alten" Fassung kam das regelmäßig bei Last.

Zitatdoppeltes ACK Bug vermutlich gefixt. Kann nicht testen, da ich die doppelten Acks nicht reproduzieren kann.
Ich kann auch 4x 0013-ACK erzeugen und habe dabei festgestellt, dass auch nach 10(!) Sekunden noch die angeforderte Nachricht kommen kann (Antwort auf 010a001304038613852504d0 ab 18:56:37.930 ff.). Verstehen kann ich einen solch langen Zeitraum zwischen Abfrage und Antwort überhaupt nicht.
Es werden einige Nachrichten nicht per SW verschickt, da anscheinend die 0013-ACKs nicht der richtigen Nachricht zugeordnet werden können (18:57:05.993 ff).

Ganzes Log:
2016.03.10 18:56:26.849 2: ZWave get ZWave_SWITCH_MULTILEVEL_4 versionClass ASSOCIATION
2016.03.10 18:56:26.852 5: ZWDongle_Write 001304038613852504 (e345c452)
2016.03.10 18:56:26.867 5: SW: 010a001304038613852504d0
2016.03.10 18:56:26.931 2: ZWave get ZWave_SWITCH_MULTILEVEL_4 versionClass CONFIGURATION
2016.03.10 18:56:26.993 2: ZWave get ZWave_SWITCH_MULTILEVEL_4 versionClass FIRMWARE_UPDATE_MD
2016.03.10 18:56:27.039 2: ZWave get ZWave_SWITCH_MULTILEVEL_4 versionClass MANUFACTURER_PROPRIETARY
2016.03.10 18:56:27.094 2: ZWave get ZWave_SWITCH_MULTILEVEL_4 versionClass MANUFACTURER_SPECIFIC
2016.03.10 18:56:27.166 2: ZWave get ZWave_SWITCH_MULTILEVEL_4 versionClass METER
2016.03.10 18:56:27.236 2: ZWave get ZWave_SWITCH_MULTILEVEL_4 versionClass POWERLEVEL
2016.03.10 18:56:27.290 2: ZWave get ZWave_SWITCH_MULTILEVEL_4 versionClass PROTECTION
2016.03.10 18:56:27.335 2: ZWave get ZWave_SWITCH_MULTILEVEL_4 versionClass SCENE_ACTIVATION
2016.03.10 18:56:27.382 2: ZWave get ZWave_SWITCH_MULTILEVEL_4 versionClass SENSOR_MULTILEVEL
2016.03.10 18:56:27.436 2: ZWave get ZWave_SWITCH_MULTILEVEL_4 versionClass SWITCH_BINARY
2016.03.10 18:56:27.487 2: ZWave get ZWave_SWITCH_MULTILEVEL_4 versionClass SWITCH_MULTILEVEL
2016.03.10 18:56:27.542 2: ZWave get ZWave_SWITCH_MULTILEVEL_4 versionClass VERSION
2016.03.10 18:56:27.670 5: ACK received, WaitForAck=>2 for 010a001304038613852504d0
2016.03.10 18:56:27.673 4: ZWDongle_Read ZWDongle_0: rcvd 011301, sending ACK
2016.03.10 18:56:27.695 5: SW: 06
2016.03.10 18:56:27.700 5: ZWDongle_0 dispatch 011301
2016.03.10 18:56:37.186 4: no response from device, removing 010a001304038613852504d0 from dongle sendstack
2016.03.10 18:56:37.189 2: ZWave: No ACK from ZWave_SWITCH_MULTILEVEL_4 after 5s for sentget:1304038613852504
2016.03.10 18:56:37.197 5: ZWDongle_Write 001304038613702504 (e345c452)
2016.03.10 18:56:37.200 5: SW: 010a00130403861370250425
2016.03.10 18:56:37.911 4: ZWDongle_Read ZWDongle_0: rcvd 00130400, sending ACK
2016.03.10 18:56:37.924 5: SW: 06
2016.03.10 18:56:37.927 5: device ack reveived, removing 010a00130403861370250425 from dongle sendstack
2016.03.10 18:56:37.930 5: ZWDongle_0 dispatch 00130400
2016.03.10 18:56:37.943 4: CMD:ZW_SEND_DATA ID:00 ARG: CB:04
2016.03.10 18:56:37.945 4: ZWDongle_0 transmit OK for 04
2016.03.10 18:56:37.952 4: ZWDongle_Read ZWDongle_0: rcvd 00130400, sending ACK
2016.03.10 18:56:37.965 5: SW: 06
2016.03.10 18:56:37.970 5: ZWDongle_0 dispatch 00130400
2016.03.10 18:56:37.984 4: CMD:ZW_SEND_DATA ID:00 ARG: CB:04
2016.03.10 18:56:37.986 4: ZWDongle_0 transmit OK for 04
2016.03.10 18:56:37.992 4: ZWDongle_Read ZWDongle_0: rcvd 00130400, sending ACK
2016.03.10 18:56:38.005 5: SW: 06
2016.03.10 18:56:38.010 5: ZWDongle_0 dispatch 00130400
2016.03.10 18:56:38.025 4: CMD:ZW_SEND_DATA ID:00 ARG: CB:04
2016.03.10 18:56:38.027 4: ZWDongle_0 transmit OK for 04
2016.03.10 18:56:38.045 4: ZWDongle_Read ZWDongle_0: rcvd 00130400, sending ACK
2016.03.10 18:56:38.047 5: SW: 06
2016.03.10 18:56:38.052 5: ZWDongle_0 dispatch 00130400
2016.03.10 18:56:38.056 4: CMD:ZW_SEND_DATA ID:00 ARG: CB:04
2016.03.10 18:56:38.057 4: ZWDongle_0 transmit OK for 04
2016.03.10 18:56:38.079 4: ZWDongle_Read ZWDongle_0: rcvd 000400040486148502, sending ACK
2016.03.10 18:56:38.081 5: SW: 06
2016.03.10 18:56:38.095 5: ZWDongle_0 dispatch 000400040486148502
2016.03.10 18:56:38.098 4: CMD:APPLICATION_COMMAND_HANDLER ID:04 ARG:0486148502 CB:00
2016.03.10 18:56:38.116 5: ZWDongle_Write 0013040386137a2504 (e345c452)
2016.03.10 18:56:38.120 5: SW: 010a0013040386137a25042f
2016.03.10 18:56:38.129 4: ZWDongle_Read ZWDongle_0: rcvd 000400040486148502, sending ACK
2016.03.10 18:56:38.131 5: SW: 06
2016.03.10 18:56:38.145 5: ZWDongle_0 dispatch 000400040486148502
2016.03.10 18:56:38.149 4: CMD:APPLICATION_COMMAND_HANDLER ID:04 ARG:0486148502 CB:00
2016.03.10 18:56:38.169 5: ZWDongle_Write 001304038613912504 (e345c452)
2016.03.10 18:56:38.186 4: ZWDongle_Read ZWDongle_0: rcvd 000400040486148502, sending ACK
2016.03.10 18:56:38.188 5: SW: 06
2016.03.10 18:56:38.194 5: ZWDongle_0 dispatch 000400040486148502
2016.03.10 18:56:38.198 4: CMD:APPLICATION_COMMAND_HANDLER ID:04 ARG:0486148502 CB:00
2016.03.10 18:56:38.217 5: ZWDongle_Write 001304038613722504 (e345c452)
2016.03.10 18:56:38.233 4: ZWDongle_Read ZWDongle_0: rcvd 000400040486148502, sending ACK
2016.03.10 18:56:38.235 5: SW: 06
2016.03.10 18:56:38.246 5: ZWDongle_0 dispatch 000400040486148502
2016.03.10 18:56:38.249 4: CMD:APPLICATION_COMMAND_HANDLER ID:04 ARG:0486148502 CB:00
2016.03.10 18:56:38.267 5: ZWDongle_Write 001304038613322504 (e345c452)
2016.03.10 18:56:38.272 5: ACK received, WaitForAck=>2 for 010a0013040386137a25042f
2016.03.10 18:56:38.285 4: ZWDongle_Read ZWDongle_0: rcvd 011301, sending ACK
2016.03.10 18:56:38.286 5: SW: 06
2016.03.10 18:56:38.290 5: ZWDongle_0 dispatch 011301
2016.03.10 18:56:50.594 4: no response from device, removing 010a0013040386137a25042f from dongle sendstack
2016.03.10 18:56:50.597 5: SW: 010a001304038613912504c4
2016.03.10 18:56:50.602 2: ZWave: No ACK from ZWave_SWITCH_MULTILEVEL_4 after 5s for sentget:1304038613322504
2016.03.10 18:56:50.607 5: ZWDongle_Write 001304038613732504 (e345c452)
2016.03.10 18:56:50.629 4: ZWDongle_Read ZWDongle_0: rcvd 00130400, sending ACK
2016.03.10 18:56:50.631 5: SW: 06
2016.03.10 18:56:50.648 5: device ack reveived, removing 010a001304038613912504c4 from dongle sendstack
2016.03.10 18:56:50.652 5: ZWDongle_0 dispatch 00130400
2016.03.10 18:56:50.656 4: CMD:ZW_SEND_DATA ID:00 ARG: CB:04
2016.03.10 18:56:50.658 4: ZWDongle_0 transmit OK for 04
2016.03.10 18:56:50.688 4: ZWDongle_Read ZWDongle_0: rcvd 000400040486147001, sending ACK
2016.03.10 18:56:50.690 5: SW: 06
2016.03.10 18:56:50.694 5: ZWDongle_0 dispatch 000400040486147001
2016.03.10 18:56:50.697 4: CMD:APPLICATION_COMMAND_HANDLER ID:04 ARG:0486147001 CB:00
2016.03.10 18:56:50.714 5: ZWDongle_Write 001304038613752504 (e345c452)
2016.03.10 18:56:50.718 5: SW: 010a00130403861372250427
2016.03.10 18:56:50.735 5: ACK received, WaitForAck=>2 for 010a00130403861372250427
2016.03.10 18:56:50.738 4: ZWDongle_Read ZWDongle_0: rcvd 011301, sending ACK
2016.03.10 18:56:50.740 5: SW: 06
2016.03.10 18:56:50.754 5: ZWDongle_0 dispatch 011301
2016.03.10 18:56:50.767 4: ZWDongle_Read ZWDongle_0: rcvd 00130400, sending ACK
2016.03.10 18:56:50.774 5: SW: 06
2016.03.10 18:56:50.782 5: device ack reveived, removing 010a00130403861372250427 from dongle sendstack
2016.03.10 18:56:50.790 5: ZWDongle_0 dispatch 00130400
2016.03.10 18:56:50.799 4: CMD:ZW_SEND_DATA ID:00 ARG: CB:04
2016.03.10 18:56:50.804 4: ZWDongle_0 transmit OK for 04
2016.03.10 18:56:50.822 4: ZWDongle_Read ZWDongle_0: rcvd 000400040486147a01, sending ACK
2016.03.10 18:56:50.827 5: SW: 06
2016.03.10 18:56:50.839 5: ZWDongle_0 dispatch 000400040486147a01
2016.03.10 18:56:50.848 4: CMD:APPLICATION_COMMAND_HANDLER ID:04 ARG:0486147a01 CB:00
2016.03.10 18:56:50.873 5: ZWDongle_Write 0013040386132b2504 (e345c452)
2016.03.10 18:56:50.883 5: SW: 010a00130403861332250467
2016.03.10 18:56:50.896 5: ACK received, WaitForAck=>2 for 010a00130403861332250467
2016.03.10 18:56:50.898 4: ZWDongle_Read ZWDongle_0: rcvd 011301, sending ACK
2016.03.10 18:56:50.901 5: SW: 06
2016.03.10 18:56:50.915 5: ZWDongle_0 dispatch 011301
2016.03.10 18:57:04.825 4: no response from device, removing 010a00130403861332250467 from dongle sendstack
2016.03.10 18:57:04.826 5: SW: 010a00130403861373250426
2016.03.10 18:57:04.834 2: ZWave: No ACK from ZWave_SWITCH_MULTILEVEL_4 after 5s for sentget:13040386132b2504
2016.03.10 18:57:04.837 5: ZWDongle_Write 001304038613312504 (e345c452)
2016.03.10 18:57:05.836 4: ZWDongle_Read ZWDongle_0: rcvd 00130400, sending ACK
2016.03.10 18:57:05.837 5: SW: 06
2016.03.10 18:57:05.840 5: device ack reveived, removing 010a00130403861373250426 from dongle sendstack
2016.03.10 18:57:05.843 5: ZWDongle_0 dispatch 00130400
2016.03.10 18:57:05.856 4: CMD:ZW_SEND_DATA ID:00 ARG: CB:04
2016.03.10 18:57:05.857 4: ZWDongle_0 transmit OK for 04
2016.03.10 18:57:05.863 4: ZWDongle_Read ZWDongle_0: rcvd 000400040486149101, sending ACK
2016.03.10 18:57:05.875 5: SW: 06
2016.03.10 18:57:05.879 5: ZWDongle_0 dispatch 000400040486149101
2016.03.10 18:57:05.881 4: CMD:APPLICATION_COMMAND_HANDLER ID:04 ARG:0486149101 CB:00
2016.03.10 18:57:05.898 5: ZWDongle_Write 001304038613252504 (e345c452)
2016.03.10 18:57:05.901 5: SW: 010a00130403861375250420
2016.03.10 18:57:05.924 4: ZWDongle_Read ZWDongle_0: CAN received
2016.03.10 18:57:05.927 5: ACK received, WaitForAck=>2 for 010a00130403861375250420
2016.03.10 18:57:05.929 4: ZWDongle_Read ZWDongle_0: rcvd 011301, sending ACK
2016.03.10 18:57:05.930 5: SW: 06
2016.03.10 18:57:05.946 5: ZWDongle_0 dispatch 011301
2016.03.10 18:57:05.949 4: ZWDongle_Read ZWDongle_0: rcvd 00130400, sending ACK
2016.03.10 18:57:05.950 5: SW: 06
2016.03.10 18:57:05.964 5: device ack reveived, removing 010a00130403861375250420 from dongle sendstack
2016.03.10 18:57:05.966 5: ZWDongle_0 dispatch 00130400
2016.03.10 18:57:05.968 4: CMD:ZW_SEND_DATA ID:00 ARG: CB:04
2016.03.10 18:57:05.970 4: ZWDongle_0 transmit OK for 04
2016.03.10 18:57:05.988 4: ZWDongle_Read ZWDongle_0: rcvd 00130400, sending ACK
2016.03.10 18:57:05.989 5: SW: 06
2016.03.10 18:57:05.993 5: device ack reveived, removing 010a0013040386132b25047e from dongle sendstack
2016.03.10 18:57:05.996 5: ZWDongle_0 dispatch 00130400
2016.03.10 18:57:05.998 4: CMD:ZW_SEND_DATA ID:00 ARG: CB:04
2016.03.10 18:57:06.000 4: ZWDongle_0 transmit OK for 04
2016.03.10 18:57:06.015 4: ZWDongle_Read ZWDongle_0: rcvd 00130400, sending ACK
2016.03.10 18:57:06.016 5: SW: 06
2016.03.10 18:57:06.024 5: device ack reveived, removing 010a00130403861331250464 from dongle sendstack
2016.03.10 18:57:06.026 5: ZWDongle_0 dispatch 00130400
2016.03.10 18:57:06.028 4: CMD:ZW_SEND_DATA ID:00 ARG: CB:04
2016.03.10 18:57:06.030 4: ZWDongle_0 transmit OK for 04
2016.03.10 18:57:06.045 4: ZWDongle_Read ZWDongle_0: rcvd 00130400, sending ACK
2016.03.10 18:57:06.046 5: SW: 06
2016.03.10 18:57:06.055 5: device ack reveived, removing 010a00130403861325250470 from dongle sendstack
2016.03.10 18:57:06.057 5: ZWDongle_0 dispatch 00130400
2016.03.10 18:57:06.060 4: CMD:ZW_SEND_DATA ID:00 ARG: CB:04
2016.03.10 18:57:06.061 4: ZWDongle_0 transmit OK for 04
2016.03.10 18:57:06.076 4: ZWDongle_Read ZWDongle_0: rcvd 000400040486143202, sending ACK
2016.03.10 18:57:06.078 5: SW: 06
2016.03.10 18:57:06.084 5: ZWDongle_0 dispatch 000400040486143202
2016.03.10 18:57:06.087 4: CMD:APPLICATION_COMMAND_HANDLER ID:04 ARG:0486143202 CB:00
2016.03.10 18:57:06.092 5: ZWDongle_Write 001304038613262504 (e345c452)
2016.03.10 18:57:06.106 5: SW: 010a00130403861326250473
2016.03.10 18:57:06.115 4: ZWDongle_Read ZWDongle_0: rcvd 000400040486143202, sending ACK
2016.03.10 18:57:06.116 5: SW: 06
2016.03.10 18:57:06.124 5: ZWDongle_0 dispatch 000400040486143202
2016.03.10 18:57:06.127 4: CMD:APPLICATION_COMMAND_HANDLER ID:04 ARG:0486143202 CB:00
2016.03.10 18:57:06.132 5: ZWDongle_Write 001304038613862504 (e345c452)
2016.03.10 18:57:06.157 4: ZWDongle_Read ZWDongle_0: rcvd 000400040486143202, sending ACK
2016.03.10 18:57:06.158 5: SW: 06
2016.03.10 18:57:06.162 5: ZWDongle_0 dispatch 000400040486143202
2016.03.10 18:57:06.165 4: CMD:APPLICATION_COMMAND_HANDLER ID:04 ARG:0486143202 CB:00
2016.03.10 18:57:06.185 4: ZWDongle_Read ZWDongle_0: rcvd 000400040486143202, sending ACK
2016.03.10 18:57:06.187 5: SW: 06
2016.03.10 18:57:06.190 5: ZWDongle_0 dispatch 000400040486143202
2016.03.10 18:57:06.204 4: CMD:APPLICATION_COMMAND_HANDLER ID:04 ARG:0486143202 CB:00
2016.03.10 18:57:06.208 5: ACK received, WaitForAck=>2 for 010a00130403861326250473
2016.03.10 18:57:06.210 4: ZWDongle_Read ZWDongle_0: rcvd 011301, sending ACK
2016.03.10 18:57:06.212 5: SW: 06
2016.03.10 18:57:06.221 5: ZWDongle_0 dispatch 011301
2016.03.10 18:57:06.234 4: ZWDongle_Read ZWDongle_0: rcvd 011301, sending ACK
2016.03.10 18:57:06.236 5: SW: 06
2016.03.10 18:57:06.240 5: ZWDongle_0 dispatch 011301
2016.03.10 18:57:14.256 4: no response from device, removing 010a00130403861326250473 from dongle sendstack
2016.03.10 18:57:14.258 5: SW: 010a001304038613862504d3
2016.03.10 18:57:15.149 4: ZWDongle_Read ZWDongle_0: rcvd 00130400, sending ACK
2016.03.10 18:57:15.150 5: SW: 06
2016.03.10 18:57:15.165 5: device ack reveived, removing 010a001304038613862504d3 from dongle sendstack
2016.03.10 18:57:15.167 5: ZWDongle_0 dispatch 00130400
2016.03.10 18:57:15.170 4: CMD:ZW_SEND_DATA ID:00 ARG: CB:04
2016.03.10 18:57:15.172 4: ZWDongle_0 transmit OK for 04
2016.03.10 18:57:15.186 4: ZWDongle_Read ZWDongle_0: rcvd 000400040486147301, sending ACK
2016.03.10 18:57:15.187 5: SW: 06
2016.03.10 18:57:15.195 5: ZWDongle_0 dispatch 000400040486147301
2016.03.10 18:57:15.197 4: CMD:APPLICATION_COMMAND_HANDLER ID:04 ARG:0486147301 CB:00
2016.03.10 18:57:15.201 4: ZWDongle_Read ZWDongle_0: CAN received
2016.03.10 18:57:15.213 4: ZWDongle_Read ZWDongle_0: rcvd 011301, sending ACK
2016.03.10 18:57:15.215 5: SW: 06
2016.03.10 18:57:15.219 5: ZWDongle_0 dispatch 011301
2016.03.10 18:57:15.222 4: ZWDongle_Read ZWDongle_0: rcvd 00130400, sending ACK
2016.03.10 18:57:15.234 5: SW: 06
2016.03.10 18:57:15.238 5: ZWDongle_0 dispatch 00130400
2016.03.10 18:57:15.240 4: CMD:ZW_SEND_DATA ID:00 ARG: CB:04
2016.03.10 18:57:15.242 4: ZWDongle_0 transmit OK for 04
2016.03.10 18:57:15.257 4: ZWDongle_Read ZWDongle_0: rcvd 000400040486142603, sending ACK
2016.03.10 18:57:15.258 5: SW: 06
2016.03.10 18:57:15.262 5: ZWDongle_0 dispatch 000400040486142603
2016.03.10 18:57:15.274 4: CMD:APPLICATION_COMMAND_HANDLER ID:04 ARG:0486142603 CB:00
2016.03.10 18:57:15.279 4: ZWDongle_Read ZWDongle_0: rcvd 011301, sending ACK
2016.03.10 18:57:15.280 5: SW: 06
2016.03.10 18:57:15.295 5: ZWDongle_0 dispatch 011301
2016.03.10 18:57:26.077 4: ZWDongle_Read ZWDongle_0: rcvd 00130400, sending ACK
2016.03.10 18:57:26.078 5: SW: 06
2016.03.10 18:57:26.094 5: ZWDongle_0 dispatch 00130400
2016.03.10 18:57:26.097 4: CMD:ZW_SEND_DATA ID:00 ARG: CB:04
2016.03.10 18:57:26.098 4: ZWDongle_0 transmit OK for 04
2016.03.10 18:57:26.103 4: ZWDongle_Read ZWDongle_0: rcvd 000400040486148601, sending ACK
2016.03.10 18:57:26.106 5: SW: 06
2016.03.10 18:57:26.109 5: ZWDongle_0 dispatch 000400040486148601
2016.03.10 18:57:26.125 4: CMD:APPLICATION_COMMAND_HANDLER ID:04 ARG:0486148601 CB:00




krikan

Zitat von: krikan am 10 März 2016, 21:27:12
Es werden einige Nachrichten nicht per SW verschickt, da anscheinend die 0013-ACKs nicht der richtigen Nachricht zugeordnet werden können (18:57:05.993 ff).
011301-Prüfung fehlt bei den nicht versandten Nachrichten ganz.

krikan

Noch mal zum letzten Log:
Da ich die langen Pausen im Log nicht verstehe und immer auch noch Hardware-/Systemprobleme befürchte, habe ich diese Nacht das Modul "perfmon" laufen lassen. Es sind keine "freezes" angefallen. Hatte ich bald auch nicht anders erwartet, da ich solche langen Pausen zwischen den Nachrichten bisher im system noch nicht beobachtet hatte und auch nur dieses eine Mal festgestellt habe. Also betrachte ich das Log als Ausnahme. Ich erkenne im Log keine fehlenden (verschluckten) Nachrichten, so dass ich das Log als falsch/fehlerhaft verwerfen kann. Für mein Verständnis ist die Nachrichtenabfolge/Logeintragfolge logisch nachvollziehbar nur die Zeitstempel machen mich stutzig.

rudolfkoenig

Zitat011301-Prüfung fehlt bei den nicht versandten Nachrichten ganz.
Stimmt. Falls wir das brauchen, werde ich es einbauen. Als naechstes kommt aber die fortlaufende CallbackId.



krikan

Zitat von: rudolfkoenig am 11 März 2016, 09:10:18
Stimmt. Falls wir das brauchen, werde ich es einbauen.
Brauchen? Tendiere zu unnötig, Hauptsache der Fehlerfall 011300 wird mit Resend behandelt.
Im Übrigen hast Du die nächsten ca. 1,5 Wochen wegen anderweitiger Verpflichtung Ruhe vor meinen Extremtests  :) .

rudolfkoenig

Ich habe die fortlaufenden callbackIds implementiert, d.h. der Sendstack akzeptiert nur ACKs mit dem zum Nachricht passenden callbackid.

Ich habe die Aenderung mit dem KFOB und dem as6 getestet, sowohl mit dem zme Dongle als auch mit dem ZWCUL. Bei beidem get versionClassAll geuebt, beim as6 auch set und get configAll. Den "overflow" habe ich auch getestet: 00 wird als callbackid (CB) nicht vergeben, nur Werte zwischen 1 und ff. Ich habe keine Fehler gesehen, allerdings ist die Aenderung tiefgreifend, und koennte irgendwo Seiteneffekte haben.

scooty

Hallo zusammen,

anbei, wie von Christian hier angeregt, ein paar Infos/logs mit gesetztem Attribut "noWakeupForApplicationUpdate" bei einem Aeotec Multisensor 6, bei dem es bei einem wakeup zu NO_ACKS kommt:
List:
Internals:
   DEF        d79c8805 86
   IODev      ZW_Dongle
   LASTInputDev ZW_Dongle
   MSGCNT     242
   NAME       ZWave_SENSOR_MULTILEVEL_86
   NR         581
   STATE      nomotion
   TYPE       ZWave
   ZW_Dongle_MSGCNT 242
   ZW_Dongle_RAWMSG 00040056028407
   ZW_Dongle_TIME 2016-03-16 17:29:23
   homeId     d79c8805
   isWakeUp   1
   lastMsgSent 1458145763.4927
   nodeIdHex  56
   Readings:
     2016-02-24 13:09:27   CMD             ZW_APPLICATION_UPDATE
     2016-03-16 16:32:48   alarm           HomeSecurity: Previous Events cleared, arg 0000
     2016-02-14 12:18:32   assocGroup_1    Max 5 Nodes ZW_Dongle
     2016-02-14 12:18:32   assocGroups     1
     2016-03-16 17:29:23   battery         100 %
     2016-02-14 09:02:45   configBatteryReportingThreshold 5
     2016-02-14 09:02:45   configCommandOptions BinarySensorReport
     2016-02-14 09:02:45   configEnableDisableLockConfiguration Disable
     2016-02-14 09:02:45   configEnableMotionSensor EnabledLevel1MinimumSensitivity
     2016-02-14 10:18:51   configGroup1Interval 900
     2016-02-14 09:02:45   configGroup1Reports 241
     2016-02-14 09:02:45   configGroup2Interval 3600
     2016-02-14 09:02:45   configGroup2Reports 0
     2016-02-14 09:02:45   configGroup3Interval 3600
     2016-02-14 09:02:46   configGroup3Reports 0
     2016-02-14 09:02:46   configHumidityCalibration 0
     2016-02-14 09:02:46   configHumidityReportingThreshold 5
     2016-02-14 09:02:46   configLowBattery 20
     2016-02-14 09:02:46   configLowTempAlarm Disabled
     2016-02-14 09:02:46   configLuminanceCalibration 0
     2016-02-19 13:32:30   configLuminanceReportingThreshold 100
     2016-02-19 09:57:30   configOnTime    45
     2016-02-14 09:02:46   configReportingThreshold Enabled
     2016-02-14 09:02:46   configTemperatureCalibration 218
     2016-02-14 09:02:46   configTemperatureReportingThreshold 5
     2016-02-14 09:02:46   configUVReportingThreshold 2
     2016-02-14 09:02:46   configUltravioletCalibration 0
     2016-02-14 09:02:46   configWakeUp10MinutesOnPowerOn Yes
     2016-03-16 17:29:21   fp_TempHumMot   13.6 C / 26 % / nomotion
     2016-03-16 17:29:22   humidity        26 %
     2016-03-16 16:59:22   humidity_num    26
     2016-03-16 17:29:23   luminance       6657 Lux
     2016-02-14 08:59:12   model           Aeotec MultiSensor 6
     2016-02-14 08:59:12   modelConfig     aeotec/multisensor6.xml
     2016-02-14 08:59:12   modelId         0086-0002-0064
     2016-03-16 16:32:48   reportedState   closed
     2016-03-16 17:19:32   state           TRANSMIT_NO_ACK
     2016-03-16 17:29:21   temperature     13.6 C
     2016-03-16 17:29:21   temperature_num 13.6
     2016-03-16 17:19:32   transmit        NO_ACK
     2016-03-16 17:29:23   ultraviolet     1 UV
     2016-02-16 11:35:30   version         Lib 3 Prot 4.5 App 1.6 HW 100 FWCounter 0
     2016-03-16 17:29:23   wakeup          notification
     2016-02-17 09:10:52   wakeupIntervalCapabilitiesReport min 240 max 3600 default 3600 step 60
     2016-03-14 13:39:23   wakeupReport    interval 600 target 1
Attributes:
   IODev      ZW_Dongle
   classes    ZWAVEPLUS_INFO VERSION MANUFACTURER_SPECIFIC ASSOCIATION_GRP_INFO ASSOCIATION POWERLEVEL ALARM WAKE_UP BATTERY SENSOR_BINARY SENSOR_MULTILEVEL CONFIGURATION FIRMWARE_UPDATE_MD MARK DEVICE_RESET_LOCALLY
   comment    classes: WAKE_UP BATTERY
secureclasses: WAKE_UP ASSOCIATION_GRP_INFO
   devStateIcon motion:people_sensor@green nomotion:people_sensor@red
   event-on-change-reading state,alarm,humidity,luminance,temperature,ultraviolet,battery
   event-on-update-reading wakeup
   eventMap   open:motion closed:nomotion
   noWakeupForApplicationUpdate 1
   room       ZWave
   stateFormat reportedState
   userReadings fp_TempHumMot:temperature|humidity|state {ReadingsVal($name,"temperature","1")." / ".ReadingsVal($name,"humidity","1")." / ".InternalVal($name,"STATE","nomotion");;},
temperature_num:temperature {ReadingsNum($name,"temperature","1");;},
humidity_num:humidity {ReadingsNum($name,"humidity","1");;}


Log verbose 5 (wakeup um 17:29:23, sind noch ein paar weitere ZWave-Ereignisse beim loggen aufgetreten):
2016.03.16 17:29:01.066 4: ZWDongle_Read ZW_Dongle: rcvd 0004000d06310504220000, sending ACK
2016.03.16 17:29:01.067 5: SW: 06
2016.03.16 17:29:01.069 5: ZW_Dongle dispatch 0004000d06310504220000
2016.03.16 17:29:01.069 4: CMD:APPLICATION_COMMAND_HANDLER ID:0d ARG:06310504220000 CB:00
2016.03.16 17:29:15.491 4: ZWDongle_Read ZW_Dongle: rcvd 0004003912600d01033202213400000050000900000041, sending ACK
2016.03.16 17:29:15.491 5: SW: 06
2016.03.16 17:29:15.494 5: ZW_Dongle dispatch 0004003912600d01033202213400000050000900000041
2016.03.16 17:29:15.495 4: CMD:APPLICATION_COMMAND_HANDLER ID:39 ARG:12600d01033202213400000050000900000041 CB:00
2016.03.16 17:29:21.932 4: ZWDongle_Read ZW_Dongle: rcvd 0004005606310501220088, sending ACK
2016.03.16 17:29:21.932 5: SW: 06
2016.03.16 17:29:21.934 5: ZW_Dongle dispatch 0004005606310501220088
2016.03.16 17:29:21.935 4: CMD:APPLICATION_COMMAND_HANDLER ID:56 ARG:06310501220088 CB:00
2016.03.16 17:29:22.407 4: ZWDongle_Read ZW_Dongle: rcvd 0004005605310505011a, sending ACK
2016.03.16 17:29:22.408 5: SW: 06
2016.03.16 17:29:22.409 5: ZW_Dongle dispatch 0004005605310505011a
2016.03.16 17:29:22.410 4: CMD:APPLICATION_COMMAND_HANDLER ID:56 ARG:05310505011a CB:00
2016.03.16 17:29:23.209 4: ZWDongle_Read ZW_Dongle: rcvd 0004005603800364, sending ACK
2016.03.16 17:29:23.210 5: SW: 06
2016.03.16 17:29:23.212 5: ZW_Dongle dispatch 0004005603800364
2016.03.16 17:29:23.213 4: CMD:APPLICATION_COMMAND_HANDLER ID:56 ARG:03800364 CB:00
2016.03.16 17:29:23.291 4: ZWDongle_Read ZW_Dongle: rcvd 00040056063105030a1a01, sending ACK
2016.03.16 17:29:23.292 5: SW: 06
2016.03.16 17:29:23.294 5: ZW_Dongle dispatch 00040056063105030a1a01
2016.03.16 17:29:23.295 4: CMD:APPLICATION_COMMAND_HANDLER ID:56 ARG:063105030a1a01 CB:00
2016.03.16 17:29:23.410 4: ZWDongle_Read ZW_Dongle: rcvd 000400560531051b0101, sending ACK
2016.03.16 17:29:23.410 5: SW: 06
2016.03.16 17:29:23.412 5: ZW_Dongle dispatch 000400560531051b0101
2016.03.16 17:29:23.412 4: CMD:APPLICATION_COMMAND_HANDLER ID:56 ARG:0531051b0101 CB:00
2016.03.16 17:29:23.489 4: ZWDongle_Read ZW_Dongle: rcvd 00040056028407, sending ACK
2016.03.16 17:29:23.489 5: SW: 06
2016.03.16 17:29:23.491 5: ZW_Dongle dispatch 00040056028407
2016.03.16 17:29:23.491 4: CMD:APPLICATION_COMMAND_HANDLER ID:56 ARG:028407 CB:00
2016.03.16 17:29:24.491 4: ZWDongle_Read ZW_Dongle: rcvd 0004003912600d01033202213400000042000900000050, sending ACK
2016.03.16 17:29:24.491 5: SW: 06
2016.03.16 17:29:24.493 5: ZW_Dongle dispatch 0004003912600d01033202213400000042000900000050
2016.03.16 17:29:24.493 4: CMD:APPLICATION_COMMAND_HANDLER ID:39 ARG:12600d01033202213400000042000900000050 CB:00
2016.03.16 17:29:25.528 5: ZWDongle_Write 00135602840825c0 (d79c8805)
2016.03.16 17:29:25.530 5: SW: 010900135602840825c0d8
2016.03.16 17:29:25.535 5: ACK received, WaitForAck=>2 for 010900135602840825c0d8
2016.03.16 17:29:25.542 4: ZWDongle_Read ZW_Dongle: rcvd 011301, sending ACK
2016.03.16 17:29:25.543 5: SW: 06
2016.03.16 17:29:25.544 5: ZW_Dongle dispatch 011301
2016.03.16 17:29:27.564 4: no response from device, removing 010900135602840825c0d8 from dongle sendstack
2016.03.16 17:29:29.462 2: ZWave set WGEG_ENTF off
2016.03.16 17:29:29.463 5: ZWDongle_Write 00131b0325010025c1 (d79c8805)
2016.03.16 17:29:29.465 5: SW: 010a00131b0325010025c13e
2016.03.16 17:29:29.734 5: ACK received, WaitForAck=>2 for 010a00131b0325010025c13e
2016.03.16 17:29:29.735 4: ZWDongle_Read ZW_Dongle: rcvd 011301, sending ACK
2016.03.16 17:29:29.735 5: SW: 06
2016.03.16 17:29:29.737 5: ZW_Dongle dispatch 011301
2016.03.16 17:29:29.747 4: ZWDongle_Read ZW_Dongle: rcvd 0013c1000013, sending ACK
2016.03.16 17:29:29.747 5: SW: 06
2016.03.16 17:29:29.749 5: device ack reveived, removing 010a00131b0325010025c13e from dongle sendstack
2016.03.16 17:29:29.750 5: ZW_Dongle dispatch 0013c1000013
2016.03.16 17:29:29.750 4: CMD:ZW_SEND_DATA ID:00 ARG:0013 CB:c1
2016.03.16 17:29:29.750 4: ZW_Dongle transmit OK for CB c1, target WGEG_ENTF
2016.03.16 17:29:30.399 4: ZWDongle_Read ZW_Dongle: rcvd 0004001b06310504220000, sending ACK
2016.03.16 17:29:30.400 5: SW: 06
2016.03.16 17:29:30.401 5: ZW_Dongle dispatch 0004001b06310504220000
2016.03.16 17:29:30.402 4: CMD:APPLICATION_COMMAND_HANDLER ID:1b ARG:06310504220000 CB:00
2016.03.16 17:29:33.636 4: ZWDongle_Read ZW_Dongle: rcvd 0013c10101a0, sending ACK
2016.03.16 17:29:33.637 5: SW: 06
2016.03.16 17:29:33.639 5: ZW_Dongle dispatch 0013c10101a0
2016.03.16 17:29:33.640 4: CMD:ZW_SEND_DATA ID:01 ARG:01a0 CB:c1
2016.03.16 17:29:33.641 2: ZW_Dongle transmit NO_ACK for CB c1, target WGEG_ENTF
2016.03.16 17:29:42.491 4: ZWDongle_Read ZW_Dongle: rcvd 0004003912600d01033202213400000051000900000041, sending ACK
2016.03.16 17:29:42.491 5: SW: 06
2016.03.16 17:29:42.493 5: ZW_Dongle dispatch 0004003912600d01033202213400000051000900000041
2016.03.16 17:29:42.494 4: CMD:APPLICATION_COMMAND_HANDLER ID:39 ARG:12600d01033202213400000051000900000041 CB:00
2016.03.16 17:29:51.491 4: ZWDongle_Read ZW_Dongle: rcvd 0004003912600d0103320221340000005a000900000051, sending ACK
2016.03.16 17:29:51.492 5: SW: 06
2016.03.16 17:29:51.494 5: ZW_Dongle dispatch 0004003912600d0103320221340000005a000900000051
2016.03.16 17:29:51.495 4: CMD:APPLICATION_COMMAND_HANDLER ID:39 ARG:12600d0103320221340000005a000900000051 CB:00
2016.03.16 17:29:59.102 4: ZWDongle_Read ZW_Dongle: rcvd 0004003a12600d010632022134000000b30009000000a7, sending ACK
2016.03.16 17:29:59.103 5: SW: 06
2016.03.16 17:29:59.105 5: ZW_Dongle dispatch 0004003a12600d010632022134000000b30009000000a7
2016.03.16 17:29:59.106 4: CMD:APPLICATION_COMMAND_HANDLER ID:3a ARG:12600d010632022134000000b30009000000a7 CB:00
2016.03.16 17:30:00.056 2: ZWave set SZOG_LURE on
2016.03.16 17:30:00.057 5: ZWDongle_Write 00134007600d01022501FF25c2 (d79c8805)
2016.03.16 17:30:00.059 5: SW: 010e00134007600d01022501FF25c2f7
2016.03.16 17:30:00.064 3: SZOG_LURE on-for-timer 1800
2016.03.16 17:30:00.107 5: ACK received, WaitForAck=>2 for 010e00134007600d01022501FF25c2f7
2016.03.16 17:30:00.107 4: ZWDongle_Read ZW_Dongle: rcvd 011301, sending ACK
2016.03.16 17:30:00.108 5: SW: 06
2016.03.16 17:30:00.109 5: ZW_Dongle dispatch 011301
2016.03.16 17:30:00.113 4: ZWDongle_Read ZW_Dongle: rcvd 0013c2000002, sending ACK
2016.03.16 17:30:00.114 5: SW: 06
2016.03.16 17:30:00.115 5: device ack reveived, removing 010e00134007600d01022501FF25c2f7 from dongle sendstack
2016.03.16 17:30:00.116 5: ZW_Dongle dispatch 0013c2000002
2016.03.16 17:30:00.116 4: CMD:ZW_SEND_DATA ID:00 ARG:0002 CB:c2
2016.03.16 17:30:00.117 4: ZW_Dongle transmit OK for CB c2, target SZOG_SLL_00
2016.03.16 17:30:09.491 4: ZWDongle_Read ZW_Dongle: rcvd 0004003912600d01033202213400000048000900000058, sending ACK
2016.03.16 17:30:09.492 5: SW: 06
2016.03.16 17:30:09.494 5: ZW_Dongle dispatch 0004003912600d01033202213400000048000900000058
2016.03.16 17:30:09.495 4: CMD:APPLICATION_COMMAND_HANDLER ID:39 ARG:12600d01033202213400000048000900000058 CB:00
2016.03.16 17:30:17.102 4: ZWDongle_Read ZW_Dongle: rcvd 0004003a12600d0106320221340000009c0009000000ad, sending ACK
2016.03.16 17:30:17.103 5: SW: 06
2016.03.16 17:30:17.105 5: ZW_Dongle dispatch 0004003a12600d0106320221340000009c0009000000ad
2016.03.16 17:30:17.105 4: CMD:APPLICATION_COMMAND_HANDLER ID:3a ARG:12600d0106320221340000009c0009000000ad CB:00
2016.03.16 17:30:18.491 4: ZWDongle_Read ZW_Dongle: rcvd 0004003912600d0103320221340000003b000900000048, sending ACK
2016.03.16 17:30:18.492 5: SW: 06
2016.03.16 17:30:18.494 5: ZW_Dongle dispatch 0004003912600d0103320221340000003b000900000048
2016.03.16 17:30:18.495 4: CMD:APPLICATION_COMMAND_HANDLER ID:39 ARG:12600d0103320221340000003b000900000048 CB:00
2016.03.16 17:30:35.102 4: ZWDongle_Read ZW_Dongle: rcvd 0004003a12600d010632022134000000b5000900000093, sending ACK
2016.03.16 17:30:35.103 5: SW: 06
2016.03.16 17:30:35.105 5: ZW_Dongle dispatch 0004003a12600d010632022134000000b5000900000093
2016.03.16 17:30:35.105 4: CMD:APPLICATION_COMMAND_HANDLER ID:3a ARG:12600d010632022134000000b5000900000093 CB:00
2016.03.16 17:30:36.491 4: ZWDongle_Read ZW_Dongle: rcvd 0004003912600d0103320221340000004600090000003b, sending ACK
2016.03.16 17:30:36.491 5: SW: 06
2016.03.16 17:30:36.493 5: ZW_Dongle dispatch 0004003912600d0103320221340000004600090000003b
2016.03.16 17:30:36.494 4: CMD:APPLICATION_COMMAND_HANDLER ID:39 ARG:12600d0103320221340000004600090000003b CB:00
2016.03.16 17:30:42.556 1: Perfmon: possible freeze starting at 17:30:41, delay is 1.555
2016.03.16 17:30:54.490 4: ZWDongle_Read ZW_Dongle: rcvd 0004003912600d0103320221340000006600090000004c, sending ACK
2016.03.16 17:30:54.491 5: SW: 06
2016.03.16 17:30:54.493 5: ZW_Dongle dispatch 0004003912600d0103320221340000006600090000004c
2016.03.16 17:30:54.493 4: CMD:APPLICATION_COMMAND_HANDLER ID:39 ARG:12600d0103320221340000006600090000004c CB:00
Fhem auf Gigabyte Brix
CUL V3 HM / CUL V3 MAX / MaxCube aFW Homematic&MAX / ZWave.me ZME_UZB1 / SDuino 433 / Velux KLF200
Homematic / MAX / Logitech Hub / ZWave / Wifi LED / div. 433 Temperatursensoren / pywws WH1080 / IO Homecontrol

krikan

Hallo Andreas,
könntest Du mal mit dem Attribut WNMI_delay auf 1 Sekunde oder weniger probieren. Mir fällt sonst momentan nichts auf.
Danke, Christian

scooty

WNMI_delay 1
Wakeup um 18:19:23h
NO_ACK um 18:19:32.379
2016.03.16 18:19:12.498 4: ZWDongle_Read ZW_Dongle: rcvd 0004003912600d0103320221340000004900090000003d, sending ACK
2016.03.16 18:19:12.498 5: SW: 06
2016.03.16 18:19:12.500 5: ZW_Dongle dispatch 0004003912600d0103320221340000004900090000003d
2016.03.16 18:19:12.501 4: CMD:APPLICATION_COMMAND_HANDLER ID:39 ARG:12600d0103320221340000004900090000003d CB:00
2016.03.16 18:19:21.498 4: ZWDongle_Read ZW_Dongle: rcvd 0004003912600d01033202213400000040000900000049, sending ACK
2016.03.16 18:19:21.499 5: SW: 06
2016.03.16 18:19:21.501 5: ZW_Dongle dispatch 0004003912600d01033202213400000040000900000049
2016.03.16 18:19:21.501 4: CMD:APPLICATION_COMMAND_HANDLER ID:39 ARG:12600d01033202213400000040000900000049 CB:00
2016.03.16 18:19:21.911 4: ZWDongle_Read ZW_Dongle: rcvd 000400560631050122002e, sending ACK
2016.03.16 18:19:21.911 5: SW: 06
2016.03.16 18:19:21.913 5: ZW_Dongle dispatch 000400560631050122002e
2016.03.16 18:19:21.914 4: CMD:APPLICATION_COMMAND_HANDLER ID:56 ARG:0631050122002e CB:00
2016.03.16 18:19:22.390 4: ZWDongle_Read ZW_Dongle: rcvd 00040056053105050127, sending ACK
2016.03.16 18:19:22.391 5: SW: 06
2016.03.16 18:19:22.392 5: ZW_Dongle dispatch 00040056053105050127
2016.03.16 18:19:22.393 4: CMD:APPLICATION_COMMAND_HANDLER ID:56 ARG:053105050127 CB:00
2016.03.16 18:19:23.248 4: ZWDongle_Read ZW_Dongle: rcvd 00040056063105030a01eb, sending ACK
2016.03.16 18:19:23.249 5: SW: 06
2016.03.16 18:19:23.251 5: ZW_Dongle dispatch 00040056063105030a01eb
2016.03.16 18:19:23.252 4: CMD:APPLICATION_COMMAND_HANDLER ID:56 ARG:063105030a01eb CB:00
2016.03.16 18:19:23.426 4: ZWDongle_Read ZW_Dongle: rcvd 00040056028407, sending ACK
2016.03.16 18:19:23.426 5: SW: 06
2016.03.16 18:19:23.428 5: ZW_Dongle dispatch 00040056028407
2016.03.16 18:19:23.428 4: CMD:APPLICATION_COMMAND_HANDLER ID:56 ARG:028407 CB:00
2016.03.16 18:19:24.451 5: ZWDongle_Write 00135602840825d8 (d79c8805)
2016.03.16 18:19:24.453 5: SW: 010900135602840825d8c0
2016.03.16 18:19:24.458 5: ACK received, WaitForAck=>2 for 010900135602840825d8c0
2016.03.16 18:19:24.465 4: ZWDongle_Read ZW_Dongle: rcvd 011301, sending ACK
2016.03.16 18:19:24.465 5: SW: 06
2016.03.16 18:19:24.467 5: ZW_Dongle dispatch 011301
2016.03.16 18:19:26.481 4: no response from device, removing 010900135602840825d8c0 from dongle sendstack
2016.03.16 18:19:29.111 4: ZWDongle_Read ZW_Dongle: rcvd 0004003a12600d010632022134000000c7000900000095, sending ACK
2016.03.16 18:19:29.111 5: SW: 06
2016.03.16 18:19:29.113 5: ZW_Dongle dispatch 0004003a12600d010632022134000000c7000900000095
2016.03.16 18:19:29.114 4: CMD:APPLICATION_COMMAND_HANDLER ID:3a ARG:12600d010632022134000000c7000900000095 CB:00
2016.03.16 18:19:30.751 4: ZWDongle_Read ZW_Dongle: rcvd 0004003912600d01033202213400000048000900000040, sending ACK
2016.03.16 18:19:30.752 5: SW: 06
2016.03.16 18:19:30.753 5: ZW_Dongle dispatch 0004003912600d01033202213400000048000900000040
2016.03.16 18:19:30.754 4: CMD:APPLICATION_COMMAND_HANDLER ID:39 ARG:12600d01033202213400000048000900000040 CB:00
2016.03.16 18:19:32.373 4: ZWDongle_Read ZW_Dongle: rcvd 0013d8010318, sending ACK
2016.03.16 18:19:32.374 5: SW: 06
2016.03.16 18:19:32.378 5: ZW_Dongle dispatch 0013d8010318
2016.03.16 18:19:32.378 4: CMD:ZW_SEND_DATA ID:01 ARG:0318 CB:d8
2016.03.16 18:19:32.379 2: ZW_Dongle transmit NO_ACK for CB d8, target ZWave_SENSOR_MULTILEVEL_86
2016.03.16 18:19:32.439 4: ZWDongle_Read ZW_Dongle: rcvd 00040028063105012200ba, sending ACK
2016.03.16 18:19:32.439 5: SW: 06
2016.03.16 18:19:32.441 5: ZW_Dongle dispatch 00040028063105012200ba
2016.03.16 18:19:32.441 4: CMD:APPLICATION_COMMAND_HANDLER ID:28 ARG:063105012200ba CB:00
2016.03.16 18:19:32.993 4: ZWDongle_Read ZW_Dongle: rcvd 00040028053105050133, sending ACK
2016.03.16 18:19:32.993 5: SW: 06
2016.03.16 18:19:32.995 5: ZW_Dongle dispatch 00040028053105050133
2016.03.16 18:19:32.996 4: CMD:APPLICATION_COMMAND_HANDLER ID:28 ARG:053105050133 CB:00
2016.03.16 18:19:34.303 4: ZWDongle_Read ZW_Dongle: rcvd 0004002803800364, sending ACK
2016.03.16 18:19:34.304 5: SW: 06
2016.03.16 18:19:34.306 5: ZW_Dongle dispatch 0004002803800364
2016.03.16 18:19:34.306 4: CMD:APPLICATION_COMMAND_HANDLER ID:28 ARG:03800364 CB:00
2016.03.16 18:19:34.711 4: ZWDongle_Read ZW_Dongle: rcvd 00040028063105030a0089, sending ACK
2016.03.16 18:19:34.712 5: SW: 06
2016.03.16 18:19:34.714 5: ZW_Dongle dispatch 00040028063105030a0089
2016.03.16 18:19:34.714 4: CMD:APPLICATION_COMMAND_HANDLER ID:28 ARG:063105030a0089 CB:00
2016.03.16 18:19:34.953 4: ZWDongle_Read ZW_Dongle: rcvd 000400280531051b0100, sending ACK
2016.03.16 18:19:34.954 5: SW: 06
2016.03.16 18:19:34.956 5: ZW_Dongle dispatch 000400280531051b0100
2016.03.16 18:19:34.956 4: CMD:APPLICATION_COMMAND_HANDLER ID:28 ARG:0531051b0100 CB:00
2016.03.16 18:19:39.498 4: ZWDongle_Read ZW_Dongle: rcvd 0004003912600d0103320221340000005b000900000048, sending ACK
2016.03.16 18:19:39.499 5: SW: 06
2016.03.16 18:19:39.500 5: ZW_Dongle dispatch 0004003912600d0103320221340000005b000900000048
2016.03.16 18:19:39.501 4: CMD:APPLICATION_COMMAND_HANDLER ID:39 ARG:12600d0103320221340000005b000900000048 CB:00
2016.03.16 18:19:39.646 4: ZWDongle_Read ZW_Dongle: rcvd 0004000b03300300, sending ACK
2016.03.16 18:19:39.646 5: SW: 06
2016.03.16 18:19:39.648 5: ZW_Dongle dispatch 0004000b03300300
2016.03.16 18:19:39.649 4: CMD:APPLICATION_COMMAND_HANDLER ID:0b ARG:03300300 CB:00
2016.03.16 18:19:39.702 4: ZWDongle_Read ZW_Dongle: rcvd 0004000b03200100, sending ACK
2016.03.16 18:19:39.703 5: SW: 06
2016.03.16 18:19:39.704 5: ZW_Dongle dispatch 0004000b03200100
2016.03.16 18:19:39.705 4: CMD:APPLICATION_COMMAND_HANDLER ID:0b ARG:03200100 CB:00
2016.03.16 18:19:47.112 4: ZWDongle_Read ZW_Dongle: rcvd 0004003a12600d010632022134000000930009000000b5, sending ACK
2016.03.16 18:19:47.113 5: SW: 06
2016.03.16 18:19:47.115 5: ZW_Dongle dispatch 0004003a12600d010632022134000000930009000000b5
2016.03.16 18:19:47.115 4: CMD:APPLICATION_COMMAND_HANDLER ID:3a ARG:12600d010632022134000000930009000000b5 CB:00
2016.03.16 18:19:48.499 4: ZWDongle_Read ZW_Dongle: rcvd 0004003912600d0103320221340000004800090000005b, sending ACK
2016.03.16 18:19:48.499 5: SW: 06
2016.03.16 18:19:48.501 5: ZW_Dongle dispatch 0004003912600d0103320221340000004800090000005b
2016.03.16 18:19:48.502 4: CMD:APPLICATION_COMMAND_HANDLER ID:39 ARG:12600d0103320221340000004800090000005b CB:00
2016.03.16 18:19:57.389 4: ZWDongle_Read ZW_Dongle: rcvd 0004005d03300300, sending ACK
2016.03.16 18:19:57.390 5: SW: 06
2016.03.16 18:19:57.392 5: ZW_Dongle dispatch 0004005d03300300
2016.03.16 18:19:57.393 4: CMD:APPLICATION_COMMAND_HANDLER ID:5d ARG:03300300 CB:00
2016.03.16 18:19:57.589 4: ZWDongle_Read ZW_Dongle: rcvd 0004005d0a7105000000ff07000000, sending ACK
2016.03.16 18:19:57.590 5: SW: 06
2016.03.16 18:19:57.591 5: ZW_Dongle dispatch 0004005d0a7105000000ff07000000
2016.03.16 18:19:57.592 4: CMD:APPLICATION_COMMAND_HANDLER ID:5d ARG:0a7105000000ff07000000 CB:00
2016.03.16 18:19:58.923 4: ZWDongle_Read ZW_Dongle: rcvd 0004005f03300300, sending ACK
2016.03.16 18:19:58.924 5: SW: 06
2016.03.16 18:19:58.926 5: ZW_Dongle dispatch 0004005f03300300
2016.03.16 18:19:58.926 4: CMD:APPLICATION_COMMAND_HANDLER ID:5f ARG:03300300 CB:00
2016.03.16 18:19:59.125 4: ZWDongle_Read ZW_Dongle: rcvd 0004005f0a7105000000ff07000000, sending ACK
2016.03.16 18:19:59.125 5: SW: 06
2016.03.16 18:19:59.127 5: ZW_Dongle dispatch 0004005f0a7105000000ff07000000
2016.03.16 18:19:59.128 4: CMD:APPLICATION_COMMAND_HANDLER ID:5f ARG:0a7105000000ff07000000 CB:00
2016.03.16 18:20:00.015 2: ZWave set HZKG_WWZP on
2016.03.16 18:20:00.017 5: ZWDongle_Write 00134f032501FF25d9 (d79c8805)
2016.03.16 18:20:00.019 5: SW: 010a00134f032501FF25d98d
2016.03.16 18:20:00.059 3: HZKG_WWZP on-for-timer 240
2016.03.16 18:20:00.103 5: ACK received, WaitForAck=>2 for 010a00134f032501FF25d98d
2016.03.16 18:20:00.104 4: ZWDongle_Read ZW_Dongle: rcvd 011301, sending ACK
2016.03.16 18:20:00.104 5: SW: 06
2016.03.16 18:20:00.106 5: ZW_Dongle dispatch 011301
2016.03.16 18:20:00.115 4: ZWDongle_Read ZW_Dongle: rcvd 0013d9000002, sending ACK
2016.03.16 18:20:00.116 5: SW: 06
2016.03.16 18:20:00.117 5: device ack reveived, removing 010a00134f032501FF25d98d from dongle sendstack
2016.03.16 18:20:00.118 5: ZW_Dongle dispatch 0013d9000002
2016.03.16 18:20:00.118 4: CMD:ZW_SEND_DATA ID:00 ARG:0002 CB:d9
2016.03.16 18:20:00.119 4: ZW_Dongle transmit OK for CB d9, target HZKG_WWZP
2016.03.16 18:20:00.241 4: ZWDongle_Read ZW_Dongle: rcvd 0004004f0e3202213400000010000100000000, sending ACK
2016.03.16 18:20:00.241 5: SW: 06
2016.03.16 18:20:00.243 5: ZW_Dongle dispatch 0004004f0e3202213400000010000100000000
2016.03.16 18:20:00.244 4: CMD:APPLICATION_COMMAND_HANDLER ID:4f ARG:0e3202213400000010000100000000 CB:00
2016.03.16 18:20:01.741 4: ZWDongle_Read ZW_Dongle: rcvd 0004004f0e320221340000003a000100000010, sending ACK
2016.03.16 18:20:01.742 5: SW: 06
2016.03.16 18:20:01.743 5: ZW_Dongle dispatch 0004004f0e320221340000003a000100000010
2016.03.16 18:20:01.744 4: CMD:APPLICATION_COMMAND_HANDLER ID:4f ARG:0e320221340000003a000100000010 CB:00
2016.03.16 18:20:03.242 4: ZWDongle_Read ZW_Dongle: rcvd 0004004f0e320221340000002c00010000003a, sending ACK
2016.03.16 18:20:03.242 5: SW: 06
2016.03.16 18:20:03.244 5: ZW_Dongle dispatch 0004004f0e320221340000002c00010000003a
2016.03.16 18:20:03.244 4: CMD:APPLICATION_COMMAND_HANDLER ID:4f ARG:0e320221340000002c00010000003a CB:00
2016.03.16 18:20:14.165 4: ZWDongle_Read ZW_Dongle: rcvd 0004003a12600d010632022134000000ab000900000098, sending ACK
2016.03.16 18:20:14.165 5: SW: 06
2016.03.16 18:20:14.167 5: ZW_Dongle dispatch 0004003a12600d010632022134000000ab000900000098
2016.03.16 18:20:14.168 4: CMD:APPLICATION_COMMAND_HANDLER ID:3a ARG:12600d010632022134000000ab000900000098 CB:00
2016.03.16 18:20:15.498 4: ZWDongle_Read ZW_Dongle: rcvd 0004003912600d01033202213400000060000900000045, sending ACK
2016.03.16 18:20:15.499 5: SW: 06
2016.03.16 18:20:15.500 5: ZW_Dongle dispatch 0004003912600d01033202213400000060000900000045
2016.03.16 18:20:15.501 4: CMD:APPLICATION_COMMAND_HANDLER ID:39 ARG:12600d01033202213400000060000900000045 CB:00
2016.03.16 18:20:23.113 4: ZWDongle_Read ZW_Dongle: rcvd 0004003a12600d010632022134000000990009000000ab, sending ACK
2016.03.16 18:20:23.113 5: SW: 06
2016.03.16 18:20:23.115 5: ZW_Dongle dispatch 0004003a12600d010632022134000000990009000000ab
2016.03.16 18:20:23.116 4: CMD:APPLICATION_COMMAND_HANDLER ID:3a ARG:12600d010632022134000000990009000000ab CB:00
2016.03.16 18:20:24.499 4: ZWDongle_Read ZW_Dongle: rcvd 0004003912600d01033202213400000044000900000060, sending ACK
2016.03.16 18:20:24.500 5: SW: 06
2016.03.16 18:20:24.501 5: ZW_Dongle dispatch 0004003912600d01033202213400000044000900000060
2016.03.16 18:20:24.502 4: CMD:APPLICATION_COMMAND_HANDLER ID:39 ARG:12600d01033202213400000044000900000060 CB:00
2016.03.16 18:20:32.111 4: ZWDongle_Read ZW_Dongle: rcvd 0004003a12600d010632022134000000ab000900000099, sending ACK
2016.03.16 18:20:32.112 5: SW: 06
2016.03.16 18:20:32.114 5: ZW_Dongle dispatch 0004003a12600d010632022134000000ab000900000099
2016.03.16 18:20:32.114 4: CMD:APPLICATION_COMMAND_HANDLER ID:3a ARG:12600d010632022134000000ab000900000099 CB:00
2016.03.16 18:20:33.499 4: ZWDongle_Read ZW_Dongle: rcvd 0004003912600d01033202213400000066000900000044, sending ACK
2016.03.16 18:20:33.500 5: SW: 06
2016.03.16 18:20:33.501 5: ZW_Dongle dispatch 0004003912600d01033202213400000066000900000044
2016.03.16 18:20:33.502 4: CMD:APPLICATION_COMMAND_HANDLER ID:39 ARG:12600d01033202213400000066000900000044 CB:00
2016.03.16 18:20:41.111 4: ZWDongle_Read ZW_Dongle: rcvd 0004003a12600d010632022134000000980009000000ab, sending ACK
2016.03.16 18:20:41.112 5: SW: 06
2016.03.16 18:20:41.114 5: ZW_Dongle dispatch 0004003a12600d010632022134000000980009000000ab
2016.03.16 18:20:41.114 4: CMD:APPLICATION_COMMAND_HANDLER ID:3a ARG:12600d010632022134000000980009000000ab CB:00
2016.03.16 18:20:42.498 4: ZWDongle_Read ZW_Dongle: rcvd 0004003912600d01033202213400000054000900000066, sending ACK
2016.03.16 18:20:42.499 5: SW: 06
2016.03.16 18:20:42.501 5: ZW_Dongle dispatch 0004003912600d01033202213400000054000900000066
2016.03.16 18:20:42.501 4: CMD:APPLICATION_COMMAND_HANDLER ID:39 ARG:12600d01033202213400000054000900000066 CB:00
2016.03.16 18:20:51.499 4: ZWDongle_Read ZW_Dongle: rcvd 0004003912600d01033202213400000060000900000054, sending ACK
2016.03.16 18:20:51.499 5: SW: 06
2016.03.16 18:20:51.501 5: ZW_Dongle dispatch 0004003912600d01033202213400000060000900000054
2016.03.16 18:20:51.502 4: CMD:APPLICATION_COMMAND_HANDLER ID:39 ARG:12600d01033202213400000060000900000054 CB:00
2016.03.16 18:20:54.058 1: Perfmon: possible freeze starting at 18:20:52, delay is 2.057
2016.03.16 18:20:59.113 4: ZWDongle_Read ZW_Dongle: rcvd 0004003a12600d010632022134000000bb0009000000a4, sending ACK
2016.03.16 18:20:59.113 5: SW: 06
2016.03.16 18:20:59.115 5: ZW_Dongle dispatch 0004003a12600d010632022134000000bb0009000000a4
2016.03.16 18:20:59.116 4: CMD:APPLICATION_COMMAND_HANDLER ID:3a ARG:12600d010632022134000000bb0009000000a4 CB:00
Fhem auf Gigabyte Brix
CUL V3 HM / CUL V3 MAX / MaxCube aFW Homematic&MAX / ZWave.me ZME_UZB1 / SDuino 433 / Velux KLF200
Homematic / MAX / Logitech Hub / ZWave / Wifi LED / div. 433 Temperatursensoren / pywws WH1080 / IO Homecontrol