Bug 26880

Summary: Unexpected busfree err w/ Adaptec 19160 and Quantum Atlas HD
Product: Base System Reporter: Thomas Seck <t.seck>
Component: kernAssignee: freebsd-bugs (Nobody) <bugs>
Status: Closed FIXED    
Severity: Affects Only Me    
Priority: Normal    
Version: 4.3-STABLE   
Hardware: Any   
OS: Any   

Description Thomas Seck 2001-04-26 18:10:01 UTC
See also the following excerpt from /var/log/messages.

After a warm boot, the affected disc is not being detected by the adaptor 
anymore. The only way to get the disc working again is power cycling the 
machine.

Excerpt from /var/log/messages:

Apr 26 09:29:17 proxy-bhm /kernel: (da1:ahc0:0:4:0): Unexpected busfree in Data-out phase
Apr 26 09:29:17 proxy-bhm /kernel: SEQADDR == 0x8f
Apr 26 09:29:17 proxy-bhm /kernel: (da1:ahc0:0:4:0): Invalidating pack
Apr 26 09:30:00 proxy-bhm /kernel: (da1:ahc0:0:4:0): SCB 0x14 - timed out while idle, SEQADDR == 0x8
Apr 26 09:30:00 proxy-bhm /kernel: STACK == 0x3, 0x10e, 0x164, 0x0
Apr 26 09:30:00 proxy-bhm /kernel: SXFRCTL0 == 0x80
Apr 26 09:30:00 proxy-bhm /kernel: ahc0: Dumping Card State at SEQADDR 0x8
Apr 26 09:30:00 proxy-bhm /kernel: SCSISEQ = 0x12, SBLKCTL = 0xa, SSTAT0 0x0
Apr 26 09:30:00 proxy-bhm /kernel: SCB count = 140
Apr 26 09:30:00 proxy-bhm /kernel: Kernel NEXTQSCB = 11
Apr 26 09:30:00 proxy-bhm /kernel: Card NEXTQSCB = 11
Apr 26 09:30:00 proxy-bhm /kernel: QINFIFO entries: 
Apr 26 09:30:00 proxy-bhm /kernel: Waiting Queue entries: 
Apr 26 09:30:00 proxy-bhm /kernel: Disconnected Queue entries: 6:37 28:20 
Apr 26 09:30:00 proxy-bhm /kernel: QOUTFIFO entries: 
Apr 26 09:30:00 proxy-bhm /kernel: Sequencer Free SCB List: 20 12 16 3 22 15 13 18 31 8 11 23 26 7 14 2 10 24 4 30 5 17 27 25 0 9 1 19 29 21 
Apr 26 09:30:00 proxy-bhm /kernel: Pending list: 37 20 
Apr 26 09:30:00 proxy-bhm /kernel: Kernel Free SCB list: 3 53 16 32 49 44 40 58 66 2 125 65 18 124 12 29 123 68 55 5 4 121 122 14 63 6 24 26 33 15 56 31 54 46 21 39 22 36 38 47 10 50 48 62 35 28 69 51 43 1 57 42 52 30 45 120 41 9 23 13 59 25 139 27 67 19 7 0 64 17 126 127 128 129 110 111 112 113 114 115 116 117 118 119 100 101 102 103 104 105 106 107 108 109 90 91 92 93 94 95 96 97 98 99 80 81 82 83 84 85 86 87 88 89 70 71 72 73 74 75 76 77 78 79 60 61 34 8 138 137 136 135 134 133 132 131 130 
Apr 26 09:30:00 proxy-bhm /kernel: sg[0] - Addr 0xcbc8000 : Length 3072
Apr 26 09:30:00 proxy-bhm /kernel: (da1:ahc0:0:4:0): Queuing a BDR SCB
Apr 26 09:30:00 proxy-bhm /kernel: (da1:ahc0:0:4:0): no longer in timeout, status = 34a
Apr 26 09:30:17 proxy-bhm /kernel: (da1:ahc0:0:4:0): Invalidating pack
Apr 26 09:31:17 proxy-bhm /kernel: (da1:ahc0:0:4:0): SCB 0x25 - timed out while idle, SEQADDR == 0x8
Apr 26 09:31:17 proxy-bhm /kernel: STACK == 0x3, 0x10e, 0x164, 0x0
Apr 26 09:31:17 proxy-bhm /kernel: SXFRCTL0 == 0x80
Apr 26 09:31:17 proxy-bhm /kernel: ahc0: Dumping Card State at SEQADDR 0x8
Apr 26 09:31:17 proxy-bhm /kernel: SCSISEQ = 0x12, SBLKCTL = 0xa, SSTAT0 0x0
Apr 26 09:31:17 proxy-bhm /kernel: SCB count = 140
Apr 26 09:31:17 proxy-bhm /kernel: Kernel NEXTQSCB = 20
Apr 26 09:31:17 proxy-bhm /kernel: Card NEXTQSCB = 20
Apr 26 09:31:17 proxy-bhm /kernel: QINFIFO entries: 
Apr 26 09:31:17 proxy-bhm /kernel: Waiting Queue entries: 
Apr 26 09:31:17 proxy-bhm /kernel: Disconnected Queue entries: 6:37 
Apr 26 09:31:17 proxy-bhm /kernel: QOUTFIFO entries: 
Apr 26 09:31:17 proxy-bhm /kernel: Sequencer Free SCB List: 28 20 12 16 3 22 15 13 18 31 8 11 23 26 7 14 2 10 24 4 30 5 17 27 25 0 9 1 19 29 21 
Apr 26 09:31:17 proxy-bhm /kernel: Pending list: 37 
Apr 26 09:31:17 proxy-bhm /kernel: Kernel Free SCB list: 11 3 53 16 32 49 44 40 58 66 2 125 65 18 124 12 29 123 68 55 5 4 121 122 14 63 6 24 26 33 15 56 31 54 46 21 39 22 36 38 47 10 50 48 62 35 28 69 51 43 1 57 42 52 30 45 120 41 9 23 13 59 25 139 27 67 19 7 0 64 17 126 127 128 129 110 111 112 113 114 115 116 117 118 119 100 101 102 103 104 105 106 107 108 109 90 91 92 93 94 95 96 97 98 99 80 81 82 83 84 85 86 87 88 89 70 71 72 73 74 75 76 77 78 79 60 61 34 8 138 137 136 135 134 133 132 131 130 
Apr 26 09:31:17 proxy-bhm /kernel: sg[0] - Addr 0x61ea000 : Length 2048
Apr 26 09:31:17 proxy-bhm /kernel: (da1:ahc0:0:4:0): Queuing a BDR SCB
Apr 26 09:31:17 proxy-bhm /kernel: (da1:ahc0:0:4:0): no longer in timeout, status = 34a
Apr 26 09:31:17 proxy-bhm /kernel: (da1:ahc0:0:4:0): Invalidating pack
Apr 26 09:31:47 proxy-bhm /kernel: handle_workitem_freefile: got error 6 while accessing filesystem

