INFO: task syz.3.50:5976 blocked for more than 143 seconds.
Not tainted 6.10.0-syzkaller-02711-g0434dbe32053 #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz.3.50 state:D stack:14520 pid:5976 tgid:5940 ppid:5597 flags:0x00000004
Call Trace:
context_switch kernel/sched/core.c:5188 [inline]
__schedule+0x17ae/0x4a10 kernel/sched/core.c:6529
__schedule_loop kernel/sched/core.c:6606 [inline]
schedule+0x14b/0x320 kernel/sched/core.c:6621
schedule_preempt_disabled+0x13/0x30 kernel/sched/core.c:6678
rwsem_down_write_slowpath+0xeeb/0x13b0 kernel/locking/rwsem.c:1178
__down_write_common kernel/locking/rwsem.c:1306 [inline]
__down_write kernel/locking/rwsem.c:1315 [inline]
down_write+0x1d7/0x220 kernel/locking/rwsem.c:1580
inode_lock include/linux/fs.h:799 [inline]
bch2_fallocate_dispatch+0x295/0x3810 fs/bcachefs/fs-io.c:774
vfs_fallocate+0x553/0x6c0 fs/open.c:334
ksys_fallocate fs/open.c:357 [inline]
__do_sys_fallocate fs/open.c:365 [inline]
__se_sys_fallocate fs/open.c:363 [inline]
__x64_sys_fallocate+0xbd/0x110 fs/open.c:363
do_syscall_x64 arch/x86/entry/common.c:52 [inline]
do_syscall_64+0xf3/0x230 arch/x86/entry/common.c:83
entry_SYSCALL_64_after_hwframe+0x77/0x7f
RIP: 0033:0x7febe4375a19
RSP: 002b:00007febe5073048 EFLAGS: 00000246 ORIG_RAX: 000000000000011d
RAX: ffffffffffffffda RBX: 00007febe4504038 RCX: 00007febe4375a19
RDX: 0000000000000000 RSI: 0000000000000008 RDI: 0000000000000005
RBP: 00007febe43e4e49 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000001000 R11: 0000000000000246 R12: 0000000000000000
R13: 000000000000006e R14: 00007febe4504038 R15: 00007ffc0f93f498
INFO: task syz.3.50:5985 blocked for more than 144 seconds.
Not tainted 6.10.0-syzkaller-02711-g0434dbe32053 #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz.3.50 state:D stack:26392 pid:5985 tgid:5940 ppid:5597 flags:0x00000004
Call Trace:
context_switch kernel/sched/core.c:5188 [inline]
__schedule+0x17ae/0x4a10 kernel/sched/core.c:6529
__schedule_loop kernel/sched/core.c:6606 [inline]
schedule+0x14b/0x320 kernel/sched/core.c:6621
schedule_preempt_disabled+0x13/0x30 kernel/sched/core.c:6678
rwsem_down_write_slowpath+0xeeb/0x13b0 kernel/locking/rwsem.c:1178
__down_write_common kernel/locking/rwsem.c:1306 [inline]
__down_write kernel/locking/rwsem.c:1315 [inline]
down_write+0x1d7/0x220 kernel/locking/rwsem.c:1580
inode_lock include/linux/fs.h:799 [inline]
process_measurement+0x43c/0x1fb0 security/integrity/ima/ima_main.c:250
ima_file_check+0xf2/0x170 security/integrity/ima/ima_main.c:572
security_file_post_open+0x6d/0xa0 security/security.c:3008
do_open fs/namei.c:3729 [inline]
path_openat+0x2b91/0x3470 fs/namei.c:3886
do_filp_open+0x235/0x490 fs/namei.c:3913
do_sys_openat2+0x13e/0x1d0 fs/open.c:1416
do_sys_open fs/open.c:1431 [inline]
__do_sys_open fs/open.c:1439 [inline]
__se_sys_open fs/open.c:1435 [inline]
__x64_sys_open+0x225/0x270 fs/open.c:1435
do_syscall_x64 arch/x86/entry/common.c:52 [inline]
do_syscall_64+0xf3/0x230 arch/x86/entry/common.c:83
entry_SYSCALL_64_after_hwframe+0x77/0x7f
RIP: 0033:0x7febe4375a19
RSP: 002b:00007febe3dff048 EFLAGS: 00000246 ORIG_RAX: 0000000000000002
RAX: ffffffffffffffda RBX: 00007febe4504110 RCX: 00007febe4375a19
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000020000000
RBP: 00007febe43e4e49 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 000000000000006e R14: 00007febe4504110 R15: 00007ffc0f93f498
Showing all locks held in the system:
1 lock held by khungtaskd/30:
#0: ffffffff8e335fe0 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire include/linux/rcupdate.h:327 [inline]
#0: ffffffff8e335fe0 (rcu_read_lock){....}-{1:2}, at: rcu_read_lock include/linux/rcupdate.h:839 [inline]
#0: ffffffff8e335fe0 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x55/0x2a0 kernel/locking/lockdep.c:6613
2 locks held by kworker/u8:4/63:
2 locks held by kworker/u8:6/2414:
#0: ffff8880b943e718 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock_nested+0x2a/0x140 kernel/sched/core.c:560
#1: ffff8880b9428948 (&per_cpu_ptr(group->pcpu, cpu)->seq){-.-.}-{0:0}, at: psi_task_switch+0x441/0x770 kernel/sched/psi.c:989
2 locks held by getty/4843:
#0: ffff88802b1750a0 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x25/0x70 drivers/tty/tty_ldisc.c:243
#1: ffffc900031332f0 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0x6b5/0x1e10 drivers/tty/n_tty.c:2211
3 locks held by syz.3.50/5941:
#0: ffff88807c98aac8 (&f->f_pos_lock){+.+.}-{3:3}, at: __fdget_pos+0x24e/0x310 fs/file.c:1191
#1: ffff888064eba420 (sb_writers#25){.+.+}-{0:0}, at: file_start_write include/linux/fs.h:2876 [inline]
#1: ffff888064eba420 (sb_writers#25){.+.+}-{0:0}, at: vfs_write+0x227/0xc90 fs/read_write.c:586
#2: ffff88807a989008 (&sb->s_type->i_mutex_key#32){+.+.}-{3:3}, at: inode_lock include/linux/fs.h:799 [inline]
#2: ffff88807a989008 (&sb->s_type->i_mutex_key#32){+.+.}-{3:3}, at: bch2_direct_write+0x243/0x3050 fs/bcachefs/fs-io-direct.c:598
2 locks held by syz.3.50/5976:
#0: ffff888064eba420 (sb_writers#25){.+.+}-{0:0}, at: file_start_write include/linux/fs.h:2876 [inline]
#0: ffff888064eba420 (sb_writers#25){.+.+}-{0:0}, at: vfs_fallocate+0x4ea/0x6c0 fs/open.c:333
#1: ffff88807a989008 (&sb->s_type->i_mutex_key#32){+.+.}-{3:3}, at: inode_lock include/linux/fs.h:799 [inline]
#1: ffff88807a989008 (&sb->s_type->i_mutex_key#32){+.+.}-{3:3}, at: bch2_fallocate_dispatch+0x295/0x3810 fs/bcachefs/fs-io.c:774
1 lock held by syz.3.50/5985:
#0: ffff88807a989008 (&sb->s_type->i_mutex_key#32){+.+.}-{3:3}, at: inode_lock include/linux/fs.h:799 [inline]
#0: ffff88807a989008 (&sb->s_type->i_mutex_key#32){+.+.}-{3:3}, at: process_measurement+0x43c/0x1fb0 security/integrity/ima/ima_main.c:250
2 locks held by bch-copygc/loop/5969:
1 lock held by syz-executor/7096:
#0: ffffffff8e33b3b8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: exp_funnel_lock kernel/rcu/tree_exp.h:328 [inline]
#0: ffffffff8e33b3b8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: synchronize_rcu_expedited+0x451/0x830 kernel/rcu/tree_exp.h:958
2 locks held by syz.4.247/7764:
#0: ffff88807848e0e0 (&type->s_umount_key#61/1){+.+.}-{3:3}, at: alloc_super+0x221/0x9d0 fs/super.c:344
#1: ffff8880b943e718 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock_nested+0x2a/0x140 kernel/sched/core.c:560
=============================================
NMI backtrace for cpu 0
CPU: 0 PID: 30 Comm: khungtaskd Not tainted 6.10.0-syzkaller-02711-g0434dbe32053 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 06/07/2024
Call Trace:
__dump_stack lib/dump_stack.c:88 [inline]
dump_stack_lvl+0x241/0x360 lib/dump_stack.c:114
nmi_cpu_backtrace+0x49c/0x4d0 lib/nmi_backtrace.c:113
nmi_trigger_cpumask_backtrace+0x198/0x320 lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:162 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:223 [inline]
watchdog+0xfde/0x1020 kernel/hung_task.c:379
kthread+0x2f0/0x390 kernel/kthread.c:389
ret_from_fork+0x4b/0x80 arch/x86/kernel/process.c:147
ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:244
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 2414 Comm: kworker/u8:6 Not tainted 6.10.0-syzkaller-02711-g0434dbe32053 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 06/07/2024
Workqueue: writeback wb_workfn (flush-btrfs-29)
RIP: 0010:io_serial_in+0x6f/0xb0 drivers/tty/serial/8250/8250_port.c:406
Code: fc 83 fd 1f 77 4c e8 70 5f 62 fc 89 e9 41 d3 e6 48 83 c3 40 48 89 d8 48 c1 e8 03 42 80 3c 38 00 74 08 48 89 df e8 41 e5 c4 fc <44> 03 33 44 89 f2 ec 0f b6 c0 5b 41 5e 41 5f 5d c3 cc cc cc cc 89
RSP: 0018:ffffc900094062f8 EFLAGS: 00000046
RAX: 1ffffffff29551bc RBX: ffffffff94aa8de0 RCX: 0000000000000000
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000020
RBP: 0000000000000000 R08: ffffffff8533fca6 R09: 1ffff11003f69046
R10: dffffc0000000000 R11: ffffffff8533fc60 R12: dffffc0000000000
R13: 0000000000002700 R14: 0000000000000005 R15: dffffc0000000000
FS: 0000000000000000(0000) GS:ffff8880b9500000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000555593063648 CR3: 000000000e134000 CR4: 00000000003506f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
serial_in drivers/tty/serial/8250/8250.h:117 [inline]
serial_lsr_in drivers/tty/serial/8250/8250.h:139 [inline]
wait_for_lsr drivers/tty/serial/8250/8250_port.c:2068 [inline]
serial8250_console_fifo_write drivers/tty/serial/8250/8250_port.c:3315 [inline]
serial8250_console_write+0x1099/0x1770 drivers/tty/serial/8250/8250_port.c:3393
console_emit_next_record kernel/printk/printk.c:2913 [inline]
console_flush_all+0x865/0xfd0 kernel/printk/printk.c:2979
console_unlock+0x13b/0x4d0 kernel/printk/printk.c:3048
vprintk_emit+0x5a6/0x770 kernel/printk/printk.c:2348
_printk+0xd5/0x120 kernel/printk/printk.c:2373
_btrfs_printk+0x59c/0x5c0 fs/btrfs/messages.c:246
btrfs_dev_stat_inc_and_print+0x45f/0x530 fs/btrfs/volumes.c:7873
btrfs_simple_end_io+0x1c8/0x4d0 fs/btrfs/bio.c:375
btrfs_submit_chunk fs/btrfs/bio.c:753 [inline]
btrfs_submit_bio+0x11ad/0x1920 fs/btrfs/bio.c:772
submit_eb_page fs/btrfs/extent_io.c:1930 [inline]
btree_write_cache_pages+0x1200/0x1b10 fs/btrfs/extent_io.c:1980
do_writepages+0x359/0x870 mm/page-writeback.c:2656
__writeback_single_inode+0x165/0x10b0 fs/fs-writeback.c:1651
writeback_sb_inodes+0x99c/0x1380 fs/fs-writeback.c:1947
wb_writeback+0x481/0xd40 fs/fs-writeback.c:2127
wb_do_writeback fs/fs-writeback.c:2274 [inline]
wb_workfn+0x410/0x1090 fs/fs-writeback.c:2314
process_one_work kernel/workqueue.c:3231 [inline]
process_scheduled_works+0xa2c/0x1830 kernel/workqueue.c:3312
worker_thread+0x86d/0xd40 kernel/workqueue.c:3390
kthread+0x2f0/0x390 kernel/kthread.c:389
ret_from_fork+0x4b/0x80 arch/x86/kernel/process.c:147
ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:244