From owner-freebsd-current@FreeBSD.ORG Sun Jan 15 19:38:29 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 95ECC1065670; Sun, 15 Jan 2012 19:38:29 +0000 (UTC) (envelope-from hselasky@c2i.net) Received: from swip.net (mailfe07.c2i.net [212.247.154.194]) by mx1.freebsd.org (Postfix) with ESMTP id CC6F68FC13; Sun, 15 Jan 2012 19:38:28 +0000 (UTC) X-T2-Spam-Status: No, hits=-0.2 required=5.0 tests=ALL_TRUSTED, BAYES_50 Received: from [188.126.198.129] (account mc467741@c2i.net HELO laptop002.hselasky.homeunix.org) by mailfe07.swip.net (CommuniGate Pro SMTP 5.4.2) with ESMTPA id 228458891; Sun, 15 Jan 2012 20:38:25 +0100 From: Hans Petter Selasky To: freebsd-usb@freebsd.org Date: Sun, 15 Jan 2012 20:36:09 +0100 User-Agent: KMail/1.13.5 (FreeBSD/8.2-STABLE; KDE/4.4.5; amd64; ; ) References: <4F130E7F.9090400@m5p.com> In-Reply-To: <4F130E7F.9090400@m5p.com> 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: <201201152036.09426.hselasky@c2i.net> Cc: freebsd-current@freebsd.org, George Mitchell 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: Sun, 15 Jan 2012 19:38:29 -0000 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, I think this is a SCSI / CAM layer problem and not a USB problem. --HPS