Name Theory_2773-2937233-140_0
Workunit 229756755
Created 12 Jan 2025, 2:21:17 UTC
Sent 12 Jan 2025, 10:41:53 UTC
Report deadline 23 Jan 2025, 10:41:53 UTC
Received 12 Jan 2025, 11:50:09 UTC
Server state Over
Outcome Computation error
Client state Compute error
Exit status -182 (0xFFFFFF4A) ERR_TIMEOUT
Computer ID 10867685
Run time 12 min 16 sec
CPU time 1 min 1 sec
Validate state Invalid
Credit 0.00
Device peak FLOPS 1.00 GFLOPS
Application version Theory Simulation v300.30 (vbox64_theory)
windows_x86_64
Peak working set size 70.64 MB
Peak swap size 54.13 MB
Peak disk usage 768.57 MB

Stderr output

<core_client_version>8.0.2</core_client_version>
<![CDATA[
<message>
(unknown error) (317) - exit code 4294967114 (0xffffff4a)</message>
<stderr_txt>
2025-01-12 11:44:26 (8032): vboxwrapper version 26207
2025-01-12 11:44:26 (8032): BOINC client version: 8.0.2
2025-01-12 11:44:27 (8032): Detected: VirtualBox VboxManage Interface (Version: 7.1.4)
2025-01-12 11:44:27 (8032): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-01-12 11:44:27 (8032): Successfully copied 'init_data.xml' to the shared directory.
2025-01-12 11:44:27 (8032): Successfully copied 'input' to the shared directory.
2025-01-12 11:44:28 (8032): Create VM. (boinc_45773974f6eca50e, slot#17)
2025-01-12 11:44:28 (8032): Setting Memory Size for VM. (630MB)
2025-01-12 11:44:28 (8032): Setting CPU Count for VM. (1)
2025-01-12 11:44:29 (8032): Setting Chipset Options for VM.
2025-01-12 11:44:29 (8032): Setting Graphics Controller Options for VM.
2025-01-12 11:44:29 (8032): Setting Boot Options for VM.
2025-01-12 11:44:29 (8032): Setting Network Configuration for NAT.
2025-01-12 11:44:30 (8032): Enabling VM Network Access.
2025-01-12 11:44:30 (8032): Disabling USB Support for VM.
2025-01-12 11:44:30 (8032): Disabling COM Port Support for VM.
2025-01-12 11:44:30 (8032): Disabling LPT Port Support for VM.
2025-01-12 11:44:31 (8032): Disabling Audio Support for VM.
2025-01-12 11:44:31 (8032): Disabling Clipboard Support for VM.
2025-01-12 11:44:31 (8032): Disabling Drag and Drop Support for VM.
2025-01-12 11:44:31 (8032): Adding storage controller(s) to VM.
2025-01-12 11:44:32 (8032): Adding virtual disk drive to VM. (Theory_2024_04_30_prod.vdi)
2025-01-12 11:44:32 (8032): Adding VirtualBox Guest Additions to VM.
2025-01-12 11:44:33 (8032): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2025-01-12 11:44:33 (8032): forwarding host port 50572 to guest port 80
2025-01-12 11:44:33 (8032): Enabling remote desktop for VM.
2025-01-12 11:44:33 (8032): Required extension pack not installed, remote desktop not enabled.
2025-01-12 11:44:33 (8032): Enabling shared directory for VM.
2025-01-12 11:44:34 (8032): Starting VM using VBoxManage interface. (boinc_45773974f6eca50e, slot#17)
2025-01-12 11:44:40 (8032): Successfully started VM. (PID = '15552')
2025-01-12 11:44:40 (8032): Reporting VM Process ID to BOINC.
2025-01-12 11:44:40 (8032): Guest Log: BIOS: VirtualBox 7.1.4
2025-01-12 11:44:40 (8032): Guest Log: CPUID EDX: 0x178bfbff
2025-01-12 11:44:40 (8032): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-01-12 11:44:40 (8032): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-01-12 11:44:40 (8032): VM state change detected. (old = 'poweredoff', new = 'running')
2025-01-12 11:44:40 (8032): Detected: Web Application Enabled (http://localhost:50572)
2025-01-12 11:44:40 (8032): Preference change detected
2025-01-12 11:44:40 (8032): Setting CPU throttle for VM. (100%)
2025-01-12 11:44:40 (8032): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-01-12 11:44:42 (8032): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-01-12 11:44:42 (8032): Guest Log: BIOS: Booting from Hard Disk...
2025-01-12 11:44:44 (8032): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-01-12 11:44:44 (8032): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-01-12 11:45:07 (8032): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-01-12 11:45:07 (8032): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-01-12 11:45:09 (8032): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-01-12 11:45:09 (8032): Guest Log: 00:00:00.000102 main     Log opened 2025-01-12T10:45:14.460020000Z
2025-01-12 11:45:09 (8032): Guest Log: 00:00:00.000194 main     OS Product: Linux
2025-01-12 11:45:09 (8032): Guest Log: 00:00:00.000246 main     OS Release: 4.14.76-13.cernvm.x86_64
2025-01-12 11:45:09 (8032): Guest Log: 00:00:00.000275 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2025-01-12 11:45:09 (8032): Guest Log: 00:00:00.000299 main     Executable: /usr/sbin/VBoxService
2025-01-12 11:45:09 (8032): Guest Log: 00:00:00.000300 main     Process ID: 3222
2025-01-12 11:45:09 (8032): Guest Log: 00:00:00.000300 main     Package type: LINUX_64BITS_GENERIC
2025-01-12 11:45:09 (8032): Guest Log: 00:00:00.002556 main     5.2.6 r120293 started. Verbose level = 0
2025-01-12 11:46:55 (8032): Guest Log: 11:47:00 CET +01:00 2025-01-12: cranky: [INFO] Detected Theory App
2025-01-12 11:46:55 (8032): Guest Log: 11:47:00 CET +01:00 2025-01-12: cranky: [INFO] Checking CVMFS.
2025-01-12 11:46:56 (8032): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2025-01-12 11:46:57 (8032): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2025-01-12 11:46:57 (8032): Guest Log: 2.5.2.0 4124 1 28560 31452 3 1 278826 4096000 0 65024 0 0 n/a 5 13 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2025-01-12 11:46:58 (8032): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2025-01-12 11:46:58 (8032): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2025-01-12 11:46:58 (8032): Guest Log: 2.5.2.0 4146 1 27492 26207 3 2 278826 4096000 0 65024 0 2 -100 10084 7604 http://s1ral-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2025-01-12 11:46:59 (8032): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2025-01-12 11:47:00 (8032): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2025-01-12 11:47:00 (8032): Guest Log: 2.5.2.0 4073 1 27200 272 2 1 278826 4096000 0 65024 0 0 n/a 4 11 http://s1ral-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2025-01-12 11:47:00 (8032): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2025-01-12 11:47:01 (8032): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2025-01-12 11:47:01 (8032): Guest Log: 2.5.2.0 4095 1 38616 20836 2 1 278826 4096000 0 65024 0 0 n/a 6549 8206 http://s1bnl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2025-01-12 11:47:01 (8032): Guest Log: 11:47:06 CET +01:00 2025-01-12: cranky: [INFO] Checking runc.
2025-01-12 11:47:10 (8032): Guest Log: 11:47:15 CET +01:00 2025-01-12: cranky: [INFO] Creating the filesystem.
2025-01-12 11:47:10 (8032): Guest Log: 11:47:15 CET +01:00 2025-01-12: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2025-01-12 11:47:10 (8032): Guest Log: 11:47:15 CET +01:00 2025-01-12: cranky: [INFO] Updating config.json.
2025-01-12 11:47:11 (8032): Guest Log: 11:47:16 CET +01:00 2025-01-12: cranky: [INFO] Running Container 'runc'.
2025-01-12 11:48:07 (8032): Guest Log: job: htmld=/shared/html/job
2025-01-12 11:48:08 (8032): Guest Log: job: unpack exitcode=0
2025-01-12 11:48:09 (8032): Guest Log: INFO: activated the work-around for ld:
2025-01-12 11:48:09 (8032): Guest Log: lrwxrwxrwx 1 0 0 15 Jan 12 10:48 /tmp/tmp.xxFc2brMeq/ld -> /usr/bin/ld.bfd
2025-01-12 11:48:14 (8032): Guest Log: 11:48:18 CET +01:00 2025-01-12: cranky: [INFO] ===> [runRivet] Sun Jan 12 10:48:14 UTC 2025 [boinc pp jets 13000 310 - powheg-box r3744 pthard0 100000 140]
2025-01-12 12:00:50 (8032): Preference change detected
2025-01-12 12:00:50 (8032): Setting CPU throttle for VM. (100%)
2025-01-12 12:00:51 (8032): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-01-12 12:02:26 (8032): Stopping VM.
2025-01-12 12:02:42 (8032): Successfully stopped VM.
2025-01-12 12:46:16 (1724): vboxwrapper version 26207
2025-01-12 12:46:16 (1724): BOINC client version: 8.0.2
2025-01-12 12:46:18 (1724): Detected: VirtualBox VboxManage Interface (Version: 7.1.4)
2025-01-12 12:46:18 (1724): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-01-12 12:46:19 (1724): Register VM. (boinc_45773974f6eca50e, slot#17)
2025-01-12 12:46:25 (1724): Error in register for VM: -182
Command:
VBoxManage -q registervm "C:\ProgramData\BOINC\slots\17/boinc_45773974f6eca50e/boinc_45773974f6eca50e.vbox" 
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\17/boinc_45773974f6eca50e/boinc_45773974f6eca50e.vbox' which has the same UUID as an existing virtual machine
VBoxManage.exe: error: Details: code E_FAIL (0x80004005), component MachineWrap, interface IMachine, callee IUnknown
VBoxManage.exe: error: Context: "OpenMachine(Bstr(a->argv[0]).raw(), Bstr(strPassword).raw(), machine.asOutParam()))" at line 159 of file VBoxManageMisc.cpp

2025-01-12 12:46:25 (1724): Could not register
2025-01-12 12:46:25 (1724): ERROR: VM failed to start
2025-01-12 12:46:25 (1724): Powering off VM.
2025-01-12 12:46:25 (1724): Deregistering VM. (boinc_45773974f6eca50e, slot#17)
2025-01-12 12:46:25 (1724): Removing network bandwidth throttle group from VM.
2025-01-12 12:46:35 (1724): Attempts: 6
2025-01-12 12:46:35 (1724): Removing VM from VirtualBox.

    Hypervisor System Log:

00:00:21.966991          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.966998          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967005          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967011          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967018          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967024          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967031          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967037          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967044          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967051          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967057          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967063          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967070          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967076          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967085          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967093          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967100          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967107          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967113          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967120          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967127          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967133          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967140          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967147          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967153          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967160          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967166          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967172          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967179          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967186          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967192          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967208          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967215          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967222          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967230          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967237          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:21.967243          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={d644ad1e-c501-4fc7-9ab6-aa6d763bc540} aComponent={VirtualBoxWrap} aText={Could not find a registered machine named 'boinc_19a8a08fb7d6a7c6'}, preserve=false aResultDetail=0

    VM Execution Log:

27220214)
00:17:56.085752 /PROF/CPU0/VM/Halt/Block          4407337 ns/call ( 88345082886 ns,   20045 calls, max 197193645, min       1)
00:17:56.085758 /PROF/CPU0/VM/Halt/BlockInsomnia  6365726 ns/call ( 13208883374 ns,    2075 calls, max 165783826, min       1)
00:17:56.085764 /PROF/CPU0/VM/Halt/BlockOnTime    9462355 ns/call (  4977198834 ns,     526 calls, max 197193645, min    5507)
00:17:56.085769 /PROF/CPU0/VM/Halt/BlockOverslept   683103 ns/call ( 11916052087 ns,   17444 calls, max   5294234, min   50052)
00:17:56.085775 /PROF/CPU0/VM/Halt/R0HaltBlock    9341962 ns/call (906011524468 ns,   96983 calls, max 209190392, min       2)
00:17:56.085785 /PROF/CPU0/VM/Halt/R0HaltBlockInsomnia  7865948 ns/call (334114016794 ns,   42476 calls, max 207822482, min       2)
00:17:56.085792 /PROF/CPU0/VM/Halt/R0HaltBlockOnTime  5287023 ns/call ( 70296260719 ns,   13296 calls, max 207925475, min    4190)
00:17:56.085797 /PROF/CPU0/VM/Halt/R0HaltBlockOverslept   517590 ns/call ( 21330427343 ns,   41211 calls, max   5089230, min   50001)
00:17:56.085802 /PROF/CPU0/VM/Halt/R0HaltExec       19670 times
00:17:56.085806 /PROF/CPU0/VM/Halt/R0HaltExec/FromBlock    19459 times
00:17:56.085809 /PROF/CPU0/VM/Halt/R0HaltExec/FromSpin       14 times
00:17:56.085813 /PROF/CPU0/VM/Halt/R0HaltHistoryCounter   128000 times
00:17:56.085817 /PROF/CPU0/VM/Halt/R0HaltHistorySucceeded        0 times
00:17:56.085821 /PROF/CPU0/VM/Halt/R0HaltHistoryToRing3        3 times
00:17:56.085824 /PROF/CPU0/VM/Halt/R0HaltToR3      108330 times
00:17:56.085828 /PROF/CPU0/VM/Halt/R0HaltToR3/FromSpin        0 times
00:17:56.085832 /PROF/CPU0/VM/Halt/R0HaltToR3/Other        0 times
00:17:56.085835 /PROF/CPU0/VM/Halt/R0HaltToR3/PendingFF    13818 times
00:17:56.085839 /PROF/CPU0/VM/Halt/R0HaltToR3/PostWaitNoInt    75693 times
00:17:56.085842 /PROF/CPU0/VM/Halt/R0HaltToR3/PostWaitPendingFF     1831 times
00:17:56.085846 /PROF/CPU0/VM/Halt/R0HaltToR3/SmallDelta    16988 times
00:17:56.085850 /PROF/CPU0/VM/Halt/Timers            4942 ns/call (   614930268 ns,  124417 calls, max    942391, min       2)
00:17:56.085859 /PROF/CPU0/VM/Halt/Yield             8277 ns/call (     4511016 ns,     545 calls, max    238771, min       1)
00:17:56.085865 /Public/NetAdapter/0/BytesReceived 373135458 bytes
00:17:56.085869 /Public/NetAdapter/0/BytesTransmitted  2109852 bytes
00:17:56.085873 /Public/NetAdapter/0/e1000              0 
00:17:56.085915 /Public/Storage/AHCI0/Port0/BytesRead 488765952 bytes
00:17:56.085923 /Public/Storage/AHCI0/Port0/BytesWritten 834028032 bytes
00:17:56.085927 /Public/Storage/AHCI0/Port0/QueryBufAttempts        0 count
00:17:56.085933 /Public/Storage/AHCI0/Port0/QueryBufSuccess        0 count
00:17:56.085942 /Public/Storage/AHCI0/Port0/ReqsFlush      304 count
00:17:56.085948 /Public/Storage/AHCI0/Port0/ReqsRead    13706 count
00:17:56.085951 /Public/Storage/AHCI0/Port0/ReqsSubmitted    18459 count
00:17:56.085955 /Public/Storage/AHCI0/Port0/ReqsSucceeded    18459 count
00:17:56.085959 /Public/Storage/AHCI0/Port0/ReqsWrite     4449 count
00:17:56.085963 /Public/Storage/AHCI0/Port1/BytesRead   321536 bytes
00:17:56.085967 /Public/Storage/AHCI0/Port1/QueryBufAttempts        0 count
00:17:56.085970 /Public/Storage/AHCI0/Port1/QueryBufSuccess        0 count
00:17:56.085975 /Public/Storage/AHCI0/Port1/ReqsRead       22 count
00:17:56.085978 /Public/Storage/AHCI0/Port1/ReqsSubmitted       22 count
00:17:56.085982 /Public/Storage/AHCI0/Port1/ReqsSucceeded       22 count
00:17:56.085986 /SELM/LoadHidSel/GstReadErrors          0 times
00:17:56.085990 /SELM/LoadHidSel/NoGoodGuest            0 times
00:17:56.085994 /TM/CPU/00/cNsExecuting          57650212341 ns
00:17:56.085998 /TM/CPU/00/cNsHalted             89112684937 ns
00:17:56.086002 /TM/CPU/00/cNsOther              920481347994 ns
00:17:56.086011 /TM/CPU/00/cNsTotal              1067244245272 ns
00:17:56.086016 /TM/CPU/00/cPeriodsExecuting      2036520 count
00:17:56.086022 /TM/CPU/00/cPeriodsHalted           93823 count
00:17:56.086027 /TM/CPU/00/pctExecuting                 4 %
00:17:56.086031 /TM/CPU/00/pctHalted                    8 %
00:17:56.086034 /TM/CPU/00/pctOther                    87 %
00:17:56.086038 /TM/CPU/pctExecuting                    4 %
00:17:56.086042 /TM/CPU/pctHalted                       8 %
00:17:56.086046 /TM/CPU/pctOther                       87 %
00:17:56.086050 /TM/MaxHzHint                           0 Hz
00:17:56.086054 /TM/MaxHzHint/real                      0 Hz
00:17:56.086058 /TM/MaxHzHint/tsc                       0 Hz
00:17:56.086062 /TM/MaxHzHint/virtual                   0 Hz
00:17:56.086066 /TM/MaxHzHint/virtual_sync              0 Hz
00:17:56.086070 /TM/PIT/Handler                         0 ticks/call (           0 ticks,       0 calls, max         0, min      -1)
00:17:56.086074 /TM/PIT/Irq                             0 times
00:17:56.086085 /TM/R3/1nsSteps                      3545 times
00:17:56.086091 /TM/TSC/offCPU0                  3060883979941 ticks
00:17:56.086095 /TM/VirtualSync/CurrentOffset     1015740 ns
00:17:56.086101 /TRPM/ForwardRaw/IRQ/30               104 times
00:17:56.086106 /TRPM/ForwardRaw/IRQ/41              1597 times
00:17:56.086112 /TRPM/ForwardRaw/IRQ/61             23658 times
00:17:56.086116 /TRPM/ForwardRaw/IRQ/71               214 times
00:17:56.086129 /TRPM/ForwardRaw/IRQ/EF            155825 times
00:17:56.086134 /TRPM/ForwardRaw/TRAP/08              198 times
00:17:56.086140 /VMM/EmtHashCollisions/Emt00            0 times
00:17:56.086144 /VMM/LogFlush/00-Flushes                0 times
00:17:56.086148 /VMM/LogFlush/00-NoWakups               0 times
00:17:56.086153 /VMM/LogFlush/CPU0/Rel/cbBuf         4096 bytes
00:17:56.086160 ********************* End of statistics **********************
00:17:56.089633 E1000#0: Interrupt attempts: 301916
00:17:56.089650 E1000#0: Interrupts raised : 58560
00:17:56.089656 E1000#0: Interrupts lowered: 12831
00:17:56.089660 E1000#0: ICR outside ISR   : 0
00:17:56.089665 E1000#0: IMS raised ints   : 15061
00:17:56.089669 E1000#0: Interrupts skipped: 130660
00:17:56.089674 E1000#0: Masked interrupts : 112696
00:17:56.089684 E1000#0: Early interrupts  : 0
00:17:56.089691 E1000#0: Late interrupts   : 2719
00:17:56.089697 E1000#0: Lost interrupts   : 0
00:17:56.089702 E1000#0: Interrupts by RX  : 254457
00:17:56.089707 E1000#0: Interrupts by TX  : 22121
00:17:56.089712 E1000#0: Interrupts by ICS : 515
00:17:56.089723 E1000#0: Interrupts by RDTR: 0
00:17:56.089731 E1000#0: Interrupts by RDMT: 0
00:17:56.089735 E1000#0: Interrupts by TXQE: 0
00:17:56.089740 E1000#0: TX int delay asked: 0
00:17:56.089745 E1000#0: TX delayed:         0
00:17:56.089749 E1000#0: TX delay expired:   0
00:17:56.089762 E1000#0: TX no report asked: 22081
00:17:56.089770 E1000#0: TX abs timer expd : 0
00:17:56.089775 E1000#0: TX int timer expd : 0
00:17:56.089779 E1000#0: RX abs timer expd : 0
00:17:56.089784 E1000#0: RX int timer expd : 0
00:17:56.089788 E1000#0: TX CTX descriptors: 22081
00:17:56.089793 E1000#0: TX DAT descriptors: 22081
00:17:56.089797 E1000#0: TX LEG descriptors: 40
00:17:56.089802 E1000#0: Received frames   : 254457
00:17:56.089807 E1000#0: Transmitted frames: 22121
00:17:56.089811 E1000#0: TX frames up to 1514: 22121
00:17:56.089816 E1000#0: TX frames up to 2962: 0
00:17:56.089820 E1000#0: TX frames up to 4410: 0
00:17:56.089828 E1000#0: TX frames up to 5858: 0
00:17:56.089837 E1000#0: TX frames up to 7306: 0
00:17:56.089842 E1000#0: TX frames up to 8754: 0
00:17:56.089846 E1000#0: TX frames up to 16384: 0
00:17:56.089851 E1000#0: TX frames up to 32768: 0
00:17:56.089855 E1000#0: Larger TX frames    : 0
00:17:56.089859 E1000#0: Max TX Delay        : 0
00:17:56.090944 GIM: KVM: Resetting MSRs
00:17:56.091901 vmmR3LogFlusher: Terminating (VERR_OBJECT_DESTROYED)
00:17:56.092026 Changing the VM state from 'DESTROYING' to 'TERMINATED'
00:17:56.092051 Console: Machine state changed to 'Saved'
00:17:56.092298 VBoxHeadless: processEventQueue: VERR_INTERRUPTED, termination requested
00:18:05.519183 VBoxHeadless: exiting

    VM Startup Log:


    VM Trace Log:

n: Intel(R) Xeon(R) CPU E5-2687W v4 @ 3.00GHz
Processor#27 speed: unknown
Processor#27 description: Intel(R) Xeon(R) CPU E5-2687W v4 @ 3.00GHz
Processor#28 speed: unknown
Processor#28 description: Intel(R) Xeon(R) CPU E5-2687W v4 @ 3.00GHz
Processor#29 speed: unknown
Processor#29 description: Intel(R) Xeon(R) CPU E5-2687W v4 @ 3.00GHz
Processor#30 speed: unknown
Processor#30 description: Intel(R) Xeon(R) CPU E5-2687W v4 @ 3.00GHz
Processor#31 speed: unknown
Processor#31 description: Intel(R) Xeon(R) CPU E5-2687W v4 @ 3.00GHz
Processor#32 speed: unknown
Processor#32 description: Intel(R) Xeon(R) CPU E5-2687W v4 @ 3.00GHz
Processor#33 speed: unknown
Processor#33 description: Intel(R) Xeon(R) CPU E5-2687W v4 @ 3.00GHz
Processor#34 speed: unknown
Processor#34 description: Intel(R) Xeon(R) CPU E5-2687W v4 @ 3.00GHz
Processor#35 speed: unknown
Processor#35 description: Intel(R) Xeon(R) CPU E5-2687W v4 @ 3.00GHz
Processor#36 speed: unknown
Processor#36 description: Intel(R) Xeon(R) CPU E5-2687W v4 @ 3.00GHz
Processor#37 speed: unknown
Processor#37 description: Intel(R) Xeon(R) CPU E5-2687W v4 @ 3.00GHz
Processor#38 speed: unknown
Processor#38 description: Intel(R) Xeon(R) CPU E5-2687W v4 @ 3.00GHz
Processor#39 speed: unknown
Processor#39 description: Intel(R) Xeon(R) CPU E5-2687W v4 @ 3.00GHz
Processor#40 speed: unknown
Processor#40 description: Intel(R) Xeon(R) CPU E5-2687W v4 @ 3.00GHz
Processor#41 speed: unknown
Processor#41 description: Intel(R) Xeon(R) CPU E5-2687W v4 @ 3.00GHz
Processor#42 speed: unknown
Processor#42 description: Intel(R) Xeon(R) CPU E5-2687W v4 @ 3.00GHz
Processor#43 speed: unknown
Processor#43 description: Intel(R) Xeon(R) CPU E5-2687W v4 @ 3.00GHz
Processor#44 speed: unknown
Processor#44 description: Intel(R) Xeon(R) CPU E5-2687W v4 @ 3.00GHz
Processor#45 speed: unknown
Processor#45 description: Intel(R) Xeon(R) CPU E5-2687W v4 @ 3.00GHz
Processor#46 speed: unknown
Processor#46 description: Intel(R) Xeon(R) CPU E5-2687W v4 @ 3.00GHz
Processor#47 speed: unknown
Processor#47 description: Intel(R) Xeon(R) CPU E5-2687W v4 @ 3.00GHz
Memory size: 524158 MByte
Memory available: 514773 MByte
Operating system: Windows 2022
Operating system version: 10.0.20348

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

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

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

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

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

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

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

2025-01-12 12:46:25 (1724): 
Command: VBoxManage -q snapshot "boinc_45773974f6eca50e" list 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_45773974f6eca50e'
VBoxManage.exe: error: Details: code VBOX_E_OBJECT_NOT_FOUND (0x80bb0001), component VirtualBoxWrap, interface IVirtualBox, callee IUnknown
VBoxManage.exe: error: Context: "FindMachine(bstrMachine.raw(), pMachine.asOutParam())" at line 345 of file VBoxManageSnapshot.cpp

2025-01-12 12:46:26 (1724): 
Command: VBoxManage -q bandwidthctl "boinc_45773974f6eca50e" remove "boinc_45773974f6eca50e_net" 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_45773974f6eca50e'
VBoxManage.exe: error: Details: code VBOX_E_OBJECT_NOT_FOUND (0x80bb0001), component VirtualBoxWrap, interface IVirtualBox, callee IUnknown
VBoxManage.exe: error: Context: "FindMachine(Bstr(a->argv[0]).raw(), machine.asOutParam())" at line 334 of file VBoxManageBandwidthControl.cpp

2025-01-12 12:46:35 (1724): 
Command: VBoxManage -q unregistervm "boinc_45773974f6eca50e" --delete 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_45773974f6eca50e'
VBoxManage.exe: error: Details: code VBOX_E_OBJECT_NOT_FOUND (0x80bb0001), component VirtualBoxWrap, interface IVirtualBox, callee IUnknown
VBoxManage.exe: error: Context: "FindMachine(Bstr(VMName).raw(), machine.asOutParam())" at line 230 of file VBoxManageMisc.cpp

2025-01-12 12:46:45 (1724): called boinc_finish(-182)

</stderr_txt>
]]>


©2025 CERN