From owner-freebsd-stable Tue Mar 20 9:26: 1 2001 Delivered-To: freebsd-stable@freebsd.org Received: from postal.incyte.com (postal.incyte.com [198.31.37.2]) by hub.freebsd.org (Postfix) with ESMTP id 8E43337B72A for ; Tue, 20 Mar 2001 09:25:52 -0800 (PST) (envelope-from bl@incyte.com) Received: from blah.incyte.com (blah.incyte.com [10.99.1.40]) by postal.incyte.com (8.11.1/8.11.1) with ESMTP id f2KHPoM14794 for ; Tue, 20 Mar 2001 09:25:50 -0800 (PST) Received: from blah.incyte.com (bl@localhost) by blah.incyte.com (8.9.1a/8.9.1) with ESMTP id JAA04278 for ; Tue, 20 Mar 2001 09:25:51 -0800 (PST) Message-Id: <200103201725.JAA04278@blah.incyte.com> X-Authentication-Warning: blah.incyte.com: bl owned process doing -bs To: freebsd-stable@freebsd.org Subject: ahc - Invalidating pack Date: Tue, 20 Mar 2001 09:25:51 -0800 From: "Brett G. Lemoine" Sender: owner-freebsd-stable@FreeBSD.ORG Precedence: bulk X-Loop: FreeBSD.ORG OK, I need help. I'm starting to suspect either FreeBSD just doesn't like my motherboard (a Tyan S1837 Thunderbolt), or that I've got a flaky on-board scsi controller. I've been getting the following errors on both my internal disks (and ocasionally on my jaz drive as well): I note that in the code (cam/scsi/scsi_da.c), that this is a 'catastrophic error'. The error messages appear to be coming from ahc_timeout in dev/aic7xxx/aic7xxx_freebsd.c, but I'm not familure enough with the code (or PC hardware for that matter) to determine why. Can someone help me determine what I need to do to more conclusively pin this on the on-board scsi controller (or if it's not that, determine what the problem is)? FWIW, I'm running 4.3-BETA updated as of yesterday afternoon with an _unchanged_ GENERIC kernel. boot dmesg is below the errors. Thanks for any assistance you can provide. A few days ago -- jaz drive: Mar 16 18:10:00 blur /kernel: (da2:ahc1:0:6:0): SCB 0x3 - timed out in Data-out phase, SEQADDR == 0x8 Mar 16 18:10:00 blur /kernel: STACK == 0x3, 0x110, 0x166, 0x0 Mar 16 18:10:00 blur /kernel: SXFRCTL0 == 0x80 Mar 16 18:10:00 blur /kernel: ahc1: Dumping Card State at SEQADDR 0x8 Mar 16 18:10:00 blur /kernel: SCSISEQ = 0x12, SBLKCTL = 0x6, SSTAT0 0x0 Mar 16 18:10:00 blur /kernel: SCB count = 20 Mar 16 18:10:00 blur /kernel: Kernel NEXTQSCB = 4 Mar 16 18:10:00 blur /kernel: Card NEXTQSCB = 4 Mar 16 18:10:00 blur /kernel: QINFIFO entries: Mar 16 18:10:00 blur /kernel: Waiting Queue entries: Mar 16 18:10:00 blur /kernel: Disconnected Queue entries: 0:3 Mar 16 18:10:00 blur /kernel: QOUTFIFO entries: Mar 16 18:10:00 blur /kernel: Sequencer Free SCB List: 1 2 3 4 5 6 7 8 9 10 11 1 2 13 14 15 16 17 18 19 20 21 22 23 24 25 26 27 28 29 30 31 Mar 16 18:10:00 blur /kernel: Pending list: 3 Mar 16 18:10:00 blur /kernel: Kernel Free SCB list: 14 15 16 17 18 19 0 1 2 5 6 7 8 9 13 12 11 10 Mar 16 18:10:01 blur /kernel: Untagged Q(6): 3 Mar 16 18:10:01 blur /kernel: sg[0] - Addr 0xca3a900 : Length 8 Mar 16 18:10:01 blur /kernel: (da2:ahc1:0:6:0): Queuing a BDR SCB Mar 16 18:10:01 blur /kernel: (da2:ahc1:0:6:0): Bus Device Reset Message Sent Mar 16 18:10:01 blur /kernel: (da2:ahc1:0:6:0): no longer in timeout, status = 3 4b Mar 16 18:10:01 blur /kernel: ahc1: Bus Device Reset on A:6. 1 SCBs aborted Yesterday -- root disk: Mar 19 15:02:40 blur /kernel: (da0:ahc0:0:0:0): Invalidating pack Mar 19 15:03:41 blur /kernel: Kernel NEXTQSCB = 19 Mar 19 15:03:41 blur /kernel: (da0:ahc0:0:0:0): SCB 94: Immediate reset. Flags = 0x4040 Mar 19 15:07:11 blur /kernel: nread: 0, reqpage: 0, pindex: 0, pcount: 14 Today -- other disk: Mar 20 09:56:48 blur /kernel: (da1:ahc0:0:1:0): Invalidating pack Mar 20 09:57:48 blur /kernel: (da1:ahc0:0:1:0): SCB 0x80 - timed out while idle, SEQADDR == 0x8 Mar 20 09:57:48 blur /kernel: STACK == 0x3, 0x110, 0x166, 0x0 Mar 20 09:57:48 blur /kernel: SXFRCTL0 == 0x80 Mar 20 09:57:48 blur /kernel: ahc0: Dumping Card State at SEQADDR 0x8 Mar 20 09:57:48 blur /kernel: SCSISEQ = 0x12, SBLKCTL = 0xa, SSTAT0 0x0 Mar 20 09:57:48 blur /kernel: SCB count = 130 Mar 20 09:57:48 blur /kernel: Kernel NEXTQSCB = 67 Mar 20 09:57:48 blur /kernel: Card NEXTQSCB = 67 Mar 20 09:57:48 blur /kernel: QINFIFO entries: Mar 20 09:57:48 blur /kernel: Waiting Queue entries: Mar 20 09:57:48 blur /kernel: Disconnected Queue entries: 0:105 7:127 24:128 Mar 20 09:57:48 blur /kernel: QOUTFIFO entries: Mar 20 09:57:48 blur /kernel: Sequencer Free SCB List: 17 5 15 4 29 12 9 25 23 3 1 13 19 20 11 28 30 27 16 6 2 14 3 1 26 22 8 21 10 18 Mar 20 09:57:48 blur /kernel: Pending list: 105 127 128 Mar 20 09:57:48 blur /kernel: Kernel Free SCB list: 18 100 93 102 109 114 2 129 123 44 11 110 82 1 117 115 119 4 40 66 52 16 104 31 101 92 116 126 112 53 30 15 55 113 29 124 12 9 58 25 111 21 103 108 118 54 20 28 39 10 0 125 120 6 26 51 69 50 47 32 106 59 7 42 68 37 46 8 33 3 17 48 56 41 5 35 24 27 57 23 19 91 43 34 10 7 49 14 36 13 45 22 38 121 122 90 94 95 96 97 98 99 80 81 64 63 62 61 60 79 78 7 7 76 75 74 73 72 71 70 89 88 87 86 85 84 83 65 Mar 20 09:57:48 blur /kernel: sg[0] - Addr 0x9387c00 : Length 1024 Mar 20 09:57:48 blur /kernel: (da1:ahc0:0:1:0): Queuing a BDR SCB Mar 20 09:57:48 blur /kernel: (da1:ahc0:0:1:0): no longer in timeout, status = 3 4a Mar 20 09:57:48 blur /kernel: (da1:ahc0:0:1:0): Invalidating pack Mar 20 09:58:48 blur /kernel: (da1:ahc0:0:1:0): SCB 0x69 - timed out while idle, SEQADDR == 0x8 Mar 20 09:58:48 blur /kernel: STACK == 0x3, 0x110, 0x166, 0x0 Mar 20 09:58:48 blur /kernel: SXFRCTL0 == 0x80 Mar 20 09:58:48 blur /kernel: ahc0: Dumping Card State at SEQADDR 0x8 Mar 20 09:58:48 blur /kernel: SCSISEQ = 0x12, SBLKCTL = 0xa, SSTAT0 0x0 Mar 20 09:58:48 blur /kernel: SCB count = 130 Mar 20 09:58:48 blur /kernel: Kernel NEXTQSCB = 67 Mar 20 09:58:48 blur /kernel: Card NEXTQSCB = 67 Mar 20 09:58:48 blur /kernel: QINFIFO entries: Mar 20 09:58:48 blur /kernel: Waiting Queue entries: Mar 20 09:58:48 blur /kernel: Disconnected Queue entries: 0:105 7:127 Mar 20 09:58:48 blur /kernel: QOUTFIFO entries: Mar 20 09:58:48 blur /kernel: Sequencer Free SCB List: 24 17 5 15 4 29 12 9 25 2 3 31 13 19 20 11 28 30 27 16 6 2 14 3 1 26 22 8 21 10 18 Mar 20 09:58:48 blur /kernel: Pending list: 105 127 Mar 20 09:58:48 blur /kernel: Kernel Free SCB list: 18 128 100 93 102 109 114 2 129 123 44 11 110 82 1 117 115 119 4 40 66 52 16 104 31 101 92 116 126 112 53 30 15 55 113 29 124 12 9 58 25 111 21 103 108 118 54 20 28 39 10 0 125 120 6 26 51 69 50 47 32 106 59 7 42 68 37 46 8 33 3 17 48 56 41 5 35 24 27 57 23 19 91 43 3 4 107 49 14 36 13 45 22 38 121 122 90 94 95 96 97 98 99 80 81 64 63 62 61 60 79 78 77 76 75 74 73 72 71 70 89 88 87 86 85 84 83 65 Mar 20 09:58:48 blur /kernel: sg[0] - Addr 0x1b6d8000 : Length 4096 Mar 20 09:58:48 blur /kernel: sg[1] - Addr 0x22a59000 : Length 4096 Mar 20 09:58:48 blur /kernel: sg[2] - Addr 0x27eba000 : Length 4096 Mar 20 09:58:48 blur /kernel: sg[3] - Addr 0x205db000 : Length 4096 Mar 20 09:58:48 blur /kernel: sg[4] - Addr 0x1b45c000 : Length 4096 Mar 20 09:58:48 blur /kernel: sg[5] - Addr 0x237fd000 : Length 4096 Mar 20 09:58:48 blur /kernel: sg[6] - Addr 0x1fade000 : Length 4096 Mar 20 09:58:48 blur /kernel: sg[7] - Addr 0x24b7f000 : Length 4096 Mar 20 09:58:48 blur /kernel: sg[8] - Addr 0x26aa0000 : Length 4096 Mar 20 09:58:48 blur /kernel: sg[9] - Addr 0x28e21000 : Length 4096 Mar 20 09:58:48 blur /kernel: sg[10] - Addr 0x27682000 : Length 4096 Mar 20 09:58:48 blur /kernel: sg[11] - Addr 0x24c03000 : Length 4096 Mar 20 09:58:48 blur /kernel: sg[12] - Addr 0x260c4000 : Length 4096 Mar 20 09:58:48 blur /kernel: sg[13] - Addr 0x1b6a5000 : Length 4096 Mar 20 09:58:48 blur /kernel: sg[14] - Addr 0x27426000 : Length 4096 Mar 20 09:58:48 blur /kernel: sg[15] - Addr 0x24e27000 : Length 4096 Mar 20 09:58:48 blur /kernel: (da1:ahc0:0:1:0): Queuing a BDR SCB Mar 20 09:58:48 blur /kernel: (da1:ahc0:0:1:0): no longer in timeout, status = 3 4a Mar 20 09:58:48 blur /kernel: (da1:ahc0:0:1:0): Invalidating pack Mar 20 09:59:48 blur /kernel: (da1:ahc0:0:1:0): SCB 0x7f - timed out while idle, SEQADDR == 0x8 Mar 20 09:59:48 blur /kernel: STACK == 0x3, 0x110, 0x166, 0x0 Mar 20 09:59:48 blur /kernel: SXFRCTL0 == 0x80 Mar 20 09:59:48 blur /kernel: ahc0: Dumping Card State at SEQADDR 0x8 Mar 20 09:59:48 blur /kernel: SCSISEQ = 0x12, SBLKCTL = 0xa, SSTAT0 0x0 Mar 20 09:59:48 blur /kernel: SCB count = 130 Mar 20 09:59:48 blur /kernel: Kernel NEXTQSCB = 93 Mar 20 09:59:48 blur /kernel: Card NEXTQSCB = 93 Mar 20 09:59:48 blur /kernel: QINFIFO entries: Mar 20 09:59:48 blur /kernel: Waiting Queue entries: Mar 20 09:59:48 blur /kernel: Disconnected Queue entries: 7:127 Mar 20 09:59:48 blur /kernel: QOUTFIFO entries: Mar 20 09:59:48 blur /kernel: Sequencer Free SCB List: 15 4 5 17 24 0 29 12 9 25 23 31 13 19 20 11 28 30 27 16 6 2 14 3 1 26 22 8 21 10 18 Mar 20 09:59:48 blur /kernel: Pending list: 127 Mar 20 09:59:48 blur /kernel: Kernel Free SCB list: 100 102 128 18 105 67 109 11 4 2 129 123 44 11 110 82 1 117 115 119 4 40 66 52 16 104 31 101 92 116 126 112 5 3 30 15 55 113 29 124 12 9 58 25 111 21 103 108 118 54 20 28 39 10 0 125 120 6 2 6 51 69 50 47 32 106 59 7 42 68 37 46 8 33 3 17 48 56 41 5 35 24 27 57 23 19 91 43 34 107 49 14 36 13 45 22 38 121 122 90 94 95 96 97 98 99 80 81 64 63 62 61 60 79 78 77 76 75 74 73 72 71 70 89 88 87 86 85 84 83 65 Mar 20 09:59:48 blur /kernel: sg[0] - Addr 0x271b2000 : Length 2048 Mar 20 09:59:48 blur /kernel: (da1:ahc0:0:1:0): Queuing a BDR SCB Mar 20 09:59:48 blur /kernel: (da1:ahc0:0:1:0): no longer in timeout, status = 3 4a Mar 20 09:59:48 blur /kernel: (da1:ahc0:0:1:0): Invalidating pack Copyright (c) 1992-2001 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 4.3-BETA #0: Mon Mar 19 16:49:41 CST 2001 root@blur.unixshaman.com:/usr/local/obj/usr/src/sys/GENERIC Timecounter "i8254" frequency 1193182 Hz CPU: Pentium III/Pentium III Xeon/Celeron (751.71-MHz 686-class CPU) Origin = "GenuineIntel" Id = 0x681 Stepping = 1 Features=0x383fbff real memory = 1073741824 (1048576K bytes) config> di sn0 config> di lnc0 config> di ie0 config> di fe0 config> di ed0 config> di cs0 config> di bt0 config> di aic0 config> di aha0 config> di adv0 config> q avail memory = 1041444864 (1017036K bytes) Preloaded elf kernel "kernel" at 0xc044c000. Preloaded userconfig_script "/boot/kernel.conf" at 0xc044c09c. Pentium Pro MTRR support enabled md0: Malloc disk npx0: on motherboard npx0: INT 16 interface pcib0: on motherboard pci0: on pcib0 pcib2: at device 1.0 on pci0 pci1: on pcib2 pcib3: at device 1.0 on pci1 pci2: on pcib3 pci2: at 1.0 pci2: at 2.0 pci2: at 3.0 pci2: at 4.0 isab0: at device 7.0 on pci0 isa0: on isab0 atapci0: port 0xffa0-0xffaf at device 7.1 on pci0 ata0: at 0x1f0 irq 14 on atapci0 ata1: at 0x170 irq 15 on atapci0 uhci0: port 0xef80-0xef9f irq 11 at device 7.2 on pci0 usb0: 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 chip1: port 0x440-0x44f at device 7.3 on pci0 ahc0: port 0xe400-0xe4ff mem 0xfebfe000-0xfebfefff irq 10 at device 11.0 on pci0 aic7896/97: Wide Channel A, SCSI Id=7, 32/255 SCBs ahc1: port 0xe800-0xe8ff mem 0xfebff000-0xfebfffff irq 10 at device 11.1 on pci0 aic7896/97: Wide Channel B, SCSI Id=7, 32/255 SCBs pci0: (vendor=0x1274, dev=0x1371) at 12.0 irq 9 fxp0: port 0xee80-0xeebf mem 0xfea00000-0xfeafffff,0xfebfd000-0xfebfdfff irq 11 at device 13.0 on pci0 fxp0: Ethernet address 00:e0:81:10:c9:0e fxp1: port 0xed80-0xedbf mem 0xfe800000-0xfe8fffff,0xfebfc000-0xfebfcfff irq 5 at device 17.0 on pci0 fxp1: Ethernet address 00:d0:b7:73:39:03 pcib1: on motherboard pci3: on pcib1 fdc0: at port 0x3f0-0x3f5,0x3f7 irq 6 drq 2 on isa0 fdc0: FIFO enabled, 8 bytes threshold fd0: <1440-KB 3.5" drive> on fdc0 drive 0 atkbdc0: at port 0x60,0x64 on isa0 atkbd0: flags 0x1 irq 1 on atkbdc0 kbd0 at atkbd0 psm0: irq 12 on atkbdc0 psm0: model IntelliMouse, device ID 3 vga0: at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0 sc0: at flags 0x100 on isa0 sc0: VGA <16 virtual consoles, flags=0x300> sio0 at port 0x3f8-0x3ff irq 4 flags 0x10 on isa0 sio0: type 16550A sio1 at port 0x2f8-0x2ff irq 3 on isa0 sio1: type 16550A ppc0: at port 0x378-0x37f irq 7 on isa0 ppc0: Generic chipset (NIBBLE-only) in COMPATIBLE mode ppbus0: IEEE1284 device found /NIBBLE Probing for PnP devices on ppbus0: ppbus0: HP ENHANCED PCL5,PJL,POSTSCRIPT plip0: on ppbus0 lpt0: on ppbus0 lpt0: Interrupt-driven port ppi0: on ppbus0 acd0: CDROM at ata1-master using PIO4 Waiting 15 seconds for SCSI devices to settle Mounting root from ufs:/dev/da0s1a da0 at ahc0 bus 0 target 0 lun 0 da0: Fixed Direct Access SCSI-3 device da0: 80.000MB/s transfers (40.000MHz, offset 63, 16bit), Tagged Queueing Enabled da0: 17501MB (35843670 512 byte sectors: 255H 63S/T 2231C) da1 at ahc0 bus 0 target 1 lun 0 da1: Fixed Direct Access SCSI-3 device da1: 80.000MB/s transfers (40.000MHz, offset 63, 16bit), Tagged Queueing Enabled da1: 17501MB (35843670 512 byte sectors: 255H 63S/T 2231C) cd0 at ahc1 bus 0 target 5 lun 0 cd0: Removable CD-ROM SCSI-2 device cd0: 20.000MB/s transfers (20.000MHz, offset 15) cd0: Attempt to query device size failed: NOT READY, Medium not present - tray closed da2 at ahc1 bus 0 target 6 lun 0 da2: Removable Direct Access SCSI-2 device da2: 20.000MB/s transfers (20.000MHz, offset 15) da2: Attempt to query device size failed: NOT READY, Medium not present bl -- //====== Brett G. Lemoine -=- ===============================\\ || Info. Systems Architect | || ||Core Unix System Services| Practice random acts of intelligence || || Incyte Genomics | & senseless acts of self-control. || || Palo Alto, California | || |+-------------------------+-------------------------------------------------+| \\== PGP Key Fingerprint: 68 A1 2A 2D 82 CE E9 70 5B 80 D1 11 EC F3 FB 85 ==// To Unsubscribe: send mail to majordomo@FreeBSD.org with "unsubscribe freebsd-stable" in the body of the message