Subject: kern/20367: panic: SA VP 15243.3 is in state 7, not running or sleeping
To: None <gnats-bugs@gnats.netbsd.org>
From: None <jarle@uninett.no>
List: netbsd-bugs
Date: 02/16/2003 16:11:50
>Number:         20367
>Category:       kern
>Synopsis:       panic: SA VP 15243.3 is in state 7, not running or sleeping
>Confidential:   no
>Severity:       serious
>Priority:       medium
>Responsible:    kern-bug-people
>State:          open
>Class:          sw-bug
>Submitter-Id:   net
>Arrival-Date:   Sun Feb 16 07:12:00 PST 2003
>Closed-Date:
>Last-Modified:
>Originator:     Jarle Greipsland
>Release:        NetBSD 1.6N
>Organization:
The redundancy department of redundancy
>Environment:
	
	
System: NetBSD splitter-pine.urc.uninett.no 1.6N NetBSD 1.6N (GENERIC.MPDEBUG) #12: Fri Feb 14 21:55:33 CET 2003 jarle@splitter-pine.urc.uninett.no:/sys/arch/i386/compile/GENERIC.MPDEBUG i386
Architecture: i386
Machine: i386
>Description:
I had just compiled and installed a fresh version of phoenix from the
pkgsrc setup.  When I tried to run it, the system paniced with the message:
  panic: SA VP 15243.3 is in state 7, not running or sleeping

The system kernel and binaries are from the -current source base from
yesterday.

DDB output and dmesg follows below.

panic: SA VP 15243.3 is in state 7, not running or sleeping

Stopped in pid 15243.1 (phoenix-bin) at cpu_Debugger+0x4:       leave
db{1}> trace
cpu_Debugger(e6712708,0,e669e1d4,c030c692,c07295a0) at cpu_Debugger+0x4
panic(c05779e0,3b8b,3,7,e669e1d4) at panic+0xb8
sa_vp_repossess(e6712008,e6733c6c,e6733c76,c200c540,e669e1d4) at sa_vp_repossess
+0xd3
sa_upcall_userret(e6712008,e6733f80,c,c03c0821,0) at sa_upcall_userret+0x14c
syscall_plain(1f,1f,1f,1f,ffffffff) at syscall_plain+0x161
db{1}> ps
 PID           PPID     PGRP        UID S   FLAGS LWPS          COMMAND    WAIT
 15288        15249    10038          0 2  0x4002    1              cat
 15249        15248    10038          0 2  0x4002    1               sh    wait
 15248        14659    10038          0 2  0x4002    1               sh    wait
