Subject: Anyone else had 'lost interrupt' on Silicon Image 3112 SATA with WD drives ?
To: None <netbsd-users@netbsd.org>
From: ian <netbsd@minimal.cx>
List: netbsd-users
Date: 05/18/2005 22:22:14
Hi all,

I've got a Mac B&W G3 350 running NetBSD/macppc 2.0.2 with a Firmtek 
SeriTek1S2 (two port internal) SATA PCI card that has been running fine 
with a single Western Digital 2500 (250GB Caviar Raid Edition) drive 
for the past 10 days or so in the 66MHz (32-bit) PCI slot.  Today I 
added a second identical WD drive to the second port on the card and 
started to configure RAIDframe as a mirror: as soon as I got to the 
first dump|restore line in the instructions, I got a stream of lost 
interrupt error messages, and the system got so slow I ended up hitting 
the reset button.

This is the dmesg for that first run:

May 18 15:01:58 blue /netbsd: NetBSD 2.0.2 (BLUE) #1: Thu May 12 
23:27:56 BST 2005
May 18 15:01:58 blue /netbsd: 
	root@blue.cambridge:/usr/src/sys/arch/macppc/compile/BLUE
May 18 15:01:58 blue /netbsd: total memory = 384 MB
May 18 15:01:58 blue /netbsd: avail memory = 364 MB
May 18 15:01:58 blue /netbsd: mainbus0 (root)
May 18 15:01:58 blue /netbsd: cpu0 at mainbus0: 750 (Revision 2.1), ID 
0 (primary)
May 18 15:01:58 blue /netbsd: cpu0: HID0 
8090c0a4<EMCP,DOZE,DPM,ICE,DCE,SGE,BTIC,BHT>
May 18 15:01:58 blue /netbsd: cpu0: 350.00 MHz, no-parity 1MB WT L2 
cache (PB SRAM) at 2:1 ratio
May 18 15:01:58 blue /netbsd: grackle0 at mainbus0
May 18 15:01:58 blue /netbsd: pci0 at grackle0 bus 0
May 18 15:01:58 blue /netbsd: pci0: i/o space, memory space enabled
May 18 15:01:58 blue /netbsd: pchb0 at pci0 dev 0 function 0
May 18 15:01:58 blue /netbsd: pchb0: Motorola MPC106 "Grackle" Host 
Bridge (rev. 0x40)
May 18 15:01:58 blue /netbsd: ppb0 at pci0 dev 13 function 0: Digital 
Equipment DECchip 21154 PCI-PCI Bridge (rev. 0x02)
May 18 15:01:58 blue /netbsd: pci1 at ppb0 bus 1
May 18 15:01:58 blue /netbsd: pci1: i/o space, memory space enabled
May 18 15:01:58 blue /netbsd: Texas Instruments TSB12LV21 IEEE 1394 
Host Controller (Firewire serial bus, revision 0x02) at pci1 dev 0 
function 0 not configured
May 18 15:01:58 blue /netbsd: cmdide0 at pci1 dev 1 function 0
May 18 15:01:58 blue /netbsd: cmdide0: CMD Technology PCI0646 (rev. 
0x05)
May 18 15:01:58 blue /netbsd: cmdide0: bus-master DMA support present
May 18 15:01:58 blue /netbsd: cmdide0: primary channel configured to 
native-PCI mode
May 18 15:01:58 blue /netbsd: cmdide0: using irq 26 for native-PCI 
interrupt
May 18 15:01:58 blue /netbsd: atabus0 at cmdide0 channel 0
May 18 15:01:58 blue /netbsd: cmdide0: secondary channel configured to 
native-PCI mode
May 18 15:01:58 blue /netbsd: cmdide0: secondary channel ignored 
(disabled)
May 18 15:01:58 blue /netbsd: ahc0 at pci1 dev 2 function 0: Adaptec 
2902/04/10/15/20/30C SCSI adapter
May 18 15:01:58 blue /netbsd: ahc0: interrupting at irq 23
May 18 15:01:58 blue /netbsd: ahc0: aic7850: Single Channel A, SCSI 
Id=7, 3/253 SCBs
May 18 15:01:58 blue /netbsd: scsibus0 at ahc0: 8 targets, 8 luns per 
target
May 18 15:01:58 blue /netbsd: ofb0 at pci1 dev 3 function 0: ATI 
Technologies Rage 128 GL PCI
May 18 15:01:58 blue /netbsd: ofb0: 640 x 480, 8bpp
May 18 15:01:58 blue /netbsd: wsdisplay0 at ofb0 kbdmux 1: console 
(std, vt100 emulation)
May 18 15:01:58 blue /netbsd: wsmux1: connecting to wsdisplay0
May 18 15:01:58 blue /netbsd: tlp0 at pci1 dev 4 function 0: ADMtek 
AN985 Ethernet, pass 1.1
May 18 15:01:58 blue /netbsd: tlp0: interrupting at irq 25
May 18 15:01:58 blue /netbsd: tlp0: Ethernet address 00:04:e2:39:37:ae
May 18 15:01:58 blue /netbsd: ukphy0 at tlp0 phy 1: Generic IEEE 802.3u 
media interface
May 18 15:01:58 blue /netbsd: ukphy0: OUI 0x00e092, model 0x0001, rev. 1
May 18 15:01:58 blue /netbsd: ukphy0: 10baseT, 10baseT-FDX, 100baseTX, 
100baseTX-FDX, auto
May 18 15:01:58 blue /netbsd: obio0 at pci1 dev 5 function 0: addr 
0x80800000
May 18 15:01:58 blue /netbsd: mesh0 at obio0 offset 0x10000 irq 12: 
50MHz, SCSI ID 7
May 18 15:01:58 blue /netbsd: scsibus1 at mesh0: 8 targets, 8 luns per 
target
May 18 15:01:58 blue /netbsd: zsc0 at obio0 offset 0x13000: irq 15,16
May 18 15:01:58 blue /netbsd: zstty0 at zsc0 channel 0
May 18 15:01:58 blue /netbsd: zstty1 at zsc0 channel 1
May 18 15:01:58 blue /netbsd: davbus at obio0 offset 0x14000 not 
configured
May 18 15:01:58 blue /netbsd: fdc at obio0 offset 0x15000 not configured
May 18 15:01:58 blue /netbsd: adb0 at obio0 offset 0x16000 irq 18: 0 
targets
May 18 15:01:58 blue /netbsd: wdc0 at obio0 offset 0x20000 irq 13: DMA 
transfer
May 18 15:01:58 blue /netbsd: atabus at wdc0 channel 0 not configured
May 18 15:01:58 blue /netbsd: bm0 at obio0 offset 0x11000 irq 42,33: 
address 00:05:02:b1:f0:78
May 18 15:01:58 blue /netbsd: lxtphy0 at bm0 phy 0: LXT970 10/100 media 
interface, rev. 1
May 18 15:01:58 blue /netbsd: lxtphy0: 10baseT, 10baseT-FDX, 100baseTX, 
100baseTX-FDX, auto
May 18 15:01:58 blue /netbsd: nvram0 at obio0 offset 0x60000
May 18 15:01:58 blue /netbsd: ohci0 at pci1 dev 6 function 0: Opti 
RM861HA (rev. 0x10)
May 18 15:01:58 blue /netbsd: ohci0: interrupting at irq 28
May 18 15:01:58 blue /netbsd: ohci0: OHCI version 1.0, legacy support
May 18 15:01:58 blue /netbsd: usb0 at ohci0: USB revision 1.0
May 18 15:01:58 blue /netbsd: uhub0 at usb0
May 18 15:01:58 blue /netbsd: uhub0: Opti OHCI root hub, class 9/0, rev 
1.00/1.00, addr 1
May 18 15:01:58 blue /netbsd: uhub0: 2 ports with 2 removable, self 
powered
May 18 15:01:58 blue /netbsd: satalink0 at pci0 dev 16 function 0
May 18 15:01:58 blue /netbsd: satalink0: Silicon Image SATALink 3112 
(rev. 0x02)
May 18 15:01:59 blue /netbsd: satalink0: SATALink BA5 register space 
enabled
May 18 15:01:59 blue /netbsd: satalink0: bus-master DMA support present
May 18 15:01:59 blue /netbsd: satalink0: primary channel wired to 
native-PCI mode
May 18 15:01:59 blue /netbsd: satalink0: using irq 22 for native-PCI 
interrupt
May 18 15:01:59 blue /netbsd: atabus1 at satalink0 channel 0
May 18 15:01:59 blue /netbsd: satalink0: secondary channel wired to 
native-PCI mode
May 18 15:01:59 blue /netbsd: atabus2 at satalink0 channel 1
May 18 15:01:59 blue /netbsd: Kernelized RAIDframe activated
May 18 15:01:59 blue /netbsd: IPsec: Initialized Security Association 
Processing.
May 18 15:01:59 blue /netbsd: scsibus0: waiting 2 seconds for devices 
to settle...
May 18 15:01:59 blue /netbsd: scsibus1: waiting 2 seconds for devices 
to settle...
May 18 15:01:59 blue /netbsd: satalink0: port 0: device present, speed: 
1.5Gb/s
May 18 15:01:59 blue /netbsd: wd0 at atabus1 drive 0satalink0: port 1: 
device present, speed: 1.5Gb/s
May 18 15:01:59 blue /netbsd: : <WDC WD2500SD-01KCB0>
May 18 15:01:59 blue /netbsd: wd0: drive supports 16-sector PIO 
transfers, LBA48 addressing
May 18 15:01:59 blue /netbsd: wd0: 232 GB, 484521 cyl, 16 head, 63 sec, 
512 bytes/sect x 488397168 sectors
May 18 15:01:59 blue /netbsd: wd0: drive supports PIO mode 4, DMA mode 
2, Ultra-DMA mode 6 (Ultra/133)
May 18 15:01:59 blue /netbsd: wd0(satalink0:0:0): using PIO mode 4, 
Ultra-DMA mode 6 (Ultra/133) (using DMA data transfers)
May 18 15:01:59 blue /netbsd: wd1 at atabus2 drive 0: <WDC 
WD2500SD-01KCB0>
May 18 15:01:59 blue /netbsd: wd1: drive supports 16-sector PIO 
transfers, LBA48 addressing
May 18 15:01:59 blue /netbsd: wd1: 232 GB, 484521 cyl, 16 head, 63 sec, 
512 bytes/sect x 488397168 sectors
May 18 15:01:59 blue /netbsd: wd1: drive supports PIO mode 4, DMA mode 
2, Ultra-DMA mode 6 (Ultra/133)
May 18 15:01:59 blue /netbsd: wd1(satalink0:1:0): using PIO mode 4, 
Ultra-DMA mode 6 (Ultra/133) (using DMA data transfers)
May 18 15:01:59 blue /netbsd: uhub1 at uhub0 port 2
May 18 15:01:59 blue /netbsd: uhub1: Mitsumi Electric Hub in Apple 
Extended USB Keyboard, class 9/0, rev 1.10/1.22, addr 2
May 18 15:01:59 blue /netbsd: uhub1: 3 ports with 2 removable, bus 
powered
May 18 15:01:59 blue /netbsd: uhidev0 at uhub1 port 1 configuration 1 
interface 0
May 18 15:01:59 blue /netbsd: uhidev0: Mitsumi Electric Apple Extended 
USB Keyboard, rev 1.10/1.22, addr 3, iclass 3/1
May 18 15:01:59 blue /netbsd: ukbd0 at uhidev0: 8 modifier keys, 6 key 
codes
May 18 15:01:59 blue /netbsd: wskbd0 at ukbd0: console keyboard, using 
wsdisplay0
May 18 15:01:59 blue /netbsd: uhidev1 at uhub1 port 1 configuration 1 
interface 1
May 18 15:01:59 blue /netbsd: uhidev1: Mitsumi Electric Apple Extended 
USB Keyboard, rev 1.10/1.22, addr 3, iclass 3/0
May 18 15:01:59 blue /netbsd: uhidev1: 3 report ids
May 18 15:01:59 blue /netbsd: uhid at uhidev1 reportid 2 not configured
May 18 15:01:59 blue /netbsd: uhid at uhidev1 reportid 3 not configured
May 18 15:01:59 blue /netbsd: st0 at scsibus0 target 5 lun 0: <SONY, 
SDT-7000, 0300> tape removable
May 18 15:01:59 blue /netbsd: st0: drive empty
May 18 15:01:59 blue /netbsd: st0: sync (100.00ns offset 15), 8-bit 
(10.000MB/s) transfers
May 18 15:01:59 blue /netbsd: boot device: <unknown>
May 18 15:01:59 blue /netbsd: root on wd0a dumps on wd0b
May 18 15:01:59 blue savecore: no core dump
May 18 15:02:00 blue ntpd[333]: ntpd 4.2.0-r Tue Mar 22 15:46:59 UTC 
2005 (1)
May 18 15:02:00 blue ntpd[333]: precision = 2.000 usec
May 18 15:02:00 blue ntpd[333]: kernel time sync status 0040
May 18 15:02:00 blue ntpd[333]: frequency initialized 500.000 PPM from 
/var/db/ntp.drift
May 18 15:03:09 blue /netbsd: raidlookup on device: /dev/wd9a failed!
May 18 15:03:09 blue /netbsd: Hosed component: /dev/wd1a
May 18 15:03:09 blue /netbsd: Hosed component: /dev/wd9a
May 18 15:03:09 blue /netbsd: raid0: Component /dev/wd9a being 
configured at col: 0
May 18 15:03:09 blue /netbsd:          Column: 0 Num Columns: 0
May 18 15:03:09 blue /netbsd:          Version: 0 Serial Number: 0 Mod 
Counter: 0
May 18 15:03:09 blue /netbsd:          Clean: No Status: 0
May 18 15:03:09 blue /netbsd: /dev/wd9a has a different modfication 
count: 20 0
May 18 15:03:09 blue /netbsd: Number of columns do not match for: 
/dev/wd9a
May 18 15:03:09 blue /netbsd: /dev/wd9a is not clean!
May 18 15:03:09 blue /netbsd: raid0: Component /dev/wd1a being 
configured at col: 1
May 18 15:03:09 blue /netbsd:          Column: -1 Num Columns: -1
May 18 15:03:09 blue /netbsd:          Version: -1 Serial Number: -1 
Mod Counter: 20
May 18 15:03:09 blue /netbsd:          Clean: No Status: 0
May 18 15:03:09 blue /netbsd: /dev/wd1a has a different serial number: 
0 -1
May 18 15:03:09 blue /netbsd: Row out of alignment for: /dev/wd1a
May 18 15:03:09 blue /netbsd: Column out of alignment for: /dev/wd1a
May 18 15:03:09 blue /netbsd: Number of columns do not match for: 
/dev/wd1a
May 18 15:03:09 blue /netbsd: /dev/wd1a is not clean!
May 18 15:03:09 blue /netbsd: raid0: There were fatal errors
May 18 15:03:09 blue /netbsd: raid0: Fatal errors being ignored.
May 18 15:03:09 blue /netbsd: raid0: RAID Level 1
May 18 15:03:09 blue /netbsd: raid0: Components: /dev/wd9a[**FAILED**] 
/dev/wd1a
May 18 15:03:09 blue /netbsd: raid0: Total Sectors: 488355968 (238455 
MB)
May 18 15:03:32 blue /netbsd: raid0: Error re-writing parity!
May 18 15:43:49 blue /netbsd: satalink0:0:0: lost interrupt
May 18 15:43:49 blue /netbsd: 	type: ata tc_bcount: 32768 tc_skip: 0
May 18 15:43:49 blue /netbsd: satalink0:1:0: lost interrupt
May 18 15:43:49 blue /netbsd: 	type: ata tc_bcount: 32768 tc_skip: 0
May 18 15:44:01 blue /netbsd: satalink0:0:0: lost interrupt
May 18 15:45:41 blue /netbsd: 	type: ata tc_bcount: 32768 tc_skip: 0
May 18 15:47:41 blue /netbsd: satalink0:1:0: lost interrupt
May 18 15:49:01 blue /netbsd: 	type: ata tc_bcount: 2048 tc_skip: 0
May 18 15:49:01 blue /netbsd: satalink0:0:0: lost interrupt
May 18 15:49:01 blue /netbsd: 	type: ata tc_bcount: 2048 tc_skip: 0
May 18 15:49:01 blue /netbsd: satalink0:1:0: lost interrupt
May 18 15:49:01 blue /netbsd: 	type: ata tc_bcount: 16384 tc_skip: 0
May 18 15:49:01 blue /netbsd: satalink0:0:0: lost interrupt
May 18 15:49:01 blue /netbsd: 	type: ata tc_bcount: 14336 tc_skip: 0
May 18 15:49:01 blue /netbsd: satalink0:1:0: lost interrupt
May 18 15:49:01 blue /netbsd: 	type: ata tc_bcount: 16384 tc_skip: 0
May 18 15:49:01 blue /netbsd: satalink0:0:0: lost interrupt
May 18 15:49:01 blue /netbsd: 	type: ata tc_bcount: 16384 tc_skip: 0
May 18 15:49:01 blue /netbsd: satalink0:1:0: lost interrupt
May 18 15:49:01 blue /netbsd: 	type: ata tc_bcount: 16384 tc_skip: 0
May 18 15:49:01 blue /netbsd: satalink0:0:0: lost interrupt
May 18 15:49:01 blue /netbsd: 	type: ata tc_bcount: 16384 tc_skip: 0
May 18 15:49:01 blue /netbsd: satalink0:1:0: lost interrupt
May 18 15:49:01 blue /netbsd: 	type: ata tc_bcount: 16384 tc_skip: 0

