./strace-static-x86_64 -e \!wait4,clock_nanosleep,nanosleep -s 100 -x -f ./syz-executor1670482997 <...> Warning: Permanently added '10.128.1.163' (ED25519) to the list of known hosts. execve("./syz-executor1670482997", ["./syz-executor1670482997"], 0x7ffd91c7f400 /* 10 vars */) = 0 brk(NULL) = 0x55558c9c8000 brk(0x55558c9c8e00) = 0x55558c9c8e00 arch_prctl(ARCH_SET_FS, 0x55558c9c8480) = 0 set_tid_address(0x55558c9c8750) = 5820 set_robust_list(0x55558c9c8760, 24) = 0 rseq(0x55558c9c8da0, 0x20, 0, 0x53053053) = 0 prlimit64(0, RLIMIT_STACK, NULL, {rlim_cur=8192*1024, rlim_max=RLIM64_INFINITY}) = 0 readlink("/proc/self/exe", "/root/syz-executor1670482997", 4096) = 28 getrandom("\xc5\x57\x8e\xb1\xff\xad\xb0\x1b", 8, GRND_NONBLOCK) = 8 brk(NULL) = 0x55558c9c8e00 brk(0x55558c9e9e00) = 0x55558c9e9e00 brk(0x55558c9ea000) = 0x55558c9ea000 mprotect(0x7f4673bd0000, 16384, PROT_READ) = 0 mmap(0x1ffffffff000, 4096, PROT_NONE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x1ffffffff000 mmap(0x200000000000, 16777216, PROT_READ|PROT_WRITE|PROT_EXEC, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x200000000000 mmap(0x200001000000, 4096, PROT_NONE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x200001000000 clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5821 attached [pid 5821] set_robust_list(0x55558c9c8760, 24 [pid 5820] <... clone resumed>, child_tidptr=0x55558c9c8750) = 5821 [pid 5821] <... set_robust_list resumed>) = 0 [pid 5820] openat(AT_FDCWD, "/sys/kernel/debug/x86/nmi_longest_ns", O_WRONLY|O_CLOEXEC) = 3 [pid 5820] write(3, "10000000000", 11) = 11 [pid 5820] close(3) = 0 [pid 5820] openat(AT_FDCWD, "/proc/sys/kernel/hung_task_check_interval_secs", O_WRONLY|O_CLOEXEC) = 3 [pid 5820] write(3, "20", 2) = 2 [pid 5820] close(3) = 0 [pid 5820] openat(AT_FDCWD, "/proc/sys/net/core/bpf_jit_kallsyms", O_WRONLY|O_CLOEXEC) = 3 [pid 5820] write(3, "1", 1) = 1 [pid 5820] close(3) = 0 [pid 5820] openat(AT_FDCWD, "/proc/sys/net/core/bpf_jit_harden", O_WRONLY|O_CLOEXEC) = 3 [pid 5820] write(3, "0", 1) = 1 [pid 5820] close(3) = 0 [pid 5820] openat(AT_FDCWD, "/proc/sys/kernel/kptr_restrict", O_WRONLY|O_CLOEXEC) = 3 [pid 5820] write(3, "0", 1) = 1 [pid 5820] close(3) = 0 [pid 5820] openat(AT_FDCWD, "/proc/sys/kernel/softlockup_all_cpu_backtrace", O_WRONLY|O_CLOEXEC) = 3 [pid 5820] write(3, "1", 1) = 1 [pid 5820] close(3) = 0 [pid 5820] openat(AT_FDCWD, "/proc/sys/fs/mount-max", O_WRONLY|O_CLOEXEC) = 3 [pid 5820] write(3, "100", 3) = 3 [pid 5820] close(3) = 0 [pid 5820] openat(AT_FDCWD, "/proc/sys/vm/oom_dump_tasks", O_WRONLY|O_CLOEXEC) = 3 [pid 5820] write(3, "0", 1) = 1 [pid 5820] close(3) = 0 [pid 5820] openat(AT_FDCWD, "/proc/sys/debug/exception-trace", O_WRONLY|O_CLOEXEC) = 3 [pid 5820] write(3, "0", 1) = 1 [pid 5820] close(3) = 0 [pid 5820] openat(AT_FDCWD, "/proc/sys/kernel/printk", O_WRONLY|O_CLOEXEC) = 3 [pid 5820] write(3, "7 4 1 3", 7) = 7 [pid 5820] close(3) = 0 [pid 5820] openat(AT_FDCWD, "/proc/sys/kernel/keys/gc_delay", O_WRONLY|O_CLOEXEC) = 3 [pid 5820] write(3, "1", 1) = 1 [pid 5820] close(3) = 0 [pid 5820] openat(AT_FDCWD, "/proc/sys/vm/oom_kill_allocating_task", O_WRONLY|O_CLOEXEC) = 3 [pid 5820] write(3, "1", 1) = 1 [pid 5820] close(3) = 0 [pid 5820] openat(AT_FDCWD, "/proc/sys/kernel/ctrl-alt-del", O_WRONLY|O_CLOEXEC) = 3 [pid 5820] write(3, "0", 1) = 1 [pid 5820] close(3) = 0 [pid 5820] openat(AT_FDCWD, "/proc/sys/kernel/cad_pid", O_WRONLY|O_CLOEXEC) = 3 [pid 5820] write(3, "5821", 4) = 4 [pid 5820] close(3) = 0 [pid 5820] kill(5821, SIGKILL) = 0 [pid 5821] +++ killed by SIGKILL +++ --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_KILLED, si_pid=5821, si_uid=0, si_status=SIGKILL, si_utime=0, si_stime=0} --- rt_sigaction(SIGRTMIN, {sa_handler=SIG_IGN, sa_mask=[], sa_flags=0}, NULL, 8) = 0 rt_sigaction(SIGRT_1, {sa_handler=SIG_IGN, sa_mask=[], sa_flags=0}, NULL, 8) = 0 rt_sigaction(SIGSEGV, {sa_handler=0x7f4673b21df0, sa_mask=[], sa_flags=SA_RESTORER|SA_NODEFER|SA_SIGINFO, sa_restorer=0x7f4673b2a030}, NULL, 8) = 0 rt_sigaction(SIGBUS, {sa_handler=0x7f4673b21df0, sa_mask=[], sa_flags=SA_RESTORER|SA_NODEFER|SA_SIGINFO, sa_restorer=0x7f4673b2a030}, NULL, 8) = 0 clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x55558c9c8750) = 5822 ./strace-static-x86_64: Process 5822 attached [pid 5820] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5822] set_robust_list(0x55558c9c8760, 24./strace-static-x86_64: Process 5823 attached [pid 5820] <... clone resumed>, child_tidptr=0x55558c9c8750) = 5823 [pid 5822] <... set_robust_list resumed>) = 0 [pid 5820] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5822] openat(AT_FDCWD, "/dev/loop0", O_RDWR [pid 5823] set_robust_list(0x55558c9c8760, 24./strace-static-x86_64: Process 5824 attached ) = 0 [pid 5822] <... openat resumed>) = 3 [pid 5824] set_robust_list(0x55558c9c8760, 24) = 0 [pid 5823] openat(AT_FDCWD, "/dev/loop1", O_RDWR [pid 5820] <... clone resumed>, child_tidptr=0x55558c9c8750) = 5824 [pid 5824] openat(AT_FDCWD, "/dev/loop2", O_RDWR [pid 5822] ioctl(3, LOOP_CLR_FD [pid 5820] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5823] <... openat resumed>) = 3 [pid 5822] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5824] <... openat resumed>) = 3 ./strace-static-x86_64: Process 5825 attached [pid 5823] ioctl(3, LOOP_CLR_FD [pid 5822] close(3 [pid 5820] <... clone resumed>, child_tidptr=0x55558c9c8750) = 5825 [pid 5825] set_robust_list(0x55558c9c8760, 24 [pid 5824] ioctl(3, LOOP_CLR_FD [pid 5823] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5820] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5822] <... close resumed>) = 0 [pid 5825] <... set_robust_list resumed>) = 0 [pid 5824] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5825] openat(AT_FDCWD, "/dev/loop3", O_RDWR [pid 5822] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5826 attached [pid 5823] close(3) = 0 ./strace-static-x86_64: Process 5827 attached [pid 5826] set_robust_list(0x55558c9c8760, 24 [pid 5825] <... openat resumed>) = 3 [pid 5824] close(3 [pid 5823] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5822] <... clone resumed>, child_tidptr=0x55558c9c8750) = 5827 [pid 5820] <... clone resumed>, child_tidptr=0x55558c9c8750) = 5826 [pid 5827] set_robust_list(0x55558c9c8760, 24 [pid 5826] <... set_robust_list resumed>) = 0 [pid 5825] ioctl(3, LOOP_CLR_FD [pid 5824] <... close resumed>) = 0 [pid 5827] <... set_robust_list resumed>) = 0 [pid 5826] openat(AT_FDCWD, "/dev/loop4", O_RDWR [pid 5825] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5824] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5828 attached [pid 5827] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5825] close(3 [pid 5828] set_robust_list(0x55558c9c8760, 24 [pid 5827] <... prctl resumed>) = 0 [pid 5827] setpgid(0, 0 [pid 5828] <... set_robust_list resumed>) = 0 [pid 5827] <... setpgid resumed>) = 0 ./strace-static-x86_64: Process 5829 attached [pid 5827] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5828] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5826] <... openat resumed>) = 3 [pid 5829] set_robust_list(0x55558c9c8760, 24 [pid 5828] <... prctl resumed>) = 0 [pid 5827] <... openat resumed>) = 3 [pid 5825] <... close resumed>) = 0 [pid 5823] <... clone resumed>, child_tidptr=0x55558c9c8750) = 5828 [pid 5829] <... set_robust_list resumed>) = 0 [pid 5828] setpgid(0, 0 [pid 5825] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5829] prctl(PR_SET_PDEATHSIG, SIGKILL./strace-static-x86_64: Process 5831 attached ) = 0 [pid 5829] setpgid(0, 0) = 0 [pid 5831] set_robust_list(0x55558c9c8760, 24 [pid 5829] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5831] <... set_robust_list resumed>) = 0 [pid 5831] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5825] <... clone resumed>, child_tidptr=0x55558c9c8750) = 5831 [pid 5829] <... openat resumed>) = 3 [pid 5831] <... prctl resumed>) = 0 [pid 5831] setpgid(0, 0) = 0 [pid 5831] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5829] write(3, "1000", 4) = 4 [pid 5829] close(3) = 0 executing program [pid 5829] write(1, "executing program\n", 18 [pid 5831] <... openat resumed>) = 3 [pid 5828] <... setpgid resumed>) = 0 [pid 5827] write(3, "1000", 4 [pid 5826] ioctl(3, LOOP_CLR_FD [pid 5824] <... clone resumed>, child_tidptr=0x55558c9c8750) = 5829 [pid 5829] <... write resumed>) = 18 [pid 5829] memfd_create("syzkaller", 0 [pid 5831] write(3, "1000", 4 [pid 5828] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC [pid 5827] <... write resumed>) = 4 [pid 5826] <... ioctl resumed>) = -1 ENXIO (No such device or address) [pid 5831] <... write resumed>) = 4 [pid 5828] <... openat resumed>) = 3 [pid 5831] close(3 [pid 5827] close(3 [pid 5826] close(3 [pid 5828] write(3, "1000", 4 [pid 5827] <... close resumed>) = 0 [pid 5828] <... write resumed>) = 4 executing program [pid 5827] write(1, "executing program\n", 18 [pid 5826] <... close resumed>) = 0 [pid 5828] close(3 [pid 5827] <... write resumed>) = 18 [pid 5826] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5828] <... close resumed>) = 0 ./strace-static-x86_64: Process 5834 attached [pid 5831] <... close resumed>) = 0 [pid 5828] write(1, "executing program\n", 18 [pid 5827] memfd_create("syzkaller", 0executing program executing program [pid 5831] write(1, "executing program\n", 18 [pid 5829] <... memfd_create resumed>) = 3 [pid 5828] <... write resumed>) = 18 [pid 5826] <... clone resumed>, child_tidptr=0x55558c9c8750) = 5834 [pid 5829] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5831] <... write resumed>) = 18 [pid 5829] <... mmap resumed>) = 0x7f466b600000 [pid 5834] set_robust_list(0x55558c9c8760, 24 [pid 5831] memfd_create("syzkaller", 0 [pid 5828] memfd_create("syzkaller", 0 [pid 5827] <... memfd_create resumed>) = 3 [pid 5834] <... set_robust_list resumed>) = 0 [pid 5827] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5831] <... memfd_create resumed>) = 3 [pid 5834] prctl(PR_SET_PDEATHSIG, SIGKILL [pid 5831] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f466b600000 [pid 5834] <... prctl resumed>) = 0 [pid 5828] <... memfd_create resumed>) = 3 [pid 5827] <... mmap resumed>) = 0x7f466b600000 [pid 5834] setpgid(0, 0 [pid 5828] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 [pid 5834] <... setpgid resumed>) = 0 [pid 5828] <... mmap resumed>) = 0x7f466b600000 [pid 5834] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC) = 3 [pid 5834] write(3, "1000", 4) = 4 [pid 5834] close(3) = 0 [pid 5834] write(1, "executing program\n", 18executing program ) = 18 [pid 5834] memfd_create("syzkaller", 0) = 3 [pid 5834] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f466b600000 [pid 5827] 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 5834] 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 5831] 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 5829] 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 5828] 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 5827] <... write resumed>) = 16777216 [pid 5831] <... write resumed>) = 16777216 [pid 5831] munmap(0x7f466b600000, 138412032 [pid 5834] <... write resumed>) = 16777216 [pid 5827] munmap(0x7f466b600000, 138412032 [pid 5829] <... write resumed>) = 16777216 [pid 5829] munmap(0x7f466b600000, 138412032 [pid 5827] <... munmap resumed>) = 0 [pid 5831] <... munmap resumed>) = 0 [pid 5834] munmap(0x7f466b600000, 138412032 [pid 5831] openat(AT_FDCWD, "/dev/loop3", O_RDWR [pid 5829] <... munmap resumed>) = 0 [pid 5828] <... write resumed>) = 16777216 [pid 5827] openat(AT_FDCWD, "/dev/loop0", O_RDWR [pid 5831] <... openat resumed>) = 4 [pid 5828] munmap(0x7f466b600000, 138412032 [pid 5834] <... munmap resumed>) = 0 [pid 5831] ioctl(4, LOOP_SET_FD, 3 [pid 5829] openat(AT_FDCWD, "/dev/loop2", O_RDWR [pid 5827] <... openat resumed>) = 4 [pid 5829] <... openat resumed>) = 4 [pid 5834] openat(AT_FDCWD, "/dev/loop4", O_RDWR [pid 5829] ioctl(4, LOOP_SET_FD, 3 [pid 5828] <... munmap resumed>) = 0 [pid 5827] ioctl(4, LOOP_SET_FD, 3 [pid 5831] <... ioctl resumed>) = 0 [pid 5831] close(3 [pid 5834] <... openat resumed>) = 4 [pid 5831] <... close resumed>) = 0 [pid 5834] ioctl(4, LOOP_SET_FD, 3 [pid 5831] close(4) = 0 [pid 5828] openat(AT_FDCWD, "/dev/loop1", O_RDWR [pid 5831] mkdir("./file1", 0777 [pid 5828] <... openat resumed>) = 4 [pid 5828] ioctl(4, LOOP_SET_FD, 3 [pid 5831] <... mkdir resumed>) = 0 [ 75.642443][ T5831] loop3: detected capacity change from 0 to 32768 [ 75.650746][ T5829] loop2: detected capacity change from 0 to 32768 [ 75.662108][ T5828] loop1: detected capacity change from 0 to 32768 [ 75.668902][ T5834] loop4: detected capacity change from 0 to 32768 [ 75.675838][ T5827] loop0: detected capacity change from 0 to 32768 [ 75.684361][ T5831] ======================================================= [pid 5831] mount("/dev/loop3", "./file1", "bcachefs", MS_RDONLY|MS_NOEXEC|MS_MANDLOCK|MS_DIRSYNC|MS_I_VERSION|MS_LAZYTIME, "" [pid 5829] <... ioctl resumed>) = 0 [pid 5828] <... ioctl resumed>) = 0 [pid 5829] close(3 [pid 5828] close(3 [pid 5829] <... close resumed>) = 0 [pid 5828] <... close resumed>) = 0 [pid 5829] close(4 [pid 5828] close(4 [pid 5829] <... close resumed>) = 0 [pid 5828] <... close resumed>) = 0 [pid 5829] mkdir("./file1", 0777 [pid 5828] mkdir("./file1", 0777 [pid 5829] <... mkdir resumed>) = -1 EEXIST (File exists) [pid 5828] <... mkdir resumed>) = -1 EEXIST (File exists) [pid 5829] mount("/dev/loop2", "./file1", "bcachefs", MS_RDONLY|MS_NOEXEC|MS_MANDLOCK|MS_DIRSYNC|MS_I_VERSION|MS_LAZYTIME, "" [pid 5828] mount("/dev/loop1", "./file1", "bcachefs", MS_RDONLY|MS_NOEXEC|MS_MANDLOCK|MS_DIRSYNC|MS_I_VERSION|MS_LAZYTIME, "" [pid 5834] <... ioctl resumed>) = 0 [pid 5834] close(3) = 0 [pid 5834] close(4) = 0 [pid 5834] mkdir("./file1", 0777) = -1 EEXIST (File exists) [pid 5834] mount("/dev/loop4", "./file1", "bcachefs", MS_RDONLY|MS_NOEXEC|MS_MANDLOCK|MS_DIRSYNC|MS_I_VERSION|MS_LAZYTIME, "" [pid 5827] <... ioctl resumed>) = 0 [pid 5827] close(3) = 0 [pid 5827] close(4) = 0 [pid 5827] mkdir("./file1", 0777) = -1 EEXIST (File exists) [ 75.684361][ T5831] WARNING: The mand mount option has been deprecated and [ 75.684361][ T5831] and is ignored by this kernel. Remove the mand [ 75.684361][ T5831] option from the mount to silence this warning. [ 75.684361][ T5831] ======================================================= [ 75.927783][ T5827] bcachefs (loop0): starting version 1.7: mi_btree_bitmap opts=metadata_checksum=none,data_checksum=none,compression=lz4,nojournal_transaction_names,read_only [ 75.927805][ T5827] allowing incompatible features above 0.0: (unknown version) [ 75.927816][ T5827] features: lz4,new_siphash,inline_data,new_extent_overwrite,btree_ptr_v2,new_varint,journal_no_flush,alloc_v2,extents_across_btree_nodes [ 75.968160][ T5827] bcachefs (loop0): Using encoding defined by superblock: utf8-12.1.0 [ 75.976662][ T5827] bcachefs (loop0): recovering from clean shutdown, journal seq 10 [ 75.985863][ T5827] bcachefs (loop0): superblock requires following recovery passes to be run: [ 75.985863][ T5827] check_topology,alloc_read,stripes_read,initialize_subvolumes,snapshots_read,check_allocations,set_may_go_rw,journal_replay,check_alloc_info,check_lrus [ 76.015531][ T5828] bcachefs (loop1): starting version 1.7: mi_btree_bitmap opts=metadata_checksum=none,data_checksum=none,compression=lz4,nojournal_transaction_names,read_only [ 76.015552][ T5828] allowing incompatible features above 0.0: (unknown version) [ 76.015562][ T5828] features: lz4,new_siphash,inline_data,new_extent_overwrite,btree_ptr_v2,new_varint,journal_no_flush,alloc_v2,extents_across_btree_nodes [ 76.054894][ T5827] bcachefs (loop0): Version upgrade required: [ 76.054894][ T5827] Version upgrade from 0.24: unwritten_extents to 1.7: mi_btree_bitmap incomplete [ 76.054894][ T5827] Doing incompatible version upgrade from 0.24: unwritten_extents to 1.28: inode_has_case_insensitive [ 76.054894][ T5827] running recovery passes: 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,check_rebalance_work,set_fs_needs_rebalance [ 76.087615][ T5831] bcachefs (loop3): starting version 1.7: mi_btree_bitmap opts=metadata_checksum=none,data_checksum=none,compression=lz4,nojournal_transaction_names,read_only [ 76.087635][ T5831] allowing incompatible features above 0.0: (unknown version) [ 76.087644][ T5831] features: lz4,new_siphash,inline_data,new_extent_overwrite,btree_ptr_v2,new_varint,journal_no_flush,alloc_v2,extents_across_btree_nodes [ 76.087668][ T5831] bcachefs (loop3): Using encoding defined by superblock: utf8-12.1.0 [ 76.087771][ T5831] bcachefs (loop3): recovering from clean shutdown, journal seq 10 [ 76.087869][ T5831] bcachefs (loop3): superblock requires following recovery passes to be run: [ 76.087869][ T5831] check_topology,alloc_read,stripes_read,initialize_subvolumes,snapshots_read,check_allocations,set_may_go_rw,journal_replay,check_alloc_info,check_lrus [ 76.088448][ T5831] bcachefs (loop3): Version upgrade required: [ 76.088448][ T5831] Version upgrade from 0.24: unwritten_extents to 1.7: mi_btree_bitmap incomplete [ 76.088448][ T5831] Doing incompatible version upgrade from 0.24: unwritten_extents to 1.28: inode_has_case_insensitive [ 76.088448][ T5831] running recovery passes: 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,check_rebalance_work,set_fs_needs_rebalance [ 76.103916][ T5834] bcachefs (loop4): starting version 1.7: mi_btree_bitmap opts=metadata_checksum=none,data_checksum=none,compression=lz4,nojournal_transaction_names,read_only [ 76.103937][ T5834] allowing incompatible features above 0.0: (unknown version) [ 76.103947][ T5834] features: lz4,new_siphash,inline_data,new_extent_overwrite,btree_ptr_v2,new_varint,journal_no_flush,alloc_v2,extents_across_btree_nodes [ 76.103971][ T5834] bcachefs (loop4): Using encoding defined by superblock: utf8-12.1.0 [ 76.104089][ T5834] bcachefs (loop4): recovering from clean shutdown, journal seq 10 [ 76.104187][ T5834] bcachefs (loop4): superblock requires following recovery passes to be run: [ 76.104187][ T5834] check_topology,alloc_read,stripes_read,initialize_subvolumes,snapshots_read,check_allocations,set_may_go_rw,journal_replay,check_alloc_info,check_lrus [ 76.104432][ T5834] bcachefs (loop4): Version upgrade required: [ 76.104432][ T5834] Version upgrade from 0.24: unwritten_extents to 1.7: mi_btree_bitmap incomplete [ 76.104432][ T5834] Doing incompatible version upgrade from 0.24: unwritten_extents to 1.28: inode_has_case_insensitive [ 76.104432][ T5834] running recovery passes: 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,check_rebalance_work,set_fs_needs_rebalance [ 76.174359][ T5829] bcachefs (loop2): starting version 1.7: mi_btree_bitmap opts=metadata_checksum=none,data_checksum=none,compression=lz4,nojournal_transaction_names,read_only [ 76.229410][ T5828] bcachefs (loop1): Using encoding defined by superblock: utf8-12.1.0 [ 76.260290][ T5829] allowing incompatible features above 0.0: (unknown version) [ 76.400235][ T5827] bcachefs (loop0): btree node read error at btree extents level 0/0 [ 76.408450][ T5829] features: lz4,new_siphash,inline_data,new_extent_overwrite,btree_ptr_v2,new_varint,journal_no_flush,alloc_v2,extents_across_btree_nodes [ 76.456276][ T5828] bcachefs (loop1): recovering from clean shutdown, journal seq 10 [ 76.511852][ T5831] bcachefs (loop3): btree node read error at btree extents level 0/0 [ 76.520357][ T5827] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 16 min_key POS_MIN durability: 1 ptr: 0:27:0 gen 0 [ 76.528547][ T5834] bcachefs (loop4): btree node read error at btree extents level 0/0 [ 76.544625][ T5827] loop0 node offset 0/16: incorrect min_key: got 0:9:2751463424 should be POS_MIN [ 76.544642][ T5827] flagging btree extents lost data [ 76.544650][ T5827] running recovery pass scan_for_btree_nodes (1), currently at recovery_pass_empty (0) [ 76.544659][ T5827] ret btree_node_read_validate_error [ 76.546509][ T5827] bcachefs (loop0): error reading btree root btree=extents level=0: btree_node_read_error, fixing [ 76.559438][ T5831] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 16 min_key POS_MIN durability: 1 ptr: 0:27:0 gen 0 [ 76.599103][ T5827] bcachefs (loop0): btree node read error at btree freespace level 0/0 [ 76.606261][ T5834] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 16 min_key POS_MIN durability: 1 ptr: 0:27:0 gen 0 [ 76.613966][ T5827] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq e81e1ed936acf3df written 32 min_key POS_MIN durability: 1 ptr: 0:29:0 gen 0 [ 76.621487][ T5834] loop4 node offset 0/16: incorrect min_key: got 0:9:2751463424 should be POS_MIN [ 76.628281][ T5828] bcachefs (loop1): superblock requires following recovery passes to be run: [ 76.628281][ T5828] check_topology,alloc_read,stripes_read,initialize_subvolumes,snapshots_read,check_allocations,set_may_go_rw,journal_replay,check_alloc_info,check_lrus [ 76.637555][ T5829] bcachefs (loop2): Using encoding defined by superblock: utf8-12.1.0 [ 76.652260][ T5827] loop0 node offset 0/32: incorrect min_key: got 0:227633266688:0 should be POS_MIN [ 76.659472][ T5831] loop3 node offset 0/16: incorrect min_key: got 0:9:2751463424 should be POS_MIN [ 76.674407][ T5828] bcachefs (loop1): Version upgrade required: [ 76.674407][ T5828] Version upgrade from 0.24: unwritten_extents to 1.7: mi_btree_bitmap incomplete [ 76.674407][ T5828] Doing incompatible version upgrade from 0.24: unwritten_extents to 1.28: inode_has_case_insensitive [ 76.674407][ T5828] running recovery passes: 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,check_rebalance_work,set_fs_needs_rebalance [ 76.687290][ T5834] flagging btree extents lost data [ 76.722107][ T5827] flagging btree freespace lost data [ 76.729715][ T5829] bcachefs (loop2): recovering from clean shutdown, journal seq 10 [ 76.817767][ T5827] ret btree_node_read_validate_error [ 76.823337][ T5831] flagging btree extents lost data [ 76.828548][ T5827] bcachefs (loop0): error reading btree root btree=freespace level=0: btree_node_read_error, fixing [ 76.837145][ T5831] running recovery pass scan_for_btree_nodes (1), currently at recovery_pass_empty (0) [ 76.851486][ T5827] bcachefs (loop0): btree node read error at btree backpointers level 0/0 [ 76.858173][ T5834] running recovery pass scan_for_btree_nodes (1), currently at recovery_pass_empty (0) [ 76.879529][ T5828] bcachefs (loop1): btree node read error at btree extents level 0/0 [ 76.886753][ T5831] ret btree_node_read_validate_error [ 76.894849][ T5827] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 4a8b0fa43a9980a6 written 24 min_key POS_MIN durability: 1 ptr: 0:37:0 gen 0 [ 76.900402][ T5834] ret btree_node_read_validate_error [ 76.915066][ T5828] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 16 min_key POS_MIN durability: 1 ptr: 0:27:0 gen 0 [ 76.920233][ T5831] bcachefs (loop3): error reading btree root btree=extents level=0: btree_node_read_error, fixing [ 76.944013][ T5827] loop0 node offset 0/24 bset u64s 0: invalid bkey format: field 4 too large: 0 + 1125899906842624 > 4294967295 [ 76.944032][ T5827] u64s 3 fields 64:0, 64:0, 32:0, 0:0, 0:1125899906842624, 0:0 [ 76.944041][ T5827] flagging btree backpointers lost data [ 76.944049][ T5827] ret btree_node_read_validate_error [ 76.944907][ T5834] bcachefs (loop4): error reading btree root btree=extents level=0: btree_node_read_error, fixing [ 76.957113][ T5828] loop1 node offset 0/16: incorrect min_key: got 0:9:2751463424 should be POS_MIN [ 76.964607][ T5829] bcachefs (loop2): superblock requires following recovery passes to be run: [ 76.964607][ T5829] check_topology,alloc_read,stripes_read,initialize_subvolumes,snapshots_read,check_allocations,set_may_go_rw,journal_replay,check_alloc_info,check_lrus [ 76.975355][ T5827] bcachefs (loop0): error reading btree root btree=backpointers level=0: btree_node_read_error, fixing [ 76.987607][ T5829] bcachefs (loop2): Version upgrade required: [ 76.987607][ T5829] Version upgrade from 0.24: unwritten_extents to 1.7: mi_btree_bitmap incomplete [ 76.987607][ T5829] Doing incompatible version upgrade from 0.24: unwritten_extents to 1.28: inode_has_case_insensitive [ 76.987607][ T5829] running recovery passes: 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,check_rebalance_work,set_fs_needs_rebalance [ 76.996787][ T5828] flagging btree extents lost data [ 77.031680][ T5834] bcachefs (loop4): btree node read error at btree freespace level 0/0 [ 77.100933][ T5828] running recovery pass scan_for_btree_nodes (1), currently at recovery_pass_empty (0) [ 77.111691][ T5831] bcachefs (loop3): btree node read error at btree freespace level 0/0 [ 77.114791][ T5827] bcachefs (loop0): check_topology... [ 77.131808][ T5831] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq e81e1ed936acf3df written 32 min_key POS_MIN durability: 1 ptr: 0:29:0 gen 0 [ 77.138902][ T5827] bcachefs (loop0): btree root extents unreadable, must recover from scan [ 77.160676][ T5828] ret btree_node_read_validate_error [ 77.166641][ T5828] bcachefs (loop1): error reading btree root btree=extents level=0: btree_node_read_error, fixing [ 77.177368][ T5831] loop3 node offset 0/32: incorrect min_key: got 0:227633266688:0 should be POS_MIN [ 77.177386][ T5831] flagging btree freespace lost data [ 77.177393][ T5831] ret btree_node_read_validate_error [ 77.177574][ T5831] bcachefs (loop3): error reading btree root btree=freespace level=0: btree_node_read_error, fixing [ 77.179224][ T5827] bcachefs (loop0): running recovery pass scan_for_btree_nodes (1), currently at check_topology (2) - rewinding [ 77.179297][ T5827] bcachefs (loop0): bch2_check_root(): error restart_recovery [ 77.179315][ T5827] bcachefs (loop0): scan_for_btree_nodes... [ 77.181337][ T5831] bcachefs (loop3): btree node read error at btree backpointers level 0/0 [ 77.191065][ T5834] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq e81e1ed936acf3df written 32 min_key POS_MIN durability: 1 ptr: 0:29:0 gen 0 [ 77.196687][ T5829] bcachefs (loop2): btree node read error at btree extents level 0/0 [ 77.204026][ T5834] loop4 node offset 0/32: incorrect min_key: got 0:227633266688:0 should be POS_MIN [ 77.212887][ T5831] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 4a8b0fa43a9980a6 written 24 min_key POS_MIN durability: 1 ptr: 0:37:0 gen 0 [ 77.226028][ T5834] flagging btree freespace lost data [ 77.238567][ T5828] bcachefs (loop1): error reading btree root btree=freespace level=0: btree_node_read_error, fixing [ 77.247488][ T5829] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 16 min_key POS_MIN durability: 1 ptr: 0:27:0 gen 0 [ 77.291561][ T5831] loop3 node offset 0/24 bset u64s 0: invalid bkey format: field 4 too large: 0 + 1125899906842624 > 4294967295 [ 77.298432][ T5834] ret btree_node_read_validate_error [ 77.320726][ T5828] bcachefs (loop1): error reading btree root btree=backpointers level=0: btree_node_read_error, fixing [ 77.322698][ T5834] bcachefs (loop4): error reading btree root btree=freespace level=0: btree_node_read_error, fixing [ 77.351320][ T5831] u64s 3 fields 64:0, 64:0, 32:0, 0:0, 0:1125899906842624, 0:0 [ 77.351524][ T5827] bcachefs (loop0): btree node scan found 7 nodes after overwrites [ 77.363529][ T5828] bcachefs (loop1): check_topology... [ 77.371821][ T5829] loop2 node offset 0/16: incorrect min_key: got 0:9:2751463424 should be POS_MIN [ 77.379040][ T5827] done [ 77.385067][ T5829] flagging btree extents lost data [ 77.396291][ T5831] flagging btree backpointers lost data [ 77.396304][ T5831] ret btree_node_read_validate_error [ 77.402820][ T5829] running recovery pass scan_for_btree_nodes (1), currently at recovery_pass_empty (0) [ 77.407791][ T5828] bcachefs (loop1): btree root extents unreadable, must recover from scan [ 77.414696][ T5829] ret btree_node_read_validate_error [ 77.423040][ T5827] bcachefs (loop0): check_topology... [ 77.432713][ T5829] bcachefs (loop2): error reading btree root btree=extents level=0: btree_node_read_error, fixing [ 77.437209][ T5831] bcachefs (loop3): error reading btree root btree=backpointers level=0: btree_node_read_error, fixing [ 77.443651][ T5828] bcachefs (loop1): running recovery pass scan_for_btree_nodes (1), currently at check_topology (2) - rewinding [ 77.453847][ T5827] bcachefs (loop0): btree root extents unreadable, must recover from scan [ 77.466492][ T5828] bcachefs (loop1): bch2_check_root(): error restart_recovery [ 77.476822][ T5827] bcachefs (loop0): bch2_get_scanned_nodes(): recovery btree=extents level=0 POS_MIN - SPOS_MAX [ 77.486003][ T5834] bcachefs (loop4): error reading btree root btree=backpointers level=0: btree_node_read_error, fixing [ 77.493429][ T5831] bcachefs (loop3): check_topology... [ 77.517033][ T5827] bcachefs (loop0): bch2_get_scanned_nodes(): recovering u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 16 min_key 0:9:2751463424 durability: 1 ptr: 0:27:0 gen 0 [ 77.543168][ T5831] bcachefs (loop3): btree root extents unreadable, must recover from scan [ 77.547540][ T5834] bcachefs (loop4): check_topology... [ 77.552040][ T5831] bcachefs (loop3): running recovery pass scan_for_btree_nodes (1), currently at check_topology (2) - rewinding [ 77.555119][ T5834] bcachefs (loop4): btree root extents unreadable, must recover from scan [ 77.557460][ T5831] bcachefs (loop3): bch2_check_root(): error restart_recovery [ 77.570725][ T5829] bcachefs (loop2): error reading btree root btree=freespace level=0: btree_node_read_error, fixing [ 77.579366][ T5831] bcachefs (loop3): scan_for_btree_nodes... [ 77.587955][ T5828] bcachefs (loop1): scan_for_btree_nodes... [ 77.597146][ T5827] bcachefs (loop0): bch2_get_scanned_nodes(): recovery btree=extents level=0 POS_MIN - 0:9:2751463423 [ 77.604247][ T5834] bcachefs (loop4): running recovery pass scan_for_btree_nodes (1), currently at check_topology (2) - rewinding [ 77.610492][ T5827] bcachefs (loop0): btree node with incorrect min_key at btree=extents level=1: [ 77.619881][ T5829] bcachefs (loop2): error reading btree root btree=backpointers level=0: btree_node_read_error, fixing [ 77.632362][ T5827] parent: u64s 5 type btree_ptr SPOS_MAX len 0 ver 0 [ 77.652140][ T5834] bcachefs (loop4): bch2_check_root(): error restart_recovery [ 77.659834][ T5827] next: u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 16 min_key 0:9:2751463424 durability: 1 ptr: 0:27:0 gen 0, fixing [ 77.667934][ T5829] bcachefs (loop2): check_topology... [ 77.681635][ T5829] bcachefs (loop2): btree root extents unreadable, must recover from scan [ 77.683185][ T5827] bcachefs (loop0): set_node_min(): u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 16 min_key 0:9:2751463424 durability: 1 ptr: 0:27:0 gen 0 -> POS_MIN [ 77.687408][ T5829] bcachefs (loop2): running recovery pass scan_for_btree_nodes (1), currently at check_topology (2) - rewinding [ 77.698879][ T5834] bcachefs (loop4): scan_for_btree_nodes... [ 77.714187][ T5829] bcachefs (loop2): bch2_check_root(): error restart_recovery [ 77.728604][ T5827] done [ 77.732984][ T5829] bcachefs (loop2): scan_for_btree_nodes... [ 77.740248][ T5827] bcachefs (loop0): accounting_read... done [ 77.761288][ T5827] bcachefs (loop0): alloc_read... [ 77.763906][ T5831] bcachefs (loop3): btree node scan found 7 nodes after overwrites [ 77.767229][ T5827] done [ 77.769148][ T5834] bcachefs (loop4): btree node scan found 7 nodes after overwrites [ 77.776893][ T5827] bcachefs (loop0): stripes_read... done [ 77.785568][ T5831] done [ 77.797794][ T5827] bcachefs (loop0): initialize_subvolumes... [ 77.798378][ T5831] bcachefs (loop3): check_topology... [ 77.802597][ T5829] bcachefs (loop2): btree node scan found 7 nodes after overwrites [ 77.804853][ T5834] done [ 77.811072][ T5827] done [ 77.818476][ T5834] bcachefs (loop4): check_topology... [ 77.822319][ T5829] done [ 77.824111][ T5831] bcachefs (loop3): btree root extents unreadable, must recover from scan [ 77.829384][ T5829] bcachefs (loop2): check_topology... [ 77.833388][ T5834] bcachefs (loop4): btree root extents unreadable, must recover from scan [ 77.841438][ T5827] bcachefs (loop0): snapshots_read... [ 77.847485][ T5831] bcachefs (loop3): bch2_get_scanned_nodes(): recovery btree=extents level=0 POS_MIN - SPOS_MAX [ 77.855396][ T5829] bcachefs (loop2): btree root extents unreadable, must recover from scan [ 77.862120][ T5834] bcachefs (loop4): bch2_get_scanned_nodes(): recovery btree=extents level=0 POS_MIN - SPOS_MAX [ 77.891681][ T5827] done [ 77.892461][ T5831] bcachefs (loop3): bch2_get_scanned_nodes(): recovering u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 16 min_key 0:9:2751463424 durability: 1 ptr: 0:27:0 gen 0 [ 77.894469][ T5827] bcachefs (loop0): check_allocations... [ 77.914024][ T5829] bcachefs (loop2): bch2_get_scanned_nodes(): recovery btree=extents level=0 POS_MIN - SPOS_MAX [ 77.921339][ T5834] bcachefs (loop4): bch2_get_scanned_nodes(): recovering u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 16 min_key 0:9:2751463424 durability: 1 ptr: 0:27:0 gen 0 [ 77.932215][ T5829] bcachefs (loop2): bch2_get_scanned_nodes(): recovering u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 16 min_key 0:9:2751463424 durability: 1 ptr: 0:27:0 gen 0 [ 77.956476][ T5831] bcachefs (loop3): bch2_get_scanned_nodes(): recovery btree=extents level=0 POS_MIN - 0:9:2751463423 [ 77.968583][ T5828] bcachefs (loop1): btree node scan found 7 nodes after overwrites [ 77.981615][ T5834] bcachefs (loop4): bch2_get_scanned_nodes(): recovery btree=extents level=0 POS_MIN - 0:9:2751463423 [ 77.993310][ T5831] bcachefs (loop3): btree node with incorrect min_key at btree=extents level=1: [ 78.000457][ T5834] bcachefs (loop4): btree node with incorrect min_key at btree=extents level=1: [ 78.008457][ T5829] bcachefs (loop2): bch2_get_scanned_nodes(): recovery btree=extents level=0 POS_MIN - 0:9:2751463423 [ 78.017379][ T5834] parent: u64s 5 type btree_ptr SPOS_MAX len 0 ver 0 [ 78.028981][ T5829] bcachefs (loop2): btree node with incorrect min_key at btree=extents level=1: [ 78.044330][ T5834] next: u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 16 min_key 0:9:2751463424 durability: 1 ptr: 0:27:0 gen 0, fixing [ 78.044501][ T5829] parent: u64s 5 type btree_ptr SPOS_MAX len 0 ver 0 [ 78.060827][ T5834] bcachefs (loop4): set_node_min(): u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 16 min_key 0:9:2751463424 durability: 1 ptr: 0:27:0 gen 0 -> POS_MIN [ 78.067486][ T5827] bcachefs (loop0): bucket 0:26 data type btree ptr gen 0 missing in alloc btree [ 78.088169][ T5834] done [ 78.094599][ T5828] done [ 78.099285][ T5834] bcachefs (loop4): accounting_read... [ 78.100855][ T5828] bcachefs (loop1): check_topology... [ 78.101771][ T5831] parent: u64s 5 type btree_ptr SPOS_MAX len 0 ver 0 [ 78.106385][ T5828] bcachefs (loop1): btree root extents unreadable, must recover from scan [ 78.113527][ T5831] next: u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 16 min_key 0:9:2751463424 durability: 1 ptr: 0:27:0 gen 0, fixing [ 78.120480][ T5828] bcachefs (loop1): bch2_get_scanned_nodes(): recovery btree=extents level=0 POS_MIN - SPOS_MAX [ 78.129631][ T5831] bcachefs (loop3): set_node_min(): u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 16 min_key 0:9:2751463424 durability: 1 ptr: 0:27:0 gen 0 -> POS_MIN [ 78.143437][ T5829] next: u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 16 min_key 0:9:2751463424 durability: 1 ptr: 0:27:0 gen 0, fixing [ 78.173611][ T5834] done [ 78.188008][ T5827] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq ac62141f8dc7e261 written 24 min_key POS_MIN durability: 1 ptr: 0:26:0 gen 0, fixing [ 78.206870][ T5828] bcachefs (loop1): bch2_get_scanned_nodes(): recovering u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 16 min_key 0:9:2751463424 durability: 1 ptr: 0:27:0 gen 0 [ 78.207183][ T5834] bcachefs (loop4): alloc_read... [ 78.229299][ T5829] bcachefs (loop2): set_node_min(): u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 16 min_key 0:9:2751463424 durability: 1 ptr: 0:27:0 gen 0 -> POS_MIN [ 78.230707][ T5831] done [ 78.235353][ T5828] bcachefs (loop1): bch2_get_scanned_nodes(): recovery btree=extents level=0 POS_MIN - 0:9:2751463423 [ 78.254525][ T5834] done [ 78.255551][ T5827] bcachefs (loop0): bucket 0:38 data type btree ptr gen 0 missing in alloc btree [ 78.266376][ T5834] bcachefs (loop4): stripes_read... [ 78.270333][ T5827] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 7589ab5e0c11cc7a written 24 min_key POS_MIN durability: 1 ptr: 0:38:0 gen 0, fixing [ 78.278513][ T5831] bcachefs (loop3): accounting_read... [ 78.286138][ T5828] bcachefs (loop1): btree node with incorrect min_key at btree=extents level=1: [ 78.301090][ T5834] done [ 78.308194][ T5828] parent: u64s 5 type btree_ptr SPOS_MAX len 0 ver 0 [ 78.315262][ T5834] bcachefs (loop4): initialize_subvolumes... [ 78.318518][ T5829] done [ 78.325321][ T5828] next: u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 16 min_key 0:9:2751463424 durability: 1 ptr: 0:27:0 gen 0, fixing [ 78.350384][ T5834] done [ 78.351074][ T5829] bcachefs (loop2): accounting_read... [ 78.353207][ T5834] bcachefs (loop4): snapshots_read... done [ 78.366368][ T5831] done [ 78.366525][ T5827] bcachefs (loop0): bucket 0:41 data type btree ptr gen 0 missing in alloc btree [ 78.369184][ T5831] bcachefs (loop3): alloc_read... [ 78.378400][ T5834] bcachefs (loop4): check_allocations... [ 78.383726][ T5827] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 9aa2895aefce4bdf written 24 min_key POS_MIN durability: 1 ptr: 0:41:0 gen 0, fixing [ 78.386090][ T5831] done [ 78.390897][ T5829] done [ 78.405891][ T5834] bcachefs (loop4): bucket 0:26 data type btree ptr gen 0 missing in alloc btree [ 78.409084][ T5829] bcachefs (loop2): alloc_read... [ 78.410715][ T5834] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq ac62141f8dc7e261 written 24 min_key POS_MIN durability: 1 ptr: 0:26:0 gen 0, fixing [ 78.422595][ T5827] bcachefs (loop0): bucket 0:35 data type btree ptr gen 0 missing in alloc btree [ 78.426281][ T5831] bcachefs (loop3): stripes_read... [ 78.442251][ T5829] done [ 78.450086][ T5828] bcachefs (loop1): set_node_min(): u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 16 min_key 0:9:2751463424 durability: 1 ptr: 0:27:0 gen 0 -> POS_MIN [ 78.456055][ T5829] bcachefs (loop2): stripes_read... [ 78.459215][ T5827] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c0bef60d07ceb940 written 16 min_key POS_MIN durability: 1 ptr: 0:35:0 gen 0, fixing [ 78.478638][ T5829] done [ 78.482627][ T5834] bcachefs (loop4): bucket 0:38 data type btree ptr gen 0 missing in alloc btree [ 78.510528][ T5831] done [ 78.511727][ T5829] bcachefs (loop2): initialize_subvolumes... [ 78.513291][ T5831] bcachefs (loop3): initialize_subvolumes... [ 78.513963][ T5828] done [ 78.528673][ T5828] bcachefs (loop1): accounting_read... [ 78.529526][ T5834] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 7589ab5e0c11cc7a written 24 min_key POS_MIN durability: 1 ptr: 0:38:0 gen 0, fixing [ 78.529890][ T5828] done [ 78.531210][ T5829] done [ 78.535362][ T5828] bcachefs (loop1): alloc_read... [ 78.552545][ T5829] bcachefs (loop2): snapshots_read... [ 78.555015][ T5831] done [ 78.558865][ T5827] bcachefs (loop0): bucket 0:1 gen 0 has wrong data_type: got free, should be sb, fixing [ 78.562309][ T5831] bcachefs (loop3): snapshots_read... [ 78.569357][ T5827] bcachefs (loop0): bucket 0:1 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 78.582900][ T5829] done [ 78.587077][ T5831] done [ 78.599965][ T5827] bcachefs (loop0): bucket 0:2 gen 0 has wrong data_type: got free, should be sb, fixing [ 78.601189][ T5828] done [ 78.603097][ T5827] bcachefs (loop0): bucket 0:2 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 78.612933][ T5831] bcachefs (loop3): check_allocations... [ 78.616399][ T5829] bcachefs (loop2): check_allocations... [ 78.627459][ T5828] bcachefs (loop1): stripes_read... [ 78.635276][ T5827] bcachefs (loop0): bucket 0:3 gen 0 has wrong data_type: got free, should be sb, fixing [ 78.658788][ T5834] bcachefs (loop4): bucket 0:41 data type btree ptr gen 0 missing in alloc btree [ 78.658824][ T5834] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 9aa2895aefce4bdf written 24 min_key POS_MIN durability: 1 ptr: 0:41:0 gen 0, fixing [ 78.660309][ T5829] bcachefs (loop2): bucket 0:26 data type btree ptr gen 0 missing in alloc btree [ 78.669065][ T5828] done [ 78.687116][ T5827] bcachefs (loop0): bucket 0:3 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 78.696265][ T5831] bcachefs (loop3): bucket 0:26 data type btree ptr gen 0 missing in alloc btree [ 78.700214][ T5829] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq ac62141f8dc7e261 written 24 min_key POS_MIN durability: 1 ptr: 0:26:0 gen 0, fixing [ 78.711171][ T5831] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq ac62141f8dc7e261 written 24 min_key POS_MIN durability: 1 ptr: 0:26:0 gen 0, fixing [ 78.722183][ T5827] bcachefs (loop0): bucket 0:4 gen 0 has wrong data_type: got free, should be sb, fixing [ 78.735852][ T5828] bcachefs (loop1): initialize_subvolumes... [ 78.755510][ T5829] bcachefs (loop2): bucket 0:38 data type btree ptr gen 0 missing in alloc btree [ 78.777025][ T5834] bcachefs (loop4): bucket 0:35 data type btree ptr gen 0 missing in alloc btree [ 78.777043][ T5834] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c0bef60d07ceb940 written 16 min_key POS_MIN durability: 1 ptr: 0:35:0 gen 0, fixing [ 78.778179][ T5829] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 7589ab5e0c11cc7a written 24 min_key POS_MIN durability: 1 ptr: 0:38:0 gen 0, fixing [ 78.819725][ T5827] bcachefs (loop0): bucket 0:4 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 78.821417][ T5831] bcachefs (loop3): bucket 0:38 data type btree ptr gen 0 missing in alloc btree [ 78.832740][ T5827] bcachefs (loop0): bucket 0:5 gen 0 has wrong data_type: got free, should be sb, fixing [ 78.840821][ T5828] done [ 78.851281][ T5827] bcachefs (loop0): bucket 0:5 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 78.854176][ T5834] bcachefs (loop4): bucket 0:1 gen 0 has wrong data_type: got free, should be sb, fixing [ 78.866453][ T5827] bcachefs (loop0): bucket 0:6 gen 0 has wrong data_type: got free, should be sb, fixing [ 78.874617][ T5828] bcachefs (loop1): snapshots_read... [ 78.884377][ T5831] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 7589ab5e0c11cc7a written 24 min_key POS_MIN durability: 1 ptr: 0:38:0 gen 0, fixing [ 78.886373][ T5827] bcachefs (loop0): bucket 0:6 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 78.892127][ T5828] done [ 78.908396][ T5827] bcachefs (loop0): bucket 0:7 gen 0 has wrong data_type: got free, should be sb, fixing [ 78.917795][ T5834] bcachefs (loop4): bucket 0:1 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 78.921574][ T5827] bcachefs (loop0): bucket 0:7 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 78.941870][ T5834] bcachefs (loop4): bucket 0:2 gen 0 has wrong data_type: got free, should be sb, fixing [ 78.954247][ T5829] bcachefs (loop2): bucket 0:41 data type btree ptr gen 0 missing in alloc btree [ 78.971864][ T5831] bcachefs (loop3): bucket 0:41 data type btree ptr gen 0 missing in alloc btree [ 78.971882][ T5831] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 9aa2895aefce4bdf written 24 min_key POS_MIN durability: 1 ptr: 0:41:0 gen 0, fixing [ 78.972974][ T5829] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 9aa2895aefce4bdf written 24 min_key POS_MIN durability: 1 ptr: 0:41:0 gen 0, fixing [ 78.981288][ T5828] bcachefs (loop1): check_allocations... [ 78.998920][ T5827] bcachefs (loop0): bucket 0:8 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.013103][ T5834] bcachefs (loop4): bucket 0:2 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 79.020706][ T5827] bcachefs (loop0): bucket 0:8 gen 0 data type sb has wrong dirty_sectors: got 0, should be 8, fixing [ 79.029988][ T5834] bcachefs (loop4): bucket 0:3 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.041880][ T5827] bcachefs (loop0): bucket 0:9 gen 0 has wrong data_type: got free, should be journal, fixing [ 79.050992][ T5834] bcachefs (loop4): bucket 0:3 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 79.063345][ T5827] bcachefs (loop0): bucket 0:9 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 79.071325][ T5834] bcachefs (loop4): bucket 0:4 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.105867][ T5831] bcachefs (loop3): bucket 0:35 data type btree ptr gen 0 missing in alloc btree [ 79.105886][ T5831] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c0bef60d07ceb940 written 16 min_key POS_MIN durability: 1 ptr: 0:35:0 gen 0, fixing [ 79.106241][ T5827] bcachefs (loop0): bucket 0:10 gen 0 has wrong data_type: got free, should be journal, fixing [ 79.115946][ T5828] bcachefs (loop1): bucket 0:26 data type btree ptr gen 0 missing in alloc btree [ 79.132585][ T5827] bcachefs (loop0): bucket 0:10 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 79.143097][ T5831] bcachefs (loop3): bucket 0:1 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.152292][ T5827] bcachefs (loop0): bucket 0:11 gen 0 has wrong data_type: got free, should be journal, fixing [ 79.163906][ T5829] bcachefs (loop2): bucket 0:35 data type btree ptr gen 0 missing in alloc btree [ 79.173623][ T5827] Ratelimiting new instances of previous error [ 79.182298][ T5834] bcachefs (loop4): bucket 0:4 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 79.193144][ T5829] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c0bef60d07ceb940 written 16 min_key POS_MIN durability: 1 ptr: 0:35:0 gen 0, fixing [ 79.197648][ T5828] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq ac62141f8dc7e261 written 24 min_key POS_MIN durability: 1 ptr: 0:26:0 gen 0, fixing [ 79.211999][ T5827] bcachefs (loop0): bucket 0:11 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 79.224938][ T5831] bcachefs (loop3): bucket 0:1 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 79.253367][ T5829] bcachefs (loop2): bucket 0:1 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.263120][ T5834] bcachefs (loop4): bucket 0:5 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.283113][ T5829] bcachefs (loop2): bucket 0:1 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 79.296194][ T5834] bcachefs (loop4): bucket 0:5 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 79.296521][ T5829] bcachefs (loop2): bucket 0:2 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.318022][ T5831] bcachefs (loop3): bucket 0:2 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.318883][ T5827] Ratelimiting new instances of previous error [ 79.329128][ T5834] bcachefs (loop4): bucket 0:6 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.335930][ T5829] bcachefs (loop2): bucket 0:2 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 79.355789][ T5831] bcachefs (loop3): bucket 0:2 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 79.363462][ T5829] bcachefs (loop2): bucket 0:3 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.367746][ T5828] bcachefs (loop1): bucket 0:38 data type btree ptr gen 0 missing in alloc btree [ 79.383734][ T5827] done [ 79.389855][ T5834] bcachefs (loop4): bucket 0:6 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 79.391657][ T5827] bcachefs (loop0): going read-write [ 79.401940][ T5831] bcachefs (loop3): bucket 0:3 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.410134][ T5829] bcachefs (loop2): bucket 0:3 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 79.416843][ T5828] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 7589ab5e0c11cc7a written 24 min_key POS_MIN durability: 1 ptr: 0:38:0 gen 0, fixing [ 79.429083][ T5829] bcachefs (loop2): bucket 0:4 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.444006][ T5834] bcachefs (loop4): bucket 0:7 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.454598][ T5829] bcachefs (loop2): bucket 0:4 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 79.465421][ T5831] bcachefs (loop3): bucket 0:3 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 79.503641][ T5834] bcachefs (loop4): bucket 0:7 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 79.517946][ T5828] bcachefs (loop1): bucket 0:41 data type btree ptr gen 0 missing in alloc btree [ 79.517964][ T5828] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 9aa2895aefce4bdf written 24 min_key POS_MIN durability: 1 ptr: 0:41:0 gen 0, fixing [ 79.519783][ T5828] bcachefs (loop1): bucket 0:35 data type btree ptr gen 0 missing in alloc btree [ 79.519798][ T5828] while marking u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c0bef60d07ceb940 written 16 min_key POS_MIN durability: 1 ptr: 0:35:0 gen 0, fixing [ 79.522120][ T5828] bcachefs (loop1): bucket 0:1 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.522270][ T5828] bcachefs (loop1): bucket 0:1 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 79.522901][ T5828] bcachefs (loop1): bucket 0:2 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.523035][ T5828] bcachefs (loop1): bucket 0:2 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 79.523542][ T5828] bcachefs (loop1): bucket 0:3 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.523667][ T5828] bcachefs (loop1): bucket 0:3 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 79.523906][ T5828] bcachefs (loop1): bucket 0:4 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.524037][ T5828] bcachefs (loop1): bucket 0:4 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 79.524274][ T5828] bcachefs (loop1): bucket 0:5 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.524399][ T5828] bcachefs (loop1): bucket 0:5 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 79.524658][ T5828] bcachefs (loop1): bucket 0:6 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.524779][ T5828] bcachefs (loop1): bucket 0:6 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 79.525044][ T5828] bcachefs (loop1): bucket 0:7 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.525168][ T5828] bcachefs (loop1): bucket 0:7 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 79.526781][ T5828] bcachefs (loop1): bucket 0:8 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.526905][ T5828] bcachefs (loop1): bucket 0:8 gen 0 data type sb has wrong dirty_sectors: got 0, should be 8, fixing [ 79.527170][ T5828] bcachefs (loop1): bucket 0:9 gen 0 has wrong data_type: got free, should be journal, fixing [ 79.527296][ T5828] bcachefs (loop1): bucket 0:9 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 79.527561][ T5828] bcachefs (loop1): bucket 0:10 gen 0 has wrong data_type: got free, should be journal, fixing [ 79.527711][ T5828] bcachefs (loop1): bucket 0:10 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 79.527988][ T5828] bcachefs (loop1): bucket 0:11 gen 0 has wrong data_type: got free, should be journal, fixing [ 79.528001][ T5828] Ratelimiting new instances of previous error [ 79.528169][ T5828] bcachefs (loop1): bucket 0:11 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 79.528182][ T5828] Ratelimiting new instances of previous error [ 79.545186][ T5831] bcachefs (loop3): bucket 0:4 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.545320][ T5831] bcachefs (loop3): bucket 0:4 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 79.545559][ T5831] bcachefs (loop3): bucket 0:5 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.545708][ T5831] bcachefs (loop3): bucket 0:5 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [pid 5827] mount("/dev/loop0", "./file1", "bcachefs", MS_RDONLY|MS_NOEXEC|MS_MANDLOCK|MS_DIRSYNC|MS_I_VERSION|MS_LAZYTIME, "" [pid 5822] kill(-5827, SIGKILL) = 0 [pid 5822] kill(5827, SIGKILL) = 0 [pid 5823] kill(-5828, SIGKILL) = 0 [pid 5823] kill(5828, SIGKILL) = 0 [ 79.545988][ T5831] bcachefs (loop3): bucket 0:6 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.546117][ T5831] bcachefs (loop3): bucket 0:6 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 79.546353][ T5831] bcachefs (loop3): bucket 0:7 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.546476][ T5831] bcachefs (loop3): bucket 0:7 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 79.546713][ T5831] bcachefs (loop3): bucket 0:8 gen 0 has wrong data_type: got free, should be sb, fixing [pid 5824] kill(-5829, SIGKILL) = 0 [pid 5824] kill(5829, SIGKILL) = 0 [pid 5825] kill(-5831, SIGKILL [pid 5826] kill(-5834, SIGKILL) = 0 [pid 5826] kill(5834, SIGKILL) = 0 [ 79.546836][ T5831] bcachefs (loop3): bucket 0:8 gen 0 data type sb has wrong dirty_sectors: got 0, should be 8, fixing [ 79.552038][ T5831] bcachefs (loop3): bucket 0:9 gen 0 has wrong data_type: got free, should be journal, fixing [ 79.552177][ T5831] bcachefs (loop3): bucket 0:9 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 79.552463][ T5831] bcachefs (loop3): bucket 0:10 gen 0 has wrong data_type: got free, should be journal, fixing [pid 5825] <... kill resumed>) = 0 [ 79.552933][ T5831] bcachefs (loop3): bucket 0:10 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 79.553262][ T5831] bcachefs (loop3): bucket 0:11 gen 0 has wrong data_type: got free, should be journal, fixing [ 79.553275][ T5831] Ratelimiting new instances of previous error [ 79.553434][ T5831] bcachefs (loop3): bucket 0:11 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 79.553446][ T5831] Ratelimiting new instances of previous error [ 79.559846][ T5829] bcachefs (loop2): bucket 0:5 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.559973][ T5829] bcachefs (loop2): bucket 0:5 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 79.560207][ T5829] bcachefs (loop2): bucket 0:6 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.560332][ T5829] bcachefs (loop2): bucket 0:6 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 79.560571][ T5829] bcachefs (loop2): bucket 0:7 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.560694][ T5829] bcachefs (loop2): bucket 0:7 gen 0 data type sb has wrong dirty_sectors: got 0, should be 256, fixing [ 79.560938][ T5829] bcachefs (loop2): bucket 0:8 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.561086][ T5829] bcachefs (loop2): bucket 0:8 gen 0 data type sb has wrong dirty_sectors: got 0, should be 8, fixing [ 79.561322][ T5829] bcachefs (loop2): bucket 0:9 gen 0 has wrong data_type: got free, should be journal, fixing [ 79.561447][ T5829] bcachefs (loop2): bucket 0:9 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 79.561684][ T5829] bcachefs (loop2): bucket 0:10 gen 0 has wrong data_type: got free, should be journal, fixing [ 79.561819][ T5829] bcachefs (loop2): bucket 0:10 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 79.562112][ T5829] bcachefs (loop2): bucket 0:11 gen 0 has wrong data_type: got free, should be journal, fixing [ 79.562124][ T5829] Ratelimiting new instances of previous error [ 79.562283][ T5829] bcachefs (loop2): bucket 0:11 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 79.562295][ T5829] Ratelimiting new instances of previous error [ 79.578626][ T5829] done [ 79.579132][ T5829] bcachefs (loop2): going read-write [ 79.585898][ T5831] done [ 79.597939][ T5834] bcachefs (loop4): bucket 0:8 gen 0 has wrong data_type: got free, should be sb, fixing [ 79.610730][ T5831] bcachefs (loop3): going read-write [ 79.642356][ T5834] bcachefs (loop4): bucket 0:8 gen 0 data type sb has wrong dirty_sectors: got 0, should be 8, fixing [ 79.655411][ T5828] done [ 79.673269][ T5834] bcachefs (loop4): bucket 0:9 gen 0 has wrong data_type: got free, should be journal, fixing [ 79.715616][ T5828] bcachefs (loop1): going read-write [ 79.727488][ T5834] bcachefs (loop4): bucket 0:9 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 79.760945][ T5827] bcachefs (loop0): journal_replay... [ 79.771599][ T5834] bcachefs (loop4): bucket 0:10 gen 0 has wrong data_type: got free, should be journal, fixing [ 79.805161][ T969] bcachefs (loop0): bucket incorrectly unset in freespace btree [ 79.813434][ T5834] bcachefs (loop4): bucket 0:10 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 79.827832][ T969] u64s 5 type deleted 0:25:0 len 0 ver 0, , continuing [ 79.837331][ T5834] bcachefs (loop4): bucket 0:11 gen 0 has wrong data_type: got free, should be journal, fixing [ 79.851788][ T5829] bcachefs (loop2): journal_replay... [ 79.864302][ T13] bcachefs (loop2): bucket incorrectly unset in freespace btree [ 79.873328][ T5834] Ratelimiting new instances of previous error [ 79.881802][ T13] u64s 5 type deleted 0:25:0 len 0 ver 0, , continuing [ 79.915917][ T969] bcachefs (loop0): bucket incorrectly unset in freespace btree [ 79.925931][ T5834] bcachefs (loop4): bucket 0:11 gen 0 data type journal has wrong dirty_sectors: got 0, should be 256, fixing [ 79.938647][ T969] u64s 5 type deleted 0:29:0 len 0 ver 0, , continuing [ 79.961096][ T5828] syz-executor167: vmalloc error: size 6291456, failed to allocated page array size 12288, mode:0xcc2(GFP_KERNEL|__GFP_HIGHMEM), nodemask=(null) [ 79.974092][ T969] bcachefs (loop0): bucket incorrectly unset in freespace btree [ 79.984034][ T5834] Ratelimiting new instances of previous error [pid 5825] kill(5831, SIGKILL) = 0 [ 79.990029][ T969] u64s 5 type deleted 0:43:0 len 0 ver 0, , continuing [ 80.002987][ T5828] ,cpuset= [ 80.014677][ T969] bcachefs (loop0): bucket incorrectly unset in freespace btree [ 80.032742][ T5828] / [ 80.442455][ T969] u64s 5 type deleted 0:45:0 len 0 ver 0, , continuing [ 80.452337][ T5828] ,mems_allowed=0-1 [ 80.459029][ T5828] CPU: 1 UID: 0 PID: 5828 Comm: syz-executor167 Not tainted 6.16.0-rc4-syzkaller-00013-g66701750d556 #0 PREEMPT(full) [ 80.459052][ T5828] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 05/07/2025 [ 80.459066][ T5828] Call Trace: [ 80.459077][ T5828] [ 80.459085][ T5828] dump_stack_lvl+0x189/0x250 [ 80.459114][ T5828] ? __pfx_rcu_read_unlock_special+0x10/0x10 [ 80.459140][ T5828] ? __pfx_dump_stack_lvl+0x10/0x10 [ 80.459159][ T5828] ? __pfx__printk+0x10/0x10 [ 80.459173][ T5828] ? cpuset_print_current_mems_allowed+0x1f/0x360 [ 80.459196][ T5828] ? cpuset_print_current_mems_allowed+0x1f/0x360 [ 80.459223][ T5828] warn_alloc+0x214/0x310 [ 80.459245][ T5828] ? __pfx_warn_alloc+0x10/0x10 [ 80.459274][ T5828] ? __get_vm_area_node+0x28f/0x300 [ 80.459291][ T5828] ? __bch2_darray_resize_noprof+0xd7/0x290 [ 80.459311][ T5828] __vmalloc_node_range_noprof+0x67e/0x12f0 [ 80.459352][ T5828] ? __pfx___vmalloc_node_range_noprof+0x10/0x10 [ 80.459373][ T5828] ? rcu_is_watching+0x15/0xb0 [ 80.459392][ T5828] ? __bch2_darray_resize_noprof+0xd7/0x290 [ 80.459407][ T5828] ? __bch2_darray_resize_noprof+0xd7/0x290 [ 80.459421][ T5828] __kvmalloc_node_noprof+0x3b8/0x5f0 [ 80.459438][ T5828] ? __bch2_darray_resize_noprof+0xd7/0x290 [ 80.459452][ T5828] ? __bch2_darray_resize_noprof+0x1c9/0x290 [ 80.459469][ T5828] ? kfree+0x4d/0x440 [ 80.459487][ T5828] __bch2_darray_resize_noprof+0xd7/0x290 [ 80.459510][ T5828] bch2_fs_btree_write_buffer_init+0x19b/0x1f0 [ 80.459538][ T5828] bch2_fs_init_rw+0x226/0x2d0 [ 80.459559][ T5828] __bch2_fs_read_write+0x184/0x590 [ 80.459581][ T5828] bch2_fs_read_write_early+0x26/0x40 [ 80.459599][ T5828] __bch2_run_recovery_passes+0x395/0x1010 [ 80.459639][ T5828] bch2_run_recovery_passes+0x184/0x210 [ 80.459658][ T5828] bch2_fs_recovery+0x2690/0x3a50 [ 80.459690][ T5828] ? __pfx_bch2_fs_recovery+0x10/0x10 [ 80.459719][ T5828] ? __lock_acquire+0xab9/0xd20 [ 80.459749][ T5828] ? __lock_acquire+0xab9/0xd20 [ 80.459789][ T5828] ? __lock_acquire+0xab9/0xd20 [ 80.459831][ T5828] ? bch2_fs_start+0x9fe/0xd90 [ 80.459852][ T5828] ? up_write+0x1c4/0x420 [ 80.459864][ T5828] ? bch2_fs_start+0x5c4/0xd90 [ 80.459885][ T5828] bch2_fs_start+0xa99/0xd90 [ 80.459905][ T5828] ? bch2_fs_start+0x5c4/0xd90 [ 80.459927][ T5828] ? __pfx_bch2_fs_start+0x10/0x10 [ 80.459972][ T5828] ? sget+0x267/0x620 [ 80.459993][ T5828] bch2_fs_get_tree+0xafc/0x14f0 [ 80.460031][ T5828] ? __pfx_bch2_fs_get_tree+0x10/0x10 [ 80.460063][ T5828] ? vfs_parse_monolithic_sep+0x2df/0x310 [ 80.460079][ T5828] ? __pfx_vfs_parse_comma_sep+0x10/0x10 [ 80.460101][ T5828] ? cap_capable+0x11f/0x460 [ 80.460115][ T5828] ? bch2_init_fs_context+0x88/0x110 [ 80.460131][ T5828] ? safesetid_security_capable+0xa9/0x1a0 [ 80.460155][ T5828] vfs_get_tree+0x8f/0x2b0 [ 80.460174][ T5828] do_new_mount+0x24a/0xa40 [ 80.460198][ T5828] __se_sys_mount+0x317/0x410 [ 80.460224][ T5828] ? __pfx___se_sys_mount+0x10/0x10 [ 80.460241][ T5828] ? rcu_is_watching+0x15/0xb0 [ 80.460266][ T5828] ? __x64_sys_mount+0x20/0xc0 [ 80.460288][ T5828] do_syscall_64+0xfa/0x3b0 [ 80.460320][ T5828] ? lockdep_hardirqs_on+0x9c/0x150 [ 80.460340][ T5828] ? entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 80.460356][ T5828] ? clear_bhb_loop+0x60/0xb0 [ 80.460377][ T5828] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 80.460392][ T5828] RIP: 0033:0x7f4673b5851a [ 80.460413][ T5828] Code: d8 64 89 02 48 c7 c0 ff ff ff ff eb a6 e8 5e 04 00 00 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 40 00 49 89 ca b8 a5 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 c7 c1 b8 ff ff ff f7 d8 64 89 01 48 [ 80.460427][ T5828] RSP: 002b:00007ffc34e64088 EFLAGS: 00000282 ORIG_RAX: 00000000000000a5 [ 80.460445][ T5828] RAX: ffffffffffffffda RBX: 00007ffc34e640a0 RCX: 00007f4673b5851a [ 80.460457][ T5828] RDX: 0000200000000000 RSI: 0000200000000200 RDI: 00007ffc34e640a0 [ 80.460469][ T5828] RBP: 0000200000000200 R08: 00007ffc34e640e0 R09: 00000000000059cd [ 80.460480][ T5828] R10: 00000000028000c9 R11: 0000000000000282 R12: 0000200000000000 [ 80.460491][ T5828] R13: 0000000000000004 R14: 0000000000000003 R15: 00007ffc34e640e0 [ 80.460518][ T5828] [ 80.461772][ T5834] done [ 80.494855][ T13] bcachefs (loop2): bucket incorrectly unset in freespace btree [ 80.506322][ T5831] bcachefs (loop3): bch2_journal_reclaim_start(): error creating journal reclaim thread EINTR [ 80.511188][ T13] u64s 5 type deleted 0:29:0 len 0 ver 0, , continuing [ 80.517425][ T5831] bcachefs (loop3): flushing journal and stopping allocators, journal seq 10 [ 80.523845][ T5828] Mem-Info: [ 80.531882][ T969] bcachefs (loop0): bucket incorrectly unset in freespace btree [ 80.537158][ T13] bcachefs (loop2): bucket incorrectly unset in freespace btree [ 80.539018][ T5831] bcachefs (loop3): flushing journal and stopping allocators complete, journal seq 10 [ 80.543664][ T5828] active_anon:2958 inactive_anon:20964 isolated_anon:0 [ 80.543664][ T5828] active_file:4596 inactive_file:17366 isolated_file:0 [ 80.543664][ T5828] unevictable:768 dirty:14030 writeback:0 [ 80.543664][ T5828] slab_reclaimable:9659 slab_unreclaimable:89198 [ 80.543664][ T5828] mapped:3062 shmem:21840 pagetables:671 [ 80.543664][ T5828] sec_pagetables:0 bounce:0 [ 80.543664][ T5828] kernel_misc_reclaimable:0 [ 80.543664][ T5828] free:1384255 free_pcp:15031 free_cma:0 [ 80.551961][ T969] u64s 5 type deleted 0:44:0 len 0 ver 0, , continuing [ 80.556269][ T13] u64s 5 type deleted 0:33:0 len 0 ver 0, , continuing [ 80.564609][ T5834] bcachefs (loop4): going read-write [ 80.584405][ T5828] Node 0 active_anon:11832kB inactive_anon:83856kB active_file:18180kB inactive_file:69464kB unevictable:1536kB isolated(anon):0kB isolated(file):0kB mapped:12248kB dirty:56112kB writeback:0kB shmem:85824kB shmem_thp:0kB shmem_pmdmapped:0kB anon_thp:0kB writeback_tmp:0kB kernel_stack:10220kB pagetables:2552kB sec_pagetables:0kB all_unreclaimable? no Balloon:0kB [ 80.590763][ T5834] workqueue: Failed to create a rescuer kthread for wq "bcachefs": -EINTR [ 80.595371][ T5831] bcachefs (loop3): unclean shutdown complete, journal seq 11 [ 80.601269][ T5834] bcachefs (loop4): flushing journal and stopping allocators, journal seq 10 [ 80.607674][ T5831] bcachefs (loop3): error in recovery: EINTR [ 80.612160][ T5834] bcachefs (loop4): flushing journal and stopping allocators complete, journal seq 10 [ 80.621833][ T5831] emergency read only at seq 11 [ 80.621899][ T5831] bcachefs (loop3): bch2_fs_start(): error starting filesystem EINTR [ 80.621912][ T5831] bcachefs (loop3): shutting down [ 80.639177][ T5828] Node 1 active_anon:0kB inactive_anon:0kB active_file:204kB inactive_file:0kB unevictable:1536kB isolated(anon):0kB isolated(file):0kB mapped:0kB dirty:8kB writeback:0kB shmem:1536kB shmem_thp:0kB shmem_pmdmapped:0kB anon_thp:0kB writeback_tmp:0kB kernel_stack:80kB pagetables:132kB sec_pagetables:0kB all_unreclaimable? no Balloon:0kB [ 80.646526][ T5834] bcachefs (loop4): unclean shutdown complete, journal seq 10 [ 80.657884][ T13] bcachefs (loop2): bucket incorrectly unset in freespace btree [ 80.661353][ T5834] bcachefs (loop4): error in recovery: ENOMEM_fs_other_alloc [ 80.666383][ T5831] bcachefs (loop3): shutdown complete [ 80.688235][ T5828] Node 0 [ 80.692100][ T969] bcachefs (loop0): bucket incorrectly unset in freespace btree [ 80.693558][ T13] u64s 5 type deleted 0:30:0 len 0 ver 0, , continuing [ 80.697370][ T969] u64s 5 type deleted 0:46:0 len 0 ver 0, , continuing [ 80.749747][ T5828] DMA free:15360kB boost:0kB min:204kB low:252kB high:300kB reserved_highatomic:0KB free_highatomic:0KB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15360kB mlocked:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB [ 80.755046][ T5834] emergency read only at seq 10 [ 80.769083][ T5828] lowmem_reserve[]: [ 80.775955][ T5834] bcachefs (loop4): bch2_fs_start(): error starting filesystem ENOMEM_fs_other_alloc [ 80.789836][ T5828] 0 [ 80.791181][ T5834] bcachefs (loop4): shutting down [pid 5834] <... mount resumed>) = ? [pid 5831] <... mount resumed>) = ? [pid 5831] +++ killed by SIGKILL +++ [ 80.839664][ T5828] 2501 [ 80.846761][ T969] bcachefs (loop0): bucket incorrectly unset in freespace btree [ 80.859605][ T5828] 2503 [ 80.863590][ T969] u64s 5 type deleted 0:51:0 len 0 ver 0, , continuing [ 80.879660][ T5828] 2503 [ 80.908039][ T5834] bcachefs (loop4): shutdown complete [ 80.952762][ T13] bcachefs (loop2): bucket incorrectly unset in freespace btree [ 81.090105][ T5831] bcachefs: bch2_fs_get_tree() error: EINTR [ 81.116542][ T5828] 2503 [ 81.158829][ T5834] bcachefs: bch2_fs_get_tree() error: ENOMEM_fs_other_alloc [pid 5825] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_KILLED, si_pid=5831, si_uid=0, si_status=SIGKILL, si_utime=4 /* 0.04 s */, si_stime=137 /* 1.37 s */} --- [pid 5825] openat(AT_FDCWD, "/dev/loop3", O_RDWR) = 3 [pid 5825] ioctl(3, LOOP_CLR_FD) = 0 [pid 5825] close(3 [pid 5826] openat(AT_FDCWD, "/sys/fs/fuse/connections", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 5826] newfstatat(3, "", {st_mode=S_IFDIR|0755, st_size=0, ...}, AT_EMPTY_PATH) = 0 [pid 5826] getdents64(3, 0x55558c9c97f0 /* 2 entries */, 32768) = 48 [pid 5826] getdents64(3, 0x55558c9c97f0 /* 0 entries */, 32768) = 0 [pid 5826] close(3) = 0 [ 81.161866][ T5828] [ 81.161876][ T5828] Node 0 DMA32 free:1641800kB boost:0kB min:34264kB low:42828kB high:51392kB reserved_highatomic:0KB free_highatomic:0KB active_anon:12016kB inactive_anon:83940kB active_file:16436kB inactive_file:69388kB unevictable:1536kB writepending:56112kB present:3129332kB managed:2561448kB mlocked:0kB bounce:0kB free_pcp:61744kB local_pcp:34936kB free_cma:0kB [ 81.174956][ T5827] done [ 81.198627][ T5828] lowmem_reserve[]: [pid 5823] openat(AT_FDCWD, "/sys/fs/fuse/connections", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 5823] newfstatat(3, "", {st_mode=S_IFDIR|0755, st_size=0, ...}, AT_EMPTY_PATH) = 0 [pid 5823] getdents64(3, 0x55558c9c97f0 /* 2 entries */, 32768) = 48 [pid 5823] getdents64(3, 0x55558c9c97f0 /* 0 entries */, 32768) = 0 [pid 5823] close(3) = 0 [ 81.204931][ T13] u64s 5 type deleted 0:47:0 len 0 ver 0, , continuing [ 81.219298][ T5828] 0 [ 81.241822][ T5831] syz-executor167 (5831) used greatest stack depth: 20168 bytes left [ 81.251298][ T13] bcachefs (loop2): bucket incorrectly unset in freespace btree [ 81.353775][ T5828] 0 1 1 1 [pid 5834] +++ killed by SIGKILL +++ [pid 5826] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_KILLED, si_pid=5834, si_uid=0, si_status=SIGKILL, si_utime=4 /* 0.04 s */, si_stime=176 /* 1.76 s */} --- [pid 5826] openat(AT_FDCWD, "/dev/loop4", O_RDWR) = 3 [pid 5826] ioctl(3, LOOP_CLR_FD) = 0 [pid 5826] close(3 [pid 5822] openat(AT_FDCWD, "/sys/fs/fuse/connections", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 5822] newfstatat(3, "", {st_mode=S_IFDIR|0755, st_size=0, ...}, AT_EMPTY_PATH) = 0 [ 81.356912][ T5828] Node 0 Normal free:20kB boost:0kB min:24kB low:28kB high:32kB reserved_highatomic:0KB free_highatomic:0KB active_anon:4kB inactive_anon:44kB active_file:1760kB inactive_file:68kB unevictable:0kB writepending:4kB present:1048580kB managed:1904kB mlocked:0kB bounce:0kB free_pcp:8kB local_pcp:0kB free_cma:0kB [ 81.361350][ T5827] bcachefs (loop0): check_alloc_info... [ 81.386541][ T5828] lowmem_reserve[]: 0 0 0 0 0 [ 81.397017][ T5828] Node 1 Normal free:3901516kB boost:0kB min:55612kB low:69512kB high:83412kB reserved_highatomic:0KB free_highatomic:0KB active_anon:0kB inactive_anon:0kB active_file:204kB inactive_file:0kB unevictable:1536kB writepending:8kB present:4194300kB managed:4111164kB mlocked:0kB bounce:0kB free_pcp:20288kB local_pcp:8320kB free_cma:0kB [ 81.430304][ T5828] lowmem_reserve[]: 0 0 0 0 0 [ 81.435065][ T5828] Node 0 DMA: 0*4kB 0*8kB 0*16kB 0*32kB 0*64kB 0*128kB 0*256kB 0*512kB 1*1024kB (U) 1*2048kB (M) 3*4096kB (M) = 15360kB [ 81.448092][ T5828] Node 0 DMA32: 161*4kB (UME) 79*8kB (UM) 70*16kB (UME) 112*32kB (UME) 28*64kB (UME) 23*128kB (UME) 13*256kB (UME) 14*512kB (UME) 5*1024kB (UME) 6*2048kB (UE) 393*4096kB (M) = 1648348kB [ 81.448379][ T13] u64s 5 type deleted 0:49:0 len 0 ver 0, , continuing [pid 5822] getdents64(3, 0x55558c9c97f0 /* 2 entries */, 32768) = 48 [pid 5822] getdents64(3, 0x55558c9c97f0 /* 0 entries */, 32768) = 0 [pid 5822] close(3) = 0 [ 81.466629][ T5828] Node 0 Normal: 1*4kB (M) 0*8kB 1*16kB (M) 0*32kB 0*64kB 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 20kB [ 81.507604][ T5828] Node 1 Normal: 177*4kB (UE) 37*8kB (UME) 40*16kB (UME) 49*32kB (UME) 17*64kB (UME) 7*128kB (UME) 4*256kB (UM) 4*512kB (UME) 2*1024kB (ME) 2*2048kB (UE) 949*4096kB (M) = 3901516kB [pid 5824] openat(AT_FDCWD, "/sys/fs/fuse/connections", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 [pid 5824] newfstatat(3, "", {st_mode=S_IFDIR|0755, st_size=0, ...}, AT_EMPTY_PATH) = 0 [pid 5824] getdents64(3, 0x55558c9c97f0 /* 2 entries */, 32768) = 48 [pid 5824] getdents64(3, 0x55558c9c97f0 /* 0 entries */, 32768) = 0 [pid 5824] close(3) = 0 [ 81.522482][ T5827] bcachefs (loop0): hole in alloc btree missing in freespace btree [ 81.561402][ T5828] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=1048576kB [ 81.582061][ T5828] Node 0 hugepages_total=2 hugepages_free=2 hugepages_surp=0 hugepages_size=2048kB [ 81.589628][ T5827] device 0 buckets 30-31, fixing [ 81.592330][ T5828] Node 1 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=1048576kB [ 81.598813][ T5827] bcachefs (loop0): hole in alloc btree missing in freespace btree [ 81.606519][ T5828] Node 1 hugepages_total=2 hugepages_free=2 hugepages_surp=0 hugepages_size=2048kB [ 81.635640][ T5828] 38550 total pagecache pages [ 81.646178][ T5828] 0 pages in swap cache [ 81.650364][ T5827] device 0 buckets 33-34, fixing [ 81.650686][ T5827] bcachefs (loop0): hole in alloc btree missing in freespace btree [ 81.650699][ T5827] device 0 buckets 36-37, fixing [ 81.651594][ T5827] bcachefs (loop0): bucket incorrectly unset in need_discard btree [ 81.657244][ T5828] Free swap = 0kB [ 81.682435][ T13] bcachefs (loop2): bucket incorrectly unset in freespace btree [ 81.682476][ T13] u64s 5 type deleted 0:55:0 len 0 ver 0, , continuing [pid 5825] <... close resumed>) = 0 [pid 5825] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x55558c9c8750) = 5885 [ 81.691804][ T5827] u64s 13 type alloc_v4 0:37:0 len 0 ver 0: [ 81.691823][ T5827] gen 0 oldest_gen 0 data_type need_discard [ 81.691833][ T5827] journal_seq_nonempty 6 [ 81.691841][ T5827] journal_seq_empty 0 [ 81.691849][ T5827] need_discard 1 [ 81.691857][ T5827] need_inc_gen 1 [ 81.691865][ T5827] dirty_sectors 0 [ 81.691873][ T5827] stripe_sectors 0 [ 81.691881][ T5827] cached_sectors 0 [ 81.691890][ T5827] stripe 0 [pid 5826] <... close resumed>) = 0 ./strace-static-x86_64: Process 5885 attached [ 81.691898][ T5827] stripe_redundancy 0 [ 81.691906][ T5827] io_time[READ] 1 [ 81.691915][ T5827] io_time[WRITE] 1024 [ 81.691923][ T5827] fragmentation 0 [ 81.691931][ T5827] bp_start 8 [ 81.691939][ T5827] , fixing [ 81.723995][ T5827] bcachefs (loop0): hole in alloc btree missing in freespace btree [ 81.732435][ T5828] Total swap = 0kB [ 81.732455][ T5828] 2097051 pages RAM [ 81.732462][ T5828] 0 pages HighMem/MovableOnly [pid 5826] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5885] set_robust_list(0x55558c9c8760, 24./strace-static-x86_64: Process 5886 attached [pid 5886] set_robust_list(0x55558c9c8760, 24) = 0 [pid 5886] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5886] setpgid(0, 0) = 0 [pid 5886] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC) = 3 [pid 5886] write(3, "1000", 4) = 4 [pid 5886] close(3executing program ) = 0 [pid 5886] write(1, "executing program\n", 18) = 18 [pid 5886] memfd_create("syzkaller", 0) = 3 [pid 5886] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f466b600000 [pid 5885] <... set_robust_list resumed>) = 0 [pid 5885] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5885] setpgid(0, 0) = 0 [pid 5885] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC) = 3 [pid 5885] write(3, "1000", 4) = 4 [pid 5885] close(3) = 0 executing program [pid 5885] write(1, "executing program\n", 18) = 18 [pid 5885] memfd_create("syzkaller", 0 [pid 5826] <... clone resumed>, child_tidptr=0x55558c9c8750) = 5886 [pid 5885] <... memfd_create resumed>) = 3 [ 81.732469][ T5828] 424582 pages reserved [ 81.732476][ T5828] 0 pages cma reserved [ 81.749893][ T5828] bcachefs (loop1): flushing journal and stopping allocators, journal seq 10 [ 81.769819][ T5827] device 0 buckets 39-41, fixing [ 81.793379][ T5828] bcachefs (loop1): flushing journal and stopping allocators complete, journal seq 10 [ 81.793398][ T5828] bcachefs (loop1): unclean shutdown complete, journal seq 10 [ 81.794075][ T5828] bcachefs (loop1): error in recovery: ENOMEM [pid 5885] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f466b600000 [ 81.805321][ T5827] bcachefs (loop0): hole in alloc btree missing in freespace btree [ 81.822853][ T5829] done [ 81.878775][ T5827] device 0 buckets 47-51, fixing [ 81.889635][ T5828] emergency read only at seq 10 [ 81.894770][ T5828] bcachefs (loop1): bch2_fs_start(): error starting filesystem ENOMEM [ 81.904488][ T969] bcachefs (loop0): bucket incorrectly unset in freespace btree [ 81.904521][ T969] u64s 5 type deleted 0:55:0 len 0 ver 0, , continuing [ 81.921922][ T5828] bcachefs (loop1): shutting down [ 81.921947][ T5829] bcachefs (loop2): check_alloc_info... [ 81.924256][ T5829] bcachefs (loop2): hole in alloc btree missing in freespace btree [ 81.924270][ T5829] device 0 buckets 36-37, fixing [ 81.926635][ T5829] bcachefs (loop2): bucket incorrectly unset in need_discard btree [ 81.926651][ T5829] u64s 13 type alloc_v4 0:37:0 len 0 ver 0: [ 81.926661][ T5829] gen 0 oldest_gen 0 data_type need_discard [ 81.926671][ T5829] journal_seq_nonempty 6 [ 81.926680][ T5829] journal_seq_empty 0 [ 81.926688][ T5829] need_discard 1 [ 81.926697][ T5829] need_inc_gen 1 [ 81.926705][ T5829] dirty_sectors 0 [ 81.926713][ T5829] stripe_sectors 0 [ 81.926722][ T5829] cached_sectors 0 [ 81.926730][ T5829] stripe 0 [ 81.926739][ T5829] stripe_redundancy 0 [ 81.926747][ T5829] io_time[READ] 1 [ 81.926756][ T5829] io_time[WRITE] 1024 [ 81.926764][ T5829] fragmentation 0 [ 81.926773][ T5829] bp_start 8 [ 81.926781][ T5829] , fixing [ 81.960407][ T5829] bcachefs (loop2): hole in alloc btree missing in freespace btree [ 81.960426][ T5829] device 0 buckets 39-41, fixing [ 81.960671][ T5829] bcachefs (loop2): hole in alloc btree missing in freespace btree [ 81.960691][ T5829] device 0 buckets 43-47, fixing [ 81.960879][ T5829] bcachefs (loop2): hole in alloc btree missing in freespace btree [ 81.960889][ T5829] device 0 buckets 48-49, fixing [ 81.961136][ T5829] bcachefs (loop2): hole in alloc btree missing in freespace btree [ 81.961147][ T5829] device 0 buckets 50-55, fixing [ 81.961336][ T5829] bcachefs (loop2): hole in alloc btree missing in freespace btree [pid 5886] 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 [ 81.961347][ T5829] device 0 buckets 56-120, fixing [ 81.963045][ T5829] done [ 81.963699][ T5829] bcachefs (loop2): check_lrus... done [ 81.963935][ T5829] bcachefs (loop2): check_btree_backpointers... done [ 81.964273][ T5829] bcachefs (loop2): check_backpointers_to_extents... done [ 81.965073][ T5829] bcachefs (loop2): check_extents_to_backpointers... [ 81.966355][ T5829] bcachefs (loop2): scanning for missing backpointers in 8/128 buckets [ 81.977028][ T5829] done [ 81.981646][ T5829] bcachefs (loop2): check_alloc_to_lru_refs... done [ 81.982687][ T5829] bcachefs (loop2): bucket_gens_init... [ 81.989231][ T5828] bcachefs (loop1): shutdown complete [ 82.040165][ T5829] done [ 82.042871][ T5829] bcachefs (loop2): check_snapshot_trees... done [ 82.044254][ T5829] bcachefs (loop2): check_snapshots... done [ 82.044742][ T5829] bcachefs (loop2): check_subvols... done [ 82.050250][ T5829] bcachefs (loop2): check_subvol_children... done [ 82.050351][ T5829] bcachefs (loop2): delete_dead_snapshots... done [ 82.050526][ T5829] bcachefs (loop2): check_inodes... [ 82.051707][ T5829] bcachefs (loop2): inode points to dirent that does not point back: [ 82.051721][ T5829] u64s 7 type dirent 4096:189491840996961599:U32_MAX len 0 ver 0: file0 -> 4098 type dir [ 82.051732][ T5829] inum: 4398046515202:4294967295 [ 82.051740][ T5829] mode=40755 [ 82.051748][ T5829] flags=(15300000) [ 82.051756][ T5829] journal_seq=4 [ 82.051764][ T5829] hash_seed=ece93825deac2443 [ 82.051773][ T5829] hash_type=siphash [ 82.051781][ T5829] bi_size=0 [ 82.051789][ T5829] bi_sectors=0 [ 82.051797][ T5829] bi_version=0 [ 82.051805][ T5829] bi_atime=2770562249 [ 82.051813][ T5829] bi_ctime=2780562352 [ 82.051821][ T5829] bi_mtime=2780562352 [ 82.051829][ T5829] bi_otime=2770562249 [ 82.051838][ T5829] bi_uid=0 [ 82.051845][ T5829] bi_gid=0 [ 82.051853][ T5829] bi_nlink=0 [ 82.051861][ T5829] bi_generation=0 [ 82.051869][ T5829] bi_dev=0 [ 82.051877][ T5829] bi_data_checksum=0 [ 82.051885][ T5829] bi_compression=0 [ 82.051893][ T5829] bi_project=0 [ 82.051901][ T5829] bi_background_compression=0 [ 82.051909][ T5829] bi_data_replicas=0 [ 82.051917][ T5829] bi_promote_target=0 [ 82.051925][ T5829] bi_foreground_target=0 [ 82.051934][ T5829] bi_background_target=0 [ 82.051942][ T5829] bi_erasure_code=0 [ 82.051950][ T5829] bi_fields_set=0 [ 82.051958][ T5829] bi_dir=4096 [ 82.051966][ T5829] bi_dir_offset=189491840996961599 [ 82.051975][ T5829] bi_subvol=0 [ 82.051983][ T5829] bi_parent_subvol=0 [ 82.051991][ T5829] bi_nocow=0 [ 82.051999][ T5829] bi_depth=0 [ 82.052007][ T5829] bi_inodes_32bit=0 [ 82.052015][ T5829] bi_casefold=0, fixing [ 82.052701][ T5829] done [ 82.059616][ T5829] bcachefs (loop2): check_extents... [ 82.478562][ T5827] bcachefs (loop0): hole in alloc btree missing in freespace btree [pid 5885] 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 5828] <... mount resumed>) = ? [pid 5828] +++ killed by SIGKILL +++ [pid 5823] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_KILLED, si_pid=5828, si_uid=0, si_status=SIGKILL, si_utime=5 /* 0.05 s */, si_stime=164 /* 1.64 s */} --- [pid 5823] openat(AT_FDCWD, "/dev/loop1", O_RDWR) = 3 [pid 5823] ioctl(3, LOOP_CLR_FD) = 0 [ 82.478598][ T5827] device 0 buckets 52-55, fixing [ 82.580930][ T5827] bcachefs (loop0): hole in alloc btree missing in freespace btree [ 82.580949][ T5827] device 0 buckets 56-120, fixing [ 82.590432][ T5828] bcachefs: bch2_fs_get_tree() error: ENOMEM [ 82.601166][ T5829] bcachefs (loop2): key in missing inode, found keys: [ 82.601182][ T5829] u64s 7 type extent 4099:8:U32_MAX len 8 ver 0: durability: 1 crc: c_size 8 size 8 offset 0 nonce 0 csum none 0:0 compress incompressible ptr: 0:34:0 gen 0 [pid 5823] close(3 [pid 5885] <... write resumed>) = 16777216 [ 82.601195][ T5829] , fixing [ 82.650758][ T5829] bcachefs (loop2): key in missing inode, found keys: [ 82.650782][ T5829] u64s 10 type inline_data 4100:8:U32_MAX len 8 ver 0: datalen 40: 2f746d702f73797a2d696d61676567656e3931343136303536352f66696c6530 [ 82.650794][ T5829] , fixing [ 82.659933][ T5829] bcachefs (loop2): key in missing inode, found keys: [pid 5885] munmap(0x7f466b600000, 138412032 [pid 5886] <... write resumed>) = 16777216 [pid 5885] <... munmap resumed>) = 0 [pid 5823] <... close resumed>) = 0 [pid 5886] munmap(0x7f466b600000, 138412032 [pid 5885] openat(AT_FDCWD, "/dev/loop3", O_RDWR [pid 5823] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD [pid 5885] <... openat resumed>) = 4 [ 82.659949][ T5829] u64s 7 type inline_data 536870912:8:U32_MAX len 8 ver 0: datalen 16: 73797a6b616c6c657273000000000000 [ 82.659961][ T5829] , fixing [ 82.681423][ T5829] bcachefs (loop2): key in missing inode, found keys: [ 82.681440][ T5829] u64s 7 type extent 536870913:24:U32_MAX len 24 ver 0: durability: 1 crc: c_size 8 size 24 offset 0 nonce 0 csum none 0:0 compress lz4 ptr: 0:34:8 gen 0 [ 82.681452][ T5829] , fixing [ 82.700860][ T5829] bcachefs (loop2): key in missing inode, found keys: [ 82.700878][ T5829] u64s 18 type inline_data 536870914:8:U32_MAX len 8 ver 0: datalen 104: 73797a6b616c6c657273797a6b616c6c657273797a6b616c6c657273797a6b61 [ 82.700890][ T5829] , fixing [ 82.730329][ T5829] done [ 82.738183][ T5829] bcachefs (loop2): check_indirect_extents... done [ 82.738245][ T5829] bcachefs (loop2): check_dirents... [ 82.739404][ T5829] bcachefs (loop2): dirent points to missing inode: [ 82.739417][ T5829] u64s 7 type dirent 4096:189491840996961599:U32_MAX len 0 ver 0: file0 -> 4098 type dir, fixing [pid 5885] ioctl(4, LOOP_SET_FD, 3./strace-static-x86_64: Process 5890 attached [pid 5823] <... clone resumed>, child_tidptr=0x55558c9c8750) = 5890 [pid 5890] set_robust_list(0x55558c9c8760, 24) = 0 [pid 5886] <... munmap resumed>) = 0 [pid 5890] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5886] openat(AT_FDCWD, "/dev/loop4", O_RDWR [pid 5890] setpgid(0, 0 [pid 5886] <... openat resumed>) = 4 [pid 5886] ioctl(4, LOOP_SET_FD, 3 [pid 5890] <... setpgid resumed>) = 0 [pid 5890] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC) = 3 [pid 5890] write(3, "1000", 4) = 4 [pid 5890] close(3) = 0 executing program [pid 5890] write(1, "executing program\n", 18) = 18 [pid 5890] memfd_create("syzkaller", 0) = 3 [pid 5890] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f466b600000 [ 82.740555][ T5829] bcachefs (loop2): dirent points to missing inode: [ 82.740568][ T5829] u64s 7 type dirent 4096:1896155912177158345:U32_MAX len 0 ver 0: file3 -> 536870913 type reg, fixing [ 82.740913][ T5829] bcachefs (loop2): dirent points to missing inode: [ 82.740924][ T5829] u64s 7 type dirent 4096:2695648408715017799:U32_MAX len 0 ver 0: file2 -> 536870913 type reg, fixing [ 82.741251][ T5829] bcachefs (loop2): dirent points to missing inode: [ 82.741261][ T5829] u64s 7 type dirent 4096:4330382808765833931:U32_MAX len 0 ver 0: file1 -> 536870912 type reg, fixing [pid 5886] <... ioctl resumed>) = 0 [pid 5885] <... ioctl resumed>) = 0 [ 82.741647][ T5829] bcachefs (loop2): dirent points to missing inode: [ 82.741657][ T5829] u64s 8 type dirent 4096:9097378837824744618:U32_MAX len 0 ver 0: file.cold -> 536870914 type reg, fixing [ 82.742102][ T5829] bcachefs (loop2): key in missing inode, found keys: [ 82.742113][ T5829] u64s 7 type dirent 4098:5675548428000973578:U32_MAX len 0 ver 0: file1 -> 4100 type lnk [ 82.742124][ T5829] u64s 7 type dirent 4098:8977922886548783724:U32_MAX len 0 ver 0: file0 -> 4099 type reg [ 82.742135][ T5829] , fixing [ 82.742442][ T5829] bcachefs (loop2): key in missing inode, found keys: [ 82.742453][ T5829] u64s 7 type dirent 4098:8977922886548783724:U32_MAX len 0 ver 0: file0 -> 4099 type reg [ 82.742464][ T5829] , fixing [ 82.742624][ T5829] done [ 82.745190][ T5829] bcachefs (loop2): check_xattrs... [ 82.746570][ T5829] bcachefs (loop2): key in missing inode, found keys: [ 82.746586][ T5829] u64s 7 type xattr 536870912:3798421620223919902:U32_MAX len 0 ver 0: user.xattr2:xattr2 [pid 5886] close(3 [pid 5885] close(3) = 0 [pid 5886] <... close resumed>) = 0 [pid 5885] close(4 [pid 5886] close(4 [pid 5885] <... close resumed>) = 0 [pid 5886] <... close resumed>) = 0 [pid 5886] mkdir("./file1", 0777 [pid 5885] mkdir("./file1", 0777 [pid 5886] <... mkdir resumed>) = -1 EEXIST (File exists) [pid 5885] <... mkdir resumed>) = -1 EEXIST (File exists) [pid 5886] mount("/dev/loop4", "./file1", "bcachefs", MS_RDONLY|MS_NOEXEC|MS_MANDLOCK|MS_DIRSYNC|MS_I_VERSION|MS_LAZYTIME, "" [ 82.746596][ T5829] u64s 7 type xattr 536870912:9073845653939145521:U32_MAX len 0 ver 0: user.xattr1:xattr1 [ 82.746607][ T5829] , fixing [ 82.747428][ T5829] bcachefs (loop2): key in missing inode, found keys: [ 82.747439][ T5829] u64s 7 type xattr 536870912:9073845653939145521:U32_MAX len 0 ver 0: user.xattr1:xattr1 [ 82.747450][ T5829] , fixing [ 82.747545][ T5829] done [ 82.750899][ T5829] bcachefs (loop2): check_root... done [ 82.751361][ T5829] bcachefs (loop2): check_unreachable_inodes... [ 82.752520][ T5829] bcachefs (loop2): unreachable inode: [ 82.752533][ T5829] inum: 4398046515202:4294967295 [ 82.752541][ T5829] mode=40755 [ 82.752549][ T5829] flags=(4300000) [ 82.752557][ T5829] journal_seq=20 [ 82.752565][ T5829] hash_seed=ece93825deac2443 [ 82.752574][ T5829] hash_type=siphash [ 82.752582][ T5829] bi_size=0 [ 82.752590][ T5829] bi_sectors=0 [ 82.752598][ T5829] bi_version=0 [ 82.752606][ T5829] bi_atime=2770562249 [ 82.752614][ T5829] bi_ctime=2780562352 [ 82.752622][ T5829] bi_mtime=2780562352 [ 82.752630][ T5829] bi_otime=2770562249 [ 82.752638][ T5829] bi_uid=0 [ 82.752646][ T5829] bi_gid=0 [ 82.752654][ T5829] bi_nlink=0 [ 82.752661][ T5829] bi_generation=0 [ 82.752669][ T5829] bi_dev=0 [ 82.752677][ T5829] bi_data_checksum=0 [ 82.752685][ T5829] bi_compression=0 [ 82.752693][ T5829] bi_project=0 [ 82.752701][ T5829] bi_background_compression=0 [ 82.752710][ T5829] bi_data_replicas=0 [ 82.752718][ T5829] bi_promote_target=0 [ 82.752726][ T5829] bi_foreground_target=0 [pid 5885] mount("/dev/loop3", "./file1", "bcachefs", MS_RDONLY|MS_NOEXEC|MS_MANDLOCK|MS_DIRSYNC|MS_I_VERSION|MS_LAZYTIME, "" [ 82.752734][ T5829] bi_background_target=0 [ 82.752743][ T5829] bi_erasure_code=0 [ 82.752750][ T5829] bi_fields_set=0 [ 82.752758][ T5829] bi_dir=0 [ 82.752766][ T5829] bi_dir_offset=0 [ 82.752774][ T5829] bi_subvol=0 [ 82.752782][ T5829] bi_parent_subvol=0 [ 82.752796][ T5829] bi_nocow=0 [ 82.752804][ T5829] bi_depth=0 [ 82.752812][ T5829] bi_inodes_32bit=0 [ 82.752820][ T5829] bi_casefold=0, fixing [ 82.755303][ T5829] bcachefs (loop2): got lostfound inum 4097 [ 82.792296][ T5829] bcachefs (loop2): got lostfound inum 4097 [ 82.844064][ T5885] loop3: detected capacity change from 0 to 32768 [ 82.850577][ T5829] bcachefs (loop2): got lostfound inum 4097 [ 82.878684][ T5827] done [ 82.884107][ T5829] bcachefs (loop2): reattached at (disconnected) [ 82.916643][ T5886] loop4: detected capacity change from 0 to 32768 [ 82.925218][ T5829] done [ 82.951695][ T5827] bcachefs (loop0): check_lrus... [ 82.967365][ T5829] bcachefs (loop2): check_subvolume_structure... [ 82.980150][ T5827] done [ 83.069719][ T5829] done [ 83.140251][ T5827] bcachefs (loop0): check_btree_backpointers... [ 83.250101][ T5829] bcachefs (loop2): check_directory_structure... [ 83.252760][ T5827] done [ 83.257547][ T5829] done [ 83.308040][ T5827] bcachefs (loop0): check_backpointers_to_extents... [ 83.349604][ T5829] bcachefs (loop2): check_nlinks... done [ 83.363346][ T5827] done [ 83.366145][ T5827] bcachefs (loop0): check_extents_to_backpointers... [ 83.367410][ T5827] bcachefs (loop0): scanning for missing backpointers in 8/128 buckets [ 83.380189][ T5829] bcachefs (loop2): check_rebalance_work... done [ 83.386261][ T5885] bcachefs (loop3): starting version 1.7: mi_btree_bitmap opts=metadata_checksum=none,data_checksum=none,compression=lz4,nojournal_transaction_names,read_only [ 83.389503][ T5829] bcachefs (loop2): resume_logged_ops... [ 83.406745][ T5827] done [ 83.423443][ T5885] allowing incompatible features above 0.0: (unknown version) [ 83.432070][ T5827] bcachefs (loop0): check_alloc_to_lru_refs... done [ 83.439780][ T5885] features: lz4,new_siphash,inline_data,new_extent_overwrite,btree_ptr_v2,new_varint,journal_no_flush,alloc_v2,extents_across_btree_nodes [ 83.439873][ T5827] bcachefs (loop0): bucket_gens_init... [ 83.456521][ T5829] done [ 83.461947][ T5827] done [ 83.463287][ T5886] bcachefs (loop4): starting version 1.7: mi_btree_bitmap opts=metadata_checksum=none,data_checksum=none,compression=lz4,nojournal_transaction_names,read_only [ 83.466956][ T5827] bcachefs (loop0): check_snapshot_trees... [ 83.468529][ T5886] allowing incompatible features above 0.0: (unknown version) [ 83.500046][ T5827] done [ 83.500698][ T5885] bcachefs (loop3): Using encoding defined by superblock: utf8-12.1.0 [ 83.502827][ T5827] bcachefs (loop0): check_snapshots... [ 83.512941][ T5829] bcachefs (loop2): delete_dead_inodes... done [ 83.520081][ T5827] done [ 83.526475][ T5885] bcachefs (loop3): recovering from clean shutdown, journal seq 10 [ 83.527670][ T5827] bcachefs (loop0): check_subvols... [ 83.535766][ T5829] bcachefs (loop2): set_fs_needs_rebalance... [pid 5890] write(3, "\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., 16777216) = 16777216 [ 83.543331][ T5885] bcachefs (loop3): superblock requires following recovery passes to be run: [ 83.543331][ T5885] check_topology,alloc_read,stripes_read,initialize_subvolumes,snapshots_read,check_allocations,set_may_go_rw,journal_replay,check_alloc_info,check_lrus [ 83.574546][ T5886] features: lz4,new_siphash,inline_data,new_extent_overwrite,btree_ptr_v2,new_varint,journal_no_flush,alloc_v2,extents_across_btree_nodes [ 83.577572][ T5827] done [ 83.589289][ T5829] done [pid 5890] munmap(0x7f466b600000, 138412032) = 0 [ 83.596386][ T5886] bcachefs (loop4): Using encoding defined by superblock: utf8-12.1.0 [ 83.605168][ T5886] bcachefs (loop4): recovering from clean shutdown, journal seq 10 [ 83.606598][ T5827] bcachefs (loop0): check_subvol_children... [ 83.614408][ T5885] bcachefs (loop3): Version upgrade required: [ 83.614408][ T5885] Version upgrade from 0.24: unwritten_extents to 1.7: mi_btree_bitmap incomplete [ 83.614408][ T5885] Doing incompatible version upgrade from 0.24: unwritten_extents to 1.28: inode_has_case_insensitive [ 83.614408][ T5885] running recovery passes: 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,check_rebalance_work,set_fs_needs_rebalance [ 83.639630][ T5827] done [pid 5890] openat(AT_FDCWD, "/dev/loop1", O_RDWR) = 4 [ 83.691349][ T5886] bcachefs (loop4): superblock requires following recovery passes to be run: [ 83.691349][ T5886] check_topology,alloc_read,stripes_read,initialize_subvolumes,snapshots_read,check_allocations,set_may_go_rw,journal_replay,check_alloc_info,check_lrus [ 83.717187][ T5886] bcachefs (loop4): Version upgrade required: [ 83.717187][ T5886] Version upgrade from 0.24: unwritten_extents to 1.7: mi_btree_bitmap incomplete [ 83.717187][ T5886] Doing incompatible version upgrade from 0.24: unwritten_extents to 1.28: inode_has_case_insensitive [ 83.717187][ T5886] running recovery passes: 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,check_rebalance_work,set_fs_needs_rebalance [ 83.800446][ T5829] bcachefs (loop2): going read-only [ 83.800501][ T5885] btree_node_read_work: 5 callbacks suppressed [ 83.800514][ T5885] bcachefs (loop3): btree node read error at btree extents level 0/0 [ 83.805769][ T5829] bcachefs (loop2): finished waiting for writes to stop [ 83.814464][ T5890] loop1: detected capacity change from 0 to 32768 [ 83.835190][ T5827] bcachefs (loop0): delete_dead_snapshots... done [pid 5890] ioctl(4, LOOP_SET_FD, 3) = 0 [pid 5890] close(3) = 0 [pid 5890] close(4) = 0 [pid 5890] mkdir("./file1", 0777) = -1 EEXIST (File exists) [ 83.842085][ T5885] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 16 min_key POS_MIN durability: 1 ptr: 0:27:0 gen 0 [ 83.842172][ T5870] bch-copygc/loop (5870) used greatest stack depth: 15736 bytes left [ 83.868830][ T5829] bcachefs (loop2): flushing journal and stopping allocators, journal seq 31 [ 83.873107][ T5885] loop3 node offset 0/16: incorrect min_key: got 0:9:2751463424 should be POS_MIN [ 83.888519][ T5885] flagging btree extents lost data [ 83.894515][ T5827] bcachefs (loop0): check_inodes... [ 83.895687][ T5827] bcachefs (loop0): inode points to dirent that does not point back: [ 83.895704][ T5827] u64s 7 type dirent 4096:189491840996961599:U32_MAX len 0 ver 0: file0 -> 4098 type dir [ 83.895715][ T5827] inum: 4398046515202:4294967295 [ 83.895724][ T5827] mode=40755 [ 83.895732][ T5827] flags=(15300000) [ 83.895740][ T5827] journal_seq=4 [ 83.895749][ T5827] hash_seed=ece93825deac2443 [ 83.895757][ T5827] hash_type=siphash [ 83.895772][ T5827] bi_size=0 [ 83.895780][ T5827] bi_sectors=0 [ 83.895788][ T5827] bi_version=0 [ 83.895796][ T5827] bi_atime=2770562249 [ 83.895804][ T5827] bi_ctime=2780562352 [ 83.895812][ T5827] bi_mtime=2780562352 [ 83.895820][ T5827] bi_otime=2770562249 [ 83.895828][ T5827] bi_uid=0 [ 83.895834][ T5827] bi_gid=0 [ 83.895840][ T5827] bi_nlink=0 [ 83.895847][ T5827] bi_generation=0 [ 83.895855][ T5827] bi_dev=0 [ 83.895862][ T5827] bi_data_checksum=0 [ 83.895870][ T5827] bi_compression=0 [ 83.895877][ T5827] bi_project=0 [ 83.895885][ T5827] bi_background_compression=0 [ 83.895893][ T5827] bi_data_replicas=0 [ 83.895902][ T5827] bi_promote_target=0 [ 83.895909][ T5827] bi_foreground_target=0 [ 83.895918][ T5827] bi_background_target=0 [ 83.895926][ T5827] bi_erasure_code=0 [ 83.895934][ T5827] bi_fields_set=0 [ 83.895940][ T5827] bi_dir=4096 [ 83.895946][ T5827] bi_dir_offset=189491840996961599 [ 83.895954][ T5827] bi_subvol=0 [ 83.895961][ T5827] bi_parent_subvol=0 [ 83.895969][ T5827] bi_nocow=0 [ 83.895977][ T5827] bi_depth=0 [ 83.895984][ T5827] bi_inodes_32bit=0 [ 83.895993][ T5827] bi_casefold=0, fixing [ 83.899137][ T5829] bcachefs (loop2): flushing journal and stopping allocators complete, journal seq 31 [ 83.915995][ T5886] bcachefs (loop4): btree node read error at btree extents level 0/0 [ 83.921209][ T5885] running recovery pass scan_for_btree_nodes (1), currently at recovery_pass_empty (0) [ 83.939846][ T5827] done [ 83.959621][ T5829] bcachefs (loop2): clean shutdown complete, journal seq 32 [ 83.963874][ T5886] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 16 min_key POS_MIN durability: 1 ptr: 0:27:0 gen 0 [ 83.974362][ T5890] bcachefs (loop1): starting version 1.7: mi_btree_bitmap opts=metadata_checksum=none,data_checksum=none,compression=lz4,nojournal_transaction_names,read_only [ 83.985487][ T5829] bcachefs (loop2): done going read-only, filesystem not clean [pid 5890] mount("/dev/loop1", "./file1", "bcachefs", MS_RDONLY|MS_NOEXEC|MS_MANDLOCK|MS_DIRSYNC|MS_I_VERSION|MS_LAZYTIME, "" [pid 5829] <... mount resumed>) = ? [ 84.009621][ T5890] allowing incompatible features above 0.0: (unknown version) [ 84.024236][ T5886] loop4 node offset 0/16: incorrect min_key: got 0:9:2751463424 should be POS_MIN [ 84.037438][ T5885] ret btree_node_read_validate_error [ 84.089604][ T5829] bcachefs (loop2): done starting filesystem [ 84.091898][ T5890] features: lz4,new_siphash,inline_data,new_extent_overwrite,btree_ptr_v2,new_varint,journal_no_flush,alloc_v2,extents_across_btree_nodes [ 84.102971][ T5886] flagging btree extents lost data [pid 5829] +++ killed by SIGKILL +++ [pid 5824] --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_KILLED, si_pid=5829, si_uid=0, si_status=SIGKILL, si_utime=1 /* 0.01 s */, si_stime=228 /* 2.28 s */} --- [pid 5824] openat(AT_FDCWD, "/dev/loop2", O_RDWR) = 3 [pid 5824] ioctl(3, LOOP_CLR_FD) = 0 [pid 5824] close(3) = 0 [pid 5824] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x55558c9c8750) = 5896 ./strace-static-x86_64: Process 5896 attached [pid 5896] set_robust_list(0x55558c9c8760, 24) = 0 [pid 5896] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5896] setpgid(0, 0) = 0 [ 84.104861][ T5890] bcachefs (loop1): Using encoding defined by superblock: utf8-12.1.0 [ 84.120785][ T5827] bcachefs (loop0): check_extents... [ 84.126104][ T5890] bcachefs (loop1): recovering from clean shutdown, journal seq 10 [ 84.160251][ T5886] running recovery pass scan_for_btree_nodes (1), currently at recovery_pass_empty (0) [ 84.167947][ T5885] bcachefs (loop3): error reading btree root btree=extents level=0: btree_node_read_error, fixing [ 84.208702][ T5829] syz-executor167 (5829) used greatest stack depth: 13288 bytes left [ 84.212563][ T5890] bcachefs (loop1): superblock requires following recovery passes to be run: [ 84.212563][ T5890] check_topology,alloc_read,stripes_read,initialize_subvolumes,snapshots_read,check_allocations,set_may_go_rw,journal_replay,check_alloc_info,check_lrus [ 84.241027][ T5886] ret btree_node_read_validate_error [ 84.241586][ T5886] bcachefs (loop4): error reading btree root btree=extents level=0: btree_node_read_error, fixing [ 84.257314][ T5827] bcachefs (loop0): key in missing inode, found keys: [pid 5896] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC) = 3 [pid 5896] write(3, "1000", 4) = 4 [pid 5896] close(3) = 0 [ 84.276090][ T5890] bcachefs (loop1): Version upgrade required: [ 84.276090][ T5890] Version upgrade from 0.24: unwritten_extents to 1.7: mi_btree_bitmap incomplete [ 84.276090][ T5890] Doing incompatible version upgrade from 0.24: unwritten_extents to 1.28: inode_has_case_insensitive executing program [pid 5896] write(1, "executing program\n", 18) = 18 [pid 5896] memfd_create("syzkaller", 0) = 3 [pid 5896] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f466b600000 [ 84.276090][ T5890] running recovery passes: 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,check_rebalance_work,set_fs_needs_rebalance [ 84.310990][ T5885] bcachefs (loop3): btree node read error at btree freespace level 0/0 [ 84.412438][ T5827] u64s 7 type extent 4099:8:U32_MAX len 8 ver 0: durability: 1 crc: c_size 8 size 8 offset 0 nonce 0 csum none 0:0 compress incompressible ptr: 0:63:0 gen 0 [ 84.438968][ T5885] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq e81e1ed936acf3df written 32 min_key POS_MIN durability: 1 ptr: 0:29:0 gen 0 [ 84.450222][ T5886] bcachefs (loop4): btree node read error at btree freespace level 0/0 [ 84.453118][ T5885] loop3 node offset 0/32: incorrect min_key: got 0:227633266688:0 should be POS_MIN [ 84.472375][ T5885] flagging btree freespace lost data [ 84.477868][ T5885] ret btree_node_read_validate_error [ 84.483831][ T5827] , fixing [ 84.488408][ T5885] bcachefs (loop3): error reading btree root btree=freespace level=0: btree_node_read_error, fixing [ 84.496913][ T5827] ================================================================== [ 84.499596][ T5886] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq e81e1ed936acf3df written 32 min_key POS_MIN durability: 1 ptr: 0:29:0 gen 0 [ 84.507213][ T5827] BUG: KASAN: use-after-free in check_extent_overbig+0x273/0x7b0 [ 84.520795][ T5886] loop4 node offset 0/32: incorrect min_key: got 0:227633266688:0 should be POS_MIN [ 84.528675][ T5827] Read of size 8 at addr ffff88806bd02050 by task syz-executor167/5827 [ 84.538415][ T5886] flagging btree freespace lost data [ 84.546409][ T5827] [ 84.546423][ T5827] CPU: 1 UID: 0 PID: 5827 Comm: syz-executor167 Not tainted 6.16.0-rc4-syzkaller-00013-g66701750d556 #0 PREEMPT(full) [ 84.546442][ T5827] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 05/07/2025 [ 84.546452][ T5827] Call Trace: [ 84.546461][ T5827] [ 84.546468][ T5827] dump_stack_lvl+0x189/0x250 [ 84.546492][ T5827] ? __virt_addr_valid+0x1c8/0x5c0 [ 84.546506][ T5827] ? rcu_is_watching+0x15/0xb0 [ 84.546527][ T5827] ? __kasan_check_byte+0x12/0x40 [ 84.546546][ T5827] ? __pfx_dump_stack_lvl+0x10/0x10 [ 84.546566][ T5827] ? rcu_is_watching+0x15/0xb0 [ 84.546585][ T5827] ? lock_release+0x4b/0x3e0 [ 84.546606][ T5827] ? __virt_addr_valid+0x1c8/0x5c0 [ 84.546620][ T5827] ? __virt_addr_valid+0x4a5/0x5c0 [ 84.546635][ T5827] print_report+0xd2/0x2b0 [ 84.546653][ T5827] ? check_extent_overbig+0x273/0x7b0 [ 84.546670][ T5827] kasan_report+0x118/0x150 [ 84.546697][ T5827] ? check_extent_overbig+0x273/0x7b0 [ 84.546717][ T5827] check_extent_overbig+0x273/0x7b0 [ 84.546735][ T5827] ? __pfx_check_extent_overbig+0x10/0x10 [ 84.546752][ T5827] ? bch2_printbuf_exit+0x6f/0xb0 [ 84.546770][ T5827] ? rcu_is_watching+0x15/0xb0 [ 84.546789][ T5827] ? bch2_printbuf_exit+0x6f/0xb0 [ 84.546807][ T5827] ? kfree+0x4d/0x440 [ 84.546827][ T5827] bch2_check_extents+0x5b0/0x4520 [ 84.546848][ T5827] ? finish_task_switch+0x18b/0x950 [ 84.546873][ T5827] ? bch2_check_extents+0x26e/0x4520 [ 84.546889][ T5827] ? rcu_is_watching+0x15/0xb0 [ 84.546910][ T5827] ? __schedule+0x16c0/0x4cb0 [ 84.546930][ T5827] ? lockdep_hardirqs_on+0x9c/0x150 [ 84.546950][ T5827] ? __pfx_bch2_check_extents+0x10/0x10 [ 84.546969][ T5827] ? preempt_schedule_common+0x83/0xd0 [ 84.546987][ T5827] ? console_flush_all+0x7f7/0xc40 [ 84.547004][ T5827] ? __pfx___schedule+0x10/0x10 [ 84.547030][ T5827] ? tick_nohz_tick_stopped+0x86/0xb0 [ 84.547052][ T5827] ? __irq_work_queue_local+0x1de/0x550 [ 84.547072][ T5827] ? __pfx___irq_work_queue_local+0x10/0x10 [ 84.547090][ T5827] ? console_unlock+0x214/0x270 [ 84.547112][ T5827] ? __pfx_console_unlock+0x10/0x10 [ 84.547134][ T5827] ? irq_work_queue+0xbc/0x140 [ 84.547156][ T5827] ? __pfx_vprintk_emit+0x10/0x10 [ 84.547186][ T5827] ? bch2_check_extents+0x26e/0x4520 [ 84.547202][ T5827] ? __pfx___bch2_print+0x10/0x10 [ 84.547220][ T5827] ? _raw_spin_unlock_irq+0x23/0x50 [ 84.547239][ T5827] ? lockdep_hardirqs_on+0x9c/0x150 [ 84.547259][ T5827] __bch2_run_recovery_passes+0x395/0x1010 [ 84.547287][ T5827] bch2_run_recovery_passes+0x184/0x210 [ 84.547306][ T5827] bch2_fs_recovery+0x2690/0x3a50 [ 84.547321][ T5827] ? check_noncircular+0xe0/0x160 [ 84.547350][ T5827] ? __pfx_bch2_fs_recovery+0x10/0x10 [ 84.547371][ T5827] ? __lock_acquire+0xab9/0xd20 [ 84.547395][ T5827] ? __lock_acquire+0xab9/0xd20 [ 84.547416][ T5827] ? __lock_acquire+0xab9/0xd20 [ 84.547444][ T5827] ? bch2_fs_start+0x9fe/0xd90 [ 84.547462][ T5827] ? up_write+0x1c4/0x420 [ 84.547475][ T5827] ? bch2_fs_start+0x5c4/0xd90 [ 84.547493][ T5827] bch2_fs_start+0xa99/0xd90 [ 84.547511][ T5827] ? bch2_fs_start+0x5c4/0xd90 [ 84.547530][ T5827] ? __pfx_bch2_fs_start+0x10/0x10 [ 84.547556][ T5827] ? sget+0x267/0x620 [ 84.547573][ T5827] bch2_fs_get_tree+0xafc/0x14f0 [ 84.547602][ T5827] ? __pfx_bch2_fs_get_tree+0x10/0x10 [ 84.547627][ T5827] ? vfs_parse_monolithic_sep+0x2df/0x310 [ 84.547646][ T5827] ? __pfx_vfs_parse_comma_sep+0x10/0x10 [ 84.547668][ T5827] ? cap_capable+0x11f/0x460 [ 84.547685][ T5827] ? bch2_init_fs_context+0x88/0x110 [ 84.547705][ T5827] ? safesetid_security_capable+0xa9/0x1a0 [ 84.547726][ T5827] vfs_get_tree+0x8f/0x2b0 [ 84.547744][ T5827] do_new_mount+0x24a/0xa40 [ 84.547766][ T5827] __se_sys_mount+0x317/0x410 [ 84.547788][ T5827] ? __pfx___se_sys_mount+0x10/0x10 [ 84.547806][ T5827] ? rcu_is_watching+0x15/0xb0 [ 84.547828][ T5827] ? __x64_sys_mount+0x20/0xc0 [ 84.547847][ T5827] do_syscall_64+0xfa/0x3b0 [ 84.547868][ T5827] ? lockdep_hardirqs_on+0x9c/0x150 [ 84.547887][ T5827] ? entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 84.547903][ T5827] ? clear_bhb_loop+0x60/0xb0 [ 84.547920][ T5827] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 84.547936][ T5827] RIP: 0033:0x7f4673b5851a [ 84.547950][ T5827] Code: d8 64 89 02 48 c7 c0 ff ff ff ff eb a6 e8 5e 04 00 00 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 40 00 49 89 ca b8 a5 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 c7 c1 b8 ff ff ff f7 d8 64 89 01 48 [ 84.547964][ T5827] RSP: 002b:00007ffc34e64088 EFLAGS: 00000282 ORIG_RAX: 00000000000000a5 [ 84.547982][ T5827] RAX: ffffffffffffffda RBX: 00007ffc34e640a0 RCX: 00007f4673b5851a [ 84.547994][ T5827] RDX: 0000200000000000 RSI: 0000200000000200 RDI: 00007ffc34e640a0 [ 84.548006][ T5827] RBP: 0000200000000200 R08: 00007ffc34e640e0 R09: 00000000000059cd [ 84.548017][ T5827] R10: 00000000028000c9 R11: 0000000000000282 R12: 0000200000000000 [ 84.548027][ T5827] R13: 0000000000000004 R14: 0000000000000003 R15: 00007ffc34e640e0 [ 84.548044][ T5827] [ 84.548051][ T5827] [ 84.552038][ T5886] ret btree_node_read_validate_error [ 84.554230][ T5827] The buggy address belongs to the physical page: [ 84.554239][ T5827] page: refcount:0 mapcount:0 mapping:0000000000000000 index:0x0 pfn:0x6bd02 [ 84.566962][ T5886] bcachefs (loop4): error reading btree root btree=freespace level=0: btree_node_read_error, fixing [ 84.576904][ T5827] flags: 0xfff00000000000(node=0|zone=1|lastcpupid=0x7ff) [ 84.576927][ T5827] raw: 00fff00000000000 0000000000000000 ffffea0001af4090 0000000000000000 [ 84.576939][ T5827] raw: 0000000000000000 0000000000000000 00000000ffffffff 0000000000000000 [ 84.576947][ T5827] page dumped because: kasan: bad access detected [ 84.576966][ T5827] page_owner tracks the page as freed [ 84.576972][ T5827] page last allocated via order 5, migratetype Unmovable, gfp_mask 0x42800(GFP_NOWAIT|__GFP_COMP), pid 25, tgid 25 (kworker/1:0H), ts 77587477268, free_ts 84496733498 [ 84.642318][ T5890] bcachefs (loop1): btree node read error at btree extents level 0/0 [ 84.647206][ T5827] post_alloc_hook+0x240/0x2a0 [ 84.663846][ T5886] bcachefs (loop4): btree node read error at btree backpointers level 0/0 [ 84.667964][ T5827] get_page_from_freelist+0x21d5/0x22b0 [ 84.674200][ T5890] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq c6c25c03258c59c5 written 16 min_key POS_MIN durability: 1 ptr: 0:27:0 gen 0 [ 84.677596][ T5827] __alloc_frozen_pages_noprof+0x181/0x370 [ 84.683402][ T5885] bcachefs (loop3): btree node read error at btree backpointers level 0/0 [ 84.688069][ T5827] __alloc_pages_noprof+0xa/0x30 [ 84.695376][ T5886] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 4a8b0fa43a9980a6 written 24 min_key POS_MIN durability: 1 ptr: 0:37:0 gen 0 [ 84.698609][ T5827] ___kmalloc_large_node+0x85/0x210 [ 84.703716][ T5885] u64s 11 type btree_ptr_v2 SPOS_MAX len 0 ver 0: seq 4a8b0fa43a9980a6 written 24 min_key POS_MIN durability: 1 ptr: 0:37:0 gen 0 [ 84.708723][ T5827] __kmalloc_large_node_noprof+0x18/0x90 [ 84.714322][ T5890] loop1 node offset 0/16: incorrect min_key: got 0:9:2751463424 should be POS_MIN [ 84.719683][ T5827] __kvmalloc_node_noprof+0x6d/0x5f0 [ 84.719703][ T5827] bch2_btree_node_read_done+0x33c4/0x5700 [ 84.719723][ T5827] btree_node_read_work+0x426/0xe30 [ 84.719740][ T5827] process_scheduled_works+0xae1/0x17b0 [ 84.719760][ T5827] worker_thread+0x8a0/0xda0 [ 84.725672][ T5886] loop4 node offset 0/24 bset u64s 0: invalid bkey format: field 4 too large: 0 + 1125899906842624 > 4294967295 [ 84.729669][ T5827] kthread+0x711/0x8a0 [ 84.729688][ T5827] ret_from_fork+0x3fc/0x770 [ 84.729704][ T5827] ret_from_fork_asm+0x1a/0x30 [ 84.729718][ T5827] page last free pid 5827 tgid 5827 stack trace: [ 84.729728][ T5827] __free_pages_ok+0xa3b/0xc10 [ 84.735305][ T5890] flagging btree extents lost data [ 84.741302][ T5827] __folio_put+0x21b/0x2c0 [ 84.741321][ T5827] free_large_kmalloc+0x145/0x200 [ 84.741336][ T5827] btree_node_sort+0x117f/0x1760 [ 84.741350][ T5827] bch2_btree_post_write_cleanup+0x11f/0xad0 [ 84.741362][ T5827] bch2_btree_node_prep_for_write+0x337/0x650 [ 84.741380][ T5827] bch2_trans_lock_write+0x669/0xba0 [ 84.747445][ T5886] u64s 3 fields 64:0, 64:0, 32:0, 0:0, 0:1125899906842624, 0:0 [ 84.752209][ T5827] __bch2_trans_commit+0x2773/0x8870 [ 84.752234][ T5827] bch2_check_extents+0x2b24/0x4520 [ 84.752248][ T5827] __bch2_run_recovery_passes+0x395/0x1010 [ 84.752266][ T5827] bch2_run_recovery_passes+0x184/0x210 [ 84.758523][ T5885] loop3 node offset 0/24 bset u64s 0: invalid bkey format: field 4 too large: 0 + 1125899906842624 > 4294967295 [ 84.762185][ T5827] bch2_fs_recovery+0x2690/0x3a50 [ 84.762204][ T5827] bch2_fs_start+0xa99/0xd90 [ 84.762220][ T5827] bch2_fs_get_tree+0xafc/0x14f0 [ 84.762235][ T5827] vfs_get_tree+0x8f/0x2b0 [ 84.762251][ T5827] do_new_mount+0x24a/0xa40 [ 84.762268][ T5827] [ 84.769617][ T5890] running recovery pass scan_for_btree_nodes (1), currently at recovery_pass_empty (0) [ 84.772522][ T5827] Memory state around the buggy address: [ 84.772534][ T5827] ffff88806bd01f00: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 [ 84.777523][ T5890] ret btree_node_read_validate_error [ 84.782694][ T5827] ffff88806bd01f80: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 [ 84.782706][ T5827] >ffff88806bd02000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 [ 84.782713][ T5827] ^ [ 84.782722][ T5827] ffff88806bd02080: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 [ 84.782732][ T5827] ffff88806bd02100: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 [ 84.782739][ T5827] ================================================================== [ 85.059668][ T5886] flagging btree backpointers lost data [ 85.060109][ T5885] u64s 3 fields 64:0, 64:0, 32:0, 0:0, 0:1125899906842624, 0:0 [ 85.072569][ T5886] ret btree_node_read_validate_error [ 85.089870][ T5885] flagging btree backpointers lost data [ 85.147152][ T5886] bcachefs (loop4): error reading btree root btree=backpointers level=0: btree_node_read_error, fixing [ 85.173199][ T5885] ret btree_node_read_validate_error [ 85.185944][ T5827] Kernel panic - not syncing: KASAN: panic_on_warn set ... [ 85.185980][ T5827] CPU: 1 UID: 0 PID: 5827 Comm: syz-executor167 Not tainted 6.16.0-rc4-syzkaller-00013-g66701750d556 #0 PREEMPT(full) [ 85.186002][ T5827] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 05/07/2025 [ 85.186014][ T5827] Call Trace: [ 85.186022][ T5827] [ 85.186030][ T5827] dump_stack_lvl+0x99/0x250 [ 85.186057][ T5827] ? __asan_memcpy+0x40/0x70 [ 85.186073][ T5827] ? __pfx_dump_stack_lvl+0x10/0x10 [ 85.186095][ T5827] ? __pfx__printk+0x10/0x10 [ 85.186116][ T5827] panic+0x2db/0x790 [ 85.186138][ T5827] ? __pfx_panic+0x10/0x10 [ 85.186161][ T5827] ? _raw_spin_unlock_irqrestore+0xfd/0x110 [ 85.186181][ T5827] ? __pfx__raw_spin_unlock_irqrestore+0x10/0x10 [ 85.186200][ T5827] ? print_memory_metadata+0x314/0x400 [ 85.186220][ T5827] ? check_extent_overbig+0x273/0x7b0 [ 85.186237][ T5827] check_panic_on_warn+0x89/0xb0 [ 85.186256][ T5827] ? check_extent_overbig+0x273/0x7b0 [ 85.186272][ T5827] end_report+0x78/0x160 [ 85.186290][ T5827] kasan_report+0x129/0x150 [ 85.186310][ T5827] ? check_extent_overbig+0x273/0x7b0 [ 85.186329][ T5827] check_extent_overbig+0x273/0x7b0 [ 85.186348][ T5827] ? __pfx_check_extent_overbig+0x10/0x10 [ 85.186365][ T5827] ? bch2_printbuf_exit+0x6f/0xb0 [ 85.186383][ T5827] ? rcu_is_watching+0x15/0xb0 [ 85.186405][ T5827] ? bch2_printbuf_exit+0x6f/0xb0 [ 85.186423][ T5827] ? kfree+0x4d/0x440 [ 85.186443][ T5827] bch2_check_extents+0x5b0/0x4520 [ 85.186464][ T5827] ? finish_task_switch+0x18b/0x950 [ 85.186491][ T5827] ? bch2_check_extents+0x26e/0x4520 [ 85.186507][ T5827] ? rcu_is_watching+0x15/0xb0 [ 85.186528][ T5827] ? __schedule+0x16c0/0x4cb0 [ 85.186548][ T5827] ? lockdep_hardirqs_on+0x9c/0x150 [ 85.186569][ T5827] ? __pfx_bch2_check_extents+0x10/0x10 [ 85.186589][ T5827] ? preempt_schedule_common+0x83/0xd0 [ 85.186608][ T5827] ? console_flush_all+0x7f7/0xc40 [ 85.186640][ T5827] ? __pfx___schedule+0x10/0x10 [ 85.186666][ T5827] ? tick_nohz_tick_stopped+0x86/0xb0 [ 85.186689][ T5827] ? __irq_work_queue_local+0x1de/0x550 [ 85.186710][ T5827] ? __pfx___irq_work_queue_local+0x10/0x10 [ 85.186729][ T5827] ? console_unlock+0x214/0x270 [ 85.186752][ T5827] ? __pfx_console_unlock+0x10/0x10 [ 85.186774][ T5827] ? irq_work_queue+0xbc/0x140 [ 85.186797][ T5827] ? __pfx_vprintk_emit+0x10/0x10 [ 85.186828][ T5827] ? bch2_check_extents+0x26e/0x4520 [ 85.186845][ T5827] ? __pfx___bch2_print+0x10/0x10 [ 85.186865][ T5827] ? _raw_spin_unlock_irq+0x23/0x50 [ 85.186884][ T5827] ? lockdep_hardirqs_on+0x9c/0x150 [ 85.186905][ T5827] __bch2_run_recovery_passes+0x395/0x1010 [ 85.186933][ T5827] bch2_run_recovery_passes+0x184/0x210 [ 85.186953][ T5827] bch2_fs_recovery+0x2690/0x3a50 [ 85.186969][ T5827] ? check_noncircular+0xe0/0x160 [ 85.187016][ T5827] ? __pfx_bch2_fs_recovery+0x10/0x10 [ 85.187036][ T5827] ? __lock_acquire+0xab9/0xd20 [ 85.802557][ T5827] ? __lock_acquire+0xab9/0xd20 [ 85.807419][ T5827] ? __lock_acquire+0xab9/0xd20 [ 85.812270][ T5827] ? bch2_fs_start+0x9fe/0xd90 [ 85.817050][ T5827] ? up_write+0x1c4/0x420 [ 85.821373][ T5827] ? bch2_fs_start+0x5c4/0xd90 [ 85.826134][ T5827] bch2_fs_start+0xa99/0xd90 [ 85.831173][ T5827] ? bch2_fs_start+0x5c4/0xd90 [ 85.836020][ T5827] ? __pfx_bch2_fs_start+0x10/0x10 [ 85.841127][ T5827] ? sget+0x267/0x620 [ 85.845123][ T5827] bch2_fs_get_tree+0xafc/0x14f0 [ 85.850059][ T5827] ? __pfx_bch2_fs_get_tree+0x10/0x10 [ 85.855427][ T5827] ? vfs_parse_monolithic_sep+0x2df/0x310 [ 85.861140][ T5827] ? __pfx_vfs_parse_comma_sep+0x10/0x10 [ 85.866765][ T5827] ? cap_capable+0x11f/0x460 [ 85.871433][ T5827] ? bch2_init_fs_context+0x88/0x110 [ 85.876811][ T5827] ? safesetid_security_capable+0xa9/0x1a0 [ 85.882613][ T5827] vfs_get_tree+0x8f/0x2b0 [ 85.887029][ T5827] do_new_mount+0x24a/0xa40 [ 85.891530][ T5827] __se_sys_mount+0x317/0x410 [ 85.896205][ T5827] ? __pfx___se_sys_mount+0x10/0x10 [ 85.901393][ T5827] ? rcu_is_watching+0x15/0xb0 [ 85.906154][ T5827] ? __x64_sys_mount+0x20/0xc0 [ 85.911095][ T5827] do_syscall_64+0xfa/0x3b0 [ 85.915591][ T5827] ? lockdep_hardirqs_on+0x9c/0x150 [ 85.920785][ T5827] ? entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 85.926842][ T5827] ? clear_bhb_loop+0x60/0xb0 [ 85.931508][ T5827] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 85.937392][ T5827] RIP: 0033:0x7f4673b5851a [ 85.941886][ T5827] Code: d8 64 89 02 48 c7 c0 ff ff ff ff eb a6 e8 5e 04 00 00 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 40 00 49 89 ca b8 a5 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 c7 c1 b8 ff ff ff f7 d8 64 89 01 48 [ 85.961594][ T5827] RSP: 002b:00007ffc34e64088 EFLAGS: 00000282 ORIG_RAX: 00000000000000a5 [ 85.970023][ T5827] RAX: ffffffffffffffda RBX: 00007ffc34e640a0 RCX: 00007f4673b5851a [ 85.978004][ T5827] RDX: 0000200000000000 RSI: 0000200000000200 RDI: 00007ffc34e640a0 [ 85.985983][ T5827] RBP: 0000200000000200 R08: 00007ffc34e640e0 R09: 00000000000059cd [ 85.993963][ T5827] R10: 00000000028000c9 R11: 0000000000000282 R12: 0000200000000000 [ 86.002115][ T5827] R13: 0000000000000004 R14: 0000000000000003 R15: 00007ffc34e640e0 [ 86.010179][ T5827] [ 86.013484][ T5827] Kernel Offset: disabled [ 86.017802][ T5827] Rebooting in 86400 seconds..