[wiregate] - √ - eibd stürzt ständig ab...

[Fry]

Hallo zusammen,
hier mal wieder ein Rätsel. Da mein eibd ständig abstürzte und mein Eindruck war, das könnte mit dem Traffic der CometVisu zusammenhängen, hab ich mich sogar in Unkosten gestürzt und ein USB-TP-UART gekauft. Ergebnis ist wie vor:

root@wiregate581:~# tail -n100 /var/log/messages  
...
Oct 10 22:51:53 wiregate581 /usr/sbin/wiregated.pl: INFO - connected to eibd local:/tmp/eib
Oct 10 22:52:44 wiregate581 /usr/sbin/wiregated.pl: INFO - eibd connection lost - retrying
Oct 10 22:54:23 wiregate581 /usr/sbin/wiregated.pl: INFO - *** reading config
Oct 10 22:54:25 wiregate581 /usr/sbin/wiregated.pl: INFO - connected to eibd local:/tmp/eib
Oct 10 22:55:16 wiregate581 /usr/sbin/wiregated.pl: INFO - eibd connection lost - retrying
Oct 10 22:56:55 wiregate581 /usr/sbin/wiregated.pl: INFO - *** reading config
Oct 10 22:56:57 wiregate581 /usr/sbin/wiregated.pl: INFO - connected to eibd local:/tmp/eib
Oct 10 22:57:49 wiregate581 /usr/sbin/wiregated.pl: INFO - eibd connection lost - retrying
Oct 10 22:59:29 wiregate581 /usr/sbin/wiregated.pl: INFO - *** reading config
Oct 10 23:00:58 wiregate581 /usr/sbin/wiregated.pl: INFO - *** reading config
Oct 10 23:00:59 wiregate581 /usr/sbin/wiregated.pl: INFO - connected to eibd local:/tmp/eib
Oct 10 23:01:52 wiregate581 /usr/sbin/wiregated.pl: INFO - eibd connection lost - retrying
Oct 10 23:03:30 wiregate581 /usr/sbin/wiregated.pl: INFO - *** reading config
Oct 10 23:03:31 wiregate581 /usr/sbin/wiregated.pl: INFO - connected to eibd local:/tmp/eib
Oct 10 23:04:24 wiregate581 /usr/sbin/wiregated.pl: INFO - eibd connection lost - retrying
Oct 10 23:04:29 wiregate581 /usr/sbin/wiregated.pl: INFO - connected to eibd local:/tmp/eib
Oct 10 23:09:32 wiregate581 /usr/sbin/wiregated.pl: INFO - *** reading config
Oct 10 23:09:34 wiregate581 /usr/sbin/wiregated.pl: INFO - connected to eibd local:/tmp/eib
Oct 11 06:26:51 wiregate581 syslog-ng[2305]: Configuration reload request received, reloading configuration;
Oct 11 09:31:29 wiregate581 /usr/sbin/wiregated.pl: INFO - *** reading config
Oct 11 09:31:30 wiregate581 /usr/sbin/wiregated.pl: INFO - connected to eibd local:/tmp/eib
Oct 11 09:32:24 wiregate581 /usr/sbin/wiregated.pl: INFO - eibd connection lost - retrying
Oct 11 09:32:29 wiregate581 /usr/sbin/wiregated.pl: INFO - connected to eibd local:/tmp/eib
Oct 11 09:40:00 wiregate581 /usr/sbin/wiregated.pl: INFO - eibd connection lost - retrying
Oct 11 09:40:05 wiregate581 /usr/sbin/wiregated.pl: INFO - connected to eibd local:/tmp/eib
Oct 11 09:40:57 wiregate581 /usr/sbin/wiregated.pl: INFO - eibd connection lost - retrying
Oct 11 09:41:02 wiregate581 /usr/sbin/wiregated.pl: INFO - connected to eibd local:/tmp/eib
Oct 11 09:50:18 wiregate581 /usr/sbin/wiregated.pl: INFO - eibd connection lost - retrying

Interessanterweise ist auf dem Bus kaum was los, ich kopiere hier mal einen Ausschnitt aus einer "busy"-Phase:

(PA 1.1.14 ist die Wetterstation, 1.1.101 ist das Wiregate-TP-UART)

root@wiregate581:~# tail -n1000 /var/log/eib.log
....
2012-10-11 09:46:00.268,A_GroupValue_Write,1.1.14,5/4/252,3C A1,1516.8,,9.004,0,low,6,T_DATA_XXX_REQ,0
2012-10-11 09:46:00.340,A_GroupValue_Write,1.1.14,5/4/253,3F 11,2315.52,,9.004,0,low,6,T_DATA_XXX_REQ,0
2012-10-11 09:46:00.455,A_GroupValue_Write,1.1.14,5/4/254,46 F9,4569.6,,9.004,0,low,6,T_DATA_XXX_REQ,0
2012-10-11 09:46:00.514,A_GroupValue_Write,1.1.14,4/5/250,03 77,3,,1.002,0,low,6,T_DATA_XXX_REQ,0
2012-10-11 09:46:00.575,A_GroupValue_Write,1.1.14,4/5/252,05 B7,5,,1.002,0,low,6,T_DATA_XXX_REQ,0
2012-10-11 09:46:00.640,A_GroupValue_Write,1.1.14,4/5/253,07 73,7,,1.002,0,low,6,T_DATA_XXX_REQ,0
2012-10-11 09:46:00.716,A_GroupValue_Write,1.1.14,4/5/254,15 B0,15,,1.002,0,low,6,T_DATA_XXX_REQ,0
2012-10-11 09:46:00.765,A_GroupValue_Read,1.1.101,6/5/2,00,0,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:01.622,A_GroupValue_Read,1.1.101,6/5/2,00,0,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:02.282,A_GroupValue_Response,1.1.64,6/5/2,01,1,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:03.180,A_GroupValue_Read,1.1.101,6/5/2,00,0,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:03.841,A_GroupValue_Response,1.1.64,6/5/2,01,1,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:04.643,A_GroupValue_Read,1.1.101,6/5/2,00,0,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:05.265,A_GroupValue_Response,1.1.64,6/5/2,01,1,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:05.889,A_GroupValue_Read,1.1.101,6/5/13,00,0,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:06.673,A_GroupValue_Response,1.1.64,6/5/2,01,1,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:07.428,A_GroupValue_Response,1.1.68,6/5/13,01,1,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:08.002,A_GroupValue_Read,1.1.101,6/5/13,00,0,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:08.993,A_GroupValue_Response,1.1.68,6/5/13,01,1,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:09.591,A_GroupValue_Read,1.1.101,6/5/13,00,0,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:10.398,A_GroupValue_Response,1.1.68,6/5/13,01,1,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:10.924,A_GroupValue_Read,1.1.101,6/5/13,00,0,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:11.745,A_GroupValue_Response,1.1.68,6/5/13,01,1,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:12.332,A_GroupValue_Read,1.1.101,6/5/27,00,0,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:13.022,A_GroupValue_Response,1.1.70,6/5/27,01,1,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:13.710,A_GroupValue_Read,1.1.101,6/5/27,00,0,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:14.436,A_GroupValue_Response,1.1.70,6/5/27,01,1,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:14.957,A_GroupValue_Read,1.1.101,6/5/27,00,0,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:15.361,A_GroupValue_Response,1.1.70,6/5/27,01,1,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:15.743,A_GroupValue_Read,1.1.101,6/5/27,00,0,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:16.101,A_GroupValue_Response,1.1.70,6/5/27,01,1,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:16.566,A_GroupValue_Read,1.1.101,6/5/28,00,0,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:16.937,A_GroupValue_Response,1.1.98,6/5/28,01,1,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:17.305,A_GroupValue_Read,1.1.101,6/5/28,00,0,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:17.713,A_GroupValue_Response,1.1.98,6/5/28,01,1,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:18.035,A_GroupValue_Read,1.1.101,6/5/28,00,0,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:18.593,A_GroupValue_Response,1.1.98,6/5/28,01,1,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:19.128,A_GroupValue_Read,1.1.101,6/5/28,00,0,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:19.526,A_GroupValue_Response,1.1.98,6/5/28,01,1,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:19.840,A_GroupValue_Read,1.1.101,6/5/34,00,0,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:20.546,A_GroupValue_Response,1.1.69,6/5/34,01,1,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:20.899,A_GroupValue_Read,1.1.101,6/5/34,00,0,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:21.250,A_GroupValue_Response,1.1.69,6/5/34,01,1,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:21.631,A_GroupValue_Read,1.1.101,6/5/34,00,0,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:22.109,A_GroupValue_Response,1.1.69,6/5/34,01,1,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:22.732,A_GroupValue_Read,1.1.101,6/5/34,00,0,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:23.082,A_GroupValue_Response,1.1.69,6/5/34,01,1,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:23.381,A_GroupValue_Read,1.1.101,6/5/53,00,0,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:23.977,A_GroupValue_Response,1.1.73,6/5/53,01,1,,1.009,0,low,7,T_DATA_XXX_REQ,0
2012-10-11 09:46:24.546,A_GroupValue_Read,1.1.101,6/5/53,00,0,,1.009,0,low,7,T_DATA_XXX_REQ,0
2

