You are not logged in.

#1 2015-05-30 20:09:30

Kotrfa
Member
Registered: 2012-10-25
Posts: 213

Systemd don't suspend

Hello,

I have a problem suspending my system from time to time. It happens randomly (as much as it is when we talk about 0 and 1) and very rarely (e.g. in 1% of cases). When the problems occurs, laptop freezes and do not respond to anything (changing tty, ctrl+alt+delete, touchpad - nothing). But after few seconds or minute, it comes back as usual.

Here is the log since initiating the suspend until it comes back as normal:

May 30 17:08:15 530uarch systemd[1]: Starting TLP suspend/resume...
May 30 17:08:15 530uarch systemd[1]: Starting netctl sleep hook...
May 30 17:08:15 530uarch systemd[1]: Stopped Networking for netctl profile w_ZLUTY.
May 30 17:08:15 530uarch systemd[1]: Stopped Networking for netctl profile w_MSI.
May 30 17:08:15 530uarch systemd[1]: Stopped Networking for netctl profile wlp1s0-NovyRepin.
May 30 17:08:15 530uarch systemd[1]: Stopped Networking for netctl profile w_AndroidAP.
May 30 17:08:15 530uarch systemd[1]: Stopped Networking for netctl profile w_DHLink.
May 30 17:08:15 530uarch systemd[1]: Stopped Networking for netctl profile w_uMisi.
May 30 17:08:15 530uarch systemd[1]: Stopped Networking for netctl profile w_ZubniHH.
May 30 17:08:15 530uarch systemd[1]: Stopped Networking for netctl profile wlp1s0-WiFi-Sokol.
May 30 17:08:15 530uarch systemd[1]: Stopped Networking for netctl profile w_Sim.
May 30 17:08:15 530uarch systemd[1]: Stopped Networking for netctl profile w_DobraCajovnaKV.
May 30 17:08:15 530uarch systemd[1]: Stopped Networking for netctl profile ethernet-dhcp.
May 30 17:08:15 530uarch systemd[1]: Stopped Networking for netctl profile w_TechniSmecka.
May 30 17:08:15 530uarch systemd[1]: Stopped Networking for netctl profile w_McDonalds.
May 30 17:08:15 530uarch systemd[1]: Stopped Networking for netctl profile wlp1s0-PivovarChyse.
May 30 17:08:15 530uarch systemd[1]: Stopped Networking for netctl profile w_wififji.
May 30 17:08:15 530uarch systemd[1]: Stopped Networking for netctl profile w_resiedelweiss.
May 30 17:08:15 530uarch systemd[1]: Started netctl sleep hook.
May 30 17:08:15 530uarch systemd[1]: Started TLP suspend/resume.
May 30 17:08:15 530uarch systemd[1]: Reached target Sleep.
May 30 17:08:15 530uarch systemd[1]: Starting Sleep.
May 30 17:08:15 530uarch systemd[1]: Starting Suspend...
May 30 17:08:15 530uarch systemd-sleep[11527]: Suspending system...
May 30 17:08:35 530uarch kernel: PM: Syncing filesystems ... done.
May 30 17:08:35 530uarch kernel: PM: Preparing system for mem sleep
May 30 17:08:35 530uarch kernel: Freezing user space processes ... 
May 30 17:08:35 530uarch kernel: Freezing of tasks failed after 20.000 seconds (1 tasks refusing to freeze, wq_busy=0):
May 30 17:08:35 530uarch kernel: ranger          D ffff880210ff39d8     0   985    953 0x00000004
May 30 17:08:35 530uarch kernel:  ffff880210ff39d8 ffff8801a28a8a20 ffff8800d0ad8a20 ffff8800d0ad8a20
May 30 17:08:35 530uarch kernel:  ffff880210ff3fd8 ffff8801aedf9000 ffff880210ff3a08 ffff88002c4c00d0
May 30 17:08:35 530uarch kernel:  ffff880210ff3b88 ffff880210ff39f8 ffffffff81576707 ffff8801aedf9000
May 30 17:08:35 530uarch kernel: Call Trace:
May 30 17:08:35 530uarch kernel:  [<ffffffff81576707>] schedule+0x37/0x90
May 30 17:08:35 530uarch kernel:  [<ffffffffa08cc8d5>] __fuse_request_send+0xd5/0x2c0 [fuse]
May 30 17:08:35 530uarch kernel:  [<ffffffff810b6c70>] ? wake_atomic_t_function+0x60/0x60
May 30 17:08:35 530uarch kernel:  [<ffffffffa08cff40>] fuse_simple_request+0xd0/0x1c0 [fuse]
May 30 17:08:35 530uarch kernel:  [<ffffffffa08d2ca8>] fuse_lookup_name+0x128/0x290 [fuse]
May 30 17:08:35 530uarch kernel:  [<ffffffffa08d2e5e>] fuse_lookup+0x4e/0x140 [fuse]
May 30 17:08:35 530uarch kernel:  [<ffffffff811e217d>] lookup_real+0x1d/0x70
May 30 17:08:35 530uarch kernel:  [<ffffffff811e49e2>] __lookup_hash+0x42/0x60
May 30 17:08:35 530uarch kernel:  [<ffffffff811e4a43>] lookup_slow+0x43/0xc0
May 30 17:08:35 530uarch kernel:  [<ffffffff811e63da>] path_lookupat+0x6fa/0x860
May 30 17:08:35 530uarch kernel:  [<ffffffff811e8690>] ? getname_flags+0x30/0x140
May 30 17:08:35 530uarch kernel:  [<ffffffff811e6566>] filename_lookup.isra.7+0x26/0x80
May 30 17:08:35 530uarch kernel:  [<ffffffff811e9313>] user_path_at_empty+0x63/0xd0
May 30 17:08:35 530uarch kernel:  [<ffffffffa08d3085>] ? fuse_update_attributes+0x35/0x80 [fuse]
May 30 17:08:35 530uarch kernel:  [<ffffffff810ab86d>] ? update_curr+0x7d/0x1b0
May 30 17:08:35 530uarch kernel:  [<ffffffff811f9190>] ? mntput_no_expire+0x30/0x1d0
May 30 17:08:35 530uarch kernel:  [<ffffffff811dd8a1>] ? cp_new_stat+0x121/0x150
May 30 17:08:35 530uarch kernel:  [<ffffffff811e9391>] user_path_at+0x11/0x20
May 30 17:08:35 530uarch kernel:  [<ffffffff811dd6da>] vfs_fstatat+0x6a/0xd0
May 30 17:08:35 530uarch kernel:  [<ffffffff811ddbf3>] SyS_newstat+0x33/0x60
May 30 17:08:35 530uarch kernel:  [<ffffffff8157a449>] system_call_fastpath+0x12/0x17
May 30 17:08:35 530uarch kernel: 
May 30 17:08:35 530uarch rtkit-daemon[1115]: The canary thread is apparently starving. Taking action.
May 30 17:08:35 530uarch rtkit-daemon[1115]: Demoting known real-time threads.
May 30 17:08:35 530uarch rtkit-daemon[1115]: Successfully demoted thread 1112 of process 1112 (/usr/bin/pulseaudio).
May 30 17:08:35 530uarch rtkit-daemon[1115]: Demoted 1 threads.
May 30 17:08:35 530uarch kernel: Restarting tasks ... done.
May 30 17:08:35 530uarch kernel: video LNXVIDEO:00: Restoring backlight state
May 30 17:08:55 530uarch kernel: PM: Syncing filesystems ... done.
May 30 17:08:55 530uarch kernel: PM: Preparing system for standby sleep
May 30 17:08:55 530uarch kernel: Freezing user space processes ... 
May 30 17:08:55 530uarch kernel: Freezing of tasks failed after 20.006 seconds (1 tasks refusing to freeze, wq_busy=0):
May 30 17:08:55 530uarch kernel: ranger          D ffff880210ff3a58     0   985    953 0x00000004
May 30 17:08:55 530uarch kernel:  ffff880210ff3a58 ffff880214c58a20 ffff8800d0ad8a20 ffff8800d0ad8a20
May 30 17:08:55 530uarch kernel:  ffff880210ff3fd8 ffff8801aedf9000 ffff880210ff3a88 ffff88002c4c00d0
May 30 17:08:55 530uarch kernel:  ffff8801f2ee78a0 ffff880210ff3a78 ffffffff81576707 ffff8801aedf9000
May 30 17:08:55 530uarch kernel: Call Trace:
May 30 17:08:55 530uarch kernel:  [<ffffffff81576707>] schedule+0x37/0x90
May 30 17:08:55 530uarch kernel:  [<ffffffffa08cc8d5>] __fuse_request_send+0xd5/0x2c0 [fuse]
May 30 17:08:55 530uarch kernel:  [<ffffffff810b6c70>] ? wake_atomic_t_function+0x60/0x60
May 30 17:08:55 530uarch kernel:  [<ffffffffa08cff40>] fuse_simple_request+0xd0/0x1c0 [fuse]
May 30 17:08:55 530uarch kernel:  [<ffffffffa08d113c>] fuse_dentry_revalidate+0x1ac/0x330 [fuse]
May 30 17:08:55 530uarch kernel:  [<ffffffff811e4805>] lookup_fast+0x215/0x300
May 30 17:08:55 530uarch kernel:  [<ffffffff811e557e>] ? path_init+0x17e/0x460
May 30 17:08:55 530uarch kernel:  [<ffffffff811e5db0>] path_lookupat+0xd0/0x860
May 30 17:08:55 530uarch kernel:  [<ffffffff811e8690>] ? getname_flags+0x30/0x140
May 30 17:08:55 530uarch kernel:  [<ffffffff811e6566>] filename_lookup.isra.7+0x26/0x80
May 30 17:08:55 530uarch kernel:  [<ffffffff811e9313>] user_path_at_empty+0x63/0xd0
May 30 17:08:55 530uarch kernel:  [<ffffffff810155a7>] ? do_signal+0x37/0x750
May 30 17:08:55 530uarch kernel:  [<ffffffff811dd8a1>] ? cp_new_stat+0x121/0x150
May 30 17:08:55 530uarch kernel:  [<ffffffff811e9391>] user_path_at+0x11/0x20
May 30 17:08:55 530uarch kernel:  [<ffffffff811dd6da>] vfs_fstatat+0x6a/0xd0
May 30 17:08:55 530uarch kernel:  [<ffffffff811ddbf3>] SyS_newstat+0x33/0x60
May 30 17:08:55 530uarch kernel:  [<ffffffff81015d20>] ? do_notify_resume+0x60/0x80
May 30 17:08:55 530uarch kernel:  [<ffffffff8157a6a3>] ? int_signal+0x12/0x17
May 30 17:08:55 530uarch kernel:  [<ffffffff8157a449>] system_call_fastpath+0x12/0x17
May 30 17:08:55 530uarch kernel: 
May 30 17:08:55 530uarch kernel: Restarting tasks ... done.
May 30 17:08:55 530uarch kernel: video LNXVIDEO:00: Restoring backlight state
May 30 17:08:55 530uarch rtkit-daemon[1115]: The canary thread is apparently starving. Taking action.
May 30 17:08:55 530uarch rtkit-daemon[1115]: Demoting known real-time threads.
May 30 17:08:55 530uarch rtkit-daemon[1115]: Successfully demoted thread 1112 of process 1112 (/usr/bin/pulseaudio).
May 30 17:08:55 530uarch rtkit-daemon[1115]: Demoted 1 threads.
May 30 17:09:15 530uarch kernel: PM: Syncing filesystems ... done.
May 30 17:09:15 530uarch kernel: PM: Preparing system for freeze sleep
May 30 17:09:15 530uarch kernel: Freezing user space processes ... 
May 30 17:09:15 530uarch kernel: Freezing of tasks failed after 20.005 seconds (1 tasks refusing to freeze, wq_busy=0):
May 30 17:09:15 530uarch kernel: ranger          D ffff880210ff38e8     0   985    953 0x00000004
May 30 17:09:15 530uarch kernel:  ffff880210ff38e8 ffff8801aef646e0 ffff8800d0ad8a20 ffff8800d0ad8a20
May 30 17:09:15 530uarch kernel:  ffff880210ff3fd8 ffff8801aedf9000 ffff880210ff3918 ffff88002c4c00d0
May 30 17:09:15 530uarch kernel:  ffff880210ff3a98 ffff880210ff3908 ffffffff81576707 ffff8801aedf9000
May 30 17:09:15 530uarch kernel: Call Trace:
May 30 17:09:15 530uarch kernel:  [<ffffffff81576707>] schedule+0x37/0x90
May 30 17:09:15 530uarch kernel:  [<ffffffffa08cc8d5>] __fuse_request_send+0xd5/0x2c0 [fuse]
May 30 17:09:15 530uarch kernel:  [<ffffffff810b6c70>] ? wake_atomic_t_function+0x60/0x60
May 30 17:09:15 530uarch kernel:  [<ffffffffa08cff40>] fuse_simple_request+0xd0/0x1c0 [fuse]
May 30 17:09:15 530uarch kernel:  [<ffffffffa08d2ca8>] fuse_lookup_name+0x128/0x290 [fuse]
May 30 17:09:15 530uarch kernel:  [<ffffffffa08d2e5e>] fuse_lookup+0x4e/0x140 [fuse]
May 30 17:09:15 530uarch kernel:  [<ffffffff811e217d>] lookup_real+0x1d/0x70
May 30 17:09:15 530uarch kernel:  [<ffffffff811e49e2>] __lookup_hash+0x42/0x60
May 30 17:09:15 530uarch kernel:  [<ffffffff811e4a43>] lookup_slow+0x43/0xc0
May 30 17:09:15 530uarch kernel:  [<ffffffff811e52a0>] link_path_walk+0x7e0/0x940
May 30 17:09:15 530uarch kernel:  [<ffffffff811e557e>] path_init+0x17e/0x460
May 30 17:09:15 530uarch kernel:  [<ffffffff811e5d10>] path_lookupat+0x30/0x860
May 30 17:09:15 530uarch kernel:  [<ffffffff811bae23>] ? kmem_cache_alloc+0x1d3/0x230
May 30 17:09:15 530uarch kernel:  [<ffffffff811e8690>] ? getname_flags+0x30/0x140
May 30 17:09:15 530uarch kernel:  [<ffffffff811e6566>] filename_lookup.isra.7+0x26/0x80
May 30 17:09:15 530uarch kernel:  [<ffffffff811e9313>] user_path_at_empty+0x63/0xd0
May 30 17:09:15 530uarch kernel:  [<ffffffff810155a7>] ? do_signal+0x37/0x750
May 30 17:09:15 530uarch kernel:  [<ffffffff811dd8a1>] ? cp_new_stat+0x121/0x150
May 30 17:09:15 530uarch kernel:  [<ffffffff811e9391>] user_path_at+0x11/0x20
May 30 17:09:15 530uarch kernel:  [<ffffffff811dd6da>] vfs_fstatat+0x6a/0xd0
May 30 17:09:15 530uarch kernel:  [<ffffffff811ddc56>] SyS_newlstat+0x36/0x70
May 30 17:09:15 530uarch kernel:  [<ffffffff81015d20>] ? do_notify_resume+0x60/0x80
May 30 17:09:15 530uarch kernel:  [<ffffffff8157a6a3>] ? int_signal+0x12/0x17
May 30 17:09:15 530uarch kernel:  [<ffffffff8157a449>] system_call_fastpath+0x12/0x17
May 30 17:09:15 530uarch kernel: 
May 30 17:09:15 530uarch kernel: Restarting tasks ... done.
May 30 17:09:15 530uarch kernel: video LNXVIDEO:00: Restoring backlight state
May 30 17:09:15 530uarch rtkit-daemon[1115]: The canary thread is apparently starving. Taking action.
May 30 17:09:15 530uarch rtkit-daemon[1115]: Demoting known real-time threads.
May 30 17:09:15 530uarch rtkit-daemon[1115]: Successfully demoted thread 1112 of process 1112 (/usr/bin/pulseaudio).
May 30 17:09:15 530uarch rtkit-daemon[1115]: Demoted 1 threads.
May 30 17:09:15 530uarch systemd[1]: systemd-suspend.service: main process exited, code=exited, status=1/FAILURE
May 30 17:09:15 530uarch systemd[1]: Failed to start Suspend.
May 30 17:09:15 530uarch systemd[1]: Dependency failed for Suspend.
May 30 17:09:15 530uarch systemd-logind[383]: Operation finished.
May 30 17:09:15 530uarch systemd[1]: Job suspend.target/start failed with result 'dependency'.
May 30 17:09:15 530uarch systemd[1]: Unit sleep.target is not needed anymore. Stopping.
May 30 17:09:15 530uarch systemd[1]: Unit systemd-suspend.service entered failed state.
May 30 17:09:15 530uarch systemd[1]: systemd-suspend.service failed.
May 30 17:09:15 530uarch systemd[1]: Stopped target Sleep.
May 30 17:09:15 530uarch systemd[1]: Unit tlp-sleep.service is not needed anymore. Stopping.
May 30 17:09:15 530uarch systemd[1]: Unit netctl-sleep.service is not needed anymore. Stopping.
May 30 17:09:15 530uarch systemd[1]: Stopping Sleep.
May 30 17:09:15 530uarch systemd[1]: Stopping netctl sleep hook...
May 30 17:09:15 530uarch systemd[1]: Stopping TLP suspend/resume...
May 30 17:09:15 530uarch systemd[1]: Starting Local system resume actions...
May 30 17:09:15 530uarch systemd[1]: Stopped netctl sleep hook.
May 30 17:09:15 530uarch kernel: xhci_hcd 0000:03:00.0: remove, state 4
May 30 17:09:15 530uarch kernel: usb usb3: USB disconnect, device number 1
May 30 17:09:15 530uarch systemd-udevd[185]: error opening USB device 'descriptors' file
May 30 17:09:15 530uarch kernel: xhci_hcd 0000:03:00.0: USB bus 3 deregistered
May 30 17:09:15 530uarch kernel: xhci_hcd 0000:03:00.0: remove, state 4
May 30 17:09:15 530uarch kernel: usb usb2: USB disconnect, device number 1
May 30 17:09:15 530uarch systemd-udevd[185]: error opening USB device 'descriptors' file
May 30 17:09:15 530uarch kernel: xhci_hcd 0000:03:00.0: USB bus 2 deregistered
May 30 17:09:15 530uarch kernel: xhci_hcd 0000:03:00.0: xHCI Host Controller
May 30 17:09:15 530uarch kernel: xhci_hcd 0000:03:00.0: new USB bus registered, assigned bus number 2
May 30 17:09:16 530uarch kernel: xhci_hcd 0000:03:00.0: hcc params 0x0200f180 hci version 0x96 quirks 0x00080000
May 30 17:09:16 530uarch kernel: hub 2-0:1.0: USB hub found
May 30 17:09:16 530uarch kernel: hub 2-0:1.0: 2 ports detected
May 30 17:09:16 530uarch systemd[1]: Started Local system resume actions.
May 30 17:09:16 530uarch kernel: xhci_hcd 0000:03:00.0: xHCI Host Controller
May 30 17:09:16 530uarch kernel: xhci_hcd 0000:03:00.0: new USB bus registered, assigned bus number 3
May 30 17:09:16 530uarch kernel: hub 3-0:1.0: USB hub found
May 30 17:09:16 530uarch kernel: hub 3-0:1.0: 2 ports detected
May 30 17:09:16 530uarch systemd[1]: Stopped TLP suspend/resume.

It was discussed e.g. here:
https://bbs.archlinux.org/viewtopic.php?id=148957
https://bbs.archlinux.org/viewtopic.php?id=194213
https://bbs.archlinux.org/viewtopic.php?id=182419

but no solution related to my case. My model is  Samsung 530U.

thank you

Offline

#2 2018-02-22 09:41:46

dushistov
Member
Registered: 2016-04-09
Posts: 4

Re: Systemd don't suspend

I suppose this links are relevant:

https://bugzilla.kernel.org/show_bug.cgi?id=34932
https://bugzilla.kernel.org/show_bug.cgi?id=198879

also this one: https://lists.debian.org/debian-kernel/ … 00412.html

It's a bug in the fuse-freezer interaction.  Yes, it is known.

Before suspending the machine all userspace task are frozen, which means
the freezer will wait until they exit the kernel (i.e. finish any system
calls).  If some task does not exit the kernel within a predefined time
then the freezer will give up and not let the machine be suspended.

Lets say task A is executing a system call that depends on task B to
finish.  In this case task B must not be frozen until task A is frozen
otherwise the suspend will be unsuccessful.

Offline

Board footer

Powered by FluxBB