./strace-static-x86_64 -e \!wait4,clock_nanosleep,nanosleep -s 100 -x -f ./syz-executor1595210350 <...> Warning: Permanently added '10.128.0.100' (ED25519) to the list of known hosts. execve("./syz-executor1595210350", ["./syz-executor1595210350"], 0x7ffd69393e70 /* 10 vars */) = 0 brk(NULL) = 0x55556bb9e000 brk(0x55556bb9ed00) = 0x55556bb9ed00 arch_prctl(ARCH_SET_FS, 0x55556bb9e380) = 0 set_tid_address(0x55556bb9e650) = 5242 set_robust_list(0x55556bb9e660, 24) = 0 rseq(0x55556bb9eca0, 0x20, 0, 0x53053053) = 0 prlimit64(0, RLIMIT_STACK, NULL, {rlim_cur=8192*1024, rlim_max=RLIM64_INFINITY}) = 0 readlink("/proc/self/exe", "/root/syz-executor1595210350", 4096) = 28 getrandom("\x45\x12\xd5\x70\x00\x56\x09\xbd", 8, GRND_NONBLOCK) = 8 brk(NULL) = 0x55556bb9ed00 brk(0x55556bbbfd00) = 0x55556bbbfd00 brk(0x55556bbc0000) = 0x55556bbc0000 mprotect(0x7fb74e1de000, 16384, PROT_READ) = 0 mmap(0x1ffff000, 4096, PROT_NONE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x1ffff000 mmap(0x20000000, 16777216, PROT_READ|PROT_WRITE|PROT_EXEC, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x20000000 mmap(0x21000000, 4096, PROT_NONE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x21000000 clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5243 attached [pid 5243] set_robust_list(0x55556bb9e660, 24 [pid 5242] <... clone resumed>, child_tidptr=0x55556bb9e650) = 5243 [pid 5243] <... set_robust_list resumed>) = 0 [pid 5243] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5243] setpgid(0, 0) = 0 [pid 5243] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC) = 3 [pid 5243] write(3, "1000", 4) = 4 [pid 5243] close(3) = 0 [pid 5243] write(1, "executing program\n", 18executing program ) = 18 [pid 5243] bpf(BPF_PROG_LOAD, {prog_type=BPF_PROG_TYPE_UNSPEC, insn_cnt=12, insns=0x20000440, license=NULL, log_level=0, log_size=0, log_buf=NULL, kern_version=KERNEL_VERSION(0, 0, 0), prog_flags=0, prog_name="", prog_ifindex=0, expected_attach_type=BPF_CGROUP_INET_INGRESS, prog_btf_fd=-1, func_info_rec_size=0, func_info=NULL, func_info_cnt=0, line_info_rec_size=0, line_info=NULL, line_info_cnt=4294966948, attach_btf_id=0, attach_prog_fd=0, fd_array=NULL}, 144) = -1 EFAULT (Bad address) [pid 5243] socketpair(AF_TIPC, SOCK_DGRAM, 0, [3, 4]) = 0 [pid 5243] close(3) = 0 [pid 5243] bpf(BPF_MAP_CREATE, {map_type=BPF_MAP_TYPE_LPM_TRIE, key_size=7, value_size=65537, max_entries=8, map_flags=BPF_F_NO_PREALLOC, inner_map_fd=-1, map_name="", map_ifindex=0, btf_fd=-1, btf_key_type_id=0, btf_value_type_id=0, btf_vmlinux_value_type_id=0, map_extra=0}, 72) = 3 [pid 5243] bpf(BPF_PROG_LOAD, {prog_type=BPF_PROG_TYPE_UNSPEC, insn_cnt=12, insns=0x20000440, license=NULL, log_level=0, log_size=0, log_buf=NULL, kern_version=KERNEL_VERSION(0, 0, 0), prog_flags=0, prog_name="", prog_ifindex=0, expected_attach_type=BPF_CGROUP_INET_INGRESS, prog_btf_fd=-1, func_info_rec_size=0, func_info=NULL, func_info_cnt=0, line_info_rec_size=0, line_info=NULL, line_info_cnt=0, attach_btf_id=0, attach_prog_fd=0, fd_array=NULL}, 144) = -1 EFAULT (Bad address) [pid 5243] close(3) = 0 [pid 5243] bpf(BPF_MAP_CREATE, {map_type=BPF_MAP_TYPE_LPM_TRIE, key_size=7, value_size=3983, max_entries=9, map_flags=BPF_F_NO_PREALLOC, inner_map_fd=-1, map_name="", map_ifindex=0, btf_fd=-1, btf_key_type_id=0, btf_value_type_id=0, btf_vmlinux_value_type_id=0, map_extra=0}, 72) = 3 [pid 5243] bpf(BPF_MAP_UPDATE_ELEM, {map_fd=3, key=0x20000340, value=0x20000200, flags=BPF_ANY}, 32) = 0 [pid 5243] bpf(BPF_PROG_LOAD, {prog_type=BPF_PROG_TYPE_RAW_TRACEPOINT, insn_cnt=12, insns=0x20000440, license="GPL", log_level=0, log_size=0, log_buf=NULL, kern_version=KERNEL_VERSION(0, 0, 0), prog_flags=0, prog_name="", prog_ifindex=0, expected_attach_type=BPF_CGROUP_INET_INGRESS, prog_btf_fd=-1, func_info_rec_size=0, func_info=NULL, func_info_cnt=0, line_info_rec_size=0, line_info=NULL, line_info_cnt=0, attach_btf_id=0, attach_prog_fd=0, fd_array=NULL}, 144) = 5 [pid 5243] bpf(BPF_RAW_TRACEPOINT_OPEN, {raw_tracepoint={name="timer_start", prog_fd=5}}, 16) = 6 [pid 5243] exit_group(0) = ? [pid 5243] +++ exited with 0 +++ --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5243, si_uid=0, si_status=0, si_utime=0, si_stime=0} --- restart_syscall(<... resuming interrupted clone ...>) = 0 clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5244 attached [pid 5244] set_robust_list(0x55556bb9e660, 24 [pid 5242] <... clone resumed>, child_tidptr=0x55556bb9e650) = 5244 [pid 5244] <... set_robust_list resumed>) = 0 [pid 5244] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5244] setpgid(0, 0) = 0 [pid 5244] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC) = 3 [pid 5244] write(3, "1000", 4) = 4 [pid 5244] close(3) = 0 [pid 5244] write(1, "executing program\n", 18executing program ) = 18 [pid 5244] bpf(BPF_PROG_LOAD, {prog_type=BPF_PROG_TYPE_UNSPEC, insn_cnt=12, insns=0x20000440, license=NULL, log_level=0, log_size=0, log_buf=NULL, kern_version=KERNEL_VERSION(0, 0, 0), prog_flags=0, prog_name="", prog_ifindex=0, expected_attach_type=BPF_CGROUP_INET_INGRESS, prog_btf_fd=-1, func_info_rec_size=0, func_info=NULL, func_info_cnt=0, line_info_rec_size=0, line_info=NULL, line_info_cnt=4294966948, attach_btf_id=0, attach_prog_fd=0, fd_array=NULL}, 144) = -1 EFAULT (Bad address) [pid 5244] socketpair(AF_TIPC, SOCK_DGRAM, 0, [3, 4]) = 0 [pid 5244] close(3) = 0 [pid 5244] bpf(BPF_MAP_CREATE, {map_type=BPF_MAP_TYPE_LPM_TRIE, key_size=7, value_size=65537, max_entries=8, map_flags=BPF_F_NO_PREALLOC, inner_map_fd=-1, map_name="", map_ifindex=0, btf_fd=-1, btf_key_type_id=0, btf_value_type_id=0, btf_vmlinux_value_type_id=0, map_extra=0}, 72) = 3 [pid 5244] bpf(BPF_PROG_LOAD, {prog_type=BPF_PROG_TYPE_UNSPEC, insn_cnt=12, insns=0x20000440, license=NULL, log_level=0, log_size=0, log_buf=NULL, kern_version=KERNEL_VERSION(0, 0, 0), prog_flags=0, prog_name="", prog_ifindex=0, expected_attach_type=BPF_CGROUP_INET_INGRESS, prog_btf_fd=-1, func_info_rec_size=0, func_info=NULL, func_info_cnt=0, line_info_rec_size=0, line_info=NULL, line_info_cnt=0, attach_btf_id=0, attach_prog_fd=0, fd_array=NULL}, 144) = -1 EFAULT (Bad address) [pid 5244] close(3) = 0 [pid 5244] bpf(BPF_MAP_CREATE, {map_type=BPF_MAP_TYPE_LPM_TRIE, key_size=7, value_size=3983, max_entries=9, map_flags=BPF_F_NO_PREALLOC, inner_map_fd=-1, map_name="", map_ifindex=0, btf_fd=-1, btf_key_type_id=0, btf_value_type_id=0, btf_vmlinux_value_type_id=0, map_extra=0}, 72) = 3 [pid 5244] bpf(BPF_MAP_UPDATE_ELEM, {map_fd=3, key=0x20000340, value=0x20000200, flags=BPF_ANY}, 32) = 0 [pid 5244] bpf(BPF_PROG_LOAD, {prog_type=BPF_PROG_TYPE_RAW_TRACEPOINT, insn_cnt=12, insns=0x20000440, license="GPL", log_level=0, log_size=0, log_buf=NULL, kern_version=KERNEL_VERSION(0, 0, 0), prog_flags=0, prog_name="", prog_ifindex=0, expected_attach_type=BPF_CGROUP_INET_INGRESS, prog_btf_fd=-1, func_info_rec_size=0, func_info=NULL, func_info_cnt=0, line_info_rec_size=0, line_info=NULL, line_info_cnt=0, attach_btf_id=0, attach_prog_fd=0, fd_array=NULL}, 144) = 5 [ 78.692803][ T5237] [ 78.695213][ T5237] ====================================================== [ 78.702244][ T5237] WARNING: possible circular locking dependency detected [ 78.709280][ T5237] 6.11.0-rc5-syzkaller-00155-ga3c1e45156ad #0 Not tainted [ 78.716386][ T5237] ------------------------------------------------------ [ 78.723402][ T5237] sshd/5237 is trying to acquire lock: [ 78.728865][ T5237] ffff8880b8829430 (krc.lock){....}-{2:2}, at: kvfree_call_rcu+0x18a/0x790 [ 78.737531][ T5237] [ 78.737531][ T5237] but task is already holding lock: [ 78.744892][ T5237] ffff8880b882a718 (&base->lock){-.-.}-{2:2}, at: __mod_timer+0x744/0xeb0 [ 78.753445][ T5237] [ 78.753445][ T5237] which lock already depends on the new lock. [ 78.753445][ T5237] [ 78.763869][ T5237] [ 78.763869][ T5237] the existing dependency chain (in reverse order) is: [ 78.772999][ T5237] [ 78.772999][ T5237] -> #1 (&base->lock){-.-.}-{2:2}: [ 78.780402][ T5237] lock_acquire+0x1ed/0x550 [ 78.785444][ T5237] _raw_spin_lock_irqsave+0xd5/0x120 [ 78.791361][ T5237] lock_timer_base+0x112/0x240 [ 78.796653][ T5237] __mod_timer+0x1ca/0xeb0 [ 78.801599][ T5237] queue_delayed_work_on+0x1ca/0x390 [ 78.807415][ T5237] kvfree_call_rcu+0x47f/0x790 [ 78.812709][ T5237] pwq_release_workfn+0x6d1/0x860 [ 78.818262][ T5237] kthread_worker_fn+0x500/0xaf0 [ 78.823729][ T5237] kthread+0x2f0/0x390 [ 78.828388][ T5237] ret_from_fork+0x4b/0x80 [ 78.833335][ T5237] ret_from_fork_asm+0x1a/0x30 [ 78.838642][ T5237] [ 78.838642][ T5237] -> #0 (krc.lock){....}-{2:2}: [ 78.845878][ T5237] validate_chain+0x18e0/0x5900 [ 78.851360][ T5237] __lock_acquire+0x137a/0x2040 [ 78.856746][ T5237] lock_acquire+0x1ed/0x550 [ 78.861868][ T5237] _raw_spin_lock+0x2e/0x40 [ 78.866926][ T5237] kvfree_call_rcu+0x18a/0x790 [ 78.872221][ T5237] trie_delete_elem+0x546/0x6a0 [ 78.877599][ T5237] bpf_prog_2c29ac5cdc6b1842+0x42/0x46 [ 78.883591][ T5237] bpf_trace_run2+0x2ec/0x540 [ 78.888790][ T5237] enqueue_timer+0x3ce/0x570 [ 78.893915][ T5237] __mod_timer+0xa0e/0xeb0 [ 78.898872][ T5237] sk_reset_timer+0x23/0xc0 [ 78.903910][ T5237] tcp_schedule_loss_probe+0x448/0x590 [ 78.909909][ T5237] tcp_write_xmit+0x4308/0x6a10 [ 78.915286][ T5237] __tcp_push_pending_frames+0x9b/0x360 [ 78.921360][ T5237] tcp_sendmsg_locked+0x43b1/0x4e10 [ 78.927079][ T5237] tcp_sendmsg+0x30/0x50 [ 78.931933][ T5237] __sock_sendmsg+0x1a6/0x270 [ 78.937248][ T5237] sock_write_iter+0x2dd/0x400 [ 78.942558][ T5237] vfs_write+0xa72/0xc90 [ 78.947324][ T5237] ksys_write+0x1a0/0x2c0 [ 78.952174][ T5237] do_syscall_64+0xf3/0x230 [ 78.957198][ T5237] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 78.963620][ T5237] [ 78.963620][ T5237] other info that might help us debug this: [ 78.963620][ T5237] [ 78.974035][ T5237] Possible unsafe locking scenario: [ 78.974035][ T5237] [ 78.981491][ T5237] CPU0 CPU1 [ 78.986885][ T5237] ---- ---- [ 78.992339][ T5237] lock(&base->lock); [ 78.996425][ T5237] lock(krc.lock); [ 79.002760][ T5237] lock(&base->lock); [ 79.009440][ T5237] lock(krc.lock); [ 79.013256][ T5237] [ 79.013256][ T5237] *** DEADLOCK *** [ 79.013256][ T5237] [ 79.021401][ T5237] 3 locks held by sshd/5237: [ 79.025988][ T5237] #0: ffff88807cdc2718 (sk_lock-AF_INET){+.+.}-{0:0}, at: tcp_sendmsg+0x22/0x50 [ 79.035165][ T5237] #1: ffff8880b882a718 (&base->lock){-.-.}-{2:2}, at: __mod_timer+0x744/0xeb0 [ 79.044165][ T5237] #2: ffffffff8e938320 (rcu_read_lock){....}-{1:2}, at: bpf_trace_run2+0x1fc/0x540 [ 79.053584][ T5237] [ 79.053584][ T5237] stack backtrace: [ 79.059490][ T5237] CPU: 0 UID: 0 PID: 5237 Comm: sshd Not tainted 6.11.0-rc5-syzkaller-00155-ga3c1e45156ad #0 [ 79.069691][ T5237] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 08/06/2024 [ 79.079761][ T5237] Call Trace: [ 79.083048][ T5237] [ 79.085990][ T5237] dump_stack_lvl+0x241/0x360 [ 79.090683][ T5237] ? __pfx_dump_stack_lvl+0x10/0x10 [ 79.095904][ T5237] ? print_circular_bug+0x130/0x1a0 [ 79.101109][ T5237] check_noncircular+0x36a/0x4a0 [ 79.106055][ T5237] ? __pfx_check_noncircular+0x10/0x10 [ 79.111522][ T5237] ? lockdep_lock+0x123/0x2b0 [ 79.116216][ T5237] ? mark_lock+0x9a/0x350 [ 79.120563][ T5237] validate_chain+0x18e0/0x5900 [ 79.125431][ T5237] ? __pfx_validate_chain+0x10/0x10 [ 79.130641][ T5237] ? stack_depot_save_flags+0x6e4/0x830 [ 79.136202][ T5237] ? do_raw_spin_lock+0x14f/0x370 [ 79.141234][ T5237] ? __pfx_lock_release+0x10/0x10 [ 79.146273][ T5237] ? do_raw_spin_unlock+0x13c/0x8b0 [ 79.151497][ T5237] ? _raw_spin_unlock_irqrestore+0xdd/0x140 [ 79.157436][ T5237] ? __pfx__raw_spin_unlock_irqrestore+0x10/0x10 [ 79.163804][ T5237] ? stack_trace_save+0x118/0x1d0 [ 79.168861][ T5237] ? mark_lock+0x9a/0x350 [ 79.173250][ T5237] __lock_acquire+0x137a/0x2040 [ 79.178135][ T5237] lock_acquire+0x1ed/0x550 [ 79.182652][ T5237] ? kvfree_call_rcu+0x18a/0x790 [ 79.187610][ T5237] ? __pfx_lock_acquire+0x10/0x10 [ 79.192657][ T5237] ? __phys_addr+0xba/0x170 [ 79.197168][ T5237] _raw_spin_lock+0x2e/0x40 [ 79.201704][ T5237] ? kvfree_call_rcu+0x18a/0x790 [ 79.206656][ T5237] kvfree_call_rcu+0x18a/0x790 [ 79.211524][ T5237] ? _raw_spin_unlock_irqrestore+0xdd/0x140 [ 79.217436][ T5237] ? __pfx_kvfree_call_rcu+0x10/0x10 [ 79.222738][ T5237] ? longest_prefix_match+0x49f/0x650 [ 79.228169][ T5237] trie_delete_elem+0x546/0x6a0 [ 79.233045][ T5237] ? bpf_trace_run2+0x1fc/0x540 [ 79.237908][ T5237] bpf_prog_2c29ac5cdc6b1842+0x42/0x46 [ 79.243369][ T5237] bpf_trace_run2+0x2ec/0x540 [ 79.248057][ T5237] ? __pfx_bpf_trace_run2+0x10/0x10 [ 79.253270][ T5237] ? __pfx_debug_object_activate+0x10/0x10 [ 79.259111][ T5237] ? __pfx_do_raw_spin_lock+0x10/0x10 [ 79.264502][ T5237] enqueue_timer+0x3ce/0x570 [ 79.269204][ T5237] __mod_timer+0xa0e/0xeb0 [ 79.273636][ T5237] ? __pfx___mod_timer+0x10/0x10 [ 79.278583][ T5237] ? ktime_get+0x3c/0xb0 [ 79.282840][ T5237] ? __asan_memset+0x23/0x50 [ 79.287441][ T5237] sk_reset_timer+0x23/0xc0 [ 79.291962][ T5237] tcp_schedule_loss_probe+0x448/0x590 [ 79.297435][ T5237] tcp_write_xmit+0x4308/0x6a10 [ 79.302311][ T5237] ? __virt_addr_valid+0x183/0x530 [ 79.307444][ T5237] ? __alloc_skb+0x2d5/0x440 [ 79.312051][ T5237] __tcp_push_pending_frames+0x9b/0x360 [ 79.317610][ T5237] tcp_sendmsg_locked+0x43b1/0x4e10 [ 79.322842][ T5237] ? __pfx_tcp_sendmsg_locked+0x10/0x10 [ 79.328391][ T5237] ? __local_bh_enable_ip+0x168/0x200 [ 79.333774][ T5237] ? do_raw_spin_unlock+0x13c/0x8b0 [ 79.338984][ T5237] tcp_sendmsg+0x30/0x50 [ 79.343233][ T5237] __sock_sendmsg+0x1a6/0x270 [ 79.348011][ T5237] sock_write_iter+0x2dd/0x400 [ 79.352788][ T5237] ? __pfx_sock_write_iter+0x10/0x10 [ 79.358089][ T5237] ? bpf_lsm_file_permission+0x9/0x10 [ 79.363476][ T5237] ? security_file_permission+0x7f/0xa0 [ 79.369042][ T5237] vfs_write+0xa72/0xc90 [ 79.373645][ T5237] ? __pfx_sock_write_iter+0x10/0x10 [ 79.379031][ T5237] ? __pfx_vfs_write+0x10/0x10 [ 79.383804][ T5237] ? kvm_sched_clock_read+0x11/0x20 [ 79.389016][ T5237] ? sched_clock+0x4a/0x70 [ 79.393441][ T5237] ? __might_fault+0xc6/0x120 [ 79.398131][ T5237] ksys_write+0x1a0/0x2c0 [ 79.402496][ T5237] ? __pfx_ksys_write+0x10/0x10 [ 79.407351][ T5237] ? __pfx_lockdep_hardirqs_on_prepare+0x10/0x10 [ 79.413689][ T5237] ? __irq_exit_rcu+0x100/0x1c0 [ 79.418550][ T5237] ? do_syscall_64+0xb6/0x230 [ 79.423234][ T5237] do_syscall_64+0xf3/0x230 [ 79.427747][ T5237] ? clear_bhb_loop+0x35/0x90 [ 79.432522][ T5237] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 79.438521][ T5237] RIP: 0033:0x7fa996b16bf2 [ 79.442942][ T5237] Code: 89 c7 48 89 44 24 08 e8 7b 34 fa ff 48 8b 44 24 08 48 83 c4 28 c3 c3 64 8b 04 25 18 00 00 00 85 c0 75 20 b8 01 00 00 00 0f 05 <48> 3d 00 f0 ff ff 76 6f 48 8b 15 07 a2 0d 00 f7 d8 64 89 02 48 83 [ 79.462561][ T5237] RSP: 002b:00007ffea0169a58 EFLAGS: 00000246 ORIG_RAX: 0000000000000001 [ 79.470985][ T5237] RAX: ffffffffffffffda RBX: 0000000000000084 RCX: 00007fa996b16bf2 [ 79.478961][ T5237] RDX: 0000000000000084 RSI: 000055651d85c960 RDI: 0000000000000004 [ 79.486939][ T5237] RBP: 000055651d8653f0 R08: 0000000000000000 R09: 0000000000000000 [ 79.494914][ T5237] R10: 0000000000000000 R11: 0000000000000246 R12: 00005564f205baa4 [ 79.502886][ T5237] R13: 000000000000004e R14: 00005564f205c3e8 R15: 00007ffea0169ac8 [ 79.510868][ T5237]