panic: pool_cache_item_magicW_AcRhNIeNckG:: mSbPuL fpNOl T cLpOu WEfRrEeDe OlNi stSY mSCoAdLiLfi 1e3d6: -i1t1em12 0a0

0 views
Skip to first unread message

syzbot

unread,
Apr 15, 2020, 4:37:15 PM4/15/20
to syzkaller-o...@googlegroups.com
Hello,

syzbot found the following crash on:

HEAD commit: 20c8eb7c Add bse(4) device to unbreak build.
git tree: openbsd
console output: https://syzkaller.appspot.com/x/log.txt?x=145d02abe00000
kernel config: https://syzkaller.appspot.com/x/.config?x=bf87b6915a88cd0d
dashboard link: https://syzkaller.appspot.com/bug?extid=d8741d8aa208b801c320

Unfortunately, I don't have any reproducer for this crash yet.

IMPORTANT: if you fix the bug, please add the following tag to the commit:
Reported-by: syzbot+d8741d...@syzkaller.appspotmail.com

login: panic: pool_cache_item_magicW_AcRhNIeNckG:: mSbPuL fpNOl T cLpOu WEfRrEeDe OlNi stSY mSCoAdLiLfi 1e3d6: -i1t1em12 0a0d dErX 0ITxf f0 f9ff
d8Stopped at savectx+0xb1: movl $0,%gs:0x530
TID PID UID PRFLAGS PFLAGS CPU COMMAND
*468088 34430 0 0x2 0 0 syz-executor.0
213562 71387 0 0x14000 0x200 1 softnet
savectx() at savectx+0xb1
end of kernel
end trace frame: 0x7f7ffffe4e10, count: 14
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
pool_cache_item_magic_check: mbufpl cpu free list modified: item addr 0xfffffd8070611f00+24 0xc3a78d046d155e89!=0xc3a78d84006ff689
ddb{0}> trace
savectx() at savectx+0xb1
end of kernel
end trace frame: 0x7f7ffffe4e10, count: -1
ddb{0}> show registers
rdi 0
rsi 0
rbp 0xffff800020f6b780
rbx 0
rdx 0xffff800020e6c278
rcx 0
rax 0x39
r8 0xffffffff816473af kprintf+0x16f
r9 0x1
r10 0x25
r11 0x25cbf7e3b51e5dcf
r12 0
r13 0
r14 0xffff800020e6c278
r15 0
rip 0xffffffff821643f1 savectx+0xb1
cs 0x8
rflags 0x46
rsp 0xffff800020f6b700
ss 0x10
savectx+0xb1: movl $0,%gs:0x530
ddb{0}> show proc
PROC (syz-executor.0) pid=468088 stat=onproc
flags process=2<EXEC,8ORPHAN> proc=0
pri=17, usrpri=69, nice=20
forw=0xffffffffffffffff, list=0xffff800020e6dd48,0xffff800020e6d878
process=0xffff800020e80010 user=0xffff800020f66000, vmspace=0xfffffd807f0008a0
estcpu=36, cpticks=1, pctcpu=0.0
user=0, sys=1, intr=0
ddb{0}> ps
PID TID PPID UID S FLAGS WAIT COMMAND
28025 333368 0 0 3 0x14200 bored sosplice
57722 72080 37886 0 3 0x82 nanosleep syz-executor.1
*34430 468088 37886 0 7 0x2 syz-executor.0
37886 193861 49932 0 3 0x82 nanosleep syz-fuzzer
37886 127519 49932 0 3 0x4000082 nanosleep syz-fuzzer
37886 485634 49932 0 3 0x4000082 thrsleep syz-fuzzer
37886 223573 49932 0 3 0x4000082 thrsleep syz-fuzzer
37886 147294 49932 0 3 0x4000082 thrsleep syz-fuzzer
37886 3445 49932 0 3 0x4000082 thrsleep syz-fuzzer
37886 254544 49932 0 3 0x4000082 thrsleep syz-fuzzer
37886 80944 49932 0 3 0x4000082 thrsleep syz-fuzzer
37886 139690 49932 0 3 0x4000082 kqread syz-fuzzer
37886 9410 49932 0 3 0x4000082 thrsleep syz-fuzzer
49932 354158 42823 0 3 0x10008a pause ksh
42823 229080 60580 0 3 0x92 select sshd
46930 254421 1 0 3 0x100083 ttyin getty
60580 402842 1 0 3 0x80 select sshd
35554 88919 32338 74 3 0x100092 bpf pflogd
32338 108105 1 0 3 0x80 netio pflogd
9084 102968 35154 73 3 0x100090 kqread syslogd
35154 269165 1 0 3 0x100082 netio syslogd
58184 222206 1 77 3 0x100090 poll dhclient
69862 274706 1 0 3 0x80 poll dhclient
27561 414782 0 0 3 0x14200 bored smr
9376 390292 0 0 3 0x14200 pgzero zerothread
70507 21507 0 0 3 0x14200 aiodoned aiodoned
14138 446180 0 0 3 0x14200 syncer update
89220 475938 0 0 3 0x14200 cleaner cleaner
10663 186661 0 0 3 0x14200 reaper reaper
15774 383467 0 0 3 0x14200 pgdaemon pagedaemon
13299 487751 0 0 3 0x14200 bored crynlk
49741 223553 0 0 3 0x14200 bored crypto
98926 180192 0 0 3 0x40014200 acpi0 acpi0
42746 180165 0 0 3 0x40014200 idle1
71387 213562 0 0 7 0x14200 softnet
29839 478416 0 0 3 0x14200 bored systqmp
19389 291076 0 0 3 0x14200 bored systq
30873 457588 0 0 3 0x40014200 bored softclock
99580 197124 0 0 3 0x40014200 idle0
1 294683 0 0 3 0x82 wait init
0 0 -1 0 3 0x10200 scheduler swapper
ddb{0}> show all locks
CPU 0:
exclusive mutex &iopl->mtx r = 0 (0xffff800000038170)
#0 witness_lock+0x4c5 sys/kern/subr_witness.c:1164
#1 mtx_enter_try+0x102
#2 mtx_enter+0x4b sys/kern/kern_lock.c:266
#3 scsi_iopool_run+0x131 scsi_ioh_pending sys/scsi/scsi_base.c:405 [inline]
#3 scsi_iopool_run+0x131 sys/scsi/scsi_base.c:420
#4 scsi_xsh_runqueue+0x210 sys/scsi/scsi_base.c:596
#5 scsi_xsh_add+0xc9 sys/scsi/scsi_base.c:535
#6 sdstrategy+0x187 sys/scsi/sd.c:585
#7 spec_strategy+0x74 sys/kern/spec_vnops.c:468
#8 VOP_STRATEGY+0x99 sys/kern/vfs_vops.c:712
#9 bwrite+0x1b9 sys/kern/vfs_bio.c:756
#10 ffs_update+0x2c2 sys/ufs/ffs/ffs_inode.c:113
#11 ufs_mkdir+0x665 sys/ufs/ufs/ufs_vnops.c:1232
#12 VOP_MKDIR+0xc6 sys/kern/vfs_vops.c:450
#13 domkdirat+0x121 sys/kern/vfs_syscalls.c:3051
#14 syscall+0x4a4 mi_syscall sys/sys/syscall_mi.h:102 [inline]
#14 syscall+0x4a4 sys/arch/amd64/amd64/trap.c:570
#15 Xsyscall+0x128
Process 34430 (syz-executor.0) thread 0xffff800020e6c278 (468088)
exclusive kernel_lock &kernel_lock r = 0 (0xffffffff8267b700)
#0 witness_lock+0x4c5 sys/kern/subr_witness.c:1164
#1 __mp_acquire_count+0x51 sys/kern/kern_lock.c:227
#2 mi_switch+0x392 sys/kern/sched_bsd.c:435
#3 sleep_finish+0x113 sys/kern/kern_synch.c:418
#4 sleep_finish_all+0x32 sleep_finish_timeout sys/kern/kern_synch.c:447 [inline]
#4 sleep_finish_all+0x32 sys/kern/kern_synch.c:393
#5 tsleep+0x1cc sys/kern/kern_synch.c:155
#6 biowait+0xa6 sys/kern/vfs_bio.c:1255
#7 bwrite+0x1e4 sys/kern/vfs_bio.c:765
#8 ffs_update+0x2c2 sys/ufs/ffs/ffs_inode.c:113
#9 ufs_mkdir+0x42e sys/ufs/ufs/ufs_vnops.c:1197
#10 VOP_MKDIR+0xc6 sys/kern/vfs_vops.c:450
#11 domkdirat+0x121 sys/kern/vfs_syscalls.c:3051
#12 syscall+0x4a4 mi_syscall sys/sys/syscall_mi.h:102 [inline]
#12 syscall+0x4a4 sys/arch/amd64/amd64/trap.c:570
#13 Xsyscall+0x128
exclusive rrwlock inode r = 0 (0xfffffd80644f0c50)
#0 witness_lock+0x4c5 sys/kern/subr_witness.c:1164
#1 rw_enter+0x453 sys/kern/kern_rwlock.c:311
#2 rrw_enter+0x88 sys/kern/kern_rwlock.c:462
#3 ufs_ihashins+0x45 sys/ufs/ufs/ufs_ihash.c:140
#4 ffs_vget+0x13e sys/ufs/ffs/ffs_vfsops.c:1358
#5 ffs_inode_alloc+0x1cf sys/ufs/ffs/ffs_alloc.c:392
#6 ufs_mkdir+0xf4 sys/ufs/ufs/ufs_vnops.c:1162
#7 VOP_MKDIR+0xc6 sys/kern/vfs_vops.c:450
#8 domkdirat+0x121 sys/kern/vfs_syscalls.c:3051
#9 syscall+0x4a4 mi_syscall sys/sys/syscall_mi.h:102 [inline]
#9 syscall+0x4a4 sys/arch/amd64/amd64/trap.c:570
#10 Xsyscall+0x128
exclusive rrwlock inode r = 0 (0xfffffd806b4451a8)
#0 witness_lock+0x4c5 sys/kern/subr_witness.c:1164
#1 rw_enter+0x453 sys/kern/kern_rwlock.c:311
#2 rrw_enter+0x88 sys/kern/kern_rwlock.c:462
#3 VOP_LOCK+0x4b sys/kern/vfs_vops.c:603
#4 vn_lock+0x81 sys/kern/vfs_vnops.c:575
#5 vfs_lookup+0xe6 sys/kern/vfs_lookup.c:419
#6 namei+0x63c sys/kern/vfs_lookup.c:249
#7 domkdirat+0x75 sys/kern/vfs_syscalls.c:3036
#8 syscall+0x4a4 mi_syscall sys/sys/syscall_mi.h:102 [inline]
#8 syscall+0x4a4 sys/arch/amd64/amd64/trap.c:570
#9 Xsyscall+0x128
exclusive mutex &iopl->mtx r = 0 (0xffff800000038170)
#0 witness_lock+0x4c5 sys/kern/subr_witness.c:1164
#1 mtx_enter_try+0x102
#2 mtx_enter+0x4b sys/kern/kern_lock.c:266
#3 scsi_iopool_run+0x131 scsi_ioh_pending sys/scsi/scsi_base.c:405 [inline]
#3 scsi_iopool_run+0x131 sys/scsi/scsi_base.c:420
#4 scsi_xsh_runqueue+0x210 sys/scsi/scsi_base.c:596
#5 scsi_xsh_add+0xc9 sys/scsi/scsi_base.c:535
#6 sdstrategy+0x187 sys/scsi/sd.c:585
#7 spec_strategy+0x74 sys/kern/spec_vnops.c:468
#8 VOP_STRATEGY+0x99 sys/kern/vfs_vops.c:712
#9 bwrite+0x1b9 sys/kern/vfs_bio.c:756
#10 ffs_update+0x2c2 sys/ufs/ffs/ffs_inode.c:113
#11 ufs_mkdir+0x665 sys/ufs/ufs/ufs_vnops.c:1232
#12 VOP_MKDIR+0xc6 sys/kern/vfs_vops.c:450
#13 domkdirat+0x121 sys/kern/vfs_syscalls.c:3051
#14 syscall+0x4a4 mi_syscall sys/sys/syscall_mi.h:102 [inline]
#14 syscall+0x4a4 sys/arch/amd64/amd64/trap.c:570
#15 Xsyscall+0x128
Process 71387 (softnet) thread 0xffff800020e18270 (213562)
exclusive rwlock netlock r = 0 (0xffffffff82499d58)
#0 witness_lock+0x4c5 sys/kern/subr_witness.c:1164
#1 if_input_process+0x84 sys/net/if.c:941
#2 ifiq_process+0x80 sys/net/ifq.c:646
#3 taskq_thread+0x9c sys/kern/kern_task.c:369
#4 proc_trampoline+0x1c
shared rwlock softnet r = 0 (0xffff80000002b0e0)
#0 witness_lock+0x4c5 sys/kern/subr_witness.c:1164
#1 taskq_thread+0x8f sys/kern/kern_task.c:368
#2 proc_trampoline+0x1c
ddb{0}> show malloc
Type InUse MemUse HighUse Limit Requests Type Lim
devbuf 9494 6403K 6985K 78643K 10924 0
pcb 13 8K 8K 78643K 25 0
rtable 105 3K 3K 78643K 247 0
ifaddr 59 12K 13K 78643K 86 0
counters 43 33K 34K 78643K 53 0
ioctlops 0 0K 4K 78643K 1470 0
iov 0 0K 16K 78643K 26 0
mount 1 1K 1K 78643K 1 0
vnodes 1222 77K 77K 78643K 1316 0
UFS quota 1 32K 32K 78643K 1 0
UFS mount 5 36K 36K 78643K 5 0
shm 2 1K 5K 78643K 4 0
VM map 2 1K 1K 78643K 2 0
sem 10 0K 0K 78643K 10 0
dirhash 12 2K 2K 78643K 12 0
ACPI 1809 196K 290K 78643K 12766 0
file desc 4 9K 25K 78643K 101 0
sigio 0 0K 0K 78643K 2 0
proc 61 63K 95K 78643K 440 0
subproc 32 2K 2K 78643K 34 0
NFS srvsock 1 0K 0K 78643K 1 0
NFS daemon 1 16K 16K 78643K 1 0
ip_moptions 0 0K 0K 78643K 12 0
in_multi 41 2K 2K 78643K 44 0
ether_multi 1 0K 0K 78643K 2 0
ISOFS mount 1 32K 32K 78643K 1 0
MSDOSFS mount 1 16K 16K 78643K 1 0
ttys 31 148K 148K 78643K 31 0
exec 0 0K 1K 78643K 211 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 91 21K 21K 78643K 1251 0
UVM aobj 7 2K 2K 78643K 7 0
memdesc 1 4K 4K 78643K 1 0
crypto data 1 1K 1K 78643K 1 0
ip6_options 0 0K 0K 78643K 8 0
NDP 9 0K 0K 78643K 18 0
temp 82 3036K 3101K 78643K 4787 0
kqueue 3 4K 8K 78643K 7 0
SYN cache 2 16K 16K 78643K 2 0
ddb{0}> show all pools
Name Size Requests Fail Releases Pgreq Pgrel Npage Hiwat Minpg Maxpg Idle
arp 64 8 0 1 1 0 1 1 0 8 0
plcache 128 20 0 0 1 0 1 1 0 8 0
rtpcb 80 21 0 19 1 0 1 1 0 8 0
rtentry 112 48 0 4 2 0 2 2 0 8 0
unpcb 120 63 0 53 1 0 1 1 0 8 0
syncache 264 4 0 4 1 1 0 1 0 8 0
tcpcb 544 54 0 50 1 0 1 1 0 8 0
inpcb 280 138 0 131 2 0 2 2 0 8 1
nd6 48 6 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 27 0 0 1 0 1 1 0 8 0
pfstkey 112 27 0 0 1 0 1 1 0 8 0
pfstate 328 27 0 0 3 0 3 3 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 195 0 2 13 0 13 13 0 8 0
art_table 32 196 0 2 2 0 2 2 0 8 0
art_node 16 47 0 8 1 0 1 1 0 8 0
sysvmsgpl 40 6 0 2 1 0 1 1 0 8 0
semapl 112 8 0 0 1 0 1 1 0 8 0
shmpl 112 5 0 0 1 0 1 1 0 8 0
dirhash 1024 17 0 0 3 0 3 3 0 8 0
dino1pl 128 1541 0 135 46 0 46 46 0 8 0
ffsino 272 1541 0 135 95 0 95 95 0 8 0
nchpl 144 1856 0 239 61 0 61 61 0 8 1
uvmvnodes 72 1660 0 0 31 0 31 31 0 8 0
vnodes 208 1660 0 0 88 0 88 88 0 8 0
namei 1024 4831 0 4831 1 0 1 1 0 8 1
percpumem 16 37 0 5 1 0 1 1 0 8 0
vcpupl 1984 1 0 0 1 0 1 1 0 8 0
vmpool 560 1 0 0 1 0 1 1 0 8 0
scxspl 192 5570 0 5570 7 1 6 6 0 8 6
plimitpl 152 17 0 9 1 0 1 1 0 8 0
sigapl 424 317 0 286 4 0 4 4 0 8 0
futexpl 56 1193 0 1193 1 0 1 1 0 8 1
knotepl 112 57 0 38 1 0 1 1 0 8 0
kqueuepl 144 8 0 6 1 0 1 1 0 8 0
pipelkpl 48 102 0 92 1 0 1 1 0 8 0
pipepl 120 204 0 185 1 0 1 1 0 8 0
fdescpl 496 301 0 286 3 0 3 3 0 8 0
filepl 152 1611 0 1511 5 0 5 5 0 8 1
lockfpl 104 31 0 30 1 0 1 1 0 8 0
lockfspl 48 14 0 13 1 0 1 1 0 8 0
sessionpl 112 18 0 7 1 0 1 1 0 8 0
pgrppl 48 18 0 7 1 0 1 1 0 8 0
ucredpl 96 87 0 78 1 0 1 1 0 8 0
zombiepl 144 286 0 285 1 0 1 1 0 8 0
processpl 984 317 0 285 5 0 5 5 0 8 0
procpl 624 498 0 457 4 0 4 4 0 8 0
sosppl 128 8 0 8 1 0 1 1 0 8 1
sockpl 400 223 0 204 3 0 3 3 0 8 1
mcl64k 65536 5 0 0 1 0 1 1 0 8 0
mcl12k 12288 1 0 0 1 0 1 1 0 8 0
mcl8k 8192 1 0 0 1 0 1 1 0 8 0
mcl4k 4096 5 0 0 1 0 1 1 0 8 0
mcl2k 2048 163 0 0 20 0 20 20 0 8 0
mtagpl 80 40 0 0 1 0 1 1 0 8 0
mbufpl 256 175 0 0 11 0 11 11 0 8 0
bufpl 280 4243 0 174 291 0 291 291 0 8 0
anonpl 16 41147 0 27234 59 1 58 58 0 124 0
amapchunkpl 152 1408 0 1282 7 0 7 7 0 158 0
amappl16 192 1144 0 399 39 0 39 39 0 8 1
amappl15 184 78 0 76 2 1 1 1 0 8 0
amappl14 176 1 0 1 1 1 0 1 0 8 0
amappl13 168 30 0 28 1 0 1 1 0 8 0
amappl12 160 39 0 36 1 0 1 1 0 8 0
amappl11 152 84 0 64 2 0 2 2 0 8 1
amappl10 144 20 0 14 1 0 1 1 0 8 0
amappl9 136 381 0 378 1 0 1 1 0 8 0
amappl8 128 301 0 288 1 0 1 1 0 8 0
amappl7 120 120 0 108 1 0 1 1 0 8 0
amappl6 112 27 0 20 1 0 1 1 0 8 0
amappl5 104 248 0 233 1 0 1 1 0 8 0
amappl4 96 500 0 472 1 0 1 1 0 8 0
amappl3 88 112 0 105 1 0 1 1 0 8 0
amappl2 80 1528 0 1466 3 1 2 3 0 8 0
amappl1 72 16618 0 16185 26 13 13 20 0 8 3
amappl 80 753 0 713 2 0 2 2 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 6 0 0 1 0 1 1 0 8 0
uaddrrnd 24 302 0 286 1 0 1 1 0 8 0
uaddrbest 32 2 0 0 1 0 1 1 0 8 0
uaddr 24 302 0 286 1 0 1 1 0 8 0
vmmpekpl 168 6357 0 6324 2 0 2 2 0 8 0
vmmpepl 168 43458 0 41683 107 6 101 101 0 357 18
vmsppl 368 301 0 286 2 0 2 2 0 8 0
pdppl 4096 612 0 573 6 0 6 6 0 8 0
pvpl 32 144243 0 127278 146 0 146 146 0 265 7
pmappl 232 301 0 286 2 0 2 2 0 8 1
extentpl 40 46 0 29 1 0 1 1 0 8 0
phpool 112 167 0 3 5 0 5 5 0 8 0


---
This bug is generated by a bot. It may contain errors.
See https://goo.gl/tpsmEJ for more information about syzbot.
syzbot engineers can be reached at syzk...@googlegroups.com.

syzbot will keep track of this bug report. See:
https://goo.gl/tpsmEJ#status for how to communicate with syzbot.

Greg Steuck

unread,
Apr 15, 2020, 6:35:48 PM4/15/20
to syzbot, syzkaller-o...@googlegroups.com
#syz dup: pool: cpu free list modified: mbufpl
> --
> You received this message because you are subscribed to the Google Groups "syzkaller-openbsd-bugs" group.
> To unsubscribe from this group and stop receiving emails from it, send an email to syzkaller-openbsd...@googlegroups.com.
> To view this discussion on the web visit https://groups.google.com/d/msgid/syzkaller-openbsd-bugs/0000000000000ecc1a05a35a4886%40google.com.



--
nest.cx is Gmail hosted, use PGP: https://pgp.key-server.io/0x0B1542BD8DF5A1B0
Fingerprint: 5E2B 2D0E 1E03 2046 BEC3 4D50 0B15 42BD 8DF5 A1B0
Reply all
Reply to author
Forward
0 new messages