| Name | 5w2KDmIWrf8nsSi4ap6QjLDmwznN0nGgGQJmNLGKDmWjGKDmcNrRwn_2 |
| Workunit | 237676642 |
| Created | 19 Nov 2025, 12:25:57 UTC |
| Sent | 19 Nov 2025, 17:07:57 UTC |
| Report deadline | 27 Nov 2025, 17:07:57 UTC |
| Received | 25 Nov 2025, 15:20:05 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 10671356 |
| Run time | 19 hours 24 min 49 sec |
| CPU time | 2 days 1 hours 44 min 45 sec |
| Validate state | Valid |
| Credit | 14,508.83 |
| Device peak FLOPS | 32.04 GFLOPS |
| Application version | ATLAS Simulation v3.03 (vbox64_mt_mcore_atlas) x86_64-apple-darwin |
| Peak working set size | 8.38 GB |
| Peak swap size | 70.20 GB |
| Peak disk usage | 391.42 MB |
Stderr output
<core_client_version>8.2.5</core_client_version> <![CDATA[ <stderr_txt> : Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-11-19 18:14:48 (2845): Guest Log: BIOS: Booting from Hard Disk... 2025-11-19 18:14:54 (2845): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-11-19 18:14:54 (2845): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2025-11-19 18:14:54 (2845): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2025-11-19 18:15:43 (2845): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-11-19 18:15:43 (2845): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-11-19 18:17:13 (2845): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2025-11-19 18:17:13 (2845): Guest Log: 00:00:00.000194 main Log opened 2025-11-19T17:17:11.475971000Z 2025-11-19 18:17:14 (2845): Guest Log: 00:00:00.089776 main OS Product: Linux 2025-11-19 18:17:14 (2845): Guest Log: 00:00:00.089888 main OS Release: 3.10.0-957.27.2.el7.x86_64 2025-11-19 18:17:14 (2845): Guest Log: 00:00:00.090049 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2025-11-19 18:17:14 (2845): Guest Log: 00:00:00.090176 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2025-11-19 18:17:14 (2845): Guest Log: 00:00:00.090178 main Process ID: 1403 2025-11-19 18:17:14 (2845): Guest Log: 00:00:00.090179 main Package type: LINUX_64BITS_GENERIC 2025-11-19 18:17:14 (2845): Guest Log: 00:00:00.101030 main 5.2.32 r132073 started. Verbose level = 0 2025-11-19 18:17:15 (2845): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2025-11-19 18:17:15 (2845): Guest Log: [INFO] Mounting shared directory 2025-11-19 18:17:17 (2845): Guest Log: [INFO] Checking for init_data.xml 2025-11-19 18:18:27 (2845): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2025-11-19 18:18:27 (2845): Guest Log: [INFO] Detected branch: prod 2025-11-19 18:18:27 (2845): Guest Log: This is the prod version of the ATLAS job wrapper 2025-11-19 18:18:28 (2845): Guest Log: Copying input files 2025-11-19 18:19:19 (2845): Guest Log: Copied input files into RunAtlas. 2025-11-19 18:19:20 (2845): Guest Log: This VM did not configure a local http proxy via BOINC. 2025-11-19 18:19:20 (2845): Guest Log: Small home clusters do not require a local http proxy but it is suggested if 2025-11-19 18:19:20 (2845): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks. 2025-11-19 18:19:20 (2845): Guest Log: Further information can be found at the LHC@home message board. 2025-11-19 18:19:40 (2845): Guest Log: Running cvmfs_config stat atlas.cern.ch 2025-11-19 18:19:45 (2845): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2025-11-19 18:19:45 (2845): Guest Log: 2.6.3.0 1697 1 32348 153052 3 1 3120538 4096000 0 65024 0 0 n/a 1292 281 http://s1bnl-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1 2025-11-19 18:19:52 (2845): Guest Log: copied the webapp to /var/www 2025-11-19 18:19:53 (2845): Guest Log: ATHENA_PROC_NUMBER=8 2025-11-19 18:19:53 (2845): Guest Log: ATHENA_CORE_NUMBER=8 2025-11-19 18:19:54 (2845): Guest Log: Apptainer command /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/data,/home/atlas/RunAtlas /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 2025-11-19 18:19:55 (2845): Guest Log: *** Starting ATLAS job. (PandaID=6892526957 taskID=47493029) *** 2025-11-19 18:26:07 (2845): VM state change detected. (old = 'running', new = 'paused') 2025-11-19 18:26:32 (2845): VM state change detected. (old = 'paused', new = 'running') 2025-11-19 18:26:37 (2845): VM state change detected. (old = 'running', new = 'paused') 2025-11-19 18:27:04 (2845): VM state change detected. (old = 'paused', new = 'running') 2025-11-19 18:27:28 (2845): VM state change detected. (old = 'running', new = 'paused') 2025-11-19 18:27:54 (2845): VM state change detected. (old = 'paused', new = 'running') 2025-11-19 18:30:07 (2845): Stopping VM. 2025-11-19 18:30:21 (2845): Successfully stopped VM. 2025-11-19 19:00:56 (4374): vboxwrapper version 26210 2025-11-19 19:00:56 (4374): BOINC client version: 8.2.5 2025-11-19 19:00:56 (4374): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-11-19 19:00:56 (4374): Detected: Sandbox Configuration Enabled 2025-11-19 19:00:56 (4374): Guest Log: BIOS: VirtualBox 7.1.10 2025-11-19 19:00:56 (4374): Guest Log: CPUID EDX: 0x178bfbff 2025-11-19 19:00:56 (4374): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-11-19 19:00:56 (4374): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-11-19 19:00:56 (4374): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-11-19 19:00:56 (4374): Guest Log: BIOS: Booting from Hard Disk... 2025-11-19 19:00:56 (4374): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-11-19 19:00:56 (4374): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2025-11-19 19:00:56 (4374): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2025-11-19 19:00:56 (4374): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-11-19 19:00:56 (4374): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-11-19 19:00:56 (4374): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2025-11-19 19:00:56 (4374): Guest Log: 00:00:00.000194 main Log opened 2025-11-19T17:17:11.475971000Z 2025-11-19 19:00:56 (4374): Guest Log: 00:00:00.089776 main OS Product: Linux 2025-11-19 19:00:56 (4374): Guest Log: 00:00:00.089888 main OS Release: 3.10.0-957.27.2.el7.x86_64 2025-11-19 19:00:56 (4374): Guest Log: 00:00:00.090049 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2025-11-19 19:00:56 (4374): Guest Log: 00:00:00.090176 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2025-11-19 19:00:56 (4374): Guest Log: 00:00:00.090178 main Process ID: 1403 2025-11-19 19:00:56 (4374): Guest Log: 00:00:00.090179 main Package type: LINUX_64BITS_GENERIC 2025-11-19 19:00:56 (4374): Guest Log: 00:00:00.101030 main 5.2.32 r132073 started. Verbose level = 0 2025-11-19 19:00:56 (4374): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2025-11-19 19:00:56 (4374): Guest Log: [INFO] Mounting shared directory 2025-11-19 19:00:56 (4374): Guest Log: [INFO] Checking for init_data.xml 2025-11-19 19:00:56 (4374): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2025-11-19 19:00:56 (4374): Guest Log: [INFO] Detected branch: prod 2025-11-19 19:00:56 (4374): Guest Log: This is the prod version of the ATLAS job wrapper 2025-11-19 19:00:56 (4374): Guest Log: Copying input files 2025-11-19 19:00:56 (4374): Guest Log: Copied input files into RunAtlas. 2025-11-19 19:00:56 (4374): Guest Log: This VM did not configure a local http proxy via BOINC. 2025-11-19 19:00:56 (4374): Guest Log: Small home clusters do not require a local http proxy but it is suggested if 2025-11-19 19:00:56 (4374): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks. 2025-11-19 19:00:56 (4374): Guest Log: Further information can be found at the LHC@home message board. 2025-11-19 19:00:56 (4374): Guest Log: Running cvmfs_config stat atlas.cern.ch 2025-11-19 19:00:56 (4374): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2025-11-19 19:00:56 (4374): Guest Log: 2.6.3.0 1697 1 32348 153052 3 1 3120538 4096000 0 65024 0 0 n/a 1292 281 http://s1bnl-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1 2025-11-19 19:00:56 (4374): Guest Log: copied the webapp to /var/www 2025-11-19 19:00:56 (4374): Guest Log: ATHENA_PROC_NUMBER=8 2025-11-19 19:00:56 (4374): Guest Log: ATHENA_CORE_NUMBER=8 2025-11-19 19:00:56 (4374): Guest Log: Apptainer command /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/data,/home/atlas/RunAtlas /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 2025-11-19 19:00:56 (4374): Guest Log: *** Starting ATLAS job. (PandaID=6892526957 taskID=47493029) *** 2025-11-19 19:00:56 (4374): Starting VM using VBoxManage interface. (boinc_1a056c4dc96080c1, slot#16) 2025-11-19 19:01:15 (4374): Successfully started VM. (PID = '4387') 2025-11-19 19:01:15 (4374): Reporting VM Process ID to BOINC. 2025-11-19 19:01:15 (4374): VM state change detected. (old = 'poweredoff', new = 'running') 2025-11-19 19:01:15 (4374): Detected: Web Application Enabled (http://localhost:50562) 2025-11-19 19:01:15 (4374): Preference change detected 2025-11-19 19:01:15 (4374): Setting CPU throttle for VM. (10%) 2025-11-19 19:01:15 (4374): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-11-19 19:01:20 (4374): Guest Log: 00:11:41.396664 timesync vgsvcTimeSyncWorker: Radical host time change: 1 876 957 000 000ns (HostNow=1 763 575 279 688 000 000 ns HostLast=1 763 573 402 731 000 000 ns) 2025-11-19 19:01:30 (4374): Guest Log: 00:11:51.451011 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 957 116 663 000ns (GuestNow=1 763 575 289 865 641 000 ns GuestLast=1 763 573 332 748 978 000 ns fSetTimeLastLoop=true ) 2025-11-19 19:02:10 (4374): VM state change detected. (old = 'running', new = 'paused') 2025-11-19 19:02:30 (4374): VM state change detected. (old = 'paused', new = 'running') 2025-11-19 19:08:16 (4374): VM state change detected. (old = 'running', new = 'paused') 2025-11-19 19:08:37 (4374): VM state change detected. (old = 'paused', new = 'running') 2025-11-19 19:22:50 (4374): VM state change detected. (old = 'running', new = 'paused') 2025-11-19 19:23:11 (4374): VM state change detected. (old = 'paused', new = 'running') 2025-11-19 19:52:50 (4374): VM state change detected. (old = 'running', new = 'paused') 2025-11-19 19:53:11 (4374): VM state change detected. (old = 'paused', new = 'running') 2025-11-19 20:28:11 (4374): Status Report: Elapsed Time: '6000.000000' 2025-11-19 20:28:11 (4374): Status Report: CPU Time: '3251.160000' 2025-11-19 21:10:40 (4374): VM state change detected. (old = 'running', new = 'paused') 2025-11-19 21:10:59 (4374): VM state change detected. (old = 'paused', new = 'running') 2025-11-19 22:08:13 (4374): Status Report: Elapsed Time: '12000.000000' 2025-11-19 22:08:13 (4374): Status Report: CPU Time: '4649.830000' 2025-11-19 22:27:57 (4374): VM state change detected. (old = 'running', new = 'paused') 2025-11-19 22:28:18 (4374): VM state change detected. (old = 'paused', new = 'running') 2025-11-19 23:46:03 (4374): Stopping VM. 2025-11-19 23:46:26 (4374): Successfully stopped VM. 2025-11-20 09:37:13 (936): vboxwrapper version 26210 2025-11-20 09:37:13 (936): BOINC client version: 8.2.5 2025-11-20 09:37:15 (936): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-11-20 09:37:15 (936): Detected: Sandbox Configuration Enabled 2025-11-20 09:37:18 (936): Guest Log: 00:11:41.396664 timesync vgsvcTimeSyncWorker: Radical host time change: 1 876 957 000 000ns (HostNow=1 763 575 279 688 000 000 ns HostLast=1 763 573 402 731 000 000 ns) 2025-11-20 09:37:18 (936): Guest Log: 00:11:51.451011 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 957 116 663 000ns (GuestNow=1 763 575 289 865 641 000 ns GuestLast=1 763 573 332 748 978 000 ns fSetTimeLastLoop=true ) 2025-11-20 09:37:18 (936): Starting VM using VBoxManage interface. (boinc_1a056c4dc96080c1, slot#16) 2025-11-20 09:37:46 (936): Successfully started VM. (PID = '1000') 2025-11-20 09:37:46 (936): Reporting VM Process ID to BOINC. 2025-11-20 09:37:46 (936): VM state change detected. (old = 'poweredoff', new = 'running') 2025-11-20 09:37:46 (936): Detected: Web Application Enabled (http://localhost:50562) 2025-11-20 09:37:47 (936): VM state change detected. (old = 'running', new = 'paused') 2025-11-20 09:38:46 (936): Status Report: Elapsed Time: '17866.000000' 2025-11-20 09:38:46 (936): Status Report: CPU Time: '11223.660000' 2025-11-20 09:38:46 (936): Preference change detected 2025-11-20 09:38:46 (936): Setting CPU throttle for VM. (10%) 2025-11-20 09:38:46 (936): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-11-20 09:38:47 (936): VM state change detected. (old = 'paused', new = 'running') 2025-11-20 09:38:54 (936): Guest Log: 04:54:25.166901 timesync vgsvcTimeSyncWorker: Radical host time change: 35 567 081 000 000ns (HostNow=1 763 627 885 317 000 000 ns HostLast=1 763 592 318 236 000 000 ns) 2025-11-20 09:39:04 (936): Guest Log: 04:54:35.216026 timesync vgsvcTimeSyncWorker: Radical guest time change: 35 652 346 287 000ns (GuestNow=1 763 627 895 646 786 000 ns GuestLast=1 763 592 243 300 499 000 ns fSetTimeLastLoop=true ) 2025-11-20 10:49:54 (936): Stopping VM. 2025-11-20 10:50:29 (936): Successfully stopped VM. 2025-11-20 11:14:27 (4464): vboxwrapper version 26210 2025-11-20 11:14:27 (4464): BOINC client version: 8.2.5 2025-11-20 11:14:27 (4464): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-11-20 11:14:27 (4464): Detected: Sandbox Configuration Enabled 2025-11-20 11:14:27 (4464): Guest Log: 04:54:25.166901 timesync vgsvcTimeSyncWorker: Radical host time change: 35 567 081 000 000ns (HostNow=1 763 627 885 317 000 000 ns HostLast=1 763 592 318 236 000 000 ns) 2025-11-20 11:14:27 (4464): Guest Log: 04:54:35.216026 timesync vgsvcTimeSyncWorker: Radical guest time change: 35 652 346 287 000ns (GuestNow=1 763 627 895 646 786 000 ns GuestLast=1 763 592 243 300 499 000 ns fSetTimeLastLoop=true ) 2025-11-20 11:14:27 (4464): Starting VM using VBoxManage interface. (boinc_1a056c4dc96080c1, slot#16) 2025-11-20 11:14:48 (4464): Successfully started VM. (PID = '4477') 2025-11-20 11:14:48 (4464): Reporting VM Process ID to BOINC. 2025-11-20 11:14:48 (4464): VM state change detected. (old = 'poweredoff', new = 'running') 2025-11-20 11:14:48 (4464): Detected: Web Application Enabled (http://localhost:50562) 2025-11-20 11:14:48 (4464): Status Report: Elapsed Time: '22166.000000' 2025-11-20 11:14:48 (4464): Status Report: CPU Time: '26275.750000' 2025-11-20 11:14:48 (4464): Preference change detected 2025-11-20 11:14:48 (4464): Setting CPU throttle for VM. (10%) 2025-11-20 11:14:49 (4464): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-11-20 11:18:27 (4464): VM state change detected. (old = 'running', new = 'paused') 2025-11-20 11:18:56 (4464): VM state change detected. (old = 'paused', new = 'running') 2025-11-20 11:19:29 (4464): VM state change detected. (old = 'running', new = 'paused') 2025-11-20 11:19:49 (4464): VM state change detected. (old = 'paused', new = 'running') 2025-11-20 11:20:09 (4464): VM state change detected. (old = 'running', new = 'paused') 2025-11-20 11:20:36 (4464): VM state change detected. (old = 'paused', new = 'running') 2025-11-20 11:20:40 (4464): VM state change detected. (old = 'running', new = 'paused') 2025-11-20 11:21:07 (4464): VM state change detected. (old = 'paused', new = 'running') 2025-11-20 11:21:41 (4464): VM state change detected. (old = 'running', new = 'paused') 2025-11-20 11:22:09 (4464): VM state change detected. (old = 'paused', new = 'running') 2025-11-20 11:27:07 (4464): VM state change detected. (old = 'running', new = 'paused') 2025-11-20 11:27:31 (4464): VM state change detected. (old = 'paused', new = 'running') 2025-11-20 12:11:14 (4464): Stopping VM. 2025-11-20 12:11:43 (4464): Successfully stopped VM. 2025-11-20 12:52:41 (8047): vboxwrapper version 26210 2025-11-20 12:52:41 (8047): BOINC client version: 8.2.5 2025-11-20 12:52:41 (8047): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-11-20 12:52:41 (8047): Detected: Sandbox Configuration Enabled 2025-11-20 12:52:41 (8047): Starting VM using VBoxManage interface. (boinc_1a056c4dc96080c1, slot#16) 2025-11-20 12:53:02 (8047): Successfully started VM. (PID = '8060') 2025-11-20 12:53:02 (8047): Reporting VM Process ID to BOINC. 2025-11-20 12:53:02 (8047): VM state change detected. (old = 'poweredoff', new = 'running') 2025-11-20 12:53:02 (8047): Detected: Web Application Enabled (http://localhost:50562) 2025-11-20 12:53:02 (8047): Status Report: Elapsed Time: '25415.000000' 2025-11-20 12:53:02 (8047): Status Report: CPU Time: '37613.650000' 2025-11-20 12:53:02 (8047): Preference change detected 2025-11-20 12:53:02 (8047): Setting CPU throttle for VM. (10%) 2025-11-20 12:53:02 (8047): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-11-20 12:53:08 (8047): Guest Log: 06:59:21.573212 timesync vgsvcTimeSyncWorker: Radical host time change: 2 509 058 000 000ns (HostNow=1 763 639 553 600 000 000 ns HostLast=1 763 637 044 542 000 000 ns) 2025-11-20 12:53:18 (8047): Guest Log: 06:59:31.586478 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 639 830 830 000ns (GuestNow=1 763 639 563 682 598 000 ns GuestLast=1 763 636 923 851 768 000 ns fSetTimeLastLoop=true ) 2025-11-20 13:19:19 (8047): VM state change detected. (old = 'running', new = 'paused') 2025-11-20 13:19:39 (8047): VM state change detected. (old = 'paused', new = 'running') 2025-11-20 13:27:50 (8047): VM state change detected. (old = 'running', new = 'paused') 2025-11-20 13:28:10 (8047): VM state change detected. (old = 'paused', new = 'running') 2025-11-20 14:33:13 (8047): VM state change detected. (old = 'running', new = 'paused') 2025-11-20 14:33:34 (8047): VM state change detected. (old = 'paused', new = 'running') 2025-11-20 14:33:38 (8047): Status Report: Elapsed Time: '31415.000000' 2025-11-20 14:33:38 (8047): Status Report: CPU Time: '61160.060000' 2025-11-20 14:57:07 (8047): Stopping VM. 2025-11-20 14:57:42 (8047): Successfully stopped VM. 2025-11-20 16:24:56 (14252): vboxwrapper version 26210 2025-11-20 16:24:56 (14252): BOINC client version: 8.2.5 2025-11-20 16:24:56 (14252): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-11-20 16:24:56 (14252): Detected: Sandbox Configuration Enabled 2025-11-20 16:24:57 (14252): Guest Log: 06:59:21.573212 timesync vgsvcTimeSyncWorker: Radical host time change: 2 509 058 000 000ns (HostNow=1 763 639 553 600 000 000 ns HostLast=1 763 637 044 542 000 000 ns) 2025-11-20 16:24:57 (14252): Guest Log: 06:59:31.586478 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 639 830 830 000ns (GuestNow=1 763 639 563 682 598 000 ns GuestLast=1 763 636 923 851 768 000 ns fSetTimeLastLoop=true ) 2025-11-20 16:24:57 (14252): Starting VM using VBoxManage interface. (boinc_1a056c4dc96080c1, slot#16) 2025-11-20 16:25:19 (14252): Successfully started VM. (PID = '14268') 2025-11-20 16:25:19 (14252): Reporting VM Process ID to BOINC. 2025-11-20 16:25:19 (14252): VM state change detected. (old = 'poweredoff', new = 'running') 2025-11-20 16:25:19 (14252): Detected: Web Application Enabled (http://localhost:50562) 2025-11-20 16:25:19 (14252): Status Report: Elapsed Time: '32830.000000' 2025-11-20 16:25:19 (14252): Status Report: CPU Time: '66798.440000' 2025-11-20 16:25:19 (14252): Preference change detected 2025-11-20 16:25:19 (14252): Setting CPU throttle for VM. (10%) 2025-11-20 16:25:19 (14252): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-11-20 16:25:28 (14252): Guest Log: 09:02:26.094619 timesync vgsvcTimeSyncWorker: Radical host time change: 5 294 389 000 000ns (HostNow=1 763 652 307 778 000 000 ns HostLast=1 763 647 013 389 000 000 ns) 2025-11-20 16:25:38 (14252): Guest Log: 09:02:36.096393 timesync vgsvcTimeSyncWorker: Radical guest time change: 5 380 002 307 000ns (GuestNow=1 763 652 317 986 529 000 ns GuestLast=1 763 646 937 984 222 000 ns fSetTimeLastLoop=true ) 2025-11-20 16:27:43 (14252): Stopping VM. 2025-11-20 16:27:59 (14252): Error in stop VM for VM: -2147023170 Command: VBoxManage -q controlvm "boinc_1a056c4dc96080c1" savestate Output: 0%...10%...20%...30%...40%... Progress object failure: NS_ERROR_CALL_FAILED VBoxManage: error: Failed to save machine state. VBoxManage: error: Code NS_ERROR_CALL_FAILED (0x800706BE) - Call to remote object failed (extended info not available) VBoxManage: error: Context: "RTEXITCODE handleControlVM(HandlerArg *)" at line 648 of file VBoxManageControlVM.cpp 2025-11-20 16:27:59 (14252): VM did not stop when requested. 2025-11-20 16:27:59 (14252): VM was successfully terminated. 2025-11-21 11:26:13 (925): vboxwrapper version 26210 2025-11-21 11:26:13 (925): BOINC client version: 8.2.5 2025-11-21 11:26:15 (925): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-11-21 11:26:15 (925): Detected: Sandbox Configuration Enabled 2025-11-21 11:26:17 (925): Guest Log: 09:02:26.094619 timesync vgsvcTimeSyncWorker: Radical host time change: 5 294 389 000 000ns (HostNow=1 763 652 307 778 000 000 ns HostLast=1 763 647 013 389 000 000 ns) 2025-11-21 11:26:17 (925): Guest Log: 09:02:36.096393 timesync vgsvcTimeSyncWorker: Radical guest time change: 5 380 002 307 000ns (GuestNow=1 763 652 317 986 529 000 ns GuestLast=1 763 646 937 984 222 000 ns fSetTimeLastLoop=true ) 2025-11-21 11:26:17 (925): Starting VM using VBoxManage interface. (boinc_1a056c4dc96080c1, slot#16) 2025-11-21 11:26:29 (925): Successfully started VM. (PID = '1024') 2025-11-21 11:26:29 (925): Reporting VM Process ID to BOINC. 2025-11-21 11:26:29 (925): Guest Log: BIOS: VirtualBox 7.1.10 2025-11-21 11:26:29 (925): Guest Log: CPUID EDX: 0x178bfbff 2025-11-21 11:26:29 (925): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-11-21 11:26:29 (925): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-11-21 11:26:29 (925): VM state change detected. (old = 'poweredoff', new = 'running') 2025-11-21 11:26:29 (925): Detected: Web Application Enabled (http://localhost:50562) 2025-11-21 11:26:30 (925): VM state change detected. (old = 'running', new = 'paused') 2025-11-21 11:27:45 (925): Status Report: Elapsed Time: '32975.000000' 2025-11-21 11:27:45 (925): Status Report: CPU Time: '67280.880000' 2025-11-21 11:27:45 (925): Preference change detected 2025-11-21 11:27:45 (925): Setting CPU throttle for VM. (10%) 2025-11-21 11:27:45 (925): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-11-21 11:27:46 (925): VM state change detected. (old = 'paused', new = 'running') 2025-11-21 11:27:48 (925): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-11-21 11:27:48 (925): Guest Log: BIOS: Booting from Hard Disk... 2025-11-21 11:27:53 (925): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-11-21 11:27:53 (925): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2025-11-21 11:27:53 (925): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2025-11-21 11:28:57 (925): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-11-21 11:28:57 (925): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-11-21 11:30:25 (925): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2025-11-21 11:30:25 (925): Guest Log: 00:00:00.000175 main Log opened 2025-11-21T10:29:06.425835000Z 2025-11-21 11:30:25 (925): Guest Log: 00:00:00.000326 main OS Product: Linux 2025-11-21 11:30:25 (925): Guest Log: 00:00:00.000421 main OS Release: 3.10.0-957.27.2.el7.x86_64 2025-11-21 11:30:25 (925): Guest Log: 00:00:00.000654 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2025-11-21 11:30:25 (925): Guest Log: 00:00:00.000738 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2025-11-21 11:30:25 (925): Guest Log: 00:00:00.000740 main Process ID: 1395 2025-11-21 11:30:25 (925): Guest Log: 00:00:00.000741 main Package type: LINUX_64BITS_GENERIC 2025-11-21 11:30:25 (925): Guest Log: 00:00:00.003543 main 5.2.32 r132073 started. Verbose level = 0 2025-11-21 11:30:26 (925): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2025-11-21 11:30:26 (925): Guest Log: [INFO] Mounting shared directory 2025-11-21 11:30:27 (925): Guest Log: [INFO] Checking for init_data.xml 2025-11-21 11:30:52 (925): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2025-11-21 11:30:52 (925): Guest Log: [INFO] Detected branch: prod 2025-11-21 11:30:53 (925): Guest Log: This is the prod version of the ATLAS job wrapper 2025-11-21 11:30:53 (925): Guest Log: Copying input files 2025-11-21 11:31:44 (925): Guest Log: Copied input files into RunAtlas. 2025-11-21 11:31:45 (925): Guest Log: This VM did not configure a local http proxy via BOINC. 2025-11-21 11:31:45 (925): Guest Log: Small home clusters do not require a local http proxy but it is suggested if 2025-11-21 11:31:45 (925): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks. 2025-11-21 11:31:45 (925): Guest Log: Further information can be found at the LHC@home message board. 2025-11-21 11:32:04 (925): Guest Log: Running cvmfs_config stat atlas.cern.ch 2025-11-21 11:32:07 (925): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2025-11-21 11:32:07 (925): Guest Log: 2.6.3.0 1672 1 29976 153121 3 1 2087373 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1 2025-11-21 11:32:14 (925): Guest Log: copied the webapp to /var/www 2025-11-21 11:32:15 (925): Guest Log: ATHENA_PROC_NUMBER=8 2025-11-21 11:32:15 (925): Guest Log: ATHENA_CORE_NUMBER=8 2025-11-21 11:32:16 (925): Guest Log: Apptainer command /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/data,/home/atlas/RunAtlas /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 2025-11-21 11:32:17 (925): Guest Log: *** Starting ATLAS job. (PandaID=6892526957 taskID=47493029) *** 2025-11-21 11:54:27 (925): VM state change detected. (old = 'running', new = 'paused') 2025-11-21 11:54:51 (925): VM state change detected. (old = 'paused', new = 'running') 2025-11-21 12:08:27 (925): Preference change detected 2025-11-21 12:08:27 (925): Setting CPU throttle for VM. (5%) 2025-11-21 12:08:27 (925): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-11-21 12:09:19 (925): VM state change detected. (old = 'running', new = 'paused') 2025-11-21 12:09:45 (925): VM state change detected. (old = 'paused', new = 'running') 2025-11-21 12:38:15 (925): Stopping VM. 2025-11-21 12:38:34 (925): Successfully stopped VM. 2025-11-21 12:43:25 (3985): vboxwrapper version 26210 2025-11-21 12:43:25 (3985): BOINC client version: 8.2.5 2025-11-21 12:43:25 (3985): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-11-21 12:43:25 (3985): Detected: Sandbox Configuration Enabled 2025-11-21 12:43:25 (3985): Guest Log: BIOS: VirtualBox 7.1.10 2025-11-21 12:43:25 (3985): Guest Log: CPUID EDX: 0x178bfbff 2025-11-21 12:43:25 (3985): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-11-21 12:43:25 (3985): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-11-21 12:43:25 (3985): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-11-21 12:43:25 (3985): Guest Log: BIOS: Booting from Hard Disk... 2025-11-21 12:43:25 (3985): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-11-21 12:43:25 (3985): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2025-11-21 12:43:25 (3985): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2025-11-21 12:43:25 (3985): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-11-21 12:43:25 (3985): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-11-21 12:43:25 (3985): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2025-11-21 12:43:25 (3985): Guest Log: 00:00:00.000175 main Log opened 2025-11-21T10:29:06.425835000Z 2025-11-21 12:43:25 (3985): Guest Log: 00:00:00.000326 main OS Product: Linux 2025-11-21 12:43:25 (3985): Guest Log: 00:00:00.000421 main OS Release: 3.10.0-957.27.2.el7.x86_64 2025-11-21 12:43:25 (3985): Guest Log: 00:00:00.000654 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2025-11-21 12:43:25 (3985): Guest Log: 00:00:00.000738 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2025-11-21 12:43:25 (3985): Guest Log: 00:00:00.000740 main Process ID: 1395 2025-11-21 12:43:25 (3985): Guest Log: 00:00:00.000741 main Package type: LINUX_64BITS_GENERIC 2025-11-21 12:43:25 (3985): Guest Log: 00:00:00.003543 main 5.2.32 r132073 started. Verbose level = 0 2025-11-21 12:43:25 (3985): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2025-11-21 12:43:25 (3985): Guest Log: [INFO] Mounting shared directory 2025-11-21 12:43:25 (3985): Guest Log: [INFO] Checking for init_data.xml 2025-11-21 12:43:25 (3985): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2025-11-21 12:43:25 (3985): Guest Log: [INFO] Detected branch: prod 2025-11-21 12:43:25 (3985): Guest Log: This is the prod version of the ATLAS job wrapper 2025-11-21 12:43:25 (3985): Guest Log: Copying input files 2025-11-21 12:43:25 (3985): Guest Log: Copied input files into RunAtlas. 2025-11-21 12:43:25 (3985): Guest Log: This VM did not configure a local http proxy via BOINC. 2025-11-21 12:43:25 (3985): Guest Log: Small home clusters do not require a local http proxy but it is suggested if 2025-11-21 12:43:25 (3985): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks. 2025-11-21 12:43:25 (3985): Guest Log: Further information can be found at the LHC@home message board. 2025-11-21 12:43:25 (3985): Guest Log: Running cvmfs_config stat atlas.cern.ch 2025-11-21 12:43:25 (3985): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2025-11-21 12:43:25 (3985): Guest Log: 2.6.3.0 1672 1 29976 153121 3 1 2087373 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1 2025-11-21 12:43:25 (3985): Guest Log: copied the webapp to /var/www 2025-11-21 12:43:25 (3985): Guest Log: ATHENA_PROC_NUMBER=8 2025-11-21 12:43:25 (3985): Guest Log: ATHENA_CORE_NUMBER=8 2025-11-21 12:43:25 (3985): Guest Log: Apptainer command /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/data,/home/atlas/RunAtlas /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 2025-11-21 12:43:25 (3985): Guest Log: *** Starting ATLAS job. (PandaID=6892526957 taskID=47493029) *** 2025-11-21 12:43:25 (3985): Starting VM using VBoxManage interface. (boinc_1a056c4dc96080c1, slot#16) 2025-11-21 12:43:43 (3985): Successfully started VM. (PID = '3998') 2025-11-21 12:43:43 (3985): Reporting VM Process ID to BOINC. 2025-11-21 12:43:43 (3985): VM state change detected. (old = 'poweredoff', new = 'running') 2025-11-21 12:43:43 (3985): Detected: Web Application Enabled (http://localhost:50562) 2025-11-21 12:43:43 (3985): Status Report: Elapsed Time: '37182.000000' 2025-11-21 12:43:43 (3985): Status Report: CPU Time: '69489.980000' 2025-11-21 12:43:43 (3985): Preference change detected 2025-11-21 12:43:43 (3985): Setting CPU throttle for VM. (5%) 2025-11-21 12:43:43 (3985): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-11-21 12:49:41 (3985): Preference change detected 2025-11-21 12:49:41 (3985): Setting CPU throttle for VM. (10%) 2025-11-21 12:49:41 (3985): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-11-21 12:49:53 (3985): VM state change detected. (old = 'running', new = 'paused') 2025-11-21 12:50:13 (3985): VM state change detected. (old = 'paused', new = 'running') 2025-11-21 13:49:11 (3985): VM state change detected. (old = 'running', new = 'paused') 2025-11-21 13:49:12 (3985): VM state change detected. (old = 'paused', new = 'running') 2025-11-21 14:23:38 (3985): Status Report: Elapsed Time: '43182.000000' 2025-11-21 14:23:38 (3985): Status Report: CPU Time: '82952.270000' 2025-11-21 15:06:09 (3985): VM state change detected. (old = 'running', new = 'paused') 2025-11-21 15:06:10 (3985): VM state change detected. (old = 'paused', new = 'running') 2025-11-21 16:03:13 (3985): Status Report: Elapsed Time: '49182.000000' 2025-11-21 16:03:13 (3985): Status Report: CPU Time: '105429.000000' 2025-11-21 17:02:00 (3985): VM state change detected. (old = 'running', new = 'paused') 2025-11-21 17:02:20 (3985): VM state change detected. (old = 'paused', new = 'running') 2025-11-21 17:36:55 (3985): Stopping VM. 2025-11-21 17:37:23 (3985): Successfully stopped VM. 2025-11-21 18:48:27 (14313): vboxwrapper version 26210 2025-11-21 18:48:27 (14313): BOINC client version: 8.2.5 2025-11-21 18:48:27 (14313): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-11-21 18:48:27 (14313): Detected: Sandbox Configuration Enabled 2025-11-21 18:48:27 (14313): Starting VM using VBoxManage interface. (boinc_1a056c4dc96080c1, slot#16) 2025-11-21 18:48:50 (14313): Successfully started VM. (PID = '14326') 2025-11-21 18:48:50 (14313): Reporting VM Process ID to BOINC. 2025-11-21 18:48:50 (14313): VM state change detected. (old = 'poweredoff', new = 'running') 2025-11-21 18:48:50 (14313): Detected: Web Application Enabled (http://localhost:50562) 2025-11-21 18:48:50 (14313): Status Report: Elapsed Time: '54810.000000' 2025-11-21 18:48:50 (14313): Status Report: CPU Time: '126388.400000' 2025-11-21 18:48:50 (14313): Preference change detected 2025-11-21 18:48:50 (14313): Setting CPU throttle for VM. (5%) 2025-11-21 18:48:50 (14313): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-11-21 18:48:51 (14313): Guest Log: 05:58:56.819573 timesync vgsvcTimeSyncWorker: Radical host time change: 4 317 197 000 000ns (HostNow=1 763 747 282 580 000 000 ns HostLast=1 763 742 965 383 000 000 ns) 2025-11-21 18:49:01 (14313): Guest Log: 05:59:06.952569 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 348 658 021 000ns (GuestNow=1 763 747 293 152 805 000 ns GuestLast=1 763 742 944 494 784 000 ns fSetTimeLastLoop=true ) 2025-11-21 18:49:38 (14313): VM state change detected. (old = 'running', new = 'paused') 2025-11-21 18:49:58 (14313): VM state change detected. (old = 'paused', new = 'running') 2025-11-21 18:50:39 (14313): VM state change detected. (old = 'running', new = 'paused') 2025-11-21 18:51:13 (14313): VM state change detected. (old = 'paused', new = 'running') 2025-11-21 18:51:17 (14313): VM state change detected. (old = 'running', new = 'paused') 2025-11-21 20:01:35 (14313): VM state change detected. (old = 'paused', new = 'running') 2025-11-21 20:01:44 (14313): Guest Log: 06:00:37.437093 timesync vgsvcTimeSyncWorker: Radical host time change: 4 223 546 000 000ns (HostNow=1 763 751 660 839 000 000 ns HostLast=1 763 747 437 293 000 000 ns) 2025-11-21 20:01:55 (14313): Guest Log: 06:00:47.461833 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 287 638 613 000ns (GuestNow=1 763 751 671 070 069 000 ns GuestLast=1 763 747 383 431 456 000 ns fSetTimeLastLoop=true ) 2025-11-21 20:02:07 (14313): VM state change detected. (old = 'running', new = 'paused') 2025-11-21 20:02:36 (14313): Stopping VM. 2025-11-21 20:03:09 (14313): Successfully stopped VM. 2025-11-21 20:05:09 (15890): vboxwrapper version 26210 2025-11-21 20:05:09 (15890): BOINC client version: 8.2.5 2025-11-21 20:05:09 (15890): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-11-21 20:05:09 (15890): Detected: Sandbox Configuration Enabled 2025-11-21 20:05:09 (15890): Guest Log: 05:58:56.819573 timesync vgsvcTimeSyncWorker: Radical host time change: 4 317 197 000 000ns (HostNow=1 763 747 282 580 000 000 ns HostLast=1 763 742 965 383 000 000 ns) 2025-11-21 20:05:09 (15890): Guest Log: 05:59:06.952569 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 348 658 021 000ns (GuestNow=1 763 747 293 152 805 000 ns GuestLast=1 763 742 944 494 784 000 ns fSetTimeLastLoop=true ) 2025-11-21 20:05:09 (15890): Guest Log: 06:00:37.437093 timesync vgsvcTimeSyncWorker: Radical host time change: 4 223 546 000 000ns (HostNow=1 763 751 660 839 000 000 ns HostLast=1 763 747 437 293 000 000 ns) 2025-11-21 20:05:09 (15890): Guest Log: 06:00:47.461833 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 287 638 613 000ns (GuestNow=1 763 751 671 070 069 000 ns GuestLast=1 763 747 383 431 456 000 ns fSetTimeLastLoop=true ) 2025-11-21 20:05:09 (15890): Starting VM using VBoxManage interface. (boinc_1a056c4dc96080c1, slot#16) 2025-11-21 20:05:33 (15890): Successfully started VM. (PID = '15903') 2025-11-21 20:05:33 (15890): Reporting VM Process ID to BOINC. 2025-11-21 20:05:33 (15890): VM state change detected. (old = 'poweredoff', new = 'running') 2025-11-21 20:05:33 (15890): Detected: Web Application Enabled (http://localhost:50562) 2025-11-21 20:05:33 (15890): Status Report: Elapsed Time: '54930.000000' 2025-11-21 20:05:33 (15890): Status Report: CPU Time: '126770.500000' 2025-11-21 20:05:33 (15890): Preference change detected 2025-11-21 20:05:33 (15890): Setting CPU throttle for VM. (5%) 2025-11-21 20:05:33 (15890): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-11-21 21:04:39 (15890): VM state change detected. (old = 'running', new = 'paused') 2025-11-21 21:04:40 (15890): VM state change detected. (old = 'paused', new = 'running') 2025-11-21 21:25:14 (15890): VM state change detected. (old = 'running', new = 'paused') 2025-11-21 21:25:15 (15890): VM state change detected. (old = 'paused', new = 'running') 2025-11-21 21:45:12 (15890): Status Report: Elapsed Time: '60930.000000' 2025-11-21 21:45:12 (15890): Status Report: CPU Time: '146767.370000' 2025-11-21 23:19:06 (15890): VM state change detected. (old = 'running', new = 'paused') 2025-11-21 23:19:07 (15890): VM state change detected. (old = 'paused', new = 'running') 2025-11-21 23:24:52 (15890): Status Report: Elapsed Time: '66930.000000' 2025-11-21 23:24:52 (15890): Status Report: CPU Time: '167749.900000' 2025-11-22 00:01:37 (15890): Stopping VM. 2025-11-22 00:02:17 (15890): Successfully stopped VM. 2025-11-22 12:38:56 (881): vboxwrapper version 26210 2025-11-22 12:38:56 (881): BOINC client version: 8.2.5 2025-11-22 12:38:57 (881): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-11-22 12:38:57 (881): Detected: Sandbox Configuration Enabled 2025-11-22 12:38:58 (881): Starting VM using VBoxManage interface. (boinc_1a056c4dc96080c1, slot#16) 2025-11-22 12:39:28 (881): Successfully started VM. (PID = '951') 2025-11-22 12:39:28 (881): Reporting VM Process ID to BOINC. 2025-11-22 12:39:28 (881): VM state change detected. (old = 'poweredoff', new = 'running') 2025-11-22 12:39:28 (881): Detected: Web Application Enabled (http://localhost:50562) 2025-11-22 12:39:28 (881): Status Report: Elapsed Time: '69141.000000' 2025-11-22 12:39:28 (881): Status Report: CPU Time: '175455.160000' 2025-11-22 12:39:28 (881): Preference change detected 2025-11-22 12:39:28 (881): Setting CPU throttle for VM. (5%) 2025-11-22 12:39:28 (881): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-11-22 12:39:31 (881): Guest Log: 09:56:44.246017 timesync vgsvcTimeSyncWorker: Radical host time change: 45 473 406 000 000ns (HostNow=1 763 811 561 731 000 000 ns HostLast=1 763 766 088 325 000 000 ns) 2025-11-22 12:39:41 (881): Guest Log: 09:56:54.321116 timesync vgsvcTimeSyncWorker: Radical guest time change: 45 552 709 903 000ns (GuestNow=1 763 811 571 904 995 000 ns GuestLast=1 763 766 019 195 092 000 ns fSetTimeLastLoop=true ) 2025-11-22 12:39:59 (881): VM state change detected. (old = 'running', new = 'paused') 2025-11-22 12:40:18 (881): Preference change detected 2025-11-22 12:40:18 (881): Setting CPU throttle for VM. (5%) 2025-11-22 12:40:18 (881): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-11-22 12:40:19 (881): VM state change detected. (old = 'paused', new = 'running') 2025-11-22 12:40:28 (881): Stopping VM. 2025-11-22 12:40:50 (881): Successfully stopped VM. 2025-11-22 13:19:36 (2876): vboxwrapper version 26210 2025-11-22 13:19:36 (2876): BOINC client version: 8.2.5 2025-11-22 13:19:36 (2876): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-11-22 13:19:36 (2876): Detected: Sandbox Configuration Enabled 2025-11-22 13:19:37 (2876): Guest Log: 09:56:44.246017 timesync vgsvcTimeSyncWorker: Radical host time change: 45 473 406 000 000ns (HostNow=1 763 811 561 731 000 000 ns HostLast=1 763 766 088 325 000 000 ns) 2025-11-22 13:19:37 (2876): Guest Log: 09:56:54.321116 timesync vgsvcTimeSyncWorker: Radical guest time change: 45 552 709 903 000ns (GuestNow=1 763 811 571 904 995 000 ns GuestLast=1 763 766 019 195 092 000 ns fSetTimeLastLoop=true ) 2025-11-22 13:19:37 (2876): Starting VM using VBoxManage interface. (boinc_1a056c4dc96080c1, slot#16) 2025-11-22 13:19:58 (2876): Successfully started VM. (PID = '2889') 2025-11-22 13:19:58 (2876): Reporting VM Process ID to BOINC. 2025-11-22 13:19:58 (2876): VM state change detected. (old = 'poweredoff', new = 'running') 2025-11-22 13:19:58 (2876): Detected: Web Application Enabled (http://localhost:50562) 2025-11-22 13:19:58 (2876): Status Report: Elapsed Time: '69180.000000' 2025-11-22 13:19:58 (2876): Status Report: CPU Time: '175574.460000' 2025-11-22 13:19:58 (2876): Preference change detected 2025-11-22 13:19:58 (2876): Setting CPU throttle for VM. (5%) 2025-11-22 13:19:59 (2876): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-11-22 13:20:01 (2876): Guest Log: 09:57:24.732222 timesync vgsvcTimeSyncWorker: Radical host time change: 2 373 093 000 000ns (HostNow=1 763 813 967 399 000 000 ns HostLast=1 763 811 594 306 000 000 ns) 2025-11-22 13:20:11 (2876): Guest Log: 09:57:34.739324 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 375 699 234 000ns (GuestNow=1 763 813 977 711 324 000 ns GuestLast=1 763 811 602 012 090 000 ns fSetTimeLastLoop=true ) 2025-11-22 13:38:41 (2876): Stopping VM. 2025-11-22 13:39:02 (2876): Successfully stopped VM. 2025-11-25 15:03:06 (897): vboxwrapper version 26210 2025-11-25 15:03:06 (897): BOINC client version: 8.2.5 2025-11-25 15:03:10 (897): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-11-25 15:03:10 (897): Detected: Sandbox Configuration Enabled 2025-11-25 15:03:12 (897): Guest Log: 09:57:24.732222 timesync vgsvcTimeSyncWorker: Radical host time change: 2 373 093 000 000ns (HostNow=1 763 813 967 399 000 000 ns HostLast=1 763 811 594 306 000 000 ns) 2025-11-25 15:03:12 (897): Guest Log: 09:57:34.739324 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 375 699 234 000ns (GuestNow=1 763 813 977 711 324 000 ns GuestLast=1 763 811 602 012 090 000 ns fSetTimeLastLoop=true ) 2025-11-25 15:03:12 (897): Starting VM using VBoxManage interface. (boinc_1a056c4dc96080c1, slot#16) 2025-11-25 15:03:39 (897): Successfully started VM. (PID = '1004') 2025-11-25 15:03:39 (897): Reporting VM Process ID to BOINC. 2025-11-25 15:03:39 (897): VM state change detected. (old = 'poweredoff', new = 'running') 2025-11-25 15:03:39 (897): Detected: Web Application Enabled (http://localhost:50562) 2025-11-25 15:03:39 (897): Status Report: Elapsed Time: '70307.000000' 2025-11-25 15:03:39 (897): Status Report: CPU Time: '178793.530000' 2025-11-25 15:03:39 (897): Preference change detected 2025-11-25 15:03:39 (897): Setting CPU throttle for VM. (5%) 2025-11-25 15:03:39 (897): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-11-25 15:03:45 (897): Guest Log: 10:16:09.078512 timesync vgsvcTimeSyncWorker: Radical host time change: 264 303 641 000 000ns (HostNow=1 764 079 376 548 000 000 ns HostLast=1 763 815 072 907 000 000 ns) 2025-11-25 15:03:55 (897): Guest Log: 10:16:19.151540 timesync vgsvcTimeSyncWorker: Radical guest time change: 264 294 878 069 000ns (GuestNow=1 764 079 386 774 744 000 ns GuestLast=1 763 815 091 896 675 000 ns fSetTimeLastLoop=true ) 2025-11-25 15:04:08 (897): Stopping VM. 2025-11-25 15:04:31 (897): Successfully stopped VM. 2025-11-25 15:17:07 (842): vboxwrapper version 26210 2025-11-25 15:17:07 (842): BOINC client version: 8.2.5 2025-11-25 15:17:08 (842): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-11-25 15:17:08 (842): Detected: Sandbox Configuration Enabled 2025-11-25 15:17:09 (842): Guest Log: 10:16:09.078512 timesync vgsvcTimeSyncWorker: Radical host time change: 264 303 641 000 000ns (HostNow=1 764 079 376 548 000 000 ns HostLast=1 763 815 072 907 000 000 ns) 2025-11-25 15:17:09 (842): Guest Log: 10:16:19.151540 timesync vgsvcTimeSyncWorker: Radical guest time change: 264 294 878 069 000ns (GuestNow=1 764 079 386 774 744 000 ns GuestLast=1 763 815 091 896 675 000 ns fSetTimeLastLoop=true ) 2025-11-25 15:17:09 (842): Starting VM using VBoxManage interface. (boinc_1a056c4dc96080c1, slot#16) 2025-11-25 15:17:32 (842): Successfully started VM. (PID = '889') 2025-11-25 15:17:32 (842): Reporting VM Process ID to BOINC. 2025-11-25 15:17:32 (842): VM state change detected. (old = 'poweredoff', new = 'running') 2025-11-25 15:17:32 (842): Detected: Web Application Enabled (http://localhost:50562) 2025-11-25 15:17:32 (842): Status Report: Elapsed Time: '70336.000000' 2025-11-25 15:17:32 (842): Status Report: CPU Time: '178864.000000' 2025-11-25 15:17:32 (842): Preference change detected 2025-11-25 15:17:32 (842): Setting CPU throttle for VM. (5%) 2025-11-25 15:17:32 (842): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-11-25 15:18:09 (842): VM state change detected. (old = 'running', new = 'paused') 2025-11-25 15:18:39 (842): VM state change detected. (old = 'paused', new = 'running') 2025-11-25 15:19:10 (842): Guest Log: *** Job finished *** 2025-11-25 15:19:10 (842): Guest Log: *** The last 20 lines of the pilot log: *** 2025-11-25 15:19:11 (842): Guest Log: 2025-11-25 14:17:42,523 | INFO | [payload] execute_payloads thread has finished 2025-11-25 15:19:11 (842): Guest Log: 2025-11-25 14:17:44,528 | INFO | caller=run is remaining thread - safe to abort (names=['<_MainThread(MainThread, started 139974297868096)>']) 2025-11-25 15:19:11 (842): Guest Log: 2025-11-25 14:17:47,748 [wrapper] supervise_pilot (15 min periods counter: 41) 2025-11-25 15:19:11 (842): Guest Log: 2025-11-25 14:17:49,535 | INFO | all workflow threads have been joined 2025-11-25 15:19:11 (842): Guest Log: 2025-11-25 14:17:49,535 | INFO | end of generic workflow (traces error code: 1213) 2025-11-25 15:19:11 (842): Guest Log: 2025-11-25 14:17:49,639 | INFO | traces error code: 1213 2025-11-25 15:19:11 (842): Guest Log: 2025-11-25 14:17:49,641 | INFO | an exit code was already set: 1213 (will be converted to a standard shell code) 2025-11-25 15:19:11 (842): Guest Log: 2025-11-25 14:17:49,645 | INFO | pilot has finished (exit code=1213, shell exit code=81) 2025-11-25 15:19:11 (842): Guest Log: 2025-11-25 14:17:54,923 [wrapper] ==== pilot stdout END ==== 2025-11-25 15:19:11 (842): Guest Log: 2025-11-25 14:17:55,242 [wrapper] ==== wrapper stdout RESUME ==== 2025-11-25 15:19:11 (842): Guest Log: 2025-11-25 14:17:55,451 [wrapper] pilotpid: 6186 2025-11-25 15:19:11 (842): Guest Log: 2025-11-25 14:17:55,970 [wrapper] Pilot exit status: 81 2025-11-25 15:19:11 (842): Guest Log: 2025-11-25 14:17:57,776 [wrapper] pandaids: 6892526957 2025-11-25 15:19:11 (842): Guest Log: 2025-11-25 14:17:58,554 [wrapper] WARNING: pilot exitcode non-zero: 81 2025-11-25 15:19:11 (842): Guest Log: 2025-11-25 14:17:58,858 [wrapper] WARNING: pilot exitcode non-zero: 81 2025-11-25 15:19:11 (842): Guest Log: 2025-11-25 14:18:00,703 [wrapper] cleanup supervisor_pilot 24015 6187 2025-11-25 15:19:11 (842): Guest Log: 2025-11-25 14:18:01,116 [wrapper] Test setup, not cleaning 2025-11-25 15:19:11 (842): Guest Log: 2025-11-25 14:18:01,739 [wrapper] apfmon messages muted 2025-11-25 15:19:11 (842): Guest Log: 2025-11-25 14:18:02,259 [wrapper] ==== wrapper stdout END ==== 2025-11-25 15:19:11 (842): Guest Log: 2025-11-25 14:18:03,598 [wrapper] ==== wrapper stderr END ==== 2025-11-25 15:19:11 (842): Guest Log: *** Error codes and diagnostics *** 2025-11-25 15:19:11 (842): Guest Log: *** Listing of results directory *** 2025-11-25 15:19:12 (842): Guest Log: total 12444 2025-11-25 15:19:12 (842): Guest Log: -rw-r--r--. 1 atlas atlas 576529 Nov 19 07:00 pilot3.tar.gz 2025-11-25 15:19:12 (842): Guest Log: -rw-r--r--. 1 atlas atlas 5112 Nov 19 07:10 queuedata.json 2025-11-25 15:19:12 (842): Guest Log: -rwx------. 1 atlas atlas 36292 Nov 19 07:10 runpilot2-wrapper.sh 2025-11-25 15:19:12 (842): Guest Log: -rw-r-----. 1 atlas atlas 15120 Nov 21 10:29 start_atlas.sh 2025-11-25 15:19:12 (842): Guest Log: -rw-r-----. 1 atlas atlas 590096 Nov 21 10:29 input.tar.gz 2025-11-25 15:19:12 (842): Guest Log: -rw-r--r--. 1 atlas atlas 10075 Nov 21 10:29 init_data.xml 2025-11-25 15:19:12 (842): Guest Log: lrwxrwxrwx. 1 atlas atlas 20 Nov 21 10:30 EVNT.47493027._000120.pool.root.1 -> /data/./ATLAS.root_0 2025-11-25 15:19:12 (842): Guest Log: -rw-r--r--. 1 atlas atlas 2773 Nov 21 10:30 pandaJob.out 2025-11-25 15:19:12 (842): Guest Log: -rw-------. 1 atlas atlas 989817 Nov 21 10:36 agis_schedconf.cvmfs.json 2025-11-25 15:19:12 (842): Guest Log: -rw-------. 1 atlas atlas 1526164 Nov 21 10:36 agis_ddmendpoints.agis.ALL.json 2025-11-25 15:19:12 (842): Guest Log: drwx------. 5 atlas atlas 4096 Nov 21 10:36 pilot3 2025-11-25 15:19:12 (842): Guest Log: -rw-------. 1 atlas atlas 98 Nov 22 12:37 pilot_heartbeat.json 2025-11-25 15:19:12 (842): Guest Log: drwxrwx---. 3 atlas atlas 4096 Nov 25 14:03 PanDA_Pilot-6892526957 2025-11-25 15:19:12 (842): Guest Log: -rw-------. 1 atlas atlas 1044 Nov 25 14:03 memory_monitor_summary.json 2025-11-25 15:19:12 (842): Guest Log: -rw-------. 1 atlas atlas 1169 Nov 25 14:03 heartbeat.json 2025-11-25 15:19:12 (842): Guest Log: -rw-------. 1 atlas atlas 2963528 Nov 25 14:17 pilotlog.txt 2025-11-25 15:19:12 (842): Guest Log: -rw-------. 1 atlas atlas 2978061 Nov 25 14:18 log.47493029._001158.job.log.1 2025-11-25 15:19:12 (842): Guest Log: -rw-r--r--. 1 atlas atlas 571 Nov 25 14:18 runtime_log 2025-11-25 15:19:12 (842): Guest Log: -rw-------. 1 atlas atlas 2990080 Nov 25 14:18 result.tar.gz 2025-11-25 15:19:12 (842): Guest Log: -rw-r--r--. 1 atlas atlas 8037 Nov 25 14:18 runtime_log.err 2025-11-25 15:19:12 (842): Guest Log: -rw-------. 1 atlas atlas 681 Nov 25 14:18 5w2KDmIWrf8nsSi4ap6QjLDmwznN0nGgGQJmNLGKDmWjGKDmcNrRwn.diag 2025-11-25 15:19:12 (842): Guest Log: Looking for outputfile HITS.47493029._001158.pool.root.1 2025-11-25 15:19:12 (842): Guest Log: No HITS file was produced 2025-11-25 15:19:13 (842): Guest Log: Successfully finished the ATLAS job! 2025-11-25 15:19:13 (842): Guest Log: Copying the results back to the shared directory! 2025-11-25 15:19:17 (842): Guest Log: *** Contents of shared directory: *** 2025-11-25 15:19:18 (842): Guest Log: total 403520 2025-11-25 15:19:18 (842): Guest Log: -rw-rw----. 1 root root 409591248 Nov 19 17:14 ATLAS.root_0 2025-11-25 15:19:18 (842): Guest Log: -rw-rw-r--. 1 root root 10075 Nov 19 17:14 init_data.xml 2025-11-25 15:19:18 (842): Guest Log: -rw-rw----. 1 root root 590096 Nov 19 17:14 input.tar.gz 2025-11-25 15:19:18 (842): Guest Log: -rw-r--r--. 1 root root 2990080 Nov 25 2025 result.tar.gz 2025-11-25 15:19:18 (842): Guest Log: -rw-rw----. 1 root root 15120 Nov 19 17:14 start_atlas.sh 2025-11-25 15:19:18 (842): Guest Log: *** Success! Shutting down the machine. *** 2025-11-25 15:19:19 (842): VM Completion File Detected. 2025-11-25 15:19:19 (842): Powering off VM. 2025-11-25 15:19:19 (842): Successfully stopped VM. 2025-11-25 15:19:19 (842): Deregistering VM. (boinc_1a056c4dc96080c1, slot#16) 2025-11-25 15:19:19 (842): Removing network bandwidth throttle group from VM. 2025-11-25 15:19:19 (842): Removing VM from VirtualBox. 2025-11-25 15:19:24 (842): called boinc_finish(0) </stderr_txt> ]]>
©2025 CERN