Am Donnerstag 26 November 2009 00:13:23 schrieb Stephan Diestelhorst:
> Am Mittwoch 25 November 2009 23:38:25 schrieb Alan Stern:
> > On Wed, 25 Nov 2009, Stephan Diestelhorst wrote:
> > You should add a dump_stack() line to handshake_on_error_set_halt(),
> > just after the ehci_err() call. Then we'd be able to see the failure
> > pathway and determine whether it really was caused by the delay being
> > too short.
>
> Will do that now and report back.
>
> I have bumped the delay up to 1000 us, and could not trigger the
> issue, even with doing modprobe uvcvideo; rmmod uvcvideo in a loop for
> several hundred interations, with varying delays between the insert
> and removal. However, I am not sure, whether this is actually stress
> testing anything.
Gotcha. Tried again with 500 us delay and the repeated modprobe/rmmod.
Crashed the thing quite quickly, see attachment for the relevant
excerpt (including call stack) from dmesg.
Now back to bumping up the value. rant { The compilation speed on this
machine does not help, though. Partly thanks to the disk encryption
eating some of the few Atom-FLOPS. Maybe compiling on an unencrypted
USB key does the trick. Erm, no. For that the USB system should work
:-/ }
Cheers,
Stephan
[ 208.638789] usbcore: deregistering interface driver uvcvideo
[ 246.782150] uvcvideo: Found UVC 1.00 device BisonCam, NB Pro (5986:0203)
[ 246.786416] input: BisonCam, NB Pro as /devices/pci0000:00/0000:00:1d.7/usb1/1-5/1-5:1.0/input/input10
[ 246.786612] usbcore: registered new interface driver uvcvideo
[ 246.786621] USB Video Class driver (v0.1.0)
[ 246.820018] ehci_hcd 0000:00:1d.7: force halt; handhake f8042024 00004000 00000000 -> -110
[ 246.820018] Pid: 2332, comm: hald-probe-vide Tainted: G C 2.6.31.4-bison-u2000 #14
[ 246.820018] Call Trace:
[ 246.820018] [<c0563aa1>] ? printk+0x18/0x1f
[ 246.820018] [<c04174fc>] handshake_on_error_set_halt+0x8c/0xa0
[ 246.820018] [<c0417651>] enable_periodic+0x51/0xa0
[ 246.820018] [<c0418df6>] qh_schedule+0x236/0x300
[ 246.820018] [<c041cc01>] ehci_urb_enqueue+0x631/0xc80
[ 246.820018] [<c040616f>] usb_hcd_submit_urb+0x13f/0xaf0
[ 246.820018] [<c013ac21>] ? enqueue_task_fair+0x31/0x70
[ 246.820018] [<c011b911>] ? native_smp_send_reschedule+0x31/0x50
[ 246.820018] [<c013012e>] ? resched_task+0x5e/0x70
[ 246.820018] [<c0139977>] ? try_to_wake_up+0xf7/0x350
[ 246.820018] [<c0566338>] ? _spin_lock+0x8/0x10
[ 246.820018] [<c01f4612>] ? __d_lookup+0x102/0x110
[ 246.820018] [<c0406f4d>] usb_submit_urb+0xdd/0x240
[ 246.820018] [<f837eea5>] ? uvc_v4l2_open+0x75/0x160 [uvcvideo]
[ 246.820018] [<c040aeb2>] ? usb_autopm_do_interface+0x82/0xf0
[ 246.820018] [<f838241b>] uvc_status_start+0x1b/0x20 [uvcvideo]
[ 246.820018] [<f837eedc>] uvc_v4l2_open+0xac/0x160 [uvcvideo]
[ 246.820018] [<c01e60ca>] ? exact_lock+0xa/0x20
[ 246.820018] [<f8112932>] v4l2_open+0x62/0xa0 [videodev]
[ 246.820018] [<c01e631d>] chrdev_open+0xcd/0x190
[ 246.820018] [<c01e14d9>] __dentry_open+0xb9/0x230
[ 246.820018] [<c01e1735>] nameidata_to_filp+0x55/0x70
[ 246.820018] [<c01e6250>] ? chrdev_open+0x0/0x190
[ 246.820018] [<c01ef0da>] do_filp_open+0x53a/0x920
[ 246.820018] [<c01af591>] ? unlock_page+0x41/0x50
[ 246.820018] [<c01c7038>] ? __do_fault+0x388/0x470
[ 246.820018] [<c01e1270>] do_sys_open+0x50/0x150
[ 246.820018] [<c01e13d9>] sys_open+0x29/0x40
[ 246.820018] [<c01033ac>] syscall_call+0x7/0xb
[ 247.079713] hub 1-0:1.0: cannot reset port 6 (err = -108)
[ 247.087168] hub 1-0:1.0: cannot reset port 6 (err = -108)
[ 247.094976] hub 1-0:1.0: cannot reset port 6 (err = -108)
[ 247.102383] hub 1-0:1.0: cannot reset port 6 (err = -108)
[ 247.109743] hub 1-0:1.0: cannot reset port 6 (err = -108)
[ 247.113368] hub 1-0:1.0: Cannot enable port 6. Maybe the USB cable is bad?
[ 247.117367] hub 1-0:1.0: cannot disable port 6 (err = -108)
[ 247.120767] hub 1-0:1.0: cannot reset port 6 (err = -108)
[ 247.124569] hub 1-0:1.0: cannot reset port 6 (err = -108)
[ 247.127725] hub 1-0:1.0: cannot reset port 6 (err = -108)
[ 247.130755] hub 1-0:1.0: cannot reset port 6 (err = -108)
[ 247.134138] hub 1-0:1.0: cannot reset port 6 (err = -108)
[ 247.136794] hub 1-0:1.0: Cannot enable port 6. Maybe the USB cable is bad?
[ 247.139802] hub 1-0:1.0: cannot disable port 6 (err = -108)
[ 247.142394] hub 1-0:1.0: cannot reset port 6 (err = -108)
[ 247.145476] hub 1-0:1.0: cannot reset port 6 (err = -108)
[ 247.148030] hub 1-0:1.0: cannot reset port 6 (err = -108)
[ 247.150844] hub 1-0:1.0: cannot reset port 6 (err = -108)
[ 247.153222] hub 1-0:1.0: cannot reset port 6 (err = -108)
[ 247.155875] hub 1-0:1.0: Cannot enable port 6. Maybe the USB cable is bad?
[ 247.158207] hub 1-0:1.0: cannot disable port 6 (err = -108)
[ 247.160913] hub 1-0:1.0: cannot reset port 6 (err = -108)
[ 247.163136] hub 1-0:1.0: cannot reset port 6 (err = -108)
[ 247.165388] hub 1-0:1.0: cannot reset port 6 (err = -108)
[ 247.168111] hub 1-0:1.0: cannot reset port 6 (err = -108)
[ 247.170241] hub 1-0:1.0: cannot reset port 6 (err = -108)
[ 247.172308] hub 1-0:1.0: Cannot enable port 6. Maybe the USB cable is bad?
[ 247.174908] hub 1-0:1.0: cannot disable port 6 (err = -108)
[ 247.177043] hub 1-0:1.0: cannot disable port 6 (err = -108)
[ 247.179673] hub 1-0:1.0: hub_port_status failed (err = -108)
[ 247.829353] usbcore: deregistering interface driver uvcvideo
[ 247.908608] uvcvideo: Found UVC 1.00 device BisonCam, NB Pro (5986:0203)
[ 247.908661] uvcvideo: UVC non compliance - GET_DEF(PROBE) not supported. Enabling workaround.
[ 247.908678] uvcvideo: Failed to query (129) UVC probe control : -108 (exp. 26).
[ 247.911117] uvcvideo: Failed to initialize the device (-5).
[ 247.913213] usbcore: registered new interface driver uvcvideo
[ 247.913224] USB Video Class driver (v0.1.0)
[ 248.948360] usbcore: deregistering interface driver uvcvideo
[ 248.987338] uvcvideo: Found UVC 1.00 device BisonCam, NB Pro (5986:0203)
[ 248.987410] uvcvideo: UVC non compliance - GET_DEF(PROBE) not supported. Enabling workaround.
[ 248.987432] uvcvideo: Failed to query (129) UVC probe control : -108 (exp. 26).
[ 248.991170] uvcvideo: Failed to initialize the device (-5).
[ 248.996860] usbcore: registered new interface driver uvcvideo
[ 248.996873] USB Video Class driver (v0.1.0)
[ 250.027311] usbcore: deregistering interface driver uvcvideo
[ 250.065112] uvcvideo: Found UVC 1.00 device BisonCam, NB Pro (5986:0203)
[ 250.065166] uvcvideo: UVC non compliance - GET_DEF(PROBE) not supported. Enabling workaround.
[ 250.065184] uvcvideo: Failed to query (129) UVC probe control : -108 (exp. 26).
[ 250.067093] uvcvideo: Failed to initialize the device (-5).
[ 250.069135] usbcore: registered new interface driver uvcvideo
[ 250.069147] USB Video Class driver (v0.1.0)
[ 251.105638] usbcore: deregistering interface driver uvcvideo
[ 251.142583] uvcvideo: Found UVC 1.00 device BisonCam, NB Pro (5986:0203)
[ 251.142623] uvcvideo: UVC non compliance - GET_DEF(PROBE) not supported. Enabling workaround.
[ 251.142634] uvcvideo: Failed to query (129) UVC probe control : -108 (exp. 26).
[ 251.144805] uvcvideo: Failed to initialize the device (-5).
[ 251.147469] usbcore: registered new interface driver uvcvideo
[ 251.147481] USB Video Class driver (v0.1.0)
