umass0: BBB reset failed, TIMEOUT (again)

Juergen Lock nox at jelal.kn-bremen.de
Thu Sep 21 15:15:07 PDT 2006 

On Wed, Sep 20, 2006 at 11:18:32AM +0200, Hans Petter Selasky wrote:
> On Wednesday 20 September 2006 03:11, Juergen Lock wrote:
> > Today for the first time since this box got a new board I tried to
> > copy data onto the usb cardreader, and after copying for a while it
> > suddenly stopped (led stopped flashing, no further io), and after
> > some time i had the above in dmesg.  And that was it, cp process
> > hung, no way to kill it.  Unplugged the thing, and got the expected
> > panic: vinvalbuf: dirty bufs.  Tried the same thing from linux (after
> > dosfsck), and there copying stopped for a while too, but it then
> > continued and finished.  Is this is some kind of new hardware quirk of
> > the new board's ehci controller, that linux recovers from?  (via,
> > there already is a `dropped interrupt' fix for it, which helped with
> > my last board...)  I also tried building a RELENG_6 kernel (one
> > of the PRs I looked at also suggested this), but it behaved the same.
> > Just in case, I took a dump of that too, but I don't really know for
> > what to look in there so you'd have to tell me...
> >
> 
> Could you have tried my new USB driver and see if the problem is the same?
> 
> #
> # First get all the sources
> # (you need /usr/ports/devel/subversion installed)
> #
> 
> svn --username anonsvn --password anonsvn \
>       checkout svn://svn.turbocat.net/i4b
> 
> #
> # The following commands will
> # install the driver on FreeBSD:
> #
> 
> cd i4b/trunk/i4b/FreeBSD.usb
> make S=../src package
> make install
> 
> #
> # Then build a new kernel (with modules).
> #
> 
> When the device hangs, turn on USB debugging:
> 
> sysctl hw.usb.umass.debug=-1

Ok.  This time writing worked, but reading back to verify (cmp) seemed
to hang.  Did the sysctl (see below), then a while later I got an IO error.
Tried to umount, got another IO error, tried umount -f, got a panic
(probably expected.)  I have now installed mtools and won't mount umass
devices on this box anymore... :/  (Btw when I later tried to mcopy the
file off the thing using the original kernel I noticed the led was off
after it hung, dunno if that also was the case when I tried it with the
new code but I would suspect so.  At least this time, since it wasnt
mounted, I could unplug it without getting a panic...)

 Oh, one thing that occured to me: Even when you may be able to get
around (what appars to be) hardware quirks like this by retrying IO
or resetting the device, that probably wont work when you have an
umass tape drive (sa), since with tape you can't just retry a read/write,
and resetting it may even rewind, with the next write erasing everything
on the tape.  Just a thought...

 Anyway, here's the syslog of the `experiment', beginning after the sysctl:

