Stderr output

<core_client_version>7.16.20</core_client_version>
<![CDATA[
<message>
aborted by project - no longer usable</message>
<stderr_txt>
2023-05-03 17:28:37 (25996): Detected: vboxwrapper 26206
2023-05-03 17:28:37 (25996): Detected: BOINC client v7.16.20
2023-05-03 17:28:37 (25996): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2023-05-03 17:28:37 (25996): Successfully copied 'init_data.xml' to the shared directory.
2023-05-03 17:28:38 (25996): Create VM. (boinc_fb1cbe0a785cf29c, slot#0)
2023-05-03 17:28:39 (25996): Setting Memory Size for VM. (4800MB)
2023-05-03 17:28:39 (25996): Setting CPU Count for VM. (8)
2023-05-03 17:28:39 (25996): Setting Chipset Options for VM.
2023-05-03 17:28:39 (25996): Setting Graphics Controller Options for VM.
2023-05-03 17:28:40 (25996): Setting Boot Options for VM.
2023-05-03 17:28:40 (25996): Setting Network Configuration for NAT.
2023-05-03 17:28:40 (25996): Enabling VM Network Access.
2023-05-03 17:28:40 (25996): Disabling USB Support for VM.
2023-05-03 17:28:41 (25996): Disabling COM Port Support for VM.
2023-05-03 17:28:41 (25996): Disabling LPT Port Support for VM.
2023-05-03 17:28:41 (25996): Disabling Audio Support for VM.
2023-05-03 17:28:41 (25996): Disabling Clipboard Support for VM.
2023-05-03 17:28:42 (25996): Disabling Drag and Drop Support for VM.
2023-05-03 17:28:42 (25996): Adding storage controller(s) to VM.
2023-05-03 17:28:42 (25996): Adding virtual disk drive to VM. (ATLAS_vbox_3.01_image.vdi)
2023-05-03 17:28:43 (25996): Adding VirtualBox Guest Additions to VM.
2023-05-03 17:28:43 (25996): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2023-05-03 17:28:43 (25996): forwarding host port 57815 to guest port 80
2023-05-03 17:28:43 (25996): Enabling remote desktop for VM.
2023-05-03 17:28:44 (25996): Enabling shared directory for VM.
2023-05-03 17:28:44 (25996): Starting VM using VBoxManage interface. (boinc_fb1cbe0a785cf29c, slot#0)
2023-05-03 17:28:48 (25996): Successfully started VM. (PID = '19876')
2023-05-03 17:28:48 (25996): Reporting VM Process ID to BOINC.
2023-05-03 17:28:48 (25996): Guest Log: BIOS: VirtualBox 6.0.14
2023-05-03 17:28:48 (25996): Guest Log: CPUID EDX: 0x178bfbff
2023-05-03 17:28:48 (25996): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-05-03 17:28:48 (25996): VM state change detected. (old = 'poweredoff', new = 'running')
2023-05-03 17:28:48 (25996): Detected: Web Application Enabled (http://localhost:57815)
2023-05-03 17:28:48 (25996): Detected: Remote Desktop Enabled (localhost:57816)
2023-05-03 17:28:48 (25996): Preference change detected
2023-05-03 17:28:48 (25996): Setting CPU throttle for VM. (100%)
2023-05-03 17:28:49 (25996): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 900 seconds))
2023-05-03 17:28:50 (25996): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-05-03 17:28:50 (25996): Guest Log: BIOS: Booting from Hard Disk...
2023-05-03 17:28:53 (25996): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-05-03 17:28:53 (25996): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2023-05-03 17:28:53 (25996): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2023-05-03 17:28:59 (25996): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-05-03 17:28:59 (25996): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-05-03 17:29:05 (25996): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2023-05-03 17:29:05 (25996): Guest Log: 00:00:00.000124 main     Log opened 2023-05-03T17:29:03.949224000Z
2023-05-03 17:29:05 (25996): Guest Log: 00:00:00.000223 main     OS Product: Linux
2023-05-03 17:29:05 (25996): Guest Log: 00:00:00.000247 main     OS Release: 3.10.0-957.27.2.el7.x86_64
2023-05-03 17:29:05 (25996): Guest Log: 00:00:00.000267 main     OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2023-05-03 17:29:05 (25996): Guest Log: 00:00:00.000286 main     Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2023-05-03 17:29:05 (25996): Guest Log: 00:00:00.000287 main     Process ID: 1388
2023-05-03 17:29:05 (25996): Guest Log: 00:00:00.000287 main     Package type: LINUX_64BITS_GENERIC
2023-05-03 17:29:05 (25996): Guest Log: 00:00:00.000956 main     5.2.32 r132073 started. Verbose level = 0
2023-05-03 17:29:05 (25996): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch...
2023-05-03 17:29:05 (25996): Guest Log: [INFO] Mounting shared directory
2023-05-03 17:29:05 (25996): Guest Log: [INFO] Checking for init_data.xml
2023-05-03 17:29:07 (25996): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK
2023-05-03 17:29:07 (25996): Guest Log: [INFO] Detected branch: dev
2023-05-03 17:29:08 (25996): Guest Log: This is the dev version of the ATLAS job wrapper
2023-05-03 17:29:08 (25996): Guest Log: Copying input files
2023-05-03 17:29:08 (25996): Guest Log: Copied input files into RunAtlas.
2023-05-03 17:29:08 (25996): Guest Log: This VM did not configure a local http proxy via BOINC.
2023-05-03 17:29:08 (25996): Guest Log: Small home clusters do not require a local http proxy but it is suggested if
2023-05-03 17:29:08 (25996): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
2023-05-03 17:29:08 (25996): Guest Log: Further information can be found at the LHC@home message board.
2023-05-03 17:29:15 (25996): Guest Log: 00:00:10.003223 timesync vgsvcTimeSyncWorker: Radical guest time change: -7 188 461 903 000ns (GuestNow=1 683 127 755 489 675 000 ns GuestLast=1 683 134 943 951 578 000 ns fSetTimeLastLoop=true )
2023-05-03 17:29:17 (25996): Guest Log: Running cvmfs_config stat atlas.cern.ch
2023-05-03 17:29:18 (25996): 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-03 17:29:18 (25996): Guest Log: 2.6.3.0 1667 0 30188 118572 4 1 3116374 4096000 0 65024 0 0 n/a 1 1 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1
2023-05-03 17:29:19 (25996): Guest Log: copied the webapp to /var/www
2023-05-03 17:29:19 (25996): Guest Log: ATHENA_PROC_NUMBER=8
2023-05-03 17:29:19 (25996): Guest Log: ATHENA_CORE_NUMBER=8
2023-05-03 17:29:19 (25996): 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-03 17:29:19 (25996): Guest Log:  *** Starting ATLAS job. (PandaID=5838039397 taskID=NULL&cor) ***
2023-05-03 17:40:08 (25996): VM state change detected. (old = 'running', new = 'paused')
2023-05-04 09:34:54 (25996): VM state change detected. (old = 'paused', new = 'running')
2023-05-04 09:35:00 (25996): Guest Log: 00:11:08.445388 timesync vgsvcTimeSyncWorker: Radical host time change: 57 288 121 000 000ns (HostNow=1 683 185 666 164 000 000 ns HostLast=1 683 128 378 043 000 000 ns)
2023-05-04 09:35:10 (25996): Guest Log: 00:11:18.461753 timesync vgsvcTimeSyncWorker: Radical guest time change: 57 262 248 668 000ns (GuestNow=1 683 185 676 180 303 000 ns GuestLast=1 683 128 413 931 635 000 ns fSetTimeLastLoop=true )
2023-05-04 09:40:50 (25996): Powering off VM.
2023-05-04 09:40:51 (25996): Successfully stopped VM.
2023-05-04 09:40:51 (25996): Deregistering VM. (boinc_fb1cbe0a785cf29c, slot#0)
2023-05-04 09:40:51 (25996): Removing network bandwidth throttle group from VM.
2023-05-04 09:40:52 (25996): Removing VM from VirtualBox.

    Hypervisor System Log:

146:10:31.249910 USBPROXY Getting USB descriptor (id 0) failed with error 31
146:10:32.008908 USBPROXY Getting USB descriptor (id 0) failed with error 31
146:11:25.215490          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
146:11:25.215560          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
146:11:25.292958          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
146:11:25.344936          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
146:11:25.605847          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
146:11:25.945302          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
146:11:40.041998 MainPower Host suspending: Paused 6 VMs
146:11:40.759244 USBPROXY Getting USB descriptor (id 0) failed with error 31
161:54:38.233141 MainPower Host resumed: Resumed 6 VMs
161:54:39.949477 dns-monitor HostDnsMonitor::updateInfo
161:54:40.232298 dns-monitor HostDnsMonitor: old information
161:54:40.232325 dns-monitor   server 1: 192.168.1.1
161:54:40.232331 dns-monitor   domain: home
161:54:40.232336 dns-monitor   no search string entries
161:54:40.232341 dns-monitor HostDnsMonitor: new information
161:54:40.232346 dns-monitor   no server entries
161:54:40.232351 dns-monitor   no domain set
161:54:40.232356 dns-monitor   no search string entries
161:54:40.488181 USBPROXY Getting USB descriptor (id 0) failed with error 31
161:54:44.754245 dns-monitor HostDnsMonitor::updateInfo
161:54:44.754268 dns-monitor HostDnsMonitor: old information
161:54:44.754274 dns-monitor   no server entries
161:54:44.754280 dns-monitor   no domain set
161:54:44.754285 dns-monitor   no search string entries
161:54:44.754290 dns-monitor HostDnsMonitor: new information
161:54:44.754295 dns-monitor   server 1: 192.168.1.1
161:54:44.754300 dns-monitor   domain: home
161:54:44.754304 dns-monitor   no search string entries
161:54:49.737149 USBPROXY Getting USB descriptor (id 0) failed with error 31
161:55:35.486901 USBPROXY Getting USB descriptor (id 0) failed with error 31
162:05:48.823991 USBPROXY Getting USB descriptor (id 0) failed with error 31
162:06:11.418612          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
162:06:11.507621          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
162:06:11.838953          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
162:06:12.357494          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
162:06:12.357554          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
162:06:12.397630          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
162:08:16.981677 USBPROXY Getting USB descriptor (id 0) failed with error 31
162:10:19.631774          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
162:10:19.735711          Saving settings file "C:\ProgramData\BOINC\slots\29\boinc_596715e23373e51d\boinc_596715e23373e51d.vbox" with version "1.16-windows"
162:10:20.145711          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
162:10:20.148322          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
162:10:20.198532          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
162:10:20.200414          Saving settings file "C:\ProgramData\BOINC\slots\29\boinc_596715e23373e51d\boinc_596715e23373e51d.vbox" with version "1.16-windows"
162:10:20.463227          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
162:10:20.464722          Saving settings file "C:\Users\123\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
162:10:20.467898          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
162:10:20.468047          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_fb1cbe0a785cf29c\boinc_fb1cbe0a785cf29c.vbox" with version "1.16-windows"
162:10:20.471846 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
162:10:20.472093 DeleteVM Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_fb1cbe0a785cf29c\boinc_fb1cbe0a785cf29c.vbox" with version "1.16-windows"
162:12:08.877252          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
162:12:08.941417          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_fb1cbe0a785cf29c\boinc_fb1cbe0a785cf29c.vbox" with version "1.16-windows"
162:12:09.906184          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
162:12:09.908757          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
162:12:09.982383          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
162:12:09.985607          Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_fb1cbe0a785cf29c\boinc_fb1cbe0a785cf29c.vbox" with version "1.16-windows"
162:12:10.249690          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
162:12:10.250191          Saving settings file "C:\Users\123\.VirtualBox\VirtualBox.xml" with version "1.12-windows"

    VM Execution Log:

/TM/CPU/00/cPeriodsExecuting      4748661 count
16:12:04.020151 /TM/CPU/00/cPeriodsHalted          484816 count
16:12:04.020158 /TM/CPU/00/pctExecuting                 0 %
16:12:04.020164 /TM/CPU/00/pctHalted                   99 %
16:12:04.020171 /TM/CPU/00/pctOther                     0 %
16:12:04.020177 /TM/CPU/01/cNsExecuting          27730105840 ns
16:12:04.020184 /TM/CPU/01/cNsHalted             1000406861140 ns
16:12:04.020191 /TM/CPU/01/cNsOther              9038501671 ns
16:12:04.020198 /TM/CPU/01/cNsTotal              1037175468651 ns
16:12:04.020204 /TM/CPU/01/cPeriodsExecuting      1632416 count
16:12:04.020211 /TM/CPU/01/cPeriodsHalted          364984 count
16:12:04.020217 /TM/CPU/01/pctExecuting                 0 %
16:12:04.020223 /TM/CPU/01/pctHalted                   99 %
16:12:04.020230 /TM/CPU/01/pctOther                     0 %
16:12:04.020236 /TM/CPU/02/cNsExecuting          12045386483 ns
16:12:04.020242 /TM/CPU/02/cNsHalted             1017329604975 ns
16:12:04.020249 /TM/CPU/02/cNsOther              7800449589 ns
16:12:04.020256 /TM/CPU/02/cNsTotal              1037175441047 ns
16:12:04.020263 /TM/CPU/02/cPeriodsExecuting      1526143 count
16:12:04.020269 /TM/CPU/02/cPeriodsHalted          350408 count
16:12:04.020275 /TM/CPU/02/pctExecuting                 0 %
16:12:04.020281 /TM/CPU/02/pctHalted                   99 %
16:12:04.020288 /TM/CPU/02/pctOther                     0 %
16:12:04.020294 /TM/CPU/03/cNsExecuting          11139815282 ns
16:12:04.020300 /TM/CPU/03/cNsHalted             1018508523560 ns
16:12:04.020307 /TM/CPU/03/cNsOther              7527151329 ns
16:12:04.020313 /TM/CPU/03/cNsTotal              1037175490171 ns
16:12:04.020319 /TM/CPU/03/cPeriodsExecuting      1307119 count
16:12:04.020326 /TM/CPU/03/cPeriodsHalted          300174 count
16:12:04.020332 /TM/CPU/03/pctExecuting                 0 %
16:12:04.020339 /TM/CPU/03/pctHalted                   99 %
16:12:04.020346 /TM/CPU/03/pctOther                     0 %
16:12:04.020352 /TM/CPU/04/cNsExecuting          27272114539 ns
16:12:04.020359 /TM/CPU/04/cNsHalted             1002198075338 ns
16:12:04.020366 /TM/CPU/04/cNsOther              7705323395 ns
16:12:04.020372 /TM/CPU/04/cNsTotal              1037175513272 ns
16:12:04.020378 /TM/CPU/04/cPeriodsExecuting      1350049 count
16:12:04.020385 /TM/CPU/04/cPeriodsHalted          318779 count
16:12:04.020391 /TM/CPU/04/pctExecuting                 0 %
16:12:04.020455 /TM/CPU/04/pctHalted                   99 %
16:12:04.020465 /TM/CPU/04/pctOther                     0 %
16:12:04.020472 /TM/CPU/05/cNsExecuting          57213220684 ns
16:12:04.020480 /TM/CPU/05/cNsHalted             971858872406 ns
16:12:04.020487 /TM/CPU/05/cNsOther              8103422634 ns
16:12:04.020494 /TM/CPU/05/cNsTotal              1037175515724 ns
16:12:04.020501 /TM/CPU/05/cPeriodsExecuting      1203368 count
16:12:04.020508 /TM/CPU/05/cPeriodsHalted          273819 count
16:12:04.020516 /TM/CPU/05/pctExecuting                 0 %
16:12:04.020523 /TM/CPU/05/pctHalted                   99 %
16:12:04.020530 /TM/CPU/05/pctOther                     0 %
16:12:04.020538 /TM/CPU/06/cNsExecuting          130437672120 ns
16:12:04.020545 /TM/CPU/06/cNsHalted             897063423123 ns
16:12:04.020552 /TM/CPU/06/cNsOther              9674392418 ns
16:12:04.020559 /TM/CPU/06/cNsTotal              1037175487661 ns
16:12:04.020566 /TM/CPU/06/cPeriodsExecuting      1419203 count
16:12:04.020572 /TM/CPU/06/cPeriodsHalted          298796 count
16:12:04.020579 /TM/CPU/06/pctExecuting                 0 %
16:12:04.020586 /TM/CPU/06/pctHalted                   99 %
16:12:04.020594 /TM/CPU/06/pctOther                     0 %
16:12:04.020601 /TM/CPU/07/cNsExecuting          70181752370 ns
16:12:04.020608 /TM/CPU/07/cNsHalted             954065311275 ns
16:12:04.020616 /TM/CPU/07/cNsOther              12928473560 ns
16:12:04.020623 /TM/CPU/07/cNsTotal              1037175537205 ns
16:12:04.020630 /TM/CPU/07/cPeriodsExecuting      2083900 count
16:12:04.020637 /TM/CPU/07/cPeriodsHalted          378910 count
16:12:04.020644 /TM/CPU/07/pctExecuting                 0 %
16:12:04.020651 /TM/CPU/07/pctHalted                   99 %
16:12:04.020657 /TM/CPU/07/pctOther                     0 %
16:12:04.020664 /TM/CPU/pctExecuting                    0 %
16:12:04.020671 /TM/CPU/pctHalted                      99 %
16:12:04.020678 /TM/CPU/pctOther                        0 %
16:12:04.020686 /TM/MaxHzHint                           0 Hz
16:12:04.020693 /TM/R0/1nsSteps                       897 times
16:12:04.020701 /TM/R3/1nsSteps                      5396 times
16:12:04.020708 /TM/TSC/offCPU0                  800286300723081 ticks
16:12:04.020716 /TM/TSC/offCPU1                  800286300723081 ticks
16:12:04.020723 /TM/TSC/offCPU2                  800286300723081 ticks
16:12:04.020730 /TM/TSC/offCPU3                  800286300723081 ticks
16:12:04.020737 /TM/TSC/offCPU4                  800286300723081 ticks
16:12:04.020745 /TM/TSC/offCPU5                  800286300723081 ticks
16:12:04.020752 /TM/TSC/offCPU6                  800286300723081 ticks
16:12:04.020759 /TM/TSC/offCPU7                  800286300723081 ticks
16:12:04.020766 /TM/VirtualSync/CurrentOffset    176289745679 ns
16:12:04.020774 /TM/VirtualSync/GivenUp          120030524436 ns
16:12:04.020782 ********************* End of statistics **********************
16:12:04.026100 NAT: Zone(nm:mbuf_cluster, used:0)
16:12:04.026391 NAT: Zone(nm:mbuf_packet, used:0)
16:12:04.026402 NAT: Zone(nm:mbuf, used:1)
16:12:04.026712 NAT: Zone(nm:mbuf_jumbo_pagesize, used:0)
16:12:04.026990 NAT: Zone(nm:mbuf_jumbo_9k, used:0)
16:12:04.027405 NAT: Zone(nm:mbuf_jumbo_16k, used:0)
16:12:04.027638 NAT: Zone(nm:mbuf_ext_refcnt, used:0)
16:12:04.027833 E1000#0: Interrupt attempts: 185059
16:12:04.027845 E1000#0: Interrupts raised : 49777
16:12:04.027856 E1000#0: Interrupts lowered: 8093
16:12:04.027862 E1000#0: ICR outside ISR   : 0
16:12:04.027869 E1000#0: IMS raised ints   : 17404
16:12:04.027875 E1000#0: Interrupts skipped: 60230
16:12:04.027882 E1000#0: Masked interrupts : 75052
16:12:04.027889 E1000#0: Early interrupts  : 0
16:12:04.027895 E1000#0: Late interrupts   : 4595
16:12:04.027901 E1000#0: Lost interrupts   : 0
16:12:04.027907 E1000#0: Interrupts by RX  : 137167
16:12:04.027913 E1000#0: Interrupts by TX  : 21408
16:12:04.027919 E1000#0: Interrupts by ICS : 488
16:12:04.027926 E1000#0: Interrupts by RDTR: 0
16:12:04.027932 E1000#0: Interrupts by RDMT: 0
16:12:04.028031 E1000#0: Interrupts by TXQE: 0
16:12:04.028044 E1000#0: TX int delay asked: 0
16:12:04.028052 E1000#0: TX delayed:         0
16:12:04.028058 E1000#0: TX delay expired:   0
16:12:04.028065 E1000#0: TX no report asked: 21277
16:12:04.028072 E1000#0: TX abs timer expd : 0
16:12:04.028078 E1000#0: TX int timer expd : 0
16:12:04.028085 E1000#0: RX abs timer expd : 0
16:12:04.028091 E1000#0: RX int timer expd : 0
16:12:04.028098 E1000#0: TX CTX descriptors: 21271
16:12:04.028104 E1000#0: TX DAT descriptors: 21277
16:12:04.028110 E1000#0: TX LEG descriptors: 137
16:12:04.028117 E1000#0: Received frames   : 137167
16:12:04.028124 E1000#0: Transmitted frames: 21408
16:12:04.028130 E1000#0: TX frames up to 1514: 21406
16:12:04.028137 E1000#0: TX frames up to 2962: 2
16:12:04.028143 E1000#0: TX frames up to 4410: 0
16:12:04.028150 E1000#0: TX frames up to 5858: 0
16:12:04.028156 E1000#0: TX frames up to 7306: 0
16:12:04.028163 E1000#0: TX frames up to 8754: 0
16:12:04.028169 E1000#0: TX frames up to 16384: 0
16:12:04.028175 E1000#0: TX frames up to 32768: 0
16:12:04.028182 E1000#0: Larger TX frames    : 0
16:12:04.028188 E1000#0: Max TX Delay        : 0
16:12:04.029127 GIM: KVM: Resetting MSRs
16:12:04.033077 Changing the VM state from 'DESTROYING' to 'TERMINATED'
16:12:04.034596 Console: Machine state changed to 'PoweredOff'
16:12:04.262240 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={872da645-4a9b-1727-bee2-5585105b9eed} aComponent={ConsoleWrap} aText={The object is not ready}, preserve=false aResultDetail=0

    VM Startup Log:


    VM Trace Log:

#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: 18372 MByte
Operating system: Windows 10
Operating system version: 10.0.19044

2023-05-03 17:28:38 (25996): 
Command: VBoxManage -q showvminfo "boinc_fb1cbe0a785cf29c" --machinereadable 
Exit Code: -2135228415
Output:
VBoxManage.exe: error: Could not find a registered machine named 'boinc_fb1cbe0a785cf29c'
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-03 17:28:38 (25996): 
Command: VBoxManage -q showhdinfo "C:\ProgramData\BOINC\slots\0/vm_image.vdi" 
Exit Code: -2135228412
Output:
VBoxManage.exe: error: Could not find file for the medium 'C:\ProgramData\BOINC\slots\0\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-03 17:28:38 (25996): 
Command: VBoxManage -q createvm --name "boinc_fb1cbe0a785cf29c" --basefolder "C:\ProgramData\BOINC\slots\0" --ostype "Linux26_64" --register
Exit Code: 0
Output:
Virtual machine 'boinc_fb1cbe0a785cf29c' is created and registered.
UUID: b441b111-49f1-4f63-9bcf-c2163117484b
Settings file: 'C:\ProgramData\BOINC\slots\0\boinc_fb1cbe0a785cf29c\boinc_fb1cbe0a785cf29c.vbox'

2023-05-03 17:28:39 (25996): 
Command: VBoxManage -q modifyvm "boinc_fb1cbe0a785cf29c" --description "o28KDmXUTE3n7Olcko1bjSoqABFKDmABFKDm7AsVDmynIKDmjUrlXm_0" 
Exit Code: 0
Output:

2023-05-03 17:28:39 (25996): 
Command: VBoxManage -q modifyvm "boinc_fb1cbe0a785cf29c" --memory 4800 
Exit Code: 0
Output:

2023-05-03 17:28:39 (25996): 
Command: VBoxManage -q modifyvm "boinc_fb1cbe0a785cf29c" --cpus 8 
Exit Code: 0
Output:

2023-05-03 17:28:39 (25996): 
Command: VBoxManage -q modifyvm "boinc_fb1cbe0a785cf29c" --acpi on --ioapic on --rtcuseutc off 
Exit Code: 0
Output:

2023-05-03 17:28:40 (25996): 
Command: VBoxManage -q modifyvm "boinc_fb1cbe0a785cf29c" --vram 16 --graphicscontroller VBoxVGA 
Exit Code: 0
Output:

2023-05-03 17:28:40 (25996): 
Command: VBoxManage -q modifyvm "boinc_fb1cbe0a785cf29c" --boot1 disk --boot2 dvd --boot3 none --boot4 none 
Exit Code: 0
Output:

2023-05-03 17:28:40 (25996): 
Command: VBoxManage -q modifyvm "boinc_fb1cbe0a785cf29c" --nic1 nat --natdnsproxy1 on --cableconnected1 off 
Exit Code: 0
Output:

2023-05-03 17:28:40 (25996): 
Command: VBoxManage -q modifyvm "boinc_fb1cbe0a785cf29c" --cableconnected1 on 
Exit Code: 0
Output:

2023-05-03 17:28:41 (25996): 
Command: VBoxManage -q modifyvm "boinc_fb1cbe0a785cf29c" --usb off 
Exit Code: 0
Output:

2023-05-03 17:28:41 (25996): 
Command: VBoxManage -q modifyvm "boinc_fb1cbe0a785cf29c" --uart1 off --uart2 off 
Exit Code: 0
Output:

2023-05-03 17:28:41 (25996): 
Command: VBoxManage -q modifyvm "boinc_fb1cbe0a785cf29c" --lpt1 off --lpt2 off 
Exit Code: 0
Output:

2023-05-03 17:28:41 (25996): 
Command: VBoxManage -q modifyvm "boinc_fb1cbe0a785cf29c" --audio none 
Exit Code: 0
Output:

2023-05-03 17:28:42 (25996): 
Command: VBoxManage -q modifyvm "boinc_fb1cbe0a785cf29c" --clipboard disabled 
Exit Code: 0
Output:

2023-05-03 17:28:42 (25996): 
Command: VBoxManage -q modifyvm "boinc_fb1cbe0a785cf29c" --draganddrop disabled 
Exit Code: 0
Output:

2023-05-03 17:28:42 (25996): 
Command: VBoxManage -q storagectl "boinc_fb1cbe0a785cf29c" --name "Hard Disk Controller" --add "sata" --controller "IntelAHCI" --hostiocache off --portcount 3
Exit Code: 0
Output:

2023-05-03 17:28:42 (25996): 
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:          locked read
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
Child UUIDs:    b6cc63d3-b28f-4b58-9d2c-9419c8dc903a

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

2023-05-03 17:28:43 (25996): 
Command: VBoxManage -q bandwidthctl "boinc_fb1cbe0a785cf29c" add "boinc_fb1cbe0a785cf29c_net" --type network --limit 1024G 
Exit Code: 0
Output:

2023-05-03 17:28:43 (25996): 
Command: VBoxManage -q modifyvm "boinc_fb1cbe0a785cf29c" --natpf1 ",tcp,127.0.0.1,57815,,80" 
Exit Code: 0
Output:

2023-05-03 17:28:44 (25996): 
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-03 17:28:44 (25996): 
Command: VBoxManage -q modifyvm "boinc_fb1cbe0a785cf29c" --vrde on --vrdeextpack default --vrdeauthlibrary default --vrdeauthtype null --vrdeport 57816 
Exit Code: 0
Output:

2023-05-03 17:28:44 (25996): 
Command: VBoxManage -q sharedfolder add "boinc_fb1cbe0a785cf29c" --name "shared" --hostpath "C:\ProgramData\BOINC\slots\0/shared"
Exit Code: 0
Output:

2023-05-03 17:28:47 (25996): 
Command: VBoxManage -q startvm "boinc_fb1cbe0a785cf29c" --type headless
Exit Code: 0
Output:
Waiting for VM "boinc_fb1cbe0a785cf29c" to power on...
VM "boinc_fb1cbe0a785cf29c" has been successfully started.

2023-05-03 17:28:49 (25996): 
Command: VBoxManage -q controlvm "boinc_fb1cbe0a785cf29c" cpuexecutioncap 100 
Exit Code: 0
Output:

2023-05-03 17:40:07 (25996): 
Command: VBoxManage -q controlvm "boinc_fb1cbe0a785cf29c" pause
Exit Code: 0
Output:

2023-05-04 09:34:53 (25996): 
Command: VBoxManage -q controlvm "boinc_fb1cbe0a785cf29c" resume
Exit Code: 0
Output:

2023-05-04 09:40:51 (25996): 
Command: VBoxManage -q controlvm "boinc_fb1cbe0a785cf29c" poweroff
Exit Code: 0
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...100%

2023-05-04 09:40:51 (25996): 
Command: VBoxManage -q snapshot "boinc_fb1cbe0a785cf29c" list 
Exit Code: -108
Output:
This machine does not have any snapshots

2023-05-04 09:40:52 (25996): 
Command: VBoxManage -q bandwidthctl "boinc_fb1cbe0a785cf29c" remove "boinc_fb1cbe0a785cf29c_net" 
Exit Code: 0
Output:

2023-05-04 09:40:52 (25996): 
Command: VBoxManage -q unregistervm "boinc_fb1cbe0a785cf29c" --delete 
Exit Code: 0
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...100%

09:41:02 (25996): called boinc_finish(194)

</stderr_txt>
]]>

©2024 CERN