Name Theory_2773-2932217-141_0
Workunit 229756992
Created 12 Jan 2025, 2:40:55 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 18 sec
CPU time 1 min 2 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 71.92 MB
Peak swap size 55.34 MB
Peak disk usage 777.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:34 (14956): vboxwrapper version 26207
2025-01-12 11:44:34 (14956): BOINC client version: 8.0.2
2025-01-12 11:44:34 (14956): Detected: VirtualBox VboxManage Interface (Version: 7.1.4)
2025-01-12 11:44:35 (14956): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-01-12 11:44:35 (14956): Successfully copied 'init_data.xml' to the shared directory.
2025-01-12 11:44:35 (14956): Successfully copied 'input' to the shared directory.
2025-01-12 11:44:35 (14956): Create VM. (boinc_4b9e2c977ff7536d, slot#24)
2025-01-12 11:44:36 (14956): Setting Memory Size for VM. (630MB)
2025-01-12 11:44:36 (14956): Setting CPU Count for VM. (1)
2025-01-12 11:44:36 (14956): Setting Chipset Options for VM.
2025-01-12 11:44:36 (14956): Setting Graphics Controller Options for VM.
2025-01-12 11:44:37 (14956): Setting Boot Options for VM.
2025-01-12 11:44:37 (14956): Setting Network Configuration for NAT.
2025-01-12 11:44:37 (14956): Enabling VM Network Access.
2025-01-12 11:44:37 (14956): Disabling USB Support for VM.
2025-01-12 11:44:38 (14956): Disabling COM Port Support for VM.
2025-01-12 11:44:38 (14956): Disabling LPT Port Support for VM.
2025-01-12 11:44:38 (14956): Disabling Audio Support for VM.
2025-01-12 11:44:38 (14956): Disabling Clipboard Support for VM.
2025-01-12 11:44:39 (14956): Disabling Drag and Drop Support for VM.
2025-01-12 11:44:39 (14956): Adding storage controller(s) to VM.
2025-01-12 11:44:39 (14956): Adding virtual disk drive to VM. (Theory_2024_04_30_prod.vdi)
2025-01-12 11:44:40 (14956): Adding VirtualBox Guest Additions to VM.
2025-01-12 11:44:40 (14956): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2025-01-12 11:44:40 (14956): forwarding host port 50580 to guest port 80
2025-01-12 11:44:40 (14956): Enabling remote desktop for VM.
2025-01-12 11:44:41 (14956): Required extension pack not installed, remote desktop not enabled.
2025-01-12 11:44:41 (14956): Enabling shared directory for VM.
2025-01-12 11:44:41 (14956): Starting VM using VBoxManage interface. (boinc_4b9e2c977ff7536d, slot#24)
2025-01-12 11:44:47 (14956): Successfully started VM. (PID = '14672')
2025-01-12 11:44:47 (14956): Reporting VM Process ID to BOINC.
2025-01-12 11:44:47 (14956): Guest Log: BIOS: VirtualBox 7.1.4
2025-01-12 11:44:47 (14956): Guest Log: CPUID EDX: 0x178bfbff
2025-01-12 11:44:47 (14956): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-01-12 11:44:47 (14956): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-01-12 11:44:47 (14956): VM state change detected. (old = 'poweredoff', new = 'running')
2025-01-12 11:44:47 (14956): Detected: Web Application Enabled (http://localhost:50580)
2025-01-12 11:44:47 (14956): Preference change detected
2025-01-12 11:44:47 (14956): Setting CPU throttle for VM. (100%)
2025-01-12 11:44:47 (14956): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-01-12 11:44:49 (14956): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-01-12 11:44:49 (14956): Guest Log: BIOS: Booting from Hard Disk...
2025-01-12 11:44:51 (14956): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-01-12 11:44:51 (14956): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-01-12 11:45:51 (14956): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-01-12 11:45:51 (14956): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-01-12 11:46:26 (14956): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-01-12 11:46:26 (14956): Guest Log: 00:00:00.000196 main     Log opened 2025-01-12T10:46:31.836999000Z
2025-01-12 11:46:26 (14956): Guest Log: 00:00:00.000750 main     OS Product: Linux
2025-01-12 11:46:26 (14956): Guest Log: 00:00:00.000826 main     OS Release: 4.14.76-13.cernvm.x86_64
2025-01-12 11:46:26 (14956): Guest Log: 00:00:00.000918 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2025-01-12 11:46:26 (14956): Guest Log: 00:00:00.000978 main     Executable: /usr/sbin/VBoxService
2025-01-12 11:46:26 (14956): Guest Log: 00:00:00.000980 main     Process ID: 3199
2025-01-12 11:46:26 (14956): Guest Log: 00:00:00.000981 main     Package type: LINUX_64BITS_GENERIC
2025-01-12 11:46:26 (14956): Guest Log: 00:00:00.005759 main     5.2.6 r120293 started. Verbose level = 0
2025-01-12 11:49:29 (14956): Guest Log: 11:49:35 CET +01:00 2025-01-12: cranky: [INFO] Detected Theory App
2025-01-12 11:49:29 (14956): Guest Log: 11:49:35 CET +01:00 2025-01-12: cranky: [INFO] Checking CVMFS.
2025-01-12 11:49:31 (14956): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2025-01-12 11:49:32 (14956): 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:49:32 (14956): Guest Log: 2.5.2.0 4208 2 28108 31453 2 1 278826 4096000 0 65024 0 0 n/a 5 5 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2025-01-12 11:49:33 (14956): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2025-01-12 11:49:34 (14956): 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:49:34 (14956): Guest Log: 2.5.2.0 4155 2 27548 26207 2 2 278826 4096000 0 65024 0 2 -100 10084 4596 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2025-01-12 11:49:34 (14956): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2025-01-12 11:49:35 (14956): 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:49:35 (14956): Guest Log: 2.5.2.0 4175 2 25328 272 2 1 278826 4096000 0 65024 0 0 n/a 4 11 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2025-01-12 11:49:36 (14956): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2025-01-12 11:49:36 (14956): 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:49:36 (14956): Guest Log: 2.5.2.0 4229 2 37584 20836 2 1 278826 4096000 0 65024 0 0 n/a 6549 4027 http://s1ral-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2025-01-12 11:49:36 (14956): Guest Log: 11:49:42 CET +01:00 2025-01-12: cranky: [INFO] Checking runc.
2025-01-12 11:49:45 (14956): Guest Log: 11:49:50 CET +01:00 2025-01-12: cranky: [INFO] Creating the filesystem.
2025-01-12 11:49:45 (14956): Guest Log: 11:49:50 CET +01:00 2025-01-12: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2025-01-12 11:49:46 (14956): Guest Log: 11:49:51 CET +01:00 2025-01-12: cranky: [INFO] Updating config.json.
2025-01-12 11:49:46 (14956): Guest Log: 11:49:51 CET +01:00 2025-01-12: cranky: [INFO] Running Container 'runc'.
2025-01-12 11:50:24 (14956): Guest Log: job: htmld=/shared/html/job
2025-01-12 11:50:27 (14956): Guest Log: job: unpack exitcode=0
2025-01-12 11:50:27 (14956): Guest Log: INFO: activated the work-around for ld:
2025-01-12 11:50:28 (14956): Guest Log: lrwxrwxrwx 1 0 0 15 Jan 12 10:50 /tmp/tmp.Ybf5CNAeXp/ld -> /usr/bin/ld.bfd
2025-01-12 11:50:32 (14956): Guest Log: 11:50:37 CET +01:00 2025-01-12: cranky: [INFO] ===> [runRivet] Sun Jan 12 10:50:33 UTC 2025 [boinc pp jets 13000 250 - powheg-box r3744 ptdef2 100000 141]
2025-01-12 12:00:51 (14956): Preference change detected
2025-01-12 12:00:51 (14956): Setting CPU throttle for VM. (100%)
2025-01-12 12:00:52 (14956): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-01-12 12:02:25 (14956): Stopping VM.
2025-01-12 12:02:39 (14956): Successfully stopped VM.
2025-01-12 12:46:16 (9240): vboxwrapper version 26207
2025-01-12 12:46:16 (9240): BOINC client version: 8.0.2
2025-01-12 12:46:18 (9240): Detected: VirtualBox VboxManage Interface (Version: 7.1.4)
2025-01-12 12:46:18 (9240): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-01-12 12:46:19 (9240): Register VM. (boinc_4b9e2c977ff7536d, slot#24)
2025-01-12 12:46:25 (9240): Error in register for VM: -182
Command:
VBoxManage -q registervm "C:\ProgramData\BOINC\slots\24/boinc_4b9e2c977ff7536d/boinc_4b9e2c977ff7536d.vbox" 
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\24/boinc_4b9e2c977ff7536d/boinc_4b9e2c977ff7536d.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 (9240): Could not register
2025-01-12 12:46:25 (9240): ERROR: VM failed to start
2025-01-12 12:46:25 (9240): Powering off VM.
2025-01-12 12:46:25 (9240): Deregistering VM. (boinc_4b9e2c977ff7536d, slot#24)
2025-01-12 12:46:25 (9240): Removing network bandwidth throttle group from VM.
2025-01-12 12:46:37 (9240): Attempts: 7
2025-01-12 12:46:37 (9240): 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:

24471730)
00:17:48.010168 /PROF/CPU0/VM/Halt/Block          5303484 ns/call ( 94550513288 ns,   17828 calls, max 205033885, min       1)
00:17:48.010176 /PROF/CPU0/VM/Halt/BlockInsomnia 11876310 ns/call ( 18004486822 ns,    1516 calls, max 173099849, min       1)
00:17:48.010186 /PROF/CPU0/VM/Halt/BlockOnTime   11278509 ns/call (  4815923623 ns,     427 calls, max 185504338, min    8057)
00:17:48.010196 /PROF/CPU0/VM/Halt/BlockOverslept   677623 ns/call ( 10764046206 ns,   15885 calls, max  18453298, min   50219)
00:17:48.010204 /PROF/CPU0/VM/Halt/R0HaltBlock   10688692 ns/call (898502206196 ns,   84061 calls, max 208577571, min       5)
00:17:48.010212 /PROF/CPU0/VM/Halt/R0HaltBlockInsomnia  9518360 ns/call (349580831496 ns,   36727 calls, max 207832918, min       5)
00:17:48.010220 /PROF/CPU0/VM/Halt/R0HaltBlockOnTime  6243163 ns/call ( 65715540040 ns,   10526 calls, max 207883347, min   16145)
00:17:48.010228 /PROF/CPU0/VM/Halt/R0HaltBlockOverslept   504978 ns/call ( 18587236504 ns,   36808 calls, max   5548657, min   50008)
00:17:48.010236 /PROF/CPU0/VM/Halt/R0HaltExec       17686 times
00:17:48.010242 /PROF/CPU0/VM/Halt/R0HaltExec/FromBlock    17545 times
00:17:48.010248 /PROF/CPU0/VM/Halt/R0HaltExec/FromSpin       12 times
00:17:48.010256 /PROF/CPU0/VM/Halt/R0HaltHistoryCounter   109354 times
00:17:48.010263 /PROF/CPU0/VM/Halt/R0HaltHistorySucceeded       31 times
00:17:48.010268 /PROF/CPU0/VM/Halt/R0HaltHistoryToRing3       14 times
00:17:48.010274 /PROF/CPU0/VM/Halt/R0HaltToR3       91668 times
00:17:48.010281 /PROF/CPU0/VM/Halt/R0HaltToR3/FromSpin        0 times
00:17:48.010287 /PROF/CPU0/VM/Halt/R0HaltToR3/Other        0 times
00:17:48.010293 /PROF/CPU0/VM/Halt/R0HaltToR3/PendingFF    11844 times
00:17:48.010299 /PROF/CPU0/VM/Halt/R0HaltToR3/PostWaitNoInt    64981 times
00:17:48.010305 /PROF/CPU0/VM/Halt/R0HaltToR3/PostWaitPendingFF     1535 times
00:17:48.010311 /PROF/CPU0/VM/Halt/R0HaltToR3/SmallDelta    13308 times
00:17:48.010319 /PROF/CPU0/VM/Halt/Timers            5204 ns/call (   560335270 ns,  107656 calls, max    935137, min       2)
00:17:48.010327 /PROF/CPU0/VM/Halt/Yield             7588 ns/call (     3945998 ns,     520 calls, max     29286, min    1320)
00:17:48.010335 /Public/NetAdapter/0/BytesReceived 372237537 bytes
00:17:48.010359 /Public/NetAdapter/0/BytesTransmitted  1804887 bytes
00:17:48.010366 /Public/NetAdapter/0/e1000              0 
00:17:48.010373 /Public/Storage/AHCI0/Port0/BytesRead 511732224 bytes
00:17:48.010384 /Public/Storage/AHCI0/Port0/BytesWritten 828690944 bytes
00:17:48.010394 /Public/Storage/AHCI0/Port0/QueryBufAttempts        0 count
00:17:48.010400 /Public/Storage/AHCI0/Port0/QueryBufSuccess        0 count
00:17:48.010407 /Public/Storage/AHCI0/Port0/ReqsFlush      326 count
00:17:48.010413 /Public/Storage/AHCI0/Port0/ReqsRead    15680 count
00:17:48.010419 /Public/Storage/AHCI0/Port0/ReqsSubmitted    20691 count
00:17:48.010428 /Public/Storage/AHCI0/Port0/ReqsSucceeded    20691 count
00:17:48.010434 /Public/Storage/AHCI0/Port0/ReqsWrite     4685 count
00:17:48.010440 /Public/Storage/AHCI0/Port1/BytesRead   321536 bytes
00:17:48.010446 /Public/Storage/AHCI0/Port1/QueryBufAttempts        0 count
00:17:48.010452 /Public/Storage/AHCI0/Port1/QueryBufSuccess        0 count
00:17:48.010458 /Public/Storage/AHCI0/Port1/ReqsRead       22 count
00:17:48.010465 /Public/Storage/AHCI0/Port1/ReqsSubmitted       22 count
00:17:48.010471 /Public/Storage/AHCI0/Port1/ReqsSucceeded       22 count
00:17:48.010486 /SELM/LoadHidSel/GstReadErrors          0 times
00:17:48.010492 /SELM/LoadHidSel/NoGoodGuest            0 times
00:17:48.010498 /TM/CPU/00/cNsExecuting          51605718056 ns
00:17:48.010505 /TM/CPU/00/cNsHalted             95253202431 ns
00:17:48.010511 /TM/CPU/00/cNsOther              912408493714 ns
00:17:48.010517 /TM/CPU/00/cNsTotal              1059267414201 ns
00:17:48.010524 /TM/CPU/00/cPeriodsExecuting      1831888 count
00:17:48.010530 /TM/CPU/00/cPeriodsHalted           79590 count
00:17:48.010536 /TM/CPU/00/pctExecuting                96 %
00:17:48.010543 /TM/CPU/00/pctHalted                    0 %
00:17:48.010549 /TM/CPU/00/pctOther                     3 %
00:17:48.010555 /TM/CPU/pctExecuting                   96 %
00:17:48.010561 /TM/CPU/pctHalted                       0 %
00:17:48.010569 /TM/CPU/pctOther                        3 %
00:17:48.010576 /TM/MaxHzHint                           0 Hz
00:17:48.010586 /TM/MaxHzHint/real                      0 Hz
00:17:48.010592 /TM/MaxHzHint/tsc                       0 Hz
00:17:48.010599 /TM/MaxHzHint/virtual                   0 Hz
00:17:48.010604 /TM/MaxHzHint/virtual_sync              0 Hz
00:17:48.010612 /TM/PIT/Handler                         0 ticks/call (           0 ticks,       0 calls, max         0, min      -1)
00:17:48.010621 /TM/PIT/Irq                             0 times
00:17:48.010628 /TM/R3/1nsSteps                      3536 times
00:17:48.010634 /TM/TSC/offCPU0                  3083202950824 ticks
00:17:48.010641 /TM/VirtualSync/CurrentOffset     5536474 ns
00:17:48.010649 /TRPM/ForwardRaw/IRQ/30               106 times
00:17:48.010656 /TRPM/ForwardRaw/IRQ/41              1740 times
00:17:48.010668 /TRPM/ForwardRaw/IRQ/61             21513 times
00:17:48.010676 /TRPM/ForwardRaw/IRQ/71               156 times
00:17:48.010693 /TRPM/ForwardRaw/IRQ/EF            133940 times
00:17:48.010702 /TRPM/ForwardRaw/TRAP/08              197 times
00:17:48.010712 /VMM/EmtHashCollisions/Emt00            0 times
00:17:48.010718 /VMM/LogFlush/00-Flushes                0 times
00:17:48.010724 /VMM/LogFlush/00-NoWakups               0 times
00:17:48.010732 /VMM/LogFlush/CPU0/Rel/cbBuf         4096 bytes
00:17:48.010740 ********************* End of statistics **********************
00:17:48.015236 E1000#0: Interrupt attempts: 293117
00:17:48.015270 E1000#0: Interrupts raised : 52233
00:17:48.015279 E1000#0: Interrupts lowered: 13068
00:17:48.015287 E1000#0: ICR outside ISR   : 0
00:17:48.015294 E1000#0: IMS raised ints   : 15438
00:17:48.015303 E1000#0: Interrupts skipped: 117481
00:17:48.015310 E1000#0: Masked interrupts : 123403
00:17:48.015317 E1000#0: Early interrupts  : 0
00:17:48.015325 E1000#0: Late interrupts   : 2389
00:17:48.015332 E1000#0: Lost interrupts   : 0
00:17:48.015339 E1000#0: Interrupts by RX  : 252747
00:17:48.015347 E1000#0: Interrupts by TX  : 18743
00:17:48.015354 E1000#0: Interrupts by ICS : 511
00:17:48.015362 E1000#0: Interrupts by RDTR: 0
00:17:48.015374 E1000#0: Interrupts by RDMT: 0
00:17:48.015386 E1000#0: Interrupts by TXQE: 0
00:17:48.015393 E1000#0: TX int delay asked: 0
00:17:48.015400 E1000#0: TX delayed:         0
00:17:48.015409 E1000#0: TX delay expired:   0
00:17:48.015417 E1000#0: TX no report asked: 18700
00:17:48.015424 E1000#0: TX abs timer expd : 0
00:17:48.015430 E1000#0: TX int timer expd : 0
00:17:48.015437 E1000#0: RX abs timer expd : 0
00:17:48.015445 E1000#0: RX int timer expd : 0
00:17:48.015452 E1000#0: TX CTX descriptors: 18700
00:17:48.015459 E1000#0: TX DAT descriptors: 18700
00:17:48.015467 E1000#0: TX LEG descriptors: 43
00:17:48.015477 E1000#0: Received frames   : 252747
00:17:48.015484 E1000#0: Transmitted frames: 18743
00:17:48.015491 E1000#0: TX frames up to 1514: 18743
00:17:48.015499 E1000#0: TX frames up to 2962: 0
00:17:48.015506 E1000#0: TX frames up to 4410: 0
00:17:48.015514 E1000#0: TX frames up to 5858: 0
00:17:48.015521 E1000#0: TX frames up to 7306: 0
00:17:48.015528 E1000#0: TX frames up to 8754: 0
00:17:48.015535 E1000#0: TX frames up to 16384: 0
00:17:48.015542 E1000#0: TX frames up to 32768: 0
00:17:48.015550 E1000#0: Larger TX frames    : 0
00:17:48.015558 E1000#0: Max TX Delay        : 0
00:17:48.017542 GIM: KVM: Resetting MSRs
00:17:48.018187 vmmR3LogFlusher: Terminating (VERR_OBJECT_DESTROYED)
00:17:48.018316 Changing the VM state from 'DESTROYING' to 'TERMINATED'
00:17:48.018337 Console: Machine state changed to 'Saved'
00:17:48.018463 VBoxHeadless: processEventQueue: VERR_INTERRUPTED, termination requested
00:17:58.084417 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: 514828 MByte
Operating system: Windows 2022
Operating system version: 10.0.20348

2025-01-12 12:46:19 (9240): 
Command: VBoxManage -q showvminfo "boinc_4b9e2c977ff7536d" --machinereadable 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_4b9e2c977ff7536d'
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 (9240): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\24/boinc_4b9e2c977ff7536d/boinc_4b9e2c977ff7536d.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\24/boinc_4b9e2c977ff7536d/boinc_4b9e2c977ff7536d.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 (9240): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\24/boinc_4b9e2c977ff7536d/boinc_4b9e2c977ff7536d.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\24/boinc_4b9e2c977ff7536d/boinc_4b9e2c977ff7536d.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 (9240): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\24/boinc_4b9e2c977ff7536d/boinc_4b9e2c977ff7536d.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\24/boinc_4b9e2c977ff7536d/boinc_4b9e2c977ff7536d.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 (9240): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\24/boinc_4b9e2c977ff7536d/boinc_4b9e2c977ff7536d.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\24/boinc_4b9e2c977ff7536d/boinc_4b9e2c977ff7536d.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 (9240): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\24/boinc_4b9e2c977ff7536d/boinc_4b9e2c977ff7536d.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\24/boinc_4b9e2c977ff7536d/boinc_4b9e2c977ff7536d.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 (9240): 
Command: VBoxManage -q registervm "C:\ProgramData\BOINC\slots\24/boinc_4b9e2c977ff7536d/boinc_4b9e2c977ff7536d.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'C:\ProgramData\BOINC\slots\24/boinc_4b9e2c977ff7536d/boinc_4b9e2c977ff7536d.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 (9240): 
Command: VBoxManage -q snapshot "boinc_4b9e2c977ff7536d" list 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_4b9e2c977ff7536d'
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 (9240): 
Command: VBoxManage -q bandwidthctl "boinc_4b9e2c977ff7536d" remove "boinc_4b9e2c977ff7536d_net" 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_4b9e2c977ff7536d'
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:37 (9240): 
Command: VBoxManage -q unregistervm "boinc_4b9e2c977ff7536d" --delete 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_4b9e2c977ff7536d'
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:47 (9240): called boinc_finish(-182)

</stderr_txt>
]]>


©2025 CERN