UZB1 Stick: Lizenz schaltet AES Security frei?

[A.Harrenberg]

*push*

Hi Thomas,

hattest Du inzwischen mal Gelegenheit die Änderungen in der 10_ZWave.pm zu testen?

Gruß,
Andreas.

[krikan]

Hallo Andreas!
Muss mit secure eingebundenen KFOB-S und Philio PST02 getestet werden?
Gruß, Christian

[A.Harrenberg]

Hi,

Im Fall von Thomas war wenn mich nicht mein Gedächtnis nicht täuscht die KFOB-S nicht mit secure eingebunden, hat aber anscheinend den "Funkkanal dicht gemacht"...

Falls Du das testen möchtest wäre es natürlich gut wenn Du mit der bisherigen Version ähnliche "asynchrone" Übertrgungen provozieren könntest damit klar ist das es wirklich gegen so etwas hilft. Ein Test das es keine neuen Probleme aufwirft ist natürlich gerne gesehen ,-)

Gruß,
Andreas.

[buspirat]

Hallo Andreas,

*push*

hattest Du inzwischen mal Gelegenheit die Änderungen in der 10_ZWave.pm zu testen?

Sorry für die Pause auf meiner Seite, ich hatte gleich zwei undichte Schläuche am Fahrrad hintereinander, die relativ zeitnah beseitigt werden wollten. Dabei sind unplattbare Reifen verbaut...

Werde mir das nächste Woche ansehen, die Weihnachtsgeschenke sind auch bereits erledigt

Schönes Wochenende,
Thomas

[krikan]

Habe KFOB-S und Philio PST02-1A secure inkludiert und 0,5 Std. versucht Störungen mit svn-Version von FHEM zu erzeugen -> habe es nicht geschafft.

Test der obigen geaenderten Fassung kommt spaeter...

[A.Harrenberg]

Hi Christian,

Habe KFOB-S und Philio PST02-1A secure inkludiert und 0,5 Std. versucht Störungen mit svn-Version von FHEM zu erzeugen -> habe es nicht geschafft.

das ist natürlich gut (für Dich) wenn Du auch mit der jetzigen Version keine Probleme hast, das Ergebnis

Test der obigen geaenderten Fassung kommt spaeter...

dieser Tests lautet dann hoffentlich das keine neuen Probleme durch meine Änderungen geschaffen wurden ,-)

Danke,
Andreas.

[krikan]

Hallo Andreas!

Irgendetwas ist merkwürdig. Die Meldung

Code Auswählen Erweitern

ZWave_SENSOR_NOTIFICATION_29: secStart older than 6 seconds detected, secUnlock will call Zwave_secEnd
füllt das Log nach manuellem Wakeup

Ausgangs-list

Code Auswählen Erweitern

Internals:
   DEF        e345c452 29
   Frame_01
   IODev      ZWDongle_0
   LASTInputDev ZWDongle_0
   MSGCNT     7
   NAME       ZWave_SENSOR_NOTIFICATION_29
   NR         317
   STATE      configOperationMode 8
   TYPE       ZWave
   ZWDongle_0_MSGCNT 7
   ZWDongle_0_RAWMSG 0004001d18988157023946a9d9081c4194e3eed4861e485518c4ff32fa
   ZWDongle_0_TIME 2016-12-10 05:37:11
   ZWaveSubDevice no
   homeId     e345c452
   isWakeUp   1
   lastMsgSent 1481344631.29889
   nodeIdHex  1d
   secTime    1481344631.24378
   Readings:
     2016-12-09 18:28:30   SECURITY        ENABLED
     2016-12-09 21:49:29   SEND_DATA       failed:00
     2016-12-10 05:37:11   alarm_AccessControl Window/Door is open, notificationIsOn
     2016-12-09 21:42:35   alarm_HomeSecurity Motion Detection - Unknown Location, notificationIsOn
     2016-12-09 21:40:58   assocGroup_1    Max 8 Nodes ZWDongle_0
     2016-12-09 21:40:58   assocGroup_2    Max 8 Nodes
     2016-12-09 21:40:57   assocGroups     2
     2016-12-10 05:37:11   battery         32 %
     2016-12-09 21:26:54   configAutoReportBatteryTime 12
     2016-12-09 21:26:54   configAutoReportDoorWindowStateTime 12
     2016-12-09 21:26:54   configAutoReportIlluminationTime 12
     2016-12-09 21:26:54   configAutoReportTemperatureTime 12
     2016-12-09 21:26:54   configAutoReportTickInterval 30
     2016-12-09 21:26:55   configBasicSetLevel 255
     2016-12-09 21:26:55   configCustomerFunction 4
     2016-12-09 21:26:55   configIlluminationDifferentialReport 0
     2016-12-09 21:26:55   configLightThreshold 99
     2016-12-09 21:26:55   configMultiSensorFunctionSwitch 4
     2016-12-09 21:26:55   configOperationMode 0
     2016-12-09 21:26:55   configPIRReDetectIntervalTime 3
     2016-12-09 21:26:56   configPIRSensitivity 80
     2016-12-09 21:26:58   configTemperatureDifferentialReport 1
     2016-12-09 21:26:59   configTurnOffLightTime 4
     2016-12-10 05:37:11   luminance       2 %
     2016-12-09 18:28:42   model           Philio Technology Corporation PST02-A 4 in 1 Multi-Sensor
     2016-12-09 18:28:42   modelConfig     philio/pst02.xml
     2016-12-09 18:28:42   modelId         013c-0002-000c
     2016-12-09 21:42:08   state           configOperationMode 8
     2016-12-10 05:37:11   temperature     21.0 C
     2016-12-10 05:37:11   timeToAck       0.029
     2016-12-10 05:37:11   transmit        OK
     2016-12-09 22:05:37   wakeup          notification
   SendStack:
     set:481d73
   Secnonce:
     0f:
       nonce      0f51384eedcbe8cd
       timeStamp  1481344631.24393
     86:
       nonce      86c239cd5ad34839
       timeStamp  1481344631.29876
