INFO: task syz.1.49:6275 blocked for more than 143 seconds.
Not tainted 6.16.0-rc6-syzkaller-00002-g155a3c003e55 #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz.1.49 state:D stack:17352 pid:6275 tgid:6274 ppid:5850 task_flags:0x440140 flags:0x00004006
Call Trace:
context_switch kernel/sched/core.c:5397 [inline]
__schedule+0x16a2/0x4cb0 kernel/sched/core.c:6786
__schedule_loop kernel/sched/core.c:6864 [inline]
schedule+0x165/0x360 kernel/sched/core.c:6879
__bch2_two_state_lock+0x1ea/0x370 fs/bcachefs/two_state_shared_lock.c:7
bch2_two_state_lock fs/bcachefs/two_state_shared_lock.h:55 [inline]
bch2_readahead+0x94f/0x1100 fs/bcachefs/fs-io-buffered.c:296
read_pages+0x177/0x580 mm/readahead.c:160
page_cache_ra_order+0xa24/0xc70 mm/readahead.c:515
filemap_get_pages+0x43c/0x1ea0 mm/filemap.c:2602
filemap_splice_read+0x4fc/0xbc0 mm/filemap.c:2990
do_splice_read fs/splice.c:979 [inline]
splice_direct_to_actor+0x4a6/0xcc0 fs/splice.c:1083
do_splice_direct_actor fs/splice.c:1201 [inline]
do_splice_direct+0x181/0x270 fs/splice.c:1227
vfs_copy_file_range+0xabc/0x1310 fs/read_write.c:1627
__do_sys_copy_file_range fs/read_write.c:1677 [inline]
__se_sys_copy_file_range+0x2fb/0x470 fs/read_write.c:1644
do_syscall_x64 arch/x86/entry/syscall_64.c:63 [inline]
do_syscall_64+0xfa/0x3b0 arch/x86/entry/syscall_64.c:94
entry_SYSCALL_64_after_hwframe+0x77/0x7f
RIP: 0033:0x7f3703f8e929
RSP: 002b:00007f3704ec1038 EFLAGS: 00000246 ORIG_RAX: 0000000000000146
RAX: ffffffffffffffda RBX: 00007f37041b5fa0 RCX: 00007f3703f8e929
RDX: 0000000000000004 RSI: 0000000000000000 RDI: 0000000000000005
RBP: 00007f3704010b39 R08: fffffbffa003e458 R09: 0700000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 0000000000000000 R14: 00007f37041b5fa0 R15: 00007ffd65f7eb88
INFO: task syz.1.49:6331 blocked for more than 144 seconds.
Not tainted 6.16.0-rc6-syzkaller-00002-g155a3c003e55 #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz.1.49 state:D stack:24728 pid:6331 tgid:6274 ppid:5850 task_flags:0x400140 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:5397 [inline]
__schedule+0x16a2/0x4cb0 kernel/sched/core.c:6786
__schedule_loop kernel/sched/core.c:6864 [inline]
schedule+0x165/0x360 kernel/sched/core.c:6879
io_schedule+0x81/0xe0 kernel/sched/core.c:7724
folio_wait_bit_common+0x6b0/0xb90 mm/filemap.c:1317
__folio_lock mm/filemap.c:1675 [inline]
folio_lock include/linux/pagemap.h:1114 [inline]
__filemap_get_folio+0x139/0xaf0 mm/filemap.c:1928
filemap_lock_folio include/linux/pagemap.h:785 [inline]
__bch2_truncate_folio+0x11d/0x1a30 fs/bcachefs/fs-io.c:291
bch2_truncate_folio fs/bcachefs/fs-io.c:393 [inline]
bchfs_truncate+0x5de/0xc20 fs/bcachefs/fs-io.c:483
notify_change+0xb36/0xe40 fs/attr.c:552
do_truncate+0x1a4/0x220 fs/open.c:68
handle_truncate fs/namei.c:3517 [inline]
do_open fs/namei.c:3900 [inline]
path_openat+0x306c/0x3830 fs/namei.c:4055
do_filp_open+0x1fa/0x410 fs/namei.c:4082
do_sys_openat2+0x121/0x1c0 fs/open.c:1437
do_sys_open fs/open.c:1452 [inline]
__do_sys_open fs/open.c:1460 [inline]
__se_sys_open fs/open.c:1456 [inline]
__x64_sys_open+0x11e/0x150 fs/open.c:1456
do_syscall_x64 arch/x86/entry/syscall_64.c:63 [inline]
do_syscall_64+0xfa/0x3b0 arch/x86/entry/syscall_64.c:94
entry_SYSCALL_64_after_hwframe+0x77/0x7f
RIP: 0033:0x7f3703f8e929
RSP: 002b:00007f3704ea0038 EFLAGS: 00000246 ORIG_RAX: 0000000000000002
RAX: ffffffffffffffda RBX: 00007f37041b6080 RCX: 00007f3703f8e929
RDX: 0000000000000000 RSI: 000000000014d27e RDI: 0000200000000180
RBP: 00007f3704010b39 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 0000000000000000 R14: 00007f37041b6080 R15: 00007ffd65f7eb88
Showing all locks held in the system:
3 locks held by kworker/u8:1/13:
#0: ffff88801a489148 ((wq_completion)events_unbound){+.+.}-{0:0}, at: process_one_work kernel/workqueue.c:3213 [inline]
#0: ffff88801a489148 ((wq_completion)events_unbound){+.+.}-{0:0}, at: process_scheduled_works+0x9b4/0x17b0 kernel/workqueue.c:3321
#1: ffffc90000127bc0 ((linkwatch_work).work){+.+.}-{0:0}, at: process_one_work kernel/workqueue.c:3214 [inline]
#1: ffffc90000127bc0 ((linkwatch_work).work){+.+.}-{0:0}, at: process_scheduled_works+0x9ef/0x17b0 kernel/workqueue.c:3321
#2: ffffffff8f50b748 (rtnl_mutex){+.+.}-{4:4}, at: linkwatch_event+0xe/0x60 net/core/link_watch.c:303
1 lock held by khungtaskd/31:
#0: ffffffff8e13f0e0 (rcu_read_lock){....}-{1:3}, at: rcu_lock_acquire include/linux/rcupdate.h:331 [inline]
#0: ffffffff8e13f0e0 (rcu_read_lock){....}-{1:3}, at: rcu_read_lock include/linux/rcupdate.h:841 [inline]
#0: ffffffff8e13f0e0 (rcu_read_lock){....}-{1:3}, at: debug_show_all_locks+0x2e/0x180 kernel/locking/lockdep.c:6770
5 locks held by kworker/u8:5/972:
#0: ffff88801b2fb948 ((wq_completion)netns){+.+.}-{0:0}, at: process_one_work kernel/workqueue.c:3213 [inline]
#0: ffff88801b2fb948 ((wq_completion)netns){+.+.}-{0:0}, at: process_scheduled_works+0x9b4/0x17b0 kernel/workqueue.c:3321
#1: ffffc90003a47bc0 (net_cleanup_work){+.+.}-{0:0}, at: process_one_work kernel/workqueue.c:3214 [inline]
#1: ffffc90003a47bc0 (net_cleanup_work){+.+.}-{0:0}, at: process_scheduled_works+0x9ef/0x17b0 kernel/workqueue.c:3321
#2: ffffffff8f4feb50 (pernet_ops_rwsem){++++}-{4:4}, at: cleanup_net+0xf7/0x800 net/core/net_namespace.c:662
#3: ffffffff8f50b748 (rtnl_mutex){+.+.}-{4:4}, at: default_device_exit_batch+0xdc/0x890 net/core/dev.c:12630
#4: ffffffff8e144bf8 (rcu_state.exp_mutex){+.+.}-{4:4}, at: exp_funnel_lock kernel/rcu/tree_exp.h:304 [inline]
#4: ffffffff8e144bf8 (rcu_state.exp_mutex){+.+.}-{4:4}, at: synchronize_rcu_expedited+0x2f6/0x730 kernel/rcu/tree_exp.h:998
5 locks held by kworker/u8:8/1166:
3 locks held by kworker/u8:10/3575:
#0: ffff88802faa4948 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: process_one_work kernel/workqueue.c:3213 [inline]
#0: ffff88802faa4948 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: process_scheduled_works+0x9b4/0x17b0 kernel/workqueue.c:3321
#1: ffffc9000c6c7bc0 ((work_completion)(&(&net->ipv6.addr_chk_work)->work)){+.+.}-{0:0}, at: process_one_work kernel/workqueue.c:3214 [inline]
#1: ffffc9000c6c7bc0 ((work_completion)(&(&net->ipv6.addr_chk_work)->work)){+.+.}-{0:0}, at: process_scheduled_works+0x9ef/0x17b0 kernel/workqueue.c:3321
#2: ffffffff8f50b748 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_net_lock include/linux/rtnetlink.h:130 [inline]
#2: ffffffff8f50b748 (rtnl_mutex){+.+.}-{4:4}, at: addrconf_verify_work+0x19/0x30 net/ipv6/addrconf.c:4733
2 locks held by syslogd/5191:
#0: ffff8880b8739e18 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock_nested+0x2a/0x140 kernel/sched/core.c:606
#1: ffff888034d9a218 (rlock-AF_UNIX){+.+.}-{3:3}, at: psi_task_switch+0x39e/0x6d0 kernel/sched/psi.c:987
1 lock held by dhcpcd/5504:
#0: ffffffff8f50b748 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_net_lock include/linux/rtnetlink.h:130 [inline]
#0: ffffffff8f50b748 (rtnl_mutex){+.+.}-{4:4}, at: inet_rtm_newaddr+0x3b0/0x18b0 net/ipv4/devinet.c:979
2 locks held by getty/5598:
#0: ffff8880318240a0 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x25/0x70 drivers/tty/tty_ldisc.c:243
#1: ffffc9000333b2f0 (&ldata->atomic_read_lock){+.+.}-{4:4}, at: n_tty_read+0x43e/0x1400 drivers/tty/n_tty.c:2222
4 locks held by syz-executor/6102:
#0: ffff888027e04dc0 (&hdev->req_lock){+.+.}-{4:4}, at: hci_dev_do_close net/bluetooth/hci_core.c:499 [inline]
#0: ffff888027e04dc0 (&hdev->req_lock){+.+.}-{4:4}, at: hci_unregister_dev+0x212/0x510 net/bluetooth/hci_core.c:2717
#1: ffff888027e040b8 (&hdev->lock){+.+.}-{4:4}, at: hci_dev_close_sync+0x66a/0x1330 net/bluetooth/hci_sync.c:5282
#2: ffffffff8f6739c8 (hci_cb_list_lock){+.+.}-{4:4}, at: hci_disconn_cfm include/net/bluetooth/hci_core.h:2067 [inline]
#2: ffffffff8f6739c8 (hci_cb_list_lock){+.+.}-{4:4}, at: hci_conn_hash_flush+0xa1/0x230 net/bluetooth/hci_conn.c:2560
#3: ffff888027b3cb38 (&conn->lock#2){+.+.}-{4:4}, at: l2cap_conn_del+0x70/0x680 net/bluetooth/l2cap_core.c:1762
1 lock held by syz.1.49/6275:
#0: ffff8880553382e8 (mapping.invalidate_lock#9){.+.+}-{4:4}, at: filemap_invalidate_lock_shared include/linux/fs.h:934 [inline]
#0: ffff8880553382e8 (mapping.invalidate_lock#9){.+.+}-{4:4}, at: page_cache_ra_order+0x445/0xc70 mm/readahead.c:491
2 locks held by syz.1.49/6331:
#0: ffff88807f856428 (sb_writers#22){.+.+}-{0:0}, at: mnt_want_write+0x41/0x90 fs/namespace.c:557
#1: ffff888055338148 (&sb->s_type->i_mutex_key#31){+.+.}-{4:4}, at: inode_lock_killable include/linux/fs.h:874 [inline]
#1: ffff888055338148 (&sb->s_type->i_mutex_key#31){+.+.}-{4:4}, at: do_truncate+0x171/0x220 fs/open.c:63
2 locks held by syz-executor/6557:
1 lock held by syz-executor/6769:
#0: ffff88807fb8a0e0 (&type->s_umount_key#74){++++}-{4:4}, at: __super_lock fs/super.c:57 [inline]
#0: ffff88807fb8a0e0 (&type->s_umount_key#74){++++}-{4:4}, at: __super_lock_excl fs/super.c:72 [inline]
#0: ffff88807fb8a0e0 (&type->s_umount_key#74){++++}-{4:4}, at: deactivate_super+0xa9/0xe0 fs/super.c:506
2 locks held by syz-executor/8903:
#0: ffffffff8fa10698 (&ops->srcu#2){.+.+}-{0:0}, at: rcu_lock_acquire include/linux/rcupdate.h:331 [inline]
#0: ffffffff8fa10698 (&ops->srcu#2){.+.+}-{0:0}, at: rcu_read_lock include/linux/rcupdate.h:841 [inline]
#0: ffffffff8fa10698 (&ops->srcu#2){.+.+}-{0:0}, at: rtnl_link_ops_get+0x23/0x250 net/core/rtnetlink.c:570
#1: ffffffff8f50b748 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_lock net/core/rtnetlink.c:80 [inline]
#1: ffffffff8f50b748 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_nets_lock net/core/rtnetlink.c:341 [inline]
#1: ffffffff8f50b748 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x8db/0x1c70 net/core/rtnetlink.c:4054
3 locks held by syz.7.346/9127:
#0: ffff8880585ecdc0 (&hdev->req_lock){+.+.}-{4:4}, at: hci_dev_do_close net/bluetooth/hci_core.c:499 [inline]
#0: ffff8880585ecdc0 (&hdev->req_lock){+.+.}-{4:4}, at: hci_unregister_dev+0x212/0x510 net/bluetooth/hci_core.c:2717
#1: ffff8880585ec0b8 (&hdev->lock){+.+.}-{4:4}, at: hci_dev_close_sync+0x66a/0x1330 net/bluetooth/hci_sync.c:5282
#2: ffffffff8f6739c8 (hci_cb_list_lock){+.+.}-{4:4}, at: hci_disconn_cfm include/net/bluetooth/hci_core.h:2067 [inline]
#2: ffffffff8f6739c8 (hci_cb_list_lock){+.+.}-{4:4}, at: hci_conn_hash_flush+0xa1/0x230 net/bluetooth/hci_conn.c:2560
1 lock held by syz-executor/9129:
#0: ffffffff8f50b748 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_net_lock include/linux/rtnetlink.h:130 [inline]
#0: ffffffff8f50b748 (rtnl_mutex){+.+.}-{4:4}, at: inet_rtm_newaddr+0x3b0/0x18b0 net/ipv4/devinet.c:979
=============================================
NMI backtrace for cpu 0
CPU: 0 UID: 0 PID: 31 Comm: khungtaskd Not tainted 6.16.0-rc6-syzkaller-00002-g155a3c003e55 #0 PREEMPT(full)
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 05/07/2025
Call Trace:
dump_stack_lvl+0x189/0x250 lib/dump_stack.c:120
nmi_cpu_backtrace+0x39e/0x3d0 lib/nmi_backtrace.c:113
nmi_trigger_cpumask_backtrace+0x17a/0x300 lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:158 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:307 [inline]
watchdog+0xfee/0x1030 kernel/hung_task.c:470
kthread+0x711/0x8a0 kernel/kthread.c:464
ret_from_fork+0x3fc/0x770 arch/x86/kernel/process.c:148
ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:245
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 UID: 0 PID: 6766 Comm: syz-executor Not tainted 6.16.0-rc6-syzkaller-00002-g155a3c003e55 #0 PREEMPT(full)
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 05/07/2025
RIP: 0010:spec_flag lib/vsprintf.c:2567 [inline]
RIP: 0010:format_decode+0x161/0xe30 lib/vsprintf.c:2632
Code: f6 80 fb 11 0f 83 b2 00 00 00 4c 8d ab 20 0e b9 8c 4c 89 e8 48 c1 e8 03 48 ba 00 00 00 00 00 fc ff df 0f b6 04 10 84 c0 75 59 <45> 0f b6 6d 00 41 0f b6 04 16 84 c0 75 69 48 8b 44 24 08 44 08 28
RSP: 0018:ffffc9000409f2f0 EFLAGS: 00000297
RAX: 0000000000000001 RBX: 0000000000000010 RCX: 000000008cb90e00
RDX: dffffc0000000000 RSI: 0000000000000010 RDI: 0000000000000011
RBP: ffffffff8b8b8947 R08: ffff888058de8000 R09: 0000000000000002
R10: 0000000000000025 R11: 0000000000000000 R12: 1ffffffff1717128
R13: ffffffff8cb90e30 R14: 1ffff92000813e73 R15: ffffffff8b8b8947
FS: 000055557b7b0500(0000) GS:ffff888125d4f000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f7c1a0e4de0 CR3: 000000007913a000 CR4: 00000000003526f0
Call Trace:
vsnprintf+0x102/0xf00 lib/vsprintf.c:2817
sprintf+0xd9/0x120 lib/vsprintf.c:3037
print_time kernel/printk/printk.c:1381 [inline]
info_print_prefix+0x155/0x310 kernel/printk/printk.c:1407
record_print_text+0x154/0x430 kernel/printk/printk.c:1456
printk_get_next_message+0x26d/0x7b0 kernel/printk/printk.c:3024
console_emit_next_record kernel/printk/printk.c:3092 [inline]
console_flush_all+0x4ca/0xc40 kernel/printk/printk.c:3226
__console_flush_and_unlock kernel/printk/printk.c:3285 [inline]
console_unlock+0xc4/0x270 kernel/printk/printk.c:3325
vprintk_emit+0x5b7/0x7a0 kernel/printk/printk.c:2450
bch2_print_maybe_redirect fs/bcachefs/super.c:137 [inline]
__bch2_print+0x176/0x220 fs/bcachefs/super.c:156
bch2_fs_free+0x526/0x5a0 fs/bcachefs/super.c:732
deactivate_locked_super+0xbc/0x130 fs/super.c:474
cleanup_mnt+0x425/0x4c0 fs/namespace.c:1417
task_work_run+0x1d4/0x260 kernel/task_work.c:227
resume_user_mode_work include/linux/resume_user_mode.h:50 [inline]
exit_to_user_mode_loop+0xec/0x110 kernel/entry/common.c:114
exit_to_user_mode_prepare include/linux/entry-common.h:330 [inline]
syscall_exit_to_user_mode_work include/linux/entry-common.h:414 [inline]
syscall_exit_to_user_mode include/linux/entry-common.h:449 [inline]
do_syscall_64+0x2bd/0x3b0 arch/x86/entry/syscall_64.c:100
entry_SYSCALL_64_after_hwframe+0x77/0x7f
RIP: 0033:0x7fbf7918fc57
Code: a8 ff ff ff f7 d8 64 89 01 48 83 c8 ff c3 0f 1f 44 00 00 31 f6 e9 09 00 00 00 66 0f 1f 84 00 00 00 00 00 b8 a6 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 01 c3 48 c7 c2 a8 ff ff ff f7 d8 64 89 02 b8
RSP: 002b:00007ffd1655d728 EFLAGS: 00000246 ORIG_RAX: 00000000000000a6
RAX: 0000000000000000 RBX: 00007fbf79210925 RCX: 00007fbf7918fc57
RDX: 0000000000000000 RSI: 0000000000000009 RDI: 00007ffd1655d7e0
RBP: 00007ffd1655d7e0 R08: 0000000000000000 R09: 0000000000000000
R10: 00000000ffffffff R11: 0000000000000246 R12: 00007ffd1655e870
R13: 00007fbf79210925 R14: 000000000003da37 R15: 00007ffd1655e8b0