syzbot


BUG: soft lockup in tcp_write_timer

Status: premoderation: reported on 2024/04/21 15:01
Reported-by: syzbot+a34075020f9c5e580505@syzkaller.appspotmail.com
First crash: 14d, last: 14h21m
Similar bugs (9)
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
linux-4.19 BUG: soft lockup in tcp_write_timer (3) 2 491d 505d 0/1 upstream: reported on 2022/12/17 21:41
linux-4.14 BUG: soft lockup in tcp_write_timer 2 1458d 1537d 0/1 auto-closed as invalid on 2020/09/05 12:42
linux-4.19 BUG: soft lockup in tcp_write_timer (2) 2 901d 965d 0/1 auto-closed as invalid on 2022/03/16 10:56
linux-4.19 BUG: soft lockup in tcp_write_timer 1 1130d 1130d 0/1 auto-closed as invalid on 2021/07/30 14:52
upstream BUG: soft lockup in tcp_write_timer net 11 1737d 1745d 0/26 auto-closed as invalid on 2019/10/25 14:11
upstream BUG: soft lockup in tcp_write_timer (2) kvm 1 741d 741d 0/26 auto-closed as invalid on 2022/06/24 22:31
upstream BUG: soft lockup in tcp_write_timer (3) net 6 118d 225d 0/26 closed as invalid on 2024/03/18 17:07
upstream INFO: rcu detected stall in tcp_write_timer (2) bpf 2 1188d 1243d 0/26 auto-closed as invalid on 2021/05/03 11:59
upstream INFO: rcu detected stall in tcp_write_timer (3) net 1 1055d 1055d 0/26 auto-closed as invalid on 2021/09/13 13:17

Sample crash report:
watchdog: BUG: soft lockup - CPU#1 stuck for 246s! [syz-executor.3:18314]
Modules linked in:
CPU: 1 PID: 18314 Comm: syz-executor.3 Not tainted 5.15.149-syzkaller-00490-g5d96939590c0 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 03/27/2024
RIP: 0010:native_safe_halt arch/x86/include/asm/irqflags.h:51 [inline]
RIP: 0010:arch_safe_halt arch/x86/include/asm/irqflags.h:89 [inline]
RIP: 0010:kvm_wait+0x147/0x180 arch/x86/kernel/kvm.c:918
Code: 4c 89 e8 48 c1 e8 03 42 0f b6 04 20 84 c0 44 8b 74 24 1c 75 34 41 0f b6 45 00 44 38 f0 75 10 66 90 0f 00 2d 5b 03 f3 03 fb f4 <e9> 24 ff ff ff fb e9 1e ff ff ff 44 89 e9 80 e1 07 38 c1 7c a3 4c
RSP: 0018:ffffc900001d0ac0 EFLAGS: 00000246
RAX: 0000000000000003 RBX: 1ffff9200003a15c RCX: ffffffff8154fa7f
RDX: dffffc0000000000 RSI: 0000000000000003 RDI: ffff8881185d0a48
RBP: ffffc900001d0b70 R08: dffffc0000000000 R09: ffffed10230ba14a
R10: 0000000000000000 R11: dffffc0000000001 R12: dffffc0000000000
R13: ffff8881185d0a48 R14: 0000000000000003 R15: 1ffff9200003a160
FS:  00007f32232cd6c0(0000) GS:ffff8881f7100000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000000000000000 CR3: 0000000120cd7000 CR4: 00000000003506a0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 <IRQ>
 pv_wait arch/x86/include/asm/paravirt.h:597 [inline]
 pv_wait_head_or_lock kernel/locking/qspinlock_paravirt.h:470 [inline]
 __pv_queued_spin_lock_slowpath+0x6bc/0xc40 kernel/locking/qspinlock.c:508
 pv_queued_spin_lock_slowpath arch/x86/include/asm/paravirt.h:585 [inline]
 queued_spin_lock_slowpath arch/x86/include/asm/qspinlock.h:51 [inline]
 queued_spin_lock include/asm-generic/qspinlock.h:85 [inline]
 do_raw_spin_lock include/linux/spinlock.h:187 [inline]
 __raw_spin_lock include/linux/spinlock_api_smp.h:143 [inline]
 _raw_spin_lock+0x139/0x1b0 kernel/locking/spinlock.c:154
 spin_lock include/linux/spinlock.h:363 [inline]
 tcp_write_timer+0x25/0x1d0 net/ipv4/tcp_timer.c:662
 call_timer_fn+0x3b/0x2d0 kernel/time/timer.c:1427
 expire_timers kernel/time/timer.c:1472 [inline]
 __run_timers+0x72a/0xa10 kernel/time/timer.c:1743
 run_timer_softirq+0x69/0xf0 kernel/time/timer.c:1756
 __do_softirq+0x26d/0x5bf kernel/softirq.c:565
 invoke_softirq kernel/softirq.c:425 [inline]
 __irq_exit_rcu+0x50/0xf0 kernel/softirq.c:648
 irq_exit_rcu+0x9/0x10 kernel/softirq.c:660
 sysvec_apic_timer_interrupt+0x9a/0xc0 arch/x86/kernel/apic/apic.c:1096
 </IRQ>
 <TASK>
 asm_sysvec_apic_timer_interrupt+0x1b/0x20 arch/x86/include/asm/idtentry.h:638
