INFO: task kworker/u4:2:41 blocked for more than 143 seconds.
Not tainted 6.3.0-rc4-syzkaller-00195-g5a57b48fdfcb #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/u4:2 state:D stack:19992 pid:41 ppid:2 flags:0x00004000
Workqueue: events_unbound btrfs_async_reclaim_metadata_space
Call Trace:
context_switch kernel/sched/core.c:5307 [inline]
__schedule+0x173b/0x4630 kernel/sched/core.c:6625
schedule+0xc3/0x180 kernel/sched/core.c:6701
schedule_timeout+0xb0/0x310 kernel/time/timer.c:2143
do_wait_for_common+0x449/0x5f0 kernel/sched/completion.c:85
__wait_for_common kernel/sched/completion.c:106 [inline]
wait_for_common kernel/sched/completion.c:117 [inline]
wait_for_completion+0x4a/0x60 kernel/sched/completion.c:138
btrfs_wait_ordered_extents+0xd69/0xe20 fs/btrfs/ordered-data.c:674
btrfs_wait_ordered_roots+0x65c/0x950 fs/btrfs/ordered-data.c:704
shrink_delalloc fs/btrfs/space-info.c:654 [inline]
flush_space+0x821/0xe30 fs/btrfs/space-info.c:719
btrfs_async_reclaim_metadata_space+0x29f/0x350 fs/btrfs/space-info.c:1066
process_one_work+0x8a0/0x10e0 kernel/workqueue.c:2390
worker_thread+0xa63/0x1210 kernel/workqueue.c:2537
kthread+0x270/0x300 kernel/kthread.c:376
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:308
INFO: task kworker/u4:13:12552 blocked for more than 143 seconds.
Not tainted 6.3.0-rc4-syzkaller-00195-g5a57b48fdfcb #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/u4:13 state:D stack:21312 pid:12552 ppid:2 flags:0x00004000
Workqueue: btrfs-flush_delalloc btrfs_work_helper
Call Trace:
context_switch kernel/sched/core.c:5307 [inline]
__schedule+0x173b/0x4630 kernel/sched/core.c:6625
schedule+0xc3/0x180 kernel/sched/core.c:6701
wait_on_state fs/btrfs/extent-io-tree.c:707 [inline]
wait_extent_bit+0x50c/0x670 fs/btrfs/extent-io-tree.c:751
lock_extent+0x1ce/0x280 fs/btrfs/extent-io-tree.c:1742
find_lock_delalloc_range+0x4c9/0x9a0 fs/btrfs/extent_io.c:487
writepage_delalloc+0x1f1/0x590 fs/btrfs/extent_io.c:1417
__extent_writepage+0x850/0x16d0 fs/btrfs/extent_io.c:1724
extent_write_cache_pages fs/btrfs/extent_io.c:2635 [inline]
extent_writepages+0xc31/0x1930 fs/btrfs/extent_io.c:2755
do_writepages+0x3a6/0x670 mm/page-writeback.c:2551
filemap_fdatawrite_wbc+0x125/0x180 mm/filemap.c:390
__filemap_fdatawrite_range mm/filemap.c:423 [inline]
filemap_fdatawrite_range+0x16e/0x1e0 mm/filemap.c:441
btrfs_start_ordered_extent+0x26e/0x5f0 fs/btrfs/ordered-data.c:745
btrfs_run_ordered_extent_work+0x19/0x30 fs/btrfs/ordered-data.c:619
btrfs_work_helper+0x380/0xbe0 fs/btrfs/async-thread.c:280
process_one_work+0x8a0/0x10e0 kernel/workqueue.c:2390
worker_thread+0xa63/0x1210 kernel/workqueue.c:2537
kthread+0x270/0x300 kernel/kthread.c:376
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:308
INFO: task syz-executor.5:16009 blocked for more than 144 seconds.
Not tainted 6.3.0-rc4-syzkaller-00195-g5a57b48fdfcb #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.5 state:D stack:21768 pid:16009 ppid:5125 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:5307 [inline]
__schedule+0x173b/0x4630 kernel/sched/core.c:6625
schedule+0xc3/0x180 kernel/sched/core.c:6701
schedule_preempt_disabled+0x13/0x20 kernel/sched/core.c:6760
rwsem_down_write_slowpath+0xedd/0x13a0 kernel/locking/rwsem.c:1178
__down_write_common+0x1aa/0x200 kernel/locking/rwsem.c:1306
inode_lock include/linux/fs.h:758 [inline]
btrfs_inode_lock+0x4d/0xd0 fs/btrfs/inode.c:177
btrfs_sync_file+0x43e/0x10b0 fs/btrfs/file.c:1817
generic_write_sync include/linux/fs.h:2452 [inline]
btrfs_do_write_iter+0xccc/0x1270 fs/btrfs/file.c:1684
do_iter_write+0x6ea/0xc50 fs/read_write.c:861
iter_file_splice_write+0x843/0xfe0 fs/splice.c:778
do_splice_from fs/splice.c:856 [inline]
direct_splice_actor+0xe7/0x1c0 fs/splice.c:1022
splice_direct_to_actor+0x4c4/0xbd0 fs/splice.c:977
do_splice_direct+0x283/0x3d0 fs/splice.c:1065
do_sendfile+0x620/0xff0 fs/read_write.c:1255
__do_sys_sendfile64 fs/read_write.c:1323 [inline]
__se_sys_sendfile64+0x17c/0x1e0 fs/read_write.c:1309
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x41/0xc0 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x63/0xcd
RIP: 0033:0x7f6a96a8c0f9
RSP: 002b:00007f6a955fe168 EFLAGS: 00000246 ORIG_RAX: 0000000000000028
RAX: ffffffffffffffda RBX: 00007f6a96babf80 RCX: 00007f6a96a8c0f9
RDX: 0000000000000000 RSI: 0000000000000007 RDI: 0000000000000006
RBP: 00007f6a96ae7b39 R08: 0000000000000000 R09: 0000000000000000
R10: 0001000000201005 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffda4e3607f R14: 00007f6a955fe300 R15: 0000000000022000
INFO: task syz-executor.5:16080 blocked for more than 144 seconds.
Not tainted 6.3.0-rc4-syzkaller-00195-g5a57b48fdfcb #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.5 state:D stack:22336 pid:16080 ppid:5125 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:5307 [inline]
__schedule+0x173b/0x4630 kernel/sched/core.c:6625
schedule+0xc3/0x180 kernel/sched/core.c:6701
io_schedule+0x8c/0x100 kernel/sched/core.c:8887
folio_wait_bit_common+0x86c/0x12b0 mm/filemap.c:1301
lock_page include/linux/pagemap.h:973 [inline]
set_page_dirty_lock+0xfd/0x2d0 mm/page-writeback.c:2861
bio_set_pages_dirty+0x1f7/0x2c0 block/bio.c:1480
iomap_dio_bio_iter+0xb7f/0x1440 fs/iomap/direct-io.c:341
__iomap_dio_rw+0x121a/0x20d0 fs/iomap/direct-io.c:595
iomap_dio_rw+0x46/0xa0 fs/iomap/direct-io.c:683
btrfs_dio_read+0xbc/0x110 fs/btrfs/inode.c:7794
btrfs_direct_read fs/btrfs/file.c:3772 [inline]
btrfs_file_read_iter+0x39d/0x6b0 fs/btrfs/file.c:3811
do_iter_read+0x71a/0xc70 fs/read_write.c:796
vfs_readv fs/read_write.c:916 [inline]
do_preadv+0x212/0x350 fs/read_write.c:1008
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x41/0xc0 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x63/0xcd
RIP: 0033:0x7f6a96a8c0f9
RSP: 002b:00007f6a8e1dd168 EFLAGS: 00000246 ORIG_RAX: 0000000000000147
RAX: ffffffffffffffda RBX: 00007f6a96bac050 RCX: 00007f6a96a8c0f9
RDX: 0000000000000001 RSI: 0000000020000100 RDI: 0000000000000005
RBP: 00007f6a96ae7b39 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffda4e3607f R14: 00007f6a8e1dd300 R15: 0000000000022000
INFO: task syz-executor.5:16081 blocked for more than 144 seconds.
Not tainted 6.3.0-rc4-syzkaller-00195-g5a57b48fdfcb #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.5 state:D stack:24104 pid:16081 ppid:5125 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:5307 [inline]
__schedule+0x173b/0x4630 kernel/sched/core.c:6625
schedule+0xc3/0x180 kernel/sched/core.c:6701
schedule_preempt_disabled+0x13/0x20 kernel/sched/core.c:6760
rwsem_down_write_slowpath+0xedd/0x13a0 kernel/locking/rwsem.c:1178
__down_write_common+0x1aa/0x200 kernel/locking/rwsem.c:1306
inode_lock include/linux/fs.h:758 [inline]
process_measurement+0x435/0x1ce0 security/integrity/ima/ima_main.c:243
ima_file_check+0xf1/0x170 security/integrity/ima/ima_main.c:539
do_open fs/namei.c:3562 [inline]
path_openat+0x280a/0x3170 fs/namei.c:3715
do_filp_open+0x234/0x490 fs/namei.c:3742
do_sys_openat2+0x13f/0x500 fs/open.c:1348
do_sys_open fs/open.c:1364 [inline]
__do_sys_creat fs/open.c:1440 [inline]
__se_sys_creat fs/open.c:1434 [inline]
__x64_sys_creat+0x123/0x160 fs/open.c:1434
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x41/0xc0 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x63/0xcd
RIP: 0033:0x7f6a96a8c0f9
RSP: 002b:00007f6a8e1bc168 EFLAGS: 00000246 ORIG_RAX: 0000000000000055
RAX: ffffffffffffffda RBX: 00007f6a96bac120 RCX: 00007f6a96a8c0f9
RDX: 0000000000000000 RSI: 0000000000000002 RDI: 0000000020000080
RBP: 00007f6a96ae7b39 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffda4e3607f R14: 00007f6a8e1bc300 R15: 0000000000022000
INFO: task syz-executor.5:16082 blocked for more than 145 seconds.
Not tainted 6.3.0-rc4-syzkaller-00195-g5a57b48fdfcb #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.5 state:D stack:20856 pid:16082 ppid:5125 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:5307 [inline]
__schedule+0x173b/0x4630 kernel/sched/core.c:6625
schedule+0xc3/0x180 kernel/sched/core.c:6701
schedule_preempt_disabled+0x13/0x20 kernel/sched/core.c:6760
rwsem_down_write_slowpath+0xedd/0x13a0 kernel/locking/rwsem.c:1178
__down_write_common+0x1aa/0x200 kernel/locking/rwsem.c:1306
inode_lock include/linux/fs.h:758 [inline]
btrfs_inode_lock+0x4d/0xd0 fs/btrfs/inode.c:177
btrfs_sync_file+0x43e/0x10b0 fs/btrfs/file.c:1817
generic_write_sync include/linux/fs.h:2452 [inline]
btrfs_do_write_iter+0xccc/0x1270 fs/btrfs/file.c:1684
do_iter_write+0x6ea/0xc50 fs/read_write.c:861
iter_file_splice_write+0x843/0xfe0 fs/splice.c:778
do_splice_from fs/splice.c:856 [inline]
direct_splice_actor+0xe7/0x1c0 fs/splice.c:1022
splice_direct_to_actor+0x4c4/0xbd0 fs/splice.c:977
do_splice_direct+0x283/0x3d0 fs/splice.c:1065
do_sendfile+0x620/0xff0 fs/read_write.c:1255
__do_sys_sendfile64 fs/read_write.c:1323 [inline]
__se_sys_sendfile64+0x17c/0x1e0 fs/read_write.c:1309
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x41/0xc0 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x63/0xcd
RIP: 0033:0x7f6a96a8c0f9
RSP: 002b:00007f6a8df9b168 EFLAGS: 00000246 ORIG_RAX: 0000000000000028
RAX: ffffffffffffffda RBX: 00007f6a96bac1f0 RCX: 00007f6a96a8c0f9
RDX: 0000000000000000 RSI: 000000000000000b RDI: 000000000000000a
RBP: 00007f6a96ae7b39 R08: 0000000000000000 R09: 0000000000000000
R10: 0001000000201005 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffda4e3607f R14: 00007f6a8df9b300 R15: 0000000000022000
Showing all locks held in the system:
1 lock held by rcu_tasks_kthre/12:
#0: ffffffff8cf255b0 (rcu_tasks.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x29/0xd20 kernel/rcu/tasks.h:510
1 lock held by rcu_tasks_trace/13:
#0: ffffffff8cf25db0 (rcu_tasks_trace.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x29/0xd20 kernel/rcu/tasks.h:510
1 lock held by khungtaskd/28:
#0: ffffffff8cf253e0 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire+0x0/0x30
4 locks held by kworker/u4:2/41:
#0: ffff888012479138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: process_one_work+0x77e/0x10e0 kernel/workqueue.c:2363
#1: ffffc90000b27d20 ((work_completion)(&fs_info->async_reclaim_work)){+.+.}-{0:0}, at: process_one_work+0x7c8/0x10e0 kernel/workqueue.c:2365
#2: ffff8880286b4a20 (&fs_info->ordered_operations_mutex){+.+.}-{3:3}, at: btrfs_wait_ordered_roots+0x104/0x950 fs/btrfs/ordered-data.c:692
#3: ffff8880797d8850 (&root->ordered_extent_mutex){+.+.}-{3:3}, at: btrfs_wait_ordered_extents+0x1f3/0xe20 fs/btrfs/ordered-data.c:638
2 locks held by getty/4750:
#0: ffff888028749098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x25/0x70 drivers/tty/tty_ldisc.c:244
#1: ffffc900015a02f0 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0x6ab/0x1db0 drivers/tty/n_tty.c:2177
2 locks held by kworker/u4:11/12178:
2 locks held by kworker/u4:13/12552:
#0: ffff88801ced1138 ((wq_completion)btrfs-flush_delalloc){+.+.}-{0:0}, at: process_one_work+0x77e/0x10e0 kernel/workqueue.c:2363
#1: ffffc90016b57d20 ((work_completion)(&work->normal_work)){+.+.}-{0:0}, at: process_one_work+0x7c8/0x10e0 kernel/workqueue.c:2365
3 locks held by kworker/u4:16/14896:
#0: ffff888017784138 ((wq_completion)writeback){+.+.}-{0:0}, at: process_one_work+0x77e/0x10e0 kernel/workqueue.c:2363
#1: ffffc90015877d20 ((work_completion)(&(&wb->dwork)->work)){+.+.}-{0:0}, at: process_one_work+0x7c8/0x10e0 kernel/workqueue.c:2365
#2: ffff88801cc440e0 (&type->s_umount_key#49){++++}-{3:3}, at: trylock_super+0x1f/0xf0 fs/super.c:414
2 locks held by syz-executor.5/16009:
#0: ffff88801cc44460 (sb_writers#13){.+.+}-{0:0}, at: do_sendfile+0x5fb/0xff0 fs/read_write.c:1254
#1: ffff8880333bb450 (&sb->s_type->i_mutex_key#20){++++}-{3:3}, at: inode_lock include/linux/fs.h:758 [inline]
#1: ffff8880333bb450 (&sb->s_type->i_mutex_key#20){++++}-{3:3}, at: btrfs_inode_lock+0x4d/0xd0 fs/btrfs/inode.c:177
1 lock held by syz-executor.5/16080:
#0: ffff8880333bb450 (&sb->s_type->i_mutex_key#20){++++}-{3:3}, at: inode_lock_shared include/linux/fs.h:768 [inline]
#0: ffff8880333bb450 (&sb->s_type->i_mutex_key#20){++++}-{3:3}, at: btrfs_inode_lock+0x60/0xd0 fs/btrfs/inode.c:169
2 locks held by syz-executor.5/16081:
#0: ffff88801cc44460 (sb_writers#13){.+.+}-{0:0}, at: mnt_want_write+0x3f/0x90 fs/namespace.c:394
#1: ffff8880333bb450 (&sb->s_type->i_mutex_key#20){++++}-{3:3}, at: inode_lock include/linux/fs.h:758 [inline]
#1: ffff8880333bb450 (&sb->s_type->i_mutex_key#20){++++}-{3:3}, at: process_measurement+0x435/0x1ce0 security/integrity/ima/ima_main.c:243
2 locks held by syz-executor.5/16082:
#0: ffff88801cc44460 (sb_writers#13){.+.+}-{0:0}, at: do_sendfile+0x5fb/0xff0 fs/read_write.c:1254
#1: ffff8880333bb450 (&sb->s_type->i_mutex_key#20){++++}-{3:3}, at: inode_lock include/linux/fs.h:758 [inline]
#1: ffff8880333bb450 (&sb->s_type->i_mutex_key#20){++++}-{3:3}, at: btrfs_inode_lock+0x4d/0xd0 fs/btrfs/inode.c:177
2 locks held by syz-executor.3/17456:
#0: ffff88801cc440e0 (&type->s_umount_key#49){++++}-{3:3}, at: iterate_supers+0xb0/0x1e0 fs/super.c:743
#1: ffff88801cc427d0 (&bdi->wb_switch_rwsem){+.+.}-{3:3}, at: bdi_down_write_wb_switch_rwsem fs/fs-writeback.c:364 [inline]
#1: ffff88801cc427d0 (&bdi->wb_switch_rwsem){+.+.}-{3:3}, at: sync_inodes_sb+0x278/0xab0 fs/fs-writeback.c:2725
2 locks held by syz-executor.3/17457:
#0: ffff88801cc440e0 (&type->s_umount_key#49){++++}-{3:3}, at: iterate_supers+0xb0/0x1e0 fs/super.c:743
#1: ffff88801cc427d0 (&bdi->wb_switch_rwsem){+.+.}-{3:3}, at: bdi_down_write_wb_switch_rwsem fs/fs-writeback.c:364 [inline]
#1: ffff88801cc427d0 (&bdi->wb_switch_rwsem){+.+.}-{3:3}, at: sync_inodes_sb+0x278/0xab0 fs/fs-writeback.c:2725
=============================================
NMI backtrace for cpu 0
CPU: 0 PID: 28 Comm: khungtaskd Not tainted 6.3.0-rc4-syzkaller-00195-g5a57b48fdfcb #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 03/02/2023
Call Trace:
__dump_stack lib/dump_stack.c:88 [inline]
dump_stack_lvl+0x1e7/0x2d0 lib/dump_stack.c:106
nmi_cpu_backtrace+0x498/0x4d0 lib/nmi_backtrace.c:113
nmi_trigger_cpumask_backtrace+0x187/0x300 lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:148 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:222 [inline]
watchdog+0xec2/0xf00 kernel/hung_task.c:379
kthread+0x270/0x300 kernel/kthread.c:376
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:308
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 56 Comm: kworker/u4:4 Not tainted 6.3.0-rc4-syzkaller-00195-g5a57b48fdfcb #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 03/02/2023
Workqueue: phy4 ieee80211_iface_work
RIP: 0010:ieee80211_bss_info_update+0x37b/0xf00 net/mac80211/scan.c:170
Code: e8 03 42 0f b6 04 28 84 c0 0f 85 a9 09 00 00 0f b6 1b c1 eb 03 83 e3 0f 48 89 df 48 c7 c6 30 a4 2e 8e e8 98 4a 6f f7 80 fb 02 <4d> 89 f5 74 19 83 fb 01 4c 8d b4 24 60 01 00 00 75 3e e8 be 45 6f
RSP: 0018:ffffc900015776e0 EFLAGS: 00000293
RAX: 0000000000000000 RBX: 0000000000000000 RCX: dffffc0000000000
RDX: 0000000000000002 RSI: ffffffff8e2ea430 RDI: 0000000000000000
RBP: ffffc900015778f0 R08: 0000000000000001 R09: ffffffff8a1b0ca8
R10: 0000000000000002 R11: ffff888018710000 R12: ffff88801d2dda28
R13: dffffc0000000000 R14: ffff8880869a6a50 R15: 1ffff920002aef09
FS: 0000000000000000(0000) GS:ffff8880b9900000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 000000c015fbeda0 CR3: 000000000cd30000 CR4: 00000000003506e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
ieee80211_rx_bss_info net/mac80211/ibss.c:1120 [inline]
ieee80211_rx_mgmt_probe_beacon net/mac80211/ibss.c:1609 [inline]
ieee80211_ibss_rx_queued_mgmt+0x192f/0x2cf0 net/mac80211/ibss.c:1638
ieee80211_iface_process_skb net/mac80211/iface.c:1583 [inline]
ieee80211_iface_work+0x7bd/0xd00 net/mac80211/iface.c:1637
process_one_work+0x8a0/0x10e0 kernel/workqueue.c:2390
worker_thread+0xa63/0x1210 kernel/workqueue.c:2537
kthread+0x270/0x300 kernel/kthread.c:376
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:308