assert "pg->wire_count == 1" failed in vfs_biomem.c (2)

0 views
Skip to first unread message

syzbot

unread,
May 3, 2020, 1:03:12 AM5/3/20
to syzkaller-o...@googlegroups.com
Hello,

syzbot found the following crash on:

HEAD commit: 3207ab99 Repair the description of "edh [params (none|auto..
git tree: openbsd
console output: https://syzkaller.appspot.com/x/log.txt?x=11237d40100000
kernel config: https://syzkaller.appspot.com/x/.config?x=fe55924c11e64b0a
dashboard link: https://syzkaller.appspot.com/bug?extid=3ed893b5fcbcae9ca5c6

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+3ed893...@syzkaller.appspotmail.com

panic: kernel diagnostic assertion "pg->wire_count == 1" failed: file "/syzkaller/managers/main/kernel/sys/kern/vfs_biomem.c", line 310
Stopped at db_enter+0x18: addq $0x8,%rsp
TID PID UID PRFLAGS PFLAGS CPU COMMAND
*153402 22101 0 0 0x4000000 0 syz-executor.1
db_enter() at db_enter+0x18 sys/arch/amd64/amd64/db_interface.c:398
panic(ffffffff821d89d6) at panic+0x15c sys/kern/subr_prf.c:207
__assert(ffffffff8222f710,ffffffff82241581,136,ffffffff8220a028) at __assert+0x2b sys/kern/subr_prf.c:154
buf_free_pages(fffffd8053915258) at buf_free_pages+0x1d3 sys/kern/vfs_biomem.c:299
buf_dealloc_mem(fffffd8053915258) at buf_dealloc_mem+0xe1 sys/kern/vfs_biomem.c:179
buf_put(fffffd8053915258) at buf_put+0x16b sys/kern/vfs_bio.c:131
brelse(fffffd8053915258) at brelse+0x27d sys/kern/vfs_bio.c:948
vinvalbuf(fffffd80568efde8,2,ffffffffffffffff,ffff80001d7399c8,0,ffffffffffffffff) at vinvalbuf+0x3b1 sys/kern/vfs_subr.c:1981
ffs_truncate(fffffd80577c3008,0,0,ffffffffffffffff) at ffs_truncate+0xeb1 sys/ufs/ffs/ffs_inode.c:326
ufs_inactive(ffff80001d8209e8) at ufs_inactive+0x155 sys/ufs/ufs/ufs_inode.c:84
VOP_INACTIVE(fffffd80568efde8,ffff80001d7399c8) at VOP_INACTIVE+0xaa sys/kern/vfs_vops.c:573
vrele(fffffd80568efde8) at vrele+0xca sys/kern/vfs_subr.c:816
ktrsettrace(ffff8000ffffae70,a0000026,fffffd805848b500,fffffd806c3bfba0) at ktrsettrace+0xb3 sys/kern/kern_ktrace.c:124
ktrops(ffff80001d7399c8,ffff8000ffffae70,0,a0000026,fffffd805848b500,fffffd806c3bfba0) at ktrops+0x1a1 sys/kern/kern_ktrace.c:544
end trace frame: 0xffff80001d820c50, 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>
ddb> set $lines = 0
ddb> set $maxwidth = 0
ddb> show panic
kernel diagnostic assertion "pg->wire_count == 1" failed: file "/syzkaller/managers/main/kernel/sys/kern/vfs_biomem.c", line 310
ddb> trace
db_enter() at db_enter+0x18 sys/arch/amd64/amd64/db_interface.c:398
panic(ffffffff821d89d6) at panic+0x15c sys/kern/subr_prf.c:207
__assert(ffffffff8222f710,ffffffff82241581,136,ffffffff8220a028) at __assert+0x2b sys/kern/subr_prf.c:154
buf_free_pages(fffffd8053915258) at buf_free_pages+0x1d3 sys/kern/vfs_biomem.c:299
buf_dealloc_mem(fffffd8053915258) at buf_dealloc_mem+0xe1 sys/kern/vfs_biomem.c:179
buf_put(fffffd8053915258) at buf_put+0x16b sys/kern/vfs_bio.c:131
brelse(fffffd8053915258) at brelse+0x27d sys/kern/vfs_bio.c:948
vinvalbuf(fffffd80568efde8,2,ffffffffffffffff,ffff80001d7399c8,0,ffffffffffffffff) at vinvalbuf+0x3b1 sys/kern/vfs_subr.c:1981
ffs_truncate(fffffd80577c3008,0,0,ffffffffffffffff) at ffs_truncate+0xeb1 sys/ufs/ffs/ffs_inode.c:326
ufs_inactive(ffff80001d8209e8) at ufs_inactive+0x155 sys/ufs/ufs/ufs_inode.c:84
VOP_INACTIVE(fffffd80568efde8,ffff80001d7399c8) at VOP_INACTIVE+0xaa sys/kern/vfs_vops.c:573
vrele(fffffd80568efde8) at vrele+0xca sys/kern/vfs_subr.c:816
ktrsettrace(ffff8000ffffae70,a0000026,fffffd805848b500,fffffd806c3bfba0) at ktrsettrace+0xb3 sys/kern/kern_ktrace.c:124
ktrops(ffff80001d7399c8,ffff8000ffffae70,0,a0000026,fffffd805848b500,fffffd806c3bfba0) at ktrops+0x1a1 sys/kern/kern_ktrace.c:544
doktrace(fffffd805848b500,4,20000026,0,ffff80001d7399c8) at doktrace+0x60d ktrsetchildren sys/kern/kern_ktrace.c:566 [inline]
doktrace(fffffd805848b500,4,20000026,0,ffff80001d7399c8) at doktrace+0x60d sys/kern/kern_ktrace.c:488
sys_ktrace(ffff80001d7399c8,ffff80001d820da8,ffff80001d820df0) at sys_ktrace+0xd5 sys/kern/kern_ktrace.c:529
syscall(ffff80001d820e70) at syscall+0x507 sys/arch/amd64/amd64/trap.c:570
Xsyscall() at Xsyscall+0x128
end of kernel
end trace frame: 0x74f97b25a60, count: -18
ddb> show registers
rdi 0xffffffff81dc5507 db_enter+0x17
rsi 0x2e096 acpi_pdirpa+0x19efe
rbp 0xffff80001d8204e0
rbx 0xffff80001d820590
rdx 0x2e097 acpi_pdirpa+0x19eff
rcx 0xffff800020a29000
rax 0xffff800020a29000
r8 0xffff80001d8204a0
r9 0x1
r10 0xffff800000a295c0
r11 0xfea6cdb031eaf8c8
r12 0x3000000008
r13 0xffff80001d8204f0
r14 0x100
r15 0x1
rip 0xffffffff81dc5508 db_enter+0x18
cs 0x8
rflags 0x246
rsp 0xffff80001d8204d0
ss 0x10
db_enter+0x18: addq $0x8,%rsp
ddb> show proc
PROC (syz-executor.1) pid=153402 stat=onproc
flags process=0 proc=4000000<THREAD>
pri=17, usrpri=81, nice=20
forw=0xffffffffffffffff, list=0xffff80001d73a868,0xffffffff825ad0d8
process=0xffff8000ffffaad8 user=0xffff80001d81b000, vmspace=0xfffffd806bc0add0
estcpu=36, cpticks=1, pctcpu=0.0
user=0, sys=1, intr=0
ddb> ps
PID TID PPID UID S FLAGS WAIT COMMAND
22101 147968 1309 0 2 0 syz-executor.1
*22101 153402 1309 0 7 0x4000000 syz-executor.1
1309 113925 98315 0 3 0x82 nanosleep syz-executor.1
55091 294018 0 0 3 0x14200 bored sosplice
8642 7882 98315 0 3 0x82 piperd syz-executor.0
98315 74594 93466 0 2 0x2 syz-fuzzer
98315 73707 93466 0 3 0x4000082 nanosleep syz-fuzzer
98315 290415 93466 0 3 0x4000082 thrsleep syz-fuzzer
98315 293662 93466 0 3 0x4000082 thrsleep syz-fuzzer
98315 274084 93466 0 3 0x4000082 thrsleep syz-fuzzer
98315 236821 93466 0 3 0x4000082 thrsleep syz-fuzzer
98315 347910 93466 0 3 0x4000082 thrsleep syz-fuzzer
93466 257543 32590 0 3 0x10008a pause ksh
32590 360108 35081 0 3 0x92 select sshd
45046 233080 1 0 3 0x100083 ttyin getty
35081 235201 1 0 3 0x80 select sshd
49530 318518 20486 73 3 0x100090 kqread syslogd
20486 55453 1 0 3 0x100082 netio syslogd
34358 37933 1 77 3 0x100090 poll dhclient
30227 72479 1 0 3 0x80 poll dhclient
44383 38822 0 0 3 0x14200 bored smr
44595 376268 0 0 2 0x14200 zerothread
831 60563 0 0 3 0x14200 aiodoned aiodoned
78680 269481 0 0 3 0x14200 syncer update
61768 123060 0 0 3 0x14200 cleaner cleaner
73780 280983 0 0 3 0x14200 reaper reaper
16047 285287 0 0 3 0x14200 pgdaemon pagedaemon
41016 36709 0 0 3 0x14200 bored crynlk
14247 179269 0 0 3 0x14200 bored crypto
33441 122867 0 0 3 0x40014200 acpi0 acpi0
10808 244814 0 0 3 0x14200 bored softnet
46386 167197 0 0 3 0x14200 bored systqmp
53187 224632 0 0 3 0x14200 bored systq
2089 109581 0 0 3 0x40014200 bored softclock
6236 2324 0 0 3 0x40014200 idle0
1 406451 0 0 3 0x82 wait init
0 0 -1 0 3 0x10200 scheduler swapper
ddb> show all locks
No such command
ddb> show malloc
Type InUse MemUse HighUse Limit Requests Type Lim
devbuf 9520 6358K 7948K 78643K 14155 0
pcb 13 8K 8K 78643K 89 0
rtable 111 11K 12K 78643K 344 0
ifaddr 86 16K 17K 78643K 127 0
counters 21 16K 16K 78643K 28 0
ioctlops 0 0K 2K 78643K 56 0
iov 0 0K 12K 78643K 115 0
mount 1 1K 1K 78643K 1 0
vnodes 1219 77K 77K 78643K 2402 0
UFS quota 1 32K 32K 78643K 1 0
UFS mount 5 36K 36K 78643K 5 0
shm 2 1K 5K 78643K 8 0
VM map 2 0K 0K 78643K 2 0
sem 12 0K 1K 78643K 112 0
dirhash 12 2K 2K 78643K 12 0
ACPI 1794 195K 288K 78643K 12646 0
file desc 5 13K 25K 78643K 682 0
sigio 0 0K 0K 78643K 8 0
proc 53 39K 55K 78643K 456 0
subproc 32 2K 2K 78643K 51 0
NFS srvsock 1 0K 0K 78643K 1 0
NFS daemon 1 16K 16K 78643K 1 0
ip_moptions 0 0K 0K 78643K 44 0
in_multi 65 3K 3K 78643K 125 0
ether_multi 1 0K 0K 78643K 18 0
ISOFS mount 1 32K 32K 78643K 1 0
MSDOSFS mount 1 16K 16K 78643K 1 0
ttys 55 254K 254K 78643K 55 0
exec 0 0K 1K 78643K 238 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 133 39K 55K 78643K 2371 0
UVM aobj 50 6K 6K 78643K 56 0
memdesc 1 4K 4K 78643K 1 0
crypto data 1 1K 1K 78643K 1 0
ip6_options 0 0K 0K 78643K 100 0
NDP 14 0K 0K 78643K 27 0
temp 109 3035K 3099K 78643K 39878 0
kqueue 3 4K 12K 78643K 29 0
SYN cache 2 16K 16K 78643K 2 0
ddb> show all pools
Name Size Requests Fail Releases Pgreq Pgrel Npage Hiwat Minpg Maxpg Idle
arp 64 10 0 4 1 0 1 1 0 8 0
rtpcb 80 56 0 54 1 0 1 1 0 8 0
rtentry 112 64 0 20 2 0 2 2 0 8 0
unpcb 120 430 0 422 1 0 1 1 0 8 0
syncache 264 9 0 9 4 4 0 1 0 8 0
tcpqe 32 24 0 24 1 1 0 1 0 8 0
tcpcb 544 195 0 191 2 1 1 2 0 8 0
ipq 40 1 0 1 1 1 0 1 0 8 0
ipqe 40 4 0 4 1 1 0 1 0 8 0
inpcb 280 638 0 631 4 3 1 2 0 8 0
nd6 48 11 0 5 1 0 1 1 0 8 0
ppxss 1128 1 0 1 1 1 0 1 0 8 0
art_heap8 4096 1 0 0 1 0 1 1 0 8 0
art_heap4 256 245 0 56 15 3 12 13 0 8 0
art_table 32 246 0 56 2 0 2 2 0 8 0
art_node 16 63 0 23 1 0 1 1 0 8 0
sysvmsgpl 40 32 0 24 3 2 1 1 0 8 0
semapl 112 110 0 100 1 0 1 1 0 8 0
shmpl 112 54 0 6 2 0 2 2 0 8 0
dirhash 1024 17 0 0 3 0 3 3 0 8 0
dino2pl 256 2251 0 858 88 0 88 88 0 8 0
ffsino 240 2251 0 858 83 0 83 83 0 8 0
nchpl 144 3338 0 1749 60 0 60 60 0 8 0
uvmvnodes 72 3413 0 0 63 0 63 63 0 8 0
vnodes 208 3413 0 0 180 0 180 180 0 8 0
namei 1024 9467 0 9467 3 2 1 1 0 8 1
vcpupl 1984 1 0 0 1 0 1 1 0 8 0
vmpool 528 3 0 2 2 1 1 1 0 8 0
scxspl 192 27801 0 27801 1 0 1 1 0 8 1
plimitpl 152 38 0 31 1 0 1 1 0 8 0
sigapl 424 866 0 837 4 0 4 4 0 8 0
futexpl 56 13229 0 13229 2 1 1 1 0 8 1
knotepl 112 108 0 89 1 0 1 1 0 8 0
kqueuepl 144 80 0 78 1 0 1 1 0 8 0
pipelkpl 16 545 0 535 1 0 1 1 0 8 0
pipepl 120 1090 0 1071 1 0 1 1 0 8 0
fdescpl 432 851 0 837 2 0 2 2 0 8 0
filepl 120 5765 0 5669 5 1 4 4 0 8 1
lockfpl 104 138 0 137 1 0 1 1 0 8 0
lockfspl 48 59 0 58 1 0 1 1 0 8 0
sessionpl 112 18 0 8 1 0 1 1 0 8 0
pgrppl 48 48 0 38 1 0 1 1 0 8 0
ucredpl 96 276 0 269 1 0 1 1 0 8 0
zombiepl 144 837 0 837 2 1 1 1 0 8 1
processpl 920 866 0 837 4 0 4 4 0 8 0
procpl 624 1592 0 1556 7 4 3 4 0 8 0
sosppl 128 15 0 15 5 4 1 1 0 8 1
sockpl 400 1127 0 1110 7 4 3 5 0 8 1
mcl64k 65536 60 0 60 9 9 0 1 0 8 0
mcl16k 16384 10 0 10 4 3 1 1 0 8 1
mcl12k 12288 15 0 15 4 4 0 1 0 8 0
mcl9k 9216 6 0 6 4 4 0 1 0 8 0
mcl8k 8192 12 0 12 9 9 0 1 0 8 0
mcl4k 4096 40 0 40 9 8 1 1 0 8 1
mcl2k2 2112 9 0 9 8 8 0 1 0 8 0
mcl2k 2048 63318 0 63274 16 10 6 12 0 8 0
mtagpl 80 37 0 13 2 1 1 1 0 8 0
mbufpl 256 104462 0 104318 18 7 11 15 0 8 0
bufpl 280 6611 0 1250 384 0 384 384 0 8 0
anonpl 16 93188 0 76616 85 6 79 83 0 107 0
amapchunkpl 152 5008 0 4864 46 33 13 20 0 158 6
amappl16 192 3957 0 2900 59 5 54 55 0 8 1
amappl15 184 388 0 384 1 0 1 1 0 8 0
amappl14 176 27 0 22 1 0 1 1 0 8 0
amappl13 168 30 0 28 1 0 1 1 0 8 0
amappl12 160 8 0 6 2 1 1 1 0 8 0
amappl11 152 295 0 286 1 0 1 1 0 8 0
amappl10 144 20 0 14 1 0 1 1 0 8 0
amappl9 136 366 0 365 1 0 1 1 0 8 0
amappl8 128 351 0 312 2 0 2 2 0 8 0
amappl7 120 112 0 100 1 0 1 1 0 8 0
amappl6 112 275 0 268 1 0 1 1 0 8 0
amappl5 104 542 0 531 1 0 1 1 0 8 0
amappl4 96 691 0 662 1 0 1 1 0 8 0
amappl3 88 113 0 107 1 0 1 1 0 8 0
amappl2 80 6302 0 6234 2 0 2 2 0 8 0
amappl1 72 23971 0 23562 23 14 9 17 0 8 0
amappl 80 1849 0 1802 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 55 0 6 1 0 1 1 0 8 0
uaddrrnd 24 854 0 839 1 0 1 1 0 8 0
uaddrbest 32 2 0 0 1 0 1 1 0 8 0
uaddr 24 854 0 839 1 0 1 1 0 8 0
vmmpekpl 168 10468 0 10441 2 0 2 2 0 8 0
vmmpepl 168 104832 0 102695 154 59 95 136 0 357 0
vmsppl 272 853 0 839 2 1 1 2 0 8 0
pdppl 4096 1714 0 1679 6 1 5 6 0 8 0
pvpl 32 305380 0 285775 304 122 182 303 0 265 0
pmappl 200 853 0 839 1 0 1 1 0 8 0
extentpl 40 46 0 29 1 0 1 1 0 8 0
phpool 112 284 0 64 7 0 7 7 0 8 0
ddb> machine ddbcpu 0
No such command
ddb> trace
db_enter() at db_enter+0x18 sys/arch/amd64/amd64/db_interface.c:398
panic(ffffffff821d89d6) at panic+0x15c sys/kern/subr_prf.c:207
__assert(ffffffff8222f710,ffffffff82241581,136,ffffffff8220a028) at __assert+0x2b sys/kern/subr_prf.c:154
buf_free_pages(fffffd8053915258) at buf_free_pages+0x1d3 sys/kern/vfs_biomem.c:299
buf_dealloc_mem(fffffd8053915258) at buf_dealloc_mem+0xe1 sys/kern/vfs_biomem.c:179
buf_put(fffffd8053915258) at buf_put+0x16b sys/kern/vfs_bio.c:131
brelse(fffffd8053915258) at brelse+0x27d sys/kern/vfs_bio.c:948
vinvalbuf(fffffd80568efde8,2,ffffffffffffffff,ffff80001d7399c8,0,ffffffffffffffff) at vinvalbuf+0x3b1 sys/kern/vfs_subr.c:1981
ffs_truncate(fffffd80577c3008,0,0,ffffffffffffffff) at ffs_truncate+0xeb1 sys/ufs/ffs/ffs_inode.c:326
ufs_inactive(ffff80001d8209e8) at ufs_inactive+0x155 sys/ufs/ufs/ufs_inode.c:84
VOP_INACTIVE(fffffd80568efde8,ffff80001d7399c8) at VOP_INACTIVE+0xaa sys/kern/vfs_vops.c:573
vrele(fffffd80568efde8) at vrele+0xca sys/kern/vfs_subr.c:816
ktrsettrace(ffff8000ffffae70,a0000026,fffffd805848b500,fffffd806c3bfba0) at ktrsettrace+0xb3 sys/kern/kern_ktrace.c:124
ktrops(ffff80001d7399c8,ffff8000ffffae70,0,a0000026,fffffd805848b500,fffffd806c3bfba0) at ktrops+0x1a1 sys/kern/kern_ktrace.c:544
doktrace(fffffd805848b500,4,20000026,0,ffff80001d7399c8) at doktrace+0x60d ktrsetchildren sys/kern/kern_ktrace.c:566 [inline]
doktrace(fffffd805848b500,4,20000026,0,ffff80001d7399c8) at doktrace+0x60d sys/kern/kern_ktrace.c:488
sys_ktrace(ffff80001d7399c8,ffff80001d820da8,ffff80001d820df0) at sys_ktrace+0xd5 sys/kern/kern_ktrace.c:529
syscall(ffff80001d820e70) at syscall+0x507 sys/arch/amd64/amd64/trap.c:570
Xsyscall() at Xsyscall+0x128
end of kernel
end trace frame: 0x74f97b25a60, count: -18
ddb> machine ddbcpu 1
No such command
ddb> trace
db_enter() at db_enter+0x18 sys/arch/amd64/amd64/db_interface.c:398
panic(ffffffff821d89d6) at panic+0x15c sys/kern/subr_prf.c:207
__assert(ffffffff8222f710,ffffffff82241581,136,ffffffff8220a028) at __assert+0x2b sys/kern/subr_prf.c:154
buf_free_pages(fffffd8053915258) at buf_free_pages+0x1d3 sys/kern/vfs_biomem.c:299
buf_dealloc_mem(fffffd8053915258) at buf_dealloc_mem+0xe1 sys/kern/vfs_biomem.c:179
buf_put(fffffd8053915258) at buf_put+0x16b sys/kern/vfs_bio.c:131
brelse(fffffd8053915258) at brelse+0x27d sys/kern/vfs_bio.c:948
vinvalbuf(fffffd80568efde8,2,ffffffffffffffff,ffff80001d7399c8,0,ffffffffffffffff) at vinvalbuf+0x3b1 sys/kern/vfs_subr.c:1981
ffs_truncate(fffffd80577c3008,0,0,ffffffffffffffff) at ffs_truncate+0xeb1 sys/ufs/ffs/ffs_inode.c:326
ufs_inactive(ffff80001d8209e8) at ufs_inactive+0x155 sys/ufs/ufs/ufs_inode.c:84
VOP_INACTIVE(fffffd80568efde8,ffff80001d7399c8) at VOP_INACTIVE+0xaa sys/kern/vfs_vops.c:573
vrele(fffffd80568efde8) at vrele+0xca sys/kern/vfs_subr.c:816
ktrsettrace(ffff8000ffffae70,a0000026,fffffd805848b500,fffffd806c3bfba0) at ktrsettrace+0xb3 sys/kern/kern_ktrace.c:124
ktrops(ffff80001d7399c8,ffff8000ffffae70,0,a0000026,fffffd805848b500,fffffd806c3bfba0) at ktrops+0x1a1 sys/kern/kern_ktrace.c:544
doktrace(fffffd805848b500,4,20000026,0,ffff80001d7399c8) at doktrace+0x60d ktrsetchildren sys/kern/kern_ktrace.c:566 [inline]
doktrace(fffffd805848b500,4,20000026,0,ffff80001d7399c8) at doktrace+0x60d sys/kern/kern_ktrace.c:488
sys_ktrace(ffff80001d7399c8,ffff80001d820da8,ffff80001d820df0) at sys_ktrace+0xd5 sys/kern/kern_ktrace.c:529
syscall(ffff80001d820e70) at syscall+0x507 sys/arch/amd64/amd64/trap.c:570
Xsyscall() at Xsyscall+0x128
end of kernel
end trace frame: 0x74f97b25a60, count: -18


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

syzbot

unread,
Oct 8, 2020, 12:30:12 AM10/8/20
to syzkaller-o...@googlegroups.com
Auto-closing this bug as obsolete.
Crashes did not happen for a while, no reproducer and no activity.
Reply all
Reply to author
Forward
0 new messages