Solar-Logger bicht ab

[Ralf B.]

Hallo,

Mein Solar-Logger läuft seit einem halben Jahr auf meinem Eisfair-Server.
Nach dem letzten Neustart (wegen Kernelupdate) bricht der Solar-Logger immer nach kurzer Zeit ab!

eSERVER # bash /etc/init.d/solar-logger start
start Solar-Logger
/etc/init.d/solar-logger: line 62: 25567 Segmentation fault      ./Solar-Logger >/dev/null
eSERVER #

Ich habe auch eine Logdatei, wo ich keinen Fehler sehe. Sie endet aber immer mit der gleichen Meldung:

<16.06.2009 19:47:00> 'GetAdressteil' gestartet. DPAdresse = 'Wert'
<16.06.2009 19:47:00> 'GetAdressteil' *AnzahlZeichen = 4
<16.06.2009 19:47:00> 'GetAdressteil' Adresse = 'Wert'
<16.06.2009 19:47:00> 'GetAdressteil' gestartet. DPAdresse = 'E-Heute.Einheit'
<16.06.2009 19:47:00> 'GetAdressteil' *AnzahlZeichen = 7
<16.06.2009 19:47:00> 'GetAdressteil' Adresse = 'E-Heute'
<16.06.2009 19:47:00> 'GetWertSMAKanal' Adresse 'E-Heute.xxx' wurde gefunden.
<16.06.2009 19:47:00> 'GetAdressteil' gestartet. DPAdresse = 'Einheit'
<16.06.2009 19:47:00> 'GetAdressteil' *AnzahlZeichen = 7
<16.06.2009 19:47:00> 'GetAdressteil' Adresse = 'Einheit'
<16.06.2009 19:47:00> 'GetAdressteil' gestartet. DPAdresse = 'E-Heute.Wert'
<16.06.2009 19:47:00> 'GetAdressteil' *AnzahlZeichen = 7
<16.06.2009 19:47:00> 'GetAdressteil' Adresse = 'E-Heute'
<16.06.2009 19:47:00> 'GetWertSMAKanal' Adresse 'E-Heute.xxx' wurde gefunden.
<16.06.2009 19:47:00> 'GetAdressteil' gestartet. DPAdresse = 'Wert'
<16.06.2009 19:47:00> 'GetAdressteil' *AnzahlZeichen = 4
<16.06.2009 19:47:00> 'GetAdressteil' Adresse = 'Wert'
<16.06.2009 19:47:00> 'GetWertSMA' Kanalabfrage erfolgreich.
<16.06.2009 19:47:00> 'GetWertSMA' Summe bilden.
<16.06.2009 19:47:00> 'FormatWert' gestartet. Format = '%.0f'
<16.06.2009 19:47:00> 'FormatWert' gestartet. xFormat = ''
<16.06.2009 19:47:00> 'FormatWert' gestartet. xFormat = '%.0f'
<16.06.2009 19:47:00> 'FormatWert' Type 'ZahlSave' angegeben.
<16.06.2009 19:47:00> 'FormatWert' xFormat = '%.0f'
<16.06.2009 19:47:00> 'GetWert' Adresse einer Kopplung wurde gefunden.

Viele Grüße

Ralf

[Klaus D.]

Hallo Ralf,

welche Logger Version nutzt du?
Hast du den Logger und die Anderen LIB's neu übertsetzt nach den KernelUpdate?


mfg


Klaus D.

[vigeland]

Hi,

das kenne ich, es gibt den ein oder andern Logeintrag in dem die Parameter nicht stimmen.
Es wird beim Fehler Loggen abgestürzt sein.

starte mal mit gdb

gdb Solar-Logger
r
und wenn der sich weghängt
bt
dann kann st man den Trace anhängen, wenn es irgendwas mit ...print.. ist es das Problem.

Gruß
Vigeland

[Ralf B.]

Hallo,

ich verwende die Version 0.3.0
Da ich einen Eisfair-Server habe, kann ich den Logger nicht mit "make..." neu übersetzen. Aber auch mit dem "alten" Kernel bekomme ich den gleichen Fehler.  Vor dem Neustart hatte ich immer folgende Fehlermeldung:

<14.06.2009 05:15:08> Es ist ein Fehler beim Lesen von Format 10 aufgetreten.
<14.06.2009 05:15:08> Es ist ein Fehler beim Lesen von Format 10 aufgetreten.
<14.06.2009 05:20:08> Es ist ein Fehler beim Lesen von Format 10 aufgetreten.
<14.06.2009 05:25:08> Es ist ein Fehler beim Lesen von Format 10 aufgetreten.
<14.06.2009 05:30:08> Es ist ein Fehler beim Lesen von Format 10 aufgetreten.
<14.06.2009 05:35:07> Es ist ein Fehler beim Lesen von Format 10 aufgetreten.
<14.06.2009 05:40:08> Es ist ein Fehler beim Lesen von Format 10 aufgetreten.
<14.06.2009 05:45:08> Es ist ein Fehler beim Lesen von Format 10 aufgetreten.
<14.06.2009 05:50:08> Es ist ein Fehler beim Lesen von Format 10 aufgetreten.
<14.06.2009 05:55:07> Es ist ein Fehler beim Lesen von Format 10 aufgetreten.
<14.06.2009 06:00:08> Es ist ein Fehler beim Lesen von Format 10 aufgetreten.

