login: panic: pool_cache_item_magic_check: mbufpl cpu free list modified: item addr 0xfffffd806f246900+16 0x0!=0xbd19239a5c7bb567
Stopped at db_enter+0x18: addq $0x8,%rsp
TID PID UID PRFLAGS PFLAGS CPU COMMAND
*522214 31648 74 0x100012 0 1K pflogd
474401 54771 73 0x100010 0x80 0 syslogd
db_enter() at db_enter+0x18 sys/arch/amd64/amd64/db_interface.c:398
panic(ffffffff82407375) at panic+0x164 sys/kern/subr_prf.c:218
pool_cache_get(ffffffff828d9e68) at pool_cache_get+0x323 pool_cache_item_magic_check sys/kern/subr_pool.c:1781 [inline]
pool_cache_get(ffffffff828d9e68) at pool_cache_get+0x323 sys/kern/subr_pool.c:1884
pool_get(ffffffff828d9e68,1) at pool_get+0x91 sys/kern/subr_pool.c:572
m_gethdr(1,1) at m_gethdr+0x4c sys/kern/uipc_mbuf.c:283
m_getuio(ffff800020e24708,1,100000,ffff800020e247f0) at m_getuio+0xe4 sys/kern/uipc_socket.c:587
sosend(fffffd806eaeaaf8,0,ffff800020e247f0,0,0,0) at sosend+0x54e sys/kern/uipc_socket.c:542
dosendsyslog(ffff800020e3f280,7f7ffffe4c60,3d,0,0) at dosendsyslog+0x2b8 sys/kern/subr_log.c:517
sys_sendsyslog(ffff800020e3f280,ffff800020e24980,ffff800020e249d0) at sys_sendsyslog+0x13e sys/kern/subr_log.c:437
syscall(ffff800020e24a50) at syscall+0x4a4 mi_syscall sys/sys/syscall_mi.h:102 [inline]
syscall(ffff800020e24a50) at syscall+0x4a4 sys/arch/amd64/amd64/trap.c:570
Xsyscall() at Xsyscall+0x128
end of kernel
end trace frame: 0x7f7ffffe71e0, count: 4
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{1}>
ddb{1}> set $lines = 0
ddb{1}> set $maxwidth = 0
ddb{1}> show panic
pool_cache_item_magic_check: mbufpl cpu free list modified: item addr 0xfffffd806f246900+16 0x0!=0xbd19239a5c7bb567
ddb{1}> trace
db_enter() at db_enter+0x18 sys/arch/amd64/amd64/db_interface.c:398
panic(ffffffff82407375) at panic+0x164 sys/kern/subr_prf.c:218
pool_cache_get(ffffffff828d9e68) at pool_cache_get+0x323 pool_cache_item_magic_check sys/kern/subr_pool.c:1781 [inline]
pool_cache_get(ffffffff828d9e68) at pool_cache_get+0x323 sys/kern/subr_pool.c:1884
pool_get(ffffffff828d9e68,1) at pool_get+0x91 sys/kern/subr_pool.c:572
m_gethdr(1,1) at m_gethdr+0x4c sys/kern/uipc_mbuf.c:283
m_getuio(ffff800020e24708,1,100000,ffff800020e247f0) at m_getuio+0xe4 sys/kern/uipc_socket.c:587
sosend(fffffd806eaeaaf8,0,ffff800020e247f0,0,0,0) at sosend+0x54e sys/kern/uipc_socket.c:542
dosendsyslog(ffff800020e3f280,7f7ffffe4c60,3d,0,0) at dosendsyslog+0x2b8 sys/kern/subr_log.c:517
sys_sendsyslog(ffff800020e3f280,ffff800020e24980,ffff800020e249d0) at sys_sendsyslog+0x13e sys/kern/subr_log.c:437
syscall(ffff800020e24a50) at syscall+0x4a4 mi_syscall sys/sys/syscall_mi.h:102 [inline]
syscall(ffff800020e24a50) at syscall+0x4a4 sys/arch/amd64/amd64/trap.c:570
Xsyscall() at Xsyscall+0x128
end of kernel
end trace frame: 0x7f7ffffe71e0, count: -11
ddb{1}> show registers
rdi 0
rsi 0x1
rbp 0xffff800020e24430
rbx 0xffff800020e244e0
rdx 0x8b
rcx 0x2
rax 0x1
r8 0xffff800020e243f0
r9 0xffffffff81379bbf kprintf+0x16f
r10 0x1
r11 0x345bdd4895598224
r12 0x3000000008
r13 0xffff800020e24440
r14 0x100
r15 0x1
rip 0xffffffff81f0e6b8 db_enter+0x18
cs 0x8
rflags 0x246
rsp 0xffff800020e24420
ss 0x10
db_enter+0x18: addq $0x8,%rsp
ddb{1}> show proc
PROC (pflogd) pid=522214 stat=onproc
flags process=100012<EXEC,SUGID,PLEDGE,8ORPHAN> proc=0
pri=26, usrpri=51, nice=20
forw=0xffffffffffffffff, list=0xffff800020e40390,0xffff800020e40880
process=0xffff8000ffffe7d8 user=0xffff800020e1f000, vmspace=0xfffffd806e9068a8
estcpu=1, cpticks=1, pctcpu=0.0
user=0, sys=1, intr=0
ddb{1}> ps
PID TID PPID UID S FLAGS WAIT COMMAND
35907 400550 21912 0 3 0x82 nanosleep syz-executor.0
21912 185546 83546 0 3 0x82 thrsleep syz-execprog
21912 184631 83546 0 3 0x4000082 nanosleep syz-execprog
21912 262755 83546 0 3 0x4000082 thrsleep syz-execprog
21912 67123 83546 0 3 0x4000082 thrsleep syz-execprog
21912 25591 83546 0 3 0x4000082 kqread syz-execprog
21912 327221 83546 0 3 0x4000082 thrsleep syz-execprog
21912 223025 83546 0 3 0x4000082 nanosleep syz-execprog
21912 417620 83546 0 3 0x4000082 thrsleep syz-execprog
83546 34343 56355 0 3 0x10008a pause ksh
56355 70053 16732 0 3 0x92 select sshd
49051 440337 1 0 3 0x100083 ttyin getty
16732 500979 1 0 3 0x80 select sshd
*31648 522214 24151 74 7 0x100012 pflogd
24151 93140 1 0 3 0x80 netio pflogd
54771 474401 65591 73 7 0x100090 syslogd
65591 520326 1 0 3 0x100082 netio syslogd
40285 398341 1 77 3 0x100090 poll dhclient
69445 458230 1 0 3 0x80 poll dhclient
11254 439309 0 0 3 0x14200 bored smr
99639 383927 0 0 3 0x14200 pgzero zerothread
99757 362409 0 0 3 0x14200 aiodoned aiodoned
19677 358877 0 0 3 0x14200 syncer update
23765 303927 0 0 3 0x14200 cleaner cleaner
38383 158972 0 0 3 0x14200 reaper reaper
70967 124927 0 0 3 0x14200 pgdaemon pagedaemon
18266 236190 0 0 3 0x14200 bored crynlk
35825 313844 0 0 3 0x14200 bored crypto
27950 410924 0 0 3 0x40014200 acpi0 acpi0
65435 30742 0 0 3 0x40014200 idle1
4563 190689 0 0 3 0x14200 bored softnet
57231 232067 0 0 3 0x14200 bored systqmp
91770 48738 0 0 3 0x14200 bored systq
59529 227015 0 0 3 0x40014200 bored softclock
86266 421901 0 0 3 0x40014200 idle0
1 42246 0 0 3 0x82 wait init
0 0 -1 0 3 0x10200 scheduler swapper
ddb{1}> show all locks
Process 31648 (pflogd) thread 0xffff800020e3f280 (522214)
exclusive kernel_lock &kernel_lock r = 0 (0xffffffff82934728)
#0 witness_lock+0x4c7 stacktrace_save sys/sys/stacktrace.h:36 [inline]
#0 witness_lock+0x4c7 sys/kern/subr_witness.c:1164
#1 syscall+0x400 mi_syscall sys/sys/syscall_mi.h:93 [inline]
#1 syscall+0x400 sys/arch/amd64/amd64/trap.c:570
#2 Xsyscall+0x128
ddb{1}> show malloc
Type InUse MemUse HighUse Limit Requests Type Lim
devbuf 9464 6394K 6394K 78643K 10557 0
pcb 13 8K 8K 78643K 13 0
rtable 83 2K 2K 78643K 163 0
ifaddr 37 9K 9K 78643K 50 0
counters 41 33K 33K 78643K 41 0
ioctlops 0 0K 4K 78643K 1468 0
mount 1 1K 1K 78643K 1 0
vnodes 1183 74K 75K 78643K 1188 0
UFS quota 1 32K 32K 78643K 1 0
UFS mount 5 36K 36K 78643K 5 0
shm 2 1K 1K 78643K 2 0
VM map 2 1K 1K 78643K 2 0
sem 2 0K 0K 78643K 2 0
dirhash 12 2K 2K 78643K 12 0
ACPI 1824 197K 290K 78643K 13058 0
file desc 2 4K 12K 78643K 29 0
proc 59 63K 83K 78643K 398 0
NFS srvsock 1 0K 0K 78643K 1 0
NFS daemon 1 16K 16K 78643K 1 0
in_multi 22 1K 1K 78643K 22 0
ether_multi 1 0K 0K 78643K 1 0
ISOFS mount 1 32K 32K 78643K 1 0
MSDOSFS mount 1 16K 16K 78643K 1 0
ttys 19 95K 95K 78643K 19 0
exec 0 0K 1K 78643K 197 0
pagedep 1 8K 8K 78643K 1 0
inodedep 1 32K 32K 78643K 1 0
newblk 1 0K 0K 78643K 1 0
VM swap 7 26K 26K 78643K 7 0
UVM amap 84 12K 12K 78643K 972 0
UVM aobj 3 2K 2K 78643K 3 0
memdesc 1 4K 4K 78643K 1 0
crypto data 1 1K 1K 78643K 1 0
NDP 7 0K 0K 78643K 7 0
temp 29 3849K 3913K 78643K 1891 0
kqueue 3 4K 4K 78643K 3 0
SYN cache 2 16K 16K 78643K 2 0
ddb{1}> show all pools
Name Size Requests Fail Releases Pgreq Pgrel Npage Hiwat Minpg Maxpg Idle
arp 64 4 0 0 1 0 1 1 0 8 0
plcache 128 20 0 0 1 0 1 1 0 8 0
rtpcb 80 17 0 15 1 0 1 1 0 8 0
rtentry 112 34 0 1 1 0 1 1 0 8 0
unpcb 120 29 0 19 1 0 1 1 0 8 0
syncache 264 5 0 5 2 1 1 1 0 8 1
tcpcb 544 8 0 5 1 0 1 1 0 8 0
inpcb 296 45 0 39 1 0 1 1 0 8 0
nd6 48 3 0 0 1 0 1 1 0 8 0
pfosfp 40 846 0 423 5 0 5 5 0 8 0
pfosfpen 112 1428 0 714 21 0 21 21 0 8 0
pfstitem 24 11 0 0 1 0 1 1 0 8 0
pfstkey 112 11 0 0 1 0 1 1 0 8 0
pfstate 328 11 0 0 1 0 1 1 0 8 0
pfrule 1360 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 144 0 0 9 0 9 9 0 8 0
art_table 32 145 0 0 2 0 2 2 0 8 0
art_node 16 33 0 3 1 0 1 1 0 8 0
dirhash 1024 17 0 0 3 0 3 3 0 8 0
dino2pl 256 1433 0 33 88 0 88 88 0 8 0
ffsino 272 1433 0 33 94 0 94 94 0 8 0
nchpl 144 1662 0 61 61 1 60 60 0 8 0
uvmvnodes 72 1443 0 0 27 0 27 27 0 8 0
vnodes 208 1443 0 0 76 0 76 76 0 8 0
namei 1024 4270 0 4270 2 1 1 1 0 8 1
percpumem 16 31 0 0 1 0 1 1 0 8 0
scxspl 192 4619 0 4619 8 1 7 7 0 8 7
plimitpl 152 15 0 8 1 0 1 1 0 8 0
sigapl 424 252 0 223 4 0 4 4 0 8 0
knotepl 112 48 0 36 1 0 1 1 0 8 0
kqueuepl 144 2 0 0 1 0 1 1 0 8 0
pipepl 304 78 0 70 2 1 1 1 0 8 0
fdescpl 496 237 0 223 4 1 3 3 0 8 1
filepl 152 1136 0 1076 3 0 3 3 0 8 0
lockfpl 104 5 0 4 1 0 1 1 0 8 0
lockfspl 48 3 0 2 1 0 1 1 0 8 0
sessionpl 112 19 0 9 1 0 1 1 0 8 0
pgrppl 48 19 0 9 1 0 1 1 0 8 0
ucredpl 96 62 0 53 1 0 1 1 0 8 0
zombiepl 144 223 0 222 2 1 1 1 0 8 0
processpl 992 252 0 222 5 0 5 5 0 8 1
procpl 624 259 0 222 3 0 3 3 0 8 0
sockpl 400 91 0 73 2 0 2 2 0 8 0
mcl4k 4096 2 0 0 1 0 1 1 0 8 0
mcl2k 2048 69 0 0 9 0 9 9 0 8 0
mtagpl 96 1 0 0 1 0 1 1 0 8 0
mbufpl 256 96 0 0 5 0 5 5 0 8 0
bufpl 280 2999 0 127 206 0 206 206 0 8 0
anonpl 16 22749 0 21036 14 2 12 12 0 124 4
amapchunkpl 152 823 0 745 5 0 5 5 0 158 1
amappl16 192 195 0 164 2 0 2 2 0 8 0
amappl15 184 4 0 2 1 0 1 1 0 8 0
amappl14 176 10 0 8 1 0 1 1 0 8 0
amappl13 168 22 0 20 2 1 1 1 0 8 0
amappl12 160 25 0 22 1 0 1 1 0 8 0
amappl11 152 52 0 37 1 0 1 1 0 8 0
amappl10 144 16 0 13 1 0 1 1 0 8 0
amappl9 136 219 0 217 1 0 1 1 0 8 0
amappl8 128 293 0 277 1 0 1 1 0 8 0
amappl7 120 112 0 101 1 0 1 1 0 8 0
amappl6 112 30 0 27 1 0 1 1 0 8 0
amappl5 104 142 0 128 1 0 1 1 0 8 0
amappl4 96 495 0 467 1 0 1 1 0 8 0
amappl3 88 126 0 118 1 0 1 1 0 8 0
amappl2 80 895 0 837 3 1 2 2 0 8 0
amappl1 72 15595 0 15176 23 5 18 18 0 8 8
amappl 80 493 0 462 1 0 1 1 0 84 0
dma4096 4096 1 0 1 1 1 0 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 64 2 0 0 1 0 1 1 0 8 0
uaddrrnd 24 237 0 223 1 0 1 1 0 8 0
uaddrbest 32 2 0 0 1 0 1 1 0 8 0
uaddr 24 237 0 223 1 0 1 1 0 8 0
vmmpekpl 168 6421 0 6396 2 0 2 2 0 8 0
vmmpepl 168 33555 0 32606 89 15 74 74 0 357 30
vmsppl 368 236 0 223 2 0 2 2 0 8 0
pdppl 4096 481 0 446 6 0 6 6 0 8 1
pvpl 32 114653 0 110616 110 6 104 104 0 265 70
pmappl 232 236 0 223 1 0 1 1 0 8 0
extentpl 40 53 0 36 1 0 1 1 0 8 0
phpool 112 230 0 4 7 0 7 7 0 8 0
ddb{1}> machine ddbcpu 0
Stopped at x86_ipi_db+0x1a: addq $0x8,%rsp
x86_ipi_db(ffffffff82752ff0) at x86_ipi_db+0x1a sys/arch/amd64/amd64/db_interface.c:352
x86_ipi_handler() at x86_ipi_handler+0xc6 sys/arch/amd64/amd64/ipi.c:106
Xresume_lapic_ipi() at Xresume_lapic_ipi+0x23
__mp_lock(ffffffff82934520) at __mp_lock+0x127 __mp_lock_spin sys/kern/kern_lock.c:116 [inline]
__mp_lock(ffffffff82934520) at __mp_lock+0x127 sys/kern/kern_lock.c:147
__mp_acquire_count(ffffffff82934520,2) at __mp_acquire_count+0x51 sys/kern/kern_lock.c:227
mi_switch() at mi_switch+0x392 sys/kern/sched_bsd.c:435
sleep_finish(ffff800020e548e0,1) at sleep_finish+0x113 sys/kern/kern_synch.c:418
sleep_finish_all(ffff800020e548e0,1) at sleep_finish_all+0x32 sleep_finish_timeout sys/kern/kern_synch.c:447 [inline]
sleep_finish_all(ffff800020e548e0,1) at sleep_finish_all+0x32 sys/kern/kern_synch.c:393
tsleep(fffffd806e8d3ea0,118,ffffffff82469356,b49) at tsleep+0x1cc sys/kern/kern_synch.c:155
kqueue_sleep(fffffd806e8d3ea0,ffff800020e54d70) at kqueue_sleep+0x101 sys/kern/kern_event.c:885
kqueue_scan(fffffd806e8d3ea0,40,c18d1bfb800,ffff800020e54d70,ffff800020e3feb0,ffff800020e54dbc) at kqueue_scan+0x2b6 sys/kern/kern_event.c:928
sys_kevent(ffff800020e3feb0,ffff800020e54e30,ffff800020e54e80) at sys_kevent+0x464 sys/kern/kern_event.c:640
syscall(ffff800020e54f00) at syscall+0x4a4 mi_syscall sys/sys/syscall_mi.h:102 [inline]
syscall(ffff800020e54f00) at syscall+0x4a4 sys/arch/amd64/amd64/trap.c:570
Xsyscall() at Xsyscall+0x128
end of kernel
end trace frame: 0x7f7ffffcffb0, count: 1
ddb{0}> trace
x86_ipi_db(ffffffff82752ff0) at x86_ipi_db+0x1a sys/arch/amd64/amd64/db_interface.c:352
x86_ipi_handler() at x86_ipi_handler+0xc6 sys/arch/amd64/amd64/ipi.c:106
Xresume_lapic_ipi() at Xresume_lapic_ipi+0x23
__mp_lock(ffffffff82934520) at __mp_lock+0x127 __mp_lock_spin sys/kern/kern_lock.c:116 [inline]
__mp_lock(ffffffff82934520) at __mp_lock+0x127 sys/kern/kern_lock.c:147
__mp_acquire_count(ffffffff82934520,2) at __mp_acquire_count+0x51 sys/kern/kern_lock.c:227
mi_switch() at mi_switch+0x392 sys/kern/sched_bsd.c:435
sleep_finish(ffff800020e548e0,1) at sleep_finish+0x113 sys/kern/kern_synch.c:418
sleep_finish_all(ffff800020e548e0,1) at sleep_finish_all+0x32 sleep_finish_timeout sys/kern/kern_synch.c:447 [inline]
sleep_finish_all(ffff800020e548e0,1) at sleep_finish_all+0x32 sys/kern/kern_synch.c:393
tsleep(fffffd806e8d3ea0,118,ffffffff82469356,b49) at tsleep+0x1cc sys/kern/kern_synch.c:155
kqueue_sleep(fffffd806e8d3ea0,ffff800020e54d70) at kqueue_sleep+0x101 sys/kern/kern_event.c:885
kqueue_scan(fffffd806e8d3ea0,40,c18d1bfb800,ffff800020e54d70,ffff800020e3feb0,ffff800020e54dbc) at kqueue_scan+0x2b6 sys/kern/kern_event.c:928
sys_kevent(ffff800020e3feb0,ffff800020e54e30,ffff800020e54e80) at sys_kevent+0x464 sys/kern/kern_event.c:640
syscall(ffff800020e54f00) at syscall+0x4a4 mi_syscall sys/sys/syscall_mi.h:102 [inline]
syscall(ffff800020e54f00) at syscall+0x4a4 sys/arch/amd64/amd64/trap.c:570
Xsyscall() at Xsyscall+0x128
end of kernel
end trace frame: 0x7f7ffffcffb0, count: -14
ddb{0}> machine ddbcpu 1
Stopped at db_enter+0x18: addq $0x8,%rsp
db_enter() at db_enter+0x18 sys/arch/amd64/amd64/db_interface.c:398
panic(ffffffff82407375) at panic+0x164 sys/kern/subr_prf.c:218
pool_cache_get(ffffffff828d9e68) at pool_cache_get+0x323 pool_cache_item_magic_check sys/kern/subr_pool.c:1781 [inline]
pool_cache_get(ffffffff828d9e68) at pool_cache_get+0x323 sys/kern/subr_pool.c:1884
pool_get(ffffffff828d9e68,1) at pool_get+0x91 sys/kern/subr_pool.c:572
m_gethdr(1,1) at m_gethdr+0x4c sys/kern/uipc_mbuf.c:283
m_getuio(ffff800020e24708,1,100000,ffff800020e247f0) at m_getuio+0xe4 sys/kern/uipc_socket.c:587
sosend(fffffd806eaeaaf8,0,ffff800020e247f0,0,0,0) at sosend+0x54e sys/kern/uipc_socket.c:542
dosendsyslog(ffff800020e3f280,7f7ffffe4c60,3d,0,0) at dosendsyslog+0x2b8 sys/kern/subr_log.c:517
sys_sendsyslog(ffff800020e3f280,ffff800020e24980,ffff800020e249d0) at sys_sendsyslog+0x13e sys/kern/subr_log.c:437
syscall(ffff800020e24a50) at syscall+0x4a4 mi_syscall sys/sys/syscall_mi.h:102 [inline]
syscall(ffff800020e24a50) at syscall+0x4a4 sys/arch/amd64/amd64/trap.c:570
Xsyscall() at Xsyscall+0x128
end of kernel
end trace frame: 0x7f7ffffe71e0, count: 4
ddb{1}> trace
db_enter() at db_enter+0x18 sys/arch/amd64/amd64/db_interface.c:398
panic(ffffffff82407375) at panic+0x164 sys/kern/subr_prf.c:218
pool_cache_get(ffffffff828d9e68) at pool_cache_get+0x323 pool_cache_item_magic_check sys/kern/subr_pool.c:1781 [inline]
pool_cache_get(ffffffff828d9e68) at pool_cache_get+0x323 sys/kern/subr_pool.c:1884
pool_get(ffffffff828d9e68,1) at pool_get+0x91 sys/kern/subr_pool.c:572
m_gethdr(1,1) at m_gethdr+0x4c sys/kern/uipc_mbuf.c:283
m_getuio(ffff800020e24708,1,100000,ffff800020e247f0) at m_getuio+0xe4 sys/kern/uipc_socket.c:587
sosend(fffffd806eaeaaf8,0,ffff800020e247f0,0,0,0) at sosend+0x54e sys/kern/uipc_socket.c:542
dosendsyslog(ffff800020e3f280,7f7ffffe4c60,3d,0,0) at dosendsyslog+0x2b8 sys/kern/subr_log.c:517
sys_sendsyslog(ffff800020e3f280,ffff800020e24980,ffff800020e249d0) at sys_sendsyslog+0x13e sys/kern/subr_log.c:437
syscall(ffff800020e24a50) at syscall+0x4a4 mi_syscall sys/sys/syscall_mi.h:102 [inline]
syscall(ffff800020e24a50) at syscall+0x4a4 sys/arch/amd64/amd64/trap.c:570
Xsyscall() at Xsyscall+0x128
end of kernel
end trace frame: 0x7f7ffffe71e0, count: -11
ddb{1}>