syzbot


INFO: rcu detected stall in __sock_release

Status: auto-obsoleted due to no activity on 2023/11/28 04:02
Subsystems: netfilter
[Documentation on labels]
First crash: 539d, last: 539d

Sample crash report:
rcu: INFO: rcu_preempt detected stalls on CPUs/tasks:
rcu: 	0-...!: (1 GPs behind) idle=74ec/1/0x4000000000000000 softirq=81551/81552 fqs=0
rcu: 	Tasks blocked on level-0 rcu_node (CPUs 0-1): P7980/1:b..l
rcu: 	(detected by 1, t=10505 jiffies, g=134769, q=67 ncpus=2)
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 5084 Comm: syz-executor.2 Not tainted 6.6.0-rc3-next-20230928-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/06/2023
RIP: 0010:variable_test_bit arch/x86/include/asm/bitops.h:228 [inline]
RIP: 0010:arch_test_bit arch/x86/include/asm/bitops.h:240 [inline]
RIP: 0010:_test_bit include/asm-generic/bitops/instrumented-non-atomic.h:142 [inline]
RIP: 0010:hlock_class kernel/locking/lockdep.c:228 [inline]
RIP: 0010:mark_lock+0x10a/0x1950 kernel/locking/lockdep.c:4655
Code: 81 e2 ff 1f 0f b7 d2 be 08 00 00 00 48 89 d0 48 89 54 24 38 48 c1 e8 06 48 8d 3c c5 80 ae a0 91 e8 6b 84 76 00 48 8b 54 24 38 <48> 0f a3 15 ae 6c 38 10 0f 83 61 01 00 00 48 69 d2 d0 00 00 00 48
RSP: 0018:ffffc90000007920 EFLAGS: 00000046
RAX: 0000000000000001 RBX: ffff88802503e450 RCX: ffffffff816841c5
RDX: 0000000000000001 RSI: 0000000000000008 RDI: ffffffff91a0ae80
RBP: ffffc90000007a88 R08: 0000000000000000 R09: fffffbfff23415d0
R10: ffffffff91a0ae87 R11: ffffc90000007ff8 R12: 0000000000000001
R13: 0000000000000000 R14: 1ffff92000000f2c R15: ffff88802503e470
FS:  000055555708b480(0000) GS:ffff8880b9800000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f295fd75198 CR3: 000000005bd6e000 CR4: 00000000003506f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 <NMI>
 </NMI>
 <IRQ>
 mark_usage kernel/locking/lockdep.c:4563 [inline]
 __lock_acquire+0x163e/0x5de0 kernel/locking/lockdep.c:5090
 lock_acquire kernel/locking/lockdep.c:5753 [inline]
 lock_acquire+0x1ae/0x510 kernel/locking/lockdep.c:5718
 __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline]
 _raw_spin_lock_irqsave+0x3a/0x50 kernel/locking/spinlock.c:162
 debug_object_activate+0x1a0/0x490 lib/debugobjects.c:717
 debug_hrtimer_activate kernel/time/hrtimer.c:422 [inline]
 debug_activate kernel/time/hrtimer.c:477 [inline]
 enqueue_hrtimer+0x23/0x310 kernel/time/hrtimer.c:1087
 __run_hrtimer kernel/time/hrtimer.c:1705 [inline]
 __hrtimer_run_queues+0xa0a/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:1063 [inline]
 __sysvec_apic_timer_interrupt+0x105/0x3f0 arch/x86/kernel/apic/apic.c:1080
 sysvec_apic_timer_interrupt+0x8e/0xc0 arch/x86/kernel/apic/apic.c:1074
 </IRQ>
 <TASK>
 asm_sysvec_apic_timer_interrupt+0x1a/0x20 arch/x86/include/asm/idtentry.h:645
