syzbot


BUG: soft lockup in sys_recvmmsg

Status: premoderation: reported on 2024/04/23 17:26
Reported-by: syzbot+fb9bd648865106ac5555@syzkaller.appspotmail.com
First crash: 54d, last: 18d
Similar bugs (7)
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
upstream INFO: rcu detected stall in sys_recvmmsg mptcp C done 52 867d 999d 20/27 fixed on 2022/03/08 16:11
upstream INFO: rcu detected stall in sys_recvmmsg (3) net 40 4d08h 180d 0/27 upstream: reported on 2023/12/19 09:31
linux-4.19 INFO: rcu detected stall in sys_recvmmsg C error 1 542d 542d 0/1 upstream: reported C repro on 2022/12/23 04:58
linux-5.15 INFO: rcu detected stall in sys_recvmmsg origin:upstream C 9 5d20h 438d 0/3 upstream: reported C repro on 2023/04/06 01:32
linux-6.1 INFO: rcu detected stall in sys_recvmmsg (2) 3 13d 73d 0/3 upstream: reported on 2024/04/05 00:00
linux-6.1 INFO: rcu detected stall in sys_recvmmsg 5 318d 450d 0/3 auto-obsoleted due to no activity on 2023/11/11 06:06
upstream INFO: rcu detected stall in sys_recvmmsg (2) net 4 628d 658d 0/27 auto-obsoleted due to no activity on 2023/01/03 09:53

