VPS aus unerfindlichen Gründen down - warum?

smasherx · May 18th 2018

Hallo allerseits,

einer meiner VPS Instanzen ist vor 2 Tagen down gegangen. Ich musste sie heut morgen neu starten.

Jetzt wäre es natürlich schön, wenn man heraus bekommt warum das passiert ist.

Netcup sagt, dass das Wirtssystem seit 55 Tagen on ist, was ich ihnen durchaus glaube.

Meine syslog ist zumindest für mich nicht aufschlussreich...

Code

May 16 06:48:58 v22018035818363324 systemd[1]: Starting Daily apt download activities...
May 16 06:49:07 v22018035818363324 systemd[1]: Started Daily apt download activities.
May 16 07:17:01 v22018035818363324 CRON[1834]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
May 16 07:18:47 v22018035818363324 systemd-timesyncd[759]: Timed out waiting for reply from 91.189.94.4:123 (ntp.ubuntu.com).
May 16 07:18:58 v22018035818363324 systemd-timesyncd[759]: Timed out waiting for reply from 91.189.89.198:123 (ntp.ubuntu.com).
May 16 07:19:08 v22018035818363324 systemd-timesyncd[759]: Timed out waiting for reply from 91.189.89.199:123 (ntp.ubuntu.com).
May 16 07:19:18 v22018035818363324 systemd-timesyncd[759]: Timed out waiting for reply from [2001:67c:1560:8003::c8]:123 (ntp.ubuntu.com).
May 16 07:19:28 v22018035818363324 systemd-timesyncd[759]: Timed out waiting for reply from [2001:67c:1560:8003::c7]:123 (ntp.ubuntu.com).
May 16 07:53:37 v22018035818363324 systemd-timesyncd[759]: Synchronized to time server 91.189.91.157:123 (ntp.ubuntu.com).
May 16 08:17:01 v22018035818363324 CRON[2124]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
May 16 09:17:01 v22018035818363324 CRON[2280]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
May 16 09:44:46 v22018035818363324 dhclient[1179]: DHCPREQUEST of 185.233.106.217 on ens3 to 46.38.225.11 port 67 (xid=0x7e94cc7e)
May 16 09:44:46 v22018035818363324 dhclient[1179]: DHCPACK of 185.233.106.217 from 46.38.225.11
May 16 09:44:46 v22018035818363324 dhclient[1179]: bound to 185.233.106.217 -- renewal in 43117 seconds.
May 16 10:17:01 v22018035818363324 CRON[2414]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
May 16 10:47:01 v22018035818363324 CRON[2562]: (root) CMD (/sbin/fstrim / >/dev/null 2>&1)
May 18 09:21:45 v22018035818363324 rsyslogd: [origin software="rsyslogd" swVersion="8.16.0" x-pid="1061" x-info="http://www.rsyslog.com"] start
May 18 09:21:45 v22018035818363324 rsyslogd-2222: command 'KLogPermitNonKernelFacility' is currently not permitted - did you already set it via a RainerScript command (v6+ config)? [v8.16.0 try http://www.rsyslog.com/e/2222 ]
May 18 09:21:45 v22018035818363324 rsyslogd: rsyslogd's groupid changed to 108
May 18 09:21:45 v22018035818363324 rsyslogd: rsyslogd's userid changed to 104
May 18 09:21:45 v22018035818363324 systemd-modules-load[588]: Inserted module 'iscsi_tcp'
May 18 09:21:45 v22018035818363324 systemd-modules-load[588]: Inserted module 'ib_iser'
May 18 09:21:45 v22018035818363324 loadkeys[592]: Lade /etc/console-setup/cached.kmap.gz.
May 18 09:21:45 v22018035818363324 systemd[1]: Started Set console keymap.
May 18 09:21:45 v22018035818363324 systemd[1]: Started LVM2 metadata daemon.
May 18 09:21:45 v22018035818363324 systemd[1]: Reached target Network (Pre).
May 18 09:21:45 v22018035818363324 systemd[1]: Starting Create Static Device Nodes in /dev...
May 18 09:21:45 v22018035818363324 systemd[1]: Starting Apply Kernel Variables...

Display More

Auch die Ressourcenauslastung zeigt keinerlei Ungereimtheiten...

Das witzige ist, dass der Dienst, den ich drauf laufen hab auf einem identischen VPS auch noch läuft und dort nicht down gegangen ist...

Habt ihr eine Ahnung was ich noch nachschauen kann woran das gelegen hat?

heavygale · May 18th 2018

Ein unvermittelter Abbruch im Log klingt nach "Erzwungen abschalten" aus, im SCP Protokoll ist nicht aufgeführt?

smasherx · May 18th 2018

Quote from heavygale

Ein unvermittelter Abbruch im Log klingt nach "Erzwungen abschalten" aus, im SCP Protokoll ist nicht aufgeführt?

Im SCP Protokoll stehen genau 2 Dinge:

neues Image wurde installiert (im März)
und Server wurde neu gestartet (heute morgen)

mir ist es völlig schleierhaft was hier passiert ist...

.A. · May 18th 2018

Das letzte was nach syslog passierte, war

Code

May 16 10:47:01 v22018035818363324 CRON[2562]: (root) CMD (/sbin/fstrim / >/dev/null 2>&1)

Du wirst aber aufgrund >/dev/null 2>&1 nie herausfinden, ob und wie dies für das Problem verantwortlich ist. Wer schon Fehlermeldungen unterdrückt, sollte wenigstens Fehler ordentlich abfangen.

Gelöscht03 · May 18th 2018

Vielleicht Option Autostart aktivieren im SCP nicht aktiviert und der Host wurde durchgestartet (wartungsbedingt)

smasherx · May 19th 2018

Quote from Georg

Vielleicht Option Autostart aktivieren im SCP nicht aktiviert und der Host wurde durchgestartet (wartungsbedingt)

nope - also wenn das grüne Häkchen bedeutet, dass Autostart AN ist, dann ist es nicht der Fall...

manchmal steht man echt wie nen Esel vorm Berg und kann nur "muh" machen...

smasherx · May 19th 2018

Quote from .A.
Das letzte was nach syslog passierte, war
Code
May 16 10:47:01 v22018035818363324 CRON[2562]: (root) CMD (/sbin/fstrim / >/dev/null 2>&1)
Du wirst aber aufgrund >/dev/null 2>&1 nie herausfinden, ob und wie dies für das Problem verantwortlich ist. Wer schon Fehlermeldungen unterdrückt, sollte wenigstens Fehler ordentlich abfangen.

Nun das scheint so "Standard" zu sein, denn ich hab nie etwas willentlich unterdrückt. Könntest du mir behilflich sein, da dran was zu ändern (link o.ä.) damit mir das nicht wieder passiert.

vmk · May 19th 2018

Gibt es in anderen Logfiles noch Einträge nachdem fstrim gestartet wurde?

Was meinst du mit down gegangen eigentlich? War die Maschine ausgeschaltet oder hat die mit einer Fehlermeldung in der Konsole gehangen?

smasherx · May 21st 2018

Quote from vmk

Gibt es in anderen Logfiles noch Einträge nachdem fstrim gestartet wurde?

Was meinst du mit down gegangen eigentlich? War die Maschine ausgeschaltet oder hat die mit einer Fehlermeldung in der Konsole gehangen?

Die Maschine war "einfach aus". Keinerlei offensichtliche Fehlermeldung o.ä.
Im SCP einfach gestartet und dann lief alles wie vorher...

Ich steh bissl aufm Schlauch was fstrim ist... aber egal... es bleibt hoffentlich bei dem einem Mal...

.A. · May 21st 2018

Quote from smasherx

Nun das scheint so "Standard" zu sein, denn ich hab nie etwas willentlich unterdrückt. Könntest du mir behilflich sein, da dran was zu ändern (link o.ä.) damit mir das nicht wieder passiert.

Es gibt mehrere Wege:

Wenn Du den Output nicht unterdrückst, schickt cron den Output per Mail.
Du kannst den Output in eine Logdatei schreiben oder durch logger an syslog übergeben.
Du kannst einen watchdog laufen lassen, damit das System bei Problemen sofort neu startet.
Du solltest das System überwachen, damit damit Du bei solchen Situationen künftig sofort Bescheid weißt.

Nicht alles davon funktioniert bei jeder Fehlerursache. Daher kannst Du diese Maßnahmen gerne auch kombinieren.

Tags