Šílěně pomalé vypínaní systému - MGA5

[Rellik]

Zdravím vespolek. Měl bych jeden dotaz nebo spíš bych chtěl info ohledně vypínání MGA5. Oproti startu, který trvá pár sekund je vypínání až neskutečně pomalé. Například včera jsem dal vypnout PC a ani po20 minutách se nic nedělo, tak jsem to vypl natvrdo podržením vypinače. Dřív jsem to bral jako, že to stahovalo aktualizace a pak se to při vypínání nějak zapisovalo (moje dedukce). Nicméně včerejší prodleva trvající snad delší dobu než samotná instalace systému mě tuž trošku naštvala.
Bohužel nevím co přesně se u vypínání děje, ale spouští se tam nějaká služba (BSE, LSB, BSL nebo tak něco a shuting down) a to tedy nevím proč se něco spouští když to chci vypnout. Nemá někdo nějaké řešení nebo info proč to tak dělá?
Pro pořádek opakuji: Týká se to MGA5.
Jinak celý systém mám na SSD disku http://www.crucial.com/usa/en/ct128mx100ssd1 takže pomalostí disku to asi nebude (16Gb ram, i3-4330 CPU @ 3.50GHz).
Díky za jakoukoliv odpověď

[Rellik]

Včera opět to samé. Vypínání cca 10 minut. Přidávám fotku obrazovky na co to vlastně čeká...

[Pavel Vybíral]

Ahoj.
To, co ti to při vypínání vypisuje, podle mě nejsou zprávy z vypínání, ale jenom pozůstatky z bootu. Teda nevím jak u ostatních, ale u mě vypadají zprávy z vypínání systému úplně jinak a hlavně je jich tam podstatně víc. :-)
Nemáš na počítači diodu indikující práci disku? Jestli jo, bliká během vypínání nebo je disk skoro nečinný?

Bohužel teda nevím, v jakým souboru se dají najít logy z vypínání...Měl jsem za to, že to může být ve /var/log/dmesg.old nebo dmesg, ale já tam nic z vypínání nemám. U mě se na MGA4 občas stane, že se odmítá vypnout nějakej démon (v mým případě je to většinou TeamViewer) a vždycky musí asi po 3 minutách přijít na řadu jádro a toho démona prostě zabít (nebo si aspoň myslím, že to tak probíhá). Kdyžtak se zkus podívat, jestli tam taky nemáš nějakýho "speciálního" démona.

Jinak, jak asi víš, MGA5 je beta, takže je dost možný, že se to třeba po přechodu na RC opraví samo.

[Rellik]

Jo vím, že to není ještě plná verze. Takže doufám, že se to pak třeba opraví (pokud tento problém tedy nemám jen já ). Jinak diodu HDD mám a právě podle ní to vypadá, že to celou dobu nic nedělá, pak to "zachrochtá" a vypne. Přitom restart na nic nečeká a hned restartuje. Nicméně neřekl bych, že je to něco od startu systému, jelikož se to evidentně spouští až po vypnutí... Zkusím nahrát video a dát sem odkaz... Do těch logů jsem nahlédal, ale nic o vypínání nenašel...

[Pavel Vybíral]

Tu hlášku s LSB občas vídávám při vypínání taky, ale jen před tím, než se mi spustí splash screen a nikdy mi to problémy nezpůsobovalo. Jestli HDD během vypínání nic nedělá, opravdu by se to chtělo podívat po nějakým tom démonovi. Víc ti bohužel poradit nedokážu.

[Rellik]

JO v pohodě. jen dodám, že pokud byl systém nainstalovaný čerstvě, tak se vypínal rychlostí blesku. Jediné doinstalované věci, které se pak spouští jsou součásti webservru - apache + mysql (provozováno pouze na PC - ven to nejde). Jinak schválně jsem natočil ty videa.
Jedno z nejkratších vypínání - https://youtu.be/mPFnpY25vos
A klasické zapínání - https://youtu.be/1GDsHyl8ms4
Tak nevím no... Uvidíme tedy časem po dalších aktualizacích.
Jinak našel jsem i nějaký BUG - https://forums.mageia.org/en/viewtopic.php?f=7&t=6459 https://bugs.mageia.org/show_bug.cgi?id=11102 Ale zda je aktuální i v MGA5 netuším...

[Pavel Vybíral]

