On 18/03/11 20:19, Greg KH wrote:
On Fri, Mar 18, 2011 at 12:09:31PM +0000, Richard Senior wrote:
OK, so I've completed the git bisect:
$ cat .git/refs/bisect/bad
a1e8fad5900fa94adb500c6e0dfd60a307f7a3c9
Really? Do you have CONFIG_TRACE enabled? If not, that patch should
have no affect on your system.
If you do have it enabled, this change causing a lack of USB device
connection seems very strange, and I really don't understand what is
going on.
If you manually revert that patch, does your problem go away?
OK, I believe I've run the git bisect to completion now. My last kernel
tested out OK, so I issued:
$ git bisect good
a1e8fad5900fa94adb500c6e0dfd60a307f7a3c9 is the first bad commit
My current tree is a45b0616e7ee9db4c1b2b9a4a79a974325fa9bf3, with the
small patch I referred to in previous messages.
---------------------------------------------------------------------
$ git diff a45b0616e7ee9db4c1b2b9a4a79a974325fa9bf3
diff --git a/arch/x86/kernel/entry_64.S b/arch/x86/kernel/entry_64.S
index e3ba417..b235db9 100644
--- a/arch/x86/kernel/entry_64.S
+++ b/arch/x86/kernel/entry_64.S
@@ -1238,7 +1238,7 @@ ENTRY(xen_do_hypervisor_callback) #
do_hypervisor_callback(struct *pt_regs)
decl PER_CPU_VAR(irq_count)
jmp error_exit
CFI_ENDPROC
-END(do_hypervisor_callback)
+END(xen_do_hypervisor_callback)
/*
* Hypervisor uses this for application faults while it executes.
---------------------------------------------------------------------
This is the commit for my "bad" tree which I obtained with git checkout
-f a1e8fad5900fa94adb500c6e0dfd60a307f7a3c9 ...
http://git.kernel.org/?p=linux/kernel/git/torvalds/linux-2.6.git;a=commit;h=a1e8fad5900fa94adb500c6e0dfd60a307f7a3c9
and shows the parent as a45b0616e7ee9db4c1b2b9a4a79a974325fa9bf3, which
is my current version (with above small patch) that tests out OK.
I've just re-tested the "bad" kernel
(a1e8fad5900fa94adb500c6e0dfd60a307f7a3c9) and the "good" kernel
(a45b0616e7ee9db4c1b2b9a4a79a974325fa9bf3) and the transcripts of my
testing session are attached.
I should probably explain the difference between plugging in the device
and enabling it: There is a menu option on the device called "USB Open",
which is used to enable the USB port on the device and allow access to
the FAT partition on its disk for transfer. I'm assuming this is
normally disabled because it would affect the latency of the device when
recording audio.
Does any of that make any sense?
--
Regards,
Richard
Script started on Sat 19 Mar 2011 13:51:41 GMT
root@calder:~# echo 'Device plugged but not enabled'
Device plugged but not enabled
root@calder:~# tail /var/log/syslog
Mar 19 13:52:04 calder kernel: [ 73.240069] usb 6-1: device descriptor read/64, error -71
Mar 19 13:52:04 calder kernel: [ 73.480035] usb 6-1: device descriptor read/64, error -71
Mar 19 13:52:04 calder kernel: [ 73.770068] usb 6-1: new full speed USB device using uhci_hcd and address 3
Mar 19 13:52:04 calder kernel: [ 73.900049] usb 6-1: device descriptor read/64, error -71
Mar 19 13:52:05 calder kernel: [ 74.200036] usb 6-1: device descriptor read/64, error -71
Mar 19 13:52:05 calder kernel: [ 74.490070] usb 6-1: new full speed USB device using uhci_hcd and address 4
Mar 19 13:52:05 calder kernel: [ 74.910072] usb 6-1: device not accepting address 4, error -71
Mar 19 13:52:06 calder kernel: [ 75.090070] usb 6-1: new full speed USB device using uhci_hcd and address 5
Mar 19 13:52:06 calder kernel: [ 75.510066] usb 6-1: device not accepting address 5, error -71
Mar 19 13:52:06 calder kernel: [ 75.510123] hub 6-0:1.0: unable to enumerate USB device on port 1
root@calder:~# echo 'Device enabled'
Device enabled
root@calder:~# tail /var/log/syslog
Mar 19 13:52:33 calder kernel: [ 102.774577] scsi5 : usb-storage 2-3:1.0
Mar 19 13:52:33 calder kernel: [ 102.774733] usbcore: registered new interface driver usb-storage
Mar 19 13:52:33 calder kernel: [ 102.774736] USB Mass Storage support registered.
Mar 19 13:52:34 calder kernel: [ 103.773448] scsi 5:0:0:0: Direct-Access USB-HS SAMSUNG SP0411N 0.01 PQ: 0 ANSI: 0
Mar 19 13:52:34 calder kernel: [ 103.774377] sd 5:0:0:0: Attached scsi generic sg2 type 0
Mar 19 13:52:34 calder kernel: [ 103.777176] sd 5:0:0:0: [sdb] 78242976 512-byte logical blocks: (40.0 GB/37.3 GiB)
Mar 19 13:52:34 calder kernel: [ 103.778864] sd 5:0:0:0: [sdb] Write Protect is off
Mar 19 13:52:34 calder kernel: [ 103.778870] sd 5:0:0:0: [sdb] Mode Sense: 0b 00 00 08
Mar 19 13:52:34 calder kernel: [ 103.910084] usb 2-3: reset high speed USB device using ehci_hcd and address 3
Mar 19 13:52:49 calder kernel: [ 119.030090] usb 2-3: device descriptor read/64, error -110
root@calder:~# fdisk -l
Disk /dev/sda: 120.0 GB, 120034123776 bytes
255 heads, 63 sectors/track, 14593 cylinders
Units = cylinders of 16065 * 512 = 8225280 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 512 bytes / 512 bytes
Disk identifier: 0x47c7fe89
Device Boot Start End Blocks Id System
/dev/sda1 * 1 1245 10000431 83 Linux
/dev/sda2 1246 14400 105667537+ 83 Linux
/dev/sda3 14401 14593 1550272+ 82 Linux swap / Solaris
root@calder:~# lsusb
Bus 007 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 006 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 005 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 004 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 003 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 002 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub
Bus 001 Device 002: ID 04f2:b070 Chicony Electronics Co., Ltd
Bus 001 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub
root@calder:~# echo 'lsusb hung and only completed when device unplugged'
lsusb hung and only completed when device unplugged
root@calder:~# tail /var/log/syslog
Mar 19 13:53:19 calder kernel: [ 149.010313] sd 5:0:0:0: Device offlined - not ready after error recovery
Mar 19 13:53:19 calder kernel: [ 149.010352] sd 5:0:0:0: [sdb] Asking for cache data failed
Mar 19 13:53:19 calder kernel: [ 149.010400] usb 2-3: USB disconnect, address 3
Mar 19 13:53:19 calder kernel: [ 149.012788] sd 5:0:0:0: [sdb] Assuming drive cache: write through
Mar 19 13:53:19 calder kernel: [ 149.015340] sd 5:0:0:0: [sdb] READ CAPACITY failed
Mar 19 13:53:19 calder kernel: [ 149.015345] sd 5:0:0:0: [sdb] Result: hostbyte=DID_NO_CONNECT driverbyte=DRIVER_OK
Mar 19 13:53:19 calder kernel: [ 149.015350] sd 5:0:0:0: [sdb] Sense not available.
Mar 19 13:53:19 calder kernel: [ 149.015392] sd 5:0:0:0: [sdb] No Caching mode page present
Mar 19 13:53:19 calder kernel: [ 149.017653] sd 5:0:0:0: [sdb] Assuming drive cache: write through
Mar 19 13:53:19 calder kernel: [ 149.019762] sd 5:0:0:0: [sdb] Attached SCSI disk
root@calder:~# exit
Script done on Sat 19 Mar 2011 13:54:17 GMT
Script started on Sat 19 Mar 2011 13:47:54 GMT
root@calder:~# echo 'Device plugged but not enabled'
Device plugged but not enabled
root@calder:~# tail /var/log/syslog
Mar 19 13:48:09 calder kernel: [ 65.980073] usb 6-1: device descriptor read/64, error -71
Mar 19 13:48:10 calder kernel: [ 66.280053] usb 6-1: device descriptor read/64, error -71
Mar 19 13:48:10 calder kernel: [ 66.570073] usb 6-1: new full speed USB device using uhci_hcd and address 3
Mar 19 13:48:10 calder kernel: [ 66.760047] usb 6-1: device descriptor read/64, error -71
Mar 19 13:48:10 calder kernel: [ 67.000051] usb 6-1: device descriptor read/64, error -71
Mar 19 13:48:11 calder kernel: [ 67.230052] usb 6-1: new full speed USB device using uhci_hcd and address 4
Mar 19 13:48:11 calder kernel: [ 67.650048] usb 6-1: device not accepting address 4, error -71
Mar 19 13:48:11 calder kernel: [ 67.830072] usb 6-1: new full speed USB device using uhci_hcd and address 5
Mar 19 13:48:12 calder kernel: [ 68.250049] usb 6-1: device not accepting address 5, error -71
Mar 19 13:48:12 calder kernel: [ 68.250104] hub 6-0:1.0: unable to enumerate USB device on port 1
root@calder:~# echo 'Device enabled'
Device enabled
root@calder:~# tail /var/log/syslog
Mar 19 13:48:40 calder kernel: [ 96.573451] scsi 5:0:0:0: Direct-Access USB-HS SAMSUNG SP0411N 0.01 PQ: 0 ANSI: 0
Mar 19 13:48:40 calder kernel: [ 96.574419] sd 5:0:0:0: Attached scsi generic sg2 type 0
Mar 19 13:48:40 calder kernel: [ 96.575827] sd 5:0:0:0: [sdb] 78242976 512-byte logical blocks: (40.0 GB/37.3 GiB)
Mar 19 13:48:40 calder kernel: [ 96.579065] sd 5:0:0:0: [sdb] Write Protect is off
Mar 19 13:48:40 calder kernel: [ 96.579072] sd 5:0:0:0: [sdb] Mode Sense: 0b 00 00 08
Mar 19 13:48:40 calder kernel: [ 96.579075] sd 5:0:0:0: [sdb] Assuming drive cache: write through
Mar 19 13:48:40 calder kernel: [ 96.582924] sd 5:0:0:0: [sdb] Assuming drive cache: write through
Mar 19 13:48:40 calder kernel: [ 96.594072] sdb: sdb1
Mar 19 13:48:40 calder kernel: [ 96.597555] sd 5:0:0:0: [sdb] Assuming drive cache: write through
Mar 19 13:48:40 calder kernel: [ 96.597605] sd 5:0:0:0: [sdb] Attached SCSI disk
root@calder:~# fdisk -l
Disk /dev/sda: 120.0 GB, 120034123776 bytes
255 heads, 63 sectors/track, 14593 cylinders
Units = cylinders of 16065 * 512 = 8225280 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 512 bytes / 512 bytes
Disk identifier: 0x47c7fe89
Device Boot Start End Blocks Id System
/dev/sda1 * 1 1245 10000431 83 Linux
/dev/sda2 1246 14400 105667537+ 83 Linux
/dev/sda3 14401 14593 1550272+ 82 Linux swap / Solaris
Disk /dev/sdb: 40.1 GB, 40060403712 bytes
255 heads, 63 sectors/track, 4870 cylinders
Units = cylinders of 16065 * 512 = 8225280 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 512 bytes / 512 bytes
Disk identifier: 0xce3e5a45
Device Boot Start End Blocks Id System
/dev/sdb1 1 522 4192933+ 6 FAT16
root@calder:~# mount /dev/sdb1 /media/tascam
root@calder:~# ls /media/tascam
BACKUP UTILITY WAVE
root@calder:~# umount /dev/sdb1
root@calder:~# lsusb
Bus 007 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 006 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 005 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 004 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 003 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 002 Device 003: ID 0644:800d TEAC Corp. TASCAM Portastudio DP-01FX
Bus 002 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub
Bus 001 Device 002: ID 04f2:b070 Chicony Electronics Co., Ltd
Bus 001 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub
root@calder:~# exit
Script done on Sat 19 Mar 2011 13:49:44 GMT
