Skip site navigation (1)Skip section navigation (2)
Date:      Tue, 3 Aug 2004 02:45:45 +0200
From:      "Daniel Eriksson" <daniel_k_eriksson@telia.com>
To:        "'freebsd current'" <current@freebsd.org>
Subject:   Panic in today's current, UFS problem?
Message-ID:  <!~!UENERkVCMDkAAQACAAAAAAAAAAAAAAAAABgAAAAAAAAA0VcX9IoJqUaXPS8MjT1PdsKAAAAQAAAA5PQ1jek5/EqvRvENdXMWUAEAAAAA@telia.com>

next in thread | raw e-mail | index | archive | help
This is a multi-part message in MIME format.

------=_NextPart_000_0000_01C47903.FCAF82C0
Content-Type: text/plain;
	charset="us-ascii"
Content-Transfer-Encoding: quoted-printable


I was trying out the new patch from Ville-Pertti Keinonen that might fix =
my
interrupt storm problems with SATA when I ran into a panic. The dmesg is
attached.

OS: CURRENT, 2004.08.02.16.00.00
    + VIA/SATA patch from Ville-Pertti Keinonen
(http://docs.freebsd.org/cgi/getmsg.cgi?fetch=3D505643+0+current/freebsd-=
curre
nt)
    + libdisk patch from Lukas Ertl
(http://docs.freebsd.org/cgi/getmsg.cgi?fetch=3D526964+0+current/freebsd-=
curre
nt)


What I did:
1. fdisk/label two 250GB discs hooked up to the on-board SATA controller
(using sysinstall)
2. copy ~20GB of data to both discs
3. successfully run the stress-test mentioned in Ville-Pertti Keinonen's
mail (above)
4. unmount both discs
5. run "atacontrol create RAID0 128 ad20 ad22" (the two SATA discs)
6. fdisk/label the striped array (using sysinstall, forcing it to UFS1)
7. mount the new partition, and create three empty dirs
8. *boom*

The panic:
----------
panic: initiate_write_filepage: dir inum 0 !=3D new 1254481
KDB: enter: panic
[thread 100029]
Stopped at      kdb_enter+0x30: leave
db> trace
kdb_enter(c075f5bf,c07be420,c076e0eb,dbca7b64,100) at kdb_enter+0x30
panic(c076e0eb,c076e0d3,0,132451,c3010980) at panic+0xcc
initiate_write_filepage(c3010980,cf18b440,200200a4,0,cf18b440) at
initiate_write_filepage+0x8c
softdep_disk_io_initiation(cf18b440,dbca7bd0,cf18b440,c2b1da50,dbca7c00) =
at
softdep_disk_io_initiation+0x5c
softdep_disk_prewrite(c2b1da50,cf18b440,cf18b440,c4028108,dbca7bf0) at
softdep_disk_prewrite+0x82
ufs_strategy(dbca7c28,dbca7c44,c05abfa7,dbca7c28,1) at =
ufs_strategy+0x113
ufs_vnoperate(dbca7c28,1,dbca7c48,1000040,80012) at ufs_vnoperate+0x18
ibwrite(cf18b440,dbca7c5c,c05ac968,cf18b440,dbca7ca0) at ibwrite+0x557
bwrite(cf18b440,dbca7ca0,c06b3b6e,cf18b440,80012) at bwrite+0x15
bawrite(cf18b440,80012,0,c26e99a0,4) at bawrite+0x18
ffs_fsync(dbca7cdc,30002,c26e99a0,0,0) at ffs_fsync+0x31e
sched_sync(0,dbca7d48,0,0,0) at sched_sync+0x45d
fork_exit(c05bfa40,0,dbca7d48) at fork_exit+0x80
fork_trampoline() at fork_trampoline+0x8
--- trap 0x1, eip =3D 0, esp =3D 0xdbca7d7c, ebp =3D 0 ---


Misc info:
----------
geom_vinum used (raid-0 and raid-1 arrays)
ataraid used (raid-0 arrays)
compiled with "CPUTYPE?=3Dathlon-xp" but no CFLAGS/COPTFLAGS

/Daniel Eriksson

------=_NextPart_000_0000_01C47903.FCAF82C0
Content-Type: text/plain;
	name="dmesg.txt"
Content-Transfer-Encoding: quoted-printable
Content-Disposition: attachment;
	filename="dmesg.txt"

KDB: debugger backends: ddb
KDB: current backend: ddb
Copyright (c) 1992-2004 The FreeBSD Project.
Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994
        The Regents of the University of California. All rights =
reserved.
FreeBSD 5.2-CURRENT #0: Mon Aug  2 20:44:56 CEST 2004
    daniel@fortify.satra.zapto.org:/usr/obj/usr/src/sys/FORTIFY
