INFO: task syz-executor.4:13201 can't die for more than 143 seconds.
task:syz-executor.4 state:D stack:24240 pid:13201 ppid: 6557 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:4987 [inline]
__schedule+0xa9a/0x4940 kernel/sched/core.c:6268
schedule+0xd2/0x260 kernel/sched/core.c:6341
__bio_queue_enter+0x3c5/0x6a0 block/blk-core.c:441
bio_queue_enter block/blk.h:91 [inline]
blk_mq_get_request block/blk-mq.c:2588 [inline]
blk_mq_submit_bio+0x4ae/0x22c0 block/blk-mq.c:2632
__submit_bio block/blk-core.c:849 [inline]
__submit_bio_noacct_mq block/blk-core.c:924 [inline]
submit_bio_noacct block/blk-core.c:950 [inline]
submit_bio_noacct+0x82c/0xa20 block/blk-core.c:939
submit_bio block/blk-core.c:1011 [inline]
submit_bio+0x1ea/0x430 block/blk-core.c:969
submit_bio_wait+0x106/0x230 block/bio.c:1254
blkdev_issue_flush+0xd6/0x130 block/blk-flush.c:458
blkdev_fsync+0x68/0xa0 block/fops.c:474
vfs_fsync_range+0x13a/0x220 fs/sync.c:182
generic_write_sync include/linux/fs.h:2955 [inline]
blkdev_write_iter+0x552/0x690 block/fops.c:559
call_write_iter include/linux/fs.h:2162 [inline]
do_iter_readv_writev+0x472/0x750 fs/read_write.c:725
do_iter_write+0x188/0x710 fs/read_write.c:851
vfs_iter_write+0x70/0xa0 fs/read_write.c:892
iter_file_splice_write+0x723/0xc70 fs/splice.c:689
do_splice_from fs/splice.c:767 [inline]
direct_splice_actor+0x110/0x180 fs/splice.c:936
splice_direct_to_actor+0x34b/0x8c0 fs/splice.c:891
do_splice_direct+0x1b3/0x280 fs/splice.c:979
do_sendfile+0xaf2/0x1250 fs/read_write.c:1245
__do_sys_sendfile64 fs/read_write.c:1310 [inline]
__se_sys_sendfile64 fs/read_write.c:1296 [inline]
__x64_sys_sendfile64+0x1cc/0x210 fs/read_write.c:1296
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x7fae43f20ae9
RSP: 002b:00007fae41496188 EFLAGS: 00000246 ORIG_RAX: 0000000000000028
RAX: ffffffffffffffda RBX: 00007fae44033f60 RCX: 00007fae43f20ae9
RDX: 0000000000000000 RSI: 0000000000000004 RDI: 0000000000000004
RBP: 00007fae43f7af6d R08: 0000000000000000 R09: 0000000000000000
R10: 0000000024002da6 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffff5f4b54f R14: 00007fae41496300 R15: 0000000000022000
INFO: task syz-executor.4:13201 blocked for more than 143 seconds.
Not tainted 5.16.0-rc1-next-20211118-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.4 state:D stack:24240 pid:13201 ppid: 6557 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:4987 [inline]
__schedule+0xa9a/0x4940 kernel/sched/core.c:6268
schedule+0xd2/0x260 kernel/sched/core.c:6341
__bio_queue_enter+0x3c5/0x6a0 block/blk-core.c:441
bio_queue_enter block/blk.h:91 [inline]
blk_mq_get_request block/blk-mq.c:2588 [inline]
blk_mq_submit_bio+0x4ae/0x22c0 block/blk-mq.c:2632
__submit_bio block/blk-core.c:849 [inline]
__submit_bio_noacct_mq block/blk-core.c:924 [inline]
submit_bio_noacct block/blk-core.c:950 [inline]
submit_bio_noacct+0x82c/0xa20 block/blk-core.c:939
submit_bio block/blk-core.c:1011 [inline]
submit_bio+0x1ea/0x430 block/blk-core.c:969
submit_bio_wait+0x106/0x230 block/bio.c:1254
blkdev_issue_flush+0xd6/0x130 block/blk-flush.c:458
blkdev_fsync+0x68/0xa0 block/fops.c:474
vfs_fsync_range+0x13a/0x220 fs/sync.c:182
generic_write_sync include/linux/fs.h:2955 [inline]
blkdev_write_iter+0x552/0x690 block/fops.c:559
call_write_iter include/linux/fs.h:2162 [inline]
do_iter_readv_writev+0x472/0x750 fs/read_write.c:725
do_iter_write+0x188/0x710 fs/read_write.c:851
vfs_iter_write+0x70/0xa0 fs/read_write.c:892
iter_file_splice_write+0x723/0xc70 fs/splice.c:689
do_splice_from fs/splice.c:767 [inline]
direct_splice_actor+0x110/0x180 fs/splice.c:936
splice_direct_to_actor+0x34b/0x8c0 fs/splice.c:891
do_splice_direct+0x1b3/0x280 fs/splice.c:979
do_sendfile+0xaf2/0x1250 fs/read_write.c:1245
__do_sys_sendfile64 fs/read_write.c:1310 [inline]
__se_sys_sendfile64 fs/read_write.c:1296 [inline]
__x64_sys_sendfile64+0x1cc/0x210 fs/read_write.c:1296
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x7fae43f20ae9
RSP: 002b:00007fae41496188 EFLAGS: 00000246 ORIG_RAX: 0000000000000028
RAX: ffffffffffffffda RBX: 00007fae44033f60 RCX: 00007fae43f20ae9
RDX: 0000000000000000 RSI: 0000000000000004 RDI: 0000000000000004
RBP: 00007fae43f7af6d R08: 0000000000000000 R09: 0000000000000000
R10: 0000000024002da6 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffff5f4b54f R14: 00007fae41496300 R15: 0000000000022000
INFO: task syz-executor.4:13209 can't die for more than 144 seconds.
task:syz-executor.4 state:D stack:28848 pid:13209 ppid: 6557 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:4987 [inline]
__schedule+0xa9a/0x4940 kernel/sched/core.c:6268
schedule+0xd2/0x260 kernel/sched/core.c:6341
blk_mq_freeze_queue_wait+0x112/0x160 block/blk-mq.c:178
__loop_clr_fd+0x1ae/0x1070 drivers/block/loop.c:1122
loop_clr_fd drivers/block/loop.c:1237 [inline]
lo_ioctl+0x398/0x17c0 drivers/block/loop.c:1562
blkdev_ioctl+0x37a/0x800 block/ioctl.c:609
vfs_ioctl fs/ioctl.c:51 [inline]
__do_sys_ioctl fs/ioctl.c:874 [inline]
__se_sys_ioctl fs/ioctl.c:860 [inline]
__x64_sys_ioctl+0x193/0x200 fs/ioctl.c:860
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x7fae43f20ae9
RSP: 002b:00007fae41475188 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 00007fae44034020 RCX: 00007fae43f20ae9
RDX: 0000000000000000 RSI: 0000000000004c01 RDI: 0000000000000004
RBP: 00007fae43f7af6d R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffff5f4b54f R14: 00007fae41475300 R15: 0000000000022000
INFO: task syz-executor.4:13209 blocked for more than 144 seconds.
Not tainted 5.16.0-rc1-next-20211118-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.4 state:D stack:28848 pid:13209 ppid: 6557 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:4987 [inline]
__schedule+0xa9a/0x4940 kernel/sched/core.c:6268
schedule+0xd2/0x260 kernel/sched/core.c:6341
blk_mq_freeze_queue_wait+0x112/0x160 block/blk-mq.c:178
__loop_clr_fd+0x1ae/0x1070 drivers/block/loop.c:1122
loop_clr_fd drivers/block/loop.c:1237 [inline]
lo_ioctl+0x398/0x17c0 drivers/block/loop.c:1562
blkdev_ioctl+0x37a/0x800 block/ioctl.c:609
vfs_ioctl fs/ioctl.c:51 [inline]
__do_sys_ioctl fs/ioctl.c:874 [inline]
__se_sys_ioctl fs/ioctl.c:860 [inline]
__x64_sys_ioctl+0x193/0x200 fs/ioctl.c:860
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x7fae43f20ae9
RSP: 002b:00007fae41475188 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 00007fae44034020 RCX: 00007fae43f20ae9
RDX: 0000000000000000 RSI: 0000000000004c01 RDI: 0000000000000004
RBP: 00007fae43f7af6d R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffff5f4b54f R14: 00007fae41475300 R15: 0000000000022000
Showing all locks held in the system:
1 lock held by khungtaskd/27:
#0: ffffffff8bb83ba0 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x53/0x260 kernel/locking/lockdep.c:6458
2 locks held by systemd-udevd/2969:
#0: ffff88801a1ef918 (&disk->open_mutex){+.+.}-{3:3}, at: blkdev_get_by_dev.part.0+0x9b/0xb50 block/bdev.c:819
#1: ffff88801a1eb360 (&lo->lo_mutex){+.+.}-{3:3}, at: lo_open+0x75/0x120 drivers/block/loop.c:1733
1 lock held by in:imklog/6329:
#0: ffff8880125c1770 (&f->f_pos_lock){+.+.}-{3:3}, at: __fdget_pos+0xe9/0x100 fs/file.c:990
2 locks held by kworker/u4:14/12997:
#0: ffff8880b9d39a98 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock_nested+0x2b/0x120 kernel/sched/core.c:478
#1: ffff8880b9d279c8 (&per_cpu_ptr(group->pcpu, cpu)->seq){-.-.}-{0:0}, at: psi_task_switch+0x173/0x490 kernel/sched/psi.c:871
1 lock held by syz-executor.4/13209:
#0: ffff88801a1eb360 (&lo->lo_mutex){+.+.}-{3:3}, at: __loop_clr_fd+0x7a/0x1070 drivers/block/loop.c:1106
=============================================
NMI backtrace for cpu 1
CPU: 1 PID: 27 Comm: khungtaskd Not tainted 5.16.0-rc1-next-20211118-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Call Trace:
__dump_stack lib/dump_stack.c:88 [inline]
dump_stack_lvl+0xcd/0x134 lib/dump_stack.c:106
nmi_cpu_backtrace.cold+0x47/0x144 lib/nmi_backtrace.c:111
nmi_trigger_cpumask_backtrace+0x1b3/0x230 lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:254 [inline]
watchdog+0xcb7/0xed0 kernel/hung_task.c:339
kthread+0x405/0x4f0 kernel/kthread.c:327
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 12997 Comm: kworker/u4:14 Not tainted 5.16.0-rc1-next-20211118-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Workqueue: events_unbound toggle_allocation_gate
RIP: 0010:spin_lock include/linux/spinlock.h:354 [inline]
RIP: 0010:__get_locked_pte+0x2b1/0x4d0 mm/memory.c:1726
Code: 00 80 88 ff ff 48 01 c3 48 c1 ea 03 48 b8 00 00 00 00 00 fc ff df 49 01 dc 80 3c 02 00 0f 85 c3 01 00 00 49 89 6d 00 48 89 ef ca e4 96 07 e8 45 75 ca ff 4c 89 e0 5b 5d 41 5c 41 5d 41 5e 41
RSP: 0018:ffffc90004caf9c8 EFLAGS: 00000246
RAX: dffffc0000000000 RBX: ffff888000000558 RCX: 0000000000000000
RDX: 1ffff92000995f4c RSI: ffffffff81ad2e7c RDI: ffff888010dbb120
RBP: ffff888010dbb120 R08: 0000000000000000 R09: ffffea000006f807
R10: ffffffff81ad2e1e R11: 000000000000003f R12: ffff8880118d7558
R13: ffffc90004cafa60 R14: 00000000118d7067 R15: 00000000000118d7
FS: 0000000000000000(0000) GS:ffff8880b9c00000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f0d8cc31000 CR3: 000000000b88e000 CR4: 00000000003506f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
get_locked_pte include/linux/mm.h:2160 [inline]
__text_poke+0x1ae/0x8c0 arch/x86/kernel/alternative.c:1000
text_poke_bp_batch+0x3d7/0x560 arch/x86/kernel/alternative.c:1361
text_poke_flush arch/x86/kernel/alternative.c:1451 [inline]
text_poke_flush arch/x86/kernel/alternative.c:1448 [inline]
text_poke_finish+0x16/0x30 arch/x86/kernel/alternative.c:1458
arch_jump_label_transform_apply+0x13/0x20 arch/x86/kernel/jump_label.c:146
jump_label_update+0x1d5/0x430 kernel/jump_label.c:830
static_key_enable_cpuslocked+0x1b1/0x260 kernel/jump_label.c:177
static_key_enable+0x16/0x20 kernel/jump_label.c:190
toggle_allocation_gate mm/kfence/core.c:732 [inline]
toggle_allocation_gate+0x100/0x390 mm/kfence/core.c:724
process_one_work+0x9b2/0x1690 kernel/workqueue.c:2298
worker_thread+0x658/0x11f0 kernel/workqueue.c:2445
kthread+0x405/0x4f0 kernel/kthread.c:327
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295
----------------
Code disassembly (best guess):
0: 00 80 88 ff ff 48 add %al,0x48ffff88(%rax)
6: 01 c3 add %eax,%ebx
8: 48 c1 ea 03 shr $0x3,%rdx
c: 48 b8 00 00 00 00 00 movabs $0xdffffc0000000000,%rax
13: fc ff df
16: 49 01 dc add %rbx,%r12
19: 80 3c 02 00 cmpb $0x0,(%rdx,%rax,1)
1d: 0f 85 c3 01 00 00 jne 0x1e6
23: 49 89 6d 00 mov %rbp,0x0(%r13)
27: 48 89 ef mov %rbp,%rdi
* 2a: e8 ca e4 96 07 callq 0x796e4f9 <-- trapping instruction
2f: e8 45 75 ca ff callq 0xffca7579
34: 4c 89 e0 mov %r12,%rax
37: 5b pop %rbx
38: 5d pop %rbp
39: 41 5c pop %r12
3b: 41 5d pop %r13
3d: 41 5e pop %r14
3f: 41 rex.B