Starke Verzögerung bei der Steuerung knxd oder VISU?

[z1marco]

Gestern Abend auf den aktuellen Debian Zweig gewechselt, kompiliert und die Probleme sind weg. Läuft nun mit Smarthomeng Image 1.7.1 perfekt. Vielen Dank für den schnellen Fix.

[z1marco]

Sorry wenn ich so oft nachfrage aber ich bin noch sehr unsicher und noch nicht so tief drinnen. Passt der Debian Zweig denn für das Smarthomeng Image 1.7.1?

[Medicusi]

Hallo zusammen,

ich nutze das Smarthomeng Image 1.7.1 mit dem knxd in der version 0.14.30 und beobachte scheinbar das gleiche Problem. Nach dem starten wird der erste Befehl direkt auf den KNX Bus ausgeführt. Die weiteren Befehle kommen nur stark verzögert oder manchmal auch gar nicht im KNX an. Ich hab das direkt mit knxtool groupswrite ausprobiert, um Smartvisu und Smarthomeng auszuschliessen.

Kann es sein, dass bei mir das gleiche Problem existiert? Wie komme ich am einfachsten an den Patch?

Gruß und Danke

Oder du schaust einfach hier:

https://github.com/knxd/knxd/commit/...358a062a2b351d

[Smurf]

oder du schnappst dir den aktuellen debian-Zweig und kompilierst den. Da ist der Fix nämlich drin.

[Msinn]

Der hängt doch am Beitrag #29 dieses Threads.

[z1marco]

Hallo zusammen,

ich nutze das Smarthomeng Image 1.7.1 mit dem knxd in der version 0.14.30 und beobachte scheinbar das gleiche Problem. Nach dem starten wird der erste Befehl direkt auf den KNX Bus ausgeführt. Die weiteren Befehle kommen nur stark verzögert oder manchmal auch gar nicht im KNX an. Ich hab das direkt mit knxtool groupswrite ausprobiert, um Smartvisu und Smarthomeng auszuschliessen.

Kann es sein, dass bei mir das gleiche Problem existiert? Wie komme ich am einfachsten an den Patch?

Gruß und Danke

[Medicusi]

Patch anbei

SUPER! Das hat das Problem anscheinend vollständig gelöst, bisher läuft alles ohne Verzögerung!

VIELEN LIEBEN DANK nochmal Matthias!!

[Medicusi]

Patch anbei

super, wird sofort eingespielt ... und getestet!

[Smurf]

Patch anbei

[Medicusi]

OK, Problem identifiziert, ich schick dir morgen einen neuen Patch.

Super, nur noch einmal schlafen

[Smurf]

OK, Problem identifiziert, ich schick dir morgen einen neuen Patch.

[Medicusi]

leider wieder über 20 Sekunden:

Jun 17 21:29:18 smartHomeNUC knxd[564]: Layer 0 [16:log/C.ip 3963.403] Recv L_Data low from 1.1.200 to 0/4/5 hops: 05 T_Data_Group A_GroupValue_Write 01 5E
Jun 17 21:29:19 smartHomeNUC knxd[564]: Layer 0 [16:log/C.ip 3964.966] Recv L_Data low from 1.1.200 to 0/4/5 hops: 05 T_Data_Group A_GroupValue_Write 02 58
Jun 17 21:29:20 smartHomeNUC knxd[564]: Layer 0 [16:log/C.ip 3965.979] Recv L_Data low from 1.1.200 to 0/4/5 hops: 05 T_Data_Group A_GroupValue_Write 03 8E
Jun 17 21:29:23 smartHomeNUC knxd[564]: Layer 0 [16:log/C.ip 3969.185] Recv L_Data low from 1.1.200 to 0/4/5 hops: 05 T_Data_Group A_GroupValue_Write 02 8A
Jun 17 21:29:28 smartHomeNUC knxd[564]: Layer 0 [16:log/C.ip 3973.996] Recv L_Data low from 1.1.200 to 0/4/5 hops: 05 T_Data_Group A_GroupValue_Write 03 CA
Jun 17 21:29:31 smartHomeNUC knxd[564]: Layer 0 [16:log/C.ip 3977.101] Recv L_Data low from 1.1.200 to 0/4/5 hops: 05 T_Data_Group A_GroupValue_Write 02 E4
Jun 17 21:29:33 smartHomeNUC knxd[564]: Layer 0 [16:log/C.ip 3978.846] Recv L_Data low from 1.1.200 to 0/4/5 hops: 05 T_Data_Group A_GroupValue_Write 02 12
Jun 17 21:29:36 smartHomeNUC knxd[564]: Layer 0 [16:log/C.ip 3981.789] Recv L_Data low from 1.1.200 to 0/4/5 hops: 05 T_Data_Group A_GroupValue_Write 02 A8
Jun 17 21:29:37 smartHomeNUC knxd[564]: Layer 0 [16:log/C.ip 3982.517] Recv L_Data low from 1.1.88 to 0/2/117 hops: 05 T_Data_Group A_GroupValue_Write 0C 15
Jun 17 21:29:38 smartHomeNUC knxd[564]: Layer 0 [14:A.log/C.ip 3984.039] Send L_Data low from 2.1.10 to 4/1/0 hops: 05 T_Data_Group A_GroupValue_Write (small) 01
Jun 17 21:29:38 smartHomeNUC knxd[564]: Layer 0 [16:log/C.ip 3984.039] Send L_Data low from 2.1.10 to 4/1/0 hops: 05 T_Data_Group A_GroupValue_Write (small) 01
Jun 17 21:29:38 smartHomeNUC knxd[564]: Layer 6 [16:log/C.ip 3984.039] send next
Jun 17 21:29:38 smartHomeNUC knxd[564]: Layer 2 [15:B.pace/C.ip 3984.039] out 1/2: delay for 0.052 sec
Jun 17 21:29:38 smartHomeNUC knxd[564]: Layer 0 [16:log/C.ip 3984.090] Recv L_Data low from 1.1.5 to 4/1/4 hops: 05 T_Data_Group A_GroupValue_Write 06 00
[MARKIEREN]Jun 17 21:29:38 smartHomeNUC knxd[564]: Layer 2 [15:B.pace/C.ip 3984.091] in 651/4 0.050000/0.001000/0.750000: delay more, for 24.416 sec[/MARKIEREN]
Jun 17 21:29:39 smartHomeNUC knxd[564]: Layer 0 [16:log/C.ip 3984.715] Recv L_Data low from 1.1.6 to 4/7/5 hops: 05 T_Data_Group A_GroupValue_Write 00 20
Jun 17 21:29:39 smartHomeNUC knxd[564]: Layer 0 [16:log/C.ip 3984.738] Recv L_Data low from 1.1.6 to 4/7/25 hops: 05 T_Data_Group A_GroupValue_Write 00 20
Jun 17 21:29:40 smartHomeNUC knxd[564]: Layer 0 [16:log/C.ip 3985.914] Recv L_Data low from 1.1.200 to 0/4/4 hops: 05 T_Data_Group A_GroupValue_Write 0C 01
Jun 17 21:29:42 smartHomeNUC knxd[564]: Layer 0 [16:log/C.ip 3988.242] Recv L_Data low from 1.1.10 to 3/1/3 hops: 05 T_Data_Group A_GroupValue_Write 0C 97
Jun 17 21:29:42 smartHomeNUC knxd[564]: Layer 0 [16:log/C.ip 3988.279] Recv L_Data low from 1.1.10 to 3/1/43 hops: 05 T_Data_Group A_GroupValue_Write 0C 4C
Jun 17 21:29:43 smartHomeNUC knxd[564]: Layer 0 [16:log/C.ip 3989.241] Recv L_Data low from 1.1.10 to 3/1/23 hops: 05 T_Data_Group A_GroupValue_Write 07 D0
Jun 17 21:29:44 smartHomeNUC knxd[564]: Layer 0 [16:log/C.ip 3990.241] Recv L_Data low from 1.1.10 to 3/1/63 hops: 05 T_Data_Group A_GroupValue_Write 0C 65
Jun 17 21:29:47 smartHomeNUC knxd[564]: Layer 0 [16:log/C.ip 3992.881] Recv L_Data low from 1.1.200 to 0/4/5 hops: 05 T_Data_Group A_GroupValue_Write 02 08
Jun 17 21:29:48 smartHomeNUC knxd[564]: Layer 0 [16:log/C.ip 3994.192] Recv L_Data low from 1.1.200 to 0/4/5 hops: 05 T_Data_Group A_GroupValue_Write 02 C6
Jun 17 21:29:53 smartHomeNUC knxd[564]: Layer 0 [16:log/C.ip 3998.984] Recv L_Data low from 1.1.200 to 0/4/5 hops: 05 T_Data_Group A_GroupValue_Write 02 08
Jun 17 21:29:56 smartHomeNUC knxd[564]: Layer 0 [16:log/C.ip 4001.890] Recv L_Data low from 1.1.200 to 0/4/5 hops: 05 T_Data_Group A_GroupValue_Write 01 4A
Jun 17 21:29:58 smartHomeNUC knxd[564]: Layer 0 [16:log/C.ip 4003.915] Recv L_Data low from 1.1.200 to 0/4/5 hops: 05 T_Data_Group A_GroupValue_Write 01 E0
Jun 17 21:30:00 smartHomeNUC knxd[564]: Layer 0 [16:log/C.ip 4005.433] Recv L_Data low from 1.1.200 to 0/4/5 hops: 05 T_Data_Group A_GroupValue_Write 02 62
Jun 17 21:30:01 smartHomeNUC knxd[564]: Layer 0 [16:log/C.ip 4006.469] Recv L_Data low from 1.1.200 to 0/4/5 hops: 05 T_Data_Group A_GroupValue_Write 03 5C
Jun 17 21:30:03 smartHomeNUC knxd[564]: Layer 2 [15:B.pace/C.ip 4008.509] in 14/4 0.050000/0.001000/0.750000: delay more, for 0.528 sec
Jun 17 21:30:03 smartHomeNUC knxd[564]: Layer 0 [16:log/C.ip 4008.576] Recv L_Data low from 1.1.60 to 0/2/15 hops: 05 T_Data_Group A_GroupValue_Write 0C 88
Jun 17 21:30:03 smartHomeNUC knxd[564]: Layer 2 [15:B.pace/C.ip 4009.037] in 1/4 0.050000/0.001000/0.750000: delay more, for 0.041 sec
Jun 17 21:30:03 smartHomeNUC knxd[564]: Layer 2 [15:B.pace/C.ip 4009.078] delay done
Jun 17 21:30:03 smartHomeNUC knxd[564]: Layer 6 [14:A.log/C.ip 4009.078] send next
Jun 17 21:30:03 smartHomeNUC knxd[564]: Layer 0 [14:A.log/C.ip 4009.078] Send L_Data low from 2.1.10 to 4/1/20 hops: 05 T_Data_Group A_GroupValue_Write (small) 01
Jun 17 21:30:03 smartHomeNUC knxd[564]: Layer 0 [16:log/C.ip 4009.078] Send L_Data low from 2.1.10 to 4/1/20 hops: 05 T_Data_Group A_GroupValue_Write (small) 01
Jun 17 21:30:03 smartHomeNUC knxd[564]: Layer 6 [16:log/C.ip 4009.078] send next

