Regelmäßiges neighborUpdate

ToKa · 27 November 2016, 13:41:36

Hallo zusammen,

obwohl ich in der letzten Zeit keine Veränderungen bzgl. der Positionierung meiner ZWave Komponenten gemacht habe, finden sich im Log immer mal wieder Meldungen mit

Code Auswählen

2016.11.27 13:01:19.137 3: ZWave get E2.ez.HR.Bodenheizung setpoint 
2016.11.27 13:01:23.515 2: ERROR: cannot SEND_DATA to E2.ez.HR.Bodenheizung: transmit queue overflow
2016.11.27 13:01:29.287 2: ZWAVE1 transmit NO_ACK for CB 60, target E2.ez.HR.Bodenheizung
2016.11.27 13:01:30.307 2: ZWAVE1 transmit NO_ACK for CB 60, target E2.ez.HR.Bodenheizung
2016.11.27 13:01:30.602 2: ZWAVE1 transmit NO_ACK for CB 60, target E2.ez.HR.Bodenheizung
20

und die Zeiten für timeToAck schwanken für das ein und selbe Gerät (auch Zwischenstecker) auf bis zu 7.542s.

Code Auswählen

Internals: 
   DEF        d14c12e6 23 
   IODev      ZWAVE1 
   LASTInputDev ZWAVE1 
   MSGCNT     14 
   NAME       E2.ku.ZS.Tischleuchte 
   NR         135 
   STATE      neighborUpdate 
   TYPE       ZWave 
   ZWAVE1_MSGCNT 14 
   ZWAVE1_RAWMSG 00489a22 
   ZWAVE1_TIME 2016-11-27 13:22:27 
   ZWaveSubDevice no 
   homeId     d14c12e6 
   isWakeUp 
   lastMsgSent 1480249344.29863 
   nodeIdHex  17 
   Readings: 
     2016-11-22 19:04:42   assocGroup_1    Max 1 Nodes ZWAVE1 
     2016-11-22 19:04:42   assocGroup_2    Max 1 Nodes 
     2016-11-22 19:04:42   assocGroup_3    Max 1 Nodes ZWAVE1 
     2016-11-22 19:04:43   assocGroup_4    Max 1 Nodes 
     2016-11-22 19:04:41   assocGroups     4 
     2016-11-21 22:09:51   indState        off 
     2016-11-08 20:01:52   model           GreenWave PowerNode 1 port 
     2016-11-08 20:01:52   modelConfig     greenwave/powernode1.xml 
     2016-11-08 20:01:52   modelId         0099-0002-0002 
     2016-11-27 12:43:49   neighborList    ZWAVE1 E2.ez.HR.Bodenheizung E4.az.ZS.Stereoanlage 
     2016-11-27 13:22:27   neighborUpdate  done 
     2016-11-27 09:49:51   power            0 W previous: 0.3 delta_time: 1 s 
     2016-11-08 20:25:09   reportedState   on 
     2016-11-27 13:22:24   state           neighborUpdate 
     2016-11-27 00:23:07   timeToAck       7.542 
     2016-11-27 00:23:07   transmit        OK 
Attributes: 
   IODev      ZWAVE1 
   alias      Tischleuchte Küche 
   classes    SWITCH_BINARY METER MANUFACTURER_SPECIFIC VERSION BASIC ALARM CONFIGURATION SWITCH_ALL ASSOCIATION INDICATOR PROTECTION CRC_16_ENCAP 
   group      Licht 
   icon       light_light 
   room       Küche,Übersicht 
   sortby     2 
   struc_Tischleuchten Tischleuchten 
   userattr   E1.wz.ZS.Tischleuchte E1.wz.ZS.Tischleuchte_map struc_Tischleuchten struc_Tischleuchten_map structexclude 
   vclasses   ALARM:1 ASSOCIATION:1 BASIC:1 CONFIGURATION:1 CRC_16_ENCAP:1 MANUFACTURER_SPECIFIC:2 METER:2 PROTECTION:2 SWITCH_ALL:1 SWITCH_BINARY:1 VERSION:1

Macht es Sinn per at einmal am Tag mit set TYPE=ZWave:FILTER=ZWaveSubDevice=no neighborUpdate für alle Geräte die NeigborList aktualisieren zu lassen? Oder was gibt es noch für Möglichkeiten?

Beste Grüße

Torsten

krikan · 27 November 2016, 18:53:38

Zitat von: ToKa am 27 November 2016, 13:41:36
Macht es Sinn per at einmal am Tag mit set TYPE=ZWave:FILTER=ZWaveSubDevice=no neighborUpdate für alle Geräte die NeigborList aktualisieren zu lassen?

Wenn man nicht die Positionen der Geraete veraendert hat oder Geraete hinzugekommen bzw. entfernt wurden, dann ist das neighborUpdate mMn überflüssig und führt eher zu mehr Problemen als zu weniger.

Hast Du mal mit perfmon/apptime nachgeschaut, ob etwas FHEM blockiert? Solche timeToAck darf es eigentlich nicht geben.

Ansonsten schau Dir mal die Kommunikation FHEM mit E2.ez.HR.Bodenheizung naeher an (vebose 5), warum und wann es zu diesen NO_ACK kommt. "ERROR: cannot SEND_DATA" habe ich im Realbetrieb bisher nicht erzeugen können und dazu braeuchte man weitere Infos/Logs.

Gruß, Christian

ToKa · 27 November 2016, 23:38:12

Hallo Christian,

hatte eben jetzt wieder im Log ein "ERROR: cannot SEND_DATA to ST.sz.HR.Wandheizung: transmit queue overflow". Allerdings für einen anderen COMET Z. Anbei das Log, allerdings nur für den Controller mit Verbose=5. Insgesamt habe ich 368 solcher Fehlermeldungen im LOG November. Hoffe, das hilft Dir schon mal für eine weitere Analyse:

Code Auswählen

2016.11.27 23:16:34.021 3: ZWave set GH.gt.ZS.Gartenbeleuchtung on 
2016.11.27 23:16:34.022 5: ZWDongle_Write 001318032501FF25db (d14c12e6)
2016.11.27 23:16:34.023 5: SW: 010a001318032501FF25dbd8
2016.11.27 23:16:34.060 5: ACK received, WaitForAck=>2 for 010a001318032501FF25dbd8
2016.11.27 23:16:34.060 4: ZWDongle_Read ZWAVE1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
2016.11.27 23:16:34.060 5: SW: 06
2016.11.27 23:16:34.062 5: ZWAVE1 dispatch 011301
2016.11.27 23:16:34.154 4: ZWDongle_Read ZWAVE1: rcvd 0013db00000c (request ZW_SEND_DATA), sending ACK
2016.11.27 23:16:34.155 5: SW: 06
2016.11.27 23:16:34.156 5: device ack reveived, removing 010a001318032501FF25dbd8 from dongle sendstack
2016.11.27 23:16:34.156 5: ZWAVE1 dispatch 0013db00000c
2016.11.27 23:16:34.157 4: CMD:ZW_SEND_DATA ID:00 ARG:000c CB:db
2016.11.27 23:16:34.157 4: ZWAVE1 transmit OK for CB db, target GH.gt.ZS.Gartenbeleuchtung
2016.11.27 23:16:34.488 4: ZWDongle_Read ZWAVE1: rcvd 00040018032503ff (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.11.27 23:16:34.489 5: SW: 06
2016.11.27 23:16:34.490 5: ZWAVE1 dispatch 00040018032503ff
2016.11.27 23:16:34.491 4: CMD:APPLICATION_COMMAND_HANDLER ID:18 ARG:032503ff CB:00
2016.11.27 23:16:34.645 4: ZWDongle_Read ZWAVE1: rcvd 000400180832022112003c0000 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.11.27 23:16:34.646 5: SW: 06
2016.11.27 23:16:34.648 5: ZWAVE1 dispatch 000400180832022112003c0000
2016.11.27 23:16:34.648 4: CMD:APPLICATION_COMMAND_HANDLER ID:18 ARG:0832022112003c0000 CB:00
2016.11.27 23:22:02.771 4: ZWDongle_Read ZWAVE1: rcvd 0004000d028407 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.11.27 23:22:02.772 5: SW: 06
2016.11.27 23:22:02.774 5: ZWAVE1 dispatch 0004000d028407
2016.11.27 23:22:02.775 4: CMD:APPLICATION_COMMAND_HANDLER ID:0d ARG:028407 CB:00
2016.11.27 23:22:02.971 3: ZWave get ST.sz.HR.Wandheizung smStatus 
2016.11.27 23:22:02.972 5: ZWDongle_Write 00130d02310425dc (d14c12e6)
2016.11.27 23:22:02.973 5: SW: 010900130d02310425dc26
2016.11.27 23:22:02.978 3: ZWave get ST.sz.HR.Wandheizung swmStatus 
2016.11.27 23:22:02.982 3: ZWave get ST.sz.HR.Wandheizung setpoint 
2016.11.27 23:22:02.985 5: ACK received, WaitForAck=>2 for 010900130d02310425dc26
2016.11.27 23:22:02.985 4: ZWDongle_Read ZWAVE1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
2016.11.27 23:22:02.986 5: SW: 06
2016.11.27 23:22:02.988 5: ZWAVE1 dispatch 011301
2016.11.27 23:22:03.040 4: ZWDongle_Read ZWAVE1: rcvd 0013dc000006 (request ZW_SEND_DATA), sending ACK
2016.11.27 23:22:03.040 5: SW: 06
2016.11.27 23:22:03.042 5: device ack reveived, removing 010900130d02310425dc26 from dongle sendstack
2016.11.27 23:22:03.043 5: ZWAVE1 dispatch 0013dc000006
2016.11.27 23:22:03.043 4: CMD:ZW_SEND_DATA ID:00 ARG:0006 CB:dc
2016.11.27 23:22:03.044 4: ZWAVE1 transmit OK for CB dc, target ST.sz.HR.Wandheizung
2016.11.27 23:22:03.093 4: ZWDongle_Read ZWAVE1: rcvd 0004000d063105012200e1 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.11.27 23:22:03.093 5: SW: 06
2016.11.27 23:22:03.095 5: ZWAVE1 dispatch 0004000d063105012200e1
2016.11.27 23:22:03.096 4: CMD:APPLICATION_COMMAND_HANDLER ID:0d ARG:063105012200e1 CB:00
2016.11.27 23:22:03.099 5: ZWDongle_Write 00130d02260225dd (d14c12e6)
2016.11.27 23:22:03.100 5: SW: 010900130d02260225dd36
2016.11.27 23:22:03.122 5: ACK received, WaitForAck=>2 for 010900130d02260225dd36
2016.11.27 23:22:03.123 4: ZWDongle_Read ZWAVE1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
2016.11.27 23:22:03.124 5: SW: 06
2016.11.27 23:22:03.125 5: ZWAVE1 dispatch 011301
2016.11.27 23:22:03.225 4: ZWDongle_Read ZWAVE1: rcvd 0013dd00000c (request ZW_SEND_DATA), sending ACK
2016.11.27 23:22:03.226 5: SW: 06
2016.11.27 23:22:03.227 5: device ack reveived, removing 010900130d02260225dd36 from dongle sendstack
2016.11.27 23:22:03.228 5: ZWAVE1 dispatch 0013dd00000c
2016.11.27 23:22:03.229 4: CMD:ZW_SEND_DATA ID:00 ARG:000c CB:dd
2016.11.27 23:22:03.229 4: ZWAVE1 transmit OK for CB dd, target ST.sz.HR.Wandheizung
2016.11.27 23:22:03.273 4: ZWDongle_Read ZWAVE1: rcvd 0004000d0326030d (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.11.27 23:22:03.274 5: SW: 06
2016.11.27 23:22:03.276 5: ZWAVE1 dispatch 0004000d0326030d
2016.11.27 23:22:03.276 4: CMD:APPLICATION_COMMAND_HANDLER ID:0d ARG:0326030d CB:00
2016.11.27 23:22:03.279 5: ZWDongle_Write 00130d0343020125de (d14c12e6)
2016.11.27 23:22:03.280 5: SW: 010a00130d0343020125de53
2016.11.27 23:22:03.305 5: ACK received, WaitForAck=>2 for 010a00130d0343020125de53
2016.11.27 23:22:03.306 4: ZWDongle_Read ZWAVE1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
2016.11.27 23:22:03.306 5: SW: 06
2016.11.27 23:22:03.308 5: ZWAVE1 dispatch 011301
2016.11.27 23:22:03.582 4: ZWDongle_Read ZWAVE1: rcvd 0004001803250300 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.11.27 23:22:03.583 5: SW: 06
2016.11.27 23:22:03.584 5: ZWAVE1 dispatch 0004001803250300
2016.11.27 23:22:03.585 4: CMD:APPLICATION_COMMAND_HANDLER ID:18 ARG:03250300 CB:00
2016.11.27 23:22:04.507 4: ZWDongle_Read ZWAVE1: rcvd 0004000d064303012200dc (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.11.27 23:22:04.508 5: SW: 06
2016.11.27 23:22:04.510 5: ZWAVE1 dispatch 0004000d064303012200dc
2016.11.27 23:22:04.510 4: CMD:APPLICATION_COMMAND_HANDLER ID:0d ARG:064303012200dc CB:00
2016.11.27 23:22:05.344 5: ZWDongle_Write 00130d02840825df (d14c12e6)
2016.11.27 23:22:05.345 4: no response from device, removing 010a00130d0343020125de53 from dongle sendstack
2016.11.27 23:22:05.345 5: SW: 010900130d02840825df9c
2016.11.27 23:22:06.285 5: ACK received, WaitForAck=>2 for 010900130d02840825df9c
2016.11.27 23:22:06.291 4: ZWDongle_Read ZWAVE1: rcvd 011300 (answer ZW_SEND_DATA), sending ACK
2016.11.27 23:22:06.291 5: SW: 06
2016.11.27 23:22:06.293 5: ZWAVE1 dispatch 011300
2016.11.27 23:22:06.296 2: ERROR: cannot SEND_DATA to ST.sz.HR.Wandheizung: transmit queue overflow
2016.11.27 23:22:06.298 4: ZWDongle_Read ZWAVE1: rcvd 00040018083202211200000000 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.11.27 23:22:06.298 5: SW: 06
2016.11.27 23:22:06.300 5: ZWAVE1 dispatch 00040018083202211200000000
2016.11.27 23:22:06.301 4: CMD:APPLICATION_COMMAND_HANDLER ID:18 ARG:083202211200000000 CB:00
2016.11.27 23:22:06.916 4: ZWDongle_Read ZWAVE1: rcvd 000400180a32022144000012e60000 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.11.27 23:22:06.917 5: SW: 06
2016.11.27 23:22:06.919 5: ZWAVE1 dispatch 000400180a32022144000012e60000
2016.11.27 23:22:06.920 4: CMD:APPLICATION_COMMAND_HANDLER ID:18 ARG:0a32022144000012e60000 CB:00
2016.11.27 23:22:07.940 4: no response from device, removing 010900130d02840825df9c from dongle sendstack
2016.11.27 23:22:08.601 4: ZWDongle_Read ZWAVE1: rcvd 0004000d064303012200dc (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.11.27 23:22:08.601 5: SW: 06
2016.11.27 23:22:08.603 5: ZWAVE1 dispatch 0004000d064303012200dc
2016.11.27 23:22:08.604 4: CMD:APPLICATION_COMMAND_HANDLER ID:0d ARG:064303012200dc CB:00
2016.11.27 23:22:08.750 4: ZWDongle_Read ZWAVE1: rcvd 0004000d064303012200dc (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.11.27 23:22:08.751 5: SW: 06
2016.11.27 23:22:08.753 5: ZWAVE1 dispatch 0004000d064303012200dc
2016.11.27 23:22:08.753 4: CMD:APPLICATION_COMMAND_HANDLER ID:0d ARG:064303012200dc CB:00
2016.11.27 23:22:08.890 4: ZWDongle_Read ZWAVE1: rcvd 0004000d064303012200dc (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.11.27 23:22:08.891 5: SW: 06
2016.11.27 23:22:08.893 5: ZWAVE1 dispatch 0004000d064303012200dc
2016.11.27 23:22:08.893 4: CMD:APPLICATION_COMMAND_HANDLER ID:0d ARG:064303012200dc CB:00
2016.11.27 23:22:10.078 4: ZWDongle_Read ZWAVE1: rcvd 0004100d064303012200dc (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.11.27 23:22:10.079 5: SW: 06
2016.11.27 23:22:10.080 5: ZWAVE1 dispatch 0004100d064303012200dc
2016.11.27 23:22:10.081 4: CMD:APPLICATION_COMMAND_HANDLER ID:0d ARG:064303012200dc CB:10
2016.11.27 23:22:10.547 4: ZWDongle_Read ZWAVE1: rcvd 0013df0101aa (request ZW_SEND_DATA), sending ACK
2016.11.27 23:22:10.548 5: SW: 06
2016.11.27 23:22:10.549 5: ZWAVE1 dispatch 0013df0101aa
2016.11.27 23:22:10.550 4: CMD:ZW_SEND_DATA ID:01 ARG:01aa CB:df
2016.11.27 23:22:10.551 2: ZWAVE1 transmit NO_ACK for CB df, target ST.sz.HR.Wandheizung
2016.11.27 23:22:10.712 4: ZWDongle_Read ZWAVE1: rcvd 00041009064303052200dc (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.11.27 23:22:10.713 5: SW: 06
2016.11.27 23:22:10.714 5: ZWAVE1 dispatch 00041009064303052200dc
2016.11.27 23:22:10.715 4: CMD:APPLICATION_COMMAND_HANDLER ID:09 ARG:064303052200dc CB:10

jump to the top

Hier noch das List vom betroffenen Gerät:

Code Auswählen

Internals: 
   DEF        d14c12e6 13 
   IMAGE      /fhem/deviceimages/zwave/ZC08-15110002 
   IODev      ZWAVE1 
   LASTInputDev ZWAVE1 
   MSGCNT     619 
   NAME       ST.sz.HR.Wandheizung 
   NR         92 
   STATE      <strong>Ist-Temperatur: </strong>22.5 °C<strong> / Soll-Temperatur: </strong>22.0 °C</br><strong>Ventil: </strong>13 % 
   STILLDONETIME 0 
   TYPE       ZWave 
   ZWAVE1_MSGCNT 619 
   ZWAVE1_RAWMSG 0013df0101aa 
   ZWAVE1_TIME 2016-11-27 23:22:10 
   ZWaveSubDevice no 
   homeId     d14c12e6 
   isWakeUp   1 
   lastMsgSent 1480285325.34404 
   nodeIdHex  0d 
   Readings: 
     2016-11-27 23:22:03   ActValve        13 
     2016-11-27 23:22:03   IstTemp         22.5 
     2016-11-27 23:22:06   SEND_DATA       failed:00 
     2016-11-27 23:22:10   SollTemp        22.0 
     2016-11-22 03:24:06   UNPARSED        SWITCH_MULTILEVEL 022603 
     2016-11-26 21:57:04   WunschTemp      00 
     2016-11-27 04:58:35   battery         100 % 
     2016-07-01 10:19:52   model           EUROtronic EUR_COMETZ Wall Radiator Thermostat Valve Control 
     2016-07-01 10:19:52   modelConfig     eurotronic/eur_cometz.xml 
     2016-07-01 10:19:52   modelId         0148-0002-0001 
     2016-11-12 20:53:22   neighborList    EG.ga.ZS.Glasbausteine ST.sz.ZS.WakeUpLight 
     2016-11-27 13:32:38   neighborUpdate  done 
     2016-11-27 23:22:03   reportedState   dim 13 
     2016-11-27 23:22:10   setpointTemp    22.0 C heating 
     2016-11-27 23:22:03   state           dim 13 
     2016-11-27 23:22:03   temperature     22.5 C 
     2016-11-10 19:49:00   thermostatMode  heating 
     2016-11-27 23:22:03   timeToAck       0.133 
     2016-11-27 23:22:10   transmit        NO_ACK 
     2016-10-22 15:59:02   userCode        id 1 status 2 code 00c3 
     2016-11-27 23:22:02   wakeup          notification 
     2016-10-08 09:27:21   wakeupReport    interval 600 target 1 
Attributes: 
   IODev      ZWAVE1 
   alias      Heizkörper Schlafzimmer 
   classes    BASIC SWITCH_MULTILEVEL SENSOR_MULTILEVEL THERMOSTAT_MODE THERMOSTAT_SETPOINT NODE_NAMING BATTERY WAKE_UP MANUFACTURER_SPECIFIC VERSION 
   group      Heizung 
   icon       sani_heating 
   room       Übersicht 
   sortby     5 
   stateFormat {"<strong>Ist-Temperatur: </strong>".ReadingsVal('ST.sz.HR.Wandheizung','IstTemp','')." °C<strong> / Soll-Temperatur: </strong>".ReadingsVal('ST.sz.HR.Wandheizung','SollTemp','')." °C</br><strong>Ventil: </strong>".ReadingsVal('ST.sz.HR.Wandheizung','ActValve','')." %"} 
   userReadings IstTemp:temperature.* { my @a = split(" ",ReadingsVal("ST.sz.HR.Wandheizung","temperature",0));; $a[0] }, SollTemp:setpointTemp.* { my @a = split(" ",ReadingsVal("ST.sz.HR.Wandheizung","setpointTemp",0));; $a[0] }, ActValve:reportedState.* { if (ReadingsVal("ST.sz.HR.Wandheizung","reportedState",0) eq "off") { "0" } else { my @a = split (" ", ReadingsVal("ST.sz.HR.Wandheizung","reportedState",0));; $a[1] }} 
   vclasses   BASIC:1 BATTERY:1 MANUFACTURER_SPECIFIC:1 NODE_NAMING:1 SENSOR_MULTILEVEL:4 SWITCH_MULTILEVEL:3 THERMOSTAT_MODE:3 THERMOSTAT_SETPOINT:3 VERSION:1 WAKE_UP:2

krikan · 28 November 2016, 16:47:22

Die Probleme beginnen im Log damit, dass auf die verschickte Nachricht "get ST.sz.HR.Wandheizung setpoint" keine Empfangsbestätigung des Stellantriebs (0013de00) bei FHEM/Controller eingeht. An der Stelle, wo die Empfangsbestätigung kommen sollte, wird die laufende Kommunikation Controller/Stellantrieb durch eine SWITCH_BINARY Nachricht von hexNodeId 18 unterbrochen. Eigentlich kein Problem für ZWave. Jedoch kommt bei Dir auch danach keine Empfangsbestätigung des Stellantriebs (0013de00) noch die Info des Controllers über eine ausbleibende Empfangsbestätigung für den Befehl (0013de01). Stattdessen über eine Sekunde nach "get ST.sz.HR.Wandheizung setpoint" direkt die Antwort auf die Abfrage und weitere 4 Sekunden später noch 3x. Also hat wohl der Stellantrieb den Abfragebefehl mehrfach auf Protokollebene erhalten, weil der Controller kein ACK vom Stellantrieb empfangen hat.

Die "ERROR: Cannot SEND_DATA" und "NO_ACK" sind mMn nur Folgeerscheinungen der Kommunikationsprobleme bei der Abfrage des Stellantriebs.

Tritt das Problem nur bei StellaZ-Antrieben auf?
Wenn das erst seit kurzem in der Regelmäßigkeit auftritt und vorher problemlos lief, musst Du an Deinem System etwas verändert haben. Was?
Weniger get-Abfragen auf wakeupNotification-Event: Warum fragst (pollst) Du so viele Werte des Stella-Z ab? Sind die alle notwendig? Was passiert, wenn Du die herausnimmst oder per FHEM-sleep den Versand verzögert anstößt?
Gibt es Zusammenhänge zwischen hexNodeId 18 und Stellantrieb?

ToKa · 28 November 2016, 19:23:06

Hallo Christian,

vielen Dank für die Entschlüsselung des Logs. Beim hexNodeId 18 handelt es sich mal wieder um den POPP 9105 für die Gartenbeleuchtung, der sich ja anfänglich beim Inkludieren merkwürdig verhalten hat (secure ja/nein???). Es besteht allenfalls die Möglichkeit, dass der COMET Z und der POPP im Netz als "Nachbarn" vorhanden sind, da sie räumlich nicht weit auseinander sind.

Im WakeUp für den COMET Z frage ich nur alle 15 Minuten die Temperatur, den Sollwert und das Ventil ab. Sofern hier mehrere Anfragen liefen, liegt das mMn an den noch nicht abgearbeiteten Abfragen auf dem Sendstack, was leider auch immer mal wieder vorkommt.

Werde den POPP mal exkludieren, neu inkludieren und das Log weiter beobachten.

Beste Grüße

Torsten

EDIT: Nachdem ich den POPP neu inkludiert habe, lässt er sich zwar per ZWAVE an- und ausschalten, aber die angeschlossene Lampe bleibt aus (höre auch kein klackern, wie früher...). Ich gehe davon aus, dass das Ding nun ganz hinüber ist. Werde es mal aus dem Verkehr ziehen und schauen, wie sich das Netz jetzt verhält.

ToKa · 30 November 2016, 19:14:07

Hallo Christian,

seitdem der POPP nicht mehr im Netz ist, hat sich die Sache etwas beruhigt. Aber heute sind wieder ein Einträge im Log mit
ERROR: cannot SEND_DATA to E4.az.HR.Wandheizung: transmit queue overflow

Leider war zu diesem Zeitpunkt kein verbose 5 eingeschaltet. Es sind wieder mehrfache Abfragen an das gleiche Gerät gegangen. Ich vermute, dass sich die Abfragen wieder auf dem Sendstack gesammelt hatten. Der Heizungsregler hatte noch nie was mit dem POPP "zu tun". Im gleichen Raum befindet sich eine Greenwave Funksteckdose, die als Repeater dient.

Ich scheue etwas davor zurück, permanent verbose 5 eingeschaltet zu lassen, da ich befürchte die SD Karte im Raspi verkraftet das nicht.

Code Auswählen

2016.11.30 17:29:39.889 3: ZWave get E4.az.HR.Wandheizung smStatus 
2016.11.30 17:29:39.896 3: ZWave get E4.az.HR.Wandheizung swmStatus 
2016.11.30 17:29:39.900 3: ZWave get E4.az.HR.Wandheizung setpoint 
2016.11.30 17:29:40.014 3: ZWave get E4.az.HR.Wandheizung smStatus 
2016.11.30 17:29:40.018 3: ZWave get E4.az.HR.Wandheizung swmStatus 
2016.11.30 17:29:40.022 3: ZWave get E4.az.HR.Wandheizung setpoint 
2016.11.30 17:29:40.691 3: ZWave get E4.az.HR.Wandheizung smStatus 
2016.11.30 17:29:40.695 3: ZWave get E4.az.HR.Wandheizung swmStatus 
2016.11.30 17:29:40.699 3: ZWave get E4.az.HR.Wandheizung setpoint 
2016.11.30 17:29:41.672 3: ZWave get E4.az.HR.Wandheizung smStatus 
2016.11.30 17:29:41.676 3: ZWave get E4.az.HR.Wandheizung swmStatus 
2016.11.30 17:29:41.680 3: ZWave get E4.az.HR.Wandheizung setpoint 
2016.11.30 17:29:41.772 3: ZWave get E4.az.HR.Wandheizung smStatus 
2016.11.30 17:29:41.776 3: ZWave get E4.az.HR.Wandheizung swmStatus 
2016.11.30 17:29:41.781 3: ZWave get E4.az.HR.Wandheizung setpoint 
2016.11.30 17:29:44.742 2: ERROR: cannot SEND_DATA to E4.az.HR.Wandheizung: transmit queue overflow
2016.11.30 17:29:46.758 2: ERROR: cannot SEND_DATA to E4.az.HR.Wandheizung: transmit queue overflow
2016.11.30 17:29:51.179 2: ZWAVE1 transmit NO_ACK for CB 48, target E4.az.HR.Wandheizung
2016.11.30 17:29:51.669 2: ZWAVE1 transmit NO_ACK for CB 48, target E4.az.HR.Wandheizung
2016.11.30 17:32:18.938 3: ZWave get E4.az.HR.Wandheizung smStatus 
2016.11.30 17:32:18.942 3: ZWave get E4.az.HR.Wandheizung swmStatus 
2016.11.30 17:32:18.946 3: ZWave get E4.az.HR.Wandheizung setpoint 
2016.11.30 17:32:27.112 2: ERROR: cannot SEND_DATA to E4.az.HR.Wandheizung: transmit queue overflow
2016.11.30 17:32:32.801 2: ZWAVE1 transmit NO_ACK for CB 57, target E4.az.HR.Wandheizung
2016.11.30 17:32:37.350 2: ZWAVE1 transmit NO_ACK for CB 57, target E4.az.HR.Wandheizung

Hast Du noch eine Idee, was ich tun kann? Deinen Vorschlag mit dem sleep zwischen den gets im notify kann ich gerne mal ausprobieren. Was wäre dann der "richtige" Wert für das sleep?

Beste Grüße
Torsten

ToKa · 30 November 2016, 19:19:54

Nachdem ich jetzt mal noch ein neighbor update angestoßen habe, sind auf dem stack wieder einige gets nach dem wakeup stehe geblieben:

Code Auswählen

Internals: 
   DEF        d14c12e6 20 
   IODev      ZWAVE1 
   LASTInputDev ZWAVE1 
   MSGCNT     19 
   NAME       E4.az.HR.Wandheizung 
   NR         110 
   STATE      <strong>Ist-Temperatur: </strong>23.0 °C<strong> / Soll-Temperatur: </strong>22 °C</br><strong>Ventil: </strong>0 % 
   TYPE       ZWave 
   ZWAVE1_MSGCNT 19 
   ZWAVE1_RAWMSG 00485222 
   ZWAVE1_TIME 2016-11-30 19:16:22 
   ZWaveSubDevice no 
   homeId     d14c12e6 
   isWakeUp   1 
   lastMsgSent 1480529779.04102 
   nodeIdHex  14 
   Readings: 
     2016-11-30 19:01:12   ActValve        0 
     2016-10-22 20:40:31   CMD             ZW_APPLICATION_UPDATE 
     2016-11-30 19:01:12   IstTemp         23.0 
     2016-11-30 17:32:27   SEND_DATA       failed:00 
     2016-11-30 19:06:11   SollTemp        22 
     2016-11-29 01:25:25   UNPARSED        SENSOR_MULTILEVEL 023105 
     2016-11-30 19:06:11   WunschTemp      00 
     2016-11-30 04:53:43   battery         100 % 
     2016-10-22 12:27:27   model           EUROtronic EUR_COMETZ Wall Radiator Thermostat Valve Control 
     2016-10-22 12:27:27   modelConfig     eurotronic/eur_cometz.xml 
     2016-10-22 12:27:27   modelId         0148-0002-0001 
     2016-11-15 21:17:09   neighborList    E4.az.ZS.Stereoanlage 
     2016-11-30 19:16:22   neighborUpdate  done 
     2016-11-30 19:01:12   reportedState   off 
     2016-11-30 19:01:12   setpointTemp    19.5 C heating 
     2016-11-30 19:01:12   state           off 
     2016-11-30 19:01:12   temperature     23.0 C 
     2016-11-10 19:30:24   thermostatMode  heating 
     2016-11-30 19:16:19   timeToAck       0.132 
     2016-11-30 19:16:19   transmit        OK 
     2016-11-30 19:16:18   wakeup          notification 
     2016-11-04 19:58:24   wakeupReport    interval 900 target 1 
   SendStack: 
     sentset:481452 
     get:13140231042568 
     get:13140226022569 
     get:131403430201256a 
Attributes: 
   IODev      ZWAVE1 
   alias      Heizkörper Arbeitszimmer 
   classes    BASIC SWITCH_MULTILEVEL SENSOR_MULTILEVEL THERMOSTAT_MODE THERMOSTAT_SETPOINT NODE_NAMING BATTERY WAKE_UP MANUFACTURER_SPECIFIC VERSION 
   group      Heizung 
   icon       sani_heating 
   room       Übersicht 
   sortby     1 
   stateFormat {"<strong>Ist-Temperatur: </strong>".ReadingsVal('E4.az.HR.Wandheizung','IstTemp','')." °C<strong> / Soll-Temperatur: </strong>".ReadingsVal('E4.az.HR.Wandheizung','SollTemp','')." °C</br><strong>Ventil: </strong>".ReadingsVal('E4.az.HR.Wandheizung','ActValve','')." %"} 
   userReadings IstTemp:temperature.* { my @a = split(" ",ReadingsVal("E4.az.HR.Wandheizung","temperature",0));; $a[0] }, SollTemp:setpointTemp.* { my @a = split(" ",ReadingsVal("E4.az.HR.Wandheizung","setpointTemp",0));; $a[0] }, ActValve:reportedState.* { if (ReadingsVal("E4.az.HR.Wandheizung","reportedState",0) eq "off") { "0" } else { my @a = split (" ", ReadingsVal("E4.az.HR.Wandheizung","reportedState",0));; $a[1] }} 
   vclasses   BASIC:1 BATTERY:1 MANUFACTURER_SPECIFIC:1 NODE_NAMING:1 SENSOR_MULTILEVEL:4 SWITCH_MULTILEVEL:3 THERMOSTAT_MODE:3 THERMOSTAT_SETPOINT:3 VERSION:1 WAKE_UP:2

Werde mal verbose 5 einstellen, vielleicht lässt sich der Fall ja provozieren / reproduzieren.

Gruß
Torsten

krikan · 30 November 2016, 20:04:37

Ohne verbose 5-Log ist eine Analyse "schwierig"; mit zugegebenermaßen auch bei Unkenntnis der Systemdetails auch oft Raterei.

Wenn es wirklich immer nur bei den Stella-Z und auch noch bei verschiedenen auftritt, dann vergiss FHEM-sleep-

Stell doch einmal die get-Abfragen in einzelne notifys um:
1. notify triggert auf wakeupNotification und setzt "get E4.az.HR.Wandheizung smStatus" ab. 2. notify triggert auf Event der Antwort und setzt "get E4.az.HR.Wandheizung swmStatus" usw.

Ob das wirklich Besserung bringt, kann ich nicht versprechen. Anhand der Angaben habe ich momentan keine anderen Ideen.

ToKa · 09 Dezember 2016, 10:04:30

Nachdem heute Nacht im Log wieder etliche mal der Fehler "ERROR: cannot SEND_DATA to E4.az.HR.Heizung: transmit queue overflow" zu finden war und auf dem sendstack über zehn messages hingen, habe ich nach einem restart von fhem mit verbose 5 eine Logdatei erstellt. Das Gerät hat laut Protokoll 3 wakeup notofications ausgelöst...

Der Fehler ähnelt m.E. auch sehr dem von tomspatz in https://forum.fhem.de/index.php/topic,59026.msg534117.html#msg534117 geschilderten verhalten.

Eventmonitor:

Code Auswählen

2016-12-09 09:35:51.116 ZWave E4.az.HR.Heizung wakeup: notification
2016-12-09 09:35:51.903 ZWave E4.az.HR.Heizung wakeup: notification
2016-12-09 09:35:53.056 ZWave E4.az.HR.Heizung wakeup: notification
2016-12-09 09:35:53.389 readingsGroup E4.az.HZ.Wandheizung.ctl E4.az.HR.Heizung.IstTemp: 20.5 °C
2016-12-09 09:35:53.412 readingsGroup Raumtemperatur E4.az.HR.Heizung.temperature: 20.5 °C
2016-12-09 09:35:53.417 ZWave E4.az.HR.Heizung temperature: 20.5 C
2016-12-09 09:35:53.417 ZWave E4.az.HR.Heizung IstTemp: 20.5
2016-12-09 09:35:53.921 readingsGroup E4.az.HZ.Wandheizung.ctl E4.az.HR.Heizung.IstTemp: 20.5 °C
2016-12-09 09:35:53.943 readingsGroup Raumtemperatur E4.az.HR.Heizung.temperature: 20.5 °C
2016-12-09 09:35:53.947 ZWave E4.az.HR.Heizung temperature: 20.5 C
2016-12-09 09:35:53.947 ZWave E4.az.HR.Heizung IstTemp: 20.5
2016-12-09 09:35:54.276 readingsGroup E4.az.HZ.Wandheizung.ctl E4.az.HR.Heizung.IstTemp: 20.5 °C
2016-12-09 09:35:54.298 readingsGroup Raumtemperatur E4.az.HR.Heizung.temperature: 20.5 °C
2016-12-09 09:35:54.302 ZWave E4.az.HR.Heizung temperature: 20.5 C
2016-12-09 09:35:54.302 ZWave E4.az.HR.Heizung IstTemp: 20.5
2016-12-09 09:35:54.460 readingsGroup E4.az.HZ.Wandheizung.ctl E4.az.HR.Heizung.IstTemp: 20.5 °C
2016-12-09 09:35:54.482 readingsGroup Raumtemperatur E4.az.HR.Heizung.temperature: 20.5 °C
2016-12-09 09:35:54.487 ZWave E4.az.HR.Heizung temperature: 20.5 C
2016-12-09 09:35:54.487 ZWave E4.az.HR.Heizung IstTemp: 20.5
2016-12-09 09:35:54.965 readingsGroup E4.az.HZ.Wandheizung.ctl E4.az.HR.Heizung.ActValve: 6 %
2016-12-09 09:35:54.980 ZWave E4.az.HR.Heizung dim 6
2016-12-09 09:35:54.980 ZWave E4.az.HR.Heizung reportedState: dim 6
2016-12-09 09:35:54.980 ZWave E4.az.HR.Heizung ActValve: 6
2016-12-09 09:35:56.827 readingsGroup E4.az.HZ.Wandheizung.ctl E4.az.HR.Heizung.ActValve: 6 %
2016-12-09 09:35:56.843 ZWave E4.az.HR.Heizung dim 6
2016-12-09 09:35:56.843 ZWave E4.az.HR.Heizung reportedState: dim 6
2016-12-09 09:35:56.843 ZWave E4.az.HR.Heizung ActValve: 6
2016-12-09 09:36:06.088 readingsGroup E4.az.HZ.Wandheizung.ctl E4.az.HR.Heizung.ActValve: 6 %
2016-12-09 09:36:06.113 ZWave E4.az.HR.Heizung SEND_DATA: failed:00
2016-12-09 09:36:06.113 ZWave E4.az.HR.Heizung SEND_DATA: failed:00
2016-12-09 09:36:06.113 ZWave E4.az.HR.Heizung SEND_DATA: failed:00
2016-12-09 09:36:06.113 ZWave E4.az.HR.Heizung dim 6
2016-12-09 09:36:06.113 ZWave E4.az.HR.Heizung reportedState: dim 6
2016-12-09 09:36:06.113 ZWave E4.az.HR.Heizung ActValve: 6
2016-12-09 09:36:06.494 readingsGroup E4.az.HZ.Wandheizung.ctl E4.az.HR.Heizung.ActValve: 6 %
2016-12-09 09:36:06.509 ZWave E4.az.HR.Heizung dim 6
2016-12-09 09:36:06.509 ZWave E4.az.HR.Heizung reportedState: dim 6
2016-12-09 09:36:06.509 ZWave E4.az.HR.Heizung ActValve: 6
2016-12-09 09:36:06.570 readingsGroup E4.az.HZ.Wandheizung.ctl E4.az.HR.Heizung.SollTemp: 19.5 °C
2016-12-09 09:36:06.585 ZWave E4.az.HR.Heizung setpointTemp: 19.5 C heating
2016-12-09 09:36:06.585 ZWave E4.az.HR.Heizung SollTemp: 19.5
2016-12-09 09:36:06.643 readingsGroup E4.az.HZ.Wandheizung.ctl E4.az.HR.Heizung.IstTemp: 20.5 °C
2016-12-09 09:36:06.665 readingsGroup Raumtemperatur E4.az.HR.Heizung.temperature: 20.5 °C
2016-12-09 09:36:06.670 ZWave E4.az.HR.Heizung temperature: 20.5 C
2016-12-09 09:36:06.670 ZWave E4.az.HR.Heizung IstTemp: 20.5
2016-12-09 09:36:06.712 readingsGroup E4.az.HZ.Wandheizung.ctl E4.az.HR.Heizung.ActValve: 6 %
2016-12-09 09:36:06.728 ZWave E4.az.HR.Heizung dim 6
2016-12-09 09:36:06.728 ZWave E4.az.HR.Heizung reportedState: dim 6
2016-12-09 09:36:06.728 ZWave E4.az.HR.Heizung ActValve: 6
2016-12-09 09:36:07.595 readingsGroup E4.az.HZ.Wandheizung.ctl E4.az.HR.Heizung.SollTemp: 19.5 °C
2016-12-09 09:36:07.615 ZWave E4.az.HR.Heizung setpointTemp: 19.5 C heating
2016-12-09 09:36:07.615 ZWave E4.az.HR.Heizung SollTemp: 19.5
2016-12-09 09:36:07.690 readingsGroup E4.az.HZ.Wandheizung.ctl E4.az.HR.Heizung.SollTemp: 19.5 °C
2016-12-09 09:36:07.704 ZWave E4.az.HR.Heizung setpointTemp: 19.5 C heating
2016-12-09 09:36:07.704 ZWave E4.az.HR.Heizung SollTemp: 19.5
2016-12-09 09:36:07.984 readingsGroup E4.az.HZ.Wandheizung.ctl E4.az.HR.Heizung.SollTemp: 19.5 °C
2016-12-09 09:36:07.998 ZWave E4.az.HR.Heizung setpointTemp: 19.5 C heating
2016-12-09 09:36:07.998 ZWave E4.az.HR.Heizung SollTemp: 19.5
2016-12-09 09:36:08.084 readingsGroup E4.az.HZ.Wandheizung.ctl E4.az.HR.Heizung.SollTemp: 19.5 °C
2016-12-09 09:36:08.098 ZWave E4.az.HR.Heizung setpointTemp: 19.5 C heating
2016-12-09 09:36:08.098 ZWave E4.az.HR.Heizung SollTemp: 19.5
2016-12-09 09:36:08.486 readingsGroup E4.az.HZ.Wandheizung.ctl E4.az.HR.Heizung.SollTemp: 19.5 °C
2016-12-09 09:36:08.500 ZWave E4.az.HR.Heizung setpointTemp: 19.5 C heating
2016-12-09 09:36:08.500 ZWave E4.az.HR.Heizung SollTemp: 19.5
2016-12-09 09:36:08.774 readingsGroup E4.az.HZ.Wandheizung.ctl E4.az.HR.Heizung.SollTemp: 19.5 °C
2016-12-09 09:36:08.788 ZWave E4.az.HR.Heizung setpointTemp: 19.5 C heating
2016-12-09 09:36:08.788 ZWave E4.az.HR.Heizung SollTemp: 19.5
2016-12-09 09:36:08.890 readingsGroup E4.az.HZ.Wandheizung.ctl E4.az.HR.Heizung.SollTemp: 19.5 °C
2016-12-09 09:36:08.904 ZWave E4.az.HR.Heizung setpointTemp: 19.5 C heating
2016-12-09 09:36:08.904 ZWave E4.az.HR.Heizung SollTemp: 19.5
2016-12-09 09:36:09.201 ZWave E4.az.HR.Heizung transmit: NO_ACK
2016-12-09 09:36:30.638 readingsGroup Raumtemperatur EG.fl.RM.Decke.temperature: 21.4 °C
2016-12-09 09:36:30.643 ZWave EG.fl.RM.Decke temperature: 21.4 C

Logdatei:

Code Auswählen

2016.12.09 09:35:51.096 3: ZS.zs.HR.wakeUpAll.nfy: E4.az.HR.Heizung wakeup: notification
2016.12.09 09:35:51.100 3: ZWave get E4.az.HR.Heizung smStatus 
2016.12.09 09:35:51.101 5: ZWDongle_Write 0013140231042520 (d14c12e6)
2016.12.09 09:35:51.103 5: SW: 01090013140231042520c3
2016.12.09 09:35:51.107 3: ZWave get E4.az.HR.Heizung swmStatus 
2016.12.09 09:35:51.112 3: ZWave get E4.az.HR.Heizung setpoint 
2016.12.09 09:35:51.118 5: ACK received, WaitForAck=>2 for 01090013140231042520c3
2016.12.09 09:35:51.119 4: ZWDongle_Read ZWAVE1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
2016.12.09 09:35:51.119 5: SW: 06
2016.12.09 09:35:51.121 5: ZWAVE1: dispatch 011301
2016.12.09 09:35:51.858 4: ZWDongle_Read ZWAVE1: rcvd 00040014028407 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.09 09:35:51.859 5: SW: 06
2016.12.09 09:35:51.861 5: ZWAVE1: dispatch 00040014028407
2016.12.09 09:35:51.862 4: CMD:APPLICATION_COMMAND_HANDLER ID:14 ARG:028407 CB:00
2016.12.09 09:35:51.863 5: ZWDongle_Write 0013140226022521 (d14c12e6)
2016.12.09 09:35:51.889 3: ZS.zs.HR.wakeUpAll.nfy: E4.az.HR.Heizung wakeup: notification
2016.12.09 09:35:51.892 3: ZWave get E4.az.HR.Heizung smStatus 
2016.12.09 09:35:51.896 3: ZWave get E4.az.HR.Heizung swmStatus 
2016.12.09 09:35:51.900 3: ZWave get E4.az.HR.Heizung setpoint 
2016.12.09 09:35:53.011 4: ZWDongle_Read ZWAVE1: rcvd 00041014028407 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.09 09:35:53.012 5: SW: 06
2016.12.09 09:35:53.014 5: ZWAVE1: dispatch 00041014028407
2016.12.09 09:35:53.015 4: CMD:APPLICATION_COMMAND_HANDLER ID:14 ARG:028407 CB:10
2016.12.09 09:35:53.017 5: ZWDongle_Write 001314034302012522 (d14c12e6)
2016.12.09 09:35:53.041 3: ZS.zs.HR.wakeUpAll.nfy: E4.az.HR.Heizung wakeup: notification
2016.12.09 09:35:53.045 3: ZWave get E4.az.HR.Heizung smStatus 
2016.12.09 09:35:53.048 3: ZWave get E4.az.HR.Heizung swmStatus 
2016.12.09 09:35:53.052 3: ZWave get E4.az.HR.Heizung setpoint 
2016.12.09 09:35:53.085 4: ZWDongle_Read ZWAVE1: rcvd 0013200000c6 (request ZW_SEND_DATA), sending ACK
2016.12.09 09:35:53.086 5: SW: 06
2016.12.09 09:35:53.088 5: device ack reveived, removing 01090013140231042520c3 from dongle sendstack
2016.12.09 09:35:53.089 5: ZWAVE1: dispatch 0013200000c6
2016.12.09 09:35:53.089 4: CMD:ZW_SEND_DATA ID:00 ARG:00c6 CB:20
2016.12.09 09:35:53.090 4: ZWAVE1 transmit OK for CB 20, target E4.az.HR.Heizung
2016.12.09 09:35:53.093 5: SW: 01090013140226022521d3
2016.12.09 09:35:53.096 5: ACK received, WaitForAck=>2 for 01090013140226022521d3
2016.12.09 09:35:53.100 4: ZWDongle_Read ZWAVE1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
2016.12.09 09:35:53.100 5: SW: 06
2016.12.09 09:35:53.103 5: ZWAVE1: dispatch 011301
2016.12.09 09:35:53.364 4: ZWDongle_Read ZWAVE1: rcvd 00040014063105012200cd (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.09 09:35:53.364 5: SW: 06
2016.12.09 09:35:53.366 5: ZWAVE1: dispatch 00040014063105012200cd
2016.12.09 09:35:53.367 4: CMD:APPLICATION_COMMAND_HANDLER ID:14 ARG:063105012200cd CB:00
2016.12.09 09:35:53.369 5: ZWDongle_Write 0013140231042523 (d14c12e6)
2016.12.09 09:35:53.896 4: ZWDongle_Read ZWAVE1: rcvd 00041014063105012200cd (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.09 09:35:53.896 5: SW: 06
2016.12.09 09:35:53.898 5: ZWAVE1: dispatch 00041014063105012200cd
2016.12.09 09:35:53.899 4: CMD:APPLICATION_COMMAND_HANDLER ID:14 ARG:063105012200cd CB:10
2016.12.09 09:35:53.901 5: ZWDongle_Write 0013140226022524 (d14c12e6)
2016.12.09 09:35:53.957 4: ZWDongle_Read ZWAVE1: rcvd 001321000056 (request ZW_SEND_DATA), sending ACK
2016.12.09 09:35:53.958 5: SW: 06
2016.12.09 09:35:53.959 5: device ack reveived, removing 01090013140226022521d3 from dongle sendstack
2016.12.09 09:35:53.960 5: ZWAVE1: dispatch 001321000056
2016.12.09 09:35:53.961 4: CMD:ZW_SEND_DATA ID:00 ARG:0056 CB:21
2016.12.09 09:35:53.961 4: ZWAVE1 transmit OK for CB 21, target E4.az.HR.Heizung
2016.12.09 09:35:53.963 5: SW: 010a001314034302012522b6
2016.12.09 09:35:53.965 5: ACK received, WaitForAck=>2 for 010a001314034302012522b6
2016.12.09 09:35:53.971 4: ZWDongle_Read ZWAVE1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
2016.12.09 09:35:53.971 5: SW: 06
2016.12.09 09:35:53.973 5: ZWAVE1: dispatch 011301
2016.12.09 09:35:54.251 4: ZWDongle_Read ZWAVE1: rcvd 00041014063105012200cd (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.09 09:35:54.251 5: SW: 06
2016.12.09 09:35:54.253 5: ZWAVE1: dispatch 00041014063105012200cd
2016.12.09 09:35:54.254 4: CMD:APPLICATION_COMMAND_HANDLER ID:14 ARG:063105012200cd CB:10
2016.12.09 09:35:54.256 5: ZWDongle_Write 001314034302012525 (d14c12e6)
2016.12.09 09:35:54.435 4: ZWDongle_Read ZWAVE1: rcvd 00041014063105012200cd (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.09 09:35:54.436 5: SW: 06
2016.12.09 09:35:54.438 5: ZWAVE1: dispatch 00041014063105012200cd
2016.12.09 09:35:54.439 4: CMD:APPLICATION_COMMAND_HANDLER ID:14 ARG:063105012200cd CB:10
2016.12.09 09:35:54.441 5: ZWDongle_Write 0013140231042526 (d14c12e6)
2016.12.09 09:35:54.876 4: ZWDongle_Read ZWAVE1: rcvd 00132200005b (request ZW_SEND_DATA), sending ACK
2016.12.09 09:35:54.876 5: SW: 06
2016.12.09 09:35:54.878 5: device ack reveived, removing 010a001314034302012522b6 from dongle sendstack
2016.12.09 09:35:54.879 5: ZWAVE1: dispatch 00132200005b
2016.12.09 09:35:54.879 4: CMD:ZW_SEND_DATA ID:00 ARG:005b CB:22
2016.12.09 09:35:54.879 4: ZWAVE1 transmit OK for CB 22, target E4.az.HR.Heizung
2016.12.09 09:35:54.882 5: SW: 01090013140231042523c0
2016.12.09 09:35:54.884 5: ACK received, WaitForAck=>2 for 01090013140231042523c0
2016.12.09 09:35:54.888 4: ZWDongle_Read ZWAVE1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
2016.12.09 09:35:54.889 5: SW: 06
2016.12.09 09:35:54.890 5: ZWAVE1: dispatch 011301
2016.12.09 09:35:54.939 4: ZWDongle_Read ZWAVE1: rcvd 0004001403260306 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.09 09:35:54.940 5: SW: 06
2016.12.09 09:35:54.942 5: ZWAVE1: dispatch 0004001403260306
2016.12.09 09:35:54.942 4: CMD:APPLICATION_COMMAND_HANDLER ID:14 ARG:03260306 CB:00
2016.12.09 09:35:54.944 5: ZWDongle_Write 0013140226022527 (d14c12e6)
2016.12.09 09:35:55.218 4: ZWDongle_Read ZWAVE1: rcvd 001323000021 (request ZW_SEND_DATA), sending ACK
2016.12.09 09:35:55.218 5: SW: 06
2016.12.09 09:35:55.219 5: device ack reveived, removing 01090013140231042523c0 from dongle sendstack
2016.12.09 09:35:55.220 5: ZWAVE1: dispatch 001323000021
2016.12.09 09:35:55.221 4: CMD:ZW_SEND_DATA ID:00 ARG:0021 CB:23
2016.12.09 09:35:55.221 4: ZWAVE1 transmit OK for CB 23, target E4.az.HR.Heizung
2016.12.09 09:35:55.223 5: SW: 01090013140226022524d6
2016.12.09 09:35:55.226 5: ACK received, WaitForAck=>2 for 01090013140226022524d6
2016.12.09 09:35:55.230 4: ZWDongle_Read ZWAVE1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
2016.12.09 09:35:55.230 5: SW: 06
2016.12.09 09:35:55.232 5: ZWAVE1: dispatch 011301
2016.12.09 09:35:56.802 4: ZWDongle_Read ZWAVE1: rcvd 0004101403260306 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.09 09:35:56.803 5: SW: 06
2016.12.09 09:35:56.805 5: ZWAVE1: dispatch 0004101403260306
2016.12.09 09:35:56.805 4: CMD:APPLICATION_COMMAND_HANDLER ID:14 ARG:03260306 CB:10
2016.12.09 09:35:56.807 5: ZWDongle_Write 001314034302012528 (d14c12e6)
2016.12.09 09:35:57.846 4: no response from device, removing 01090013140226022524d6 from dongle sendstack
2016.12.09 09:35:57.847 5: SW: 010a001314034302012525b1
2016.12.09 09:35:58.438 5: ACK received, WaitForAck=>2 for 010a001314034302012525b1
2016.12.09 09:35:58.440 4: ZWDongle_Read ZWAVE1: rcvd 011300 (answer ZW_SEND_DATA), sending ACK
2016.12.09 09:35:58.441 5: SW: 06
2016.12.09 09:35:58.443 5: ZWAVE1: dispatch 011300
2016.12.09 09:35:58.446 2: ERROR: cannot SEND_DATA to E4.az.HR.Heizung: transmit queue overflow
2016.12.09 09:36:00.453 4: no response from device, removing 010a001314034302012525b1 from dongle sendstack
2016.12.09 09:36:00.454 5: SW: 01090013140231042526c5
2016.12.09 09:36:01.456 2: ZWDongle_ProcessSendStack: no ACK, resending message 01090013140231042526c5
2016.12.09 09:36:01.457 5: SW: 01090013140231042526c5
2016.12.09 09:36:02.459 2: ZWDongle_ProcessSendStack: no ACK, resending message 01090013140231042526c5
2016.12.09 09:36:02.460 5: SW: 01090013140231042526c5
2016.12.09 09:36:03.463 2: ZWDongle_ProcessSendStack: no ACK, resending message 01090013140231042526c5
2016.12.09 09:36:03.463 5: SW: 01090013140231042526c5
2016.12.09 09:36:04.466 2: ZWDongle_ProcessSendStack: no ACK, resending message 01090013140231042526c5
2016.12.09 09:36:04.466 1: ERROR: max send retries reached, removing 01090013140231042526c5 from dongle sendstack
2016.12.09 09:36:04.467 5: SW: 01090013140226022527d5
2016.12.09 09:36:05.049 5: ACK received, WaitForAck=>2 for 01090013140226022527d5
2016.12.09 09:36:05.051 4: ZWDongle_Read ZWAVE1: rcvd 011300 (answer ZW_SEND_DATA), sending ACK
2016.12.09 09:36:05.051 5: SW: 06
2016.12.09 09:36:05.054 5: ZWAVE1: dispatch 011300
2016.12.09 09:36:05.057 2: ERROR: cannot SEND_DATA to E4.az.HR.Heizung: transmit queue overflow
2016.12.09 09:36:05.059 4: ZWDongle_Read ZWAVE1: CAN received
2016.12.09 09:36:05.059 4: ZWDongle_Read ZWAVE1: CAN received
2016.12.09 09:36:06.042 4: ZWDongle_Read ZWAVE1: rcvd 011300 (answer ZW_SEND_DATA), sending ACK
2016.12.09 09:36:06.042 5: SW: 06
2016.12.09 09:36:06.045 5: ZWAVE1: dispatch 011300
2016.12.09 09:36:06.048 2: ERROR: cannot SEND_DATA to E4.az.HR.Heizung: transmit queue overflow
2016.12.09 09:36:06.050 4: ZWDongle_Read ZWAVE1: rcvd 0004001403260306 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.09 09:36:06.051 5: SW: 06
2016.12.09 09:36:06.053 5: ZWAVE1: dispatch 0004001403260306
2016.12.09 09:36:06.054 4: CMD:APPLICATION_COMMAND_HANDLER ID:14 ARG:03260306 CB:00
2016.12.09 09:36:06.114 4: no response from device, removing 01090013140226022527d5 from dongle sendstack
2016.12.09 09:36:06.115 5: SW: 010a001314034302012528bc
2016.12.09 09:36:06.118 5: ACK received, WaitForAck=>2 for 010a001314034302012528bc
2016.12.09 09:36:06.121 4: ZWDongle_Read ZWAVE1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
2016.12.09 09:36:06.122 5: SW: 06
2016.12.09 09:36:06.124 5: ZWAVE1: dispatch 011301
2016.12.09 09:36:06.470 4: ZWDongle_Read ZWAVE1: rcvd 0004001403260306 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.09 09:36:06.470 5: SW: 06
2016.12.09 09:36:06.472 5: ZWAVE1: dispatch 0004001403260306
2016.12.09 09:36:06.473 4: CMD:APPLICATION_COMMAND_HANDLER ID:14 ARG:03260306 CB:00
2016.12.09 09:36:06.548 4: ZWDongle_Read ZWAVE1: rcvd 00040014064303012200c3 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.09 09:36:06.548 5: SW: 06
2016.12.09 09:36:06.550 5: ZWAVE1: dispatch 00040014064303012200c3
2016.12.09 09:36:06.551 4: CMD:APPLICATION_COMMAND_HANDLER ID:14 ARG:064303012200c3 CB:00
2016.12.09 09:36:06.620 4: ZWDongle_Read ZWAVE1: rcvd 00040014063105012200cd (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.09 09:36:06.620 5: SW: 06
2016.12.09 09:36:06.622 5: ZWAVE1: dispatch 00040014063105012200cd
2016.12.09 09:36:06.622 4: CMD:APPLICATION_COMMAND_HANDLER ID:14 ARG:063105012200cd CB:00
2016.12.09 09:36:06.688 4: ZWDongle_Read ZWAVE1: rcvd 0004001403260306 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.09 09:36:06.689 5: SW: 06
2016.12.09 09:36:06.690 5: ZWAVE1: dispatch 0004001403260306
2016.12.09 09:36:06.691 4: CMD:APPLICATION_COMMAND_HANDLER ID:14 ARG:03260306 CB:00
2016.12.09 09:36:06.823 4: ZWDongle_Read ZWAVE1: rcvd 001328000047 (request ZW_SEND_DATA), sending ACK
2016.12.09 09:36:06.823 5: SW: 06
2016.12.09 09:36:06.825 5: device ack reveived, removing 010a001314034302012528bc from dongle sendstack
2016.12.09 09:36:06.825 5: ZWAVE1: dispatch 001328000047
2016.12.09 09:36:06.826 4: CMD:ZW_SEND_DATA ID:00 ARG:0047 CB:28
2016.12.09 09:36:06.826 4: ZWAVE1 transmit OK for CB 28, target E4.az.HR.Heizung
2016.12.09 09:36:06.828 5: ZWDongle_Write 001314034302012528 (d14c12e6)
2016.12.09 09:36:06.829 5: SW: 010a001314034302012528bc
2016.12.09 09:36:06.832 5: ACK received, WaitForAck=>2 for 010a001314034302012528bc
2016.12.09 09:36:06.835 4: ZWDongle_Read ZWAVE1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
2016.12.09 09:36:06.836 5: SW: 06
2016.12.09 09:36:06.838 5: ZWAVE1: dispatch 011301
2016.12.09 09:36:07.560 4: ZWDongle_Read ZWAVE1: rcvd 00041014064303012200c3 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.09 09:36:07.563 5: SW: 06
2016.12.09 09:36:07.565 5: ZWAVE1: dispatch 00041014064303012200c3
2016.12.09 09:36:07.566 4: CMD:APPLICATION_COMMAND_HANDLER ID:14 ARG:064303012200c3 CB:10
2016.12.09 09:36:07.621 4: ZWDongle_Read ZWAVE1: rcvd 00132800004e (request ZW_SEND_DATA), sending ACK
2016.12.09 09:36:07.621 5: SW: 06
2016.12.09 09:36:07.623 5: device ack reveived, removing 010a001314034302012528bc from dongle sendstack
2016.12.09 09:36:07.624 5: ZWAVE1: dispatch 00132800004e
2016.12.09 09:36:07.625 4: CMD:ZW_SEND_DATA ID:00 ARG:004e CB:28
2016.12.09 09:36:07.625 4: ZWAVE1 transmit OK for CB 28, target E4.az.HR.Heizung
2016.12.09 09:36:07.668 4: ZWDongle_Read ZWAVE1: rcvd 00040014064303012200c3 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.09 09:36:07.668 5: SW: 06
2016.12.09 09:36:07.670 5: ZWAVE1: dispatch 00040014064303012200c3
2016.12.09 09:36:07.671 4: CMD:APPLICATION_COMMAND_HANDLER ID:14 ARG:064303012200c3 CB:00
2016.12.09 09:36:07.961 4: ZWDongle_Read ZWAVE1: rcvd 00041014064303012200c3 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.09 09:36:07.962 5: SW: 06
2016.12.09 09:36:07.964 5: ZWAVE1: dispatch 00041014064303012200c3
2016.12.09 09:36:07.964 4: CMD:APPLICATION_COMMAND_HANDLER ID:14 ARG:064303012200c3 CB:10
2016.12.09 09:36:08.061 4: ZWDongle_Read ZWAVE1: rcvd 00041014064303012200c3 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.09 09:36:08.062 5: SW: 06
2016.12.09 09:36:08.064 5: ZWAVE1: dispatch 00041014064303012200c3
2016.12.09 09:36:08.064 4: CMD:APPLICATION_COMMAND_HANDLER ID:14 ARG:064303012200c3 CB:10
2016.12.09 09:36:08.463 4: ZWDongle_Read ZWAVE1: rcvd 00041014064303012200c3 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.09 09:36:08.464 5: SW: 06
2016.12.09 09:36:08.466 5: ZWAVE1: dispatch 00041014064303012200c3
2016.12.09 09:36:08.466 4: CMD:APPLICATION_COMMAND_HANDLER ID:14 ARG:064303012200c3 CB:10
2016.12.09 09:36:08.751 4: ZWDongle_Read ZWAVE1: rcvd 00041014064303012200c3 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.09 09:36:08.752 5: SW: 06
2016.12.09 09:36:08.754 5: ZWAVE1: dispatch 00041014064303012200c3
2016.12.09 09:36:08.754 4: CMD:APPLICATION_COMMAND_HANDLER ID:14 ARG:064303012200c3 CB:10
2016.12.09 09:36:08.867 4: ZWDongle_Read ZWAVE1: rcvd 00041014064303012200c3 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.09 09:36:08.868 5: SW: 06
2016.12.09 09:36:08.870 5: ZWAVE1: dispatch 00041014064303012200c3
2016.12.09 09:36:08.870 4: CMD:APPLICATION_COMMAND_HANDLER ID:14 ARG:064303012200c3 CB:10
2016.12.09 09:36:09.181 4: ZWDongle_Read ZWAVE1: rcvd 0013280100ea (request ZW_SEND_DATA), sending ACK
2016.12.09 09:36:09.182 5: SW: 06
2016.12.09 09:36:09.184 5: ZWAVE1: dispatch 0013280100ea
2016.12.09 09:36:09.185 4: CMD:ZW_SEND_DATA ID:01 ARG:00ea CB:28
2016.12.09 09:36:09.185 2: ZWAVE1 transmit NO_ACK for CB 28, target E4.az.HR.Heizung
2016.12.09 09:36:30.596 4: ZWDongle_Read ZWAVE1: rcvd 00040006063105012200d6 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.09 09:36:30.596 5: SW: 06
2016.12.09 09:36:30.598 5: ZWAVE1: dispatch 00040006063105012200d6
2016.12.09 09:36:30.599 4: CMD:APPLICATION_COMMAND_HANDLER ID:06 ARG:063105012200d6 CB:00

List device:

Code Auswählen

Internals: 
   DEF        d14c12e6 20 
   IODev      ZWAVE1 
   LASTInputDev ZWAVE1 
   MSGCNT     22 
   NAME       E4.az.HR.Heizung 
   NR         91 
   STATE      <strong>Ist-Temperatur: </strong>20.5 °C<strong> / Soll-Temperatur: </strong>19.5 °C</br><strong>Ventil: </strong>6 % 
   TYPE       ZWave 
   ZWAVE1_MSGCNT 22 
   ZWAVE1_RAWMSG 0013280100ea 
   ZWAVE1_TIME 2016-12-09 09:36:09 
   ZWaveSubDevice no 
   homeId     d14c12e6 
   isWakeUp   1 
   lastMsgSent 1481272566.82839 
   nodeIdHex  14 
   Readings: 
     2016-12-09 09:36:06   ActValve        6 
     2016-10-22 20:40:31   CMD             ZW_APPLICATION_UPDATE 
     2016-12-09 09:36:06   IstTemp         20.5 
     2016-12-09 09:36:06   SEND_DATA       failed:00 
     2016-12-09 09:36:08   SollTemp        19.5 
     2016-12-09 07:18:52   UNPARSED        SENSOR_MULTILEVEL 023105 
     2016-12-06 13:16:22   WunschTemp      00 
     2016-12-09 04:47:14   battery         100 % 
     2016-10-22 12:27:27   model           EUROtronic EUR_COMETZ Wall Radiator Thermostat Valve Control 
     2016-10-22 12:27:27   modelConfig     eurotronic/eur_cometz.xml 
     2016-10-22 12:27:27   modelId         0148-0002-0001 
     2016-11-30 19:21:42   neighborList    E4.az.ZS.Stereoanlage 
     2016-11-30 19:16:22   neighborUpdate  done 
     2016-12-09 09:36:06   reportedState   dim 6 
     2016-12-09 09:36:08   setpointTemp    19.5 C heating 
     2016-12-09 09:36:06   state           dim 6 
     2016-12-09 09:36:06   temperature     20.5 C 
     2016-11-10 19:30:24   thermostatMode  heating 
     2016-12-09 09:36:07   timeToAck       0.800 
     2016-12-09 09:36:09   transmit        NO_ACK 
     2016-12-09 09:35:53   wakeup          notification 
     2016-11-04 19:58:24   wakeupReport    interval 900 target 1 
   SendStack: 
     sentackget:1314034302012528 
Attributes: 
   IODev      ZWAVE1 
   alias      Arbeitszimmer 
   classes    BASIC SWITCH_MULTILEVEL SENSOR_MULTILEVEL THERMOSTAT_MODE THERMOSTAT_SETPOINT NODE_NAMING BATTERY WAKE_UP MANUFACTURER_SPECIFIC VERSION 
   group      Heizung 
   icon       sani_heating 
   room       Übersicht 
   sortby     1 
   stateFormat {"<strong>Ist-Temperatur: </strong>".ReadingsVal('E4.az.HR.Heizung','IstTemp','')." °C<strong> / Soll-Temperatur: </strong>".ReadingsVal('E4.az.HR.Heizung','SollTemp','')." °C</br><strong>Ventil: </strong>".ReadingsVal('E4.az.HR.Heizung','ActValve','')." %"} 
   userReadings IstTemp:temperature.* { my @a = split(" ",ReadingsVal("E4.az.HR.Heizung","temperature",0));; $a[0] }, SollTemp:setpointTemp.* { my @a = split(" ",ReadingsVal("E4.az.HR.Heizung","setpointTemp",0));; $a[0] }, ActValve:reportedState.* { if (ReadingsVal("E4.az.HR.Heizung","reportedState",0) eq "off") { "0" } else { my @a = split (" ", ReadingsVal("E4.az.HR.Heizung","reportedState",0));; $a[1] }} 
   vclasses   BASIC:1 BATTERY:1 MANUFACTURER_SPECIFIC:1 NODE_NAMING:1 SENSOR_MULTILEVEL:4 SWITCH_MULTILEVEL:3 THERMOSTAT_MODE:3 THERMOSTAT_SETPOINT:3 VERSION:1 WAKE_UP:2 
   verbose    5 
   webCmd     ::

Beste Grüße

Torsten

krikan · 09 Dezember 2016, 16:47:38

Stella-Z wiederholt die WUN vermutlich mehrfach, da es ACK des Controllers nicht empfangen hat. Gleiches Spiel gibt es wohl auch bei der ersten "get E4.az.HR.Heizung smStatus"-Abfrage: Antwort von Stella-Z trifft mehrfach ein. Das Chaos steigert sich bis zum Ausstieg im ERROR.

Eigentlich dürfte wohl zur Verhinderung des Problems der Befehl

Code Auswählen

2016.12.09 09:35:53.093 5: SW: 01090013140226022521d3
nicht an den Controller geschickt werden, bevor die Antwort auf den letzten Befehl "get E4.az.HR.Heizung smStatus" beim Controller angekommen ist.

Ich würde es bei seltenem Auftreten so akzeptieren, wenn es zu keinen funktionalen Einschränkungen führt.

ToKa · 09 Dezember 2016, 20:06:05

Erstmal vielen Dank für die Analyse. Das Spiel geht heute den ganzen Tag so weiter...

Code Auswählen

2016.12.09 19:54:21.094 3: ZS.zs.HR.wakeUpAll.nfy: E4.az.HR.Heizung wakeup: notification
2016.12.09 19:54:21.250 3: ZWave get E4.az.HR.Heizung smStatus 
2016.12.09 19:54:21.254 3: ZWave get E4.az.HR.Heizung swmStatus 
2016.12.09 19:54:21.258 3: ZWave get E4.az.HR.Heizung setpoint 
2016.12.09 19:54:21.409 3: ZS.zs.HR.wakeUpAll.nfy: E4.az.HR.Heizung wakeup: notification
2016.12.09 19:54:21.565 3: ZWave get E4.az.HR.Heizung smStatus 
2016.12.09 19:54:21.569 3: ZWave get E4.az.HR.Heizung swmStatus 
2016.12.09 19:54:21.573 3: ZWave get E4.az.HR.Heizung setpoint 
2016.12.09 19:54:22.569 3: ZS.zs.HR.wakeUpAll.nfy: E4.az.HR.Heizung wakeup: notification
2016.12.09 19:54:22.725 3: ZWave get E4.az.HR.Heizung smStatus 
2016.12.09 19:54:22.729 3: ZWave get E4.az.HR.Heizung swmStatus 
2016.12.09 19:54:22.733 3: ZWave get E4.az.HR.Heizung setpoint 
2016.12.09 19:54:22.803 3: ZS.zs.HR.wakeUpAll.nfy: E4.az.HR.Heizung wakeup: notification
2016.12.09 19:54:22.959 3: ZWave get E4.az.HR.Heizung smStatus 
2016.12.09 19:54:22.963 3: ZWave get E4.az.HR.Heizung swmStatus 
2016.12.09 19:54:22.967 3: ZWave get E4.az.HR.Heizung setpoint 
2016.12.09 19:54:23.001 3: ZS.zs.HR.wakeUpAll.nfy: E4.az.HR.Heizung wakeup: notification
2016.12.09 19:54:23.157 3: ZWave get E4.az.HR.Heizung smStatus 
2016.12.09 19:54:23.161 3: ZWave get E4.az.HR.Heizung swmStatus 
2016.12.09 19:54:23.165 3: ZWave get E4.az.HR.Heizung setpoint 
2016.12.09 19:54:26.903 2: ERROR: cannot SEND_DATA to E4.az.HR.Heizung: transmit queue overflow
2016.12.09 19:54:28.909 2: ERROR: cannot SEND_DATA to E4.az.HR.Heizung: transmit queue overflow

Funktional sehe ich schon ein Problem, da ja der sendstack nicht mehr sauber abgearbeitet wird und somit auch set Befehle nicht mehr oder nach Stunden erst beim Regler ankommen. So ist im Moment der sendstack aus...

Code Auswählen

Internals: 
   DEF        d14c12e6 20 
   IODev      ZWAVE1 
   LASTInputDev ZWAVE1 
   MSGCNT     196 
   NAME       E4.az.HR.Heizung 
   NR         91 
   STATE      <strong>Ist-Temperatur: </strong>20.5 °C<strong> / Soll-Temperatur: </strong>19.5 °C</br><strong>Ventil: </strong>6 % 
   TYPE       ZWave 
   ZWAVE1_MSGCNT 196 
   ZWAVE1_RAWMSG 00041014028407 
   ZWAVE1_TIME 2016-12-09 19:54:22 
   ZWaveSubDevice no 
   homeId     d14c12e6 
   isWakeUp   1 
   lastMsgSent 1481309662.97947 
   nodeIdHex  14 
   CHANGED: 
     SEND_DATA: failed:00 
     SEND_DATA: failed:00 
   Readings: 
     2016-12-09 19:23:56   ActValve        6 
     2016-10-22 20:40:31   CMD             ZW_APPLICATION_UPDATE 
     2016-12-09 19:39:16   IstTemp         20.5 
     2016-12-09 19:54:28   SEND_DATA       failed:00 
     2016-12-09 19:39:17   SollTemp        19.5 
     2016-12-09 19:23:44   UNPARSED        SWITCH_MULTILEVEL 022603 
     2016-12-06 13:16:22   WunschTemp      00 
     2016-12-09 12:52:09   battery         100 % 
     2016-10-22 12:27:27   model           EUROtronic EUR_COMETZ Wall Radiator Thermostat Valve Control 
     2016-10-22 12:27:27   modelConfig     eurotronic/eur_cometz.xml 
     2016-10-22 12:27:27   modelId         0148-0002-0001 
     2016-12-09 12:50:25   neighborList    E4.az.ZS.Stereoanlage 
     2016-12-09 12:48:42   neighborUpdate  done 
     2016-12-09 19:23:56   reportedState   dim 6 
     2016-12-09 19:39:17   setpointTemp    19.5 C heating 
     2016-12-09 19:23:56   state           dim 6 
     2016-12-09 19:39:16   temperature     20.5 C 
     2016-11-10 19:30:24   thermostatMode  heating 
     2016-12-09 16:06:47   timeToAck       0.052 
     2016-12-09 18:38:29   transmit        NO_ACK 
     2016-12-09 19:54:22   wakeup          notification 
     2016-11-04 19:58:24   wakeupReport    interval 900 target 1 
   SendStack: 
     get:131403430201256b 
     get:1314023104256c 
     get:1314022602256d 
     get:131403430201256e 
     get:1314023104258a 
     get:1314022602258b 
     get:131403430201258c 
     get:1314023104258d 
     get:1314022602258e 
     get:131403430201258f 
     get:13140231042590 
     get:13140226022591 
     get:1314034302012592 
     get:13140231042593 
     get:13140226022594 
     get:1314034302012595 
     get:131402310425af 
     get:131402260225b0 
     get:13140343020125b1 
     get:131402310425b2 
     get:131402260225b3 
     get:13140343020125b4 
     get:131402310425b5 
     get:131402260225b6 
     get:13140343020125b7 
     get:131402310425d5 
     get:131402260225d6 
     get:13140343020125d7 
     get:131402310425d8 
     get:131402260225d9 
     get:13140343020125da 
     get:131402310425db 
     get:131402260225dc 
     get:13140343020125dd 
     get:131402310425f9 
     get:131402260225fa 
     get:13140343020125fb 
     get:1314023104251b 
     get:1314022602251c 
     get:131403430201251d 
     get:13140231042537 
     get:13140226022538 
     get:1314034302012539 
     get:1314023104253a 
     get:1314022602253b 
     get:131403430201253c 
     get:1314023104253d 
     get:1314022602253e 
     get:131403430201253f 
     get:13140231042540 
     get:13140226022541 
     get:1314034302012542 
     get:1314023104255a 
     get:1314022602255b 
     get:131403430201255c 
     get:1314023104255d 
     get:1314022602255e 
     get:131403430201255f 
     get:13140231042560 
     get:13140226022561 
     get:1314034302012562 
     get:13140231042583 
     get:13140226022584 
     get:1314034302012585 
     get:13140231042586 
     get:13140226022587 
     get:1314034302012588 
     get:131402310425af 
     get:131402260225b0 
     get:13140343020125b1 
     get:131402310425cb 
     get:131402260225cc 
     get:13140343020125cd 
     get:131402310425ce 
     get:131402260225cf 
     get:13140343020125d0 
     get:131402310425d1 
     get:131402260225d2 
     get:13140343020125d3 
     get:131402310425d4 
     get:131402260225d5 
     get:13140343020125d6 
     get:131402310425d7 
     get:131402260225d8 
     get:13140343020125d9 
Attributes: 
   IODev      ZWAVE1 
   alias      Arbeitszimmer 
   classes    BASIC SWITCH_MULTILEVEL SENSOR_MULTILEVEL THERMOSTAT_MODE THERMOSTAT_SETPOINT NODE_NAMING BATTERY WAKE_UP MANUFACTURER_SPECIFIC VERSION 
   group      Heizung 
   icon       sani_heating 
   room       Übersicht 
   sortby     1 
   stateFormat {"<strong>Ist-Temperatur: </strong>".ReadingsVal('E4.az.HR.Heizung','IstTemp','')." °C<strong> / Soll-Temperatur: </strong>".ReadingsVal('E4.az.HR.Heizung','SollTemp','')." °C</br><strong>Ventil: </strong>".ReadingsVal('E4.az.HR.Heizung','ActValve','')." %"} 
   userReadings IstTemp:temperature.* { my @a = split(" ",ReadingsVal("E4.az.HR.Heizung","temperature",0));; $a[0] }, SollTemp:setpointTemp.* { my @a = split(" ",ReadingsVal("E4.az.HR.Heizung","setpointTemp",0));; $a[0] }, ActValve:reportedState.* { if (ReadingsVal("E4.az.HR.Heizung","reportedState",0) eq "off") { "0" } else { my @a = split (" ", ReadingsVal("E4.az.HR.Heizung","reportedState",0));; $a[1] }} 
   vclasses   BASIC:1 BATTERY:1 MANUFACTURER_SPECIFIC:1 NODE_NAMING:1 SENSOR_MULTILEVEL:4 SWITCH_MULTILEVEL:3 THERMOSTAT_MODE:3 THERMOSTAT_SETPOINT:3 VERSION:1 WAKE_UP:2 
   verbose    5 
   webCmd     ::

Ich kann es jetzt gerne mal mit 3 einzelnen notifys probieren oder welche Möglichkeiten habe ich noch?

Gruß

Torsten

krikan · 09 Dezember 2016, 20:19:54

Bitte starte FHEM neu, damit der wakeup-Sendstack geleert wird.

ZitatIch kann es jetzt gerne mal mit 3 einzelnen notifys probieren

Probiere es einmal aus. Aber komplett wird es das Problem vermutlich nicht beheben, wenn 3 WUN oder 3 Antworten auf gleiche Abfragen kommen.

Zitatoder welche Möglichkeiten habe ich noch?

Mir faellt dazu nichts wirklich Sinnvolles ein, was ohne Veraenderung an den ZWave-Modulen funktionieren kann.

ToKa · 09 Dezember 2016, 20:55:30

So nun das Ergebnis mit 3 einzelnen notifys nach einem Neustart von fhem und leerem sendstack. Leider auch nicht wirklich besser...

Code Auswählen

2016.12.09 20:39:46.641 3: E4.az.HR.1.nfy smStatus: E4.az.HR.Heizung wakeup: notification
2016.12.09 20:39:46.645 3: ZWave get E4.az.HR.Heizung smStatus 
2016.12.09 20:39:46.647 5: ZWDongle_Write 0013140231042514 (d14c12e6)
2016.12.09 20:39:46.648 5: SW: 01090013140231042514f7
2016.12.09 20:39:46.652 3: E4.az.HR.2.nfy swmStatus: E4.az.HR.Heizung wakeup: notification
2016.12.09 20:39:46.656 3: ZWave get E4.az.HR.Heizung swmStatus 
2016.12.09 20:39:46.659 3: E4.az.HR.3.nfy setpoint: E4.az.HR.Heizung wakeup: notification
2016.12.09 20:39:46.663 3: ZWave get E4.az.HR.Heizung setpoint 
2016.12.09 20:39:46.685 5: ACK received, WaitForAck=>2 for 01090013140231042514f7
2016.12.09 20:39:46.686 4: ZWDongle_Read ZWAVE1: rcvd 011301 (answer ZW_SEND_DATA), sending ACK
2016.12.09 20:39:46.686 5: SW: 06
2016.12.09 20:39:46.688 5: ZWAVE1: dispatch 011301
2016.12.09 20:39:48.694 4: no response from device, removing 01090013140231042514f7 from dongle sendstack
2016.12.09 20:39:49.929 4: ZWDongle_Read ZWAVE1: rcvd 00041014028407 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.09 20:39:49.930 5: SW: 06
2016.12.09 20:39:49.932 5: ZWAVE1: dispatch 00041014028407
2016.12.09 20:39:49.933 4: CMD:APPLICATION_COMMAND_HANDLER ID:14 ARG:028407 CB:10
2016.12.09 20:39:49.934 5: ZWDongle_Write 0013140226022515 (d14c12e6)
2016.12.09 20:39:49.935 5: SW: 01090013140226022515e7
2016.12.09 20:39:49.970 3: E4.az.HR.1.nfy smStatus: E4.az.HR.Heizung wakeup: notification
2016.12.09 20:39:49.973 3: ZWave get E4.az.HR.Heizung smStatus 
2016.12.09 20:39:49.977 3: E4.az.HR.2.nfy swmStatus: E4.az.HR.Heizung wakeup: notification
2016.12.09 20:39:49.980 3: ZWave get E4.az.HR.Heizung swmStatus 
2016.12.09 20:39:49.983 3: E4.az.HR.3.nfy setpoint: E4.az.HR.Heizung wakeup: notification
2016.12.09 20:39:49.987 3: ZWave get E4.az.HR.Heizung setpoint 
2016.12.09 20:39:50.008 5: ACK received, WaitForAck=>2 for 01090013140226022515e7
2016.12.09 20:39:50.008 4: ZWDongle_Read ZWAVE1: rcvd 011300 (answer ZW_SEND_DATA), sending ACK
2016.12.09 20:39:50.009 5: SW: 06
2016.12.09 20:39:50.011 5: ZWAVE1: dispatch 011300
2016.12.09 20:39:50.013 2: ERROR: cannot SEND_DATA to E4.az.HR.Heizung: transmit queue overflow
2016.12.09 20:39:52.016 4: no response from device, removing 01090013140226022515e7 from dongle sendstack
2016.12.09 20:40:00.063 4: ZWDongle_Read ZWAVE1: rcvd 0013150103f4 (request ZW_SEND_DATA), sending ACK
2016.12.09 20:40:00.064 5: SW: 06
2016.12.09 20:40:00.066 5: ZWAVE1: dispatch 0013150103f4
2016.12.09 20:40:00.067 4: CMD:ZW_SEND_DATA ID:01 ARG:03f4 CB:15
2016.12.09 20:40:00.068 2: ZWAVE1 transmit NO_ACK for CB 15, target E4.az.HR.Heizung
2016.12.09 20:40:32.753 4: ZWDongle_Read ZWAVE1: rcvd 0004001e028407 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.09 20:40:32.754 5: SW: 06
2016.12.09 20:40:32.757 5: ZWAVE1: dispatch 0004001e028407
2016.12.09 20:40:32.758 4: CMD:APPLICATION_COMMAND_HANDLER ID:1e ARG:028407 CB:00
2016.12.09 20:40:32.782 3: ZS.zs.HR.wakeUpAll.nfy: EG.fl.HR.Wandheizung wakeup: notification

Und auf dem sendstack sammeln sich wieder die gets:

Code Auswählen

Internals: 
   DEF        d14c12e6 20 
   IODev      ZWAVE1 
   LASTInputDev ZWAVE1 
   MSGCNT     3 
   NAME       E4.az.HR.Heizung 
   NR         91 
   STATE      <strong>Ist-Temperatur: </strong>20.5 °C<strong> / Soll-Temperatur: </strong>19.5 °C</br><strong>Ventil: </strong>6 % 
   TYPE       ZWave 
   ZWAVE1_MSGCNT 3 
   ZWAVE1_RAWMSG 0013150103f4 
   ZWAVE1_TIME 2016-12-09 20:40:00 
   ZWaveSubDevice no 
   homeId     d14c12e6 
   isWakeUp   1 
   lastMsgSent 1481312389.9346 
   nodeIdHex  14 
   Readings: 
     2016-12-09 19:23:56   ActValve        6 
     2016-10-22 20:40:31   CMD             ZW_APPLICATION_UPDATE 
     2016-12-09 20:09:27   IstTemp         20.5 
     2016-12-09 20:39:50   SEND_DATA       failed:00 
     2016-12-09 19:39:17   SollTemp        19.5 
     2016-12-09 19:23:44   UNPARSED        SWITCH_MULTILEVEL 022603 
     2016-12-06 13:16:22   WunschTemp      00 
     2016-12-09 12:52:09   battery         100 % 
     2016-10-22 12:27:27   model           EUROtronic EUR_COMETZ Wall Radiator Thermostat Valve Control 
     2016-10-22 12:27:27   modelConfig     eurotronic/eur_cometz.xml 
     2016-10-22 12:27:27   modelId         0148-0002-0001 
     2016-12-09 12:50:25   neighborList    E4.az.ZS.Stereoanlage 
     2016-12-09 12:48:42   neighborUpdate  done 
     2016-12-09 19:23:56   reportedState   dim 6 
     2016-12-09 19:39:17   setpointTemp    19.5 C heating 
     2016-12-09 19:23:56   state           dim 6 
     2016-12-09 20:09:27   temperature     20.5 C 
     2016-11-10 19:30:24   thermostatMode  heating 
     2016-12-09 16:06:47   timeToAck       0.052 
     2016-12-09 20:40:00   transmit        NO_ACK 
     2016-12-09 20:39:49   wakeup          notification 
     2016-11-04 19:58:24   wakeupReport    interval 900 target 1 
   SendStack: 
     get:13140226022515 
     get:1314034302012516 
     get:13140231042517 
     get:13140226022518 
     get:1314034302012519 
Attributes: 
   IODev      ZWAVE1 
   alias      Arbeitszimmer 
   classes    BASIC SWITCH_MULTILEVEL SENSOR_MULTILEVEL THERMOSTAT_MODE THERMOSTAT_SETPOINT NODE_NAMING BATTERY WAKE_UP MANUFACTURER_SPECIFIC VERSION 
   group      Heizung 
   icon       sani_heating 
   room       Übersicht 
   sortby     1 
   stateFormat {"<strong>Ist-Temperatur: </strong>".ReadingsVal('E4.az.HR.Heizung','IstTemp','')." °C<strong> / Soll-Temperatur: </strong>".ReadingsVal('E4.az.HR.Heizung','SollTemp','')." °C</br><strong>Ventil: </strong>".ReadingsVal('E4.az.HR.Heizung','ActValve','')." %"} 
   userReadings IstTemp:temperature.* { my @a = split(" ",ReadingsVal("E4.az.HR.Heizung","temperature",0));; $a[0] }, SollTemp:setpointTemp.* { my @a = split(" ",ReadingsVal("E4.az.HR.Heizung","setpointTemp",0));; $a[0] }, ActValve:reportedState.* { if (ReadingsVal("E4.az.HR.Heizung","reportedState",0) eq "off") { "0" } else { my @a = split (" ", ReadingsVal("E4.az.HR.Heizung","reportedState",0));; $a[1] }} 
   vclasses   BASIC:1 BATTERY:1 MANUFACTURER_SPECIFIC:1 NODE_NAMING:1 SENSOR_MULTILEVEL:4 SWITCH_MULTILEVEL:3 THERMOSTAT_MODE:3 THERMOSTAT_SETPOINT:3 VERSION:1 WAKE_UP:2 
   verbose    5 
   webCmd     ::

Kann es sein, dass der Regler defekt ist oder doch mein zwave-Netzwerk spinnt? Wenn es natürlich eine Möglichkeit gäbe das "Chaos" in den z-wave Modulen abzufangen, wäre das genial.

Beste Grüße

Torsten

krikan · 09 Dezember 2016, 21:06:30

Die notify triggern aber alle auf WUN, oder?
Ich meinte aber: 1. auf WUN, 2. auf Ergebnis von 1. und 3. auf Ergebnis vom 2.

ZitatKann es sein, dass der Regler defekt ist oder doch mein zwave-Netzwerk spinnt?

Ja. Mich wundern die mehrfachen WUN oder hast Du das so kurz eingestellt?
Tritt das nur bei dem einen Regler auf?
Wie sieht die Route zum Controller aus?

ToKa · 09 Dezember 2016, 21:28:21

Achso, das werde ich gleich mal noch umstellen.

Das Wakeupintervall steht auf 15 Minuten. Die Route zum Controller läuft über eine Funksteckdose, die wiederum über eine andere Funksteckdose mit dem Controller kommuniziert. Das mit den mehrfachen wakeups passiert nur bei diesem Regler. Bei anderen kommt es sporadisch zu den NO_ACK Meldungen und falls dabei mal was auf dem sendstack hängen bleibt, dann reguliert sich das nach kurzer Zeit wieder.

Macht es Sinn mit dem WNMI_Delay zu experimentieren? Wenn ja, mit welchem Wert?

Gruß

Torsten