INFO: task kworker/0:1H:94 blocked for more than 143 seconds.
Not tainted 6.4.0-syzkaller-01312-gb19edac5992d #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/0:1H state:D stack:25632 pid:94 ppid:2 flags:0x00004000
Workqueue: xfs-log/loop5 xlog_ioend_work
Call Trace:
context_switch kernel/sched/core.c:5343 [inline]
__schedule+0x187b/0x4900 kernel/sched/core.c:6669
schedule+0xc3/0x180 kernel/sched/core.c:6745
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:1119
xfs_buf_item_unpin+0x1cd/0x6c0 fs/xfs/xfs_buf_item.c:581
xfs_trans_committed_bulk+0x346/0x830 fs/xfs/xfs_trans.c:808
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:2408
worker_thread+0xa63/0x1210 kernel/workqueue.c:2555
kthread+0x2b8/0x350 kernel/kthread.c:379
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:308
INFO: task syz-executor.5:18669 blocked for more than 144 seconds.
Not tainted 6.4.0-syzkaller-01312-gb19edac5992d #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.5 state:D stack:23456 pid:18669 ppid:5040 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:5343 [inline]
__schedule+0x187b/0x4900 kernel/sched/core.c:6669
schedule+0xc3/0x180 kernel/sched/core.c:6745
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:1119
xfs_trans_getsb+0x89/0x4d0 fs/xfs/xfs_trans_buf.c:190
xfs_trans_apply_sb_deltas+0x28/0x950 fs/xfs/xfs_trans.c:481
__xfs_trans_commit+0x96d/0x11d0 fs/xfs/xfs_trans.c:1009
xfs_create+0xe5a/0x1240 fs/xfs/xfs_inode.c:1070
xfs_generic_create+0x491/0xd70 fs/xfs/xfs_iops.c:199
lookup_open fs/namei.c:3492 [inline]
open_last_lookups fs/namei.c:3560 [inline]
path_openat+0x13e7/0x3180 fs/namei.c:3790
do_filp_open+0x234/0x490 fs/namei.c:3820
do_sys_openat2+0x13a/0x520 fs/open.c:1402
do_sys_open fs/open.c:1418 [inline]
__do_sys_open fs/open.c:1426 [inline]
__se_sys_open fs/open.c:1422 [inline]
__x64_sys_open+0x225/0x270 fs/open.c:1422
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:0x7f43f388c389
RSP: 002b:00007f43f461f168 EFLAGS: 00000246 ORIG_RAX: 0000000000000002
RAX: ffffffffffffffda RBX: 00007f43f39abf80 RCX: 00007f43f388c389
RDX: 0000000000000000 RSI: 000000000014d27e RDI: 0000000020000000
RBP: 00007f43f38d7493 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007fff85df1b6f R14: 00007f43f461f300 R15: 0000000000022000
INFO: task syz-executor.5:18715 blocked for more than 144 seconds.
Not tainted 6.4.0-syzkaller-01312-gb19edac5992d #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.5 state:D stack:27224 pid:18715 ppid:5040 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:5343 [inline]
__schedule+0x187b/0x4900 kernel/sched/core.c:6669
schedule+0xc3/0x180 kernel/sched/core.c:6745
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+0xb38/0x11d0 fs/xfs/xfs_trans.c:1021
xfs_sync_sb_buf+0x14f/0x1e0 fs/xfs/libxfs/xfs_sb.c:1112
xfs_ioc_setlabel fs/xfs/xfs_ioctl.c:1801 [inline]
xfs_file_ioctl+0x1316/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+0xf8/0x170 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:0x7f43f388c389
RSP: 002b:00007f43f45fe168 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 00007f43f39ac050 RCX: 00007f43f388c389
RDX: 0000000020000000 RSI: 0000000041009432 RDI: 0000000000000004
RBP: 00007f43f38d7493 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007fff85df1b6f R14: 00007f43f45fe300 R15: 0000000000022000
INFO: task syz-executor.5:18716 blocked for more than 145 seconds.
Not tainted 6.4.0-syzkaller-01312-gb19edac5992d #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.5 state:D stack:25624 pid:18716 ppid:5040 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:5343 [inline]
__schedule+0x187b/0x4900 kernel/sched/core.c:6669
schedule+0xc3/0x180 kernel/sched/core.c:6745
schedule_preempt_disabled+0x13/0x20 kernel/sched/core.c:6804
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:771 [inline]
open_last_lookups fs/namei.c:3557 [inline]
path_openat+0x7c2/0x3180 fs/namei.c:3790
do_filp_open+0x234/0x490 fs/namei.c:3820
do_sys_openat2+0x13a/0x520 fs/open.c:1402
do_sys_open fs/open.c:1418 [inline]
__do_sys_open fs/open.c:1426 [inline]
__se_sys_open fs/open.c:1422 [inline]
__x64_sys_open+0x225/0x270 fs/open.c:1422
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:0x7f43f388c389
RSP: 002b:00007f43f45dd168 EFLAGS: 00000246 ORIG_RAX: 0000000000000002
RAX: ffffffffffffffda RBX: 00007f43f39ac120 RCX: 00007f43f388c389
RDX: 0000000000000000 RSI: 000000000014d27e RDI: 0000000020000000
RBP: 00007f43f38d7493 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007fff85df1b6f R14: 00007f43f45dd300 R15: 0000000000022000
Showing all locks held in the system:
1 lock held by rcu_tasks_kthre/13:
#0: ffffffff8cf27530 (rcu_tasks.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x29/0xd20 kernel/rcu/tasks.h:522
1 lock held by rcu_tasks_trace/14:
#0: ffffffff8cf278f0 (rcu_tasks_trace.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x29/0xd20 kernel/rcu/tasks.h:522
1 lock held by khungtaskd/28:
#0: ffffffff8cf27360 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire+0x0/0x30
2 locks held by kworker/0:1H/94:
#0: ffff888023863138 ((wq_completion)xfs-log/loop5){+.+.}-{0:0}, at: process_one_work+0x77e/0x10e0 kernel/workqueue.c:2381
#1: ffffc900025b7d20 ((work_completion)(&iclog->ic_end_io_work)){+.+.}-{0:0}, at: process_one_work+0x7c8/0x10e0 kernel/workqueue.c:2383
3 locks held by kworker/0:3/1778:
#0: ffff888012470d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x77e/0x10e0 kernel/workqueue.c:2381
#1: ffffc90005f4fd20 ((work_completion)(&pwq->unbound_release_work)){+.+.}-{0:0}, at: process_one_work+0x7c8/0x10e0 kernel/workqueue.c:2383
#2: ffffffff8cf2c9f8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: exp_funnel_lock kernel/rcu/tree_exp.h:325 [inline]
#2: ffffffff8cf2c9f8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: synchronize_rcu_expedited+0x46c/0x890 kernel/rcu/tree_exp.h:992
2 locks held by getty/4757:
#0: ffff88802d38a098 (&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+0x6b1/0x1db0 drivers/tty/n_tty.c:2176
1 lock held by syz-executor.3/5046:
2 locks held by syz-executor.1/6994:
#0: ffff88802b40a0e0 (&type->s_umount_key#53){++++}-{3:3}, at: deactivate_super+0xad/0xf0 fs/super.c:361
#1: ffffffff8cf2c9f8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: exp_funnel_lock kernel/rcu/tree_exp.h:293 [inline]
#1: ffffffff8cf2c9f8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: synchronize_rcu_expedited+0x3a3/0x890 kernel/rcu/tree_exp.h:992
2 locks held by kworker/0:17/7878:
#0: ffff888012472538 ((wq_completion)rcu_gp){+.+.}-{0:0}, at: process_one_work+0x77e/0x10e0 kernel/workqueue.c:2381
#1: ffffc90003a8fd20 ((work_completion)(&rew->rew_work)){+.+.}-{0:0}, at: process_one_work+0x7c8/0x10e0 kernel/workqueue.c:2383
5 locks held by syz-executor.5/18669:
#0: ffff88803f430460 (sb_writers#15){.+.+}-{0:0}, at: mnt_want_write+0x3f/0x90 fs/namespace.c:403
#1: ffff888078c06038 (&inode->i_sb->s_type->i_mutex_dir_key#2){++++}-{3:3}, at: inode_lock include/linux/fs.h:771 [inline]
#1: ffff888078c06038 (&inode->i_sb->s_type->i_mutex_dir_key#2){++++}-{3:3}, at: open_last_lookups fs/namei.c:3557 [inline]
#1: ffff888078c06038 (&inode->i_sb->s_type->i_mutex_dir_key#2){++++}-{3:3}, at: path_openat+0x7c2/0x3180 fs/namei.c:3790
#2: ffff88803f430650 (sb_internal#3){.+.+}-{0:0}, at: xfs_trans_alloc_icreate+0xc9/0x2b0 fs/xfs/xfs_trans.c:1253
#3: ffff888078c05e18 (&xfs_dir_ilock_class/5){+.+.}-{3:3}, at: xfs_create+0x7ed/0x1240 fs/xfs/xfs_inode.c:1013
#4: ffff888081276d98 (&xfs_nondir_ilock_class#3){++++}-{3:3}, at: mrtryupdate fs/xfs/mrlock.h:49 [inline]
#4: ffff888081276d98 (&xfs_nondir_ilock_class#3){++++}-{3:3}, at: xfs_ilock_nowait+0x23f/0x510 fs/xfs/xfs_inode.c:254
1 lock held by syz-executor.5/18715:
#0: ffff88803f430460 (sb_writers#15){.+.+}-{0:0}, at: mnt_want_write_file+0x61/0x200 fs/namespace.c:447
2 locks held by syz-executor.5/18716:
#0: ffff88803f430460 (sb_writers#15){.+.+}-{0:0}, at: mnt_want_write+0x3f/0x90 fs/namespace.c:403
#1: ffff888078c06038 (&inode->i_sb->s_type->i_mutex_dir_key#2){++++}-{3:3}, at: inode_lock include/linux/fs.h:771 [inline]
#1: ffff888078c06038 (&inode->i_sb->s_type->i_mutex_dir_key#2){++++}-{3:3}, at: open_last_lookups fs/namei.c:3557 [inline]
#1: ffff888078c06038 (&inode->i_sb->s_type->i_mutex_dir_key#2){++++}-{3:3}, at: path_openat+0x7c2/0x3180 fs/namei.c:3790
1 lock held by udevd/18927:
#0: ffff88801e2194c8 (mapping.invalidate_lock#2){.+.+}-{3:3}, at: filemap_invalidate_lock_shared include/linux/fs.h:826 [inline]
#0: ffff88801e2194c8 (mapping.invalidate_lock#2){.+.+}-{3:3}, at: page_cache_ra_unbounded+0xf1/0x7c0 mm/readahead.c:226
1 lock held by syz-executor.0/20741:
#0: ffff88802b40a0e0 (&type->s_umount_key#53){++++}-{3:3}, at: iterate_supers+0xb0/0x1e0 fs/super.c:743
1 lock held by syz-executor.0/20742:
#0: ffff88802b40a0e0 (&type->s_umount_key#53){++++}-{3:3}, at: iterate_supers+0xb0/0x1e0 fs/super.c:743
1 lock held by syz-executor.5/20745:
#0: ffff88802b40a0e0 (&type->s_umount_key#53){++++}-{3:3}, at: iterate_supers+0xb0/0x1e0 fs/super.c:743
1 lock held by syz-executor.5/20746:
#0: ffff88802b40a0e0 (&type->s_umount_key#53){++++}-{3:3}, at: iterate_supers+0xb0/0x1e0 fs/super.c:743
2 locks held by syz-executor.2/20758:
2 locks held by syz-executor.3/20765:
=============================================
NMI backtrace for cpu 1
CPU: 1 PID: 28 Comm: khungtaskd Not tainted 6.4.0-syzkaller-01312-gb19edac5992d #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 05/27/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+0x2b8/0x350 kernel/kthread.c:379
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:308
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 4438 Comm: klogd Not tainted 6.4.0-syzkaller-01312-gb19edac5992d #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 05/27/2023
RIP: 0010:__sanitizer_cov_trace_const_cmp2+0x0/0x90 kernel/kcov.c:298
Code: 89 11 48 c7 44 0a 08 01 00 00 00 48 89 44 0a 10 48 89 74 0a 18 4c 89 44 0a 20 c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 44 00 00 0f 1e fa 4c 8b 04 24 65 48 8b 15 70 08 78 7e 65 8b 05 71 08 78
RSP: 0018:ffffc9000318fb58 EFLAGS: 00000202
RAX: 0000000000000000 RBX: 0000000000000002 RCX: ffff88807e268000
RDX: ffff88807e268000 RSI: 0000000000000002 RDI: 0000000000000002
RBP: ffffc9000318fc78 R08: ffffffff83f68460 R09: ffffffff83f683dd
R10: 0000000000000003 R11: ffff88807e268000 R12: 0000000000000001
R13: 0000000000000000 R14: 0000000000000002 R15: 0000000000000000
FS: 00007f0b0bbe2380(0000) GS:ffff8880b9800000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f5c0cc9f000 CR3: 000000002a5e1000 CR4: 00000000003506f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
tomoyo_socket_sendmsg_permission+0x1c5/0x410
security_socket_sendmsg+0x71/0xa0 security/security.c:4204
sock_sendmsg net/socket.c:745 [inline]
__sys_sendto+0x3e3/0x630 net/socket.c:2145
__do_sys_sendto net/socket.c:2157 [inline]
__se_sys_sendto net/socket.c:2153 [inline]
__x64_sys_sendto+0xde/0xf0 net/socket.c:2153
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:0x7f0b0bd449b5
Code: 8b 44 24 08 48 83 c4 28 48 98 c3 48 98 c3 41 89 ca 64 8b 04 25 18 00 00 00 85 c0 75 26 45 31 c9 45 31 c0 b8 2c 00 00 00 0f 05 <48> 3d 00 f0 ff ff 76 7a 48 8b 15 44 c4 0c 00 f7 d8 64 89 02 48 83
RSP: 002b:00007fffd5843798 EFLAGS: 00000246 ORIG_RAX: 000000000000002c
RAX: ffffffffffffffda RBX: 0000000000000002 RCX: 00007f0b0bd449b5
RDX: 0000000000000039 RSI: 000055e4d9ded480 RDI: 0000000000000003
RBP: 000055e4d9de5910 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000004000 R11: 0000000000000246 R12: 0000000000000013
R13: 00007f0b0bed2212 R14: 00007fffd5843898 R15: 0000000000000000