./strace-static-x86_64 -e \!wait4,clock_nanosleep,nanosleep -s 100 -x -f ./syz-executor41107797 <...> Warning: Permanently added '10.128.0.202' (ECDSA) to the list of known hosts. execve("./syz-executor41107797", ["./syz-executor41107797"], 0x7fff0263d970 /* 10 vars */) = 0 brk(NULL) = 0x555556dc8000 brk(0x555556dc8c40) = 0x555556dc8c40 arch_prctl(ARCH_SET_FS, 0x555556dc8300) = 0 uname({sysname="Linux", nodename="syzkaller", ...}) = 0 set_tid_address(0x555556dc85d0) = 3606 set_robust_list(0x555556dc85e0, 24) = 0 rt_sigaction(SIGRTMIN, {sa_handler=0x7f0941dc5c30, sa_mask=[], sa_flags=SA_RESTORER|SA_SIGINFO, sa_restorer=0x7f0941dc6300}, NULL, 8) = 0 rt_sigaction(SIGRT_1, {sa_handler=0x7f0941dc5cd0, sa_mask=[], sa_flags=SA_RESTORER|SA_RESTART|SA_SIGINFO, sa_restorer=0x7f0941dc6300}, NULL, 8) = 0 rt_sigprocmask(SIG_UNBLOCK, [RTMIN RT_1], NULL, 8) = 0 prlimit64(0, RLIMIT_STACK, NULL, {rlim_cur=8192*1024, rlim_max=RLIM64_INFINITY}) = 0 readlink("/proc/self/exe", "/root/syz-executor41107797", 4096) = 26 brk(0x555556de9c40) = 0x555556de9c40 brk(0x555556dea000) = 0x555556dea000 mprotect(0x7f0941e86000, 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 futex(0x7f0941e8c40c, FUTEX_WAKE_PRIVATE, 1000000) = 0 mmap(NULL, 135168, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_STACK, -1, 0) = 0x7f0941d96000 mprotect(0x7f0941d97000, 131072, PROT_READ|PROT_WRITE) = 0 clone(child_stack=0x7f0941db63f0, flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID, parent_tid=[3607], tls=0x7f0941db6700, child_tidptr=0x7f0941db69d0) = 3607 futex(0x7f0941e8c408, FUTEX_WAKE_PRIVATE, 1000000) = 0 futex(0x7f0941e8c40c, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000}./strace-static-x86_64: Process 3607 attached [pid 3607] set_robust_list(0x7f0941db69e0, 24) = 0 [pid 3607] pipe([3, 4]) = 0 [pid 3607] futex(0x7f0941e8c40c, FUTEX_WAKE_PRIVATE, 1000000 [pid 3606] <... futex resumed>) = 0 [pid 3606] futex(0x7f0941e8c408, FUTEX_WAKE_PRIVATE, 1000000) = 0 [pid 3606] futex(0x7f0941e8c40c, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 3607] <... futex resumed>) = 1 [pid 3607] pipe2([5, 6], O_EXCL) = 0 [pid 3607] futex(0x7f0941e8c40c, FUTEX_WAKE_PRIVATE, 1000000 [pid 3606] <... futex resumed>) = 0 [pid 3606] futex(0x7f0941e8c408, FUTEX_WAKE_PRIVATE, 1000000) = 0 [pid 3606] futex(0x7f0941e8c40c, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 3607] <... futex resumed>) = 1 [pid 3607] splice(3, NULL, 6, NULL, 511, 0 [pid 3606] <... futex resumed>) = -1 ETIMEDOUT (Connection timed out) [pid 3606] futex(0x7f0941e8c41c, FUTEX_WAKE_PRIVATE, 1000000) = 0 [pid 3606] mmap(NULL, 135168, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_STACK, -1, 0) = 0x7f0941d75000 [pid 3606] mprotect(0x7f0941d76000, 131072, PROT_READ|PROT_WRITE) = 0 [pid 3606] clone(child_stack=0x7f0941d953f0, flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID, parent_tid=[3608], tls=0x7f0941d95700, child_tidptr=0x7f0941d959d0) = 3608 [pid 3606] futex(0x7f0941e8c418, FUTEX_WAKE_PRIVATE, 1000000) = 0 [pid 3606] futex(0x7f0941e8c41c, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000}./strace-static-x86_64: Process 3608 attached [pid 3608] set_robust_list(0x7f0941d959e0, 24) = 0 [pid 3608] vmsplice(4, [{iov_base="\xb5", iov_len=1}], 1, 0) = 1 [pid 3608] futex(0x7f0941e8c41c, FUTEX_WAKE_PRIVATE, 1000000) = 1 [pid 3608] futex(0x7f0941e8c418, FUTEX_WAIT_PRIVATE, 0, NULL [pid 3606] <... futex resumed>) = 0 syzkaller login: [ 50.744596][ T3607] [ 50.746979][ T3607] ============================================ [ 50.753110][ T3607] WARNING: possible recursive locking detected [ 50.759776][ T3607] 5.19.0-rc7-syzkaller-00199-g515f71412bb7 #0 Not tainted [ 50.766879][ T3607] -------------------------------------------- [ 50.773008][ T3607] syz-executor411/3607 is trying to acquire lock: [ 50.779405][ T3607] ffff888021f59868 (&pipe->mutex/1){+.+.}-{3:3}, at: pipe_write+0x12f/0x1b00 [ 50.788196][ T3607] [ 50.788196][ T3607] but task is already holding lock: [ 50.795546][ T3607] ffff888021f59c68 (&pipe->mutex/1){+.+.}-{3:3}, at: pipe_wait_readable+0x3d7/0x550 [ 50.804926][ T3607] [ 50.804926][ T3607] other info that might help us debug this: [ 50.812967][ T3607] Possible unsafe locking scenario: [ 50.812967][ T3607] [ 50.820402][ T3607] CPU0 [ 50.823676][ T3607] ---- [ 50.826934][ T3607] lock(&pipe->mutex/1); [ 50.831250][ T3607] lock(&pipe->mutex/1); [ 50.835572][ T3607] [ 50.835572][ T3607] *** DEADLOCK *** [ 50.835572][ T3607] [pid 3606] exit_group(0) = ? [pid 3608] <... futex resumed>) = ? [pid 3608] +++ exited with 0 +++ [ 50.843974][ T3607] May be due to missing lock nesting notation [ 50.843974][ T3607] [ 50.852286][ T3607] 1 lock held by syz-executor411/3607: [ 50.857766][ T3607] #0: ffff888021f59c68 (&pipe->mutex/1){+.+.}-{3:3}, at: pipe_wait_readable+0x3d7/0x550 [ 50.867592][ T3607] [ 50.867592][ T3607] stack backtrace: [ 50.873461][ T3607] CPU: 1 PID: 3607 Comm: syz-executor411 Not tainted 5.19.0-rc7-syzkaller-00199-g515f71412bb7 #0 [ 50.883935][ T3607] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 06/29/2022 [ 50.893975][ T3607] Call Trace: [ 50.897243][ T3607] [ 50.900163][ T3607] dump_stack_lvl+0x1e3/0x2cb [ 50.904843][ T3607] ? bfq_pos_tree_add_move+0x436/0x436 [ 50.910292][ T3607] ? panic+0x76e/0x76e [ 50.914349][ T3607] ? print_tainted+0x145/0x170 [ 50.919101][ T3607] ? lockdep_print_held_locks+0x10f/0x1b0 [ 50.924811][ T3607] validate_chain+0x485d/0x65c0 [ 50.929661][ T3607] ? reacquire_held_locks+0x680/0x680 [ 50.935033][ T3607] ? validate_chain+0x126/0x65c0 [ 50.939959][ T3607] ? reacquire_held_locks+0x680/0x680 [ 50.945328][ T3607] ? validate_chain+0x126/0x65c0 [ 50.950254][ T3607] ? validate_chain+0x126/0x65c0 [ 50.955178][ T3607] ? update_blocked_averages+0x10b0/0x10b0 [ 50.960971][ T3607] ? mark_lock+0x98/0x350 [ 50.965290][ T3607] ? reacquire_held_locks+0x680/0x680 [ 50.970686][ T3607] ? register_lock_class+0xfe/0x9d0 [ 50.975881][ T3607] ? reacquire_held_locks+0x680/0x680 [ 50.981241][ T3607] ? is_dynamic_key+0x1f0/0x1f0 [ 50.986526][ T3607] ? mark_lock+0x98/0x350 [ 50.990842][ T3607] __lock_acquire+0x129a/0x1f80 [ 50.995778][ T3607] lock_acquire+0x1a7/0x400 [ 51.000265][ T3607] ? pipe_write+0x12f/0x1b00 [ 51.005189][ T3607] ? read_lock_is_recursive+0x10/0x10 [ 51.010559][ T3607] ? __might_sleep+0xc0/0xc0 [ 51.015141][ T3607] ? __lock_acquire+0x129a/0x1f80 [ 51.020172][ T3607] __mutex_lock_common+0x1de/0x26c0 [ 51.025359][ T3607] ? pipe_write+0x12f/0x1b00 [ 51.030025][ T3607] ? pipe_write+0x12f/0x1b00 [ 51.034599][ T3607] ? mutex_lock_io_nested+0x60/0x60 [ 51.039787][ T3607] ? __bpf_trace_rcu_stall_warning+0x10/0x10 [ 51.045764][ T3607] ? trace_raw_output_contention_end+0xd0/0xd0 [ 51.051905][ T3607] mutex_lock_nested+0x17/0x20 [ 51.056663][ T3607] pipe_write+0x12f/0x1b00 [ 51.061066][ T3607] ? lockdep_hardirqs_on_prepare+0x448/0x7b0 [ 51.067036][ T3607] ? print_irqtrace_events+0x220/0x220 [ 51.072486][ T3607] ? pipe_wait_readable+0x3d7/0x550 [ 51.077703][ T3607] ? mutex_lock_io_nested+0x60/0x60 [ 51.082888][ T3607] ? _raw_spin_unlock_irqrestore+0xd9/0x130 [ 51.088854][ T3607] ? pipe_read+0x12a0/0x12a0 [ 51.093437][ T3607] ? finish_wait+0xc5/0x1d0 [ 51.097929][ T3607] ? mutex_lock_nested+0x17/0x20 [ 51.102856][ T3607] do_iter_readv_writev+0x499/0x650 [ 51.108050][ T3607] ? generic_file_rw_checks+0x250/0x250 [ 51.113586][ T3607] ? iter_file_splice_write+0x2a2/0xff0 [ 51.119118][ T3607] ? bpf_lsm_file_permission+0x5/0x10 [ 51.124476][ T3607] ? security_file_permission+0xe0/0x5c0 [ 51.130097][ T3607] ? do_iter_write+0x147/0x7a0 [ 51.134846][ T3607] do_iter_write+0x1f1/0x7a0 [ 51.139530][ T3607] ? vfs_iter_write+0x69/0xa0 [ 51.144197][ T3607] iter_file_splice_write+0x830/0xff0 [ 51.149567][ T3607] ? splice_from_pipe+0x220/0x220 [ 51.154583][ T3607] ? rcu_lock_release+0x9/0x20 [ 51.159340][ T3607] ? bpf_lsm_file_permission+0x5/0x10 [ 51.164784][ T3607] ? security_file_permission+0xe0/0x5c0 [ 51.170403][ T3607] ? splice_from_pipe+0x220/0x220 [ 51.175501][ T3607] do_splice+0x1105/0x1930 [ 51.179905][ T3607] ? lockdep_hardirqs_on_prepare+0x448/0x7b0 [ 51.185884][ T3607] ? print_irqtrace_events+0x220/0x220 [ 51.191339][ T3607] ? splice_file_to_pipe+0x660/0x660 [ 51.196709][ T3607] ? __fdget+0x180/0x210 [ 51.201029][ T3607] __se_sys_splice+0x2a8/0x410 [ 51.205800][ T3607] ? __x64_sys_splice+0xf0/0xf0 [ 51.210673][ T3607] ? syscall_enter_from_user_mode+0x2e/0x1a0 [ 51.216666][ T3607] ? __x64_sys_splice+0x1d/0xf0 [ 51.221513][ T3607] do_syscall_64+0x2b/0x70 [ 51.225955][ T3607] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 51.231887][ T3607] RIP: 0033:0x7f0941e03c99 [ 51.236317][ T3607] Code: 28 00 00 00 75 05 48 83 c4 28 c3 e8 81 14 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 b8 ff ff ff f7 d8 64 89 01 48 [ 51.255926][ T3607] RSP: 002b:00007f0941db6308 EFLAGS: 00000246 ORIG_RAX: 0000000000000113 [ 51.264334][ T3607] RAX: ffffffffffffffda RBX: 00007f0941e8c408 RCX: 00007f0941e03c99 [ 51.272314][ T3607] RDX: 0000000000000006 RSI: 0000000000000000 RDI: 0000000000000003 [ 51.280277][ T3607] RBP: 00007f0941e8c400 R08: 00000000000001ff R09: 0000000000000000 [ 51.288240][ T3607] R10: 0000000000000000 R11: 0000000000000246 R12: 00007f0941e8c40c [pid 3607] <... splice resumed>) = ? [pid 3607] +++ exited with 0 +++ +++ exited with 0 +++ [ 51.2962