How-To-Repeat: 
Hard to tell. The problem does not occur under heavy disc load, I experience 
it only when the system is nearly idle, typically when the daily periodic job
is being started or small files are about to be written to the disc.
Moving large chunks of data between the discs or buildworlds work ok.

I get one to two errors a day, on different disks so I assume sw problems.
But I did not run 4.2 (w/o problems BTW) on the box long enough to blame 
it definitely on 4.3 :)
Comment 1 Justin T. Gibbs 2001-04-26 20:01:41 UTC
>>Synopsis:       Unexpected busfree err w/ Adaptec 19160 and Quantum Atlas HD

Can you provide full dmesg output?  This smells like a drive firmware
problem.  You might try upgrading to the latest firmware for your drive
from here:

ftp://ftp.quantum.com/Disk_Firmware

--
Justin
Comment 2 thomas.seck 2001-04-27 09:54:39 UTC
Hi Justin,

the box did not run into any errors after switching to 80MB/s tonight.
Maybe this is a workaround so far.

dmesg output as of today: 

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-20010422-STABLE #1: Wed Apr 25 12:23:21 CEST 2001
    root@proxy-bhm.gkd:/usr/obj/usr/src/sys/PROXY
Timecounter "i8254"  frequency 1193182 Hz
Timecounter "TSC"  frequency 801820992 Hz
CPU: Pentium III/Pentium III Xeon/Celeron (801.82-MHz 686-class CPU)
  Origin = "GenuineIntel"  Id = 0x686  Stepping = 6
 
