Test Adapter KNX v2.x

JojoS

@chefkoch009 ich habe jetzt nochmal die neue Version aktiviert und eine einfache Lampe angeschlossen. Die Ein/Ausschaltzeiten sind sehr zufällig verzögert, bis mehrere Sekunden. Ich kann da jetzt noch kein Schema erkennen.
Ein log habe ich aufgenzeichnet, wo kann ich das hinschicken?
Da war doch auch was mit Redis, wo kann ich nochmal sehen ob ich das benutze, die Installation ist schon so lange her...
edit:
also der redis service läuft nicht. Nur im log sehe ich States user redis pmessage knx.0.* Meldungen.

lessthanmore

@jojos said in Test Adapter KNX v2.x:

wo kann ich nochmal sehen ob ich das benutze

iob status

gibt dann sowas:

iob status
iobroker is running on this host.

At least one iobroker host is running.

Objects type: redis
States  type: redis

JojoS

@lessthanmore danke, ich benutze json1

@chefkoch009

knx.0	2022-06-15 13:15:24.204	info	( 4.b ) return to STATE_READY, processing : false
knx.0	2022-06-15 13:15:24.204	info	( 4 ) Sending Tunnel_Request ACK : 06 10 04 21 00 0a 04 59 10 00 ChID : 89 SeqCntIN : 16 SeqCntOUT : 142 queue length : 0
knx.0	2022-06-15 13:15:24.203	info	=====> STATE_TUNNELING_ACK
knx.0	2022-06-15 13:15:24.202	info	WRITE : mappedName : Terasse Steckdose3 li Status dest : 3/1/3 val: 0 (DPT1.011) Terasse_Steckdose3_li_Status
knx.0	2022-06-15 13:15:24.202	info	( 3.2 ) Received TUNNEL_REQUEST (WRITE - send ACK ) : 06 10 04 20 00 15 04 59 10 00 29 00 bc e0 11 03 19 03 01 00 80 ChID: 89
knx.0	2022-06-15 13:15:24.149	info	( 4.b ) return to STATE_READY, processing : false
knx.0	2022-06-15 13:15:24.149	info	( 4 ) Sending Tunnel_Request ACK : 06 10 04 21 00 0a 04 59 0f 00 ChID : 89 SeqCntIN : 15 SeqCntOUT : 142 queue length : 0
knx.0	2022-06-15 13:15:24.148	info	=====> STATE_TUNNELING_ACK
knx.0	2022-06-15 13:15:24.148	info	( 3.6a ) Received L_DATA.con 06 10 04 20 00 15 04 59 0f 00 2e 00 bc e0 11 64 18 03 01 00 80 was successfully processed by receiver.
knx.0	2022-06-15 13:15:24.131	info	==> easy-knx.js: signal runtime : 0s 1.209669ms
knx.0	2022-06-15 13:15:24.131	info	==> successful acknowledged previous package... processing next of 0
knx.0	2022-06-15 13:15:24.131	info	( 2 ) Received TUNNEL_ACK : 06 10 04 21 00 0a 04 59 8d 00 from 192.168.100.64:3671 SeqCntIN : 14 SeqCntOUT : 142 GA : 0/0/0
knx.0	2022-06-15 13:15:24.130	info	easy-knx: task.data : 06 10 04 20 00 15 04 59 8d 00 11 00 bc e0 11 64 18 03 01 00 80 byteLen : 21
knx.0	2022-06-15 13:15:24.130	info	( 1 ) Sending : GroupValueWrite : 06 10 04 20 00 15 04 59 8d 00 11 00 bc e0 11 64 18 03 01 00 80 sent to 192.168.100.64:3671 ChID: 89 SeqCntIN : 14 SeqCntOUT : 141 GA : 3/0/3 conCheck.conected : true
knx.0	2022-06-15 13:15:24.130	info	Has todo still 1 tasks, just processing : false
knx.0	2022-06-15 13:15:24.129	info	Received CONNECTIONSTATE_RESPONSE : 06 10 02 08 00 08 59 00 192.168.100.64:3671 ChID : 89 SeqCntIN : 14 SeqCntOUT : 141 msgCode : [object Object]
knx.0	2022-06-15 13:15:24.129	info	Send : conCheck Connection State Request : 06 10 02 07 00 10 59 00 08 01 00 00 00 00 9d 01 sent to 192.168.100.64:3671
knx.0	2022-06-15 13:15:24.128	info	checkConnectionState 192.168.100.64 State : true
knx.0	2022-06-15 13:15:17.897	info	BINARY CHANGE change from false to 0
knx.0	2022-06-15 13:15:17.896	info	easy-knx.js groupValueWrite value: 0 dpt : DPT1.001{"type":"Buffer","data":[6,16,4,32,0,21,4,89,141,0,17,0,188,224,17,100,24,3,1,0,128]}
knx.0	2022-06-15 13:15:17.896	info	main.js : tGA.write on Statechange : 3/0/3 P-0AC9-0_GA-52 typeof val: boolean false DPT1.001