Attributes:
   IODev      ZWDongle_0
   classes    ZWAVEPLUS_INFO BATTERY ALARM ASSOCIATION CONFIGURATION MANUFACTURER_SPECIFIC VERSION SENSOR_BINARY SENSOR_MULTILEVEL WAKE_UP ASSOCIATION_GRP_INFO POWERLEVEL DEVICE_RESET_LOCALLY MULTI_CMD SECURITY FIRMWARE_UPDATE_MD MARK BASIC
   extendedAlarmReadings 1
   room       ZWave
   secure_classes BATTERY ALARM ASSOCIATION CONFIGURATION SENSOR_BINARY SENSOR_MULTILEVEL WAKE_UP MARK
   vclasses   ALARM:4 ASSOCIATION:2 ASSOCIATION_GRP_INFO:1 BASIC:0 BATTERY:1 CONFIGURATION:1 DEVICE_RESET_LOCALLY:1 FIRMWARE_UPDATE_MD:2 MANUFACTURER_SPECIFIC:2 MULTI_CMD:1 POWERLEVEL:1 SECURITY:1 SENSOR_BINARY:2 SENSOR_MULTILEVEL:5 VERSION:2 WAKE_UP:2 ZWAVEPLUS_INFO:2

Log bis zum naechsten list haengt an.

Code Auswählen Erweitern

Internals:
   DEF        e345c452 29
   Frame_01
   IODev      ZWDongle_0
   LASTInputDev ZWDongle_0
   MSGCNT     12
   NAME       ZWave_SENSOR_NOTIFICATION_29
   NR         317
   STATE      configOperationMode 8
   TYPE       ZWave
   ZWDongle_0_MSGCNT 12
   ZWDongle_0_RAWMSG 00487322
   ZWDongle_0_TIME 2016-12-10 08:14:06
   ZWaveSubDevice no
   homeId     e345c452
   isWakeUp   1
   lastMsgSent 1481354038.23286
   nodeIdHex  1d
   secInProgress 1
   secTime    1481354341.04029
   Readings:
     2016-12-09 18:28:30   SECURITY        ENABLED
     2016-12-09 21:49:29   SEND_DATA       failed:00
     2016-12-10 05:37:11   alarm_AccessControl Window/Door is open, notificationIsOn
     2016-12-09 21:42:35   alarm_HomeSecurity Motion Detection - Unknown Location, notificationIsOn
     2016-12-09 21:40:58   assocGroup_1    Max 8 Nodes ZWDongle_0
     2016-12-09 21:40:58   assocGroup_2    Max 8 Nodes
     2016-12-09 21:40:57   assocGroups     2
     2016-12-10 05:37:11   battery         32 %
     2016-12-09 21:26:54   configAutoReportBatteryTime 12
     2016-12-09 21:26:54   configAutoReportDoorWindowStateTime 12
     2016-12-09 21:26:54   configAutoReportIlluminationTime 12
     2016-12-09 21:26:54   configAutoReportTemperatureTime 12
     2016-12-09 21:26:54   configAutoReportTickInterval 30
     2016-12-09 21:26:55   configBasicSetLevel 255
     2016-12-09 21:26:55   configCustomerFunction 4
     2016-12-09 21:26:55   configIlluminationDifferentialReport 0
     2016-12-09 21:26:55   configLightThreshold 99
     2016-12-09 21:26:55   configMultiSensorFunctionSwitch 4
     2016-12-09 21:26:55   configOperationMode 0
     2016-12-09 21:26:55   configPIRReDetectIntervalTime 3
     2016-12-09 21:26:56   configPIRSensitivity 80
     2016-12-09 21:26:58   configTemperatureDifferentialReport 1
     2016-12-09 21:26:59   configTurnOffLightTime 4
     2016-12-10 05:37:11   luminance       2 %
     2016-12-09 18:28:42   model           Philio Technology Corporation PST02-A 4 in 1 Multi-Sensor
     2016-12-09 18:28:42   modelConfig     philio/pst02.xml
     2016-12-09 18:28:42   modelId         013c-0002-000c
     2016-12-10 08:14:06   neighborUpdate  done
     2016-12-09 21:42:08   state           configOperationMode 8
     2016-12-10 05:37:11   temperature     21.0 C
     2016-12-10 05:37:11   timeToAck       0.029
     2016-12-10 05:37:11   transmit        OK
     2016-12-10 08:13:58   wakeup          notification
   SendStack:
     sentset:481d73
     set:131d0a9880443ee2a81cf8fdac25a7
     set:131d0a98806f6b505a664f270225a8
     set:131d0a988035be32a0f561739c25a9
     set:131d0a98804dbf17a78ee2376f25aa
     set:131d0a9880b7199d8885ae181f25ab
     set:131d0a9880415145dda0bd92c225ac
     set:131d0a98806b515e5f439f125625ad
     set:131d0a9880c9d2fc82b0335a9925ae
     set:131d0a9880807854d6595085c725af
     set:131d0a9880406456048242299925b0
     set:131d0a9880e17f394e7135b43625b1
     set:131d0a9880c7b30791c7a53c8125b2
     set:131d0a9880464f5e97d2d69bdd25b3
     set:131d0a98809f43b28138c7df5625b4
     set:131d0a988092154cdce0fdd61825b5
     set:131d0a98807da18fea0f795fea25b6
     set:131d0a988039ebb158f4b625e525b7
     set:131d0a9880891788377bd2ad7825b8
     set:131d0a9880a8d28c4aca7f6dcd25b9
   Secnonce:
     0f:
       nonce      0f51384eedcbe8cd
       timeStamp  1481344631.24393
     35:
       nonce      35be32a0f561739c
       timeStamp  1481354026.23165
     39:
       nonce      39ebb158f4b625e5
       timeStamp  1481354287.68028
     40:
       nonce      4064560482422999
       timeStamp  1481354101.74498
     41:
       nonce      415145dda0bd92c2
       timeStamp  1481354035.23486
     44:
       nonce      443ee2a81cf8fdac
       timeStamp  1481354020.27313
     46:
       nonce      464f5e97d2d69bdd
       timeStamp  1481354195.13538
     4d:
       nonce      4dbf17a78ee2376f
       timeStamp  1481354029.23243
     6b:
       nonce      6b515e5f439f1256
       timeStamp  1481354040.32644
     6f:
       nonce      6f6b505a664f2702
       timeStamp  1481354023.23214
     7d:
       nonce      7da18fea0f795fea
       timeStamp  1481354275.83605
     80:
       nonce      807854d6595085c7
       timeStamp  1481354073.98747
     86:
       nonce      86c239cd5ad34839
       timeStamp  1481344631.29876
     89:
       nonce      891788377bd2ad78
       timeStamp  1481354315.10169
     92:
       nonce      92154cdce0fdd618
       timeStamp  1481354257.00108
     9f:
       nonce      9f43b28138c7df56
       timeStamp  1481354235.83062
     A8:
       nonce      a8d28c4aca7f6dcd
       timeStamp  1481354341.04043
     B7:
       nonce      b7199d8885ae181f
       timeStamp  1481354032.23188
     C7:
       nonce      c7b30791c7a53c81
       timeStamp  1481354164.96221
     C9:
       nonce      c9d2fc82b0335a99
       timeStamp  1481354054.93475
     E1:
       nonce      e17f394e7135b436
       timeStamp  1481354104.70756
   secStack:
   Sectimer:
     Hash:
