From owner-freebsd-current@FreeBSD.ORG Tue Sep 18 17:46:14 2012 Return-Path: Delivered-To: freebsd-current@freebsd.org Received: from mx1.freebsd.org (mx1.freebsd.org [IPv6:2001:4f8:fff6::34]) by hub.freebsd.org (Postfix) with ESMTP id BE75E1065673; Tue, 18 Sep 2012 17:46:14 +0000 (UTC) (envelope-from hselasky@c2i.net) Received: from swip.net (mailfe08.c2i.net [212.247.154.226]) by mx1.freebsd.org (Postfix) with ESMTP id 0DBC88FC16; Tue, 18 Sep 2012 17:46:13 +0000 (UTC) X-T2-Spam-Status: No, hits=-0.2 required=5.0 tests=ALL_TRUSTED, BAYES_50 Received: from [176.74.213.204] (account mc467741@c2i.net HELO laptop015.hselasky.homeunix.org) by mailfe08.swip.net (CommuniGate Pro SMTP 5.4.4) with ESMTPA id 322194007; Tue, 18 Sep 2012 19:46:05 +0200 From: Hans Petter Selasky To: freebsd-current@freebsd.org Date: Tue, 18 Sep 2012 19:47:17 +0200 User-Agent: KMail/1.13.7 (FreeBSD/9.1-PRERELEASE; KDE/4.8.4; amd64; ; ) References: <4F130E7F.9090400@m5p.com> <201201152036.09426.hselasky@c2i.net> In-Reply-To: <201201152036.09426.hselasky@c2i.net> X-Face: 'mmZ:T{)),Oru^0c+/}w'`gU1$ubmG?lp!=R4Wy\ELYo2)@'UZ24N@d2+AyewRX}mAm; Yp |U[@, _z/([?1bCfM{_"B<.J>mICJCHAzzGHI{y7{%JVz%R~yJHIji`y>Y}k1C4TfysrsUI -%GU9V5]iUZF&nRn9mJ'?&>O MIME-Version: 1.0 Content-Type: Text/Plain; charset="iso-8859-1" Content-Transfer-Encoding: 7bit Message-Id: <201209181947.17991.hselasky@c2i.net> Cc: George Mitchell , freebsd-usb@freebsd.org Subject: Re: 9.0 umass problem X-BeenThere: freebsd-current@freebsd.org X-Mailman-Version: 2.1.5 Precedence: list List-Id: Discussions about the use of FreeBSD-current List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Tue, 18 Sep 2012 17:46:14 -0000 On Sunday 15 January 2012 20:36:09 Hans Petter Selasky wrote: > On Sunday 15 January 2012 18:35:59 George Mitchell wrote: > > I have a USB compact flash reader-writer which is normally connected to > > my computer all the time but rarely contains a compact flash card. Here > > is a snippet from a verbose dmesg with FreeBSD 9.0-RC3: > > > > > > ugen0.5: at usbus0 > > umass0: on > > usbus0 > > umass0: SCSI over Bulk-Only; quirks = 0x4101 > > umass0:2:0:-1: Attached to scbus2 > > (probe0:umass-sim0:0:0:0): SCSI status error > > (probe0:umass-sim0:0:0:0): INQUIRY. CDB: 12 1 0 0 ff 0 > > (probe0:umass-sim0:0:0:0): CAM status: SCSI Status Error > > (probe0:umass-sim0:0:0:0): SCSI status: Check Condition > > (probe0:umass-sim0:0:0:0): SCSI sense: NOT READY asc:3a,0 (Medium not > > present) > > (probe0:umass-sim0:0:0:0): Error 6, Unretryable error > > (probe0:umass-sim0:0:0:0): Down reving Protocol Version from 2 to 0? > > ... > > (probe0:umass-sim0:0:0:0): AutoSense failed > > (probe0:umass-sim0:0:0:0): Error 5, Unretryable error > > GEOM: new disk da0 > > pass2 at umass-sim0 bus 0 scbus2 target 0 lun 0 > > pass2: Removable Direct Access SCSI-0 > > device pass2: 1.000MB/s transfers > > ... > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Retrying command > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Retrying command > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Retrying command > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Retrying command > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Error 5, Retries exhausted > > (da0:umass-sim0:0:0:0): got CAM status 0x4 > > (da0:umass-sim0:0:0:0): fatal error, failed to attach to device > > (da0:umass-sim0:0:0:0): lost device - 0 outstanding > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Error 5, Retries exhausted > > (da0:umass-sim0:0:0:0): removing device entry > > Opened disk da0 -> 5 > > > > > > Everything works normally, but the above events take about half a > > minute and bring the booting-up procedure to a halt while the > > retries finish. Is there a umass quirk I could enable to speed up > > whatever is happening here? usbconfig -d 0.5 dump_device_desc says: > > > > ugen0.5: at usbus0, cfg=0 md=HOST spd=FULL > > (12Mbps) pwr=ON > > > > bLength = 0x0012 > > bDescriptorType = 0x0001 > > bcdUSB = 0x0200 > > bDeviceClass = 0x0000 > > bDeviceSubClass = 0x0000 > > bDeviceProtocol = 0x0000 > > bMaxPacketSize0 = 0x0040 > > idVendor = 0x05e3 > > idProduct = 0x0703 > > bcdDevice = 0x0032 > > iManufacturer = 0x0000 > > iProduct = 0x0001 > > iSerialNumber = 0x0000 > > bNumConfigurations = 0x0001 > > > > > > Here's the corresponding dmesg output from 8.2-STABLE: > > > > ugen0.5: at usbus0 > > umass0: on > > usbus0 > > umass0: SCSI over Bulk-Only; quirks = 0x0000 > > umass0: Get Max Lun not supported (USB_ERR_STALLED) > > umass0:2:0:-1: Attached to scbus2 > > (probe0:umass-sim0:0:0:0): SCSI status error > > (probe0:umass-sim0:0:0:0): INQUIRY. CDB: 12 1 0 0 ff 0 > > (probe0:umass-sim0:0:0:0): CAM status: SCSI Status Error > > (probe0:umass-sim0:0:0:0): SCSI status: Check Condition > > (probe0:umass-sim0:0:0:0): SCSI sense: NOT READY asc:3a,0 (Medium not > > present) > > (probe0:umass-sim0:0:0:0): Error 6, Unretryable error > > (probe0:umass-sim0:0:0:0): Down reving Protocol Version from 2 to 0? > > (probe0:umass-sim0:0:0:0): SCSI status error > > (probe0:umass-sim0:0:0:0): TEST UNIT READY. CDB: 0 0 0 0 0 0 > > (probe0:umass-sim0:0:0:0): CAM status: SCSI Status Error > > (probe0:umass-sim0:0:0:0): SCSI status: Check Condition > > (probe0:umass-sim0:0:0:0): SCSI sense: NOT READY asc:3a,0 (Medium not > > present) > > (probe0:umass-sim0:0:0:0): Error 6, Unretryable error > > GEOM: new disk da0 > > pass2 at umass-sim0 bus 0 scbus2 target 0 lun 0 > > pass2: Removable Direct Access SCSI-0 > > device pass2: 1.000MB/s transfers > > (da0:umass-sim0:0:0:0): SCSI status error > > (da0:umass-sim0:0:0:0): READ CAPACITY(10). CDB: 25 0 0 0 0 0 0 0 0 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: NOT READY asc:3a,0 (Medium not > > present) (da0:umass-sim0:0:0:0): Error 6, Unretryable error > > da0 at umass-sim0 bus 0 scbus2 target 0 lun 0 > > da0: Removable Direct Access SCSI-0 device > > da0: 1.000MB/s transfers > > da0: Attempt to query device size failed: NOT READY, Medium not present > > (da0:umass-sim0:0:0:0): SCSI status error > > (da0:umass-sim0:0:0:0): READ CAPACITY(10). CDB: 25 0 0 0 0 0 0 0 0 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: NOT READY asc:3a,0 (Medium not > > present) (da0:umass-sim0:0:0:0): Error 6, Unretryable error > > Opened disk da0 -> 6 > > (da0:umass-sim0:0:0:0): SCSI status error > > (da0:umass-sim0:0:0:0): READ CAPACITY(10). CDB: 25 0 0 0 0 0 0 0 0 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: NOT READY asc:3a,0 (Medium not > > present) (da0:umass-sim0:0:0:0): Error 6, Unretryable error > > Opened disk da0 -> 6 > > > > (which all took only a couple of seconds, compared to half a minute > > with 9.0.) > > > > When there is a flash card in the device, 9.0 behaves even worse, > > taking about two and a half minutes to do this: > > > > ugen0.5: at usbus0 > > umass0: on > > usbus0 > > umass0: SCSI over Bulk-Only; quirks = 0x4101 > > umass0:2:0:-1: Attached to scbus2 > > (probe0:umass-sim0:0:0:0): Down reving Protocol Version from 2 to 0? > > GEOM: new disk da0 > > pass2 at umass-sim0 bus 0 scbus2 target 0 lun 0 > > pass2: Removable Direct Access SCSI-0 > > device pass2: 1.000MB/s transfers > > da0 at umass-sim0 bus 0 scbus2 target 0 lun 0 > > da0: Removable Direct Access SCSI-0 device > > da0: 1.000MB/s transfers > > da0: 245MB (501760 512 byte sectors: 64H 32S/T 245C) > > ... > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Retrying command > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Retrying command > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Retrying command > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Retrying command > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Error 5, Retries exhausted > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Retrying command > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Retrying command > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Retrying command > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Retrying command > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Error 5, Retries exhausted > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Retrying command > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Retrying command > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Retrying command > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Retrying command > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Error 5, Retries exhausted > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Retrying command > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Retrying command > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Retrying command > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Retrying command > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Error 5, Retries exhausted > > Opened disk da0 -> 5 > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Retrying command > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Retrying command > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Retrying command > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Retrying command > > (da0:umass-sim0:0:0:0): Request completed with CAM_REQ_CMP_ERR > > (da0:umass-sim0:0:0:0): Error 5, Retries exhausted > > Opened disk da0 -> 5 > > > > Suggestions? -- George Mitchell > Hi, Can you try 9-stable or apply this patch: http://svn.freebsd.org/changeset/base/240662 --HPS