j-Serie ds110j erwacht oft aus dem standby

[macondo]

es wird ruhiger... außer 1x die geheimnisvolle pid 407 hat nix ungewolltes die ds aus dem schlaf gerissen... sehr schön..

 

[macondo]

kann mir jemand sagen, was das für ein prozess ist?

Apr  6 08:48:53 kernel: [428296.490000] [] opened by pid 3816 [u:(/usr/syno/sbin/smbd), comm:(smbd)]
Apr  6 08:48:53 kernel: [428296.520000] drivers/scsi/sd.c[471]:sd_prep_fn(), sda: cmd 0x0 spin up by pid=3540, comm=cupsd
Apr  6 08:48:53 scemd: SCEMD: disk 1 wake up from hibernation
Apr  6 08:48:57 kernel: [428299.840000] [/var/run/cups/certs/0] opened by pid 3540 [u:(/usr/syno/sbin/cupsd), comm:(cupsd)]

DS> ps | grep 3540
 3540 root      4016 S    /usr/syno/sbin/cupsd -C /usr/local/cups/cupsd.conf
29700 root      2928 S    grep 3540

 

[Hruendel]

Drucker an der DS? Weitere PCs im Windows Netzerk? Netzwerkdrucker? Wurde der Drucker schon mal an DS angesteckt?
Wurde über DS-Druckerfreigabe etwas gedruckt? ... könnte noch ein Druckauftrag in der DS hängen.

 

[macondo]

hallo, danke für die antwort... also der printserver an der ds war nie aktiv, es war auch nie ein drucker angeschlossen. an meinem pc hängt ein drucker, der rechner war zu dem zeitpunkt eingeschaltet, der drucker aber nicht...

habe noch einen mir nicht bekannten prozess gefunden, ich bitte um hilfe...

Apr  6 16:42:37 scemd: SCEMD: disk 1 wake up from hibernation
Apr  6 16:42:37 kernel: [456719.760000] drivers/scsi/sd.c[471]:sd_prep_fn(), sda: cmd 0x0 spin up by pid=87, comm=kblockd/0

DS> ps | grep 87
   87 root         0 SW   [kblockd/0]
14612 root      2928 S    grep 87

 

[Matthieu]

kblockd gehört ebenso zum Dateisystem wenn ich das richtig im Kopf habe (nicht noch mal nachgesehen). Mich verwundert etwas, warum localtime mehrfach auftaucht nachdem die Platte aufgewacht ist.

MfG Matthieu

 

[macondo]

ja, das ist schon häufiger passiert... aber das siehst du ja auch in den logfiles die ich dir geschickt habe... ich hoffe du kannst da was finden.

 

[Matthieu]

ja, das ist schon häufiger passiert... aber das siehst du ja auch in den logfiles die ich dir geschickt habe... ich hoffe du kannst da was finden.

Im Zusammenhang scheinen keine Einträge zu finden zu sein. Auch wenn einige der Logs ganz schön aus den Nähten platzen, weil echt jeder AdminTool-Aufruf dutzende Einträge generiert. Mir fällt nur noch eins ein: Probier mal alle externen USB- und eSATA-Geräte für eine Weile zu entfernen und schau dann noch mal. Vielleicht ist das 1x pro Tag aber auch beabsichtigt oder so, keine Ahnung, das weiß nur Synology selbst. Wie du die erreichst sollte bekannt sein.

MfG Matthieu

 

[macondo]

an der ds hing noch nie ein usb oder esata gerät, ebenso wenig wie ein drucker...

dieses jbd2 dings weckt die ds 1-3 mal am tag, ansonsten sind da öfters mal smbd prozesse, was immer das auch sein soll... aber alle mit verschiedenen pids die über "ps | grep" keine andere auswertung bringen als die pid selbst. der rest sind gewollte zugriffe oder einzelfälle wie cupsd oder kblockd, bei denen ich auch keine ahnung habe wo die herkommen.

 

[Hruendel]

kann mir jemand sagen, was das für ein prozess ist?

Apr  6 08:48:53 kernel: [428296.490000] [] opened by pid 3816 [u:(/usr/syno/sbin/smbd), comm:(smbd)]
Apr  6 08:48:53 kernel: [428296.520000] drivers/scsi/sd.c[471]:sd_prep_fn(), sda: cmd 0x0 spin up by pid=3540, comm=cupsd
Apr  6 08:48:53 scemd: SCEMD: disk 1 wake up from hibernation
Apr  6 08:48:57 kernel: [428299.840000] [/var/run/cups/certs/0] opened by pid 3540 [u:(/usr/syno/sbin/cupsd), comm:(cupsd)]

