Date: Sun, 13 Oct 2002 05:58:03 +0000 (GMT) From: Daniel Flickinger <attila@hun.org> To: Poul-Henning Kamp <phk@critter.freebsd.dk> Cc: FreeBSD-CURRENT <current@freebsd.org> Subject: GEOM/SCSI auto-sense failures and timeouts Message-ID: <20021013055803.mlMl18750@hun.org>
next in thread | raw e-mail | index | archive | help
After 07 Oct, and the upgrading of the aic7899 code, the
aic7899 started working, showing both channels as ahc0
and ahc1 in the probe stage, and the devices on both
channels after the 'waiting for SCSI to settle'
message. At that point I was also able to enable GEOM
without problems, and dispense with the Tekram DC395
controller whose driver definitely was not GEOM
compatible.
Good work!
1. there is a problem with the auto-sense and timeouts
listed below. They appear a couple times per day. There
are no date stamps, but there are times when disk
activity is high. I had not seen them before GEOM. The
error message and the dmesg listing follows.
2. the disappearance of cd0a/c... I use a Creative
DVDRAM for storage/archiving. It sure beats tape as it
is random access and it's cheap: <$3/GB, fully reusable,
portable, and easy to store. I format the disks UFS and
drop 10-300 MB .tbz files on it. Mounting it to cd0
seems to be OK, but a little bizarre. Loss of the a-h
partitions has orphaned a few disks, including one with
a bootable full live filesystem, but it's no big loss,
it was already obsolete. Just don't blow away SCSI RW
completely!
(da1:ahc0:0:1:0): AutoSense Failed
(da1:ahc0:0:1:0): SCB 0x24 - timed out
ahc0: Dumping Card State while idle, at SEQADDR 0x8
ACCUM = 0x0, SINDEX = 0x61, DINDEX = 0xe4, ARG_2 = 0x0
HCNT = 0x0 SCBPTR = 0xe
SCSISEQ = 0x12, SBLKCTL = 0xa
DFCNTRL = 0x0, DFSTATUS = 0x89
LASTPHASE = 0x1, SCSISIGI = 0x0, SXFRCTL0 = 0x80
SSTAT0 = 0x0, SSTAT1 = 0x8
SCSIPHASE = 0x0
STACK == 0x0, 0x160, 0x108, 0x3
SCB count = 130
Kernel NEXTQSCB = 44
Card NEXTQSCB = 44
QINFIFO entries:
Waiting Queue entries:
Disconnected Queue entries: 0:14 3:11 4:80 22:66 23:86 15:128 19:23 21:98 24:125 30:9 5:105 7:103 6:106 2:7 31:41 27:96 26:21 8:3 29:122 1:123 12:116 9:58 13:0 11:46 20:118 16:29 28:79 18:6 17:113 25:102 10:36
QOUTFIFO entries:
Sequencer Free SCB List: 14
Sequencer SCB Info: 0(c 0x64, s 0x17, l 0, t 0xe) 1(c 0x64, s 0x17, l 0, t 0x7b) 2(c 0x64, s 0x17, l 0, t 0x7) 3(c 0x64, s 0x17, l 0, t 0xb) 4(c 0x64, s 0x17, l 0, t 0x50) 5(c 0x64, s 0x17, l 0, t 0x69) 6(c 0x64, s 0x17, l 0, t 0x6a) 7(c 0x64, s 0x17, l 0, t 0x67) 8(c 0x64, s 0x17, l 0, t 0x3) 9(c 0x64, s 0x17, l 0, t 0x3a) 10(c 0x64, s 0x17, l 0, t 0x24) 11(c 0x64, s 0x17, l 0, t 0x2e) 12(c 0x64, s 0x17, l 0, t 0x74) 13(c 0x64, s 0x17, l 0, t 0x0) 14(c 0x60, s 0x7, l 0, t 0xff) 15(c 0x64, s 0x17, l 0, t 0x80) 16(c 0x64, s 0x17, l 0, t 0x1d) 17(c 0x64, s 0x17, l 0, t 0x71) 18(c 0x64, s 0x17, l 0, t 0x6) 19(c 0x64, s 0x17, l 0, t 0x17) 20(c 0x64, s 0x17, l 0, t 0x76) 21(c 0x64, s 0x17, l 0, t 0x62) 22(c 0x64, s 0x17, l 0, t 0x42) 23(c 0x64, s 0x17, l 0, t 0x56) 24(c 0x64, s 0x17, l 0, t 0x7d) 25(c 0x64, s 0x17, l 0, t 0x66) 26(c 0x64, s 0x17, l 0, t 0x15) 27(c 0x64, s 0x17, l 0, t 0x60) 28(c 0x64, s 0x17, l 0, t 0x4f) 29(c 0x64, s 0x17, l 0, t 0x7a) 30(c 0x64, s 0x17, l 0, t
0x9) 31(c 0x64, s 0x17, l 0, t 0x29)
Pending list: 68(c 0x64, s 0x17, l 0), 1(c 0x64, s 0x17, l 0), 93(c 0x64, s 0x17, l 0), 92(c 0x64, s 0x17, l 0), 59(c 0x64, s 0x17, l 0), 15(c 0x64, s 0x17, l 0), 115(c 0x64, s 0x17, l 0), 99(c 0x64, s 0x17, l 0), 104(c 0x64, s 0x17, l 0), 78(c 0x64, s 0x17, l 0), 19(c 0x64, s 0x17, l 0), 90(c 0x64, s 0x17, l 0), 4(c 0x64, s 0x17, l 0), 35(c 0x64, s 0x17, l 0), 64(c 0x64, s 0x17, l 0), 124(c 0x64, s 0x17, l 0), 33(c 0x64, s 0x17, l 0), 52(c 0x64, s 0x17, l 0), 8(c 0x64, s 0x17, l 0), 50(c 0x64, s 0x17, l 0), 110(c 0x64, s 0x17, l 0), 95(c 0x64, s 0x17, l 0), 88(c 0x64, s 0x17, l 0), 17(c 0x64, s 0x17, l 0), 24(c 0x64, s 0x17, l 0), 40(c 0x64, s 0x17, l 0), 47(c 0x64, s 0x17, l 0), 31(c 0x64, s 0x17, l 0), 117(c 0x64, s 0x17, l 0), 121(c 0x64, s 0x17, l 0), 45(c 0x64, s 0x17, l 0), 49(c 0x64, s 0x17, l 0), 42(c 0x64, s 0x17, l 0), 114(c 0x64, s 0x17, l 0), 101(c 0x64, s 0x17, l 0), 75(c 0x64, s 0x17, l 0), 32(c 0x64, s 0x17, l 0), 48(c 0x64, s 0x17, l 0), 72(c 0x64, s 0x17,
l 0), 65(c 0x64, s 0x17, l 0), 89(c 0x64, s 0x17, l 0), 38(c 0x64, s 0x17, l 0), 16(c 0x64, s 0x17, l 0), 120(c 0x64, s 0x17, l 0), 67(c 0x64, s 0x17, l 0), 37(c 0x64, s 0x17, l 0), 81(c 0x64, s 0x17, l 0), 111(c 0x64, s 0x17, l 0), 39(c 0x64, s 0x17, l 0), 13(c 0x64, s 0x17, l 0), 109(c 0x64, s 0x17, l 0), 53(c 0x64, s 0x17, l 0), 22(c 0x64, s 0x17, l 0), 119(c 0x64, s 0x17, l 0), 28(c 0x64, s 0x17, l 0), 18(c 0x64, s 0x17, l 0), 83(c 0x64, s 0x17, l 0), 91(c 0x64, s 0x17, l 0), 87(c 0x64, s 0x17, l 0), 62(c 0x64, s 0x17, l 0), 55(c 0x64, s 0x17, l 0), 56(c 0x64, s 0x17, l 0), 85(c 0x64, s 0x17, l 0), 26(c 0x64, s 0x17, l 0), 126(c 0x64, s 0x17, l 0), 77(c 0x64, s 0x17, l 0), 43(c 0x64, s 0x17, l 0), 82(c 0x64, s 0x17, l 0), 112(c 0x64, s 0x17, l 0), 129(c 0x64, s 0x17, l 0), 10(c 0x64, s 0x17, l 0), 69(c 0x64, s 0x17, l 0), 107(c 0x64, s 0x17, l 0), 25(c 0x64, s 0x17, l 0), 94(c 0x64, s 0x17, l 0), 57(c 0x64, s 0x17, l 0), 34(c 0x64, s 0x17, l 0), 60(c 0x64, s 0x17, l 0),
108(c 0x64, s 0x17, l 0), 76(c 0x64, s 0x17, l 0), 51(c 0x64, s 0x17,
l 0), 20(c 0x64, s 0x17, l 0), 30(c 0x64, s 0x17, l 0), 54(c 0x64, s 0x17, l 0), 61(c 0x64, s 0x17, l 0), 127(c 0x64, s 0x17, l 0), 100(c 0x64, s 0x17, l 0), 14(c 0x60, s 0x17, l 0), 27(c 0x64, s 0x17, l 0), 71(c 0x64, s 0x17, l 0), 5(c 0x64, s 0x17, l 0), 74(c 0x64, s 0x17, l 0), 63(c 0x64, s 0x17, l 0), 84(c 0x64, s 0x17, l 0), 70(c 0x64, s 0x17, l 0), 12(c 0x64, s 0x17, l 0), 73(c 0x64, s 0x17, l 0), 2(c 0x64, s 0x17, l 0), 11(c 0x60, s 0x17, l 0), 80(c 0x60, s 0x17, l 0), 66(c 0x60, s 0x17, l 0), 86(c 0x60, s 0x17, l 0), 128(c 0x60, s 0x17, l 0), 23(c 0x60, s 0x17, l 0), 98(c 0x60, s 0x17, l 0), 125(c 0x60, s 0x17, l 0), 9(c 0x60, s 0x17, l 0), 105(c 0x60, s 0x17, l 0), 103(c 0x60, s 0x17, l 0), 106(c 0x60, s 0x17, l 0), 7(c 0x60, s 0x17, l 0), 41(c 0x60, s 0x17, l 0), 96(c 0x60, s 0x17, l 0), 21(c 0x60, s 0x17, l 0), 3(c 0x60, s 0x17, l 0), 122(c 0x60, s 0x17, l 0), 123(c 0x60, s 0x17, l 0), 116(c 0x60, s 0x17, l 0), 58(c 0x60, s 0x17, l 0), 0(c 0x60, s 0x17, l 0), 46(c
0x60, s 0x17, l 0), 118(c 0x60, s 0x17, l 0), 29(c 0x60, s 0x17, l 0), 79(c 0x60, s 0x17, l 0), 6(c 0x60, s 0x17, l 0), 113(c 0x60, s 0x17, l 0), 102(c 0x60, s 0x17, l 0), 36(c 0x60, s 0x17, l 0)
Kernel Free SCB list: 97
sg[0] - Addr 0x19ea1000 : Length 4096
sg[1] - Addr 0x26a2000 : Length 4096
(da1:ahc0:0:1:0): Queuing a BDR SCB
(da1:ahc0:0:1:0): Bus Device Reset Message Sent
(da1:ahc0:0:1:0): no longer in timeout, status = 34b
ahc0: Bus Device Reset on A:1. 128 SCBs aborted
(da1:ahc0:0:1:0): WRITE(10). CDB: 2a 0 1 9 a3 8f 0 0 10 0
(da1:ahc0:0:1:0): CAM Status: SCSI Status Error
(da1:ahc0:0:1:0): SCSI Status: Check Condition
(da1:ahc0:0:1:0): UNIT ATTENTION asc:29,3
(da1:ahc0:0:1:0): Bus device reset function occurred
(da1:ahc0:0:1:0): Retrying Command (per Sense Data)
---- dmesg -----
Copyright (c) 1992-2002 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.0-CURRENT #117: 11 Oct 2002 0000 GMT
root@hun.org:/usr/obj/usr/src/sys/hun
Preloaded elf kernel "/boot/kernel/kernel" at 0xc08be000.
Preloaded mfs_root "/boot/mfsroot" at 0xc08be0b4.
Preloaded elf module "/boot/kernel/acpi.ko" at 0xc08be0f8.
Timecounter "i8254" frequency 1193182 Hz
CPU: AMD Athlon(tm) Processor (1194.68-MHz 686-class CPU)
Origin = "AuthenticAMD" Id = 0x662 Stepping = 2
Features=0x383fbff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,MMX,FXSR,SSE>
AMD Features=0xffffffffc0480000<MP,AMIE,DSP,3DNow!>
real memory = 536805376 (524224K bytes)
avail memory = 512040960 (500040K bytes)
Programming 24 pins in IOAPIC #0
IOAPIC #0 intpin 2 -> irq 0
FreeBSD/SMP: Multiprocessor System Detected: 2 CPUs
cpu0 (BSP): apic id: 1, version: 0x00040010, at 0xfee00000
cpu1 (AP): apic id: 0, version: 0x00040010, at 0xfee00000
io0 (APIC): apic id: 2, version: 0x00170011, at 0xfec00000
Pentium Pro MTRR support enabled
md0: Preloaded image </boot/mfsroot> 4423680 bytes at 0xc043be04
Initializing GEOMetry subsystem
npx0: <math processor> on motherboard
npx0: INT 16 interface
acpi0: <PTLTD RSDT > on motherboard
acpi0: power button is handled as a fixed feature programming model.
acpi0: sleep button is handled as a fixed feature programming model.
Timecounter "ACPI-fast" frequency 3579545 Hz
acpi_timer0: <24-bit timer at 3.579545MHz> port 0x8008-0x800b on acpi0
acpi_cpu0: <CPU> on acpi0
acpi_cpu1: <CPU> on acpi0
acpi_button0: <Power Button> on acpi0
pcib0: <ACPI Host-PCI bridge> port 0x8080-0x80ff,0x8000-0x807f,0xcf8-0xcff iomem 0xdc000-0xdffff on acpi0
---- initial configuration ------------------------
---- before setting priority for links ------------
---- before fixup boot-disabled links -------------
---- after fixup boot-disabled links --------------
---- arbitrated configuration ---------------------
pci0: <ACPI PCI bus> on pcib0
agp0: <AMD 762 host to AGP bridge> port 0x1c10-0x1c13 mem 0xf4004000-0xf4004fff,0xf8000000-0xfbffffff at device 0.0 on pci0
pcib1: <ACPI PCI-PCI bridge> at device 1.0 on pci0
---- initial configuration ------------------------
---- before setting priority for links ------------
---- before fixup boot-disabled links -------------
---- after fixup boot-disabled links --------------
---- arbitrated configuration ---------------------
pci1: <ACPI PCI bus> on pcib1
pci1: <display, VGA> at device 5.0 (no driver attached)
isab0: <PCI-ISA bridge> at device 7.0 on pci0
isa0: <ISA bus> on isab0
pci0: <mass storage, ATA> at device 7.1 (no driver attached)
pci0: <bridge, PCI-unknown> at device 7.3 (no driver attached)
pci0: <serial bus, USB> at device 7.4 (no driver attached)
ahc0: <Adaptec aic7899 Ultra160 SCSI adapter> port 0x1000-0x10ff mem 0xf4001000-0xf4001fff irq 10 at device 13.0 on pci0
aic7899: Ultra160 Wide Channel A, SCSI Id=7, 32/253 SCBs
ahc1: <Adaptec aic7899 Ultra160 SCSI adapter> port 0x1400-0x14ff mem 0xf4002000-0xf4002fff irq 11 at device 13.1 on pci0
aic7899: Ultra160 Wide Channel B, SCSI Id=7, 32/253 SCBs
xl0: <3Com 3c980C Fast Etherlink XL> port 0x1800-0x187f mem 0xf4003000-0xf400307f irq 5 at device 15.0 on pci0
xl0: Ethernet address: 00:e0:81:03:e2:89
miibus0: <MII bus> on xl0
ukphy0: <Generic IEEE 802.3u media interface> on miibus0
ukphy0: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto
xl1: <3Com 3c980C Fast Etherlink XL> port 0x1880-0x18ff mem 0xf4003400-0xf400347f irq 11 at device 16.0 on pci0
xl1: Ethernet address: 00:e0:81:03:e2:8a
miibus1: <MII bus> on xl1
ukphy1: <Generic IEEE 802.3u media interface> on miibus1
ukphy1: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto
atspeaker0 port 0x61 on acpi0
atkbdc0: <Keyboard controller (i8042)> port 0x64,0x60 irq 1 on acpi0
atkbd0: <AT Keyboard> flags 0x1 irq 1 on atkbdc0
kbd0 at atkbd0
psm0: <PS/2 Mouse> irq 12 on atkbdc0
psm0: model Generic PS/2 mouse, device ID 0
sio0 port 0x3f8-0x3ff irq 4 on acpi0
sio0: type 16550A
ppc0 port 0x778-0x77f,0x378-0x37f irq 7 drq 3 on acpi0
ppc0: Generic chipset (NIBBLE-only) in COMPATIBLE mode
lpt0: <Printer> on ppbus0
lpt0: Interrupt-driven port
fdc0: <enhanced floppy controller (i82077, NE72065 or clone)> port 0x3f7,0x3f0-0x3f5 irq 6 drq 2 on acpi0
fdc0: FIFO enabled, 8 bytes threshold
fd0: <1440-KB 3.5" drive> on fdc0 drive 0
orm0: <Option ROMs> at iomem 0xe0000-0xe3fff,0xce000-0xce7ff,0xcd800-0xcdfff,0xc0000-0xc7fff on isa0
sc0: <System console> on isa0
sc0: VGA <12 virtual consoles, flags=0x200>
vga0: <Generic ISA VGA> at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0
sio1 at port 0x2f8-0x2ff irq 3 on isa0
sio1: type 16550A
Timecounters tick every 10.000 msec
APIC_IO: Testing 8254 interrupt delivery
APIC_IO: routing 8254 via IOAPIC #0 intpin 2
ipfw2 initialized, divert enabled, rule-based forwarding enabled, default to accept, logging limited to 100 packets/entry by default
DUMMYNET initialized (011031)
BRIDGE 020214 loaded
IPsec: Initialized Security Association Processing.
IP Filter: v3.4.29 initialized. Default = pass all, Logging = enabled
Waiting 3 seconds for SCSI devices to settle
SMP: AP CPU #1 Launched!
Mounting root from ufs:/dev/da0a
cd0 at ahc1 bus 0 target 6 lun 0
cd0: <CREATIVE DVD-RAM RAM1216S 1311> Removable CD-ROM SCSI-2 device
cd0: 10.000MB/s transfers (10.000MHz, offset 15)
cd0: cd present [1218960 x 2048 byte records]
da0 at ahc0 bus 0 target 0 lun 0
da0: <IBM DDYS-T09170N S96H> Fixed Direct Access SCSI-3 device
da0: 160.000MB/s transfers (80.000MHz, offset 63, 16bit), Tagged Queueing Enabled
da0: 8748MB (17916240 512 byte sectors: 255H 63S/T 1115C)
da1 at ahc0 bus 0 target 1 lun 0
da1: <IBM DDYS-T09170N S96H> Fixed Direct Access SCSI-3 device
da1: 160.000MB/s transfers (80.000MHz, offset 63, 16bit), Tagged Queueing Enabled
da1: 8748MB (17916240 512 byte sectors: 255H 63S/T 1115C)
da2 at ahc1 bus 0 target 5 lun 0
da2: <IOMEGA ZIP 100 N*32> Removable Direct Access SCSI-2 device
da2: 3.300MB/s transfers
da2: 96MB (196608 512 byte sectors: 64H 32S/T 96C)
Invalid time in real time clock.
Check and reset the date immediately!
To Unsubscribe: send mail to majordomo@FreeBSD.org
with "unsubscribe freebsd-current" in the body of the message
Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?20021013055803.mlMl18750>