syzbot


INFO: rcu detected stall in sys_clone (8)

Status: upstream: reported C repro on 2024/03/29 00:16
Subsystems: mm
[Documentation on labels]
Reported-by: syzbot+c4c6c3dc10cc96bcf723@syzkaller.appspotmail.com
First crash: 330d, last: 3d13h
Discussions (1)
Title Replies (including bot) Last reply
[syzbot] [mm?] INFO: rcu detected stall in sys_clone (8) 0 (1) 2024/03/29 00:16
Similar bugs (13)
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
linux-5.15 INFO: rcu detected stall in sys_clone 1 129d 129d 0/3 auto-obsoleted due to no activity on 2024/03/15 18:08
linux-6.1 INFO: rcu detected stall in sys_clone 3 276d 348d 0/3 auto-obsoleted due to no activity on 2023/10/20 18:18
upstream INFO: rcu detected stall in sys_clone (2) mm 49 1503d 1619d 0/26 auto-closed as invalid on 2020/06/01 05:26
upstream INFO: rcu detected stall in sys_clone (4) kernel 1 1019d 1019d 0/26 auto-closed as invalid on 2021/09/27 17:49
upstream INFO: rcu detected stall in sys_clone (3) kernel 2 1355d 1377d 0/26 auto-closed as invalid on 2020/10/26 22:48
upstream INFO: rcu detected stall in sys_clone (6) kasan mm 1 690d 690d 0/26 auto-closed as invalid on 2022/08/23 03:28
upstream INFO: rcu detected stall in sys_clone kernel 1 1676d 1675d 13/26 fixed on 2019/10/09 10:54
linux-4.19 INFO: rcu detected stall in sys_clone 2 1573d 1592d 0/1 auto-closed as invalid on 2020/04/21 05:46
upstream INFO: rcu detected stall in sys_clone (5) kernfs 5 824d 923d 0/26 closed as invalid on 2022/02/08 10:00
upstream INFO: rcu detected stall in sys_clone (7) fs 1 425d 425d 0/26 auto-obsoleted due to no activity on 2023/05/14 17:18
linux-5.15 INFO: rcu detected stall in sys_clone (2) 1 18d 18d 0/3 upstream: reported on 2024/03/27 00:16
linux-6.1 INFO: rcu detected stall in sys_clone (2) 1 24d 24d 0/3 upstream: reported on 2024/03/20 15:17
android-5-15 BUG: soft lockup in sys_clone 1 6d08h 6d08h 0/2 premoderation: reported on 2024/04/07 21:07

Sample crash report:
rcu: INFO: rcu_preempt detected stalls on CPUs/tasks:
rcu: 	Tasks blocked on level-0 rcu_node (CPUs 0-1): P5084/1:b..l
rcu: 	(detected by 1, t=10503 jiffies, g=5721, q=12 ncpus=2)
task:syz-executor870 state:R  running task     stack:23984 pid:5084  tgid:5084  ppid:5083   flags:0x00000002
Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5409 [inline]
 __schedule+0x1781/0x49d0 kernel/sched/core.c:6736
 preempt_schedule_irq+0xfb/0x1c0 kernel/sched/core.c:7058
 irqentry_exit+0x5e/0x90 kernel/entry/common.c:348
 asm_sysvec_apic_timer_interrupt+0x1a/0x20 arch/x86/include/asm/idtentry.h:702
