./strace-static-x86_64 -e \!wait4,clock_nanosleep,nanosleep -s 100 -x -f ./syz-executor2202231419 <...> Warning: Permanently added '10.128.1.116' (ED25519) to the list of known hosts. execve("./syz-executor2202231419", ["./syz-executor2202231419"], 0x7fff1056fe50 /* 10 vars */) = 0 brk(NULL) = 0x55557e1f7000 brk(0x55557e1f7d00) = 0x55557e1f7d00 arch_prctl(ARCH_SET_FS, 0x55557e1f7380) = 0 set_tid_address(0x55557e1f7650) = 5237 set_robust_list(0x55557e1f7660, 24) = 0 rseq(0x55557e1f7ca0, 0x20, 0, 0x53053053) = 0 prlimit64(0, RLIMIT_STACK, NULL, {rlim_cur=8192*1024, rlim_max=RLIM64_INFINITY}) = 0 readlink("/proc/self/exe", "/root/syz-executor2202231419", 4096) = 28 getrandom("\xd9\x4f\xf9\x25\xef\xa6\xad\xc6", 8, GRND_NONBLOCK) = 8 brk(NULL) = 0x55557e1f7d00 brk(0x55557e218d00) = 0x55557e218d00 brk(0x55557e219000) = 0x55557e219000 mprotect(0x7feeed260000, 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 5238 attached , child_tidptr=0x55557e1f7650) = 5238 [pid 5238] set_robust_list(0x55557e1f7660, 24) = 0 [pid 5237] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5238] mkdir("./syzkaller.1FDdBY", 0700./strace-static-x86_64: Process 5239 attached [pid 5237] <... clone resumed>, child_tidptr=0x55557e1f7650) = 5239 [pid 5239] set_robust_list(0x55557e1f7660, 24 [pid 5238] <... mkdir resumed>) = 0 [pid 5237] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5239] <... set_robust_list resumed>) = 0 [pid 5238] chmod("./syzkaller.1FDdBY", 0777) = 0 ./strace-static-x86_64: Process 5240 attached [pid 5239] mkdir("./syzkaller.cuDq88", 0700 [pid 5240] set_robust_list(0x55557e1f7660, 24 [pid 5238] chdir("./syzkaller.1FDdBY" [pid 5240] <... set_robust_list resumed>) = 0 [pid 5238] <... chdir resumed>) = 0 [pid 5237] <... clone resumed>, child_tidptr=0x55557e1f7650) = 5240 [pid 5240] mkdir("./syzkaller.Dpr6Do", 0700 [pid 5238] mkdir("./0", 0777 [pid 5237] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5238] <... mkdir resumed>) = 0 ./strace-static-x86_64: Process 5241 attached [pid 5240] <... mkdir resumed>) = 0 [pid 5239] <... mkdir resumed>) = 0 [pid 5240] chmod("./syzkaller.Dpr6Do", 0777 [pid 5238] openat(AT_FDCWD, "/dev/loop0", O_RDWR [pid 5241] set_robust_list(0x55557e1f7660, 24 [pid 5240] <... chmod resumed>) = 0 [pid 5239] chmod("./syzkaller.cuDq88", 0777 [pid 5238] <... openat resumed>) = 3 [pid 5241] <... set_robust_list resumed>) = 0 [pid 5240] chdir("./syzkaller.Dpr6Do") = 0 [pid 5237] <... clone resumed>, child_tidptr=0x55557e1f7650) = 5241 [pid 5241] mkdir("./syzkaller.pESYyI", 0700 [pid 5240] mkdir("./0", 0777 [pid 5239] <... chmod resumed>) = 0 [pid 5238] ioctl(3, LOOP_CLR_FD [pid 5237] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5240] <... mkdir resumed>) = 0 [pid 5238] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5241] <... mkdir resumed>) = 0 [pid 5239] chdir("./syzkaller.cuDq88"./strace-static-x86_64: Process 5242 attached [pid 5240] openat(AT_FDCWD, "/dev/loop2", O_RDWR [pid 5239] <... chdir resumed>) = 0 [pid 5238] close(3 [pid 5237] <... clone resumed>, child_tidptr=0x55557e1f7650) = 5242 [pid 5242] set_robust_list(0x55557e1f7660, 24 [pid 5241] chmod("./syzkaller.pESYyI", 0777 [pid 5240] <... openat resumed>) = 3 [pid 5239] mkdir("./0", 0777 [pid 5242] <... set_robust_list resumed>) = 0 [pid 5241] <... chmod resumed>) = 0 [pid 5238] <... close resumed>) = 0 [pid 5242] mkdir("./syzkaller.PFdoDH", 0700 [pid 5240] ioctl(3, LOOP_CLR_FD [pid 5238] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5239] <... mkdir resumed>) = 0 ./strace-static-x86_64: Process 5243 attached [pid 5241] chdir("./syzkaller.pESYyI" [pid 5240] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5242] <... mkdir resumed>) = 0 [pid 5241] <... chdir resumed>) = 0 [pid 5240] close(3 [pid 5239] openat(AT_FDCWD, "/dev/loop1", O_RDWR [pid 5241] mkdir("./0", 0777 [pid 5240] <... close resumed>) = 0 [pid 5243] set_robust_list(0x55557e1f7660, 24 [pid 5242] chmod("./syzkaller.PFdoDH", 0777 [pid 5241] <... mkdir resumed>) = 0 [pid 5239] <... openat resumed>) = 3 [pid 5238] <... clone resumed>, child_tidptr=0x55557e1f7650) = 5243 [pid 5240] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5243] <... set_robust_list resumed>) = 0 [pid 5242] <... chmod resumed>) = 0 [pid 5241] openat(AT_FDCWD, "/dev/loop3", O_RDWR [pid 5239] ioctl(3, LOOP_CLR_FD./strace-static-x86_64: Process 5245 attached [pid 5245] set_robust_list(0x55557e1f7660, 24 [pid 5243] chdir("./0" [pid 5241] <... openat resumed>) = 3 [pid 5239] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5245] <... set_robust_list resumed>) = 0 [pid 5239] close(3 [pid 5242] chdir("./syzkaller.PFdoDH" [pid 5239] <... close resumed>) = 0 [pid 5242] <... chdir resumed>) = 0 [pid 5245] chdir("./0" [pid 5242] mkdir("./0", 0777 [pid 5239] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5243] <... chdir resumed>) = 0 [pid 5242] <... mkdir resumed>) = 0 [pid 5240] <... clone resumed>, child_tidptr=0x55557e1f7650) = 5245 [pid 5243] prctl(PR_SET_PDEATHSIG, SIGKILL./strace-static-x86_64: Process 5246 attached ) = 0 [pid 5243] setpgid(0, 0) = 0 [pid 5243] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5242] openat(AT_FDCWD, "/dev/loop4", O_RDWR [pid 5243] <... openat resumed>) = 3 [pid 5242] <... openat resumed>) = 3 [pid 5242] ioctl(3, LOOP_CLR_FD) = -1 ENXIO (No such device or address) [pid 5243] write(3, "1000", 4) = 4 [pid 5242] close(3 [pid 5243] close(3 [pid 5242] <... close resumed>) = 0 [pid 5242] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5247 attached [pid 5246] set_robust_list(0x55557e1f7660, 24 [pid 5245] <... chdir resumed>) = 0 [pid 5241] ioctl(3, LOOP_CLR_FD [pid 5246] <... set_robust_list resumed>) = 0 [pid 5245] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5239] <... clone resumed>, child_tidptr=0x55557e1f7650) = 5246 [pid 5247] set_robust_list(0x55557e1f7660, 24 [pid 5246] chdir("./0" [pid 5245] <... prctl resumed>) = 0 [pid 5243] <... close resumed>) = 0 [pid 5241] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5246] <... chdir resumed>) = 0 [pid 5245] setpgid(0, 0 [pid 5243] symlink("/dev/binderfs", "./binderfs" [pid 5241] close(3 [pid 5247] <... set_robust_list resumed>) = 0 [pid 5246] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5245] <... setpgid resumed>) = 0 [pid 5247] chdir("./0" [pid 5246] <... prctl resumed>) = 0 [pid 5242] <... clone resumed>, child_tidptr=0x55557e1f7650) = 5247 [pid 5247] <... chdir resumed>) = 0 [pid 5246] setpgid(0, 0 [pid 5245] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5243] <... symlink resumed>) = 0 [pid 5241] <... close resumed>) = 0 [pid 5247] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5246] <... setpgid resumed>) = 0 executing program [pid 5245] <... openat resumed>) = 3 [pid 5243] write(1, "executing program\n", 18 [pid 5241] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5248 attached [pid 5247] <... prctl resumed>) = 0 [pid 5246] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5245] write(3, "1000", 4 [pid 5243] <... write resumed>) = 18 [pid 5247] setpgid(0, 0 [pid 5246] <... openat resumed>) = 3 [pid 5243] memfd_create("syzkaller", 0 [pid 5248] set_robust_list(0x55557e1f7660, 24 [pid 5247] <... setpgid resumed>) = 0 [pid 5246] write(3, "1000", 4 [pid 5245] <... write resumed>) = 4 [pid 5241] <... clone resumed>, child_tidptr=0x55557e1f7650) = 5248 [pid 5248] <... set_robust_list resumed>) = 0 [pid 5247] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5246] <... write resumed>) = 4 [pid 5245] close(3 [pid 5243] <... memfd_create resumed>) = 3 [pid 5248] chdir("./0" [pid 5247] <... openat resumed>) = 3 [pid 5246] close(3 [pid 5245] <... close resumed>) = 0 [pid 5243] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5248] <... chdir resumed>) = 0 [pid 5247] write(3, "1000", 4 [pid 5246] <... close resumed>) = 0 [pid 5245] symlink("/dev/binderfs", "./binderfs" [pid 5243] <... mmap resumed>) = 0x7feee4c00000 [pid 5248] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5247] <... write resumed>) = 4 [pid 5246] symlink("/dev/binderfs", "./binderfs" [pid 5248] <... prctl resumed>) = 0 [pid 5247] close(3 [pid 5248] setpgid(0, 0 [pid 5247] <... close resumed>) = 0 [pid 5246] <... symlink resumed>) = 0 [pid 5245] <... symlink resumed>) = 0 [pid 5246] write(1, "executing program\n", 18executing program ) = 18 [pid 5248] <... setpgid resumed>) = 0 [pid 5247] symlink("/dev/binderfs", "./binderfs" [pid 5246] memfd_create("syzkaller", 0executing program [pid 5248] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5246] <... memfd_create resumed>) = 3 [pid 5245] write(1, "executing program\n", 18executing program [pid 5247] <... symlink resumed>) = 0 [pid 5246] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5245] <... write resumed>) = 18 [pid 5248] <... openat resumed>) = 3 [pid 5247] write(1, "executing program\n", 18 [pid 5246] <... mmap resumed>) = 0x7feee4c00000 [pid 5245] memfd_create("syzkaller", 0 [pid 5248] write(3, "1000", 4 [pid 5247] <... write resumed>) = 18 [pid 5248] <... write resumed>) = 4 [pid 5248] close(3 [pid 5247] memfd_create("syzkaller", 0 [pid 5248] <... close resumed>) = 0 [pid 5247] <... memfd_create resumed>) = 3 [pid 5248] symlink("/dev/binderfs", "./binderfs" [pid 5247] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5245] <... memfd_create resumed>) = 3 [pid 5248] <... symlink resumed>) = 0 [pid 5247] <... mmap resumed>) = 0x7feee4c00000 [pid 5245] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7feee4c00000 [pid 5248] write(1, "executing program\n", 18executing program ) = 18 [pid 5248] memfd_create("syzkaller", 0) = 3 [pid 5248] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7feee4c00000 [pid 5247] 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 5248] 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 5243] 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 5245] 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 5246] 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 5247] <... write resumed>) = 16777216 [pid 5247] munmap(0x7feee4c00000, 138412032) = 0 [pid 5247] openat(AT_FDCWD, "/dev/loop4", O_RDWR) = 4 [pid 5247] ioctl(4, LOOP_SET_FD, 3) = 0 [pid 5247] close(3) = 0 [pid 5247] close(4) = 0 [pid 5247] mkdir("./file1", 0777) = 0 [ 180.011654][ T5247] loop4: detected capacity change from 0 to 32768 [pid 5247] mount("/dev/loop4", "./file1", "bcachefs", MS_I_VERSION, "data_checksum=xxhash,direct_io,norecovery,fsck,journal_flush_disabled,norecovery,btree_node_imizatio"... [pid 5248] <... write resumed>) = 16777216 [pid 5248] munmap(0x7feee4c00000, 138412032) = 0 [pid 5248] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = 4 [pid 5248] ioctl(4, LOOP_SET_FD, 3 [pid 5243] <... write resumed>) = 16777216 [pid 5248] <... ioctl resumed>) = 0 [pid 5246] <... write resumed>) = 16777216 [pid 5245] <... write resumed>) = 16777216 [pid 5243] munmap(0x7feee4c00000, 138412032 [pid 5248] close(3 [pid 5246] munmap(0x7feee4c00000, 138412032 [pid 5248] <... close resumed>) = 0 [pid 5248] close(4 [pid 5243] <... munmap resumed>) = 0 [pid 5248] <... close resumed>) = 0 [pid 5248] mkdir("./file1", 0777) = 0 [pid 5248] mount("/dev/loop3", "./file1", "bcachefs", MS_I_VERSION, "data_checksum=xxhash,direct_io,norecovery,fsck,journal_flush_disabled,norecovery,btree_node_imizatio"... [pid 5246] <... munmap resumed>) = 0 [pid 5245] munmap(0x7feee4c00000, 138412032 [pid 5243] openat(AT_FDCWD, "/dev/loop0", O_RDWR [pid 5246] openat(AT_FDCWD, "/dev/loop1", O_RDWR [pid 5243] <... openat resumed>) = 4 [pid 5246] <... openat resumed>) = 4 [pid 5245] <... munmap resumed>) = 0 [pid 5243] ioctl(4, LOOP_SET_FD, 3 [pid 5246] ioctl(4, LOOP_SET_FD, 3 [pid 5245] openat(AT_FDCWD, "/dev/loop2", O_RDWR) = 4 [ 180.120322][ T5248] loop3: detected capacity change from 0 to 32768 [pid 5245] ioctl(4, LOOP_SET_FD, 3 [pid 5243] <... ioctl resumed>) = 0 [pid 5243] close(3) = 0 [pid 5243] close(4) = 0 [pid 5246] <... ioctl resumed>) = 0 [pid 5245] <... ioctl resumed>) = 0 [pid 5243] mkdir("./file1", 0777 [pid 5246] close(3 [pid 5245] close(3 [pid 5246] <... close resumed>) = 0 [pid 5245] <... close resumed>) = 0 [pid 5246] close(4 [pid 5245] close(4 [pid 5243] <... mkdir resumed>) = 0 [ 180.170233][ T5243] loop0: detected capacity change from 0 to 32768 [ 180.179564][ T5246] loop1: detected capacity change from 0 to 32768 [ 180.186602][ T5245] loop2: detected capacity change from 0 to 32768 [pid 5243] mount("/dev/loop0", "./file1", "bcachefs", MS_I_VERSION, "data_checksum=xxhash,direct_io,norecovery,fsck,journal_flush_disabled,norecovery,btree_node_imizatio"... [pid 5246] <... close resumed>) = 0 [pid 5245] <... close resumed>) = 0 [pid 5246] mkdir("./file1", 0777 [pid 5245] mkdir("./file1", 0777) = 0 [pid 5246] <... mkdir resumed>) = 0 [pid 5246] mount("/dev/loop1", "./file1", "bcachefs", MS_I_VERSION, "data_checksum=xxhash,direct_io,norecovery,fsck,journal_flush_disabled,norecovery,btree_node_imizatio"... [ 180.221810][ T5247] bcachefs (loop4): starting version 1.7: mi_btree_bitmap opts=metadata_checksum=none,data_checksum=xxhash,compression=lz4,journal_flush_disabled,fsck,norecovery,nojournal_transaction_names,reconstruct_alloc [ 180.269413][ T5247] bcachefs (loop4): recovering from clean shutdown, journal seq 10 [ 180.285656][ T5248] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 180.297117][ T5247] bcachefs (loop4): Version upgrade required: [ 180.297117][ T5247] Version upgrade from 0.24: unwritten_extents to 1.7: mi_btree_bitmap incomplete [ 180.297117][ T5247] Doing incompatible version upgrade from 0.24: unwritten_extents to 1.13: inode_has_child_snapshots [ 180.297117][ T5247] running recovery passes: check_allocations,check_alloc_info,check_lrus,check_btree_backpointers,check_backpointers_to_extents,check_extents_to_backpointers,check_alloc_to_lru_refs,bucket_gens_init,check_snapshot_trees,check_snapshots,check_subvols,check_subvol_children,delete_dead_snapshots,check_inodes,check_extents,check_indirect_extents,check_dirents,check_xattrs,check_root,check_unreachable_inodes,check_subvolume_structure,check_directory_structure,check_nlinks,set_fs_needs_rebalance [ 180.305965][ T5248] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 180.372122][ T5247] bcachefs (loop4): dropping and reconstructing all alloc info [ 180.396457][ T5247] bcachefs (loop4): check_topology... done [ 180.402502][ T5247] bcachefs (loop4): accounting_read... done [ 180.409737][ T5247] bcachefs (loop4): alloc_read... done [ 180.415255][ T5247] bcachefs (loop4): stripes_read... done [ 180.421098][ T5247] bcachefs (loop4): snapshots_read... done [ 180.427247][ T5247] bcachefs (loop4): check_allocations... done [ 180.453605][ T5246] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 180.460329][ T5247] bcachefs (loop4): going read-write [ 180.477282][ T5246] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 180.499575][ T5247] bcachefs (loop4): done starting filesystem [ 180.506411][ T5243] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 180.521903][ T5248] bcachefs: bch2_fs_get_tree() error: EINVAL [pid 5245] mount("/dev/loop2", "./file1", "bcachefs", MS_I_VERSION, "data_checksum=xxhash,direct_io,norecovery,fsck,journal_flush_disabled,norecovery,btree_node_imizatio"... [pid 5248] <... mount resumed>) = -1 EINVAL (Invalid argument) [pid 5248] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = 3 [pid 5248] ioctl(3, LOOP_CLR_FD) = 0 [pid 5248] close(3 [pid 5247] <... mount resumed>) = 0 [pid 5247] openat(AT_FDCWD, "./file1", O_RDONLY|O_DIRECTORY) = 3 [pid 5247] chdir("./file1") = 0 [pid 5247] openat(AT_FDCWD, "/dev/loop4", O_RDWR) = 4 [pid 5247] ioctl(4, LOOP_CLR_FD) = 0 [pid 5247] close(4) = 0 [ 180.533905][ T5243] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 180.545663][ T5245] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 180.557078][ T5245] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [pid 5247] openat(AT_FDCWD, "cpuset.effective_cpus", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000) = 4 [pid 5247] exit_group(0) = ? [pid 5247] +++ exited with 0 +++ [pid 5242] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5247, si_uid=0, si_status=0, si_utime=8 /* 0.08 s */, si_stime=35 /* 0.35 s */} --- [pid 5242] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5242] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 5242] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5242] getdents64(3, 0x55557e1f86f0 /* 4 entries */, 32768) = 112 [pid 5242] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5242] newfstatat(AT_FDCWD, "./0/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5242] unlink("./0/binderfs") = 0 [pid 5242] umount2("./0/file1", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5245] <... mount resumed>) = -1 EINVAL (Invalid argument) [pid 5246] <... mount resumed>) = -1 EINVAL (Invalid argument) [ 180.676724][ T5242] bcachefs (loop4): shutting down [ 180.694184][ T5242] bcachefs (loop4): going read-only [ 180.701123][ T5245] bcachefs: bch2_fs_get_tree() error: EINVAL [ 180.709363][ T5242] bcachefs (loop4): finished waiting for writes to stop [ 180.717851][ T5246] bcachefs: bch2_fs_get_tree() error: EINVAL [pid 5245] openat(AT_FDCWD, "/dev/loop2", O_RDWR) = 3 [pid 5246] openat(AT_FDCWD, "/dev/loop1", O_RDWR [pid 5245] ioctl(3, LOOP_CLR_FD) = 0 [pid 5246] <... openat resumed>) = 3 [pid 5245] close(3 [pid 5246] ioctl(3, LOOP_CLR_FD) = 0 [pid 5246] close(3 [pid 5243] <... mount resumed>) = -1 EINVAL (Invalid argument) [ 180.733821][ T5243] bcachefs: bch2_fs_get_tree() error: EINVAL [pid 5243] openat(AT_FDCWD, "/dev/loop0", O_RDWR) = 3 [pid 5243] ioctl(3, LOOP_CLR_FD) = 0 [ 180.779201][ T5242] bcachefs (loop4): flushing journal and stopping allocators, journal seq 11 [pid 5243] close(3 [pid 5248] <... close resumed>) = 0 [pid 5248] openat(AT_FDCWD, "cpuset.effective_cpus", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000) = 3 [pid 5248] exit_group(0) = ? [pid 5248] +++ exited with 0 +++ [pid 5241] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5248, si_uid=0, si_status=0, si_utime=8 /* 0.08 s */, si_stime=33 /* 0.33 s */} --- [pid 5241] restart_syscall(<... resuming interrupted clone ...>) = 0 [pid 5241] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5241] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 5241] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5241] getdents64(3, 0x55557e1f86f0 /* 5 entries */, 32768) = 160 [pid 5241] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5241] newfstatat(AT_FDCWD, "./0/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5241] unlink("./0/binderfs") = 0 [pid 5241] umount2("./0/file1", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5241] newfstatat(AT_FDCWD, "./0/file1", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5241] umount2("./0/file1", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5241] openat(AT_FDCWD, "./0/file1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4 [pid 5243] <... close resumed>) = 0 [pid 5241] newfstatat(4, "", [pid 5243] openat(AT_FDCWD, "cpuset.effective_cpus", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000 [pid 5241] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5243] <... openat resumed>) = 3 [pid 5241] getdents64(4, 0x55557e200730 /* 2 entries */, 32768) = 48 [pid 5241] getdents64(4, 0x55557e200730 /* 0 entries */, 32768) = 0 [pid 5241] close(4) = 0 [pid 5241] rmdir("./0/file1" [pid 5243] exit_group(0) = ? [pid 5243] +++ exited with 0 +++ [pid 5238] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5243, si_uid=0, si_status=0, si_utime=8 /* 0.08 s */, si_stime=36 /* 0.36 s */} --- [pid 5238] restart_syscall(<... resuming interrupted clone ...> [pid 5241] <... rmdir resumed>) = 0 [pid 5238] <... restart_syscall resumed>) = 0 [pid 5238] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5238] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5241] umount2("./0/cpuset.effective_cpus", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5238] <... openat resumed>) = 3 [pid 5238] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5241] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5241] newfstatat(AT_FDCWD, "./0/cpuset.effective_cpus", {st_mode=S_IFREG|000, st_size=0, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5241] unlink("./0/cpuset.effective_cpus") = 0 [pid 5238] getdents64(3, [pid 5241] getdents64(3, 0x55557e1f86f0 /* 0 entries */, 32768) = 0 [pid 5238] <... getdents64 resumed>0x55557e1f86f0 /* 5 entries */, 32768) = 160 [pid 5241] close(3 [pid 5238] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5241] <... close resumed>) = 0 [pid 5238] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5241] rmdir("./0" [pid 5238] newfstatat(AT_FDCWD, "./0/binderfs", [pid 5241] <... rmdir resumed>) = 0 [pid 5238] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5241] mkdir("./1", 0777 [pid 5238] unlink("./0/binderfs") = 0 [pid 5241] <... mkdir resumed>) = 0 [pid 5238] umount2("./0/file1", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5241] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = 3 [pid 5241] ioctl(3, LOOP_CLR_FD) = -1 ENXIO (No such device or address) [pid 5241] close(3 [pid 5238] newfstatat(AT_FDCWD, "./0/file1", [pid 5241] <... close resumed>) = 0 [pid 5238] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [ 180.961934][ T1095] bcachefs (loop4): bch2_write_super(): fatal error loop4: Superblock write was silently dropped! (seq 0 expected 53) [pid 5241] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5238] umount2("./0/file1", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5241] <... clone resumed>, child_tidptr=0x55557e1f7650) = 5289 ./strace-static-x86_64: Process 5289 attached [pid 5289] set_robust_list(0x55557e1f7660, 24) = 0 [pid 5289] chdir("./1") = 0 [pid 5289] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5289] setpgid(0, 0) = 0 [pid 5289] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5245] <... close resumed>) = 0 [pid 5238] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5289] <... openat resumed>) = 3 [pid 5289] write(3, "1000", 4 [pid 5238] openat(AT_FDCWD, "./0/file1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5245] openat(AT_FDCWD, "cpuset.effective_cpus", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000 [pid 5238] <... openat resumed>) = 4 [pid 5289] <... write resumed>) = 4 [pid 5289] close(3) = 0 [pid 5245] <... openat resumed>) = 3 [pid 5238] newfstatat(4, "", [pid 5289] symlink("/dev/binderfs", "./binderfs" [pid 5238] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 executing program [pid 5289] <... symlink resumed>) = 0 [pid 5245] exit_group(0 [pid 5238] getdents64(4, [pid 5289] write(1, "executing program\n", 18) = 18 [pid 5238] <... getdents64 resumed>0x55557e200730 /* 2 entries */, 32768) = 48 [pid 5245] <... exit_group resumed>) = ? [pid 5289] memfd_create("syzkaller", 0 [pid 5238] getdents64(4, 0x55557e200730 /* 0 entries */, 32768) = 0 [pid 5238] close(4 [pid 5289] <... memfd_create resumed>) = 3 [pid 5289] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7feee4c00000 [pid 5246] <... close resumed>) = 0 [pid 5238] <... close resumed>) = 0 [pid 5238] rmdir("./0/file1" [pid 5246] openat(AT_FDCWD, "cpuset.effective_cpus", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000 [pid 5245] +++ exited with 0 +++ [pid 5238] <... rmdir resumed>) = 0 [pid 5240] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5245, si_uid=0, si_status=0, si_utime=7 /* 0.07 s */, si_stime=39 /* 0.39 s */} --- [ 181.015655][ T1095] bcachefs (loop4): fatal error - emergency read only [ 181.032406][ T5242] bcachefs (loop4): flushing journal and stopping allocators complete, journal seq 12 [pid 5238] umount2("./0/cpuset.effective_cpus", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5240] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5238] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5240] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5238] newfstatat(AT_FDCWD, "./0/cpuset.effective_cpus", {st_mode=S_IFREG|000, st_size=0, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5240] <... openat resumed>) = 3 [pid 5238] unlink("./0/cpuset.effective_cpus") = 0 [pid 5240] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5238] getdents64(3, [pid 5246] <... openat resumed>) = 3 [pid 5240] getdents64(3, [pid 5238] <... getdents64 resumed>0x55557e1f86f0 /* 0 entries */, 32768) = 0 [pid 5246] exit_group(0 [pid 5238] close(3 [pid 5246] <... exit_group resumed>) = ? [pid 5240] <... getdents64 resumed>0x55557e1f86f0 /* 5 entries */, 32768) = 160 [pid 5238] <... close resumed>) = 0 [pid 5246] +++ exited with 0 +++ [pid 5240] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5238] rmdir("./0" [pid 5239] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5246, si_uid=0, si_status=0, si_utime=5 /* 0.05 s */, si_stime=42 /* 0.42 s */} --- [pid 5238] <... rmdir resumed>) = 0 [pid 5240] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5239] restart_syscall(<... resuming interrupted clone ...> [pid 5240] newfstatat(AT_FDCWD, "./0/binderfs", [pid 5238] mkdir("./1", 0777 [pid 5239] <... restart_syscall resumed>) = 0 [pid 5240] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5238] <... mkdir resumed>) = 0 [pid 5240] unlink("./0/binderfs" [pid 5238] openat(AT_FDCWD, "/dev/loop0", O_RDWR [pid 5239] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5239] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5238] <... openat resumed>) = 3 [pid 5240] <... unlink resumed>) = 0 [pid 5238] ioctl(3, LOOP_CLR_FD [pid 5239] <... openat resumed>) = 3 [pid 5238] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5238] close(3 [ 181.061459][ T5242] bcachefs (loop4): unshutdown complete, journal seq 12 [pid 5239] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5238] <... close resumed>) = 0 [pid 5239] getdents64(3, [pid 5240] umount2("./0/file1", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5239] <... getdents64 resumed>0x55557e1f86f0 /* 5 entries */, 32768) = 160 [pid 5238] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5239] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW./strace-static-x86_64: Process 5290 attached [pid 5240] newfstatat(AT_FDCWD, "./0/file1", [pid 5239] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5290] set_robust_list(0x55557e1f7660, 24 [pid 5240] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5239] newfstatat(AT_FDCWD, "./0/binderfs", [pid 5238] <... clone resumed>, child_tidptr=0x55557e1f7650) = 5290 [pid 5239] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5240] umount2("./0/file1", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5290] <... set_robust_list resumed>) = 0 [pid 5239] unlink("./0/binderfs" [pid 5290] chdir("./1" [pid 5239] <... unlink resumed>) = 0 [pid 5239] umount2("./0/file1", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5290] <... chdir resumed>) = 0 [pid 5239] newfstatat(AT_FDCWD, "./0/file1", [pid 5290] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5240] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5290] <... prctl resumed>) = 0 [pid 5239] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5240] openat(AT_FDCWD, "./0/file1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5290] setpgid(0, 0 [pid 5240] <... openat resumed>) = 4 [pid 5239] umount2("./0/file1", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5290] <... setpgid resumed>) = 0 [pid 5240] newfstatat(4, "", [pid 5239] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5240] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5239] openat(AT_FDCWD, "./0/file1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4 [pid 5240] getdents64(4, [pid 5290] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5240] <... getdents64 resumed>0x55557e200730 /* 2 entries */, 32768) = 48 [pid 5239] newfstatat(4, "", [pid 5290] <... openat resumed>) = 3 [pid 5240] getdents64(4, [pid 5290] write(3, "1000", 4 [pid 5239] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5240] <... getdents64 resumed>0x55557e200730 /* 0 entries */, 32768) = 0 [pid 5290] <... write resumed>) = 4 [pid 5239] getdents64(4, [pid 5290] close(3 [ 181.103758][ T5242] bcachefs (loop4): done going read-only, filesystem not clean [pid 5240] close(4 [pid 5239] <... getdents64 resumed>0x55557e200730 /* 2 entries */, 32768) = 48 [pid 5290] <... close resumed>) = 0 [pid 5240] <... close resumed>) = 0 [pid 5240] rmdir("./0/file1" [pid 5290] symlink("/dev/binderfs", "./binderfs" [pid 5239] getdents64(4, [pid 5290] <... symlink resumed>) = 0 executing program [pid 5240] <... rmdir resumed>) = 0 [pid 5239] <... getdents64 resumed>0x55557e200730 /* 0 entries */, 32768) = 0 [pid 5290] write(1, "executing program\n", 18 [pid 5239] close(4 [pid 5290] <... write resumed>) = 18 [pid 5239] <... close resumed>) = 0 [pid 5290] memfd_create("syzkaller", 0 [pid 5239] rmdir("./0/file1") = 0 [pid 5239] umount2("./0/cpuset.effective_cpus", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5290] <... memfd_create resumed>) = 3 [pid 5240] umount2("./0/cpuset.effective_cpus", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5239] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5290] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5240] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5239] newfstatat(AT_FDCWD, "./0/cpuset.effective_cpus", [pid 5290] <... mmap resumed>) = 0x7feee4c00000 [pid 5240] newfstatat(AT_FDCWD, "./0/cpuset.effective_cpus", [pid 5239] <... newfstatat resumed>{st_mode=S_IFREG|000, st_size=0, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5240] <... newfstatat resumed>{st_mode=S_IFREG|000, st_size=0, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5239] unlink("./0/cpuset.effective_cpus") = 0 [pid 5240] unlink("./0/cpuset.effective_cpus") = 0 [pid 5239] getdents64(3, 0x55557e1f86f0 /* 0 entries */, 32768) = 0 [pid 5239] close(3 [pid 5240] getdents64(3, 0x55557e1f86f0 /* 0 entries */, 32768) = 0 [pid 5239] <... close resumed>) = 0 [pid 5240] close(3 [pid 5239] rmdir("./0") = 0 [pid 5240] <... close resumed>) = 0 [pid 5240] rmdir("./0") = 0 [pid 5239] mkdir("./1", 0777 [pid 5240] mkdir("./1", 0777 [pid 5239] <... mkdir resumed>) = 0 [pid 5240] <... mkdir resumed>) = 0 [pid 5240] openat(AT_FDCWD, "/dev/loop2", O_RDWR [pid 5239] openat(AT_FDCWD, "/dev/loop1", O_RDWR [pid 5240] <... openat resumed>) = 3 [pid 5239] <... openat resumed>) = 3 [pid 5240] ioctl(3, LOOP_CLR_FD [pid 5239] ioctl(3, LOOP_CLR_FD) = -1 ENXIO (No such device or address) [pid 5240] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5239] close(3 [pid 5240] close(3 [pid 5239] <... close resumed>) = 0 [pid 5240] <... close resumed>) = 0 [pid 5239] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x55557e1f7650) = 5291 [pid 5240] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5291 attached , child_tidptr=0x55557e1f7650) = 5292 [pid 5291] set_robust_list(0x55557e1f7660, 24./strace-static-x86_64: Process 5292 attached [pid 5292] set_robust_list(0x55557e1f7660, 24 [pid 5291] <... set_robust_list resumed>) = 0 [pid 5292] <... set_robust_list resumed>) = 0 [pid 5291] chdir("./1" [pid 5292] chdir("./1" [pid 5291] <... chdir resumed>) = 0 [pid 5292] <... chdir resumed>) = 0 [pid 5291] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5292] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5291] <... prctl resumed>) = 0 [pid 5292] <... prctl resumed>) = 0 [pid 5291] setpgid(0, 0 [pid 5292] setpgid(0, 0 [pid 5291] <... setpgid resumed>) = 0 [pid 5292] <... setpgid resumed>) = 0 [pid 5291] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5292] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5291] <... openat resumed>) = 3 [pid 5292] <... openat resumed>) = 3 [pid 5291] write(3, "1000", 4 [pid 5292] write(3, "1000", 4) = 4 [pid 5291] <... write resumed>) = 4 [ 181.159212][ T5242] bcachefs (loop4): shutdown complete [pid 5292] close(3) = 0 [pid 5291] close(3) = 0 [pid 5292] symlink("/dev/binderfs", "./binderfs" [pid 5291] symlink("/dev/binderfs", "./binderfs" [pid 5292] <... symlink resumed>) = 0 [pid 5291] <... symlink resumed>) = 0 executing program [pid 5291] write(1, "executing program\n", 18) = 18 [pid 5292] write(1, "executing program\n", 18executing program ) = 18 [pid 5291] memfd_create("syzkaller", 0 [pid 5292] memfd_create("syzkaller", 0) = 3 [pid 5292] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5291] <... memfd_create resumed>) = 3 [pid 5292] <... mmap resumed>) = 0x7feee4c00000 [pid 5291] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7feee4c00000 [pid 5289] 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 5290] 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 5291] 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 5292] 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 5289] <... write resumed>) = 16777216 [pid 5289] munmap(0x7feee4c00000, 138412032) = 0 [pid 5289] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = 4 [pid 5289] ioctl(4, LOOP_SET_FD, 3) = 0 [pid 5289] close(3) = 0 [pid 5289] close(4) = 0 [pid 5289] mkdir("./file1", 0777) = 0 [ 181.629334][ T5289] loop3: detected capacity change from 0 to 32768 [pid 5289] mount("/dev/loop3", "./file1", "bcachefs", MS_I_VERSION, "data_checksum=xxhash,direct_io,norecovery,fsck,journal_flush_disabled,norecovery,btree_node_imizatio"... [pid 5290] <... write resumed>) = 16777216 [pid 5291] <... write resumed>) = 16777216 [pid 5291] munmap(0x7feee4c00000, 138412032 [pid 5290] munmap(0x7feee4c00000, 138412032 [pid 5291] <... munmap resumed>) = 0 [pid 5290] <... munmap resumed>) = 0 [pid 5291] openat(AT_FDCWD, "/dev/loop1", O_RDWR [pid 5290] openat(AT_FDCWD, "/dev/loop0", O_RDWR [pid 5291] <... openat resumed>) = 4 [pid 5290] <... openat resumed>) = 4 [pid 5291] ioctl(4, LOOP_SET_FD, 3 [pid 5290] ioctl(4, LOOP_SET_FD, 3) = 0 [pid 5290] close(3 [pid 5292] <... write resumed>) = 16777216 [pid 5291] <... ioctl resumed>) = 0 [pid 5290] <... close resumed>) = 0 [pid 5292] munmap(0x7feee4c00000, 138412032 [pid 5291] close(3 [pid 5290] close(4 [pid 5292] <... munmap resumed>) = 0 [pid 5291] <... close resumed>) = 0 [pid 5290] <... close resumed>) = 0 [pid 5292] openat(AT_FDCWD, "/dev/loop2", O_RDWR [pid 5291] close(4 [pid 5290] mkdir("./file1", 0777 [pid 5292] <... openat resumed>) = 4 [ 181.814868][ T5291] loop1: detected capacity change from 0 to 32768 [ 181.822182][ T5290] loop0: detected capacity change from 0 to 32768 [pid 5292] ioctl(4, LOOP_SET_FD, 3 [pid 5291] <... close resumed>) = 0 [pid 5290] <... mkdir resumed>) = 0 [pid 5292] <... ioctl resumed>) = 0 [pid 5291] mkdir("./file1", 0777) = 0 [pid 5292] close(3 [pid 5290] mount("/dev/loop0", "./file1", "bcachefs", MS_I_VERSION, "data_checksum=xxhash,direct_io,norecovery,fsck,journal_flush_disabled,norecovery,btree_node_imizatio"... [pid 5292] <... close resumed>) = 0 [pid 5292] close(4) = 0 [pid 5291] mount("/dev/loop1", "./file1", "bcachefs", MS_I_VERSION, "data_checksum=xxhash,direct_io,norecovery,fsck,journal_flush_disabled,norecovery,btree_node_imizatio"... [pid 5292] mkdir("./file1", 0777) = 0 [ 181.873141][ T5292] loop2: detected capacity change from 0 to 32768 [ 181.996041][ T5289] bcachefs (loop3): starting version 1.7: mi_btree_bitmap opts=metadata_checksum=none,data_checksum=xxhash,compression=lz4,journal_flush_disabled,fsck,norecovery,nojournal_transaction_names,reconstruct_alloc [ 182.016381][ T5289] bcachefs (loop3): recovering from clean shutdown, journal seq 10 [ 182.024527][ T5289] bcachefs (loop3): Version upgrade required: [ 182.024527][ T5289] Version upgrade from 0.24: unwritten_extents to 1.7: mi_btree_bitmap incomplete [ 182.024527][ T5289] Doing incompatible version upgrade from 0.24: unwritten_extents to 1.13: inode_has_child_snapshots [ 182.024527][ T5289] running recovery passes: check_allocations,check_alloc_info,check_lrus,check_btree_backpointers,check_backpointers_to_extents,check_extents_to_backpointers,check_alloc_to_lru_refs,bucket_gens_init,check_snapshot_trees,check_snapshots,check_subvols,check_subvol_children,delete_dead_snapshots,check_inodes,check_extents,check_indirect_extents,check_dirents,check_xattrs,check_root,check_unreachable_inodes,check_subvolume_structure,check_directory_structure,check_nlinks,set_fs_needs_rebalance [ 182.085008][ T5291] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 182.105222][ T5290] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 182.116945][ T5290] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 182.121554][ T5292] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 182.134773][ T5291] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 182.147778][ T5292] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 182.161278][ T5289] bcachefs (loop3): dropping and reconstructing all alloc info [pid 5292] mount("/dev/loop2", "./file1", "bcachefs", MS_I_VERSION, "data_checksum=xxhash,direct_io,norecovery,fsck,journal_flush_disabled,norecovery,btree_node_imizatio"... [pid 5291] <... mount resumed>) = -1 EINVAL (Invalid argument) [ 182.254319][ T5289] bcachefs (loop3): check_topology... done [ 182.268796][ T5291] bcachefs: bch2_fs_get_tree() error: EINVAL [ 182.279075][ T5289] bcachefs (loop3): accounting_read... done [ 182.296128][ T5289] bcachefs (loop3): alloc_read... done [pid 5291] openat(AT_FDCWD, "/dev/loop1", O_RDWR) = 3 [pid 5290] <... mount resumed>) = -1 EINVAL (Invalid argument) [pid 5291] ioctl(3, LOOP_CLR_FD) = 0 [pid 5290] openat(AT_FDCWD, "/dev/loop0", O_RDWR [pid 5291] close(3 [pid 5290] <... openat resumed>) = 3 [pid 5290] ioctl(3, LOOP_CLR_FD) = 0 [ 182.302469][ T5289] bcachefs (loop3): stripes_read... done [ 182.309968][ T5290] bcachefs: bch2_fs_get_tree() error: EINVAL [ 182.323669][ T5289] bcachefs (loop3): snapshots_read... done [pid 5290] close(3 [pid 5292] <... mount resumed>) = -1 EINVAL (Invalid argument) [ 182.336621][ T5289] bcachefs (loop3): check_allocations... [ 182.360328][ T5292] bcachefs: bch2_fs_get_tree() error: EINVAL [pid 5292] openat(AT_FDCWD, "/dev/loop2", O_RDWR) = 3 [pid 5292] ioctl(3, LOOP_CLR_FD) = 0 [ 182.492589][ T5289] done [ 182.519753][ T5289] bcachefs (loop3): going read-write [pid 5292] close(3 [pid 5242] <... umount2 resumed>) = 0 [pid 5291] <... close resumed>) = 0 [pid 5289] <... mount resumed>) = 0 [pid 5289] openat(AT_FDCWD, "./file1", O_RDONLY|O_DIRECTORY [pid 5242] umount2("./0/file1", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5289] <... openat resumed>) = 3 [pid 5242] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5242] newfstatat(AT_FDCWD, "./0/file1", [pid 5289] chdir("./file1") = 0 [pid 5242] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5291] openat(AT_FDCWD, "cpuset.effective_cpus", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000 [pid 5289] openat(AT_FDCWD, "/dev/loop3", O_RDWR [pid 5242] umount2("./0/file1", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5291] <... openat resumed>) = 3 [pid 5289] <... openat resumed>) = 4 [pid 5242] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5289] ioctl(4, LOOP_CLR_FD [pid 5242] openat(AT_FDCWD, "./0/file1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5289] <... ioctl resumed>) = 0 [pid 5242] <... openat resumed>) = 4 [pid 5289] close(4 [pid 5242] newfstatat(4, "", [pid 5289] <... close resumed>) = 0 [pid 5242] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5242] getdents64(4, [pid 5291] exit_group(0 [pid 5242] <... getdents64 resumed>0x55557e200730 /* 2 entries */, 32768) = 48 [pid 5291] <... exit_group resumed>) = ? [pid 5242] getdents64(4, [pid 5291] +++ exited with 0 +++ [pid 5242] <... getdents64 resumed>0x55557e200730 /* 0 entries */, 32768) = 0 [pid 5242] close(4 [pid 5239] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5291, si_uid=0, si_status=0, si_utime=10 /* 0.10 s */, si_stime=43 /* 0.43 s */} --- [pid 5242] <... close resumed>) = 0 [pid 5239] restart_syscall(<... resuming interrupted clone ...> [pid 5242] rmdir("./0/file1" [pid 5289] openat(AT_FDCWD, "cpuset.effective_cpus", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000 [pid 5242] <... rmdir resumed>) = 0 [pid 5242] getdents64(3, 0x55557e1f86f0 /* 0 entries */, 32768) = 0 [pid 5239] <... restart_syscall resumed>) = 0 [pid 5242] close(3) = 0 [pid 5242] rmdir("./0" [pid 5239] umount2("./1", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5242] <... rmdir resumed>) = 0 [pid 5239] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5239] openat(AT_FDCWD, "./1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 5239] newfstatat(3, "", [pid 5289] <... openat resumed>) = 4 [pid 5242] mkdir("./1", 0777 [pid 5239] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5242] <... mkdir resumed>) = 0 [pid 5239] getdents64(3, 0x55557e1f86f0 /* 5 entries */, 32768) = 160 [pid 5239] umount2("./1/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5239] newfstatat(AT_FDCWD, "./1/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5239] unlink("./1/binderfs") = 0 [pid 5239] umount2("./1/file1", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5239] newfstatat(AT_FDCWD, "./1/file1", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5239] umount2("./1/file1", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5239] openat(AT_FDCWD, "./1/file1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4 [pid 5239] newfstatat(4, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5239] getdents64(4, 0x55557e200730 /* 2 entries */, 32768) = 48 [pid 5242] openat(AT_FDCWD, "/dev/loop4", O_RDWR [pid 5239] getdents64(4, [pid 5242] <... openat resumed>) = 3 [pid 5239] <... getdents64 resumed>0x55557e200730 /* 0 entries */, 32768) = 0 [pid 5239] close(4 [pid 5242] ioctl(3, LOOP_CLR_FD [pid 5239] <... close resumed>) = 0 [pid 5242] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5239] rmdir("./1/file1" [pid 5289] exit_group(0 [pid 5242] close(3 [pid 5239] <... rmdir resumed>) = 0 [pid 5239] umount2("./1/cpuset.effective_cpus", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5239] newfstatat(AT_FDCWD, "./1/cpuset.effective_cpus", [pid 5242] <... close resumed>) = 0 [pid 5239] <... newfstatat resumed>{st_mode=S_IFREG|000, st_size=0, ...}, AT_SYMLINK_NOFOLLOW) = 0 [ 182.559102][ T5289] bcachefs (loop3): done starting filesystem [pid 5242] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5239] unlink("./1/cpuset.effective_cpus" [pid 5290] <... close resumed>) = 0 [pid 5289] <... exit_group resumed>) = ? [pid 5239] <... unlink resumed>) = 0 [pid 5242] <... clone resumed>, child_tidptr=0x55557e1f7650) = 5324 [pid 5239] getdents64(3, 0x55557e1f86f0 /* 0 entries */, 32768) = 0 [pid 5239] close(3) = 0 [pid 5239] rmdir("./1" [pid 5289] +++ exited with 0 +++ [pid 5241] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5289, si_uid=0, si_status=0, si_utime=6 /* 0.06 s */, si_stime=34 /* 0.34 s */} --- [pid 5241] restart_syscall(<... resuming interrupted clone ...>./strace-static-x86_64: Process 5324 attached [pid 5239] <... rmdir resumed>) = 0 [pid 5239] mkdir("./2", 0777) = 0 [pid 5239] openat(AT_FDCWD, "/dev/loop1", O_RDWR) = 3 [pid 5324] set_robust_list(0x55557e1f7660, 24 [pid 5239] ioctl(3, LOOP_CLR_FD [pid 5324] <... set_robust_list resumed>) = 0 [pid 5239] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5324] chdir("./1" [pid 5239] close(3) = 0 [pid 5239] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5325 attached [pid 5324] <... chdir resumed>) = 0 [pid 5324] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5324] setpgid(0, 0) = 0 [pid 5324] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5325] set_robust_list(0x55557e1f7660, 24 [pid 5324] <... openat resumed>) = 3 [pid 5325] <... set_robust_list resumed>) = 0 [pid 5324] write(3, "1000", 4 [pid 5239] <... clone resumed>, child_tidptr=0x55557e1f7650) = 5325 [pid 5325] chdir("./2" [pid 5324] <... write resumed>) = 4 [pid 5290] openat(AT_FDCWD, "cpuset.effective_cpus", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000 [pid 5241] <... restart_syscall resumed>) = 0 [pid 5241] umount2("./1", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5241] openat(AT_FDCWD, "./1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 5241] newfstatat(3, "", [pid 5324] close(3 [pid 5290] <... openat resumed>) = 3 [pid 5241] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5325] <... chdir resumed>) = 0 [pid 5241] getdents64(3, 0x55557e1f86f0 /* 4 entries */, 32768) = 112 [pid 5241] umount2("./1/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5325] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5241] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5241] newfstatat(AT_FDCWD, "./1/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5241] unlink("./1/binderfs") = 0 [pid 5325] <... prctl resumed>) = 0 [pid 5325] setpgid(0, 0 [pid 5241] umount2("./1/file1", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5325] <... setpgid resumed>) = 0 [pid 5324] <... close resumed>) = 0 [pid 5324] symlink("/dev/binderfs", "./binderfs" [pid 5325] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5324] <... symlink resumed>) = 0 [pid 5290] exit_group(0 [pid 5324] write(1, "executing program\n", 18 [pid 5290] <... exit_group resumed>) = ? executing program [pid 5325] <... openat resumed>) = 3 [pid 5324] <... write resumed>) = 18 [pid 5290] +++ exited with 0 +++ [pid 5324] memfd_create("syzkaller", 0 [pid 5238] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5290, si_uid=0, si_status=0, si_utime=9 /* 0.09 s */, si_stime=36 /* 0.36 s */} --- [pid 5238] restart_syscall(<... resuming interrupted clone ...> [pid 5324] <... memfd_create resumed>) = 3 [pid 5324] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7feee4c00000 [pid 5325] write(3, "1000", 4 [pid 5238] <... restart_syscall resumed>) = 0 [pid 5325] <... write resumed>) = 4 [pid 5325] close(3) = 0 [pid 5325] symlink("/dev/binderfs", "./binderfs" [pid 5238] umount2("./1", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5325] <... symlink resumed>) = 0 [pid 5238] <... umount2 resumed>) = -1 EINVAL (Invalid argument) executing program [pid 5325] write(1, "executing program\n", 18 [pid 5238] openat(AT_FDCWD, "./1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5325] <... write resumed>) = 18 [pid 5238] <... openat resumed>) = 3 [pid 5238] newfstatat(3, "", [pid 5325] memfd_create("syzkaller", 0 [pid 5238] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5325] <... memfd_create resumed>) = 3 [pid 5325] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5238] getdents64(3, [pid 5325] <... mmap resumed>) = 0x7feee4c00000 [pid 5238] <... getdents64 resumed>0x55557e1f86f0 /* 5 entries */, 32768) = 160 [pid 5238] umount2("./1/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5238] newfstatat(AT_FDCWD, "./1/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5238] unlink("./1/binderfs") = 0 [pid 5238] umount2("./1/file1", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5238] newfstatat(AT_FDCWD, "./1/file1", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5238] umount2("./1/file1", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5238] openat(AT_FDCWD, "./1/file1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4 [pid 5238] newfstatat(4, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5238] getdents64(4, 0x55557e200730 /* 2 entries */, 32768) = 48 [pid 5238] getdents64(4, 0x55557e200730 /* 0 entries */, 32768) = 0 [pid 5238] close(4) = 0 [pid 5238] rmdir("./1/file1") = 0 [pid 5238] umount2("./1/cpuset.effective_cpus", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5238] newfstatat(AT_FDCWD, "./1/cpuset.effective_cpus", {st_mode=S_IFREG|000, st_size=0, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5238] unlink("./1/cpuset.effective_cpus") = 0 [ 182.683686][ T5241] bcachefs (loop3): shutting down [pid 5292] <... close resumed>) = 0 [pid 5238] getdents64(3, 0x55557e1f86f0 /* 0 entries */, 32768) = 0 [pid 5238] close(3 [pid 5292] openat(AT_FDCWD, "cpuset.effective_cpus", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000 [pid 5238] <... close resumed>) = 0 [pid 5238] rmdir("./1" [pid 5292] <... openat resumed>) = 3 [pid 5238] <... rmdir resumed>) = 0 [pid 5292] exit_group(0) = ? [pid 5238] mkdir("./2", 0777) = 0 [pid 5238] openat(AT_FDCWD, "/dev/loop0", O_RDWR [pid 5292] +++ exited with 0 +++ [pid 5238] <... openat resumed>) = 3 [pid 5240] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5292, si_uid=0, si_status=0, si_utime=4 /* 0.04 s */, si_stime=39 /* 0.39 s */} --- [ 182.705978][ T5241] bcachefs (loop3): going read-only [pid 5238] ioctl(3, LOOP_CLR_FD) = -1 ENXIO (No such device or address) [pid 5238] close(3 [pid 5240] umount2("./1", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5238] <... close resumed>) = 0 [pid 5240] openat(AT_FDCWD, "./1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5238] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5240] <... openat resumed>) = 3 [pid 5240] newfstatat(3, "", [pid 5238] <... clone resumed>, child_tidptr=0x55557e1f7650) = 5326 [pid 5240] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 ./strace-static-x86_64: Process 5326 attached [pid 5240] getdents64(3, 0x55557e1f86f0 /* 5 entries */, 32768) = 160 [pid 5240] umount2("./1/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5240] newfstatat(AT_FDCWD, "./1/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5240] unlink("./1/binderfs") = 0 [pid 5240] umount2("./1/file1", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5240] newfstatat(AT_FDCWD, "./1/file1", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5240] umount2("./1/file1", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5240] openat(AT_FDCWD, "./1/file1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4 [pid 5240] newfstatat(4, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5240] getdents64(4, 0x55557e200730 /* 2 entries */, 32768) = 48 [pid 5240] getdents64(4, 0x55557e200730 /* 0 entries */, 32768) = 0 [pid 5240] close(4) = 0 [pid 5240] rmdir("./1/file1") = 0 [pid 5240] umount2("./1/cpuset.effective_cpus", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5240] newfstatat(AT_FDCWD, "./1/cpuset.effective_cpus", {st_mode=S_IFREG|000, st_size=0, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5240] unlink("./1/cpuset.effective_cpus") = 0 [pid 5240] getdents64(3, 0x55557e1f86f0 /* 0 entries */, 32768) = 0 [pid 5240] close(3) = 0 [pid 5240] rmdir("./1") = 0 [pid 5240] mkdir("./2", 0777) = 0 [pid 5240] openat(AT_FDCWD, "/dev/loop2", O_RDWR) = 3 [pid 5326] set_robust_list(0x55557e1f7660, 24) = 0 [pid 5240] ioctl(3, LOOP_CLR_FD [pid 5326] chdir("./2" [pid 5240] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5240] close(3) = 0 [pid 5240] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5327 attached [pid 5326] <... chdir resumed>) = 0 [pid 5326] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5327] set_robust_list(0x55557e1f7660, 24) = 0 [pid 5327] chdir("./2" [pid 5326] setpgid(0, 0 [pid 5327] <... chdir resumed>) = 0 [pid 5326] <... setpgid resumed>) = 0 [pid 5327] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5327] setpgid(0, 0) = 0 [pid 5326] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5327] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC) = 3 [pid 5326] <... openat resumed>) = 3 [pid 5240] <... clone resumed>, child_tidptr=0x55557e1f7650) = 5327 [pid 5327] write(3, "1000", 4 [pid 5326] write(3, "1000", 4 [pid 5327] <... write resumed>) = 4 executing program [pid 5327] close(3 [pid 5326] <... write resumed>) = 4 [pid 5327] <... close resumed>) = 0 [pid 5327] symlink("/dev/binderfs", "./binderfs") = 0 [pid 5327] write(1, "executing program\n", 18) = 18 [pid 5327] memfd_create("syzkaller", 0) = 3 [pid 5327] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5326] close(3 [pid 5327] <... mmap resumed>) = 0x7feee4c00000 [pid 5326] <... close resumed>) = 0 [pid 5326] symlink("/dev/binderfs", "./binderfs") = 0 [pid 5326] write(1, "executing program\n", 18) = 18 executing program [pid 5326] memfd_create("syzkaller", 0) = 3 [ 182.732359][ T5241] bcachefs (loop3): finished waiting for writes to stop [ 182.763612][ T5241] bcachefs (loop3): flushing journal and stopping allocators, journal seq 11 [pid 5326] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7feee4c00000 [ 182.865999][ T5241] bcachefs (loop3): flushing journal and stopping allocators complete, journal seq 17 [ 182.922684][ T5241] bcachefs (loop3): unshutdown complete, journal seq 18 [ 182.952422][ T5241] bcachefs (loop3): done going read-only, filesystem not clean [ 183.022735][ T5241] bcachefs (loop3): shutdown complete [pid 5326] 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 5325] 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 5324] 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 5327] 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 5326] <... write resumed>) = 16777216 [pid 5326] munmap(0x7feee4c00000, 138412032) = 0 [pid 5326] openat(AT_FDCWD, "/dev/loop0", O_RDWR) = 4 [pid 5326] ioctl(4, LOOP_SET_FD, 3) = 0 [pid 5326] close(3) = 0 [pid 5326] close(4) = 0 [pid 5326] mkdir("./file1", 0777) = 0 [ 183.337074][ T5326] loop0: detected capacity change from 0 to 32768 [pid 5326] mount("/dev/loop0", "./file1", "bcachefs", MS_I_VERSION, "data_checksum=xxhash,direct_io,norecovery,fsck,journal_flush_disabled,norecovery,btree_node_imizatio"... [pid 5325] <... write resumed>) = 16777216 [pid 5325] munmap(0x7feee4c00000, 138412032 [pid 5324] <... write resumed>) = 16777216 [pid 5324] munmap(0x7feee4c00000, 138412032 [pid 5325] <... munmap resumed>) = 0 [pid 5325] openat(AT_FDCWD, "/dev/loop1", O_RDWR) = 4 [pid 5325] ioctl(4, LOOP_SET_FD, 3 [pid 5327] <... write resumed>) = 16777216 [pid 5324] <... munmap resumed>) = 0 [pid 5327] munmap(0x7feee4c00000, 138412032 [pid 5324] openat(AT_FDCWD, "/dev/loop4", O_RDWR) = 4 [pid 5324] ioctl(4, LOOP_SET_FD, 3 [pid 5325] <... ioctl resumed>) = 0 [pid 5324] <... ioctl resumed>) = 0 [pid 5327] <... munmap resumed>) = 0 [pid 5325] close(3 [pid 5327] openat(AT_FDCWD, "/dev/loop2", O_RDWR [pid 5325] <... close resumed>) = 0 [pid 5324] close(3 [pid 5327] <... openat resumed>) = 4 [pid 5325] close(4 [pid 5324] <... close resumed>) = 0 [pid 5327] ioctl(4, LOOP_SET_FD, 3 [pid 5325] <... close resumed>) = 0 [pid 5324] close(4 [pid 5325] mkdir("./file1", 0777 [pid 5324] <... close resumed>) = 0 [pid 5325] <... mkdir resumed>) = 0 [pid 5324] mkdir("./file1", 0777 [pid 5325] mount("/dev/loop1", "./file1", "bcachefs", MS_I_VERSION, "data_checksum=xxhash,direct_io,norecovery,fsck,journal_flush_disabled,norecovery,btree_node_imizatio"... [pid 5327] <... ioctl resumed>) = 0 [pid 5324] <... mkdir resumed>) = 0 [pid 5324] mount("/dev/loop4", "./file1", "bcachefs", MS_I_VERSION, "data_checksum=xxhash,direct_io,norecovery,fsck,journal_flush_disabled,norecovery,btree_node_imizatio"... [pid 5327] close(3) = 0 [pid 5327] close(4) = 0 [pid 5327] mkdir("./file1", 0777) = 0 [ 183.466817][ T5325] loop1: detected capacity change from 0 to 32768 [ 183.476726][ T5324] loop4: detected capacity change from 0 to 32768 [ 183.498935][ T5327] loop2: detected capacity change from 0 to 32768 [ 183.847061][ T5324] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 183.857543][ T5324] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 183.857927][ T5326] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 183.866112][ T5325] bcachefs (loop1): starting version 1.7: mi_btree_bitmap opts=metadata_checksum=none,data_checksum=xxhash,compression=lz4,journal_flush_disabled,fsck,norecovery,nojournal_transaction_names,reconstruct_alloc [ 183.905282][ T5326] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 183.914700][ T5327] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 183.949191][ T5327] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 183.964078][ T5325] bcachefs (loop1): recovering from clean shutdown, journal seq 10 [ 184.002126][ T5325] bcachefs (loop1): Version upgrade required: [ 184.002126][ T5325] Version upgrade from 0.24: unwritten_extents to 1.7: mi_btree_bitmap incomplete [ 184.002126][ T5325] Doing incompatible version upgrade from 0.24: unwritten_extents to 1.13: inode_has_child_snapshots [ 184.002126][ T5325] running recovery passes: check_allocations,check_alloc_info,check_lrus,check_btree_backpointers,check_backpointers_to_extents,check_extents_to_backpointers,check_alloc_to_lru_refs,bucket_gens_init,check_snapshot_trees,check_snapshots,check_subvols,check_subvol_children,delete_dead_snapshots,check_inodes,check_extents,check_indirect_extents,check_dirents,check_xattrs,check_root,check_unreachable_inodes,check_subvolume_structure,check_directory_structure,check_nlinks,set_fs_needs_rebalance [pid 5327] mount("/dev/loop2", "./file1", "bcachefs", MS_I_VERSION, "data_checksum=xxhash,direct_io,norecovery,fsck,journal_flush_disabled,norecovery,btree_node_imizatio"... [pid 5324] <... mount resumed>) = -1 EINVAL (Invalid argument) [pid 5324] openat(AT_FDCWD, "/dev/loop4", O_RDWR) = 3 [pid 5326] <... mount resumed>) = -1 EINVAL (Invalid argument) [pid 5324] ioctl(3, LOOP_CLR_FD [pid 5326] openat(AT_FDCWD, "/dev/loop0", O_RDWR [pid 5324] <... ioctl resumed>) = 0 [pid 5326] <... openat resumed>) = 3 [pid 5324] close(3 [pid 5327] <... mount resumed>) = -1 EINVAL (Invalid argument) [pid 5326] ioctl(3, LOOP_CLR_FD [pid 5327] openat(AT_FDCWD, "/dev/loop2", O_RDWR) = 3 [pid 5327] ioctl(3, LOOP_CLR_FD) = 0 [pid 5326] <... ioctl resumed>) = 0 [pid 5241] <... umount2 resumed>) = 0 [pid 5327] close(3 [ 184.113218][ T5324] bcachefs: bch2_fs_get_tree() error: EINVAL [ 184.127477][ T5326] bcachefs: bch2_fs_get_tree() error: EINVAL [ 184.134837][ T5327] bcachefs: bch2_fs_get_tree() error: EINVAL [ 184.155075][ T5325] bcachefs (loop1): dropping and reconstructing all alloc info [pid 5326] close(3 [pid 5241] umount2("./1/file1", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5241] newfstatat(AT_FDCWD, "./1/file1", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5241] umount2("./1/file1", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5241] openat(AT_FDCWD, "./1/file1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4 [pid 5241] newfstatat(4, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5241] getdents64(4, 0x55557e200730 /* 2 entries */, 32768) = 48 [pid 5241] getdents64(4, 0x55557e200730 /* 0 entries */, 32768) = 0 [pid 5241] close(4) = 0 [pid 5241] rmdir("./1/file1") = 0 [pid 5241] getdents64(3, 0x55557e1f86f0 /* 0 entries */, 32768) = 0 [pid 5241] close(3) = 0 [pid 5241] rmdir("./1") = 0 [pid 5241] mkdir("./2", 0777) = 0 [pid 5241] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = 3 [pid 5241] ioctl(3, LOOP_CLR_FD) = -1 ENXIO (No such device or address) [pid 5241] close(3) = 0 [pid 5241] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5357 attached [pid 5357] set_robust_list(0x55557e1f7660, 24 [pid 5241] <... clone resumed>, child_tidptr=0x55557e1f7650) = 5357 [pid 5357] <... set_robust_list resumed>) = 0 [pid 5357] chdir("./2") = 0 [pid 5357] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5357] setpgid(0, 0) = 0 [pid 5357] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC) = 3 [pid 5357] write(3, "1000", 4) = 4 [pid 5357] close(3) = 0 [pid 5357] symlink("/dev/binderfs", "./binderfs") = 0 [ 184.266007][ T5325] bcachefs (loop1): check_topology... done [pid 5357] write(1, "executing program\n", 18executing program ) = 18 [pid 5357] memfd_create("syzkaller", 0) = 3 [pid 5357] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7feee4c00000 [ 184.291257][ T5325] bcachefs (loop1): accounting_read... done [ 184.319198][ T5325] bcachefs (loop1): alloc_read... done [pid 5326] <... close resumed>) = 0 [pid 5326] openat(AT_FDCWD, "cpuset.effective_cpus", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000 [pid 5327] <... close resumed>) = 0 [pid 5324] <... close resumed>) = 0 [pid 5327] openat(AT_FDCWD, "cpuset.effective_cpus", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000 [pid 5324] openat(AT_FDCWD, "cpuset.effective_cpus", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000 [pid 5326] <... openat resumed>) = 3 [pid 5324] <... openat resumed>) = 3 [pid 5327] <... openat resumed>) = 3 [pid 5326] exit_group(0) = ? [pid 5327] exit_group(0 [pid 5326] +++ exited with 0 +++ [pid 5324] exit_group(0) = ? [ 184.355575][ T5325] bcachefs (loop1): stripes_read... done [ 184.379602][ T5325] bcachefs (loop1): snapshots_read... done [pid 5327] <... exit_group resumed>) = ? [pid 5238] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5326, si_uid=0, si_status=0, si_utime=9 /* 0.09 s */, si_stime=43 /* 0.43 s */} --- [pid 5238] restart_syscall(<... resuming interrupted clone ...>) = 0 [pid 5238] umount2("./2", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5327] +++ exited with 0 +++ [pid 5324] +++ exited with 0 +++ [pid 5238] openat(AT_FDCWD, "./2", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5242] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5324, si_uid=0, si_status=0, si_utime=8 /* 0.08 s */, si_stime=37 /* 0.37 s */} --- [pid 5240] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5327, si_uid=0, si_status=0, si_utime=10 /* 0.10 s */, si_stime=39 /* 0.39 s */} --- [pid 5238] <... openat resumed>) = 3 [pid 5242] restart_syscall(<... resuming interrupted clone ...> [pid 5240] restart_syscall(<... resuming interrupted clone ...> [pid 5238] newfstatat(3, "", [pid 5242] <... restart_syscall resumed>) = 0 [pid 5240] <... restart_syscall resumed>) = 0 [pid 5238] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5242] umount2("./1", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5238] getdents64(3, 0x55557e1f86f0 /* 5 entries */, 32768) = 160 [pid 5242] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5240] umount2("./2", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5238] umount2("./2/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5242] openat(AT_FDCWD, "./1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5240] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5238] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5240] openat(AT_FDCWD, "./2", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5238] newfstatat(AT_FDCWD, "./2/binderfs", [pid 5242] <... openat resumed>) = 3 [pid 5240] <... openat resumed>) = 3 [pid 5238] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5242] newfstatat(3, "", [pid 5240] newfstatat(3, "", [pid 5238] unlink("./2/binderfs" [pid 5242] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5240] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5238] <... unlink resumed>) = 0 [pid 5240] getdents64(3, [pid 5238] umount2("./2/file1", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5242] getdents64(3, [pid 5240] <... getdents64 resumed>0x55557e1f86f0 /* 5 entries */, 32768) = 160 [pid 5238] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5242] <... getdents64 resumed>0x55557e1f86f0 /* 5 entries */, 32768) = 160 [pid 5238] newfstatat(AT_FDCWD, "./2/file1", [pid 5242] umount2("./1/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5240] umount2("./2/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5238] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5242] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5240] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5238] umount2("./2/file1", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5242] newfstatat(AT_FDCWD, "./1/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5240] newfstatat(AT_FDCWD, "./2/binderfs", [pid 5238] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5242] unlink("./1/binderfs" [pid 5240] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5242] <... unlink resumed>) = 0 [pid 5240] unlink("./2/binderfs" [pid 5238] openat(AT_FDCWD, "./2/file1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4 [pid 5240] <... unlink resumed>) = 0 [pid 5238] newfstatat(4, "", [pid 5242] umount2("./1/file1", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5240] umount2("./2/file1", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5242] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5238] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5242] newfstatat(AT_FDCWD, "./1/file1", [pid 5240] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5238] getdents64(4, [pid 5242] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5240] newfstatat(AT_FDCWD, "./2/file1", [pid 5238] <... getdents64 resumed>0x55557e200730 /* 2 entries */, 32768) = 48 [pid 5242] umount2("./1/file1", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5240] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5238] getdents64(4, [pid 5242] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5240] umount2("./2/file1", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5242] openat(AT_FDCWD, "./1/file1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY