Re: External HDD does not work with 3.11-rc2

2013-07-31 Thread Philipp Dreimann
On Tue, Jul 30, 2013 at 9:28 PM, Alan Stern st...@rowland.harvard.edu wrote:
 On Tue, 30 Jul 2013, Sarah Sharp wrote:

 On Tue, Jul 30, 2013 at 12:52:40PM -0400, Alan Stern wrote:
  Sarah, the usbmon trace shows that after doing a successful port reset
  and clearing a bunch of port features, the system tells the port to go
  into the SS.disabled state for no apparent reason:
 
  88014649f3c0 1804119918 S Co:4:001:0 s 23 03 0004 0002  0
  88014649f3c0 1804119924 C Co:4:001:0 0 0
  88020a1dd000 1804170382 S Ci:4:001:0 s a3 00  0002 0004 4 
  88020a1dd000 1804170389 C Ci:4:001:0 0 4 = 03021000
  8801b7173300 1804221388 S Co:4:001:0 s 23 01 0014 0002  0
  8801b7173300 1804221397 C Co:4:001:0 0 0
  8801b7173300 1804221398 S Co:4:001:0 s 23 01 001d 0002  0
  8801b7173300 1804221403 C Co:4:001:0 0 0
  8801b7173300 1804221403 S Co:4:001:0 s 23 01 0019 0002  0
  8801b7173300 1804221407 C Co:4:001:0 0 0
  8801b7173300 1804221408 S Co:4:001:0 s 23 01 0010 0002  0
  8801b7173300 1804221412 C Co:4:001:0 0 0
  8801b7173300 1804221414 S Ci:4:001:0 s a3 00  0002 0004 4 
  8801b7173300 1804221417 C Ci:4:001:0 0 4 = 0302
  88014649f3c0 1804623388 S Co:4:001:0 s 23 03 0005 0402  0
  88020ceb1600 1804623409 C Ii:4:001:1 0:2048 1 = 04
  88020ceb1600 1804623410 S Ii:4:001:1 -115:2048 4 
  88014649f3c0 1804623415 C Co:4:001:0 0 0
 
  Do you have any idea why it is doing this?

 If a warm reset failed, the USB core will put the port into SS.Disabled.
 If enumeration fails in the right places, the port will also be
 disabled.

 As far as I can tell from the usbmon trace, the reset succeeded.

 dmesg with CONFIG_USB_DEBUG and CONFIG_USB_XHCI_HCD_DEBUGGING might help
 me understand what's going on.