DS> ps | grep 3540
 3540 root      4016 S    /usr/syno/sbin/cupsd -C /usr/local/cups/cupsd.conf
29700 root      2928 S    grep 3540

Hier geht es definitiv um Druckprozess. Ist bei der DS Druckerdienst eingeschaltet?
Es sind immer diverse Dienste die die Ds aufwäcken. Installiere die DS neu und gut ist.

 

[Matthieu]

Es sind immer diverse Dienste die die Ds aufwäcken. Installiere die DS neu und gut ist.

Das würde ich so nicht verallgemeinern. Der bis zuletzt ungeklärte Dienst hängt am Dateisystem und er ist auch bisher der einzigste, der reproduzierbar auftritt. Der Rest kümmert mich recht wenig, aber irgend etwas fummelt da mit netter Regelmäßigkeit an der Struktur von ext ... und der sollte bestehen bleiben egal was man da macht. Leider finden sich im Log keine Fehlermeldungen über defekte Sektoren o.ä.

MfG Matthieu

 

[Hruendel]

Laut Logs mal sind das http Zugriffe auf apache (webordner), mal ist das Samba (Windows Netzwerk), mal ist das die automatische Zeitaktualisierung, mal Druckprozess. Ziemlich wenig Unerklärliches...

Ich weiß jetzt nicht ob man die Druckprozesse an der DS einsehen kann. Wenn aber jemand aus Versehen auf die Druckerfreigabe was gesendet hat sucht man sich dumm und dämlich. ... ob es in der DS oder im PC hängt.

Ich würde:
- automatische Zeitaktualisierung ausschalten
- alle nicht gebrauchten Dienste abstellen wie Netzwerkdrucher, Appeltalk und alles was da so gibt.
- Cron prüfen
- DS vom Netzwerk trennen
- wenn alles nicht hilft OS neu rauf und gut ist

An defekte Sektoren glaube ich nicht da diese kaum etwas mit Aufwachen zu tun haben. Im Allgemeinen sind Windows-PCs im Netzwerk recht neugierig. Habe bei WinXP mal mit einer Hardware Firewall protokoliert was da rumläuft, es waren Dutzende Anfragen an ca. 20 diversen Ports. Wenn ein Windows PC im Netzwerk mitläuft sollte man immer mit Anfragen rechnen. Und hier wird es über den Start von Firefox geredet.

Dass die Pids (Prozess IDs) unteschiedlich sind ist wohl klar .

JBD ist Journaling Block Device. Kurzgesagt Festplatte, die auch gemountet ist und wahrscheinlich dabei geweckt wird .

 

[macondo]

- zeit wird manuell eingestellt, war nie automatisch
- druckerserver war nie aktiv, wurde nie genutzt, es war nie ein drucker an der ds angeschlossen
- die anderen dienste abseits von web, photostation sind auch aus, ich nutze relativ wenig
- wie prüfe ich cronjobs?
- habe die ds jetzt nochmal vom lan genommen... mal sehen

das jbd2 dings weckte die platte gerade ziemlich oft... wozu soll das journaling denn gut sein? kann man das irgendwie steuern?

das die pids unterschiedlich sind ist mir auch klar, mich wundert es nur wenn da wechselnde pids über smbd die platte wecken und im gegensatz zu den anderen prozessen bei der abfrage mit "ps | grep" nur die pid selbst als antwort kommt, bei all den anderen prozessen kommt dann ein prozessname etc. als antwort...

 

[Hruendel]

... jbd2/sda1-8 steht hier für den Pfad zu der Festplate jbd2 ist die physikalische Festplatte 2 (1 wird wohl Flashspeicher sein). sda1 ist der Anbindungspunkt unter Linux. sda1 steht unter Linux für die angebungdene Festplatte. jbd2 hat somit nichts mit Aufwecken zu tun.

Gucken muss man immer nach der ersten Meldung nach "... disk 1 wake up from hibernation ...". Das erste was danach steht hat die Festplatte aufgeweckt.

Hier die Sammlung de Meldungen:

[/usr/syno/synoman/phpsrc/blog/login.php] opened by pid 3638 [u:(/usr/syno/apache/bin/httpd), comm:(httpd)] - Hat sich einer versucht bei Blog einzuloggen.
[/etc/localtime] opened by pid 1633 [u:(/usr/syno/bin/scemd), comm:(scemd)] - hat mit Zeit zu tun.
[/usr/syno/mediaserver/dmsicon48.png] opened by pid 2576 [u:(/usr/syno/sbin/dms), comm:(dms)] - DSM Zugriff
[/var/log/messages] opened by pid 1057 [u:(/sbin/syslogd), comm:(syslogd)] - Logdatei wird geschrieben
[/var/log/messages] opened by pid 1057 [u:(/sbin/syslogd), comm:(syslogd)] - das Selbe.
[/var/log/messages] opened by pid 1057 [u:(/sbin/syslogd), comm:(syslogd)] - wieder Logdatei
drivers/scsi/sd.c[469]:sd_prep_fn(), sda: cmd 0x0 spin up by pid=15958, comm=httpd - keine Ahnung, sieht nach SCSI-Laufwerk aus
... Logdatei
[/usr/syno/mediaserver/dmsicon48.png] opened by pid 3775 [u:(/usr/syno/sbin/dms), comm:(dms)] - Webzugriff
[/var/log/messages] opened by pid 1865 [u:(/sbin/syslogd), comm:(syslogd)] - Logdatei wird geschrieben
[/usr/syno/mediaserver/dmsicon48.png] opened by pid 3787 [u:(/usr/syno/sbin/dms), comm:(dms)] - Webzugriff
drivers/scsi/sd.c[471]:sd_prep_fn(), sda: cmd 0x0 spin up by pid=3899, comm=dms, ?, danach localtime 
[/etc/localtime] opened by pid 2605 [u:(/usr/syno/bin/scemd), comm:(scemd)] - Zeit
[/usr/syno/mediaserver/dmsicon48.png] opened by pid 3899 [u:(/usr/syno/sbin/dms), comm:(dms)] - Webzugriff
[/etc/localtime] opened by pid 2605 [u:(/usr/syno/bin/scemd), comm:(scemd)] - Zeit
... SCSI, Zeit
[/usr/.htaccess] opened by pid 4086 [u:(/usr/syno/apache/bin/httpd), comm:(httpd)] - Webzugriff
[/var/log/messages] opened by pid 1865 [u:(/sbin/syslogd), comm:(syslogd)] - Logdstei
... Zeit
... Zeit
[/var/run/cups/certs/0] opened by pid 3540 [u:(/usr/syno/sbin/cupsd), comm:(cupsd)] - Druckprozess über DS

...
Das wars, ich finde da nichts.

 

[Matthieu]

Das wo du dahintergeschrieben hast "keine Ahnung, sieht nach iSCSI aus" war in äußerst vielen Fällen jbd. Und da das außerdem oft an erster Stelle stand nach "Wake up from Hibernation", weiß ich nicht was das nicht damit zu tun haben soll ... les dir bitte erst mal den Thread durch bevor du in so einer komplexen Sache neue Ansätze suchst, einige Punkte wurden auch schon gebracht die du da ansprichst, oder verschaff dir wenigstens einen Überblick ...
Wenn du dir jetzt ein Stück Log aus den über 30 Seiten die mir vorliegen nimmst, kommst du natürlich zu einem anderen Schluss, aber er hat ja konkret gesagt, wann er was gemacht hat und damit ließ sich einiges zurückverfolgen und schlussendlich blieb nur jbd unerklärlich und zwar häufig alleine in den Meldungen, sprich nur er hat die DS aufgeweckt.
Wenn es übrigens das Zeitupdate gewesen wäre, hätte man das an der PID erkannt. localtime wird für die Logs benötigt, die müssen ja ihre Zeit irgendwo her nehmen.

MfG Matthieu

 

[macondo]

wir konnten wirklich schon ne ganze menge klären... zum beispiel pid 3899, die immer die ds geweckt und diese png icon geladen hat, war wohl die windows mediaplayer netzwerkfreigabe, bzw. der dienst dazu. seitdem der auf den beiden rechnern im heimnetz deaktiviert wurde, ist da ruhe. im moment weiß ich zb nur nicht, wieso ein druckprozess (cupsd) die ds geweckt haben soll... und natürlich das jbd2 thema.

 

[Hruendel]

Das wo du dahintergeschrieben hast "keine Ahnung, sieht nach iSCSI aus" war in äußerst vielen Fällen jbd. Und da das außerdem oft an erster Stelle stand nach "Wake up from Hibernation", weiß ich nicht was das nicht damit zu tun haben soll ... les dir bitte erst mal den Thread durch bevor du in so einer komplexen Sache neue Ansätze suchst, einige Punkte wurden auch schon gebracht die du da ansprichst, oder verschaff dir wenigstens einen Überblick ...

Den Thread habe ich schon mehrmals komplett durchgelesen.

