./strace-static-x86_64 -e \!wait4,clock_nanosleep,nanosleep -s 100 -x -f ./syz-executor3618860463 <...> Warning: Permanently added '10.128.1.222' (ED25519) to the list of known hosts. execve("./syz-executor3618860463", ["./syz-executor3618860463"], 0x7ffeb7449330 /* 10 vars */) = 0 brk(NULL) = 0x5555891ec000 brk(0x5555891ecd00) = 0x5555891ecd00 arch_prctl(ARCH_SET_FS, 0x5555891ec380) = 0 set_tid_address(0x5555891ec650) = 5866 set_robust_list(0x5555891ec660, 24) = 0 rseq(0x5555891ecca0, 0x20, 0, 0x53053053) = 0 prlimit64(0, RLIMIT_STACK, NULL, {rlim_cur=8192*1024, rlim_max=RLIM64_INFINITY}) = 0 readlink("/proc/self/exe", "/root/syz-executor3618860463", 4096) = 28 getrandom("\xdf\x25\xe0\x6d\xbc\xcd\x0d\xf6", 8, GRND_NONBLOCK) = 8 brk(NULL) = 0x5555891ecd00 brk(0x55558920dd00) = 0x55558920dd00 brk(0x55558920e000) = 0x55558920e000 mprotect(0x7f2a7e712000, 16384, PROT_READ) = 0 mmap(0x1ffffffff000, 4096, PROT_NONE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x1ffffffff000 mmap(0x200000000000, 16777216, PROT_READ|PROT_WRITE|PROT_EXEC, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x200000000000 mmap(0x200001000000, 4096, PROT_NONE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x200001000000 clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x5555891ec650) = 5867 ./strace-static-x86_64: Process 5867 attached [pid 5866] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5867] set_robust_list(0x5555891ec660, 24) = 0 [pid 5867] mkdir("./syzkaller.5pV0LQ", 0700./strace-static-x86_64: Process 5868 attached [pid 5866] <... clone resumed>, child_tidptr=0x5555891ec650) = 5868 [pid 5866] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5868] set_robust_list(0x5555891ec660, 24./strace-static-x86_64: Process 5869 attached ) = 0 [pid 5868] mkdir("./syzkaller.GQOv8s", 0700 [pid 5867] <... mkdir resumed>) = 0 [pid 5866] <... clone resumed>, child_tidptr=0x5555891ec650) = 5869 [pid 5869] set_robust_list(0x5555891ec660, 24 [pid 5866] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5869] <... set_robust_list resumed>) = 0 [pid 5867] chmod("./syzkaller.5pV0LQ", 0777 [pid 5868] <... mkdir resumed>) = 0 [pid 5868] chmod("./syzkaller.GQOv8s", 0777./strace-static-x86_64: Process 5870 attached [pid 5869] mkdir("./syzkaller.8mTrBs", 0700 [pid 5867] <... chmod resumed>) = 0 [pid 5866] <... clone resumed>, child_tidptr=0x5555891ec650) = 5870 [pid 5868] <... chmod resumed>) = 0 [pid 5870] set_robust_list(0x5555891ec660, 24) = 0 [pid 5866] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5870] getrandom( [pid 5868] chdir("./syzkaller.GQOv8s" [pid 5867] chdir("./syzkaller.5pV0LQ") = 0 [pid 5868] <... chdir resumed>) = 0 [pid 5867] mkdir("./0", 0777 [pid 5870] <... getrandom resumed>"\xef\xe3\x73\x63\x94\x63\x2b\x33", 8, GRND_NONBLOCK) = 8 [pid 5869] <... mkdir resumed>) = 0 [pid 5868] mkdir("./0", 0777 [pid 5867] <... mkdir resumed>) = 0 [pid 5870] mkdir("./syzkaller.p4sPhh", 0700) = 0 ./strace-static-x86_64: Process 5871 attached [pid 5869] chmod("./syzkaller.8mTrBs", 0777 [pid 5868] <... mkdir resumed>) = 0 [pid 5867] openat(AT_FDCWD, "/dev/loop0", O_RDWR [pid 5866] <... clone resumed>, child_tidptr=0x5555891ec650) = 5871 [pid 5871] set_robust_list(0x5555891ec660, 24 [pid 5870] chmod("./syzkaller.p4sPhh", 0777 [pid 5867] <... openat resumed>) = 3 [pid 5871] <... set_robust_list resumed>) = 0 [pid 5869] <... chmod resumed>) = 0 [pid 5868] openat(AT_FDCWD, "/dev/loop1", O_RDWR [pid 5870] <... chmod resumed>) = 0 [pid 5869] chdir("./syzkaller.8mTrBs" [pid 5867] ioctl(3, LOOP_CLR_FD [pid 5871] mkdir("./syzkaller.f2CuL6", 0700 [pid 5870] chdir("./syzkaller.p4sPhh" [pid 5869] <... chdir resumed>) = 0 [pid 5868] <... openat resumed>) = 3 [pid 5870] <... chdir resumed>) = 0 [pid 5867] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5870] mkdir("./0", 0777 [pid 5869] mkdir("./0", 0777 [pid 5868] ioctl(3, LOOP_CLR_FD [pid 5867] close(3 [pid 5871] <... mkdir resumed>) = 0 [pid 5871] chmod("./syzkaller.f2CuL6", 0777 [pid 5870] <... mkdir resumed>) = 0 [pid 5869] <... mkdir resumed>) = 0 [pid 5868] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5867] <... close resumed>) = 0 [pid 5869] openat(AT_FDCWD, "/dev/loop2", O_RDWR [pid 5871] <... chmod resumed>) = 0 [pid 5869] <... openat resumed>) = 3 [pid 5868] close(3) = 0 [pid 5868] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5872 attached [pid 5871] chdir("./syzkaller.f2CuL6" [pid 5870] openat(AT_FDCWD, "/dev/loop3", O_RDWR [pid 5869] ioctl(3, LOOP_CLR_FD [pid 5867] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5872] set_robust_list(0x5555891ec660, 24 [pid 5871] <... chdir resumed>) = 0 [pid 5869] <... ioctl resumed>) = -1 ENXIO (No such device or address) ./strace-static-x86_64: Process 5874 attached [pid 5872] <... set_robust_list resumed>) = 0 [pid 5871] mkdir("./0", 0777 [pid 5870] <... openat resumed>) = 3 [pid 5869] close(3) = 0 [pid 5868] <... clone resumed>, child_tidptr=0x5555891ec650) = 5872 [pid 5869] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5875 attached [pid 5870] ioctl(3, LOOP_CLR_FD) = -1 ENXIO (No such device or address) [pid 5870] close(3) = 0 [pid 5867] <... clone resumed>, child_tidptr=0x5555891ec650) = 5874 [pid 5872] chdir("./0" [pid 5870] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5876 attached [pid 5874] set_robust_list(0x5555891ec660, 24 [pid 5872] <... chdir resumed>) = 0 [pid 5874] <... set_robust_list resumed>) = 0 [pid 5872] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5875] set_robust_list(0x5555891ec660, 24) = 0 [pid 5874] chdir("./0" [pid 5872] <... prctl resumed>) = 0 [pid 5871] <... mkdir resumed>) = 0 [pid 5874] <... chdir resumed>) = 0 [pid 5869] <... clone resumed>, child_tidptr=0x5555891ec650) = 5875 [pid 5872] setpgid(0, 0 [pid 5874] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5871] openat(AT_FDCWD, "/dev/loop4", O_RDWR [pid 5872] <... setpgid resumed>) = 0 [pid 5870] <... clone resumed>, child_tidptr=0x5555891ec650) = 5876 [pid 5876] set_robust_list(0x5555891ec660, 24 [pid 5874] <... prctl resumed>) = 0 [pid 5875] chdir("./0" [pid 5874] setpgid(0, 0 [pid 5872] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5876] <... set_robust_list resumed>) = 0 [pid 5874] <... setpgid resumed>) = 0 [pid 5875] <... chdir resumed>) = 0 [pid 5875] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5872] <... openat resumed>) = 3 [pid 5876] chdir("./0" [pid 5875] setpgid(0, 0) = 0 [pid 5875] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5874] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5871] <... openat resumed>) = 3 [pid 5876] <... chdir resumed>) = 0 [pid 5875] <... openat resumed>) = 3 [pid 5875] write(3, "1000", 4) = 4 [pid 5875] close(3 [pid 5872] write(3, "1000", 4 [pid 5875] <... close resumed>) = 0 [pid 5872] <... write resumed>) = 4 [pid 5872] close(3 [pid 5875] symlink("/dev/binderfs", "./binderfs" [pid 5872] <... close resumed>) = 0 [pid 5876] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5875] <... symlink resumed>) = 0 [pid 5872] symlink("/dev/binderfs", "./binderfs"executing program executing program [pid 5876] <... prctl resumed>) = 0 [pid 5874] <... openat resumed>) = 3 [pid 5872] <... symlink resumed>) = 0 [pid 5871] ioctl(3, LOOP_CLR_FD [pid 5875] write(1, "executing program\n", 18 [pid 5876] setpgid(0, 0 [pid 5875] <... write resumed>) = 18 [pid 5875] memfd_create("syzkaller", 0 [pid 5872] write(1, "executing program\n", 18) = 18 [pid 5871] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5876] <... setpgid resumed>) = 0 [pid 5874] write(3, "1000", 4 [pid 5872] memfd_create("syzkaller", 0 [pid 5876] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5875] <... memfd_create resumed>) = 3 [pid 5874] <... write resumed>) = 4 [pid 5871] close(3 [pid 5875] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5872] <... memfd_create resumed>) = 3 [pid 5876] <... openat resumed>) = 3 [pid 5875] <... mmap resumed>) = 0x7f2a76200000 [pid 5874] close(3 [pid 5871] <... close resumed>) = 0 [pid 5872] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5876] write(3, "1000", 4 [pid 5874] <... close resumed>) = 0 [pid 5871] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5876] <... write resumed>) = 4 [pid 5874] symlink("/dev/binderfs", "./binderfs" [pid 5872] <... mmap resumed>) = 0x7f2a76200000 ./strace-static-x86_64: Process 5877 attached [pid 5876] close(3 [pid 5877] set_robust_list(0x5555891ec660, 24) = 0 [pid 5877] chdir("./0") = 0 [pid 5877] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5877] setpgid(0, 0) = 0 [pid 5877] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC) = 3 [pid 5877] write(3, "1000", 4) = 4 [pid 5877] close(3) = 0 [pid 5877] symlink("/dev/binderfs", "./binderfs") = 0 [pid 5876] <... close resumed>) = 0 [pid 5874] <... symlink resumed>) = 0 [pid 5874] write(1, "executing program\n", 18 [pid 5876] symlink("/dev/binderfs", "./binderfs"executing program ) = 0 [pid 5877] write(1, "executing program\n", 18) = 18 [pid 5877] memfd_create("syzkaller", 0) = 3 [pid 5877] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f2a76200000 executing program executing program [pid 5876] write(1, "executing program\n", 18 [pid 5874] <... write resumed>) = 18 [pid 5871] <... clone resumed>, child_tidptr=0x5555891ec650) = 5877 [pid 5876] <... write resumed>) = 18 [pid 5876] memfd_create("syzkaller", 0 [pid 5874] memfd_create("syzkaller", 0 [pid 5876] <... memfd_create resumed>) = 3 [pid 5874] <... memfd_create resumed>) = 3 [pid 5876] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5874] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5876] <... mmap resumed>) = 0x7f2a76200000 [pid 5874] <... mmap resumed>) = 0x7f2a76200000 [pid 5877] 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 5875] 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 5872] 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 5876] 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 5874] 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 5877] <... write resumed>) = 16777216 [pid 5877] munmap(0x7f2a76200000, 138412032) = 0 [pid 5877] openat(AT_FDCWD, "/dev/loop4", O_RDWR) = 4 [pid 5877] ioctl(4, LOOP_SET_FD, 3 [pid 5874] <... write resumed>) = 16777216 [pid 5877] <... ioctl resumed>) = 0 [pid 5874] munmap(0x7f2a76200000, 138412032 [pid 5877] close(3) = 0 [pid 5877] close(4) = 0 [pid 5877] mkdir("./file0", 0777) = 0 [pid 5877] mount("/dev/loop4", "./file0", "jfs", MS_DIRSYNC|MS_NODIRATIME|MS_POSIXACL|MS_LAZYTIME, "discard=0x0000000000000004,quota,errors=continue,discard=0x0000000000000004,umask=0407,usrquota,erro"... [pid 5874] <... munmap resumed>) = 0 [pid 5874] openat(AT_FDCWD, "/dev/loop0", O_RDWR) = 4 [ 241.709862][ T5877] loop4: detected capacity change from 0 to 32768 [pid 5874] ioctl(4, LOOP_SET_FD, 3) = 0 [pid 5874] close(3) = 0 [pid 5874] close(4) = 0 [pid 5874] mkdir("./file0", 0777) = 0 [pid 5877] <... mount resumed>) = 0 [pid 5874] mount("/dev/loop0", "./file0", "jfs", MS_DIRSYNC|MS_NODIRATIME|MS_POSIXACL|MS_LAZYTIME, "discard=0x0000000000000004,quota,errors=continue,discard=0x0000000000000004,umask=0407,usrquota,erro"... [ 241.771781][ T5874] loop0: detected capacity change from 0 to 32768 [pid 5877] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY [pid 5875] <... write resumed>) = 16777216 [pid 5877] <... openat resumed>) = 3 [pid 5877] chdir("./file0") = 0 [pid 5877] openat(AT_FDCWD, "/dev/loop4", O_RDWR) = -1 EBUSY (Device or resource busy) [pid 5877] mount(".", "./file0/../file0", NULL, MS_RDONLY|MS_MANDLOCK|MS_BIND|MS_SILENT|MS_SHARED, NULL [pid 5875] munmap(0x7f2a76200000, 138412032 [pid 5876] <... write resumed>) = 16777216 [pid 5875] <... munmap resumed>) = 0 [pid 5872] <... write resumed>) = 16777216 [pid 5876] munmap(0x7f2a76200000, 138412032 [pid 5875] openat(AT_FDCWD, "/dev/loop2", O_RDWR [pid 5872] munmap(0x7f2a76200000, 138412032 [pid 5875] <... openat resumed>) = 4 [pid 5874] <... mount resumed>) = 0 [ 241.850593][ T5877] ======================================================= [ 241.850593][ T5877] WARNING: The mand mount option has been deprecated and [ 241.850593][ T5877] and is ignored by this kernel. Remove the mand [ 241.850593][ T5877] option from the mount to silence this warning. [ 241.850593][ T5877] ======================================================= [pid 5875] ioctl(4, LOOP_SET_FD, 3 [pid 5874] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY) = 3 [pid 5874] chdir("./file0") = 0 [pid 5874] openat(AT_FDCWD, "/dev/loop0", O_RDWR) = -1 EBUSY (Device or resource busy) [pid 5874] mount(".", "./file0/../file0", NULL, MS_RDONLY|MS_MANDLOCK|MS_BIND|MS_SILENT|MS_SHARED, NULL [pid 5876] <... munmap resumed>) = 0 [pid 5875] <... ioctl resumed>) = 0 [pid 5874] <... mount resumed>) = 0 [pid 5876] openat(AT_FDCWD, "/dev/loop3", O_RDWR [pid 5875] close(3 [pid 5874] exit_group(0 [pid 5875] <... close resumed>) = 0 [pid 5875] close(4 [pid 5876] <... openat resumed>) = 4 [pid 5874] <... exit_group resumed>) = ? [pid 5875] <... close resumed>) = 0 [pid 5876] ioctl(4, LOOP_SET_FD, 3 [pid 5874] +++ exited with 0 +++ [pid 5877] <... mount resumed>) = 0 [pid 5876] <... ioctl resumed>) = 0 [pid 5875] mkdir("./file0", 0777 [pid 5872] <... munmap resumed>) = 0 [pid 5877] exit_group(0 [pid 5876] close(3 [pid 5875] <... mkdir resumed>) = 0 [pid 5872] openat(AT_FDCWD, "/dev/loop1", O_RDWR [pid 5867] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5874, si_uid=0, si_status=0, si_utime=5 /* 0.05 s */, si_stime=23 /* 0.23 s */} --- [pid 5875] mount("/dev/loop2", "./file0", "jfs", MS_DIRSYNC|MS_NODIRATIME|MS_POSIXACL|MS_LAZYTIME, "discard=0x0000000000000004,quota,errors=continue,discard=0x0000000000000004,umask=0407,usrquota,erro"... [pid 5867] restart_syscall(<... resuming interrupted clone ...>) = 0 [pid 5877] <... exit_group resumed>) = ? [pid 5876] <... close resumed>) = 0 [ 241.898553][ T5875] loop2: detected capacity change from 0 to 32768 [ 241.913194][ T5876] loop3: detected capacity change from 0 to 32768 [pid 5872] <... openat resumed>) = 4 [pid 5867] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5872] ioctl(4, LOOP_SET_FD, 3 [pid 5867] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5867] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5877] +++ exited with 0 +++ [pid 5876] close(4 [pid 5872] <... ioctl resumed>) = 0 [pid 5867] <... openat resumed>) = 3 [pid 5867] newfstatat(3, "", [pid 5876] <... close resumed>) = 0 [pid 5875] <... mount resumed>) = 0 [pid 5872] close(3 [pid 5871] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5877, si_uid=0, si_status=0, si_utime=5 /* 0.05 s */, si_stime=28 /* 0.28 s */} --- [pid 5867] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5876] mkdir("./file0", 0777 [pid 5875] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY [pid 5872] <... close resumed>) = 0 [pid 5871] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5867] getdents64(3, [pid 5876] <... mkdir resumed>) = 0 [pid 5875] <... openat resumed>) = 3 [pid 5872] close(4 [pid 5871] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5867] <... getdents64 resumed>0x5555891ed6f0 /* 4 entries */, 32768) = 112 [pid 5875] chdir("./file0" [pid 5871] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5875] <... chdir resumed>) = 0 [pid 5872] <... close resumed>) = 0 [pid 5867] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5871] <... openat resumed>) = 3 [pid 5876] mount("/dev/loop3", "./file0", "jfs", MS_DIRSYNC|MS_NODIRATIME|MS_POSIXACL|MS_LAZYTIME, "discard=0x0000000000000004,quota,errors=continue,discard=0x0000000000000004,umask=0407,usrquota,erro"... [pid 5875] openat(AT_FDCWD, "/dev/loop2", O_RDWR [pid 5872] mkdir("./file0", 0777 [pid 5871] newfstatat(3, "", [pid 5867] <... umount2 resumed>) = -1 EBUSY (Device or resource busy) [pid 5875] <... openat resumed>) = -1 EBUSY (Device or resource busy) [pid 5872] <... mkdir resumed>) = 0 [pid 5871] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5867] newfstatat(AT_FDCWD, "./0/file0", [pid 5875] mount(".", "./file0/../file0", NULL, MS_RDONLY|MS_MANDLOCK|MS_BIND|MS_SILENT|MS_SHARED, NULL [pid 5872] mount("/dev/loop1", "./file0", "jfs", MS_DIRSYNC|MS_NODIRATIME|MS_POSIXACL|MS_LAZYTIME, "discard=0x0000000000000004,quota,errors=continue,discard=0x0000000000000004,umask=0407,usrquota,erro"... [pid 5867] <... newfstatat resumed>{st_mode=S_IFDIR|0370, st_size=40, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5867] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5875] <... mount resumed>) = 0 [pid 5872] <... mount resumed>) = 0 [pid 5871] getdents64(3, [pid 5867] <... umount2 resumed>) = -1 EBUSY (Device or resource busy) [pid 5872] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY [pid 5871] <... getdents64 resumed>0x5555891ed6f0 /* 4 entries */, 32768) = 112 [ 241.954453][ T5872] loop1: detected capacity change from 0 to 32768 [pid 5867] openat(AT_FDCWD, "./0/file0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5875] exit_group(0 [pid 5872] <... openat resumed>) = 3 [pid 5871] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5867] <... openat resumed>) = 4 [pid 5875] <... exit_group resumed>) = ? [pid 5872] chdir("./file0" [pid 5871] <... umount2 resumed>) = -1 EBUSY (Device or resource busy) [pid 5867] newfstatat(4, "", {st_mode=S_IFDIR|0370, st_size=40, ...}, AT_EMPTY_PATH) = 0 [pid 5875] +++ exited with 0 +++ [pid 5867] getdents64(4, [pid 5872] <... chdir resumed>) = 0 [pid 5867] <... getdents64 resumed>0x5555891f5730 /* 7 entries */, 32768) = 208 [pid 5871] newfstatat(AT_FDCWD, "./0/file0", [pid 5869] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5875, si_uid=0, si_status=0, si_utime=1 /* 0.01 s */, si_stime=26 /* 0.26 s */} --- [pid 5872] openat(AT_FDCWD, "/dev/loop1", O_RDWR [pid 5867] umount2("./0/file0/file.cold", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5871] <... newfstatat resumed>{st_mode=S_IFDIR|0370, st_size=40, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5869] restart_syscall(<... resuming interrupted clone ...> [pid 5867] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5872] <... openat resumed>) = -1 EBUSY (Device or resource busy) [pid 5867] newfstatat(AT_FDCWD, "./0/file0/file.cold", [pid 5872] mount(".", "./file0/../file0", NULL, MS_RDONLY|MS_MANDLOCK|MS_BIND|MS_SILENT|MS_SHARED, NULL [pid 5871] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5867] <... newfstatat resumed>{st_mode=S_IFREG|0370, st_size=100, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5867] unlink("./0/file0/file.cold") = 0 [pid 5872] <... mount resumed>) = 0 [pid 5867] umount2("./0/file0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5871] <... umount2 resumed>) = -1 EBUSY (Device or resource busy) [pid 5872] exit_group(0) = ? [pid 5871] openat(AT_FDCWD, "./0/file0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5869] <... restart_syscall resumed>) = 0 [pid 5869] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5869] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5871] <... openat resumed>) = 4 [pid 5869] <... openat resumed>) = 3 [pid 5871] newfstatat(4, "", [pid 5869] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5871] <... newfstatat resumed>{st_mode=S_IFDIR|0370, st_size=40, ...}, AT_EMPTY_PATH) = 0 [pid 5869] getdents64(3, [pid 5871] getdents64(4, [pid 5869] <... getdents64 resumed>0x5555891ed6f0 /* 4 entries */, 32768) = 112 [pid 5871] <... getdents64 resumed>0x5555891f5730 /* 7 entries */, 32768) = 208 [pid 5869] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5871] umount2("./0/file0/file.cold", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5869] <... umount2 resumed>) = -1 EBUSY (Device or resource busy) [pid 5871] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5869] newfstatat(AT_FDCWD, "./0/file0", [pid 5871] newfstatat(AT_FDCWD, "./0/file0/file.cold", [pid 5869] <... newfstatat resumed>{st_mode=S_IFDIR|0370, st_size=40, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5871] <... newfstatat resumed>{st_mode=S_IFREG|0370, st_size=100, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5869] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EBUSY (Device or resource busy) [pid 5871] unlink("./0/file0/file.cold" [pid 5869] openat(AT_FDCWD, "./0/file0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4 [pid 5871] <... unlink resumed>) = 0 [pid 5876] <... mount resumed>) = 0 [pid 5872] +++ exited with 0 +++ [pid 5871] umount2("./0/file0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5869] newfstatat(4, "", [pid 5867] <... umount2 resumed>) = 0 [pid 5867] umount2("./0/file0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5868] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5872, si_uid=0, si_status=0, si_utime=6 /* 0.06 s */, si_stime=21 /* 0.21 s */} --- [pid 5876] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY [pid 5869] <... newfstatat resumed>{st_mode=S_IFDIR|0370, st_size=40, ...}, AT_EMPTY_PATH) = 0 [pid 5868] restart_syscall(<... resuming interrupted clone ...> [pid 5867] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5869] getdents64(4, [pid 5867] newfstatat(AT_FDCWD, "./0/file0/file0", [pid 5876] <... openat resumed>) = 3 [pid 5869] <... getdents64 resumed>0x5555891f5730 /* 7 entries */, 32768) = 208 [pid 5867] <... newfstatat resumed>{st_mode=S_IFDIR|0370, st_size=16, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5876] chdir("./file0" [pid 5869] umount2("./0/file0/file.cold", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5876] <... chdir resumed>) = 0 [pid 5867] umount2("./0/file0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5869] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5867] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5867] openat(AT_FDCWD, "./0/file0/file0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 5 [pid 5876] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = -1 EBUSY (Device or resource busy) [pid 5869] newfstatat(AT_FDCWD, "./0/file0/file.cold", [pid 5868] <... restart_syscall resumed>) = 0 [pid 5867] newfstatat(5, "", [pid 5869] <... newfstatat resumed>{st_mode=S_IFREG|0370, st_size=100, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5867] <... newfstatat resumed>{st_mode=S_IFDIR|0370, st_size=16, ...}, AT_EMPTY_PATH) = 0 [pid 5869] unlink("./0/file0/file.cold" [pid 5868] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5876] mount(".", "./file0/../file0", NULL, MS_RDONLY|MS_MANDLOCK|MS_BIND|MS_SILENT|MS_SHARED, NULL [pid 5868] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5869] <... unlink resumed>) = 0 [pid 5868] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 5869] umount2("./0/file0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5876] <... mount resumed>) = 0 [pid 5871] <... umount2 resumed>) = 0 [pid 5868] newfstatat(3, "", [pid 5867] getdents64(5, [pid 5868] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5868] getdents64(3, 0x5555891ed6f0 /* 4 entries */, 32768) = 112 [pid 5868] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5876] exit_group(0 [pid 5871] umount2("./0/file0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5868] <... umount2 resumed>) = -1 EBUSY (Device or resource busy) [pid 5876] <... exit_group resumed>) = ? [pid 5871] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5868] newfstatat(AT_FDCWD, "./0/file0", {st_mode=S_IFDIR|0370, st_size=40, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5868] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5871] newfstatat(AT_FDCWD, "./0/file0/file0", [pid 5868] <... umount2 resumed>) = -1 EBUSY (Device or resource busy) [pid 5871] <... newfstatat resumed>{st_mode=S_IFDIR|0370, st_size=16, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5868] openat(AT_FDCWD, "./0/file0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4 [pid 5868] newfstatat(4, "", [pid 5871] umount2("./0/file0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5876] +++ exited with 0 +++ [pid 5868] <... newfstatat resumed>{st_mode=S_IFDIR|0370, st_size=40, ...}, AT_EMPTY_PATH) = 0 [pid 5871] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5870] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5876, si_uid=0, si_status=0, si_utime=3 /* 0.03 s */, si_stime=23 /* 0.23 s */} --- [pid 5868] getdents64(4, [pid 5871] openat(AT_FDCWD, "./0/file0/file0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5870] restart_syscall(<... resuming interrupted clone ...> [pid 5868] <... getdents64 resumed>0x5555891f5730 /* 7 entries */, 32768) = 208 [pid 5871] <... openat resumed>) = 5 [pid 5870] <... restart_syscall resumed>) = 0 [pid 5868] umount2("./0/file0/file.cold", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5871] newfstatat(5, "", {st_mode=S_IFDIR|0370, st_size=16, ...}, AT_EMPTY_PATH) = 0 [pid 5868] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5871] getdents64(5, [pid 5870] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5868] newfstatat(AT_FDCWD, "./0/file0/file.cold", [pid 5870] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5868] <... newfstatat resumed>{st_mode=S_IFREG|0370, st_size=100, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5870] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5869] <... umount2 resumed>) = 0 [pid 5868] unlink("./0/file0/file.cold") = 0 [pid 5870] <... openat resumed>) = 3 [pid 5869] umount2("./0/file0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5868] umount2("./0/file0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5870] newfstatat(3, "", [pid 5869] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5870] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5869] newfstatat(AT_FDCWD, "./0/file0/file0", [pid 5870] getdents64(3, [pid 5869] <... newfstatat resumed>{st_mode=S_IFDIR|0370, st_size=16, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5870] <... getdents64 resumed>0x5555891ed6f0 /* 4 entries */, 32768) = 112 [pid 5869] umount2("./0/file0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5870] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5869] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5870] <... umount2 resumed>) = -1 EBUSY (Device or resource busy) [pid 5869] openat(AT_FDCWD, "./0/file0/file0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 5 [ 242.070616][ T5867] non-latin1 character 0x2e66 found in JFS file name [ 242.092007][ T5871] non-latin1 character 0x2e66 found in JFS file name [ 242.099422][ T5867] mount with iocharset=utf8 to access [pid 5869] newfstatat(5, "", {st_mode=S_IFDIR|0370, st_size=16, ...}, AT_EMPTY_PATH) = 0 [pid 5868] <... umount2 resumed>) = 0 [pid 5869] getdents64(5, [pid 5868] umount2("./0/file0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5867] <... getdents64 resumed>0x5555891fd770 /* 4 entries */, 32768) = 112 [pid 5867] umount2("./0/file0/file0/?ile0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 ENOENT (No such file or directory) [pid 5867] newfstatat(AT_FDCWD, "./0/file0/file0/?ile0", [pid 5868] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5867] <... newfstatat resumed>0x7ffdec4903a0, AT_SYMLINK_NOFOLLOW) = -1 ENOENT (No such file or directory) [pid 5868] newfstatat(AT_FDCWD, "./0/file0/file0", [pid 5867] exit_group(1) = ? [pid 5870] newfstatat(AT_FDCWD, "./0/file0", [pid 5868] <... newfstatat resumed>{st_mode=S_IFDIR|0370, st_size=16, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5867] +++ exited with 1 +++ [pid 5866] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5867, si_uid=0, si_status=1, si_utime=0, si_stime=2 /* 0.02 s */} --- [pid 5866] restart_syscall(<... resuming interrupted clone ...> [pid 5868] umount2("./0/file0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5870] <... newfstatat resumed>{st_mode=S_IFDIR|0370, st_size=40, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5868] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5870] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5868] openat(AT_FDCWD, "./0/file0/file0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5870] <... umount2 resumed>) = -1 EBUSY (Device or resource busy) [pid 5870] openat(AT_FDCWD, "./0/file0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5868] <... openat resumed>) = 5 [pid 5870] <... openat resumed>) = 4 [pid 5868] newfstatat(5, "", [pid 5870] newfstatat(4, "", [pid 5868] <... newfstatat resumed>{st_mode=S_IFDIR|0370, st_size=16, ...}, AT_EMPTY_PATH) = 0 [pid 5868] getdents64(5, [pid 5870] <... newfstatat resumed>{st_mode=S_IFDIR|0370, st_size=40, ...}, AT_EMPTY_PATH) = 0 [pid 5870] getdents64(4, 0x5555891f5730 /* 7 entries */, 32768) = 208 [pid 5871] <... getdents64 resumed>0x5555891fd770 /* 4 entries */, 32768) = 112 [pid 5870] umount2("./0/file0/file.cold", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5871] umount2("./0/file0/file0/?ile0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5870] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5869] <... getdents64 resumed>0x5555891fd770 /* 4 entries */, 32768) = 112 [pid 5868] <... getdents64 resumed>0x5555891fd770 /* 4 entries */, 32768) = 112 [pid 5870] newfstatat(AT_FDCWD, "./0/file0/file.cold", [pid 5871] <... umount2 resumed>) = -1 ENOENT (No such file or directory) [pid 5871] newfstatat(AT_FDCWD, "./0/file0/file0/?ile0", [pid 5870] <... newfstatat resumed>{st_mode=S_IFREG|0370, st_size=100, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5869] umount2("./0/file0/file0/?ile0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5868] umount2("./0/file0/file0/?ile0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5871] <... newfstatat resumed>0x7ffdec4903a0, AT_SYMLINK_NOFOLLOW) = -1 ENOENT (No such file or directory) [pid 5870] unlink("./0/file0/file.cold" [pid 5869] <... umount2 resumed>) = -1 ENOENT (No such file or directory) [pid 5870] <... unlink resumed>) = 0 [pid 5868] <... umount2 resumed>) = -1 ENOENT (No such file or directory) [pid 5870] umount2("./0/file0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5869] newfstatat(AT_FDCWD, "./0/file0/file0/?ile0", [pid 5871] exit_group(1 [pid 5870] <... umount2 resumed>) = 0 [pid 5869] <... newfstatat resumed>0x7ffdec4903a0, AT_SYMLINK_NOFOLLOW) = -1 ENOENT (No such file or directory) [pid 5871] <... exit_group resumed>) = ? [pid 5870] umount2("./0/file0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5869] exit_group(1 [pid 5871] +++ exited with 1 +++ [pid 5870] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5869] <... exit_group resumed>) = ? [pid 5868] newfstatat(AT_FDCWD, "./0/file0/file0/?ile0", [pid 5870] newfstatat(AT_FDCWD, "./0/file0/file0", [pid 5866] <... restart_syscall resumed>) = ? ERESTART_RESTARTBLOCK (Interrupted by signal) [pid 5866] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5871, si_uid=0, si_status=1, si_utime=0, si_stime=3 /* 0.03 s */} --- [pid 5866] restart_syscall(<... resuming interrupted restart_syscall ...> [pid 5870] <... newfstatat resumed>{st_mode=S_IFDIR|0370, st_size=16, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5869] +++ exited with 1 +++ [pid 5868] <... newfstatat resumed>0x7ffdec4903a0, AT_SYMLINK_NOFOLLOW) = -1 ENOENT (No such file or directory) [pid 5870] umount2("./0/file0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5866] <... restart_syscall resumed>) = ? ERESTART_RESTARTBLOCK (Interrupted by signal) [pid 5868] exit_group(1 [pid 5870] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5866] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5869, si_uid=0, si_status=1, si_utime=0, si_stime=0} --- [pid 5870] openat(AT_FDCWD, "./0/file0/file0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5868] <... exit_group resumed>) = ? [pid 5866] restart_syscall(<... resuming interrupted restart_syscall ...> [pid 5870] <... openat resumed>) = 5 [pid 5870] newfstatat(5, "", {st_mode=S_IFDIR|0370, st_size=16, ...}, AT_EMPTY_PATH) = 0 [pid 5868] +++ exited with 1 +++ [ 242.114891][ T5869] non-latin1 character 0x2e66 found in JFS file name [ 242.121635][ T5869] mount with iocharset=utf8 to access [ 242.129669][ T5871] mount with iocharset=utf8 to access [ 242.143374][ T5868] non-latin1 character 0x2e66 found in JFS file name [ 242.150166][ T5868] mount with iocharset=utf8 to access [pid 5866] <... restart_syscall resumed>) = ? ERESTART_RESTARTBLOCK (Interrupted by signal) [pid 5870] getdents64(5, [pid 5866] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5868, si_uid=0, si_status=1, si_utime=0, si_stime=0} --- [pid 5866] restart_syscall(<... resuming interrupted restart_syscall ...> [pid 5870] <... getdents64 resumed>0x5555891fd770 /* 4 entries */, 32768) = 112 [pid 5870] umount2("./0/file0/file0/?ile0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 ENOENT (No such file or directory) [pid 5870] newfstatat(AT_FDCWD, "./0/file0/file0/?ile0", 0x7ffdec4903a0, AT_SYMLINK_NOFOLLOW) = -1 ENOENT (No such file or directory) [pid 5870] exit_group(1) = ? [pid 5870] +++ exited with 1 +++ <... restart_syscall resumed>) = ? ERESTART_RESTARTBLOCK (Interrupted by signal) --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5870, si_uid=0, si_status=1, si_utime=0, si_stime=1 /* 0.01 s */} --- [ 242.185304][ T5870] non-latin1 character 0x2e66 found in JFS file name [ 242.192061][ T5870] mount with iocharset=utf8 to access [ 429.792397][ T31] INFO: task jfsCommit:113 blocked for more than 143 seconds. [ 429.799985][ T31] Not tainted 6.16.0-rc6-syzkaller-00281-gf4a40a4282f4 #0 [ 429.807757][ T31] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 429.816712][ T31] task:jfsCommit state:D stack:26888 pid:113 tgid:113 ppid:2 task_flags:0x200040 flags:0x00004000 [ 429.828787][ T31] Call Trace: [ 429.832236][ T31] [ 429.835190][ T31] __schedule+0x16a2/0x4cb0 [ 429.839732][ T31] ? __lock_acquire+0xab9/0xd20 [ 429.844635][ T31] ? schedule+0x165/0x360 [ 429.848989][ T31] ? __pfx___schedule+0x10/0x10 [ 429.853903][ T31] ? schedule+0x91/0x360 [ 429.858198][ T31] schedule+0x165/0x360 [ 429.862445][ T31] io_schedule+0x81/0xe0 [ 429.866719][ T31] lock_metapage+0x1f3/0x400 [ 429.871342][ T31] ? lock_metapage+0x10b/0x400 [ 429.876218][ T31] ? __pfx_lock_metapage+0x10/0x10 [ 429.881363][ T31] ? __pfx_default_wake_function+0x10/0x10 [ 429.887314][ T31] ? do_read_cache_folio+0x4c6/0x590 [ 429.892662][ T31] ? __pfx_metapage_read_folio+0x10/0x10 [ 429.898319][ T31] __get_metapage+0x497/0xde0 [ 429.903098][ T31] diIAGRead+0xce/0x140 [ 429.907309][ T31] diFree+0x983/0x2c40 [ 429.911402][ T31] ? __pfx_diFree+0x10/0x10 [ 429.916009][ T31] ? __dquot_initialize+0x218/0xcb0 [ 429.921234][ T31] ? jfs_free_zero_link+0x33a/0x4a0 [ 429.926734][ T31] ? __pfx_jfs_free_zero_link+0x10/0x10 [ 429.932463][ T31] jfs_evict_inode+0x331/0x440 [ 429.937284][ T31] ? evict+0x4f8/0x9c0 [ 429.941555][ T31] ? __pfx_jfs_evict_inode+0x10/0x10 [ 429.946948][ T31] evict+0x504/0x9c0 [ 429.950882][ T31] ? __pfx_evict+0x10/0x10 [ 429.955364][ T31] ? do_raw_spin_unlock+0x122/0x240 [ 429.960591][ T31] ? _raw_spin_unlock+0x28/0x50 [ 429.965493][ T31] ? iput+0x6d8/0x9d0 [ 429.969511][ T31] jfs_lazycommit+0x43f/0xa90 [ 429.974259][ T31] ? __pfx_jfs_lazycommit+0x10/0x10 [ 429.979475][ T31] ? __pfx_default_wake_function+0x10/0x10 [ 429.985437][ T31] ? __kthread_parkme+0x7b/0x200 [ 429.990415][ T31] ? __kthread_parkme+0x1a1/0x200 [ 429.995537][ T31] kthread+0x711/0x8a0 [ 429.999643][ T31] ? __pfx_jfs_lazycommit+0x10/0x10 [ 430.004904][ T31] ? __pfx_kthread+0x10/0x10 [ 430.009540][ T31] ? _raw_spin_unlock_irq+0x23/0x50 [ 430.014808][ T31] ? lockdep_hardirqs_on+0x9c/0x150 [ 430.020028][ T31] ? __pfx_kthread+0x10/0x10 [ 430.024806][ T31] ret_from_fork+0x3fc/0x770 [ 430.029526][ T31] ? __pfx_ret_from_fork+0x10/0x10 [ 430.034732][ T31] ? __switch_to_asm+0x39/0x70 [ 430.039528][ T31] ? __switch_to_asm+0x33/0x70 [ 430.044355][ T31] ? __pfx_kthread+0x10/0x10 [ 430.048991][ T31] ret_from_fork_asm+0x1a/0x30 [ 430.053876][ T31] [ 430.056962][ T31] INFO: task jfsCommit:114 blocked for more than 143 seconds. [ 430.064502][ T31] Not tainted 6.16.0-rc6-syzkaller-00281-gf4a40a4282f4 #0 [ 430.072219][ T31] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 430.081170][ T31] task:jfsCommit state:D stack:26856 pid:114 tgid:114 ppid:2 task_flags:0x200040 flags:0x00004000 [ 430.093198][ T31] Call Trace: [ 430.096516][ T31] [ 430.099456][ T31] __schedule+0x16a2/0x4cb0 [ 430.104027][ T31] ? __lock_acquire+0xab9/0xd20 [ 430.108903][ T31] ? schedule+0x165/0x360 [ 430.113290][ T31] ? __pfx___schedule+0x10/0x10 [ 430.118172][ T31] ? schedule+0x91/0x360 [ 430.122474][ T31] schedule+0x165/0x360 [ 430.126658][ T31] io_schedule+0x81/0xe0 [ 430.130897][ T31] lock_metapage+0x1f3/0x400 [ 430.135557][ T31] ? lock_metapage+0x10b/0x400 [ 430.140341][ T31] ? __pfx_lock_metapage+0x10/0x10 [ 430.145516][ T31] ? __pfx_default_wake_function+0x10/0x10 [ 430.151361][ T31] ? do_read_cache_folio+0x4c6/0x590 [ 430.156733][ T31] ? __pfx_metapage_read_folio+0x10/0x10 [ 430.162443][ T31] __get_metapage+0x497/0xde0 [ 430.167145][ T31] diIAGRead+0xce/0x140 [ 430.171386][ T31] diFree+0x983/0x2c40 [ 430.175555][ T31] ? __pfx_diFree+0x10/0x10 [ 430.180069][ T31] ? __dquot_initialize+0x218/0xcb0 [ 430.185351][ T31] ? jfs_free_zero_link+0x33a/0x4a0 [ 430.190774][ T31] ? __pfx_jfs_free_zero_link+0x10/0x10 [ 430.196888][ T31] jfs_evict_inode+0x331/0x440 [ 430.201711][ T31] ? evict+0x4f8/0x9c0 [ 430.205856][ T31] ? __pfx_jfs_evict_inode+0x10/0x10 [ 430.211180][ T31] evict+0x504/0x9c0 [ 430.215182][ T31] ? __pfx_evict+0x10/0x10 [ 430.219635][ T31] ? do_raw_spin_unlock+0x122/0x240 [ 430.224875][ T31] ? _raw_spin_unlock+0x28/0x50 [ 430.229749][ T31] ? iput+0x6d8/0x9d0 [ 430.233815][ T31] jfs_lazycommit+0x43f/0xa90 [ 430.238528][ T31] ? __pfx_jfs_lazycommit+0x10/0x10 [ 430.243806][ T31] ? __pfx_default_wake_function+0x10/0x10 [ 430.249645][ T31] ? __kthread_parkme+0x7b/0x200 [ 430.254663][ T31] ? __kthread_parkme+0x1a1/0x200 [ 430.259727][ T31] kthread+0x711/0x8a0 [ 430.263868][ T31] ? __pfx_jfs_lazycommit+0x10/0x10 [ 430.269183][ T31] ? __pfx_kthread+0x10/0x10 [ 430.273853][ T31] ? _raw_spin_unlock_irq+0x23/0x50 [ 430.279087][ T31] ? lockdep_hardirqs_on+0x9c/0x150 [ 430.284419][ T31] ? __pfx_kthread+0x10/0x10 [ 430.289057][ T31] ret_from_fork+0x3fc/0x770 [ 430.293725][ T31] ? __pfx_ret_from_fork+0x10/0x10 [ 430.298862][ T31] ? __switch_to_asm+0x39/0x70 [ 430.303684][ T31] ? __switch_to_asm+0x33/0x70 [ 430.308493][ T31] ? __pfx_kthread+0x10/0x10 [ 430.313168][ T31] ret_from_fork_asm+0x1a/0x30 [ 430.317979][ T31] [ 430.321080][ T31] [ 430.321080][ T31] Showing all locks held in the system: [ 430.328931][ T31] 5 locks held by kworker/u8:0/12: [ 430.334111][ T31] 1 lock held by khungtaskd/31: [ 430.338974][ T31] #0: ffffffff8e13f0e0 (rcu_read_lock){....}-{1:3}, at: debug_show_all_locks+0x2e/0x180 [ 430.348915][ T31] 2 locks held by jfsCommit/113: [ 430.353905][ T31] #0: ffff888033868920 (&(imap->im_aglock[index])){+.+.}-{4:4}, at: diFree+0x29f/0x2c40 [ 430.363833][ T31] #1: ffff88807655dd68 (&jfs_ip->rdwrlock/1){.+.+}-{4:4}, at: diFree+0x2bd/0x2c40 [ 430.373252][ T31] 2 locks held by jfsCommit/114: [ 430.378194][ T31] #0: ffff88807db70920 (&(imap->im_aglock[index])){+.+.}-{4:4}, at: diFree+0x29f/0x2c40 [ 430.388098][ T31] #1: ffff88807655a618 (&jfs_ip->rdwrlock/1){.+.+}-{4:4}, at: diFree+0x2bd/0x2c40 [ 430.397551][ T31] 2 locks held by getty/5594: [ 430.402285][ T31] #0: ffff8880353620a0 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x25/0x70 [ 430.412092][ T31] #1: ffffc9000333b2f0 (&ldata->atomic_read_lock){+.+.}-{4:4}, at: n_tty_read+0x43e/0x1400 [ 430.422405][ T31] [ 430.424743][ T31] ============================================= [ 430.424743][ T31] [ 430.433234][ T31] NMI backtrace for cpu 1 [ 430.433256][ T31] CPU: 1 UID: 0 PID: 31 Comm: khungtaskd Not tainted 6.16.0-rc6-syzkaller-00281-gf4a40a4282f4 #0 PREEMPT(full) [ 430.433279][ T31] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 05/07/2025 [ 430.433291][ T31] Call Trace: [ 430.433299][ T31] [ 430.433307][ T31] dump_stack_lvl+0x189/0x250 [ 430.433331][ T31] ? __wake_up_klogd+0xd9/0x110 [ 430.433362][ T31] ? __pfx_dump_stack_lvl+0x10/0x10 [ 430.433384][ T31] ? __pfx__printk+0x10/0x10 [ 430.433424][ T31] nmi_cpu_backtrace+0x39e/0x3d0 [ 430.433460][ T31] ? __pfx_nmi_cpu_backtrace+0x10/0x10 [ 430.433497][ T31] ? _printk+0xcf/0x120 [ 430.433527][ T31] ? __pfx__printk+0x10/0x10 [ 430.433555][ T31] ? __pfx_nmi_raise_cpu_backtrace+0x10/0x10 [ 430.433590][ T31] nmi_trigger_cpumask_backtrace+0x17a/0x300 [ 430.433625][ T31] watchdog+0xfee/0x1030 [ 430.433658][ T31] ? watchdog+0x1de/0x1030 [ 430.433698][ T31] kthread+0x711/0x8a0 [ 430.433730][ T31] ? __pfx_watchdog+0x10/0x10 [ 430.433759][ T31] ? __pfx_kthread+0x10/0x10 [ 430.433790][ T31] ? _raw_spin_unlock_irq+0x23/0x50 [ 430.433824][ T31] ? lockdep_hardirqs_on+0x9c/0x150 [ 430.433843][ T31] ? __pfx_kthread+0x10/0x10 [ 430.433872][ T31] ret_from_fork+0x3fc/0x770 [ 430.433896][ T31] ? __pfx_ret_from_fork+0x10/0x10 [ 430.433923][ T31] ? __switch_to_asm+0x39/0x70 [ 430.433948][ T31] ? __switch_to_asm+0x33/0x70 [ 430.433972][ T31] ? __pfx_kthread+0x10/0x10 [ 430.434001][ T31] ret_from_fork_asm+0x1a/0x30 [ 430.434043][ T31] [ 430.434051][ T31] Sending NMI from CPU 1 to CPUs 0: [ 430.591620][ C0] NMI backtrace for cpu 0 [ 430.591638][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Not tainted 6.16.0-rc6-syzkaller-00281-gf4a40a4282f4 #0 PREEMPT(full) [ 430.591659][ C0] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 05/07/2025 [ 430.591670][ C0] RIP: 0010:pv_native_safe_halt+0x13/0x20 [ 430.591695][ C0] Code: 93 de 02 00 cc cc cc 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 f3 0f 1e fa 66 90 0f 00 2d d3 bd 21 00 f3 0f 1e fa fb f4 cc cc cc cc cc cc cc cc cc cc cc cc 90 90 90 90 90 90 90 90 90 [ 430.591711][ C0] RSP: 0018:ffffffff8de07d80 EFLAGS: 000002c2 [ 430.591728][ C0] RAX: d47f5fb47ac93300 RBX: ffffffff81976938 RCX: d47f5fb47ac93300 [ 430.591749][ C0] RDX: 0000000000000001 RSI: ffffffff8d982a65 RDI: ffffffff8be1ba00 [ 430.591762][ C0] RBP: ffffffff8de07ea8 R08: ffff8880b8632f5b R09: 1ffff110170c65eb [ 430.591776][ C0] R10: dffffc0000000000 R11: ffffed10170c65ec R12: ffffffff8fa0b2f0 [ 430.591789][ C0] R13: 0000000000000000 R14: 0000000000000000 R15: 1ffffffff1bd2a50 [ 430.591801][ C0] FS: 0000000000000000(0000) GS:ffff888125c57000(0000) knlGS:0000000000000000 [ 430.591816][ C0] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 430.591828][ C0] CR2: 00005636fc642168 CR3: 000000000df38000 CR4: 00000000003526f0 [ 430.591844][ C0] Call Trace: [ 430.591853][ C0] [ 430.591860][ C0] default_idle+0x13/0x20 [ 430.591882][ C0] default_idle_call+0x74/0xb0 [ 430.591906][ C0] do_idle+0x1e8/0x510 [ 430.591930][ C0] ? __pfx_do_idle+0x10/0x10 [ 430.591949][ C0] ? lockdep_hardirqs_on+0x9c/0x150 [ 430.591968][ C0] ? _raw_spin_unlock_irqrestore+0xad/0x110 [ 430.591998][ C0] ? __pfx__raw_spin_unlock_irqrestore+0x10/0x10 [ 430.592042][ C0] cpu_startup_entry+0x44/0x60 [ 430.592061][ C0] rest_init+0x2de/0x300 [ 430.592083][ C0] ? __pfx_x86_late_time_init+0x10/0x10 [ 430.592125][ C0] start_kernel+0x47d/0x500 [ 430.592147][ C0] x86_64_start_reservations+0x24/0x30 [ 430.592175][ C0] x86_64_start_kernel+0x143/0x1c0 [ 430.592202][ C0] common_startup_64+0x13e/0x147 [ 430.592237][ C0] [ 430.592610][ T31] Kernel panic - not syncing: hung_task: blocked tasks [ 430.592633][ T31] CPU: 1 UID: 0 PID: 31 Comm: khungtaskd Not tainted 6.16.0-rc6-syzkaller-00281-gf4a40a4282f4 #0 PREEMPT(full) [ 430.592661][ T31] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 05/07/2025 [ 430.592676][ T31] Call Trace: [ 430.592686][ T31] [ 430.592697][ T31] dump_stack_lvl+0x99/0x250 [ 430.592728][ T31] ? __asan_memcpy+0x40/0x70 [ 430.592760][ T31] ? __pfx_dump_stack_lvl+0x10/0x10 [ 430.592787][ T31] ? __pfx__printk+0x10/0x10 [ 430.592833][ T31] panic+0x2db/0x790 [ 430.592856][ T31] ? lockdep_hardirqs_on+0x9c/0x150 [ 430.592888][ T31] ? __pfx_panic+0x10/0x10 [ 430.592911][ T31] ? __pfx_delay_tsc+0x10/0x10 [ 430.592944][ T31] ? nmi_backtrace_stall_check+0x433/0x440 [ 430.592978][ T31] ? irq_work_queue+0xbc/0x140 [ 430.593024][ T31] watchdog+0x102d/0x1030 [ 430.593062][ T31] ? watchdog+0x1de/0x1030 [ 430.593106][ T31] kthread+0x711/0x8a0 [ 430.593141][ T31] ? __pfx_watchdog+0x10/0x10 [ 430.593175][ T31] ? __pfx_kthread+0x10/0x10 [ 430.593209][ T31] ? _raw_spin_unlock_irq+0x23/0x50 [ 430.593246][ T31] ? lockdep_hardirqs_on+0x9c/0x150 [ 430.593268][ T31] ? __pfx_kthread+0x10/0x10 [ 430.593301][ T31] ret_from_fork+0x3fc/0x770 [ 430.593328][ T31] ? __pfx_ret_from_fork+0x10/0x10 [ 430.593359][ T31] ? __switch_to_asm+0x39/0x70 [ 430.593387][ T31] ? __switch_to_asm+0x33/0x70 [ 430.593415][ T31] ? __pfx_kthread+0x10/0x10 [ 430.593448][ T31] ret_from_fork_asm+0x1a/0x30 [ 430.593503][ T31] [ 430.944417][ T31] Kernel Offset: disabled [ 430.948751][ T31] Rebooting in 86400 seconds..