syzbot


INFO: rcu detected stall in __sock_sendmsg

Status: auto-obsoleted due to no activity on 2024/09/06 23:00
Subsystems: kernel
[Documentation on labels]
First crash: 244d, last: 244d

Sample crash report:
rcu: INFO: rcu_preempt detected stalls on CPUs/tasks:
rcu: 	1-...!: (2 GPs behind) idle=9e9c/1/0x4000000000000000 softirq=20505/20518 fqs=1
rcu: 	(detected by 0, t=10503 jiffies, g=22601, q=1019 ncpus=2)
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 7064 Comm: syz-executor.1 Not tainted 6.10.0-rc2-syzkaller-00315-gdc772f8237f9 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 04/02/2024
RIP: 0010:variable_test_bit arch/x86/include/asm/bitops.h:227 [inline]
RIP: 0010:arch_test_bit arch/x86/include/asm/bitops.h:239 [inline]
RIP: 0010:_test_bit include/asm-generic/bitops/instrumented-non-atomic.h:142 [inline]
RIP: 0010:cpumask_test_cpu include/linux/cpumask.h:571 [inline]
RIP: 0010:cpu_online include/linux/cpumask.h:1181 [inline]
RIP: 0010:trace_hrtimer_expire_entry include/trace/events/timer.h:259 [inline]
RIP: 0010:__run_hrtimer kernel/time/hrtimer.c:1684 [inline]
RIP: 0010:__hrtimer_run_queues+0x4c8/0xd50 kernel/time/hrtimer.c:1751
Code: 7e a4 12 00 41 89 df 4c 89 f8 48 c1 e8 06 48 8d 3c c5 a8 4a ad 8f be 08 00 00 00 e8 c2 6a 78 00 31 db 4c 0f a3 3d 80 c8 29 0e <41> 0f 92 c7 0f 92 c3 bf 02 00 00 00 89 de e8 45 a7 12 00 31 ff 89
RSP: 0018:ffffc90000a18d60 EFLAGS: 00000047
RAX: 0000000000000001 RBX: 0000000000000000 RCX: ffffffff8183821e
RDX: 0000000000000000 RSI: 0000000000000008 RDI: ffffffff8fad4aa8
RBP: ffffc90000a18ea8 R08: ffffffff8fad4aaf R09: 1ffffffff1f5a955
R10: dffffc0000000000 R11: fffffbfff1f5a956 R12: 1ffff110172a593b
R13: ffffffff898ffe30 R14: ffff88805f013340 R15: 0000000000000001
FS:  00007fb7d19de6c0(0000) GS:ffff8880b9500000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000001b3212e000 CR3: 00000000622e0000 CR4: 00000000003526f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 <NMI>
 </NMI>
 <IRQ>
 hrtimer_interrupt+0x396/0x990 kernel/time/hrtimer.c:1813
 local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1032 [inline]
 __sysvec_apic_timer_interrupt+0x110/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:seqcount_lockdep_reader_access+0x1e0/0x220 include/linux/seqlock.h:75
Code: 00 4d 85 ed 75 16 e8 bf 58 12 00 eb 15 e8 b8 58 12 00 e8 33 ba 02 0a 4d 85 ed 74 ea e8 a9 58 12 00 fb 48 c7 04 24 0e 36 e0 45 <4b> c7 04 3c 00 00 00 00 66 43 c7 44 3c 09 00 00 43 c6 44 3c 0b 00
RSP: 0018:ffffc90009b86e80 EFLAGS: 00000246
RAX: ffffffff8183cdd7 RBX: 0000000000000000 RCX: 0000000000040000
RDX: ffffc900111f1000 RSI: 000000000003ffff RDI: 0000000000040000
RBP: ffffc90009b86f28 R08: ffffffff8183cdad R09: 1ffffffff25f56c7
R10: dffffc0000000000 R11: fffffbfff25f56c8 R12: dffffc0000000000
R13: 0000000000000200 R14: 0000000000000046 R15: 1ffff92001370dd0
 timekeeping_debug_get_ns kernel/time/timekeeping.c:256 [inline]
 timekeeping_get_ns+0x5c/0x420 kernel/time/timekeeping.c:401
 ktime_get+0x89/0xb0 kernel/time/timekeeping.c:850
 ktime_get_ns include/linux/timekeeping.h:169 [inline]
 tcp_clock_ns include/net/tcp.h:844 [inline]
 tcp_mstamp_refresh net/ipv4/tcp_output.c:57 [inline]
 tcp_write_xmit+0x41/0x69d0 net/ipv4/tcp_output.c:2748
 __tcp_push_pending_frames+0x9b/0x360 net/ipv4/tcp_output.c:3014
 tcp_sendmsg_locked+0x43b1/0x4e10 net/ipv4/tcp.c:1319
 tcp_sendmsg+0x30/0x50 net/ipv4/tcp.c:1351
 sock_sendmsg_nosec net/socket.c:730 [inline]
 __sock_sendmsg+0xef/0x270 net/socket.c:745
 sock_sendmsg+0x134/0x200 net/socket.c:768
 splice_to_socket+0xa13/0x10b0 fs/splice.c:889
 do_splice_from fs/splice.c:941 [inline]
 direct_splice_actor+0x11e/0x220 fs/splice.c:1164
 splice_direct_to_actor+0x58e/0xc90 fs/splice.c:1108
 do_splice_direct_actor fs/splice.c:1207 [inline]
 do_splice_direct+0x28c/0x3e0 fs/splice.c:1233
 do_sendfile+0x56d/0xe10 fs/read_write.c:1295
 __do_sys_sendfile64 fs/read_write.c:1362 [inline]
 __se_sys_sendfile64+0x17c/0x1e0 fs/read_write.c:1348
 do_syscall_x64 arch/x86/entry/common.c:52 [inline]
 do_syscall_64+0xf3/0x230 arch/x86/entry/common.c:83
 entry_SYSCALL_64_after_hwframe+0x77/0x7f
RIP: 0033:0x7fb7d1e7cf69
Code: 28 00 00 00 75 05 48 83 c4 28 c3 e8 e1 20 00 00 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 73 01 c3 48 c7 c1 b0 ff ff ff f7 d8 64 89 01 48
RSP: 002b:00007fb7d19de0c8 EFLAGS: 00000246 ORIG_RAX: 0000000000000028
RAX: ffffffffffffffda RBX: 00007fb7d1fb4050 RCX: 00007fb7d1e7cf69
RDX: 0000000000000000 RSI: 0000000000000008 RDI: 0000000000000007
RBP: 00007fb7d1eda6fe R08: 0000000000000000 R09: 0000000000000000
R10: 000000008000002b R11: 0000000000000246 R12: 0000000000000000
R13: 000000000000006e R14: 00007fb7d1fb4050 R15: 00007fb7d20dfaa8
 </TASK>
rcu: rcu_preempt kthread starved for 10498 jiffies! g22601 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:24464 pid:17    tgid:17    ppid:2      flags:0x00004000
Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5408 [inline]
 __schedule+0x17e8/0x4a20 kernel/sched/core.c:6745
 __schedule_loop kernel/sched/core.c:6822 [inline]
 schedule+0x14b/0x320 kernel/sched/core.c:6837
 schedule_timeout+0x1be/0x310 kernel/time/timer.c:2581
 rcu_gp_fqs_loop+0x2df/0x1330 kernel/rcu/tree.c:2000
 rcu_gp_kthread+0xa7/0x3b0 kernel/rcu/tree.c:2202
 kthread+0x2f0/0x390 kernel/kthread.c:389
 ret_from_fork+0x4b/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: 0 PID: 2808 Comm: kworker/u8:8 Not tainted 6.10.0-rc2-syzkaller-00315-gdc772f8237f9 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 04/02/2024
Workqueue: events_unbound toggle_allocation_gate
RIP: 0010:csd_lock_wait kernel/smp.c:311 [inline]
RIP: 0010:smp_call_function_many_cond+0x1860/0x29d0 kernel/smp.c:855
Code: 45 8b 65 00 44 89 e6 83 e6 01 31 ff e8 99 09 0c 00 41 83 e4 01 49 bc 00 00 00 00 00 fc ff df 75 07 e8 44 05 0c 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 28 05
RSP: 0018:ffffc900098e7700 EFLAGS: 00000293
RAX: ffffffff818a2158 RBX: 1ffff110172a88a9 RCX: ffff88802b473c00
RDX: 0000000000000000 RSI: 0000000000000001 RDI: 0000000000000000
RBP: ffffc900098e78e0 R08: ffffffff818a2127 R09: 1ffffffff25f56b0
R10: dffffc0000000000 R11: fffffbfff25f56b1 R12: dffffc0000000000
R13: ffff8880b9544548 R14: ffff8880b943f900 R15: 0000000000000001
FS:  0000000000000000(0000) GS:ffff8880b9400000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 000000002044a000 CR3: 000000000e132000 CR4: 00000000003526f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
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:2069 [inline]
 text_poke_bp_batch+0x352/0xb30 arch/x86/kernel/alternative.c:2279
 text_poke_flush arch/x86/kernel/alternative.c:2470 [inline]
 text_poke_finish+0x30/0x50 arch/x86/kernel/alternative.c:2477
 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:3231 [inline]
 process_scheduled_works+0xa2c/0x1830 kernel/workqueue.c:3312
 worker_thread+0x86d/0xd70 kernel/workqueue.c:3393
 kthread+0x2f0/0x390 kernel/kthread.c:389
 ret_from_fork+0x4b/0x80 arch/x86/kernel/process.c:147
 ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:244
 </TASK>

Crashes (1):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2024/06/08 22:58 upstream dc772f8237f9 82c05ab8 .config console log report info [disk image] [vmlinux] [kernel image] ci-upstream-kasan-gce INFO: rcu detected stall in __sock_sendmsg
* Struck through repros no longer work on HEAD.