das müsste ein Ausschnitt sein wo die Reaktion lange gedauert hat.

chefkoch009

@jojos Zwischen Zeile 18 und 19 liegen 7Sek?..... In Zeile 19 hat er alles soweit vorbereitet zum Senden. Dann passiert nix, deshalb fragt er nach, ob die Verbindung noch besteht und bekommt ein OK zurück und sendet unmittelbar danach.

Die Frage ist nun kann oder will er nicht senden? Tritt das erst nach längerem Betrieb auf, oder direkt beim Start?

VG
chefkoch009

JojoS

@chefkoch009 das passiert auch direkt beim Start. Ist das vielleicht was mit Zusammenspiel mit neuem Admin/Controller?

ich hatte es vorher nochmal mit level silly, da sieht man in der Pause aber auch nichts.

2022-06-15 12:59:58.628 - info: knx.0 (4178186) =====> STATE_TUNNELING_ACK
2022-06-15 12:59:58.629 - info: knx.0 (4178186) ( 4 ) Sending Tunnel_Request ACK : 06 10 04 21 00 0a 04 58 d1 00 ChID : 88 SeqCntIN : 209 SeqCntOUT : 106 queue length : 0
2022-06-15 12:59:58.629 - info: knx.0 (4178186) ( 4.b ) return to STATE_READY, processing : false
2022-06-15 12:59:58.630 - info: knx.0 (4178186) ( 3.2 ) Received TUNNEL_REQUEST (WRITE - send ACK ) : 06 10 04 20 00 17 04 58 d2 00 29 00 bc e0 11 04 30 03 03 00 80 0c 92 ChID: 88
2022-06-15 12:59:58.630 - info: knx.0 (4178186) WRITE : mappedName : Schlafzimmer dest : 6/0/3 val: 23.400000000000002 (DPT9.001) Schlafzimmer
2022-06-15 12:59:58.630 - info: knx.0 (4178186) =====> STATE_TUNNELING_ACK
2022-06-15 12:59:58.630 - info: knx.0 (4178186) ( 4 ) Sending Tunnel_Request ACK : 06 10 04 21 00 0a 04 58 d2 00 ChID : 88 SeqCntIN : 210 SeqCntOUT : 106 queue length : 0
2022-06-15 12:59:58.630 - info: knx.0 (4178186) ( 4.b ) return to STATE_READY, processing : false
2022-06-15 12:59:58.643 - silly: knx.0 (4178186) States user redis pmessage knx.0.*/knx.0.Sensoren.Licht.HelligkeitSchlafzimmer:{"val":511.04,"ack":true,"ts":1655290798641,"q":0,"from":"system.adapter.knx.0","user":"system.user.admin","lc":1655290797661}
2022-06-15 12:59:58.644 - silly: knx.0 (4178186) States user redis pmessage knx.0.*/knx.0.Sensoren.Temperaturen.Schlafzimmer:{"val":23.400000000000002,"ack":true,"ts":1655290798641,"q":0,"from":"system.adapter.knx.0","user":"system.user.admin","lc":1655290078077}
2022-06-15 13:00:00.785 - silly: knx.0 (4178186) States user redis pmessage knx.0.*/knx.0.Dosen_schalten.Schalten.Terasse_Steckdose3_li:{"val":true,"ack":false,"ts":1655290800784,"q":0,"from":"system.adapter.web.0","user":"system.user.admin","lc":1655290800784}
2022-06-15 13:00:00.785 - info: knx.0 (4178186) main.js : tGA.write on Statechange : 3/0/3 P-0AC9-0_GA-52 typeof val: boolean true DPT1.001
2022-06-15 13:00:00.785 - info: knx.0 (4178186) easy-knx.js groupValueWrite value: 1 dpt : DPT1.001{"type":"Buffer","data":[6,16,4,32,0,21,4,88,106,0,17,0,188,224,17,100,24,3,1,0,129]}
2022-06-15 13:00:00.786 - info: knx.0 (4178186) BINARY CHANGE change from true to 1
2022-06-15 13:00:08.631 - info: knx.0 (4178186) checkConnectionState 192.168.100.64 State : true
2022-06-15 13:00:08.632 - info: knx.0 (4178186) Send : conCheck Connection State Request : 06 10 02 07 00 10 58 00 08 01 00 00 00 00 cd e1 sent to 192.168.100.64:3671
2022-06-15 13:00:08.632 - info: knx.0 (4178186) Received CONNECTIONSTATE_RESPONSE : 06 10 02 08 00 08 58 00 192.168.100.64:3671 ChID : 88 SeqCntIN : 210 SeqCntOUT : 106 msgCode : [object Object]
2022-06-15 13:00:08.632 - info: knx.0 (4178186) Has todo still 1 tasks, just processing : false
2022-06-15 13:00:08.632 - info: knx.0 (4178186) ( 1 ) Sending : GroupValueWrite : 06 10 04 20 00 15 04 58 6a 00 11 00 bc e0 11 64 18 03 01 00 81 sent to 192.168.100.64:3671 ChID: 88 SeqCntIN : 210 SeqCntOUT : 106 GA : 3/0/3 conCheck.conected : true
2022-06-15 13:00:08.633 - info: knx.0 (4178186) easy-knx: task.data : 06 10 04 20 00 15 04 58 6a 00 11 00 bc e0 11 64 18 03 01 00 81 byteLen : 21
2022-06-15 13:00:08.633 - info: knx.0 (4178186) ( 2 ) Received TUNNEL_ACK : 06 10 04 21 00 0a 04 58 6a 00 from 192.168.100.64:3671 SeqCntIN : 210 SeqCntOUT : 107 GA : 0/0/0
2022-06-15 13:00:08.633 - info: knx.0 (4178186) ==> successful acknowledged previous package... processing next of 0
2022-06-15 13:00:08.633 - info: knx.0 (4178186) ==> easy-knx.js: signal runtime : 0s 0.917653ms

