Bug 13316

Summary:	task khubd:281 blocked for more than 120 seconds
Product:	Drivers	Reporter:	Martin Bammer (mrb74)
Component:	USB	Assignee:	Greg Kroah-Hartman (greg)
Status:	RESOLVED INVALID
Severity:	normal	CC:	gonzhauser, raa.lkml
Priority:	P1
Hardware:	All
OS:	Linux
Kernel Version:	2.6.30-rc5	Subsystem:
Regression:	No	Bisected commit-id:
Attachments:	Resume bug with dib0700 device Resume bug with dib0700 device dmesg output of 2.6.32-rc8-git3

Description Martin Bammer 2009-05-15 17:46:49 UTC

When unplugging the dvb-t device while using it (running me-tv) I got the following syslog output:

May 15 19:35:42 jupiter kernel: [ 6601.222871] INFO: task khubd:281 blocked for more than 120 seconds.
May 15 19:35:42 jupiter kernel: [ 6601.222890] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
May 15 19:35:42 jupiter kernel: [ 6601.222906] khubd         D 000005e3     0   281      2
May 15 19:35:42 jupiter kernel: [ 6601.222932]  f71b3e30 00000046 bc40db98 000005e3 f0ce8000 f71b3dd0 c08e0510 c08a8dc0
May 15 19:35:42 jupiter kernel: [ 6601.222982]  c08a8dc0 00000000 f256fab8 f71994e0 f7199774 c2225dc0 00000000 c014046b
May 15 19:35:42 jupiter kernel: [ 6601.223030]  bc414f32 000005e3 f256fab8 ffffffff 00000000 00000046 f71b3e14 f256faa8
May 15 19:35:42 jupiter kernel: [ 6601.223077] Call Trace:
May 15 19:35:42 jupiter kernel: [ 6601.223112]  [<c014046b>] ? prepare_to_wait+0x14/0x48
May 15 19:35:42 jupiter kernel: [ 6601.223136]  [<c014d665>] ? trace_hardirqs_on+0xb/0xd
May 15 19:35:42 jupiter kernel: [ 6601.223160]  [<c04c9459>] ? _spin_unlock_irqrestore+0x5f/0x6c
May 15 19:35:42 jupiter kernel: [ 6601.223181]  [<c04c7833>] schedule+0x12/0x33
May 15 19:35:42 jupiter kernel: [ 6601.223235]  [<f8a989b2>] dvb_unregister_frontend+0x99/0xd3 [dvb_core]
May 15 19:35:42 jupiter kernel: [ 6601.223258]  [<c01402db>] ? autoremove_wake_function+0x0/0x33
May 15 19:35:42 jupiter kernel: [ 6601.223290]  [<f83f8b81>] dvb_usb_adapter_frontend_exit+0x15/0x25 [dvb_usb]
May 15 19:35:42 jupiter kernel: [ 6601.223318]  [<f83f82f8>] dvb_usb_exit+0x2c/0x93 [dvb_usb]
May 15 19:35:42 jupiter kernel: [ 6601.223345]  [<f83f8394>] dvb_usb_device_exit+0x35/0x47 [dvb_usb]
May 15 19:35:42 jupiter kernel: [ 6601.223369]  [<c03a2cdc>] usb_unbind_interface+0x4d/0xc4
May 15 19:35:42 jupiter kernel: [ 6601.223393]  [<c0348252>] __device_release_driver+0x5a/0x77
May 15 19:35:42 jupiter kernel: [ 6601.223413]  [<c034830c>] device_release_driver+0x18/0x23
May 15 19:35:42 jupiter kernel: [ 6601.223433]  [<c0347adc>] bus_remove_device+0x71/0x88
May 15 19:35:42 jupiter kernel: [ 6601.223453]  [<c034679a>] device_del+0xf9/0x152
May 15 19:35:42 jupiter kernel: [ 6601.223473]  [<c03a092f>] usb_disable_device+0x5c/0xba
May 15 19:35:42 jupiter kernel: [ 6601.223493]  [<c039c9e9>] usb_disconnect+0x73/0xdc
May 15 19:35:42 jupiter kernel: [ 6601.223564]  [<c039d7a8>] hub_thread+0x548/0xdf8
May 15 19:35:42 jupiter kernel: [ 6601.223601]  [<c014d639>] ? trace_hardirqs_on_caller+0x103/0x124
May 15 19:35:42 jupiter kernel: [ 6601.223632]  [<c01402db>] ? autoremove_wake_function+0x0/0x33
May 15 19:35:42 jupiter kernel: [ 6601.223660]  [<c039d260>] ? hub_thread+0x0/0xdf8
May 15 19:35:42 jupiter kernel: [ 6601.223685]  [<c039d260>] ? hub_thread+0x0/0xdf8
May 15 19:35:42 jupiter kernel: [ 6601.223714]  [<c013ffb6>] kthread+0x45/0x6b
May 15 19:35:42 jupiter kernel: [ 6601.223744]  [<c013ff71>] ? kthread+0x0/0x6b
May 15 19:35:42 jupiter kernel: [ 6601.223777]  [<c01037e7>] kernel_thread_helper+0x7/0x10
May 15 19:35:42 jupiter kernel: [ 6601.223796] INFO: lockdep is turned off.

