./strace-static-x86_64 -e \!wait4,clock_nanosleep,nanosleep -s 100 -x -f ./syz-executor1582194831

<...>
Warning: Permanently added '10.128.0.34' (ED25519) to the list of known hosts.
execve("./syz-executor1582194831", ["./syz-executor1582194831"], 0x7ffce33c55f0 /* 10 vars */) = 0
brk(NULL)                               = 0x55558005b000
brk(0x55558005bd00)                     = 0x55558005bd00
arch_prctl(ARCH_SET_FS, 0x55558005b380) = 0
set_tid_address(0x55558005b650)         = 5085
set_robust_list(0x55558005b660, 24)     = 0
rseq(0x55558005bca0, 0x20, 0, 0x53053053) = 0
prlimit64(0, RLIMIT_STACK, NULL, {rlim_cur=8192*1024, rlim_max=RLIM64_INFINITY}) = 0
readlink("/proc/self/exe", "/root/syz-executor1582194831", 4096) = 28
getrandom("\x79\xb6\x75\xaa\x88\x9a\x9b\x43", 8, GRND_NONBLOCK) = 8
brk(NULL)                               = 0x55558005bd00
brk(0x55558007cd00)                     = 0x55558007cd00
brk(0x55558007d000)                     = 0x55558007d000
mprotect(0x7f2b41f33000, 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
unshare(CLONE_NEWPID)                   = 0
clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5086 attached
, child_tidptr=0x55558005b650) = 5086
[pid  5086] set_robust_list(0x55558005b660, 24) = 0
[pid  5086] mount(NULL, "/sys/fs/fuse/connections", "fusectl", 0, NULL) = -1 EBUSY (Device or resource busy)
[pid  5086] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0
[pid  5086] setsid()                    = 1
[pid  5086] prlimit64(0, RLIMIT_AS, {rlim_cur=204800*1024, rlim_max=204800*1024}, NULL) = 0
[pid  5086] prlimit64(0, RLIMIT_MEMLOCK, {rlim_cur=32768*1024, rlim_max=32768*1024}, NULL) = 0
[pid  5086] prlimit64(0, RLIMIT_FSIZE, {rlim_cur=139264*1024, rlim_max=139264*1024}, NULL) = 0
[pid  5086] prlimit64(0, RLIMIT_STACK, {rlim_cur=1024*1024, rlim_max=1024*1024}, NULL) = 0
[pid  5086] prlimit64(0, RLIMIT_CORE, {rlim_cur=131072*1024, rlim_max=131072*1024}, NULL) = 0
[pid  5086] prlimit64(0, RLIMIT_NOFILE, {rlim_cur=256, rlim_max=256}, NULL) = 0
[pid  5086] unshare(CLONE_NEWNS)        = 0
[pid  5086] mount(NULL, "/", NULL, MS_REC|MS_PRIVATE, NULL) = 0
[pid  5086] unshare(CLONE_NEWIPC)       = 0
[pid  5086] unshare(CLONE_NEWCGROUP)    = 0
[pid  5086] unshare(CLONE_NEWUTS)       = 0
[pid  5086] unshare(CLONE_SYSVSEM)      = 0
[pid  5086] openat(AT_FDCWD, "/proc/sys/kernel/shmmax", O_WRONLY|O_CLOEXEC) = 3
[pid  5086] write(3, "16777216", 8)     = 8
[pid  5086] close(3)                    = 0
[pid  5086] openat(AT_FDCWD, "/proc/sys/kernel/shmall", O_WRONLY|O_CLOEXEC) = 3
[pid  5086] write(3, "536870912", 9)    = 9
[pid  5086] close(3)                    = 0
[pid  5086] openat(AT_FDCWD, "/proc/sys/kernel/shmmni", O_WRONLY|O_CLOEXEC) = 3
[pid  5086] write(3, "1024", 4)         = 4
[pid  5086] close(3)                    = 0
[pid  5086] openat(AT_FDCWD, "/proc/sys/kernel/msgmax", O_WRONLY|O_CLOEXEC) = 3
[pid  5086] write(3, "8192", 4)         = 4
[pid  5086] close(3)                    = 0
[pid  5086] openat(AT_FDCWD, "/proc/sys/kernel/msgmni", O_WRONLY|O_CLOEXEC) = 3
[pid  5086] write(3, "1024", 4)         = 4
[pid  5086] close(3)                    = 0
[pid  5086] openat(AT_FDCWD, "/proc/sys/kernel/msgmnb", O_WRONLY|O_CLOEXEC) = 3
[pid  5086] write(3, "1024", 4)         = 4
[pid  5086] close(3)                    = 0
[pid  5086] openat(AT_FDCWD, "/proc/sys/kernel/sem", O_WRONLY|O_CLOEXEC) = 3
[pid  5086] write(3, "1024 1048576 500 1024", 21) = 21
[pid  5086] close(3)                    = 0
[pid  5086] getpid()                    = 1
[pid  5086] capget({version=_LINUX_CAPABILITY_VERSION_3, pid=1}, {effective=1<<CAP_CHOWN|1<<CAP_DAC_OVERRIDE|1<<CAP_DAC_READ_SEARCH|1<<CAP_FOWNER|1<<CAP_FSETID|1<<CAP_KILL|1<<CAP_SETGID|1<<CAP_SETUID|1<<CAP_SETPCAP|1<<CAP_LINUX_IMMUTABLE|1<<CAP_NET_BIND_SERVICE|1<<CAP_NET_BROADCAST|1<<CAP_NET_ADMIN|1<<CAP_NET_RAW|1<<CAP_IPC_LOCK|1<<CAP_IPC_OWNER|1<<CAP_SYS_MODULE|1<<CAP_SYS_RAWIO|1<<CAP_SYS_CHROOT|1<<CAP_SYS_PTRACE|1<<CAP_SYS_PACCT|1<<CAP_SYS_ADMIN|1<<CAP_SYS_BOOT|1<<CAP_SYS_NICE|1<<CAP_SYS_RESOURCE|1<<CAP_SYS_TIME|1<<CAP_SYS_TTY_CONFIG|1<<CAP_MKNOD|1<<CAP_LEASE|1<<CAP_AUDIT_WRITE|1<<CAP_AUDIT_CONTROL|1<<CAP_SETFCAP|1<<CAP_MAC_OVERRIDE|1<<CAP_MAC_ADMIN|1<<CAP_SYSLOG|1<<CAP_WAKE_ALARM|1<<CAP_BLOCK_SUSPEND|1<<CAP_AUDIT_READ|1<<CAP_PERFMON|1<<CAP_BPF|1<<CAP_CHECKPOINT_RESTORE, permitted=1<<CAP_CHOWN|1<<CAP_DAC_OVERRIDE|1<<CAP_DAC_READ_SEARCH|1<<CAP_FOWNER|1<<CAP_FSETID|1<<CAP_KILL|1<<CAP_SETGID|1<<CAP_SETUID|1<<CAP_SETPCAP|1<<CAP_LINUX_IMMUTABLE|1<<CAP_NET_BIND_SERVICE|1<<CAP_NET_BROADCAST|1<<CAP_NET_ADMIN|1<<CAP_NET_RAW|1<<CAP_IPC_LOCK|1<<CAP_IPC_OWNER|1<<CAP_SYS_MODULE|1<<CAP_SYS_RAWIO|1<<CAP_SYS_CHROOT|1<<CAP_SYS_PTRACE|1<<CAP_SYS_PACCT|1<<CAP_SYS_ADMIN|1<<CAP_SYS_BOOT|1<<CAP_SYS_NICE|1<<CAP_SYS_RESOURCE|1<<CAP_SYS_TIME|1<<CAP_SYS_TTY_CONFIG|1<<CAP_MKNOD|1<<CAP_LEASE|1<<CAP_AUDIT_WRITE|1<<CAP_AUDIT_CONTROL|1<<CAP_SETFCAP|1<<CAP_MAC_OVERRIDE|1<<CAP_MAC_ADMIN|1<<CAP_SYSLOG|1<<CAP_WAKE_ALARM|1<<CAP_BLOCK_SUSPEND|1<<CAP_AUDIT_READ|1<<CAP_PERFMON|1<<CAP_BPF|1<<CAP_CHECKPOINT_RESTORE, inheritable=0}) = 0
[pid  5086] capset({version=_LINUX_CAPABILITY_VERSION_3, pid=1}, {effective=1<<CAP_CHOWN|1<<CAP_DAC_OVERRIDE|1<<CAP_DAC_READ_SEARCH|1<<CAP_FOWNER|1<<CAP_FSETID|1<<CAP_KILL|1<<CAP_SETGID|1<<CAP_SETUID|1<<CAP_SETPCAP|1<<CAP_LINUX_IMMUTABLE|1<<CAP_NET_BIND_SERVICE|1<<CAP_NET_BROADCAST|1<<CAP_NET_ADMIN|1<<CAP_NET_RAW|1<<CAP_IPC_LOCK|1<<CAP_IPC_OWNER|1<<CAP_SYS_MODULE|1<<CAP_SYS_RAWIO|1<<CAP_SYS_CHROOT|1<<CAP_SYS_PACCT|1<<CAP_SYS_ADMIN|1<<CAP_SYS_BOOT|1<<CAP_SYS_RESOURCE|1<<CAP_SYS_TIME|1<<CAP_SYS_TTY_CONFIG|1<<CAP_MKNOD|1<<CAP_LEASE|1<<CAP_AUDIT_WRITE|1<<CAP_AUDIT_CONTROL|1<<CAP_SETFCAP|1<<CAP_MAC_OVERRIDE|1<<CAP_MAC_ADMIN|1<<CAP_SYSLOG|1<<CAP_WAKE_ALARM|1<<CAP_BLOCK_SUSPEND|1<<CAP_AUDIT_READ|1<<CAP_PERFMON|1<<CAP_BPF|1<<CAP_CHECKPOINT_RESTORE, permitted=1<<CAP_CHOWN|1<<CAP_DAC_OVERRIDE|1<<CAP_DAC_READ_SEARCH|1<<CAP_FOWNER|1<<CAP_FSETID|1<<CAP_KILL|1<<CAP_SETGID|1<<CAP_SETUID|1<<CAP_SETPCAP|1<<CAP_LINUX_IMMUTABLE|1<<CAP_NET_BIND_SERVICE|1<<CAP_NET_BROADCAST|1<<CAP_NET_ADMIN|1<<CAP_NET_RAW|1<<CAP_IPC_LOCK|1<<CAP_IPC_OWNER|1<<CAP_SYS_MODULE|1<<CAP_SYS_RAWIO|1<<CAP_SYS_CHROOT|1<<CAP_SYS_PACCT|1<<CAP_SYS_ADMIN|1<<CAP_SYS_BOOT|1<<CAP_SYS_RESOURCE|1<<CAP_SYS_TIME|1<<CAP_SYS_TTY_CONFIG|1<<CAP_MKNOD|1<<CAP_LEASE|1<<CAP_AUDIT_WRITE|1<<CAP_AUDIT_CONTROL|1<<CAP_SETFCAP|1<<CAP_MAC_OVERRIDE|1<<CAP_MAC_ADMIN|1<<CAP_SYSLOG|1<<CAP_WAKE_ALARM|1<<CAP_BLOCK_SUSPEND|1<<CAP_AUDIT_READ|1<<CAP_PERFMON|1<<CAP_BPF|1<<CAP_CHECKPOINT_RESTORE, inheritable=0}) = 0
[pid  5086] unshare(CLONE_NEWNET)       = 0
[pid  5086] openat(AT_FDCWD, "/proc/sys/net/ipv4/ping_group_range", O_WRONLY|O_CLOEXEC) = 3
[pid  5086] write(3, "0 65535", 7)      = 7
[pid  5086] close(3)                    = 0
[pid  5086] mkdir("/dev/binderfs", 0777) = 0
[pid  5086] mount("binder", "/dev/binderfs", "binder", 0, NULL) = 0
[pid  5086] symlink("/dev/binderfs", "./binderfs") = 0
[pid  5086] openat(AT_FDCWD, "/dev/loop0", O_RDWR) = 3
[pid  5086] ioctl(3, LOOP_CLR_FD)       = -1 ENXIO (No such device or address)
[pid  5086] close(3)                    = 0
[pid  5086] clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD./strace-static-x86_64: Process 5089 attached
, child_tidptr=0x55558005b650) = 2
[pid  5089] set_robust_list(0x55558005b660, 24) = 0
[pid  5089] prctl(PR_SET_PDEATHSIG, SIGKILL) = 0
[pid  5089] setpgid(0, 0)               = 0
[pid  5089] openat(AT_FDCWD, "/proc/self/oom_score_adj", O_WRONLY|O_CLOEXEC) = 3
[pid  5089] write(3, "1000", 4)         = 4
[pid  5089] close(3)                    = 0
[pid  5089] write(1, "executing program\n", 18executing program
) = 18
[pid  5089] memfd_create("syzkaller", 0) = 3
[pid  5089] mmap(NULL, 138412032, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f2b39a00000
[pid  5089] 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  5089] munmap(0x7f2b39a00000, 138412032) = 0
[pid  5089] openat(AT_FDCWD, "/dev/loop0", O_RDWR) = 4
[pid  5089] ioctl(4, LOOP_SET_FD, 3)    = 0
[pid  5089] close(3)                    = 0
[pid  5089] close(4)                    = 0
[pid  5089] mkdir("./bus", 0777)        = 0
syzkaller login: [   76.727254][ T5089] loop0: detected capacity change from 0 to 32768
[   76.798027][ T5089] bcachefs (loop0): mounting version 1.7: mi_btree_bitmap opts=metadata_checksum=none,data_checksum=none,noshard_inode_numbers,noinodes_use_key_cache,gc_reserve_bytes=512 GiB,nojournal_transaction_names
[   76.818420][ T5089] bcachefs (loop0): recovering from clean shutdown, journal seq 8
[   76.840730][ T5089] bcachefs (loop0): alloc_read... done
[pid  5089] mount("/dev/loop0", "./bus", "bcachefs", 0, "") = 0
[pid  5089] openat(AT_FDCWD, "./bus", O_RDONLY|O_DIRECTORY) = 3
[pid  5089] chdir("./bus")              = 0
[pid  5089] openat(AT_FDCWD, "/dev/loop0", O_RDWR) = 4
[pid  5089] ioctl(4, LOOP_CLR_FD)       = 0
[pid  5089] close(4)                    = 0
[pid  5089] creat("./bus", 000)         = 4
[   76.846846][ T5089] bcachefs (loop0): stripes_read... done
[   76.852648][ T5089] bcachefs (loop0): snapshots_read... done
[   76.862412][ T5089] bcachefs (loop0): journal_replay... done
[   76.868311][ T5089] bcachefs (loop0): resume_logged_ops... done
[   76.875165][ T5089] bcachefs (loop0): going read-write
[   76.885700][ T5089] bcachefs (loop0): done starting filesystem
[pid  5089] fcntl(4, F_SETFL, O_RDONLY|O_NOCTTY|O_DIRECT|FASYNC) = 0
[pid  5089] write(4, "\x74\x68\x72\x65\x61\x64\x65\x64\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00"..., 392007683 <unfinished ...>
[pid  5086] kill(-2, SIGKILL)           = 0
[pid  5086] kill(2, SIGKILL)            = 0
[pid  5086] openat(AT_FDCWD, "/sys/fs/fuse/connections", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 3
[pid  5086] newfstatat(3, "", {st_mode=S_IFDIR|0755, st_size=0, ...}, AT_EMPTY_PATH) = 0
[pid  5086] getdents64(3, 0x55558005c6f0 /* 2 entries */, 32768) = 48
[pid  5086] getdents64(3, 0x55558005c6f0 /* 0 entries */, 32768) = 0
[pid  5086] close(3)                    = 0
[   90.511941][ T5089] Allocator stuck? Waited for 10 seconds
[   90.511970][ T5089] Allocator debug:
[   90.511977][ T5089]   hidden8448
[   90.511984][ T5089]   btree                2816
[   90.511992][ T5089]   data                 6432
[   90.511999][ T5089]   cached               0
[   90.512006][ T5089]   reserved             0
[   90.512013][ T5089]   online_reserved      2040
[   90.512021][ T5089]   nr_inodes            9
[   90.512028][ T5089]   
[   90.512035][ T5089]   freelist_wait        waiting
[   90.512042][ T5089]   open buckets allocated1
[   90.512049][ T5089]   open buckets total   1024
[   90.512057][ T5089]   open_buckets_wait    empty
[   90.512064][ T5089]   open_buckets_btree   0
[   90.512071][ T5089]   open_buckets_user    0
[   90.512079][ T5089]   btree reserve cache  0
[   90.512086][ T5089] 
[   90.512092][ T5089] Dev 0:
[   90.512099][ T5089]                              buckets         sectors      fragmented
[   90.512108][ T5089]   free                            58               0               0
[   90.512117][ T5089]   sb                              25            6152             248
[   90.512126][ T5089]   journal                          8            2048               0
[   90.512135][ T5089]   btree                           11            2816               0
[   90.512144][ T5089]   user                            26            6432             224
[   90.512153][ T5089]   cached                           0               0               0
[   90.512162][ T5089]   parity                           0               0               0
[   90.512176][ T5089]   stripe                           0               0               0
[   90.512185][ T5089]   need_gc_gens                     0               0               0
[   90.512194][ T5089]   need_discard                     0               0               0
[   90.512202][ T5089]   
[   90.512209][ T5089]   reserves:
[   90.512216][ T5089]   stripe                          60
[   90.512223][ T5089]   normal                          58
[   90.512231][ T5089]   copygc                          56
[   90.512238][ T5089]   btree                           28
[   90.512246][ T5089]   btree_copygc                     0
[   90.512254][ T5089]   reclaim                          0
[   90.512261][ T5089]   interior_updates                 0
[   90.512269][ T5089]   
[   90.512275][ T5089]   open buckets             0
[   90.512282][ T5089]   buckets to invalidate    0
[   90.512290][ T5089] 
[   90.512296][ T5089] Copygc debug:
[   90.512303][ T5089]   Currently waiting for:     0 B
[   90.512310][ T5089]   Currently waiting since:   1.99 MiB
[   90.512318][ T5089]   Currently calculated wait: 0 B
[   90.512325][ T5089] 
[   90.512331][ T5089] Journal debug:
[   90.512338][ T5089]   flags:   replay_done,running,may_skip_flush
[   90.512346][ T5089]   dirty journal entries:0/32768
[   90.512354][ T5089]   seq:     11
[   90.512361][ T5089]   seq_ondisk:11
[   90.512367][ T5089]   last_seq:12
[   90.512374][ T5089]   last_seq_ondisk:11
[   90.512381][ T5089]   flushed_seq_ondisk:11
[   90.512388][ T5089]   watermark:stripe
[   90.512395][ T5089]   each entry reserved:361
[   90.512402][ T5089]   nr flush writes:3
[   90.512409][ T5089]   nr noflush writes:0
[   90.512417][ T5089]   average write size:5.81 KiB
[   90.512424][ T5089]   nr direct reclaim:0
[   90.512431][ T5089]   nr background reclaim:17
[   90.512438][ T5089]   reclaim kicked:0
[   90.512445][ T5089]   reclaim runs in:0 ms
[   90.512452][ T5089]   blocked: 0
[   90.512459][ T5089]   current entry sectors:256
[   90.512466][ T5089]   current entry error:ok
[   90.512473][ T5089]   current entry:closed
[   90.512480][ T5089]   unwritten entries:
[   90.512487][ T5089]   last buf closed
[   90.512494][ T5089]   space:
[   90.512501][ T5089]     discarded256:1536
[   90.512508][ T5089]     clean ondisk256:1536
[   90.512515][ T5089]     clean  256:1536
[   90.512522][ T5089]     total  256:2048
[   90.512529][ T5089]   dev 0:
[   90.512535][ T5089]     nr     8
[   90.512542][ T5089]     bucket size256
[   90.512549][ T5089]     available6:208
[   90.512556][ T5089]     discard_idx0
[   90.512563][ T5089]     dirty_ondisk0 (seq 11)
[   90.512570][ T5089]     dirty_idx0 (seq 11)
[   90.512577][ T5089]     cur_idx0 (seq 11)
[   90.512584][ T5089] 
[   92.423442][  T928] cfg80211: failed to load regulatory.db
[  118.671816][ T5089] Allocator stuck? Waited for 10 seconds
[  118.671835][ T5089] Allocator debug:
[  118.671843][ T5089]   hidden8448
[  118.671849][ T5089]   btree                2816
[  118.671857][ T5089]   data                 6432
[  118.671864][ T5089]   cached               0
[  118.671872][ T5089]   reserved             0
[  118.671879][ T5089]   online_reserved      2040
[  118.671886][ T5089]   nr_inodes            9
[  118.671894][ T5089]   
[  118.671900][ T5089]   freelist_wait        waiting
[  118.671908][ T5089]   open buckets allocated1
[  118.671915][ T5089]   open buckets total   1024
[  118.671922][ T5089]   open_buckets_wait    empty
[  118.671930][ T5089]   open_buckets_btree   0
[  118.671937][ T5089]   open_buckets_user    0
[  118.671945][ T5089]   btree reserve cache  0
[  118.671952][ T5089] 
[  118.671958][ T5089] Dev 0:
[  118.671965][ T5089]                              buckets         sectors      fragmented
[  118.671974][ T5089]   free                            58               0               0
[  118.671983][ T5089]   sb                              25            6152             248
[  118.671992][ T5089]   journal                          8            2048               0
[  118.672001][ T5089]   btree                           11            2816               0
[  118.672022][ T5089]   user                            26            6432             224
[  118.672031][ T5089]   cached                           0               0               0
[  118.672039][ T5089]   parity                           0               0               0
[  118.672048][ T5089]   stripe                           0               0               0
[  118.672057][ T5089]   need_gc_gens                     0               0               0
[  118.672066][ T5089]   need_discard                     0               0               0
[  118.672075][ T5089]   
[  118.672081][ T5089]   reserves:
[  118.672088][ T5089]   stripe                          60
[  118.672096][ T5089]   normal                          58
[  118.672104][ T5089]   copygc                          56
[  118.672111][ T5089]   btree                           28
[  118.672119][ T5089]   btree_copygc                     0
[  118.672126][ T5089]   reclaim                          0
[  118.672134][ T5089]   interior_updates                 0
[  118.672142][ T5089]   
[  118.672148][ T5089]   open buckets             0
[  118.672156][ T5089]   buckets to invalidate    0
[  118.672163][ T5089] 
[  118.672170][ T5089] Copygc debug:
[  118.672176][ T5089]   Currently waiting for:     0 B
[  118.672184][ T5089]   Currently waiting since:   1.99 MiB
[  118.672192][ T5089]   Currently calculated wait: 0 B
[  118.672199][ T5089] 
[  118.672205][ T5089] Journal debug:
[  118.672212][ T5089]   flags:   replay_done,running,may_skip_flush
[  118.672220][ T5089]   dirty journal entries:0/32768
[  118.672228][ T5089]   seq:     12
[  118.672234][ T5089]   seq_ondisk:12
[  118.672241][ T5089]   last_seq:13
[  118.672248][ T5089]   last_seq_ondisk:12
[  118.672256][ T5089]   flushed_seq_ondisk:12
[  118.672264][ T5089]   watermark:stripe
[  118.672271][ T5089]   each entry reserved:361
[  118.672279][ T5089]   nr flush writes:4
[  118.672286][ T5089]   nr noflush writes:0
[  118.672293][ T5089]   average write size:4.79 KiB
[  118.672300][ T5089]   nr direct reclaim:0
[  118.672307][ T5089]   nr background reclaim:18
[  118.672315][ T5089]   reclaim kicked:0
[  118.672322][ T5089]   reclaim runs in:0 ms
[  118.672329][ T5089]   blocked: 0
[  118.672335][ T5089]   current entry sectors:256
[  118.672343][ T5089]   current entry error:ok
[  118.672352][ T5089]   current entry:closed
[  118.672359][ T5089]   unwritten entries:
[  118.672366][ T5089]   last buf closed
[  118.672374][ T5089]   space:
[  118.672382][ T5089]     discarded256:1536
[  118.672389][ T5089]     clean ondisk256:1536
[  118.672397][ T5089]     clean  256:1536
[  118.672405][ T5089]     total  256:2048
[  118.672412][ T5089]   dev 0:
[  118.672420][ T5089]     nr     8
[  118.672427][ T5089]     bucket size256
[  118.672434][ T5089]     available6:200
[  118.672441][ T5089]     discard_idx0
[  118.672448][ T5089]     dirty_ondisk0 (seq 12)
[  118.672455][ T5089]     dirty_idx0 (seq 12)
[  118.672463][ T5089]     cur_idx0 (seq 12)
[  118.672470][ T5089] 
[  286.981136][   T30] INFO: task syz-executor158:5089 blocked for more than 143 seconds.
[  286.990032][   T30]       Not tainted 6.10.0-rc3-syzkaller #0
[  286.996049][   T30] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[  287.005260][   T30] task:syz-executor158 state:D stack:15992 pid:5089  tgid:5089  ppid:5086   flags:0x00004006
[  287.015647][   T30] Call Trace:
[  287.019043][   T30]  <TASK>
[  287.022133][   T30]  __schedule+0x1796/0x49d0
[  287.026733][   T30]  ? __pfx___schedule+0x10/0x10
[  287.031747][   T30]  ? __pfx_lock_release+0x10/0x10
[  287.036819][   T30]  ? bch2_print_allocator_stuck+0x143/0xc80
[  287.042953][   T30]  ? bch2_printbuf_exit+0x6d/0xa0
[  287.048076][   T30]  ? bch2_print_allocator_stuck+0x143/0xc80
[  287.054165][   T30]  ? bch2_printbuf_exit+0x6d/0xa0
[  287.059329][   T30]  ? schedule+0x90/0x320
[  287.064100][   T30]  schedule+0x14b/0x320
[  287.068425][   T30]  __closure_sync+0x259/0x2f0
[  287.073311][   T30]  ? __closure_sync+0x149/0x2f0
[  287.078299][   T30]  ? __pfx___closure_sync+0x10/0x10
[  287.083879][   T30]  __bch2_write+0x54a5/0x5c40
[  287.088672][   T30]  ? __pfx___bch2_write+0x10/0x10
[  287.093883][   T30]  ? __pfx_lock_release+0x10/0x10
[  287.099082][   T30]  ? do_raw_spin_unlock+0x13c/0x8b0
[  287.104457][   T30]  bch2_write+0x947/0x1670
[  287.108939][   T30]  ? __pfx_bch2_write+0x10/0x10
[  287.114358][   T30]  ? bio_uninit+0x2b0/0x3b0
[  287.118912][   T30]  ? iov_iter_revert+0x1c8/0x390
[  287.123982][   T30]  ? bch2_direct_write+0x1160/0x3050
[  287.129360][   T30]  bch2_direct_write+0x1a52/0x3050
[  287.134651][   T30]  ? __pfx_bch2_direct_write+0x10/0x10
[  287.140165][   T30]  bch2_write_iter+0x206/0x2840
[  287.145185][   T30]  ? __pfx_lock_acquire+0x10/0x10
[  287.150252][   T30]  ? __pfx_bch2_write_iter+0x10/0x10
[  287.155719][   T30]  ? rcu_read_lock_any_held+0xb7/0x160
[  287.161305][   T30]  ? __pfx_rcu_read_lock_any_held+0x10/0x10
[  287.167251][   T30]  vfs_write+0xa72/0xc90
[  287.171660][   T30]  ? __pfx_bch2_write_iter+0x10/0x10
[  287.177003][   T30]  ? __pfx_vfs_write+0x10/0x10
[  287.181907][   T30]  ? lockdep_hardirqs_on+0x99/0x150
[  287.187177][   T30]  ksys_write+0x1a0/0x2c0
[  287.191650][   T30]  ? __pfx_ksys_write+0x10/0x10
[  287.196650][   T30]  ? do_syscall_64+0x100/0x230
[  287.201713][   T30]  do_syscall_64+0xf3/0x230
[  287.206272][   T30]  ? clear_bhb_loop+0x35/0x90
[  287.211241][   T30]  entry_SYSCALL_64_after_hwframe+0x77/0x7f
[  287.217216][   T30] RIP: 0033:0x7f2b41eb9df9
[  287.221884][   T30] RSP: 002b:00007ffce5de58b8 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
[  287.230354][   T30] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007f2b41eb9df9
[  287.238615][   T30] RDX: 00000000175d9003 RSI: 0000000020000200 RDI: 0000000000000004
[  287.247193][   T30] RBP: 0000000000000000 R08: 0000555500000000 R09: 0000555500000000
[  287.255344][   T30] R10: 0000555500000000 R11: 0000000000000246 R12: 00000000000f4240
[  287.263494][   T30] R13: 00007ffce5de5b28 R14: 0000000000000001 R15: 00007ffce5de58f0
[  287.271594][   T30]  </TASK>
[  287.274654][   T30] 
[  287.274654][   T30] Showing all locks held in the system:
[  287.282494][   T30] 1 lock held by khungtaskd/30:
[  287.287388][   T30]  #0: ffffffff8e333fa0 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x55/0x2a0
[  287.297372][   T30] 2 locks held by getty/4838:
[  287.302140][   T30]  #0: ffff88802ab530a0 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x25/0x70
[  287.312130][   T30]  #1: ffffc900031332f0 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0x6b5/0x1e10
[  287.322382][   T30] 2 locks held by syz-executor158/5089:
[  287.327935][   T30]  #0: ffff888023ecc420 (sb_writers#9){.+.+}-{0:0}, at: vfs_write+0x227/0xc90
[  287.336923][   T30]  #1: ffff8880786e0150 (&sb->s_type->i_mutex_key#16){+.+.}-{3:3}, at: bch2_direct_write+0x243/0x3050
[  287.348060][   T30] 
[  287.350391][   T30] =============================================
[  287.350391][   T30] 
[  287.359036][   T30] NMI backtrace for cpu 0
[  287.363459][   T30] CPU: 0 PID: 30 Comm: khungtaskd Not tainted 6.10.0-rc3-syzkaller #0
[  287.371631][   T30] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 04/02/2024
[  287.381733][   T30] Call Trace:
[  287.385028][   T30]  <TASK>
[  287.387971][   T30]  dump_stack_lvl+0x241/0x360
[  287.392671][   T30]  ? __pfx_dump_stack_lvl+0x10/0x10
[  287.397898][   T30]  ? __pfx__printk+0x10/0x10
[  287.402503][   T30]  ? vprintk_emit+0x631/0x770
[  287.407212][   T30]  ? __pfx_vprintk_emit+0x10/0x10
[  287.412265][   T30]  nmi_cpu_backtrace+0x49c/0x4d0
[  287.417237][   T30]  ? __pfx_nmi_cpu_backtrace+0x10/0x10
[  287.422725][   T30]  ? _printk+0xd5/0x120
[  287.426900][   T30]  ? __pfx__printk+0x10/0x10
[  287.431525][   T30]  ? __wake_up_klogd+0xcc/0x110
[  287.436415][   T30]  ? __pfx__printk+0x10/0x10
[  287.441025][   T30]  ? __pfx_nmi_raise_cpu_backtrace+0x10/0x10
[  287.447027][   T30]  nmi_trigger_cpumask_backtrace+0x198/0x320
[  287.453045][   T30]  watchdog+0xfde/0x1020
[  287.457312][   T30]  ? watchdog+0x1ea/0x1020
[  287.461771][   T30]  ? __pfx_watchdog+0x10/0x10
[  287.466582][   T30]  kthread+0x2f0/0x390
[  287.470687][   T30]  ? __pfx_watchdog+0x10/0x10
[  287.475399][   T30]  ? __pfx_kthread+0x10/0x10
[  287.480098][   T30]  ret_from_fork+0x4b/0x80
[  287.484546][   T30]  ? __pfx_kthread+0x10/0x10
[  287.489245][   T30]  ret_from_fork_asm+0x1a/0x30
[  287.494053][   T30]  </TASK>
[  287.497266][   T30] Sending NMI from CPU 0 to CPUs 1:
[  287.502621][    C1] NMI backtrace for cpu 1
[  287.502636][    C1] CPU: 1 PID: 11 Comm: kworker/u8:0 Not tainted 6.10.0-rc3-syzkaller #0
[  287.502654][    C1] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 04/02/2024
[  287.502666][    C1] Workqueue: events_unbound toggle_allocation_gate
[  287.502692][    C1] RIP: 0010:__sanitizer_cov_trace_pc+0x8/0x70
[  287.502715][    C1] Code: 8b 3d bc 4c 44 0c 48 89 de 5b e9 13 06 57 00 0f 1f 00 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 f3 0f 1e fa 48 8b 04 24 <65> 48 8b 0c 25 c0 d4 03 00 65 8b 15 a0 ae 6d 7e f7 c2 00 01 ff 00
[  287.502730][    C1] RSP: 0018:ffffc90000107678 EFLAGS: 00000002
[  287.502744][    C1] RAX: ffffffff820463ef RBX: 8000000001ed1063 RCX: ffff8880176b3c00
[  287.502757][    C1] RDX: ffff8880176b3c00 RSI: 0000000000000000 RDI: 0000000000000000
[  287.502769][    C1] RBP: ffffc90000107730 R08: ffffffff820463d3 R09: 1ffffffff1f583d5
[  287.502788][    C1] R10: dffffc0000000000 R11: fffffbfff1f583d6 R12: 0000000000000000
[  287.502800][    C1] R13: 0000000000000001 R14: 1ffff92000020ed4 R15: 0000000000000001
[  287.502812][    C1] FS:  0000000000000000(0000) GS:ffff8880b9500000(0000) knlGS:0000000000000000
[  287.502826][    C1] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  287.502838][    C1] CR2: 000055a79afc3600 CR3: 000000000e132000 CR4: 00000000003506f0
[  287.502853][    C1] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[  287.502863][    C1] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
[  287.502874][    C1] Call Trace:
[  287.502881][    C1]  <NMI>
[  287.502888][    C1]  ? nmi_cpu_backtrace+0x3c2/0x4d0
[  287.502914][    C1]  ? __pfx_lock_acquire+0x10/0x10
[  287.502935][    C1]  ? __pfx_nmi_cpu_backtrace+0x10/0x10
[  287.502960][    C1]  ? nmi_handle+0x2a/0x5a0
[  287.502995][    C1]  ? nmi_cpu_backtrace_handler+0xc/0x20
[  287.503017][    C1]  ? nmi_handle+0x14f/0x5a0
[  287.503042][    C1]  ? nmi_handle+0x2a/0x5a0
[  287.503068][    C1]  ? __sanitizer_cov_trace_pc+0x8/0x70
[  287.503086][    C1]  ? default_do_nmi+0x63/0x160
[  287.503112][    C1]  ? exc_nmi+0x123/0x1f0
[  287.503137][    C1]  ? end_repeat_nmi+0xf/0x53
[  287.503162][    C1]  ? __page_table_check_ptes_set+0x143/0x410
[  287.503185][    C1]  ? __page_table_check_ptes_set+0x15f/0x410
[  287.503209][    C1]  ? __sanitizer_cov_trace_pc+0x8/0x70
[  287.503227][    C1]  ? __sanitizer_cov_trace_pc+0x8/0x70
[  287.503247][    C1]  ? __sanitizer_cov_trace_pc+0x8/0x70
[  287.503266][    C1]  </NMI>
[  287.503271][    C1]  <TASK>
[  287.503276][    C1]  __page_table_check_ptes_set+0x15f/0x410
[  287.503301][    C1]  ? __pfx___pte_offset_map_lock+0x10/0x10
[  287.503325][    C1]  ? __pfx___page_table_check_ptes_set+0x10/0x10
[  287.503347][    C1]  ? do_raw_spin_unlock+0x13c/0x8b0
[  287.503371][    C1]  ? walk_to_pmd+0x19b/0x240
[  287.503389][    C1]  ? kmem_cache_alloc_node_noprof+0x89/0x320
[  287.503411][    C1]  ? rcu_is_watching+0x15/0xb0
[  287.503432][    C1]  __text_poke+0xcdb/0xd30
[  287.503452][    C1]  ? kmem_cache_alloc_node_noprof+0x89/0x320
[  287.503475][    C1]  ? __pfx_text_poke_memcpy+0x10/0x10
[  287.503495][    C1]  ? __pfx___text_poke+0x10/0x10
[  287.503518][    C1]  ? __pfx___might_resched+0x10/0x10
[  287.503540][    C1]  ? __mutex_trylock_common+0x183/0x2e0
[  287.503563][    C1]  ? __pfx___might_resched+0x10/0x10
[  287.503590][    C1]  ? kmem_cache_alloc_node_noprof+0x89/0x320
[  287.503613][    C1]  text_poke_bp_batch+0x265/0xb30
[  287.503640][    C1]  ? __pfx_text_poke_bp_batch+0x10/0x10
[  287.503659][    C1]  ? __pfx___mutex_lock+0x10/0x10
[  287.503689][    C1]  ? arch_jump_label_transform_queue+0x9b/0x100
[  287.503716][    C1]  text_poke_finish+0x30/0x50
[  287.503734][    C1]  arch_jump_label_transform_apply+0x1c/0x30
[  287.503756][    C1]  static_key_disable_cpuslocked+0xce/0x1c0
[  287.503791][    C1]  static_key_disable+0x1a/0x20
[  287.503816][    C1]  toggle_allocation_gate+0x1b8/0x250
[  287.503835][    C1]  ? __pfx_toggle_allocation_gate+0x10/0x10
[  287.503853][    C1]  ? __pfx_lockdep_hardirqs_on_prepare+0x10/0x10
[  287.503879][    C1]  ? process_scheduled_works+0x945/0x1830
[  287.503896][    C1]  process_scheduled_works+0xa2c/0x1830
[  287.503930][    C1]  ? __pfx_process_scheduled_works+0x10/0x10
[  287.503952][    C1]  ? assign_work+0x364/0x3d0
[  287.503972][    C1]  worker_thread+0x86d/0xd70
[  287.503999][    C1]  ? __kthread_parkme+0x169/0x1d0
[  287.504020][    C1]  ? __pfx_worker_thread+0x10/0x10
[  287.504039][    C1]  kthread+0x2f0/0x390
[  287.504059][    C1]  ? __pfx_worker_thread+0x10/0x10
[  287.504077][    C1]  ? __pfx_kthread+0x10/0x10
[  287.504106][    C1]  ret_from_fork+0x4b/0x80
[  287.504129][    C1]  ? __pfx_kthread+0x10/0x10
[  287.504150][    C1]  ret_from_fork_asm+0x1a/0x30
[  287.504184][    C1]  </TASK>
[  287.504192][    C1] INFO: NMI handler (nmi_cpu_backtrace_handler) took too long to run: 1.570 msecs
[  287.504673][   T30] Kernel panic - not syncing: hung_task: blocked tasks
[  287.972571][   T30] CPU: 0 PID: 30 Comm: khungtaskd Not tainted 6.10.0-rc3-syzkaller #0
[  287.980744][   T30] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 04/02/2024
[  287.990814][   T30] Call Trace:
[  287.994122][   T30]  <TASK>
[  287.997077][   T30]  dump_stack_lvl+0x241/0x360
[  288.001945][   T30]  ? __pfx_dump_stack_lvl+0x10/0x10
[  288.007260][   T30]  ? __pfx__printk+0x10/0x10
[  288.011861][   T30]  ? lockdep_hardirqs_on_prepare+0x43d/0x780
[  288.017853][   T30]  ? vscnprintf+0x5d/0x90
[  288.022220][   T30]  panic+0x349/0x860
[  288.026236][   T30]  ? nmi_trigger_cpumask_backtrace+0x244/0x320
[  288.032570][   T30]  ? __pfx_panic+0x10/0x10
[  288.036996][   T30]  ? preempt_schedule_thunk+0x1a/0x30
[  288.042582][   T30]  ? nmi_trigger_cpumask_backtrace+0x244/0x320
[  288.048853][   T30]  ? nmi_trigger_cpumask_backtrace+0x2d4/0x320
[  288.055026][   T30]  ? nmi_trigger_cpumask_backtrace+0x2d9/0x320
[  288.061220][   T30]  watchdog+0x101d/0x1020
[  288.065760][   T30]  ? watchdog+0x1ea/0x1020
[  288.070205][   T30]  ? __pfx_watchdog+0x10/0x10
[  288.074895][   T30]  kthread+0x2f0/0x390
[  288.078995][   T30]  ? __pfx_watchdog+0x10/0x10
[  288.083685][   T30]  ? __pfx_kthread+0x10/0x10
[  288.088287][   T30]  ret_from_fork+0x4b/0x80
[  288.092734][   T30]  ? __pfx_kthread+0x10/0x10
[  288.097433][   T30]  ret_from_fork_asm+0x1a/0x30
[  288.102259][   T30]  </TASK>
[  288.105634][   T30] Kernel Offset: disabled
[  288.109984][   T30] Rebooting in 86400 seconds..