chefkoch009

@jojos Auf meinem Dev-System und Produktionssystem habe ich den 5er Admin laufen.

Wenn das der einzige Unterschied ist, dann möchte ich einmal in die Runde fragen, ob jemand das bestätigen kann, oder so etwas beobachtet hat.

Hast Du dieses Verhalten auch, wenn Du direkt über den Objektbaum schaltest oder nur über die Visu?

VG
chefkoch009

JojoS

@chefkoch009 Verzögerungen gab es auch bei Logik über Node Red. Beim Schalten über den Objektbaum gibt es die Verzögerung auch.
Den Admin habe ich bis 5.4.8 zurück installiert, die Verzögerung tritt trotzdem nur bei KNX 2.0.15 auf. Reproduzierbar, mehrmals verschiedene Versionen installiert.
Garfonso hat das doch auch beobachtet?

jojo@iobroker-prod:~$ iob info
Platform       : linux
os             : linux
Architecture   : x64
CPUs           : 1
Speed          : 2600 MHz
Model          : Intel(R) Core(TM) i3-10110U CPU @ 2.10GHz
RAM            : 4 GB
System uptime  : 17d. 23:07:09
Node.js        : v14.19.3
time           : 1655378041359
timeOffset     : -120
adapters count : 501
NPM            : v6.14.17
Disk size      : 15.6 GiB
Disk free      : 7.3 GiB
jojo@iobroker-prod:~$ iobroker v
4.0.23

Garfonso

@jojos
ja, hab das mit Admin 5.x und auch Admin 6 beobachtet. Schalten per Javascript, Visu (Lovelace) oder Objektbaum macht keinen Unterschied, kann alles verzögert sein.

chefkoch009

Vielen Dank für eure Mühen. Tritt es nur bei "Schalten" oder auch bei "dimmen Wert" auf?

VG
chefkoch009

schmid_no1

@chefkoch009 kann ich bestätigen mit admin 6.
Verzögerungen geschaltet über die vis kommen bis zu 7 Sekunden später an

Garfonso

@chefkoch009
bei dimmen bin ich mir nicht 100% sicher, ich meine aber auch das schon gesehen zu haben. Sicher gesehen habe ich es schon bei farbtemperatur und bei rolladen position (also 0-100, müsste dann ja der gleiche Datentyp sein) (Rolladenposition ließ sich gerade reproduzieren).

leachim200

Hallo ich verzweifle gerade an der Iobroker-KNX verbindung.
Ich habe in der ETS mein MD Ip Interface 0003 Secure mit der physicalischen Adresse 1.1.1 ausgestattet Tunnel 1-4 liegen dann auf 1.1.2-5
Die physikalische Adresse der verbindung ist 1.0.250. Wenn ich nun 1.1.4 als physikalische Adresse eintrage bekomme ich keine Geräte verbindung zu stande.

Ich hab im Interface bereits auf Set gedrück somit sollte er die Adressen ausgerollt haben. Wo liegt mein Gedanken fehler?