Attributes:
   IODev      ZWDongle_0
   classes    ZWAVEPLUS_INFO BATTERY ALARM ASSOCIATION CONFIGURATION MANUFACTURER_SPECIFIC VERSION SENSOR_BINARY SENSOR_MULTILEVEL WAKE_UP ASSOCIATION_GRP_INFO POWERLEVEL DEVICE_RESET_LOCALLY MULTI_CMD SECURITY FIRMWARE_UPDATE_MD MARK BASIC
   extendedAlarmReadings 1
   room       ZWave
   secure_classes BATTERY ALARM ASSOCIATION CONFIGURATION SENSOR_BINARY SENSOR_MULTILEVEL WAKE_UP MARK
   vclasses   ALARM:4 ASSOCIATION:2 ASSOCIATION_GRP_INFO:1 BASIC:0 BATTERY:1 CONFIGURATION:1 DEVICE_RESET_LOCALLY:1 FIRMWARE_UPDATE_MD:2 MANUFACTURER_SPECIFIC:2 MULTI_CMD:1 POWERLEVEL:1 SECURITY:1 SENSOR_BINARY:2 SENSOR_MULTILEVEL:5 VERSION:2 WAKE_UP:2 ZWAVEPLUS_INFO:2

Gruß, Christian

[A.Harrenberg]

Hi Christian,

habe noch nicht in das Log reingeschaut, aber es sieht so aus als ob bei Dir das gleiche Problem mit dem SendStack aufgetreten ist das buspirat auch schon hatte. Der Stack friert ein und es bleibt ein "sentset:" oben drauf liegen, danach wird nichts mehr versendet. Die "secUnlock" Nachricht wird generiert weil nach dem "Abschicken" der NONCE (die aber auf dem Stack landet und nicht bearbeitet wird keine RM vom Gerät kommt (kann ja auch nicht, wurde ja nix versendet).

D.h. Du hast jetzt erfolgreich das "andere" Problem nachgestellt.

Hier müssen wir verstehen was im Ablauf vom Stack schief läuft. Eigentlich erscheint der Ablauf fool-proof, irgendwas geht da aber dennoch schief.

Dieses Verhalten hat aber nichts mit meinen Änderungen zu tun, das war ja die Ausgangssituation durch die ich diese ewig langen asynchronen "eine NONCE daneben" Kommunikationen entdeckt habe die dann irgendwann auch das Problem mit dem eingefrorenen Stack gezeigt haben.

Am besten noch mal fhem neustarten, ich bin nicht sicher ob beim Laden des Moduls der Stack zurückgesetzt wird, vermute aber das es nicht passiert und daher nicht reicht um die Kommunikation wieder in Gang zu bringen.

Ich schau später auch noch mal in das Logfile ob ich erkenne wo der Stack hängen bleibt. Allerdings war da selbst mit den erweiterten Logmeldungen von buspirat nicht zu erkennen wo genau das hängenbleibt, daher mache ich mir da jetzt erst mal wenig Hoffnung was zu finden was uns der Lösung näherbringt. Außerdem leide ich noch ein wenig unter der gestrigen Weihnachtsfeier ,-)

Gruß,
Andreas.

[A.Harrenberg]

Hi,

im Log ist auch nichts erhellendes zu finden. Anscheinend ist bereits zu Beginn des Logs der Stack schon eingefroren, es wird außer den ACK nichts mehr gesendet...

Gruß,
Andreas.

[krikan]

Kann gut sein. System lief seit gestern abend durch.
FHEM empfängt während der "secStart older than 6 seconds detected, secUnlock will call Zwave_secEnd"- Meldung auch keine Nachrichten mehr vom Gerät. Im Log taucht nichts auf. Nach einiger Zeit erholt es sich aber wieder und Nachrichten kommen wieder an.

Aber egal, vermutlich alles Folgewirkungen. Ich beginne mal einen neuen Test mit frischen gestarteten FHEM und werde berichten. Wird aber frühestens heute abend etwas werden.

Gruß, Christian

[buspirat]

Es scheint das bei dem ZWDongle_shiftSendStack Aufruf was schief läuft und der Befehl nicht vom Stack entfernt wird. Ich war eigentlich der Meinung das im Hintergrund auch ein Timer werkelt der dort aufräumt, evtl. kommt auch Timer aus dem Tritt...

Kurze Rückmeldung von unterwegs: ich denke shiftSendStack für sich alleine arbeitet einwandfrei. Ich hatte extra den Data::Dumper vor und nach dem "shift" Befehl eingebaut. Ich tippe darauf, dass irgendwer *danach* die Nachricht wieder auf den Stack legt. Mein Plan ist bisher die Stellen bei denen die 'sentxxx' Nachrichten erzeugt werden mit weiteren debug Loggern zu versehen.

Evtl. wie von Dir vermutet ein Timer.


VG,
Thomas

[krikan]

Mir ist nicht so ganz klar, worauf ich achten muss. Sind bspw. die vielen nonce und timeStamp-Angaben im list ok? Die tauchen schon nach kurzer Betriebszeit auf ohne im Log erkennbare Auffaelligkeiten.

Code Auswählen Erweitern