WARNING: Kernel preemption is disabled, expect reduced performance.
Timecounter "i8254" frequency 1193182 Hz quality 0
CPU: AMD Athlon(TM) XP 2500+ (1999.78-MHz 686-class CPU)
  Origin =3D "AuthenticAMD"  Id =3D 0x6a0  Stepping =3D 0
  =
Features=3D0x383fbff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE=
,MCA,CMOV,PAT,PSE36,MMX,FXSR,SSE>
  AMD Features=3D0xc0400000<AMIE,DSP,3DNow!>
real memory  =3D 1342156800 (1279 MB)
avail memory =3D 1305059328 (1244 MB)
npx0: [FAST]
npx0: <math processor> on motherboard
npx0: INT 16 interface
pcib0: <Host to PCI bridge> at pcibus 0 on motherboard
pir0: <PCI Interrupt Routing Table: 11 Entries> on motherboard
$PIR: BIOS IRQ 14 for 0.15.INTA is not valid for link 0x6
pci0: <PCI bus> on pcib0
agp0: <VIA 8377 (Apollo KT400/KT400A/KT600) host to PCI bridge> mem =
0xf8000000-0xfbffffff at device 0.0 on pci0
pcib1: <PCIBIOS PCI-PCI bridge> at device 1.0 on pci0
pci1: <PCI bus> on pcib1
pci1: <display, VGA> at device 0.0 (no driver attached)
atapci0: <HighPoint HPT374 (channel 0+1) UDMA133 controller> port =
0xb400-0xb4ff,0xb800-0xb803,0xd000-0xd007,0xd400-0xd403,0xd800-0xd807 =
irq 11 at device 10.0 on pci0
ata2: at 0xd800 on atapci0
ata3: at 0xd000 on atapci0
atapci1: <HighPoint HPT374 (channel 2+3) UDMA133 controller> port =
0x9800-0x98ff,0xa000-0xa003,0xa400-0xa407,0xa800-0xa803,0xb000-0xb007 =
irq 11 at device 10.1 on pci0
ata4: at 0xb000 on atapci1
ata5: at 0xa400 on atapci1
ahc0: <Adaptec 29160 Ultra160 SCSI adapter> port 0x9400-0x94ff mem =
0xed800000-0xed800fff irq 3 at device 12.0 on pci0
ahc0: [GIANT-LOCKED]
aic7892: Ultra160 Wide Channel A, SCSI Id=3D7, 32/253 SCBs
atapci2: <HighPoint HPT374 (channel 0+1) UDMA133 controller> port =
0x7800-0x78ff,0x8000-0x8003,0x8400-0x8407,0x8800-0x8803,0x9000-0x9007 =
irq 10 at device 14.0 on pci0
ata6: at 0x9000 on atapci2
ata7: at 0x8400 on atapci2
atapci3: <HighPoint HPT374 (channel 2+3) UDMA133 controller> port =
0x6000-0x60ff,0x6400-0x6403,0x6800-0x6807,0x7000-0x7003,0x7400-0x7407 =
irq 10 at device 14.1 on pci0
ata8: at 0x7400 on atapci3
ata9: at 0x6800 on atapci3
atapci4: <VIA 6420 SATA150 controller> port =
0x4000-0x40ff,0x4400-0x440f,0x4800-0x4803,0x5000-0x5007,0x5400-0x5403,0x5=
800-0x5807 irq 5 at device 15.0 on pci0
ata10: at 0x5800 on atapci4
ata11: at 0x5000 on atapci4
atapci5: <VIA 8237 UDMA133 controller> port =
0x3800-0x380f,0x376,0x170-0x177,0x3f6,0x1f0-0x1f7 irq 7 at device 15.1 =
on pci0
ata0: at 0x1f0 irq 14 on atapci5
ata1: at 0x170 irq 15 on atapci5
uhci0: <VIA 83C572 USB controller> port 0x3400-0x341f irq 7 at device =
16.0 on pci0
uhci0: [GIANT-LOCKED]
usb0: <VIA 83C572 USB controller> on uhci0
usb0: USB revision 1.0
uhub0: VIA UHCI root hub, class 9/0, rev 1.00/1.00, addr 1
uhub0: 2 ports with 2 removable, self powered
uhci1: <VIA 83C572 USB controller> port 0x3000-0x301f irq 7 at device =
16.1 on pci0
uhci1: [GIANT-LOCKED]
usb1: <VIA 83C572 USB controller> on uhci1
usb1: USB revision 1.0
uhub1: VIA UHCI root hub, class 9/0, rev 1.00/1.00, addr 1
uhub1: 2 ports with 2 removable, self powered
uhci2: <VIA 83C572 USB controller> port 0x2800-0x281f irq 5 at device =
16.2 on pci0
uhci2: [GIANT-LOCKED]
usb2: <VIA 83C572 USB controller> on uhci2
usb2: USB revision 1.0
uhub2: VIA UHCI root hub, class 9/0, rev 1.00/1.00, addr 1
uhub2: 2 ports with 2 removable, self powered
uhci3: <VIA 83C572 USB controller> port 0x2400-0x241f irq 5 at device =
16.3 on pci0
uhci3: [GIANT-LOCKED]
usb3: <VIA 83C572 USB controller> on uhci3
usb3: USB revision 1.0
uhub3: VIA UHCI root hub, class 9/0, rev 1.00/1.00, addr 1
uhub3: 2 ports with 2 removable, self powered
ehci0: <VIA VT6202 USB 2.0 controller> mem 0xed000000-0xed0000ff irq 9 =
at device 16.4 on pci0
ehci0: [GIANT-LOCKED]
ehci_pci_attach: companion usb0
ehci_pci_attach: companion usb1
ehci_pci_attach: companion usb2
ehci_pci_attach: companion usb3
usb4: EHCI version 1.0
usb4: companion controllers, 2 ports each: usb0 usb1 usb2 usb3
usb4: <VIA VT6202 USB 2.0 controller> on ehci0
usb4: USB revision 2.0
uhub4: VIA EHCI root hub, class 9/0, rev 2.00/1.00, addr 1
uhub4: 8 ports with 8 removable, self powered
isab0: <PCI-ISA bridge> at device 17.0 on pci0
isa0: <ISA bus> on isab0
vr0: <VIA VT6102 Rhine II 10/100BaseTX> port 0x2000-0x20ff mem =
0xec800000-0xec8000ff irq 7 at device 18.0 on pci0
miibus0: <MII bus> on vr0
rlphy0: <RTL8201L 10/100 media interface> on miibus0
rlphy0:  10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto
vr0: Ethernet address: 00:0e:a6:1f:29:1e
vr0: [GIANT-LOCKED]
re0: <RealTek 8110S Single-chip Gigabit Ethernet> port 0x1800-0x18ff mem =
0xec000000-0xec0000ff irq 12 at device 19.0 on pci0
miibus1: <MII bus> on re0
rgephy0: <RTL8169S/8110S media interface> on miibus1
rgephy0:  10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, 1000baseTX, =
1000baseTX-FDX, auto
re0: Ethernet address: 00:50:fc:f8:c6:81
re0: [GIANT-LOCKED]
cpu0 on motherboard
orm0: <ISA Option ROM> at iomem 0xc0000-0xcafff on isa0
pmtimer0 on isa0
atkbdc0: <Keyboard controller (i8042)> at port 0x64,0x60 on isa0
atkbd0: <AT Keyboard> irq 1 on atkbdc0
kbd0 at atkbd0
atkbd0: [GIANT-LOCKED]
fdc0: <Enhanced floppy controller (i82077, NE72065 or clone)> at port =
0x3f7,0x3f0-0x3f5 irq 6 drq 2 on isa0
fdc0: FIFO enabled, 8 bytes threshold
fd0: <1440-KB 3.5" drive> on fdc0 drive 0
sc0: <System console> at flags 0x100 on isa0
sc0: VGA <16 virtual consoles, flags=3D0x100>
sio0 at port 0x3f8-0x3ff irq 4 flags 0x10 on isa0
sio0: type 16550A, console
sio1: configured irq 3 not in bitmap of probed irqs 0
sio1: port may not be enabled
vga0: <Generic ISA VGA> at port 0x3c0-0x3df iomem 0xa0000-0xbffff on =
isa0
unknown: <PNP0501> can't assign resources (port)
unknown: <PNP0700> can't assign resources (port)
unknown: <PNP0303> can't assign resources (port)
Timecounter "TSC" frequency 1999781807 Hz quality 800
Timecounters tick every 1.000 msec
ipfw2 initialized, divert enabled, rule-based forwarding enabled, =
default to accept, logging unlimited
ad0: 114473MB <ST3120022A> [232581/16/63] at ata0-master UDMA100
ad1: 114473MB <ST3120022A> [232581/16/63] at ata0-slave UDMA100
ad2: 117800MB <IC35L120AVV207-0> [239340/16/63] at ata1-master UDMA100
ad3: 117800MB <IC35L120AVV207-0> [239340/16/63] at ata1-slave UDMA100
ad4: 238475MB <WDC WD2500JB-00FUA0> [484521/16/63] at ata2-master =
UDMA100
ad5: 238475MB <WDC WD2500JB-00FUA0> [484521/16/63] at ata2-slave UDMA100
ad6: 239372MB <Maxtor 4A250J0> [486344/16/63] at ata3-master UDMA133
ad7: 239372MB <Maxtor 5A250J0> [486344/16/63] at ata3-slave UDMA133
ad8: 194481MB <Maxtor 6Y200P0> [395136/16/63] at ata4-master UDMA133
ad9: 194481MB <Maxtor 6Y200P0> [395136/16/63] at ata4-slave UDMA133
ad10: 194481MB <Maxtor 6Y200P0> [395136/16/63] at ata5-master UDMA133
ad11: 239372MB <Maxtor 7Y250P0> [486344/16/63] at ata5-slave UDMA133
ad12: 117800MB <IC35L120AVV207-0> [239340/16/63] at ata6-master UDMA100
ad13: 117800MB <HDS722512VLAT20> [239340/16/63] at ata6-slave UDMA100
ad14: 117246MB <Maxtor 6Y120L0> [238216/16/63] at ata7-master UDMA133
ad15: 117246MB <Maxtor 6Y120L0> [238216/16/63] at ata7-slave UDMA133
ad16: 114473MB <WDC WD1200JB-00DUA3> [232581/16/63] at ata8-master =
UDMA100
ad18: 26059MB <Maxtor 92732U8> [52946/16/63] at ata9-master UDMA66
ad20: 238475MB <WDC WD2500JD-00FYB0> [484521/16/63] at ata10-master =
SATA150
ad22: 239372MB <Maxtor 7Y250M0> [486344/16/63] at ata11-master SATA150
ar0: 476950MB <ATA RAID0 array> [60802/255/63] status: READY subdisks:
 disk0 READY on ad4 at ata2-master
 disk1 READY on ad5 at ata2-slave
