USB bus stopping

[Peter Jeremy]

I'm trying to do a dump|restore from one disk to a replacement, with
the new disk in a USB enclosure.  Every few minutes (though it's
random), the writes stop for a few minutes for no obvious reason.  I
managed to capture one instance with usbdump:

07:34:26.142023 usbus4.2 SUBM-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=16384,IVAL=0
07:34:26.143096 usbus4.2 DONE-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=0,IVAL=0,ERR=0
07:34:26.143110 usbus4.2 SUBM-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=0,IVAL=0
07:34:26.143220 usbus4.2 DONE-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=16,IVAL=0,ERR=0
07:34:26.143321 usbus4.2 SUBM-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=32,IVAL=0
07:34:26.143478 usbus4.2 DONE-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=0,IVAL=0,ERR=0
07:34:26.143582 usbus4.2 SUBM-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=65536,IVAL=0
07:34:26.145743 usbus4.2 DONE-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=0,IVAL=0,ERR=0
07:34:26.145761 usbus4.2 SUBM-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=0,IVAL=0
07:34:26.145842 usbus4.2 DONE-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=16,IVAL=0,ERR=0
07:34:26.145884 usbus4.2 SUBM-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=32,IVAL=0
07:34:26.145964 usbus4.2 DONE-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=0,IVAL=0,ERR=0
07:34:26.146027 usbus4.2 SUBM-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=32768,IVAL=0
07:34:26.147098 usbus4.2 DONE-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=0,IVAL=0,ERR=0
07:34:26.147114 usbus4.2 SUBM-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=0,IVAL=0
07:34:26.147222 usbus4.2 DONE-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=16,IVAL=0,ERR=0
07:34:26.147299 usbus4.2 SUBM-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=32,IVAL=0
07:34:26.147358 usbus4.2 DONE-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=0,IVAL=0,ERR=0
07:34:26.147420 usbus4.2 SUBM-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=20480,IVAL=0
07:35:29.624720 usbus4.2 DONE-BULK-EP=00000002,SPD=HIGH,NFR=0,SLEN=0,IVAL=0,ERR=TIMEOUT
07:35:29.624742 usbus4.2 SUBM-CTRL-EP=00000000,SPD=HIGH,NFR=1,SLEN=8,IVAL=0
07:35:29.624842 usbus4.2 DONE-CTRL-EP=00000000,SPD=HIGH,NFR=1,SLEN=0,IVAL=0,ERR=0
07:35:29.624858 usbus4.2 SUBM-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=0,IVAL=0
07:35:29.624955 usbus4.2 DONE-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=16,IVAL=0,ERR=0
07:35:29.625051 usbus4.2 SUBM-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=32,IVAL=0
07:35:29.625205 usbus4.2 DONE-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=0,IVAL=0,ERR=0
07:35:29.625239 usbus4.2 SUBM-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=4096,IVAL=0
07:35:29.625453 usbus4.2 DONE-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=0,IVAL=0,ERR=0
07:35:29.625463 usbus4.2 SUBM-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=0,IVAL=0
07:35:29.625579 usbus4.2 DONE-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=16,IVAL=0,ERR=0
07:35:29.625657 usbus4.2 SUBM-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=32,IVAL=0
07:35:29.625712 usbus4.2 DONE-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=0,IVAL=0,ERR=0
07:35:29.625736 usbus4.2 SUBM-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=4096,IVAL=0
07:35:29.625955 usbus4.2 DONE-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=0,IVAL=0,ERR=0
07:35:29.625965 usbus4.2 SUBM-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=0,IVAL=0
07:35:29.626078 usbus4.2 DONE-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=16,IVAL=0,ERR=0

One anomoly is that the above doesn't match the usbdump man page.

The system is a JW-D2500-GT motherboard (Intel D2500 CPU) using the builtin
N10 for USB, running FreeBSD 9.2R/amd64.  The disk is a new WDC WD5000BPKT
plugged into a Sunplus Technology Inc. adapter.  I'm not using any hubs.

The problem doesn't seem to occur if I just do sequential writes (dd
to the disk).  Any suggestions?

-- 
Peter Jeremy
-------------- next part --------------
A non-text attachment was scrubbed...
Name: not available
Type: application/pgp-signature
Size: 326 bytes
Desc: not available
URL: <http://lists.freebsd.org/pipermail/freebsd-usb/attachments/20131117/01b43e82/attachment.sig>