RIP: 0010:lock_acquire+0x25b/0x530 kernel/locking/lockdep.c:5758
Code: 2b 00 74 08 4c 89 f7 e8 b3 5a 83 00 f6 44 24 61 02 0f 85 8e 01 00 00 41 f7 c7 00 02 00 00 74 01 fb 48 c7 44 24 40 0e 36 e0 45 <4b> c7 44 25 00 00 00 00 00 43 c7 44 25 09 00 00 00 00 43 c7 44 25
RSP: 0018:ffffc90003e5f200 EFLAGS: 00000206
RAX: 0000000000000001 RBX: 1ffff920007cbe4c RCX: 0000000000000001
RDX: dffffc0000000000 RSI: ffffffff8baad360 RDI: ffffffff8bfdff00
RBP: ffffc90003e5f348 R08: ffffffff92cae507 R09: 1ffffffff2595ca0
R10: dffffc0000000000 R11: fffffbfff2595ca1 R12: 1ffff920007cbe48
R13: dffffc0000000000 R14: ffffc90003e5f260 R15: 0000000000000246
 rcu_lock_acquire include/linux/rcupdate.h:298 [inline]
 rcu_read_lock include/linux/rcupdate.h:750 [inline]
 is_bpf_text_address+0x42/0x2b0 kernel/bpf/core.c:767
 kernel_text_address+0xa7/0xe0 kernel/extable.c:125
 __kernel_text_address+0xd/0x40 kernel/extable.c:79
 unwind_get_return_address+0x5d/0xc0 arch/x86/kernel/unwind_orc.c:369
 arch_stack_walk+0x125/0x1b0 arch/x86/kernel/stacktrace.c:26
 stack_trace_save+0x118/0x1d0 kernel/stacktrace.c:122
 kasan_save_stack mm/kasan/common.c:47 [inline]
 kasan_save_track+0x3f/0x80 mm/kasan/common.c:68
 unpoison_slab_object mm/kasan/common.c:312 [inline]
 __kasan_slab_alloc+0x66/0x80 mm/kasan/common.c:338
 kasan_slab_alloc include/linux/kasan.h:201 [inline]
 slab_post_alloc_hook mm/slub.c:3798 [inline]
 slab_alloc_node mm/slub.c:3845 [inline]
 kmem_cache_alloc+0x174/0x340 mm/slub.c:3852
 anon_vma_alloc mm/rmap.c:94 [inline]
 anon_vma_fork+0xe8/0x580 mm/rmap.c:361
 dup_mmap kernel/fork.c:714 [inline]
 dup_mm kernel/fork.c:1687 [inline]
 copy_mm+0xe79/0x21b0 kernel/fork.c:1736
 copy_process+0x187a/0x3df0 kernel/fork.c:2389
 kernel_clone+0x223/0x840 kernel/fork.c:2796
 __do_sys_clone kernel/fork.c:2939 [inline]
 __se_sys_clone kernel/fork.c:2923 [inline]
 __x64_sys_clone+0x258/0x2a0 kernel/fork.c:2923
 do_syscall_64+0xfb/0x240
 entry_SYSCALL_64_after_hwframe+0x6d/0x75
RIP: 0033:0x7f958cd6dc33
RSP: 002b:00007fff6e3ef9b8 EFLAGS: 00000246 ORIG_RAX: 0000000000000038
RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007f958cd6dc33
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000001200011
RBP: 0000000000000001 R08: 0000000000000000 R09: 0000000000000000
R10: 000055558ab23690 R11: 0000000000000246 R12: 0000000000000000
R13: 0000000000000004 R14: 00007fff6e3efb30 R15: 00007fff6e3efb20
 </TASK>
rcu: rcu_preempt kthread starved for 10550 jiffies! g5721 f0x0 RCU_GP_WAIT_FQS(5) ->state=0x0 ->cpu=0
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:26232 pid:16    tgid:16    ppid:2      flags:0x00004000
Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5409 [inline]
 __schedule+0x1781/0x49d0 kernel/sched/core.c:6736
 __schedule_loop kernel/sched/core.c:6813 [inline]
 schedule+0x14b/0x320 kernel/sched/core.c:6828
 schedule_timeout+0x1be/0x310 kernel/time/timer.c:2572
 rcu_gp_fqs_loop+0x2df/0x1370 kernel/rcu/tree.c:1663
 rcu_gp_kthread+0xa7/0x3b0 kernel/rcu/tree.c:1862
 kthread+0x2f0/0x390 kernel/kthread.c:388
 ret_from_fork+0x4b/0x80 arch/x86/kernel/process.c:147
 ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:243
 </TASK>
