Stderr output

<core_client_version>8.0.2</core_client_version>
<![CDATA[
<message>
(unknown error) (317) - exit code 4294967114 (0xffffff4a)</message>
<stderr_txt>
2025-06-14 23:40:52 (4324): vboxwrapper version 26210
2025-06-14 23:40:52 (4324): BOINC client version: 8.0.2
2025-06-14 23:40:52 (4324): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-06-14 23:40:52 (4324): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-06-14 23:40:52 (4324): Successfully copied 'init_data.xml' to the shared directory.
2025-06-14 23:40:53 (4324): Create VM. (boinc_b3a7986ccc99537e, slot#1)
2025-06-14 23:40:56 (4324): Setting Memory Size for VM. (4584MB)
2025-06-14 23:40:56 (4324): Setting CPU Count for VM. (4)
2025-06-14 23:40:56 (4324): Setting Chipset Options for VM.
2025-06-14 23:40:56 (4324): Setting Graphics Controller Options for VM. (Driver: VBoxVGA, 16MB)
2025-06-14 23:40:57 (4324): Setting Boot Options for VM.
2025-06-14 23:40:57 (4324): Setting Network Configuration for NAT. (Driver: virtio)
2025-06-14 23:40:57 (4324): Enabling VM Network Access.
2025-06-14 23:40:58 (4324): Disabling USB Support for VM.
2025-06-14 23:40:58 (4324): Disabling COM Port Support for VM.
2025-06-14 23:40:58 (4324): Disabling LPT Port Support for VM.
2025-06-14 23:40:58 (4324): Disabling Audio Support for VM.
2025-06-14 23:40:59 (4324): Disabling Clipboard Support for VM.
2025-06-14 23:40:59 (4324): Disabling Drag and Drop Support for VM.
2025-06-14 23:40:59 (4324): Adding storage controller(s) to VM.
2025-06-14 23:41:00 (4324): Adding virtual disk drive to VM. (CMS_2025_04_08_prod.vdi)
2025-06-14 23:41:01 (4324): Adding VirtualBox Guest Additions to VM.
2025-06-14 23:41:01 (4324): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2025-06-14 23:41:01 (4324): forwarding host port 50751 to guest port 80
2025-06-14 23:41:01 (4324): Enabling remote desktop for VM.
2025-06-14 23:41:02 (4324): Required extension pack not installed, remote desktop not enabled.
2025-06-14 23:41:02 (4324): Enabling shared directory for VM.
2025-06-14 23:41:02 (4324): Starting VM using VBoxManage interface. (boinc_b3a7986ccc99537e, slot#1)
2025-06-14 23:41:14 (4324): Successfully started VM. (PID = '7832')
2025-06-14 23:41:14 (4324): Reporting VM Process ID to BOINC.
2025-06-14 23:41:14 (4324): Guest Log: BIOS: VirtualBox 7.0.6
2025-06-14 23:41:14 (4324): Guest Log: CPUID EDX: 0x178bfbff
2025-06-14 23:41:14 (4324): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-06-14 23:41:14 (4324): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-06-14 23:41:14 (4324): VM state change detected. (old = 'poweredoff', new = 'running')
2025-06-14 23:41:14 (4324): Detected: Web Application Enabled (http://localhost:50751)
2025-06-14 23:41:14 (4324): Preference change detected
2025-06-14 23:41:14 (4324): Setting CPU throttle for VM. (100%)
2025-06-14 23:41:15 (4324): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 30 seconds) or (Vbox_job.xml: 600 seconds))
2025-06-14 23:41:15 (4324): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-06-14 23:41:15 (4324): Guest Log: BIOS: Booting from Hard Disk...
2025-06-14 23:41:18 (4324): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-06-14 23:41:18 (4324): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-06-14 23:41:43 (4324): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-06-14 23:41:43 (4324): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-06-14 23:41:45 (4324): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-06-14 23:41:45 (4324): Guest Log: 00:00:00.000108 main     Log opened 2025-06-14T21:41:43.454425000Z
2025-06-14 23:41:45 (4324): Guest Log: 00:00:00.000214 main     OS Product: Linux
2025-06-14 23:41:45 (4324): Guest Log: 00:00:00.000246 main     OS Release: 4.14.232-19.cernvm.x86_64
2025-06-14 23:41:45 (4324): Guest Log: 00:00:00.000276 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-06-14 23:41:45 (4324): Guest Log: 00:00:00.000305 main     Executable: /usr/sbin/VBoxService
2025-06-14 23:41:45 (4324): Guest Log: 00:00:00.000306 main     Process ID: 2285
2025-06-14 23:41:45 (4324): Guest Log: 00:00:00.000307 main     Package type: LINUX_64BITS_GENERIC
2025-06-14 23:41:45 (4324): Guest Log: 00:00:00.002525 main     5.2.6 r120293 started. Verbose level = 0
2025-06-14 23:42:20 (4324): Guest Log: [INFO] Mounting the shared directory
2025-06-14 23:42:20 (4324): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-06-14 23:42:20 (4324): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-06-14 23:42:22 (4324): Guest Log: [INFO] Testing connection to cern.ch
2025-06-14 23:42:22 (4324): Guest Log: [INFO] Testing connection to VCCS
2025-06-14 23:42:22 (4324): Guest Log: [INFO] Testing connection to HTCondor
2025-06-14 23:42:23 (4324): Guest Log: [INFO] Testing connection to WMAgent
2025-06-14 23:42:23 (4324): Guest Log: [INFO] Testing connection to EOSCMS
2025-06-14 23:42:23 (4324): Guest Log: [INFO] Testing connection to CMS-Factory
2025-06-14 23:42:23 (4324): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-06-14 23:42:23 (4324): Guest Log: [INFO] Testing connection to Frontier
2025-06-14 23:42:24 (4324): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/
2025-06-14 23:42:25 (4324): Guest Log: [INFO] Could not find a local HTTP proxy
2025-06-14 23:42:26 (4324): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-06-14 23:42:26 (4324): Guest Log: [INFO] This makes the application less efficient
2025-06-14 23:42:26 (4324): Guest Log: [INFO] It also puts higher load on the project servers
2025-06-14 23:42:26 (4324): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-06-14 23:42:26 (4324): Guest Log: [INFO] Advice can be found in the project forum
2025-06-14 23:42:30 (4324): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-06-14 23:42:43 (4324): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-06-14 23:42:50 (4324): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2025-06-14 23:42:50 (4324): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2025-06-14 23:42:50 (4324): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2025-06-14 23:42:50 (4324): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2025-06-14 23:42:53 (4324): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2025-06-14 23:42:53 (4324): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT
2025-06-14 23:42:54 (4324): Guest Log: [INFO] Environment HTTP proxy: not set
2025-06-14 23:42:56 (4324): Guest Log: [INFO] Reading volunteer information
2025-06-14 23:43:45 (4324): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2025-06-14 23:43:55 (4324): Guest Log: [INFO] Requesting an idtoken from LHC@home
2025-06-14 23:43:59 (4324): Guest Log: [INFO] CMS application starting. Check log files.
2025-06-15 00:21:12 (4324): Error in parsing the log file
2025-06-15 00:21:12 (4324): WARNING: Vboxwrapper poll command returned -148.
2025-06-15 00:21:24 (4324): VM state change detected. (old = 'running', new = 'paused')
2025-06-15 00:21:42 (4324): VM state change detected. (old = 'paused', new = 'running')
2025-06-15 00:30:25 (3348): Can't acquire lockfile (32) - waiting 35s
2025-06-15 00:31:00 (3348): Can't acquire lockfile (32) - exiting
2025-06-15 00:31:00 (3348): Error: Der Prozess kann nicht auf die Datei zugreifen, da sie von einem anderen Prozess verwendet wird.

 (0x20)
2025-06-15 00:34:15 (10848): Can't acquire lockfile (32) - waiting 35s
2025-06-15 00:34:50 (10848): Can't acquire lockfile (32) - exiting
2025-06-15 00:34:50 (10848): Error: Der Prozess kann nicht auf die Datei zugreifen, da sie von einem anderen Prozess verwendet wird.

 (0x20)
2025-06-15 00:43:06 (4324): VM Heartbeat file specified, but missing heartbeat.
2025-06-15 00:43:06 (4324): Powering off VM.
2025-06-15 00:43:52 (4324): Error in poweroff VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_b3a7986ccc99537e" poweroff
Output:
0%...10%...20%...
2025-06-15 00:43:52 (4324): VM did not power off when requested.
2025-06-15 00:43:52 (4324): VM was NOT successfully terminated.
2025-06-15 00:43:52 (4324): Deregistering VM. (boinc_b3a7986ccc99537e, slot#1)
2025-06-15 00:43:52 (4324): Removing network bandwidth throttle group from VM.
2025-06-15 00:43:53 (4324): Removing VM from VirtualBox.

    Hypervisor System Log:

00:12:12.709460          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={7682d5eb-f00e-44f1-8ca2-99d08b1cd607} aComponent={VirtualBoxWrap} aText={&#197;&#131;o extension pack providing a cryptographic support module could be found}, preserve=false aResultDetail=0
00:12:12.738337          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:12:12.738429          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:12:12.747017          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
00:12:13.002985          Launched VM: 3501940064 pid: 9248 (0x2420) frontend: headless name: boinc_b3a7986ccc99537e
00:12:22.940991          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Property 'CRYPT/KeyId' does not exist}, preserve=false aResultDetail=0
00:12:22.942125          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Property 'CRYPT/KeyId' does not exist}, preserve=false aResultDetail=0
00:12:25.538343          Saving settings file "C:\ProgramData\BOINC\slots\1\boinc_b3a7986ccc99537e\boinc_b3a7986ccc99537e.vbox" with version "1.19-windows"
00:12:25.543795          Finished saving settings file "C:\ProgramData\BOINC\slots\1\boinc_b3a7986ccc99537e\boinc_b3a7986ccc99537e.vbox"
00:20:04.896596 dns-monitor HostDnsMonitor: updating information
00:20:04.896639 dns-monitor HostDnsMonitor: unchanged
00:35:05.054136 dns-monitor HostDnsMonitor: updating information
00:35:05.054252 dns-monitor HostDnsMonitor: unchanged
00:50:05.142274 dns-monitor HostDnsMonitor: updating information
00:50:05.142764 dns-monitor HostDnsMonitor: unchanged
01:00:32.368382          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={7682d5eb-f00e-44f1-8ca2-99d08b1cd607} aComponent={VirtualBoxWrap} aText={&#197;&#131;o extension pack providing a cryptographic support module could be found}, preserve=false aResultDetail=0
01:00:32.464848          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
01:00:32.464966          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
01:00:32.520756          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
01:00:41.355588          ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The machine 'boinc_01328f0a585541e3' is already locked by a session (or being locked or unlocked)}, preserve=false aResultDetail=0
01:00:44.180498          ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The machine 'boinc_01328f0a585541e3' is already locked by a session (or being locked or unlocked)}, preserve=false aResultDetail=0
01:00:46.300627          ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The machine 'boinc_01328f0a585541e3' is already locked by a session (or being locked or unlocked)}, preserve=false aResultDetail=0
01:00:50.423830          ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The machine 'boinc_01328f0a585541e3' is already locked by a session (or being locked or unlocked)}, preserve=false aResultDetail=0
01:00:58.549084          ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The machine 'boinc_01328f0a585541e3' is already locked by a session (or being locked or unlocked)}, preserve=false aResultDetail=0
01:01:14.670881          ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The machine 'boinc_01328f0a585541e3' is already locked by a session (or being locked or unlocked)}, preserve=false aResultDetail=0
01:01:14.752088          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
01:01:15.083311          ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={Cannot unregister the machine 'boinc_01328f0a585541e3' while it is locked}, preserve=false aResultDetail=0
01:01:16.356085          ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={Cannot unregister the machine 'boinc_01328f0a585541e3' while it is locked}, preserve=false aResultDetail=0
01:01:18.617067          ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={Cannot unregister the machine 'boinc_01328f0a585541e3' while it is locked}, preserve=false aResultDetail=0
01:03:15.269493 dns-monitor HostDnsMonitor: updating information
01:03:15.269529 dns-monitor HostDnsMonitor: unchanged
01:05:05.300861 dns-monitor HostDnsMonitor: updating information
01:05:05.301017 dns-monitor HostDnsMonitor: unchanged
01:15:03.087654          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
01:15:03.422511          ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={Cannot unregister the machine 'boinc_b3a7986ccc99537e' while it is locked}, preserve=false aResultDetail=0
01:15:04.687240          ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={Cannot unregister the machine 'boinc_b3a7986ccc99537e' while it is locked}, preserve=false aResultDetail=0
01:15:06.948336          ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={Cannot unregister the machine 'boinc_b3a7986ccc99537e' while it is locked}, preserve=false aResultDetail=0
01:15:11.207999          ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={Cannot unregister the machine 'boinc_b3a7986ccc99537e' while it is locked}, preserve=false aResultDetail=0
01:15:19.473549          ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={Cannot unregister the machine 'boinc_b3a7986ccc99537e' while it is locked}, preserve=false aResultDetail=0
01:15:35.734636          ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={Cannot unregister the machine 'boinc_b3a7986ccc99537e' while it is locked}, preserve=false aResultDetail=0

    VM Execution Log:

00:40:06.227625 PGM: aHandyPages[#0x4e] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227627 PGM: aHandyPages[#0x4f] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227628 PGM: aHandyPages[#0x50] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227630 PGM: aHandyPages[#0x51] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227632 PGM: aHandyPages[#0x52] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227633 PGM: aHandyPages[#0x53] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227635 PGM: aHandyPages[#0x54] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227636 PGM: aHandyPages[#0x55] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227638 PGM: aHandyPages[#0x56] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227639 PGM: aHandyPages[#0x57] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227641 PGM: aHandyPages[#0x58] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227642 PGM: aHandyPages[#0x59] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227644 PGM: aHandyPages[#0x5a] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227645 PGM: aHandyPages[#0x5b] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227647 PGM: aHandyPages[#0x5c] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227648 PGM: aHandyPages[#0x5d] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227650 PGM: aHandyPages[#0x5e] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.229312 *FLUSH DONE*
00:40:06.236394 *FLUSH*
00:40:06.227651 PGM: aHandyPages[#0x5f] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227653 PGM: aHandyPages[#0x60] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227654 PGM: aHandyPages[#0x61] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227656 PGM: aHandyPages[#0x62] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227657 PGM: aHandyPages[#0x63] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227659 PGM: aHandyPages[#0x64] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227660 PGM: aHandyPages[#0x65] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227662 PGM: aHandyPages[#0x66] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227663 PGM: aHandyPages[#0x67] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227665 PGM: aHandyPages[#0x68] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227667 PGM: aHandyPages[#0x69] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227668 PGM: aHandyPages[#0x6a] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227670 PGM: aHandyPages[#0x6b] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227671 PGM: aHandyPages[#0x6c] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227673 PGM: aHandyPages[#0x6d] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227674 PGM: aHandyPages[#0x6e] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227676 PGM: aHandyPages[#0x6f] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227677 PGM: aHandyPages[#0x70] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227679 PGM: aHandyPages[#0x71] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227680 PGM: aHandyPages[#0x72] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227682 PGM: aHandyPages[#0x73] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227683 PGM: aHandyPages[#0x74] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227685 PGM: aHandyPages[#0x75] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227686 PGM: aHandyPages[#0x76] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227688 PGM: aHandyPages[#0x77] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227689 PGM: aHandyPages[#0x78] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227691 PGM: aHandyPages[#0x79] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227692 PGM: aHandyPages[#0x7a] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227694 PGM: aHandyPages[#0x7b] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227695 PGM: aHandyPages[#0x7c] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227697 PGM: aHandyPages[#0x7d] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227698 PGM: aHandyPages[#0x7e] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.227700 PGM: aHandyPages[#0x7f] = {.HCPhysGCPhys=7fffffffffffffff, .idPage=0x000000, .idSharedPage=0x000000}
00:40:06.236443 *END*
00:40:10.308290 VMMDev: vmmDevHeartbeatFlatlinedTimer: Guest seems to be unresponsive. Last heartbeat received 4 seconds ago
00:40:10.308382 VM: Raising runtime error 'HostMemoryLow' (fFlags=0x2)
00:40:10.308526 Changing the VM state from 'RUNNING' to 'SUSPENDING'
00:40:17.492350 AIOMgr: Endpoint for file 'C:\ProgramData\BOINC\slots\1\boinc_b3a7986ccc99537e\Snapshots\{0cc2fd85-fc5e-4f11-802b-22312600cb84}.vdi' (flags 000c0781) created successfully
00:40:17.495586 PDMR3Suspend: Driver 'VD'/0 on LUN#0 of device 'ahci'/0 took 7 186 829 734 ns to suspend
00:40:17.496214 PDMR3Suspend: 7 187 602 490 ns run time
00:40:17.496229 Changing the VM state from 'SUSPENDING' to 'SUSPENDED'
00:40:17.496245 Console: Machine state changed to 'Paused'
00:40:17.497749 Console: VM runtime error: fatal=false, errorID=HostMemoryLow message="Unable to allocate and lock memory. The virtual machine will be paused. Please close applications to free up memory or close the VM"
00:40:36.016267 Changing the VM state from 'SUSPENDED' to 'RESUMING'
00:40:36.033500 AIOMgr: Endpoint for file 'C:\ProgramData\BOINC\slots\1\boinc_b3a7986ccc99537e\Snapshots\{0cc2fd85-fc5e-4f11-802b-22312600cb84}.vdi' (flags 000c0723) created successfully
00:40:36.037744 Changing the VM state from 'RESUMING' to 'RUNNING'
00:40:36.037770 Console: Machine state changed to 'Running'
00:40:36.038167 VMMDev: GuestHeartBeat: Guest is alive (gone 11 472 908 396 ns)
00:40:36.051286 AIOMgr: Async flushes not supported
00:40:43.134750 I/O cache: Error while writing entry at offset 12235665920 (245760 bytes) to medium "ahci-0-0" (rc=VERR_NO_MEMORY)
00:40:43.134831 VM: Raising runtime error 'BLKCACHE_IOERR' (fFlags=0x6)
00:40:43.134902 Changing the VM state from 'RUNNING' to 'SUSPENDING'
00:40:43.134975 PDMR3Suspend: after     0 ms, 1 loops: 1 async tasks - ahci/0
01:02:00.113067 Console: Machine state changed to 'Stopping'
01:02:00.113593 Console::powerDown(): A request to power off the VM has been issued (mMachineState=Stopping, InUninit=0)
01:02:00.113814 PDMR3Suspend: after 1276978 ms, 2 loops: 1 async tasks - ahci/0

    VM Startup Log:


    VM Trace Log:

oxManage -q modifyvm "boinc_b3a7986ccc99537e" --nic1 nat --nic-type1 "virtio" --cable-connected1 off --nat-dns-proxy1 on 
Exit Code: 0
Output:

2025-06-14 23:40:58 (4324): 
Command: VBoxManage -q modifyvm "boinc_b3a7986ccc99537e" --cable-connected1 on 
Exit Code: 0
Output:

2025-06-14 23:40:58 (4324): 
Command: VBoxManage -q modifyvm "boinc_b3a7986ccc99537e" --usb off 
Exit Code: 0
Output:

2025-06-14 23:40:58 (4324): 
Command: VBoxManage -q modifyvm "boinc_b3a7986ccc99537e" --uart1 off --uart2 off 
Exit Code: 0
Output:

2025-06-14 23:40:58 (4324): 
Command: VBoxManage -q modifyvm "boinc_b3a7986ccc99537e" --lpt1 off --lpt2 off 
Exit Code: 0
Output:

2025-06-14 23:40:59 (4324): 
Command: VBoxManage -q modifyvm "boinc_b3a7986ccc99537e" --audio-enabled off 
Exit Code: 0
Output:

2025-06-14 23:40:59 (4324): 
Command: VBoxManage -q modifyvm "boinc_b3a7986ccc99537e" --clipboard disabled 
Exit Code: 0
Output:

2025-06-14 23:40:59 (4324): 
Command: VBoxManage -q modifyvm "boinc_b3a7986ccc99537e" --draganddrop disabled 
Exit Code: 0
Output:

2025-06-14 23:41:00 (4324): 
Command: VBoxManage -q storagectl "boinc_b3a7986ccc99537e" --name "Hard Disk Controller" --add "sata" --controller "IntelAHCI" --hostiocache off --portcount 3
Exit Code: 0
Output:

2025-06-14 23:41:00 (4324): 
Command: VBoxManage -q showhdinfo "C:\ProgramData\BOINC/projects/lhcathome.cern.ch_lhcathome/CMS_2025_04_08_prod.vdi" 
Exit Code: 0
Output:
UUID:           fa49c4e2-ad29-47a5-b96a-3c89ce80d84c
Parent UUID:    base
State:          created
Type:           normal (base)
Location:       C:\ProgramData\BOINC\projects\lhcathome.cern.ch_lhcathome\CMS_2025_04_08_prod.vdi
Storage format: VDI
Format variant: dynamic default
Capacity:       20480 MBytes
Size on disk:   3853 MBytes
Encryption:     disabled
Property:       AllocationBlockSize=1048576

2025-06-14 23:41:00 (4324): 
Command: VBoxManage -q storageattach "boinc_b3a7986ccc99537e" --storagectl "Hard Disk Controller" --port 0 --device 0 --type hdd --medium "C:\ProgramData\BOINC/projects/lhcathome.cern.ch_lhcathome/CMS_2025_04_08_prod.vdi" 
Exit Code: 0
Output:

2025-06-14 23:41:00 (4324): 
Command: VBoxManage -q storageattach "boinc_b3a7986ccc99537e" --storagectl "Hard Disk Controller" --port 0 --device 0 --type hdd --medium none 
Exit Code: 0
Output:

2025-06-14 23:41:01 (4324): 
Command: VBoxManage -q storageattach "boinc_b3a7986ccc99537e" --storagectl "Hard Disk Controller" --port 0 --device 0 --type hdd --mtype multiattach --medium "C:\ProgramData\BOINC/projects/lhcathome.cern.ch_lhcathome/CMS_2025_04_08_prod.vdi" 
Exit Code: 0
Output:

2025-06-14 23:41:01 (4324): 
Command: VBoxManage -q storageattach "boinc_b3a7986ccc99537e" --storagectl "Hard Disk Controller" --port 1 --device 0 --type dvddrive --medium "C:\Program Files\Oracle\VirtualBox/VBoxGuestAdditions.iso" 
Exit Code: 0
Output:

2025-06-14 23:41:01 (4324): 
Command: VBoxManage -q bandwidthctl "boinc_b3a7986ccc99537e" add "boinc_b3a7986ccc99537e_net" --type network --limit 1024G 
Exit Code: 0
Output:

2025-06-14 23:41:01 (4324): 
Command: VBoxManage -q modifyvm "boinc_b3a7986ccc99537e" --natpf1 ",tcp,127.0.0.1,50751,,80" 
Exit Code: 0
Output:

2025-06-14 23:41:02 (4324): 
Command: VBoxManage -q list extpacks
Exit Code: 0
Output:
Extension Packs: 0

2025-06-14 23:41:02 (4324): 
Command: VBoxManage -q sharedfolder add "boinc_b3a7986ccc99537e" --name "shared" --hostpath "C:\ProgramData\BOINC\slots\1/shared"
Exit Code: 0
Output:

2025-06-14 23:41:12 (4324): 
Command: VBoxManage -q startvm "boinc_b3a7986ccc99537e" --type headless
Exit Code: 0
Output:
Waiting for VM "boinc_b3a7986ccc99537e" to power on...
VM "boinc_b3a7986ccc99537e" has been successfully started.

2025-06-14 23:41:15 (4324): 
Command: VBoxManage -q controlvm "boinc_b3a7986ccc99537e" cpuexecutioncap 100 
Exit Code: 0
Output:

2025-06-15 00:21:42 (4324): 
Command: VBoxManage -q controlvm "boinc_b3a7986ccc99537e" resume
Exit Code: 0
Output:

2025-06-15 00:43:52 (4324): 
Command: VBoxManage -q controlvm "boinc_b3a7986ccc99537e" poweroff
Exit Code: -182
Output:
0%...10%...20%...
2025-06-15 00:43:52 (4324): 
Command: VBoxManage -q snapshot "boinc_b3a7986ccc99537e" list 
Exit Code: -108
Output:
This machine does not have any snapshots

2025-06-15 00:43:53 (4324): 
Command: VBoxManage -q bandwidthctl "boinc_b3a7986ccc99537e" remove "boinc_b3a7986ccc99537e_net" 
Exit Code: 0
Output:
VBoxManage.exe: error: Bandwidth groups cannot be deleted while the VM is running

2025-06-15 00:43:53 (4324): 
Command: VBoxManage -q unregistervm "boinc_b3a7986ccc99537e" --delete 
Exit Code: -2135228409
Output:
VBoxManage.exe: error: Cannot unregister the machine 'boinc_b3a7986ccc99537e' while it is locked
VBoxManage.exe: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee IUnknown
VBoxManage.exe: error: Context: "Unregister(fDeleteAll ? CleanupMode_DetachAllReturnHardDisksAndVMRemovable :CleanupMode_DetachAllReturnHardDisksOnly, ComSafeArrayAsOutParam(aMedia))" at line 236 of file VBoxManageMisc.cpp

2025-06-15 00:43:54 (4324): 
Command: VBoxManage -q unregistervm "boinc_b3a7986ccc99537e" --delete 
Exit Code: -2135228409
Output:
VBoxManage.exe: error: Cannot unregister the machine 'boinc_b3a7986ccc99537e' while it is locked
VBoxManage.exe: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee IUnknown
VBoxManage.exe: error: Context: "Unregister(fDeleteAll ? CleanupMode_DetachAllReturnHardDisksAndVMRemovable :CleanupMode_DetachAllReturnHardDisksOnly, ComSafeArrayAsOutParam(aMedia))" at line 236 of file VBoxManageMisc.cpp

2025-06-15 00:43:56 (4324): 
Command: VBoxManage -q unregistervm "boinc_b3a7986ccc99537e" --delete 
Exit Code: -2135228409
Output:
VBoxManage.exe: error: Cannot unregister the machine 'boinc_b3a7986ccc99537e' while it is locked
VBoxManage.exe: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee IUnknown
VBoxManage.exe: error: Context: "Unregister(fDeleteAll ? CleanupMode_DetachAllReturnHardDisksAndVMRemovable :CleanupMode_DetachAllReturnHardDisksOnly, ComSafeArrayAsOutParam(aMedia))" at line 236 of file VBoxManageMisc.cpp

2025-06-15 00:44:01 (4324): 
Command: VBoxManage -q unregistervm "boinc_b3a7986ccc99537e" --delete 
Exit Code: -2135228409
Output:
VBoxManage.exe: error: Cannot unregister the machine 'boinc_b3a7986ccc99537e' while it is locked
VBoxManage.exe: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee IUnknown
VBoxManage.exe: error: Context: "Unregister(fDeleteAll ? CleanupMode_DetachAllReturnHardDisksAndVMRemovable :CleanupMode_DetachAllReturnHardDisksOnly, ComSafeArrayAsOutParam(aMedia))" at line 236 of file VBoxManageMisc.cpp

2025-06-15 00:44:09 (4324): 
Command: VBoxManage -q unregistervm "boinc_b3a7986ccc99537e" --delete 
Exit Code: -2135228409
Output:
VBoxManage.exe: error: Cannot unregister the machine 'boinc_b3a7986ccc99537e' while it is locked
VBoxManage.exe: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee IUnknown
VBoxManage.exe: error: Context: "Unregister(fDeleteAll ? CleanupMode_DetachAllReturnHardDisksAndVMRemovable :CleanupMode_DetachAllReturnHardDisksOnly, ComSafeArrayAsOutParam(aMedia))" at line 236 of file VBoxManageMisc.cpp

2025-06-15 00:44:25 (4324): 
Command: VBoxManage -q unregistervm "boinc_b3a7986ccc99537e" --delete 
Exit Code: -2135228409
Output:
VBoxManage.exe: error: Cannot unregister the machine 'boinc_b3a7986ccc99537e' while it is locked
VBoxManage.exe: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee IUnknown
VBoxManage.exe: error: Context: "Unregister(fDeleteAll ? CleanupMode_DetachAllReturnHardDisksAndVMRemovable :CleanupMode_DetachAllReturnHardDisksOnly, ComSafeArrayAsOutParam(aMedia))" at line 236 of file VBoxManageMisc.cpp

2025-06-15 00:44:41 (4324): called boinc_finish(-182)

</stderr_txt>
]]>

©2025 CERN