| Name | 9qPLDmTZXg8nsSi4ap6QjLDmwznN0nGgGQJmNLGKDmdzIKDmESYeVo_1 |
| Workunit | 237695582 |
| Created | 21 Nov 2025, 10:41:13 UTC |
| Sent | 21 Nov 2025, 17:53:33 UTC |
| Report deadline | 29 Nov 2025, 17:53:33 UTC |
| Received | 24 Nov 2025, 19:07:47 UTC |
| Server state | Over |
| Outcome | Computation error |
| Client state | Compute error |
| Exit status | -2147467259 (0x80004005) Unknown error code |
| Computer ID | 10848313 |
| Run time | 14 hours 17 min 23 sec |
| CPU time | 13 hours 0 min |
| Validate state | Invalid |
| Credit | 0.00 |
| Device peak FLOPS | 39.66 GFLOPS |
| Application version | ATLAS Simulation v3.03 (vbox64_mt_mcore_atlas) windows_x86_64 |
| Peak working set size | 96.21 MB |
| Peak swap size | 98.36 MB |
| Peak disk usage | 4.78 GB |
Stderr output
<core_client_version>8.0.2</core_client_version>
<![CDATA[
<message>
Unspecified error
(0x80004005) - exit code 2147500037 (0x80004005)</message>
<stderr_txt>
2025-11-21 13:23:53 (87020): vboxwrapper version 26210
2025-11-21 13:23:53 (87020): BOINC client version: 8.0.2
2025-11-21 13:23:53 (87020): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-11-21 13:23:54 (87020): Successfully copied 'init_data.xml' to the shared directory.
2025-11-21 13:23:54 (87020): Create VM. (boinc_7254b67a5f61b57d, slot#3)
2025-11-21 13:23:54 (87020): Setting Memory Size for VM. (4800MB)
2025-11-21 13:23:55 (87020): Setting CPU Count for VM. (8)
2025-11-21 13:23:55 (87020): Setting Chipset Options for VM.
2025-11-21 13:23:55 (87020): Setting Graphics Controller Options for VM. (Driver: VBoxVGA, 16MB)
2025-11-21 13:23:55 (87020): Setting Boot Options for VM.
2025-11-21 13:23:56 (87020): Setting Network Configuration for NAT. (Driver: virtio)
2025-11-21 13:23:56 (87020): Enabling VM Network Access.
2025-11-21 13:23:56 (87020): Disabling USB Support for VM.
2025-11-21 13:23:57 (87020): Disabling COM Port Support for VM.
2025-11-21 13:23:57 (87020): Disabling LPT Port Support for VM.
2025-11-21 13:23:57 (87020): Disabling Audio Support for VM.
2025-11-21 13:23:57 (87020): Disabling Clipboard Support for VM.
2025-11-21 13:23:58 (87020): Disabling Drag and Drop Support for VM.
2025-11-21 13:23:58 (87020): Adding storage controller(s) to VM.
2025-11-21 13:23:58 (87020): Adding virtual disk drive to VM. (ATLAS_vbox_3.03_image.vdi)
2025-11-21 13:23:59 (87020): Adding VirtualBox Guest Additions to VM.
2025-11-21 13:23:59 (87020): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2025-11-21 13:23:59 (87020): forwarding host port 59002 to guest port 80
2025-11-21 13:24:00 (87020): Enabling remote desktop for VM.
2025-11-21 13:24:00 (87020): Required extension pack not installed, remote desktop not enabled.
2025-11-21 13:24:00 (87020): Enabling shared directory for VM.
2025-11-21 13:24:00 (87020): Starting VM using VBoxManage interface. (boinc_7254b67a5f61b57d, slot#3)
2025-11-21 13:24:07 (87020): Successfully started VM. (PID = '91400')
2025-11-21 13:24:07 (87020): Reporting VM Process ID to BOINC.
2025-11-21 13:24:07 (87020): Guest Log: BIOS: VirtualBox 7.0.6
2025-11-21 13:24:07 (87020): Guest Log: CPUID EDX: 0x178bfbff
2025-11-21 13:24:07 (87020): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-11-21 13:24:07 (87020): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-11-21 13:24:07 (87020): VM state change detected. (old = 'poweredoff', new = 'running')
2025-11-21 13:24:07 (87020): Detected: Web Application Enabled (http://localhost:59002)
2025-11-21 13:24:07 (87020): Preference change detected
2025-11-21 13:24:07 (87020): Setting CPU throttle for VM. (100%)
2025-11-21 13:24:07 (87020): Setting network throttle for VM. (1464KB)
2025-11-21 13:24:07 (87020): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-11-21 13:24:09 (87020): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-11-21 13:24:09 (87020): Guest Log: BIOS: Booting from Hard Disk...
2025-11-21 13:24:12 (87020): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-11-21 13:24:12 (87020): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2025-11-21 13:24:12 (87020): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2025-11-21 13:24:17 (87020): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-11-21 13:24:17 (87020): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-11-21 13:24:21 (87020): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2025-11-21 13:24:21 (87020): Guest Log: 00:00:00.000159 main Log opened 2025-11-21T13:24:19.525782000Z
2025-11-21 13:24:21 (87020): Guest Log: 00:00:00.000279 main OS Product: Linux
2025-11-21 13:24:21 (87020): Guest Log: 00:00:00.000320 main OS Release: 3.10.0-957.27.2.el7.x86_64
2025-11-21 13:24:21 (87020): Guest Log: 00:00:00.000349 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2025-11-21 13:24:21 (87020): Guest Log: 00:00:00.000379 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2025-11-21 13:24:21 (87020): Guest Log: 00:00:00.000380 main Process ID: 1371
2025-11-21 13:24:21 (87020): Guest Log: 00:00:00.000381 main Package type: LINUX_64BITS_GENERIC
2025-11-21 13:24:21 (87020): Guest Log: 00:00:00.001562 main 5.2.32 r132073 started. Verbose level = 0
2025-11-21 13:24:22 (87020): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch...
2025-11-21 13:24:22 (87020): Guest Log: [INFO] Mounting shared directory
2025-11-21 13:24:22 (87020): Guest Log: [INFO] Checking for init_data.xml
2025-11-21 13:24:28 (87020): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK
2025-11-21 13:24:28 (87020): Guest Log: [INFO] Detected branch: prod
2025-11-21 13:24:29 (87020): Guest Log: This is the prod version of the ATLAS job wrapper
2025-11-21 13:24:29 (87020): Guest Log: Copying input files
2025-11-21 13:24:31 (87020): Guest Log: Copied input files into RunAtlas.
2025-11-21 13:24:31 (87020): Guest Log: This VM did not configure a local http proxy via BOINC.
2025-11-21 13:24:31 (87020): Guest Log: Small home clusters do not require a local http proxy but it is suggested if
2025-11-21 13:24:31 (87020): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
2025-11-21 13:24:31 (87020): Guest Log: Further information can be found at the LHC@home message board.
2025-11-21 13:24:31 (87020): Guest Log: 00:00:10.004890 timesync vgsvcTimeSyncWorker: Radical guest time change: 28 811 832 610 000ns (GuestNow=1 763 760 271 361 543 000 ns GuestLast=1 763 731 459 528 933 000 ns fSetTimeLastLoop=true )
2025-11-21 13:24:40 (87020): Guest Log: Running cvmfs_config stat atlas.cern.ch
2025-11-21 13:24:40 (87020): 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-11-21 13:24:40 (87020): Guest Log: 2.6.3.0 1653 0 30128 153143 4 1 3117639 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1
2025-11-21 13:24:41 (87020): Guest Log: copied the webapp to /var/www
2025-11-21 13:24:41 (87020): Guest Log: ATHENA_PROC_NUMBER=8
2025-11-21 13:24:41 (87020): Guest Log: ATHENA_CORE_NUMBER=8
2025-11-21 13:24:43 (87020): 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-11-21 13:24:43 (87020): Guest Log: *** Starting ATLAS job. (PandaID=6894258921 taskID=47533967) ***
2025-11-21 15:04:12 (87020): Status Report: Elapsed Time: '6000.000000'
2025-11-21 15:04:12 (87020): Status Report: CPU Time: '4071.796875'
2025-11-21 15:41:18 (87020): VM state change detected. (old = 'running', new = 'paused')
2025-11-21 15:41:38 (87020): VM state change detected. (old = 'paused', new = 'running')
2025-11-21 16:44:39 (87020): Status Report: Elapsed Time: '12000.000000'
2025-11-21 16:44:39 (87020): Status Report: CPU Time: '9470.296875'
2025-11-21 18:24:44 (87020): Status Report: Elapsed Time: '18000.000000'
2025-11-21 18:24:44 (87020): Status Report: CPU Time: '14774.437500'
2025-11-21 19:21:43 (87020): Stopping VM.
2025-11-21 19:26:42 (99104): vboxwrapper version 26210
2025-11-21 19:26:42 (99104): BOINC client version: 8.0.2
2025-11-21 19:26:43 (99104): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-11-21 19:26:44 (99104): Guest Log: BIOS: VirtualBox 7.0.6
2025-11-21 19:26:44 (99104): Guest Log: CPUID EDX: 0x178bfbff
2025-11-21 19:26:44 (99104): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-11-21 19:26:44 (99104): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-11-21 19:26:44 (99104): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-11-21 19:26:44 (99104): Guest Log: BIOS: Booting from Hard Disk...
2025-11-21 19:26:44 (99104): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-11-21 19:26:44 (99104): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2025-11-21 19:26:44 (99104): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2025-11-21 19:26:44 (99104): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-11-21 19:26:44 (99104): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-11-21 19:26:44 (99104): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2025-11-21 19:26:44 (99104): Guest Log: 00:00:00.000159 main Log opened 2025-11-21T13:24:19.525782000Z
2025-11-21 19:26:44 (99104): Guest Log: 00:00:00.000279 main OS Product: Linux
2025-11-21 19:26:44 (99104): Guest Log: 00:00:00.000320 main OS Release: 3.10.0-957.27.2.el7.x86_64
2025-11-21 19:26:44 (99104): Guest Log: 00:00:00.000349 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2025-11-21 19:26:44 (99104): Guest Log: 00:00:00.000379 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2025-11-21 19:26:44 (99104): Guest Log: 00:00:00.000380 main Process ID: 1371
2025-11-21 19:26:44 (99104): Guest Log: 00:00:00.000381 main Package type: LINUX_64BITS_GENERIC
2025-11-21 19:26:44 (99104): Guest Log: 00:00:00.001562 main 5.2.32 r132073 started. Verbose level = 0
2025-11-21 19:26:44 (99104): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch...
2025-11-21 19:26:44 (99104): Guest Log: [INFO] Mounting shared directory
2025-11-21 19:26:44 (99104): Guest Log: [INFO] Checking for init_data.xml
2025-11-21 19:26:44 (99104): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK
2025-11-21 19:26:44 (99104): Guest Log: [INFO] Detected branch: prod
2025-11-21 19:26:44 (99104): Guest Log: This is the prod version of the ATLAS job wrapper
2025-11-21 19:26:44 (99104): Guest Log: Copying input files
2025-11-21 19:26:44 (99104): Guest Log: Copied input files into RunAtlas.
2025-11-21 19:26:44 (99104): Guest Log: This VM did not configure a local http proxy via BOINC.
2025-11-21 19:26:44 (99104): Guest Log: Small home clusters do not require a local http proxy but it is suggested if
2025-11-21 19:26:44 (99104): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
2025-11-21 19:26:44 (99104): Guest Log: Further information can be found at the LHC@home message board.
2025-11-21 19:26:44 (99104): Guest Log: 00:00:10.004890 timesync vgsvcTimeSyncWorker: Radical guest time change: 28 811 832 610 000ns (GuestNow=1 763 760 271 361 543 000 ns GuestLast=1 763 731 459 528 933 000 ns fSetTimeLastLoop=true )
2025-11-21 19:26:44 (99104): Guest Log: Running cvmfs_config stat atlas.cern.ch
2025-11-21 19:26:44 (99104): 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-11-21 19:26:44 (99104): Guest Log: 2.6.3.0 1653 0 30128 153143 4 1 3117639 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1
2025-11-21 19:26:44 (99104): Guest Log: copied the webapp to /var/www
2025-11-21 19:26:44 (99104): Guest Log: ATHENA_PROC_NUMBER=8
2025-11-21 19:26:44 (99104): Guest Log: ATHENA_CORE_NUMBER=8
2025-11-21 19:26:44 (99104): 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-11-21 19:26:44 (99104): Guest Log: *** Starting ATLAS job. (PandaID=6894258921 taskID=47533967) ***
2025-11-21 19:26:44 (99104): Starting VM using VBoxManage interface. (boinc_7254b67a5f61b57d, slot#3)
2025-11-22 00:11:38 (100692): vboxwrapper version 26210
2025-11-22 00:11:38 (100692): BOINC client version: 8.0.2
2025-11-22 00:11:38 (100692): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-11-22 00:11:44 (100692): VM was running
2025-11-22 00:11:44 (100692): Powering off VM.
2025-11-22 00:11:44 (100692): Error in poweroff VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_7254b67a5f61b57d" 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-11-22 00:11:44 (100692): VM did not power off when requested.
2025-11-22 00:11:44 (100692): VM was NOT successfully terminated.
2025-11-22 00:11:44 (100692): Could not stop running VM
2025-11-22 00:11:44 (100692): ERROR: VM failed to start
2025-11-22 00:11:49 (100692):
NOTE: VM was already running.
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-11-23 00:11:57 (112480): vboxwrapper version 26210
2025-11-23 00:11:57 (112480): BOINC client version: 8.0.2
2025-11-23 00:11:58 (112480): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-11-23 00:12:03 (112480): VM was running
2025-11-23 00:12:03 (112480): Powering off VM.
2025-11-23 00:12:04 (112480): Error in poweroff VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_7254b67a5f61b57d" 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-11-23 00:12:04 (112480): VM did not power off when requested.
2025-11-23 00:12:04 (112480): VM was NOT successfully terminated.
2025-11-23 00:12:04 (112480): Could not stop running VM
2025-11-23 00:12:04 (112480): ERROR: VM failed to start
2025-11-23 00:12:09 (112480):
NOTE: VM was already running.
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-11-24 00:12:35 (138596): vboxwrapper version 26210
2025-11-24 00:12:35 (138596): BOINC client version: 8.0.2
2025-11-24 00:12:36 (138596): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-11-24 00:12:37 (138596): Starting VM using VBoxManage interface. (boinc_7254b67a5f61b57d, slot#3)
2025-11-24 00:12:45 (138596): Successfully started VM. (PID = '143144')
2025-11-24 00:12:45 (138596): Reporting VM Process ID to BOINC.
2025-11-24 00:12:45 (138596): Guest Log: BIOS: VirtualBox 7.0.6
2025-11-24 00:12:45 (138596): Guest Log: CPUID EDX: 0x178bfbff
2025-11-24 00:12:45 (138596): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-11-24 00:12:45 (138596): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-11-24 00:12:45 (138596): VM state change detected. (old = 'poweredoff', new = 'running')
2025-11-24 00:12:45 (138596): Detected: Web Application Enabled (http://localhost:59002)
2025-11-24 00:12:45 (138596): Status Report: Elapsed Time: '21416.000000'
2025-11-24 00:12:45 (138596): Status Report: CPU Time: '17775.140625'
2025-11-24 00:12:45 (138596): Preference change detected
2025-11-24 00:12:45 (138596): Setting CPU throttle for VM. (100%)
2025-11-24 00:12:45 (138596): Setting network throttle for VM. (1464KB)
2025-11-24 00:12:45 (138596): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-11-24 00:12:47 (138596): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-11-24 00:12:47 (138596): Guest Log: BIOS: Booting from Hard Disk...
2025-11-24 00:12:50 (138596): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-11-24 00:12:50 (138596): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2025-11-24 00:12:50 (138596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2025-11-24 00:12:56 (138596): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-11-24 00:12:56 (138596): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-11-24 00:13:02 (138596): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2025-11-24 00:13:02 (138596): Guest Log: 00:00:00.000188 main Log opened 2025-11-24T00:13:00.581448000Z
2025-11-24 00:13:02 (138596): Guest Log: 00:00:00.000416 main OS Product: Linux
2025-11-24 00:13:02 (138596): Guest Log: 00:00:00.000479 main OS Release: 3.10.0-957.27.2.el7.x86_64
2025-11-24 00:13:02 (138596): Guest Log: 00:00:00.000522 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2025-11-24 00:13:02 (138596): Guest Log: 00:00:00.000563 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2025-11-24 00:13:02 (138596): Guest Log: 00:00:00.000564 main Process ID: 1372
2025-11-24 00:13:02 (138596): Guest Log: 00:00:00.000565 main Package type: LINUX_64BITS_GENERIC
2025-11-24 00:13:02 (138596): Guest Log: 00:00:00.001588 main 5.2.32 r132073 started. Verbose level = 0
2025-11-24 00:13:02 (138596): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch...
2025-11-24 00:13:02 (138596): Guest Log: [INFO] Mounting shared directory
2025-11-24 00:13:02 (138596): Guest Log: [INFO] Checking for init_data.xml
2025-11-24 00:13:09 (138596): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK
2025-11-24 00:13:09 (138596): Guest Log: [INFO] Detected branch: prod
2025-11-24 00:13:09 (138596): Guest Log: This is the prod version of the ATLAS job wrapper
2025-11-24 00:13:09 (138596): Guest Log: Copying input files
2025-11-24 00:13:11 (138596): Guest Log: Copied input files into RunAtlas.
2025-11-24 00:13:11 (138596): Guest Log: This VM did not configure a local http proxy via BOINC.
2025-11-24 00:13:11 (138596): Guest Log: Small home clusters do not require a local http proxy but it is suggested if
2025-11-24 00:13:11 (138596): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
2025-11-24 00:13:11 (138596): Guest Log: Further information can be found at the LHC@home message board.
2025-11-24 00:13:12 (138596): Guest Log: 00:00:10.015458 timesync vgsvcTimeSyncWorker: Radical guest time change: 28 810 741 540 000ns (GuestNow=1 763 971 991 326 099 000 ns GuestLast=1 763 943 180 584 559 000 ns fSetTimeLastLoop=true )
2025-11-24 00:13:21 (138596): Guest Log: Running cvmfs_config stat atlas.cern.ch
2025-11-24 00:13:21 (138596): 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-11-24 00:13:21 (138596): Guest Log: 2.6.3.0 1675 0 29988 153238 4 1 4079606 4096001 0 65024 0 0 n/a 0 0 http://s1fnal-cvmfs.openhtc.io:8080/cvmfs/atlas.cern.ch DIRECT 1
2025-11-24 00:13:28 (138596): Guest Log: copied the webapp to /var/www
2025-11-24 00:13:28 (138596): Guest Log: ATHENA_PROC_NUMBER=8
2025-11-24 00:13:28 (138596): Guest Log: ATHENA_CORE_NUMBER=8
2025-11-24 00:13:30 (138596): 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-11-24 00:13:30 (138596): Guest Log: *** Starting ATLAS job. (PandaID=6894258921 taskID=47533967) ***
2025-11-24 00:21:07 (138596): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 00:21:27 (138596): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 00:21:57 (138596): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 00:22:17 (138596): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 00:22:37 (138596): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 00:22:57 (138596): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 00:23:17 (138596): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 00:23:37 (138596): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 00:23:47 (138596): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 00:24:08 (138596): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 00:24:48 (138596): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 00:25:08 (138596): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 00:25:28 (138596): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 00:25:48 (138596): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 00:29:38 (138596): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 00:29:58 (138596): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 00:30:39 (138596): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 00:30:59 (138596): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 00:32:59 (138596): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 00:33:19 (138596): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 00:36:59 (138596): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 00:37:19 (138596): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 00:37:29 (138596): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 00:37:49 (138596): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 00:41:11 (138596): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 00:41:31 (138596): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 00:41:51 (138596): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 00:42:11 (138596): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 00:42:21 (138596): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 00:42:41 (138596): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 00:43:21 (138596): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 00:43:41 (138596): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 00:51:22 (138596): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 00:51:42 (138596): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 00:51:52 (138596): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 00:52:12 (138596): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 00:53:52 (138596): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 00:54:12 (138596): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 00:59:03 (138596): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 00:59:23 (138596): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 01:59:52 (138596): Status Report: Elapsed Time: '27416.000000'
2025-11-24 01:59:52 (138596): Status Report: CPU Time: '27590.687500'
2025-11-24 03:39:57 (138596): Status Report: Elapsed Time: '33416.000000'
2025-11-24 03:39:57 (138596): Status Report: CPU Time: '30560.375000'
2025-11-24 03:45:34 (138596): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 03:45:55 (138596): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 03:47:17 (138596): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 03:47:35 (138596): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 05:20:45 (138596): Status Report: Elapsed Time: '39416.000000'
2025-11-24 05:20:45 (138596): Status Report: CPU Time: '35771.875000'
2025-11-24 07:00:50 (138596): Status Report: Elapsed Time: '45416.000000'
2025-11-24 07:00:50 (138596): Status Report: CPU Time: '41292.234375'
2025-11-24 08:40:53 (138596): Stopping VM.
2025-11-24 09:39:52 (141804): vboxwrapper version 26210
2025-11-24 09:39:52 (141804): BOINC client version: 8.0.2
2025-11-24 09:39:53 (141804): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-11-24 09:39:54 (141804): Guest Log: BIOS: VirtualBox 7.0.6
2025-11-24 09:39:54 (141804): Guest Log: CPUID EDX: 0x178bfbff
2025-11-24 09:39:54 (141804): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-11-24 09:39:54 (141804): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-11-24 09:39:54 (141804): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-11-24 09:39:54 (141804): Guest Log: BIOS: Booting from Hard Disk...
2025-11-24 09:39:54 (141804): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-11-24 09:39:54 (141804): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2025-11-24 09:39:54 (141804): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2025-11-24 09:39:54 (141804): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-11-24 09:39:54 (141804): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-11-24 09:39:54 (141804): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2025-11-24 09:39:54 (141804): Guest Log: 00:00:00.000188 main Log opened 2025-11-24T00:13:00.581448000Z
2025-11-24 09:39:54 (141804): Guest Log: 00:00:00.000416 main OS Product: Linux
2025-11-24 09:39:54 (141804): Guest Log: 00:00:00.000479 main OS Release: 3.10.0-957.27.2.el7.x86_64
2025-11-24 09:39:54 (141804): Guest Log: 00:00:00.000522 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2025-11-24 09:39:54 (141804): Guest Log: 00:00:00.000563 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2025-11-24 09:39:54 (141804): Guest Log: 00:00:00.000564 main Process ID: 1372
2025-11-24 09:39:54 (141804): Guest Log: 00:00:00.000565 main Package type: LINUX_64BITS_GENERIC
2025-11-24 09:39:54 (141804): Guest Log: 00:00:00.001588 main 5.2.32 r132073 started. Verbose level = 0
2025-11-24 09:39:54 (141804): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch...
2025-11-24 09:39:54 (141804): Guest Log: [INFO] Mounting shared directory
2025-11-24 09:39:54 (141804): Guest Log: [INFO] Checking for init_data.xml
2025-11-24 09:39:54 (141804): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK
2025-11-24 09:39:54 (141804): Guest Log: [INFO] Detected branch: prod
2025-11-24 09:39:54 (141804): Guest Log: This is the prod version of the ATLAS job wrapper
2025-11-24 09:39:54 (141804): Guest Log: Copying input files
2025-11-24 09:39:54 (141804): Guest Log: Copied input files into RunAtlas.
2025-11-24 09:39:54 (141804): Guest Log: This VM did not configure a local http proxy via BOINC.
2025-11-24 09:39:54 (141804): Guest Log: Small home clusters do not require a local http proxy but it is suggested if
2025-11-24 09:39:54 (141804): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
2025-11-24 09:39:54 (141804): Guest Log: Further information can be found at the LHC@home message board.
2025-11-24 09:39:54 (141804): Guest Log: 00:00:10.015458 timesync vgsvcTimeSyncWorker: Radical guest time change: 28 810 741 540 000ns (GuestNow=1 763 971 991 326 099 000 ns GuestLast=1 763 943 180 584 559 000 ns fSetTimeLastLoop=true )
2025-11-24 09:39:54 (141804): Guest Log: Running cvmfs_config stat atlas.cern.ch
2025-11-24 09:39:54 (141804): 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-11-24 09:39:54 (141804): Guest Log: 2.6.3.0 1675 0 29988 153238 4 1 4079606 4096001 0 65024 0 0 n/a 0 0 http://s1fnal-cvmfs.openhtc.io:8080/cvmfs/atlas.cern.ch DIRECT 1
2025-11-24 09:39:54 (141804): Guest Log: copied the webapp to /var/www
2025-11-24 09:39:54 (141804): Guest Log: ATHENA_PROC_NUMBER=8
2025-11-24 09:39:54 (141804): Guest Log: ATHENA_CORE_NUMBER=8
2025-11-24 09:39:54 (141804): 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-11-24 09:39:54 (141804): Guest Log: *** Starting ATLAS job. (PandaID=6894258921 taskID=47533967) ***
2025-11-24 09:39:54 (141804): Starting VM using VBoxManage interface. (boinc_7254b67a5f61b57d, slot#3)
2025-11-24 09:40:03 (141804): Error in start VM for VM: -2147467259
Command:
VBoxManage -q startvm "boinc_7254b67a5f61b57d" --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_7254b67a5f61b57d" to power on...
2025-11-24 09:40:03 (141804): VM failed to start.
2025-11-24 09:40:03 (141804): Could not start
2025-11-24 09:40:03 (141804): ERROR: VM failed to start
2025-11-24 09:40:03 (141804): Powering off VM.
2025-11-24 09:40:03 (141804): Deregistering VM. (boinc_7254b67a5f61b57d, slot#3)
2025-11-24 09:40:03 (141804): Removing network bandwidth throttle group from VM.
2025-11-24 09:40:03 (141804): Removing VM from VirtualBox.
Hypervisor System Log:
00:00:11.081415 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:00:11.081429 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:00:11.081443 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:00:11.081457 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:00:11.081471 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:00:11.081485 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:00:11.081499 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:00:11.081514 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:00:11.081529 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:00:11.081543 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:00:11.081557 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:00:11.081572 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:00:11.081586 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:00:11.081600 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:00:11.081614 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:00:11.081628 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:00:11.081643 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:00:11.081658 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:00:11.081673 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:00:11.081687 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:00:11.081701 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:00:11.081716 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:00:11.081730 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:00:11.081744 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:00:11.081759 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:00:11.081773 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:00:11.081788 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:00:11.081803 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:00:11.081817 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:00:11.081832 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:00:11.081846 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:00:11.081861 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:00:11.081875 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:00:11.082188 DeleteVM Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_b1af72e1e8f2507c\boinc_b1af72e1e8f2507c.vbox" with version "1.19-windows"
00:00:11.089624 DeleteVM Finished saving settings file "C:\ProgramData\BOINC\slots\0\boinc_b1af72e1e8f2507c\boinc_b1af72e1e8f2507c.vbox"
00:00:14.195417 Saving settings file "C:\ProgramData\BOINC\slots\1\boinc_80c970846bcef980\boinc_80c970846bcef980.vbox" with version "1.19-windows"
00:00:14.279715 Finished saving settings file "C:\ProgramData\BOINC\slots\1\boinc_80c970846bcef980\boinc_80c970846bcef980.vbox"
00:00:14.331686 SaveState Saving settings file "C:\ProgramData\BOINC\slots\1\boinc_80c970846bcef980\boinc_80c970846bcef980.vbox" with version "1.19-windows"
00:00:14.419395 SaveState Finished saving settings file "C:\ProgramData\BOINC\slots\1\boinc_80c970846bcef980\boinc_80c970846bcef980.vbox"
VM Execution Log:
VM Startup Log:
VM Trace Log:
ICH9 Floppy Controllers: 1
Maximum Floppy Port count: 1
Maximum Devices per Floppy Port: 2
Default machine folder: C:\Users\bill\VirtualBox VMs
Raw-mode Supported: 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-11-24 09:39:53 (141804):
Command: VBoxManage -q list hostinfo
Exit Code: 0
Output:
Host Information:
Host time: 2025-11-24T17:39:53.667000000Z
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) Xeon(R) W-2155 CPU @ 3.30GHz
Processor#1 speed: unknown
Processor#1 description: Intel(R) Xeon(R) W-2155 CPU @ 3.30GHz
Processor#2 speed: unknown
Processor#2 description: Intel(R) Xeon(R) W-2155 CPU @ 3.30GHz
Processor#3 speed: unknown
Processor#3 description: Intel(R) Xeon(R) W-2155 CPU @ 3.30GHz
Processor#4 speed: unknown
Processor#4 description: Intel(R) Xeon(R) W-2155 CPU @ 3.30GHz
Processor#5 speed: unknown
Processor#5 description: Intel(R) Xeon(R) W-2155 CPU @ 3.30GHz
Processor#6 speed: unknown
Processor#6 description: Intel(R) Xeon(R) W-2155 CPU @ 3.30GHz
Processor#7 speed: unknown
Processor#7 description: Intel(R) Xeon(R) W-2155 CPU @ 3.30GHz
Processor#8 speed: unknown
Processor#8 description: Intel(R) Xeon(R) W-2155 CPU @ 3.30GHz
Processor#9 speed: unknown
Processor#9 description: Intel(R) Xeon(R) W-2155 CPU @ 3.30GHz
Processor#10 speed: unknown
Processor#10 description: Intel(R) Xeon(R) W-2155 CPU @ 3.30GHz
Processor#11 speed: unknown
Processor#11 description: Intel(R) Xeon(R) W-2155 CPU @ 3.30GHz
Processor#12 speed: unknown
Processor#12 description: Intel(R) Xeon(R) W-2155 CPU @ 3.30GHz
Processor#13 speed: unknown
Processor#13 description: Intel(R) Xeon(R) W-2155 CPU @ 3.30GHz
Processor#14 speed: unknown
Processor#14 description: Intel(R) Xeon(R) W-2155 CPU @ 3.30GHz
Processor#15 speed: unknown
Processor#15 description: Intel(R) Xeon(R) W-2155 CPU @ 3.30GHz
Processor#16 speed: unknown
Processor#16 description: Intel(R) Xeon(R) W-2155 CPU @ 3.30GHz
Processor#17 speed: unknown
Processor#17 description: Intel(R) Xeon(R) W-2155 CPU @ 3.30GHz
Processor#18 speed: unknown
Processor#18 description: Intel(R) Xeon(R) W-2155 CPU @ 3.30GHz
Processor#19 speed: unknown
Processor#19 description: Intel(R) Xeon(R) W-2155 CPU @ 3.30GHz
Memory size: 65208 MByte
Memory available: 32928 MByte
Operating system: Windows 11
Operating system version: 10.0.22631
2025-11-24 09:39:54 (141804):
Command: VBoxManage -q showvminfo "boinc_7254b67a5f61b57d" --machinereadable
Exit Code: 0
Output:
name="boinc_7254b67a5f61b57d"
Encryption: disabled
groups="/"
ostype="Linux 2.6 / 3.x / 4.x / 5.x (64-bit)"
UUID="6a21085f-b186-4ca1-b204-82894d107310"
CfgFile="C:\\ProgramData\\BOINC\\slots\\3\\boinc_7254b67a5f61b57d\\boinc_7254b67a5f61b57d.vbox"
SnapFldr="C:\\ProgramData\\BOINC\\slots\\3\\boinc_7254b67a5f61b57d\\Snapshots"
LogFldr="C:\\ProgramData\\BOINC\\slots\\3\\boinc_7254b67a5f61b57d\\Logs"
hardwareuuid="6a21085f-b186-4ca1-b204-82894d107310"
memory=4800
pagefusion="off"
vram=16
cpuexecutioncap=100
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\\3\\boinc_7254b67a5f61b57d\\boinc_7254b67a5f61b57d.nvram"
rtcuseutc="off"
hwvirtex="on"
nestedpaging="on"
largepages="on"
vtxvpid="on"
vtxux="on"
virtvmsavevmload="on"
iommu="none"
paravirtprovider="default"
effparavirtprovider="kvm"
VMState="aborted"
VMStateChangeTime="2025-11-24T16:42:05.000000000"
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\\3\\boinc_7254b67a5f61b57d\\Snapshots/{7509fffc-06f4-4bf7-b1d3-b4f0a049979d}.vdi"
"Hard Disk Controller-ImageUUID-0-0"="7509fffc-06f4-4bf7-b1d3-b4f0a049979d"
"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"="f2789e5b-3de2-49c4-94e1-393b7d9e3285"
"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="080027F9D9E8"
cableconnected1="on"
nic1="nat"
nictype1="virtio"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="tcp_59002_80,tcp,127.0.0.1,59002,,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_7254b67a5f61b57d_net",Network,1499136
SharedFolderNameMachineMapping1="shared"
SharedFolderPathMachineMapping1="C:\\ProgramData\\BOINC\\slots\\3\\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\\3\\boinc_7254b67a5f61b57d\\boinc_7254b67a5f61b57d-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="9qPLDmTZXg8nsSi4ap6QjLDmwznN0nGgGQJmNLGKDmdzIKDmESYeVo_1"
GuestMemoryBalloon=0
2025-11-24 09:40:03 (141804):
Command: VBoxManage -q startvm "boinc_7254b67a5f61b57d" --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_7254b67a5f61b57d" to power on...
2025-11-24 09:40:03 (141804):
Command: VBoxManage -q snapshot "boinc_7254b67a5f61b57d" list
Exit Code: -108
Output:
This machine does not have any snapshots
2025-11-24 09:40:03 (141804):
Command: VBoxManage -q bandwidthctl "boinc_7254b67a5f61b57d" remove "boinc_7254b67a5f61b57d_net"
Exit Code: 0
Output:
2025-11-24 09:40:04 (141804):
Command: VBoxManage -q unregistervm "boinc_7254b67a5f61b57d" --delete
Exit Code: 0
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...100%
2025-11-24 09:40:16 (141804): called boinc_finish(-2147467259)
</stderr_txt>
]]>
©2025 CERN