panic: acquiring blockable sleep lock with spinlock or critical section held (kernel_lock) &kernel_lock
Stopped at db_enter+0x1c: addq $0x8,%rsp
TID PID UID PRFLAGS PFLAGS CPU COMMAND
*333560 15184 0 0x8000000 0x4000000 0 syz-executor.0
238499 5529 0 0x14000 0x200 1 reaper
db_enter() at db_enter+0x1c sys/arch/amd64/amd64/db_interface.c:437
panic(ffffffff828e8745) at panic+0x17b sys/kern/subr_prf.c:198
witness_checkorder(ffffffff82e31640,9,0) at witness_checkorder+0xd03 witness_debugger sys/kern/subr_witness.c:2524 [inline]
witness_checkorder(ffffffff82e31640,9,0) at witness_checkorder+0xd03 sys/kern/subr_witness.c:786
__mp_lock(ffffffff82e31438) at __mp_lock+0xa2 read_rflags machine/cpufunc.h:195 [inline]
__mp_lock(ffffffff82e31438) at __mp_lock+0xa2 intr_disable machine/cpufunc.h:216 [inline]
__mp_lock(ffffffff82e31438) at __mp_lock+0xa2 sys/kern/kern_lock.c:142
intr_handler(ffff80002a4ace10,ffff80000006bc00) at intr_handler+0x62 sys/arch/amd64/amd64/intr.c:539
Xintr_ioapic_edge23_untramp() at Xintr_ioapic_edge23_untramp+0x18f
Xspllower() at Xspllower+0x1d
mtx_enter_try(ffffffff82e90320) at mtx_enter_try+0x103
mtx_enter(ffffffff82e90320) at mtx_enter+0x4e sys/kern/kern_lock.c:266
pool_get(ffffffff82e90320,9) at pool_get+0xc4 sys/kern/subr_pool.c:579
uvmspace_alloc(0,1000,1,0) at uvmspace_alloc+0x41 sys/uvm/uvm_map.c:3279
vm_impl_init(ffff80002a2a00e0,ffff80002a2dacf8) at vm_impl_init+0x92 sys/arch/amd64/amd64/vmm_machdep.c:1245
vm_create(ffff800000dfac00,ffff80002a2dacf8) at vm_create+0x13e sys/dev/vmm/vmm.c:388
vmmioctl(a00,c2585601,ffff800000dfac00,1,ffff80002a2dacf8) at vmmioctl+0x2de
end trace frame: 0xffff80002a4ad2d0, count: 0
https://www.openbsd.org/ddb.html describes the minimum info required in bug
reports. Insufficient info makes it difficult to find and fix bugs.
ddb{0}>
ddb{0}> set $lines = 0
ddb{0}> set $maxwidth = 0
ddb{0}> show panic
*cpu0: acquiring blockable sleep lock with spinlock or critical section held (kernel_lock) &kernel_lock
ddb{0}> trace
db_enter() at db_enter+0x1c sys/arch/amd64/amd64/db_interface.c:437
panic(ffffffff828e8745) at panic+0x17b sys/kern/subr_prf.c:198
witness_checkorder(ffffffff82e31640,9,0) at witness_checkorder+0xd03 witness_debugger sys/kern/subr_witness.c:2524 [inline]
witness_checkorder(ffffffff82e31640,9,0) at witness_checkorder+0xd03 sys/kern/subr_witness.c:786
__mp_lock(ffffffff82e31438) at __mp_lock+0xa2 read_rflags machine/cpufunc.h:195 [inline]
__mp_lock(ffffffff82e31438) at __mp_lock+0xa2 intr_disable machine/cpufunc.h:216 [inline]
__mp_lock(ffffffff82e31438) at __mp_lock+0xa2 sys/kern/kern_lock.c:142
intr_handler(ffff80002a4ace10,ffff80000006bc00) at intr_handler+0x62 sys/arch/amd64/amd64/intr.c:539
Xintr_ioapic_edge23_untramp() at Xintr_ioapic_edge23_untramp+0x18f
Xspllower() at Xspllower+0x1d
mtx_enter_try(ffffffff82e90320) at mtx_enter_try+0x103
mtx_enter(ffffffff82e90320) at mtx_enter+0x4e sys/kern/kern_lock.c:266
pool_get(ffffffff82e90320,9) at pool_get+0xc4 sys/kern/subr_pool.c:579
uvmspace_alloc(0,1000,1,0) at uvmspace_alloc+0x41 sys/uvm/uvm_map.c:3279
vm_impl_init(ffff80002a2a00e0,ffff80002a2dacf8) at vm_impl_init+0x92 sys/arch/amd64/amd64/vmm_machdep.c:1245
vm_create(ffff800000dfac00,ffff80002a2dacf8) at vm_create+0x13e sys/dev/vmm/vmm.c:388
vmmioctl(a00,c2585601,ffff800000dfac00,1,ffff80002a2dacf8) at vmmioctl+0x2de
VOP_IOCTL(fffffd806e8f4d88,c2585601,ffff800000dfac00,1,fffffd807f7d3820,ffff80002a2dacf8) at VOP_IOCTL+0x9a sys/kern/vfs_vops.c:264
vn_ioctl(fffffd806a393390,c2585601,ffff800000dfac00,ffff80002a2dacf8) at vn_ioctl+0xc0 sys/kern/vfs_vnops.c:525
sys_ioctl(ffff80002a2dacf8,ffff80002a4ad5d0,ffff80002a4ad520) at sys_ioctl+0x4a9
syscall(ffff80002a4ad5d0) at syscall+0x8cf mi_syscall sys/sys/syscall_mi.h:180 [inline]
syscall(ffff80002a4ad5d0) at syscall+0x8cf sys/arch/amd64/amd64/trap.c:577
Xsyscall() at Xsyscall+0x128
end of kernel
end trace frame: 0x2a52a009da0, count: -19
ddb{0}> show registers
rdi 0
rsi 0x1
rbp 0xffff80002a4acc00
rbx 0xffffffff82cf7d77 cpu_info_full_primary+0x2d77
rdx 0x3fd
rcx 0
rax 0x68
r8 0x101010101010101
r9 0x8080808080808080
r10 0x1fa7e82c56c5f89d
r11 0xbb784455d53bcb73
r12 0xffffffff82cf7b78 cpu_info_full_primary+0x2b78
r13 0
r14 0
r15 0x1
rip 0xffffffff827f493c db_enter+0x1c
cs 0x8
rflags 0x246
rsp 0xffff80002a4acbf0
ss 0x10
db_enter+0x1c: addq $0x8,%rsp
ddb{0}> show proc
PROC (syz-executor.0) tid=333560 pid=15184 tcnt=2 stat=onproc
flags process=8000000 proc=4000000<THREAD>
runpri=32, usrpri=66, slppri=32, nice=20
wchan=0x0, wmesg=, ps_single=0x0
forw=0xffffffffffffffff, list=0xffff80002a2dbc58,0xffff80002a2da038
process=0xffff80002a2a7558 user=0xffff80002a4a8000, vmspace=0xfffffd80682936e0
estcpu=36, cpticks=1, pctcpu=0.0, user=0, sys=0, intr=1
ddb{0}> ps
PID TID PPID UID S FLAGS WAIT COMMAND
92114 122098 50908 0 2 0x8000000 syz-executor.5
92114 403793 50908 0 2 0xc000000 syz-executor.5
15184 383428 58898 0 2 0x8000000 syz-executor.0
*15184 333560 58898 0 7 0xc000000 syz-executor.0
2767 22786 46044 0 3 0x8000082 nanoslp syz-executor.4
50908 423896 46044 0 3 0x8000082 nanoslp syz-executor.5
2046 59095 46044 0 3 0x8000082 nanoslp syz-executor.7
85862 339630 46044 0 3 0x8000082 nanoslp syz-executor.6
49310 148549 46044 0 3 0x8000082 nanoslp syz-executor.3
59703 170593 46044 0 3 0x8000082 nanoslp syz-executor.2
58898 125815 46044 0 3 0x8000082 nanoslp syz-executor.0
14750 517043 46044 0 3 0x8000002 biowait syz-executor.1
46044 289159 93579 0 3 0x1a000082 thrsleep syz-execprog
46044 490177 93579 0 3 0x1e000082 nanoslp syz-execprog
46044 153146 93579 0 3 0x1e000082 wait syz-execprog
46044 154480 93579 0 3 0x1e000082 wait syz-execprog
46044 249431 93579 0 3 0x1e000082 wait syz-execprog
46044 146727 93579 0 3 0x1e000082 wait syz-execprog
46044 339860 93579 0 3 0x1e000082 thrsleep syz-execprog
46044 336071 93579 0 3 0x1e000082 wait syz-execprog
46044 17689 93579 0 3 0x1e000082 wait syz-execprog
46044 110545 93579 0 3 0x1e000082 wait syz-execprog
46044 248566 93579 0 3 0x1e000082 thrsleep syz-execprog
46044 224114 93579 0 3 0x1e000082 wait syz-execprog
46044 439710 93579 0 3 0x1e000082 thrsleep syz-execprog
46044 510466 93579 0 3 0x1e000082 kqread syz-execprog
46044 396890 93579 0 3 0x1e000082 thrsleep syz-execprog
93579 133770 9956 0 3 0x810008a sigsusp ksh
9956 310397 77341 0 3 0x1800009a kqread sshd
73646 199519 1 0 3 0x18100083 ttyin getty
77341 78334 1 0 3 0x18000088 kqread sshd
46392 70894 33921 73 3 0x19100090 kqread syslogd
33921 188452 1 0 3 0x18100082 sbwait syslogd
12797 306920 1 0 3 0x18100080 kqread resolvd
9917 253556 52497 77 3 0x18100092 kqread dhcpleased
96880 84875 52497 77 3 0x18100092 kqread dhcpleased
52497 481271 1 0 3 0x18000080 kqread dhcpleased
11261 468793 0 0 3 0x14200 bored smr
2420 138598 0 0 2 0x14200 zerothread
91192 466516 0 0 3 0x14200 aiodoned aiodoned
83471 381592 0 0 3 0x14200 syncer update
97546 311456 0 0 3 0x14200 cleaner cleaner
5529 238499 0 0 7 0x14200 reaper
63078 218998 0 0 3 0x14200 pgdaemon pagedaemon
52600 310649 0 0 3 0x14200 bored viomb
97334 168941 0 0 3 0x40014200 acpi0 acpi0
15851 183592 0 0 3 0x40014200 idle1
69189 371970 0 0 3 0x14200 bored softnet3
58772 119539 0 0 3 0x14200 bored softnet2
69537 437250 0 0 3 0x14200 bored softnet1
15904 450242 0 0 3 0x14200 bored softnet0
23510 176551 0 0 3 0x14200 bored systqmp
6041 220379 0 0 3 0x14200 bored systq
72570 333006 0 0 3 0x14200 tmoslp softclockmp
34411 98678 0 0 3 0x40014200 tmoslp softclock
18045 448988 0 0 3 0x40014200 idle0
1 233913 0 0 3 0x8000082 wait init
0 0 -1 0 3 0x10200 scheduler swapper
ddb{0}> show all locks
CPU 0:
exclusive mutex vmsppl r = 0 (0xffffffff82e90330)
#0 witness_lock+0x446 stacktrace_save sys/sys/stacktrace.h:37 [inline]
#0 witness_lock+0x446 sys/kern/subr_witness.c:1157
#1 mtx_enter_try+0x103
#2 mtx_enter+0x4e sys/kern/kern_lock.c:266
#3 pool_get+0xc4 sys/kern/subr_pool.c:579
#4 uvmspace_alloc+0x41 sys/uvm/uvm_map.c:3279
#5 vm_impl_init+0x92 sys/arch/amd64/amd64/vmm_machdep.c:1245
#6 vm_create+0x13e sys/dev/vmm/vmm.c:388
#7 vmmioctl+0x2de
#8 VOP_IOCTL+0x9a sys/kern/vfs_vops.c:264
#9 vn_ioctl+0xc0 sys/kern/vfs_vnops.c:525
#10 sys_ioctl+0x4a9
#11 syscall+0x8cf mi_syscall sys/sys/syscall_mi.h:180 [inline]
#11 syscall+0x8cf sys/arch/amd64/amd64/trap.c:577
#12 Xsyscall+0x128
CPU 1:
kernel: protection fault trap, code=0
Faulted in DDB; continuing...
ddb{0}> show malloc
Type InUse MemUse HighUse Limit Requests Type Lim
devbuf 10167 6406K 6419K 166960K 11245 0
pcb 17 12K 12K 166960K 17 0
rtable 234 6K 6K 166960K 347 0
pf 29 8K 10K 166960K 40 0
ifaddr 44 15K 15K 166960K 46 0
ifgroup 50 2K 2K 166960K 50 0
counters 64 36K 36K 166960K 64 0
ioctlops 1 1K 4K 166960K 1795 0
mount 1 1K 1K 166960K 1 0
log 0 0K 0K 166960K 4 0
vnodes 1260 79K 79K 166960K 1279 0
UFS quota 1 32K 32K 166960K 1 0
UFS mount 5 36K 36K 166960K 5 0
shm 2 1K 1K 166960K 2 0
VM map 2 1K 1K 166960K 2 0
sem 2 0K 0K 166960K 2 0
dirhash 12 2K 2K 166960K 12 0
ACPI 1697 195K 286K 166960K 12548 0
file desc 12 41K 93K 166960K 447 0
proc 55 78K 115K 166960K 480 0
NFS srvsock 1 0K 0K 166960K 1 0
NFS daemon 1 16K 16K 166960K 1 0
in_multi 99 7K 7K 166960K 99 0
ether_multi 1 0K 0K 166960K 1 0
ISOFS mount 1 32K 32K 166960K 1 0
MSDOSFS mount 1 16K 16K 166960K 1 0
ttys 25 122K 122K 166960K 25 0
exec 0 0K 1K 166960K 370 0
tdb 3 0K 0K 166960K 3 0
VM swap 8 62K 64K 166960K 10 0
UVM amap 865 5161K 5162K 166960K 6766 0
UVM aobj 3 2K 2K 166960K 3 0
pinsyscall 32 64K 100K 166960K 1588 0
memdesc 1 4K 4K 166960K 1 0
crypto data 1 1K 1K 166960K 1 0
NDP 11 0K 2K 166960K 27 0
temp 1 6804K 6868K 166960K 4675 0
kqueue 12 18K 18K 166960K 25 0
SYN cache 2 16K 16K 166960K 2 0
ddb{0}> show all pools
Name Size Requests Fail Releases Pgreq Pgrel Npage Hiwat Minpg Maxpg Idle
plcache 128 24 0 0 1 0 1 1 0 8 0
rtpcb 120 33 0 30 1 0 1 1 0 8 0
rtentry 112 111 0 1 4 0 4 4 0 8 0
unpcb 144 33 0 20 1 0 1 1 0 8 0
syncache 336 5 0 5 1 1 0 1 0 8 0
tcpqe 32 29 0 29 1 1 0 1 0 8 0
tcpcb 808 8 0 5 1 0 1 1 0 8 0
arp 120 18 0 0 1 0 1 1 0 8 0
inpcb 384 62 0 56 1 0 1 1 0 8 0
nd6 136 24 0 0 1 0 1 1 0 8 0
pfosfp 40 1428 0 1005 5 0 5 5 0 8 0
pfosfpen 112 1428 0 714 21 0 21 21 0 8 0
pfstitem 24 20 0 0 1 0 1 1 0 8 0
pfstkey 128 20 0 0 1 0 1 1 0 8 0
pfstate 376 20 0 0 2 0 2 2 0 8 0
pfrule 1344 21 0 16 2 1 1 2 0 8 0
art_heap8 4096 1 0 0 1 0 1 1 0 8 0
art_heap4 256 453 0 0 29 0 29 29 0 8 0
art_table 32 454 0 0 4 0 4 4 0 8 0
art_node 16 110 0 10 1 0 1 1 0 8 0
dirhash 1024 17 0 0 3 0 3 3 0 8 0
dino2pl 256 2187 0 660 96 0 96 96 0 8 0
ffsino 272 2187 0 660 102 0 102 102 0 8 0
nchpl 144 3077 0 1298 67 0 67 67 0 8 0
uvmvnodes 80 2200 0 0 45 0 45 45 0 8 0
vnodes 216 2200 0 0 123 0 123 123 0 8 0
namei 1024 9707 0 9707 2 0 2 2 0 8 2
percpumem 16 46 0 0 1 0 1 1 0 8 0
vcpupl 3904 313 0 0 40 0 40 40 0 8 0
vmpool 696 314 0 0 29 0 29 29 0 8 0
kstatmem 264 22 0 0 2 0 2 2 0 8 0
scxspl 216 9931 0 9930 3 2 1 2 1 8 0
plimitpl 152 34 0 19 1 0 1 1 0 8 0
sigapl 424 752 0 706 7 0 7 7 0 8 1
futexpl 64 3710 0 3710 1 0 1 1 0 8 1
knotepl 120 102 0 0 4 0 4 4 0 8 0
kqueuepl 216 21 0 13 1 0 1 1 0 8 0
pipepl 320 142 0 114 3 0 3 3 0 8 0
fdescpl 496 734 0 711 6 1 5 5 0 8 1
filepl 152 3536 0 3406 6 0 6 6 0 8 0
lockfpl 104 6 0 4 1 0 1 1 0 8 0
lockfspl 48 4 0 2 1 0 1 1 0 8 0
sessionpl 144 25 0 9 1 0 1 1 0 8 0
pgrppl 48 25 0 9 1 0 1 1 0 8 0
ucredpl 104 66 0 56 1 0 1 1 0 8 0
zombiepl 144 711 0 706 1 0 1 1 0 8 0
processpl 1136 752 0 706 4 0 4 4 0 8 0
procpl 656 1083 0 1021 6 0 6 6 0 8 0
sockpl 664 128 0 106 3 0 3 3 0 8 1
mcl8k 8192 2 0 0 1 0 1 1 0 8 0
mcl4k 4096 3 0 0 1 0 1 1 0 8 0
mcl2k 2048 381 0 0 48 0 48 48 0 8 0
mtagpl 96 3 0 0 1 0 1 1 0 8 0
mbufpl 256 397 0 0 25 0 25 25 0 8 0
bufpl 280 4702 0 180 323 0 323 323 0 8 0
anonpl 24 223890 0 218548 57 1 56 56 0 186 22
amapchunkpl 152 19963 0 19426 28 0 28 28 0 158 4
amappl16 200 5697 0 5580 8 0 8 8 0 8 0
amappl15 192 34 0 33 1 0 1 1 0 8 0
amappl14 184 157 0 146 2 0 2 2 0 8 1
amappl13 176 15 0 15 1 1 0 1 0 8 0
amappl12 168 1384 0 1359 2 0 2 2 0 8 0
amappl11 160 71 0 60 1 0 1 1 0 8 0
amappl10 152 44 0 36 1 0 1 1 0 8 0
amappl9 144 351 0 350 1 0 1 1 0 8 0
amappl8 136 133 0 97 2 0 2 2 0 8 0
amappl7 128 47 0 37 1 0 1 1 0 8 0
amappl6 120 354 0 339 2 0 2 2 0 8 0
amappl5 112 183 0 170 1 0 1 1 0 8 0
amappl4 104 559 0 526 2 0 2 2 0 8 0
amappl3 96 3701 0 3644 3 0 3 3 0 8 1
amappl2 88 1129 0 1063 3 0 3 3 0 8 1
amappl1 80 11865 0 11380 22 3 19 22 0 8 8
amappl 88 5906 0 5441 11 0 11 11 0 92 0
dma4096 4096 1 0 1 1 1 0 1 0 8 0
dma1024 1024 1 0 0 1 0 1 1 0 8 0
dma256 256 6 0 6 1 1 0 1 0 8 0
dma128 128 253 0 253 1 1 0 1 0 8 0
dma64 64 6 0 6 1 1 0 1 0 8 0
dma32 32 7 0 7 1 1 0 1 0 8 0
dma16 16 18 0 17 1 0 1 1 0 8 0
aobjpl 72 2 0 0 1 0 1 1 0 8 0
uaddrrnd 24 1047 0 711 3 0 3 3 0 8 0
uaddrbest 32 2 0 0 1 0 1 1 0 8 0
uaddr 24 1047 0 711 3 0 3 3 0 8 0
vmmpekpl 168 9875 0 9833 3 0 3 3 0 8 0
vmmpepl 168 63100 0 61250 115 1 114 115 0 357 25
vmsppl 440 1046 0 711 38 0 38 38 0 8 0
rwobjpl 56 25800 0 22300 50 0 50 50 0 8 0
pdppl 4096 2101 0 1735 391 16 375 375 0 8 9
pvpl 32 45786 0 0 371 1 370 370 0 265 0
pmappl 248 1046 0 711 23 1 22 22 0 8 0
extentpl 40 56 0 38 1 0 1 1 0 8 0
phpool 112 704 0 19 20 0 20 20 0 8 0
ddb{0}> machine ddbcpu 0
Invalid cpu 0
ddb{0}> trace
db_enter() at db_enter+0x1c sys/arch/amd64/amd64/db_interface.c:437
panic(ffffffff828e8745) at panic+0x17b sys/kern/subr_prf.c:198
witness_checkorder(ffffffff82e31640,9,0) at witness_checkorder+0xd03 witness_debugger sys/kern/subr_witness.c:2524 [inline]
witness_checkorder(ffffffff82e31640,9,0) at witness_checkorder+0xd03 sys/kern/subr_witness.c:786
__mp_lock(ffffffff82e31438) at __mp_lock+0xa2 read_rflags machine/cpufunc.h:195 [inline]
__mp_lock(ffffffff82e31438) at __mp_lock+0xa2 intr_disable machine/cpufunc.h:216 [inline]
__mp_lock(ffffffff82e31438) at __mp_lock+0xa2 sys/kern/kern_lock.c:142
intr_handler(ffff80002a4ace10,ffff80000006bc00) at intr_handler+0x62 sys/arch/amd64/amd64/intr.c:539
Xintr_ioapic_edge23_untramp() at Xintr_ioapic_edge23_untramp+0x18f
Xspllower() at Xspllower+0x1d
mtx_enter_try(ffffffff82e90320) at mtx_enter_try+0x103
mtx_enter(ffffffff82e90320) at mtx_enter+0x4e sys/kern/kern_lock.c:266
pool_get(ffffffff82e90320,9) at pool_get+0xc4 sys/kern/subr_pool.c:579
uvmspace_alloc(0,1000,1,0) at uvmspace_alloc+0x41 sys/uvm/uvm_map.c:3279
vm_impl_init(ffff80002a2a00e0,ffff80002a2dacf8) at vm_impl_init+0x92 sys/arch/amd64/amd64/vmm_machdep.c:1245
vm_create(ffff800000dfac00,ffff80002a2dacf8) at vm_create+0x13e sys/dev/vmm/vmm.c:388
vmmioctl(a00,c2585601,ffff800000dfac00,1,ffff80002a2dacf8) at vmmioctl+0x2de
VOP_IOCTL(fffffd806e8f4d88,c2585601,ffff800000dfac00,1,fffffd807f7d3820,ffff80002a2dacf8) at VOP_IOCTL+0x9a sys/kern/vfs_vops.c:264
vn_ioctl(fffffd806a393390,c2585601,ffff800000dfac00,ffff80002a2dacf8) at vn_ioctl+0xc0 sys/kern/vfs_vnops.c:525
sys_ioctl(ffff80002a2dacf8,ffff80002a4ad5d0,ffff80002a4ad520) at sys_ioctl+0x4a9
syscall(ffff80002a4ad5d0) at syscall+0x8cf mi_syscall sys/sys/syscall_mi.h:180 [inline]
syscall(ffff80002a4ad5d0) at syscall+0x8cf sys/arch/amd64/amd64/trap.c:577
Xsyscall() at Xsyscall+0x128
end of kernel
end trace frame: 0x2a52a009da0, count: -19
ddb{0}>