RIP: 0010:csd_lock_wait kernel/smp.c:440 [inline]
RIP: 0010:smp_call_function_many_cond+0x848/0x9b0 kernel/smp.c:969
Code: 89 fe 83 e6 01 31 ff e8 76 a8 0a 00 41 83 e7 01 49 bf 00 00 00 00 00 fc ff df 75 07 e8 b1 a4 0a 00 eb 38 f3 90 42 0f b6 04 3b <84> c0 75 11 41 f7 45 00 01 00 00 00 74 1e e8 95 a4 0a 00 eb e4 44
RSP: 0018:ffffc90000bef200 EFLAGS: 00000246
RAX: 0000000000000000 RBX: 1ffff1103ee07971 RCX: 0000000000040000
RDX: ffffc90005912000 RSI: 000000000003ffff RDI: 0000000000040000
RBP: ffffc90000bef308 R08: ffffffff8165816a R09: ffffc90000bef140
R10: 0000000000000000 R11: dffffc0000000001 R12: 0000000000000000
R13: ffff8881f703cb88 R14: ffff8881f7138280 R15: dffffc0000000000
 on_each_cpu_cond_mask+0x40/0x80 kernel/smp.c:1135
 on_each_cpu include/linux/smp.h:71 [inline]
 flush_tlb_kernel_range+0x49/0x210 arch/x86/mm/tlb.c:1026
 __purge_vmap_area_lazy+0x230/0x1690 mm/vmalloc.c:1694
 _vm_unmap_aliases+0x339/0x3b0 mm/vmalloc.c:2118
 vm_unmap_aliases+0x19/0x20 mm/vmalloc.c:2141
 change_page_attr_set_clr+0x308/0x1050 arch/x86/mm/pat/set_memory.c:1740
 change_page_attr_clear arch/x86/mm/pat/set_memory.c:1797 [inline]
 set_memory_ro+0xa1/0xe0 arch/x86/mm/pat/set_memory.c:1943
 bpf_jit_binary_lock_ro include/linux/filter.h:888 [inline]
 bpf_int_jit_compile+0xbf42/0xc6d0 arch/x86/net/bpf_jit_comp.c:2372
 bpf_prog_select_runtime+0x706/0x9e0 kernel/bpf/core.c:1930
 bpf_prog_load+0x1315/0x1b50 kernel/bpf/syscall.c:2337
 __sys_bpf+0x4bc/0x760 kernel/bpf/syscall.c:4633
 __do_sys_bpf kernel/bpf/syscall.c:4737 [inline]
 __se_sys_bpf kernel/bpf/syscall.c:4735 [inline]
 __x64_sys_bpf+0x7c/0x90 kernel/bpf/syscall.c:4735
 do_syscall_x64 arch/x86/entry/common.c:50 [inline]
 do_syscall_64+0x3d/0xb0 arch/x86/entry/common.c:80
 entry_SYSCALL_64_after_hwframe+0x61/0xcb
