syzbot


INFO: rcu detected stall in sys_perf_event_open (2)

Status: closed as invalid on 2019/12/04 14:14
Subsystems: perf
[Documentation on labels]
First crash: 1606d, last: 1604d
Similar bugs (5)
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
linux-5.15 INFO: rcu detected stall in sys_perf_event_open (2) origin:lts-only C error 1 108d 107d 0/3 upstream: reported C repro on 2024/01/09 18:19
upstream INFO: rcu detected stall in sys_perf_event_open (3) perf 1 1570d 1570d 0/26 closed as invalid on 2020/01/08 05:23
upstream INFO: rcu detected stall in sys_perf_event_open (4) perf 1 1569d 1569d 0/26 closed as invalid on 2020/01/09 08:13
linux-5.15 INFO: rcu detected stall in sys_perf_event_open 1 373d 373d 0/3 auto-obsoleted due to no activity on 2023/08/17 04:33
upstream INFO: rcu detected stall in sys_perf_event_open perf 1 2049d 2047d 0/26 auto-closed as invalid on 2019/03/14 17:19

Sample crash report:
rcu: INFO: rcu_preempt detected stalls on CPUs/tasks:
	(detected by 1, t=10502 jiffies, g=6361, q=241)
rcu: All QSes seen, last rcu_preempt kthread activity 10503 (4294953722-4294943219), jiffies_till_next_fqs=1, root ->qsmask 0x0
syz-executor.0  R  running task    25680  8234   8211 0x0000400e
Call Trace:
 <IRQ>
 sched_show_task+0x40f/0x560 kernel/sched/core.c:5954
 print_other_cpu_stall kernel/rcu/tree_stall.h:410 [inline]
 check_cpu_stall kernel/rcu/tree_stall.h:538 [inline]
 rcu_pending kernel/rcu/tree.c:2827 [inline]
 rcu_sched_clock_irq+0x1861/0x1ad0 kernel/rcu/tree.c:2271
 update_process_times+0x12d/0x180 kernel/time/timer.c:1726
 tick_sched_handle kernel/time/tick-sched.c:167 [inline]
 tick_sched_timer+0x263/0x420 kernel/time/tick-sched.c:1310
 __run_hrtimer kernel/time/hrtimer.c:1517 [inline]
 __hrtimer_run_queues+0x403/0x840 kernel/time/hrtimer.c:1579
 hrtimer_interrupt+0x38c/0xda0 kernel/time/hrtimer.c:1641
 local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1110 [inline]
 smp_apic_timer_interrupt+0x109/0x280 arch/x86/kernel/apic/apic.c:1135
 apic_timer_interrupt+0xf/0x20 arch/x86/entry/entry_64.S:829
 </IRQ>
RIP: 0010:__sanitizer_cov_trace_pc+0x31/0x50 kernel/kcov.c:107
Code: 0c 25 c0 1d 02 00 65 8b 15 38 84 8b 7e f7 c2 00 01 1f 00 75 2c 8b 91 80 13 00 00 83 fa 02 75 21 48 8b 91 88 13 00 00 48 8b 32 <48> 8d 7e 01 8b 89 84 13 00 00 48 39 cf 73 08 48 89 44 f2 08 48 89
RSP: 0018:ffffc90002417a08 EFLAGS: 00000246 ORIG_RAX: ffffffffffffff13
RAX: ffffffff81487326 RBX: ffffea00029ebd00 RCX: ffff8880a8d02080
RDX: ffffc900021ba000 RSI: 000000000003ffff RDI: ffffea00029ebd00
RBP: ffffc90002417a30 R08: dffffc0000000000 R09: fffffbfff1287a8d
R10: fffffbfff1287a8d R11: 0000000000000000 R12: ffff8880921767a0
R13: dffffc0000000000 R14: 00000000fffffffc R15: ffff8880961d5828
 free_thread_stack+0x168/0x590 kernel/fork.c:280
 release_task_stack kernel/fork.c:440 [inline]
 put_task_stack+0xa3/0x130 kernel/fork.c:451
 finish_task_switch+0x3f1/0x550 kernel/sched/core.c:3256
 context_switch kernel/sched/core.c:3388 [inline]
 __schedule+0x9a8/0xcc0 kernel/sched/core.c:4081
 schedule+0x181/0x210 kernel/sched/core.c:4155
 schedule_preempt_disabled+0x13/0x20 kernel/sched/core.c:4214
 __mutex_lock_common+0x1411/0x2e10 kernel/locking/mutex.c:1036
 __mutex_lock kernel/locking/mutex.c:1106 [inline]
 mutex_lock_interruptible_nested+0x1b/0x30 kernel/locking/mutex.c:1143
 __do_sys_perf_event_open kernel/events/core.c:11257 [inline]
 __se_sys_perf_event_open+0xb66/0x41c0 kernel/events/core.c:11151
 __x64_sys_perf_event_open+0xbf/0xd0 kernel/events/core.c:11151
 do_syscall_64+0xf7/0x1c0 arch/x86/entry/common.c:294
 entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x45a679
