./strace-static-x86_64 -e \!wait4,clock_nanosleep,nanosleep -s 100 -x -f ./syz-executor4053292427 <...> [ 76.705577][ T940] cfg80211: failed to load regulatory.db Warning: Permanently added '10.128.0.141' (ED25519) to the list of known hosts. execve("./syz-executor4053292427", ["./syz-executor4053292427"], 0x7ffe77769aa0 /* 10 vars */) = 0 brk(NULL) = 0x555586986000 brk(0x555586986d00) = 0x555586986d00 arch_prctl(ARCH_SET_FS, 0x555586986380) = 0 set_tid_address(0x555586986650) = 5219 set_robust_list(0x555586986660, 24) = 0 rseq(0x555586986ca0, 0x20, 0, 0x53053053) = 0 prlimit64(0, RLIMIT_STACK, NULL, {rlim_cur=8192*1024, rlim_max=RLIM64_INFINITY}) = 0 readlink("/proc/self/exe", "/root/syz-executor4053292427", 4096) = 28 getrandom("\x62\x6a\x70\x4d\x6d\x39\xfa\x86", 8, GRND_NONBLOCK) = 8 brk(NULL) = 0x555586986d00 brk(0x5555869a7d00) = 0x5555869a7d00 brk(0x5555869a8000) = 0x5555869a8000 mprotect(0x7ff94a4fd000, 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, child_tidptr=0x555586986650) = 5220 ./strace-static-x86_64: Process 5220 attached [pid 5219] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5220] set_robust_list(0x555586986660, 24) = 0 ./strace-static-x86_64: Process 5221 attached [pid 5220] mkdir("./syzkaller.W8skh6", 0700 [pid 5221] set_robust_list(0x555586986660, 24 [pid 5219] <... clone resumed>, child_tidptr=0x555586986650) = 5221 [pid 5219] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5221] <... set_robust_list resumed>) = 0 [pid 5221] mkdir("./syzkaller.nTRX1C", 0700 [pid 5220] <... mkdir resumed>) = 0 ./strace-static-x86_64: Process 5222 attached [pid 5221] <... mkdir resumed>) = 0 [pid 5219] <... clone resumed>, child_tidptr=0x555586986650) = 5222 [pid 5222] set_robust_list(0x555586986660, 24 [pid 5221] chmod("./syzkaller.nTRX1C", 0777 [pid 5220] chmod("./syzkaller.W8skh6", 0777 [pid 5219] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5222] <... set_robust_list resumed>) = 0 [pid 5221] <... chmod resumed>) = 0 [pid 5222] mkdir("./syzkaller.WKRsW5", 0700 [pid 5220] <... chmod resumed>) = 0 [pid 5221] chdir("./syzkaller.nTRX1C") = 0 ./strace-static-x86_64: Process 5223 attached [pid 5221] mkdir("./0", 0777 [pid 5223] set_robust_list(0x555586986660, 24 [pid 5222] <... mkdir resumed>) = 0 [pid 5221] <... mkdir resumed>) = 0 [pid 5220] chdir("./syzkaller.W8skh6" [pid 5223] <... set_robust_list resumed>) = 0 [pid 5220] <... chdir resumed>) = 0 [pid 5222] chmod("./syzkaller.WKRsW5", 0777 [pid 5219] <... clone resumed>, child_tidptr=0x555586986650) = 5223 [pid 5223] getrandom( [pid 5222] <... chmod resumed>) = 0 [pid 5221] openat(AT_FDCWD, "/dev/loop1", O_RDWR [pid 5220] mkdir("./0", 0777 [pid 5219] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5221] <... openat resumed>) = 3 ./strace-static-x86_64: Process 5224 attached [pid 5223] <... getrandom resumed>"\xe6\x4a\xbb\x92\xf6\x47\xf8\xe6", 8, GRND_NONBLOCK) = 8 [pid 5224] set_robust_list(0x555586986660, 24 [pid 5223] mkdir("./syzkaller.4pFeHd", 0700 [pid 5222] chdir("./syzkaller.WKRsW5") = 0 [pid 5222] mkdir("./0", 0777 [pid 5221] ioctl(3, LOOP_CLR_FD [pid 5220] <... mkdir resumed>) = 0 [pid 5219] <... clone resumed>, child_tidptr=0x555586986650) = 5224 [pid 5224] <... set_robust_list resumed>) = 0 [pid 5223] <... mkdir resumed>) = 0 [pid 5222] <... mkdir resumed>) = 0 [pid 5221] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5220] openat(AT_FDCWD, "/dev/loop0", O_RDWR [pid 5221] close(3 [pid 5224] mkdir("./syzkaller.nwbyOA", 0700 [pid 5223] chmod("./syzkaller.4pFeHd", 0777 [pid 5222] openat(AT_FDCWD, "/dev/loop2", O_RDWR [pid 5221] <... close resumed>) = 0 [pid 5220] <... openat resumed>) = 3 [pid 5223] <... chmod resumed>) = 0 [pid 5222] <... openat resumed>) = 3 [pid 5221] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5225 attached [pid 5223] chdir("./syzkaller.4pFeHd" [pid 5222] ioctl(3, LOOP_CLR_FD [pid 5223] <... chdir resumed>) = 0 [pid 5222] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5223] mkdir("./0", 0777 [pid 5225] set_robust_list(0x555586986660, 24 [pid 5224] <... mkdir resumed>) = 0 [pid 5223] <... mkdir resumed>) = 0 [pid 5222] close(3 [pid 5221] <... clone resumed>, child_tidptr=0x555586986650) = 5225 [pid 5220] ioctl(3, LOOP_CLR_FD [pid 5222] <... close resumed>) = 0 [pid 5225] <... set_robust_list resumed>) = 0 [pid 5224] chmod("./syzkaller.nwbyOA", 0777 [pid 5223] openat(AT_FDCWD, "/dev/loop3", O_RDWR [pid 5222] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5220] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5224] <... chmod resumed>) = 0 [pid 5220] close(3 [pid 5225] chdir("./0" [pid 5224] chdir("./syzkaller.nwbyOA" [pid 5223] <... openat resumed>) = 3 [pid 5220] <... close resumed>) = 0 [pid 5224] <... chdir resumed>) = 0 ./strace-static-x86_64: Process 5227 attached [pid 5222] <... clone resumed>, child_tidptr=0x555586986650) = 5227 [pid 5224] mkdir("./0", 0777 [pid 5220] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5227] set_robust_list(0x555586986660, 24) = 0 [pid 5224] <... mkdir resumed>) = 0 [pid 5227] chdir("./0") = 0 [pid 5227] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5224] openat(AT_FDCWD, "/dev/loop4", O_RDWR./strace-static-x86_64: Process 5228 attached [pid 5227] setpgid(0, 0 [pid 5224] <... openat resumed>) = 3 [pid 5228] set_robust_list(0x555586986660, 24 [pid 5227] <... setpgid resumed>) = 0 [pid 5224] ioctl(3, LOOP_CLR_FD [pid 5220] <... clone resumed>, child_tidptr=0x555586986650) = 5228 [pid 5228] <... set_robust_list resumed>) = 0 [pid 5225] <... chdir resumed>) = 0 [pid 5228] chdir("./0" [pid 5227] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5225] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5224] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5223] ioctl(3, LOOP_CLR_FD [pid 5228] <... chdir resumed>) = 0 [pid 5225] <... prctl resumed>) = 0 [pid 5224] close(3 [pid 5228] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5227] <... openat resumed>) = 3 [pid 5225] setpgid(0, 0 [pid 5224] <... close resumed>) = 0 [pid 5223] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5228] <... prctl resumed>) = 0 [pid 5225] <... setpgid resumed>) = 0 [pid 5224] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5223] close(3 [pid 5228] setpgid(0, 0 [pid 5227] write(3, "1000", 4) = 4 ./strace-static-x86_64: Process 5229 attached [pid 5228] <... setpgid resumed>) = 0 [pid 5225] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5223] <... close resumed>) = 0 [pid 5229] set_robust_list(0x555586986660, 24 [pid 5228] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5227] close(3 [pid 5228] <... openat resumed>) = 3 [pid 5227] <... close resumed>) = 0 [pid 5225] <... openat resumed>) = 3 [pid 5224] <... clone resumed>, child_tidptr=0x555586986650) = 5229 [pid 5223] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5225] write(3, "1000", 4 [pid 5229] <... set_robust_list resumed>) = 0 [pid 5227] symlink("/dev/binderfs", "./binderfs"./strace-static-x86_64: Process 5230 attached [pid 5229] chdir("./0" [pid 5227] <... symlink resumed>) = 0 [pid 5225] <... write resumed>) = 4 [pid 5230] set_robust_list(0x555586986660, 24 [pid 5229] <... chdir resumed>) = 0 [pid 5228] write(3, "1000", 4 [pid 5225] close(3 [pid 5223] <... clone resumed>, child_tidptr=0x555586986650) = 5230 [pid 5230] <... set_robust_list resumed>) = 0 [pid 5229] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5228] <... write resumed>) = 4 [pid 5225] <... close resumed>) = 0 [pid 5228] close(3 [pid 5225] symlink("/dev/binderfs", "./binderfs" [pid 5228] <... close resumed>) = 0 [pid 5229] <... prctl resumed>) = 0 executing program [pid 5227] write(1, "executing program\n", 18 [pid 5225] <... symlink resumed>) = 0 [pid 5228] symlink("/dev/binderfs", "./binderfs" [pid 5230] chdir("./0" [pid 5229] setpgid(0, 0) = 0 [pid 5227] <... write resumed>) = 18 [pid 5229] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5227] memfd_create("syzkaller", 0 [pid 5229] <... openat resumed>) = 3 [pid 5227] <... memfd_create resumed>) = 3 [pid 5229] write(3, "1000", 4 [pid 5227] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5229] <... write resumed>) = 4 [pid 5227] <... mmap resumed>) = 0x7ff942000000 [pid 5229] close(3) = 0 executing program executing program executing program [pid 5229] symlink("/dev/binderfs", "./binderfs" [pid 5228] <... symlink resumed>) = 0 [pid 5230] <... chdir resumed>) = 0 [pid 5229] <... symlink resumed>) = 0 [pid 5228] write(1, "executing program\n", 18 [pid 5225] write(1, "executing program\n", 18 [pid 5230] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5228] <... write resumed>) = 18 [pid 5225] <... write resumed>) = 18 [pid 5230] <... prctl resumed>) = 0 [pid 5229] write(1, "executing program\n", 18 [pid 5230] setpgid(0, 0 [pid 5229] <... write resumed>) = 18 [pid 5225] memfd_create("syzkaller", 0 [pid 5230] <... setpgid resumed>) = 0 [pid 5229] memfd_create("syzkaller", 0 [pid 5228] memfd_create("syzkaller", 0 [pid 5225] <... memfd_create resumed>) = 3 [pid 5228] <... memfd_create resumed>) = 3 [pid 5230] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5229] <... memfd_create resumed>) = 3 [pid 5228] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5225] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5229] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7ff942000000 [pid 5230] <... openat resumed>) = 3 [pid 5228] <... mmap resumed>) = 0x7ff942000000 [pid 5225] <... mmap resumed>) = 0x7ff942000000 [pid 5230] write(3, "1000", 4) = 4 [pid 5230] close(3) = 0 [pid 5230] symlink("/dev/binderfs", "./binderfs") = 0 executing program [pid 5230] write(1, "executing program\n", 18) = 18 [pid 5230] memfd_create("syzkaller", 0) = 3 [pid 5230] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7ff942000000 [pid 5225] 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 5230] 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 5229] 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 5227] 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 5228] 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 5230] <... write resumed>) = 16777216 [pid 5225] <... write resumed>) = 16777216 [pid 5230] munmap(0x7ff942000000, 138412032 [pid 5227] <... write resumed>) = 16777216 [pid 5225] munmap(0x7ff942000000, 138412032 [pid 5227] munmap(0x7ff942000000, 138412032 [pid 5225] <... munmap resumed>) = 0 [pid 5228] <... write resumed>) = 16777216 [pid 5230] <... munmap resumed>) = 0 [pid 5229] <... write resumed>) = 16777216 [pid 5227] <... munmap resumed>) = 0 [pid 5225] openat(AT_FDCWD, "/dev/loop1", O_RDWR [pid 5230] openat(AT_FDCWD, "/dev/loop3", O_RDWR [pid 5227] openat(AT_FDCWD, "/dev/loop2", O_RDWR [pid 5229] munmap(0x7ff942000000, 138412032 [pid 5228] munmap(0x7ff942000000, 138412032 [pid 5227] <... openat resumed>) = 4 [pid 5230] <... openat resumed>) = 4 [pid 5227] ioctl(4, LOOP_SET_FD, 3 [pid 5225] <... openat resumed>) = 4 [pid 5230] ioctl(4, LOOP_SET_FD, 3 [pid 5229] <... munmap resumed>) = 0 [pid 5228] <... munmap resumed>) = 0 [pid 5225] ioctl(4, LOOP_SET_FD, 3 [pid 5229] openat(AT_FDCWD, "/dev/loop4", O_RDWR [pid 5228] openat(AT_FDCWD, "/dev/loop0", O_RDWR [pid 5230] <... ioctl resumed>) = 0 [pid 5229] <... openat resumed>) = 4 [pid 5228] <... openat resumed>) = 4 [pid 5227] <... ioctl resumed>) = 0 [pid 5230] close(3 [pid 5229] ioctl(4, LOOP_SET_FD, 3 [pid 5228] ioctl(4, LOOP_SET_FD, 3 [pid 5227] close(3 [pid 5230] <... close resumed>) = 0 [pid 5229] <... ioctl resumed>) = 0 [pid 5227] <... close resumed>) = 0 [pid 5225] <... ioctl resumed>) = 0 [pid 5229] close(3 [pid 5227] close(4 [pid 5229] <... close resumed>) = 0 [pid 5230] close(4) = 0 [pid 5225] close(3 [pid 5230] mkdir("./file0", 0777 [pid 5225] <... close resumed>) = 0 [pid 5230] <... mkdir resumed>) = 0 [pid 5228] <... ioctl resumed>) = 0 [pid 5225] close(4 [pid 5228] close(3 [pid 5225] <... close resumed>) = 0 [pid 5228] <... close resumed>) = 0 [pid 5225] mkdir("./file0", 0777 [pid 5228] close(4 [pid 5225] <... mkdir resumed>) = 0 [pid 5228] <... close resumed>) = 0 [pid 5230] mount("/dev/loop3", "./file0", "bcachefs", MS_POSIXACL, "fsck,inline_data,nocow,degraded,str_hash=siphash,norecovery,discard,reconstruct_alloc,erasure_code,a"... [pid 5228] mkdir("./file0", 0777 [pid 5229] close(4 [pid 5228] <... mkdir resumed>) = 0 [pid 5227] <... close resumed>) = 0 [pid 5227] mkdir("./file0", 0777 [pid 5229] <... close resumed>) = 0 [pid 5225] mount("/dev/loop1", "./file0", "bcachefs", MS_POSIXACL, "fsck,inline_data,nocow,degraded,str_hash=siphash,norecovery,discard,reconstruct_alloc,erasure_code,a"... [pid 5229] mkdir("./file0", 0777 [pid 5227] <... mkdir resumed>) = 0 [pid 5229] <... mkdir resumed>) = 0 [pid 5228] mount("/dev/loop0", "./file0", "bcachefs", MS_POSIXACL, "fsck,inline_data,nocow,degraded,str_hash=siphash,norecovery,discard,reconstruct_alloc,erasure_code,a"... [pid 5227] mount("/dev/loop2", "./file0", "bcachefs", MS_POSIXACL, "fsck,inline_data,nocow,degraded,str_hash=siphash,norecovery,discard,reconstruct_alloc,erasure_code,a"... [ 80.582941][ T5227] loop2: detected capacity change from 0 to 32768 [ 80.591005][ T5230] loop3: detected capacity change from 0 to 32768 [ 80.598935][ T5225] loop1: detected capacity change from 0 to 32768 [ 80.606518][ T5229] loop4: detected capacity change from 0 to 32768 [ 80.607150][ T5228] loop0: detected capacity change from 0 to 32768 [ 80.851460][ T5228] bcachefs (loop0): starting version 1.7: mi_btree_bitmap opts=metadata_checksum=none,data_checksum=none,compression=lz4,erasure_code,degraded,no_splitbrain_check,fsck,norecovery,nojournal_transaction_names,reconstruct_alloc,nocow [ 80.853320][ T5227] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 80.874776][ T5228] bcachefs (loop0): recovering from clean shutdown, journal seq 10 [ 80.892783][ T5228] bcachefs (loop0): Version upgrade required: [ 80.892783][ T5228] Version upgrade from 0.24: unwritten_extents to 1.7: mi_btree_bitmap incomplete [ 80.892783][ T5228] Doing incompatible version upgrade from 0.24: unwritten_extents to 1.13: inode_has_child_snapshots [ 80.892783][ T5228] 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 [ 80.966722][ T5228] bcachefs (loop0): dropping and reconstructing all alloc info [ 80.967428][ T5230] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 80.985392][ T5229] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 80.996842][ T5225] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 80.996877][ T5229] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 81.006082][ T5225] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 81.023156][ T5227] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 81.023915][ T5228] bcachefs (loop0): check_topology... [ 81.035030][ T5230] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 81.042342][ T5228] done [ 81.070477][ T5228] bcachefs (loop0): accounting_read... done [ 81.095089][ T5228] bcachefs (loop0): alloc_read... done [ 81.112621][ T5228] bcachefs (loop0): stripes_read... done [ 81.122712][ T5228] bcachefs (loop0): snapshots_read... done [pid 5229] mount("/dev/loop4", "./file0", "bcachefs", MS_POSIXACL, "fsck,inline_data,nocow,degraded,str_hash=siphash,norecovery,discard,reconstruct_alloc,erasure_code,a"... [pid 5225] <... mount resumed>) = -1 EINVAL (Invalid argument) [pid 5225] openat(AT_FDCWD, "/dev/loop1", O_RDWR [pid 5230] <... mount resumed>) = -1 EINVAL (Invalid argument) [pid 5229] <... mount resumed>) = -1 EINVAL (Invalid argument) [pid 5225] <... openat resumed>) = 3 [pid 5230] openat(AT_FDCWD, "/dev/loop3", O_RDWR [pid 5225] ioctl(3, LOOP_CLR_FD [pid 5230] <... openat resumed>) = 3 [pid 5225] <... ioctl resumed>) = 0 [ 81.141320][ T5228] bcachefs (loop0): check_allocations... [ 81.148218][ T5229] bcachefs: bch2_fs_get_tree() error: EINVAL [ 81.176657][ T5225] bcachefs: bch2_fs_get_tree() error: EINVAL [ 81.192325][ T5230] bcachefs: bch2_fs_get_tree() error: EINVAL [pid 5230] ioctl(3, LOOP_CLR_FD [pid 5225] close(3 [pid 5230] <... ioctl resumed>) = 0 [pid 5229] openat(AT_FDCWD, "/dev/loop4", O_RDWR [pid 5230] close(3 [pid 5229] <... openat resumed>) = 3 [ 81.213972][ T5228] done [pid 5229] ioctl(3, LOOP_CLR_FD) = 0 [ 81.238490][ T5228] bcachefs (loop0): going read-write [pid 5229] close(3 [pid 5227] <... mount resumed>) = -1 EINVAL (Invalid argument) [pid 5227] openat(AT_FDCWD, "/dev/loop2", O_RDWR) = 3 [pid 5227] ioctl(3, LOOP_CLR_FD) = 0 [pid 5228] <... mount resumed>) = 0 [pid 5227] close(3 [pid 5228] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY) = 3 [pid 5228] chdir("./file0") = 0 [pid 5228] openat(AT_FDCWD, "/dev/loop0", O_RDWR) = 4 [ 81.276217][ T5227] bcachefs: bch2_fs_get_tree() error: EINVAL [ 81.292676][ T5228] bcachefs (loop0): done starting filesystem [pid 5228] ioctl(4, LOOP_CLR_FD) = 0 [pid 5228] close(4) = 0 [pid 5228] openat(AT_FDCWD, "cpuacct.usage_percpu_sys", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000) = 4 [pid 5228] exit_group(0) = ? [pid 5228] +++ exited with 0 +++ [pid 5220] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5228, si_uid=0, si_status=0, si_utime=8 /* 0.08 s */, si_stime=38 /* 0.38 s */} --- [pid 5220] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5220] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 5220] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5220] getdents64(3, 0x5555869876f0 /* 4 entries */, 32768) = 112 [pid 5220] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5220] newfstatat(AT_FDCWD, "./0/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5220] unlink("./0/binderfs") = 0 [ 81.469654][ T5220] bcachefs (loop0): shutting down [ 81.492468][ T5220] bcachefs (loop0): going read-only [pid 5220] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5230] <... close resumed>) = 0 [pid 5230] openat(AT_FDCWD, "cpuacct.usage_percpu_sys", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000) = 3 [pid 5230] exit_group(0) = ? [pid 5229] <... close resumed>) = 0 [pid 5230] +++ exited with 0 +++ [pid 5223] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5230, si_uid=0, si_status=0, si_utime=3 /* 0.03 s */, si_stime=39 /* 0.39 s */} --- [pid 5225] <... close resumed>) = 0 [pid 5225] openat(AT_FDCWD, "cpuacct.usage_percpu_sys", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000 [pid 5223] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5225] <... openat resumed>) = 3 [pid 5229] openat(AT_FDCWD, "cpuacct.usage_percpu_sys", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000 [pid 5227] <... close resumed>) = 0 [pid 5223] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5223] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5229] <... openat resumed>) = 3 [pid 5225] exit_group(0 [pid 5223] <... openat resumed>) = 3 [pid 5227] openat(AT_FDCWD, "cpuacct.usage_percpu_sys", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000) = 3 [pid 5229] exit_group(0 [pid 5227] exit_group(0 [pid 5225] <... exit_group resumed>) = ? [pid 5227] <... exit_group resumed>) = ? [pid 5227] +++ exited with 0 +++ [pid 5225] +++ exited with 0 +++ [pid 5229] <... exit_group resumed>) = ? [pid 5222] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5227, si_uid=0, si_status=0, si_utime=6 /* 0.06 s */, si_stime=38 /* 0.38 s */} --- [pid 5222] restart_syscall(<... resuming interrupted clone ...> [pid 5221] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5225, si_uid=0, si_status=0, si_utime=8 /* 0.08 s */, si_stime=39 /* 0.39 s */} --- [pid 5223] newfstatat(3, "", [pid 5221] restart_syscall(<... resuming interrupted clone ...> [pid 5223] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5223] getdents64(3, [pid 5222] <... restart_syscall resumed>) = 0 [pid 5229] +++ exited with 0 +++ [pid 5223] <... getdents64 resumed>0x5555869876f0 /* 5 entries */, 32768) = 160 [pid 5223] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5224] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5229, si_uid=0, si_status=0, si_utime=4 /* 0.04 s */, si_stime=38 /* 0.38 s */} --- [pid 5223] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [ 81.513040][ T5220] bcachefs (loop0): finished waiting for writes to stop [ 81.540893][ T5220] bcachefs (loop0): flushing journal and stopping allocators, journal seq 12 [pid 5222] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5224] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5223] newfstatat(AT_FDCWD, "./0/binderfs", [pid 5222] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5221] <... restart_syscall resumed>) = 0 [pid 5224] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5223] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5222] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5224] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5223] unlink("./0/binderfs" [pid 5222] <... openat resumed>) = 3 [pid 5224] <... openat resumed>) = 3 [pid 5223] <... unlink resumed>) = 0 [pid 5222] newfstatat(3, "", [pid 5224] newfstatat(3, "", [pid 5222] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5224] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5222] getdents64(3, [pid 5224] getdents64(3, [pid 5222] <... getdents64 resumed>0x5555869876f0 /* 5 entries */, 32768) = 160 [pid 5224] <... getdents64 resumed>0x5555869876f0 /* 5 entries */, 32768) = 160 [pid 5222] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5224] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5222] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5224] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5222] newfstatat(AT_FDCWD, "./0/binderfs", [pid 5224] newfstatat(AT_FDCWD, "./0/binderfs", [pid 5222] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5224] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5222] unlink("./0/binderfs" [pid 5224] unlink("./0/binderfs" [pid 5222] <... unlink resumed>) = 0 [pid 5224] <... unlink resumed>) = 0 [pid 5222] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5221] umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5222] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5222] newfstatat(AT_FDCWD, "./0/file0", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5222] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5222] openat(AT_FDCWD, "./0/file0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4 [pid 5223] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5222] newfstatat(4, "", [pid 5223] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5222] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5223] newfstatat(AT_FDCWD, "./0/file0", [pid 5222] getdents64(4, [pid 5221] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5223] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5222] <... getdents64 resumed>0x55558698f730 /* 2 entries */, 32768) = 48 [pid 5222] getdents64(4, 0x55558698f730 /* 0 entries */, 32768) = 0 [pid 5221] openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5222] close(4 [pid 5223] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5222] <... close resumed>) = 0 [pid 5221] <... openat resumed>) = 3 [pid 5223] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5222] rmdir("./0/file0" [pid 5221] newfstatat(3, "", [pid 5223] openat(AT_FDCWD, "./0/file0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4 [pid 5223] newfstatat(4, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5223] getdents64(4, [pid 5222] <... rmdir resumed>) = 0 [pid 5221] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5224] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5223] <... getdents64 resumed>0x55558698f730 /* 2 entries */, 32768) = 48 [pid 5223] getdents64(4, 0x55558698f730 /* 0 entries */, 32768) = 0 [pid 5223] close(4) = 0 [pid 5223] rmdir("./0/file0") = 0 [pid 5224] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5223] umount2("./0/cpuacct.usage_percpu_sys", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5222] umount2("./0/cpuacct.usage_percpu_sys", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5221] getdents64(3, [pid 5224] newfstatat(AT_FDCWD, "./0/file0", [pid 5223] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5224] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5223] newfstatat(AT_FDCWD, "./0/cpuacct.usage_percpu_sys", [pid 5222] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5224] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5223] <... newfstatat resumed>{st_mode=S_IFREG|000, st_size=0, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5222] newfstatat(AT_FDCWD, "./0/cpuacct.usage_percpu_sys", [pid 5224] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5223] unlink("./0/cpuacct.usage_percpu_sys" [pid 5222] <... newfstatat resumed>{st_mode=S_IFREG|000, st_size=0, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5224] openat(AT_FDCWD, "./0/file0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5223] <... unlink resumed>) = 0 [pid 5224] <... openat resumed>) = 4 [pid 5223] getdents64(3, [pid 5222] unlink("./0/cpuacct.usage_percpu_sys" [pid 5223] <... getdents64 resumed>0x5555869876f0 /* 0 entries */, 32768) = 0 [pid 5224] newfstatat(4, "", [pid 5223] close(3 [pid 5222] <... unlink resumed>) = 0 [pid 5221] <... getdents64 resumed>0x5555869876f0 /* 5 entries */, 32768) = 160 [pid 5224] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5223] <... close resumed>) = 0 [pid 5224] getdents64(4, [pid 5222] getdents64(3, [pid 5224] <... getdents64 resumed>0x55558698f730 /* 2 entries */, 32768) = 48 [pid 5223] rmdir("./0" [pid 5222] <... getdents64 resumed>0x5555869876f0 /* 0 entries */, 32768) = 0 [pid 5223] <... rmdir resumed>) = 0 [pid 5224] getdents64(4, [pid 5222] close(3 [pid 5224] <... getdents64 resumed>0x55558698f730 /* 0 entries */, 32768) = 0 [pid 5222] <... close resumed>) = 0 [pid 5224] close(4 [pid 5222] rmdir("./0" [pid 5224] <... close resumed>) = 0 [pid 5222] <... rmdir resumed>) = 0 [pid 5224] rmdir("./0/file0") = 0 [pid 5223] mkdir("./1", 0777) = 0 [pid 5222] mkdir("./1", 0777 [pid 5221] umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5224] umount2("./0/cpuacct.usage_percpu_sys", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5224] newfstatat(AT_FDCWD, "./0/cpuacct.usage_percpu_sys", {st_mode=S_IFREG|000, st_size=0, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5224] unlink("./0/cpuacct.usage_percpu_sys" [pid 5223] openat(AT_FDCWD, "/dev/loop3", O_RDWR [pid 5222] <... mkdir resumed>) = 0 [pid 5221] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5224] <... unlink resumed>) = 0 [pid 5223] <... openat resumed>) = 3 [pid 5222] openat(AT_FDCWD, "/dev/loop2", O_RDWR) = 3 [pid 5224] getdents64(3, [pid 5223] ioctl(3, LOOP_CLR_FD [pid 5222] ioctl(3, LOOP_CLR_FD [pid 5224] <... getdents64 resumed>0x5555869876f0 /* 0 entries */, 32768) = 0 [pid 5223] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5222] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5224] close(3 [pid 5223] close(3 [pid 5222] close(3 [pid 5224] <... close resumed>) = 0 [pid 5221] newfstatat(AT_FDCWD, "./0/binderfs", [pid 5224] rmdir("./0" [pid 5223] <... close resumed>) = 0 [pid 5222] <... close resumed>) = 0 [pid 5224] <... rmdir resumed>) = 0 [pid 5223] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5222] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5221] <... newfstatat resumed>{st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [ 81.628149][ T5220] bcachefs (loop0): flushing journal and stopping allocators complete, journal seq 13 [ 81.640694][ T11] bcachefs (loop0): bch2_write_super(): fatal error loop0: Superblock write was silently dropped! (seq 0 expected 54) [ 81.656006][ T5220] bcachefs (loop0): unshutdown complete, journal seq 14 [ 81.664287][ T11] bcachefs (loop0): fatal error - emergency read only [pid 5221] unlink("./0/binderfs" [pid 5224] mkdir("./1", 0777) = 0 ./strace-static-x86_64: Process 5273 attached [pid 5223] <... clone resumed>, child_tidptr=0x555586986650) = 5274 [pid 5222] <... clone resumed>, child_tidptr=0x555586986650) = 5273 [pid 5221] <... unlink resumed>) = 0 ./strace-static-x86_64: Process 5274 attached [pid 5224] openat(AT_FDCWD, "/dev/loop4", O_RDWR) = 3 [pid 5224] ioctl(3, LOOP_CLR_FD) = -1 ENXIO (No such device or address) [pid 5274] set_robust_list(0x555586986660, 24 [pid 5273] set_robust_list(0x555586986660, 24 [pid 5221] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5274] <... set_robust_list resumed>) = 0 [pid 5273] <... set_robust_list resumed>) = 0 [pid 5224] close(3 [pid 5221] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5274] chdir("./1" [pid 5273] chdir("./1" [pid 5224] <... close resumed>) = 0 [pid 5221] newfstatat(AT_FDCWD, "./0/file0", [pid 5274] <... chdir resumed>) = 0 [pid 5273] <... chdir resumed>) = 0 [pid 5221] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5274] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5273] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5224] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5221] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5274] <... prctl resumed>) = 0 [pid 5273] <... prctl resumed>) = 0 [pid 5221] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5274] setpgid(0, 0 [pid 5273] setpgid(0, 0 [pid 5221] openat(AT_FDCWD, "./0/file0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5274] <... setpgid resumed>) = 0 [pid 5273] <... setpgid resumed>) = 0 [pid 5221] <... openat resumed>) = 4 [pid 5274] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5273] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5221] newfstatat(4, "", [pid 5274] <... openat resumed>) = 3 [pid 5273] <... openat resumed>) = 3 [pid 5224] <... clone resumed>, child_tidptr=0x555586986650) = 5275 [pid 5221] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 ./strace-static-x86_64: Process 5275 attached [pid 5274] write(3, "1000", 4 [pid 5273] write(3, "1000", 4 [pid 5221] getdents64(4, [pid 5275] set_robust_list(0x555586986660, 24 [pid 5274] <... write resumed>) = 4 [pid 5273] <... write resumed>) = 4 [pid 5221] <... getdents64 resumed>0x55558698f730 /* 2 entries */, 32768) = 48 [pid 5275] <... set_robust_list resumed>) = 0 [pid 5274] close(3 [pid 5273] close(3 [pid 5221] getdents64(4, [pid 5275] chdir("./1" [pid 5274] <... close resumed>) = 0 [pid 5273] <... close resumed>) = 0 [pid 5221] <... getdents64 resumed>0x55558698f730 /* 0 entries */, 32768) = 0 [pid 5275] <... chdir resumed>) = 0 [pid 5274] symlink("/dev/binderfs", "./binderfs" [ 81.673799][ T5220] bcachefs (loop0): done going read-only, filesystem not clean [pid 5273] symlink("/dev/binderfs", "./binderfs"executing program executing program [pid 5221] close(4 [pid 5275] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5274] <... symlink resumed>) = 0 [pid 5273] <... symlink resumed>) = 0 [pid 5221] <... close resumed>) = 0 [pid 5221] rmdir("./0/file0" [pid 5273] write(1, "executing program\n", 18 [pid 5221] <... rmdir resumed>) = 0 [pid 5274] write(1, "executing program\n", 18 [pid 5273] <... write resumed>) = 18 [pid 5221] umount2("./0/cpuacct.usage_percpu_sys", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5275] <... prctl resumed>) = 0 [pid 5274] <... write resumed>) = 18 [pid 5273] memfd_create("syzkaller", 0 [pid 5221] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5275] setpgid(0, 0 [pid 5274] memfd_create("syzkaller", 0 [pid 5273] <... memfd_create resumed>) = 3 [pid 5221] newfstatat(AT_FDCWD, "./0/cpuacct.usage_percpu_sys", [pid 5275] <... setpgid resumed>) = 0 [pid 5274] <... memfd_create resumed>) = 3 [pid 5273] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5221] <... newfstatat resumed>{st_mode=S_IFREG|000, st_size=0, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5275] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5274] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5273] <... mmap resumed>) = 0x7ff942000000 [pid 5221] unlink("./0/cpuacct.usage_percpu_sys" [pid 5275] <... openat resumed>) = 3 [pid 5274] <... mmap resumed>) = 0x7ff942000000 [pid 5221] <... unlink resumed>) = 0 [pid 5275] write(3, "1000", 4 [pid 5221] getdents64(3, [pid 5275] <... write resumed>) = 4 [pid 5275] close(3) = 0 [pid 5275] symlink("/dev/binderfs", "./binderfs") = 0 executing program [pid 5275] write(1, "executing program\n", 18) = 18 [pid 5221] <... getdents64 resumed>0x5555869876f0 /* 0 entries */, 32768) = 0 [pid 5275] memfd_create("syzkaller", 0 [pid 5221] close(3 [pid 5275] <... memfd_create resumed>) = 3 [pid 5221] <... close resumed>) = 0 [pid 5275] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5221] rmdir("./0" [pid 5275] <... mmap resumed>) = 0x7ff942000000 [pid 5221] <... rmdir resumed>) = 0 [pid 5221] mkdir("./1", 0777) = 0 [pid 5221] openat(AT_FDCWD, "/dev/loop1", O_RDWR) = 3 [pid 5221] ioctl(3, LOOP_CLR_FD) = -1 ENXIO (No such device or address) [pid 5221] close(3) = 0 [pid 5221] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x555586986650) = 5276 ./strace-static-x86_64: Process 5276 attached [pid 5276] set_robust_list(0x555586986660, 24) = 0 [pid 5276] chdir("./1") = 0 [pid 5276] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [ 81.718792][ T5220] bcachefs (loop0): shutdown complete [pid 5276] setpgid(0, 0) = 0 [pid 5276] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC) = 3 [pid 5276] write(3, "1000", 4) = 4 [pid 5276] close(3) = 0 [pid 5276] symlink("/dev/binderfs", "./binderfs") = 0 executing program [pid 5276] write(1, "executing program\n", 18) = 18 [pid 5276] memfd_create("syzkaller", 0) = 3 [pid 5276] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7ff942000000 [pid 5273] 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 5274] 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 5275] 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 5276] 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 5273] <... write resumed>) = 16777216 [pid 5273] munmap(0x7ff942000000, 138412032) = 0 [pid 5273] openat(AT_FDCWD, "/dev/loop2", O_RDWR) = 4 [pid 5273] ioctl(4, LOOP_SET_FD, 3) = 0 [pid 5273] close(3) = 0 [pid 5273] close(4) = 0 [pid 5273] mkdir("./file0", 0777) = 0 [ 82.275529][ T5273] loop2: detected capacity change from 0 to 32768 [pid 5273] mount("/dev/loop2", "./file0", "bcachefs", MS_POSIXACL, "fsck,inline_data,nocow,degraded,str_hash=siphash,norecovery,discard,reconstruct_alloc,erasure_code,a"... [pid 5276] <... write resumed>) = 16777216 [pid 5276] munmap(0x7ff942000000, 138412032) = 0 [pid 5276] openat(AT_FDCWD, "/dev/loop1", O_RDWR) = 4 [pid 5276] ioctl(4, LOOP_SET_FD, 3 [pid 5274] <... write resumed>) = 16777216 [pid 5274] munmap(0x7ff942000000, 138412032 [pid 5276] <... ioctl resumed>) = 0 [pid 5276] close(3) = 0 [pid 5276] close(4) = 0 [pid 5274] <... munmap resumed>) = 0 [pid 5276] mkdir("./file0", 0777 [pid 5274] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = 4 [pid 5274] ioctl(4, LOOP_SET_FD, 3 [pid 5276] <... mkdir resumed>) = 0 [pid 5276] mount("/dev/loop1", "./file0", "bcachefs", MS_POSIXACL, "fsck,inline_data,nocow,degraded,str_hash=siphash,norecovery,discard,reconstruct_alloc,erasure_code,a"... [pid 5275] <... write resumed>) = 16777216 [pid 5275] munmap(0x7ff942000000, 138412032 [pid 5274] <... ioctl resumed>) = 0 [pid 5274] close(3) = 0 [pid 5274] close(4) = 0 [pid 5274] mkdir("./file0", 0777) = 0 [pid 5275] <... munmap resumed>) = 0 [pid 5274] mount("/dev/loop3", "./file0", "bcachefs", MS_POSIXACL, "fsck,inline_data,nocow,degraded,str_hash=siphash,norecovery,discard,reconstruct_alloc,erasure_code,a"... [pid 5275] openat(AT_FDCWD, "/dev/loop4", O_RDWR) = 4 [ 82.383814][ T5276] loop1: detected capacity change from 0 to 32768 [ 82.415585][ T5274] loop3: detected capacity change from 0 to 32768 [pid 5275] ioctl(4, LOOP_SET_FD, 3) = 0 [pid 5275] close(3) = 0 [pid 5275] close(4) = 0 [pid 5275] mkdir("./file0", 0777) = 0 [ 82.460243][ T5275] loop4: detected capacity change from 0 to 32768 [ 82.678870][ T5273] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 82.679101][ T5276] bcachefs (loop1): starting version 1.7: mi_btree_bitmap opts=metadata_checksum=none,data_checksum=none,compression=lz4,erasure_code,degraded,no_splitbrain_check,fsck,norecovery,nojournal_transaction_names,reconstruct_alloc,nocow [ 82.689328][ T5273] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 82.711634][ T5276] bcachefs (loop1): recovering from clean shutdown, journal seq 10 [ 82.738606][ T5274] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 82.753220][ T5276] bcachefs (loop1): Version upgrade required: [ 82.753220][ T5276] Version upgrade from 0.24: unwritten_extents to 1.7: mi_btree_bitmap incomplete [ 82.753220][ T5276] Doing incompatible version upgrade from 0.24: unwritten_extents to 1.13: inode_has_child_snapshots [ 82.753220][ T5276] 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 [ 82.830605][ T5274] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 82.832942][ T5275] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 82.842263][ T5276] bcachefs (loop1): dropping and reconstructing all alloc info [ 82.904910][ T5275] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 82.922856][ T5274] bcachefs: bch2_fs_get_tree() error: EINVAL [pid 5275] mount("/dev/loop4", "./file0", "bcachefs", MS_POSIXACL, "fsck,inline_data,nocow,degraded,str_hash=siphash,norecovery,discard,reconstruct_alloc,erasure_code,a"... [pid 5274] <... mount resumed>) = -1 EINVAL (Invalid argument) [pid 5274] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = 3 [pid 5274] ioctl(3, LOOP_CLR_FD) = 0 [pid 5274] close(3 [pid 5273] <... mount resumed>) = -1 EINVAL (Invalid argument) [pid 5273] openat(AT_FDCWD, "/dev/loop2", O_RDWR) = 3 [pid 5273] ioctl(3, LOOP_CLR_FD) = 0 [ 82.966671][ T5273] bcachefs: bch2_fs_get_tree() error: EINVAL [ 82.996731][ T5276] bcachefs (loop1): check_topology... done [ 83.002637][ T5276] bcachefs (loop1): accounting_read... done [ 83.104406][ T5276] bcachefs (loop1): alloc_read... done [ 83.110012][ T5276] bcachefs (loop1): stripes_read... done [pid 5273] close(3 [pid 5275] <... mount resumed>) = -1 EINVAL (Invalid argument) [pid 5220] <... umount2 resumed>) = 0 [pid 5275] openat(AT_FDCWD, "/dev/loop4", O_RDWR [pid 5220] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5275] <... openat resumed>) = 3 [pid 5220] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5275] ioctl(3, LOOP_CLR_FD [pid 5220] newfstatat(AT_FDCWD, "./0/file0", [pid 5275] <... ioctl resumed>) = 0 [pid 5220] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [ 83.148830][ T5276] bcachefs (loop1): snapshots_read... done [ 83.163218][ T5276] bcachefs (loop1): check_allocations... [ 83.164190][ T5275] bcachefs: bch2_fs_get_tree() error: EINVAL [pid 5275] close(3 [pid 5273] <... close resumed>) = 0 [pid 5273] openat(AT_FDCWD, "cpuacct.usage_percpu_sys", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000 [pid 5220] umount2("./0/file0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5220] openat(AT_FDCWD, "./0/file0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4 [pid 5220] newfstatat(4, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5220] getdents64(4, [pid 5273] <... openat resumed>) = 3 [pid 5220] <... getdents64 resumed>0x55558698f730 /* 2 entries */, 32768) = 48 [pid 5220] getdents64(4, 0x55558698f730 /* 0 entries */, 32768) = 0 [ 83.232259][ T5276] done [pid 5220] close(4 [pid 5273] exit_group(0 [pid 5220] <... close resumed>) = 0 [pid 5273] <... exit_group resumed>) = ? [pid 5220] rmdir("./0/file0" [pid 5274] <... close resumed>) = 0 [pid 5273] +++ exited with 0 +++ [pid 5220] <... rmdir resumed>) = 0 [pid 5220] getdents64(3, [pid 5222] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5273, si_uid=0, si_status=0, si_utime=9 /* 0.09 s */, si_stime=34 /* 0.34 s */} --- [pid 5220] <... getdents64 resumed>0x5555869876f0 /* 0 entries */, 32768) = 0 [pid 5222] restart_syscall(<... resuming interrupted clone ...>) = 0 [pid 5220] close(3) = 0 [pid 5274] openat(AT_FDCWD, "cpuacct.usage_percpu_sys", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000 [pid 5222] umount2("./1", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5220] rmdir("./0" [pid 5222] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5274] <... openat resumed>) = 3 [pid 5222] openat(AT_FDCWD, "./1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 5220] <... rmdir resumed>) = 0 [pid 5274] exit_group(0 [pid 5222] newfstatat(3, "", [pid 5220] mkdir("./1", 0777 [pid 5222] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5222] getdents64(3, 0x5555869876f0 /* 5 entries */, 32768) = 160 [pid 5222] umount2("./1/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5222] newfstatat(AT_FDCWD, "./1/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5222] unlink("./1/binderfs") = 0 [pid 5222] umount2("./1/file0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5222] newfstatat(AT_FDCWD, "./1/file0", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5222] umount2("./1/file0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5222] openat(AT_FDCWD, "./1/file0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5220] <... mkdir resumed>) = 0 [pid 5274] <... exit_group resumed>) = ? [pid 5222] <... openat resumed>) = 4 [pid 5222] newfstatat(4, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5222] getdents64(4, [pid 5274] +++ exited with 0 +++ [pid 5222] <... getdents64 resumed>0x55558698f730 /* 2 entries */, 32768) = 48 [pid 5220] openat(AT_FDCWD, "/dev/loop0", O_RDWR [pid 5223] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5274, si_uid=0, si_status=0, si_utime=6 /* 0.06 s */, si_stime=36 /* 0.36 s */} --- [pid 5222] getdents64(4, [pid 5223] restart_syscall(<... resuming interrupted clone ...> [pid 5222] <... getdents64 resumed>0x55558698f730 /* 0 entries */, 32768) = 0 [pid 5220] <... openat resumed>) = 3 [pid 5222] close(4 [pid 5220] ioctl(3, LOOP_CLR_FD [pid 5222] <... close resumed>) = 0 [pid 5222] rmdir("./1/file0" [pid 5276] <... mount resumed>) = 0 [pid 5223] <... restart_syscall resumed>) = 0 [pid 5222] <... rmdir resumed>) = 0 [pid 5220] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5276] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY [pid 5220] close(3) = 0 [pid 5223] umount2("./1", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5223] openat(AT_FDCWD, "./1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 5223] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5223] getdents64(3, 0x5555869876f0 /* 5 entries */, 32768) = 160 [pid 5223] umount2("./1/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5223] newfstatat(AT_FDCWD, "./1/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5223] unlink("./1/binderfs") = 0 [pid 5223] umount2("./1/file0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5223] newfstatat(AT_FDCWD, "./1/file0", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5222] umount2("./1/cpuacct.usage_percpu_sys", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5220] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5222] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5223] umount2("./1/file0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5223] openat(AT_FDCWD, "./1/file0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY [pid 5222] newfstatat(AT_FDCWD, "./1/cpuacct.usage_percpu_sys", ./strace-static-x86_64: Process 5308 attached [pid 5276] <... openat resumed>) = 3 [pid 5223] <... openat resumed>) = 4 [pid 5222] <... newfstatat resumed>{st_mode=S_IFREG|000, st_size=0, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5220] <... clone resumed>, child_tidptr=0x555586986650) = 5308 [pid 5276] chdir("./file0" [ 83.262524][ T5276] bcachefs (loop1): going read-write [ 83.276878][ T5276] bcachefs (loop1): done starting filesystem [pid 5222] unlink("./1/cpuacct.usage_percpu_sys" [pid 5276] <... chdir resumed>) = 0 [pid 5308] set_robust_list(0x555586986660, 24 [pid 5223] newfstatat(4, "", [pid 5222] <... unlink resumed>) = 0 [pid 5308] <... set_robust_list resumed>) = 0 [pid 5223] <... newfstatat resumed>{st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5222] getdents64(3, [pid 5308] chdir("./1" [pid 5222] <... getdents64 resumed>0x5555869876f0 /* 0 entries */, 32768) = 0 [pid 5308] <... chdir resumed>) = 0 [pid 5222] close(3 [pid 5308] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5276] openat(AT_FDCWD, "/dev/loop1", O_RDWR [pid 5223] getdents64(4, [pid 5222] <... close resumed>) = 0 [pid 5308] setpgid(0, 0 [pid 5276] <... openat resumed>) = 4 [pid 5308] <... setpgid resumed>) = 0 [pid 5222] rmdir("./1" [pid 5276] ioctl(4, LOOP_CLR_FD [pid 5308] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5223] <... getdents64 resumed>0x55558698f730 /* 2 entries */, 32768) = 48 [pid 5223] getdents64(4, [pid 5222] <... rmdir resumed>) = 0 [pid 5276] <... ioctl resumed>) = 0 [pid 5308] <... openat resumed>) = 3 [pid 5223] <... getdents64 resumed>0x55558698f730 /* 0 entries */, 32768) = 0 [pid 5308] write(3, "1000", 4 [pid 5276] close(4 [pid 5223] close(4 [pid 5222] mkdir("./2", 0777 [pid 5276] <... close resumed>) = 0 [pid 5223] <... close resumed>) = 0 [pid 5223] rmdir("./1/file0" [pid 5276] openat(AT_FDCWD, "cpuacct.usage_percpu_sys", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000 [pid 5223] <... rmdir resumed>) = 0 [pid 5222] <... mkdir resumed>) = 0 [pid 5223] umount2("./1/cpuacct.usage_percpu_sys", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5222] openat(AT_FDCWD, "/dev/loop2", O_RDWR [pid 5223] <... umount2 resumed>) = -1 EINVAL (Invalid argument) [pid 5223] newfstatat(AT_FDCWD, "./1/cpuacct.usage_percpu_sys", {st_mode=S_IFREG|000, st_size=0, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5223] unlink("./1/cpuacct.usage_percpu_sys") = 0 [pid 5276] <... openat resumed>) = 4 [pid 5223] getdents64(3, [pid 5222] <... openat resumed>) = 3 [pid 5223] <... getdents64 resumed>0x5555869876f0 /* 0 entries */, 32768) = 0 [pid 5222] ioctl(3, LOOP_CLR_FD [pid 5308] <... write resumed>) = 4 [pid 5223] close(3 [pid 5308] close(3 [pid 5223] <... close resumed>) = 0 [pid 5222] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5308] <... close resumed>) = 0 [pid 5223] rmdir("./1" [pid 5308] symlink("/dev/binderfs", "./binderfs" [pid 5223] <... rmdir resumed>) = 0 [pid 5222] close(3 [pid 5223] mkdir("./2", 0777 [pid 5222] <... close resumed>) = 0 [pid 5223] <... mkdir resumed>) = 0 [pid 5308] <... symlink resumed>) = 0 [pid 5276] exit_group(0 [pid 5222] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5308] write(1, "executing program\n", 18 [pid 5276] <... exit_group resumed>) = ? executing program ./strace-static-x86_64: Process 5309 attached [pid 5308] <... write resumed>) = 18 [pid 5276] +++ exited with 0 +++ [pid 5223] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = 3 [pid 5308] memfd_create("syzkaller", 0 [pid 5223] ioctl(3, LOOP_CLR_FD [pid 5221] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5276, si_uid=0, si_status=0, si_utime=7 /* 0.07 s */, si_stime=42 /* 0.42 s */} --- [pid 5309] set_robust_list(0x555586986660, 24 [pid 5308] <... memfd_create resumed>) = 3 [pid 5222] <... clone resumed>, child_tidptr=0x555586986650) = 5309 [pid 5309] <... set_robust_list resumed>) = 0 [pid 5308] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5309] chdir("./2" [pid 5308] <... mmap resumed>) = 0x7ff942000000 [pid 5223] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5221] restart_syscall(<... resuming interrupted clone ...> [pid 5309] <... chdir resumed>) = 0 [pid 5223] close(3) = 0 [pid 5223] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5310 attached , child_tidptr=0x555586986650) = 5310 [pid 5221] <... restart_syscall resumed>) = 0 [pid 5221] umount2("./1", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5221] openat(AT_FDCWD, "./1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 5221] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5221] getdents64(3, 0x5555869876f0 /* 4 entries */, 32768) = 112 [pid 5221] umount2("./1/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5221] newfstatat(AT_FDCWD, "./1/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5310] set_robust_list(0x555586986660, 24 [pid 5309] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5221] unlink("./1/binderfs" [pid 5310] <... set_robust_list resumed>) = 0 [pid 5309] <... prctl resumed>) = 0 [pid 5310] chdir("./2" [pid 5309] setpgid(0, 0 [pid 5221] <... unlink resumed>) = 0 [pid 5310] <... chdir resumed>) = 0 [pid 5309] <... setpgid resumed>) = 0 [pid 5221] umount2("./1/file0", MNT_FORCE|UMOUNT_NOFOLLOW [pid 5309] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5310] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5309] <... openat resumed>) = 3 [pid 5309] write(3, "1000", 4 [pid 5310] setpgid(0, 0 [pid 5309] <... write resumed>) = 4 [pid 5310] <... setpgid resumed>) = 0 [pid 5310] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC) = 3 [pid 5309] close(3 [pid 5310] write(3, "1000", 4 [pid 5309] <... close resumed>) = 0 [pid 5310] <... write resumed>) = 4 [pid 5309] symlink("/dev/binderfs", "./binderfs" [pid 5310] close(3) = 0 [pid 5309] <... symlink resumed>) = 0 [pid 5310] symlink("/dev/binderfs", "./binderfs" [pid 5309] write(1, "executing program\n", 18executing program [pid 5310] <... symlink resumed>) = 0 [pid 5309] <... write resumed>) = 18 executing program [pid 5309] memfd_create("syzkaller", 0 [pid 5310] write(1, "executing program\n", 18 [pid 5309] <... memfd_create resumed>) = 3 [pid 5310] <... write resumed>) = 18 [pid 5309] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5310] memfd_create("syzkaller", 0 [pid 5309] <... mmap resumed>) = 0x7ff942000000 [pid 5310] <... memfd_create resumed>) = 3 [pid 5275] <... close resumed>) = 0 [pid 5310] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7ff942000000 [ 83.423630][ T5221] bcachefs (loop1): shutting down [ 83.428713][ T5221] bcachefs (loop1): going read-only [pid 5275] openat(AT_FDCWD, "cpuacct.usage_percpu_sys", O_RDWR|O_CREAT|O_NOCTTY|O_TRUNC|O_APPEND|FASYNC|0x18, 000) = 3 [pid 5275] exit_group(0) = ? [pid 5275] +++ exited with 0 +++ [pid 5224] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5275, si_uid=0, si_status=0, si_utime=8 /* 0.08 s */, si_stime=36 /* 0.36 s */} --- [pid 5224] restart_syscall(<... resuming interrupted clone ...>) = 0 [pid 5224] umount2("./1", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5224] openat(AT_FDCWD, "./1", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 5224] newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5224] getdents64(3, 0x5555869876f0 /* 5 entries */, 32768) = 160 [pid 5224] umount2("./1/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5224] newfstatat(AT_FDCWD, "./1/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5224] unlink("./1/binderfs") = 0 [pid 5224] umount2("./1/file0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [ 83.474052][ T5221] bcachefs (loop1): finished waiting for writes to stop [ 83.486867][ T5221] bcachefs (loop1): flushing journal and stopping allocators, journal seq 12 [pid 5224] newfstatat(AT_FDCWD, "./1/file0", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5224] umount2("./1/file0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5224] openat(AT_FDCWD, "./1/file0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 4 [pid 5224] newfstatat(4, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 [pid 5224] getdents64(4, 0x55558698f730 /* 2 entries */, 32768) = 48 [pid 5224] getdents64(4, 0x55558698f730 /* 0 entries */, 32768) = 0 [pid 5224] close(4) = 0 [pid 5224] rmdir("./1/file0") = 0 [pid 5224] umount2("./1/cpuacct.usage_percpu_sys", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) [pid 5224] newfstatat(AT_FDCWD, "./1/cpuacct.usage_percpu_sys", {st_mode=S_IFREG|000, st_size=0, ...}, AT_SYMLINK_NOFOLLOW) = 0 [pid 5224] unlink("./1/cpuacct.usage_percpu_sys") = 0 [pid 5224] getdents64(3, 0x5555869876f0 /* 0 entries */, 32768) = 0 [pid 5224] close(3) = 0 [pid 5224] rmdir("./1") = 0 [pid 5224] mkdir("./2", 0777) = 0 [pid 5224] openat(AT_FDCWD, "/dev/loop4", O_RDWR) = 3 [ 83.529727][ T5221] bcachefs (loop1): flushing journal and stopping allocators complete, journal seq 13 [ 83.554619][ T11] bcachefs (loop1): bch2_write_super(): fatal error loop1: Superblock write was silently dropped! (seq 0 expected 54) [ 83.568606][ T5221] bcachefs (loop1): unshutdown complete, journal seq 14 [pid 5224] ioctl(3, LOOP_CLR_FD) = -1 ENXIO (No such device or address) [pid 5224] close(3) = 0 [pid 5224] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5311 attached , child_tidptr=0x555586986650) = 5311 [pid 5311] set_robust_list(0x555586986660, 24) = 0 [pid 5311] chdir("./2") = 0 [pid 5311] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5311] setpgid(0, 0) = 0 [pid 5311] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC) = 3 [pid 5311] write(3, "1000", 4) = 4 [pid 5311] close(3) = 0 [pid 5311] symlink("/dev/binderfs", "./binderfs") = 0 [pid 5311] write(1, "executing program\n", 18executing program ) = 18 [pid 5311] memfd_create("syzkaller", 0) = 3 [pid 5311] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7ff942000000 [ 83.599579][ T11] bcachefs (loop1): fatal error - emergency read only [ 83.637438][ T11] ------------[ cut here ]------------ [ 83.643085][ T11] kernel BUG at fs/bcachefs/journal.h:375! [ 83.673762][ T11] Oops: invalid opcode: 0000 [#1] PREEMPT SMP KASAN PTI [ 83.680754][ T11] CPU: 1 UID: 0 PID: 11 Comm: kworker/u8:0 Not tainted 6.12.0-rc3-syzkaller-00420-g715ca9dd687f #0 [ 83.691432][ T11] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/13/2024 [ 83.701492][ T11] Workqueue: btree_update btree_interior_update_work [ 83.708194][ T11] RIP: 0010:__bch2_trans_commit+0x9232/0x93c0 [ 83.714273][ T11] Code: fd 90 0f 0b e8 3f bb 78 fd 90 0f 0b e8 37 bb 78 fd 90 0f 0b e8 2f bb 78 fd 90 0f 0b e8 27 bb 78 fd 90 0f 0b e8 1f bb 78 fd 90 <0f> 0b e8 17 bb 78 fd 90 0f 0b e8 0f bb 78 fd 90 0f 0b e8 07 bb 78 [ 83.733904][ T11] RSP: 0018:ffffc900001076c0 EFLAGS: 00010293 [ 83.739999][ T11] RAX: ffffffff841c2c91 RBX: 0000000000000000 RCX: ffff88801cebbc00 [ 83.747985][ T11] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000 [ 83.755968][ T11] RBP: ffffc90000107890 R08: ffffffff841bcfc8 R09: 1ffff1100cd494a8 [ 83.763962][ T11] R10: dffffc0000000000 R11: ffffed100cd494a9 R12: ffff888066a00000 [ 83.771945][ T11] R13: ffff888066a4a500 R14: 0000000000000044 R15: ffff88803060c0d0 [ 83.779957][ T11] FS: 0000000000000000(0000) GS:ffff8880b8700000(0000) knlGS:0000000000000000 [ 83.788901][ T11] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 83.795493][ T11] CR2: 00007ff942fe8000 CR3: 000000007bcb8000 CR4: 00000000003526f0 [ 83.803483][ T11] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [ 83.811467][ T11] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [ 83.819456][ T11] Call Trace: [ 83.822739][ T11] [ 83.825674][ T11] ? __die_body+0x5f/0xb0 [ 83.830014][ T11] ? die+0x9e/0xc0 [ 83.833744][ T11] ? do_trap+0x15a/0x3a0 [ 83.838003][ T11] ? __bch2_trans_commit+0x9232/0x93c0 [ 83.843475][ T11] ? do_error_trap+0x1dc/0x2c0 [ 83.848246][ T11] ? __bch2_trans_commit+0x9232/0x93c0 [ 83.853732][ T11] ? __pfx_do_error_trap+0x10/0x10 [ 83.858856][ T11] ? report_bug+0x3e8/0x500 [ 83.863392][ T11] ? handle_invalid_op+0x34/0x40 [ 83.868353][ T11] ? __bch2_trans_commit+0x9232/0x93c0 [ 83.873826][ T11] ? exc_invalid_op+0x38/0x50 [ 83.878515][ T11] ? asm_exc_invalid_op+0x1a/0x20 [ 83.883547][ T11] ? __bch2_trans_commit+0x3568/0x93c0 [ 83.889016][ T11] ? __bch2_trans_commit+0x9231/0x93c0 [ 83.894488][ T11] ? __bch2_trans_commit+0x9232/0x93c0 [ 83.899974][ T11] ? __pfx___bch2_trans_commit+0x10/0x10 [ 83.905618][ T11] ? bch2_dev_btree_bitmap_marked+0x2f/0xda0 [ 83.911618][ T11] ? __bch2_trans_jset_entry_alloc+0x2c7/0x4b0 [ 83.917799][ T11] ? btree_interior_update_work+0x117a/0x2b10 [ 83.923884][ T11] btree_interior_update_work+0x1492/0x2b10 [ 83.929811][ T11] ? __pfx_btree_interior_update_work+0x10/0x10 [ 83.936075][ T11] ? __pfx_lock_acquire+0x10/0x10 [ 83.941111][ T11] ? lockdep_hardirqs_on_prepare+0x43d/0x780 [ 83.947108][ T11] ? __pfx_lockdep_hardirqs_on_prepare+0x10/0x10 [ 83.953559][ T11] ? process_scheduled_works+0x976/0x1850 [ 83.959298][ T11] process_scheduled_works+0xa63/0x1850 [ 83.964865][ T11] ? __pfx_process_scheduled_works+0x10/0x10 [ 83.970860][ T11] ? assign_work+0x364/0x3d0 [ 83.975462][ T11] worker_thread+0x870/0xd30 [ 83.980075][ T11] ? __kthread_parkme+0x169/0x1d0 [ 83.985116][ T11] ? __pfx_worker_thread+0x10/0x10 [ 83.990245][ T11] kthread+0x2f0/0x390 [ 83.994326][ T11] ? __pfx_worker_thread+0x10/0x10 [ 83.999553][ T11] ? __pfx_kthread+0x10/0x10 [ 84.004152][ T11] ret_from_fork+0x4b/0x80 [ 84.008014][ T5308] loop0: detected capacity change from 0 to 32768 [ 84.008568][ T11] ? __pfx_kthread+0x10/0x10 [ 84.019551][ T11] ret_from_fork_asm+0x1a/0x30 [pid 5308] 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 5310] 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 5308] <... write resumed>) = 16777216 [pid 5311] 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 5308] munmap(0x7ff942000000, 138412032) = 0 [pid 5308] openat(AT_FDCWD, "/dev/loop0", O_RDWR) = 4 [pid 5308] ioctl(4, LOOP_SET_FD, 3) = 0 [pid 5308] close(3) = 0 [pid 5308] close(4) = 0 [pid 5309] 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 5308] mkdir("./file0", 0777) = 0 [ 84.024337][ T11] [ 84.027359][ T11] Modules linked in: [ 84.031452][ T11] ---[ end trace 0000000000000000 ]--- [ 84.039943][ T11] RIP: 0010:__bch2_trans_commit+0x9232/0x93c0 [pid 5308] mount("/dev/loop0", "./file0", "bcachefs", MS_POSIXACL, "fsck,inline_data,nocow,degraded,str_hash=siphash,norecovery,discard,reconstruct_alloc,erasure_code,a"... [pid 5310] <... write resumed>) = 16777216 [pid 5310] munmap(0x7ff942000000, 138412032) = 0 [ 84.083568][ T11] Code: fd 90 0f 0b e8 3f bb 78 fd 90 0f 0b e8 37 bb 78 fd 90 0f 0b e8 2f bb 78 fd 90 0f 0b e8 27 bb 78 fd 90 0f 0b e8 1f bb 78 fd 90 <0f> 0b e8 17 bb 78 fd 90 0f 0b e8 0f bb 78 fd 90 0f 0b e8 07 bb 78 [ 84.102550][ T5308] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 84.127571][ T11] RSP: 0018:ffffc900001076c0 EFLAGS: 00010293 [pid 5310] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = 4 [pid 5310] ioctl(4, LOOP_SET_FD, 3 [pid 5309] <... write resumed>) = 16777216 [pid 5310] <... ioctl resumed>) = 0 [pid 5309] munmap(0x7ff942000000, 138412032 [pid 5310] close(3) = 0 [pid 5310] close(4) = 0 [pid 5310] mkdir("./file0", 0777) = 0 [pid 5310] mount("/dev/loop3", "./file0", "bcachefs", MS_POSIXACL, "fsck,inline_data,nocow,degraded,str_hash=siphash,norecovery,discard,reconstruct_alloc,erasure_code,a"... [pid 5309] <... munmap resumed>) = 0 [pid 5309] openat(AT_FDCWD, "/dev/loop2", O_RDWR) = 4 [ 84.134534][ T5310] loop3: detected capacity change from 0 to 32768 [ 84.143933][ T5308] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 84.152757][ T11] RAX: ffffffff841c2c91 RBX: 0000000000000000 RCX: ffff88801cebbc00 [ 84.162348][ T11] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000 [pid 5309] ioctl(4, LOOP_SET_FD, 3) = 0 [pid 5309] close(3) = 0 [pid 5309] close(4) = 0 [pid 5309] mkdir("./file0", 0777) = 0 [pid 5309] mount("/dev/loop2", "./file0", "bcachefs", MS_POSIXACL, "fsck,inline_data,nocow,degraded,str_hash=siphash,norecovery,discard,reconstruct_alloc,erasure_code,a"... [pid 5311] <... write resumed>) = 16777216 [pid 5311] munmap(0x7ff942000000, 138412032) = 0 [ 84.184291][ T5309] loop2: detected capacity change from 0 to 32768 [ 84.189747][ T11] RBP: ffffc90000107890 R08: ffffffff841bcfc8 R09: 1ffff1100cd494a8 [ 84.215422][ T11] R10: dffffc0000000000 R11: ffffed100cd494a9 R12: ffff888066a00000 [pid 5311] openat(AT_FDCWD, "/dev/loop4", O_RDWR) = 4 [ 84.230611][ T11] R13: ffff888066a4a500 R14: 0000000000000044 R15: ffff88803060c0d0 [ 84.239128][ T11] FS: 0000000000000000(0000) GS:ffff8880b8600000(0000) knlGS:0000000000000000 [ 84.248820][ T11] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 84.257783][ T5311] loop4: detected capacity change from 0 to 32768 [ 84.272151][ T5310] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [pid 5311] ioctl(4, LOOP_SET_FD, 3) = 0 [pid 5311] close(3) = 0 [pid 5311] close(4) = 0 [pid 5311] mkdir("./file0", 0777) = 0 [ 84.281819][ T11] CR2: 00007ff942fff000 CR3: 000000002ce04000 CR4: 00000000003526f0 [ 84.283676][ T5310] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): shutdown complete [ 84.299978][ T11] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [ 84.309078][ T11] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [ 84.319760][ T5309] bcachefs (da441363-bb6a-4ab9-999b-c1f40db4fee2): filesystem UUID already open [ 84.325688][ T11] Kernel panic - not syncing: Fatal exception [ 84.328895][ T11] Kernel Offset: disabled