syzbot


INFO: rcu detected stall in sys_symlinkat (3)

Status: auto-obsoleted due to no activity on 2023/10/26 22:46
Subsystems: ext4
[Documentation on labels]
First crash: 335d, last: 283d
Similar bugs (8)
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
linux-5.15 INFO: rcu detected stall in sys_symlinkat 1 346d 346d 0/3 auto-obsoleted due to no activity on 2023/09/03 15:54
linux-6.1 INFO: rcu detected stall in sys_symlinkat (2) 1 131d 131d 0/3 auto-obsoleted due to no activity on 2024/04/06 00:16
upstream INFO: rcu detected stall in sys_symlinkat kvm 5 616d 715d 0/26 auto-obsoleted due to no activity on 2022/11/28 07:06
linux-6.1 INFO: rcu detected stall in sys_symlinkat 1 376d 376d 0/3 auto-obsoleted due to no activity on 2023/08/23 09:07
upstream INFO: rcu detected stall in sys_symlinkat (2) ext4 lsm 2 428d 522d 0/26 auto-obsoleted due to no activity on 2023/06/03 10:14
upstream INFO: rcu detected stall in sys_symlinkat (4) ext4 1 160d 160d 0/26 auto-obsoleted due to no activity on 2024/02/27 04:07
linux-5.15 INFO: rcu detected stall in sys_symlinkat (2) 1 155d 155d 0/3 auto-obsoleted due to no activity on 2024/03/12 11:22
android-5-15 BUG: soft lockup in sys_symlinkat 9 3d15h 22d 0/2 premoderation: reported on 2024/04/15 06:45

Sample crash report:
ip6_tunnel: ip6tnl3 xmit: Local address not yet configured!
rcu: INFO: rcu_preempt detected stalls on CPUs/tasks:
rcu: 	0-...!: (1 GPs behind) idle=5d8c/1/0x4000000000000000 softirq=55947/55950 fqs=0
rcu: 	(detected by 1, t=10506 jiffies, g=73441, q=150 ncpus=2)
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 19527 Comm: syz-executor.1 Not tainted 6.5.0-rc3-syzkaller-00225-gf837f0a3c948 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 07/12/2023
RIP: 0010:rcu_read_lock include/linux/rcupdate.h:750 [inline]
RIP: 0010:advance_sched+0x68e/0xc60 net/sched/sch_taprio.c:996
Code: 31 d2 31 f6 b9 02 00 00 00 68 20 77 5a 88 48 c7 c7 80 65 9a 8c e8 12 11 0d f9 e8 dd ca d7 01 31 ff 89 c3 89 c6 e8 62 f5 2b f9 <85> db 58 0f 85 78 02 00 00 e8 e4 f9 2b f9 48 8b 7c 24 20 e8 4a 99
RSP: 0018:ffffc90000007d88 EFLAGS: 00000046
RAX: 0000000080010000 RBX: 0000000000000001 RCX: ffffffff885a775e
RDX: ffff888021148000 RSI: 0000000000000000 RDI: 0000000000000005
RBP: ffff888069090800 R08: 0000000000000005 R09: 0000000000000000
R10: 0000000000000001 R11: ffffc90000007ff8 R12: 0000000000000000
R13: ffff888069090800 R14: ffff88805b4b2340 R15: ffff888069090000
FS:  0000555555b5f480(0000) GS:ffff8880b9800000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f55636ffa61 CR3: 000000002b6f7000 CR4: 0000000000350ef0
Call Trace:
 <NMI>
 </NMI>
 <IRQ>
 __run_hrtimer kernel/time/hrtimer.c:1688 [inline]
 __hrtimer_run_queues+0x203/0xc10 kernel/time/hrtimer.c:1752
 hrtimer_interrupt+0x31b/0x800 kernel/time/hrtimer.c:1814
 local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1098 [inline]
 __sysvec_apic_timer_interrupt+0x14a/0x430 arch/x86/kernel/apic/apic.c:1115
 sysvec_apic_timer_interrupt+0x8e/0xc0 arch/x86/kernel/apic/apic.c:1109
 </IRQ>
 <TASK>
 asm_sysvec_apic_timer_interrupt+0x1a/0x20 arch/x86/include/asm/idtentry.h:645