RIP: 0010:lock_acquire+0x1ef/0x510 kernel/locking/lockdep.c:5721
Code: c1 05 95 b7 99 7e 83 f8 01 0f 85 b0 02 00 00 9c 58 f6 c4 02 0f 85 9b 02 00 00 48 85 ed 74 01 fb 48 b8 00 00 00 00 00 fc ff df <48> 01 c3 48 c7 03 00 00 00 00 48 c7 43 08 00 00 00 00 48 8b 84 24
RSP: 0018:ffffc90003fdfce0 EFLAGS: 00000206
RAX: dffffc0000000000 RBX: 1ffff920007fbf9e RCX: 0000000000000001
RDX: 1ffff11004a07c7f RSI: ffffffff8a8cad20 RDI: ffffffff8ae97260
RBP: 0000000000000200 R08: 0000000000000000 R09: fffffbfff23415e4
R10: ffffffff91a0af27 R11: 0000000000000000 R12: 0000000000000001
R13: 0000000000000000 R14: ffff88804e928e10 R15: 0000000000000000
 down_write+0x93/0x200 kernel/locking/rwsem.c:1579
 inode_lock include/linux/fs.h:802 [inline]
 __sock_release+0x86/0x260 net/socket.c:658
 sock_close+0x1c/0x20 net/socket.c:1402
 __fput+0x3f7/0xa70 fs/file_table.c:384
 __fput_sync+0x47/0x50 fs/file_table.c:465
 __do_sys_close fs/open.c:1572 [inline]
 __se_sys_close fs/open.c:1557 [inline]
 __x64_sys_close+0x87/0xf0 fs/open.c:1557
 do_syscall_x64 arch/x86/entry/common.c:51 [inline]
 do_syscall_64+0x38/0xb0 arch/x86/entry/common.c:81
 entry_SYSCALL_64_after_hwframe+0x63/0xcd
RIP: 0033:0x7f295fc7b9da
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:00007ffee994d050 EFLAGS: 00000293 ORIG_RAX: 0000000000000003
RAX: ffffffffffffffda RBX: 00000000ffffffff RCX: 00007f295fc7b9da
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000003
RBP: 00007ffee994d0cc R08: 00007ffee994c9cc R09: 00007ffee994cdb7
R10: 00007ffee994ca20 R11: 0000000000000293 R12: 0000000000000032
R13: 00000000003609be R14: 00000000003609b2 R15: 0000000000000005
 </TASK>
task:kworker/1:0     state:R  running task     stack:25840 pid:7980  ppid:2      flags:0x00004000
Workqueue: events_power_efficient gc_worker
Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5365 [inline]
 __schedule+0xee1/0x5a00 kernel/sched/core.c:6676
 preempt_schedule_irq+0x52/0x90 kernel/sched/core.c:6998
 irqentry_exit+0x35/0x80 kernel/entry/common.c:432
 asm_sysvec_apic_timer_interrupt+0x1a/0x20 arch/x86/include/asm/idtentry.h:645
RIP: 0010:__seqprop_spinlock_sequence include/linux/seqlock.h:275 [inline]
RIP: 0010:nf_conntrack_get_ht include/net/netfilter/nf_conntrack.h:339 [inline]
RIP: 0010:gc_worker+0x2e1/0x17d0 net/netfilter/nf_conntrack_core.c:1490
Code: 00 00 48 c7 c7 48 a5 cf 8e e8 bb 83 ee f8 9c 5b 81 e3 00 02 00 00 31 ff 48 89 de e8 19 16 0e f9 48 85 db 58 0f 85 9a 10 00 00 <e8> 7a 1a 0e f9 eb 07 e8 73 1a 0e f9 f3 90 44 8b 35 3a 67 55 06 31
RSP: 0018:ffffc9001659fbf0 EFLAGS: 00000293
RAX: 0000000000000000 RBX: 0000000000000000 RCX: ffffffff887a49b8
RDX: ffff888072163b80 RSI: ffffffff887a49c7 RDI: 0000000000000007
RBP: ffff888025a00000 R08: 0000000000000007 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000000 R12: 00000000000195d2
R13: dffffc0000000000 R14: 0000000000032ba3 R15: 0000000000040000
 process_one_work+0x884/0x15c0 kernel/workqueue.c:2630
 process_scheduled_works kernel/workqueue.c:2703 [inline]
 worker_thread+0x8b9/0x1290 kernel/workqueue.c:2784
 kthread+0x33c/0x440 kernel/kthread.c:388
 ret_from_fork+0x45/0x80 arch/x86/kernel/process.c:147
 ret_from_fork_asm+0x11/0x20 arch/x86/entry/entry_64.S:304
 </TASK>
