panic: softclock: invalid to_clock: NUM

0 views
Skip to first unread message

syzbot

unread,
Mar 3, 2024, 2:39:17 AMMar 3
to syzkaller-o...@googlegroups.com
Hello,

syzbot found the following issue on:

HEAD commit: a60241574931 snc
git tree: openbsd
console output: https://syzkaller.appspot.com/x/log.txt?x=1219bcf2180000
kernel config: https://syzkaller.appspot.com/x/.config?x=7058272de1526588
dashboard link: https://syzkaller.appspot.com/bug?extid=dd421ccba4b7e7777417

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

Downloadable assets:
disk image: https://storage.googleapis.com/syzbot-assets/44a7ede60a70/disk-a6024157.raw.xz
bsd.gdb: https://storage.googleapis.com/syzbot-assets/759103c1f15a/bsd-a6024157.gdb.xz
kernel image: https://storage.googleapis.com/syzbot-assets/ce21c47bba0b/kernel-a6024157.xz

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

panic: softclock: invalid to_clock: 512
Stopped at db_enter+0x1c: addq $0x8,%rsp
TID PID UID PRFLAGS PFLAGS CPU COMMAND
db_enter() at db_enter+0x1c sys/arch/amd64/amd64/db_interface.c:437
panic(ffffffff8291b09d) at panic+0x17b sys/kern/subr_prf.c:198
softclock(0) at softclock+0x22d sys/kern/kern_timeout.c:759
softintr_dispatch(0) at softintr_dispatch+0xfb sys/arch/amd64/amd64/softintr.c:90
Xsoftclock() at Xsoftclock+0x27
acpicpu_idle() at acpicpu_idle+0x312 sys/dev/acpi/acpicpu.c:1206
sched_idle(ffffffff82d21ff0) at sched_idle+0x41e sys/kern/kern_sched.c:183
end trace frame: 0x0, count: 8
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
*cpu0: softclock: invalid to_clock: 512
ddb{0}> trace
db_enter() at db_enter+0x1c sys/arch/amd64/amd64/db_interface.c:437
panic(ffffffff8291b09d) at panic+0x17b sys/kern/subr_prf.c:198
softclock(0) at softclock+0x22d sys/kern/kern_timeout.c:759
softintr_dispatch(0) at softintr_dispatch+0xfb sys/arch/amd64/amd64/softintr.c:90
Xsoftclock() at Xsoftclock+0x27
acpicpu_idle() at acpicpu_idle+0x312 sys/dev/acpi/acpicpu.c:1206
sched_idle(ffffffff82d21ff0) at sched_idle+0x41e sys/kern/kern_sched.c:183
end trace frame: 0x0, count: -7
ddb{0}> show registers
rdi 0
rsi 0x1
rbp 0xffff80002a1022c0
rbx 0xffffffff82d22cb7 cpu_info_full_primary+0x2cb7
rdx 0
rcx 0xffff80002a0fc7e8
rax 0xffffffff82d21ff0 cpu_info_full_primary+0x1ff0
r8 0x101010101010101
r9 0x8080808080808080
r10 0xb3f30bde1686f53e
r11 0x92e45ddbc9f97ee1
r12 0xffffffff82d22ab8 cpu_info_full_primary+0x2ab8
r13 0
r14 0
r15 0x1
rip 0xffffffff8178926c db_enter+0x1c
cs 0x8
rflags 0x246
rsp 0xffff80002a1022b0
ss 0x10
db_enter+0x1c: addq $0x8,%rsp
ddb{0}> show proc
PROC (idle0) tid=145346 pid=8502 tcnt=1 stat=onproc
flags process=14000<NOZOMBIE,SYSTEM> proc=40000200<SYSTEM,CPUPEG>
runpri=0, usrpri=50, slppri=0, nice=20
wchan=0x0, wmesg=, ps_single=0x0
forw=0x1dcb09983d0208d1, list=0xffff80002a0fca90,0xffff80002a0fc000
process=0xffff8000fffff0d0 user=0xffff80002a0fd000, vmspace=0xffffffff82e114a0
estcpu=0, cpticks=25819, pctcpu=0.0, user=0, sys=0, intr=0
ddb{0}> ps
PID TID PPID UID S FLAGS WAIT COMMAND
29251 63672 53224 0 3 0x82 piperd syz-executor.1
42727 98702 53224 0 3 0x82 piperd syz-executor.5
27619 219367 53224 0 3 0x82 piperd syz-executor.6
55031 343419 53224 0 3 0x82 piperd syz-executor.4
25136 516404 53224 0 3 0x82 piperd syz-executor.3
34543 258980 1 0 3 0x100083 ttyin getty
30076 335689 53224 0 3 0x82 piperd syz-executor.2
59383 174407 53224 0 2 0x482 syz-executor.7
19214 373089 53224 0 3 0x82 piperd syz-executor.0
25637 173700 0 0 3 0x14200 acct acct
20176 225713 0 0 3 0x14280 nfsidl nfsio
14913 289095 0 0 3 0x14280 nfsidl nfsio
53147 518802 0 0 3 0x14280 nfsidl nfsio
86910 405372 0 0 3 0x14280 nfsidl nfsio
75540 487858 0 0 3 0x14280 nfsidl nfsio
41870 403648 0 0 3 0x14280 nfsidl nfsio
27921 21943 0 0 3 0x14280 nfsidl nfsio
79325 225052 0 0 3 0x14280 nfsidl nfsio
9139 3043 0 0 3 0x14280 nfsidl nfsio
40550 231248 0 0 3 0x14280 nfsidl nfsio
99492 437624 0 0 3 0x14280 nfsidl nfsio
97292 51642 0 0 3 0x14280 nfsidl nfsio
62977 299727 0 0 3 0x14280 nfsidl nfsio
81576 294594 0 0 3 0x14280 nfsidl nfsio
25219 46808 0 0 3 0x14280 nfsidl nfsio
28629 331200 0 0 3 0x14280 nfsidl nfsio
89122 415298 0 0 3 0x14280 nfsidl nfsio
57290 10278 0 0 3 0x14280 nfsidl nfsio
86810 305516 0 0 3 0x14280 nfsidl nfsio
3434 314766 0 0 3 0x14280 nfsidl nfsio
7312 230117 0 0 3 0x14200 bored sosplice
53224 123193 94346 0 3 0x2000082 thrsleep syz-fuzzer
53224 40919 94346 0 3 0x6000082 thrsleep syz-fuzzer
53224 122910 94346 0 3 0x6000082 thrsleep syz-fuzzer
53224 88776 94346 0 3 0x6000082 kqread syz-fuzzer
53224 129332 94346 0 3 0x6000082 wait syz-fuzzer
53224 325382 94346 0 3 0x6000082 thrsleep syz-fuzzer
53224 433004 94346 0 3 0x6000082 wait syz-fuzzer
53224 242075 94346 0 3 0x6000082 wait syz-fuzzer
53224 458681 94346 0 3 0x6000082 wait syz-fuzzer
53224 120499 94346 0 3 0x6000082 thrsleep syz-fuzzer
53224 398295 94346 0 3 0x6000082 thrsleep syz-fuzzer
53224 325575 94346 0 3 0x6000082 wait syz-fuzzer
53224 39015 94346 0 3 0x6000082 wait syz-fuzzer
53224 99087 94346 0 3 0x6000082 thrsleep syz-fuzzer
53224 406236 94346 0 3 0x6000082 wait syz-fuzzer
53224 136754 94346 0 3 0x6000082 wait syz-fuzzer
94346 454545 31571 0 3 0x10008a sigsusp ksh
31571 233949 20727 0 3 0x9a kqread sshd
20727 115818 1 0 3 0x88 kqread sshd
42830 258557 54485 74 3 0x1100092 bpf pflogd
54485 171599 1 0 3 0x80 netio pflogd
74107 184607 64438 73 3 0x1100010 ffs_fsync syslogd
64438 479236 1 0 3 0x100082 netio syslogd
22775 6672 1 0 3 0x100080 kqread resolvd
91266 285292 39362 77 3 0x100092 kqread dhcpleased
23483 518617 39362 77 3 0x100092 kqread dhcpleased
39362 194773 1 0 3 0x80 kqread dhcpleased
570 182354 0 0 3 0x14200 bored smr
19987 188097 0 0 3 0x14200 pgzero zerothread
45571 222950 0 0 3 0x14200 aiodoned aiodoned
69511 385297 0 0 3 0x14200 syncer update
45647 209530 0 0 3 0x14200 cleaner cleaner
68471 21992 0 0 3 0x14200 reaper reaper
96384 327104 0 0 3 0x14200 pgdaemon pagedaemon
3303 62656 0 0 3 0x14200 bored viomb
47097 17313 0 0 3 0x40014200 acpi0 acpi0
48138 75754 0 0 7 0x40014200 idle1
96102 143463 0 0 3 0x14200 bored softnet3
29958 28712 0 0 3 0x14200 bored softnet2
369 180792 0 0 3 0x14200 bored softnet1
31823 191469 0 0 3 0x14200 bored softnet0
97359 74192 0 0 3 0x14200 bored systqmp
86948 247931 0 0 3 0x14200 bored systq
7543 161252 0 0 3 0x14200 tmoslp softclockmp
22688 211757 0 0 3 0x40014200 tmoslp softclock
* 8502 145346 0 0 7 0x40014200 idle0
1 237484 0 0 3 0x82 wait init
0 0 -1 0 3 0x10200 scheduler swapper
ddb{0}> show all locks
CPU 0:
exclusive mutex /syzkaller/managers/multicore/kernel/sys/kern/kern_timeout.c:57 r = 0 (0xffffffff82d2a980)
#0 witness_lock+0x447
#1 mtx_enter_try+0x104
#2 mtx_enter+0x4f sys/kern/kern_lock.c:266
#3 softclock_process_tick_timeout+0x1b2 sys/kern/kern_timeout.c:723
#4 softclock+0x13a sys/kern/kern_timeout.c:755
#5 softintr_dispatch+0xfb sys/arch/amd64/amd64/softintr.c:90
#6 Xsoftclock+0x27
#7 acpicpu_idle+0x312 sys/dev/acpi/acpicpu.c:1206
#8 sched_idle+0x41e sys/kern/kern_sched.c:183
#9 proc_trampoline+0x10
Process 74107 (syslogd) thread 0xffff80002a18ad48 (184607)
Process 8502 (idle0) thread 0xffff80002a0fc7e8 (145346)
ddb{0}> show malloc
Type InUse MemUse HighUse Limit Requests Type Lim
devbuf 10218 6505K 6828K 166960K 13961 0
pcb 15 24K 28K 166960K 854 0
rtable 188 14K 16K 166960K 2181 0
pf 33 9K 10K 166960K 270 0
ifaddr 37 14K 16K 166960K 253 0
ifgroup 56 2K 2K 166960K 434 0
sysctl 3 0K 0K 166960K 7 0
counters 64 36K 37K 166960K 274 0
ioctlops 0 0K 4K 166960K 2054 0
iov 0 0K 32K 166960K 1376 0
mount 1 1K 1K 166960K 1 0
log 0 0K 0K 166960K 1 0
vnodes 1473 92K 92K 166960K 4355 0
UFS quota 1 32K 32K 166960K 1 0
UFS mount 5 36K 36K 166960K 5 0
shm 2 1K 9K 166960K 129 0
VM map 2 1K 1K 166960K 2 0
sem 12 0K 0K 166960K 1362 0
dirhash 12 2K 2K 166960K 81 0
ACPI 1697 195K 286K 166960K 12548 0
file desc 11 37K 89K 166960K 11656 0
sigio 0 0K 0K 166960K 794 0
proc 73 91K 128K 166960K 1887 0
subproc 104 6K 8K 166960K 524 0
NFS srvsock 1 0K 0K 166960K 1 0
NFS daemon 1 16K 16K 166960K 1 0
ip_moptions 0 0K 0K 166960K 548 0
in_multi 75 5K 7K 166960K 464 0
ether_multi 1 0K 0K 166960K 13 0
mrt 0 0K 0K 166960K 6 0
ISOFS mount 1 32K 32K 166960K 1 0
MSDOSFS mount 1 16K 16K 166960K 1 0
ttys 229 1023K 1023K 166960K 229 0
exec 0 0K 1K 166960K 2329 0
pfkey data 0 0K 0K 166960K 5 0
tdb 3 0K 0K 166960K 3 0
VM swap 8 62K 64K 166960K 10 0
UVM amap 452 397K 414K 166960K 110878 0
UVM aobj 131 4K 4K 166960K 138 0
memdesc 1 4K 4K 166960K 1 0
crypto data 1 1K 1K 166960K 1 0
ip6_options 0 0K 0K 166960K 331 0
NDP 12 0K 2K 166960K 189 0
temp 74 6772K 7412K 166960K 124391 0
kqueue 12 18K 28K 166960K 864 0
SYN cache 2 16K 16K 166960K 2 0
ddb{0}> show all pools
Name Size Requests Fail Releases Pgreq Pgrel Npage Hiwat Minpg Maxpg Idle
plcache 128 24 0 0 1 0 1 1 0 8 0
rtpcb 120 770 0 767 11 10 1 3 0 8 0
rtentry 112 571 0 489 5 2 3 4 0 8 0
unpcb 144 8917 0 8902 89 83 6 10 0 8 5
syncache 336 110 0 110 19 19 0 1 0 8 0
sackhl 24 1 0 1 1 1 0 1 0 8 0
tcpqe 32 210 0 210 14 14 0 1 0 8 0
tcpcb 808 3930 0 3920 115 107 8 12 0 8 6
arp 120 104 0 93 1 0 1 1 0 8 0
inpcb 392 10544 0 10528 174 165 9 26 0 8 7
nd6 136 113 0 94 1 0 1 1 0 8 0
pkpcb 40 33 0 33 8 8 0 1 0 8 0
kcovpl 48 37 0 29 1 0 1 1 0 8 0
ppxss 1168 29 0 29 9 9 0 1 0 8 0
pffrag 232 39 0 37 6 5 1 1 0 482 0
pffrnode 88 38 0 36 6 5 1 1 0 8 0
pffrent 40 140 0 138 6 5 1 1 0 8 0
pfosfp 40 1428 0 1005 5 0 5 5 0 8 0
pfosfpen 112 1428 0 714 21 0 21 21 0 8 0
pfstitem 24 374 0 349 1 0 1 1 0 8 0
pfstkey 128 374 0 349 3 1 2 2 0 8 0
pfstate 376 374 0 349 13 9 4 5 0 8 0
pfrule 1344 21 0 16 2 1 1 2 0 8 0
rttmr 136 1 0 1 1 1 0 1 0 8 0
art_heap8 4096 2 0 1 2 1 1 2 0 8 0
art_heap4 256 1939 0 1562 52 25 27 31 0 8 0
art_table 32 1941 0 1563 4 0 4 4 0 8 0
art_node 16 521 0 449 1 0 1 1 0 8 0
sysvmsgpl 40 26 0 26 2 2 0 1 0 8 0
semupl 112 2 0 2 1 1 0 1 0 8 0
semapl 112 1358 0 1348 1 0 1 1 0 8 0
shmpl 112 135 0 7 4 0 4 4 0 8 0
dirhash 1024 63 0 46 3 0 3 3 0 8 0
dino2pl 256 17013 0 15509 95 0 95 95 0 8 0
ffsino 272 17013 0 15509 101 0 101 101 0 8 0
nchpl 144 33715 0 32068 64 0 64 64 0 8 0
uvmvnodes 80 6619 0 0 136 0 136 136 0 8 0
vnodes 216 6619 0 0 368 0 368 368 0 8 0
namei 1024 114230 0 114230 16 15 1 2 0 8 1
percpumem 16 151 0 105 1 0 1 1 0 8 0
vcpupl 2048 90 0 1 12 0 12 12 0 8 0
vmpool 696 116 0 27 11 2 9 9 0 8 0
kstatmem 264 234 0 210 7 5 2 3 0 8 0
scxspl 216 120688 0 120687 25 24 1 8 1 8 0
plimitpl 152 1869 0 1853 1 0 1 1 0 8 0
sigapl 424 11998 0 11934 14 5 9 9 0 8 0
futexpl 64 102392 0 102392 4 3 1 1 0 8 1
knotepl 120 803 0 0 16 5 11 11 0 8 0
kqueuepl 216 2189 0 2181 34 33 1 8 0 8 0
pipepl 320 2042 0 2014 61 53 8 8 0 8 5
fdescpl 496 11957 0 11933 10 6 4 5 0 8 0
filepl 152 71817 0 71576 128 113 15 24 0 8 2
lockfpl 104 2839 0 2837 7 6 1 3 0 8 0
lockfspl 48 717 0 715 1 0 1 1 0 8 0
sessionpl 144 58 0 41 1 0 1 1 0 8 0
pgrppl 48 241 0 224 1 0 1 1 0 8 0
ucredpl 104 9534 0 9516 1 0 1 1 0 8 0
zombiepl 144 11935 0 11934 3 2 1 1 0 8 0
processpl 1136 11998 0 11934 6 0 6 6 0 8 0
procpl 680 29651 0 29572 11 2 9 10 0 8 0
srpgc 96 50 0 50 17 16 1 1 0 8 1
sosppl 168 181 0 178 10 9 1 1 0 8 0
sockpl 584 20274 0 20243 212 201 11 20 0 8 8
mcl64k 65536 11 0 0 2 0 2 2 0 8 0
mcl16k 16384 12 0 0 2 0 2 2 0 8 0
mcl12k 12288 6 0 0 1 0 1 1 0 8 0
mcl9k 9216 5 0 0 1 0 1 1 0 8 0
mcl8k 8192 12 0 0 2 0 2 2 0 8 0
mcl4k 4096 14 0 0 2 0 2 2 0 8 0
mcl2k2 2112 3 0 0 1 0 1 1 0 8 0
mcl2k 2048 344 0 0 33 9 24 33 0 8 0
mtagpl 96 108 0 0 3 0 3 3 0 8 0
mbufpl 256 3945 0 0 214 0 214 214 0 8 0
bufpl 280 25902 0 19279 474 0 474 474 0 8 0
anonpl 24 1236454 0 1222318 353 188 165 165 0 186 53
amapchunkpl 152 355114 0 354326 162 95 67 67 0 158 22
amappl16 200 22699 0 22205 89 61 28 39 0 8 0
amappl15 192 19 0 19 2 2 0 1 0 8 0
amappl14 184 281 0 262 2 1 1 2 0 8 0
amappl13 176 41 0 40 1 0 1 1 0 8 0
amappl12 168 13132 0 13107 3 1 2 2 0 8 0
amappl11 160 59 0 45 1 0 1 1 0 8 0
amappl10 152 68 0 56 1 0 1 1 0 8 0
amappl9 144 245 0 245 22 22 0 1 0 8 0
amappl8 136 644 0 517 6 1 5 5 0 8 0
amappl7 128 316 0 286 2 0 2 2 0 8 0
amappl6 120 818 0 793 1 0 1 1 0 8 0
amappl5 112 344 0 333 1 0 1 1 0 8 0
amappl4 104 843 0 811 2 0 2 2 0 8 0
amappl3 96 69122 0 69054 5 2 3 4 0 8 0
amappl2 88 12960 0 12880 3 1 2 3 0 8 0
amappl1 80 53440 0 52897 23 10 13 23 0 8 0
amappl 88 109684 0 109453 7 0 7 7 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 137 0 7 3 0 3 3 0 8 0
uaddrrnd 24 12073 0 11960 1 0 1 1 0 8 0
uaddrbest 32 2 0 0 1 0 1 1 0 8 0
uaddr 24 12073 0 11960 1 0 1 1 0 8 0
vmmpekpl 168 83538 0 83467 4 0 4 4 0 8 0
vmmpepl 168 709514 0 707172 391 252 139 146 0 357 11
vmsppl 448 12072 0 11960 17 3 14 14 0 8 0
rwobjpl 56 171518 0 163110 127 7 120 123 0 8 0
pdppl 4096 24153 0 24009 559 401 158 158 0 8 14
pvpl 32 43950 0 0 355 1 354 354 0 265 0
pmappl 248 12072 0 11960 10 2 8 8 0 8 0
extentpl 40 56 0 38 1 0 1 1 0 8 0
phpool 112 1481 0 794 20 0 20 20 0 8 0
ddb{0}> machine ddbcpu 0
Invalid cpu 0
ddb{0}> trace
db_enter() at db_enter+0x1c sys/arch/amd64/amd64/db_interface.c:437
panic(ffffffff8291b09d) at panic+0x17b sys/kern/subr_prf.c:198
softclock(0) at softclock+0x22d sys/kern/kern_timeout.c:759
softintr_dispatch(0) at softintr_dispatch+0xfb sys/arch/amd64/amd64/softintr.c:90
Xsoftclock() at Xsoftclock+0x27
acpicpu_idle() at acpicpu_idle+0x312 sys/dev/acpi/acpicpu.c:1206
sched_idle(ffffffff82d21ff0) at sched_idle+0x41e sys/kern/kern_sched.c:183
end trace frame: 0x0, count: -7
ddb{0}> machine ddbcpu 1
Stopped at x86_ipi_db+0x1e: addq $0x8,%rsp
x86_ipi_db(ffff800029cebff0) at x86_ipi_db+0x1e 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+0x27
acpicpu_idle() at acpicpu_idle+0x312 sys/dev/acpi/acpicpu.c:1206
sched_idle(ffff800029cebff0) at sched_idle+0x41e sys/kern/kern_sched.c:183
end trace frame: 0x0, count: 10
ddb{1}> trace
x86_ipi_db(ffff800029cebff0) at x86_ipi_db+0x1e 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+0x27
acpicpu_idle() at acpicpu_idle+0x312 sys/dev/acpi/acpicpu.c:1206
sched_idle(ffff800029cebff0) at sched_idle+0x41e sys/kern/kern_sched.c:183
end trace frame: 0x0, count: -5


---
This report 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 issue. See:
https://goo.gl/tpsmEJ#status for how to communicate with syzbot.

If the report is already addressed, let syzbot know by replying with:
#syz fix: exact-commit-title

If you want to overwrite report's subsystems, reply with:
#syz set subsystems: new-subsystem
(See the list of subsystem names on the web dashboard)

If the report is a duplicate of another one, reply with:
#syz dup: exact-subject-of-another-report

If you want to undo deduplication, reply with:
#syz undup
Reply all
Reply to author
Forward
0 new messages