@Werner, danke erst mal für die erste Antwort, jetzt wirds eine »Doktorarbeit« für mich:
HeavyWeather (HW) wird um X:05, X:25 und X:45 Uhr neu gestartet (mit zcron und relaunch), d.h., dass die Fehlmeldung von 03:40 Uhr 15min NACH Neustart HW erfolgte und die nächste (anscheinend richtige) Meldung GENAU NACH Neustart von HW erfolgte.
Beim Wechsel »kurze/lange« Datensätze ist mir jetzt aufgefallen, dass die langen immer um 00:05 (Tageswechsel – anscheinend »interne« Abarbeitung des alten Tages und Vorbereitung des neuen Tages durch WsWin) auftreten:
kurz:
2015-09-30
00:00:07.088 ?val=xxx;xxx;29.09.2015;23:59;5.6;87;1025.0;0.000;0.6;135;;;;de;0;3.1;;;;;;0.00;wswin_2.98.1
2015-09-30 00:00:07.291 OK
lang:
2015-09-30
00:05:07.107 ?val=xxx;xxx;30.09.2015;00:04;5.6;87;1024.9;0.000;0.4;135;;;;de;0;3.1;;;;;;0.00;wswin_2.98.1;13.136389;47.077222;5.6;5.6;5.6;0.5;10.3;27.2;-12.3;8.1;32.8;87.0;87.0;87.0;42.0;81.8;96.0;23.0;78.2;99.0;1024.6;1024.6;1024.6;1003.6;1016.1;1027.6;976.6;1017.8;1036.6;0.0;0.4;1.6;0.0;4.4;49.4;0.0;4.9;52.5;0.0;1.9;3.1;0.0;7.2;67.1;0.0;7.8;82.7;68.0;158;158;0.0;199.7;1117.4;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;
2015-09-30 00:05:08.013 OK
und weiter lang BIS Neustart WsWin (um 19:31 Uhr):
2015-09-30
19:25:10.986 ?val=xxx;xxx;30.09.2015;19:24;5.5;76;1023.2;0.000;2.5;135;;;;de;1;6.2;;;;;;0.00;wswin_2.98.1;13.136389;47.077222;-0.1;5.8;13.7;0.5;10.3;27.2;-12.3;8.1;32.8;48.0;79.5;94.0;42.0;81.8;96.0;23.0;78.2;99.0;1022.6;1023.6;1024.6;1003.6;1016.1;1027.6;976.6;1017.8;1036.6;0.0;2.2;16.6;0.0;4.4;49.4;0.0;4.9;52.5;0.0;3.9;22.4;0.0;7.2;67.1;0.0;7.8;82.7;202.0;158;158;0.0;199.7;1117.4;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;
2015-09-30 19:25:11.127 OK
2015-09-30
19:30:10.991 ?val=xxx;xxx;30.09.2015;19:30;5.2;77;1023.2;0.000;2.1;135;;;;de;1;6.2;;;;;;0.00;wswin_2.98.1;13.136389;47.077222;-0.1;5.8;13.7;0.5;10.3;27.2;-12.3;8.1;32.8;48.0;79.4;94.0;42.0;81.8;96.0;23.0;78.2;99.0;1022.6;1023.6;1024.6;1003.6;1016.1;1027.6;976.6;1017.8;1036.6;0.0;2.2;16.6;0.0;4.4;49.4;0.0;4.9;52.5;0.0;3.9;22.4;0.0;7.2;67.1;0.0;7.8;82.7;68.0;158;158;0.0;199.7;1117.4;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;
2015-09-30 19:30:11.898 OK
und dann (6min NACH Neustart HW UND Neustart WsWin um 19:31) plötzlich außerhalb des 5min-Takts kurz:
2015-09-30
19:31:38.776 ?val=Geri;B5921B3E3D4F28202F5AC850F6317B73;30.09.2015;19:31;5.2;77;1023.6;0.000;1.9;135;;;;de;1;6.2;;;;;;0.00;wswin_2.98.1
2015-09-30 19:31:38.901 OK
danach kurz weiter bis 00:00, dann wieder lang.
Ich habe bei Einzeldurchsicht noch interessante Datensätze gefunden (ob es einen Grund von meiner Seite gab, weiß ich nicht mehr – zu lange her –, glaube es aber nicht) – diese dürften mit Internet-, bzw. Serverproblemen zu tun haben:
2015-09-30
09:15:09.031 Daten konnten nicht eingefuegt werden
INSERT INTO awekas_value_unlocked (id,timestamp,temp,hum,baro,regen,regenrate,wind_gesch,wind_richt,wetterlage,warntext,taupunkt,gust,uv,solar,helligkeit,sonnenzeit,bodentemp)
VALUES (11117,"1443597313",3.2,94,1024.1,0,0,0.1,135,,,2.4,3.1,,,,NULL,)
ON DUPLICATE KEY
UPDATE awekas_value_unlocked SET timestamp="1443597313",temp=3.2 , hum=94, baro=1024.1, regen=0, wind_gesch=0.1, wind_richt=135, wetterlage=, warntext="", taupunkt=2.4, gust=3.1, solar= , uv= , bodentemp= , helligkeit= , sonnenzeit= NULL , regenrate= 0 WHERE id=11117
2015-10-05
21:00:06.685 ?val=xxx;xxx;05.10.2015;20:59;6.0;91;1014.5;0.000;3.4;135;;;;de;0;6.2;;;;;;0.00;wswin_2.98.1
2015-10-05 21:01:10.873 <DOCTYPE>
<html><head>
<title>503 Service Temporarily Unavailable</title>
</head><body>
<h1>Service Temporarily Unavailable</h1>
<p>The server is temporarily unable to service your
request due to maintenance downtime or capacity
problems. Please try again later.</p>
<hr>
<address>Apache/2.2.22 (Debian) Server at data.awekas.at Port 80</address>
</body></html>
Am 07.10. begann alles folgend:
2015-10-07
00:05:07.383 ?val=xxx;xxx;07.10.2015;00:04;10.1;91;1010.3;
0.000;0.0;135;;;;de;0;0.0;;;;;;
0.00;wswin_2.98.1;13.136389;47.077222;10.1;10.1;10.1;2.0;10.2;19.2;-12.3;8.2;32.8;91.0;91.0;91.0;48.0;78.8;95.0;23.0;78.1;99.0;1010.6;1010.6;1010.6;1007.6;1016.5;1023.6;976.6;1017.8;1036.6;0.0;0.0;0.0;0.0;6.1;37.9;0.0;4.9;52.5;0.0;0.0;0.0;0.0;9.5;50.9;0.0;7.8;82.7;202.0;135;158;0.0;8.5;1125.9;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;
2015-10-07 00:05:09.883 OK
2015-10-07
00:10:07.448 ?val=xxx;xxx;07.10.2015;00:09;10.1;91;1010.3;
0.000;0.0;135;;;;de;0;0.0;;;;;;
0.00;wswin_2.98.1;13.136389;47.077222;10.1;10.1;10.1;2.0;10.2;19.2;-12.3;8.2;32.8;91.0;91.0;91.0;48.0;78.8;95.0;23.0;78.1;99.0;1010.6;1010.6;1010.6;1007.6;1016.5;1023.6;976.6;1017.8;1036.6;0.0;0.0;0.0;0.0;6.1;37.9;0.0;4.9;52.5;0.0;0.0;0.0;0.0;9.5;50.9;0.0;7.8;82.7;202.0;135;158;0.0;8.5;1125.9;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;
2015-10-07 00:10:17.682 OK
2015-10-07
00:15:07.453 ?val=xxx;xxx;07.10.2015;00:15;10.1;91;1010.3;
0.000;0.8;135;;;;de;0;3.1;;;;;;
0.00;wswin_2.98.1;13.136389;47.077222;99999.0;10.1;-99999.0;2.0;10.2;19.2;-12.3;8.2;32.8;99999.0;91.0;-99999.0;48.0;78.8;95.0;23.0;78.1;99.0;99999.0;1010.6;-99999.0;1007.6;1016.5;1023.6;976.6;1017.8;1036.6;99999.0;0.5;-99999.0;0.0;6.1;37.9;0.0;4.9;52.5;99999.0;1.2;-99999.0;0.0;9.5;50.9;0.0;7.8;82.7;68.0;135;158;0.0;8.5;1125.9;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;
2015-10-07 00:15:07.625
Warning: Invalid argument supplied for foreach() in /var/www/wetter/awekas/import/eingabe_pruefung.php on line 1130
OK
2015-10-07
00:20:07.504 ?val=xxx];xxx;07.10.2015;00:19;10.1;91;1010.4;
0.258;1.4;135;;;;de;0;3.1;;;;;;
1.55;wswin_2.98.1;13.136389;47.077222;10.1;10.1;10.1;2.0;10.2;19.2;-12.3;8.2;32.8;91.0;91.1;92.0;48.0;78.8;95.0;23.0;78.1;99.0;1010.6;1010.6;1010.6;1007.6;1016.5;1023.6;976.6;1017.8;1036.6;0.0;0.7;2.6;0.0;6.1;37.9;0.0;4.9;52.5;0.0;1.6;3.1;0.0;9.5;50.9;0.0;7.8;82.7;68.0;135;158;0.3;8.5;1125.9;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;
2015-10-07 00:20:11.676 OK
2015-10-07
00:25:07.506 ?val=xxx;xxx;07.10.2015;00:24;10.1;91;1010.3;
0.258;1.6;135;;;;de;0;3.1;;;;;;
1.55;wswin_2.98.1;13.136389;47.077222;10.1;10.1;10.1;2.0;10.2;19.2;-12.3;8.2;32.8;91.0;91.1;92.0;48.0;78.8;95.0;23.0;78.1;99.0;1010.6;1010.6;1010.6;1007.6;1016.5;1023.6;976.6;1017.8;1036.6;0.0;0.9;2.6;0.0;6.1;37.9;0.0;4.9;52.5;0.0;1.9;3.1;0.0;9.5;50.9;0.0;7.8;82.7;68.0;135;158;0.3;8.5;1125.9;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;
2015-10-07 00:25:12.741 OK
2015-10-07
00:30:07.555 ?val=xxx;xxx;07.10.2015;00:30;10.1;92;1010.3;
0.258;0.9;135;;;;de;0;3.1;;;;;;
17.03;wswin_2.98.1;13.136389;47.077222;10.1;10.1;10.1;2.0;10.2;19.2;-12.3;8.2;32.8;91.0;91.3;92.0;48.0;78.8;95.0;23.0;78.1;99.0;1010.6;1010.6;1010.6;1007.6;1016.5;1023.6;976.6;1017.8;1036.6;0.0;0.8;2.6;0.0;6.1;37.9;0.0;4.9;52.5;0.0;1.8;3.1;0.0;9.5;50.9;0.0;7.8;82.7;202.0;135;158;0.3;8.5;1125.9;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;
2015-10-07 00:30:19.149 OK
(HIER IST DER ERSTE RR-AUSREISSER!)
Die betreffenden HW-Aufzeichnungen (gekürzt):
Nummer;Datum;Relativer Regen (mm);Absoluter Regen (mm)
46173;07.10.2015 00:24;0;162,5
46174;07.10.2015 00:25;0;162,5
46175;07.10.2015 00:26;0;162,5
46176;07.10.2015 00:27;0;162,5
46177;07.10.2015 00:28;0;162,5
46178;07.10.2015 00:29;0;162,5
46179;07.10.2015 00:30;0;162,5
... da scheint alles zu stimmen
2015-10-07
00:35:07.542 ?val=xxx;xxx3;07.10.2015;00:35;10.1;92;1010.2;
0.516;0.1;135;;;;de;0;3.1;;;;;;
1.55;wswin_2.98.1;13.136389;47.077222;10.1;10.1;10.1;2.0;10.2;19.2;-12.3;8.2;32.8;91.0;91.4;92.0;48.0;78.8;95.0;23.0;78.1;99.0;1010.6;1010.6;1010.6;1007.6;1016.5;1023.6;976.6;1017.8;1036.6;0.0;0.7;2.6;0.0;6.1;37.9;0.0;4.9;52.5;0.0;1.5;3.1;0.0;9.5;50.9;0.0;7.8;82.7;68.0;135;158;0.5;8.5;1125.9;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;;
2015-10-07 00:35:08.948 OK
...
Ich habe für WsWin einen täglichen automatischen Neustart unter »Optionen/Zeitsteuerung/Zeitsteuerung« und hier »Programm beenden & Restart« um 19:31 Uhr eingestellt. Grund:
Ohne Neustart bekam ich automatisch nach etwas mehr als einem Tag Meldeprobleme (keine Meldung an AWEKAS ...).
Mit dem automatischen Neustart handelte ich mir jedoch ein neues Problem ein und zwar:
In der Taskleiste bleibt das WsWin-Symbol bestehen (meistens, nicht immer!) und lt. Task-Manager laufen dann ZWEI WsWin-Prozesse – einer unter Apps (das ist, glaube ich, der Normalfall unter WIN8.1) UND einer unter HINTERGRUNDPROZESSE (dieser belegt dann alleine über 50% CPU!). Ließ ich das bestehen, bekam ich erst recht Meldeprobleme. Wenn ich diesen Hintergrundprozess im Taskmanager »kille« und WsWin vorher »normal« beende (Datei/Progamm beenden) und neu starte, geht die Gesamt-CPU-Auslastung von fast 100% auf max. 50% (je nach Aktivitäten) zurück.
Ich will natürlich nicht täglich um Mitternacht den 2. Prozess killen und ca. 19:30 Uhr ist für mich die »beste« Zeit, weil ich da am ehesten zeitnah zum PC komme.
Warum das nicht täglich passiert und dann ein killen des Hintergrundprozesses notwendig ist, weiß ich nicht, mir fällt nur auf, dass WsWin (auch auf meinem Stand-PC, einer »Rennmaschine« im Vergleich zum Netbook) ca. 7 - 8 Sek. zum beenden braucht. Dieser Hintergrundprozess tritt bei Deaktivierung des automatischen Neustarts nicht auf, dafür aber die Meldeprobleme ... hier beißt sich die Katze in den Schwanz.
Die RR-Ausreißer treten anscheined seit Juni 2015 auf (lt. AWEKAS Jahresstatistik – die GANZEN Meldungen will ich nicht durchsehen wegen der minütlichen Aufzeichnung, heuer bis jetzt an die 400.000 Datensätze mit Zeilenumbrüchen und verschiedener Länge ...).
Ob das ev. mit einer neuen WsWin-Version zu tun hat weiß ich nicht (bitte nicht böse sein
– in v2.97.x gabs da schon mal ein Problem mit der RR, wie ich bei AWEKAS gelesen habe).
Ich hoffe, dass dieser ewig lange Beitrag noch verständlich ist und Mitternacht ist auch schon LANGE vorbei.
Danke im Voraus, falls darin die Lösung meines Problems versteckt ist und Du mir helfen kannst
Gerald
PS:
@Tex
NACH Fertigstellung meiner »Doktorarbeit« hab ich Deinen Beitrag erst gesehen (der war ja nicht so lang
).
Das ist schon mal ein SUPER ANSATZ!!!, 5min nach HW-Start passt auch auf ersten Fehldatensatz um 0:30 Uhr, aber andererseits nicht auf den (in anderem Beitrag beschriebenen) Rekordfehler um 3:40 Uhr ...
Ausleseverzögerung ist bei mir 0
Danke
Gerald