lsusb:
Bus 005 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 004 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 003 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 002 Device 004: ID 046d:0a01 Logitech, Inc. USB Headset
Bus 002 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 001 Device 007: ID 0ccd:0078 TerraTec Electronic GmbH 
Bus 001 Device 002: ID 06f8:3020 Guillemot Corp. 
Bus 001 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub

lspci:
00:00.0 Host bridge: Intel Corporation Mobile 945GME Express Memory Controller Hub (rev 03)
00:02.0 VGA compatible controller: Intel Corporation Mobile 945GME Express Integrated Graphics Controller (rev 03)
00:02.1 Display controller: Intel Corporation Mobile 945GM/GMS/GME, 943/940GML Express Integrated Graphics Controller (rev 03)
00:1b.0 Audio device: Intel Corporation 82801G (ICH7 Family) High Definition Audio Controller (rev 02)
00:1c.0 PCI bridge: Intel Corporation 82801G (ICH7 Family) PCI Express Port 1 (rev 02)
00:1c.1 PCI bridge: Intel Corporation 82801G (ICH7 Family) PCI Express Port 2 (rev 02)
00:1c.2 PCI bridge: Intel Corporation 82801G (ICH7 Family) PCI Express Port 3 (rev 02)
00:1d.0 USB Controller: Intel Corporation 82801G (ICH7 Family) USB UHCI Controller #1 (rev 02)
00:1d.1 USB Controller: Intel Corporation 82801G (ICH7 Family) USB UHCI Controller #2 (rev 02)
00:1d.2 USB Controller: Intel Corporation 82801G (ICH7 Family) USB UHCI Controller #3 (rev 02)
00:1d.3 USB Controller: Intel Corporation 82801G (ICH7 Family) USB UHCI Controller #4 (rev 02)
00:1d.7 USB Controller: Intel Corporation 82801G (ICH7 Family) USB2 EHCI Controller (rev 02)
00:1e.0 PCI bridge: Intel Corporation 82801 Mobile PCI Bridge (rev e2)
00:1f.0 ISA bridge: Intel Corporation 82801GBM (ICH7-M) LPC Interface Bridge (rev 02)
00:1f.2 IDE interface: Intel Corporation 82801GBM/GHM (ICH7 Family) SATA IDE Controller (rev 02)
00:1f.3 SMBus: Intel Corporation 82801G (ICH7 Family) SMBus Controller (rev 02)
01:00.0 Ethernet controller: Realtek Semiconductor Co., Ltd. RTL8101E/RTL8102E PCI Express Fast Ethernet controller (rev 02)
02:00.0 Ethernet controller: Atheros Communications Inc. AR242x 802.11abg Wireless PCI Express Adapter (rev 01)

lsmod:
Module                  Size  Used by
snd_usb_audio          72016  1 
snd_usb_lib            14260  1 snd_usb_audio
snd_seq_midi            6008  0 
snd_rawmidi            19680  2 snd_usb_lib,snd_seq_midi
snd_hwdep               6660  1 snd_usb_audio
dvb_usb_dib0700        37004  7 
dib7000p               14300  2 dvb_usb_dib0700
dib7000m               12300  1 dvb_usb_dib0700
dvb_usb                15216  1 dvb_usb_dib0700
dvb_core               77632  1 dvb_usb
dib3000mc              11144  1 dvb_usb_dib0700
dibx000_common          3192  3 dib7000p,dib7000m,dib3000mc
dib0070                 6356  2 dvb_usb_dib0700
usb_storage            33144  0 
binfmt_misc             7556  1 
bridge                 41764  0 
stp                     2296  1 bridge
llc                     5888  2 bridge,stp
ppdev                   6576  0 
lp                      9320  0 
parport                32600  2 ppdev,lp
xfs                   433188  1 
exportfs                3836  1 xfs
ath5k                 104892  0 
uvcvideo               51076  0 
mac80211              190540  1 ath5k
rng_core                3884  0 
videodev               31492  1 uvcvideo
v4l1_compat            11860  2 uvcvideo,videodev
led_class               3944  1 ath5k
psmouse                51080  0 
serio_raw               5052  0 
pcspkr                  2160  0 
r8169                  28380  0 
uhci_hcd               19560  0 
mii                     4704  1 r8169

