witness: userret: returning with the following locks held: exclusive rwlock solock r = 0 (0xfffffd8073c3a828) #0 witness_lock+0x44d #1 unp_solock_peer+0x64 sys/kern/uipc_usrreq.c:168 #2 uipc_usrreq+0x7c6 sys/kern/uipc_usrreq.c:350 #3 sosend+0x61b sys/kern/uipc_socket.c:657 #4 sendit+0x65d sys/kern/uipc_syscalls.c:682 #5 sys_sendmsg+0x198 sys/kern/uipc_syscalls.c:589 #6 syscall+0x4c3 mi_syscall sys/sys/syscall_mi.h:101 [inline] #6 syscall+0x4c3 sys/arch/amd64/amd64/trap.c:585 #7 Xsyscall+0x128 panic: witness_warn Stopped at db_enter+0x18: addq $0x8,%rsp TID PID UID PRFLAGS PFLAGS CPU COMMAND *426185 76405 32767 0x10 0x4000000 1 syz-executor.3 323663 86800 0 0x14000 0x40000200 0 softclock db_enter() at db_enter+0x18 sys/arch/amd64/amd64/db_interface.c:437 panic(ffffffff82595df3) at panic+0x177 sys/kern/subr_prf.c:202 witness_warn(2,0,ffffffff8262507e) at witness_warn+0x65e witness_debugger sys/kern/subr_witness.c:2505 [inline] witness_warn(2,0,ffffffff8262507e) at witness_warn+0x65e sys/kern/subr_witness.c:1473 userret(ffff8000fffec548) at userret+0x265 sys/kern/kern_sig.c:2012 syscall(ffff80002e524930) at syscall+0x57e mi_syscall_return sys/sys/syscall_mi.h:128 [inline] syscall(ffff80002e524930) at syscall+0x57e sys/arch/amd64/amd64/trap.c:607 Xsyscall() at Xsyscall+0x128 end of kernel end trace frame: 0xdfbaaf2bab0, count: 9 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 *cpu1: witness_warn ddb{1}> trace db_enter() at db_enter+0x18 sys/arch/amd64/amd64/db_interface.c:437 panic(ffffffff82595df3) at panic+0x177 sys/kern/subr_prf.c:202 witness_warn(2,0,ffffffff8262507e) at witness_warn+0x65e witness_debugger sys/kern/subr_witness.c:2505 [inline] witness_warn(2,0,ffffffff8262507e) at witness_warn+0x65e sys/kern/subr_witness.c:1473 userret(ffff8000fffec548) at userret+0x265 sys/kern/kern_sig.c:2012 syscall(ffff80002e524930) at syscall+0x57e mi_syscall_return sys/sys/syscall_mi.h:128 [inline] syscall(ffff80002e524930) at syscall+0x57e sys/arch/amd64/amd64/trap.c:607 Xsyscall() at Xsyscall+0x128 end of kernel end trace frame: 0xdfbaaf2bab0, count: -6 ddb{1}> show registers rdi 0 rsi 0x1 rbp 0xffff80002e524660 rbx 0xffff800020dd9bb7 rdx 0 rcx 0 rax 0xffff8000fffec548 r8 0x101010101010101 r9 0x8080808080808080 r10 0x638e63e83d8a8529 r11 0x1af50f13e461297c r12 0xffff800020dd99b8 r13 0 r14 0 r15 0x1 rip 0xffffffff81844108 db_enter+0x18 cs 0x8 rflags 0x246 rsp 0xffff80002e524650 ss 0x10 db_enter+0x18: addq $0x8,%rsp ddb{1}> show proc PROC (syz-executor.3) pid=426185 stat=onproc flags process=10 proc=4000000 pri=82, usrpri=83, nice=20 forw=0xffffffffffffffff, list=0xffff8000fffee000,0xffffffff82b7b3a8 process=0xffff8000ffff8430 user=0xffff80002e51f000, vmspace=0xfffffd8065726b98 estcpu=33, cpticks=4, pctcpu=0.0 user=0, sys=4, intr=0 ddb{1}> ps PID TID PPID UID S FLAGS WAIT COMMAND 55197 261680 67829 32767 2 0x490 syz-executor.7 55197 295118 67829 32767 3 0x4000090 fsleep syz-executor.7 55197 223286 67829 32767 2 0x4000010 syz-executor.7 55197 8429 67829 32767 3 0x4000090 fsleep syz-executor.7 76405 349654 16274 32767 2 0x10 syz-executor.3 76405 124023 16274 32767 3 0x4000090 fsleep syz-executor.3 76405 451302 16274 32767 2 0x4000010 syz-executor.3 *76405 426185 16274 32767 7 0x4000010 syz-executor.3 86492 204145 11304 32767 3 0x90 nanoslp syz-executor.4 86492 283830 11304 32767 3 0x4000090 fsleep syz-executor.4 86492 86427 11304 32767 3 0x4000090 netcon syz-executor.4 76978 365367 42726 32767 2 0x490 syz-executor.2 42726 227306 58301 0 3 0x82 wait syz-executor.2 11304 467866 7063 32767 2 0x490 syz-executor.4 7063 375433 58301 0 3 0x82 wait syz-executor.4 51623 281397 83862 32767 3 0x90 piperd syz-executor.0 83862 90517 58301 0 3 0x82 wait syz-executor.0 67829 301076 38692 32767 3 0x90 nanoslp syz-executor.7 38692 147654 58301 0 3 0x82 wait syz-executor.7 16274 307253 40849 32767 2 0x490 syz-executor.3 40849 351063 58301 0 3 0x82 wait syz-executor.3 13128 324757 27158 32767 3 0x90 piperd syz-executor.6 27158 369809 58301 0 3 0x82 wait syz-executor.6 41512 211744 67745 32767 3 0x90 piperd syz-executor.1 67745 214833 58301 0 3 0x82 wait syz-executor.1 39962 290905 47526 32767 2 0x10 syz-executor.5 47526 277708 58301 0 3 0x82 wait syz-executor.5 47183 230235 0 0 3 0x14200 bored sosplice 58301 227291 42895 0 3 0x82 thrsleep syz-fuzzer 58301 479450 42895 0 2 0x4000082 syz-fuzzer 58301 195773 42895 0 3 0x4000082 thrsleep syz-fuzzer 58301 132647 42895 0 3 0x4000082 thrsleep syz-fuzzer 58301 420544 42895 0 3 0x4000082 thrsleep syz-fuzzer 58301 222710 42895 0 3 0x4000082 thrsleep syz-fuzzer 58301 340137 42895 0 3 0x4000082 thrsleep syz-fuzzer 58301 142464 42895 0 2 0x4000082 syz-fuzzer 58301 380888 42895 0 3 0x4000082 thrsleep syz-fuzzer 58301 158368 42895 0 3 0x4000082 kqread syz-fuzzer 58301 332763 42895 0 3 0x4000082 thrsleep syz-fuzzer 42895 500794 43700 0 3 0x10008a sigsusp ksh 43700 192629 60312 0 2 0x9a sshd 24321 73525 1 0 3 0x100083 ttyin getty 60312 353837 1 0 3 0x88 kqread sshd 18903 200195 64583 73 2 0x1100010 syslogd 64583 40576 1 0 3 0x100082 netio syslogd 43078 287497 1 0 3 0x100080 kqread resolvd 65822 388802 5002 77 3 0x100092 kqread dhcpleased 26861 298706 5002 77 3 0x100092 kqread dhcpleased 5002 156355 1 0 3 0x80 kqread dhcpleased 88580 355930 0 0 3 0x14200 bored smr 18734 300109 0 0 2 0x14200 zerothread 4249 313920 0 0 3 0x14200 aiodoned aiodoned 42747 421701 0 0 3 0x14200 syncer update 68023 40096 0 0 3 0x14200 cleaner cleaner 40599 407990 0 0 3 0x14200 reaper reaper 3621 357802 0 0 3 0x14200 pgdaemon pagedaemon 10519 461554 0 0 3 0x14200 bored viomb 36423 338009 0 0 3 0x40014200 acpi0 acpi0 26238 54904 0 0 3 0x40014200 idle1 88270 70171 0 0 3 0x14200 bored softnet 29812 373781 0 0 3 0x14200 bored softnet 24324 506552 0 0 3 0x14200 bored softnet 91171 464728 0 0 3 0x14200 bored softnet 44361 247223 0 0 3 0x14200 bored systqmp 92586 161950 0 0 3 0x14200 bored systq 86800 323663 0 0 7 0x40014200 softclock 27056 55586 0 0 3 0x40014200 idle0 1 153278 0 0 3 0x82 wait init 0 0 -1 0 3 0x10200 scheduler swapper ddb{1}> show all locks Process 76405 (syz-executor.3) thread 0xffff8000fffec548 (426185) exclusive rwlock solock r = 0 (0xfffffd8073c3a828) #0 witness_lock+0x44d #1 unp_solock_peer+0x64 sys/kern/uipc_usrreq.c:168 #2 uipc_usrreq+0x7c6 sys/kern/uipc_usrreq.c:350 #3 sosend+0x61b sys/kern/uipc_socket.c:657 #4 sendit+0x65d sys/kern/uipc_syscalls.c:682 #5 sys_sendmsg+0x198 sys/kern/uipc_syscalls.c:589 #6 syscall+0x4c3 mi_syscall sys/sys/syscall_mi.h:101 [inline] #6 syscall+0x4c3 sys/arch/amd64/amd64/trap.c:585 #7 Xsyscall+0x128 Process 18903 (syslogd) thread 0xffff8000ffff7cf0 (200195) exclusive rrwlock inode r = 0 (0xfffffd806e6e6f80) #0 witness_lock+0x44d #1 rw_enter+0x3e1 sys/kern/kern_rwlock.c:310 #2 rrw_enter+0x8b sys/kern/kern_rwlock.c:465 #3 VOP_LOCK+0x87 sys/kern/vfs_vops.c:518 #4 vn_lock+0x84 sys/kern/vfs_vnops.c:567 #5 sys_fsync+0xf5 sys/kern/vfs_syscalls.c:2939 #6 syscall+0x435 mi_syscall sys/sys/syscall_mi.h:101 [inline] #6 syscall+0x435 sys/arch/amd64/amd64/trap.c:585 #7 Xsyscall+0x128 ddb{1}> show malloc Type InUse MemUse HighUse Limit Requests Type Lim devbuf 10209 6412K 6420K 78643K 11382 0 pcb 13 20K 24K 78643K 21 0 rtable 236 6K 7K 78643K 2250 0 ifaddr 81 17K 17K 78643K 273 0 sysctl 3 1K 1K 78643K 3 0 counters 56 35K 35K 78643K 110 0 ioctlops 0 0K 2K 78643K 220 0 iov 0 0K 24K 78643K 2825 0 mount 1 1K 1K 78643K 1 0 log 0 0K 0K 78643K 4 0 vnodes 1271 79K 79K 78643K 4128 0 UFS quota 1 32K 32K 78643K 1 0 UFS mount 5 36K 36K 78643K 5 0 shm 2 1K 9K 78643K 136 0 VM map 2 1K 1K 78643K 2 0 sem 12 0K 0K 78643K 2878 0 dirhash 12 2K 2K 78643K 12 0 ACPI 1697 195K 286K 78643K 12548 0 file desc 21 77K 117K 78643K 11940 0 sigio 0 0K 0K 78643K 150 0 proc 56 78K 127K 78643K 2066 0 subproc 104 6K 6K 78643K 455 0 NFS srvsock 1 0K 0K 78643K 1 0 NFS daemon 1 16K 16K 78643K 1 0 ip_moptions 0 0K 0K 78643K 965 0 in_multi 99 6K 6K 78643K 499 0 ether_multi 1 0K 0K 78643K 23 0 mrt 1 0K 0K 78643K 2 0 ISOFS mount 1 32K 32K 78643K 1 0 MSDOSFS mount 1 16K 16K 78643K 1 0 ttys 253 1129K 1129K 78643K 253 0 exec 0 0K 2K 78643K 3395 0 tdb 3 0K 0K 78643K 3 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 296 88K 105K 78643K 73855 0 UVM aobj 131 8K 8K 78643K 142 0 memdesc 1 4K 4K 78643K 1 0 crypto data 1 1K 1K 78643K 1 0 ip6_options 0 0K 0K 78643K 394 0 NDP 11 0K 2K 78643K 108 0 temp 124 4726K 4790K 78643K 32922 0 kqueue 12 18K 27K 78643K 887 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 plcache 128 22 0 0 1 0 1 1 0 8 0 rtpcb 120 1305 0 1302 23 20 3 4 0 8 2 rtentry 112 419 0 308 4 0 4 4 0 8 0 unpcb 144 10143 0 10128 85 82 3 8 0 8 2 syncache 296 110 0 110 20 20 0 1 0 8 0 tcpqe 32 96 0 96 14 14 0 1 0 8 0 tcpcb 736 4280 0 4271 154 152 2 30 0 8 1 arp 120 74 0 56 1 0 1 1 0 8 0 ipq 40 1 0 1 1 1 0 1 0 8 0 ipqe 40 2 0 2 1 1 0 1 0 8 0 inpcb 320 13193 0 13183 173 166 7 19 0 8 6 ip6q 72 8 0 8 3 3 0 1 0 8 0 ip6af 40 24 0 24 3 3 0 1 0 8 0 nd6 48 114 0 89 1 0 1 1 0 8 0 kcovpl 48 35 0 27 1 0 1 1 0 8 0 art_heap8 4096 1 0 0 1 0 1 1 0 8 0 art_heap4 256 1685 0 1224 31 2 29 30 0 8 0 art_table 32 1686 0 1224 4 0 4 4 0 8 0 art_node 16 418 0 317 1 0 1 1 0 8 0 semapl 112 2876 0 2866 1 0 1 1 0 8 0 shmpl 112 139 0 11 4 0 4 4 0 8 0 dirhash 1024 17 0 0 3 0 3 3 0 8 0 dino2pl 256 19223 0 17765 92 0 92 92 0 8 0 ffsino 272 19223 0 17765 98 0 98 98 0 8 0 nchpl 144 36343 0 34707 63 0 63 63 0 8 0 uvmvnodes 80 5926 0 0 121 0 121 121 0 8 0 vnodes 224 5926 0 0 349 0 349 349 0 8 0 namei 1024 126557 0 126557 9 8 1 2 0 8 1 percpumem 16 67 0 27 1 0 1 1 0 8 0 kstatmem 264 76 0 54 2 0 2 2 0 8 0 scxspl 216 127565 0 127565 45 44 1 8 0 8 1 plimitpl 152 2848 0 2826 5 4 1 2 0 8 0 sigapl 424 12169 0 12118 7 0 7 7 0 8 0 futexpl 64 113481 0 113477 7 6 1 1 0 8 0 knotepl 120 723 0 0 11 1 10 11 0 8 0 kqueuepl 224 3929 0 3921 65 64 1 9 0 8 0 pipepl 336 3077 0 3049 79 76 3 13 0 8 0 fdescpl 496 12151 0 12119 7 2 5 6 0 8 0 filepl 152 90693 0 90451 171 156 15 22 0 8 5 lockfpl 104 5437 0 5433 3 2 1 2 0 8 0 lockfspl 48 2396 0 2392 1 0 1 1 0 8 0 sessionpl 144 50 0 34 1 0 1 1 0 8 0 pgrppl 48 225 0 209 1 0 1 1 0 8 0 ucredpl 104 16213 0 16195 1 0 1 1 0 8 0 zombiepl 144 12119 0 12118 1 0 1 1 0 8 0 processpl 1064 12169 0 12118 4 0 4 4 0 8 0 procpl 672 35697 0 35628 32 24 8 8 0 8 1 sosppl 168 142 0 142 15 15 0 1 0 8 0 sockpl 504 25205 0 25177 527 515 12 37 0 8 8 mcl64k 65536 38 0 0 3 0 3 3 0 8 0 mcl16k 16384 27 0 0 3 1 2 3 0 8 0 mcl12k 12288 25 0 0 2 0 2 2 0 8 0 mcl9k 9216 25 0 0 2 0 2 2 0 8 0 mcl8k 8192 69 0 0 7 4 3 3 0 8 0 mcl4k 4096 54 0 0 4 2 2 3 0 8 0 mcl2k2 2112 10 0 0 1 0 1 1 0 8 0 mcl2k 2048 292 0 0 19 1 18 19 0 8 0 mtagpl 96 2 0 0 1 0 1 1 0 8 0 mbufpl 256 991 0 0 36 2 34 35 0 8 0 bufpl 288 26618 0 20291 453 0 453 453 0 8 0 anonpl 24 2650256 0 2637225 277 168 109 121 0 186 3 amapchunkpl 152 223893 0 223276 152 120 32 40 0 158 3 amappl16 200 45318 0 44936 201 170 31 35 0 8 8 amappl15 192 2424 0 2421 1 0 1 1 0 8 0 amappl14 184 1702 0 1691 1 0 1 1 0 8 0 amappl13 176 2206 0 2203 1 0 1 1 0 8 0 amappl12 168 30 0 23 1 0 1 1 0 8 0 amappl11 160 1478 0 1461 1 0 1 1 0 8 0 amappl10 152 2585 0 2579 1 0 1 1 0 8 0 amappl9 144 2114 0 2112 1 0 1 1 0 8 0 amappl8 136 2816 0 2707 5 1 4 4 0 8 0 amappl7 128 1899 0 1881 1 0 1 1 0 8 0 amappl6 120 1919 0 1901 2 1 1 2 0 8 0 amappl5 112 10311 0 10294 1 0 1 1 0 8 0 amappl4 104 5574 0 5545 2 0 2 2 0 8 0 amappl3 96 39076 0 39022 2 0 2 2 0 8 0 amappl2 88 14903 0 14833 3 1 2 3 0 8 0 amappl1 80 292497 0 291832 27 10 17 19 0 8 0 amappl 88 72429 0 72247 6 1 5 5 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 141 0 11 3 0 3 3 0 8 0 uaddrrnd 24 12151 0 12119 1 0 1 1 0 8 0 uaddrbest 32 2 0 0 1 0 1 1 0 8 0 uaddr 24 12151 0 12119 1 0 1 1 0 8 0 vmmpekpl 168 98847 0 98780 4 0 4 4 0 8 0 vmmpepl 168 1220518 0 1217978 291 149 142 142 0 357 14 vmsppl 368 12150 0 12119 4 0 4 4 0 8 0 rwobjpl 56 314273 0 306821 124 14 110 110 0 8 1 pdppl 4096 24309 0 24238 447 366 81 91 0 8 10 pvpl 32 5078815 0 5060388 619 424 195 255 0 265 17 pmappl 248 12150 0 12119 4 1 3 3 0 8 0 extentpl 40 58 0 38 1 0 1 1 0 8 0 phpool 112 1973 0 1131 26 0 26 26 0 8 0 ddb{1}> machine ddbcpu 0 Stopped at x86_ipi_db+0x1a: addq $0x8,%rsp x86_ipi_db(ffffffff82925ff0) at x86_ipi_db+0x1a sys/arch/amd64/amd64/db_interface.c:393 x86_ipi_handler() at x86_ipi_handler+0xb7 sys/arch/amd64/amd64/ipi.c:106 Xresume_lapic_ipi() at Xresume_lapic_ipi+0x23 __mp_lock(ffffffff829fb820) at __mp_lock+0x12e __mp_lock_spin sys/kern/kern_lock.c:116 [inline] __mp_lock(ffffffff829fb820) at __mp_lock+0x12e sys/kern/kern_lock.c:147 __mp_acquire_count(ffffffff829fb820,1) at __mp_acquire_count+0x48 sys/kern/kern_lock.c:227 mi_switch() at mi_switch+0x3bb sys/kern/sched_bsd.c:416 sleep_finish(ffff8000211f5778,1) at sleep_finish+0x180 sys/kern/kern_synch.c:420 softclock_thread(ffff8000211e9500) at softclock_thread+0xd9 sys/kern/kern_timeout.c:797 end trace frame: 0x0, count: 7 ddb{0}> trace x86_ipi_db(ffffffff82925ff0) at x86_ipi_db+0x1a sys/arch/amd64/amd64/db_interface.c:393 x86_ipi_handler() at x86_ipi_handler+0xb7 sys/arch/amd64/amd64/ipi.c:106 Xresume_lapic_ipi() at Xresume_lapic_ipi+0x23 __mp_lock(ffffffff829fb820) at __mp_lock+0x12e __mp_lock_spin sys/kern/kern_lock.c:116 [inline] __mp_lock(ffffffff829fb820) at __mp_lock+0x12e sys/kern/kern_lock.c:147 __mp_acquire_count(ffffffff829fb820,1) at __mp_acquire_count+0x48 sys/kern/kern_lock.c:227 mi_switch() at mi_switch+0x3bb sys/kern/sched_bsd.c:416 sleep_finish(ffff8000211f5778,1) at sleep_finish+0x180 sys/kern/kern_synch.c:420 softclock_thread(ffff8000211e9500) at softclock_thread+0xd9 sys/kern/kern_timeout.c:797 end trace frame: 0x0, count: -8 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:437 panic(ffffffff82595df3) at panic+0x177 sys/kern/subr_prf.c:202 witness_warn(2,0,ffffffff8262507e) at witness_warn+0x65e witness_debugger sys/kern/subr_witness.c:2505 [inline] witness_warn(2,0,ffffffff8262507e) at witness_warn+0x65e sys/kern/subr_witness.c:1473 userret(ffff8000fffec548) at userret+0x265 sys/kern/kern_sig.c:2012 syscall(ffff80002e524930) at syscall+0x57e mi_syscall_return sys/sys/syscall_mi.h:128 [inline] syscall(ffff80002e524930) at syscall+0x57e sys/arch/amd64/amd64/trap.c:607 Xsyscall() at Xsyscall+0x128 end of kernel end trace frame: 0xdfbaaf2bab0, count: 9 ddb{1}> trace db_enter() at db_enter+0x18 sys/arch/amd64/amd64/db_interface.c:437 panic(ffffffff82595df3) at panic+0x177 sys/kern/subr_prf.c:202 witness_warn(2,0,ffffffff8262507e) at witness_warn+0x65e witness_debugger sys/kern/subr_witness.c:2505 [inline] witness_warn(2,0,ffffffff8262507e) at witness_warn+0x65e sys/kern/subr_witness.c:1473 userret(ffff8000fffec548) at userret+0x265 sys/kern/kern_sig.c:2012 syscall(ffff80002e524930) at syscall+0x57e mi_syscall_return sys/sys/syscall_mi.h:128 [inline] syscall(ffff80002e524930) at syscall+0x57e sys/arch/amd64/amd64/trap.c:607 Xsyscall() at Xsyscall+0x128 end of kernel end trace frame: 0xdfbaaf2bab0, count: -6