rcu: rcu_preempt kthread starved for 10505 jiffies! g134769 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:28016 pid:17    ppid:2      flags:0x00004000
Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5365 [inline]
 __schedule+0xee1/0x5a00 kernel/sched/core.c:6676
 __schedule_loop kernel/sched/core.c:6753 [inline]
 schedule+0xe7/0x270 kernel/sched/core.c:6768
 schedule_timeout+0x157/0x2c0 kernel/time/timer.c:2167
 rcu_gp_fqs_loop+0x1ec/0xb10 kernel/rcu/tree.c:1625
 rcu_gp_kthread+0x249/0x380 kernel/rcu/tree.c:1824
 kthread+0x33c/0x440 kernel/kthread.c:388
 ret_from_fork+0x45/0x80 arch/x86/kernel/process.c:147
 ret_from_fork_asm+0x11/0x20 arch/x86/entry/entry_64.S:304
 </TASK>
rcu: Stack dump where RCU GP kthread last ran:
CPU: 1 PID: 26214 Comm: kworker/u4:7 Not tainted 6.6.0-rc3-next-20230928-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/06/2023
Workqueue: events_unbound toggle_allocation_gate
RIP: 0010:csd_lock_wait kernel/smp.c:309 [inline]
RIP: 0010:smp_call_function_many_cond+0x4d6/0x1570 kernel/smp.c:853
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 4c bd 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:ffffc90004f67920 EFLAGS: 00000293
RAX: 0000000000000000 RBX: ffff8880b98441e0 RCX: ffffffff817c9b4a
RDX: ffff88802050bb80 RSI: ffffffff817c9b24 RDI: 0000000000000005
RBP: 0000000000000003 R08: 0000000000000005 R09: 0000000000000000
R10: 0000000000000001 R11: 0000000000000000 R12: ffffed101730883d
R13: 0000000000000001 R14: ffff8880b993d900 R15: ffff8880b98441e8
FS:  0000000000000000(0000) GS:ffff8880b9900000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000001b3122d000 CR3: 000000000c976000 CR4: 00000000003506f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 <IRQ>
 </IRQ>
 <TASK>
 on_each_cpu_cond_mask+0x40/0x90 kernel/smp.c:1021
 on_each_cpu include/linux/smp.h:71 [inline]
 text_poke_sync arch/x86/kernel/alternative.c:1993 [inline]
 text_poke_bp_batch+0x2ce/0x960 arch/x86/kernel/alternative.c:2203
 text_poke_flush arch/x86/kernel/alternative.c:2394 [inline]
 text_poke_flush arch/x86/kernel/alternative.c:2391 [inline]
 text_poke_finish+0x30/0x40 arch/x86/kernel/alternative.c:2401
 arch_jump_label_transform_apply+0x1c/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:830 [inline]
 toggle_allocation_gate+0xf4/0x250 mm/kfence/core.c:822
 process_one_work+0x884/0x15c0 kernel/workqueue.c:2630
 process_scheduled_works kernel/workqueue.c:2703 [inline]
 worker_thread+0x8b9/0x1290 kernel/workqueue.c:2784
 kthread+0x33c/0x440 kernel/kthread.c:388
 ret_from_fork+0x45/0x80 arch/x86/kernel/process.c:147
 ret_from_fork_asm+0x11/0x20 arch/x86/entry/entry_64.S:304
 </TASK>

Crashes (1):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2023/09/29 03:53 linux-next 719136e5c247 d265efd8 .config console log report info [disk image] [vmlinux] [kernel image] ci-upstream-linux-next-kasan-gce-root INFO: rcu detected stall in __sock_release
* Struck through repros no longer work on HEAD.