Skip site navigation (1)Skip section navigation (2)
Date:      Mon, 22 Sep 2014 21:07:56 -0500
From:      Bryan Drewery <bdrewery@FreeBSD.org>
To:        FreeBSD FS <freebsd-fs@FreeBSD.org>, Konstantin Belousov <kib@FreeBSD.org>
Subject:   Deadlock with umount -f involving tmpfs on top of ZFS on r271170
Message-ID:  <5420D5FC.4030600@FreeBSD.org>

next in thread | raw e-mail | index | archive | help
This is an OpenPGP/MIME signed message (RFC 4880 and 3156)
--Hb4K9m0hacv3IKadGr1XVwrOU5suiheIf
Content-Type: text/plain; charset=utf-8
Content-Transfer-Encoding: quoted-printable

This is slightly different than my last report (involving
zfs_lookup/zfs_dirent). I still need to gather information from that
previous one.

Here is what I have on this one. Quoted so Thunderbird doesn't trash it:

> 1. Poudriere build startup, run for N=3D01,...,12 in parallel:
>      a. mount tmpfs on /poudriere/data/.m/exp-10amd64-commit-test/N
>         /poudriere/data/.m is a ZFS mount.
>      b. cpdup /poudriere/data/.m/exp-10amd64-commit-test/ref to /poudri=
ere/data/.m/exp-10amd64-commit-test/N
> [1]  c. mkdir -p /poudriere/data/.m/exp-10amd64-commit-test/N/.p
> 2. SIGINT during this phase:
> [2]  a. umount -f all tmpfs
>      b. cpdup processes are *not* killed. They continue running. Most o=
f them fail due to their dst tmpfs being gone.
> [3]  c. A cpdup process managed to continue running. Since the tmpfs wa=
s gone it started trying to write to the ZFS mount under it. (/poudriere/=
data/.m)
>=20
> # procstat -kka|egrep "(lockmgr|tmpfs)"
> [3] 76137 100919 cpdup            -                mi_switch+0x179 slee=
pq_switch+0x152 sleepq_wait+0x43 sleeplk+0x14a __lockmgr_args+0x862 vop_s=
tdlock+0x3c VOP_LOCK1_APV+0xfc _vn_lock+0xaa vget+0x67 cache_lookup+0x5b2=
 vfs_cache_lookup+0xac VOP_LOOKUP_APV+0xf1 lookup+0x5ad namei+0x4e4 kern_=
linkat+0x13d sys_link+0x28 filemon_wrapper_link+0x19 amd64_syscall+0x25a
> [1] 76346 102346 mkdir            -                mi_switch+0x179 slee=
pq_switch+0x152 sleepq_wait+0x43 sleeplk+0x14a __lockmgr_args+0xea1 vop_s=
tdlock+0x3c VOP_LOCK1_APV+0xfc _vn_lock+0xaa lookup+0x496 namei+0x4e4 ker=
n_mkdirat+0xcb amd64_syscall+0x25a Xfast_syscall+0xfb
> [2] 76286 102085 umount           -                mi_switch+0x179 slee=
pq_switch+0x152 sleepq_wait+0x43 _sleep+0x366 vfs_write_suspend+0xf0 vfs_=
write_suspend_umnt+0x38 tmpfs_unmount+0x6d dounmount+0x424 sys_unmount+0x=
2ec amd64_syscall+0x25a Xfast_syscall+0xfb
>=20
> [3] root    76137    0.7  0.0  14772   2844  3  D+    3:12PM     0:05.2=
8 cpdup -i0 -x /poudriere/data/.m/exp-10amd64-commit-test/ref /poudriere/=
data/.m/exp-10amd64-commit-test/02
> [1] root    76346    0.0  0.0   8200   1916  3  D+    3:12PM     0:00.0=
0 mkdir -p /poudriere/data/.m/exp-10amd64-commit-test/ref/../03/.p
> [2] root    76286    [command taken from gdb]                          =
  umount -f /poudriere/data/.m/exp-10amd64-commit-test/02
>=20
> Locked vnodes:
>=20
> 0xfffff80fda0bcce8: tag zfs, type VDIR
>     usecount 2, writecount 0, refcount 3 mountedhere 0x0
>     flags ()
>     v_object 0xfffff805fc81a300 ref 0 pages 0
>     lock type zfs: SHARED (count 2) with exclusive waiters pending
>     mount /poudriere/data/.m from zroot/poudriere/data/.m
>     path /poudriere/data/.m/exp-10am64-commit-test/02
> 0xfffff8065de471d8: tag zfs, type VDIR
>     usecount 1, writecount 0, refcount 3 mountedhere 0xfffff8058f582330=

