usb/110855: ugen: interrupt in msgs are truncated when buffer is full

Wed Mar 28 18:27:26 UTC 2007

Hans Petter Selasky schrieb:
> <ZAP>
> 
> Can you revert the changes you made to "umass.c" ?
> 
> You can do this for example by copying "sys/dev/usb/umass.c" from the SVN repo 
> to where you have your kernel sources.
> 
> Then edit "sys/dev/usb/umass.c" again.
> 
> Lookup the function "umass_t_bbb_status_callback()".
> 
> Right below the label "tr_transferred" you add like this:
> 
> tr_transferred:
> 	/* don't retry the status, but do a full reset if 
> 	 * there is something wrong with the CSW:
> 	 */
> 	sc->sc_status_try = 1; 
> 
> Compile a new kernel (or if you are smart, leave "device umass" out of the 
> kernel config file and just recompile the "umass" module: sys/modules/umass)
> 
> What happens now?
> 
> --HPS
> 

Mmmm, seems like I must have messed something up before. So I reapplied
the changes to a clean system. The first stick says now. The !!!! mark
the point where the hanging occurs.

Changes:
tr_transferred:
	/* don't retry the status, but do a full reset if
	 * there is something wrong with the CSW:
	 */
	sc->sc_status_try = 1;
Result:

> umass0: <JetFlash Mass Storage Device, class 0/0, rev 2.00/1.41, addr 126>
> umass0:  SCSI over Bulk-Only; quirks = 0x0000
> umass0: Get Max Lun not supported (USBD_STALLED)
> umass0:umass_cam_action: 0:-1:-1:XPT_PATH_INQ:.
> umass0:0:0:-1: Attached to scbus0
> umass0:umass_cam_rescan: scbus0: scanning for 0:0:-1
> umass0:umass_cam_action: 0:-1:-1:XPT_PATH_INQ:.
> umass0:umass_cam_action: 0:0:0:XPT_PATH_INQ:.
> umass0:umass_cam_action: 0:0:0:XPT_PATH_INQ:.
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x12, flags: 0x40, 6b cmd/36b data/18b sense
> umass0:umass_bbb_dump_cbw: CBW 1: cmd = 6b (0x120000002400), data = 36b, lun = 0, dir = in
> umass0:umass_attach: Attach finishedumass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=36
> 
> 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 274: sig = 0x28120799 (invalid), tag = 274, res = 134217728, status = 0x8f (<invalid>)
> umass0:umass_t_bbb_status_callback: truncating residue from 134217728 to 36 bytes
> umass0:umass_t_bbb_status_callback: bad CSW signature 0x28120799 != 0x53425355
> umass0:umass_t_bbb_status_callback: Failed to read CSW: USBD_NORMAL_COMPLETION, try 1
> umass0:umass_tr_error: transfer error, USBD_NORMAL_COMPLETION -> reset
> umass0:umass_transfer_start: transfer index = 0
> umass0:umass_t_bbb_reset1_callback: BBB reset!
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x12, flags: 0x40, 6b cmd/36b data/18b sense
> umass0:umass_transfer_start: transfer index = 1
> umass0:umass_transfer_start: transfer index = 2
> umass0:umass_transfer_start: transfer index = 3
> umass0:umass_bbb_dump_cbw: CBW 2: cmd = 6b (0x120000002400), data = 36b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=36
!!!!! It hangs here for several seconds
> umass0:umass_transfer_start: transfer index = 5
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_t_bbb_status_callback: Failed to read CSW: USBD_TIMEOUT, try 0
> umass0:umass_transfer_start: transfer index = 5
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_t_bbb_status_callback: Failed to read CSW: USBD_TIMEOUT, try 1
> umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
> umass0:umass_transfer_start: transfer index = 0
> umass0:umass_t_bbb_reset1_callback: BBB reset!
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x12, flags: 0x40, 6b cmd/36b data/18b sense
> umass0:umass_transfer_start: transfer index = 1
> umass0:umass_transfer_start: transfer index = 2
> umass0:umass_transfer_start: transfer index = 3
> umass0:umass_bbb_dump_cbw: CBW 3: cmd = 6b (0x120000002400), data = 36b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=36
> 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 3: sig = 0x53425355 (valid), tag = 3, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x12, flags: 0x40, 6b cmd/255b data/18b sense
> umass0:umass_bbb_dump_cbw: CBW 4: cmd = 6b (0x12018000ff00), data = 255b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=255
> 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 4: sig = 0x53425355 (valid), tag = 4, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_GET_TRAN_SETTINGS:.
> umass0:umass_cam_action: 0:0:0:XPT_PATH_INQ:.
> umass0:umass_cam_action: 0:0:0:XPT_GET_TRAN_SETTINGS:.
> umass0:umass_cam_action: 0:0:0:XPT_SET_TRAN_SETTINGS:.
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x00, flags: 0xc0, 6b cmd/0b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 5: cmd = 6b (0x000000000000), data = 0b, lun = 0, dir = out
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_bbb_dump_csw: CSW 5: sig = 0x53425355 (valid), tag = 5, res = 0, status = 0x01 (failed)
> umass0:umass_t_bbb_status_callback: Command failed, residue = 0
> umass0:umass_cam_cb: Fetching 32 bytes of sense data
> umass0:umass_bbb_dump_cbw: CBW 6: cmd = 6b (0x030000002000), data = 32b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=32
> 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 6: sig = 0x53425355 (valid), tag = 6, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_PATH_INQ:.
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x25, flags: 0x40, 10b cmd/8b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 7: cmd = 10b (0x250000000000...), data = 8b, lun = 0, dir = in
> umassX:umass_cam_rescan_callback: xptumass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=8
> 0: Rescan suumass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=0
> umass0:umass_transfer_start: transfer index = 8
> cceededumass0:umass_bbb_dump_csw: CSW 7: sig = 0x53425355 (valid), tag = 7, res = 0, status = 0x00 (good)
> 
> da0 at umass-sim0 bus 0 target 0 lun 0
> da0: <JetFlash TS512MJFV30 8.07> Removable Direct Access SCSI-2 device 
> umass0:umass_cam_action: 0:0:0:XPT_GET_TRAN_SETTINGS:.
> umass0:umass_cam_action: 0:0:0:XPT_PATH_INQ:.
> da0: 40.000MB/s transfers
> da0: 484MB (991232 512 byte sectors: 64H 32S/T 484C)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x25, flags: 0x40, 10b cmd/8b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 8: cmd = 10b (0x250000000000...), data = 8b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=8
> 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 8: sig = 0x53425355 (valid), tag = 8, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x1e, flags: 0xc0, 6b cmd/0b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 9: cmd = 6b (0x1e0000000100), data = 0b, lun = 0, dir = out
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_bbb_dump_csw: CSW 9: sig = 0x53425355 (valid), tag = 9, res = 0, status = 0x01 (failed)
> umass0:umass_t_bbb_status_callback: Command failed, residue = 0
> umass0:umass_cam_cb: Fetching 32 bytes of sense data
> umass0:umass_bbb_dump_cbw: CBW 10: cmd = 6b (0x030000002000), data = 32b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=32
> 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 10: sig = 0x53425355 (valid), tag = 10, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x28, flags: 0x40, 10b cmd/512b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 11: cmd = 10b (0x280000000000...), data = 512b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=512
> 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 11: sig = 0x53425355 (valid), tag = 11, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x35, flags: 0xc0, 10b cmd/0b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 12: cmd = 10b (0x350000000000...), data = 0b, lun = 0, dir = out
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_bbb_dump_csw: CSW 12: sig = 0x53425355 (valid), tag = 12, res = 0, status = 0x01 (failed)
> umass0:umass_t_bbb_status_callback: Command failed, residue = 0
> umass0:umass_cam_cb: Fetching 32 bytes of sense data
> umass0:umass_bbb_dump_cbw: CBW 13: cmd = 6b (0x030000002000), data = 32b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=32
> 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 13: sig = 0x53425355 (valid), tag = 13, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x1e, flags: 0xc0, 6b cmd/0b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 14: cmd = 6b (0x1e0000000000), data = 0b, lun = 0, dir = out
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_bbb_dump_csw: CSW 14: sig = 0x53425355 (valid), tag = 14, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x25, flags: 0x40, 10b cmd/8b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 15: cmd = 10b (0x250000000000...), data = 8b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=8
> 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 15: sig = 0x53425355 (valid), tag = 15, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x1e, flags: 0xc0, 6b cmd/0b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 16: cmd = 6b (0x1e0000000100), data = 0b, lun = 0, dir = out
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_bbb_dump_csw: CSW 16: sig = 0x53425355 (valid), tag = 16, res = 0, status = 0x01 (failed)
> umass0:umass_t_bbb_status_callback: Command failed, residue = 0
> umass0:umass_cam_cb: Fetching 32 bytes of sense data
> umass0:umass_bbb_dump_cbw: CBW 17: cmd = 6b (0x030000002000), data = 32b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=32
> 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 17: sig = 0x53425355 (valid), tag = 17, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x28, flags: 0x40, 10b cmd/512b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 18: cmd = 10b (0x280000000001...), data = 512b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=512
> 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 18: sig = 0x53425355 (valid), tag = 18, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x28, flags: 0x40, 10b cmd/512b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 19: cmd = 10b (0x280000000000...), data = 512b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=512
> 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 19: sig = 0x53425355 (valid), tag = 19, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x35, flags: 0xc0, 10b cmd/0b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 20: cmd = 10b (0x350000000000...), data = 0b, lun = 0, dir = out
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_bbb_dump_csw: CSW 20: sig = 0x53425355 (valid), tag = 20, res = 0, status = 0x01 (failed)
> umass0:umass_t_bbb_status_callback: Command failed, residue = 0
> umass0:umass_cam_cb: Fetching 32 bytes of sense data
> umass0:umass_bbb_dump_cbw: CBW 21: cmd = 6b (0x030000002000), data = 32b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=32
> 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 21: sig = 0x53425355 (valid), tag = 21, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x1e, flags: 0xc0, 6b cmd/0b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 22: cmd = 6b (0x1e0000000000), data = 0b, lun = 0, dir = out
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_bbb_dump_csw: CSW 22: sig = 0x53425355 (valid), tag = 22, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x25, flags: 0x40, 10b cmd/8b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 23: cmd = 10b (0x250000000000...), data = 8b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=8
> 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 23: sig = 0x53425355 (valid), tag = 23, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x1e, flags: 0xc0, 6b cmd/0b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 24: cmd = 6b (0x1e0000000100), data = 0b, lun = 0, dir = out
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_bbb_dump_csw: CSW 24: sig = 0x53425355 (valid), tag = 24, res = 0, status = 0x01 (failed)
> umass0:umass_t_bbb_status_callback: Command failed, residue = 0
> umass0:umass_cam_cb: Fetching 32 bytes of sense data
> umass0:umass_bbb_dump_cbw: CBW 25: cmd = 6b (0x030000002000), data = 32b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=32
> 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 25: sig = 0x53425355 (valid), tag = 25, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x35, flags: 0xc0, 10b cmd/0b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 26: cmd = 10b (0x350000000000...), data = 0b, lun = 0, dir = out
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_bbb_dump_csw: CSW 26: sig = 0x53425355 (valid), tag = 26, res = 0, status = 0x01 (failed)
> umass0:umass_t_bbb_status_callback: Command failed, residue = 0
> umass0:umass_cam_cb: Fetching 32 bytes of sense data
> umass0:umass_bbb_dump_cbw: CBW 27: cmd = 6b (0x030000002000), data = 32b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=32
> 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 27: sig = 0x53425355 (valid), tag = 27, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x1e, flags: 0xc0, 6b cmd/0b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 28: cmd = 6b (0x1e0000000000), data = 0b, lun = 0, dir = out
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_bbb_dump_csw: CSW 28: sig = 0x53425355 (valid), tag = 28, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x25, flags: 0x40, 10b cmd/8b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 29: cmd = 10b (0x250000000000...), data = 8b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=8
> 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 29: sig = 0x53425355 (valid), tag = 29, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x1e, flags: 0xc0, 6b cmd/0b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 30: cmd = 6b (0x1e0000000100), data = 0b, lun = 0, dir = out
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_bbb_dump_csw: CSW 30: sig = 0x53425355 (valid), tag = 30, res = 0, status = 0x01 (failed)
> umass0:umass_t_bbb_status_callback: Command failed, residue = 0
> umass0:umass_cam_cb: Fetching 32 bytes of sense data
> umass0:umass_bbb_dump_cbw: CBW 31: cmd = 6b (0x030000002000), data = 32b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=32
> 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 31: sig = 0x53425355 (valid), tag = 31, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x35, flags: 0xc0, 10b cmd/0b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 32: cmd = 10b (0x350000000000...), data = 0b, lun = 0, dir = out
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_bbb_dump_csw: CSW 32: sig = 0x53425355 (valid), tag = 32, res = 0, status = 0x01 (failed)
> umass0:umass_t_bbb_status_callback: Command failed, residue = 0
> umass0:umass_cam_cb: Fetching 32 bytes of sense data
> umass0:umass_bbb_dump_cbw: CBW 33: cmd = 6b (0x030000002000), data = 32b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=32
> 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 33: sig = 0x53425355 (valid), tag = 33, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x1e, flags: 0xc0, 6b cmd/0b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 34: cmd = 6b (0x1e0000000000), data = 0b, lun = 0, dir = out
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_bbb_dump_csw: CSW 34: sig = 0x53425355 (valid), tag = 34, res = 0, status = 0x00 (good)