I then moved the SATA card to one of the 33MHz (64-bit) slots and 
booted up ok (fsck ran without problems on wd0).  As soon as I ran fsck 
on the raid0a mount point that the above dump|restore failed on, I got 
another stream of lost interrupt messages.

This is the result:

May 18 17:06:51 blue /netbsd: NetBSD 2.0.2 (BLUE) #1: Thu May 12 
23:27:56 BST 2005
May 18 17:06:51 blue /netbsd: 
	root@blue.cambridge:/usr/src/sys/arch/macppc/compile/BLUE
May 18 17:06:51 blue /netbsd: total memory = 384 MB
May 18 17:06:51 blue /netbsd: avail memory = 364 MB
May 18 17:06:51 blue /netbsd: mainbus0 (root)
May 18 17:06:51 blue /netbsd: cpu0 at mainbus0: 750 (Revision 2.1), ID 
0 (primary)
May 18 17:06:51 blue /netbsd: cpu0: HID0 
8090c0a4<EMCP,DOZE,DPM,ICE,DCE,SGE,BTIC,BHT>
May 18 17:06:51 blue /netbsd: cpu0: 350.00 MHz, no-parity 1MB WT L2 
cache (PB SRAM) at 2:1 ratio
May 18 17:06:51 blue /netbsd: grackle0 at mainbus0
May 18 17:06:51 blue /netbsd: pci0 at grackle0 bus 0
May 18 17:06:51 blue /netbsd: pci0: i/o space, memory space enabled
May 18 17:06:51 blue /netbsd: pchb0 at pci0 dev 0 function 0
May 18 17:06:51 blue /netbsd: pchb0: Motorola MPC106 "Grackle" Host 
Bridge (rev. 0x40)
May 18 17:06:51 blue /netbsd: ppb0 at pci0 dev 13 function 0: Digital 
Equipment DECchip 21154 PCI-PCI Bridge (rev. 0x02)
May 18 17:06:51 blue /netbsd: pci1 at ppb0 bus 1
May 18 17:06:51 blue /netbsd: pci1: i/o space, memory space enabled
May 18 17:06:51 blue /netbsd: Texas Instruments TSB12LV21 IEEE 1394 
Host Controller (Firewire serial bus, revision 0x02) at pci1 dev 0 
function 0 not configured
May 18 17:06:51 blue /netbsd: cmdide0 at pci1 dev 1 function 0
May 18 17:06:51 blue /netbsd: cmdide0: CMD Technology PCI0646 (rev. 
0x05)
May 18 17:06:51 blue /netbsd: cmdide0: bus-master DMA support present
May 18 17:06:51 blue /netbsd: cmdide0: primary channel configured to 
native-PCI mode
May 18 17:06:51 blue /netbsd: cmdide0: using irq 26 for native-PCI 
interrupt
May 18 17:06:51 blue /netbsd: atabus0 at cmdide0 channel 0
May 18 17:06:51 blue /netbsd: cmdide0: secondary channel configured to 
native-PCI mode
May 18 17:06:51 blue /netbsd: cmdide0: secondary channel ignored 
(disabled)
May 18 17:06:51 blue /netbsd: satalink0 at pci1 dev 2 function 0
May 18 17:06:51 blue /netbsd: satalink0: Silicon Image SATALink 3112 
(rev. 0x02)
May 18 17:06:51 blue /netbsd: satalink0: SATALink BA5 register space 
disabled
May 18 17:06:51 blue /netbsd: satalink0: bus-master DMA support present
May 18 17:06:52 blue /netbsd: satalink0: primary channel wired to 
native-PCI mode
May 18 17:06:52 blue /netbsd: satalink0: using irq 23 for native-PCI 
interrupt
May 18 17:06:52 blue /netbsd: atabus1 at satalink0 channel 0
May 18 17:06:52 blue /netbsd: satalink0: secondary channel wired to 
native-PCI mode
May 18 17:06:52 blue /netbsd: atabus2 at satalink0 channel 1
May 18 17:06:52 blue /netbsd: ofb0 at pci1 dev 3 function 0: ATI 
Technologies Rage 128 GL PCI
May 18 17:06:52 blue /netbsd: ofb0: 640 x 480, 8bpp
May 18 17:06:52 blue /netbsd: wsdisplay0 at ofb0 kbdmux 1: console 
(std, vt100 emulation)
May 18 17:06:52 blue /netbsd: wsmux1: connecting to wsdisplay0
May 18 17:06:52 blue /netbsd: tlp0 at pci1 dev 4 function 0: ADMtek 
AN985 Ethernet, pass 1.1
May 18 17:06:52 blue /netbsd: tlp0: interrupting at irq 25
May 18 17:06:52 blue /netbsd: tlp0: Ethernet address 00:04:e2:39:37:ae
May 18 17:06:52 blue /netbsd: ukphy0 at tlp0 phy 1: Generic IEEE 802.3u 
media interface
May 18 17:06:52 blue /netbsd: ukphy0: OUI 0x00e092, model 0x0001, rev. 1
May 18 17:06:52 blue /netbsd: ukphy0: 10baseT, 10baseT-FDX, 100baseTX, 
100baseTX-FDX, auto
May 18 17:06:52 blue /netbsd: obio0 at pci1 dev 5 function 0: addr 
0x80800000
May 18 17:06:52 blue /netbsd: mesh0 at obio0 offset 0x10000 irq 12: 
50MHz, SCSI ID 7
May 18 17:06:52 blue /netbsd: scsibus0 at mesh0: 8 targets, 8 luns per 
target
May 18 17:06:52 blue /netbsd: zsc0 at obio0 offset 0x13000: irq 15,16
May 18 17:06:52 blue /netbsd: zstty0 at zsc0 channel 0
May 18 17:06:52 blue /netbsd: zstty1 at zsc0 channel 1
May 18 17:06:52 blue /netbsd: davbus at obio0 offset 0x14000 not 
configured
May 18 17:06:52 blue /netbsd: fdc at obio0 offset 0x15000 not configured
May 18 17:06:52 blue /netbsd: adb0 at obio0 offset 0x16000 irq 18: 0 
targets
May 18 17:06:52 blue /netbsd: wdc0 at obio0 offset 0x20000 irq 13: DMA 
transfer
May 18 17:06:52 blue /netbsd: atabus at wdc0 channel 0 not configured
May 18 17:06:52 blue /netbsd: bm0 at obio0 offset 0x11000 irq 42,33: 
address 00:05:02:b1:f0:78
May 18 17:06:52 blue /netbsd: lxtphy0 at bm0 phy 0: LXT970 10/100 media 
interface, rev. 1
May 18 17:06:52 blue /netbsd: lxtphy0: 10baseT, 10baseT-FDX, 100baseTX, 
100baseTX-FDX, auto
May 18 17:06:52 blue /netbsd: nvram0 at obio0 offset 0x60000
May 18 17:06:52 blue /netbsd: ohci0 at pci1 dev 6 function 0: Opti 
RM861HA (rev. 0x10)
May 18 17:06:52 blue /netbsd: ohci0: interrupting at irq 28
May 18 17:06:52 blue /netbsd: ohci0: OHCI version 1.0, legacy support
May 18 17:06:52 blue /netbsd: usb0 at ohci0: USB revision 1.0
May 18 17:06:52 blue /netbsd: uhub0 at usb0
May 18 17:06:52 blue /netbsd: uhub0: Opti OHCI root hub, class 9/0, rev 
1.00/1.00, addr 1
May 18 17:06:52 blue /netbsd: uhub0: 2 ports with 2 removable, self 
powered
May 18 17:06:52 blue /netbsd: Kernelized RAIDframe activated
May 18 17:06:52 blue /netbsd: IPsec: Initialized Security Association 
Processing.
May 18 17:06:52 blue /netbsd: satalink0: port 0: device present, speed: 
1.5Gb/s
May 18 17:06:52 blue /netbsd: wd0 at atabus1 drive 0satalink0: port 1: 
device present, speed: 1.5Gb/s
May 18 17:06:52 blue /netbsd: scsibus0: waiting 2 seconds for devices 
to settle...
May 18 17:06:52 blue /netbsd: : <WDC WD2500SD-01KCB0>
May 18 17:06:52 blue /netbsd: wd0: drive supports 16-sector PIO 
transfers, LBA48 addressing
May 18 17:06:52 blue /netbsd: wd0: 232 GB, 484521 cyl, 16 head, 63 sec, 
512 bytes/sect x 488397168 sectors
May 18 17:06:52 blue /netbsd: wd0: drive supports PIO mode 4, DMA mode 
2, Ultra-DMA mode 6 (Ultra/133)
May 18 17:06:52 blue /netbsd: wd0(satalink0:0:0): using PIO mode 4, 
Ultra-DMA mode 6 (Ultra/133) (using DMA data transfers)
May 18 17:06:52 blue /netbsd: wd1 at atabus2 drive 0: <WDC 
WD2500SD-01KCB0>
May 18 17:06:52 blue /netbsd: wd1: drive supports 16-sector PIO 
transfers, LBA48 addressing
May 18 17:06:52 blue /netbsd: wd1: 232 GB, 484521 cyl, 16 head, 63 sec, 
512 bytes/sect x 488397168 sectors
May 18 17:06:52 blue /netbsd: wd1: drive supports PIO mode 4, DMA mode 
2, Ultra-DMA mode 6 (Ultra/133)
May 18 17:06:52 blue /netbsd: wd1(satalink0:1:0): using PIO mode 4, 
Ultra-DMA mode 6 (Ultra/133) (using DMA data transfers)
May 18 17:06:52 blue /netbsd: uhub1 at uhub0 port 2
May 18 17:06:52 blue /netbsd: uhub1: Mitsumi Electric Hub in Apple 
Extended USB Keyboard, class 9/0, rev 1.10/1.22, addr 2
May 18 17:06:52 blue /netbsd: uhub1: 3 ports with 2 removable, bus 
powered
May 18 17:06:52 blue /netbsd: uhidev0 at uhub1 port 1 configuration 1 
interface 0
May 18 17:06:52 blue /netbsd: uhidev0: Mitsumi Electric Apple Extended 
USB Keyboard, rev 1.10/1.22, addr 3, iclass 3/1
May 18 17:06:52 blue /netbsd: ukbd0 at uhidev0: 8 modifier keys, 6 key 
codes
May 18 17:06:52 blue /netbsd: wskbd0 at ukbd0: console keyboard, using 
wsdisplay0
May 18 17:06:52 blue /netbsd: uhidev1 at uhub1 port 1 configuration 1 
interface 1
May 18 17:06:52 blue /netbsd: uhidev1: Mitsumi Electric Apple Extended 
USB Keyboard, rev 1.10/1.22, addr 3, iclass 3/0
May 18 17:06:52 blue /netbsd: uhidev1: 3 report ids
May 18 17:06:52 blue /netbsd: uhid at uhidev1 reportid 2 not configured
May 18 17:06:52 blue /netbsd: uhid at uhidev1 reportid 3 not configured
May 18 17:06:52 blue /netbsd: uhidev2 at uhub1 port 2 configuration 1 
interface 0
May 18 17:06:52 blue /netbsd: uhidev2: Logitech M4848, rev 1.00/5.00, 
addr 4, iclass 3/1
May 18 17:06:52 blue /netbsd: ums0 at uhidev2: 1 button
May 18 17:06:52 blue /netbsd: wsmouse0 at ums0 mux 0
May 18 17:06:52 blue /netbsd: boot device: <unknown>
May 18 17:06:52 blue /netbsd: root on wd0a dumps on wd0b
May 18 17:06:52 blue savecore: no core dump
May 18 17:06:53 blue ntpd[253]: ntpd 4.2.0-r Tue Mar 22 15:46:59 UTC 
2005 (1)
May 18 17:06:53 blue ntpd[253]: precision = 2.000 usec
May 18 17:06:53 blue ntpd[253]: kernel time sync status 0040
May 18 17:06:53 blue ntpd[253]: frequency initialized 500.000 PPM from 
/var/db/ntp.drift
May 18 17:07:59 blue /netbsd: raidlookup on device: /dev/wd9a failed!
May 18 17:07:59 blue /netbsd: Hosed component: /dev/wd1a
May 18 17:07:59 blue /netbsd: Hosed component: /dev/wd9a
May 18 17:07:59 blue /netbsd: raid0: Component /dev/wd9a being 
configured at col: 0
May 18 17:07:59 blue /netbsd:          Column: 0 Num Columns: 0
May 18 17:07:59 blue /netbsd:          Version: 0 Serial Number: 0 Mod 
Counter: 0
May 18 17:07:59 blue /netbsd:          Clean: No Status: 0
May 18 17:07:59 blue /netbsd: /dev/wd9a has a different modfication 
count: 66 0
May 18 17:07:59 blue /netbsd: Number of columns do not match for: 
/dev/wd9a
May 18 17:07:59 blue /netbsd: /dev/wd9a is not clean!
May 18 17:07:59 blue /netbsd: raid0: Component /dev/wd1a being 
configured at col: 1
May 18 17:07:59 blue /netbsd:          Column: 1 Num Columns: 2
May 18 17:07:59 blue /netbsd:          Version: 2 Serial Number: 
20050518 Mod Counter: 66
May 18 17:07:59 blue /netbsd:          Clean: No Status: 0
May 18 17:07:59 blue /netbsd: /dev/wd1a has a different serial number: 
0 20050518
May 18 17:07:59 blue /netbsd: /dev/wd1a is not clean!
May 18 17:07:59 blue /netbsd: raid0: There were fatal errors
May 18 17:07:59 blue /netbsd: raid0: Fatal errors being ignored.
May 18 17:07:59 blue /netbsd: raid0: RAID Level 1
May 18 17:07:59 blue /netbsd: raid0: Components: /dev/wd9a[**FAILED**] 
/dev/wd1a
May 18 17:07:59 blue /netbsd: raid0: Total Sectors: 488355968 (238455 
MB)
May 18 17:08:17 blue /netbsd: raid0: Error re-writing parity!
May 18 17:08:57 blue /netbsd: satalink0:0:0: lost interrupt
May 18 17:09:47 blue /netbsd: 	type: ata tc_bcount: 16384 tc_skip: 0
May 18 17:10:27 blue /netbsd: satalink0:1:0: lost interrupt
May 18 17:11:27 blue /netbsd: 	type: ata tc_bcount: 1024 tc_skip: 0
May 18 17:12:47 blue /netbsd: satalink0:0:0: lost interrupt
May 18 17:14:07 blue /netbsd: 	type: ata tc_bcount: 16384 tc_skip: 0
May 18 17:14:37 blue /netbsd: satalink0:1:0: lost interrupt
May 18 17:15:48 blue /netbsd: 	type: ata tc_bcount: 8192 tc_skip: 0
May 18 17:16:18 blue /netbsd: satalink0:0:0: lost interrupt
May 18 17:17:28 blue /netbsd: 	type: ata tc_bcount: 10240 tc_skip: 0
May 18 17:17:58 blue /netbsd: satalink0:1:0: lost interrupt
May 18 17:18:58 blue /netbsd: 	type: ata tc_bcount: 8192 tc_skip: 0

Has anyone else seen this ?  Should I be looking at the satalink code, 
or is it more likely to be a macppc issue ?  Have I messed up my kernel 
config ? (I have hardcoded wd0 and wd1 so that they are no longer 
dynamic to aid debugging raid drive failures)  I'm in the process of 
downloading and building NetBSD 3 - is this likely to help ?  Is there 
anything extra I can add to the system (kernel, userland, *anything*) 
that can help me debug this ?

Thanks in advance for any suggestions: I've not gone this deeply into 
NetBSD driver problems before, so all advice is most welcome (even if 
it is 'post to port-macppc' :)

TTFN,
-- 
ian.
GPG Fingerprint: D170 35A3 C858 6E85 9B5B  1557 4CD5 6F6F E176 2D0A