INFO: task systemd-udevd:8977 blocked for more than 143 seconds.
Not tainted 5.15.0-rc6-next-20211022-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:systemd-udevd state:D stack:25208 pid: 8977 ppid: 2977 flags:0x00004000
Call Trace:
context_switch kernel/sched/core.c:4965 [inline]
__schedule+0xa9a/0x4940 kernel/sched/core.c:6246
schedule+0xd2/0x260 kernel/sched/core.c:6319
io_schedule+0xee/0x170 kernel/sched/core.c:8364
folio_wait_bit_common+0x4f2/0xa60 mm/filemap.c:1364
folio_wait_bit mm/filemap.c:1424 [inline]
folio_wait_locked include/linux/pagemap.h:802 [inline]
folio_wait_locked include/linux/pagemap.h:799 [inline]
wait_on_page_locked include/linux/pagemap.h:814 [inline]
wait_on_page_read mm/filemap.c:3424 [inline]
do_read_cache_page+0x986/0x11a0 mm/filemap.c:3467
read_mapping_page include/linux/pagemap.h:602 [inline]
read_part_sector+0xf6/0x5b0 block/partitions/core.c:727
adfspart_check_ICS+0x9d/0xc90 block/partitions/acorn.c:360
check_partition block/partitions/core.c:149 [inline]
blk_add_partitions block/partitions/core.c:612 [inline]
bdev_disk_changed+0x759/0x1100 block/partitions/core.c:698
blkdev_get_whole+0x206/0x2d0 block/bdev.c:683
blkdev_get_by_dev.part.0+0x354/0xb50 block/bdev.c:825
blkdev_get_by_dev+0x6b/0x80 block/bdev.c:858
blkdev_open+0x154/0x2e0 block/fops.c:434
do_dentry_open+0x4c8/0x11d0 fs/open.c:822
do_open fs/namei.c:3428 [inline]
path_openat+0x1c9a/0x2740 fs/namei.c:3561
do_filp_open+0x1aa/0x400 fs/namei.c:3588
do_sys_openat2+0x16d/0x4d0 fs/open.c:1200
do_sys_open fs/open.c:1216 [inline]
__do_sys_open fs/open.c:1224 [inline]
__se_sys_open fs/open.c:1220 [inline]
__x64_sys_open+0x119/0x1c0 fs/open.c:1220
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:0x7f44ecd02840
RSP: 002b:00007ffd72c553a8 EFLAGS: 00000246 ORIG_RAX: 0000000000000002
RAX: ffffffffffffffda RBX: 0000556cfdf74870 RCX: 00007f44ecd02840
RDX: 0000556cfc644fe3 RSI: 00000000000a0800 RDI: 0000556cfdf69c40
RBP: 00007ffd72c55520 R08: 0000556cfc644670 R09: 0000000000000010
R10: 0000556cfc644d0c R11: 0000000000000246 R12: 00007ffd72c55470
R13: 0000556cfdf798e0 R14: 0000000000000003 R15: 000000000000000e
INFO: task syz-executor.4:9887 can't die for more than 143 seconds.
task:syz-executor.4 state:D stack:28128 pid: 9887 ppid: 6588 flags:0x00000004
Call Trace:
context_switch kernel/sched/core.c:4965 [inline]
__schedule+0xa9a/0x4940 kernel/sched/core.c:6246
schedule+0xd2/0x260 kernel/sched/core.c:6319
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6378
__mutex_lock_common kernel/locking/mutex.c:680 [inline]
__mutex_lock+0xa32/0x12f0 kernel/locking/mutex.c:740
blkdev_put+0x97/0x9e0 block/bdev.c:913
blkdev_close+0x6a/0x80 block/fops.c:448
__fput+0x286/0x9f0 fs/file_table.c:280
task_work_run+0xdd/0x1a0 kernel/task_work.c:164
tracehook_notify_resume include/linux/tracehook.h:189 [inline]
exit_to_user_mode_loop kernel/entry/common.c:175 [inline]
exit_to_user_mode_prepare+0x27e/0x290 kernel/entry/common.c:207
__syscall_exit_to_user_mode_work kernel/entry/common.c:289 [inline]
syscall_exit_to_user_mode+0x19/0x60 kernel/entry/common.c:300
do_syscall_64+0x42/0xb0 arch/x86/entry/common.c:86
entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x7f1e8590567b
RSP: 002b:00007ffc7d6fb3a0 EFLAGS: 00000293 ORIG_RAX: 0000000000000003
RAX: 0000000000000000 RBX: 0000000000000004 RCX: 00007f1e8590567b
RDX: 0000001b2f12b13c RSI: 00007f1e857176c0 RDI: 0000000000000003
RBP: 0000000000000001 R08: 0000000000000000 R09: 0000001b2f128cc8
R10: 00000000000004e1 R11: 0000000000000293 R12: 00007f1e85a56b60
R13: 00007f1e85a56b60 R14: 00007f1e85a55f60 R15: 00000000001f1aeb
INFO: task syz-executor.4:9887 blocked for more than 143 seconds.
Not tainted 5.15.0-rc6-next-20211022-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.4 state:D stack:28128 pid: 9887 ppid: 6588 flags:0x00000004
Call Trace:
context_switch kernel/sched/core.c:4965 [inline]
__schedule+0xa9a/0x4940 kernel/sched/core.c:6246
schedule+0xd2/0x260 kernel/sched/core.c:6319
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6378
__mutex_lock_common kernel/locking/mutex.c:680 [inline]
__mutex_lock+0xa32/0x12f0 kernel/locking/mutex.c:740
blkdev_put+0x97/0x9e0 block/bdev.c:913
blkdev_close+0x6a/0x80 block/fops.c:448
__fput+0x286/0x9f0 fs/file_table.c:280
task_work_run+0xdd/0x1a0 kernel/task_work.c:164
tracehook_notify_resume include/linux/tracehook.h:189 [inline]
exit_to_user_mode_loop kernel/entry/common.c:175 [inline]
exit_to_user_mode_prepare+0x27e/0x290 kernel/entry/common.c:207
__syscall_exit_to_user_mode_work kernel/entry/common.c:289 [inline]
syscall_exit_to_user_mode+0x19/0x60 kernel/entry/common.c:300
do_syscall_64+0x42/0xb0 arch/x86/entry/common.c:86
entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x7f1e8590567b
RSP: 002b:00007ffc7d6fb3a0 EFLAGS: 00000293 ORIG_RAX: 0000000000000003
RAX: 0000000000000000 RBX: 0000000000000004 RCX: 00007f1e8590567b
RDX: 0000001b2f12b13c RSI: 00007f1e857176c0 RDI: 0000000000000003
RBP: 0000000000000001 R08: 0000000000000000 R09: 0000001b2f128cc8
R10: 00000000000004e1 R11: 0000000000000293 R12: 00007f1e85a56b60
R13: 00007f1e85a56b60 R14: 00007f1e85a55f60 R15: 00000000001f1aeb
Showing all locks held in the system:
1 lock held by khungtaskd/27:
#0: ffffffff8bb83460 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x53/0x260 kernel/locking/lockdep.c:6458
1 lock held by in:imklog/6248:
#0: ffff88807b6d8af0 (&f->f_pos_lock){+.+.}-{3:3}, at: __fdget_pos+0xe9/0x100 fs/file.c:990
2 locks held by systemd-udevd/8726:
1 lock held by systemd-udevd/8977:
#0: ffff88801a6f2118 (&disk->open_mutex){+.+.}-{3:3}, at: blkdev_get_by_dev.part.0+0x9b/0xb50 block/bdev.c:818
1 lock held by syz-executor.4/9887:
#0: ffff88801a6f2118 (&disk->open_mutex){+.+.}-{3:3}, at: blkdev_put+0x97/0x9e0 block/bdev.c:913
=============================================
NMI backtrace for cpu 1
CPU: 1 PID: 27 Comm: khungtaskd Not tainted 5.15.0-rc6-next-20211022-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:105
nmi_trigger_cpumask_backtrace+0x1ae/0x220 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: 30 Comm: kcompactd0 Not tainted 5.15.0-rc6-next-20211022-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
RIP: 0010:account_system_time+0x54/0xb0 kernel/sched/cputime.c:194
Code: e0 07 83 c0 03 38 d0 7c 04 84 d2 75 5d f6 45 2c 01 74 10 65 8b 05 0c af af 7e 25 00 ff ff 00 39 c6 74 35 65 8b 05 fc ae af 7e <89> c1 ba 04 00 00 00 81 e1 00 00 0f 00 39 ce 75 0b 31 d2 f6 c4 01
RSP: 0018:ffffc90000e5fab0 EFLAGS: 00000046
RAX: 0000000080000002 RBX: ffff88801ba00720 RCX: 1ffff110037400ed
RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffff88801ba0002c
RBP: ffff88801ba00000 R08: 0000000000000000 R09: ffffffff8f14500f
R10: ffffffff8f145017 R11: 0000000000000001 R12: 0000000001ceda9f
R13: ffff88801ba00728 R14: ffff88801ba00758 R15: ffff8880b9c39a80
FS: 0000000000000000(0000) GS:ffff8880b9c00000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000556cff7962a8 CR3: 000000000b88e000 CR4: 00000000003506f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
vtime_account_system+0x63/0xb0 kernel/sched/cputime.c:668
__vtime_account_kernel kernel/sched/cputime.c:690 [inline]
vtime_task_switch_generic+0xfa/0x5a0 kernel/sched/cputime.c:772
vtime_task_switch include/linux/vtime.h:95 [inline]
finish_task_switch.isra.0+0x6b4/0xb60 kernel/sched/core.c:4827
context_switch kernel/sched/core.c:4968 [inline]
__schedule+0xaa2/0x4940 kernel/sched/core.c:6246
schedule+0xd2/0x260 kernel/sched/core.c:6319
schedule_timeout+0x14a/0x2a0 kernel/time/timer.c:1881
freezable_schedule_timeout include/linux/freezer.h:192 [inline]
kcompactd+0xa5d/0xf30 mm/compaction.c:2936
kthread+0x405/0x4f0 kernel/kthread.c:327
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295
----------------
Code disassembly (best guess):
0: e0 07 loopne 0x9
2: 83 c0 03 add $0x3,%eax
5: 38 d0 cmp %dl,%al
7: 7c 04 jl 0xd
9: 84 d2 test %dl,%dl
b: 75 5d jne 0x6a
d: f6 45 2c 01 testb $0x1,0x2c(%rbp)
11: 74 10 je 0x23
13: 65 8b 05 0c af af 7e mov %gs:0x7eafaf0c(%rip),%eax # 0x7eafaf26
1a: 25 00 ff ff 00 and $0xffff00,%eax
1f: 39 c6 cmp %eax,%esi
21: 74 35 je 0x58
23: 65 8b 05 fc ae af 7e mov %gs:0x7eafaefc(%rip),%eax # 0x7eafaf26
* 2a: 89 c1 mov %eax,%ecx <-- trapping instruction
2c: ba 04 00 00 00 mov $0x4,%edx
31: 81 e1 00 00 0f 00 and $0xf0000,%ecx
37: 39 ce cmp %ecx,%esi
39: 75 0b jne 0x46
3b: 31 d2 xor %edx,%edx
3d: f6 c4 01 test $0x1,%ah