INFO: task kworker/u4:0:9 blocked for more than 143 seconds.
Not tainted 6.3.0-rc3-syzkaller-00012-g17214b70a159 #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/u4:0 state:D stack:24544 pid:9 ppid:2 flags:0x00004000
Workqueue: events_unbound io_ring_exit_work
Call Trace:
context_switch kernel/sched/core.c:5304 [inline]
__schedule+0x173b/0x4630 kernel/sched/core.c:6622
schedule+0xc3/0x180 kernel/sched/core.c:6698
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
io_ring_exit_work+0x702/0x7f0 io_uring/io_uring.c:3027
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.2:5211 blocked for more than 143 seconds.
Not tainted 6.3.0-rc3-syzkaller-00012-g17214b70a159 #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.2 state:D stack:23056 pid:5211 ppid:5105 flags:0x00024004
Call Trace:
context_switch kernel/sched/core.c:5304 [inline]
__schedule+0x173b/0x4630 kernel/sched/core.c:6622
schedule+0xc3/0x180 kernel/sched/core.c:6698
io_schedule+0x8c/0x100 kernel/sched/core.c:8884
bit_wait_io+0x12/0xc0 kernel/sched/wait_bit.c:209
__wait_on_bit_lock+0xbd/0x1a0 kernel/sched/wait_bit.c:90
out_of_line_wait_on_bit_lock+0x1d4/0x250 kernel/sched/wait_bit.c:117
wait_on_bit_lock_io include/linux/wait_bit.h:208 [inline]
__lock_buffer fs/buffer.c:70 [inline]
lock_buffer include/linux/buffer_head.h:400 [inline]
__sync_dirty_buffer+0x120/0x380 fs/buffer.c:2780
__ext4_handle_dirty_metadata+0x2a6/0x820 fs/ext4/ext4_jbd2.c:387
ext4_handle_dirty_dirblock+0x362/0x6f0 fs/ext4/namei.c:438
ext4_finish_convert_inline_dir+0x57b/0x6f0 fs/ext4/inline.c:1180
ext4_convert_inline_data_nolock+0xa01/0xd80 fs/ext4/inline.c:1257
ext4_try_add_inline_entry+0x809/0xb70 fs/ext4/inline.c:1330
ext4_add_entry+0x535/0x1010 fs/ext4/namei.c:2384
ext4_mkdir+0x553/0xce0 fs/ext4/namei.c:3006
vfs_mkdir+0x29d/0x450 fs/namei.c:4038
do_mkdirat+0x264/0x520 fs/namei.c:4061
__do_sys_mkdirat fs/namei.c:4076 [inline]
__se_sys_mkdirat fs/namei.c:4074 [inline]
__x64_sys_mkdirat+0x89/0xa0 fs/namei.c:4074
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:0x7f7e2a48c0f9
RSP: 002b:00007f7e2b1f9168 EFLAGS: 00000246 ORIG_RAX: 0000000000000102
RAX: ffffffffffffffda RBX: 00007f7e2a5abf80 RCX: 00007f7e2a48c0f9
RDX: 0000000000000000 RSI: 0000000020000540 RDI: 000000000000000b
RBP: 00007f7e2a4e7b39 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffd52ec71bf R14: 00007f7e2b1f9300 R15: 0000000000022000
Showing all locks held in the system:
2 locks held by kworker/u4:0/9:
#0: ffff888012479138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: process_one_work+0x77e/0x10e0 kernel/workqueue.c:2363
#1: ffffc900000e7d20 ((work_completion)(&ctx->exit_work)){+.+.}-{0:0}, at: process_one_work+0x7c8/0x10e0 kernel/workqueue.c:2365
1 lock held by rcu_tasks_kthre/12:
#0: ffffffff8cf255f0 (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: ffffffff8cf25df0 (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: ffffffff8cf25420 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire+0x0/0x30
2 locks held by kworker/u4:3/42:
#0: ffff888012479138 ((wq_completion)events_unbound){+.+.}-{0:0}, at: process_one_work+0x77e/0x10e0 kernel/workqueue.c:2363
#1: ffffc90000b37d20 ((work_completion)(&ctx->exit_work)){+.+.}-{0:0}, at: process_one_work+0x7c8/0x10e0 kernel/workqueue.c:2365
3 locks held by kworker/u4:4/75:
#0: ffff8880b983be98 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock_nested+0x2a/0x140 kernel/sched/core.c:539
#1: ffff8880b9828788 (&per_cpu_ptr(group->pcpu, cpu)->seq){-.-.}-{0:0}, at: psi_task_switch+0x3a7/0x770 kernel/sched/psi.c:964
#2: ffff8880b9829598 (&base->lock){-.-.}-{2:2}, at: lock_timer_base+0x120/0x260 kernel/time/timer.c:999
1 lock held by syslogd/4415:
2 locks held by getty/4750:
#0: ffff888028ebb098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x25/0x70 drivers/tty/tty_ldisc.c:244
#1: ffffc900015902f0 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0x6ab/0x1db0 drivers/tty/n_tty.c:2177
3 locks held by syz-executor.2/5211:
#0: ffff88807aa48460 (sb_writers#4){.+.+}-{0:0}, at: mnt_want_write+0x3f/0x90 fs/namespace.c:394
#1: ffff88802f0cd440 (&type->i_mutex_dir_key#3/1){+.+.}-{3:3}, at: inode_lock_nested include/linux/fs.h:793 [inline]
#1: ffff88802f0cd440 (&type->i_mutex_dir_key#3/1){+.+.}-{3:3}, at: filename_create+0x25a/0x530 fs/namei.c:3808
#2: ffff88802f0cd108 (&ei->xattr_sem){++++}-{3:3}, at: ext4_write_lock_xattr fs/ext4/xattr.h:155 [inline]
#2: ffff88802f0cd108 (&ei->xattr_sem){++++}-{3:3}, at: ext4_try_add_inline_entry+0xf6/0xb70 fs/ext4/inline.c:1288
3 locks held by kworker/u4:7/5252:
#0: ffff888144b43938 ((wq_completion)writeback){+.+.}-{0:0}, at: process_one_work+0x77e/0x10e0 kernel/workqueue.c:2363
#1: ffffc9000503fd20 ((work_completion)(&(&wb->dwork)->work)){+.+.}-{0:0}, at: process_one_work+0x7c8/0x10e0 kernel/workqueue.c:2365
#2: ffff8880167700e0 (&type->s_umount_key#41){.+.+}-{3:3}, at: trylock_super+0x1f/0xf0 fs/super.c:414
3 locks held by syz-executor.4/5304:
#0: ffff888027d7e460 (sb_writers#4){.+.+}-{0:0}, at: mnt_want_write+0x3f/0x90 fs/namespace.c:394
#1: ffff888074b6d440 (&type->i_mutex_dir_key#3/1){+.+.}-{3:3}, at: inode_lock_nested include/linux/fs.h:793 [inline]
#1: ffff888074b6d440 (&type->i_mutex_dir_key#3/1){+.+.}-{3:3}, at: filename_create+0x25a/0x530 fs/namei.c:3808
#2: ffff888074b6d108 (&ei->xattr_sem){++++}-{3:3}, at: ext4_write_lock_xattr fs/ext4/xattr.h:155 [inline]
#2: ffff888074b6d108 (&ei->xattr_sem){++++}-{3:3}, at: ext4_try_add_inline_entry+0xf6/0xb70 fs/ext4/inline.c:1288
2 locks held by syz-executor.2/5410:
#0: ffff888027d7e0e0 (&type->s_umount_key#30){++++}-{3:3}, at: iterate_supers+0xb0/0x1e0 fs/super.c:743
#1: ffff88801ef207d0 (&bdi->wb_switch_rwsem){+.+.}-{3:3}, at: bdi_down_write_wb_switch_rwsem fs/fs-writeback.c:364 [inline]
#1: ffff88801ef207d0 (&bdi->wb_switch_rwsem){+.+.}-{3:3}, at: sync_inodes_sb+0x278/0xab0 fs/fs-writeback.c:2725
1 lock held by syz-executor.2/5482:
#0: ffff88801ee994c8 (&disk->open_mutex){+.+.}-{3:3}, at: sync_bdevs+0x1a9/0x320 block/bdev.c:974
1 lock held by syz-executor.4/5477:
#0: ffff88801ee994c8 (&disk->open_mutex){+.+.}-{3:3}, at: blkdev_get_by_dev+0x148/0xa30 block/bdev.c:735
=============================================
NMI backtrace for cpu 1
CPU: 1 PID: 28 Comm: khungtaskd Not tainted 6.3.0-rc3-syzkaller-00012-g17214b70a159 #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 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 4415 Comm: syslogd Not tainted 6.3.0-rc3-syzkaller-00012-g17214b70a159 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 03/02/2023
RIP: 0010:visit_lock_entry kernel/locking/lockdep.c:1526 [inline]
RIP: 0010:__bfs kernel/locking/lockdep.c:1806 [inline]
RIP: 0010:__bfs_backwards kernel/locking/lockdep.c:1850 [inline]
RIP: 0010:check_irq_usage kernel/locking/lockdep.c:2790 [inline]
RIP: 0010:check_prev_add kernel/locking/lockdep.c:3102 [inline]
RIP: 0010:check_prevs_add kernel/locking/lockdep.c:3217 [inline]
RIP: 0010:validate_chain+0x1d2e/0x58e0 kernel/locking/lockdep.c:3832
Code: 41 b5 01 eb 0c 4d 8b 3f 4d 39 f7 0f 84 e3 fb ff ff 49 8d 5f 30 48 89 d8 48 c1 e8 03 48 b9 00 00 00 00 00 fc ff df 80 3c 08 00 <74> 08 48 89 df e8 c8 30 75 00 4c 89 23 41 f6 c5 01 0f 84 82 00 00
RSP: 0018:ffffc9000306efa0 EFLAGS: 00000046
RAX: 1ffffffff228ace7 RBX: ffffffff91456738 RCX: dffffc0000000000
RDX: 0000000000000000 RSI: 0000000000000008 RDI: ffffffff8ffd8f90
RBP: ffffc9000306f250 R08: dffffc0000000000 R09: fffffbfff205c039
R10: 0000000000000000 R11: dffffc0000000001 R12: ffffffff9138a2e8
R13: 0000000000000000 R14: ffffffff8ffd8f70 R15: ffffffff91456708
FS: 00007f0944af8800(0000) GS:ffff8880b9800000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 000000c000e87000 CR3: 00000000205cf000 CR4: 00000000003506f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
__lock_acquire+0x125b/0x1f80 kernel/locking/lockdep.c:5056
lock_acquire+0x1e1/0x520 kernel/locking/lockdep.c:5669
__raw_spin_lock include/linux/spinlock_api_smp.h:133 [inline]
_raw_spin_lock+0x2e/0x40 kernel/locking/spinlock.c:154
mm_cid_put kernel/sched/sched.h:3270 [inline]
switch_mm_cid kernel/sched/sched.h:3298 [inline]
prepare_task_switch kernel/sched/core.c:5114 [inline]
context_switch kernel/sched/core.c:5255 [inline]
__schedule+0x11e1/0x4630 kernel/sched/core.c:6622
preempt_schedule_common+0x83/0xc0 kernel/sched/core.c:6791
preempt_schedule+0xdd/0xf0 kernel/sched/core.c:6815
preempt_schedule_thunk+0x1a/0x20 arch/x86/entry/thunk_64.S:34
__raw_spin_unlock_irqrestore include/linux/spinlock_api_smp.h:152 [inline]
_raw_spin_unlock_irqrestore+0x12c/0x140 kernel/locking/spinlock.c:194
spin_unlock_irqrestore include/linux/spinlock.h:405 [inline]
__wake_up_common_lock kernel/sched/wait.c:140 [inline]
__wake_up_sync_key+0x125/0x1c0 kernel/sched/wait.c:208
__unix_dgram_recvmsg+0x602/0x1260 net/unix/af_unix.c:2479
sock_recvmsg_nosec net/socket.c:1017 [inline]
sock_recvmsg net/socket.c:1038 [inline]
sock_read_iter+0x3a8/0x500 net/socket.c:1116
call_read_iter include/linux/fs.h:1845 [inline]
new_sync_read fs/read_write.c:389 [inline]
vfs_read+0x7e2/0xbe0 fs/read_write.c:470
ksys_read+0x1a0/0x2c0 fs/read_write.c:613
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:0x7f0944c848fe
Code: c0 e9 e6 fe ff ff 50 48 8d 3d 0e c7 09 00 e8 c9 cf 01 00 66 0f 1f 84 00 00 00 00 00 64 8b 04 25 18 00 00 00 85 c0 75 14 0f 05 <48> 3d 00 f0 ff ff 77 5a c3 66 0f 1f 84 00 00 00 00 00 48 83 ec 28
RSP: 002b:00007ffe876075b8 EFLAGS: 00000246 ORIG_RAX: 0000000000000000
RAX: ffffffffffffffda RBX: 0000000000000002 RCX: 00007f0944c848fe
RDX: 00000000000000ff RSI: 0000558a7f833950 RDI: 0000000000000000
RBP: 0000558a7f833910 R08: 00007f0944d14040 R09: 00007f0944d140c0
R10: 00007f0944d13fc0 R11: 0000000000000246 R12: 0000558a7f833983
R13: 0000558a7f833950 R14: 0000000000000000 R15: 0000000000000000