Code: ad b6 fb ff c3 66 2e 0f 1f 84 00 00 00 00 00 66 90 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 0f 83 7b b6 fb ff c3 66 2e 0f 1f 84 00 00 00 00
RSP: 002b:00007f5304681c78 EFLAGS: 00000246 ORIG_RAX: 000000000000012a
RAX: ffffffffffffffda RBX: 0000000000000005 RCX: 000000000045a679
RDX: ffffffffffffffff RSI: 0000000000000000 RDI: 0000000020000180
RBP: 000000000075bfc8 R08: 0000000000000000 R09: 0000000000000000
R10: ffffffffffffffff R11: 0000000000000246 R12: 00007f53046826d4
R13: 00000000004c84e1 R14: 00000000004df940 R15: 00000000ffffffff
rcu: rcu_preempt kthread starved for 10536 jiffies! g6361 f0x2 RCU_GP_WAIT_FQS(5) ->state=0x0 ->cpu=0
rcu: RCU grace-period kthread stack dump:
rcu_preempt     R  running task    29032    10      2 0x80004008
Call Trace:
 context_switch kernel/sched/core.c:3388 [inline]
 __schedule+0x9a8/0xcc0 kernel/sched/core.c:4081
 schedule+0x181/0x210 kernel/sched/core.c:4155
 schedule_timeout+0x14f/0x240 kernel/time/timer.c:1895
 rcu_gp_fqs_loop kernel/rcu/tree.c:1661 [inline]
 rcu_gp_kthread+0xed8/0x1770 kernel/rcu/tree.c:1821
 kthread+0x332/0x350 kernel/kthread.c:255
 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:352

Crashes (8):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2019/12/04 09:29 upstream 63de37476ebd 0ecb9746 .config console log report ci-upstream-kasan-gce-smack-root
2019/12/04 06:23 upstream 76bb8b05960c ae13a849 .config console log report ci-upstream-kasan-gce-smack-root
2019/12/04 02:51 upstream 76bb8b05960c ae13a849 .config console log report ci-upstream-kasan-gce-smack-root
2019/12/04 01:29 upstream 76bb8b05960c ae13a849 .config console log report ci-upstream-kasan-gce-smack-root
2019/12/03 23:50 upstream 76bb8b05960c ae13a849 .config console log report ci-upstream-kasan-gce-smack-root
2019/12/03 20:50 upstream 76bb8b05960c ae13a849 .config console log report ci-upstream-kasan-gce-smack-root
2019/12/03 00:37 upstream 596cf45cbf6e ab342da3 .config console log report ci-upstream-kasan-gce-smack-root
2019/12/02 20:59 upstream 596cf45cbf6e ab342da3 .config console log report ci-upstream-kasan-gce-smack-root
* Struck through repros no longer work on HEAD.