Internals:
   DEF        e345c452 29
   Frame_01
   Frame_02
   Frame_03
   IODev      ZWDongle_0
   LASTInputDev ZWDongle_0
   MSGCNT     20
   NAME       ZWave_SENSOR_NOTIFICATION_29
   NR         317
   STATE      configOperationMode 8
   TYPE       ZWave
   ZWDongle_0_MSGCNT 20
   ZWDongle_0_RAWMSG 0004001d189881e6b7ead4de885ec1da9f18acc9aea5eb83b3bb14bcd5
   ZWDongle_0_TIME 2016-12-10 17:08:16
   ZWaveSubDevice no
   homeId     e345c452
   isWakeUp   1
   lastMsgSent 1481386096.91327
   nodeIdHex  1d
   secTime    1481386096.85669
   Readings:
     2016-12-09 18:28:30   SECURITY        ENABLED
     2016-12-09 21:49:29   SEND_DATA       failed:00
     2016-12-10 17:08:16   alarm_AccessControl Window/Door is closed, notificationIsOn
     2016-12-10 08:30:45   alarm_HomeSecurity Tampering - product covering removed, notificationIsOn
     2016-12-09 21:40:58   assocGroup_1    Max 8 Nodes ZWDongle_0
     2016-12-09 21:40:58   assocGroup_2    Max 8 Nodes
     2016-12-09 21:40:57   assocGroups     2
     2016-12-10 17:08:16   battery         32 %
     2016-12-09 21:26:54   configAutoReportBatteryTime 12
     2016-12-09 21:26:54   configAutoReportDoorWindowStateTime 12
     2016-12-09 21:26:54   configAutoReportIlluminationTime 12
     2016-12-09 21:26:54   configAutoReportTemperatureTime 12
     2016-12-09 21:26:54   configAutoReportTickInterval 30
     2016-12-09 21:26:55   configBasicSetLevel 255
     2016-12-09 21:26:55   configCustomerFunction 4
     2016-12-09 21:26:55   configIlluminationDifferentialReport 0
     2016-12-09 21:26:55   configLightThreshold 99
     2016-12-09 21:26:55   configMultiSensorFunctionSwitch 4
     2016-12-09 21:26:55   configOperationMode 0
     2016-12-09 21:26:55   configPIRReDetectIntervalTime 3
     2016-12-09 21:26:56   configPIRSensitivity 80
     2016-12-09 21:26:58   configTemperatureDifferentialReport 1
     2016-12-09 21:26:59   configTurnOffLightTime 4
     2016-12-10 17:08:16   luminance       4 %
     2016-12-09 18:28:42   model           Philio Technology Corporation PST02-A 4 in 1 Multi-Sensor
     2016-12-09 18:28:42   modelConfig     philio/pst02.xml
     2016-12-09 18:28:42   modelId         013c-0002-000c
     2016-12-10 08:14:06   neighborUpdate  done
     2016-12-09 21:42:08   state           configOperationMode 8
     2016-12-10 17:08:16   temperature     21.5 C
     2016-12-10 17:08:16   timeToAck       0.029
     2016-12-10 17:08:16   transmit        OK
     2016-12-10 08:30:59   wakeup          notification
   Secnonce:
     0b:
       nonce      0bfd515ee83393b3
       timeStamp  1481386096.38738
     0e:
       nonce      0e22c319694b0cd0
       timeStamp  1481386094.92757
     25:
       nonce      25f9b9ccc73e30ff
       timeStamp  1481386090.73895
     3a:
       nonce      3a09c932718a12dc
       timeStamp  1481386087.84218
     45:
       nonce      455d0be88e7eaca3
       timeStamp  1481386094.87272
     50:
       nonce      50e397c8dfcb3456
       timeStamp  1481386095.97406
     51:
       nonce      51a11d894b0ba218
       timeStamp  1481386087.78439
     52:
       nonce      526efbdc720c8a77
       timeStamp  1481386096.33123
     61:
       nonce      613cf4a920658f68
       timeStamp  1481386096.85683
     6b:
       nonce      6bd32ce909678b55
       timeStamp  1481386091.23978
     6f:
       nonce      6f09fff199bc9056
       timeStamp  1481386094.72877
     79:
       nonce      7981e37a82d3f84a
       timeStamp  1481386094.64166
     7d:
       nonce      7d14e4c54eba8400
       timeStamp  1481386091.29653
     97:
       nonce      97fe194e10dcb3d5
       timeStamp  1481386090.68395
     9b:
       nonce      9bfda456537624e0
       timeStamp  1481386094.58528
     A0:
       nonce      a0db3458fac0f6b6
       timeStamp  1481386089.06342
     Ad:
       nonce      ad534d0bffa218b1
       timeStamp  1481386089.11961
     Ae:
       nonce      ae79d8475d9c5c1d
       timeStamp  1481386096.91315
     D7:
       nonce      d70e59a059d6944a
       timeStamp  1481386094.78474
     E0:
       nonce      e0e356cbc63bdb0d
       timeStamp  1481386096.02925
Attributes:
   IODev      ZWDongle_0
   classes    ZWAVEPLUS_INFO BATTERY ALARM ASSOCIATION CONFIGURATION MANUFACTURER_SPECIFIC VERSION SENSOR_BINARY SENSOR_MULTILEVEL WAKE_UP ASSOCIATION_GRP_INFO POWERLEVEL DEVICE_RESET_LOCALLY MULTI_CMD SECURITY FIRMWARE_UPDATE_MD MARK BASIC
   extendedAlarmReadings 1
   room       ZWave
   secure_classes BATTERY ALARM ASSOCIATION CONFIGURATION SENSOR_BINARY SENSOR_MULTILEVEL WAKE_UP MARK
   vclasses   ALARM:4 ASSOCIATION:2 ASSOCIATION_GRP_INFO:1 BASIC:0 BATTERY:1 CONFIGURATION:1 DEVICE_RESET_LOCALLY:1 FIRMWARE_UPDATE_MD:2 MANUFACTURER_SPECIFIC:2 MULTI_CMD:1 POWERLEVEL:1 SECURITY:1 SENSOR_BINARY:2 SENSOR_MULTILEVEL:5 VERSION:2 WAKE_UP:2 ZWAVEPLUS_INFO:2

[A.Harrenberg]

Hallo Christian,

