./strace-static-x86_64 -e \!wait4,clock_nanosleep,nanosleep -s 100 -x -f ./syz-executor935049785 <...> Warning: Permanently added '10.128.0.75' (ED25519) to the list of known hosts. execve("./syz-executor935049785", ["./syz-executor935049785"], 0x7ffc29a99230 /* 10 vars */) = 0 brk(NULL) = 0x5555870f9000 brk(0x5555870f9d00) = 0x5555870f9d00 arch_prctl(ARCH_SET_FS, 0x5555870f9380) = 0 set_tid_address(0x5555870f9650) = 5835 set_robust_list(0x5555870f9660, 24) = 0 rseq(0x5555870f9ca0, 0x20, 0, 0x53053053) = 0 prlimit64(0, RLIMIT_STACK, NULL, {rlim_cur=8192*1024, rlim_max=RLIM64_INFINITY}) = 0 readlink("/proc/self/exe", "/root/syz-executor935049785", 4096) = 27 getrandom("\x4f\xae\xec\x0d\x90\x97\xa2\x74", 8, GRND_NONBLOCK) = 8 brk(NULL) = 0x5555870f9d00 brk(0x55558711ad00) = 0x55558711ad00 brk(0x55558711b000) = 0x55558711b000 mprotect(0x7fd7ad4f8000, 16384, PROT_READ) = 0 mmap(0x1ffff000, 4096, PROT_NONE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x1ffff000 mmap(0x20000000, 16777216, PROT_READ|PROT_WRITE|PROT_EXEC, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x20000000 mmap(0x21000000, 4096, PROT_NONE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x21000000 clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5836 attached [pid 5836] set_robust_list(0x5555870f9660, 24 [pid 5835] <... clone resumed>, child_tidptr=0x5555870f9650) = 5836 [pid 5836] <... set_robust_list resumed>) = 0 [pid 5835] openat(AT_FDCWD, "/sys/kernel/debug/x86/nmi_longest_ns", O_WRONLY|O_CLOEXEC) = 3 [pid 5835] write(3, "10000000000", 11) = 11 [pid 5835] close(3) = 0 [pid 5835] openat(AT_FDCWD, "/proc/sys/kernel/hung_task_check_interval_secs", O_WRONLY|O_CLOEXEC) = 3 [pid 5835] write(3, "20", 2) = 2 [pid 5835] close(3) = 0 [pid 5835] openat(AT_FDCWD, "/proc/sys/net/core/bpf_jit_kallsyms", O_WRONLY|O_CLOEXEC) = 3 [pid 5835] write(3, "1", 1) = 1 [pid 5835] close(3) = 0 [pid 5835] openat(AT_FDCWD, "/proc/sys/net/core/bpf_jit_harden", O_WRONLY|O_CLOEXEC) = 3 [pid 5835] write(3, "0", 1) = 1 [pid 5835] close(3) = 0 [pid 5835] openat(AT_FDCWD, "/proc/sys/kernel/kptr_restrict", O_WRONLY|O_CLOEXEC) = 3 [pid 5835] write(3, "0", 1) = 1 [pid 5835] close(3) = 0 [pid 5835] openat(AT_FDCWD, "/proc/sys/kernel/softlockup_all_cpu_backtrace", O_WRONLY|O_CLOEXEC) = 3 [pid 5835] write(3, "1", 1) = 1 [pid 5835] close(3) = 0 [pid 5835] openat(AT_FDCWD, "/proc/sys/fs/mount-max", O_WRONLY|O_CLOEXEC) = 3 [pid 5835] write(3, "100", 3) = 3 [pid 5835] close(3) = 0 [pid 5835] openat(AT_FDCWD, "/proc/sys/vm/oom_dump_tasks", O_WRONLY|O_CLOEXEC) = 3 [pid 5835] write(3, "0", 1) = 1 [pid 5835] close(3) = 0 [pid 5835] openat(AT_FDCWD, "/proc/sys/debug/exception-trace", O_WRONLY|O_CLOEXEC) = 3 [pid 5835] write(3, "0", 1) = 1 [pid 5835] close(3) = 0 [pid 5835] openat(AT_FDCWD, "/proc/sys/kernel/printk", O_WRONLY|O_CLOEXEC) = 3 [pid 5835] write(3, "7 4 1 3", 7) = 7 [pid 5835] close(3) = 0 [pid 5835] openat(AT_FDCWD, "/proc/sys/kernel/keys/gc_delay", O_WRONLY|O_CLOEXEC) = 3 [pid 5835] write(3, "1", 1) = 1 [pid 5835] close(3) = 0 [pid 5835] openat(AT_FDCWD, "/proc/sys/vm/oom_kill_allocating_task", O_WRONLY|O_CLOEXEC) = 3 [pid 5835] write(3, "1", 1) = 1 [pid 5835] close(3) = 0 [pid 5835] openat(AT_FDCWD, "/proc/sys/kernel/ctrl-alt-del", O_WRONLY|O_CLOEXEC) = 3 [pid 5835] write(3, "0", 1) = 1 [pid 5835] close(3) = 0 [pid 5835] openat(AT_FDCWD, "/proc/sys/kernel/cad_pid", O_WRONLY|O_CLOEXEC) = 3 [pid 5835] write(3, "5836", 4) = 4 [pid 5835] close(3) = 0 [pid 5835] kill(5836, SIGKILL) = 0 [pid 5836] +++ killed by SIGKILL +++ --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_KILLED, si_pid=5836, si_uid=0, si_status=SIGKILL, si_utime=0, si_stime=0} --- mkdir("./syzkaller.Iz1Iza", 0700) = 0 chmod("./syzkaller.Iz1Iza", 0777) = 0 chdir("./syzkaller.Iz1Iza") = 0 mkdir("./0", 0777) = 0 openat(AT_FDCWD, "/dev/loop0", O_RDWR) = 3 ioctl(3, LOOP_CLR_FD) = -1 ENXIO (No such device or address) close(3) = 0 clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5838 attached , child_tidptr=0x5555870f9650) = 5838 [pid 5838] set_robust_list(0x5555870f9660, 24) = 0 [pid 5838] chdir("./0") = 0 [pid 5838] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5838] setpgid(0, 0) = 0 [pid 5838] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC) = 3 [pid 5838] write(3, "1000", 4) = 4 [pid 5838] close(3) = 0 [pid 5838] symlink("/dev/binderfs", "./binderfs") = 0 [pid 5838] write(1, "executing program\n", 18executing program ) = 18 [pid 5838] memfd_create("syzkaller", 0) = 3 [pid 5838] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7fd7a5000000 [pid 5838] write(3, "\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., 16777216) = 16777216 [pid 5838] munmap(0x7fd7a5000000, 138412032) = 0 [pid 5838] openat(AT_FDCWD, "/dev/loop0", O_RDWR) = 4 [pid 5838] ioctl(4, LOOP_SET_FD, 3) = 0 [pid 5838] close(3) = 0 [pid 5838] close(4) = 0 [pid 5838] mkdir("./file0", 0777) = 0 [ 148.346347][ T5838] loop0: detected capacity change from 0 to 32768 [ 148.423046][ T5838] bcachefs (loop0): starting version 1.7: mi_btree_bitmap opts=metadata_checksum=none,data_checksum=none,compression=lz4,nojournal_transaction_names [ 148.438900][ T5838] bcachefs (loop0): recovering from clean shutdown, journal seq 13 [ 148.458147][ T5838] bcachefs (loop0): accounting_read... done [ 148.465236][ T5838] bcachefs (loop0): alloc_read... done [ 148.470846][ T5838] bcachefs (loop0): stripes_read... done [ 148.476563][ T5838] bcachefs (loop0): snapshots_read... done [ 148.484437][ T5838] bcachefs (loop0): journal_replay... done [ 148.490371][ T5838] bcachefs (loop0): resume_logged_ops... done [ 148.496516][ T5838] bcachefs (loop0): delete_dead_inodes... done [ 148.505068][ T5838] bcachefs (loop0): going read-write [ 148.514234][ T3508] bcachefs (loop0 inum 4099 offset 0): data data checksum error, type chacha20_poly1305_80: got d2966045f85a9d651be5 should be 7179c5105bb769ac71e3 [ 148.525398][ T53] bcachefs (loop0 inum 1073741825 offset 0): data data checksum error, type chacha20_poly1305_80: got bae05aa1239bc278accd should be 9d9f00f7643c85751d5c [ 148.545985][ T5838] bcachefs (loop0): done starting filesystem [ 148.546326][ T3508] bcachefs (loop0 inum 4099 offset 0): no device to read from: no_device_to_read_from [pid 5838] mount("/dev/loop0", "./file0", "bcachefs", MS_RELATIME|MS_STRICTATIME|MS_LAZYTIME, "\xf3\xf6\xe7\xab\x27\x5e\x7b\x9e\xc1\xca\x06\x63\x35\x54\xe2\xf6\xfa\xd2\xf9\xfb\xc1\x7a\x0b\x2f\xed\xc7\xf5\x95\x28\xeb\xb3\x35\xc5\x51\x32\xcf\x87\x9c\x5c\x26\x1e\x3a\xa0\x60\x65\xeb\xb6\x78\x7a\x85\xfd\xc3\x1e\xc4\xc0\xb0\xad\xd4\xec\x97\xcf\x69\x24\xcf\x23\xa5\x53\xcb\x53\xcc\x5f\x4a\xf2\xff\x61\x4b\xdd\x64\xf0\x9d\xe3\x27") = 0 [pid 5838] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY) = 3 [pid 5838] chdir("./file0") = 0 [pid 5838] openat(AT_FDCWD, "/dev/loop0", O_RDWR) = 4 [pid 5838] ioctl(4, LOOP_CLR_FD) = 0 [pid 5838] close(4) = 0 [ 148.546326][ T3508] u64s 8 type extent 4099:8:U32_MAX len 8 ver 1: durability: 1 crc: c_size 8 size 8 offset 0 nonce 0 csum chacha20_poly1305_80 e371:ac69b75b10c57971 compress incompressible ptr: 0:34:0 gen 0 [ 148.560413][ T53] bcachefs (loop0 inum 1073741825 offset 0): no device to read from: no_device_to_read_from [ 148.560413][ T53] u64s 8 type extent 1073741825:24:U32_MAX len 24 ver 2: durability: 1 crc: c_size 8 size 24 offset 0 nonce 0 csum chacha20_poly1305_80 5c1d:75853c64f7009f9d compress lz4 ptr: 0:34:8 gen 0 [pid 5838] creat("./file0aaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaa", 020) = 4 [pid 5838] exit_group(0) = ? [pid 5838] +++ exited with 0 +++ --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5838, si_uid=0, si_status=0, si_utime=3 /* 0.03 s */, si_stime=25 /* 0.25 s */} --- umount2("./0", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) openat(AT_FDCWD, "./0", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3 newfstatat(3, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0 getdents64(3, 0x5555870fa6f0 /* 4 entries */, 32768) = 112 [ 148.664882][ T5838] syz-executor935 (5838) used greatest stack depth: 19248 bytes left umount2("./0/binderfs", MNT_FORCE|UMOUNT_NOFOLLOW) = -1 EINVAL (Invalid argument) newfstatat(AT_FDCWD, "./0/binderfs", {st_mode=S_IFLNK|0777, st_size=13, ...}, AT_SYMLINK_NOFOLLOW) = 0 unlink("./0/binderfs") = 0 [ 148.756002][ T5835] bcachefs (loop0): shutting down [ 148.761143][ T5835] bcachefs (loop0): going read-only [ 148.766862][ T5835] bcachefs (loop0): finished waiting for writes to stop [ 148.776002][ T5835] bcachefs (loop0): flushing journal and stopping allocators, journal seq 15 [ 180.476010][ T5835] Allocator stuck? Waited for 30 seconds [ 180.476033][ T5835] Allocator debug: [ 180.476039][ T5835] capacity1536 [ 180.476044][ T5835] reserved 31232 [ 180.476050][ T5835] hidden 0 [ 180.476055][ T5835] btree 0 [ 180.476061][ T5835] data 0 [ 180.476066][ T5835] cached 0 [ 180.476072][ T5835] reserved 0 [ 180.476077][ T5835] online_reserved 768 [ 180.476083][ T5835] nr_inodes 0 [ 180.476088][ T5835] [ 180.476093][ T5835] freelist_wait waiting [ 180.476099][ T5835] open buckets allocated1 [ 180.476104][ T5835] open buckets total 1024 [ 180.476110][ T5835] open_buckets_wait empty [ 180.476116][ T5835] open_buckets_btree 0 [ 180.476121][ T5835] open_buckets_user 0 [ 180.476127][ T5835] btree reserve cache 0 [ 180.476132][ T5835] [ 180.476137][ T5835] Dev 0: [ 180.476142][ T5835] buckets sectors fragmented [ 180.476148][ T5835] free 0 0 0 [ 180.476155][ T5835] sb 0 0 0 [ 180.476161][ T5835] journal 0 0 0 [ 180.476167][ T5835] btree 0 0 0 [ 180.476173][ T5835] user 0 0 0 [ 180.476180][ T5835] cached 0 0 0 [ 180.476186][ T5835] parity 0 0 0 [ 180.476192][ T5835] stripe 0 0 0 [ 180.476198][ T5835] need_gc_gens 0 0 0 [ 180.476204][ T5835] need_discard 0 0 0 [ 180.476210][ T5835] unstriped 0 0 0 [ 180.476217][ T5835] capacity 128 [ 180.476222][ T5835] [ 180.476227][ T5835] reserves: [ 180.476232][ T5835] stripe 60 [ 180.476238][ T5835] normal 58 [ 180.476243][ T5835] copygc 56 [ 180.476249][ T5835] btree 28 [ 180.476254][ T5835] btree_copygc 0 [ 180.476260][ T5835] reclaim 0 [ 180.476265][ T5835] interior_updates 0 [ 180.476271][ T5835] [ 180.476276][ T5835] open buckets 0 [ 180.476282][ T5835] buckets to invalidate 0 [ 180.476287][ T5835] [ 180.476293][ T5835] Copygc debug: [ 180.476298][ T5835] running: 0 [ 180.476303][ T5835] copygc_wait:0 [ 180.476308][ T5835] copygc_wait_at:0 [ 180.476314][ T5835] Currently waiting for:0 B [ 180.476319][ T5835] Currently waiting since:640 KiB [ 180.476325][ T5835] Currently calculated wait:0 B [ 180.476330][ T5835] [ 180.476335][ T5835] Journal debug: [ 180.476340][ T5835] flags: replay_done,running,may_skip_flush [ 180.476347][ T5835] dirty journal entries: 3/32768 [ 180.476352][ T5835] seq: 16 [ 180.476358][ T5835] seq_ondisk: 16 [ 180.476363][ T5835] last_seq: 14 [ 180.476369][ T5835] last_seq_ondisk: 14 [ 180.476374][ T5835] flushed_seq_ondisk: 16 [ 180.476380][ T5835] watermark: stripe [ 180.476385][ T5835] each entry reserved: 321 [ 180.476391][ T5835] nr flush writes: 2 [ 180.476396][ T5835] nr noflush writes: 1 [ 180.476402][ T5835] average write size: 1.43 KiB [ 180.476408][ T5835] nr direct reclaim: 0 [ 180.476413][ T5835] nr background reclaim: 4 [ 180.476419][ T5835] reclaim kicked: 0 [ 180.476426][ T5835] reclaim runs in: 0 ms [ 180.476433][ T5835] blocked: 0 [ 180.476438][ T5835] current entry sectors: 256 [ 180.476444][ T5835] current entry error: ok [ 180.476450][ T5835] current entry: closed [ 180.476455][ T5835] unwritten entries: [ 180.476460][ T5835] last buf closed [ 180.476466][ T5835] space: [ 180.476471][ T5835] discarded 256:1536 [ 180.476477][ T5835] clean ondisk 256:1536 [ 180.476482][ T5835] clean 256:1536 [ 180.476488][ T5835] total 256:2048 [ 180.476493][ T5835] dev 0: [ 180.476499][ T5835] nr 8 [ 180.476504][ T5835] bucket size 256 [ 180.476510][ T5835] available 6:232 [ 180.476515][ T5835] discard_idx 0 [ 180.476521][ T5835] dirty_ondisk 0 (seq 16) [ 180.476527][ T5835] dirty_idx 0 (seq 16) [ 180.476532][ T5835] cur_idx 0 (seq 16) [ 180.476538][ T5835] [ 307.185412][ T30] INFO: task bch-reclaim/loo:5846 blocked for more than 143 seconds. [ 307.194025][ T30] Not tainted 6.13.0-rc2-syzkaller-00159-gf932fb9b4074 #0 [ 307.201786][ T30] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 307.210527][ T30] task:bch-reclaim/loo state:D stack:25176 pid:5846 tgid:5846 ppid:2 flags:0x00004000 [ 307.220774][ T30] Call Trace: [ 307.224072][ T30] [ 307.227054][ T30] __schedule+0x17fb/0x4be0 [ 307.231626][ T30] ? __pfx___schedule+0x10/0x10 [ 307.236536][ T30] ? __pfx_lock_release+0x10/0x10 [ 307.241687][ T30] ? _raw_spin_unlock_irqrestore+0x8f/0x140 [ 307.247904][ T30] ? _raw_spin_unlock_irqrestore+0xdd/0x140 [ 307.253827][ T30] ? __pfx__raw_spin_unlock_irqrestore+0x10/0x10 [ 307.260246][ T30] ? schedule+0x90/0x320 [ 307.264515][ T30] schedule+0x14b/0x320 [ 307.268747][ T30] schedule_preempt_disabled+0x13/0x30 [ 307.274225][ T30] __mutex_lock+0x7e7/0xee0 [ 307.278781][ T30] ? __mutex_lock+0x5ef/0xee0 [ 307.283511][ T30] ? btree_write_buffer_flush_seq+0x1b19/0x1cc0 [ 307.289797][ T30] ? __pfx___mutex_lock+0x10/0x10 [ 307.294875][ T30] ? bch2_next_write_buffer_flush_journal_buf+0xb1/0x1b0 [ 307.301951][ T30] ? __pfx_bch2_next_write_buffer_flush_journal_buf+0x10/0x10 [ 307.309468][ T30] ? bch2_trans_unlock+0x3a6/0x470 [ 307.314687][ T30] btree_write_buffer_flush_seq+0x1b19/0x1cc0 [ 307.320873][ T30] ? __asan_memset+0x23/0x50 [ 307.325523][ T30] ? lockdep_init_map_type+0xa1/0x910 [ 307.330926][ T30] ? __pfx_btree_write_buffer_flush_seq+0x10/0x10 [ 307.337416][ T30] ? __pfx_lockdep_init_map_type+0x10/0x10 [ 307.343251][ T30] ? __pfx_bch2_btree_write_buffer_journal_flush+0x10/0x10 [ 307.350522][ T30] bch2_btree_write_buffer_journal_flush+0xc7/0x150 [ 307.357195][ T30] ? __pfx_bch2_btree_write_buffer_journal_flush+0x10/0x10 [ 307.364535][ T30] ? do_raw_spin_unlock+0xa1/0x8b0 [ 307.369746][ T30] ? __pfx_bch2_btree_write_buffer_journal_flush+0x10/0x10 [ 307.376992][ T30] journal_flush_pins+0x5f7/0xb20 [ 307.382120][ T30] __bch2_journal_reclaim+0x789/0xda0 [ 307.387621][ T30] bch2_journal_reclaim_thread+0x174/0x560 [ 307.393467][ T30] ? bch2_journal_reclaim_thread+0x249/0x560 [ 307.399544][ T30] ? __pfx_bch2_journal_reclaim_thread+0x10/0x10 [ 307.405945][ T30] kthread+0x2f0/0x390 [ 307.410026][ T30] ? __pfx_bch2_journal_reclaim_thread+0x10/0x10 [ 307.416402][ T30] ? __pfx_kthread+0x10/0x10 [ 307.421017][ T30] ret_from_fork+0x4b/0x80 [ 307.425490][ T30] ? __pfx_kthread+0x10/0x10 [ 307.430101][ T30] ret_from_fork_asm+0x1a/0x30 [ 307.434872][ T30] [ 307.437994][ T30] [ 307.437994][ T30] Showing all locks held in the system: [ 307.445753][ T30] 1 lock held by khungtaskd/30: [ 307.450625][ T30] #0: ffffffff8e937ae0 (rcu_read_lock){....}-{1:3}, at: debug_show_all_locks+0x55/0x2a0 [ 307.460583][ T30] 1 lock held by klogd/5183: [ 307.465237][ T30] #0: ffff8880b873e758 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock_nested+0x2a/0x140 [ 307.475276][ T30] 2 locks held by getty/5573: [ 307.479971][ T30] #0: ffff8880317670a0 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x25/0x70 [ 307.489802][ T30] #1: ffffc90002fde2f0 (&ldata->atomic_read_lock){+.+.}-{4:4}, at: n_tty_read+0x6a6/0x1e00 [ 307.500181][ T30] 5 locks held by syz-executor935/5835: [ 307.505910][ T30] #0: ffff88807bb860e0 (&type->s_umount_key#43){+.+.}-{4:4}, at: deactivate_super+0xb5/0xf0 [ 307.516219][ T30] #1: ffff888072900278 (&c->state_lock){+.+.}-{4:4}, at: __bch2_fs_stop+0xfd/0x5c0 [ 307.525700][ T30] #2: ffff888072904398 (&c->btree_trans_barrier){.+.+}-{0:0}, at: __bch2_trans_get+0x7e1/0xd30 [ 307.536237][ T30] #3: ffff888072904740 (&wb->flushing.lock){+.+.}-{4:4}, at: btree_write_buffer_flush_seq+0x1b19/0x1cc0 [ 307.547584][ T30] #4: ffff8880729266d0 (&c->gc_lock){.+.+}-{4:4}, at: bch2_btree_update_start+0x682/0x14e0 [ 307.557759][ T30] 3 locks held by bch-reclaim/loo/5846: [ 307.563354][ T30] #0: ffff88807294b0a8 (&j->reclaim_lock){+.+.}-{4:4}, at: bch2_journal_reclaim_thread+0x167/0x560 [ 307.574241][ T30] #1: ffff888072904398 (&c->btree_trans_barrier){.+.+}-{0:0}, at: __bch2_trans_get+0x7e1/0xd30 [ 307.584791][ T30] #2: ffff888072904740 (&wb->flushing.lock){+.+.}-{4:4}, at: btree_write_buffer_flush_seq+0x1b19/0x1cc0 [ 307.596133][ T30] [ 307.598469][ T30] ============================================= [ 307.598469][ T30] [ 307.606952][ T30] NMI backtrace for cpu 0 [ 307.611347][ T30] CPU: 0 UID: 0 PID: 30 Comm: khungtaskd Not tainted 6.13.0-rc2-syzkaller-00159-gf932fb9b4074 #0 [ 307.621839][ T30] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 11/25/2024 [ 307.631889][ T30] Call Trace: [ 307.635164][ T30] [ 307.638097][ T30] dump_stack_lvl+0x241/0x360 [ 307.642799][ T30] ? __pfx_dump_stack_lvl+0x10/0x10 [ 307.648000][ T30] ? __pfx__printk+0x10/0x10 [ 307.652585][ T30] nmi_cpu_backtrace+0x49c/0x4d0 [ 307.657515][ T30] ? __pfx_nmi_cpu_backtrace+0x10/0x10 [ 307.662961][ T30] ? _printk+0xd5/0x120 [ 307.667125][ T30] ? __pfx__printk+0x10/0x10 [ 307.671720][ T30] ? __wake_up_klogd+0xcc/0x110 [ 307.676576][ T30] ? __pfx__printk+0x10/0x10 [ 307.681255][ T30] ? __rcu_read_unlock+0xa1/0x110 [ 307.686281][ T30] ? __pfx_nmi_raise_cpu_backtrace+0x10/0x10 [ 307.692266][ T30] nmi_trigger_cpumask_backtrace+0x198/0x320 [ 307.698251][ T30] watchdog+0xff6/0x1040 [ 307.702758][ T30] ? watchdog+0x1ea/0x1040 [ 307.707174][ T30] ? __pfx_watchdog+0x10/0x10 [ 307.711859][ T30] kthread+0x2f0/0x390 [ 307.715931][ T30] ? __pfx_watchdog+0x10/0x10 [ 307.720606][ T30] ? __pfx_kthread+0x10/0x10 [ 307.725196][ T30] ret_from_fork+0x4b/0x80 [ 307.729612][ T30] ? __pfx_kthread+0x10/0x10 [ 307.734200][ T30] ret_from_fork_asm+0x1a/0x30 [ 307.738974][ T30] [ 307.742103][ T30] Sending NMI from CPU 0 to CPUs 1: [ 307.747500][ C1] NMI backtrace for cpu 1 [ 307.747513][ C1] CPU: 1 UID: 0 PID: 5183 Comm: klogd Not tainted 6.13.0-rc2-syzkaller-00159-gf932fb9b4074 #0 [ 307.747531][ C1] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 11/25/2024 [ 307.747541][ C1] RIP: 0010:check_preemption_disabled+0x67/0x120 [ 307.747568][ C1] Code: 85 ce 00 00 00 89 d8 48 83 c4 10 5b 41 5c 41 5e 41 5f c3 cc cc cc cc 48 c7 04 24 00 00 00 00 9c 8f 04 24 f7 04 24 00 02 00 00 <74> c5 49 89 f6 49 89 ff 65 4c 8b 24 25 80 d4 03 00 41 f6 44 24 2f [ 307.747580][ C1] RSP: 0018:ffffc900031378f0 EFLAGS: 00000046 [ 307.747596][ C1] RAX: 0000000080000000 RBX: 0000000000000001 RCX: 0000000000000010 [ 307.747607][ C1] RDX: 0000000000000001 RSI: ffffffff8c0a9760 RDI: ffffffff8c5ec400 [ 307.747618][ C1] RBP: ffffc900031379f0 R08: 00000000000000c3 R09: 1ffffffff284dd10 [ 307.747630][ C1] R10: dffffc0000000000 R11: fffffbfff284dd11 R12: 0000000000000246 [ 307.747641][ C1] R13: 1ffff92000626f2c R14: ffffffff8bc31770 R15: dffffc0000000000 [ 307.747653][ C1] FS: 00007f4f50bb2380(0000) GS:ffff8880b8700000(0000) knlGS:0000000000000000 [ 307.747667][ C1] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 307.747678][ C1] CR2: 000055830c5af680 CR3: 000000003457c000 CR4: 00000000003526f0 [ 307.747692][ C1] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [ 307.747702][ C1] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [ 307.747712][ C1] Call Trace: [ 307.747724][ C1] [ 307.747731][ C1] ? nmi_cpu_backtrace+0x3c2/0x4d0 [ 307.747748][ C1] ? __pfx_lock_acquire+0x10/0x10 [ 307.747766][ C1] ? __pfx_nmi_cpu_backtrace+0x10/0x10 [ 307.747782][ C1] ? nmi_handle+0x2a/0x5a0 [ 307.747805][ C1] ? nmi_cpu_backtrace_handler+0xc/0x20 [ 307.747825][ C1] ? nmi_handle+0x14f/0x5a0 [ 307.747847][ C1] ? nmi_handle+0x2a/0x5a0 [ 307.747863][ C1] ? check_preemption_disabled+0x67/0x120 [ 307.747883][ C1] ? default_do_nmi+0x63/0x160 [ 307.747898][ C1] ? exc_nmi+0x123/0x1f0 [ 307.747914][ C1] ? end_repeat_nmi+0xf/0x53 [ 307.747934][ C1] ? _raw_spin_lock_irqsave+0xb0/0x120 [ 307.747955][ C1] ? check_preemption_disabled+0x67/0x120 [ 307.747975][ C1] ? check_preemption_disabled+0x67/0x120 [ 307.747996][ C1] ? check_preemption_disabled+0x67/0x120 [ 307.748016][ C1] [ 307.748021][ C1] [ 307.748028][ C1] ? _raw_spin_lock_irqsave+0xb0/0x120 [ 307.748044][ C1] lockdep_hardirqs_off+0x75/0x110 [ 307.748062][ C1] ? _raw_spin_lock_irqsave+0xb0/0x120 [ 307.748079][ C1] trace_hardirqs_off+0x12/0x40 [ 307.748094][ C1] _raw_spin_lock_irqsave+0xb0/0x120 [ 307.748111][ C1] ? __pfx__raw_spin_lock_irqsave+0x10/0x10 [ 307.748129][ C1] ? unix_dgram_sendmsg+0x145f/0x1f80 [ 307.748146][ C1] ? __pfx_lock_release+0x10/0x10 [ 307.748163][ C1] __wake_up_common_lock+0x25/0x1e0 [ 307.748183][ C1] sock_def_readable+0x20f/0x5a0 [ 307.748202][ C1] ? sock_def_readable+0xd7/0x5a0 [ 307.748221][ C1] unix_dgram_sendmsg+0x1493/0x1f80 [ 307.748248][ C1] ? __pfx_unix_dgram_sendmsg+0x10/0x10 [ 307.748271][ C1] ? __pfx_unix_dgram_sendmsg+0x10/0x10 [ 307.748286][ C1] __sock_sendmsg+0x221/0x270 [ 307.748307][ C1] __sys_sendto+0x363/0x4c0 [ 307.748324][ C1] ? __pfx___sys_sendto+0x10/0x10 [ 307.748350][ C1] ? lockdep_hardirqs_on_prepare+0x43d/0x780 [ 307.748367][ C1] ? __pfx_lockdep_hardirqs_on_prepare+0x10/0x10 [ 307.748386][ C1] __x64_sys_sendto+0xde/0x100 [ 307.748402][ C1] do_syscall_64+0xf3/0x230 [ 307.748422][ C1] ? clear_bhb_loop+0x35/0x90 [ 307.748442][ C1] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 307.748461][ C1] RIP: 0033:0x7f4f50d149b5 [ 307.748479][ C1] Code: 8b 44 24 08 48 83 c4 28 48 98 c3 48 98 c3 41 89 ca 64 8b 04 25 18 00 00 00 85 c0 75 26 45 31 c9 45 31 c0 b8 2c 00 00 00 0f 05 <48> 3d 00 f0 ff ff 76 7a 48 8b 15 44 c4 0c 00 f7 d8 64 89 02 48 83 [ 307.748491][ C1] RSP: 002b:00007ffc66821f98 EFLAGS: 00000246 ORIG_RAX: 000000000000002c [ 307.748506][ C1] RAX: ffffffffffffffda RBX: 0000000000000002 RCX: 00007f4f50d149b5 [ 307.748517][ C1] RDX: 000000000000008b RSI: 000055983bc7bf10 RDI: 0000000000000003 [ 307.748527][ C1] RBP: 000055983bc77910 R08: 0000000000000000 R09: 0000000000000000 [ 307.748537][ C1] R10: 0000000000004000 R11: 0000000000000246 R12: 0000000000000013 [ 307.748547][ C1] R13: 00007f4f50ea2212 R14: 00007ffc66822098 R15: 0000000000000000 [ 307.748565][ C1] [ 307.749504][ T30] Kernel panic - not syncing: hung_task: blocked tasks [ 308.176069][ T30] CPU: 0 UID: 0 PID: 30 Comm: khungtaskd Not tainted 6.13.0-rc2-syzkaller-00159-gf932fb9b4074 #0 [ 308.186574][ T30] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 11/25/2024 [ 308.196628][ T30] Call Trace: [ 308.199906][ T30] [ 308.202843][ T30] dump_stack_lvl+0x241/0x360 [ 308.207533][ T30] ? __pfx_dump_stack_lvl+0x10/0x10 [ 308.212771][ T30] ? __pfx__printk+0x10/0x10 [ 308.217389][ T30] ? lockdep_hardirqs_on_prepare+0x43d/0x780 [ 308.223374][ T30] ? vscnprintf+0x5d/0x90 [ 308.227701][ T30] panic+0x349/0x880 [ 308.231638][ T30] ? nmi_trigger_cpumask_backtrace+0x244/0x320 [ 308.237794][ T30] ? __pfx_panic+0x10/0x10 [ 308.242233][ T30] ? tick_nohz_tick_stopped+0x82/0xb0 [ 308.247607][ T30] ? __irq_work_queue_local+0x137/0x410 [ 308.253150][ T30] ? irq_work_queue+0xca/0x150 [ 308.257941][ T30] ? __pfx_nmi_raise_cpu_backtrace+0x10/0x10 [ 308.263928][ T30] ? __pfx_nmi_raise_cpu_backtrace+0x10/0x10 [ 308.269912][ T30] ? __pfx_nmi_raise_cpu_backtrace+0x10/0x10 [ 308.275921][ T30] ? nmi_trigger_cpumask_backtrace+0x251/0x320 [ 308.282120][ T30] watchdog+0x1035/0x1040 [ 308.286463][ T30] ? watchdog+0x1ea/0x1040 [ 308.290894][ T30] ? __pfx_watchdog+0x10/0x10 [ 308.295609][ T30] kthread+0x2f0/0x390 [ 308.299681][ T30] ? __pfx_watchdog+0x10/0x10 [ 308.304354][ T30] ? __pfx_kthread+0x10/0x10 [ 308.308944][ T30] ret_from_fork+0x4b/0x80 [ 308.313357][ T30] ? __pfx_kthread+0x10/0x10 [ 308.318008][ T30] ret_from_fork_asm+0x1a/0x30 [ 308.322784][ T30] [ 308.326126][ T30] Kernel Offset: disabled [ 308.330448][ T30] Rebooting in 86400 seconds..