Da der Logger aber ohne Probleme gearbeitet hat, habe ich die Meldung nicht weiter beachtet.

@ vigeland
"gdb Solar-Logger" führt zur Fehlermeldung:
bash: gdb: command not found


Vielen Dank für die schnellen Antworten

Ralf

[vigeland]

hi,

du hast kein debugger installiert. Für Eis-Fair kann ich leider keine Version bauen.

Schraub das Logging mal hoch. Debug.ini.

DebugPTAlle
DebugLVAlles

Ev. kannst du dann sehen wo er hängt.

Dann mal den letzten Logeintrag schicken.

ev. kann was sehen.

Welcher Version verwendest du 2x oder 3x. ?

Gruß
Vigeland.

[vigeland]

hi,

nochwas
Kommt der Fehler "Es ist ein Fehler beim Lesen von Format" beim Js Log für javascript verlierst du bei jedem Eintrag ein File Handle.
fclose () wird nicht ausgeführt. Das wird früher oder später auch zum crash führen.

ich musste mal alles im tmp Verzeichniss löschen, sonst ist er immer abgestürzt. Rausbekommen warum habe ich nicht.
Am besten vorher sichern, dort werden Statistik Daten gespeichert.

Gruß
Vigeland

[Klaus D.]

hi,

nochwas
Kommt der Fehler "Es ist ein Fehler beim Lesen von Format" beim Js Log für javascript verlierst du bei jedem Eintrag ein File Handle.
fclose () wird nicht ausgeführt. Das wird früher oder später auch zum crash führen.

ich musste mal alles im tmp Verzeichniss löschen, sonst ist er immer abgestürzt. Rausbekommen warum habe ich nicht.
Am besten vorher sichern, dort werden Statistik Daten gespeichert.

Gruß
Vigeland

Hallo Vigeland,

Dieser Fehler war mir noch nicht bekannt.
Danke für das finden des Fehlers.

Zur Behebung muss man an etlichen Stellen immer
vor einem

return -1;

noch die Zeile

if (Datei) fclose(Datei);

einfügen.
Und dieses in xxxLog.c und xxxStatus.c Dateien in den Funktionen wo die Dateien erstellt werden.



mfg


Klaus D.

[Ralf B.]

Hallo Vigeland,

ich habe das tpm-Verzeichniss gelösch und die Debug-Funktionen eingeschaltet.

Der Solar-Logger bricht immer an der gleichen Stelle ab.


<20.06.2009 16:11:05> 'GetWertSMAKanalWert' Kanal->Handle = 104
<20.06.2009 16:11:05> 'GetWertSMAKanalWert' Kanal->dWert = 1.083000
<20.06.2009 16:11:05> 'GetWertSMAKanalWert' Kanal->cWert = '1.08'
<20.06.2009 16:11:05> 'GetWertSMAKanalWert' sizeof(Kanal->cWert) = 40
<20.06.2009 16:11:05> 'GetWertSMAKanalWert' dWertTemp = 18225.566866
<20.06.2009 16:11:05> 'GetWertSMAKanalWert' cWertTemp = ''
<20.06.2009 16:11:05> 'GetWertSMAKanalWert' Kanal->Art == 'Tagesdifferenz' Kanal->dWert = '1.129000'
<20.06.2009 16:11:05> 'GetWertSMAKanalWert' Kanal->dWert = 1.129000
<20.06.2009 16:11:05> 'GetWertSMAKanalWert' Kanal->cWert = '1.13'
<20.06.2009 16:11:05> 'GetWertSMAKanalWert' *dWert = 235843584
<20.06.2009 16:11:05> 'GetWertSMAKanalWert' Zeichen = 0
<20.06.2009 16:11:05> 'GetWertSMAKanalWert' Kanalabfrage erfolgreich
<20.06.2009 16:11:05> 'GetWertSMA' Kanalabfrage erfolgreich.
<20.06.2009 16:11:05> 'GetWertSMA' Summe bilden.
<20.06.2009 16:11:05> 'FormatWert' gestartet. Format = '%.0f'
<20.06.2009 16:11:05> 'FormatWert' gestartet. xFormat = ''
<20.06.2009 16:11:05> 'FormatWert' gestartet. xFormat = '%.0f'
<20.06.2009 16:11:05> 'FormatWert' Type 'ZahlSave' angegeben.
<20.06.2009 16:11:05> 'FormatWert' xFormat = '%.0f'
<20.06.2009 16:11:05> 'GetWert' Adresse einer Kopplung wurde gefunden.
<20.06.2009 16:11:05> 'JSLogSchreiben' cWert = '1129'
<20.06.2009 16:11:05> 'JSLogSchreiben' i = 40, j = 62
<20.06.2009 16:11:05> 'JSLogSchreiben' AusgabeBuffer = 'TagesDaten[TagesDatenZaehler++]="20.06.2009 16:11:04|4670|1129'
<20.06.2009 16:11:05> 'JSLogSchreiben' ZeilenFormat[41] = '|'
<20.06.2009 16:11:05> 'JSLogSchreiben' i = 41, j = 63
<20.06.2009 16:11:05> 'JSLogSchreiben' AusgabeBuffer = 'TagesDaten[TagesDatenZaehler++]="20.06.2009 16:11:04|4670|1129|'
<20.06.2009 16:11:05> 'JSLogSchreiben' ZeilenFormat[42] = '%'
<20.06.2009 16:11:05> 'JSLogSchreiben' Prozent gefunden.