Mir ist nicht so ganz klar, worauf ich achten muss. Sind bspw. die vielen nonce und timeStamp-Angaben im list ok? Die tauchen schon nach kurzer Betriebszeit auf ohne im Log erkennbare Auffaelligkeiten.

hmm, in der Version die ich euch zum Testen abgelegt habe ist leider eine Zeile auskommentiert... daher sammeln sich da NONCE Einträge an...

Könntest Du bitte die korrigierte Version aus dem Anhang nehmen oder einfach in der Funktion ZWave_secRetrieveNonce in Zeile 3624 die Kommentierung vor dem "delete($hash->{secNonce}{$s_nonce_id_hex});" entfernen?

Code Auswählen Erweitern

  if ($hash->{secNonce}{$s_nonce_id_hex}) {
      $s_nonce_hex = $hash->{secNonce}{$s_nonce_id_hex}{nonce};
      delete($hash->{secNonce}{$s_nonce_id_hex});
      return $s_nonce_hex;
  } else {
    return undef;
  }

Das funktioniert zwar auch so, aber Du bekommst dann unnötige Einträge im Log und kannst das nicht mehr von potentiellen Fehlern unterscheiden.

WENN es zu mehrfachem Anfordern eine NONCE gekommen ist und die beide noch "jünger" als 10 Sekunden sind, sollte sich im Log (verbose 5) eine Meldung mit

Code Auswählen Erweitern

SECURITY: multiple nonce warning, there are $n nonce active
finden lassen.

Falls das passiert wäre ich an dem entsprechenden Logsegment interessiert um zu sehen warum hier zwei Nonce aktiv wurden.
Gleiches gilt für Passagen in denen secUnlock aufgerufen wird. Hier ist es aber in bisher allen Fällen die ich so gesehen haben wirklich zu einem Kommunikationsabbruch gekommen, in letzter Zeit aber auch das von Dir nachgestellte Verhalten mit dem klemmenden SendStack.

Ansonsten sollten hoffentlich keine neuen Nebeneffekte auftreten.

Gruß,
Andreas.

[krikan]

Hallo Andreas!

Habe den Philio mit Abfragen im Sendstack gequaelt. Jetzt bleibt der Sendstack so haengen:

Code Auswählen Erweitern

Internals:
   DEF        e345c452 29
   Frame_01
   IODev      ZWDongle_0
   LASTInputDev ZWDongle_0
   MSGCNT     92
   NAME       ZWave_SENSOR_NOTIFICATION_29
   NR         317
   STATE      closed
   TYPE       ZWave
   ZWDongle_0_MSGCNT 92
   ZWDongle_0_RAWMSG 0004001d1998818b6b089ede9ad86882fc28e630b82bd558ff850b33de29
   ZWDongle_0_TIME 2016-12-11 21:56:45
   ZWaveSubDevice no
   homeId     e345c452
   isWakeUp   1
   lastMsgSent 1481489817.82236
   nodeIdHex  1d
   secTime    1481490203.23422
   Readings:
     2016-12-09 18:28:30   SECURITY        ENABLED
     2016-12-09 21:49:29   SEND_DATA       failed:00
     2016-12-11 21:55:44   alarm_AccessControl Window/Door is closed, notificationIsOn
     2016-12-11 21:55:28   alarm_HomeSecurity Motion Detection - Unknown Location, notificationIsOn
     2016-12-11 21:54:37   assocGroup_1    Max 8 Nodes ZWDongle_0
     2016-12-11 21:54:38   assocGroup_2    Max 8 Nodes
     2016-12-11 21:54:37   assocGroups     2
     2016-12-11 21:55:44   battery         32 %
     2016-12-11 21:54:35   configAutoReportBatteryTime 12
     2016-12-11 21:54:35   configAutoReportDoorWindowStateTime 12
     2016-12-11 21:54:35   configAutoReportIlluminationTime 12
     2016-12-11 21:56:43   configAutoReportTemperatureTime 12
     2016-12-11 21:56:44   configAutoReportTickInterval 30
     2016-12-11 21:56:44   configBasicSetLevel 255
     2016-12-11 21:56:44   configCustomerFunction 4
     2016-12-11 21:56:44   configIlluminationDifferentialReport 0
     2016-12-11 21:56:44   configLightThreshold 99
     2016-12-11 21:56:44   configMultiSensorFunctionSwitch 4
     2016-12-11 21:56:44   configOperationMode 8
     2016-12-11 21:56:45   configPIRReDetectIntervalTime 3
     2016-12-11 21:56:45   configPIRSensitivity 80
     2016-12-11 21:56:45   configTemperatureDifferentialReport 1
     2016-12-11 21:56:45   configTurnOffLightTime 4
     2016-12-11 21:55:44   luminance       6 %
     2016-12-09 18:28:42   model           Philio Technology Corporation PST02-A 4 in 1 Multi-Sensor
     2016-12-09 18:28:42   modelConfig     philio/pst02.xml
     2016-12-09 18:28:42   modelId         013c-0002-000c
     2016-12-10 08:14:06   neighborUpdate  done
     2016-12-09 21:42:08   state           configOperationMode 8
     2016-12-11 21:55:44   temperature     25.0 C
     2016-12-11 21:56:57   timeToAck       0.092
     2016-12-11 21:56:57   transmit        OK
     2016-12-11 21:56:43   wakeup          notification
   SendStack:
     sentackget:131d03861331250b
     get:131d03861386250c
     get:131d03861384250d
     get:131d0386135e250e
     set:131d0298402510
     set:131d0a98801ec1ca50510f17b52511
     set:131d0a9880daf7ad79a46044e62512
     set:131d0a98804bdf27270ccd8d832513
     set:131d0a988013d6118d21bddc432514
     set:131d0a9880e9faec99aff4ff3e2515
   secMsg:
     8505 get ZWave_SENSOR_NOTIFICATION_29 associationGroups
   Secnonce:
     13:
       nonce      13d6118d21bddc43
       timeStamp  1481490184.41603
     1e:
       nonce      1ec1ca50510f17b5
       timeStamp  1481489817.82169
     29:
       nonce      2923cf83e3bc6197
       timeStamp  1481489800.3939
     4b:
       nonce      4bdf27270ccd8d83
       timeStamp  1481490169.39011
     Da:
       nonce      daf7ad79a46044e6
       timeStamp  1481489876.53989
     Db:
       nonce      dbfadec559d2b3ea
       timeStamp  1481489797.39694
     E9:
       nonce      e9faec99aff4ff3e
       timeStamp  1481490203.23437
Attributes:
   IODev      ZWDongle_0
   classes    ZWAVEPLUS_INFO BATTERY ALARM ASSOCIATION CONFIGURATION MANUFACTURER_SPECIFIC VERSION SENSOR_BINARY SENSOR_MULTILEVEL WAKE_UP ASSOCIATION_GRP_INFO POWERLEVEL DEVICE_RESET_LOCALLY MULTI_CMD SECURITY FIRMWARE_UPDATE_MD MARK BASIC
   extendedAlarmReadings 1
   room       ZWave
   secure_classes BATTERY ALARM ASSOCIATION CONFIGURATION SENSOR_BINARY SENSOR_MULTILEVEL WAKE_UP MARK
   stateFormat {(split(/,|is /, ReadingsVal($name,"alarm_AccessControl","")))[1]}
   vclasses   ALARM:4 ASSOCIATION:2 ASSOCIATION_GRP_INFO:1 BASIC:0 BATTERY:1 CONFIGURATION:1 DEVICE_RESET_LOCALLY:1 FIRMWARE_UPDATE_MD:2 MANUFACTURER_SPECIFIC:2 MULTI_CMD:1 POWERLEVEL:1 SECURITY:1 SENSOR_BINARY:2 SENSOR_MULTILEVEL:5 VERSION:2 WAKE_UP:2 ZWAVEPLUS_INFO:2

Das angehaengte Log ist "etwas" laenger. Aber so siehst Du es hoffentlich von Anfang an.

Nach der angehaengten Datei geht es so weiter, wenn ich nichts mehr selbst in den Sendstack lege:

Code Auswählen Erweitern

