Bug 714065

Summary: Unplugging hybrid DVB-T/analog TV USB device (0ccd:005e, TerraTec Cinergy XS) causes Kernel Oops
Product: [openSUSE] openSUSE 11.4 Reporter: Till Dörges <doerges>
Component: KernelAssignee: E-mail List <kernel-maintainers>
Status: RESOLVED WONTFIX QA Contact: E-mail List <qa-bugs>
Severity: Normal    
Priority: P5 - None CC: jeffm, jslaby
Version: Final   
Target Milestone: ---   
Hardware: PC   
OS: openSUSE 11.4   
Whiteboard:
Found By: --- Services Priority:
Business Priority: Blocker: ---
Marketing QA Status: --- IT Deployment: ---

Description Till Dörges 2011-08-24 18:21:39 UTC
User-Agent:       Mozilla/5.0 (X11; Linux x86_64; rv:5.0) Gecko/20100101 Firefox/5.0

The following device reproducibly crashes my system, when it is unplugged. While plugged it works just fine:

# lsusb | grep -i terra
Bus 001 Device 007: ID 0ccd:005e TerraTec Electronic GmbH 

System information:
$  cat /etc/SuSE-release
openSUSE 11.4 (x86_64)
VERSION = 11.4
CODENAME = Celadon
$  uname -a
Linux box.none 2.6.37.6-0.7-desktop #1 SMP PREEMPT 2011-07-21 02:17:24 +0200 x86_64 x86_64 x86_64 GNU/Linux


The same also occurs on a i686 system:

$  cat /etc/SuSE-release
openSUSE 11.4 (i586)
VERSION = 11.4
CODENAME = Celadon
$  uname -a
Linux box2 2.6.37.6-0.7-default #1 SMP 2011-07-21 02:17:24 +0200 i686 i686 i386 GNU/Linux


Reproducible: Always

Steps to Reproduce:
1. Plug device into USB port
2. Unplug device

Actual Results:  
Kernel Oops.

Expected Results:  
No Kernel Oops.

I believe the bug has been described here already:  http://bugs.debian.org/cgi-bin/bugreport.cgi?bug=613275

Kernel Oops from x86_64 system:

