./strace-static-x86_64 -e \!wait4,clock_nanosleep,nanosleep -s 100 -x -f ./syz-executor2537874361 <...> Warning: Permanently added '10.128.1.143' (ED25519) to the list of known hosts. execve("./syz-executor2537874361", ["./syz-executor2537874361"], 0x7ffc0f4de510 /* 10 vars */) = 0 brk(NULL) = 0x555589fa7000 brk(0x555589fa7d00) = 0x555589fa7d00 arch_prctl(ARCH_SET_FS, 0x555589fa7380) = 0 set_tid_address(0x555589fa7650) = 5847 set_robust_list(0x555589fa7660, 24) = 0 rseq(0x555589fa7ca0, 0x20, 0, 0x53053053) = 0 prlimit64(0, RLIMIT_STACK, NULL, {rlim_cur=8192*1024, rlim_max=RLIM64_INFINITY}) = 0 readlink("/proc/self/exe", "/root/syz-executor2537874361", 4096) = 28 getrandom("\x10\xef\x49\xc3\x1a\x65\xf9\xc4", 8, GRND_NONBLOCK) = 8 brk(NULL) = 0x555589fa7d00 brk(0x555589fc8d00) = 0x555589fc8d00 brk(0x555589fc9000) = 0x555589fc9000 mprotect(0x7fbbc7ab5000, 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 5848 attached , child_tidptr=0x555589fa7650) = 5848 [pid 5847] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5848] set_robust_list(0x555589fa7660, 24./strace-static-x86_64: Process 5849 attached [pid 5849] set_robust_list(0x555589fa7660, 24 [pid 5847] <... clone resumed>, child_tidptr=0x555589fa7650) = 5849 [pid 5848] <... set_robust_list resumed>) = 0 [pid 5849] <... set_robust_list resumed>) = 0 [pid 5849] mkdir("./syzkaller.JtXqqo", 0700 [pid 5848] mkdir("./syzkaller.hXjubC", 0700 [pid 5847] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5850 attached , child_tidptr=0x555589fa7650) = 5850 [pid 5847] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5850] set_robust_list(0x555589fa7660, 24./strace-static-x86_64: Process 5851 attached ) = 0 [pid 5849] <... mkdir resumed>) = 0 [pid 5848] <... mkdir resumed>) = 0 [pid 5851] set_robust_list(0x555589fa7660, 24 [pid 5847] <... clone resumed>, child_tidptr=0x555589fa7650) = 5851 [pid 5851] <... set_robust_list resumed>) = 0 [pid 5849] chmod("./syzkaller.JtXqqo", 0777 [pid 5848] chmod("./syzkaller.hXjubC", 0777 [pid 5850] mkdir("./syzkaller.KFGac8", 0700 [pid 5848] <... chmod resumed>) = 0 [pid 5849] <... chmod resumed>) = 0 [pid 5847] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5851] mkdir("./syzkaller.jAGD44", 0700 [pid 5850] <... mkdir resumed>) = 0 [pid 5849] chdir("./syzkaller.JtXqqo" [pid 5848] chdir("./syzkaller.hXjubC" [pid 5850] chmod("./syzkaller.KFGac8", 0777./strace-static-x86_64: Process 5852 attached [pid 5851] <... mkdir resumed>) = 0 [pid 5849] <... chdir resumed>) = 0 [pid 5848] <... chdir resumed>) = 0 [pid 5847] <... clone resumed>, child_tidptr=0x555589fa7650) = 5852 [pid 5852] set_robust_list(0x555589fa7660, 24) = 0 [pid 5850] <... chmod resumed>) = 0 [pid 5849] mkdir("./0", 0777 [pid 5848] mkdir("./0", 0777 [pid 5851] chmod("./syzkaller.jAGD44", 0777) = 0 [pid 5850] chdir("./syzkaller.KFGac8") = 0 [pid 5852] mkdir("./syzkaller.uRyhV0", 0700 [pid 5850] mkdir("./0", 0777 [pid 5851] chdir("./syzkaller.jAGD44" [pid 5849] <... mkdir resumed>) = 0 [pid 5851] <... chdir resumed>) = 0 [pid 5850] <... mkdir resumed>) = 0 [pid 5848] <... mkdir resumed>) = 0 [pid 5851] mkdir("./0", 0777 [pid 5852] <... mkdir resumed>) = 0 [pid 5850] openat(AT_FDCWD, "/dev/loop2", O_RDWR [pid 5849] openat(AT_FDCWD, "/dev/loop1", O_RDWR [pid 5848] openat(AT_FDCWD, "/dev/loop0", O_RDWR [pid 5851] <... mkdir resumed>) = 0 [pid 5852] chmod("./syzkaller.uRyhV0", 0777) = 0 [pid 5851] openat(AT_FDCWD, "/dev/loop3", O_RDWR [pid 5850] <... openat resumed>) = 3 [pid 5849] <... openat resumed>) = 3 [pid 5848] <... openat resumed>) = 3 [pid 5848] ioctl(3, LOOP_CLR_FD [pid 5852] chdir("./syzkaller.uRyhV0" [pid 5851] <... openat resumed>) = 3 [pid 5850] ioctl(3, LOOP_CLR_FD [pid 5849] ioctl(3, LOOP_CLR_FD [pid 5848] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5852] <... chdir resumed>) = 0 [pid 5851] ioctl(3, LOOP_CLR_FD [pid 5850] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5849] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5852] mkdir("./0", 0777 [pid 5851] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5849] close(3 [pid 5848] close(3 [pid 5851] close(3 [pid 5850] close(3 [pid 5848] <... close resumed>) = 0 [pid 5851] <... close resumed>) = 0 [pid 5850] <... close resumed>) = 0 [pid 5852] <... mkdir resumed>) = 0 [pid 5849] <... close resumed>) = 0 [pid 5850] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5851] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5848] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5854 attached ./strace-static-x86_64: Process 5853 attached [pid 5852] openat(AT_FDCWD, "/dev/loop4", O_RDWR [pid 5849] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5852] <... openat resumed>) = 3 [pid 5851] <... clone resumed>, child_tidptr=0x555589fa7650) = 5854 [pid 5850] <... clone resumed>, child_tidptr=0x555589fa7650) = 5853 ./strace-static-x86_64: Process 5856 attached ./strace-static-x86_64: Process 5855 attached [pid 5854] set_robust_list(0x555589fa7660, 24 [pid 5853] set_robust_list(0x555589fa7660, 24 [pid 5852] ioctl(3, LOOP_CLR_FD [pid 5853] <... set_robust_list resumed>) = 0 [pid 5852] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5855] set_robust_list(0x555589fa7660, 24 [pid 5853] chdir("./0" [pid 5852] close(3 [pid 5856] set_robust_list(0x555589fa7660, 24 [pid 5849] <... clone resumed>, child_tidptr=0x555589fa7650) = 5856 [pid 5854] <... set_robust_list resumed>) = 0 [pid 5848] <... clone resumed>, child_tidptr=0x555589fa7650) = 5855 [pid 5856] <... set_robust_list resumed>) = 0 [pid 5853] <... chdir resumed>) = 0 [pid 5852] <... close resumed>) = 0 [pid 5856] chdir("./0" [pid 5855] <... set_robust_list resumed>) = 0 [pid 5854] chdir("./0" [pid 5856] <... chdir resumed>) = 0 [pid 5853] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5852] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5857 attached [pid 5855] chdir("./0" [pid 5853] <... prctl resumed>) = 0 [pid 5857] set_robust_list(0x555589fa7660, 24 [pid 5856] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5855] <... chdir resumed>) = 0 [pid 5854] <... chdir resumed>) = 0 [pid 5853] setpgid(0, 0 [pid 5857] <... set_robust_list resumed>) = 0 [pid 5855] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5854] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5856] <... prctl resumed>) = 0 [pid 5855] setpgid(0, 0 [pid 5854] <... prctl resumed>) = 0 [pid 5853] <... setpgid resumed>) = 0 [pid 5857] chdir("./0" [pid 5854] setpgid(0, 0 [pid 5856] setpgid(0, 0 [pid 5853] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5856] <... setpgid resumed>) = 0 [pid 5854] <... setpgid resumed>) = 0 [pid 5857] <... chdir resumed>) = 0 [pid 5856] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5855] <... setpgid resumed>) = 0 [pid 5854] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5853] <... openat resumed>) = 3 [pid 5857] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5856] <... openat resumed>) = 3 [pid 5855] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5854] <... openat resumed>) = 3 [pid 5857] setpgid(0, 0) = 0 [pid 5856] write(3, "1000", 4 [pid 5855] <... openat resumed>) = 3 [pid 5854] write(3, "1000", 4 [pid 5853] write(3, "1000", 4 [pid 5852] <... clone resumed>, child_tidptr=0x555589fa7650) = 5857 [pid 5857] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5856] <... write resumed>) = 4 [pid 5855] write(3, "1000", 4 [pid 5854] <... write resumed>) = 4 [pid 5853] <... write resumed>) = 4 [pid 5857] <... openat resumed>) = 3 [pid 5856] close(3 [pid 5855] <... write resumed>) = 4 [pid 5854] close(3 [pid 5853] close(3 [pid 5857] write(3, "1000", 4 [pid 5855] close(3 [pid 5857] <... write resumed>) = 4 [pid 5857] close(3 [pid 5855] <... close resumed>) = 0 [pid 5856] <... close resumed>) = 0 [pid 5855] symlink("/dev/binderfs", "./binderfs" [pid 5854] <... close resumed>) = 0 [pid 5853] <... close resumed>) = 0 [pid 5856] symlink("/dev/binderfs", "./binderfs" [pid 5854] symlink("/dev/binderfs", "./binderfs" [pid 5853] symlink("/dev/binderfs", "./binderfs" [pid 5857] <... close resumed>) = 0 [pid 5856] <... symlink resumed>) = 0 [pid 5854] <... symlink resumed>) = 0 [pid 5853] <... symlink resumed>) = 0 executing program [pid 5857] symlink("/dev/binderfs", "./binderfs" [pid 5855] <... symlink resumed>) = 0 [pid 5854] write(1, "executing program\n", 18executing program executing program executing program ) = 18 [pid 5857] <... symlink resumed>) = 0 [pid 5853] write(1, "executing program\n", 18 [pid 5857] write(1, "executing program\n", 18 [pid 5855] write(1, "executing program\n", 18 [pid 5857] <... write resumed>) = 18 [pid 5855] <... write resumed>) = 18 [pid 5857] memfd_create("syzkaller", 0executing program [pid 5856] write(1, "executing program\n", 18 [pid 5855] memfd_create("syzkaller", 0 [pid 5854] memfd_create("syzkaller", 0 [pid 5853] <... write resumed>) = 18 [pid 5856] <... write resumed>) = 18 [pid 5855] <... memfd_create resumed>) = 3 [pid 5857] <... memfd_create resumed>) = 3 [pid 5855] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5856] memfd_create("syzkaller", 0 [pid 5855] <... mmap resumed>) = 0x7fbbbf400000 [pid 5854] <... memfd_create resumed>) = 3 [pid 5853] memfd_create("syzkaller", 0 [pid 5856] <... memfd_create resumed>) = 3 [pid 5854] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5853] <... memfd_create resumed>) = 3 [pid 5856] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5854] <... mmap resumed>) = 0x7fbbbf400000 [pid 5853] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5856] <... mmap resumed>) = 0x7fbbbf400000 [pid 5853] <... mmap resumed>) = 0x7fbbbf400000 [pid 5857] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5856] 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"..., 524288 [pid 5853] 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"..., 524288 [pid 5857] <... mmap resumed>) = 0x7fbbbf400000 [pid 5855] 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"..., 524288 [pid 5854] 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"..., 524288 [pid 5856] <... write resumed>) = 524288 [pid 5853] <... write resumed>) = 524288 [pid 5857] 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"..., 524288 [pid 5854] <... write resumed>) = 524288 [pid 5853] munmap(0x7fbbbf400000, 138412032 [pid 5855] <... write resumed>) = 524288 [pid 5853] <... munmap resumed>) = 0 [pid 5855] munmap(0x7fbbbf400000, 138412032 [pid 5853] openat(AT_FDCWD, "/dev/loop2", O_RDWR [pid 5855] <... munmap resumed>) = 0 [pid 5853] <... openat resumed>) = 4 [pid 5856] munmap(0x7fbbbf400000, 138412032 [pid 5855] openat(AT_FDCWD, "/dev/loop0", O_RDWR [pid 5853] ioctl(4, LOOP_SET_FD, 3 [pid 5857] <... write resumed>) = 524288 [pid 5856] <... munmap resumed>) = 0 [pid 5855] <... openat resumed>) = 4 [pid 5856] openat(AT_FDCWD, "/dev/loop1", O_RDWR) = 4 [pid 5856] ioctl(4, LOOP_SET_FD, 3 [pid 5854] munmap(0x7fbbbf400000, 138412032) = 0 [pid 5857] munmap(0x7fbbbf400000, 138412032 [pid 5855] ioctl(4, LOOP_SET_FD, 3 [pid 5854] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = 4 [pid 5854] ioctl(4, LOOP_SET_FD, 3 [pid 5857] <... munmap resumed>) = 0 [pid 5855] <... ioctl resumed>) = 0 [pid 5857] openat(AT_FDCWD, "/dev/loop4", O_RDWR [pid 5855] close(3 [pid 5857] <... openat resumed>) = 4 [pid 5855] <... close resumed>) = 0 [pid 5857] ioctl(4, LOOP_SET_FD, 3 [pid 5855] close(4 [pid 5853] <... ioctl resumed>) = 0 [pid 5853] close(3) = 0 [pid 5853] close(4 [pid 5856] <... ioctl resumed>) = 0 [pid 5856] close(3) = 0 [pid 5856] close(4) = 0 [pid 5856] mkdir("./file2", 0777) = 0 [pid 5856] mount("/dev/loop1", "./file2", "hfsplus", MS_NOEXEC|MS_SYNCHRONOUS|MS_REC|MS_POSIXACL, "\x64\x65\x63\x6f\x6d\x70\x6f\x73\x65\x2c\x75\x6d\x61\x73\x6b\x3d\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x34\x30\x2c\x74\x79\x70\x65\x3d\xa7\x86\x88\x28\x2c\x75\x6d\x61\x73\x6b\x3d\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x31\x30\x30\x30\x30\x31\x2c\x6e\x6c\x73\x3d\x63\x70\x38\x36\x36\x2c\x75\x6d\x61\x73\x6b\x3d\x30\x30\x30\x30"... [pid 5855] <... close resumed>) = 0 [pid 5853] <... close resumed>) = 0 [pid 5853] mkdir("./file2", 0777 [pid 5855] mkdir("./file2", 0777 [pid 5853] <... mkdir resumed>) = 0 [pid 5853] mount("/dev/loop2", "./file2", "hfsplus", MS_NOEXEC|MS_SYNCHRONOUS|MS_REC|MS_POSIXACL, "\x64\x65\x63\x6f\x6d\x70\x6f\x73\x65\x2c\x75\x6d\x61\x73\x6b\x3d\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x34\x30\x2c\x74\x79\x70\x65\x3d\xa7\x86\x88\x28\x2c\x75\x6d\x61\x73\x6b\x3d\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x31\x30\x30\x30\x30\x31\x2c\x6e\x6c\x73\x3d\x63\x70\x38\x36\x36\x2c\x75\x6d\x61\x73\x6b\x3d\x30\x30\x30\x30"... [pid 5855] <... mkdir resumed>) = 0 [pid 5855] mount("/dev/loop0", "./file2", "hfsplus", MS_NOEXEC|MS_SYNCHRONOUS|MS_REC|MS_POSIXACL, "\x64\x65\x63\x6f\x6d\x70\x6f\x73\x65\x2c\x75\x6d\x61\x73\x6b\x3d\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x34\x30\x2c\x74\x79\x70\x65\x3d\xa7\x86\x88\x28\x2c\x75\x6d\x61\x73\x6b\x3d\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x31\x30\x30\x30\x30\x31\x2c\x6e\x6c\x73\x3d\x63\x70\x38\x36\x36\x2c\x75\x6d\x61\x73\x6b\x3d\x30\x30\x30\x30"... [pid 5856] <... mount resumed>) = 0 [pid 5853] <... mount resumed>) = 0 [pid 5857] <... ioctl resumed>) = 0 [pid 5857] close(3 [pid 5856] openat(AT_FDCWD, "./file2", O_RDONLY|O_DIRECTORY [pid 5855] <... mount resumed>) = 0 [pid 5857] <... close resumed>) = 0 [pid 5856] <... openat resumed>) = 3 [ 57.555254][ T5853] loop2: detected capacity change from 0 to 1024 [ 57.572682][ T5856] loop1: detected capacity change from 0 to 1024 [ 57.579940][ T5855] loop0: detected capacity change from 0 to 1024 [ 57.581701][ T5854] loop3: detected capacity change from 0 to 1024 [ 57.595375][ T5857] loop4: detected capacity change from 0 to 1024 [pid 5855] openat(AT_FDCWD, "./file2", O_RDONLY|O_DIRECTORY [pid 5853] openat(AT_FDCWD, "./file2", O_RDONLY|O_DIRECTORY [pid 5857] close(4 [pid 5856] chdir("./file2" [pid 5855] <... openat resumed>) = 3 [pid 5854] <... ioctl resumed>) = 0 [pid 5853] <... openat resumed>) = 3 [pid 5856] <... chdir resumed>) = 0 [pid 5856] openat(AT_FDCWD, "/dev/loop1", O_RDWR [pid 5855] chdir("./file2" [pid 5853] chdir("./file2" [pid 5856] <... openat resumed>) = -1 EBUSY (Device or resource busy) [pid 5855] <... chdir resumed>) = 0 [pid 5854] close(3 [pid 5853] <... chdir resumed>) = 0 [pid 5856] openat(AT_FDCWD, "/dev/loop0", O_RDONLY [pid 5855] openat(AT_FDCWD, "/dev/loop0", O_RDWR [pid 5854] <... close resumed>) = 0 [pid 5853] openat(AT_FDCWD, "/dev/loop2", O_RDWR [pid 5856] <... openat resumed>) = 4 [pid 5855] <... openat resumed>) = -1 EBUSY (Device or resource busy) [pid 5854] close(4 [pid 5853] <... openat resumed>) = -1 EBUSY (Device or resource busy) [pid 5856] openat(AT_FDCWD, "cgroup.stat", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000 [pid 5855] openat(AT_FDCWD, "/dev/loop0", O_RDONLY [pid 5854] <... close resumed>) = 0 [pid 5853] openat(AT_FDCWD, "/dev/loop0", O_RDONLY [pid 5857] <... close resumed>) = 0 [pid 5857] mkdir("./file2", 0777 [pid 5855] <... openat resumed>) = 4 [pid 5854] mkdir("./file2", 0777 [pid 5853] <... openat resumed>) = 4 [pid 5853] openat(AT_FDCWD, "cgroup.stat", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000 [pid 5857] <... mkdir resumed>) = 0 [pid 5854] <... mkdir resumed>) = 0 [pid 5855] openat(AT_FDCWD, "cgroup.stat", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000 [pid 5854] mount("/dev/loop3", "./file2", "hfsplus", MS_NOEXEC|MS_SYNCHRONOUS|MS_REC|MS_POSIXACL, "\x64\x65\x63\x6f\x6d\x70\x6f\x73\x65\x2c\x75\x6d\x61\x73\x6b\x3d\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x34\x30\x2c\x74\x79\x70\x65\x3d\xa7\x86\x88\x28\x2c\x75\x6d\x61\x73\x6b\x3d\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x31\x30\x30\x30\x30\x31\x2c\x6e\x6c\x73\x3d\x63\x70\x38\x36\x36\x2c\x75\x6d\x61\x73\x6b\x3d\x30\x30\x30\x30"... [pid 5857] mount("/dev/loop4", "./file2", "hfsplus", MS_NOEXEC|MS_SYNCHRONOUS|MS_REC|MS_POSIXACL, "\x64\x65\x63\x6f\x6d\x70\x6f\x73\x65\x2c\x75\x6d\x61\x73\x6b\x3d\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x34\x30\x2c\x74\x79\x70\x65\x3d\xa7\x86\x88\x28\x2c\x75\x6d\x61\x73\x6b\x3d\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x31\x30\x30\x30\x30\x31\x2c\x6e\x6c\x73\x3d\x63\x70\x38\x36\x36\x2c\x75\x6d\x61\x73\x6b\x3d\x30\x30\x30\x30"... [pid 5855] <... openat resumed>) = 5 [pid 5853] <... openat resumed>) = 5 [pid 5853] ioctl(4, LOOP_CONFIGURE, {fd=5, block_size=0, info={lo_offset=0, lo_number=0, lo_flags=LO_FLAGS_AUTOCLEAR|LO_FLAGS_PARTSCAN|LO_FLAGS_DIRECT_IO, lo_file_name="\xfe\xe8\xa2\xab\x78\xfc\x17\x9f\xd1\xf8\xa0\xe9\x1d\xda\xac\xa7\xbd\x64\xc6\xa4\xb4\xe0\x0d\x96\x83\xdd\xa1\xaf\x1e\xa8\x9d\xe2\xb7\xfb\x0a\x01", ...}}) = -1 EBUSY (Device or resource busy) [pid 5856] <... openat resumed>) = 5 [pid 5855] ioctl(4, LOOP_CONFIGURE, {fd=5, block_size=0, info={lo_offset=0, lo_number=0, lo_flags=LO_FLAGS_AUTOCLEAR|LO_FLAGS_PARTSCAN|LO_FLAGS_DIRECT_IO, lo_file_name="\xfe\xe8\xa2\xab\x78\xfc\x17\x9f\xd1\xf8\xa0\xe9\x1d\xda\xac\xa7\xbd\x64\xc6\xa4\xb4\xe0\x0d\x96\x83\xdd\xa1\xaf\x1e\xa8\x9d\xe2\xb7\xfb\x0a\x01", ...}} [pid 5853] ioctl(4, LOOP_SET_STATUS64, {lo_offset=0x5, lo_number=0, lo_flags=LO_FLAGS_USE_AOPS|LO_FLAGS_PARTSCAN|LO_FLAGS_DIRECT_IO, lo_file_name="\xeb\xbf\x52\x74\x8b\x0b\x2a\xff\x33\x0c\x21\x36\x7b\x06\x62\x4f\xde\x30\x88\x7f\xda\x17\x2e\xe2\x51\xca\x9d\xea\x03\xca\x09\x48\x80\x22\x55\x71\x64\x5c\xc0\x27\xcd\x4c\x7a\x81\x38\x8e\x08\xc0\xa4\xa8\x77\x31\x91\x41\x08\x48\xa8\x94\x10\xf3\x19\xbd\xe2"..., ...} [pid 5855] <... ioctl resumed>) = -1 EBUSY (Device or resource busy) [pid 5856] ioctl(4, LOOP_CONFIGURE, {fd=5, block_size=0, info={lo_offset=0, lo_number=0, lo_flags=LO_FLAGS_AUTOCLEAR|LO_FLAGS_PARTSCAN|LO_FLAGS_DIRECT_IO, lo_file_name="\xfe\xe8\xa2\xab\x78\xfc\x17\x9f\xd1\xf8\xa0\xe9\x1d\xda\xac\xa7\xbd\x64\xc6\xa4\xb4\xe0\x0d\x96\x83\xdd\xa1\xaf\x1e\xa8\x9d\xe2\xb7\xfb\x0a\x01", ...}} [pid 5855] ioctl(4, LOOP_SET_STATUS64, {lo_offset=0x5, lo_number=0, lo_flags=LO_FLAGS_USE_AOPS|LO_FLAGS_PARTSCAN|LO_FLAGS_DIRECT_IO, lo_file_name="\xeb\xbf\x52\x74\x8b\x0b\x2a\xff\x33\x0c\x21\x36\x7b\x06\x62\x4f\xde\x30\x88\x7f\xda\x17\x2e\xe2\x51\xca\x9d\xea\x03\xca\x09\x48\x80\x22\x55\x71\x64\x5c\xc0\x27\xcd\x4c\x7a\x81\x38\x8e\x08\xc0\xa4\xa8\x77\x31\x91\x41\x08\x48\xa8\x94\x10\xf3\x19\xbd\xe2"..., ...} [pid 5856] <... ioctl resumed>) = -1 EBUSY (Device or resource busy) [pid 5856] ioctl(4, LOOP_SET_STATUS64, {lo_offset=0x5, lo_number=0, lo_flags=LO_FLAGS_USE_AOPS|LO_FLAGS_PARTSCAN|LO_FLAGS_DIRECT_IO, lo_file_name="\xeb\xbf\x52\x74\x8b\x0b\x2a\xff\x33\x0c\x21\x36\x7b\x06\x62\x4f\xde\x30\x88\x7f\xda\x17\x2e\xe2\x51\xca\x9d\xea\x03\xca\x09\x48\x80\x22\x55\x71\x64\x5c\xc0\x27\xcd\x4c\x7a\x81\x38\x8e\x08\xc0\xa4\xa8\x77\x31\x91\x41\x08\x48\xa8\x94\x10\xf3\x19\xbd\xe2"..., ...} [pid 5857] <... mount resumed>) = 0 [pid 5854] <... mount resumed>) = 0 [pid 5854] openat(AT_FDCWD, "./file2", O_RDONLY|O_DIRECTORY [pid 5857] openat(AT_FDCWD, "./file2", O_RDONLY|O_DIRECTORY) = 3 [pid 5857] chdir("./file2") = 0 [pid 5857] openat(AT_FDCWD, "/dev/loop4", O_RDWR) = -1 EBUSY (Device or resource busy) [pid 5857] openat(AT_FDCWD, "/dev/loop0", O_RDONLY [pid 5854] <... openat resumed>) = 3 [pid 5854] chdir("./file2") = 0 [pid 5854] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = -1 EBUSY (Device or resource busy) [pid 5854] openat(AT_FDCWD, "/dev/loop0", O_RDONLY [pid 5855] <... ioctl resumed>) = 0 [ 57.674573][ T5853] loop0: detected capacity change from 1024 to 3 [pid 5855] ftruncate(-1, 4402345721857) = -1 EBADF (Bad file descriptor) [pid 5855] exit_group(0) = ? [pid 5857] <... openat resumed>) = 4 [pid 5857] openat(AT_FDCWD, "cgroup.stat", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000 [pid 5856] <... ioctl resumed>) = 0 [pid 5857] <... openat resumed>) = 5 [pid 5857] ioctl(4, LOOP_CONFIGURE, {fd=5, block_size=0, info={lo_offset=0, lo_number=0, lo_flags=LO_FLAGS_AUTOCLEAR|LO_FLAGS_PARTSCAN|LO_FLAGS_DIRECT_IO, lo_file_name="\xfe\xe8\xa2\xab\x78\xfc\x17\x9f\xd1\xf8\xa0\xe9\x1d\xda\xac\xa7\xbd\x64\xc6\xa4\xb4\xe0\x0d\x96\x83\xdd\xa1\xaf\x1e\xa8\x9d\xe2\xb7\xfb\x0a\x01", ...}}) = -1 EBUSY (Device or resource busy) [pid 5857] ioctl(4, LOOP_SET_STATUS64, {lo_offset=0x5, lo_number=0, lo_flags=LO_FLAGS_USE_AOPS|LO_FLAGS_PARTSCAN|LO_FLAGS_DIRECT_IO, lo_file_name="\xeb\xbf\x52\x74\x8b\x0b\x2a\xff\x33\x0c\x21\x36\x7b\x06\x62\x4f\xde\x30\x88\x7f\xda\x17\x2e\xe2\x51\xca\x9d\xea\x03\xca\x09\x48\x80\x22\x55\x71\x64\x5c\xc0\x27\xcd\x4c\x7a\x81\x38\x8e\x08\xc0\xa4\xa8\x77\x31\x91\x41\x08\x48\xa8\x94\x10\xf3\x19\xbd\xe2"..., ...} [pid 5856] ftruncate(-1, 4402345721857) = -1 EBADF (Bad file descriptor) [pid 5856] exit_group(0) = ? [pid 5853] <... ioctl resumed>) = 0 [pid 5853] ftruncate(-1, 4402345721857) = -1 EBADF (Bad file descriptor) [pid 5853] exit_group(0 [pid 5857] <... ioctl resumed>) = 0 [pid 5857] ftruncate(-1, 4402345721857 [pid 5856] +++ exited with 0 +++ [pid 5855] +++ exited with 0 +++ [pid 5854] <... openat resumed>) = 4 [pid 5853] <... exit_group resumed>) = ? [pid 5857] <... ftruncate resumed>) = -1 EBADF (Bad file descriptor) [pid 5854] openat(AT_FDCWD, "cgroup.stat", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000 [pid 5857] exit_group(0) = ? [pid 5857] +++ exited with 0 +++ [pid 5853] +++ exited with 0 +++ [pid 5852] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5857, si_uid=0, si_status=0, si_utime=0, si_stime=1 /* 0.01 s */} --- [pid 5852] restart_syscall(<... resuming interrupted clone ...> [pid 5850] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5853, si_uid=0, si_status=0, si_utime=0, si_stime=3 /* 0.03 s */} --- [pid 5849] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5856, si_uid=0, si_status=0, si_utime=0, si_stime=5 /* 0.05 s */} --- [pid 5848] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5855, si_uid=0, si_status=0, si_utime=0, si_stime=1 /* 0.01 s */} --- [pid 5850] restart_syscall(<... resuming interrupted clone ...> [pid 5849] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5854] <... openat resumed>) = 5 [pid 5848] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5854] ioctl(4, LOOP_CONFIGURE, {fd=5, block_size=0, info={lo_offset=0, lo_number=0, lo_flags=LO_FLAGS_AUTOCLEAR|LO_FLAGS_PARTSCAN|LO_FLAGS_DIRECT_IO, lo_file_name="\xfe\xe8\xa2\xab\x78\xfc\x17\x9f\xd1\xf8\xa0\xe9\x1d\xda\xac\xa7\xbd\x64\xc6\xa4\xb4\xe0\x0d\x96\x83\xdd\xa1\xaf\x1e\xa8\x9d\xe2\xb7\xfb\x0a\x01", ...}} [pid 5849] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5848] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5849] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5848] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5854] <... ioctl resumed>) = -1 EBUSY (Device or resource busy) [pid 5854] ioctl(4, LOOP_SET_STATUS64, {lo_offset=0x5, lo_number=0, lo_flags=LO_FLAGS_USE_AOPS|LO_FLAGS_PARTSCAN|LO_FLAGS_DIRECT_IO, lo_file_name="\xeb\xbf\x52\x74\x8b\x0b\x2a\xff\x33\x0c\x21\x36\x7b\x06\x62\x4f\xde\x30\x88\x7f\xda\x17\x2e\xe2\x51\xca\x9d\xea\x03\xca\x09\x48\x80\x22\x55\x71\x64\x5c\xc0\x27\xcd\x4c\x7a\x81\x38\x8e\x08\xc0\xa4\xa8\x77\x31\x91\x41\x08\x48\xa8\x94\x10\xf3\x19\xbd\xe2"..., ...} [pid 5849] <... openat resumed>) = 3 [pid 5848] <... openat resumed>) = 3 [pid 5849] newfstatat(3, "", [pid 5852] <... restart_syscall resumed>) = 0 [pid 5850] <... restart_syscall resumed>) = 0 [pid 5848] newfstatat(3, "", [pid 5849] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5848] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5849] getdents64(3, [pid 5852] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5848] getdents64(3, [pid 5852] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5852] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [ 57.775670][ T5853] Dev loop0: unable to read RDB block 3 [ 57.784678][ T5853] loop0: unable to read partition table [ 57.790471][ T5853] loop0: partition table beyond EOD, truncated [ 57.797013][ T5853] loop_reread_partitions: partition scan of loop0 (�Rt�*�3!6{bO�0��.�Qʝ�� H�"Uqd\�'�Lz�8��w1�AH��) failed (rc=-5) [pid 5852] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5850] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5852] getdents64(3, [pid 5849] <... getdents64 resumed>0x555589fa86f0 /* 4 entries */, 32768) = 112 [pid 5848] <... getdents64 resumed>0x555589fa86f0 /* 4 entries */, 32768) = 112 [pid 5850] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5850] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5849] umount2("./0/file2", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5848] umount2("./0/file2", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5850] <... openat resumed>) = 3 [pid 5852] <... getdents64 resumed>0x555589fa86f0 /* 4 entries */, 32768) = 112 [pid 5850] newfstatat(3, "", [pid 5852] umount2("./0/file2", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5850] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5850] getdents64(3, 0x555589fa86f0 /* 4 entries */, 32768) = 112 [pid 5850] umount2("./0/file2", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5849] <... umount2 resumed>) = 0 [pid 5854] <... ioctl resumed>) = 0 [pid 5852] <... umount2 resumed>) = 0 [pid 5850] <... umount2 resumed>) = 0 [pid 5849] umount2("./0/file2", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5854] ftruncate(-1, 4402345721857) = -1 EBADF (Bad file descriptor) [pid 5852] umount2("./0/file2", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5854] exit_group(0 [pid 5852] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5852] newfstatat(AT_FDCWD, "./0/file2", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5848] <... umount2 resumed>) = 0 [pid 5854] <... exit_group resumed>) = ? [pid 5848] umount2("./0/file2", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5852] umount2("./0/file2", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5852] openat(AT_FDCWD, "./0/file2", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4 [pid 5852] newfstatat(4, "", [pid 5854] +++ exited with 0 +++ [pid 5850] umount2("./0/file2", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5849] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5848] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5852] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5851] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5854, si_uid=0, si_status=0, si_utime=0, si_stime=3 /* 0.03 s */} --- [pid 5850] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5849] newfstatat(AT_FDCWD, "./0/file2", [pid 5848] newfstatat(AT_FDCWD, "./0/file2", [pid 5851] restart_syscall(<... resuming interrupted clone ...> [pid 5850] newfstatat(AT_FDCWD, "./0/file2", [pid 5849] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5848] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5852] getdents64(4, [pid 5850] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5849] umount2("./0/file2", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5848] umount2("./0/file2", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5852] <... getdents64 resumed>0x555589fb0730 /* 2 entries */, 32768) = 48 [pid 5850] umount2("./0/file2", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5849] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5848] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5852] getdents64(4, [pid 5850] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5849] openat(AT_FDCWD, "./0/file2", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5848] openat(AT_FDCWD, "./0/file2", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5852] <... getdents64 resumed>0x555589fb0730 /* 0 entries */, 32768) = 0 [pid 5850] openat(AT_FDCWD, "./0/file2", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5849] <... openat resumed>) = 4 [pid 5848] <... openat resumed>) = 4 [pid 5852] close(4 [pid 5850] <... openat resumed>) = 4 [pid 5849] newfstatat(4, "", [pid 5848] newfstatat(4, "", [pid 5852] <... close resumed>) = 0 [pid 5850] newfstatat(4, "", [pid 5849] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5848] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5852] rmdir("./0/file2" [pid 5850] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5849] getdents64(4, [pid 5848] getdents64(4, [pid 5850] getdents64(4, [pid 5849] <... getdents64 resumed>0x555589fb0730 /* 2 entries */, 32768) = 48 [pid 5848] <... getdents64 resumed>0x555589fb0730 /* 2 entries */, 32768) = 48 [pid 5850] <... getdents64 resumed>0x555589fb0730 /* 2 entries */, 32768) = 48 [pid 5849] getdents64(4, [pid 5848] getdents64(4, [pid 5850] getdents64(4, [pid 5849] <... getdents64 resumed>0x555589fb0730 /* 0 entries */, 32768) = 0 [pid 5848] <... getdents64 resumed>0x555589fb0730 /* 0 entries */, 32768) = 0 [pid 5850] <... getdents64 resumed>0x555589fb0730 /* 0 entries */, 32768) = 0 [pid 5849] close(4 [pid 5848] close(4 [pid 5850] close(4 [pid 5849] <... close resumed>) = 0 [pid 5848] <... close resumed>) = 0 [pid 5850] <... close resumed>) = 0 [pid 5848] rmdir("./0/file2" [pid 5852] <... rmdir resumed>) = 0 [pid 5851] <... restart_syscall resumed>) = 0 [pid 5850] rmdir("./0/file2" [pid 5849] rmdir("./0/file2" [pid 5852] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5850] <... rmdir resumed>) = 0 [pid 5848] <... rmdir resumed>) = 0 [pid 5852] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5849] <... rmdir resumed>) = 0 [pid 5848] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5852] newfstatat(AT_FDCWD, "./0/binderfs", [pid 5851] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5850] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5851] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5850] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5851] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5850] newfstatat(AT_FDCWD, "./0/binderfs", [pid 5851] <... openat resumed>) = 3 [pid 5850] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5851] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5850] unlink("./0/binderfs" [pid 5852] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5851] getdents64(3, [pid 5850] <... unlink resumed>) = 0 [pid 5849] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5848] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5852] unlink("./0/binderfs" [pid 5851] <... getdents64 resumed>0x555589fa86f0 /* 4 entries */, 32768) = 112 [pid 5849] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5851] umount2("./0/file2", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5848] newfstatat(AT_FDCWD, "./0/binderfs", [pid 5852] <... unlink resumed>) = 0 [pid 5850] getdents64(3, [pid 5849] newfstatat(AT_FDCWD, "./0/binderfs", [pid 5852] getdents64(3, [pid 5850] <... getdents64 resumed>0x555589fa86f0 /* 0 entries */, 32768) = 0 [pid 5848] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5852] <... getdents64 resumed>0x555589fa86f0 /* 0 entries */, 32768) = 0 [pid 5850] close(3 [pid 5849] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5852] close(3 [pid 5849] unlink("./0/binderfs" [pid 5848] unlink("./0/binderfs" [pid 5852] <... close resumed>) = 0 [pid 5852] rmdir("./0" [pid 5851] <... umount2 resumed>) = 0 [pid 5850] <... close resumed>) = 0 [pid 5849] <... unlink resumed>) = 0 [pid 5848] <... unlink resumed>) = 0 [pid 5848] getdents64(3, 0x555589fa86f0 /* 0 entries */, 32768) = 0 [pid 5850] rmdir("./0" [pid 5848] close(3 [pid 5852] <... rmdir resumed>) = 0 [pid 5848] <... close resumed>) = 0 [pid 5849] getdents64(3, [pid 5848] rmdir("./0" [pid 5852] mkdir("./1", 0777 [pid 5850] <... rmdir resumed>) = 0 [pid 5849] <... getdents64 resumed>0x555589fa86f0 /* 0 entries */, 32768) = 0 [pid 5848] <... rmdir resumed>) = 0 [pid 5849] close(3 [pid 5851] umount2("./0/file2", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5850] mkdir("./1", 0777 [pid 5848] mkdir("./1", 0777 [pid 5851] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5850] <... mkdir resumed>) = 0 [pid 5852] <... mkdir resumed>) = 0 [pid 5851] newfstatat(AT_FDCWD, "./0/file2", [pid 5849] <... close resumed>) = 0 [pid 5848] <... mkdir resumed>) = 0 [pid 5851] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5851] umount2("./0/file2", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5850] openat(AT_FDCWD, "/dev/loop2", O_RDWR [pid 5852] openat(AT_FDCWD, "/dev/loop4", O_RDWR [pid 5851] openat(AT_FDCWD, "./0/file2", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5850] <... openat resumed>) = 3 [pid 5849] rmdir("./0" [pid 5848] openat(AT_FDCWD, "/dev/loop0", O_RDWR [pid 5852] <... openat resumed>) = 3 [pid 5851] <... openat resumed>) = 4 [pid 5852] ioctl(3, LOOP_CLR_FD [pid 5851] newfstatat(4, "", [pid 5850] ioctl(3, LOOP_CLR_FD [pid 5848] <... openat resumed>) = 3 [pid 5852] <... ioctl resumed>) = 0 [pid 5851] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5850] <... ioctl resumed>) = 0 [pid 5852] close(3 [pid 5851] getdents64(4, [pid 5850] close(3 [pid 5848] ioctl(3, LOOP_CLR_FD [pid 5852] <... close resumed>) = 0 [pid 5851] <... getdents64 resumed>0x555589fb0730 /* 2 entries */, 32768) = 48 [pid 5850] <... close resumed>) = 0 [pid 5849] <... rmdir resumed>) = 0 [pid 5848] <... ioctl resumed>) = 0 [pid 5851] getdents64(4, 0x555589fb0730 /* 0 entries */, 32768) = 0 [pid 5851] close(4) = 0 [pid 5851] rmdir("./0/file2") = 0 [pid 5849] mkdir("./1", 0777 [ 57.870913][ T12] kworker/u8:1: attempt to access beyond end of device [ 57.870913][ T12] loop0: rw=1, sector=206, nr_sectors = 8 limit=3 [ 57.886732][ T12] kworker/u8:1: attempt to access beyond end of device [ 57.886732][ T12] loop0: rw=2049, sector=198, nr_sectors = 16 limit=3 [pid 5848] close(3 [pid 5851] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5852] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5850] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5849] <... mkdir resumed>) = 0 [pid 5848] <... close resumed>) = 0 [pid 5851] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5851] newfstatat(AT_FDCWD, "./0/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5851] unlink("./0/binderfs") = 0 [pid 5849] openat(AT_FDCWD, "/dev/loop1", O_RDWR) = 3 [pid 5849] ioctl(3, LOOP_CLR_FD./strace-static-x86_64: Process 5862 attached ) = 0 [pid 5848] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5863 attached [pid 5862] set_robust_list(0x555589fa7660, 24 [pid 5851] getdents64(3, [pid 5849] close(3 [pid 5851] <... getdents64 resumed>0x555589fa86f0 /* 0 entries */, 32768) = 0 [pid 5851] close(3) = 0 [pid 5852] <... clone resumed>, child_tidptr=0x555589fa7650) = 5862 [pid 5851] rmdir("./0") = 0 [pid 5850] <... clone resumed>, child_tidptr=0x555589fa7650) = 5863 [pid 5848] <... clone resumed>, child_tidptr=0x555589fa7650) = 5864 [pid 5851] mkdir("./1", 0777) = 0 [pid 5849] <... close resumed>) = 0 ./strace-static-x86_64: Process 5864 attached [pid 5863] set_robust_list(0x555589fa7660, 24 [pid 5862] <... set_robust_list resumed>) = 0 [pid 5851] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = 3 [pid 5851] ioctl(3, LOOP_CLR_FD) = 0 [pid 5851] close(3 [pid 5862] chdir("./1" [pid 5864] set_robust_list(0x555589fa7660, 24 [pid 5863] <... set_robust_list resumed>) = 0 [pid 5862] <... chdir resumed>) = 0 [pid 5851] <... close resumed>) = 0 [pid 5849] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLDexecuting program [pid 5851] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5865 attached [pid 5864] <... set_robust_list resumed>) = 0 [pid 5863] chdir("./1" [pid 5862] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5865] set_robust_list(0x555589fa7660, 24) = 0 [pid 5865] chdir("./1") = 0 [pid 5865] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5865] setpgid(0, 0) = 0 [pid 5865] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5851] <... clone resumed>, child_tidptr=0x555589fa7650) = 5866 [pid 5865] <... openat resumed>) = 3 [pid 5865] write(3, "1000", 4) = 4 [pid 5865] close(3) = 0 [pid 5865] symlink("/dev/binderfs", "./binderfs") = 0 [pid 5865] write(1, "executing program\n", 18) = 18 [pid 5865] memfd_create("syzkaller", 0) = 3 [pid 5865] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7fbbbf400000 ./strace-static-x86_64: Process 5866 attached [pid 5864] chdir("./1" [pid 5863] <... chdir resumed>) = 0 [pid 5862] <... prctl resumed>) = 0 [pid 5849] <... clone resumed>, child_tidptr=0x555589fa7650) = 5865 [pid 5866] set_robust_list(0x555589fa7660, 24 [pid 5865] 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"..., 524288 [pid 5864] <... chdir resumed>) = 0 [pid 5863] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5862] setpgid(0, 0 [pid 5866] <... set_robust_list resumed>) = 0 [pid 5863] <... prctl resumed>) = 0 [pid 5862] <... setpgid resumed>) = 0 [pid 5866] chdir("./1" [pid 5862] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5863] setpgid(0, 0 [pid 5862] <... openat resumed>) = 3 [pid 5863] <... setpgid resumed>) = 0 [pid 5866] <... chdir resumed>) = 0 [pid 5864] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5862] write(3, "1000", 4 [pid 5866] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5863] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5864] <... prctl resumed>) = 0 [pid 5862] <... write resumed>) = 4 [pid 5866] setpgid(0, 0) = 0 [pid 5865] <... write resumed>) = 524288 [pid 5864] setpgid(0, 0 [pid 5863] <... openat resumed>) = 3 [pid 5862] close(3 [pid 5866] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5864] <... setpgid resumed>) = 0 [pid 5862] <... close resumed>) = 0 executing program [pid 5862] symlink("/dev/binderfs", "./binderfs" [pid 5864] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5862] <... symlink resumed>) = 0 [pid 5864] <... openat resumed>) = 3 [pid 5862] write(1, "executing program\n", 18) = 18 [pid 5866] <... openat resumed>) = 3 [pid 5864] write(3, "1000", 4 [pid 5862] memfd_create("syzkaller", 0 [pid 5866] write(3, "1000", 4 [pid 5864] <... write resumed>) = 4 [pid 5862] <... memfd_create resumed>) = 3 [pid 5866] <... write resumed>) = 4 [pid 5864] close(3 [pid 5863] write(3, "1000", 4 [pid 5866] close(3 [pid 5862] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5866] <... close resumed>) = 0 [pid 5864] <... close resumed>) = 0 [pid 5863] <... write resumed>) = 4 [pid 5864] symlink("/dev/binderfs", "./binderfs" [pid 5862] <... mmap resumed>) = 0x7fbbbf400000 [pid 5866] symlink("/dev/binderfs", "./binderfs" [pid 5863] close(3 [pid 5865] munmap(0x7fbbbf400000, 138412032 [pid 5864] <... symlink resumed>) = 0 [pid 5863] <... close resumed>) = 0 [pid 5866] <... symlink resumed>) = 0 [pid 5865] <... munmap resumed>) = 0 [pid 5863] symlink("/dev/binderfs", "./binderfs"executing program executing program [pid 5866] write(1, "executing program\n", 18 [pid 5865] openat(AT_FDCWD, "/dev/loop1", O_RDWR [pid 5863] <... symlink resumed>) = 0 [pid 5865] <... openat resumed>) = 4 [pid 5863] write(1, "executing program\n", 18 [pid 5866] <... write resumed>) = 18 [pid 5865] ioctl(4, LOOP_SET_FD, 3 [pid 5863] <... write resumed>) = 18 [pid 5866] memfd_create("syzkaller", 0 [pid 5864] write(1, "executing program\n", 18 [pid 5863] memfd_create("syzkaller", 0executing program [pid 5866] <... memfd_create resumed>) = 3 [pid 5864] <... write resumed>) = 18 [pid 5863] <... memfd_create resumed>) = 3 [pid 5862] 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"..., 524288 [pid 5866] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5863] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5866] <... mmap resumed>) = 0x7fbbbf400000 [pid 5863] <... mmap resumed>) = 0x7fbbbf400000 [pid 5865] <... ioctl resumed>) = 0 [pid 5864] memfd_create("syzkaller", 0 [pid 5862] <... write resumed>) = 524288 [pid 5865] close(3 [pid 5864] <... memfd_create resumed>) = 3 [pid 5865] <... close resumed>) = 0 [pid 5864] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5865] close(4 [pid 5864] <... mmap resumed>) = 0x7fbbbf400000 [pid 5865] <... close resumed>) = 0 [pid 5864] 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"..., 524288 [pid 5865] mkdir("./file2", 0777) = 0 [pid 5865] mount("/dev/loop1", "./file2", "hfsplus", MS_NOEXEC|MS_SYNCHRONOUS|MS_REC|MS_POSIXACL, "\x64\x65\x63\x6f\x6d\x70\x6f\x73\x65\x2c\x75\x6d\x61\x73\x6b\x3d\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x34\x30\x2c\x74\x79\x70\x65\x3d\xa7\x86\x88\x28\x2c\x75\x6d\x61\x73\x6b\x3d\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x31\x30\x30\x30\x30\x31\x2c\x6e\x6c\x73\x3d\x63\x70\x38\x36\x36\x2c\x75\x6d\x61\x73\x6b\x3d\x30\x30\x30\x30"... [pid 5866] 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"..., 524288 [pid 5865] <... mount resumed>) = 0 [pid 5864] <... write resumed>) = 524288 [pid 5863] 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"..., 524288 [pid 5862] munmap(0x7fbbbf400000, 138412032 [pid 5865] openat(AT_FDCWD, "./file2", O_RDONLY|O_DIRECTORY) = 3 [pid 5864] munmap(0x7fbbbf400000, 138412032 [pid 5863] <... write resumed>) = 524288 [pid 5862] <... munmap resumed>) = 0 [pid 5865] chdir("./file2") = 0 [pid 5865] openat(AT_FDCWD, "/dev/loop1", O_RDWR) = -1 EBUSY (Device or resource busy) [pid 5865] openat(AT_FDCWD, "/dev/loop0", O_RDONLY) = 4 [ 58.064495][ T5865] loop1: detected capacity change from 0 to 1024 [pid 5865] openat(AT_FDCWD, "cgroup.stat", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000 [pid 5862] openat(AT_FDCWD, "/dev/loop4", O_RDWR [pid 5864] <... munmap resumed>) = 0 [pid 5862] <... openat resumed>) = 4 [pid 5863] munmap(0x7fbbbf400000, 138412032 [pid 5866] <... write resumed>) = 524288 [pid 5865] <... openat resumed>) = 5 [pid 5864] openat(AT_FDCWD, "/dev/loop0", O_RDWR [pid 5862] ioctl(4, LOOP_SET_FD, 3 [pid 5864] <... openat resumed>) = 4 [pid 5863] <... munmap resumed>) = 0 [pid 5866] munmap(0x7fbbbf400000, 138412032 [pid 5865] ioctl(4, LOOP_CONFIGURE, {fd=5, block_size=0, info={lo_offset=0, lo_number=0, lo_flags=LO_FLAGS_AUTOCLEAR|LO_FLAGS_PARTSCAN|LO_FLAGS_DIRECT_IO, lo_file_name="\xfe\xe8\xa2\xab\x78\xfc\x17\x9f\xd1\xf8\xa0\xe9\x1d\xda\xac\xa7\xbd\x64\xc6\xa4\xb4\xe0\x0d\x96\x83\xdd\xa1\xaf\x1e\xa8\x9d\xe2\xb7\xfb\x0a\x01", ...}} [pid 5864] ioctl(4, LOOP_SET_FD, 3 [pid 5863] openat(AT_FDCWD, "/dev/loop2", O_RDWR [pid 5862] <... ioctl resumed>) = 0 [pid 5863] <... openat resumed>) = 4 [pid 5865] <... ioctl resumed>) = 0 [pid 5864] <... ioctl resumed>) = -1 EBUSY (Device or resource busy) [pid 5862] close(3 [pid 5866] <... munmap resumed>) = 0 [pid 5865] ioctl(4, LOOP_SET_STATUS64, {lo_offset=0x5, lo_number=0, lo_flags=LO_FLAGS_USE_AOPS|LO_FLAGS_PARTSCAN|LO_FLAGS_DIRECT_IO, lo_file_name="\xeb\xbf\x52\x74\x8b\x0b\x2a\xff\x33\x0c\x21\x36\x7b\x06\x62\x4f\xde\x30\x88\x7f\xda\x17\x2e\xe2\x51\xca\x9d\xea\x03\xca\x09\x48\x80\x22\x55\x71\x64\x5c\xc0\x27\xcd\x4c\x7a\x81\x38\x8e\x08\xc0\xa4\xa8\x77\x31\x91\x41\x08\x48\xa8\x94\x10\xf3\x19\xbd\xe2"..., ...} [pid 5864] ioctl(4, LOOP_CLR_FD [pid 5863] ioctl(4, LOOP_SET_FD, 3 [pid 5862] <... close resumed>) = 0 [pid 5862] close(4) = 0 [pid 5862] mkdir("./file2", 0777) = 0 [pid 5862] mount("/dev/loop4", "./file2", "hfsplus", MS_NOEXEC|MS_SYNCHRONOUS|MS_REC|MS_POSIXACL, "\x64\x65\x63\x6f\x6d\x70\x6f\x73\x65\x2c\x75\x6d\x61\x73\x6b\x3d\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x34\x30\x2c\x74\x79\x70\x65\x3d\xa7\x86\x88\x28\x2c\x75\x6d\x61\x73\x6b\x3d\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x31\x30\x30\x30\x30\x31\x2c\x6e\x6c\x73\x3d\x63\x70\x38\x36\x36\x2c\x75\x6d\x61\x73\x6b\x3d\x30\x30\x30\x30"... [pid 5866] openat(AT_FDCWD, "/dev/loop3", O_RDWR [pid 5863] <... ioctl resumed>) = 0 [pid 5863] close(3) = 0 [pid 5866] <... openat resumed>) = 4 [pid 5863] close(4 [pid 5866] ioctl(4, LOOP_SET_FD, 3 [pid 5862] <... mount resumed>) = 0 [pid 5863] <... close resumed>) = 0 [pid 5863] mkdir("./file2", 0777) = 0 [pid 5863] mount("/dev/loop2", "./file2", "hfsplus", MS_NOEXEC|MS_SYNCHRONOUS|MS_REC|MS_POSIXACL, "\x64\x65\x63\x6f\x6d\x70\x6f\x73\x65\x2c\x75\x6d\x61\x73\x6b\x3d\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x34\x30\x2c\x74\x79\x70\x65\x3d\xa7\x86\x88\x28\x2c\x75\x6d\x61\x73\x6b\x3d\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x31\x30\x30\x30\x30\x31\x2c\x6e\x6c\x73\x3d\x63\x70\x38\x36\x36\x2c\x75\x6d\x61\x73\x6b\x3d\x30\x30\x30\x30"... [pid 5866] <... ioctl resumed>) = 0 [pid 5862] openat(AT_FDCWD, "./file2", O_RDONLY|O_DIRECTORY [pid 5866] close(3 [pid 5862] <... openat resumed>) = 3 [pid 5866] <... close resumed>) = 0 [pid 5862] chdir("./file2" [pid 5866] close(4 [pid 5862] <... chdir resumed>) = 0 [pid 5866] <... close resumed>) = 0 [pid 5863] <... mount resumed>) = 0 [pid 5862] openat(AT_FDCWD, "/dev/loop4", O_RDWR [pid 5863] openat(AT_FDCWD, "./file2", O_RDONLY|O_DIRECTORY [pid 5862] <... openat resumed>) = -1 EBUSY (Device or resource busy) [ 58.136760][ T5862] loop4: detected capacity change from 0 to 1024 [ 58.150000][ T5863] loop2: detected capacity change from 0 to 1024 [ 58.172548][ T5866] loop3: detected capacity change from 0 to 1024 [pid 5866] mkdir("./file2", 0777 [pid 5863] <... openat resumed>) = 3 [pid 5862] openat(AT_FDCWD, "/dev/loop0", O_RDONLY [pid 5863] chdir("./file2") = 0 [pid 5863] openat(AT_FDCWD, "/dev/loop2", O_RDWR) = -1 EBUSY (Device or resource busy) [pid 5863] openat(AT_FDCWD, "/dev/loop0", O_RDONLY [pid 5866] <... mkdir resumed>) = 0 [pid 5866] mount("/dev/loop3", "./file2", "hfsplus", MS_NOEXEC|MS_SYNCHRONOUS|MS_REC|MS_POSIXACL, "\x64\x65\x63\x6f\x6d\x70\x6f\x73\x65\x2c\x75\x6d\x61\x73\x6b\x3d\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x34\x30\x2c\x74\x79\x70\x65\x3d\xa7\x86\x88\x28\x2c\x75\x6d\x61\x73\x6b\x3d\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x30\x31\x30\x30\x30\x30\x31\x2c\x6e\x6c\x73\x3d\x63\x70\x38\x36\x36\x2c\x75\x6d\x61\x73\x6b\x3d\x30\x30\x30\x30"...) = 0 [pid 5866] openat(AT_FDCWD, "./file2", O_RDONLY|O_DIRECTORY) = 3 [ 58.199911][ T5865] [ 58.202267][ T5865] ====================================================== [ 58.209313][ T5865] WARNING: possible circular locking dependency detected [ 58.216362][ T5865] 6.12.0-rc5-next-20241101-syzkaller #0 Not tainted [ 58.222961][ T5865] ------------------------------------------------------ [ 58.229983][ T5865] syz-executor253/5865 is trying to acquire lock: [ 58.236393][ T5865] ffff88805996a0b0 (&tree->tree_lock){+.+.}-{4:4}, at: hfsplus_find_init+0x14a/0x1c0 [ 58.245889][ T5865] [pid 5866] chdir("./file2") = 0 [pid 5866] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = -1 EBUSY (Device or resource busy) [ 58.245889][ T5865] but task is already holding lock: [ 58.253247][ T5865] ffff88807dec5ab8 (&sb->s_type->i_mutex_key#15){+.+.}-{4:4}, at: hfsplus_file_fsync+0xe8/0x4d0 [ 58.263712][ T5865] [ 58.263712][ T5865] which lock already depends on the new lock. [ 58.263712][ T5865] [ 58.274101][ T5865] [ 58.274101][ T5865] the existing dependency chain (in reverse order) is: [ 58.283108][ T5865] [ 58.283108][ T5865] -> #2 (&sb->s_type->i_mutex_key#15){+.+.}-{4:4}: [ 58.291800][ T5865] lock_acquire+0x1ed/0x550 [ 58.296812][ T5865] down_write+0x99/0x220 [ 58.301563][ T5865] hfsplus_file_fsync+0xe8/0x4d0 [ 58.307006][ T5865] __loop_update_dio+0x1a4/0x500 [ 58.312456][ T5865] loop_set_status+0x62b/0x8f0 [ 58.317730][ T5865] lo_ioctl+0xcbc/0x1f50 [ 58.322484][ T5865] blkdev_ioctl+0x57d/0x6a0 [ 58.327505][ T5865] __se_sys_ioctl+0xf9/0x170 [ 58.332600][ T5865] do_syscall_64+0xf3/0x230 [ 58.337610][ T5865] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 58.344012][ T5865] [ 58.344012][ T5865] -> #1 (&q->q_usage_counter(io)#17){++++}-{0:0}: [ 58.352597][ T5865] lock_acquire+0x1ed/0x550 [ 58.357606][ T5865] blk_mq_submit_bio+0x1510/0x2490 [ 58.363221][ T5865] __submit_bio+0x2c2/0x560 [ 58.368230][ T5865] submit_bio_noacct_nocheck+0x4d3/0xe30 [ 58.374364][ T5865] block_read_full_folio+0x93b/0xcd0 [ 58.380155][ T5865] filemap_read_folio+0x14b/0x630 [ 58.385685][ T5865] do_read_cache_folio+0x3f5/0x850 [ 58.391302][ T5865] do_read_cache_page+0x30/0x200 [ 58.396764][ T5865] __hfs_bnode_create+0x487/0x770 [ 58.402297][ T5865] hfsplus_bnode_find+0x237/0x10c0 [ 58.408091][ T5865] hfsplus_brec_find+0x183/0x570 [ 58.413533][ T5865] hfsplus_brec_read+0x2b/0x110 [ 58.418886][ T5865] hfsplus_find_cat+0x17f/0x5d0 [ 58.424244][ T5865] hfsplus_iget+0x483/0x680 [ 58.429260][ T5865] hfsplus_fill_super+0xc4d/0x1be0 [ 58.434876][ T5865] get_tree_bdev_flags+0x48c/0x5c0 [ 58.440501][ T5865] vfs_get_tree+0x90/0x2b0 [ 58.445422][ T5865] do_new_mount+0x2be/0xb40 [ 58.450432][ T5865] __se_sys_mount+0x2d6/0x3c0 [ 58.455614][ T5865] do_syscall_64+0xf3/0x230 [ 58.460623][ T5865] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 58.467031][ T5865] [ 58.467031][ T5865] -> #0 (&tree->tree_lock){+.+.}-{4:4}: [ 58.474743][ T5865] validate_chain+0x18ef/0x5920 [ 58.480103][ T5865] __lock_acquire+0x1397/0x2100 [ 58.485482][ T5865] lock_acquire+0x1ed/0x550 [ 58.490487][ T5865] __mutex_lock+0x1ac/0xee0 [ 58.495513][ T5865] hfsplus_find_init+0x14a/0x1c0 [ 58.500959][ T5865] hfsplus_cat_write_inode+0x1df/0x1070 [ 58.507009][ T5865] __writeback_single_inode+0x711/0x10d0 [ 58.513149][ T5865] writeback_single_inode+0x1f3/0x660 [ 58.519027][ T5865] sync_inode_metadata+0xc4/0x120 [ 58.524556][ T5865] hfsplus_file_fsync+0xf5/0x4d0 [ 58.530023][ T5865] __loop_update_dio+0x1a4/0x500 [ 58.535466][ T5865] loop_set_status+0x62b/0x8f0 [ 58.540735][ T5865] lo_ioctl+0xcbc/0x1f50 [ 58.545484][ T5865] blkdev_ioctl+0x57d/0x6a0 [ 58.550502][ T5865] __se_sys_ioctl+0xf9/0x170 [ 58.555597][ T5865] do_syscall_64+0xf3/0x230 [ 58.560602][ T5865] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 58.567003][ T5865] [ 58.567003][ T5865] other info that might help us debug this: [ 58.567003][ T5865] [ 58.577215][ T5865] Chain exists of: [ 58.577215][ T5865] &tree->tree_lock --> &q->q_usage_counter(io)#17 --> &sb->s_type->i_mutex_key#15 [ 58.577215][ T5865] [ 58.592345][ T5865] Possible unsafe locking scenario: [ 58.592345][ T5865] [ 58.599776][ T5865] CPU0 CPU1 [ 58.605122][ T5865] ---- ---- [ 58.610470][ T5865] lock(&sb->s_type->i_mutex_key#15); [ 58.615918][ T5865] lock(&q->q_usage_counter(io)#17); [ 58.623809][ T5865] lock(&sb->s_type->i_mutex_key#15); [ 58.631890][ T5865] lock(&tree->tree_lock); [ 58.636388][ T5865] [ 58.636388][ T5865] *** DEADLOCK *** [ 58.636388][ T5865] [ 58.644531][ T5865] 4 locks held by syz-executor253/5865: [ 58.650081][ T5865] #0: ffff888024b0a360 (&lo->lo_mutex){+.+.}-{4:4}, at: loop_set_status+0x2a/0x8f0 [ 58.659486][ T5865] #1: ffff888024e91db8 (&q->q_usage_counter(io)#17){++++}-{0:0}, at: blk_mq_freeze_queue+0x15/0x20 [ 58.670264][ T5865] #2: ffff888024e91df0 (&q->q_usage_counter(queue)){+.+.}-{0:0}, at: blk_mq_freeze_queue+0x15/0x20 [ 58.681034][ T5865] #3: ffff88807dec5ab8 (&sb->s_type->i_mutex_key#15){+.+.}-{4:4}, at: hfsplus_file_fsync+0xe8/0x4d0 [ 58.691898][ T5865] [ 58.691898][ T5865] stack backtrace: [ 58.697782][ T5865] CPU: 1 UID: 0 PID: 5865 Comm: syz-executor253 Not tainted 6.12.0-rc5-next-20241101-syzkaller #0 [ 58.708348][ T5865] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/13/2024 [ 58.718396][ T5865] Call Trace: [ 58.721662][ T5865] [ 58.724581][ T5865] dump_stack_lvl+0x241/0x360 [ 58.729249][ T5865] ? __pfx_dump_stack_lvl+0x10/0x10 [ 58.734433][ T5865] ? __pfx__printk+0x10/0x10 [ 58.739013][ T5865] print_circular_bug+0x13a/0x1b0 [ 58.744026][ T5865] check_noncircular+0x36a/0x4a0 [ 58.748951][ T5865] ? __pfx_check_noncircular+0x10/0x10 [ 58.754395][ T5865] ? lockdep_lock+0x123/0x2b0 [ 58.759065][ T5865] validate_chain+0x18ef/0x5920 [ 58.763932][ T5865] ? __pfx_validate_chain+0x10/0x10 [ 58.769207][ T5865] ? mark_lock+0x9a/0x360 [ 58.773543][ T5865] ? lockdep_hardirqs_on_prepare+0x43d/0x780 [ 58.779512][ T5865] ? mark_lock+0x9a/0x360 [ 58.783825][ T5865] __lock_acquire+0x1397/0x2100 [ 58.788665][ T5865] lock_acquire+0x1ed/0x550 [ 58.793149][ T5865] ? hfsplus_find_init+0x14a/0x1c0 [ 58.798268][ T5865] ? __pfx_lock_acquire+0x10/0x10 [ 58.803279][ T5865] ? hfsplus_find_init+0x85/0x1c0 [ 58.808300][ T5865] ? hfsplus_cat_write_inode+0x1df/0x1070 [ 58.814026][ T5865] ? __pfx___might_resched+0x10/0x10 [ 58.819298][ T5865] ? __loop_update_dio+0x1a4/0x500 [ 58.824429][ T5865] ? loop_set_status+0x62b/0x8f0 [ 58.829376][ T5865] ? lo_ioctl+0xcbc/0x1f50 [ 58.833789][ T5865] ? blkdev_ioctl+0x57d/0x6a0 [ 58.838457][ T5865] ? __se_sys_ioctl+0xf9/0x170 [ 58.843219][ T5865] ? do_syscall_64+0xf3/0x230 [ 58.847880][ T5865] ? entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 58.853939][ T5865] __mutex_lock+0x1ac/0xee0 [ 58.858427][ T5865] ? hfsplus_find_init+0x14a/0x1c0 [ 58.863524][ T5865] ? hfsplus_find_init+0x14a/0x1c0 [ 58.868619][ T5865] ? __pfx___mutex_lock+0x10/0x10 [ 58.873632][ T5865] ? rcu_is_watching+0x15/0xb0 [ 58.878382][ T5865] ? __kmalloc_noprof+0x2a5/0x4c0 [ 58.883396][ T5865] ? hfsplus_find_init+0x85/0x1c0 [ 58.888408][ T5865] hfsplus_find_init+0x14a/0x1c0 [ 58.893333][ T5865] hfsplus_cat_write_inode+0x1df/0x1070 [ 58.898866][ T5865] ? __pfx_hfsplus_cat_write_inode+0x10/0x10 [ 58.904839][ T5865] ? trace_contention_end+0x3c/0x120 [ 58.910108][ T5865] ? __mutex_lock+0x37f/0xee0 [ 58.914862][ T5865] ? __writeback_single_inode+0x48f/0x10d0 [ 58.920653][ T5865] ? do_raw_spin_lock+0x14f/0x370 [ 58.925665][ T5865] ? __pfx_lock_release+0x10/0x10 [ 58.930672][ T5865] ? hfsplus_write_inode+0x19c/0x5e0 [ 58.935946][ T5865] __writeback_single_inode+0x711/0x10d0 [ 58.941592][ T5865] writeback_single_inode+0x1f3/0x660 [ 58.946950][ T5865] sync_inode_metadata+0xc4/0x120 [ 58.951961][ T5865] ? __pfx_sync_inode_metadata+0x10/0x10 [ 58.957584][ T5865] ? __pfx_down_write+0x10/0x10 [ 58.962424][ T5865] ? kobject_uevent_env+0x54d/0x8e0 [ 58.967620][ T5865] ? kfree+0x196/0x420 [ 58.971670][ T5865] hfsplus_file_fsync+0xf5/0x4d0 [ 58.976594][ T5865] __loop_update_dio+0x1a4/0x500 [ 58.981515][ T5865] loop_set_status+0x62b/0x8f0 [ 58.986267][ T5865] lo_ioctl+0xcbc/0x1f50 [ 58.990500][ T5865] ? mark_lock+0x9a/0x360 [ 58.994815][ T5865] ? validate_chain+0x11e/0x5920 [ 58.999736][ T5865] ? __pfx_lo_ioctl+0x10/0x10 [ 59.004398][ T5865] ? mark_lock+0x9a/0x360 [ 59.008710][ T5865] ? __lock_acquire+0x1397/0x2100 [ 59.013739][ T5865] ? unwind_next_frame+0x18e6/0x22d0 [ 59.019132][ T5865] ? preempt_count_add+0x93/0x190 [ 59.024158][ T5865] ? is_bpf_text_address+0x285/0x2a0 [ 59.029780][ T5865] ? is_bpf_text_address+0x26/0x2a0 [ 59.034987][ T5865] ? __pfx_stack_trace_consume_entry+0x10/0x10 [ 59.041127][ T5865] ? kernel_text_address+0xa7/0xe0 [ 59.046231][ T5865] ? __kernel_text_address+0xd/0x40 [ 59.051414][ T5865] ? unwind_get_return_address+0x4d/0x90 [ 59.057031][ T5865] ? arch_stack_walk+0xfd/0x150 [ 59.061871][ T5865] ? stack_trace_save+0x118/0x1d0 [ 59.066888][ T5865] ? __pfx_stack_trace_save+0x10/0x10 [ 59.072246][ T5865] ? stack_depot_save_flags+0x29/0x830 [ 59.077695][ T5865] ? kasan_save_track+0x51/0x80 [ 59.082534][ T5865] ? kasan_save_track+0x3f/0x80 [ 59.087373][ T5865] ? kasan_save_free_info+0x40/0x50 [ 59.092558][ T5865] ? __kasan_slab_free+0x59/0x70 [ 59.097484][ T5865] ? kfree+0x196/0x420 [ 59.101533][ T5865] ? tomoyo_path_number_perm+0x679/0x860 [ 59.107152][ T5865] ? security_file_ioctl+0xc6/0x2a0 [ 59.112355][ T5865] ? __se_sys_ioctl+0x47/0x170 [ 59.117123][ T5865] ? do_syscall_64+0xf3/0x230 [ 59.121783][ T5865] ? entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 59.127838][ T5865] ? do_vfs_ioctl+0xf08/0x2e40 [ 59.132591][ T5865] ? __pfx_do_vfs_ioctl+0x10/0x10 [ 59.137604][ T5865] ? mark_lock+0x9a/0x360 [ 59.141918][ T5865] ? tomoyo_path_number_perm+0x206/0x860 [ 59.147544][ T5865] ? __pfx_lock_release+0x10/0x10 [ 59.152579][ T5865] ? tomoyo_path_number_perm+0x679/0x860 [ 59.158207][ T5865] ? tomoyo_path_number_perm+0x679/0x860 [ 59.163829][ T5865] ? blkdev_common_ioctl+0xfca/0x2480 [ 59.169186][ T5865] ? __pfx_blkdev_common_ioctl+0x10/0x10 [ 59.174800][ T5865] ? tomoyo_path_number_perm+0x206/0x860 [ 59.180418][ T5865] ? __pfx_tomoyo_path_number_perm+0x10/0x10 [ 59.186389][ T5865] ? file_to_blk_mode+0xcc/0x140 [ 59.191311][ T5865] ? __pfx_lo_ioctl+0x10/0x10 [ 59.195974][ T5865] blkdev_ioctl+0x57d/0x6a0 [ 59.200465][ T5865] ? __pfx_blkdev_ioctl+0x10/0x10 [ 59.205473][ T5865] ? __pfx_lockdep_hardirqs_on_prepare+0x10/0x10 [ 59.211786][ T5865] ? __pfx_blkdev_ioctl+0x10/0x10 [ 59.216790][ T5865] __se_sys_ioctl+0xf9/0x170 [ 59.221368][ T5865] do_syscall_64+0xf3/0x230 [ 59.225858][ T5865] ? clear_bhb_loop+0x35/0x90 [ 59.230521][ T5865] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 59.236404][ T5865] RIP: 0033:0x7fbbc7a41659 [ 59.240811][ T5865] Code: 28 00 00 00 75 05 48 83 c4 28 c3 e8 21 18 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 [ 59.260410][ T5865] RSP: 002b:00007ffedaced158 EFLAGS: 00000246 ORIG_RAX: 0000000000000010 [ 59.268838][ T5865] RAX: ffffffffffffffda RBX: 00007fbbc7a8a0a0 RCX: 00007fbbc7a41659 [ 59.276795][ T5865] RDX: 0000000020001300 RSI: 0000000000004c04 RDI: 0000000000000004 [ 59.284773][ T5865] RBP: 0000000000000000 R08: 0000000000000000 R09: 00007ffedaced190 [ 59.292747][ T5865] R10: 0000000000000000 R11: 0000000000000246 R12: 00007ffedaced17c [pid 5866] openat(AT_FDCWD, "/dev/loop0", O_RDONLY) = 4 [pid 5865] <... ioctl resumed>) = 0 [pid 5864] <... ioctl resumed>) = 0 [pid 5863] <... openat resumed>) = 4 [pid 5862] <... openat resumed>) = 4 [pid 5865] ftruncate(-1, 4402345721857 [pid 5863] openat(AT_FDCWD, "cgroup.stat", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000 [pid 5866] openat(AT_FDCWD, "cgroup.stat", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000 [pid 5865] <... ftruncate resumed>) = -1 EBADF (Bad file descriptor) [pid 5864] ioctl(4, LOOP_SET_FD, 3 [pid 5862] openat(AT_FDCWD, "cgroup.stat", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000 [pid 5864] <... ioctl resumed>) = -1 EBUSY (Device or resource busy) [pid 5865] exit_group(0 [pid 5864] close(4 [pid 5865] <... exit_group resumed>) = ? [pid 5864] <... close resumed>) = 0 [pid 5863] <... openat resumed>) = 5 [pid 5865] +++ exited with 0 +++ [pid 5864] close(3 [pid 5863] ioctl(4, LOOP_CONFIGURE, {fd=5, block_size=0, info={lo_offset=0, lo_number=0, lo_flags=LO_FLAGS_AUTOCLEAR|LO_FLAGS_PARTSCAN|LO_FLAGS_DIRECT_IO, lo_file_name="\xfe\xe8\xa2\xab\x78\xfc\x17\x9f\xd1\xf8\xa0\xe9\x1d\xda\xac\xa7\xbd\x64\xc6\xa4\xb4\xe0\x0d\x96\x83\xdd\xa1\xaf\x1e\xa8\x9d\xe2\xb7\xfb\x0a\x01", ...}} [pid 5864] <... close resumed>) = 0 [pid 5863] <... ioctl resumed>) = -1 EBUSY (Device or resource busy) [pid 5863] ioctl(4, LOOP_SET_STATUS64, {lo_offset=0x5, lo_number=0, lo_flags=LO_FLAGS_USE_AOPS|LO_FLAGS_PARTSCAN|LO_FLAGS_DIRECT_IO, lo_file_name="\xeb\xbf\x52\x74\x8b\x0b\x2a\xff\x33\x0c\x21\x36\x7b\x06\x62\x4f\xde\x30\x88\x7f\xda\x17\x2e\xe2\x51\xca\x9d\xea\x03\xca\x09\x48\x80\x22\x55\x71\x64\x5c\xc0\x27\xcd\x4c\x7a\x81\x38\x8e\x08\xc0\xa4\xa8\x77\x31\x91\x41\x08\x48\xa8\x94\x10\xf3\x19\xbd\xe2"..., ...} [pid 5849] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5865, si_uid=0, si_status=0, si_utime=0, si_stime=2 /* 0.02 s */} --- [pid 5864] openat(AT_FDCWD, "/dev/loop0", O_RDONLY [pid 5866] <... openat resumed>) = 5 [pid 5862] <... openat resumed>) = 5 [pid 5866] ioctl(4, LOOP_CONFIGURE, {fd=5, block_size=0, info={lo_offset=0, lo_number=0, lo_flags=LO_FLAGS_AUTOCLEAR|LO_FLAGS_PARTSCAN|LO_FLAGS_DIRECT_IO, lo_file_name="\xfe\xe8\xa2\xab\x78\xfc\x17\x9f\xd1\xf8\xa0\xe9\x1d\xda\xac\xa7\xbd\x64\xc6\xa4\xb4\xe0\x0d\x96\x83\xdd\xa1\xaf\x1e\xa8\x9d\xe2\xb7\xfb\x0a\x01", ...}} [pid 5862] ioctl(4, LOOP_CONFIGURE, {fd=5, block_size=0, info={lo_offset=0, lo_number=0, lo_flags=LO_FLAGS_AUTOCLEAR|LO_FLAGS_PARTSCAN|LO_FLAGS_DIRECT_IO, lo_file_name="\xfe\xe8\xa2\xab\x78\xfc\x17\x9f\xd1\xf8\xa0\xe9\x1d\xda\xac\xa7\xbd\x64\xc6\xa4\xb4\xe0\x0d\x96\x83\xdd\xa1\xaf\x1e\xa8\x9d\xe2\xb7\xfb\x0a\x01", ...}} [pid 5866] <... ioctl resumed>) = -1 EBUSY (Device or resource busy) [pid 5864] <... openat resumed>) = 3 [pid 5863] <... ioctl resumed>) = 0 [pid 5862] <... ioctl resumed>) = -1 EBUSY (Device or resource busy) [pid 5862] ioctl(4, LOOP_SET_STATUS64, {lo_offset=0x5, lo_number=0, lo_flags=LO_FLAGS_USE_AOPS|LO_FLAGS_PARTSCAN|LO_FLAGS_DIRECT_IO, lo_file_name="\xeb\xbf\x52\x74\x8b\x0b\x2a\xff\x33\x0c\x21\x36\x7b\x06\x62\x4f\xde\x30\x88\x7f\xda\x17\x2e\xe2\x51\xca\x9d\xea\x03\xca\x09\x48\x80\x22\x55\x71\x64\x5c\xc0\x27\xcd\x4c\x7a\x81\x38\x8e\x08\xc0\xa4\xa8\x77\x31\x91\x41\x08\x48\xa8\x94\x10\xf3\x19\xbd\xe2"..., ...} [pid 5866] ioctl(4, LOOP_SET_STATUS64, {lo_offset=0x5, lo_number=0, lo_flags=LO_FLAGS_USE_AOPS|LO_FLAGS_PARTSCAN|LO_FLAGS_DIRECT_IO, lo_file_name="\xeb\xbf\x52\x74\x8b\x0b\x2a\xff\x33\x0c\x21\x36\x7b\x06\x62\x4f\xde\x30\x88\x7f\xda\x17\x2e\xe2\x51\xca\x9d\xea\x03\xca\x09\x48\x80\x22\x55\x71\x64\x5c\xc0\x27\xcd\x4c\x7a\x81\x38\x8e\x08\xc0\xa4\xa8\x77\x31\x91\x41\x08\x48\xa8\x94\x10\xf3\x19\xbd\xe2"..., ...} [pid 5863] ftruncate(-1, 4402345721857) = -1 EBADF (Bad file descriptor) [ 59.300699][ T5865] R13: 0000000000000001 R14: 431bde82d7b634db R15: 00007ffedaced1b0 [ 59.308658][ T5865] [pid 5864] openat(AT_FDCWD, "cgroup.stat", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000 [pid 5849] umount2("./1", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5864] <... openat resumed>) = 4 [pid 5863] exit_group(0 [pid 5849] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5863] <... exit_group resumed>) = ? [pid 5849] openat(AT_FDCWD, "./1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 5849] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5864] ioctl(3, LOOP_CONFIGURE, {fd=4, block_size=0, info={lo_offset=0, lo_number=0, lo_flags=LO_FLAGS_AUTOCLEAR|LO_FLAGS_PARTSCAN|LO_FLAGS_DIRECT_IO, lo_file_name="\xfe\xe8\xa2\xab\x78\xfc\x17\x9f\xd1\xf8\xa0\xe9\x1d\xda\xac\xa7\xbd\x64\xc6\xa4\xb4\xe0\x0d\x96\x83\xdd\xa1\xaf\x1e\xa8\x9d\xe2\xb7\xfb\x0a\x01", ...}} [pid 5849] getdents64(3, [pid 5863] +++ exited with 0 +++ [pid 5850] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5863, si_uid=0, si_status=0, si_utime=0, si_stime=1 /* 0.01 s */} --- [pid 5850] restart_syscall(<... resuming interrupted clone ...> [pid 5849] <... getdents64 resumed>0x555589fa86f0 /* 4 entries */, 32768) = 112 [pid 5849] umount2("./1/file2", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EBUSY (Device or resource busy) [pid 5849] newfstatat(AT_FDCWD, "./1/file2", {st_mode=S_IFDIR|0766, st_size=10, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5850] <... restart_syscall resumed>) = 0 [pid 5849] umount2("./1/file2", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EBUSY (Device or resource busy) [pid 5849] openat(AT_FDCWD, "./1/file2", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5850] umount2("./1", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5849] <... openat resumed>) = 4 [pid 5850] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5849] newfstatat(4, "", [pid 5850] openat(AT_FDCWD, "./1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 5849] <... newfstatat resumed>{st_mode=S_IFDIR|0766, st_size=10, ...}, AT_EMPTY_PATH) = 0 [pid 5850] newfstatat(3, "", [pid 5849] getdents64(4, [pid 5850] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5850] getdents64(3, 0x555589fa86f0 /* 4 entries */, 32768) = 112 [pid 5850] umount2("./1/file2", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5849] <... getdents64 resumed>0x555589fb0730 /* 4 entries */, 32768) = 112 [pid 5849] umount2("./1/file2/cgroup.stat", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5849] newfstatat(AT_FDCWD, "./1/file2/cgroup.stat", {st_mode=S_IFREG|000, st_size=0, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5849] unlink("./1/file2/cgroup.stat") = 0 [pid 5849] umount2("./1/file2/file.c??d", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5862] <... ioctl resumed>) = 0 [pid 5850] <... umount2 resumed>) = 0 [pid 5849] <... umount2 resumed>) = -1 ENOENT (No such file or directory) [pid 5862] ftruncate(-1, 4402345721857 [pid 5849] newfstatat(AT_FDCWD, "./1/file2/file.c??d", [pid 5862] <... ftruncate resumed>) = -1 EBADF (Bad file descriptor) [pid 5849] <... newfstatat resumed>0x7ffedaceafa0, AT_SYMLINK_NOFOLLOW) = -1 ENOENT (No such file or directory) [pid 5862] exit_group(0 [pid 5850] umount2("./1/file2", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5849] exit_group(1 [pid 5850] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5850] newfstatat(AT_FDCWD, "./1/file2", [pid 5862] <... exit_group resumed>) = ? [pid 5849] <... exit_group resumed>) = ? [pid 5850] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5850] umount2("./1/file2", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5850] openat(AT_FDCWD, "./1/file2", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4 [pid 5850] newfstatat(4, "", [pid 5862] +++ exited with 0 +++ [pid 5850] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5849] +++ exited with 1 +++ [pid 5847] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5849, si_uid=0, si_status=1, si_utime=0, si_stime=2 /* 0.02 s */} --- [pid 5852] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5862, si_uid=0, si_status=0, si_utime=0, si_stime=1 /* 0.01 s */} --- [pid 5850] getdents64(4, [pid 5847] restart_syscall(<... resuming interrupted clone ...> [pid 5850] <... getdents64 resumed>0x555589fb0730 /* 2 entries */, 32768) = 48 [pid 5852] umount2("./1", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5850] getdents64(4, [pid 5852] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5850] <... getdents64 resumed>0x555589fb0730 /* 0 entries */, 32768) = 0 [pid 5852] openat(AT_FDCWD, "./1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5850] close(4 [pid 5852] <... openat resumed>) = 3 [pid 5850] <... close resumed>) = 0 [pid 5852] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [ 59.385610][ T5849] hfsplus: walked past end of dir [pid 5850] rmdir("./1/file2" [pid 5852] getdents64(3, [pid 5866] <... ioctl resumed>) = 0 [pid 5864] <... ioctl resumed>) = -1 EBUSY (Device or resource busy) [pid 5852] <... getdents64 resumed>0x555589fa86f0 /* 4 entries */, 32768) = 112 [pid 5850] <... rmdir resumed>) = 0 [pid 5864] ioctl(3, LOOP_SET_STATUS64, {lo_offset=0x5, lo_number=0, lo_flags=LO_FLAGS_USE_AOPS|LO_FLAGS_PARTSCAN|LO_FLAGS_DIRECT_IO, lo_file_name="\xeb\xbf\x52\x74\x8b\x0b\x2a\xff\x33\x0c\x21\x36\x7b\x06\x62\x4f\xde\x30\x88\x7f\xda\x17\x2e\xe2\x51\xca\x9d\xea\x03\xca\x09\x48\x80\x22\x55\x71\x64\x5c\xc0\x27\xcd\x4c\x7a\x81\x38\x8e\x08\xc0\xa4\xa8\x77\x31\x91\x41\x08\x48\xa8\x94\x10\xf3\x19\xbd\xe2"..., ...} [pid 5852] umount2("./1/file2", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5866] ftruncate(-1, 4402345721857) = -1 EBADF (Bad file descriptor) [pid 5866] exit_group(0 [pid 5852] <... umount2 resumed>) = 0 [pid 5850] umount2("./1/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5852] umount2("./1/file2", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5850] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5866] <... exit_group resumed>) = ? [pid 5852] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5852] newfstatat(AT_FDCWD, "./1/file2", [pid 5850] newfstatat(AT_FDCWD, "./1/binderfs", [pid 5852] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5850] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5852] umount2("./1/file2", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5850] unlink("./1/binderfs" [pid 5852] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5850] <... unlink resumed>) = 0 [pid 5866] +++ exited with 0 +++ [pid 5852] openat(AT_FDCWD, "./1/file2", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4 [pid 5850] getdents64(3, [pid 5852] newfstatat(4, "", [pid 5851] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5866, si_uid=0, si_status=0, si_utime=1 /* 0.01 s */, si_stime=0} --- [pid 5850] <... getdents64 resumed>0x555589fa86f0 /* 0 entries */, 32768) = 0 [pid 5852] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5850] close(3 [pid 5852] getdents64(4, [pid 5850] <... close resumed>) = 0 [pid 5850] rmdir("./1" [pid 5852] <... getdents64 resumed>0x555589fb0730 /* 2 entries */, 32768) = 48 [pid 5851] umount2("./1", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5852] getdents64(4, [pid 5850] <... rmdir resumed>) = 0 [pid 5852] <... getdents64 resumed>0x555589fb0730 /* 0 entries */, 32768) = 0 [pid 5851] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5850] mkdir("./2", 0777 [pid 5852] close(4 [pid 5851] openat(AT_FDCWD, "./1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5852] <... close resumed>) = 0 [pid 5851] <... openat resumed>) = 3 [pid 5852] rmdir("./1/file2" [pid 5850] <... mkdir resumed>) = 0 [pid 5851] newfstatat(3, "", [pid 5850] openat(AT_FDCWD, "/dev/loop2", O_RDWR [pid 5852] <... rmdir resumed>) = 0 [pid 5851] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5852] umount2("./1/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5851] getdents64(3, [pid 5852] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5852] newfstatat(AT_FDCWD, "./1/binderfs", [pid 5851] <... getdents64 resumed>0x555589fa86f0 /* 4 entries */, 32768) = 112 [pid 5850] <... openat resumed>) = 3 [pid 5852] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5851] umount2("./1/file2", MNT_FORCE|UMOUNT_NOFOLLOW