You are not logged in.
- Topics: Active | Unanswered
Pages: 1
#1 2014-06-09 09:27:45
- stri
- Member
- Registered: 2014-06-09
- Posts: 72
[workaround] suspend fails
Hi,
Several days ago I noticed that my Laptop doesn't suspend any more when I close the lid. Today I tried to find out why, I ran dmesg and journalctl and there appears to be a problem with alsactl.
I tried both with the current kernel and the lts version, same problem.
I have 2 graphic cards, intel and ati, the ati one is always powered off with vgaswitcheroo.
Unfortunately I don't remember exactly when the problem ocurred (after which update), must have been a week ago or two.
Sound works fine in KDE despite the messages.
I only switched to Arch recently and I'm not good yet at finding out where the actual problem comes from. Below is some output.
Thanks!
Edit: Contrary to what I claimed above, the error only occurs using the LTS kernel. Using the current kernel is an acceptable workaround for me.
Output from dmesg:
[ 1256.825010] PM: Syncing filesystems ... done.
[ 1257.230218] PM: Preparing system for mem sleep
[ 1259.489626] Freezing user space processes ...
[ 1279.498644] Freezing of tasks failed after 20.00 seconds (3 tasks refusing to freeze, wq_busy=0):
[ 1279.498750] alsactl D c15ba540 0 418 1 0x00000004
[ 1279.498756] f2dddcd8 00000086 00000041 c15ba540 00000002 fb1ba8e0 00000123 fb1c8f22
[ 1279.498763] 00000123 c165cc80 f5e26c80 0000010f f5e26c80 f2d6f0e0 000000d0 c1172a4b
[ 1279.498769] 01081dc0 f2dddcac f4fa8088 00000282 c16f3a40 c16f3a40 f2dddcc0 c104abc3
[ 1279.498775] Call Trace:
[ 1279.498806] [<c1172a4b>] ? __find_get_block_slow+0xcb/0x170
[ 1279.498814] [<c104abc3>] ? lock_timer_base.isra.36+0x23/0x50
[ 1279.498822] [<c14188b3>] schedule+0x23/0x60
[ 1279.498826] [<c141680b>] schedule_timeout+0xfb/0x1f0
[ 1279.498831] [<c104a7e0>] ? ftrace_raw_event_tick_stop+0x140/0x140
[ 1279.498841] [<f890642e>] snd_power_wait+0x9e/0xf0 [snd]
[ 1279.498847] [<c106b960>] ? wake_up_process+0x40/0x40
[ 1279.498853] [<c1105511>] ? shrink_slab+0xa1/0x2d0
[ 1279.498861] [<f8908def>] snd_ctl_elem_info_user+0x4f/0x250 [snd]
[ 1279.498866] [<c1105511>] ? shrink_slab+0xa1/0x2d0
[ 1279.498873] [<f890a29a>] snd_ctl_ioctl+0x6ba/0xa80 [snd]
[ 1279.498878] [<c12178f5>] ? __copy_to_user_ll+0x55/0x60
[ 1279.498884] [<c1156cdb>] ? do_filp_open+0x2b/0x90
[ 1279.498891] [<f8909be0>] ? snd_ctl_open+0x150/0x150 [snd]
[ 1279.498895] [<c1158ec6>] do_vfs_ioctl+0x2f6/0x4e0
[ 1279.498899] [<c115297d>] ? final_putname+0x1d/0x40
[ 1279.498904] [<c1161b13>] ? set_close_on_exec+0x23/0x50
[ 1279.498908] [<c1157e5c>] ? do_fcntl+0x37c/0x480
[ 1279.498912] [<c115913f>] SyS_ioctl+0x8f/0xa0
[ 1279.498915] [<c1105511>] ? shrink_slab+0xa1/0x2d0
[ 1279.498922] [<c1420e0d>] sysenter_do_call+0x12/0x28
[ 1279.498926] [<c1105511>] ? shrink_slab+0xa1/0x2d0
[ 1279.498928] alsactl D c15ba540 0 419 1 0x00000004
[ 1279.498932] f2f59cd8 00000086 00000041 c15ba540 00000002 fbb446f6 00000123 fbb52ee0
[ 1279.498938] 00000123 c165cc80 f5e26c80 000000f3 f5e26c80 f2d6f640 000000d0 c1172a4b
[ 1279.498944] 01051c00 f2f59cac f4fa8088 00000286 f50e0000 f50e0000 f2f59cc0 c104abc3
[ 1279.498950] Call Trace:
[ 1279.498957] [<c1172a4b>] ? __find_get_block_slow+0xcb/0x170
[ 1279.498961] [<c104abc3>] ? lock_timer_base.isra.36+0x23/0x50
[ 1279.498965] [<c14188b3>] schedule+0x23/0x60
[ 1279.498968] [<c141680b>] schedule_timeout+0xfb/0x1f0
[ 1279.498973] [<c104a7e0>] ? ftrace_raw_event_tick_stop+0x140/0x140
[ 1279.498980] [<f890642e>] snd_power_wait+0x9e/0xf0 [snd]
[ 1279.498984] [<c106b960>] ? wake_up_process+0x40/0x40
[ 1279.498988] [<c1105511>] ? shrink_slab+0xa1/0x2d0
[ 1279.498995] [<f8908def>] snd_ctl_elem_info_user+0x4f/0x250 [snd]
[ 1279.499000] [<c1105511>] ? shrink_slab+0xa1/0x2d0
[ 1279.499007] [<f890a29a>] snd_ctl_ioctl+0x6ba/0xa80 [snd]
[ 1279.499010] [<c12178f5>] ? __copy_to_user_ll+0x55/0x60
[ 1279.499014] [<c1156cdb>] ? do_filp_open+0x2b/0x90
[ 1279.499021] [<f8909be0>] ? snd_ctl_open+0x150/0x150 [snd]
[ 1279.499025] [<c1158ec6>] do_vfs_ioctl+0x2f6/0x4e0
[ 1279.499028] [<c115297d>] ? final_putname+0x1d/0x40
[ 1279.499032] [<c1161b13>] ? set_close_on_exec+0x23/0x50
[ 1279.499036] [<c1157e5c>] ? do_fcntl+0x37c/0x480
[ 1279.499040] [<c115913f>] SyS_ioctl+0x8f/0xa0
[ 1279.499044] [<c1105511>] ? shrink_slab+0xa1/0x2d0
[ 1279.499048] [<c1420e0d>] sysenter_do_call+0x12/0x28
[ 1279.499051] [<c1105511>] ? shrink_slab+0xa1/0x2d0
[ 1279.499060] pulseaudio D f1e4bc74 0 842 841 0x00000004
[ 1279.499064] f1e4bcd8 00000086 f2e9813c f1e4bc74 00000000 08a4bd76 00000128 08a5a4af
[ 1279.499070] 00000128 c165cc80 f5e0ac80 000000d4 f5e0ac80 f2d7f0e0 f1e4bcac 00000246
[ 1279.499076] 0000070e f1e4bcb4 f90dbc58 00000286 f50e2000 f50e2000 f1e4bcc0 c104abc3
[ 1279.499082] Call Trace:
[ 1279.499092] [<f90dbc58>] ? set_dig_out+0x28/0x70 [snd_hda_codec]
[ 1279.499096] [<c104abc3>] ? lock_timer_base.isra.36+0x23/0x50
[ 1279.499100] [<c14188b3>] schedule+0x23/0x60
[ 1279.499104] [<c141680b>] schedule_timeout+0xfb/0x1f0
[ 1279.499108] [<c104a7e0>] ? ftrace_raw_event_tick_stop+0x140/0x140
[ 1279.499115] [<f890642e>] snd_power_wait+0x9e/0xf0 [snd]
[ 1279.499119] [<c106b960>] ? wake_up_process+0x40/0x40
[ 1279.499123] [<c1105511>] ? shrink_slab+0xa1/0x2d0
[ 1279.499130] [<f8908def>] snd_ctl_elem_info_user+0x4f/0x250 [snd]
[ 1279.499135] [<c1105511>] ? shrink_slab+0xa1/0x2d0
[ 1279.499142] [<f890a29a>] snd_ctl_ioctl+0x6ba/0xa80 [snd]
[ 1279.499148] [<c1119b76>] ? handle_pte_fault+0x76/0x8a0
[ 1279.499152] [<c12178f5>] ? __copy_to_user_ll+0x55/0x60
[ 1279.499156] [<c111a596>] ? handle_mm_fault+0x1f6/0x280
[ 1279.499163] [<f8909be0>] ? snd_ctl_open+0x150/0x150 [snd]
[ 1279.499167] [<c1158ec6>] do_vfs_ioctl+0x2f6/0x4e0
[ 1279.499171] [<c141ce92>] ? __do_page_fault+0x1e2/0x540
[ 1279.499175] [<c115c7f2>] ? dput+0x22/0x180
[ 1279.499178] [<c115bdda>] ? dget_parent+0x1a/0x60
[ 1279.499182] [<c1161b13>] ? set_close_on_exec+0x23/0x50
[ 1279.499186] [<c1157e5c>] ? do_fcntl+0x37c/0x480
[ 1279.499190] [<c115913f>] SyS_ioctl+0x8f/0xa0
[ 1279.499194] [<c1105511>] ? shrink_slab+0xa1/0x2d0
[ 1279.499198] [<c1420e0d>] sysenter_do_call+0x12/0x28
[ 1279.499201] [<c1105511>] ? shrink_slab+0xa1/0x2d0
[ 1279.499211] Restarting tasks ... done.
[ 1279.501152] video LNXVIDEO:00: Restoring backlight state
[ 1279.501376] video LNXVIDEO:01: Restoring backlight state
[ 1279.502496] PM: Syncing filesystems ... done.
[ 1279.831875] PM: Preparing system for freeze sleep
[ 1281.948583] Freezing user space processes ...
[ 1301.957641] Freezing of tasks failed after 20.00 seconds (3 tasks refusing to freeze, wq_busy=0):
[ 1301.957651] alsactl D c15ba540 0 418 1 0x00000004
[ 1301.957656] f2dddcd8 00000086 00000041 c15ba540 00000002 f7f6a8bb 0000012a f7f6a340
[ 1301.957663] 0000012a c165cc80 f7f6cfe1 0000012a f5e26c80 f2d6f0e0 000000d0 c1172a4b
[ 1301.957669] 01081dc0 f2dddcac f4fa8088 00000286 f50e2000 f50e2000 f2dddcc0 c104abc3
[ 1301.957676] Call Trace:
[ 1301.957687] [<c1172a4b>] ? __find_get_block_slow+0xcb/0x170
[ 1301.957697] [<c104abc3>] ? lock_timer_base.isra.36+0x23/0x50
[ 1301.957703] [<c14188b3>] schedule+0x23/0x60
[ 1301.957707] [<c141680b>] schedule_timeout+0xfb/0x1f0
[ 1301.957712] [<c104a7e0>] ? ftrace_raw_event_tick_stop+0x140/0x140
[ 1301.957734] [<f890642e>] snd_power_wait+0x9e/0xf0 [snd]
[ 1301.957741] [<c106b960>] ? wake_up_process+0x40/0x40
[ 1301.957747] [<c1105511>] ? shrink_slab+0xa1/0x2d0
[ 1301.957755] [<f8908def>] snd_ctl_elem_info_user+0x4f/0x250 [snd]
[ 1301.957760] [<c1105511>] ? shrink_slab+0xa1/0x2d0
[ 1301.957768] [<f890a29a>] snd_ctl_ioctl+0x6ba/0xa80 [snd]
[ 1301.957773] [<c12178f5>] ? __copy_to_user_ll+0x55/0x60
[ 1301.957778] [<c1156cdb>] ? do_filp_open+0x2b/0x90
[ 1301.957785] [<f8909be0>] ? snd_ctl_open+0x150/0x150 [snd]
[ 1301.957789] [<c1158ec6>] do_vfs_ioctl+0x2f6/0x4e0
[ 1301.957793] [<c115297d>] ? final_putname+0x1d/0x40
[ 1301.957798] [<c1161b13>] ? set_close_on_exec+0x23/0x50
[ 1301.957802] [<c1157e5c>] ? do_fcntl+0x37c/0x480
[ 1301.957806] [<c115913f>] SyS_ioctl+0x8f/0xa0
[ 1301.957810] [<c1105511>] ? shrink_slab+0xa1/0x2d0
[ 1301.957818] [<c1420e0d>] sysenter_do_call+0x12/0x28
[ 1301.957822] [<c1105511>] ? shrink_slab+0xa1/0x2d0
[ 1301.957824] alsactl D c15ba540 0 419 1 0x00000004
[ 1301.957828] f2f59cd8 00000086 00000041 c15ba540 00000002 f88f68d0 0000012a f88f6262
[ 1301.957834] 0000012a c165cc80 f88f8c0e 0000012a f5e26c80 f2d6f640 000000d0 c1172a4b
[ 1301.957840] 01051c00 f2f59cac f4fa8088 00000286 f50e2000 f50e2000 f2f59cc0 c104abc3
[ 1301.957846] Call Trace:
[ 1301.957859] [<c1172a4b>] ? __find_get_block_slow+0xcb/0x170
[ 1301.957864] [<c104abc3>] ? lock_timer_base.isra.36+0x23/0x50
[ 1301.957868] [<c14188b3>] schedule+0x23/0x60
[ 1301.957872] [<c141680b>] schedule_timeout+0xfb/0x1f0
[ 1301.957876] [<c104a7e0>] ? ftrace_raw_event_tick_stop+0x140/0x140
[ 1301.957884] [<f890642e>] snd_power_wait+0x9e/0xf0 [snd]
[ 1301.957888] [<c106b960>] ? wake_up_process+0x40/0x40
[ 1301.957892] [<c1105511>] ? shrink_slab+0xa1/0x2d0
[ 1301.957899] [<f8908def>] snd_ctl_elem_info_user+0x4f/0x250 [snd]
[ 1301.957904] [<c1105511>] ? shrink_slab+0xa1/0x2d0
[ 1301.957911] [<f890a29a>] snd_ctl_ioctl+0x6ba/0xa80 [snd]
[ 1301.957914] [<c12178f5>] ? __copy_to_user_ll+0x55/0x60
[ 1301.957918] [<c1156cdb>] ? do_filp_open+0x2b/0x90
[ 1301.957925] [<f8909be0>] ? snd_ctl_open+0x150/0x150 [snd]
[ 1301.957929] [<c1158ec6>] do_vfs_ioctl+0x2f6/0x4e0
[ 1301.957933] [<c115297d>] ? final_putname+0x1d/0x40
[ 1301.957936] [<c1161b13>] ? set_close_on_exec+0x23/0x50
[ 1301.957940] [<c1157e5c>] ? do_fcntl+0x37c/0x480
[ 1301.957944] [<c115913f>] SyS_ioctl+0x8f/0xa0
[ 1301.957948] [<c1105511>] ? shrink_slab+0xa1/0x2d0
[ 1301.957952] [<c1420e0d>] sysenter_do_call+0x12/0x28
[ 1301.957955] [<c1105511>] ? shrink_slab+0xa1/0x2d0
[ 1301.957965] pulseaudio D f1e4bc74 0 842 841 0x00000004
[ 1301.957968] f1e4bcd8 00000086 f2e9813c f1e4bc74 00000000 057ff31d 0000012f 057fedcd
[ 1301.957974] 0000012f c165cc80 05801a0d 0000012f f5e0ac80 f2d7f0e0 f1e4bcac 00000246
[ 1301.957980] 0000070e f1e4bcb4 f90dbc58 00000282 c16f3a40 c16f3a40 f1e4bcc0 c104abc3
[ 1301.957986] Call Trace:
[ 1301.957996] [<f90dbc58>] ? set_dig_out+0x28/0x70 [snd_hda_codec]
[ 1301.958001] [<c104abc3>] ? lock_timer_base.isra.36+0x23/0x50
[ 1301.958005] [<c14188b3>] schedule+0x23/0x60
[ 1301.958008] [<c141680b>] schedule_timeout+0xfb/0x1f0
[ 1301.958013] [<c104a7e0>] ? ftrace_raw_event_tick_stop+0x140/0x140
[ 1301.958020] [<f890642e>] snd_power_wait+0x9e/0xf0 [snd]
[ 1301.958024] [<c106b960>] ? wake_up_process+0x40/0x40
[ 1301.958028] [<c1105511>] ? shrink_slab+0xa1/0x2d0
[ 1301.958035] [<f8908def>] snd_ctl_elem_info_user+0x4f/0x250 [snd]
[ 1301.958040] [<c1105511>] ? shrink_slab+0xa1/0x2d0
[ 1301.958047] [<f890a29a>] snd_ctl_ioctl+0x6ba/0xa80 [snd]
[ 1301.958053] [<c1119b76>] ? handle_pte_fault+0x76/0x8a0
[ 1301.958056] [<c12178f5>] ? __copy_to_user_ll+0x55/0x60
[ 1301.958061] [<c111a596>] ? handle_mm_fault+0x1f6/0x280
[ 1301.958068] [<f8909be0>] ? snd_ctl_open+0x150/0x150 [snd]
[ 1301.958071] [<c1158ec6>] do_vfs_ioctl+0x2f6/0x4e0
[ 1301.958075] [<c141ce92>] ? __do_page_fault+0x1e2/0x540
[ 1301.958079] [<c115c7f2>] ? dput+0x22/0x180
[ 1301.958083] [<c115bdda>] ? dget_parent+0x1a/0x60
[ 1301.958087] [<c1161b13>] ? set_close_on_exec+0x23/0x50
[ 1301.958090] [<c1157e5c>] ? do_fcntl+0x37c/0x480
[ 1301.958094] [<c115913f>] SyS_ioctl+0x8f/0xa0
[ 1301.958098] [<c1105511>] ? shrink_slab+0xa1/0x2d0
[ 1301.958102] [<c1420e0d>] sysenter_do_call+0x12/0x28
[ 1301.958106] [<c1105511>] ? shrink_slab+0xa1/0x2d0
[ 1301.958115] Restarting tasks ... done.
[ 1301.961265] video LNXVIDEO:00: Restoring backlight state
[ 1301.961483] video LNXVIDEO:01: Restoring backlight statealsactl related output from journalctl:
Jun 09 18:49:50 kistn systemd-udevd[157]: timeout '/usr/bin/alsactl restore '
Jun 09 18:49:50 kistn systemd-udevd[161]: timeout '/usr/bin/alsactl restore '
Jun 09 18:49:51 kistn dbus[271]: [system] Activating via systemd: service name='org.freedesktop.Avahi' unit='dbus-org.free
Jun 09 18:49:51 kistn dbus[271]: [system] Activation via systemd failed for unit 'dbus-org.freedesktop.Avahi.service': Uni
Jun 09 18:49:51 kistn systemd-udevd[161]: timeout: killing '/usr/bin/alsactl restore ' [419]
Jun 09 18:49:51 kistn systemd-udevd[157]: timeout: killing '/usr/bin/alsactl restore ' [418]
Jun 09 18:49:51 kistn systemd-udevd[144]: worker [157] /devices/pci0000:00/0000:00:01.0/0000:01:00.1/sound/card1/controlC1
Jun 09 18:49:51 kistn systemd-udevd[144]: seq 1677 '/devices/pci0000:00/0000:00:01.0/0000:01:00.1/sound/card1/controlC1' k
Jun 09 18:49:51 kistn systemd-udevd[144]: worker [161] /devices/pci0000:00/0000:00:1b.0/sound/card0/controlC0 timeout; kil
Jun 09 18:49:51 kistn systemd-udevd[144]: seq 1595 '/devices/pci0000:00/0000:00:1b.0/sound/card0/controlC0' killed
Jun 09 18:49:51 kistn systemd-udevd[144]: worker [157] terminated by signal 9 (Killed)
Jun 09 18:49:51 kistn systemd-udevd[144]: worker [161] terminated by signal 9 (Killed)#cat /sys/kernel/debug/vgaswitcheroo/switch
0:IGD:+:Pwr:0000:00:02.0
1:DIS: :Off:0000:01:00.0
2:DIS-Audio: :Off:0000:01:00.1# lspci|grep -i VGA
00:02.0 VGA compatible controller: Intel Corporation Core Processor Integrated Graphics Controller (rev 12)
01:00.0 VGA compatible controller: Advanced Micro Devices, Inc. [AMD/ATI] Park [Mobility Radeon HD 5430/5450/5470] (rev ff)
# lspci|grep -i audio
00:1b.0 Audio device: Intel Corporation 5 Series/3400 Series Chipset High Definition Audio (rev 05)
01:00.1 Audio device: Advanced Micro Devices, Inc. [AMD/ATI] Cedar HDMI Audio [Radeon HD 5400/6300 Series] (rev ff)Last edited by stri (2014-06-12 04:05:55)
Offline
#2 2014-06-10 06:37:14
- R3D
- Member
- Registered: 2014-01-12
- Posts: 14
Re: [workaround] suspend fails
I believe this is a bug with arch and has been for some time, I have had this problem also. Can anyone else back me up on this?
"Do not attribute to malice that which can be explained through incompetence"
Offline
#3 2014-06-11 01:23:17
- fungle
- Member
- Registered: 2014-05-01
- Posts: 81
Re: [workaround] suspend fails
Your journal log seems to be cut off. Post the full log. Try running systemd-udevd with the --debug switch, maybe that can give you more info. You can edit the ExecStart line in th systemd-udevd.service file in /usr/lib/systemd/system/, or override it with a conf file in /etc/systemd/system/systemd-udevd.service.d/
Offline
#4 2014-06-12 03:58:37
- stri
- Member
- Registered: 2014-06-09
- Posts: 72
Re: [workaround] suspend fails
Thanks for your replies!
Yesterday I found out that the problem only occurs with the LTS linux version, suspend works fine in the current kernel (contrary to what I claimed in the first post). I installed the LTS version a while ago because I have a networking problem, and didn't realize that the LTS version becomes the default choice in GRUB. Sorry about that.
Offline
Pages: 1