[systemd] Mise en veille très lente

[hansi]

Bonjour à tous,

Voilà un nouveau problème, la mise en veille (suspend to ram) ne fonctionne pas correctement. Déjà l'endormissement met un temps fou, genre 1 minute... Mais ensuite le réveil échoue, on dirait que ça fonctionne mais en fait non car l'écran reste noir, le ventilo s'emballe et les diodes sont en mode plantage.

J'ai donc réinstallé et configuré pm-utils en suivant la page du wiki à la lettre mais ça ne change rien :-/

Une idée de comment y remédier svp ?

Merci

[hansi]

Donc après recherches j'ai essayé de downgrader systemd, pm-utils, d'enlever autodetect des hooks du mkinitcpio.conf ou d'ajouter le hook resume mais rien à faire ça ne fonctionne pas !
Quelle poisse ! Est-ce que ça pourrait venir de xorg 1.15 ? Ou d'xfce-power-manager ?

[bobo]

Es-tu sûr·e que ça vienne de XFCE ? Plusieurs pistes pour troubleshooter ça :
— tester la mise en veille par ligne de commande "systemctl suspend" dans un terminal – ça roule chez moi sans droit admin
— tester la mise en veille sur un autre environnement de bureau

(de mon côté, j'ai des soucis de veille récurrents : ça concerne la mise en veille automatique)

[hansi]

Salut,

Pour Xfce non je n'en suis pas sûr. En fait je viens de désinstaller pm-utils et d'installer xfce4-power-manager-nodep du coup ça refonctionne à peu près, la machine se met en veille mais vraiment très lentement comparé à avant.
Et c'est exactement pareil avec la commande systemctl suspend. Ça fonctionne mais il se passe bien 30 secondes jusqu'à ce que la croissant de lune soit allumé. Alors qu'avant c'était instantané

[bobo]

Et c'est exactement pareil avec la commande systemctl suspend. Ça fonctionne mais il se passe bien 30 secondes jusqu'à ce que la croissant de lune soit allumé. Alors qu'avant c'était instantané

Ce n'est donc pas un soucis de xfce… cqfd.

Peut-être faut-il éditer le sujet du fil. Ou mieux en ouvrir un autre en partant de ce symptôme (intitulé « mise en veille très lente avec "systemctl suspend" » par exemple). Une petite notification sur ce fil serait un plus .

Bon courage

[benjarobin]

Les logs complet suite à une mise en veille et son retour serait intéressant (en root) :

Code : Tout sélectionner

journalctl --no-pager -b

[hansi]

Bah disons qu'apparemment il y a quand même quelque chose qui coince avec pm-utils et le xfce-power-manager par défaut... Mais ok je vais modifier le sujet et poster les logs dès que j'ai retrouvé mon PC !

Edit: Est-ce qu'un modo pourrait déplacer le sujet dans le bon forum svp ? Merci

[hansi]

Et voilà l'extrait du log indiqué par benjarobin

Code : Tout sélectionner

mai 18 22:04:13 jlaptop systemd[1]: Starting Sleep.
mai 18 22:04:13 jlaptop systemd[1]: Reached target Sleep.
mai 18 22:04:13 jlaptop systemd[1]: Starting Suspend...
mai 18 22:04:13 jlaptop polkitd[668]: Unregistered Authentication Agent for unix-process:16946:3683884 (system bus name :1.26, object path /org/freedesktop/PolicyKit1/AuthenticationAgent, locale fr_FR.UTF-8) (disconnected from bus)
mai 18 22:04:13 jlaptop systemd-sleep[16950]: Suspending system...
mai 18 22:04:13 jlaptop kernel: PM: Syncing filesystems ... done.
mai 18 22:04:13 jlaptop kernel: PM: Preparing system for mem sleep
mai 19 10:21:01 jlaptop kernel: Freezing user space processes ... (elapsed 0.001 seconds) done.
mai 19 10:21:01 jlaptop kernel: Freezing remaining freezable tasks ... (elapsed 0.000 seconds) done.
mai 19 10:21:01 jlaptop kernel: PM: Entering mem sleep
mai 19 10:21:01 jlaptop kernel: Suspending console(s) (use no_console_suspend to debug)
mai 19 10:21:01 jlaptop kernel: wlan0: deauthenticating from cc:b2:55:c8:58:b0 by local choice (reason=3)
mai 19 10:21:01 jlaptop kernel: cfg80211: Calling CRDA to update world regulatory domain
mai 19 10:21:01 jlaptop kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache
mai 19 10:21:01 jlaptop kernel: sd 0:0:0:0: [sda] Stopping disk
mai 19 10:21:01 jlaptop kernel: [drm] Disabling audio 0 support
mai 19 10:21:01 jlaptop kernel: PM: suspend of devices complete after 13931.925 msecs
mai 19 10:21:01 jlaptop kernel: PM: late suspend of devices complete after 0.249 msecs
mai 19 10:21:01 jlaptop kernel: PM: noirq suspend of devices complete after 54.596 msecs
mai 19 10:21:01 jlaptop kernel: ACPI: Preparing to enter system sleep state S3
mai 19 10:21:01 jlaptop kernel: PM: Saving platform NVS memory
mai 19 10:21:01 jlaptop kernel: Disabling non-boot CPUs ...
mai 19 10:21:01 jlaptop kernel: Removed affinity for 299 processes to cpu 1
mai 19 10:21:01 jlaptop kernel: smpboot: CPU 1 is now offline
mai 19 10:21:01 jlaptop kernel: Removed affinity for 298 processes to cpu 2
mai 19 10:21:01 jlaptop kernel: smpboot: CPU 2 is now offline
mai 19 10:21:01 jlaptop kernel: Removed affinity for 300 processes to cpu 3
mai 19 10:21:01 jlaptop kernel: smpboot: CPU 3 is now offline
mai 19 10:21:01 jlaptop kernel: ACPI: Low-level resume complete
mai 19 10:21:01 jlaptop kernel: PM: Restoring platform NVS memory
mai 19 10:21:01 jlaptop kernel: Enabling non-boot CPUs ...
mai 19 10:21:01 jlaptop kernel: x86: Booting SMP configuration:
mai 19 10:21:01 jlaptop kernel: smpboot: Booting Node 0 Processor 1 APIC 0x1
mai 19 10:21:01 jlaptop kernel: Added affinity for 236 processes to cpu 1
mai 19 10:21:01 jlaptop kernel: CPU1 is up
mai 19 10:21:01 jlaptop kernel: smpboot: Booting Node 0 Processor 2 APIC 0x4
mai 19 10:21:01 jlaptop kernel: Added affinity for 236 processes to cpu 2
mai 19 10:21:01 jlaptop kernel: CPU2 is up
mai 19 10:21:01 jlaptop kernel: smpboot: Booting Node 0 Processor 3 APIC 0x5
mai 19 10:21:01 jlaptop kernel: Added affinity for 236 processes to cpu 3
mai 19 10:21:01 jlaptop kernel: Released forced binding to cpu0 for 236 processes
mai 19 10:21:01 jlaptop kernel: CPU3 is up
mai 19 10:21:01 jlaptop kernel: ACPI: Waking up from system sleep state S3
mai 19 10:21:01 jlaptop kernel: acpi LNXPOWER:00: Turning ON
mai 19 10:21:01 jlaptop kernel: PM: noirq resume of devices complete after 99.159 msecs
mai 19 10:21:01 jlaptop kernel: PM: early resume of devices complete after 0.138 msecs
mai 19 10:21:01 jlaptop kernel: mei_me 0000:00:16.0: irq 40 for MSI/MSI-X
mai 19 10:21:01 jlaptop kernel: e1000e 0000:00:19.0: irq 43 for MSI/MSI-X
mai 19 10:21:01 jlaptop kernel: [drm] PCIE GART of 1024M enabled (table at 0x000000000025D000).
mai 19 10:21:01 jlaptop kernel: radeon 0000:05:00.0: WB enabled
mai 19 10:21:01 jlaptop kernel: radeon 0000:05:00.0: fence driver on ring 0 use gpu addr 0x0000000020000c00 and cpu addr 0xffff88024edffc00
mai 19 10:21:01 jlaptop kernel: radeon 0000:05:00.0: fence driver on ring 3 use gpu addr 0x0000000020000c0c and cpu addr 0xffff88024edffc0c
mai 19 10:21:01 jlaptop kernel: radeon 0000:05:00.0: fence driver on ring 5 use gpu addr 0x000000000005c418 and cpu addr 0xffffc9002151c418
mai 19 10:21:01 jlaptop kernel: [drm] ring test on 0 succeeded in 1 usecs
mai 19 10:21:01 jlaptop kernel: [drm] ring test on 3 succeeded in 1 usecs
mai 19 10:21:01 jlaptop kernel: [drm] ring test on 5 succeeded in 1 usecs
mai 19 10:21:01 jlaptop kernel: [drm] UVD initialized successfully.
mai 19 10:21:01 jlaptop kernel: [drm] Enabling audio 0 support
mai 19 10:21:01 jlaptop kernel: [drm] ib test on ring 0 succeeded in 0 usecs
mai 19 10:21:01 jlaptop kernel: [drm] ib test on ring 3 succeeded in 1 usecs
mai 19 10:21:01 jlaptop kernel: snd_hda_intel 0000:05:00.1: irq 44 for MSI/MSI-X
mai 19 10:21:01 jlaptop kernel: snd_hda_intel 0000:00:1b.0: irq 46 for MSI/MSI-X
mai 19 10:21:01 jlaptop kernel: [drm] ib test on ring 5 succeeded
mai 19 10:21:01 jlaptop kernel: usb 2-1.6: reset high-speed USB device number 4 using ehci-pci
mai 19 10:21:01 jlaptop kernel: ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
mai 19 10:21:01 jlaptop kernel: ata2: SATA link down (SStatus 0 SControl 300)
mai 19 10:21:01 jlaptop kernel: ata5: SATA link down (SStatus 0 SControl 300)
mai 19 10:21:01 jlaptop kernel: ata6: SATA link down (SStatus 0 SControl 300)
mai 19 10:21:01 jlaptop kernel: usb 2-1.1: reset high-speed USB device number 3 using ehci-pci
mai 19 10:21:01 jlaptop kernel: usb 1-1.3: reset full-speed USB device number 3 using ehci-pci
mai 19 10:21:01 jlaptop kernel: usb 1-1.6: reset high-speed USB device number 5 using ehci-pci
mai 19 10:21:01 jlaptop kernel: ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
mai 19 10:21:01 jlaptop kernel: ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
mai 19 10:21:01 jlaptop kernel: usb 1-1.5.4: reset high-speed USB device number 8 using ehci-pci
mai 19 10:21:01 jlaptop kernel: ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
mai 19 10:21:01 jlaptop kernel: ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
mai 19 10:21:01 jlaptop kernel: dpm_run_callback(): usb_dev_resume+0x0/0x10 [usbcore] returns -5
mai 19 10:21:01 jlaptop kernel: PM: Device 1-1.5.4 failed to resume async: error -5
mai 19 10:21:01 jlaptop kernel: ata1.00: configured for UDMA/133
mai 19 10:21:01 jlaptop kernel: sd 0:0:0:0: [sda] Starting disk
mai 19 10:21:01 jlaptop kernel: iwlwifi 0000:02:00.0: L1 Enabled; Disabling L0S
mai 19 10:21:01 jlaptop kernel: iwlwifi 0000:02:00.0: Radio type=0x1-0x3-0x1
mai 19 10:21:01 jlaptop kernel: usb 2-1.6.3: reset full-speed USB device number 5 using ehci-pci
mai 19 10:21:01 jlaptop kernel: PM: resume of devices complete after 1575.567 msecs
mai 19 10:21:01 jlaptop kernel: PM: Finishing wakeup.
mai 19 10:21:01 jlaptop kernel: usb 1-1.5.4: USB disconnect, device number 8
mai 19 10:21:01 jlaptop kernel: Restarting tasks ... done.
mai 19 10:21:01 jlaptop kernel: cfg80211: World regulatory domain updated:
mai 19 10:21:01 jlaptop kernel: cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
mai 19 10:21:01 jlaptop kernel: cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm)
mai 19 10:21:01 jlaptop kernel: cfg80211:   (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm)
mai 19 10:21:01 jlaptop kernel: cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm)
mai 19 10:21:01 jlaptop kernel: cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz), (N/A, 2000 mBm)
mai 19 10:21:01 jlaptop kernel: cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm)
mai 19 10:21:01 jlaptop kernel: cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm)
mai 19 10:21:01 jlaptop systemd[385]: Time has been changed
mai 19 10:21:01 jlaptop systemd-sleep[16950]: System resumed.
mai 19 10:21:01 jlaptop systemd[1]: Started Suspend.
mai 19 10:21:01 jlaptop systemd[1]: Service sleep.target is not needed anymore. Stopping.
mai 19 10:21:01 jlaptop systemd[1]: Time has been changed
mai 19 10:21:01 jlaptop systemd[1]: Starting Rotate log files...
mai 19 10:21:01 jlaptop systemd[1]: Starting Verify integrity of password and group files...
mai 19 10:21:01 jlaptop systemd[1]: Starting Update man-db cache...
mai 19 10:21:01 jlaptop systemd[1]: Stopping Sleep.
mai 19 10:21:01 jlaptop systemd[1]: Stopped target Sleep.
mai 19 10:21:01 jlaptop systemd[1]: Starting Suspend.
mai 19 10:21:01 jlaptop systemd[1]: Reached target Suspend.
mai 19 10:21:02 jlaptop systemd-logind[277]: Operation finished.

