[pvrusb2] HVR-1950 driver loading problem

Sun Jun 14 20:29:29 CDT 2009

Sorry, did not have the debug to all 16 bits set, just 8.  Changed to
15 to get FIRMWARE trace and got NULL kernel pointer deref oops.

Are some of the debug mask bits exclusive?

If the oops trace does not help, I will try a bit at a time to see
which is oopsing.  debug without a modprobe command line parameter
appears to default to 31 decimal.

Jun 14 21:22:00 geiger5 kernel: Linux video capture interface: v2.00
Jun 14 21:22:00 geiger5 kernel: pvrusb2: pvr_init
Jun 14 21:22:00 geiger5 kernel: pvrusb2: Creating pvr2_sysfs_class id=f4f14400
Jun 14 21:22:00 geiger5 kernel: pvrusb2: pvr2_context thread start
Jun 14 21:22:00 geiger5 kernel: pvrusb2: pvr2_context f4f13480 (create)
Jun 14 21:22:00 geiger5 kernel: pvrusb2: pvr2_hdw_create:
hdw=f4f3a000, type "WinTV HVR-1950 Model Category 751xx"
Jun 14 21:22:00 geiger5 kernel: pvrusb2: Driver unit number is 0, name
is pvrusb2_a
Jun 14 21:22:00 geiger5 kernel: pvrusb2: pvr_probe(pvr=f4f13480)
Jun 14 21:22:00 geiger5 kernel: pvrusb2: pvr2_context f4f13480 (notify)
Jun 14 21:22:00 geiger5 kernel: pvrusb2: pvr2_context f4f13480 (initialize)
Jun 14 21:22:00 geiger5 kernel: pvrusb2: pvr2_hdw_setup(hdw=f4f3a000) begin
Jun 14 21:22:00 geiger5 kernel: usbcore: registered new interface driver pvrusb2
Jun 14 21:22:00 geiger5 kernel: pvrusb2: Probe of device endpoint 1
result status -75
Jun 14 21:22:00 geiger5 kernel: pvrusb2: Check for FX2 firmware
failed; possibly firmware needs to be loaded
Jun 14 21:22:00 geiger5 kernel: usb 1-3: firmware: requesting
v4l-pvrusb2-73xxx-01.fw
Jun 14 21:22:00 geiger5 kernel: pvrusb2: V4L in-tree version:Hauppauge
WinTV-PVR-USB2 MPEG2 Encoder/Tuner
Jun 14 21:22:00 geiger5 kernel: pvrusb2: Debug mask is 32767 (0x7fff)
Jun 14 21:22:00 geiger5 kernel: pvrusb2: pvr_init complete
Jun 14 21:22:00 geiger5 kernel: pvrusb2: cpureset_assert(1)
Jun 14 21:22:00 geiger5 kernel: pvrusb2: cpureset_assert(0)
Jun 14 21:22:00 geiger5 kernel: pvrusb2: pvr2_hdw_setup(hdw=f4f3a000)
done, ok=1 init_ok=0
Jun 14 21:22:00 geiger5 kernel: pvrusb2: Device microcontroller
firmware (re)loaded; it should now reset and reconnect.
Jun 14 21:22:00 geiger5 kernel: pvrusb2: pvr2_hdw_setup(hdw=f4f3a000) end
Jun 14 21:22:00 geiger5 kernel: pvrusb2: pvr2_context f4f13480 (thread
skipping setup)
Jun 14 21:22:00 geiger5 kernel: usb 1-3: USB disconnect, address 2
Jun 14 21:22:00 geiger5 kernel: pvrusb2: pvr_disconnect(pvr=f4f13480) BEGIN
Jun 14 21:22:00 geiger5 kernel: pvrusb2: pvr2_hdw_disconnect(hdw=f4f3a000)
Jun 14 21:22:00 geiger5 kernel: pvrusb2: pvr2_hdw_remove_usb_stuff: hdw=f4f3a000
Jun 14 21:22:00 geiger5 kernel: pvrusb2: Device being rendered inoperable
Jun 14 21:22:00 geiger5 kernel: pvrusb2: State bit flag_ok <-- false
Jun 14 21:22:00 geiger5 kernel: pvrusb2: State bit state_stale <-- true
Jun 14 21:22:00 geiger5 kernel: pvrusb2: pvr_disconnect(pvr=f4f13480) DONE
Jun 14 21:22:00 geiger5 kernel: pvrusb2: Drive state check START
Jun 14 21:22:00 geiger5 kernel: pvrusb2_a driver: <fail>
<uninitialized> <disconnected> <mode=unknown>
Jun 14 21:22:00 geiger5 kernel: pvrusb2_a pipeline: <stale>
Jun 14 21:22:00 geiger5 kernel: pvrusb2_a worker: <decode:stop>
<encode:init> <encode:virgin> <encode:waitok> <usb:stop>
Jun 14 21:22:00 geiger5 kernel: pvrusb2_a state: dead
Jun 14 21:22:00 geiger5 kernel: pvrusb2_a Hardware supported inputs:
television, dtv, composite, s-video
Jun 14 21:22:00 geiger5 kernel: BUG: unable to handle kernel NULL
pointer dereference at (null)
Jun 14 21:22:00 geiger5 kernel: IP: [<c0562c32>] __list_add+0x2a/0x5c
Jun 14 21:22:00 geiger5 kernel: *pde = 7f97e067
Jun 14 21:22:00 geiger5 kernel: Oops: 0000 [#1] SMP
Jun 14 21:22:00 geiger5 kernel: last sysfs file:
/sys/devices/pci0000:00/0000:00:02.1/usb1/1-3/firmware/1-3/loading
Jun 14 21:22:00 geiger5 kernel: Modules linked in: pvrusb2 dvb_core
cx2341x v4l2_common videodev v4l1_compat tveeprom nls_utf8 fuse
ath_pci ath_rate_sample ath_hal(P) wlan_scan_sta wlan_wep wlan bridge
stp llc bnep sco l2cap bluetooth autofs4 hwmon_vid sunrpc
cpufreq_ondemand powernow_k8 dm_multipath uinput ppdev parport_pc
parport pcspkr snd_intel8x0 snd_ac97_codec ac97_bus snd_pcm k8temp
hwmon snd_timer snd soundcore i2c_nforce2 forcedeth sata_nv
snd_page_alloc ata_generic pata_acpi pata_amd nvidia(P) nouveau drm
i2c_algo_bit i2c_core [last unloaded: scsi_wait_scan]
Jun 14 21:22:00 geiger5 kernel:
Jun 14 21:22:00 geiger5 kernel: Pid: 2644, comm: pvrusb2_a Tainted: P
         (2.6.29.4-167.fc11.i586 #1)
Jun 14 21:22:00 geiger5 kernel: EIP: 0060:[<c0562c32>] EFLAGS: 00010246 CPU: 0
Jun 14 21:22:00 geiger5 kernel: EIP is at __list_add+0x2a/0x5c
Jun 14 21:22:00 geiger5 kernel: EAX: 00000000 EBX: f4f41de0 ECX:
f4f3a0e8 EDX: 00000000
Jun 14 21:22:00 geiger5 kernel: ESI: 00000000 EDI: f4f3a0e8 EBP:
f4f41dc8 ESP: f4f41dbc
Jun 14 21:22:00 geiger5 kernel: DS: 007b ES: 007b FS: 00d8 GS: 0000 SS: 0068
Jun 14 21:22:00 geiger5 kernel: Process pvrusb2_a (pid: 2644,
ti=f4f40000 task=f4e9f1a0 task.ti=f4f40000)
Jun 14 21:22:00 geiger5 kernel: Stack:
Jun 14 21:22:00 geiger5 kernel: f4f3a0e0 f4e9f1a0 00000002 f4f41df8
c0706cae 00000246 ffffffff f4f3a0e8
Jun 14 21:22:00 geiger5 kernel: f4f3a0e4 f4f41e84 00000000 f4f41f64
f4f3a0e0 0000002d 00000100 f4f41e04
Jun 14 21:22:00 geiger5 kernel: c0706d69 c0706e33 f4f41e10 c0706e33
f4f41e64 f4f41e54 f9a681c0 f4f41e84
Jun 14 21:22:00 geiger5 kernel: Call Trace:
Jun 14 21:22:00 geiger5 kernel: [<c0706cae>] ? __mutex_lock_common+0x38/0xdc
Jun 14 21:22:00 geiger5 kernel: pvrusb2: pvr2_context f4f13480 (notify)
Jun 14 21:22:00 geiger5 kernel: pvrusb2: pvr2_context f4f13480 (destroy)
Jun 14 21:22:00 geiger5 kernel: pvrusb2: pvr2_hdw_destroy: hdw=f4f3a000
Jun 14 21:22:00 geiger5 kernel: [<c0706d69>] ? __mutex_lock_slowpath+0x17/0x1a
Jun 14 21:22:00 geiger5 kernel: [<c0706e33>] ? mutex_lock+0x2b/0x2e
Jun 14 21:22:00 geiger5 kernel: [<c0706e33>] ? mutex_lock+0x2b/0x2e
Jun 14 21:22:00 geiger5 kernel: [<f9a681c0>] ?
pvr2_hdw_report_clients+0xb6/0x1a8 [pvrusb2]
Jun 14 21:22:00 geiger5 kernel: [<f9a68729>] ?
pvr2_hdw_state_log_state+0x61/0xb6 [pvrusb2]
Jun 14 21:22:00 geiger5 kernel: [<c0707e14>] ? _spin_unlock_irqrestore+0x27/0x3d
Jun 14 21:22:00 geiger5 kernel: [<c0707e14>] ? _spin_unlock_irqrestore+0x27/0x3d
Jun 14 21:22:00 geiger5 kernel: [<c042f800>] ? release_console_sem+0x1aa/0x1d7
Jun 14 21:22:00 geiger5 kernel: [<c0402aa1>] ? __switch_to+0x7b/0xfd
Jun 14 21:22:00 geiger5 kernel: [<c042a7aa>] ? finish_task_switch+0x85/0x9f
Jun 14 21:22:00 geiger5 kernel: [<c07065e3>] ? schedule+0x709/0x78f
Jun 14 21:22:00 geiger5 kernel: [<c0402aa1>] ? __switch_to+0x7b/0xfd
Jun 14 21:22:00 geiger5 kernel: [<c0705dba>] ? printk+0x14/0x1a
Jun 14 21:22:00 geiger5 kernel: [<f9a6ae37>] ?
pvr2_hdw_worker_poll+0x47/0x31a [pvrusb2]
Jun 14 21:22:00 geiger5 kernel: [<c043d4e2>] ? run_workqueue+0x8e/0x118
Jun 14 21:22:00 geiger5 kernel: [<f9a6adf0>] ?
pvr2_hdw_worker_poll+0x0/0x31a [pvrusb2]
Jun 14 21:22:00 geiger5 kernel: [<c043d627>] ? worker_thread+0xbb/0xc7
Jun 14 21:22:00 geiger5 kernel: [<c0440749>] ? autoremove_wake_function+0x0/0x34
Jun 14 21:22:00 geiger5 kernel: [<c043d56c>] ? worker_thread+0x0/0xc7
Jun 14 21:22:00 geiger5 kernel: [<c0440470>] ? kthread+0x41/0x65
Jun 14 21:22:00 geiger5 kernel: [<c044042f>] ? kthread+0x0/0x65
Jun 14 21:22:00 geiger5 kernel: [<c0404877>] ? kernel_thread_helper+0x7/0x10
Jun 14 21:22:00 geiger5 kernel: Code: c3 55 89 e5 57 89 cf 56 89 d6 53
89 c3 8b 41 04 39 d0 74 17 51 50 52 68 be 15 80 c0 6a 1a 68 73 15 80
c0 e8 47 c6 ec ff 83 c4 18 <8b> 06 39 f8 74 17 56 50 57 68 0b 16 80 c0
6a 1e 68 73 15 80 c0
Jun 14 21:22:00 geiger5 kernel: EIP: [<c0562c32>] __list_add+0x2a/0x5c
SS:ESP 0068:f4f41dbc
Jun 14 21:22:00 geiger5 kernel: ---[ end trace 428f8bacbf92b610 ]---
Jun 14 21:22:02 geiger5 kernel: usb 1-3: new high speed USB device
using ehci_hcd and address 3
Jun 14 21:22:02 geiger5 kernel: usb 1-3: New USB device found,
idVendor=2040, idProduct=7501
Jun 14 21:22:02 geiger5 kernel: usb 1-3: New USB device strings:
Mfr=1, Product=2, SerialNumber=3
Jun 14 21:22:02 geiger5 kernel: usb 1-3: Product: WinTV
Jun 14 21:22:02 geiger5 kernel: usb 1-3: Manufacturer: Hauppauge
Jun 14 21:22:02 geiger5 kernel: usb 1-3: SerialNumber: 7300-00-F0522D8C
Jun 14 21:22:02 geiger5 kernel: usb 1-3: configuration #1 chosen from 1 choice
Jun 14 21:22:02 geiger5 kernel: pvrusb2: pvr2_context f4f134e0 (create)
Jun 14 21:22:02 geiger5 kernel: pvrusb2: pvr2_hdw_create:
hdw=f4f36000, type "WinTV HVR-1950 Model Category 751xx"
Jun 14 21:22:02 geiger5 kernel: pvrusb2: Driver unit number is 1, name
is pvrusb2_b
Jun 14 21:22:02 geiger5 kernel: pvrusb2: pvr_probe(pvr=f4f134e0)