Fhem via Razberry mit Danalock verbinden

A.Harrenberg · 09 November 2015, 19:22:28

Hi Elmar,

Zitat von: ElmarK am 09 November 2015, 19:13:39
die 10_zwave... ist über die fhem update Funktion immer aktuell, oder muss ich eine Andere nehmen?

die offizielle Version ist erst einmal in Ordnung, die letzten Änderungen sind auch schon ein paar Tage alt, d.h. es ist also alles enthalten solange Du auch "shutdown restart" nach dem Update machst.

Es hat mit den Tests auch Zeit, ich hab' gerade auch noch zwei andere Baustellen zu Hause ,-)
Hmm, während ich schrieb hast Du schon den ersten Test geschickt... Ich schau mir das später noch mal kurz an. Status "Initializing" ist schon mal nicht gut... Dann ist Security nicht da, dann sind die ganzen Klassen nicht da und die beiden Befehle auch nicht.

Gruß,
Andreas.

Edit: P.S.: Logausschnitte am besten in die "Code-Tags" packen (das Icon mit dem "#")

ElmarK · 09 November 2015, 19:42:45

Hallo Andreas,
hier noch ein 2ter Versuch....

Code Auswählen


2015.11.09 19:39:29 1: in UNDEFINED
2015.11.09 19:39:29 2: autocreate: define ZWave_ENTRY_CONTROL_4 ZWave e6bfee46 4 72808698
2015.11.09 19:39:29 2: autocreate: define FileLog_ZWave_ENTRY_CONTROL_4 FileLog ./log/ZWave_ENTRY_CONTROL_4-%Y.log ZWave_ENTRY_CONTROL_4
2015.11.09 19:39:31 1: checkFritzMACpresent (FritzBox_Telnet): mac_98_FE_94_39_8B_95 nicht gefunden, abwesend.
2015.11.09 19:39:31 1: checkFritzMACpresent (FritzBox_Telnet): mac_24_E3_14_26_AF_D7 gefunden, Gerät heißt >eKoschka-SKV<.
2015.11.09 19:39:31 1: checkFritzMACpresent (FritzBox_Telnet): mac_78_D7_5F_53_94_2F gefunden, Gerät heißt >PC-192-168-178-22<.
2015.11.09 19:39:34 4: ZWDongle_Read ZWDongle_0: sending ACK, processing 004a01050400
2015.11.09 19:39:34 5: SW: 06
2015.11.09 19:39:34 5: ZWDongle_0 dispatch 004a01050400
2015.11.09 19:39:34 4: ZWDongle_0 CMD:ZW_ADD_NODE_TO_NETWORK ID:05 ARG:0400
2015.11.09 19:39:34 2: ZWAVE Starting secure init
2015.11.09 19:39:34 5: ZWDongle_Write 00 1304039804002504
2015.11.09 19:39:34 5: SW: 010a0013040398040025045c
2015.11.09 19:39:34 5: ACK received, WaitForAck=>2 for 010a0013040398040025045c
2015.11.09 19:39:34 4: ZWDongle_Read ZWDongle_0: sending ACK, processing 011301
2015.11.09 19:39:34 5: SW: 06
2015.11.09 19:39:34 5: ZWDongle_0 dispatch 011301
2015.11.09 19:39:35 4: ZWDongle_Read ZWDongle_0: sending ACK, processing 001304000074
2015.11.09 19:39:35 5: SW: 06
2015.11.09 19:39:35 5: device ack reveived, removing 010a0013040398040025045c from dongle sendstack
2015.11.09 19:39:35 5: ZWDongle_0 dispatch 001304000074
2015.11.09 19:39:35 4: ZWDongle_0 CMD:ZW_SEND_DATA ID:00 ARG:0074
2015.11.09 19:39:35 4: ZWDongle_0 transmit OK for 04
2015.11.09 19:39:35 4: ZWDongle_Read ZWDongle_0: sending ACK, processing 0004000403980500
2015.11.09 19:39:35 5: SW: 06
2015.11.09 19:39:35 5: ZWDongle_0 dispatch 0004000403980500
2015.11.09 19:39:35 4: ZWDongle_0 CMD:APPLICATION_COMMAND_HANDLER ID:04 ARG:03980500
2015.11.09 19:39:35 5: ZWDongle_Write 00 13040298402504
2015.11.09 19:39:35 5: SW: 010900130402984025041a
2015.11.09 19:39:35 4: ZWDongle_ReadAnswer arg:secNonce regexp:^00040004..98
2015.11.09 19:39:35 5: ACK received, WaitForAck=>2 for 010900130402984025041a
2015.11.09 19:39:35 4: ZWDongle_Read ZWDongle_0: sending ACK, processing 011301
2015.11.09 19:39:35 5: SW: 06
2015.11.09 19:39:35 5: ZWDongle_0 dispatch 011301
2015.11.09 19:39:37 4: ZWDongle_Read ZWDongle_0: sending ACK, processing 00130400007c
2015.11.09 19:39:37 5: SW: 06
2015.11.09 19:39:37 5: device ack reveived, removing 010900130402984025041a from dongle sendstack
2015.11.09 19:39:37 5: ZWDongle_0 dispatch 00130400007c
2015.11.09 19:39:37 4: ZWDongle_0 CMD:ZW_SEND_DATA ID:00 ARG:007c
2015.11.09 19:39:37 4: ZWDongle_0 transmit OK for 04
2015.11.09 19:39:40 5: ZWDongle_ReadAnswer: select timeout