Vous voyez quelque chose qui cloche ?

[benjarobin]

Tu n'as surtout pas donné la sortie demandée...
Comme tu n'as pas redémarrer depuis quelques jours, je vais en profiter pour modifier la commande (en root) :

Code : Tout sélectionner

journalctl --no-pager -b --since=2014-05-19

[hansi]

Voilà le log : http://pastebin.com/QvE2aKi5
Vu sa taille, si tu veux juste un extrait pas de problème

[benjarobin]

Sérieusement il y a rien d'exploitable ici (Ce n'est pas forcement de ta faute).
Redémarre, met en veille avec : systemctl suspend, note l'heure (hh:mm:ss) d’exécution de la commande, donne le nombre de secondes approximatif pour mettre le système en veille, attends au moins une minute, réveil le PC, note l'heure de réveil, et pour finir donne la sortie de : journalctl --no-pager -b

[hansi]

Voilà : http://pastebin.com/ErejyYP0

J'ai donc mis en veille aux alentours de 23h01, la mise en veille a mis 16 secondes (après une journée de taff c'est à vu de nez plus long). Sortie de veille vers 23h05...

[benjarobin]

Code : Tout sélectionner

PM: suspend of devices complete after 12762.232 msecs

Donc cela prend en effet un peu plus de 13 secondes. Mais rien d'anormal vu ici.
Il faudrait répéter la procédure en lançant au préalable la commande sync pour voir si cela ne vient pas du disque dur...

Pour ceux qui se pose la question, le warning avec la trace n'est pas trop grave et n’impacte pas que je sache la veille, cf: http://lists.freedesktop.org/archives/d ... 52725.html

[hansi]

Bon j'ai du nouveau, déjà le disque est sain (infos SMART). Mais surtout on dirait que ça vient (encore une fois) de la carte graphique externe car quand l'ordi tourne sans elle la mise en veille est instantanée... Trop cheulou !
Grrr ça m'énerve que ce dispositif ne fonctionne pas nickel sous Linux