>     flags ()
>     lock type zfs: EXCL by thread 0xfffff8047c0eb920 (pid 76286) with e=
xclusive and shared waiters pending
>     mount /poudriere/data/.m from zroot/poudriere/data/.m
>     path /poudriere/data/.m
>=20
>=20
> Processes:
>=20
> PID 76286 (umount -f /poudriere/data/.m/exp-10amd64-commit-test/02):
>   Waiting in vfs_write_suspend(mp=3D0xfffff8058f582330) for mn_writeopc=
ount=3D=3D0
>=20
>=20
> (kgdb) thread 521
> [Switching to thread 521 (Thread 102085)]#0  sched_switch (td=3D0xfffff=
8047c0eb920, newtd=3D<value optimized out>, flags=3D<value optimized out>=
) at /usr/src/sys/kern/sched_ule.c:1932
> 1932                    cpuid =3D PCPU_GET(cpuid);
> (kgdb) backtrace
> #0  sched_switch (td=3D0xfffff8047c0eb920, newtd=3D<value optimized out=
>, flags=3D<value optimized out>) at /usr/src/sys/kern/sched_ule.c:1932
> #1  0xffffffff80929379 in mi_switch (flags=3D260, newtd=3D0x0) at /usr/=
src/sys/kern/kern_synch.c:493
> #2  0xffffffff80966af2 in sleepq_switch (wchan=3D<value optimized out>,=
 pri=3D<value optimized out>) at /usr/src/sys/kern/subr_sleepqueue.c:552
