Name OhLKDmRq6D3n7Olcko1bjSoqABFKDmABFKDm7AsVDmsiIKDmeu5krn_0
Workunit 2304364
Created 2 May 2023, 15:11:48 UTC
Sent 2 May 2023, 15:13:30 UTC
Report deadline 9 May 2023, 15:13:30 UTC
Received 3 May 2023, 9:52:41 UTC
Server state Over
Outcome Computation error
Client state Cancelled by server
Exit status 202 (0x000000CA) EXIT_ABORTED_BY_PROJECT
Computer ID 4862
Run time 19 min 44 sec
CPU time 9 min 9 sec
Validate state Invalid
Credit 0.00
Device peak FLOPS 38.68 GFLOPS
Application version ATLAS Simulation v3.01 (vbox64_mt_mcore_atlas)
windows_x86_64
Peak working set size 112.63 MB
Peak swap size 128.82 MB
Peak disk usage 610.96 MB

Stderr output

<core_client_version>7.16.20</core_client_version>
<![CDATA[
<message>
aborted by project - no longer usable</message>
<stderr_txt>
2023-05-02 17:13:44 (21472): Detected: vboxwrapper 26206
2023-05-02 17:13:44 (21472): Detected: BOINC client v7.16.20
2023-05-02 17:13:45 (21472): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2023-05-02 17:13:45 (21472): Successfully copied 'init_data.xml' to the shared directory.
2023-05-02 17:13:46 (21472): Create VM. (boinc_f3a34c527cba8ab8, slot#25)
2023-05-02 17:13:46 (21472): Setting Memory Size for VM. (4800MB)
2023-05-02 17:13:46 (21472): Setting CPU Count for VM. (8)
2023-05-02 17:13:47 (21472): Setting Chipset Options for VM.
2023-05-02 17:13:47 (21472): Setting Graphics Controller Options for VM.
2023-05-02 17:13:47 (21472): Setting Boot Options for VM.
2023-05-02 17:13:47 (21472): Setting Network Configuration for NAT.
2023-05-02 17:13:48 (21472): Enabling VM Network Access.
2023-05-02 17:13:48 (21472): Disabling USB Support for VM.
2023-05-02 17:13:48 (21472): Disabling COM Port Support for VM.
2023-05-02 17:13:49 (21472): Disabling LPT Port Support for VM.
2023-05-02 17:13:49 (21472): Disabling Audio Support for VM.
2023-05-02 17:13:49 (21472): Disabling Clipboard Support for VM.
2023-05-02 17:13:49 (21472): Disabling Drag and Drop Support for VM.
2023-05-02 17:13:50 (21472): Adding storage controller(s) to VM.
2023-05-02 17:13:50 (21472): Adding virtual disk drive to VM. (ATLAS_vbox_3.01_image.vdi)
2023-05-02 17:13:50 (21472): Adding VirtualBox Guest Additions to VM.
2023-05-02 17:13:51 (21472): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2023-05-02 17:13:51 (21472): forwarding host port 53579 to guest port 80
2023-05-02 17:13:51 (21472): Enabling remote desktop for VM.
2023-05-02 17:13:52 (21472): Enabling shared directory for VM.
2023-05-02 17:13:52 (21472): Starting VM using VBoxManage interface. (boinc_f3a34c527cba8ab8, slot#25)
2023-05-02 17:13:56 (21472): Successfully started VM. (PID = '5948')
2023-05-02 17:13:56 (21472): Reporting VM Process ID to BOINC.
2023-05-02 17:13:56 (21472): Guest Log: BIOS: VirtualBox 6.0.14
2023-05-02 17:13:56 (21472): Guest Log: CPUID EDX: 0x178bfbff
2023-05-02 17:13:56 (21472): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-05-02 17:13:56 (21472): VM state change detected. (old = 'poweredoff', new = 'running')
2023-05-02 17:13:56 (21472): Detected: Web Application Enabled (http://localhost:53579)
2023-05-02 17:13:56 (21472): Detected: Remote Desktop Enabled (localhost:53580)
2023-05-02 17:13:56 (21472): Preference change detected
2023-05-02 17:13:56 (21472): Setting CPU throttle for VM. (100%)
2023-05-02 17:13:57 (21472): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 900 seconds))
2023-05-02 17:13:58 (21472): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-05-02 17:13:58 (21472): Guest Log: BIOS: Booting from Hard Disk...
2023-05-02 17:14:01 (21472): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-05-02 17:14:01 (21472): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2023-05-02 17:14:01 (21472): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2023-05-02 17:14:07 (21472): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-05-02 17:14:07 (21472): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-05-02 17:14:13 (21472): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2023-05-02 17:14:13 (21472): Guest Log: 00:00:00.000136 main     Log opened 2023-05-02T17:14:11.459638000Z
2023-05-02 17:14:13 (21472): Guest Log: 00:00:00.000234 main     OS Product: Linux
2023-05-02 17:14:13 (21472): Guest Log: 00:00:00.000262 main     OS Release: 3.10.0-957.27.2.el7.x86_64
2023-05-02 17:14:13 (21472): Guest Log: 00:00:00.000287 main     OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2023-05-02 17:14:13 (21472): Guest Log: 00:00:00.000312 main     Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2023-05-02 17:14:13 (21472): Guest Log: 00:00:00.000312 main     Process ID: 1366
2023-05-02 17:14:13 (21472): Guest Log: 00:00:00.000313 main     Package type: LINUX_64BITS_GENERIC
2023-05-02 17:14:13 (21472): Guest Log: 00:00:00.001042 main     5.2.32 r132073 started. Verbose level = 0
2023-05-02 17:14:13 (21472): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch...
2023-05-02 17:14:13 (21472): Guest Log: [INFO] Mounting shared directory
2023-05-02 17:14:13 (21472): Guest Log: [INFO] Checking for init_data.xml
2023-05-02 17:14:15 (21472): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK
2023-05-02 17:14:15 (21472): Guest Log: [INFO] Detected branch: dev
2023-05-02 17:14:15 (21472): Guest Log: This is the dev version of the ATLAS job wrapper
2023-05-02 17:14:15 (21472): Guest Log: Copying input files
2023-05-02 17:14:16 (21472): Guest Log: Copied input files into RunAtlas.
2023-05-02 17:14:16 (21472): Guest Log: This VM did not configure a local http proxy via BOINC.
2023-05-02 17:14:16 (21472): Guest Log: Small home clusters do not require a local http proxy but it is suggested if
2023-05-02 17:14:16 (21472): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
2023-05-02 17:14:16 (21472): Guest Log: Further information can be found at the LHC@home message board.
2023-05-02 17:14:23 (21472): Guest Log: 00:00:10.005875 timesync vgsvcTimeSyncWorker: Radical guest time change: -7 188 370 015 000ns (GuestNow=1 683 040 463 093 158 000 ns GuestLast=1 683 047 651 463 173 000 ns fSetTimeLastLoop=true )
2023-05-02 17:14:27 (21472): Guest Log: Running cvmfs_config stat atlas.cern.ch
2023-05-02 17:14:27 (21472): 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
2023-05-02 17:14:27 (21472): Guest Log: 2.6.3.0 1643 0 32344 118534 4 1 3118198 4096000 0 65024 0 0 n/a 823 196 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1
2023-05-02 17:14:27 (21472): Guest Log: copied the webapp to /var/www
2023-05-02 17:14:27 (21472): Guest Log: ATHENA_PROC_NUMBER=8
2023-05-02 17:14:27 (21472): Guest Log: ATHENA_CORE_NUMBER=8
2023-05-02 17:14:28 (21472): Guest Log: Apptainer command /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/data,/home/atlas/RunAtlas /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 
2023-05-02 17:14:28 (21472): Guest Log:  *** Starting ATLAS job. (PandaID=5837320722 taskID=NULL&cor) ***
2023-05-02 17:32:04 (21472): VM state change detected. (old = 'running', new = 'paused')
2023-05-03 11:40:18 (21472): Guest Log: 00:17:51.463532 timesync vgsvcTimeSyncWorker: Radical host time change: 65 303 274 000 000ns (HostNow=1 683 106 765 860 000 000 ns HostLast=1 683 041 462 586 000 000 ns)
2023-05-03 11:40:18 (21472): VM state change detected. (old = 'paused', new = 'running')
2023-05-03 11:40:28 (21472): Guest Log: 00:18:01.473792 timesync vgsvcTimeSyncWorker: Radical guest time change: 65 251 319 815 000ns (GuestNow=1 683 106 775 870 460 000 ns GuestLast=1 683 041 524 550 645 000 ns fSetTimeLastLoop=true )
2023-05-03 11:41:30 (21472): Powering off VM.
2023-05-03 11:41:30 (21472): Successfully stopped VM.
2023-05-03 11:41:30 (21472): Deregistering VM. (boinc_f3a34c527cba8ab8, slot#25)
2023-05-03 11:41:30 (21472): Removing network bandwidth throttle group from VM.
2023-05-03 11:41:31 (21472): Removing VM from VirtualBox.

    Hypervisor System Log:

121:56:57.478161          Saving settings file "C:\ProgramData\BOINC\slots\9\boinc_2c6c255a1265bad2\boinc_2c6c255a1265bad2.vbox" with version "1.16-windows"
121:57:04.688503          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
121:57:05.063120          Saving settings file "C:\ProgramData\BOINC\slots\23\boinc_5b6ccad5f3f354a0\boinc_5b6ccad5f3f354a0.vbox" with version "1.16-windows"
121:57:05.198119          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
121:57:05.200010          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
121:57:05.245368          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
121:57:05.247503          Saving settings file "C:\ProgramData\BOINC\slots\23\boinc_5b6ccad5f3f354a0\boinc_5b6ccad5f3f354a0.vbox" with version "1.16-windows"
121:57:05.501144          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
121:57:05.501462          Saving settings file "C:\Users\123\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
121:57:05.505150 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
121:57:05.505390 DeleteVM Saving settings file "C:\ProgramData\BOINC\slots\2\boinc_bfa5d00b56429bff\boinc_bfa5d00b56429bff.vbox" with version "1.16-windows"
122:01:20.754620 USBPROXY Getting USB descriptor (id 0) failed with error 31
122:01:22.078765 USBPROXY Getting USB descriptor (id 0) failed with error 31
122:03:20.177725          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
122:03:20.285236          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
122:03:20.834258          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
122:03:20.845098          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
122:03:20.936735          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
122:03:59.008781 MainPower Host suspending: Paused 5 VMs
122:03:59.621658 USBPROXY Getting USB descriptor (id 0) failed with error 31
140:04:42.469430 MainPower Host resumed: Resumed 5 VMs
140:04:44.151918 dns-monitor HostDnsMonitor::updateInfo
140:04:44.151964 dns-monitor HostDnsMonitor: old information
140:04:44.151971 dns-monitor   server 1: 192.168.1.1
140:04:44.151981 dns-monitor   domain: home
140:04:44.151987 dns-monitor   no search string entries
140:04:44.151992 dns-monitor HostDnsMonitor: new information
140:04:44.151997 dns-monitor   no server entries
140:04:44.152002 dns-monitor   no domain set
140:04:44.152007 dns-monitor   no search string entries
140:04:45.470588 USBPROXY Getting USB descriptor (id 0) failed with error 31
140:04:49.374221 dns-monitor HostDnsMonitor::updateInfo
140:04:49.374254 dns-monitor HostDnsMonitor: old information
140:04:49.374261 dns-monitor   no server entries
140:04:49.374268 dns-monitor   no domain set
140:04:49.374274 dns-monitor   no search string entries
140:04:49.374280 dns-monitor HostDnsMonitor: new information
140:04:49.374287 dns-monitor   server 1: 192.168.1.1
140:04:49.374293 dns-monitor   domain: home
140:04:49.374300 dns-monitor   no search string entries
140:04:58.593962 USBPROXY Getting USB descriptor (id 0) failed with error 31
140:11:35.311579          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
140:11:35.311653          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
140:11:35.729722          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
140:11:35.770541          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
140:11:35.833973          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
140:12:48.370819          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
140:12:48.469338          Saving settings file "C:\ProgramData\BOINC\slots\25\boinc_f3a34c527cba8ab8\boinc_f3a34c527cba8ab8.vbox" with version "1.16-windows"
140:12:48.898710          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
140:12:48.901429          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
140:12:48.958085          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
140:12:48.960958          Saving settings file "C:\ProgramData\BOINC\slots\25\boinc_f3a34c527cba8ab8\boinc_f3a34c527cba8ab8.vbox" with version "1.16-windows"
140:12:49.218369          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
140:12:49.219981          Saving settings file "C:\Users\123\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
140:12:49.222635          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
140:12:49.222808          Saving settings file "C:\ProgramData\BOINC\slots\9\boinc_2c6c255a1265bad2\boinc_2c6c255a1265bad2.vbox" with version "1.16-windows"
140:12:49.226099 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
140:12:49.226294 DeleteVM Saving settings file "C:\ProgramData\BOINC\slots\9\boinc_2c6c255a1265bad2\boinc_2c6c255a1265bad2.vbox" with version "1.16-windows"

    VM Execution Log:

cNsHalted             1120854156780 ns
18:27:37.461283 /TM/CPU/00/cNsOther              17186534171 ns
18:27:37.461288 /TM/CPU/00/cNsTotal              1161304544408 ns
18:27:37.461295 /TM/CPU/00/cPeriodsExecuting      4449493 count
18:27:37.461300 /TM/CPU/00/cPeriodsHalted          487765 count
18:27:37.461305 /TM/CPU/00/pctExecuting                 0 %
18:27:37.461310 /TM/CPU/00/pctHalted                   99 %
18:27:37.461315 /TM/CPU/00/pctOther                     0 %
18:27:37.461319 /TM/CPU/01/cNsExecuting          22655144363 ns
18:27:37.461324 /TM/CPU/01/cNsHalted             1127506231401 ns
18:27:37.461329 /TM/CPU/01/cNsOther              11143826799 ns
18:27:37.461334 /TM/CPU/01/cNsTotal              1161305202563 ns
18:27:37.461338 /TM/CPU/01/cPeriodsExecuting      1793185 count
18:27:37.461343 /TM/CPU/01/cPeriodsHalted          399767 count
18:27:37.461347 /TM/CPU/01/pctExecuting                 0 %
18:27:37.461352 /TM/CPU/01/pctHalted                   99 %
18:27:37.461357 /TM/CPU/01/pctOther                     0 %
18:27:37.461361 /TM/CPU/02/cNsExecuting          51923822583 ns
18:27:37.461366 /TM/CPU/02/cNsHalted             1098692655448 ns
18:27:37.461371 /TM/CPU/02/cNsOther              10688712129 ns
18:27:37.461376 /TM/CPU/02/cNsTotal              1161305190160 ns
18:27:37.461380 /TM/CPU/02/cPeriodsExecuting      1571984 count
18:27:37.461385 /TM/CPU/02/cPeriodsHalted          333850 count
18:27:37.461390 /TM/CPU/02/pctExecuting                 0 %
18:27:37.461394 /TM/CPU/02/pctHalted                   99 %
18:27:37.461399 /TM/CPU/02/pctOther                     0 %
18:27:37.461404 /TM/CPU/03/cNsExecuting          16575626569 ns
18:27:37.461409 /TM/CPU/03/cNsHalted             1135230301794 ns
18:27:37.461413 /TM/CPU/03/cNsOther              9499265083 ns
18:27:37.461419 /TM/CPU/03/cNsTotal              1161305193446 ns
18:27:37.461423 /TM/CPU/03/cPeriodsExecuting      1473475 count
18:27:37.461428 /TM/CPU/03/cPeriodsHalted          327985 count
18:27:37.461432 /TM/CPU/03/pctExecuting                 0 %
18:27:37.461437 /TM/CPU/03/pctHalted                   99 %
18:27:37.461442 /TM/CPU/03/pctOther                     0 %
18:27:37.461446 /TM/CPU/04/cNsExecuting          38760761584 ns
18:27:37.461451 /TM/CPU/04/cNsHalted             1113051162980 ns
18:27:37.461456 /TM/CPU/04/cNsOther              9493272110 ns
18:27:37.461460 /TM/CPU/04/cNsTotal              1161305196674 ns
18:27:37.461465 /TM/CPU/04/cPeriodsExecuting      1473932 count
18:27:37.461470 /TM/CPU/04/cPeriodsHalted          353998 count
18:27:37.461474 /TM/CPU/04/pctExecuting                 0 %
18:27:37.461479 /TM/CPU/04/pctHalted                   99 %
18:27:37.461483 /TM/CPU/04/pctOther                     0 %
18:27:37.461488 /TM/CPU/05/cNsExecuting          99197041496 ns
18:27:37.461493 /TM/CPU/05/cNsHalted             1050787543878 ns
18:27:37.461497 /TM/CPU/05/cNsOther              11320615500 ns
18:27:37.461502 /TM/CPU/05/cNsTotal              1161305200874 ns
18:27:37.461507 /TM/CPU/05/cPeriodsExecuting      1404599 count
18:27:37.461511 /TM/CPU/05/cPeriodsHalted          300374 count
18:27:37.461516 /TM/CPU/05/pctExecuting                 0 %
18:27:37.461521 /TM/CPU/05/pctHalted                   99 %
18:27:37.461525 /TM/CPU/05/pctOther                     0 %
18:27:37.461530 /TM/CPU/06/cNsExecuting          117103013036 ns
18:27:37.461535 /TM/CPU/06/cNsHalted             1033924680923 ns
18:27:37.461539 /TM/CPU/06/cNsOther              10276856048 ns
18:27:37.461544 /TM/CPU/06/cNsTotal              1161304550007 ns
18:27:37.461549 /TM/CPU/06/cPeriodsExecuting      1443122 count
18:27:37.461553 /TM/CPU/06/cPeriodsHalted          302206 count
18:27:37.461558 /TM/CPU/06/pctExecuting                 0 %
18:27:37.461563 /TM/CPU/06/pctHalted                   99 %
18:27:37.461567 /TM/CPU/06/pctOther                     0 %
18:27:37.461572 /TM/CPU/07/cNsExecuting          98127010354 ns
18:27:37.461576 /TM/CPU/07/cNsHalted             1044675822199 ns
18:27:37.461581 /TM/CPU/07/cNsOther              18502369752 ns
18:27:37.461586 /TM/CPU/07/cNsTotal              1161305202305 ns
18:27:37.461591 /TM/CPU/07/cPeriodsExecuting      2143150 count
18:27:37.461597 /TM/CPU/07/cPeriodsHalted          363312 count
18:27:37.461601 /TM/CPU/07/pctExecuting                 0 %
18:27:37.461606 /TM/CPU/07/pctHalted                   99 %
18:27:37.461610 /TM/CPU/07/pctOther                     0 %
18:27:37.461615 /TM/CPU/pctExecuting                    0 %
18:27:37.461620 /TM/CPU/pctHalted                      99 %
18:27:37.461624 /TM/CPU/pctOther                        0 %
18:27:37.461629 /TM/MaxHzHint                           0 Hz
18:27:37.461634 /TM/R0/1nsSteps                       312 times
18:27:37.461639 /TM/R3/1nsSteps                      5762 times
18:27:37.461643 /TM/TSC/offCPU0                  713908766277372 ticks
18:27:37.461648 /TM/TSC/offCPU1                  713908766277372 ticks
18:27:37.461653 /TM/TSC/offCPU2                  713908766277372 ticks
18:27:37.461658 /TM/TSC/offCPU3                  713908766277372 ticks
18:27:37.461663 /TM/TSC/offCPU4                  713908766277372 ticks
18:27:37.461667 /TM/TSC/offCPU5                  713908766277372 ticks
18:27:37.461672 /TM/TSC/offCPU6                  713908766277372 ticks
18:27:37.461677 /TM/TSC/offCPU7                  713908766277372 ticks
18:27:37.461682 /TM/VirtualSync/CurrentOffset    232241961216 ns
18:27:37.461687 /TM/VirtualSync/GivenUp          180004382020 ns
18:27:37.461692 ********************* End of statistics **********************
18:27:37.466106 NAT: Zone(nm:mbuf_cluster, used:0)
18:27:37.466589 NAT: Zone(nm:mbuf_packet, used:0)
18:27:37.466601 NAT: Zone(nm:mbuf, used:1)
18:27:37.466737 NAT: Zone(nm:mbuf_jumbo_pagesize, used:0)
18:27:37.467502 NAT: Zone(nm:mbuf_jumbo_9k, used:0)
18:27:37.467930 NAT: Zone(nm:mbuf_jumbo_16k, used:0)
18:27:37.468173 NAT: Zone(nm:mbuf_ext_refcnt, used:0)
18:27:37.468331 E1000#0: Interrupt attempts: 168360
18:27:37.468341 E1000#0: Interrupts raised : 45215
18:27:37.468348 E1000#0: Interrupts lowered: 7145
18:27:37.468354 E1000#0: ICR outside ISR   : 0
18:27:37.468360 E1000#0: IMS raised ints   : 14268
18:27:37.468366 E1000#0: Interrupts skipped: 53033
18:27:37.468372 E1000#0: Masked interrupts : 70112
18:27:37.468378 E1000#0: Early interrupts  : 0
18:27:37.468384 E1000#0: Late interrupts   : 5028
18:27:37.468390 E1000#0: Lost interrupts   : 0
18:27:37.468396 E1000#0: Interrupts by RX  : 123809
18:27:37.468402 E1000#0: Interrupts by TX  : 19501
18:27:37.468409 E1000#0: Interrupts by ICS : 529
18:27:37.468415 E1000#0: Interrupts by RDTR: 0
18:27:37.468421 E1000#0: Interrupts by RDMT: 0
18:27:37.468427 E1000#0: Interrupts by TXQE: 0
18:27:37.468433 E1000#0: TX int delay asked: 0
18:27:37.468439 E1000#0: TX delayed:         0
18:27:37.468445 E1000#0: TX delay expired:   0
18:27:37.468451 E1000#0: TX no report asked: 19364
18:27:37.468457 E1000#0: TX abs timer expd : 0
18:27:37.468463 E1000#0: TX int timer expd : 0
18:27:37.468469 E1000#0: RX abs timer expd : 0
18:27:37.468475 E1000#0: RX int timer expd : 0
18:27:37.468480 E1000#0: TX CTX descriptors: 19358
18:27:37.468486 E1000#0: TX DAT descriptors: 19364
18:27:37.468492 E1000#0: TX LEG descriptors: 143
18:27:37.468498 E1000#0: Received frames   : 123809
18:27:37.468504 E1000#0: Transmitted frames: 19501
18:27:37.468510 E1000#0: TX frames up to 1514: 19499
18:27:37.468517 E1000#0: TX frames up to 2962: 2
18:27:37.468522 E1000#0: TX frames up to 4410: 0
18:27:37.468528 E1000#0: TX frames up to 5858: 0
18:27:37.468534 E1000#0: TX frames up to 7306: 0
18:27:37.468540 E1000#0: TX frames up to 8754: 0
18:27:37.468546 E1000#0: TX frames up to 16384: 0
18:27:37.468552 E1000#0: TX frames up to 32768: 0
18:27:37.468558 E1000#0: Larger TX frames    : 0
18:27:37.468564 E1000#0: Max TX Delay        : 0
18:27:37.469386 GIM: KVM: Resetting MSRs
18:27:37.471789 Changing the VM state from 'DESTROYING' to 'TERMINATED'
18:27:37.472762 Console: Machine state changed to 'PoweredOff'

    VM Startup Log:


    VM Trace Log:

ption: AMD Ryzen 9 3900X 12-Core Processor
Processor#19 speed: unknown
Processor#19 description: AMD Ryzen 9 3900X 12-Core Processor
Processor#20 speed: unknown
Processor#20 description: AMD Ryzen 9 3900X 12-Core Processor
Processor#21 speed: unknown
Processor#21 description: AMD Ryzen 9 3900X 12-Core Processor
Processor#22 speed: unknown
Processor#22 description: AMD Ryzen 9 3900X 12-Core Processor
Processor#23 speed: unknown
Processor#23 description: AMD Ryzen 9 3900X 12-Core Processor
Memory size: 32691 MByte
Memory available: 20536 MByte
Operating system: Windows 10
Operating system version: 10.0.19044

2023-05-02 17:13:45 (21472): 
Command: VBoxManage -q showvminfo "boinc_f3a34c527cba8ab8" --machinereadable 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_f3a34c527cba8ab8'
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 2621 of file VBoxManageInfo.cpp

2023-05-02 17:13:46 (21472): 
Command: VBoxManage -q showhdinfo "C:\ProgramData\BOINC\slots\25/vm_image.vdi" 
Exit Code: -2135228412
Output:
VBoxManage.exe: error: Could not find file for the medium 'C:\ProgramData\BOINC\slots\25\vm_image.vdi' (VERR_FILE_NOT_FOUND)
VBoxManage.exe: error: Details: code VBOX_E_FILE_ERROR (0x80bb0004), component MediumWrap, interface IMedium, callee IUnknown
VBoxManage.exe: error: Context: "OpenMedium(Bstr(pszFilenameOrUuid).raw(), enmDevType, enmAccessMode, fForceNewUuidOnOpen, pMedium.asOutParam())" at line 191 of file VBoxManageDisk.cpp

2023-05-02 17:13:46 (21472): 
Command: VBoxManage -q createvm --name "boinc_f3a34c527cba8ab8" --basefolder "C:\ProgramData\BOINC\slots\25" --ostype "Linux26_64" --register
Exit Code: 0
Output:
Virtual machine 'boinc_f3a34c527cba8ab8' is created and registered.
UUID: 7e977152-8f7f-46ff-9656-00b4b8d24c8e
Settings file: 'C:\ProgramData\BOINC\slots\25\boinc_f3a34c527cba8ab8\boinc_f3a34c527cba8ab8.vbox'

2023-05-02 17:13:46 (21472): 
Command: VBoxManage -q modifyvm "boinc_f3a34c527cba8ab8" --description "OhLKDmRq6D3n7Olcko1bjSoqABFKDmABFKDm7AsVDmsiIKDmeu5krn_0" 
Exit Code: 0
Output:

2023-05-02 17:13:46 (21472): 
Command: VBoxManage -q modifyvm "boinc_f3a34c527cba8ab8" --memory 4800 
Exit Code: 0
Output:

2023-05-02 17:13:47 (21472): 
Command: VBoxManage -q modifyvm "boinc_f3a34c527cba8ab8" --cpus 8 
Exit Code: 0
Output:

2023-05-02 17:13:47 (21472): 
Command: VBoxManage -q modifyvm "boinc_f3a34c527cba8ab8" --acpi on --ioapic on --rtcuseutc off 
Exit Code: 0
Output:

2023-05-02 17:13:47 (21472): 
Command: VBoxManage -q modifyvm "boinc_f3a34c527cba8ab8" --vram 16 --graphicscontroller VBoxVGA 
Exit Code: 0
Output:

2023-05-02 17:13:47 (21472): 
Command: VBoxManage -q modifyvm "boinc_f3a34c527cba8ab8" --boot1 disk --boot2 dvd --boot3 none --boot4 none 
Exit Code: 0
Output:

2023-05-02 17:13:48 (21472): 
Command: VBoxManage -q modifyvm "boinc_f3a34c527cba8ab8" --nic1 nat --natdnsproxy1 on --cableconnected1 off 
Exit Code: 0
Output:

2023-05-02 17:13:48 (21472): 
Command: VBoxManage -q modifyvm "boinc_f3a34c527cba8ab8" --cableconnected1 on 
Exit Code: 0
Output:

2023-05-02 17:13:48 (21472): 
Command: VBoxManage -q modifyvm "boinc_f3a34c527cba8ab8" --usb off 
Exit Code: 0
Output:

2023-05-02 17:13:49 (21472): 
Command: VBoxManage -q modifyvm "boinc_f3a34c527cba8ab8" --uart1 off --uart2 off 
Exit Code: 0
Output:

2023-05-02 17:13:49 (21472): 
Command: VBoxManage -q modifyvm "boinc_f3a34c527cba8ab8" --lpt1 off --lpt2 off 
Exit Code: 0
Output:

2023-05-02 17:13:49 (21472): 
Command: VBoxManage -q modifyvm "boinc_f3a34c527cba8ab8" --audio none 
Exit Code: 0
Output:

2023-05-02 17:13:49 (21472): 
Command: VBoxManage -q modifyvm "boinc_f3a34c527cba8ab8" --clipboard disabled 
Exit Code: 0
Output:

2023-05-02 17:13:50 (21472): 
Command: VBoxManage -q modifyvm "boinc_f3a34c527cba8ab8" --draganddrop disabled 
Exit Code: 0
Output:

2023-05-02 17:13:50 (21472): 
Command: VBoxManage -q storagectl "boinc_f3a34c527cba8ab8" --name "Hard Disk Controller" --add "sata" --controller "IntelAHCI" --hostiocache off --portcount 3
Exit Code: 0
Output:

2023-05-02 17:13:50 (21472): 
Command: VBoxManage -q showhdinfo "C:\ProgramData\BOINC/projects/lhcathomedev.cern.ch_lhcathome-dev/ATLAS_vbox_3.01_image.vdi" 
Exit Code: 0
Output:
UUID:           3cf239b7-a9fd-4709-b194-cc98ec498c97
Parent UUID:    base
State:          created
Type:           multiattach
Location:       C:\ProgramData\BOINC\projects\lhcathomedev.cern.ch_lhcathome-dev\ATLAS_vbox_3.01_image.vdi
Storage format: VDI
Format variant: dynamic default
Capacity:       20480 MBytes
Size on disk:   4204 MBytes
Encryption:     disabled

2023-05-02 17:13:50 (21472): 
Command: VBoxManage -q storageattach "boinc_f3a34c527cba8ab8" --storagectl "Hard Disk Controller" --port 0 --device 0 --type hdd --mtype multiattach --medium "C:\ProgramData\BOINC/projects/lhcathomedev.cern.ch_lhcathome-dev/ATLAS_vbox_3.01_image.vdi" 
Exit Code: 0
Output:

2023-05-02 17:13:51 (21472): 
Command: VBoxManage -q storageattach "boinc_f3a34c527cba8ab8" --storagectl "Hard Disk Controller" --port 1 --device 0 --type dvddrive --medium "C:\Program Files\Oracle\VirtualBox/VBoxGuestAdditions.iso" 
Exit Code: 0
Output:

2023-05-02 17:13:51 (21472): 
Command: VBoxManage -q bandwidthctl "boinc_f3a34c527cba8ab8" add "boinc_f3a34c527cba8ab8_net" --type network --limit 1024G 
Exit Code: 0
Output:

2023-05-02 17:13:51 (21472): 
Command: VBoxManage -q modifyvm "boinc_f3a34c527cba8ab8" --natpf1 ",tcp,127.0.0.1,53579,,80" 
Exit Code: 0
Output:

2023-05-02 17:13:51 (21472): 
Command: VBoxManage -q list extpacks
Exit Code: 0
Output:
Extension Packs: 1
Pack no. 0:   Oracle VM VirtualBox Extension Pack
Version:      6.1.28
Revision:     147628
Edition:      
Description:  Oracle Cloud Infrastructure integration, USB 2.0 and USB 3.0 Host Controller, Host Webcam, VirtualBox RDP, PXE ROM, Disk Encryption, NVMe.
VRDE Module:  VBoxVRDP
Usable:       false
Why unusable: Failed to load the main module ('C:\Program Files\Oracle\VirtualBox\ExtensionPacks\Oracle_VM_VirtualBox_Extension_Pack\win.amd64\VBoxPuelMain.DLL'): VERR_SYMBOL_NOT_FOUND - GetLastError=127

2023-05-02 17:13:52 (21472): 
Command: VBoxManage -q modifyvm "boinc_f3a34c527cba8ab8" --vrde on --vrdeextpack default --vrdeauthlibrary default --vrdeauthtype null --vrdeport 53580 
Exit Code: 0
Output:

2023-05-02 17:13:52 (21472): 
Command: VBoxManage -q sharedfolder add "boinc_f3a34c527cba8ab8" --name "shared" --hostpath "C:\ProgramData\BOINC\slots\25/shared"
Exit Code: 0
Output:

2023-05-02 17:13:55 (21472): 
Command: VBoxManage -q startvm "boinc_f3a34c527cba8ab8" --type headless
Exit Code: 0
Output:
Waiting for VM "boinc_f3a34c527cba8ab8" to power on...
VM "boinc_f3a34c527cba8ab8" has been successfully started.

2023-05-02 17:13:57 (21472): 
Command: VBoxManage -q controlvm "boinc_f3a34c527cba8ab8" cpuexecutioncap 100 
Exit Code: 0
Output:

2023-05-02 17:32:04 (21472): 
Command: VBoxManage -q controlvm "boinc_f3a34c527cba8ab8" pause
Exit Code: 0
Output:

2023-05-03 11:40:17 (21472): 
Command: VBoxManage -q controlvm "boinc_f3a34c527cba8ab8" resume
Exit Code: 0
Output:

2023-05-03 11:41:30 (21472): 
Command: VBoxManage -q controlvm "boinc_f3a34c527cba8ab8" poweroff
Exit Code: 0
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...100%

2023-05-03 11:41:30 (21472): 
Command: VBoxManage -q snapshot "boinc_f3a34c527cba8ab8" list 
Exit Code: -108
Output:
This machine does not have any snapshots

2023-05-03 11:41:31 (21472): 
Command: VBoxManage -q bandwidthctl "boinc_f3a34c527cba8ab8" remove "boinc_f3a34c527cba8ab8_net" 
Exit Code: 0
Output:

2023-05-03 11:41:31 (21472): 
Command: VBoxManage -q unregistervm "boinc_f3a34c527cba8ab8" --delete 
Exit Code: 0
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...100%

11:41:41 (21472): called boinc_finish(194)

</stderr_txt>
]]>


©2024 CERN