Changes:
usbd_delay_ms(uaa->device, 1000);
-->  usbd_delay_ms(uaa->device, 5000)

sc->sc_last_xfer_index = UMASS_T_BBB_COMMAND;
 --> sc->sc_last_xfer_index = UMASS_T_BBB_RESET2;

Result:
> 
> umass0: detached
> umass0: <JetFlash Mass Storage Device, class 0/0, rev 2.00/1.41, addr 126>
> umass0:  SCSI over Bulk-Only; quirks = 0x0000
> umass0: Get Max Lun not supported (USBD_STALLED)
> umass0:umass_cam_action: 0:-1:-1:XPT_PATH_INQ:.
> umass0:0:0:-1: Attached to scbus0
> umass0:umass_cam_rescan: scbus0: scanning for 0:0:-1
> umass0:umass_cam_action: 0:-1:-1:XPT_PATH_INQ:.
> umass0:umass_cam_action: 0:0:0:XPT_PATH_INQ:.
> umass0:umass_cam_action: 0:0:0:XPT_PATH_INQ:.
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x12, flags: 0x40, 6b cmd/36b data/18b sense
> umass0:umass_attach: Attach finishedumass0:umass_transfer_start: transfer index = 2
> 
> umass0:umass_transfer_start: transfer index = 3
> umass0:umass_bbb_dump_cbw: CBW 1: cmd = 6b (0x120000002400), data = 36b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=36
> 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 274: sig = 0x28120799 (invalid), tag = 274, res = 134217728, status = 0x8f (<invalid>)
> umass0:umass_t_bbb_status_callback: truncating residue from 134217728 to 36 bytes
> umass0:umass_t_bbb_status_callback: bad CSW signature 0x28120799 != 0x53425355
> umass0:umass_t_bbb_status_callback: Failed to read CSW: USBD_NORMAL_COMPLETION, try 0
> umass0:umass_transfer_start: transfer index = 5
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_t_bbb_status_callback: Failed to read CSW: USBD_TIMEOUT, try 1
> umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
> umass0:umass_transfer_start: transfer index = 0
> umass0:umass_t_bbb_reset1_callback: BBB reset!
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x12, flags: 0x40, 6b cmd/36b data/18b sense
> umass0:umass_transfer_start: transfer index = 1
> umass0:umass_transfer_start: transfer index = 2
> umass0:umass_transfer_start: transfer index = 3
> umass0:umass_bbb_dump_cbw: CBW 2: cmd = 6b (0x120000002400), data = 36b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=36
!!!!! It hangs here for several seconds
> umass0:umass_transfer_start: transfer index = 5
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_t_bbb_status_callback: Failed to read CSW: USBD_TIMEOUT, try 0
> umass0:umass_transfer_start: transfer index = 5
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_t_bbb_status_callback: Failed to read CSW: USBD_TIMEOUT, try 1
> umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
> umass0:umass_transfer_start: transfer index = 0
> umass0:umass_t_bbb_reset1_callback: BBB reset!
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x12, flags: 0x40, 6b cmd/36b data/18b sense
> umass0:umass_transfer_start: transfer index = 1
> umass0:umass_transfer_start: transfer index = 2
> umass0:umass_transfer_start: transfer index = 3
> umass0:umass_bbb_dump_cbw: CBW 3: cmd = 6b (0x120000002400), data = 36b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=36
> 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 3: sig = 0x53425355 (valid), tag = 3, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x12, flags: 0x40, 6b cmd/255b data/18b sense
> umass0:umass_bbb_dump_cbw: CBW 4: cmd = 6b (0x12018000ff00), data = 255b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=255
> 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 4: sig = 0x53425355 (valid), tag = 4, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_GET_TRAN_SETTINGS:.
> umass0:umass_cam_action: 0:0:0:XPT_PATH_INQ:.
> umass0:umass_cam_action: 0:0:0:XPT_GET_TRAN_SETTINGS:.
> umass0:umass_cam_action: 0:0:0:XPT_SET_TRAN_SETTINGS:.
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x00, flags: 0xc0, 6b cmd/0b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 5: cmd = 6b (0x000000000000), data = 0b, lun = 0, dir = out
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_bbb_dump_csw: CSW 5: sig = 0x53425355 (valid), tag = 5, res = 0, status = 0x01 (failed)
> umass0:umass_t_bbb_status_callback: Command failed, residue = 0
> umass0:umass_cam_cb: Fetching 32 bytes of sense data
> umass0:umass_bbb_dump_cbw: CBW 6: cmd = 6b (0x030000002000), data = 32b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=32
> 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 6: sig = 0x53425355 (valid), tag = 6, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_PATH_INQ:.
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x25, flags: 0x40, 10b cmd/8b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 7: cmd = 10b (0x250000000000...), data = 8b, lun = 0, dir = in
> umassX:umass_cam_rescan_callback:umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=8
>  xpt0: Rescan suumass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=0
> umass0:umass_transfer_start: transfer index = 8
> cceededumass0:umass_bbb_dump_csw: CSW 7: sig = 0x53425355 (valid), tag = 7, res = 0, status = 0x00 (good)
> 
> da0 at umass-sim0 bus 0 target 0 lun 0
> da0: <JetFlash TS512MJFV30 8.07> Removable Direct Access SCSI-2 device 
> umass0:umass_cam_action: 0:0:0:XPT_GET_TRAN_SETTINGS:.
> umass0:umass_cam_action: 0:0:0:XPT_PATH_INQ:.
> da0: 40.000MB/s transfers
> da0: 484MB (991232 512 byte sectors: 64H 32S/T 484C)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x25, flags: 0x40, 10b cmd/8b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 8: cmd = 10b (0x250000000000...), data = 8b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=8
> 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 8: sig = 0x53425355 (valid), tag = 8, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x1e, flags: 0xc0, 6b cmd/0b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 9: cmd = 6b (0x1e0000000100), data = 0b, lun = 0, dir = out
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_bbb_dump_csw: CSW 9: sig = 0x53425355 (valid), tag = 9, res = 0, status = 0x01 (failed)
> umass0:umass_t_bbb_status_callback: Command failed, residue = 0
> umass0:umass_cam_cb: Fetching 32 bytes of sense data
> umass0:umass_bbb_dump_cbw: CBW 10: cmd = 6b (0x030000002000), data = 32b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=32
> 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 10: sig = 0x53425355 (valid), tag = 10, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x28, flags: 0x40, 10b cmd/512b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 11: cmd = 10b (0x280000000000...), data = 512b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=512
> 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 11: sig = 0x53425355 (valid), tag = 11, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x35, flags: 0xc0, 10b cmd/0b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 12: cmd = 10b (0x350000000000...), data = 0b, lun = 0, dir = out
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_bbb_dump_csw: CSW 12: sig = 0x53425355 (valid), tag = 12, res = 0, status = 0x01 (failed)
> umass0:umass_t_bbb_status_callback: Command failed, residue = 0
> umass0:umass_cam_cb: Fetching 32 bytes of sense data
> umass0:umass_bbb_dump_cbw: CBW 13: cmd = 6b (0x030000002000), data = 32b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=32
> 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 13: sig = 0x53425355 (valid), tag = 13, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x1e, flags: 0xc0, 6b cmd/0b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 14: cmd = 6b (0x1e0000000000), data = 0b, lun = 0, dir = out
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_bbb_dump_csw: CSW 14: sig = 0x53425355 (valid), tag = 14, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x25, flags: 0x40, 10b cmd/8b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 15: cmd = 10b (0x250000000000...), data = 8b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=8
> 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 15: sig = 0x53425355 (valid), tag = 15, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x1e, flags: 0xc0, 6b cmd/0b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 16: cmd = 6b (0x1e0000000100), data = 0b, lun = 0, dir = out
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_bbb_dump_csw: CSW 16: sig = 0x53425355 (valid), tag = 16, res = 0, status = 0x01 (failed)
> umass0:umass_t_bbb_status_callback: Command failed, residue = 0
> umass0:umass_cam_cb: Fetching 32 bytes of sense data
> umass0:umass_bbb_dump_cbw: CBW 17: cmd = 6b (0x030000002000), data = 32b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=32
> 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 17: sig = 0x53425355 (valid), tag = 17, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x28, flags: 0x40, 10b cmd/512b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 18: cmd = 10b (0x280000000001...), data = 512b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=512
> 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 18: sig = 0x53425355 (valid), tag = 18, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x28, flags: 0x40, 10b cmd/512b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 19: cmd = 10b (0x280000000000...), data = 512b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=512
> 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 19: sig = 0x53425355 (valid), tag = 19, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x35, flags: 0xc0, 10b cmd/0b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 20: cmd = 10b (0x350000000000...), data = 0b, lun = 0, dir = out
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_bbb_dump_csw: CSW 20: sig = 0x53425355 (valid), tag = 20, res = 0, status = 0x01 (failed)
> umass0:umass_t_bbb_status_callback: Command failed, residue = 0
> umass0:umass_cam_cb: Fetching 32 bytes of sense data
> umass0:umass_bbb_dump_cbw: CBW 21: cmd = 6b (0x030000002000), data = 32b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=32
> 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 21: sig = 0x53425355 (valid), tag = 21, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x1e, flags: 0xc0, 6b cmd/0b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 22: cmd = 6b (0x1e0000000000), data = 0b, lun = 0, dir = out
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_bbb_dump_csw: CSW 22: sig = 0x53425355 (valid), tag = 22, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x25, flags: 0x40, 10b cmd/8b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 23: cmd = 10b (0x250000000000...), data = 8b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=8
> 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 23: sig = 0x53425355 (valid), tag = 23, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x1e, flags: 0xc0, 6b cmd/0b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 24: cmd = 6b (0x1e0000000100), data = 0b, lun = 0, dir = out
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_bbb_dump_csw: CSW 24: sig = 0x53425355 (valid), tag = 24, res = 0, status = 0x01 (failed)
> umass0:umass_t_bbb_status_callback: Command failed, residue = 0
> umass0:umass_cam_cb: Fetching 32 bytes of sense data
> umass0:umass_bbb_dump_cbw: CBW 25: cmd = 6b (0x030000002000), data = 32b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=32
> 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 25: sig = 0x53425355 (valid), tag = 25, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x35, flags: 0xc0, 10b cmd/0b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 26: cmd = 10b (0x350000000000...), data = 0b, lun = 0, dir = out
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_bbb_dump_csw: CSW 26: sig = 0x53425355 (valid), tag = 26, res = 0, status = 0x01 (failed)
> umass0:umass_t_bbb_status_callback: Command failed, residue = 0
> umass0:umass_cam_cb: Fetching 32 bytes of sense data
> umass0:umass_bbb_dump_cbw: CBW 27: cmd = 6b (0x030000002000), data = 32b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=32
> 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 27: sig = 0x53425355 (valid), tag = 27, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x1e, flags: 0xc0, 6b cmd/0b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 28: cmd = 6b (0x1e0000000000), data = 0b, lun = 0, dir = out
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_bbb_dump_csw: CSW 28: sig = 0x53425355 (valid), tag = 28, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x25, flags: 0x40, 10b cmd/8b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 29: cmd = 10b (0x250000000000...), data = 8b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=8
> 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 29: sig = 0x53425355 (valid), tag = 29, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x1e, flags: 0xc0, 6b cmd/0b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 30: cmd = 6b (0x1e0000000100), data = 0b, lun = 0, dir = out
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_bbb_dump_csw: CSW 30: sig = 0x53425355 (valid), tag = 30, res = 0, status = 0x01 (failed)
> umass0:umass_t_bbb_status_callback: Command failed, residue = 0
> umass0:umass_cam_cb: Fetching 32 bytes of sense data
> umass0:umass_bbb_dump_cbw: CBW 31: cmd = 6b (0x030000002000), data = 32b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=32
> 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 31: sig = 0x53425355 (valid), tag = 31, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x35, flags: 0xc0, 10b cmd/0b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 32: cmd = 10b (0x350000000000...), data = 0b, lun = 0, dir = out
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_bbb_dump_csw: CSW 32: sig = 0x53425355 (valid), tag = 32, res = 0, status = 0x01 (failed)
> umass0:umass_t_bbb_status_callback: Command failed, residue = 0
> umass0:umass_cam_cb: Fetching 32 bytes of sense data
> umass0:umass_bbb_dump_cbw: CBW 33: cmd = 6b (0x030000002000), data = 32b, lun = 0, dir = in
> umass0:umass_transfer_start: transfer index = 4
> umass0:umass_t_bbb_data_read_callback: max_bulk=131072, data_rem=32
> 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 33: sig = 0x53425355 (valid), tag = 33, res = 0, status = 0x00 (good)
> umass0:umass_cam_action: 0:0:0:XPT_SCSI_IO: cmd: 0x1e, flags: 0xc0, 6b cmd/0b data/32b sense
> umass0:umass_bbb_dump_cbw: CBW 34: cmd = 6b (0x1e0000000000), data = 0b, lun = 0, dir = out
> umass0:umass_transfer_start: transfer index = 8
> umass0:umass_bbb_dump_csw: CSW 34: sig = 0x53425355 (valid), tag = 34, res = 0, status = 0x00 (good)

Thank you for your time. Let me know if you want me to try other
changes. May be it would be easier if you could create a branch in svn
with the changes needed?

-- 
Regards,

Markus Henschel
Development

BALLY WULFF Automaten GmbH
Maybachufer 48-51
12045 Berlin
Phone:  +49(30)62002 161
FAX:    +49(30)62002 230
http://www.ballywulff.de