Sample crash report:
watchdog: BUG: soft lockup - CPU#0 stuck for 246s! [syz-executor.2:359]
Modules linked in:
CPU: 0 PID: 359 Comm: syz-executor.2 Not tainted 5.15.149-syzkaller-00055-g424f92bcbe8f #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 04/02/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:ffffc900057df3e0 EFLAGS: 00000246
RAX: 0000000000000003 RBX: 1ffff92000afbe80 RCX: ffffffff8154fa7f
RDX: dffffc0000000000 RSI: 0000000000000003 RDI: ffff88810cd79698
RBP: ffffc900057df490 R08: dffffc0000000000 R09: ffffed10219af2d4
R10: 0000000000000000 R11: dffffc0000000001 R12: dffffc0000000000
R13: ffff88810cd79698 R14: 0000000000000003 R15: 1ffff92000afbe84
FS:  00007f7bfd0336c0(0000) GS:ffff8881f7000000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007fef323996c6 CR3: 000000012bf38000 CR4: 00000000003506b0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 <IRQ>
 </IRQ>
 <TASK>
 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_bh include/linux/spinlock_api_smp.h:136 [inline]
 _raw_spin_lock_bh+0x139/0x1b0 kernel/locking/spinlock.c:178
 sock_hash_delete_elem+0xb1/0x2f0 net/core/sock_map.c:937
 bpf_prog_2c29ac5cdc6b1842+0x3a/0xbb8
 bpf_dispatcher_nop_func include/linux/bpf.h:785 [inline]
 __bpf_prog_run include/linux/filter.h:625 [inline]
 bpf_prog_run include/linux/filter.h:632 [inline]
 __bpf_trace_run kernel/trace/bpf_trace.c:1883 [inline]
 bpf_trace_run2+0xec/0x210 kernel/trace/bpf_trace.c:1920
 __bpf_trace_kfree+0x6f/0x90 include/trace/events/kmem.h:118
 trace_kfree include/trace/events/kmem.h:118 [inline]
 kfree+0x1f3/0x220 mm/slub.c:4569
 sk_psock_free_link include/linux/skmsg.h:420 [inline]
 sock_map_del_link net/core/sock_map.c:160 [inline]
 sock_map_unref+0x352/0x4d0 net/core/sock_map.c:182
 sock_hash_delete_elem+0x274/0x2f0 net/core/sock_map.c:941
 bpf_prog_2c29ac5cdc6b1842+0x3a/0xbb8
 bpf_dispatcher_nop_func include/linux/bpf.h:785 [inline]
 __bpf_prog_run include/linux/filter.h:625 [inline]
 bpf_prog_run include/linux/filter.h:632 [inline]
 __bpf_trace_run kernel/trace/bpf_trace.c:1883 [inline]
 bpf_trace_run2+0xec/0x210 kernel/trace/bpf_trace.c:1920
 __bpf_trace_kfree+0x6f/0x90 include/trace/events/kmem.h:118
 trace_kfree include/trace/events/kmem.h:118 [inline]
 kfree+0x1f3/0x220 mm/slub.c:4569
 ___sys_recvmsg+0x210/0x690 net/socket.c:2693
 do_recvmmsg+0x36b/0x8b0 net/socket.c:2786
 __sys_recvmmsg net/socket.c:2865 [inline]
 __do_sys_recvmmsg net/socket.c:2888 [inline]
 __se_sys_recvmmsg net/socket.c:2881 [inline]
 __x64_sys_recvmmsg+0x195/0x240 net/socket.c:2881
 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:0x7f7bfe2dfee9
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:00007f7bfd0330c8 EFLAGS: 00000246 ORIG_RAX: 000000000000012b
RAX: ffffffffffffffda RBX: 00007f7bfe417070 RCX: 00007f7bfe2dfee9
RDX: 0000000000010106 RSI: 00000000200000c0 RDI: 0000000000000003
RBP: 00007f7bfe32c47f R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000002 R11: 0000000000000246 R12: 0000000000000000
R13: 000000000000006e R14: 00007f7bfe417070 R15: 00007ffcdfa06d48
 </TASK>
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 371 Comm: syz-executor.4 Not tainted 5.15.149-syzkaller-00055-g424f92bcbe8f #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 04/02/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:ffffc900056c7200 EFLAGS: 00000246
RAX: 0000000000000001 RBX: 1ffff92000ad8e44 RCX: 1ffffffff0d1aa9c
RDX: 0000000000000001 RSI: 0000000000000001 RDI: ffff8881f7137ed4
RBP: ffffc900056c72b0 R08: dffffc0000000000 R09: ffffed103ee26fdb
R10: 0000000000000000 R11: dffffc0000000001 R12: dffffc0000000000
R13: ffff8881f7137ed4 R14: 0000000000000001 R15: 1ffff92000ad8e48
FS:  00007f3850c546c0(0000) GS:ffff8881f7100000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000001b2f025000 CR3: 000000012bd18000 CR4: 00000000003506a0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 <NMI>
 </NMI>
 <TASK>
 pv_wait arch/x86/include/asm/paravirt.h:597 [inline]
 pv_wait_node kernel/locking/qspinlock_paravirt.h:325 [inline]
 __pv_queued_spin_lock_slowpath+0x41b/0xc40 kernel/locking/qspinlock.c:473
 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_bh include/linux/spinlock_api_smp.h:136 [inline]
 _raw_spin_lock_bh+0x139/0x1b0 kernel/locking/spinlock.c:178
 sock_hash_delete_elem+0xb1/0x2f0 net/core/sock_map.c:937
 bpf_prog_2c29ac5cdc6b1842+0x3a/0xbb8
 bpf_dispatcher_nop_func include/linux/bpf.h:785 [inline]
 __bpf_prog_run include/linux/filter.h:625 [inline]
 bpf_prog_run include/linux/filter.h:632 [inline]
 __bpf_trace_run kernel/trace/bpf_trace.c:1883 [inline]
 bpf_trace_run2+0xec/0x210 kernel/trace/bpf_trace.c:1920
 __bpf_trace_kfree+0x6f/0x90 include/trace/events/kmem.h:118
 trace_kfree include/trace/events/kmem.h:118 [inline]
 kfree+0x1f3/0x220 mm/slub.c:4569
 audit_log_d_path+0x270/0x2e0 kernel/audit.c:2164
 dump_common_audit_data security/lsm_audit.c:261 [inline]
 common_lsm_audit+0x9c0/0x18b0 security/lsm_audit.c:466
 slow_avc_audit+0x26c/0x3c0 security/selinux/avc.c:802
 avc_xperms_audit security/selinux/avc.c:433 [inline]
 avc_has_extended_perms+0xa2d/0x10f0 security/selinux/avc.c:1107
 ioctl_has_perm+0x3f5/0x560 security/selinux/hooks.c:3763
 selinux_file_ioctl+0x3cc/0x540
 security_file_ioctl+0x74/0xb0 security/security.c:1556
 __do_sys_ioctl fs/ioctl.c:868 [inline]
 __se_sys_ioctl+0x53/0x190 fs/ioctl.c:860
 __x64_sys_ioctl+0x7b/0x90 fs/ioctl.c:860
 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:0x7f3851edfee9
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:00007f3850c540c8 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 00007f3852016fa0 RCX: 00007f3851edfee9
RDX: 0000000020000340 RSI: 00000000401c5504 RDI: 0000000000000003
RBP: 00007f3851f2c47f R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 000000000000000b R14: 00007f3852016fa0 R15: 00007fff14202ec8
 </TASK>

Crashes (4):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2024/05/30 02:49 android13-5.15-lts 424f92bcbe8f 34889ee3 .config console log report info [disk image] [vmlinux] [kernel image] ci2-android-5-15 BUG: soft lockup in sys_recvmmsg
2024/05/21 14:54 android13-5.15-lts 5d96939590c0 4c0d3ee3 .config console log report info [disk image] [vmlinux] [kernel image] ci2-android-5-15 BUG: soft lockup in sys_recvmmsg
2024/05/19 08:08 android13-5.15-lts 5d96939590c0 c0f1611a .config console log report info [disk image] [vmlinux] [kernel image] ci2-android-5-15 BUG: soft lockup in sys_recvmmsg
2024/04/23 17:25 android13-5.15-lts ad06eaf051cd 21339d7b .config console log report info [disk image] [vmlinux] [kernel image] ci2-android-5-15 BUG: soft lockup in sys_recvmmsg
* Struck through repros no longer work on HEAD.