syzbot


BUG: soft lockup in discover_timer

Status: auto-closed as invalid on 2022/04/13 00:08
Reported-by: syzbot+be6bb7e248ae86e53d6e@syzkaller.appspotmail.com
First crash: 195d, last: 195d
similar bugs (1):
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
upstream BUG: soft lockup in discover_timer 2 939d 940d 0/22 closed as invalid on 2019/11/30 16:49

Sample crash report:
watchdog: BUG: soft lockup - CPU#0 stuck for 22s! [syz-executor.5:9514]
Modules linked in:
irq event stamp: 4536185
hardirqs last  enabled at (4536184): [<ffffffff87400976>] restore_regs_and_return_to_kernel+0x0/0x2a
hardirqs last disabled at (4536185): [<ffffffff874018ae>] apic_timer_interrupt+0x8e/0xa0 arch/x86/entry/entry_64.S:793
softirqs last  enabled at (106774): [<ffffffff8760068b>] __do_softirq+0x68b/0x9ff kernel/softirq.c:314
softirqs last disabled at (107459): [<ffffffff81321d13>] invoke_softirq kernel/softirq.c:368 [inline]
softirqs last disabled at (107459): [<ffffffff81321d13>] irq_exit+0x193/0x240 kernel/softirq.c:409
CPU: 0 PID: 9514 Comm: syz-executor.5 Not tainted 4.14.257-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
task: ffff8880726e4580 task.stack: ffff888072720000
RIP: 0010:on_stack arch/x86/include/asm/stacktrace.h:42 [inline]
RIP: 0010:stack_access_ok arch/x86/kernel/unwind_orc.c:276 [inline]
RIP: 0010:deref_stack_reg+0xaa/0x1a0 arch/x86/kernel/unwind_orc.c:286
RSP: 0018:ffff8880ba407778 EFLAGS: 00000246 ORIG_RAX: ffffffffffffff10
RAX: dffffc0000000000 RBX: 1ffff11017480ef0 RCX: ffffffff8a6d218c
RDX: ffff8880ba4078c0 RSI: ffff8880ba407f28 RDI: ffff8880ba4078c0
RBP: ffff8880ba407f28 R08: ffffffff8a6d2190 R09: ffffffff8a6d2191
R10: 0000000000010d4a R11: 0000000000000001 R12: ffff8880ba4078b0
R13: ffff8880ba4078f8 R14: ffff8880ba400000 R15: ffff8880ba4078b0
FS:  00007ffaa0be9700(0000) GS:ffff8880ba400000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000000020000040 CR3: 0000000094012000 CR4: 00000000003406f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 <IRQ>
 unwind_next_frame+0xc98/0x17d0 arch/x86/kernel/unwind_orc.c:425
 __save_stack_trace+0x90/0x160 arch/x86/kernel/stacktrace.c:44
 save_stack mm/kasan/kasan.c:447 [inline]
 set_track mm/kasan/kasan.c:459 [inline]
 kasan_kmalloc+0xeb/0x160 mm/kasan/kasan.c:551
 slab_post_alloc_hook mm/slab.h:442 [inline]
 slab_alloc_node mm/slab.c:3333 [inline]
 kmem_cache_alloc_node_trace+0x13d/0x400 mm/slab.c:3659
 __do_kmalloc_node mm/slab.c:3681 [inline]
 __kmalloc_node_track_caller+0x38/0x70 mm/slab.c:3696
 __kmalloc_reserve net/core/skbuff.c:137 [inline]
 __alloc_skb+0x96/0x510 net/core/skbuff.c:205
 alloc_skb include/linux/skbuff.h:980 [inline]
 new_skb+0x24/0x1c0 drivers/block/aoe/aoecmd.c:67
 aoecmd_cfg_pkts drivers/block/aoe/aoecmd.c:427 [inline]
 aoecmd_cfg+0x15b/0x560 drivers/block/aoe/aoecmd.c:1392
 discover_timer+0xc5/0x160 drivers/block/aoe/aoemain.c:44
 call_timer_fn+0x14a/0x650 kernel/time/timer.c:1280
 expire_timers+0x232/0x4d0 kernel/time/timer.c:1319
 __run_timers kernel/time/timer.c:1637 [inline]
 run_timer_softirq+0x1d5/0x5a0 kernel/time/timer.c:1650
 __do_softirq+0x24d/0x9ff kernel/softirq.c:288
 invoke_softirq kernel/softirq.c:368 [inline]
 irq_exit+0x193/0x240 kernel/softirq.c:409
 exiting_irq arch/x86/include/asm/apic.h:638 [inline]
 smp_apic_timer_interrupt+0x141/0x5e0 arch/x86/kernel/apic/apic.c:1106
 apic_timer_interrupt+0x93/0xa0 arch/x86/entry/entry_64.S:793
 </IRQ>