Aha, tak tady bude asi chyba jinde než v démonovi, protože tobě se to čekání projevuje ještě před zapnutím splash screenu, což by se v případě neschopnosti ukončit démona nemělo stávat. Co se těch nalezených bugů týká, tak si nejsem úplně jistej, jestli to bude tím. Chybu [FAILED] Failed to start LSB: Bring up/down networking vídávám při startu každej den, ale nikdy to u mě nezpůsobilo žádnej problém. Víc už k tomu asi fakt říct nemůžu

Jinak díky za to video se spouštěním systému na SSD, zajímalo mě, jak dlouho ten start s SSD trvá.

[Yullaw]

@Rellik:
Jakmile se ti PC opět kousne při vypnutí/restartu, restartuj PC reset tlačítkem a pak opět nabootuj Mageiu. Po přihlášení do prostředí otevři konzoli a zadej:

Kód: [Vybrat]

journalctl -a -b-1 | tail -750což dle komentáře forums.mageia.org - Re: slow to close the computer znamená zobrazit všechny (-a) záznamy během posledního (-b-1) nebo např. předposledního (pak -b-2) spuštění/vypnutí.

Tento příkaz jsme již řešili zde: http://forum.mageia.cz/index.php?topic=699.msg5647#msg5647

Nebo si zobraz nápovědu příkazem: journalctl --help

