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 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}>