logauszug:
2022-07-12 19:40:52.079 - info: knx.0 (27588) Debuglevel: 2 3
2022-07-12 19:40:52.085 - info: knx.0 (27588) Event : UDP - listening
2022-07-12 19:40:52.092 - info: knx.0 (27588) Connected - local UDP Server listening on xxxxxxxxxxxxxxx:51181
2022-07-12 19:40:52.096 - info: knx.0 (27588) Send : UDP Connection Request : 06 10 02 05 00 1a 08 01 c0 a8 58 fc c7 ed 08 01 00 00 00 00 c7 ed 04 04 02 00 sent to 192.168.88.240:3671
2022-07-12 19:40:52.104 - info: knx.0 (27588) Connection persists.....closing now
2022-07-12 19:40:52.106 - info: knx.0 (27588) ... not able to close connection, because already closed
2022-07-12 19:40:52.108 - info: knx.0 (27588) STATE_NOT_CONNECTED : Try to connect / reconnect : STATE_CONNECTION_STATE_REQUEST(5) to STATE_NOT_CONNECTED(0).
2022-07-12 19:40:54.104 - info: knx.0 (27588) STATE_CONNECTION_STATE_REQUEST : Not acceptable step... disconnecting
2022-07-12 19:40:54.114 - info: knx.0 (27588) ( END ) Sending DISCONNECT_REQUEST : 06 10 02 09 00 10 00 00 08 01 c0 a8 58 fc c7 ed ChID : 0 SeqCntIN : 0 SeqCntOUT : 0 msgCode : [object Object]
2022-07-12 19:40:54.117 - info: knx.0 (27588) STATE_DISCONNECT_REQUEST : no defined handling for transition from State: STATE_CONNECTION_STATE_REQUEST(5) to STATE_DISCONNECT_REQUEST(15).
2022-07-12 19:40:54.118 - info: knx.0 (27588) Connection persists.....closing now

leachim200

So ich bin weiter es dürfte an der physikalischen Adresse liegen.
Wenn ich das Interface auf werkseinstellungen setzte und die physikalische Standart IP nehme funktioniert alles. Sobald ich Secure darüber spiele geht nix mehr.
Wenn ich das ganze Ohne IP-Secure aufspiele funktioniert alles fehlerfrei.
Unterstützt der Adapter IP-Secure?

leachim200

@schmid_no1 Kann ich bestätigen. Ich habe direkt am Objekt Befehle abgesätzt, egal ob Tag/Nach umschaltung oder Rolläden Positionen die Befehle kommen oft bis zu 7 Sekunden später an.

leachim200

Hallo,
ich bin auf ein weiteres Problem gestoßen und wäre echt froh über Hilfe.
Ich versuche einen Text über iobroker an den MDT Glastaster in form eines Statustextes zu senden.

GA ist angelegt und auch im iobroker hinterlegt. Schalten und prozentwerte senden funktioniert aber der Text nicht. Was mache ich falsch?

Hier noch die Screenshots

leachim200

Ich bin einen Schritt weiter. Wenn ich das Ganze am Gruppenmonitor in der ETS durchführe wird der Wert ohne Probleme geschrieben. Daher gehe ich davon aus, dass es am Iobroker liegt. Logfile zeigt bei einer Wertänderung keine Regung das hier etwas gesendet wurde.

Weissnicht

@chefkoch009
Habe diesen Verzögerungseffekt zB auch beim Senden von Datum / Uhrzeit aus ioBroker an KNX. In Version 2.0.13 passiert das nicht.

JojoS

eine neue Version 2.0.16. Soll das delay da behoben sein? Habe langsam keine Lust mehr auf Betatester wenn ich schon so viel Geld für den Adapter bezahle.

mikah111

@jojos Ist bei mir mit der 2.0.16 nicht besser geworden. Bin und bleibe nun wohl auf der 2.0.13

Tobi68

@jojos ich hatte letztes Jahr immer wieder Verzögerungen.
Hatte den IOBroker sogar einmal die Woche neu gestartet, das half zu 90%
Dann musste ich den IOBroker wegen Absturz kpl. neu installieren.

Danach waren die Verzögerungen weg.
Es hatte bei mir teilweise schon mal 30sec. Gedauert bis ne Lampe über die vis geschaltet wurde. War nur bei Knx objekten so, Meross oder Tasmota hatte das Problem nicht.
Erst nach IOBroker neuinstallation und backup aufspielen was das Problem behoben.

NEWS

Test Adapter KNX v2.x

Support us

1.5k
Online

30.4k
Users

76.7k
Topics

1.2m
Posts

NEWS

Test Adapter KNX v2.x

Support us

1.5kOnline

30.4kUsers

76.7kTopics

1.2mPosts

1.5k
Online

30.4k
Users

76.7k
Topics

1.2m
Posts