syzbot


INFO: rcu detected stall in timerfd_release (3)

Status: auto-obsoleted due to no activity on 2024/09/02 07:15
Subsystems: kernel
[Documentation on labels]
First crash: 292d, last: 249d
Similar bugs (4)
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
upstream INFO: rcu detected stall in timerfd_release (4) fs 3 109d 133d 0/28 auto-obsoleted due to no activity on 2025/01/20 14:31
upstream INFO: rcu detected stall in timerfd_release fs 2 1000d 1068d 0/28 auto-closed as invalid on 2022/08/12 21:39
upstream INFO: rcu detected stall in timerfd_release (2) fs 1 579d 579d 0/28 auto-obsoleted due to no activity on 2023/10/07 22:46
linux-6.1 INFO: rcu detected stall in timerfd_release 1 25d 25d 0/3 upstream: reported on 2025/01/14 16:10

Sample crash report:
rcu: INFO: rcu_preempt detected stalls on CPUs/tasks:
rcu: 	0-...!: (1 GPs behind) idle=4b54/1/0x4000000000000000 softirq=18179/18181 fqs=4
rcu: 	Tasks blocked on level-0 rcu_node (CPUs 0-1): P6660/2:b..l
rcu: 	(detected by 1, t=10502 jiffies, g=26621, q=261 ncpus=2)
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 7824 Comm: syz-executor.5 Not tainted 6.9.0-rc6-syzkaller-00113-g49a73b1652c5 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 03/27/2024
RIP: 0010:advance_sched+0x586/0xca0 net/sched/sch_taprio.c:961
Code: 8b 34 fe 48 89 d8 48 c1 e8 03 42 80 3c 20 00 74 08 48 89 df e8 db 52 70 f8 4c 8b 23 4c 89 f7 4c 89 e6 e8 8d aa 0b f8 4d 39 e6 <75> 25 e8 23 a8 0b f8 48 bb ff ff ff ff ff ff ff 7f 49 bc 00 00 00
RSP: 0018:ffffc90000007c90 EFLAGS: 00000097
RAX: 0000000000010002 RBX: ffff88805e4e8530 RCX: ffff888020718000
RDX: 0000000000010002 RSI: 00000000040010ab RDI: 0000000000000000
RBP: 1ffff1100bc9d201 R08: ffffffff898a6893 R09: fffff52000000f80
R10: dffffc0000000000 R11: fffff52000000f80 R12: 00000000040010ab
R13: ffff88805e4e9008 R14: 0000000000000000 R15: 0000000000000001
FS:  0000555573234480(0000) GS:ffff8880b9400000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000001b32221000 CR3: 00000000614ec000 CR4: 0000000000350ef0
Call Trace:
 <NMI>
 </NMI>
 <IRQ>
 __run_hrtimer kernel/time/hrtimer.c:1692 [inline]
 __hrtimer_run_queues+0x5a7/0xd50 kernel/time/hrtimer.c:1756
 hrtimer_interrupt+0x396/0x990 kernel/time/hrtimer.c:1818
 local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1032 [inline]
 __sysvec_apic_timer_interrupt+0x112/0x3f0 arch/x86/kernel/apic/apic.c:1049
 instr_sysvec_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1043 [inline]
 sysvec_apic_timer_interrupt+0xa1/0xc0 arch/x86/kernel/apic/apic.c:1043
 </IRQ>
 <TASK>
 asm_sysvec_apic_timer_interrupt+0x1a/0x20 arch/x86/include/asm/idtentry.h:702
