Name CEuLDmqmCy7n9Rq4apOajLDm4fhM0noT9bVof3QYDmCOtKDmNEuWPo_0
Workunit 233717011
Created 21 Jul 2025, 20:59:59 UTC
Sent 21 Jul 2025, 21:49:47 UTC
Report deadline 29 Jul 2025, 21:49:47 UTC
Received 23 Jul 2025, 22:18:54 UTC
Server state Over
Outcome Computation error
Client state Compute error
Exit status 194 (0x000000C2) EXIT_ABORTED_BY_CLIENT
Computer ID 10681008
Run time 15 min 46 sec
CPU time 5 hours 15 min 23 sec
Validate state Invalid
Credit 0.00
Device peak FLOPS 36.13 GFLOPS
Application version ATLAS Simulation v3.01 (vbox64_mt_mcore_atlas)
windows_x86_64
Peak working set size 92.25 MB
Peak swap size 95.76 MB
Peak disk usage 1.90 GB

Stderr output

<core_client_version>8.0.2</core_client_version>
<![CDATA[
<message>
Process still present 5 min after writing finish file; aborting</message>
<stderr_txt>
2025-07-21 19:18:17 (14808): Detected: vboxwrapper 26206
2025-07-21 19:18:17 (14808): Detected: BOINC client v8.0.2
2025-07-21 19:18:17 (14808): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-07-21 19:18:18 (14808): Successfully copied 'init_data.xml' to the shared directory.
2025-07-21 19:18:18 (14808): Create VM. (boinc_7020698016f608eb, slot#1)
2025-07-21 19:18:19 (14808): Setting Memory Size for VM. (4800MB)
2025-07-21 19:18:19 (14808): Setting CPU Count for VM. (8)
2025-07-21 19:18:19 (14808): Setting Chipset Options for VM.
2025-07-21 19:18:19 (14808): Setting Graphics Controller Options for VM.
2025-07-21 19:18:20 (14808): Setting Boot Options for VM.
2025-07-21 19:18:20 (14808): Setting Network Configuration for NAT.
2025-07-21 19:18:20 (14808): Enabling VM Network Access.
2025-07-21 19:18:20 (14808): Disabling USB Support for VM.
2025-07-21 19:18:21 (14808): Disabling COM Port Support for VM.
2025-07-21 19:18:21 (14808): Disabling LPT Port Support for VM.
2025-07-21 19:18:21 (14808): Disabling Audio Support for VM.
2025-07-21 19:18:21 (14808): Disabling Clipboard Support for VM.
2025-07-21 19:18:22 (14808): Disabling Drag and Drop Support for VM.
2025-07-21 19:18:22 (14808): Adding storage controller(s) to VM.
2025-07-21 19:18:22 (14808): Adding virtual disk drive to VM. (ATLAS_vbox_3.01_image.vdi)
2025-07-21 19:18:25 (14808): Adding VirtualBox Guest Additions to VM.
2025-07-21 19:18:25 (14808): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2025-07-21 19:18:26 (14808): forwarding host port 53083 to guest port 80
2025-07-21 19:18:26 (14808): Enabling remote desktop for VM.
2025-07-21 19:18:26 (14808): Required extension pack not installed, remote desktop not enabled.
2025-07-21 19:18:26 (14808): Enabling shared directory for VM.
2025-07-21 19:18:27 (14808): Starting VM using VBoxManage interface. (boinc_7020698016f608eb, slot#1)
2025-07-21 19:18:33 (14808): Successfully started VM. (PID = '18376')
2025-07-21 19:18:33 (14808): Reporting VM Process ID to BOINC.
2025-07-21 19:18:33 (14808): Guest Log: BIOS: VirtualBox 7.0.6
2025-07-21 19:18:33 (14808): Guest Log: CPUID EDX: 0x178bfbff
2025-07-21 19:18:33 (14808): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-07-21 19:18:33 (14808): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-07-21 19:18:33 (14808): VM state change detected. (old = 'poweredoff', new = 'running')
2025-07-21 19:18:33 (14808): Detected: Web Application Enabled (http://localhost:53083)
2025-07-21 19:18:34 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:18:41 (14808): Preference change detected
2025-07-21 19:18:41 (14808): Setting CPU throttle for VM. (50%)
2025-07-21 19:18:41 (14808): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-07-21 19:18:42 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:18:43 (14808): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-07-21 19:18:43 (14808): Guest Log: BIOS: Booting from Hard Disk...
2025-07-21 19:18:46 (14808): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-07-21 19:18:46 (14808): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2025-07-21 19:18:46 (14808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2025-07-21 19:18:54 (14808): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-07-21 19:18:54 (14808): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-07-21 19:18:59 (14808): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2025-07-21 19:18:59 (14808): Guest Log: 00:00:00.000073 main     Log opened 2025-07-21T19:18:49.455079000Z
2025-07-21 19:18:59 (14808): Guest Log: 00:00:00.000143 main     OS Product: Linux
2025-07-21 19:18:59 (14808): Guest Log: 00:00:00.000176 main     OS Release: 3.10.0-957.27.2.el7.x86_64
2025-07-21 19:18:59 (14808): Guest Log: 00:00:00.000199 main     OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2025-07-21 19:18:59 (14808): Guest Log: 00:00:00.000220 main     Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2025-07-21 19:18:59 (14808): Guest Log: 00:00:00.000221 main     Process ID: 1368
2025-07-21 19:18:59 (14808): Guest Log: 00:00:00.000221 main     Package type: LINUX_64BITS_GENERIC
2025-07-21 19:18:59 (14808): Guest Log: 00:00:00.000726 main     5.2.32 r132073 started. Verbose level = 0
2025-07-21 19:18:59 (14808): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch...
2025-07-21 19:18:59 (14808): Guest Log: [INFO] Mounting shared directory
2025-07-21 19:18:59 (14808): Guest Log: [INFO] Checking for init_data.xml
2025-07-21 19:19:05 (14808): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK
2025-07-21 19:19:05 (14808): Guest Log: [INFO] Detected branch: prod
2025-07-21 19:19:05 (14808): Guest Log: This is the prod version of the ATLAS job wrapper
2025-07-21 19:19:05 (14808): Guest Log: Copying input files
2025-07-21 19:19:07 (14808): Guest Log: Copied input files into RunAtlas.
2025-07-21 19:19:07 (14808): Guest Log: This VM did not configure a local http proxy via BOINC.
2025-07-21 19:19:07 (14808): Guest Log: Small home clusters do not require a local http proxy but it is suggested if
2025-07-21 19:19:07 (14808): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
2025-07-21 19:19:07 (14808): Guest Log: Further information can be found at the LHC@home message board.
2025-07-21 19:19:09 (14808): Guest Log: 00:00:10.003291 timesync vgsvcTimeSyncWorker: Radical guest time change: 18 019 127 522 000ns (GuestNow=1 753 143 548 584 385 000 ns GuestLast=1 753 125 529 456 863 000 ns fSetTimeLastLoop=true )
2025-07-21 19:19:15 (14808): Guest Log: Running cvmfs_config stat atlas.cern.ch
2025-07-21 19:19:15 (14808): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2025-07-21 19:19:15 (14808): Guest Log: 2.6.3.0 1650 0 30168 148602 4 1 3117619 4096000 0 65024 0 0 n/a 0 0 http://s1fnal-cvmfs.openhtc.io:8080/cvmfs/atlas.cern.ch DIRECT 1
2025-07-21 19:19:15 (14808): Guest Log: copied the webapp to /var/www
2025-07-21 19:19:15 (14808): Guest Log: ATHENA_PROC_NUMBER=8
2025-07-21 19:19:15 (14808): Guest Log: ATHENA_CORE_NUMBER=8
2025-07-21 19:19:15 (14808): 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 
2025-07-21 19:19:16 (14808): Guest Log:  *** Starting ATLAS job. (PandaID=6741691242 taskID=45697532) ***
2025-07-21 19:21:32 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:21:52 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:22:02 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:22:22 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:22:32 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:22:52 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:23:02 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:23:22 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:23:32 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:23:52 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:24:02 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:24:22 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:24:33 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:24:53 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:25:02 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:25:23 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:25:32 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:25:52 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:26:03 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:26:23 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:26:33 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:26:53 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:27:03 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:27:23 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:27:33 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:27:53 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:28:03 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:28:23 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:28:33 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:28:53 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:29:03 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:29:23 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:29:33 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:29:53 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:30:03 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:30:23 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:30:33 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:30:53 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:31:03 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:31:23 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:31:33 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:31:53 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:32:03 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:32:23 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:32:33 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:32:53 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:33:03 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:33:23 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:33:33 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:33:53 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:34:03 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:34:23 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:34:33 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:34:53 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:35:03 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:35:23 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:35:33 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:35:53 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:36:03 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:36:23 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:36:33 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:36:53 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:37:03 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:37:23 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:37:33 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:37:53 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:38:03 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:38:24 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:38:33 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:38:53 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:39:03 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:39:24 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:39:33 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:39:53 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:40:03 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:40:24 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:40:33 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:40:53 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:41:03 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:41:24 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:41:33 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:41:53 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:42:03 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:42:24 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:42:33 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:42:53 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:43:03 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:43:24 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:43:33 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:43:53 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:44:03 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:44:24 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:44:33 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:44:53 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:45:03 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:45:24 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:45:33 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:45:53 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:46:03 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:46:25 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:46:34 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:46:54 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:47:04 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:47:25 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:47:34 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:47:54 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:48:04 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:48:25 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:48:34 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:48:54 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:49:04 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:49:25 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:49:34 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:49:54 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:50:04 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:50:25 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:50:34 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:50:54 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:51:04 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:51:25 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:51:34 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:51:54 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:52:04 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:52:25 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:52:34 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:52:54 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:53:04 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:53:25 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:53:34 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:53:54 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:54:05 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:54:25 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:54:34 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:54:55 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:55:05 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:55:25 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:55:35 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:55:55 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:56:05 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:56:25 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:56:35 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:56:55 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:57:05 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:57:25 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:57:35 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:57:55 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:58:05 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:58:25 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:58:35 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:58:55 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:59:05 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:59:25 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:59:35 (14808): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:59:36 (14808): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 21:25:41 (14808): Status Report: Elapsed Time: '6000.000000'
2025-07-21 21:25:41 (14808): Status Report: CPU Time: '27057.421875'
2025-07-22 12:09:00 (37060): Detected: vboxwrapper 26206
2025-07-22 12:09:00 (37060): Detected: BOINC client v8.0.2
2025-07-22 12:09:01 (37060): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-07-22 12:09:02 (37060): Guest Log: BIOS: VirtualBox 7.0.6
2025-07-22 12:09:02 (37060): Guest Log: CPUID EDX: 0x178bfbff
2025-07-22 12:09:02 (37060): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-07-22 12:09:02 (37060): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-07-22 12:09:02 (37060): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-07-22 12:09:02 (37060): Guest Log: BIOS: Booting from Hard Disk...
2025-07-22 12:09:02 (37060): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-07-22 12:09:02 (37060): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2025-07-22 12:09:02 (37060): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2025-07-22 12:09:02 (37060): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-07-22 12:09:02 (37060): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-07-22 12:09:02 (37060): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2025-07-22 12:09:02 (37060): Guest Log: 00:00:00.000073 main     Log opened 2025-07-21T19:18:49.455079000Z
2025-07-22 12:09:02 (37060): Guest Log: 00:00:00.000143 main     OS Product: Linux
2025-07-22 12:09:02 (37060): Guest Log: 00:00:00.000176 main     OS Release: 3.10.0-957.27.2.el7.x86_64
2025-07-22 12:09:02 (37060): Guest Log: 00:00:00.000199 main     OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2025-07-22 12:09:02 (37060): Guest Log: 00:00:00.000220 main     Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2025-07-22 12:09:02 (37060): Guest Log: 00:00:00.000221 main     Process ID: 1368
2025-07-22 12:09:02 (37060): Guest Log: 00:00:00.000221 main     Package type: LINUX_64BITS_GENERIC
2025-07-22 12:09:02 (37060): Guest Log: 00:00:00.000726 main     5.2.32 r132073 started. Verbose level = 0
2025-07-22 12:09:02 (37060): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch...
2025-07-22 12:09:02 (37060): Guest Log: [INFO] Mounting shared directory
2025-07-22 12:09:02 (37060): Guest Log: [INFO] Checking for init_data.xml
2025-07-22 12:09:02 (37060): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK
2025-07-22 12:09:02 (37060): Guest Log: [INFO] Detected branch: prod
2025-07-22 12:09:02 (37060): Guest Log: This is the prod version of the ATLAS job wrapper
2025-07-22 12:09:02 (37060): Guest Log: Copying input files
2025-07-22 12:09:02 (37060): Guest Log: Copied input files into RunAtlas.
2025-07-22 12:09:02 (37060): Guest Log: This VM did not configure a local http proxy via BOINC.
2025-07-22 12:09:02 (37060): Guest Log: Small home clusters do not require a local http proxy but it is suggested if
2025-07-22 12:09:02 (37060): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
2025-07-22 12:09:02 (37060): Guest Log: Further information can be found at the LHC@home message board.
2025-07-22 12:09:02 (37060): Guest Log: 00:00:10.003291 timesync vgsvcTimeSyncWorker: Radical guest time change: 18 019 127 522 000ns (GuestNow=1 753 143 548 584 385 000 ns GuestLast=1 753 125 529 456 863 000 ns fSetTimeLastLoop=true )
2025-07-22 12:09:02 (37060): Guest Log: Running cvmfs_config stat atlas.cern.ch
2025-07-22 12:09:02 (37060): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2025-07-22 12:09:02 (37060): Guest Log: 2.6.3.0 1650 0 30168 148602 4 1 3117619 4096000 0 65024 0 0 n/a 0 0 http://s1fnal-cvmfs.openhtc.io:8080/cvmfs/atlas.cern.ch DIRECT 1
2025-07-22 12:09:02 (37060): Guest Log: copied the webapp to /var/www
2025-07-22 12:09:02 (37060): Guest Log: ATHENA_PROC_NUMBER=8
2025-07-22 12:09:02 (37060): Guest Log: ATHENA_CORE_NUMBER=8
2025-07-22 12:09:02 (37060): 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 
2025-07-22 12:09:02 (37060): Guest Log:  *** Starting ATLAS job. (PandaID=6741691242 taskID=45697532) ***
2025-07-22 12:09:02 (37060): Starting VM using VBoxManage interface. (boinc_7020698016f608eb, slot#1)
2025-07-22 12:14:05 (54620): Detected: vboxwrapper 26206
2025-07-22 12:14:05 (54620): Detected: BOINC client v8.0.2
2025-07-22 12:14:05 (54620): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-07-22 12:14:11 (54620): VM was running
2025-07-22 12:14:11 (54620): Powering off VM.
2025-07-22 12:14:11 (54620): Error in poweroff VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_7020698016f608eb" poweroff
Output:
VBoxManage.exe: error: Invalid machine state: Starting (must be Running, Paused or Stuck)
VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown
VBoxManage.exe: error: Context: "PowerDown(progress.asOutParam())" at line 604 of file VBoxManageControlVM.cpp

2025-07-22 12:14:11 (54620): VM did not power off when requested.
2025-07-22 12:14:11 (54620): VM was successfully terminated.
2025-07-22 12:14:11 (54620): Starting VM using VBoxManage interface. (boinc_7020698016f608eb, slot#1)
2025-07-22 12:14:42 (54620): Error in start VM for VM: -2135228409
Command:
VBoxManage -q startvm "boinc_7020698016f608eb" --type headless
Output:
VBoxManage.exe: error: The machine 'boinc_7020698016f608eb' is already locked by a session (or being locked or unlocked)
VBoxManage.exe: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee IUnknown
VBoxManage.exe: error: Context: "LaunchVMProcess(a->session, sessionType.raw(), ComSafeArrayAsInParam(aBstrEnv), progress.asOutParam())" at line 883 of file VBoxManageMisc.cpp

Notes:

Another VirtualBox management application has locked the session for
this VM. BOINC cannot properly monitor this VM
and so this job will be aborted.


2025-07-22 12:14:42 (54620): VM failed to start.
2025-07-22 12:14:42 (54620): Could not start 
2025-07-22 12:14:42 (54620): ERROR: VM failed to start
2025-07-22 12:14:47 (54620): 
   NOTE: VM session lock error encountered.
               BOINC will be notified that it needs to clean up the environment.
               This might be a temporary problem and so this job will be rescheduled for another time.

2025-07-23 15:18:05 (8696): Detected: vboxwrapper 26206
2025-07-23 15:18:05 (8696): Detected: BOINC client v8.0.2
2025-07-23 15:18:06 (8696): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-07-23 15:18:07 (8696): Starting VM using VBoxManage interface. (boinc_7020698016f608eb, slot#1)
2025-07-23 15:18:13 (8696): Successfully started VM. (PID = '17112')
2025-07-23 15:18:13 (8696): Reporting VM Process ID to BOINC.
2025-07-23 15:18:13 (8696): Guest Log: BIOS: VirtualBox 7.0.6
2025-07-23 15:18:13 (8696): Guest Log: CPUID EDX: 0x178bfbff
2025-07-23 15:18:13 (8696): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-07-23 15:18:13 (8696): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-07-23 15:18:13 (8696): VM state change detected. (old = 'poweredoff', new = 'running')
2025-07-23 15:18:13 (8696): Detected: Web Application Enabled (http://localhost:53083)
2025-07-23 15:18:13 (8696): Stopping VM.
2025-07-23 15:18:13 (8696): Successfully stopped VM.
2025-07-23 15:34:42 (26736): Detected: vboxwrapper 26206
2025-07-23 15:34:42 (26736): Detected: BOINC client v8.0.2
2025-07-23 15:34:43 (26736): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-07-23 15:34:44 (26736): Guest Log: BIOS: VirtualBox 7.0.6
2025-07-23 15:34:44 (26736): Guest Log: CPUID EDX: 0x178bfbff
2025-07-23 15:34:44 (26736): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-07-23 15:34:44 (26736): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-07-23 15:34:44 (26736): Starting VM using VBoxManage interface. (boinc_7020698016f608eb, slot#1)
2025-07-23 15:36:49 (26736): Error in start VM for VM: -2147467259
Command:
VBoxManage -q startvm "boinc_7020698016f608eb" --type headless
Output:
VBoxManage.exe: error: The VM session was aborted
VBoxManage.exe: error: Details: code E_FAIL (0x80004005), component SessionMachine, interface ISession
Waiting for VM "boinc_7020698016f608eb" to power on...

2025-07-23 15:36:49 (26736): VM failed to start.
2025-07-23 15:36:49 (26736): Could not start 
2025-07-23 15:36:49 (26736): ERROR: VM failed to start
2025-07-23 15:36:49 (26736): Powering off VM.
2025-07-23 15:36:49 (26736): Deregistering VM. (boinc_7020698016f608eb, slot#1)
2025-07-23 15:36:49 (26736): Removing network bandwidth throttle group from VM.
2025-07-23 15:36:49 (26736): Removing VM from VirtualBox.

    Hypervisor System Log:

00:02:06.706560 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706566 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706571 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706576 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706582 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706588 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706594 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706601 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706607 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706612 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706618 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706623 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706629 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706635 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706640 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706646 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706652 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706658 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706663 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706669 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706674 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706680 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706686 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706692 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706697 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706703 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706709 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706715 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706720 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706727 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706733 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706739 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706744 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706750 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706755 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706760 DeleteVM ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:02:06.706942 DeleteVM Saving settings file "C:\ProgramData\BOINC\slots\3\boinc_f50570f9fe30d410\boinc_f50570f9fe30d410.vbox" with version "1.19-windows"
00:02:06.709370 DeleteVM Finished saving settings file "C:\ProgramData\BOINC\slots\3\boinc_f50570f9fe30d410\boinc_f50570f9fe30d410.vbox"

    VM Execution Log:


    VM Startup Log:


    VM Trace Log:

     no
Exclusive HW virtualization use: off
Default hard disk format:        VDI
VRDE auth library:               VBoxAuth
Webservice auth. library:        VBoxAuth
Remote desktop ExtPack:          
VM encryption ExtPack:           
Log history count:               3
Default frontend:                
Default audio driver:            Windows Audio Session
Autostart database path:         
Default Guest Additions ISO:     C:\Program Files\Oracle\VirtualBox/VBoxGuestAdditions.iso
Logging Level:                   all
Proxy Mode:                      System
Proxy URL:                       
User language:                   C

2025-07-23 15:34:43 (26736): 
Command: VBoxManage -q list hostinfo 
Exit Code: 0
Output:
Host Information:

Host time: 2025-07-23T20:34:43.361000000Z
Processor online count: 20
Processor count: 20
Processor online core count: 10
Processor core count: 10
Processor supports HW virtualization: yes
Processor supports PAE: yes
Processor supports long mode: yes
Processor supports nested paging: yes
Processor supports unrestricted guest: yes
Processor supports nested HW virtualization: yes
Processor supports virt. vmsave/vmload: no
Processor#0 speed: unknown
Processor#0 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#1 speed: unknown
Processor#1 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#2 speed: unknown
Processor#2 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#3 speed: unknown
Processor#3 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#4 speed: unknown
Processor#4 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#5 speed: unknown
Processor#5 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#6 speed: unknown
Processor#6 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#7 speed: unknown
Processor#7 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#8 speed: unknown
Processor#8 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#9 speed: unknown
Processor#9 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#10 speed: unknown
Processor#10 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#11 speed: unknown
Processor#11 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#12 speed: unknown
Processor#12 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#13 speed: unknown
Processor#13 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#14 speed: unknown
Processor#14 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#15 speed: unknown
Processor#15 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#16 speed: unknown
Processor#16 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#17 speed: unknown
Processor#17 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#18 speed: unknown
Processor#18 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#19 speed: unknown
Processor#19 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Memory size: 130872 MByte
Memory available: 118523 MByte
Operating system: Windows 10
Operating system version: 10.0.19045

2025-07-23 15:34:43 (26736): 
Command: VBoxManage -q showvminfo "boinc_7020698016f608eb" --machinereadable 
Exit Code: 0
Output:
name="boinc_7020698016f608eb"
Encryption:     disabled
groups="/"
ostype="Linux 2.6 / 3.x / 4.x / 5.x (64-bit)"
UUID="437ac715-c468-4443-a1d6-bf51883e1f2f"
CfgFile="C:\\ProgramData\\BOINC\\slots\\1\\boinc_7020698016f608eb\\boinc_7020698016f608eb.vbox"
SnapFldr="C:\\ProgramData\\BOINC\\slots\\1\\boinc_7020698016f608eb\\Snapshots"
LogFldr="C:\\ProgramData\\BOINC\\slots\\1\\boinc_7020698016f608eb\\Logs"
hardwareuuid="437ac715-c468-4443-a1d6-bf51883e1f2f"
memory=4800
pagefusion="off"
vram=16
cpuexecutioncap=50
hpet="off"
cpu-profile="host"
chipset="piix3"
firmware="BIOS"
cpus=8
pae="on"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="on"
nested-hw-virt="off"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
BIOS NVRAM File="C:\\ProgramData\\BOINC\\slots\\1\\boinc_7020698016f608eb\\boinc_7020698016f608eb.nvram"
rtcuseutc="off"
hwvirtex="on"
nestedpaging="on"
largepages="on"
vtxvpid="on"
vtxux="on"
virtvmsavevmload="on"
iommu="none"
paravirtprovider="default"
effparavirtprovider="kvm"
VMState="saved"
VMStateChangeTime="2025-07-23T20:18:13.000000000"
VMStateFile="C:\ProgramData\BOINC\slots\1\boinc_7020698016f608eb\Snapshots\2025-07-23T20-18-13-767009100Z.sav"
graphicscontroller="vboxvga"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
defaultfrontend=""
vmprocpriority="default"
storagecontrollername0="Hard Disk Controller"
storagecontrollertype0="IntelAhci"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="30"
storagecontrollerportcount0="3"
storagecontrollerbootable0="on"
"Hard Disk Controller-0-0"="C:\\ProgramData\\BOINC\\slots\\1\\boinc_7020698016f608eb\\Snapshots/{4f710f1f-ed86-4304-a6be-f95d6e06f1df}.vdi"
"Hard Disk Controller-ImageUUID-0-0"="4f710f1f-ed86-4304-a6be-f95d6e06f1df"
"Hard Disk Controller-nonrotational-0-0"="off"
"Hard Disk Controller-discard-0-0"="off"
"Hard Disk Controller-1-0"="C:\\Program Files\\Oracle\\VirtualBox\\VBoxGuestAdditions.iso"
"Hard Disk Controller-ImageUUID-1-0"="ed773174-5cc3-4174-9516-b18356a47c43"
"Hard Disk Controller-tempeject-1-0"="off"
"Hard Disk Controller-IsEjected-1-0"="off"
"Hard Disk Controller-nonrotational-1-0"="off"
"Hard Disk Controller-discard-1-0"="off"
"Hard Disk Controller-2-0"="none"
natnet1="nat"
macaddress1="0800279BF425"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="tcp_53083_80,tcp,127.0.0.1,53083,,80"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="none"
audio_out="off"
audio_in="off"
clipboard="disabled"
draganddrop="disabled"
vrde="off"
usb="off"
ehci="off"
xhci="off"
BandwidthGroup0="boinc_7020698016f608eb_net",Network,1099511627776
SharedFolderNameMachineMapping1="shared"
SharedFolderPathMachineMapping1="C:\\ProgramData\\BOINC\\slots\\1\\shared"
recording_enabled="off"
recording_screens=1
 rec_screen0
rec_screen_enabled="on"
rec_screen_id=0
rec_screen_video_enabled="on"
rec_screen_audio_enabled="off"
rec_screen_dest="File"
rec_screen_dest_filename="C:\\ProgramData\\BOINC\\slots\\1\\boinc_7020698016f608eb\\boinc_7020698016f608eb-screen0.webm"
rec_screen_opts="vc_enabled=true,ac_enabled=false,ac_profile=med"
rec_screen_video_res_xy="1024x768"
rec_screen_video_rate_kbps=512
rec_screen_video_fps=25
description="CEuLDmqmCy7n9Rq4apOajLDm4fhM0noT9bVof3QYDmCOtKDmNEuWPo_0"
GuestMemoryBalloon=0

2025-07-23 15:36:49 (26736): 
Command: VBoxManage -q startvm "boinc_7020698016f608eb" --type headless
Exit Code: -2147467259
Output:
VBoxManage.exe: error: The VM session was aborted
VBoxManage.exe: error: Details: code E_FAIL (0x80004005), component SessionMachine, interface ISession
Waiting for VM "boinc_7020698016f608eb" to power on...

2025-07-23 15:36:49 (26736): 
Command: VBoxManage -q snapshot "boinc_7020698016f608eb" list 
Exit Code: -108
Output:
This machine does not have any snapshots

2025-07-23 15:36:49 (26736): 
Command: VBoxManage -q bandwidthctl "boinc_7020698016f608eb" remove "boinc_7020698016f608eb_net" 
Exit Code: 0
Output:

2025-07-23 15:36:49 (26736): 
Command: VBoxManage -q unregistervm "boinc_7020698016f608eb" --delete 
Exit Code: 0
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...100%

15:36:59 (26736): called boinc_finish(-2147467259)
2025-07-23 16:13:30 (27604): Detected: vboxwrapper 26206
2025-07-23 16:13:30 (27604): Detected: BOINC client v8.0.2
2025-07-23 16:13:30 (27604): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-07-23 16:13:31 (27604): Create VM. (boinc_7020698016f608eb, slot#1)
2025-07-23 16:13:32 (27604): Setting Memory Size for VM. (4800MB)
2025-07-23 16:13:32 (27604): Setting CPU Count for VM. (8)
2025-07-23 16:13:32 (27604): Setting Chipset Options for VM.
2025-07-23 16:13:33 (27604): Setting Graphics Controller Options for VM.
2025-07-23 16:13:33 (27604): Setting Boot Options for VM.
2025-07-23 16:13:33 (27604): Setting Network Configuration for NAT.
2025-07-23 16:13:33 (27604): Enabling VM Network Access.
2025-07-23 16:13:34 (27604): Disabling USB Support for VM.
2025-07-23 16:13:34 (27604): Disabling COM Port Support for VM.
2025-07-23 16:13:34 (27604): Disabling LPT Port Support for VM.
2025-07-23 16:13:34 (27604): Disabling Audio Support for VM.
2025-07-23 16:13:35 (27604): Disabling Clipboard Support for VM.
2025-07-23 16:13:35 (27604): Disabling Drag and Drop Support for VM.
2025-07-23 16:13:35 (27604): Adding storage controller(s) to VM.
2025-07-23 16:13:35 (27604): Adding virtual disk drive to VM. (ATLAS_vbox_3.01_image.vdi)
2025-07-23 16:13:36 (27604): Adding VirtualBox Guest Additions to VM.
2025-07-23 16:13:36 (27604): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2025-07-23 16:13:37 (27604): forwarding host port 53083 to guest port 80
2025-07-23 16:13:37 (27604): Enabling remote desktop for VM.
2025-07-23 16:13:37 (27604): Required extension pack not installed, remote desktop not enabled.
2025-07-23 16:13:37 (27604): Enabling shared directory for VM.
2025-07-23 16:13:38 (27604): ERROR: VM failed to start
2025-07-23 16:13:43 (27604): 
   BOINC will be notified that it needs to clean up the environment.
         This is a temporary problem and so this job will be rescheduled for another time.

2025-07-23 16:18:34 (12836): Detected: vboxwrapper 26206
2025-07-23 16:18:34 (12836): Detected: BOINC client v8.0.2
2025-07-23 16:18:34 (12836): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-07-23 16:18:35 (12836): Starting VM using VBoxManage interface. (boinc_7020698016f608eb, slot#1)
2025-07-23 16:18:41 (12836): Successfully started VM. (PID = '5296')
2025-07-23 16:18:41 (12836): Reporting VM Process ID to BOINC.
2025-07-23 16:18:41 (12836): Guest Log: BIOS: VirtualBox 7.0.6
2025-07-23 16:18:41 (12836): Guest Log: CPUID EDX: 0x178bfbff
2025-07-23 16:18:41 (12836): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-07-23 16:18:41 (12836): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-07-23 16:18:41 (12836): VM state change detected. (old = 'poweredoff', new = 'running')
2025-07-23 16:18:41 (12836): Detected: Web Application Enabled (http://localhost:53083)
2025-07-23 16:18:41 (12836): Powering off VM.
2025-07-23 16:18:41 (12836): Successfully stopped VM.
2025-07-23 16:18:41 (12836): Deregistering VM. (boinc_7020698016f608eb, slot#1)
2025-07-23 16:18:41 (12836): Removing network bandwidth throttle group from VM.
2025-07-23 16:18:42 (12836): Removing VM from VirtualBox.

</stderr_txt>
]]>


©2025 CERN