> #3  0xffffffff80966953 in sleepq_wait (wchan=3D0xfffff8058f5823bc, pri=3D=
119) at /usr/src/sys/kern/subr_sleepqueue.c:631
> #4  0xffffffff80928c86 in _sleep (ident=3D<value optimized out>, lock=3D=
<value optimized out>, priority=3D<value optimized out>, wmesg=3D<value o=
ptimized out>, sbt=3D<value optimized out>,
>     pr=3D<value optimized out>) at /usr/src/sys/kern/kern_synch.c:255
> #5  0xffffffff809df0b0 in vfs_write_suspend (mp=3D0xfffff8058f582330, f=
lags=3D<value optimized out>) at /usr/src/sys/kern/vfs_vnops.c:1793
> #6  0xffffffff809df308 in vfs_write_suspend_umnt (mp=3D0xfffff8058f5823=
30) at /usr/src/sys/kern/vfs_vnops.c:1848
> #7  0xffffffff822ad9ed in tmpfs_unmount (mp=3D0xfffff8058f582330, mntfl=
ags=3D<value optimized out>) at /usr/src/sys/modules/tmpfs/../../fs/tmpfs=
/tmpfs_vfsops.c:280
> #8  0xffffffff809c7664 in dounmount (mp=3D0xfffff8058f582330, flags=3D1=
34742016, td=3D0xfffff8047c0eb920) at /usr/src/sys/kern/vfs_mount.c:1310
> #9  0xffffffff809c721c in sys_unmount (td=3D0xfffff8047c0eb920, uap=3D0=
xfffffe1248712b80) at /usr/src/sys/kern/vfs_mount.c:1201
> #10 0xffffffff80d38b6a in amd64_syscall (td=3D0xfffff8047c0eb920, trace=
d=3D0) at subr_syscall.c:133
> #11 0xffffffff80d1a44b in Xfast_syscall () at /usr/src/sys/amd64/amd64/=
exception.S:390
>=20
> (kgdb) p ((struct mount*)0xfffff8058f582330)->mnt_writeopcount
> $12 =3D 1
> (kgdb) p ((struct mount*)0xfffff8058f582330)->mnt_activevnodelistsize
> $13 =3D 1
> (kgdb) p ((struct mount*)0xfffff8058f582330)->mnt_vnodecovered
> $25 =3D (struct vnode *) 0xfffff8065de471d8
> (kgdb) p *(struct mount*)0xfffff8058f582330
> $5 =3D {mnt_mtx =3D {lock_object =3D {lo_name =3D 0xffffffff80fc4c20 "s=
truct mount mtx", lo_flags =3D 16973824, lo_data =3D 0, lo_witness =3D 0x=
fffffe0000b1ea00}, mtx_lock =3D 4}, mnt_gen =3D 23,
>   mnt_list =3D {tqe_next =3D 0x0, tqe_prev =3D 0xfffff8117c2abce8}, mnt=
_op =3D 0xffffffff822b3e40, mnt_vfc =3D 0xffffffff822b3f60, mnt_vnodecove=
red =3D 0xfffff8065de471d8, mnt_syncer =3D 0x0,
>   mnt_ref =3D 7357, mnt_nvnodelist =3D {tqh_first =3D 0xfffff803f6a691d=
8, tqh_last =3D 0xfffff8065dc871f8}, mnt_nvnodelistsize =3D 7356, mnt_act=
ivevnodelist =3D {tqh_first =3D 0xfffff806dff493b0,
>     tqh_last =3D 0xfffff806dff49470}, mnt_activevnodelistsize =3D 1, mn=
t_writeopcount =3D 1, mnt_kern_flag =3D 150994953, mnt_flag =3D 4096, mnt=
_opt =3D 0xfffff804e377eaf0, mnt_optnew =3D 0x0,
>   mnt_maxsymlinklen =3D 0, mnt_stat =3D {f_version =3D 537068824, f_typ=
e =3D 135, f_flags =3D 4096, f_bsize =3D 4096, f_iosize =3D 4096, f_block=
s =3D 1835008, f_bfree =3D 1798116, f_bavail =3D 1798116,
>     f_files =3D 25690112, f_ffree =3D 25682842, f_syncwrites =3D 0, f_a=
syncwrites =3D 0, f_syncreads =3D 0, f_asyncreads =3D 0, f_spare =3D {0, =
0, 0, 0, 0, 0, 0, 0, 0, 0}, f_namemax =3D 255, f_owner =3D 0,
>     f_fsid =3D {val =3D {-2027880658, 135}}, f_charspare =3D '\0' <repe=
ats 79 times>, f_fstypename =3D "tmpfs\000\000\000\000\000\000\000\000\00=
0\000",
>     f_mntfromname =3D "tmpfs", '\0' <repeats 82 times>, f_mntonname =3D=
 "/poudriere/data/.m/exp-10amd64-commit-test/02", '\0' <repeats 42 times>=
}, mnt_cred =3D 0xfffff8047c8a4a00,
>   mnt_data =3D 0xfffff8000bd2b800, mnt_time =3D 0, mnt_iosize_max =3D 6=
5536, mnt_export =3D 0x0, mnt_label =3D 0x0, mnt_hashseed =3D 3766194835,=
 mnt_lockref =3D 0, mnt_secondary_writes =3D 0,
>   mnt_secondary_accwrites =3D 0, mnt_susp_owner =3D 0xfffff8047c0eb920,=
 mnt_gjprovider =3D 0x0, mnt_explock =3D {lock_object =3D {lo_name =3D 0x=
ffffffff80fa4b29 "explock", lo_flags =3D 108199936,
>       lo_data =3D 0, lo_witness =3D 0xfffffe0000b26c80}, lk_lock =3D 1,=
 lk_exslpfail =3D 0, lk_timo =3D 0, lk_pri =3D 96}, mnt_upper_link =3D {t=
qe_next =3D 0x0, tqe_prev =3D 0xfffff8005c842ca0},
>   mnt_uppers =3D {tqh_first =3D 0x0, tqh_last =3D 0xfffff8058f582650}}
> (kgdb) p (((struct mount*)0xfffff8058f582330)->mnt_activevnodelist->tqh=
_first)
> $30 =3D (struct vnode *) 0xfffff806dff493b0
> (kgdb) p *(((struct mount*)0xfffff8058f582330)->mnt_activevnodelist->tq=
h_first)
> $24 =3D {v_tag =3D 0xffffffff822b2f76 "tmpfs", v_op =3D 0xffffffff822b3=
918, v_data =3D 0xfffff80ae07caae0, v_mount =3D 0xfffff8058f582330, v_nmn=
tvnodes =3D {tqe_next =3D 0xfffff806071d11d8,
>     tqe_prev =3D 0xfffff804d63963d0}, v_un =3D {vu_mount =3D 0x0, vu_so=
cket =3D 0x0, vu_cdev =3D 0x0, vu_fifoinfo =3D 0x0}, v_hashlist =3D {le_n=
ext =3D 0x0, le_prev =3D 0x0}, v_cache_src =3D {
>     lh_first =3D 0x0}, v_cache_dst =3D {tqh_first =3D 0x0, tqh_last =3D=
 0xfffff806dff49400}, v_cache_dd =3D 0x0, v_lock =3D {lock_object =3D {lo=
_name =3D 0xffffffff822b2f76 "tmpfs", lo_flags =3D 116588544,
>       lo_data =3D 0, lo_witness =3D 0xfffffe0000b29a00}, lk_lock =3D 1,=
 lk_exslpfail =3D 0, lk_timo =3D 51, lk_pri =3D 96}, v_interlock =3D {loc=
k_object =3D {
>       lo_name =3D 0xffffffff80fc4bc6 "vnode interlock", lo_flags =3D 16=
973824, lo_data =3D 0, lo_witness =3D 0xfffffe0000b1e500}, mtx_lock =3D 4=
}, v_vnlock =3D 0xfffff806dff49418, v_actfreelist =3D {
>     tqe_next =3D 0x0, tqe_prev =3D 0xfffff8058f5823a8}, v_bufobj =3D {b=
o_lock =3D {lock_object =3D {lo_name =3D 0xffffffff80fcd144 "bufobj inter=
lock", lo_flags =3D 86179840, lo_data =3D 0,
>         lo_witness =3D 0xfffffe0000b26580}, rw_lock =3D 1}, bo_ops =3D =
0xffffffff814ab900, bo_object =3D 0xfffff809dc520a00, bo_synclist =3D {le=
_next =3D 0x0, le_prev =3D 0x0},
>     bo_private =3D 0xfffff806dff493b0, __bo_vnode =3D 0xfffff806dff493b=
0, bo_clean =3D {bv_hd =3D {tqh_first =3D 0x0, tqh_last =3D 0xfffff806dff=
494d0}, bv_root =3D {pt_root =3D 0}, bv_cnt =3D 0},
>     bo_dirty =3D {bv_hd =3D {tqh_first =3D 0x0, tqh_last =3D 0xfffff806=
dff494f0}, bv_root =3D {pt_root =3D 0}, bv_cnt =3D 0}, bo_numoutput =3D 0=
, bo_flag =3D 0, bo_bsize =3D 4096}, v_pollinfo =3D 0x0,
>   v_label =3D 0x0, v_lockf =3D 0x0, v_rl =3D {rl_waiters =3D {tqh_first=
 =3D 0x0, tqh_last =3D 0xfffff806dff49538}, rl_currdep =3D 0x0}, v_cstart=
 =3D 0, v_lasta =3D 0, v_lastw =3D 0, v_clen =3D 0,
>   v_holdcnt =3D 1, v_usecount =3D 1, v_iflag =3D 512, v_vflag =3D 0, v_=
writecount =3D 0, v_hash =3D 115340435, v_type =3D VREG}
>=20
>=20
> PID 76137 (cpdup -i0 -x /poudriere/data/.m/exp-10amd64-commit-test/ref =
/poudriere/data/.m/exp-10amd64-commit-test/02):
>   Waiting for vget(vp=3D0xfffff8065de471d8) [which is mnt_vnodecovered =
from umount -f]
>=20
> (kgdb) thread 520
> [Switching to thread 520 (Thread 100919)]#0  sched_switch (td=3D0xfffff=
8005cd2a490, newtd=3D<value optimized out>, flags=3D<value optimized out>=
) at /usr/src/sys/kern/sched_ule.c:1932
> 1932                    cpuid =3D PCPU_GET(cpuid);
> (kgdb) backtrace
> #0  sched_switch (td=3D0xfffff8005cd2a490, newtd=3D<value optimized out=
>, flags=3D<value optimized out>) at /usr/src/sys/kern/sched_ule.c:1932
> #1  0xffffffff80929379 in mi_switch (flags=3D260, newtd=3D0x0) at /usr/=
src/sys/kern/kern_synch.c:493
> #2  0xffffffff80966af2 in sleepq_switch (wchan=3D<value optimized out>,=
 pri=3D<value optimized out>) at /usr/src/sys/kern/subr_sleepqueue.c:552
> #3  0xffffffff80966953 in sleepq_wait (wchan=3D0xfffff8065de47240, pri=3D=
96) at /usr/src/sys/kern/subr_sleepqueue.c:631
> #4  0xffffffff808fdf3a in sleeplk (lk=3D<value optimized out>, flags=3D=
<value optimized out>, ilk=3D<value optimized out>, wmesg=3D<value optimi=
zed out>, pri=3D<value optimized out>,
>     timo=3D<value optimized out>) at /usr/src/sys/kern/kern_lock.c:225
> #5  0xffffffff808fcfc2 in __lockmgr_args (lk=3D0xfffff8065de47240, flag=
s=3D<value optimized out>, ilk=3D0xfffff8065de47270, wmesg=3D<value optim=
ized out>, pri=3D<value optimized out>,
>     timo=3D<value optimized out>, file=3D0xffffffff80fcd0e8 "/usr/src/s=
ys/kern/vfs_subr.c", line=3D2137) at /usr/src/sys/kern/kern_lock.c:680
> #6  0xffffffff809be27c in vop_stdlock (ap=3D<value optimized out>) at l=
ockmgr.h:98
> #7  0xffffffff80e5b75c in VOP_LOCK1_APV (vop=3D<value optimized out>, a=
=3D<value optimized out>) at vnode_if.c:2082
> #8  0xffffffff809ddbca in _vn_lock (vp=3D0xfffff8065de471d8, flags=3D<v=
alue optimized out>, file=3D0xffffffff80fcd0e8 "/usr/src/sys/kern/vfs_sub=
r.c", line=3D2137) at vnode_if.h:859
> #9  0xffffffff809cde87 in vget (vp=3D0xfffff8065de471d8, flags=3D209740=
8, td=3D0xfffff8005cd2a490) at /usr/src/sys/kern/vfs_subr.c:2137
> #10 0xffffffff809ba132 in cache_lookup (dvp=3D0xfffff80fda0bcce8, vpp=3D=
0xfffffe1247de78b8, cnp=3D0xfffffe1247de78e0, tsp=3D0x0, ticksp=3D0x0) at=
 /usr/src/sys/kern/vfs_cache.c:673