*15243          269    15243       1001 2  0x4402    3      phoenix-bin       *
 14659        14658    10038          0 2  0x4002    1             make    wait
 14658        14644    10038          0 2  0x4002    1               sh    wait
 14644        14643    10038          0 2  0x4002    1             make    wait
 14643        12211    10038          0 2  0x4002    1               sh    wait
 12211        12210    10038          0 2  0x4002    1             make    wait
 12210        12195    10038          0 2  0x4002    1               sh    wait
 12195        12192    10038          0 2  0x4002    1             make    wait
 12192         5340    10038          0 2  0x4002    1               sh    wait
 5340          5339    10038          0 2  0x4002    1             make    wait
 5339          5292    10038          0 2  0x4002    1               sh    wait
 5292          5291    10038          0 2  0x4002    1             make    wait
 5291          5268    10038          0 2  0x4002    1               sh    wait
 5268          5265    10038          0 2  0x4002    1             make    wait
 5265         13011    10038          0 2  0x4002    1               sh    wait
 13011        13010    10038          0 2  0x4002    1             make    wait
 13010        12955    10038          0 2  0x4002    1               sh    wait
 12955        12954    10038          0 2  0x4002    1             make    wait
 12954        12933    10038          0 2  0x4002    1               sh    wait
 12933        12930    10038          0 2  0x4002    1             make    wait
 12930        10183    10038          0 2  0x4002    1               sh    wait
 10183        10182    10038          0 2  0x4002    1             make    wait
 10182        10040    10038          0 2  0x4002    1               sh    wait
 10040        10038    10038          0 2  0x4002    1             make    wait
 10039         2351    10039          0 2  0x4002    1             tail  kqread
 10038         2351    10038          0 2     0x2    1             tcsh   pause
 20996            1    20996       1001 2  0x4000    1             oafd  select
 20991          423    20991       1001 2  0x4002    1       junkbuster  netcon
 7700          7672     7700       1000 2  0x4002    1             tcsh   ttyin
 7672          7650     7650       1000 2  0x4100    1            xterm  select
 7650          7632     7650       1000 2  0x4000    1             tcsh   pause
 7632          7617     7617       1000 2   0x100    1             sshd  select
 7617           219     7617          0 2   0x100    1             sshd   netio
 2351           423     2351          0 2  0x5002    1             tcsh   pause
 423            422      423       1001 2  0x4002    1             bash    wait
 422            419      419       1001 2  0x4100    1            xterm  select
 419            418      419       1001 2  0x4000    1              csh   pause
 418            416      416       1001 2   0x100    1             sshd  select
 416            219      416          0 2   0x100    1             sshd   netio
 276            269      276          0 4  0x5002    1             tcsh
 269            268      269       1001 2  0x4002    1             bash    wait
 268            265      265       1001 2  0x4100    1            xterm  select
 265            264      265       1001 2  0x4000    1              csh   pause
 264            262      262       1001 2   0x100    1             sshd
 262            219      262          0 2   0x100    1             sshd   netio
 259              1      245       1000 2  0x4000    1       setiathome
 258              1      243       1000 2  0x4000    1       setiathome
 257              1      246       1000 2  0x4000    1       setiathome
 256              1      244       1000 2  0x4000    1       setiathome
 254              1      254          0 2  0x4002    1            getty   ttyin
 253              1      253          0 2  0x4002    1            getty   ttyin
 252              1      252          0 2  0x4002    1            getty   ttyin
 251              1        1          0 2  0x4000    1            getty nanosle
 247              1      247          0 2  0x4002    1            getty   ttyin
 237              1      237          0 2       0    1             cron nanosle
 233              1      233          0 2       0    1            inetd   pause
 219              1      219          0 2       0    1             sshd  select
 204              1      204          0 2       0    1             ntpd   pause
 189            188        9       1002 2     0x2    1         postgres  select
 188            184        9       1002 2     0x2    1         postgres  select
 184              1        9       1002 2  0x4002    1         postgres  select
 129              1      129          0 2       0    1        mount_mfs  mfsidl
 107              1      107          0 2       0    1          syslogd  select
 8                0        0          0 2 0x20200    1         aiodoned aiodone
 7                0        0          0 2 0x20200    1          ioflush  syncer
 6                0        0          0 2 0x20200    1           reaper  reaper
 5                0        0          0 2 0x20200    1       pagedaemon pgdaemo
 4                0        0          0 2 0x20200    1         scsibus2  sccomp
 3                0        0          0 2 0x20200    1         scsibus1  sccomp
 2                0        0          0 2 0x20200    1         scsibus0  sccomp
 1                0        1          0 2  0x4000    1             init    wait
 0               -1        0          0 2 0x20200    1          swapper schedul
