Name CMS_3832222_1748007832.519604_0
Workunit 232529714
Created 23 May 2025, 13:43:57 UTC
Sent 23 May 2025, 14:15:23 UTC
Report deadline 23 Jun 2025, 14:15:23 UTC
Received 24 May 2025, 7:02:12 UTC
Server state Over
Outcome Computation error
Client state Compute error
Exit status -182 (0xFFFFFF4A) ERR_TIMEOUT
Computer ID 10874664
Run time 3 hours 14 min 11 sec
CPU time 10 hours 28 min 27 sec
Validate state Invalid
Credit 0.00
Device peak FLOPS 27.68 GFLOPS
Application version CMS Simulation v70.91 (vbox64_mt_mcore_cms)
windows_x86_64
Peak working set size 71.89 MB
Peak swap size 68.51 MB
Peak disk usage 1.60 GB

Stderr output

<core_client_version>8.0.4</core_client_version>
<![CDATA[
<message>
(unknown error) (317) - exit code 4294967114 (0xffffff4a)</message>
<stderr_txt>
2025-05-23 15:15:25 (13664): vboxwrapper version 26210
2025-05-23 15:15:25 (13664): BOINC client version: 8.0.4
2025-05-23 15:15:25 (13664): Detected: VirtualBox VboxManage Interface (Version: 7.1.4)
2025-05-23 15:15:25 (13664): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-05-23 15:15:25 (13664): Successfully copied 'init_data.xml' to the shared directory.
2025-05-23 15:15:26 (13664): Create VM. (boinc_466fe908d0e55609, slot#15)
2025-05-23 15:15:26 (13664): Setting Memory Size for VM. (4584MB)
2025-05-23 15:15:26 (13664): Setting CPU Count for VM. (4)
2025-05-23 15:15:27 (13664): Setting Chipset Options for VM.
2025-05-23 15:15:27 (13664): Setting Graphics Controller Options for VM. (Driver: VBoxVGA, 16MB)
2025-05-23 15:15:27 (13664): Setting Boot Options for VM.
2025-05-23 15:15:28 (13664): Setting Network Configuration for NAT. (Driver: virtio)
2025-05-23 15:15:28 (13664): Enabling VM Network Access.
2025-05-23 15:15:28 (13664): Disabling USB Support for VM.
2025-05-23 15:15:28 (13664): Disabling COM Port Support for VM.
2025-05-23 15:15:29 (13664): Disabling LPT Port Support for VM.
2025-05-23 15:15:29 (13664): Disabling Audio Support for VM.
2025-05-23 15:15:29 (13664): Disabling Clipboard Support for VM.
2025-05-23 15:15:29 (13664): Disabling Drag and Drop Support for VM.
2025-05-23 15:15:30 (13664): Adding storage controller(s) to VM.
2025-05-23 15:15:30 (13664): Adding virtual disk drive to VM. (CMS_2025_04_08_prod.vdi)
2025-05-23 15:15:33 (13664): Attempts: 3
2025-05-23 15:15:33 (13664): Adding VirtualBox Guest Additions to VM.
2025-05-23 15:15:33 (13664): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2025-05-23 15:15:34 (13664): forwarding host port 57036 to guest port 80
2025-05-23 15:15:34 (13664): Enabling remote desktop for VM.
2025-05-23 15:15:34 (13664): Required extension pack not installed, remote desktop not enabled.
2025-05-23 15:15:34 (13664): Enabling shared directory for VM.
2025-05-23 15:15:35 (13664): Starting VM using VBoxManage interface. (boinc_466fe908d0e55609, slot#15)
2025-05-23 15:15:39 (13664): Successfully started VM. (PID = '25012')
2025-05-23 15:15:39 (13664): Reporting VM Process ID to BOINC.
2025-05-23 15:15:39 (13664): Guest Log: BIOS: VirtualBox 7.1.4
2025-05-23 15:15:39 (13664): Guest Log: CPUID EDX: 0x178bfbff
2025-05-23 15:15:39 (13664): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-05-23 15:15:39 (13664): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-05-23 15:15:39 (13664): VM state change detected. (old = 'poweredoff', new = 'running')
2025-05-23 15:15:39 (13664): Detected: Web Application Enabled (http://localhost:57036)
2025-05-23 15:15:39 (13664): Preference change detected
2025-05-23 15:15:39 (13664): Setting CPU throttle for VM. (100%)
2025-05-23 15:15:39 (13664): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds))
2025-05-23 15:15:41 (13664): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-05-23 15:15:41 (13664): Guest Log: BIOS: Booting from Hard Disk...
2025-05-23 15:15:43 (13664): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-05-23 15:15:43 (13664): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-05-23 15:16:06 (13664): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-05-23 15:16:06 (13664): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-05-23 15:16:06 (13664): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-05-23 15:16:06 (13664): Guest Log: 00:00:00.000090 main     Log opened 2025-05-23T14:16:07.212540000Z
2025-05-23 15:16:06 (13664): Guest Log: 00:00:00.000172 main     OS Product: Linux
2025-05-23 15:16:06 (13664): Guest Log: 00:00:00.000188 main     OS Release: 4.14.232-19.cernvm.x86_64
2025-05-23 15:16:06 (13664): Guest Log: 00:00:00.000202 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-05-23 15:16:06 (13664): Guest Log: 00:00:00.000216 main     Executable: /usr/sbin/VBoxService
2025-05-23 15:16:06 (13664): Guest Log: 00:00:00.000217 main     Process ID: 2288
2025-05-23 15:16:06 (13664): Guest Log: 00:00:00.000217 main     Package type: LINUX_64BITS_GENERIC
2025-05-23 15:16:06 (13664): Guest Log: 00:00:00.000599 main     5.2.6 r120293 started. Verbose level = 0
2025-05-23 15:16:16 (13664): Guest Log: [INFO] Mounting the shared directory
2025-05-23 15:16:16 (13664): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-05-23 15:16:16 (13664): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-05-23 15:16:17 (13664): Guest Log: [INFO] Testing connection to cern.ch
2025-05-23 15:16:17 (13664): Guest Log: [INFO] Testing connection to VCCS
2025-05-23 15:16:17 (13664): Guest Log: [INFO] Testing connection to HTCondor
2025-05-23 15:16:17 (13664): Guest Log: [INFO] Testing connection to WMAgent
2025-05-23 15:16:17 (13664): Guest Log: [INFO] Testing connection to EOSCMS
2025-05-23 15:16:17 (13664): Guest Log: [INFO] Testing connection to CMS-Factory
2025-05-23 15:16:17 (13664): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-05-23 15:16:17 (13664): Guest Log: [INFO] Testing connection to Frontier
2025-05-23 15:16:17 (13664): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/
2025-05-23 15:16:18 (13664): Guest Log: [INFO] Could not find a local HTTP proxy
2025-05-23 15:16:18 (13664): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-05-23 15:16:18 (13664): Guest Log: [INFO] This makes the application less efficient
2025-05-23 15:16:18 (13664): Guest Log: [INFO] It also puts higher load on the project servers
2025-05-23 15:16:18 (13664): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-05-23 15:16:18 (13664): Guest Log: [INFO] Advice can be found in the project forum
2025-05-23 15:16:19 (13664): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-05-23 15:16:22 (13664): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-05-23 15:16:24 (13664): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2025-05-23 15:16:24 (13664): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2025-05-23 15:16:24 (13664): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2025-05-23 15:16:24 (13664): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2025-05-23 15:16:24 (13664): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2025-05-23 15:16:24 (13664): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2025-05-23 15:16:24 (13664): Guest Log: [INFO] Environment HTTP proxy: not set
2025-05-23 15:16:24 (13664): Guest Log: [INFO] Reading volunteer information
2025-05-23 15:16:34 (13664): Guest Log: [INFO] Using weak account key.
2025-05-23 15:16:34 (13664): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2025-05-23 15:16:35 (13664): Guest Log: [INFO] Using weak account key.
2025-05-23 15:16:35 (13664): Guest Log: [INFO] Requesting an idtoken from LHC@home
2025-05-23 15:16:36 (13664): Guest Log: [INFO] CMS application starting. Check log files.
2025-05-23 15:17:55 (13664): VM state change detected. (old = 'running', new = 'paused')
2025-05-23 16:34:13 (13664): VM state change detected. (old = 'paused', new = 'running')
2025-05-23 16:34:19 (13664): Guest Log: 00:02:00.088144 timesync vgsvcTimeSyncWorker: Radical host time change: 4 587 392 000 000ns (HostNow=1 748 014 458 907 000 000 ns HostLast=1 748 009 871 515 000 000 ns)
2025-05-23 16:34:29 (13664): Guest Log: 00:02:10.090578 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 581 608 857 000ns (GuestNow=1 748 014 468 909 355 000 ns GuestLast=1 748 009 887 300 498 000 ns fSetTimeLastLoop=true )
2025-05-23 18:12:02 (13664): Status Report: Job Duration: '64800.000000'
2025-05-23 18:12:02 (13664): Status Report: Elapsed Time: '6000.000000'
2025-05-23 18:12:02 (13664): Status Report: CPU Time: '18360.421875'
2025-05-23 19:46:52 (13664): VM state change detected. (old = 'running', new = 'paused')
2025-05-23 19:47:09 (13664): Stopping VM.
2025-05-23 19:47:09 (13664): Error in stop VM for VM: -108
Command:
VBoxManage -q controlvm "boinc_466fe908d0e55609" savestate
Output:

2025-05-23 19:47:09 (13664): VM did not stop when requested.
2025-05-23 19:47:09 (13664): VM was NOT successfully terminated.
2025-05-24 07:58:23 (5964): vboxwrapper version 26210
2025-05-24 07:58:23 (5964): BOINC client version: 8.0.4
2025-05-24 07:58:24 (5964): Detected: VirtualBox VboxManage Interface (Version: 7.1.4)
2025-05-24 07:58:24 (5964): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-05-24 07:58:24 (5964): Register VM. (boinc_466fe908d0e55609, slot#15)
2025-05-24 07:58:31 (5964): Error in register for VM: -182
Command:
VBoxManage -q registervm "C:\ProgramData\BOINC\slots\15/boinc_466fe908d0e55609/boinc_466fe908d0e55609.vbox" 
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\15/boinc_466fe908d0e55609/boinc_466fe908d0e55609.vbox' which has the same UUID as an existing virtual machine
VBoxManage.exe: error: Details: code E_FAIL (0x80004005), component MachineWrap, interface IMachine, callee IUnknown
VBoxManage.exe: error: Context: "OpenMachine(Bstr(a->argv[0]).raw(), Bstr(strPassword).raw(), machine.asOutParam()))" at line 159 of file VBoxManageMisc.cpp

2025-05-24 07:58:31 (5964): Could not register
2025-05-24 07:58:31 (5964): ERROR: VM failed to start
2025-05-24 07:58:31 (5964): Powering off VM.
2025-05-24 07:58:31 (5964): Deregistering VM. (boinc_466fe908d0e55609, slot#15)
2025-05-24 07:58:31 (5964): Removing network bandwidth throttle group from VM.
2025-05-24 07:58:31 (5964): Removing VM from VirtualBox.

    Hypervisor System Log:

00:00:07.606599          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.606603          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.606607          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.606611          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.606615          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.606623          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={d644ad1e-c501-4fc7-9ab6-aa6d763bc540} aComponent={VirtualBoxWrap} aText={Could not find a registered machine named 'boinc_466fe908d0e55609'}, preserve=false aResultDetail=0
00:00:07.861010          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861030          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861036          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861045          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861050          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861054          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861058          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861062          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861067          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861071          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861075          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861079          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861083          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861087          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861091          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861095          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861099          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861103          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861110          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861115          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861119          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861124          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861127          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861131          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861135          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861139          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861143          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861147          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861151          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861155          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:07.861162          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={d644ad1e-c501-4fc7-9ab6-aa6d763bc540} aComponent={VirtualBoxWrap} aText={Could not find a registered machine named 'boinc_466fe908d0e55609'}, preserve=false aResultDetail=0

    VM Execution Log:

87976 ns,  165575 calls, max   6553965, min   50002)
04:31:36.052768 /PROF/CPU3/VM/Halt/R0HaltExec      800050 times
04:31:36.052771 /PROF/CPU3/VM/Halt/R0HaltExec/FromBlock   794217 times
04:31:36.052774 /PROF/CPU3/VM/Halt/R0HaltExec/FromSpin     3957 times
04:31:36.052777 /PROF/CPU3/VM/Halt/R0HaltHistoryCounter  1388303 times
04:31:36.052784 /PROF/CPU3/VM/Halt/R0HaltHistorySucceeded        9 times
04:31:36.052790 /PROF/CPU3/VM/Halt/R0HaltHistoryToRing3        9 times
04:31:36.052793 /PROF/CPU3/VM/Halt/R0HaltToR3      588253 times
04:31:36.052795 /PROF/CPU3/VM/Halt/R0HaltToR3/FromSpin      217 times
04:31:36.052798 /PROF/CPU3/VM/Halt/R0HaltToR3/Other      101 times
04:31:36.052800 /PROF/CPU3/VM/Halt/R0HaltToR3/PendingFF   157777 times
04:31:36.052803 /PROF/CPU3/VM/Halt/R0HaltToR3/PostWaitNoInt   276285 times
04:31:36.052805 /PROF/CPU3/VM/Halt/R0HaltToR3/PostWaitPendingFF    62350 times
04:31:36.052807 /PROF/CPU3/VM/Halt/R0HaltToR3/SmallDelta    91523 times
04:31:36.052810 /PROF/CPU3/VM/Halt/Timers            2352 ns/call (  3921143212 ns, 1667111 calls, max   4920433, min       2)
04:31:36.052813 /PROF/CPU3/VM/Halt/Yield             1705 ns/call (    24741243 ns,   14506 calls, max     99426, min       1)
04:31:36.052816 /Public/NetAdapter/0/BytesReceived 605488165 bytes
04:31:36.052818 /Public/NetAdapter/0/BytesTransmitted 24437904 bytes
04:31:36.052821 /Public/NetAdapter/0/virtio-net         0 
04:31:36.052824 /Public/Storage/AHCI0/Port0/BytesRead 1023066624 bytes
04:31:36.052826 /Public/Storage/AHCI0/Port0/BytesWritten 1823412736 bytes
04:31:36.052829 /Public/Storage/AHCI0/Port0/QueryBufAttempts        0 count
04:31:36.052831 /Public/Storage/AHCI0/Port0/QueryBufSuccess        0 count
04:31:36.052834 /Public/Storage/AHCI0/Port0/ReqsFlush     4794 count
04:31:36.052836 /Public/Storage/AHCI0/Port0/ReqsRead    20144 count
04:31:36.052839 /Public/Storage/AHCI0/Port0/ReqsSubmitted    52089 count
04:31:36.052841 /Public/Storage/AHCI0/Port0/ReqsSucceeded    52089 count
04:31:36.052844 /Public/Storage/AHCI0/Port0/ReqsWrite    27151 count
04:31:36.052846 /Public/Storage/AHCI0/Port1/BytesRead   321536 bytes
04:31:36.052849 /Public/Storage/AHCI0/Port1/QueryBufAttempts        0 count
04:31:36.052852 /Public/Storage/AHCI0/Port1/QueryBufSuccess        0 count
04:31:36.052856 /Public/Storage/AHCI0/Port1/ReqsRead       22 count
04:31:36.052859 /Public/Storage/AHCI0/Port1/ReqsSubmitted       22 count
04:31:36.052862 /Public/Storage/AHCI0/Port1/ReqsSucceeded       22 count
04:31:36.052864 /SELM/LoadHidSel/GstReadErrors          0 times
04:31:36.052866 /SELM/LoadHidSel/NoGoodGuest            0 times
04:31:36.052869 /TM/CPU/00/cNsExecuting          9191717909697 ns
04:31:36.052872 /TM/CPU/00/cNsHalted             33098284974 ns
04:31:36.052875 /TM/CPU/00/cNsOther              2470245793160 ns
04:31:36.052877 /TM/CPU/00/cNsTotal              11695061987831 ns
04:31:36.052880 /TM/CPU/00/cPeriodsExecuting     73666136 count
04:31:36.052882 /TM/CPU/00/cPeriodsHalted           83832 count
04:31:36.052885 /TM/CPU/00/pctExecuting                84 %
04:31:36.052887 /TM/CPU/00/pctHalted                    0 %
04:31:36.052890 /TM/CPU/00/pctOther                    15 %
04:31:36.052892 /TM/CPU/01/cNsExecuting          9223085163346 ns
04:31:36.052895 /TM/CPU/01/cNsHalted             55418539793 ns
04:31:36.052897 /TM/CPU/01/cNsOther              2416558284033 ns
04:31:36.052900 /TM/CPU/01/cNsTotal              11695061987172 ns
04:31:36.052903 /TM/CPU/01/cPeriodsExecuting     70754755 count
04:31:36.052905 /TM/CPU/01/cPeriodsHalted           79607 count
04:31:36.052908 /TM/CPU/01/pctExecuting                83 %
04:31:36.052911 /TM/CPU/01/pctHalted                    0 %
04:31:36.052914 /TM/CPU/01/pctOther                    16 %
04:31:36.052917 /TM/CPU/02/cNsExecuting          9229138568985 ns
04:31:36.052919 /TM/CPU/02/cNsHalted             59162732796 ns
04:31:36.052922 /TM/CPU/02/cNsOther              2406760757936 ns
04:31:36.052924 /TM/CPU/02/cNsTotal              11695062059717 ns
04:31:36.052927 /TM/CPU/02/cPeriodsExecuting     72049838 count
04:31:36.052929 /TM/CPU/02/cPeriodsHalted           81927 count
04:31:36.052932 /TM/CPU/02/pctExecuting                84 %
04:31:36.052935 /TM/CPU/02/pctHalted                    0 %
04:31:36.052939 /TM/CPU/02/pctOther                    15 %
04:31:36.052942 /TM/CPU/03/cNsExecuting          8906706699760 ns
04:31:36.052945 /TM/CPU/03/cNsHalted             780591676383 ns
04:31:36.052948 /TM/CPU/03/cNsOther              2007763728857 ns
04:31:36.052950 /TM/CPU/03/cNsTotal              11695062105000 ns
04:31:36.052953 /TM/CPU/03/cPeriodsExecuting     62348881 count
04:31:36.052955 /TM/CPU/03/cPeriodsHalted          502586 count
04:31:36.052958 /TM/CPU/03/pctExecuting                80 %
04:31:36.052960 /TM/CPU/03/pctHalted                    0 %
04:31:36.052963 /TM/CPU/03/pctOther                    19 %
04:31:36.052966 /TM/CPU/pctExecuting                   83 %
04:31:36.052968 /TM/CPU/pctHalted                       0 %
04:31:36.052971 /TM/CPU/pctOther                       16 %
04:31:36.052973 /TM/MaxHzHint                           0 Hz
04:31:36.052976 /TM/MaxHzHint/real                      0 Hz
04:31:36.052978 /TM/MaxHzHint/tsc                       0 Hz
04:31:36.052981 /TM/MaxHzHint/virtual                   0 Hz
04:31:36.052984 /TM/MaxHzHint/virtual_sync              0 Hz
04:31:36.052990 /TM/PIT/Handler                         0 ticks/call (           0 ticks,       0 calls, max         0, min      -1)
04:31:36.052994 /TM/PIT/Irq                             0 times
04:31:36.052997 /TM/R3/1nsSteps                    520990 times
04:31:36.052999 /TM/TSC/offCPU0                  147385670493580 ticks
04:31:36.053002 /TM/TSC/offCPU1                  147385670493580 ticks
04:31:36.053005 /TM/TSC/offCPU2                  147385670493580 ticks
04:31:36.053008 /TM/TSC/offCPU3                  147385670493580 ticks
04:31:36.053012 /TM/VirtualSync/CurrentOffset      334391 ns
04:31:36.053017 /TRPM/ForwardRaw/IRQ/30                77 times
04:31:36.053021 /TRPM/ForwardRaw/IRQ/31                 1 times
04:31:36.053025 /TRPM/ForwardRaw/IRQ/3C                28 times
04:31:36.053029 /TRPM/ForwardRaw/IRQ/41             10465 times
04:31:36.053034 /TRPM/ForwardRaw/IRQ/51             17137 times
04:31:36.053043 /TRPM/ForwardRaw/IRQ/71              2977 times
04:31:36.053052 /TRPM/ForwardRaw/IRQ/EF          52584828 times
04:31:36.053055 /TRPM/ForwardRaw/IRQ/FB            466914 times
04:31:36.053058 /TRPM/ForwardRaw/IRQ/FC              8894 times
04:31:36.053060 /TRPM/ForwardRaw/IRQ/FD            403066 times
04:31:36.053065 /TRPM/ForwardRaw/TRAP/08                2 times
04:31:36.053069 /VMM/EmtHashCollisions/Emt00            0 times
04:31:36.053071 /VMM/EmtHashCollisions/Emt01            0 times
04:31:36.053074 /VMM/EmtHashCollisions/Emt02            0 times
04:31:36.053076 /VMM/EmtHashCollisions/Emt03            0 times
04:31:36.053079 /VMM/LogFlush/00-Flushes                0 times
04:31:36.053082 /VMM/LogFlush/00-NoWakups               0 times
04:31:36.053086 /VMM/LogFlush/CPU0/Rel/cbBuf         4096 bytes
04:31:36.053089 /VMM/LogFlush/CPU1/Rel/cbBuf         4096 bytes
04:31:36.053093 /VMM/LogFlush/CPU2/Rel/cbBuf         4096 bytes
04:31:36.053096 /VMM/LogFlush/CPU3/Rel/cbBuf         4096 bytes
04:31:36.053099 ********************* End of statistics **********************
04:31:36.056272 GIM: KVM: Resetting MSRs
04:31:36.057513 vmmR3LogFlusher: Terminating (VERR_OBJECT_DESTROYED)
04:31:36.057576 Changing the VM state from 'DESTROYING' to 'TERMINATED'
04:31:36.057591 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={6ac83d89-6ee7-4e33-8ae6-b257b2e81be8} aComponent={ConsoleWrap} aText={The object is not ready}, preserve=false aResultDetail=0
04:31:36.057608 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={6ac83d89-6ee7-4e33-8ae6-b257b2e81be8} aComponent={ConsoleWrap} aText={The object is not ready}, preserve=false aResultDetail=0
04:31:36.808924 End of log file - Log started 2025-05-23T14:15:37.849933100Z

    VM Startup Log:


    VM Trace Log:

ximum ICH9 SAS Controllers:   8
Maximum ICH9 NVMe Controllers:  8
Maximum ICH9 virtio-scsi Controllers:  8
Maximum ICH9 Floppy Controllers:1

2025-05-24 07:58:24 (5964): 
Command: VBoxManage -q list hostinfo 
Exit Code: 0
Output:
Host Information:

Host time: 2025-05-24T06:58:24.108000000Z
Processor online count: 16
Processor count: 16
Processor online core count: 8
Processor core count: 8
Processor supports HW virtualization: yes
Processor supports PAE: yes
Processor supports long mode: yes
Processor supports nested paging: yes
Processor supports unrestricted guest: yes
Processor supports nested HW virtualization: yes
Processor supports virt. vmsave/vmload: yes
Processor#0 speed: unknown
Processor#0 description: AMD Ryzen 7 7700X 8-Core Processor
Processor#1 speed: unknown
Processor#1 description: AMD Ryzen 7 7700X 8-Core Processor
Processor#2 speed: unknown
Processor#2 description: AMD Ryzen 7 7700X 8-Core Processor
Processor#3 speed: unknown
Processor#3 description: AMD Ryzen 7 7700X 8-Core Processor
Processor#4 speed: unknown
Processor#4 description: AMD Ryzen 7 7700X 8-Core Processor
Processor#5 speed: unknown
Processor#5 description: AMD Ryzen 7 7700X 8-Core Processor
Processor#6 speed: unknown
Processor#6 description: AMD Ryzen 7 7700X 8-Core Processor
Processor#7 speed: unknown
Processor#7 description: AMD Ryzen 7 7700X 8-Core Processor
Processor#8 speed: unknown
Processor#8 description: AMD Ryzen 7 7700X 8-Core Processor
Processor#9 speed: unknown
Processor#9 description: AMD Ryzen 7 7700X 8-Core Processor
Processor#10 speed: unknown
Processor#10 description: AMD Ryzen 7 7700X 8-Core Processor
Processor#11 speed: unknown
Processor#11 description: AMD Ryzen 7 7700X 8-Core Processor
Processor#12 speed: unknown
Processor#12 description: AMD Ryzen 7 7700X 8-Core Processor
Processor#13 speed: unknown
Processor#13 description: AMD Ryzen 7 7700X 8-Core Processor
Processor#14 speed: unknown
Processor#14 description: AMD Ryzen 7 7700X 8-Core Processor
Processor#15 speed: unknown
Processor#15 description: AMD Ryzen 7 7700X 8-Core Processor
Memory size: 31957 MByte
Memory available: 21978 MByte
Operating system: Windows 11
Operating system version: 10.0.26120

2025-05-24 07:58:24 (5964): 
Command: VBoxManage -q showvminfo "boinc_466fe908d0e55609" --machinereadable 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_466fe908d0e55609'
VBoxManage.exe: error: Details: code VBOX_E_OBJECT_NOT_FOUND (0x80bb0001), component VirtualBoxWrap, interface IVirtualBox, callee IUnknown
VBoxManage.exe: error: Context: "FindMachine(Bstr(VMNameOrUuid).raw(), machine.asOutParam())" at line 3212 of file VBoxManageInfo.cpp

2025-05-24 07:58:24 (5964): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\15/boinc_466fe908d0e55609/boinc_466fe908d0e55609.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\15/boinc_466fe908d0e55609/boinc_466fe908d0e55609.vbox' which has the same UUID as an existing virtual machine
VBoxManage.exe: error: Details: code E_FAIL (0x80004005), component MachineWrap, interface IMachine, callee IUnknown
VBoxManage.exe: error: Context: "OpenMachine(Bstr(a->argv[0]).raw(), Bstr(strPassword).raw(), machine.asOutParam()))" at line 159 of file VBoxManageMisc.cpp

2025-05-24 07:58:26 (5964): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\15/boinc_466fe908d0e55609/boinc_466fe908d0e55609.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\15/boinc_466fe908d0e55609/boinc_466fe908d0e55609.vbox' which has the same UUID as an existing virtual machine
VBoxManage.exe: error: Details: code E_FAIL (0x80004005), component MachineWrap, interface IMachine, callee IUnknown
VBoxManage.exe: error: Context: "OpenMachine(Bstr(a->argv[0]).raw(), Bstr(strPassword).raw(), machine.asOutParam()))" at line 159 of file VBoxManageMisc.cpp

2025-05-24 07:58:27 (5964): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\15/boinc_466fe908d0e55609/boinc_466fe908d0e55609.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\15/boinc_466fe908d0e55609/boinc_466fe908d0e55609.vbox' which has the same UUID as an existing virtual machine
VBoxManage.exe: error: Details: code E_FAIL (0x80004005), component MachineWrap, interface IMachine, callee IUnknown
VBoxManage.exe: error: Context: "OpenMachine(Bstr(a->argv[0]).raw(), Bstr(strPassword).raw(), machine.asOutParam()))" at line 159 of file VBoxManageMisc.cpp

2025-05-24 07:58:28 (5964): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\15/boinc_466fe908d0e55609/boinc_466fe908d0e55609.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\15/boinc_466fe908d0e55609/boinc_466fe908d0e55609.vbox' which has the same UUID as an existing virtual machine
VBoxManage.exe: error: Details: code E_FAIL (0x80004005), component MachineWrap, interface IMachine, callee IUnknown
VBoxManage.exe: error: Context: "OpenMachine(Bstr(a->argv[0]).raw(), Bstr(strPassword).raw(), machine.asOutParam()))" at line 159 of file VBoxManageMisc.cpp

2025-05-24 07:58:29 (5964): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\15/boinc_466fe908d0e55609/boinc_466fe908d0e55609.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\15/boinc_466fe908d0e55609/boinc_466fe908d0e55609.vbox' which has the same UUID as an existing virtual machine
VBoxManage.exe: error: Details: code E_FAIL (0x80004005), component MachineWrap, interface IMachine, callee IUnknown
VBoxManage.exe: error: Context: "OpenMachine(Bstr(a->argv[0]).raw(), Bstr(strPassword).raw(), machine.asOutParam()))" at line 159 of file VBoxManageMisc.cpp

2025-05-24 07:58:31 (5964): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\15/boinc_466fe908d0e55609/boinc_466fe908d0e55609.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\15/boinc_466fe908d0e55609/boinc_466fe908d0e55609.vbox' which has the same UUID as an existing virtual machine
VBoxManage.exe: error: Details: code E_FAIL (0x80004005), component MachineWrap, interface IMachine, callee IUnknown
VBoxManage.exe: error: Context: "OpenMachine(Bstr(a->argv[0]).raw(), Bstr(strPassword).raw(), machine.asOutParam()))" at line 159 of file VBoxManageMisc.cpp

2025-05-24 07:58:31 (5964): 
Command: VBoxManage -q snapshot "boinc_466fe908d0e55609" list 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_466fe908d0e55609'
VBoxManage.exe: error: Details: code VBOX_E_OBJECT_NOT_FOUND (0x80bb0001), component VirtualBoxWrap, interface IVirtualBox, callee IUnknown
VBoxManage.exe: error: Context: "FindMachine(bstrMachine.raw(), pMachine.asOutParam())" at line 345 of file VBoxManageSnapshot.cpp

2025-05-24 07:58:31 (5964): 
Command: VBoxManage -q bandwidthctl "boinc_466fe908d0e55609" remove "boinc_466fe908d0e55609_net" 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_466fe908d0e55609'
VBoxManage.exe: error: Details: code VBOX_E_OBJECT_NOT_FOUND (0x80bb0001), component VirtualBoxWrap, interface IVirtualBox, callee IUnknown
VBoxManage.exe: error: Context: "FindMachine(Bstr(a->argv[0]).raw(), machine.asOutParam())" at line 334 of file VBoxManageBandwidthControl.cpp

2025-05-24 07:58:31 (5964): 
Command: VBoxManage -q unregistervm "boinc_466fe908d0e55609" --delete 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_466fe908d0e55609'
VBoxManage.exe: error: Details: code VBOX_E_OBJECT_NOT_FOUND (0x80bb0001), component VirtualBoxWrap, interface IVirtualBox, callee IUnknown
VBoxManage.exe: error: Context: "FindMachine(Bstr(VMName).raw(), machine.asOutParam())" at line 230 of file VBoxManageMisc.cpp

2025-05-24 07:58:41 (5964): called boinc_finish(-182)

</stderr_txt>
]]>


©2025 CERN