You are not logged in.
Hi,
I have no idea how to get to the source of the problem, so I am asking for your help.
Suspend is not working on my acer notebook (fresh archlinux (re)install). I get the "tasks refusing to freeze" message.
Journalctl tells me that alsactl is to be blamed. Didn't find anything on google, though. Here's the journalctl output:
Sep 14 21:56:51 bwacer logger[9728]: SleepButton pressed
Sep 14 21:56:51 bwacer su[9730]: (to root) root on (null)
Sep 14 21:56:51 bwacer su[9730]: pam_unix(su:session): session opened for user bw by (uid=0)
Sep 14 21:56:52 bwacer su[9730]: pam_unix(su:session): session closed for user bw
Sep 14 21:56:52 bwacer systemd[1]: Starting Sleep.
Sep 14 21:56:52 bwacer systemd[1]: Reached target Sleep.
Sep 14 21:56:52 bwacer systemd[1]: Starting Suspend...
Sep 14 21:56:52 bwacer systemd-sleep[9733]: Suspending system...
Sep 14 21:56:52 bwacer kernel: PM: Syncing filesystems ... done.
Sep 14 21:56:52 bwacer kernel: PM: Preparing system for mem sleep
Sep 14 21:57:12 bwacer kernel: Freezing user space processes ...
Sep 14 21:57:12 bwacer kernel: Freezing of tasks failed after 20.00 seconds (2 tasks refusing to freeze, wq_busy=0):
Sep 14 21:57:12 bwacer kernel: alsactl D ffff880131b53000 0 1211 1 0x00000004
Sep 14 21:57:12 bwacer kernel: ffff88013106fbe0 0000000000000082 0000000000014340 ffff88013106ffd8
Sep 14 21:57:12 bwacer kernel: ffff88013106ffd8 0000000000014340 ffff88012bd85460 ffffffff8108dd88
Sep 14 21:57:12 bwacer kernel: ffff88013106fb58 ffffffff810920f6 ffff880130e31180 ffff88013076ac00
Sep 14 21:57:12 bwacer kernel: Call Trace:
Sep 14 21:57:12 bwacer kernel: [<ffffffff8108dd88>] ? __enqueue_entity+0x78/0x80
Sep 14 21:57:12 bwacer kernel: [<ffffffff810920f6>] ? enqueue_entity+0x286/0xa20
Sep 14 21:57:12 bwacer kernel: [<ffffffff81092991>] ? enqueue_task_fair+0x101/0x540
Sep 14 21:57:12 bwacer kernel: [<ffffffff81065bbb>] ? lock_timer_base.isra.35+0x2b/0x50
Sep 14 21:57:12 bwacer kernel: [<ffffffff814c6f09>] schedule+0x29/0x70
Sep 14 21:57:12 bwacer kernel: [<ffffffff814c4784>] schedule_timeout+0x134/0x290
Sep 14 21:57:12 bwacer kernel: [<ffffffff810656a0>] ? call_timer_fn+0x190/0x190
Sep 14 21:57:12 bwacer kernel: [<ffffffffa051f742>] snd_power_wait+0xb2/0x100 [snd]
Sep 14 21:57:12 bwacer kernel: [<ffffffff8108a660>] ? wake_up_process+0x40/0x40
Sep 14 21:57:12 bwacer kernel: [<ffffffffa052336f>] snd_ctl_elem_info_user+0x5f/0xf0 [snd]
Sep 14 21:57:12 bwacer kernel: [<ffffffffa0524963>] snd_ctl_ioctl+0x683/0x7d0 [snd]
Sep 14 21:57:12 bwacer kernel: [<ffffffff8119b2e8>] ? do_filp_open+0x38/0x80
Sep 14 21:57:12 bwacer kernel: [<ffffffff8119d5b5>] do_vfs_ioctl+0x2e5/0x4d0
Sep 14 21:57:12 bwacer kernel: [<ffffffff811969f2>] ? final_putname+0x22/0x50
Sep 14 21:57:12 bwacer kernel: [<ffffffff811a7b7d>] ? set_close_on_exec+0x4d/0x70
Sep 14 21:57:12 bwacer kernel: [<ffffffff8119d821>] SyS_ioctl+0x81/0xa0
Sep 14 21:57:12 bwacer kernel: [<ffffffff814cfe1d>] system_call_fastpath+0x1a/0x1f
Sep 14 21:57:12 bwacer kernel: alsactl D ffff880131b53000 0 1212 1 0x00000004
Sep 14 21:57:12 bwacer kernel: ffff880130643be0 0000000000000086 0000000000014340 ffff880130643fd8
Sep 14 21:57:12 bwacer kernel: ffff880130643fd8 0000000000014340 ffff88012bd86db0 ffffffff8108dd88
Sep 14 21:57:12 bwacer kernel: ffff880130643b58 ffffffff810920f6 0000000000014340 ffff880131837c00
Sep 14 21:57:12 bwacer kernel: Call Trace:
Sep 14 21:57:12 bwacer kernel: [<ffffffff8108dd88>] ? __enqueue_entity+0x78/0x80
Sep 14 21:57:12 bwacer kernel: [<ffffffff810920f6>] ? enqueue_entity+0x286/0xa20
Sep 14 21:57:12 bwacer kernel: [<ffffffff81065bbb>] ? lock_timer_base.isra.35+0x2b/0x50
Sep 14 21:57:12 bwacer kernel: [<ffffffff814c6f09>] schedule+0x29/0x70
Sep 14 21:57:12 bwacer kernel: [<ffffffff814c4784>] schedule_timeout+0x134/0x290
Sep 14 21:57:12 bwacer kernel: [<ffffffff810656a0>] ? call_timer_fn+0x190/0x190
Sep 14 21:57:12 bwacer kernel: [<ffffffffa051f742>] snd_power_wait+0xb2/0x100 [snd]
Sep 14 21:57:12 bwacer kernel: [<ffffffff8108a660>] ? wake_up_process+0x40/0x40
Sep 14 21:57:12 bwacer kernel: [<ffffffffa052336f>] snd_ctl_elem_info_user+0x5f/0xf0 [snd]
Sep 14 21:57:12 bwacer kernel: [<ffffffffa0524963>] snd_ctl_ioctl+0x683/0x7d0 [snd]
Sep 14 21:57:12 bwacer kernel: [<ffffffff8119b2e8>] ? do_filp_open+0x38/0x80
Sep 14 21:57:12 bwacer kernel: [<ffffffff8119d5b5>] do_vfs_ioctl+0x2e5/0x4d0
Sep 14 21:57:12 bwacer kernel: [<ffffffff811969f2>] ? final_putname+0x22/0x50
Sep 14 21:57:12 bwacer kernel: [<ffffffff811a7b7d>] ? set_close_on_exec+0x4d/0x70
Sep 14 21:57:12 bwacer kernel: [<ffffffff8119d821>] SyS_ioctl+0x81/0xa0
Sep 14 21:57:12 bwacer kernel: [<ffffffff814cfe1d>] system_call_fastpath+0x1a/0x1f
Sep 14 21:57:12 bwacer kernel:
Sep 14 21:57:12 bwacer kernel: Restarting tasks ... done.
Sep 14 21:57:12 bwacer kernel: video LNXVIDEO:00: Restoring backlight state
Sep 14 21:57:12 bwacer kernel: video LNXVIDEO:01: Restoring backlight state
Sep 14 21:57:12 bwacer kernel: PM: Syncing filesystems ... done.
Sep 14 21:57:12 bwacer kernel: PM: Preparing system for freeze sleep
Sep 14 21:57:12 bwacer laptop-mode[9760]: Laptop mode
Sep 14 21:57:12 bwacer laptop-mode[9761]: enabled, active [unchanged]
Sep 14 21:57:33 bwacer kernel: Freezing user space processes ...
Sep 14 21:57:33 bwacer kernel: Freezing of tasks failed after 20.00 seconds (2 tasks refusing to freeze, wq_busy=0):
Sep 14 21:57:33 bwacer kernel: alsactl D ffff880131b53000 0 1211 1 0x00000004
Sep 14 21:57:33 bwacer kernel: ffff88013106fbe0 0000000000000082 0000000000014340 ffff88013106ffd8
Sep 14 21:57:33 bwacer kernel: ffff88013106ffd8 0000000000014340 ffff88012bd85460 ffffffff8108dd88
Sep 14 21:57:33 bwacer kernel: ffff88013106fb58 ffffffff810920f6 ffff880130e31180 ffff88013076ac00
Sep 14 21:57:33 bwacer kernel: Call Trace:
Sep 14 21:57:33 bwacer kernel: [<ffffffff8108dd88>] ? __enqueue_entity+0x78/0x80
Sep 14 21:57:33 bwacer kernel: [<ffffffff810920f6>] ? enqueue_entity+0x286/0xa20
Sep 14 21:57:33 bwacer kernel: [<ffffffff81092991>] ? enqueue_task_fair+0x101/0x540
Sep 14 21:57:33 bwacer kernel: [<ffffffff81065bbb>] ? lock_timer_base.isra.35+0x2b/0x50
Sep 14 21:57:33 bwacer kernel: [<ffffffff814c6f09>] schedule+0x29/0x70
Sep 14 21:57:33 bwacer kernel: [<ffffffff814c4784>] schedule_timeout+0x134/0x290
Sep 14 21:57:33 bwacer kernel: [<ffffffff810656a0>] ? call_timer_fn+0x190/0x190
Sep 14 21:57:33 bwacer kernel: [<ffffffffa051f742>] snd_power_wait+0xb2/0x100 [snd]
Sep 14 21:57:33 bwacer kernel: [<ffffffff8108a660>] ? wake_up_process+0x40/0x40
Sep 14 21:57:33 bwacer kernel: [<ffffffffa052336f>] snd_ctl_elem_info_user+0x5f/0xf0 [snd]
Sep 14 21:57:33 bwacer kernel: [<ffffffffa0524963>] snd_ctl_ioctl+0x683/0x7d0 [snd]
Sep 14 21:57:33 bwacer kernel: [<ffffffff8119b2e8>] ? do_filp_open+0x38/0x80
Sep 14 21:57:33 bwacer kernel: [<ffffffff8119d5b5>] do_vfs_ioctl+0x2e5/0x4d0
Sep 14 21:57:33 bwacer kernel: [<ffffffff811969f2>] ? final_putname+0x22/0x50
Sep 14 21:57:33 bwacer kernel: [<ffffffff811a7b7d>] ? set_close_on_exec+0x4d/0x70
Sep 14 21:57:33 bwacer kernel: [<ffffffff8119d821>] SyS_ioctl+0x81/0xa0
Sep 14 21:57:33 bwacer kernel: [<ffffffff814cfe1d>] system_call_fastpath+0x1a/0x1f
Sep 14 21:57:33 bwacer kernel: alsactl D ffff880131b53000 0 1212 1 0x00000004
Sep 14 21:57:33 bwacer kernel: ffff880130643be0 0000000000000086 0000000000014340 ffff880130643fd8
Sep 14 21:57:33 bwacer kernel: ffff880130643fd8 0000000000014340 ffff88012bd86db0 ffffffff8108dd88
Sep 14 21:57:33 bwacer kernel: ffff880130643b58 ffffffff810920f6 0000000000014340 ffff880131837c00
Sep 14 21:57:33 bwacer kernel: Call Trace:
Sep 14 21:57:33 bwacer kernel: [<ffffffff8108dd88>] ? __enqueue_entity+0x78/0x80
Sep 14 21:57:33 bwacer kernel: [<ffffffff810920f6>] ? enqueue_entity+0x286/0xa20
Sep 14 21:57:33 bwacer kernel: [<ffffffff81065bbb>] ? lock_timer_base.isra.35+0x2b/0x50
Sep 14 21:57:33 bwacer kernel: [<ffffffff814c6f09>] schedule+0x29/0x70
Sep 14 21:57:33 bwacer kernel: [<ffffffff814c4784>] schedule_timeout+0x134/0x290
Sep 14 21:57:33 bwacer kernel: [<ffffffff810656a0>] ? call_timer_fn+0x190/0x190
Sep 14 21:57:33 bwacer kernel: [<ffffffffa051f742>] snd_power_wait+0xb2/0x100 [snd]
Sep 14 21:57:33 bwacer kernel: [<ffffffff8108a660>] ? wake_up_process+0x40/0x40
Sep 14 21:57:33 bwacer kernel: [<ffffffffa052336f>] snd_ctl_elem_info_user+0x5f/0xf0 [snd]
Sep 14 21:57:33 bwacer kernel: [<ffffffffa0524963>] snd_ctl_ioctl+0x683/0x7d0 [snd]
Sep 14 21:57:33 bwacer kernel: [<ffffffff8119b2e8>] ? do_filp_open+0x38/0x80
Sep 14 21:57:33 bwacer kernel: [<ffffffff8119d5b5>] do_vfs_ioctl+0x2e5/0x4d0
Sep 14 21:57:33 bwacer kernel: [<ffffffff811969f2>] ? final_putname+0x22/0x50
Sep 14 21:57:33 bwacer kernel: [<ffffffff811a7b7d>] ? set_close_on_exec+0x4d/0x70
Sep 14 21:57:33 bwacer kernel: [<ffffffff8119d821>] SyS_ioctl+0x81/0xa0
Sep 14 21:57:33 bwacer kernel: [<ffffffff814cfe1d>] system_call_fastpath+0x1a/0x1f
Sep 14 21:57:33 bwacer kernel:
Sep 14 21:57:33 bwacer kernel: Restarting tasks ... done.
Sep 14 21:57:33 bwacer kernel: video LNXVIDEO:00: Restoring backlight state
Sep 14 21:57:33 bwacer kernel: video LNXVIDEO:01: Restoring backlight state
Sep 14 21:57:33 bwacer systemd[1]: systemd-suspend.service: main process exited, code=exited, status=1/FAILURE
Sep 14 21:57:33 bwacer systemd[1]: Failed to start Suspend.
Sep 14 21:57:33 bwacer systemd[1]: Dependency failed for Suspend.
Sep 14 21:57:33 bwacer systemd[1]: Service sleep.target is not needed anymore. Stopping.
Sep 14 21:57:33 bwacer systemd[1]: Unit systemd-suspend.service entered failed state.
Sep 14 21:57:33 bwacer systemd[1]: Stopping Sleep.
Sep 14 21:57:33 bwacer systemd[1]: Stopped target Sleep.
Sep 14 21:57:33 bwacer laptop-mode[9789]: Laptop mode
Sep 14 21:57:33 bwacer laptop-mode[9790]: enabled, active [unchanged]
Waiting for alsactl for 20 seconds, twice? Indeed, I have two alsactl processes. (don't know why, though)
Any ideas how to debug it?
Offline
What are the two processes exactly? I thought alsactl was something you used to set stuff - not something which then continued to run.
Do you have pm-utils installed?
Have you tried suspending in different ways? (e.g. using the systemctl command directly etc.)
CLI Paste | How To Ask Questions
Arch Linux | x86_64 | GPT | EFI boot | refind | stub loader | systemd | LVM2 on LUKS
Lenovo x270 | Intel(R) Core(TM) i5-7200U CPU @ 2.50GHz | Intel Wireless 8265/8275 | US keyboard w/ Euro | 512G NVMe INTEL SSDPEKKF512G7L
Offline
Actually, I use the systemctl command directly. I don't have pm-utils, but I tried that already - same. And no wonder, alsactl process cannot be killed:
bwacer /home/bw # pstree
systemd─┬─acpid
├─2*[alsactl]
...
bwacer /home/bw # killall alsactl
bwacer /home/bw # killall alsactl
bwacer /home/bw # ps -e | grep alsactl
1247 ? 00:00:00 alsactl
1248 ? 00:00:00 alsactl
bwacer /home/bw # kill 1247
bwacer /home/bw # ps -e | grep alsactl
1247 ? 00:00:00 alsactl
1248 ? 00:00:00 alsactl
I have no idea what these processes are doing here. It's a fresh install, I don't have pulseaudio, all I did with alsa is installed few packages (alsa-plugins, alsa-oss, libsamplerate etc) and maybe enabled power saving in laptop-mode-tools (but that worked in previous installs).
Offline
I would start searching for what is starting those processes e.g. look under /etc/acpi/, /etc/systemd/system/, maybe /usr/lib/systemd/system/ and also in the config files in your home directory e.g. under ~/.config/ etc.
Are you using a DE at all?
You might also check the journal to see what might be starting it earlier on e.g. journalctl -b | grep -i alsa.
CLI Paste | How To Ask Questions
Arch Linux | x86_64 | GPT | EFI boot | refind | stub loader | systemd | LVM2 on LUKS
Lenovo x270 | Intel(R) Core(TM) i5-7200U CPU @ 2.50GHz | Intel Wireless 8265/8275 | US keyboard w/ Euro | 512G NVMe INTEL SSDPEKKF512G7L
Offline