Name CMS_3419019_1728668383.398117_0
Workunit 2455091
Created 11 Oct 2024, 17:39:45 UTC
Sent 13 Oct 2024, 4:35:36 UTC
Report deadline 20 Oct 2024, 4:35:36 UTC
Received 13 Oct 2024, 5:36:30 UTC
Server state Over
Outcome Computation error
Client state Compute error
Exit status -182 (0xFFFFFF4A) ERR_TIMEOUT
Computer ID 4899
Run time 6 min 25 sec
CPU time 1 min 44 sec
Validate state Invalid
Credit 0.00
Device peak FLOPS 19.71 GFLOPS
Application version CMS Simulation v61.01 (vbox64_mt_mcore_cms)
windows_x86_64
Peak working set size 81.67 MB
Peak swap size 101.71 MB
Peak disk usage 287.29 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-10-13 05:23:08 (9568): vboxwrapper version 26207
2024-10-13 05:23:08 (9568): BOINC client version: 8.0.2
2024-10-13 05:23:09 (9568): Detected: VirtualBox VboxManage Interface (Version: 7.0.20)
2024-10-13 05:23:09 (9568): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-10-13 05:23:09 (9568): Successfully copied 'init_data.xml' to the shared directory.
2024-10-13 05:23:10 (9568): Create VM. (boinc_2c1c301dd2594ea6, slot#5)
2024-10-13 05:23:10 (9568): Setting Memory Size for VM. (4584MB)
2024-10-13 05:23:11 (9568): Setting CPU Count for VM. (4)
2024-10-13 05:23:11 (9568): Setting Chipset Options for VM.
2024-10-13 05:23:11 (9568): Setting Graphics Controller Options for VM.
2024-10-13 05:23:11 (9568): Setting Boot Options for VM.
2024-10-13 05:23:12 (9568): Setting Network Configuration for NAT.
2024-10-13 05:23:12 (9568): Enabling VM Network Access.
2024-10-13 05:23:12 (9568): Disabling USB Support for VM.
2024-10-13 05:23:12 (9568): Disabling COM Port Support for VM.
2024-10-13 05:23:13 (9568): Disabling LPT Port Support for VM.
2024-10-13 05:23:13 (9568): Disabling Audio Support for VM.
2024-10-13 05:23:13 (9568): Disabling Clipboard Support for VM.
2024-10-13 05:23:13 (9568): Disabling Drag and Drop Support for VM.
2024-10-13 05:23:14 (9568): Adding storage controller(s) to VM.
2024-10-13 05:23:14 (9568): Adding virtual disk drive to VM. (CMS_2024_04_26a_mt_dev.vdi)
2024-10-13 05:23:17 (9568): Attempts: 2
2024-10-13 05:23:18 (9568): Adding VirtualBox Guest Additions to VM.
2024-10-13 05:23:18 (9568): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2024-10-13 05:23:18 (9568): forwarding host port 50717 to guest port 80
2024-10-13 05:23:18 (9568): Enabling remote desktop for VM.
2024-10-13 05:23:19 (9568): Enabling shared directory for VM.
2024-10-13 05:23:20 (9568): Starting VM using VBoxManage interface. (boinc_2c1c301dd2594ea6, slot#5)
2024-10-13 05:23:25 (9568): Successfully started VM. (PID = '9016')
2024-10-13 05:23:25 (9568): Reporting VM Process ID to BOINC.
2024-10-13 05:23:25 (9568): Guest Log: BIOS: VirtualBox 7.0.20
2024-10-13 05:23:25 (9568): Guest Log: CPUID EDX: 0x178bfbff
2024-10-13 05:23:25 (9568): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-10-13 05:23:25 (9568): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-10-13 05:23:25 (9568): VM state change detected. (old = 'poweredoff', new = 'running')
2024-10-13 05:23:25 (9568): Detected: Web Application Enabled (http://localhost:50717)
2024-10-13 05:23:25 (9568): Detected: Remote Desktop Enabled (localhost:50718)
2024-10-13 05:23:25 (9568): Preference change detected
2024-10-13 05:23:25 (9568): Setting CPU throttle for VM. (100%)
2024-10-13 05:23:26 (9568): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-10-13 05:23:27 (9568): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-10-13 05:23:27 (9568): Guest Log: BIOS: Booting from Hard Disk...
2024-10-13 05:23:29 (9568): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-10-13 05:23:29 (9568): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2024-10-13 05:23:57 (9568): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-10-13 05:23:57 (9568): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-10-13 05:23:58 (9568): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-10-13 05:23:58 (9568): Guest Log: 00:00:00.000572 main     Log opened 2024-10-13T05:23:58.265199000Z
2024-10-13 05:23:58 (9568): Guest Log: 00:00:00.000790 main     OS Product: Linux
2024-10-13 05:23:58 (9568): Guest Log: 00:00:00.000996 main     OS Release: 4.14.232-19.cernvm.x86_64
2024-10-13 05:23:58 (9568): Guest Log: 00:00:00.001231 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2024-10-13 05:23:58 (9568): Guest Log: 00:00:00.001319 main     Executable: /usr/sbin/VBoxService
2024-10-13 05:23:58 (9568): Guest Log: 00:00:00.001321 main     Process ID: 2286
2024-10-13 05:23:58 (9568): Guest Log: 00:00:00.001321 main     Package type: LINUX_64BITS_GENERIC
2024-10-13 05:23:58 (9568): Guest Log: 00:00:00.002274 main     5.2.6 r120293 started. Verbose level = 0
2024-10-13 05:24:08 (9568): Guest Log: 00:00:10.004621 timesync vgsvcTimeSyncWorker: Radical guest time change: 25 210 079 147 000ns (GuestNow=1 728 822 248 346 633 000 ns GuestLast=1 728 797 038 267 486 000 ns fSetTimeLastLoop=true )
2024-10-13 05:24:11 (9568): Guest Log: [INFO] Mounting the shared directory
2024-10-13 05:24:11 (9568): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2024-10-13 05:24:11 (9568): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2024-10-13 05:24:12 (9568): Guest Log: [INFO] Testing connection to cern.ch
2024-10-13 05:24:12 (9568): Guest Log: [INFO] Testing connection to VCCS
2024-10-13 05:24:12 (9568): Guest Log: [INFO] Testing connection to HTCondor
2024-10-13 05:24:13 (9568): Guest Log: [INFO] Testing connection to WMAgent
2024-10-13 05:24:13 (9568): Guest Log: [INFO] Testing connection to EOSCMS
2024-10-13 05:24:14 (9568): Guest Log: [INFO] Testing connection to CMS-Factory
2024-10-13 05:24:15 (9568): Guest Log: [INFO] Testing connection to CMS-Frontier
2024-10-13 05:24:15 (9568): Guest Log: [INFO] Testing connection to Frontier
2024-10-13 05:24:16 (9568): Guest Log: [INFO] Could not find a local HTTP proxy
2024-10-13 05:24:16 (9568): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2024-10-13 05:24:16 (9568): Guest Log: [INFO] This makes the application less efficient
2024-10-13 05:24:16 (9568): Guest Log: [INFO] It also puts higher load on the project servers
2024-10-13 05:24:16 (9568): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2024-10-13 05:24:16 (9568): Guest Log: [INFO] Advice can be found in the project forum
2024-10-13 05:24:16 (9568): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2024-10-13 05:24:23 (9568): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2024-10-13 05:24:25 (9568): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2024-10-13 05:24:26 (9568): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2024-10-13 05:24:26 (9568): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2024-10-13 05:24:28 (9568): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2024-10-13 05:24:29 (9568): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2024-10-13 05:24:29 (9568): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2024-10-13 05:24:29 (9568): Guest Log: [INFO] Environment HTTP proxy: not set
2024-10-13 05:24:29 (9568): Guest Log: [INFO] Reading volunteer information
2024-10-13 05:24:37 (9568): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2024-10-13 05:24:38 (9568): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2024-10-13 05:24:39 (9568): Guest Log: [INFO] Requesting an idtoken from LHC@home
2024-10-13 05:24:41 (9568): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2024-10-13 05:24:42 (9568): Guest Log: [INFO] CMS application starting. Check log files.
2024-10-12 22:29:29 (9568): Guest Log: 00:05:30.109349 timesync vgsvcTimeSyncWorker: Radical host time change: -25 189 977 000 000ns (HostNow=1 728 797 368 474 000 000 ns HostLast=1 728 822 558 451 000 000 ns)
2024-10-12 22:29:30 (9568): VM state change detected. (old = 'running', new = 'paused')
2024-10-12 22:34:33 (7784): vboxwrapper version 26207
2024-10-12 22:34:33 (7784): BOINC client version: 8.0.2
2024-10-12 22:34:34 (7784): Detected: VirtualBox VboxManage Interface (Version: 7.0.20)
2024-10-12 22:34:34 (7784): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-10-12 22:34:35 (7784): Register VM. (boinc_2c1c301dd2594ea6, slot#5)
2024-10-12 22:34:41 (7784): Error in register for VM: -182
Command:
VBoxManage -q registervm "C:\ProgramData\BOINC\slots\5/boinc_2c1c301dd2594ea6/boinc_2c1c301dd2594ea6.vbox" 
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\5/boinc_2c1c301dd2594ea6/boinc_2c1c301dd2594ea6.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-10-12 22:34:41 (7784): Could not register
2024-10-12 22:34:41 (7784): ERROR: VM failed to start
2024-10-12 22:34:41 (7784): Powering off VM.
2024-10-12 22:34:41 (7784): Deregistering VM. (boinc_2c1c301dd2594ea6, slot#5)
2024-10-12 22:34:41 (7784): Removing network bandwidth throttle group from VM.
2024-10-12 22:34:42 (7784): Removing VM from VirtualBox.

    Hypervisor System Log:

00:00:01.009373          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:01.029171          ERROR [COM]: aRC=VBOX_E_NOT_SUPPORTED (0x80bb0009) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={This VM is not encrypted}, preserve=false aResultDetail=0
00:00:01.038016          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:01.038084          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:01.232129          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
00:00:01.267558          Loading settings file "C:\ProgramData\BOINC\slots\5\boinc_2c1c301dd2594ea6\boinc_2c1c301dd2594ea6.vbox" with version "1.19-windows"
00:00:01.267640          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\5/boinc_2c1c301dd2594ea6/boinc_2c1c301dd2594ea6.vbox' which has the same UUID as an existing virtual machine}, preserve=false aResultDetail=0
00:00:01.523104          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:01.524660          ERROR [COM]: aRC=VBOX_E_NOT_SUPPORTED (0x80bb0009) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={This VM is not encrypted}, preserve=false aResultDetail=0
00:00:01.529945          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:01.530012          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:01.737770          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
00:00:02.052210          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:02.058370          Launched VM: 4251781808 pid: 10000 (0x2710) frontend: headless name: boinc_24974bd8bfe24160
00:00:02.541826          Loading settings file "C:\ProgramData\BOINC\slots\5\boinc_2c1c301dd2594ea6\boinc_2c1c301dd2594ea6.vbox" with version "1.19-windows"
00:00:02.541901          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\5/boinc_2c1c301dd2594ea6/boinc_2c1c301dd2594ea6.vbox' which has the same UUID as an existing virtual machine}, preserve=false aResultDetail=0
00:00:03.825578          Loading settings file "C:\ProgramData\BOINC\slots\5\boinc_2c1c301dd2594ea6\boinc_2c1c301dd2594ea6.vbox" with version "1.19-windows"
00:00:03.825684          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\5/boinc_2c1c301dd2594ea6/boinc_2c1c301dd2594ea6.vbox' which has the same UUID as an existing virtual machine}, preserve=false aResultDetail=0
00:00:05.082312          Loading settings file "C:\ProgramData\BOINC\slots\5\boinc_2c1c301dd2594ea6\boinc_2c1c301dd2594ea6.vbox" with version "1.19-windows"
00:00:05.082409          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\5/boinc_2c1c301dd2594ea6/boinc_2c1c301dd2594ea6.vbox' which has the same UUID as an existing virtual machine}, preserve=false aResultDetail=0
00:00:06.341766          Loading settings file "C:\ProgramData\BOINC\slots\5\boinc_2c1c301dd2594ea6\boinc_2c1c301dd2594ea6.vbox" with version "1.19-windows"
00:00:06.341910          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\5/boinc_2c1c301dd2594ea6/boinc_2c1c301dd2594ea6.vbox' which has the same UUID as an existing virtual machine}, preserve=false aResultDetail=0
00:00:06.688186          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Property 'CRYPT/KeyId' does not exist}, preserve=false aResultDetail=0
00:00:06.688712          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Property 'CRYPT/KeyId' does not exist}, preserve=false aResultDetail=0
00:00:07.600996          Loading settings file "C:\ProgramData\BOINC\slots\5\boinc_2c1c301dd2594ea6\boinc_2c1c301dd2594ea6.vbox" with version "1.19-windows"
00:00:07.601097          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\5/boinc_2c1c301dd2594ea6/boinc_2c1c301dd2594ea6.vbox' which has the same UUID as an existing virtual machine}, preserve=false aResultDetail=0
00:00:07.755345          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.757403          Saving settings file "C:\ProgramData\BOINC\slots\4\boinc_24974bd8bfe24160\boinc_24974bd8bfe24160.vbox" with version "1.19-windows"
00:00:07.760921          Finished saving settings file "C:\ProgramData\BOINC\slots\4\boinc_24974bd8bfe24160\boinc_24974bd8bfe24160.vbox"
00:00:07.857704          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.857726          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_2c1c301dd2594ea6'}, preserve=false aResultDetail=0
00:00:07.904635          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.904666          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_2c1c301dd2594ea6'}, preserve=false aResultDetail=0
00:00:08.160474          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:08.160498          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_2c1c301dd2594ea6'}, preserve=false aResultDetail=0

    VM Execution Log:

t
00:09:26.506354 /Public/Storage/AHCI0/Port1/QueryBufSuccess        0 count
00:09:26.506357 /Public/Storage/AHCI0/Port1/ReqsRead       22 count
00:09:26.506359 /Public/Storage/AHCI0/Port1/ReqsSubmitted       22 count
00:09:26.506361 /Public/Storage/AHCI0/Port1/ReqsSucceeded       22 count
00:09:26.506364 /SELM/LoadHidSel/GstReadErrors          0 times
00:09:26.506366 /SELM/LoadHidSel/NoGoodGuest            0 times
00:09:26.506369 /TM/CPU/00/cNsExecuting          17697465718 ns
00:09:26.506372 /TM/CPU/00/cNsHalted             20297126717 ns
00:09:26.506375 /TM/CPU/00/cNsOther              326346665761 ns
00:09:26.506377 /TM/CPU/00/cNsTotal              364341258196 ns
00:09:26.506380 /TM/CPU/00/cPeriodsExecuting      2508636 count
00:09:26.506383 /TM/CPU/00/cPeriodsHalted          116087 count
00:09:26.506385 /TM/CPU/00/pctExecuting                 1 %
00:09:26.506388 /TM/CPU/00/pctHalted                    6 %
00:09:26.506391 /TM/CPU/00/pctOther                    91 %
00:09:26.506393 /TM/CPU/01/cNsExecuting          14618996481 ns
00:09:26.506396 /TM/CPU/01/cNsHalted             37881770659 ns
00:09:26.506399 /TM/CPU/01/cNsOther              311840500819 ns
00:09:26.506402 /TM/CPU/01/cNsTotal              364341267959 ns
00:09:26.506404 /TM/CPU/01/cPeriodsExecuting      1561369 count
00:09:26.506407 /TM/CPU/01/cPeriodsHalted          113776 count
00:09:26.506409 /TM/CPU/01/pctExecuting                 1 %
00:09:26.506412 /TM/CPU/01/pctHalted                    3 %
00:09:26.506414 /TM/CPU/01/pctOther                    94 %
00:09:26.506417 /TM/CPU/02/cNsExecuting          18267028780 ns
00:09:26.506420 /TM/CPU/02/cNsHalted             34156468969 ns
00:09:26.506422 /TM/CPU/02/cNsOther              311917764045 ns
00:09:26.506425 /TM/CPU/02/cNsTotal              364341261794 ns
00:09:26.506428 /TM/CPU/02/cPeriodsExecuting      1549924 count
00:09:26.506430 /TM/CPU/02/cPeriodsHalted          110985 count
00:09:26.506433 /TM/CPU/02/pctExecuting                 0 %
00:09:26.506435 /TM/CPU/02/pctHalted                    0 %
00:09:26.506438 /TM/CPU/02/pctOther                    99 %
00:09:26.506440 /TM/CPU/03/cNsExecuting          17063403553 ns
00:09:26.506443 /TM/CPU/03/cNsHalted             223165846558 ns
00:09:26.506446 /TM/CPU/03/cNsOther              124111993508 ns
00:09:26.506449 /TM/CPU/03/cNsTotal              364341243619 ns
00:09:26.506451 /TM/CPU/03/cPeriodsExecuting      1863871 count
00:09:26.506454 /TM/CPU/03/cPeriodsHalted          226675 count
00:09:26.506456 /TM/CPU/03/pctExecuting                 1 %
00:09:26.506459 /TM/CPU/03/pctHalted                   62 %
00:09:26.506461 /TM/CPU/03/pctOther                    36 %
00:09:26.506464 /TM/CPU/pctExecuting                    1 %
00:09:26.506466 /TM/CPU/pctHalted                      18 %
00:09:26.506469 /TM/CPU/pctOther                       80 %
00:09:26.506472 /TM/MaxHzHint                           0 Hz
00:09:26.506474 /TM/MaxHzHint/real                      0 Hz
00:09:26.506477 /TM/MaxHzHint/tsc                       0 Hz
00:09:26.506479 /TM/MaxHzHint/virtual                   0 Hz
00:09:26.506482 /TM/MaxHzHint/virtual_sync              0 Hz
00:09:26.506485 /TM/PIT/Handler                         0 ticks/call (           0 ticks,       0 calls, max         0, min      -1)
00:09:26.506488 /TM/PIT/Irq                             0 times
00:09:26.506490 /TM/R3/1nsSteps                       357 times
00:09:26.506493 /TM/TSC/offCPU0                  16766366813642 ticks
00:09:26.506496 /TM/TSC/offCPU1                  16766366813642 ticks
00:09:26.506499 /TM/TSC/offCPU2                  16766366813642 ticks
00:09:26.506502 /TM/TSC/offCPU3                  16766366813642 ticks
00:09:26.506505 /TM/VirtualSync/CurrentOffset     1132751 ns
00:09:26.506509 /TRPM/ForwardRaw/IRQ/30                61 times
00:09:26.506512 /TRPM/ForwardRaw/IRQ/31                 2 times
00:09:26.506515 /TRPM/ForwardRaw/IRQ/3C                11 times
00:09:26.506518 /TRPM/ForwardRaw/IRQ/41              2250 times
00:09:26.506522 /TRPM/ForwardRaw/IRQ/61              4875 times
00:09:26.506525 /TRPM/ForwardRaw/IRQ/71               193 times
00:09:26.506533 /TRPM/ForwardRaw/IRQ/EF            260348 times
00:09:26.506536 /TRPM/ForwardRaw/IRQ/FB             18868 times
00:09:26.506538 /TRPM/ForwardRaw/IRQ/FC               177 times
00:09:26.506541 /TRPM/ForwardRaw/IRQ/FD            464074 times
00:09:26.506544 /VMM/EmtHashCollisions/Emt00            0 times
00:09:26.506547 /VMM/EmtHashCollisions/Emt01            0 times
00:09:26.506549 /VMM/EmtHashCollisions/Emt02            0 times
00:09:26.506552 /VMM/EmtHashCollisions/Emt03            0 times
00:09:26.506554 /VMM/LogFlush/00-Flushes                0 times
00:09:26.506557 /VMM/LogFlush/00-NoWakups               0 times
00:09:26.506560 /VMM/LogFlush/CPU0/Rel/cbBuf         4096 bytes
00:09:26.506563 /VMM/LogFlush/CPU1/Rel/cbBuf         4096 bytes
00:09:26.506566 /VMM/LogFlush/CPU2/Rel/cbBuf         4096 bytes
00:09:26.506569 /VMM/LogFlush/CPU3/Rel/cbBuf         4096 bytes
00:09:26.506572 ********************* End of statistics **********************
00:09:26.509803 NAT: Zone(nm:mbuf_cluster, used:0)
00:09:26.509970 NAT: Zone(nm:mbuf_packet, used:0)
00:09:26.509975 NAT: Zone(nm:mbuf, used:1)
00:09:26.510037 NAT: Zone(nm:mbuf_jumbo_pagesize, used:0)
00:09:26.510209 NAT: Zone(nm:mbuf_jumbo_9k, used:0)
00:09:26.510475 NAT: Zone(nm:mbuf_jumbo_16k, used:0)
00:09:26.510613 NAT: Zone(nm:mbuf_ext_refcnt, used:0)
00:09:26.510709 E1000#0: Interrupt attempts: 244549
00:09:26.510713 E1000#0: Interrupts raised : 55509
00:09:26.510716 E1000#0: Interrupts lowered: 10417
00:09:26.510718 E1000#0: ICR outside ISR   : 0
00:09:26.510721 E1000#0: IMS raised ints   : 18560
00:09:26.510723 E1000#0: Interrupts skipped: 84339
00:09:26.510726 E1000#0: Masked interrupts : 104701
00:09:26.510728 E1000#0: Early interrupts  : 0
00:09:26.510730 E1000#0: Late interrupts   : 6542
00:09:26.510733 E1000#0: Lost interrupts   : 0
00:09:26.510735 E1000#0: Interrupts by RX  : 189205
00:09:26.510738 E1000#0: Interrupts by TX  : 24334
00:09:26.510740 E1000#0: Interrupts by ICS : 167
00:09:26.510742 E1000#0: Interrupts by RDTR: 0
00:09:26.510745 E1000#0: Interrupts by RDMT: 0
00:09:26.510747 E1000#0: Interrupts by TXQE: 0
00:09:26.510749 E1000#0: TX int delay asked: 0
00:09:26.510752 E1000#0: TX delayed:         0
00:09:26.510754 E1000#0: TX delay expired:   0
00:09:26.510756 E1000#0: TX no report asked: 24199
00:09:26.510759 E1000#0: TX abs timer expd : 0
00:09:26.510761 E1000#0: TX int timer expd : 0
00:09:26.510763 E1000#0: RX abs timer expd : 0
00:09:26.510766 E1000#0: RX int timer expd : 0
00:09:26.510768 E1000#0: TX CTX descriptors: 24199
00:09:26.510770 E1000#0: TX DAT descriptors: 24199
00:09:26.510773 E1000#0: TX LEG descriptors: 135
00:09:26.510775 E1000#0: Received frames   : 189205
00:09:26.510778 E1000#0: Transmitted frames: 24334
00:09:26.510780 E1000#0: TX frames up to 1514: 24334
00:09:26.510782 E1000#0: TX frames up to 2962: 0
00:09:26.510785 E1000#0: TX frames up to 4410: 0
00:09:26.510787 E1000#0: TX frames up to 5858: 0
00:09:26.510789 E1000#0: TX frames up to 7306: 0
00:09:26.510792 E1000#0: TX frames up to 8754: 0
00:09:26.510794 E1000#0: TX frames up to 16384: 0
00:09:26.510796 E1000#0: TX frames up to 32768: 0
00:09:26.510799 E1000#0: Larger TX frames    : 0
00:09:26.510801 E1000#0: Max TX Delay        : 0
00:09:26.511610 GIM: KVM: Resetting MSRs
00:09:26.513797 vmmR3LogFlusher: Terminating (VERR_OBJECT_DESTROYED)
00:09:26.639879 Changing the VM state from 'DESTROYING' to 'TERMINATED'
00:09:26.639899 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={6ac83d89-6ee7-4e33-8ae6-b257b2e81be8} aComponent={ConsoleWrap} aText={The object is not ready}, preserve=false aResultDetail=0
00:09:26.640999 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={6ac83d89-6ee7-4e33-8ae6-b257b2e81be8} aComponent={ConsoleWrap} aText={The object is not ready}, preserve=false aResultDetail=0
00:09:26.772359 End of log file - Log started 2024-10-13T12:23:23.321410700Z

    VM Startup Log:


    VM Trace Log:

m Devices per Floppy Port: 2
Default machine folder:          C:\Users\zombi\VirtualBox VMs
Raw-mode Supported:              no
Exclusive HW virtualization use: off
Default hard disk format:        VDI
VRDE auth library:               VBoxAuth
Webservice auth. library:        VBoxAuth
Remote desktop ExtPack:          Oracle VM VirtualBox Extension Pack
VM encryption ExtPack:           Oracle VM VirtualBox Extension Pack
Log history count:               3
Default frontend:                
Default audio driver:            Windows Audio Session
Autostart database path:         
Default Guest Additions ISO:     C:\Program Files\Oracle\VirtualBox/VBoxGuestAdditions.iso
Logging Level:                   all
Proxy Mode:                      System
Proxy URL:                       
User language:                   C

2024-10-12 22:34:34 (7784): 
Command: VBoxManage -q list hostinfo 
Exit Code: 0
Output:
Host Information:

Host time: 2024-10-13T05:34:34.659000000Z
Processor online count: 8
Processor count: 8
Processor online core count: 4
Processor core count: 4
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) i7-4790K CPU @ 4.00GHz
Processor#1 speed: unknown
Processor#1 description: Intel(R) Core(TM) i7-4790K CPU @ 4.00GHz
Processor#2 speed: unknown
Processor#2 description: Intel(R) Core(TM) i7-4790K CPU @ 4.00GHz
Processor#3 speed: unknown
Processor#3 description: Intel(R) Core(TM) i7-4790K CPU @ 4.00GHz
Processor#4 speed: unknown
Processor#4 description: Intel(R) Core(TM) i7-4790K CPU @ 4.00GHz
Processor#5 speed: unknown
Processor#5 description: Intel(R) Core(TM) i7-4790K CPU @ 4.00GHz
Processor#6 speed: unknown
Processor#6 description: Intel(R) Core(TM) i7-4790K CPU @ 4.00GHz
Processor#7 speed: unknown
Processor#7 description: Intel(R) Core(TM) i7-4790K CPU @ 4.00GHz
Memory size: 16329 MByte
Memory available: 13742 MByte
Operating system: Windows 10
Operating system version: 10.0.19045

2024-10-12 22:34:35 (7784): 
Command: VBoxManage -q showvminfo "boinc_2c1c301dd2594ea6" --machinereadable 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_2c1c301dd2594ea6'
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-10-12 22:34:35 (7784): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\5/boinc_2c1c301dd2594ea6/boinc_2c1c301dd2594ea6.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\5/boinc_2c1c301dd2594ea6/boinc_2c1c301dd2594ea6.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-10-12 22:34:36 (7784): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\5/boinc_2c1c301dd2594ea6/boinc_2c1c301dd2594ea6.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\5/boinc_2c1c301dd2594ea6/boinc_2c1c301dd2594ea6.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-10-12 22:34:37 (7784): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\5/boinc_2c1c301dd2594ea6/boinc_2c1c301dd2594ea6.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\5/boinc_2c1c301dd2594ea6/boinc_2c1c301dd2594ea6.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-10-12 22:34:39 (7784): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\5/boinc_2c1c301dd2594ea6/boinc_2c1c301dd2594ea6.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\5/boinc_2c1c301dd2594ea6/boinc_2c1c301dd2594ea6.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-10-12 22:34:40 (7784): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\5/boinc_2c1c301dd2594ea6/boinc_2c1c301dd2594ea6.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\5/boinc_2c1c301dd2594ea6/boinc_2c1c301dd2594ea6.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-10-12 22:34:41 (7784): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\5/boinc_2c1c301dd2594ea6/boinc_2c1c301dd2594ea6.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\5/boinc_2c1c301dd2594ea6/boinc_2c1c301dd2594ea6.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-10-12 22:34:41 (7784): 
Command: VBoxManage -q snapshot "boinc_2c1c301dd2594ea6" list 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_2c1c301dd2594ea6'
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-10-12 22:34:42 (7784): 
Command: VBoxManage -q bandwidthctl "boinc_2c1c301dd2594ea6" remove "boinc_2c1c301dd2594ea6_net" 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_2c1c301dd2594ea6'
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-10-12 22:34:42 (7784): 
Command: VBoxManage -q unregistervm "boinc_2c1c301dd2594ea6" --delete 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_2c1c301dd2594ea6'
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-10-12 22:34:52 (7784): called boinc_finish(-182)

</stderr_txt>
]]>


©2025 CERN