[Medicusi]

wir sind viel besser geworden aber noch bei 4 Sekunden

Jun 17 20:10:44 smartHomeNUC knxd[14371]: Layer 0 [16:log/C.ip 697.055] Recv L_Data low from 1.1.84 to 3/1/40 hops: 05 T_Data_Group A_GroupValue_Write 0D 41
Jun 17 20:10:49 smartHomeNUC knxd[14371]: Layer 0 [16:log/C.ip 702.148] Recv L_Data low from 1.1.63 to 3/0/100 hops: 05 T_Data_Group A_GroupValue_Write 0C 1A
Jun 17 20:10:50 smartHomeNUC knxd[14371]: Layer 0 [16:log/C.ip 702.952] Recv L_Data low from 1.1.76 to 3/1/60 hops: 05 T_Data_Group A_GroupValue_Write 0D 4B
Jun 17 20:10:51 smartHomeNUC knxd[14371]: Layer 0 [16:log/C.ip 703.876] Recv L_Data low from 1.1.83 to 5/1/0 hops: 05 T_Data_Group A_GroupValue_Write 0D 64
Jun 17 20:11:02 smartHomeNUC knxd[14371]: Layer 0 [16:log/C.ip 714.371] Recv L_Data low from 1.1.200 to 0/4/5 hops: 05 T_Data_Group A_GroupValue_Write 00 82
Jun 17 20:11:03 smartHomeNUC knxd[14371]: Layer 0 [16:log/C.ip 715.923] Recv L_Data low from 1.1.84 to 3/1/40 hops: 05 T_Data_Group A_GroupValue_Write 0D 3C
Jun 17 20:11:05 smartHomeNUC knxd[14371]: Layer 0 [16:log/C.ip 718.041] Recv L_Data low from 1.1.200 to 0/4/5 hops: 05 T_Data_Group A_GroupValue_Write 00 00
Jun 17 20:11:12 smartHomeNUC knxd[14371]: Layer 0 [14:A.log/C.ip 724.893] Send L_Data low from 2.1.10 to 2/0/163 hops: 05 T_Data_Group A_GroupValue_Write FF
Jun 17 20:11:12 smartHomeNUC knxd[14371]: Layer 0 [16:log/C.ip 724.893] Send L_Data low from 2.1.10 to 2/0/163 hops: 05 T_Data_Group A_GroupValue_Write FF
Jun 17 20:11:12 smartHomeNUC knxd[14371]: Layer 6 [16:log/C.ip 724.893] send next
Jun 17 20:11:12 smartHomeNUC knxd[14371]: Layer 2 [15:B.pace/C.ip 724.893] out 1/3: delay for 0.053 sec
[MARKIEREN]Jun 17 20:11:12 smartHomeNUC knxd[14371]: Layer 2 [15:B.pace/C.ip 724.946] in 114/4 0.050000/0.001000/0.750000: delay more, for 4.278 sec[/MARKIEREN]
Jun 17 20:11:12 smartHomeNUC knxd[14371]: Layer 0 [16:log/C.ip 725.193] Recv L_Data low from 1.1.3 to 2/0/161 hops: 05 T_Data_Group A_GroupValue_Write (small) 01
Jun 17 20:11:13 smartHomeNUC knxd[14371]: Layer 0 [16:log/C.ip 725.338] Recv L_Data low from 1.1.3 to 2/0/164 hops: 05 T_Data_Group A_GroupValue_Write FF
Jun 17 20:11:15 smartHomeNUC knxd[14371]: Layer 0 [16:log/C.ip 727.770] Recv L_Data low from 1.1.50 to 3/0/0 hops: 05 T_Data_Group A_GroupValue_Write 0C AB
Jun 17 20:11:16 smartHomeNUC knxd[14371]: Layer 2 [15:B.pace/C.ip 729.226] in 3/4 0.050000/0.001000/0.750000: delay more, for 0.116 sec
Jun 17 20:11:17 smartHomeNUC knxd[14371]: Layer 2 [15:B.pace/C.ip 729.341] delay done
Jun 17 20:11:17 smartHomeNUC knxd[14371]: Layer 6 [14:A.log/C.ip 729.342] send next
Jun 17 20:11:17 smartHomeNUC knxd[14371]: Layer 0 [14:A.log/C.ip 729.342] Send L_Data low from 2.1.10 to 4/1/0 hops: 05 T_Data_Group A_GroupValue_Write (small) 01
Jun 17 20:11:17 smartHomeNUC knxd[14371]: Layer 0 [16:log/C.ip 729.342] Send L_Data low from 2.1.10 to 4/1/0 hops: 05 T_Data_Group A_GroupValue_Write (small) 01
Jun 17 20:11:17 smartHomeNUC knxd[14371]: Layer 6 [16:log/C.ip 729.342] send next
Jun 17 20:11:17 smartHomeNUC knxd[14371]: Layer 2 [15:B.pace/C.ip 729.342] out 1/2: delay for 0.052 sec
Jun 17 20:11:17 smartHomeNUC knxd[14371]: Layer 2 [15:B.pace/C.ip 729.394] delay done