Auffallend ist, dass das WG fast jedes Read-Telegramm dreimal raussendet, selbst wenn zwischendurch eine Antwort kommt.

Irgendwelche Ideen?

EDIT: Ach ja, ein Hinweis noch: die Uhrzeiten der eibd-Abstürze sind etwa die Uhrzeiten, zu denen mein Laptop lief. Auf dem Laptop ist die CometVisu-Seite geöffnet, auf der viele Sensorwerte im Überblick gezeigt werden sollten (sind aber alle leer, selbst die, die im Log oben bereits beantwortet wurden).

VG, Fry

[makki]

Sehr suspekt..
Mach mir doch mal bitte das Wartungs-VPN an

Makki

[Fry]

Ampel steht auf Grün!
VG, Fry

[Fry]

Aktuell scheint das Problem nicht weiter zu bestehen.
Aber den Status hatte ich bereits mehrmals...
Fry

[Fechter65]

Ich hatte einmal ein vergleichbares Problem. Es rührte daher, dass ich in der CometVisu eine grosse Zahl von Grafiken eingebaut hatte. Dies erhöhte den Load des Wiregates massiv und führte u.a. auch dazu, dass die eibd-Verbindungen verloren gingen.

Indem ich die Grafiken in der CV durch Links ersetzte, konnte ich das Problem beseitigen. Dabei verwendete ich den nachfolgenden Code:

<text>&lt;a href=                
"/graph.pl?--start=-96h;--end=now;-X=0;-W=WireGate;--slope-mode;-h=450;-w=650;--full-size-mode;--vertical-label=%B0%20Celsius%20/%20Prozent;--title=Wohnen;-c=BACK%23000000;-c=CANVAS%23000000;-c=SHADEA%23000000;-c=SHADEB%23000000;-c=GRID%23960000;-c=MGRID%236B4F42;-c=FONT%23FFFFFF;-c=AXIS%23000000;-c=FRAME%23000000;-c=ARROW%23000080;DEF:ds0=28.E19F1B030000_temp.rrd:value:AVERAGE;LINE1:ds0%23FF0000:Temp;VDEF:ds0_LAST=ds0,LAST;GPRINT:ds0_LAST:%8.2lf%20%B0C;VDEF:ds0_MIN=ds0,MINIMUM;GPRINT:ds0_MIN:Min\:%8.2lf%20%B0C;VDEF:ds0_AVERAGE=ds0,AVERAGE;GPRINT:ds0_AVERAGE:Mittel\:%8.2lf%20%B0C;VDEF:ds0_MAX=ds0,MAXIMUM;GPRINT:ds0_MAX:Max\:%8.2lf%20%B0C\n;TEXTALIGN:right;DEF:ds1=26.D8A52E010000_hum.rrd:value:AVERAGE;LINE1:ds1%230000FF:Feuchte;VDEF:ds1_LAST=ds1,LAST;GPRINT:ds1_LAST:%8.2lf%20%B0C;VDEF:ds1_MIN=ds1,MINIMUM;GPRINT:ds1_MIN:Min\:%8.2lf%20%B0C;VDEF:ds1_AVERAGE=ds1,AVERAGE;GPRINT:ds1_AVERAGE:Mittel\:%8.2lf%20%B0C;VDEF:ds1_MAX=ds1,MAXIMUM;GPRINT:ds1_MAX:Max\:%8.2lf%20%B0C\n;DEF:ds2=40-Wohnen_StellW.rrd:value:AVERAGE;LINE1:ds2%2300FF00:Stellwert;VDEF:ds2_LAST=ds2,LAST;GPRINT:ds2_LAST:%8.2lf%20Pro;VDEF:ds2_MIN=ds2,MINIMUM;GPRINT:ds2_MIN:Min\:%8.2lf%20Pro;VDEF:ds2_AVERAGE=ds2,AVERAGE;GPRINT:ds2_AVERAGE:Mittel\:%8.2lf%20Pro;VDEF:ds2_MAX=ds2,MAXIMUM;GPRINT:ds2_MAX:Max\:%8.2lf%20Pro\n;DEF:ds4=40-Wohnen_SollW.rrd:value:AVERAGE;LINE1:ds4%23FFFF00:Sollwert;VDEF:ds4_LAST=ds4,LAST;GPRINT:ds4_LAST:%8.2lf%20%B0C;VDEF:ds4_MIN=ds4,MINIMUM;GPRINT:ds4_MIN:Min\:%8.2lf%20%B0C;VDEF:ds4_AVERAGE=ds4,AVERAGE;GPRINT:ds4_AVERAGE:Mittel\:%8.2lf%20%B0C;VDEF:ds4_MAX=ds4,MAXIMUM;GPRINT:ds4_MAX:Max\:%8.2lf%20%B0C\n;" 
target="_blank" &gt;Diagramm&lt;/a&gt;</text>

