INFO: task syz-executor.2:11015 can't die for more than 143 seconds.
task:syz-executor.2 state:D stack:27888 pid:11015 ppid: 6535 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:0x7f73f59508a7
RSP: 002b:00007f73f2ec5fa8 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 00000000200000c0 RCX: 00007f73f59508a7
RDX: 0000000000000000 RSI: 0000000000004c01 RDI: 0000000000000004
RBP: 00007f73f2ec66bc R08: 00007f73f2ec6040 R09: 0000000020000000
R10: 0000000000000000 R11: 0000000000000246 R12: ffffffffffffffff
R13: 0000000000000005 R14: 00007f73f2ec6000 R15: 0000000020000100
INFO: task syz-executor.2:11015 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:27888 pid:11015 ppid: 6535 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:0x7f73f59508a7
RSP: 002b:00007f73f2ec5fa8 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 00000000200000c0 RCX: 00007f73f59508a7
RDX: 0000000000000000 RSI: 0000000000004c01 RDI: 0000000000000004
RBP: 00007f73f2ec66bc R08: 00007f73f2ec6040 R09: 0000000020000000
R10: 0000000000000000 R11: 0000000000000246 R12: ffffffffffffffff
R13: 0000000000000005 R14: 00007f73f2ec6000 R15: 0000000020000100
INFO: task syz-executor.2:11024 can't die for more than 144 seconds.
task:syz-executor.2 state:D stack:27216 pid:11024 ppid: 6535 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
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6400
__mutex_lock_common kernel/locking/mutex.c:680 [inline]
__mutex_lock+0xa32/0x12f0 kernel/locking/mutex.c:740
blkdev_get_by_dev.part.0+0x9b/0xb50 block/bdev.c:819
blkdev_get_by_dev+0x6b/0x80 block/bdev.c:859
blkdev_open+0x154/0x2e0 block/fops.c:501
do_dentry_open+0x4c8/0x1250 fs/open.c:822
do_open fs/namei.c:3426 [inline]
path_openat+0x1cad/0x2750 fs/namei.c:3559
do_filp_open+0x1aa/0x400 fs/namei.c:3586
do_sys_openat2+0x16d/0x4d0 fs/open.c:1212
do_sys_open fs/open.c:1228 [inline]
__do_sys_openat fs/open.c:1244 [inline]
__se_sys_openat fs/open.c:1239 [inline]
__x64_sys_openat+0x13f/0x1f0 fs/open.c:1239
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:0x7f73f5903a04
RSP: 002b:00007f73f2ea4ed0 EFLAGS: 00000293 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 00007f73f599a970 RCX: 00007f73f5903a04
RDX: 0000000000000002 RSI: 00007f73f2ea5000 RDI: 00000000ffffff9c
RBP: 00007f73f2ea5000 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000002
R13: 0000000000000005 R14: 0000000020000548 R15: 0000000000000003
INFO: task syz-executor.2:11024 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:27216 pid:11024 ppid: 6535 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
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6400
__mutex_lock_common kernel/locking/mutex.c:680 [inline]
__mutex_lock+0xa32/0x12f0 kernel/locking/mutex.c:740
blkdev_get_by_dev.part.0+0x9b/0xb50 block/bdev.c:819
blkdev_get_by_dev+0x6b/0x80 block/bdev.c:859
blkdev_open+0x154/0x2e0 block/fops.c:501
do_dentry_open+0x4c8/0x1250 fs/open.c:822
do_open fs/namei.c:3426 [inline]
path_openat+0x1cad/0x2750 fs/namei.c:3559
do_filp_open+0x1aa/0x400 fs/namei.c:3586
do_sys_openat2+0x16d/0x4d0 fs/open.c:1212
do_sys_open fs/open.c:1228 [inline]
__do_sys_openat fs/open.c:1244 [inline]
__se_sys_openat fs/open.c:1239 [inline]
__x64_sys_openat+0x13f/0x1f0 fs/open.c:1239
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:0x7f73f5903a04
RSP: 002b:00007f73f2ea4ed0 EFLAGS: 00000293 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 00007f73f599a970 RCX: 00007f73f5903a04
RDX: 0000000000000002 RSI: 00007f73f2ea5000 RDI: 00000000ffffff9c
RBP: 00007f73f2ea5000 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000002
R13: 0000000000000005 R14: 0000000020000548 R15: 0000000000000003
Showing all locks held in the system:
1 lock held by khungtaskd/26:
#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/2971:
#0: ffff88801a534118 (&disk->open_mutex){+.+.}-{3:3}, at: blkdev_get_by_dev.part.0+0x9b/0xb50 block/bdev.c:819
#1: ffff888146e60b60 (&lo->lo_mutex){+.+.}-{3:3}, at: lo_open+0x75/0x120 drivers/block/loop.c:1733
1 lock held by in:imklog/6234:
#0: ffff88807741a370 (&f->f_pos_lock){+.+.}-{3:3}, at: __fdget_pos+0xe9/0x100 fs/file.c:990
1 lock held by syz-executor.2/11015:
#0: ffff888146e60b60 (&lo->lo_mutex){+.+.}-{3:3}, at: __loop_clr_fd+0x7a/0x1070 drivers/block/loop.c:1106
1 lock held by syz-executor.2/11024:
#0: ffff88801a534118 (&disk->open_mutex){+.+.}-{3:3}, at: blkdev_get_by_dev.part.0+0x9b/0xb50 block/bdev.c:819
=============================================
NMI backtrace for cpu 1
CPU: 1 PID: 26 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:check_preemption_disabled+0x2/0x170 lib/smp_processor_id.c:13
Code: 1f 44 00 00 e8 7f a0 5a f8 65 48 8b 3c 25 40 70 02 00 e8 a1 99 11 f8 eb 99 0f 1f 44 00 00 0f 0b e9 23 ff ff ff cc cc cc 41 56 <41> 55 49 89 f5 41 54 55 48 89 fd 53 0f 1f 44 00 00 65 44 8b 25 0d
RSP: 0018:ffffc9000208fde0 EFLAGS: 00000082
RAX: 0000000000000001 RBX: 0000000000000000 RCX: ffffffff815cb331
RDX: fffffbfff1b21cfb RSI: ffffffff8a04b620 RDI: ffffffff8a04b660
RBP: 1ffff92000411fc5 R08: 0000000000000000 R09: ffffffff8d90e7d7
R10: fffffbfff1b21cfa R11: 0000000000000001 R12: 0000000000000001
R13: ffff88807af7a4a0 R14: 0000000000000000 R15: 0000000000000000
FS: 00007ffa7673e8c0(0000) GS:ffff8880b9c00000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007ffa73bc5000 CR3: 0000000021d45000 CR4: 00000000003506f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
rcu_dynticks_curr_cpu_in_eqs kernel/rcu/tree.c:330 [inline]
rcu_is_watching+0xe/0xb0 kernel/rcu/tree.c:1121
rcu_read_lock_held_common kernel/rcu/update.c:108 [inline]
rcu_read_lock_sched_held+0x1c/0x70 kernel/rcu/update.c:123
trace_lock_release include/trace/events/lock.h:58 [inline]
lock_release+0x522/0x720 kernel/locking/lockdep.c:5648
do_write_seqcount_end include/linux/seqlock.h:565 [inline]
vtime_user_exit+0x12d/0x210 kernel/sched/cputime.c:726
__context_tracking_exit+0xb8/0xe0 kernel/context_tracking.c:160
user_exit_irqoff include/linux/context_tracking.h:47 [inline]
__enter_from_user_mode kernel/entry/common.c:22 [inline]
syscall_enter_from_user_mode+0x4c/0x70 kernel/entry/common.c:104
do_syscall_64+0x16/0xb0 arch/x86/entry/common.c:76
entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x7ffa759d6f17
Code: ff ff ff 48 8b 4d a0 0f b7 51 fe 48 8b 4d a8 66 89 54 08 fe e9 1a ff ff ff 66 2e 0f 1f 84 00 00 00 00 00 b8 27 00 00 00 0f 05 0f 1f 84 00 00 00 00 00 b8 6e 00 00 00 0f 05 c3 0f 1f 84 00 00
RSP: 002b:00007ffc6565e578 EFLAGS: 00000202 ORIG_RAX: 0000000000000027
RAX: ffffffffffffffda RBX: 000056154ea8e1e0 RCX: 00007ffa759d6f17
RDX: 0000000000000000 RSI: ffffffffffffffff RDI: 000056154ea8e1e0
RBP: 0000000000000b98 R08: 000000006198cfce R09: 00007ffc6572a080
R10: 00007ffc6572a080 R11: 0000000000000202 R12: ffffffffffffffff
R13: 00007ffc6565e608 R14: 000056154d4c4958 R15: 0005d135f8dc04e2
----------------
Code disassembly (best guess), 1 bytes skipped:
0: 44 00 00 add %r8b,(%rax)
3: e8 7f a0 5a f8 callq 0xf85aa087
8: 65 48 8b 3c 25 40 70 mov %gs:0x27040,%rdi
f: 02 00
11: e8 a1 99 11 f8 callq 0xf81199b7
16: eb 99 jmp 0xffffffb1
18: 0f 1f 44 00 00 nopl 0x0(%rax,%rax,1)
1d: 0f 0b ud2
1f: e9 23 ff ff ff jmpq 0xffffff47
24: cc int3
25: cc int3
26: cc int3
27: 41 56 push %r14
* 29: 41 55 push %r13 <-- trapping instruction
2b: 49 89 f5 mov %rsi,%r13
2e: 41 54 push %r12
30: 55 push %rbp
31: 48 89 fd mov %rdi,%rbp
34: 53 push %rbx
35: 0f 1f 44 00 00 nopl 0x0(%rax,%rax,1)
3a: 65 gs
3b: 44 rex.R
3c: 8b .byte 0x8b
3d: 25 .byte 0x25
3e: 0d .byte 0xd