Name CMS_1240766_1730986013.945142_0
Workunit 2456507
Created 7 Nov 2024, 13:26:56 UTC
Sent 9 Nov 2024, 1:12:49 UTC
Report deadline 16 Nov 2024, 1:12:49 UTC
Received 10 Nov 2024, 0:09:13 UTC
Server state Over
Outcome Computation error
Client state Compute error
Exit status -182 (0xFFFFFF4A) ERR_TIMEOUT
Computer ID 5258
Run time 11 hours 26 min 49 sec
CPU time 1 days 8 hours 39 min 47 sec
Validate state Invalid
Credit 0.00
Device peak FLOPS 21.59 GFLOPS
Application version CMS Simulation v61.01 (vbox64_mt_mcore_cms)
windows_x86_64
Peak working set size 85.47 MB
Peak swap size 88.02 MB
Peak disk usage 1.76 GB

Stderr output

<core_client_version>8.0.2</core_client_version>
<![CDATA[
<message>
(unknown error) (317) - exit code 4294967114 (0xffffff4a)</message>
<stderr_txt>
2024-11-09 12:56:12 (12420): vboxwrapper version 26207
2024-11-09 12:56:12 (12420): BOINC client version: 8.0.2
2024-11-09 12:56:13 (12420): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2024-11-09 12:56:13 (12420): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-11-09 12:56:13 (12420): Successfully copied 'init_data.xml' to the shared directory.
2024-11-09 12:56:13 (12420): Create VM. (boinc_4797bd12f07dda63, slot#4)
2024-11-09 12:56:14 (12420): Setting Memory Size for VM. (4584MB)
2024-11-09 12:56:14 (12420): Setting CPU Count for VM. (4)
2024-11-09 12:56:14 (12420): Setting Chipset Options for VM.
2024-11-09 12:56:14 (12420): Setting Graphics Controller Options for VM.
2024-11-09 12:56:15 (12420): Setting Boot Options for VM.
2024-11-09 12:56:15 (12420): Setting Network Configuration for NAT.
2024-11-09 12:56:15 (12420): Enabling VM Network Access.
2024-11-09 12:56:15 (12420): Disabling USB Support for VM.
2024-11-09 12:56:16 (12420): Disabling COM Port Support for VM.
2024-11-09 12:56:16 (12420): Disabling LPT Port Support for VM.
2024-11-09 12:56:16 (12420): Disabling Audio Support for VM.
2024-11-09 12:56:16 (12420): Disabling Clipboard Support for VM.
2024-11-09 12:56:17 (12420): Disabling Drag and Drop Support for VM.
2024-11-09 12:56:17 (12420): Adding storage controller(s) to VM.
2024-11-09 12:56:17 (12420): Adding virtual disk drive to VM. (CMS_2024_04_26a_mt_dev.vdi)
2024-11-09 12:56:18 (12420): Attempts: 2
2024-11-09 12:56:19 (12420): Adding VirtualBox Guest Additions to VM.
2024-11-09 12:56:19 (12420): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2024-11-09 12:56:19 (12420): forwarding host port 2693 to guest port 80
2024-11-09 12:56:20 (12420): Enabling remote desktop for VM.
2024-11-09 12:56:20 (12420): Required extension pack not installed, remote desktop not enabled.
2024-11-09 12:56:20 (12420): Enabling shared directory for VM.
2024-11-09 12:56:20 (12420): Starting VM using VBoxManage interface. (boinc_4797bd12f07dda63, slot#4)
2024-11-09 12:56:26 (12420): Successfully started VM. (PID = '1360')
2024-11-09 12:56:26 (12420): Reporting VM Process ID to BOINC.
2024-11-09 12:56:26 (12420): Guest Log: BIOS: VirtualBox 7.0.6
2024-11-09 12:56:26 (12420): Guest Log: CPUID EDX: 0x178bfbff
2024-11-09 12:56:26 (12420): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-11-09 12:56:26 (12420): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-11-09 12:56:26 (12420): VM state change detected. (old = 'poweredoff', new = 'running')
2024-11-09 12:56:26 (12420): Detected: Web Application Enabled (http://localhost:2693)
2024-11-09 12:56:26 (12420): Preference change detected
2024-11-09 12:56:26 (12420): Setting CPU throttle for VM. (100%)
2024-11-09 12:56:26 (12420): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-11-09 12:56:28 (12420): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-11-09 12:56:28 (12420): Guest Log: BIOS: Booting from Hard Disk...
2024-11-09 12:56:30 (12420): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-11-09 12:56:30 (12420): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2024-11-09 12:57:07 (12420): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-11-09 12:57:07 (12420): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-11-09 12:57:07 (12420): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-11-09 12:57:07 (12420): Guest Log: 00:00:00.000090 main     Log opened 2024-11-09T01:57:12.480671000Z
2024-11-09 12:57:07 (12420): Guest Log: 00:00:00.000221 main     OS Product: Linux
2024-11-09 12:57:07 (12420): Guest Log: 00:00:00.000241 main     OS Release: 4.14.232-19.cernvm.x86_64
2024-11-09 12:57:07 (12420): Guest Log: 00:00:00.000255 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2024-11-09 12:57:07 (12420): Guest Log: 00:00:00.000273 main     Executable: /usr/sbin/VBoxService
2024-11-09 12:57:07 (12420): Guest Log: 00:00:00.000273 main     Process ID: 2285
2024-11-09 12:57:07 (12420): Guest Log: 00:00:00.000274 main     Package type: LINUX_64BITS_GENERIC
2024-11-09 12:57:07 (12420): Guest Log: 00:00:00.000745 main     5.2.6 r120293 started. Verbose level = 0
2024-11-09 12:57:19 (12420): Guest Log: [INFO] Mounting the shared directory
2024-11-09 12:57:19 (12420): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2024-11-09 12:57:19 (12420): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2024-11-09 12:57:19 (12420): Guest Log: [INFO] Testing connection to cern.ch
2024-11-09 12:57:20 (12420): Guest Log: [INFO] Testing connection to VCCS
2024-11-09 12:57:20 (12420): Guest Log: [INFO] Testing connection to HTCondor
2024-11-09 12:57:20 (12420): Guest Log: [INFO] Testing connection to WMAgent
2024-11-09 12:57:21 (12420): Guest Log: [INFO] Testing connection to EOSCMS
2024-11-09 12:57:21 (12420): Guest Log: [INFO] Testing connection to CMS-Factory
2024-11-09 12:57:21 (12420): Guest Log: [INFO] Testing connection to CMS-Frontier
2024-11-09 12:57:22 (12420): Guest Log: [INFO] Testing connection to Frontier
2024-11-09 12:57:22 (12420): Guest Log: [INFO] Could not find a local HTTP proxy
2024-11-09 12:57:22 (12420): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2024-11-09 12:57:22 (12420): Guest Log: [INFO] This makes the application less efficient
2024-11-09 12:57:22 (12420): Guest Log: [INFO] It also puts higher load on the project servers
2024-11-09 12:57:22 (12420): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2024-11-09 12:57:22 (12420): Guest Log: [INFO] Advice can be found in the project forum
2024-11-09 12:57:23 (12420): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2024-11-09 12:57:28 (12420): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2024-11-09 12:57:29 (12420): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2024-11-09 12:57:29 (12420): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2024-11-09 12:57:30 (12420): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2024-11-09 12:57:30 (12420): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2024-11-09 12:57:30 (12420): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2024-11-09 12:57:30 (12420): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT
2024-11-09 12:57:30 (12420): Guest Log: [INFO] Environment HTTP proxy: not set
2024-11-09 12:57:30 (12420): Guest Log: [INFO] Reading volunteer information
2024-11-09 12:57:33 (12420): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2024-11-09 12:57:35 (12420): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2024-11-09 12:57:36 (12420): Guest Log: [INFO] Requesting an idtoken from LHC@home
2024-11-09 12:57:37 (12420): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2024-11-09 12:57:39 (12420): Guest Log: [INFO] CMS application starting. Check log files.
2024-11-09 14:36:41 (12420): Status Report: Job Duration: '64800.000000'
2024-11-09 14:36:41 (12420): Status Report: Elapsed Time: '6000.000000'
2024-11-09 14:36:41 (12420): Status Report: CPU Time: '21922.968750'
2024-11-09 16:16:56 (12420): Status Report: Job Duration: '64800.000000'
2024-11-09 16:16:56 (12420): Status Report: Elapsed Time: '12000.000000'
2024-11-09 16:16:56 (12420): Status Report: CPU Time: '45173.968750'
2024-11-09 17:57:09 (12420): Status Report: Job Duration: '64800.000000'
2024-11-09 17:57:09 (12420): Status Report: Elapsed Time: '18000.000000'
2024-11-09 17:57:09 (12420): Status Report: CPU Time: '66107.421875'
2024-11-09 19:00:01 (12420): Preference change detected
2024-11-09 19:00:01 (12420): Setting CPU throttle for VM. (40%)
2024-11-09 19:00:01 (12420): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-11-09 19:37:20 (12420): Status Report: Job Duration: '64800.000000'
2024-11-09 19:37:20 (12420): Status Report: Elapsed Time: '24000.000000'
2024-11-09 19:37:20 (12420): Status Report: CPU Time: '84259.187500'
2024-11-09 21:17:24 (12420): Status Report: Job Duration: '64800.000000'
2024-11-09 21:17:24 (12420): Status Report: Elapsed Time: '30000.000000'
2024-11-09 21:17:24 (12420): Status Report: CPU Time: '95041.203125'
2024-11-09 22:57:27 (12420): Status Report: Job Duration: '64800.000000'
2024-11-09 22:57:27 (12420): Status Report: Elapsed Time: '36000.000000'
2024-11-09 22:57:27 (12420): Status Report: CPU Time: '104443.843750'
2024-11-09 23:51:55 (12420): Preference change detected
2024-11-09 23:51:55 (12420): Setting CPU throttle for VM. (100%)
2024-11-09 23:51:56 (12420): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-11-10 00:22:43 (12420): Stopping VM.
2024-11-10 00:22:56 (12420): Successfully stopped VM.
2024-11-10 10:56:15 (15012): vboxwrapper version 26207
2024-11-10 10:56:15 (15012): BOINC client version: 8.0.2
2024-11-10 10:56:16 (15012): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2024-11-10 10:56:16 (15012): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-11-10 10:56:16 (15012): Register VM. (boinc_4797bd12f07dda63, slot#4)
2024-11-10 10:56:23 (15012): Error in register for VM: -182
Command:
VBoxManage -q registervm "C:\ProgramData\BOINC\slots\4/boinc_4797bd12f07dda63/boinc_4797bd12f07dda63.vbox" 
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\4/boinc_4797bd12f07dda63/boinc_4797bd12f07dda63.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-11-10 10:56:23 (15012): Could not register
2024-11-10 10:56:23 (15012): ERROR: VM failed to start
2024-11-10 10:56:23 (15012): Powering off VM.
2024-11-10 10:56:23 (15012): Deregistering VM. (boinc_4797bd12f07dda63, slot#4)
2024-11-10 10:56:23 (15012): Removing network bandwidth throttle group from VM.
2024-11-10 10:56:25 (15012): Attempts: 2
2024-11-10 10:56:25 (15012): Removing VM from VirtualBox.

    Hypervisor System Log:

00:00:07.381825          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:07.381830          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:07.381837          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:07.381842          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:07.381849          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_4797bd12f07dda63'}, preserve=false aResultDetail=0
00:00:07.633331          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:07.633350          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:07.633358          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:07.633364          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:07.633369          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:07.633374          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:07.633379          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:07.633388          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:07.633394          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:07.633400          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_4a147701040e47ea'}, preserve=false aResultDetail=0
00:00:09.525965          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:09.525985          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:09.525992          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:09.525997          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:09.526002          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:09.526007          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:09.526012          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:09.526024          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:09.526032          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:09.526042          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_4797bd12f07dda63'}, preserve=false aResultDetail=0
00:00:12.121422          Saving settings file "C:\ProgramData\BOINC\slots\6\boinc_ab79ae65309214db\boinc_ab79ae65309214db.vbox" with version "1.19-windows"
00:00:12.123177          Finished saving settings file "C:\ProgramData\BOINC\slots\6\boinc_ab79ae65309214db\boinc_ab79ae65309214db.vbox"
00:00:13.152633          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:13.152652          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:13.152658          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:13.152663          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:13.152668          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:13.152673          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:13.152677          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:13.152685          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:13.152690          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:13.154076          Saving settings file "C:\ProgramData\BOINC\slots\6\boinc_ab79ae65309214db\boinc_ab79ae65309214db.vbox" with version "1.19-windows"
00:00:13.156100          Finished saving settings file "C:\ProgramData\BOINC\slots\6\boinc_ab79ae65309214db\boinc_ab79ae65309214db.vbox"

    VM Execution Log:

AHCI0/Port0/ReqsWrite    81597 count
11:26:34.218286 /Public/Storage/AHCI0/Port1/BytesRead   321536 bytes
11:26:34.218288 /Public/Storage/AHCI0/Port1/QueryBufAttempts        0 count
11:26:34.218290 /Public/Storage/AHCI0/Port1/QueryBufSuccess        0 count
11:26:34.218292 /Public/Storage/AHCI0/Port1/ReqsRead       22 count
11:26:34.218293 /Public/Storage/AHCI0/Port1/ReqsSubmitted       22 count
11:26:34.218295 /Public/Storage/AHCI0/Port1/ReqsSucceeded       22 count
11:26:34.218297 /SELM/LoadHidSel/GstReadErrors          0 times
11:26:34.218298 /SELM/LoadHidSel/NoGoodGuest            0 times
11:26:34.218300 /TM/CPU/00/cNsExecuting          26660311077811 ns
11:26:34.218302 /TM/CPU/00/cNsHalted             138773078308 ns
11:26:34.218304 /TM/CPU/00/cNsOther              14380531253996 ns
11:26:34.218306 /TM/CPU/00/cNsTotal              41179615410115 ns
11:26:34.218308 /TM/CPU/00/cPeriodsExecuting     221394838 count
11:26:34.218310 /TM/CPU/00/cPeriodsHalted         1174431 count
11:26:34.218312 /TM/CPU/00/pctExecuting                91 %
11:26:34.218314 /TM/CPU/00/pctHalted                    0 %
11:26:34.218315 /TM/CPU/00/pctOther                     8 %
11:26:34.218317 /TM/CPU/01/cNsExecuting          26646373167715 ns
11:26:34.218320 /TM/CPU/01/cNsHalted             202150888144 ns
11:26:34.218322 /TM/CPU/01/cNsOther              14331091358211 ns
11:26:34.218324 /TM/CPU/01/cNsTotal              41179615414070 ns
11:26:34.218326 /TM/CPU/01/cPeriodsExecuting     218766666 count
11:26:34.218328 /TM/CPU/01/cPeriodsHalted         1257381 count
11:26:34.218329 /TM/CPU/01/pctExecuting                91 %
11:26:34.218331 /TM/CPU/01/pctHalted                    0 %
11:26:34.218333 /TM/CPU/01/pctOther                     8 %
11:26:34.218335 /TM/CPU/02/cNsExecuting          26643473440906 ns
11:26:34.218337 /TM/CPU/02/cNsHalted             205064908320 ns
11:26:34.218339 /TM/CPU/02/cNsOther              14331077064417 ns
11:26:34.218341 /TM/CPU/02/cNsTotal              41179615413643 ns
11:26:34.218343 /TM/CPU/02/cPeriodsExecuting     218412739 count
11:26:34.218344 /TM/CPU/02/cPeriodsHalted         1256941 count
11:26:34.218346 /TM/CPU/02/pctExecuting                90 %
11:26:34.218348 /TM/CPU/02/pctHalted                    0 %
11:26:34.218350 /TM/CPU/02/pctOther                     9 %
11:26:34.218352 /TM/CPU/03/cNsExecuting          26455586188893 ns
11:26:34.218353 /TM/CPU/03/cNsHalted             1687773174895 ns
11:26:34.218356 /TM/CPU/03/cNsOther              13036256053922 ns
11:26:34.218357 /TM/CPU/03/cNsTotal              41179615417710 ns
11:26:34.218359 /TM/CPU/03/cPeriodsExecuting     162539600 count
11:26:34.218361 /TM/CPU/03/cPeriodsHalted         1805295 count
11:26:34.218363 /TM/CPU/03/pctExecuting                88 %
11:26:34.218365 /TM/CPU/03/pctHalted                    0 %
11:26:34.218366 /TM/CPU/03/pctOther                    11 %
11:26:34.218368 /TM/CPU/pctExecuting                   90 %
11:26:34.218370 /TM/CPU/pctHalted                       0 %
11:26:34.218372 /TM/CPU/pctOther                        9 %
11:26:34.218374 /TM/MaxHzHint                           0 Hz
11:26:34.218375 /TM/MaxHzHint/real                      0 Hz
11:26:34.218377 /TM/MaxHzHint/tsc                       0 Hz
11:26:34.218379 /TM/MaxHzHint/virtual                   0 Hz
11:26:34.218381 /TM/MaxHzHint/virtual_sync              0 Hz
11:26:34.218383 /TM/PIT/Handler                         0 ticks/call (           0 ticks,       0 calls, max         0, min      -1)
11:26:34.218385 /TM/PIT/Irq                             0 times
11:26:34.218387 /TM/R3/1nsSteps                    343845 times
11:26:34.218389 /TM/TSC/offCPU0                  34974394110508 ticks
11:26:34.218391 /TM/TSC/offCPU1                  34974394110508 ticks
11:26:34.218393 /TM/TSC/offCPU2                  34974394110508 ticks
11:26:34.218395 /TM/TSC/offCPU3                  34974394110508 ticks
11:26:34.218397 /TM/VirtualSync/CurrentOffset      398237 ns
11:26:34.218400 /TRPM/ForwardRaw/IRQ/30                34 times
11:26:34.218401 /TRPM/ForwardRaw/IRQ/31                 2 times
11:26:34.218404 /TRPM/ForwardRaw/IRQ/3C                12 times
11:26:34.218405 /TRPM/ForwardRaw/IRQ/41             50284 times
11:26:34.218409 /TRPM/ForwardRaw/IRQ/61             35301 times
11:26:34.218411 /TRPM/ForwardRaw/IRQ/71             14538 times
11:26:34.218417 /TRPM/ForwardRaw/IRQ/EF          113877226 times
11:26:34.218419 /TRPM/ForwardRaw/IRQ/FB            926523 times
11:26:34.218421 /TRPM/ForwardRaw/IRQ/FC             34708 times
11:26:34.218422 /TRPM/ForwardRaw/IRQ/FD          11778142 times
11:26:34.218425 /VMM/EmtHashCollisions/Emt00            0 times
11:26:34.218427 /VMM/EmtHashCollisions/Emt01            0 times
11:26:34.218428 /VMM/EmtHashCollisions/Emt02            0 times
11:26:34.218430 /VMM/EmtHashCollisions/Emt03            0 times
11:26:34.218432 /VMM/LogFlush/00-Flushes                0 times
11:26:34.218434 /VMM/LogFlush/00-NoWakups               0 times
11:26:34.218436 /VMM/LogFlush/CPU0/Rel/cbBuf         4096 bytes
11:26:34.218439 /VMM/LogFlush/CPU1/Rel/cbBuf         4096 bytes
11:26:34.218441 /VMM/LogFlush/CPU2/Rel/cbBuf         4096 bytes
11:26:34.218443 /VMM/LogFlush/CPU3/Rel/cbBuf         4096 bytes
11:26:34.218445 ********************* End of statistics **********************
11:26:34.221313 NAT: Zone(nm:mbuf_cluster, used:0)
11:26:34.221470 NAT: Zone(nm:mbuf_packet, used:0)
11:26:34.221473 NAT: Zone(nm:mbuf, used:1)
11:26:34.221547 NAT: Zone(nm:mbuf_jumbo_pagesize, used:0)
11:26:34.221697 NAT: Zone(nm:mbuf_jumbo_9k, used:0)
11:26:34.221946 NAT: Zone(nm:mbuf_jumbo_16k, used:0)
11:26:34.222073 NAT: Zone(nm:mbuf_ext_refcnt, used:0)
11:26:34.222172 E1000#0: Interrupt attempts: 911182
11:26:34.222175 E1000#0: Interrupts raised : 310313
11:26:34.222176 E1000#0: Interrupts lowered: 42249
11:26:34.222178 E1000#0: ICR outside ISR   : 0
11:26:34.222180 E1000#0: IMS raised ints   : 85833
11:26:34.222181 E1000#0: Interrupts skipped: 354497
11:26:34.222183 E1000#0: Masked interrupts : 246372
11:26:34.222184 E1000#0: Early interrupts  : 0
11:26:34.222186 E1000#0: Late interrupts   : 22841
11:26:34.222188 E1000#0: Lost interrupts   : 0
11:26:34.222189 E1000#0: Interrupts by RX  : 595479
11:26:34.222191 E1000#0: Interrupts by TX  : 136674
11:26:34.222192 E1000#0: Interrupts by ICS : 20010
11:26:34.222194 E1000#0: Interrupts by RDTR: 0
11:26:34.222196 E1000#0: Interrupts by RDMT: 0
11:26:34.222197 E1000#0: Interrupts by TXQE: 0
11:26:34.222199 E1000#0: TX int delay asked: 0
11:26:34.222200 E1000#0: TX delayed:         0
11:26:34.222202 E1000#0: TX delay expired:   0
11:26:34.222203 E1000#0: TX no report asked: 147370
11:26:34.222205 E1000#0: TX abs timer expd : 0
11:26:34.222206 E1000#0: TX int timer expd : 0
11:26:34.222208 E1000#0: RX abs timer expd : 0
11:26:34.222209 E1000#0: RX int timer expd : 0
11:26:34.222211 E1000#0: TX CTX descriptors: 136007
11:26:34.222213 E1000#0: TX DAT descriptors: 147277
11:26:34.222214 E1000#0: TX LEG descriptors: 760
11:26:34.222216 E1000#0: Received frames   : 595479
11:26:34.222218 E1000#0: Transmitted frames: 136674
11:26:34.222219 E1000#0: TX frames up to 1514: 134494
11:26:34.222221 E1000#0: TX frames up to 2962: 247
11:26:34.222222 E1000#0: TX frames up to 4410: 804
11:26:34.222224 E1000#0: TX frames up to 5858: 71
11:26:34.222226 E1000#0: TX frames up to 7306: 41
11:26:34.222227 E1000#0: TX frames up to 8754: 61
11:26:34.222229 E1000#0: TX frames up to 16384: 231
11:26:34.222230 E1000#0: TX frames up to 32768: 725
11:26:34.222232 E1000#0: Larger TX frames    : 0
11:26:34.222233 E1000#0: Max TX Delay        : 0
11:26:34.222821 GIM: KVM: Resetting MSRs
11:26:34.225541 vmmR3LogFlusher: Terminating (VERR_OBJECT_DESTROYED)
11:26:34.225590 Changing the VM state from 'DESTROYING' to 'TERMINATED'
11:26:34.226231 Console: Machine state changed to 'Saved'
11:26:34.226331 VBoxHeadless: processEventQueue: VERR_INTERRUPTED, termination requested
11:26:34.388929 End of log file - Log started 2024-11-09T01:56:23.870683100Z

    VM Startup Log:


    VM Trace Log:

            
User language:                   C

2024-11-10 10:56:16 (15012): 
Command: VBoxManage -q list hostinfo 
Exit Code: 0
Output:
Host Information:

Host time: 2024-11-09T23:56:16.182000000Z
Processor online count: 16
Processor count: 16
Processor online core count: 16
Processor core count: 16
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: no
Processor supports virt. vmsave/vmload: no
Processor#0 speed: unknown
Processor#0 description: Intel(R) Core(TM) i9-9960X CPU @ 3.10GHz
Processor#1 speed: unknown
Processor#1 description: Intel(R) Core(TM) i9-9960X CPU @ 3.10GHz
Processor#2 speed: unknown
Processor#2 description: Intel(R) Core(TM) i9-9960X CPU @ 3.10GHz
Processor#3 speed: unknown
Processor#3 description: Intel(R) Core(TM) i9-9960X CPU @ 3.10GHz
Processor#4 speed: unknown
Processor#4 description: Intel(R) Core(TM) i9-9960X CPU @ 3.10GHz
Processor#5 speed: unknown
Processor#5 description: Intel(R) Core(TM) i9-9960X CPU @ 3.10GHz
Processor#6 speed: unknown
Processor#6 description: Intel(R) Core(TM) i9-9960X CPU @ 3.10GHz
Processor#7 speed: unknown
Processor#7 description: Intel(R) Core(TM) i9-9960X CPU @ 3.10GHz
Processor#8 speed: unknown
Processor#8 description: Intel(R) Core(TM) i9-9960X CPU @ 3.10GHz
Processor#9 speed: unknown
Processor#9 description: Intel(R) Core(TM) i9-9960X CPU @ 3.10GHz
Processor#10 speed: unknown
Processor#10 description: Intel(R) Core(TM) i9-9960X CPU @ 3.10GHz
Processor#11 speed: unknown
Processor#11 description: Intel(R) Core(TM) i9-9960X CPU @ 3.10GHz
Processor#12 speed: unknown
Processor#12 description: Intel(R) Core(TM) i9-9960X CPU @ 3.10GHz
Processor#13 speed: unknown
Processor#13 description: Intel(R) Core(TM) i9-9960X CPU @ 3.10GHz
Processor#14 speed: unknown
Processor#14 description: Intel(R) Core(TM) i9-9960X CPU @ 3.10GHz
Processor#15 speed: unknown
Processor#15 description: Intel(R) Core(TM) i9-9960X CPU @ 3.10GHz
Memory size: 32451 MByte
Memory available: 29520 MByte
Operating system: Windows 10
Operating system version: 10.0.19045

2024-11-10 10:56:16 (15012): 
Command: VBoxManage -q showvminfo "boinc_4797bd12f07dda63" --machinereadable 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_4797bd12f07dda63'
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-11-10 10:56:16 (15012): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\4/boinc_4797bd12f07dda63/boinc_4797bd12f07dda63.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\4/boinc_4797bd12f07dda63/boinc_4797bd12f07dda63.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-11-10 10:56:18 (15012): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\4/boinc_4797bd12f07dda63/boinc_4797bd12f07dda63.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\4/boinc_4797bd12f07dda63/boinc_4797bd12f07dda63.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-11-10 10:56:19 (15012): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\4/boinc_4797bd12f07dda63/boinc_4797bd12f07dda63.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\4/boinc_4797bd12f07dda63/boinc_4797bd12f07dda63.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-11-10 10:56:20 (15012): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\4/boinc_4797bd12f07dda63/boinc_4797bd12f07dda63.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\4/boinc_4797bd12f07dda63/boinc_4797bd12f07dda63.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-11-10 10:56:22 (15012): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\4/boinc_4797bd12f07dda63/boinc_4797bd12f07dda63.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\4/boinc_4797bd12f07dda63/boinc_4797bd12f07dda63.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-11-10 10:56:23 (15012): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\4/boinc_4797bd12f07dda63/boinc_4797bd12f07dda63.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\4/boinc_4797bd12f07dda63/boinc_4797bd12f07dda63.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-11-10 10:56:23 (15012): 
Command: VBoxManage -q snapshot "boinc_4797bd12f07dda63" list 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_4797bd12f07dda63'
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-11-10 10:56:23 (15012): 
Command: VBoxManage -q bandwidthctl "boinc_4797bd12f07dda63" remove "boinc_4797bd12f07dda63_net" 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_4797bd12f07dda63'
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-11-10 10:56:25 (15012): 
Command: VBoxManage -q unregistervm "boinc_4797bd12f07dda63" --delete 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_4797bd12f07dda63'
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-11-10 10:56:35 (15012): called boinc_finish(-182)

</stderr_txt>
]]>


©2024 CERN