Gruss
Diego

[JNK]

Passt vielleicht auch dazu, ist allerdings andere Richtung (nicht Lese-Telegramme).
Ich habe gestern zufällig beobachtet als ich den knxdmxd debugged habe, dass das Schreib-Telegramm des knxdmxd auch repeated wird, weil es wohl nicht selbst geACKed wird.
Ausser der Visu und in Logiken verwende ich die Rückmeldungen aber nicht, ein anderes Gerät ACKed das also garantiert nicht. Linienkoppler gibt es nicht. Ich dachte eigentlich, durch das tpuarts-ack-all würde der eibd alles mit ACK versehen....

Gruss,

der Jan

Edit: VPN ist offen, GA war 12/1/*, gestern, WG 371.
Edit2: Es läuft aber alles stabil, ich habe keine Probleme mit irgendwas, Programmieren geht, PA setzen geht und der eibd kachelt auch nicht ab.

[makki]

Nene, da hat nen Grund, ich war heut mittag schon drauf
da hat das monitoring zugeschlagen, werde da wohl nochmal an den Detailschrauben drehen müssen.

Auslöser waren Lesetelegramme von der Visu auf ziemlich viele GA's (habs nicht gezählt, schätze 100-150) die jedoch nicht lesbar/vorhanden sind.
Dann stieg die loadavg vom eibd und der monit meinte den Stecker ziehen zu müssen - sprich den eibd restartet; dann Cache leer -> ging dasselbe Spiel von vorne los..
Sollte natürlich nicht passieren, nicht lesbare GA's in der Visu aber auch nicht, weil das bremst bei leerem Cache nach start ungemein..

Makki

[Fry]

Danke fürs Nachsehen Makki!

Naja, das sind so Dinge, die passieren eben beim Errichten eines neuen Systems...

Die GAs werden in der Literatur ja gerne mit elektronischen Kabeln verglichen, und genau wie die physischen Kabel liegen die eben erstmal rum oder werden an einer Seite angeschlossen, bevor die andere dran ist.

VG, Fry

[Fry]

Nene, da hat nen Grund, ich war heut mittag schon drauf
da hat das monitoring zugeschlagen, werde da wohl nochmal an den Detailschrauben drehen müssen.

Welche Schrauben sind das denn? Ich würde das gerne für die Test- und Aufbauphase mal etwas anpassen...

Fry

[makki]

Die loadavg vom eibd. das kommt wieder aus den Checks in /etc/monit/enable/eibd raus..
Bitte daran nichts selber drehen..

Makki