Features=0x387f9ff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,SEP,MTRR,PGE,MCA,C
MOV,PAT,PSE36,PN,MMX,FXSR,SSE>
real memory  = 268369920 (262080K bytes)
avail memory = 258199552 (252148K bytes)
Preloaded elf kernel "kernel" at 0xc02ed000.
Pentium Pro MTRR support enabled
md0: Malloc disk
npx0: <math processor> on motherboard
npx0: INT 16 interface
pcib0: <Intel 82443BX (440 BX) host to PCI bridge> on motherboard
pci0: <PCI bus> on pcib0
pcib1: <Intel 82443BX (440 BX) PCI-PCI (AGP) bridge> at device 1.0 on
pci0
pci1: <PCI bus> on pcib1
pci1: <ATI model 5046 graphics accelerator> at 0.0 irq 11
isab0: <Intel 82371AB PCI to ISA bridge> at device 7.0 on pci0
isa0: <ISA bus> on isab0
atapci0: <Intel PIIX4 ATA33 controller> port 0xf000-0xf00f at device 7.1
on pci0
ata1: at 0x170 irq 15 on atapci0
pci0: <Intel 82371AB/EB (PIIX4) USB controller> at 7.2 irq 10
chip1: <Intel 82371AB Power management controller> port 0x5000-0x500f at
device 7.3 on pci0
ahc0: <Adaptec 19160B Ultra160 SCSI adapter> port 0xe400-0xe4ff mem
0xe4100000-0xe4100fff irq 11 at device 8.0 on pci0
aic7892: Wide Channel A, SCSI Id=7, 32/255 SCBs
fxp0: <Intel Pro 10/100B/100+ Ethernet> port 0xe800-0xe83f mem
0xe4000000-0xe40fffff,0xe4101000-0xe4101fff irq 5 at device 10.0 on pci0
fxp0: Ethernet address 00:d0:b7:43:b1:e1
fdc0: <NEC 72065B or clone> 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: <Keyboard controller (i8042)> at port 0x60,0x64 on isa0
atkbd0: <AT Keyboard> flags 0x1 irq 1 on atkbdc0
kbd0 at atkbd0
vga0: <Generic ISA VGA> at port 0x3c0-0x3df iomem 0xa0000-0xbffff on
isa0
sc0: <System console> 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: <Parallel port> at port 0x378-0x37f irq 7 on isa0
ppc0: Generic chipset (NIBBLE-only) in COMPATIBLE mode
lpt0: <Printer> on ppbus0
lpt0: Interrupt-driven port
ata1-slave: ata_command: timeout waiting for intr
ata1-slave: identify failed
acd0: CDROM <CD-ROM 52X/AKH> at ata1-master using PIO4
Waiting 5 seconds for SCSI devices to settle
Mounting root from ufs:/dev/da0s1a
da0 at ahc0 bus 0 target 0 lun 0
da0: <QUANTUM ATLAS_V_18_WLS 0230> Fixed Direct Access SCSI-3 device 
da0: 80.000MB/s transfers (40.000MHz, offset 63, 16bit), Tagged Queueing
Enabled
da0: 17510MB (35861388 512 byte sectors: 255H 63S/T 2232C)
da1 at ahc0 bus 0 target 4 lun 0
da1: <QUANTUM ATLAS_V_18_WLS 0230> Fixed Direct Access SCSI-3 device 
da1: 80.000MB/s transfers (40.000MHz, offset 63, 16bit), Tagged Queueing
Enabled
da1: 17510MB (35861388 512 byte sectors: 255H 63S/T 2232C)
da2 at ahc0 bus 0 target 8 lun 0
da2: <QUANTUM ATLAS_V_18_WLS 0230> Fixed Direct Access SCSI-3 device 
da2: 80.000MB/s transfers (40.000MHz, offset 63, 16bit), Tagged Queueing
Enabled
da2: 17510MB (35861388 512 byte sectors: 255H 63S/T 2232C)
da3 at ahc0 bus 0 target 12 lun 0
da3: <QUANTUM ATLAS_V_18_WLS 0230> Fixed Direct Access SCSI-3 device 
da3: 80.000MB/s transfers (40.000MHz, offset 63, 16bit), Tagged Queueing
Enabled
da3: 17510MB (35861388 512 byte sectors: 255H 63S/T 2232C)
Comment 3 Kris Kennaway freebsd_committer freebsd_triage 2001-07-13 00:52:36 UTC
State Changed
From-To: open->closed

No response from submitter