audit: type=1804 audit(1677961172.083:210): pid=22210 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=invalid_pcr cause=ToMToU comm="syz-executor.3" name="/root/syzkaller-testdir3351815771/syzkaller.7KHKUP/74/bus" dev="sda1" ino=14002 res=1 INFO: task syz-executor.3:17574 blocked for more than 140 seconds. Not tainted 4.19.211-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.3 D26152 17574 8133 0x00000004 Call Trace: context_switch kernel/sched/core.c:2828 [inline] __schedule+0x887/0x2040 kernel/sched/core.c:3517 schedule+0x8d/0x1b0 kernel/sched/core.c:3561 xlog_grant_head_wait+0x13b/0xcd0 fs/xfs/xfs_log.c:263 xlog_grant_head_check+0x3c8/0x420 fs/xfs/xfs_log.c:325 xfs_log_reserve+0x347/0xa70 fs/xfs/xfs_log.c:454 xfs_trans_reserve+0x63a/0x9c0 fs/xfs/xfs_trans.c:197 xfs_trans_alloc+0x2f7/0x700 fs/xfs/xfs_trans.c:289 xlog_finish_defer_ops fs/xfs/xfs_log_recover.c:4841 [inline] xlog_recover_process_intents+0x274/0x430 fs/xfs/xfs_log_recover.c:4947 xlog_recover_finish+0x5f/0x230 fs/xfs/xfs_log_recover.c:5839 xfs_log_mount_finish+0x135/0x450 fs/xfs/xfs_log.c:778 xfs_mountfs+0x1032/0x1bf0 fs/xfs/xfs_mount.c:974 xfs_fs_fill_super+0xd0e/0x1540 fs/xfs/xfs_super.c:1720 mount_bdev+0x2fc/0x3b0 fs/super.c:1158 mount_fs+0xa3/0x310 fs/super.c:1261 vfs_kern_mount.part.0+0x68/0x470 fs/namespace.c:961 vfs_kern_mount fs/namespace.c:951 [inline] do_new_mount fs/namespace.c:2492 [inline] do_mount+0x115c/0x2f50 fs/namespace.c:2822 ksys_mount+0xcf/0x130 fs/namespace.c:3038 __do_sys_mount fs/namespace.c:3052 [inline] __se_sys_mount fs/namespace.c:3049 [inline] __x64_sys_mount+0xba/0x150 fs/namespace.c:3049 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x7f219db8062a Code: Bad RIP value. RSP: 002b:00007f219c0f0f88 EFLAGS: 00000202 ORIG_RAX: 00000000000000a5 RAX: ffffffffffffffda RBX: 000000000000acf4 RCX: 00007f219db8062a RDX: 0000000020000080 RSI: 00000000200000c0 RDI: 00007f219c0f0fe0 RBP: 00007f219c0f1020 R08: 00007f219c0f1020 R09: 0000000001000003 R10: 0000000001000003 R11: 0000000000000202 R12: 0000000020000080 R13: 00000000200000c0 R14: 00007f219c0f0fe0 R15: 00000000200002c0 Showing all locks held in the system: 1 lock held by khungtaskd/1570: #0: 0000000043391921 (rcu_read_lock){....}, at: debug_show_all_locks+0x53/0x265 kernel/locking/lockdep.c:4441 1 lock held by in:imklog/7811: #0: 00000000496011c8 (&f->f_pos_lock){+.+.}, at: __fdget_pos+0x26f/0x310 fs/file.c:767 5 locks held by kworker/u4:5/8656: 2 locks held by syz-executor.3/17574: #0: 00000000d3fafafa (&type->s_umount_key#73/1){+.+.}, at: alloc_super fs/super.c:226 [inline] #0: 00000000d3fafafa (&type->s_umount_key#73/1){+.+.}, at: sget_userns+0x20b/0xcd0 fs/super.c:519 #1: 000000008a749cca (sb_internal#4){.+.+}, at: sb_start_intwrite include/linux/fs.h:1626 [inline] #1: 000000008a749cca (sb_internal#4){.+.+}, at: xfs_trans_alloc+0x4fc/0x700 fs/xfs/xfs_trans.c:271 2 locks held by syz-executor.1/22159: ============================================= NMI backtrace for cpu 1 CPU: 1 PID: 1570 Comm: khungtaskd Not tainted 4.19.211-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 03/02/2023 Call Trace: __dump_stack lib/dump_stack.c:77 [inline] dump_stack+0x1fc/0x2ef lib/dump_stack.c:118 nmi_cpu_backtrace.cold+0x63/0xa2 lib/nmi_backtrace.c:101 nmi_trigger_cpumask_backtrace+0x1a6/0x1f0 lib/nmi_backtrace.c:62 trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline] check_hung_uninterruptible_tasks kernel/hung_task.c:203 [inline] watchdog+0x991/0xe60 kernel/hung_task.c:287 kthread+0x33f/0x460 kernel/kthread.c:259 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415 Sending NMI from CPU 1 to CPUs 0: NMI backtrace for cpu 0 CPU: 0 PID: 4691 Comm: systemd-journal Not tainted 4.19.211-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 03/02/2023 RIP: 0010:__sanitizer_cov_trace_pc+0x0/0x50 kernel/kcov.c:97 Code: ff 48 89 df e8 11 dd 35 00 e9 ab fe ff ff 4c 89 ef e8 04 dd 35 00 e9 23 fe ff ff 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 <48> 8b 34 24 65 48 8b 04 25 c0 df 01 00 65 8b 15 cc 59 9f 7e 81 e2 RSP: 0018:ffff8880a0e473a0 EFLAGS: 00000046 RAX: 0000000000000000 RBX: 0000000000000000 RCX: ffffffff816538dc RDX: 0000000000000000 RSI: ffff8880a0e3a540 RDI: 0000000000000005 RBP: 0000000000000002 R08: ffff8880ba027720 R09: 0000000000000000 R10: 0000000000000005 R11: 0000000000000000 R12: ffffe8ffffcd8000 R13: 0000000000000000 R14: 0000000000001201 R15: 0000000000000000 FS: 00007f51f6f678c0(0000) GS:ffff8880ba000000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007f51f4478018 CR3: 00000000a3235000 CR4: 00000000003406f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: tracing_generic_entry_update+0x10b/0x200 kernel/trace/trace.c:2159 perf_trace_buf_update+0x5d/0xb0 kernel/trace/trace_event_perf.c:422 perf_tp_event+0x15a/0xaa0 kernel/events/core.c:8435 perf_trace_run_bpf_submit+0x144/0x220 kernel/events/core.c:8413 perf_trace_lock_acquire+0x36b/0x530 include/trace/events/lock.h:13 trace_lock_acquire include/trace/events/lock.h:13 [inline] lock_acquire+0x298/0x3c0 kernel/locking/lockdep.c:3907 __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline] _raw_spin_lock_irqsave+0x8c/0xc0 kernel/locking/spinlock.c:152 rmqueue mm/page_alloc.c:3024 [inline] get_page_from_freelist+0x1269/0x4170 mm/page_alloc.c:3373 __alloc_pages_nodemask+0x387/0x2890 mm/page_alloc.c:4399 __alloc_pages include/linux/gfp.h:496 [inline] __alloc_pages_node include/linux/gfp.h:509 [inline] kmem_getpages mm/slab.c:1412 [inline] cache_grow_begin+0xa4/0x8a0 mm/slab.c:2682 cache_alloc_refill+0x273/0x340 mm/slab.c:3049 ____cache_alloc mm/slab.c:3132 [inline] __do_cache_alloc mm/slab.c:3354 [inline] slab_alloc mm/slab.c:3389 [inline] kmem_cache_alloc+0x346/0x370 mm/slab.c:3557 getname_flags+0xce/0x590 fs/namei.c:140 user_path_at_empty+0x2a/0x50 fs/namei.c:2609 user_path_at include/linux/namei.h:57 [inline] do_faccessat+0x248/0x7a0 fs/open.c:397 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x7f51f62229c7 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:00007ffe308b2898 EFLAGS: 00000246 ORIG_RAX: 0000000000000015 RAX: ffffffffffffffda RBX: 00007ffe308b58c0 RCX: 00007f51f62229c7 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000555c1e4589a3 RBP: 00007ffe308b29e0 R08: 0000555c1e44e3e5 R09: 0000000000000018 R10: 0000000000000069 R11: 0000000000000246 R12: 0000000000000000 R13: 0000000000000000 R14: 0000555c1e5da8a0 R15: 00007ffe308b2ed0