drivers/scsi/sd.c ist der SATA Treiber. Dieser prüft warscheinlich ab und an ob die Platte noch da ist (TIMEOUT).

Wenn du dir jetzt ein Stück Log aus den über 30 Seiten die mir vorliegen nimmst, kommst du natürlich zu einem anderen Schluss, aber er hat ja konkret gesagt, wann er was gemacht hat und damit ließ sich einiges zurückverfolgen und schlussendlich blieb nur jbd unerklärlich und zwar häufig alleine in den Meldungen, sprich nur er hat die DS aufgeweckt.

Wenn es übrigens das Zeitupdate gewesen wäre, hätte man das an der PID erkannt. localtime wird für die Logs benötigt, die müssen ja ihre Zeit irgendwo her nehmen.

jbd2 ist die physikalische Festplatte. Diese wird nur in Zusammenhang mit dem Pfad jbd2/sda1... in den Logs angegeben.
Sonst wenn es störrt das die DS aufwacht kann man sie auch ausschalten. Habe zum Beispiel unter Powermanagement nur das Ausschalten so gegen 3.00 aktiviert. Wenn ich sie brauche schalte ich sie ein.

Sonst kann man eine Hardware Firewall wie Zyxel Zywall 2 Plus oder ähnliche besorgen und Mitschnitte der Verbindungen machen. Da wird man sich sehr wundern vieviel Müll aus dem Windows PC läuft.

 

[goetz]

Hallo,
cups wird immer gestartet, auch wenn keine Drucker vorhanden sind. So kann im laufenden Betrieb ein neuer Drucker hinzugefügt und eingerichtet werden. Windows sucht auch ganz gern allein Drucker im Netzwerk, so könnte es sein, daß cups auf diese Anfrage reagiert. Wenn man /usr/syno/etc/rc.d/S55cupsd.sh die Ausführungsrechte entzieht sollte Ruhe sein.
Was sagt auf der Konsole
free

Gruß Götz

 

[macondo]

Was sagt auf der Konsole
free

was meinst du damit?

danke für die erläuterung zu cups, das klingt nach einer schlüssigen erklärung... vielleicht hat wirklich windows frecherweise die ds aufgeweckt und einfach mal nachgefragt, ob sie einen drucker angeschlossen hat... ist ja wirklich ein neugieriges ding... ;-)

dann bleibt nur noch die frage, was es genau mit dem jbd2 prozessen auf sich hat... wieso diese manchmal alle 30min die ds aufwecken und manchmal nur einmal am tag, dann aber immer wieder gerne um 14:43:34...

edit: zu kblockd habe ich folgendes gefunden -> "kblockd is a kernel thread, essentially, it periodically activates the block device drivers"... also auch ok, wenn der prozess ab und zu mal gestartet wird...

 

[macondo]

so, die ds war nun fast 48h vom lan getrennt und wurde in der zeit nur einmal am tag geweckt... durch pid 407 wie immer um 14:43:34... ansonsten war ruhe.

nach dem anschließen des lan wachte sie wieder auf und machte ohne weitere einflüsse das folgende:

Apr  8 18:41:41 kernel: [636663.440000] [/etc/localtime] opened by pid 1867 [u:(/sbin/klogd), comm:(klogd)]
Apr  8 18:41:47 kernel: [636669.000000] drivers/scsi/sd.c[471]:sd_prep_fn(), sda: cmd 0x0 spin up by pid=407, comm=jbd2/sda1-8
Apr  8 18:41:47 kernel: [636669.010000] [/etc/localtime] opened by pid 1867 [u:(/sbin/klogd), comm:(klogd)]
Apr  8 18:41:47 scemd: SCEMD: disk 1 wake up from hibernation
Apr  8 18:41:51 kernel: [636672.250000] [/var/log/messages] opened by pid 1865 [u:(/sbin/syslogd), comm:(syslogd)]
Apr  8 18:47:46 kernel: [637027.990000] [/usr/syno/synoman/phpsrc/web/] opened by pid 1094 [u:(/usr/syno/apache/bin/httpd), comm:(httpd)]
Apr  8 18:48:14 kernel: [637055.820000] [/usr/syno/synoman/phpsrc/photo/] opened by pid 13035 [u:(/usr/syno/apache/bin/httpd), comm:(httpd)]
Apr  8 18:48:24 kernel: [637065.440000] [/usr/syno/synoman/phpsrc/web/crossdomain.xml] opened by pid 29087 [u:(/usr/syno/apache/bin/httpd), comm:(httpd)]
Apr  8 18:48:38 kernel: [637079.160000] [/usr/syno/synoman/phpsrc/photo/scripts/extjs/resources/images/aero/basic-dialog/bg-left.gif] opened by pid 1094 [u:(/usr/syno/apache/bin/httpd), comm:(httpd)]
Apr  8 18:48:38 kernel: [637079.170000] [/usr/syno/synoman/phpsrc/photo/scripts/extjs/resources/images/aero/basic-dialog/hd-sprite.gif] opened by pid 29058 [u:(/usr/syno/apache/bin/httpd), comm:(httpd)]
Apr  8 18:48:39 kernel: [637080.780000] [/etc/group] opened by pid 29344 [u:(/usr/syno/apache/bin/httpd), comm:(httpd)]
Apr  8 18:48:45 kernel: [637086.150000] [/usr/syno/synoman/phpsrc/photo/scripts/extjs/resources/images/default/qtip/bg.gif] opened by pid 29344 [u:(/usr/syno/apache/bin/httpd), comm:(httpd)]
Apr  8 18:48:50 kernel: [637091.220000] [/usr/syno/synoman/phpsrc/photo/photo_thumb.php] opened by pid 29087 [u:(/usr/syno/apache/bin/httpd), comm:(httpd)]
Apr  8 18:49:04 kernel: [637105.220000] [/usr/syno/synoman/phpsrc/web/crossdomain.xml] opened by pid 29358 [u:(/usr/syno/apache/bin/httpd), comm:(httpd)]
Apr  8 18:49:07 kernel: [637109.060000] [/etc/group] opened by pid 29704 [u:(/usr/syno/apache/bin/httpd), comm:(httpd)]
Apr  8 18:49:09 kernel: [637110.600000] [/usr/syno/synoman/phpsrc/photo/convert.php] opened by pid 29360 [u:(/usr/syno/apache/bin/httpd), comm:(httpd)]
Apr  8 18:49:13 kernel: [637114.110000] [/usr/syno/synoman/phpsrc/photo/convert.php] opened by pid 29344 [u:(/usr/syno/apache/bin/httpd), comm:(httpd)]
Apr  8 18:49:14 kernel: [637116.040000] [/usr/syno/synoman/phpsrc/photo/convert.php] opened by pid 29360 [u:(/usr/syno/apache/bin/httpd), comm:(httpd)]
Apr  8 18:49:17 kernel: [637118.150000] [/usr/syno/synoman/phpsrc/photo/convert.php] opened by pid 29344 [u:(/usr/syno/apache/bin/httpd), comm:(httpd)]
Apr  8 18:49:19 kernel: [637120.180000] [/usr/syno/synoman/phpsrc/photo/convert.php] opened by pid 29360 [u:(/usr/syno/apache/bin/httpd), comm:(httpd)]
Apr  8 18:49:20 kernel: [637121.590000] [/usr/syno/synoman/phpsrc/photo/convert.php] opened by pid 29344 [u:(/usr/syno/apache/bin/httpd), comm:(httpd)]
Apr  8 18:49:24 kernel: [637125.960000] [/usr/syno/synoman/phpsrc/photo/convert.php] opened by pid 29344 [u:(/usr/syno/apache/bin/httpd), comm:(httpd)]
Apr  8 18:49:27 kernel: [637128.780000] [/usr/syno/synoman/phpsrc/photo/convert.php] opened by pid 29344 [u:(/usr/syno/apache/bin/httpd), comm:(httpd)]
Apr  8 18:49:30 kernel: [637131.450000] [/usr/syno/synoman/phpsrc/photo/convert.php] opened by pid 29344 [u:(/usr/syno/apache/bin/httpd), comm:(httpd)]
Apr  8 18:49:35 kernel: [637136.400000] [/usr/syno/synoman/phpsrc/photo/convert.php] opened by pid 29344 [u:(/usr/syno/apache/bin/httpd), comm:(httpd)]
Apr  8 18:49:40 kernel: [637142.040000] [/usr/syno/synoman/phpsrc/photo/convert.php] opened by pid 29330 [u:(/usr/syno/apache/bin/httpd), comm:(httpd)]
Apr  8 18:49:51 kernel: [637152.100000] [pg_clog/0000] opened by pid 2510 [u:(postgres: writer process   ), comm:(postgres)]

ich nehme mal an, das ist alles normal... oder? es war kein rechner im lan angeschaltet.

 

[Matthieu]

Geht das mit den Webzugriffen wieder los ... du musst dich damit abfinden oder deine Portweiterleitung abschalten.

MfG Matthieu