rcu: Stack dump where RCU GP kthread last ran:
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 5111 Comm: syz-executor870 Not tainted 6.8.0-syzkaller-08951-gfe46a7dd189e #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 03/27/2024
RIP: 0010:check_preemption_disabled+0x4d/0x120 lib/smp_processor_id.c:55
Code: f1 1e 98 74 a9 ff ff ff 7f 74 26 65 48 8b 04 25 28 00 00 00 48 3b 44 24 08 0f 85 ce 00 00 00 89 d8 48 83 c4 10 5b 41 5c 41 5e <41> 5f c3 cc cc cc cc 48 c7 04 24 00 00 00 00 9c 8f 04 24 f7 04 24
RSP: 0018:ffffc90000007fa8 EFLAGS: 00000086
RAX: 0000000000000000 RBX: ffffffff8dafb9d0 RCX: ffffffff944a6603
RDX: 0000000000000000 RSI: ffffffff8bfdfee0 RDI: ffffffff8bfdfea0
RBP: ffff88807a9c3c00 R08: ffffffff8f860def R09: 1ffffffff1f0c1bd
R10: dffffc0000000000 R11: ffffc90000007ff8 R12: ffff8880b94288a8
R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000010000
FS:  000055558ab233c0(0000) GS:ffff8880b9400000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 000000002006b000 CR3: 000000007a976000 CR4: 00000000003506f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 <NMI>
 </NMI>
 <IRQ>
 irqtime_account_irq+0x6d/0x1e0 kernel/sched/cputime.c:63
 instr_sysvec_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1043 [inline]
 sysvec_apic_timer_interrupt+0x99/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_irq include/linux/spinlock_api_smp.h:160 [inline]
RIP: 0010:_raw_spin_unlock_irq+0x29/0x50 kernel/locking/spinlock.c:202
Code: 90 f3 0f 1e fa 53 48 89 fb 48 83 c7 18 48 8b 74 24 08 e8 da 67 fb f5 48 89 df e8 92 a7 fc f5 e8 fd cc 25 f6 fb bf 01 00 00 00 <e8> 22 94 ee f5 65 8b 05 33 79 8d 74 85 c0 74 06 5b c3 cc cc cc cc
RSP: 0018:ffffc90003fafc70 EFLAGS: 00000282
RAX: 11676286f41adb00 RBX: ffff88801cac65c0 RCX: ffffffff944a6603
RDX: dffffc0000000000 RSI: ffffffff8baac1e0 RDI: 0000000000000001
RBP: ffffc90003fafdb0 R08: ffffffff8f860def R09: 1ffffffff1f0c1bd
R10: dffffc0000000000 R11: fffffbfff1f0c1be R12: 1ffff11003958d4b
R13: 000000001c000004 R14: 0000000000000021 R15: ffff88801cac6a58
 spin_unlock_irq include/linux/spinlock.h:401 [inline]
 get_signal+0x156e/0x1850 kernel/signal.c:2910
 arch_do_signal_or_restart+0x96/0x860 arch/x86/kernel/signal.c:310
 exit_to_user_mode_loop kernel/entry/common.c:105 [inline]
 exit_to_user_mode_prepare include/linux/entry-common.h:328 [inline]
 __syscall_exit_to_user_mode_work kernel/entry/common.c:201 [inline]
 syscall_exit_to_user_mode+0xc9/0x360 kernel/entry/common.c:212
 do_syscall_64+0x10a/0x240 arch/x86/entry/common.c:89
 entry_SYSCALL_64_after_hwframe+0x6d/0x75
