panic: mutex process lock not owned at /syzkaller/managers/i386/kernel/sys/kern/kern_time.c:LINE

5 views
Skip to first unread message

syzbot

unread,
Feb 4, 2020, 1:02:13 PM2/4/20
to syzkaller-f...@googlegroups.com
Hello,

syzbot found the following crash on:

HEAD commit: 618d4923 Regen after r357503.
git tree: freebsd
console output: https://syzkaller.appspot.com/x/log.txt?x=10423511e00000
dashboard link: https://syzkaller.appspot.com/bug?extid=1512c89909091c3b51a4
userspace arch: i386

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+1512c8...@syzkaller.appspotmail.com

panic: mutex process lock not owned at /syzkaller/managers/i386/kernel/sys/kern/kern_time.c:261
cpuid = 0
time = 12447
KDB: stack backtrace:
db_trace_self_wrapper() at db_trace_self_wrapper+0x47/frame 0xfffffe0022d468b0
vpanic() at vpanic+0x1ce/frame 0xfffffe0022d46920
panic() at panic+0x43/frame 0xfffffe0022d46980
__mtx_assert() at __mtx_assert+0x196/frame 0xfffffe0022d469c0
kern_thread_cputime() at kern_thread_cputime+0xaa/frame 0xfffffe0022d46a10
kern_clock_gettime() at kern_clock_gettime+0x277/frame 0xfffffe0022d46a70
freebsd32_clock_gettime() at freebsd32_clock_gettime+0x25/frame 0xfffffe0022d46ab0
ia32_syscall() at ia32_syscall+0x48c/frame 0xfffffe0022d46bf0
int0x80_syscall_common() at int0x80_syscall_common+0x9c/frame 0x8142581
KDB: enter: panic
[ thread pid 17691 tid 100549 ]
Stopped at kdb_enter+0x67: movq $0,0x14669d6(%rip)
db>
db> set $lines = 0
db> set $maxwidth = 0
db> show registers
cs 0x20
ds 0x3b ll+0x1a
es 0x3b ll+0x1a
fs 0x13
gs 0x1b
ss 0
rax 0x12
rcx 0xfffffe0023200000
rdx 0x3ffff
rbx 0
rsp 0xfffffe0022d46890
rbp 0xfffffe0022d468b0
rsi 0x40001
rdi 0xffffffff810ba616 vprintf+0x176
r8 0
r9 0xffffffff
r10 0
r11 0xfffff8000c53fbd0
r12 0xffffffff82068d90 ddb_dbbe
r13 0
r14 0xffffffff81938d3c
r15 0xffffffff81938d3c
rip 0xffffffff810af6c7 kdb_enter+0x67
rflags 0x200086 kernphys+0x86
kdb_enter+0x67: movq $0,0x14669d6(%rip)
db> show proc
Process 17691 (syz-executor.0) at 0xfffff8003ac03a60:
state: NORMAL
uid: 0 gids: 0, 0, 5
parent: pid 768 at 0xfffff8003a64e530
ABI: FreeBSD ELF32
arguments: /root/syz-executor.0
reaper: 0xfffff80003300a60 reapsubtree: 1
sigparent: 20
vmspace: 0xfffff8000c1fc000
(map 0xfffff8000c1fc000)
(map.pmap 0xfffff8000c1fc0c0)
(pmap 0xfffff8000c1fc120)
threads: 2
100972 RunQ syz-executor.0
100549 Run CPU 0 syz-executor.0
db> ps
pid ppid pgrp uid state wmesg wchan cmd
17691 768 768 0 R (threaded) syz-executor.0
100972 RunQ syz-executor.0
100549 Run CPU 0 syz-executor.0
17690 770 770 0 R (threaded) syz-executor.3
101070 Run CPU 1 syz-executor.3
100544 S pipdwt 0xfffff80003d48000 syz-executor.3
17689 769 769 0 S (threaded) syz-executor.1
100466 S nanslp 0xffffffff824feca1 syz-executor.1
100515 S select 0xfffff8003abb2bc0 syz-executor.1
100524 S uwait 0xfffff80003a46300 syz-executor.1
17688 772 772 0 S (threaded) syz-executor.2
100987 S nanslp 0xffffffff824feca1 syz-executor.2
100115 S accept 0xfffff80003e25878 syz-executor.2
100533 S uwait 0xfffff8003a516280 syz-executor.2
2764 1 2764 65 Ss select 0xfffff8000c146940 dhclient
2321 1 2321 0 Ss select 0xfffff80003d55a40 dhclient
2318 1 2318 0 Ss select 0xfffff8003a516d40 dhclient
2299 1 2299 65 Ss select 0xfffff8003a516cc0 dhclient
1832 1 1832 0 Ss select 0xfffff8000c146840 dhclient
1829 1 1829 0 Ss select 0xfffff8000c1468c0 dhclient
1810 1 1810 65 Ss select 0xfffff80003a47ac0 dhclient
1344 1 1344 0 Ss select 0xfffff80003d55940 dhclient
1339 1 1339 0 Ss select 0xfffff80003a45640 dhclient
1319 1 1319 65 Ss select 0xfffff80003a46740 dhclient
818 1 818 0 Ss select 0xfffff80003d52940 dhclient
808 1 808 0 Ss select 0xfffff80003a45cc0 dhclient
772 766 772 0 Ss nanslp 0xffffffff824feca0 syz-executor.2
770 766 770 0 Ss nanslp 0xffffffff824feca0 syz-executor.3
769 766 769 0 Ss nanslp 0xffffffff824feca1 syz-executor.1
768 766 768 0 Ss nanslp 0xffffffff824feca0 syz-executor.0
766 764 764 0 S (threaded) syz-fuzzer
100088 S kqread 0xfffff80003cbb300 syz-fuzzer
100102 S uwait 0xfffff80003d55c00 syz-fuzzer
100103 S uwait 0xfffff80003d55d00 syz-fuzzer
100104 S uwait 0xfffff80003d55e00 syz-fuzzer
100105 S uwait 0xfffff80003d55f00 syz-fuzzer
100106 S uwait 0xfffff80003d58080 syz-fuzzer
100107 S uwait 0xfffff80003d55300 syz-fuzzer
100108 S uwait 0xfffff80003d55400 syz-fuzzer
100109 S uwait 0xfffff80003d55500 syz-fuzzer
100111 S uwait 0xfffff80003a48b80 syz-fuzzer
764 762 764 0 Ss pause 0xfffff80003dd1b08 csh
762 680 762 0 Ss select 0xfffff80003d3e2c0 sshd
746 1 746 0 Ss+ ttyin 0xfffff800034384b0 getty
745 1 745 0 Ss+ ttyin 0xfffff80003b368b0 getty
744 1 744 0 Ss+ ttyin 0xfffff80003b36cb0 getty
743 1 743 0 Ss+ ttyin 0xfffff80003b3b0b0 getty
742 1 742 0 Ss+ ttyin 0xfffff80003b3b4b0 getty
741 1 741 0 Ss+ ttyin 0xfffff80003b3b8b0 getty
740 1 740 0 Ss+ ttyin 0xfffff80003b3bcb0 getty
739 1 739 0 Ss+ ttyin 0xfffff80003b3a0b0 getty
738 1 738 0 Ss+ ttyin 0xfffff80003b3a4b0 getty
684 1 684 0 Ss nanslp 0xffffffff824feca1 cron
680 1 680 0 Ss select 0xfffff80003d3e340 sshd
493 1 493 0 Ss select 0xfffff80003d58ec0 syslogd
422 1 422 0 Ss select 0xfffff80003d58840 devd
421 1 421 65 Ss select 0xfffff80003d3e140 dhclient
336 1 336 0 Ss select 0xfffff80003d3e8c0 dhclient
333 1 333 0 Ss select 0xfffff80003a482c0 dhclient
21 0 0 0 DL vlruwt 0xfffff80003b15a60 [vnlru]
20 0 0 0 DL syncer 0xffffffff825d5158 [syncer]
19 0 0 0 DL (threaded) [bufdaemon]
100065 D qsleep 0xffffffff825d4658 [bufdaemon]
100070 D - 0xffffffff8200a980 [bufspacedaemon-0]
100080 D sdflush 0xfffff80003cca4e8 [/ worker]
18 0 0 0 DL psleep 0xffffffff825f00c8 [vmdaemon]
17 0 0 0 DL (threaded) [pagedaemon]
100063 D psleep 0xffffffff8261cfd8 [dom0]
100068 D launds 0xffffffff8261cfe4 [laundry: dom0]
100069 D umarcl 0xffffffff8153f880 [uma]
16 0 0 0 DL - 0xffffffff82359530 [rand_harvestq]
15 0 0 0 DL waiting 0xffffffff826625a0 [sctp_iterator]
9 0 0 0 DL - 0xffffffff825d405c [soaiod4]
8 0 0 0 DL - 0xffffffff825d405c [soaiod3]
7 0 0 0 DL - 0xffffffff825d405c [soaiod2]
6 0 0 0 DL - 0xffffffff825d405c [soaiod1]
5 0 0 0 DL (threaded) [cam]
100031 D - 0xffffffff82234940 [doneq0]
100062 D - 0xffffffff82234808 [scanner]
4 0 0 0 DL crypto_ 0xfffff80003338190 [crypto returns 1]
3 0 0 0 DL crypto_ 0xfffff80003338130 [crypto returns 0]
2 0 0 0 DL crypto_ 0xffffffff825ea138 [crypto]
14 0 0 0 DL seqstat 0xfffff8000337a088 [sequencer 00]
13 0 0 0 DL (threaded) [geom]
100022 D - 0xffffffff8261b608 [g_event]
100023 D - 0xffffffff8261b618 [g_up]
100024 D - 0xffffffff8261b610 [g_down]
12 0 0 0 WL (threaded) [intr]
100006 I [swi5: fast taskq]
100010 I [swi6: task queue]
100011 I [swi6: Giant taskq]
100017 I [swi3: vm]
100018 I [swi4: clock (0)]
100019 I [swi4: clock (1)]
100020 I [swi1: netisr 0]
100032 I [irq24: virtio_pci0]
100033 I [irq25: virtio_pci0]
100034 I [irq26: virtio_pci0]
100035 I [irq27: virtio_pci0]
100036 I [irq28: virtio_pci1]
100037 I [irq29: virtio_pci1]
100038 I [irq30: virtio_pci1]
100039 I [irq31: virtio_pci1]
100040 I [irq32: virtio_pci1]
100045 I [irq10: virtio_pci2]
100047 I [irq1: atkbd0]
100048 I [irq12: psm0]
100049 I [swi0: uart uart++]
11 0 0 0 RL (threaded) [idle]
100003 CanRun [idle: cpu0]
100004 CanRun [idle: cpu1]
1 0 1 0 SLs wait 0xfffff80003300a60 [init]
10 0 0 0 DL audit_w 0xffffffff82663230 [audit]
0 0 0 0 DLs (threaded) [kernel]
100000 D swapin 0xffffffff82609c48 [swapper]
100005 D - 0xfffff80003200b00 [thread taskq]
100007 D - 0xfffff80003200700 [kqueue_ctx taskq]
100008 D - 0xfffff800031fc000 [config_0]
100009 D - 0xfffff80003200400 [aiod_kick taskq]
100012 D - 0xfffff800031fbe00 [if_config_tqg_0]
100013 D - 0xfffff800031fbd00 [if_io_tqg_0]
100014 D - 0xfffff800031fbc00 [if_io_tqg_1]
100015 D - 0xfffff800031fbb00 [softirq_0]
100016 D - 0xfffff800031fba00 [softirq_1]
100021 D - 0xfffff800031ff400 [firmware taskq]
100026 D - 0xfffff800031fed00 [crypto_0]
100027 D - 0xfffff800031fed00 [crypto_1]
100041 D - 0xfffff800031fe000 [vtnet0 rxq 0]
100042 D - 0xfffff800031fde00 [vtnet0 txq 0]
100043 D - 0xfffff800031fdd00 [vtnet0 rxq 1]
100044 D - 0xfffff800031fdc00 [vtnet0 txq 1]
100046 D vtbslp 0xfffff80003579880 [virtio_balloon]
100050 D - 0xfffff8000380ce00 [mca taskq]
100054 D - 0xffffffff81cdce20 [deadlkres]
100057 D - 0xfffff80003a4e700 [acpi_task_0]
100058 D - 0xfffff80003a4e700 [acpi_task_1]
100059 D - 0xfffff80003a4e700 [acpi_task_2]
100061 D - 0xfffff800031fe600 [CAM taskq]
db> show all locks
Process 17690 (syz-executor.3) thread 0xfffff8000c12d000 (101070)
exclusive sleep mutex umtxql (umtxql) r = 0 (0xffffffff8250d740) locked @ /syzkaller/managers/i386/kernel/sys/kern/kern_umtx.c:507
db> show malloc
Type InUse MemUse Requests
devbuf 4213 4851K 4241
vtbuf 24 1968K 46
sysctloid 26737 1565K 26801
kobj 332 1328K 488
newblk 9 1026K 67447
vfscache 4 1025K 4
pcb 63 578K 16796
inodedep 14 519K 21998
ufs_quota 1 512K 1
vfs_hash 1 512K 1
callout 2 512K 2
intr 4 388K 4
subproc 152 290K 17783
acpica 1674 185K 49750
vnet_data 1 168K 1
filedesc 21 149K 33521
pagedep 9 130K 17224
tfo_ccache 1 128K 1
sem 4 106K 4
DEVFS1 105 105K 122
linker 222 89K 253
BPF 46 88K 46
bus 964 78K 3332
mtx_pool 2 72K 2
syncache 1 68K 1
acpitask 1 64K 1
ddb_capture 1 64K 1
module 494 62K 494
umtx 372 47K 372
kdtrace 187 36K 73083
gtaskqueue 22 34K 22
hostcache 1 32K 1
shm 1 32K 424
cred 125 32K 1805
DEVFS3 124 31K 134
msg 4 30K 4
DEVFS_RULE 56 27K 56
ifaddr 74 25K 76
kbdmux 6 22K 6
vmem 3 20K 6
sctp_atcl 36 18K 6843
sctp_stro 18 18K 1911
temp 34 17K 3029
ufs_mount 3 17K 4
proc 3 17K 3
lltable 44 16K 326
tty 16 16K 16
tidhash 1 16K 1
ithread 89 15K 89
ether_multi 172 14K 257
bus-sc 30 14K 1394
KTRACE 100 13K 100
ifnet 7 13K 7
kenv 95 12K 99
select 86 11K 86
in6_multi 89 11K 89
eventhandler 122 11K 122
pfs_nodes 20 10K 20
GEOM 60 10K 487
rman 82 10K 423
bmsafemap 2 9K 22971
devstat 4 9K 4
UART 12 9K 12
rpc 2 8K 2
sctp_timw 32 8K 32
shmfd 1 8K 1
pfs_vncache 1 8K 1
routetbl 58 8K 62
audit_evclass 231 8K 289
kqueue 63 7K 17696
CAM DEV 3 6K 510
plimit 24 6K 684
vt 11 6K 11
sglist 5 6K 5
CAM queue 5 6K 1528
DEVFSP 78 5K 82
ufs_dirhash 24 5K 24
taskqueue 42 5K 42
session 35 5K 56
pgrp 35 5K 86
memdesc 1 4K 1
MCA 32 4K 32
evdev 4 4K 4
kcovinfo 64 4K 68
UMA 236 4K 236
lockf 32 4K 6781
hhook 13 4K 13
proc-args 52 3K 694
acpisem 22 3K 22
terminal 11 3K 11
uidinfo 6 3K 46
sctp_atky 54 3K 8797
sctp_ifa 17 3K 17
local_apic 1 2K 1
io_apic 1 2K 1
ipsec-saq 2 2K 2
ip6ndp 12 2K 21
Unitno 30 2K 73267
CAM XPT 22 2K 543
in_multi 6 2K 47
acpidev 20 2K 20
crypto 2 2K 2
msi 9 2K 9
tun 7 2K 7
freework 5 2K 39425
softdep 1 1K 1
dirrem 4 1K 21365
mkdir 8 1K 34058
freeblks 4 1K 20257
ipsecpolicy 1 1K 1
sahead 1 1K 1
secasvar 1 1K 1
clone 8 1K 8
vnodemarker 2 1K 512
NFSD session 1 1K 1
CAM periph 4 1K 271
mld 6 1K 6
sctp_ifn 6 1K 6
igmp 6 1K 6
toponodes 6 1K 6
isadev 6 1K 6
mount 16 1K 86
pci_link 10 1K 10
freefile 5 1K 21169
sctp_athm 36 1K 6862
sctp_map 36 1K 3798
CAM SIM 2 1K 2
newdirblk 4 1K 17029
diradd 4 1K 21408
pfil 4 1K 4
chacha20random 1 1K 1
epoch 4 1K 4
cdev 2 1K 2
encap_export_host 8 1K 8
inpcbpolicy 12 1K 11491
osd 3 1K 9
ip_msource 4 1K 155
vnodes 1 1K 1475
NFSD lckfile 1 1K 1
NFSD V4client 1 1K 1
DEVFS 9 1K 10
feeder 7 1K 7
loginclass 3 1K 3
CAM path 4 1K 1034
apmdev 1 1K 1
atkbddev 2 1K 2
pmchooks 1 1K 1
prison 4 1K 4
CAM dev queue 2 1K 2
CAM I/O Scheduler 1 1K 1
soname 4 1K 13447
nexusdev 5 1K 5
filecaps 5 1K 106
entropy 2 1K 47
tcpfunc 1 1K 1
sctp_vrf 1 1K 1
vnet 1 1K 1
acpiintr 1 1K 1
pmc 1 1K 1
cpus 2 1K 2
vnet_data_free 1 1K 1
Per-cpu 1 1K 1
p1003.1b 1 1K 1
CAM CCB 0 0K 111822
madt_table 0 0K 2
PUC 0 0K 0
ppbusdev 0 0K 0
agtiapi_MemAlloc malloc 0 0K 0
osti_cacheable 0 0K 0
tempbuff 0 0K 0
tempbuff 0 0K 0
pvscsi 0 0K 0
smartpqi 0 0K 0
ag_tgt_map_t malloc 0 0K 0
ag_slr_map_t malloc 0 0K 0
lDevFlags * malloc 0 0K 0
tiDeviceHandle_t * malloc 0 0K 0
ag_portal_data_t malloc 0 0K 0
ag_device_t malloc 0 0K 0
STLock malloc 0 0K 0
CCB List 0 0K 0
iavf 0 0K 0
ixl 0 0K 0
sr_iov 0 0K 0
OCS 0 0K 0
OCS 0 0K 0
nvme 0 0K 0
nvd 0 0K 0
netmap 0 0K 0
mwldev 0 0K 0
MVS driver 0 0K 0
fpukern_ctx 0 0K 0
xen_intr 0 0K 0
CAM ccb queue 0 0K 0
xen_hvm 0 0K 0
legacydrv 0 0K 0
qpidrv 0 0K 0
mrsasbuf 0 0K 0
mpt_user 0 0K 0
dmar_idpgtbl 0 0K 0
dmar_dom 0 0K 0
dmar_ctx 0 0K 0
dmar_dmamap 0 0K 0
mps_user 0 0K 0
MPSSAS 0 0K 0
isci 0 0K 0
bxe_ilt 0 0K 0
xenbus 0 0K 0
vm_fictitious 0 0K 0
mps 0 0K 0
mpr_user 0 0K 0
MPRSAS 0 0K 0
UMAHash 0 0K 0
vm_pgdata 0 0K 0
jblocks 0 0K 0
savedino 0 0K 12010
sentinel 0 0K 0
jfsync 0 0K 0
jtrunc 0 0K 0
sbdep 0 0K 257
jsegdep 0 0K 0
jseg 0 0K 0
jfreefrag 0 0K 0
jfreeblk 0 0K 0
jnewblk 0 0K 0
jmvref 0 0K 0
jremref 0 0K 0
jaddref 0 0K 0
freedep 0 0K 0
freefrag 0 0K 354
allocindir 0 0K 0
indirdep 0 0K 25734
allocdirect 0 0K 0
ufs_trim 0 0K 0
mactemp 0 0K 0
audit_trigger 0 0K 0
audit_pipe_presel 0 0K 0
audit_pipeent 0 0K 0
audit_pipe 0 0K 0
audit_evname 0 0K 0
audit_bsm 0 0K 0
audit_gidset 0 0K 0
audit_text 0 0K 0
audit_path 0 0K 0
audit_data 0 0K 0
audit_cred 0 0K 0
xform 0 0K 0
NLM 0 0K 0
nfsclient_nlminfo 0 0K 0
nfsclient_lock 0 0K 0
NFS FHA 0 0K 0
ipsec-spdcache 0 0K 0
ipsec-reg 0 0K 0
ipsec-misc 0 0K 0
ipsecrequest 0 0K 0
ip6opt 0 0K 152
ip6_msource 0 0K 0
ip6_moptions 0 0K 5
in6_mfilter 0 0K 0
frag6 0 0K 0
tcplog 0 0K 0
LRO 0 0K 0
sctp_mcore 0 0K 0
sctp_socko 0 0K 2275
sctp_iter 0 0K 9
sctp_mvrf 0 0K 0
sctp_cpal 0 0K 0
sctp_cmsg 0 0K 0
sctp_stre 0 0K 0
sctp_athi 0 0K 0
sctp_a_it 0 0K 9
sctp_aadr 0 0K 10
sctp_stri 0 0K 94
newreno data 0 0K 0
ip_moptions 0 0K 106
in_mfilter 0 0K 322
ipid 0 0K 0
80211scan 0 0K 0
80211ratectl 0 0K 0
80211power 0 0K 0
80211nodeie 0 0K 0
80211node 0 0K 0
80211mesh_gt 0 0K 0
80211mesh_rt 0 0K 0
80211perr 0 0K 0
80211prep 0 0K 0
80211preq 0 0K 0
80211dfs 0 0K 0
80211crypto 0 0K 0
80211vap 0 0K 0
iflib 0 0K 0
vlan 0 0K 0
gif 0 0K 0
ifdescr 0 0K 0
zlib 0 0K 0
fadvise 0 0K 0
mpr 0 0K 0
statfs 0 0K 17202
export_host 0 0K 0
cl_savebuf 0 0K 136
biobuf 0 0K 0
aios 0 0K 0
lio 0 0K 0
acl 0 0K 0
mfibuf 0 0K 0
mbuf_tag 0 0K 1094
accf 0 0K 0
pts 0 0K 0
iov 0 0K 23378
ioctlops 0 0K 198
Witness 0 0K 0
stack 0 0K 0
md_sectors 0 0K 0
sbuf 0 0K 288
md_disk 0 0K 0
compressor 0 0K 0
malodev 0 0K 0
SWAP 0 0K 0
LED 0 0K 0
sysctltmp 0 0K 825
sysctl 0 0K 1
ekcd 0 0K 0
dumper 0 0K 0
rctl 0 0K 0
ix_sriov 0 0K 0
aacraidcam 0 0K 0
ix 0 0K 0
ipsbuf 0 0K 0
iirbuf 0 0K 0
cache 0 0K 0
aacraid_buf 0 0K 0
prison_racct 0 0K 0
Fail Points 0 0K 0
sigio 0 0K 20
filedesc_to_leader 0 0K 0
tty console 0 0K 0
aaccam 0 0K 0
aacbuf 0 0K 0
zstd 0 0K 0
nvlist 0 0K 0
SCSI ENC 0 0K 0
SCSI sa 0 0K 0
isofs_node 0 0K 0
isofs_mount 0 0K 0
tr_raid5_data 0 0K 0
tr_raid1e_data 0 0K 0
tr_raid1_data 0 0K 0
tr_raid0_data 0 0K 0
tr_concat_data 0 0K 0
md_sii_data 0 0K 0
md_promise_data 0 0K 0
md_nvidia_data 0 0K 0
md_jmicron_data 0 0K 0
md_intel_data 0 0K 0
md_ddf_data 0 0K 0
raid_data 0 0K 72
geom_flashmap 0 0K 0
newnfsmnt 0 0K 0
newnfsclient_req 0 0K 0
NFSCL layrecall 0 0K 0
NFSCL session 0 0K 0
NFSCL sockreq 0 0K 0
NFSCL devinfo 0 0K 0
NFSCL flayout 0 0K 0
NFSCL layout 0 0K 0
NFSD rollback 0 0K 0
NFSCL diroffdiroff 0 0K 0
NEWdirectio 0 0K 0
NEWNFSnode 0 0K 0
NFSCL lck 0 0K 0
NFSCL lckown 0 0K 0
NFSCL client 0 0K 0
NFSCL deleg 0 0K 0
NFSCL open 0 0K 0
NFSCL owner 0 0K 0
NFS fh 0 0K 0
NFS req 0 0K 0
NFSD usrgroup 0 0K 0
NFSD string 0 0K 0
NFSD V4lock 0 0K 0
NFSD V4state 0 0K 0
NFSD srvcache 0 0K 0
msdosfs_fat 0 0K 0
msdosfs_mount 0 0K 0
msdosfs_node 0 0K 0
DEVFS4 0 0K 0
DEVFS2 0 0K 0
gntdev 0 0K 0
privcmd_dev 0 0K 0
evtchn_dev 0 0K 0
xenstore 0 0K 0
scsi_pass 0 0K 0
ciss_data 0 0K 0
xnb 0 0K 0
xbbd 0 0K 0
xbd 0 0K 0
Balloon 0 0K 0
sysmouse 0 0K 0
vtfont 0 0K 0
ath_hal 0 0K 0
athdev 0 0K 0
ata_pci 0 0K 0
ata_dma 0 0K 0
ata_generic 0 0K 0
amr 0 0K 0
scsi_da 0 0K 69
ata_da 0 0K 0
scsi_ch 0 0K 0
scsi_cd 0 0K 0
USBdev 0 0K 0
USB 0 0K 0
AHCI driver 0 0K 0
agp 0 0K 0
nvme_da 0 0K 0
acpipwr 0 0K 0
twsbuf 0 0K 0
twe_commands 0 0K 0
twa_commands 0 0K 0
tcp_log_dev 0 0K 12
midi buffers 0 0K 0
mixer 0 0K 0
ac97 0 0K 0
hdacc 0 0K 0
hdac 0 0K 0
hdaa 0 0K 0
acpi_perf 0 0K 0
acpicmbat 0 0K 0
SIIS driver 0 0K 0
db> show ktr
No such command; use "help" to list available commands