ar1: 478744MB <ATA RAID0 array> [61031/255/63] status: READY subdisks:
 disk0 READY on ad6 at ata3-master
 disk1 READY on ad7 at ata3-slave
ar2: 388962MB <ATA RAID0 array> [49585/255/63] status: READY subdisks:
 disk0 READY on ad9 at ata4-slave
 disk1 READY on ad8 at ata4-master
ar3: 228946MB <ATA RAID0 array> [29186/255/63] status: READY subdisks:
 disk0 READY on ad15 at ata7-slave
 disk1 READY on ad16 at ata8-master
Waiting 5 seconds for SCSI devices to settle
sa0 at ahc0 bus 0 target 5 lun 0
sa0: <Seagate STT20000N 6A51> Removable Sequential Access SCSI-2 device=20
sa0: 10.000MB/s transfers (10.000MHz, offset 15)
da0 at ahc0 bus 0 target 10 lun 0
da0: <IBM DDYS-T36950N S93E> Fixed Direct Access SCSI-3 device=20
da0: 160.000MB/s transfers (80.000MHz, offset 63, 16bit), Tagged =
Queueing Enabled
da0: 35003MB (71687340 512 byte sectors: 255H 63S/T 4462C)
da1 at ahc0 bus 0 target 11 lun 0
da1: <IBM IC35L036UWD210-0 S5CQ> Fixed Direct Access SCSI-3 device=20
da1: 160.000MB/s transfers (80.000MHz, offset 63, 16bit), Tagged =
Queueing Enabled
da1: 35003MB (71687340 512 byte sectors: 255H 63S/T 4462C)
da2 at ahc0 bus 0 target 12 lun 0
da2: <IBM DDYS-T36950N S93E> Fixed Direct Access SCSI-3 device=20
da2: 160.000MB/s transfers (80.000MHz, offset 63, 16bit), Tagged =
Queueing Enabled
da2: 35003MB (71687340 512 byte sectors: 255H 63S/T 4462C)
da3 at ahc0 bus 0 target 13 lun 0
da3: <IBM DDYS-T36950N S93E> Fixed Direct Access SCSI-3 device=20
da3: 160.000MB/s transfers (80.000MHz, offset 63, 16bit), Tagged =
Queueing Enabled
da3: 35003MB (71687340 512 byte sectors: 255H 63S/T 4462C)
Mounting root from ufs:/dev/ad0s1a

------=_NextPart_000_0000_01C47903.FCAF82C0--




Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?!~!UENERkVCMDkAAQACAAAAAAAAAAAAAAAAABgAAAAAAAAA0VcX9IoJqUaXPS8MjT1PdsKAAAAQAAAA5PQ1jek5/EqvRvENdXMWUAEAAAAA>