RIP: 0010:clear_page_erms+0x7/0x10 arch/x86/lib/clear_page_64.S:50
RSP: 0018:ffff888072727620 EFLAGS: 00010246 ORIG_RAX: ffffffffffffff10
RAX: 0000000000000000 RBX: ffff888000000000 RCX: 0000000000000540
RDX: 1ffff1100e4dcaf7 RSI: 00000000ffffffff RDI: ffff888070e19ac0
RBP: 0000000000000019 R08: 0000000000037b28 R09: 0000000000000008
R10: ffffffffffffffe8 R11: ffff8880726e4580 R12: ffff8880726e4580
R13: ffffea0001c38000 R14: 0000000000000000 R15: dffffc0000000000
 clear_page arch/x86/include/asm/page_64.h:45 [inline]
 clear_user_page arch/x86/include/asm/page.h:28 [inline]
 clear_user_highpage include/linux/highmem.h:137 [inline]
 clear_huge_page+0x114/0x7b0 mm/memory.c:4730
 __do_huge_pmd_anonymous_page mm/huge_memory.c:574 [inline]
 do_huge_pmd_anonymous_page+0x93b/0x1700 mm/huge_memory.c:731
 create_huge_pmd mm/memory.c:3984 [inline]
 __handle_mm_fault+0x2ac4/0x4620 mm/memory.c:4187
 handle_mm_fault+0x455/0x9c0 mm/memory.c:4253
 __do_page_fault+0x549/0xad0 arch/x86/mm/fault.c:1442
 page_fault+0x25/0x50 arch/x86/entry/entry_64.S:1123
RIP: 0010:__clear_user+0x3d/0x60 arch/x86/lib/usercopy_64.c:23
RSP: 0018:ffff888072727a18 EFLAGS: 00050206
RAX: 0000000000000000 RBX: 0000000000000200 RCX: 000000000000008b
RDX: 0000000000000000 RSI: 0000000000000008 RDI: 0000000020bfffff
RBP: 0000000020bff457 R08: ffffffff8b99dbe8 R09: 0000000000000000
R10: 0000000000000000 R11: ffff8880726e4580 R12: 0000000020bff457
R13: 0000000020c00457 R14: 0000000000000000 R15: 0000000000001000
 clear_user+0x74/0xb0 arch/x86/lib/usercopy_64.c:53
 iov_iter_zero+0x1c7/0xcc0 lib/iov_iter.c:776
 read_iter_zero+0xb8/0x180 drivers/char/mem.c:710
 call_read_iter include/linux/fs.h:1774 [inline]
 do_iter_readv_writev+0x41d/0x5f0 fs/read_write.c:673
 do_iter_read+0x21d/0x5b0 fs/read_write.c:917
 vfs_readv+0xc8/0x120 fs/read_write.c:981
 do_readv+0xfc/0x2c0 fs/read_write.c:1014
 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292
 entry_SYSCALL_64_after_hwframe+0x46/0xbb