A log with CONFIG_USB_DEBUG and CONFIG_USB_XHCI_HCD_DEBUGGING enabled
is attached to this mail.
Note that the issue only occures if the drive is connected to the usb3
port of my docking station. (As described in
https://bugzilla.redhat.com/show_bug.cgi?id=984189 .)


usb-debug.txt.bz2
Description: BZip2 compressed data


Re: External HDD does not work with 3.11-rc2

2013-07-30 Thread Philipp Dreimann
On Mon, Jul 29, 2013 at 7:04 PM, Alan Stern st...@rowland.harvard.edu wrote:
 It turns out I was probably wrong.  Take a look at this message:

 http://marc.info/?l=linux-scsim=137511040432420w=2

 The patch in that email may fix your problem.
It does. Thanks!

I am unfortunately still seeing the suspend/resume issue which I
linked in the inital report:
The drive works if it is attached while the system is running. It is
not accessible anymore after a syspend/resume cycle that lasts a bit.
(A few minutes seem to be sufficient.) I do not know any good kernel
version for this problem.
Plugging the device in while the system is suspended does not work
reliably too, yielding a similar error, just with a few more retries:

Suspend/Resume:
usb 4-2: USB disconnect, device number 9
usb 4-2: Device not responding to set address.
usb 4-2: Device not responding to set address.
usb 4-2: device not accepting address 10, error -71

Plugged before resume:
usb 4-2: Device not responding to set address.
usb 4-2: Device not responding to set address.
usb 4-2: device not accepting address 12, error -71
usb 4-2: Device not responding to set address.
usb 4-2: Device not responding to set address.
usb 4-2: device not accepting address 14, error -71
usb 4-2: Device not responding to set address.
usb 4-2: Device not responding to set address.
usb 4-2: device not accepting address 16, error -71
usb 4-2: Device not responding to set address.
usb 4-2: Device not responding to set address.
usb 4-2: device not accepting address 18, error -71
usb 4-2: Device not responding to set address.
usb 4-2: Device not responding to set address.
usb 4-2: device not accepting address 20, error -71


A usbmon log is attached for the Suspend/Resume case running 3.11-rc3
+ the patch you pointed me at.


suspend-resume.txt.bz2
Description: BZip2 compressed data


Re: External HDD does not work with 3.11-rc2

2013-07-25 Thread Philipp Dreimann
On Wed, Jul 24, 2013 at 11:03 PM, Alan Stern st...@rowland.harvard.edu wrote:
 On Wed, 24 Jul 2013, Philipp Dreimann wrote:

 Hello,

 one of my external HDDs does not work using 3.11-rc2. The drive works
 using 3.10, and 3.9, except for a suspend/resume issue described here:
 https://bugzilla.redhat.com/show_bug.cgi?id=984189 .

 dmesg snipped:
 [  119.334908] usb 4-1: new SuperSpeed USB device number 2 using xhci_hcd
 [  119.347397] usb 4-1: Parent hub missing LPM exit latency info.
 Power management will be impacted.
 [  119.350614] usb 4-1: New USB device found, idVendor=054c, idProduct=c005
 [  119.350620] usb 4-1: New USB device strings: Mfr=1, Product=2, 
 SerialNumber=3
 [  119.350624] usb 4-1: Product: USB 3.0 SATA Bridge
 [  119.350627] usb 4-1: Manufacturer: VIA Technologies Inc.
 [  119.350630] usb 4-1: SerialNumber: l刁A柜鬨xffc2\xff80籁7鮘d
 [  119.377782] usb-storage 4-1:1.0: USB Mass Storage device detected
 [  119.377847] scsi6 : usb-storage 4-1:1.0
 [  119.377900] usbcore: registered new interface driver usb-storage
 [  129.844989] scsi 6:0:0:0: Direct-Access Hitachi  HDS5C3030BLE
   MZ6O PQ: 0 ANSI: 6
 [  129.845465] sd 6:0:0:0: Attached scsi generic sg1 type 0
 [  129.863425] sd 6:0:0:0: [sdb] 732566646 4096-byte logical blocks:
 (3.00 TB/2.72 TiB)
 [  129.871203] sd 6:0:0:0: [sdb] Write Protect is off
 [  129.871209] sd 6:0:0:0: [sdb] Mode Sense: 2f 00 00 00
 [  129.879196] sd 6:0:0:0: [sdb] Write cache: disabled, read cache:
 enabled, doesn't support DPO or FUA
 [  160.787920] usb 4-1: reset SuperSpeed USB device number 2 using xhci_hcd
 [  160.800582] usb 4-1: Parent hub missing LPM exit latency info.
 Power management will be impacted.
 [  160.801795] usb 4-1: device firmware changed
 [  160.801857] usb 4-1: USB disconnect, device number 2
 [  160.801938] sd 6:0:0:0: Device offlined - not ready after error recovery
 [  160.805190] sd 6:0:0:0: [sdb] READ CAPACITY failed
 [  160.805194] sd 6:0:0:0: [sdb]
 [  160.805195] Result: hostbyte=DID_NO_CONNECT driverbyte=DRIVER_OK
 [  160.805197] sd 6:0:0:0: [sdb] Sense not available.
 [  160.805218] sd 6:0:0:0: [sdb] Asking for cache data failed
 [  160.805220] sd 6:0:0:0: [sdb] Assuming drive cache: write through
 [  160.805233] sdb: detected capacity change from 3000592982016 to 0
 [  160.805353] sd 6:0:0:0: [sdb] READ CAPACITY failed
 [  160.805357] sd 6:0:0:0: [sdb]
 [  160.805359] Result: hostbyte=DID_NO_CONNECT driverbyte=DRIVER_OK
 [  160.805361] sd 6:0:0:0: [sdb] Sense not available.
 [  160.805383] sd 6:0:0:0: [sdb] No Caching mode page present
 [  160.805386] sd 6:0:0:0: [sdb] Assuming drive cache: write through
 [  160.805397] sd 6:0:0:0: [sdb] Attached SCSI disk
 [  160.806605] xhci_hcd :0e:00.0: xHCI xhci_drop_endpoint called
 with disabled ep 880212315e80
 [  160.806609] xhci_hcd :0e:00.0: xHCI xhci_drop_endpoint called
 with disabled ep 880212315ec0

 kernel log, lsusb and usbmon are attached. I tried usb2 and 3 ports,
 both have the same issue with this drive. Other drives work.

 The problem is caused by some program on your computer sending a
 command to the drive that it can't handle (SCSI INQUIRY command with a
 transfer length of 512).  It is not a kernel problem.

