./strace-static-x86_64 -e \!wait4,clock_nanosleep,nanosleep -s 100 -x -f ./syz-executor1386857010

<...>
Warning: Permanently added '10.128.1.108' (ED25519) to the list of known hosts.
execve("./syz-executor1386857010", ["./syz-executor1386857010"], 0x7ffe7fd6f540 /* 10 vars */) = 0
brk(NULL)                               = 0x55558d737000
brk(0x55558d737d00)                     = 0x55558d737d00
arch_prctl(ARCH_SET_FS, 0x55558d737380) = 0
set_tid_address(0x55558d737650)         = 5845
set_robust_list(0x55558d737660, 24)     = 0
rseq(0x55558d737ca0, 0x20, 0, 0x53053053) = 0
prlimit64(0, RLIMIT_STACK, NULL, {rlim_cur=8192*1024, rlim_max=RLIM64_INFINITY}) = 0
readlink("/proc/self/exe", "/root/syz-executor1386857010", 4096) = 28
getrandom("\x5c\x8a\xff\x6d\xec\xa4\xa5\x57", 8, GRND_NONBLOCK) = 8
brk(NULL)                               = 0x55558d737d00
brk(0x55558d758d00)                     = 0x55558d758d00
brk(0x55558d759000)                     = 0x55558d759000
mprotect(0x7f721dfae000, 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 5846 attached
, child_tidptr=0x55558d737650) = 5846
[pid  5846] set_robust_list(0x55558d737660, 24 <unfinished ...>
[pid  5845] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD <unfinished ...>
[pid  5846] <... set_robust_list resumed>) = 0
[pid  5846] getrandom(./strace-static-x86_64: Process 5847 attached
"\xda\x1a\x1e\x9a\xc5\xa4\xa0\xad", 8, GRND_NONBLOCK) = 8
[pid  5847] set_robust_list(0x55558d737660, 24 <unfinished ...>
[pid  5845] <... clone resumed>, child_tidptr=0x55558d737650) = 5847
[pid  5847] <... set_robust_list resumed>) = 0
[pid  5846] mkdir("./syzkaller.kwBUwx", 0700 <unfinished ...>
[pid  5845] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD <unfinished ...>
[pid  5847] mkdir("./syzkaller.j5cpIT", 0700) = 0
[pid  5846] <... mkdir resumed>)        = 0
[pid  5845] <... clone resumed>, child_tidptr=0x55558d737650) = 5848
[pid  5847] chmod("./syzkaller.j5cpIT", 0777./strace-static-x86_64: Process 5848 attached
 <unfinished ...>
[pid  5845] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD <unfinished ...>
[pid  5846] chmod("./syzkaller.kwBUwx", 0777 <unfinished ...>
[pid  5847] <... chmod resumed>)        = 0
./strace-static-x86_64: Process 5849 attached
[pid  5847] chdir("./syzkaller.j5cpIT" <unfinished ...>
[pid  5848] set_robust_list(0x55558d737660, 24 <unfinished ...>
[pid  5845] <... clone resumed>, child_tidptr=0x55558d737650) = 5849
[pid  5849] set_robust_list(0x55558d737660, 24 <unfinished ...>
[pid  5848] <... set_robust_list resumed>) = 0
[pid  5847] <... chdir resumed>)        = 0
[pid  5846] <... chmod resumed>)        = 0
[pid  5845] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD <unfinished ...>
[pid  5849] <... set_robust_list resumed>) = 0
[pid  5848] mkdir("./syzkaller.tQryFr", 0700 <unfinished ...>
[pid  5847] mkdir("./0", 0777 <unfinished ...>
[pid  5849] mkdir("./syzkaller.2pucky", 0700 <unfinished ...>
[pid  5846] chdir("./syzkaller.kwBUwx" <unfinished ...>
[pid  5848] <... mkdir resumed>)        = 0
[pid  5847] <... mkdir resumed>)        = 0
[pid  5845] <... clone resumed>, child_tidptr=0x55558d737650) = 5850
[pid  5846] <... chdir resumed>)        = 0
./strace-static-x86_64: Process 5850 attached
[pid  5850] set_robust_list(0x55558d737660, 24 <unfinished ...>
[pid  5848] chmod("./syzkaller.tQryFr", 0777 <unfinished ...>
[pid  5847] openat(AT_FDCWD, "/dev/loop1", O_RDWR <unfinished ...>
[pid  5846] mkdir("./0", 0777 <unfinished ...>
[pid  5850] <... set_robust_list resumed>) = 0
[pid  5849] <... mkdir resumed>)        = 0
[pid  5848] <... chmod resumed>)        = 0
[pid  5846] <... mkdir resumed>)        = 0
[pid  5847] <... openat resumed>)       = 3
[pid  5846] openat(AT_FDCWD, "/dev/loop0", O_RDWR <unfinished ...>
[pid  5850] mkdir("./syzkaller.c8Z4f3", 0700 <unfinished ...>
[pid  5849] chmod("./syzkaller.2pucky", 0777 <unfinished ...>
[pid  5848] chdir("./syzkaller.tQryFr" <unfinished ...>
[pid  5847] ioctl(3, LOOP_CLR_FD <unfinished ...>
[pid  5846] <... openat resumed>)       = 3
[pid  5850] <... mkdir resumed>)        = 0
[pid  5849] <... chmod resumed>)        = 0
[pid  5848] <... chdir resumed>)        = 0
[pid  5847] <... ioctl resumed>)        = -1 ENXIO (No such device or address)
[pid  5846] ioctl(3, LOOP_CLR_FD <unfinished ...>
[pid  5847] close(3 <unfinished ...>
[pid  5850] chmod("./syzkaller.c8Z4f3", 0777 <unfinished ...>
[pid  5849] chdir("./syzkaller.2pucky" <unfinished ...>
[pid  5848] mkdir("./0", 0777 <unfinished ...>
[pid  5846] <... ioctl resumed>)        = -1 ENXIO (No such device or address)
[pid  5847] <... close resumed>)        = 0
[pid  5850] <... chmod resumed>)        = 0
[pid  5850] chdir("./syzkaller.c8Z4f3") = 0
[pid  5849] <... chdir resumed>)        = 0
[pid  5850] mkdir("./0", 0777)          = 0
[pid  5849] mkdir("./0", 0777 <unfinished ...>
[pid  5848] <... mkdir resumed>)        = 0
[pid  5847] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD <unfinished ...>
[pid  5846] close(3 <unfinished ...>
[pid  5850] openat(AT_FDCWD, "/dev/loop4", O_RDWR./strace-static-x86_64: Process 5851 attached
 <unfinished ...>
[pid  5849] <... mkdir resumed>)        = 0
[pid  5848] openat(AT_FDCWD, "/dev/loop2", O_RDWR <unfinished ...>
[pid  5846] <... close resumed>)        = 0
[pid  5850] <... openat resumed>)       = 3
[pid  5846] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD <unfinished ...>
[pid  5851] set_robust_list(0x55558d737660, 24 <unfinished ...>
[pid  5849] openat(AT_FDCWD, "/dev/loop3", O_RDWR <unfinished ...>
[pid  5848] <... openat resumed>)       = 3
[pid  5847] <... clone resumed>, child_tidptr=0x55558d737650) = 5851
[pid  5851] <... set_robust_list resumed>) = 0
./strace-static-x86_64: Process 5853 attached
[pid  5849] <... openat resumed>)       = 3
[pid  5851] chdir("./0" <unfinished ...>
[pid  5849] ioctl(3, LOOP_CLR_FD <unfinished ...>
[pid  5848] ioctl(3, LOOP_CLR_FD <unfinished ...>
[pid  5846] <... clone resumed>, child_tidptr=0x55558d737650) = 5853
[pid  5851] <... chdir resumed>)        = 0
[pid  5851] prctl(PR_SET_PDEATHSIG, SIGKILL <unfinished ...>
[pid  5848] <... ioctl resumed>)        = -1 ENXIO (No such device or address)
[pid  5851] <... prctl resumed>)        = 0
[pid  5849] <... ioctl resumed>)        = -1 ENXIO (No such device or address)
[pid  5848] close(3 <unfinished ...>
[pid  5853] set_robust_list(0x55558d737660, 24 <unfinished ...>
[pid  5851] setpgid(0, 0 <unfinished ...>
[pid  5850] ioctl(3, LOOP_CLR_FD <unfinished ...>
[pid  5849] close(3 <unfinished ...>
[pid  5848] <... close resumed>)        = 0
[pid  5851] <... setpgid resumed>)      = 0
[pid  5849] <... close resumed>)        = 0
[pid  5848] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5854 attached
 <unfinished ...>
[pid  5853] <... set_robust_list resumed>) = 0
[pid  5851] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC <unfinished ...>
[pid  5850] <... ioctl resumed>)        = -1 ENXIO (No such device or address)
[pid  5849] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5855 attached
 <unfinished ...>
