kernel-3.15 series fail to load gnome desktop

Tom London selinux at gmail.com
Sat Apr 19 16:32:00 UTC 2014


On Sat, Apr 19, 2014 at 8:22 AM, Tom London <selinux at gmail.com> wrote:

> I also had not been able to get a 3-15 kernel to boot-up/display the Gnome
> desktop (Lenovo X200, Intel graphics).
>
> I had tried my usual tricks:
> 1. boot with enforcing=0
> 2. switch to a VT, run "telinit 3" and then "telinit 5".
>
> I noticed that "ps" seemed to be reporting that all was well: all the
> obvious processes were running, but I did notice more than the usual number
> of pulseaudio processes.
>
> I also noticed shutdown hanging on "saving sound state" (or some such).
>
> I tried again with the latest  kernel
> (kernel-3.15.0-0.rc1.git4.1.fc21.x86_64), and when I reached the "black
> screen" state, I switch to a VT, and as root killed all the pulseaudio
> processes ('killall -9 pulseaudio'). Within about 5-10 seconds, I got the
> gdm-greeter login screen. System hung (black screen) again after entering
> password, so I switched to VT and again killed the pulseaudio processes
> with 'killall -9 pulseaudio'.  Apparently the "new ones" were spawned by
> login process.
>
> Lo and behold, got my gnome desktop (of course, no sound).
>
> I have absolutely no idea what relationship pulsaudio/sound has to
> gdm/gnome/shutting down.
>
> Anyone have any ideas/thoughs?
>
> tom
> --
> Tom London
>

See this spew in journal:

Apr 19 08:12:34 tlondon.localhost.org pulseaudio[857]: [pulseaudio]
authkey.c: Failed to open cookie file '/var/lib/gdm/.config/pulse/cookie':
No such file or directory
Apr 19 08:12:34 tlondon.localhost.org pulseaudio[857]: [pulseaudio]
authkey.c: Failed to load authorization key
'/var/lib/gdm/.config/pulse/cookie': No such file or director
Apr 19 08:12:34 tlondon.localhost.org rtkit-daemon[648]: Successfully made
thread 860 of process 860 (/usr/bin/pulseaudio) owned by '42' high priority
at nice level -11.
Apr 19 08:12:34 tlondon.localhost.org rtkit-daemon[648]: Supervising 1
threads of 1 processes of 1 users.
Apr 19 08:12:34 tlondon.localhost.org gdm-Xorg-:0[719]: (II) intel(0): EDID
vendor "LEN", prod id 16400
Apr 19 08:12:34 tlondon.localhost.org gdm-Xorg-:0[719]: (II) intel(0):
Printing DDC gathered Modelines:
Apr 19 08:12:34 tlondon.localhost.org gdm-Xorg-:0[719]: (II) intel(0):
Modeline "1280x800"x0.0   75.30  1280 1296 1344 1512  800 802 804 830
-hsync -vsync (49.8 kHz eP)
Apr 19 08:12:34 tlondon.localhost.org gdm-Xorg-:0[719]: (II) intel(0):
Modeline "1280x800"x0.0   59.26  1280 1328 1360 1440  800 803 809 823
-hsync -vsync (41.2 kHz e)
Apr 19 08:12:35 tlondon.localhost.org kernel: usb 1-5.3.4: reset high-speed
USB device number 7 using ehci-pci
Apr 19 08:12:35 tlondon.localhost.org pulseaudio[865]: [pulseaudio]
authkey.c: Failed to open cookie file '/var/lib/gdm/.config/pulse/cookie':
No such file or directory
Apr 19 08:12:35 tlondon.localhost.org pulseaudio[865]: [pulseaudio]
authkey.c: Failed to load authorization key
'/var/lib/gdm/.config/pulse/cookie': No such file or director
Apr 19 08:12:35 tlondon.localhost.org kernel:
Apr 19 08:12:35 tlondon.localhost.org kernel:
=============================================
Apr 19 08:12:35 tlondon.localhost.org kernel: [ INFO: possible recursive
locking detected ]
Apr 19 08:12:35 tlondon.localhost.org kernel:
3.15.0-0.rc1.git4.1.fc21.x86_64 #1 Tainted: G        W
Apr 19 08:12:35 tlondon.localhost.org kernel:
---------------------------------------------
Apr 19 08:12:35 tlondon.localhost.org kernel: pulseaudio/860 is trying to
acquire lock:
Apr 19 08:12:35 tlondon.localhost.org kernel:
(&chip->shutdown_rwsem){.+.+.+}, at: [<ffffffffa0613013>]
snd_usb_autoresume+0x23/0x60 [snd_usb_audio]
Apr 19 08:12:35 tlondon.localhost.org kernel:
                                              but task is already holding