db{1}> show reg
ds                0x10
es                0x10
fs                0x30
gs                0x10
edi         0xc05779e0  proclists+0xf20
esi              0x100
ebp         0xe6733b60
ebx         0xe6733b8c
edx         0xc1f5a800  end+0x181363c
ecx                  0
eax             0x2ca6  gdt_desc+0xb7a
eip         0xc03ad028  cpu_Debugger+0x4
cs                 0x8
eflags           0x202
esp         0xe6733b60
ss                0x10
cpu_Debugger+0x4:       leave
db{1}> mach cpu 0
using cpu 0
db{1}> trace
__cpu_simple_lock(c06e2880,e57f5e0c,0,d,c) at __cpu_simple_lock+0xb4
_simple_lock(c06e2880,c0578329,45d,e5828f2c,c1f57010) at _simple_lock+0x153
schedclock(e5811204,0,c0738040,0,c1f57000) at schedclock+0x5f
statclock(e5828fa4,c1f57000,4,0,c1f57000) at statclock+0x196
hardclock(e5828fa4,c1f57000,1,0,0) at hardclock+0xae
lapic_clockintr(0,0,10001f,d2001f,1f) at lapic_clockintr+0x80
db{1}> show reg
ds                0x10
es                0x10
fs                0x30
gs                0x10
edi                  0
esi            0x296a8  gdt_desc+0x2757c
ebp         0xe5828ea8
ebx                  0
edx         0xc06e2880  sched_lock
ecx         0xc06e2880  sched_lock
eax                0x1
eip         0xc03c19b8  __cpu_simple_lock+0xb4
cs                 0x8
eflags           0x287
esp         0xe5828e80
ss                0x10
__cpu_simple_lock+0xb4: cmpl    $0x1,%eax
db{1}> mach cpu 1
using cpu 1
db{1}> trace
cpu_Debugger(e6712708,0,e669e1d4,c030c692,c07295a0) at cpu_Debugger+0x4
panic(c05779e0,3b8b,3,7,e669e1d4) at panic+0xb8
sa_vp_repossess(e6712008,e6733c6c,e6733c76,c200c540,e669e1d4) at sa_vp_repossess+0xd3
sa_upcall_userret(e6712008,e6733f80,c,c03c0821,0) at sa_upcall_userret+0x14c
syscall_plain(1f,1f,1f,1f,ffffffff) at syscall_plain+0x161
db{1}> show reg
ds                0x10
es                0x10
fs                0x30
gs                0x10
edi         0xc05779e0  proclists+0xf20
esi              0x100
ebp         0xe6733b60
ebx         0xe6733b8c
edx         0xc1f5a800  end+0x181363c
ecx                  0
eax             0x2ca6  gdt_desc+0xb7a
eip         0xc03ad028  cpu_Debugger+0x4
cs                 0x8
eflags           0x202
esp         0xe6733b60
ss                0x10
cpu_Debugger+0x4:       leave
db{1}> mach cpu 2
using cpu 2
db{1}> show reg
ds                0x10
es                0x10
fs                0x30
gs                0x10
edi                0x8
esi            0x4e4dc  gdt_desc+0x4c3b0
ebp         0xe66f5d88
ebx                0x2
edx         0xc06e2880  sched_lock
ecx         0xc06e2880  sched_lock
eax                0x1
eip         0xc03c19b8  __cpu_simple_lock+0xb4
cs                 0x8
eflags           0x287
esp         0xe66f5d60
ss                0x10
__cpu_simple_lock+0xb4: cmpl    $0x1,%eax
db{1}> trace
__cpu_simple_lock(c06e2880,c0345719,ffffffff,1,c) at __cpu_simple_lock+0xb4
_simple_lock(c06e2880,c0578329,45d,0,c1f5a010) at _simple_lock+0x153
schedclock(e6712708,4,2,58000000,0) at schedclock+0x5f
statclock(e66f5e84,3dc62,0,0,c1f5a000) at statclock+0x196
hardclock(e66f5e84,c0515986,c07295a0,d,0) at hardclock+0xae
lapic_clockintr(0,0,c0720010,30,e66f0010) at lapic_clockintr+0x80
Xintr_lapic_ltimer() at Xintr_lapic_ltimer+0x76
--- interrupt ---
_lockmgr(c07295a0,400002,0,c05756ac,533) at _lockmgr+0xa3f
_kernel_proc_lock(e6712708,498c0000,0,e66f5f94,0) at _kernel_proc_lock+0x56
trap() at trap+0x544
--- trap (number 6) ---
0x49898649:
db{1}> mach cpu 3
using cpu 3
db{1}> trace
__cpu_simple_lock(c06e2880,1,e5835e28,c030c288,c) at __cpu_simple_lock+0xb4
_simple_lock(c06e2880,c0578329,45d,c030c288,c06ecd30) at _simple_lock+0x153
schedclock(e5811304,3,e5835e88,c031cddb,c06ecd20) at schedclock+0x5f
statclock(e5835ee4,c0574377,345,c02ff7d2,c06ecd20) at statclock+0x196
hardclock(e5835ee4,c06df890,c07295a0,d,4) at hardclock+0xae
lapic_clockintr(0,4,c0720010,c0300030,c06f0010) at lapic_clockintr+0x80
Xintr_lapic_ltimer() at Xintr_lapic_ltimer+0x76
--- interrupt ---
_lockmgr(c07295a0,400042,0,c058e880,287) at _lockmgr+0xae4
i386_softintlock(1f,1f,10001f,bfbf001f,456a) at i386_softintlock+0x24
db{1}> show reg
ds                0x10
es                0x10
fs                0x30
gs                0x10
edi                0xc
esi            0x23002  gdt_desc+0x20ed6
ebp         0xe5835de8
ebx                0x3
edx         0xc06e2880  sched_lock
ecx         0xc06e2880  sched_lock
eax                0x1
eip         0xc03c19b8  __cpu_simple_lock+0xb4
cs                 0x8
eflags           0x283
esp         0xe5835dc0
ss                0x10
__cpu_simple_lock+0xb4: cmpl    $0x1,%eax
db{1}> reboot 4
rebooting...