ElmarK · 09 November 2015, 20:02:42

Hab den FHEM Server mal komplett neu gestartet. Jetzt stehe ich auf

Code Auswählen


SECURITY  INITIALIZING (Networkkey sent)

Das Logfile sagt:

Code Auswählen


2015.11.09 19:50:42 2: autocreate: define ZWave_ENTRY_CONTROL_4 ZWave e6bfee46 4 72808698
2015.11.09 19:50:42 2: autocreate: define FileLog_ZWave_ENTRY_CONTROL_4 FileLog ./log/ZWave_ENTRY_CONTROL_4-%Y.log ZWave_ENTRY_CONTROL_4
2015.11.09 19:50:44 4: ZWDongle_Read ZWDongle_0: sending ACK, processing 004a01050400
2015.11.09 19:50:44 5: SW: 06
2015.11.09 19:50:44 5: ZWDongle_0 dispatch 004a01050400
2015.11.09 19:50:44 4: ZWDongle_0 CMD:ZW_ADD_NODE_TO_NETWORK ID:05 ARG:0400
2015.11.09 19:50:44 2: ZWAVE Starting secure init
2015.11.09 19:50:44 5: ZWDongle_Write 00 1304039804002504
2015.11.09 19:50:44 5: SW: 010a0013040398040025045c
2015.11.09 19:50:44 5: ACK received, WaitForAck=>2 for 010a0013040398040025045c
2015.11.09 19:50:44 4: ZWDongle_Read ZWDongle_0: sending ACK, processing 011301
2015.11.09 19:50:44 5: SW: 06
2015.11.09 19:50:44 5: ZWDongle_0 dispatch 011301
2015.11.09 19:50:46 4: no response from device, removing 010a0013040398040025045c from dongle sendstack
2015.11.09 19:50:47 4: ZWDongle_Read ZWDongle_0: sending ACK, processing 00130400016e
2015.11.09 19:50:47 5: SW: 06
2015.11.09 19:50:47 5: ZWDongle_0 dispatch 00130400016e
2015.11.09 19:50:47 4: ZWDongle_0 CMD:ZW_SEND_DATA ID:00 ARG:016e
2015.11.09 19:50:47 4: ZWDongle_0 transmit OK for 04
2015.11.09 19:50:47 4: ZWDongle_Read ZWDongle_0: sending ACK, processing 0004000403980500
2015.11.09 19:50:47 5: SW: 06
2015.11.09 19:50:47 5: ZWDongle_0 dispatch 0004000403980500
2015.11.09 19:50:47 4: ZWDongle_0 CMD:APPLICATION_COMMAND_HANDLER ID:04 ARG:03980500
2015.11.09 19:50:47 5: ZWDongle_Write 00 13040298402504
2015.11.09 19:50:47 5: SW: 010900130402984025041a
2015.11.09 19:50:47 4: ZWDongle_ReadAnswer arg:secNonce regexp:^00040004..98
2015.11.09 19:50:47 5: ACK received, WaitForAck=>2 for 010900130402984025041a
2015.11.09 19:50:47 4: ZWDongle_Read ZWDongle_0: sending ACK, processing 011301
2015.11.09 19:50:47 5: SW: 06
2015.11.09 19:50:47 5: ZWDongle_0 dispatch 011301
2015.11.09 19:50:47 4: ZWDongle_Read ZWDongle_0: sending ACK, processing 001304000002
2015.11.09 19:50:47 5: SW: 06
2015.11.09 19:50:47 5: device ack reveived, removing 010900130402984025041a from dongle sendstack
2015.11.09 19:50:47 5: ZWDongle_0 dispatch 001304000002
2015.11.09 19:50:47 4: ZWDongle_0 CMD:ZW_SEND_DATA ID:00 ARG:0002
2015.11.09 19:50:47 4: ZWDongle_0 transmit OK for 04
2015.11.09 19:50:48 4: ZWDongle_Read ZWDongle_0: sending ACK, processing 000400040a98800c1d9d4f0f6b178f
2015.11.09 19:50:48 5: SW: 06
2015.11.09 19:50:48 4: ZWDongle_ReadAnswer for secNonce: 000400040a98800c1d9d4f0f6b178f
2015.11.09 19:50:48 4: ZWDongle_0 CMD:APPLICATION_COMMAND_HANDLER ID:04 ARG:0a98800c1d9d4f0f6b178f
2015.11.09 19:50:48 5: ZWDongle_Write 00 1304269881aa22b29b0d5aa9928ba4fcc53bc223c49afdfb72db92a265e61d900c268721843416c9d72504
2015.11.09 19:50:48 5: SW: 012d001304269881aa22b29b0d5aa9928ba4fcc53bc223c49afdfb72db92a265e61d900c268721843416c9d7250421
2015.11.09 19:50:48 5: ACK received, WaitForAck=>2 for 012d001304269881aa22b29b0d5aa9928ba4fcc53bc223c49afdfb72db92a265e61d900c268721843416c9d7250421
2015.11.09 19:50:48 4: ZWDongle_Read ZWDongle_0: sending ACK, processing 011301
2015.11.09 19:50:48 5: SW: 06
2015.11.09 19:50:48 5: ZWDongle_0 dispatch 011301
2015.11.09 19:50:48 4: ZWDongle_Read ZWDongle_0: sending ACK, processing 001304000003
2015.11.09 19:50:48 5: SW: 06
2015.11.09 19:50:48 5: device ack reveived, removing 012d001304269881aa22b29b0d5aa9928ba4fcc53bc223c49afdfb72db92a265e61d900c268721843416c9d7250421 from dongle sendstack
2015.11.09 19:50:48 5: ZWDongle_0 dispatch 001304000003
2015.11.09 19:50:48 4: ZWDongle_0 CMD:ZW_SEND_DATA ID:00 ARG:0003
2015.11.09 19:50:48 4: ZWDongle_0 transmit OK for 04

