INFO: task syz-executor.2:17730 can't die for more than 143 seconds. task:syz-executor.2 state:D stack:24296 pid:17730 ppid: 6560 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 mpage_bio_submit fs/mpage.c:66 [inline] mpage_readahead+0x589/0x750 fs/mpage.c:393 read_pages+0x1e4/0xfa0 mm/readahead.c:129 page_cache_ra_unbounded+0x64b/0x940 mm/readahead.c:238 do_page_cache_ra mm/readahead.c:268 [inline] ondemand_readahead+0x594/0x1090 mm/readahead.c:551 page_cache_async_ra mm/readahead.c:608 [inline] page_cache_async_ra+0x2e1/0x3f0 mm/readahead.c:583 page_cache_async_readahead include/linux/pagemap.h:1052 [inline] filemap_readahead mm/filemap.c:2531 [inline] filemap_get_pages+0x6f1/0x1be0 mm/filemap.c:2572 filemap_read+0x315/0xeb0 mm/filemap.c:2642 generic_file_read_iter+0x3b6/0x5a0 mm/filemap.c:2792 blkdev_read_iter+0xf8/0x1d0 block/fops.c:583 call_read_iter include/linux/fs.h:2156 [inline] generic_file_splice_read+0x453/0x6d0 fs/splice.c:311 do_splice_to+0x1bf/0x250 fs/splice.c:796 splice_direct_to_actor+0x2c2/0x8c0 fs/splice.c:870 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:0x7f581ebd7ae9 RSP: 002b:00007f581c14d188 EFLAGS: 00000246 ORIG_RAX: 0000000000000028 RAX: ffffffffffffffda RBX: 00007f581eceaf60 RCX: 00007f581ebd7ae9 RDX: 0000000000000000 RSI: 0000000000000004 RDI: 0000000000000004 RBP: 00007f581ec31f6d R08: 0000000000000000 R09: 0000000000000000 R10: 0000000024002da6 R11: 0000000000000246 R12: 0000000000000000 R13: 00007fff58c3f94f R14: 00007f581c14d300 R15: 0000000000022000 INFO: task syz-executor.2:17730 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.2 state:D stack:24296 pid:17730 ppid: 6560 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 mpage_bio_submit fs/mpage.c:66 [inline] mpage_readahead+0x589/0x750 fs/mpage.c:393 read_pages+0x1e4/0xfa0 mm/readahead.c:129 page_cache_ra_unbounded+0x64b/0x940 mm/readahead.c:238 do_page_cache_ra mm/readahead.c:268 [inline] ondemand_readahead+0x594/0x1090 mm/readahead.c:551 page_cache_async_ra mm/readahead.c:608 [inline] page_cache_async_ra+0x2e1/0x3f0 mm/readahead.c:583 page_cache_async_readahead include/linux/pagemap.h:1052 [inline] filemap_readahead mm/filemap.c:2531 [inline] filemap_get_pages+0x6f1/0x1be0 mm/filemap.c:2572 filemap_read+0x315/0xeb0 mm/filemap.c:2642 generic_file_read_iter+0x3b6/0x5a0 mm/filemap.c:2792 blkdev_read_iter+0xf8/0x1d0 block/fops.c:583 call_read_iter include/linux/fs.h:2156 [inline] generic_file_splice_read+0x453/0x6d0 fs/splice.c:311 do_splice_to+0x1bf/0x250 fs/splice.c:796 splice_direct_to_actor+0x2c2/0x8c0 fs/splice.c:870 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:0x7f581ebd7ae9 RSP: 002b:00007f581c14d188 EFLAGS: 00000246 ORIG_RAX: 0000000000000028 RAX: ffffffffffffffda RBX: 00007f581eceaf60 RCX: 00007f581ebd7ae9 RDX: 0000000000000000 RSI: 0000000000000004 RDI: 0000000000000004 RBP: 00007f581ec31f6d R08: 0000000000000000 R09: 0000000000000000 R10: 0000000024002da6 R11: 0000000000000246 R12: 0000000000000000 R13: 00007fff58c3f94f R14: 00007f581c14d300 R15: 0000000000022000 INFO: task syz-executor.2:17734 can't die for more than 144 seconds. task:syz-executor.2 state:D stack:29072 pid:17734 ppid: 6560 flags:0x00000004 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:0x7f581ebd7ae9 RSP: 002b:00007f581c12c188 EFLAGS: 00000246 ORIG_RAX: 0000000000000010 RAX: ffffffffffffffda RBX: 00007f581eceb020 RCX: 00007f581ebd7ae9 RDX: 0000000000000000 RSI: 0000000000004c01 RDI: 0000000000000004 RBP: 00007f581ec31f6d R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 R13: 00007fff58c3f94f R14: 00007f581c12c300 R15: 0000000000022000 INFO: task syz-executor.2:17734 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.2 state:D stack:29072 pid:17734 ppid: 6560 flags:0x00000004 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:0x7f581ebd7ae9 RSP: 002b:00007f581c12c188 EFLAGS: 00000246 ORIG_RAX: 0000000000000010 RAX: ffffffffffffffda RBX: 00007f581eceb020 RCX: 00007f581ebd7ae9 RDX: 0000000000000000 RSI: 0000000000004c01 RDI: 0000000000000004 RBP: 00007f581ec31f6d R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 R13: 00007fff58c3f94f R14: 00007f581c12c300 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 kworker/u4:2/50: 5 locks held by kworker/u4:4/1007: 2 locks held by systemd-udevd/2972: #0: ffff88801a704118 (&disk->open_mutex){+.+.}-{3:3}, at: blkdev_get_by_dev.part.0+0x9b/0xb50 block/bdev.c:819 #1: ffff888147440b60 (&lo->lo_mutex){+.+.}-{3:3}, at: lo_open+0x75/0x120 drivers/block/loop.c:1733 1 lock held by syz-executor.2/17730: #0: ffff888145fe3888 (mapping.invalidate_lock#2){.+.+}-{3:3}, at: filemap_invalidate_lock_shared include/linux/fs.h:838 [inline] #0: ffff888145fe3888 (mapping.invalidate_lock#2){.+.+}-{3:3}, at: page_cache_ra_unbounded+0x1b3/0x940 mm/readahead.c:194 1 lock held by syz-executor.2/17734: #0: ffff888147440b60 (&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: 2968 Comm: systemd-journal Not tainted 5.16.0-rc1-next-20211118-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 RIP: 0010:write_comp_data kernel/kcov.c:221 [inline] RIP: 0010:__sanitizer_cov_trace_const_cmp4+0x3/0x70 kernel/kcov.c:287 Code: 83 c2 01 48 c7 44 30 e0 02 00 00 00 48 89 7c 30 e8 48 89 4c 30 f0 4c 89 54 d8 20 48 89 10 5b c3 0f 1f 80 00 00 00 00 41 89 f8 03 00 00 00 4c 8b 14 24 89 f1 65 48 8b 34 25 40 70 02 00 e8 14 RSP: 0018:ffffc9000279fb90 EFLAGS: 00000246 RAX: 0000000000000000 RBX: 0000000000000040 RCX: 0000000000000041 RDX: 1ffffffff17028e0 RSI: 0000000000000000 RDI: 0000000000000000 RBP: ffffc9000279fc38 R08: 0000000000000000 R09: ffffffff81cd1979 R10: ffffffff81cd19b9 R11: 0000000000000000 R12: ffffc9000279fd1c R13: 00000000000030ca R14: ffffffff8b814700 R15: 0000000000000000 FS: 00007ff7477028c0(0000) GS:ffff8880b9c00000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007ff744c28000 CR3: 0000000021f7a000 CR4: 00000000003506f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: path_init+0x193/0x1920 fs/namei.c:2335 path_lookupat+0x30/0x860 fs/namei.c:2439 filename_lookup+0x1c6/0x590 fs/namei.c:2478 user_path_at_empty+0x42/0x60 fs/namei.c:2801 user_path_at include/linux/namei.h:57 [inline] do_faccessat+0x127/0x850 fs/open.c:421 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:0x7ff7469bd9c7 Code: 83 c4 08 48 3d 01 f0 ff ff 73 01 c3 48 8b 0d c8 d4 2b 00 f7 d8 64 89 01 48 83 c8 ff c3 66 0f 1f 44 00 00 b8 15 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d a1 d4 2b 00 f7 d8 64 89 01 48 RSP: 002b:00007ffc057d60e8 EFLAGS: 00000246 ORIG_RAX: 0000000000000015 RAX: ffffffffffffffda RBX: 00007ffc057d9000 RCX: 00007ff7469bd9c7 RDX: 00007ff74742ea00 RSI: 0000000000000000 RDI: 00005584085fa9a3 RBP: 00007ffc057d6120 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000069 R11: 0000000000000246 R12: 0000000000000000 R13: 0000000000000000 R14: 00007ffc057d9000 R15: 00007ffc057d6610 ---------------- Code disassembly (best guess): 0: 83 c2 01 add $0x1,%edx 3: 48 c7 44 30 e0 02 00 movq $0x2,-0x20(%rax,%rsi,1) a: 00 00 c: 48 89 7c 30 e8 mov %rdi,-0x18(%rax,%rsi,1) 11: 48 89 4c 30 f0 mov %rcx,-0x10(%rax,%rsi,1) 16: 4c 89 54 d8 20 mov %r10,0x20(%rax,%rbx,8) 1b: 48 89 10 mov %rdx,(%rax) 1e: 5b pop %rbx 1f: c3 retq 20: 0f 1f 80 00 00 00 00 nopl 0x0(%rax) 27: 41 89 f8 mov %edi,%r8d * 2a: bf 03 00 00 00 mov $0x3,%edi <-- trapping instruction 2f: 4c 8b 14 24 mov (%rsp),%r10 33: 89 f1 mov %esi,%ecx 35: 65 48 8b 34 25 40 70 mov %gs:0x27040,%rsi 3c: 02 00 3e: e8 .byte 0xe8 3f: 14 .byte 0x14