syzbot


INFO: rcu detected stall in sys_getsockopt (2)

Status: upstream: reported on 2024/10/21 14:07
Reported-by: syzbot+ef72cd904969122c5343@syzkaller.appspotmail.com
First crash: 1d06h, last: 1d06h
Similar bugs (16)
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
upstream INFO: rcu detected stall in sys_getsockopt (2) kernel 1 1749d 1749d 0/28 closed as invalid on 2020/01/08 05:23
linux-4.19 INFO: rcu detected stall in sys_getsockopt 1 762d 762d 0/1 auto-obsoleted due to no activity on 2023/01/19 05:52
upstream INFO: rcu detected stall in sys_getsockopt (11) netfilter 4 296d 308d 0/28 auto-obsoleted due to no activity on 2024/03/30 17:47
linux-5.15 INFO: rcu detected stall in sys_getsockopt 1 315d 315d 0/3 auto-obsoleted due to no activity on 2024/03/21 16:23
upstream INFO: rcu detected stall in sys_getsockopt (3) kernel 1 1749d 1749d 0/28 closed as invalid on 2020/01/08 05:33
upstream INFO: rcu detected stall in sys_getsockopt (4) kernel 3 1749d 1749d 0/28 closed as invalid on 2020/01/09 08:13
upstream INFO: rcu detected stall in sys_getsockopt (6) kvm 3 1167d 1235d 0/28 auto-closed as invalid on 2021/11/10 12:58
upstream INFO: rcu detected stall in sys_getsockopt (7) netfilter 2 1024d 1073d 0/28 closed as invalid on 2022/02/08 10:10
upstream INFO: rcu detected stall in sys_getsockopt (5) sctp 2 1567d 1609d 0/28 auto-closed as invalid on 2020/10/06 19:28
linux-6.1 INFO: rcu detected stall in sys_getsockopt 4 232d 389d 0/3 auto-obsoleted due to no activity on 2024/06/12 17:46
upstream INFO: rcu detected stall in sys_getsockopt (10) mm 9 427d 509d 0/28 auto-obsoleted due to no activity on 2023/11/20 15:28
upstream INFO: rcu detected stall in sys_getsockopt (9) kernel 6 630d 786d 0/28 auto-obsoleted due to no activity on 2023/05/01 05:21
upstream INFO: rcu detected stall in sys_getsockopt (8) net 2 914d 930d 0/28 auto-closed as invalid on 2022/07/21 00:25
upstream INFO: rcu detected stall in sys_getsockopt kernel 2 1784d 1784d 0/28 closed as invalid on 2019/12/04 14:04
android-54 BUG: soft lockup in sys_getsockopt 1 188d 188d 0/2 auto-obsoleted due to no activity on 2024/07/15 21:19
android-5-15 BUG: soft lockup in sys_getsockopt 6 83d 182d 0/2 premoderation: reported on 2024/04/23 07:54

Sample crash report:
rcu: INFO: rcu_preempt detected stalls on CPUs/tasks:
rcu: 	1-...!: (1 GPs behind) idle=09f/1/0x4000000000000000 softirq=10871/10873 fqs=0 
rcu: 	Tasks blocked on level-0 rcu_node (CPUs 0-1): P579/1:b..l
	(detected by 0, t=10506 jiffies, g=13569, q=54)
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 4601 Comm: syz-executor Not tainted 5.15.168-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/13/2024
RIP: 0010:native_save_fl arch/x86/include/asm/irqflags.h:35 [inline]
RIP: 0010:arch_local_save_flags arch/x86/include/asm/irqflags.h:70 [inline]
RIP: 0010:arch_irqs_disabled arch/x86/include/asm/irqflags.h:132 [inline]
RIP: 0010:lock_acquire+0x225/0x4f0 kernel/locking/lockdep.c:5626
Code: 0f 85 a4 01 00 00 49 89 de 48 c1 eb 03 42 80 3c 2b 00 74 08 4c 89 f7 e8 a9 7e 67 00 48 c7 44 24 60 00 00 00 00 9c 8f 44 24 60 <42> 80 3c 2b 00 74 08 4c 89 f7 e8 0c 7e 67 00 f6 44 24 61 02 0f 85
RSP: 0018:ffffc90000dd0b60 EFLAGS: 00000046
RAX: 0000000000000001 RBX: 1ffff920001ba178 RCX: ffffffff81637942
RDX: dffffc0000000000 RSI: ffffffff8a8b3d20 RDI: ffffffff8ad90280
RBP: ffffc90000dd0ca8 R08: dffffc0000000000 R09: fffffbfff20ec622
R10: 0000000000000000 R11: dffffc0000000001 R12: 1ffff920001ba174
R13: dffffc0000000000 R14: ffffc90000dd0bc0 R15: 0000000000000046
FS:  0000555574ce5500(0000) GS:ffff8880b9100000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f1d3a00dd38 CR3: 000000005b699000 CR4: 00000000003526e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 <NMI>
 </NMI>
 <IRQ>
 __raw_spin_lock_irq include/linux/spinlock_api_smp.h:128 [inline]
 _raw_spin_lock_irq+0xcf/0x110 kernel/locking/spinlock.c:170
 __run_hrtimer kernel/time/hrtimer.c:1692 [inline]
 __hrtimer_run_queues+0x662/0xcf0 kernel/time/hrtimer.c:1752
 hrtimer_interrupt+0x392/0x980 kernel/time/hrtimer.c:1814
 local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1085 [inline]
 __sysvec_apic_timer_interrupt+0x139/0x470 arch/x86/kernel/apic/apic.c:1102
 instr_sysvec_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1096 [inline]
 sysvec_apic_timer_interrupt+0x9b/0xc0 arch/x86/kernel/apic/apic.c:1096
 </IRQ>
 <TASK>
 asm_sysvec_apic_timer_interrupt+0x16/0x20 arch/x86/include/asm/idtentry.h:676
RIP: 0010:__sanitizer_cov_trace_cmp8+0x0/0x80 kernel/kcov.c:273
Code: 39 d0 77 22 89 f8 89 f6 48 c7 44 0a 08 04 00 00 00 48 89 44 0a 10 48 89 74 0a 18 4c 89 44 0a 20 49 ff c1 4c 89 09 c3 0f 1f 00 <4c> 8b 04 24 65 48 8b 0d a4 fa 81 7e 65 8b 05 a5 fa 81 7e 25 00 01
RSP: 0018:ffffc900033f6f58 EFLAGS: 00000293
RAX: ffffffff840997c0 RBX: 00007ffc6544d974 RCX: ffff888021438000
RDX: 0000000000000000 RSI: 0000000000000004 RDI: 00007ffc6544d974
RBP: 0000000000000004 R08: ffffffff84099771 R09: fffffbfff1bd2cbe
R10: 0000000000000000 R11: dffffc0000000001 R12: 0000000000000004
R13: 00007ffc6544d970 R14: ffff8880252de108 R15: 00007ffc6544d970
 __chk_range_not_ok arch/x86/include/asm/uaccess.h:33 [inline]
 _copy_to_user+0xaf/0x130 lib/usercopy.c:38
 copy_to_user include/linux/uaccess.h:200 [inline]
 xt_data_to_user net/netfilter/x_tables.c:316 [inline]
 xt_target_to_user+0x16e/0x280 net/netfilter/x_tables.c:344
 copy_entries_to_user net/ipv6/netfilter/ip6_tables.c:877 [inline]
 get_entries net/ipv6/netfilter/ip6_tables.c:1041 [inline]
 do_ip6t_get_ctl+0x1123/0x1890 net/ipv6/netfilter/ip6_tables.c:1679
 nf_getsockopt+0x28e/0x2b0 net/netfilter/nf_sockopt.c:116
 ipv6_getsockopt+0x468/0x2ff0 net/ipv6/ipv6_sockglue.c:1492
 tcp_getsockopt+0x25a/0x6fe0 net/ipv4/tcp.c:4313
 __sys_getsockopt+0x2a6/0x550 net/socket.c:2247
 __do_sys_getsockopt net/socket.c:2262 [inline]
 __se_sys_getsockopt net/socket.c:2259 [inline]
 __x64_sys_getsockopt+0xb1/0xc0 net/socket.c:2259
 do_syscall_x64 arch/x86/entry/common.c:50 [inline]
 do_syscall_64+0x3b/0xb0 arch/x86/entry/common.c:80
 entry_SYSCALL_64_after_hwframe+0x66/0xd0
RIP: 0033:0x7f1d39e86d3a
Code: ff c3 66 0f 1f 44 00 00 48 c7 c2 a8 ff ff ff f7 d8 64 89 02 b8 ff ff ff ff eb b8 0f 1f 44 00 00 49 89 ca b8 37 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 06 c3 0f 1f 44 00 00 48 c7 c2 a8 ff ff ff f7
RSP: 002b:00007ffc6544d7f8 EFLAGS: 00000216 ORIG_RAX: 0000000000000037
RAX: ffffffffffffffda RBX: 00007ffc6544d880 RCX: 00007f1d39e86d3a
RDX: 0000000000000041 RSI: 0000000000000029 RDI: 0000000000000003
RBP: 0000000000000003 R08: 00007ffc6544d81c R09: 0079746972756365
R10: 00007ffc6544d880 R11: 0000000000000216 R12: 00007f1d3a00e340
R13: 00007ffc6544d81c R14: 0000000000000000 R15: 00007f1d3a00fe40
 </TASK>
task:kworker/u4:3    state:R  running task     stack:18360 pid:  579 ppid:     2 flags:0x00004000
Workqueue: netns cleanup_net
Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5027 [inline]
 __schedule+0x12c4/0x45b0 kernel/sched/core.c:6373
 preempt_schedule_notrace+0xf8/0x140 kernel/sched/core.c:6628
 preempt_schedule_notrace_thunk+0x16/0x18 arch/x86/entry/thunk_64.S:35
 rcu_is_watching+0x72/0xa0 kernel/rcu/tree.c:1124
 rcu_read_unlock include/linux/rcupdate.h:768 [inline]
 inet_twsk_purge+0x8b5/0x9d0 net/ipv4/inet_timewait_sock.c:309
 ops_exit_list net/core/net_namespace.c:177 [inline]
 cleanup_net+0x763/0xb60 net/core/net_namespace.c:599
 process_one_work+0x8a1/0x10c0 kernel/workqueue.c:2310
 worker_thread+0xaca/0x1280 kernel/workqueue.c:2457
 kthread+0x3f6/0x4f0 kernel/kthread.c:334
 ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:287
 </TASK>
rcu: rcu_preempt kthread timer wakeup didn't happen for 10505 jiffies! g13569 f0x0 RCU_GP_WAIT_FQS(5) ->state=0x402
rcu: 	Possible timer handling issue on cpu=0 timer-softirq=5075
rcu: rcu_preempt kthread starved for 10506 jiffies! g13569 f0x0 RCU_GP_WAIT_FQS(5) ->state=0x402 ->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:I stack:26816 pid:   15 ppid:     2 flags:0x00004000
Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5027 [inline]
 __schedule+0x12c4/0x45b0 kernel/sched/core.c:6373
 schedule+0x11b/0x1f0 kernel/sched/core.c:6456
 schedule_timeout+0x1b9/0x300 kernel/time/timer.c:1914
 rcu_gp_fqs_loop+0x2bf/0x1080 kernel/rcu/tree.c:1972
 rcu_gp_kthread+0xa4/0x360 kernel/rcu/tree.c:2145
 kthread+0x3f6/0x4f0 kernel/kthread.c:334
 ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:287
 </TASK>
rcu: Stack dump where RCU GP kthread last ran:
NMI backtrace for cpu 0
CPU: 0 PID: 4737 Comm: syz.0.402 Not tainted 5.15.168-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/13/2024
Call Trace:
 <IRQ>
 __dump_stack lib/dump_stack.c:88 [inline]
 dump_stack_lvl+0x1e3/0x2d0 lib/dump_stack.c:106
 nmi_cpu_backtrace+0x46a/0x4a0 lib/nmi_backtrace.c:111
 nmi_trigger_cpumask_backtrace+0x181/0x2a0 lib/nmi_backtrace.c:62
 trigger_single_cpu_backtrace include/linux/nmi.h:166 [inline]
 rcu_check_gp_kthread_starvation+0x1d2/0x240 kernel/rcu/tree_stall.h:487
 print_other_cpu_stall+0x137a/0x14d0 kernel/rcu/tree_stall.h:592
 check_cpu_stall kernel/rcu/tree_stall.h:745 [inline]
 rcu_pending kernel/rcu/tree.c:3932 [inline]
 rcu_sched_clock_irq+0xa38/0x1150 kernel/rcu/tree.c:2619
 update_process_times+0x196/0x200 kernel/time/timer.c:1818
 tick_sched_handle kernel/time/tick-sched.c:254 [inline]
 tick_sched_timer+0x386/0x550 kernel/time/tick-sched.c:1473
 __run_hrtimer kernel/time/hrtimer.c:1688 [inline]
 __hrtimer_run_queues+0x55b/0xcf0 kernel/time/hrtimer.c:1752
 hrtimer_interrupt+0x392/0x980 kernel/time/hrtimer.c:1814
 local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1085 [inline]
 __sysvec_apic_timer_interrupt+0x139/0x470 arch/x86/kernel/apic/apic.c:1102
 instr_sysvec_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1096 [inline]
 sysvec_apic_timer_interrupt+0x9b/0xc0 arch/x86/kernel/apic/apic.c:1096
 </IRQ>
 <TASK>
 asm_sysvec_apic_timer_interrupt+0x16/0x20 arch/x86/include/asm/idtentry.h:676
RIP: 0010:csd_lock_wait kernel/smp.c:440 [inline]
RIP: 0010:smp_call_function_many_cond+0xa93/0xd90 kernel/smp.c:969
Code: 04 03 84 c0 0f 85 84 00 00 00 45 8b 7d 00 44 89 fe 83 e6 01 31 ff e8 5c d5 0b 00 41 83 e7 01 75 07 e8 f1 d1 0b 00 eb 41 f3 90 <48> b8 00 00 00 00 00 fc ff df 0f b6 04 03 84 c0 75 11 41 f7 45 00
RSP: 0018:ffffc90003567780 EFLAGS: 00000246
RAX: ffffffff8174a164 RBX: 1ffff110172280b1 RCX: 0000000000040000
RDX: ffffc90003619000 RSI: 000000000003ffff RDI: 0000000000040000
RBP: ffffc900035678c0 R08: ffffffff8174a134 R09: fffffbfff20ec621
R10: 0000000000000000 R11: dffffc0000000001 R12: 0000000000000001
R13: ffff8880b9140588 R14: ffff8880b903b380 R15: 0000000000000001
 on_each_cpu_cond_mask+0x3b/0x80 kernel/smp.c:1135
 on_each_cpu include/linux/smp.h:71 [inline]
 text_poke_sync arch/x86/kernel/alternative.c:1207 [inline]
 text_poke_bp_batch+0x2b4/0x930 arch/x86/kernel/alternative.c:1407
 text_poke_flush arch/x86/kernel/alternative.c:1598 [inline]
 text_poke_finish+0x16/0x30 arch/x86/kernel/alternative.c:1605
 arch_jump_label_transform_apply+0x13/0x20 arch/x86/kernel/jump_label.c:146
 static_key_slow_inc_cpuslocked+0x12a/0x220 kernel/jump_label.c:144
 static_key_slow_inc+0x16/0x20 kernel/jump_label.c:159
 kvm_arch_vcpu_create+0x247/0x9b0 arch/x86/kvm/x86.c:11062
 kvm_vm_ioctl_create_vcpu+0x2eb/0x810 virt/kvm/kvm_main.c:3724
 kvm_vm_ioctl+0x60b/0xb60 virt/kvm/kvm_main.c:4473
 vfs_ioctl fs/ioctl.c:51 [inline]
 __do_sys_ioctl fs/ioctl.c:874 [inline]
 __se_sys_ioctl+0xf1/0x160 fs/ioctl.c:860
 do_syscall_x64 arch/x86/entry/common.c:50 [inline]
 do_syscall_64+0x3b/0xb0 arch/x86/entry/common.c:80
 entry_SYSCALL_64_after_hwframe+0x66/0xd0
RIP: 0033:0x7fa1802cdff9
Code: ff ff c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 40 00 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 73 01 c3 48 c7 c1 a8 ff ff ff f7 d8 64 89 01 48
RSP: 002b:00007fa17e746038 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 00007fa180485f80 RCX: 00007fa1802cdff9
RDX: 0000000000000000 RSI: 000000000000ae41 RDI: 0000000000000004
RBP: 00007fa180340296 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 0000000000000000 R14: 00007fa180485f80 R15: 00007ffd97a0e8e8
 </TASK>

Crashes (1):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2024/10/21 14:06 linux-5.15.y 584a40a22cb9 f1e4447c .config console log report info [disk image] [vmlinux] [kernel image] ci2-linux-5-15-kasan INFO: rcu detected stall in sys_getsockopt
* Struck through repros no longer work on HEAD.