Výpis zkopíruj dle času a pošli sem (jak na to: http://wiki.mageia.cz/_media/forum:video:jak_pridat_vystup_do_kodu_v_prispevku.ogg).

[Rellik]

Takž včera se mi to opět vypínalo velmi dlouze.
Tady je tedy výpis asi při vypínání (podle času).
Ono to sice vypadá, jako by se to vyplo za 2s, ale trvalo to minimálně 10 minut.

Kód: [Vybrat]

dub 15 20:47:15 localhost org.kde.kuiserver[3174]: kuiserver: Fatal IO error: client killed
dub 15 20:47:15 localhost org.a11y.atspi.Registry[4335]: XIO:  fatal IO error 11 (Resource temporarily unavailable) on X server ":0"
dub 15 20:47:15 localhost org.a11y.atspi.Registry[4335]: after 13101 requests (13101 known processed) with 0 events remaining.
dub 15 20:47:15 localhost org.a11y.Bus[3174]: g_dbus_connection_real_closed: Remote peer vanished with error: Underlying GIOStream returned 0 bytes on an async read (g-io-error-quark, 0). Exiting.
dub 15 20:47:16 localhost systemd[3027]: Stopping Sound Service...
dub 15 20:47:16 localhost systemd[3027]: Stopping Default.
dub 15 20:47:16 localhost systemd[3027]: Stopped target Default.
dub 15 20:47:16 localhost systemd[3027]: pulseaudio.service: main process exited, code=exited, status=1/FAILURE
dub 15 20:47:16 localhost systemd[3027]: Stopped Sound Service.
dub 15 20:47:16 localhost systemd[3027]: Unit pulseaudio.service entered failed state.
dub 15 20:47:16 localhost systemd[3027]: pulseaudio.service failed.
dub 15 20:47:16 localhost systemd[3027]: Stopping Basic System.
dub 15 20:47:16 localhost systemd[3027]: Stopped target Basic System.
dub 15 20:47:16 localhost systemd[3027]: Stopping Paths.
dub 15 20:47:16 localhost systemd[3027]: Stopped target Paths.
dub 15 20:47:16 localhost systemd[3027]: Stopping Timers.
dub 15 20:47:16 localhost systemd[3027]: Stopped target Timers.
dub 15 20:47:16 localhost systemd[3027]: Stopping Sockets.
dub 15 20:47:16 localhost systemd[3027]: Stopped target Sockets.
dub 15 20:47:16 localhost systemd[3027]: Stopping Sound System.
dub 15 20:47:16 localhost systemd[3027]: Closed Sound System.
dub 15 20:47:16 localhost systemd[3027]: Stopping -.slice.
dub 15 20:47:16 localhost systemd[3027]: Removed slice -.slice.
dub 15 20:47:16 localhost systemd[3027]: Starting Shutdown.
dub 15 20:47:16 localhost systemd[3027]: Reached target Shutdown.
dub 15 20:47:16 localhost systemd[3027]: Starting Exit the Session...
dub 15 20:47:16 localhost systemd[3027]: Received SIGRTMIN+24 from PID 14369 (kill).
dub 15 20:47:16 localhost systemd[3029]: pam_tcb(systemd-user:session): Session closed for rellik
[rellik@localhost ~]$
A pro jistotu ještě celý kód:

Kód: [Vybrat]

[rellik@localhost ~]$ journalctl -a -b-1 | tail -750
-- Logs begin at Pá 2015-03-06 19:29:25 CET, end at Čt 2015-04-16 15:28:37 CEST. --
dub 15 15:18:00 localhost systemd[3027]: Starting Paths.
dub 15 15:18:00 localhost systemd[3027]: Reached target Paths.
dub 15 15:18:00 localhost systemd[3027]: Starting Timers.
dub 15 15:18:00 localhost systemd[3027]: Reached target Timers.
dub 15 15:18:00 localhost systemd[3027]: Starting -.slice.
dub 15 15:18:00 localhost systemd[3027]: Created slice -.slice.
dub 15 15:18:00 localhost systemd[3027]: Starting Sound System.
dub 15 15:18:00 localhost systemd[3027]: Listening on Sound System.
dub 15 15:18:00 localhost systemd[3027]: Starting Sockets.
dub 15 15:18:00 localhost systemd[3027]: Reached target Sockets.
dub 15 15:18:00 localhost systemd[3027]: Starting Basic System.
dub 15 15:18:00 localhost systemd[3027]: Reached target Basic System.
dub 15 15:18:00 localhost systemd[3027]: Starting Default.
dub 15 15:18:00 localhost systemd[3027]: Reached target Default.
dub 15 15:18:00 localhost systemd[3027]: Startup finished in 56ms.
dub 15 15:18:03 localhost systemd[3027]: Starting Sound Service...
dub 15 15:18:03 localhost systemd[3027]: Started Sound Service.
dub 15 15:18:04 localhost pulseaudio[3402]: W: [pulseaudio] server-lookup.c: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
dub 15 15:18:04 localhost pulseaudio[3402]: W: [pulseaudio] main.c: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
dub 15 15:18:04 localhost hp-systray[3418]: hp-systray[3418]: error: option -s not recognized
dub 15 15:18:06 localhost mgaapplet[4165]: ### Program is starting ###
dub 15 15:18:06 localhost net_applet[4168]: ### Program is starting ###
dub 15 15:18:06 localhost org.a11y.Bus[3174]: Activating service name='org.a11y.atspi.Registry'
dub 15 15:18:06 localhost org.a11y.Bus[3174]: Successfully activated service 'org.a11y.atspi.Registry'
dub 15 15:18:06 localhost org.a11y.atspi.Registry[4335]: SpiRegistry daemon is running with well-known name - org.a11y.atspi.Registry
dub 15 15:18:06 localhost org.a11y.atspi.Registry[4335]: Xlib:  extension "XEVIE" missing on display ":0".
dub 15 15:18:07 localhost mgaapplet[4165]: running: ionice -p 4165 -n7
dub 15 15:23:07 localhost mgaapplet[4165]: Computing new updates...
dub 15 15:23:07 localhost mgaapplet[4165]: running: mgaapplet-update-checker
dub 15 15:23:07 localhost mgaapplet-update-checker[24798]: ### Program is starting ###
dub 15 15:23:08 localhost mgaapplet-update-checker[24798]: running: urpmi.update -a
dub 15 15:23:08 localhost pkexec[24809]: pam_tcb(polkit-1:session): Session opened for root by (uid=1000)
dub 15 15:23:11 localhost mgaapplet-update-checker[24798]: updating inactive backport media Core Backports (distrib7), Nonfree Backports (distrib17), Tainted Backports (distrib27), Core 32bit Backports (distrib34), Nonfree 32bit Backports (distrib39), Tainted 32bit Backports (distrib44)
dub 15 15:23:11 localhost mgaapplet-update-checker[24798]: running: urpmi.update Core Backports (distrib7)
dub 15 15:23:11 localhost pkexec[26252]: pam_tcb(polkit-1:session): Session opened for root by (uid=1000)
dub 15 15:23:11 localhost mgaapplet-update-checker[24798]: running: urpmi.update Nonfree Backports (distrib17)
dub 15 15:23:11 localhost pkexec[26260]: pam_tcb(polkit-1:session): Session opened for root by (uid=1000)
dub 15 15:23:11 localhost mgaapplet-update-checker[24798]: running: urpmi.update Tainted Backports (distrib27)                                                                                                     
dub 15 15:23:11 localhost pkexec[26268]: pam_tcb(polkit-1:session): Session opened for root by (uid=1000)                                                                                                         
dub 15 15:23:11 localhost mgaapplet-update-checker[24798]: running: urpmi.update Core 32bit Backports (distrib34)                                                                                                 
dub 15 15:23:11 localhost pkexec[26276]: pam_tcb(polkit-1:session): Session opened for root by (uid=1000)                                                                                                         
dub 15 15:23:12 localhost mgaapplet-update-checker[24798]: running: urpmi.update Nonfree 32bit Backports (distrib39)                                                                                               
dub 15 15:23:12 localhost pkexec[26284]: pam_tcb(polkit-1:session): Session opened for root by (uid=1000)                                                                                                         
dub 15 15:23:12 localhost mgaapplet-update-checker[24798]: running: urpmi.update Tainted 32bit Backports (distrib44)                                                                                               
dub 15 15:23:12 localhost pkexec[26292]: pam_tcb(polkit-1:session): Session opened for root by (uid=1000)                                                                                                         
dub 15 15:23:13 localhost mgaapplet[4165]: Checking... Updates are available                                                                                                                                       
dub 15 17:02:28 localhost mgaapplet[4165]: Launching MageiaUpdate                                                                                                                                                 
dub 15 17:02:28 localhost mgaapplet[4165]: running: MageiaUpdate --no-media-update --no-confirmation --no-splash                                                                                                   
dub 15 17:02:28 localhost polkit-agent-helper-1[17882]: pam_tcb(polkit-1:auth): Authentication passed for rellik from (uid=1000)                                                                                   
dub 15 17:02:28 localhost pkexec[17880]: pam_tcb(polkit-1:session): Session opened for root by (uid=1000)                                                                                                         
dub 15 17:03:38 localhost mgaapplet[4165]: Computing new updates...
dub 15 17:03:38 localhost mgaapplet[4165]: running: mgaapplet-update-checker
dub 15 17:03:38 localhost mgaapplet-update-checker[31963]: ### Program is starting ###
dub 15 17:03:38 localhost mgaapplet-update-checker[31963]: running: urpmi.update -a
dub 15 17:03:39 localhost pkexec[31974]: pam_tcb(polkit-1:session): Session opened for root by (uid=1000)
dub 15 17:03:40 localhost mgaapplet-update-checker[31963]: updating inactive backport media Core Backports (distrib7), Nonfree Backports (distrib17), Tainted Backports (distrib27), Core 32bit Backports (distrib34), Nonfree 32bit Backports (distrib39), Tainted 32bit Backports (distrib44)
dub 15 17:03:40 localhost mgaapplet-update-checker[31963]: running: urpmi.update Core Backports (distrib7)
dub 15 17:03:40 localhost pkexec[1008]: pam_tcb(polkit-1:session): Session opened for root by (uid=1000)
dub 15 17:03:40 localhost mgaapplet-update-checker[31963]: running: urpmi.update Nonfree Backports (distrib17)
dub 15 17:03:40 localhost pkexec[1016]: pam_tcb(polkit-1:session): Session opened for root by (uid=1000)
dub 15 17:03:41 localhost mgaapplet-update-checker[31963]: running: urpmi.update Tainted Backports (distrib27)
dub 15 17:03:41 localhost pkexec[1024]: pam_tcb(polkit-1:session): Session opened for root by (uid=1000)
dub 15 17:03:41 localhost mgaapplet-update-checker[31963]: running: urpmi.update Core 32bit Backports (distrib34)
dub 15 17:03:41 localhost pkexec[1032]: pam_tcb(polkit-1:session): Session opened for root by (uid=1000)
dub 15 17:03:41 localhost mgaapplet-update-checker[31963]: running: urpmi.update Nonfree 32bit Backports (distrib39)
dub 15 17:03:41 localhost pkexec[1040]: pam_tcb(polkit-1:session): Session opened for root by (uid=1000)
dub 15 17:03:41 localhost mgaapplet-update-checker[31963]: running: urpmi.update Tainted 32bit Backports (distrib44)
dub 15 17:03:41 localhost pkexec[1049]: pam_tcb(polkit-1:session): Session opened for root by (uid=1000)
dub 15 17:03:42 localhost mgaapplet[4165]: Packages are up to date
dub 15 18:23:07 localhost mgaapplet[4165]: Computing new updates...
dub 15 18:23:07 localhost mgaapplet[4165]: running: mgaapplet-update-checker
dub 15 18:23:07 localhost mgaapplet-update-checker[8634]: ### Program is starting ###
dub 15 18:23:08 localhost mgaapplet-update-checker[8634]: running: urpmi.update -a
dub 15 18:23:08 localhost pkexec[8645]: pam_tcb(polkit-1:session): Session opened for root by (uid=1000)
dub 15 18:23:09 localhost mgaapplet-update-checker[8634]: updating inactive backport media Core Backports (distrib7), Nonfree Backports (distrib17), Tainted Backports (distrib27), Core 32bit Backports (distrib34), Nonfree 32bit Backports (distrib39), Tainted 32bit Backports (distrib44)
dub 15 18:23:09 localhost mgaapplet-update-checker[8634]: running: urpmi.update Core Backports (distrib7)
dub 15 18:23:09 localhost pkexec[8663]: pam_tcb(polkit-1:session): Session opened for root by (uid=1000)
dub 15 18:23:09 localhost mgaapplet-update-checker[8634]: running: urpmi.update Nonfree Backports (distrib17)
dub 15 18:23:09 localhost pkexec[8671]: pam_tcb(polkit-1:session): Session opened for root by (uid=1000)
dub 15 18:23:10 localhost mgaapplet-update-checker[8634]: running: urpmi.update Tainted Backports (distrib27)
dub 15 18:23:10 localhost pkexec[9439]: pam_tcb(polkit-1:session): Session opened for root by (uid=1000)
dub 15 18:23:10 localhost mgaapplet-update-checker[8634]: running: urpmi.update Core 32bit Backports (distrib34)
dub 15 18:23:10 localhost pkexec[10100]: pam_tcb(polkit-1:session): Session opened for root by (uid=1000)
dub 15 18:23:11 localhost mgaapplet-update-checker[8634]: running: urpmi.update Nonfree 32bit Backports (distrib39)
dub 15 18:23:11 localhost pkexec[10108]: pam_tcb(polkit-1:session): Session opened for root by (uid=1000)
dub 15 18:23:11 localhost mgaapplet-update-checker[8634]: running: urpmi.update Tainted 32bit Backports (distrib44)
dub 15 18:23:11 localhost pkexec[10117]: pam_tcb(polkit-1:session): Session opened for root by (uid=1000)
dub 15 18:23:12 localhost mgaapplet[4165]: Packages are up to date
dub 15 20:47:15 localhost org.kde.kuiserver[3174]: kuiserver: Fatal IO error: client killed
dub 15 20:47:15 localhost org.a11y.atspi.Registry[4335]: XIO:  fatal IO error 11 (Resource temporarily unavailable) on X server ":0"
dub 15 20:47:15 localhost org.a11y.atspi.Registry[4335]: after 13101 requests (13101 known processed) with 0 events remaining.
dub 15 20:47:15 localhost org.a11y.Bus[3174]: g_dbus_connection_real_closed: Remote peer vanished with error: Underlying GIOStream returned 0 bytes on an async read (g-io-error-quark, 0). Exiting.
dub 15 20:47:16 localhost systemd[3027]: Stopping Sound Service...
dub 15 20:47:16 localhost systemd[3027]: Stopping Default.
dub 15 20:47:16 localhost systemd[3027]: Stopped target Default.
dub 15 20:47:16 localhost systemd[3027]: pulseaudio.service: main process exited, code=exited, status=1/FAILURE
dub 15 20:47:16 localhost systemd[3027]: Stopped Sound Service.
dub 15 20:47:16 localhost systemd[3027]: Unit pulseaudio.service entered failed state.
dub 15 20:47:16 localhost systemd[3027]: pulseaudio.service failed.
dub 15 20:47:16 localhost systemd[3027]: Stopping Basic System.
dub 15 20:47:16 localhost systemd[3027]: Stopped target Basic System.
dub 15 20:47:16 localhost systemd[3027]: Stopping Paths.
dub 15 20:47:16 localhost systemd[3027]: Stopped target Paths.
dub 15 20:47:16 localhost systemd[3027]: Stopping Timers.
dub 15 20:47:16 localhost systemd[3027]: Stopped target Timers.
dub 15 20:47:16 localhost systemd[3027]: Stopping Sockets.
dub 15 20:47:16 localhost systemd[3027]: Stopped target Sockets.
dub 15 20:47:16 localhost systemd[3027]: Stopping Sound System.
dub 15 20:47:16 localhost systemd[3027]: Closed Sound System.
dub 15 20:47:16 localhost systemd[3027]: Stopping -.slice.
dub 15 20:47:16 localhost systemd[3027]: Removed slice -.slice.
dub 15 20:47:16 localhost systemd[3027]: Starting Shutdown.
dub 15 20:47:16 localhost systemd[3027]: Reached target Shutdown.
dub 15 20:47:16 localhost systemd[3027]: Starting Exit the Session...
dub 15 20:47:16 localhost systemd[3027]: Received SIGRTMIN+24 from PID 14369 (kill).
dub 15 20:47:16 localhost systemd[3029]: pam_tcb(systemd-user:session): Session closed for rellik
[rellik@localhost ~]$