./strace-static-x86_64 -e \!wait4,clock_nanosleep,nanosleep -s 100 -x -f ./syz-executor1474714889 <...> Warning: Permanently added '10.128.0.156' (ED25519) to the list of known hosts. execve("./syz-executor1474714889", ["./syz-executor1474714889"], 0x7ffe148b1510 /* 10 vars */) = 0 brk(NULL) = 0x55556d80a000 brk(0x55556d80ad00) = 0x55556d80ad00 arch_prctl(ARCH_SET_FS, 0x55556d80a380) = 0 set_tid_address(0x55556d80a650) = 5075 set_robust_list(0x55556d80a660, 24) = 0 rseq(0x55556d80aca0, 0x20, 0, 0x53053053) = 0 prlimit64(0, RLIMIT_STACK, NULL, {rlim_cur=8192*1024, rlim_max=RLIM64_INFINITY}) = 0 readlink("/proc/self/exe", "/root/syz-executor1474714889", 4096) = 28 getrandom("\xe4\x6d\x9d\x5c\xe9\x0c\x82\xfe", 8, GRND_NONBLOCK) = 8 brk(NULL) = 0x55556d80ad00 brk(0x55556d82bd00) = 0x55556d82bd00 brk(0x55556d82c000) = 0x55556d82c000 mprotect(0x7f24d5856000, 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 getpid() = 5075 openat(AT_FDCWD, "/sys/kernel/debug/x86/nmi_longest_ns", O_WRONLY|O_CLOEXEC) = 3 write(3, "10000000000", 11) = 11 close(3) = 0 openat(AT_FDCWD, "/proc/sys/kernel/hung_task_check_interval_secs", O_WRONLY|O_CLOEXEC) = 3 write(3, "20", 2) = 2 close(3) = 0 openat(AT_FDCWD, "/proc/sys/net/core/bpf_jit_kallsyms", O_WRONLY|O_CLOEXEC) = 3 write(3, "1", 1) = 1 close(3) = 0 openat(AT_FDCWD, "/proc/sys/net/core/bpf_jit_harden", O_WRONLY|O_CLOEXEC) = 3 write(3, "0", 1) = 1 close(3) = 0 openat(AT_FDCWD, "/proc/sys/kernel/kptr_restrict", O_WRONLY|O_CLOEXEC) = 3 write(3, "0", 1) = 1 close(3) = 0 openat(AT_FDCWD, "/proc/sys/kernel/softlockup_all_cpu_backtrace", O_WRONLY|O_CLOEXEC) = 3 write(3, "1", 1) = 1 close(3) = 0 openat(AT_FDCWD, "/proc/sys/fs/mount-max", O_WRONLY|O_CLOEXEC) = 3 write(3, "100", 3) = 3 close(3) = 0 openat(AT_FDCWD, "/proc/sys/vm/oom_dump_tasks", O_WRONLY|O_CLOEXEC) = 3 write(3, "0", 1) = 1 close(3) = 0 openat(AT_FDCWD, "/proc/sys/debug/exception-trace", O_WRONLY|O_CLOEXEC) = 3 write(3, "0", 1) = 1 close(3) = 0 openat(AT_FDCWD, "/proc/sys/kernel/printk", O_WRONLY|O_CLOEXEC) = 3 write(3, "7 4 1 3", 7) = 7 close(3) = 0 openat(AT_FDCWD, "/proc/sys/kernel/keys/gc_delay", O_WRONLY|O_CLOEXEC) = 3 write(3, "1", 1) = 1 close(3) = 0 openat(AT_FDCWD, "/proc/sys/vm/oom_kill_allocating_task", O_WRONLY|O_CLOEXEC) = 3 write(3, "1", 1) = 1 close(3) = 0 openat(AT_FDCWD, "/proc/sys/kernel/ctrl-alt-del", O_WRONLY|O_CLOEXEC) = 3 write(3, "0", 1) = 1 close(3) = 0 openat(AT_FDCWD, "/proc/sys/kernel/cad_pid", O_WRONLY|O_CLOEXEC) = 3 write(3, "5075", 4) = 4 close(3) = 0 clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x55556d80a650) = 5076 ./strace-static-x86_64: Process 5076 attached [pid 5075] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5076] set_robust_list(0x55556d80a660, 24) = 0 ./strace-static-x86_64: Process 5077 attached [pid 5075] <... clone resumed>, child_tidptr=0x55556d80a650) = 5077 [pid 5077] set_robust_list(0x55556d80a660, 24 [pid 5075] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5076] mkdir("./syzkaller.FQ5Fcn", 0700 [pid 5077] <... set_robust_list resumed>) = 0 ./strace-static-x86_64: Process 5078 attached [pid 5075] <... clone resumed>, child_tidptr=0x55556d80a650) = 5078 [pid 5078] set_robust_list(0x55556d80a660, 24 [pid 5077] mkdir("./syzkaller.pXhFTS", 0700 [pid 5076] <... mkdir resumed>) = 0 [pid 5078] <... set_robust_list resumed>) = 0 [pid 5076] chmod("./syzkaller.FQ5Fcn", 0777 [pid 5075] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5076] <... chmod resumed>) = 0 [pid 5076] chdir("./syzkaller.FQ5Fcn"./strace-static-x86_64: Process 5079 attached [pid 5078] mkdir("./syzkaller.bMUJYI", 0700 [pid 5077] <... mkdir resumed>) = 0 [pid 5075] <... clone resumed>, child_tidptr=0x55556d80a650) = 5079 [pid 5079] set_robust_list(0x55556d80a660, 24 [pid 5077] chmod("./syzkaller.pXhFTS", 0777 [pid 5076] <... chdir resumed>) = 0 [pid 5079] <... set_robust_list resumed>) = 0 [pid 5077] <... chmod resumed>) = 0 [pid 5076] mkdir("./0", 0777 [pid 5079] mkdir("./syzkaller.sLjD5D", 0700 [pid 5075] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5077] chdir("./syzkaller.pXhFTS" [pid 5076] <... mkdir resumed>) = 0 [pid 5077] <... chdir resumed>) = 0 [pid 5079] <... mkdir resumed>) = 0 [pid 5078] <... mkdir resumed>) = 0 [pid 5078] chmod("./syzkaller.bMUJYI", 0777 [pid 5077] mkdir("./0", 0777 [pid 5078] <... chmod resumed>) = 0 [pid 5077] <... mkdir resumed>) = 0 [pid 5079] chmod("./syzkaller.sLjD5D", 0777 [pid 5078] chdir("./syzkaller.bMUJYI"./strace-static-x86_64: Process 5080 attached ) = 0 [pid 5075] <... clone resumed>, child_tidptr=0x55556d80a650) = 5080 [pid 5079] <... chmod resumed>) = 0 [pid 5078] mkdir("./0", 0777 [pid 5077] openat(AT_FDCWD, "/dev/loop1", O_RDWR [pid 5076] openat(AT_FDCWD, "/dev/loop0", O_RDWR [pid 5080] set_robust_list(0x55556d80a660, 24 [pid 5079] chdir("./syzkaller.sLjD5D" [pid 5077] <... openat resumed>) = 3 [pid 5076] <... openat resumed>) = 3 [pid 5080] <... set_robust_list resumed>) = 0 [pid 5079] <... chdir resumed>) = 0 [pid 5079] mkdir("./0", 0777 [pid 5080] mkdir("./syzkaller.VwcTtG", 0700 [pid 5079] <... mkdir resumed>) = 0 [pid 5078] <... mkdir resumed>) = 0 [pid 5077] ioctl(3, LOOP_CLR_FD [pid 5076] ioctl(3, LOOP_CLR_FD [pid 5080] <... mkdir resumed>) = 0 [pid 5077] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5076] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5078] openat(AT_FDCWD, "/dev/loop2", O_RDWR [pid 5079] openat(AT_FDCWD, "/dev/loop3", O_RDWR [pid 5080] chmod("./syzkaller.VwcTtG", 0777 [pid 5079] <... openat resumed>) = 3 [pid 5077] close(3 [pid 5076] close(3 [pid 5080] <... chmod resumed>) = 0 [pid 5079] ioctl(3, LOOP_CLR_FD [pid 5078] <... openat resumed>) = 3 [pid 5077] <... close resumed>) = 0 [pid 5076] <... close resumed>) = 0 [pid 5079] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5077] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5079] close(3 [pid 5076] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5079] <... close resumed>) = 0 [pid 5079] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5076] <... clone resumed>, child_tidptr=0x55556d80a650) = 5082 [pid 5079] <... clone resumed>, child_tidptr=0x55556d80a650) = 5083 ./strace-static-x86_64: Process 5083 attached [pid 5083] set_robust_list(0x55556d80a660, 24./strace-static-x86_64: Process 5081 attached ) = 0 [pid 5077] <... clone resumed>, child_tidptr=0x55556d80a650) = 5081 [pid 5081] set_robust_list(0x55556d80a660, 24 [pid 5083] chdir("./0" [pid 5078] ioctl(3, LOOP_CLR_FD [pid 5081] <... set_robust_list resumed>) = 0 [pid 5080] chdir("./syzkaller.VwcTtG"./strace-static-x86_64: Process 5082 attached [pid 5081] chdir("./0" [pid 5083] <... chdir resumed>) = 0 [pid 5078] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5078] close(3 [pid 5083] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5082] set_robust_list(0x55556d80a660, 24 [pid 5080] <... chdir resumed>) = 0 [pid 5078] <... close resumed>) = 0 [pid 5081] <... chdir resumed>) = 0 [pid 5083] <... prctl resumed>) = 0 [pid 5078] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5081] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5083] setpgid(0, 0 [pid 5080] mkdir("./0", 0777 [pid 5081] <... prctl resumed>) = 0 [pid 5083] <... setpgid resumed>) = 0 [pid 5081] setpgid(0, 0 [pid 5083] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5081] <... setpgid resumed>) = 0 [pid 5081] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5083] <... openat resumed>) = 3 [pid 5080] <... mkdir resumed>) = 0 [pid 5080] openat(AT_FDCWD, "/dev/loop4", O_RDWR [pid 5078] <... clone resumed>, child_tidptr=0x55556d80a650) = 5084 [pid 5082] <... set_robust_list resumed>) = 0 [pid 5081] <... openat resumed>) = 3 [pid 5083] write(3, "1000", 4) = 4 [pid 5081] write(3, "1000", 4 [pid 5083] close(3 [pid 5081] <... write resumed>) = 4 [pid 5083] <... close resumed>) = 0 [pid 5081] close(3 [pid 5083] symlink("/dev/binderfs", "./binderfs" [pid 5081] <... close resumed>) = 0 [pid 5083] <... symlink resumed>) = 0 [pid 5082] chdir("./0") = 0 [pid 5080] <... openat resumed>) = 3 ./strace-static-x86_64: Process 5084 attached [pid 5081] symlink("/dev/binderfs", "./binderfs" [pid 5083] memfd_create("syzkaller", 0 [pid 5082] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5080] ioctl(3, LOOP_CLR_FD [pid 5084] set_robust_list(0x55556d80a660, 24 [pid 5082] <... prctl resumed>) = 0 [pid 5080] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5082] setpgid(0, 0 [pid 5084] <... set_robust_list resumed>) = 0 [pid 5082] <... setpgid resumed>) = 0 [pid 5080] close(3 [pid 5084] chdir("./0" [pid 5083] <... memfd_create resumed>) = 3 [pid 5082] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5080] <... close resumed>) = 0 [pid 5084] <... chdir resumed>) = 0 [pid 5081] <... symlink resumed>) = 0 [pid 5083] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5082] <... openat resumed>) = 3 [pid 5080] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5084] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5083] <... mmap resumed>) = 0x7f24cd200000 [pid 5084] <... prctl resumed>) = 0 [pid 5082] write(3, "1000", 4 [pid 5084] setpgid(0, 0 [pid 5081] memfd_create("syzkaller", 0 [pid 5082] <... write resumed>) = 4 [pid 5084] <... setpgid resumed>) = 0 [pid 5082] close(3 [pid 5084] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5081] <... memfd_create resumed>) = 3 [pid 5080] <... clone resumed>, child_tidptr=0x55556d80a650) = 5086 [pid 5082] <... close resumed>) = 0 [pid 5082] symlink("/dev/binderfs", "./binderfs") = 0 [pid 5082] memfd_create("syzkaller", 0./strace-static-x86_64: Process 5086 attached [pid 5086] set_robust_list(0x55556d80a660, 24) = 0 [pid 5082] <... memfd_create resumed>) = 3 [pid 5086] chdir("./0" [pid 5082] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5086] <... chdir resumed>) = 0 [pid 5082] <... mmap resumed>) = 0x7f24cd200000 [pid 5086] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5084] <... openat resumed>) = 3 [pid 5081] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5086] <... prctl resumed>) = 0 [pid 5081] <... mmap resumed>) = 0x7f24cd200000 [pid 5086] setpgid(0, 0) = 0 [pid 5086] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5084] write(3, "1000", 4 [pid 5086] <... openat resumed>) = 3 [pid 5084] <... write resumed>) = 4 [pid 5084] close(3 [pid 5086] write(3, "1000", 4 [pid 5084] <... close resumed>) = 0 [pid 5086] <... write resumed>) = 4 [pid 5086] close(3) = 0 [pid 5084] symlink("/dev/binderfs", "./binderfs" [pid 5086] symlink("/dev/binderfs", "./binderfs") = 0 [pid 5084] <... symlink resumed>) = 0 [pid 5086] memfd_create("syzkaller", 0 [pid 5084] memfd_create("syzkaller", 0 [pid 5086] <... memfd_create resumed>) = 3 [pid 5086] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f24cd200000 [pid 5084] <... memfd_create resumed>) = 3 [pid 5084] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f24cd200000 [pid 5082] 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 5083] 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 5081] 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 5086] 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 5084] 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 5082] <... write resumed>) = 16777216 [pid 5082] munmap(0x7f24cd200000, 138412032 [pid 5083] <... write resumed>) = 16777216 [pid 5083] munmap(0x7f24cd200000, 138412032 [pid 5082] <... munmap resumed>) = 0 [pid 5081] <... write resumed>) = 16777216 [pid 5081] munmap(0x7f24cd200000, 138412032 [pid 5082] openat(AT_FDCWD, "/dev/loop0", O_RDWR) = 4 [pid 5082] ioctl(4, LOOP_SET_FD, 3 [pid 5086] <... write resumed>) = 16777216 [pid 5084] <... write resumed>) = 16777216 [pid 5083] <... munmap resumed>) = 0 [pid 5084] munmap(0x7f24cd200000, 138412032 [pid 5086] munmap(0x7f24cd200000, 138412032 [pid 5083] openat(AT_FDCWD, "/dev/loop3", O_RDWR [pid 5082] <... ioctl resumed>) = 0 [pid 5082] close(3) = 0 [pid 5083] <... openat resumed>) = 4 [pid 5082] close(4 [pid 5084] <... munmap resumed>) = 0 [pid 5081] <... munmap resumed>) = 0 [pid 5086] <... munmap resumed>) = 0 [pid 5084] openat(AT_FDCWD, "/dev/loop2", O_RDWR [pid 5083] ioctl(4, LOOP_SET_FD, 3 [pid 5082] <... close resumed>) = 0 [pid 5086] openat(AT_FDCWD, "/dev/loop4", O_RDWR [pid 5084] <... openat resumed>) = 4 [pid 5081] openat(AT_FDCWD, "/dev/loop1", O_RDWR [pid 5086] <... openat resumed>) = 4 [pid 5084] ioctl(4, LOOP_SET_FD, 3 [pid 5081] <... openat resumed>) = 4 [pid 5082] mkdir("./file0", 0777 [pid 5086] ioctl(4, LOOP_SET_FD, 3 [pid 5082] <... mkdir resumed>) = 0 [pid 5081] ioctl(4, LOOP_SET_FD, 3 [pid 5084] <... ioctl resumed>) = 0 [pid 5083] <... ioctl resumed>) = 0 [ 73.486996][ T5082] loop0: detected capacity change from 0 to 32768 [ 73.524250][ T5083] loop3: detected capacity change from 0 to 32768 [ 73.527371][ T5084] loop2: detected capacity change from 0 to 32768 [pid 5084] close(3 [pid 5081] <... ioctl resumed>) = 0 [pid 5083] close(3 [pid 5084] <... close resumed>) = 0 [pid 5081] close(3 [pid 5083] <... close resumed>) = 0 [pid 5084] close(4 [pid 5081] <... close resumed>) = 0 [pid 5083] close(4 [pid 5086] <... ioctl resumed>) = 0 [pid 5084] <... close resumed>) = 0 [pid 5083] <... close resumed>) = 0 [pid 5082] mount("/dev/loop0", "./file0", "jfs", MS_NOSUID, "quota,iocharset=cp1250,nodiscard,gid=0x000000000000ee00,discard=0x0000000000000009,errors=continue,q"... [pid 5084] mkdir("./file0", 0777 [pid 5081] close(4 [pid 5083] mkdir("./file0", 0777 [pid 5086] close(3 [pid 5084] <... mkdir resumed>) = 0 [pid 5081] <... close resumed>) = 0 [pid 5083] <... mkdir resumed>) = 0 [pid 5083] mount("/dev/loop3", "./file0", "jfs", MS_NOSUID, "quota,iocharset=cp1250,nodiscard,gid=0x000000000000ee00,discard=0x0000000000000009,errors=continue,q"... [pid 5086] <... close resumed>) = 0 [pid 5081] mkdir("./file0", 0777 [pid 5086] close(4) = 0 [pid 5084] mount("/dev/loop2", "./file0", "jfs", MS_NOSUID, "quota,iocharset=cp1250,nodiscard,gid=0x000000000000ee00,discard=0x0000000000000009,errors=continue,q"... [pid 5081] <... mkdir resumed>) = 0 [pid 5086] mkdir("./file0", 0777) = 0 [pid 5081] mount("/dev/loop1", "./file0", "jfs", MS_NOSUID, "quota,iocharset=cp1250,nodiscard,gid=0x000000000000ee00,discard=0x0000000000000009,errors=continue,q"... [pid 5083] <... mount resumed>) = 0 [pid 5082] <... mount resumed>) = 0 [pid 5082] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY [pid 5086] mount("/dev/loop4", "./file0", "jfs", MS_NOSUID, "quota,iocharset=cp1250,nodiscard,gid=0x000000000000ee00,discard=0x0000000000000009,errors=continue,q"... [pid 5082] <... openat resumed>) = 3 [pid 5084] <... mount resumed>) = 0 [pid 5083] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY [pid 5082] chdir("./file0" [ 73.540752][ T5081] loop1: detected capacity change from 0 to 32768 [ 73.541669][ T5086] loop4: detected capacity change from 0 to 32768 [pid 5084] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY [pid 5083] <... openat resumed>) = 3 [pid 5082] <... chdir resumed>) = 0 [pid 5082] openat(AT_FDCWD, "/dev/loop0", O_RDWR [pid 5084] <... openat resumed>) = 3 [pid 5083] chdir("./file0" [pid 5082] <... openat resumed>) = -1 EBUSY (Device or resource busy) [pid 5084] chdir("./file0" [pid 5083] <... chdir resumed>) = 0 [pid 5084] <... chdir resumed>) = 0 [pid 5083] openat(AT_FDCWD, "/dev/loop3", O_RDWR [pid 5082] chdir("./file0" [pid 5084] openat(AT_FDCWD, "/dev/loop2", O_RDWR [pid 5083] <... openat resumed>) = -1 EBUSY (Device or resource busy) [pid 5084] <... openat resumed>) = -1 EBUSY (Device or resource busy) [pid 5083] chdir("./file0" [pid 5084] chdir("./file0" [pid 5083] <... chdir resumed>) = 0 [pid 5086] <... mount resumed>) = 0 [pid 5084] <... chdir resumed>) = 0 [pid 5083] rename("./file0", "./file3" [pid 5086] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY [pid 5084] rename("./file0", "./file3" [pid 5082] <... chdir resumed>) = 0 [pid 5086] <... openat resumed>) = 3 [pid 5086] chdir("./file0" [pid 5082] rename("./file0", "./file3" [pid 5086] <... chdir resumed>) = 0 [pid 5086] openat(AT_FDCWD, "/dev/loop4", O_RDWR) = -1 EBUSY (Device or resource busy) [pid 5081] <... mount resumed>) = 0 [ 73.618506][ T5084] find_entry called with index = 0 [ 73.624617][ T5084] read_mapping_page failed! [ 73.631660][ T5083] find_entry called with index = 0 [ 73.633039][ T5082] find_entry called with index = 0 [ 73.650760][ T5082] read_mapping_page failed! [ 73.657777][ T5086] find_entry called with index = 0 [ 73.663190][ T5086] read_mapping_page failed! [pid 5086] chdir("./file0") = 0 [pid 5081] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY [pid 5086] rename("./file0", "./file3" [pid 5081] <... openat resumed>) = 3 [pid 5081] chdir("./file0") = 0 [pid 5081] openat(AT_FDCWD, "/dev/loop1", O_RDWR) = -1 EBUSY (Device or resource busy) [pid 5081] chdir("./file0") = 0 [pid 5081] rename("./file0", "./file3" [pid 5084] <... rename resumed>) = -1 EIO (Input/output error) [pid 5082] <... rename resumed>) = -1 EIO (Input/output error) [pid 5084] openat(AT_FDCWD, "./file0", O_RDONLY [pid 5082] openat(AT_FDCWD, "./file0", O_RDONLY [pid 5084] <... openat resumed>) = 4 [pid 5084] exit_group(0 [pid 5082] <... openat resumed>) = 4 [ 73.668198][ T5083] read_mapping_page failed! [ 73.672947][ T5083] ERROR: (device loop3): txCommit: [ 73.672947][ T5083] [ 73.676048][ T5082] ERROR: (device loop0): txCommit: [ 73.676048][ T5082] [ 73.683331][ T5081] find_entry called with index = 0 [ 73.689471][ T5084] ERROR: (device loop2): txCommit: [ 73.689471][ T5084] [ 73.698510][ T5081] read_mapping_page failed! [pid 5084] <... exit_group resumed>) = ? [pid 5082] exit_group(0 [pid 5083] <... rename resumed>) = -1 EIO (Input/output error) [pid 5082] <... exit_group resumed>) = ? [pid 5083] openat(AT_FDCWD, "./file0", O_RDONLY [pid 5082] +++ exited with 0 +++ [pid 5076] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5082, si_uid=0, si_status=0, si_utime=6 /* 0.06 s */, si_stime=34 /* 0.34 s */} --- [pid 5084] +++ exited with 0 +++ [pid 5083] <... openat resumed>) = 4 [pid 5078] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5084, si_uid=0, si_status=0, si_utime=7 /* 0.07 s */, si_stime=28 /* 0.28 s */} --- [pid 5076] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5086] <... rename resumed>) = -1 EIO (Input/output error) [pid 5076] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5086] openat(AT_FDCWD, "./file0", O_RDONLY [pid 5083] exit_group(0 [pid 5076] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5078] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5083] <... exit_group resumed>) = ? [pid 5078] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5076] <... openat resumed>) = 3 [pid 5078] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5076] newfstatat(3, "", [pid 5086] <... openat resumed>) = 4 [pid 5083] +++ exited with 0 +++ [pid 5078] <... openat resumed>) = 3 [pid 5076] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5079] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5083, si_uid=0, si_status=0, si_utime=1 /* 0.01 s */, si_stime=38 /* 0.38 s */} --- [pid 5086] exit_group(0 [pid 5078] newfstatat(3, "", [pid 5076] getdents64(3, [pid 5086] <... exit_group resumed>) = ? [pid 5076] <... getdents64 resumed>0x55556d80b6f0 /* 4 entries */, 32768) = 112 [pid 5086] +++ exited with 0 +++ [pid 5079] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5078] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5076] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5080] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5086, si_uid=0, si_status=0, si_utime=2 /* 0.02 s */, si_stime=34 /* 0.34 s */} --- [pid 5079] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5080] restart_syscall(<... resuming interrupted clone ...> [pid 5079] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5076] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [ 73.730385][ T5086] ERROR: (device loop4): txCommit: [ 73.730385][ T5086] [ 73.748266][ T5081] ERROR: (device loop1): txCommit: [ 73.748266][ T5081] [pid 5081] <... rename resumed>) = -1 EIO (Input/output error) [pid 5080] <... restart_syscall resumed>) = 0 [pid 5079] <... openat resumed>) = 3 [pid 5078] getdents64(3, [pid 5076] newfstatat(AT_FDCWD, "./0/binderfs", [pid 5079] newfstatat(3, "", [pid 5076] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5079] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5076] unlink("./0/binderfs" [pid 5080] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5076] <... unlink resumed>) = 0 [pid 5079] getdents64(3, [pid 5076] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5080] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5079] <... getdents64 resumed>0x55556d80b6f0 /* 4 entries */, 32768) = 112 [pid 5080] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 5078] <... getdents64 resumed>0x55556d80b6f0 /* 4 entries */, 32768) = 112 [pid 5078] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5078] newfstatat(AT_FDCWD, "./0/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5078] unlink("./0/binderfs") = 0 [pid 5080] newfstatat(3, "", [pid 5079] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5081] openat(AT_FDCWD, "./file0", O_RDONLY [pid 5080] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5079] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5078] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5080] getdents64(3, [pid 5079] newfstatat(AT_FDCWD, "./0/binderfs", [pid 5080] <... getdents64 resumed>0x55556d80b6f0 /* 4 entries */, 32768) = 112 [pid 5079] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5081] <... openat resumed>) = 4 [pid 5080] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5079] unlink("./0/binderfs" [pid 5081] exit_group(0 [pid 5080] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5079] <... unlink resumed>) = 0 [pid 5080] newfstatat(AT_FDCWD, "./0/binderfs", [pid 5081] <... exit_group resumed>) = ? [pid 5079] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5080] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5081] +++ exited with 0 +++ [pid 5080] unlink("./0/binderfs" [pid 5077] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5081, si_uid=0, si_status=0, si_utime=3 /* 0.03 s */, si_stime=29 /* 0.29 s */} --- [pid 5080] <... unlink resumed>) = 0 [pid 5077] restart_syscall(<... resuming interrupted clone ...> [pid 5080] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5077] <... restart_syscall resumed>) = 0 [pid 5077] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5077] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 5077] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5077] getdents64(3, 0x55556d80b6f0 /* 4 entries */, 32768) = 112 [pid 5077] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5077] newfstatat(AT_FDCWD, "./0/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5077] unlink("./0/binderfs") = 0 [ 87.008624][ T783] cfg80211: failed to load regulatory.db [ 127.806785][ T5076] jfs_flush_journal: synclist not empty [ 127.812599][ T5076] metapage: ffff888023b8a9b0: 00001000 00000000 00003a48 00000000 [ 127.820571][ T5076] metapage: ffff888023b8a9c0: 21d51228 ffff8880 21d51228 ffff8880 [ 127.828414][ T5077] jfs_flush_journal: synclist not empty [ 127.828456][ T5077] metapage: ffff888078f52aa8: 00001000 00000000 00003a48 00000000 [ 127.828481][ T5077] metapage: ffff888078f52ab8: 1e182228 ffff8880 1e182228 ffff8880 [ 127.834777][ T5080] jfs_flush_journal: synclist not empty [ 127.849737][ T5079] jfs_flush_journal: synclist not empty [ 127.849759][ T5079] metapage: ffff888078f526c8: 00001000 00000000 00003a48 00000000 [ 127.855304][ T5078] jfs_flush_journal: synclist not empty [ 127.868739][ T5079] metapage: ffff888078f526d8: 1e183228 ffff8880 1e183228 ffff8880 [ 127.868769][ T5079] metapage: ffff888078f526e8: 00000004 00000000 00000000 00000000 [ 127.868792][ T5079] metapage: ffff888078f526f8: 23f8b000 ffff8880 00000024 00000000 [ 127.874349][ T5076] metapage: ffff888023b8a9d0: 00000004 00000000 00000000 00000000 [ 127.882644][ T5077] metapage: ffff888078f52ac8: 00000004 00000000 00000000 00000000 [ 127.890780][ T5078] metapage: ffff888078f523e0: 00001000 00000000 00003a48 00000000 [ 127.898278][ T5079] metapage: ffff888078f52708: 00000000 dead4ead ffffffff 00000000 [ 127.906023][ T5080] metapage: ffff888023b8ac98: 00001000 00000000 00003a48 00000000 [ 127.913979][ T5077] metapage: ffff888078f52ad8: 78f5f000 ffff8880 00000024 00000000 [ 127.921549][ T5078] metapage: ffff888078f523f0: 1e182a28 ffff8880 1e182a28 ffff8880 [ 127.929621][ T5079] metapage: ffff888078f52718: ffffffff ffffffff 9483d840 ffffffff [ 127.937653][ T5080] metapage: ffff888023b8aca8: 21d56228 ffff8880 21d56228 ffff8880 [ 127.945345][ T5076] metapage: ffff888023b8a9e0: 23c09000 ffff8880 00000024 00000000 [ 127.953107][ T5078] metapage: ffff888078f52400: 00000004 00000000 00000000 00000000 [ 127.961033][ T5077] metapage: ffff888078f52ae8: 00000000 dead4ead ffffffff 00000000 [ 127.968787][ T5080] metapage: ffff888023b8acb8: 00000004 00000000 00000000 00000000 [ 127.976673][ T5079] metapage: ffff888078f52728: 92c33a50 ffffffff 00000000 00000000 [ 127.984429][ T5078] metapage: ffff888078f52410: 23f8d000 ffff8880 00000024 00000000 [ 127.992183][ T5076] metapage: ffff888023b8a9f0: 00000000 dead4ead ffffffff 00000000 [ 127.992213][ T5076] metapage: ffff888023b8aa00: ffffffff ffffffff 9483d840 ffffffff [ 127.992233][ T5076] metapage: ffff888023b8aa10: 92c33a50 ffffffff 00000000 00000000 [ 127.992253][ T5076] metapage: ffff888023b8aa20: 8c025960 ffffffff 00000200 00000000 [ 127.992273][ T5076] metapage: ffff888023b8aa30: 23b8aa30 ffff8880 23b8aa30 ffff8880 [ 127.992293][ T5076] metapage: ffff888023b8aa40: 008f0240 ffffea00 2016e000 ffff8880 [ 127.992312][ T5076] metapage: ffff888023b8aa50: 00001000 00003b14 00000001 00000000 [ 127.992329][ T5076] metapage: ffff888023b8aa60: 21d51000 ffff8880 [ 127.992348][ T5076] page: ffffea00008f0240: 00fff0000000812c ffffea00008e26c8 [ 127.992365][ T5076] page: ffffea00008f0250: ffffea00008f0288 ffff88807ae50658 [ 127.992382][ T5076] page: ffffea00008f0260: 0000000000000024 ffff888023b8a9b0 [ 127.992399][ T5076] page: ffffea00008f0270: 00000002ffffffff ffff888016abc000 [ 127.993919][ T5077] metapage: ffff888078f52af8: ffffffff ffffffff 9483d840 ffffffff [ 128.011097][ T5080] metapage: ffff888023b8acc8: 23c08000 ffff8880 00000024 00000000 [ 128.016478][ T5079] metapage: ffff888078f52738: 8c025960 ffffffff 00000200 00000000 [ 128.032131][ T5078] metapage: ffff888078f52420: 00000000 dead4ead ffffffff 00000000 [ 128.032158][ T5078] metapage: ffff888078f52430: ffffffff ffffffff 9483d840 ffffffff [ 128.032180][ T5078] metapage: ffff888078f52440: 92c33a50 ffffffff 00000000 00000000 [ 128.041064][ T5077] metapage: ffff888078f52b08: 92c33a50 ffffffff 00000000 00000000 [ 128.064143][ T5080] metapage: ffff888023b8acd8: 00000000 dead4ead ffffffff 00000000 [ 128.074647][ T5079] metapage: ffff888078f52748: 78f52748 ffff8880 78f52748 ffff8880 [ 128.079547][ T5078] metapage: ffff888078f52450: 8c025960 ffffffff 00000200 00000000 [ 128.085717][ T5079] metapage: ffff888078f52758: 008fe2c0 ffffea00 2466e000 ffff8880 [ 128.093607][ T5080] metapage: ffff888023b8ace8: ffffffff ffffffff 9483d840 ffffffff [ 128.107982][ T5077] metapage: ffff888078f52b18: 8c025960 ffffffff 00000200 00000000 [ 128.108010][ T5077] metapage: ffff888078f52b28: 78f52b28 ffff8880 78f52b28 ffff8880 [ 128.108033][ T5077] metapage: ffff888078f52b38: 01e3d7c0 ffffea00 1edf2000 ffff8880 [ 128.115864][ T5078] metapage: ffff888078f52460: 78f52460 ffff8880 78f52460 ffff8880 [ 128.131511][ T5079] metapage: ffff888078f52768: 00001000 00003b14 00000001 00000000 [ 128.131536][ T5079] metapage: ffff888078f52778: 1e183000 ffff8880 [ 128.131560][ T5079] page: ffffea00008fe2c0: 00fff0000000812c ffffea0000b52748 [ 128.131580][ T5079] page: ffffea00008fe2d0: ffffea00008fe348 ffff88807ae70658 [ 128.140883][ T5080] metapage: ffff888023b8acf8: 92c33a50 ffffffff 00000000 00000000 [ 128.147325][ T5077] metapage: ffff888078f52b48: 00001000 00003b14 00000001 00000000 [ 128.155453][ T5080] metapage: ffff888023b8ad08: 8c025960 ffffffff 00000200 00000000 [ 128.163035][ T5079] page: ffffea00008fe2e0: 0000000000000024 ffff888078f526c8 [ 128.171383][ T5078] metapage: ffff888078f52470: 008fe340 ffffea00 23eb0000 ffff8880 [ 128.178660][ T5077] metapage: ffff888078f52b58: 1e182000 ffff8880 [ 128.186655][ T5078] metapage: ffff888078f52480: 00001000 00003b14 00000001 00000000 [ 128.194321][ T5079] page: ffffea00008fe2f0: 00000002ffffffff ffff888016abc000 [ 128.202141][ T5080] metapage: ffff888023b8ad18: 23b8ad18 ffff8880 23b8ad18 ffff8880 [ 128.210278][ T5077] page: ffffea0001e3d7c0: 00fff0000000812c ffffea00008f0208 [ 128.218723][ T5078] metapage: ffff888078f52490: 1e182800 ffff8880 [ 128.228399][ T5077] page: ffffea0001e3d7d0: ffffea0001e3d548 ffff88807ae76c18 [ 128.233931][ T5080] metapage: ffff888023b8ad28: 008f0200 ffffea00 22f40000 ffff8880 [ 128.247500][ T5077] page: ffffea0001e3d7e0: 0000000000000024 ffff888078f52aa8 [ 128.247525][ T5077] page: ffffea0001e3d7f0: 00000002ffffffff ffff888016abc000 [ 128.270008][ T5078] page: ffffea00008fe340: 00fff0000000812c ffffea00008fe2c8 [ 128.270037][ T5078] page: ffffea00008fe350: ffffea0001e3d688 ffff88807ae70f98 [ 128.278693][ T5080] metapage: ffff888023b8ad38: 00001000 00003b14 00000001 00000000 [ 128.292992][ T5078] page: ffffea00008fe360: 0000000000000024 ffff888078f523e0 [ 128.293015][ T5078] page: ffffea00008fe370: 00000002ffffffff ffff888016abc000 [ 128.411299][ T5080] metapage: ffff888023b8ad48: 21d56000 ffff8880 [ 128.417643][ T5080] page: ffffea00008f0200: 00fff0000000812c ffffea00008f0288 [ 128.424963][ T5080] page: ffffea00008f0210: ffffea0001e3d7c8 ffff88807ae53dd8 [ 128.432360][ T5080] page: ffffea00008f0220: 0000000000000024 ffff888023b8ac98 [ 128.439710][ T5080] page: ffffea00008f0230: 00000002ffffffff ffff888016abc000 [ 182.066770][ T5076] jfs_flush_journal: synclist not empty [ 182.072570][ T5076] metapage: ffff888023b8a9b0: 00001000 00000000 00003a48 00000000 [ 182.080640][ T5076] metapage: ffff888023b8a9c0: 21d51228 ffff8880 21d51228 ffff8880 [ 182.088629][ T5076] metapage: ffff888023b8a9d0: 00000004 00000000 00000000 00000000 [ 182.096487][ T5076] metapage: ffff888023b8a9e0: 23c09000 ffff8880 00000024 00000000 [ 182.104490][ T5076] metapage: ffff888023b8a9f0: 00000000 dead4ead ffffffff 00000000 [ 182.112455][ T5076] metapage: ffff888023b8aa00: ffffffff ffffffff 9483d840 ffffffff [ 182.120354][ T5076] metapage: ffff888023b8aa10: 92c33a50 ffffffff 00000000 00000000 [ 182.128228][ T5076] metapage: ffff888023b8aa20: 8c025960 ffffffff 00000200 00000000 [ 182.136047][ T5076] metapage: ffff888023b8aa30: 23b8aa30 ffff8880 23b8aa30 ffff8880 [ 182.143939][ T5076] metapage: ffff888023b8aa40: 008f0240 ffffea00 2016e000 ffff8880 [ 182.151833][ T5076] metapage: ffff888023b8aa50: 00001000 00003b14 00000001 00000000 [ 182.159737][ T5076] metapage: ffff888023b8aa60: 21d51000 ffff8880 [pid 5077] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5076] <... umount2 resumed>) = 0 [pid 5076] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5076] newfstatat(AT_FDCWD, "./0/file0", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5076] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5076] openat(AT_FDCWD, "./0/file0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4 [pid 5076] newfstatat(4, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5076] getdents64(4, 0x55556d813730 /* 2 entries */, 32768) = 48 [pid 5076] getdents64(4, 0x55556d813730 /* 0 entries */, 32768) = 0 [pid 5076] close(4) = 0 [ 182.166005][ T5076] page: ffffea00008f0240: 00fff0000000812c ffffea00008e26c8 [ 182.173400][ T5076] page: ffffea00008f0250: ffffea00008f0208 ffff88807ae50658 [ 182.180879][ T5076] page: ffffea00008f0260: 0000000000000024 ffff888023b8a9b0 [ 182.188212][ T5076] page: ffffea00008f0270: 00000002ffffffff ffff888016abc000 [pid 5076] rmdir("./0/file0") = 0 [pid 5076] getdents64(3, 0x55556d80b6f0 /* 0 entries */, 32768) = 0 [pid 5076] close(3) = 0 [pid 5076] rmdir("./0") = 0 [pid 5076] mkdir("./1", 0777) = 0 [pid 5076] openat(AT_FDCWD, "/dev/loop0", O_RDWR) = 3 [pid 5076] ioctl(3, LOOP_CLR_FD) = 0 [pid 5076] close(3) = 0 [pid 5076] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5108 attached , child_tidptr=0x55556d80a650) = 5108 [pid 5108] set_robust_list(0x55556d80a660, 24) = 0 [pid 5108] chdir("./1") = 0 [pid 5108] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5108] setpgid(0, 0) = 0 [pid 5108] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC) = 3 [pid 5108] write(3, "1000", 4) = 4 [pid 5108] close(3) = 0 [pid 5108] symlink("/dev/binderfs", "./binderfs") = 0 [pid 5108] memfd_create("syzkaller", 0) = 3 [pid 5108] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f24cd200000 [pid 5108] 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) = 16777216 [pid 5108] munmap(0x7f24cd200000, 138412032) = 0 [pid 5108] openat(AT_FDCWD, "/dev/loop0", O_RDWR) = 4 [pid 5108] ioctl(4, LOOP_SET_FD, 3) = 0 [pid 5108] close(3) = 0 [pid 5108] close(4) = 0 [pid 5108] mkdir("./file0", 0777) = 0 [pid 5108] mount("/dev/loop0", "./file0", "jfs", MS_NOSUID, "quota,iocharset=cp1250,nodiscard,gid=0x000000000000ee00,discard=0x0000000000000009,errors=continue,q"...) = 0 [pid 5108] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY) = 3 [pid 5108] chdir("./file0") = 0 [pid 5108] openat(AT_FDCWD, "/dev/loop0", O_RDWR) = -1 EBUSY (Device or resource busy) [pid 5108] chdir("./file0") = 0 [ 182.688376][ T5108] loop0: detected capacity change from 0 to 32768 [pid 5108] rename("./file0", "./file3") = -1 EIO (Input/output error) [pid 5108] openat(AT_FDCWD, "./file0", O_RDONLY) = 4 [pid 5108] exit_group(0) = ? [pid 5108] +++ exited with 0 +++ [pid 5076] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5108, si_uid=0, si_status=0, si_utime=2 /* 0.02 s */, si_stime=19 /* 0.19 s */} --- [pid 5076] restart_syscall(<... resuming interrupted clone ...>) = 0 [pid 5076] umount2("./1", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5076] openat(AT_FDCWD, "./1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [ 182.737928][ T5108] find_entry called with index = 0 [ 182.743942][ T5108] read_mapping_page failed! [ 182.749172][ T5108] ERROR: (device loop0): txCommit: [ 182.749172][ T5108] [pid 5076] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5076] getdents64(3, 0x55556d80b6f0 /* 4 entries */, 32768) = 112 [pid 5076] umount2("./1/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5076] newfstatat(AT_FDCWD, "./1/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5076] unlink("./1/binderfs") = 0 [ 236.206722][ T5079] jfs_flush_journal: synclist not empty [ 236.213152][ T5079] metapage: ffff888078f526c8: 00001000 00000000 00003a48 00000000 [ 236.221232][ T5079] metapage: ffff888078f526d8: 1e183228 ffff8880 1e183228 ffff8880 [ 236.229149][ T5079] metapage: ffff888078f526e8: 00000004 00000000 00000000 00000000 [ 236.237081][ T5079] metapage: ffff888078f526f8: 23f8b000 ffff8880 00000024 00000000 [ 236.244946][ T5079] metapage: ffff888078f52708: 00000000 dead4ead ffffffff 00000000 [ 236.252842][ T5079] metapage: ffff888078f52718: ffffffff ffffffff 9483d840 ffffffff [ 236.260823][ T5079] metapage: ffff888078f52728: 92c33a50 ffffffff 00000000 00000000 [ 236.268691][ T5079] metapage: ffff888078f52738: 8c025960 ffffffff 00000200 00000000 [ 236.276518][ T5079] metapage: ffff888078f52748: 78f52748 ffff8880 78f52748 ffff8880 [ 236.284443][ T5079] metapage: ffff888078f52758: 008fe2c0 ffffea00 2466e000 ffff8880 [ 236.292337][ T5079] metapage: ffff888078f52768: 00001000 00003b14 00000001 00000000 [ 236.300239][ T5079] metapage: ffff888078f52778: 1e183000 ffff8880 [pid 5076] umount2("./1/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5079] <... umount2 resumed>) = 0 [pid 5079] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5079] newfstatat(AT_FDCWD, "./0/file0", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5079] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5079] openat(AT_FDCWD, "./0/file0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4 [pid 5079] newfstatat(4, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5079] getdents64(4, 0x55556d813730 /* 2 entries */, 32768) = 48 [pid 5079] getdents64(4, 0x55556d813730 /* 0 entries */, 32768) = 0 [pid 5079] close(4) = 0 [pid 5079] rmdir("./0/file0") = 0 [pid 5079] getdents64(3, 0x55556d80b6f0 /* 0 entries */, 32768) = 0 [ 236.306489][ T5079] page: ffffea00008fe2c0: 00fff0000000812c ffffea0000b52748 [ 236.313837][ T5079] page: ffffea00008fe2d0: ffffea00008fe348 ffff88807ae70658 [ 236.321195][ T5079] page: ffffea00008fe2e0: 0000000000000024 ffff888078f526c8 [ 236.328570][ T5079] page: ffffea00008fe2f0: 00000002ffffffff ffff888016abc000 [pid 5079] close(3) = 0 [pid 5079] rmdir("./0") = 0 [pid 5079] mkdir("./1", 0777) = 0 [pid 5079] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = 3 [pid 5079] ioctl(3, LOOP_CLR_FD) = 0 [pid 5079] close(3) = 0 [pid 5079] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5110 attached , child_tidptr=0x55556d80a650) = 5110 [pid 5110] set_robust_list(0x55556d80a660, 24) = 0 [pid 5110] chdir("./1") = 0 [pid 5110] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5110] setpgid(0, 0) = 0 [pid 5110] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC) = 3 [pid 5110] write(3, "1000", 4) = 4 [pid 5110] close(3) = 0 [pid 5110] symlink("/dev/binderfs", "./binderfs") = 0 [pid 5110] memfd_create("syzkaller", 0) = 3 [pid 5110] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f24cd200000 [pid 5110] 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) = 16777216 [pid 5110] munmap(0x7f24cd200000, 138412032) = 0 [pid 5110] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = 4 [ 236.826663][ T5076] jfs_flush_journal: synclist not empty [ 236.832274][ T5076] metapage: ffff888023f884d8: 00001000 00000000 00003a48 00000000 [ 236.840274][ T5076] metapage: ffff888023f884e8: 1e186228 ffff8880 1e186228 ffff8880 [ 236.848852][ T5076] metapage: ffff888023f884f8: 00000004 00000000 00000000 00000000 [ 236.856849][ T5076] metapage: ffff888023f88508: 24274000 ffff8880 00000024 00000000 [ 236.864717][ T5076] metapage: ffff888023f88518: 00000000 dead4ead ffffffff 00000000 [pid 5110] ioctl(4, LOOP_SET_FD, 3) = 0 [pid 5110] close(3) = 0 [ 236.872631][ T5076] metapage: ffff888023f88528: ffffffff ffffffff 9483d840 ffffffff [ 236.880569][ T5076] metapage: ffff888023f88538: 92c33a50 ffffffff 00000000 00000000 [ 236.882757][ T5110] loop3: detected capacity change from 0 to 32768 [ 236.888517][ T5076] metapage: ffff888023f88548: 8c025960 ffffffff 00000200 00000000 [ 236.888544][ T5076] metapage: ffff888023f88558: 23f88558 ffff8880 23f88558 ffff8880 [ 236.910687][ T5076] metapage: ffff888023f88568: 00909d00 ffffea00 277bc000 ffff8880 [ 236.918577][ T5076] metapage: ffff888023f88578: 00001000 00003b14 00000001 00000000 [pid 5110] close(4) = 0 [pid 5110] mkdir("./file0", 0777) = 0 [pid 5110] mount("/dev/loop3", "./file0", "jfs", MS_NOSUID, "quota,iocharset=cp1250,nodiscard,gid=0x000000000000ee00,discard=0x0000000000000009,errors=continue,q"...) = 0 [pid 5110] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY) = 3 [pid 5110] chdir("./file0") = 0 [pid 5110] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = -1 EBUSY (Device or resource busy) [pid 5110] chdir("./file0") = 0 [ 236.926423][ T5076] metapage: ffff888023f88588: 1e186000 ffff8880 [ 236.932942][ T5076] page: ffffea0000909d00: 00fff0000000812c ffffea0000968108 [ 236.947225][ T5076] page: ffffea0000909d10: ffffea0001e21c08 ffff88807ae16c18 [ 236.954741][ T5076] page: ffffea0000909d20: 0000000000000024 ffff888023f884d8 [ 236.968741][ T5076] page: ffffea0000909d30: 00000002ffffffff ffff888016abc000 [pid 5110] rename("./file0", "./file3") = -1 EIO (Input/output error) [pid 5110] openat(AT_FDCWD, "./file0", O_RDONLY) = 4 [pid 5110] exit_group(0) = ? [pid 5110] +++ exited with 0 +++ [pid 5079] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5110, si_uid=0, si_status=0, si_utime=2 /* 0.02 s */, si_stime=22 /* 0.22 s */} --- [pid 5079] umount2("./1", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5079] openat(AT_FDCWD, "./1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 5079] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5079] getdents64(3, 0x55556d80b6f0 /* 4 entries */, 32768) = 112 [ 236.989202][ T5110] find_entry called with index = 0 [ 236.994558][ T5110] read_mapping_page failed! [ 236.999427][ T5110] ERROR: (device loop3): txCommit: [ 236.999427][ T5110] [pid 5079] umount2("./1/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5079] newfstatat(AT_FDCWD, "./1/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5079] unlink("./1/binderfs") = 0 [ 277.086762][ T29] INFO: task syz-executor147:5078 blocked for more than 143 seconds. [ 277.095070][ T29] Not tainted 6.9.0-rc6-syzkaller-00042-g50dffbf77180 #0 [ 277.102748][ T29] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 277.111494][ T29] task:syz-executor147 state:D stack:25424 pid:5078 tgid:5078 ppid:5075 flags:0x00004002 [ 277.121841][ T29] Call Trace: [ 277.125262][ T29] [ 277.128325][ T29] __schedule+0x1796/0x4a00 [ 277.133051][ T29] ? __pfx___schedule+0x10/0x10 [ 277.138515][ T29] ? __pfx_lock_release+0x10/0x10 [ 277.143619][ T29] ? __mutex_trylock_common+0x92/0x2e0 [ 277.149181][ T29] ? schedule+0x90/0x320 [ 277.153460][ T29] schedule+0x14b/0x320 [ 277.157706][ T29] schedule_preempt_disabled+0x13/0x30 [ 277.163346][ T29] __mutex_lock+0x6a4/0xd70 [ 277.167973][ T29] ? __mutex_lock+0x527/0xd70 [ 277.172689][ T29] ? lmLogClose+0xb2/0x530 [ 277.177223][ T29] ? __pfx___mutex_lock+0x10/0x10 [ 277.182285][ T29] ? updateSuper+0x13d/0x760 [ 277.187022][ T29] lmLogClose+0xb2/0x530 [ 277.191319][ T29] jfs_umount+0x2ce/0x3a0 [ 277.195694][ T29] jfs_put_super+0x8a/0x190 [ 277.200290][ T29] ? __pfx_jfs_put_super+0x10/0x10 [ 277.205452][ T29] generic_shutdown_super+0x136/0x2d0 [ 277.210954][ T29] kill_block_super+0x44/0x90 [ 277.215707][ T29] deactivate_locked_super+0xc4/0x130 [ 277.221169][ T29] cleanup_mnt+0x426/0x4c0 [ 277.225650][ T29] ? _raw_spin_unlock_irq+0x23/0x50 [ 277.230954][ T29] task_work_run+0x24f/0x310 [ 277.235635][ T29] ? __pfx_task_work_run+0x10/0x10 [ 277.240866][ T29] ? path_umount+0x284/0xf80 [ 277.245513][ T29] ptrace_notify+0x2d2/0x380 [ 277.250213][ T29] ? __pfx_path_umount+0x10/0x10 [ 277.255201][ T29] ? user_path_at_empty+0x4c/0x60 [ 277.260304][ T29] ? __pfx_ptrace_notify+0x10/0x10 [ 277.265465][ T29] ? __x64_sys_umount+0x126/0x170 [ 277.270578][ T29] ? __pfx___x64_sys_umount+0x10/0x10 [ 277.276010][ T29] syscall_exit_work+0xc6/0x190 [ 277.280965][ T29] syscall_exit_to_user_mode+0x273/0x370 [ 277.286787][ T29] do_syscall_64+0x102/0x240 [ 277.291440][ T29] ? clear_bhb_loop+0x35/0x90 [ 277.296217][ T29] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 277.302172][ T29] RIP: 0033:0x7f24d57e42e7 [ 277.306705][ T29] RSP: 002b:00007ffc04b58c58 EFLAGS: 00000202 ORIG_RAX: 00000000000000a6 [ 277.315129][ T29] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 00007f24d57e42e7 [ 277.323223][ T29] RDX: 0000000000000000 RSI: 0000000000000009 RDI: 00007ffc04b58d10 [ 277.331354][ T29] RBP: 00007ffc04b58d10 R08: 0000000000000000 R09: 0000000000000000 [ 277.339396][ T29] R10: 00000000ffffffff R11: 0000000000000202 R12: 00007ffc04b59d80 [ 277.347511][ T29] R13: 000055556d80b6c0 R14: 431bde82d7b634db R15: 00007ffc04b59da0 [ 277.355530][ T29] [ 277.358625][ T29] INFO: task syz-executor147:5080 blocked for more than 143 seconds. [ 277.366773][ T29] Not tainted 6.9.0-rc6-syzkaller-00042-g50dffbf77180 #0 [ 277.374340][ T29] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 277.383230][ T29] task:syz-executor147 state:D stack:24592 pid:5080 tgid:5080 ppid:5075 flags:0x00004002 [ 277.393520][ T29] Call Trace: [ 277.396915][ T29] [ 277.399883][ T29] __schedule+0x1796/0x4a00 [ 277.404426][ T29] ? __pfx___schedule+0x10/0x10 [ 277.409735][ T29] ? __pfx_lock_release+0x10/0x10 [ 277.414808][ T29] ? __mutex_trylock_common+0x92/0x2e0 [ 277.420421][ T29] ? schedule+0x90/0x320 [ 277.424719][ T29] schedule+0x14b/0x320 [ 277.428953][ T29] schedule_preempt_disabled+0x13/0x30 [ 277.434456][ T29] __mutex_lock+0x6a4/0xd70 [ 277.439028][ T29] ? __mutex_lock+0x527/0xd70 [ 277.443730][ T29] ? lmLogClose+0xb2/0x530 [ 277.448230][ T29] ? __pfx___mutex_lock+0x10/0x10 [ 277.453288][ T29] ? updateSuper+0x13d/0x760 [ 277.458038][ T29] lmLogClose+0xb2/0x530 [ 277.462329][ T29] jfs_umount+0x2ce/0x3a0 [ 277.466739][ T29] jfs_put_super+0x8a/0x190 [ 277.471291][ T29] ? __pfx_jfs_put_super+0x10/0x10 [ 277.476441][ T29] generic_shutdown_super+0x136/0x2d0 [ 277.482058][ T29] kill_block_super+0x44/0x90 [ 277.486820][ T29] deactivate_locked_super+0xc4/0x130 [ 277.492208][ T29] cleanup_mnt+0x426/0x4c0 [ 277.496699][ T29] ? _raw_spin_unlock_irq+0x23/0x50 [ 277.501933][ T29] task_work_run+0x24f/0x310 [ 277.506627][ T29] ? __pfx_task_work_run+0x10/0x10 [ 277.511783][ T29] ? path_umount+0x284/0xf80 [ 277.516424][ T29] ptrace_notify+0x2d2/0x380 [ 277.521119][ T29] ? __pfx_path_umount+0x10/0x10 [ 277.526091][ T29] ? user_path_at_empty+0x4c/0x60 [ 277.531175][ T29] ? __pfx_ptrace_notify+0x10/0x10 [ 277.536355][ T29] ? __x64_sys_umount+0x126/0x170 [ 277.541461][ T29] ? __pfx___x64_sys_umount+0x10/0x10 [ 277.546922][ T29] syscall_exit_work+0xc6/0x190 [ 277.551789][ T29] syscall_exit_to_user_mode+0x273/0x370 [ 277.557499][ T29] do_syscall_64+0x102/0x240 [ 277.562152][ T29] ? clear_bhb_loop+0x35/0x90 [ 277.566939][ T29] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 277.572876][ T29] RIP: 0033:0x7f24d57e42e7 [ 277.577379][ T29] RSP: 002b:00007ffc04b58c58 EFLAGS: 00000202 ORIG_RAX: 00000000000000a6 [ 277.585828][ T29] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 00007f24d57e42e7 [ 277.593866][ T29] RDX: 0000000000000000 RSI: 0000000000000009 RDI: 00007ffc04b58d10 [ 277.601894][ T29] RBP: 00007ffc04b58d10 R08: 0000000000000000 R09: 0000000000000000 [ 277.609945][ T29] R10: 00000000ffffffff R11: 0000000000000202 R12: 00007ffc04b59d80 [ 277.617976][ T29] R13: 000055556d80b6c0 R14: 431bde82d7b634db R15: 00007ffc04b59da0 [ 277.625966][ T29] [ 277.629140][ T29] [ 277.629140][ T29] Showing all locks held in the system: [ 277.637011][ T29] 1 lock held by khungtaskd/29: [ 277.641889][ T29] #0: ffffffff8e334d60 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x55/0x2a0 [ 277.651894][ T29] 5 locks held by kworker/u8:2/34: [ 277.657098][ T29] #0: ffff8880b943e658 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock_nested+0x2a/0x140 [ 277.667171][ T29] #1: ffff8880b9428948 (&per_cpu_ptr(group->pcpu, cpu)->seq){-.-.}-{0:0}, at: psi_task_switch+0x3a7/0x770 [ 277.678716][ T29] #2: ffff8880b942a718 (&base->lock){-.-.}-{2:2}, at: lock_timer_base+0x112/0x240 [ 277.688207][ T29] #3: ffffffff9492f1b0 (&obj_hash[i].lock){-.-.}-{2:2}, at: debug_object_activate+0x16d/0x510 [ 277.698817][ T29] #4: ffffffff8e1e4708 (text_mutex){+.+.}-{3:3}, at: arch_jump_label_transform_apply+0x17/0x30 [ 277.709442][ T29] 2 locks held by getty/4826: [ 277.714225][ T29] #0: ffff88802f4520a0 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x25/0x70 [ 277.724117][ T29] #1: ffffc90002f0e2f0 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0x6b5/0x1e10 [ 277.734500][ T29] 2 locks held by syz-executor147/5076: [ 277.740118][ T29] #0: ffff8880277bc0e0 (&type->s_umount_key#44){+.+.}-{3:3}, at: deactivate_super+0xb5/0xf0 [ 277.750441][ T29] #1: ffffffff8e73bfe8 (jfs_log_mutex){+.+.}-{3:3}, at: lmLogClose+0xb2/0x530 [ 277.759517][ T29] 2 locks held by syz-executor147/5077: [ 277.765084][ T29] #0: ffff88801edf20e0 (&type->s_umount_key#44){+.+.}-{3:3}, at: deactivate_super+0xb5/0xf0 [ 277.775417][ T29] #1: ffffffff8e73bfe8 (jfs_log_mutex){+.+.}-{3:3}, at: lmLogClose+0xb2/0x530 [ 277.784574][ T29] 2 locks held by syz-executor147/5078: [ 277.790288][ T29] #0: ffff888023eb00e0 (&type->s_umount_key#44){+.+.}-{3:3}, at: deactivate_super+0xb5/0xf0 [ 277.800621][ T29] #1: ffffffff8e73bfe8 (jfs_log_mutex){+.+.}-{3:3}, at: lmLogClose+0xb2/0x530 [ 277.809780][ T29] 1 lock held by syz-executor147/5079: [ 277.815250][ T29] #0: ffff8880785480e0 (&type->s_umount_key#44){+.+.}-{3:3}, at: deactivate_super+0xb5/0xf0 [ 277.825542][ T29] 2 locks held by syz-executor147/5080: [ 277.831153][ T29] #0: ffff888022f400e0 (&type->s_umount_key#44){+.+.}-{3:3}, at: deactivate_super+0xb5/0xf0 [ 277.841415][ T29] #1: ffffffff8e73bfe8 (jfs_log_mutex){+.+.}-{3:3}, at: lmLogClose+0xb2/0x530 [ 277.850497][ T29] [ 277.852822][ T29] ============================================= [ 277.852822][ T29] [ 277.861280][ T29] NMI backtrace for cpu 1 [ 277.865624][ T29] CPU: 1 PID: 29 Comm: khungtaskd Not tainted 6.9.0-rc6-syzkaller-00042-g50dffbf77180 #0 [ 277.875428][ T29] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 03/27/2024 [ 277.885510][ T29] Call Trace: [ 277.888792][ T29] [ 277.891721][ T29] dump_stack_lvl+0x241/0x360 [ 277.896447][ T29] ? __pfx_dump_stack_lvl+0x10/0x10 [ 277.901656][ T29] ? __pfx__printk+0x10/0x10 [ 277.906297][ T29] ? vprintk_emit+0x631/0x770 [ 277.910999][ T29] ? __pfx_vprintk_emit+0x10/0x10 [ 277.916036][ T29] nmi_cpu_backtrace+0x49c/0x4d0 [ 277.921025][ T29] ? __pfx_nmi_cpu_backtrace+0x10/0x10 [ 277.926497][ T29] ? _printk+0xd5/0x120 [ 277.930673][ T29] ? __pfx__printk+0x10/0x10 [ 277.935278][ T29] ? __wake_up_klogd+0xcc/0x110 [ 277.940166][ T29] ? __pfx__printk+0x10/0x10 [ 277.944797][ T29] ? __rcu_read_unlock+0xa1/0x110 [ 277.949854][ T29] ? __pfx_nmi_raise_cpu_backtrace+0x10/0x10 [ 277.955893][ T29] nmi_trigger_cpumask_backtrace+0x198/0x320 [ 277.961911][ T29] watchdog+0xfde/0x1020 [ 277.966204][ T29] ? watchdog+0x1ea/0x1020 [ 277.970638][ T29] ? __pfx_watchdog+0x10/0x10 [ 277.975327][ T29] kthread+0x2f0/0x390 [ 277.979433][ T29] ? __pfx_watchdog+0x10/0x10 [ 277.984211][ T29] ? __pfx_kthread+0x10/0x10 [ 277.988820][ T29] ret_from_fork+0x4b/0x80 [ 277.993267][ T29] ? __pfx_kthread+0x10/0x10 [ 277.997871][ T29] ret_from_fork_asm+0x1a/0x30 [ 278.002674][ T29] [ 278.005849][ T29] Sending NMI from CPU 1 to CPUs 0: [ 278.011134][ C0] NMI backtrace for cpu 0 [ 278.011147][ C0] CPU: 0 PID: 34 Comm: kworker/u8:2 Not tainted 6.9.0-rc6-syzkaller-00042-g50dffbf77180 #0 [ 278.011166][ C0] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 03/27/2024 [ 278.011178][ C0] Workqueue: events_unbound toggle_allocation_gate [ 278.011205][ C0] RIP: 0010:inat_get_escape_attribute+0x42/0x190 [ 278.011229][ C0] Code: 00 00 00 00 00 fc ff df e8 4b 57 22 f6 c1 eb 04 83 e3 03 48 c1 e3 05 48 8d ab e0 dc e7 8c 48 89 e8 48 c1 e8 03 42 80 3c 20 00 <74> 08 48 89 ef e8 14 a7 83 f6 4c 8b 65 00 4d 85 e4 0f 84 9e 00 00 [ 278.011244][ C0] RSP: 0018:ffffc90000aa7628 EFLAGS: 00000246 [ 278.011258][ C0] RAX: 1ffffffff19cfba0 RBX: 0000000000000020 RCX: ffff8880176d5a00 [ 278.011272][ C0] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 000000000000001f [ 278.011282][ C0] RBP: ffffffff8ce7dd00 R08: ffffffff8b7433b3 R09: 0000000000000000 [ 278.011295][ C0] R10: ffffc90000aa7920 R11: fffff52000154f2f R12: dffffc0000000000 [ 278.011308][ C0] R13: ffffc90000aa796c R14: 0000000000000000 R15: 000000000000001f [ 278.011320][ C0] FS: 0000000000000000(0000) GS:ffff8880b9400000(0000) knlGS:0000000000000000 [ 278.011335][ C0] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 278.011348][ C0] CR2: 000055aa1150a680 CR3: 000000000e134000 CR4: 00000000003506f0 [ 278.011363][ C0] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [ 278.011374][ C0] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [ 278.011385][ C0] Call Trace: [ 278.011392][ C0] [ 278.011399][ C0] ? nmi_cpu_backtrace+0x3c2/0x4d0 [ 278.011418][ C0] ? __pfx_lock_acquire+0x10/0x10 [ 278.011439][ C0] ? __pfx_nmi_cpu_backtrace+0x10/0x10 [ 278.011458][ C0] ? nmi_handle+0x2a/0x5a0 [ 278.011485][ C0] ? nmi_cpu_backtrace_handler+0xc/0x20 [ 278.011508][ C0] ? nmi_handle+0x14f/0x5a0 [ 278.011525][ C0] ? nmi_handle+0x2a/0x5a0 [ 278.011544][ C0] ? inat_get_escape_attribute+0x42/0x190 [ 278.011564][ C0] ? default_do_nmi+0x63/0x160 [ 278.011584][ C0] ? exc_nmi+0x123/0x1f0 [ 278.011602][ C0] ? end_repeat_nmi+0xf/0x53 [ 278.011626][ C0] ? insn_get_opcode+0x493/0xa90 [ 278.011648][ C0] ? inat_get_escape_attribute+0x42/0x190 [ 278.011669][ C0] ? inat_get_escape_attribute+0x42/0x190 [ 278.011690][ C0] ? inat_get_escape_attribute+0x42/0x190 [ 278.011710][ C0] [ 278.011716][ C0] [ 278.011725][ C0] insn_get_opcode+0x4d4/0xa90 [ 278.011755][ C0] insn_get_modrm+0x63/0x730 [ 278.011777][ C0] ? insn_get_modrm+0x4a2/0x730 [ 278.011801][ C0] insn_get_displacement+0x151/0x9a0 [ 278.011828][ C0] insn_get_immediate+0x62/0x11f0 [ 278.011850][ C0] ? insn_get_immediate+0xad4/0x11f0 [ 278.011875][ C0] insn_decode+0x2d6/0x4c0 [ 278.011899][ C0] ? kmem_cache_alloc+0xae/0x340 [ 278.011950][ C0] text_poke_loc_init+0xed/0x870 [ 278.011973][ C0] ? __jump_label_patch+0x2ca/0x490 [ 278.011995][ C0] ? kmem_cache_alloc+0xae/0x340 [ 278.012020][ C0] ? __pfx_text_poke_loc_init+0x10/0x10 [ 278.012041][ C0] ? trace_contention_end+0x3c/0x120 [ 278.012071][ C0] ? static_key_disable_cpuslocked+0x9b/0x1c0 [ 278.012104][ C0] ? text_poke_queue+0x46/0x180 [ 278.012124][ C0] arch_jump_label_transform_queue+0x8f/0x100 [ 278.012150][ C0] __jump_label_update+0x177/0x3a0 [ 278.012175][ C0] ? process_scheduled_works+0x91b/0x17c0 [ 278.012194][ C0] static_key_disable_cpuslocked+0xce/0x1c0 [ 278.012217][ C0] static_key_disable+0x1a/0x20 [ 278.012237][ C0] toggle_allocation_gate+0x1b8/0x250 [ 278.012259][ C0] ? __pfx_toggle_allocation_gate+0x10/0x10 [ 278.012282][ C0] ? __pfx_lockdep_hardirqs_on_prepare+0x10/0x10 [ 278.012309][ C0] process_scheduled_works+0xa10/0x17c0 [ 278.012343][ C0] ? __pfx_process_scheduled_works+0x10/0x10 [ 278.012367][ C0] ? assign_work+0x364/0x3d0 [ 278.012387][ C0] worker_thread+0x86d/0xd70 [ 278.012411][ C0] ? _raw_spin_unlock_irqrestore+0xdd/0x140 [ 278.012439][ C0] ? __kthread_parkme+0x169/0x1d0 [ 278.012461][ C0] ? __pfx_worker_thread+0x10/0x10 [ 278.012480][ C0] kthread+0x2f0/0x390 [ 278.012501][ C0] ? __pfx_worker_thread+0x10/0x10 [ 278.012520][ C0] ? __pfx_kthread+0x10/0x10 [ 278.012541][ C0] ret_from_fork+0x4b/0x80 [ 278.012566][ C0] ? __pfx_kthread+0x10/0x10 [ 278.012588][ C0] ret_from_fork_asm+0x1a/0x30 [ 278.012622][ C0] [ 278.013243][ T29] Kernel panic - not syncing: hung_task: blocked tasks [ 278.438570][ T29] CPU: 1 PID: 29 Comm: khungtaskd Not tainted 6.9.0-rc6-syzkaller-00042-g50dffbf77180 #0 [ 278.448392][ T29] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 03/27/2024 [ 278.458448][ T29] Call Trace: [ 278.461729][ T29] [ 278.464688][ T29] dump_stack_lvl+0x241/0x360 [ 278.469400][ T29] ? __pfx_dump_stack_lvl+0x10/0x10 [ 278.474615][ T29] ? __pfx__printk+0x10/0x10 [ 278.479240][ T29] ? vscnprintf+0x5d/0x90 [ 278.483576][ T29] panic+0x349/0x860 [ 278.487479][ T29] ? nmi_trigger_cpumask_backtrace+0x244/0x320 [ 278.493636][ T29] ? __pfx_panic+0x10/0x10 [ 278.498058][ T29] ? tick_nohz_tick_stopped+0x82/0xb0 [ 278.503540][ T29] ? __irq_work_queue_local+0x137/0x410 [ 278.509107][ T29] ? preempt_schedule_thunk+0x1a/0x30 [ 278.514482][ T29] ? nmi_trigger_cpumask_backtrace+0x244/0x320 [ 278.520637][ T29] ? nmi_trigger_cpumask_backtrace+0x2d4/0x320 [ 278.526794][ T29] ? nmi_trigger_cpumask_backtrace+0x2d9/0x320 [ 278.532976][ T29] watchdog+0x101d/0x1020 [ 278.537306][ T29] ? watchdog+0x1ea/0x1020 [ 278.541756][ T29] ? __pfx_watchdog+0x10/0x10 [ 278.546474][ T29] kthread+0x2f0/0x390 [ 278.550548][ T29] ? __pfx_watchdog+0x10/0x10 [ 278.555240][ T29] ? __pfx_kthread+0x10/0x10 [ 278.559851][ T29] ret_from_fork+0x4b/0x80 [ 278.564276][ T29] ? __pfx_kthread+0x10/0x10 [ 278.568869][ T29] ret_from_fork_asm+0x1a/0x30 [ 278.573648][ T29] [ 278.577072][ T29] Kernel Offset: disabled [ 278.581409][ T29] Rebooting in 86400 seconds..