RIP: 0010:__raw_spin_unlock_irqrestore include/linux/spinlock_api_smp.h:152 [inline]
RIP: 0010:_raw_spin_unlock_irqrestore+0xd8/0x140 kernel/locking/spinlock.c:194
Code: 9c 8f 44 24 20 42 80 3c 23 00 74 08 4c 89 f7 e8 ee 8f 6f f6 f6 44 24 21 02 75 52 41 f7 c7 00 02 00 00 74 01 fb bf 01 00 00 00 <e8> d3 8c da f5 65 8b 05 34 a8 78 74 85 c0 74 43 48 c7 04 24 0e 36
RSP: 0018:ffffc9000ed0fd20 EFLAGS: 00000206
RAX: 30f0b2dfc1630000 RBX: 1ffff92001da1fa8 RCX: ffffffff9472d603
RDX: dffffc0000000000 RSI: ffffffff8bcab8a0 RDI: 0000000000000001
RBP: ffffc9000ed0fda8 R08: ffffffff8fa8fa2f R09: 1ffffffff1f51f45
R10: dffffc0000000000 R11: fffffbfff1f51f46 R12: dffffc0000000000
R13: 1ffff92001da1fa4 R14: ffffc9000ed0fd40 R15: 0000000000000246
 spin_unlock_irqrestore include/linux/spinlock.h:406 [inline]
 alarm_try_to_cancel+0x131/0x3c0 kernel/time/alarmtimer.c:425
 alarm_cancel+0x16/0x60 kernel/time/alarmtimer.c:442
 timerfd_release+0x1b4/0x250 fs/timerfd.c:242
 __fput+0x42b/0x8a0 fs/file_table.c:422
 __do_sys_close fs/open.c:1556 [inline]
 __se_sys_close fs/open.c:1541 [inline]
 __x64_sys_close+0x7f/0x110 fs/open.c:1541
 do_syscall_x64 arch/x86/entry/common.c:52 [inline]
 do_syscall_64+0xf5/0x240 arch/x86/entry/common.c:83
 entry_SYSCALL_64_after_hwframe+0x77/0x7f
RIP: 0033:0x7f0bab27cd9a
Code: 48 3d 00 f0 ff ff 77 48 c3 0f 1f 80 00 00 00 00 48 83 ec 18 89 7c 24 0c e8 03 7f 02 00 8b 7c 24 0c 89 c2 b8 03 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 36 89 d7 89 44 24 0c e8 63 7f 02 00 8b 44 24
RSP: 002b:00007ffcc41d80c0 EFLAGS: 00000293 ORIG_RAX: 0000000000000003
RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f0bab27cd9a
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000003
RBP: 00007f0bab3ad980 R08: 00007f0bab200000 R09: 0000000000000001
R10: 0000000000000001 R11: 0000000000000293 R12: 00000000000338b7
R13: 0000000000033885 R14: 00007ffcc41d8280 R15: 00007f0bab234cb0
 </TASK>
task:syz-executor.0  state:R  running task     stack:20216 pid:6660  tgid:6660  ppid:6634   flags:0x00004002
Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5409 [inline]
 __schedule+0x17e8/0x4a50 kernel/sched/core.c:6746
 preempt_schedule_irq+0xfb/0x1c0 kernel/sched/core.c:7068
 irqentry_exit+0x5e/0x90 kernel/entry/common.c:354
 asm_sysvec_reschedule_ipi+0x1a/0x20 arch/x86/include/asm/idtentry.h:707
RIP: 0010:rcu_is_watching+0x0/0xb0 kernel/rcu/tree.c:696
Code: 4c 89 f6 e8 22 d9 6c 03 e9 2b ff ff ff e8 68 f9 03 0a 0f 1f 84 00 00 00 00 00 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 <f3> 0f 1e fa 41 57 41 56 53 65 ff 05 28 70 87 7e e8 9b 17 04 0a 89
RSP: 0018:ffffc9000c88efa0 EFLAGS: 00000202
RAX: 0000000000000001 RBX: ffff88801d2bc010 RCX: ffff88802b601e00
RDX: dffffc0000000000 RSI: ffffffff8bcaca20 RDI: ffffffff8c1f7ee0
RBP: 1ffff11004eeaab2 R08: ffffffff92f35507 R09: 1ffffffff25e6aa0
R10: dffffc0000000000 R11: fffffbfff25e6aa1 R12: ffff888027755590
R13: dffffc0000000000 R14: ffffffff8203a6a4 R15: ffff88801d2bc000
 rcu_read_lock include/linux/rcupdate.h:782 [inline]
 percpu_ref_tryget_many include/linux/percpu-refcount.h:241 [inline]
 percpu_ref_tryget+0x43/0x180 include/linux/percpu-refcount.h:266
 css_tryget include/linux/cgroup_refcnt.h:45 [inline]
 get_mem_cgroup_from_objcg+0xc8/0x150 include/linux/memcontrol.h:536
 obj_cgroup_charge_pages mm/memcontrol.c:3300 [inline]
 __memcg_kmem_charge_page+0xd1/0x250 mm/memcontrol.c:3328
 __alloc_pages+0x28c/0x6c0 mm/page_alloc.c:4592
 alloc_pages_mpol+0x3e8/0x680 mm/mempolicy.c:2264
 pagetable_alloc include/linux/mm.h:2864 [inline]
 __pte_alloc_one include/asm-generic/pgalloc.h:68 [inline]
 pte_alloc_one+0x88/0x5d0 arch/x86/mm/pgtable.c:33
 __pte_alloc+0x79/0x3a0 mm/memory.c:440
 copy_pte_range mm/memory.c:1092 [inline]
 copy_pmd_range mm/memory.c:1238 [inline]
 copy_pud_range mm/memory.c:1275 [inline]
 copy_p4d_range mm/memory.c:1299 [inline]
 copy_page_range+0x507d/0x5b00 mm/memory.c:1397
 dup_mmap kernel/fork.c:751 [inline]
 dup_mm kernel/fork.c:1688 [inline]
 copy_mm+0x1321/0x2180 kernel/fork.c:1737
 copy_process+0x187a/0x3df0 kernel/fork.c:2390
 kernel_clone+0x226/0x8f0 kernel/fork.c:2797
 __do_sys_clone kernel/fork.c:2940 [inline]
 __se_sys_clone kernel/fork.c:2924 [inline]
 __x64_sys_clone+0x258/0x2a0 kernel/fork.c:2924
 do_syscall_x64 arch/x86/entry/common.c:52 [inline]
 do_syscall_64+0xf5/0x240 arch/x86/entry/common.c:83
 entry_SYSCALL_64_after_hwframe+0x77/0x7f
RIP: 0033:0x7fee4587aed3
RSP: 002b:00007ffd70b864a8 EFLAGS: 00000246 ORIG_RAX: 0000000000000038
RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007fee4587aed3
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000001200011
RBP: 0000000000000001 R08: 0000000000000000 R09: 0000000000000000
R10: 0000555581c8f750 R11: 0000000000000246 R12: 0000000000000000
R13: 0000000000000000 R14: 0000000000000001 R15: 0000000000000001
 </TASK>
rcu: rcu_preempt kthread starved for 10494 jiffies! g26621 f0x0 RCU_GP_WAIT_FQS(5) ->state=0x0 ->cpu=1
rcu: 	Unless rcu_preempt kthread gets sufficient CPU time, OOM is now expected behavior.
rcu: RCU grace-period kthread stack dump:
task:rcu_preempt     state:R  running task     stack:26256 pid:16    tgid:16    ppid:2      flags:0x00004000
Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5409 [inline]
 __schedule+0x17e8/0x4a50 kernel/sched/core.c:6746
 __schedule_loop kernel/sched/core.c:6823 [inline]
 schedule+0x14b/0x320 kernel/sched/core.c:6838
 schedule_timeout+0x1be/0x310 kernel/time/timer.c:2582
 rcu_gp_fqs_loop+0x2df/0x1370 kernel/rcu/tree.c:1663
 rcu_gp_kthread+0xa7/0x3b0 kernel/rcu/tree.c:1862
 kthread+0x2f2/0x390 kernel/kthread.c:388
 ret_from_fork+0x4d/0x80 arch/x86/kernel/process.c:147
 ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:244
 </TASK>
rcu: Stack dump where RCU GP kthread last ran:
CPU: 1 PID: 2778 Comm: kworker/u8:7 Not tainted 6.9.0-rc6-syzkaller-00113-g49a73b1652c5 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 03/27/2024
Workqueue: events_unbound toggle_allocation_gate
RIP: 0010:csd_lock_wait kernel/smp.c:311 [inline]
RIP: 0010:smp_call_function_many_cond+0x1899/0x2a00 kernel/smp.c:855
Code: 89 e6 83 e6 01 31 ff e8 15 db 0b 00 41 83 e4 01 49 bc 00 00 00 00 00 fc ff df 75 07 e8 c0 d6 0b 00 eb 38 f3 90 42 0f b6 04 23 <84> c0 75 11 41 f7 45 00 01 00 00 00 74 1e e8 a4 d6 0b 00 eb e4 44
RSP: 0018:ffffc900093776e0 EFLAGS: 00000293
RAX: 0000000000000000 RBX: 1ffff11017288c6d RCX: ffff88802afb5a00
RDX: 0000000000000000 RSI: 0000000000000001 RDI: 0000000000000000
RBP: ffffc900093778e0 R08: ffffffff818a39eb R09: 1ffffffff25e6aa0
R10: dffffc0000000000 R11: fffffbfff25e6aa1 R12: dffffc0000000000
R13: ffff8880b9446368 R14: ffff8880b953f7c0 R15: 0000000000000000
FS:  0000000000000000(0000) GS:ffff8880b9500000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00000000200000c0 CR3: 000000000e134000 CR4: 0000000000350ef0
Call Trace:
 <IRQ>
 </IRQ>
 <TASK>
 on_each_cpu_cond_mask+0x3f/0x80 kernel/smp.c:1023
 on_each_cpu include/linux/smp.h:71 [inline]
 text_poke_sync arch/x86/kernel/alternative.c:2086 [inline]
 text_poke_bp_batch+0x352/0xb30 arch/x86/kernel/alternative.c:2296
 text_poke_flush arch/x86/kernel/alternative.c:2487 [inline]
 text_poke_finish+0x30/0x50 arch/x86/kernel/alternative.c:2494
 arch_jump_label_transform_apply+0x1c/0x30 arch/x86/kernel/jump_label.c:146
 static_key_enable_cpuslocked+0x136/0x260 kernel/jump_label.c:205
 static_key_enable+0x1a/0x20 kernel/jump_label.c:218
 toggle_allocation_gate+0xb5/0x250 mm/kfence/core.c:826
 process_one_work kernel/workqueue.c:3267 [inline]
 process_scheduled_works+0xa12/0x17c0 kernel/workqueue.c:3348
 worker_thread+0x86d/0xd70 kernel/workqueue.c:3429
 kthread+0x2f2/0x390 kernel/kthread.c:388
 ret_from_fork+0x4d/0x80 arch/x86/kernel/process.c:147
 ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:244
 </TASK>

Crashes (4):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2024/05/02 18:13 upstream 49a73b1652c5 3ba885bc .config console log report info [disk image] [vmlinux] [kernel image] ci-upstream-kasan-gce-root INFO: rcu detected stall in timerfd_release
2024/04/22 09:04 upstream ed30a4a51bb1 af24b050 .config console log report info [disk image] [vmlinux] [kernel image] ci-upstream-kasan-gce-smack-root INFO: rcu detected stall in timerfd_release
2024/06/04 07:08 linux-next d97496ca23a2 a1feae05 .config console log report info [disk image] [vmlinux] [kernel image] ci-upstream-linux-next-kasan-gce-root INFO: rcu detected stall in timerfd_release
2024/06/03 06:28 linux-next 861a3cb5a2a8 3113787f .config console log report info [disk image] [vmlinux] [kernel image] ci-upstream-linux-next-kasan-gce-root INFO: rcu detected stall in timerfd_release
* Struck through repros no longer work on HEAD.