2016.12.11 22:02:23.387 4: ZWDongle_Read ZWDongle_0: rcvd 000400040a320221440000000c0000 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.11 22:02:23.387 5: SW: 06
2016.12.11 22:02:23.389 5: ZWDongle_0: dispatch 000400040a320221440000000c0000
2016.12.11 22:02:23.390 4: CMD:APPLICATION_COMMAND_HANDLER ID:04 ARG:0a320221440000000c0000 CB:00
2016.12.11 22:02:49.386 4: ZWDongle_Read ZWDongle_0: rcvd 0004001d029840 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.11 22:02:49.387 5: SW: 06
2016.12.11 22:02:49.388 5: ZWDongle_0: dispatch 0004001d029840
2016.12.11 22:02:49.389 4: CMD:APPLICATION_COMMAND_HANDLER ID:1d ARG:029840 CB:00
2016.12.11 22:02:56.390 3: ZWave_SENSOR_NOTIFICATION_29: secStart older than 6 seconds detected, secUnlock will call Zwave_secEnd
2016.12.11 22:03:04.412 4: ZWDongle_Read ZWDongle_0: rcvd 0004001d029840 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.11 22:03:04.413 5: SW: 06
2016.12.11 22:03:04.414 5: ZWDongle_0: dispatch 0004001d029840
2016.12.11 22:03:04.415 4: CMD:APPLICATION_COMMAND_HANDLER ID:1d ARG:029840 CB:00
2016.12.11 22:03:11.416 3: ZWave_SENSOR_NOTIFICATION_29: secStart older than 6 seconds detected, secUnlock will call Zwave_secEnd
2016.12.11 22:03:23.231 4: ZWDongle_Read ZWDongle_0: rcvd 0004001d029840 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.11 22:03:23.231 5: SW: 06
2016.12.11 22:03:23.233 5: ZWDongle_0: dispatch 0004001d029840
2016.12.11 22:03:23.233 4: CMD:APPLICATION_COMMAND_HANDLER ID:1d ARG:029840 CB:00
2016.12.11 22:03:27.708 4: ZWDongle_Read ZWDongle_0: rcvd 0004001b0a32022144000000020000 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.11 22:03:27.708 5: SW: 06
2016.12.11 22:03:27.710 5: ZWDongle_0: dispatch 0004001b0a32022144000000020000
2016.12.11 22:03:27.711 4: CMD:APPLICATION_COMMAND_HANDLER ID:1b ARG:0a32022144000000020000 CB:00
2016.12.11 22:03:30.234 3: ZWave_SENSOR_NOTIFICATION_29: secStart older than 6 seconds detected, secUnlock will call Zwave_secEnd
2016.12.11 22:03:48.103 4: ZWDongle_Read ZWDongle_0: rcvd 0004001d029840 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.11 22:03:48.103 5: SW: 06
2016.12.11 22:03:48.104 5: ZWDongle_0: dispatch 0004001d029840
2016.12.11 22:03:48.105 4: CMD:APPLICATION_COMMAND_HANDLER ID:1d ARG:029840 CB:00
2016.12.11 22:03:55.106 3: ZWave_SENSOR_NOTIFICATION_29: secStart older than 6 seconds detected, secUnlock will call Zwave_secEnd
2016.12.11 22:04:02.408 4: ZWDongle_Read ZWDongle_0: rcvd 0004001d029840 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.11 22:04:02.408 5: SW: 06
2016.12.11 22:04:02.410 5: ZWDongle_0: dispatch 0004001d029840
2016.12.11 22:04:02.410 4: CMD:APPLICATION_COMMAND_HANDLER ID:1d ARG:029840 CB:00
2016.12.11 22:04:09.411 3: ZWave_SENSOR_NOTIFICATION_29: secStart older than 6 seconds detected, secUnlock will call Zwave_secEnd
2016.12.11 22:05:45.534 4: ZWDongle_Read ZWDongle_0: rcvd 0004001d029840 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.11 22:05:45.534 5: SW: 06
2016.12.11 22:05:45.535 5: ZWDongle_0: dispatch 0004001d029840
2016.12.11 22:05:45.536 4: CMD:APPLICATION_COMMAND_HANDLER ID:1d ARG:029840 CB:00
2016.12.11 22:05:52.538 3: ZWave_SENSOR_NOTIFICATION_29: secStart older than 6 seconds detected, secUnlock will call Zwave_secEnd
2016.12.11 22:07:43.000 4: ZWDongle_Read ZWDongle_0: rcvd 0004001d029840 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.11 22:07:43.001 5: SW: 06
2016.12.11 22:07:43.002 5: ZWDongle_0: dispatch 0004001d029840
2016.12.11 22:07:43.003 4: CMD:APPLICATION_COMMAND_HANDLER ID:1d ARG:029840 CB:00
2016.12.11 22:07:50.004 3: ZWave_SENSOR_NOTIFICATION_29: secStart older than 6 seconds detected, secUnlock will call Zwave_secEnd
2016.12.11 22:09:04.738 4: ZWDongle_Read ZWDongle_0: rcvd 0004001d029840 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.11 22:09:04.738 5: SW: 06
2016.12.11 22:09:04.740 5: ZWDongle_0: dispatch 0004001d029840
2016.12.11 22:09:04.740 4: CMD:APPLICATION_COMMAND_HANDLER ID:1d ARG:029840 CB:00
2016.12.11 22:09:11.741 3: ZWave_SENSOR_NOTIFICATION_29: secStart older than 6 seconds detected, secUnlock will call Zwave_secEnd
2016.12.11 22:09:28.755 4: ZWDongle_Read ZWDongle_0: rcvd 0004001d029840 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.11 22:09:28.755 5: SW: 06
2016.12.11 22:09:28.757 5: ZWDongle_0: dispatch 0004001d029840
2016.12.11 22:09:28.757 4: CMD:APPLICATION_COMMAND_HANDLER ID:1d ARG:029840 CB:00
2016.12.11 22:09:34.481 4: ZWDongle_Read ZWDongle_0: rcvd 0004003e0e32022144000000b10e10000000b0 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.11 22:09:34.481 5: SW: 06
2016.12.11 22:09:34.482 5: ZWDongle_0: dispatch 0004003e0e32022144000000b10e10000000b0
2016.12.11 22:09:34.483 4: CMD:APPLICATION_COMMAND_HANDLER ID:3e ARG:0e32022144000000b10e10000000b0 CB:00
2016.12.11 22:09:35.758 3: ZWave_SENSOR_NOTIFICATION_29: secStart older than 6 seconds detected, secUnlock will call Zwave_secEnd
2016.12.11 22:09:47.791 4: ZWDongle_Read ZWDongle_0: rcvd 0004000d032001ff (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.11 22:09:47.792 5: SW: 06
2016.12.11 22:09:47.793 5: ZWDongle_0: dispatch 0004000d032001ff
2016.12.11 22:09:47.793 4: CMD:APPLICATION_COMMAND_HANDLER ID:0d ARG:032001ff CB:00
2016.12.11 22:09:47.847 4: ZWDongle_Read ZWDongle_0: rcvd 0004000d0a710507ff00ff07080000 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.11 22:09:47.847 5: SW: 06
2016.12.11 22:09:47.849 5: ZWDongle_0: dispatch 0004000d0a710507ff00ff07080000
2016.12.11 22:09:47.849 4: CMD:APPLICATION_COMMAND_HANDLER ID:0d ARG:0a710507ff00ff07080000 CB:00
2016.12.11 22:09:52.149 4: ZWDongle_Read ZWDongle_0: rcvd 0004001d029840 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.11 22:09:52.150 5: SW: 06
2016.12.11 22:09:52.152 5: ZWDongle_0: dispatch 0004001d029840
2016.12.11 22:09:52.152 4: CMD:APPLICATION_COMMAND_HANDLER ID:1d ARG:029840 CB:00
2016.12.11 22:09:59.154 3: ZWave_SENSOR_NOTIFICATION_29: secStart older than 6 seconds detected, secUnlock will call Zwave_secEnd
2016.12.11 22:10:24.776 3: Wetter: 0 result(s) retrieved
2016.12.11 22:10:38.064 4: ZWDongle_Read ZWDongle_0: rcvd 0004001d029840 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.11 22:10:38.064 5: SW: 06
2016.12.11 22:10:38.066 5: ZWDongle_0: dispatch 0004001d029840
2016.12.11 22:10:38.066 4: CMD:APPLICATION_COMMAND_HANDLER ID:1d ARG:029840 CB:00
2016.12.11 22:10:45.067 3: ZWave_SENSOR_NOTIFICATION_29: secStart older than 6 seconds detected, secUnlock will call Zwave_secEnd
2016.12.11 22:11:02.285 4: ZWDongle_Read ZWDongle_0: rcvd 0004001d029840 (request APPLICATION_COMMAND_HANDLER), sending ACK
2016.12.11 22:11:02.286 5: SW: 06
2016.12.11 22:11:02.288 5: ZWDongle_0: dispatch 0004001d029840
2016.12.11 22:11:02.289 4: CMD:APPLICATION_COMMAND_HANDLER ID:1d ARG:029840 CB:00
2016.12.11 22:11:09.291 3: ZWave_SENSOR_NOTIFICATION_29: secStart older than 6 seconds detected, secUnlock will call Zwave_secEnd

Code Auswählen Erweitern

Internals:
   DEF        e345c452 29
   Frame_01
   IODev      ZWDongle_0
   LASTInputDev ZWDongle_0
   MSGCNT     92
   NAME       ZWave_SENSOR_NOTIFICATION_29
   NR         317
   STATE      closed
   TYPE       ZWave
   ZWDongle_0_MSGCNT 92
   ZWDongle_0_RAWMSG 0004001d1998818b6b089ede9ad86882fc28e630b82bd558ff850b33de29
   ZWDongle_0_TIME 2016-12-11 21:56:45
   ZWaveSubDevice no
   homeId     e345c452
   isWakeUp   1
   lastMsgSent 1481489817.82236
   nodeIdHex  1d
   secTime    1481490662.29033
   Readings:
     2016-12-09 18:28:30   SECURITY        ENABLED
     2016-12-09 21:49:29   SEND_DATA       failed:00
     2016-12-11 21:55:44   alarm_AccessControl Window/Door is closed, notificationIsOn
     2016-12-11 21:55:28   alarm_HomeSecurity Motion Detection - Unknown Location, notificationIsOn
     2016-12-11 21:54:37   assocGroup_1    Max 8 Nodes ZWDongle_0
     2016-12-11 21:54:38   assocGroup_2    Max 8 Nodes
     2016-12-11 21:54:37   assocGroups     2
     2016-12-11 21:55:44   battery         32 %
     2016-12-11 21:54:35   configAutoReportBatteryTime 12
     2016-12-11 21:54:35   configAutoReportDoorWindowStateTime 12
     2016-12-11 21:54:35   configAutoReportIlluminationTime 12
     2016-12-11 21:56:43   configAutoReportTemperatureTime 12
     2016-12-11 21:56:44   configAutoReportTickInterval 30
     2016-12-11 21:56:44   configBasicSetLevel 255
     2016-12-11 21:56:44   configCustomerFunction 4
     2016-12-11 21:56:44   configIlluminationDifferentialReport 0
     2016-12-11 21:56:44   configLightThreshold 99
     2016-12-11 21:56:44   configMultiSensorFunctionSwitch 4
     2016-12-11 21:56:44   configOperationMode 8
     2016-12-11 21:56:45   configPIRReDetectIntervalTime 3
     2016-12-11 21:56:45   configPIRSensitivity 80
     2016-12-11 21:56:45   configTemperatureDifferentialReport 1
     2016-12-11 21:56:45   configTurnOffLightTime 4
     2016-12-11 21:55:44   luminance       6 %
     2016-12-09 18:28:42   model           Philio Technology Corporation PST02-A 4 in 1 Multi-Sensor
     2016-12-09 18:28:42   modelConfig     philio/pst02.xml
     2016-12-09 18:28:42   modelId         013c-0002-000c
     2016-12-10 08:14:06   neighborUpdate  done
     2016-12-09 21:42:08   state           configOperationMode 8
     2016-12-11 21:55:44   temperature     25.0 C
     2016-12-11 21:56:57   timeToAck       0.092
     2016-12-11 21:56:57   transmit        OK
     2016-12-11 21:56:43   wakeup          notification
   SendStack:
     sentackget:131d03861331250b
     get:131d03861386250c
     get:131d03861384250d
     get:131d0386135e250e
     set:131d0298402510
     set:131d0a98801ec1ca50510f17b52511
     set:131d0a9880daf7ad79a46044e62512
     set:131d0a98804bdf27270ccd8d832513
     set:131d0a988013d6118d21bddc432514
     set:131d0a9880e9faec99aff4ff3e2515
     set:131d0a988012167ba4209a30b62516
     set:131d0a988050071a5c16203f6b2517
     set:131d0a9880582d3fa38f4f21fb2518
     set:131d0a98806d0f68ed211935312519
     set:131d0a9880e2b13a9330fe799b251a
     set:131d0a988019b40df8836c4894251b
     set:131d0a9880fcbeaeb653bee8f6251c
     set:131d0a9880325f5034b90d6118251d
     set:131d0a988057a8403761d5b4fe251e
   secMsg:
     8505 get ZWave_SENSOR_NOTIFICATION_29 associationGroups
   Secnonce:
     12:
       nonce      12167ba4209a30b6
       timeStamp  1481490228.10585
     13:
       nonce      13d6118d21bddc43
       timeStamp  1481490184.41603
     19:
       nonce      19b40df8836c4894
       timeStamp  1481490568.75829
     1e:
       nonce      1ec1ca50510f17b5
       timeStamp  1481489817.82169
     29:
       nonce      2923cf83e3bc6197
       timeStamp  1481489800.3939
     32:
       nonce      325f5034b90d6118
       timeStamp  1481490638.06751
     4b:
       nonce      4bdf27270ccd8d83
       timeStamp  1481490169.39011
     50:
       nonce      50071a5c16203f6b
       timeStamp  1481490242.41115
     57:
       nonce      57a8403761d5b4fe
       timeStamp  1481490662.29072
     58:
       nonce      582d3fa38f4f21fb
       timeStamp  1481490345.53691
     6d:
       nonce      6d0f68ed21193531
       timeStamp  1481490463.00396
     Da:
       nonce      daf7ad79a46044e6
       timeStamp  1481489876.53989
     Db:
       nonce      dbfadec559d2b3ea
       timeStamp  1481489797.39694
     E2:
       nonce      e2b13a9330fe799b
       timeStamp  1481490544.74118
     E9:
       nonce      e9faec99aff4ff3e
       timeStamp  1481490203.23437
     Fc:
       nonce      fcbeaeb653bee8f6
       timeStamp  1481490592.1539
Attributes:
   IODev      ZWDongle_0
   classes    ZWAVEPLUS_INFO BATTERY ALARM ASSOCIATION CONFIGURATION MANUFACTURER_SPECIFIC VERSION SENSOR_BINARY SENSOR_MULTILEVEL WAKE_UP ASSOCIATION_GRP_INFO POWERLEVEL DEVICE_RESET_LOCALLY MULTI_CMD SECURITY FIRMWARE_UPDATE_MD MARK BASIC
   extendedAlarmReadings 1
   room       ZWave
   secure_classes BATTERY ALARM ASSOCIATION CONFIGURATION SENSOR_BINARY SENSOR_MULTILEVEL WAKE_UP MARK
   stateFormat {(split(/,|is /, ReadingsVal($name,"alarm_AccessControl","")))[1]}
   vclasses   ALARM:4 ASSOCIATION:2 ASSOCIATION_GRP_INFO:1 BASIC:0 BATTERY:1 CONFIGURATION:1 DEVICE_RESET_LOCALLY:1 FIRMWARE_UPDATE_MD:2 MANUFACTURER_SPECIFIC:2 MULTI_CMD:1 POWERLEVEL:1 SECURITY:1 SENSOR_BINARY:2 SENSOR_MULTILEVEL:5 VERSION:2 WAKE_UP:2 ZWAVEPLUS_INFO:2

Wenn ich etwas bestimmtes probieren darf, bitte melden.
Gruß, Christian

[krikan]

Wichtiges vergessen:
Im Zeitraum zwischen den beiden lists kommen keine Events mehr durch. Dazwischen liegt auch keine WUN. Nach einer WUN erholt es sich wieder und Events kommen durch.