Hello,
it looks like the in-kernel pppoe causes systems to hang up sometimes. I
testet with two systems (completly different hardware) and two different
dsl-modems (I'm from germany - standard tcom modems).
Did someone else notice such problems?
Here is my hostname.pppoe0:
#cat /etc/hostname.pppoe0
inet 0.0.0.0 255.255.255.255 NONE \
pppoedev bge1 authproto pap \
authname 'USERNAME' authkey 'PASSWORD' up
dest 0.0.0.1
!/sbin/route add default 0.0.0.1
# cat /etc/hostname.bge1
up
Here is the output from the kernel panic:
cached lines from terminal server:
ddb{0}> <start of buffer>
<13/6/2008 11:49:39>pppoe0: LCP keepalive timeout
<13/6/2008 11:49:39>kernel: page fault trap, code=0
<13/6/2008 11:49:41>Stopped at softclock+0x2d: movl
%edx,0x4(%eax)
<13/6/2008 11:49:41>ddb{0}>
<13/6/2008 18:29:27>ddb{0}>
<end of buffer>
output from ddb commands:
ddb{0}> trace
softclock(58,de8a0010,10,de8a0010,de8ae000) at softclock+0x2d
Bad frame pointer: 0xde8aff20
ddb{0}> ps
PID PPID PGRP UID S FLAGS WAIT COMMAND
26917 24357 32309 220 3 0x2004080 select qmail-smtpd
19628 22976 22976 0 3 0x2000082 netio tcpdump
22976 3048 22976 76 3 0x2004182 bpf tcpdump
28819 15851 28819 0 3 0x2004082 ttyin ksh
15851 13411 15851 0 3 0x2004180 select sshd
3048 1164 3048 0 3 0x2004082 pause ksh
1164 13411 1164 0 3 0x2004080 select sshd
26129 27247 32309 200 3 0x2004080 piperd multilog
10965 19992 32309 201 3 0x2004180 poll dnscache
1687 11010 10844 0 3 0x2800082 netio tcpdump
11010 10844 10844 76 3 0x2804182 bpf tcpdump
10844 1 10844 0 3 0x2805082 pause sh
12506 22056 12506 515 3 0x2004080 piperd unlinkd
22056 15607 15607 515 3 0x2004180 kqread squid
6061 24437 32309 225 3 0x2004080 piperd qmail-clean
12394 24437 32309 226 3 0x2004080 select qmail-rspawn
23031 24437 32309 0 3 0x2004080 select qmail-lspawn
24357 12238 32309 220 3 0x2004180 netcon tcpserver
14976 11484 32309 222 3 0x2004080 piperd multilog
24437 30067 32309 227 3 0x2004080 select qmail-send
20754 31587 32309 222 3 0x2004080 piperd multilog
27247 17401 32309 0 3 0x2004080 poll supervise
19992 17401 32309 0 3 0x2004080 poll supervise
11484 17401 32309 0 3 0x2004080 poll supervise
12238 17401 32309 0 3 0x2004080 poll supervise
31587 17401 32309 0 3 0x2004080 poll supervise
30067 17401 32309 0 3 0x2004080 poll supervise
22921 32309 32309 0 3 0x2004080 piperd readproctitle
17401 32309 32309 0 3 0x2004080 nanosleep svscan
5641 1 5641 0 3 0x2004082 ttyin getty
9200 1 9200 0 3 0x2004082 ttyin getty
11008 1 11008 0 3 0x2004082 ttyin getty
30618 1 30618 0 3 0x2004082 ttyin getty
32099 1 32099 0 3 0x2004082 ttyin getty
12115 1 12115 0 3 0x2004082 ttyin getty
8185 1 8185 0 3 0x2000080 select cron
32309 1 32309 0 3 0x2004082 pause sh
15607 1 15607 0 3 0x2000080 wait squid
13411 1 13411 0 3 0x2000080 select sshd
5549 1 5549 0 3 0x2000180 select inetd
14162 2559 2559 83 3 0x2000180 poll ntpd
2559 1 2559 0 3 0x2000080 poll ntpd
22633 3798 3798 68 3 0x2000180 select isakmpd
3798 1 3798 0 3 0x2000080 netio isakmpd
6099 5809 5809 74 3 0x2000180 bpf pflogd
5809 1 5809 0 3 0x2000080 netio pflogd
30348 17649 17649 73 3 0x2000180 poll syslogd
17649 1 17649 0 3 0x2000088 netio syslogd
17 0 0 0 3 0x2100200 crypto_wait crypto
16 0 0 0 3 0x2100200 aiodoned aiodoned
15 0 0 0 3 0x2100200 syncer update
14 0 0 0 3 0x2100200 cleaner cleaner
13 0 0 0 3 0x100200 reaper reaper
12 0 0 0 3 0x2100200 pgdaemon pagedaemon
11 0 0 0 3 0x2100200 pftm pfpurge
10 0 0 0 3 0x2100200 usbevt usb3
9 0 0 0 3 0x2100200 usbevt usb2
8 0 0 0 3 0x2100200 usbevt usb1
7 0 0 0 3 0x2100200 usbtsk usbtask
6 0 0 0 3 0x2100200 usbevt usb0
5 0 0 0 3 0x2100200 bored syswq
4 0 0 0 3 0x2100200 ipmi_poll ipmi0
3 0 0 0 3 0x2100200 bored syswq
2 0 0 0 3 0x2100200 kmalloc kmthread
1 0 1 0 3 0x2004080 wait init
0 -1 0 0 3 0x2080200 scheduler swapper
ddb{0}>
ddb{0}> show all pools
Name Size Requests Fail Releases Pgreq Pgrel Npage Hiwat Minpg
Maxpg Idle
phpool 32 6518 0 5614 10 0 10 10 0
8 1
extentpl 20 223 0 194 1 0 1 1 0
8 0
pmappl 84 309946 0 309897 3 0 3 3 0
8 0
vmsppl 188 309946 0 309897 5 0 5 5 0
8 1
vmmpepl 88 32890691 0 32877710 310 0 310 310 0
179 23
vmmpekpl 88 1132357 0 1132338 1 0 1 1 0
8 0
aobjpl 52 1 0 0 1 0 1 1 0
8 0
amappl 44 13932936 0 13923392 111 0 111 111 0
45 5
anonpl 16 19885717 0 19867511 76 0 76 76 0
62 3
bufpl 124 124820 0 118383 206 0 206 206 0
8 0
mbpl 256 38567542 0 38566510 92 0 92 92 1
384 19
mclpl 2048 12111455 0 12110430 586 0 586 586 4
3072 69
sockpl 212 1477973 0 1477825 31 13 18 27 0
8 8
procpl 344 309962 0 309897 11 0 11 11 0
8 4
processpl 20 309962 0 309897 1 0 1 1 0
8 0
zombiepl 72 309897 0 309897 1 0 1 1 0
8 1
ucredpl 80 141475 0 141450 1 0 1 1 0
8 0
pgrppl 24 42006 0 41983 1 0 1 1 0
8 0
sessionpl 48 41836 0 41814 1 0 1 1 0
8 0
pcredpl 24 309962 0 309897 1 0 1 1 0
8 0
lockfpl 52 173957 0 173946 1 0 1 1 0
8 0
filepl 88 6071748 0 6071495 12 0 12 12 0
8 3
fdescpl 296 309963 0 309897 10 0 10 10 0
8 4
pipepl 72 489356 0 489316 3 0 3 3 0
8 1
kqueuepl 192 2 0 1 1 0 1 1 0
8 0
knotepl 64 2983123 0 2983120 1 0 1 1 0
8 0
sigapl 316 309946 0 309897 9 0 9 9 0
8 3
wqtasks 20 189776 0 189776 1 0 1 1 0
8 1
pfiaddrpl 100 9 0 6 1 0 1 1 0
8 0
wdcspl 96 2909229 0 2909229 1 0 1 1 0
8 1
scxspl 132 3 0 3 1 0 1 1 0
8 1
namei 1024 11466984 0 11466984 4 0 4 4 0
8 4
vnodes 148 2621 0 0 98 0 98 98 0
8 0
nchpl 72 974680 0 973370 24 0 24 24 0
8 0
ffsino 184 4266204 0 4263591 119 0 119 119 0
8 0
dino1pl 128 4266204 0 4263591 85 0 85 85 0
8 0
dirhash 1024 48370 0 47942 5561 5424 137 461 0
128 25
pfrulepl 824 308 0 207 62 26 36 51 0
8 8
pfstatepl 204 591231 0 591156 38 0 38 38 0
527 34
pfstatekeypl 108 591231 0 591156 91 82 9 20 0
8 6
pfpooladdrpl 68 24 0 16 1 0 1 1 0
8 0
pfrktable 1240 67 0 56 8 0 8 8 0
334 1
pfrkentry 156 78 0 53 2 0 2 2 0
7693 1
pfrkentry2 156 24 0 22 1 0 1 1 0
8 0
pfosfpen 108 2784 0 2088 52 33 19 19 0
8 0
pfosfp 28 1628 0 1221 3 0 3 3 0
8 0
pffrent 16 1604 0 1604 1 0 1 1 0
20 1
pffrag 48 787 0 787 1 0 1 1 0
12 1
rtentpl 108 1997 0 1913 3 0 3 3 0
8 0
rttmrpl 32 1 0 1 1 0 1 1 0
8 1
tcpcbpl 400 334362 0 334345 175 164 11 39 0
8 8
tcpqepl 16 138727 0 138727 1 0 1 1 0
13 1
sackhlpl 20 391 0 391 1 0 1 1 0
162 1
synpl 184 95748 0 95748 1 0 1 1 0
8 1
plimitpl 152 314 0 299 1 0 1 1 0
8 0
inpcbpl 216 980315 0 980216 35 20 15 26 0
8 8
ipsec policy 212 6 0 2 1 0 1 1 0
8 0
cryptop 52 36474 0 36474 1 0 1 1 0
8 1
cryptodesc 56 72948 0 72948 1 0 1 1 0
8 1
ddb{0}> show all procs
PID PPID PGRP UID S FLAGS WAIT COMMAND
26917 24357 32309 220 3 0x2004080 select qmail-smtpd
19628 22976 22976 0 3 0x2000082 netio tcpdump
22976 3048 22976 76 3 0x2004182 bpf tcpdump
28819 15851 28819 0 3 0x2004082 ttyin ksh
15851 13411 15851 0 3 0x2004180 select sshd
3048 1164 3048 0 3 0x2004082 pause ksh
1164 13411 1164 0 3 0x2004080 select sshd
26129 27247 32309 200 3 0x2004080 piperd multilog
10965 19992 32309 201 3 0x2004180 poll dnscache
1687 11010 10844 0 3 0x2800082 netio tcpdump
11010 10844 10844 76 3 0x2804182 bpf tcpdump
10844 1 10844 0 3 0x2805082 pause sh
12506 22056 12506 515 3 0x2004080 piperd unlinkd
22056 15607 15607 515 3 0x2004180 kqread squid
6061 24437 32309 225 3 0x2004080 piperd qmail-clean
12394 24437 32309 226 3 0x2004080 select qmail-rspawn
23031 24437 32309 0 3 0x2004080 select qmail-lspawn
24357 12238 32309 220 3 0x2004180 netcon tcpserver
14976 11484 32309 222 3 0x2004080 piperd multilog
24437 30067 32309 227 3 0x2004080 select qmail-send
20754 31587 32309 222 3 0x2004080 piperd multilog
27247 17401 32309 0 3 0x2004080 poll supervise
19992 17401 32309 0 3 0x2004080 poll supervise
11484 17401 32309 0 3 0x2004080 poll supervise
12238 17401 32309 0 3 0x2004080 poll supervise
31587 17401 32309 0 3 0x2004080 poll supervise
30067 17401 32309 0 3 0x2004080 poll supervise
22921 32309 32309 0 3 0x2004080 piperd readproctitle
17401 32309 32309 0 3 0x2004080 nanosleep svscan
5641 1 5641 0 3 0x2004082 ttyin getty
9200 1 9200 0 3 0x2004082 ttyin getty
11008 1 11008 0 3 0x2004082 ttyin getty
30618 1 30618 0 3 0x2004082 ttyin getty
32099 1 32099 0 3 0x2004082 ttyin getty
12115 1 12115 0 3 0x2004082 ttyin getty
8185 1 8185 0 3 0x2000080 select cron
32309 1 32309 0 3 0x2004082 pause sh
15607 1 15607 0 3 0x2000080 wait squid
13411 1 13411 0 3 0x2000080 select sshd
5549 1 5549 0 3 0x2000180 select inetd
14162 2559 2559 83 3 0x2000180 poll ntpd
2559 1 2559 0 3 0x2000080 poll ntpd
22633 3798 3798 68 3 0x2000180 select isakmpd
3798 1 3798 0 3 0x2000080 netio isakmpd
6099 5809 5809 74 3 0x2000180 bpf pflogd
5809 1 5809 0 3 0x2000080 netio pflogd
30348 17649 17649 73 3 0x2000180 poll syslogd
17649 1 17649 0 3 0x2000088 netio syslogd
17 0 0 0 3 0x2100200 crypto_wait crypto
16 0 0 0 3 0x2100200 aiodoned aiodoned
15 0 0 0 3 0x2100200 syncer update
14 0 0 0 3 0x2100200 cleaner cleaner
13 0 0 0 3 0x100200 reaper reaper
12 0 0 0 3 0x2100200 pgdaemon pagedaemon
11 0 0 0 3 0x2100200 pftm pfpurge
10 0 0 0 3 0x2100200 usbevt usb3
9 0 0 0 3 0x2100200 usbevt usb2
8 0 0 0 3 0x2100200 usbevt usb1
7 0 0 0 3 0x2100200 usbtsk usbtask
6 0 0 0 3 0x2100200 usbevt usb0
5 0 0 0 3 0x2100200 bored syswq
4 0 0 0 3 0x2100200 ipmi_poll ipmi0
3 0 0 0 3 0x2100200 bored syswq
2 0 0 0 3 0x2100200 kmalloc kmthread
1 0 1 0 3 0x2004080 wait init
0 -1 0 0 3 0x2080200 scheduler swapper
ddb{0}> show all callout
ticks now: 94887746
ticks wheel arg func
panic: mtx_enter: locking against myself
Stopped at Debugger+0x4: leave
RUN AT LEAST 'trace' AND 'ps' AND INCLUDE OUTPUT WHEN REPORTING THIS
PANIC!
DO NOT EVEN BOTHER REPORTING THIS WITHOUT INCLUDING THAT INFORMATION!
ddb{0}> trace
Debugger(14,0,0,0,de8afd44) at Debugger+0x4
panic(d020340c,de8afd20,d0336b9c,d0759890,5a7df42) at panic+0x63
mtx_enter(d0759890,5a7df42,de8afd40,0,0) at mtx_enter+0x5c
db_show_callout(d03368b5,0,ffffffff,de8afd48,d0757b40) at
db_show_callout+0x30
db_command(d0757b40,d0757960,de8afe50,d0303641,de8afe2c) at
db_command+0xff
db_command_loop(0,de8afed8,de8afe90,d04616ac,6) at db_command_loop+0x93
db_trap(6,0,de8afe90,d0461651,a15e66dc) at db_trap+0x90
kdb_trap(6,0,de8afed8,d0) at kdb_trap+0xe8
trap() at trap+0x99
--- trap (number 6) ---
softclock(58,de8a0010,10,de8a0010,de8ae000) at softclock+0x2d
Bad frame pointer: 0xde8aff20
Please let me know if you need further informations.
Thank you.
Regards
Hagen Volpers