A.Harrenberg · 09 November 2015, 20:34:35

Hi Elmar,

ich denke Du kannst erst mal 'ne kleine Pause beim Testen machen. Ich muss mal schauen an welchen Stellen das System hängen bleibt und kann Dir dann evtl. eine angepasste Version der 10_Zwave.pm für weitere Tests zur Verfügung stellen. Das wird aber wohl frühestens Donnerstag was werden.

Bisher ist mir aufgefallen das im ersten Versuch die Empfangsbestätigung vom Schloss 2 Sekunden gebraucht hat -> ZWave hatte da bereits "aufgegeben"....
Danach kommt der Ablauf etwas durcheinander und anscheinend geht in meinem Stack ein Befehl verloren ,-(

Im zweiten Versuch gibt es einen Timeout bei einem Get-Befehl (kann ich in einer Testversion "umgehen")

Im dritten Versuch fängt es erst mal genau an wie im ersten, läuft dann aber weiter durch. Allerdings kommt anscheinend keine Antwort auf das Senden des Netzwerkschlüssels.

Insgesamt alles eher Probleme die auf grundlege Probleme mit dem aktuellen ZWave Code hindeuten. Ich schau mir das mal etwas genauer an und werde mich auch mal mit Rudi deswegen in Verbindung setzen.

Weitere Tests machen daher momentan wenig Sinn...

Gruß,
Andreas.

P.S.: Könntest Du bitte in "global" das Attribut mseclog auf "1" setzen? Das schaltet die Anzeige von millisekunden im Logfile ein.

ElmarK · 09 November 2015, 20:47:20

Hallo Andreas,
dann pausier ich mal

Danke, das Du da so dran bist !

LG, Elmar

A.Harrenberg · 09 November 2015, 21:31:31

Hi Elmar,

hast Du evtl. gleichzeitig noch irgendwas auf dem Server oder in FHEM laufen was zum Blockieren von FHEM führen könnte? Andere komplizierte Steuerungen, HomeMatic Geräte, weitere CUL, ...?

Da ich auch Probleme mit der Kommunikation hatte habe ich ein allgemeines Problem vermuten, aktuell funktioniert bei mir aber alles einwandfrei, sodaß es kein allegemeines Problem sein kann.
Bei Dir dauern Antworten vom Schloss aber teilweise ungewöhnlich lang oder bleiben ganz weg.

Hast Du noch weitere ZWave Geräte? Wie weit bist Du mit dem Dongle vom Schloss weg? Wird das evtl. über ein anderes Gerät geroutet?

Gruß,
Andreas.

ElmarK · 10 November 2015, 11:34:57

Zitat von: A.Harrenberg am 09 November 2015, 21:31:31
hast Du evtl. gleichzeitig noch irgendwas auf dem Server oder in FHEM laufen was zum Blockieren von FHEM führen könnte? Andere komplizierte Steuerungen, HomeMatic Geräte, weitere CUL, ...?

Da ich auch Probleme mit der Kommunikation hatte habe ich ein allgemeines Problem vermuten, aktuell funktioniert bei mir aber alles einwandfrei, sodaß es kein allegemeines Problem sein kann.
Bei Dir dauern Antworten vom Schloss aber teilweise ungewöhnlich lang oder bleiben ganz weg.

Hast Du noch weitere ZWave Geräte? Wie weit bist Du mit dem Dongle vom Schloss weg? Wird das evtl. über ein anderes Gerät geroutet?

Gruß,
Andreas.

Hallo Andreas,
ich habe noch einen CUL an einem anderen USB Port. Allerdings kann man nicht von komplizierter Steuerung reden. Bin erst am Aufbauen und habe nur 3 Intertechno Steckdosen zum testen dran. ZWave habe ich derzeit nur das Danalock. Allerdings ist der Server am Dachboden und die Tür im Erdgeschoss (2 Stockwerke). Kann das zu weit weg sein, zumal ja ein teil am ZWave Stick ankommt? Werde das heute Abend mal testen, wenn ich das Schloss neben den Stick halte ...

LG, Elmar
Hi Elmar,

ElmarK · 10 November 2015, 18:00:18

Hallo Andreas,
also jetzt ca 50 cm. vom ZWave Dongle weg stehe ich wieder auf:

Code Auswählen

SECURITY INITIALIZING (starting secure inclusion)

A.Harrenberg · 10 November 2015, 18:32:57

Hi Elmar,

Zitat von: ElmarK am 10 November 2015, 18:00:18
Hallo Andreas,
also jetzt ca 50 cm. vom ZWave Dongle weg stehe ich wieder auf:

Code Auswählen Erweitern
SECURITY INITIALIZING (starting secure inclusion)

könntest Du bitte noch mal ein Log von der Inklusion (mit dem mseclog = 1) machen und posten?

Wahrscheinlich reicht bei Dir der Time-Out von 2 Sekunden für die Sendebestätigung nicht aus und müsste etwas erhöht werden, das muss ich mir aber erst noch mal im Detail ansehen da Rudi da kurzlich was geändert hat und ich das noch nicht so genau analysiert haben.

Gruß,
Andreas.

ElmarK · 10 November 2015, 19:03:08

Hallo Andreas,
klar!

Code Auswählen

2015.11.10 17:57:34.594 1: in UNDEFINED
2015.11.10 17:57:34.594 2: autocreate: define ZWave_ENTRY_CONTROL_4 ZWave e6bfee46 4 72808698
2015.11.10 17:57:34.594 2: autocreate: define FileLog_ZWave_ENTRY_CONTROL_4 FileLog ./log/ZWave_ENTRY_CONTROL_4-%Y.log ZWave_ENTRY_CONTROL_4
2015.11.10 17:57:35.778 4: ZWDongle_Read ZWDongle_0: sending ACK, processing 004a01050400
2015.11.10 17:57:35.778 5: SW: 06
2015.11.10 17:57:35.779 5: ZWDongle_0 dispatch 004a01050400
2015.11.10 17:57:35.781 4: ZWDongle_0 CMD:ZW_ADD_NODE_TO_NETWORK ID:05 ARG:0400
2015.11.10 17:57:35.781 2: ZWAVE Starting secure init
2015.11.10 17:57:35.781 5: ZWDongle_Write 00 1304039804002504
2015.11.10 17:57:35.782 5: SW: 010a0013040398040025045c
2015.11.10 17:57:35.783 5: ACK received, WaitForAck=>2 for 010a0013040398040025045c
2015.11.10 17:57:35.791 4: ZWDongle_Read ZWDongle_0: sending ACK, processing 011301
2015.11.10 17:57:35.791 5: SW: 06
2015.11.10 17:57:35.792 5: ZWDongle_0 dispatch 011301
2015.11.10 17:57:36.935 4: ZWDongle_Read ZWDongle_0: sending ACK, processing 001304000073
2015.11.10 17:57:36.935 5: SW: 06
2015.11.10 17:57:36.936 5: device ack reveived, removing 010a0013040398040025045c from dongle sendstack
2015.11.10 17:57:36.936 5: ZWDongle_0 dispatch 001304000073

A.Harrenberg · 10 November 2015, 21:20:21

Hi Elmar,

wie, mehr kommt / passiert da nicht?

Also mit: "ZWDongle_Write 00 1304039804002504" wird eine Anfrage "980400" an das Schloss geschickt, das muss vom Schloss mit einer Nachricht *980500* beantwortet werden. Wenn die Antwort vom Schloss nicht kommt dann kann es nicht weitergehen...

Die Anfrage ist aber einwandfrei beim Schloss angekommen, der Empfang der Nachricht wird sauber bestätigt, das ist absolut gar nichts auffällig, außer das keine Antwort kommt.

Kann es evtl. sein das die Batterie von dem Schloss nicht mehr so ganz "frisch" ist? Mir gehen die Ideen aus was hier passiert...

Gruß,
Andreas.

ElmarK · 10 November 2015, 21:46:56

Hallo Andreas,
aktueller Versuch:

Code Auswählen

2015.11.10 21:45:00.526 2: autocreate: define ZWave_ENTRY_CONTROL_4 ZWave e6bfee46 4 72808698
2015.11.10 21:45:00.526 2: autocreate: define FileLog_ZWave_ENTRY_CONTROL_4 FileLog ./log/ZWave_ENTRY_CONTROL_4-%Y.log ZWave_ENTRY_CONTROL_4
2015.11.10 21:45:01.991 4: ZWDongle_Read ZWDongle_0: sending ACK, processing 004a01050400
2015.11.10 21:45:01.991 5: SW: 06
2015.11.10 21:45:01.993 5: ZWDongle_0 dispatch 004a01050400
2015.11.10 21:45:01.994 4: ZWDongle_0 CMD:ZW_ADD_NODE_TO_NETWORK ID:05 ARG:0400
2015.11.10 21:45:01.994 2: ZWAVE Starting secure init
2015.11.10 21:45:01.995 5: ZWDongle_Write 00 1304039804002504
2015.11.10 21:45:01.995 5: SW: 010a0013040398040025045c
2015.11.10 21:45:01.996 5: ACK received, WaitForAck=>2 for 010a0013040398040025045c
2015.11.10 21:45:02.004 4: ZWDongle_Read ZWDongle_0: sending ACK, processing 011301
2015.11.10 21:45:02.004 5: SW: 06
2015.11.10 21:45:02.005 5: ZWDongle_0 dispatch 011301
2015.11.10 21:45:03.148 4: ZWDongle_Read ZWDongle_0: sending ACK, processing 001304000073
2015.11.10 21:45:03.148 5: SW: 06
2015.11.10 21:45:03.149 5: device ack reveived, removing 010a0013040398040025045c from dongle sendstack
2015.11.10 21:45:03.149 5: ZWDongle_0 dispatch 001304000073
2015.11.10 21:45:03.149 4: ZWDongle_0 CMD:ZW_SEND_DATA ID:00 ARG:0073
2015.11.10 21:45:03.149 4: ZWDongle_0 transmit OK for 04

Steht jetzt wieder bei :

Code Auswählen

SECURITY INITIALIZING (starting secure inclusion) 2015-11-10 21:45:01

LG, Elmar

A.Harrenberg · 10 November 2015, 22:02:49

Hi Elmar,

sorry, aber so wird das irgendwie nichts ;-(

Es kommte einfach keine Antwort auf die Anfrage vom Gerät... Ob das am Gerät oder an FHEM/ZWave liegt ist nicht feststellbar.
Könntest Du vielleicht noch mal versuchen das Ding OHNE Security einzubinden und das Log posten?

Gruß,
Andreas.

ElmarK · 12 November 2015, 11:42:53

Hallo Andreas,
klar. Mach ich gleich heute Abend.

Komisch ist nur, dass ich z.B. den Batteriezustand abfragen kann...

LG, Elmar

A.Harrenberg · 12 November 2015, 12:44:59

Hi Elmar,

Zitat von: ElmarK am 12 November 2015, 11:42:53
klar. Mach ich gleich heute Abend.

Komisch ist nur, dass ich z.B. den Batteriezustand abfragen kann...

keine übertriebene Eile, aber "komisch" ist das ganze Verhalten schon.

Ich bin mir nicht sicher ob wir (damit meine ich das ZWave-Modul) nicht durch "Quereinwirkung" von anderen Modulen gestört werden. Ich hatte vor ein paar Tagen ja auch ganz merkwürdige Effekte die ich jetzt nicht mehr nachvollziehen kann.

Das Schloss antwortet ja auch auch ansonsten, die Inklusion hat funktioniert, der Empfang der Nachricht wurde ja auch bestätigt, Batteriezustand funktioniert... Es kann kein absolut generelles Problem sein, nur irgendetwas temporäres. Das zu Finden ist aber nahezu unmöglich, das es ja kein "Logfile" im Schloss gibt das man sich anschauen könnte...

Na schauen wir mal was das Ding heute abend "sagt" ,-)

Gruß,
Andreas.