#22185 new defect
BUG: scheduling while atomic: VMPwrUp/153655/0x00000000
| 回報者: | VirtualBarista | 負責人: | |
|---|---|---|---|
| 元件: | host support | 版本: | VirtualBox-7.0.20 |
| 關鍵字: | 副本: | ||
| Guest type: | Linux | Host type: | Linux |
描述 (由 作最後更新)
Hello everyone,
I'm using Fedora 40 with VirtualBox 7.0.20 as a host and my guest VMs are a wide range of Linux distros (Oracle, Alma, Rocky).
On first boot of the host system, everything appears fine, VMs boot fine. Eventually, after a few hours of use, VirtualBox stops working and NO VMs can boot.
The VMs report the following error:
VBoxManage: error: Out of memory condition when allocating memory with low physical backing. (VERR_NO_LOW_MEMORY) VBoxManage: error: Details: code NS_ERROR_FAILURE (0x80004005), component ConsoleWrap, interface IConsole
dmesg reports the following:
[Sep25 15:18] vboxdrv: 0000000000000000 VMMR0.r0 [ +0.155956] BUG: scheduling while atomic: VMPwrUp/153655/0x00000000 [ +0.000012] Modules linked in: vboxnetflt(O) vboxnetadp(O) vboxdrv(O) uas usb_storage snd_seq_dummy snd_hrtimer nft_fib_inet nft_fib_ipv4 nft_fib_ipv6 nft_fib nft_reject_inet nf_reject_ipv4 nf_reject_ipv6 nft_reject nft_ct nft_chain_nat nf_nat nf_conntrack rfkill nf_defrag_ipv6 nf_defrag_ipv4 ip_set amdgpu nf_tables nct6775 nct6775_core hwmon_vid snd_hda_codec_realtek snd_hda_codec_generic intel_rapl_msr snd_hda_codec_hdmi snd_hda_scodec_component intel_rapl_common snd_hda_intel x86_pkg_temp_thermal intel_powerclamp snd_intel_dspcfg snd_intel_sdw_acpi coretemp snd_hda_codec kvm_intel snd_hda_core amdxcp drm_exec gpu_sched drm_buddy snd_hwdep iTCO_wdt i2c_algo_bit snd_seq kvm intel_pmc_bxt iTCO_vendor_support drm_suballoc_helper drm_ttm_helper snd_seq_device ttm snd_pcm rapl drm_display_helper snd_timer intel_cstate mxm_wmi intel_uncore pcspkr i2c_i801 cec mei_me snd i2c_smbus e1000e video soundcore lpc_ich mei raid1 vfat fat joydev fuse loop nfnetlink zram dm_crypt crct10dif_pclmul crc32_pclmul crc32c_intel [ +0.000120] polyval_clmulni polyval_generic nvme ghash_clmulni_intel serio_raw sha512_ssse3 sha256_ssse3 nvme_core sha1_ssse3 nvme_auth wmi [ +0.000015] Unloaded tainted modules: vboxdrv(O):5 vboxnetflt(O):2 vboxnetadp(O):2 [last unloaded: vboxdrv(O)] [ +0.000013] CPU: 7 PID: 153655 Comm: VMPwrUp Tainted: G W O 6.10.10-200.fc40.x86_64 #1 [ +0.000006] Hardware name: MSI MS-7885/X99A RAIDER (MS-7885), BIOS P.71 06/13/2019 [ +0.000003] Call Trace: [ +0.000004] <TASK> [ +0.000003] dump_stack_lvl+0x5d/0x80 [ +0.000021] __schedule_bug.cold+0x42/0x4e [ +0.000005] __schedule+0x1100/0x1720 [ +0.000004] ? timerqueue_del+0x2e/0x50 [ +0.000004] ? __remove_hrtimer+0x41/0xa0 [ +0.000004] ? enqueue_hrtimer+0x42/0xa0 [ +0.000006] ? hrtimer_start_range_ns+0x26f/0x3b0 [ +0.000004] schedule+0x27/0xf0 [ +0.000003] futex_wait_queue+0x65/0x90 [ +0.000007] __futex_wait+0x151/0x1c0 [ +0.000005] ? __pfx_futex_wake_mark+0x10/0x10 [ +0.000005] futex_wait+0x79/0x120 [ +0.000004] ? __smp_call_single_queue+0xc4/0x150 [ +0.000004] ? __pfx_hrtimer_wakeup+0x10/0x10 [ +0.000005] do_futex+0xcb/0x190 [ +0.000005] __x64_sys_futex+0x127/0x1e0 [ +0.000005] do_syscall_64+0x82/0x160 [ +0.000005] ? do_futex+0x125/0x190 [ +0.000003] ? __x64_sys_futex+0x127/0x1e0 [ +0.000004] ? syscall_exit_to_user_mode+0x72/0x220 [ +0.000005] ? do_syscall_64+0x8e/0x160 [ +0.000004] ? vfs_write+0x31e/0x460 [ +0.000004] ? vfs_write+0x31e/0x460 [ +0.000005] ? syscall_exit_to_user_mode+0x72/0x220 [ +0.000004] ? do_syscall_64+0x8e/0x160 [ +0.000003] ? do_user_addr_fault+0x36c/0x620 [ +0.000005] ? exc_page_fault+0x7e/0x180 [ +0.000004] entry_SYSCALL_64_after_hwframe+0x76/0x7e [ +0.000005] RIP: 0033:0x7f3be7fcdda9 [ +0.000017] Code: 7d e0 89 75 e8 e8 d7 f8 ff ff 4c 8b 55 d8 8b 75 e8 45 31 c0 41 89 c4 48 8b 7d e0 41 b9 ff ff ff ff 89 da b8 ca 00 00 00 0f 05 <44> 89 e7 48 89 45 e8 e8 2b f9 ff ff 48 8b 45 e8 eb 90 0f 1f 44 00 [ +0.000003] RSP: 002b:00007f3bc4162a80 EFLAGS: 00000246 ORIG_RAX: 00000000000000ca [ +0.000004] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007f3be7fcdda9 [ +0.000003] RDX: 0000000000000000 RSI: 0000000000000089 RDI: 00007f3b60000e58 [ +0.000002] RBP: 00007f3bc4162ab0 R08: 0000000000000000 R09: 00000000ffffffff [ +0.000002] R10: 00007f3bc4162ba0 R11: 0000000000000246 R12: 0000000000000000 [ +0.000002] R13: 0000000000000000 R14: 0000000000000000 R15: 00007f3b60000e58 [ +0.000005] </TASK>
I can rmmod the modules (vboxnetadp vboxnetflt vboxdrv) and modprobe them to reload them again, which results in the following errors:
# modprobe -a vboxdrv vboxnetadp vboxnetflt modprobe: ERROR: could not insert 'vboxdrv': Invalid argument modprobe: ERROR: could not insert 'vboxnetadp': Invalid argument modprobe: ERROR: could not insert 'vboxnetflt': Invalid argument
dmesg output:
[ +0.000075] vboxdrv: Found 12 processor cores/threads [ +0.000325] supdrvGipCreate: failed to allocate the GIP page. rc=-26
Only a complete host reboot makes things work again for a little while until the problem reappears and nothing is bootable again.
更動歷史 (19)
comment:5 6 月 前 由 編輯
I can't find an upload function, so I'll paste the log here:
00:00:01.015579 VirtualBox VM 7.0.20_rpmfusion r163906 linux.amd64 (Jul 16 2024 00:00:00) release log
00:00:01.015583 Log opened 2024-09-25T20:12:39.184610000Z
00:00:01.015584 Build Type: release
00:00:01.015588 OS Product: Linux
00:00:01.015590 OS Release: 6.10.10-200.fc40.x86_64
00:00:01.015592 OS Version: #1 SMP PREEMPT_DYNAMIC Thu Sep 12 18:26:09 UTC 2024
00:00:01.015631 DMI Product Name: MS-7885
00:00:01.015647 DMI Product Version: 5.0
00:00:01.015658 Firmware type: UEFI
00:00:01.016100 Secure Boot: Enabled
00:00:01.016162 Host RAM: 31985MB (31.2GB) total, 26996MB (26.3GB) available
00:00:01.016168 Executable: /usr/lib64/virtualbox/VirtualBoxVM
00:00:01.016169 Process ID: 29517
00:00:01.016170 Package type: LINUX_64BITS_GENERIC (OSE)
00:00:01.033658 Installed Extension Packs:
00:00:01.033695 None installed!
00:00:01.035436 Console: Machine state changed to 'Starting'
00:00:01.069711 Qt version: 5.15.15
00:00:01.069737 X11 Window Manager code: 5
00:00:01.071808 SUP: Opened VMMR0.r0 (/usr/lib64/virtualbox/VMMR0.r0) at 0xXXXXXXXXXXXXXXXX.
00:00:01.075677 Guest OS type: 'RedHat_64'
00:00:01.077991 fHMForced=true - No raw-mode support in this build!
00:00:01.089193 File system of '/home/user/vbox/distro/alma-8/Snapshots' (snapshots) is btrfs
00:00:01.089221 File system of '/home/user/vbox/distro/alma-8/Snapshots/{86b1915a-3ba9-49a5-b688-525d4eadf585}.vdi' is btrfs
00:00:01.091906 GUI: UIMediumEnumerator: Medium-enumeration finished!
00:00:01.093230 X Server details: vendor: The X.Org Foundation, release: 12014000, protocol version: 11.0, display string: :0
00:00:01.093246 Using XKB for keycode to scan code conversion
00:00:01.095622 GUI: UIDesktopWidgetWatchdog::sltHandleHostScreenAvailableGeometryCalculated: Screen 0 work area is actually resized to: 0x36 x 3440x1404
00:00:01.102557 Shared Clipboard: Service loaded
00:00:01.102577 Shared Clipboard: Mode: Off
00:00:01.102636 Shared Clipboard: Service running in normal mode
00:00:01.103428 Drag and drop service loaded
00:00:01.103439 Drag and drop mode: Off
00:00:01.105772 ************************* CFGM dump *************************
00:00:01.105778 [/] (level 0)
00:00:01.105791 CpuExecutionCap <integer> = 0x0000000000000064 (100)
00:00:01.105796 EnablePAE <integer> = 0x0000000000000001 (1)
00:00:01.105797 HMEnabled <integer> = 0x0000000000000001 (1)
00:00:01.105798 MemBalloonSize <integer> = 0x0000000000000000 (0, 0 B)
00:00:01.105800 Name <string> = "alma-8" (cb=7)
00:00:01.105801 NumCPUs <integer> = 0x0000000000000002 (2)
00:00:01.105802 PageFusionAllowed <integer> = 0x0000000000000000 (0)
00:00:01.105802 RamHoleSize <integer> = 0x0000000020000000 (536 870 912, 512.0 MiB)
00:00:01.105803 RamSize <integer> = 0x0000000020000000 (536 870 912, 512.0 MiB)
00:00:01.105804 TimerMillies <integer> = 0x000000000000000a (10)
00:00:01.105805 UUID <bytes> = "4d a4 61 cf eb 7b c6 45 8b ba a9 7f ca 05 76 fc" (cb=16)
00:00:01.105808
00:00:01.105810 [/CPUM/] (level 1)
00:00:01.105812 Enable64bit <integer> = 0x0000000000000001 (1)
00:00:01.105812 GuestCpuName <string> = "host" (cb=5)
00:00:01.105813 NestedHWVirt <integer> = 0x0000000000000000 (0)
00:00:01.105814 PortableCpuIdLevel <integer> = 0x0000000000000000 (0)
00:00:01.105814 SpecCtrl <integer> = 0x0000000000000000 (0)
00:00:01.105815
00:00:01.105815 [/CPUM/IsaExts/] (level 2)
00:00:01.105816
00:00:01.105818 [/DBGC/] (level 1)
00:00:01.105819 GlobalInitScript <string> = "/home/user/.config/VirtualBox/dbgc-init" (cb=40)
00:00:01.105820 HistoryFile <string> = "/home/user/.config/VirtualBox/dbgc-history" (cb=43)
00:00:01.105820 LocalInitScript <string> = "/home/user/vbox/distro/alma-8/dbgc-init" (cb=41)
00:00:01.105821
00:00:01.105821 [/DBGF/] (level 1)
00:00:01.105821 Path <string> = "/home/user/vbox/distro/alma-8/debug/;/home/user/vbox/distro/alma-8/;cache*/home/user/vbox/distro/alma-8/dbgcache/;/home/user/" (cb=129)
00:00:01.105822
00:00:01.105822 [/Devices/] (level 1)
00:00:01.105823
00:00:01.105823 [/Devices/3c501/] (level 2)
00:00:01.105823
00:00:01.105824 [/Devices/8237A/] (level 2)
00:00:01.105824
00:00:01.105825 [/Devices/8237A/0/] (level 3)
00:00:01.105826 Trusted <integer> = 0x0000000000000001 (1)
00:00:01.105826
00:00:01.105826 [/Devices/GIMDev/] (level 2)
00:00:01.105827
00:00:01.105827 [/Devices/GIMDev/0/] (level 3)
00:00:01.105828 Trusted <integer> = 0x0000000000000001 (1)
00:00:01.105828
00:00:01.105829 [/Devices/VMMDev/] (level 2)
00:00:01.105829
00:00:01.105829 [/Devices/VMMDev/0/] (level 3)
00:00:01.105830 PCIBusNo <integer> = 0x0000000000000000 (0)
00:00:01.105831 PCIDeviceNo <integer> = 0x0000000000000004 (4)
00:00:01.105831 PCIFunctionNo <integer> = 0x0000000000000000 (0)
00:00:01.105832 Trusted <integer> = 0x0000000000000001 (1)
00:00:01.105832
00:00:01.105833 [/Devices/VMMDev/0/Config/] (level 4)
00:00:01.105833 GuestCoreDumpDir <string> = "/home/user/vbox/distro/alma-8/Snapshots" (cb=41)
00:00:01.105834
00:00:01.105834 [/Devices/VMMDev/0/LUN#0/] (level 4)
00:00:01.105835 Driver <string> = "HGCM" (cb=5)
00:00:01.105835
00:00:01.105836 [/Devices/VMMDev/0/LUN#0/Config/] (level 5)
00:00:01.105836
00:00:01.105837 [/Devices/VMMDev/0/LUN#999/] (level 4)
00:00:01.105837 Driver <string> = "MainStatus" (cb=11)
00:00:01.105838
00:00:01.105838 [/Devices/VMMDev/0/LUN#999/Config/] (level 5)
00:00:01.105839 First <integer> = 0x0000000000000000 (0)
00:00:01.105840 HasMediumAttachments <integer> = 0x0000000000000000 (0)
00:00:01.105840 Last <integer> = 0x0000000000000000 (0)
00:00:01.105841 iLedSet <integer> = 0x0000000000000003 (3)
00:00:01.105841
00:00:01.105842 [/Devices/acpi/] (level 2)
00:00:01.105842
00:00:01.105842 [/Devices/acpi/0/] (level 3)
00:00:01.105843 PCIBusNo <integer> = 0x0000000000000000 (0)
00:00:01.105844 PCIDeviceNo <integer> = 0x0000000000000007 (7)
00:00:01.105844 PCIFunctionNo <integer> = 0x0000000000000000 (0)
00:00:01.105844 Trusted <integer> = 0x0000000000000001 (1)
00:00:01.105845
00:00:01.105845 [/Devices/acpi/0/Config/] (level 4)
00:00:01.105846 CpuHotPlug <integer> = 0x0000000000000000 (0)
00:00:01.105847 FdcEnabled <integer> = 0x0000000000000000 (0)
00:00:01.105847 HostBusPciAddress <integer> = 0x0000000000000000 (0)
00:00:01.105848 HpetEnabled <integer> = 0x0000000000000000 (0)
00:00:01.105848 IOAPIC <integer> = 0x0000000000000001 (1)
00:00:01.105849 IocPciAddress <integer> = 0x0000000000010000 (65 536)
00:00:01.105850 NumCPUs <integer> = 0x0000000000000002 (2)
00:00:01.105850 Parallel0IoPortBase <integer> = 0x0000000000000000 (0)
00:00:01.105851 Parallel0Irq <integer> = 0x0000000000000000 (0)
00:00:01.105851 Parallel1IoPortBase <integer> = 0x0000000000000000 (0)
00:00:01.105852 Parallel1Irq <integer> = 0x0000000000000000 (0)
00:00:01.105852 Serial0IoPortBase <integer> = 0x0000000000000000 (0)
00:00:01.105853 Serial0Irq <integer> = 0x0000000000000000 (0)
00:00:01.105853 Serial1IoPortBase <integer> = 0x0000000000000000 (0)
00:00:01.105854 Serial1Irq <integer> = 0x0000000000000000 (0)
00:00:01.105855 ShowCpu <integer> = 0x0000000000000001 (1)
00:00:01.105855 ShowRtc <integer> = 0x0000000000000000 (0)
00:00:01.105856 SmcEnabled <integer> = 0x0000000000000000 (0)
00:00:01.105856
00:00:01.105856 [/Devices/acpi/0/LUN#0/] (level 4)
00:00:01.105857 Driver <string> = "ACPIHost" (cb=9)
00:00:01.105858
00:00:01.105858 [/Devices/acpi/0/LUN#0/Config/] (level 5)
00:00:01.105859
00:00:01.105859 [/Devices/acpi/0/LUN#1/] (level 4)
00:00:01.105860 Driver <string> = "ACPICpu" (cb=8)
00:00:01.105860
00:00:01.105860 [/Devices/acpi/0/LUN#1/Config/] (level 5)
00:00:01.105861
00:00:01.105861 [/Devices/ahci/] (level 2)
00:00:01.105862
00:00:01.105862 [/Devices/ahci/0/] (level 3)
00:00:01.105863 PCIBusNo <integer> = 0x0000000000000000 (0)
00:00:01.105864 PCIDeviceNo <integer> = 0x000000000000000d (13)
00:00:01.105864 PCIFunctionNo <integer> = 0x0000000000000000 (0)
00:00:01.105865 Trusted <integer> = 0x0000000000000001 (1)
00:00:01.105865
00:00:01.105865 [/Devices/ahci/0/Config/] (level 4)
00:00:01.105866 Bootable <integer> = 0x0000000000000001 (1)
00:00:01.105867 PortCount <integer> = 0x0000000000000002 (2)
00:00:01.105867
00:00:01.105867 [/Devices/ahci/0/Config/Port0/] (level 5)
00:00:01.105868 Hotpluggable <integer> = 0x0000000000000000 (0)
00:00:01.105869
00:00:01.105869 [/Devices/ahci/0/Config/Port1/] (level 5)
00:00:01.105870 Hotpluggable <integer> = 0x0000000000000000 (0)
00:00:01.105870
00:00:01.105870 [/Devices/ahci/0/LUN#0/] (level 4)
00:00:01.105871 Driver <string> = "VD" (cb=3)
00:00:01.105872
00:00:01.105872 [/Devices/ahci/0/LUN#0/Config/] (level 5)
00:00:01.105873 Format <string> = "VDI" (cb=4)
00:00:01.105874 Mountable <integer> = 0x0000000000000000 (0)
00:00:01.105874 NonRotationalMedium <integer> = 0x0000000000000001 (1)
00:00:01.105875 Path <string> = "/home/user/vbox/distro/alma-8/Snapshots/{86b1915a-3ba9-49a5-b688-525d4eadf585}.vdi" (cb=84)
00:00:01.105875 Type <string> = "HardDisk" (cb=9)
00:00:01.105876
00:00:01.105876 [/Devices/ahci/0/LUN#0/Config/Parent/] (level 6)
00:00:01.105878 Format <string> = "VDI" (cb=4)
00:00:01.105878 Path <string> = "/home/user/vbox/distro/alma-8/alma 8.vdi" (cb=42)
00:00:01.105879
00:00:01.105879 [/Devices/ahci/0/LUN#0/Config/Parent/VDConfig/] (level 7)
00:00:01.105880 AllocationBlockSize <string> = "1048576" (cb=8)
00:00:01.105880
00:00:01.105881 [/Devices/ahci/0/LUN#0/Config/VDConfig/] (level 6)
00:00:01.105882 AllocationBlockSize <string> = "1048576" (cb=8)
00:00:01.105882
00:00:01.105882 [/Devices/ahci/0/LUN#1/] (level 4)
00:00:01.105883 Driver <string> = "SCSI" (cb=5)
00:00:01.105884
00:00:01.105884 [/Devices/ahci/0/LUN#1/AttachedDriver/] (level 5)
00:00:01.105885 Driver <string> = "VD" (cb=3)
00:00:01.105885
00:00:01.105886 [/Devices/ahci/0/LUN#1/AttachedDriver/Config/] (level 6)
00:00:01.105887 EmptyDrive <integer> = 0x0000000000000001 (1)
00:00:01.105887 Mountable <integer> = 0x0000000000000001 (1)
00:00:01.105888 Type <string> = "DVD" (cb=4)
00:00:01.105888
00:00:01.105889 [/Devices/ahci/0/LUN#999/] (level 4)
00:00:01.105889 Driver <string> = "MainStatus" (cb=11)
00:00:01.105890
00:00:01.105890 [/Devices/ahci/0/LUN#999/Config/] (level 5)
00:00:01.105891 DeviceInstance <string> = "ahci/0" (cb=7)
00:00:01.105891 First <integer> = 0x0000000000000000 (0)
00:00:01.105892 HasMediumAttachments <integer> = 0x0000000000000001 (1)
00:00:01.105893 Last <integer> = 0x0000000000000001 (1)
00:00:01.105893 iLedSet <integer> = 0x0000000000000001 (1)
00:00:01.105894
00:00:01.105894 [/Devices/apic/] (level 2)
00:00:01.105895
00:00:01.105895 [/Devices/apic/0/] (level 3)
00:00:01.105896 Trusted <integer> = 0x0000000000000001 (1)
00:00:01.105896
00:00:01.105896 [/Devices/apic/0/Config/] (level 4)
00:00:01.105897 IOAPIC <integer> = 0x0000000000000001 (1)
00:00:01.105898 Mode <integer> = 0x0000000000000003 (3)
00:00:01.105898 NumCPUs <integer> = 0x0000000000000002 (2)
00:00:01.105899
00:00:01.105899 [/Devices/dp8390/] (level 2)
00:00:01.105900
00:00:01.105900 [/Devices/e1000/] (level 2)
00:00:01.105901
00:00:01.105901 [/Devices/e1000/0/] (level 3)
00:00:01.105902 PCIBusNo <integer> = 0x0000000000000000 (0)
00:00:01.105902 PCIDeviceNo <integer> = 0x0000000000000003 (3)
00:00:01.105903 PCIFunctionNo <integer> = 0x0000000000000000 (0)
00:00:01.105903 Trusted <integer> = 0x0000000000000001 (1)
00:00:01.105904
00:00:01.105904 [/Devices/e1000/0/Config/] (level 4)
00:00:01.105905 AdapterType <integer> = 0x0000000000000000 (0)
00:00:01.105905 CableConnected <integer> = 0x0000000000000001 (1)
00:00:01.105906 LineSpeed <integer> = 0x0000000000000000 (0)
00:00:01.105907 MAC <bytes> = "08 00 27 68 c9 8b" (cb=6)
00:00:01.105909
00:00:01.105909 [/Devices/e1000/0/LUN#0/] (level 4)
00:00:01.105911 Driver <string> = "IntNet" (cb=7)
00:00:01.105911
00:00:01.105912 [/Devices/e1000/0/LUN#0/Config/] (level 5)
00:00:01.105913 IfPolicyPromisc <string> = "deny" (cb=5)
00:00:01.105914 IgnoreConnectFailure <integer> = 0x0000000000000000 (0)
00:00:01.105915 Network <string> = "HostInterfaceNetworking-eno1" (cb=29)
00:00:01.105916 Trunk <string> = "4026531840/eno1" (cb=16)
00:00:01.105917 TrunkType <integer> = 0x0000000000000003 (3)
00:00:01.105918
00:00:01.105918 [/Devices/e1000/0/LUN#999/] (level 4)
00:00:01.105919 Driver <string> = "MainStatus" (cb=11)
00:00:01.105920
00:00:01.105920 [/Devices/e1000/0/LUN#999/Config/] (level 5)
00:00:01.105921 First <integer> = 0x0000000000000000 (0)
00:00:01.105921 HasMediumAttachments <integer> = 0x0000000000000000 (0)
00:00:01.105922 Last <integer> = 0x0000000000000000 (0)
00:00:01.105922 iLedSet <integer> = 0x0000000000000002 (2)
00:00:01.105923
00:00:01.105923 [/Devices/i8254/] (level 2)
00:00:01.105924
00:00:01.105924 [/Devices/i8254/0/] (level 3)
00:00:01.105925
00:00:01.105925 [/Devices/i8254/0/Config/] (level 4)
00:00:01.105926
00:00:01.105926 [/Devices/i8259/] (level 2)
00:00:01.105927
00:00:01.105927 [/Devices/i8259/0/] (level 3)
00:00:01.105927 Trusted <integer> = 0x0000000000000001 (1)
00:00:01.105928
00:00:01.105928 [/Devices/i8259/0/Config/] (level 4)
00:00:01.105929
00:00:01.105929 [/Devices/ioapic/] (level 2)
00:00:01.105930
00:00:01.105930 [/Devices/ioapic/0/] (level 3)
00:00:01.105930 Trusted <integer> = 0x0000000000000001 (1)
00:00:01.105931
00:00:01.105931 [/Devices/ioapic/0/Config/] (level 4)
00:00:01.105932 NumCPUs <integer> = 0x0000000000000002 (2)
00:00:01.105932
00:00:01.105933 [/Devices/mc146818/] (level 2)
00:00:01.105933
00:00:01.105933 [/Devices/mc146818/0/] (level 3)
00:00:01.105934
00:00:01.105934 [/Devices/mc146818/0/Config/] (level 4)
00:00:01.105935 UseUTC <integer> = 0x0000000000000000 (0)
00:00:01.105935
00:00:01.105936 [/Devices/parallel/] (level 2)
00:00:01.105936
00:00:01.105937 [/Devices/pcarch/] (level 2)
00:00:01.105937
00:00:01.105937 [/Devices/pcarch/0/] (level 3)
00:00:01.105938 Trusted <integer> = 0x0000000000000001 (1)
00:00:01.105939
00:00:01.105939 [/Devices/pcarch/0/Config/] (level 4)
00:00:01.105940
00:00:01.105940 [/Devices/pcbios/] (level 2)
00:00:01.105940
00:00:01.105941 [/Devices/pcbios/0/] (level 3)
00:00:01.105941 Trusted <integer> = 0x0000000000000001 (1)
00:00:01.105942
00:00:01.105942 [/Devices/pcbios/0/Config/] (level 4)
00:00:01.105943 APIC <integer> = 0x0000000000000001 (1)
00:00:01.105944 BootDevice0 <string> = "DVD" (cb=4)
00:00:01.105944 BootDevice1 <string> = "IDE" (cb=4)
00:00:01.105945 BootDevice2 <string> = "NONE" (cb=5)
00:00:01.105945 BootDevice3 <string> = "NONE" (cb=5)
00:00:01.105946 FloppyDevice <string> = "i82078" (cb=7)
00:00:01.105946 HardDiskDevice <string> = "piix3ide" (cb=9)
00:00:01.105947 IOAPIC <integer> = 0x0000000000000001 (1)
00:00:01.105947 McfgBase <integer> = 0x0000000000000000 (0)
00:00:01.105948 McfgLength <integer> = 0x0000000000000000 (0)
00:00:01.105948 NumCPUs <integer> = 0x0000000000000002 (2)
00:00:01.105949 PXEDebug <integer> = 0x0000000000000000 (0)
00:00:01.105950 SataHardDiskDevice <string> = "ahci" (cb=5)
00:00:01.105950 SataLUN1 <integer> = 0x0000000000000000 (0)
00:00:01.105951 UUID <bytes> = "4d a4 61 cf eb 7b c6 45 8b ba a9 7f ca 05 76 fc" (cb=16)
00:00:01.105952 UuidLe <integer> = 0x0000000000000001 (1)
00:00:01.105953
00:00:01.105953 [/Devices/pcbios/0/Config/NetBoot/] (level 5)
00:00:01.105954
00:00:01.105954 [/Devices/pcbios/0/Config/NetBoot/0/] (level 6)
00:00:01.105955 NIC <integer> = 0x0000000000000000 (0)
00:00:01.105956 PCIBusNo <integer> = 0x0000000000000000 (0)
00:00:01.105956 PCIDeviceNo <integer> = 0x0000000000000003 (3)
00:00:01.105957 PCIFunctionNo <integer> = 0x0000000000000000 (0)
00:00:01.105957
00:00:01.105957 [/Devices/pci/] (level 2)
00:00:01.105958
00:00:01.105958 [/Devices/pci/0/] (level 3)
00:00:01.105959 Trusted <integer> = 0x0000000000000001 (1)
00:00:01.105959
00:00:01.105960 [/Devices/pci/0/Config/] (level 4)
00:00:01.105960 IOAPIC <integer> = 0x0000000000000001 (1)
00:00:01.105961
00:00:01.105961 [/Devices/pcibridge/] (level 2)
00:00:01.105962
00:00:01.105962 [/Devices/pckbd/] (level 2)
00:00:01.105971
00:00:01.105971 [/Devices/pckbd/0/] (level 3)
00:00:01.105972 Trusted <integer> = 0x0000000000000001 (1)
00:00:01.105972
00:00:01.105973 [/Devices/pckbd/0/Config/] (level 4)
00:00:01.105973
00:00:01.105974 [/Devices/pckbd/0/LUN#0/] (level 4)
00:00:01.105974 Driver <string> = "KeyboardQueue" (cb=14)
00:00:01.105975
00:00:01.105975 [/Devices/pckbd/0/LUN#0/AttachedDriver/] (level 5)
00:00:01.105976 Driver <string> = "MainKeyboard" (cb=13)
00:00:01.105976
00:00:01.105977 [/Devices/pckbd/0/LUN#0/Config/] (level 5)
00:00:01.105978 QueueSize <integer> = 0x0000000000000040 (64, 64 B)
00:00:01.105978
00:00:01.105979 [/Devices/pckbd/0/LUN#1/] (level 4)
00:00:01.105979 Driver <string> = "MouseQueue" (cb=11)
00:00:01.105980
00:00:01.105980 [/Devices/pckbd/0/LUN#1/AttachedDriver/] (level 5)
00:00:01.105981 Driver <string> = "MainMouse" (cb=10)
00:00:01.105981
00:00:01.105981 [/Devices/pckbd/0/LUN#1/Config/] (level 5)
00:00:01.105982 QueueSize <integer> = 0x0000000000000080 (128, 128 B)
00:00:01.105983
00:00:01.105983 [/Devices/pcnet/] (level 2)
00:00:01.105984
00:00:01.105984 [/Devices/serial/] (level 2)
00:00:01.105985
00:00:01.105985 [/Devices/vga/] (level 2)
00:00:01.105985
00:00:01.105986 [/Devices/vga/0/] (level 3)
00:00:01.105986 PCIBusNo <integer> = 0x0000000000000000 (0)
00:00:01.105987 PCIDeviceNo <integer> = 0x0000000000000002 (2)
00:00:01.105988 PCIFunctionNo <integer> = 0x0000000000000000 (0)
00:00:01.105988 Trusted <integer> = 0x0000000000000001 (1)
00:00:01.105989
00:00:01.105989 [/Devices/vga/0/Config/] (level 4)
00:00:01.105990 3DEnabled <integer> = 0x0000000000000000 (0)
00:00:01.105991 CustomVideoModes <integer> = 0x0000000000000000 (0)
00:00:01.105991 FadeIn <integer> = 0x0000000000000001 (1)
00:00:01.105992 FadeOut <integer> = 0x0000000000000001 (1)
00:00:01.105993 HeightReduction <integer> = 0x0000000000000000 (0)
00:00:01.105993 LogoFile <string> = "" (cb=1)
00:00:01.105994 LogoTime <integer> = 0x0000000000000000 (0)
00:00:01.105994 MonitorCount <integer> = 0x0000000000000001 (1)
00:00:01.105995 ShowBootMenu <integer> = 0x0000000000000002 (2)
00:00:01.105995 VMSVGA3dEnabled <integer> = 0x0000000000000000 (0)
00:00:01.105996 VMSVGAEnabled <integer> = 0x0000000000000001 (1)
00:00:01.105996 VMSVGAPciBarLayout <integer> = 0x0000000000000001 (1)
00:00:01.105997 VMSVGAPciId <integer> = 0x0000000000000001 (1)
00:00:01.105997 VRamSize <integer> = 0x0000000001400000 (20 971 520, 20.0 MiB)
00:00:01.105998
00:00:01.105999 [/Devices/vga/0/LUN#0/] (level 4)
00:00:01.105999 Driver <string> = "MainDisplay" (cb=12)
00:00:01.106000
00:00:01.106000 [/Devices/vga/0/LUN#0/Config/] (level 5)
00:00:01.106001
00:00:01.106001 [/Devices/vga/0/LUN#999/] (level 4)
00:00:01.106002 Driver <string> = "MainStatus" (cb=11)
00:00:01.106002
00:00:01.106003 [/Devices/vga/0/LUN#999/Config/] (level 5)
00:00:01.106003 First <integer> = 0x0000000000000000 (0)
00:00:01.106004 HasMediumAttachments <integer> = 0x0000000000000000 (0)
00:00:01.106005 Last <integer> = 0x0000000000000000 (0)
00:00:01.106005 iLedSet <integer> = 0x0000000000000000 (0)
00:00:01.106006
00:00:01.106006 [/Devices/virtio-net/] (level 2)
00:00:01.106007
00:00:01.106007 [/EM/] (level 1)
00:00:01.106008 TripleFaultReset <integer> = 0x0000000000000000 (0)
00:00:01.106008
00:00:01.106009 [/GCM/] (level 1)
00:00:01.106009 FixerSet <integer> = 0x0000000000000000 (0)
00:00:01.106010
00:00:01.106010 [/GIM/] (level 1)
00:00:01.106010 Provider <string> = "KVM" (cb=4)
00:00:01.106011
00:00:01.106011 [/HM/] (level 1)
00:00:01.106012 64bitEnabled <integer> = 0x0000000000000001 (1)
00:00:01.106013 EnableLargePages <integer> = 0x0000000000000000 (0)
00:00:01.106014 EnableNestedPaging <integer> = 0x0000000000000001 (1)
00:00:01.106014 EnableUX <integer> = 0x0000000000000001 (1)
00:00:01.106015 EnableVPID <integer> = 0x0000000000000001 (1)
00:00:01.106015 Exclusive <integer> = 0x0000000000000001 (1)
00:00:01.106016 HMForced <integer> = 0x0000000000000001 (1)
00:00:01.106017 IBPBOnVMEntry <integer> = 0x0000000000000000 (0)
00:00:01.106017 IBPBOnVMExit <integer> = 0x0000000000000000 (0)
00:00:01.106018 L1DFlushOnSched <integer> = 0x0000000000000001 (1)
00:00:01.106018 L1DFlushOnVMEntry <integer> = 0x0000000000000000 (0)
00:00:01.106019 LovelyMesaDrvWorkaround <integer> = 0x0000000000000001 (1)
00:00:01.106019 MDSClearOnSched <integer> = 0x0000000000000001 (1)
00:00:01.106020 MDSClearOnVMEntry <integer> = 0x0000000000000000 (0)
00:00:01.106021 SpecCtrlByHost <integer> = 0x0000000000000000 (0)
00:00:01.106022 SvmVirtVmsaveVmload <integer> = 0x0000000000000000 (0)
00:00:01.106023 UseNEMInstead <integer> = 0x0000000000000000 (0)
00:00:01.106024
00:00:01.106025 [/MM/] (level 1)
00:00:01.106025 CanUseLargerHeap <integer> = 0x0000000000000000 (0)
00:00:01.106026
00:00:01.106026 [/NEM/] (level 1)
00:00:01.106027 Allow64BitGuests <integer> = 0x0000000000000001 (1)
00:00:01.106028 LovelyMesaDrvWorkaround <integer> = 0x0000000000000001 (1)
00:00:01.106029
00:00:01.106030 [/PDM/] (level 1)
00:00:01.106031
00:00:01.106031 [/PDM/AsyncCompletion/] (level 2)
00:00:01.106032
00:00:01.106032 [/PDM/AsyncCompletion/File/] (level 3)
00:00:01.106033
00:00:01.106033 [/PDM/AsyncCompletion/File/BwGroups/] (level 4)
00:00:01.106034
00:00:01.106034 [/PDM/BlkCache/] (level 2)
00:00:01.106035 CacheSize <integer> = 0x0000000000500000 (5 242 880, 5.0 MiB)
00:00:01.106036
00:00:01.106036 [/PDM/Devices/] (level 2)
00:00:01.106037
00:00:01.106037 [/PDM/Drivers/] (level 2)
00:00:01.106038
00:00:01.106038 [/PDM/Drivers/VBoxC/] (level 3)
00:00:01.106039 Path <string> = "/usr/lib64/virtualbox/components/VBoxC" (cb=39)
00:00:01.106039
00:00:01.106040 [/PDM/NetworkShaper/] (level 2)
00:00:01.106040
00:00:01.106040 [/PDM/NetworkShaper/BwGroups/] (level 3)
00:00:01.106041
00:00:01.106041 [/TM/] (level 1)
00:00:01.106042 UTCOffset <integer> = 0x0000000000000000 (0)
00:00:01.106042
00:00:01.106043 ********************* End of CFGM dump **********************
00:00:01.106177 HM: HMR3Init: VT-x w/ nested paging and unrestricted guest execution hw support
00:00:01.106250 CPUM: fXStateHostMask=0x7; initial: 0x7; host XCR0=0x7
00:00:01.107139 CPUM: Matched host CPU INTEL 0x6/0x3f/0x2 Intel_Core7_Haswell with CPU DB entry 'Intel Core i7-5600U' (INTEL 0x6/0x3d/0x4 Intel_Core7_Broadwell)
00:00:01.107186 CPUM: MXCSR_MASK=0xffff (host: 0xffff)
00:00:01.107199 CPUM: Microcode revision 0x00000049
00:00:01.107207 CPUM: MSR/CPUID reconciliation insert: 0x0000010b IA32_FLUSH_CMD
00:00:01.107212 CPUM: MSR fudge: 0x00000001 IA32_P5_MC_TYPE
00:00:01.107215 CPUM: MSR fudge: 0x00000017 IA32_PLATFORM_ID
00:00:01.107217 CPUM: MSR fudge: 0x0000001b IA32_APIC_BASE
00:00:01.107219 CPUM: MSR fudge: 0x0000008b BIOS_SIGN
00:00:01.107221 CPUM: MSR fudge: 0x000000fe IA32_MTRRCAP
00:00:01.107224 CPUM: MSR fudge: 0x00000179 IA32_MCG_CAP
00:00:01.107226 CPUM: MSR fudge: 0x0000017a IA32_MCG_STATUS
00:00:01.107228 CPUM: MSR fudge: 0x000001a0 IA32_MISC_ENABLE
00:00:01.107230 CPUM: MSR fudge: 0x000001d9 IA32_DEBUGCTL
00:00:01.107234 CPUM: MSR fudge: 0x000001db P6_LAST_BRANCH_FROM_IP
00:00:01.107237 CPUM: MSR fudge: 0x000001dc P6_LAST_BRANCH_TO_IP
00:00:01.107252 CPUM: MSR fudge: 0x000001dd P6_LAST_INT_FROM_IP
00:00:01.107256 CPUM: MSR fudge: 0x000001de P6_LAST_INT_TO_IP
00:00:01.107258 CPUM: MSR fudge: 0x00000277 IA32_PAT
00:00:01.107260 CPUM: MSR fudge: 0x000002ff IA32_MTRR_DEF_TYPE
00:00:01.107262 CPUM: MSR fudge: 0x00000400 IA32_MCi_CTL_STATUS_ADDR_MISC
00:00:01.107265 CPUM: MSR fudge: 0xc0000103 AMD64_TSC_AUX
00:00:01.107279 CPUM: SetGuestCpuIdFeature: Enabled SYSENTER/EXIT
00:00:01.107282 CPUM: SetGuestCpuIdFeature: Enabled SYSCALL/RET
00:00:01.107285 CPUM: SetGuestCpuIdFeature: Enabled PAE
00:00:01.107287 CPUM: SetGuestCpuIdFeature: Enabled LAHF/SAHF
00:00:01.107289 CPUM: SetGuestCpuIdFeature: Enabled NX
00:00:01.107293 CPUM: SetGuestCpuIdFeature: Enabled LONG MODE
00:00:01.107619 PGM: Host paging mode: AMD64+PGE+NX
00:00:01.107638 PGM: PGMPool: cMaxPages=512 (u64MaxPages=288)
00:00:01.107645 PGM: pgmR3PoolInit: cMaxPages=0x200 cMaxUsers=0x400 cMaxPhysExts=0x400 fCacheEnable=true
PGMR0PoolGrow: rc=-72 cNewPages=0x1ff cCurPages=0x1 cMaxPages=0x200 fCanUseHighMemory=0
00:00:01.108262 PGMR3PoolGrow: rc=VERR_NO_LOW_MEMORY cCurPages=0x1 cMaxPages=0x200
00:00:01.108268 AssertLogRel /builddir/build/BUILD/VirtualBox-7.0.20/src/VBox/VMM/VMMAll/PGMAllShw.h(263) int pgmR3ShwEPTEnter(PVMCPUCC): RT_SUCCESS_NP(rc)
00:00:01.108272 VERR_NO_LOW_MEMORY (-72) - Out of memory condition when allocating memory with low physical backing.
00:00:01.108282 AssertLogRel /builddir/build/BUILD/VirtualBox-7.0.20/src/VBox/VMM/VMMAll/PGMAll.cpp(3450) int PGMHCChangeMode(PVMCC, PVMCPUCC, PGMMODE, bool): RT_SUCCESS_NP(rc)
00:00:01.108291 Entering enmShadowMode=EPT failed: VERR_NO_LOW_MEMORY
00:00:01.233545 VMSetError: /builddir/build/BUILD/VirtualBox-7.0.20/src/VBox/VMM/VMMR3/VM.cpp(341) int VMR3Create(uint32_t, PCVMM2USERMETHODS, uint64_t, PFNVMATERROR, void*, PFNCFGMCONSTRUCTOR, void*, VM**, UVM**); rc=VERR_NO_LOW_MEMORY
00:00:01.233553 VMSetError: Out of memory condition when allocating memory with low physical backing.
00:00:01.234956 ERROR [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={6ac83d89-6ee7-4e33-8ae6-b257b2e81be8} aComponent={ConsoleWrap} aText={Out of memory condition when allocating memory with low physical backing. (VERR_NO_LOW_MEMORY)}, preserve=false aResultDetail=-72
00:00:01.235117 Console: Machine state changed to 'PoweredOff'
00:00:01.274936 Power up failed (vrc=VERR_NO_LOW_MEMORY, hrc=NS_ERROR_FAILURE (0X80004005))
00:00:01.294297 GUI: UIMachineViewNormal::resendSizeHint: Restoring guest size-hint for screen 0 to 800x600
00:00:01.294363 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={4680b2de-8690-11e9-b83d-5719e53cf1de} aComponent={DisplayWrap} aText={The console is not powered up (setVideoModeHint)}, preserve=false aResultDetail=0
00:00:01.294449 GUI: Aborting startup due to power up progress issue detected...
00:00:01.300656 GUI: UICommon: Handling aboutToQuit request..
00:00:01.799275 GUI: UICommon: aboutToQuit request handled!
comment:6 6 月 前 由 編輯
I forgot to mention something interesting:
when the problem appears and I can't boot any VMs, the existing VMs continue to work just fine.
comment:7 6 月 前 由 編輯
Hi VirtualBarista,
How many VMs are you running in parallel? Do they have the same amount of assigned memory? Please note that you are running VBox built by rpmfusion, not by us. Is there any difference if you install official version from virtualbox.org?
comment:8 6 月 前 由 編輯
I've build an automated cI/CD pipeline, which boots 3 VMs and keeps those running, then it proceeds to subsequently boot a single VM, run my software tests, then shutdown the VM and proceed to the next VM (10 in total). So the pipeline will run 4 VMs at most in parallel.
All VMs have either 512MB or 2048MB of ram. Distros like Oracle, Alma and Rocky use 512MB of ram, while variations of Fedora use 2048MB of ram.
Yes this is the rpmfusion rpm packaged VirtualBox, sorry I haven't tried the official version.
Thank you for taking the time to help me with this issue.
comment:9 6 月 前 由 編輯
Hi VirtualBarista,
Still would be interesting to know if the issue is reproducible with official build from download page.
comment:10 6 月 前 由 編輯
It seems this issue is very wide spread and others are having the same problem:
comment:11 4 月 前 由 編輯
The problem persists in VirtualBox version 7.1.4
and even more people are having the same problem:
comment:12 4 月 前 由 編輯
The reason is very simple; Virtualbox started checking available memory before starting a virtual machine. However, the program only tests for unused RAM. However, there are several types of used memory, including cached memory. Cached memory can always be reclaimed by programs and thus should be considered as unused.
Since a Linux system can accumulate as much RAM as wanted for cache, after some time you cannot run any machine.
While waiting for Oracle to fix that silly mistake, you can force-reclaim your cache in Linux with:
echo 3 | sudo tee /proc/sys/vm/drop_caches
comment:13 4 月 前 由 編輯
I am getting the same error message, also on F40, and VirtualBox via rpmfusion. Maybe it helps to find the cause: I am getting the error if I shut down and start the guest via the command line in the host. If I start the guest via the Virtualbox GUI it starts normally.
comment:14 3 月 前 由 編輯
... and the above workaround with
echo 3 | sudo tee /proc/sys/vm/drop_caches
doesn't work for me.
comment:15 2 月 前 由 編輯
Several of my collages and I have experienced the same issue. I am using Debian 12 and I have installed VirtualBox 7.1.4 using the official .deb from the download page. The workaround echo 3 | sudo tee /proc/sys/vm/drop_caches provided above fixes the issue. But the VM is powered off when I get the VERR_NO_LOW_MEMORY error, which means I lose the the state of the VM when the error happens. 😢 Let me know if I can provide any extra information to help fixing the issue.
comment:16 7 週 前 由 編輯
Any news on this ticket? I was hoping that it would be fixed in 7.1.6 since this is big bug and is extremely annoying but it has been 4 months and there is no fix in sight. Btw this is reproducible really easily with the official VirtualBox version. The cache command workaround at least works but it's not a great solution...
comment:17 7 週 前 由 編輯
The immediate issue here seems to be that we're needlessly allocating memory below 4GB for the shadow page pool during VM construct (the failing PGMR0PoolGrow/pgmR3PoolInit calls in the log) because of some init misordering. (Note to self: HMR0SetupVM/VMXR0SetupVM sets the HMR0PERVM::fNestedPaging variable used here, but runs from HMR3InitCompleted/VMINITCOMPLETED_RING0. The PGMR3PoolInit code runs a lot earlier from PGMR3Init.)
Another question, however, is if we're somehow not asking strongly enough for memory when allocating it here. Or perhaps we're doing something else slightly wrong during allocation...
comment:18 5 週 前 由 編輯
Lots of people are still having this problem, which remains unfixed :(
https://bbs.archlinux.org/viewtopic.php?id=298056
Time to start reviewing migrating to qemu...
comment:19 2 週 前 由 編輯
I am also seeing this on Versions 7.0.x - I am using an AWS based metal machine i3 instance based on a Debian 12 AWS Marketplace AMI and running many machines in parallel. The metal machine has lots of CPU cores and RAM yet this still happens.
This issue wasn't a problem with a Debian 12 machine running on kernel 6.7.12. A version of the kernel between then till now (6.12/13) is somewhere where this issue has shown itself.
注意:
瀏覽 TracTickets
來幫助您使用待辦事項功能
Hi VirtualBarista,
Please attach VBox.log for a VM which fails to start.