Thanks, I can reproduce the issue using kernel 3.9.9 and
$ sg_inq -l 512 /dev/sdb

I am guessing that this is the reason for the suspend/resume issues
with 3.9 and 3.10 as well. A look at the program's code might reveal
why this was not triggered on 3.9 and 3.10 as bad as on 3.11...
--
To unsubscribe from this list: send the line unsubscribe linux-usb in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


External HDD does not work with 3.11-rc2

2013-07-24 Thread Philipp Dreimann
Hello,

one of my external HDDs does not work using 3.11-rc2. The drive works
using 3.10, and 3.9, except for a suspend/resume issue described here:
https://bugzilla.redhat.com/show_bug.cgi?id=984189 .

dmesg snipped:
[  119.334908] usb 4-1: new SuperSpeed USB device number 2 using xhci_hcd
[  119.347397] usb 4-1: Parent hub missing LPM exit latency info.
Power management will be impacted.
[  119.350614] usb 4-1: New USB device found, idVendor=054c, idProduct=c005
[  119.350620] usb 4-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[  119.350624] usb 4-1: Product: USB 3.0 SATA Bridge
[  119.350627] usb 4-1: Manufacturer: VIA Technologies Inc.
[  119.350630] usb 4-1: SerialNumber: lþmµóA¹ñô\xffc2\xff80ô¥7õ\d
[  119.377782] usb-storage 4-1:1.0: USB Mass Storage device detected
[  119.377847] scsi6 : usb-storage 4-1:1.0
[  119.377900] usbcore: registered new interface driver usb-storage
[  129.844989] scsi 6:0:0:0: Direct-Access Hitachi  HDS5C3030BLE
  MZ6O PQ: 0 ANSI: 6
[  129.845465] sd 6:0:0:0: Attached scsi generic sg1 type 0
[  129.863425] sd 6:0:0:0: [sdb] 732566646 4096-byte logical blocks:
(3.00 TB/2.72 TiB)
[  129.871203] sd 6:0:0:0: [sdb] Write Protect is off
[  129.871209] sd 6:0:0:0: [sdb] Mode Sense: 2f 00 00 00
[  129.879196] sd 6:0:0:0: [sdb] Write cache: disabled, read cache:
enabled, doesn't support DPO or FUA
[  160.787920] usb 4-1: reset SuperSpeed USB device number 2 using xhci_hcd
[  160.800582] usb 4-1: Parent hub missing LPM exit latency info.
Power management will be impacted.
[  160.801795] usb 4-1: device firmware changed
[  160.801857] usb 4-1: USB disconnect, device number 2
[  160.801938] sd 6:0:0:0: Device offlined - not ready after error recovery
[  160.805190] sd 6:0:0:0: [sdb] READ CAPACITY failed
[  160.805194] sd 6:0:0:0: [sdb]
[  160.805195] Result: hostbyte=DID_NO_CONNECT driverbyte=DRIVER_OK
[  160.805197] sd 6:0:0:0: [sdb] Sense not available.
[  160.805218] sd 6:0:0:0: [sdb] Asking for cache data failed
[  160.805220] sd 6:0:0:0: [sdb] Assuming drive cache: write through
[  160.805233] sdb: detected capacity change from 3000592982016 to 0
[  160.805353] sd 6:0:0:0: [sdb] READ CAPACITY failed
[  160.805357] sd 6:0:0:0: [sdb]
[  160.805359] Result: hostbyte=DID_NO_CONNECT driverbyte=DRIVER_OK
[  160.805361] sd 6:0:0:0: [sdb] Sense not available.
[  160.805383] sd 6:0:0:0: [sdb] No Caching mode page present
[  160.805386] sd 6:0:0:0: [sdb] Assuming drive cache: write through
[  160.805397] sd 6:0:0:0: [sdb] Attached SCSI disk
[  160.806605] xhci_hcd :0e:00.0: xHCI xhci_drop_endpoint called
with disabled ep 880212315e80
[  160.806609] xhci_hcd :0e:00.0: xHCI xhci_drop_endpoint called
with disabled ep 880212315ec0

kernel log, lsusb and usbmon are attached. I tried usb2 and 3 ports,
both have the same issue with this drive. Other drives work.

Thanks,
 Philipp


logs.tar.bz2
Description: BZip2 compressed data