On Sun, Nov 18, 2012 at 12:44:37PM -0500, Alan Stern wrote: > On Sun, 18 Nov 2012, Piergiorgio Sartor wrote: > > > 32830f207691176234b4c4dd17f0d7ab6d87d94b is the first bad commit > > commit 32830f207691176234b4c4dd17f0d7ab6d87d94b > > Author: Alan Stern <stern@xxxxxxxxxxxxxxxxxxx> > > Date: Wed Jul 11 11:22:53 2012 -0400 > > > > USB: EHCI: use hrtimer for unlinking empty async QHs > > > > This patch (as1583) changes ehci-hcd to use an hrtimer event for > > unlinking empty (unused) async QHs instead of using a kernel timer. > > > > The check for empty QHs is moved to a new routine, where it doesn't > > require going through an entire scan of both the async and periodic > > schedules. And it can unlink multiple QHs at once, unlike the current > > code. > > > > Signed-off-by: Alan Stern <stern@xxxxxxxxxxxxxxxxxxx> > > Signed-off-by: Greg Kroah-Hartman <gregkh@xxxxxxxxxxxxxxxxxxx> > > > > :040000 040000 9767ca0f3b8c9fa0530e90730dc3106420412822 > > 6b567d1137df3cdec9f19f835ea7c546491d9ca8 M drivers > > > > Which looks like to me more consistent with the problem. > > Here's what you should do. Build a kernel that exhibits the problem > with CONFIG_USB_DEBUG enabled and post a copy of the dmesg log showing > what happens when the problem occurs. Also, it would help if you can > collect a usbmon trace at the same time (see the instructions in > Documentation/usb/usbmon.txt). > > Alan Stern This is the output of usbmod just when the problem happened: ffff8801232fd6c0 815566692 C Co:1:012:0 -2 0 ffff880130cd9000 815566767 S Co:1:012:0 s 23 03 0004 0001 0000 0 ffff880130cd9000 816577053 C Co:1:012:0 -2 0 ffff8800649db6c0 816577128 S Co:1:012:0 s 23 03 0004 0001 0000 0 ffff8800649db6c0 817588087 C Co:1:012:0 -2 0 ffff8800649bcb40 817588171 S Co:1:012:0 s 23 03 0004 0001 0000 0 ffff8800649bcb40 818599529 C Co:1:012:0 -2 0 ffff8800276fc900 818599606 S Co:1:012:0 s 23 03 0004 0001 0000 0 ffff8800276fc900 819611470 C Co:1:012:0 -2 0 ffff8800649bc9c0 819611555 S Co:1:012:0 s 23 01 0001 0001 0000 0 ffff8800649bc9c0 820622047 C Co:1:012:0 -2 0 ffff88010b2ea300 820622129 S Co:1:012:0 s 23 03 0004 0001 0000 0 ffff88010b2ea300 821633095 C Co:1:012:0 -2 0 ffff8800273ed6c0 821633152 S Co:1:012:0 s 23 03 0004 0001 0000 0 ffff8800273ed6c0 822644294 C Co:1:012:0 -2 0 ffff880130f02cc0 822644367 S Co:1:012:0 s 23 03 0004 0001 0000 0 ffff880130f02cc0 823655689 C Co:1:012:0 -2 0 ffff8801193c3300 823655742 S Co:1:012:0 s 23 03 0004 0001 0000 0 ffff8801193c3300 824666926 C Co:1:012:0 -2 0 ffff880130f02600 824667018 S Co:1:012:0 s 23 03 0004 0001 0000 0 ffff880130f02600 825678105 C Co:1:012:0 -2 0 ffff8801193c3840 825678165 S Co:1:012:0 s 23 01 0001 0001 0000 0 ffff8801193c3840 826690597 C Co:1:012:0 -2 0 ffff880130f02a80 826690671 S Co:1:012:0 s 23 03 0004 0001 0000 0 ffff880130f02a80 827701091 C Co:1:012:0 -2 0 ffff880027340a80 827701145 S Co:1:012:0 s 23 03 0004 0001 0000 0 ffff880027340a80 828712752 C Co:1:012:0 -2 0 ffff88010b2ea240 828712814 S Co:1:012:0 s 23 03 0004 0001 0000 0 ffff88010b2ea240 829723041 C Co:1:012:0 -2 0 ffff880133cb8600 829723083 S Co:1:012:0 s 23 03 0004 0001 0000 0 ffff880133cb8600 830734734 C Co:1:012:0 -2 0 ffff8800649bc780 830734808 S Co:1:012:0 s 23 03 0004 0001 0000 0 ffff8800649bc780 831746050 C Co:1:012:0 -2 0 ffff880133cb86c0 831746129 S Co:1:012:0 s 23 01 0001 0001 0000 0 ffff880133cb86c0 832757150 C Co:1:012:0 -2 0 ffff880026d5c6c0 832757231 S Co:1:012:0 s 23 03 0004 0001 0000 0 ffff880026d5c6c0 833768771 C Co:1:012:0 -2 0 ffff880133cb8000 833768846 S Co:1:012:0 s 23 03 0004 0001 0000 0 ffff880133cb8000 834779719 C Co:1:012:0 -2 0 ffff880071bd0300 834779783 S Co:1:012:0 s 23 03 0004 0001 0000 0 ffff880071bd0300 835790173 C Co:1:012:0 -2 0 ffff88010b2ea480 835790244 S Co:1:012:0 s 23 03 0004 0001 0000 0 ffff88010b2ea480 836801136 C Co:1:012:0 -2 0 ffff880064bb3900 836801194 S Co:1:012:0 s 23 03 0004 0001 0000 0 ffff880064bb3900 837812753 C Co:1:012:0 -2 0 ffff88010b2ea840 837812827 S Co:1:012:0 s 23 01 0001 0001 0000 0 ffff88010b2ea840 838823775 C Co:1:012:0 -2 0 ffff880064bb3600 838823839 S Co:1:012:0 s 23 01 0001 0001 0000 0 ffff880133cb8b40 838823856 S Co:1:013:0 s 23 03 0004 0002 0000 0 ffff880064bb3600 839834571 C Co:1:012:0 -2 0 ffff88010b2ea600 839834661 S Ci:1:012:0 s a3 00 0000 0001 0004 4 < ffff880133cb8b40 839845616 C Co:1:013:0 -2 0 ffff880071bd0000 839845675 S Co:1:013:0 s 23 03 0004 0002 0000 0 ffff88010b2ea600 840845592 C Ci:1:012:0 -2 0 ffff8800273edd80 840845632 S Ci:1:012:0 s a3 00 0000 0001 0004 4 < ffff880071bd0000 840856651 C Co:1:013:0 -2 0 ffff880062d5bb40 840856720 S Co:1:013:0 s 23 03 0004 0002 0000 0 ffff8800273edd80 841856072 C Ci:1:012:0 -2 0 ffff88014822eb40 841856108 S Ci:1:012:0 s a3 00 0000 0001 0004 4 < ffff880062d5bb40 841867394 C Co:1:013:0 -2 0 ffff880064bb3240 841867456 S Co:1:013:0 s 23 03 0004 0002 0000 0 ffff88014822eb40 842867197 C Ci:1:012:0 -2 0 ffff880064bb3d80 842867250 S Ci:1:012:0 s a3 00 0000 0001 0004 4 < ffff880064bb3240 842878251 C Co:1:013:0 -2 0 ffff8800273ed3c0 842878305 S Co:1:013:0 s 23 03 0004 0002 0000 0 ffff880064bb3d80 843878403 C Ci:1:012:0 -2 0 ffff8800afa13900 843878450 S Ci:1:012:0 s a3 00 0000 0001 0004 4 < ffff8800273ed3c0 843889465 C Co:1:013:0 -2 0 ffff8800273ed3c0 843889525 S Co:1:013:0 s 23 01 0001 0002 0000 0 ffff8800afa13900 844889198 C Ci:1:012:0 -2 0 ffff8800273ed3c0 844900744 C Co:1:013:0 -2 0 ffff880064bb33c0 844900819 S Co:1:013:0 s 23 03 0004 0002 0000 0 ffff880064bb33c0 845911079 C Co:1:013:0 -2 0 ffff880026fb2780 845911126 S Co:1:013:0 s 23 03 0004 0002 0000 0 ffff880026fb2780 846922109 C Co:1:013:0 -2 0 ffff880062d5b600 846922181 S Co:1:013:0 s 23 03 0004 0002 0000 0 After dmesg reported the error -110 I stopped it. Interesting enough, with usbmod running (cat /sys/.../1u > usb1.txt) the transfer rate, from the HDDs, was around about 10% slower than usual and the problem did not show up at first. I do not know if it was just by random, but this could hint a race condition somewhere. Any idea? bye, -- piergiorgio -- To unsubscribe from this list: send the line "unsubscribe linux-usb" in the body of a message to majordomo@xxxxxxxxxxxxxxx More majordomo info at http://vger.kernel.org/majordomo-info.html
