./strace-static-x86_64 -e \!wait4,clock_nanosleep,nanosleep -s 100 -x -f ./syz-executor1381516181 <...> Warning: Permanently added '10.128.0.69' (ED25519) to the list of known hosts. execve("./syz-executor1381516181", ["./syz-executor1381516181"], 0x7ffef3206e00 /* 10 vars */) = 0 brk(NULL) = 0x555556ab2000 brk(0x555556ab2d40) = 0x555556ab2d40 arch_prctl(ARCH_SET_FS, 0x555556ab23c0) = 0 set_tid_address(0x555556ab2690) = 5060 set_robust_list(0x555556ab26a0, 24) = 0 rseq(0x555556ab2ce0, 0x20, 0, 0x53053053) = 0 prlimit64(0, RLIMIT_STACK, NULL, {rlim_cur=8192*1024, rlim_max=RLIM64_INFINITY}) = 0 readlink("/proc/self/exe", "/root/syz-executor1381516181", 4096) = 28 getrandom("\x68\x6c\x2b\xba\x62\x14\x5a\x40", 8, GRND_NONBLOCK) = 8 brk(NULL) = 0x555556ab2d40 brk(0x555556ad3d40) = 0x555556ad3d40 brk(0x555556ad4000) = 0x555556ad4000 mprotect(0x7f7262c17000, 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 5061 attached , child_tidptr=0x555556ab2690) = 5061 [pid 5060] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5061] set_robust_list(0x555556ab26a0, 24) = 0 ./strace-static-x86_64: Process 5062 attached [pid 5061] mkdir("./syzkaller.CFSDVF", 0700 [pid 5060] <... clone resumed>, child_tidptr=0x555556ab2690) = 5062 [pid 5062] set_robust_list(0x555556ab26a0, 24 [pid 5060] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5062] <... set_robust_list resumed>) = 0 [pid 5061] <... mkdir resumed>) = 0 [pid 5061] chmod("./syzkaller.CFSDVF", 0777 [pid 5062] mkdir("./syzkaller.JlUFmI", 0700./strace-static-x86_64: Process 5063 attached [pid 5060] <... clone resumed>, child_tidptr=0x555556ab2690) = 5063 [pid 5061] <... chmod resumed>) = 0 [pid 5061] chdir("./syzkaller.CFSDVF") = 0 [pid 5061] mkdir("./0", 0777 [pid 5062] <... mkdir resumed>) = 0 [pid 5063] set_robust_list(0x555556ab26a0, 24 [pid 5060] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5063] <... set_robust_list resumed>) = 0 [pid 5062] chmod("./syzkaller.JlUFmI", 0777 [pid 5061] <... mkdir resumed>) = 0 ./strace-static-x86_64: Process 5064 attached [pid 5064] set_robust_list(0x555556ab26a0, 24 [pid 5061] openat(AT_FDCWD, "/dev/loop0", O_RDWR [pid 5060] <... clone resumed>, child_tidptr=0x555556ab2690) = 5064 [pid 5064] <... set_robust_list resumed>) = 0 [pid 5063] getrandom( [pid 5062] <... chmod resumed>) = 0 [pid 5061] <... openat resumed>) = 3 [pid 5063] <... getrandom resumed>"\xdc\x2f\xa8\x32\xe2\x51\x38\x48", 8, GRND_NONBLOCK) = 8 [pid 5060] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5062] chdir("./syzkaller.JlUFmI" [pid 5063] mkdir("./syzkaller.2Z7QTV", 0700 [pid 5064] getrandom( [pid 5061] ioctl(3, LOOP_CLR_FD [pid 5064] <... getrandom resumed>"\x8f\xde\x04\x16\xc6\xb0\x68\x22", 8, GRND_NONBLOCK) = 8 [pid 5063] <... mkdir resumed>) = 0 [pid 5062] <... chdir resumed>) = 0 [pid 5061] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5064] mkdir("./syzkaller.3cdOhB", 0700) = 0 [pid 5062] mkdir("./0", 0777 [pid 5061] close(3./strace-static-x86_64: Process 5065 attached [pid 5065] set_robust_list(0x555556ab26a0, 24 [pid 5063] chmod("./syzkaller.2Z7QTV", 0777 [pid 5061] <... close resumed>) = 0 [pid 5065] <... set_robust_list resumed>) = 0 [pid 5065] mkdir("./syzkaller.wrAhdo", 0700 [pid 5061] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5063] <... chmod resumed>) = 0 [pid 5062] <... mkdir resumed>) = 0 [pid 5064] chmod("./syzkaller.3cdOhB", 0777 [pid 5065] <... mkdir resumed>) = 0 [pid 5064] <... chmod resumed>) = 0 [pid 5064] chdir("./syzkaller.3cdOhB") = 0 [pid 5064] mkdir("./0", 0777) = 0 ./strace-static-x86_64: Process 5066 attached [pid 5060] <... clone resumed>, child_tidptr=0x555556ab2690) = 5065 [pid 5065] chmod("./syzkaller.wrAhdo", 0777 [pid 5063] chdir("./syzkaller.2Z7QTV" [pid 5062] openat(AT_FDCWD, "/dev/loop1", O_RDWR [pid 5061] <... clone resumed>, child_tidptr=0x555556ab2690) = 5066 [pid 5060] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5066] set_robust_list(0x555556ab26a0, 24 [pid 5065] <... chmod resumed>) = 0 [pid 5064] openat(AT_FDCWD, "/dev/loop3", O_RDWR [pid 5063] <... chdir resumed>) = 0 [pid 5065] chdir("./syzkaller.wrAhdo" [pid 5064] <... openat resumed>) = 3 [pid 5065] <... chdir resumed>) = 0 ./strace-static-x86_64: Process 5068 attached [pid 5065] mkdir("./0", 0777 [pid 5062] <... openat resumed>) = 3 [pid 5066] <... set_robust_list resumed>) = 0 [pid 5063] mkdir("./0", 0777 [pid 5068] set_robust_list(0x555556ab26a0, 24 [pid 5066] chdir("./0" [pid 5064] ioctl(3, LOOP_CLR_FD [pid 5060] <... clone resumed>, child_tidptr=0x555556ab2690) = 5068 [pid 5068] <... set_robust_list resumed>) = 0 [pid 5066] <... chdir resumed>) = 0 [pid 5065] <... mkdir resumed>) = 0 [pid 5064] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5063] <... mkdir resumed>) = 0 [pid 5068] mkdir("./syzkaller.dZWG80", 0700 [pid 5062] ioctl(3, LOOP_CLR_FD [pid 5064] close(3 [pid 5065] openat(AT_FDCWD, "/dev/loop4", O_RDWR [pid 5064] <... close resumed>) = 0 [pid 5065] <... openat resumed>) = 3 [pid 5068] <... mkdir resumed>) = 0 [pid 5066] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5065] ioctl(3, LOOP_CLR_FD [pid 5064] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5063] openat(AT_FDCWD, "/dev/loop2", O_RDWR [pid 5062] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5066] <... prctl resumed>) = 0 [pid 5065] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5063] <... openat resumed>) = 3 [pid 5062] close(3 [pid 5066] setpgid(0, 0 [pid 5063] ioctl(3, LOOP_CLR_FD [pid 5066] <... setpgid resumed>) = 0 [pid 5062] <... close resumed>) = 0 [pid 5065] close(3 [pid 5062] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5066] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5065] <... close resumed>) = 0 [pid 5065] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5068] chmod("./syzkaller.dZWG80", 0777./strace-static-x86_64: Process 5069 attached ./strace-static-x86_64: Process 5070 attached ) = 0 [pid 5066] <... openat resumed>) = 3 [pid 5063] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5070] set_robust_list(0x555556ab26a0, 24 [pid 5066] write(3, "1000", 4 [pid 5063] close(3./strace-static-x86_64: Process 5071 attached [pid 5070] <... set_robust_list resumed>) = 0 [pid 5066] <... write resumed>) = 4 [pid 5063] <... close resumed>) = 0 [pid 5062] <... clone resumed>, child_tidptr=0x555556ab2690) = 5070 [pid 5066] close(3 [pid 5065] <... clone resumed>, child_tidptr=0x555556ab2690) = 5071 [pid 5064] <... clone resumed>, child_tidptr=0x555556ab2690) = 5069 [pid 5063] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5069] set_robust_list(0x555556ab26a0, 24 [pid 5071] set_robust_list(0x555556ab26a0, 24 [pid 5070] chdir("./0" [pid 5068] chdir("./syzkaller.dZWG80" [pid 5066] <... close resumed>) = 0 [pid 5069] <... set_robust_list resumed>) = 0 [pid 5068] <... chdir resumed>) = 0 [pid 5069] chdir("./0" [pid 5068] mkdir("./0", 0777./strace-static-x86_64: Process 5072 attached [pid 5069] <... chdir resumed>) = 0 [pid 5071] <... set_robust_list resumed>) = 0 [pid 5070] <... chdir resumed>) = 0 [pid 5068] <... mkdir resumed>) = 0 [pid 5066] symlink("/dev/binderfs", "./binderfs" [pid 5069] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5069] setpgid(0, 0) = 0 [pid 5069] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5071] chdir("./0" [pid 5070] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5066] <... symlink resumed>) = 0 [pid 5063] <... clone resumed>, child_tidptr=0x555556ab2690) = 5072 [pid 5072] set_robust_list(0x555556ab26a0, 24 [pid 5069] <... openat resumed>) = 3 [pid 5071] <... chdir resumed>) = 0 [pid 5070] <... prctl resumed>) = 0 [pid 5068] openat(AT_FDCWD, "/dev/loop5", O_RDWR [pid 5072] <... set_robust_list resumed>) = 0 [pid 5070] setpgid(0, 0 [pid 5069] write(3, "1000", 4 [pid 5071] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5070] <... setpgid resumed>) = 0 [pid 5068] <... openat resumed>) = 3 [pid 5072] chdir("./0" [pid 5069] <... write resumed>) = 4 [pid 5066] futex(0x7f7262c1d6ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 5069] close(3 [pid 5070] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5066] <... futex resumed>) = 0 [pid 5069] <... close resumed>) = 0 [pid 5068] ioctl(3, LOOP_CLR_FD [pid 5072] <... chdir resumed>) = 0 [pid 5069] symlink("/dev/binderfs", "./binderfs" [pid 5071] <... prctl resumed>) = 0 [pid 5068] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5066] rt_sigaction(SIGRT_1, {sa_handler=0x7f7262bb6160, sa_mask=[], sa_flags=SA_RESTORER|SA_ONSTACK|SA_RESTART|SA_SIGINFO, sa_restorer=0x7f7262ba7310}, [pid 5072] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5069] <... symlink resumed>) = 0 [pid 5070] <... openat resumed>) = 3 [pid 5072] <... prctl resumed>) = 0 [pid 5068] close(3 [pid 5072] setpgid(0, 0 [pid 5071] setpgid(0, 0 [pid 5070] write(3, "1000", 4 [pid 5068] <... close resumed>) = 0 [pid 5066] <... rt_sigaction resumed>NULL, 8) = 0 [pid 5072] <... setpgid resumed>) = 0 [pid 5069] futex(0x7f7262c1d6ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 5071] <... setpgid resumed>) = 0 [pid 5070] <... write resumed>) = 4 [pid 5068] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5072] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5069] <... futex resumed>) = 0 [pid 5071] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5070] close(3 [pid 5066] rt_sigprocmask(SIG_UNBLOCK, [RTMIN RT_1], ./strace-static-x86_64: Process 5073 attached [pid 5069] rt_sigaction(SIGRT_1, {sa_handler=0x7f7262bb6160, sa_mask=[], sa_flags=SA_RESTORER|SA_ONSTACK|SA_RESTART|SA_SIGINFO, sa_restorer=0x7f7262ba7310}, [pid 5072] <... openat resumed>) = 3 [pid 5069] <... rt_sigaction resumed>NULL, 8) = 0 [pid 5070] <... close resumed>) = 0 [pid 5066] <... rt_sigprocmask resumed>NULL, 8) = 0 [pid 5073] set_robust_list(0x555556ab26a0, 24 [pid 5069] rt_sigprocmask(SIG_UNBLOCK, [RTMIN RT_1], [pid 5071] <... openat resumed>) = 3 [pid 5073] <... set_robust_list resumed>) = 0 [pid 5069] <... rt_sigprocmask resumed>NULL, 8) = 0 [pid 5073] chdir("./0" [pid 5069] mmap(NULL, 135168, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_STACK, -1, 0 [pid 5068] <... clone resumed>, child_tidptr=0x555556ab2690) = 5073 [pid 5073] <... chdir resumed>) = 0 [pid 5069] <... mmap resumed>) = 0x7f7262b2c000 [pid 5071] write(3, "1000", 4 [pid 5066] mmap(NULL, 135168, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_STACK, -1, 0 [pid 5070] symlink("/dev/binderfs", "./binderfs" [pid 5072] write(3, "1000", 4 [pid 5073] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5069] mprotect(0x7f7262b2d000, 131072, PROT_READ|PROT_WRITE [pid 5071] <... write resumed>) = 4 [pid 5073] <... prctl resumed>) = 0 [pid 5069] <... mprotect resumed>) = 0 [pid 5071] close(3 [pid 5072] <... write resumed>) = 4 [pid 5073] setpgid(0, 0 [pid 5072] close(3 [pid 5069] rt_sigprocmask(SIG_BLOCK, ~[], [pid 5071] <... close resumed>) = 0 [pid 5070] <... symlink resumed>) = 0 [pid 5066] <... mmap resumed>) = 0x7f7262b2c000 [pid 5073] <... setpgid resumed>) = 0 [pid 5073] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5072] <... close resumed>) = 0 [pid 5069] <... rt_sigprocmask resumed>[], 8) = 0 [pid 5071] symlink("/dev/binderfs", "./binderfs" [pid 5070] futex(0x7f7262c1d6ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 5066] mprotect(0x7f7262b2d000, 131072, PROT_READ|PROT_WRITE [pid 5073] <... openat resumed>) = 3 [pid 5072] symlink("/dev/binderfs", "./binderfs" [pid 5069] clone3({flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID, child_tid=0x7f7262b4c990, parent_tid=0x7f7262b4c990, exit_signal=0, stack=0x7f7262b2c000, stack_size=0x20300, tls=0x7f7262b4c6c0} [pid 5070] <... futex resumed>) = 0 [pid 5066] <... mprotect resumed>) = 0 ./strace-static-x86_64: Process 5074 attached [pid 5073] write(3, "1000", 4 [pid 5070] rt_sigaction(SIGRT_1, {sa_handler=0x7f7262bb6160, sa_mask=[], sa_flags=SA_RESTORER|SA_ONSTACK|SA_RESTART|SA_SIGINFO, sa_restorer=0x7f7262ba7310}, [pid 5066] rt_sigprocmask(SIG_BLOCK, ~[], [pid 5074] rseq(0x7f7262b4cfe0, 0x20, 0, 0x53053053 [pid 5073] <... write resumed>) = 4 [pid 5072] <... symlink resumed>) = 0 [pid 5070] <... rt_sigaction resumed>NULL, 8) = 0 [pid 5074] <... rseq resumed>) = 0 [pid 5073] close(3 [pid 5069] <... clone3 resumed> => {parent_tid=[5074]}, 88) = 5074 [pid 5074] set_robust_list(0x7f7262b4c9a0, 24 [pid 5073] <... close resumed>) = 0 [pid 5069] rt_sigprocmask(SIG_SETMASK, [], [pid 5070] rt_sigprocmask(SIG_UNBLOCK, [RTMIN RT_1], [pid 5074] <... set_robust_list resumed>) = 0 [pid 5073] symlink("/dev/binderfs", "./binderfs" [pid 5069] <... rt_sigprocmask resumed>NULL, 8) = 0 [pid 5074] rt_sigprocmask(SIG_SETMASK, [], [pid 5069] futex(0x7f7262c1d6a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 5071] <... symlink resumed>) = 0 [pid 5070] <... rt_sigprocmask resumed>NULL, 8) = 0 [pid 5066] <... rt_sigprocmask resumed>[], 8) = 0 [pid 5072] futex(0x7f7262c1d6ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 5070] mmap(NULL, 135168, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_STACK, -1, 0 [pid 5066] clone3({flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID, child_tid=0x7f7262b4c990, parent_tid=0x7f7262b4c990, exit_signal=0, stack=0x7f7262b2c000, stack_size=0x20300, tls=0x7f7262b4c6c0} [pid 5070] <... mmap resumed>) = 0x7f7262b2c000 ./strace-static-x86_64: Process 5075 attached [pid 5074] <... rt_sigprocmask resumed>NULL, 8) = 0 [pid 5073] <... symlink resumed>) = 0 [pid 5072] <... futex resumed>) = 0 [pid 5069] <... futex resumed>) = 0 [pid 5070] mprotect(0x7f7262b2d000, 131072, PROT_READ|PROT_WRITE [pid 5075] rseq(0x7f7262b4cfe0, 0x20, 0, 0x53053053 [pid 5074] memfd_create("syzkaller", 0 [pid 5075] <... rseq resumed>) = 0 [pid 5074] <... memfd_create resumed>) = 3 [pid 5069] futex(0x7f7262c1d6ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=4, tv_nsec=50000000} [pid 5075] set_robust_list(0x7f7262b4c9a0, 24 [pid 5074] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5073] futex(0x7f7262c1d6ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 5072] rt_sigaction(SIGRT_1, {sa_handler=0x7f7262bb6160, sa_mask=[], sa_flags=SA_RESTORER|SA_ONSTACK|SA_RESTART|SA_SIGINFO, sa_restorer=0x7f7262ba7310}, [pid 5071] futex(0x7f7262c1d6ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 5070] <... mprotect resumed>) = 0 [pid 5075] <... set_robust_list resumed>) = 0 [pid 5074] <... mmap resumed>) = 0x7f725a72c000 [pid 5073] <... futex resumed>) = 0 [pid 5072] <... rt_sigaction resumed>NULL, 8) = 0 [pid 5070] rt_sigprocmask(SIG_BLOCK, ~[], [pid 5066] <... clone3 resumed> => {parent_tid=[5075]}, 88) = 5075 [pid 5075] rt_sigprocmask(SIG_SETMASK, [], [pid 5073] rt_sigaction(SIGRT_1, {sa_handler=0x7f7262bb6160, sa_mask=[], sa_flags=SA_RESTORER|SA_ONSTACK|SA_RESTART|SA_SIGINFO, sa_restorer=0x7f7262ba7310}, [pid 5071] <... futex resumed>) = 0 [pid 5075] <... rt_sigprocmask resumed>NULL, 8) = 0 [pid 5075] futex(0x7f7262c1d6a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 5073] <... rt_sigaction resumed>NULL, 8) = 0 [pid 5073] rt_sigprocmask(SIG_UNBLOCK, [RTMIN RT_1], NULL, 8) = 0 [pid 5073] mmap(NULL, 135168, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_STACK, -1, 0) = 0x7f7262b2c000 [pid 5073] mprotect(0x7f7262b2d000, 131072, PROT_READ|PROT_WRITE) = 0 [pid 5073] rt_sigprocmask(SIG_BLOCK, ~[], [], 8) = 0 [pid 5073] clone3({flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID, child_tid=0x7f7262b4c990, parent_tid=0x7f7262b4c990, exit_signal=0, stack=0x7f7262b2c000, stack_size=0x20300, tls=0x7f7262b4c6c0}./strace-static-x86_64: Process 5076 attached [pid 5076] rseq(0x7f7262b4cfe0, 0x20, 0, 0x53053053) = 0 [pid 5076] set_robust_list(0x7f7262b4c9a0, 24) = 0 [pid 5076] rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 [pid 5076] futex(0x7f7262c1d6a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 5071] rt_sigaction(SIGRT_1, {sa_handler=0x7f7262bb6160, sa_mask=[], sa_flags=SA_RESTORER|SA_ONSTACK|SA_RESTART|SA_SIGINFO, sa_restorer=0x7f7262ba7310}, [pid 5066] rt_sigprocmask(SIG_SETMASK, [], [pid 5072] rt_sigprocmask(SIG_UNBLOCK, [RTMIN RT_1], [pid 5070] <... rt_sigprocmask resumed>[], 8) = 0 [pid 5072] <... rt_sigprocmask resumed>NULL, 8) = 0 [pid 5072] mmap(NULL, 135168, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_STACK, -1, 0 [pid 5070] clone3({flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID, child_tid=0x7f7262b4c990, parent_tid=0x7f7262b4c990, exit_signal=0, stack=0x7f7262b2c000, stack_size=0x20300, tls=0x7f7262b4c6c0} [pid 5073] <... clone3 resumed> => {parent_tid=[5076]}, 88) = 5076 [pid 5066] <... rt_sigprocmask resumed>NULL, 8) = 0 [pid 5073] rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 [pid 5072] <... mmap resumed>) = 0x7f7262b2c000 [pid 5066] futex(0x7f7262c1d6a8, FUTEX_WAKE_PRIVATE, 1000000./strace-static-x86_64: Process 5077 attached [pid 5075] <... futex resumed>) = 0 [pid 5073] futex(0x7f7262c1d6a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 5072] mprotect(0x7f7262b2d000, 131072, PROT_READ|PROT_WRITE [pid 5071] <... rt_sigaction resumed>NULL, 8) = 0 [pid 5070] <... clone3 resumed> => {parent_tid=[5077]}, 88) = 5077 [pid 5066] <... futex resumed>) = 1 [pid 5076] <... futex resumed>) = 0 [pid 5075] memfd_create("syzkaller", 0 [pid 5073] <... futex resumed>) = 1 [pid 5072] <... mprotect resumed>) = 0 [pid 5071] rt_sigprocmask(SIG_UNBLOCK, [RTMIN RT_1], [pid 5070] rt_sigprocmask(SIG_SETMASK, [], [pid 5066] futex(0x7f7262c1d6ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=4, tv_nsec=50000000} [pid 5077] rseq(0x7f7262b4cfe0, 0x20, 0, 0x53053053 [pid 5076] memfd_create("syzkaller", 0 [pid 5075] <... memfd_create resumed>) = 3 [pid 5073] futex(0x7f7262c1d6ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=4, tv_nsec=50000000} [pid 5071] <... rt_sigprocmask resumed>NULL, 8) = 0 [pid 5070] <... rt_sigprocmask resumed>NULL, 8) = 0 [pid 5077] <... rseq resumed>) = 0 [pid 5077] set_robust_list(0x7f7262b4c9a0, 24 [pid 5076] <... memfd_create resumed>) = 3 [pid 5075] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5076] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5075] <... mmap resumed>) = 0x7f725a72c000 [pid 5072] rt_sigprocmask(SIG_BLOCK, ~[], [pid 5076] <... mmap resumed>) = 0x7f725a72c000 [pid 5072] <... rt_sigprocmask resumed>[], 8) = 0 [pid 5071] mmap(NULL, 135168, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_STACK, -1, 0 [pid 5070] futex(0x7f7262c1d6a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 5072] clone3({flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID, child_tid=0x7f7262b4c990, parent_tid=0x7f7262b4c990, exit_signal=0, stack=0x7f7262b2c000, stack_size=0x20300, tls=0x7f7262b4c6c0} [pid 5071] <... mmap resumed>) = 0x7f7262b2c000 [pid 5070] <... futex resumed>) = 0 [pid 5077] <... set_robust_list resumed>) = 0 ./strace-static-x86_64: Process 5078 attached [pid 5077] rt_sigprocmask(SIG_SETMASK, [], [pid 5071] mprotect(0x7f7262b2d000, 131072, PROT_READ|PROT_WRITE [pid 5070] futex(0x7f7262c1d6ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=4, tv_nsec=50000000} [pid 5078] rseq(0x7f7262b4cfe0, 0x20, 0, 0x53053053 [pid 5072] <... clone3 resumed> => {parent_tid=[5078]}, 88) = 5078 [pid 5078] <... rseq resumed>) = 0 [pid 5078] set_robust_list(0x7f7262b4c9a0, 24 [pid 5072] rt_sigprocmask(SIG_SETMASK, [], [pid 5078] <... set_robust_list resumed>) = 0 [pid 5072] <... rt_sigprocmask resumed>NULL, 8) = 0 [pid 5071] <... mprotect resumed>) = 0 [pid 5078] rt_sigprocmask(SIG_SETMASK, [], [pid 5072] futex(0x7f7262c1d6a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 5078] <... rt_sigprocmask resumed>NULL, 8) = 0 [pid 5072] <... futex resumed>) = 0 [pid 5071] rt_sigprocmask(SIG_BLOCK, ~[], [pid 5078] memfd_create("syzkaller", 0 [pid 5072] futex(0x7f7262c1d6ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=4, tv_nsec=50000000} [pid 5071] <... rt_sigprocmask resumed>[], 8) = 0 [pid 5077] <... rt_sigprocmask resumed>NULL, 8) = 0 [pid 5071] clone3({flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID, child_tid=0x7f7262b4c990, parent_tid=0x7f7262b4c990, exit_signal=0, stack=0x7f7262b2c000, stack_size=0x20300, tls=0x7f7262b4c6c0}./strace-static-x86_64: Process 5079 attached [pid 5077] memfd_create("syzkaller", 0) = 3 [pid 5071] <... clone3 resumed> => {parent_tid=[5079]}, 88) = 5079 [pid 5079] rseq(0x7f7262b4cfe0, 0x20, 0, 0x53053053 [pid 5078] <... memfd_create resumed>) = 3 [pid 5077] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5071] rt_sigprocmask(SIG_SETMASK, [], [pid 5079] <... rseq resumed>) = 0 [pid 5078] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5071] <... rt_sigprocmask resumed>NULL, 8) = 0 [pid 5079] set_robust_list(0x7f7262b4c9a0, 24 [pid 5071] futex(0x7f7262c1d6a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 5079] <... set_robust_list resumed>) = 0 [pid 5078] <... mmap resumed>) = 0x7f725a72c000 [pid 5077] <... mmap resumed>) = 0x7f725a72c000 [pid 5071] <... futex resumed>) = 0 [pid 5079] rt_sigprocmask(SIG_SETMASK, [], [pid 5071] futex(0x7f7262c1d6ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=4, tv_nsec=50000000} [pid 5079] <... rt_sigprocmask resumed>NULL, 8) = 0 [pid 5079] memfd_create("syzkaller", 0) = 3 [pid 5079] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f725a72c000 [pid 5078] write(3, "\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., 16777216 [pid 5074] write(3, "\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., 16777216 [pid 5076] write(3, "\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., 16777216 [pid 5075] write(3, "\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., 16777216 [pid 5077] write(3, "\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., 16777216 [pid 5079] write(3, "\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., 16777216 [pid 5074] <... write resumed>) = 16777216 [pid 5074] munmap(0x7f725a72c000, 138412032) = 0 [pid 5074] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = 4 [pid 5074] ioctl(4, LOOP_SET_FD, 3 [pid 5077] <... write resumed>) = 16777216 [pid 5074] <... ioctl resumed>) = 0 [pid 5074] close(3) = 0 [pid 5074] mkdir("./file0", 0777) = 0 [pid 5078] <... write resumed>) = 16777216 [pid 5077] munmap(0x7f725a72c000, 138412032 [pid 5075] <... write resumed>) = 16777216 [pid 5074] mount("/dev/loop3", "./file0", "btrfs", MS_RDONLY, "flushoncommit,commit=0x0000000000000000,flushoncommit,clear_cache,datacow,compress-force,space_cache"... [pid 5078] munmap(0x7f725a72c000, 138412032 [pid 5077] <... munmap resumed>) = 0 [ 55.278799][ T5074] loop3: detected capacity change from 0 to 32768 [pid 5075] munmap(0x7f725a72c000, 138412032 [pid 5077] openat(AT_FDCWD, "/dev/loop1", O_RDWR) = 4 [pid 5077] ioctl(4, LOOP_SET_FD, 3 [pid 5078] <... munmap resumed>) = 0 [pid 5075] <... munmap resumed>) = 0 [pid 5077] <... ioctl resumed>) = 0 [pid 5079] <... write resumed>) = 16777216 [pid 5078] openat(AT_FDCWD, "/dev/loop2", O_RDWR [pid 5075] openat(AT_FDCWD, "/dev/loop0", O_RDWR [ 55.338250][ T5074] BTRFS: device fsid ed167579-eb65-4e76-9a50-61ac97e9b59d devid 1 transid 8 /dev/loop3 scanned by syz-executor138 (5074) [ 55.354624][ T5077] loop1: detected capacity change from 0 to 32768 [pid 5079] munmap(0x7f725a72c000, 138412032 [pid 5078] <... openat resumed>) = 4 [pid 5076] <... write resumed>) = 16777216 [pid 5075] <... openat resumed>) = 4 [pid 5079] <... munmap resumed>) = 0 [pid 5078] ioctl(4, LOOP_SET_FD, 3 [pid 5077] close(3 [pid 5076] munmap(0x7f725a72c000, 138412032 [pid 5075] ioctl(4, LOOP_SET_FD, 3 [pid 5076] <... munmap resumed>) = 0 [pid 5079] openat(AT_FDCWD, "/dev/loop4", O_RDWR [pid 5078] <... ioctl resumed>) = 0 [pid 5077] <... close resumed>) = 0 [pid 5076] openat(AT_FDCWD, "/dev/loop5", O_RDWR [pid 5075] <... ioctl resumed>) = 0 [pid 5079] <... openat resumed>) = 4 [pid 5078] close(3 [pid 5077] mkdir("./file0", 0777 [pid 5076] <... openat resumed>) = 4 [pid 5075] close(3 [ 55.383711][ T5074] BTRFS info (device loop3): using sha256 (sha256-avx2) checksum algorithm [ 55.391051][ T5075] loop0: detected capacity change from 0 to 32768 [ 55.393532][ T5074] BTRFS info (device loop3): turning on flush-on-commit [ 55.400068][ T5078] loop2: detected capacity change from 0 to 32768 [ 55.406100][ T5074] BTRFS info (device loop3): using default commit interval 30s [ 55.419827][ T5074] BTRFS info (device loop3): force clearing of disk cache [pid 5079] ioctl(4, LOOP_SET_FD, 3 [pid 5078] <... close resumed>) = 0 [pid 5077] <... mkdir resumed>) = 0 [pid 5075] <... close resumed>) = 0 [pid 5078] mkdir("./file0", 0777 [pid 5077] mount("/dev/loop1", "./file0", "btrfs", MS_RDONLY, "flushoncommit,commit=0x0000000000000000,flushoncommit,clear_cache,datacow,compress-force,space_cache"... [pid 5076] ioctl(4, LOOP_SET_FD, 3 [pid 5075] mkdir("./file0", 0777 [pid 5079] <... ioctl resumed>) = 0 [pid 5079] close(3) = 0 [pid 5079] mkdir("./file0", 0777) = 0 [pid 5075] <... mkdir resumed>) = 0 [pid 5079] mount("/dev/loop4", "./file0", "btrfs", MS_RDONLY, "flushoncommit,commit=0x0000000000000000,flushoncommit,clear_cache,datacow,compress-force,space_cache"... [pid 5078] <... mkdir resumed>) = 0 [pid 5076] <... ioctl resumed>) = 0 [ 55.427035][ T5074] BTRFS info (device loop3): force zlib compression, level 3 [ 55.433267][ T5079] loop4: detected capacity change from 0 to 32768 [ 55.446188][ T5076] loop5: detected capacity change from 0 to 32768 [ 55.449776][ T5074] BTRFS info (device loop3): enabling disk space caching [ 55.452827][ T5077] BTRFS: device /dev/loop1 using temp-fsid b2bd6c2d-b19f-4413-a6cb-29dfd91f4191 [ 55.459786][ T5074] BTRFS info (device loop3): disk space caching is enabled [pid 5075] mount("/dev/loop0", "./file0", "btrfs", MS_RDONLY, "flushoncommit,commit=0x0000000000000000,flushoncommit,clear_cache,datacow,compress-force,space_cache"... [pid 5078] mount("/dev/loop2", "./file0", "btrfs", MS_RDONLY, "flushoncommit,commit=0x0000000000000000,flushoncommit,clear_cache,datacow,compress-force,space_cache"... [pid 5076] close(3) = 0 [pid 5076] mkdir("./file0", 0777) = 0 [ 55.470055][ T5077] BTRFS: device fsid ed167579-eb65-4e76-9a50-61ac97e9b59d devid 1 transid 8 /dev/loop1 scanned by syz-executor138 (5077) [ 55.492249][ T5079] BTRFS: device /dev/loop4 using temp-fsid 99d8e25a-17d9-4921-b6a5-75b7f722615e [ 55.501826][ T5077] BTRFS info (device loop1): using sha256 (sha256-avx2) checksum algorithm [ 55.510522][ T5079] BTRFS: device fsid ed167579-eb65-4e76-9a50-61ac97e9b59d devid 1 transid 8 /dev/loop4 scanned by syz-executor138 (5079) [ 55.512742][ T5077] BTRFS info (device loop1): turning on flush-on-commit [ 55.536817][ T5075] BTRFS: device /dev/loop0 using temp-fsid 1d0cadb6-49e6-435d-80dd-7fd53dbb0780 [ 55.537103][ T5079] BTRFS info (device loop4): using sha256 (sha256-avx2) checksum algorithm [ 55.554636][ T5079] BTRFS info (device loop4): turning on flush-on-commit [ 55.558595][ T5077] BTRFS info (device loop1): using default commit interval 30s [ 55.561570][ T5079] BTRFS info (device loop4): using default commit interval 30s [ 55.561592][ T5079] BTRFS info (device loop4): force clearing of disk cache [ 55.561611][ T5079] BTRFS info (device loop4): force zlib compression, level 3 [ 55.561632][ T5079] BTRFS info (device loop4): enabling disk space caching [ 55.561646][ T5079] BTRFS info (device loop4): disk space caching is enabled [ 55.583973][ T5075] BTRFS: device fsid ed167579-eb65-4e76-9a50-61ac97e9b59d devid 1 transid 8 /dev/loop0 scanned by syz-executor138 (5075) [ 55.592830][ T5077] BTRFS info (device loop1): force clearing of disk cache [ 55.625733][ T5077] BTRFS info (device loop1): force zlib compression, level 3 [ 55.632784][ T5078] BTRFS: device /dev/loop2 using temp-fsid 8871b341-df99-4c35-865a-5edfb002cbc3 [ 55.634845][ T5077] BTRFS info (device loop1): enabling disk space caching [ 55.644679][ T5075] BTRFS info (device loop0): using sha256 (sha256-avx2) checksum algorithm [ 55.651553][ T5077] BTRFS info (device loop1): disk space caching is enabled [ 55.658685][ T5078] BTRFS: device fsid ed167579-eb65-4e76-9a50-61ac97e9b59d devid 1 transid 8 /dev/loop2 scanned by syz-executor138 (5078) [ 55.678239][ T5075] BTRFS info (device loop0): turning on flush-on-commit [ 55.685644][ T5075] BTRFS info (device loop0): using default commit interval 30s [ 55.694656][ T5076] BTRFS: device /dev/loop5 using temp-fsid 8d56a264-7350-4cc9-a945-f5e57afda4a8 [ 55.703776][ T5075] BTRFS info (device loop0): force clearing of disk cache [ 55.713413][ T5075] BTRFS info (device loop0): force zlib compression, level 3 [ 55.716213][ T5076] BTRFS: device fsid ed167579-eb65-4e76-9a50-61ac97e9b59d devid 1 transid 8 /dev/loop5 scanned by syz-executor138 (5076) [ 55.721346][ T5075] BTRFS info (device loop0): enabling disk space caching [ 55.733911][ T5078] BTRFS info (device loop2): using sha256 (sha256-avx2) checksum algorithm [ 55.751809][ T5075] BTRFS info (device loop0): disk space caching is enabled [ 55.766617][ T5078] BTRFS info (device loop2): turning on flush-on-commit [ 55.773764][ T5076] BTRFS info (device loop5): using sha256 (sha256-avx2) checksum algorithm [ 55.774944][ T5078] BTRFS info (device loop2): using default commit interval 30s [ 55.784592][ T5074] BTRFS info (device loop3): enabling ssd optimizations [ 55.791359][ T5078] BTRFS info (device loop2): force clearing of disk cache [ 55.801146][ T5076] BTRFS info (device loop5): turning on flush-on-commit [ 55.805759][ T5074] BTRFS info (device loop3): auto enabling async discard [ 55.812245][ T5076] BTRFS info (device loop5): using default commit interval 30s [ 55.826110][ T5076] BTRFS info (device loop5): force clearing of disk cache [pid 5076] mount("/dev/loop5", "./file0", "btrfs", MS_RDONLY, "flushoncommit,commit=0x0000000000000000,flushoncommit,clear_cache,datacow,compress-force,space_cache"... [pid 5074] <... mount resumed>) = 0 [pid 5074] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY) = 3 [pid 5074] chdir("./file0") = 0 [pid 5074] ioctl(4, LOOP_CLR_FD) = 0 [pid 5074] close(4) = 0 [pid 5074] futex(0x7f7262c1d6ac, FUTEX_WAKE_PRIVATE, 1000000) = 1 [ 55.829965][ T5078] BTRFS info (device loop2): force zlib compression, level 3 [ 55.837867][ T5076] BTRFS info (device loop5): force zlib compression, level 3 [ 55.842813][ T5078] BTRFS info (device loop2): enabling disk space caching [ 55.855439][ T5079] BTRFS info (device loop4): enabling ssd optimizations [ 55.862005][ T5076] BTRFS info (device loop5): enabling disk space caching [ 55.862368][ T5079] BTRFS info (device loop4): auto enabling async discard [ 55.869616][ T5077] BTRFS info (device loop1): enabling ssd optimizations [pid 5074] futex(0x7f7262c1d6a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 5069] <... futex resumed>) = 0 [pid 5069] futex(0x7f7262c1d6a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 5074] <... futex resumed>) = 0 [pid 5069] <... futex resumed>) = 1 [pid 5074] mount(".", "./file0/../file0", NULL, MS_RDONLY|MS_SYNCHRONOUS|MS_DIRSYNC|MS_BIND|MS_SHARED, NULL) = 0 [pid 5069] futex(0x7f7262c1d6ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 5074] futex(0x7f7262c1d6ac, FUTEX_WAKE_PRIVATE, 1000000) = 1 [pid 5069] <... futex resumed>) = 0 [pid 5074] mkdir(".", 0777 [pid 5069] futex(0x7f7262c1d6a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 5074] <... mkdir resumed>) = -1 EEXIST (File exists) [pid 5069] <... futex resumed>) = 0 [pid 5074] mount(NULL, ".", 0x20000180, MS_NODEV|MS_NOEXEC|MS_REMOUNT|MS_DIRSYNC|MS_NOATIME|MS_PRIVATE|MS_RELATIME|MS_I_VERSION|MS_STRICTATIME, "" [pid 5069] futex(0x7f7262c1d6ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=4, tv_nsec=50000000} [pid 5079] <... mount resumed>) = 0 [pid 5079] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY) = 3 [pid 5079] chdir("./file0") = 0 [ 55.881242][ T5076] BTRFS info (device loop5): disk space caching is enabled [pid 5079] ioctl(4, LOOP_CLR_FD) = 0 [pid 5079] close(4) = 0 [pid 5079] futex(0x7f7262c1d6ac, FUTEX_WAKE_PRIVATE, 1000000) = 1 [pid 5071] <... futex resumed>) = 0 [pid 5079] futex(0x7f7262c1d6a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 5071] futex(0x7f7262c1d6a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 5079] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 5071] <... futex resumed>) = 0 [pid 5079] mount(".", "./file0/../file0", NULL, MS_RDONLY|MS_SYNCHRONOUS|MS_DIRSYNC|MS_BIND|MS_SHARED, NULL [pid 5071] futex(0x7f7262c1d6ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 5079] <... mount resumed>) = 0 [pid 5079] futex(0x7f7262c1d6ac, FUTEX_WAKE_PRIVATE, 1000000) = 1 [pid 5071] <... futex resumed>) = 0 [pid 5079] futex(0x7f7262c1d6a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 5071] futex(0x7f7262c1d6a8, FUTEX_WAKE_PRIVATE, 1000000) = 0 [pid 5071] futex(0x7f7262c1d6ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=4, tv_nsec=50000000} [pid 5079] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 5079] mkdir(".", 0777) = -1 EEXIST (File exists) [pid 5079] mount(NULL, ".", 0x20000180, MS_NODEV|MS_NOEXEC|MS_REMOUNT|MS_DIRSYNC|MS_NOATIME|MS_PRIVATE|MS_RELATIME|MS_I_VERSION|MS_STRICTATIME, "" [pid 5077] <... mount resumed>) = 0 [pid 5077] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY) = 3 [pid 5077] chdir("./file0") = 0 [pid 5074] <... mount resumed>) = 0 [pid 5077] ioctl(4, LOOP_CLR_FD) = 0 [pid 5077] close(4 [pid 5079] <... mount resumed>) = 0 [pid 5077] <... close resumed>) = 0 [pid 5074] openat(AT_FDCWD, ".", O_RDONLY|O_DIRECTORY [pid 5077] futex(0x7f7262c1d6ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 5074] <... openat resumed>) = 4 [pid 5077] <... futex resumed>) = 1 [pid 5074] chdir("." [pid 5070] <... futex resumed>) = 0 [ 55.932007][ T5077] BTRFS info (device loop1): auto enabling async discard [ 55.942030][ T5078] BTRFS info (device loop2): disk space caching is enabled [pid 5079] openat(AT_FDCWD, ".", O_RDONLY|O_DIRECTORY [pid 5077] futex(0x7f7262c1d6a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 5074] <... chdir resumed>) = 0 [pid 5070] futex(0x7f7262c1d6a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 5079] <... openat resumed>) = 4 [pid 5077] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 5074] futex(0x7f7262c1d6ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 5070] <... futex resumed>) = 0 [pid 5079] chdir("." [pid 5077] mount(".", "./file0/../file0", NULL, MS_RDONLY|MS_SYNCHRONOUS|MS_DIRSYNC|MS_BIND|MS_SHARED, NULL [pid 5074] <... futex resumed>) = 1 [pid 5069] <... futex resumed>) = 0 [pid 5070] futex(0x7f7262c1d6ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 5079] <... chdir resumed>) = 0 [pid 5077] <... mount resumed>) = 0 [pid 5074] mount(NULL, "./file0/../file0", NULL, MS_NODEV|MS_SYNCHRONOUS|MS_REMOUNT|MS_MANDLOCK|MS_MOVE|MS_REC|MS_POSIXACL|MS_PRIVATE|MS_SLAVE|MS_RELATIME|MS_STRICTATIME|MS_LAZYTIME, "flushoncommit,commit=0x0000000000000000,flushoncommit,clear_cache,datacow,compress-force,space_cache"... [pid 5069] futex(0x7f7262c1d6a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 5079] futex(0x7f7262c1d6ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 5077] futex(0x7f7262c1d6ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 5079] <... futex resumed>) = 1 [pid 5077] <... futex resumed>) = 1 [pid 5069] <... futex resumed>) = 0 [pid 5071] <... futex resumed>) = 0 [pid 5070] <... futex resumed>) = 0 [pid 5077] futex(0x7f7262c1d6a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 5069] futex(0x7f7262c1d6ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 5071] futex(0x7f7262c1d6a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 5070] futex(0x7f7262c1d6a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 5077] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 5071] <... futex resumed>) = 0 [pid 5070] <... futex resumed>) = 0 [pid 5077] mkdir(".", 0777 [pid 5071] futex(0x7f7262c1d6ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 5077] <... mkdir resumed>) = -1 EEXIST (File exists) [pid 5070] futex(0x7f7262c1d6ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=4, tv_nsec=50000000} [ 56.002736][ T5075] BTRFS info (device loop0): enabling ssd optimizations [ 56.008744][ T5074] ======================================================= [ 56.008744][ T5074] WARNING: The mand mount option has been deprecated and [ 56.008744][ T5074] and is ignored by this kernel. Remove the mand [ 56.008744][ T5074] option from the mount to silence this warning. [ 56.008744][ T5074] ======================================================= [ 56.011341][ T5075] BTRFS info (device loop0): auto enabling async discard [pid 5077] mount(NULL, ".", 0x20000180, MS_NODEV|MS_NOEXEC|MS_REMOUNT|MS_DIRSYNC|MS_NOATIME|MS_PRIVATE|MS_RELATIME|MS_I_VERSION|MS_STRICTATIME, "" [pid 5079] mount(NULL, "./file0/../file0", NULL, MS_NODEV|MS_SYNCHRONOUS|MS_REMOUNT|MS_MANDLOCK|MS_MOVE|MS_REC|MS_POSIXACL|MS_PRIVATE|MS_SLAVE|MS_RELATIME|MS_STRICTATIME|MS_LAZYTIME, "flushoncommit,commit=0x0000000000000000,flushoncommit,clear_cache,datacow,compress-force,space_cache"... [pid 5075] <... mount resumed>) = 0 [pid 5075] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY) = 3 [pid 5075] chdir("./file0") = 0 [pid 5075] ioctl(4, LOOP_CLR_FD) = 0 [pid 5075] close(4) = 0 [pid 5075] futex(0x7f7262c1d6ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 5069] <... futex resumed>) = -1 ETIMEDOUT (Connection timed out) [pid 5069] futex(0x7f7262c1d6ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=0} [pid 5066] <... futex resumed>) = 0 [pid 5075] <... futex resumed>) = 1 [pid 5071] <... futex resumed>) = -1 ETIMEDOUT (Connection timed out) [pid 5066] futex(0x7f7262c1d6a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 5071] futex(0x7f7262c1d6ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=0} [pid 5075] mount(".", "./file0/../file0", NULL, MS_RDONLY|MS_SYNCHRONOUS|MS_DIRSYNC|MS_BIND|MS_SHARED, NULL [pid 5066] <... futex resumed>) = 0 [pid 5071] <... futex resumed>) = -1 ETIMEDOUT (Connection timed out) [pid 5075] <... mount resumed>) = 0 [pid 5069] <... futex resumed>) = -1 ETIMEDOUT (Connection timed out) [pid 5071] futex(0x7f7262c1d6bc, FUTEX_WAKE_PRIVATE, 1000000 [pid 5066] futex(0x7f7262c1d6ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 5075] futex(0x7f7262c1d6ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 5071] <... futex resumed>) = 0 [pid 5066] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 5069] futex(0x7f7262c1d6bc, FUTEX_WAKE_PRIVATE, 1000000 [pid 5075] <... futex resumed>) = 0 [pid 5069] <... futex resumed>) = 0 [pid 5071] mmap(NULL, 135168, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_STACK, -1, 0 [pid 5066] futex(0x7f7262c1d6a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 5075] mkdir(".", 0777 [pid 5069] mmap(NULL, 135168, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_STACK, -1, 0 [pid 5075] <... mkdir resumed>) = -1 EEXIST (File exists) [pid 5071] <... mmap resumed>) = 0x7f7262b0b000 [pid 5066] <... futex resumed>) = 0 [pid 5069] <... mmap resumed>) = 0x7f7262b0b000 [pid 5071] mprotect(0x7f7262b0c000, 131072, PROT_READ|PROT_WRITE [pid 5066] futex(0x7f7262c1d6ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=4, tv_nsec=50000000} [pid 5075] mount(NULL, ".", 0x20000180, MS_NODEV|MS_NOEXEC|MS_REMOUNT|MS_DIRSYNC|MS_NOATIME|MS_PRIVATE|MS_RELATIME|MS_I_VERSION|MS_STRICTATIME, "" [pid 5069] mprotect(0x7f7262b0c000, 131072, PROT_READ|PROT_WRITE [pid 5071] <... mprotect resumed>) = 0 [pid 5077] <... mount resumed>) = 0 [pid 5069] <... mprotect resumed>) = 0 [pid 5071] rt_sigprocmask(SIG_BLOCK, ~[], [pid 5069] rt_sigprocmask(SIG_BLOCK, ~[], [pid 5071] <... rt_sigprocmask resumed>[], 8) = 0 [pid 5069] <... rt_sigprocmask resumed>[], 8) = 0 [pid 5069] clone3({flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID, child_tid=0x7f7262b2b990, parent_tid=0x7f7262b2b990, exit_signal=0, stack=0x7f7262b0b000, stack_size=0x20300, tls=0x7f7262b2b6c0} [ 56.070885][ T5079] BTRFS info (device loop4: state M): using default commit interval 30s [ 56.081957][ T5076] BTRFS info (device loop5): enabling ssd optimizations [pid 5071] clone3({flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID, child_tid=0x7f7262b2b990, parent_tid=0x7f7262b2b990, exit_signal=0, stack=0x7f7262b0b000, stack_size=0x20300, tls=0x7f7262b2b6c0}./strace-static-x86_64: Process 5169 attached ./strace-static-x86_64: Process 5168 attached [pid 5077] openat(AT_FDCWD, ".", O_RDONLY|O_DIRECTORY [pid 5169] rseq(0x7f7262b2bfe0, 0x20, 0, 0x53053053 [pid 5168] rseq(0x7f7262b2bfe0, 0x20, 0, 0x53053053 [pid 5169] <... rseq resumed>) = 0 [pid 5168] <... rseq resumed>) = 0 [pid 5069] <... clone3 resumed> => {parent_tid=[5169]}, 88) = 5169 [pid 5071] <... clone3 resumed> => {parent_tid=[5168]}, 88) = 5168 [pid 5169] set_robust_list(0x7f7262b2b9a0, 24 [pid 5168] set_robust_list(0x7f7262b2b9a0, 24 [pid 5069] rt_sigprocmask(SIG_SETMASK, [], [pid 5071] rt_sigprocmask(SIG_SETMASK, [], [pid 5169] <... set_robust_list resumed>) = 0 [pid 5168] <... set_robust_list resumed>) = 0 [pid 5069] <... rt_sigprocmask resumed>NULL, 8) = 0 [pid 5071] <... rt_sigprocmask resumed>NULL, 8) = 0 [pid 5169] rt_sigprocmask(SIG_SETMASK, [], [pid 5168] rt_sigprocmask(SIG_SETMASK, [], [pid 5069] futex(0x7f7262c1d6b8, FUTEX_WAKE_PRIVATE, 1000000 [pid 5071] futex(0x7f7262c1d6b8, FUTEX_WAKE_PRIVATE, 1000000 [pid 5168] <... rt_sigprocmask resumed>NULL, 8) = 0 [pid 5077] <... openat resumed>) = 4 [pid 5075] <... mount resumed>) = 0 [pid 5071] <... futex resumed>) = 0 [pid 5168] open("./bus", O_RDWR|O_CREAT|O_NOCTTY|O_SYNC|O_NOATIME|FASYNC, 000 [pid 5077] chdir("." [pid 5075] openat(AT_FDCWD, ".", O_RDONLY|O_DIRECTORY [pid 5069] <... futex resumed>) = 0 [pid 5071] futex(0x7f7262c1d6bc, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 5077] <... chdir resumed>) = 0 [pid 5077] futex(0x7f7262c1d6ac, FUTEX_WAKE_PRIVATE, 1000000) = 1 [pid 5169] <... rt_sigprocmask resumed>NULL, 8) = 0 [pid 5077] futex(0x7f7262c1d6a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 5069] futex(0x7f7262c1d6bc, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 5169] open("./bus", O_RDWR|O_CREAT|O_NOCTTY|O_SYNC|O_NOATIME|FASYNC, 000 [pid 5070] <... futex resumed>) = 0 [pid 5168] <... open resumed>) = 5 [pid 5075] <... openat resumed>) = 4 [ 56.127948][ T5076] BTRFS info (device loop5): auto enabling async discard [ 56.139468][ T5079] BTRFS info (device loop4: state M): force clearing of disk cache [pid 5070] futex(0x7f7262c1d6a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 5077] <... futex resumed>) = 0 [pid 5075] chdir("." [pid 5070] <... futex resumed>) = 1 [pid 5077] mount(NULL, "./file0/../file0", NULL, MS_NODEV|MS_SYNCHRONOUS|MS_REMOUNT|MS_MANDLOCK|MS_MOVE|MS_REC|MS_POSIXACL|MS_PRIVATE|MS_SLAVE|MS_RELATIME|MS_STRICTATIME|MS_LAZYTIME, "flushoncommit,commit=0x0000000000000000,flushoncommit,clear_cache,datacow,compress-force,space_cache"... [pid 5169] <... open resumed>) = 5 [pid 5075] <... chdir resumed>) = 0 [pid 5070] futex(0x7f7262c1d6ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 5075] futex(0x7f7262c1d6ac, FUTEX_WAKE_PRIVATE, 1000000) = 1 [pid 5069] <... futex resumed>) = -1 ETIMEDOUT (Connection timed out) [pid 5071] <... futex resumed>) = -1 ETIMEDOUT (Connection timed out) [pid 5066] <... futex resumed>) = 0 [pid 5169] futex(0x7f7262c1d6bc, FUTEX_WAKE_PRIVATE, 1000000 [pid 5066] futex(0x7f7262c1d6a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 5169] <... futex resumed>) = 0 [pid 5066] <... futex resumed>) = 0 [pid 5169] futex(0x7f7262c1d6b8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 5066] futex(0x7f7262c1d6ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [ 56.185036][ T5077] BTRFS info (device loop1: state M): using default commit interval 30s [ 56.199507][ T5077] BTRFS info (device loop1: state M): force clearing of disk cache [ 56.200289][ T5079] BTRFS warning (device loop4: state M): remount supports changing free space tree only from ro to rw [ 56.212622][ T5077] BTRFS warning (device loop1: state M): remount supports changing free space tree only from ro to rw [pid 5075] mount(NULL, "./file0/../file0", NULL, MS_NODEV|MS_SYNCHRONOUS|MS_REMOUNT|MS_MANDLOCK|MS_MOVE|MS_REC|MS_POSIXACL|MS_PRIVATE|MS_SLAVE|MS_RELATIME|MS_STRICTATIME|MS_LAZYTIME, "flushoncommit,commit=0x0000000000000000,flushoncommit,clear_cache,datacow,compress-force,space_cache"... [pid 5076] <... mount resumed>) = 0 [pid 5168] futex(0x7f7262c1d6bc, FUTEX_WAKE_PRIVATE, 1000000 [pid 5076] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY [pid 5070] <... futex resumed>) = -1 ETIMEDOUT (Connection timed out) [pid 5168] <... futex resumed>) = 0 [pid 5076] <... openat resumed>) = 3 [pid 5070] futex(0x7f7262c1d6bc, FUTEX_WAKE_PRIVATE, 1000000 [pid 5168] futex(0x7f7262c1d6b8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 5076] chdir("./file0" [pid 5070] <... futex resumed>) = 0 [pid 5076] <... chdir resumed>) = 0 [pid 5070] mmap(NULL, 135168, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_STACK, -1, 0 [pid 5077] <... mount resumed>) = 0 [pid 5076] ioctl(4, LOOP_CLR_FD) = 0 [pid 5070] <... mmap resumed>) = 0x7f7262b0b000 [pid 5076] close(4 [pid 5070] mprotect(0x7f7262b0c000, 131072, PROT_READ|PROT_WRITE [pid 5077] futex(0x7f7262c1d6ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 5076] <... close resumed>) = 0 [pid 5070] <... mprotect resumed>) = 0 [pid 5076] futex(0x7f7262c1d6ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 5070] rt_sigprocmask(SIG_BLOCK, ~[], [pid 5077] <... futex resumed>) = 0 [pid 5076] <... futex resumed>) = 1 [pid 5070] <... rt_sigprocmask resumed>[], 8) = 0 [ 56.229819][ T5075] BTRFS info (device loop0: state M): using default commit interval 30s [pid 5077] futex(0x7f7262c1d6a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 5076] futex(0x7f7262c1d6a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 5073] <... futex resumed>) = 0 [pid 5070] clone3({flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID, child_tid=0x7f7262b2b990, parent_tid=0x7f7262b2b990, exit_signal=0, stack=0x7f7262b0b000, stack_size=0x20300, tls=0x7f7262b2b6c0} [pid 5066] <... futex resumed>) = -1 ETIMEDOUT (Connection timed out) [pid 5073] futex(0x7f7262c1d6a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 5066] futex(0x7f7262c1d6bc, FUTEX_WAKE_PRIVATE, 1000000 [pid 5076] <... futex resumed>) = 0 [pid 5073] <... futex resumed>) = 1 [pid 5070] <... clone3 resumed> => {parent_tid=[5177]}, 88) = 5177 [pid 5066] <... futex resumed>) = 0 ./strace-static-x86_64: Process 5177 attached [pid 5076] mount(".", "./file0/../file0", NULL, MS_RDONLY|MS_SYNCHRONOUS|MS_DIRSYNC|MS_BIND|MS_SHARED, NULL [pid 5073] futex(0x7f7262c1d6ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 5070] rt_sigprocmask(SIG_SETMASK, [], [pid 5066] mmap(NULL, 135168, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_STACK, -1, 0 [pid 5177] rseq(0x7f7262b2bfe0, 0x20, 0, 0x53053053 [pid 5079] <... mount resumed>) = 0 [pid 5076] <... mount resumed>) = 0 [pid 5070] <... rt_sigprocmask resumed>NULL, 8) = 0 [pid 5076] futex(0x7f7262c1d6ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 5070] futex(0x7f7262c1d6b8, FUTEX_WAKE_PRIVATE, 1000000 [pid 5177] <... rseq resumed>) = 0 [pid 5079] futex(0x7f7262c1d6ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 5076] <... futex resumed>) = 1 [pid 5073] <... futex resumed>) = 0 [pid 5070] <... futex resumed>) = 0 [pid 5066] <... mmap resumed>) = 0x7f7262b0b000 [pid 5073] futex(0x7f7262c1d6a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 5079] <... futex resumed>) = 0 [pid 5079] futex(0x7f7262c1d6a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 5073] <... futex resumed>) = 0 [pid 5177] set_robust_list(0x7f7262b2b9a0, 24) = 0 [pid 5076] mkdir(".", 0777 [pid 5073] futex(0x7f7262c1d6ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=4, tv_nsec=50000000} [pid 5070] futex(0x7f7262c1d6bc, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 5066] mprotect(0x7f7262b0c000, 131072, PROT_READ|PROT_WRITE [pid 5177] rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 [pid 5076] <... mkdir resumed>) = -1 EEXIST (File exists) [pid 5071] exit_group(0 [pid 5066] <... mprotect resumed>) = 0 [pid 5177] open("./bus", O_RDWR|O_CREAT|O_NOCTTY|O_SYNC|O_NOATIME|FASYNC, 000) = 5 [pid 5168] <... futex resumed>) = ? [pid 5079] <... futex resumed>) = ? [pid 5076] mount(NULL, ".", 0x20000180, MS_NODEV|MS_NOEXEC|MS_REMOUNT|MS_DIRSYNC|MS_NOATIME|MS_PRIVATE|MS_RELATIME|MS_I_VERSION|MS_STRICTATIME, "" [pid 5071] <... exit_group resumed>) = ? [pid 5066] rt_sigprocmask(SIG_BLOCK, ~[], [pid 5079] +++ exited with 0 +++ [pid 5177] futex(0x7f7262c1d6bc, FUTEX_WAKE_PRIVATE, 1000000 [pid 5168] +++ exited with 0 +++ [pid 5071] +++ exited with 0 +++ [pid 5066] <... rt_sigprocmask resumed>[], 8) = 0 [pid 5177] <... futex resumed>) = 1 [pid 5070] <... futex resumed>) = 0 [ 56.292686][ T5075] BTRFS info (device loop0: state M): force clearing of disk cache [ 56.300644][ T5075] BTRFS warning (device loop0: state M): remount supports changing free space tree only from ro to rw [ 56.306392][ T5074] BTRFS info (device loop3: state M): using default commit interval 30s [ 56.322149][ T5078] BTRFS info (device loop2): enabling ssd optimizations [pid 5066] clone3({flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID, child_tid=0x7f7262b2b990, parent_tid=0x7f7262b2b990, exit_signal=0, stack=0x7f7262b0b000, stack_size=0x20300, tls=0x7f7262b2b6c0} [pid 5065] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5071, si_uid=0, si_status=0, si_utime=2 /* 0.02 s */, si_stime=41 /* 0.41 s */} --- [pid 5070] exit_group(0) = ? [pid 5066] <... clone3 resumed> => {parent_tid=[5179]}, 88) = 5179 [pid 5077] <... futex resumed>) = ? [pid 5066] rt_sigprocmask(SIG_SETMASK, [], [pid 5077] +++ exited with 0 +++ [pid 5066] <... rt_sigprocmask resumed>NULL, 8) = 0 [pid 5066] futex(0x7f7262c1d6b8, FUTEX_WAKE_PRIVATE, 1000000 [pid 5177] +++ exited with 0 +++ [pid 5070] +++ exited with 0 +++ [pid 5066] <... futex resumed>) = 0 ./strace-static-x86_64: Process 5179 attached [pid 5066] futex(0x7f7262c1d6bc, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 5065] umount2("./0", MNT_DETACH|UMOUNT_NOFOLLOW [pid 5179] rseq(0x7f7262b2bfe0, 0x20, 0, 0x53053053 [pid 5065] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5062] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5070, si_uid=0, si_status=0, si_utime=7 /* 0.07 s */, si_stime=42 /* 0.42 s */} --- [pid 5179] <... rseq resumed>) = 0 [pid 5065] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5062] umount2("./0", MNT_DETACH|UMOUNT_NOFOLLOW [pid 5179] set_robust_list(0x7f7262b2b9a0, 24 [pid 5076] <... mount resumed>) = 0 [pid 5179] <... set_robust_list resumed>) = 0 [pid 5076] openat(AT_FDCWD, ".", O_RDONLY|O_DIRECTORY [pid 5065] <... openat resumed>) = 3 [pid 5062] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5179] rt_sigprocmask(SIG_SETMASK, [], [pid 5076] <... openat resumed>) = 4 [pid 5179] <... rt_sigprocmask resumed>NULL, 8) = 0 [pid 5076] chdir("." [pid 5062] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5179] open("./bus", O_RDWR|O_CREAT|O_NOCTTY|O_SYNC|O_NOATIME|FASYNC, 000 [pid 5076] <... chdir resumed>) = 0 [pid 5065] newfstatat(3, "", [pid 5062] <... openat resumed>) = 3 [pid 5179] <... open resumed>) = 5 [pid 5076] futex(0x7f7262c1d6ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 5062] newfstatat(3, "", [pid 5076] <... futex resumed>) = 1 [pid 5076] futex(0x7f7262c1d6a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 5062] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5062] getdents64(3, [pid 5075] <... mount resumed>) = 0 [pid 5073] <... futex resumed>) = 0 [pid 5065] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5075] futex(0x7f7262c1d6ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 5073] futex(0x7f7262c1d6a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 5065] getdents64(3, [pid 5062] <... getdents64 resumed>0x555556ab3730 /* 4 entries */, 32768) = 112 [pid 5078] <... mount resumed>) = 0 [pid 5076] <... futex resumed>) = 0 [pid 5075] <... futex resumed>) = 0 [pid 5073] <... futex resumed>) = 1 [pid 5065] <... getdents64 resumed>0x555556ab3730 /* 4 entries */, 32768) = 112 [ 56.344768][ T5074] BTRFS info (device loop3: state M): force clearing of disk cache [ 56.373240][ T5078] BTRFS info (device loop2): auto enabling async discard [ 56.380529][ T5074] BTRFS warning (device loop3: state M): remount supports changing free space tree only from ro to rw [pid 5062] umount2("./0/binderfs", MNT_DETACH|UMOUNT_NOFOLLOW [pid 5179] futex(0x7f7262c1d6bc, FUTEX_WAKE_PRIVATE, 1000000 [pid 5078] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY [pid 5076] mount(NULL, "./file0/../file0", NULL, MS_NODEV|MS_SYNCHRONOUS|MS_REMOUNT|MS_MANDLOCK|MS_MOVE|MS_REC|MS_POSIXACL|MS_PRIVATE|MS_SLAVE|MS_RELATIME|MS_STRICTATIME|MS_LAZYTIME, "flushoncommit,commit=0x0000000000000000,flushoncommit,clear_cache,datacow,compress-force,space_cache"... [pid 5075] futex(0x7f7262c1d6a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 5074] <... mount resumed>) = 0 [pid 5073] futex(0x7f7262c1d6ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 5066] <... futex resumed>) = -1 ETIMEDOUT (Connection timed out) [pid 5065] umount2("./0/binderfs", MNT_DETACH|UMOUNT_NOFOLLOW [pid 5179] <... futex resumed>) = 0 [pid 5078] <... openat resumed>) = 3 [pid 5074] futex(0x7f7262c1d6ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 5069] exit_group(0 [pid 5066] exit_group(0 [pid 5169] <... futex resumed>) = ? [pid 5069] <... exit_group resumed>) = ? [pid 5066] <... exit_group resumed>) = ? [pid 5075] <... futex resumed>) = ? [pid 5169] +++ exited with 0 +++ [pid 5078] chdir("./file0" [pid 5075] +++ exited with 0 +++ [pid 5074] <... futex resumed>) = ? [pid 5065] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5062] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5179] +++ exited with 0 +++ [pid 5078] <... chdir resumed>) = 0 [pid 5074] +++ exited with 0 +++ [pid 5069] +++ exited with 0 +++ [pid 5066] +++ exited with 0 +++ [pid 5065] newfstatat(AT_FDCWD, "./0/binderfs", [pid 5078] ioctl(4, LOOP_CLR_FD) = 0 [pid 5065] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5062] newfstatat(AT_FDCWD, "./0/binderfs", [pid 5061] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5066, si_uid=0, si_status=0, si_utime=2 /* 0.02 s */, si_stime=35 /* 0.35 s */} --- [pid 5078] close(4 [pid 5064] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5069, si_uid=0, si_status=0, si_utime=2 /* 0.02 s */, si_stime=41 /* 0.41 s */} --- [pid 5062] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5065] unlink("./0/binderfs" [pid 5064] restart_syscall(<... resuming interrupted clone ...> [pid 5062] unlink("./0/binderfs" [pid 5078] <... close resumed>) = 0 [pid 5064] <... restart_syscall resumed>) = 0 [pid 5062] <... unlink resumed>) = 0 [pid 5078] futex(0x7f7262c1d6ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 5065] <... unlink resumed>) = 0 [pid 5078] <... futex resumed>) = 1 [pid 5072] <... futex resumed>) = 0 [pid 5062] umount2("./0/file0", MNT_DETACH|UMOUNT_NOFOLLOW [pid 5078] futex(0x7f7262c1d6a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 5072] futex(0x7f7262c1d6a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 5065] umount2("./0/file0", MNT_DETACH|UMOUNT_NOFOLLOW [pid 5064] umount2("./0", MNT_DETACH|UMOUNT_NOFOLLOW [pid 5078] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 5072] <... futex resumed>) = 0 [pid 5064] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5078] mount(".", "./file0/../file0", NULL, MS_RDONLY|MS_SYNCHRONOUS|MS_DIRSYNC|MS_BIND|MS_SHARED, NULL [pid 5072] futex(0x7f7262c1d6ac, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000} [pid 5064] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5061] umount2("./0", MNT_DETACH|UMOUNT_NOFOLLOW [pid 5064] <... openat resumed>) = 3 [pid 5061] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5073] <... futex resumed>) = -1 ETIMEDOUT (Connection timed out) [pid 5064] newfstatat(3, "", [pid 5061] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5073] futex(0x7f7262c1d6bc, FUTEX_WAKE_PRIVATE, 1000000) = 0 [pid 5064] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5061] <... openat resumed>) = 3 [pid 5073] mmap(NULL, 135168, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_STACK, -1, 0) = 0x7f7262b0b000 [pid 5064] getdents64(3, [pid 5061] newfstatat(3, "", [ 56.414902][ T5076] BTRFS info (device loop5: state M): using default commit interval 30s [ 56.443203][ T5076] BTRFS info (device loop5: state M): force clearing of disk cache [pid 5073] mprotect(0x7f7262b0c000, 131072, PROT_READ|PROT_WRITE [pid 5064] <... getdents64 resumed>0x555556ab3730 /* 4 entries */, 32768) = 112 [pid 5064] umount2("./0/binderfs", MNT_DETACH|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5064] newfstatat(AT_FDCWD, "./0/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5064] unlink("./0/binderfs") = 0 [pid 5064] umount2("./0/file0", MNT_DETACH|UMOUNT_NOFOLLOW [pid 5073] <... mprotect resumed>) = 0 [pid 5061] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5078] <... mount resumed>) = 0 [pid 5073] rt_sigprocmask(SIG_BLOCK, ~[], [], 8) = 0 [pid 5061] getdents64(3, [pid 5073] clone3({flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID, child_tid=0x7f7262b2b990, parent_tid=0x7f7262b2b990, exit_signal=0, stack=0x7f7262b0b000, stack_size=0x20300, tls=0x7f7262b2b6c0} [pid 5061] <... getdents64 resumed>0x555556ab3730 /* 4 entries */, 32768) = 112 [pid 5078] futex(0x7f7262c1d6ac, FUTEX_WAKE_PRIVATE, 1000000 [pid 5073] <... clone3 resumed> => {parent_tid=[5181]}, 88) = 5181 [pid 5061] umount2("./0/binderfs", MNT_DETACH|UMOUNT_NOFOLLOW [pid 5078] <... futex resumed>) = 1 [pid 5073] rt_sigprocmask(SIG_SETMASK, [], [pid 5072] <... futex resumed>) = 0 [pid 5073] <... rt_sigprocmask resumed>NULL, 8) = 0 [pid 5061] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5078] futex(0x7f7262c1d6a8, FUTEX_WAIT_PRIVATE, 0, NULL [pid 5073] futex(0x7f7262c1d6b8, FUTEX_WAKE_PRIVATE, 1000000 [pid 5072] futex(0x7f7262c1d6a8, FUTEX_WAKE_PRIVATE, 1000000 [pid 5061] newfstatat(AT_FDCWD, "./0/binderfs", ./strace-static-x86_64: Process 5181 attached [pid 5078] <... futex resumed>) = -1 EAGAIN (Resource temporarily unavailable) [pid 5073] <... futex resumed>) = 0 [pid 5072] <... futex resumed>) = 0 [pid 5061] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5078] mkdir(".", 0777 [pid 5073] futex(0x7f7262c1d6bc, FUTEX_WAIT_PRIVATE, 0, {tv_sec=0, tv_nsec=50000000}