> #11 0xffffffff809bb2dc in vfs_cache_lookup (ap=3D<value optimized out>)=
 at /usr/src/sys/kern/vfs_cache.c:1038
> #12 0xffffffff80e58e41 in VOP_LOOKUP_APV (vop=3D<value optimized out>, =
a=3D<value optimized out>) at vnode_if.c:127
> #13 0xffffffff809c364d in lookup (ndp=3D0xfffffe1247de7858) at vnode_if=
=2Eh:54
> #14 0xffffffff809c2d84 in namei (ndp=3D0xfffffe1247de7858) at /usr/src/=
sys/kern/vfs_lookup.c:300
> #15 0xffffffff809d76dd in kern_linkat (td=3D0xfffff8005cd2a490, fd1=3D<=
value optimized out>, fd2=3D-100, path1=3D<value optimized out>, path2=3D=
0x80141c600 <Address 0x80141c600 out of bounds>,
>     segflg=3DUIO_USERSPACE, follow=3D64) at /usr/src/sys/kern/vfs_sysca=
lls.c:1572
> #16 0xffffffff809d7518 in sys_link (td=3D0x0, uap=3D<value optimized ou=
t>) at /usr/src/sys/kern/vfs_syscalls.c:1541
> #17 0xffffffff820c64e9 in filemon_wrapper_link (td=3D0x0, uap=3D0xfffff=
e1247de7b80) at filemon_wrapper.c:364
> #18 0xffffffff80d38b6a in amd64_syscall (td=3D0xfffff8005cd2a490, trace=
d=3D0) at subr_syscall.c:133
> #19 0xffffffff80d1a44b in Xfast_syscall () at /usr/src/sys/amd64/amd64/=
exception.S:390
>=20
> (kgdb) p *(struct vnode*)0xfffff8065de471d8
> $34 =3D {v_tag =3D 0xffffffff81f0f8ff "zfs", v_op =3D 0xffffffff81f24b5=
0, v_data =3D 0xfffff80cb12f22e0, v_mount =3D 0xfffff8005c8a8660, v_nmntv=
nodes =3D {tqe_next =3D 0xfffff80528f4d938,
>     tqe_prev =3D 0xfffff804d659cb30}, v_un =3D {vu_mount =3D 0xfffff805=
8f582330, vu_socket =3D 0xfffff8058f582330, vu_cdev =3D 0xfffff8058f58233=
0, vu_fifoinfo =3D 0xfffff8058f582330}, v_hashlist =3D {
>     le_next =3D 0x0, le_prev =3D 0x0}, v_cache_src =3D {lh_first =3D 0x=
0}, v_cache_dst =3D {tqh_first =3D 0xfffff805d7724a80, tqh_last =3D 0xfff=
ff805d7724aa0}, v_cache_dd =3D 0xfffff805d7724a80,
>   v_lock =3D {lock_object =3D {lo_name =3D 0xffffffff81f0f8ff "zfs", lo=
_flags =3D 117112832, lo_data =3D 0, lo_witness =3D 0xfffffe0000b28780}, =
lk_lock =3D 18446735296877738278, lk_exslpfail =3D 0,
>     lk_timo =3D 51, lk_pri =3D 96}, v_interlock =3D {lock_object =3D {l=
o_name =3D 0xffffffff80fc4bc6 "vnode interlock", lo_flags =3D 16973824, l=
o_data =3D 0, lo_witness =3D 0xfffffe0000b1e500},
>     mtx_lock =3D 4}, v_vnlock =3D 0xfffff8065de47240, v_actfreelist =3D=
 {tqe_next =3D 0xfffff80528f4d938, tqe_prev =3D 0xfffff804d659cbd0}, v_bu=
fobj =3D {bo_lock =3D {lock_object =3D {
>         lo_name =3D 0xffffffff80fcd144 "bufobj interlock", lo_flags =3D=
 86179840, lo_data =3D 0, lo_witness =3D 0xfffffe0000b26580}, rw_lock =3D=
 1}, bo_ops =3D 0xffffffff814ab900, bo_object =3D 0x0,
>     bo_synclist =3D {le_next =3D 0x0, le_prev =3D 0x0}, bo_private =3D =
0xfffff8065de471d8, __bo_vnode =3D 0xfffff8065de471d8, bo_clean =3D {bv_h=
d =3D {tqh_first =3D 0x0, tqh_last =3D 0xfffff8065de472f8},
>       bv_root =3D {pt_root =3D 0}, bv_cnt =3D 0}, bo_dirty =3D {bv_hd =3D=
 {tqh_first =3D 0x0, tqh_last =3D 0xfffff8065de47318}, bv_root =3D {pt_ro=
ot =3D 0}, bv_cnt =3D 0}, bo_numoutput =3D 0, bo_flag =3D 0,
>     bo_bsize =3D 131072}, v_pollinfo =3D 0x0, v_label =3D 0x0, v_lockf =
=3D 0x0, v_rl =3D {rl_waiters =3D {tqh_first =3D 0x0, tqh_last =3D 0xffff=
f8065de47360}, rl_currdep =3D 0x0}, v_cstart =3D 0,
>   v_lasta =3D 0, v_lastw =3D 0, v_clen =3D 0, v_holdcnt =3D 3, v_usecou=
nt =3D 1, v_iflag =3D 512, v_vflag =3D 0, v_writecount =3D 0, v_hash =3D =
106816625, v_type =3D VDIR}
>=20
> (kgdb) frame 15
> #15 0xffffffff809d76dd in kern_linkat (td=3D0xfffff8005cd2a490, fd1=3D<=
value optimized out>, fd2=3D-100, path1=3D<value optimized out>, path2=3D=
0x80141c600 <Address 0x80141c600 out of bounds>,
>     segflg=3DUIO_USERSPACE, follow=3D64) at /usr/src/sys/kern/vfs_sysca=
lls.c:1572
> 1572            if ((error =3D namei(&nd)) =3D=3D 0) {
> (kgdb) info locals
> mp =3D (struct mount *) 0xfffff8058f582330
> nd =3D {ni_dirp =3D 0x80141c600 <Address 0x80141c600 out of bounds>, ni=
_segflg =3D UIO_USERSPACE, ni_rightsneeded =3D {cr_rights =3D {1441151880=
80051200, 288230376151711744}}, ni_startdir =3D 0x0,
>   ni_rootdir =3D 0xfffff8005c0ea1d8, ni_topdir =3D 0x0, ni_dirfd =3D -1=
00, ni_strictrelative =3D 0, ni_filecaps =3D {fc_rights =3D {cr_rights =3D=
 {0, 0}}, fc_ioctls =3D 0x0, fc_nioctls =3D -1,
>     fc_fcntls =3D 0}, ni_vp =3D 0xfffff8065de471d8, ni_dvp =3D 0xfffff8=
0fda0bcce8, ni_pathlen =3D 63,
>   ni_next =3D 0xfffff80e918bb02d "/usr/share/openssl/man/man3/CMS_Signe=
rInfo_get0_signer_id.3.gz", ni_loopcnt =3D 0, ni_cnd =3D {cn_nameiop =3D =
1, cn_flags =3D 134236168,
>     cn_thread =3D 0xfffff8005cd2a490, cn_cred =3D 0xfffff8005c22a700, c=
n_lkflags =3D 2097152,
>     cn_pnbuf =3D 0xfffff80e918bb000 "/poudriere/data/.m/exp-10amd64-com=
mit-test/02/usr/share/openssl/man/man3/CMS_SignerInfo_get0_signer_id.3.gz=
",
>     cn_nameptr =3D 0xfffff80e918bb02b "02/usr/share/openssl/man/man3/CM=
S_SignerInfo_get0_signer_id.3.gz", cn_namelen =3D 2, cn_consume =3D 0}}
> rights =3D {cr_rights =3D {144115188080051200, 288230376151711744}}
> mp =3D (struct mount *) 0xfffff8058f582330
> vp =3D (struct vnode *) 0xfffff806dff493b0
> error =3D <value optimized out>
>   kern_linkat
>     mp =3D (struct mount *) 0xfffff8058f582330
>     vp =3D (struct vnode *) 0xfffff806dff493b0
>=20
>=20
> PID 76346 (mkdir -p /poudriere/data/.m/exp-10amd64-commit-test/ref/../0=
3/.p)
>   Waiting on vn_lock(0xfffff80fda0bcce8)
>=20
> (kgdb) thread 522
> [Switching to thread 522 (Thread 102346)]#0  sched_switch (td=3D0xfffff=
80419f86920, newtd=3D<value optimized out>, flags=3D<value optimized out>=
) at /usr/src/sys/kern/sched_ule.c:1932
> 1932                    cpuid =3D PCPU_GET(cpuid);
> (kgdb) backtrace
> #0  sched_switch (td=3D0xfffff80419f86920, newtd=3D<value optimized out=
>, flags=3D<value optimized out>) at /usr/src/sys/kern/sched_ule.c:1932
> #1  0xffffffff80929379 in mi_switch (flags=3D260, newtd=3D0x0) at /usr/=
src/sys/kern/kern_synch.c:493
> #2  0xffffffff80966af2 in sleepq_switch (wchan=3D<value optimized out>,=
 pri=3D<value optimized out>) at /usr/src/sys/kern/subr_sleepqueue.c:552
