Name rOPLDmMkND3n7Olcko1bjSoqABFKDmABFKDm7AsVDm5XIKDmjQGM0m_0
Workunit 2303772
Created 30 Apr 2023, 15:02:26 UTC
Sent 30 Apr 2023, 15:04:01 UTC
Report deadline 7 May 2023, 15:04:01 UTC
Received 1 May 2023, 12:29:36 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 9 min 10 sec
CPU time 3 min 2 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 114.00 MB
Peak swap size 129.03 MB
Peak disk usage 505.66 MB

Stderr output

<core_client_version>7.16.20</core_client_version>
<![CDATA[
<message>
aborted by project - no longer usable</message>
<stderr_txt>
2023-04-30 17:04:22 (17396): Detected: vboxwrapper 26206
2023-04-30 17:04:22 (17396): Detected: BOINC client v7.16.20
2023-04-30 17:04:23 (17396): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2023-04-30 17:04:23 (17396): Successfully copied 'init_data.xml' to the shared directory.
2023-04-30 17:04:23 (17396): Create VM. (boinc_77e2b5e7613d8fff, slot#29)
2023-04-30 17:04:24 (17396): Setting Memory Size for VM. (4800MB)
2023-04-30 17:04:24 (17396): Setting CPU Count for VM. (8)
2023-04-30 17:04:24 (17396): Setting Chipset Options for VM.
2023-04-30 17:04:25 (17396): Setting Graphics Controller Options for VM.
2023-04-30 17:04:25 (17396): Setting Boot Options for VM.
2023-04-30 17:04:25 (17396): Setting Network Configuration for NAT.
2023-04-30 17:04:25 (17396): Enabling VM Network Access.
2023-04-30 17:04:26 (17396): Disabling USB Support for VM.
2023-04-30 17:04:26 (17396): Disabling COM Port Support for VM.
2023-04-30 17:04:26 (17396): Disabling LPT Port Support for VM.
2023-04-30 17:04:26 (17396): Disabling Audio Support for VM.
2023-04-30 17:04:27 (17396): Disabling Clipboard Support for VM.
2023-04-30 17:04:27 (17396): Disabling Drag and Drop Support for VM.
2023-04-30 17:04:27 (17396): Adding storage controller(s) to VM.
2023-04-30 17:04:27 (17396): Adding virtual disk drive to VM. (ATLAS_vbox_3.01_image.vdi)
2023-04-30 17:04:28 (17396): Adding VirtualBox Guest Additions to VM.
2023-04-30 17:04:28 (17396): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2023-04-30 17:04:28 (17396): forwarding host port 52423 to guest port 80
2023-04-30 17:04:29 (17396): Enabling remote desktop for VM.
2023-04-30 17:04:29 (17396): Enabling shared directory for VM.
2023-04-30 17:04:30 (17396): Starting VM using VBoxManage interface. (boinc_77e2b5e7613d8fff, slot#29)
2023-04-30 17:04:34 (17396): Successfully started VM. (PID = '4472')
2023-04-30 17:04:34 (17396): Reporting VM Process ID to BOINC.
2023-04-30 17:04:34 (17396): Guest Log: BIOS: VirtualBox 6.0.14
2023-04-30 17:04:34 (17396): Guest Log: CPUID EDX: 0x178bfbff
2023-04-30 17:04:34 (17396): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-04-30 17:04:34 (17396): VM state change detected. (old = 'poweredoff', new = 'running')
2023-04-30 17:04:34 (17396): Detected: Web Application Enabled (http://localhost:52423)
2023-04-30 17:04:34 (17396): Detected: Remote Desktop Enabled (localhost:52424)
2023-04-30 17:04:34 (17396): Preference change detected
2023-04-30 17:04:34 (17396): Setting CPU throttle for VM. (100%)
2023-04-30 17:04:34 (17396): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 900 seconds))
2023-04-30 17:04:36 (17396): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-04-30 17:04:36 (17396): Guest Log: BIOS: Booting from Hard Disk...
2023-04-30 17:04:39 (17396): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-04-30 17:04:39 (17396): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2023-04-30 17:04:39 (17396): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2023-04-30 17:05:17 (17396): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-04-30 17:05:17 (17396): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-04-30 17:05:23 (17396): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2023-04-30 17:05:23 (17396): Guest Log: 00:00:00.000138 main     Log opened 2023-04-30T17:05:21.507480000Z
2023-04-30 17:05:23 (17396): Guest Log: 00:00:00.000237 main     OS Product: Linux
2023-04-30 17:05:23 (17396): Guest Log: 00:00:00.000267 main     OS Release: 3.10.0-957.27.2.el7.x86_64
2023-04-30 17:05:23 (17396): Guest Log: 00:00:00.000292 main     OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2023-04-30 17:05:23 (17396): Guest Log: 00:00:00.000317 main     Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2023-04-30 17:05:23 (17396): Guest Log: 00:00:00.000318 main     Process ID: 1364
2023-04-30 17:05:23 (17396): Guest Log: 00:00:00.000318 main     Package type: LINUX_64BITS_GENERIC
2023-04-30 17:05:23 (17396): Guest Log: 00:00:00.001081 main     5.2.32 r132073 started. Verbose level = 0
2023-04-30 17:05:23 (17396): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch...
2023-04-30 17:05:23 (17396): Guest Log: [INFO] Mounting shared directory
2023-04-30 17:05:23 (17396): Guest Log: [INFO] Checking for init_data.xml
2023-04-30 17:05:27 (17396): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK
2023-04-30 17:05:27 (17396): Guest Log: [INFO] Detected branch: dev
2023-04-30 17:05:27 (17396): Guest Log: This is the dev version of the ATLAS job wrapper
2023-04-30 17:05:27 (17396): Guest Log: Copying input files
2023-04-30 17:05:27 (17396): Guest Log: Copied input files into RunAtlas.
2023-04-30 17:05:27 (17396): Guest Log: This VM did not configure a local http proxy via BOINC.
2023-04-30 17:05:27 (17396): Guest Log: Small home clusters do not require a local http proxy but it is suggested if
2023-04-30 17:05:27 (17396): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
2023-04-30 17:05:27 (17396): Guest Log: Further information can be found at the LHC@home message board.
2023-04-30 17:05:33 (17396): Guest Log: 00:00:10.004781 timesync vgsvcTimeSyncWorker: Radical guest time change: -7 225 696 339 000ns (GuestNow=1 682 867 095 813 864 000 ns GuestLast=1 682 874 321 510 203 000 ns fSetTimeLastLoop=true )
2023-04-30 17:05:35 (17396): Guest Log: Running cvmfs_config stat atlas.cern.ch
2023-04-30 17:05:35 (17396): 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-04-30 17:05:35 (17396): Guest Log: 2.6.3.0 1643 0 32220 118462 4 1 3116371 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1
2023-04-30 17:05:36 (17396): Guest Log: copied the webapp to /var/www
2023-04-30 17:05:36 (17396): Guest Log: ATHENA_PROC_NUMBER=8
2023-04-30 17:05:36 (17396): Guest Log: ATHENA_CORE_NUMBER=8
2023-04-30 17:05:36 (17396): 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-04-30 17:05:36 (17396): Guest Log:  *** Starting ATLAS job. (PandaID=5836048059 taskID=NULL&cor) ***
2023-04-30 17:12:09 (17396): VM state change detected. (old = 'running', new = 'paused')
2023-05-01 14:26:29 (17396): VM state change detected. (old = 'paused', new = 'running')
2023-05-01 14:26:32 (17396): Guest Log: 00:06:50.064175 timesync vgsvcTimeSyncWorker: Radical host time change: 76 468 983 000 000ns (HostNow=1 682 943 943 235 000 000 ns HostLast=1 682 867 474 252 000 000 ns)
2023-05-01 14:26:42 (17396): Guest Log: 00:07:00.064343 timesync vgsvcTimeSyncWorker: Radical guest time change: 76 457 363 917 000ns (GuestNow=1 682 943 953 236 192 000 ns GuestLast=1 682 867 495 872 275 000 ns fSetTimeLastLoop=true )
2023-05-01 14:27:39 (17396): Powering off VM.
2023-05-01 14:27:39 (17396): Successfully stopped VM.
2023-05-01 14:27:39 (17396): Deregistering VM. (boinc_77e2b5e7613d8fff, slot#29)
2023-05-01 14:27:39 (17396): Removing network bandwidth throttle group from VM.
2023-05-01 14:27:39 (17396): Removing VM from VirtualBox.

    Hypervisor System Log:

73:35:45.369415          Saving settings file "C:\ProgramData\BOINC\slots\29\boinc_77e2b5e7613d8fff\boinc_77e2b5e7613d8fff.vbox" with version "1.16-windows"
73:35:45.883679          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
73:35:45.886923          Saving settings file "C:\ProgramData\BOINC\slots\29\boinc_77e2b5e7613d8fff\boinc_77e2b5e7613d8fff.vbox" with version "1.16-windows"
73:35:46.145599          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
73:35:46.147740          Saving settings file "C:\ProgramData\BOINC\slots\29\boinc_77e2b5e7613d8fff\boinc_77e2b5e7613d8fff.vbox" with version "1.16-windows"
73:35:46.401965          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
73:35:46.407765          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
73:35:46.407919          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
73:35:46.413532          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
73:35:46.662071          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
73:35:50.802326          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
73:35:50.804420          Saving settings file "C:\ProgramData\BOINC\slots\29\boinc_77e2b5e7613d8fff\boinc_77e2b5e7613d8fff.vbox" with version "1.16-windows"
73:42:33.408602 USBPROXY Getting USB descriptor (id 0) failed with error 31
73:42:34.206611 USBPROXY Getting USB descriptor (id 0) failed with error 31
73:42:38.503057 USBPROXY Getting USB descriptor (id 0) failed with error 31
73:43:25.242499          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
73:43:25.376039          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
73:43:25.456970          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
73:43:25.692276          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
73:43:25.761288          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
73:43:25.762104          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
73:43:34.857928 MainPower Host suspending: Paused 6 VMs
73:43:35.567130 USBPROXY Getting USB descriptor (id 0) failed with error 31
94:57:32.437982 MainPower Host resumed: Resumed 6 VMs
94:57:34.032549 USBPROXY Getting USB descriptor (id 0) failed with error 31
94:57:34.152562 dns-monitor HostDnsMonitor::updateInfo
94:57:34.153351 dns-monitor HostDnsMonitor: old information
94:57:34.153370 dns-monitor   server 1: 192.168.1.1
94:57:34.153379 dns-monitor   domain: home
94:57:34.153386 dns-monitor   no search string entries
94:57:34.153394 dns-monitor HostDnsMonitor: new information
94:57:34.153400 dns-monitor   no server entries
94:57:34.153406 dns-monitor   no domain set
94:57:34.153413 dns-monitor   no search string entries
94:57:38.449086 dns-monitor HostDnsMonitor::updateInfo
94:57:38.449114 dns-monitor HostDnsMonitor: old information
94:57:38.449120 dns-monitor   no server entries
94:57:38.449126 dns-monitor   no domain set
94:57:38.449131 dns-monitor   no search string entries
94:57:38.449135 dns-monitor HostDnsMonitor: new information
94:57:38.449140 dns-monitor   server 1: 192.168.1.1
94:57:38.449146 dns-monitor   domain: home
94:57:38.449150 dns-monitor   no search string entries
94:57:43.609544 USBPROXY Getting USB descriptor (id 0) failed with error 31
94:57:43.639510          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
94:57:43.895824          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
94:57:43.908785          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
94:57:43.982556          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
94:57:43.984031          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
94:57:44.456191          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
94:58:55.531261          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
94:58:55.606090          Saving settings file "C:\ProgramData\BOINC\slots\29\boinc_77e2b5e7613d8fff\boinc_77e2b5e7613d8fff.vbox" with version "1.16-windows"
94:58:55.795933          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
94:58:55.798597          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
94:58:55.853480          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
94:58:55.855730          Saving settings file "C:\ProgramData\BOINC\slots\29\boinc_77e2b5e7613d8fff\boinc_77e2b5e7613d8fff.vbox" with version "1.16-windows"
94:58:56.121581          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
94:58:56.121977          Saving settings file "C:\Users\123\.VirtualBox\VirtualBox.xml" with version "1.12-windows"

    VM Execution Log:

:23:07.002266 /TM/CPU/00/cNsExecuting          20004915911 ns
21:23:07.002272 /TM/CPU/00/cNsHalted             494917648066 ns
21:23:07.002278 /TM/CPU/00/cNsOther              11763154410 ns
21:23:07.002284 /TM/CPU/00/cNsTotal              526685718387 ns
21:23:07.002290 /TM/CPU/00/cPeriodsExecuting      4271036 count
21:23:07.002295 /TM/CPU/00/cPeriodsHalted          433249 count
21:23:07.002301 /TM/CPU/00/pctExecuting                 0 %
21:23:07.002307 /TM/CPU/00/pctHalted                   99 %
21:23:07.002313 /TM/CPU/00/pctOther                     0 %
21:23:07.002319 /TM/CPU/01/cNsExecuting          12219883387 ns
21:23:07.002325 /TM/CPU/01/cNsHalted             507649356745 ns
21:23:07.002331 /TM/CPU/01/cNsOther              6817062405 ns
21:23:07.002337 /TM/CPU/01/cNsTotal              526686302537 ns
21:23:07.002343 /TM/CPU/01/cPeriodsExecuting      1583817 count
21:23:07.002349 /TM/CPU/01/cPeriodsHalted          346438 count
21:23:07.002355 /TM/CPU/01/pctExecuting                 0 %
21:23:07.002360 /TM/CPU/01/pctHalted                   99 %
21:23:07.002366 /TM/CPU/01/pctOther                     0 %
21:23:07.002372 /TM/CPU/02/cNsExecuting          18343934168 ns
21:23:07.002378 /TM/CPU/02/cNsHalted             501914370580 ns
21:23:07.002384 /TM/CPU/02/cNsOther              6427999188 ns
21:23:07.002390 /TM/CPU/02/cNsTotal              526686303936 ns
21:23:07.002396 /TM/CPU/02/cPeriodsExecuting      1417072 count
21:23:07.002402 /TM/CPU/02/cPeriodsHalted          337241 count
21:23:07.002407 /TM/CPU/02/pctExecuting                 0 %
21:23:07.002413 /TM/CPU/02/pctHalted                   99 %
21:23:07.002419 /TM/CPU/02/pctOther                     0 %
21:23:07.002425 /TM/CPU/03/cNsExecuting          11756881964 ns
21:23:07.002431 /TM/CPU/03/cNsHalted             508943305790 ns
21:23:07.002437 /TM/CPU/03/cNsOther              5986116938 ns
21:23:07.002443 /TM/CPU/03/cNsTotal              526686304692 ns
21:23:07.002448 /TM/CPU/03/cPeriodsExecuting      1289484 count
21:23:07.002454 /TM/CPU/03/cPeriodsHalted          308939 count
21:23:07.002460 /TM/CPU/03/pctExecuting                 0 %
21:23:07.002466 /TM/CPU/03/pctHalted                   99 %
21:23:07.002472 /TM/CPU/03/pctOther                     0 %
21:23:07.002477 /TM/CPU/04/cNsExecuting          11862553762 ns
21:23:07.002483 /TM/CPU/04/cNsHalted             509132662282 ns
21:23:07.002489 /TM/CPU/04/cNsOther              5691089480 ns
21:23:07.002495 /TM/CPU/04/cNsTotal              526686305524 ns
21:23:07.002501 /TM/CPU/04/cPeriodsExecuting      1145394 count
21:23:07.002507 /TM/CPU/04/cPeriodsHalted          276186 count
21:23:07.002512 /TM/CPU/04/pctExecuting                 0 %
21:23:07.002518 /TM/CPU/04/pctHalted                   99 %
21:23:07.002524 /TM/CPU/04/pctOther                     0 %
21:23:07.002529 /TM/CPU/05/cNsExecuting          10535163277 ns
21:23:07.002535 /TM/CPU/05/cNsHalted             510529181217 ns
21:23:07.002541 /TM/CPU/05/cNsOther              5621975791 ns
21:23:07.002547 /TM/CPU/05/cNsTotal              526686320285 ns
21:23:07.002553 /TM/CPU/05/cPeriodsExecuting      1181709 count
21:23:07.002559 /TM/CPU/05/cPeriodsHalted          277441 count
21:23:07.002564 /TM/CPU/05/pctExecuting                 0 %
21:23:07.002570 /TM/CPU/05/pctHalted                   99 %
21:23:07.002576 /TM/CPU/05/pctOther                     0 %
21:23:07.002582 /TM/CPU/06/cNsExecuting          18815323490 ns
21:23:07.002587 /TM/CPU/06/cNsHalted             501732432260 ns
21:23:07.002633 /TM/CPU/06/cNsOther              6137958708 ns
21:23:07.002641 /TM/CPU/06/cNsTotal              526685714458 ns
21:23:07.002648 /TM/CPU/06/cPeriodsExecuting      1220633 count
21:23:07.002654 /TM/CPU/06/cPeriodsHalted          296463 count
21:23:07.002659 /TM/CPU/06/pctExecuting                 0 %
21:23:07.002665 /TM/CPU/06/pctHalted                   99 %
21:23:07.002671 /TM/CPU/06/pctOther                     0 %
21:23:07.002677 /TM/CPU/07/cNsExecuting          18299191473 ns
21:23:07.002683 /TM/CPU/07/cNsHalted             498580212072 ns
21:23:07.002688 /TM/CPU/07/cNsOther              9806951970 ns
21:23:07.002694 /TM/CPU/07/cNsTotal              526686355515 ns
21:23:07.002700 /TM/CPU/07/cPeriodsExecuting      2214291 count
21:23:07.002706 /TM/CPU/07/cPeriodsHalted          472572 count
21:23:07.002712 /TM/CPU/07/pctExecuting                 0 %
21:23:07.002718 /TM/CPU/07/pctHalted                   99 %
21:23:07.002724 /TM/CPU/07/pctOther                     0 %
21:23:07.002730 /TM/CPU/pctExecuting                    0 %
21:23:07.002735 /TM/CPU/pctHalted                      99 %
21:23:07.002741 /TM/CPU/pctOther                        0 %
21:23:07.002747 /TM/MaxHzHint                           0 Hz
21:23:07.002753 /TM/R0/1nsSteps                       248 times
21:23:07.002759 /TM/R3/1nsSteps                      1817 times
21:23:07.002765 /TM/TSC/offCPU0                  550691041989533 ticks
21:23:07.002771 /TM/TSC/offCPU1                  550691041989533 ticks
21:23:07.002777 /TM/TSC/offCPU2                  550691041989533 ticks
21:23:07.002783 /TM/TSC/offCPU3                  550691041989533 ticks
21:23:07.002789 /TM/TSC/offCPU4                  550691041989533 ticks
21:23:07.002795 /TM/TSC/offCPU5                  550691041989533 ticks
21:23:07.002801 /TM/TSC/offCPU6                  550691041989533 ticks
21:23:07.002807 /TM/TSC/offCPU7                  550691041989533 ticks
21:23:07.002813 /TM/VirtualSync/CurrentOffset    49633950250 ns
21:23:07.002819 ********************* End of statistics **********************
21:23:07.009045 NAT: Zone(nm:mbuf_cluster, used:0)
21:23:07.009302 NAT: Zone(nm:mbuf_packet, used:0)
21:23:07.009314 NAT: Zone(nm:mbuf, used:1)
21:23:07.009323 NAT: Zone(nm:mbuf_jumbo_pagesize, used:0)
21:23:07.009553 NAT: Zone(nm:mbuf_jumbo_9k, used:0)
21:23:07.009916 NAT: Zone(nm:mbuf_jumbo_16k, used:0)
21:23:07.010115 NAT: Zone(nm:mbuf_ext_refcnt, used:0)
21:23:07.010255 E1000#0: Interrupt attempts: 174893
21:23:07.010266 E1000#0: Interrupts raised : 52120
21:23:07.010273 E1000#0: Interrupts lowered: 8987
21:23:07.010279 E1000#0: ICR outside ISR   : 0
21:23:07.010286 E1000#0: IMS raised ints   : 13270
21:23:07.010292 E1000#0: Interrupts skipped: 71931
21:23:07.010298 E1000#0: Masked interrupts : 50842
21:23:07.010304 E1000#0: Early interrupts  : 0
21:23:07.010310 E1000#0: Late interrupts   : 3224
21:23:07.010316 E1000#0: Lost interrupts   : 0
21:23:07.010322 E1000#0: Interrupts by RX  : 129606
21:23:07.010329 E1000#0: Interrupts by TX  : 20911
21:23:07.010335 E1000#0: Interrupts by ICS : 241
21:23:07.010341 E1000#0: Interrupts by RDTR: 0
21:23:07.010347 E1000#0: Interrupts by RDMT: 0
21:23:07.010353 E1000#0: Interrupts by TXQE: 0
21:23:07.010360 E1000#0: TX int delay asked: 0
21:23:07.010366 E1000#0: TX delayed:         0
21:23:07.010372 E1000#0: TX delay expired:   0
21:23:07.010378 E1000#0: TX no report asked: 20860
21:23:07.010384 E1000#0: TX abs timer expd : 0
21:23:07.010390 E1000#0: TX int timer expd : 0
21:23:07.010397 E1000#0: RX abs timer expd : 0
21:23:07.010403 E1000#0: RX int timer expd : 0
21:23:07.010409 E1000#0: TX CTX descriptors: 20860
21:23:07.010415 E1000#0: TX DAT descriptors: 20860
21:23:07.010421 E1000#0: TX LEG descriptors: 51
21:23:07.010427 E1000#0: Received frames   : 129606
21:23:07.010434 E1000#0: Transmitted frames: 20911
21:23:07.010440 E1000#0: TX frames up to 1514: 20911
21:23:07.010446 E1000#0: TX frames up to 2962: 0
21:23:07.010452 E1000#0: TX frames up to 4410: 0
21:23:07.010463 E1000#0: TX frames up to 5858: 0
21:23:07.010472 E1000#0: TX frames up to 7306: 0
21:23:07.010478 E1000#0: TX frames up to 8754: 0
21:23:07.010484 E1000#0: TX frames up to 16384: 0
21:23:07.010490 E1000#0: TX frames up to 32768: 0
21:23:07.010496 E1000#0: Larger TX frames    : 0
21:23:07.010502 E1000#0: Max TX Delay        : 0
21:23:07.011206 GIM: KVM: Resetting MSRs
21:23:07.013575 Changing the VM state from 'DESTROYING' to 'TERMINATED'
21:23:07.014451 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: 20409 MByte
Operating system: Windows 10
Operating system version: 10.0.19044

2023-04-30 17:04:23 (17396): 
Command: VBoxManage -q showvminfo "boinc_77e2b5e7613d8fff" --machinereadable 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_77e2b5e7613d8fff'
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-04-30 17:04:23 (17396): 
Command: VBoxManage -q showhdinfo "C:\ProgramData\BOINC\slots\29/vm_image.vdi" 
Exit Code: -2135228412
Output:
VBoxManage.exe: error: Could not find file for the medium 'C:\ProgramData\BOINC\slots\29\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-04-30 17:04:24 (17396): 
Command: VBoxManage -q createvm --name "boinc_77e2b5e7613d8fff" --basefolder "C:\ProgramData\BOINC\slots\29" --ostype "Linux26_64" --register
Exit Code: 0
Output:
Virtual machine 'boinc_77e2b5e7613d8fff' is created and registered.
UUID: 78353db4-bfcf-4cdb-88b2-859d5f503b59
Settings file: 'C:\ProgramData\BOINC\slots\29\boinc_77e2b5e7613d8fff\boinc_77e2b5e7613d8fff.vbox'

2023-04-30 17:04:24 (17396): 
Command: VBoxManage -q modifyvm "boinc_77e2b5e7613d8fff" --description "rOPLDmMkND3n7Olcko1bjSoqABFKDmABFKDm7AsVDm5XIKDmjQGM0m_0" 
Exit Code: 0
Output:

2023-04-30 17:04:24 (17396): 
Command: VBoxManage -q modifyvm "boinc_77e2b5e7613d8fff" --memory 4800 
Exit Code: 0
Output:

2023-04-30 17:04:24 (17396): 
Command: VBoxManage -q modifyvm "boinc_77e2b5e7613d8fff" --cpus 8 
Exit Code: 0
Output:

2023-04-30 17:04:25 (17396): 
Command: VBoxManage -q modifyvm "boinc_77e2b5e7613d8fff" --acpi on --ioapic on --rtcuseutc off 
Exit Code: 0
Output:

2023-04-30 17:04:25 (17396): 
Command: VBoxManage -q modifyvm "boinc_77e2b5e7613d8fff" --vram 16 --graphicscontroller VBoxVGA 
Exit Code: 0
Output:

2023-04-30 17:04:25 (17396): 
Command: VBoxManage -q modifyvm "boinc_77e2b5e7613d8fff" --boot1 disk --boot2 dvd --boot3 none --boot4 none 
Exit Code: 0
Output:

2023-04-30 17:04:25 (17396): 
Command: VBoxManage -q modifyvm "boinc_77e2b5e7613d8fff" --nic1 nat --natdnsproxy1 on --cableconnected1 off 
Exit Code: 0
Output:

2023-04-30 17:04:26 (17396): 
Command: VBoxManage -q modifyvm "boinc_77e2b5e7613d8fff" --cableconnected1 on 
Exit Code: 0
Output:

2023-04-30 17:04:26 (17396): 
Command: VBoxManage -q modifyvm "boinc_77e2b5e7613d8fff" --usb off 
Exit Code: 0
Output:

2023-04-30 17:04:26 (17396): 
Command: VBoxManage -q modifyvm "boinc_77e2b5e7613d8fff" --uart1 off --uart2 off 
Exit Code: 0
Output:

2023-04-30 17:04:26 (17396): 
Command: VBoxManage -q modifyvm "boinc_77e2b5e7613d8fff" --lpt1 off --lpt2 off 
Exit Code: 0
Output:

2023-04-30 17:04:27 (17396): 
Command: VBoxManage -q modifyvm "boinc_77e2b5e7613d8fff" --audio none 
Exit Code: 0
Output:

2023-04-30 17:04:27 (17396): 
Command: VBoxManage -q modifyvm "boinc_77e2b5e7613d8fff" --clipboard disabled 
Exit Code: 0
Output:

2023-04-30 17:04:27 (17396): 
Command: VBoxManage -q modifyvm "boinc_77e2b5e7613d8fff" --draganddrop disabled 
Exit Code: 0
Output:

2023-04-30 17:04:27 (17396): 
Command: VBoxManage -q storagectl "boinc_77e2b5e7613d8fff" --name "Hard Disk Controller" --add "sata" --controller "IntelAHCI" --hostiocache off --portcount 3
Exit Code: 0
Output:

2023-04-30 17:04:28 (17396): 
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-04-30 17:04:28 (17396): 
Command: VBoxManage -q storageattach "boinc_77e2b5e7613d8fff" --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-04-30 17:04:28 (17396): 
Command: VBoxManage -q storageattach "boinc_77e2b5e7613d8fff" --storagectl "Hard Disk Controller" --port 1 --device 0 --type dvddrive --medium "C:\Program Files\Oracle\VirtualBox/VBoxGuestAdditions.iso" 
Exit Code: 0
Output:

2023-04-30 17:04:28 (17396): 
Command: VBoxManage -q bandwidthctl "boinc_77e2b5e7613d8fff" add "boinc_77e2b5e7613d8fff_net" --type network --limit 1024G 
Exit Code: 0
Output:

2023-04-30 17:04:29 (17396): 
Command: VBoxManage -q modifyvm "boinc_77e2b5e7613d8fff" --natpf1 ",tcp,127.0.0.1,52423,,80" 
Exit Code: 0
Output:

2023-04-30 17:04:29 (17396): 
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-04-30 17:04:29 (17396): 
Command: VBoxManage -q modifyvm "boinc_77e2b5e7613d8fff" --vrde on --vrdeextpack default --vrdeauthlibrary default --vrdeauthtype null --vrdeport 52424 
Exit Code: 0
Output:

2023-04-30 17:04:30 (17396): 
Command: VBoxManage -q sharedfolder add "boinc_77e2b5e7613d8fff" --name "shared" --hostpath "C:\ProgramData\BOINC\slots\29/shared"
Exit Code: 0
Output:

2023-04-30 17:04:33 (17396): 
Command: VBoxManage -q startvm "boinc_77e2b5e7613d8fff" --type headless
Exit Code: 0
Output:
Waiting for VM "boinc_77e2b5e7613d8fff" to power on...
VM "boinc_77e2b5e7613d8fff" has been successfully started.

2023-04-30 17:04:34 (17396): 
Command: VBoxManage -q controlvm "boinc_77e2b5e7613d8fff" cpuexecutioncap 100 
Exit Code: 0
Output:

2023-04-30 17:12:09 (17396): 
Command: VBoxManage -q controlvm "boinc_77e2b5e7613d8fff" pause
Exit Code: 0
Output:

2023-05-01 14:26:28 (17396): 
Command: VBoxManage -q controlvm "boinc_77e2b5e7613d8fff" resume
Exit Code: 0
Output:

2023-05-01 14:27:39 (17396): 
Command: VBoxManage -q controlvm "boinc_77e2b5e7613d8fff" poweroff
Exit Code: 0
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...100%

2023-05-01 14:27:39 (17396): 
Command: VBoxManage -q snapshot "boinc_77e2b5e7613d8fff" list 
Exit Code: -108
Output:
This machine does not have any snapshots

2023-05-01 14:27:39 (17396): 
Command: VBoxManage -q bandwidthctl "boinc_77e2b5e7613d8fff" remove "boinc_77e2b5e7613d8fff_net" 
Exit Code: 0
Output:

2023-05-01 14:27:39 (17396): 
Command: VBoxManage -q unregistervm "boinc_77e2b5e7613d8fff" --delete 
Exit Code: 0
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...100%

14:27:50 (17396): called boinc_finish(194)

</stderr_txt>
]]>


©2024 CERN