| Name | gBeMDmBQbN7n9Rq4apOajLDm4fhM0noT9bVoFjIUDmpJxKDm0VR43m_0 |
| Workunit | 231547606 |
| Created | 11 Apr 2025, 21:50:25 UTC |
| Sent | 11 Apr 2025, 22:24:06 UTC |
| Report deadline | 19 Apr 2025, 22:24:06 UTC |
| Received | 17 Apr 2025, 13:57:54 UTC |
| Server state | Over |
| Outcome | Computation error |
| Client state | Compute error |
| Exit status | -2147467259 (0x80004005) Unknown error code |
| Computer ID | 10835558 |
| Run time | 22 min 51 sec |
| CPU time | 3 min 39 sec |
| Validate state | Invalid |
| Credit | 0.00 |
| Device peak FLOPS | 41.00 GFLOPS |
| Application version | ATLAS Simulation v3.01 (vbox64_mt_mcore_atlas) windows_x86_64 |
| Peak working set size | 90.16 MB |
| Peak swap size | 91.22 MB |
| Peak disk usage | 1,018.05 MB |
Stderr output
<core_client_version>8.0.2</core_client_version>
<![CDATA[
<message>
Unspecified error
(0x80004005) - exit code 2147500037 (0x80004005)</message>
<stderr_txt>
2025-04-16 19:39:29 (10612): Detected: vboxwrapper 26206
2025-04-16 19:39:29 (10612): Detected: BOINC client v8.0.2
2025-04-16 19:39:29 (10612): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-04-16 19:39:29 (10612): Successfully copied 'init_data.xml' to the shared directory.
2025-04-16 19:39:30 (10612): Create VM. (boinc_449e7e15952e8913, slot#4)
2025-04-16 19:39:30 (10612): Setting Memory Size for VM. (4800MB)
2025-04-16 19:39:31 (10612): Setting CPU Count for VM. (8)
2025-04-16 19:39:31 (10612): Setting Chipset Options for VM.
2025-04-16 19:39:31 (10612): Setting Graphics Controller Options for VM.
2025-04-16 19:39:31 (10612): Setting Boot Options for VM.
2025-04-16 19:39:32 (10612): Setting Network Configuration for NAT.
2025-04-16 19:39:32 (10612): Enabling VM Network Access.
2025-04-16 19:39:32 (10612): Disabling USB Support for VM.
2025-04-16 19:39:33 (10612): Disabling COM Port Support for VM.
2025-04-16 19:39:33 (10612): Disabling LPT Port Support for VM.
2025-04-16 19:39:33 (10612): Disabling Audio Support for VM.
2025-04-16 19:39:34 (10612): Disabling Clipboard Support for VM.
2025-04-16 19:39:34 (10612): Disabling Drag and Drop Support for VM.
2025-04-16 19:39:35 (10612): Adding storage controller(s) to VM.
2025-04-16 19:39:35 (10612): Adding virtual disk drive to VM. (ATLAS_vbox_3.01_image.vdi)
2025-04-16 19:39:36 (10612): Adding VirtualBox Guest Additions to VM.
2025-04-16 19:39:37 (10612): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2025-04-16 19:39:37 (10612): forwarding host port 55764 to guest port 80
2025-04-16 19:39:37 (10612): Enabling remote desktop for VM.
2025-04-16 19:39:38 (10612): Required extension pack not installed, remote desktop not enabled.
2025-04-16 19:39:38 (10612): Enabling shared directory for VM.
2025-04-16 19:39:38 (10612): Starting VM using VBoxManage interface. (boinc_449e7e15952e8913, slot#4)
2025-04-16 19:39:43 (10612): Successfully started VM. (PID = '14004')
2025-04-16 19:39:43 (10612): Reporting VM Process ID to BOINC.
2025-04-16 19:39:43 (10612): Guest Log: BIOS: VirtualBox 7.0.6
2025-04-16 19:39:43 (10612): Guest Log: CPUID EDX: 0x178bfbff
2025-04-16 19:39:43 (10612): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-04-16 19:39:43 (10612): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-04-16 19:39:43 (10612): VM state change detected. (old = 'poweredoff', new = 'running')
2025-04-16 19:39:43 (10612): Detected: Web Application Enabled (http://localhost:55764)
2025-04-16 19:39:44 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:39:58 (10612): Preference change detected
2025-04-16 19:39:58 (10612): Setting CPU throttle for VM. (100%)
2025-04-16 19:39:58 (10612): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-04-16 19:39:59 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:40:00 (10612): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-04-16 19:40:00 (10612): Guest Log: BIOS: Booting from Hard Disk...
2025-04-16 19:40:03 (10612): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-04-16 19:40:03 (10612): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2025-04-16 19:40:03 (10612): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2025-04-16 19:40:03 (10612): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2025-04-16 19:40:03 (10612): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2025-04-16 19:40:03 (10612): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2025-04-16 19:40:03 (10612): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2025-04-16 19:40:03 (10612): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2025-04-16 19:40:03 (10612): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2025-04-16 19:40:03 (10612): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2025-04-16 19:40:03 (10612): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2025-04-16 19:40:03 (10612): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2025-04-16 19:40:03 (10612): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2025-04-16 19:40:03 (10612): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2025-04-16 19:40:03 (10612): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2025-04-16 19:40:03 (10612): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2025-04-16 19:40:04 (10612): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2025-04-16 19:40:04 (10612): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2025-04-16 19:40:04 (10612): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2025-04-16 19:40:04 (10612): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2025-04-16 19:40:06 (10612): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2025-04-16 19:40:06 (10612): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2025-04-16 19:40:06 (10612): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2025-04-16 19:40:06 (10612): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2025-04-16 19:40:06 (10612): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2025-04-16 19:40:06 (10612): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2025-04-16 19:40:06 (10612): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2025-04-16 19:40:06 (10612): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2025-04-16 19:40:06 (10612): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2025-04-16 19:40:06 (10612): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2025-04-16 19:40:06 (10612): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2025-04-16 19:40:06 (10612): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2025-04-16 19:40:08 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:40:28 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:40:34 (10612): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-04-16 19:40:34 (10612): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-04-16 19:40:42 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:40:58 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:41:01 (10612): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2025-04-16 19:41:01 (10612): Guest Log: 00:00:00.000169 main Log opened 2025-04-16T19:40:09.622230000Z
2025-04-16 19:41:02 (10612): Guest Log: 00:00:00.000301 main OS Product: Linux
2025-04-16 19:41:02 (10612): Guest Log: 00:00:00.000348 main OS Release: 3.10.0-957.27.2.el7.x86_64
2025-04-16 19:41:02 (10612): Guest Log: 00:00:00.000381 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2025-04-16 19:41:02 (10612): Guest Log: 00:00:00.000412 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2025-04-16 19:41:02 (10612): Guest Log: 00:00:00.000413 main Process ID: 1365
2025-04-16 19:41:02 (10612): Guest Log: 00:00:00.000413 main Package type: LINUX_64BITS_GENERIC
2025-04-16 19:41:02 (10612): Guest Log: 00:00:00.001653 main 5.2.32 r132073 started. Verbose level = 0
2025-04-16 19:41:02 (10612): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch...
2025-04-16 19:41:02 (10612): Guest Log: [INFO] Mounting shared directory
2025-04-16 19:41:02 (10612): Guest Log: [INFO] Checking for init_data.xml
2025-04-16 19:41:08 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:41:28 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:41:31 (10612): Guest Log: 00:00:10.060229 timesync vgsvcTimeSyncWorker: Radical guest time change: -3 538 717 760 000ns (GuestNow=1 744 828 870 917 061 000 ns GuestLast=1 744 832 409 634 821 000 ns fSetTimeLastLoop=true )
2025-04-16 19:41:38 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:41:58 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:42:08 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:42:28 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:42:39 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:42:58 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:43:08 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:43:28 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:43:38 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:43:58 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:44:06 (10612): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK
2025-04-16 19:44:06 (10612): Guest Log: [INFO] Detected branch: prod
2025-04-16 19:44:06 (10612): Guest Log: This is the prod version of the ATLAS job wrapper
2025-04-16 19:44:07 (10612): Guest Log: Copying input files
2025-04-16 19:44:09 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:44:29 (10612): Guest Log: Copied input files into RunAtlas.
2025-04-16 19:44:29 (10612): Guest Log: This VM did not configure a local http proxy via BOINC.
2025-04-16 19:44:29 (10612): Guest Log: Small home clusters do not require a local http proxy but it is suggested if
2025-04-16 19:44:29 (10612): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
2025-04-16 19:44:29 (10612): Guest Log: Further information can be found at the LHC@home message board.
2025-04-16 19:44:29 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:44:38 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:44:58 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:45:08 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:45:28 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:45:38 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:45:58 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:46:08 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:46:29 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:46:39 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:46:59 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:47:08 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:47:28 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:47:38 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:47:58 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:48:00 (10612): Guest Log: Running cvmfs_config stat atlas.cern.ch
2025-04-16 19:48:00 (10612): 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-04-16 19:48:02 (10612): Guest Log: 2.6.3.0 1681 1 31616 144935 3 1 3117322 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch http://128.142.35.143:3126 1
2025-04-16 19:48:02 (10612): Guest Log: copied the webapp to /var/www
2025-04-16 19:48:02 (10612): Guest Log: ATHENA_PROC_NUMBER=8
2025-04-16 19:48:02 (10612): Guest Log: ATHENA_CORE_NUMBER=8
2025-04-16 19:48:02 (10612): 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-04-16 19:48:02 (10612): Guest Log: *** Starting ATLAS job. (PandaID=6600379218 taskID=44075164) ***
2025-04-16 19:48:09 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:48:29 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:48:39 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:48:59 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:49:08 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:49:28 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:49:38 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:49:58 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:50:08 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:50:28 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:50:39 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:50:59 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:51:08 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:51:28 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:51:38 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:51:58 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:52:08 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:52:28 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:52:39 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:52:59 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:53:09 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:53:29 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:53:38 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:53:59 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:54:08 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:54:28 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:54:39 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:54:59 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:55:09 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:55:29 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:55:39 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:55:59 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:56:08 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:56:29 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:56:39 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:56:59 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:57:08 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:57:29 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:57:39 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:57:59 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:58:09 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:58:29 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:58:39 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:58:59 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:59:09 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:59:29 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:59:39 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:59:59 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:00:09 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:00:30 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:00:39 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:00:59 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:01:09 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:01:29 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:01:39 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:01:59 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:02:09 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:02:29 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:02:39 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:02:59 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:03:10 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:03:30 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:03:40 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:04:00 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:04:09 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:04:29 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:04:40 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:05:00 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:05:10 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:05:30 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:05:40 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:06:00 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:06:10 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:06:30 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:06:40 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:07:00 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:07:11 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:07:31 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:07:40 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:08:00 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:08:10 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:08:30 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:08:41 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:09:03 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:09:10 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:09:30 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:09:40 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:10:00 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:10:10 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:10:30 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:10:40 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:11:00 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:11:11 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:11:30 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:11:40 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:12:00 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:12:11 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:12:31 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:12:40 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:13:04 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:13:10 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:13:31 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:13:40 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:14:00 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:14:10 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:14:31 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:14:41 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:15:01 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:15:11 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:15:31 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:15:40 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:16:01 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:16:11 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:16:32 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:16:56 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:17:00 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:17:11 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:17:31 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:17:41 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:18:01 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:18:11 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:18:31 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:18:41 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:19:01 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:19:11 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:19:31 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:19:41 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:20:01 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:20:10 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:20:31 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:20:41 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:21:01 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:21:11 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:21:32 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:21:41 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:22:02 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:22:11 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:22:31 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:22:41 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:23:01 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:23:11 (10612): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:23:31 (10612): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:23:34 (10612): Stopping VM.
2025-04-16 20:23:41 (10612): Successfully stopped VM.
2025-04-16 20:29:58 (17196): Detected: vboxwrapper 26206
2025-04-16 20:29:58 (17196): Detected: BOINC client v8.0.2
2025-04-16 20:29:58 (17196): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-04-16 20:29:59 (17196): Guest Log: BIOS: VirtualBox 7.0.6
2025-04-16 20:29:59 (17196): Guest Log: CPUID EDX: 0x178bfbff
2025-04-16 20:29:59 (17196): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-04-16 20:29:59 (17196): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-04-16 20:29:59 (17196): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-04-16 20:29:59 (17196): Guest Log: BIOS: Booting from Hard Disk...
2025-04-16 20:29:59 (17196): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-04-16 20:29:59 (17196): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2025-04-16 20:29:59 (17196): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2025-04-16 20:29:59 (17196): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-04-16 20:29:59 (17196): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-04-16 20:29:59 (17196): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2025-04-16 20:29:59 (17196): Guest Log: 00:00:00.000169 main Log opened 2025-04-16T19:40:09.622230000Z
2025-04-16 20:29:59 (17196): Guest Log: 00:00:00.000301 main OS Product: Linux
2025-04-16 20:29:59 (17196): Guest Log: 00:00:00.000348 main OS Release: 3.10.0-957.27.2.el7.x86_64
2025-04-16 20:29:59 (17196): Guest Log: 00:00:00.000381 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2025-04-16 20:29:59 (17196): Guest Log: 00:00:00.000412 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2025-04-16 20:29:59 (17196): Guest Log: 00:00:00.000413 main Process ID: 1365
2025-04-16 20:29:59 (17196): Guest Log: 00:00:00.000413 main Package type: LINUX_64BITS_GENERIC
2025-04-16 20:29:59 (17196): Guest Log: 00:00:00.001653 main 5.2.32 r132073 started. Verbose level = 0
2025-04-16 20:29:59 (17196): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch...
2025-04-16 20:29:59 (17196): Guest Log: [INFO] Mounting shared directory
2025-04-16 20:29:59 (17196): Guest Log: [INFO] Checking for init_data.xml
2025-04-16 20:29:59 (17196): Guest Log: 00:00:10.060229 timesync vgsvcTimeSyncWorker: Radical guest time change: -3 538 717 760 000ns (GuestNow=1 744 828 870 917 061 000 ns GuestLast=1 744 832 409 634 821 000 ns fSetTimeLastLoop=true )
2025-04-16 20:29:59 (17196): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK
2025-04-16 20:29:59 (17196): Guest Log: [INFO] Detected branch: prod
2025-04-16 20:29:59 (17196): Guest Log: This is the prod version of the ATLAS job wrapper
2025-04-16 20:29:59 (17196): Guest Log: Copying input files
2025-04-16 20:29:59 (17196): Guest Log: Copied input files into RunAtlas.
2025-04-16 20:29:59 (17196): Guest Log: This VM did not configure a local http proxy via BOINC.
2025-04-16 20:29:59 (17196): Guest Log: Small home clusters do not require a local http proxy but it is suggested if
2025-04-16 20:29:59 (17196): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
2025-04-16 20:29:59 (17196): Guest Log: Further information can be found at the LHC@home message board.
2025-04-16 20:29:59 (17196): Guest Log: Running cvmfs_config stat atlas.cern.ch
2025-04-16 20:29:59 (17196): 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-04-16 20:29:59 (17196): Guest Log: 2.6.3.0 1681 1 31616 144935 3 1 3117322 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch http://128.142.35.143:3126 1
2025-04-16 20:29:59 (17196): Guest Log: copied the webapp to /var/www
2025-04-16 20:29:59 (17196): Guest Log: ATHENA_PROC_NUMBER=8
2025-04-16 20:29:59 (17196): Guest Log: ATHENA_CORE_NUMBER=8
2025-04-16 20:29:59 (17196): 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-04-16 20:29:59 (17196): Guest Log: *** Starting ATLAS job. (PandaID=6600379218 taskID=44075164) ***
2025-04-16 20:29:59 (17196): Starting VM using VBoxManage interface. (boinc_449e7e15952e8913, slot#4)
2025-04-16 20:30:06 (17196): Successfully started VM. (PID = '9652')
2025-04-16 20:30:06 (17196): Reporting VM Process ID to BOINC.
2025-04-16 20:30:06 (17196): VM state change detected. (old = 'poweredoff', new = 'running')
2025-04-16 20:30:06 (17196): Detected: Web Application Enabled (http://localhost:55764)
2025-04-16 20:30:06 (17196): Preference change detected
2025-04-16 20:30:06 (17196): Setting CPU throttle for VM. (100%)
2025-04-16 20:30:07 (17196): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-04-16 20:30:26 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:30:46 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:30:56 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:31:16 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:31:25 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:31:45 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:31:55 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:32:16 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:32:26 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:32:46 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:32:55 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:33:16 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:33:25 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:33:45 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:34:18 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:34:38 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:34:45 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:35:05 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:35:16 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:35:36 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:35:46 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:36:06 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:36:16 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:36:38 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:36:46 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:37:06 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:37:15 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:37:35 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:37:46 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:38:06 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:38:16 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:38:36 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:38:46 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:39:06 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:39:16 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:39:42 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:39:47 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:40:07 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:40:16 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:40:36 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:40:46 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:41:06 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:41:16 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:41:36 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:41:46 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:42:06 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:42:16 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:42:36 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:42:45 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:43:07 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:43:16 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:43:36 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:43:46 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:44:06 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:44:16 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:44:36 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:44:46 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:45:06 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:45:16 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:45:36 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:45:47 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:46:07 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:46:16 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:46:36 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:46:46 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:47:06 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:47:16 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:47:36 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:47:47 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:48:07 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:48:17 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:48:37 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:48:46 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:49:06 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:49:16 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:49:36 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:49:46 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:50:06 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:50:17 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:50:37 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:50:47 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:51:07 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:51:16 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:51:36 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:51:46 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:52:06 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:52:16 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:52:36 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:52:47 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:53:07 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:53:17 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:53:37 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:53:46 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:54:06 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:54:16 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:54:36 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:54:46 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:55:07 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:55:17 (17196): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:55:37 (17196): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:55:43 (17196): Stopping VM.
2025-04-16 20:56:00 (17196): Successfully stopped VM.
2025-04-16 23:45:51 (13344): Detected: vboxwrapper 26206
2025-04-16 23:45:51 (13344): Detected: BOINC client v8.0.2
2025-04-16 23:45:52 (13344): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-04-16 23:45:52 (13344): Starting VM using VBoxManage interface. (boinc_449e7e15952e8913, slot#4)
2025-04-16 23:46:15 (13344): Error in start VM for VM: -2147467259
Command:
VBoxManage -q startvm "boinc_449e7e15952e8913" --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_449e7e15952e8913" to power on...
2025-04-16 23:46:15 (13344): VM failed to start.
2025-04-16 23:46:15 (13344): Could not start
2025-04-16 23:46:15 (13344): ERROR: VM failed to start
2025-04-16 23:46:15 (13344): Powering off VM.
2025-04-16 23:46:15 (13344): Deregistering VM. (boinc_449e7e15952e8913, slot#4)
2025-04-16 23:46:15 (13344): Removing network bandwidth throttle group from VM.
2025-04-16 23:46:15 (13344): Removing VM from VirtualBox.
Hypervisor System Log:
00:00:18.545929 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:23.674101 Watcher Saving settings file "C:\ProgramData\BOINC\slots\4\boinc_449e7e15952e8913\boinc_449e7e15952e8913.vbox" with version "1.19-windows"
00:00:23.680134 Watcher Finished saving settings file "C:\ProgramData\BOINC\slots\4\boinc_449e7e15952e8913\boinc_449e7e15952e8913.vbox"
00:00:23.740084 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:23.740106 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:23.740115 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:23.740121 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:23.740126 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:23.740130 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:23.741236 Watcher Reaper: Pid 2896 (0xb50) exited normally: -2147483645 (0x80000003)
00:00:23.741663 ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
00:00:23.769421 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:23.769445 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:23.769452 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:23.769457 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:23.769462 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:23.769467 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:23.772488 Saving settings file "C:\ProgramData\BOINC\slots\4\boinc_449e7e15952e8913\boinc_449e7e15952e8913.vbox" with version "1.19-windows"
00:00:23.776344 Finished saving settings file "C:\ProgramData\BOINC\slots\4\boinc_449e7e15952e8913\boinc_449e7e15952e8913.vbox"
00:00:24.028456 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:24.028475 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:24.028482 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:24.028487 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:24.028491 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:24.028496 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:24.029264 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:24.029284 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:24.029291 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:24.029296 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:24.029300 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:24.029305 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:24.030847 Saving settings file "C:\Users\hairy\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:00:24.033541 Finished saving settings file "C:\Users\hairy\.VirtualBox\VirtualBox.xml"
00:00:24.034209 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:24.034249 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:24.034264 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:24.034275 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:24.034285 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:24.034294 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:24.034939 DeleteVM Saving settings file "C:\ProgramData\BOINC\slots\18\boinc_563dfa4cbdf9f534\boinc_563dfa4cbdf9f534.vbox" with version "1.19-windows"
00:00:24.039602 DeleteVM Finished saving settings file "C:\ProgramData\BOINC\slots\18\boinc_563dfa4cbdf9f534\boinc_563dfa4cbdf9f534.vbox"
VM Execution Log:
VM Startup Log:
VM Trace Log:
Port count: 255
Maximum Devices per NVMe Port: 1
Maximum virtio-scsi PIIX3 Controllers: 1
Maximum virtio-scsi ICH9 Controllers: 8
Maximum virtio-scsi Port count: 256
Maximum Devices per virtio-scsi Port: 1
Maximum PIIX3 Floppy Controllers:1
Maximum ICH9 Floppy Controllers: 1
Maximum Floppy Port count: 1
Maximum Devices per Floppy Port: 2
Default machine folder: C:\Users\hairy\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-04-16 23:45:52 (13344):
Command: VBoxManage -q list hostinfo
Exit Code: 0
Output:
Host Information:
Host time: 2025-04-16T22:45:52.173000000Z
Processor online count: 16
Processor count: 16
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: 13th Gen Intel(R) Core(TM) i5-13400F
Processor#1 speed: unknown
Processor#1 description: 13th Gen Intel(R) Core(TM) i5-13400F
Processor#2 speed: unknown
Processor#2 description: 13th Gen Intel(R) Core(TM) i5-13400F
Processor#3 speed: unknown
Processor#3 description: 13th Gen Intel(R) Core(TM) i5-13400F
Processor#4 speed: unknown
Processor#4 description: 13th Gen Intel(R) Core(TM) i5-13400F
Processor#5 speed: unknown
Processor#5 description: 13th Gen Intel(R) Core(TM) i5-13400F
Processor#6 speed: unknown
Processor#6 description: 13th Gen Intel(R) Core(TM) i5-13400F
Processor#7 speed: unknown
Processor#7 description: 13th Gen Intel(R) Core(TM) i5-13400F
Processor#8 speed: unknown
Processor#8 description: 13th Gen Intel(R) Core(TM) i5-13400F
Processor#9 speed: unknown
Processor#9 description: 13th Gen Intel(R) Core(TM) i5-13400F
Processor#10 speed: unknown
Processor#10 description: 13th Gen Intel(R) Core(TM) i5-13400F
Processor#11 speed: unknown
Processor#11 description: 13th Gen Intel(R) Core(TM) i5-13400F
Processor#12 speed: unknown
Processor#12 description: 13th Gen Intel(R) Core(TM) i5-13400F
Processor#13 speed: unknown
Processor#13 description: 13th Gen Intel(R) Core(TM) i5-13400F
Processor#14 speed: unknown
Processor#14 description: 13th Gen Intel(R) Core(TM) i5-13400F
Processor#15 speed: unknown
Processor#15 description: 13th Gen Intel(R) Core(TM) i5-13400F
Memory size: 65379 MByte
Memory available: 55404 MByte
Operating system: Windows 11
Operating system version: 10.0.26100
2025-04-16 23:45:52 (13344):
Command: VBoxManage -q showvminfo "boinc_449e7e15952e8913" --machinereadable
Exit Code: 0
Output:
name="boinc_449e7e15952e8913"
Encryption: disabled
groups="/"
ostype="Linux 2.6 / 3.x / 4.x / 5.x (64-bit)"
UUID="c32c0d09-8ea1-4e8b-8b3a-3a446b28c3e2"
CfgFile="C:\\ProgramData\\BOINC\\slots\\4\\boinc_449e7e15952e8913\\boinc_449e7e15952e8913.vbox"
SnapFldr="C:\\ProgramData\\BOINC\\slots\\4\\boinc_449e7e15952e8913\\Snapshots"
LogFldr="C:\\ProgramData\\BOINC\\slots\\4\\boinc_449e7e15952e8913\\Logs"
hardwareuuid="c32c0d09-8ea1-4e8b-8b3a-3a446b28c3e2"
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\\4\\boinc_449e7e15952e8913\\boinc_449e7e15952e8913.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-04-16T19:56:00.000000000"
VMStateFile="C:\ProgramData\BOINC\slots\4\boinc_449e7e15952e8913\Snapshots\2025-04-16T19-55-43-218400200Z.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\\4\\boinc_449e7e15952e8913\\Snapshots\\{8bf3d5ea-7fc0-46a2-b194-1864e0fdeb7e}.vdi"
"Hard Disk Controller-ImageUUID-0-0"="8bf3d5ea-7fc0-46a2-b194-1864e0fdeb7e"
"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"="e4aac2e7-294f-4a85-80ba-c872de205c15"
"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="08002706F00F"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="tcp_55764_80,tcp,127.0.0.1,55764,,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_449e7e15952e8913_net",Network,1099511627776
SharedFolderNameMachineMapping1="shared"
SharedFolderPathMachineMapping1="C:\\ProgramData\\BOINC\\slots\\4\\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\\4\\boinc_449e7e15952e8913\\boinc_449e7e15952e8913-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="gBeMDmBQbN7n9Rq4apOajLDm4fhM0noT9bVoFjIUDmpJxKDm0VR43m_0"
GuestMemoryBalloon=0
2025-04-16 23:46:15 (13344):
Command: VBoxManage -q startvm "boinc_449e7e15952e8913" --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_449e7e15952e8913" to power on...
2025-04-16 23:46:15 (13344):
Command: VBoxManage -q snapshot "boinc_449e7e15952e8913" list
Exit Code: -108
Output:
This machine does not have any snapshots
2025-04-16 23:46:15 (13344):
Command: VBoxManage -q bandwidthctl "boinc_449e7e15952e8913" remove "boinc_449e7e15952e8913_net"
Exit Code: 0
Output:
2025-04-16 23:46:15 (13344):
Command: VBoxManage -q unregistervm "boinc_449e7e15952e8913" --delete
Exit Code: 0
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...100%
23:46:26 (13344): called boinc_finish(-2147467259)
</stderr_txt>
]]>
©2025 CERN