Name | rkOLDml3AP8n9Rq4apOajLDm4fhM0noT9bVof3QYDmq2CMDmwEFCKm_2 |
Workunit | 235427991 |
Created | 5 Oct 2025, 2:53:29 UTC |
Sent | 5 Oct 2025, 4:19:36 UTC |
Report deadline | 13 Oct 2025, 4:19:36 UTC |
Received | 5 Oct 2025, 9:40:27 UTC |
Server state | Over |
Outcome | Success |
Client state | Done |
Exit status | 0 (0x00000000) |
Computer ID | 10856815 |
Run time | 1 hours 35 min 15 sec |
CPU time | 10 hours 4 min 23 sec |
Validate state | Valid |
Credit | 221.27 |
Device peak FLOPS | 24.18 GFLOPS |
Application version | ATLAS Simulation v3.01 (native_mt) x86_64-pc-linux-gnu |
Peak working set size | 2.67 GB |
Peak swap size | 3.05 GB |
Peak disk usage | 585.78 MB |
<core_client_version>8.1.0</core_client_version> <![CDATA[ <stderr_txt> 03:59:50 (1906732): wrapper (7.7.26015): starting 03:59:50 (1906732): wrapper: running run_atlas (--nthreads 9) [2025-10-05 03:59:50] Arguments: --nthreads 9 [2025-10-05 03:59:50] Threads: 9 [2025-10-05 03:59:50] Checking for CVMFS [2025-10-05 03:59:51] Probing /cvmfs/atlas.cern.ch... OK [2025-10-05 03:59:51] Probing /cvmfs/atlas-condb.cern.ch... OK [2025-10-05 03:59:51] Running cvmfs_config stat atlas.cern.ch [2025-10-05 03:59:52] VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE [2025-10-05 03:59:52] 2.13.2.0 2815078 118896 428604 151355 1 285 24243704 32947200 22210 16776704 0 224665052 99.634 218383224 21460 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.231.239:6081 1 [2025-10-05 03:59:52] CVMFS is ok [2025-10-05 03:59:52] Efficiency of ATLAS tasks can be improved by the following measure(s): [2025-10-05 03:59:52] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io. [2025-10-05 03:59:52] Further information can be found at the LHC@home message board. [2025-10-05 03:59:52] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 [2025-10-05 03:59:52] Checking for apptainer binary... [2025-10-05 03:59:52] Using apptainer found in PATH at /usr/bin/apptainer [2025-10-05 03:59:52] Running /usr/bin/apptainer --version [2025-10-05 03:59:52] apptainer version 1.4.2-1.el9 [2025-10-05 03:59:52] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname [2025-10-05 03:59:52] c6-6-8-2.aglt2.org [2025-10-05 03:59:52] apptainer works [2025-10-05 03:59:52] Set ATHENA_PROC_NUMBER=9 [2025-10-05 03:59:52] Set ATHENA_CORE_NUMBER=9 [2025-10-05 03:59:52] Starting ATLAS job with PandaID=6829374961 [2025-10-05 03:59:52] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/2 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh [2025-10-05 05:36:22] *** The last 200 lines of the pilot log: *** [2025-10-05 05:36:22] 2025-10-05 09:35:26,211 | INFO | .. there are 29 such processes running [2025-10-05 05:36:22] 2025-10-05 09:35:27,212 | INFO | time since job start (5683s) is within the limit (172800.0s) [2025-10-05 05:36:22] 2025-10-05 09:35:27,569 | INFO | monitor loop #392: job 0:6829374961 is in state 'finished' [2025-10-05 05:36:22] 2025-10-05 09:35:27,569 | INFO | will abort job monitoring soon since job state=finished (job is still in queue) [2025-10-05 05:36:22] 2025-10-05 09:35:27,938 | INFO | job 6829374961 has state=finished [2025-10-05 05:36:22] 2025-10-05 09:35:27,938 | INFO | preparing for final server update for job 6829374961 in state='finished' [2025-10-05 05:36:22] 2025-10-05 09:35:27,938 | INFO | this job has now completed (state=finished) [2025-10-05 05:36:22] 2025-10-05 09:35:27,939 | INFO | pilot will not update the server (heartbeat message will be written to file) [2025-10-05 05:36:22] 2025-10-05 09:35:27,939 | INFO | log transfer has been attempted: DONE [2025-10-05 05:36:22] 2025-10-05 09:35:27,939 | INFO | job 6829374961 has finished - writing final server update [2025-10-05 05:36:22] 2025-10-05 09:35:27,939 | INFO | total number of processed events: 400 (read) [2025-10-05 05:36:22] 2025-10-05 09:35:27,957 | INFO | executing command: lscpu [2025-10-05 05:36:22] 2025-10-05 09:35:28,091 | INFO | executing command: export ATLAS_LOCAL_ROOT_BASE=/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase;source ${ATLAS_LOCAL_ROOT_BASE}/user/atlasLocalSetup.sh --quiet;lsetup [2025-10-05 05:36:22] 2025-10-05 09:35:29,225 | INFO | time since job start (5685s) is within the limit (172800.0s) [2025-10-05 05:36:22] 2025-10-05 09:35:30,074 | INFO | monitor loop #393: job 0:6829374961 is in state 'finished' [2025-10-05 05:36:22] 2025-10-05 09:35:30,075 | INFO | will abort job monitoring soon since job state=finished (job is still in queue) [2025-10-05 05:36:22] 2025-10-05 09:35:31,232 | INFO | time since job start (5687s) is within the limit (172800.0s) [2025-10-05 05:36:22] 2025-10-05 09:35:32,580 | INFO | monitor loop #394: job 0:6829374961 is in state 'finished' [2025-10-05 05:36:22] 2025-10-05 09:35:32,580 | INFO | will abort job monitoring soon since job state=finished (job is still in queue) [2025-10-05 05:36:22] 2025-10-05 09:35:33,260 | INFO | time since job start (5689s) is within the limit (172800.0s) [2025-10-05 05:36:22] 2025-10-05 09:35:35,088 | INFO | monitor loop #395: job 0:6829374961 is in state 'finished' [2025-10-05 05:36:22] 2025-10-05 09:35:35,088 | INFO | will abort job monitoring soon since job state=finished (job is still in queue) [2025-10-05 05:36:22] 2025-10-05 09:35:35,270 | INFO | time since job start (5691s) is within the limit (172800.0s) [2025-10-05 05:36:22] 2025-10-05 09:35:37,277 | INFO | time since job start (5693s) is within the limit (172800.0s) [2025-10-05 05:36:22] 2025-10-05 09:35:37,594 | INFO | monitor loop #396: job 0:6829374961 is in state 'finished' [2025-10-05 05:36:22] 2025-10-05 09:35:37,594 | INFO | will abort job monitoring soon since job state=finished (job is still in queue) [2025-10-05 05:36:22] 2025-10-05 09:35:39,285 | INFO | time since job start (5695s) is within the limit (172800.0s) [2025-10-05 05:36:22] 2025-10-05 09:35:40,099 | INFO | monitor loop #397: job 0:6829374961 is in state 'finished' [2025-10-05 05:36:22] 2025-10-05 09:35:40,099 | INFO | will abort job monitoring soon since job state=finished (job is still in queue) [2025-10-05 05:36:22] 2025-10-05 09:35:41,293 | INFO | time since job start (5697s) is within the limit (172800.0s) [2025-10-05 05:36:22] 2025-10-05 09:35:42,614 | INFO | monitor loop #398: job 0:6829374961 is in state 'finished' [2025-10-05 05:36:22] 2025-10-05 09:35:42,614 | INFO | will abort job monitoring soon since job state=finished (job is still in queue) [2025-10-05 05:36:22] 2025-10-05 09:35:43,301 | INFO | time since job start (5699s) is within the limit (172800.0s) [2025-10-05 05:36:22] 2025-10-05 09:35:45,121 | INFO | monitor loop #399: job 0:6829374961 is in state 'finished' [2025-10-05 05:36:22] 2025-10-05 09:35:45,121 | INFO | will abort job monitoring soon since job state=finished (job is still in queue) [2025-10-05 05:36:22] 2025-10-05 09:35:45,307 | INFO | time since job start (5701s) is within the limit (172800.0s) [2025-10-05 05:36:22] 2025-10-05 09:35:45,786 | INFO | CPU arch script returned: x86-64-v4 [2025-10-05 05:36:22] 2025-10-05 09:35:45,849 | INFO | found 48 cores (24 cores per socket, 2 sockets) HT, CPU MHz: 2719.207104166666 [2025-10-05 05:36:22] 2025-10-05 09:35:45,958 | INFO | using path: /tmp/boinchome/slots/2/PanDA_Pilot-6829374961/memory_monitor_summary.json (trf name=prmon) [2025-10-05 05:36:22] 2025-10-05 09:35:45,959 | INFO | extracted standard info from prmon json [2025-10-05 05:36:22] 2025-10-05 09:35:45,959 | INFO | extracted standard memory fields from prmon json [2025-10-05 05:36:22] 2025-10-05 09:35:45,959 | WARNING | GPU info not found in prmon json: 'gpu' [2025-10-05 05:36:22] 2025-10-05 09:35:45,981 | WARNING | format EVNTtoHITS has no such key: dbData [2025-10-05 05:36:22] 2025-10-05 09:35:45,981 | WARNING | format EVNTtoHITS has no such key: dbTime [2025-10-05 05:36:22] 2025-10-05 09:35:45,983 | INFO | fitting pss+swap vs Time [2025-10-05 05:36:22] 2025-10-05 09:35:45,984 | INFO | sum of square deviations: 190404912.98823565 [2025-10-05 05:36:22] 2025-10-05 09:35:45,984 | INFO | sum of deviations: -7417227101.458822 [2025-10-05 05:36:22] 2025-10-05 09:35:45,984 | INFO | mean x: 1759654211.0117648 [2025-10-05 05:36:22] 2025-10-05 09:35:45,984 | INFO | mean y: 2241826.4588235295 [2025-10-05 05:36:22] 2025-10-05 09:35:45,985 | INFO | -- intersect: 68549605958.38654 [2025-10-05 05:36:22] 2025-10-05 09:35:45,985 | INFO | intersect: 68549605958.38654 [2025-10-05 05:36:22] 2025-10-05 09:35:45,985 | INFO | chi2: 0.16740312678794128 [2025-10-05 05:36:22] 2025-10-05 09:35:45,985 | INFO | -- intersect: 68549605958.38654 [2025-10-05 05:36:22] 2025-10-05 09:35:45,985 | INFO | current memory leak: -38.96 B/s (using 85 data points, chi2=0.17) [2025-10-05 05:36:22] 2025-10-05 09:35:45,985 | INFO | could have reported an average CPU frequency of 2709 MHz (7 samples) [2025-10-05 05:36:22] 2025-10-05 09:35:45,986 | INFO | .............................. [2025-10-05 05:36:22] 2025-10-05 09:35:45,986 | INFO | . Timing measurements: [2025-10-05 05:36:22] 2025-10-05 09:35:45,986 | INFO | . get job = 0 s [2025-10-05 05:36:22] 2025-10-05 09:35:45,986 | INFO | . initial setup = 4 s [2025-10-05 05:36:22] 2025-10-05 09:35:45,986 | INFO | . payload setup = 24 s [2025-10-05 05:36:22] 2025-10-05 09:35:45,986 | INFO | . stage-in = 0 s [2025-10-05 05:36:22] 2025-10-05 09:35:45,986 | INFO | . payload execution = 5592 s [2025-10-05 05:36:22] 2025-10-05 09:35:45,986 | INFO | . stage-out = 2 s [2025-10-05 05:36:22] 2025-10-05 09:35:45,986 | INFO | . log creation = 0 s [2025-10-05 05:36:22] 2025-10-05 09:35:45,986 | INFO | .............................. [2025-10-05 05:36:22] 2025-10-05 09:35:46,579 | INFO | [2025-10-05 05:36:22] 2025-10-05 09:35:46,579 | INFO | job summary report [2025-10-05 05:36:22] 2025-10-05 09:35:46,579 | INFO | -------------------------------------------------- [2025-10-05 05:36:22] 2025-10-05 09:35:46,579 | INFO | PanDA job id: 6829374961 [2025-10-05 05:36:22] 2025-10-05 09:35:46,579 | INFO | task id: 46376905 [2025-10-05 05:36:22] 2025-10-05 09:35:46,579 | INFO | errors: (none) [2025-10-05 05:36:22] 2025-10-05 09:35:46,579 | INFO | status: LOG_TRANSFER = DONE [2025-10-05 05:36:22] 2025-10-05 09:35:46,579 | INFO | pilot state: finished [2025-10-05 05:36:22] 2025-10-05 09:35:46,579 | INFO | transexitcode: 0 [2025-10-05 05:36:22] 2025-10-05 09:35:46,579 | INFO | exeerrorcode: 0 [2025-10-05 05:36:22] 2025-10-05 09:35:46,580 | INFO | exeerrordiag: [2025-10-05 05:36:22] 2025-10-05 09:35:46,580 | INFO | exitcode: 0 [2025-10-05 05:36:22] 2025-10-05 09:35:46,580 | INFO | exitmsg: OK [2025-10-05 05:36:22] 2025-10-05 09:35:46,580 | INFO | cpuconsumptiontime: 35889 s [2025-10-05 05:36:22] 2025-10-05 09:35:46,580 | INFO | nevents: 400 [2025-10-05 05:36:22] 2025-10-05 09:35:46,580 | INFO | neventsw: 0 [2025-10-05 05:36:22] 2025-10-05 09:35:46,580 | INFO | pid: 1940876 [2025-10-05 05:36:22] 2025-10-05 09:35:46,580 | INFO | pgrp: 1940876 [2025-10-05 05:36:22] 2025-10-05 09:35:46,580 | INFO | corecount: 9 [2025-10-05 05:36:22] 2025-10-05 09:35:46,580 | INFO | event service: False [2025-10-05 05:36:22] 2025-10-05 09:35:46,580 | INFO | sizes: {0: 2348589, 1: 2348645, 2: 2348872, 13: 2348872, 24: 2348928, 28: 2349218, 35: 2349374, 5620: 2376130, 5621: 2376129, 5625: 2385183, 5626: 2385239, 5646: 2 [2025-10-05 05:36:22] 2025-10-05 09:35:46,580 | INFO | -------------------------------------------------- [2025-10-05 05:36:22] 2025-10-05 09:35:46,580 | INFO | [2025-10-05 05:36:22] 2025-10-05 09:35:46,581 | INFO | executing command: ls -lF /tmp/boinchome/slots/2 [2025-10-05 05:36:22] 2025-10-05 09:35:46,744 | INFO | queue jobs had 0 job(s) [purged] [2025-10-05 05:36:22] 2025-10-05 09:35:46,744 | INFO | queue payloads had 0 job(s) [purged] [2025-10-05 05:36:22] 2025-10-05 09:35:46,744 | INFO | queue data_in had 0 job(s) [purged] [2025-10-05 05:36:22] 2025-10-05 09:35:46,744 | INFO | queue data_out had 0 job(s) [purged] [2025-10-05 05:36:22] 2025-10-05 09:35:46,744 | INFO | queue current_data_in had 0 job(s) [purged] [2025-10-05 05:36:22] 2025-10-05 09:35:46,745 | INFO | queue validated_jobs had 0 job(s) [purged] [2025-10-05 05:36:22] 2025-10-05 09:35:46,745 | INFO | queue validated_payloads had 0 job(s) [purged] [2025-10-05 05:36:22] 2025-10-05 09:35:46,745 | INFO | queue monitored_payloads had 0 job(s) [purged] [2025-10-05 05:36:22] 2025-10-05 09:35:46,745 | INFO | queue finished_jobs had 0 job(s) [purged] [2025-10-05 05:36:22] 2025-10-05 09:35:46,745 | INFO | queue finished_payloads had 0 job(s) [purged] [2025-10-05 05:36:22] 2025-10-05 09:35:46,745 | INFO | queue finished_data_in had 1 job(s) [purged] [2025-10-05 05:36:22] 2025-10-05 09:35:46,745 | INFO | queue finished_data_out had 0 job(s) [purged] [2025-10-05 05:36:22] 2025-10-05 09:35:46,745 | INFO | queue failed_jobs had 0 job(s) [purged] [2025-10-05 05:36:22] 2025-10-05 09:35:46,745 | INFO | queue failed_payloads had 0 job(s) [purged] [2025-10-05 05:36:22] 2025-10-05 09:35:46,745 | INFO | queue failed_data_in had 0 job(s) [purged] [2025-10-05 05:36:22] 2025-10-05 09:35:46,745 | INFO | queue failed_data_out had 0 job(s) [purged] [2025-10-05 05:36:22] 2025-10-05 09:35:46,745 | INFO | queue completed_jobs had 0 job(s) [purged] [2025-10-05 05:36:22] 2025-10-05 09:35:46,746 | INFO | queue completed_jobids has 1 job(s) [2025-10-05 05:36:22] 2025-10-05 09:35:46,746 | INFO | queue realtimelog_payloads had 0 job(s) [purged] [2025-10-05 05:36:22] 2025-10-05 09:35:46,746 | INFO | queue messages had 0 job(s) [purged] [2025-10-05 05:36:22] 2025-10-05 09:35:46,746 | INFO | job 6829374961 has completed (purged errors) [2025-10-05 05:36:22] 2025-10-05 09:35:46,746 | INFO | overall cleanup function is called [2025-10-05 05:36:22] 2025-10-05 09:35:47,774 | INFO | --- collectZombieJob: --- 10, [1940876] [2025-10-05 05:36:22] 2025-10-05 09:35:47,774 | INFO | zombie collector waiting for pid 1940876 [2025-10-05 05:36:22] 2025-10-05 09:35:47,774 | INFO | harmless exception when collecting zombies: [Errno 10] No child processes [2025-10-05 05:36:22] 2025-10-05 09:35:47,774 | INFO | collected zombie processes [2025-10-05 05:36:22] 2025-10-05 09:35:47,774 | INFO | will attempt to kill all subprocesses of pid=1940876 [2025-10-05 05:36:22] 2025-10-05 09:35:49,998 | INFO | process IDs to be killed: [1940876] (in reverse order) [2025-10-05 05:36:22] 2025-10-05 09:35:50,166 | WARNING | found no corresponding commands to process id(s) [2025-10-05 05:36:22] 2025-10-05 09:35:50,166 | INFO | Do not look for orphan processes in BOINC jobs [2025-10-05 05:36:22] 2025-10-05 09:35:50,196 | INFO | did not find any defunct processes belonging to 1940876 [2025-10-05 05:36:22] 2025-10-05 09:35:50,223 | INFO | did not find any defunct processes belonging to 1940876 [2025-10-05 05:36:22] 2025-10-05 09:35:50,223 | INFO | ready for new job [2025-10-05 05:36:22] 2025-10-05 09:35:50,224 | INFO | pilot has finished with previous job - re-establishing logging [2025-10-05 05:36:22] 2025-10-05 09:35:50,226 | INFO | *************************************** [2025-10-05 05:36:22] 2025-10-05 09:35:50,227 | INFO | *** PanDA Pilot version 3.10.5.57 *** [2025-10-05 05:36:22] 2025-10-05 09:35:50,227 | INFO | *************************************** [2025-10-05 05:36:22] 2025-10-05 09:35:50,227 | INFO | [2025-10-05 05:36:22] 2025-10-05 09:35:50,269 | INFO | architecture information: [2025-10-05 05:36:22] 2025-10-05 09:35:50,277 | INFO | executing command: cat /etc/os-release [2025-10-05 05:36:22] 2025-10-05 09:35:50,385 | INFO | cat /etc/os-release: [2025-10-05 05:36:22] NAME="CentOS Linux" [2025-10-05 05:36:22] VERSION="7 (Core)" [2025-10-05 05:36:22] ID="centos" [2025-10-05 05:36:22] ID_LIKE="rhel fedora" [2025-10-05 05:36:22] VERSION_ID="7" [2025-10-05 05:36:22] PRETTY_NAME="CentOS Linux 7 (Core)" [2025-10-05 05:36:22] ANSI_COLOR="0;31" [2025-10-05 05:36:22] CPE_NAME="cpe:/o:centos:centos:7" [2025-10-05 05:36:22] HOME_URL="https://www.centos.org/" [2025-10-05 05:36:22] BUG_REPORT_URL="https://bugs.centos.org/" [2025-10-05 05:36:22] [2025-10-05 05:36:22] CENTOS_MANTISBT_PROJECT="CentOS-7" [2025-10-05 05:36:22] CENTOS_MANTISBT_PROJECT_VERSION="7" [2025-10-05 05:36:22] REDHAT_SUPPORT_PRODUCT="centos" [2025-10-05 05:36:22] REDHAT_SUPPORT_PRODUCT_VERSION="7" [2025-10-05 05:36:22] [2025-10-05 05:36:22] 2025-10-05 09:35:50,385 | INFO | *************************************** [2025-10-05 05:36:22] 2025-10-05 09:35:50,889 | INFO | executing command: df -mP /tmp/boinchome/slots/2 [2025-10-05 05:36:22] 2025-10-05 09:35:51,043 | INFO | sufficient remaining disk space (74159489024 B) [2025-10-05 05:36:22] 2025-10-05 09:35:51,043 | WARNING | since timefloor is set to 0, pilot was only allowed to run one job [2025-10-05 05:36:22] 2025-10-05 09:35:51,043 | INFO | current server update state: UPDATING_FINAL [2025-10-05 05:36:22] 2025-10-05 09:35:51,043 | INFO | update_server=False [2025-10-05 05:36:22] 2025-10-05 09:35:51,044 | WARNING | setting graceful_stop since proceed_with_getjob() returned False (pilot will end) [2025-10-05 05:36:22] 2025-10-05 09:35:51,044 | WARNING | data:copytool_out:received graceful stop - abort after this iteration [2025-10-05 05:36:22] 2025-10-05 09:35:51,166 | WARNING | job:job_monitor:received graceful stop - abort after this iteration [2025-10-05 05:36:22] 2025-10-05 09:35:51,166 | INFO | aborting loop [2025-10-05 05:36:22] 2025-10-05 09:35:51,251 | INFO | all job control threads have been joined [2025-10-05 05:36:22] 2025-10-05 09:35:51,316 | WARNING | job:queue_monitor:received graceful stop - abort after this iteration [2025-10-05 05:36:22] 2025-10-05 09:35:51,554 | INFO | all payload control threads have been joined [2025-10-05 05:36:22] 2025-10-05 09:35:51,750 | INFO | all data control threads have been joined [2025-10-05 05:36:22] 2025-10-05 09:35:52,050 | INFO | [job] retrieve thread has finished [2025-10-05 05:36:22] 2025-10-05 09:35:52,172 | INFO | [job] job monitor thread has finished [2025-10-05 05:36:22] 2025-10-05 09:35:52,256 | INFO | [job] control thread has finished [2025-10-05 05:36:22] 2025-10-05 09:35:52,317 | INFO | [payload] failed_post thread has finished [2025-10-05 05:36:22] 2025-10-05 09:35:52,322 | INFO | [job] queue monitor thread has finished [2025-10-05 05:36:22] 2025-10-05 09:35:52,328 | INFO | [payload] run_realtimelog thread has finished [2025-10-05 05:36:22] 2025-10-05 09:35:52,352 | INFO | [payload] validate_post thread has finished [2025-10-05 05:36:22] 2025-10-05 09:35:52,560 | INFO | [payload] control thread has finished [2025-10-05 05:36:22] 2025-10-05 09:35:52,756 | INFO | [data] control thread has finished [2025-10-05 05:36:22] 2025-10-05 09:35:52,820 | INFO | [job] create_data_payload thread has finished [2025-10-05 05:36:22] 2025-10-05 09:35:52,842 | INFO | [job] validate thread has finished [2025-10-05 05:36:22] 2025-10-05 09:35:53,051 | INFO | [data] copytool_out thread has finished [2025-10-05 05:36:22] 2025-10-05 09:35:53,220 | INFO | [data] copytool_in thread has finished [2025-10-05 05:36:22] 2025-10-05 09:35:53,220 | INFO | [payload] execute_payloads thread has finished [2025-10-05 05:36:22] 2025-10-05 09:35:53,455 | INFO | [payload] validate_pre thread has finished [2025-10-05 05:36:22] 2025-10-05 09:35:53,847 | INFO | [monitor] cgroup control has ended [2025-10-05 05:36:22] 2025-10-05 09:35:54,099 | WARNING | data:queue_monitoring:received graceful stop - abort after this iteration [2025-10-05 05:36:22] 2025-10-05 09:35:58,122 | INFO | [data] queue_monitor thread has finished [2025-10-05 05:36:22] 2025-10-05 09:35:59,297 | INFO | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 140032649361216)>', '<ExcThread(monitor, started 140032174192384)>'] [2025-10-05 05:36:22] 2025-10-05 09:36:04,323 | INFO | all workflow threads have been joined [2025-10-05 05:36:22] 2025-10-05 09:36:04,323 | INFO | end of generic workflow (traces error code: 0) [2025-10-05 05:36:22] 2025-10-05 09:36:04,323 | INFO | traces error code: 0 [2025-10-05 05:36:22] 2025-10-05 09:36:04,323 | INFO | pilot has finished (exit code=0, shell exit code=0) [2025-10-05 05:36:22] 2025-10-05 09:36:21,218 | INFO | PID=1917800 has CPU usage=2.4% 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 P [2025-10-05 05:36:22] 2025-10-05 09:36:21,218 | INFO | .. there are 29 such processes running [2025-10-05 05:36:22] 2025-10-05 09:36:21,219 | INFO | found 0 job(s) in 20 queues [2025-10-05 05:36:22] 2025-10-05 09:36:21,219 | WARNING | pilot monitor received instruction that args.graceful_stop has been set [2025-10-05 05:36:22] 2025-10-05 09:36:21,219 | WARNING | will wait for a maximum of 300 s for threads to finish [2025-10-05 05:36:22] 2025-10-05 09:36:21,219 | WARNING | job_aborted has been set - aborting pilot monitoring [2025-10-05 05:36:22] 2025-10-05 09:36:21,219 | INFO | [monitor] control thread has ended [2025-10-05 05:36:22] 2025-10-05 09:36:21,812 [wrapper] ==== pilot stdout END ==== [2025-10-05 05:36:22] 2025-10-05 09:36:21,829 [wrapper] ==== wrapper stdout RESUME ==== [2025-10-05 05:36:22] 2025-10-05 09:36:21,843 [wrapper] pilotpid: 1917800 [2025-10-05 05:36:22] 2025-10-05 09:36:21,874 [wrapper] Pilot exit status: 0 [2025-10-05 05:36:22] 2025-10-05 09:36:22,041 [wrapper] pandaids: 6829374961 [2025-10-05 05:36:22] 2025-10-05 09:36:22,298 [wrapper] cleanup supervisor_pilot 2259204 1917801 [2025-10-05 05:36:22] 2025-10-05 09:36:22,320 [wrapper] Test setup, not cleaning [2025-10-05 05:36:22] 2025-10-05 09:36:22,372 [wrapper] apfmon messages muted [2025-10-05 05:36:22] 2025-10-05 09:36:22,386 [wrapper] ==== wrapper stdout END ==== [2025-10-05 05:36:22] 2025-10-05 09:36:22,401 [wrapper] ==== wrapper stderr END ==== [2025-10-05 05:36:22] *** Error codes and diagnostics *** [2025-10-05 05:36:22] "exeErrorCode": 0, [2025-10-05 05:36:22] "exeErrorDiag": "", [2025-10-05 05:36:22] "pilotErrorCode": 0, [2025-10-05 05:36:22] "pilotErrorDiag": "", [2025-10-05 05:36:22] *** Listing of results directory *** [2025-10-05 05:36:22] total 390788 [2025-10-05 05:36:22] -rw-r--r-- 1 boincer umatlas 552446 Oct 4 02:28 pilot3.tar.gz [2025-10-05 05:36:22] -rwx------ 1 boincer umatlas 36292 Oct 4 02:36 runpilot2-wrapper.sh [2025-10-05 05:36:22] -rw-r--r-- 1 boincer umatlas 5112 Oct 4 02:36 queuedata.json [2025-10-05 05:36:22] -rw-r--r-- 1 boincer umatlas 100 Oct 5 03:59 wrapper_26015_x86_64-pc-linux-gnu [2025-10-05 05:36:22] -rwxr-xr-x 1 boincer umatlas 7986 Oct 5 03:59 run_atlas [2025-10-05 05:36:22] -rw-r--r-- 1 boincer umatlas 105 Oct 5 03:59 job.xml [2025-10-05 05:36:22] -rw-r--r-- 2 boincer umatlas 212916831 Oct 5 03:59 EVNT.46376901._001940.pool.root.1 [2025-10-05 05:36:22] -rw-r--r-- 2 boincer umatlas 15120 Oct 5 03:59 start_atlas.sh [2025-10-05 05:36:22] drwxrwx--x 2 boincer umatlas 4096 Oct 5 03:59 shared [2025-10-05 05:36:22] -rw-r--r-- 2 boincer umatlas 565602 Oct 5 03:59 input.tar.gz [2025-10-05 05:36:22] -rw-r--r-- 1 boincer umatlas 0 Oct 5 03:59 boinc_lockfile [2025-10-05 05:36:22] -rw-r--r-- 1 boincer umatlas 2519 Oct 5 03:59 pandaJob.out [2025-10-05 05:36:22] -rw------- 1 boincer umatlas 973982 Oct 5 04:00 agis_schedconf.cvmfs.json [2025-10-05 05:36:22] -rw------- 1 boincer umatlas 1560401 Oct 5 04:00 agis_ddmendpoints.agis.ALL.json [2025-10-05 05:36:22] drwx------ 4 boincer umatlas 4096 Oct 5 04:00 pilot3 [2025-10-05 05:36:22] -rw------- 1 boincer umatlas 181072982 Oct 5 05:34 HITS.46376905._054448.pool.root.1 [2025-10-05 05:36:22] -rw-r--r-- 1 boincer umatlas 529 Oct 5 05:34 boinc_task_state.xml [2025-10-05 05:36:22] -rw------- 1 boincer umatlas 1040 Oct 5 05:35 memory_monitor_summary.json [2025-10-05 05:36:22] -rw------- 1 boincer umatlas 358404 Oct 5 05:35 log.46376905._054448.job.log.tgz.1 [2025-10-05 05:36:22] -rw------- 1 boincer umatlas 7827 Oct 5 05:35 heartbeat.json [2025-10-05 05:36:22] -rw-r--r-- 1 boincer umatlas 6855 Oct 5 05:36 init_data.xml [2025-10-05 05:36:22] -rw-r--r-- 1 boincer umatlas 8192 Oct 5 05:36 boinc_mmap_file [2025-10-05 05:36:22] -rw-r--r-- 1 boincer umatlas 27 Oct 5 05:36 wrapper_checkpoint.txt [2025-10-05 05:36:22] -rw------- 1 boincer umatlas 823 Oct 5 05:36 pilotlog.txt [2025-10-05 05:36:22] -rw------- 1 boincer umatlas 95 Oct 5 05:36 pilot_heartbeat.json [2025-10-05 05:36:22] -rw------- 1 boincer umatlas 786982 Oct 5 05:36 log.46376905._054448.job.log.1 [2025-10-05 05:36:22] -rw------- 1 boincer umatlas 357 Oct 5 05:36 output.list [2025-10-05 05:36:22] -rw-r--r-- 1 boincer umatlas 620 Oct 5 05:36 runtime_log [2025-10-05 05:36:22] -rw------- 1 boincer umatlas 1167360 Oct 5 05:36 result.tar.gz [2025-10-05 05:36:22] -rw-r--r-- 1 boincer umatlas 8703 Oct 5 05:36 runtime_log.err [2025-10-05 05:36:22] -rw------- 1 boincer umatlas 652 Oct 5 05:36 rkOLDml3AP8n9Rq4apOajLDm4fhM0noT9bVof3QYDmq2CMDmwEFCKm.diag [2025-10-05 05:36:22] -rw-r--r-- 1 boincer umatlas 22241 Oct 5 05:36 stderr.txt [2025-10-05 05:36:22] HITS file was successfully produced: [2025-10-05 05:36:22] -rw------- 1 boincer umatlas 181072982 Oct 5 05:34 shared/HITS.pool.root.1 [2025-10-05 05:36:22] *** Contents of shared directory: *** [2025-10-05 05:36:22] total 386480 [2025-10-05 05:36:22] -rw-r--r-- 2 boincer umatlas 212916831 Oct 5 03:59 ATLAS.root_0 [2025-10-05 05:36:22] -rw-r--r-- 2 boincer umatlas 15120 Oct 5 03:59 start_atlas.sh [2025-10-05 05:36:22] -rw-r--r-- 2 boincer umatlas 565602 Oct 5 03:59 input.tar.gz [2025-10-05 05:36:22] -rw------- 1 boincer umatlas 181072982 Oct 5 05:34 HITS.pool.root.1 [2025-10-05 05:36:22] -rw------- 1 boincer umatlas 1167360 Oct 5 05:36 result.tar.gz 05:36:24 (1906732): run_atlas exited; CPU time 36112.014491 05:36:24 (1906732): called boinc_finish(0) </stderr_txt> ]]>
©2025 CERN