INFO: task systemd-udevd:2969 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:systemd-udevd state:D stack:22616 pid: 2969 ppid: 1 flags:0x00000000
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_open fs/open.c:1236 [inline]
__se_sys_open fs/open.c:1232 [inline]
__x64_sys_open+0x119/0x1c0 fs/open.c:1232
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:0x7fe8db5cc840
RSP: 002b:00007ffca3873b18 EFLAGS: 00000246 ORIG_RAX: 0000000000000002
RAX: ffffffffffffffda RBX: 00007ffca3873be0 RCX: 00007fe8db5cc840
RDX: 00005559d9ac6fe3 RSI: 00000000000a0800 RDI: 00005559da5183d0
RBP: 00007ffca3874100 R08: 00005559d9ac6670 R09: 0000000000000010
R10: 0000000000000120 R11: 0000000000000246 R12: 00007ffca3873cc0
R13: 00005559d9c3d010 R14: 00005559d9e52b10 R15: 00007ffca3873b90
INFO: task syz-executor.4:15648 can't die for more than 143 seconds.
task:syz-executor.4 state:D stack:27480 pid:15648 ppid: 12381 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:0x7f15083388a7
RSP: 002b:00007f15058adfa8 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 0000000020000200 RCX: 00007f15083388a7
RDX: 0000000000000000 RSI: 0000000000004c01 RDI: 0000000000000004
RBP: 00007f15058ae6bc R08: 00007f15058ae040 R09: 0000000020000000
R10: 0000000000000000 R11: 0000000000000246 R12: ffffffffffffffff
R13: 0000000000000016 R14: 00007f15058ae000 R15: 0000000020064f00
INFO: task syz-executor.4:15648 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:27480 pid:15648 ppid: 12381 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:0x7f15083388a7
RSP: 002b:00007f15058adfa8 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 0000000020000200 RCX: 00007f15083388a7
RDX: 0000000000000000 RSI: 0000000000004c01 RDI: 0000000000000004
RBP: 00007f15058ae6bc R08: 00007f15058ae040 R09: 0000000020000000
R10: 0000000000000000 R11: 0000000000000246 R12: ffffffffffffffff
R13: 0000000000000016 R14: 00007f15058ae000 R15: 0000000020064f00
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
1 lock held by systemd-udevd/2969:
#0: ffff88801abca918 (&disk->open_mutex){+.+.}-{3:3}, at: blkdev_get_by_dev.part.0+0x9b/0xb50 block/bdev.c:819
1 lock held by in:imklog/6381:
#0: ffff8880204e6370 (&f->f_pos_lock){+.+.}-{3:3}, at: __fdget_pos+0xe9/0x100 fs/file.c:990
2 locks held by agetty/6457:
#0: ffff88801a84c098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:252
#1: ffffc90001a8c2e8 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0xcf0/0x1230 drivers/tty/n_tty.c:2113
2 locks held by systemd-udevd/15744:
#0: ffff88801abca918 (&disk->open_mutex){+.+.}-{3:3}, at: blkdev_get_by_dev.part.0+0x9b/0xb50 block/bdev.c:819
#1: ffff88801abbe360 (&lo->lo_mutex){+.+.}-{3:3}, at: lo_open+0x75/0x120 drivers/block/loop.c:1733
1 lock held by syz-executor.4/15648:
#0: ffff88801abbe360 (&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: 2955 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:strlen+0x54/0x90 lib/string.c:487
Code: 75 48 80 7d 00 00 74 39 48 bb 00 00 00 00 00 fc ff df 48 89 e8 48 83 c0 01 48 89 c2 48 89 c1 48 c1 ea 03 83 e1 07 0f b6 14 1a <38> ca 7f 04 84 d2 75 1f 80 38 00 75 de 48 83 c4 08 48 29 e8 5b 5d
RSP: 0018:ffffc90001b0fae8 EFLAGS: 00000002
RAX: ffffffff8b38df2a RBX: dffffc0000000000 RCX: 0000000000000002
RDX: 0000000000000000 RSI: ffff888010c409d8 RDI: ffffffff8b38df28
RBP: ffffffff8b38df28 R08: 0000000000000000 R09: ffffffff8d90e7d7
R10: fffffbfff1b21cfa R11: 0000000000000001 R12: ffff888010c409d8
R13: ffffffff8ba80ea0 R14: ffff888010c409d8 R15: ffffc90001b0fbb8
FS: 00007f8ddf95f8c0(0000) GS:ffff8880b9c00000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f8ddc7cd000 CR3: 0000000022734000 CR4: 00000000003506f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
strlen include/linux/fortify-string.h:102 [inline]
trace_event_get_offsets_lock include/trace/events/lock.h:39 [inline]
perf_trace_lock+0xb1/0x4d0 include/trace/events/lock.h:39
trace_lock_release include/trace/events/lock.h:58 [inline]
lock_release+0x4a8/0x720 kernel/locking/lockdep.c:5648
__raw_spin_unlock_irqrestore include/linux/spinlock_api_smp.h:149 [inline]
_raw_spin_unlock_irqrestore+0x16/0x70 kernel/locking/spinlock.c:194
spin_unlock_irqrestore include/linux/spinlock.h:409 [inline]
__unfreeze_partials+0x31f/0x360 mm/slub.c:2520
qlink_free mm/kasan/quarantine.c:146 [inline]
qlist_free_all+0x5a/0xc0 mm/kasan/quarantine.c:165
kasan_quarantine_reduce+0x180/0x200 mm/kasan/quarantine.c:272
__kasan_slab_alloc+0xa2/0xc0 mm/kasan/common.c:444
kasan_slab_alloc include/linux/kasan.h:259 [inline]
slab_post_alloc_hook mm/slab.h:519 [inline]
slab_alloc_node mm/slub.c:3234 [inline]
slab_alloc mm/slub.c:3242 [inline]
kmem_cache_alloc+0x202/0x3a0 mm/slub.c:3247
prepare_creds+0x3f/0x7b0 kernel/cred.c:260
access_override_creds fs/open.c:351 [inline]
do_faccessat+0x3f4/0x850 fs/open.c:415
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:0x7f8ddec1a9c7
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:00007fffafae2cd8 EFLAGS: 00000246 ORIG_RAX: 0000000000000015
RAX: ffffffffffffffda RBX: 00007fffafae5d00 RCX: 00007f8ddec1a9c7
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000555af62c59a3
RBP: 00007fffafae2e20 R08: 0000555af62bb3e5 R09: 0000000000000018
R10: 0000000000000069 R11: 0000000000000246 R12: 0000000000000000
R13: 0000000000000000 R14: 0000555af78d08a0 R15: 00007fffafae3310
----------------
Code disassembly (best guess):
0: 75 48 jne 0x4a
2: 80 7d 00 00 cmpb $0x0,0x0(%rbp)
6: 74 39 je 0x41
8: 48 bb 00 00 00 00 00 movabs $0xdffffc0000000000,%rbx
f: fc ff df
12: 48 89 e8 mov %rbp,%rax
15: 48 83 c0 01 add $0x1,%rax
19: 48 89 c2 mov %rax,%rdx
1c: 48 89 c1 mov %rax,%rcx
1f: 48 c1 ea 03 shr $0x3,%rdx
23: 83 e1 07 and $0x7,%ecx
26: 0f b6 14 1a movzbl (%rdx,%rbx,1),%edx
* 2a: 38 ca cmp %cl,%dl <-- trapping instruction
2c: 7f 04 jg 0x32
2e: 84 d2 test %dl,%dl
30: 75 1f jne 0x51
32: 80 38 00 cmpb $0x0,(%rax)
35: 75 de jne 0x15
37: 48 83 c4 08 add $0x8,%rsp
3b: 48 29 e8 sub %rbp,%rax
3e: 5b pop %rbx
3f: 5d pop %rbp