RIP: 0033:0x7f958cd954af
Code: 48 89 50 50 48 8b 50 10 48 89 78 10 48 89 50 40 48 89 d7 eb b2 66 0f 1f 44 00 00 64 48 8b 0c 25 10 00 00 00 8b 91 08 03 00 00 <48> 8d b9 08 03 00 00 89 d6 83 ce 02 39 d6 74 21 89 d0 f0 0f b1 37
RSP: 002b:00007fff6e3efa98 EFLAGS: 00000206
RAX: 0000000000000000 RBX: 0000000000000004 RCX: 000055558ab233c0
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000003
RBP: 00000000000f4240 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 000055558ab23370
R13: 0000000000000002 R14: 00007fff6e3efb30 R15: 00007fff6e3efb20
 </TASK>
INFO: NMI handler (nmi_cpu_backtrace_handler) took too long to run: 1.037 msecs
sched: RT throttling activated

Crashes (13):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2024/04/01 23:04 upstream fe46a7dd189e 6baf5069 .config console log report syz C [disk image] [vmlinux] [kernel image] ci-upstream-kasan-gce-smack-root INFO: rcu detected stall in sys_clone
2024/03/25 00:05 net f99c5f563c17 0ea90952 .config strace log report syz C [disk image] [vmlinux] [kernel image] ci-upstream-net-this-kasan-gce INFO: rcu detected stall in sys_clone
2024/04/10 16:14 upstream fe46a7dd189e 56086b24 .config console log report info [disk image] [vmlinux] [kernel image] ci-upstream-kasan-gce-smack-root INFO: rcu detected stall in sys_clone
2024/04/01 12:54 upstream fe46a7dd189e 6baf5069 .config console log report info [disk image] [vmlinux] [kernel image] ci-upstream-kasan-gce-smack-root INFO: rcu detected stall in sys_clone
2024/01/12 06:45 upstream 22d29f1112c8 dda5a988 .config console log report info [disk image] [vmlinux] [kernel image] ci-upstream-kasan-gce-smack-root INFO: rcu detected stall in sys_clone
2023/12/21 16:21 upstream a4aebe936554 4f9530a3 .config console log report info [disk image] [vmlinux] [kernel image] ci-upstream-kasan-gce-smack-root INFO: rcu detected stall in sys_clone
2023/12/05 00:36 upstream bee0e7762ad2 f819d6f7 .config console log report info [disk image] [vmlinux] [kernel image] ci-upstream-kasan-gce-smack-root INFO: rcu detected stall in sys_clone
2023/09/06 13:35 upstream 65d6e954e378 8bc9053e .config console log report info [disk image] [vmlinux] [kernel image] ci-upstream-kasan-gce-smack-root INFO: rcu detected stall in sys_clone
2023/09/03 22:21 upstream db906f0ca6bb 696ea0d2 .config console log report info [disk image] [vmlinux] [kernel image] ci-upstream-kasan-gce-smack-root INFO: rcu detected stall in sys_clone
2023/06/27 13:44 upstream 1ef6663a587b 4cd5bb25 .config console log report info [disk image] [vmlinux] [kernel image] ci-upstream-kasan-gce-smack-root INFO: rcu detected stall in sys_clone
2023/05/20 01:33 upstream cbd6ac3837cd 96689200 .config console log report info [disk image] [vmlinux] [kernel image] ci-upstream-kasan-gce-smack-root INFO: rcu detected stall in sys_clone
2023/06/05 17:13 upstream 9561de3a55be a4ae4f42 .config console log report info [disk image (non-bootable)] [vmlinux] [kernel image] ci-qemu2-arm64-mte INFO: rcu detected stall in sys_clone
2024/04/05 10:15 linux-next 8568bb2ccc27 0ee3535e .config console log report info [disk image] [vmlinux] [kernel image] ci-upstream-linux-next-kasan-gce-root INFO: rcu detected stall in sys_clone
* Struck through repros no longer work on HEAD.