Failed to read CSW: USB_ERR_STALLED

[Krzysztof Parzyszek]

Hi,
I have a PowerMac G5, and a 4-bay USB3 enclosure. Until a few days ago I 
was using it as a USB2 device with ZFS and everything worked fine (at 
least in terms of functionality).  After one disk failed, the 
resilvering of a new one was taking a very long time so I put an Iomega 
USB3 card in, and connected the enclosure to it.  Things went a LOT 
faster, but after a few hours the problems began.  With USB3/XHCI at 
first I was getting "xhci_do_command: command timeout", the devices 
would be lost (disconnect/disappear).  I removed the USB3 card, compiled 
XHCI out of the kernel and reverted back to USB2, but the enclosure 
would no longer work: I get SCSI read/write errors (again, as if the 
drives disappeared).  I'm attaching the ending of the dmesg log 
(hw.usb.umass.debug=-1).  I have the whole log, starting at boot, but 
it's 800kb long.

This happens with two USB ports (I haven't tested all of them), and at 
least one of the ports works fine with other umass device.  (I suspect 
the ports themselves are ok.)

A dump of raw 1MB from /dev/da0p1 (using dd) works fine, but the problem 
appears almost immediately after "zpool status".

Does anyone have any ideas as to what is happening?  The computer works 
fine otherwise.  I could provide more information if needed.

Thanks,
-Krzysztof


umass0:umass_t_bbb_data_write_callback: max_bulk=131072, data_rem=65536
umass0:umass_t_bbb_data_write_callback: max_bulk=131072, data_rem=0
umass0:umass_transfer_start: transfer index = 8
umass0:umass_bbb_dump_csw: CSW 1352: sig = 0x53425355 (valid), tag = 
0x00000548, res = 0, status = 0x00 (good)
umass0:umass_cam_action: 5:0:0:XPT_SCSI_IO: cmd: 0x28, flags: 0x40, 10b 
cmd/65536b data/252b sense
umass0:umass_bbb_dump_cbw: CBW 1353: cmd = 10b (0x28008708d465...), data 
= 65536b, lun = 0, dir = in
umass0:umass_transfer_start: transfer index = 4
umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=65536
umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=0
umass0:umass_transfer_start: transfer index = 8
umass0:umass_bbb_dump_csw: CSW 1353: sig = 0x53425355 (valid), tag = 
0x00000549, res = 0, status = 0x00 (good)
umass0:umass_cam_action: 5:0:1:XPT_SCSI_IO: cmd: 0x2a, flags: 0x80, 10b 
cmd/65536b data/252b sense
umass0:umass_dump_buffer: 0x 9d756ba95c94e1a7f42b8263e2ee6cf0 
buffer=0xc00000002157e000, buflen=655369d756ba95c94e1a7f42b8263e2ee6cf0
umass0:umass_dump_buffer: 0x 42b01146acb6fa4465bde50c811b044b
umass0:umass_dump_buffer: 0x e92808a22527f170a371c776963aebf0 ...
umass0:umass_bbb_dump_cbw: CBW 1354: cmd = 10b (0x2a208708d34d...), data 
= 65536b, lun = 1, dir = out
umass0:umass_transfer_start: transfer index = 6
umass0:umass_t_bbb_data_write_callback: max_bulk=131072, data_rem=65536
umass0:umass_t_bbb_data_write_callback: max_bulk=131072, data_rem=0
umass0:umass_transfer_start: transfer index = 8
umass0:umass_bbb_dump_csw: CSW 1354: sig = 0x53425355 (valid), tag = 
0x0000054a, res = 0, status = 0x00 (good)
umass0:umass_cam_action: 5:0:0:XPT_SCSI_IO: cmd: 0x28, flags: 0x40, 10b 
cmd/65536b data/252b sense
umass0:umass_bbb_dump_cbw: CBW 1355: cmd = 10b (0x28008708d4e5...), data 
= 65536b, lun = 0, dir = in
umass0:umass_transfer_start: transfer index = 4
umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=65536
umass0:umass_transfer_start: transfer index = 5
umass0:umass_transfer_start: transfer index = 8
umass0:umass_bbb_dump_csw: CSW 1355: sig = 0x53425355 (valid), tag = 
0x0000054b, res = 32768, status = 0x01 (failed)
umass0:umass_t_bbb_status_callback: Command failed, residue = 32768
umass0:umass_cam_cb: Fetching 252 bytes of sense data
umass0:umass_bbb_dump_cbw: CBW 1356: cmd = 6b (0x03000000fc00), data = 
252b, lun = 0, dir = in
umass0:umass_transfer_start: transfer index = 4
umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=252
umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=0
umass0:umass_transfer_start: transfer index = 8
umass0:umass_t_bbb_status_callback: Failed to read CSW: USB_ERR_STALLED, 
try 0
umass0:umass_transfer_start: transfer index = 5
umass0:umass_transfer_start: transfer index = 8
umass0:umass_bbb_dump_csw: CSW 1356: sig = 0x53425355 (valid), tag = 
0x0000054c, res = 234, status = 0x00 (good)
(da0:umass-sim0:0:0:0): READ(10). CDB: 28 0 87 8 d4 e5 0 0 80 0
(da0:umass-sim0:0:0:0): CAM status: SCSI Status Error
(da0:umass-sim0:0:0:0): SCSI status: Check Condition
(da0:umass-sim0:0:0:0): SCSI sense: ABORTED COMMAND asc:0,0 (No 
additional sense information)
(da0:umass-sim0:0:0:0): Retrying command (per sense data)
umass0:umass_cam_action: 5:0:0:XPT_SCSI_IO: cmd: 0x28, flags: 0x40, 10b 
cmd/65536b data/252b sense
umass0:umass_bbb_dump_cbw: CBW 1357: cmd = 10b (0x28008708d4e5...), data 
= 65536b, lun = 0, dir = in
umass0:umass_transfer_start: transfer index = 4
umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=65536
umass0:umass_transfer_start: transfer index = 5
umass0:umass_transfer_start: transfer index = 8
umass0:umass_bbb_dump_csw: CSW 1357: sig = 0x53425355 (valid), tag = 
0x0000054d, res = 32768, status = 0x01 (failed)