Subject: port-i386/17957: page fault trap on SMP kernel
To: None <gnats-bugs@gnats.netbsd.org>
From: None <jarle@uninett.no>
List: netbsd-bugs
Date: 08/16/2002 14:23:59
>Number:         17957
>Category:       port-i386
>Synopsis:       page fault trap on SMP kernel
>Confidential:   no
>Severity:       serious
>Priority:       medium
>Responsible:    port-i386-maintainer
>State:          open
>Class:          sw-bug
>Submitter-Id:   net
>Arrival-Date:   Fri Aug 16 05:25:00 PDT 2002
>Closed-Date:
>Last-Modified:
>Originator:     Jarle Greipsland
>Release:        NetBSD 1.6B sommerfeld_i386mp_1 June 25th -current synch
>Organization:
UNINETT
>Environment:
	
	
System: NetBSD splitter-pine.urc.uninett.no 1.6B NetBSD 1.6B (GENERIC.MPDEBUG) #10: Mon Jul  1 12:00:35 CEST 2002     jarle@splitter-pine.urc.uninett.no:/usr/src/sys/arch/i386/compile/GENERIC.MPDEBUG i386
Architecture: i386
Machine: i386
>Description:
The system crashed with the kernel message:
kernel: page fault trap, code=0

This happened while I was using ttcp to measure the network speed from
another computer on the same cisco-4006 switch.  The commands run were:
splitter-pine% ttcp -r -s -p 9876  -b 128000
other-system% ttcp -t -s -p 9876 -b 128000 -f k -n 16384 splitter-pine

I had previously been running the test in the other direction, i.e. with
splitter-pine as the traffic generator, without any problems.

To the untrained eye (read: me), the DDB output suggests a kernel stack
overrun.

A transcript of the DDB session follows:
kernel: page fault trap, code=0
Stopped in pid 11897 (setiathome) at    Xintrltimer+0x49:       addb    %al,0xbc
e904c4(%ebx)
db{3}> 
kernel: page fault trap, code=0
Stopped in pid 11897 (setiathome) at    Xintrltimer+0x49:       addb    %al,0xbc
e904c4(%ebx)
db{3}> trace
Xintrltimer() at Xintrltimer+0x49
--- interrupt ---
_lockmgr(c0871b00,400042,0,c06cc180,513,c0844260,80,d0) at _lockmgr+0xf88
_kernel_lock(42,e668acc8,3,400000) at _kernel_lock+0x5e
apic_intlock(60,400010,30,c06c0010,10) at apic_intlock+0x10
Xintrioapic1() at Xintrioapic1+0x5c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xdoreti() at Xdoreti+0x3c
--- interrupt ---
Xsoftnet() at Xsoftnet+0x81
--- interrupt ---
Xdoreti() at Xdoreti+0x2b
--- interrupt ---
Xdoreti() at Xdoreti+0x2b
--- interrupt ---
Xdoreti() at Xdoreti+0x2b
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x2b
--- interrupt ---
Xdoreti() at Xdoreti+0x2b
--- interrupt ---
Xdoreti() at Xdoreti+0x2b
--- interrupt ---
Xdoreti() at Xdoreti+0x2b
--- interrupt ---
Xdoreti() at Xdoreti+0x2b
--- interrupt ---
Xdoreti() at Xdoreti+0x2b
--- interrupt ---
Xdoreti() at Xdoreti+0x2b
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x2b
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x2b
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x2b
--- interrupt ---
Xdoreti() at Xdoreti+0x2b
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
Xdoreti() at Xdoreti+0x2b
--- interrupt ---
Xdoreti() at Xdoreti+0x2b
--- interrupt ---
Xdoreti() at Xdoreti+0x2b
--- interrupt ---
Xdoreti() at Xdoreti+0x2b
--- interrupt ---
Xdoreti() at Xdoreti+0x18
--- interrupt ---
gdt_desc+0xb8e3:
db{3}> ps
 PID             PPID       PGRP        UID S   FLAGS          COMMAND    WAIT
 4475           22515       4475       1001 3 0x84086             ttcp   netio
 4159           22515       4159       1001 3 0x84086       junkbuster  netcon
 26969          22515      26969       1001 3 0x84087       galeon-bin  select
 24787              1          1          0 3 0x84084            getty nanosle
 22884              1      22882       1001 3 0x84087         gconfd-1  select
 17900              1      26791          0 3 0x84086             Xvfb  select
 24781          22515      24781          0 4  0x5006             tcsh
 22515          22514      22515       1001 3 0x84086             bash    wait
 22514          22511      22511       1001 3 0x84184            xterm  select
 22511          22510      22511       1001 3 0x84080              csh   pause
 22510          22508      22508       1001 3 0x80184             sshd  select
 22508            215      22508          0 3 0x80180             sshd   netio
