INFO: rcu detected stall in kvm_tdp_page_fault

Status: auto-obsoleted due to no activity on 2024/09/25 13:23
Subsystems: kvm-x86
[Documentation on labels]
First crash: 817d, last: 817d

Sample crash report:
rcu: INFO: rcu_preempt detected stalls on CPUs/tasks:
rcu: 	Tasks blocked on level-0 rcu_node (CPUs 0-1): P4750/1:b..l P10691/1:b..l
rcu: 	(detected by 1, t=10502 jiffies, g=48465, q=111 ncpus=2)
task:syz.3.1491      state:R  running task     stack:27552 pid:10691 tgid:10662 ppid:7481   flags:0x00000000
Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5408 [inline]
 __schedule+0xf15/0x5d00 kernel/sched/core.c:6745
 preempt_schedule_irq+0x51/0x90 kernel/sched/core.c:7067
 irqentry_exit+0x36/0x90 kernel/entry/common.c:354
 asm_sysvec_apic_timer_interrupt+0x1a/0x20 arch/x86/include/asm/idtentry.h:702
RIP: 0010:check_kcov_mode kernel/kcov.c:173 [inline]
RIP: 0010:__sanitizer_cov_trace_pc+0x13/0x60 kernel/kcov.c:207
Code: 1f 84 00 00 00 00 00 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 f3 0f 1e fa 65 48 8b 15 74 f3 75 7e 65 8b 05 75 f3 75 7e <a9> 00 01 ff 00 48 8b 34 24 74 0f f6 c4 01 74 35 8b 82 1c 16 00 00
RSP: 0018:ffffc9000338f660 EFLAGS: 00000286
RAX: 0000000080000000 RBX: 000000006d435000 RCX: ffffffff813e31d0
RDX: ffff8880251c0000 RSI: ffff8880ed435000 RDI: 0000000000000006
RBP: ffff8880ed435000 R08: 0000000000000006 R09: ffff8880ed435000
R10: 000000006d435000 R11: 0000000000000002 R12: 0000000000000000
R13: 0000000000000000 R14: 8000000073463975 R15: 1ffff92000671ed8
 phys_addr_valid arch/x86/mm/physaddr.h:7 [inline]
 __phys_addr+0x5a/0x150 arch/x86/mm/physaddr.c:28
 sptep_to_sp arch/x86/kvm/mmu/spte.h:255 [inline]
 fast_page_fault+0x21d/0x1240 arch/x86/kvm/mmu/mmu.c:3446
 kvm_tdp_mmu_page_fault arch/x86/kvm/mmu/mmu.c:4597 [inline]
 kvm_tdp_page_fault+0x324/0x5a0 arch/x86/kvm/mmu/mmu.c:4658
 kvm_mmu_do_page_fault+0x5ca/0x850 arch/x86/kvm/mmu/mmu_internal.h:330
 kvm_mmu_page_fault+0x1ee/0x1770 arch/x86/kvm/mmu/mmu.c:5889
 handle_ept_violation+0x27a/0x600 arch/x86/kvm/vmx/vmx.c:5805
 __vmx_handle_exit arch/x86/kvm/vmx/vmx.c:6625 [inline]
 vmx_handle_exit+0x6ee/0x1dc0 arch/x86/kvm/vmx/vmx.c:6642
 vcpu_enter_guest arch/x86/kvm/x86.c:11147 [inline]
 vcpu_run+0x2f10/0x4e60 arch/x86/kvm/x86.c:11251
 kvm_arch_vcpu_ioctl_run+0x42e/0x1680 arch/x86/kvm/x86.c:11477
 kvm_vcpu_ioctl+0x5a1/0x1090 arch/x86/kvm/../../../virt/kvm/kvm_main.c:4424
 vfs_ioctl fs/ioctl.c:51 [inline]
 __do_sys_ioctl fs/ioctl.c:907 [inline]
 __se_sys_ioctl fs/ioctl.c:893 [inline]
 __x64_sys_ioctl+0x193/0x220 fs/ioctl.c:893
 do_syscall_x64 arch/x86/entry/common.c:52 [inline]
 do_syscall_64+0xcd/0x250 arch/x86/entry/common.c:83
 entry_SYSCALL_64_after_hwframe+0x77/0x7f
RIP: 0033:0x7fd685b75ae9
RSP: 002b:00007fd6868e9048 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 00007fd685d04140 RCX: 00007fd685b75ae9
RDX: 0000000000000000 RSI: 000000000000ae80 RDI: 0000000000000008
RBP: 00007fd685bf6756 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 000000000000006e R14: 00007fd685d04140 R15: 00007ffdb858ab08
 </TASK>
task:dhcpcd          state:R  running task     stack:22904 pid:4750  tgid:4750  ppid:4749   flags:0x00000002
Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5408 [inline]
 __schedule+0xf15/0x5d00 kernel/sched/core.c:6745
 preempt_schedule_common+0x44/0xc0 kernel/sched/core.c:6924
 preempt_schedule_thunk+0x1a/0x30 arch/x86/entry/thunk.S:12
 __raw_spin_unlock_irqrestore include/linux/spinlock_api_smp.h:152 [inline]
 _raw_spin_unlock_irqrestore+0x61/0x80 kernel/locking/spinlock.c:194
 sock_def_readable+0x160/0x610 net/core/sock.c:3353
 unix_dgram_sendmsg+0xfc6/0x1a60 net/unix/af_unix.c:2116
 sock_sendmsg_nosec net/socket.c:730 [inline]
 __sock_sendmsg net/socket.c:745 [inline]
 sock_write_iter+0x50a/0x5c0 net/socket.c:1160
 do_iter_readv_writev+0x504/0x780 fs/read_write.c:741
 vfs_writev+0x36f/0xde0 fs/read_write.c:971
 do_writev+0x287/0x370 fs/read_write.c:1018
 do_syscall_x64 arch/x86/entry/common.c:52 [inline]
 do_syscall_64+0xcd/0x250 arch/x86/entry/common.c:83
 entry_SYSCALL_64_after_hwframe+0x77/0x7f
RIP: 0033:0x7f54ba944e03
RSP: 002b:00007ffff9b75598 EFLAGS: 00000246 ORIG_RAX: 0000000000000014
RAX: ffffffffffffffda RBX: 00007f54ba8766c0 RCX: 00007f54ba944e03
RDX: 0000000000000002 RSI: 00007ffff9b755e0 RDI: 000000000000000b
RBP: 00007ffff9b95948 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffff9b85788 R14: 00007ffff9b75608 R15: 0000000000000000
 </TASK>
rcu: rcu_preempt kthread starved for 10568 jiffies! g48465 f0x0 RCU_GP_WAIT_FQS(5) ->state=0x0 ->cpu=1
rcu: 	Unless rcu_preempt kthread gets sufficient CPU time, OOM is now expected behavior.
rcu: RCU grace-period kthread stack dump:
task:rcu_preempt     state:R  running task     stack:26336 pid:17    tgid:17    ppid:2      flags:0x00004000
Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5408 [inline]
 __schedule+0xf15/0x5d00 kernel/sched/core.c:6745
 __schedule_loop kernel/sched/core.c:6822 [inline]
 schedule+0xe7/0x350 kernel/sched/core.c:6837
 schedule_timeout+0x136/0x2a0 kernel/time/timer.c:2581
 rcu_gp_fqs_loop+0x1eb/0xb00 kernel/rcu/tree.c:2000
 rcu_gp_kthread+0x271/0x380 kernel/rcu/tree.c:2202
 kthread+0x2c1/0x3a0 kernel/kthread.c:389
 ret_from_fork+0x45/0x80 arch/x86/kernel/process.c:147
 ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:244
 </TASK>
rcu: Stack dump where RCU GP kthread last ran:
CPU: 1 PID: 0 Comm: swapper/1 Not tainted 6.10.0-rc5-syzkaller-00021-g24ca36a562d6 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 06/07/2024
RIP: 0010:native_irq_disable arch/x86/include/asm/irqflags.h:37 [inline]
RIP: 0010:arch_local_irq_disable arch/x86/include/asm/irqflags.h:72 [inline]
RIP: 0010:acpi_safe_halt+0x1a/0x20 drivers/acpi/processor_idle.c:113
Code: 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 65 48 8b 05 d8 73 1c 75 48 8b 00 a8 08 75 0c 66 90 0f 00 2d a8 d1 b3 00 fb f4 <fa> c3 cc cc cc cc 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90
RSP: 0018:ffffc900001a7d58 EFLAGS: 00000246
RAX: 0000000000004000 RBX: 0000000000000001 RCX: ffffffff8ae74849
RDX: 0000000000000001 RSI: ffff88801a2bb000 RDI: ffff88801a2bb064
RBP: ffff88801a2bb064 R08: 0000000000000001 R09: ffffed1017266fdd
R10: ffff8880b9337eeb R11: 0000000000000000 R12: ffff88801b701000
R13: ffffffff8e7429e0 R14: 0000000000000001 R15: 0000000000000000
FS:  0000000000000000(0000) GS:ffff8880b9300000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000001b31ad2ff8 CR3: 0000000023a40000 CR4: 00000000003526f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 <IRQ>
 </IRQ>
 <TASK>
 acpi_idle_enter+0xc5/0x160 drivers/acpi/processor_idle.c:707
 cpuidle_enter_state+0x85/0x500 drivers/cpuidle/cpuidle.c:267
 cpuidle_enter+0x4e/0xa0 drivers/cpuidle/cpuidle.c:388
 cpuidle_idle_call kernel/sched/idle.c:236 [inline]
 do_idle+0x313/0x3f0 kernel/sched/idle.c:332
 cpu_startup_entry+0x4f/0x60 kernel/sched/idle.c:430
 start_secondary+0x220/0x2b0 arch/x86/kernel/smpboot.c:313
 common_startup_64+0x13e/0x148
 </TASK>

Crashes (1):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2024/06/27 13:16 upstream 24ca36a562d6 5c045c04 .config console log report info [disk image] [vmlinux] [kernel image] ci-upstream-kasan-gce-selinux-root INFO: rcu detected stall in kvm_tdp_page_fault
* Struck through repros no longer work on HEAD.