syzbot


INFO: rcu detected stall in sys_perf_event_open

Status: auto-closed as invalid on 2019/03/14 17:19
Subsystems: perf
[Documentation on labels]
Reported-by: syzbot+d2b5c4f404959013eb50@syzkaller.appspotmail.com
First crash: 2269d, last: 2269d
Similar bugs (7)
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 2 60d 326d 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 1789d 1789d 0/28 closed as invalid on 2020/01/08 05:23
upstream INFO: rcu detected stall in sys_perf_event_open (4) perf 1 1789d 1789d 0/28 closed as invalid on 2020/01/09 08:13
upstream INFO: rcu detected stall in sys_perf_event_open (2) perf 8 1824d 1825d 0/28 closed as invalid on 2019/12/04 14:14
linux-6.1 INFO: rcu detected stall in sys_perf_event_open (2) origin:lts-only syz 2 9d14h 69d 0/3 upstream: reported syz repro on 2024/09/23 05:55
linux-6.1 INFO: rcu detected stall in sys_perf_event_open 1 173d 173d 0/3 auto-obsoleted due to no activity on 2024/09/19 01:45
linux-5.15 INFO: rcu detected stall in sys_perf_event_open 1 592d 592d 0/3 auto-obsoleted due to no activity on 2023/08/17 04:33

Sample crash report:
rcu: INFO: rcu_sched detected stalls on CPUs/tasks:
rcu: 	0-....: (10501 ticks this GP) idle=c86/1/0x4000000000000002 softirq=126005/126006 fqs=5249 
rcu: 	(detected by 1, t=10502 jiffies, g=50541, q=2)
Sending NMI from CPU 1 to CPUs 0:
INFO: NMI handler (nmi_cpu_backtrace_handler) took too long to run: 2.253 msecs
NMI backtrace for cpu 0
CPU: 0 PID: 2425 Comm: syz-executor2 Not tainted 4.19.0-rc2+ #96
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
RIP: 0010:arch_atomic_inc arch/x86/include/asm/atomic.h:98 [inline]
RIP: 0010:atomic_inc include/asm-generic/atomic-instrumented.h:110 [inline]
RIP: 0010:__lock_acquire+0x2a8/0x4ec0 kernel/locking/lockdep.c:3304
Code: 08 48 85 db 0f 84 27 ff ff ff 48 8d bb 38 01 00 00 be 04 00 00 00 44 89 84 24 88 00 00 00 e8 ff 8e 61 00 f0 ff 83 38 01 00 00 <49> 8d 86 78 08 00 00 44 8b 84 24 88 00 00 00 48 89 c2 48 89 44 24
RSP: 0018:ffff8801dac074b0 EFLAGS: 00000006
RAX: fffffbfff161b758 RBX: ffffffff8b0db980 RCX: ffffffff816083b1
RDX: 0000000000000001 RSI: 0000000000000004 RDI: ffffffff8b0dbab8
RBP: ffff8801dac07838 R08: fffffbfff161b758 R09: fffffbfff161b757
R10: fffffbfff161b757 R11: ffffffff8b0dbabb R12: 0000000000000001
R13: ffffffff8b6e3700 R14: ffff88019d5242c0 R15: 0000000000000000
FS:  00007f1b67b74700(0000) GS:ffff8801dac00000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000000100000000 CR3: 00000001bc44c000 CR4: 00000000001406f0
DR0: 0000000020000080 DR1: 0000000020000080 DR2: 0000000020000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000600
Call Trace:
 <IRQ>
 lock_acquire+0x1ed/0x520 kernel/locking/lockdep.c:3901
 __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline]
 _raw_spin_lock_irqsave+0x99/0xd0 kernel/locking/spinlock.c:152
 debug_object_activate+0x1d4/0x600 lib/debugobjects.c:473
 debug_hrtimer_activate kernel/time/hrtimer.c:416 [inline]
 debug_activate kernel/time/hrtimer.c:465 [inline]
 enqueue_hrtimer+0x97/0x560 kernel/time/hrtimer.c:954
 __run_hrtimer kernel/time/hrtimer.c:1413 [inline]
 __hrtimer_run_queues+0xcdc/0x10d0 kernel/time/hrtimer.c:1460
 hrtimer_interrupt+0x313/0x780 kernel/time/hrtimer.c:1518
 local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1029 [inline]
 smp_apic_timer_interrupt+0x1a1/0x760 arch/x86/kernel/apic/apic.c:1054
 apic_timer_interrupt+0xf/0x20 arch/x86/entry/entry_64.S:864
 </IRQ>
RIP: 0010:write_comp_data+0x19/0x70 kernel/kcov.c:116
Code: ef c9 ff 90 90 90 90 90 90 90 90 90 90 90 90 90 90 55 65 4c 8b 04 25 40 ee 01 00 65 8b 05 ff 1e 83 7e a9 00 01 1f 00 48 89 e5 <75> 51 41 8b 80 d0 12 00 00 83 f8 03 75 45 49 8b 80 d8 12 00 00 45
RSP: 0018:ffff8801a2ad7098 EFLAGS: 00000246 ORIG_RAX: ffffffffffffff13
RAX: 0000000000000001 RBX: 0000000000000001 RCX: ffffffff83904d6a
RDX: 0000000000000001 RSI: 0000000000000000 RDI: 0000000000000005
RBP: ffff8801a2ad7098 R08: ffff88019d5242c0 R09: ffffed0034752ce3
R10: ffffed0034752ce3 R11: ffff8801a3a9671b R12: 0000000000000000
R13: ffffffff8864a0c0 R14: ffffffff8831e5e0 R15: 0000000000000000
 __sanitizer_cov_trace_const_cmp4+0x16/0x20 kernel/kcov.c:188
 check_preemption_disabled+0x3a/0x200 lib/smp_processor_id.c:15
 __this_cpu_preempt_check+0x1c/0x1f lib/smp_processor_id.c:62
 __perf_event_account_interrupt+0x28/0x2d0 kernel/events/core.c:7696
 __perf_event_overflow+0x164/0x4c0 kernel/events/core.c:7748
 perf_swevent_overflow+0xad/0x150 kernel/events/core.c:7839
 perf_swevent_event+0x153/0x2e0 kernel/events/core.c:7877
 perf_tp_event+0x4dc/0xbe0 kernel/events/core.c:8295
 perf_trace_run_bpf_submit+0x267/0x330 kernel/events/core.c:8269
 perf_trace_kmem_alloc+0xe6/0x110 include/trace/events/kmem.h:12
 trace_kmem_cache_alloc include/trace/events/kmem.h:54 [inline]
 kmem_cache_alloc+0x25f/0x730 mm/slab.c:3555
 kmem_cache_zalloc include/linux/slab.h:697 [inline]
 __alloc_file+0xa8/0x470 fs/file_table.c:100
 alloc_empty_file+0x72/0x170 fs/file_table.c:150
 alloc_file+0x5e/0x4d0 fs/file_table.c:192
 alloc_file_pseudo+0x261/0x3f0 fs/file_table.c:231
 anon_inode_getfile+0xd7/0x1f0 fs/anon_inodes.c:87
 __do_sys_perf_event_open+0x177e/0x2f30 kernel/events/core.c:10620
 __se_sys_perf_event_open kernel/events/core.c:10389 [inline]
 __x64_sys_perf_event_open+0xbe/0x150 kernel/events/core.c:10389
 do_syscall_64+0x1b9/0x820 arch/x86/entry/common.c:290
 entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x4572d9
Code: fd b4 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 cb b4 fb ff c3 66 2e 0f 1f 84 00 00 00 00
RSP: 002b:00007f1b67b73c78 EFLAGS: 00000246 ORIG_RAX: 000000000000012a
RAX: ffffffffffffffda RBX: 00007f1b67b746d4 RCX: 00000000004572d9
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000020000000
RBP: 00000000009300a0 R08: 0000000000000000 R09: 0000000000000000
R10: ffffffffffffffff R11: 0000000000000246 R12: 00000000ffffffff
R13: 00000000004d4050 R14: 00000000004c8b05 R15: 0000000000000000
rcu: INFO: rcu_preempt detected stalls on CPUs/tasks:
rcu: 	0-....: (10584 ticks this GP) idle=c86/1/0x4000000000000000 softirq=126006/126006 fqs=5248 
rcu: 	(detected by 1, t=10502 jiffies, g=187809, q=797)
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 2425 Comm: syz-executor2 Not tainted 4.19.0-rc2+ #96
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
RIP: 0010:check_preemption_disabled+0x48/0x200 lib/smp_processor_id.c:51
Code: 65 8b 1d 7b a0 71 7c 81 e3 ff ff ff 7f 89 de 65 44 8b 25 cb 33 71 7c e8 d6 82 ee fd 85 db 74 1c e8 bd 81 ee fd e8 b8 81 ee fd <44> 89 e0 48 83 c4 08 5b 41 5c 41 5d 41 5e 41 5f 5d c3 e8 a1 81 ee
RSP: 0018:ffff8801dac07e18 EFLAGS: 00000046
RAX: 0000000000040000 RBX: 0000000000000001 RCX: ffffc90002262000
RDX: 0000000000040000 RSI: ffffffff83904d78 RDI: 0000000000000005
RBP: ffff8801dac07e48 R08: ffff88019d5242c0 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000
R13: ffffffff8864a080 R14: ffffffff8864a040 R15: 0000000000000000
FS:  00007f1b67b74700(0000) GS:ffff8801dac00000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000000100000000 CR3: 00000001bc44c000 CR4: 00000000001406f0
DR0: 0000000020000080 DR1: 0000000020000080 DR2: 0000000020000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000600
Call Trace:
 <IRQ>
 debug_smp_processor_id+0x1c/0x20 lib/smp_processor_id.c:56
 rcu_irq_enter+0xa/0x100 kernel/rcu/tree.c:987
 irq_enter+0xa/0xe0 kernel/softirq.c:346
 entering_irq arch/x86/include/asm/apic.h:517 [inline]
 entering_ack_irq arch/x86/include/asm/apic.h:523 [inline]
 smp_apic_timer_interrupt+0xaf/0x760 arch/x86/kernel/apic/apic.c:1052
 apic_timer_interrupt+0xf/0x20 arch/x86/entry/entry_64.S:864
 </IRQ>
RIP: 0010:__sanitizer_cov_trace_const_cmp8+0x13/0x20 kernel/kcov.c:195
Code: 00 48 89 e5 48 8b 4d 08 e8 6a fe ff ff 5d c3 0f 1f 84 00 00 00 00 00 55 48 89 f2 48 89 fe bf 07 00 00 00 48 89 e5 48 8b 4d 08 <e8> 48 fe ff ff 5d c3 66 0f 1f 44 00 00 55 48 89 e5 41 57 41 56 41
RSP: 0018:ffff8801a2ad6bf0 EFLAGS: 00000246 ORIG_RAX: ffffffffffffff13
RAX: 0000000000040000 RBX: 0000000000000001 RCX: ffffffff819a1305
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000007
RBP: ffff8801a2ad6bf0 R08: ffff88019d5242c0 R09: 1ffffffff12f43cd
R10: ffffed003b584732 R11: ffff8801dac23993 R12: 0000000000000088
R13: 0000000000000001 R14: 0000000000000000 R15: ffff8801a2ad7380
 __perf_output_begin kernel/events/ring_buffer.c:139 [inline]
 perf_output_begin_forward+0x235/0xdf0 kernel/events/ring_buffer.c:237
 __perf_event_output kernel/events/core.c:6503 [inline]
 perf_event_output_forward+0x156/0x2d0 kernel/events/core.c:6519
 __perf_event_overflow+0x239/0x4c0 kernel/events/core.c:7763
 perf_swevent_overflow+0xad/0x150 kernel/events/core.c:7839
 perf_swevent_event+0x153/0x2e0 kernel/events/core.c:7877
 perf_tp_event+0x4dc/0xbe0 kernel/events/core.c:8295
 perf_trace_run_bpf_submit+0x267/0x330 kernel/events/core.c:8269
 perf_trace_kmem_alloc+0xe6/0x110 include/trace/events/kmem.h:12
 trace_kmem_cache_alloc include/trace/events/kmem.h:54 [inline]
 kmem_cache_alloc+0x25f/0x730 mm/slab.c:3555
 kmem_cache_zalloc include/linux/slab.h:697 [inline]
 __alloc_file+0xa8/0x470 fs/file_table.c:100
 alloc_empty_file+0x72/0x170 fs/file_table.c:150
 alloc_file+0x5e/0x4d0 fs/file_table.c:192
 alloc_file_pseudo+0x261/0x3f0 fs/file_table.c:231
 anon_inode_getfile+0xd7/0x1f0 fs/anon_inodes.c:87
 __do_sys_perf_event_open+0x177e/0x2f30 kernel/events/core.c:10620
 __se_sys_perf_event_open kernel/events/core.c:10389 [inline]
 __x64_sys_perf_event_open+0xbe/0x150 kernel/events/core.c:10389
 do_syscall_64+0x1b9/0x820 arch/x86/entry/common.c:290
 entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x4572d9
Code: fd b4 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 cb b4 fb ff c3 66 2e 0f 1f 84 00 00 00 00
RSP: 002b:00007f1b67b73c78 EFLAGS: 00000246 ORIG_RAX: 000000000000012a
RAX: ffffffffffffffda RBX: 00007f1b67b746d4 RCX: 00000000004572d9
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000020000000
RBP: 00000000009300a0 R08: 0000000000000000 R09: 0000000000000000
R10: ffffffffffffffff R11: 0000000000000246 R12: 00000000ffffffff
R13: 00000000004d4050 R14: 00000000004c8b05 R15: 0000000000000000

Crashes (1):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2018/09/15 17:18 bpf-next 70e88c758a6b a343a400 .config console log report ci-upstream-bpf-next-kasan-gce
* Struck through repros no longer work on HEAD.