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>