Promise SATA300 TX4 problems in CURRENT

Fri Jul 13 13:51:30 UTC 2007

Hi,

I just bought a Promise SATA-300 TX4 card for my computer. I use a SCSI drive on
an adaptect controller for the system disk. I started encountering problems when
trying to copy data from the filesystem on one of the ATA disks connected to the
Promise card. I get these messages:

ad10: WARNING - READ_DMA UDMA ICRC error (retrying request) LBA=37814559
ad10: FAILURE - device detached
subdisk10: detached
ad10: detached
g_vfs_done():ad10s3a[WRITE(offset=114688, length=16384)]error = 6
g_vfs_done():ad10s3a[READ(offset=23412736, length=131072)]error = 6
g_vfs_done():ad10s3a[READ(offset=23412736, length=65536)]error = 6
g_vfs_done():ad10s3a[READ(offset=23478272, length=131072)]error = 6

Then if I try to use the system (dhclient in this case), it panics with:
panic: vinvalbuf: dirty bufs

However, I tried installing 6.2 to see if the issue remains there as well. And
it didn't. I works excellent in 6.2. However, I'd like to run CURRENT on this
machine. I've attached relevant part of messages, and a core dump can be found
at http://twoflower.idi.ntnu.no/crash 

Is this perhaps a bug in the ata-subsystem?
-- 
Ulf Lilleengen
-------------- next part --------------
Jul 13 13:21:02 ridcully syslogd: kernel boot file is /boot/kernel/kernel
Jul 13 13:21:02 ridcully kernel: Copyright (c) 1992-2007 The FreeBSD Project.
Jul 13 13:21:02 ridcully kernel: Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994
Jul 13 13:21:02 ridcully kernel: The Regents of the University of California. All rights reserved.
Jul 13 13:21:02 ridcully kernel: FreeBSD is a registered trademark of The FreeBSD Foundation.
Jul 13 13:21:02 ridcully kernel: FreeBSD 7.0-CURRENT #0: Sat Jul  7 19:38:03 CEST 2007
Jul 13 13:21:02 ridcully kernel: root at dhcppc4:/usr/obj/usr/src/sys/GENERIC
Jul 13 13:21:02 ridcully kernel: WARNING: WITNESS option enabled, expect reduced performance.
Jul 13 13:21:02 ridcully kernel: Timecounter "i8254" frequency 1193182 Hz quality 0
Jul 13 13:21:02 ridcully kernel: CPU: Intel Pentium III (698.14-MHz 686-class CPU)
Jul 13 13:21:02 ridcully kernel: Origin = "GenuineIntel"  Id = 0x683  Stepping = 3
Jul 13 13:21:02 ridcully kernel: Features=0x387fbff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,PN,MMX,FXSR,SSE>
Jul 13 13:21:02 ridcully kernel: real memory  = 1073676288 (1023 MB)
Jul 13 13:21:02 ridcully kernel: avail memory = 1037074432 (989 MB)
Jul 13 13:21:02 ridcully kernel: ACPI APIC Table: <GBT    >
Jul 13 13:21:02 ridcully kernel: FreeBSD/SMP: Multiprocessor System Detected: 2 CPUs
Jul 13 13:21:02 ridcully kernel: cpu0 (BSP): APIC ID:  0
Jul 13 13:21:02 ridcully kernel: cpu1 (AP): APIC ID:  1
Jul 13 13:21:02 ridcully kernel: ioapic0 <Version 1.1> irqs 0-23 on motherboard
Jul 13 13:21:02 ridcully kernel: kbd1 at kbdmux0
Jul 13 13:21:02 ridcully kernel: ath_hal: 0.9.20.3 (AR5210, AR5211, AR5212, RF5111, RF5112, RF2413, RF5413)
Jul 13 13:21:02 ridcully kernel: acpi0: <GBT AWRDACPI> on motherboard
Jul 13 13:21:02 ridcully kernel: acpi0: [ITHREAD]
Jul 13 13:21:02 ridcully kernel: acpi0: Power Button (fixed)
Jul 13 13:21:02 ridcully kernel: acpi0: reservation of 0, a0000 (3) failed
Jul 13 13:21:02 ridcully kernel: acpi0: reservation of 100000, 3fef0000 (3) failed
Jul 13 13:21:02 ridcully kernel: Timecounter "ACPI-safe" frequency 3579545 Hz quality 1000
Jul 13 13:21:02 ridcully kernel: acpi_timer0: <24-bit timer at 3.579545MHz> port 0x4008-0x400b on acpi0
Jul 13 13:21:02 ridcully kernel: cpu0: <ACPI CPU> on acpi0
Jul 13 13:21:02 ridcully kernel: cpu1: <ACPI CPU> on acpi0
Jul 13 13:21:02 ridcully kernel: acpi_button0: <Power Button> on acpi0
Jul 13 13:21:02 ridcully kernel: pcib0: <ACPI Host-PCI bridge> port 0xcf8-0xcff,0x4000-0x4041,0x5000-0x500f on acpi0
Jul 13 13:21:02 ridcully kernel: pci0: <ACPI PCI bus> on pcib0
Jul 13 13:21:02 ridcully kernel: agp0: <Intel 82443BX (440 BX) host to PCI bridge> on hostb0
Jul 13 13:21:02 ridcully kernel: pcib1: <PCI-PCI bridge> at device 1.0 on pci0
Jul 13 13:21:02 ridcully kernel: pci1: <PCI bus> on pcib1
Jul 13 13:21:02 ridcully kernel: vgapci0: <VGA-compatible display> port 0xc000-0xc0ff mem 0xdc000000-0xdcffffff,0xde000000-0xde000fff at device 0.0 on pci1
Jul 13 13:21:02 ridcully kernel: isab0: <PCI-ISA bridge> at device 7.0 on pci0
Jul 13 13:21:02 ridcully kernel: isa0: <ISA bus> on isab0
Jul 13 13:21:02 ridcully kernel: atapci0: <Intel PIIX4 UDMA33 controller> port 0x1f0-0x1f7,0x3f6,0x170-0x177,0x376,0xf000-0xf00f at device 7.1 on pci0
Jul 13 13:21:02 ridcully kernel: ata0: <ATA channel 0> on atapci0
Jul 13 13:21:02 ridcully kernel: ata0: [ITHREAD]
Jul 13 13:21:02 ridcully kernel: ata1: <ATA channel 1> on atapci0
Jul 13 13:21:02 ridcully kernel: ata1: [ITHREAD]
Jul 13 13:21:02 ridcully kernel: uhci0: <Intel 82371AB/EB (PIIX4) USB controller> port 0xd000-0xd01f irq 19 at device 7.2 on pci0
Jul 13 13:21:02 ridcully kernel: uhci0: [GIANT-LOCKED]
Jul 13 13:21:02 ridcully kernel: uhci0: [ITHREAD]
Jul 13 13:21:02 ridcully kernel: usb0: <Intel 82371AB/EB (PIIX4) USB controller> on uhci0
Jul 13 13:21:02 ridcully kernel: usb0: USB revision 1.0
Jul 13 13:21:02 ridcully kernel: uhub0: <Intel UHCI root hub, class 9/0, rev 1.00/1.00, addr 1> on usb0
Jul 13 13:21:02 ridcully kernel: uhub0: 2 ports with 2 removable, self powered
Jul 13 13:21:02 ridcully kernel: pci0: <bridge> at device 7.3 (no driver attached)
Jul 13 13:21:02 ridcully kernel: xl0: <3Com 3c905C-TX Fast Etherlink XL> port 0xd400-0xd47f mem 0xe4021000-0xe402107f irq 17 at device 9.0 on pci0
Jul 13 13:21:02 ridcully kernel: miibus0: <MII bus> on xl0
Jul 13 13:21:02 ridcully kernel: xlphy0: <3c905C 10/100 internal PHY> PHY 24 on miibus0
Jul 13 13:21:02 ridcully kernel: xlphy0:  10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto
Jul 13 13:21:02 ridcully kernel: xl0: Ethernet address: 00:01:02:ab:b9:b0
Jul 13 13:21:02 ridcully kernel: xl0: [ITHREAD]
Jul 13 13:21:02 ridcully kernel: xl1: <3Com 3c905C-TX Fast Etherlink XL> port 0xd800-0xd87f mem 0xe4020000-0xe402007f irq 18 at device 10.0 on pci0
Jul 13 13:21:02 ridcully kernel: miibus1: <MII bus> on xl1
Jul 13 13:21:02 ridcully kernel: xlphy1: <3c905C 10/100 internal PHY> PHY 24 on miibus1
Jul 13 13:21:02 ridcully kernel: xlphy1:  10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto
Jul 13 13:21:02 ridcully kernel: xl1: Ethernet address: 00:01:02:ab:b9:44
Jul 13 13:21:02 ridcully kernel: xl1: [ITHREAD]
Jul 13 13:21:02 ridcully kernel: atapci1: <Promise PDC40718 SATA300 controller> port 0xdc00-0xdc7f,0xe000-0xe0ff mem 0xe4023000-0xe4023fff,0xe4000000-0xe401ffff irq 19 at device 11.0 on pci0
Jul 13 13:21:02 ridcully kernel: atapci1: [ITHREAD]
Jul 13 13:21:02 ridcully kernel: atapci1: [ITHREAD]
Jul 13 13:21:02 ridcully kernel: ata2: <ATA channel 0> on atapci1
Jul 13 13:21:02 ridcully kernel: ata2: [ITHREAD]
Jul 13 13:21:02 ridcully kernel: ata3: <ATA channel 1> on atapci1
Jul 13 13:21:02 ridcully kernel: ata3: [ITHREAD]
Jul 13 13:21:02 ridcully kernel: ata4: <ATA channel 2> on atapci1
Jul 13 13:21:02 ridcully kernel: ata4: [ITHREAD]
Jul 13 13:21:02 ridcully kernel: ata5: <ATA channel 3> on atapci1
Jul 13 13:21:02 ridcully kernel: ata5: [ITHREAD]
Jul 13 13:21:02 ridcully kernel: ahc0: <Adaptec aic7895 Ultra SCSI adapter> port 0xe400-0xe4ff mem 0xe4022000-0xe4022fff irq 16 at device 12.0 on pci0
Jul 13 13:21:02 ridcully kernel: ahc0: [ITHREAD]
Jul 13 13:21:02 ridcully kernel: aic7895C: Ultra Wide Channel A, SCSI Id=7, 32/253 SCBs
Jul 13 13:21:02 ridcully kernel: ahc1: <Adaptec aic7895 Ultra SCSI adapter> port 0xe800-0xe8ff mem 0xe4024000-0xe4024fff irq 16 at device 12.1 on pci0
Jul 13 13:21:02 ridcully kernel: ahc1: [ITHREAD]
Jul 13 13:21:02 ridcully kernel: aic7895C: Ultra Wide Channel B, SCSI Id=7, 32/253 SCBs
Jul 13 13:21:02 ridcully kernel: acpi_tz0: <Thermal Zone> on acpi0
Jul 13 13:21:02 ridcully kernel: fdc0: <floppy drive controller> port 0x3f2-0x3f5,0x3f7 irq 6 drq 2 on acpi0
Jul 13 13:21:02 ridcully kernel: fdc0: [FILTER]
Jul 13 13:21:02 ridcully kernel: sio0: <16550A-compatible COM port> port 0x3f8-0x3ff irq 4 flags 0x10 on acpi0
Jul 13 13:21:02 ridcully kernel: sio0: type 16550A
Jul 13 13:21:02 ridcully kernel: sio0: [FILTER]
Jul 13 13:21:02 ridcully kernel: sio1: <16550A-compatible COM port> port 0x2f8-0x2ff irq 3 on acpi0
Jul 13 13:21:02 ridcully kernel: sio1: type 16550A
Jul 13 13:21:02 ridcully kernel: sio1: [FILTER]
Jul 13 13:21:02 ridcully kernel: pmtimer0 on isa0
Jul 13 13:21:02 ridcully kernel: orm0: <ISA Option ROMs> at iomem 0xc0000-0xc7fff,0xc8000-0xc87ff,0xc9000-0xc97ff,0xca000-0xcefff,0xcf000-0xd57ff pnpid ORM0000 on isa0
Jul 13 13:21:02 ridcully kernel: atkbdc0: <Keyboard controller (i8042)> at port 0x60,0x64 on isa0
Jul 13 13:21:02 ridcully kernel: atkbd0: <AT Keyboard> irq 1 on atkbdc0
Jul 13 13:21:02 ridcully kernel: kbd0 at atkbd0
Jul 13 13:21:02 ridcully kernel: atkbd0: [GIANT-LOCKED]
Jul 13 13:21:02 ridcully kernel: atkbd0: [ITHREAD]
Jul 13 13:21:02 ridcully kernel: ppc0: <Parallel port> at port 0x378-0x37f irq 7 on isa0
Jul 13 13:21:02 ridcully kernel: ppc0: Generic chipset (NIBBLE-only) in COMPATIBLE mode
Jul 13 13:21:02 ridcully kernel: ppbus0: <Parallel port bus> on ppc0
Jul 13 13:21:02 ridcully kernel: plip0: <PLIP network interface> on ppbus0
Jul 13 13:21:02 ridcully kernel: lpt0: <Printer> on ppbus0
Jul 13 13:21:02 ridcully kernel: lpt0: Interrupt-driven port
Jul 13 13:21:02 ridcully kernel: ppi0: <Parallel I/O> on ppbus0
Jul 13 13:21:02 ridcully kernel: ppc0: [GIANT-LOCKED]
Jul 13 13:21:02 ridcully kernel: ppc0: [ITHREAD]
Jul 13 13:21:02 ridcully kernel: sc0: <System console> at flags 0x100 on isa0
Jul 13 13:21:02 ridcully kernel: sc0: VGA <16 virtual consoles, flags=0x300>
Jul 13 13:21:02 ridcully kernel: vga0: <Generic ISA VGA> at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0
Jul 13 13:21:02 ridcully kernel: Timecounters tick every 1.000 msec
Jul 13 13:21:02 ridcully kernel: acd0: DVDR <AOPEN DUW1608/ARR/A05a> at ata0-slave UDMA33
Jul 13 13:21:02 ridcully kernel: ad6: 152627MB <WDC WD1600JD-98HBB0 08.02D08> at ata3-master SATA150
Jul 13 13:21:02 ridcully kernel: ad10: 238475MB <WDC WD2500JS-00NCB1 10.02E01> at ata5-master SATA300
Jul 13 13:21:02 ridcully kernel: Waiting 5 seconds for SCSI devices to settle
Jul 13 13:21:02 ridcully kernel: da0 at ahc0 bus 0 target 1 lun 0
Jul 13 13:21:02 ridcully kernel: da0: <FUJITSU MAH3091MP 0113> Fixed Direct Access SCSI-4 device 
Jul 13 13:21:02 ridcully kernel: da0: 40.000MB/s transfers (20.000MHz, offset 8, 16bit)
Jul 13 13:21:02 ridcully kernel: da0: Command Queueing Enabled
Jul 13 13:21:02 ridcully kernel: da0: 8715MB (17850264 512 byte sectors: 255H 63S/T 1111C)
Jul 13 13:21:02 ridcully kernel: SMP: AP CPU #1 Launched!
Jul 13 13:21:02 ridcully kernel: WARNING: WITNESS option enabled, expect reduced performance.
Jul 13 13:21:02 ridcully kernel: Trying to mount root from ufs:/dev/da0s1a
Jul 13 13:21:02 ridcully root: /etc/rc: WARNING: Dump directory does not exist.  Savecore not run.
Jul 13 13:21:08 ridcully login: ROOT LOGIN (root) ON ttyv0
Jul 13 13:21:34 ridcully kernel: WARNING: R/W mount of /mnt denied.  Filesystem is not clean - run fsck
Jul 13 13:24:06 ridcully kernel: ad10: WARNING - READ_DMA UDMA ICRC error (retrying request) LBA=37814559
Jul 13 13:24:42 ridcully kernel: ad10: FAILURE - device detached
Jul 13 13:24:42 ridcully kernel: subdisk10: detached
Jul 13 13:24:42 ridcully kernel: ad10: detached
Jul 13 13:24:42 ridcully kernel: g_vfs_done():ad10s3a[WRITE(offset=114688, length=16384)]error = 6
Jul 13 13:24:42 ridcully kernel: g_vfs_done():ad10s3a[READ(offset=23412736, length=131072)]error = 6
Jul 13 13:24:42 ridcully kernel: g_vfs_done():ad10s3a[READ(offset=23412736, length=65536)]error = 6
Jul 13 13:24:42 ridcully kernel: g_vfs_done():ad10s3a[READ(offset=23478272, length=131072)]error = 6