From owner-freebsd-current@FreeBSD.ORG Sun Aug 22 14:05:34 2004 Return-Path: Delivered-To: freebsd-current@freebsd.org Received: from mx1.FreeBSD.org (mx1.freebsd.org [216.136.204.125]) by hub.freebsd.org (Postfix) with ESMTP id D514216A4CE for ; Sun, 22 Aug 2004 14:05:34 +0000 (GMT) Received: from arthur.nitro.dk (port324.ds1-khk.adsl.cybercity.dk [212.242.113.79]) by mx1.FreeBSD.org (Postfix) with ESMTP id 3C45043D69 for ; Sun, 22 Aug 2004 14:05:33 +0000 (GMT) (envelope-from simon@arthur.nitro.dk) Received: by arthur.nitro.dk (Postfix, from userid 3000) id DB47F11948; Sun, 22 Aug 2004 16:05:30 +0200 (CEST) Date: Sun, 22 Aug 2004 16:05:30 +0200 From: "Simon L. Nielsen" To: =?iso-8859-1?Q?S=F8ren?= Schmidt Message-ID: <20040822140530.GA20169@arthur.nitro.dk> References: <200408191632.25637.kent.hauser@verizon.net> <20040820085322.GC16420@eddie.nitro.dk> <20040821130814.GA2795@arthur.nitro.dk> <16679.63728.806424.628485@ran.psg.com> <41289139.6060806@DeepCore.dk> <20040822124133.GB749@zaphod.nitro.dk> <41289D02.1080103@DeepCore.dk> Mime-Version: 1.0 Content-Type: multipart/signed; micalg=pgp-sha1; protocol="application/pgp-signature"; boundary="4SFOXa2GPu3tIq4H" Content-Disposition: inline In-Reply-To: <41289D02.1080103@DeepCore.dk> User-Agent: Mutt/1.5.6i cc: Randy Bush cc: Kent Hauser cc: current@freebsd.org Subject: Re: RELENG_5: ata interrupt problems X-BeenThere: freebsd-current@freebsd.org X-Mailman-Version: 2.1.1 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, 22 Aug 2004 14:05:35 -0000 --4SFOXa2GPu3tIq4H Content-Type: multipart/mixed; boundary="jRHKVT23PllUwdXP" Content-Disposition: inline --jRHKVT23PllUwdXP Content-Type: text/plain; charset=iso-8859-1 Content-Disposition: inline Content-Transfer-Encoding: quoted-printable On 2004.08.22 15:17:54 +0200, S=F8ren Schmidt wrote: > Simon L. Nielsen wrote: > >On 2004.08.22 14:27:37 +0200, S=F8ren Schmidt wrote: > > > >>Randy Bush wrote: > >> > >>>>The actual errors from a 5.3-BETA from today (hand transcribed): > >>> > >>>>ad0: 73863MB [150071/16/63] at ata0-master= =20 > >>>>UDMA100 > >>>>ATAPI_RESET time =3D 150us > >>>>ata1-slave: FAILURE - ATAPI_IDENTIFY timed out > >>>>ATAPI_RESET time =3D 150us > >>>>acd0: CDRW at ata1-master UDMA33 > >>>>Mounting root from ufs:/dev/ad0s2a > >>>>[...] > >>>>ad0: WARNING - READ_DME interupt was seen but timeout fired LBA=3D415= 74224 > >>>>[...] > >>>>ad0: WARNING - READ_DME interupt was seen but timeout fired LBA=3D415= 62160 > >>>>ad0: WARNING - READ_DME interupt was seen but timeout fired LBA=3D415= 62160 > >>>>ad0: WARNING - READ_DME interupt was seen but taskqueue stalled=20 > >>>>LBA=3D41562160 > >>>>Slab at 0xc1c3ff70, freei 3 =3D 0 > >>>> > >>>>The "[...]" is just normal startup. It goes as far as the script that > >>>>attaches my GDBE partition before it panics. > >>>> > >>>>And then it panics like below: > >>> > >>>yep. same on a thinkpad t40p >=20 > Could I have you try the below patch and mail me the output from dmesg=20 > on a failed boot please?. I need to know what kind of state those damned= =20 > fakeslave devices are in to be able to fix this problem. It just says "status=3D00 error=3D00", but complete dmesg is attached (as much as dcons(4) has on boot). BTW. this is RELENG_5. > Or someone get me one of those crappy drives that does this here in the= =20 > lab to disect... Since the drives use some special laptop connector it's probably not really useful without a compatible IBM laptop... --=20 Simon L. Nielsen FreeBSD Documentation Team --jRHKVT23PllUwdXP Content-Type: text/plain; charset=us-ascii Content-Disposition: attachment; filename="ata.dmesg" Content-Transfer-Encoding: quoted-printable [dcons connected] npx0: [FAST] npx0: on motherboard npx0: INT 16 interface acpi0: on motherboard acpi_ec0: port 0x66,0x62 on acpi0 acpi0: Power Button (fixed) Timecounter "ACPI-fast" frequency 3579545 Hz quality 1000 acpi_timer0: <24-bit timer at 3.579545MHz> port 0x1008-0x100b on acpi0 cpu0: on acpi0 acpi_tz0: on acpi0 acpi_lid0: on acpi0 acpi_button0: on acpi0 pcib0: port 0xcf8-0xcff on acpi0 pci0: on pcib0 agp0: mem 0xd0000000-0xdfffffff at device = 0.0 on pci0 pcib1: at device 1.0 on pci0 pci1: on pcib1 drm0: port 0x3000-0x30ff mem 0xc0100000-0x= c010ffff,0xe0000000-0xe7ffffff irq 11 at device 0.0 on pci1 info: [drm] AGP at 0xd0000000 256MB info: [drm] Initialized radeon 1.11.0 20020828 on minor 0 uhci0: port 0x1800-0x181f irq 1= 1 at device 29.0 on pci0 uhci0: [GIANT-LOCKED] usb0: on uhci0 usb0: USB revision 1.0 uhub0: Intel UHCI root hub, class 9/0, rev 1.00/1.00, addr 1 uhub0: 2 ports with 2 removable, self powered uhci1: port 0x1820-0x183f irq 1= 1 at device 29.1 on pci0 uhci1: [GIANT-LOCKED] usb1: on uhci1 usb1: USB revision 1.0 uhub1: Intel UHCI root hub, class 9/0, rev 1.00/1.00, addr 1 uhub1: 2 ports with 2 removable, self powered uhci2: port 0x1840-0x185f irq 1= 1 at device 29.2 on pci0 uhci2: [GIANT-LOCKED] usb2: on uhci2 usb2: USB revision 1.0 uhub2: Intel UHCI root hub, class 9/0, rev 1.00/1.00, addr 1 uhub2: 2 ports with 2 removable, self powered pci0: at device 29.7 (no driver attached) pcib2: at device 30.0 on pci0 pci2: on pcib2 cbb0: irq 11 at device 0.0 on pci2 cardbus0: on cbb0 pccard0: <16-bit PCCard bus> on cbb0 pci2: at device 2.0 (no driver attached) fwohci0: mem 0xc0200000-0xc0203fff,= 0xc0206000-0xc02067ff irq 11 at device 7.0 on pci2 fwohci0: [GIANT-LOCKED] fwohci0: OHCI version 1.10 (ROM=3D0) fwohci0: No. of Isochronous channels is 4. fwohci0: EUI64 00:06:1b:00:20:08:fc:24 fwohci0: Phy 1394a available S400, 1 ports. fwohci0: Link S400, max_rec 2048 bytes. firewire0: on fwohci0 dcons_crom0: on firewire0 dcons_crom0: bus_addr 0x1f3ca000 fwohci0: Initiate bus reset fwohci0: node_id=3D0x8000ffc0, gen=3D1, non CYCLEMASTER mode firewire0: 2 nodes, maxhop <=3D 1, cable IRM =3D 1 fxp0: port 0x8000-0x803f mem 0xc= 0205000-0xc0205fff irq 11 at device 8.0 on pci2 miibus0: on fxp0 inphy0: on miibus0 inphy0: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto fxp0: Ethernet address: 00:06:1b:d2:d5:6f fxp0: [GIANT-LOCKED] isab0: at device 31.0 on pci0 isa0: on isab0 atapci0: port 0x1860-0x186f,0x376,0x170-0x1= 77,0x3f6,0x1f0-0x1f7 at device 31.1 on pci0 ata0: channel #0 on atapci0 ata1: channel #1 on atapci0 pci0: at device 31.3 (no driver attached) pcm0: port 0x18c0-0x18ff,0x1c00-0x1cff mem 0xc000080= 0-0xc00008ff,0xc0000c00-0xc0000dff irq 11 at device 31.5 on pci0 pcm0: [GIANT-LOCKED] pcm0: pci0: at device 31.6 (no driver attached) atkbdc0: port 0x64,0x60 irq 1 on acpi0 atkbd0: irq 1 on atkbdc0 kbd0 at atkbd0 atkbd0: [GIANT-LOCKED] psm0: irq 12 on atkbdc0 psm0: [GIANT-LOCKED] psm0: model Generic PS/2 mouse, device ID 0 sio0: configured irq 4 not in bitmap of probed irqs 0 sio0: port may not be enabled sio0 port 0x3f8-0x3ff irq 4 on acpi0 sio0: type 8250 or not responding ppc0 port 0x3bc-0x3be irq 7 on acpi0 ppc0: Generic chipset (NIBBLE-only) in COMPATIBLE mode ppbus0: on ppc0 lpt0: on ppbus0 lpt0: Interrupt-driven port ppi0: on ppbus0 sio1 port 0x2f8-0x2ff irq 3 drq 3 on acpi0 sio1: type 16550A acpi_cmbat0: on acpi0 acpi_acad0: on acpi0 pmtimer0 on isa0 orm0: at iomem 0xdc000-0xdffff,0xd1000-0xd1fff,0xd0000-0x= d0fff on isa0 sc0: on isa0 sc0: VGA <16 virtual consoles, flags=3D0x200> vga0: at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0 fdc0: ready for input in output fdc0: cmd 3 failed at out byte 1 of 3 Timecounter "TSC" frequency 1498732135 Hz quality 800 Timecounters tick every 10.000 msec IPsec: Initialized Security Association Processing. ipfw2 initialized, divert enabled, rule-based forwarding disabled, default = to deny, logging limited to 100 packets/entry by default acpi_cpu: throttling enabled, 8 steps (100% to 12.5%), currently 100.0% ad0: 73863MB [150071/16/63] at ata0-master UDMA1= 00 firewire0: bus manager 1=20 firewire0: New S400 device ID:00e01800000516f6 status=3D00 error=3D00 ATAPI_RESET time =3D 270us ata1-slave: FAILURE - ATAPI_IDENTIFY timed out ATAPI_RESET time =3D 270us acd0: CDRW at ata1-master UDMA33 Mounting root from ufs:/dev/ad0s2a Pre-seeding PRNG:ad0: WARNING - READ_DMA interrupt was seen but timeout fir= ed LBA=3D41560848 kickstart. Loading configuration files. Entropy harvesting: interrupts ethernet point_to_point kickstart. kernel dumps on /dev/ad0s2b Configuring Disk Encryption for /dev/ad0s2f.bde. Enter passphrase: ad0: WARNING - READ_DMA interrupt was seen but timeout fi= red LBA=3D41562160 ad0: WARNING - READ_DMA interrupt was seen but timeout fired LBA=3D41562160 ad0: WARNING - READ_DMA interrupt was seen but taskqueue stalled LBA=3D4156= 2160 Slab at 0xc1d1bf70, freei 18 =3D 0. panic: Duplicate free of item 0xc1d1b948 from zone 0xc198f160(g_bio) cpuid =3D 0;=20 KDB: enter: panic [thread 100024] Stopped at kdb_enter+0x30: leave db> trace kdb_enter(c0778205,0,c0795b72,d41dcb90,c198b2c0) at kdb_enter+0x30 panic(c0795b72,c1d1b948,c198f160,c077327e,8b0) at panic+0x14a uma_dbg_free(c198f160,0,c1d1b948,8b0,0) at uma_dbg_free+0x126 uma_zfree_arg(c198f160,c1d1b948,0,d41dcc20,c0523e9c) at uma_zfree_arg+0x128 g_destroy_bio(c1d1b948,c0772b0c,c1d1b948,cbe54138,0) at g_destroy_bio+0x22 g_dev_done(c1d1b948,0,c077eda3,bb8) at g_dev_done+0x7c biodone(c1d1b948,1,c1d18438,c1d18438,d41dcc84) at biodone+0x72 ad_done(c1d18438,c1d18438,0,a,d41dcc90) at ad_done+0x32 ata_completed(c1d18438,0,0,7,c1d18438) at ata_completed+0x45d ata_timeout(c1d18438,0,c07793e9,f7,1) at ata_timeout+0x11c softclock(0,0,c07759aa,268,0) at softclock+0x1b6 ithread_loop(c19b3580,d41dcd48,c0775795,32c,c19b3580) at ithread_loop+0x15f fork_exit(c0549319,c19b3580,d41dcd48) at fork_exit+0xc7 fork_trampoline() at fork_trampoline+0x8 --- trap 0x1, eip =3D 0, esp =3D 0xd41dcd7c, ebp =3D 0 --- --jRHKVT23PllUwdXP-- --4SFOXa2GPu3tIq4H Content-Type: application/pgp-signature Content-Disposition: inline -----BEGIN PGP SIGNATURE----- Version: GnuPG v1.2.4 (FreeBSD) iD8DBQFBKKgqh9pcDSc1mlERAhhMAKCOCJ4wDdKS1o63kHEhiHaDGjCNCgCgmPqb ZwartJLirEb6xrdVlJ81WBs= =D9ip -----END PGP SIGNATURE----- --4SFOXa2GPu3tIq4H--