*>11897              1      11897       1000 7  0x4006       setiathome
 29391              1      29391          0 3 0x80084             ntpd   pause
 1474               1       1474       1001 3 0x84084             oafd  select
 247                1        235       1000 7  0x4004       setiathome
 243                1        232       1000 7  0x4004       setiathome
 240                1        240          0 3 0x84082            getty   ttyin
 239                1        239          0 3 0x84082            getty   ttyin
 238                1        238          0 3 0x84082            getty   ttyin
 236                1        236          0 3 0x84086            getty   ttyin
 226                1        226          0 3 0x80084             cron nanosle
 223                1        223          0 3 0x80080            inetd   pause
 215                1        215          0 3 0x80084             sshd  select
 186              185          9       1002 3 0x80086         postgres  select
 185              181          9       1002 3 0x80086         postgres  select
 181                1          9       1002 3 0x84086         postgres  select
 126                1        126          0 3 0x80084        mount_mfs  mfsidl
 105                1        105          0 3 0x80084          syslogd  select
 8                  0          0          0 3 0xa0204         aiodoned aiodone
 7                  0          0          0 3 0xa0204          ioflush  syncer
 6                  0          0          0 3 0x20204           reaper  reaper
 5                  0          0          0 3 0xa0204       pagedaemon pgdaemo
 4                  0          0          0 3 0xa0204         scsibus2  sccomp
 3                  0          0          0 3 0xa0204         scsibus1  sccomp
 2                  0          0          0 3 0xa0204         scsibus0  sccomp
 1                  0          1          0 3 0x84084             init    wait
 0                 -1          0          0 3 0xa0204          swapper schedul
 4461            4159       4159       1001 5  0x2002       junkbuster
db{3}> reboot 100
syncing disks... panic: kernel debugging assertion "(v == __SIMPLELOCK_LOCKED) || (v == __SIMPLELOCK_UNLOCKED)" failed: file "/usr/src/sys/arch/i386/compile/GENERIC.MPDEBUG/../../../../arch/i386/i386/lock_machdep.c", line 84

Stopped in pid 11897 (setiathome) at    breakpoint+0x4: leave
db{3}> reboot
rebooting...

>How-To-Repeat:
I haven't repeated this, but I suspect that one could 
use ttcp (or possibly some other traffic generating tool) to send large
volumes of high speed traffic to the system.
	
>Fix:
	