---
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,
Feb 4, 2020, 3:17:12 PM2/4/20
to syzkaller-f...@googlegroups.com
syzbot has found a reproducer for the following crash on:

HEAD commit: 618d4923 Regen after r357503.
git tree: freebsd
console output: https://syzkaller.appspot.com/x/log.txt?x=1411a029e00000
syz repro: https://syzkaller.appspot.com/x/repro.syz?x=112cd4e9e00000
C reproducer: https://syzkaller.appspot.com/x/repro.c?x=17248d11e00000

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

login: panic: mutex process lock not owned at /syzkaller/managers/i386/kernel/sys/kern/kern_time.c:261
cpuid = 0
time = 1580847200
KDB: stack backtrace:
db_trace_self_wrapper() at db_trace_self_wrapper+0x47/frame 0xfffffe00244a68b0
vpanic() at vpanic+0x1ce/frame 0xfffffe00244a6920
panic() at panic+0x43/frame 0xfffffe00244a6980
__mtx_assert() at __mtx_assert+0x196/frame 0xfffffe00244a69c0
kern_thread_cputime() at kern_thread_cputime+0xaa/frame 0xfffffe00244a6a10
kern_clock_gettime() at kern_clock_gettime+0x277/frame 0xfffffe00244a6a70
freebsd32_clock_gettime() at freebsd32_clock_gettime+0x25/frame 0xfffffe00244a6ab0
ia32_syscall() at ia32_syscall+0x48c/frame 0xfffffe00244a6bf0
int0x80_syscall_common() at int0x80_syscall_common+0x9c/frame 0xffffdc48
KDB: enter: panic
[ thread pid 771 tid 100101 ]
Stopped at kdb_enter+0x67: movq $0,0x14669d6(%rip)
db>
db> set $lines = 0
db> set $maxwidth = 0
db> show registers
cs 0x20
ds 0x3b ll+0x1a
es 0x3b ll+0x1a
fs 0x13
gs 0x1b
ss 0
rax 0x12
rcx 0x80 ll+0x5f
rdx 0xffffffff818f0b7d
rbx 0
rsp 0xfffffe00244a6890
rbp 0xfffffe00244a68b0
rsi 0x1
rdi 0
r8 0
r9 0xffffffff
r10 0
r11 0xfffff8003a601bd0
r12 0xffffffff82068d90 ddb_dbbe
r13 0
r14 0xffffffff81938d3c
r15 0xffffffff81938d3c
rip 0xffffffff810af6c7 kdb_enter+0x67
rflags 0x200086 kernphys+0x86
kdb_enter+0x67: movq $0,0x14669d6(%rip)
db> show proc
Process 771 (syz-executor0903084) at 0xfffff8003a50f000:
state: NORMAL
uid: 0 gids: 0, 0, 5
parent: pid 769 at 0xfffff8003a50f530
ABI: FreeBSD ELF32
arguments: ./syz-executor090308476
reaper: 0xfffff80003300a60 reapsubtree: 1
sigparent: 20
vmspace: 0xfffff8003a26e000
(map 0xfffff8003a26e000)
(map.pmap 0xfffff8003a26e0c0)
(pmap 0xfffff8003a26e120)
threads: 1
100101 Run CPU 0 syz-executor0903084
db> ps
pid ppid pgrp uid state wmesg wchan cmd
771 769 769 0 R CPU 0 syz-executor0903084
769 767 769 0 Ss pause 0xfffff8003a50f5d8 csh
767 680 767 0 Rs sshd
746 1 746 0 Ss+ ttyin 0xfffff800034384b0 getty
745 1 745 0 Ss+ ttyin 0xfffff80003b3f8b0 getty
744 1 744 0 Ss+ ttyin 0xfffff80003b3fcb0 getty
743 1 743 0 Ss+ ttyin 0xfffff80003b420b0 getty
742 1 742 0 Ss+ ttyin 0xfffff80003b424b0 getty
741 1 741 0 Ss+ ttyin 0xfffff80003b428b0 getty
740 1 740 0 Ss+ ttyin 0xfffff80003b42cb0 getty
739 1 739 0 Ss+ ttyin 0xfffff80003b410b0 getty
738 1 738 0 Ss+ ttyin 0xfffff80003b414b0 getty
736 1 22 0 S+ piperd 0xfffff80003f592f8 logger
735 734 22 0 S+ nanslp 0xffffffff824feca0 sleep
734 1 22 0 S+ wait 0xfffff800032ff530 sh
684 1 684 0 Ss nanslp 0xffffffff824feca1 cron
680 1 680 0 Ss select 0xfffff80003e13d40 sshd
493 1 493 0 Ss select 0xfffff80003a60e40 syslogd
422 1 422 0 Ss select 0xfffff80003e13dc0 devd
421 1 421 65 Ss select 0xfffff80003a60ec0 dhclient
336 1 336 0 Ss select 0xfffff80003e128c0 dhclient
333 1 333 0 Ss select 0xfffff80003e12940 dhclient
21 0 0 0 DL vlruwt 0xfffff80003b1ea60 [vnlru]
20 0 0 0 DL syncer 0xffffffff825d5158 [syncer]
19 0 0 0 DL (threaded) [bufdaemon]
100065 D qsleep 0xffffffff825d4658 [bufdaemon]
100070 D - 0xffffffff8200a980 [bufspacedaemon-0]
100081 D sdflush 0xfffff800038154e8 [/ worker]
100004 Run CPU 1 [idle: cpu1]
1 0 1 0 SLs wait 0xfffff80003300a60 [init]
10 0 0 0 DL audit_w 0xffffffff82663230 [audit]
0 0 0 0 DLs (threaded) [kernel]
100000 D swapin 0xffffffff82609c48 [swapper]
100005 D - 0xfffff80003200b00 [thread taskq]
100007 D - 0xfffff80003200700 [kqueue_ctx taskq]
100008 D - 0xfffff800031fc000 [config_0]
100009 D - 0xfffff80003200400 [aiod_kick taskq]
100012 D - 0xfffff800031fbe00 [if_config_tqg_0]
100013 D - 0xfffff800031fbd00 [if_io_tqg_0]
100014 D - 0xfffff800031fbc00 [if_io_tqg_1]
100015 D - 0xfffff800031fbb00 [softirq_0]
100016 D - 0xfffff800031fba00 [softirq_1]
100021 D - 0xfffff800031ff400 [firmware taskq]
100026 D - 0xfffff800031fed00 [crypto_0]
100027 D - 0xfffff800031fed00 [crypto_1]
100041 D - 0xfffff800031fe000 [vtnet0 rxq 0]
100042 D - 0xfffff800031fde00 [vtnet0 txq 0]
100043 D - 0xfffff800031fdd00 [vtnet0 rxq 1]
100044 D - 0xfffff800031fdc00 [vtnet0 txq 1]
100046 D vtbslp 0xfffff80003579880 [virtio_balloon]
100050 D - 0xfffff8000380ce00 [mca taskq]
100055 D - 0xffffffff81cdce20 [deadlkres]
100057 D - 0xfffff80003a12500 [acpi_task_0]
100058 D - 0xfffff80003a12500 [acpi_task_1]
100059 D - 0xfffff80003a12500 [acpi_task_2]
100061 D - 0xfffff800031fe600 [CAM taskq]
db> show all locks
db> show malloc
Type InUse MemUse Requests
devbuf 4213 4851K 4238
vtbuf 24 1968K 46
sysctloid 26737 1565K 26801
kobj 332 1328K 488
newblk 482 1145K 500
vfscache 4 1025K 4
pcb 21 537K 75
inodedep 48 536K 71
ufs_quota 1 512K 1
vfs_hash 1 512K 1
callout 2 512K 2
intr 4 388K 4
subproc 105 207K 833
acpica 1674 185K 49750
vnet_data 1 168K 1
pagedep 14 132K 18
tfo_ccache 1 128K 1
sem 4 106K 4
DEVFS1 101 101K 110
linker 222 89K 241
bus 964 78K 3300
mtx_pool 2 72K 2
syncache 1 68K 1
acpitask 1 64K 1
ddb_capture 1 64K 1
module 494 62K 494
gtaskqueue 22 34K 22
hostcache 1 32K 1
shm 1 32K 1
msg 4 30K 4
DEVFS3 120 30K 130
umtx 216 27K 216
kdtrace 138 27K 1594
DEVFS_RULE 56 27K 56
kbdmux 6 22K 6
vmem 3 18K 3
BPF 10 18K 10
temp 17 17K 1533
ufs_mount 3 17K 4
proc 3 17K 3
tty 16 16K 16
tidhash 1 16K 1
ithread 89 15K 89
bus-sc 30 14K 1394
KTRACE 100 13K 100
ifaddr 30 12K 32
kenv 95 12K 99
eventhandler 122 11K 122
pfs_nodes 20 10K 20
GEOM 60 10K 487
rman 82 10K 423
bmsafemap 4 9K 41
devstat 4 9K 4
UART 12 9K 12
rpc 2 8K 2
shmfd 1 8K 1
pfs_vncache 1 8K 1
audit_evclass 231 8K 289
cred 27 7K 234
CAM DEV 3 6K 510
vt 11 6K 11
sglist 5 6K 5
CAM queue 5 6K 1528
routetbl 28 5K 32
ufs_dirhash 24 5K 24
taskqueue 42 5K 42
dirrem 17 5K 28
plimit 17 5K 322
ifnet 3 5K 3
memdesc 1 4K 1
MCA 32 4K 32
evdev 4 4K 4
filedesc 1 4K 1
UMA 236 4K 236
lltable 11 4K 11
hhook 13 4K 13
ether_multi 40 4K 45
diradd 25 4K 36
in6_multi 25 3K 25
acpisem 22 3K 22
terminal 11 3K 11
kqueue 44 3K 774
session 20 3K 31
pgrp 20 3K 31
uidinfo 4 3K 4
select 17 3K 17
local_apic 1 2K 1
io_apic 1 2K 1
ipsec-saq 2 2K 2
proc-args 39 2K 472
CAM XPT 22 2K 543
lockf 15 2K 22
Unitno 25 2K 37
acpidev 20 2K 20
crypto 2 2K 2
msi 9 2K 9
softdep 1 1K 1
ipsecpolicy 1 1K 1
sahead 1 1K 1
secasvar 1 1K 1
clone 8 1K 8
vnodemarker 2 1K 6
NFSD session 1 1K 1
CAM periph 4 1K 271
indirdep 3 1K 3
toponodes 6 1K 6
isadev 6 1K 6
mount 16 1K 86
pci_link 10 1K 10
ip6ndp 4 1K 5
sctp_ifa 5 1K 5
CAM SIM 2 1K 2
newdirblk 4 1K 8
mkdir 4 1K 16
in_multi 2 1K 3
pfil 4 1K 4
chacha20random 1 1K 1
epoch 4 1K 4
cdev 2 1K 2
encap_export_host 8 1K 8
osd 3 1K 9
mld 2 1K 2
sctp_ifn 2 1K 2
igmp 2 1K 2
vnodes 1 1K 1
NFSD lckfile 1 1K 1
NFSD V4client 1 1K 1
DEVFS 9 1K 10
feeder 7 1K 7
inpcbpolicy 6 1K 131
loginclass 3 1K 3
CAM path 4 1K 1034
apmdev 1 1K 1
atkbddev 2 1K 2
pmchooks 1 1K 1
prison 4 1K 4
DEVFSP 2 1K 2
CAM dev queue 2 1K 2
CAM I/O Scheduler 1 1K 1
soname 4 1K 5740
filecaps 4 1K 66
tun 3 1K 3
nexusdev 5 1K 5
entropy 2 1K 35
tcpfunc 1 1K 1
sctp_vrf 1 1K 1
vnet 1 1K 1
acpiintr 1 1K 1
pmc 1 1K 1
cpus 2 1K 2
freework 1 1K 26
vnet_data_free 1 1K 1
Per-cpu 1 1K 1
p1003.1b 1 1K 1
CAM CCB 0 0K 1781
savedino 0 0K 13
sentinel 0 0K 0
jfsync 0 0K 0
jtrunc 0 0K 0
sbdep 0 0K 2
jsegdep 0 0K 0
jseg 0 0K 0
jfreefrag 0 0K 0
jfreeblk 0 0K 0
jnewblk 0 0K 0
jmvref 0 0K 0
jremref 0 0K 0
jaddref 0 0K 0
freedep 0 0K 0
freefile 0 0K 9
freeblks 0 0K 25
freefrag 0 0K 7
allocindir 0 0K 0
allocdirect 0 0K 0
ufs_trim 0 0K 0
mactemp 0 0K 0
audit_trigger 0 0K 0
audit_pipe_presel 0 0K 0
audit_pipeent 0 0K 0
audit_pipe 0 0K 0
audit_evname 0 0K 0
audit_bsm 0 0K 0
audit_gidset 0 0K 0
audit_text 0 0K 0
audit_path 0 0K 0
audit_data 0 0K 0
audit_cred 0 0K 0
xform 0 0K 0
NLM 0 0K 0
nfsclient_nlminfo 0 0K 0
nfsclient_lock 0 0K 0
NFS FHA 0 0K 0
ipsec-spdcache 0 0K 0
ipsec-reg 0 0K 0
ipsec-misc 0 0K 0
ipsecrequest 0 0K 0
ip6opt 0 0K 3
ip6_msource 0 0K 0
ip6_moptions 0 0K 0
in6_mfilter 0 0K 0
frag6 0 0K 0
tcplog 0 0K 0
LRO 0 0K 0
sctp_mcore 0 0K 0
sctp_socko 0 0K 0
sctp_iter 0 0K 3
sctp_mvrf 0 0K 0
sctp_timw 0 0K 0
sctp_cpal 0 0K 0
sctp_cmsg 0 0K 0
sctp_stre 0 0K 0
sctp_athi 0 0K 0
sctp_athm 0 0K 0
sctp_atky 0 0K 0
sctp_atcl 0 0K 0
sctp_a_it 0 0K 3
sctp_aadr 0 0K 0
sctp_stro 0 0K 0
sctp_stri 0 0K 0
sctp_map 0 0K 0
newreno data 0 0K 0
ip_msource 0 0K 0
ip_moptions 0 0K 0
in_mfilter 0 0K 0
ipid 0 0K 0
80211scan 0 0K 0
80211ratectl 0 0K 0
80211power 0 0K 0
80211nodeie 0 0K 0
80211node 0 0K 0
80211mesh_gt 0 0K 0
80211mesh_rt 0 0K 0
80211perr 0 0K 0
80211prep 0 0K 0
80211preq 0 0K 0
80211dfs 0 0K 0
80211crypto 0 0K 0
80211vap 0 0K 0
iflib 0 0K 0
vlan 0 0K 0
gif 0 0K 0
ifdescr 0 0K 0
zlib 0 0K 0
fadvise 0 0K 0
mpr 0 0K 0
statfs 0 0K 195
export_host 0 0K 0
cl_savebuf 0 0K 3
biobuf 0 0K 0
aios 0 0K 0
lio 0 0K 0
acl 0 0K 0
mfibuf 0 0K 0
mbuf_tag 0 0K 25
accf 0 0K 0
pts 0 0K 0
iov 0 0K 12948
ioctlops 0 0K 86
Witness 0 0K 0
stack 0 0K 0
md_sectors 0 0K 0
sbuf 0 0K 288
md_disk 0 0K 0
compressor 0 0K 0
malodev 0 0K 0
SWAP 0 0K 0
LED 0 0K 0
sysctltmp 0 0K 567
sysctl 0 0K 1
ekcd 0 0K 0
dumper 0 0K 0
rctl 0 0K 0
ix_sriov 0 0K 0
aacraidcam 0 0K 0
ix 0 0K 0
ipsbuf 0 0K 0
iirbuf 0 0K 0
cache 0 0K 0
aacraid_buf 0 0K 0
kcovinfo 0 0K 0
prison_racct 0 0K 0
Fail Points 0 0K 0
sigio 0 0K 1
tcp_log_dev 0 0K 0
Reply all
Reply to author
Forward
0 new messages