Name CMS_2280638_1719161779.864100_0
Workunit 223714812
Created 23 Jun 2024, 16:56:24 UTC
Sent 23 Jun 2024, 17:49:06 UTC
Report deadline 24 Jul 2024, 17:49:06 UTC
Received 24 Jun 2024, 6:11:13 UTC
Server state Over
Outcome Computation error
Client state Compute error
Exit status -182 (0xFFFFFF4A) ERR_TIMEOUT
Computer ID 10839013
Run time 40 min 7 sec
CPU time 2 min 16 sec
Validate state Invalid
Credit 0.00
Device peak FLOPS 20.77 GFLOPS
Application version CMS Simulation v70.30 (vbox64_mt_mcore_cms)
windows_x86_64
Peak working set size 88.01 MB
Peak swap size 83.96 MB
Peak disk usage 524.42 MB

Stderr output

<core_client_version>8.0.2</core_client_version>
<![CDATA[
<message>
(unknown error) (317) - exit code 4294967114 (0xffffff4a)</message>
<stderr_txt>
2024-06-23 19:49:07 (17208): vboxwrapper version 26207
2024-06-23 19:49:07 (17208): BOINC client version: 8.0.2
2024-06-23 19:49:08 (17208): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2024-06-23 19:49:09 (17208): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-06-23 19:49:09 (17208): Successfully copied 'init_data.xml' to the shared directory.
2024-06-23 19:49:09 (17208): Create VM. (boinc_1d82cb4bb0202242, slot#0)
2024-06-23 19:49:09 (17208): Setting Memory Size for VM. (4584MB)
2024-06-23 19:49:10 (17208): Setting CPU Count for VM. (4)
2024-06-23 19:49:10 (17208): Setting Chipset Options for VM.
2024-06-23 19:49:10 (17208): Setting Graphics Controller Options for VM.
2024-06-23 19:49:10 (17208): Setting Boot Options for VM.
2024-06-23 19:49:11 (17208): Setting Network Configuration for NAT.
2024-06-23 19:49:11 (17208): Enabling VM Network Access.
2024-06-23 19:49:11 (17208): Disabling USB Support for VM.
2024-06-23 19:49:11 (17208): Disabling COM Port Support for VM.
2024-06-23 19:49:12 (17208): Disabling LPT Port Support for VM.
2024-06-23 19:49:12 (17208): Disabling Audio Support for VM.
2024-06-23 19:49:12 (17208): Disabling Clipboard Support for VM.
2024-06-23 19:49:12 (17208): Disabling Drag and Drop Support for VM.
2024-06-23 19:49:13 (17208): Adding storage controller(s) to VM.
2024-06-23 19:49:13 (17208): Adding virtual disk drive to VM. (CMS_2024_04_29_prod.vdi)
2024-06-23 19:49:18 (17208): Attempts: 3
2024-06-23 19:49:18 (17208): Adding VirtualBox Guest Additions to VM.
2024-06-23 19:49:19 (17208): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2024-06-23 19:49:19 (17208): forwarding host port 54287 to guest port 80
2024-06-23 19:49:19 (17208): Enabling remote desktop for VM.
2024-06-23 19:49:19 (17208): Required extension pack not installed, remote desktop not enabled.
2024-06-23 19:49:19 (17208): Enabling shared directory for VM.
2024-06-23 19:49:20 (17208): Starting VM using VBoxManage interface. (boinc_1d82cb4bb0202242, slot#0)
2024-06-23 19:49:25 (17208): Successfully started VM. (PID = '25164')
2024-06-23 19:49:25 (17208): Reporting VM Process ID to BOINC.
2024-06-23 19:49:25 (17208): Guest Log: BIOS: VirtualBox 7.0.6
2024-06-23 19:49:25 (17208): Guest Log: CPUID EDX: 0x178bfbff
2024-06-23 19:49:25 (17208): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-06-23 19:49:25 (17208): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-06-23 19:49:25 (17208): VM state change detected. (old = 'poweredoff', new = 'running')
2024-06-23 19:49:25 (17208): Detected: Web Application Enabled (http://localhost:54287)
2024-06-23 19:49:25 (17208): Preference change detected
2024-06-23 19:49:25 (17208): Setting CPU throttle for VM. (100%)
2024-06-23 19:49:25 (17208): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-23 19:49:27 (17208): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-06-23 19:49:27 (17208): Guest Log: BIOS: Booting from Hard Disk...
2024-06-23 19:49:29 (17208): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-06-23 19:49:29 (17208): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2024-06-23 19:50:06 (17208): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-06-23 19:50:06 (17208): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-06-23 19:50:06 (17208): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-06-23 19:50:06 (17208): Guest Log: 00:00:00.000165 main     Log opened 2024-06-23T17:50:07.338488000Z
2024-06-23 19:50:06 (17208): Guest Log: 00:00:00.000268 main     OS Product: Linux
2024-06-23 19:50:06 (17208): Guest Log: 00:00:00.000444 main     OS Release: 4.14.232-19.cernvm.x86_64
2024-06-23 19:50:06 (17208): Guest Log: 00:00:00.000494 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2024-06-23 19:50:06 (17208): Guest Log: 00:00:00.000511 main     Executable: /usr/sbin/VBoxService
2024-06-23 19:50:06 (17208): Guest Log: 00:00:00.000511 main     Process ID: 2285
2024-06-23 19:50:06 (17208): Guest Log: 00:00:00.000512 main     Package type: LINUX_64BITS_GENERIC
2024-06-23 19:50:06 (17208): Guest Log: 00:00:00.002351 main     5.2.6 r120293 started. Verbose level = 0
2024-06-23 19:51:16 (17208): Guest Log: [INFO] Mounting the shared directory
2024-06-23 19:51:16 (17208): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2024-06-23 19:51:16 (17208): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2024-06-23 19:51:16 (17208): Guest Log: [INFO] Testing connection to cern.ch
2024-06-23 19:51:17 (17208): Guest Log: [INFO] Testing connection to VCCS
2024-06-23 19:51:17 (17208): Guest Log: [INFO] Testing connection to HTCondor
2024-06-23 19:51:17 (17208): Guest Log: [INFO] Testing connection to WMAgent
2024-06-23 19:51:17 (17208): Guest Log: [INFO] Testing connection to EOSCMS
2024-06-23 19:51:17 (17208): Guest Log: [INFO] Testing connection to CMS-Factory
2024-06-23 19:51:17 (17208): Guest Log: [INFO] Testing connection to CMS-Frontier
2024-06-23 19:51:17 (17208): Guest Log: [INFO] Testing connection to Frontier
2024-06-23 19:51:19 (17208): Guest Log: [INFO] Could not find a local HTTP proxy
2024-06-23 19:51:19 (17208): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2024-06-23 19:51:19 (17208): Guest Log: [INFO] This makes the application less efficient
2024-06-23 19:51:19 (17208): Guest Log: [INFO] It also puts higher load on the project servers
2024-06-23 19:51:19 (17208): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2024-06-23 19:51:19 (17208): Guest Log: [INFO] Advice can be found in the project forum
2024-06-23 19:51:23 (17208): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2024-06-23 19:51:30 (17208): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2024-06-23 19:51:33 (17208): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2024-06-23 19:51:33 (17208): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2024-06-23 19:51:34 (17208): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2024-06-23 19:51:37 (17208): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2024-06-23 19:51:39 (17208): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2024-06-23 19:51:39 (17208): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT
2024-06-23 19:51:39 (17208): Guest Log: [INFO] Environment HTTP proxy: not set
2024-06-23 19:51:39 (17208): Guest Log: [INFO] Reading volunteer information
2024-06-23 19:52:42 (17208): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2024-06-23 19:52:44 (17208): Guest Log: [INFO] Requesting an idtoken from LHC@home
2024-06-23 19:52:46 (17208): Guest Log: [INFO] CMS application starting. Check log files.
2024-06-23 20:27:11 (17208): VM state change detected. (old = 'running', new = 'paused')
2024-06-23 21:02:25 (17208): VM state change detected. (old = 'paused', new = 'running')
2024-06-23 21:02:33 (17208): Guest Log: 00:37:10.854190 timesync vgsvcTimeSyncWorker: Radical host time change: 2 124 520 000 000ns (HostNow=1 719 169 352 706 000 000 ns HostLast=1 719 167 228 186 000 000 ns)
2024-06-23 21:02:43 (17208): Guest Log: 00:37:20.854349 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 124 513 959 000ns (GuestNow=1 719 169 362 706 285 000 ns GuestLast=1 719 167 238 192 326 000 ns fSetTimeLastLoop=true )
2024-06-23 21:09:16 (17208): Stopping VM.
2024-06-23 21:09:23 (17208): Successfully stopped VM.
2024-06-24 08:08:44 (24440): vboxwrapper version 26207
2024-06-24 08:08:44 (24440): BOINC client version: 8.0.2
2024-06-24 08:08:45 (24440): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2024-06-24 08:08:45 (24440): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-06-24 08:08:45 (24440): Register VM. (boinc_1d82cb4bb0202242, slot#0)
2024-06-24 08:08:52 (24440): Error in register for VM: -182
Command:
VBoxManage -q registervm "C:\ProgramData\BOINC\slots\0/boinc_1d82cb4bb0202242/boinc_1d82cb4bb0202242.vbox" 
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\0/boinc_1d82cb4bb0202242/boinc_1d82cb4bb0202242.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 160 of file VBoxManageMisc.cpp

2024-06-24 08:08:52 (24440): Could not register
2024-06-24 08:08:52 (24440): ERROR: VM failed to start
2024-06-24 08:08:52 (24440): Powering off VM.
2024-06-24 08:08:52 (24440): Deregistering VM. (boinc_1d82cb4bb0202242, slot#0)
2024-06-24 08:08:52 (24440): Removing network bandwidth throttle group from VM.
2024-06-24 08:08:52 (24440): Removing VM from VirtualBox.

    Hypervisor System Log:

00:00:21.803733          Loading settings file "C:\ProgramData\BOINC\slots\0\boinc_1d82cb4bb0202242\boinc_1d82cb4bb0202242.vbox" with version "1.19-windows"
00:00:21.807413          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={Trying to open a VM config 'C:\ProgramData\BOINC\slots\0/boinc_1d82cb4bb0202242/boinc_1d82cb4bb0202242.vbox' which has the same UUID as an existing virtual machine}, preserve=false aResultDetail=0
00:00:22.061416          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:22.061468          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:22.061516          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:22.061568          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:22.061612          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:22.061656          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:22.061694          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:22.061757          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={7682d5eb-f00e-44f1-8ca2-99d08b1cd607} aComponent={VirtualBoxWrap} aText={Could not find a registered machine named 'boinc_1d82cb4bb0202242'}, preserve=false aResultDetail=0
00:00:22.111218          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:22.111287          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:22.111420          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:22.111473          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:22.111523          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:22.111571          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:22.111620          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:22.111689          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={7682d5eb-f00e-44f1-8ca2-99d08b1cd607} aComponent={VirtualBoxWrap} aText={Could not find a registered machine named 'boinc_1d82cb4bb0202242'}, preserve=false aResultDetail=0
00:00:22.363317          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:22.363364          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:22.363401          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:22.363435          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:22.363468          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:22.363501          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:22.363536          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:22.363586          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={7682d5eb-f00e-44f1-8ca2-99d08b1cd607} aComponent={VirtualBoxWrap} aText={Could not find a registered machine named 'boinc_1d82cb4bb0202242'}, preserve=false aResultDetail=0
00:00:23.266423          Saving settings file "C:\ProgramData\BOINC\slots\22\boinc_99e44dda09ac4ffe\boinc_99e44dda09ac4ffe.vbox" with version "1.19-windows"
00:00:23.272007          Finished saving settings file "C:\ProgramData\BOINC\slots\22\boinc_99e44dda09ac4ffe\boinc_99e44dda09ac4ffe.vbox"
00:00:24.335193          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:24.335263          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:24.335445          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:24.335581          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:24.335634          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:24.335684          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:24.335732          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:24.340559          Saving settings file "C:\ProgramData\BOINC\slots\22\boinc_99e44dda09ac4ffe\boinc_99e44dda09ac4ffe.vbox" with version "1.19-windows"
00:00:24.346194          Finished saving settings file "C:\ProgramData\BOINC\slots\22\boinc_99e44dda09ac4ffe\boinc_99e44dda09ac4ffe.vbox"

    VM Execution Log:

rite     5054 count
01:20:00.138031 /Public/Storage/AHCI0/Port1/BytesRead   321536 bytes
01:20:00.138034 /Public/Storage/AHCI0/Port1/QueryBufAttempts        0 count
01:20:00.138037 /Public/Storage/AHCI0/Port1/QueryBufSuccess        0 count
01:20:00.138040 /Public/Storage/AHCI0/Port1/ReqsRead       22 count
01:20:00.138043 /Public/Storage/AHCI0/Port1/ReqsSubmitted       22 count
01:20:00.138046 /Public/Storage/AHCI0/Port1/ReqsSucceeded       22 count
01:20:00.138049 /SELM/LoadHidSel/GstReadErrors          0 times
01:20:00.138051 /SELM/LoadHidSel/NoGoodGuest            0 times
01:20:00.138054 /TM/CPU/00/cNsExecuting          40031614437 ns
01:20:00.138058 /TM/CPU/00/cNsHalted             119692753341 ns
01:20:00.138060 /TM/CPU/00/cNsOther              2517840833654 ns
01:20:00.138063 /TM/CPU/00/cNsTotal              2677565201432 ns
01:20:00.138066 /TM/CPU/00/cPeriodsExecuting      7463561 count
01:20:00.138069 /TM/CPU/00/cPeriodsHalted           96479 count
01:20:00.138072 /TM/CPU/00/pctExecuting                 1 %
01:20:00.138075 /TM/CPU/00/pctHalted                    0 %
01:20:00.138078 /TM/CPU/00/pctOther                    98 %
01:20:00.138081 /TM/CPU/01/cNsExecuting          31936177701 ns
01:20:00.138084 /TM/CPU/01/cNsHalted             211900410560 ns
01:20:00.138087 /TM/CPU/01/cNsOther              2433728618898 ns
01:20:00.138090 /TM/CPU/01/cNsTotal              2677565207159 ns
01:20:00.138093 /TM/CPU/01/cPeriodsExecuting      4973291 count
01:20:00.138095 /TM/CPU/01/cPeriodsHalted           70507 count
01:20:00.138098 /TM/CPU/01/pctExecuting                 0 %
01:20:00.138101 /TM/CPU/01/pctHalted                   12 %
01:20:00.138104 /TM/CPU/01/pctOther                    86 %
01:20:00.138107 /TM/CPU/02/cNsExecuting          31128101177 ns
01:20:00.138110 /TM/CPU/02/cNsHalted             201839769462 ns
01:20:00.138113 /TM/CPU/02/cNsOther              2444597347136 ns
01:20:00.138116 /TM/CPU/02/cNsTotal              2677565217775 ns
01:20:00.138119 /TM/CPU/02/cPeriodsExecuting      4970671 count
01:20:00.138122 /TM/CPU/02/cPeriodsHalted           64482 count
01:20:00.138125 /TM/CPU/02/pctExecuting                 0 %
01:20:00.138127 /TM/CPU/02/pctHalted                    3 %
01:20:00.138130 /TM/CPU/02/pctOther                    96 %
01:20:00.138133 /TM/CPU/03/cNsExecuting          33136919313 ns
01:20:00.138136 /TM/CPU/03/cNsHalted             2096747165657 ns
01:20:00.138139 /TM/CPU/03/cNsOther              547681110890 ns
01:20:00.138142 /TM/CPU/03/cNsTotal              2677565195860 ns
01:20:00.138146 /TM/CPU/03/cPeriodsExecuting      5616674 count
01:20:00.138149 /TM/CPU/03/cPeriodsHalted          574224 count
01:20:00.138152 /TM/CPU/03/pctExecuting                 0 %
01:20:00.138155 /TM/CPU/03/pctHalted                   88 %
01:20:00.138158 /TM/CPU/03/pctOther                    11 %
01:20:00.138160 /TM/CPU/pctExecuting                    0 %
01:20:00.138163 /TM/CPU/pctHalted                      26 %
01:20:00.138166 /TM/CPU/pctOther                       72 %
01:20:00.138169 /TM/MaxHzHint                           0 Hz
01:20:00.138172 /TM/MaxHzHint/real                      0 Hz
01:20:00.138175 /TM/MaxHzHint/tsc                       0 Hz
01:20:00.138178 /TM/MaxHzHint/virtual                   0 Hz
01:20:00.138181 /TM/MaxHzHint/virtual_sync              0 Hz
01:20:00.138183 /TM/PIT/Handler                         0 ticks/call (           0 ticks,       0 calls, max         0, min      -1)
01:20:00.138187 /TM/PIT/Irq                             0 times
01:20:00.138190 /TM/R3/1nsSteps                     55373 times
01:20:00.138193 /TM/TSC/offCPU0                  45240382612327 ticks
01:20:00.138196 /TM/TSC/offCPU1                  45240382612327 ticks
01:20:00.138199 /TM/TSC/offCPU2                  45240382612327 ticks
01:20:00.138203 /TM/TSC/offCPU3                  45240382612327 ticks
01:20:00.138206 /TM/VirtualSync/CurrentOffset     9422262 ns
01:20:00.138210 /TRPM/ForwardRaw/IRQ/30                58 times
01:20:00.138213 /TRPM/ForwardRaw/IRQ/31                 1 times
01:20:00.138216 /TRPM/ForwardRaw/IRQ/3C                18 times
01:20:00.138219 /TRPM/ForwardRaw/IRQ/41              1879 times
01:20:00.138224 /TRPM/ForwardRaw/IRQ/61             14531 times
01:20:00.138228 /TRPM/ForwardRaw/IRQ/71               418 times
01:20:00.138235 /TRPM/ForwardRaw/IRQ/EF           1632540 times
01:20:00.138238 /TRPM/ForwardRaw/IRQ/FB             35063 times
01:20:00.138241 /TRPM/ForwardRaw/IRQ/FC               535 times
01:20:00.138244 /TRPM/ForwardRaw/IRQ/FD            157639 times
01:20:00.138247 /TRPM/ForwardRaw/TRAP/08                1 times
01:20:00.138250 /VMM/EmtHashCollisions/Emt00            0 times
01:20:00.138253 /VMM/EmtHashCollisions/Emt01            0 times
01:20:00.138256 /VMM/EmtHashCollisions/Emt02            0 times
01:20:00.138259 /VMM/EmtHashCollisions/Emt03            0 times
01:20:00.138261 /VMM/LogFlush/00-Flushes                0 times
01:20:00.138264 /VMM/LogFlush/00-NoWakups               0 times
01:20:00.138267 /VMM/LogFlush/CPU0/Rel/cbBuf         4096 bytes
01:20:00.138271 /VMM/LogFlush/CPU1/Rel/cbBuf         4096 bytes
01:20:00.138274 /VMM/LogFlush/CPU2/Rel/cbBuf         4096 bytes
01:20:00.138278 /VMM/LogFlush/CPU3/Rel/cbBuf         4096 bytes
01:20:00.138281 ********************* End of statistics **********************
01:20:00.141585 NAT: Zone(nm:mbuf_cluster, used:0)
01:20:00.141746 NAT: Zone(nm:mbuf_packet, used:0)
01:20:00.141750 NAT: Zone(nm:mbuf, used:1)
01:20:00.141840 NAT: Zone(nm:mbuf_jumbo_pagesize, used:0)
01:20:00.141992 NAT: Zone(nm:mbuf_jumbo_9k, used:0)
01:20:00.142276 NAT: Zone(nm:mbuf_jumbo_16k, used:0)
01:20:00.142428 NAT: Zone(nm:mbuf_ext_refcnt, used:0)
01:20:00.142522 E1000#0: Interrupt attempts: 318135
01:20:00.142526 E1000#0: Interrupts raised : 83284
01:20:00.142529 E1000#0: Interrupts lowered: 8323
01:20:00.142532 E1000#0: ICR outside ISR   : 0
01:20:00.142536 E1000#0: IMS raised ints   : 16070
01:20:00.142539 E1000#0: Interrupts skipped: 141888
01:20:00.142543 E1000#0: Masked interrupts : 92963
01:20:00.142545 E1000#0: Early interrupts  : 0
01:20:00.142548 E1000#0: Late interrupts   : 7231
01:20:00.142552 E1000#0: Lost interrupts   : 0
01:20:00.142555 E1000#0: Interrupts by RX  : 232575
01:20:00.142558 E1000#0: Interrupts by TX  : 38559
01:20:00.142562 E1000#0: Interrupts by ICS : 1296
01:20:00.142564 E1000#0: Interrupts by RDTR: 0
01:20:00.142567 E1000#0: Interrupts by RDMT: 0
01:20:00.142570 E1000#0: Interrupts by TXQE: 0
01:20:00.142573 E1000#0: TX int delay asked: 0
01:20:00.142575 E1000#0: TX delayed:         0
01:20:00.142581 E1000#0: TX delay expired:   0
01:20:00.142585 E1000#0: TX no report asked: 38384
01:20:00.142588 E1000#0: TX abs timer expd : 0
01:20:00.142591 E1000#0: TX int timer expd : 0
01:20:00.142593 E1000#0: RX abs timer expd : 0
01:20:00.142596 E1000#0: RX int timer expd : 0
01:20:00.142599 E1000#0: TX CTX descriptors: 38384
01:20:00.142602 E1000#0: TX DAT descriptors: 38384
01:20:00.142604 E1000#0: TX LEG descriptors: 175
01:20:00.142607 E1000#0: Received frames   : 232575
01:20:00.142610 E1000#0: Transmitted frames: 38559
01:20:00.142612 E1000#0: TX frames up to 1514: 38559
01:20:00.142615 E1000#0: TX frames up to 2962: 0
01:20:00.142618 E1000#0: TX frames up to 4410: 0
01:20:00.142621 E1000#0: TX frames up to 5858: 0
01:20:00.142623 E1000#0: TX frames up to 7306: 0
01:20:00.142626 E1000#0: TX frames up to 8754: 0
01:20:00.142629 E1000#0: TX frames up to 16384: 0
01:20:00.142632 E1000#0: TX frames up to 32768: 0
01:20:00.142634 E1000#0: Larger TX frames    : 0
01:20:00.142637 E1000#0: Max TX Delay        : 0
01:20:00.143356 GIM: KVM: Resetting MSRs
01:20:00.145132 vmmR3LogFlusher: Terminating (VERR_OBJECT_DESTROYED)
01:20:00.145215 Changing the VM state from 'DESTROYING' to 'TERMINATED'
01:20:00.146741 Console: Machine state changed to 'Saved'
01:20:00.146832 VBoxHeadless: processEventQueue: VERR_INTERRUPTED, termination requested
01:20:00.224529 End of log file - Log started 2024-06-23T17:49:23.349017200Z

    VM Startup Log:


    VM Trace Log:

X 16-Core Processor
Processor#9 speed: unknown
Processor#9 description: AMD Ryzen 9 3950X 16-Core Processor
Processor#10 speed: unknown
Processor#10 description: AMD Ryzen 9 3950X 16-Core Processor
Processor#11 speed: unknown
Processor#11 description: AMD Ryzen 9 3950X 16-Core Processor
Processor#12 speed: unknown
Processor#12 description: AMD Ryzen 9 3950X 16-Core Processor
Processor#13 speed: unknown
Processor#13 description: AMD Ryzen 9 3950X 16-Core Processor
Processor#14 speed: unknown
Processor#14 description: AMD Ryzen 9 3950X 16-Core Processor
Processor#15 speed: unknown
Processor#15 description: AMD Ryzen 9 3950X 16-Core Processor
Processor#16 speed: unknown
Processor#16 description: AMD Ryzen 9 3950X 16-Core Processor
Processor#17 speed: unknown
Processor#17 description: AMD Ryzen 9 3950X 16-Core Processor
Processor#18 speed: unknown
Processor#18 description: AMD Ryzen 9 3950X 16-Core Processor
Processor#19 speed: unknown
Processor#19 description: AMD Ryzen 9 3950X 16-Core Processor
Processor#20 speed: unknown
Processor#20 description: AMD Ryzen 9 3950X 16-Core Processor
Processor#21 speed: unknown
Processor#21 description: AMD Ryzen 9 3950X 16-Core Processor
Processor#22 speed: unknown
Processor#22 description: AMD Ryzen 9 3950X 16-Core Processor
Processor#23 speed: unknown
Processor#23 description: AMD Ryzen 9 3950X 16-Core Processor
Processor#24 speed: unknown
Processor#24 description: AMD Ryzen 9 3950X 16-Core Processor
Processor#25 speed: unknown
Processor#25 description: AMD Ryzen 9 3950X 16-Core Processor
Processor#26 speed: unknown
Processor#26 description: AMD Ryzen 9 3950X 16-Core Processor
Processor#27 speed: unknown
Processor#27 description: AMD Ryzen 9 3950X 16-Core Processor
Processor#28 speed: unknown
Processor#28 description: AMD Ryzen 9 3950X 16-Core Processor
Processor#29 speed: unknown
Processor#29 description: AMD Ryzen 9 3950X 16-Core Processor
Processor#30 speed: unknown
Processor#30 description: AMD Ryzen 9 3950X 16-Core Processor
Processor#31 speed: unknown
Processor#31 description: AMD Ryzen 9 3950X 16-Core Processor
Memory size: 65460 MByte
Memory available: 57023 MByte
Operating system: Windows 8
Operating system version: 6.2.9200

2024-06-24 08:08:45 (24440): 
Command: VBoxManage -q showvminfo "boinc_1d82cb4bb0202242" --machinereadable 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_1d82cb4bb0202242'
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 3139 of file VBoxManageInfo.cpp

2024-06-24 08:08:46 (24440): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\0/boinc_1d82cb4bb0202242/boinc_1d82cb4bb0202242.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\0/boinc_1d82cb4bb0202242/boinc_1d82cb4bb0202242.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 160 of file VBoxManageMisc.cpp

2024-06-24 08:08:47 (24440): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\0/boinc_1d82cb4bb0202242/boinc_1d82cb4bb0202242.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\0/boinc_1d82cb4bb0202242/boinc_1d82cb4bb0202242.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 160 of file VBoxManageMisc.cpp

2024-06-24 08:08:48 (24440): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\0/boinc_1d82cb4bb0202242/boinc_1d82cb4bb0202242.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\0/boinc_1d82cb4bb0202242/boinc_1d82cb4bb0202242.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 160 of file VBoxManageMisc.cpp

2024-06-24 08:08:49 (24440): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\0/boinc_1d82cb4bb0202242/boinc_1d82cb4bb0202242.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\0/boinc_1d82cb4bb0202242/boinc_1d82cb4bb0202242.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 160 of file VBoxManageMisc.cpp

2024-06-24 08:08:51 (24440): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\0/boinc_1d82cb4bb0202242/boinc_1d82cb4bb0202242.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\0/boinc_1d82cb4bb0202242/boinc_1d82cb4bb0202242.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 160 of file VBoxManageMisc.cpp

2024-06-24 08:08:52 (24440): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\0/boinc_1d82cb4bb0202242/boinc_1d82cb4bb0202242.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\0/boinc_1d82cb4bb0202242/boinc_1d82cb4bb0202242.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 160 of file VBoxManageMisc.cpp

2024-06-24 08:08:52 (24440): 
Command: VBoxManage -q snapshot "boinc_1d82cb4bb0202242" list 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_1d82cb4bb0202242'
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

2024-06-24 08:08:52 (24440): 
Command: VBoxManage -q bandwidthctl "boinc_1d82cb4bb0202242" remove "boinc_1d82cb4bb0202242_net" 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_1d82cb4bb0202242'
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

2024-06-24 08:08:52 (24440): 
Command: VBoxManage -q unregistervm "boinc_1d82cb4bb0202242" --delete 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_1d82cb4bb0202242'
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 231 of file VBoxManageMisc.cpp

2024-06-24 08:09:03 (24440): called boinc_finish(-182)

</stderr_txt>
]]>


©2024 CERN