lock:
Apr 19 08:12:35 tlondon.localhost.org kernel:
(&chip->shutdown_rwsem){.+.+.+}, at: [<ffffffffa0613013>]
snd_usb_autoresume+0x23/0x60 [snd_usb_audio]
Apr 19 08:12:35 tlondon.localhost.org kernel:
                                              other info that might help us
debug this:
Apr 19 08:12:35 tlondon.localhost.org kernel:  Possible unsafe locking
scenario:
Apr 19 08:12:35 tlondon.localhost.org kernel:        CPU0
Apr 19 08:12:35 tlondon.localhost.org kernel:        ----
Apr 19 08:12:35 tlondon.localhost.org kernel:   lock(&chip->shutdown_rwsem);
Apr 19 08:12:35 tlondon.localhost.org kernel:   lock(&chip->shutdown_rwsem);
Apr 19 08:12:35 tlondon.localhost.org kernel:
                                               *** DEADLOCK ***
Apr 19 08:12:35 tlondon.localhost.org kernel:  May be due to missing lock
nesting notation
Apr 19 08:12:35 tlondon.localhost.org kernel: 2 locks held by
pulseaudio/860:
Apr 19 08:12:35 tlondon.localhost.org kernel:  #0:
(&pcm->open_mutex){+.+.+.}, at: [<ffffffffa0480dbc>]
snd_pcm_open+0xac/0x290 [snd_pcm]
Apr 19 08:12:35 tlondon.localhost.org kernel:  #1:
(&chip->shutdown_rwsem){.+.+.+}, at: [<ffffffffa0613013>]
snd_usb_autoresume+0x23/0x60 [snd_usb_audio]
Apr 19 08:12:35 tlondon.localhost.org kernel:
                                              stack backtrace:
Apr 19 08:12:35 tlondon.localhost.org kernel: CPU: 0 PID: 860 Comm:
pulseaudio Tainted: G        W     3.15.0-0.rc1.git4.1.fc21.x86_64 #1
Apr 19 08:12:35 tlondon.localhost.org kernel: Hardware name: LENOVO
74585FU/74585FU, BIOS 6DET72WW (3.22 ) 10/25/2012
Apr 19 08:12:35 tlondon.localhost.org kernel:  0000000000000000
00000000c0bd0f84 ffff8800a40bd590 ffffffff817e84d0
Apr 19 08:12:35 tlondon.localhost.org kernel:  ffffffff82843b50
ffff8800a40bd668 ffffffff810fa842 ffffffff810db86d
Apr 19 08:12:35 tlondon.localhost.org kernel:  ffff880136fd68c0
0000000000000010 ffff880100000000 00000015009564ab
Apr 19 08:12:35 tlondon.localhost.org kernel: Call Trace:
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff817e84d0>]
dump_stack+0x4d/0x66
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff810fa842>]
__lock_acquire+0x14c2/0x1d10
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff810db86d>] ?
sched_clock_local+0x1d/0x90
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff810f8d9c>] ?
mark_held_locks+0x7c/0xb0
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff817f0d56>] ?
_raw_spin_unlock_irqrestore+0x36/0x70
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff81022a6e>] ?
native_sched_clock+0x2e/0xb0
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff81022af9>] ?
sched_clock+0x9/0x10
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff810db86d>] ?
sched_clock_local+0x1d/0x90
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff810fb974>]
lock_acquire+0xa4/0x1d0
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffffa0613013>] ?
snd_usb_autoresume+0x23/0x60 [snd_usb_audio]
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff817ef951>]
down_read+0x51/0xa0
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffffa0613013>] ?
snd_usb_autoresume+0x23/0x60 [snd_usb_audio]
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffffa0613013>]
snd_usb_autoresume+0x23/0x60 [snd_usb_audio]
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffffa06175be>]
snd_usb_mixer_set_ctl_value+0xce/0x260 [snd_usb_audio]
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffffa067fb7d>] ?
uvc_set_video_ctrl.isra.10+0x11d/0x1d0 [uvcvideo]
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffffa06177bc>]
set_cur_mix_value+0x6c/0xe0 [snd_usb_audio]
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffffa061a66a>]
snd_usb_mixer_resume+0xfa/0x130 [snd_usb_audio]
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffffa0612068>]
__usb_audio_resume+0x68/0xf0 [snd_usb_audio]
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff81590f80>] ?
usb_runtime_suspend+0x70/0x70
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffffa0612103>]
usb_audio_reset_resume+0x13/0x20 [snd_usb_audio]
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff8158f959>]
usb_resume_interface.isra.5+0x69/0x120
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff8158fc74>]
usb_resume_both+0x74/0x140
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff81590f9a>]
usb_runtime_resume+0x1a/0x20
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff8150ed72>]
__rpm_callback+0x32/0x70
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff8150edd6>]
rpm_callback+0x26/0xa0
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff8150f69e>]
rpm_resume+0x49e/0x7f0
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff8150f4da>]
rpm_resume+0x2da/0x7f0
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff81510ccf>]
__pm_runtime_resume+0x4f/0x90
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff8158f732>]
usb_autopm_get_interface+0x22/0x60
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffffa0613031>]
snd_usb_autoresume+0x41/0x60 [snd_usb_audio]
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffffa061cfb1>]
snd_usb_pcm_open+0x241/0x520 [snd_usb_audio]
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffffa061d2a3>]
snd_usb_capture_open+0x13/0x20 [snd_usb_audio]
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffffa0480c54>]
snd_pcm_open_substream+0x84/0x140 [snd_pcm]
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffffa0480de2>]
snd_pcm_open+0xd2/0x290 [snd_pcm]
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff810f8fdd>] ?
trace_hardirqs_on+0xd/0x10
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff810d7f60>] ?
wake_up_state+0x20/0x20
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffffa0480fe7>]
snd_pcm_capture_open+0x47/0x70 [snd_pcm]
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffffa02295d3>]
snd_open+0xb3/0x190 [snd]
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff8123ec8e>]
chrdev_open+0xae/0x1d0
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff8123ebe0>] ?
cdev_put+0x30/0x30
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff812372bd>]
do_dentry_open+0x1ed/0x2d0
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff812374b1>]
finish_open+0x41/0x60
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff8124cadc>]
do_last+0xdac/0x14a0
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff81247189>] ?
link_path_walk+0xa9/0x1490
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff810dbb26>] ?
local_clock+0x16/0x30
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff8124d29e>]
path_openat+0xce/0x700
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff81022a6e>] ?
native_sched_clock+0x2e/0xb0
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff81022a6e>] ?
native_sched_clock+0x2e/0xb0
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff81022af9>] ?
sched_clock+0x9/0x10
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff8124e16d>]
do_filp_open+0x4d/0xc0
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff817f0cc7>] ?
_raw_spin_unlock+0x27/0x40
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff8125e3ef>] ?
__alloc_fd+0xaf/0x1c0
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff812390eb>]
do_sys_open+0x13b/0x250
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff8123921e>]
SyS_open+0x1e/0x20
Apr 19 08:12:35 tlondon.localhost.org kernel:  [<ffffffff817fbd69>]
system_call_fastpath+0x16/0x1b

And this:

Apr 19 08:15:46 tlondon.localhost.org kernel: INFO: task pulseaudio:860
blocked for more than 120 seconds.
Apr 19 08:15:46 tlondon.localhost.org kernel:       Tainted: G        W
3.15.0-0.rc1.git4.1.fc21.x86_64 #1
Apr 19 08:15:46 tlondon.localhost.org kernel: "echo 0 >
/proc/sys/kernel/hung_task_timeout_secs" disables this message.
Apr 19 08:15:46 tlondon.localhost.org kernel: pulseaudio      D
ffff8800b71cb380  3720   860      1 0x00000084
Apr 19 08:15:46 tlondon.localhost.org kernel:  ffff8800a40bd590
0000000000000046 ffff8800b71cb380 00000000001d5dc0
Apr 19 08:15:46 tlondon.localhost.org kernel:  ffff8800a40bdfd8
00000000001d5dc0 ffffffff81e16580 ffff880037033890
Apr 19 08:15:46 tlondon.localhost.org kernel:  ffff8800370339b8
ffff880037033b58 0000000000000000 0000000000000000
Apr 19 08:15:46 tlondon.localhost.org kernel: Call Trace:
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff817eb809>]
schedule+0x29/0x70
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff8150f3c5>]
rpm_resume+0x1c5/0x7f0
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff810eecd0>] ?
abort_exclusive_wait+0xb0/0xb0
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff8150f4da>]
rpm_resume+0x2da/0x7f0
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff81510ccf>]
__pm_runtime_resume+0x4f/0x90
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff8158f732>]
usb_autopm_get_interface+0x22/0x60
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffffa0613031>]
snd_usb_autoresume+0x41/0x60 [snd_usb_audio]
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffffa06175be>]
snd_usb_mixer_set_ctl_value+0xce/0x260 [snd_usb_audio]
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffffa067fb7d>] ?
uvc_set_video_ctrl.isra.10+0x11d/0x1d0 [uvcvideo]
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffffa06177bc>]
set_cur_mix_value+0x6c/0xe0 [snd_usb_audio]
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffffa061a66a>]
snd_usb_mixer_resume+0xfa/0x130 [snd_usb_audio]
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffffa0612068>]
__usb_audio_resume+0x68/0xf0 [snd_usb_audio]
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff81590f80>] ?
usb_runtime_suspend+0x70/0x70
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffffa0612103>]
usb_audio_reset_resume+0x13/0x20 [snd_usb_audio]
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff8158f959>]
usb_resume_interface.isra.5+0x69/0x120
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff8158fc74>]
usb_resume_both+0x74/0x140
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff81590f9a>]
usb_runtime_resume+0x1a/0x20
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff8150ed72>]
__rpm_callback+0x32/0x70
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff8150edd6>]
rpm_callback+0x26/0xa0
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff8150f69e>]
rpm_resume+0x49e/0x7f0
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff8150f4da>]
rpm_resume+0x2da/0x7f0
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff81510ccf>]
__pm_runtime_resume+0x4f/0x90
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff8158f732>]
usb_autopm_get_interface+0x22/0x60
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffffa0613031>]
snd_usb_autoresume+0x41/0x60 [snd_usb_audio]
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffffa061cfb1>]
snd_usb_pcm_open+0x241/0x520 [snd_usb_audio]
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffffa061d2a3>]
snd_usb_capture_open+0x13/0x20 [snd_usb_audio]
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffffa0480c54>]
snd_pcm_open_substream+0x84/0x140 [snd_pcm]
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffffa0480de2>]
snd_pcm_open+0xd2/0x290 [snd_pcm]
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff810f8fdd>] ?
trace_hardirqs_on+0xd/0x10
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff810d7f60>] ?
wake_up_state+0x20/0x20
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffffa0480fe7>]
snd_pcm_capture_open+0x47/0x70 [snd_pcm]
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffffa02295d3>]
snd_open+0xb3/0x190 [snd]
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff8123ec8e>]
chrdev_open+0xae/0x1d0
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff8123ebe0>] ?
cdev_put+0x30/0x30
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff812372bd>]
do_dentry_open+0x1ed/0x2d0
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff812374b1>]
finish_open+0x41/0x60
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff8124cadc>]
do_last+0xdac/0x14a0
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff81247189>] ?
link_path_walk+0xa9/0x1490
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff810dbb26>] ?
local_clock+0x16/0x30
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff8124d29e>]
path_openat+0xce/0x700
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff81022a6e>] ?
native_sched_clock+0x2e/0xb0
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff81022a6e>] ?
native_sched_clock+0x2e/0xb0
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff81022af9>] ?
sched_clock+0x9/0x10
Apr 19 08:15:46 tlondon.localhost.org kernel:  [<ffffffff8124e16d>]
do_filp_open+0x4d/0xc0


-- 
Tom London
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.fedoraproject.org/pipermail/test/attachments/20140419/043c86e9/attachment-0001.html>


More information about the test mailing list