Name xy2MDmrCO48nsSi4ap6QjLDmwznN0nGgGQJmNLGKDmHb8KDmR29xdm_2
Workunit 238711130
Created 26 Jan 2026, 18:07:49 UTC
Sent 26 Jan 2026, 18:32:05 UTC
Report deadline 3 Feb 2026, 18:32:05 UTC
Received 26 Jan 2026, 21:26:01 UTC
Server state Over
Outcome Validate error
Client state Done
Exit status 0 (0x00000000)
Computer ID 11015114
Run time 1 hours 42 min 33 sec
CPU time 12 hours 45 min 28 sec
Priority 28
Validate state Invalid
Credit 0.00
Device peak FLOPS 8.00 GFLOPS
Application version ATLAS Simulation v3.01 (native_mt)
x86_64-pc-linux-gnu
Peak working set size 1.91 GB
Peak swap size 3.02 GB
Peak disk usage 714.64 MB

Stderr output

<core_client_version>8.2.8</core_client_version>
<![CDATA[
<stderr_txt>
20:43:00 (9734): wrapper (7.7.26015): starting
20:43:00 (9734): wrapper: running run_atlas (--nthreads 8)
[2026-01-26 20:43:00] Arguments: --nthreads 8
[2026-01-26 20:43:00] Threads: 8
[2026-01-26 20:43:00] Checking for CVMFS
[2026-01-26 20:43:00] Probing /cvmfs/atlas.cern.ch... OK
[2026-01-26 20:43:00] Probing /cvmfs/atlas-condb.cern.ch... OK
[2026-01-26 20:43:00] Running cvmfs_config stat atlas.cern.ch
[2026-01-26 20:43:01] 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
[2026-01-26 20:43:01] 2.11.0.0 4270 153765 84740 155560 3 1 3140940 4096000 0 130560 16 14767020 99.584 12199746 612 http://cvmfs-stratum-one.cern.ch/cvmfs/atlas.cern.ch http://141.99.253.245:3128 1
[2026-01-26 20:43:01] CVMFS is ok
[2026-01-26 20:43:01] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2026-01-26 20:43:01] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2026-01-26 20:43:01] Further information can be found at the LHC@home message board.
[2026-01-26 20:43:01] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2026-01-26 20:43:01] Checking for apptainer binary...
[2026-01-26 20:43:01] /usr/bin/which: no apptainer in (/opt/ohpc/pub/libs/singularity/3.7.1/bin:/cm/shared/apps/slurm/current/sbin:/cm/shared/apps/slurm/current/bin:/home/mf493845/.local/bin:/home/mf493845/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin)
[2026-01-26 20:43:01] apptainer is not installed, using version from CVMFS
[2026-01-26 20:43:01] Checking apptainer works with /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2026-01-26 20:43:01] WARNING: Environment variable TMPDIR already has value [/tmp/job_11051318/atlas/pilot/slots/0/.apptainertmp], will not forward new value [/tmp] from parent process environment hpc-node288
[2026-01-26 20:43:01] apptainer works
[2026-01-26 20:43:01] Set ATHENA_PROC_NUMBER=8
[2026-01-26 20:43:01] Set ATHENA_CORE_NUMBER=8
[2026-01-26 20:43:01] Starting ATLAS job with PandaID=6983466590
[2026-01-26 20:43:01] Running command: /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/tmp/job_11051318/atlas/pilot/slots/0 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2026-01-26 22:25:30]  *** The last 200 lines of the pilot log: ***
[2026-01-26 22:25:30] 2026-01-26 21:24:55,369 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2026-01-26 22:25:30] 2026-01-26 21:24:56,697 | INFO     | time since job start (6109s) is within the limit (349056.0s)
[2026-01-26 22:25:30] 2026-01-26 21:24:56,749 | INFO     | job 6983466590 has state=finished
[2026-01-26 22:25:30] 2026-01-26 21:24:56,749 | INFO     | preparing for final server update for job 6983466590 in state='finished'
[2026-01-26 22:25:30] 2026-01-26 21:24:56,749 | INFO     | reading metadata from: /tmp/job_11051318/atlas/pilot/slots/0/PanDA_Pilot-6983466590/jobReport.json
[2026-01-26 22:25:30] 2026-01-26 21:24:56,751 | INFO     | added worker_node to metadata from /tmp/job_11051318/atlas/pilot/slots/0/workernode_map.json
[2026-01-26 22:25:30] 2026-01-26 21:24:56,751 | INFO     | this job has now completed (state=finished)
[2026-01-26 22:25:30] 2026-01-26 21:24:56,751 | INFO     | pilot will not update the server (heartbeat message will be written to file)
[2026-01-26 22:25:30] 2026-01-26 21:24:56,751 | INFO     | log transfer has been attempted: DONE
[2026-01-26 22:25:30] 2026-01-26 21:24:56,751 | INFO     | job 6983466590 has finished - writing final server update
[2026-01-26 22:25:30] 2026-01-26 21:24:56,751 | INFO     | total number of processed events: 400 (read)
[2026-01-26 22:25:30] 2026-01-26 21:24:56,769 | INFO     | using path: /tmp/job_11051318/atlas/pilot/slots/0/PanDA_Pilot-6983466590/memory_monitor_summary.json (trf name=prmon)
[2026-01-26 22:25:30] 2026-01-26 21:24:56,770 | INFO     | extracted standard info from prmon json
[2026-01-26 22:25:30] 2026-01-26 21:24:56,770 | INFO     | extracted standard memory fields from prmon json
[2026-01-26 22:25:30] 2026-01-26 21:24:56,770 | WARNING  | GPU info not found in prmon json: 'gpu'
[2026-01-26 22:25:30] 2026-01-26 21:24:56,770 | WARNING  | format EVNTtoHITS has no such key: dbData
[2026-01-26 22:25:30] 2026-01-26 21:24:56,770 | WARNING  | format EVNTtoHITS has no such key: dbTime
[2026-01-26 22:25:30] 2026-01-26 21:24:56,771 | INFO     | fitting pss+swap vs Time
[2026-01-26 22:25:30] 2026-01-26 21:24:56,771 | INFO     | sum of square deviations: 310052325.0
[2026-01-26 22:25:30] 2026-01-26 21:24:56,771 | INFO     | sum of deviations: -9953322206.500002
[2026-01-26 22:25:30] 2026-01-26 21:24:56,771 | INFO     | mean x: 1769459622.5
[2026-01-26 22:25:30] 2026-01-26 21:24:56,771 | INFO     | mean y: 2588256.61
[2026-01-26 22:25:30] 2026-01-26 21:24:56,771 | INFO     | intersect: 56805909290.03351
[2026-01-26 22:25:30] 2026-01-26 21:24:56,771 | INFO     | chi2: 1.2589156448271686
[2026-01-26 22:25:30] 2026-01-26 21:24:56,772 | INFO     | sum of square deviations: 265828240.0
[2026-01-26 22:25:30] 2026-01-26 21:24:56,772 | INFO     | sum of deviations: -9274751710.0
[2026-01-26 22:25:30] 2026-01-26 21:24:56,772 | INFO     | mean x: 1769459470.0
[2026-01-26 22:25:30] 2026-01-26 21:24:56,772 | INFO     | mean y: 2590598.5263157897
[2026-01-26 22:25:30] 2026-01-26 21:24:56,772 | INFO     | intersect: 61739060904.15747
[2026-01-26 22:25:30] 2026-01-26 21:24:56,772 | INFO     | chi2: 1.251942541618874
[2026-01-26 22:25:30] 2026-01-26 21:24:56,772 | INFO     | current chi2=1.251942541618874 (change=0.5538975734352545 %)
[2026-01-26 22:25:30] 2026-01-26 21:24:56,772 | INFO     | right removable region: 94
[2026-01-26 22:25:30] 2026-01-26 21:24:56,772 | INFO     | sum of square deviations: 265828240.0
[2026-01-26 22:25:30] 2026-01-26 21:24:56,772 | INFO     | sum of deviations: -18521189965.0
[2026-01-26 22:25:30] 2026-01-26 21:24:56,772 | INFO     | mean x: 1769459775.0
[2026-01-26 22:25:30] 2026-01-26 21:24:56,772 | INFO     | mean y: 2616517.452631579
[2026-01-26 22:25:30] 2026-01-26 21:24:56,773 | INFO     | intersect: 123287112657.52097
[2026-01-26 22:25:30] 2026-01-26 21:24:56,773 | INFO     | chi2: 0.14371071789360418
[2026-01-26 22:25:30] 2026-01-26 21:24:56,773 | INFO     | current chi2=0.14371071789360418 (change=88.5845633514759 %)
[2026-01-26 22:25:30] 2026-01-26 21:24:56,773 | INFO     | sum of square deviations: 226022842.5
[2026-01-26 22:25:30] 2026-01-26 21:24:56,773 | INFO     | sum of deviations: -13880595445.000002
[2026-01-26 22:25:30] 2026-01-26 21:24:56,773 | INFO     | mean x: 1769459927.5
[2026-01-26 22:25:30] 2026-01-26 21:24:56,773 | INFO     | mean y: 2598711.1555555556
[2026-01-26 22:25:30] 2026-01-26 21:24:56,773 | INFO     | intersect: 108669303094.216
[2026-01-26 22:25:30] 2026-01-26 21:24:56,773 | INFO     | chi2: 0.1295484451770072
[2026-01-26 22:25:30] 2026-01-26 21:24:56,773 | INFO     | current chi2=0.1295484451770072 (change=9.85470876784707 %)
[2026-01-26 22:25:30] 2026-01-26 21:24:56,773 | INFO     | left removable region: 20
[2026-01-26 22:25:30] 2026-01-26 21:24:56,773 | INFO     | sum of square deviations: 125630262.5
[2026-01-26 22:25:30] 2026-01-26 21:24:56,774 | INFO     | sum of deviations: -4327493659.0
[2026-01-26 22:25:30] 2026-01-26 21:24:56,774 | INFO     | mean x: 1769460049.5
[2026-01-26 22:25:30] 2026-01-26 21:24:56,774 | INFO     | mean y: 2557330.108108108
[2026-01-26 22:25:30] 2026-01-26 21:24:56,774 | INFO     | intersect: 60953851959.97547
[2026-01-26 22:25:30] 2026-01-26 21:24:56,774 | INFO     | chi2: 0.04127981535663919
[2026-01-26 22:25:30] 2026-01-26 21:24:56,774 | INFO     | current memory leak: -34.45 B/s (using 74 data points, chi2=0.04)
[2026-01-26 22:25:30] 2026-01-26 21:24:56,774 | INFO     | could have reported an average CPU frequency of 2365 MHz (7 samples)
[2026-01-26 22:25:30] 2026-01-26 21:24:56,774 | INFO     | ..............................
[2026-01-26 22:25:30] 2026-01-26 21:24:56,774 | INFO     | . Timing measurements:
[2026-01-26 22:25:30] 2026-01-26 21:24:56,774 | INFO     | . get job = 0 s
[2026-01-26 22:25:30] 2026-01-26 21:24:56,774 | INFO     | . initial setup = 2 s
[2026-01-26 22:25:30] 2026-01-26 21:24:56,774 | INFO     | . payload setup = 2 s
[2026-01-26 22:25:30] 2026-01-26 21:24:56,774 | INFO     | . stage-in = 0 s
[2026-01-26 22:25:30] 2026-01-26 21:24:56,774 | INFO     | . payload execution = 6085 s
[2026-01-26 22:25:30] 2026-01-26 21:24:56,774 | INFO     | . stage-out = 0 s
[2026-01-26 22:25:30] 2026-01-26 21:24:56,774 | INFO     | . log creation = 0 s
[2026-01-26 22:25:30] 2026-01-26 21:24:56,774 | INFO     | ..............................
[2026-01-26 22:25:30] 2026-01-26 21:24:57,200 | INFO     | 
[2026-01-26 22:25:30] 2026-01-26 21:24:57,200 | INFO     | job summary report
[2026-01-26 22:25:30] 2026-01-26 21:24:57,201 | INFO     | --------------------------------------------------
[2026-01-26 22:25:30] 2026-01-26 21:24:57,201 | INFO     | PanDA job id: 6983466590
[2026-01-26 22:25:30] 2026-01-26 21:24:57,201 | INFO     | task id: 48329874
[2026-01-26 22:25:30] 2026-01-26 21:24:57,201 | INFO     | errors: (none)
[2026-01-26 22:25:30] 2026-01-26 21:24:57,201 | INFO     | status: LOG_TRANSFER = DONE 
[2026-01-26 22:25:30] 2026-01-26 21:24:57,201 | INFO     | pilot state: finished 
[2026-01-26 22:25:30] 2026-01-26 21:24:57,201 | INFO     | transexitcode: 0
[2026-01-26 22:25:30] 2026-01-26 21:24:57,201 | INFO     | exeerrorcode: 0
[2026-01-26 22:25:30] 2026-01-26 21:24:57,201 | INFO     | exeerrordiag: 
[2026-01-26 22:25:30] 2026-01-26 21:24:57,201 | INFO     | exitcode: 0
[2026-01-26 22:25:30] 2026-01-26 21:24:57,201 | INFO     | exitmsg: OK
[2026-01-26 22:25:30] 2026-01-26 21:24:57,201 | INFO     | cpuconsumptiontime: 45802 s
[2026-01-26 22:25:30] 2026-01-26 21:24:57,201 | INFO     | nevents: 400
[2026-01-26 22:25:30] 2026-01-26 21:24:57,201 | INFO     | neventsw: 0
[2026-01-26 22:25:30] 2026-01-26 21:24:57,201 | INFO     | pid: 18205
[2026-01-26 22:25:30] 2026-01-26 21:24:57,201 | INFO     | pgrp: 18205
[2026-01-26 22:25:30] 2026-01-26 21:24:57,201 | INFO     | corecount: 8
[2026-01-26 22:25:30] 2026-01-26 21:24:57,201 | INFO     | event service: False
[2026-01-26 22:25:30] 2026-01-26 21:24:57,201 | INFO     | sizes: {0: 2284484, 10: 2284484, 6092: 2311482, 6094: 2320510, 6095: 2320566, 6098: 2320760}
[2026-01-26 22:25:30] 2026-01-26 21:24:57,201 | INFO     | --------------------------------------------------
[2026-01-26 22:25:30] 2026-01-26 21:24:57,201 | INFO     | 
[2026-01-26 22:25:30] 2026-01-26 21:24:57,201 | INFO     | executing command: ls -lF /tmp/job_11051318/atlas/pilot/slots/0
[2026-01-26 22:25:30] 2026-01-26 21:24:57,211 | INFO     | queue jobs had 0 job(s) [purged]
[2026-01-26 22:25:30] 2026-01-26 21:24:57,211 | INFO     | queue payloads had 0 job(s) [purged]
[2026-01-26 22:25:30] 2026-01-26 21:24:57,211 | INFO     | queue data_in had 0 job(s) [purged]
[2026-01-26 22:25:30] 2026-01-26 21:24:57,211 | INFO     | queue data_out had 0 job(s) [purged]
[2026-01-26 22:25:30] 2026-01-26 21:24:57,211 | INFO     | queue current_data_in had 0 job(s) [purged]
[2026-01-26 22:25:30] 2026-01-26 21:24:57,211 | INFO     | queue validated_jobs had 0 job(s) [purged]
[2026-01-26 22:25:30] 2026-01-26 21:24:57,211 | INFO     | queue validated_payloads had 0 job(s) [purged]
[2026-01-26 22:25:30] 2026-01-26 21:24:57,211 | INFO     | queue monitored_payloads had 0 job(s) [purged]
[2026-01-26 22:25:30] 2026-01-26 21:24:57,211 | INFO     | queue finished_jobs had 0 job(s) [purged]
[2026-01-26 22:25:30] 2026-01-26 21:24:57,211 | INFO     | queue finished_payloads had 0 job(s) [purged]
[2026-01-26 22:25:30] 2026-01-26 21:24:57,211 | INFO     | queue finished_data_in had 1 job(s) [purged]
[2026-01-26 22:25:30] 2026-01-26 21:24:57,212 | INFO     | queue finished_data_out had 0 job(s) [purged]
[2026-01-26 22:25:30] 2026-01-26 21:24:57,212 | INFO     | queue failed_jobs had 0 job(s) [purged]
[2026-01-26 22:25:30] 2026-01-26 21:24:57,212 | INFO     | queue failed_payloads had 0 job(s) [purged]
[2026-01-26 22:25:30] 2026-01-26 21:24:57,212 | INFO     | queue failed_data_in had 0 job(s) [purged]
[2026-01-26 22:25:30] 2026-01-26 21:24:57,212 | INFO     | queue failed_data_out had 0 job(s) [purged]
[2026-01-26 22:25:30] 2026-01-26 21:24:57,212 | INFO     | queue completed_jobs had 0 job(s) [purged]
[2026-01-26 22:25:30] 2026-01-26 21:24:57,212 | INFO     | queue completed_jobids has 1 job(s)
[2026-01-26 22:25:30] 2026-01-26 21:24:57,212 | INFO     | queue realtimelog_payloads had 0 job(s) [purged]
[2026-01-26 22:25:30] 2026-01-26 21:24:57,212 | INFO     | queue messages had 0 job(s) [purged]
[2026-01-26 22:25:30] 2026-01-26 21:24:57,212 | INFO     | job 6983466590 has completed (purged errors)
[2026-01-26 22:25:30] 2026-01-26 21:24:57,212 | INFO     | overall cleanup function is called
[2026-01-26 22:25:30] 2026-01-26 21:24:58,218 | INFO     | --- collectZombieJob: --- 10, [18205]
[2026-01-26 22:25:30] 2026-01-26 21:24:58,218 | INFO     | zombie collector waiting for pid 18205
[2026-01-26 22:25:30] 2026-01-26 21:24:58,218 | INFO     | harmless exception when collecting zombies: [Errno 10] No child processes
[2026-01-26 22:25:30] 2026-01-26 21:24:58,218 | INFO     | collected zombie processes
[2026-01-26 22:25:30] 2026-01-26 21:24:58,218 | INFO     | will attempt to kill all subprocesses of pid=18205
[2026-01-26 22:25:30] 2026-01-26 21:24:58,317 | INFO     | process IDs to be killed: [18205] (in reverse order)
[2026-01-26 22:25:30] 2026-01-26 21:24:58,352 | WARNING  | found no corresponding commands to process id(s)
[2026-01-26 22:25:30] 2026-01-26 21:24:58,352 | INFO     | Do not look for orphan processes in BOINC jobs
[2026-01-26 22:25:30] 2026-01-26 21:24:58,356 | INFO     | did not find any defunct processes belonging to 18205
[2026-01-26 22:25:30] 2026-01-26 21:24:58,359 | INFO     | did not find any defunct processes belonging to 18205
[2026-01-26 22:25:30] 2026-01-26 21:24:58,359 | INFO     | ready for new job
[2026-01-26 22:25:30] 2026-01-26 21:24:58,359 | INFO     | pilot has finished with previous job - re-establishing logging
[2026-01-26 22:25:30] 2026-01-26 21:24:58,360 | INFO     | **************************************
[2026-01-26 22:25:30] 2026-01-26 21:24:58,360 | INFO     | ***  PanDA Pilot version 3.11.3.9  ***
[2026-01-26 22:25:30] 2026-01-26 21:24:58,360 | INFO     | **************************************
[2026-01-26 22:25:30] 2026-01-26 21:24:58,360 | INFO     | 
[2026-01-26 22:25:30] 2026-01-26 21:24:58,374 | INFO     | architecture information:
[2026-01-26 22:25:30] 2026-01-26 21:24:58,374 | INFO     | executing command: cat /etc/os-release
[2026-01-26 22:25:30] 2026-01-26 21:24:58,380 | INFO     | cat /etc/os-release:
[2026-01-26 22:25:30] NAME="CentOS Linux"
[2026-01-26 22:25:30] VERSION="7 (Core)"
[2026-01-26 22:25:30] ID="centos"
[2026-01-26 22:25:30] ID_LIKE="rhel fedora"
[2026-01-26 22:25:30] VERSION_ID="7"
[2026-01-26 22:25:30] PRETTY_NAME="CentOS Linux 7 (Core)"
[2026-01-26 22:25:30] ANSI_COLOR="0;31"
[2026-01-26 22:25:30] CPE_NAME="cpe:/o:centos:centos:7"
[2026-01-26 22:25:30] HOME_URL="https://www.centos.org/"
[2026-01-26 22:25:30] BUG_REPORT_URL="https://bugs.centos.org/"
[2026-01-26 22:25:30] 
[2026-01-26 22:25:30] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2026-01-26 22:25:30] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2026-01-26 22:25:30] REDHAT_SUPPORT_PRODUCT="centos"
[2026-01-26 22:25:30] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2026-01-26 22:25:30] 
[2026-01-26 22:25:30] 2026-01-26 21:24:58,380 | INFO     | **************************************
[2026-01-26 22:25:30] 2026-01-26 21:24:58,883 | INFO     | executing command: df -mP /tmp/job_11051318/atlas/pilot/slots/0
[2026-01-26 22:25:30] 2026-01-26 21:24:58,890 | INFO     | sufficient remaining disk space (222978637824 B)
[2026-01-26 22:25:30] 2026-01-26 21:24:58,890 | WARNING  | since timefloor is set to 0, pilot was only allowed to run one job
[2026-01-26 22:25:30] 2026-01-26 21:24:58,890 | INFO     | current server update state: UPDATING_FINAL
[2026-01-26 22:25:30] 2026-01-26 21:24:58,890 | INFO     | update_server=False
[2026-01-26 22:25:30] 2026-01-26 21:24:58,890 | WARNING  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2026-01-26 22:25:30] 2026-01-26 21:24:58,890 | WARNING  | data:copytool_out:received graceful stop - abort after this iteration
[2026-01-26 22:25:30] 2026-01-26 21:24:58,890 | WARNING  | job:job_monitor:received graceful stop - abort after this iteration
[2026-01-26 22:25:30] 2026-01-26 21:24:58,890 | INFO     | aborting loop
[2026-01-26 22:25:30] 2026-01-26 21:24:59,224 | INFO     | all data control threads have been joined
[2026-01-26 22:25:30] 2026-01-26 21:24:59,835 | WARNING  | data:queue_monitoring:received graceful stop - abort after this iteration
[2026-01-26 22:25:30] 2026-01-26 21:24:59,895 | INFO     | [job] retrieve thread has finished
[2026-01-26 22:25:30] 2026-01-26 21:24:59,896 | INFO     | [job] job monitor thread has finished
[2026-01-26 22:25:30] 2026-01-26 21:25:00,001 | INFO     | all payload control threads have been joined
[2026-01-26 22:25:30] 2026-01-26 21:25:00,229 | INFO     | [data] control thread has finished
[2026-01-26 22:25:30] 2026-01-26 21:25:00,249 | INFO     | all job control threads have been joined
[2026-01-26 22:25:30] 2026-01-26 21:25:00,321 | INFO     | [payload] run_realtimelog thread has finished
[2026-01-26 22:25:30] 2026-01-26 21:25:00,337 | INFO     | [payload] execute_payloads thread has finished
[2026-01-26 22:25:30] 2026-01-26 21:25:00,497 | INFO     | [payload] failed_post thread has finished
[2026-01-26 22:25:30] 2026-01-26 21:25:00,895 | INFO     | [data] copytool_out thread has finished
[2026-01-26 22:25:30] 2026-01-26 21:25:01,006 | INFO     | [payload] control thread has finished
[2026-01-26 22:25:30] 2026-01-26 21:25:01,046 | INFO     | [job] validate thread has finished
[2026-01-26 22:25:30] 2026-01-26 21:25:01,164 | INFO     | [payload] validate_pre thread has finished
[2026-01-26 22:25:30] 2026-01-26 21:25:01,182 | INFO     | [job] create_data_payload thread has finished
[2026-01-26 22:25:30] 2026-01-26 21:25:01,255 | INFO     | [job] control thread has finished
[2026-01-26 22:25:30] 2026-01-26 21:25:01,374 | INFO     | [data] copytool_in thread has finished
[2026-01-26 22:25:30] 2026-01-26 21:25:01,481 | INFO     | [payload] validate_post thread has finished
[2026-01-26 22:25:30] 2026-01-26 21:25:01,830 | WARNING  | job:queue_monitor:received graceful stop - abort after this iteration
[2026-01-26 22:25:30] 2026-01-26 21:25:02,835 | INFO     | [job] queue monitor thread has finished
[2026-01-26 22:25:30] 2026-01-26 21:25:03,840 | INFO     | [data] queue_monitor thread has finished
[2026-01-26 22:25:30] 2026-01-26 21:25:17,433 | INFO     | [monitor] cgroup control has ended
[2026-01-26 22:25:30] 2026-01-26 21:25:19,367 | INFO     | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 23456247945024)>', '<ExcThread(monitor, started 23456063182592)>']
[2026-01-26 22:25:30] 2026-01-26 21:25:24,392 | INFO     | all workflow threads have been joined
[2026-01-26 22:25:30] 2026-01-26 21:25:24,392 | INFO     | end of generic workflow (traces error code: 0)
[2026-01-26 22:25:30] 2026-01-26 21:25:24,392 | INFO     | traces error code: 0
[2026-01-26 22:25:30] 2026-01-26 21:25:24,392 | INFO     | pilot has finished (exit code=0, shell exit code=0)
[2026-01-26 22:25:30] 2026-01-26 21:25:29,880 | INFO     | PID=13661 has CPU usage=2.1% 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 
[2026-01-26 22:25:30] 2026-01-26 21:25:29,880 | INFO     | .. there are 3 such processes running
[2026-01-26 22:25:30] 2026-01-26 21:25:29,880 | INFO     | found 0 job(s) in 20 queues
[2026-01-26 22:25:30] 2026-01-26 21:25:29,880 | WARNING  | pilot monitor received instruction that args.graceful_stop has been set
[2026-01-26 22:25:30] 2026-01-26 21:25:29,880 | WARNING  | will wait for a maximum of 300 s for threads to finish
[2026-01-26 22:25:30] 2026-01-26 21:25:29,880 | WARNING  | job_aborted has been set - aborting pilot monitoring
[2026-01-26 22:25:30] 2026-01-26 21:25:29,881 | INFO     | [monitor] control thread has ended
[2026-01-26 22:25:30] 2026-01-26 21:25:29,933 [wrapper] ==== pilot stdout END ====
[2026-01-26 22:25:30] 2026-01-26 21:25:29,934 [wrapper] ==== wrapper stdout RESUME ====
[2026-01-26 22:25:30] 2026-01-26 21:25:29,936 [wrapper] pilotpid: 13661
[2026-01-26 22:25:30] 2026-01-26 21:25:29,937 [wrapper] Pilot exit status: 0
[2026-01-26 22:25:30] 2026-01-26 21:25:29,941 [wrapper] pandaids: 6983466590
[2026-01-26 22:25:30] 2026-01-26 21:25:29,963 [wrapper] cleanup supervisor_pilot  5116 13662
[2026-01-26 22:25:30] 2026-01-26 21:25:29,965 [wrapper] Test setup, not cleaning
[2026-01-26 22:25:30] 2026-01-26 21:25:29,966 [wrapper] apfmon messages muted
[2026-01-26 22:25:30] 2026-01-26 21:25:29,967 [wrapper] ==== wrapper stdout END ====
[2026-01-26 22:25:30] 2026-01-26 21:25:29,968 [wrapper] ==== wrapper stderr END ====
[2026-01-26 22:25:30]  *** Error codes and diagnostics ***
[2026-01-26 22:25:30]     "exeErrorCode": 0,
[2026-01-26 22:25:30]     "exeErrorDiag": "",
[2026-01-26 22:25:30]     "pilotErrorCode": 0,
[2026-01-26 22:25:30]     "pilotErrorDiag": "",
[2026-01-26 22:25:30]  *** Listing of results directory ***
[2026-01-26 22:25:30] total 467244
[2026-01-26 22:25:30] -rw------- 1 mf493845 unix-user    584422 Jan 25 23:54 pilot3.tar.gz
[2026-01-26 22:25:30] -rwx------ 1 mf493845 unix-user     36322 Jan 25 23:56 runpilot2-wrapper.sh
[2026-01-26 22:25:30] -rw------- 1 mf493845 unix-user      5111 Jan 25 23:58 queuedata.json
[2026-01-26 22:25:30] -rw------- 1 mf493845 unix-user       100 Jan 26 19:33 wrapper_26015_x86_64-pc-linux-gnu
[2026-01-26 22:25:30] -rwxr-xr-x 1 mf493845 unix-user      7986 Jan 26 19:33 run_atlas
[2026-01-26 22:25:30] -rw------- 1 mf493845 unix-user       105 Jan 26 19:33 job.xml
[2026-01-26 22:25:30] -rw-r--r-- 2 mf493845 unix-user 273834948 Jan 26 20:43 EVNT.48329871._000003.pool.root.1
[2026-01-26 22:25:30] -rw-r--r-- 2 mf493845 unix-user     15845 Jan 26 20:43 start_atlas.sh
[2026-01-26 22:25:30] drwxrwx--x 2 mf493845 unix-user       100 Jan 26 20:43 shared
[2026-01-26 22:25:30] -rw-r--r-- 2 mf493845 unix-user    597765 Jan 26 20:43 input.tar.gz
[2026-01-26 22:25:30] -rw------- 1 mf493845 unix-user      6390 Jan 26 20:43 init_data.xml
[2026-01-26 22:25:30] -rw------- 1 mf493845 unix-user         0 Jan 26 20:43 boinc_setup_complete
[2026-01-26 22:25:30] -rw------- 1 mf493845 unix-user      8192 Jan 26 20:43 boinc_mmap_file
[2026-01-26 22:25:30] -rw------- 1 mf493845 unix-user         0 Jan 26 20:43 boinc_lockfile
[2026-01-26 22:25:30] -rw------- 1 mf493845 unix-user      2608 Jan 26 20:43 pandaJob.out
[2026-01-26 22:25:30] -rw------- 1 mf493845 unix-user   1006449 Jan 26 20:43 agis_schedconf.cvmfs.json
[2026-01-26 22:25:30] -rw------- 1 mf493845 unix-user   1516246 Jan 26 20:43 agis_ddmendpoints.agis.ALL.json
[2026-01-26 22:25:30] -rw------- 1 mf493845 unix-user       420 Jan 26 20:43 workernode_map.json
[2026-01-26 22:25:30] drwx------ 5 mf493845 unix-user       440 Jan 26 20:43 pilot3
[2026-01-26 22:25:30] -rw------- 1 mf493845 unix-user 198181931 Jan 26 22:24 HITS.48329874._000074.pool.root.1
[2026-01-26 22:25:30] -rw------- 1 mf493845 unix-user      1023 Jan 26 22:24 memory_monitor_summary.json
[2026-01-26 22:25:30] -rw------- 1 mf493845 unix-user    361310 Jan 26 22:24 log.48329874._000074.job.log.tgz.1
[2026-01-26 22:25:30] -rw------- 1 mf493845 unix-user      6316 Jan 26 22:24 heartbeat.json
[2026-01-26 22:25:30] -rw------- 1 mf493845 unix-user       820 Jan 26 22:25 pilotlog.txt
[2026-01-26 22:25:30] -rw------- 1 mf493845 unix-user        95 Jan 26 22:25 pilot_heartbeat.json
[2026-01-26 22:25:30] -rw------- 1 mf493845 unix-user    903008 Jan 26 22:25 log.48329874._000074.job.log.1
[2026-01-26 22:25:30] -rw------- 1 mf493845 unix-user       357 Jan 26 22:25 output.list
[2026-01-26 22:25:30] -rw------- 1 mf493845 unix-user       620 Jan 26 22:25 runtime_log
[2026-01-26 22:25:30] -rw------- 1 mf493845 unix-user   1280000 Jan 26 22:25 result.tar.gz
[2026-01-26 22:25:30] -rw------- 1 mf493845 unix-user       646 Jan 26 22:25 xy2MDmrCO48nsSi4ap6QjLDmwznN0nGgGQJmNLGKDmHb8KDmR29xdm.diag
[2026-01-26 22:25:30] -rw------- 1 mf493845 unix-user      9219 Jan 26 22:25 runtime_log.err
[2026-01-26 22:25:30] -rw------- 1 mf493845 unix-user     21729 Jan 26 22:25 stderr.txt
[2026-01-26 22:25:30] HITS file was successfully produced:
[2026-01-26 22:25:30] -rw------- 1 mf493845 unix-user 198181931 Jan 26 22:24 shared/HITS.pool.root.1
[2026-01-26 22:25:30]  *** Contents of shared directory: ***
[2026-01-26 22:25:30] total 462812
[2026-01-26 22:25:30] -rw-r--r-- 2 mf493845 unix-user 273834948 Jan 26 20:43 ATLAS.root_0
[2026-01-26 22:25:30] -rw-r--r-- 2 mf493845 unix-user     15845 Jan 26 20:43 start_atlas.sh
[2026-01-26 22:25:30] -rw-r--r-- 2 mf493845 unix-user    597765 Jan 26 20:43 input.tar.gz
[2026-01-26 22:25:30] -rw------- 1 mf493845 unix-user 198181931 Jan 26 22:24 HITS.pool.root.1
[2026-01-26 22:25:30] -rw------- 1 mf493845 unix-user   1280000 Jan 26 22:25 result.tar.gz
22:25:31 (9734): run_atlas exited; CPU time 45892.501046
22:25:31 (9734): called boinc_finish(0)

</stderr_txt>
]]>


©2026 CERN