Date: Fri, 17 Aug 2007 15:46:28 -0700 From: John-Mark Gurney <gurney_j@resnet.uoregon.edu> To: stable@FreeBSD.org Subject: 2TB+ on ahd broken? (6.2-R) Message-ID: <20070817224628.GI99491@funkthat.com>
next in thread | raw e-mail | index | archive | help
--4SFOXa2GPu3tIq4H
Content-Type: text/plain; charset=us-ascii
Content-Disposition: inline
I was just attempting to add a RAID shelf to a system w/ an Adaptec
29320 card, and when I export a 7TB disk to the card, and kept getting
timeout related issues. The dump is very similar to PR 76178 which
appears to be reporting the same issue...
I have attached a dmesg w/ the failure... I tried various sizes and
1000000MB, 500MB and 2000000MB disks work... When I tried the full
7TB or 2.3TB disk, ahd failed w/ the messages at the end of the
dmesg.
Is anyone even working on this? As 2TB disks are coming soon, I'd
imagine that ahd will need to get fixed before long, or are there just
not many people use large disks w/ ahd?
If ahd isn't getting fixed, can someone recommend a low profile PCI-X
Ultra320 card?
--
John-Mark Gurney Voice: +1 415 225 5579
"All that I will do, has been done, All that I have, has not."
--4SFOXa2GPu3tIq4H
Content-Type: text/plain; charset=us-ascii
Content-Disposition: attachment; filename="dmesg.splicer"
Copyright (c) 1992-2007 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 is a registered trademark of The FreeBSD Foundation.
FreeBSD 6.2-RELEASE #0: Thu Jul 26 14:40:30 PDT 2007
root@splicer:/usr/src/sys/i386/compile/splicer
Timecounter "i8254" frequency 1193182 Hz quality 0
CPU: Intel(R) Pentium(R) 4 CPU 3.00GHz (2992.52-MHz 686-class CPU)
Origin = "GenuineIntel" Id = 0xf41 Stepping = 1
Features=0xbfebfbff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,CLFLUSH,DTS,ACPI,MMX,FXSR,SSE,SSE2,SS,HTT,TM,PBE>
Features2=0x441d<SSE3,RSVD2,MON,DS_CPL,CNTX-ID,<b14>>
Logical CPUs per core: 2
real memory = 1073676288 (1023 MB)
avail memory = 1041502208 (993 MB)
ACPI APIC Table: <A M I OEMAPIC >
FreeBSD/SMP: Multiprocessor System Detected: 2 CPUs
cpu0 (BSP): APIC ID: 0
cpu1 (AP): APIC ID: 1
ioapic0 <Version 2.0> irqs 0-23 on motherboard
ioapic1 <Version 2.0> irqs 24-47 on motherboard
kbd1 at kbdmux0
ath_hal: 0.9.17.2 (AR5210, AR5211, AR5212, RF5111, RF5112, RF2413, RF5413)
acpi0: <A M I OEMRSDT> on motherboard
acpi0: Power Button (fixed)
Timecounter "ACPI-fast" frequency 3579545 Hz quality 1000
acpi_timer0: <24-bit timer at 3.579545MHz> port 0x808-0x80b on acpi0
cpu0: <ACPI CPU> on acpi0
acpi_throttle0: <ACPI CPU Throttling> on cpu0
cpu1: <ACPI CPU> on acpi0
pcib0: <ACPI Host-PCI bridge> port 0xcf8-0xcff on acpi0
pci0: <ACPI PCI bus> on pcib0
pcib1: <ACPI PCI-PCI bridge> at device 3.0 on pci0
pci1: <ACPI PCI bus> on pcib1
em0: <Intel(R) PRO/1000 Network Connection Version - 6.2.9> port 0xac00-0xac1f mem 0xfc2e0000-0xfc2fffff irq 18 at device 1.0 on pci1
em0: Ethernet address: 00:04:23:be:9c:f4
pcib2: <ACPI PCI-PCI bridge> at device 28.0 on pci0
pci2: <ACPI PCI bus> on pcib2
pcib3: <PCI-PCI bridge> at device 3.0 on pci2
pci3: <PCI bus> on pcib3
arcmsr0: <Areca SATA Host Adapter RAID Controller (RAID6 capable)
> mem 0xfc3ff000-0xfc3fffff irq 27 at device 14.0 on pci3
ARECA RAID ADAPTER0: Driver Version 1.20.00.13 2006-8-18
ARECA RAID ADAPTER0: FIRMWARE VERSION V1.36 2005-5-18
ahd0: <Adaptec 29320ALP Ultra320 SCSI adapter> port 0xb800-0xb8ff,0xb400-0xb4ff mem 0xfc5fe000-0xfc5fffff irq 26 at device 4.0 on pci2
ahd0: [GIANT-LOCKED]
aic7901: Ultra320 Wide Channel A, SCSI Id=7, PCI-X 50-66Mhz, 512 SCBs
uhci0: <UHCI (generic) USB controller> port 0xe800-0xe81f irq 16 at device 29.0 on pci0
uhci0: [GIANT-LOCKED]
usb0: <UHCI (generic) USB controller> 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: <UHCI (generic) USB controller> port 0xec00-0xec1f irq 19 at device 29.1 on pci0
uhci1: [GIANT-LOCKED]
usb1: <UHCI (generic) USB controller> 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
pci0: <base peripheral> at device 29.4 (no driver attached)
pci0: <base peripheral, interrupt controller> at device 29.5 (no driver attached)
ehci0: <Intel 6300ESB USB 2.0 controller> mem 0xfe7ffc00-0xfe7fffff irq 23 at device 29.7 on pci0
ehci0: [GIANT-LOCKED]
usb2: EHCI version 1.0
usb2: companion controllers, 2 ports each: usb0 usb1
usb2: <Intel 6300ESB USB 2.0 controller> on ehci0
usb2: USB revision 2.0
uhub2: Intel EHCI root hub, class 9/0, rev 2.00/1.00, addr 1
uhub2: 4 ports with 4 removable, self powered
pcib4: <ACPI PCI-PCI bridge> at device 30.0 on pci0
pci4: <ACPI PCI bus> on pcib4
pci4: <display, VGA> at device 0.0 (no driver attached)
fxp0: <Intel 82551 Pro/100 Ethernet> port 0xcc00-0xcc3f mem 0xfe6fe000-0xfe6fefff,0xfe6a0000-0xfe6bffff irq 17 at device 1.0 on pci4
miibus0: <MII bus> on fxp0
inphy0: <i82555 10/100 media interface> on miibus0
inphy0: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto
fxp0: Ethernet address: 00:04:23:be:9c:f5
isab0: <PCI-ISA bridge> at device 31.0 on pci0
isa0: <ISA bus> on isab0
atapci0: <Intel 6300ESB UDMA100 controller> port 0x1f0-0x1f7,0x3f6,0x170-0x177,0x376,0xfc00-0xfc0f at device 31.1 on pci0
ata0: <ATA channel 0> on atapci0
ata1: <ATA channel 1> on atapci0
atapci1: <Intel 6300ESB SATA150 controller> port 0xe400-0xe407,0xe000-0xe003,0xdc00-0xdc07,0xd800-0xd803,0xd400-0xd40f irq 18 at device 31.2 on pci0
ata2: <ATA channel 0> on atapci1
ata3: <ATA channel 1> on atapci1
pci0: <serial bus, SMBus> at device 31.3 (no driver attached)
acpi_button0: <Power Button> on acpi0
acpi_button1: <Sleep Button> on acpi0
atkbdc0: <Keyboard controller (i8042)> port 0x60,0x64 irq 1 on acpi0
atkbd0: <AT Keyboard> irq 1 on atkbdc0
kbd0 at atkbd0
atkbd0: [GIANT-LOCKED]
sio0: configured irq 4 not in bitmap of probed irqs 0
sio0: port may not be enabled
sio0: <16550A-compatible COM port> port 0x3f8-0x3ff irq 4 flags 0x10 on acpi0
sio0: type 16550A
sio1: configured irq 3 not in bitmap of probed irqs 0
sio1: port may not be enabled
sio1: <16550A-compatible COM port> port 0x2f8-0x2ff irq 3 on acpi0
sio1: type 16550A
fdc0: <floppy drive controller (FDE)> port 0x3f0-0x3f5,0x3f7 irq 6 drq 2 on acpi0
fdc0: does not respond
device_attach: fdc0 attach returned 6
fdc0: <floppy drive controller (FDE)> port 0x3f0-0x3f5,0x3f7 irq 6 drq 2 on acpi0
fdc0: does not respond
device_attach: fdc0 attach returned 6
pmtimer0 on isa0
orm0: <ISA Option ROMs> at iomem 0xc0000-0xc7fff,0xc8000-0xc8fff,0xc9000-0xca7ff on isa0
ppc0: parallel port not found.
sc0: <System console> at flags 0x100 on isa0
sc0: VGA <16 virtual consoles, flags=0x300>
vga0: <Generic ISA VGA> at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0
Timecounters tick every 1.000 msec
acd0: DMA limited to UDMA33, controller found non-ATA66 cable
acd0: DVDR <SONY DVD RW DW-Q30A/YYS2> at ata0-master UDMA33
ad4: 715404MB <Seagate ST3750640AS 3.AAK> at ata2-master SATA150
ad6: 476940MB <Seagate ST3500641AS 3.AAE> at ata3-master SATA150
Waiting 5 seconds for SCSI devices to settle
Copied 18 bytes of sense data offset 12: 0x70 0x0 0x6 0x0 0x0 0x0 0x0 0xa 0x0 0x0 0x0 0x0 0x29 0x0 0x0 0x0 0x0 0x0
pass1 at arcmsr0 bus 0 target 16 lun 0
pass1: <Areca RAID controller R001> Fixed Processor SCSI-0 device
da0 at arcmsr0 bus 0 target 0 lun 0
da0: <Areca ARC-1120-VOL#00 R001> Fixed Direct Access SCSI-3 device
da0: 166.666MB/s transfers (83.333MHz, offset 32, 16bit), Tagged Queueing Enabled
da0: 953674MB (1953124352 512 byte sectors: 255H 63S/T 121576C)
da1 at ahd0 bus 0 target 0 lun 0
da1: <IFT A12U-G2421 347G> Fixed Direct Access SCSI-3 device
da1: 320.000MB/s transfers (160.000MHz, offset 127, 16bit), Tagged Queueing Enabled
da1: 1000000MB (2048000000 512 byte sectors: 255H 63S/T 127482C)
da2 at ahd0 bus 0 target 0 lun 1
da2: <IFT A12U-G2421 347G> Fixed Direct Access SCSI-3 device
da2: 320.000MB/s transfers (160.000MHz, offset 127, 16bit), Tagged Queueing Enabled
da2: 500MB (1024000 512 byte sectors: 64H 32S/T 500C)
SMP: AP CPU #1 Launched!
Trying to mount root from ufs:/dev/da0s1a
WARNING: / was not properly dismounted
WARNING: /usr was not properly dismounted
WARNING: /var was not properly dismounted
WARNING: /v/arch3 was not properly dismounted
WARNING: /v/arch was not properly dismounted
em0: link state changed to UP
Copied 18 bytes of sense data offset 12: 0x70 0x0 0x6 0x0 0x0 0x0 0x0 0xa 0x0 0x0 0x0 0x0 0x3f 0xe 0x0 0x0 0x0 0x0
(da1:ahd0:0:0:0): lost device
(da1:ahd0:0:0:0): removing device entry
(ahd0:A:0:1): refuses tagged commands. Performing non-tagged I/O
(da2:ahd0:0:0:1): lost device
(da2:ahd0:0:0:1): removing device entry
da1 at ahd0 bus 0 target 0 lun 0
da1: <IFT A12U-G2421 347G> Fixed Direct Access SCSI-3 device
da1: 320.000MB/s transfers (160.000MHz, offset 127, 16bit), Tagged Queueing Enabled
da1: 500MB (1024000 512 byte sectors: 64H 32S/T 500C)
Copied 18 bytes of sense data offset 12: 0x70 0x0 0x6 0x0 0x0 0x0 0x0 0xa 0x0 0x0 0x0 0x0 0x3f 0xe 0x0 0x0 0x0 0x0
Copied 18 bytes of sense data offset 12: 0x70 0x0 0x6 0x0 0x0 0x0 0x0 0xa 0x0 0x0 0x0 0x0 0x3f 0xe 0x0 0x0 0x0 0x0
da2 at ahd0 bus 0 target 0 lun 1
da2: <IFT A12U-G2421 347G> Fixed Direct Access SCSI-3 device
da2: 320.000MB/s transfers (160.000MHz, offset 127, 16bit), Tagged Queueing Enabled
da2: 2000000MB (4096000000 512 byte sectors: 255H 63S/T 254964C)
Copied 18 bytes of sense data offset 12: 0x70 0x0 0x6 0x0 0x0 0x0 0x0 0xa 0x0 0x0 0x0 0x0 0x3f 0xe 0x0 0x0 0x0 0x0
(da1:ahd0:0:0:0): lost device
(da1:ahd0:0:0:0): removing device entry
(da1:ahd0:0:0:0): No or incomplete CDB sent to device.
(da1:ahd0:0:0:0): Protocol violation in Message-in phase. Attempting to abort.
(da1:ahd0:0:0:0): Abort Tag Message Sent
(da1:ahd0:0:0:0): SCB 15 - Abort Completed.
found == 0x1
ahd0:A:0: no active SCB for reconnecting target - issuing BUS DEVICE RESET
SAVED_SCSIID == 0x7, SAVED_LUN == 0x1, REG0 == 0x1 ACCUM = 0x0
SEQ_FLAGS == 0x0, SCBPTR == 0x1, BTT == 0xffff, SINDEX == 0x1ba
SELID == 0x0, SCB_SCSIID == 0xe7, SCB_LUN == 0x0, SCB_CONTROL == 0x40
SCSIBUS[0] == 0x81, SCSISIGI == 0xe6
SXFRCTL0 == 0x88
SEQCTL0 == 0x0
>>>>>>>>>>>>>>>>>> Dump Card State Begins <<<<<<<<<<<<<<<<<
ahd0: Dumping Card State at program address 0x15f Mode 0x33
Card was paused
INTSTAT[0x0] SELOID[0x0] SELID[0x0] HS_MAILBOX[0x0]
INTCTL[0x80]:(SWTMINTMASK) SEQINTSTAT[0x0] SAVED_MODE[0x11]
DFFSTAT[0x33]:(CURRFIFO_NONE|FIFO0FREE|FIFO1FREE)
SCSISIGI[0xe6]:(P_MESGIN|REQI|BSYI) SCSIPHASE[0x8]:(MSG_IN_PHASE)
SCSIBUS[0x81] LASTPHASE[0xe0]:(P_MESGIN) SCSISEQ0[0x0]
SCSISEQ1[0x12]:(ENAUTOATNP|ENRSELI) SEQCTL0[0x0] SEQINTCTL[0x0]
SEQ_FLAGS[0x0] SEQ_FLAGS2[0x0] QFREEZE_COUNT[0x7]
KERNEL_QFREEZE_COUNT[0x7] MK_MESSAGE_SCB[0xff00] MK_MESSAGE_SCSIID[0xff]
SSTAT0[0x2]:(SPIORDY) SSTAT1[0x11]:(REQINIT|PHASEMIS)
SSTAT2[0xc0]:(BUSFREE_DFF1) SSTAT3[0x0] PERRDIAG[0xc0]:(HIPERR|HIZERO)
SIMODE1[0xac]:(ENSCSIPERR|ENBUSFREE|ENSCSIRST|ENSELTIMO)
LQISTAT0[0x0] LQISTAT1[0x0] LQISTAT2[0x0] LQOSTAT0[0x0]
LQOSTAT1[0x0] LQOSTAT2[0x0]
SCB Count = 16 CMDS_PENDING = 1 LASTSCB 0xffff CURRSCB 0xf NEXTSCB 0xff80
qinstart = 197 qinfifonext = 198
QINFIFO: 0xf
WAITING_TID_QUEUES:
Pending list:
15 FIFO_USE[0x0] SCB_CONTROL[0x60]:(TAG_ENB|DISCENB) SCB_SCSIID[0x7]
14 FIFO_USE[0x0] SCB_CONTROL[0x64]:(DISCONNECTED|TAG_ENB|DISCENB)
SCB_SCSIID[0x7]
Total 2
Kernel Free SCB list: 1 13 12 11 10 9 8 7 6 5 4 3 2 0
Sequencer Complete DMA-inprog list:
Sequencer Complete list:
Sequencer DMA-Up and Complete list:
Sequencer On QFreeze and Complete list:
ahd0: FIFO0 Free, LONGJMP == 0x8253, SCB 0xf
SEQIMODE[0x3f]:(ENCFG4TCMD|ENCFG4ICMD|ENCFG4TSTAT|ENCFG4ISTAT|ENCFG4DATA|ENSAVEPTRS)
SEQINTSRC[0x0] DFCNTRL[0x0] DFSTATUS[0x89]:(FIFOEMP|HDONE|PRELOAD_AVAIL)
SG_CACHE_SHADOW[0x2]:(LAST_SEG) SG_STATE[0x0] DFFSXFRCTL[0x0]
SOFFCNT[0x0] MDFFSTAT[0x5]:(FIFOFREE|DLZERO) SHADDR = 0x00, SHCNT = 0x0
HADDR = 0x00, HCNT = 0x0 CCSGCTL[0x10]:(SG_CACHE_AVAIL)
ahd0: FIFO1 Free, LONGJMP == 0x8063, SCB 0xf
SEQIMODE[0x3f]:(ENCFG4TCMD|ENCFG4ICMD|ENCFG4TSTAT|ENCFG4ISTAT|ENCFG4DATA|ENSAVEPTRS)
SEQINTSRC[0x0] DFCNTRL[0x4]:(DIRECTION) DFSTATUS[0x89]:(FIFOEMP|HDONE|PRELOAD_AVAIL)
SG_CACHE_SHADOW[0x2]:(LAST_SEG) SG_STATE[0x0] DFFSXFRCTL[0x0]
SOFFCNT[0x0] MDFFSTAT[0x5]:(FIFOFREE|DLZERO) SHADDR = 0x00, SHCNT = 0x0
HADDR = 0x00, HCNT = 0x0 CCSGCTL[0x10]:(SG_CACHE_AVAIL)
LQIN: 0x8 0x0 0x0 0xf 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0
ahd0: LQISTATE = 0x0, LQOSTATE = 0x0, OPTIONMODE = 0x52
ahd0: OS_SPACE_CNT = 0x20 MAXCMDCNT = 0x1
ahd0: SAVED_SCSIID = 0x0 SAVED_LUN = 0x0
SIMODE0[0xc]:(ENOVERRUN|ENIOERR)
CCSCBCTL[0x4]:(CCSCBDIR)
ahd0: REG0 == 0x1, SINDEX = 0x1ba, DINDEX = 0x1ba
ahd0: SCBPTR == 0x1, SCB_NEXT == 0xff00, SCB_NEXT2 == 0xe
CDB 12 0 0 0 24 0
STACK: 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0
<<<<<<<<<<<<<<<<< Dump Card State Ends >>>>>>>>>>>>>>>>>>
ahd0: Someone reset channel A
(da1:ahd0:0:0:0): No or incomplete CDB sent to device.
(da1:ahd0:0:0:0): Protocol violation in Message-in phase. Attempting to abort.
(da1:ahd0:0:0:0): Abort Tag Message Sent
(da1:ahd0:0:0:0): SCB 14 - Abort Completed.
found == 0x1
(da1:ahd0:0:0:0): No or incomplete CDB sent to device.
(da1:ahd0:0:0:0): Protocol violation in Message-in phase. Attempting to abort.
(da1:ahd0:0:0:0): Abort Tag Message Sent
(da1:ahd0:0:0:0): SCB 14 - Abort Completed.
found == 0x1
(da1:ahd0:0:0:0): No or incomplete CDB sent to device.
(da1:ahd0:0:0:0): Protocol violation in Message-in phase. Attempting to abort.
(da1:ahd0:0:0:0): Abort Tag Message Sent
(da1:ahd0:0:0:0): SCB 14 - Abort Completed.
found == 0x1
(da1:ahd0:0:0:0): No or incomplete CDB sent to device.
(da1:ahd0:0:0:0): Protocol violation in Message-in phase. Attempting to abort.
(da1:ahd0:0:0:0): Abort Tag Message Sent
(da1:ahd0:0:0:0): SCB 14 - Abort Completed.
found == 0x1
(da1:ahd0:0:0:0): got CAM status 0x54
(da1:ahd0:0:0:0): fatal error, failed to attach to device
(da1:ahd0:0:0:0): lost device
(da1:ahd0:0:0:0): READ CAPACITY. CDB: 25 0 0 0 0 0 0 0 0 0
(da1:ahd0:0:0:0): CAM Status: SCSI Status Error
(da1:ahd0:0:0:0): SCSI Status: Check Condition
(da1:ahd0:0:0:0): UNIT ATTENTION asc:29,0
(da1:ahd0:0:0:0): Power on, reset, or bus device reset occurred
(da1:ahd0:0:0:0): Retrying Command (per Sense Data)
(da1:ahd0:0:0:0): No or incomplete CDB sent to device.
(da1:ahd0:0:0:0): Protocol violation in Message-in phase. Attempting to abort.
(da1:ahd0:0:0:0): Abort Tag Message Sent
(da1:ahd0:0:0:0): SCB 14 - Abort Completed.
found == 0x1
(da1:ahd0:0:0:0): No or incomplete CDB sent to device.
(da1:ahd0:0:0:0): Protocol violation in Message-in phase. Attempting to abort.
(da1:ahd0:0:0:0): Abort Tag Message Sent
(da1:ahd0:0:0:0): SCB 14 - Abort Completed.
found == 0x1
(da1:ahd0:0:0:0): No or incomplete CDB sent to device.
(da1:ahd0:0:0:0): Protocol violation in Message-in phase. Attempting to abort.
(da1:ahd0:0:0:0): Abort Tag Message Sent
(da1:ahd0:0:0:0): SCB 14 - Abort Completed.
found == 0x1
(da1:ahd0:0:0:0): No or incomplete CDB sent to device.
(da1:ahd0:0:0:0): Protocol violation in Message-in phase. Attempting to abort.
(da1:ahd0:0:0:0): Abort Tag Message Sent
(da1:ahd0:0:0:0): SCB 14 - Abort Completed.
found == 0x1
(da1:ahd0:0:0:0): No or incomplete CDB sent to device.
(da1:ahd0:0:0:0): Protocol violation in Message-in phase. Attempting to abort.
(da1:ahd0:0:0:0): Abort Tag Message Sent
(da1:ahd0:0:0:0): SCB 14 - Abort Completed.
found == 0x1
(da1:ahd0:0:0:0): removing device entry
Opened disk da1 -> 5
--4SFOXa2GPu3tIq4H--
Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?20070817224628.GI99491>