RIP: 0033:0x7ffaa2273e99
RSP: 002b:00007ffaa0be9168 EFLAGS: 00000246 ORIG_RAX: 0000000000000013
RAX: ffffffffffffffda RBX: 00007ffaa2386f60 RCX: 00007ffaa2273e99
RDX: 000000000000000a RSI: 0000000020001900 RDI: 0000000000000005
RBP: 00007ffaa22cdff1 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffcc0e5468f R14: 00007ffaa0be9300 R15: 0000000000022000
Code: fc ff df 48 89 fa 48 c1 ea 03 80 3c 02 00 0f 85 e6 00 00 00 49 8d 7c 24 10 4d 8b 74 24 08 48 b8 00 00 00 00 00 fc ff df 48 89 fa <48> c1 ea 03 80 3c 02 00 0f 85 b7 00 00 00 49 39 ee 49 8b 44 24 
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 9546 Comm: syz-executor.3 Not tainted 4.14.257-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
task: ffff888072a60680 task.stack: ffff888072a68000
RIP: 0010:match_held_lock kernel/locking/lockdep.c:3559 [inline]
RIP: 0010:find_held_lock+0x37/0x210 kernel/locking/lockdep.c:3603
RSP: 0018:ffff8880ba507a28 EFLAGS: 00000002
RAX: dffffc0000000000 RBX: 0000000000000004 RCX: ffff8880ba507a98
RDX: ffff888072a60f90 RSI: ffffffff88f77980 RDI: ffff888072a60f90
RBP: ffffffff88f77980 R08: 0000000000000001 R09: 0000000000000001
R10: 0000000000000000 R11: ffff888072a60680 R12: ffff888072a60f80
R13: 0000000000000003 R14: ffff8880ba507a98 R15: ffffffff88f77980
FS:  00007f09da853700(0000) GS:ffff8880ba500000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000000020fb1000 CR3: 00000000aba99000 CR4: 00000000003406e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 <IRQ>
 __lock_release kernel/locking/lockdep.c:3767 [inline]
 lock_release+0x237/0x870 kernel/locking/lockdep.c:4017
 rcu_lock_release include/linux/rcupdate.h:247 [inline]
 rcu_read_unlock include/linux/rcupdate.h:685 [inline]
 __perf_event_output kernel/events/core.c:6292 [inline]
 perf_event_output_backward+0x143/0x1f0 kernel/events/core.c:6308
 __perf_event_overflow+0x113/0x310 kernel/events/core.c:7549
 perf_swevent_hrtimer+0x220/0x350 kernel/events/core.c:8754
 __run_hrtimer kernel/time/hrtimer.c:1223 [inline]
 __hrtimer_run_queues+0x30b/0xc80 kernel/time/hrtimer.c:1287
 hrtimer_interrupt+0x1e6/0x5e0 kernel/time/hrtimer.c:1321
 local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1079 [inline]
 smp_apic_timer_interrupt+0x117/0x5e0 arch/x86/kernel/apic/apic.c:1104
 apic_timer_interrupt+0x93/0xa0 arch/x86/entry/entry_64.S:793
 </IRQ>
RIP: 0010:perf_output_sample_regs+0xe/0xf0 kernel/events/core.c:5633
RSP: 0018:ffff888072a6f350 EFLAGS: 00000246 ORIG_RAX: ffffffffffffff10
RAX: dffffc0000000000 RBX: 0000000000000000 RCX: 1ffff1100e54deef
RDX: 0000000000400001 RSI: ffff888072a6f968 RDI: ffff888072a6f4a8
RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed101485d4d8
R10: ffff8880a42ea6c7 R11: 0000000000000000 R12: ffff888072a6f4a8
R13: ffff888072a60680 R14: dffffc0000000000 R15: 00000000000006b8
 perf_output_sample+0x1205/0x16f0 kernel/events/core.c:6086
 __perf_event_output kernel/events/core.c:6287 [inline]
 perf_event_output_backward+0xf8/0x1f0 kernel/events/core.c:6308
 __perf_event_overflow+0x113/0x310 kernel/events/core.c:7549
 perf_swevent_overflow kernel/events/core.c:7625 [inline]
 perf_swevent_event+0x299/0x460 kernel/events/core.c:7653
 do_perf_sw_event kernel/events/core.c:7766 [inline]
 ___perf_sw_event+0x2a1/0x480 kernel/events/core.c:7797
 __perf_sw_event+0x4f/0x100 kernel/events/core.c:7809
 perf_sw_event include/linux/perf_event.h:1046 [inline]
 __do_page_fault+0x5e6/0xad0 arch/x86/mm/fault.c:1348
 page_fault+0x25/0x50 arch/x86/entry/entry_64.S:1123
