| Name | k39LDmmkXz7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDm4ePLDm3uLAYm_1 |
| Workunit | 233790054 |
| Created | 25 Jul 2025, 16:45:42 UTC |
| Sent | 25 Jul 2025, 19:25:11 UTC |
| Report deadline | 2 Aug 2025, 19:25:11 UTC |
| Received | 27 Jul 2025, 16:46:02 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 10692378 |
| Run time | 4 hours 49 min 46 sec |
| CPU time | 1 days 6 hours 27 min 49 sec |
| Validate state | Valid |
| Credit | 673.53 |
| Device peak FLOPS | 28.86 GFLOPS |
| Application version | ATLAS Simulation v3.01 (vbox64_mt_mcore_atlas) x86_64-apple-darwin |
| Peak working set size | 7.17 GB |
| Peak swap size | 70.19 GB |
| Peak disk usage | 221.93 MB |
Stderr output
<core_client_version>7.20.2</core_client_version> <![CDATA[ <stderr_txt> : 00:00:00.000397 main OS Product: Linux 2025-07-27 06:28:52 (69862): Guest Log: 00:00:00.000461 main OS Release: 3.10.0-957.27.2.el7.x86_64 2025-07-27 06:28:52 (69862): Guest Log: 00:00:00.000519 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2025-07-27 06:28:52 (69862): Guest Log: 00:00:00.000576 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2025-07-27 06:28:52 (69862): Guest Log: 00:00:00.000577 main Process ID: 1376 2025-07-27 06:28:52 (69862): Guest Log: 00:00:00.000578 main Package type: LINUX_64BITS_GENERIC 2025-07-27 06:28:52 (69862): Guest Log: 00:00:00.004530 main 5.2.32 r132073 started. Verbose level = 0 2025-07-27 06:28:53 (69862): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2025-07-27 06:28:53 (69862): Guest Log: [INFO] Mounting shared directory 2025-07-27 06:28:53 (69862): Guest Log: [INFO] Checking for init_data.xml 2025-07-27 06:28:58 (69862): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2025-07-27 06:28:58 (69862): Guest Log: [INFO] Detected branch: prod 2025-07-27 06:28:58 (69862): Guest Log: This is the prod version of the ATLAS job wrapper 2025-07-27 06:28:58 (69862): Guest Log: Copying input files 2025-07-27 06:29:02 (69862): Guest Log: Copied input files into RunAtlas. 2025-07-27 06:29:02 (69862): Guest Log: This VM did not configure a local http proxy via BOINC. 2025-07-27 06:29:02 (69862): Guest Log: Small home clusters do not require a local http proxy but it is suggested if 2025-07-27 06:29:02 (69862): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks. 2025-07-27 06:29:02 (69862): Guest Log: Further information can be found at the LHC@home message board. 2025-07-27 06:29:16 (69862): Guest Log: Running cvmfs_config stat atlas.cern.ch 2025-07-27 06:29:16 (69862): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2025-07-27 06:29:16 (69862): Guest Log: 2.6.3.0 1654 0 31968 148800 4 1 3861697 4096000 0 65024 0 0 n/a 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1 2025-07-27 06:29:17 (69862): Guest Log: copied the webapp to /var/www 2025-07-27 06:29:17 (69862): Guest Log: ATHENA_PROC_NUMBER=8 2025-07-27 06:29:17 (69862): Guest Log: ATHENA_CORE_NUMBER=8 2025-07-27 06:29:17 (69862): Guest Log: Apptainer command /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/data,/home/atlas/RunAtlas /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 2025-07-27 06:29:17 (69862): Guest Log: *** Starting ATLAS job. (PandaID=6745055598 taskID=45743349) *** 2025-07-27 06:58:20 (69862): Stopping VM. 2025-07-27 06:58:50 (69862): Successfully stopped VM. 2025-07-27 08:43:49 (3636): Detected: vboxwrapper 26206 2025-07-27 08:43:49 (3636): Detected: BOINC client v7.20.2 2025-07-27 08:43:49 (3636): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-07-27 08:43:49 (3636): Detected: Sandbox Configuration Enabled 2025-07-27 08:43:49 (3636): Guest Log: BIOS: VirtualBox 7.1.10 2025-07-27 08:43:49 (3636): Guest Log: CPUID EDX: 0x178bfbff 2025-07-27 08:43:49 (3636): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-07-27 08:43:49 (3636): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-07-27 08:43:49 (3636): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-07-27 08:43:49 (3636): Guest Log: BIOS: Booting from Hard Disk... 2025-07-27 08:43:49 (3636): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-07-27 08:43:49 (3636): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2025-07-27 08:43:49 (3636): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2025-07-27 08:43:49 (3636): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-07-27 08:43:49 (3636): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-07-27 08:43:49 (3636): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2025-07-27 08:43:49 (3636): Guest Log: 00:00:00.000237 main Log opened 2025-07-27T04:28:50.331216000Z 2025-07-27 08:43:49 (3636): Guest Log: 00:00:00.000397 main OS Product: Linux 2025-07-27 08:43:49 (3636): Guest Log: 00:00:00.000461 main OS Release: 3.10.0-957.27.2.el7.x86_64 2025-07-27 08:43:49 (3636): Guest Log: 00:00:00.000519 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2025-07-27 08:43:49 (3636): Guest Log: 00:00:00.000576 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2025-07-27 08:43:49 (3636): Guest Log: 00:00:00.000577 main Process ID: 1376 2025-07-27 08:43:49 (3636): Guest Log: 00:00:00.000578 main Package type: LINUX_64BITS_GENERIC 2025-07-27 08:43:49 (3636): Guest Log: 00:00:00.004530 main 5.2.32 r132073 started. Verbose level = 0 2025-07-27 08:43:49 (3636): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2025-07-27 08:43:49 (3636): Guest Log: [INFO] Mounting shared directory 2025-07-27 08:43:49 (3636): Guest Log: [INFO] Checking for init_data.xml 2025-07-27 08:43:49 (3636): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2025-07-27 08:43:49 (3636): Guest Log: [INFO] Detected branch: prod 2025-07-27 08:43:49 (3636): Guest Log: This is the prod version of the ATLAS job wrapper 2025-07-27 08:43:49 (3636): Guest Log: Copying input files 2025-07-27 08:43:49 (3636): Guest Log: Copied input files into RunAtlas. 2025-07-27 08:43:49 (3636): Guest Log: This VM did not configure a local http proxy via BOINC. 2025-07-27 08:43:49 (3636): Guest Log: Small home clusters do not require a local http proxy but it is suggested if 2025-07-27 08:43:49 (3636): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks. 2025-07-27 08:43:49 (3636): Guest Log: Further information can be found at the LHC@home message board. 2025-07-27 08:43:49 (3636): Guest Log: Running cvmfs_config stat atlas.cern.ch 2025-07-27 08:43:49 (3636): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2025-07-27 08:43:49 (3636): Guest Log: 2.6.3.0 1654 0 31968 148800 4 1 3861697 4096000 0 65024 0 0 n/a 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1 2025-07-27 08:43:49 (3636): Guest Log: copied the webapp to /var/www 2025-07-27 08:43:49 (3636): Guest Log: ATHENA_PROC_NUMBER=8 2025-07-27 08:43:49 (3636): Guest Log: ATHENA_CORE_NUMBER=8 2025-07-27 08:43:49 (3636): Guest Log: Apptainer command /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/data,/home/atlas/RunAtlas /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 2025-07-27 08:43:49 (3636): Guest Log: *** Starting ATLAS job. (PandaID=6745055598 taskID=45743349) *** 2025-07-27 08:43:49 (3636): Starting VM using VBoxManage interface. (boinc_ad8421673abd1a47, slot#0) 2025-07-27 08:44:15 (3636): Successfully started VM. (PID = '3651') 2025-07-27 08:44:15 (3636): Reporting VM Process ID to BOINC. 2025-07-27 08:44:15 (3636): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-27 08:44:15 (3636): Detected: Web Application Enabled (http://localhost:54893) 2025-07-27 08:44:15 (3636): Preference change detected 2025-07-27 08:44:15 (3636): Setting CPU throttle for VM. (100%) 2025-07-27 08:44:15 (3636): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-07-27 08:44:23 (3636): Guest Log: 00:29:36.148552 timesync vgsvcTimeSyncWorker: Radical host time change: 6 363 899 000 000ns (HostNow=1 753 598 663 473 000 000 ns HostLast=1 753 592 299 574 000 000 ns) 2025-07-27 08:44:34 (3636): Guest Log: 00:29:46.197332 timesync vgsvcTimeSyncWorker: Radical guest time change: 6 367 308 336 000ns (GuestNow=1 753 598 673 654 779 000 ns GuestLast=1 753 592 306 346 443 000 ns fSetTimeLastLoop=true ) 2025-07-27 08:44:47 (3636): Stopping VM. 2025-07-27 08:45:15 (3636): Successfully stopped VM. 2025-07-27 08:55:20 (3940): Detected: vboxwrapper 26206 2025-07-27 08:55:20 (3940): Detected: BOINC client v7.20.2 2025-07-27 08:55:20 (3940): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-07-27 08:55:20 (3940): Detected: Sandbox Configuration Enabled 2025-07-27 08:55:20 (3940): Guest Log: 00:29:36.148552 timesync vgsvcTimeSyncWorker: Radical host time change: 6 363 899 000 000ns (HostNow=1 753 598 663 473 000 000 ns HostLast=1 753 592 299 574 000 000 ns) 2025-07-27 08:55:20 (3940): Guest Log: 00:29:46.197332 timesync vgsvcTimeSyncWorker: Radical guest time change: 6 367 308 336 000ns (GuestNow=1 753 598 673 654 779 000 ns GuestLast=1 753 592 306 346 443 000 ns fSetTimeLastLoop=true ) 2025-07-27 08:55:20 (3940): Starting VM using VBoxManage interface. (boinc_ad8421673abd1a47, slot#0) 2025-07-27 08:55:47 (3940): Successfully started VM. (PID = '3953') 2025-07-27 08:55:47 (3940): Reporting VM Process ID to BOINC. 2025-07-27 08:55:47 (3940): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-27 08:55:47 (3940): Detected: Web Application Enabled (http://localhost:54893) 2025-07-27 08:55:47 (3940): Preference change detected 2025-07-27 08:55:47 (3940): Setting CPU throttle for VM. (100%) 2025-07-27 08:55:47 (3940): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-07-27 08:59:02 (3940): Stopping VM. 2025-07-27 08:59:33 (3940): Successfully stopped VM. 2025-07-27 09:02:06 (4228): Detected: vboxwrapper 26206 2025-07-27 09:02:06 (4228): Detected: BOINC client v7.20.2 2025-07-27 09:02:06 (4228): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-07-27 09:02:06 (4228): Detected: Sandbox Configuration Enabled 2025-07-27 09:02:07 (4228): Starting VM using VBoxManage interface. (boinc_ad8421673abd1a47, slot#0) 2025-07-27 09:02:26 (4228): Successfully started VM. (PID = '4241') 2025-07-27 09:02:26 (4228): Reporting VM Process ID to BOINC. 2025-07-27 09:02:26 (4228): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-27 09:02:26 (4228): Detected: Web Application Enabled (http://localhost:54893) 2025-07-27 09:02:26 (4228): Preference change detected 2025-07-27 09:02:26 (4228): Setting CPU throttle for VM. (100%) 2025-07-27 09:02:26 (4228): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-07-27 09:04:59 (4228): Stopping VM. 2025-07-27 09:05:28 (4228): Successfully stopped VM. 2025-07-27 09:08:41 (4659): Detected: vboxwrapper 26206 2025-07-27 09:08:41 (4659): Detected: BOINC client v7.20.2 2025-07-27 09:08:42 (4659): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-07-27 09:08:42 (4659): Detected: Sandbox Configuration Enabled 2025-07-27 09:08:42 (4659): Starting VM using VBoxManage interface. (boinc_ad8421673abd1a47, slot#0) 2025-07-27 09:09:03 (4659): Successfully started VM. (PID = '4672') 2025-07-27 09:09:03 (4659): Reporting VM Process ID to BOINC. 2025-07-27 09:09:03 (4659): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-27 09:09:03 (4659): Detected: Web Application Enabled (http://localhost:54893) 2025-07-27 09:09:03 (4659): Preference change detected 2025-07-27 09:09:03 (4659): Setting CPU throttle for VM. (100%) 2025-07-27 09:09:04 (4659): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-07-27 09:10:00 (4659): Stopping VM. 2025-07-27 09:10:25 (4659): Successfully stopped VM. 2025-07-27 09:13:10 (4977): Detected: vboxwrapper 26206 2025-07-27 09:13:10 (4977): Detected: BOINC client v7.20.2 2025-07-27 09:13:10 (4977): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-07-27 09:13:10 (4977): Detected: Sandbox Configuration Enabled 2025-07-27 09:13:10 (4977): Starting VM using VBoxManage interface. (boinc_ad8421673abd1a47, slot#0) 2025-07-27 09:13:24 (4977): Successfully started VM. (PID = '4996') 2025-07-27 09:13:24 (4977): Reporting VM Process ID to BOINC. 2025-07-27 09:13:24 (4977): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-27 09:13:24 (4977): Detected: Web Application Enabled (http://localhost:54893) 2025-07-27 09:13:24 (4977): Preference change detected 2025-07-27 09:13:24 (4977): Setting CPU throttle for VM. (100%) 2025-07-27 09:13:24 (4977): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-07-27 09:16:30 (4977): Stopping VM. 2025-07-27 09:16:57 (4977): Successfully stopped VM. 2025-07-27 09:29:58 (5683): Detected: vboxwrapper 26206 2025-07-27 09:29:58 (5683): Detected: BOINC client v7.20.2 2025-07-27 09:29:58 (5683): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-07-27 09:29:58 (5683): Detected: Sandbox Configuration Enabled 2025-07-27 09:29:58 (5683): Starting VM using VBoxManage interface. (boinc_ad8421673abd1a47, slot#0) 2025-07-27 09:30:16 (5683): Successfully started VM. (PID = '5713') 2025-07-27 09:30:16 (5683): Reporting VM Process ID to BOINC. 2025-07-27 09:30:16 (5683): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-27 09:30:16 (5683): Detected: Web Application Enabled (http://localhost:54893) 2025-07-27 09:30:16 (5683): Preference change detected 2025-07-27 09:30:16 (5683): Setting CPU throttle for VM. (100%) 2025-07-27 09:30:16 (5683): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-07-27 09:32:26 (5683): Stopping VM. 2025-07-27 09:32:56 (5683): Successfully stopped VM. 2025-07-27 09:36:03 (5898): Detected: vboxwrapper 26206 2025-07-27 09:36:03 (5898): Detected: BOINC client v7.20.2 2025-07-27 09:36:03 (5898): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-07-27 09:36:03 (5898): Detected: Sandbox Configuration Enabled 2025-07-27 09:36:03 (5898): Starting VM using VBoxManage interface. (boinc_ad8421673abd1a47, slot#0) 2025-07-27 09:36:24 (5898): Successfully started VM. (PID = '5928') 2025-07-27 09:36:24 (5898): Reporting VM Process ID to BOINC. 2025-07-27 09:36:24 (5898): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-27 09:36:24 (5898): Detected: Web Application Enabled (http://localhost:54893) 2025-07-27 09:36:24 (5898): Preference change detected 2025-07-27 09:36:24 (5898): Setting CPU throttle for VM. (100%) 2025-07-27 09:36:24 (5898): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-07-27 09:36:26 (5898): Stopping VM. 2025-07-27 09:36:54 (5898): Successfully stopped VM. 2025-07-27 10:17:29 (6867): Detected: vboxwrapper 26206 2025-07-27 10:17:29 (6867): Detected: BOINC client v7.20.2 2025-07-27 10:17:29 (6867): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-07-27 10:17:29 (6867): Detected: Sandbox Configuration Enabled 2025-07-27 10:17:29 (6867): Starting VM using VBoxManage interface. (boinc_ad8421673abd1a47, slot#0) 2025-07-27 10:17:49 (6867): Successfully started VM. (PID = '6899') 2025-07-27 10:17:49 (6867): Reporting VM Process ID to BOINC. 2025-07-27 10:17:49 (6867): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-27 10:17:49 (6867): Detected: Web Application Enabled (http://localhost:54893) 2025-07-27 10:17:49 (6867): Stopping VM. 2025-07-27 10:18:21 (6867): Successfully stopped VM. 2025-07-27 11:01:25 (8503): Detected: vboxwrapper 26206 2025-07-27 11:01:25 (8503): Detected: BOINC client v7.20.2 2025-07-27 11:01:25 (8503): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-07-27 11:01:25 (8503): Detected: Sandbox Configuration Enabled 2025-07-27 11:01:26 (8503): Starting VM using VBoxManage interface. (boinc_ad8421673abd1a47, slot#0) 2025-07-27 11:01:43 (8503): Successfully started VM. (PID = '8534') 2025-07-27 11:01:43 (8503): Reporting VM Process ID to BOINC. 2025-07-27 11:01:43 (8503): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-27 11:01:43 (8503): Detected: Web Application Enabled (http://localhost:54893) 2025-07-27 11:01:43 (8503): Preference change detected 2025-07-27 11:01:43 (8503): Setting CPU throttle for VM. (100%) 2025-07-27 11:01:43 (8503): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-07-27 11:01:49 (8503): Guest Log: 00:42:17.058676 timesync vgsvcTimeSyncWorker: Radical host time change: 5 124 169 000 000ns (HostNow=1 753 606 908 456 000 000 ns HostLast=1 753 601 784 287 000 000 ns) 2025-07-27 11:01:59 (8503): Guest Log: 00:42:27.063703 timesync vgsvcTimeSyncWorker: Radical guest time change: 5 124 173 016 000ns (GuestNow=1 753 606 918 461 923 000 ns GuestLast=1 753 601 794 288 907 000 ns fSetTimeLastLoop=true ) 2025-07-27 11:04:22 (8503): VM state change detected. (old = 'running', new = 'paused') 2025-07-27 11:04:32 (8503): VM state change detected. (old = 'paused', new = 'running') 2025-07-27 11:08:52 (8503): Stopping VM. 2025-07-27 11:09:24 (8503): Successfully stopped VM. 2025-07-27 11:52:08 (10298): Detected: vboxwrapper 26206 2025-07-27 11:52:08 (10298): Detected: BOINC client v7.20.2 2025-07-27 11:52:09 (10298): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-07-27 11:52:09 (10298): Detected: Sandbox Configuration Enabled 2025-07-27 11:52:09 (10298): Guest Log: 00:42:17.058676 timesync vgsvcTimeSyncWorker: Radical host time change: 5 124 169 000 000ns (HostNow=1 753 606 908 456 000 000 ns HostLast=1 753 601 784 287 000 000 ns) 2025-07-27 11:52:09 (10298): Guest Log: 00:42:27.063703 timesync vgsvcTimeSyncWorker: Radical guest time change: 5 124 173 016 000ns (GuestNow=1 753 606 918 461 923 000 ns GuestLast=1 753 601 794 288 907 000 ns fSetTimeLastLoop=true ) 2025-07-27 11:52:09 (10298): Starting VM using VBoxManage interface. (boinc_ad8421673abd1a47, slot#0) 2025-07-27 11:52:31 (10298): Successfully started VM. (PID = '10328') 2025-07-27 11:52:31 (10298): Reporting VM Process ID to BOINC. 2025-07-27 11:52:31 (10298): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-27 11:52:31 (10298): Detected: Web Application Enabled (http://localhost:54893) 2025-07-27 11:52:31 (10298): Preference change detected 2025-07-27 11:52:31 (10298): Setting CPU throttle for VM. (100%) 2025-07-27 11:52:31 (10298): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-07-27 11:52:37 (10298): Guest Log: 00:49:17.853727 timesync vgsvcTimeSyncWorker: Radical host time change: 2 627 965 000 000ns (HostNow=1 753 609 957 323 000 000 ns HostLast=1 753 607 329 358 000 000 ns) 2025-07-27 11:52:48 (10298): Guest Log: 00:49:27.865063 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 638 269 385 000ns (GuestNow=1 753 609 967 427 834 000 ns GuestLast=1 753 607 329 158 449 000 ns fSetTimeLastLoop=true ) 2025-07-27 11:54:56 (10298): Stopping VM. 2025-07-27 11:55:35 (10298): Successfully stopped VM. 2025-07-27 12:16:55 (11242): Detected: vboxwrapper 26206 2025-07-27 12:16:55 (11242): Detected: BOINC client v7.20.2 2025-07-27 12:16:55 (11242): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-07-27 12:16:55 (11242): Detected: Sandbox Configuration Enabled 2025-07-27 12:16:55 (11242): Guest Log: 00:49:17.853727 timesync vgsvcTimeSyncWorker: Radical host time change: 2 627 965 000 000ns (HostNow=1 753 609 957 323 000 000 ns HostLast=1 753 607 329 358 000 000 ns) 2025-07-27 12:16:55 (11242): Guest Log: 00:49:27.865063 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 638 269 385 000ns (GuestNow=1 753 609 967 427 834 000 ns GuestLast=1 753 607 329 158 449 000 ns fSetTimeLastLoop=true ) 2025-07-27 12:16:55 (11242): Starting VM using VBoxManage interface. (boinc_ad8421673abd1a47, slot#0) 2025-07-27 12:17:20 (11242): Successfully started VM. (PID = '11266') 2025-07-27 12:17:20 (11242): Reporting VM Process ID to BOINC. 2025-07-27 12:17:20 (11242): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-27 12:17:20 (11242): Detected: Web Application Enabled (http://localhost:54893) 2025-07-27 12:17:20 (11242): Preference change detected 2025-07-27 12:17:20 (11242): Setting CPU throttle for VM. (100%) 2025-07-27 12:17:20 (11242): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-07-27 12:19:51 (11242): Stopping VM. 2025-07-27 12:20:24 (11242): Successfully stopped VM. 2025-07-27 12:22:53 (11454): Detected: vboxwrapper 26206 2025-07-27 12:22:53 (11454): Detected: BOINC client v7.20.2 2025-07-27 12:22:54 (11454): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-07-27 12:22:54 (11454): Detected: Sandbox Configuration Enabled 2025-07-27 12:22:54 (11454): Starting VM using VBoxManage interface. (boinc_ad8421673abd1a47, slot#0) 2025-07-27 12:23:14 (11454): Successfully started VM. (PID = '11484') 2025-07-27 12:23:14 (11454): Reporting VM Process ID to BOINC. 2025-07-27 12:23:14 (11454): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-27 12:23:14 (11454): Detected: Web Application Enabled (http://localhost:54893) 2025-07-27 12:23:14 (11454): Preference change detected 2025-07-27 12:23:14 (11454): Setting CPU throttle for VM. (100%) 2025-07-27 12:23:14 (11454): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-07-27 12:31:56 (11454): Status Report: Elapsed Time: '6000.000000' 2025-07-27 12:31:56 (11454): Status Report: CPU Time: '35124.580000' 2025-07-27 13:09:19 (11454): Stopping VM. 2025-07-27 13:12:53 (14097): Detected: vboxwrapper 26206 2025-07-27 13:12:53 (14097): Detected: BOINC client v7.20.2 2025-07-27 13:12:53 (14097): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-07-27 13:12:53 (14097): Detected: Sandbox Configuration Enabled 2025-07-27 13:12:54 (14097): Starting VM using VBoxManage interface. (boinc_ad8421673abd1a47, slot#0) 2025-07-27 13:12:59 (14097): Successfully started VM. (PID = '14128') 2025-07-27 13:12:59 (14097): Reporting VM Process ID to BOINC. 2025-07-27 13:12:59 (14097): Guest Log: BIOS: VirtualBox 7.1.10 2025-07-27 13:12:59 (14097): Guest Log: CPUID EDX: 0x178bfbff 2025-07-27 13:12:59 (14097): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-07-27 13:12:59 (14097): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-07-27 13:12:59 (14097): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-27 13:12:59 (14097): Detected: Web Application Enabled (http://localhost:54893) 2025-07-27 13:12:59 (14097): Status Report: Elapsed Time: '8262.000000' 2025-07-27 13:12:59 (14097): Status Report: CPU Time: '50285.980000' 2025-07-27 13:12:59 (14097): Preference change detected 2025-07-27 13:12:59 (14097): Setting CPU throttle for VM. (100%) 2025-07-27 13:13:00 (14097): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-07-27 13:13:01 (14097): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-07-27 13:13:01 (14097): Guest Log: BIOS: Booting from Hard Disk... 2025-07-27 13:13:05 (14097): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-07-27 13:13:05 (14097): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2025-07-27 13:13:05 (14097): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2025-07-27 13:13:12 (14097): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-07-27 13:13:12 (14097): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-07-27 13:13:23 (14097): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2025-07-27 13:13:23 (14097): Guest Log: 00:00:00.000266 main Log opened 2025-07-27T11:13:21.813489000Z 2025-07-27 13:13:23 (14097): Guest Log: 00:00:00.000441 main OS Product: Linux 2025-07-27 13:13:23 (14097): Guest Log: 00:00:00.000518 main OS Release: 3.10.0-957.27.2.el7.x86_64 2025-07-27 13:13:23 (14097): Guest Log: 00:00:00.000562 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2025-07-27 13:13:23 (14097): Guest Log: 00:00:00.000612 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2025-07-27 13:13:23 (14097): Guest Log: 00:00:00.000613 main Process ID: 1370 2025-07-27 13:13:23 (14097): Guest Log: 00:00:00.000614 main Package type: LINUX_64BITS_GENERIC 2025-07-27 13:13:23 (14097): Guest Log: 00:00:00.005021 main 5.2.32 r132073 started. Verbose level = 0 2025-07-27 13:13:24 (14097): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2025-07-27 13:13:24 (14097): Guest Log: [INFO] Mounting shared directory 2025-07-27 13:13:24 (14097): Guest Log: [INFO] Checking for init_data.xml 2025-07-27 13:13:30 (14097): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2025-07-27 13:13:30 (14097): Guest Log: [INFO] Detected branch: prod 2025-07-27 13:13:30 (14097): Guest Log: This is the prod version of the ATLAS job wrapper 2025-07-27 13:13:30 (14097): Guest Log: Copying input files 2025-07-27 13:13:33 (14097): Guest Log: Copied input files into RunAtlas. 2025-07-27 13:13:34 (14097): Guest Log: This VM did not configure a local http proxy via BOINC. 2025-07-27 13:13:34 (14097): Guest Log: Small home clusters do not require a local http proxy but it is suggested if 2025-07-27 13:13:34 (14097): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks. 2025-07-27 13:13:34 (14097): Guest Log: Further information can be found at the LHC@home message board. 2025-07-27 13:13:44 (14097): Guest Log: Running cvmfs_config stat atlas.cern.ch 2025-07-27 13:13:44 (14097): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2025-07-27 13:13:44 (14097): Guest Log: 2.6.3.0 1648 0 29940 148810 3 1 3918856 4096001 0 65024 0 0 n/a 0 0 http://s1ihep-cvmfs.openhtc.io:8080/cvmfs/atlas.cern.ch DIRECT 1 2025-07-27 13:13:45 (14097): Guest Log: copied the webapp to /var/www 2025-07-27 13:13:45 (14097): Guest Log: ATHENA_PROC_NUMBER=8 2025-07-27 13:13:45 (14097): Guest Log: ATHENA_CORE_NUMBER=8 2025-07-27 13:13:45 (14097): Guest Log: Apptainer command /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/data,/home/atlas/RunAtlas /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 2025-07-27 13:13:46 (14097): Guest Log: *** Starting ATLAS job. (PandaID=6745055598 taskID=45743349) *** 2025-07-27 13:14:23 (14097): Stopping VM. 2025-07-27 13:14:33 (14097): Successfully stopped VM. 2025-07-27 13:23:47 (14422): Detected: vboxwrapper 26206 2025-07-27 13:23:47 (14422): Detected: BOINC client v7.20.2 2025-07-27 13:23:47 (14422): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-07-27 13:23:47 (14422): Detected: Sandbox Configuration Enabled 2025-07-27 13:23:48 (14422): Guest Log: BIOS: VirtualBox 7.1.10 2025-07-27 13:23:48 (14422): Guest Log: CPUID EDX: 0x178bfbff 2025-07-27 13:23:48 (14422): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-07-27 13:23:48 (14422): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-07-27 13:23:48 (14422): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-07-27 13:23:48 (14422): Guest Log: BIOS: Booting from Hard Disk... 2025-07-27 13:23:48 (14422): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-07-27 13:23:48 (14422): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2025-07-27 13:23:48 (14422): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2025-07-27 13:23:48 (14422): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-07-27 13:23:48 (14422): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-07-27 13:23:48 (14422): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2025-07-27 13:23:48 (14422): Guest Log: 00:00:00.000266 main Log opened 2025-07-27T11:13:21.813489000Z 2025-07-27 13:23:48 (14422): Guest Log: 00:00:00.000441 main OS Product: Linux 2025-07-27 13:23:48 (14422): Guest Log: 00:00:00.000518 main OS Release: 3.10.0-957.27.2.el7.x86_64 2025-07-27 13:23:48 (14422): Guest Log: 00:00:00.000562 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2025-07-27 13:23:48 (14422): Guest Log: 00:00:00.000612 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2025-07-27 13:23:48 (14422): Guest Log: 00:00:00.000613 main Process ID: 1370 2025-07-27 13:23:48 (14422): Guest Log: 00:00:00.000614 main Package type: LINUX_64BITS_GENERIC 2025-07-27 13:23:48 (14422): Guest Log: 00:00:00.005021 main 5.2.32 r132073 started. Verbose level = 0 2025-07-27 13:23:48 (14422): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2025-07-27 13:23:48 (14422): Guest Log: [INFO] Mounting shared directory 2025-07-27 13:23:48 (14422): Guest Log: [INFO] Checking for init_data.xml 2025-07-27 13:23:48 (14422): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2025-07-27 13:23:48 (14422): Guest Log: [INFO] Detected branch: prod 2025-07-27 13:23:48 (14422): Guest Log: This is the prod version of the ATLAS job wrapper 2025-07-27 13:23:48 (14422): Guest Log: Copying input files 2025-07-27 13:23:48 (14422): Guest Log: Copied input files into RunAtlas. 2025-07-27 13:23:48 (14422): Guest Log: This VM did not configure a local http proxy via BOINC. 2025-07-27 13:23:48 (14422): Guest Log: Small home clusters do not require a local http proxy but it is suggested if 2025-07-27 13:23:48 (14422): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks. 2025-07-27 13:23:48 (14422): Guest Log: Further information can be found at the LHC@home message board. 2025-07-27 13:23:48 (14422): Guest Log: Running cvmfs_config stat atlas.cern.ch 2025-07-27 13:23:48 (14422): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2025-07-27 13:23:48 (14422): Guest Log: 2.6.3.0 1648 0 29940 148810 3 1 3918856 4096001 0 65024 0 0 n/a 0 0 http://s1ihep-cvmfs.openhtc.io:8080/cvmfs/atlas.cern.ch DIRECT 1 2025-07-27 13:23:48 (14422): Guest Log: copied the webapp to /var/www 2025-07-27 13:23:48 (14422): Guest Log: ATHENA_PROC_NUMBER=8 2025-07-27 13:23:48 (14422): Guest Log: ATHENA_CORE_NUMBER=8 2025-07-27 13:23:48 (14422): Guest Log: Apptainer command /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/data,/home/atlas/RunAtlas /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 2025-07-27 13:23:48 (14422): Guest Log: *** Starting ATLAS job. (PandaID=6745055598 taskID=45743349) *** 2025-07-27 13:23:48 (14422): Starting VM using VBoxManage interface. (boinc_ad8421673abd1a47, slot#0) 2025-07-27 13:24:02 (14422): Successfully started VM. (PID = '14454') 2025-07-27 13:24:02 (14422): Reporting VM Process ID to BOINC. 2025-07-27 13:24:02 (14422): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-27 13:24:02 (14422): Detected: Web Application Enabled (http://localhost:54893) 2025-07-27 13:24:02 (14422): Status Report: Elapsed Time: '8346.000000' 2025-07-27 13:24:02 (14422): Status Report: CPU Time: '50416.700000' 2025-07-27 13:24:02 (14422): Preference change detected 2025-07-27 13:24:02 (14422): Setting CPU throttle for VM. (100%) 2025-07-27 13:24:02 (14422): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-07-27 13:43:53 (14422): Stopping VM. 2025-07-27 13:44:29 (14422): Successfully stopped VM. 2025-07-27 13:46:56 (15293): Detected: vboxwrapper 26206 2025-07-27 13:46:56 (15293): Detected: BOINC client v7.20.2 2025-07-27 13:46:56 (15293): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-07-27 13:46:56 (15293): Detected: Sandbox Configuration Enabled 2025-07-27 13:46:56 (15293): Starting VM using VBoxManage interface. (boinc_ad8421673abd1a47, slot#0) 2025-07-27 13:47:16 (15293): Successfully started VM. (PID = '15323') 2025-07-27 13:47:16 (15293): Reporting VM Process ID to BOINC. 2025-07-27 13:47:16 (15293): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-27 13:47:16 (15293): Detected: Web Application Enabled (http://localhost:54893) 2025-07-27 13:47:16 (15293): Status Report: Elapsed Time: '9546.000000' 2025-07-27 13:47:16 (15293): Status Report: CPU Time: '56014.120000' 2025-07-27 13:47:16 (15293): Preference change detected 2025-07-27 13:47:16 (15293): Setting CPU throttle for VM. (100%) 2025-07-27 13:47:16 (15293): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-07-27 13:57:31 (15293): Stopping VM. 2025-07-27 13:58:10 (15293): Successfully stopped VM. 2025-07-27 14:03:13 (16262): Detected: vboxwrapper 26206 2025-07-27 14:03:13 (16262): Detected: BOINC client v7.20.2 2025-07-27 14:03:13 (16262): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-07-27 14:03:13 (16262): Detected: Sandbox Configuration Enabled 2025-07-27 14:03:13 (16262): Starting VM using VBoxManage interface. (boinc_ad8421673abd1a47, slot#0) 2025-07-27 14:03:36 (16262): Successfully started VM. (PID = '16293') 2025-07-27 14:03:36 (16262): Reporting VM Process ID to BOINC. 2025-07-27 14:03:36 (16262): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-27 14:03:36 (16262): Detected: Web Application Enabled (http://localhost:54893) 2025-07-27 14:03:36 (16262): Status Report: Elapsed Time: '10166.000000' 2025-07-27 14:03:36 (16262): Status Report: CPU Time: '59956.130000' 2025-07-27 14:03:36 (16262): Preference change detected 2025-07-27 14:03:36 (16262): Setting CPU throttle for VM. (100%) 2025-07-27 14:03:36 (16262): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-07-27 14:12:32 (16262): Stopping VM. 2025-07-27 14:13:09 (16262): Successfully stopped VM. 2025-07-27 14:16:06 (16814): Detected: vboxwrapper 26206 2025-07-27 14:16:06 (16814): Detected: BOINC client v7.20.2 2025-07-27 14:16:06 (16814): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-07-27 14:16:06 (16814): Detected: Sandbox Configuration Enabled 2025-07-27 14:16:07 (16814): Starting VM using VBoxManage interface. (boinc_ad8421673abd1a47, slot#0) 2025-07-27 14:16:29 (16814): Successfully started VM. (PID = '16845') 2025-07-27 14:16:29 (16814): Reporting VM Process ID to BOINC. 2025-07-27 14:16:29 (16814): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-27 14:16:29 (16814): Detected: Web Application Enabled (http://localhost:54893) 2025-07-27 14:16:29 (16814): Status Report: Elapsed Time: '10706.000000' 2025-07-27 14:16:29 (16814): Status Report: CPU Time: '63426.960000' 2025-07-27 14:16:29 (16814): Preference change detected 2025-07-27 14:16:29 (16814): Setting CPU throttle for VM. (100%) 2025-07-27 14:16:29 (16814): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-07-27 14:20:18 (16814): Stopping VM. 2025-07-27 14:20:51 (16814): Successfully stopped VM. 2025-07-27 14:23:19 (17088): Detected: vboxwrapper 26206 2025-07-27 14:23:19 (17088): Detected: BOINC client v7.20.2 2025-07-27 14:23:19 (17088): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-07-27 14:23:19 (17088): Detected: Sandbox Configuration Enabled 2025-07-27 14:23:19 (17088): Starting VM using VBoxManage interface. (boinc_ad8421673abd1a47, slot#0) 2025-07-27 14:23:39 (17088): Successfully started VM. (PID = '17119') 2025-07-27 14:23:39 (17088): Reporting VM Process ID to BOINC. 2025-07-27 14:23:39 (17088): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-27 14:23:39 (17088): Detected: Web Application Enabled (http://localhost:54893) 2025-07-27 14:23:39 (17088): Status Report: Elapsed Time: '10937.000000' 2025-07-27 14:23:39 (17088): Status Report: CPU Time: '64889.990000' 2025-07-27 14:23:39 (17088): Preference change detected 2025-07-27 14:23:39 (17088): Setting CPU throttle for VM. (100%) 2025-07-27 14:23:39 (17088): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-07-27 14:36:40 (17088): Stopping VM. 2025-07-27 14:37:18 (17088): Successfully stopped VM. 2025-07-27 14:39:39 (17669): Detected: vboxwrapper 26206 2025-07-27 14:39:39 (17669): Detected: BOINC client v7.20.2 2025-07-27 14:39:39 (17669): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-07-27 14:39:39 (17669): Detected: Sandbox Configuration Enabled 2025-07-27 14:39:40 (17669): Starting VM using VBoxManage interface. (boinc_ad8421673abd1a47, slot#0) 2025-07-27 14:40:03 (17669): Successfully started VM. (PID = '17700') 2025-07-27 14:40:03 (17669): Reporting VM Process ID to BOINC. 2025-07-27 14:40:03 (17669): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-27 14:40:03 (17669): Detected: Web Application Enabled (http://localhost:54893) 2025-07-27 14:40:03 (17669): Status Report: Elapsed Time: '11724.000000' 2025-07-27 14:40:03 (17669): Status Report: CPU Time: '69982.890000' 2025-07-27 14:40:03 (17669): Preference change detected 2025-07-27 14:40:03 (17669): Setting CPU throttle for VM. (100%) 2025-07-27 14:40:04 (17669): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-07-27 14:41:28 (17669): Stopping VM. 2025-07-27 14:42:04 (17669): Successfully stopped VM. 2025-07-27 14:46:38 (17908): Detected: vboxwrapper 26206 2025-07-27 14:46:38 (17908): Detected: BOINC client v7.20.2 2025-07-27 14:46:38 (17908): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-07-27 14:46:38 (17908): Detected: Sandbox Configuration Enabled 2025-07-27 14:46:39 (17908): Starting VM using VBoxManage interface. (boinc_ad8421673abd1a47, slot#0) 2025-07-27 14:47:02 (17908): Successfully started VM. (PID = '17938') 2025-07-27 14:47:02 (17908): Reporting VM Process ID to BOINC. 2025-07-27 14:47:02 (17908): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-27 14:47:02 (17908): Detected: Web Application Enabled (http://localhost:54893) 2025-07-27 14:47:02 (17908): Status Report: Elapsed Time: '11809.000000' 2025-07-27 14:47:02 (17908): Status Report: CPU Time: '70444.190000' 2025-07-27 14:47:02 (17908): Preference change detected 2025-07-27 14:47:02 (17908): Setting CPU throttle for VM. (100%) 2025-07-27 14:47:02 (17908): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-07-27 14:47:29 (17908): Stopping VM. 2025-07-27 14:48:08 (17908): Successfully stopped VM. 2025-07-27 14:50:31 (18052): Detected: vboxwrapper 26206 2025-07-27 14:50:31 (18052): Detected: BOINC client v7.20.2 2025-07-27 14:50:31 (18052): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-07-27 14:50:31 (18052): Detected: Sandbox Configuration Enabled 2025-07-27 14:50:32 (18052): Starting VM using VBoxManage interface. (boinc_ad8421673abd1a47, slot#0) 2025-07-27 14:50:55 (18052): Successfully started VM. (PID = '18083') 2025-07-27 14:50:55 (18052): Reporting VM Process ID to BOINC. 2025-07-27 14:50:55 (18052): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-27 14:50:55 (18052): Detected: Web Application Enabled (http://localhost:54893) 2025-07-27 14:50:55 (18052): Status Report: Elapsed Time: '11836.000000' 2025-07-27 14:50:55 (18052): Status Report: CPU Time: '70548.610000' 2025-07-27 14:50:55 (18052): Preference change detected 2025-07-27 14:50:55 (18052): Setting CPU throttle for VM. (100%) 2025-07-27 14:50:55 (18052): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-07-27 14:55:22 (18052): Stopping VM. 2025-07-27 14:56:01 (18052): Successfully stopped VM. 2025-07-27 14:58:40 (18579): Detected: vboxwrapper 26206 2025-07-27 14:58:40 (18579): Detected: BOINC client v7.20.2 2025-07-27 14:58:40 (18579): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-07-27 14:58:40 (18579): Detected: Sandbox Configuration Enabled 2025-07-27 14:58:40 (18579): Starting VM using VBoxManage interface. (boinc_ad8421673abd1a47, slot#0) 2025-07-27 14:59:03 (18579): Successfully started VM. (PID = '18609') 2025-07-27 14:59:03 (18579): Reporting VM Process ID to BOINC. 2025-07-27 14:59:03 (18579): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-27 14:59:03 (18579): Detected: Web Application Enabled (http://localhost:54893) 2025-07-27 14:59:03 (18579): Status Report: Elapsed Time: '12105.000000' 2025-07-27 14:59:03 (18579): Status Report: CPU Time: '72145.780000' 2025-07-27 14:59:03 (18579): Preference change detected 2025-07-27 14:59:03 (18579): Setting CPU throttle for VM. (100%) 2025-07-27 14:59:03 (18579): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-07-27 15:02:35 (18579): Stopping VM. 2025-07-27 15:03:10 (18579): Successfully stopped VM. 2025-07-27 15:14:54 (19308): Detected: vboxwrapper 26206 2025-07-27 15:14:54 (19308): Detected: BOINC client v7.20.2 2025-07-27 15:14:54 (19308): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-07-27 15:14:54 (19308): Detected: Sandbox Configuration Enabled 2025-07-27 15:14:54 (19308): Starting VM using VBoxManage interface. (boinc_ad8421673abd1a47, slot#0) 2025-07-27 15:15:15 (19308): Successfully started VM. (PID = '19338') 2025-07-27 15:15:15 (19308): Reporting VM Process ID to BOINC. 2025-07-27 15:15:15 (19308): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-27 15:15:15 (19308): Detected: Web Application Enabled (http://localhost:54893) 2025-07-27 15:15:15 (19308): Status Report: Elapsed Time: '12319.000000' 2025-07-27 15:15:15 (19308): Status Report: CPU Time: '73474.960000' 2025-07-27 15:15:15 (19308): Preference change detected 2025-07-27 15:15:15 (19308): Setting CPU throttle for VM. (100%) 2025-07-27 15:15:16 (19308): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-07-27 15:16:57 (19308): Stopping VM. 2025-07-27 15:17:30 (19308): Successfully stopped VM. 2025-07-27 15:23:50 (19604): Detected: vboxwrapper 26206 2025-07-27 15:23:50 (19604): Detected: BOINC client v7.20.2 2025-07-27 15:23:51 (19604): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-07-27 15:23:51 (19604): Detected: Sandbox Configuration Enabled 2025-07-27 15:23:51 (19604): Starting VM using VBoxManage interface. (boinc_ad8421673abd1a47, slot#0) 2025-07-27 15:24:11 (19604): Successfully started VM. (PID = '19635') 2025-07-27 15:24:11 (19604): Reporting VM Process ID to BOINC. 2025-07-27 15:24:11 (19604): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-27 15:24:11 (19604): Detected: Web Application Enabled (http://localhost:54893) 2025-07-27 15:24:11 (19604): Status Report: Elapsed Time: '12422.000000' 2025-07-27 15:24:11 (19604): Status Report: CPU Time: '74075.010000' 2025-07-27 15:24:11 (19604): Preference change detected 2025-07-27 15:24:11 (19604): Setting CPU throttle for VM. (100%) 2025-07-27 15:24:11 (19604): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-07-27 15:30:01 (19604): Stopping VM. 2025-07-27 15:30:42 (19604): Successfully stopped VM. 2025-07-27 16:02:23 (20949): Detected: vboxwrapper 26206 2025-07-27 16:02:23 (20949): Detected: BOINC client v7.20.2 2025-07-27 16:02:23 (20949): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-07-27 16:02:23 (20949): Detected: Sandbox Configuration Enabled 2025-07-27 16:02:24 (20949): Starting VM using VBoxManage interface. (boinc_ad8421673abd1a47, slot#0) 2025-07-27 16:02:47 (20949): Successfully started VM. (PID = '20977') 2025-07-27 16:02:47 (20949): Reporting VM Process ID to BOINC. 2025-07-27 16:02:47 (20949): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-27 16:02:47 (20949): Detected: Web Application Enabled (http://localhost:54893) 2025-07-27 16:02:47 (20949): Status Report: Elapsed Time: '12775.000000' 2025-07-27 16:02:47 (20949): Status Report: CPU Time: '76331.940000' 2025-07-27 16:02:47 (20949): Preference change detected 2025-07-27 16:02:47 (20949): Setting CPU throttle for VM. (100%) 2025-07-27 16:02:47 (20949): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-07-27 16:02:49 (20949): Guest Log: 01:14:37.763443 timesync vgsvcTimeSyncWorker: Radical host time change: 1 974 080 000 000ns (HostNow=1 753 624 968 525 000 000 ns HostLast=1 753 622 994 445 000 000 ns) 2025-07-27 16:03:00 (20949): Guest Log: 01:14:47.808841 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 974 066 259 000ns (GuestNow=1 753 624 978 706 280 000 ns GuestLast=1 753 623 004 640 021 000 ns fSetTimeLastLoop=true ) 2025-07-27 16:05:55 (20949): Stopping VM. 2025-07-27 16:06:34 (20949): Successfully stopped VM. 2025-07-27 16:23:58 (21574): Detected: vboxwrapper 26206 2025-07-27 16:23:58 (21574): Detected: BOINC client v7.20.2 2025-07-27 16:23:58 (21574): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-07-27 16:23:58 (21574): Detected: Sandbox Configuration Enabled 2025-07-27 16:23:59 (21574): Guest Log: 01:14:37.763443 timesync vgsvcTimeSyncWorker: Radical host time change: 1 974 080 000 000ns (HostNow=1 753 624 968 525 000 000 ns HostLast=1 753 622 994 445 000 000 ns) 2025-07-27 16:23:59 (21574): Guest Log: 01:14:47.808841 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 974 066 259 000ns (GuestNow=1 753 624 978 706 280 000 ns GuestLast=1 753 623 004 640 021 000 ns fSetTimeLastLoop=true ) 2025-07-27 16:23:59 (21574): Starting VM using VBoxManage interface. (boinc_ad8421673abd1a47, slot#0) 2025-07-27 16:24:24 (21574): Successfully started VM. (PID = '21604') 2025-07-27 16:24:24 (21574): Reporting VM Process ID to BOINC. 2025-07-27 16:24:24 (21574): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-27 16:24:24 (21574): Detected: Web Application Enabled (http://localhost:54893) 2025-07-27 16:24:24 (21574): Status Report: Elapsed Time: '12965.000000' 2025-07-27 16:24:24 (21574): Status Report: CPU Time: '77534.340000' 2025-07-27 16:24:24 (21574): Preference change detected 2025-07-27 16:24:24 (21574): Setting CPU throttle for VM. (100%) 2025-07-27 16:24:24 (21574): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-07-27 17:34:16 (21574): Stopping VM. 2025-07-27 17:35:16 (21574): Successfully stopped VM. 2025-07-27 17:40:19 (25024): Detected: vboxwrapper 26206 2025-07-27 17:40:19 (25024): Detected: BOINC client v7.20.2 2025-07-27 17:40:20 (25024): Detected: VirtualBox VboxManage Interface (Version: 7.1.10) 2025-07-27 17:40:20 (25024): Detected: Sandbox Configuration Enabled 2025-07-27 17:40:20 (25024): Starting VM using VBoxManage interface. (boinc_ad8421673abd1a47, slot#0) 2025-07-27 17:40:39 (25024): Successfully started VM. (PID = '25054') 2025-07-27 17:40:39 (25024): Reporting VM Process ID to BOINC. 2025-07-27 17:40:39 (25024): VM state change detected. (old = 'poweredoff', new = 'running') 2025-07-27 17:40:39 (25024): Detected: Web Application Enabled (http://localhost:54893) 2025-07-27 17:40:39 (25024): Status Report: Elapsed Time: '17194.000000' 2025-07-27 17:40:39 (25024): Status Report: CPU Time: '106548.960000' 2025-07-27 17:40:39 (25024): Preference change detected 2025-07-27 17:40:39 (25024): Setting CPU throttle for VM. (100%) 2025-07-27 17:40:40 (25024): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2025-07-27 17:47:40 (25024): Guest Log: *** Job finished *** 2025-07-27 17:47:40 (25024): Guest Log: *** The last 20 lines of the pilot log: *** 2025-07-27 17:47:40 (25024): Guest Log: 2025-07-27 15:47:18,535 | INFO | all workflow threads have been joined 2025-07-27 17:47:40 (25024): Guest Log: 2025-07-27 15:47:18,535 | INFO | end of generic workflow (traces error code: 0) 2025-07-27 17:47:40 (25024): Guest Log: 2025-07-27 15:47:18,536 | INFO | traces error code: 0 2025-07-27 17:47:40 (25024): Guest Log: 2025-07-27 15:47:18,537 | INFO | pilot has finished (exit code=0, shell exit code=0) 2025-07-27 17:47:40 (25024): Guest Log: 2025-07-27 15:47:39,353 | INFO | PID=6035 has CPU usage=4.5% CMD=/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/python/3.9.20-x86_64-centos7/bin/python3 pilot3/pilot.py -q BOINC_MCORE -i PR -j managed --pilot-user ATLAS --harvester-submit-mode PUSH -w generic --job-type managed --resource-type MCORE -z -t 2025-07-27 17:47:40 (25024): Guest Log: 2025-07-27 15:47:39,354 | INFO | found 0 job(s) in 20 queues 2025-07-27 17:47:40 (25024): Guest Log: 2025-07-27 15:47:39,354 | WARNING | pilot monitor received instruction that args.graceful_stop has been set 2025-07-27 17:47:40 (25024): Guest Log: 2025-07-27 15:47:39,354 | WARNING | will wait for a maximum of 300 s for threads to finish 2025-07-27 17:47:40 (25024): Guest Log: 2025-07-27 15:47:39,354 | WARNING | job_aborted has been set - aborting pilot monitoring 2025-07-27 17:47:40 (25024): Guest Log: 2025-07-27 15:47:39,354 | INFO | [monitor] control thread has ended 2025-07-27 17:47:40 (25024): Guest Log: 2025-07-27 15:47:39,529 [wrapper] ==== pilot stdout END ==== 2025-07-27 17:47:40 (25024): Guest Log: 2025-07-27 15:47:39,543 [wrapper] ==== wrapper stdout RESUME ==== 2025-07-27 17:47:40 (25024): Guest Log: 2025-07-27 15:47:39,560 [wrapper] pilotpid: 6035 2025-07-27 17:47:40 (25024): Guest Log: 2025-07-27 15:47:39,575 [wrapper] Pilot exit status: 0 2025-07-27 17:47:40 (25024): Guest Log: 2025-07-27 15:47:39,728 [wrapper] pandaids: 6745055598 2025-07-27 17:47:40 (25024): Guest Log: 2025-07-27 15:47:39,834 [wrapper] cleanup supervisor_pilot 469 6036 2025-07-27 17:47:40 (25024): Guest Log: 2025-07-27 15:47:39,852 [wrapper] Test setup, not cleaning 2025-07-27 17:47:40 (25024): Guest Log: 2025-07-27 15:47:39,871 [wrapper] apfmon messages muted 2025-07-27 17:47:40 (25024): Guest Log: 2025-07-27 15:47:39,894 [wrapper] ==== wrapper stdout END ==== 2025-07-27 17:47:40 (25024): Guest Log: 2025-07-27 15:47:39,916 [wrapper] ==== wrapper stderr END ==== 2025-07-27 17:47:40 (25024): Guest Log: *** Error codes and diagnostics *** 2025-07-27 17:47:40 (25024): Guest Log: "exeErrorCode": 0, 2025-07-27 17:47:40 (25024): Guest Log: "exeErrorDiag": "", 2025-07-27 17:47:40 (25024): Guest Log: "pilotErrorCode": 0, 2025-07-27 17:47:40 (25024): Guest Log: "pilotErrorDiag": "", 2025-07-27 17:47:40 (25024): Guest Log: *** Listing of results directory *** 2025-07-27 17:47:40 (25024): Guest Log: total 212768 2025-07-27 17:47:40 (25024): Guest Log: -rw-r--r--. 1 atlas atlas 530466 Jul 25 13:22 pilot3.tar.gz 2025-07-27 17:47:40 (25024): Guest Log: -rwx------. 1 atlas atlas 36292 Jul 25 13:34 runpilot2-wrapper.sh 2025-07-27 17:47:40 (25024): Guest Log: -rw-r--r--. 1 atlas atlas 5112 Jul 25 13:34 queuedata.json 2025-07-27 17:47:40 (25024): Guest Log: -rw-r-----. 1 atlas atlas 15095 Jul 27 11:13 start_atlas.sh 2025-07-27 17:47:40 (25024): Guest Log: -rw-r-----. 1 atlas atlas 542879 Jul 27 11:13 input.tar.gz 2025-07-27 17:47:40 (25024): Guest Log: -rw-r--r--. 1 atlas atlas 8308 Jul 27 11:13 init_data.xml 2025-07-27 17:47:40 (25024): Guest Log: lrwxrwxrwx. 1 atlas atlas 20 Jul 27 11:13 EVNT.45743347._001246.pool.root.1 -> /data/./ATLAS.root_0 2025-07-27 17:47:40 (25024): Guest Log: -rw-r--r--. 1 atlas atlas 2561 Jul 27 11:13 pandaJob.out 2025-07-27 17:47:40 (25024): Guest Log: -rw-------. 1 atlas atlas 980117 Jul 27 11:24 agis_schedconf.cvmfs.json 2025-07-27 17:47:40 (25024): Guest Log: drwx------. 4 atlas atlas 4096 Jul 27 11:24 pilot3 2025-07-27 17:47:40 (25024): Guest Log: -rw-------. 1 atlas atlas 212113201 Jul 27 15:46 HITS.45743349._021788.pool.root.1 2025-07-27 17:47:40 (25024): Guest Log: -rw-------. 1 atlas atlas 1035 Jul 27 15:46 memory_monitor_summary.json 2025-07-27 17:47:40 (25024): Guest Log: -rw-------. 1 atlas atlas 1593052 Jul 27 15:46 agis_ddmendpoints.agis.ALL.json 2025-07-27 17:47:40 (25024): Guest Log: -rw-------. 1 atlas atlas 319601 Jul 27 15:46 log.45743349._021788.job.log.tgz.1 2025-07-27 17:47:40 (25024): Guest Log: -rw-------. 1 atlas atlas 97 Jul 27 15:46 pilot_heartbeat.json 2025-07-27 17:47:40 (25024): Guest Log: -rw-------. 1 atlas atlas 7774 Jul 27 15:47 heartbeat.json 2025-07-27 17:47:40 (25024): Guest Log: -rw-------. 1 atlas atlas 744 Jul 27 15:47 pilotlog.txt 2025-07-27 17:47:40 (25024): Guest Log: -rw-------. 1 atlas atlas 658602 Jul 27 15:47 log.45743349._021788.job.log.1 2025-07-27 17:47:40 (25024): Guest Log: -rw-------. 1 atlas atlas 357 Jul 27 15:47 output.list 2025-07-27 17:47:40 (25024): Guest Log: -rw-r--r--. 1 atlas atlas 620 Jul 27 15:47 runtime_log 2025-07-27 17:47:40 (25024): Guest Log: -rw-------. 1 atlas atlas 993280 Jul 27 15:47 result.tar.gz 2025-07-27 17:47:40 (25024): Guest Log: -rw-r--r--. 1 atlas atlas 8605 Jul 27 15:47 runtime_log.err 2025-07-27 17:47:40 (25024): Guest Log: -rw-------. 1 atlas atlas 666 Jul 27 15:47 k39LDmmkXz7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDm4ePLDm3uLAYm.diag 2025-07-27 17:47:40 (25024): Guest Log: Looking for outputfile HITS.45743349._021788.pool.root.1 2025-07-27 17:47:40 (25024): Guest Log: HITS file was successfully produced 2025-07-27 17:47:40 (25024): Guest Log: -rw-------. 1 atlas atlas 212113201 Jul 27 15:46 /home/atlas/RunAtlas/HITS.45743349._021788.pool.root.1 2025-07-27 17:47:40 (25024): Guest Log: Successfully finished the ATLAS job! 2025-07-27 17:47:40 (25024): Guest Log: Copying the results back to the shared directory! 2025-07-27 17:47:40 (25024): Guest Log: *** Contents of shared directory: *** 2025-07-27 17:47:40 (25024): Guest Log: total 227816 2025-07-27 17:47:40 (25024): Guest Log: -rw-rw----. 1 root root 231711218 Jul 27 03:45 ATLAS.root_0 2025-07-27 17:47:40 (25024): Guest Log: -rw-rw-r--. 1 root root 8308 Jul 27 03:45 init_data.xml 2025-07-27 17:47:40 (25024): Guest Log: -rw-rw----. 1 root root 542879 Jul 27 03:45 input.tar.gz 2025-07-27 17:47:40 (25024): Guest Log: -rw-r--r--. 1 root root 993280 Jul 27 15:47 result.tar.gz 2025-07-27 17:47:40 (25024): Guest Log: -rw-rw----. 1 root root 15095 Jul 27 03:45 start_atlas.sh 2025-07-27 17:47:40 (25024): Guest Log: *** Success! Shutting down the machine. *** 2025-07-27 17:47:40 (25024): VM Completion File Detected. 2025-07-27 17:47:40 (25024): Powering off VM. 2025-07-27 17:47:41 (25024): Successfully stopped VM. 2025-07-27 17:47:41 (25024): Deregistering VM. (boinc_ad8421673abd1a47, slot#0) 2025-07-27 17:47:41 (25024): Removing network bandwidth throttle group from VM. 2025-07-27 17:47:41 (25024): Removing VM from VirtualBox. 17:47:46 (25024): called boinc_finish(0) </stderr_txt> ]]>
©2025 CERN