>Number:         11180
>Category:       kern
>Synopsis:       ahc driver hangs, raidframe panics...
>Confidential:   no
>Severity:       serious
>Priority:       high
>Responsible:    kern-bug-people
>State:          open
>Class:          sw-bug
>Submitter-Id:   net
>Arrival-Date:   Mon Oct 09 16:19:00 PDT 2000
>Closed-Date:
>Last-Modified:
>Originator:     Robert Elz
>Release:        NetBSD-current 2000-10-08-UTC
>Organization:
University of Melbourne
>Environment:
	
System: NetBSD lavender.cs.mu.OZ.AU 1.5G NetBSD 1.5G (LAVENDER) #7: Mon Oct 9 18:36:08 EST 2000 kre@lavender.cs.mu.OZ.AU:/home/cvs/src/sys/arch/alpha/compile/LAVENDER alpha


>Description:
	Two problems, the first of which lays the groundwork for
	the other to occur.

	The first is an unrecovered ahc controller hang (reset during
	reboot "fixes" the problem).

	The second is that when both halves of a raidframe mirror
	libe on drives on the hung controller, raidframe panics
	with DAG problems.

	See the kernel printfs included below (I also have the crash
	dump if more analysis would be useful).

	This came from -current sources form less than 24 hours ago
	(late 2000-10-08 UTC probably, perhaps early -09).  (1.5G).

	Userland was generally of approx 1.4Z vintage (though some
	parts had been upgraded to approx 1.5B).

	All of this seems to be quite repeatable, I have seen the
	whole thing about 4 times now, and I expect I can repeat it
	as required (at least until the cvs checkout is finally complete).

	In all cases the raid parity (mirror) is reconstructed completely
	without problems, before any other significant I/O is appetpted
	(which suggests that the ahc hang problem is probably caused by
	simultaneous writes to both drives).

	Local time reported everywhere us UTC+1100.

>How-To-Repeat:
	Install Adaptec UW controller in AlphaPC164,
	add two LVD drives, configure (parts of) those as a
	raidframe mirror set (doing all the appropriate init etc
	as documented) build a filesystem (regular ffs, mounted
	normally, no softdep) and then start writing files at
	a moderate rate (in this case, a cvs checkout from the
	US server - fetching files from a long way away, and
	displaying the cvs ouuput messages down a slow modem
	link .. ie: the overall I/O rate is fairly low).  Wait
	a few hours.   Observe first the ahc controller hangs.
	That then causes fatal raid errors (expected, neither
	half of the mirror is responding) generating a panic
	(which isn't what should happen).

	The drives actually have actually been divided into two
	RAID areas, with some swap space between.  One of the
	areas (lower block numbers) on each drive built as raid-1
	(mirror), the other built as raid-0 (/dev/raid1*) (just concat).
	The raid-0 has been initialised and labelled, but otherwise
	unused (the label contains only the 'c' partition, no
	newfs doen on that).  The raid-1 (/dev/raid0*) contains 4
	filesystems, 2 of which have been newfs'd, one of which
	is being mounted and actually used (though not yet added
	to fstab).

	The following is the kernel console output, starting from the
	kernel running after the previous crash, raid parity
	reconstructed, fsck complete, filesys mounted, and
	cvs checkout restarted.   It finishes with the reboot
	after the panic (the hardware and kernel config can be
	seen in the boot messages) and the subsequent savecore
	(which doesn't involve uing the ahc at all).

	The following has been edited to remove what seems to be
	to be redundant information - I have the full transcript if
	anyone believes they need it (it is about twice as long as
	this version).  The omitted parts are marked by indented [...]
	type emssages.

sd3(ahc0:1:0): SCB 6d - timed out while idle, SEQADDR == 0xb
SCSIRATE == 0x0
sd3(ahc0:1:0): Queuing a BDR SCB
sd3(ahc0:1:0): Bus Device Reset Message Sent
sd3(ahc0:1:0): no longer in timeout, status = 0
ahc0: Bus Device Reset on A:1. 4 SCBs aborted
ahc0: target 1 using 16bit transfers
ahc0: target 1 synchronous at 40.0MHz, offset = 0x3f
ahc0: target 1 using 16bit transfers
ahc0: target 1 synchronous at 40.0MHz, offset = 0x3f
sd3(ahc0:1:0): SCB 6d - timed out while idle, SEQADDR == 0xc
SCSIRATE == 0x0
		[several repeats of the above deleted]
SCSIRATE == 0x0
sd3(ahc0:1:0): Queuing a BDR SCB
sd3(ahc0:1:0): Bus Device Reset Message Sent
sd3(ahc0:1:0): no longer in timeout, status = 2
raid0: node (Wsd) returned fail, rolling forward
ahc0: Bus Device Reset on A:1. 1 SCBs aborted
sd2(ahc0:0:0): SCB 6b - timed out while idle, SEQADDR == 0xb
SCSIRATE == 0x0
sd2(ahc0:0:0): Queuing a BDR SCB
sd2(ahc0:0:0): Bus Device Reset Message Sent
sd2(ahc0:0:0): no longer in timeout, status = 0
ahc0: Bus Device Reset on A:0. 4 SCBs aborted
ahc0: target 0 using 16bit transfers
ahc0: target 0 synchronous at 40.0MHz, offset = 0x3f
ahc0: target 0 using 16bit transfers
ahc0: target 0 synchronous at 40.0MHz, offset = 0x3f
sd2(ahc0:0:0): SCB 6b - timed out while idle, SEQADDR == 0xb
SCSIRATE == 0x0
sd2(ahc0:0:0): Queuing a BDR SCB
sd2(ahc0:0:0): Bus Device Reset Message Sent
sd2(ahc0:0:0): no longer in timeout, status = 2
ahc0: Bus Device Reset on A:0. 4 SCBs aborted
ahc0: target 0 using 16bit transfers
ahc0: target 0 synchronous at 40.0MHz, offset = 0x3f
ahc0: target 0 using 16bit transfers
ahc0: target 0 synchronous at 40.0MHz, offset = 0x3f
sd2(ahc0:0:0): SCB 6b - timed out while idle, SEQADDR == 0x9
SCSIRATE == 0x0
		[several repeats of the above deleted]
SCSIRATE == 0x0
sd2(ahc0:0:0): Queuing a BDR SCB
sd2(ahc0:0:0): Bus Device Reset Message Sent
raid0: IO Error.  Marking /dev/sd2a as failed.
raid0: node (Wpd) returned fail, rolling forward
sd2(ahc0:0:0): no longer in timeout, status = 2
raid0: node (Wpd) returned fail, rolling forward
ahc0: Bus Device Reset on A:0. 2 SCBs aborted
Multiple disks failed in a single group!  Aborting I/O operation.
Multiple disks failed in a single group!  Aborting I/O operation.
Multiple disks failed in a single group!  Aborting I/O operation.
Multiple disks failed in a single group!  Aborting I/O operation.
Multiple disks failed in a single group!  Aborting I/O operation.
Multiple disks failed in a single group!  Aborting I/O operation.
Multiple disks failed in a single group!  Aborting I/O operation.
Multiple disks failed in a single group!  Aborting I/O operation.
Multiple disks failed in a single group!  Aborting I/O operation.
Multiple disks failed in a single group!  Aborting I/O operation.
Multiple disks failed in a single group!  Aborting I/O operation.
Multiple disks failed in a single group!  Aborting I/O operation.
[Failed to create a DAG
]panic: raidframe error at line 449 file ../../../../dev/raidframe/rf_states.c
Stopped in raid at      cpu_Debugger+0x4:       ret     zero,(ra)
db> tr
cpu_Debugger() at cpu_Debugger+0x4
panic() at panic+0xfc
rf_State_CreateDAG() at rf_State_CreateDAG+0x224
rf_ContinueRaidAccess() at rf_ContinueRaidAccess+0xdc
rf_DoAccess() at rf_DoAccess+0x2d8
raidstart() at raidstart+0x1ec
rf_State_LastState() at rf_State_LastState+0x60
rf_ContinueRaidAccess() at rf_ContinueRaidAccess+0x154
rf_ContinueDagAccess() at rf_ContinueDagAccess+0x22c
DAGExecutionThread() at DAGExecutionThread+0x1dc
esigcode() at esigcode
--- root of call graph ---
db> cont
syncing disks... ahc0: target 0 using 16bit transfers
ahc0: target 0 synchronous at 40.0MHz, offset = 0x3f
ahc0: target 0 using 16bit transfers
ahc0: target 0 synchronous at 40.0MHz, offset = 0x3f
85 85 85 85 85 84 84 84 84 83 83 83 82 82 82 82 81 81 80 80 80 80 80 80 80 giving up
Printing vnodes for busy buffers
Dev 1005 blkno 2265024
tag 1 type VBLK, usecount 3748, writecount 0, refcount 189,
        tag VT_UFS, ino 450, on dev 8, 0 flags 0x0, effnlink 1, nlink 1
        mode 060640, owner 0, group 5, size 0 not locked
Dev 1005 blkno 2676592
tag 1 type VBLK, usecount 3748, writecount 0, refcount 189,
        tag VT_UFS, ino 450, on dev 8, 0 flags 0x0, effnlink 1, nlink 1
        mode 060640, owner 0, group 5, size 0 not locked
Dev 1005 blkno 1596704
tag 1 type VBLK, usecount 3748, writecount 0, refcount 189,
        tag VT_UFS, ino 450, on dev 8, 0 flags 0x0, effnlink 1, nlink 1
        mode 060640, owner 0, group 5, size 0 not locked
Dev 1005 blkno 4683248
		[Many similar reports deleted]
Dev 1005 blkno 155040
tag 1 type VBLK, usecount 3748, writecount 0, refcount 189,
        tag VT_UFS, ino 450, on dev 8, 0 flags 0x0, effnlink 1, nlink 1
        mode 060640, owner 0, group 5, size 0 not locked
Dev 1005 blkno 2161616
tag 1 type VBLK, usecount 3748, writecount 0, refcount 189,
        tag VT_UFS, ino 450, on dev 8, 0 flags 0x0, effnlink 1, nlink 1
        mode 060640, owner 0, group 5, size 0 not locked
Stopped in raid at      cpu_Debugger+0x4:       ret     zero,(ra)
db> tr
cpu_Debugger() at cpu_Debugger+0x4
vfs_shutdown() at vfs_shutdown+0x34c
cpu_reboot() at cpu_reboot+0x68
panic() at panic+0x194
rf_State_CreateDAG() at rf_State_CreateDAG+0x224
rf_ContinueRaidAccess() at rf_ContinueRaidAccess+0xdc
rf_DoAccess() at rf_DoAccess+0x2d8
raidstart() at raidstart+0x1ec
rf_State_LastState() at rf_State_LastState+0x60
rf_ContinueRaidAccess() at rf_ContinueRaidAccess+0x154
rf_ContinueDagAccess() at rf_ContinueDagAccess+0x22c
DAGExecutionThread() at DAGExecutionThread+0x1dc
esigcode() at esigcode
--- root of call graph ---
db> cont

dumping to dev 8,1 offset 5191
dump 256 255 254 253 252 251 250 249 248 247 246 245 244 243 242 241 240 239 238 237 236 235 234 233 232 231 230 229 228 227 226 225 224 223 222 221 220 219 218 217 216 215 214 213 212 211 210 209 208 207 206 205 204 203 202 201 200 199 198 197 196 195 194 193 192 191 190 189 188 187 186 185 184 183 182 181 180 179 178 177 176 175 174 173 172 171 170 169 168 167 166 165 164 163 162 161 160 159 158 157 156 155 154 153 152 151 150 149 148 147 146 145 144 143 142 141 140 139 138 137 136 135 134 133 132 131 130 129 128 127 126 125 124 123 122 121 120 119 118 117 116 115 114 113 112 111 110 109 108 107 106 105 104 103 102 101 100 99 98 97 96 95 94 93 92 91 90 89 88 87 86 85 84 83 82 81 80 79 78 77 76 75 74 73 72 71 70 69 68 67 66 65 64 63 62 61 60 59 58 57 56 55 54 53 52 51 50 49 48 47 46 45 44 43 42 41 40 39 38 37 36 35 34 33 32 31 30 29 28 27 26 25 24 23 22 21 20 19 18 17 16 15 14 13 12 11 10 9 8 7 6 5 4 3 2 1 succeeded


ahc0: target 1 using 16bit transfers
ahc0: target 1 synchronous at 40.0MHz, offset = 0x3f
ahc0: board is not responding
cmd fail
sd3(ahc0:1:0): SCB 6e - timed out while idle, SEQADDR == 0xc
SCSIRATE == 0x0
sd3(ahc0:1:0): Queuing a BDR SCB
sd2: cache synchronization failed
rebooting...


halted CPU 0

halt code = 5
HALT instruction executed
PC = fffffc0000300128

CPU 0 booting

(boot dka0.0.0.5.0 -flags a)
block 0 of dka0.0.0.5.0 is a valid boot block
reading 14 blocks from dka0.0.0.5.0
bootstrap code read in
base = 180000, image_start = 0, image_bytes = 1c00
initializing HWRPB at 2000
initializing page table at 172000
initializing machine state
setting affinity to the primary CPU
jumping to bootstrap code

NetBSD/alpha 1.4Z FFS Primary Bootstrap
Jumping to entry point...

NetBSD/alpha 1.4Z Secondary Bootstrap, Revision 1.10
(root@frau-farbissina, May 28 12:27:12 PDT 2000)

VMS PAL rev: 0x1000900010115
OSF PAL rev: 0x1000800020117
Switch to OSF PAL code succeeded.

Boot flags: a
3340632+348736 [85+189432+109340]=0x3cde88

Entering netbsd at 0xfffffc00003010b0...
[ using 299760 bytes of netbsd ELF symbol table ]
Copyright (c) 1996, 1997, 1998, 1999, 2000
    The NetBSD Foundation, Inc.  All rights reserved.
Copyright (c) 1982, 1986, 1989, 1991, 1993
    The Regents of the University of California.  All rights reserved.

NetBSD 1.5G (LAVENDER) #7: Mon Oct  9 18:36:08 EST 2000
    kre@lavender.cs.mu.OZ.AU:/home/cvs/src/sys/arch/alpha/compile/LAVENDER
Digital AlphaPC 164 500 MHz, s/n 
8192 byte page size, 1 processor.
total memory = 256 MB
(2472 KB reserved for PROM, 253 MB used by NetBSD)
avail memory = 231 MB
using 1635 buffers containing 13080 KB of memory
mainbus0 (root)
cpu0 at mainbus0: ID 0 (primary), 21164A-2
cpu0: Architecture extensions: 1<BWX>
cia0 at mainbus0: DECchip 2117x Core Logic Chipset (ALCOR/ALCOR2), pass 3
cia0: extended capabilities: 21<DWEN,BWEN>
cia0: using BWX for PCI config access
pci0 at cia0 bus 0
pci0: i/o space, memory space enabled, rd/line, rd/mult, wr/inv ok
isp0 at pci0 dev 5 function 0
isp0: interrupting at eb164 irq 2
isp0: Board Revision 1020, loaded F/W Revision 4.65.0
isp0: Last F/W revision was 5.57.1
isp0: 243 max I/O commands supported
isp0: driver initiated bus reset of bus 0
scsibus0 at isp0: 16 targets, 8 luns per target
ahc0 at pci0 dev 7 function 0
ahc0: interrupting at eb164 irq 1
ahc0: aic7890/91 Wide Channel A, SCSI Id=7, 16/255 SCBs
scsibus1 at ahc0 channel 0: 16 targets, 8 luns per target
sio0 at pci0 dev 8 function 0: Intel 82378ZB System I/O (SIO) (rev. 0x43)
ex0 at pci0 dev 9 function 0: 3Com 3c905B-TX 10/100 Ethernet (rev. 0x64)
ex0: interrupting at eb164 irq 3
ex0: MAC address 00:10:5a:76:5f:06
ukphy0 at ex0 phy 24: Generic IEEE 802.3u media interface
ukphy0: OUI 0x001018, model 0x0012, rev. 0
ukphy0: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto
pciide0 at pci0 dev 11 function 0: CMD Technology PCI0646 (rev. 0x01)
pciide0: bus-master DMA support present
pciide0: primary channel configured to compatibility mode
wd0 at pciide0 channel 0 drive 0: <QUANTUM FIREBALL CR6.4A>
wd0: drive supports 16-sector pio transfers, lba addressing
wd0: 6149 MB, 13328 cyl, 15 head, 63 sec, 512 bytes/sect x 12594960 sectors
wd0: 32-bit data port
wd0: drive supports PIO mode 4, DMA mode 2, Ultra-DMA mode 4
wd1 at pciide0 channel 0 drive 1: <CASTLEWOOD ORB2-E>
wd1: drive supports 16-sector pio transfers, lba addressing
wd1: 2103 MB, 4273 cyl, 16 head, 63 sec, 512 bytes/sect x 4307184 sectors
wd1: 32-bit data port
wd1: drive supports PIO mode 4, DMA mode 2
pciide0: primary channel interrupting at isa irq 14
wd0(pciide0:0:0): using PIO mode 4, DMA mode 2 (using DMA data transfers)
wd1(pciide0:0:1): using PIO mode 4, DMA mode 2 (using DMA data transfers)
pciide0: secondary channel configured to compatibility mode
atapibus0 at pciide0 channel 1
cd4 at atapibus0 drive 0: <ASUS CD-S500/A, , V2.1H> type 5 cdrom removable
cd4: 32-bit data port
cd4: drive supports PIO mode 4, DMA mode 2, Ultra-DMA mode 2
cd3 at atapibus0 drive 1: <ATAPI 44X CDROM, 44XCDROM Ver2.00, VER-2.0> type 5 cdrom removable
cd3: 32-bit data port
cd3: drive supports PIO mode 4, DMA mode 2, Ultra-DMA mode 2
pciide0: secondary channel interrupting at isa irq 15
cd4(pciide0:1:0): using PIO mode 4, DMA mode 2 (using DMA data transfers)
cd3(pciide0:1:1): using PIO mode 4, DMA mode 2 (using DMA data transfers)
isa0 at sio0
com0 at isa0 port 0x3f8-0x3ff irq 4: ns16550a, working fifo
com0: console
com1 at isa0 port 0x2f8-0x2ff irq 3: ns16550a, working fifo
pckbc0 at isa0 port 0x60-0x64
lpt0 at isa0 port 0x3bc-0x3bf irq 7
we1 at isa0 port 0x300-0x31f iomem 0xcc000-0xcffff irq 10
we1: WD8013EPC Ethernet (16-bit)
we1: Ethernet address 00:00:c0:0e:ae:4c
pcppi0 at isa0 port 0x61
spkr0 at pcppi0
isabeep0 at pcppi0
fdc0 at isa0 port 0x3f0-0x3f7 irq 6 drq 2
fd0 at fdc0 drive 0: 1.44MB, 80 cyl, 2 head, 18 sec
mcclock0 at isa0 port 0x70-0x71: mc146818 or compatible
scsibus0: waiting 2 seconds for devices to settle...
isp0: Bus 0 Target 0 Async Mode 
sd0 at scsibus0 target 0 lun 0: <SEAGATE, ST34520N, 1498> SCSI2 0/direct fixed
isp0: Bus 0 Target 0 at 10MHz Max Offset 12, Tagged Queueing Enabled
sd0: 4340 MB, 9006 cyl, 4 head, 246 sec, 512 bytes/sect x 8888924 sectors
isp0: Bus 0 Target 0 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 0 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 0 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 0 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 0 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 0 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 0 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 1 Async Mode 
sd1 at scsibus0 target 1 lun 0: <SEAGATE, ST34520N, 1498> SCSI2 0/direct fixed
isp0: Bus 0 Target 1 at 10MHz Max Offset 12, Tagged Queueing Enabled
sd1: 4340 MB, 9006 cyl, 4 head, 246 sec, 512 bytes/sect x 8888924 sectors
isp0: Bus 0 Target 1 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 1 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 1 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 1 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 1 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 1 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 1 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 3 Async Mode 
cd2 at scsibus0 target 3 lun 0: <TEAC, CD-ROM CD-532S, 1.0A> SCSI2 5/cdrom removable
isp0: Bus 0 Target 3 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 3 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 3 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 3 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 3 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 3 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 3 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 4 Async Mode 
cd1 at scsibus0 target 4 lun 0: <TEAC, CD-ROM CD-532S, 1.0A> SCSI2 5/cdrom removable
isp0: Bus 0 Target 4 at 10MHz Max Offset 12 
isp0: Bus 0 Target 4 at 10MHz Max Offset 12 
isp0: Bus 0 Target 4 at 10MHz Max Offset 12 
isp0: Bus 0 Target 4 at 10MHz Max Offset 12 
isp0: Bus 0 Target 4 at 10MHz Max Offset 12 
isp0: Bus 0 Target 4 at 10MHz Max Offset 12 
isp0: Bus 0 Target 4 at 10MHz Max Offset 12 
cd0 at scsibus0 target 5 lun 0: <SONY, CD-RW  CRX145S, 1.0b> SCSI4 5/cdrom removable
isp0: Bus 0 Target 5 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 5 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 5 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 5 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 5 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 5 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 5 at 10MHz Max Offset 12, Tagged Queueing Enabled
scsibus1: waiting 2 seconds for devices to settle...
ahc0: target 0 using 16bit transfers
ahc0: target 0 synchronous at 40.0MHz, offset = 0x3f
ahc0: target 0 using tagged queuing
sd2 at scsibus1 target 0 lun 0: <IBM, DDYS-T18350N, S80D> SCSI3 0/direct fixed
sd2: 17501 MB, 15110 cyl, 6 head, 395 sec, 512 bytes/sect x 35843670 sectors
ahc0: target 1 using 16bit transfers
ahc0: target 1 synchronous at 40.0MHz, offset = 0x3f
ahc0: target 1 using tagged queuing
sd3 at scsibus1 target 1 lun 0: <IBM, DDYS-T18350N, S80D> SCSI3 0/direct fixed
sd3: 17501 MB, 15110 cyl, 6 head, 395 sec, 512 bytes/sect x 35843670 sectors
Kernelized RAIDframe activated
wd1: no disk label
cd3(pciide0:1:1):  Check Condition on CDB: 0x25 00 00 00 00 00 00 00 00 00
    SENSE KEY:  Not Ready
     ASC/ASCQ:  Medium Not Present

isp0: Bus 0 Target 0 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 0 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 1 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 1 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 3 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 3 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 3 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 4 at 10MHz Max Offset 12 
isp0: Bus 0 Target 4 at 10MHz Max Offset 12 
isp0: Bus 0 Target 4 at 10MHz Max Offset 12 
isp0: Bus 0 Target 5 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 5 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 5 at 10MHz Max Offset 12, Tagged Queueing Enabled
RAID autoconfigure
Configuring raid0:
RAIDFRAME: protectedSectors is 64
RAIDFRAME: Configure (RAID Level 1): total number of sectors is 18959936 (9257 MB)
RAIDFRAME(RAID Level 1): Using 6 floating recon bufs with no head sep limit
RAID autoconfigure
Configuring raid1:
RAIDFRAME: Configure (RAID Level 0): total number of sectors is 32819200 (16025 MB)
RAIDFRAME(RAID Level 0): Using 6 floating recon bufs with no head sep limit
root on sd0a dumps on sd0b
isp0: Bus 0 Target 0 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 0 at 10MHz Max Offset 12, Tagged Queueing Enabled
isp0: Bus 0 Target 0 at 10MHz Max Offset 12, Tagged Queueing Enabled
raid0: Device already configured!
raidctl: ioctl (RAIDFRAME_CONFIGURE) failed: Invalid arguraid1: Device already configured!
ment
raidctl: ioctl (RAIDFRAME_CONFIGURE) failed: Invalid argument
/dev/raid0c: Parity status: DIRTY
/dev/raid0c: Initiating re-write of parity
swapctl: adding /dev/sd0b as swap device at priority 0
swapctl: adding /dev/wd0b as swap device at priority 0
Automatic boot in progress: starting file system checks.
/dev/rsd0a: 1063 files, 45303 used, 3116 free (20 frags, 387 blocks, 0.0% fragmentation)
/dev/rsd0a: MARKING FILE SYSTEM CLEAN
/dev/rsd0d: 9927 files, 162113 used, 86006 free (6726 frags, 9910 blocks, 2.7% fragmentation)
/dev/rsd0d: MARKING FILE SYSTEM CLEAN
/dev/rsd0f: 343 files, 6185 used, 74158 free (78 frags, 9260 blocks, 0.1% fragmentation)
/dev/rsd0f: MARKING FILE SYSTEM CLEAN
/dev/rsd0g: 1633 files, 27934 used, 1461216 free (648 frags, 182571 blocks, 0.0% fragmentation)
/dev/rsd0g: MARKING FILE SYSTEM CLEAN
/dev/rwd0h: 101819 files, 1246303 used, 1952550 free (4334 frags, 243527 blocks, 0.1% fragmentation)
/dev/rwd0h: MARKING FILE SYSTEM CLEAN
/dev/rsd0h: 88602 files, 434886 used, 1747908 free (2148 frags, 218220 blocks, 0.1% fragmentation)
/dev/rsd0h: MARKING FILE SYSTEM CLEAN
Setting tty flags.
Setting securelevel: kern.securelevel: 0 -> 1
Setting sysctl variables:
Starting network.
Hostname: lavender.cs.mu.OZ.AU
add net 127.0.0.0: gateway 127.0.0.1
Configuring network interfaces: we1.
add net default: gateway 128.250.1.195
Adding interface aliases:
add net fe80::: gateway ::1
add net fec0::: gateway ::1
add net ::ffff:0.0.0.0: gateway ::1
add net ::224.0.0.0: gateway ::1
add net ::127.0.0.0: gateway ::1
add net ::0.0.0.0: gateway ::1
add net ::255.0.0.0: gateway ::1
add net 2002:e000::: gateway ::1
add net 2002:7f00::: gateway ::1
add net 2002:0000::: gateway ::1
add net 2002:ff00::: gateway ::1
add net ::0.0.0.0: gateway ::1
IPv6 mode: autoconfigured host
ND default interface = we1
Sending router solicitation...
Starting syslogd.
Checking for core dump...
savecore: reboot after panic: raidframe error at line 449 file ../../../../dev/raidframe/rf_states.c
savecore: system went down at Tue Oct 10 07:02:33 2000
savecore: no dump, not enough free space in /var/crash
Oct 10 07:08:23 lavender savecore: reboot after panic: raidframe error at line 449 file ../../../../dev/raidframe/rf_states.c
Setting date via ntp.
Starting portmap.
Mounting all filesystems...
Starting statd.
Starting lockd.
Building databases...
Checking quotas: done.
Turning on accounting.
Oct 10 07:15:11 lavender /netbsd: Accounting started
Clearing /tmp.
starting local daemons:.
Updating motd.
Starting lpd.
Starting ntpd.
Starting sshd.
Starting sendmail.
Starting inetd.
Starting cron.
Tue Oct 10 07:15:16 EST 2000

NetBSD/alpha (lavender.cs.mu.OZ.AU) (console)

login: 
		[root login sequence omitted]

savecore /usr/src/crash
savecore: reboot after panic: raidframe error at line 449 file ../../../../dev/raidframe/rf_states.c
Oct 10 07:16:06 lavender savecore: reboot after panic: raidframe error at line 449 file ../../../../dev/raidframe/rf_states.c
Oct 10 07:16:06 lavender savecore: reboot after panic: raidframe error at line 449 file ../../../../dev/raidframe/rf_states.c
savecore: system went down at Tue Oct 10 07:02:33 2000
savecore: /usr/src/crash/bounds: No such file or directory
Oct 10 07:16:06 lavender savecore: /usr/src/crash/bounds: No such file or directory
savecore: writing core to /usr/src/crash/netbsd.0.core
Oct 10 07:16:06 lavender savecore: writing core to /usr/src/crash/netbsd.0.core
savecore: writing kernel to /usr/src/crash/netbsd.0
Oct 10 07:17:17 lavender savecore: writing kernel to /usr/src/crash/netbsd.0
lavender# ls -l !$
ls -l /usr/src/crash
total 265897
-rw-------  1 root  wheel          2 Oct 10 07:16 bounds
-rw-------  1 root  wheel    3681484 Oct 10 07:17 netbsd.0
-rw-------  1 root  wheel  268435992 Oct 10 07:17 netbsd.0.core

>Fix:
	No idea, this one is (these two are) out of my league...
>Release-Note:
>Audit-Trail:
>Unformatted: