Skip site navigation (1)Skip section navigation (2)
Date:      Fri, 30 Jul 2010 20:53:08 +0400
From:      pluknet <pluknet@gmail.com>
To:        freebsd-stable <freebsd-stable@freebsd.org>
Subject:   umount -f <nfs> forces to panic
Message-ID:  <AANLkTimTi=6yP-NK0ksB%2BdJc8jHXPakMN86pXcWiHqPT@mail.gmail.com>

next in thread | raw e-mail | index | archive | help
Hi.

This is 8.1 booted from NFS.
I did installworld to NFS on idle system, then it started
to print repeatedly "nfs server foo:mp lockd not responding".
umount returned EBUSY, umount -f dropped to panic:

Fatal trap 12: page fault while in kernel mode
cpuid = 0; apic id = 00
fault virtual address   = 0x1a4
fault code              = supervisor read, page not present
instruction pointer     = 0x20:0xc089af3f
stack pointer           = 0x28:0xec38c558
frame pointer           = 0x28:0xec38c570
code segment            = base 0x0, limit 0xfffff, type 0x1b
                        = DPL 0, pres 1, def32 1, gran 1
processor eflags        = interrupt enabled, resume, IOPL = 0
current process         = 56006 (lockf)


db> bt
Tracing pid 56006 tid 100464 td 0xc871a280
_mtx_lock_sleep(c6b34830,c871a280,0,0,0,...) at _mtx_lock_sleep+0x3f
nlm_feedback(3,2,ec38c984,c0ce31ec,1772,...) at nlm_feedback+0x81
clnt_dg_call(cb870840,ec38c968,2,c79ea100,ec38c6a8,...) at clnt_dg_call+0xb9e
clnt_call_private(cb870840,ec38c968,2,c0aaa0f0,ec38c748,...) at
clnt_call_private+0xf7
nlm4_lock_4(ec38c748,ec38c7fc,cb870840,ec38c968,3c,...) at nlm4_lock_4+0x4c
nlm_setlock(ec38c98c,7ffffff3,c785fb84,c,ec38cbfc,...) at nlm_setlock+0x22d
nlm_advlock_internal(ec38cbfc,20,0,1,c785fb84,...) at nlm_advlock_internal+0x894
nlm_advlock(ec38cc18,200000,c0ce293b,cd5,0,...) at nlm_advlock+0x3a
nfs_advlock(ec38cc18,ec38cc44,c0945c9f,c0dc3360,ec38cc18,...) at
nfs_advlock+0xa9
VOP_ADVLOCK_APV(c0dc3360,ec38cc18,1,c785fb84,c0db5640,...) at
VOP_ADVLOCK_APV+0x47
kern_openat(c871a280,ffffff9c,bfbfe981,0,25,...) at kern_openat+0x35f
kern_open(c871a280,bfbfe981,0,224,1b6,...) at kern_open+0x35
open(c871a280,ec38ccf8,c,c871a280,ec38cd2c,...) at open+0x30
syscall(ec38cd38) at syscall+0x2d3
Xint0x80_syscall() at Xint0x80_syscall+0x20
--- syscall (5, FreeBSD ELF32, open), eip = 0x2816bb53, esp =
0xbfbfe70c, ebp = 0xbfbfe728 ---

Other 15 CPUs in idle.

Interesting parts from alltrace:

Tracing command nfsiod 0 pid 64424 tid 100182 td 0xc67ce500
sched_switch(3330073856,0,260,3191977013,2554,...) at sched_switch+633
mi_switch(260,0,0,3330048680,3957992552,...) at mi_switch+298
sleepq_switch(3330073856,0,3234646915,416,3330074288,...) at sleepq_switch+204
sleepq_catch_signals(0,256,3330073856,3957992632,3230352936,...) at
sleepq_catch_signals+91
sleepq_timedwait_sig(3236091392,92,3234604703,256,0,...) at
sleepq_timedwait_sig+28
_sleep(3236091392,3236091344,348,3234604703,120000,...) at _sleep+600
nfssvc_iod(3236089728,3957992760,0,1,0,...) at nfssvc_iod+246
fork_exit(3232247616,3236089728,3957992760) at fork_exit+145
fork_trampoline() at fork_trampoline+8
--- trap 0, eip = 0, esp = 3957992816, ebp = 0 ---

Tracing command rpc.lockd pid 56043 tid 100339 td 0xc86b5a00
sched_switch(3362478592,0,260,590634873,2568,...) at sched_switch+633
mi_switch(260,0,0,3362445304,3960695292,...) at mi_switch+298
sleepq_switch(3362478592,0,3234646915,416,3362479024,...) at sleepq_switch+204
sleepq_catch_signals(0,3362478592,0,3960695360,3230024964,...) at
sleepq_catch_signals+91
sleepq_timedwait_sig(3381779728,0,3234741028,257,0,...) at
sleepq_timedwait_sig+28
_cv_timedwait_sig(3381779728,3386200960,5000,3960695396,3230239445,...)
at _cv_timedwait_sig+420
svc_run_internal(3362478952,20,3234741456,3234739620,3960695692,...)
at svc_run_internal+781
svc_run(3386200960,0,4,3232410704,3960695692,...) at svc_run+125
nlm_syscall(3362478592,3960696056,22,3362478592,3960696108,...) at
nlm_syscall+1897
syscall(3960696120) at syscall+723
Xint0x80_syscall() at Xint0x80_syscall+32
--- syscall (154, FreeBSD ELF32, nlm_syscall), eip = 672111019, esp =
3217025868, ebp = 3217026072 ---

Tracing command lockf pid 56006 tid 100464 td 0xc871a280
_mtx_lock_sleep(3333638192,3362890368,0,0,0,...) at _mtx_lock_sleep+63
nlm_feedback(3,2,3963144580,3234738668,6002,...) at nlm_feedback+129
clnt_dg_call(3414624320,3963144552,2,3349061888,3963143848,...) at
clnt_dg_call+2974
clnt_call_private(3414624320,3963144552,2,3232407792,3963144008,...)
at clnt_call_private+247
nlm4_lock_4(3963144008,3963144188,3414624320,3963144552,60,...) at
nlm4_lock_4+76
nlm_setlock(3963144588,2147483635,3347446660,12,3963145212,...) at
nlm_setlock+557
nlm_advlock_internal(3963145212,32,0,1,3347446660,...) at
nlm_advlock_internal+2196
nlm_advlock(3963145240,2097152,3234736443,3285,0,...) at nlm_advlock+58
nfs_advlock(3963145240,3963145284,3230948511,3235656544,3963145240,...)
at nfs_advlock+169
VOP_ADVLOCK_APV(3235656544,3963145240,1,3347446660,3235599936,...) at
VOP_ADVLOCK_APV+71
kern_openat(3362890368,4294967196,3217025409,0,37,...) at kern_openat+863
kern_open(3362890368,3217025409,0,548,438,...) at kern_open+53
open(3362890368,3963145464,12,3362890368,3963145516,...) at open+48
syscall(3963145528) at syscall+723
Xint0x80_syscall() at Xint0x80_syscall+32
--- syscall (5, FreeBSD ELF32, open), eip = 672578387, esp =
3217024780, ebp = 3217024808 ---

Tracing command rpc.statd pid 876 tid 100109 td 0xc6536780
sched_switch(3327354752,0,260,645050409,2568,...) at sched_switch+633
mi_switch(260,0,0,3327331656,3956578892,...) at mi_switch+298
sleepq_switch(3327354752,0,3234646915,416,3327355184,...) at sleepq_switch+204
sleepq_catch_signals(0,3327354752,0,3956578960,3230024964,...) at
sleepq_catch_signals+91
sleepq_timedwait_sig(3327155684,0,3234648462,257,0,...) at
sleepq_timedwait_sig+28
_cv_timedwait_sig(3327155684,3327155664,30001,3310708352,3327354752,...)
at _cv_timedwait_sig+420
seltdwait(3956579368,3956579376,3310708352,3327354752,104,...) at seltdwait+193
kern_select(3327354752,8,3217026356,0,0,3956579440,32,30,0) at kern_select+1262
select(3327354752,3956579576,12,3327354752,3956579628,...) at select+102
syscall(3956579640) at syscall+723
Xint0x80_syscall() at Xint0x80_syscall+32
--- syscall (93, FreeBSD ELF32, select), eip = 672695779, esp =
3217026188, ebp = 3217026504 ---

Tracing command rpcbind pid 874 tid 100118 td 0xc6535780
sched_switch(3327350656,0,260,649400515,2568,...) at sched_switch+633
mi_switch(260,0,0,3327135048,3956742824,...) at mi_switch+298
sleepq_switch(3327350656,0,3234646915,416,3327351088,...) at sleepq_switch+204
sleepq_catch_signals(0,3327350656,3325702144,3956742892,3230024964,...)
at sleepq_catch_signals+91
sleepq_timedwait_sig(3327284708,0,3234648462,257,0,...) at
sleepq_timedwait_sig+28
_cv_timedwait_sig(3327284708,3327284688,30001,3310708352,3327350656,...)
at _cv_timedwait_sig+420
seltdwait(3956743260,3956743268,3310708352,3327350656,3230602000,...)
at seltdwait+193
poll(3327350656,3956743416,12,3327350656,3956743468,...) at poll+831
syscall(3956743480) at syscall+723
Xint0x80_syscall() at Xint0x80_syscall+32
--- syscall (209, FreeBSD ELF32, poll), eip = 672406303, esp =
3217017820, ebp = 3217026472 ---


-- 
wbr,
pluknet



Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?AANLkTimTi=6yP-NK0ksB%2BdJc8jHXPakMN86pXcWiHqPT>