RIP: 0033:0x7f3224559ca9
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:00007f32232cd0c8 EFLAGS: 00000246 ORIG_RAX: 0000000000000141
RAX: ffffffffffffffda RBX: 00007f3224687f80 RCX: 00007f3224559ca9
RDX: 0000000000000090 RSI: 00000000200000c0 RDI: 0000000000000005
RBP: 00007f32245a547e R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 000000000000000b R14: 00007f3224687f80 R15: 00007ffcf3fb6b58
 </TASK>
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 305 Comm: syz-executor.2 Not tainted 5.15.149-syzkaller-00490-g5d96939590c0 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 03/27/2024
RIP: 0010:native_halt arch/x86/include/asm/irqflags.h:57 [inline]
RIP: 0010:halt arch/x86/include/asm/irqflags.h:98 [inline]
RIP: 0010:kvm_wait+0x117/0x180 arch/x86/kernel/kvm.c:912
Code: 48 c1 e8 03 42 0f b6 04 20 84 c0 44 8b 74 24 1c 75 53 41 0f b6 45 00 44 38 f0 0f 85 63 ff ff ff 66 90 0f 00 2d 8a 03 f3 03 f4 <e9> 54 ff ff ff fa 4c 89 e8 48 c1 e8 03 42 0f b6 04 20 84 c0 44 8b
RSP: 0018:ffffc90000006820 EFLAGS: 00000046
RAX: 0000000000000003 RBX: 1ffff92000000d08 RCX: ffffffff8154fa7f
RDX: dffffc0000000000 RSI: 0000000000000003 RDI: ffff8881f7036cc0
RBP: ffffc900000068d0 R08: dffffc0000000000 R09: ffffed103ee06d99
R10: 0000000000000000 R11: dffffc0000000001 R12: dffffc0000000000
R13: ffff8881f7036cc0 R14: 0000000000000003 R15: 1ffff92000000d0c
FS:  000055555728c480(0000) GS:ffff8881f7000000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 000055555729d858 CR3: 0000000125a8f000 CR4: 00000000003506b0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000600
Call Trace:
 <NMI>
 </NMI>
 <IRQ>
 pv_wait arch/x86/include/asm/paravirt.h:597 [inline]
 pv_wait_head_or_lock kernel/locking/qspinlock_paravirt.h:470 [inline]
 __pv_queued_spin_lock_slowpath+0x6bc/0xc40 kernel/locking/qspinlock.c:508
 pv_queued_spin_lock_slowpath arch/x86/include/asm/paravirt.h:585 [inline]
 queued_spin_lock_slowpath arch/x86/include/asm/qspinlock.h:51 [inline]
 queued_spin_lock include/asm-generic/qspinlock.h:85 [inline]
 do_raw_spin_lock include/linux/spinlock.h:187 [inline]
 __raw_spin_lock include/linux/spinlock_api_smp.h:143 [inline]
 _raw_spin_lock+0x139/0x1b0 kernel/locking/spinlock.c:154
 raw_spin_rq_lock_nested kernel/sched/core.c:489 [inline]
 raw_spin_rq_lock kernel/sched/sched.h:1352 [inline]
 rq_lock kernel/sched/sched.h:1660 [inline]
 ttwu_queue kernel/sched/core.c:3908 [inline]
 try_to_wake_up+0x625/0x1160 kernel/sched/core.c:4251
 default_wake_function+0x43/0x50 kernel/sched/core.c:6928
 ep_autoremove_wake_function+0x3a/0x130 fs/eventpoll.c:1755
 __wake_up_common+0x25e/0x460 kernel/sched/wait.c:109
 __wake_up_common_lock kernel/sched/wait.c:139 [inline]
 __wake_up+0x112/0x1c0 kernel/sched/wait.c:158
 ep_poll_callback+0x538/0x850 fs/eventpoll.c:1197
 __wake_up_common+0x25e/0x460 kernel/sched/wait.c:109
 __wake_up_common_lock kernel/sched/wait.c:139 [inline]
 __wake_up_sync_key+0x1a3/0x3d0 kernel/sched/wait.c:209
 sock_def_readable+0x154/0x3b0 net/core/sock.c:3094
 tcp_data_ready+0x2c7/0x540 net/ipv4/tcp_input.c:5020
 tcp_rcv_established+0x113e/0x1ac0 net/ipv4/tcp_input.c:5960
 tcp_v4_do_rcv+0x3d7/0xa00 net/ipv4/tcp_ipv4.c:1722
 tcp_v4_rcv+0x23dd/0x2a70 net/ipv4/tcp_ipv4.c:2125
 ip_protocol_deliver_rcu+0x32f/0x710 net/ipv4/ip_input.c:204
 ip_local_deliver_finish net/ipv4/ip_input.c:231 [inline]
 NF_HOOK include/linux/netfilter.h:305 [inline]
 ip_local_deliver+0x2c6/0x590 net/ipv4/ip_input.c:252
 dst_input include/net/dst.h:454 [inline]
 ip_sublist_rcv_finish net/ipv4/ip_input.c:577 [inline]
 ip_list_rcv_finish net/ipv4/ip_input.c:628 [inline]
 ip_sublist_rcv+0x7e2/0x980 net/ipv4/ip_input.c:636
 ip_list_rcv+0x422/0x470 net/ipv4/ip_input.c:671
 __netif_receive_skb_list_ptype net/core/dev.c:5535 [inline]
 __netif_receive_skb_list_core+0x6b1/0x890 net/core/dev.c:5583
 __netif_receive_skb_list net/core/dev.c:5635 [inline]
 netif_receive_skb_list_internal+0x967/0xcc0 net/core/dev.c:5726
 gro_normal_list net/core/dev.c:5880 [inline]
 napi_complete_done+0x344/0x770 net/core/dev.c:6618
 virtqueue_napi_complete drivers/net/virtio_net.c:357 [inline]
 virtnet_poll+0xbee/0x1260 drivers/net/virtio_net.c:1592
 __napi_poll+0xc4/0x5a0 net/core/dev.c:7042
 napi_poll net/core/dev.c:7109 [inline]
 net_rx_action+0x47d/0xc50 net/core/dev.c:7196
 __do_softirq+0x26d/0x5bf kernel/softirq.c:565
 do_softirq+0xf6/0x150 kernel/softirq.c:452
 </IRQ>
 <TASK>
 __local_bh_enable_ip+0x75/0x80 kernel/softirq.c:379
 __raw_spin_unlock_bh include/linux/spinlock_api_smp.h:176 [inline]
 _raw_spin_unlock_bh+0x51/0x60 kernel/locking/spinlock.c:210
 __sock_map_delete net/core/sock_map.c:426 [inline]
 sock_map_delete_elem+0xcb/0x130 net/core/sock_map.c:448
 bpf_prog_2c29ac5cdc6b1842+0x3a/0xa6c
 bpf_dispatcher_nop_func include/linux/bpf.h:785 [inline]
 __bpf_prog_run include/linux/filter.h:618 [inline]
 bpf_prog_run include/linux/filter.h:632 [inline]
 __bpf_trace_run kernel/trace/bpf_trace.c:1883 [inline]
 bpf_trace_run3+0x194/0x250 kernel/trace/bpf_trace.c:1921
 __bpf_trace_sched_switch+0xb/0x10 include/trace/events/sched.h:220
 __traceiter_sched_switch+0x85/0xc0 include/trace/events/sched.h:220
 trace_sched_switch include/trace/events/sched.h:220 [inline]
 __schedule+0x134b/0x1590 kernel/sched/core.c:6509
 preempt_schedule_common+0x9b/0xf0 kernel/sched/core.c:6688
 preempt_schedule+0xd9/0xe0 kernel/sched/core.c:6713
 preempt_schedule_thunk+0x16/0x18 arch/x86/entry/thunk_64.S:34
 __raw_spin_unlock include/linux/spinlock_api_smp.h:152 [inline]
 _raw_spin_unlock+0x60/0x70 kernel/locking/spinlock.c:186
 spin_unlock include/linux/spinlock.h:403 [inline]
 ext4_do_update_inode fs/ext4/inode.c:5189 [inline]
 ext4_mark_iloc_dirty+0x1e70/0x3f40 fs/ext4/inode.c:5791
 __ext4_mark_inode_dirty+0x524/0x7a0 fs/ext4/inode.c:5995
 __ext4_ext_dirty+0x133/0x1f0 fs/ext4/extents.c:183
 ext4_ext_rm_leaf fs/ext4/extents.c:2745 [inline]
 ext4_ext_remove_space+0x21a8/0x4a60 fs/ext4/extents.c:2957
 ext4_ext_truncate+0x19a/0x240 fs/ext4/extents.c:4419
 ext4_truncate+0x96c/0xfa0 fs/ext4/inode.c:4269
 ext4_evict_inode+0xcee/0x14e0 fs/ext4/inode.c:290
 evict+0x2a3/0x630 fs/inode.c:587
 iput_final fs/inode.c:1705 [inline]
 iput+0x63b/0x7e0 fs/inode.c:1731
 d_delete_notify include/linux/fsnotify.h:270 [inline]
 vfs_rmdir+0x359/0x470 fs/namei.c:4162
 do_rmdir+0x3ab/0x630 fs/namei.c:4210
 __do_sys_unlinkat fs/namei.c:4390 [inline]
 __se_sys_unlinkat fs/namei.c:4384 [inline]
 __x64_sys_unlinkat+0xdf/0xf0 fs/namei.c:4384
 do_syscall_x64 arch/x86/entry/common.c:50 [inline]
 do_syscall_64+0x3d/0xb0 arch/x86/entry/common.c:80
 entry_SYSCALL_64_after_hwframe+0x61/0xcb