[pid  5854] set_robust_list(0x55558d737660, 24 <unfinished ...>
[pid  5853] chdir("./0" <unfinished ...>
[pid  5851] <... openat resumed>)       = 3
[pid  5850] close(3 <unfinished ...>
[pid  5854] <... set_robust_list resumed>) = 0
[pid  5853] <... chdir resumed>)        = 0
[pid  5850] <... close resumed>)        = 0
[pid  5855] set_robust_list(0x55558d737660, 24 <unfinished ...>
[pid  5854] chdir("./0" <unfinished ...>
[pid  5853] prctl(PR_SET_PDEATHSIG, SIGKILL <unfinished ...>
[pid  5851] write(3, "1000", 4 <unfinished ...>
[pid  5850] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD <unfinished ...>
[pid  5849] <... clone resumed>, child_tidptr=0x55558d737650) = 5855
[pid  5848] <... clone resumed>, child_tidptr=0x55558d737650) = 5854
[pid  5855] <... set_robust_list resumed>) = 0
[pid  5854] <... chdir resumed>)        = 0
[pid  5853] <... prctl resumed>)        = 0
[pid  5851] <... write resumed>)        = 4
[pid  5855] chdir("./0" <unfinished ...>
[pid  5854] prctl(PR_SET_PDEATHSIG, SIGKILL <unfinished ...>
[pid  5853] setpgid(0, 0 <unfinished ...>
[pid  5851] close(3 <unfinished ...>
[pid  5854] <... prctl resumed>)        = 0
[pid  5853] <... setpgid resumed>)      = 0
[pid  5855] <... chdir resumed>)        = 0
[pid  5851] <... close resumed>)        = 0
[pid  5855] prctl(PR_SET_PDEATHSIG, SIGKILL <unfinished ...>
[pid  5851] symlink("/dev/binderfs", "./binderfs"./strace-static-x86_64: Process 5856 attached
executing program
 <unfinished ...>
[pid  5855] <... prctl resumed>)        = 0
[pid  5854] setpgid(0, 0 <unfinished ...>
[pid  5853] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC <unfinished ...>
[pid  5851] <... symlink resumed>)      = 0
[pid  5854] <... setpgid resumed>)      = 0
[pid  5855] setpgid(0, 0)               = 0
[pid  5853] <... openat resumed>)       = 3
[pid  5855] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC <unfinished ...>
[pid  5854] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC <unfinished ...>
[pid  5853] write(3, "1000", 4 <unfinished ...>
[pid  5850] <... clone resumed>, child_tidptr=0x55558d737650) = 5856
[pid  5855] <... openat resumed>)       = 3
[pid  5851] write(1, "executing program\n", 18) = 18
[pid  5854] <... openat resumed>)       = 3
[pid  5856] set_robust_list(0x55558d737660, 24 <unfinished ...>
[pid  5853] <... write resumed>)        = 4
[pid  5851] memfd_create("syzkaller", 0 <unfinished ...>
[pid  5856] <... set_robust_list resumed>) = 0
[pid  5853] close(3 <unfinished ...>
[pid  5855] write(3, "1000", 4)         = 4
[pid  5856] chdir("./0" <unfinished ...>
[pid  5855] close(3 <unfinished ...>
[pid  5853] <... close resumed>)        = 0
[pid  5855] <... close resumed>)        = 0
[pid  5851] <... memfd_create resumed>) = 3
[pid  5855] symlink("/dev/binderfs", "./binderfs" <unfinished ...>
[pid  5853] symlink("/dev/binderfs", "./binderfs" <unfinished ...>
[pid  5855] <... symlink resumed>)      = 0
[pid  5851] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f7215a00000
[pid  5856] <... chdir resumed>)        = 0
[pid  5854] write(3, "1000", 4 <unfinished ...>
[pid  5853] <... symlink resumed>)      = 0
[pid  5856] prctl(PR_SET_PDEATHSIG, SIGKILL <unfinished ...>
[pid  5855] write(1, "executing program\n", 18 <unfinished ...>
[pid  5854] <... write resumed>)        = 4
executing program
[pid  5855] <... write resumed>)        = 18
[pid  5856] <... prctl resumed>)        = 0
[pid  5855] memfd_create("syzkaller", 0 <unfinished ...>
[pid  5854] close(3 <unfinished ...>
[pid  5856] setpgid(0, 0 <unfinished ...>
[pid  5854] <... close resumed>)        = 0
[pid  5853] write(1, "executing program\n", 18 <unfinished ...>
[pid  5854] symlink("/dev/binderfs", "./binderfs" <unfinished ...>
[pid  5856] <... setpgid resumed>)      = 0
executing program
[pid  5856] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC <unfinished ...>
[pid  5854] <... symlink resumed>)      = 0
[pid  5853] <... write resumed>)        = 18
[pid  5856] <... openat resumed>)       = 3
[pid  5855] <... memfd_create resumed>) = 3
executing program
[pid  5855] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
[pid  5854] write(1, "executing program\n", 18 <unfinished ...>
[pid  5853] memfd_create("syzkaller", 0 <unfinished ...>
[pid  5856] write(3, "1000", 4 <unfinished ...>
[pid  5854] <... write resumed>)        = 18
[pid  5855] <... mmap resumed>)         = 0x7f7215a00000
[pid  5853] <... memfd_create resumed>) = 3
[pid  5856] <... write resumed>)        = 4
[pid  5854] memfd_create("syzkaller", 0 <unfinished ...>
[pid  5853] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
[pid  5856] close(3 <unfinished ...>
[pid  5853] <... mmap resumed>)         = 0x7f7215a00000
[pid  5856] <... close resumed>)        = 0
[pid  5854] <... memfd_create resumed>) = 3
[pid  5856] symlink("/dev/binderfs", "./binderfs") = 0
[pid  5854] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0executing program
) = 0x7f7215a00000
[pid  5856] write(1, "executing program\n", 18) = 18
[pid  5856] memfd_create("syzkaller", 0) = 3
[pid  5856] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f7215a00000
[pid  5851] 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 <unfinished ...>
[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 <unfinished ...>
[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 <unfinished ...>
[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 <unfinished ...>
[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 <unfinished ...>
[pid  5855] <... write resumed>)        = 16777216
[pid  5851] <... write resumed>)        = 16777216
[pid  5855] munmap(0x7f7215a00000, 138412032 <unfinished ...>
[pid  5851] munmap(0x7f7215a00000, 138412032 <unfinished ...>
[pid  5855] <... munmap resumed>)       = 0
[pid  5855] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = 4
[pid  5855] ioctl(4, LOOP_SET_FD, 3 <unfinished ...>
[pid  5854] <... write resumed>)        = 16777216
[pid  5854] munmap(0x7f7215a00000, 138412032 <unfinished ...>
[pid  5851] <... munmap resumed>)       = 0
[pid  5855] <... ioctl resumed>)        = 0
[pid  5853] <... write resumed>)        = 16777216
[pid  5851] openat(AT_FDCWD, "/dev/loop1", O_RDWR <unfinished ...>
[pid  5855] close(3)                    = 0
[pid  5853] munmap(0x7f7215a00000, 138412032 <unfinished ...>
[pid  5851] <... openat resumed>)       = 4
[pid  5855] close(4)                    = 0
[pid  5851] ioctl(4, LOOP_SET_FD, 3 <unfinished ...>
[pid  5855] mkdir("./file0", 0777 <unfinished ...>
[pid  5854] <... munmap resumed>)       = 0
[pid  5855] <... mkdir resumed>)        = 0
[pid  5853] <... munmap resumed>)       = 0
[pid  5855] mount("/dev/loop3", "./file0", "jfs", MS_I_VERSION, "" <unfinished ...>
[pid  5854] openat(AT_FDCWD, "/dev/loop2", O_RDWR <unfinished ...>
[pid  5853] openat(AT_FDCWD, "/dev/loop0", O_RDWR <unfinished ...>
[pid  5854] <... openat resumed>)       = 4
[pid  5853] <... openat resumed>)       = 4
[  222.390145][ T5855] loop3: detected capacity change from 0 to 32768
[  222.423989][ T5851] loop1: detected capacity change from 0 to 32768
[pid  5854] ioctl(4, LOOP_SET_FD, 3 <unfinished ...>
[pid  5853] ioctl(4, LOOP_SET_FD, 3 <unfinished ...>
[pid  5851] <... ioctl resumed>)        = 0
[pid  5851] close(3)                    = 0
[pid  5851] close(4)                    = 0
[pid  5851] mkdir("./file0", 0777 <unfinished ...>
[pid  5856] <... write resumed>)        = 16777216
[pid  5855] <... mount resumed>)        = 0
[pid  5854] <... ioctl resumed>)        = 0
[pid  5853] <... ioctl resumed>)        = 0
[pid  5851] <... mkdir resumed>)        = 0
[pid  5855] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY) = 3
[pid  5854] close(3 <unfinished ...>
[pid  5853] close(3 <unfinished ...>
[pid  5856] munmap(0x7f7215a00000, 138412032 <unfinished ...>
[pid  5854] <... close resumed>)        = 0
[pid  5853] <... close resumed>)        = 0
[pid  5854] close(4 <unfinished ...>
[pid  5853] close(4 <unfinished ...>
[pid  5855] chdir("./file0")            = 0
[pid  5855] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = -1 EBUSY (Device or resource busy)
[pid  5854] <... close resumed>)        = 0
[pid  5853] <... close resumed>)        = 0
[pid  5851] mount("/dev/loop1", "./file0", "jfs", MS_I_VERSION, "" <unfinished ...>
[pid  5855] openat(AT_FDCWD, "./file1", O_RDWR|O_CREAT|O_SYNC|O_NOATIME|FASYNC, 0424 <unfinished ...>
[pid  5854] mkdir("./file0", 0777 <unfinished ...>
[pid  5853] mkdir("./file0", 0777 <unfinished ...>
[pid  5854] <... mkdir resumed>)        = 0
[pid  5853] <... mkdir resumed>)        = 0
[  222.439300][ T5854] loop2: detected capacity change from 0 to 32768
[  222.453745][ T5853] loop0: detected capacity change from 0 to 32768
[pid  5853] mount("/dev/loop0", "./file0", "jfs", MS_I_VERSION, "" <unfinished ...>
[pid  5854] mount("/dev/loop2", "./file0", "jfs", MS_I_VERSION, "" <unfinished ...>
[pid  5855] <... openat resumed>)       = 4
[pid  5855] openat(AT_FDCWD, "./bus", O_RDWR|O_CREAT|O_SYNC|O_DIRECT, 0737 <unfinished ...>
[pid  5856] <... munmap resumed>)       = 0
[pid  5856] openat(AT_FDCWD, "/dev/loop4", O_RDWR) = 4
[pid  5856] ioctl(4, LOOP_SET_FD, 3 <unfinished ...>
[pid  5851] <... mount resumed>)        = 0
[pid  5851] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY) = 3
[pid  5851] chdir("./file0")            = 0
[pid  5851] openat(AT_FDCWD, "/dev/loop1", O_RDWR) = -1 EBUSY (Device or resource busy)
[pid  5851] openat(AT_FDCWD, "./file1", O_RDWR|O_CREAT|O_SYNC|O_NOATIME|FASYNC, 0424 <unfinished ...>
[pid  5856] <... ioctl resumed>)        = 0
[pid  5851] <... openat resumed>)       = 4
[  222.514578][ T5855] ERROR: (device loop3): diWrite: ixpxd invalid
[  222.514578][ T5855] 
[  222.538461][ T5856] loop4: detected capacity change from 0 to 32768
[  222.539137][ T5855] ERROR: (device loop3): remounting filesystem as read-only
[pid  5851] openat(AT_FDCWD, "./bus", O_RDWR|O_CREAT|O_SYNC|O_DIRECT, 0737 <unfinished ...>
[pid  5856] close(3)                    = 0
[pid  5856] close(4 <unfinished ...>
[pid  5853] <... mount resumed>)        = 0
[pid  5856] <... close resumed>)        = 0
[pid  5854] <... mount resumed>)        = 0
[pid  5853] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY <unfinished ...>
[pid  5854] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY) = 3
[pid  5853] <... openat resumed>)       = 3
[pid  5853] chdir("./file0")            = 0
[pid  5856] mkdir("./file0", 0777 <unfinished ...>
[pid  5854] chdir("./file0")            = 0
[pid  5854] openat(AT_FDCWD, "/dev/loop2", O_RDWR) = -1 EBUSY (Device or resource busy)
[pid  5854] openat(AT_FDCWD, "./file1", O_RDWR|O_CREAT|O_SYNC|O_NOATIME|FASYNC, 0424 <unfinished ...>
[pid  5856] <... mkdir resumed>)        = 0
[pid  5854] <... openat resumed>)       = 4
[pid  5853] openat(AT_FDCWD, "/dev/loop0", O_RDWR <unfinished ...>
[pid  5854] openat(AT_FDCWD, "./bus", O_RDWR|O_CREAT|O_SYNC|O_DIRECT, 0737 <unfinished ...>
[pid  5856] mount("/dev/loop4", "./file0", "jfs", MS_I_VERSION, "" <unfinished ...>
[pid  5853] <... openat resumed>)       = -1 EBUSY (Device or resource busy)
[  222.562620][ T5851] ERROR: (device loop1): diWrite: ixpxd invalid
[  222.562620][ T5851] 
[  222.594079][ T5854] ERROR: (device loop2): diWrite: ixpxd invalid
[  222.594079][ T5854] 
[  222.597344][ T5855] ERROR: (device loop3): txCommit: 
[  222.597344][ T5855] 
[pid  5853] openat(AT_FDCWD, "./file1", O_RDWR|O_CREAT|O_SYNC|O_NOATIME|FASYNC, 0424) = 4
[pid  5853] openat(AT_FDCWD, "./bus", O_RDWR|O_CREAT|O_SYNC|O_DIRECT, 0737 <unfinished ...>
[pid  5856] <... mount resumed>)        = 0
[pid  5855] <... openat resumed>)       = -1 EIO (Input/output error)
[pid  5856] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY <unfinished ...>
[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 <unfinished ...>
[pid  5856] <... openat resumed>)       = 3
[pid  5856] chdir("./file0")            = 0
[  222.610506][ T5851] ERROR: (device loop1): remounting filesystem as read-only
[  222.620360][ T5854] ERROR: (device loop2): remounting filesystem as read-only
[  222.620359][ T5853] ERROR: (device loop0): diWrite: ixpxd invalid
[  222.620359][ T5853] 
[  222.620685][ T5853] ERROR: (device loop0): remounting filesystem as read-only
[  222.629150][ T5851] ERROR: (device loop1): txCommit: 
[  222.629150][ T5851] 
[  222.655438][ T5854] ERROR: (device loop2): txCommit: 
[  222.655438][ T5854] 
[pid  5856] openat(AT_FDCWD, "/dev/loop4", O_RDWR <unfinished ...>
[pid  5855] <... write resumed>)        = 24
[pid  5856] <... openat resumed>)       = -1 EBUSY (Device or resource busy)
[pid  5855] exit_group(0 <unfinished ...>
[pid  5854] <... openat resumed>)       = -1 EIO (Input/output error)
[pid  5853] <... openat resumed>)       = -1 EIO (Input/output error)
[pid  5851] <... openat resumed>)       = -1 EIO (Input/output error)
[pid  5856] openat(AT_FDCWD, "./file1", O_RDWR|O_CREAT|O_SYNC|O_NOATIME|FASYNC, 0424 <unfinished ...>
[pid  5855] <... exit_group resumed>)   = ?
[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 <unfinished ...>
[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 <unfinished ...>
[pid  5851] 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 <unfinished ...>
[pid  5856] <... openat resumed>)       = 4
[pid  5855] +++ exited with 0 +++
[  222.659237][ T5853] ERROR: (device loop0): txCommit: 
[  222.659237][ T5853] 
[pid  5856] openat(AT_FDCWD, "./bus", O_RDWR|O_CREAT|O_SYNC|O_DIRECT, 0737 <unfinished ...>
[pid  5849] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5855, si_uid=0, si_status=0, si_utime=9 /* 0.09 s */, si_stime=24 /* 0.24 s */} ---
[pid  5854] <... write resumed>)        = 24
[pid  5854] exit_group(0 <unfinished ...>
[pid  5853] <... write resumed>)        = 24
[pid  5851] <... write resumed>)        = 24
[pid  5854] <... exit_group resumed>)   = ?
[pid  5853] exit_group(0 <unfinished ...>
[pid  5851] exit_group(0)               = ?
[pid  5851] +++ exited with 0 +++
[pid  5853] <... exit_group resumed>)   = ?
[pid  5853] +++ exited with 0 +++
[pid  5849] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW <unfinished ...>
[pid  5854] +++ exited with 0 +++
[pid  5849] <... umount2 resumed>)      = -1 EINVAL (Invalid argument)
[pid  5849] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY <unfinished ...>
[pid  5848] --- 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=30 /* 0.30 s */} ---
[pid  5849] <... openat resumed>)       = 3
[pid  5848] restart_syscall(<... resuming interrupted clone ...> <unfinished ...>
[pid  5849] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0
[pid  5849] getdents64(3, 0x55558d7386f0 /* 4 entries */, 32768) = 112
[pid  5849] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument)
[pid  5849] newfstatat(AT_FDCWD, "./0/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0
[pid  5849] unlink("./0/binderfs")      = 0
[pid  5847] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5851, si_uid=0, si_status=0, si_utime=10 /* 0.10 s */, si_stime=20 /* 0.20 s */} ---
[pid  5849] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW <unfinished ...>
[pid  5847] restart_syscall(<... resuming interrupted clone ...> <unfinished ...>
[pid  5846] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5853, si_uid=0, si_status=0, si_utime=12 /* 0.12 s */, si_stime=23 /* 0.23 s */} ---
[pid  5847] <... restart_syscall resumed>) = 0
[pid  5846] restart_syscall(<... resuming interrupted clone ...> <unfinished ...>
[pid  5856] <... openat resumed>)       = -1 EIO (Input/output error)
[pid  5848] <... restart_syscall resumed>) = 0
[pid  5846] <... restart_syscall resumed>) = 0
[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 <unfinished ...>
[pid  5847] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW <unfinished ...>
[pid  5848] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW <unfinished ...>
[pid  5847] <... umount2 resumed>)      = -1 EINVAL (Invalid argument)
[pid  5846] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW <unfinished ...>
[pid  5848] <... umount2 resumed>)      = -1 EINVAL (Invalid argument)
[pid  5847] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY <unfinished ...>
[pid  5848] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY <unfinished ...>
[pid  5847] <... openat resumed>)       = 3
[pid  5846] <... umount2 resumed>)      = -1 EINVAL (Invalid argument)
[pid  5856] <... write resumed>)        = 24
[pid  5848] <... openat resumed>)       = 3
[pid  5846] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY <unfinished ...>
[pid  5847] newfstatat(3, "",  <unfinished ...>
[pid  5848] newfstatat(3, "",  <unfinished ...>
[pid  5847] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0
[pid  5856] exit_group(0 <unfinished ...>
[pid  5846] <... openat resumed>)       = 3
[pid  5848] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0
[pid  5856] <... exit_group resumed>)   = ?
[pid  5848] getdents64(3,  <unfinished ...>
[pid  5847] getdents64(3,  <unfinished ...>
[pid  5846] newfstatat(3, "",  <unfinished ...>
[pid  5848] <... getdents64 resumed>0x55558d7386f0 /* 4 entries */, 32768) = 112
[pid  5847] <... getdents64 resumed>0x55558d7386f0 /* 4 entries */, 32768) = 112
[pid  5848] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW <unfinished ...>
[pid  5847] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW <unfinished ...>
[pid  5846] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0
[pid  5848] <... umount2 resumed>)      = -1 EINVAL (Invalid argument)
[pid  5847] <... umount2 resumed>)      = -1 EINVAL (Invalid argument)
[pid  5848] newfstatat(AT_FDCWD, "./0/binderfs",  <unfinished ...>
[pid  5847] newfstatat(AT_FDCWD, "./0/binderfs",  <unfinished ...>
[pid  5846] getdents64(3,  <unfinished ...>
[pid  5856] +++ exited with 0 +++
[pid  5848] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0
[pid  5847] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0
[pid  5850] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5856, si_uid=0, si_status=0, si_utime=5 /* 0.05 s */, si_stime=28 /* 0.28 s */} ---
[pid  5848] unlink("./0/binderfs" <unfinished ...>
[pid  5847] unlink("./0/binderfs" <unfinished ...>
[pid  5846] <... getdents64 resumed>0x55558d7386f0 /* 4 entries */, 32768) = 112
[pid  5850] restart_syscall(<... resuming interrupted clone ...> <unfinished ...>
[pid  5848] <... unlink resumed>)       = 0
[pid  5847] <... unlink resumed>)       = 0
[pid  5846] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument)
[pid  5846] newfstatat(AT_FDCWD, "./0/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0
[pid  5848] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW <unfinished ...>
[pid  5847] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW <unfinished ...>
[pid  5846] unlink("./0/binderfs")      = 0
[pid  5846] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW <unfinished ...>
[pid  5850] <... restart_syscall resumed>) = 0
[pid  5850] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument)
[pid  5850] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3
[  222.687136][ T5856] ERROR: (device loop4): diWrite: ixpxd invalid
[  222.687136][ T5856] 
[  222.698435][ T5856] ERROR: (device loop4): remounting filesystem as read-only
[  222.707481][ T5856] ERROR: (device loop4): txCommit: 
[  222.707481][ T5856] 
[pid  5850] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0
[pid  5850] getdents64(3, 0x55558d7386f0 /* 4 entries */, 32768) = 112
[pid  5850] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument)
[pid  5850] newfstatat(AT_FDCWD, "./0/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0
[pid  5850] unlink("./0/binderfs")      = 0
[  274.712174][ T5849] jfs_flush_journal: synclist not empty
[  274.717918][ T5849] metapage: ffff888077e972e8: 00001000 00000000 000036c8 00000000
[  274.725881][ T5849] metapage: ffff888077e972f8: 427dda28 ffff8881 427dda28 ffff8881
[  274.733866][ T5849] metapage: ffff888077e97308: 00000004 00000000 00000000 00000000
[  274.741710][ T5849] metapage: ffff888077e97318: 27559000 ffff8880 0000001c 00000000
[  274.749635][ T5849] metapage: ffff888077e97328: 00000000 dead4ead ffffffff 00000000
[  274.752042][ T5848] jfs_flush_journal: synclist not empty
[  274.757527][ T5849] metapage: ffff888077e97338: ffffffff ffffffff 9a4c9520 ffffffff
[  274.763064][ T5848] metapage: ffff888027c560f8: 00001000 00000000 000036c8 00000000
[  274.770858][ T5849] metapage: ffff888077e97348: 93c462c0 ffffffff 00000000 00000000
[  274.779199][ T5846] jfs_flush_journal: synclist not empty
[  274.786546][ T5847] jfs_flush_journal: synclist not empty
[  274.792169][ T5846] metapage: ffff88807620bc98: 00001000 00000000 000036c8 00000000
[  274.792190][ T5846] metapage: ffff88807620bca8: 427d9a28 ffff8881 427d9a28 ffff8881
[  274.792207][ T5846] metapage: ffff88807620bcb8: 00000004 00000000 00000000 00000000
[  274.797799][ T5847] metapage: ffff888076f03aa8: 00001000 00000000 000036c8 00000000
[  274.805634][ T5848] metapage: ffff888027c56108: 427da228 ffff8881 427da228 ffff8881
[  274.813509][ T5849] metapage: ffff888077e97358: 8c427c60 ffffffff 00000300 00000000
[  274.822194][ T5846] metapage: ffff88807620bcc8: 76d84000 ffff8880 0000001c 00000000
[  274.829715][ T5847] metapage: ffff888076f03ab8: 427dc228 ffff8881 427dc228 ffff8881
[  274.837811][ T5848] metapage: ffff888027c56118: 00000004 00000000 00000000 00000000
[  274.845350][ T5849] metapage: ffff888077e97368: 77e97368 ffff8880 77e97368 ffff8880
[  274.845371][ T5849] metapage: ffff888077e97378: 009d5640 ffffea00 356ac000 ffff8880
[  274.845389][ T5849] metapage: ffff888077e97388: 00001000 00003794 00000001 00000000
[  274.868840][ T5850] jfs_flush_journal: synclist not empty
[  274.868926][ T5850] metapage: ffff888024e442e8: 00001000 00000000 000036c8 00000000
[  274.876735][ T5847] metapage: ffff888076f03ac8: 00000004 00000000 00000000 00000000
[  274.885029][ T5846] metapage: ffff88807620bcd8: 00000000 dead4ead ffffffff 00000000
[  274.892387][ T5847] metapage: ffff888076f03ad8: 76244000 ffff8880 0000001c 00000000
[  274.897936][ T5848] metapage: ffff888027c56128: 24f77000 ffff8880 0000001c 00000000
[  274.905763][ T5849] metapage: ffff888077e97398: 427dd800 ffff8881
[  274.914103][ T5846] metapage: ffff88807620bce8: ffffffff ffffffff 9a4c9520 ffffffff
[  274.937761][ T5847] metapage: ffff888076f03ae8: 00000000 dead4ead ffffffff 00000000
[  274.943370][ T5850] metapage: ffff888024e442f8: 6db3b228 ffff8880 6db3b228 ffff8880
[  274.951154][ T5849] page: ffffea00009d5640: 00fff00000004128 ffffea00009d5608
[  274.959826][ T5848] metapage: ffff888027c56138: 00000000 dead4ead ffffffff 00000000
[  274.974140][ T5847] metapage: ffff888076f03af8: ffffffff ffffffff 9a4c9520 ffffffff
[  274.974164][ T5847] metapage: ffff888076f03b08: 93c462c0 ffffffff 00000000 00000000
[  274.974183][ T5847] metapage: ffff888076f03b18: 8c427c60 ffffffff 00000300 00000000
[  274.982659][ T5850] metapage: ffff888024e44308: 00000004 00000000 00000000 00000000
[  274.997610][ T5849] page: ffffea00009d5650: ffffea0001dbc788 ffff888076410650
[  274.997630][ T5849] page: ffffea00009d5660: 000000000000001c ffff888077e972e8
[  274.997645][ T5849] page: ffffea00009d5670: 00000003ffffffff ffff88801beec000
[  274.998855][ T5846] metapage: ffff88807620bcf8: 93c462c0 ffffffff 00000000 00000000
[  275.006164][ T5848] metapage: ffff888027c56148: ffffffff ffffffff 9a4c9520 ffffffff
[  275.014428][ T5847] metapage: ffff888076f03b28: 76f03b28 ffff8880 76f03b28 ffff8880
[  275.021318][ T5850] metapage: ffff888024e44318: 33fd9000 ffff8880 0000001c 00000000
[  275.028679][ T5846] metapage: ffff88807620bd08: 8c427c60 ffffffff 00000300 00000000
[  275.036083][ T5848] metapage: ffff888027c56158: 93c462c0 ffffffff 00000000 00000000
[  275.043788][ T5847] metapage: ffff888076f03b38: 01d89100 ffffea00 12502000 ffff8880
[  275.052530][ T5848] metapage: ffff888027c56168: 8c427c60 ffffffff 00000300 00000000
[  275.059440][ T5846] metapage: ffff88807620bd18: 7620bd18 ffff8880 7620bd18 ffff8880
[  275.067406][ T5850] metapage: ffff888024e44328: 00000000 dead4ead ffffffff 00000000
[  275.075618][ T5847] metapage: ffff888076f03b48: 00001000 00003794 00000001 00000000
[  275.083111][ T5848] metapage: ffff888027c56178: 27c56178 ffff8880 27c56178 ffff8880
[  275.090428][ T5846] metapage: ffff88807620bd28: 01db6100 ffffea00 7d01c000 ffff8880
[  275.098339][ T5850] metapage: ffff888024e44338: ffffffff ffffffff 9a4c9520 ffffffff
[  275.098361][ T5850] metapage: ffff888024e44348: 93c462c0 ffffffff 00000000 00000000
[  275.098379][ T5850] metapage: ffff888024e44358: 8c427c60 ffffffff 00000300 00000000
[  275.106249][ T5847] metapage: ffff888076f03b58: 427dc000 ffff8881
[  275.129755][ T5848] metapage: ffff888027c56188: 0093ddc0 ffffea00 6d976000 ffff8880
[  275.129779][ T5848] metapage: ffff888027c56198: 00001000 00003794 00000001 00000000
[  275.129796][ T5848] metapage: ffff888027c561a8: 427da000 ffff8881
[  275.138142][ T5846] metapage: ffff88807620bd38: 00001000 00003794 00000001 00000000
[  275.145924][ T5850] metapage: ffff888024e44368: 24e44368 ffff8880 24e44368 ffff8880
[  275.153666][ T5846] metapage: ffff88807620bd48: 427d9800 ffff8881
[  275.175221][ T5850] metapage: ffff888024e44378: 00cff640 ffffea00 7a692000 ffff8880
[  275.175247][ T5850] metapage: ffff888024e44388: 00001000 00003794 00000001 00000000
[  275.175263][ T5850] metapage: ffff888024e44398: 6db3b000 ffff8880
[  275.183367][ T5847] page: ffffea0001d89100: 00fff0000000412c ffffea0001dbc788
[  275.189517][ T5848] page: ffffea000093ddc0: 00fff0000000412c ffffea0000909b88
[  275.197367][ T5847] page: ffffea0001d89110: ffffea0000d55c48 ffff888076413da0
[  275.205068][ T5850] page: ffffea0000cff640: 00fff0000000412c ffffea0000d55c48
[  275.211742][ T5847] page: ffffea0001d89120: 000000000000001c ffff888076f03aa8
[  275.219279][ T5848] page: ffffea000093ddd0: ffffea0000cd8708 ffff8880764d8650
[  275.227350][ T5846] page: ffffea0001db6100: 00fff0000000412c ffffea0001d88288
[  275.233298][ T5850] page: ffffea0000cff650: ffffea0001ebc048 ffff888076588f88
[  275.233315][ T5850] page: ffffea0000cff660: 000000000000001c ffff888024e442e8
[  275.233329][ T5850] page: ffffea0000cff670: 00000003ffffffff ffff88801beec000
[  275.235603][ T5848] page: ffffea000093dde0: 000000000000001c ffff888027c560f8
[  275.240928][ T5846] page: ffffea0001db6110: ffffea0001e42748 ffff888076416bb8
[  275.248012][ T5848] page: ffffea000093ddf0: 00000003ffffffff ffff88801beec000
[  275.255900][ T5847] page: ffffea0001d89130: 00000003ffffffff ffff88801beec000
[  275.265764][ T5846] page: ffffea0001db6120: 000000000000001c ffff88807620bc98
[  275.343414][ T5846] page: ffffea0001db6130: 00000003ffffffff ffff88801beec000
[  327.072111][ T5849] jfs_flush_journal: synclist not empty
[  327.077850][ T5849] metapage: ffff888077e972e8: 00001000 00000000 000036c8 00000000
[  327.085757][ T5849] metapage: ffff888077e972f8: 427dda28 ffff8881 427dda28 ffff8881
[  327.093653][ T5849] metapage: ffff888077e97308: 00000004 00000000 00000000 00000000
[  327.101502][ T5849] metapage: ffff888077e97318: 27559000 ffff8880 0000001c 00000000
[  327.109402][ T5849] metapage: ffff888077e97328: 00000000 dead4ead ffffffff 00000000
[  327.117275][ T5849] metapage: ffff888077e97338: ffffffff ffffffff 9a4c9520 ffffffff
[  327.125127][ T5849] metapage: ffff888077e97348: 93c462c0 ffffffff 00000000 00000000
[  327.133004][ T5849] metapage: ffff888077e97358: 8c427c60 ffffffff 00000300 00000000
[  327.140801][ T5849] metapage: ffff888077e97368: 77e97368 ffff8880 77e97368 ffff8880
[  327.148669][ T5849] metapage: ffff888077e97378: 009d5640 ffffea00 356ac000 ffff8880
[  327.156544][ T5849] metapage: ffff888077e97388: 00001000 00003794 00000001 00000000
[  327.164405][ T5849] metapage: ffff888077e97398: 427dd800 ffff8881
[pid  5850] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW <unfinished ...>
[pid  5849] <... umount2 resumed>)      = 0
[pid  5849] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument)
[pid  5849] newfstatat(AT_FDCWD, "./0/file0", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0
[pid  5849] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument)
[  327.170841][ T5849] page: ffffea00009d5640: 00fff00000004128 ffffea0000bf48c8
[  327.178209][ T5849] page: ffffea00009d5650: ffffea0001d89108 ffff888076410650
[  327.185534][ T5849] page: ffffea00009d5660: 000000000000001c ffff888077e972e8
[  327.192913][ T5849] page: ffffea00009d5670: 00000003ffffffff ffff88801beec000
[pid  5849] openat(AT_FDCWD, "./0/file0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4
[pid  5849] newfstatat(4, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0
[pid  5849] getdents64(4, 0x55558d740730 /* 2 entries */, 32768) = 48
[pid  5849] getdents64(4, 0x55558d740730 /* 0 entries */, 32768) = 0
[pid  5849] close(4)                    = 0
[pid  5849] rmdir("./0/file0")          = 0
[pid  5849] getdents64(3, 0x55558d7386f0 /* 0 entries */, 32768) = 0
[pid  5849] close(3)                    = 0
[pid  5849] rmdir("./0")                = 0
[pid  5849] mkdir("./1", 0777)          = 0
[pid  5849] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = 3
[pid  5849] ioctl(3, LOOP_CLR_FD)       = 0
[pid  5849] close(3)                    = 0
[pid  5849] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5865 attached
, child_tidptr=0x55558d737650) = 5865
[pid  5865] set_robust_list(0x55558d737660, 24) = 0
[pid  5865] chdir("./1")                = 0
[pid  5865] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0
[pid  5865] setpgid(0, 0)               = 0
[pid  5865] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC) = 3
[pid  5865] write(3, "1000", 4)         = 4
[pid  5865] close(3)                    = 0
[pid  5865] symlink("/dev/binderfs", "./binderfs") = 0
[pid  5865] write(1, "executing program\n", 18executing program
) = 18
[pid  5865] memfd_create("syzkaller", 0) = 3
[pid  5865] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f7215a00000
[pid  5865] write(3, "\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., 16777216) = 16777216
[pid  5865] munmap(0x7f7215a00000, 138412032) = 0
[pid  5865] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = 4
[pid  5865] ioctl(4, LOOP_SET_FD, 3)    = 0
[pid  5865] close(3)                    = 0
[pid  5865] close(4)                    = 0
[pid  5865] mkdir("./file0", 0777)      = 0
[pid  5865] mount("/dev/loop3", "./file0", "jfs", MS_I_VERSION, "") = 0
[pid  5865] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY) = 3
[  327.684548][ T5865] loop3: detected capacity change from 0 to 32768
[pid  5865] chdir("./file0")            = 0
[pid  5865] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = -1 EBUSY (Device or resource busy)
[pid  5865] openat(AT_FDCWD, "./file1", O_RDWR|O_CREAT|O_SYNC|O_NOATIME|FASYNC, 0424) = 4
[pid  5865] openat(AT_FDCWD, "./bus", O_RDWR|O_CREAT|O_SYNC|O_DIRECT, 0737) = -1 EIO (Input/output error)
[pid  5865] 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  5865] exit_group(0)               = ?
[pid  5865] +++ exited with 0 +++
[pid  5849] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5865, si_uid=0, si_status=0, si_utime=4 /* 0.04 s */, si_stime=13 /* 0.13 s */} ---
[pid  5849] restart_syscall(<... resuming interrupted clone ...>) = 0
[pid  5849] umount2("./1", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument)
[pid  5849] openat(AT_FDCWD, "./1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3
[  327.751383][ T5865] ERROR: (device loop3): diWrite: ixpxd invalid
[  327.751383][ T5865] 
[  327.761427][ T5865] ERROR: (device loop3): remounting filesystem as read-only
[  327.769857][ T5865] ERROR: (device loop3): txCommit: 
[  327.769857][ T5865] 
[pid  5849] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0
[pid  5849] getdents64(3, 0x55558d7386f0 /* 4 entries */, 32768) = 112
[pid  5849] umount2("./1/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument)
[pid  5849] newfstatat(AT_FDCWD, "./1/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0
[pid  5849] unlink("./1/binderfs")      = 0
[  379.212053][ T5850] jfs_flush_journal: synclist not empty
[  379.217643][ T5850] metapage: ffff888024e442e8: 00001000 00000000 000036c8 00000000
[  379.225558][ T5850] metapage: ffff888024e442f8: 6db3b228 ffff8880 6db3b228 ffff8880
[  379.233679][ T5850] metapage: ffff888024e44308: 00000004 00000000 00000000 00000000
[  379.241479][ T5850] metapage: ffff888024e44318: 33fd9000 ffff8880 0000001c 00000000
[  379.249518][ T5850] metapage: ffff888024e44328: 00000000 dead4ead ffffffff 00000000
[  379.257429][ T5850] metapage: ffff888024e44338: ffffffff ffffffff 9a4c9520 ffffffff
[  379.265296][ T5850] metapage: ffff888024e44348: 93c462c0 ffffffff 00000000 00000000
[  379.273161][ T5850] metapage: ffff888024e44358: 8c427c60 ffffffff 00000300 00000000
[  379.280956][ T5850] metapage: ffff888024e44368: 24e44368 ffff8880 24e44368 ffff8880
[  379.288837][ T5850] metapage: ffff888024e44378: 00cff640 ffffea00 7a692000 ffff8880
[  379.296748][ T5850] metapage: ffff888024e44388: 00001000 00003794 00000001 00000000
[  379.304939][ T5850] metapage: ffff888024e44398: 6db3b000 ffff8880
[pid  5849] umount2("./1/file0", MNT_FORCE|UMOUNT_NOFOLLOW <unfinished ...>
[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)
[  379.311202][ T5850] page: ffffea0000cff640: 00fff0000000412c ffffea0001d89108
[  379.318598][ T5850] page: ffffea0000cff650: ffffea0001ebc048 ffff888076588f88
[  379.325936][ T5850] page: ffffea0000cff660: 000000000000001c ffff888024e442e8
[  379.333325][ T5850] page: ffffea0000cff670: 00000003ffffffff ffff88801beec000
[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, 0x55558d740730 /* 2 entries */, 32768) = 48
[pid  5850] getdents64(4, 0x55558d740730 /* 0 entries */, 32768) = 0
[pid  5850] close(4)                    = 0
[pid  5850] rmdir("./0/file0")          = 0
[pid  5850] getdents64(3, 0x55558d7386f0 /* 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/loop4", 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 5873 attached
, child_tidptr=0x55558d737650) = 5873
[pid  5873] set_robust_list(0x55558d737660, 24) = 0
[pid  5873] chdir("./1")                = 0
[pid  5873] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0
[pid  5873] setpgid(0, 0)               = 0
[pid  5873] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC) = 3
[pid  5873] write(3, "1000", 4)         = 4
[pid  5873] close(3)                    = 0
[pid  5873] symlink("/dev/binderfs", "./binderfs") = 0
executing program
[pid  5873] write(1, "executing program\n", 18) = 18
[pid  5873] memfd_create("syzkaller", 0) = 3
[pid  5873] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f7215a00000
[pid  5873] 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  5873] munmap(0x7f7215a00000, 138412032) = 0
[pid  5873] openat(AT_FDCWD, "/dev/loop4", O_RDWR) = 4
[pid  5873] ioctl(4, LOOP_SET_FD, 3)    = 0
[pid  5873] close(3)                    = 0
[pid  5873] close(4)                    = 0
[pid  5873] mkdir("./file0", 0777)      = 0
[  379.859047][ T5873] loop4: detected capacity change from 0 to 32768
[  379.892447][ T5849] jfs_flush_journal: synclist not empty
[  379.898056][ T5849] metapage: ffff888027c4e3e0: 00001000 00000000 000036c8 00000000
[pid  5873] mount("/dev/loop4", "./file0", "jfs", MS_I_VERSION, "") = 0
[pid  5873] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY) = 3
[pid  5873] chdir("./file0")            = 0
[pid  5873] openat(AT_FDCWD, "/dev/loop4", O_RDWR) = -1 EBUSY (Device or resource busy)
[  379.917286][ T5849] metapage: ffff888027c4e3f0: 6db3a228 ffff8880 6db3a228 ffff8880
[  379.925630][ T5849] metapage: ffff888027c4e400: 00000004 00000000 00000000 00000000
[  379.934172][ T5849] metapage: ffff888027c4e410: 3230e000 ffff8880 0000001c 00000000
[  379.942381][ T5849] metapage: ffff888027c4e420: 00000000 dead4ead ffffffff 00000000
[  379.950720][ T5849] metapage: ffff888027c4e430: ffffffff ffffffff 9a4c9520 ffffffff
[  379.959194][ T5849] metapage: ffff888027c4e440: 93c462c0 ffffffff 00000000 00000000
[pid  5873] openat(AT_FDCWD, "./file1", O_RDWR|O_CREAT|O_SYNC|O_NOATIME|FASYNC, 0424) = 4
[  379.959464][ T5873] ERROR: (device loop4): diWrite: ixpxd invalid
[  379.959464][ T5873] 
[  379.967105][ T5849] metapage: ffff888027c4e450: 8c427c60 ffffffff 00000300 00000000
[  379.977870][ T5873] ERROR: (device loop4): remounting filesystem as read-only
[  379.984020][ T5849] metapage: ffff888027c4e460: 27c4e460 ffff8880 27c4e460 ffff8880
[  379.992083][ T5873] ERROR: (device loop4): txCommit: 
[  379.992083][ T5873] 
[  379.999124][ T5849] metapage: ffff888027c4e470: 00c8c380 ffffea00 6e8f4000 ffff8880
[pid  5873] openat(AT_FDCWD, "./bus", O_RDWR|O_CREAT|O_SYNC|O_DIRECT, 0737) = -1 EIO (Input/output error)
[pid  5873] 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  5873] exit_group(0)               = ?
[pid  5873] +++ exited with 0 +++
[pid  5850] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5873, si_uid=0, si_status=0, si_utime=3 /* 0.03 s */, si_stime=18 /* 0.18 s */} ---
[pid  5850] restart_syscall(<... resuming interrupted clone ...>) = 0
[pid  5850] umount2("./1", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument)
[  380.014381][ T5849] metapage: ffff888027c4e480: 00001000 00003794 00000001 00000000
[  380.022682][ T5849] metapage: ffff888027c4e490: 6db3a000 ffff8880
[  380.028944][ T5849] page: ffffea0000c8c380: 00fff0000000412c ffffea0000a7ed88
[  380.036296][ T5849] page: ffffea0000c8c390: ffffea00004c4308 ffff88807658e280
[  380.044157][ T5849] page: ffffea0000c8c3a0: 000000000000001c ffff888027c4e3e0
[  380.051449][ T5849] page: ffffea0000c8c3b0: 00000003ffffffff ffff88801beec000
[pid  5850] openat(AT_FDCWD, "./1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3
[pid  5850] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0
[pid  5850] getdents64(3, 0x55558d7386f0 /* 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
[  430.162239][   T30] INFO: task syz-executor138:5846 blocked for more than 143 seconds.
[  430.170467][   T30]       Not tainted 6.13.0-rc7-syzkaller-00209-g9528d418de4d #0
[  430.178237][   T30] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[  430.187171][   T30] task:syz-executor138 state:D stack:25472 pid:5846  tgid:5846  ppid:5845   flags:0x00004002
[  430.197476][   T30] Call Trace:
[  430.200787][   T30]  <TASK>
[  430.203771][   T30]  __schedule+0x17fb/0x4be0
[  430.208337][   T30]  ? __pfx___schedule+0x10/0x10
[  430.213233][   T30]  ? __pfx_lock_release+0x10/0x10
[  430.218279][   T30]  ? _raw_spin_unlock_irqrestore+0x8f/0x140
[  430.224236][   T30]  ? _raw_spin_unlock_irqrestore+0xdd/0x140
[  430.230152][   T30]  ? __pfx__raw_spin_unlock_irqrestore+0x10/0x10
[  430.236557][   T30]  ? schedule+0x90/0x320
[  430.240878][   T30]  schedule+0x14b/0x320
[  430.245215][   T30]  schedule_preempt_disabled+0x13/0x30
[  430.250816][   T30]  __mutex_lock+0x7e7/0xee0
[  430.255417][   T30]  ? __mutex_lock+0x5ef/0xee0
[  430.260132][   T30]  ? lmLogClose+0xb2/0x530
[  430.264811][   T30]  ? __pfx___mutex_lock+0x10/0x10
[  430.269879][   T30]  ? updateSuper+0x13d/0x760
[  430.274681][   T30]  lmLogClose+0xb2/0x530
[  430.278970][   T30]  jfs_umount+0x2ce/0x3a0
[  430.283397][   T30]  jfs_put_super+0x8a/0x190
[  430.287920][   T30]  ? __pfx_jfs_put_super+0x10/0x10
[  430.293135][   T30]  generic_shutdown_super+0x139/0x2d0
[  430.298544][   T30]  kill_block_super+0x44/0x90
[  430.303374][   T30]  deactivate_locked_super+0xc4/0x130
[  430.308786][   T30]  cleanup_mnt+0x41f/0x4b0
[  430.313360][   T30]  ? lockdep_hardirqs_on+0x99/0x150
[  430.318593][   T30]  task_work_run+0x24f/0x310
[  430.323414][   T30]  ? __pfx_task_work_run+0x10/0x10
[  430.328540][   T30]  ? path_umount+0x211/0xf80
[  430.333200][   T30]  ptrace_notify+0x2d2/0x380
[  430.337814][   T30]  ? user_path_at+0x44/0x60
[  430.342360][   T30]  ? __pfx_ptrace_notify+0x10/0x10
[  430.347582][   T30]  ? kmem_cache_free+0x195/0x410
[  430.352643][   T30]  ? __x64_sys_umount+0x123/0x170
[  430.357701][   T30]  syscall_exit_work+0xc7/0x1d0
[  430.362602][   T30]  syscall_exit_to_user_mode+0x24a/0x340
[  430.368260][   T30]  do_syscall_64+0x100/0x230
[  430.372917][   T30]  ? clear_bhb_loop+0x35/0x90
[  430.377617][   T30]  entry_SYSCALL_64_after_hwframe+0x77/0x7f
[  430.383586][   T30] RIP: 0033:0x7f721df364f7
[  430.388022][   T30] RSP: 002b:00007fff54dce298 EFLAGS: 00000202 ORIG_RAX: 00000000000000a6
[  430.396496][   T30] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 00007f721df364f7
[  430.404510][   T30] RDX: 0000000000000000 RSI: 0000000000000009 RDI: 00007fff54dce350
[  430.412515][   T30] RBP: 00007fff54dce350 R08: 0000000000000000 R09: 0000000000000000
[  430.420501][   T30] R10: 00000000ffffffff R11: 0000000000000202 R12: 00007fff54dcf3b0
[  430.428534][   T30] R13: 000055558d7386c0 R14: 0000000000000001 R15: 431bde82d7b634db
[  430.436564][   T30]  </TASK>
[  430.439625][   T30] INFO: task syz-executor138:5847 blocked for more than 143 seconds.
[  430.447790][   T30]       Not tainted 6.13.0-rc7-syzkaller-00209-g9528d418de4d #0
[  430.455493][   T30] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[  430.464211][   T30] task:syz-executor138 state:D stack:24248 pid:5847  tgid:5847  ppid:5845   flags:0x00004002
[  430.474441][   T30] Call Trace:
[  430.477743][   T30]  <TASK>
[  430.480672][   T30]  __schedule+0x17fb/0x4be0
[  430.485243][   T30]  ? __pfx___schedule+0x10/0x10
[  430.490137][   T30]  ? __pfx_lock_release+0x10/0x10
[  430.495428][   T30]  ? _raw_spin_unlock_irqrestore+0x8f/0x140
[  430.501370][   T30]  ? _raw_spin_unlock_irqrestore+0xdd/0x140
[  430.507393][   T30]  ? __pfx__raw_spin_unlock_irqrestore+0x10/0x10
[  430.513773][   T30]  ? schedule+0x90/0x320
[  430.518018][   T30]  schedule+0x14b/0x320
[  430.522215][   T30]  schedule_preempt_disabled+0x13/0x30
[  430.527693][   T30]  __mutex_lock+0x7e7/0xee0
[  430.532244][   T30]  ? __mutex_lock+0x5ef/0xee0
[  430.537039][   T30]  ? lmLogClose+0xb2/0x530
[  430.541459][   T30]  ? __pfx___mutex_lock+0x10/0x10
[  430.546541][   T30]  ? updateSuper+0x13d/0x760
[  430.551159][   T30]  lmLogClose+0xb2/0x530
[  430.555474][   T30]  jfs_umount+0x2ce/0x3a0
[  430.559928][   T30]  jfs_put_super+0x8a/0x190
[  430.564722][   T30]  ? __pfx_jfs_put_super+0x10/0x10
[  430.569875][   T30]  generic_shutdown_super+0x139/0x2d0
[  430.575317][   T30]  kill_block_super+0x44/0x90
[  430.580056][   T30]  deactivate_locked_super+0xc4/0x130
[  430.585566][   T30]  cleanup_mnt+0x41f/0x4b0
[  430.590004][   T30]  ? lockdep_hardirqs_on+0x99/0x150
[  430.595289][   T30]  task_work_run+0x24f/0x310
[  430.599904][   T30]  ? __pfx_task_work_run+0x10/0x10
[  430.605062][   T30]  ? path_umount+0x211/0xf80
[  430.609687][   T30]  ptrace_notify+0x2d2/0x380
[  430.614336][   T30]  ? user_path_at+0x44/0x60
[  430.618860][   T30]  ? __pfx_ptrace_notify+0x10/0x10
[  430.624035][   T30]  ? kmem_cache_free+0x195/0x410
[  430.629013][   T30]  ? __x64_sys_umount+0x123/0x170
[  430.634117][   T30]  syscall_exit_work+0xc7/0x1d0
[  430.639003][   T30]  syscall_exit_to_user_mode+0x24a/0x340
[  430.644708][   T30]  do_syscall_64+0x100/0x230
[  430.649349][   T30]  ? clear_bhb_loop+0x35/0x90
[  430.654091][   T30]  entry_SYSCALL_64_after_hwframe+0x77/0x7f
[  430.660082][   T30] RIP: 0033:0x7f721df364f7
[  430.664563][   T30] RSP: 002b:00007fff54dce298 EFLAGS: 00000202 ORIG_RAX: 00000000000000a6
[  430.673053][   T30] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 00007f721df364f7
[  430.681040][   T30] RDX: 0000000000000000 RSI: 0000000000000009 RDI: 00007fff54dce350
[  430.689179][   T30] RBP: 00007fff54dce350 R08: 0000000000000000 R09: 0000000000000000
[  430.697200][   T30] R10: 00000000ffffffff R11: 0000000000000202 R12: 00007fff54dcf3b0
[  430.705221][   T30] R13: 000055558d7386c0 R14: 0000000000000001 R15: 431bde82d7b634db
[  430.713261][   T30]  </TASK>
[  430.716302][   T30] 
[  430.716302][   T30] Showing all locks held in the system:
[  430.724093][   T30] 1 lock held by khungtaskd/30:
[  430.728951][   T30]  #0: ffffffff8e937ae0 (rcu_read_lock){....}-{1:3}, at: debug_show_all_locks+0x55/0x2a0
[  430.738910][   T30] 2 locks held by getty/5578:
[  430.743652][   T30]  #0: ffff8880319990a0 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x25/0x70
[  430.753552][   T30]  #1: ffffc90002fde2f0 (&ldata->atomic_read_lock){+.+.}-{4:4}, at: n_tty_read+0x6a6/0x1e00
[  430.763936][   T30] 2 locks held by syz-executor138/5846:
[  430.769550][   T30]  #0: ffff88807d01c0e0 (&type->s_umount_key#43){+.+.}-{4:4}, at: deactivate_super+0xb5/0xf0
[  430.779853][   T30]  #1: ffffffff8ed55008 (jfs_log_mutex){+.+.}-{4:4}, at: lmLogClose+0xb2/0x530
[  430.788910][   T30] 2 locks held by syz-executor138/5847:
[  430.794501][   T30]  #0: ffff8880125020e0 (&type->s_umount_key#43){+.+.}-{4:4}, at: deactivate_super+0xb5/0xf0
[  430.804804][   T30]  #1: ffffffff8ed55008 (jfs_log_mutex){+.+.}-{4:4}, at: lmLogClose+0xb2/0x530
[  430.813911][   T30] 2 locks held by syz-executor138/5848:
[  430.819464][   T30]  #0: ffff88806d9760e0 (&type->s_umount_key#43){+.+.}-{4:4}, at: deactivate_super+0xb5/0xf0
[  430.829796][   T30]  #1: ffffffff8ed55008 (jfs_log_mutex){+.+.}-{4:4}, at: lmLogClose+0xb2/0x530
[  430.839004][   T30] 2 locks held by syz-executor138/5849:
[  430.844616][   T30]  #0: ffff88806e8f40e0 (&type->s_umount_key#43){+.+.}-{4:4}, at: deactivate_super+0xb5/0xf0
[  430.854987][   T30]  #1: ffffffff8ed55008 (jfs_log_mutex){+.+.}-{4:4}, at: lmLogClose+0xb2/0x530
[  430.864130][   T30] 1 lock held by syz-executor138/5850:
[  430.869609][   T30]  #0: ffff888035b360e0 (&type->s_umount_key#43){+.+.}-{4:4}, at: deactivate_super+0xb5/0xf0
[  430.879917][   T30] 
[  430.882310][   T30] =============================================
[  430.882310][   T30] 
[  430.890754][   T30] NMI backtrace for cpu 0
[  430.895100][   T30] CPU: 0 UID: 0 PID: 30 Comm: khungtaskd Not tainted 6.13.0-rc7-syzkaller-00209-g9528d418de4d #0
[  430.905608][   T30] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 12/27/2024
[  430.915669][   T30] Call Trace:
[  430.918953][   T30]  <TASK>
[  430.921914][   T30]  dump_stack_lvl+0x241/0x360
[  430.926603][   T30]  ? __pfx_dump_stack_lvl+0x10/0x10
[  430.931786][   T30]  ? __pfx__printk+0x10/0x10
[  430.936369][   T30]  nmi_cpu_backtrace+0x49c/0x4d0
[  430.941298][   T30]  ? __pfx_nmi_cpu_backtrace+0x10/0x10
[  430.946738][   T30]  ? _printk+0xd5/0x120
[  430.950888][   T30]  ? __pfx__printk+0x10/0x10
[  430.955478][   T30]  ? __wake_up_klogd+0xcc/0x110
[  430.960317][   T30]  ? __pfx__printk+0x10/0x10
[  430.964908][   T30]  ? __rcu_read_unlock+0xa1/0x110
[  430.969960][   T30]  ? __pfx_nmi_raise_cpu_backtrace+0x10/0x10
[  430.976002][   T30]  nmi_trigger_cpumask_backtrace+0x198/0x320
[  430.981989][   T30]  watchdog+0xff6/0x1040
[  430.986242][   T30]  ? watchdog+0x1ea/0x1040
[  430.990645][   T30]  ? __pfx_watchdog+0x10/0x10
[  430.995306][   T30]  kthread+0x2f0/0x390
[  430.999359][   T30]  ? __pfx_watchdog+0x10/0x10
[  431.004020][   T30]  ? __pfx_kthread+0x10/0x10
[  431.008594][   T30]  ret_from_fork+0x4b/0x80
[  431.013018][   T30]  ? __pfx_kthread+0x10/0x10
[  431.017683][   T30]  ret_from_fork_asm+0x1a/0x30
[  431.022444][   T30]  </TASK>
[  431.025665][   T30] Sending NMI from CPU 0 to CPUs 1:
[  431.031008][    C1] NMI backtrace for cpu 1
[  431.031023][    C1] CPU: 1 UID: 0 PID: 12 Comm: kworker/u8:1 Not tainted 6.13.0-rc7-syzkaller-00209-g9528d418de4d #0
[  431.031041][    C1] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 12/27/2024
[  431.031051][    C1] Workqueue: events_unbound toggle_allocation_gate
[  431.031078][    C1] RIP: 0010:do_sync_core+0x49/0x50
[  431.031100][    C1] Code: e8 6c c4 5f 00 0f 01 e8 c3 cc cc cc cc f3 0f 1e fa e8 5b c4 5f 00 8c d0 50 54 48 83 04 24 08 9c 8c c8 50 68 29 a3 3f 81 48 cf <c3> cc cc cc cc 66 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90
[  431.031112][    C1] RSP: 0018:ffffc900001176d8 EFLAGS: 00000086
[  431.031124][    C1] RAX: 0000000000000010 RBX: ffffffff813fa2e0 RCX: ffff88801d2cda00
[  431.031136][    C1] RDX: 0000000000000000 RSI: ffffffff8c5f01c0 RDI: 0000000000000000
[  431.031146][    C1] RBP: ffffc900001178e0 R08: ffffffff81938215 R09: 1ffffffff20310d6
[  431.031157][    C1] R10: dffffc0000000000 R11: ffffffff813fa2e0 R12: dffffc0000000000
[  431.031169][    C1] R13: ffff8880b873f940 R14: 0000000000000200 R15: 0000000000000001
[  431.031179][    C1] FS:  0000000000000000(0000) GS:ffff8880b8700000(0000) knlGS:0000000000000000
[  431.031192][    C1] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  431.031203][    C1] CR2: 000055f4e1ba1d88 CR3: 000000000e736000 CR4: 00000000003526f0
[  431.031217][    C1] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[  431.031227][    C1] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
[  431.031236][    C1] Call Trace:
[  431.031242][    C1]  <NMI>
[  431.031248][    C1]  ? nmi_cpu_backtrace+0x3c2/0x4d0
[  431.031266][    C1]  ? __pfx_lock_acquire+0x10/0x10
[  431.031284][    C1]  ? __pfx_nmi_cpu_backtrace+0x10/0x10
[  431.031300][    C1]  ? nmi_handle+0x2a/0x5a0
[  431.031322][    C1]  ? nmi_cpu_backtrace_handler+0xc/0x20
[  431.031342][    C1]  ? nmi_handle+0x14f/0x5a0
[  431.031357][    C1]  ? nmi_handle+0x2a/0x5a0
[  431.031373][    C1]  ? do_sync_core+0x49/0x50
[  431.031389][    C1]  ? default_do_nmi+0x63/0x160
[  431.031407][    C1]  ? exc_nmi+0x123/0x1f0
[  431.031422][    C1]  ? end_repeat_nmi+0xf/0x53
[  431.031437][    C1]  ? __pfx_do_sync_core+0x10/0x10
[  431.031454][    C1]  ? __pfx_do_sync_core+0x10/0x10
[  431.031471][    C1]  ? smp_call_function_many_cond+0x1705/0x2c60
[  431.031492][    C1]  ? do_sync_core+0x49/0x50
[  431.031509][    C1]  ? do_sync_core+0x49/0x50
[  431.031526][    C1]  ? do_sync_core+0x49/0x50
[  431.031543][    C1]  </NMI>
[  431.031548][    C1]  <TASK>
[  431.031553][    C1]  smp_call_function_many_cond+0x1760/0x2c60
[  431.031576][    C1]  ? __pfx_do_sync_core+0x10/0x10
[  431.031597][    C1]  ? kmem_cache_alloc_bulk_noprof+0x156/0x7c0
[  431.031616][    C1]  ? __pfx_smp_call_function_many_cond+0x10/0x10
[  431.031635][    C1]  ? __pfx_perf_event_text_poke+0x10/0x10
[  431.031651][    C1]  ? __pfx___mutex_trylock_common+0x10/0x10
[  431.031671][    C1]  ? __pfx_do_sync_core+0x10/0x10
[  431.031689][    C1]  on_each_cpu_cond_mask+0x3f/0x80
[  431.031708][    C1]  text_poke_bp_batch+0x726/0xb30
[  431.031730][    C1]  ? kmem_cache_alloc_bulk_noprof+0x157/0x7c0
[  431.031745][    C1]  ? __pfx_text_poke_bp_batch+0x10/0x10
[  431.031766][    C1]  ? arch_jump_label_transform_queue+0x9b/0x100
[  431.031788][    C1]  ? process_scheduled_works+0x976/0x1840
[  431.031809][    C1]  text_poke_finish+0x30/0x50
[  431.031826][    C1]  arch_jump_label_transform_apply+0x1c/0x30
[  431.031851][    C1]  static_key_enable_cpuslocked+0x136/0x260
[  431.031870][    C1]  static_key_enable+0x1a/0x20
[  431.031887][    C1]  toggle_allocation_gate+0xbc/0x260
[  431.031907][    C1]  ? __pfx_toggle_allocation_gate+0x10/0x10
[  431.031929][    C1]  ? __pfx_lockdep_hardirqs_on_prepare+0x10/0x10
[  431.031948][    C1]  process_scheduled_works+0xa66/0x1840
[  431.031980][    C1]  ? __pfx_process_scheduled_works+0x10/0x10
[  431.032003][    C1]  ? assign_work+0x364/0x3d0
[  431.032024][    C1]  worker_thread+0x870/0xd30
[  431.032044][    C1]  ? __kthread_parkme+0x169/0x1d0
[  431.032061][    C1]  ? __pfx_worker_thread+0x10/0x10
[  431.032074][    C1]  kthread+0x2f0/0x390
[  431.032090][    C1]  ? __pfx_worker_thread+0x10/0x10
[  431.032104][    C1]  ? __pfx_kthread+0x10/0x10
[  431.032119][    C1]  ret_from_fork+0x4b/0x80
[  431.032133][    C1]  ? __pfx_kthread+0x10/0x10
[  431.032148][    C1]  ret_from_fork_asm+0x1a/0x30
[  431.032174][    C1]  </TASK>
[  431.032181][    C1] INFO: NMI handler (nmi_cpu_backtrace_handler) took too long to run: 1.173 msecs
[  431.033014][   T30] Kernel panic - not syncing: hung_task: blocked tasks
[  431.033027][   T30] CPU: 0 UID: 0 PID: 30 Comm: khungtaskd Not tainted 6.13.0-rc7-syzkaller-00209-g9528d418de4d #0
[  431.033048][   T30] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 12/27/2024
[  431.033058][   T30] Call Trace:
[  431.033065][   T30]  <TASK>
[  431.033073][   T30]  dump_stack_lvl+0x241/0x360
[  431.033106][   T30]  ? __pfx_dump_stack_lvl+0x10/0x10
[  431.033128][   T30]  ? __pfx__printk+0x10/0x10
[  431.033146][   T30]  ? lockdep_hardirqs_on_prepare+0x43d/0x780
[  431.033171][   T30]  ? vscnprintf+0x5d/0x90
[  431.033194][   T30]  panic+0x349/0x880
[  431.033214][   T30]  ? nmi_trigger_cpumask_backtrace+0x244/0x320
[  431.033237][   T30]  ? __pfx_panic+0x10/0x10
[  431.033254][   T30]  ? tick_nohz_tick_stopped+0x82/0xb0
[  431.033279][   T30]  ? __irq_work_queue_local+0x137/0x410
[  431.033300][   T30]  ? irq_work_queue+0xca/0x150
[  431.033317][   T30]  ? __pfx_nmi_raise_cpu_backtrace+0x10/0x10
[  431.033342][   T30]  ? __pfx_nmi_raise_cpu_backtrace+0x10/0x10
[  431.033365][   T30]  ? __pfx_nmi_raise_cpu_backtrace+0x10/0x10
[  431.033388][   T30]  ? nmi_trigger_cpumask_backtrace+0x251/0x320
[  431.033412][   T30]  watchdog+0x1035/0x1040
[  431.033433][   T30]  ? watchdog+0x1ea/0x1040
[  431.033456][   T30]  ? __pfx_watchdog+0x10/0x10
[  431.033474][   T30]  kthread+0x2f0/0x390
[  431.033492][   T30]  ? __pfx_watchdog+0x10/0x10
[  431.033509][   T30]  ? __pfx_kthread+0x10/0x10
[  431.033529][   T30]  ret_from_fork+0x4b/0x80
[  431.033545][   T30]  ? __pfx_kthread+0x10/0x10
[  431.033564][   T30]  ret_from_fork_asm+0x1a/0x30
[  431.033598][   T30]  </TASK>
[  431.605581][   T30] Kernel Offset: disabled
[  431.609903][   T30] Rebooting in 86400 seconds..