./strace-static-x86_64 -e \!wait4,clock_nanosleep,nanosleep -s 100 -x -f ./syz-executor2940681306 <...> Warning: Permanently added '10.128.0.239' (ED25519) to the list of known hosts. execve("./syz-executor2940681306", ["./syz-executor2940681306"], 0x7ffdab0e2e30 /* 10 vars */) = 0 brk(NULL) = 0x55557e7b2000 brk(0x55557e7b2d00) = 0x55557e7b2d00 arch_prctl(ARCH_SET_FS, 0x55557e7b2380) = 0 set_tid_address(0x55557e7b2650) = 5846 set_robust_list(0x55557e7b2660, 24) = 0 rseq(0x55557e7b2ca0, 0x20, 0, 0x53053053) = 0 prlimit64(0, RLIMIT_STACK, NULL, {rlim_cur=8192*1024, rlim_max=RLIM64_INFINITY}) = 0 readlink("/proc/self/exe", "/root/syz-executor2940681306", 4096) = 28 getrandom("\xc2\xc4\x70\x44\xf7\xc5\x06\x5d", 8, GRND_NONBLOCK) = 8 brk(NULL) = 0x55557e7b2d00 brk(0x55557e7d3d00) = 0x55557e7d3d00 brk(0x55557e7d4000) = 0x55557e7d4000 mprotect(0x7fe4dc9c4000, 16384, PROT_READ) = 0 mmap(0x1ffff000, 4096, PROT_NONE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x1ffff000 mmap(0x20000000, 16777216, PROT_READ|PROT_WRITE|PROT_EXEC, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x20000000 mmap(0x21000000, 4096, PROT_NONE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x21000000 clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5847 attached [pid 5847] set_robust_list(0x55557e7b2660, 24 [pid 5846] <... clone resumed>, child_tidptr=0x55557e7b2650) = 5847 [pid 5846] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5847] <... set_robust_list resumed>) = 0 [pid 5847] mkdir("./syzkaller.qQJ9rL", 0700./strace-static-x86_64: Process 5848 attached [pid 5846] <... clone resumed>, child_tidptr=0x55557e7b2650) = 5848 [pid 5848] set_robust_list(0x55557e7b2660, 24 [pid 5846] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5848] <... set_robust_list resumed>) = 0 [pid 5848] mkdir("./syzkaller.YwN7ac", 0700 [pid 5847] <... mkdir resumed>) = 0 [pid 5847] chmod("./syzkaller.qQJ9rL", 0777./strace-static-x86_64: Process 5849 attached [pid 5848] <... mkdir resumed>) = 0 [pid 5848] chmod("./syzkaller.YwN7ac", 0777 [pid 5847] <... chmod resumed>) = 0 [pid 5846] <... clone resumed>, child_tidptr=0x55557e7b2650) = 5849 [pid 5849] set_robust_list(0x55557e7b2660, 24 [pid 5848] <... chmod resumed>) = 0 [pid 5849] <... set_robust_list resumed>) = 0 [pid 5847] chdir("./syzkaller.qQJ9rL" [pid 5846] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5848] chdir("./syzkaller.YwN7ac" [pid 5849] mkdir("./syzkaller.RJOSGn", 0700 [pid 5848] <... chdir resumed>) = 0 [pid 5847] <... chdir resumed>) = 0 ./strace-static-x86_64: Process 5850 attached [pid 5849] <... mkdir resumed>) = 0 [pid 5848] mkdir("./0", 0777 [pid 5847] mkdir("./0", 0777) = 0 [pid 5846] <... clone resumed>, child_tidptr=0x55557e7b2650) = 5850 [pid 5850] set_robust_list(0x55557e7b2660, 24 [pid 5849] chmod("./syzkaller.RJOSGn", 0777 [pid 5848] <... mkdir resumed>) = 0 [pid 5846] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5850] <... set_robust_list resumed>) = 0 [pid 5849] <... chmod resumed>) = 0 [pid 5847] openat(AT_FDCWD, "/dev/loop0", O_RDWR [pid 5850] mkdir("./syzkaller.FnhZxa", 0700 [pid 5849] chdir("./syzkaller.RJOSGn") = 0 [pid 5848] openat(AT_FDCWD, "/dev/loop1", O_RDWR [pid 5847] <... openat resumed>) = 3 [pid 5850] <... mkdir resumed>) = 0 ./strace-static-x86_64: Process 5851 attached [pid 5846] <... clone resumed>, child_tidptr=0x55557e7b2650) = 5851 [pid 5851] set_robust_list(0x55557e7b2660, 24 [pid 5850] chmod("./syzkaller.FnhZxa", 0777 [pid 5849] mkdir("./0", 0777 [pid 5848] <... openat resumed>) = 3 [pid 5847] ioctl(3, LOOP_CLR_FD [pid 5851] <... set_robust_list resumed>) = 0 [pid 5850] <... chmod resumed>) = 0 [pid 5848] ioctl(3, LOOP_CLR_FD [pid 5847] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5851] mkdir("./syzkaller.KiApMr", 0700 [pid 5850] chdir("./syzkaller.FnhZxa" [pid 5848] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5847] close(3 [pid 5850] <... chdir resumed>) = 0 [pid 5849] <... mkdir resumed>) = 0 [pid 5848] close(3 [pid 5847] <... close resumed>) = 0 [pid 5850] mkdir("./0", 0777 [pid 5851] <... mkdir resumed>) = 0 [pid 5850] <... mkdir resumed>) = 0 [pid 5849] openat(AT_FDCWD, "/dev/loop2", O_RDWR [pid 5848] <... close resumed>) = 0 [pid 5847] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5852 attached [pid 5850] openat(AT_FDCWD, "/dev/loop3", O_RDWR [pid 5849] <... openat resumed>) = 3 [pid 5848] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5852] set_robust_list(0x55557e7b2660, 24 [pid 5851] chmod("./syzkaller.KiApMr", 0777 [pid 5850] <... openat resumed>) = 3 [pid 5849] ioctl(3, LOOP_CLR_FD./strace-static-x86_64: Process 5853 attached [pid 5852] <... set_robust_list resumed>) = 0 [pid 5851] <... chmod resumed>) = 0 [pid 5853] set_robust_list(0x55557e7b2660, 24 [pid 5852] chdir("./0" [pid 5849] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5852] <... chdir resumed>) = 0 [pid 5853] <... set_robust_list resumed>) = 0 [pid 5852] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5851] chdir("./syzkaller.KiApMr" [pid 5850] ioctl(3, LOOP_CLR_FD [pid 5849] close(3 [pid 5848] <... clone resumed>, child_tidptr=0x55557e7b2650) = 5853 [pid 5847] <... clone resumed>, child_tidptr=0x55557e7b2650) = 5852 [pid 5853] chdir("./0" [pid 5852] setpgid(0, 0 [pid 5851] <... chdir resumed>) = 0 [pid 5850] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5849] <... close resumed>) = 0 [pid 5853] <... chdir resumed>) = 0 [pid 5852] <... setpgid resumed>) = 0 [pid 5851] mkdir("./0", 0777 [pid 5849] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5853] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5852] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5851] <... mkdir resumed>) = 0 [pid 5850] close(3./strace-static-x86_64: Process 5854 attached [pid 5853] setpgid(0, 0 [pid 5852] <... openat resumed>) = 3 [pid 5850] <... close resumed>) = 0 [pid 5854] set_robust_list(0x55557e7b2660, 24 [pid 5853] <... setpgid resumed>) = 0 [pid 5852] write(3, "1000", 4 [pid 5850] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5854] <... set_robust_list resumed>) = 0 [pid 5853] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5852] <... write resumed>) = 4 [pid 5851] openat(AT_FDCWD, "/dev/loop4", O_RDWR./strace-static-x86_64: Process 5855 attached [pid 5854] chdir("./0" [pid 5853] <... openat resumed>) = 3 [pid 5852] close(3 [pid 5851] <... openat resumed>) = 3 [pid 5849] <... clone resumed>, child_tidptr=0x55557e7b2650) = 5854 [pid 5855] set_robust_list(0x55557e7b2660, 24 [pid 5854] <... chdir resumed>) = 0 [pid 5853] write(3, "1000", 4 [pid 5852] <... close resumed>) = 0 [pid 5855] <... set_robust_list resumed>) = 0 [pid 5854] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5853] <... write resumed>) = 4 [pid 5852] symlink("/dev/binderfs", "./binderfs" [pid 5853] close(3 [pid 5851] ioctl(3, LOOP_CLR_FD [pid 5850] <... clone resumed>, child_tidptr=0x55557e7b2650) = 5855 [pid 5853] <... close resumed>) = 0 [pid 5852] <... symlink resumed>) = 0 [pid 5851] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5854] <... prctl resumed>) = 0 [pid 5855] chdir("./0" [pid 5854] setpgid(0, 0 [pid 5853] symlink("/dev/binderfs", "./binderfs" [pid 5855] <... chdir resumed>) = 0 [pid 5854] <... setpgid resumed>) = 0 [pid 5852] write(1, "executing program\n", 18executing program [pid 5853] <... symlink resumed>) = 0 [pid 5851] close(3executing program [pid 5855] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5854] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5853] write(1, "executing program\n", 18 [pid 5852] <... write resumed>) = 18 [pid 5851] <... close resumed>) = 0 [pid 5855] <... prctl resumed>) = 0 [pid 5854] <... openat resumed>) = 3 [pid 5853] <... write resumed>) = 18 [pid 5851] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5856 attached [pid 5855] setpgid(0, 0 [pid 5854] write(3, "1000", 4 [pid 5853] memfd_create("syzkaller", 0 [pid 5852] memfd_create("syzkaller", 0 [pid 5855] <... setpgid resumed>) = 0 [pid 5854] <... write resumed>) = 4 [pid 5856] set_robust_list(0x55557e7b2660, 24 [pid 5855] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5854] close(3 [pid 5853] <... memfd_create resumed>) = 3 [pid 5852] <... memfd_create resumed>) = 3 [pid 5851] <... clone resumed>, child_tidptr=0x55557e7b2650) = 5856 [pid 5856] <... set_robust_list resumed>) = 0 [pid 5855] <... openat resumed>) = 3 [pid 5854] <... close resumed>) = 0 [pid 5853] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5852] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5856] chdir("./0" [pid 5855] write(3, "1000", 4 [pid 5856] <... chdir resumed>) = 0 [pid 5855] <... write resumed>) = 4 [pid 5856] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5855] close(3 [pid 5856] <... prctl resumed>) = 0 [pid 5855] <... close resumed>) = 0 [pid 5856] setpgid(0, 0 [pid 5855] symlink("/dev/binderfs", "./binderfs" [pid 5856] <... setpgid resumed>) = 0 [pid 5856] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5855] <... symlink resumed>) = 0 [pid 5856] <... openat resumed>) = 3 [pid 5856] write(3, "1000", 4) = 4 [pid 5856] close(3) = 0 [pid 5855] write(1, "executing program\n", 18executing program [pid 5856] symlink("/dev/binderfs", "./binderfs") = 0 [pid 5855] <... write resumed>) = 18 [pid 5853] <... mmap resumed>) = 0x7fe4d4400000 [pid 5854] symlink("/dev/binderfs", "./binderfs" [pid 5852] <... mmap resumed>) = 0x7fe4d4400000 [pid 5855] memfd_create("syzkaller", 0 [pid 5856] write(1, "executing program\n", 18executing program ) = 18 executing program [pid 5856] memfd_create("syzkaller", 0 [pid 5855] <... memfd_create resumed>) = 3 [pid 5854] <... symlink resumed>) = 0 [pid 5854] write(1, "executing program\n", 18) = 18 [pid 5854] memfd_create("syzkaller", 0) = 3 [pid 5856] <... memfd_create resumed>) = 3 [pid 5855] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5854] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5856] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5855] <... mmap resumed>) = 0x7fe4d4400000 [pid 5856] <... mmap resumed>) = 0x7fe4d4400000 [pid 5854] <... mmap resumed>) = 0x7fe4d4400000 [pid 5855] write(3, "\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., 16777216 [pid 5853] write(3, "\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., 16777216 [pid 5852] 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 5856] write(3, "\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., 16777216 [pid 5854] write(3, "\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., 16777216 [pid 5855] <... write resumed>) = 16777216 [pid 5856] <... write resumed>) = 16777216 [pid 5855] munmap(0x7fe4d4400000, 138412032 [pid 5853] <... write resumed>) = 16777216 [pid 5856] munmap(0x7fe4d4400000, 138412032 [pid 5853] munmap(0x7fe4d4400000, 138412032 [pid 5852] <... write resumed>) = 16777216 [pid 5852] munmap(0x7fe4d4400000, 138412032 [pid 5856] <... munmap resumed>) = 0 [pid 5855] <... munmap resumed>) = 0 [pid 5856] openat(AT_FDCWD, "/dev/loop4", O_RDWR [pid 5854] <... write resumed>) = 16777216 [pid 5853] <... munmap resumed>) = 0 [pid 5852] <... munmap resumed>) = 0 [pid 5856] <... openat resumed>) = 4 [pid 5852] openat(AT_FDCWD, "/dev/loop0", O_RDWR [pid 5856] ioctl(4, LOOP_SET_FD, 3 [pid 5853] openat(AT_FDCWD, "/dev/loop1", O_RDWR [pid 5852] <... openat resumed>) = 4 [pid 5853] <... openat resumed>) = 4 [pid 5852] ioctl(4, LOOP_SET_FD, 3 [pid 5853] ioctl(4, LOOP_SET_FD, 3 [pid 5852] <... ioctl resumed>) = 0 [pid 5856] <... ioctl resumed>) = 0 [pid 5855] openat(AT_FDCWD, "/dev/loop3", O_RDWR [pid 5854] munmap(0x7fe4d4400000, 138412032 [pid 5855] <... openat resumed>) = 4 [pid 5855] ioctl(4, LOOP_SET_FD, 3 [pid 5852] close(3) = 0 [pid 5853] <... ioctl resumed>) = 0 [pid 5852] close(4 [pid 5856] close(3) = 0 [pid 5854] <... munmap resumed>) = 0 [pid 5853] close(3 [pid 5852] <... close resumed>) = 0 [pid 5856] close(4 [pid 5854] openat(AT_FDCWD, "/dev/loop2", O_RDWR [pid 5852] mkdir("./file0", 0777 [pid 5856] <... close resumed>) = 0 [pid 5855] <... ioctl resumed>) = 0 [pid 5853] <... close resumed>) = 0 [pid 5855] close(3 [pid 5852] <... mkdir resumed>) = 0 [pid 5856] mkdir("./file0", 0777 [pid 5852] mount("/dev/loop0", "./file0", "jfs", MS_I_VERSION, "" [pid 5855] <... close resumed>) = 0 [pid 5855] close(4) = 0 [pid 5855] mkdir("./file0", 0777) = 0 [pid 5856] <... mkdir resumed>) = 0 [pid 5854] <... openat resumed>) = 4 [pid 5853] close(4 [pid 5856] mount("/dev/loop4", "./file0", "jfs", MS_I_VERSION, "" [pid 5854] ioctl(4, LOOP_SET_FD, 3 [pid 5853] <... close resumed>) = 0 [pid 5853] mkdir("./file0", 0777 [pid 5855] mount("/dev/loop3", "./file0", "jfs", MS_I_VERSION, "" [pid 5853] <... mkdir resumed>) = 0 [pid 5852] <... mount resumed>) = 0 [pid 5852] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY [pid 5853] mount("/dev/loop1", "./file0", "jfs", MS_I_VERSION, "" [pid 5852] <... openat resumed>) = 3 [ 230.969161][ T5856] loop4: detected capacity change from 0 to 32768 [ 230.969160][ T5852] loop0: detected capacity change from 0 to 32768 [ 230.969830][ T5853] loop1: detected capacity change from 0 to 32768 [ 230.983488][ T5855] loop3: detected capacity change from 0 to 32768 [pid 5852] chdir("./file0") = 0 [pid 5852] openat(AT_FDCWD, "/dev/loop0", O_RDWR) = -1 EBUSY (Device or resource busy) [pid 5852] openat(AT_FDCWD, "./file1", O_RDWR|O_CREAT|O_SYNC|O_NOATIME|FASYNC, 0424 [pid 5854] <... ioctl resumed>) = 0 [pid 5854] close(3) = 0 [pid 5854] close(4) = 0 [pid 5854] mkdir("./file0", 0777) = 0 [pid 5854] mount("/dev/loop2", "./file0", "jfs", MS_I_VERSION, "" [pid 5856] <... mount resumed>) = 0 [pid 5856] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY [pid 5853] <... mount resumed>) = 0 [pid 5856] <... openat resumed>) = 3 [pid 5853] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY [pid 5852] <... openat resumed>) = 4 [pid 5856] chdir("./file0" [pid 5855] <... mount resumed>) = 0 [pid 5853] <... openat resumed>) = 3 [pid 5852] openat(AT_FDCWD, "./bus", O_RDWR|O_CREAT|O_SYNC|O_DIRECT, 0737 [pid 5856] <... chdir resumed>) = 0 [pid 5853] chdir("./file0") = 0 [pid 5853] openat(AT_FDCWD, "/dev/loop1", O_RDWR [pid 5856] openat(AT_FDCWD, "/dev/loop4", O_RDWR [pid 5854] <... mount resumed>) = 0 [pid 5853] <... openat resumed>) = -1 EBUSY (Device or resource busy) [pid 5854] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY [pid 5853] openat(AT_FDCWD, "./file1", O_RDWR|O_CREAT|O_SYNC|O_NOATIME|FASYNC, 0424 [pid 5856] <... openat resumed>) = -1 EBUSY (Device or resource busy) [pid 5854] <... openat resumed>) = 3 [ 231.030370][ T5854] loop2: detected capacity change from 0 to 32768 [pid 5856] openat(AT_FDCWD, "./file1", O_RDWR|O_CREAT|O_SYNC|O_NOATIME|FASYNC, 0424 [pid 5854] chdir("./file0" [pid 5855] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY [pid 5853] <... openat resumed>) = 4 [pid 5855] <... openat resumed>) = 3 [pid 5853] openat(AT_FDCWD, "./bus", O_RDWR|O_CREAT|O_SYNC|O_DIRECT, 0737 [pid 5855] chdir("./file0") = 0 [pid 5855] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = -1 EBUSY (Device or resource busy) [pid 5855] openat(AT_FDCWD, "./file1", O_RDWR|O_CREAT|O_SYNC|O_NOATIME|FASYNC, 0424 [pid 5854] <... chdir resumed>) = 0 [pid 5855] <... openat resumed>) = 4 [pid 5854] openat(AT_FDCWD, "/dev/loop2", O_RDWR [pid 5855] openat(AT_FDCWD, "./bus", O_RDWR|O_CREAT|O_SYNC|O_DIRECT, 0737 [pid 5856] <... openat resumed>) = 4 [pid 5854] <... openat resumed>) = -1 EBUSY (Device or resource busy) [ 231.076910][ T5852] ERROR: (device loop0): diWrite: ixpxd invalid [ 231.076910][ T5852] [ 231.098907][ T5853] ERROR: (device loop1): diWrite: ixpxd invalid [ 231.098907][ T5853] [ 231.110154][ T5855] ERROR: (device loop3): diWrite: ixpxd invalid [ 231.110154][ T5855] [ 231.119678][ T5852] ERROR: (device loop0): remounting filesystem as read-only [pid 5856] openat(AT_FDCWD, "./bus", O_RDWR|O_CREAT|O_SYNC|O_DIRECT, 0737 [pid 5854] openat(AT_FDCWD, "./file1", O_RDWR|O_CREAT|O_SYNC|O_NOATIME|FASYNC, 0424 [pid 5855] <... openat resumed>) = -1 EIO (Input/output error) [ 231.120069][ T5853] ERROR: (device loop1): remounting filesystem as read-only [ 231.127502][ T5852] ERROR: (device loop0): txCommit: [ 231.127502][ T5852] [ 231.139643][ T5853] ERROR: (device loop1): txCommit: [ 231.139643][ T5853] [ 231.149120][ T5855] ERROR: (device loop3): remounting filesystem as read-only [ 231.149145][ T5855] ERROR: (device loop3): txCommit: [ 231.149145][ T5855] [ 231.152761][ T5856] ERROR: (device loop4): diWrite: ixpxd invalid [ 231.152761][ T5856] [pid 5855] write(4, "\x11\x00\x00\x00\x10\x00\x00\xfa\x00\x00\x00\x00\x00\x00\x00\x00\xff\xff\xff\xff\x00\x00\x00\x00", 24 [pid 5852] <... openat resumed>) = -1 EIO (Input/output error) [pid 5854] <... openat resumed>) = 4 [pid 5853] <... openat resumed>) = -1 EIO (Input/output error) [pid 5855] <... write resumed>) = 24 [pid 5854] openat(AT_FDCWD, "./bus", O_RDWR|O_CREAT|O_SYNC|O_DIRECT, 0737 [pid 5853] write(4, "\x11\x00\x00\x00\x10\x00\x00\xfa\x00\x00\x00\x00\x00\x00\x00\x00\xff\xff\xff\xff\x00\x00\x00\x00", 24 [pid 5855] exit_group(0) = ? [pid 5855] +++ exited with 0 +++ [pid 5852] write(4, "\x11\x00\x00\x00\x10\x00\x00\xfa\x00\x00\x00\x00\x00\x00\x00\x00\xff\xff\xff\xff\x00\x00\x00\x00", 24 [pid 5850] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5855, si_uid=0, si_status=0, si_utime=10 /* 0.10 s */, si_stime=22 /* 0.22 s */} --- [pid 5850] restart_syscall(<... resuming interrupted clone ...>) = 0 [pid 5853] <... write resumed>) = 24 [pid 5853] exit_group(0) = ? [pid 5850] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5852] <... write resumed>) = 24 [pid 5852] exit_group(0) = ? [pid 5853] +++ exited with 0 +++ [pid 5852] +++ exited with 0 +++ [pid 5850] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5850] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 5847] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5852, si_uid=0, si_status=0, si_utime=9 /* 0.09 s */, si_stime=22 /* 0.22 s */} --- [pid 5848] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5853, si_uid=0, si_status=0, si_utime=6 /* 0.06 s */, si_stime=28 /* 0.28 s */} --- [pid 5847] restart_syscall(<... resuming interrupted clone ...> [pid 5850] newfstatat(3, "", [pid 5848] restart_syscall(<... resuming interrupted clone ...> [pid 5847] <... restart_syscall resumed>) = 0 [pid 5850] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5850] getdents64(3, 0x55557e7b36f0 /* 4 entries */, 32768) = 112 [pid 5848] <... restart_syscall resumed>) = 0 [pid 5847] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5854] <... openat resumed>) = -1 EIO (Input/output error) [pid 5856] <... openat resumed>) = -1 EIO (Input/output error) [pid 5850] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5847] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5850] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5847] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5854] write(4, "\x11\x00\x00\x00\x10\x00\x00\xfa\x00\x00\x00\x00\x00\x00\x00\x00\xff\xff\xff\xff\x00\x00\x00\x00", 24 [pid 5856] write(4, "\x11\x00\x00\x00\x10\x00\x00\xfa\x00\x00\x00\x00\x00\x00\x00\x00\xff\xff\xff\xff\x00\x00\x00\x00", 24 [pid 5854] <... write resumed>) = 24 [pid 5850] newfstatat(AT_FDCWD, "./0/binderfs", [pid 5848] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5847] <... openat resumed>) = 3 [pid 5854] exit_group(0 [pid 5850] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5854] <... exit_group resumed>) = ? [pid 5848] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5850] unlink("./0/binderfs" [pid 5847] newfstatat(3, "", [pid 5854] +++ exited with 0 +++ [pid 5850] <... unlink resumed>) = 0 [pid 5848] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5847] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5856] <... write resumed>) = 24 [pid 5850] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5849] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5854, si_uid=0, si_status=0, si_utime=4 /* 0.04 s */, si_stime=24 /* 0.24 s */} --- [pid 5848] <... openat resumed>) = 3 [pid 5847] getdents64(3, [pid 5856] exit_group(0 [pid 5849] restart_syscall(<... resuming interrupted clone ...> [pid 5848] newfstatat(3, "", [pid 5847] <... getdents64 resumed>0x55557e7b36f0 /* 4 entries */, 32768) = 112 [pid 5856] <... exit_group resumed>) = ? [pid 5848] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5856] +++ exited with 0 +++ [pid 5848] getdents64(3, [pid 5847] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5851] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5856, si_uid=0, si_status=0, si_utime=7 /* 0.07 s */, si_stime=25 /* 0.25 s */} --- [pid 5847] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5851] restart_syscall(<... resuming interrupted clone ...> [pid 5848] <... getdents64 resumed>0x55557e7b36f0 /* 4 entries */, 32768) = 112 [pid 5847] newfstatat(AT_FDCWD, "./0/binderfs", [pid 5848] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5847] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5848] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5847] unlink("./0/binderfs" [pid 5848] newfstatat(AT_FDCWD, "./0/binderfs", [pid 5847] <... unlink resumed>) = 0 [pid 5849] <... restart_syscall resumed>) = 0 [pid 5848] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5848] unlink("./0/binderfs" [pid 5847] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5851] <... restart_syscall resumed>) = 0 [pid 5849] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5848] <... unlink resumed>) = 0 [pid 5848] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5849] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5851] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5849] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5851] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5851] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5849] <... openat resumed>) = 3 [pid 5851] <... openat resumed>) = 3 [pid 5849] newfstatat(3, "", [pid 5851] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5849] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5851] getdents64(3, [pid 5849] getdents64(3, [pid 5851] <... getdents64 resumed>0x55557e7b36f0 /* 4 entries */, 32768) = 112 [pid 5851] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5849] <... getdents64 resumed>0x55557e7b36f0 /* 4 entries */, 32768) = 112 [pid 5851] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5851] newfstatat(AT_FDCWD, "./0/binderfs", [pid 5849] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5851] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5849] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5851] unlink("./0/binderfs") = 0 [pid 5849] newfstatat(AT_FDCWD, "./0/binderfs", [pid 5851] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5849] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5849] unlink("./0/binderfs") = 0 [ 231.175351][ T5854] ERROR: (device loop2): diWrite: ixpxd invalid [ 231.175351][ T5854] [ 231.198012][ T5854] ERROR: (device loop2): remounting filesystem as read-only [ 231.200170][ T5856] ERROR: (device loop4): remounting filesystem as read-only [ 231.205651][ T5854] ERROR: (device loop2): txCommit: [ 231.205651][ T5854] [ 231.213982][ T5856] ERROR: (device loop4): txCommit: [ 231.213982][ T5856] [ 283.246259][ T5850] jfs_flush_journal: synclist not empty [ 283.251960][ T5850] metapage: ffff88807a8bb2e8: 00001000 00000000 000036c8 00000000 [ 283.259875][ T5850] metapage: ffff88807a8bb2f8: 27673a28 ffff8880 27673a28 ffff8880 [ 283.267802][ T5850] metapage: ffff88807a8bb308: 00000004 00000000 00000000 00000000 [ 283.267808][ T5848] jfs_flush_journal: synclist not empty [ 283.275617][ T5848] metapage: ffff88804d7c38b8: 00001000 00000000 000036c8 00000000 [ 283.281214][ T5850] metapage: ffff88807a8bb318: 7ab0d000 ffff8880 0000001c 00000000 [ 283.281239][ T5850] metapage: ffff88807a8bb328: 00000000 dead4ead ffffffff 00000000 [ 283.281258][ T5850] metapage: ffff88807a8bb338: ffffffff ffffffff 9a4c3520 ffffffff [ 283.281275][ T5850] metapage: ffff88807a8bb348: 93c401f8 ffffffff 00000000 00000000 [ 283.281292][ T5850] metapage: ffff88807a8bb358: 8c425fa0 ffffffff 00000300 00000000 [ 283.281308][ T5850] metapage: ffff88807a8bb368: 7a8bb368 ffff8880 7a8bb368 ffff8880 [ 283.290114][ T5849] jfs_flush_journal: synclist not empty [ 283.296982][ T5850] metapage: ffff88807a8bb378: 01eac340 ffffea00 4dc34000 ffff8880 [ 283.297003][ T5850] metapage: ffff88807a8bb388: 00001000 00003794 00000001 00000000 [ 283.304842][ T5851] jfs_flush_journal: synclist not empty [ 283.313199][ T5850] metapage: ffff88807a8bb398: 27673800 ffff8880 [ 283.328282][ T5847] jfs_flush_journal: synclist not empty [ 283.328301][ T5847] metapage: ffff88807bae1e88: 00001000 00000000 000036c8 00000000 [ 283.328321][ T5847] metapage: ffff88807bae1e98: 34df4a28 ffff8880 34df4a28 ffff8880 [ 283.337050][ T5850] page: ffffea0001eac340: 00fff0000000412c ffffea0001eac308 [ 283.341675][ T5849] metapage: ffff88804d7c3e88: 00001000 00000000 000036c8 00000000 [ 283.349944][ T5850] page: ffffea0001eac350: ffffea0001ee74c8 ffff8880769a0650 [ 283.357333][ T5848] metapage: ffff88804d7c38c8: 7cd17228 ffff8880 7cd17228 ffff8880 [ 283.363239][ T5850] page: ffffea0001eac360: 000000000000001c ffff88807a8bb2e8 [ 283.382533][ T5848] metapage: ffff88804d7c38d8: 00000004 00000000 00000000 00000000 [ 283.382557][ T5848] metapage: ffff88804d7c38e8: 4d7c2000 ffff8880 0000001c 00000000 [ 283.382575][ T5848] metapage: ffff88804d7c38f8: 00000000 dead4ead ffffffff 00000000 [ 283.390429][ T5851] metapage: ffff88807a8bb4d8: 00001000 00000000 000036c8 00000000 [ 283.397734][ T5849] metapage: ffff88804d7c3e98: 7cd17a28 ffff8880 7cd17a28 ffff8880 [ 283.397753][ T5849] metapage: ffff88804d7c3ea8: 00000004 00000000 00000000 00000000 [ 283.405545][ T5847] metapage: ffff88807bae1ea8: 00000004 00000000 00000000 00000000 [ 283.428543][ T5848] metapage: ffff88804d7c3908: ffffffff ffffffff 9a4c3520 ffffffff [ 283.435896][ T5851] metapage: ffff88807a8bb4e8: 267fd228 ffff8880 267fd228 ffff8880 [ 283.451519][ T5849] metapage: ffff88804d7c3eb8: 7a9b1000 ffff8880 0000001c 00000000 [ 283.451542][ T5849] metapage: ffff88804d7c3ec8: 00000000 dead4ead ffffffff 00000000 [ 283.451559][ T5849] metapage: ffff88804d7c3ed8: ffffffff ffffffff 9a4c3520 ffffffff [ 283.451577][ T5849] metapage: ffff88804d7c3ee8: 93c401f8 ffffffff 00000000 00000000 [ 283.459839][ T5850] page: ffffea0001eac370: 00000003ffffffff ffff88801beec000 [ 283.467529][ T5848] metapage: ffff88804d7c3918: 93c401f8 ffffffff 00000000 00000000 [ 283.476880][ T5847] metapage: ffff88807bae1eb8: 346f0000 ffff8880 0000001c 00000000 [ 283.483329][ T5849] metapage: ffff88804d7c3ef8: 8c425fa0 ffffffff 00000300 00000000 [ 283.491509][ T5851] metapage: ffff88807a8bb4f8: 00000004 00000000 00000000 00000000 [ 283.498889][ T5848] metapage: ffff88804d7c3928: 8c425fa0 ffffffff 00000300 00000000 [ 283.507451][ T5847] metapage: ffff88807bae1ec8: 00000000 dead4ead ffffffff 00000000 [ 283.514596][ T5849] metapage: ffff88804d7c3f08: 4d7c3f08 ffff8880 4d7c3f08 ffff8880 [ 283.522579][ T5851] metapage: ffff88807a8bb508: 4d422000 ffff8880 0000001c 00000000 [ 283.530288][ T5848] metapage: ffff88804d7c3938: 4d7c3938 ffff8880 4d7c3938 ffff8880 [ 283.537746][ T5847] metapage: ffff88807bae1ed8: ffffffff ffffffff 9a4c3520 ffffffff [ 283.545481][ T5848] metapage: ffff88804d7c3948: 0135f080 ffffea00 7f5b6000 ffff8880 [ 283.553919][ T5851] metapage: ffff88807a8bb518: 00000000 dead4ead ffffffff 00000000 [ 283.561008][ T5849] metapage: ffff88804d7c3f18: 01ea6c40 ffffea00 7d176000 ffff8880 [ 283.568785][ T5847] metapage: ffff88807bae1ee8: 93c401f8 ffffffff 00000000 00000000 [ 283.592069][ T5848] metapage: ffff88804d7c3958: 00001000 00003794 00000001 00000000 [ 283.592091][ T5848] metapage: ffff88804d7c3968: 7cd17000 ffff8880 [ 283.592108][ T5848] page: ffffea000135f080: 00fff0000000412c ffffea000135f008 [ 283.592122][ T5848] page: ffffea000135f090: ffffea0001ee9748 ffff8880768cc6d8 [ 283.592136][ T5848] page: ffffea000135f0a0: 000000000000001c ffff88804d7c38b8 [ 283.592151][ T5848] page: ffffea000135f0b0: 00000003ffffffff ffff88801beec000 [ 283.594398][ T5849] metapage: ffff88804d7c3f28: 00001000 00003794 00000001 00000000 [ 283.600199][ T5851] metapage: ffff88807a8bb528: ffffffff ffffffff 9a4c3520 ffffffff [ 283.623507][ T5849] metapage: ffff88804d7c3f38: 7cd17800 ffff8880 [ 283.623533][ T5849] page: ffffea0001ea6c40: 00fff0000000412c ffffea0001ee74c8 [ 283.623550][ T5849] page: ffffea0001ea6c50: ffffea0001e2da88 ffff8880768d21f8 [ 283.631763][ T5847] metapage: ffff88807bae1ef8: 8c425fa0 ffffffff 00000300 00000000 [ 283.654899][ T5849] page: ffffea0001ea6c60: 000000000000001c ffff88804d7c3e88 [ 283.661369][ T5851] metapage: ffff88807a8bb538: 93c401f8 ffffffff 00000000 00000000 [ 283.668702][ T5849] page: ffffea0001ea6c70: 00000003ffffffff ffff88801beec000 [ 283.675860][ T5851] metapage: ffff88807a8bb548: 8c425fa0 ffffffff 00000300 00000000 [ 283.686383][ T5847] metapage: ffff88807bae1f08: 7bae1f08 ffff8880 7bae1f08 ffff8880 [ 283.690520][ T5851] metapage: ffff88807a8bb558: 7a8bb558 ffff8880 7a8bb558 ffff8880 [ 283.698238][ T5847] metapage: ffff88807bae1f18: 00d1bc00 ffffea00 7d30c000 ffff8880 [ 283.706954][ T5851] metapage: ffff88807a8bb568: 01350880 ffffea00 127e4000 ffff8880 [ 283.712842][ T5847] metapage: ffff88807bae1f28: 00001000 00003794 00000001 00000000 [ 283.720641][ T5851] metapage: ffff88807a8bb578: 00001000 00003794 00000001 00000000 [ 283.727482][ T5847] metapage: ffff88807bae1f38: 34df4800 ffff8880 [ 283.727502][ T5847] page: ffffea0000d1bc00: 00fff0000000412c ffffea0000d20588 [ 283.727517][ T5847] page: ffffea0000d1bc10: ffffea0001df0408 ffff8880768c8650 [ 283.727531][ T5847] page: ffffea0000d1bc20: 000000000000001c ffff88807bae1e88 [ 283.736032][ T5851] metapage: ffff88807a8bb588: 267fd000 ffff8880 [ 283.742627][ T5847] page: ffffea0000d1bc30: 00000003ffffffff ffff88801beec000 [ 283.750642][ T5851] page: ffffea0001350880: 00fff0000000412c ffffea0001f17788 [ 283.861910][ T5851] page: ffffea0001350890: ffffea0001e516c8 ffff8880768cb468 [ 283.869274][ T5851] page: ffffea00013508a0: 000000000000001c ffff88807a8bb4d8 [ 283.876591][ T5851] page: ffffea00013508b0: 00000003ffffffff ffff88801beec000 [ 335.546243][ T5850] jfs_flush_journal: synclist not empty [ 335.551966][ T5850] metapage: ffff88807a8bb2e8: 00001000 00000000 000036c8 00000000 [ 335.559852][ T5850] metapage: ffff88807a8bb2f8: 27673a28 ffff8880 27673a28 ffff8880 [ 335.567854][ T5850] metapage: ffff88807a8bb308: 00000004 00000000 00000000 00000000 [ 335.575687][ T5850] metapage: ffff88807a8bb318: 7ab0d000 ffff8880 0000001c 00000000 [ 335.583570][ T5850] metapage: ffff88807a8bb328: 00000000 dead4ead ffffffff 00000000 [ 335.591400][ T5850] metapage: ffff88807a8bb338: ffffffff ffffffff 9a4c3520 ffffffff [ 335.599246][ T5850] metapage: ffff88807a8bb348: 93c401f8 ffffffff 00000000 00000000 [ 335.607075][ T5850] metapage: ffff88807a8bb358: 8c425fa0 ffffffff 00000300 00000000 [ 335.614864][ T5850] metapage: ffff88807a8bb368: 7a8bb368 ffff8880 7a8bb368 ffff8880 [ 335.622720][ T5850] metapage: ffff88807a8bb378: 01eac340 ffffea00 4dc34000 ffff8880 [ 335.630578][ T5850] metapage: ffff88807a8bb388: 00001000 00003794 00000001 00000000 [ 335.638436][ T5850] metapage: ffff88807a8bb398: 27673800 ffff8880 [pid 5849] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5850] <... umount2 resumed>) = 0 [pid 5850] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5850] newfstatat(AT_FDCWD, "./0/file0", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5850] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5850] openat(AT_FDCWD, "./0/file0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4 [pid 5850] newfstatat(4, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5850] getdents64(4, 0x55557e7bb730 /* 2 entries */, 32768) = 48 [ 335.644687][ T5850] page: ffffea0001eac340: 00fff0000000412c ffffea0001e51648 [ 335.651994][ T5850] page: ffffea0001eac350: ffffea0001ea6c48 ffff8880769a0650 [ 335.659316][ T5850] page: ffffea0001eac360: 000000000000001c ffff88807a8bb2e8 [ 335.666621][ T5850] page: ffffea0001eac370: 00000003ffffffff ffff88801beec000 [pid 5850] getdents64(4, 0x55557e7bb730 /* 0 entries */, 32768) = 0 [pid 5850] close(4) = 0 [pid 5850] rmdir("./0/file0") = 0 [pid 5850] getdents64(3, 0x55557e7b36f0 /* 0 entries */, 32768) = 0 [pid 5850] close(3) = 0 [pid 5850] rmdir("./0") = 0 [pid 5850] mkdir("./1", 0777) = 0 [pid 5850] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = 3 [pid 5850] ioctl(3, LOOP_CLR_FD) = 0 [pid 5850] close(3) = 0 [pid 5850] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5861 attached , child_tidptr=0x55557e7b2650) = 5861 [pid 5861] set_robust_list(0x55557e7b2660, 24) = 0 [pid 5861] chdir("./1") = 0 [pid 5861] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5861] setpgid(0, 0) = 0 [pid 5861] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC) = 3 [pid 5861] write(3, "1000", 4) = 4 [pid 5861] close(3) = 0 [pid 5861] symlink("/dev/binderfs", "./binderfs") = 0 executing program [pid 5861] write(1, "executing program\n", 18) = 18 [pid 5861] memfd_create("syzkaller", 0) = 3 [pid 5861] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7fe4d4400000 [pid 5861] 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 5861] munmap(0x7fe4d4400000, 138412032) = 0 [pid 5861] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = 4 [pid 5861] ioctl(4, LOOP_SET_FD, 3) = 0 [pid 5861] close(3) = 0 [pid 5861] close(4) = 0 [pid 5861] mkdir("./file0", 0777) = 0 [ 336.128626][ T5861] loop3: detected capacity change from 0 to 32768 [pid 5861] mount("/dev/loop3", "./file0", "jfs", MS_I_VERSION, "") = 0 [pid 5861] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY) = 3 [pid 5861] chdir("./file0") = 0 [pid 5861] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = -1 EBUSY (Device or resource busy) [pid 5861] openat(AT_FDCWD, "./file1", O_RDWR|O_CREAT|O_SYNC|O_NOATIME|FASYNC, 0424) = 4 [pid 5861] openat(AT_FDCWD, "./bus", O_RDWR|O_CREAT|O_SYNC|O_DIRECT, 0737) = -1 EIO (Input/output error) [pid 5861] write(4, "\x11\x00\x00\x00\x10\x00\x00\xfa\x00\x00\x00\x00\x00\x00\x00\x00\xff\xff\xff\xff\x00\x00\x00\x00", 24) = 24 [pid 5861] exit_group(0) = ? [pid 5861] +++ exited with 0 +++ [pid 5850] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5861, si_uid=0, si_status=0, si_utime=1 /* 0.01 s */, si_stime=16 /* 0.16 s */} --- [pid 5850] umount2("./1", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5850] openat(AT_FDCWD, "./1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [ 336.204630][ T5861] ERROR: (device loop3): diWrite: ixpxd invalid [ 336.204630][ T5861] [ 336.213834][ T5861] ERROR: (device loop3): remounting filesystem as read-only [ 336.221883][ T5861] ERROR: (device loop3): txCommit: [ 336.221883][ T5861] [pid 5850] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5850] getdents64(3, 0x55557e7b36f0 /* 4 entries */, 32768) = 112 [pid 5850] umount2("./1/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5850] newfstatat(AT_FDCWD, "./1/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5850] unlink("./1/binderfs") = 0 [ 387.676235][ T5848] jfs_flush_journal: synclist not empty [ 387.681815][ T5848] metapage: ffff88804d7c38b8: 00001000 00000000 000036c8 00000000 [ 387.689694][ T5848] metapage: ffff88804d7c38c8: 7cd17228 ffff8880 7cd17228 ffff8880 [ 387.697574][ T5848] metapage: ffff88804d7c38d8: 00000004 00000000 00000000 00000000 [ 387.705399][ T5848] metapage: ffff88804d7c38e8: 4d7c2000 ffff8880 0000001c 00000000 [ 387.713277][ T5848] metapage: ffff88804d7c38f8: 00000000 dead4ead ffffffff 00000000 [ 387.721161][ T5848] metapage: ffff88804d7c3908: ffffffff ffffffff 9a4c3520 ffffffff [ 387.729005][ T5848] metapage: ffff88804d7c3918: 93c401f8 ffffffff 00000000 00000000 [ 387.736858][ T5848] metapage: ffff88804d7c3928: 8c425fa0 ffffffff 00000300 00000000 [ 387.744651][ T5848] metapage: ffff88804d7c3938: 4d7c3938 ffff8880 4d7c3938 ffff8880 [ 387.752502][ T5848] metapage: ffff88804d7c3948: 0135f080 ffffea00 7f5b6000 ffff8880 [ 387.760354][ T5848] metapage: ffff88804d7c3958: 00001000 00003794 00000001 00000000 [ 387.768189][ T5848] metapage: ffff88804d7c3968: 7cd17000 ffff8880 [pid 5850] umount2("./1/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5848] <... umount2 resumed>) = 0 [pid 5848] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5848] newfstatat(AT_FDCWD, "./0/file0", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5848] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5848] openat(AT_FDCWD, "./0/file0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4 [pid 5848] newfstatat(4, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [ 387.774467][ T5848] page: ffffea000135f080: 00fff0000000412c ffffea0000cbd8c8 [ 387.781816][ T5848] page: ffffea000135f090: ffffea0001e267c8 ffff8880768cc6d8 [ 387.789135][ T5848] page: ffffea000135f0a0: 000000000000001c ffff88804d7c38b8 [ 387.796467][ T5848] page: ffffea000135f0b0: 00000003ffffffff ffff88801beec000 [pid 5848] getdents64(4, 0x55557e7bb730 /* 2 entries */, 32768) = 48 [pid 5848] getdents64(4, 0x55557e7bb730 /* 0 entries */, 32768) = 0 [pid 5848] close(4) = 0 [pid 5848] rmdir("./0/file0") = 0 [pid 5848] getdents64(3, 0x55557e7b36f0 /* 0 entries */, 32768) = 0 [pid 5848] close(3) = 0 [pid 5848] rmdir("./0") = 0 [pid 5848] mkdir("./1", 0777) = 0 [pid 5848] openat(AT_FDCWD, "/dev/loop1", O_RDWR) = 3 [pid 5848] ioctl(3, LOOP_CLR_FD) = 0 [pid 5848] close(3) = 0 [pid 5848] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5870 attached , child_tidptr=0x55557e7b2650) = 5870 [pid 5870] set_robust_list(0x55557e7b2660, 24) = 0 [pid 5870] chdir("./1") = 0 [pid 5870] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5870] setpgid(0, 0) = 0 [pid 5870] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC) = 3 [pid 5870] write(3, "1000", 4) = 4 [pid 5870] close(3) = 0 [pid 5870] symlink("/dev/binderfs", "./binderfs") = 0 [pid 5870] write(1, "executing program\n", 18executing program ) = 18 [pid 5870] memfd_create("syzkaller", 0) = 3 [pid 5870] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7fe4d4400000 [pid 5870] 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 5870] munmap(0x7fe4d4400000, 138412032) = 0 [pid 5870] openat(AT_FDCWD, "/dev/loop1", O_RDWR) = 4 [pid 5870] ioctl(4, LOOP_SET_FD, 3) = 0 [pid 5870] close(3) = 0 [pid 5870] close(4) = 0 [pid 5870] mkdir("./file0", 0777) = 0 [pid 5870] mount("/dev/loop1", "./file0", "jfs", MS_I_VERSION, "") = 0 [pid 5870] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY) = 3 [pid 5870] chdir("./file0") = 0 [pid 5870] openat(AT_FDCWD, "/dev/loop1", O_RDWR) = -1 EBUSY (Device or resource busy) [pid 5870] openat(AT_FDCWD, "./file1", O_RDWR|O_CREAT|O_SYNC|O_NOATIME|FASYNC, 0424) = 4 [ 388.254567][ T5870] loop1: detected capacity change from 0 to 32768 [pid 5870] openat(AT_FDCWD, "./bus", O_RDWR|O_CREAT|O_SYNC|O_DIRECT, 0737) = -1 EIO (Input/output error) [pid 5870] write(4, "\x11\x00\x00\x00\x10\x00\x00\xfa\x00\x00\x00\x00\x00\x00\x00\x00\xff\xff\xff\xff\x00\x00\x00\x00", 24) = 24 [pid 5870] exit_group(0) = ? [ 388.305415][ T5870] ERROR: (device loop1): diWrite: ixpxd invalid [ 388.305415][ T5870] [ 388.314728][ T5870] ERROR: (device loop1): remounting filesystem as read-only [ 388.322463][ T5870] ERROR: (device loop1): txCommit: [ 388.322463][ T5870] [pid 5870] +++ exited with 0 +++ [pid 5848] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5870, si_uid=0, si_status=0, si_utime=4 /* 0.04 s */, si_stime=15 /* 0.15 s */} --- [pid 5848] restart_syscall(<... resuming interrupted clone ...>) = 0 [pid 5848] umount2("./1", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5848] openat(AT_FDCWD, "./1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 5848] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5848] getdents64(3, 0x55557e7b36f0 /* 4 entries */, 32768) = 112 [pid 5848] umount2("./1/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5848] newfstatat(AT_FDCWD, "./1/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5848] unlink("./1/binderfs") = 0 [ 388.346190][ T5850] jfs_flush_journal: synclist not empty [ 388.351827][ T5850] metapage: ffff88804d423d90: 00001000 00000000 000036c8 00000000 [ 388.359861][ T5850] metapage: ffff88804d423da0: 7ca7d228 ffff8880 7ca7d228 ffff8880 [ 388.367754][ T5850] metapage: ffff88804d423db0: 00000004 00000000 00000000 00000000 [ 388.375562][ T5850] metapage: ffff88804d423dc0: 7b9f0000 ffff8880 0000001c 00000000 [ 388.383469][ T5850] metapage: ffff88804d423dd0: 00000000 dead4ead ffffffff 00000000 [ 388.391418][ T5850] metapage: ffff88804d423de0: ffffffff ffffffff 9a4c3520 ffffffff [ 388.399317][ T5850] metapage: ffff88804d423df0: 93c401f8 ffffffff 00000000 00000000 [ 388.407275][ T5850] metapage: ffff88804d423e00: 8c425fa0 ffffffff 00000300 00000000 [ 388.415097][ T5850] metapage: ffff88804d423e10: 4d423e10 ffff8880 4d423e10 ffff8880 [ 388.423036][ T5850] metapage: ffff88804d423e20: 01ee7c00 ffffea00 7bd0a000 ffff8880 [ 388.430896][ T5850] metapage: ffff88804d423e30: 00001000 00003794 00000001 00000000 [ 388.438769][ T5850] metapage: ffff88804d423e40: 7ca7d000 ffff8880 [ 388.445018][ T5850] page: ffffea0001ee7c00: 00fff0000000412c ffffea0000cc3608 [ 388.452413][ T5850] page: ffffea0001ee7c10: ffffea0001f5f348 ffff8880768d98c0 [ 388.459771][ T5850] page: ffffea0001ee7c20: 000000000000001c ffff88804d423d90 [ 388.467163][ T5850] page: ffffea0001ee7c30: 00000003ffffffff ffff88801beec000 [ 430.036354][ T30] INFO: task syz-executor294:5847 blocked for more than 143 seconds. [ 430.044538][ T30] Not tainted 6.13.0-rc5-syzkaller-00004-gccb98ccef0e5 #0 [ 430.052311][ T30] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 430.061127][ T30] task:syz-executor294 state:D stack:24248 pid:5847 tgid:5847 ppid:5846 flags:0x00004002 [ 430.071432][ T30] Call Trace: [ 430.074720][ T30] [ 430.077704][ T30] __schedule+0x17fb/0x4be0 [ 430.082247][ T30] ? __pfx___schedule+0x10/0x10 [ 430.087153][ T30] ? __pfx_lock_release+0x10/0x10 [ 430.092194][ T30] ? _raw_spin_unlock_irqrestore+0x8f/0x140 [ 430.098122][ T30] ? _raw_spin_unlock_irqrestore+0xdd/0x140 [ 430.104027][ T30] ? __pfx__raw_spin_unlock_irqrestore+0x10/0x10 [ 430.110411][ T30] ? schedule+0x90/0x320 [ 430.114669][ T30] schedule+0x14b/0x320 [ 430.118895][ T30] schedule_preempt_disabled+0x13/0x30 [ 430.124374][ T30] __mutex_lock+0x7e7/0xee0 [ 430.129068][ T30] ? __mutex_lock+0x5ef/0xee0 [ 430.133769][ T30] ? lmLogClose+0xb2/0x530 [ 430.138219][ T30] ? __pfx___mutex_lock+0x10/0x10 [ 430.143265][ T30] ? updateSuper+0x13d/0x760 [ 430.147921][ T30] lmLogClose+0xb2/0x530 [ 430.152176][ T30] jfs_umount+0x2ce/0x3a0 [ 430.156548][ T30] jfs_put_super+0x8a/0x190 [ 430.161061][ T30] ? __pfx_jfs_put_super+0x10/0x10 [ 430.166255][ T30] generic_shutdown_super+0x139/0x2d0 [ 430.171664][ T30] kill_block_super+0x44/0x90 [ 430.176450][ T30] deactivate_locked_super+0xc4/0x130 [ 430.181843][ T30] cleanup_mnt+0x41f/0x4b0 [ 430.186342][ T30] ? lockdep_hardirqs_on+0x99/0x150 [ 430.191557][ T30] task_work_run+0x24f/0x310 [ 430.196187][ T30] ? __pfx_task_work_run+0x10/0x10 [ 430.201310][ T30] ? path_umount+0x284/0xf70 [ 430.205892][ T30] ptrace_notify+0x2d2/0x380 [ 430.210567][ T30] ? __pfx_ptrace_notify+0x10/0x10 [ 430.215689][ T30] ? kmem_cache_free+0x195/0x410 [ 430.220695][ T30] ? __x64_sys_umount+0x123/0x170 [ 430.225733][ T30] syscall_exit_work+0xc7/0x1d0 [ 430.230646][ T30] syscall_exit_to_user_mode+0x24a/0x340 [ 430.236319][ T30] do_syscall_64+0x100/0x230 [ 430.240910][ T30] ? clear_bhb_loop+0x35/0x90 [ 430.245569][ T30] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 430.251528][ T30] RIP: 0033:0x7fe4dc94c4f7 [ 430.255959][ T30] RSP: 002b:00007ffe31051848 EFLAGS: 00000206 ORIG_RAX: 00000000000000a6 [ 430.264403][ T30] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 00007fe4dc94c4f7 [ 430.272420][ T30] RDX: 0000000000000000 RSI: 0000000000000009 RDI: 00007ffe31051900 [ 430.280506][ T30] RBP: 00007ffe31051900 R08: 0000000000000000 R09: 0000000000000000 [ 430.288543][ T30] R10: 00000000ffffffff R11: 0000000000000206 R12: 00007ffe31052960 [ 430.296581][ T30] R13: 000055557e7b36c0 R14: 0000000000000001 R15: 431bde82d7b634db [ 430.304592][ T30] [ 430.307683][ T30] INFO: task syz-executor294:5851 blocked for more than 143 seconds. [ 430.315758][ T30] Not tainted 6.13.0-rc5-syzkaller-00004-gccb98ccef0e5 #0 [ 430.323682][ T30] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 430.332422][ T30] task:syz-executor294 state:D stack:25208 pid:5851 tgid:5851 ppid:5846 flags:0x00004002 [ 430.342632][ T30] Call Trace: [ 430.345901][ T30] [ 430.348876][ T30] __schedule+0x17fb/0x4be0 [ 430.353405][ T30] ? __pfx___schedule+0x10/0x10 [ 430.358292][ T30] ? __pfx_lock_release+0x10/0x10 [ 430.363326][ T30] ? _raw_spin_unlock_irqrestore+0x8f/0x140 [ 430.369277][ T30] ? _raw_spin_unlock_irqrestore+0xdd/0x140 [ 430.375182][ T30] ? __pfx__raw_spin_unlock_irqrestore+0x10/0x10 [ 430.381549][ T30] ? schedule+0x90/0x320 [ 430.385807][ T30] schedule+0x14b/0x320 [ 430.390021][ T30] schedule_preempt_disabled+0x13/0x30 [ 430.395491][ T30] __mutex_lock+0x7e7/0xee0 [ 430.400072][ T30] ? __mutex_lock+0x5ef/0xee0 [ 430.404780][ T30] ? lmLogClose+0xb2/0x530 [ 430.409260][ T30] ? __pfx___mutex_lock+0x10/0x10 [ 430.414311][ T30] ? updateSuper+0x13d/0x760 [ 430.418975][ T30] lmLogClose+0xb2/0x530 [ 430.423245][ T30] jfs_umount+0x2ce/0x3a0 [ 430.427655][ T30] jfs_put_super+0x8a/0x190 [ 430.432184][ T30] ? __pfx_jfs_put_super+0x10/0x10 [ 430.437411][ T30] generic_shutdown_super+0x139/0x2d0 [ 430.442800][ T30] kill_block_super+0x44/0x90 [ 430.447529][ T30] deactivate_locked_super+0xc4/0x130 [ 430.452946][ T30] cleanup_mnt+0x41f/0x4b0 [ 430.457401][ T30] ? lockdep_hardirqs_on+0x99/0x150 [ 430.462615][ T30] task_work_run+0x24f/0x310 [ 430.467263][ T30] ? __pfx_task_work_run+0x10/0x10 [ 430.472387][ T30] ? path_umount+0x284/0xf70 [ 430.477017][ T30] ptrace_notify+0x2d2/0x380 [ 430.481640][ T30] ? __pfx_ptrace_notify+0x10/0x10 [ 430.486806][ T30] ? kmem_cache_free+0x195/0x410 [ 430.491758][ T30] ? __x64_sys_umount+0x123/0x170 [ 430.496825][ T30] syscall_exit_work+0xc7/0x1d0 [ 430.501686][ T30] syscall_exit_to_user_mode+0x24a/0x340 [ 430.507372][ T30] do_syscall_64+0x100/0x230 [ 430.511973][ T30] ? clear_bhb_loop+0x35/0x90 [ 430.516679][ T30] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 430.522583][ T30] RIP: 0033:0x7fe4dc94c4f7 [ 430.527044][ T30] RSP: 002b:00007ffe31051848 EFLAGS: 00000206 ORIG_RAX: 00000000000000a6 [ 430.535470][ T30] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 00007fe4dc94c4f7 [ 430.543503][ T30] RDX: 0000000000000000 RSI: 0000000000000009 RDI: 00007ffe31051900 [ 430.551542][ T30] RBP: 00007ffe31051900 R08: 0000000000000000 R09: 0000000000000000 [ 430.559552][ T30] R10: 00000000ffffffff R11: 0000000000000206 R12: 00007ffe31052960 [ 430.567580][ T30] R13: 000055557e7b36c0 R14: 0000000000000001 R15: 431bde82d7b634db [ 430.575567][ T30] [ 430.578637][ T30] [ 430.578637][ T30] Showing all locks held in the system: [ 430.586415][ T30] 1 lock held by khungtaskd/30: [ 430.591252][ T30] #0: ffffffff8e937ae0 (rcu_read_lock){....}-{1:3}, at: debug_show_all_locks+0x55/0x2a0 [ 430.601177][ T30] 2 locks held by getty/5582: [ 430.605859][ T30] #0: ffff888031c3f0a0 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x25/0x70 [ 430.615698][ T30] #1: ffffc90002fde2f0 (&ldata->atomic_read_lock){+.+.}-{4:4}, at: n_tty_read+0x6a6/0x1e00 [ 430.625870][ T30] 2 locks held by syz-executor294/5847: [ 430.631476][ T30] #0: ffff88807d30c0e0 (&type->s_umount_key#43){+.+.}-{4:4}, at: deactivate_super+0xb5/0xf0 [ 430.641725][ T30] #1: ffffffff8ed52f48 (jfs_log_mutex){+.+.}-{4:4}, at: lmLogClose+0xb2/0x530 [ 430.650737][ T30] 1 lock held by syz-executor294/5848: [ 430.656225][ T30] #0: ffff88807bf380e0 (&type->s_umount_key#43){+.+.}-{4:4}, at: deactivate_super+0xb5/0xf0 [ 430.666489][ T30] 2 locks held by syz-executor294/5849: [ 430.672034][ T30] #0: ffff88807d1760e0 (&type->s_umount_key#43){+.+.}-{4:4}, at: deactivate_super+0xb5/0xf0 [ 430.682276][ T30] #1: ffffffff8ed52f48 (jfs_log_mutex){+.+.}-{4:4}, at: lmLogClose+0xb2/0x530 [ 430.691343][ T30] 2 locks held by syz-executor294/5850: [ 430.696947][ T30] #0: ffff88807bd0a0e0 (&type->s_umount_key#43){+.+.}-{4:4}, at: deactivate_super+0xb5/0xf0 [ 430.707229][ T30] #1: ffffffff8ed52f48 (jfs_log_mutex){+.+.}-{4:4}, at: lmLogClose+0xb2/0x530 [ 430.716266][ T30] 2 locks held by syz-executor294/5851: [ 430.721806][ T30] #0: ffff8880127e40e0 (&type->s_umount_key#43){+.+.}-{4:4}, at: deactivate_super+0xb5/0xf0 [ 430.732068][ T30] #1: ffffffff8ed52f48 (jfs_log_mutex){+.+.}-{4:4}, at: lmLogClose+0xb2/0x530 [ 430.741106][ T30] [ 430.743424][ T30] ============================================= [ 430.743424][ T30] [ 430.751902][ T30] NMI backtrace for cpu 0 [ 430.756244][ T30] CPU: 0 UID: 0 PID: 30 Comm: khungtaskd Not tainted 6.13.0-rc5-syzkaller-00004-gccb98ccef0e5 #0 [ 430.766725][ T30] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/13/2024 [ 430.776761][ T30] Call Trace: [ 430.780028][ T30] [ 430.782945][ T30] dump_stack_lvl+0x241/0x360 [ 430.787615][ T30] ? __pfx_dump_stack_lvl+0x10/0x10 [ 430.792796][ T30] ? __pfx__printk+0x10/0x10 [ 430.797374][ T30] nmi_cpu_backtrace+0x49c/0x4d0 [ 430.802299][ T30] ? __pfx_nmi_cpu_backtrace+0x10/0x10 [ 430.807739][ T30] ? _printk+0xd5/0x120 [ 430.811881][ T30] ? __pfx__printk+0x10/0x10 [ 430.816453][ T30] ? __wake_up_klogd+0xcc/0x110 [ 430.821291][ T30] ? __pfx__printk+0x10/0x10 [ 430.825865][ T30] ? __pfx_nmi_raise_cpu_backtrace+0x10/0x10 [ 430.831834][ T30] nmi_trigger_cpumask_backtrace+0x198/0x320 [ 430.837802][ T30] watchdog+0xff6/0x1040 [ 430.842028][ T30] ? watchdog+0x1ea/0x1040 [ 430.846429][ T30] ? __pfx_watchdog+0x10/0x10 [ 430.851090][ T30] kthread+0x2f0/0x390 [ 430.855139][ T30] ? __pfx_watchdog+0x10/0x10 [ 430.859795][ T30] ? __pfx_kthread+0x10/0x10 [ 430.864366][ T30] ret_from_fork+0x4b/0x80 [ 430.868764][ T30] ? __pfx_kthread+0x10/0x10 [ 430.873360][ T30] ret_from_fork_asm+0x1a/0x30 [ 430.878115][ T30] [ 430.881304][ T30] Sending NMI from CPU 0 to CPUs 1: [ 430.886570][ C1] NMI backtrace for cpu 1 [ 430.886583][ C1] CPU: 1 UID: 0 PID: 5187 Comm: klogd Not tainted 6.13.0-rc5-syzkaller-00004-gccb98ccef0e5 #0 [ 430.886601][ C1] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/13/2024 [ 430.886610][ C1] RIP: 0010:lock_release+0x8c/0xa30 [ 430.886631][ C1] Code: 03 48 b8 f1 f1 f1 f1 04 f2 00 f2 4b 89 04 3c 48 b8 f2 f2 00 f3 f3 f3 f3 f3 4b 89 44 3c 08 0f 1f 44 00 00 65 8b 05 60 fe 88 7e <83> f8 08 0f 83 fe 05 00 00 89 c3 48 89 d8 48 c1 e8 06 48 8d 3c c5 [ 430.886644][ C1] RSP: 0018:ffffc90003167580 EFLAGS: 00000a02 [ 430.886658][ C1] RAX: 0000000000000001 RBX: 0000000000482cc0 RCX: ffff88807d0c64d8 [ 430.886669][ C1] RDX: dffffc0000000000 RSI: ffffffff81f521f3 RDI: ffffffff8ea47660 [ 430.886681][ C1] RBP: ffffc900031676b0 R08: ffffffff94271897 R09: 1ffffffff284e312 [ 430.886692][ C1] R10: dffffc0000000000 R11: fffffbfff284e313 R12: 1ffff9200062cebc [ 430.886704][ C1] R13: ffffffff81f521f3 R14: 00000000ffffffff R15: dffffc0000000000 [ 430.886715][ C1] FS: 00007f205bdf5380(0000) GS:ffff8880b8700000(0000) knlGS:0000000000000000 [ 430.886729][ C1] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 430.886740][ C1] CR2: 00005630f80b1d88 CR3: 000000003533c000 CR4: 00000000003526f0 [ 430.886753][ C1] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [ 430.886763][ C1] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [ 430.886773][ C1] Call Trace: [ 430.886778][ C1] [ 430.886785][ C1] ? nmi_cpu_backtrace+0x3c2/0x4d0 [ 430.886803][ C1] ? __pfx_lock_acquire+0x10/0x10 [ 430.886819][ C1] ? __pfx_nmi_cpu_backtrace+0x10/0x10 [ 430.886836][ C1] ? nmi_handle+0x2a/0x5a0 [ 430.886859][ C1] ? nmi_cpu_backtrace_handler+0xc/0x20 [ 430.886878][ C1] ? nmi_handle+0x14f/0x5a0 [ 430.886893][ C1] ? nmi_handle+0x2a/0x5a0 [ 430.886910][ C1] ? lock_release+0x8c/0xa30 [ 430.886924][ C1] ? default_do_nmi+0x63/0x160 [ 430.886941][ C1] ? exc_nmi+0x123/0x1f0 [ 430.886956][ C1] ? end_repeat_nmi+0xf/0x53 [ 430.886970][ C1] ? fs_reclaim_acquire+0x93/0x130 [ 430.886990][ C1] ? fs_reclaim_acquire+0x93/0x130 [ 430.887007][ C1] ? lock_release+0x8c/0xa30 [ 430.887022][ C1] ? lock_release+0x8c/0xa30 [ 430.887038][ C1] ? lock_release+0x8c/0xa30 [ 430.887052][ C1] [ 430.887057][ C1] [ 430.887063][ C1] ? __pfx_lock_acquire+0x10/0x10 [ 430.887081][ C1] ? __pfx_lock_release+0x10/0x10 [ 430.887100][ C1] ? fs_reclaim_acquire+0x93/0x130 [ 430.887118][ C1] __kmalloc_node_track_caller_noprof+0xad/0x4c0 [ 430.887140][ C1] ? __alloc_skb+0x1f3/0x440 [ 430.887155][ C1] ? rcu_is_watching+0x15/0xb0 [ 430.887173][ C1] ? __alloc_skb+0x1f3/0x440 [ 430.887187][ C1] kmalloc_reserve+0x111/0x2a0 [ 430.887204][ C1] __alloc_skb+0x1f3/0x440 [ 430.887218][ C1] ? _raw_spin_unlock_irqrestore+0xdd/0x140 [ 430.887237][ C1] ? __pfx___alloc_skb+0x10/0x10 [ 430.887256][ C1] alloc_skb_with_frags+0xc3/0x820 [ 430.887278][ C1] sock_alloc_send_pskb+0x91a/0xa60 [ 430.887304][ C1] ? __pfx_sock_alloc_send_pskb+0x10/0x10 [ 430.887323][ C1] ? do_raw_spin_unlock+0x13c/0x8b0 [ 430.887346][ C1] unix_dgram_sendmsg+0x6d3/0x1f80 [ 430.887368][ C1] ? __pfx_smack_socket_sendmsg+0x10/0x10 [ 430.887386][ C1] ? tomoyo_socket_sendmsg_permission+0x288/0x420 [ 430.887407][ C1] ? __pfx_unix_dgram_sendmsg+0x10/0x10 [ 430.887430][ C1] ? __pfx_unix_dgram_sendmsg+0x10/0x10 [ 430.887446][ C1] __sock_sendmsg+0x221/0x270 [ 430.887466][ C1] __sys_sendto+0x363/0x4c0 [ 430.887483][ C1] ? __pfx___sys_sendto+0x10/0x10 [ 430.887509][ C1] ? lockdep_hardirqs_on_prepare+0x43d/0x780 [ 430.887525][ C1] ? __pfx_lockdep_hardirqs_on_prepare+0x10/0x10 [ 430.887543][ C1] __x64_sys_sendto+0xde/0x100 [ 430.887560][ C1] do_syscall_64+0xf3/0x230 [ 430.887578][ C1] ? clear_bhb_loop+0x35/0x90 [ 430.887593][ C1] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 430.887612][ C1] RIP: 0033:0x7f205bf579b5 [ 430.887625][ C1] Code: 8b 44 24 08 48 83 c4 28 48 98 c3 48 98 c3 41 89 ca 64 8b 04 25 18 00 00 00 85 c0 75 26 45 31 c9 45 31 c0 b8 2c 00 00 00 0f 05 <48> 3d 00 f0 ff ff 76 7a 48 8b 15 44 c4 0c 00 f7 d8 64 89 02 48 83 [ 430.887636][ C1] RSP: 002b:00007ffdd82c41f8 EFLAGS: 00000246 ORIG_RAX: 000000000000002c [ 430.887651][ C1] RAX: ffffffffffffffda RBX: 0000000000000002 RCX: 00007f205bf579b5 [ 430.887662][ C1] RDX: 000000000000008b RSI: 000055b34da04a90 RDI: 0000000000000003 [ 430.887672][ C1] RBP: 000055b34da00910 R08: 0000000000000000 R09: 0000000000000000 [ 430.887682][ C1] R10: 0000000000004000 R11: 0000000000000246 R12: 0000000000000013 [ 430.887691][ C1] R13: 00007f205c0e5212 R14: 00007ffdd82c42f8 R15: 0000000000000000 [ 430.887709][ C1] [ 430.887715][ C1] INFO: NMI handler (nmi_cpu_backtrace_handler) took too long to run: 1.145 msecs [ 430.888575][ T30] Kernel panic - not syncing: hung_task: blocked tasks [ 431.352790][ T30] CPU: 0 UID: 0 PID: 30 Comm: khungtaskd Not tainted 6.13.0-rc5-syzkaller-00004-gccb98ccef0e5 #0 [ 431.363284][ T30] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/13/2024 [ 431.373328][ T30] Call Trace: [ 431.376601][ T30] [ 431.379524][ T30] dump_stack_lvl+0x241/0x360 [ 431.384204][ T30] ? __pfx_dump_stack_lvl+0x10/0x10 [ 431.389395][ T30] ? __pfx__printk+0x10/0x10 [ 431.393974][ T30] ? lockdep_hardirqs_on_prepare+0x43d/0x780 [ 431.399953][ T30] ? vscnprintf+0x5d/0x90 [ 431.404279][ T30] panic+0x349/0x880 [ 431.408168][ T30] ? nmi_trigger_cpumask_backtrace+0x244/0x320 [ 431.414314][ T30] ? __pfx_panic+0x10/0x10 [ 431.418721][ T30] ? tick_nohz_tick_stopped+0x82/0xb0 [ 431.424111][ T30] ? __irq_work_queue_local+0x137/0x410 [ 431.429675][ T30] ? irq_work_queue+0xca/0x150 [ 431.434443][ T30] ? __pfx_nmi_raise_cpu_backtrace+0x10/0x10 [ 431.440426][ T30] ? __pfx_nmi_raise_cpu_backtrace+0x10/0x10 [ 431.446405][ T30] ? __pfx_nmi_raise_cpu_backtrace+0x10/0x10 [ 431.452382][ T30] ? nmi_trigger_cpumask_backtrace+0x251/0x320 [ 431.458529][ T30] watchdog+0x1035/0x1040 [ 431.462857][ T30] ? watchdog+0x1ea/0x1040 [ 431.467267][ T30] ? __pfx_watchdog+0x10/0x10 [ 431.471935][ T30] kthread+0x2f0/0x390 [ 431.475997][ T30] ? __pfx_watchdog+0x10/0x10 [ 431.480682][ T30] ? __pfx_kthread+0x10/0x10 [ 431.485289][ T30] ret_from_fork+0x4b/0x80 [ 431.489715][ T30] ? __pfx_kthread+0x10/0x10 [ 431.494306][ T30] ret_from_fork_asm+0x1a/0x30 [ 431.499095][ T30] [ 431.502387][ T30] Kernel Offset: disabled [ 431.506712][ T30] Rebooting in 86400 seconds..