Name Theory_2743-2877597-264_1
Workunit 223831077
Created 1 Jul 2024, 6:27:22 UTC
Sent 1 Jul 2024, 10:44:47 UTC
Report deadline 12 Jul 2024, 10:44:47 UTC
Received 1 Jul 2024, 13:39:13 UTC
Server state Over
Outcome Computation error
Client state Compute error
Exit status -182 (0xFFFFFF4A) ERR_TIMEOUT
Computer ID 10837826
Run time 33 min 38 sec
CPU time 28 min 56 sec
Validate state Invalid
Credit 0.00
Device peak FLOPS 4.89 GFLOPS
Application version Theory Simulation v300.30 (vbox64_theory)
windows_x86_64
Peak working set size 83.63 MB
Peak swap size 99.12 MB
Peak disk usage 1.19 GB

Stderr output

<core_client_version>7.24.1</core_client_version>
<![CDATA[
<message>
(unknown error) (317) - exit code 4294967114 (0xffffff4a)</message>
<stderr_txt>
2024-07-01 19:37:32 (10032): vboxwrapper version 26207
2024-07-01 19:37:32 (10032): BOINC client version: 7.24.1
2024-07-01 19:37:33 (10032): Detected: VirtualBox VboxManage Interface (Version: 7.0.18)
2024-07-01 19:37:33 (10032): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-01 19:37:33 (10032): Successfully copied 'init_data.xml' to the shared directory.
2024-07-01 19:37:33 (10032): Successfully copied 'input' to the shared directory.
2024-07-01 19:37:33 (10032): Create VM. (boinc_f2b0f3018ceff4e2, slot#5)
2024-07-01 19:37:34 (10032): Setting Memory Size for VM. (630MB)
2024-07-01 19:37:34 (10032): Setting CPU Count for VM. (1)
2024-07-01 19:37:34 (10032): Setting Chipset Options for VM.
2024-07-01 19:37:35 (10032): Setting Graphics Controller Options for VM.
2024-07-01 19:37:35 (10032): Setting Boot Options for VM.
2024-07-01 19:37:35 (10032): Setting Network Configuration for NAT.
2024-07-01 19:37:35 (10032): Enabling VM Network Access.
2024-07-01 19:37:36 (10032): Disabling USB Support for VM.
2024-07-01 19:37:36 (10032): Disabling COM Port Support for VM.
2024-07-01 19:37:36 (10032): Disabling LPT Port Support for VM.
2024-07-01 19:37:36 (10032): Disabling Audio Support for VM.
2024-07-01 19:37:37 (10032): Disabling Clipboard Support for VM.
2024-07-01 19:37:37 (10032): Disabling Drag and Drop Support for VM.
2024-07-01 19:37:37 (10032): Adding storage controller(s) to VM.
2024-07-01 19:37:37 (10032): Adding virtual disk drive to VM. (Theory_2024_04_30_prod.vdi)
2024-07-01 19:37:38 (10032): Adding VirtualBox Guest Additions to VM.
2024-07-01 19:37:38 (10032): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2024-07-01 19:37:39 (10032): forwarding host port 57641 to guest port 80
2024-07-01 19:37:39 (10032): Enabling remote desktop for VM.
2024-07-01 19:37:39 (10032): Enabling shared directory for VM.
2024-07-01 19:37:40 (10032): Starting VM using VBoxManage interface. (boinc_f2b0f3018ceff4e2, slot#5)
2024-07-01 19:37:46 (10032): Successfully started VM. (PID = '2928')
2024-07-01 19:37:46 (10032): Reporting VM Process ID to BOINC.
2024-07-01 19:37:46 (10032): Guest Log: BIOS: VirtualBox 7.0.18
2024-07-01 19:37:46 (10032): Guest Log: CPUID EDX: 0x178bfbff
2024-07-01 19:37:46 (10032): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-07-01 19:37:46 (10032): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-07-01 19:37:46 (10032): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-01 19:37:46 (10032): Detected: Web Application Enabled (http://localhost:57641)
2024-07-01 19:37:46 (10032): Detected: Remote Desktop Enabled (localhost:57642)
2024-07-01 19:37:46 (10032): Preference change detected
2024-07-01 19:37:46 (10032): Setting CPU throttle for VM. (100%)
2024-07-01 19:37:46 (10032): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-01 19:37:48 (10032): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-07-01 19:37:48 (10032): Guest Log: BIOS: Booting from Hard Disk...
2024-07-01 19:37:50 (10032): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-07-01 19:37:50 (10032): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2024-07-01 19:38:11 (10032): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-07-01 19:38:11 (10032): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-07-01 19:38:14 (10032): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-07-01 19:38:14 (10032): Guest Log: 00:00:00.000760 main     Log opened 2024-07-01T12:38:13.447462000Z
2024-07-01 19:38:14 (10032): Guest Log: 00:00:00.000857 main     OS Product: Linux
2024-07-01 19:38:14 (10032): Guest Log: 00:00:00.000906 main     OS Release: 4.14.76-13.cernvm.x86_64
2024-07-01 19:38:14 (10032): Guest Log: 00:00:00.000939 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2024-07-01 19:38:14 (10032): Guest Log: 00:00:00.000974 main     Executable: /usr/sbin/VBoxService
2024-07-01 19:38:14 (10032): Guest Log: 00:00:00.000975 main     Process ID: 3217
2024-07-01 19:38:14 (10032): Guest Log: 00:00:00.000975 main     Package type: LINUX_64BITS_GENERIC
2024-07-01 19:38:14 (10032): Guest Log: 00:00:00.002900 main     5.2.6 r120293 started. Verbose level = 0
2024-07-01 19:39:42 (10032): Guest Log: [INFO] Detected local proxy http://192.168.1.125:3128 in init_data.xml
2024-07-01 19:39:42 (10032): Guest Log: [INFO] Testing connection to 192.168.1.125 on port 3128
2024-07-01 19:39:43 (10032): Guest Log: [INFO] Ncat: Version 7.50 ( https://nmap.org/ncat )
2024-07-01 19:39:43 (10032): Guest Log: Ncat: Connected to 192.168.1.125:3128.
2024-07-01 19:39:43 (10032): Guest Log: Ncat: 0 bytes sent, 0 bytes received in 0.01 seconds.
2024-07-01 19:39:43 (10032): Guest Log: [INFO] 0
2024-07-01 19:39:47 (10032): Guest Log: 14:39:47 CEST +02:00 2024-07-01: cranky: [INFO] Detected Theory App
2024-07-01 19:39:47 (10032): Guest Log: 14:39:47 CEST +02:00 2024-07-01: cranky: [INFO] Checking CVMFS.
2024-07-01 19:39:48 (10032): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2024-07-01 19:39:48 (10032): 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
2024-07-01 19:39:48 (10032): Guest Log: 2.5.2.0 4058 1 28164 29822 3 1 272427 4096000 0 65024 0 0 n/a 0 0 http://s1ihep-cvmfs.openhtc.io/cvmfs/sft.cern.ch http://192.168.1.125:3128 1
2024-07-01 19:39:48 (10032): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2024-07-01 19:39:49 (10032): 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
2024-07-01 19:39:49 (10032): Guest Log: 2.5.2.0 4060 1 28368 24607 3 1 272427 4096000 0 65024 0 2 0 2138 6197 http://s1ihep-cvmfs.openhtc.io/cvmfs/grid.cern.ch http://192.168.1.125:3128 1
2024-07-01 19:39:49 (10032): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2024-07-01 19:39:49 (10032): 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
2024-07-01 19:39:49 (10032): Guest Log: 2.5.2.0 4126 1 26168 272 3 1 272427 4096000 0 65024 0 0 n/a 0 0 http://s1ihep-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch http://192.168.1.125:3128 1
2024-07-01 19:39:50 (10032): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2024-07-01 19:39:50 (10032): 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
2024-07-01 19:39:50 (10032): Guest Log: 2.5.2.0 4176 1 45116 19035 3 1 272427 4096000 0 65024 0 0 n/a 0 0 http://s1ihep-cvmfs.openhtc.io/cvmfs/alice.cern.ch http://192.168.1.125:3128 1
2024-07-01 19:39:50 (10032): Guest Log: 14:39:50 CEST +02:00 2024-07-01: cranky: [INFO] Checking runc.
2024-07-01 19:39:50 (10032): Guest Log: 14:39:50 CEST +02:00 2024-07-01: cranky: [INFO] Creating the filesystem.
2024-07-01 19:39:50 (10032): Guest Log: 14:39:50 CEST +02:00 2024-07-01: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2024-07-01 19:39:50 (10032): Guest Log: 14:39:50 CEST +02:00 2024-07-01: cranky: [INFO] Updating config.json.
2024-07-01 19:39:50 (10032): Guest Log: 14:39:50 CEST +02:00 2024-07-01: cranky: [INFO] Running Container 'runc'.
2024-07-01 19:39:56 (10032): Guest Log: job: htmld=/shared/html/job
2024-07-01 19:39:56 (10032): Guest Log: job: unpack exitcode=0
2024-07-01 19:39:56 (10032): Guest Log: INFO: activated the work-around for ld:
2024-07-01 19:39:56 (10032): Guest Log: lrwxrwxrwx 1 0 0 15 Jul  1 12:39 /tmp/tmp.DSUMUbRZ5A/ld -> /usr/bin/ld.bfd
2024-07-01 19:39:57 (10032): Guest Log: 14:39:56 CEST +02:00 2024-07-01: cranky: [INFO] ===> [runRivet] Mon Jul  1 12:39:56 UTC 2024 [boinc pp zinclusive 8000 -,-,480,1520 - pythia8 8.226 tune-4cx 100000 264]
2024-07-01 20:11:03 (10032): Stopping VM.
2024-07-01 20:11:08 (10032): Successfully stopped VM.
2024-07-01 20:27:35 (1952): vboxwrapper version 26207
2024-07-01 20:27:35 (1952): BOINC client version: 7.24.1
2024-07-01 20:27:35 (1952): Detected: VirtualBox VboxManage Interface (Version: 7.0.18)
2024-07-01 20:27:36 (1952): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-01 20:27:36 (1952): Register VM. (boinc_f2b0f3018ceff4e2, slot#5)
2024-07-01 20:27:43 (1952): Error in register for VM: -182
Command:
VBoxManage -q registervm "Z:\ProgramData\BOINC\slots\5/boinc_f2b0f3018ceff4e2/boinc_f2b0f3018ceff4e2.vbox" 
Output:
VBoxManage.exe: error: Trying to open a VM config 'Z:\ProgramData\BOINC\slots\5/boinc_f2b0f3018ceff4e2/boinc_f2b0f3018ceff4e2.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-07-01 20:27:43 (1952): Could not register
2024-07-01 20:27:43 (1952): ERROR: VM failed to start
2024-07-01 20:27:43 (1952): Powering off VM.
2024-07-01 20:27:43 (1952): Deregistering VM. (boinc_f2b0f3018ceff4e2, slot#5)
2024-07-01 20:27:43 (1952): Removing network bandwidth throttle group from VM.
2024-07-01 20:27:51 (1952): Attempts: 5
2024-07-01 20:27:51 (1952): Removing VM from VirtualBox.

    Hypervisor System Log:

00:01:17.893483          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:01:17.893489          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:01:17.893495          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:01:17.893501          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:01:17.893507          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:01:17.893513          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:01:17.893518          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:01:17.893524          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:01:17.907155          Finished saving settings file "Z:\ProgramData\BOINC\slots\0\boinc_027d4d37f559c1d3\boinc_027d4d37f559c1d3.vbox"
00:01:17.907208          Finished saving settings file "Z:\ProgramData\BOINC\slots\15\boinc_439f9c54f5a02310\boinc_439f9c54f5a02310.vbox"
00:01:17.907355          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_1981119cdaa6e17f'}, preserve=false aResultDetail=0
00:01:17.907380          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_25f39e4eccc39b23'}, preserve=false aResultDetail=0
00:01:17.910703          Saving settings file "Z:\ProgramData\BOINC\slots\14\boinc_c01a2ff60e91f5a1\boinc_c01a2ff60e91f5a1.vbox" with version "1.19-windows"
00:01:17.910723          Saving settings file "Z:\ProgramData\BOINC\slots\12\boinc_b972741b8dcd822a\boinc_b972741b8dcd822a.vbox" with version "1.19-windows"
00:01:17.930849          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:01:17.930876          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:01:17.930884          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:01:17.930891          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:01:17.930897          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:01:17.930903          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:01:17.930908          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:01:17.930914          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:01:17.930919          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:01:17.930925          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:01:17.930930          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:01:17.930936          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:01:17.930941          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:01:17.930947          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:01:17.931010          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:01:17.931020          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:01:17.931026          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:01:17.931032          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:01:17.931038          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:01:17.931044          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:01:17.931050          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:01:17.931055          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:01:17.931061          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:01:17.931066          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0

    VM Execution Log:

min   11173)
00:33:22.707309 /PROF/CPU0/VM/Halt/BlockOverslept   184690 ns/call (  3462949732 ns,   18750 calls, max  10310265, min   50001)
00:33:22.707312 /PROF/CPU0/VM/Halt/R0HaltBlock     478939 ns/call (232545596512 ns,  485543 calls, max 208258153, min       2)
00:33:22.707316 /PROF/CPU0/VM/Halt/R0HaltBlockInsomnia   252001 ns/call ( 93151021893 ns,  369644 calls, max 199326983, min       2)
00:33:22.707319 /PROF/CPU0/VM/Halt/R0HaltBlockOnTime   780300 ns/call ( 47231590992 ns,   60530 calls, max 207851539, min     750)
00:33:22.707322 /PROF/CPU0/VM/Halt/R0HaltBlockOverslept   192766 ns/call ( 10673267615 ns,   55369 calls, max  12494617, min   50001)
00:33:22.707325 /PROF/CPU0/VM/Halt/R0HaltExec      374506 times
00:33:22.707328 /PROF/CPU0/VM/Halt/R0HaltExec/FromBlock   371893 times
00:33:22.707331 /PROF/CPU0/VM/Halt/R0HaltExec/FromSpin      957 times
00:33:22.707334 /PROF/CPU0/VM/Halt/R0HaltHistoryCounter   764095 times
00:33:22.707337 /PROF/CPU0/VM/Halt/R0HaltHistorySucceeded       10 times
00:33:22.707340 /PROF/CPU0/VM/Halt/R0HaltHistoryToRing3      184 times
00:33:22.707342 /PROF/CPU0/VM/Halt/R0HaltToR3      389589 times
00:33:22.707345 /PROF/CPU0/VM/Halt/R0HaltToR3/FromSpin        1 times
00:33:22.707348 /PROF/CPU0/VM/Halt/R0HaltToR3/Other        0 times
00:33:22.707351 /PROF/CPU0/VM/Halt/R0HaltToR3/PendingFF   207114 times
00:33:22.707353 /PROF/CPU0/VM/Halt/R0HaltToR3/PostWaitNoInt   112470 times
00:33:22.707356 /PROF/CPU0/VM/Halt/R0HaltToR3/PostWaitPendingFF     1180 times
00:33:22.707359 /PROF/CPU0/VM/Halt/R0HaltToR3/SmallDelta    68824 times
00:33:22.707362 /PROF/CPU0/VM/Halt/Timers            1609 ns/call (   729900918 ns,  453376 calls, max  10294014, min       2)
00:33:22.707366 /PROF/CPU0/VM/Halt/Yield             4221 ns/call (     3187198 ns,     755 calls, max     78087, min       1)
00:33:22.707369 /Public/NetAdapter/0/BytesReceived 408829167 bytes
00:33:22.707372 /Public/NetAdapter/0/BytesTransmitted  7391661 bytes
00:33:22.707374 /Public/NetAdapter/0/e1000              0 
00:33:22.707377 /Public/Storage/AHCI0/Port0/BytesRead 30521600512 bytes
00:33:22.707380 /Public/Storage/AHCI0/Port0/BytesWritten 1277075968 bytes
00:33:22.707383 /Public/Storage/AHCI0/Port0/QueryBufAttempts        0 count
00:33:22.707386 /Public/Storage/AHCI0/Port0/QueryBufSuccess        0 count
00:33:22.707389 /Public/Storage/AHCI0/Port0/ReqsFlush      720 count
00:33:22.707393 /Public/Storage/AHCI0/Port0/ReqsRead   491012 count
00:33:22.707396 /Public/Storage/AHCI0/Port0/ReqsSubmitted   499784 count
00:33:22.707399 /Public/Storage/AHCI0/Port0/ReqsSucceeded   499784 count
00:33:22.707402 /Public/Storage/AHCI0/Port0/ReqsWrite     8052 count
00:33:22.707405 /Public/Storage/AHCI0/Port1/BytesRead   321536 bytes
00:33:22.707408 /Public/Storage/AHCI0/Port1/QueryBufAttempts        0 count
00:33:22.707412 /Public/Storage/AHCI0/Port1/QueryBufSuccess        0 count
00:33:22.707417 /Public/Storage/AHCI0/Port1/ReqsRead       22 count
00:33:22.707426 /Public/Storage/AHCI0/Port1/ReqsSubmitted       22 count
00:33:22.707429 /Public/Storage/AHCI0/Port1/ReqsSucceeded       22 count
00:33:22.707432 /SELM/LoadHidSel/GstReadErrors          0 times
00:33:22.707435 /SELM/LoadHidSel/NoGoodGuest            0 times
00:33:22.707438 /TM/CPU/00/cNsExecuting          1568740276274 ns
00:33:22.707441 /TM/CPU/00/cNsHalted             39634542934 ns
00:33:22.707444 /TM/CPU/00/cNsOther              389429772554 ns
00:33:22.707447 /TM/CPU/00/cNsTotal              1997804591762 ns
00:33:22.707450 /TM/CPU/00/cPeriodsExecuting     25014119 count
00:33:22.707453 /TM/CPU/00/cPeriodsHalted          298555 count
00:33:22.707456 /TM/CPU/00/pctExecuting                90 %
00:33:22.707459 /TM/CPU/00/pctHalted                    0 %
00:33:22.707462 /TM/CPU/00/pctOther                     9 %
00:33:22.707464 /TM/CPU/pctExecuting                   90 %
00:33:22.707468 /TM/CPU/pctHalted                       0 %
00:33:22.707472 /TM/CPU/pctOther                        9 %
00:33:22.707475 /TM/MaxHzHint                           0 Hz
00:33:22.707478 /TM/MaxHzHint/real                      0 Hz
00:33:22.707481 /TM/MaxHzHint/tsc                       0 Hz
00:33:22.707489 /TM/MaxHzHint/virtual                   0 Hz
00:33:22.707495 /TM/MaxHzHint/virtual_sync              0 Hz
00:33:22.707499 /TM/PIT/Handler                         0 ticks/call (           0 ticks,       0 calls, max         0, min      -1)
00:33:22.707503 /TM/PIT/Irq                             0 times
00:33:22.707507 /TM/R3/1nsSteps                    176657 times
00:33:22.707510 /TM/TSC/offCPU0                  5559461113922046 ticks
00:33:22.707513 /TM/VirtualSync/CurrentOffset     3969326 ns
00:33:22.707518 /TRPM/ForwardRaw/IRQ/30               103 times
00:33:22.707521 /TRPM/ForwardRaw/IRQ/41            100244 times
00:33:22.707526 /TRPM/ForwardRaw/IRQ/61             98070 times
00:33:22.707530 /TRPM/ForwardRaw/IRQ/71               618 times
00:33:22.707541 /TRPM/ForwardRaw/IRQ/EF           3630094 times
00:33:22.707545 /TRPM/ForwardRaw/TRAP/08              196 times
00:33:22.707549 /VMM/EmtHashCollisions/Emt00            0 times
00:33:22.707551 /VMM/LogFlush/00-Flushes                0 times
00:33:22.707554 /VMM/LogFlush/00-NoWakups               0 times
00:33:22.707558 /VMM/LogFlush/CPU0/Rel/cbBuf         4096 bytes
00:33:22.707561 ********************* End of statistics **********************
00:33:22.714169 NAT: Zone(nm:mbuf_cluster, used:0)
00:33:22.714800 NAT: Zone(nm:mbuf_packet, used:0)
00:33:22.714807 NAT: Zone(nm:mbuf, used:1)
00:33:22.714919 NAT: Zone(nm:mbuf_jumbo_pagesize, used:0)
00:33:22.715544 NAT: Zone(nm:mbuf_jumbo_9k, used:0)
00:33:22.715985 NAT: Zone(nm:mbuf_jumbo_16k, used:0)
00:33:22.716213 NAT: Zone(nm:mbuf_ext_refcnt, used:0)
00:33:22.716383 E1000#0: Interrupt attempts: 546540
00:33:22.716386 E1000#0: Interrupts raised : 230735
00:33:22.716389 E1000#0: Interrupts lowered: 6223
00:33:22.716392 E1000#0: ICR outside ISR   : 0
00:33:22.716395 E1000#0: IMS raised ints   : 11887
00:33:22.716397 E1000#0: Interrupts skipped: 282487
00:33:22.716400 E1000#0: Masked interrupts : 33318
00:33:22.716403 E1000#0: Early interrupts  : 0
00:33:22.716406 E1000#0: Late interrupts   : 4292
00:33:22.716408 E1000#0: Lost interrupts   : 0
00:33:22.716411 E1000#0: Interrupts by RX  : 321169
00:33:22.716413 E1000#0: Interrupts by TX  : 110474
00:33:22.716416 E1000#0: Interrupts by ICS : 970
00:33:22.716421 E1000#0: Interrupts by RDTR: 0
00:33:22.716425 E1000#0: Interrupts by RDMT: 0
00:33:22.716429 E1000#0: Interrupts by TXQE: 0
00:33:22.716432 E1000#0: TX int delay asked: 0
00:33:22.716435 E1000#0: TX delayed:         0
00:33:22.716438 E1000#0: TX delay expired:   0
00:33:22.716441 E1000#0: TX no report asked: 110414
00:33:22.716444 E1000#0: TX abs timer expd : 0
00:33:22.716446 E1000#0: TX int timer expd : 0
00:33:22.716449 E1000#0: RX abs timer expd : 0
00:33:22.716452 E1000#0: RX int timer expd : 0
00:33:22.716454 E1000#0: TX CTX descriptors: 110414
00:33:22.716457 E1000#0: TX DAT descriptors: 110414
00:33:22.716460 E1000#0: TX LEG descriptors: 60
00:33:22.716462 E1000#0: Received frames   : 321169
00:33:22.716465 E1000#0: Transmitted frames: 110474
00:33:22.716467 E1000#0: TX frames up to 1514: 110474
00:33:22.716470 E1000#0: TX frames up to 2962: 0
00:33:22.716473 E1000#0: TX frames up to 4410: 0
00:33:22.716475 E1000#0: TX frames up to 5858: 0
00:33:22.716478 E1000#0: TX frames up to 7306: 0
00:33:22.716480 E1000#0: TX frames up to 8754: 0
00:33:22.716483 E1000#0: TX frames up to 16384: 0
00:33:22.716486 E1000#0: TX frames up to 32768: 0
00:33:22.716488 E1000#0: Larger TX frames    : 0
00:33:22.716491 E1000#0: Max TX Delay        : 0
00:33:22.717265 GIM: KVM: Resetting MSRs
00:33:22.717906 vmmR3LogFlusher: Terminating (VERR_OBJECT_DESTROYED)
00:33:22.717963 Changing the VM state from 'DESTROYING' to 'TERMINATED'
00:33:22.719138 Console: Machine state changed to 'Saved'
00:33:22.719417 VBoxHeadless: processEventQueue: VERR_INTERRUPTED, termination requested
00:33:25.297966 VBoxHeadless: exiting

    VM Startup Log:


    VM Trace Log:

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

2024-07-01 20:27:36 (1952): 
Command: VBoxManage -q showvminfo "boinc_f2b0f3018ceff4e2" --machinereadable 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_f2b0f3018ceff4e2'
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-07-01 20:27:36 (1952): 
Command: VBoxManage -q registervm "Z:\ProgramData\BOINC\slots\5/boinc_f2b0f3018ceff4e2/boinc_f2b0f3018ceff4e2.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'Z:\ProgramData\BOINC\slots\5/boinc_f2b0f3018ceff4e2/boinc_f2b0f3018ceff4e2.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-07-01 20:27:38 (1952): 
Command: VBoxManage -q registervm "Z:\ProgramData\BOINC\slots\5/boinc_f2b0f3018ceff4e2/boinc_f2b0f3018ceff4e2.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'Z:\ProgramData\BOINC\slots\5/boinc_f2b0f3018ceff4e2/boinc_f2b0f3018ceff4e2.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-07-01 20:27:39 (1952): 
Command: VBoxManage -q registervm "Z:\ProgramData\BOINC\slots\5/boinc_f2b0f3018ceff4e2/boinc_f2b0f3018ceff4e2.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'Z:\ProgramData\BOINC\slots\5/boinc_f2b0f3018ceff4e2/boinc_f2b0f3018ceff4e2.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-07-01 20:27:40 (1952): 
Command: VBoxManage -q registervm "Z:\ProgramData\BOINC\slots\5/boinc_f2b0f3018ceff4e2/boinc_f2b0f3018ceff4e2.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'Z:\ProgramData\BOINC\slots\5/boinc_f2b0f3018ceff4e2/boinc_f2b0f3018ceff4e2.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-07-01 20:27:41 (1952): 
Command: VBoxManage -q registervm "Z:\ProgramData\BOINC\slots\5/boinc_f2b0f3018ceff4e2/boinc_f2b0f3018ceff4e2.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'Z:\ProgramData\BOINC\slots\5/boinc_f2b0f3018ceff4e2/boinc_f2b0f3018ceff4e2.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-07-01 20:27:43 (1952): 
Command: VBoxManage -q registervm "Z:\ProgramData\BOINC\slots\5/boinc_f2b0f3018ceff4e2/boinc_f2b0f3018ceff4e2.vbox" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Trying to open a VM config 'Z:\ProgramData\BOINC\slots\5/boinc_f2b0f3018ceff4e2/boinc_f2b0f3018ceff4e2.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-07-01 20:27:43 (1952): 
Command: VBoxManage -q snapshot "boinc_f2b0f3018ceff4e2" list 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_f2b0f3018ceff4e2'
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-07-01 20:27:43 (1952): 
Command: VBoxManage -q bandwidthctl "boinc_f2b0f3018ceff4e2" remove "boinc_f2b0f3018ceff4e2_net" 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_f2b0f3018ceff4e2'
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-07-01 20:27:51 (1952): 
Command: VBoxManage -q unregistervm "boinc_f2b0f3018ceff4e2" --delete 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_f2b0f3018ceff4e2'
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-07-01 20:28:01 (1952): called boinc_finish(-182)

</stderr_txt>
]]>


©2024 CERN