Backup mehrfach ausgeführt

[stasoft]

Guten Tag,

die Intranatoren unserer Kunden erstellen jeweils täglich ein Backup und legen dieses mit FTP auf einem Rechner in ihrem LAN ab. Gestern Sonntag (2008-10-26) wurde dies auf allen Intranatoren zweimal ausgeführt: einmal eine Stunde _vor_ dem auf dem Intranator eingestellten (System -> Backup -> Einstellungen -> Erstellungs-Uhrzeiten) Zeitpunkt (Umstellung auf Winterzeit?), und dann gleich noch einmal, sobald das erste Backup auf dem FTP Server abgelegt war. (Die Zeiten entnehme ich den Namen und der mtime der backup-* Verzeichnisse auf den FTP Servern.)

Wie konnte das passieren?


Freundliche Grüsse,

Jukka Salmi

[Thomas Jarosch]

Hallo Herr Salmi,

das Backup ist vermutlich auf 02:00 eingestellt. Wahrscheinlich ist das Backup gestartet und anschliessend kam die Zeitumstellung. Das System hat die Uhr von 03:00 auf 02:00 umgestellt und dadurch den Backup-Vorgang erneut ausgelöst. Da momentan noch ein Backup gelaufen ist, wurde der zweite Auftrag in die Warteschlange gelegt und nach Fertigstellung des ersten Backups + entferntes Ablegen ausgeführt.

Herzliche Grüsse,
Thomas Jarosch

[stasoft]

Hallo Herr Jarosch

Ganz so einfach war es leider nicht: das Backup wird auf allen Rechnern zwischen 22:05 und 23:30 Uhr gestartet...


Freundliche Grüsse,

Jukka Salmi

[Thomas Jarosch]

Hallo Herr Salmi,

ok, danke für die Info. Bitte kontrollieren Sie zur Sicherheit die "messages" Logdatei, ob es vielleicht zu einer Fehlfunktion im ntp-Modul kam und die Uhr deswegen gesprungen ist. (Allerdings wären bei uns dann vermutlich weitere Meldungen von anderen Kunden eingegangen). Oder verwenden Sie einen anderen NTP-Server als den von uns vorkonfigurierten?

Herzliche Grüsse,
Thomas Jarosch

[stasoft]

Hallo Herr Jarosch

die messages Dateien enthalten auf allen Intranatoren keinerlei Hinweise auf Fehlfunktionen des ntpd (allerdings ist die Option "Erweiterte Logdateien ..." nicht aktiviert); die Uhr "springt" jeweils um 3 Uhr wie erwartet auf 2 Uhr zurück. Zudem sind überall [012].intra2net.pool.ntp.org als Zeitserver konfiguriert.

Was bewirkt eigentlich die Option "Erweiterte Logdateien ..." genau? Logging ab LOG_DEBUG? Ist es möglich, den Inhalt der Warteschlange periodisch oder besser bei deren Änderung auszugeben?


Freundliche Grüsse,

Jukka Salmi

[Gerd von Egidy]

Hallo,

die messages Dateien enthalten auf allen Intranatoren keinerlei Hinweise auf Fehlfunktionen des ntpd (allerdings ist die Option "Erweiterte Logdateien ..." nicht aktiviert); die Uhr "springt" jeweils um 3 Uhr wie erwartet auf 2 Uhr zurück. Zudem sind überall [012].intra2net.pool.ntp.org als Zeitserver konfiguriert.

Das klingt erst mal gut.

Was bewirkt eigentlich die Option "Erweiterte Logdateien ..." genau? Logging ab LOG_DEBUG? Ist es möglich, den Inhalt der Warteschlange periodisch oder besser bei deren Änderung auszugeben?

Bei den erweiterten Logdateien wird deutlich mehr protokolliert, z.B. jede DNS-Abfrage und jedes Byte der IPSec-Verbindungsaushandlung. Dadurch werden die Logdateien extrem aufgebläht und es kostet auch einiges an Performance. Wir empfehlen, diese Option wirklich nur ganz geziehlt zu aktivieren sobald es Probleme gibt, die mit den normalen Logdateien nicht zu erkennen sind.

Kann es sein, daß ein früheres Backup blockiert wurde und daher erst später starten konnte? Sie finden das am besten heraus, wenn Sie die Backup-Dateien der letzten Tage vergleichen und dabei eine größere Lücke oder Zeitverschiebung auffällt.

Herzliche Grüße,

v. Egidy

[stasoft]

Kann es sein, daß ein früheres Backup blockiert wurde und daher erst später starten konnte? Sie finden das am besten heraus, wenn Sie die Backup-Dateien der letzten Tage vergleichen und dabei eine größere Lücke oder Zeitverschiebung auffällt.

Hmm, sieht nicht danach aus: alle Backups wurden in den letzten Monaten um die selbe Zeit gestartet, dauerten in etwa gleich lange und liefen jeden Tag genau einmal...

Die Ursache dieses Problems kann wohl nicht mehr gefunden werden. Mal schauen wie sich die Intranatoren bei der nächsten Zeitumstellung verhalten ;-)


Freundliche Grüsse,

Jukka Salmi

[Gerd von Egidy]

Hallo Herr Salmi,

ich bin gerade nochmal mit meinem Kollege die verschiedenen Fälle der Zeitsteuerung bei der Zeitumstellung durchgegangen und wir gehen davon aus, daß es da tatsächlich einen Fall gibt, der bisher nicht bedacht ist und der die von Ihnen beschriebenen Auswirkungen haben kann.

Wir werden uns das nochmal genauer ansehen und ich gehe davon aus, daß wenn Sie nicht vergessen die Updates einzuspielen, es bei der nächsten Zeitumstellung nicht mehr auftreten sollte...

Sie sind ja heute gut drauf, gleich 2 Bugs an einem Tag

Herzliche Grüße,

v. Egidy

[Thomas Jarosch]

Hallo Herr Salmi,

Die Ursache dieses Problems kann wohl nicht mehr gefunden werden. Mal schauen wie sich die Intranatoren bei der nächsten Zeitumstellung verhalten ;-)

Wir haben die Angelegenheit genau unter die Lupe genommen und können berichten, daß die kommende Version 5.1.2 sich richtig verhalten wird. Ob Version 5.1.2 bis Ende März erscheint kann ich nicht garantieren, bei dieser Zeitumstellung (eine Stunde nach vorne) wird das Backup am darauffolgenden Tag eine Stunde zu spät ausgeführt, ich denke damit kann man sehr gut Leben

Problematisch ist die Zeitumstellung im Herbst 2009 (eine Stunde zurück), bis dahin sollte Version 5.1.2 allerdings schon wieder Schnee von gestern sein.
Hier würde das Backup doppelt ausgeführt werden, da es eine Stunde zu früh startet und während das Backup anläuft der nächste Startzeitpunkt berechnet wird. Wenn das Backup also an diesem Tag um 21h startet und normalerweise um 22h läuft, so wird es um 22h nochmal gestartet.

Herzliche Grüsse,
Thomas Jarosch