RIP: 0010:__clear_user+0x3d/0x60 arch/x86/lib/usercopy_64.c:23
RSP: 0018:ffff888072a6fa18 EFLAGS: 00050206
RAX: 0000000000000000 RBX: 0000000000000200 RCX: 000000000000008b
RDX: 0000000000000000 RSI: 0000000000000008 RDI: 0000000020fb0fff
RBP: 0000000020fb0457 R08: ffffffff8b99dbe8 R09: 0000000000000000
R10: 0000000000000000 R11: ffff888072a60680 R12: 0000000020fb0457
R13: 0000000020fb1457 R14: 0000000000000000 R15: 0000000000001000
 clear_user+0x74/0xb0 arch/x86/lib/usercopy_64.c:53
 iov_iter_zero+0x1c7/0xcc0 lib/iov_iter.c:776
 read_iter_zero+0xb8/0x180 drivers/char/mem.c:710
 call_read_iter include/linux/fs.h:1774 [inline]
 do_iter_readv_writev+0x41d/0x5f0 fs/read_write.c:673
 do_iter_read+0x21d/0x5b0 fs/read_write.c:917
 vfs_readv+0xc8/0x120 fs/read_write.c:981
 do_readv+0xfc/0x2c0 fs/read_write.c:1014
 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292
 entry_SYSCALL_64_after_hwframe+0x46/0xbb
RIP: 0033:0x7f09dbedde99
RSP: 002b:00007f09da853168 EFLAGS: 00000246 ORIG_RAX: 0000000000000013
RAX: ffffffffffffffda RBX: 00007f09dbff0f60 RCX: 00007f09dbedde99
RDX: 000000000000000a RSI: 0000000020001900 RDI: 0000000000000005
RBP: 00007f09dbf37ff1 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffe3577a0cf R14: 00007f09da853300 R15: 0000000000022000
Code: 44 8d 6a ff 49 63 c5 41 54 48 8d 04 80 55 4c 8d a4 c7 88 08 00 00 53 89 d3 48 b8 00 00 00 00 00 fc ff df 49 8d 7c 24 10 48 89 fa <48> c1 ea 03 80 3c 02 00 0f 85 b8 01 00 00 4d 3b 7c 24 10 0f 84 
----------------
Code disassembly (best guess), 2 bytes skipped:
   0:	df 48 89             	fisttps -0x77(%rax)
   3:	fa                   	cli
   4:	48 c1 ea 03          	shr    $0x3,%rdx
   8:	80 3c 02 00          	cmpb   $0x0,(%rdx,%rax,1)
   c:	0f 85 e6 00 00 00    	jne    0xf8
  12:	49 8d 7c 24 10       	lea    0x10(%r12),%rdi
  17:	4d 8b 74 24 08       	mov    0x8(%r12),%r14
  1c:	48 b8 00 00 00 00 00 	movabs $0xdffffc0000000000,%rax
  23:	fc ff df
  26:	48 89 fa             	mov    %rdi,%rdx
* 29:	48 c1 ea 03          	shr    $0x3,%rdx <-- trapping instruction
  2d:	80 3c 02 00          	cmpb   $0x0,(%rdx,%rax,1)
  31:	0f 85 b7 00 00 00    	jne    0xee
  37:	49 39 ee             	cmp    %rbp,%r14
  3a:	49                   	rex.WB
  3b:	8b                   	.byte 0x8b
  3c:	44                   	rex.R
  3d:	24                   	.byte 0x24

Crashes (1):
Manager Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Title
ci2-linux-4-14 2021/12/14 00:08 linux-4.14.y c01d4d1b885d 5d14b1ea .config log report info BUG: soft lockup in discover_timer