[Smurf]

OK, dann bau mal die zitierte Änderung ein und teste weiter.

[Medicusi]

OK. Jetzt mach bitte mal das -t1023 weg, damit das restliche Geplapper fehlt, und gibt mir ein bisschen mehr. Das sieht nämlich so aus als hättest du zwar initial einen dicken Delay, weil zwei Variablen nicht initialisiert sind, aber sobald der vorbei ist (also hier nach 10sec) sollte eigentlich alles funktionieren … oder?

diff --git a/src/backend/fpace.cpp b/src/backend/fpace.cpp
index ce2c5f9..1e00038 100644
--- a/src/backend/fpace.cpp
+++ b/src/backend/fpace.cpp
@@ -21,6 +21,9 @@

PaceFilter::PaceFilter (const LinkConnectPtr_& c, IniSectionPtr& s) : Filter(c,s)
{
+ last_len=0;
+ nr_in = 0;
+ size_in = 0;
timer.set<PaceFilter, &PaceFilter::timer_cb>(this);
state = P_DOWN;
}

… meine Begeisterung über einen Compiler, der sowas popeliges wie nicht initialisierte Instanzvariablen nicht findet, hält sich echt in Grenzen …

Du hast vollkommen recht ... es gibt nach dem Zweiten Befehl einen Delay (hier 10 sec, sonst über 20sec) danach läuft es wieder einwandfrei ... solange ich immer regelmäßig Befehle sende oder den knxd neustarte ... sobald ich eine "Pause" > 15 min mache tritt der Fehler auf!