./strace-static-x86_64 -e \!wait4,clock_nanosleep,nanosleep -s 100 -x -f ./syz-executor1192097845 <...> Warning: Permanently added '10.128.1.89' (ECDSA) to the list of known hosts. execve("./syz-executor1192097845", ["./syz-executor1192097845"], 0x7ffe90c04cf0 /* 10 vars */) = 0 brk(NULL) = 0x555556825000 brk(0x555556825c40) = 0x555556825c40 arch_prctl(ARCH_SET_FS, 0x555556825300) = 0 uname({sysname="Linux", nodename="syzkaller", ...}) = 0 readlink("/proc/self/exe", "/root/syz-executor1192097845", 4096) = 28 brk(0x555556846c40) = 0x555556846c40 brk(0x555556847000) = 0x555556847000 mprotect(0x7ffb4281a000, 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 5079 attached , child_tidptr=0x5555568255d0) = 5079 [pid 5078] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5079] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5078] <... clone resumed>, child_tidptr=0x5555568255d0) = 5080 [pid 5078] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x5555568255d0) = 5081 [pid 5078] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5081 attached [pid 5079] <... clone resumed>, child_tidptr=0x5555568255d0) = 5082 [pid 5081] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5082 attached [pid 5078] <... clone resumed>, child_tidptr=0x5555568255d0) = 5083 [pid 5078] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5082] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5078] <... clone resumed>, child_tidptr=0x5555568255d0) = 5084 [pid 5078] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5082] setpgid(0, 0) = 0 ./strace-static-x86_64: Process 5080 attached [pid 5080] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5082] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5078] <... clone resumed>, child_tidptr=0x5555568255d0) = 5085 ./strace-static-x86_64: Process 5083 attached [pid 5083] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5080] <... clone resumed>, child_tidptr=0x5555568255d0) = 5086 [pid 5081] <... clone resumed>, child_tidptr=0x5555568255d0) = 5087 [pid 5082] <... openat resumed>) = 3 [pid 5082] write(3, "1000", 4./strace-static-x86_64: Process 5084 attached [pid 5083] <... clone resumed>, child_tidptr=0x5555568255d0) = 5088 [pid 5082] <... write resumed>) = 4 [pid 5082] close(3./strace-static-x86_64: Process 5085 attached ) = 0 [pid 5082] bpf(BPF_PROG_LOAD, {prog_type=BPF_PROG_TYPE_RAW_TRACEPOINT, insn_cnt=8, insns=0x20002040, 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}, 72./strace-static-x86_64: Process 5088 attached ./strace-static-x86_64: Process 5087 attached ./strace-static-x86_64: Process 5086 attached [pid 5085] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5084] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5090 attached ./strace-static-x86_64: Process 5089 attached [pid 5088] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5087] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5086] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5082] <... bpf resumed>) = 3 [pid 5082] bpf(BPF_RAW_TRACEPOINT_OPEN, {raw_tracepoint={name="contention_begin", prog_fd=3}}, 16 [pid 5090] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5088] <... prctl resumed>) = 0 [pid 5087] <... prctl resumed>) = 0 [pid 5086] <... prctl resumed>) = 0 [pid 5085] <... clone resumed>, child_tidptr=0x5555568255d0) = 5090 [pid 5084] <... clone resumed>, child_tidptr=0x5555568255d0) = 5089 [pid 5082] <... bpf resumed>) = 4 [pid 5082] exit_group(0) = ? [pid 5088] setpgid(0, 0 [pid 5087] setpgid(0, 0 [pid 5086] setpgid(0, 0 [pid 5090] <... prctl resumed>) = 0 [pid 5089] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5088] <... setpgid resumed>) = 0 [pid 5087] <... setpgid resumed>) = 0 [pid 5086] <... setpgid resumed>) = 0 [pid 5088] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5087] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5082] +++ exited with 0 +++ [pid 5086] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5090] setpgid(0, 0 [pid 5088] <... openat resumed>) = 3 [pid 5087] <... openat resumed>) = 3 [pid 5086] <... openat resumed>) = 3 [pid 5079] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5082, si_uid=0, si_status=0, si_utime=0, si_stime=0} --- [pid 5090] <... setpgid resumed>) = 0 [pid 5089] <... prctl resumed>) = 0 [pid 5088] write(3, "1000", 4 [pid 5087] write(3, "1000", 4 [pid 5086] write(3, "1000", 4 [pid 5090] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5088] <... write resumed>) = 4 [pid 5087] <... write resumed>) = 4 [pid 5086] <... write resumed>) = 4 [pid 5090] <... openat resumed>) = 3 [pid 5088] close(3 [pid 5087] close(3 [pid 5086] close(3 [pid 5090] write(3, "1000", 4 [pid 5089] setpgid(0, 0 [pid 5088] <... close resumed>) = 0 [pid 5087] <... close resumed>) = 0 [pid 5086] <... close resumed>) = 0 [pid 5079] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5090] <... write resumed>) = 4 [pid 5088] bpf(BPF_PROG_LOAD, {prog_type=BPF_PROG_TYPE_RAW_TRACEPOINT, insn_cnt=8, insns=0x20002040, 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}, 72 [pid 5090] close(3) = 0 [pid 5090] bpf(BPF_PROG_LOAD, {prog_type=BPF_PROG_TYPE_RAW_TRACEPOINT, insn_cnt=8, insns=0x20002040, 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}, 72 [pid 5087] bpf(BPF_PROG_LOAD, {prog_type=BPF_PROG_TYPE_RAW_TRACEPOINT, insn_cnt=8, insns=0x20002040, 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}, 72 [pid 5086] bpf(BPF_PROG_LOAD, {prog_type=BPF_PROG_TYPE_RAW_TRACEPOINT, insn_cnt=8, insns=0x20002040, 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}, 72./strace-static-x86_64: Process 5091 attached [pid 5090] <... bpf resumed>) = 3 [pid 5089] <... setpgid resumed>) = 0 [pid 5088] <... bpf resumed>) = 3 [pid 5079] <... clone resumed>, child_tidptr=0x5555568255d0) = 5091 [pid 5090] bpf(BPF_RAW_TRACEPOINT_OPEN, {raw_tracepoint={name="contention_begin", prog_fd=3}}, 16 [pid 5087] <... bpf resumed>) = 3 [pid 5090] <... bpf resumed>) = 4 [pid 5089] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5088] bpf(BPF_RAW_TRACEPOINT_OPEN, {raw_tracepoint={name="contention_begin", prog_fd=3}}, 16 [pid 5087] bpf(BPF_RAW_TRACEPOINT_OPEN, {raw_tracepoint={name="contention_begin", prog_fd=3}}, 16 [pid 5086] <... bpf resumed>) = 3 [pid 5091] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5090] exit_group(0) = ? [ 58.039376][ T5073] [ 58.041758][ T5073] ============================================ [ 58.049039][ T5073] WARNING: possible recursive locking detected [ 58.055920][ T5073] 6.1.0-syzkaller-14017-g45435d8da71f #0 Not tainted [ 58.062867][ T5073] -------------------------------------------- [ 58.069043][ T5073] sshd/5073 is trying to acquire lock: [ 58.074520][ T5073] ffffffff8c81a238 (trace_printk_lock){....}-{2:2}, at: bpf_trace_printk+0xd3/0x170 [ 58.083989][ T5073] [ 58.083989][ T5073] but task is already holding lock: [ 58.091368][ T5073] ffffffff8c81a238 (trace_printk_lock){....}-{2:2}, at: bpf_trace_printk+0xd3/0x170 [ 58.100817][ T5073] [ 58.100817][ T5073] other info that might help us debug this: [ 58.110221][ T5073] Possible unsafe locking scenario: [ 58.110221][ T5073] [ 58.117776][ T5073] CPU0 [ 58.121071][ T5073] ---- [ 58.124363][ T5073] lock(trace_printk_lock); [ 58.129076][ T5073] lock(trace_printk_lock); [ 58.134130][ T5073] [ 58.134130][ T5073] *** DEADLOCK *** [ 58.134130][ T5073] [ 58.142437][ T5073] May be due to missing lock nesting notation [ 58.142437][ T5073] [ 58.151071][ T5073] 4 locks held by sshd/5073: [ 58.155777][ T5073] #0: ffff88801818b468 (&pipe->mutex/1){+.+.}-{3:3}, at: pipe_read+0x13d/0x1110 [ 58.165267][ T5073] #1: ffffffff8c7917c0 (rcu_read_lock){....}-{1:2}, at: bpf_trace_run2+0xbd/0x3d0 [ 58.174727][ T5073] #2: ffffffff8c81a238 (trace_printk_lock){....}-{2:2}, at: bpf_trace_printk+0xd3/0x170 [ 58.184705][ T5073] #3: ffffffff8c7917c0 (rcu_read_lock){....}-{1:2}, at: bpf_trace_run2+0xbd/0x3d0 [ 58.194089][ T5073] [ 58.194089][ T5073] stack backtrace: [ 58.199993][ T5073] CPU: 0 PID: 5073 Comm: sshd Not tainted 6.1.0-syzkaller-14017-g45435d8da71f #0 [ 58.209646][ T5073] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 10/26/2022 [ 58.220568][ T5073] Call Trace: [ 58.224823][ T5073] [ 58.227895][ T5073] dump_stack_lvl+0xd1/0x138 [ 58.233283][ T5073] __lock_acquire.cold+0x116/0x3a7 [ 58.239039][ T5073] ? lockdep_hardirqs_on_prepare+0x410/0x410 [ 58.245142][ T5073] ? lock_chain_count+0x20/0x20 [ 58.250035][ T5073] lock_acquire+0x1e3/0x630 [ 58.254566][ T5073] ? bpf_trace_printk+0xd3/0x170 [ 58.259713][ T5073] ? lock_release+0x810/0x810 [ 58.265010][ T5073] ? bpf_bprintf_cleanup+0x60/0x60 [ 58.270137][ T5073] _raw_spin_lock_irqsave+0x3d/0x60 [ 58.275736][ T5073] ? bpf_trace_printk+0xd3/0x170 [ 58.280896][ T5073] bpf_trace_printk+0xd3/0x170 [ 58.285695][ T5073] ? trace_bpf_trace_printk+0x2b0/0x2b0 [ 58.291240][ T5073] ? lock_chain_count+0x20/0x20 [ 58.296107][ T5073] ? bpf_trace_run2+0x151/0x3d0 [ 58.301081][ T5073] ? __bpf_trace_bpf_trace_printk+0xc0/0xc0 [ 58.307007][ T5073] ? __bpf_trace_lock+0xe0/0xe0 [ 58.311886][ T5073] ? __bpf_trace_contention_begin+0xb9/0xf0 [ 58.317791][ T5073] ? __bpf_trace_lock+0xe0/0xe0 [ 58.322791][ T5073] ? __lock_acquire+0x166e/0x56d0 [ 58.328621][ T5073] ? __traceiter_contention_begin+0x5a/0xa0 [ 58.334546][ T5073] ? trace_contention_begin.constprop.0+0x143/0x240 [ 58.341246][ T5073] ? __pv_queued_spin_lock_slowpath+0x107/0xb50 [ 58.347503][ T5073] ? .slowpath+0x1a/0x1a [ 58.351785][ T5073] ? do_raw_spin_lock+0x204/0x2b0 [ 58.356846][ T5073] ? rwlock_bug.part.0+0x90/0x90 [ 58.361811][ T5073] ? _raw_spin_lock_irqsave+0x52/0x60 [ 58.367189][ T5073] ? _raw_spin_lock_irqsave+0x45/0x60 [ 58.372557][ T5073] ? bpf_trace_printk+0xd3/0x170 [ 58.377502][ T5073] ? bpf_trace_printk+0xd3/0x170 [ 58.382465][ T5073] ? trace_bpf_trace_printk+0x2b0/0x2b0 [ 58.388129][ T5073] ? bpf_trace_run2+0x16f/0x3d0 [ 58.393044][ T5073] ? bpf_prog_0605f9f479290f07+0x37/0x3b [ 58.398776][ T5073] ? bpf_trace_run2+0x151/0x3d0 [ 58.403657][ T5073] ? __bpf_trace_bpf_trace_printk+0xc0/0xc0 [ 58.409750][ T5073] ? __lock_acquire+0xbc3/0x56d0 [ 58.414691][ T5073] ? __bpf_trace_lock+0xe0/0xe0 [ 58.419549][ T5073] ? __bpf_trace_contention_begin+0xb9/0xf0 [ 58.425483][ T5073] ? __bpf_trace_lock+0xe0/0xe0 [ 58.430369][ T5073] ? lock_release+0x810/0x810 [ 58.435068][ T5073] ? __traceiter_contention_begin+0x5a/0xa0 [ 58.440987][ T5073] ? trace_contention_begin+0x129/0x1e0 [ 58.447000][ T5073] ? __mutex_lock+0x13c/0x1360 [ 58.451783][ T5073] ? pipe_read+0x13d/0x1110 [ 58.456306][ T5073] ? aa_file_perm+0x568/0x1210 [ 58.461064][ T5073] ? pipe_read+0x13d/0x1110 [ 58.465667][ T5073] ? mutex_lock_io_nested+0x11a0/0x11a0 [ 58.471216][ T5073] ? aa_file_perm+0x592/0x1210 [ 58.476000][ T5073] ? pipe_read+0x13d/0x1110 [ 58.481049][ T5073] ? put_timespec64+0xcf/0x120 [ 58.485848][ T5073] ? pipe_ioctl+0x2c0/0x2c0 [ 58.490387][ T5073] ? fsnotify_perm.part.0+0x221/0x610 [ 58.495792][ T5073] ? apparmor_file_permission+0x268/0x4e0 [ 58.501635][ T5073] ? security_file_permission+0xaf/0xd0 [ 58.507201][ T5073] ? vfs_read+0x7fa/0x930 [ 58.511545][ T5073] ? kernel_read+0x1c0/0x1c0 [ 58.516260][ T5073] ? __fget_light+0x20a/0x270 [ 58.520965][ T5073] ? ksys_read+0x1ec/0x250 [ 58.525409][ T5073] ? vfs_write+0xdd0/0xdd0 [ 58.529844][ T5073] ? syscall_enter_from_user_mode+0x26/0xb0 [ 58.535748][ T5073] ? do_syscall_64+0x39/0xb0 [ 58.540344][ T5073] ? entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 58.546606][ T5073] [ 58.551893][ T4415] ------------[ cut here ]------------ [ 58.557367][ T4415] WARNING: CPU: 0 PID: 4415 at kernel/bpf/helpers.c:776 bpf_bprintf_prepare+0xf35/0x11b0 [ 58.567173][ T4415] Modules linked in: [ 58.571051][ T4415] CPU: 0 PID: 4415 Comm: syslogd Not tainted 6.1.0-syzkaller-14017-g45435d8da71f #0 [ 58.580416][ T4415] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 10/26/2022 [ 58.590554][ T4415] RIP: 0010:bpf_bprintf_prepare+0xf35/0x11b0 [ 58.596544][ T4415] Code: ff e8 4f f2 e9 ff 48 83 7c 24 08 00 41 bd 04 00 00 00 0f 85 8a fa ff ff e8 38 f2 e9 ff 8d 6b 03 e9 f7 f6 ff ff e8 2b f2 e9 ff <0f> 0b 65 ff 0d ca f3 6b 7e bf 01 00 00 00 41 bc f0 ff ff ff e8 82 [ 58.616188][ T4415] RSP: 0018:ffffc9000313e918 EFLAGS: 00010093 [ 58.622285][ T4415] RAX: 0000000000000000 RBX: 0000000000000002 RCX: 0000000000000000 [ 58.630464][ T4415] RDX: ffff88807e871d40 RSI: ffffffff81975fb5 RDI: 0000000000000005 [ 58.638457][ T4415] RBP: ffffc9000313ea48 R08: 0000000000000005 R09: 0000000000000003 [ 58.646446][ T4415] R10: 0000000000000004 R11: 0000000000000000 R12: 0000000000000003 [ 58.654417][ T4415] R13: 0000000000000004 R14: ffffc9000313eb00 R15: 0000000000000003 [ 58.662389][ T4415] FS: 00007f95c4f57800(0000) GS:ffff8880b9800000(0000) knlGS:0000000000000000 [ 58.671325][ T4415] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 58.677929][ T4415] CR2: 00007ffb4281e130 CR3: 0000000028c67000 CR4: 00000000003506f0 [ 58.685935][ T4415] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [ 58.693916][ T4415] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [ 58.702067][ T4415] Call Trace: [ 58.705343][ T4415] [ 58.708288][ T4415] ? mark_lock.part.0+0xee/0x1910 [ 58.713332][ T4415] ? bpf_bprintf_cleanup+0x60/0x60 [ 58.718557][ T4415] ? read_pages+0x62d/0xd40 [ 58.723274][ T4415] ? lock_chain_count+0x20/0x20 [ 58.728759][ T4415] bpf_trace_printk+0xaf/0x170 [ 58.735378][ T4415] ? trace_bpf_trace_printk+0x2b0/0x2b0 [ 58.740956][ T4415] ? lock_release+0x810/0x810 [ 58.745645][ T4415] ? lock_chain_count+0x20/0x20 [ 58.750523][ T4415] ? lock_chain_count+0x20/0x20 [ 58.756116][ T4415] ? bpf_trace_run2+0x151/0x3d0 [ 58.762135][ T4415] ? __bpf_trace_bpf_trace_printk+0xc0/0xc0 [ 58.769198][ T4415] ? __bpf_trace_lock+0xe0/0xe0 [ 58.774953][ T4415] ? __bpf_trace_contention_begin+0xb9/0xf0 [ 58.781160][ T4415] ? __bpf_trace_lock+0xe0/0xe0 [ 58.786040][ T4415] ? lockdep_hardirqs_on_prepare+0x410/0x410 [ 58.792131][ T4415] ? __traceiter_contention_begin+0x5a/0xa0 [ 58.798144][ T4415] ? trace_contention_begin.constprop.0+0x143/0x240 [ 58.804771][ T4415] ? __pv_queued_spin_lock_slowpath+0x107/0xb50 [ 58.811127][ T4415] ? .slowpath+0x1a/0x1a [ 58.815395][ T4415] ? rcu_read_lock_sched_held+0x11/0x70 [ 58.821153][ T4415] ? lock_acquire+0x500/0x630 [ 58.826129][ T4415] ? do_raw_spin_lock+0x204/0x2b0 [ 58.831178][ T4415] ? rwlock_bug.part.0+0x90/0x90 [ 58.836129][ T4415] ? lock_chain_count+0x20/0x20 [ 58.840998][ T4415] ? lock_chain_count+0x20/0x20 [ 58.845866][ T4415] ? _raw_spin_lock_irqsave+0x45/0x60 [ 58.851393][ T4415] ? bpf_trace_printk+0xd3/0x170 [ 58.856680][ T4415] ? bpf_trace_printk+0xd3/0x170 [ 58.861983][ T4415] ? trace_bpf_trace_printk+0x2b0/0x2b0 [ 58.867670][ T4415] ? bpf_trace_run2+0x151/0x3d0 [ 58.872640][ T4415] ? __bpf_trace_bpf_trace_printk+0xc0/0xc0 [ 58.878678][ T4415] ? __bpf_trace_lock+0xe0/0xe0 [ 58.884103][ T4415] ? __bpf_trace_contention_begin+0xb9/0xf0 [ 58.890840][ T4415] ? __bpf_trace_lock+0xe0/0xe0 [ 58.895820][ T4415] ? rb_commit+0x13f/0x8c0 [ 58.900784][ T4415] ? __traceiter_contention_begin+0x5a/0xa0 [ 58.906808][ T4415] ? trace_contention_begin.constprop.0+0x143/0x240 [ 58.913630][ T4415] ? __pv_queued_spin_lock_slowpath+0x107/0xb50 [ 58.920194][ T4415] ? trace_event_buffer_commit+0x204/0xab0 [ 58.926284][ T4415] ? .slowpath+0x1a/0x1a [ 58.931163][ T4415] ? rcu_read_lock_sched_held+0x11/0x70 [ 58.936727][ T4415] ? lock_acquire+0x500/0x630 [ 58.941586][ T4415] ? do_raw_spin_lock+0x204/0x2b0 [ 58.946618][ T4415] ? rwlock_bug.part.0+0x90/0x90 [ 58.951619][ T4415] ? rcu_read_lock_sched_held+0x11/0x70 [ 58.957346][ T4415] ? _raw_spin_lock_irqsave+0x45/0x60 [ 58.963002][ T4415] ? bpf_trace_printk+0xd3/0x170 [ 58.967957][ T4415] ? bpf_trace_printk+0xd3/0x170 [ 58.972904][ T4415] ? trace_bpf_trace_printk+0x2b0/0x2b0 [ 58.978651][ T4415] ? bpf_prog_0605f9f479290f07+0x37/0x3b [ 58.984313][ T4415] ? bpf_trace_run2+0x151/0x3d0 [ 58.989181][ T4415] ? __bpf_trace_bpf_trace_printk+0xc0/0xc0 [ 58.995176][ T4415] ? __bpf_trace_lock+0xe0/0xe0 [ 59.000127][ T4415] ? __bpf_trace_contention_begin+0xb9/0xf0 [ 59.006038][ T4415] ? __bpf_trace_lock+0xe0/0xe0 [ 59.011012][ T4415] ? rb_commit+0x13f/0x8c0 [ 59.015454][ T4415] ? rcu_read_lock_sched_held+0x11/0x70 [ 59.021106][ T4415] ? rcu_read_lock_sched_held+0x11/0x70 [ 59.027054][ T4415] ? lock_release+0x5cf/0x810 [ 59.031867][ T4415] ? __traceiter_contention_begin+0x5a/0xa0 [ 59.037885][ T4415] ? trace_contention_begin.constprop.0+0x143/0x240 [ 59.044680][ T4415] ? __pv_queued_spin_lock_slowpath+0x107/0xb50 [ 59.051061][ T4415] ? .slowpath+0x1a/0x1a [ 59.055311][ T4415] ? rcu_read_lock_sched_held+0x11/0x70 [ 59.060878][ T4415] ? lock_acquire+0x500/0x630 [ 59.065562][ T4415] ? do_raw_spin_lock+0x204/0x2b0 [ 59.071299][ T4415] ? rwlock_bug.part.0+0x90/0x90 [ 59.076360][ T4415] ? arch_stack_walk+0x97/0xf0 [ 59.081326][ T4415] ? _raw_spin_lock_irqsave+0x45/0x60 [ 59.086707][ T4415] ? bpf_trace_printk+0xd3/0x170 [ 59.091921][ T4415] ? bpf_trace_printk+0xd3/0x170 [ 59.097397][ T4415] ? trace_bpf_trace_printk+0x2b0/0x2b0 [ 59.102953][ T4415] ? __stack_depot_save+0x3e/0x560 [ 59.108081][ T4415] ? kasan_save_stack+0x35/0x40 [ 59.113244][ T4415] ? ____kasan_slab_free+0x160/0x1c0 [ 59.118721][ T4415] ? slab_free_freelist_hook+0x8b/0x1c0 [ 59.124395][ T4415] ? bpf_prog_0605f9f479290f07+0x37/0x3b [ 59.130357][ T4415] ? bpf_trace_run2+0x151/0x3d0 [ 59.135402][ T4415] ? __bpf_trace_bpf_trace_printk+0xc0/0xc0 [ 59.141323][ T4415] ? vfs_read+0x7fa/0x930 [ 59.145836][ T4415] ? entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 59.151929][ T4415] ? rcu_read_lock_sched_held+0x11/0x70 [ 59.158118][ T4415] ? lock_acquire+0x500/0x630 [ 59.162825][ T4415] ? __bpf_trace_lock+0xe0/0xe0 [ 59.167705][ T4415] ? __bpf_trace_contention_begin+0xb9/0xf0 [ 59.173619][ T4415] ? __bpf_trace_lock+0xe0/0xe0 [ 59.178498][ T4415] ? rcu_read_lock_sched_held+0x11/0x70 [ 59.184298][ T4415] ? lock_acquire+0x500/0x630 [ 59.188997][ T4415] ? lock_release+0x810/0x810 [ 59.193695][ T4415] ? folio_flags.constprop.0+0x53/0x150 [ 59.199293][ T4415] ? __traceiter_contention_begin+0x5a/0xa0 [ 59.205316][ T4415] ? trace_contention_begin+0x129/0x1e0 [ 59.210900][ T4415] ? __mutex_lock+0x13c/0x1360 [ 59.215771][ T4415] ? __unix_dgram_recvmsg+0x22a/0xb90 [ 59.221241][ T4415] ? aa_label_sk_perm+0x156/0x530 [ 59.226555][ T4415] ? trace_hardirqs_on+0x31/0x180 [ 59.231606][ T4415] ? __unix_dgram_recvmsg+0x22a/0xb90 [ 59.237214][ T4415] ? mutex_lock_io_nested+0x11a0/0x11a0 [ 59.243336][ T4415] ? shmem_get_folio_gfp+0xff9/0x1a30 [ 59.248734][ T4415] ? rcu_read_lock_sched_held+0x11/0x70 [ 59.254334][ T4415] ? lock_acquire+0x500/0x630 [ 59.259031][ T4415] ? __unix_dgram_recvmsg+0x22a/0xb90 [ 59.264868][ T4415] ? unix_stream_connect+0x1640/0x1640 [ 59.270343][ T4415] ? aa_sk_perm+0x313/0xab0 [ 59.274859][ T4415] ? aa_file_perm+0x592/0x1210 [ 59.279725][ T4415] ? aa_af_perm+0x240/0x240 [ 59.284247][ T4415] ? generic_perform_write+0x3cc/0x570 [ 59.289719][ T4415] ? unix_dgram_recvmsg+0xc4/0xf0 [ 59.294754][ T4415] ? sock_read_iter+0x348/0x480 [ 59.299619][ T4415] ? ____sys_recvmsg+0x610/0x610 [ 59.304574][ T4415] ? rcu_read_lock_sched_held+0x11/0x70 [ 59.310145][ T4415] ? security_file_permission+0xaf/0xd0 [ 59.315717][ T4415] ? vfs_read+0x7fa/0x930 [ 59.320054][ T4415] ? kernel_read+0x1c0/0x1c0 [ 59.324664][ T4415] ? vfs_fstatat+0x9b/0xb0 [ 59.329704][ T4415] ? __do_sys_newfstatat+0xb0/0x120 [ 59.334921][ T4415] ? __do_compat_sys_newlstat+0x110/0x110 [ 59.341101][ T4415] ? __fget_light+0x20a/0x270 [ 59.345786][ T4415] ? ksys_read+0x1ec/0x250 [ 59.350300][ T4415] ? vfs_write+0xdd0/0xdd0 [ 59.354725][ T4415] ? syscall_enter_from_user_mode+0x26/0xb0 [ 59.360622][ T4415] ? trace_hardirqs_on+0x31/0x180 [ 59.365744][ T4415] ? do_syscall_64+0x39/0xb0 [ 59.370442][ T4415] ? entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 59.376536][ T4415] [ 59.379557][ T4415] Kernel panic - not syncing: kernel: panic_on_warn set ... [ 59.386847][ T4415] CPU: 0 PID: 4415 Comm: syslogd Not tainted 6.1.0-syzkaller-14017-g45435d8da71f #0 [ 59.396230][ T4415] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 10/26/2022 [ 59.406291][ T4415] Call Trace: [ 59.409574][ T4415] [ 59.412507][ T4415] dump_stack_lvl+0xd1/0x138 [ 59.417113][ T4415] panic+0x2cc/0x626 [ 59.421042][ T4415] ? panic_print_sys_info.part.0+0x110/0x110 [ 59.427076][ T4415] ? bpf_bprintf_prepare+0xf35/0x11b0 [ 59.432455][ T4415] check_panic_on_warn.cold+0x19/0x35 [ 59.437841][ T4415] __warn+0xf2/0x1a0 [ 59.442011][ T4415] ? bpf_bprintf_prepare+0xf35/0x11b0 [ 59.447399][ T4415] report_bug+0x1c0/0x210 [ 59.451737][ T4415] handle_bug+0x3c/0x70 [ 59.455910][ T4415] exc_invalid_op+0x18/0x50 [ 59.460426][ T4415] asm_exc_invalid_op+0x1a/0x20 [ 59.465280][ T4415] RIP: 0010:bpf_bprintf_prepare+0xf35/0x11b0 [ 59.471360][ T4415] Code: ff e8 4f f2 e9 ff 48 83 7c 24 08 00 41 bd 04 00 00 00 0f 85 8a fa ff ff e8 38 f2 e9 ff 8d 6b 03 e9 f7 f6 ff ff e8 2b f2 e9 ff <0f> 0b 65 ff 0d ca f3 6b 7e bf 01 00 00 00 41 bc f0 ff ff ff e8 82 [ 59.491000][ T4415] RSP: 0018:ffffc9000313e918 EFLAGS: 00010093 [ 59.497074][ T4415] RAX: 0000000000000000 RBX: 0000000000000002 RCX: 0000000000000000 [ 59.505048][ T4415] RDX: ffff88807e871d40 RSI: ffffffff81975fb5 RDI: 0000000000000005 [ 59.513025][ T4415] RBP: ffffc9000313ea48 R08: 0000000000000005 R09: 0000000000000003 [ 59.521185][ T4415] R10: 0000000000000004 R11: 0000000000000000 R12: 0000000000000003 [ 59.529802][ T4415] R13: 0000000000000004 R14: ffffc9000313eb00 R15: 0000000000000003 [ 59.537786][ T4415] ? bpf_bprintf_prepare+0xf35/0x11b0 [ 59.543172][ T4415] ? bpf_bprintf_prepare+0xf35/0x11b0 [ 59.548551][ T4415] ? mark_lock.part.0+0xee/0x1910 [ 59.554198][ T4415] ? bpf_bprintf_cleanup+0x60/0x60 [ 59.559313][ T4415] ? read_pages+0x62d/0xd40 [ 59.563844][ T4415] ? lock_chain_count+0x20/0x20 [ 59.569172][ T4415] bpf_trace_printk+0xaf/0x170 [ 59.574481][ T4415] ? trace_bpf_trace_printk+0x2b0/0x2b0 [ 59.580122][ T4415] ? lock_release+0x810/0x810 [ 59.584802][ T4415] ? lock_chain_count+0x20/0x20 [ 59.589656][ T4415] ? lock_chain_count+0x20/0x20 [ 59.594514][ T4415] ? bpf_trace_run2+0x151/0x3d0 [ 59.599389][ T4415] ? __bpf_trace_bpf_trace_printk+0xc0/0xc0 [ 59.605410][ T4415] ? __bpf_trace_lock+0xe0/0xe0 [ 59.610360][ T4415] ? __bpf_trace_contention_begin+0xb9/0xf0 [ 59.616269][ T4415] ? __bpf_trace_lock+0xe0/0xe0 [ 59.621145][ T4415] ? lockdep_hardirqs_on_prepare+0x410/0x410 [ 59.627142][ T4415] ? __traceiter_contention_begin+0x5a/0xa0 [ 59.633072][ T4415] ? trace_contention_begin.constprop.0+0x143/0x240 [ 59.639792][ T4415] ? __pv_queued_spin_lock_slowpath+0x107/0xb50 [ 59.646510][ T4415] ? .slowpath+0x1a/0x1a [ 59.650791][ T4415] ? rcu_read_lock_sched_held+0x11/0x70 [ 59.656734][ T4415] ? lock_acquire+0x500/0x630 [ 59.661430][ T4415] ? do_raw_spin_lock+0x204/0x2b0 [ 59.666463][ T4415] ? rwlock_bug.part.0+0x90/0x90 [ 59.673411][ T4415] ? lock_chain_count+0x20/0x20 [ 59.678282][ T4415] ? lock_chain_count+0x20/0x20 [ 59.683138][ T4415] ? _raw_spin_lock_irqsave+0x45/0x60 [ 59.688605][ T4415] ? bpf_trace_printk+0xd3/0x170 [ 59.693638][ T4415] ? bpf_trace_printk+0xd3/0x170 [ 59.698586][ T4415] ? trace_bpf_trace_printk+0x2b0/0x2b0 [ 59.705138][ T4415] ? bpf_trace_run2+0x151/0x3d0 [ 59.710003][ T4415] ? __bpf_trace_bpf_trace_printk+0xc0/0xc0 [ 59.715916][ T4415] ? __bpf_trace_lock+0xe0/0xe0 [ 59.720780][ T4415] ? __bpf_trace_contention_begin+0xb9/0xf0 [ 59.726776][ T4415] ? __bpf_trace_lock+0xe0/0xe0 [ 59.731843][ T4415] ? rb_commit+0x13f/0x8c0 [ 59.736825][ T4415] ? __traceiter_contention_begin+0x5a/0xa0 [ 59.743117][ T4415] ? trace_contention_begin.constprop.0+0x143/0x240 [ 59.749741][ T4415] ? __pv_queued_spin_lock_slowpath+0x107/0xb50 [ 59.756039][ T4415] ? trace_event_buffer_commit+0x204/0xab0 [ 59.762604][ T4415] ? .slowpath+0x1a/0x1a [ 59.767379][ T4415] ? rcu_read_lock_sched_held+0x11/0x70 [ 59.773317][ T4415] ? lock_acquire+0x500/0x630 [ 59.778373][ T4415] ? do_raw_spin_lock+0x204/0x2b0 [ 59.783953][ T4415] ? rwlock_bug.part.0+0x90/0x90 [ 59.789422][ T4415] ? rcu_read_lock_sched_held+0x11/0x70 [ 59.795011][ T4415] ? _raw_spin_lock_irqsave+0x45/0x60 [ 59.800405][ T4415] ? bpf_trace_printk+0xd3/0x170 [ 59.805356][ T4415] ? bpf_trace_printk+0xd3/0x170 [ 59.810303][ T4415] ? trace_bpf_trace_printk+0x2b0/0x2b0 [ 59.815892][ T4415] ? bpf_prog_0605f9f479290f07+0x37/0x3b [ 59.821626][ T4415] ? bpf_trace_run2+0x151/0x3d0 [ 59.826489][ T4415] ? __bpf_trace_bpf_trace_printk+0xc0/0xc0 [ 59.832417][ T4415] ? __bpf_trace_lock+0xe0/0xe0 [ 59.837325][ T4415] ? __bpf_trace_contention_begin+0xb9/0xf0 [ 59.843259][ T4415] ? __bpf_trace_lock+0xe0/0xe0 [ 59.848123][ T4415] ? rb_commit+0x13f/0x8c0 [ 59.852820][ T4415] ? rcu_read_lock_sched_held+0x11/0x70 [ 59.858389][ T4415] ? rcu_read_lock_sched_held+0x11/0x70 [ 59.863953][ T4415] ? lock_release+0x5cf/0x810 [ 59.868634][ T4415] ? __traceiter_contention_begin+0x5a/0xa0 [ 59.874630][ T4415] ? trace_contention_begin.constprop.0+0x143/0x240 [ 59.881410][ T4415] ? __pv_queued_spin_lock_slowpath+0x107/0xb50 [ 59.887667][ T4415] ? .slowpath+0x1a/0x1a [ 59.891926][ T4415] ? rcu_read_lock_sched_held+0x11/0x70 [ 59.897596][ T4415] ? lock_acquire+0x500/0x630 [ 59.902311][ T4415] ? do_raw_spin_lock+0x204/0x2b0 [ 59.907357][ T4415] ? rwlock_bug.part.0+0x90/0x90 [ 59.912311][ T4415] ? arch_stack_walk+0x97/0xf0 [ 59.917089][ T4415] ? _raw_spin_lock_irqsave+0x45/0x60 [ 59.922468][ T4415] ? bpf_trace_printk+0xd3/0x170 [ 59.927416][ T4415] ? bpf_trace_printk+0xd3/0x170 [ 59.932371][ T4415] ? trace_bpf_trace_printk+0x2b0/0x2b0 [ 59.937941][ T4415] ? __stack_depot_save+0x3e/0x560 [ 59.943067][ T4415] ? kasan_save_stack+0x35/0x40 [ 59.947932][ T4415] ? ____kasan_slab_free+0x160/0x1c0 [ 59.953220][ T4415] ? slab_free_freelist_hook+0x8b/0x1c0 [ 59.958786][ T4415] ? bpf_prog_0605f9f479290f07+0x37/0x3b [ 59.964429][ T4415] ? bpf_trace_run2+0x151/0x3d0 [ 59.969292][ T4415] ? __bpf_trace_bpf_trace_printk+0xc0/0xc0 [ 59.975627][ T4415] ? vfs_read+0x7fa/0x930 [ 59.979967][ T4415] ? entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 59.986056][ T4415] ? rcu_read_lock_sched_held+0x11/0x70 [ 59.991618][ T4415] ? lock_acquire+0x500/0x630 [ 59.996317][ T4415] ? __bpf_trace_lock+0xe0/0xe0 [ 60.001288][ T4415] ? __bpf_trace_contention_begin+0xb9/0xf0 [ 60.007213][ T4415] ? __bpf_trace_lock+0xe0/0xe0 [ 60.012161][ T4415] ? rcu_read_lock_sched_held+0x11/0x70 [ 60.017726][ T4415] ? lock_acquire+0x500/0x630 [ 60.022409][ T4415] ? lock_release+0x810/0x810 [ 60.027097][ T4415] ? folio_flags.constprop.0+0x53/0x150 [ 60.032668][ T4415] ? __traceiter_contention_begin+0x5a/0xa0 [ 60.038584][ T4415] ? trace_contention_begin+0x129/0x1e0 [ 60.044162][ T4415] ? __mutex_lock+0x13c/0x1360 [ 60.048942][ T4415] ? __unix_dgram_recvmsg+0x22a/0xb90 [ 60.054329][ T4415] ? aa_label_sk_perm+0x156/0x530 [ 60.059375][ T4415] ? trace_hardirqs_on+0x31/0x180 [ 60.064409][ T4415] ? __unix_dgram_recvmsg+0x22a/0xb90 [ 60.069880][ T4415] ? mutex_lock_io_nested+0x11a0/0x11a0 [ 60.075533][ T4415] ? shmem_get_folio_gfp+0xff9/0x1a30 [ 60.080918][ T4415] ? rcu_read_lock_sched_held+0x11/0x70 [ 60.086494][ T4415] ? lock_acquire+0x500/0x630 [ 60.091191][ T4415] ? __unix_dgram_recvmsg+0x22a/0xb90 [ 60.096590][ T4415] ? unix_stream_connect+0x1640/0x1640 [ 60.102151][ T4415] ? aa_sk_perm+0x313/0xab0 [ 60.106700][ T4415] ? aa_file_perm+0x592/0x1210 [ 60.112187][ T4415] ? aa_af_perm+0x240/0x240 [ 60.116974][ T4415] ? generic_perform_write+0x3cc/0x570 [ 60.122537][ T4415] ? unix_dgram_recvmsg+0xc4/0xf0 [ 60.127749][ T4415] ? sock_read_iter+0x348/0x480 [ 60.132614][ T4415] ? ____sys_recvmsg+0x610/0x610 [ 60.137563][ T4415] ? rcu_read_lock_sched_held+0x11/0x70 [ 60.143137][ T4415] ? security_file_permission+0xaf/0xd0 [ 60.148702][ T4415] ? vfs_read+0x7fa/0x930 [ 60.153160][ T4415] ? kernel_read+0x1c0/0x1c0 [ 60.157767][ T4415] ? vfs_fstatat+0x9b/0xb0 [ 60.162206][ T4415] ? __do_sys_newfstatat+0xb0/0x120 [ 60.167431][ T4415] ? __do_compat_sys_newlstat+0x110/0x110 [ 60.173261][ T4415] ? __fget_light+0x20a/0x270 [ 60.177945][ T4415] ? ksys_read+0x1ec/0x250 [ 60.182371][ T4415] ? vfs_write+0xdd0/0xdd0 [ 60.186798][ T4415] ? syscall_enter_from_user_mode+0x26/0xb0 [ 60.192717][ T4415] ? trace_hardirqs_on+0x31/0x180 [ 60.197777][ T4415] ? do_syscall_64+0x39/0xb0 [ 60.202394][ T4415] ? entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 60.208512][ T4415] [ 60.211616][ T4415] Kernel Offset: disabled [ 60.215960][ T4415] Rebooting in 86400 seconds..