[pvrusb2] pvrusb2 got stuck - 0 byte file, kernel panic

Mon Feb 2 17:00:41 CST 2009

>>
> There are 2 problems here :-(
>
> First, the problem with the device getting "stuck" is unforunately
> something that a few others have sporadically seen but so far I have  
> not
> been able to reproduce.  If I can't see it I can't fix it :-(
>
> Second, the kernel panic on module removal is a new issue.  I  
> routinely
> insert / remove the pvrusb2 module from a running system just as a
> result of the usual collection of stuff I do here.  If there is  
> going to
> be a problem with that I usually find out about it quickly.  The last
> kernel I've been testing with is 2.6.27.10; I sure hope the problem
> didn't get introduced with 2.6.27.13.  But from what you've  
> described I
> should be able to reproduce this one pretty easily.
>
> Can you cause the kernel panic ANY time you rmmod the module or only
> when the device is stuck?  If that is the case then it would both
> explain why I haven't seen the panic AND it would give me another  
> way to
> pry at the first problem...
>
> Along the above theme, it would help to characterize the conditions in
> effect when you attempt to do the rmmod and whether or not you get a
> panic, e.g. if the device is plugged in, if an app is using it, if the
> DVB side is locked (streaming), if the device is stuck at the time,  
> etc.
> I have tried pretty hard over time to ensure that under NO  
> circumstance
> can the driver ever cause a panic, but for a hotplugged device like
> this, it is a complex goal to get right and knowing the circumstances

Thanks for responding that quickly!

To the first problem: Is there anything I should/could try when the  
device is stuck, just to give you some help? I'm no programmer, but  
definitely able to gather some information out of sysfs or something  
like that.

It seems like the procreload option caused the second problem: As far  
as I remember I enabled it hoping it will fix this stuck-device-and-0- 
byte-file problem when I was using 2.6.19 (but it didn't). Below again  
some things I tried with procreload on. Now I disabled it and guess  
what: I can unplug the device, unload and reload the module.
So it seems like just procreload is somehow broken. No need to panic  
otherwise :-)

Tried to remove the module while the device was pluged in, not stuck  
and unused. Result: Reboot.

  router kernel: Oops: 0000 [#1]
  router kernel: Process pvrusb2-context (pid: 1117, ti=ed8d8000  
task=ef8a31c0 task.ti=ed8d8000)
  router kernel: Stack: f11d55b6 c04b22da 00000292 00000000 ef8a31c0  
c0129020 ed8d9fc4 ed8d9fc4
  router kernel: fffffffc 00000000 c0128cb2 c0128c70 00000000 00000000  
c0103137 ef2c9ed0
  router kernel: 00000000 00000000 00000000 00000000 00000000
  router kernel: Call Trace:
  router kernel: [<f11d55b6>] pvr2_context_thread_func+0xa6/0x2d0  
[pvrusb2]
  router kernel: [<c04b22da>] schedule+0x14a/0x280
  router kernel: [<c0129020>] autoremove_wake_function+0x0/0x50
  router kernel: [<c0128cb2>] kthread+0x42/0x70
  router kernel: [<c0128c70>] kthread+0x0/0x70
  router kernel: [<c0103137>] kernel_thread_helper+0x7/0x10
  router kernel: =======================
  router kernel: Code:  Bad EIP value.
  router kernel: EIP: [<30313032>] 0x30313032 SS:ESP 0068:ed8d9fac

To be sure I tried it again when the machine was up again. No  
automatic reboot this time, had to stand up and press the reset button:

Feb  2 22:35:44 router kernel: usbcore: deregistering interface driver  
pvrusb2
Feb  2 22:35:44 router kernel: pvrusb2: Device being rendered inoperable
Feb  2 22:35:44 router kernel: pvrusb2: unregistered device video0  
[mpeg]
Feb  2 22:35:44 router kernel: pvrusb2: unregistered device radio0  
[mpeg]
Feb  2 22:35:44 router kernel: tda9887 2-0043: destroying instance
Feb  2 22:35:44 router kernel: tuner-simple 2-0061: destroying instance
Feb  2 22:35:44 router kernel: *pde = 00000000
Feb  2 22:35:44 router kernel: Modules linked in: wlan_tkip wlan_xauth  
lirc_serial lirc_dev ivtv i2c_algo_bit b1isa b1 hangcheck_timer s
oftdog snd_usb_audio snd_usb_lib wlan_scan_ap ath_rate_sample wm8775  
tuner cx25840 dvb_usb_dib0700 pvrusb2(-) dib7000p cx2341x ath_pci d
ib7000m dib3000mc dibx000_common dib0070 tveeprom wlan ath_hal(P)  
gspca_zc3xx gspca_main
Feb  2 22:35:44 router kernel:
Feb  2 22:35:44 router kernel: Pid: 1093, comm: pvrusb2-context  
Tainted: P          (2.6.27.13 #10)
Feb  2 22:35:44 router kernel: EIP: 0060:[<30332038>] EFLAGS: 00010202  
CPU: 0
Feb  2 22:35:44 router kernel: EIP is at 0x30332038
Feb  2 22:35:44 router kernel: EAX: efb43000 EBX: 37313620 ECX:  
00000001 EDX: 30332038
Feb  2 22:35:44 router kernel: ESI: ef0e03a0 EDI: f11cc510 EBP:  
00000000 ESP: ee119fac
Feb  2 22:35:44 router kernel: DS: 007b ES: 007b FS: 0000 GS: 0000 SS:  
0068
Feb  2 22:35:45 router kernel: ---[ end trace 1178531e3cd61b6f ]---
(END)  router kernel: Oops: 0000 [#2]
  router kernel: Process mysqladmin (pid: 6787, ti=c3cca000  
task=ed443240 task.ti=c3cca000)

Waited again until system was up, then pulled the device's usb cable  
out (pvrusb2 was loaded). Got this:

Feb  2 23:37:20 router kernel: usb 1-2: USB disconnect, address 2
Feb  2 23:37:20 router kernel: pvrusb2: Device being rendered inoperable
Feb  2 23:37:20 router kernel: pvrusb2: unregistered device video0  
[mpeg]
Feb  2 23:37:20 router kernel: pvrusb2: unregistered device radio0  
[mpeg]
Feb  2 23:37:20 router kernel: tda9887 2-0043: destroying instance
Feb  2 23:37:20 router kernel: tuner-simple 2-0061: destroying instance
Feb  2 23:37:43 router kernel: *pde = 00000000
Feb  2 23:37:43 router kernel: Modules linked in: wlan_ccmp wlan_tkip  
wlan_xauth lirc_serial lirc_dev ivtv i2c_algo_bit b1isa b1 hangche
ck_timer softdog snd_usb_audio snd_usb_lib wlan_scan_ap  
ath_rate_sample wm8775 ath_pci tuner dvb_usb_dib0700 wlan dib7000p  
dib7000m dib3
000mc dibx000_common dib0070 cx25840 ath_hal(P) pvrusb2 cx2341x  
tveeprom gspca_zc3xx gspca_main
Feb  2 23:37:43 router kernel:
Feb  2 23:37:43 router kernel: Pid: 650, comm: udevd Tainted:  
P          (2.6.27.13 #10)
Feb  2 23:37:43 router kernel: EIP: 0060:[<c01738e2>] EFLAGS: 00010246  
CPU: 0
Feb  2 23:37:43 router kernel: EIP is at seq_read+0xb2/0x300
Feb  2 23:37:43 router kernel: EAX: ef1f8ca0 EBX: 00000000 ECX:  
0001c920 EDX: 00000001
Feb  2 23:37:43 router kernel: ESI: ef1f8ca0 EDI: 00000001 EBP:  
ef22df48 ESP: ef22df2c
Feb  2 23:37:43 router kernel: DS: 007b ES: 007b FS: 0000 GS: 0033 SS:  
0068
Feb  2 23:37:43 router kernel: ---[ end trace 646ff1ad17083df7 ]---
Feb  2 23:37:43 router kernel: Modules linked in: wlan_ccmp wlan_tkip  
wlan_xauth lirc_serial lirc_dev ivtv i2c_algo_bit b1isa b1 hangche
ck_timer softdog snd_usb_audio snd_usb_lib wlan_scan_ap  
ath_rate_sample wm8775 ath_pci tuner dvb_usb_dib0700 wlan dib7000p  
dib7000m dib3
000mc dibx000_common dib0070 cx25840 ath_hal(P) pvrusb2 cx2341x  
tveeprom gspca_zc3xx gspca_main
Feb  2 23:37:43 router kernel:
Feb  2 23:37:43 router kernel: Pid: 650, comm: udevd Tainted: P       
D   (2.6.27.13 #10)
Feb  2 23:37:43 router kernel: EIP: 0060:[<c0157270>] EFLAGS: 00010046  
CPU: 0
Feb  2 23:37:43 router kernel: EIP is at kfree+0x60/0x70
Feb  2 23:37:43 router kernel: EAX: c1805340 EBX: ef1f8ca0 ECX:  
ef1f8ca0 EDX: c1000000
Feb  2 23:37:43 router kernel: ESI: 0029a555 EDI: 00000202 EBP:  
00000000 ESP: ef22ddc0
Feb  2 23:37:43 router kernel: DS: 007b ES: 007b FS: 0000 GS: 0000 SS:  
0068
Feb  2 23:37:43 router kernel: ---[ end trace 646ff1ad17083df7 ]---

[repeated a few times]

router kernel: Oops: 0000 [#9]
  router kernel: Process imap (pid: 7544, ti=cf300000 task=d091c480  
task.ti=cf300000)
  router kernel: Stack: 00000000 c4935748 c4888b50 c01ad0dc cf301f10  
c4888b50 00000002 00000000
  router kernel: c0162d28 00000026 d0fc3000 c48c722c 00000000 00008003  
00000026 d0fc3000
  router kernel: c0164a7a cf301f10 00008003 c014811b 00008002 08090ba0  
d009ee00 00000000
  router kernel: Call Trace:
  router kernel: [<c01ad0dc>] ext3_dquot_initialize+0x5c/0x80
  router kernel: [<c0162d28>] may_open+0x148/0x230
  router kernel: [<c0164a7a>] do_filp_open+0x10a/0x680
  router kernel: [<c014811b>] __do_fault+0x14b/0x310
  router kernel: [<c01492ce>] handle_mm_fault+0xde/0x4f0
  router kernel: [<c015dc22>] vfs_stat_fd+0x22/0x60
  router kernel: [<c0158dbe>] do_sys_open+0x4e/0xf0
  router kernel: [<c0158edc>] sys_open+0x2c/0x40
  router kernel: [<c0102e79>] sysenter_do_call+0x12/0x25
  router kernel: [<c04b0000>] snd_emu10k1_init_efx+0x1a60/0x28f0
  router kernel: =======================
  router kernel: Code: 89 d8 e8 8b fe ff ff 83 c4 10 5b c3 8d b6 00 00  
00 00 83 ec 0c 89 7c 24 08 89 c7 89 d0 89 1c 24 89 74 24 04 8b 12 8b  
58 0c 8b 12 <8b> b2 f4 00 00 00 e8 ac 83 00 00 85 db 75 06 85 c0 74 0d  
89 c3
  router kernel: EIP: [<c01aa2c9>] __ext3_journal_stop+0x19/0x50  
SS:ESP 0068:cf301ea8
  router kernel: Oops: 0000 [#10]
  router kernel: Process imap (pid: 7546, ti=ce97e000 task=d564e7c0  
task.ti=ce97e000)
  router kernel: Stack: 00000000 c4935734 c4888b50 c01ad0dc ce97ff10  
c4888b50 00000002 00000000
  router kernel: c0162d28 00000026 ed670000 c48c722c 00000000 00008003  
00000026 ed670000
  router kernel: c0164a7a ce97ff10 00008003 c014811b 00008002 08090ba0  
d009ee00 00000000
  router kernel: Call Trace:
  router kernel: [<c01ad0dc>] ext3_dquot_initialize+0x5c/0x80
  router kernel: [<c0162d28>] may_open+0x148/0x230
  router kernel: [<c0164a7a>] do_filp_open+0x10a/0x680
  router kernel: [<c014811b>] __do_fault+0x14b/0x310
  router kernel: [<c01492ce>] handle_mm_fault+0xde/0x4f0
  router kernel: [<c015dc22>] vfs_stat_fd+0x22/0x60
  router kernel: [<c0158dbe>] do_sys_open+0x4e/0xf0
  router kernel: [<c0158edc>] sys_open+0x2c/0x40
  router kernel: [<c0102e79>] sysenter_do_call+0x12/0x25
  router kernel: [<c04b0000>] snd_emu10k1_init_efx+0x1a60/0x28f0
  router kernel: =======================
  router kernel: Code: 89 d8 e8 8b fe ff ff 83 c4 10 5b c3 8d b6 00 00  
00 00 83 ec 0c 89 7c 24 08 89 c7 89 d0 89 1c 24 89 74 24 04 8b 12 8b  
58 0c 8b 12 <8b> b2 f4 00 00 00 e8 ac 83 00 00 85 db 75 06 85 c0 74 0d  
89 c3
  router kernel: EIP: [<c01aa2c9>] __ext3_journal_stop+0x19/0x50  
SS:ESP 0068:ce97fea8
  router kernel: Oops: 0000 [#11]

...followed by a reboot.

-------------- next part --------------
A non-text attachment was scrubbed...
Name: PGP.sig
Type: application/pgp-signature
Size: 194 bytes
Desc: Signierter Teil der Nachricht
Url : http://www.isely.net/pipermail/pvrusb2/attachments/20090203/e0ecc902/attachment-0001.pgp 