> #3  0xffffffff80966953 in sleepq_wait (wchan=3D0xfffff80fda0bcd50, pri=3D=
96) at /usr/src/sys/kern/subr_sleepqueue.c:631
> #4  0xffffffff808fdf3a in sleeplk (lk=3D<value optimized out>, flags=3D=
<value optimized out>, ilk=3D<value optimized out>, wmesg=3D<value optimi=
zed out>, pri=3D<value optimized out>,
>     timo=3D<value optimized out>) at /usr/src/sys/kern/kern_lock.c:225
> #5  0xffffffff808fd601 in __lockmgr_args (lk=3D0xfffff80fda0bcd50, flag=
s=3D<value optimized out>, ilk=3D0xfffff80fda0bcd80, wmesg=3D<value optim=
ized out>, pri=3D<value optimized out>,
>     timo=3D<value optimized out>, file=3D0xffffffff80fcc4f0 "/usr/src/s=
ys/kern/vfs_lookup.c", line=3D691) at /usr/src/sys/kern/kern_lock.c:939
> #6  0xffffffff809be27c in vop_stdlock (ap=3D<value optimized out>) at l=
ockmgr.h:98
> #7  0xffffffff80e5b75c in VOP_LOCK1_APV (vop=3D<value optimized out>, a=
=3D<value optimized out>) at vnode_if.c:2082
> #8  0xffffffff809ddbca in _vn_lock (vp=3D0xfffff80fda0bcce8, flags=3D<v=
alue optimized out>, file=3D0xffffffff80fcc4f0 "/usr/src/sys/kern/vfs_loo=
kup.c", line=3D691) at vnode_if.h:859
> #9  0xffffffff809c3536 in lookup (ndp=3D0xfffffe1248b7b910) at /usr/src=
/sys/kern/vfs_lookup.c:691
> #10 0xffffffff809c2d84 in namei (ndp=3D0xfffffe1248b7b910) at /usr/src/=
sys/kern/vfs_lookup.c:300
> #11 0xffffffff809daf2b in kern_mkdirat (td=3D0xfffff80419f86920, fd=3D-=
100, path=3D0x7fffffffeca1 <Address 0x7fffffffeca1 out of bounds>, segflg=
=3DUIO_USERSPACE, mode=3D511)
>     at /usr/src/sys/kern/vfs_syscalls.c:3687
> #12 0xffffffff80d38b6a in amd64_syscall (td=3D0xfffff80419f86920, trace=
d=3D0) at subr_syscall.c:133
> #13 0xffffffff80d1a44b in Xfast_syscall () at /usr/src/sys/amd64/amd64/=
exception.S:390
> #14 0x0000000800953faa in ?? ()
>=20
> (kgdb) p *(struct vnode*) 0xfffff80fda0bcce8
> $35 =3D {v_tag =3D 0xffffffff81f0f8ff "zfs", v_op =3D 0xffffffff81f24b5=
0, v_data =3D 0xfffff80c56bf8b80, v_mount =3D 0xfffff8005c8a8660, v_nmntv=
nodes =3D {tqe_next =3D 0xfffff806d8e1d1d8,
>     tqe_prev =3D 0xfffff80df75d51f8}, v_un =3D {vu_mount =3D 0x0, vu_so=
cket =3D 0x0, vu_cdev =3D 0x0, vu_fifoinfo =3D 0x0}, v_hashlist =3D {le_n=
ext =3D 0x0, le_prev =3D 0x0}, v_cache_src =3D {
>     lh_first =3D 0xfffff805d7724a80}, v_cache_dst =3D {tqh_first =3D 0x=
fffff805df597690, tqh_last =3D 0xfffff805df5976b0}, v_cache_dd =3D 0xffff=
f805df597690, v_lock =3D {lock_object =3D {
>       lo_name =3D 0xffffffff81f0f8ff "zfs", lo_flags =3D 117112832, lo_=
data =3D 0, lo_witness =3D 0xfffffe0000b28780}, lk_lock =3D 21, lk_exslpf=
ail =3D 0, lk_timo =3D 51, lk_pri =3D 96}, v_interlock =3D {
>     lock_object =3D {lo_name =3D 0xffffffff80fc4bc6 "vnode interlock", =
lo_flags =3D 16973824, lo_data =3D 0, lo_witness =3D 0xfffffe0000b1e500},=
 mtx_lock =3D 4}, v_vnlock =3D 0xfffff80fda0bcd50,
>   v_actfreelist =3D {tqe_next =3D 0xfffff806d8e1d1d8, tqe_prev =3D 0xff=
fff80528f4d9f8}, v_bufobj =3D {bo_lock =3D {lock_object =3D {lo_name =3D =
0xffffffff80fcd144 "bufobj interlock",
>         lo_flags =3D 86179840, lo_data =3D 0, lo_witness =3D 0xfffffe00=
00b26580}, rw_lock =3D 1}, bo_ops =3D 0xffffffff814ab900, bo_object =3D 0=
xfffff805fc81a300, bo_synclist =3D {le_next =3D 0x0,
>       le_prev =3D 0x0}, bo_private =3D 0xfffff80fda0bcce8, __bo_vnode =3D=
 0xfffff80fda0bcce8, bo_clean =3D {bv_hd =3D {tqh_first =3D 0x0, tqh_last=
 =3D 0xfffff80fda0bce08}, bv_root =3D {pt_root =3D 0},
>       bv_cnt =3D 0}, bo_dirty =3D {bv_hd =3D {tqh_first =3D 0x0, tqh_la=
st =3D 0xfffff80fda0bce28}, bv_root =3D {pt_root =3D 0}, bv_cnt =3D 0}, b=
o_numoutput =3D 0, bo_flag =3D 0, bo_bsize =3D 131072},
>   v_pollinfo =3D 0x0, v_label =3D 0x0, v_lockf =3D 0x0, v_rl =3D {rl_wa=
iters =3D {tqh_first =3D 0x0, tqh_last =3D 0xfffff80fda0bce70}, rl_currde=
p =3D 0x0}, v_cstart =3D 0, v_lasta =3D 0, v_lastw =3D 0,
>   v_clen =3D 0, v_holdcnt =3D 3, v_usecount =3D 2, v_iflag =3D 512, v_v=
flag =3D 0, v_writecount =3D 0, v_hash =3D 18, v_type =3D VDIR}
>=20

Let me know if I can provide any further information.

--=20
Regards,
Bryan Drewery


--Hb4K9m0hacv3IKadGr1XVwrOU5suiheIf
Content-Type: application/pgp-signature; name="signature.asc"
Content-Description: OpenPGP digital signature
Content-Disposition: attachment; filename="signature.asc"

-----BEGIN PGP SIGNATURE-----
Version: GnuPG v1.4.10 (MingW32)

iQEcBAEBAgAGBQJUINX8AAoJEDXXcbtuRpfPVgcH/RqaU6geH8W5vcudmtaxxQXp
HDQ5OJDIoE1GjcN8VgYSjlqSSIdyQXYoGblQRuguibAII2u/d+/9kpNqI/LUhP4+
irPwezLbVJrxOJySsPy9Ib619Au6Lk8DNCME7LJvI0rhIa0NsENRBMIEnBtY1vEq
UbqMzlSuunYryv3FofNXOc+79oUN6fdLoKbU1Tk63/T90yGLGHEM6xY6GZyzaYBU
EjU6BWoP8OxIVCkeM9MkBkA4Ij2usp/ylj0mR5e3RUG7p7SJaY6jzMz7rGOfvme1
g8fejvLP896G1E5dVrTk/i4gDZ/UB6nBocVA+66094kLjKkxQZS7XoQE/0GZoOw=
=+qmG
-----END PGP SIGNATURE-----

--Hb4K9m0hacv3IKadGr1XVwrOU5suiheIf--



Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?5420D5FC.4030600>