INFO: task kworker/1:1H:52 blocked for more than 143 seconds.
Not tainted 6.3.0-syzkaller-10197-g91ec4b0d11fe #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/1:1H state:D stack:25712 pid:52 ppid:2 flags:0x00004000
Workqueue: xfs-log/loop3 xlog_ioend_work
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
___down_common+0x33e/0x5e0 kernel/locking/semaphore.c:225
__down_common+0x64/0x250 kernel/locking/semaphore.c:246
down+0x84/0xc0 kernel/locking/semaphore.c:63
xfs_buf_lock+0x154/0x4b0 fs/xfs/xfs_buf.c:1120
xfs_buf_item_unpin+0x200/0x720 fs/xfs/xfs_buf_item.c:547
xfs_trans_committed_bulk+0x346/0x830 fs/xfs/xfs_trans.c:806
xlog_cil_committed+0x26d/0xe40 fs/xfs/xfs_log_cil.c:795
xlog_cil_process_committed+0x159/0x1a0 fs/xfs/xfs_log_cil.c:823
xlog_state_shutdown_callbacks+0x2ba/0x3b0 fs/xfs/xfs_log.c:538
xlog_force_shutdown+0x32c/0x390 fs/xfs/xfs_log.c:3837
xlog_ioend_work+0xad/0x100 fs/xfs/xfs_log.c:1429
process_one_work+0x8a0/0x10e0 kernel/workqueue.c:2390
worker_thread+0xa63/0x1210 kernel/workqueue.c:2537
kthread+0x2b2/0x350 kernel/kthread.c:379
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:308
INFO: task syz-executor.3:16405 blocked for more than 143 seconds.
Not tainted 6.3.0-syzkaller-10197-g91ec4b0d11fe #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.3 state:D stack:19288 pid:16405 ppid:5012 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_timeout+0xb0/0x310 kernel/time/timer.c:2143
___down_common+0x33e/0x5e0 kernel/locking/semaphore.c:225
__down_common+0x64/0x250 kernel/locking/semaphore.c:246
down+0x84/0xc0 kernel/locking/semaphore.c:63
xfs_buf_lock+0x154/0x4b0 fs/xfs/xfs_buf.c:1120
xfs_trans_getsb+0x89/0x4d0 fs/xfs/xfs_trans_buf.c:190
xfs_trans_apply_sb_deltas+0x28/0x950 fs/xfs/xfs_trans.c:479
__xfs_trans_commit+0x97f/0xff0 fs/xfs/xfs_trans.c:1002
xfs_iomap_write_direct+0x553/0x810 fs/xfs/xfs_iomap.c:316
xfs_direct_write_iomap_begin+0x1021/0x1670 fs/xfs/xfs_iomap.c:888
iomap_iter+0x677/0xec0 fs/iomap/iter.c:91
__iomap_dio_rw+0xd74/0x20d0 fs/iomap/direct-io.c:594
iomap_dio_rw+0x46/0xa0 fs/iomap/direct-io.c:683
xfs_file_dio_write_aligned+0x222/0x350 fs/xfs/xfs_file.c:543
xfs_file_dio_write fs/xfs/xfs_file.c:655 [inline]
xfs_file_write_iter+0x508/0x620 fs/xfs/xfs_file.c:797
do_iter_write+0x7b1/0xcb0 fs/read_write.c:860
iter_file_splice_write+0x843/0xfe0 fs/splice.c:779
do_splice_from fs/splice.c:857 [inline]
direct_splice_actor+0xe7/0x1c0 fs/splice.c:1023
splice_direct_to_actor+0x4c4/0xbd0 fs/splice.c:978
do_splice_direct+0x283/0x3d0 fs/splice.c:1066
do_sendfile+0x620/0xff0 fs/read_write.c:1254
__do_sys_sendfile64 fs/read_write.c:1322 [inline]
__se_sys_sendfile64+0x17c/0x1e0 fs/read_write.c:1308
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:0x7fc50a08c169
RSP: 002b:00007fc508bfe168 EFLAGS: 00000246 ORIG_RAX: 0000000000000028
RAX: ffffffffffffffda RBX: 00007fc50a1abf80 RCX: 00007fc50a08c169
RDX: 0000000000000000 RSI: 0000000000000005 RDI: 0000000000000004
RBP: 00007fc50a0e7ca1 R08: 0000000000000000 R09: 0000000000000000
R10: 0001000000201005 R11: 0000000000000246 R12: 0000000000000000
R13: 00007fff6eedea1f R14: 00007fc508bfe300 R15: 0000000000022000
INFO: task syz-executor.3:16473 blocked for more than 145 seconds.
Not tainted 6.3.0-syzkaller-10197-g91ec4b0d11fe #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.3 state:D stack:22056 pid:16473 ppid:5012 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
xlog_wait+0x16e/0x1e0 fs/xfs/xfs_log_priv.h:617
xlog_wait_on_iclog+0x307/0x4e0 fs/xfs/xfs_log.c:926
xfs_log_force_seq+0x1da/0x450 fs/xfs/xfs_log.c:3409
__xfs_trans_commit+0xb4a/0xff0 fs/xfs/xfs_trans.c:1014
xfs_sync_sb_buf+0x14f/0x1e0 fs/xfs/libxfs/xfs_sb.c:1111
xfs_ioc_setlabel fs/xfs/xfs_ioctl.c:1801 [inline]
xfs_file_ioctl+0x1313/0x16a0 fs/xfs/xfs_ioctl.c:1899
vfs_ioctl fs/ioctl.c:51 [inline]
__do_sys_ioctl fs/ioctl.c:870 [inline]
__se_sys_ioctl+0xf1/0x160 fs/ioctl.c:856
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:0x7fc50a08c169
RSP: 002b:00007fc5027dd168 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 00007fc50a1ac050 RCX: 00007fc50a08c169
RDX: 0000000020000280 RSI: 0000000041009432 RDI: 0000000000000008
RBP: 00007fc50a0e7ca1 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007fff6eedea1f R14: 00007fc5027dd300 R15: 0000000000022000
Showing all locks held in the system:
1 lock held by rcu_tasks_kthre/13:
#0:
ffffffff8cf25370 (rcu_tasks.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x29/0xd20 kernel/rcu/tasks.h:518
1 lock held by rcu_tasks_trace/14:
#0: ffffffff8cf25730 (rcu_tasks_trace.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x29/0xd20 kernel/rcu/tasks.h:518
1 lock held by khungtaskd/28:
#0: ffffffff8cf251a0 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire+0x0/0x30
2 locks held by kworker/1:1H/52:
#0: ffff88806b36b538 ((wq_completion)xfs-log/loop3){+.+.}-{0:0}, at: process_one_work+0x77e/0x10e0 kernel/workqueue.c:2363
#1: ffffc90000bd7d20 ((work_completion)(&iclog->ic_end_io_work)){+.+.}-{0:0}, at: process_one_work+0x7c8/0x10e0 kernel/workqueue.c:2365
4 locks held by kworker/u4:4/56:
4 locks held by kworker/u4:6/1057:
2 locks held by getty/4732:
#0: ffff88814a6af098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x25/0x70 drivers/tty/tty_ldisc.c:243
#1: ffffc900015a02f0 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0x6ab/0x1db0 drivers/tty/n_tty.c:2176
1 lock held by syz-executor.0/5006:
#0: ffff8880234e60e0 (&type->s_umount_key#64){+.+.}-{3:3}, at: deactivate_super+0xad/0xf0 fs/super.c:361
2 locks held by syz-executor.4/5013:
#0: ffff8880792440e0 (&type->s_umount_key#50){++++}-{3:3}, at: deactivate_super+0xad/0xf0 fs/super.c:361
#1: ffffffff8cf2a878 (rcu_state.exp_mutex){+.+.}-{3:3}, at: exp_funnel_lock kernel/rcu/tree_exp.h:293 [inline]
#1: ffffffff8cf2a878 (rcu_state.exp_mutex){+.+.}-{3:3}, at: synchronize_rcu_expedited+0x3a3/0x890 kernel/rcu/tree_exp.h:992
1 lock held by syz-executor.5/5015:
2 locks held by kworker/1:22/6963:
#0: ffff888012472538 ((wq_completion)rcu_gp){+.+.}-{0:0}, at: process_one_work+0x77e/0x10e0 kernel/workqueue.c:2363
#1: ffffc90004de7d20 ((work_completion)(&rew->rew_work)){+.+.}-{0:0}, at: process_one_work+0x7c8/0x10e0 kernel/workqueue.c:2365
3 locks held by kworker/1:25/6966:
#0: ffff888012470d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x77e/0x10e0 kernel/workqueue.c:2363
#1: ffffc90004e27d20 ((work_completion)(&pwq->unbound_release_work)){+.+.}-{0:0}, at: process_one_work+0x7c8/0x10e0 kernel/workqueue.c:2365
#2: ffffffff8cf2a878 (rcu_state.exp_mutex){+.+.}-{3:3}, at: exp_funnel_lock kernel/rcu/tree_exp.h:325 [inline]
#2: ffffffff8cf2a878 (rcu_state.exp_mutex){+.+.}-{3:3}, at: synchronize_rcu_expedited+0x46c/0x890 kernel/rcu/tree_exp.h:992
2 locks held by kworker/u4:10/9265:
4 locks held by syz-executor.3/16405:
#0: ffff888026afa460 (sb_writers#13){.+.+}-{0:0}, at: do_sendfile+0x5fb/0xff0 fs/read_write.c:1253
#1: ffff888074258338 (&sb->s_type->i_mutex_key#21){++++}-{3:3}, at: xfs_ilock+0x10e/0x3a0 fs/xfs/xfs_inode.c:198
#2: ffff888026afa650 (sb_internal#2){.+.+}-{0:0}, at: xfs_trans_alloc_inode+0x12d/0x460 fs/xfs/xfs_trans.c:1191
#3: ffff888074258118 (&xfs_nondir_ilock_class#3){++++}-{3:3}, at: xfs_trans_alloc_inode+0x165/0x460 fs/xfs/xfs_trans.c:1197
1 lock held by syz-executor.3/16473:
#0: ffff888026afa460 (sb_writers#13){.+.+}-{0:0}, at: mnt_want_write_file+0x5e/0x1f0 fs/namespace.c:438
7 locks held by syz-executor.1/19382:
5 locks held by syz-executor.1/19432:
1 lock held by dhcpcd/19434:
#0: ffff888034928130 (sk_lock-AF_PACKET){+.+.}-{0:0}, at: lock_sock include/net/sock.h:1697 [inline]
#0: ffff888034928130 (sk_lock-AF_PACKET){+.+.}-{0:0}, at: packet_do_bind+0x28/0xbd0 net/packet/af_packet.c:3204
1 lock held by dhcpcd/19435:
#0: ffff888087420130 (sk_lock-AF_PACKET){+.+.}-{0:0}, at: lock_sock include/net/sock.h:1697 [inline]
#0: ffff888087420130 (sk_lock-AF_PACKET){+.+.}-{0:0}, at: packet_do_bind+0x28/0xbd0 net/packet/af_packet.c:3204
2 locks held by syz-executor.3/19439:
2 locks held by syz-executor.2/19441:
2 locks held by syz-executor.5/19443:
1 lock held by dhcpcd/19446:
#0: ffff888085436130 (sk_lock-AF_PACKET){+.+.}-{0:0}, at: lock_sock include/net/sock.h:1697 [inline]
#0: ffff888085436130 (sk_lock-AF_PACKET){+.+.}-{0:0}, at: packet_do_bind+0x28/0xbd0 net/packet/af_packet.c:3204
1 lock held by dhcpcd/19447:
#0: ffff888085432130 (sk_lock-AF_PACKET){+.+.}-{0:0}, at: lock_sock include/net/sock.h:1697 [inline]
#0: ffff888085432130 (sk_lock-AF_PACKET){+.+.}-{0:0}, at: packet_do_bind+0x28/0xbd0 net/packet/af_packet.c:3204
=============================================
NMI backtrace for cpu 0
CPU: 0 PID: 28 Comm: khungtaskd Not tainted 6.3.0-syzkaller-10197-g91ec4b0d11fe #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 04/14/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+0x2b2/0x350 kernel/kthread.c:379
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: 19439 Comm: syz-executor.3 Not tainted 6.3.0-syzkaller-10197-g91ec4b0d11fe #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 04/14/2023
RIP: 0010:constant_test_bit arch/x86/include/asm/bitops.h:207 [inline]
RIP: 0010:arch_test_bit arch/x86/include/asm/bitops.h:239 [inline]
RIP: 0010:_test_bit include/asm-generic/bitops/instrumented-non-atomic.h:142 [inline]
RIP: 0010:folio_test_head include/linux/page-flags.h:772 [inline]
RIP: 0010:folio_test_large include/linux/page-flags.h:793 [inline]
RIP: 0010:folio_mapped include/linux/mm.h:1031 [inline]
RIP: 0010:filemap_unaccount_folio+0xa2/0xc70 mm/filemap.c:155
Code: 48 b8 00 00 00 00 00 fc ff df 41 80 3c 04 00 74 08 4c 89 ef e8 9f b2 27 00 49 8b 6d 00 bb 00 00 01 00 be 00 00 01 00 48 21 ee <31> ff e8 27 e4 d0 ff 48 21 eb 0f 85 09 05 00 00 49 8d 6d 30 48 89
RSP: 0018:ffffc900189b7618 EFLAGS: 00000046
RAX: dffffc0000000000 RBX: 0000000000010000 RCX: ffffffff81ba3701
RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffffea000143fa40
RBP: 00fff00000080017 R08: dffffc0000000000 R09: fffff94000287f49
R10: 0000000000000000 R11: dffffc0000000001 R12: 1ffffd4000287f48
R13: ffffea000143fa40 R14: 1ffffd4000287f49 R15: ffffea000143fa48
FS: 00007f22157fe700(0000) GS:ffff8880b9900000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000557e18444000 CR3: 000000002bac8000 CR4: 00000000003506e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
__filemap_remove_folio+0xcb/0xab0 mm/filemap.c:224
filemap_remove_folio+0x109/0x2e0 mm/filemap.c:257
truncate_inode_folio+0x5d/0x70 mm/truncate.c:196
shmem_undo_range+0x442/0x1dd0 mm/shmem.c:942
shmem_truncate_range mm/shmem.c:1041 [inline]
shmem_evict_inode+0x258/0x9f0 mm/shmem.c:1156
evict+0x2a4/0x620 fs/inode.c:665
__dentry_kill+0x436/0x650 fs/dcache.c:607
dentry_kill+0xbb/0x290
dput+0x1f3/0x420 fs/dcache.c:913
__fput+0x5e4/0x890 fs/file_table.c:329
task_work_run+0x24a/0x300 kernel/task_work.c:179
resume_user_mode_work include/linux/resume_user_mode.h:49 [inline]
exit_to_user_mode_loop+0xd9/0x100 kernel/entry/common.c:171
exit_to_user_mode_prepare+0xb1/0x140 kernel/entry/common.c:204
__syscall_exit_to_user_mode_work kernel/entry/common.c:286 [inline]
syscall_exit_to_user_mode+0x64/0x280 kernel/entry/common.c:297
do_syscall_64+0x4d/0xc0 arch/x86/entry/common.c:86
entry_SYSCALL_64_after_hwframe+0x63/0xcd
RIP: 0033:0x7f2216c3e01b
Code: 0f 05 48 3d 00 f0 ff ff 77 45 c3 0f 1f 40 00 48 83 ec 18 89 7c 24 0c e8 63 fc ff ff 8b 7c 24 0c 41 89 c0 b8 03 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 35 44 89 c7 89 44 24 0c e8 a1 fc ff ff 8b 44
RSP: 002b:00007f22157fdf20 EFLAGS: 00000293 ORIG_RAX: 0000000000000003
RAX: 0000000000000000 RBX: 0000000000000003 RCX: 00007f2216c3e01b
RDX: 0000000000000003 RSI: 0000000000004c00 RDI: 0000000000000003
RBP: 0000000000000004 R08: 0000000000000000 R09: 0000000000005597
R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000010
R13: 00007f22157fdfdc R14: 00007f22157fe6b8 R15: 0000000020005682