RIP: 0010:trace_block_touch_buffer include/trace/events/block.h:45 [inline]
RIP: 0010:touch_buffer fs/buffer.c:63 [inline]
RIP: 0010:__find_get_block+0x22a/0xb60 fs/buffer.c:1423
Code: 65 48 89 2d 78 a9 08 7e e8 c3 99 8b ff 48 8d 7d 60 be 04 00 00 00 e8 75 98 df ff f0 ff 45 60 e8 dc 48 92 ff fb 0f 1f 44 00 00 <e8> a1 99 8b ff 65 8b 1d d6 e1 08 7e bf 07 00 00 00 89 de e8 fe 94
RSP: 0018:ffffc9001553f6c8 EFLAGS: 00000206
RAX: 000000000000055f RBX: 0000000000000000 RCX: 1ffffffff2311998
RDX: 0000000000000000 RSI: ffffffff8a6c7880 RDI: ffffffff8ac80960
RBP: ffff8880755ec828 R08: 0000000000000001 R09: fffffbfff23095e4
R10: ffffffff9184af27 R11: ffff88801034a3f0 R12: ffff8880755ec828
R13: 0000000000000000 R14: 000000000000010d R15: 000000000000010d
 __getblk_gfp+0x2b/0x80 fs/buffer.c:1441
 sb_getblk include/linux/buffer_head.h:369 [inline]
 __ext4_get_inode_loc+0x4e3/0x1330 fs/ext4/inode.c:4350
 ext4_get_inode_loc+0xbe/0x160 fs/ext4/inode.c:4478
 ext4_reserve_inode_write+0xc9/0x270 fs/ext4/inode.c:5708
 __ext4_mark_inode_dirty+0x196/0x800 fs/ext4/inode.c:5885
 __ext4_new_inode+0x2b9e/0x5660 fs/ext4/ialloc.c:1344
 ext4_symlink+0x5d6/0xa00 fs/ext4/namei.c:3393
 vfs_symlink fs/namei.c:4477 [inline]
 vfs_symlink+0x3e5/0x620 fs/namei.c:4461
 do_symlinkat+0x28e/0x310 fs/namei.c:4503
 __do_sys_symlinkat fs/namei.c:4519 [inline]
 __se_sys_symlinkat fs/namei.c:4516 [inline]
 __x64_sys_symlinkat+0x97/0xc0 fs/namei.c:4516
 do_syscall_x64 arch/x86/entry/common.c:50 [inline]
 do_syscall_64+0x38/0xb0 arch/x86/entry/common.c:80
 entry_SYSCALL_64_after_hwframe+0x63/0xcd
RIP: 0033:0x7f556367c2a7
Code: 73 01 c3 48 c7 c1 b0 ff ff ff f7 d8 64 89 01 48 83 c8 ff c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 44 00 00 b8 0a 01 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 c7 c1 b0 ff ff ff f7 d8 64 89 01 48
RSP: 002b:00007ffeef4d00f8 EFLAGS: 00000206 ORIG_RAX: 000000000000010a
RAX: ffffffffffffffda RBX: 00007ffeef4d01c0 RCX: 00007f556367c2a7
RDX: 00007f55636c851b RSI: 00000000ffffff9c RDI: 00007f55636c750e
RBP: 0000000000000001 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000206 R12: 0000000000000000
R13: 0000000000000000 R14: 0000000000000001 R15: 0000000000000001
 </TASK>
rcu: rcu_preempt kthread starved for 10506 jiffies! g73441 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:27440 pid:16    ppid:2      flags:0x00004000
Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5381 [inline]
 __schedule+0xee1/0x59f0 kernel/sched/core.c:6710
 schedule+0xe7/0x1b0 kernel/sched/core.c:6786
 schedule_timeout+0x157/0x2c0 kernel/time/timer.c:2167
 rcu_gp_fqs_loop+0x1ec/0xa50 kernel/rcu/tree.c:1609
 rcu_gp_kthread+0x249/0x380 kernel/rcu/tree.c:1808
 kthread+0x33a/0x430 kernel/kthread.c:389
 ret_from_fork+0x2c/0x70 arch/x86/kernel/process.c:145
 ret_from_fork_asm+0x11/0x20 arch/x86/entry/entry_64.S:296
RIP: 0000:0x0
Code: Unable to access opcode bytes at 0xffffffffffffffd6.
RSP: 0000:0000000000000000 EFLAGS: 00000000 ORIG_RAX: 0000000000000000
RAX: 0000000000000000 RBX: 0000000000000000 RCX: 0000000000000000
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000
RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000
R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
 </TASK>
rcu: Stack dump where RCU GP kthread last ran:
CPU: 1 PID: 3275 Comm: kworker/u4:6 Not tainted 6.5.0-rc3-syzkaller-00225-gf837f0a3c948 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 07/12/2023
Workqueue: events_unbound toggle_allocation_gate
RIP: 0010:csd_lock_wait kernel/smp.c:296 [inline]
RIP: 0010:smp_call_function_many_cond+0x4d6/0x1570 kernel/smp.c:835
Code: 0b 00 85 ed 74 4d 48 b8 00 00 00 00 00 fc ff df 4d 89 fc 4c 89 fd 49 c1 ec 03 83 e5 07 49 01 c4 83 c5 03 e8 1c 5f 0b 00 f3 90 <41> 0f b6 04 24 40 38 c5 7c 08 84 c0 0f 85 3c 0e 00 00 8b 43 08 31
RSP: 0018:ffffc9000cb1f938 EFLAGS: 00000293
RAX: 0000000000000000 RBX: ffff8880b9844fe0 RCX: 0000000000000000
RDX: ffff88802ab3bb80 RSI: ffffffff817b1234 RDI: 0000000000000005
RBP: 0000000000000003 R08: 0000000000000005 R09: 0000000000000000
R10: 0000000000000001 R11: 0000000000000000 R12: ffffed10173089fd
R13: 0000000000000001 R14: ffff8880b993d580 R15: ffff8880b9844fe8
FS:  0000000000000000(0000) GS:ffff8880b9900000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: ffffffffffffffd6 CR3: 000000000c776000 CR4: 0000000000350ee0
Call Trace:
 <IRQ>
 </IRQ>
 <TASK>
 on_each_cpu_cond_mask+0x40/0x90 kernel/smp.c:1003
 on_each_cpu include/linux/smp.h:71 [inline]
 text_poke_sync arch/x86/kernel/alternative.c:2001 [inline]
 text_poke_bp_batch+0x250/0x780 arch/x86/kernel/alternative.c:2211
 text_poke_flush arch/x86/kernel/alternative.c:2402 [inline]
 text_poke_flush arch/x86/kernel/alternative.c:2399 [inline]
 text_poke_finish+0x1a/0x30 arch/x86/kernel/alternative.c:2409
 arch_jump_label_transform_apply+0x17/0x30 arch/x86/kernel/jump_label.c:146
 jump_label_update+0x32e/0x410 kernel/jump_label.c:829
 static_key_enable_cpuslocked+0x1b5/0x270 kernel/jump_label.c:205
 static_key_enable+0x1a/0x20 kernel/jump_label.c:218
 toggle_allocation_gate mm/kfence/core.c:831 [inline]
 toggle_allocation_gate+0xf4/0x250 mm/kfence/core.c:823
 process_one_work+0xaa2/0x16f0 kernel/workqueue.c:2597
 worker_thread+0x687/0x1110 kernel/workqueue.c:2748
 kthread+0x33a/0x430 kernel/kthread.c:389
 ret_from_fork+0x2c/0x70 arch/x86/kernel/process.c:145
 ret_from_fork_asm+0x11/0x20 arch/x86/entry/entry_64.S:296
RIP: 0000:0x0
Code: Unable to access opcode bytes at 0xffffffffffffffd6.
RSP: 0000:0000000000000000 EFLAGS: 00000000 ORIG_RAX: 0000000000000000
RAX: 0000000000000000 RBX: 0000000000000000 RCX: 0000000000000000
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000
RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000
R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
 </TASK>

Crashes (3):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2023/07/28 22:37 upstream f837f0a3c948 92476829 .config console log report info [disk image] [vmlinux] [kernel image] ci-upstream-kasan-gce-root INFO: rcu detected stall in sys_symlinkat
2023/07/10 13:28 upstream 06c2afb862f9 52ae002a .config console log report info [disk image] [vmlinux] [kernel image] ci-upstream-kasan-gce-selinux-root INFO: rcu detected stall in sys_symlinkat
2023/06/06 14:59 linux-next 715abedee4cd a4ae4f42 .config console log report info [disk image] [vmlinux] [kernel image] ci-upstream-linux-next-kasan-gce-root INFO: rcu detected stall in sys_symlinkat
* Struck through repros no longer work on HEAD.