--- snip ---
[34669.206770] usb 1-5.2: USB disconnect, address 8
[34669.206943] em28xx #0: disconnecting em28xx #0 video
[34669.210284] BUG: unable to handle kernel NULL pointer dereference at 0000000000000298
[34669.210322] IP: [<ffffffffa07f50e0>] ir_close+0x10/0x30 [ir_core]
[34669.210357] PGD 0 
[34669.210378] Oops: 0000 [#1] PREEMPT SMP 
[34669.210402] last sysfs file: /sys/devices/system/cpu/cpu1/cache/index2/shared_cpu_map
[34669.210428] CPU 0 
[34669.210433] Modules linked in: zl10353 em28xx_dvb dvb_core em28xx_alsa rc_terratec_cinergy_xs tuner_xc2028 tuner tvp5150 ir_lirc_codec lirc_dev ir_sony_decoder ir_jvc_decoder ir_rc6_decoder ir_rc5_decoder em28xx ir_nec_decoder v4l2_common videodev v4l1_compat v4l2_compat_ioctl32 ir_core videobuf_vmalloc videobuf_core tveeprom xt_physdev autofs4 ipt_MASQUERADE iptable_nat nf_nat bridge stp llc md5 nls_utf8 cifs tun fuse ip6t_LOG xt_tcpudp xt_pkttype ipt_LOG xt_limit af_packet rfcomm sco bnep l2cap microcode edd ip6t_REJECT nf_conntrack_ipv6 nf_defrag_ipv6 ip6table_raw xt_NOTRACK ipt_REJECT iptable_raw iptable_filter ip6table_mangle nf_conntrack_netbios_ns nf_conntrack_ipv4 nf_defrag_ipv4 ip_tables xt_conntrack nf_conntrack ip6table_filter ip6_tables x_tables cpufreq_conservative snd_pcm_oss cpufreq_userspace snd_mixer_oss cpufreq_powersave acpi_cpufreq snd_seq mperf loop arc4 ecb hdj_mod iwlagn iwlcore snd_rawmidi mac80211 snd_hda_codec_conexant btusb sdhci_pci snd_seq_device kvm
_intel firewire_ohci zaurus sdhci cdc_ether snd_hda_intel kvm cdc_acm cdc_wdm pcmcia snd_hda_codec cfg80211 bluetooth usbnet thinkpad_acpi r852 sg sr_mod firewire_core mmc_core e1000e sm_common yenta_socket nand iTCO_wdt snd_hwdep pcmcia_rsrc rfkill nand_ids nand_ecc iTCO_vendor_support i2c_i801 snd_pcm cdrom crc_itu_t pcmcia_core mtd snd_timer snd_page_alloc ppdev video tpm_tis wmi tpm snd parport_pc pcspkr button parport joydev battery ac tpm_bios soundcore ext4 jbd2 crc16 sha256_generic cbc dm_crypt linear radeon ttm drm_kms_helper drm i2c_algo_bit dm_snapshot dm_mod fan processor thermal thermal_sys [last unloaded: preloadtrace]
[34669.210907] 
[34669.210927] Pid: 24, comm: khubd Not tainted 2.6.37.6-0.7-desktop #1 LENOVO 4061AK3/4061AK3
[34669.210959] RIP: 0010:[<ffffffffa07f50e0>]  [<ffffffffa07f50e0>] ir_close+0x10/0x30 [ir_core]
[34669.210992] RSP: 0018:ffff88023b157b20  EFLAGS: 00010282
[34669.211015] RAX: 0000000000000000 RBX: ffff88016e1d5808 RCX: 0000000000000000
[34669.211034] RDX: ffff880227a1f780 RSI: 0000000000000000 RDI: ffff8801b35bfa58
[34669.211034] RBP: ffff8801b35bf800 R08: 0000000000000000 R09: 0000000000000000
[34669.211034] R10: 0000000000012640 R11: 00000000037f2000 R12: ffff8801b35bfa30
[34669.211034] R13: ffffffffa083d420 R14: ffffffffa083d488 R15: 0000000000000000
[34669.211034] FS:  0000000000000000(0000) GS:ffff8800bf600000(0000) knlGS:0000000000000000
[34669.211034] CS:  0010 DS: 0000 ES: 0000 CR0: 000000008005003b
[34669.211034] CR2: 0000000000000298 CR3: 0000000001a03000 CR4: 00000000000026e0
[34669.211034] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[34669.211034] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400
[34669.211034] Process khubd (pid: 24, threadinfo ffff88023b156000, task ffff88023b154640)
[34669.211034] Stack:
[34669.211034]  ffff8801b35bf800 ffffffff813becf4 ffff88016e1d58a8 ffff88016e1d5808
[34669.211034]  ffff88016e1d5800 ffffffff813c4840 ffff8801b35bf800 ffff8801b35bfc88
[34669.211034]  ffff8801b35bfcb0 ffffffff813c039d ffff8801b35bf800 ffff8801b35bfa58
[34669.211372] Call Trace:
[34669.211372]  [<ffffffff813becf4>] input_close_device+0x54/0x80
[34669.211372]  [<ffffffff813c4840>] evdev_disconnect+0x30/0x60
[34669.211372]  [<ffffffff813c039d>] input_unregister_device+0xad/0x160
[34669.211372]  [<ffffffffa07f6779>] ir_unregister_class+0x49/0x70 [ir_core]
[34669.211372]  [<ffffffffa07f5071>] ir_input_unregister+0x71/0xd0 [ir_core]
[34669.211372]  [<ffffffffa0831cee>] em28xx_ir_fini+0x2e/0x60 [em28xx]
[34669.211372]  [<ffffffffa082e385>] em28xx_release_resources+0x25/0x70 [em28xx]
[34669.211372]  [<ffffffffa082e46f>] em28xx_usb_disconnect+0x9f/0x150 [em28xx]
[34669.211372]  [<ffffffff8138d616>] usb_unbind_interface+0x66/0x1b0
[34669.211372]  [<ffffffff8132ce1f>] __device_release_driver+0x6f/0xf0
[34669.211372]  [<ffffffff8132cec5>] device_release_driver+0x25/0x40
[34669.211372]  [<ffffffff8132c894>] bus_remove_device+0x74/0xe0
[34669.211372]  [<ffffffff81329410>] device_del+0x120/0x1a0
[34669.211372]  [<ffffffff8138afcd>] usb_disable_device+0x6d/0x1a0
[34669.211372]  [<ffffffff8138355c>] usb_disconnect+0x9c/0x180
[34669.211372]  [<ffffffff813844dc>] hub_port_connect_change+0xac/0xa00
[34669.211372]  [<ffffffff81385124>] hub_events+0x2f4/0x660
[34669.211372]  [<ffffffff813854c5>] hub_thread+0x35/0x1a0
[34669.211372]  [<ffffffff8107ab06>] kthread+0x96/0xa0
[34669.211372]  [<ffffffff81003d74>] kernel_thread_helper+0x4/0x10
[34669.211372] Code: 31 c0 e8 74 d7 d2 e0 e9 6a ff ff ff 66 66 66 66 66 66 2e 0f 1f 84 00 00 00 00 00 48 83 ec 08 48 81 c7 58 02 00 00 e8 10 7c b3 e0 <48> 8b 80 98 02 00 00 48 8b 78 28 48 8b 40 40 48 83 c4 08 ff e0 
[34669.211372] RIP  [<ffffffffa07f50e0>] ir_close+0x10/0x30 [ir_core]
[34669.211372]  RSP <ffff88023b157b20>
[34669.211372] CR2: 0000000000000298
[34670.042268] ---[ end trace cb81836b8a224fbc ]---
--- snap ---


Kernel Oops from i686 system:

--- snip ---
[  121.235107] usb 4-1: USB disconnect, address 2
[  121.235310] em28xx #0: disconnecting em28xx #0 video
[  121.235608] BUG: unable to handle kernel NULL pointer dereference at 00000178
[  121.235658] IP: [<f9ad50ba>] ir_close+0xa/0x20 [ir_core]
[  121.235703] *pde = 00000000 
[  121.235730] Oops: 0000 [#1] SMP 
[  121.235755] last sysfs file: /sys/devices/LNXSYSTM:00/device:00/PNP0A03:00/device:01/PNP0C09:00/PNP0C0A:00/power_supply/BAT0/voltage_now
[  121.235787] Modules linked in: fuse ip6t_LOG xt_tcpudp xt_pkttype ipt_LOG xt_limit microcode cpufreq_conservative cpufreq_userspace cpufreq_powersave acpi_cpufreq mperf snd_pcm_oss snd_mixer_oss snd_seq snd_seq_device edd ip6t_REJECT nf_conntrack_ipv6 nf_defrag_ipv6 ip6table_raw xt_NOTRACK ipt_REJECT iptable_raw iptable_filter ip6table_mangle nf_conntrack_netbios_ns nf_conntrack_ipv4 nf_defrag_ipv4 ip_tables xt_conntrack nf_conntrack ip6table_filter ip6_tables x_tables usb_storage uas zl10353 em28xx_dvb dvb_core em28xx_alsa rc_terratec_cinergy_xs dm_crypt loop dm_mod tuner_xc2028 tuner tvp5150 ir_lirc_codec lirc_dev ir_sony_decoder ir_jvc_decoder em28xx ir_rc6_decoder v4l2_common ir_rc5_decoder ir_nec_decoder videodev v4l1_compat ir_core videobuf_vmalloc videobuf_core tveeprom sha256_generic ansi_cprng aes_i586 ohci_hcd snd_intel8x0 snd_intel8x0m pcmcia snd_ac97_codec ac97_bus snd_pcm yenta_socket snd_timer pcmcia_rsrc hostap_pci thinkpad_acpi hostap rfkill firewire_ohci irda snd video pcmcia_core ppdev firewire_core snd_page_alloc lib80211 i2c_i801 e100 parport_pc iTCO_wdt sr_mod floppy cdrom soundcore output crc_itu_t parport shpchp iTCO_vendor_support battery crc_ccitt button ac sg pcspkr pci_hotplug preloadtrace ext4 jbd2 crc16 uhci_hcd ehci_hcd radeon ttm drm_kms_helper rtc_cmos drm i2c_algo_bit rtc_core rtc_lib i2c_core usbcore fan processor ata_generic pata_cmd64x ata_piix ahci libahci libata thermal thermal_sys hwmon
[  121.236026] 
[  121.236026] Pid: 104, comm: khubd Not tainted 2.6.37.6-0.7-default #1 IBM 2653R6G/2653R6G
[  121.236026] EIP: 0060:[<f9ad50ba>] EFLAGS: 00010282 CPU: 0
[  121.236026] EIP is at ir_close+0xa/0x20 [ir_core]
[  121.236026] EAX: 00000000 EBX: f3b0be08 ECX: 00000000 EDX: 00000000
[  121.236026] ESI: f3877400 EDI: f387759c EBP: 00000000 ESP: f6d37d94
[  121.236026]  DS: 007b ES: 007b FS: 00d8 GS: 0000 SS: 0068
[  121.236026] Process khubd (pid: 104, ti=f6d36000 task=f6d34eb0 task.ti=f6d36000)
[  121.236026] Stack:
[  121.236026]  c04dd518 f3b0be5c f3b0be08 f3b0be00 c04e0603 f3877400 f38776f4 f3877708
[  121.236026]  c04dd69a 00000286 f3bd8400 f3877400 f38775b8 f9ad64fd f3bd8400 f3877400
[  121.236026]  f9b88900 f9ad5061 c025cb2d f6ded980 f6ded980 f6cdd000 f9b7f195 f6cdd000
[  121.236026] Call Trace:
[  121.236026]  [<c04dd518>] input_close_device+0x48/0x70
[  121.236026]  [<c04e0603>] evdev_disconnect+0x23/0x40
[  121.236026]  [<c04dd69a>] input_unregister_device+0x9a/0x130
[  121.236026]  [<f9ad64fd>] ir_unregister_class+0x3d/0x60 [ir_core]
[  121.236026]  [<f9ad5061>] ir_input_unregister+0x61/0xb0 [ir_core]
[  121.236026]  [<f9b7f195>] em28xx_ir_fini+0x25/0x50 [em28xx]
[  121.236026]  [<f9b7bc85>] em28xx_release_resources+0x25/0x60 [em28xx]
[  121.236026]  [<f9b7bd54>] em28xx_usb_disconnect+0x94/0x150 [em28xx]
[  121.236026]  [<f81b0ff8>] usb_unbind_interface+0x38/0x130 [usbcore]
[  121.236026]  [<c04acabd>] __device_release_driver+0x4d/0xb0
[  121.236026]  [<c04acb3d>] device_release_driver+0x1d/0x30
[  121.236026]  [<c04ac5be>] bus_remove_device+0x5e/0xc0
[  121.236026]  [<c04a9ab7>] device_del+0xe7/0x150
[  121.236026]  [<f81aed72>] usb_disable_device+0x62/0x190 [usbcore]
[  121.236026]  [<f81a8195>] usb_disconnect+0x85/0x140 [usbcore]
[  121.236026]  [<f81a8fcf>] hub_port_connect_change+0x9f/0x960 [usbcore]
[  121.236026]  [<f81a9b26>] hub_events+0x296/0x610 [usbcore]
[  121.236026]  [<f81a9ecd>] hub_thread+0x2d/0x180 [usbcore]
[  121.236026]  [<c025fff4>] kthread+0x74/0x80
[  121.236026]  [<c0203526>] kernel_thread_helper+0x6/0x10
[  121.236026] Code: 44 24 04 c0 70 ad f9 c7 04 24 08 72 ad f9 e8 42 52 b2 c6 e9 7a ff ff ff 89 f6 8d bc 27 00 00 00 00 05 b8 01 00 00 e8 26 79 9d c6 <8b> 90 78 01 00 00 8b 42 20 ff 52 2c f3 c3 90 8d b4 26 00 00 00 
[  121.236026] EIP: [<f9ad50ba>] ir_close+0xa/0x20 [ir_core] SS:ESP 0068:f6d37d94
[  121.236026] CR2: 0000000000000178
[  121.471777] ---[ end trace 9a102f7b10e6ce20 ]---
--- snap ---
Comment 1 Jiri Slaby 2011-11-03 09:44:04 UTC
Is this still reproducible with 3.x kernels? Like from kernel:stable, kernel:head or tumbleweed?
Comment 2 Till Dörges 2011-11-05 09:43:42 UTC
(In reply to comment #1)

> Is this still reproducible with 3.x kernels? Like from kernel:stable,
> kernel:head or tumbleweed?

I tried 3.1 (http://download.opensuse.org/repositories/Kernel:/stable/standard/x86_64/kernel-desktop-3.1.0-3.1.x86_64.rpm).

Unplugging the device does not crash the computer anymore.


However, it still doesn't seem to be quite right.

- After having unplugged the device once, it won't work if plugged back in.
- The module em28xx_dvb can't be removed manually. The rmmod command just hangs:

--- snip ---
#  lsmod | grep dvb
em28xx_dvb             18417  0 
cxd2820r               33424  1 em28xx_dvb
dvb_core              114318  2 em28xx_dvb,cxd2820r
em28xx                113165  2 em28xx_dvb,em28xx_alsa
#  rmmod em28xx_dvb
^C^C^C^C
--- snap ---

It seems to be hanging in I/O somehwere:

--- snip ---
$  ps aux | egrep 'rmmod|USER' | grep -v grep
USER       PID %CPU %MEM    VSZ   RSS TTY      STAT START   TIME COMMAND
root     11364  0.0  0.0   3952   536 pts/9    D+   10:35   0:00 rmmod em28xx_dvb
--- snap ---


I'm not sure how to proceed. I guess the original problem (Kernel Oops) has been solved. Should I open a new ticket?
Comment 3 Jiri Slaby 2011-11-09 10:15:49 UTC
(In reply to comment #2)
> $  ps aux | egrep 'rmmod|USER' | grep -v grep
> USER       PID %CPU %MEM    VSZ   RSS TTY      STAT START   TIME COMMAND
> root     11364  0.0  0.0   3952   536 pts/9    D+   10:35   0:00 rmmod
> em28xx_dvb

I think it still crashes. Could you attach dmesg output when it is in this state?
Comment 4 Till Dörges 2011-11-26 17:59:02 UTC
I apologize for the slow response. I simply don't always have the hardware to test with at hand.

AFAICT the dmesg output doesn't give much information. But trying to rmmod one of the dvb-t modules shows an info (INFO: task khubd:28 blocked for more than 480 seconds.) in syslog with a call trace (provided below).


I tried the kernel provided here:

  http://download.opensuse.org/repositories/Kernel:/stable/standard/x86_64/


$   uname -a
Linux box.none 3.1.1-2-desktop #1 SMP PREEMPT Wed Nov 16 18:42:33 UTC 2011 (2de224b) x86_64 x86_64 x86_64 GNU/Linux


Plugin the device in yields:

--- snip ---
$   dmesg 

[  481.617248] usb 1-5.2: new high speed USB device number 8 using ehci_hcd
[  481.714751] usb 1-5.2: New USB device found, idVendor=0ccd, idProduct=005e
[  481.714760] usb 1-5.2: New USB device strings: Mfr=3, Product=1, SerialNumber=2
[  481.714767] usb 1-5.2: Product: Cinergy Hybrid T USB XS (2882)
[  481.714772] usb 1-5.2: Manufacturer: TerraTec Electronic GmbH
[  481.714778] usb 1-5.2: SerialNumber: 060902000900
[  482.214546] IR NEC protocol handler initialized
[  482.250516] IR RC5(x) protocol handler initialized
[  482.277925] Linux video capture interface: v2.00
[  482.284551] IR RC6 protocol handler initialized
[  482.310730] IR JVC protocol handler initialized
[  482.330053] em28xx: New device TerraTec Electronic GmbH Cinergy Hybrid T USB XS (2882) @ 480 Mbps (0ccd:005e, interface 0, class 0)
[  482.330062] em28xx: Audio Vendor Class interface 0 found
[  482.331598] em28xx #0: chip ID is em2882/em2883
[  482.340485] IR Sony protocol handler initialized
[  482.380669] IR MCE Keyboard/mouse protocol handler initialized
[  482.407185] lirc_dev: IR Remote Control driver registered, major 249 
[  482.409268] IR LIRC bridge handler initialized
[  482.488974] em28xx #0: i2c eeprom 00: 1a eb 67 95 cd 0c 5e 00 d0 12 5c 03 9e 40 de 1c
[  482.488998] em28xx #0: i2c eeprom 10: 6a 34 27 57 46 07 01 00 00 00 00 00 00 00 00 00
[  482.489046] em28xx #0: i2c eeprom 20: 46 00 01 00 f0 10 31 00 b8 00 14 00 5b 1e 00 00
[  482.489066] em28xx #0: i2c eeprom 30: 00 00 20 40 20 6e 02 20 10 01 00 00 00 00 00 00
[  482.489087] em28xx #0: i2c eeprom 40: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
[  482.489107] em28xx #0: i2c eeprom 50: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
[  482.489126] em28xx #0: i2c eeprom 60: 00 00 00 00 00 00 00 00 00 00 34 03 54 00 65 00
[  482.489146] em28xx #0: i2c eeprom 70: 72 00 72 00 61 00 54 00 65 00 63 00 20 00 45 00
[  482.489166] em28xx #0: i2c eeprom 80: 6c 00 65 00 63 00 74 00 72 00 6f 00 6e 00 69 00
[  482.489186] em28xx #0: i2c eeprom 90: 63 00 20 00 47 00 6d 00 62 00 48 00 00 00 40 03
[  482.489206] em28xx #0: i2c eeprom a0: 43 00 69 00 6e 00 65 00 72 00 67 00 79 00 20 00
[  482.489226] em28xx #0: i2c eeprom b0: 48 00 79 00 62 00 72 00 69 00 64 00 20 00 54 00
[  482.489247] em28xx #0: i2c eeprom c0: 20 00 55 00 53 00 42 00 20 00 58 00 53 00 20 00
[  482.489266] em28xx #0: i2c eeprom d0: 28 00 32 00 38 00 38 00 32 00 29 00 00 00 1c 03
[  482.489286] em28xx #0: i2c eeprom e0: 30 00 36 00 30 00 39 00 30 00 32 00 30 00 30 00
[  482.489306] em28xx #0: i2c eeprom f0: 30 00 39 00 30 00 30 00 00 00 00 00 00 00 00 00
[  482.489329] em28xx #0: EEPROM ID= 0x9567eb1a, EEPROM hash = 0x1513bcbe
[  482.489334] em28xx #0: EEPROM info:
[  482.489337] em28xx #0:       AC97 audio (5 sample rates)
[  482.489341] em28xx #0:       500mA max power
[  482.489346] em28xx #0:       Table at 0x27, strings=0x409e, 0x1cde, 0x346a
[  482.492478] em28xx #0: Identified as Terratec Cinnergy Hybrid T USB XS (em2882) (card=55)
[  482.520208] tvp5150 7-005c: chip found @ 0xb8 (em28xx #0)
[  482.570478] tvp5150 7-005c: tvp5150am1 detected.
[  482.596076] i2c-core: driver [tuner] using legacy suspend method
[  482.596083] i2c-core: driver [tuner] using legacy resume method
[  482.602905] tuner 7-0061: Tuner -1 found with type(s) Radio TV.
[  482.678566] xc2028 7-0061: creating new instance
[  482.678574] xc2028 7-0061: type set to XCeive xc2028/xc3028 tuner
[  482.701680] xc2028 7-0061: Loading 80 firmware images from xc3028-v27.fw, type: xc2028 firmware, ver 2.7
[  482.736086] xc2028 7-0061: Loading firmware for type=BASE MTS (5), id 0000000000000000.
[  483.892506] xc2028 7-0061: Loading firmware for type=MTS (4), id 000000000000b700.
[  483.913253] xc2028 7-0061: Loading SCODE for type=MTS LCD NOGD MONO IF SCODE HAS_IF_4500 (6002b004), id 000000000000b700.
[  484.101047] Registered IR keymap rc-terratec-cinergy-xs
[  484.103930] input: em28xx IR (em28xx #0) as /devices/pci0000:00/0000:00:1a.7/usb1/1-5/1-5.2/rc/rc0/input18
[  484.104695] rc0: em28xx IR (em28xx #0) as /devices/pci0000:00/0000:00:1a.7/usb1/1-5/1-5.2/rc/rc0
[  484.105415] em28xx #0: Config register raw data: 0xd0
[  484.106681] em28xx #0: AC97 vendor ID = 0xffffffff
[  484.108040] em28xx #0: AC97 features = 0x6a90
[  484.108045] em28xx #0: Empia 202 AC97 audio processor detected
[  484.268980] em28xx #0: v4l2 driver version 0.1.3
[  484.302040] xc2028 7-0061: Loading firmware for type=BASE F8MHZ MTS (7), id 0000000000000000.
[  485.496138] MTS (4), id 00000000000000ff:
[  485.496151] xc2028 7-0061: Loading firmware for type=MTS (4), id 0000000100000007.
[  485.698604] em28xx #0: V4L2 video device registered as video0
[  485.698611] em28xx #0: V4L2 VBI device registered as vbi0
[  485.699955] usbcore: registered new interface driver em28xx
[  485.699962] em28xx driver loaded
[  485.778789] em28xx-audio.c: probing for em28xx Audio Vendor Class
[  485.778796] em28xx-audio.c: Copyright (C) 2006 Markus Rechberger
[  485.778800] em28xx-audio.c: Copyright (C) 2007-2011 Mauro Carvalho Chehab
[  485.783878] Em28xx: Initialized (Em28xx Audio Extension) extension
[  486.029497] xc2028 7-0061: attaching existing instance
[  486.029505] xc2028 7-0061: type set to XCeive xc2028/xc3028 tuner
[  486.029511] em28xx #0: em28xx #0/2: xc3028 attached
[  486.029516] DVB: registering new adapter (em28xx #0)
[  486.029523] DVB: registering adapter 0 frontend 0 (Zarlink ZL10353 DVB-T)...
[  486.031677] em28xx #0: Successfully loaded em28xx-dvb
[  486.031690] Em28xx: Initialized (Em28xx dvb Extension) extension
[  486.370906] em28xx #0: submit of audio urb failed
--- snap ---


Unplugging the device:

--- snip ---
$   dmesg 

[  617.139070] xc2028 7-0061: Loading firmware for type=BASE F8MHZ MTS (7), id 0000000000000000.
[  618.293590] xc2028 7-0061: Loading firmware for type=D2633 DTV8 (210), id 0000000000000000.
[  618.310478] xc2028 7-0061: Loading SCODE for type=DTV6 QAM DTV7 DTV78 DTV8 ZARLINK456 SCODE HAS_IF_4760 (620003e0), id 0000000000000000.
[  692.579418] usb 1-5.2: USB disconnect, device number 8
[  692.579573] em28xx #0: disconnecting em28xx #0 video
[  692.592198] em28xx #0: V4L2 device vbi0 deregistered
[  692.592997] em28xx #0: V4L2 device video0 deregistered
[  692.644407] xc2028 7-0061: destroying instance
--- snap ---


Plugging it back in:

--- snip ---
$   dmesg

[  756.757299] usb 1-5.2: new high speed USB device number 9 using ehci_hcd
[  756.855020] usb 1-5.2: New USB device found, idVendor=0ccd, idProduct=005e
[  756.855028] usb 1-5.2: New USB device strings: Mfr=3, Product=1, SerialNumber=2
[  756.855035] usb 1-5.2: Product: Cinergy Hybrid T USB XS (2882)
[  756.855041] usb 1-5.2: Manufacturer: TerraTec Electronic GmbH
[  756.855046] usb 1-5.2: SerialNumber: 060902000900
[  756.856743] em28xx: New device TerraTec Electronic GmbH Cinergy Hybrid T USB XS (2882) @ 480 Mbps (0ccd:005e, interface 0, class 0)
[  756.856751] em28xx: Audio Vendor Class interface 0 found
[  756.856866] em28xx #0: chip ID is em2882/em2883
[  757.001390] em28xx #0: i2c eeprom 00: 1a eb 67 95 cd 0c 5e 00 d0 12 5c 03 9e 40 de 1c
[  757.001414] em28xx #0: i2c eeprom 10: 6a 34 27 57 46 07 01 00 00 00 00 00 00 00 00 00
[  757.001434] em28xx #0: i2c eeprom 20: 46 00 01 00 f0 10 31 00 b8 00 14 00 5b 1e 00 00
[  757.001454] em28xx #0: i2c eeprom 30: 00 00 20 40 20 6e 02 20 10 01 00 00 00 00 00 00
[  757.001475] em28xx #0: i2c eeprom 40: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
[  757.001494] em28xx #0: i2c eeprom 50: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
[  757.001514] em28xx #0: i2c eeprom 60: 00 00 00 00 00 00 00 00 00 00 34 03 54 00 65 00
[  757.001534] em28xx #0: i2c eeprom 70: 72 00 72 00 61 00 54 00 65 00 63 00 20 00 45 00
[  757.001554] em28xx #0: i2c eeprom 80: 6c 00 65 00 63 00 74 00 72 00 6f 00 6e 00 69 00
[  757.001574] em28xx #0: i2c eeprom 90: 63 00 20 00 47 00 6d 00 62 00 48 00 00 00 40 03
[  757.001594] em28xx #0: i2c eeprom a0: 43 00 69 00 6e 00 65 00 72 00 67 00 79 00 20 00
[  757.001614] em28xx #0: i2c eeprom b0: 48 00 79 00 62 00 72 00 69 00 64 00 20 00 54 00
[  757.001633] em28xx #0: i2c eeprom c0: 20 00 55 00 53 00 42 00 20 00 58 00 53 00 20 00
[  757.001653] em28xx #0: i2c eeprom d0: 28 00 32 00 38 00 38 00 32 00 29 00 00 00 1c 03
[  757.001673] em28xx #0: i2c eeprom e0: 30 00 36 00 30 00 39 00 30 00 32 00 30 00 30 00
[  757.001693] em28xx #0: i2c eeprom f0: 30 00 39 00 30 00 30 00 00 00 00 00 00 00 00 00
[  757.001716] em28xx #0: EEPROM ID= 0x9567eb1a, EEPROM hash = 0x1513bcbe
[  757.001720] em28xx #0: EEPROM info:
[  757.001723] em28xx #0:       AC97 audio (5 sample rates)
[  757.001727] em28xx #0:       500mA max power
[  757.001731] em28xx #0:       Table at 0x27, strings=0x409e, 0x1cde, 0x346a
[  757.004500] em28xx #0: Identified as Terratec Cinnergy Hybrid T USB XS (em2882) (card=55)
[  757.009081] tvp5150 7-005c: chip found @ 0xb8 (em28xx #0)
[  757.053645] tvp5150 7-005c: tvp5150am1 detected.
[  757.062082] tuner 7-0061: Tuner -1 found with type(s) Radio TV.
[  757.062111] xc2028 7-0061: creating new instance
[  757.062116] xc2028 7-0061: type set to XCeive xc2028/xc3028 tuner
[  757.066052] xc2028 7-0061: Loading 80 firmware images from xc3028-v27.fw, type: xc2028 firmware, ver 2.7
[  757.100074] xc2028 7-0061: Loading firmware for type=BASE MTS (5), id 0000000000000000.
[  758.241514] xc2028 7-0061: Loading firmware for type=MTS (4), id 000000000000b700.
[  758.261028] xc2028 7-0061: Loading SCODE for type=MTS LCD NOGD MONO IF SCODE HAS_IF_4500 (6002b004), id 000000000000b700.
[  758.378425] Registered IR keymap rc-terratec-cinergy-xs
[  758.378641] input: em28xx IR (em28xx #0) as /devices/pci0000:00/0000:00:1a.7/usb1/1-5/1-5.2/rc/rc1/input19
[  758.378834] rc1: em28xx IR (em28xx #0) as /devices/pci0000:00/0000:00:1a.7/usb1/1-5/1-5.2/rc/rc1
[  758.379258] em28xx #0: Config register raw data: 0xd0
[  758.380015] em28xx #0: AC97 vendor ID = 0xffffffff
[  758.380386] em28xx #0: AC97 features = 0x6a90
[  758.380391] em28xx #0: Empia 202 AC97 audio processor detected
[  758.538017] em28xx #0: v4l2 driver version 0.1.3
[  758.571074] xc2028 7-0061: Loading firmware for type=BASE F8MHZ MTS (7), id 0000000000000000.
[  759.718902] MTS (4), id 00000000000000ff:
[  759.718914] xc2028 7-0061: Loading firmware for type=MTS (4), id 0000000100000007.
[  759.917321] em28xx #0: V4L2 video device registered as video0
[  759.917328] em28xx #0: V4L2 VBI device registered as vbi0
[  759.917334] em28xx-audio.c: probing for em28xx Audio Vendor Class
[  759.917338] em28xx-audio.c: Copyright (C) 2006 Markus Rechberger
[  759.917342] em28xx-audio.c: Copyright (C) 2007-2011 Mauro Carvalho Chehab
--- snap ---

/var/log/messages:
--- snip ---
Nov 26 18:42:59 box kernel: [  759.917342] em28xx-audio.c: Copyright (C) 2007-2011 Mauro Carvalho Chehab
[...]
Nov 26 18:45:56 box udevd[561]: worker [10782] unexpectedly returned with status 0x0100
Nov 26 18:45:56 box udevd[561]: worker [10782] failed while handling '/devices/pci0000:00/0000:00:1a.7/usb1/1-5/1-5.2'
--- snap ---


Trying to remove the module doesn't work, this command never returns:
--- snip ---
# rmmod em28xx_dvb
--- snap ---


/var/log/messages:
--- snip ---
Nov 26 18:50:18 box pulseaudio[4041]: module.c: Failed to load  module "module-alsa-card" (argument: "device_id="29" name="platform-thinkpad_acpi" card_name="alsa_card.platform-thinkpad_acpi" tsched=yes ignore_dB=no card_properties="module-udev-detect.discovered=1""): initialization failed.
Nov 26 18:54:20 box kernel: [ 1440.471095] INFO: task khubd:28 blocked for more than 480 seconds.
Nov 26 18:54:20 box kernel: [ 1440.471102] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Nov 26 18:54:20 box kernel: [ 1440.471108] khubd           D 0000000000000000     0    28      2 0x00000000
Nov 26 18:54:20 box kernel: [ 1440.471119]  ffff88022ef47798 0000000000000046 ffff88022ef47fd8 0000000000012540
Nov 26 18:54:20 box kernel: [ 1440.471130]  ffff88022ef47fd8 0000000000012540 ffff88022ef46000 ffff88022ef46000
Nov 26 18:54:20 box kernel: [ 1440.471139]  0000000000012540 ffff88022ef47fd8 ffff88022ed6c440 ffff88022ef44740
Nov 26 18:54:20 box kernel: [ 1440.471149] Call Trace:
Nov 26 18:54:20 box kernel: [ 1440.471175]  [<ffffffff815a7a1c>] __mutex_lock_slowpath+0xfc/0x1b0
Nov 26 18:54:20 box kernel: [ 1440.471188]  [<ffffffff815a75fa>] mutex_lock+0x1a/0x40
Nov 26 18:54:20 box kernel: [ 1440.471202]  [<ffffffffa0803c01>] dvb_init+0x61/0xce0 [em28xx_dvb]
Nov 26 18:54:20 box kernel: [ 1440.471257]  [<ffffffffa07ef206>] em28xx_init_extension+0x36/0x60 [em28xx]
Nov 26 18:54:20 box kernel: [ 1440.471299]  [<ffffffffa07ec80f>] em28xx_init_dev+0x27f/0x5a0 [em28xx]
Nov 26 18:54:20 box kernel: [ 1440.471338]  [<ffffffffa07ecf43>] em28xx_usb_probe+0x413/0x680 [em28xx]
Nov 26 18:54:20 box kernel: [ 1440.471370]  [<ffffffff813f9082>] usb_probe_interface+0x142/0x270
Nov 26 18:54:20 box kernel: [ 1440.471385]  [<ffffffff8139af00>] really_probe+0x70/0x230
Nov 26 18:54:20 box kernel: [ 1440.471397]  [<ffffffff8139b2c7>] driver_probe_device+0x47/0xb0
Nov 26 18:54:20 box kernel: [ 1440.471407]  [<ffffffff81399cbc>] bus_for_each_drv+0x5c/0x90
Nov 26 18:54:20 box kernel: [ 1440.471417]  [<ffffffff8139b18f>] device_attach+0x9f/0xc0
Nov 26 18:54:20 box kernel: [ 1440.471428]  [<ffffffff8139a6bd>] bus_probe_device+0x2d/0x50
Nov 26 18:54:20 box kernel: [ 1440.471438]  [<ffffffff813986c7>] device_add+0x2e7/0x420
Nov 26 18:54:20 box kernel: [ 1440.471450]  [<ffffffff813f7481>] usb_set_configuration+0x5a1/0x6f0
Nov 26 18:54:20 box kernel: [ 1440.471464]  [<ffffffff8140070b>] generic_probe+0x3b/0xa0
Nov 26 18:54:20 box kernel: [ 1440.471474]  [<ffffffff8139af00>] really_probe+0x70/0x230
Nov 26 18:54:20 box kernel: [ 1440.471484]  [<ffffffff8139b2c7>] driver_probe_device+0x47/0xb0
Nov 26 18:54:20 box kernel: [ 1440.471493]  [<ffffffff81399cbc>] bus_for_each_drv+0x5c/0x90
Nov 26 18:54:20 box kernel: [ 1440.471503]  [<ffffffff8139b18f>] device_attach+0x9f/0xc0
Nov 26 18:54:20 box kernel: [ 1440.471513]  [<ffffffff8139a6bd>] bus_probe_device+0x2d/0x50
Nov 26 18:54:20 box kernel: [ 1440.471523]  [<ffffffff813986c7>] device_add+0x2e7/0x420
Nov 26 18:54:20 box kernel: [ 1440.471535]  [<ffffffff813ef311>] usb_new_device+0x181/0x1f0
Nov 26 18:54:20 box kernel: [ 1440.471547]  [<ffffffff813efd5d>] hub_port_connect_change+0x24d/0x950
Nov 26 18:54:20 box kernel: [ 1440.471558]  [<ffffffff813f07e4>] hub_events+0x384/0x820
Nov 26 18:54:20 box kernel: [ 1440.471570]  [<ffffffff813f0cb5>] hub_thread+0x35/0x1b0
Nov 26 18:54:20 box kernel: [ 1440.471583]  [<ffffffff810793b6>] kthread+0x96/0xa0
Nov 26 18:54:20 box kernel: [ 1440.471596]  [<ffffffff815b2734>] kernel_thread_helper+0x4/0x10
Nov 26 18:54:20 box kernel: [ 1440.471705] INFO: task mtp-probe:10806 blocked for more than 480 seconds.
Nov 26 18:54:20 box kernel: [ 1440.471709] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Nov 26 18:54:20 box kernel: [ 1440.471714] mtp-probe       D ffffffff816053e0     0 10806      1 0x00000000
Nov 26 18:54:20 box kernel: [ 1440.471724]  ffff88022c7b1c00 0000000000000082 ffff88022c7b1fd8 0000000000012540
Nov 26 18:54:20 box kernel: [ 1440.471734]  ffff88022c7b1fd8 0000000000012540 ffff88022c7b0000 ffff88022c7b0000
Nov 26 18:54:20 box kernel: [ 1440.471744]  0000000000012540 ffff88022c7b1fd8 ffffffff81a0e020 ffff88022d3a07c0
Nov 26 18:54:20 box kernel: [ 1440.471753] Call Trace:
Nov 26 18:54:20 box kernel: [ 1440.471763]  [<ffffffff815a7a1c>] __mutex_lock_slowpath+0xfc/0x1b0
Nov 26 18:54:20 box kernel: [ 1440.471773]  [<ffffffff815a75fa>] mutex_lock+0x1a/0x40
Nov 26 18:54:20 box kernel: [ 1440.471785]  [<ffffffff813fd0e0>] usbdev_open+0x140/0x290
Nov 26 18:54:20 box kernel: [ 1440.471797]  [<ffffffff81160a19>] chrdev_open+0x1a9/0x2b0
Nov 26 18:54:20 box kernel: [ 1440.471811]  [<ffffffff8115a58a>] __dentry_open+0x23a/0x3f0
Nov 26 18:54:20 box kernel: [ 1440.471822]  [<ffffffff8116b8a8>] do_last+0x3f8/0x7d0
Nov 26 18:54:20 box kernel: [ 1440.471833]  [<ffffffff8116c09b>] path_openat+0xdb/0x400
Nov 26 18:54:20 box kernel: [ 1440.471842]  [<ffffffff8116c4ed>] do_filp_open+0x4d/0xc0
Nov 26 18:54:20 box kernel: [ 1440.471852]  [<ffffffff8115baa1>] do_sys_open+0x101/0x1e0
Nov 26 18:54:20 box kernel: [ 1440.471863]  [<ffffffff815b0552>] system_call_fastpath+0x16/0x1b
Nov 26 18:54:20 box kernel: [ 1440.471911]  [<00007fc5a4761ce0>] 0x7fc5a4761cdf
--- snap ---
Comment 5 Till Dörges 2012-01-22 21:52:47 UTC
The situation on openSUSE-12.1 is as described in Comment 2
Comment 6 Jiri Slaby 2012-04-24 07:47:39 UTC
(In reply to comment #4)
> INFO: task khubd:28 blocked for more than 480 seconds.
...
> Call Trace:
>  [<ffffffff815a7a1c>] __mutex_lock_slowpath+0xfc/0x1b0
>  [<ffffffff815a75fa>] mutex_lock+0x1a/0x40
>  [<ffffffffa0803c01>] dvb_init+0x61/0xce0 [em28xx_dvb]

Hmm, it's a deadlock.
Comment 7 Jeff Mahoney 2012-08-02 16:00:25 UTC
With the coming release of openSUSE 12.2, openSUSE kernel developers are focusing their efforts there. Reports against openSUSE 11.4 and prior will not get the attention needed to resolve them before openSUSE 12.2 is release and openSUSE 11.4 becomes unmaintained.

Please re-test with openSUSE 12.1 or openSUSE RC2+ and re-open with an updated Product if you still encounter your issue.

We apologize for this issue not getting the attention it deserves but we are focusing our resources in the area where they will have the most impact for our users.  We're working hard to make openSUSE 12.2 the best openSUSE release yet!
Comment 8 Jeff Mahoney 2012-08-02 16:01:03 UTC
With the coming release of openSUSE 12.2, openSUSE kernel developers are focusing their efforts there. Reports against openSUSE 11.4 and prior will not get the attention needed to resolve them before openSUSE 12.2 is release and openSUSE 11.4 becomes unmaintained.

Please re-test with openSUSE 12.1 or openSUSE RC2+ and re-open with an updated Product if you still encounter your issue.

We apologize for this issue not getting the attention it deserves but we are focusing our resources in the area where they will have the most impact for our users.  We're working hard to make openSUSE 12.2 the best openSUSE release yet!