Comment 1 Andrew Morton 2009-05-28 07:05:20 UTC

(switched to email.  Please respond via emailed reply-to-all, not via the
bugzilla web interface).

On Fri, 15 May 2009 17:46:49 GMT bugzilla-daemon@bugzilla.kernel.org wrote:

> http://bugzilla.kernel.org/show_bug.cgi?id=13316
> 
>            Summary: task khubd:281 blocked for more than 120 seconds
>            Product: Drivers
>            Version: 2.5
>     Kernel Version: 2.6.30-rc5
>           Platform: All
>         OS/Version: Linux
>               Tree: Mainline
>             Status: NEW
>           Severity: normal
>           Priority: P1
>          Component: USB
>         AssignedTo: greg@kroah.com
>         ReportedBy: mrb74@gmx.at
>         Regression: No
> 
> 
> When unplugging the dvb-t device while using it (running me-tv) I got the
> following syslog output:
> 
> May 15 19:35:42 jupiter kernel: [ 6601.222871] INFO: task khubd:281 blocked
> for
> more than 120 seconds.
> May 15 19:35:42 jupiter kernel: [ 6601.222890] "echo 0 >
> /proc/sys/kernel/hung_task_timeout_secs" disables this message.
> May 15 19:35:42 jupiter kernel: [ 6601.222906] khubd         D 000005e3     0 
> 281      2
> May 15 19:35:42 jupiter kernel: [ 6601.222932]  f71b3e30 00000046 bc40db98
> 000005e3 f0ce8000 f71b3dd0 c08e0510 c08a8dc0
> May 15 19:35:42 jupiter kernel: [ 6601.222982]  c08a8dc0 00000000 f256fab8
> f71994e0 f7199774 c2225dc0 00000000 c014046b
> May 15 19:35:42 jupiter kernel: [ 6601.223030]  bc414f32 000005e3 f256fab8
> ffffffff 00000000 00000046 f71b3e14 f256faa8
> May 15 19:35:42 jupiter kernel: [ 6601.223077] Call Trace:
> May 15 19:35:42 jupiter kernel: [ 6601.223112]  [<c014046b>] ?
> prepare_to_wait+0x14/0x48
> May 15 19:35:42 jupiter kernel: [ 6601.223136]  [<c014d665>] ?
> trace_hardirqs_on+0xb/0xd
> May 15 19:35:42 jupiter kernel: [ 6601.223160]  [<c04c9459>] ?
> _spin_unlock_irqrestore+0x5f/0x6c
> May 15 19:35:42 jupiter kernel: [ 6601.223181]  [<c04c7833>]
> schedule+0x12/0x33
> May 15 19:35:42 jupiter kernel: [ 6601.223235]  [<f8a989b2>]
> dvb_unregister_frontend+0x99/0xd3 [dvb_core]
> May 15 19:35:42 jupiter kernel: [ 6601.223258]  [<c01402db>] ?
> autoremove_wake_function+0x0/0x33
> May 15 19:35:42 jupiter kernel: [ 6601.223290]  [<f83f8b81>]
> dvb_usb_adapter_frontend_exit+0x15/0x25 [dvb_usb]
> May 15 19:35:42 jupiter kernel: [ 6601.223318]  [<f83f82f8>]
> dvb_usb_exit+0x2c/0x93 [dvb_usb]
> May 15 19:35:42 jupiter kernel: [ 6601.223345]  [<f83f8394>]
> dvb_usb_device_exit+0x35/0x47 [dvb_usb]
> May 15 19:35:42 jupiter kernel: [ 6601.223369]  [<c03a2cdc>]
> usb_unbind_interface+0x4d/0xc4
> May 15 19:35:42 jupiter kernel: [ 6601.223393]  [<c0348252>]
> __device_release_driver+0x5a/0x77
> May 15 19:35:42 jupiter kernel: [ 6601.223413]  [<c034830c>]
> device_release_driver+0x18/0x23
> May 15 19:35:42 jupiter kernel: [ 6601.223433]  [<c0347adc>]
> bus_remove_device+0x71/0x88
> May 15 19:35:42 jupiter kernel: [ 6601.223453]  [<c034679a>]
> device_del+0xf9/0x152
> May 15 19:35:42 jupiter kernel: [ 6601.223473]  [<c03a092f>]
> usb_disable_device+0x5c/0xba
> May 15 19:35:42 jupiter kernel: [ 6601.223493]  [<c039c9e9>]
> usb_disconnect+0x73/0xdc
> May 15 19:35:42 jupiter kernel: [ 6601.223564]  [<c039d7a8>]
> hub_thread+0x548/0xdf8
> May 15 19:35:42 jupiter kernel: [ 6601.223601]  [<c014d639>] ?
> trace_hardirqs_on_caller+0x103/0x124
> May 15 19:35:42 jupiter kernel: [ 6601.223632]  [<c01402db>] ?
> autoremove_wake_function+0x0/0x33
> May 15 19:35:42 jupiter kernel: [ 6601.223660]  [<c039d260>] ?
> hub_thread+0x0/0xdf8
> May 15 19:35:42 jupiter kernel: [ 6601.223685]  [<c039d260>] ?
> hub_thread+0x0/0xdf8
> May 15 19:35:42 jupiter kernel: [ 6601.223714]  [<c013ffb6>]
> kthread+0x45/0x6b
> May 15 19:35:42 jupiter kernel: [ 6601.223744]  [<c013ff71>] ?
> kthread+0x0/0x6b
> May 15 19:35:42 jupiter kernel: [ 6601.223777]  [<c01037e7>]
> kernel_thread_helper+0x7/0x10
> May 15 19:35:42 jupiter kernel: [ 6601.223796] INFO: lockdep is turned off.
> 

Oh my, that wordwrapping is painful :( You're better off using
attachments with bugzilla.

Could be a USB bug, could be a DVB bug.  I'd guess DVB.  Both lists
cc'ed for disposition, please.

Comment 2 gonzhauser 2009-05-30 16:24:35 UTC

Happens for me, too.

Additionally, resuming from sleeping hangs for 40 to 60 seconds with the
dib0700 plugged in.

Comment 3 Martin Bammer 2009-05-31 09:17:23 UTC

I've tested now the dvb device again with the latest kernel master.
The problem which caused this bug report seems to be gone.
Then I tested suspend/resume with the dvb device plugged in and I got a similar problem as the previous bug reporter. The problem seems to be that the firmware can't be found and thus the usb device can't be reinitialized. See attachement.

Comment 4 Martin Bammer 2009-05-31 09:18:03 UTC

Created attachment 21651 [details]
Resume bug with dib0700 device

Comment 5 Martin Bammer 2009-05-31 09:24:28 UTC

Created attachment 21652 [details]
Resume bug with dib0700 device

When dvb device is plugged in then the video device doesn't reinitialize correctly (password dialog seems to be the small bar at the top left), keyboard is dead, only mouse works. Only the magic key sequences work. KMS is enabled. Maybe this issue is dedicated to another subsystem. But don't know which one (acpi, video,?).

Comment 6 gonzhauser 2009-06-04 00:12:44 UTC

dib0700 also seems to block suspending when running me-tv.
I tried suspending twice while me-tv was running, the kernel tried to suspend but switched back to the login prompt. After stopping me-tv it suspended two times.
I am pretty sure this is my dvb-t tuner that's causing problems.

lsmod|grep dvb:

dvb_usb_dib0700        39572  1 
dib7000p               16948  2 dvb_usb_dib0700
dib7000m               14768  1 dvb_usb_dib0700
dvb_usb                16152  1 dvb_usb_dib0700
dvb_core               86816  1 dvb_usb
dib3000mc              12468  1 dvb_usb_dib0700
dib0070                 7600  2 dvb_usb_dib0700

uname -r:
2.6.30-020630rc8-generic

from http://kernel.ubuntu.com/~kernel-ppa/mainline/

Comment 7 gonzhauser 2009-06-04 21:33:08 UTC

dmesg after kernel hangs again:

[34258.180072] usb 1-1: reset high speed USB device using ehci_hcd and address 4
[34258.312799] dvb-usb: found a 'Hauppauge Nova-T Stick' in cold state, will try to load a firmware
[34258.312805] usb 1-1: firmware: requesting dvb-usb-dib0700-1.20.fw
[34318.312097] dvb-usb: did not find the firmware file. (dvb-usb-dib0700-1.20.fw) Please see linux/Documentation/dvb/ for more details on firmware-problems. (-2)
[34318.312225] PM: resume devices took 63.620 seconds
[34318.312227] ------------[ cut here ]------------
[34318.312237] WARNING: at /home/kernel-ppa/mainline/build/kernel/power/main.c:176 suspend_test_finish+0x83/0x90()
[34318.312241] Hardware name: Inspiron 2200                   
[34318.312243] Component: resume devices
[34318.312245] Modules linked in: dvb_usb_dib0700 dib7000p dib7000m dvb_usb dvb_core dib3000mc dibx000_common dib0070 aes_i586 aes_generic binfmt_misc fbcon tileblit font bitblit softcursor ppdev i915 drm i2c_algo_bit bridge stp bnep lp parport arc4 ecb ath5k mac80211 led_class cfg80211 snd_intel8x0 snd_ac97_codec joydev ac97_bus snd_pcm_oss snd_mixer_oss snd_pcm snd_seq_dummy snd_seq_oss snd_seq_midi pcmcia snd_rawmidi snd_seq_midi_event dcdbas snd_seq snd_timer snd_seq_device yenta_socket psmouse rsrc_nonstatic pcmcia_core serio_raw pcspkr iTCO_wdt iTCO_vendor_support snd soundcore snd_page_alloc video output intel_agp agpgart usbhid e100 mii
[34318.312304] Pid: 1212, comm: pm-suspend Not tainted 2.6.30-020630rc8-generic #020630rc8
[34318.312307] Call Trace:
[34318.312314]  [<c0166a23>] ? suspend_test_finish+0x83/0x90
[34318.312318]  [<c0166a23>] ? suspend_test_finish+0x83/0x90
[34318.312326]  [<c013b7ec>] warn_slowpath_common+0x7c/0xa0
[34318.312330]  [<c0166a23>] ? suspend_test_finish+0x83/0x90
[34318.312335]  [<c013b856>] warn_slowpath_fmt+0x26/0x30
[34318.312339]  [<c0166a23>] suspend_test_finish+0x83/0x90
[34318.312344]  [<c0166abf>] suspend_devices_and_enter+0x8f/0xc0
[34318.312348]  [<c0166d23>] enter_state+0xc3/0xe0
[34318.312352]  [<c0166dd1>] state_store+0x91/0xd0
[34318.312356]  [<c0166d40>] ? state_store+0x0/0xd0
[34318.312362]  [<c02cc934>] kobj_attr_store+0x24/0x30
[34318.312369]  [<c02134db>] flush_write_buffer+0x4b/0x70
[34318.312374]  [<c02135c2>] sysfs_write_file+0x42/0x70
[34318.312381]  [<c01c7e76>] vfs_write+0x96/0x160
[34318.312386]  [<c0213580>] ? sysfs_write_file+0x0/0x70
[34318.312391]  [<c01c7ffd>] sys_write+0x3d/0x70
[34318.312396]  [<c0102ebc>] sysenter_do_call+0x12/0x28
[34318.312399] ---[ end trace 4c001d490f284970 ]---
[34318.312473] PM: Finishing wakeup.
[34318.312475] Restarting tasks ... done.

Comment 8 Alex Riesen 2009-08-16 11:39:38 UTC

Me too. 2.6.31-rc6, Pinnacle Hybrid Pro plugged in a Dell XPS m1330,
unplugged while having sox redirecting audio stream from the tv-stick
to local audio sink:

usb 2-1: USB disconnect, address 4
em28xx #0: resubmit of audio urb failed (error=-19)
em28xx #0: disconnecting em28xx #0 video
em28xx #0: V4L2 device /dev/vbi0 deregistered
em28xx #0: V4L2 device /dev/video1 deregistered
xc2028 5-0061: destroying instance
...
sox           D ffff88007e0b3e40     0  5478   4871 0x00000004
 ffff88006cce5d38 0000000000000046 0000000000000002 ffff88007e0b3e40
 000000000000068c 0000000000004000 0000000000014a80 000000000000eee8
 ffff88006cce5ce8 0000000000000202 ffff88007e0b3e40 ffff88007f301f20
Call Trace:
 [<ffffffff81067294>] ? mark_held_locks+0x4d/0x6b
 [<ffffffff81420a11>] ? mutex_lock_nested+0x17e/0x2a8
 [<ffffffff81420a19>] mutex_lock_nested+0x186/0x2a8
 [<ffffffffa00f78d2>] ? snd_em28xx_pcm_close+0x4d/0xc5 [em28xx_alsa]
 [<ffffffffa00f78d2>] snd_em28xx_pcm_close+0x4d/0xc5 [em28xx_alsa]
 [<ffffffff81312de4>] snd_pcm_release_substream+0x4e/0x7d
 [<ffffffff81312e4e>] snd_pcm_release+0x3b/0x8e
 [<ffffffff813065b6>] snd_disconnect_release+0xa3/0xc7
 [<ffffffff810c7d94>] __fput+0x11e/0x1e9
 [<ffffffff810c7e77>] fput+0x18/0x1a
 [<ffffffff810b36ae>] remove_vma+0x4f/0x74
 [<ffffffff810b4554>] do_munmap+0x2e9/0x30b
 [<ffffffff810b45b6>] sys_munmap+0x40/0x59
 [<ffffffff8100ba6b>] system_call_fastpath+0x16/0x1b
ps            D 000000000000002a     0  5570   4194 0x00000004
 ffff88006cc67d58 0000000000000046 ffff88007bb9e468 0000000000000000
 ffff88006cc67d48 0000000000004000 0000000000014a80 000000000000eee8
 00000000003ae02d 0000000100000002 ffff88007bb9dd60 ffffffff815fa020
Call Trace:
 [<ffffffff8142203c>] ? _spin_unlock_irq+0x2b/0x30
 [<ffffffff81067507>] ? trace_hardirqs_on_caller+0x10b/0x12f
 [<ffffffff81421c06>] __down_read+0x97/0xb3
 [<ffffffff81421128>] down_read+0x4d/0x52
 [<ffffffff810b059e>] ? access_process_vm+0x4d/0x1d2
 [<ffffffff810b059e>] access_process_vm+0x4d/0x1d2
 [<ffffffff814220ae>] ? _spin_unlock+0x26/0x2a
 [<ffffffff8110924c>] proc_pid_cmdline+0x6c/0xf9
 [<ffffffff8110a674>] proc_info_read+0x63/0xc3
 [<ffffffff810c7507>] vfs_read+0xab/0x147
 [<ffffffff810c7667>] sys_read+0x47/0x6f
 [<ffffffff8100ba6b>] system_call_fastpath+0x16/0x1b
...
INFO: task khubd:277 blocked for more than 120 seconds.
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
khubd         D ffff88006fe55a68     0   277      2 0x00000000
 ffff88007f17fb10 0000000000000046 ffffffff81058106 0000000000000046
 0000000000000000 0000000000004000 0000000000014a80 000000000000eee8
 0000000000000006 ffff88006fe55a68 ffff88007f163e40 ffff88007ddf9f20
Call Trace:
 [<ffffffff81058106>] ? prepare_to_wait+0x1e/0x69
 [<ffffffff81067538>] ? trace_hardirqs_on+0xd/0xf
 [<ffffffff8130647f>] snd_card_free+0x88/0xaf
 [<ffffffff81057f32>] ? autoremove_wake_function+0x0/0x38
 [<ffffffffa00f7033>] em28xx_audio_fini+0x2b/0x3c [em28xx_alsa]
 [<ffffffffa00cf48d>] em28xx_close_extension+0x38/0x5b [em28xx]
 [<ffffffffa00cd8a8>] em28xx_usb_disconnect+0xf7/0x121 [em28xx]
 [<ffffffff812b0457>] usb_unbind_interface+0x60/0xef
 [<ffffffff81244852>] __device_release_driver+0x80/0xc9
 [<ffffffff81244966>] device_release_driver+0x1e/0x2b
 [<ffffffff81243eab>] bus_remove_device+0xa8/0xc9
 [<ffffffff81242458>] device_del+0x13f/0x1ac
 [<ffffffff812ad767>] usb_disable_device+0x75/0xed
 [<ffffffff812a8beb>] usb_disconnect+0x96/0x110
 [<ffffffff812a9cf4>] hub_thread+0x697/0x11a7
 [<ffffffff81067538>] ? trace_hardirqs_on+0xd/0xf
 [<ffffffff81057f32>] ? autoremove_wake_function+0x0/0x38
 [<ffffffff812a965d>] ? hub_thread+0x0/0x11a7
 [<ffffffff81057bbd>] kthread+0x8f/0x97
 [<ffffffff8100cb1a>] child_rip+0xa/0x20
 [<ffffffff8103a3ee>] ? finish_task_switch+0x3b/0xef
 [<ffffffff8100c4bc>] ? restore_args+0x0/0x30
 [<ffffffff81057b2e>] ? kthread+0x0/0x97
 [<ffffffff8100cb10>] ? child_rip+0x0/0x20
2 locks held by khubd/277:
 #0:  (&dev->lock){+.+.+.}, at: [<ffffffffa00cd803>] em28xx_usb_disconnect+0x52/0x121 [em28xx]
 #1:  (em28xx_extension_devlist_lock){+.+.+.}, at: [<ffffffffa00cf46d>] em28xx_close_extension+0x18/0x5b [em28xx]
INFO: task sox:5478 blocked for more than 120 seconds.
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
sox           D ffff88007e0b3e40     0  5478   4871 0x00000004
 ffff88006cce5d38 0000000000000046 0000000000000002 ffff88007e0b3e40
 000000000000068c 0000000000004000 0000000000014a80 000000000000eee8
 ffff88006cce5ce8 0000000000000202 ffff88007e0b3e40 ffff88007f301f20
Call Trace:
 [<ffffffff81067294>] ? mark_held_locks+0x4d/0x6b
 [<ffffffff81420a11>] ? mutex_lock_nested+0x17e/0x2a8
 [<ffffffff81420a19>] mutex_lock_nested+0x186/0x2a8
 [<ffffffffa00f78d2>] ? snd_em28xx_pcm_close+0x4d/0xc5 [em28xx_alsa]
 [<ffffffffa00f78d2>] snd_em28xx_pcm_close+0x4d/0xc5 [em28xx_alsa]
 [<ffffffff81312de4>] snd_pcm_release_substream+0x4e/0x7d
 [<ffffffff81312e4e>] snd_pcm_release+0x3b/0x8e
 [<ffffffff813065b6>] snd_disconnect_release+0xa3/0xc7
 [<ffffffff810c7d94>] __fput+0x11e/0x1e9
 [<ffffffff810c7e77>] fput+0x18/0x1a
 [<ffffffff810b36ae>] remove_vma+0x4f/0x74
 [<ffffffff810b4554>] do_munmap+0x2e9/0x30b
 [<ffffffff810b45b6>] sys_munmap+0x40/0x59
 [<ffffffff8100ba6b>] system_call_fastpath+0x16/0x1b
3 locks held by sox/5478:
 #0:  (&mm->mmap_sem){++++++}, at: [<ffffffff810b45a8>] sys_munmap+0x32/0x59
 #1:  (&pcm->open_mutex){+.+.+.}, at: [<ffffffff81312e46>] snd_pcm_release+0x33/0x8e
 #2:  (&dev->lock){+.+.+.}, at: [<ffffffffa00f78d2>] snd_em28xx_pcm_close+0x4d/0xc5 [em28xx_alsa]

Comment 9 gonzhauser 2009-10-10 23:31:58 UTC

It seems that this is related to #6 on the oops count for 2.6.31. Is anybody looking into this?

Comment 10 Martin Bammer 2009-12-01 23:40:18 UTC

Created attachment 23988 [details]
dmesg output of 2.6.32-rc8-git3

I've compiled the latest kernel with some debugging options enabled for drm and acpi. The log shows, that the kms problem comes from acpi. The lid is detected as "closed" and no external vga monitor is connected. A closed lid leads to "LVDS-1 is disconnected". "VGA-1 is disconnected" and "LVDS-1 is disconnected" leads to "No connectors reported connected with modes" and then kms fails.

Comment 11 Martin Bammer 2009-12-01 23:41:50 UTC

Sorry wrong bug. Ignore comment #10.

Comment 12 Greg Kroah-Hartman 2012-02-22 21:01:07 UTC

All USB bugs should be sent to the linux-usb@vger.kernel.org mailing 
list, and not entered into bugzilla.  Please bring this issue up there,
if it is still a problem in the latest kernel release.