Die komplette Datei sende ich Dir per Mail.

Vielen Dank

Ralf

[Klaus D.]

Hallo Ralf,

ich denke es liegt an einem Konfig fehler.
kannst du mir mal deine INI Dateien per Mail schicken?


mfg


Klaus D.

[Ralf B.]

Hallo Klaus,

das vermute ich auch, da der Logger mit "leeren" ini-Dateien läuft. ich werde jetzt stückchenweise die ini-Dateien wieder zurückschreiben und sehen, bei welcher er hängen bleibt.
Das komische ist nur, daß ich an den Dateien nicht geändert habe.

Schönen Sonntag

Ralf

[Klaus D.]

Hallo Ralf,

vermutlich ist die JSLog ini Datei schuld oder die SMA ini Datei.

mfg


Klaus D.

[vigeland]

Hi,

das ist der Grund. Es fehlt im "DebugAusgabe" hinten  DPAnzahl oder DP, \x25s wird zu %s und der Parameter fehlt.

if (DP > DPAnzahl)
{
       DebugAusgabe (DebugPTJS, DebugLVNormal, "Die DPAnzahl ist geringer als die '\x25s' Anzahl im ZeilenFormat.\n");
   fclose (Datei);
        return -1;
}

Also DPAnzahl und Paramter zählen.

Gruß
Vigeland.

[Ralf B.]

Hallo,

Ihr habt Recht. ich habe die ini-Dateien von der Sicherung zurückgespielt und der Logger läuft wieder.

Vielen Dank für die Hilfe

Ralf

[Klaus D.]

Keine Ursache :-)

[agoss]

da bin ich mal wieder...

ich habe ein ähnliches Problem. Mein Logger 0.3 läuft auch auf dem Eisfair. (da kann man sich Pakete zum compilieren runterladen..).

Mein Logger stürzt neuerdings im häufiger ab, hatte erst den ftp Transport in Verdacht, habe deshalb alle ftp Transvers abgeschaltet. Habe nach dem letzten Update Yasdi, logger und ftp neu übersetzt, hat aber keine Änderung gebracht

Was ich bisher weiss:

in der JSlogtag wurde heute geloggt:
TagesDaten[TagesDatenZaehler++]="19.09.2009 11:25:16|1638|1108|530|3880|2679|1201";
TagesDaten[TagesDatenZaehler++]="19.09.2009 11:26:06|1643|1112|531|3908|2698|1210";
TagesDaten[TagesDatenZaehler++]="19.09.2009 11:27:05|1645|1114|531|3935|2716|1219";
TagesDaten[TagesDatenZaehler++]="19.09.2009 11:28:06|1653|1117|536|39