** 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
6105124+128872+342620 [103+300240+272657]=0x6d3224
[ using 573536 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, 2003
    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.6N (GENERIC.MPDEBUG) #12: Fri Feb 14 21:55:33 CET 2003
    jarle@splitter-pine.urc.uninett.no:/sys/arch/i386/compile/GENERIC.MPDEBUG
total memory = 1023 MB
avail memory = 931 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 (686-class), 450.01 MHz, id 0x653
cpu0: features 183fbff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR>
cpu0: features 183fbff<PGE,MCA,CMOV,PAT,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 0xe418e000 for 16384 bytes
cpu0: idle pcb at 0xe418e000, idle sp at 0xe4191f98
cpu1 at mainbus0: apid 0 (application processor)
cpu1: starting
cpu1: Intel Pentium II (686-class), 449.98 MHz, id 0x653
cpu1: features 183fbff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR>
cpu1: features 183fbff<PGE,MCA,CMOV,PAT,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 0xe419a000 for 16384 bytes
cpu1: idle pcb at 0xe419a000, idle sp at 0xe419df98
cpu2 at mainbus0: apid 1 (application processor)
cpu2: starting
cpu2: Intel Pentium II (686-class), 449.98 MHz, id 0x653
cpu2: features 183fbff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR>
cpu2: features 183fbff<PGE,MCA,CMOV,PAT,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 0xe41b6000 for 16384 bytes
cpu2: idle pcb at 0xe41b6000, idle sp at 0xe41b9f98
cpu3 at mainbus0: apid 2 (application processor)
cpu3: starting
cpu3: Intel Pentium II (686-class), 449.98 MHz, id 0x653
cpu3: features 183fbff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR>
cpu3: features 183fbff<PGE,MCA,CMOV,PAT,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 0xe41d2000 for 16384 bytes
cpu3: idle pcb at 0xe41d2000, idle sp at 0xe41d5f98
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: 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
pckbdprobe: reset error 5
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 0xc0805000
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
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 300c0<vector=c0,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: int3 1d1<vector=d1,delmode=1,dest=0> 3000000<target=3>
ioapic0: int4 1d0<vector=d0,delmode=1,dest=0> 3000000<target=3>
ioapic0: int6 163<vector=63,delmode=1,dest=0> 3000000<target=3>
ioapic0: int7 190<vector=90,delmode=1,dest=0> 3000000<target=3>
ioapic0: int14 a170<vector=70,delmode=1,actlo,level,dest=0> 3000000<target=3>
ioapic0: int20 a162<vector=62,delmode=1,actlo,level,dest=0> 3000000<target=3>
ioapic0: int21 a160<vector=60,delmode=1,actlo,level,dest=0> 3000000<target=3>
ioapic0: int22 a161<vector=61,delmode=1,actlo,level,dest=0> 3000000<target=3>
raidattach: Asked for 8 units
Kernelized RAIDframe activated
scsibus0: waiting 2 seconds for devices to settle...
sd0 at scsibus0 target 0 lun 0: <IBM, DNES-318350Y, SA60> disk 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
timeout delayed -4
sd1 at scsibus0 target 1 lun 0: <QUANTUM, QM34500TD-SCA, N1K0> disk 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
timeout delayed -4
sd2 at scsibus0 target 2 lun 0: <QUANTUM, QM34500TD-SCA, N1K0> disk 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
timeout delayed -5
timeout delayed -1
ses0 at scsibus0 target 6 lun 0: <DELL, 1x3 U2W SCSI BP, 5.39> processor fixed
ses0: SAF-TE Compliant Device
ses0: async, 8-bit transfers
timeout delayed -3
timeout delayed -3
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> cdrom removable
cd0: sync (50.0ns offset 15), 8-bit (20.000MB/s) transfers
timeout delayed -2
Searching for RAID components...
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 200c0<vector=c0,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 200c0<vector=c0,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 200c0<vector=c0,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
Sun Feb 16 14:52:55 GMT 2003
Configuring CCD devices.
swapctl: adding /dev/sd0b as swap device at priority 0
Starting file system checks:
/dev/rsd0a: 1772 files, 31406 used, 38920 free (80 frags, 4855 blocks, 0.1% fragmentation)
/dev/rsd0a: MARKING FILE SYSTEM CLEAN
/dev/rsd0e: INCORRECT BLOCK COUNT I=367008 (592 should be 0) (CORRECTED)
/dev/rsd0e: UNREF FILE I=367008  OWNER=root MODE=100600
/dev/rsd0e: SIZE=0 MTIME=Feb 16 14:46 2003  (CLEARED)
/dev/rsd0e: FREE BLK COUNT(S) WRONG IN SUPERBLK (SALVAGED)
/dev/rsd0e: SUMMARY INFORMATION BAD (SALVAGED)
/dev/rsd0e: BLK(S) MISSING IN BIT MAPS (SALVAGED)
/dev/rsd0e: 1921 files, 26790 used, 2453385 free (289 frags, 306637 blocks, 0.0% fragmentation)
/dev/rsd0e: MARKING FILE SYSTEM CLEAN
/dev/rccd0a: 646 files, 147099 used, 8470929 free (81 frags, 1058856 blocks, 0.0% fragmentation)
/dev/rccd0a: MARKING FILE SYSTEM CLEAN
/dev/rsd0g: PARTIALLY TRUNCATED INODE I=783453 (SALVAGED)
/dev/rsd0g: INCORRECT BLOCK COUNT I=1157219 (2 should be 0) (CORRECTED)
/dev/rsd0g: LINK COUNT FILE I=1157412  OWNER=root MODE=100644
/dev/rsd0g: SIZE=300 MTIME=Feb 16 14:46 2003  COUNT 2 SHOULD BE 1 (ADJUSTED)
/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: 526483 files, 8299088 used, 5190030 free (60950 frags, 641135 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.
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.
pg_ctl: Another postmaster may be running.  Trying to start postmaster anyway.
pg_ctl: cannot start postmaster
Examine the log output.
.
Updating motd.
Starting ntpd.
Starting sshd.
Starting inetd.
Starting cron.
Sun Feb 16 15:57:18 CET 2003

NetBSD/i386 (splitter-pine.urc.uninett.no) (console)

login: Feb 16 15:57:20 splitter-pine getty[251]: /dev/ttyE0: Device not configured
timeout delayed -1
timeout delayed -3
timeout delayed -2
timeout delayed -1
timeout delayed -1

>How-To-Repeat:
Try and run phoenix on a fresh NetBSD-current installation
>Fix:
Unknown.
>Release-Note:
>Audit-Trail:
>Unformatted: