From owner-freebsd-hackers@FreeBSD.ORG Mon Oct 26 13:13:33 2009 Return-Path: Delivered-To: freebsd-hackers@freebsd.org Received: from mx1.freebsd.org (mx1.freebsd.org [IPv6:2001:4f8:fff6::34]) by hub.freebsd.org (Postfix) with ESMTP id B968C106566B; Mon, 26 Oct 2009 13:13:33 +0000 (UTC) (envelope-from hselasky@c2i.net) Received: from swip.net (mailfe07.swip.net [212.247.154.193]) by mx1.freebsd.org (Postfix) with ESMTP id D3B978FC13; Mon, 26 Oct 2009 13:13:32 +0000 (UTC) X-Cloudmark-Score: 0.000000 [] X-Cloudmark-Analysis: v=1.0 c=1 a=MnI1ikcADjEx7bvsp0jZvQ==:17 a=8kQB0OdkAAAA:8 a=6I5d2MoRAAAA:8 a=6eClurgNXmmwUntNnPEA:9 a=a71AFeG_fZkDGz8ZqYAA:7 a=qYbAdOajlkFMhfmy0cX38eSLC1IA:4 a=9aOQ2cSd83gA:10 a=DQ0VqSu7VckfCXhe:21 a=frsS6xcXOKK5DfJV:21 Received: from [188.126.201.140] (account mc467741@c2i.net HELO laptop.adsl.tele2.no) by mailfe07.swip.net (CommuniGate Pro SMTP 5.2.16) with ESMTPA id 1317016878; Mon, 26 Oct 2009 14:13:30 +0100 From: Hans Petter Selasky To: "M. Warner Losh" Date: Mon, 26 Oct 2009 14:12:38 +0100 User-Agent: KMail/1.11.4 (FreeBSD/9.0-CURRENT; KDE/4.2.4; i386; ; ) References: <200910260959.20772.hselasky@c2i.net> <200910261258.08135.hselasky@c2i.net> <20091026.070117.439503022.imp@bsdimp.com> In-Reply-To: <20091026.070117.439503022.imp@bsdimp.com> X-Face: (%:6u[ldzJ`0qjD7sCkfdMmD*RxpOwEEQ+KWt[{J#x6ow~JO:,zwp.(t; @Aq :4:&nFCgDb8[3oIeTb^'",;u{5{}C9>"PuY\)!=#\u9SSM-nz8+SR~B\!qBv MIME-Version: 1.0 Content-Type: Text/Plain; charset="iso-8859-1" Content-Transfer-Encoding: 7bit Content-Disposition: inline Message-Id: <200910261412.38685.hselasky@c2i.net> Cc: freebsd-hackers@freebsd.org, freebsd-usb@freebsd.org Subject: Re: Help troubleshooting... X-BeenThere: freebsd-hackers@freebsd.org X-Mailman-Version: 2.1.5 Precedence: list List-Id: Technical Discussions relating to FreeBSD List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Mon, 26 Oct 2009 13:13:33 -0000 On Monday 26 October 2009 14:01:17 M. Warner Losh wrote: > In message: <200910261258.08135.hselasky@c2i.net> > > Hans Petter Selasky writes: > : On Monday 26 October 2009 12:48:16 M. Warner Losh wrote: > : > I know that the august 25th version failed badly when I tried to burn > : > DVDs from a USB drive to a USB attached DVD burner. This used to work > : > flawlessly. > : > : Hi, > : > : There has been a recent fix to the EHCI driver, which might affect Mass > : Storage when short transfers are used. > : > : Also someone else has pointed out that certain VIA chipsets have an IRQ > : "bug" requiring the need for a software callout to restart the EHCI > : interrupt handler. This is not yet patched, hence I don't know if this is > : a real issue. > : > : http://svn.freebsd.org/viewvc/base?view=revision&revision=197682 > : > : Is your code from after 1st of October? > > This code is from: > > FreeBSD lighthouse 9.0-CURRENT FreeBSD 9.0-CURRENT #41 r185338:198411M: Fri > Oct 23 10:08:48 MDT 2009 > imp@lighthouse:/cache/svn/head/sys/amd64/compile/LIGHTHOUSE amd64 > > so it would have r197682 baked in (the first number in my rev string > is a mystery to me). > > Re another post: This is a 8GB flash, so I'm sure that there's enough > power. > > Looking at the dmesg, this happend the second or third time I'd > plugged in this flash drive. > > Here's a partial dmesg for usb things: > > CPU: AMD Turion(tm) 64 Mobile Technology ML-37 (1994.21-MHz K8-class CPU) > Origin = "AuthenticAMD" Id = 0x20f42 Stepping = 2 > > Features=0x78bfbff,CMOV,PAT,PSE36,CLFLUSH,MMX,FXSR,SSE,SSE2> Features2=0x1 > AMD Features=0xe2500800 > AMD Features2=0x1 > real memory = 2147483648 (2048 MB) > avail memory = 2059546624 (1964 MB) > ACPI APIC Table: > MADT: Forcing active-low polarity and level trigger for SCI > ioapic0 irqs 0-23 on motherboard > ... > pcib2: at device 5.0 on pci0 > pci2: on pcib2 > ohci0: mem 0xc0000000-0xc0000fff irq 19 at > device 19.0 on pci0 Activate PA 0xc0000000 at VA 0xffffff00c0000000 > ohci0: [ITHREAD] > usbus0: on ohci0 > ohci1: mem 0xc0001000-0xc0001fff irq 19 at > device 19.1 on pci0 Activate PA 0xc0001000 at VA 0xffffff00c0001000 > ohci1: [ITHREAD] > usbus1: on ohci1 > ehci0: mem 0xc0002000-0xc0002fff irq 19 at > device 19.2 on pci0 Activate PA 0xc0002000 at VA 0xffffff00c0002000 > ehci0: [ITHREAD] > usbus2: EHCI version 1.0 > usbus2: on ehci0 > ... > Timecounter "TSC" frequency 1994209008 Hz quality 800 > Timecounters tick every 1.000 msec > usbus0: 12Mbps Full Speed USB v1.0 > usbus1: 12Mbps Full Speed USB v1.0 > usbus2: 480Mbps High Speed USB v2.0 > Status is 0x30000106 > ata0-master: pio=PIO4 wdma=WDMA2 udma=UDMA100 cable=80 wire > Activate i/o 0x8014 > Activate i/o 0x8015 > ugen0.1: at usbus0 > uhub0: on usbus0 > ugen1.1: at usbus1 > uhub1: on usbus1 > ugen2.1: at usbus2 > uhub2: on usbus2 > ad0: 114473MB at ata0-master UDMA100 > GEOM: ad0s2: geometry does not match label (255h,63s != 16h,63s). > uhub0: 4 ports with 4 removable, self powered > uhub1: 4 ports with 4 removable, self powered > ... > Root mount waiting for: usbus2 > uhub2: 8 ports with 8 removable, self powered > Root mount waiting for: usbus2 > Trying to mount root from ufs:/dev/ad0s2a > ugen0.2: at usbus0 > ubt0: 2> on usbus0 usb_alloc_device:1635: getting device descriptor at addr 2 > failed, USB_ERR_TIMEOUT! ugen2.2: at usbus2 > umass0: on usbus2 > umass0: SCSI over Bulk-Only; quirks = 0x0000 > umass0:2:0:-1: Attached to scbus2 > (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): UNIT ATTENTION asc:28,0 > (probe0:umass-sim0:0:0:0): Not ready to ready change, medium may have > changed (probe0:umass-sim0:0:0:0): Retrying Command (per Sense Data) > da0 at umass-sim0 bus 0 scbus2 target 0 lun 0 > da0: Removable Direct Access SCSI-0 device > da0: 40.000MB/s transfers > da0: 7660MB (15687680 512 byte sectors: 255H 63S/T 976C) > ugen2.2: at usbus2 (disconnected) > umass0: at uhub2, port 6, addr 2 (disconnected) > (da0:umass-sim0:0:0:0): lost device > (da0:umass-sim0:0:0:0): Invalidating pack > g_vfs_done():da0s1[READ(offset=5298202624, length=65536)]error = 6 > g_vfs_done():da0s1[READ(offset=5298268160, length=65536)]error = 6 > g_vfs_done():da0s1[READ(offset=5298333696, length=65536)]error = 6 > g_vfs_done():da0s1[WRITE(offset=1976320, length=32768)]error = 6 > g_vfs_done():da0s1[READ(offset=5298137088, length=65536)]error = 6 > (da0:umass-sim0:0:0:0): Synchronize cache failed, status == 0xa, scsi > status == 0x0 (da0:umass-sim0:0:0:0): removing device entry > ugen2.2: at usbus2 > can't re-use a leaf (%desc)! > can't re-use a leaf (%driver)! > can't re-use a leaf (%location)! > can't re-use a leaf (%pnpinfo)! > can't re-use a leaf (%parent)! > umass0: on usbus2 > umass0: SCSI over Bulk-Only; quirks = 0x0000 > umass0:2:0:-1: Attached to scbus2 > da0 at umass-sim0 bus 0 scbus2 target 0 lun 0 > da0: Removable Direct Access SCSI-0 device > da0: 40.000MB/s transfers > da0: 7660MB (15687680 512 byte sectors: 255H 63S/T 976C) > ugen2.2: at usbus2 (disconnected) > umass0: at uhub2, port 6, addr 2 (disconnected) > (da0:umass-sim0:0:0:0): lost device > (da0:umass-sim0:0:0:0): removing device entry > ugen2.2: at usbus2 > can't re-use a leaf (%desc)! > can't re-use a leaf (%driver)! > can't re-use a leaf (%location)! > can't re-use a leaf (%pnpinfo)! > can't re-use a leaf (%parent)! > umass0: on usbus2 > umass0: SCSI over Bulk-Only; quirks = 0x0000 > umass0:2:0:-1: Attached to scbus2 > (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): UNIT ATTENTION asc:28,0 > (probe0:umass-sim0:0:0:0): Not ready to ready change, medium may have > changed (probe0:umass-sim0:0:0:0): Retrying Command (per Sense Data) > da0 at umass-sim0 bus 0 scbus2 target 0 lun 0 > da0: Removable Direct Access SCSI-0 device > da0: 40.000MB/s transfers > da0: 7660MB (15687680 512 byte sectors: 255H 63S/T 976C) > ugen1.2: at usbus1 > ugen2.2: at usbus2 (disconnected) > umass0: at uhub2, port 1, addr 2 (disconnected) > (da0:umass-sim0:0:0:0): lost device > (da0:umass-sim0:0:0:0): Invalidating pack > g_vfs_done():da0s1[READ(offset=634398720, length=65536)]error = 6 > g_vfs_done():da0s1[READ(offset=634464256, length=65536)]error = 6 > g_vfs_done():da0s1[READ(offset=634529792, length=65536)]error = 6 > g_vfs_done():da0s1[WRITE(offset=1976320, length=32768)]error = 6 > g_vfs_done():da0s1[READ(offset=634333184, length=65536)]error = 6 > (da0:umass-sim0:0:0:0): Synchronize cache failed, status == 0xa, scsi > status == 0x0 (da0:umass-sim0:0:0:0): removing device entry > ugen2.2: at usbus2 > can't re-use a leaf (%desc)! > can't re-use a leaf (%driver)! > can't re-use a leaf (%location)! > can't re-use a leaf (%pnpinfo)! > can't re-use a leaf (%parent)! > umass0: on usbus2 > umass0: SCSI over Bulk-Only; quirks = 0x0000 > umass0:2:0:-1: Attached to scbus2 > da0 at umass-sim0 bus 0 scbus2 target 0 lun 0 > da0: Removable Direct Access SCSI-0 device > da0: 40.000MB/s transfers > da0: 7660MB (15687680 512 byte sectors: 255H 63S/T 976C) > Device da0s1 went missing before all of the data could be written to it; > expect data loss. ugen2.2: at usbus2 (disconnected) > umass0: at uhub2, port 1, addr 2 (disconnected) > (da0:umass-sim0:0:0:0): lost device > (da0:umass-sim0:0:0:0): removing device entry > pcm0: mem 0xc0003400-0xc00034ff irq 17 at device 20.5 on pci0 > Activate PA 0xc0003400 at VA 0xffffff00c0003400 > pcm0: [ITHREAD] > pcm0: > ugen1.2: at usbus1 (disconnected) > ugen1.2: at usbus1 > ugen1.2: at usbus1 (disconnected) Hi, Just an experiment: usbconfig -u 2 -a 2 suspend Then try to access the device. Any difference? --HPS