RIP: 0033:0x7f2162d41487
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 07 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:00007ffc7d802d88 EFLAGS: 00000207 ORIG_RAX: 0000000000000107
RAX: ffffffffffffffda RBX: 0000000000000065 RCX: 00007f2162d41487
RDX: 0000000000000200 RSI: 00007ffc7d803f00 RDI: 00000000ffffff9c
RBP: 00007f2162d8c3b9 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000100 R11: 0000000000000207 R12: 00007ffc7d803f00
R13: 00007f2162d8c3b9 R14: 000000000003fb84 R15: 000000000000001e
 </TASK>

Crashes (4):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2024/05/05 08:33 android13-5.15-lts 5d96939590c0 610f2a54 .config console log report info [disk image] [vmlinux] [kernel image] ci2-android-5-15-perf BUG: soft lockup in tcp_write_timer
2024/04/27 16:37 android13-5.15-lts 5d96939590c0 07b455f9 .config console log report info [disk image] [vmlinux] [kernel image] ci2-android-5-15-perf BUG: soft lockup in tcp_write_timer
2024/04/24 21:38 android13-5.15-lts ad06eaf051cd 8bdc0f22 .config console log report info [disk image] [vmlinux] [kernel image] ci2-android-5-15 BUG: soft lockup in tcp_write_timer
2024/04/21 15:00 android13-5.15-lts ad06eaf051cd af24b050 .config console log report info [disk image] [vmlinux] [kernel image] ci2-android-5-15-perf BUG: soft lockup in tcp_write_timer
* Struck through repros no longer work on HEAD.