im yasdi.log (eine Std länger )
[19.09.2009 12:25:08.267]          Default = 0 (BYTE)
[19.09.2009 12:25:08.267]          Storage = 0 (BYTE)
[19.09.2009 12:25:08.267] ###Free 182 Bytes, Used Mem = 30047
[19.09.2009 12:25:08.267] TStateChanReader::OnIOReqEnd
[19.09.2009 12:25:09.605] TSMADataMaster::AddCmd( MC_GET_PARAMCHANNELS ): Command queued...
[19.09.2009 12:25:09.625] TSMADataMaster::DoMasterCmds() Kommando MC_GET_PARAMCHANNEL bearbeiten ...
[19.09.2009 12:25:09.625] TStateChanReader::OnEnter
[19.09.2009 12:25:09.625] TStateChanReader::OnEnter(): Parameterkanalabfrage von Geraet 'WR11E-03 SN:643802521' [0x0009]...
[19.09.2009 12:25:09.625] Timer started (3 seconds)...
[19.09.2009 12:25:09.625] TSMAData::SendThreadExecute(): Send Packet to driver 'COM2' (Cmd = CMD_GET_DATA, NetAddr=[0x0009])
[19.09.2009 12:25:10.745] ###Alloc 68 Bytes, Used Mem = 29933
[19.09.2009 12:25:10.745] Timer started (4 seconds)...
[19.09.2009 12:25:10.745] TSMADataMaster::OnTransfer(): 0 percent transmitted...
[19.09.2009 12:25:10.785] TSMAData::SendThreadExecute(): Send Packet to driver 'COM2' (Cmd = CMD_GET_DATA, NetAddr=[0x0009])
[19.09.2009 12:25:11.955] Timer started (4 seconds)...
[19.09.2009 12:25:11.956] TSMADataMaster::OnTransfer(): 50 percent transmitted...
[19.09.2009 12:25:11.995] TSMAData::SendThreadExecute(): Send Packet to driver 'COM2' (Cmd = CMD_GET_DATA, NetAddr=[0x0009])
[19.09.2009 12:25:12.725] ###Free 68 Bytes, Used Mem = 29933
[19.09.2009 12:25:12.725] TSMADataMaster::OnTransfer(): 100 percent transmitted...
[19.09.2009 12:25:12.725] ###Alloc 198 Bytes, Used Mem = 30063
[19.09.2009 12:25:12.726] TStateChanReader::OnIOReqPktRcv(): Size=198
[19.09.2009 12:25:12.726]           SMA-SN = 643802521 (DWORD)
[19.09.2009 12:25:12.726]        Upv-Start = 180.000000 (float)
[19.09.2009 12:25:12.726]          T-Start = 10.000000 (float)
[19.09.2009 12:25:12.726]           T-Stop = 2.000000 (float)
[19.09.2009 12:25:12.726]       dU U-Konst = 1.000000 (float)
[19.09.2009 12:25:12.726]     dU-Mpp Track = 0.860000 (float)
[19.09.2009 12:25:12.726]       dUref- Mpp = 317.000000 (float)
[19.09.2009 12:25:12.726]         Ta - Mpp = 5.000000 (float)
[19.09.2009 12:25:12.726]       T Such neu = 1800.000000 (float)
[19.09.2009 12:25:12.726]       I Such neu = 240.000000 (float)
[19.09.2009 12:25:12.726]     Anz Richtung = 7.000000 (float)
[19.09.2009 12:25:12.726]      Usoll-Konst = 330.000000 (float)
[19.09.2009 12:25:12.726]      Isoll-Konst = 0.000000 (float)
[19.09.2009 12:25:12.726]       dI I-Konst = 200.000000 (float)
[19.09.2009 12:25:12.726]          KP_Ureg = 1.000000 (float)
[19.09.2009 12:25:12.726]          Tn-Ureg = 0.350000 (float)
[19.09.2009 12:25:12.726]         Iac-Adap = 2400.000000 (float)
[19.09.2009 12:25:12.726]             Pmax = 1100.000000 (float)
[19.09.2009 12:25:12.726]           Plimit = 1100.000000 (float)
[19.09.2009 12:25:12.726]         I-NiTest = 4500.000000 (float)
[19.09.2009 12:25:12.726]        Utkom.-Ni = 75.000000 (float)
[19.09.2009 12:25:12.726]        Zeit-Imax = 1.000000 (float)
[19.09.2009 12:25:12.726]         Cnt-Imax = 3.000000 (float)
[19.09.2009 12:25:12.726]          Upv-Max = 410.000000 (float)
[19.09.2009 12:25:12.726]          Uac-Min = 198.000000 (float)
[19.09.2009 12:25:12.726]          Uac-Max = 251.000000 (float)
[19.09.2009 12:25:12.726]       Fac-delta- = 0.190000 (float)
[19.09.2009 12:25:12.727]       Fac-delta+ = 0.190000 (float)
[19.09.2009 12:25:12.727]         dFac-Max = 0.250000 (float)
[19.09.2009 12:25:12.727]          Zac-Max = 1700.000000 (float)
[19.09.2009 12:25:12.727]         dZac-Max = 350.000000 (float)
[19.09.2009 12:25:12.727]         Riso-Min = 1000.000000 (float)
[19.09.2009 12:25:12.727]          Tkk-Max = 65.000000 (float)
[19.09.2009 12:25:12.727]  Fehlerstrom Max = 0.000000 (float)
[19.09.2009 12:25:12.727]  Fehlerstrom Fak = 0.000000 (float)
[19.09.2009 12:25:12.730]      Betriebsart = 2 (BYTE)

der Prozess läuft noch immer, aber die TXT logs sind alle leer (wurden bis 19:10 geschrieben)!?!

habt ihr einen Tip für mich??

gruß

Achim