unknown.
>Release-Note:
>Audit-Trail:
>Unformatted:
 	
 	
 >> NetBSD/i386 BIOS Boot, Revision 2.7
 >> (he@hamster.urc.uninett.no, Mon Dec 10 05:46:17 CET 2001)
 >> Memory: 639/1047544 k
 Use hd1a:netbsd to boot sd0 when wd0 is also installed
 Press return to boot now, any other key for boot menu
 booting wd0a:netbsd - starting in 0
 7523008+115824+328512 [65+305552+244866]=0x820fcc
 [ using 550940 bytes of netbsd ELF symbol table ]
 BIOS CFG: Model-SubM-Rev: fc-01-00, 0x74<EBDA,KBDINT,RTC,IC2>
 Copyright (c) 1996, 1997, 1998, 1999, 2000, 2001, 2002
     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.6B (GENERIC.MPDEBUG) #10: Mon Jul  1 12:00:35 CEST 2002
     jarle@splitter-pine.urc.uninett.no:/usr/src/sys/arch/i386/compile/GENERIC.MPDEBUG
 total memory = 1023 MB
 avail memory = 930 MB
 using 6144 buffers containing 52508 KB of memory
 BIOS32 rev. 0 found at 0xffe90
 mainbus0 (root)
 mainbus0: scanning 0x9fc00 to 0x9fff0 for MP signature
 mainbus0: scanning 0x9f800 to 0x9fbf0 for MP signature
 mainbus0: scanning 0xf0000 to 0xffff0 for MP signature
 mainbus0: MP floating pointer found in bios at 0xfe710
 mainbus0: MP config table at 0xf0000, 468 bytes long
 mainbus0: Intel MP Specification (Version 1.4) (DELL     PowerEdge 83)
 cpu0 at mainbus0: apid 3 (boot processor)
 cpu0: Intel Pentium II/Celeron (Deschutes) (686-class), 450.01 MHz
 cpu0: features 183fbff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR>
 cpu0: features 183fbff<PGE,MCA,CMOV,FGPAT,PSE36,MMX>
 cpu0: features 183fbff<FXSR>
 cpu0: I-cache 16 KB 32b/line 4-way, D-cache 16 KB 32b/line 4-way
 cpu0: L2 cache 512 KB 32b/line 4-way
 cpu0: ITLB 32 4 KB entries 4-way, 2 4 MB entries fully associative
 cpu0: DTLB 64 4 KB entries 4-way, 8 4 MB entries 4-way
 cpu0: calibrating local timer
 cpu0: apic clock running at 99 MHz
 cpu0: 32 page colors
 cpu0: kstack at 0xe4288000 for 8192 bytes
 cpu0: idle pcb at 0xe4288000, idle sp at 0xe4289f98
 cpu1 at mainbus0: apid 0 (application processor)
 cpu1: starting
 cpu1: Intel Pentium II/Celeron (Deschutes) (686-class), 449.98 MHz
 cpu1: features 183fbff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR>
 cpu1: features 183fbff<PGE,MCA,CMOV,FGPAT,PSE36,MMX>
 cpu1: features 183fbff<FXSR>
 cpu1: I-cache 16 KB 32b/line 4-way, D-cache 16 KB 32b/line 4-way
 cpu1: L2 cache 512 KB 32b/line 4-way
 cpu1: ITLB 32 4 KB entries 4-way, 2 4 MB entries fully associative
 cpu1: DTLB 64 4 KB entries 4-way, 8 4 MB entries 4-way
 cpu1: kstack at 0xe429a000 for 8192 bytes
 cpu1: idle pcb at 0xe429a000, idle sp at 0xe429bf98
 cpu2 at mainbus0: apid 1 (application processor)
 cpu2: starting
 cpu2: Intel Pentium II/Celeron (Deschutes) (686-class), 449.98 MHz
 cpu2: features 183fbff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR>
 cpu2: features 183fbff<PGE,MCA,CMOV,FGPAT,PSE36,MMX>
 cpu2: features 183fbff<FXSR>
 cpu2: I-cache 16 KB 32b/line 4-way, D-cache 16 KB 32b/line 4-way
 cpu2: L2 cache 512 KB 32b/line 4-way
 cpu2: ITLB 32 4 KB entries 4-way, 2 4 MB entries fully associative
 cpu2: DTLB 64 4 KB entries 4-way, 8 4 MB entries 4-way
 cpu2: kstack at 0xe42ac000 for 8192 bytes
 cpu2: idle pcb at 0xe42ac000, idle sp at 0xe42adf98
 cpu3 at mainbus0: apid 2 (application processor)
 cpu3: starting
 cpu3: Intel Pentium II/Celeron (Deschutes) (686-class), 449.98 MHz
 cpu3: features 183fbff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR>
 cpu3: features 183fbff<PGE,MCA,CMOV,FGPAT,PSE36,MMX>
 cpu3: features 183fbff<FXSR>
 cpu3: I-cache 16 KB 32b/line 4-way, D-cache 16 KB 32b/line 4-way
 cpu3: L2 cache 512 KB 32b/line 4-way
 cpu3: ITLB 32 4 KB entries 4-way, 2 4 MB entries fully associative
 cpu3: DTLB 64 4 KB entries 4-way, 8 4 MB entries 4-way
 cpu3: kstack at 0xe42be000 for 8192 bytes
 cpu3: idle pcb at 0xe42be000, idle sp at 0xe42bff98
 mpbios: bus 0 is type PCI   
 mpbios: bus 1 is type PCI   
 mpbios: bus 2 is type PCI   
 mpbios: bus 3 is type ISA   
 ioapic0 at mainbus0 apid 4 (I/O APIC)
 ioapic0: pa 0xfec00000, virtual wire mode, version 11, 24 pins
 ioapic0: misconfigured as apic 0
 ioapic0: remapped to apic 4
 ioapic0: int0 attached to ExtINT (type 3<type=3=ExtINT> flags 5<pol=1=Act Hi,trig=1=Edge>)
 ioapic0: int1 attached to isa0 irq 1 (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int2 attached to isa0 irq 0 (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int3 attached to isa0 irq 3 (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int4 attached to isa0 irq 4 (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int6 attached to isa0 irq 6 (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int7 attached to isa0 irq 7 (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int8 attached to isa0 irq 8 (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int9 attached to isa0 irq 9 (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int12 attached to isa0 irq 12 (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int15 attached to isa0 irq 15 (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int16 attached to pci2 device 1 INT_B (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int16 attached to pci2 device 3 INT_C (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int16 attached to pci2 device 5 INT_D (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int16 attached to pci2 device 7 INT_A (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int17 attached to pci2 device 1 INT_C (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int17 attached to pci2 device 3 INT_D (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int17 attached to pci2 device 5 INT_A (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int17 attached to pci2 device 7 INT_B (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int18 attached to pci2 device 1 INT_D (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int18 attached to pci2 device 3 INT_A (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int18 attached to pci2 device 5 INT_B (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int18 attached to pci2 device 7 INT_C (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int19 attached to pci2 device 1 INT_A (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int19 attached to pci2 device 3 INT_B (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int19 attached to pci2 device 5 INT_C (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int19 attached to pci2 device 7 INT_D (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int20 attached to pci0 device 6 INT_B (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int20 attached to pci0 device 8 INT_C (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int20 attached to pci0 device 10 INT_D (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int20 attached to pci1 device 8 INT_A (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int21 attached to pci1 device 4 INT_A (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int22 attached to pci1 device 6 INT_A (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int14 attached to pci0 device 6 INT_C (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int14 attached to pci0 device 8 INT_D (type 0<type=0> flags 0<pol=0,trig=0>)
 ioapic0: int14 attached to pci0 device 10 INT_A (type 0<type=0> flags 0<pol=0,trig=0>)
 local apic: int0 attached to ExtINT (type 3<type=3=ExtINT> flags 5<pol=1=Act Hi,trig=1=Edge>)
 local apic: int1 attached to NMI (type 1<type=1=NMI> flags 5<pol=1=Act Hi,trig=1=Edge>)
 mainbus0: MP WARNING: 128 bytes of extended entries not examined
 pci0 at mainbus0 bus 0: configuration mode 1
 pci0: i/o space, memory space enabled, rd/line, rd/mult, wr/inv ok
 pcib0 at pci0 dev 2 function 0
 pcib0: Intel 82371AB PCI-to-ISA Bridge (PIIX4) (rev. 0x02)
 pciide0 at pci0 dev 2 function 1: Intel 82371AB IDE controller (PIIX4) (rev. 0x01)
 pciide0: device disabled (at device)
 uhci0 at pci0 dev 2 function 2: Intel 82371AB USB Host Controller (PIIX4) (rev. 0x01)
 uhci0: can't map i/o space
 Intel 82371AB Power Management Controller (PIIX4) (miscellaneous bridge, revision 0x02) at pci0 dev 2 function 3 not configured
 vga1 at pci0 dev 4 function 0: ATI Technologies 3D Rage Pro (rev. 0x5c)
 wsdisplay0 at vga1 kbdmux 1
 wsmux1: connecting to wsdisplay0
 fxp0 at pci0 dev 10 function 0: i82558 Ethernet, rev 5
 fxp0: interrupting at apic 4 int 14 (irq 14)
 fxp0: detected 64 word EEPROM
 fxp0: Ethernet address 00:90:27:45:e3:2a
 inphy0 at fxp0 phy 1: i82555 10/100 media interface, rev. 0
 inphy0: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto
 pchb0 at pci0 dev 16 function 0
 pchb0: Intel 82451NX Memory & I/O Controller (MIOC) (rev. 0x03)
 pchb1 at pci0 dev 18 function 0
 pchb1: Intel 82451NX PCI Expander Bridge (PXB) (rev. 0x02)
 pchb2 at pci0 dev 19 function 0
 pchb2: Intel 82451NX PCI Expander Bridge (PXB) (rev. 0x02)
 pci1 at pchb2 bus 1
 pci1: i/o space, memory space enabled, rd/line, rd/mult, wr/inv ok
 ahc1 at pci1 dev 4 function 0
 ahc1: interrupting at apic 4 int 21 (irq 11)
 ahc1: aic7890/91 Wide Channel A, SCSI Id=7, 16/255 SCBs
 scsibus0 at ahc1: 16 targets, 8 luns per target
 ahc2 at pci1 dev 6 function 0
 ahc2: interrupting at apic 4 int 22 (irq 10)
 ahc2: aic7890/91 Wide Channel A, SCSI Id=7, 16/255 SCBs
 scsibus1 at ahc2: 16 targets, 8 luns per target
 ahc3 at pci1 dev 8 function 0
 ahc3: interrupting at apic 4 int 20 (irq 5)
 ahc3: aic7860 Single Channel A, SCSI Id=7, 3/255 SCBs
 scsibus2 at ahc3: 8 targets, 8 luns per target
 pchb3 at pci0 dev 20 function 0
 pchb3: Intel 82451NX PCI Expander Bridge (PXB) (rev. 0x02)
 pci2 at pchb3 bus 2
 pci2: i/o space, memory space enabled, rd/line, rd/mult, wr/inv ok
 isa0 at pcib0
 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
 pckbd0 at pckbc0 (kbd slot)
 pckbc0: using irq 1 for kbd slot
 wskbd0 at pckbd0 mux 1
 wskbd0: connecting to wsdisplay0
 pmsprobe: reset error 5
 lpt0 at isa0 port 0x378-0x37b irq 7
 lptprobe: mask ff data 55 failed
 lptprobe: mask ff data 55 failed
 seaprobe: board type unknown at address 0xc0950000
 pcppi0 at isa0 port 0x61
 midi0 at pcppi0: PC speaker
 sysbeep0 at pcppi0
 isapnp0 at isa0 port 0x279: ISA Plug 'n Play device support
 npx0 at isa0 port 0xf0-0xff: using exception 16
 fdc0 at isa0 port 0x3f0-0x3f7 irq 6 drq 2
 fd0 at fdc0 drive 0: 1.44MB, 80 cyl, 2 head, 18 sec
 isapnp0: no ISA Plug 'n Play devices found
 biomask 0 netmask 0 ttymask 0
 cpu0: prelint0 700<vector=0,delmode=7,dest=0> 0<target=0>
 cpu0: prelint1 400<vector=0,delmode=4,dest=0> 0<target=0>
 cpu0: timer0 300d0<vector=d0,delmode=0,masked,dest=0> 0<target=0>
 cpu0: pcint0 10000<vector=0,delmode=0,masked,dest=0> 0<target=0>
 cpu0: lint0 10700<vector=0,delmode=7,masked,dest=0> 0<target=0>
 cpu0: lint1 400<vector=0,delmode=4,dest=0> 0<target=0>
 cpu0: err0 10000<vector=0,delmode=0,masked,dest=0> 0<target=0>
 ioapic0: enabling
 ioapic0: int0 10700<vector=0,delmode=7,masked,dest=0> 0<target=0>
 ioapic0: int1 1a0<vector=a0,delmode=1,dest=0> 3000000<target=3>
 ioapic0: int2 10100<vector=0,delmode=1,masked,dest=0> 0<target=0>
 ioapic0: int3 1e1<vector=e1,delmode=1,dest=0> 3000000<target=3>
 ioapic0: int4 1e2<vector=e2,delmode=1,dest=0> 3000000<target=3>
 ioapic0: int5 10000<vector=0,delmode=0,masked,dest=0> 0<target=0>
 ioapic0: int6 170<vector=70,delmode=1,dest=0> 3000000<target=3>
 ioapic0: int7 1a1<vector=a1,delmode=1,dest=0> 3000000<target=3>
 ioapic0: int8 10100<vector=0,delmode=1,masked,dest=0> 0<target=0>
 ioapic0: int9 10100<vector=0,delmode=1,masked,dest=0> 0<target=0>
 ioapic0: int10 10000<vector=0,delmode=0,masked,dest=0> 0<target=0>
 ioapic0: int11 10000<vector=0,delmode=0,masked,dest=0> 0<target=0>
 ioapic0: int12 10100<vector=0,delmode=1,masked,dest=0> 0<target=0>
 ioapic0: int13 10000<vector=0,delmode=0,masked,dest=0> 0<target=0>
 ioapic0: int14 a181<vector=81,delmode=1,actlo,level,dest=0> 3000000<target=3>
 ioapic0: int15 10100<vector=0,delmode=1,masked,dest=0> 0<target=0>
 ioapic0: int16 1a100<vector=0,delmode=1,actlo,level,masked,dest=0> 0<target=0>
 ioapic0: int17 1a100<vector=0,delmode=1,actlo,level,masked,dest=0> 0<target=0>
 ioapic0: int18 1a100<vector=0,delmode=1,actlo,level,masked,dest=0> 0<target=0>
 ioapic0: int19 1a100<vector=0,delmode=1,actlo,level,masked,dest=0> 0<target=0>
 ioapic0: int20 a171<vector=71,delmode=1,actlo,level,dest=0> 3000000<target=3>
 ioapic0: int21 a172<vector=72,delmode=1,actlo,level,dest=0> 3000000<target=3>
 ioapic0: int22 a173<vector=73,delmode=1,actlo,level,dest=0> 3000000<target=3>
 ioapic0: int23 10000<vector=0,delmode=0,masked,dest=0> 0<target=0>
 scsibus0: waiting 2 seconds for devices to settle...
 sd0 at scsibus0 target 0 lun 0: <IBM, DNES-318350Y, SA60> SCSI3 0/direct fixed
 sd0: 17366 MB, 11474 cyl, 10 head, 309 sec, 512 bytes/sect x 35566501 sectors
 sd0: sync (25.0ns offset 31), 16-bit (80.000MB/s) transfers, tagged queueing
 sd1 at scsibus0 target 1 lun 0: <QUANTUM, QM34500TD-SCA, N1K0> SCSI2 0/direct fixed
 sd1: 4341 MB, 8057 cyl, 5 head, 220 sec, 512 bytes/sect x 8891624 sectors
 sd1: sync (25.0ns offset 31), 16-bit (80.000MB/s) transfers, tagged queueing
 sd2 at scsibus0 target 2 lun 0: <QUANTUM, QM34500TD-SCA, N1K0> SCSI2 0/direct fixed
 sd2: 4341 MB, 8057 cyl, 5 head, 220 sec, 512 bytes/sect x 8891624 sectors
 sd2: sync (25.0ns offset 31), 16-bit (80.000MB/s) transfers, tagged queueing
 ses0 at scsibus0 target 6 lun 0: <DELL, 1x3 U2W SCSI BP, 5.39> SCSI2 3/processor fixed
 ses0: SAF-TE Compliant Device
 ses0: async, 8-bit transfers
 scsibus1: waiting 2 seconds for devices to settle...
 scsibus2: waiting 2 seconds for devices to settle...
 cd0 at scsibus2 target 5 lun 0: <NEC, CD-ROM DRIVE:465, 1.03> SCSI2 5/cdrom removable
 cd0: sync (50.0ns offset 15), 8-bit (20.000MB/s) transfers
 boot device: sd0
 root on sd0a dumps on sd0b
 mountroot: trying coda...
 mountroot: trying msdos...
 mountroot: trying cd9660...
 isofs: session offset (part 0) 0
 mountroot: trying ntfs...
 mountroot: trying nfs...
 mountroot: trying lfs...
 mountroot: trying ext2fs...
 mountroot: trying ffs...
 root file system type: ffs
 cpu1: prelint0 10000<vector=0,delmode=0,masked,dest=0> 0<target=0>
 cpu1: prelint1 10000<vector=0,delmode=0,masked,dest=0> 0<target=0>
 cpu1: timer0 200d0<vector=d0,delmode=0,dest=0> 0<target=0>
 cpu1: pcint0 10000<vector=0,delmode=0,masked,dest=0> 0<target=0>
 cpu1: lint0 10700<vector=0,delmode=7,masked,dest=0> 0<target=0>
 cpu1: lint1 400<vector=0,delmode=4,dest=0> 0<target=0>
 cpu1: err0 10000<vector=0,delmode=0,masked,dest=0> 0<target=0>
 cpu1: CPU 0 running
 cpu2: prelint0 10000<vector=0,delmode=0,masked,dest=0> 0<target=0>
 cpu2: prelint1 10000<vector=0,delmode=0,masked,dest=0> 0<target=0>
 cpu2: timer0 200d0<vector=d0,delmode=0,dest=0> 0<target=0>
 cpu2: pcint0 10000<vector=0,delmode=0,masked,dest=0> 0<target=0>
 cpu2: lint0 10700<vector=0,delmode=7,masked,dest=0> 0<target=0>
 cpu2: lint1 400<vector=0,delmode=4,dest=0> 0<target=0>
 cpu2: err0 10000<vector=0,delmode=0,masked,dest=0> 0<target=0>
 cpu2: CPU 1 running
 cpu3: prelint0 10000<vector=0,delmode=0,masked,dest=0> 0<target=0>
 cpu3: prelint1 10000<vector=0,delmode=0,masked,dest=0> 0<target=0>
 cpu3: timer0 200d0<vector=d0,delmode=0,dest=0> 0<target=0>
 cpu3: pcint0 10000<vector=0,delmode=0,masked,dest=0> 0<target=0>
 cpu3: lint0 10700<vector=0,delmode=7,masked,dest=0> 0<target=0>
 cpu3: lint1 400<vector=0,delmode=4,dest=0> 0<target=0>
 cpu3: err0 10000<vector=0,delmode=0,masked,dest=0> 0<target=0>
 cpu3: CPU 2 running
 init: copying out path `/sbin/init' 11
 Fri Aug 16 08:58:52 GMT 2002
 Configuring CCD devices.
 swapctl: adding /dev/sd0b as swap device at priority 0
 Starting file system checks:
 /dev/rsd0a: 1689 files, 40550 used, 29776 free (144 frags, 3704 blocks, 0.2% fragmentation)
 /dev/rsd0a: MARKING FILE SYSTEM CLEAN
 /dev/rsd0e: 1741 files, 22286 used, 2457889 free (249 frags, 307205 blocks, 0.0% fragmentation)
 /dev/rsd0e: MARKING FILE SYSTEM CLEAN
 /dev/rccd0a: 416 files, 142796 used, 8475232 free (48 frags, 1059398 blocks, 0.0% fragmentation)
 /dev/rccd0a: MARKING FILE SYSTEM CLEAN
 /dev/rsd0g: UNREF FILE I=2822420  OWNER=root MODE=100755
 /dev/rsd0g: SIZE=122607 MTIME=Jun  4 15:56 2002  (CLEARED)
 /dev/rsd0g: UNREF FILE I=2822426  OWNER=root MODE=100555
 /dev/rsd0g: SIZE=65252 MTIME=Jun  4 15:56 2002  (CLEARED)
 /dev/rsd0g: UNREF FILE I=2900925  OWNER=jarle MODE=100700
 /dev/rsd0g: SIZE=1157 MTIME=Aug  2 14:17 2002  (CLEARED)
 /dev/rsd0g: FREE BLK COUNT(S) WRONG IN SUPERBLK (SALVAGED)
 /dev/rsd0g: SUMMARY INFORMATION BAD (SALVAGED)
 /dev/rsd0g: BLK(S) MISSING IN BIT MAPS (SALVAGED)
 /dev/rsd0g: 500894 files, 5273342 used, 8215776 free (67320 frags, 1018557 blocks, 0.5% fragmentation)
 /dev/rsd0g: MARKING FILE SYSTEM CLEAN
 Setting tty flags.
 Setting sysctl variables:
 net.inet.tcp.sendspace: 16384 -> 64000
 net.inet.tcp.recvspace: 16384 -> 64000
 kern.autonicetime: 600 -> 0
 Starting network.
 Hostname: splitter-pine.urc.uninett.no
 IPv6 mode: autoconfigured host
 Configuring network interfaces: fxp0.
 add net default: gateway 158.38.152.1
 Adding interface aliases:
 Sending router solicitation...
 Building databases...
 wsdisplay0: screen 1 added (80x25, vt100 emulation)
 wsdisplay0: screen 2 added (80x25, vt100 emulation)
 wsdisplay0: screen 3 added (80x25, vt100 emulation)
 wsdisplay0: screen 4 added (80x25, vt100 emulation)
 Starting syslogd.
 Checking for core dump...
 savecore: no core dump
 Setting date via ntp.
 Aug 16 11:03:18 splitter-pine ntpdate[116]: no server suitable for synchronization found
 Mounting all filesystems...
 Warning: inode blocks/cyl group (141) >= data blocks (63) in last
     cylinder group. This implies 1022 sector(s) cannot be allocated.
 Clearing /tmp.
 Creating a.out runtime link editor directory cache.
 Checking quotas: done.
 Starting virecover.
 starting local daemons:Starting pgsql.
 Updating motd.
 Starting ntpd.
 Starting sshd.
 Starting inetd.
 Starting cron.
 Fri Aug 16 11:03:27 CEST 2002
 
 NetBSD/i386 (splitter-pine.urc.uninett.no) (console)
 
 login: Aug 16 11:03:31 splitter-pine getty[255]: /dev/ttyE0: Device not configured