Sep 21 21:41:21 saturn kernel: (da2:umass-sim0:0:0:2): Request completed with CAM_REQ_CMP_ERR
Sep 21 21:41:21 saturn kernel: (da2:umass-sim0:0:0:2): Retrying Command
Sep 21 21:41:26 saturn kernel: (da2:umass-sim0:0:0:2): Request completed with CAM_REQ_CMP_ERR
Sep 21 21:41:26 saturn kernel: (da2:umass-sim0:0:0:2): Retrying Command
Sep 21 21:41:31 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:41:31 saturn kernel: umass0:umass_transfer_start: transfer index = 0
Sep 21 21:41:31 saturn kernel: (da2:umass-sim0:0:0:2): Request completed with CAM_REQ_CMP_ERR
Sep 21 21:41:31 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:41:31 saturn kernel: umass0:umass_cam_action: 4:0:2:XPT_SCSI_IO: cmd: 0x28, flags: 0x40, 10b cmd/16384b data/32b sense
Sep 21 21:41:31 saturn kernel: (da2:umass-sim0:0:0:2): Retrying Command
Sep 21 21:41:36 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:41:36 saturn kernel: umass0:umass_transfer_start: transfer index = 0
Sep 21 21:41:36 saturn kernel: (da2:umass-sim0:0:0:2): Request completed with CAM_REQ_CMP_ERR
Sep 21 21:41:36 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:41:36 saturn kernel: umass0:umass_cam_action: 4:0:2:XPT_SCSI_IO: cmd: 0x28, flags: 0x40, 10b cmd/16384b data/32b sense
Sep 21 21:41:36 saturn kernel: (da2:umass-sim0:0:0:2): Retrying Command
Sep 21 21:41:41 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:41:41 saturn kernel: umass0:umass_transfer_start: transfer index = 0
Sep 21 21:41:41 saturn kernel: (da2:umass-sim0:0:0:2): Request completed with CAM_REQ_CMP_ERR
Sep 21 21:41:41 saturn kernel: (da2:umass-sim0:0:0:2): error 5
Sep 21 21:41:41 saturn kernel: (da2:umass-sim0:0:0:2): Retries Exausted
Sep 21 21:41:41 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:41:41 saturn kernel: g_vfs_done():da2s1[READ(offset=616749568, length=16384)]error = 5
Sep 21 21:41:41 saturn kernel: vnode_pager_getpages: I/O read error
Sep 21 21:41:41 saturn kernel: vm_fault: pager read error, pid 1047 (cmp)
Sep 21 21:41:46 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:41:46 saturn kernel: umass0:umass_transfer_start: transfer index = 0
Sep 21 21:41:46 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:41:51 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:41:51 saturn kernel: umass0:umass_transfer_start: transfer index = 0
Sep 21 21:41:51 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:41:56 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:41:56 saturn kernel: umass0:umass_transfer_start: transfer index = 0
Sep 21 21:41:56 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:42:01 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:42:01 saturn kernel: umass0:umass_transfer_start: transfer index = 0
Sep 21 21:42:01 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:42:05 saturn kernel: umass0:umass_cam_action: 4:0:2:XPT_SCSI_IO: cmd: 0x2a, flags: 0x80, 10b cmd/4096b data/32b sense
Sep 21 21:42:05 saturn kernel: umass0:umass_dump_buffer: 0x f8ffffff000000000000000000000000 buffer=0xd9237200, buflen=4096
Sep 21 21:42:05 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000
Sep 21 21:42:05 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000 ...
Sep 21 21:42:06 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:42:06 saturn kernel: umass0:umass_transfer_start: transfer index = 0
Sep 21 21:42:06 saturn kernel: (da2:umass-sim0:0:0:2): Request completed with CAM_REQ_CMP_ERR
Sep 21 21:42:06 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:42:06 saturn kernel: umass0:umass_cam_action: 4:0:2:XPT_SCSI_IO: cmd: 0x2a, flags: 0x80, 10b cmd/4096b data/32b sense
Sep 21 21:42:06 saturn kernel: umass0:umass_dump_buffer: 0x f8ffffff000000000000000000000000 buffer=0xd9237200, buflen=4096
Sep 21 21:42:06 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000
Sep 21 21:42:06 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000 ...
Sep 21 21:42:06 saturn kernel: (da2:umass-sim0:0:0:2): Retrying Command
Sep 21 21:42:11 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:42:11 saturn kernel: umass0:umass_transfer_start: transfer index = 0
Sep 21 21:42:11 saturn kernel: (da2:umass-sim0:0:0:2): Request completed with CAM_REQ_CMP_ERR
Sep 21 21:42:11 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:42:11 saturn kernel: umass0:umass_cam_action: 4:0:2:XPT_SCSI_IO: cmd: 0x2a, flags: 0x80, 10b cmd/4096b data/32b sense
Sep 21 21:42:11 saturn kernel: umass0:umass_dump_buffer: 0x f8ffffff000000000000000000000000 buffer=0xd9237200, buflen=4096
Sep 21 21:42:11 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000
Sep 21 21:42:11 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000 ...
Sep 21 21:42:11 saturn kernel: (da2:umass-sim0:0:0:2): Retrying Command
Sep 21 21:42:16 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:42:16 saturn kernel: umass0:umass_transfer_start: transfer index = 0
Sep 21 21:42:16 saturn kernel: (da2:umass-sim0:0:0:2): Request completed with CAM_REQ_CMP_ERR
Sep 21 21:42:16 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:42:16 saturn kernel: umass0:umass_cam_action: 4:0:2:XPT_SCSI_IO: cmd: 0x2a, flags: 0x80, 10b cmd/4096b data/32b sense
Sep 21 21:42:16 saturn kernel: umass0:umass_dump_buffer: 0x f8ffffff000000000000000000000000 buffer=0xd9237200, buflen=4096
Sep 21 21:42:16 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000
Sep 21 21:42:16 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000 ...
Sep 21 21:42:16 saturn kernel: (da2:umass-sim0:0:0:2): Retrying Command
Sep 21 21:42:21 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:42:21 saturn kernel: umass0:umass_transfer_start: transfer index = 0
Sep 21 21:42:21 saturn kernel: (da2:umass-sim0:0:0:2): Request completed with CAM_REQ_CMP_ERR
Sep 21 21:42:21 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:42:21 saturn kernel: umass0:umass_cam_action: 4:0:2:XPT_SCSI_IO: cmd: 0x2a, flags: 0x80, 10b cmd/4096b data/32b sense
Sep 21 21:42:21 saturn kernel: umass0:umass_dump_buffer: 0x f8ffffff000000000000000000000000 buffer=0xd9237200, buflen=4096
Sep 21 21:42:21 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000
Sep 21 21:42:21 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000 ...
Sep 21 21:42:21 saturn kernel: (da2:umass-sim0:0:0:2): Retrying Command
Sep 21 21:42:26 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:42:26 saturn kernel: umass0:umass_transfer_start: transfer index = 0
Sep 21 21:42:26 saturn kernel: (da2:umass-sim0:0:0:2): Request completed with CAM_REQ_CMP_ERR
Sep 21 21:42:26 saturn kernel: (da2:umass-sim0:0:0:2): error 5
Sep 21 21:42:26 saturn kernel: (da2:umass-sim0:0:0:2): Retries Exausted
Sep 21 21:42:26 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:42:26 saturn kernel: g_vfs_done():da2s1[WRITE(offset=512, length=4096)]error = 5
Sep 21 21:42:31 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:42:31 saturn kernel: umass0:umass_transfer_start: transfer index = 0
Sep 21 21:42:31 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:42:36 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:42:36 saturn kernel: umass0:umass_transfer_start: transfer index = 0
Sep 21 21:42:36 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:42:41 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:42:41 saturn kernel: umass0: timeout: giving up reset!
Sep 21 21:42:42 saturn kernel: umass0:umass_cam_action: 4:0:2:XPT_SCSI_IO: cmd: 0x2a, flags: 0x80, 10b cmd/4096b data/32b sense
Sep 21 21:42:42 saturn kernel: umass0:umass_dump_buffer: 0x f8ffffff000000000000000000000000 buffer=0xd9237200, buflen=4096
Sep 21 21:42:42 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000
Sep 21 21:42:42 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000 ...
Sep 21 21:42:42 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:42:47 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:42:47 saturn kernel: umass0:umass_transfer_start: transfer index = 0
Sep 21 21:42:47 saturn kernel: (da2:umass-sim0:0:0:2): Request completed with CAM_REQ_CMP_ERR
Sep 21 21:42:47 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:42:47 saturn kernel: umass0:umass_cam_action: 4:0:2:XPT_SCSI_IO: cmd: 0x2a, flags: 0x80, 10b cmd/4096b data/32b sense
Sep 21 21:42:47 saturn kernel: umass0:umass_dump_buffer: 0x f8ffffff000000000000000000000000 buffer=0xd9237200, buflen=4096
Sep 21 21:42:47 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000
Sep 21 21:42:47 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000 ...
Sep 21 21:42:47 saturn kernel: (da2:umass-sim0:0:0:2): Retrying Command
Sep 21 21:42:52 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:42:52 saturn kernel: umass0:umass_transfer_start: transfer index = 0
Sep 21 21:42:52 saturn kernel: (da2:umass-sim0:0:0:2): Request completed with CAM_REQ_CMP_ERR
Sep 21 21:42:52 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:42:52 saturn kernel: umass0:umass_cam_action: 4:0:2:XPT_SCSI_IO: cmd: 0x2a, flags: 0x80, 10b cmd/4096b data/32b sense
Sep 21 21:42:52 saturn kernel: umass0:umass_dump_buffer: 0x f8ffffff000000000000000000000000 buffer=0xd9237200, buflen=4096
Sep 21 21:42:52 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000
Sep 21 21:42:52 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000 ...
Sep 21 21:42:52 saturn kernel: (da2:umass-sim0:0:0:2): Retrying Command
Sep 21 21:42:57 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:42:57 saturn kernel: umass0:umass_transfer_start: transfer index = 0
Sep 21 21:42:57 saturn kernel: (da2:umass-sim0:0:0:2): Request completed with CAM_REQ_CMP_ERR
Sep 21 21:42:57 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:42:57 saturn kernel: umass0:umass_cam_action: 4:0:2:XPT_SCSI_IO: cmd: 0x2a, flags: 0x80, 10b cmd/4096b data/32b sense
Sep 21 21:42:57 saturn kernel: umass0:umass_dump_buffer: 0x f8ffffff000000000000000000000000 buffer=0xd9237200, buflen=4096
Sep 21 21:42:57 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000
Sep 21 21:42:57 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000 ...
Sep 21 21:42:57 saturn kernel: (da2:umass-sim0:0:0:2): Retrying Command
Sep 21 21:43:02 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:43:02 saturn kernel: umass0:umass_transfer_start: transfer index = 0
Sep 21 21:43:02 saturn kernel: (da2:umass-sim0:0:0:2): Request completed with CAM_REQ_CMP_ERR
Sep 21 21:43:02 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:43:02 saturn kernel: umass0:umass_cam_action: 4:0:2:XPT_SCSI_IO: cmd: 0x2a, flags: 0x80, 10b cmd/4096b data/32b sense
Sep 21 21:43:02 saturn kernel: umass0:umass_dump_buffer: 0x f8ffffff000000000000000000000000 buffer=0xd9237200, buflen=4096
Sep 21 21:43:02 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000
Sep 21 21:43:02 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000 ...
Sep 21 21:43:02 saturn kernel: (da2:umass-sim0:0:0:2): Retrying Command
Sep 21 21:43:07 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:43:07 saturn kernel: umass0:umass_transfer_start: transfer index = 0
Sep 21 21:43:07 saturn kernel: (da2:umass-sim0:0:0:2): Request completed with CAM_REQ_CMP_ERR
Sep 21 21:43:07 saturn kernel: (da2:umass-sim0:0:0:2): error 5
Sep 21 21:43:07 saturn kernel: (da2:umass-sim0:0:0:2): Retries Exausted
Sep 21 21:43:07 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:43:07 saturn kernel: g_vfs_done():da2s1[WRITE(offset=512, length=4096)]error = 5
Sep 21 21:43:07 saturn kernel: fsync: giving up on dirty
Sep 21 21:43:07 saturn kernel: 0xc5503660: tag devfs, type VCHR
Sep 21 21:43:07 saturn kernel: usecount 1, writecount 0, refcount 35 mountedhere 0xc5273700
Sep 21 21:43:07 saturn kernel: flags ()
Sep 21 21:43:07 saturn kernel: v_object 0xc549f5ac ref 0 pages 36
Sep 21 21:43:07 saturn kernel: lock type devfs: EXCL (count 1) by thread 0xc5276d80 (pid 1058)
Sep 21 21:43:07 saturn kernel: dev da2s1
Sep 21 21:43:07 saturn kernel: umass0:umass_cam_action: 4:0:2:XPT_SCSI_IO: cmd: 0x2a, flags: 0x80, 10b cmd/4096b data/32b sense
Sep 21 21:43:07 saturn kernel: umass0:umass_dump_buffer: 0x f8ffffff000000000000000000000000 buffer=0xd9237200, buflen=4096
Sep 21 21:43:07 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000
Sep 21 21:43:07 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000 ...
Sep 21 21:43:12 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:43:12 saturn kernel: umass0:umass_transfer_start: transfer index = 0
Sep 21 21:43:12 saturn kernel: (da2:umass-sim0:0:0:2): Request completed with CAM_REQ_CMP_ERR
Sep 21 21:43:12 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:43:12 saturn kernel: umass0:umass_cam_action: 4:0:2:XPT_SCSI_IO: cmd: 0x2a, flags: 0x80, 10b cmd/4096b data/32b sense
Sep 21 21:43:12 saturn kernel: umass0:umass_dump_buffer: 0x f8ffffff000000000000000000000000 buffer=0xd9237200, buflen=4096
Sep 21 21:43:12 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000
Sep 21 21:43:12 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000 ...
Sep 21 21:43:12 saturn kernel: (da2:umass-sim0:0:0:2): Retrying Command
Sep 21 21:43:17 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:43:17 saturn kernel: umass0:umass_transfer_start: transfer index = 0
Sep 21 21:43:17 saturn kernel: (da2:umass-sim0:0:0:2): Request completed with CAM_REQ_CMP_ERR
Sep 21 21:43:17 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:43:17 saturn kernel: umass0:umass_cam_action: 4:0:2:XPT_SCSI_IO: cmd: 0x2a, flags: 0x80, 10b cmd/4096b data/32b sense
Sep 21 21:43:17 saturn kernel: umass0:umass_dump_buffer: 0x f8ffffff000000000000000000000000 buffer=0xd9237200, buflen=4096
Sep 21 21:43:17 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000
Sep 21 21:43:17 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000 ...
Sep 21 21:43:17 saturn kernel: (da2:umass-sim0:0:0:2): Retrying Command
Sep 21 21:43:22 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:43:22 saturn kernel: umass0:umass_transfer_start: transfer index = 0
Sep 21 21:43:22 saturn kernel: (da2:umass-sim0:0:0:2): Request completed with CAM_REQ_CMP_ERR
Sep 21 21:43:22 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:43:22 saturn kernel: umass0:umass_cam_action: 4:0:2:XPT_SCSI_IO: cmd: 0x2a, flags: 0x80, 10b cmd/4096b data/32b sense
Sep 21 21:43:22 saturn kernel: umass0:umass_dump_buffer: 0x f8ffffff000000000000000000000000 buffer=0xd9237200, buflen=4096
Sep 21 21:43:22 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000
Sep 21 21:43:22 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000 ...
Sep 21 21:43:22 saturn kernel: (da2:umass-sim0:0:0:2): Retrying Command
Sep 21 21:43:27 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:43:27 saturn kernel: umass0:umass_transfer_start: transfer index = 0
Sep 21 21:43:27 saturn kernel: (da2:umass-sim0:0:0:2): Request completed with CAM_REQ_CMP_ERR
Sep 21 21:43:27 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:43:27 saturn kernel: umass0:umass_cam_action: 4:0:2:XPT_SCSI_IO: cmd: 0x2a, flags: 0x80, 10b cmd/4096b data/32b sense
Sep 21 21:43:27 saturn kernel: umass0:umass_dump_buffer: 0x f8ffffff000000000000000000000000 buffer=0xd9237200, buflen=4096
Sep 21 21:43:27 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000
Sep 21 21:43:27 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000 ...
Sep 21 21:43:27 saturn kernel: (da2:umass-sim0:0:0:2): Retrying Command
Sep 21 21:43:32 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:43:32 saturn kernel: umass0:umass_transfer_start: transfer index = 0
Sep 21 21:43:32 saturn kernel: (da2:umass-sim0:0:0:2): Request completed with CAM_REQ_CMP_ERR
Sep 21 21:43:32 saturn kernel: (da2:umass-sim0:0:0:2): error 5
Sep 21 21:43:32 saturn kernel: (da2:umass-sim0:0:0:2): Retries Exausted
Sep 21 21:43:32 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:43:32 saturn kernel: g_vfs_done():da2s1[WRITE(offset=512, length=4096)]error = 5
Sep 21 21:43:32 saturn kernel: umass0:umass_cam_action: 4:0:2:XPT_SCSI_IO: cmd: 0x2a, flags: 0x80, 10b cmd/4096b data/32b sense
Sep 21 21:43:32 saturn kernel: umass0:umass_dump_buffer: 0x f8ffffff000000000000000000000000 buffer=0xd9237200, buflen=4096
Sep 21 21:43:32 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000
Sep 21 21:43:32 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000 ...
Sep 21 21:43:37 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:43:37 saturn kernel: umass0:umass_transfer_start: transfer index = 0
Sep 21 21:43:37 saturn kernel: (da2:umass-sim0:0:0:2): Request completed with CAM_REQ_CMP_ERR
Sep 21 21:43:37 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:43:37 saturn kernel: umass0:umass_cam_action: 4:0:2:XPT_SCSI_IO: cmd: 0x2a, flags: 0x80, 10b cmd/4096b data/32b sense
Sep 21 21:43:37 saturn kernel: umass0:umass_dump_buffer: 0x f8ffffff000000000000000000000000 buffer=0xd9237200, buflen=4096
Sep 21 21:43:37 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000
Sep 21 21:43:37 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000 ...
Sep 21 21:43:37 saturn kernel: (da2:umass-sim0:0:0:2): Retrying Command
Sep 21 21:43:42 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:43:42 saturn kernel: umass0:umass_transfer_start: transfer index = 0
Sep 21 21:43:42 saturn kernel: (da2:umass-sim0:0:0:2): Request completed with CAM_REQ_CMP_ERR
Sep 21 21:43:42 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:43:42 saturn kernel: umass0:umass_cam_action: 4:0:2:XPT_SCSI_IO: cmd: 0x2a, flags: 0x80, 10b cmd/4096b data/32b sense
Sep 21 21:43:42 saturn kernel: umass0:umass_dump_buffer: 0x f8ffffff000000000000000000000000 buffer=0xd9237200, buflen=4096
Sep 21 21:43:42 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000
Sep 21 21:43:42 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000 ...
Sep 21 21:43:42 saturn kernel: (da2:umass-sim0:0:0:2): Retrying Command
Sep 21 21:43:47 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:43:47 saturn kernel: umass0:umass_transfer_start: transfer index = 0
Sep 21 21:43:47 saturn kernel: (da2:umass-sim0:0:0:2): Request completed with CAM_REQ_CMP_ERR
Sep 21 21:43:47 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:43:47 saturn kernel: umass0:umass_cam_action: 4:0:2:XPT_SCSI_IO: cmd: 0x2a, flags: 0x80, 10b cmd/4096b data/32b sense
Sep 21 21:43:47 saturn kernel: umass0:umass_dump_buffer: 0x f8ffffff000000000000000000000000 buffer=0xd9237200, buflen=4096
Sep 21 21:43:47 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000
Sep 21 21:43:47 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000 ...
Sep 21 21:43:47 saturn kernel: (da2:umass-sim0:0:0:2): Retrying Command
Sep 21 21:43:52 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:43:52 saturn kernel: umass0:umass_transfer_start: transfer index = 0
Sep 21 21:43:52 saturn kernel: (da2:umass-sim0:0:0:2): Request completed with CAM_REQ_CMP_ERR
Sep 21 21:43:52 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:43:52 saturn kernel: umass0:umass_cam_action: 4:0:2:XPT_SCSI_IO: cmd: 0x2a, flags: 0x80, 10b cmd/4096b data/32b sense
Sep 21 21:43:52 saturn kernel: umass0:umass_dump_buffer: 0x f8ffffff000000000000000000000000 buffer=0xd9237200, buflen=4096
Sep 21 21:43:52 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000
Sep 21 21:43:52 saturn kernel: umass0:umass_dump_buffer: 0x 00000000000000000000000000000000 ...
Sep 21 21:43:52 saturn kernel: (da2:umass-sim0:0:0:2): Retrying Command
Sep 21 21:43:57 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:43:57 saturn kernel: umass0:umass_transfer_start: transfer index = 0
Sep 21 21:43:57 saturn kernel: (da2:umass-sim0:0:0:2): Request completed with CAM_REQ_CMP_ERR
Sep 21 21:43:57 saturn kernel: (da2:umass-sim0:0:0:2): error 5
Sep 21 21:43:57 saturn kernel: (da2:umass-sim0:0:0:2): Retries Exausted
Sep 21 21:43:57 saturn kernel: umass0:umass_t_bbb_reset1_callback: BBB reset!
Sep 21 21:43:57 saturn kernel: g_vfs_done():da2s1[WRITE(offset=512, length=4096)]error = 5
Sep 21 21:43:57 saturn kernel: fsync: giving up on dirty
Sep 21 21:43:57 saturn kernel: 0xc5503660: tag devfs, type VCHR
Sep 21 21:43:57 saturn kernel: usecount 1, writecount 0, refcount 35 mountedhere 0xc5273700
Sep 21 21:43:57 saturn kernel: flags ()
Sep 21 21:43:57 saturn kernel: v_object 0xc549f5ac ref 0 pages 36
Sep 21 21:43:57 saturn kernel: 
Sep 21 21:43:57 saturn kernel: dev da2s1
Sep 21 21:43:57 saturn kernel: umass0:umass_cam_action: 4:0:2:XPT_SCSI_IO: cmd: 0x1e, flags: 0xc0, 6b cmd/0b data/32b sense
Sep 21 21:45:50 saturn syslogd: kernel boot file is /boot/GENERIC/kernel
Sep 21 21:45:50 saturn kernel: umass0:umass_tr_error: transfer error, USBD_TIMEOUT -> reset
Sep 21 21:45:50 saturn kernel: umass0: timeout: giving up reset!
Sep 21 21:45:50 saturn kernel: 
Sep 21 21:45:50 saturn kernel: 
Sep 21 21:45:50 saturn kernel: Fatal trap 12: page fault while in kernel mode
Sep 21 21:45:50 saturn kernel: fault virtual address	= 0x0
Sep 21 21:45:50 saturn kernel: fault code		= supervisor read, page not present
Sep 21 21:45:50 saturn kernel: instruction pointer	= 0x20:0xc062503f
Sep 21 21:45:50 saturn kernel: stack pointer	        = 0x28:0xe7391c28
Sep 21 21:45:50 saturn kernel: frame pointer	        = 0x28:0xe7391c5c
Sep 21 21:45:50 saturn kernel: code segment		= base 0x0, limit 0xfffff, type 0x1b
Sep 21 21:45:50 saturn kernel: = DPL 0, pres 1, def32 1, gran 1
Sep 21 21:45:50 saturn kernel: processor eflags	= interrupt enabled, resume, IOPL = 0
Sep 21 21:45:50 saturn kernel: current process		= 1058 (umount)
Sep 21 21:45:50 saturn kernel: trap number		= 12
Sep 21 21:45:50 saturn kernel: panic: page fault
Sep 21 21:45:50 saturn kernel: KDB: stack backtrace:
Sep 21 21:45:50 saturn kernel: kdb_backtrace(100,c5276d80,28,e7391be8,c) at kdb_backtrace+0x29
Sep 21 21:45:50 saturn kernel: panic(c08b7352,c090d7ee,0,fffff,c527dc9b) at panic+0xa8
Sep 21 21:45:50 saturn kernel: trap_fatal(e7391be8,0,c5276d80,0,c) at trap_fatal+0x2a6
Sep 21 21:45:50 saturn kernel: trap_pfault(e7391be8,0,0) at trap_pfault+0x1f3
Sep 21 21:45:50 saturn kernel: trap(8,28,28,0,c5503220) at trap+0x325
Sep 21 21:45:50 saturn kernel: calltrap() at calltrap+0x5
Sep 21 21:45:50 saturn kernel: --- trap 0xc, eip = 0xc062503f, esp = 0xe7391c28, ebp = 0xe7391c5c ---
Sep 21 21:45:50 saturn kernel: deget(0,0,1fffffff,e7391c74) at deget+0xf
Sep 21 21:45:50 saturn kernel: msdosfs_root(c4be0000,2,e7391c94,c5276d80) at msdosfs_root+0x1f
Sep 21 21:45:50 saturn kernel: dounmount(c4be0000,8080000,c5276d80,a5,3) at dounmount+0x309
Sep 21 21:45:50 saturn kernel: unmount(c5276d80,e7391d04,2,0,206) at unmount+0x289
Sep 21 21:45:50 saturn kernel: syscall(3b,3b,3b,804a465,804e389) at syscall+0x2b7
Sep 21 21:45:50 saturn kernel: Xint0x80_syscall() at Xint0x80_syscall+0x1f
Sep 21 21:45:50 saturn kernel: --- syscall (22, FreeBSD ELF32, unmount), eip = 0x280b7deb, esp = 0xbfbfe54c, ebp = 0xbfbfe5f8 ---
Sep 21 21:45:50 saturn kernel: Uptime: 10m40s
Sep 21 21:45:50 saturn kernel: Dumping 1023 MB (2 chunks)
Sep 21 21:45:50 saturn kernel: chunk 0: 1MB (159 pages) ... ok
Sep 21 21:45:50 saturn kernel: chunk 1: 1023MB (261872 pages) 1007 991 975 959 943 927 911 895 879 863 847 831 815 799 783 767 751 735 719 703 687 671 655 639 623 607 591 575 559 543 527 511 495 479 463 447 431 415 399 383 367 351 335 319 303 287 271 255 239 223 207 191 175 159 143 127 111 95 79 63 47 31 15 ... ok
Sep 21 21:45:50 saturn kernel: 
Sep 21 21:45:50 saturn kernel: Dump complete
Sep 21 21:45:50 saturn kernel: Automatic reboot in 15 seconds - press a key on the console to abort
Sep 21 21:45:50 saturn kernel: Rebooting...

More information about the freebsd-usb mailing list