./strace-static-x86_64 -e \!wait4,clock_nanosleep,nanosleep -s 100 -x -f ./syz-executor4190363659 <...> Warning: Permanently added '10.128.0.25' (ED25519) to the list of known hosts. execve("./syz-executor4190363659", ["./syz-executor4190363659"], 0x7fff06a6e8b0 /* 10 vars */) = 0 brk(NULL) = 0x55555d3f6000 brk(0x55555d3f6d00) = 0x55555d3f6d00 arch_prctl(ARCH_SET_FS, 0x55555d3f6380) = 0 set_tid_address(0x55555d3f6650) = 5818 set_robust_list(0x55555d3f6660, 24) = 0 rseq(0x55555d3f6ca0, 0x20, 0, 0x53053053) = 0 prlimit64(0, RLIMIT_STACK, NULL, {rlim_cur=8192*1024, rlim_max=RLIM64_INFINITY}) = 0 readlink("/proc/self/exe", "/root/syz-executor4190363659", 4096) = 28 getrandom("\xf3\x81\xea\x27\x71\xf2\x06\xe6", 8, GRND_NONBLOCK) = 8 brk(NULL) = 0x55555d3f6d00 brk(0x55555d417d00) = 0x55555d417d00 brk(0x55555d418000) = 0x55555d418000 mprotect(0x7f090ade7000, 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 mkdir("./syzkaller.FM1T5m", 0700) = 0 chmod("./syzkaller.FM1T5m", 0777) = 0 chdir("./syzkaller.FM1T5m") = 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 5819 attached , child_tidptr=0x55555d3f6650) = 5819 [pid 5819] set_robust_list(0x55555d3f6660, 24) = 0 [pid 5819] chdir("./0") = 0 [pid 5819] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0 [pid 5819] setpgid(0, 0) = 0 [pid 5819] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC) = 3 [pid 5819] write(3, "1000", 4) = 4 [pid 5819] close(3) = 0 [pid 5819] symlink("/dev/binderfs", "./binderfs") = 0 [pid 5819] write(1, "executing program\n", 18executing program ) = 18 [pid 5819] memfd_create("syzkaller", 0) = 3 [pid 5819] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f0902800000 [pid 5819] 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 5819] munmap(0x7f0902800000, 138412032) = 0 [pid 5819] openat(AT_FDCWD, "/dev/loop0", O_RDWR) = 4 [pid 5819] ioctl(4, LOOP_SET_FD, 3) = 0 [pid 5819] close(3) = 0 [pid 5819] close(4) = 0 [pid 5819] mkdir("./file0", 0777) = 0 [ 80.701953][ T5819] loop0: detected capacity change from 0 to 32768 [ 80.784193][ T5819] bcachefs (loop0): starting version 1.7: mi_btree_bitmap opts=metadata_checksum=none,data_checksum=none,compression=lz4,nojournal_transaction_names [ 80.799939][ T5819] bcachefs (loop0): recovering from clean shutdown, journal seq 13 [ 80.819259][ T5819] bcachefs (loop0): accounting_read... done [ 80.825591][ T5819] bcachefs (loop0): alloc_read... done [pid 5819] mount("/dev/loop0", "./file0", "bcachefs", 0, "\x10\xf7\xe7\xab\x27\x5e\x7b\x9e\xc1\x8a\x06\x63\x35\x54\xe2\xf6\xfa\xd2\xf9\xfb\xc1\x7a\x1b\x2f\xed\xc7\xf5\x95") = 0 [pid 5819] openat(AT_FDCWD, "./file0", O_RDONLY|O_DIRECTORY) = 3 [pid 5819] chdir("./file0") = 0 [pid 5819] openat(AT_FDCWD, "/dev/loop0", O_RDWR) = 4 [pid 5819] ioctl(4, LOOP_CLR_FD) = 0 [pid 5819] close(4) = 0 [pid 5819] exit_group(0) = ? [pid 5819] +++ exited with 0 +++ --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=5819, si_uid=0, si_status=0, si_utime=3 /* 0.03 s */, si_stime=25 /* 0.25 s */} --- [ 80.831164][ T5819] bcachefs (loop0): stripes_read... done [ 80.836846][ T5819] bcachefs (loop0): snapshots_read... done [ 80.845309][ T5819] bcachefs (loop0): journal_replay... done [ 80.851259][ T5819] bcachefs (loop0): resume_logged_ops... done [ 80.857416][ T5819] bcachefs (loop0): delete_dead_inodes... done [ 80.866642][ T5819] bcachefs (loop0): going read-write [ 80.877939][ T5819] bcachefs (loop0): done starting filesystem restart_syscall(<... resuming interrupted clone ...>) = 0 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, 0x55555d3f76f0 /* 4 entries */, 32768) = 112 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 [ 81.025422][ T5818] bcachefs (loop0): shutting down [ 81.030856][ T5818] bcachefs (loop0): going read-only [ 81.036384][ T5818] bcachefs (loop0): finished waiting for writes to stop [ 82.032950][ T25] cfg80211: failed to load regulatory.db [ 111.481400][ T5829] Allocator stuck? Waited for 30 seconds [ 111.481413][ T5829] Allocator debug: [ 111.481418][ T5829] capacity1536 [ 111.481423][ T5829] reserved 31232 [ 111.481428][ T5829] hidden 0 [ 111.481433][ T5829] btree 0 [ 111.481438][ T5829] data 0 [ 111.481442][ T5829] cached 0 [ 111.481447][ T5829] reserved 0 [ 111.481452][ T5829] online_reserved 24 [ 111.481456][ T5829] nr_inodes 0 [ 111.481461][ T5829] [ 111.481466][ T5829] freelist_wait waiting [ 111.481471][ T5829] open buckets allocated1 [ 111.481475][ T5829] open buckets total 1024 [ 111.481480][ T5829] open_buckets_wait empty [ 111.481485][ T5829] open_buckets_btree 0 [ 111.481489][ T5829] open_buckets_user 0 [ 111.481494][ T5829] btree reserve cache 0 [ 111.481499][ T5829] [ 111.481503][ T5829] Dev 0: [ 111.481507][ T5829] buckets sectors fragmented [ 111.481513][ T5829] free 0 0 0 [ 111.481518][ T5829] sb 0 0 0 [ 111.481524][ T5829] journal 0 0 0 [ 111.481529][ T5829] btree 0 0 0 [ 111.481534][ T5829] user 0 0 0 [ 111.481540][ T5829] cached 0 0 0 [ 111.481545][ T5829] parity 0 0 0 [ 111.481550][ T5829] stripe 0 0 0 [ 111.481556][ T5829] need_gc_gens 0 0 0 [ 111.481561][ T5829] need_discard 0 0 0 [ 111.481570][ T5829] unstriped 0 0 0 [ 111.481578][ T5829] capacity 128 [ 111.481585][ T5829] [ 111.481590][ T5829] reserves: [ 111.481597][ T5829] stripe 60 [ 111.481603][ T5829] normal 58 [ 111.481610][ T5829] copygc 56 [ 111.481616][ T5829] btree 28 [ 111.481621][ T5829] btree_copygc 0 [ 111.481626][ T5829] reclaim 0 [ 111.481630][ T5829] interior_updates 0 [ 111.481635][ T5829] [ 111.481639][ T5829] open buckets 0 [ 111.481644][ T5829] buckets to invalidate 0 [ 111.481649][ T5829] [ 111.481653][ T5829] Copygc debug: [ 111.481658][ T5829] running: 1 [ 111.481662][ T5829] copygc_wait:0 [ 111.481667][ T5829] copygc_wait_at:0 [ 111.481671][ T5829] Currently waiting for:0 B [ 111.481676][ T5829] Currently waiting since:640 KiB [ 111.481681][ T5829] Currently calculated wait:0 B [ 111.481686][ T5829] [ 111.481690][ T5829] Journal debug: [ 111.481695][ T5829] flags: replay_done,running,may_skip_flush,need_flush_write [ 111.481700][ T5829] dirty journal entries: 0/32768 [ 111.481705][ T5829] seq: 13 [ 111.481710][ T5829] seq_ondisk: 13 [ 111.481715][ T5829] last_seq: 14 [ 111.481719][ T5829] last_seq_ondisk: 14 [ 111.481724][ T5829] flushed_seq_ondisk: 13 [ 111.481729][ T5829] watermark: stripe [ 111.481734][ T5829] each entry reserved: 321 [ 111.481739][ T5829] nr flush writes: 0 [ 111.481743][ T5829] nr noflush writes: 0 [ 111.481748][ T5829] average write size: 0 B [ 111.481753][ T5829] nr direct reclaim: 0 [ 111.481758][ T5829] nr background reclaim: 0 [ 111.481762][ T5829] reclaim kicked: 0 [ 111.481767][ T5829] reclaim runs in: 0 ms [ 111.481772][ T5829] blocked: 0 [ 111.481777][ T5829] current entry sectors: 256 [ 111.481781][ T5829] current entry error: ok [ 111.481786][ T5829] current entry: closed [ 111.481791][ T5829] unwritten entries: [ 111.481796][ T5829] last buf closed [ 111.481800][ T5829] space: [ 111.481805][ T5829] discarded 256:1792 [ 111.481809][ T5829] clean ondisk 256:1792 [ 111.481837][ T5829] clean 256:1792 [ 111.481842][ T5829] total 256:2048 [ 111.481847][ T5829] dev 0: [ 111.481852][ T5829] nr 8 [ 111.481856][ T5829] bucket size 256 [ 111.481861][ T5829] available 6:256 [ 111.481866][ T5829] discard_idx 0 [ 111.481871][ T5829] dirty_ondisk 0 (seq 0) [ 111.481875][ T5829] dirty_idx 0 (seq 0) [ 111.481880][ T5829] cur_idx 0 (seq 0) [ 111.481885][ T5829] [ 286.832508][ T30] INFO: task syz-executor419:5818 blocked for more than 143 seconds. [ 286.840879][ T30] Not tainted 6.13.0-rc4-syzkaller-00078-g059dd502b263 #0 [ 286.848614][ T30] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 286.857390][ T30] task:syz-executor419 state:D stack:23840 pid:5818 tgid:5818 ppid:5815 flags:0x00004002 [ 286.867802][ T30] Call Trace: [ 286.871170][ T30] [ 286.874121][ T30] __schedule+0x17fb/0x4be0 [ 286.878652][ T30] ? __pfx___schedule+0x10/0x10 [ 286.883564][ T30] ? __pfx_lock_release+0x10/0x10 [ 286.888621][ T30] ? schedule+0x90/0x320 [ 286.892907][ T30] schedule+0x14b/0x320 [ 286.897171][ T30] schedule_timeout+0xb0/0x290 [ 286.901997][ T30] ? __pfx_schedule_timeout+0x10/0x10 [ 286.907394][ T30] ? lockdep_hardirqs_on_prepare+0x43d/0x780 [ 286.913447][ T30] ? wait_for_completion+0x2fe/0x620 [ 286.918778][ T30] ? wait_for_completion+0x2fe/0x620 [ 286.924106][ T30] ? _raw_spin_unlock_irq+0x23/0x50 [ 286.929322][ T30] ? lockdep_hardirqs_on+0x99/0x150 [ 286.934604][ T30] ? wait_for_completion+0x2fe/0x620 [ 286.939911][ T30] wait_for_completion+0x355/0x620 [ 286.945099][ T30] ? __pfx_wait_for_completion+0x10/0x10 [ 286.950791][ T30] ? synchronize_rcu+0x11b/0x360 [ 286.955740][ T30] ? kthread_unpark+0xd0/0x290 [ 286.960493][ T30] kthread_stop+0x19e/0x640 [ 286.965084][ T30] bch2_copygc_stop+0x4f/0x150 [ 286.969887][ T30] __bch2_fs_read_only+0x47/0x450 [ 286.975345][ T30] bch2_fs_read_only+0xb57/0x1200 [ 286.980608][ T30] ? __pfx_bch2_fs_read_only+0x10/0x10 [ 286.986296][ T30] ? __bch2_print+0x17a/0x220 [ 286.991128][ T30] ? down_write+0x18c/0x220 [ 286.995658][ T30] ? __pfx_down_write+0x10/0x10 [ 287.000508][ T30] ? hook_sb_delete+0xaa0/0xbd0 [ 287.005454][ T30] __bch2_fs_stop+0x105/0x5c0 [ 287.010157][ T30] ? __pfx___bch2_fs_stop+0x10/0x10 [ 287.015497][ T30] ? __pfx_evict_inodes+0x10/0x10 [ 287.020570][ T30] ? bch2_sync_fs+0x155/0x300 [ 287.025311][ T30] ? __pfx_bch2_put_super+0x10/0x10 [ 287.030534][ T30] generic_shutdown_super+0x139/0x2d0 [ 287.035989][ T30] bch2_kill_sb+0x41/0x50 [ 287.040336][ T30] deactivate_locked_super+0xc4/0x130 [ 287.045768][ T30] cleanup_mnt+0x41f/0x4b0 [ 287.050290][ T30] ? lockdep_hardirqs_on+0x99/0x150 [ 287.055571][ T30] task_work_run+0x24f/0x310 [ 287.060184][ T30] ? __pfx_task_work_run+0x10/0x10 [ 287.065373][ T30] ? path_umount+0x284/0xf70 [ 287.070000][ T30] ptrace_notify+0x2d2/0x380 [ 287.074776][ T30] ? __pfx_ptrace_notify+0x10/0x10 [ 287.079946][ T30] ? kmem_cache_free+0x195/0x410 [ 287.085049][ T30] ? __x64_sys_umount+0x123/0x170 [ 287.090389][ T30] syscall_exit_work+0xc7/0x1d0 [ 287.095545][ T30] syscall_exit_to_user_mode+0x24a/0x340 [ 287.101292][ T30] do_syscall_64+0x100/0x230 [ 287.105930][ T30] ? clear_bhb_loop+0x35/0x90 [ 287.110730][ T30] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 287.116659][ T30] RIP: 0033:0x7f090ad65347 [ 287.121146][ T30] RSP: 002b:00007fff0f02a318 EFLAGS: 00000206 ORIG_RAX: 00000000000000a6 [ 287.129590][ T30] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 00007f090ad65347 [ 287.137641][ T30] RDX: 0000000000000000 RSI: 0000000000000009 RDI: 00007fff0f02a3d0 [ 287.145776][ T30] RBP: 00007fff0f02a3d0 R08: 0000000000000000 R09: 0000000000000000 [ 287.153847][ T30] R10: 00000000ffffffff R11: 0000000000000206 R12: 00007fff0f02b430 [ 287.161878][ T30] R13: 000055555d3f76c0 R14: 0000000000000001 R15: 431bde82d7b634db [ 287.169860][ T30] [ 287.173077][ T30] INFO: task bch-copygc/loop:5829 blocked for more than 143 seconds. [ 287.181251][ T30] Not tainted 6.13.0-rc4-syzkaller-00078-g059dd502b263 #0 [ 287.188926][ T30] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 287.197675][ T30] task:bch-copygc/loop state:D stack:20080 pid:5829 tgid:5829 ppid:2 flags:0x00024000 [ 287.207931][ T30] Call Trace: [ 287.211320][ T30] [ 287.214269][ T30] __schedule+0x17fb/0x4be0 [ 287.218781][ T30] ? lockdep_hardirqs_on_prepare+0x43d/0x780 [ 287.224865][ T30] ? __pfx___schedule+0x10/0x10 [ 287.229755][ T30] ? __pfx_lock_release+0x10/0x10 [ 287.234909][ T30] ? bch2_print_allocator_stuck+0x165/0xcb0 [ 287.240978][ T30] ? bch2_print_allocator_stuck+0xc24/0xcb0 [ 287.246901][ T30] ? schedule+0x90/0x320 [ 287.251270][ T30] schedule+0x14b/0x320 [ 287.255471][ T30] __closure_sync+0x259/0x2f0 [ 287.260148][ T30] ? __closure_sync+0x149/0x2f0 [ 287.265087][ T30] ? __pfx___closure_sync+0x10/0x10 [ 287.270311][ T30] ? __bch2_wait_on_allocator+0x1d6/0x250 [ 287.276155][ T30] __bch2_write+0x562a/0x5dd0 [ 287.280903][ T30] ? __pfx_submit_bio_noacct_nocheck+0x10/0x10 [ 287.287068][ T30] ? __pfx___bch2_write+0x10/0x10 [ 287.292212][ T30] ? __bch2_read_extent+0x3075/0x4850 [ 287.297630][ T30] ? __pfx___bch2_read_extent+0x10/0x10 [ 287.303326][ T30] ? __pfx___mutex_trylock_common+0x10/0x10 [ 287.309282][ T30] ? __pfx_lock_release+0x10/0x10 [ 287.314537][ T30] bch2_write+0x9b5/0x1760 [ 287.319022][ T30] ? __pfx_bch2_write+0x10/0x10 [ 287.323953][ T30] ? bch2_trans_srcu_unlock+0x43e/0x5c0 [ 287.329522][ T30] ? bch2_data_update_read_done+0xfd/0x330 [ 287.335419][ T30] bch2_data_update_read_done+0x22e/0x330 [ 287.341192][ T30] ? __pfx_bch2_data_update_read_done+0x10/0x10 [ 287.347436][ T30] ? bch2_trans_srcu_unlock+0x44d/0x5c0 [ 287.353057][ T30] bch2_moving_ctxt_do_pending_writes+0x44c/0x8d0 [ 287.359502][ T30] ? __pfx_bch2_moving_ctxt_do_pending_writes+0x10/0x10 [ 287.366539][ T30] ? bch2_backpointer_get_key+0x434/0x970 [ 287.372337][ T30] bch2_move_ratelimit+0x76c/0xeb0 [ 287.377575][ T30] ? bch2_move_get_io_opts_one+0x292/0xb90 [ 287.383479][ T30] ? __pfx_bch2_move_ratelimit+0x10/0x10 [ 287.389132][ T30] ? bch2_path_put+0xfe1/0x2150 [ 287.394095][ T30] ? __asan_memset+0x23/0x50 [ 287.398711][ T30] bch2_evacuate_bucket+0x26b3/0x3610 [ 287.404160][ T30] ? bch2_evacuate_bucket+0x30e/0x3610 [ 287.409650][ T30] ? __pfx_bch2_evacuate_bucket+0x10/0x10 [ 287.415451][ T30] ? _raw_spin_unlock_irqrestore+0xdd/0x140 [ 287.421401][ T30] ? __pfx_register_lock_class+0x10/0x10 [ 287.427032][ T30] ? stack_trace_save+0x118/0x1d0 [ 287.432162][ T30] ? bch2_backpointer_get_key+0x2b0/0x970 [ 287.437908][ T30] ? __pfx_lock_acquire+0x10/0x10 [ 287.443001][ T30] ? bch2_copygc+0x435/0x4c90 [ 287.447725][ T30] ? lockdep_hardirqs_on_prepare+0x43d/0x780 [ 287.453796][ T30] bch2_copygc+0x42c1/0x4c90 [ 287.458406][ T30] ? bch2_copygc+0x435/0x4c90 [ 287.463195][ T30] ? __pfx_bch2_copygc+0x10/0x10 [ 287.468153][ T30] ? __pfx_lock_acquire+0x10/0x10 [ 287.473284][ T30] ? __pfx_lock_release+0x10/0x10 [ 287.478329][ T30] ? bch2_copygc+0x435/0x4c90 [ 287.483067][ T30] ? bch2_copygc_wait_amount+0xc90/0xcf0 [ 287.488730][ T30] ? bch2_copygc+0x435/0x4c90 [ 287.493506][ T30] ? bch2_trans_srcu_unlock+0x44d/0x5c0 [ 287.499091][ T30] bch2_copygc_thread+0x736/0xc10 [ 287.504209][ T30] ? __pfx_bch2_copygc_thread+0x10/0x10 [ 287.509792][ T30] ? bch2_copygc_thread+0x1a1/0xc10 [ 287.515111][ T30] ? _raw_spin_unlock_irqrestore+0x8f/0x140 [ 287.521090][ T30] ? lockdep_hardirqs_on+0x99/0x150 [ 287.526320][ T30] ? _raw_spin_unlock_irqrestore+0xdd/0x140 [ 287.532281][ T30] ? __kthread_parkme+0x169/0x1d0 [ 287.537374][ T30] ? __pfx_bch2_copygc_thread+0x10/0x10 [ 287.543018][ T30] kthread+0x2f0/0x390 [ 287.547106][ T30] ? __pfx_bch2_copygc_thread+0x10/0x10 [ 287.552796][ T30] ? __pfx_kthread+0x10/0x10 [ 287.557409][ T30] ret_from_fork+0x4b/0x80 [ 287.561886][ T30] ? __pfx_kthread+0x10/0x10 [ 287.566507][ T30] ret_from_fork_asm+0x1a/0x30 [ 287.571376][ T30] [ 287.574446][ T30] [ 287.574446][ T30] Showing all locks held in the system: [ 287.582222][ T30] 1 lock held by khungtaskd/30: [ 287.587083][ T30] #0: ffffffff8e937ae0 (rcu_read_lock){....}-{1:3}, at: debug_show_all_locks+0x55/0x2a0 [ 287.597071][ T30] 2 locks held by getty/5581: [ 287.601804][ T30] #0: ffff8880364aa0a0 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x25/0x70 [ 287.611627][ T30] #1: ffffc90002fde2f0 (&ldata->atomic_read_lock){+.+.}-{4:4}, at: n_tty_read+0x6a6/0x1e00 [ 287.621910][ T30] 2 locks held by syz-executor419/5818: [ 287.627463][ T30] #0: ffff88807cf2c0e0 (&type->s_umount_key#43){+.+.}-{4:4}, at: deactivate_super+0xb5/0xf0 [ 287.637739][ T30] #1: ffff888072d00278 (&c->state_lock){+.+.}-{4:4}, at: __bch2_fs_stop+0xfd/0x5c0 [ 287.647220][ T30] [ 287.649564][ T30] ============================================= [ 287.649564][ T30] [ 287.658084][ T30] NMI backtrace for cpu 0 [ 287.662439][ T30] CPU: 0 UID: 0 PID: 30 Comm: khungtaskd Not tainted 6.13.0-rc4-syzkaller-00078-g059dd502b263 #0 [ 287.672925][ T30] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/13/2024 [ 287.682991][ T30] Call Trace: [ 287.686263][ T30] [ 287.689183][ T30] dump_stack_lvl+0x241/0x360 [ 287.693859][ T30] ? __pfx_dump_stack_lvl+0x10/0x10 [ 287.699050][ T30] ? __pfx__printk+0x10/0x10 [ 287.703639][ T30] nmi_cpu_backtrace+0x49c/0x4d0 [ 287.708573][ T30] ? __pfx_nmi_cpu_backtrace+0x10/0x10 [ 287.714021][ T30] ? _printk+0xd5/0x120 [ 287.718169][ T30] ? __pfx__printk+0x10/0x10 [ 287.722751][ T30] ? __wake_up_klogd+0xcc/0x110 [ 287.727598][ T30] ? __pfx__printk+0x10/0x10 [ 287.732205][ T30] ? __pfx_nmi_raise_cpu_backtrace+0x10/0x10 [ 287.738178][ T30] nmi_trigger_cpumask_backtrace+0x198/0x320 [ 287.744152][ T30] watchdog+0xff6/0x1040 [ 287.748384][ T30] ? watchdog+0x1ea/0x1040 [ 287.752792][ T30] ? __pfx_watchdog+0x10/0x10 [ 287.757464][ T30] kthread+0x2f0/0x390 [ 287.761523][ T30] ? __pfx_watchdog+0x10/0x10 [ 287.766187][ T30] ? __pfx_kthread+0x10/0x10 [ 287.770852][ T30] ret_from_fork+0x4b/0x80 [ 287.775257][ T30] ? __pfx_kthread+0x10/0x10 [ 287.779833][ T30] ret_from_fork_asm+0x1a/0x30 [ 287.784621][ T30] [ 287.787807][ T30] Sending NMI from CPU 0 to CPUs 1: [ 287.793090][ C1] NMI backtrace for cpu 1 [ 287.793104][ C1] CPU: 1 UID: 0 PID: 5183 Comm: klogd Not tainted 6.13.0-rc4-syzkaller-00078-g059dd502b263 #0 [ 287.793124][ C1] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/13/2024 [ 287.793133][ C1] RIP: 0010:__might_sleep+0x0/0xe0 [ 287.793162][ C1] Code: c7 c7 60 55 7f 8e e8 cf ad 83 03 e9 8d fe ff ff 66 2e 0f 1f 84 00 00 00 00 00 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 0f 1e fa 55 41 57 41 56 41 55 41 54 53 41 89 f6 49 89 ff 49 bc [ 287.793175][ C1] RSP: 0018:ffffc900033376b8 EFLAGS: 00000206 [ 287.793191][ C1] RAX: 8cc6dc8fbc65b500 RBX: 0000000000482cc0 RCX: ffffc90003337603 [ 287.793203][ C1] RDX: 0000000000000000 RSI: 0000000000000141 RDI: ffffffff8e0447aa [ 287.793214][ C1] RBP: 0000000000000003 R08: ffffffff90185337 R09: 1ffffffff2030a66 [ 287.793226][ C1] R10: dffffc0000000000 R11: fffffbfff2030a67 R12: 0000000000000200 [ 287.793238][ C1] R13: 0000000000482cc0 R14: 00000000ffffffff R15: ffff88801ac4f140 [ 287.793250][ C1] FS: 00007fced28aa380(0000) GS:ffff8880b8700000(0000) knlGS:0000000000000000 [ 287.793265][ C1] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 287.793276][ C1] CR2: 000055649365e680 CR3: 0000000032dc2000 CR4: 00000000003526f0 [ 287.793291][ C1] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [ 287.793301][ C1] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [ 287.793311][ C1] Call Trace: [ 287.793317][ C1] [ 287.793323][ C1] ? nmi_cpu_backtrace+0x3c2/0x4d0 [ 287.793343][ C1] ? __pfx_lock_acquire+0x10/0x10 [ 287.793368][ C1] ? __pfx_nmi_cpu_backtrace+0x10/0x10 [ 287.793386][ C1] ? nmi_handle+0x2a/0x5a0 [ 287.793410][ C1] ? nmi_cpu_backtrace_handler+0xc/0x20 [ 287.793433][ C1] ? nmi_handle+0x14f/0x5a0 [ 287.793450][ C1] ? nmi_handle+0x2a/0x5a0 [ 287.793468][ C1] ? __pfx___might_sleep+0x10/0x10 [ 287.793490][ C1] ? default_do_nmi+0x63/0x160 [ 287.793508][ C1] ? exc_nmi+0x123/0x1f0 [ 287.793525][ C1] ? end_repeat_nmi+0xf/0x53 [ 287.793544][ C1] ? __pfx___might_sleep+0x10/0x10 [ 287.793567][ C1] ? __pfx___might_sleep+0x10/0x10 [ 287.793591][ C1] ? __pfx___might_sleep+0x10/0x10 [ 287.793613][ C1] [ 287.793619][ C1] [ 287.793623][ C1] __kmalloc_node_track_caller_noprof+0xcd/0x4c0 [ 287.793643][ C1] ? __alloc_skb+0x1f3/0x440 [ 287.793660][ C1] ? rcu_is_watching+0x15/0xb0 [ 287.793681][ C1] ? __alloc_skb+0x1f3/0x440 [ 287.793696][ C1] kmalloc_reserve+0x111/0x2a0 [ 287.793714][ C1] __alloc_skb+0x1f3/0x440 [ 287.793729][ C1] ? _raw_spin_unlock_irqrestore+0xdd/0x140 [ 287.793751][ C1] ? __pfx___alloc_skb+0x10/0x10 [ 287.793772][ C1] alloc_skb_with_frags+0xc3/0x820 [ 287.793796][ C1] sock_alloc_send_pskb+0x91a/0xa60 [ 287.793825][ C1] ? __pfx_sock_alloc_send_pskb+0x10/0x10 [ 287.793847][ C1] ? do_raw_spin_unlock+0x13c/0x8b0 [ 287.793873][ C1] unix_dgram_sendmsg+0x6d3/0x1f80 [ 287.793896][ C1] ? __pfx_smack_socket_sendmsg+0x10/0x10 [ 287.793917][ C1] ? tomoyo_socket_sendmsg_permission+0x288/0x420 [ 287.793942][ C1] ? __pfx_unix_dgram_sendmsg+0x10/0x10 [ 287.793967][ C1] ? __pfx_unix_dgram_sendmsg+0x10/0x10 [ 287.793985][ C1] __sock_sendmsg+0x221/0x270 [ 287.794008][ C1] __sys_sendto+0x363/0x4c0 [ 287.794027][ C1] ? __pfx___sys_sendto+0x10/0x10 [ 287.794054][ C1] ? lockdep_hardirqs_on_prepare+0x43d/0x780 [ 287.794072][ C1] ? __pfx_lockdep_hardirqs_on_prepare+0x10/0x10 [ 287.794092][ C1] __x64_sys_sendto+0xde/0x100 [ 287.794109][ C1] do_syscall_64+0xf3/0x230 [ 287.794132][ C1] ? clear_bhb_loop+0x35/0x90 [ 287.794147][ C1] entry_SYSCALL_64_after_hwframe+0x77/0x7f [ 287.794170][ C1] RIP: 0033:0x7fced2a0c9b5 [ 287.794183][ 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 [ 287.794195][ C1] RSP: 002b:00007fffda6d3398 EFLAGS: 00000246 ORIG_RAX: 000000000000002c [ 287.794211][ C1] RAX: ffffffffffffffda RBX: 0000000000000002 RCX: 00007fced2a0c9b5 [ 287.794222][ C1] RDX: 000000000000008b RSI: 0000556c4f596b60 RDI: 0000000000000003 [ 287.794233][ C1] RBP: 0000556c4f592910 R08: 0000000000000000 R09: 0000000000000000 [ 287.794243][ C1] R10: 0000000000004000 R11: 0000000000000246 R12: 0000000000000013 [ 287.794253][ C1] R13: 00007fced2b9a212 R14: 00007fffda6d3498 R15: 0000000000000000 [ 287.794271][ C1] [ 287.794279][ C1] INFO: NMI handler (nmi_cpu_backtrace_handler) took too long to run: 1.189 msecs [ 287.795096][ T30] Kernel panic - not syncing: hung_task: blocked tasks [ 288.237445][ T30] CPU: 0 UID: 0 PID: 30 Comm: khungtaskd Not tainted 6.13.0-rc4-syzkaller-00078-g059dd502b263 #0 [ 288.247949][ T30] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/13/2024 [ 288.258004][ T30] Call Trace: [ 288.261299][ T30] [ 288.264225][ T30] dump_stack_lvl+0x241/0x360 [ 288.269023][ T30] ? __pfx_dump_stack_lvl+0x10/0x10 [ 288.274224][ T30] ? __pfx__printk+0x10/0x10 [ 288.278815][ T30] ? lockdep_hardirqs_on_prepare+0x43d/0x780 [ 288.284799][ T30] ? vscnprintf+0x5d/0x90 [ 288.289132][ T30] panic+0x349/0x880 [ 288.293036][ T30] ? nmi_trigger_cpumask_backtrace+0x244/0x320 [ 288.299195][ T30] ? __pfx_panic+0x10/0x10 [ 288.303613][ T30] ? tick_nohz_tick_stopped+0x82/0xb0 [ 288.309029][ T30] ? __irq_work_queue_local+0x137/0x410 [ 288.314581][ T30] ? irq_work_queue+0xca/0x150 [ 288.319354][ T30] ? __pfx_nmi_raise_cpu_backtrace+0x10/0x10 [ 288.325345][ T30] ? __pfx_nmi_raise_cpu_backtrace+0x10/0x10 [ 288.331331][ T30] ? __pfx_nmi_raise_cpu_backtrace+0x10/0x10 [ 288.337319][ T30] ? nmi_trigger_cpumask_backtrace+0x251/0x320 [ 288.343478][ T30] watchdog+0x1035/0x1040 [ 288.347812][ T30] ? watchdog+0x1ea/0x1040 [ 288.352230][ T30] ? __pfx_watchdog+0x10/0x10 [ 288.356928][ T30] kthread+0x2f0/0x390 [ 288.361001][ T30] ? __pfx_watchdog+0x10/0x10 [ 288.365681][ T30] ? __pfx_kthread+0x10/0x10 [ 288.370279][ T30] ret_from_fork+0x4b/0x80 [ 288.374701][ T30] ? __pfx_kthread+0x10/0x10 [ 288.379292][ T30] ret_from_fork_asm+0x1a/0x30 [ 288.384072][ T30] [ 288.387404][ T30] Kernel Offset: disabled [ 288.391730][ T30] Rebooting in 86400 seconds..