| Name | rdnNDmdL3Q8nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmsGZNDmR7wnpm_0 |
| Workunit | 235687333 |
| Created | 9 Oct 2025, 10:49:30 UTC |
| Sent | 9 Oct 2025, 11:33:21 UTC |
| Report deadline | 17 Oct 2025, 11:33:21 UTC |
| Received | 11 Oct 2025, 0:03:24 UTC |
| Server state | Over |
| Outcome | Computation error |
| Client state | Compute error |
| Exit status | 0 (0x00000000) |
| Computer ID | 10841080 |
| Run time | 11 hours 20 min 1 sec |
| CPU time | 11 hours 20 min 1 sec |
| Validate state | Invalid |
| Credit | 0.00 |
| Device peak FLOPS | 3.52 GFLOPS |
| Application version | ATLAS Simulation v3.03 (vbox64_mt_mcore_atlas) windows_x86_64 |
| Peak working set size | 70.18 MB |
| Peak swap size | 142.24 MB |
| Peak disk usage | 7.17 GB |
Stderr output
<core_client_version>7.16.11</core_client_version> <![CDATA[ <stderr_txt> (23452): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 14:17:41 (23452): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 14:17:57 (23452): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 14:18:11 (23452): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 14:18:20 (23452): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 14:18:31 (23452): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 14:18:41 (23452): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 14:19:01 (23452): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 14:19:14 (23452): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 14:19:31 (23452): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 14:19:44 (23452): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 14:20:01 (23452): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 14:20:11 (23452): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 14:20:36 (23452): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 14:20:41 (23452): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 14:21:02 (23452): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 14:21:25 (23452): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 14:21:43 (23452): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 14:21:51 (23452): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 14:22:01 (23452): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 14:22:12 (23452): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 14:22:31 (23452): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 14:22:41 (23452): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 14:23:17 (23452): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 14:23:25 (23452): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 14:24:32 (23452): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 14:24:56 (23452): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 14:25:42 (23452): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 14:25:52 (23452): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 14:26:02 (23452): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 14:26:12 (23452): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 14:26:22 (23452): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 14:26:32 (23452): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 14:27:43 (23452): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 14:27:52 (23452): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 14:29:33 (23452): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 14:29:47 (23452): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 14:30:08 (23452): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 14:30:08 (23452): Stopping VM. 2025-10-10 15:11:01 (3320): vboxwrapper version 26210 2025-10-10 15:11:01 (3320): BOINC client version: 7.16.11 2025-10-10 15:11:03 (3320): Detected: VirtualBox VboxManage Interface (Version: 7.2.2) 2025-10-10 15:11:04 (3320): Guest Log: 00:04:22.182468 timesync vgsvcTimeSyncWorker: Radical host time change: 6 409 206 000 000ns (HostNow=1 760 119 871 236 000 000 ns HostLast=1 760 113 462 030 000 000 ns) 2025-10-10 15:11:04 (3320): Guest Log: 00:04:32.184328 timesync vgsvcTimeSyncWorker: Radical guest time change: 6 767 052 380 000ns (GuestNow=1 760 119 881 237 893 000 ns GuestLast=1 760 113 114 185 513 000 ns fSetTimeLastLoop=true ) 2025-10-10 15:11:04 (3320): Starting VM using VBoxManage interface. (boinc_4964bc76863ec1be, slot#0) 2025-10-10 15:11:14 (3320): Successfully started VM. (PID = '17672') 2025-10-10 15:11:14 (3320): Reporting VM Process ID to BOINC. 2025-10-10 15:11:14 (3320): Guest Log: BIOS: VirtualBox 7.2.2 2025-10-10 15:11:14 (3320): Guest Log: CPUID EDX: 0x178bfbff 2025-10-10 15:11:14 (3320): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-10-10 15:11:14 (3320): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-10-10 15:11:14 (3320): VM state change detected. (old = 'poweredoff', new = 'running') 2025-10-10 15:11:14 (3320): Detected: Web Application Enabled (http://localhost:63489) 2025-10-10 15:11:14 (3320): Detected: Remote Desktop Enabled (localhost:63498) 2025-10-10 15:11:15 (3320): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 15:11:20 (3320): Status Report: Elapsed Time: '36710.325559' 2025-10-10 15:11:20 (3320): Status Report: CPU Time: '40002.687500' 2025-10-10 15:11:20 (3320): Preference change detected 2025-10-10 15:11:20 (3320): Setting CPU throttle for VM. (100%) 2025-10-10 15:11:21 (3320): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 900 seconds)) 2025-10-10 15:11:21 (3320): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 15:11:22 (3320): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-10-10 15:11:22 (3320): Guest Log: BIOS: Booting from Hard Disk... 2025-10-10 15:11:29 (3320): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-10-10 15:11:29 (3320): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2025-10-10 15:11:29 (3320): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2025-10-10 15:11:31 (3320): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 15:12:22 (3320): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 15:12:30 (3320): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-10-10 15:12:30 (3320): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-10-10 15:12:32 (3320): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 15:12:41 (3320): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 15:12:52 (3320): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 15:13:16 (3320): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 15:13:22 (3320): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 15:13:36 (3320): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 15:13:43 (3320): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2025-10-10 15:13:43 (3320): Guest Log: 00:00:00.001964 main Log opened 2025-10-10T15:12:07.662758000Z 2025-10-10 15:13:43 (3320): Guest Log: 00:00:00.002520 main OS Product: Linux 2025-10-10 15:13:43 (3320): Guest Log: 00:00:00.002624 main OS Release: 3.10.0-957.27.2.el7.x86_64 2025-10-10 15:13:43 (3320): Guest Log: 00:00:00.002754 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2025-10-10 15:13:43 (3320): Guest Log: 00:00:00.002837 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2025-10-10 15:13:43 (3320): Guest Log: 00:00:00.002838 main Process ID: 1244 2025-10-10 15:13:44 (3320): Guest Log: 00:00:00.002839 main Package type: LINUX_64BITS_GENERIC 2025-10-10 15:13:44 (3320): Guest Log: 00:00:00.006174 main 5.2.32 r132073 started. Verbose level = 0 2025-10-10 15:13:52 (3320): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2025-10-10 15:13:52 (3320): Guest Log: [INFO] Mounting shared directory 2025-10-10 15:13:52 (3320): Guest Log: [INFO] Checking for init_data.xml 2025-10-10 15:13:52 (3320): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 15:14:21 (3320): Guest Log: 00:00:10.077519 timesync vgsvcTimeSyncWorker: Radical guest time change: 14 505 294 936 000ns (GuestNow=1 760 123 633 032 296 000 ns GuestLast=1 760 109 127 737 360 000 ns fSetTimeLastLoop=true ) 2025-10-10 15:14:21 (3320): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 15:14:27 (3320): Preference change detected 2025-10-10 15:14:27 (3320): Setting CPU throttle for VM. (100%) 2025-10-10 15:14:28 (3320): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 900 seconds)) 2025-10-10 15:14:32 (3320): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 15:15:12 (3320): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 15:15:21 (3320): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2025-10-10 15:15:21 (3320): Guest Log: [INFO] Detected branch: prod 2025-10-10 15:15:22 (3320): Guest Log: This is the prod version of the ATLAS job wrapper 2025-10-10 15:15:22 (3320): Guest Log: Copying input files 2025-10-10 15:15:22 (3320): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 15:15:33 (3320): Guest Log: Copied input files into RunAtlas. 2025-10-10 15:15:33 (3320): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 15:15:34 (3320): Guest Log: This VM did not configure a local http proxy via BOINC. 2025-10-10 15:15:34 (3320): Guest Log: Small home clusters do not require a local http proxy but it is suggested if 2025-10-10 15:15:34 (3320): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks. 2025-10-10 15:15:34 (3320): Guest Log: Further information can be found at the LHC@home message board. 2025-10-10 15:15:42 (3320): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 15:16:02 (3320): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 15:16:12 (3320): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 15:16:22 (3320): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 15:16:33 (3320): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 15:17:14 (3320): Guest Log: Running cvmfs_config stat atlas.cern.ch 2025-10-10 15:17:14 (3320): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 15:17:15 (3320): 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-10-10 15:17:15 (3320): Guest Log: 2.6.3.0 1525 0 30060 151559 3 1 4086897 4096001 0 65024 0 0 n/a 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1 2025-10-10 15:17:21 (3320): Guest Log: copied the webapp to /var/www 2025-10-10 15:17:22 (3320): Guest Log: core_number=1 2025-10-10 15:17:22 (3320): 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-10-10 15:17:22 (3320): Guest Log: *** Starting ATLAS job. (PandaID=6837328490 taskID=46676269) *** 2025-10-10 15:17:24 (3320): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 15:18:12 (3320): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 15:18:12 (3320): Stopping VM. 2025-10-10 15:18:29 (3320): Successfully stopped VM. 2025-10-10 16:43:12 (12676): vboxwrapper version 26210 2025-10-10 16:43:12 (12676): BOINC client version: 7.16.11 2025-10-10 16:43:14 (12676): Detected: VirtualBox VboxManage Interface (Version: 7.2.2) 2025-10-10 16:43:15 (12676): Guest Log: BIOS: VirtualBox 7.2.2 2025-10-10 16:43:15 (12676): Guest Log: CPUID EDX: 0x178bfbff 2025-10-10 16:43:15 (12676): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-10-10 16:43:15 (12676): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-10-10 16:43:15 (12676): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-10-10 16:43:15 (12676): Guest Log: BIOS: Booting from Hard Disk... 2025-10-10 16:43:15 (12676): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-10-10 16:43:15 (12676): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2025-10-10 16:43:15 (12676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2025-10-10 16:43:15 (12676): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-10-10 16:43:15 (12676): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-10-10 16:43:15 (12676): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2025-10-10 16:43:15 (12676): Guest Log: 00:00:00.001964 main Log opened 2025-10-10T15:12:07.662758000Z 2025-10-10 16:43:15 (12676): Guest Log: 00:00:00.002520 main OS Product: Linux 2025-10-10 16:43:15 (12676): Guest Log: 00:00:00.002624 main OS Release: 3.10.0-957.27.2.el7.x86_64 2025-10-10 16:43:15 (12676): Guest Log: 00:00:00.002754 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2025-10-10 16:43:15 (12676): Guest Log: 00:00:00.002837 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2025-10-10 16:43:15 (12676): Guest Log: 00:00:00.002838 main Process ID: 1244 2025-10-10 16:43:15 (12676): Guest Log: 00:00:00.002839 main Package type: LINUX_64BITS_GENERIC 2025-10-10 16:43:15 (12676): Guest Log: 00:00:00.006174 main 5.2.32 r132073 started. Verbose level = 0 2025-10-10 16:43:15 (12676): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2025-10-10 16:43:15 (12676): Guest Log: [INFO] Mounting shared directory 2025-10-10 16:43:15 (12676): Guest Log: [INFO] Checking for init_data.xml 2025-10-10 16:43:15 (12676): Guest Log: 00:00:10.077519 timesync vgsvcTimeSyncWorker: Radical guest time change: 14 505 294 936 000ns (GuestNow=1 760 123 633 032 296 000 ns GuestLast=1 760 109 127 737 360 000 ns fSetTimeLastLoop=true ) 2025-10-10 16:43:15 (12676): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2025-10-10 16:43:15 (12676): Guest Log: [INFO] Detected branch: prod 2025-10-10 16:43:15 (12676): Guest Log: This is the prod version of the ATLAS job wrapper 2025-10-10 16:43:15 (12676): Guest Log: Copying input files 2025-10-10 16:43:15 (12676): Guest Log: Copied input files into RunAtlas. 2025-10-10 16:43:15 (12676): Guest Log: This VM did not configure a local http proxy via BOINC. 2025-10-10 16:43:15 (12676): Guest Log: Small home clusters do not require a local http proxy but it is suggested if 2025-10-10 16:43:15 (12676): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks. 2025-10-10 16:43:15 (12676): Guest Log: Further information can be found at the LHC@home message board. 2025-10-10 16:43:15 (12676): Guest Log: Running cvmfs_config stat atlas.cern.ch 2025-10-10 16:43:15 (12676): 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-10-10 16:43:15 (12676): Guest Log: 2.6.3.0 1525 0 30060 151559 3 1 4086897 4096001 0 65024 0 0 n/a 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1 2025-10-10 16:43:15 (12676): Guest Log: copied the webapp to /var/www 2025-10-10 16:43:15 (12676): Guest Log: core_number=1 2025-10-10 16:43:15 (12676): 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-10-10 16:43:15 (12676): Guest Log: *** Starting ATLAS job. (PandaID=6837328490 taskID=46676269) *** 2025-10-10 16:43:15 (12676): Starting VM using VBoxManage interface. (boinc_4964bc76863ec1be, slot#0) 2025-10-10 16:43:29 (12676): Successfully started VM. (PID = '5208') 2025-10-10 16:43:29 (12676): Reporting VM Process ID to BOINC. 2025-10-10 16:43:29 (12676): VM state change detected. (old = 'poweredoff', new = 'running') 2025-10-10 16:43:29 (12676): Detected: Web Application Enabled (http://localhost:63489) 2025-10-10 16:43:29 (12676): Detected: Remote Desktop Enabled (localhost:63498) 2025-10-10 16:43:30 (12676): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 16:43:33 (12676): Status Report: Elapsed Time: '36803.788780' 2025-10-10 16:43:33 (12676): Status Report: CPU Time: '40106.375000' 2025-10-10 16:43:33 (12676): Preference change detected 2025-10-10 16:43:33 (12676): Setting CPU throttle for VM. (100%) 2025-10-10 16:43:34 (12676): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 900 seconds)) 2025-10-10 16:43:34 (12676): Guest Log: 00:01:20.097032 timesync vgsvcTimeSyncWorker: Radical host time change: 5 175 542 000 000ns (HostNow=1 760 129 014 150 000 000 ns HostLast=1 760 123 838 608 000 000 ns) 2025-10-10 16:43:34 (12676): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 16:43:44 (12676): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 16:44:03 (12676): Guest Log: 00:01:30.662468 timesync vgsvcTimeSyncWorker: Radical guest time change: 5 321 663 030 000ns (GuestNow=1 760 129 024 715 174 000 ns GuestLast=1 760 123 703 052 144 000 ns fSetTimeLastLoop=true ) 2025-10-10 16:44:03 (12676): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 16:44:13 (12676): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 16:44:33 (12676): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 16:44:45 (12676): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 16:45:34 (12676): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 16:45:44 (12676): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 16:45:54 (12676): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 16:46:04 (12676): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 16:46:38 (12676): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 16:46:46 (12676): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 16:47:09 (12676): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 16:47:14 (12676): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 16:47:36 (12676): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 16:47:44 (12676): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 16:48:04 (12676): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 16:48:15 (12676): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 16:49:04 (12676): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 16:49:14 (12676): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 16:49:34 (12676): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 16:49:45 (12676): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 16:49:54 (12676): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 16:50:05 (12676): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 16:50:15 (12676): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 16:50:24 (12676): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 16:51:29 (12676): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 16:51:39 (12676): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 16:51:54 (12676): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 16:52:04 (12676): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 16:52:25 (12676): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 16:52:40 (12676): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 16:52:54 (12676): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 16:53:15 (12676): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 16:53:39 (12676): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 16:53:45 (12676): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 16:54:30 (12676): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 16:54:36 (12676): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 16:55:35 (12676): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 16:55:45 (12676): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 16:56:05 (12676): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 16:56:14 (12676): Stopping VM. 2025-10-10 16:56:30 (12676): Successfully stopped VM. 2025-10-10 17:05:12 (22696): vboxwrapper version 26210 2025-10-10 17:05:12 (22696): BOINC client version: 7.16.11 2025-10-10 17:05:14 (22696): Detected: VirtualBox VboxManage Interface (Version: 7.2.2) 2025-10-10 17:05:15 (22696): Guest Log: 00:01:20.097032 timesync vgsvcTimeSyncWorker: Radical host time change: 5 175 542 000 000ns (HostNow=1 760 129 014 150 000 000 ns HostLast=1 760 123 838 608 000 000 ns) 2025-10-10 17:05:15 (22696): Guest Log: 00:01:30.662468 timesync vgsvcTimeSyncWorker: Radical guest time change: 5 321 663 030 000ns (GuestNow=1 760 129 024 715 174 000 ns GuestLast=1 760 123 703 052 144 000 ns fSetTimeLastLoop=true ) 2025-10-10 17:05:15 (22696): Starting VM using VBoxManage interface. (boinc_4964bc76863ec1be, slot#0) 2025-10-10 17:05:34 (22696): Successfully started VM. (PID = '20344') 2025-10-10 17:05:34 (22696): Reporting VM Process ID to BOINC. 2025-10-10 17:05:34 (22696): VM state change detected. (old = 'poweredoff', new = 'running') 2025-10-10 17:05:34 (22696): Detected: Web Application Enabled (http://localhost:63489) 2025-10-10 17:05:34 (22696): Detected: Remote Desktop Enabled (localhost:63498) 2025-10-10 17:05:35 (22696): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:05:39 (22696): Status Report: Elapsed Time: '36983.143392' 2025-10-10 17:05:39 (22696): Status Report: CPU Time: '40322.140625' 2025-10-10 17:05:39 (22696): Preference change detected 2025-10-10 17:05:39 (22696): Setting CPU throttle for VM. (100%) 2025-10-10 17:05:41 (22696): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 900 seconds)) 2025-10-10 17:05:41 (22696): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:05:49 (22696): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:05:59 (22696): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:06:14 (22696): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:06:30 (22696): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:06:39 (22696): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:06:59 (22696): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:07:09 (22696): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:07:34 (22696): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:07:40 (22696): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:07:55 (22696): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:08:00 (22696): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:08:10 (22696): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:08:19 (22696): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:08:29 (22696): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:08:39 (22696): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:09:00 (22696): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:09:10 (22696): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:09:24 (22696): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:09:30 (22696): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:09:40 (22696): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:09:52 (22696): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:10:26 (22696): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:10:33 (22696): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:10:54 (22696): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:11:01 (22696): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:11:24 (22696): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:11:39 (22696): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:11:55 (22696): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:12:01 (22696): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:12:22 (22696): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:12:32 (22696): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:13:01 (22696): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:13:14 (22696): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:13:51 (22696): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:14:02 (22696): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:14:30 (22696): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:14:40 (22696): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:15:21 (22696): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:15:34 (22696): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:16:01 (22696): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:16:15 (22696): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:16:31 (22696): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:16:55 (22696): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:17:20 (22696): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:17:31 (22696): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:18:09 (22696): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:18:09 (22696): Stopping VM. 2025-10-10 17:18:59 (22696): Successfully stopped VM. 2025-10-10 17:29:37 (4636): vboxwrapper version 26210 2025-10-10 17:29:37 (4636): BOINC client version: 7.16.11 2025-10-10 17:29:39 (4636): Detected: VirtualBox VboxManage Interface (Version: 7.2.2) 2025-10-10 17:29:40 (4636): Starting VM using VBoxManage interface. (boinc_4964bc76863ec1be, slot#0) 2025-10-10 17:30:10 (4636): Successfully started VM. (PID = '21104') 2025-10-10 17:30:10 (4636): Reporting VM Process ID to BOINC. 2025-10-10 17:30:11 (4636): VM state change detected. (old = 'poweredoff', new = 'running') 2025-10-10 17:30:11 (4636): Detected: Web Application Enabled (http://localhost:63489) 2025-10-10 17:30:11 (4636): Detected: Remote Desktop Enabled (localhost:63498) 2025-10-10 17:30:13 (4636): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:30:22 (4636): Status Report: Elapsed Time: '37182.364093' 2025-10-10 17:30:22 (4636): Status Report: CPU Time: '40551.765625' 2025-10-10 17:30:22 (4636): Preference change detected 2025-10-10 17:30:22 (4636): Setting CPU throttle for VM. (100%) 2025-10-10 17:30:22 (4636): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 900 seconds)) 2025-10-10 17:30:22 (4636): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:30:31 (4636): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:30:59 (4636): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:31:09 (4636): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:33:30 (4636): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:33:30 (4636): Stopping VM. 2025-10-10 17:34:22 (4636): Successfully stopped VM. 2025-10-10 17:43:23 (3900): vboxwrapper version 26210 2025-10-10 17:43:23 (3900): BOINC client version: 7.16.11 2025-10-10 17:43:25 (3900): Detected: VirtualBox VboxManage Interface (Version: 7.2.2) 2025-10-10 17:43:26 (3900): Starting VM using VBoxManage interface. (boinc_4964bc76863ec1be, slot#0) 2025-10-10 17:44:07 (3900): Successfully started VM. (PID = '22752') 2025-10-10 17:44:07 (3900): Reporting VM Process ID to BOINC. 2025-10-10 17:44:07 (3900): VM state change detected. (old = 'poweredoff', new = 'running') 2025-10-10 17:44:07 (3900): Detected: Web Application Enabled (http://localhost:63489) 2025-10-10 17:44:07 (3900): Detected: Remote Desktop Enabled (localhost:63498) 2025-10-10 17:44:08 (3900): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:44:14 (3900): Status Report: Elapsed Time: '37200.915467' 2025-10-10 17:44:14 (3900): Status Report: CPU Time: '40592.328125' 2025-10-10 17:44:14 (3900): Preference change detected 2025-10-10 17:44:14 (3900): Setting CPU throttle for VM. (100%) 2025-10-10 17:44:15 (3900): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 900 seconds)) 2025-10-10 17:44:15 (3900): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:44:24 (3900): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:46:25 (3900): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:46:35 (3900): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:47:05 (3900): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:47:17 (3900): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:47:35 (3900): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:47:45 (3900): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:48:05 (3900): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:48:15 (3900): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:48:45 (3900): Stopping VM. 2025-10-10 17:49:30 (3900): Successfully stopped VM. 2025-10-10 17:52:07 (11184): vboxwrapper version 26210 2025-10-10 17:52:07 (11184): BOINC client version: 7.16.11 2025-10-10 17:52:10 (11184): Detected: VirtualBox VboxManage Interface (Version: 7.2.2) 2025-10-10 17:52:11 (11184): Starting VM using VBoxManage interface. (boinc_4964bc76863ec1be, slot#0) 2025-10-10 17:52:52 (11184): Successfully started VM. (PID = '14932') 2025-10-10 17:52:52 (11184): Reporting VM Process ID to BOINC. 2025-10-10 17:52:52 (11184): VM state change detected. (old = 'poweredoff', new = 'running') 2025-10-10 17:52:52 (11184): Detected: Web Application Enabled (http://localhost:63489) 2025-10-10 17:52:52 (11184): Detected: Remote Desktop Enabled (localhost:63498) 2025-10-10 17:52:52 (11184): Status Report: Elapsed Time: '37241.915467' 2025-10-10 17:52:53 (11184): Status Report: CPU Time: '40650.187500' 2025-10-10 17:52:53 (11184): Preference change detected 2025-10-10 17:52:53 (11184): Setting CPU throttle for VM. (100%) 2025-10-10 17:52:54 (11184): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 900 seconds)) 2025-10-10 17:53:11 (11184): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:56:40 (11184): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:56:40 (11184): Stopping VM. 2025-10-10 17:58:19 (22532): vboxwrapper version 26210 2025-10-10 17:58:19 (22532): BOINC client version: 7.16.11 2025-10-10 17:58:20 (22532): Detected: VirtualBox VboxManage Interface (Version: 7.2.2) 2025-10-10 17:58:21 (22532): Starting VM using VBoxManage interface. (boinc_4964bc76863ec1be, slot#0) 2025-10-10 17:58:31 (22532): Successfully started VM. (PID = '23236') 2025-10-10 17:58:31 (22532): Reporting VM Process ID to BOINC. 2025-10-10 17:58:31 (22532): Guest Log: BIOS: VirtualBox 7.2.2 2025-10-10 17:58:31 (22532): Guest Log: CPUID EDX: 0x178bfbff 2025-10-10 17:58:31 (22532): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-10-10 17:58:31 (22532): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-10-10 17:58:31 (22532): VM state change detected. (old = 'poweredoff', new = 'running') 2025-10-10 17:58:31 (22532): Detected: Web Application Enabled (http://localhost:63489) 2025-10-10 17:58:31 (22532): Detected: Remote Desktop Enabled (localhost:63498) 2025-10-10 17:58:32 (22532): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:58:40 (22532): Status Report: Elapsed Time: '37266.212188' 2025-10-10 17:58:40 (22532): Status Report: CPU Time: '40682.390625' 2025-10-10 17:58:40 (22532): Preference change detected 2025-10-10 17:58:40 (22532): Setting CPU throttle for VM. (100%) 2025-10-10 17:58:40 (22532): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 900 seconds)) 2025-10-10 17:58:41 (22532): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:58:42 (22532): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-10-10 17:58:42 (22532): Guest Log: BIOS: Booting from Hard Disk... 2025-10-10 17:58:49 (22532): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-10-10 17:58:49 (22532): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2025-10-10 17:58:49 (22532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2025-10-10 17:58:51 (22532): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 17:59:21 (22532): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 17:59:32 (22532): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-10-10 17:59:32 (22532): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-10-10 17:59:32 (22532): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 18:01:01 (22532): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 18:01:01 (22532): Stopping VM. 2025-10-10 18:01:03 (22532): Successfully stopped VM. 2025-10-10 18:03:31 (8840): vboxwrapper version 26210 2025-10-10 18:03:31 (8840): BOINC client version: 7.16.11 2025-10-10 18:03:32 (8840): Detected: VirtualBox VboxManage Interface (Version: 7.2.2) 2025-10-10 18:03:33 (8840): Guest Log: BIOS: VirtualBox 7.2.2 2025-10-10 18:03:33 (8840): Guest Log: CPUID EDX: 0x178bfbff 2025-10-10 18:03:33 (8840): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-10-10 18:03:33 (8840): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-10-10 18:03:33 (8840): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-10-10 18:03:33 (8840): Guest Log: BIOS: Booting from Hard Disk... 2025-10-10 18:03:33 (8840): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-10-10 18:03:33 (8840): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2025-10-10 18:03:33 (8840): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2025-10-10 18:03:33 (8840): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-10-10 18:03:33 (8840): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-10-10 18:03:33 (8840): Starting VM using VBoxManage interface. (boinc_4964bc76863ec1be, slot#0) 2025-10-10 18:03:45 (8840): Successfully started VM. (PID = '19552') 2025-10-10 18:03:45 (8840): Reporting VM Process ID to BOINC. 2025-10-10 18:03:45 (8840): VM state change detected. (old = 'poweredoff', new = 'running') 2025-10-10 18:03:45 (8840): Detected: Web Application Enabled (http://localhost:63489) 2025-10-10 18:03:45 (8840): Detected: Remote Desktop Enabled (localhost:63498) 2025-10-10 18:03:46 (8840): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 18:03:52 (8840): Status Report: Elapsed Time: '37284.212188' 2025-10-10 18:03:52 (8840): Status Report: CPU Time: '40701.171875' 2025-10-10 18:03:52 (8840): Preference change detected 2025-10-10 18:03:52 (8840): Setting CPU throttle for VM. (100%) 2025-10-10 18:03:52 (8840): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 900 seconds)) 2025-10-10 18:03:53 (8840): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 18:04:03 (8840): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 18:04:13 (8840): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 18:04:32 (8840): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2025-10-10 18:04:32 (8840): Guest Log: 00:00:00.001860 main Log opened 2025-10-10T17:59:23.395310000Z 2025-10-10 18:04:32 (8840): Guest Log: 00:00:00.002442 main OS Product: Linux 2025-10-10 18:04:32 (8840): Guest Log: 00:00:00.002535 main OS Release: 3.10.0-957.27.2.el7.x86_64 2025-10-10 18:04:32 (8840): Guest Log: 00:00:00.002601 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2025-10-10 18:04:32 (8840): Guest Log: 00:00:00.002683 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2025-10-10 18:04:32 (8840): Guest Log: 00:00:00.002684 main Process ID: 1246 2025-10-10 18:04:32 (8840): Guest Log: 00:00:00.002684 main Package type: LINUX_64BITS_GENERIC 2025-10-10 18:04:32 (8840): Guest Log: 00:00:00.005359 main 5.2.32 r132073 started. Verbose level = 0 2025-10-10 18:04:32 (8840): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2025-10-10 18:04:32 (8840): Guest Log: [INFO] Mounting shared directory 2025-10-10 18:04:32 (8840): Guest Log: [INFO] Checking for init_data.xml 2025-10-10 18:04:33 (8840): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 18:05:33 (8840): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 18:05:33 (8840): Stopping VM. 2025-10-10 18:05:43 (8840): Successfully stopped VM. 2025-10-10 18:07:53 (18780): vboxwrapper version 26210 2025-10-10 18:07:53 (18780): BOINC client version: 7.16.11 2025-10-10 18:07:53 (18780): Detected: VirtualBox VboxManage Interface (Version: 7.2.2) 2025-10-10 18:07:54 (18780): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2025-10-10 18:07:54 (18780): Guest Log: 00:00:00.001860 main Log opened 2025-10-10T17:59:23.395310000Z 2025-10-10 18:07:54 (18780): Guest Log: 00:00:00.002442 main OS Product: Linux 2025-10-10 18:07:54 (18780): Guest Log: 00:00:00.002535 main OS Release: 3.10.0-957.27.2.el7.x86_64 2025-10-10 18:07:54 (18780): Guest Log: 00:00:00.002601 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2025-10-10 18:07:54 (18780): Guest Log: 00:00:00.002683 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2025-10-10 18:07:54 (18780): Guest Log: 00:00:00.002684 main Process ID: 1246 2025-10-10 18:07:54 (18780): Guest Log: 00:00:00.002684 main Package type: LINUX_64BITS_GENERIC 2025-10-10 18:07:54 (18780): Guest Log: 00:00:00.005359 main 5.2.32 r132073 started. Verbose level = 0 2025-10-10 18:07:54 (18780): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2025-10-10 18:07:54 (18780): Guest Log: [INFO] Mounting shared directory 2025-10-10 18:07:54 (18780): Guest Log: [INFO] Checking for init_data.xml 2025-10-10 18:07:54 (18780): Starting VM using VBoxManage interface. (boinc_4964bc76863ec1be, slot#0) 2025-10-10 18:08:08 (18780): Successfully started VM. (PID = '18616') 2025-10-10 18:08:08 (18780): Reporting VM Process ID to BOINC. 2025-10-10 18:08:09 (18780): Guest Log: 00:00:10.148655 timesync vgsvcTimeSyncWorker: Radical guest time change: 14 716 296 702 000ns (GuestNow=1 760 133 879 828 879 000 ns GuestLast=1 760 119 163 532 177 000 ns fSetTimeLastLoop=true ) 2025-10-10 18:08:09 (18780): VM state change detected. (old = 'poweredoff', new = 'running') 2025-10-10 18:08:09 (18780): Detected: Web Application Enabled (http://localhost:63489) 2025-10-10 18:08:09 (18780): Detected: Remote Desktop Enabled (localhost:63498) 2025-10-10 18:08:10 (18780): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 18:08:14 (18780): Status Report: Elapsed Time: '37311.212188' 2025-10-10 18:08:14 (18780): Status Report: CPU Time: '40731.078125' 2025-10-10 18:08:14 (18780): Preference change detected 2025-10-10 18:08:14 (18780): Setting CPU throttle for VM. (100%) 2025-10-10 18:08:15 (18780): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 900 seconds)) 2025-10-10 18:08:15 (18780): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 18:08:25 (18780): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 18:08:34 (18780): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 18:08:39 (18780): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2025-10-10 18:08:39 (18780): Guest Log: [INFO] Detected branch: prod 2025-10-10 18:08:40 (18780): Guest Log: This is the prod version of the ATLAS job wrapper 2025-10-10 18:08:40 (18780): Guest Log: Copying input files 2025-10-10 18:08:45 (18780): Guest Log: Copied input files into RunAtlas. 2025-10-10 18:08:45 (18780): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 18:09:10 (18780): Guest Log: This VM did not configure a local http proxy via BOINC. 2025-10-10 18:09:10 (18780): Guest Log: Small home clusters do not require a local http proxy but it is suggested if 2025-10-10 18:09:10 (18780): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks. 2025-10-10 18:09:10 (18780): Guest Log: Further information can be found at the LHC@home message board. 2025-10-10 18:09:10 (18780): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 18:09:19 (18780): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 18:09:55 (18780): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 18:10:06 (18780): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 18:10:15 (18780): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 18:10:35 (18780): Guest Log: Running cvmfs_config stat atlas.cern.ch 2025-10-10 18:10:37 (18780): 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-10-10 18:10:37 (18780): Guest Log: 2.6.3.0 1559 1 32064 151563 3 1 2055104 4096000 0 65024 0 0 n/a 0 0 http://s1fnal-cvmfs.openhtc.io:8080/cvmfs/atlas.cern.ch DIRECT 1 2025-10-10 18:10:40 (18780): Guest Log: copied the webapp to /var/www 2025-10-10 18:10:41 (18780): Guest Log: core_number=1 2025-10-10 18:10:41 (18780): 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-10-10 18:10:41 (18780): Guest Log: *** Starting ATLAS job. (PandaID=6837328490 taskID=46676269) *** 2025-10-10 18:10:44 (18780): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 18:12:15 (18780): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 18:12:15 (18780): Stopping VM. 2025-10-10 18:13:05 (18780): Successfully stopped VM. 2025-10-10 19:43:45 (16148): vboxwrapper version 26210 2025-10-10 19:43:45 (16148): BOINC client version: 7.16.11 2025-10-10 19:43:47 (16148): Detected: VirtualBox VboxManage Interface (Version: 7.2.2) 2025-10-10 19:43:48 (16148): Guest Log: 00:00:10.148655 timesync vgsvcTimeSyncWorker: Radical guest time change: 14 716 296 702 000ns (GuestNow=1 760 133 879 828 879 000 ns GuestLast=1 760 119 163 532 177 000 ns fSetTimeLastLoop=true ) 2025-10-10 19:43:48 (16148): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2025-10-10 19:43:48 (16148): Guest Log: [INFO] Detected branch: prod 2025-10-10 19:43:48 (16148): Guest Log: This is the prod version of the ATLAS job wrapper 2025-10-10 19:43:48 (16148): Guest Log: Copying input files 2025-10-10 19:43:48 (16148): Guest Log: Copied input files into RunAtlas. 2025-10-10 19:43:48 (16148): Guest Log: This VM did not configure a local http proxy via BOINC. 2025-10-10 19:43:48 (16148): Guest Log: Small home clusters do not require a local http proxy but it is suggested if 2025-10-10 19:43:48 (16148): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks. 2025-10-10 19:43:48 (16148): Guest Log: Further information can be found at the LHC@home message board. 2025-10-10 19:43:48 (16148): Guest Log: Running cvmfs_config stat atlas.cern.ch 2025-10-10 19:43:48 (16148): 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-10-10 19:43:48 (16148): Guest Log: 2.6.3.0 1559 1 32064 151563 3 1 2055104 4096000 0 65024 0 0 n/a 0 0 http://s1fnal-cvmfs.openhtc.io:8080/cvmfs/atlas.cern.ch DIRECT 1 2025-10-10 19:43:48 (16148): Guest Log: copied the webapp to /var/www 2025-10-10 19:43:48 (16148): Guest Log: core_number=1 2025-10-10 19:43:48 (16148): 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-10-10 19:43:48 (16148): Guest Log: *** Starting ATLAS job. (PandaID=6837328490 taskID=46676269) *** 2025-10-10 19:43:48 (16148): Starting VM using VBoxManage interface. (boinc_4964bc76863ec1be, slot#0) 2025-10-10 19:44:05 (16148): Successfully started VM. (PID = '21476') 2025-10-10 19:44:05 (16148): Reporting VM Process ID to BOINC. 2025-10-10 19:44:05 (16148): VM state change detected. (old = 'poweredoff', new = 'running') 2025-10-10 19:44:05 (16148): Detected: Web Application Enabled (http://localhost:63489) 2025-10-10 19:44:05 (16148): Detected: Remote Desktop Enabled (localhost:63498) 2025-10-10 19:44:06 (16148): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 19:44:27 (16148): Status Report: Elapsed Time: '37370.348567' 2025-10-10 19:44:27 (16148): Status Report: CPU Time: '40779.453125' 2025-10-10 19:44:27 (16148): Preference change detected 2025-10-10 19:44:27 (16148): Setting CPU throttle for VM. (100%) 2025-10-10 19:44:28 (16148): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 900 seconds)) 2025-10-10 19:44:28 (16148): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 19:44:28 (16148): Stopping VM. 2025-10-10 19:44:35 (16148): Successfully stopped VM. 2025-10-10 19:52:41 (6252): vboxwrapper version 26210 2025-10-10 19:52:41 (6252): BOINC client version: 7.16.11 2025-10-10 19:52:43 (6252): Detected: VirtualBox VboxManage Interface (Version: 7.2.2) 2025-10-10 19:52:44 (6252): Starting VM using VBoxManage interface. (boinc_4964bc76863ec1be, slot#0) 2025-10-10 19:52:57 (6252): Successfully started VM. (PID = '1652') 2025-10-10 19:52:57 (6252): Reporting VM Process ID to BOINC. 2025-10-10 19:52:57 (6252): Guest Log: *** Job finished *** 2025-10-10 19:52:57 (6252): Guest Log: Failed to produce a result! Shutting down the machine. 2025-10-10 19:52:57 (6252): Guest Log: FATAL: while opening capability config file: open /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/1.2.2/etc/apptainer/capability.json: input/output error 2025-10-10 19:52:57 (6252): VM state change detected. (old = 'poweredoff', new = 'running') 2025-10-10 19:52:57 (6252): Detected: Web Application Enabled (http://localhost:63489) 2025-10-10 19:52:57 (6252): Detected: Remote Desktop Enabled (localhost:63498) 2025-10-10 19:52:58 (6252): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 19:53:02 (6252): Status Report: Elapsed Time: '37371.446588' 2025-10-10 19:53:02 (6252): Status Report: CPU Time: '40779.453125' 2025-10-10 19:53:02 (6252): Preference change detected 2025-10-10 19:53:02 (6252): Setting CPU throttle for VM. (100%) 2025-10-10 19:53:02 (6252): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 900 seconds)) 2025-10-10 19:53:02 (6252): Guest Log: 00:01:40.842919 timesync vgsvcTimeSyncWorker: Radical host time change: 6 048 983 000 000ns (HostNow=1 760 140 382 901 000 000 ns HostLast=1 760 134 333 918 000 000 ns) 2025-10-10 19:53:02 (6252): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 19:53:12 (6252): Guest Log: 00:01:50.843703 timesync vgsvcTimeSyncWorker: Radical guest time change: 6 215 551 954 000ns (GuestNow=1 760 140 392 901 844 000 ns GuestLast=1 760 134 177 349 890 000 ns fSetTimeLastLoop=true ) 2025-10-10 19:53:43 (6252): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 19:54:12 (6252): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 19:54:22 (6252): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 19:55:32 (6252): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 19:55:43 (6252): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 19:55:52 (6252): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 19:56:03 (6252): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 19:56:13 (6252): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 19:56:32 (6252): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 19:56:53 (6252): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 19:57:33 (6252): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 19:57:43 (6252): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 19:58:52 (6252): Guest Log: 00:05:00.848206 control Session 0 is about to close ... 2025-10-10 19:58:52 (6252): Guest Log: 00:05:00.848383 control Stopping all guest processes ... 2025-10-10 19:58:52 (6252): Guest Log: 00:05:00.848442 control Closing all guest files ... 2025-10-10 19:58:52 (6252): Guest Log: 00:05:00.848526 control Guest control service stopped 2025-10-10 19:58:52 (6252): Guest Log: 00:05:00.848659 control Guest control worker returned with rc=VINF_SUCCESS 2025-10-10 19:58:52 (6252): Guest Log: 00:05:00.850613 main Session 0 is about to close ... 2025-10-10 19:58:52 (6252): Guest Log: 00:05:00.850730 main Stopping all guest processes ... 2025-10-10 19:58:52 (6252): Guest Log: 00:05:00.850798 main Closing all guest files ... 2025-10-10 19:58:52 (6252): Guest Log: 00:05:00.933719 main Ended. 2025-10-10 19:58:53 (6252): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 19:59:17 (6252): VM state change detected. (old = 'paused', new = 'running') 2025-10-10 19:59:24 (6252): VM state change detected. (old = 'running', new = 'paused') 2025-10-10 19:59:33 (6252): VM is no longer is a running state. It is in 'poweredoff'. 2025-10-10 19:59:33 (6252): VM state change detected. (old = 'paused', new = 'poweredoff') 2025-10-10 19:59:33 (6252): Powering off VM. 2025-10-10 19:59:33 (6252): Deregistering VM. (boinc_4964bc76863ec1be, slot#0) 2025-10-10 19:59:33 (6252): Removing network bandwidth throttle group from VM. 2025-10-10 19:59:34 (6252): Removing VM from VirtualBox. 2025-10-10 19:59:40 (6252): Virtual machine exited. 2025-10-10 19:59:41 (6252)
©2025 CERN