Stderr output

<core_client_version>8.0.4</core_client_version>
<![CDATA[
<stderr_txt>
04:26:46 (1549552): wrapper (7.7.26015): starting
04:26:46 (1549552): wrapper: running run_atlas (--nthreads 4)
[2025-01-31 04:26:46] Arguments: --nthreads 4
[2025-01-31 04:26:46] Threads: 4
[2025-01-31 04:26:46] Checking for CVMFS
[2025-01-31 04:26:46] Probing /cvmfs/atlas.cern.ch... OK
[2025-01-31 04:26:46] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-01-31 04:26:46] Running cvmfs_config stat atlas.cern.ch
[2025-01-31 04:26:47] 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-01-31 04:26:47] 2.12.4.4 3544893 3866 69296 142158 1 55 9125890 10240000 1818 130560 0 8145441 99.994 914925 225 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch http://192.168.101.101:3128 1
[2025-01-31 04:26:47] CVMFS is ok
[2025-01-31 04:26:47] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-01-31 04:26:47] Checking for apptainer binary...
[2025-01-31 04:26:47] Using apptainer found in PATH at /usr/bin/apptainer
[2025-01-31 04:26:47] Running /usr/bin/apptainer --version
[2025-01-31 04:26:47] apptainer version 1.3.4
[2025-01-31 04:26:47] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-01-31 04:26:47] woolyvlneu
[2025-01-31 04:26:47] apptainer works
[2025-01-31 04:26:47] Set ATHENA_PROC_NUMBER=4
[2025-01-31 04:26:47] Set ATHENA_CORE_NUMBER=4
[2025-01-31 04:26:47] Starting ATLAS job with PandaID=6495923602
[2025-01-31 04:26:47] Running command: /usr/bin/apptainer exec -B /cvmfs,/var/lib/boinc_data/boinc-01/slots/2 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2025-01-31 07:49:32]  *** The last 200 lines of the pilot log: ***
[2025-01-31 07:49:32] 2025-01-31 06:49:17,984 | INFO     | monitor loop #925: job 0:6495923602 is in state 'finished'
[2025-01-31 07:49:32] 2025-01-31 06:49:17,984 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2025-01-31 07:49:32] 2025-01-31 06:49:20,488 | INFO     | monitor loop #926: job 0:6495923602 is in state 'finished'
[2025-01-31 07:49:32] 2025-01-31 06:49:20,488 | INFO     | will abort job monitoring soon since job state=finished (job is still in queue)
[2025-01-31 07:49:32] 2025-01-31 06:49:20,606 | INFO     | CPU arch script returned: x86-64-v3
[2025-01-31 07:49:32] 2025-01-31 06:49:20,606 | INFO     | using path: /var/lib/boinc_data/boinc-01/slots/2/PanDA_Pilot-6495923602/memory_monitor_summary.json (trf name=prmon)
[2025-01-31 07:49:32] 2025-01-31 06:49:20,606 | INFO     | extracted standard info from prmon json
[2025-01-31 07:49:32] 2025-01-31 06:49:20,606 | INFO     | extracted standard memory fields from prmon json
[2025-01-31 07:49:32] 2025-01-31 06:49:20,606 | WARNING  | GPU info not found in prmon json: 'gpu'
[2025-01-31 07:49:32] 2025-01-31 06:49:20,607 | WARNING  | format EVNTtoHITS has no such key: dbData
[2025-01-31 07:49:32] 2025-01-31 06:49:20,607 | WARNING  | format EVNTtoHITS has no such key: dbTime
[2025-01-31 07:49:32] 2025-01-31 06:49:20,608 | INFO     | fitting pss+swap vs Time
[2025-01-31 07:49:32] 2025-01-31 06:49:20,608 | INFO     | model: linear, x: [1738294035.0, 1738294096.0, 1738294157.0, 1738294218.0, 1738294279.0, 1738294340.0, 1738294401.0, 1738294462.0, 1738294523.0, 1738294584.0, 1738
[2025-01-31 07:49:32] 2025-01-31 06:49:20,608 | INFO     | sum of square deviations: 2443580700.0
[2025-01-31 07:49:32] 2025-01-31 06:49:20,609 | INFO     | sum of deviations: -20377238672.999996
[2025-01-31 07:49:32] 2025-01-31 06:49:20,609 | INFO     | mean x: 1738300074.0
[2025-01-31 07:49:32] 2025-01-31 06:49:20,609 | INFO     | mean y: 2446523.1708542714
[2025-01-31 07:49:32] 2025-01-31 06:49:20,609 | INFO     | -- intersect: 14498286784.63288
[2025-01-31 07:49:32] 2025-01-31 06:49:20,609 | INFO     | intersect: 14498286784.63288
[2025-01-31 07:49:32] 2025-01-31 06:49:20,609 | INFO     | chi2: 2.3456430874939134
[2025-01-31 07:49:32] 2025-01-31 06:49:20,609 | INFO     | model: linear, x: [1738294035.0, 1738294096.0, 1738294157.0, 1738294218.0, 1738294279.0, 1738294340.0, 1738294401.0, 1738294462.0, 1738294523.0, 1738294584.0, 1738
[2025-01-31 07:49:32] 2025-01-31 06:49:20,609 | INFO     | sum of square deviations: 2263977332.5
[2025-01-31 07:49:32] 2025-01-31 06:49:20,610 | INFO     | sum of deviations: -19401637094.500004
[2025-01-31 07:49:32] 2025-01-31 06:49:20,610 | INFO     | mean x: 1738299921.5
[2025-01-31 07:49:32] 2025-01-31 06:49:20,610 | INFO     | mean y: 2447351.6340206186
[2025-01-31 07:49:32] 2025-01-31 06:49:20,610 | INFO     | -- intersect: 14899179644.04572
[2025-01-31 07:49:32] 2025-01-31 06:49:20,610 | INFO     | intersect: 14899179644.04572
[2025-01-31 07:49:32] 2025-01-31 06:49:20,610 | INFO     | chi2: 2.343833646771093
[2025-01-31 07:49:32] 2025-01-31 06:49:20,610 | INFO     | current chi2=2.343833646771093 (change=0.07714049645777081 %)
[2025-01-31 07:49:32] 2025-01-31 06:49:20,610 | INFO     | right removable region: 193
[2025-01-31 07:49:32] 2025-01-31 06:49:20,610 | INFO     | model: linear, x: [1738294340.0, 1738294401.0, 1738294462.0, 1738294523.0, 1738294584.0, 1738294645.0, 1738294706.0, 1738294767.0, 1738294828.0, 1738294889.0, 1738
[2025-01-31 07:49:32] 2025-01-31 06:49:20,610 | INFO     | sum of square deviations: 2263977332.5
[2025-01-31 07:49:32] 2025-01-31 06:49:20,610 | INFO     | sum of deviations: -61060765943.0
[2025-01-31 07:49:32] 2025-01-31 06:49:20,610 | INFO     | mean x: 1738300226.5
[2025-01-31 07:49:32] 2025-01-31 06:49:20,610 | INFO     | mean y: 2480901.9175257734
[2025-01-31 07:49:32] 2025-01-31 06:49:20,610 | INFO     | -- intersect: 46885434076.97118
[2025-01-31 07:49:32] 2025-01-31 06:49:20,610 | INFO     | intersect: 46885434076.97118
[2025-01-31 07:49:32] 2025-01-31 06:49:20,611 | INFO     | chi2: 0.36349488747057923
[2025-01-31 07:49:32] 2025-01-31 06:49:20,611 | INFO     | current chi2=0.36349488747057923 (change=84.50340167229203 %)
[2025-01-31 07:49:32] 2025-01-31 06:49:20,611 | INFO     | model: linear, x: [1738294645.0, 1738294706.0, 1738294767.0, 1738294828.0, 1738294889.0, 1738294950.0, 1738295011.0, 1738295072.0, 1738295133.0, 1738295194.0, 1738
[2025-01-31 07:49:32] 2025-01-31 06:49:20,611 | INFO     | sum of square deviations: 2093397390.0
[2025-01-31 07:49:32] 2025-01-31 06:49:20,611 | INFO     | sum of deviations: -56266480093.000015
[2025-01-31 07:49:32] 2025-01-31 06:49:20,611 | INFO     | mean x: 1738300379.0
[2025-01-31 07:49:32] 2025-01-31 06:49:20,611 | INFO     | mean y: 2476587.73015873
[2025-01-31 07:49:32] 2025-01-31 06:49:20,611 | INFO     | -- intersect: 46724634615.574974
[2025-01-31 07:49:32] 2025-01-31 06:49:20,611 | INFO     | intersect: 46724634615.574974
[2025-01-31 07:49:32] 2025-01-31 06:49:20,612 | INFO     | chi2: 0.35909784035812187
[2025-01-31 07:49:32] 2025-01-31 06:49:20,612 | INFO     | current chi2=0.35909784035812187 (change=1.2096585850367028 %)
[2025-01-31 07:49:32] 2025-01-31 06:49:20,612 | INFO     | left removable region: 20
[2025-01-31 07:49:32] 2025-01-31 06:49:20,612 | INFO     | model: linear, x: [1738295255.0, 1738295316.0, 1738295377.0, 1738295438.0, 1738295499.0, 1738295560.0, 1738295621.0, 1738295682.0, 1738295743.0, 1738295804.0, 1738
[2025-01-31 07:49:32] 2025-01-31 06:49:20,612 | INFO     | sum of square deviations: 1605470102.0
[2025-01-31 07:49:32] 2025-01-31 06:49:20,612 | INFO     | sum of deviations: -39096762940.0
[2025-01-31 07:49:32] 2025-01-31 06:49:20,612 | INFO     | mean x: 1738300501.0
[2025-01-31 07:49:32] 2025-01-31 06:49:20,612 | INFO     | mean y: 2463046.87283237
[2025-01-31 07:49:32] 2025-01-31 06:49:20,612 | INFO     | -- intersect: 42333941235.98222
[2025-01-31 07:49:32] 2025-01-31 06:49:20,613 | INFO     | intersect: 42333941235.98222
[2025-01-31 07:49:32] 2025-01-31 06:49:20,613 | INFO     | chi2: 0.32583232350043395
[2025-01-31 07:49:32] 2025-01-31 06:49:20,613 | INFO     | -- intersect: 42333941235.98222
[2025-01-31 07:49:32] 2025-01-31 06:49:20,613 | INFO     | current memory leak: -24.35 B/s (using 173 data points, chi2=0.33)
[2025-01-31 07:49:32] 2025-01-31 06:49:20,613 | INFO     | ..............................
[2025-01-31 07:49:32] 2025-01-31 06:49:20,613 | INFO     | . Timing measurements:
[2025-01-31 07:49:32] 2025-01-31 06:49:20,613 | INFO     | . get job = 0 s
[2025-01-31 07:49:32] 2025-01-31 06:49:20,613 | INFO     | . initial setup = 1 s
[2025-01-31 07:49:32] 2025-01-31 06:49:20,613 | INFO     | . payload setup = 4 s
[2025-01-31 07:49:32] 2025-01-31 06:49:20,613 | INFO     | . stage-in = 0 s
[2025-01-31 07:49:32] 2025-01-31 06:49:20,613 | INFO     | . payload execution = 12113 s
[2025-01-31 07:49:32] 2025-01-31 06:49:20,613 | INFO     | . stage-out = 5 s
[2025-01-31 07:49:32] 2025-01-31 06:49:20,613 | INFO     | . log creation = 0 s
[2025-01-31 07:49:32] 2025-01-31 06:49:20,613 | INFO     | ..............................
[2025-01-31 07:49:32] 2025-01-31 06:49:20,655 | INFO     | 
[2025-01-31 07:49:32] 2025-01-31 06:49:20,655 | INFO     | job summary report
[2025-01-31 07:49:32] 2025-01-31 06:49:20,655 | INFO     | --------------------------------------------------
[2025-01-31 07:49:32] 2025-01-31 06:49:20,655 | INFO     | PanDA job id: 6495923602
[2025-01-31 07:49:32] 2025-01-31 06:49:20,655 | INFO     | task id: 43092775
[2025-01-31 07:49:32] 2025-01-31 06:49:20,655 | INFO     | errors: (none)
[2025-01-31 07:49:32] 2025-01-31 06:49:20,655 | INFO     | status: LOG_TRANSFER = DONE 
[2025-01-31 07:49:32] 2025-01-31 06:49:20,655 | INFO     | pilot state: finished 
[2025-01-31 07:49:32] 2025-01-31 06:49:20,655 | INFO     | transexitcode: 0
[2025-01-31 07:49:32] 2025-01-31 06:49:20,655 | INFO     | exeerrorcode: 0
[2025-01-31 07:49:32] 2025-01-31 06:49:20,655 | INFO     | exeerrordiag: 
[2025-01-31 07:49:32] 2025-01-31 06:49:20,655 | INFO     | exitcode: 0
[2025-01-31 07:49:32] 2025-01-31 06:49:20,655 | INFO     | exitmsg: OK
[2025-01-31 07:49:32] 2025-01-31 06:49:20,655 | INFO     | cpuconsumptiontime: 46953 s
[2025-01-31 07:49:32] 2025-01-31 06:49:20,655 | INFO     | nevents: 400
[2025-01-31 07:49:32] 2025-01-31 06:49:20,655 | INFO     | neventsw: 0
[2025-01-31 07:49:32] 2025-01-31 06:49:20,655 | INFO     | pid: 1559955
[2025-01-31 07:49:32] 2025-01-31 06:49:20,655 | INFO     | pgrp: 1559955
[2025-01-31 07:49:32] 2025-01-31 06:49:20,655 | INFO     | corecount: 4
[2025-01-31 07:49:32] 2025-01-31 06:49:20,655 | INFO     | event service: False
[2025-01-31 07:49:32] 2025-01-31 06:49:20,655 | INFO     | sizes: {0: 2378164, 3: 2378370, 11: 2378398, 12120: 2408116, 12127: 2417141, 12132: 2417255}
[2025-01-31 07:49:32] 2025-01-31 06:49:20,655 | INFO     | --------------------------------------------------
[2025-01-31 07:49:32] 2025-01-31 06:49:20,655 | INFO     | 
[2025-01-31 07:49:32] 2025-01-31 06:49:20,655 | INFO     | executing command: ls -lF /var/lib/boinc_data/boinc-01/slots/2
[2025-01-31 07:49:32] 2025-01-31 06:49:20,672 | INFO     | queue jobs had 0 job(s) [purged]
[2025-01-31 07:49:32] 2025-01-31 06:49:20,672 | INFO     | queue payloads had 0 job(s) [purged]
[2025-01-31 07:49:32] 2025-01-31 06:49:20,672 | INFO     | queue data_in had 0 job(s) [purged]
[2025-01-31 07:49:32] 2025-01-31 06:49:20,672 | INFO     | queue data_out had 0 job(s) [purged]
[2025-01-31 07:49:32] 2025-01-31 06:49:20,672 | INFO     | queue current_data_in had 0 job(s) [purged]
[2025-01-31 07:49:32] 2025-01-31 06:49:20,672 | INFO     | queue validated_jobs had 0 job(s) [purged]
[2025-01-31 07:49:32] 2025-01-31 06:49:20,672 | INFO     | queue validated_payloads had 0 job(s) [purged]
[2025-01-31 07:49:32] 2025-01-31 06:49:20,672 | INFO     | queue monitored_payloads had 0 job(s) [purged]
[2025-01-31 07:49:32] 2025-01-31 06:49:20,672 | INFO     | queue finished_jobs had 0 job(s) [purged]
[2025-01-31 07:49:32] 2025-01-31 06:49:20,672 | INFO     | queue finished_payloads had 0 job(s) [purged]
[2025-01-31 07:49:32] 2025-01-31 06:49:20,672 | INFO     | queue finished_data_in had 1 job(s) [purged]
[2025-01-31 07:49:32] 2025-01-31 06:49:20,672 | INFO     | queue finished_data_out had 0 job(s) [purged]
[2025-01-31 07:49:32] 2025-01-31 06:49:20,672 | INFO     | queue failed_jobs had 0 job(s) [purged]
[2025-01-31 07:49:32] 2025-01-31 06:49:20,672 | INFO     | queue failed_payloads had 0 job(s) [purged]
[2025-01-31 07:49:32] 2025-01-31 06:49:20,672 | INFO     | queue failed_data_in had 0 job(s) [purged]
[2025-01-31 07:49:32] 2025-01-31 06:49:20,672 | INFO     | queue failed_data_out had 0 job(s) [purged]
[2025-01-31 07:49:32] 2025-01-31 06:49:20,672 | INFO     | queue completed_jobs had 0 job(s) [purged]
[2025-01-31 07:49:32] 2025-01-31 06:49:20,672 | INFO     | queue completed_jobids has 1 job(s)
[2025-01-31 07:49:32] 2025-01-31 06:49:20,672 | INFO     | queue realtimelog_payloads had 0 job(s) [purged]
[2025-01-31 07:49:32] 2025-01-31 06:49:20,672 | INFO     | queue messages had 0 job(s) [purged]
[2025-01-31 07:49:32] 2025-01-31 06:49:20,672 | INFO     | job 6495923602 has completed (purged errors)
[2025-01-31 07:49:32] 2025-01-31 06:49:20,673 | INFO     | overall cleanup function is called
[2025-01-31 07:49:32] 2025-01-31 06:49:21,680 | INFO     | --- collectZombieJob: --- 10, [1559955]
[2025-01-31 07:49:32] 2025-01-31 06:49:21,680 | INFO     | zombie collector waiting for pid 1559955
[2025-01-31 07:49:32] 2025-01-31 06:49:21,680 | INFO     | harmless exception when collecting zombies: [Errno 10] No child processes
[2025-01-31 07:49:32] 2025-01-31 06:49:21,680 | INFO     | collected zombie processes
[2025-01-31 07:49:32] 2025-01-31 06:49:21,680 | INFO     | will attempt to kill all subprocesses of pid=1559955
[2025-01-31 07:49:32] 2025-01-31 06:49:21,731 | INFO     | process IDs to be killed: [1559955] (in reverse order)
[2025-01-31 07:49:32] 2025-01-31 06:49:21,766 | WARNING  | found no corresponding commands to process id(s)
[2025-01-31 07:49:32] 2025-01-31 06:49:21,766 | INFO     | Do not look for orphan processes in BOINC jobs
[2025-01-31 07:49:32] 2025-01-31 06:49:21,769 | INFO     | did not find any defunct processes belonging to 1559955
[2025-01-31 07:49:32] 2025-01-31 06:49:21,771 | INFO     | did not find any defunct processes belonging to 1559955
[2025-01-31 07:49:32] 2025-01-31 06:49:21,771 | INFO     | ready for new job
[2025-01-31 07:49:32] 2025-01-31 06:49:21,771 | INFO     | pilot has finished with previous job - re-establishing logging
[2025-01-31 07:49:32] 2025-01-31 06:49:21,772 | INFO     | **************************************
[2025-01-31 07:49:32] 2025-01-31 06:49:21,772 | INFO     | ***  PanDA Pilot version 3.9.4.15  ***
[2025-01-31 07:49:32] 2025-01-31 06:49:21,772 | INFO     | **************************************
[2025-01-31 07:49:32] 2025-01-31 06:49:21,772 | INFO     | 
[2025-01-31 07:49:32] 2025-01-31 06:49:21,773 | INFO     | pilot is running in a VM
[2025-01-31 07:49:32] 2025-01-31 06:49:21,773 | INFO     | architecture information:
[2025-01-31 07:49:32] 2025-01-31 06:49:21,773 | INFO     | executing command: cat /etc/os-release
[2025-01-31 07:49:32] 2025-01-31 06:49:21,782 | INFO     | cat /etc/os-release:
[2025-01-31 07:49:32] NAME="CentOS Linux"
[2025-01-31 07:49:32] VERSION="7 (Core)"
[2025-01-31 07:49:32] ID="centos"
[2025-01-31 07:49:32] ID_LIKE="rhel fedora"
[2025-01-31 07:49:32] VERSION_ID="7"
[2025-01-31 07:49:32] PRETTY_NAME="CentOS Linux 7 (Core)"
[2025-01-31 07:49:32] ANSI_COLOR="0;31"
[2025-01-31 07:49:32] CPE_NAME="cpe:/o:centos:centos:7"
[2025-01-31 07:49:32] HOME_URL="https://www.centos.org/"
[2025-01-31 07:49:32] BUG_REPORT_URL="https://bugs.centos.org/"
[2025-01-31 07:49:32] 
[2025-01-31 07:49:32] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2025-01-31 07:49:32] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2025-01-31 07:49:32] REDHAT_SUPPORT_PRODUCT="centos"
[2025-01-31 07:49:32] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2025-01-31 07:49:32] 
[2025-01-31 07:49:32] 2025-01-31 06:49:21,782 | INFO     | **************************************
[2025-01-31 07:49:32] 2025-01-31 06:49:22,285 | INFO     | executing command: df -mP /var/lib/boinc_data/boinc-01/slots/2
[2025-01-31 07:49:32] 2025-01-31 06:49:22,296 | INFO     | sufficient remaining disk space (25597837312 B)
[2025-01-31 07:49:32] 2025-01-31 06:49:22,296 | WARNING  | since timefloor is set to 0, pilot was only allowed to run one job
[2025-01-31 07:49:32] 2025-01-31 06:49:22,296 | WARNING  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2025-01-31 07:49:32] 2025-01-31 06:49:22,296 | WARNING  | job:queue_monitor:received graceful stop - abort after this iteration
[2025-01-31 07:49:32] 2025-01-31 06:49:22,296 | WARNING  | data:queue_monitoring:received graceful stop - abort after this iteration
[2025-01-31 07:49:32] 2025-01-31 06:49:22,296 | WARNING  | job:job_monitor:received graceful stop - abort after this iteration
[2025-01-31 07:49:32] 2025-01-31 06:49:22,297 | INFO     | aborting loop
[2025-01-31 07:49:32] 2025-01-31 06:49:22,343 | INFO     | all data control threads have been joined
[2025-01-31 07:49:32] 2025-01-31 06:49:22,658 | INFO     | found 0 job(s) in 20 queues
[2025-01-31 07:49:32] 2025-01-31 06:49:22,658 | WARNING  | pilot monitor received instruction that args.graceful_stop has been set
[2025-01-31 07:49:32] 2025-01-31 06:49:22,658 | WARNING  | will wait for a maximum of 300 s for threads to finish
[2025-01-31 07:49:32] 2025-01-31 06:49:22,912 | INFO     | all payload control threads have been joined
[2025-01-31 07:49:32] 2025-01-31 06:49:23,194 | INFO     | all job control threads have been joined
[2025-01-31 07:49:32] 2025-01-31 06:49:23,301 | INFO     | [job] retrieve thread has finished
[2025-01-31 07:49:32] 2025-01-31 06:49:23,302 | INFO     | [job] queue monitor thread has finished
[2025-01-31 07:49:32] 2025-01-31 06:49:23,302 | INFO     | [job] job monitor thread has finished
[2025-01-31 07:49:32] 2025-01-31 06:49:23,348 | INFO     | [data] control thread has finished
[2025-01-31 07:49:32] 2025-01-31 06:49:23,501 | WARNING  | data:copytool_out:received graceful stop - abort after this iteration
[2025-01-31 07:49:32] 2025-01-31 06:49:23,658 | INFO     | [payload] validate_post thread has finished
[2025-01-31 07:49:32] 2025-01-31 06:49:23,705 | INFO     | [payload] failed_post thread has finished
[2025-01-31 07:49:32] 2025-01-31 06:49:23,852 | INFO     | [job] validate thread has finished
[2025-01-31 07:49:32] 2025-01-31 06:49:23,892 | INFO     | [data] copytool_in thread has finished
[2025-01-31 07:49:32] 2025-01-31 06:49:23,918 | INFO     | [payload] control thread has finished
[2025-01-31 07:49:32] 2025-01-31 06:49:23,961 | INFO     | [job] create_data_payload thread has finished
[2025-01-31 07:49:32] 2025-01-31 06:49:24,162 | INFO     | [payload] validate_pre thread has finished
[2025-01-31 07:49:32] 2025-01-31 06:49:24,199 | INFO     | [job] control thread has finished
[2025-01-31 07:49:32] 2025-01-31 06:49:24,221 | INFO     | [payload] execute_payloads thread has finished
[2025-01-31 07:49:32] 2025-01-31 06:49:24,548 | INFO     | [payload] run_realtimelog thread has finished
[2025-01-31 07:49:32] 2025-01-31 06:49:25,507 | INFO     | [data] copytool_out thread has finished
[2025-01-31 07:49:32] 2025-01-31 06:49:26,304 | INFO     | [data] queue_monitor thread has finished
[2025-01-31 07:49:32] 2025-01-31 06:49:26,829 | INFO     | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 124845448320832)>', '<ExcThread(monitor, started 124845048203008)>']
[2025-01-31 07:49:32] 2025-01-31 06:49:27,682 | WARNING  | job_aborted has been set - aborting pilot monitoring
[2025-01-31 07:49:32] 2025-01-31 06:49:27,683 | INFO     | [monitor] control thread has ended
[2025-01-31 07:49:32] 2025-01-31 06:49:31,854 | INFO     | all workflow threads have been joined
[2025-01-31 07:49:32] 2025-01-31 06:49:31,854 | INFO     | end of generic workflow (traces error code: 0)
[2025-01-31 07:49:32] 2025-01-31 06:49:31,854 | INFO     | traces error code: 0
[2025-01-31 07:49:32] 2025-01-31 06:49:31,855 | INFO     | pilot has finished (exit code=0, shell exit code=0)
[2025-01-31 07:49:32] 2025-01-31 06:49:31,914 [wrapper] ==== pilot stdout END ====
[2025-01-31 07:49:32] 2025-01-31 06:49:31,917 [wrapper] ==== wrapper stdout RESUME ====
[2025-01-31 07:49:32] 2025-01-31 06:49:31,919 [wrapper] pilotpid: 1553331
[2025-01-31 07:49:32] 2025-01-31 06:49:31,922 [wrapper] Pilot exit status: 0
[2025-01-31 07:49:32] 2025-01-31 06:49:31,931 [wrapper] pandaids: 6495923602
[2025-01-31 07:49:32] 2025-01-31 06:49:31,957 [wrapper] cleanup supervisor_pilot 1654647 1553332
[2025-01-31 07:49:32] 2025-01-31 06:49:31,960 [wrapper] Test setup, not cleaning
[2025-01-31 07:49:32] 2025-01-31 06:49:31,965 [wrapper] apfmon messages muted
[2025-01-31 07:49:32] 2025-01-31 06:49:31,967 [wrapper] ==== wrapper stdout END ====
[2025-01-31 07:49:32] 2025-01-31 06:49:31,969 [wrapper] ==== wrapper stderr END ====
[2025-01-31 07:49:32]  *** Error codes and diagnostics ***
[2025-01-31 07:49:32]     "exeErrorCode": 0,
[2025-01-31 07:49:32]     "exeErrorDiag": "",
[2025-01-31 07:49:32]     "pilotErrorCode": 0,
[2025-01-31 07:49:32]     "pilotErrorDiag": "",
[2025-01-31 07:49:32]  *** Listing of results directory ***
[2025-01-31 07:49:32] insgesamt 679532
[2025-01-31 07:49:32] -rw-r--r-- 1 yeti boinc    491065 Jan 30 18:27 pilot3.tar.gz
[2025-01-31 07:49:32] -rw-r--r-- 1 yeti boinc      5117 Jan 30 18:33 queuedata.json
[2025-01-31 07:49:32] -rwx------ 1 yeti boinc     34924 Jan 30 18:33 runpilot2-wrapper.sh
[2025-01-31 07:49:32] -rw-r--r-- 1 yeti boinc       100 Jan 31 04:26 wrapper_26015_x86_64-pc-linux-gnu
[2025-01-31 07:49:32] -rwxr-xr-x 1 yeti boinc      7986 Jan 31 04:26 run_atlas
[2025-01-31 07:49:32] -rw-r--r-- 1 yeti boinc       105 Jan 31 04:26 job.xml
[2025-01-31 07:49:32] -rw-r--r-- 1 yeti boinc      6732 Jan 31 04:26 init_data.xml
[2025-01-31 07:49:32] -rw-r--r-- 2 yeti boinc 342983077 Jan 31 04:26 EVNT.43092773._000061.pool.root.1
[2025-01-31 07:49:32] -rw-r--r-- 2 yeti boinc     17569 Jan 31 04:26 start_atlas.sh
[2025-01-31 07:49:32] drwxrwx--x 2 yeti boinc      4096 Jan 31 04:26 shared
[2025-01-31 07:49:32] -rw-r--r-- 2 yeti boinc    503492 Jan 31 04:26 input.tar.gz
[2025-01-31 07:49:32] -rw-r--r-- 1 yeti boinc         0 Jan 31 04:26 boinc_lockfile
[2025-01-31 07:49:32] -rw-r--r-- 1 yeti boinc      2523 Jan 31 04:26 pandaJob.out
[2025-01-31 07:49:32] -rw------- 1 yeti boinc       462 Jan 31 04:26 setup.sh.local
[2025-01-31 07:49:32] -rw------- 1 yeti boinc    968594 Jan 31 04:26 agis_schedconf.cvmfs.json
[2025-01-31 07:49:32] drwx------ 4 yeti boinc      4096 Jan 31 04:26 pilot3
[2025-01-31 07:49:32] -rw------- 1 yeti boinc        95 Jan 31 07:48 pilot_heartbeat.json
[2025-01-31 07:49:32] -rw------- 1 yeti boinc 345887528 Jan 31 07:48 HITS.43092775._005992.pool.root.1
[2025-01-31 07:49:32] -rw------- 1 yeti boinc      1018 Jan 31 07:49 memory_monitor_summary.json
[2025-01-31 07:49:32] -rw-r--r-- 1 yeti boinc        28 Jan 31 07:49 wrapper_checkpoint.txt
[2025-01-31 07:49:32] -rw-r--r-- 1 yeti boinc      8192 Jan 31 07:49 boinc_mmap_file
[2025-01-31 07:49:32] -rw-r--r-- 1 yeti boinc       531 Jan 31 07:49 boinc_task_state.xml
[2025-01-31 07:49:32] -rw------- 1 yeti boinc   1580185 Jan 31 07:49 agis_ddmendpoints.agis.ALL.json
[2025-01-31 07:49:32] -rw------- 1 yeti boinc    320126 Jan 31 07:49 log.43092775._005992.job.log.tgz.1
[2025-01-31 07:49:32] -rw------- 1 yeti boinc      7654 Jan 31 07:49 heartbeat.json
[2025-01-31 07:49:32] -rw------- 1 yeti boinc      4291 Jan 31 07:49 pilotlog.txt
[2025-01-31 07:49:32] -rw------- 1 yeti boinc   1272927 Jan 31 07:49 log.43092775._005992.job.log.1
[2025-01-31 07:49:32] -rw------- 1 yeti boinc       357 Jan 31 07:49 output.list
[2025-01-31 07:49:32] -rw-r--r-- 1 yeti boinc       620 Jan 31 07:49 runtime_log
[2025-01-31 07:49:32] -rw------- 1 yeti boinc   1607680 Jan 31 07:49 result.tar.gz
[2025-01-31 07:49:32] -rw-r--r-- 1 yeti boinc     11624 Jan 31 07:49 runtime_log.err
[2025-01-31 07:49:32] -rw------- 1 yeti boinc       643 Jan 31 07:49 grzLDmEbnx6nsSi4ap6QjLDmwznN0nGgGQJmkKkKDm0eLKDmXLJFXo.diag
[2025-01-31 07:49:32] -rw-r--r-- 1 yeti boinc     21314 Jan 31 07:49 stderr.txt
[2025-01-31 07:49:32] HITS file was successfully produced:
[2025-01-31 07:49:32] -rw------- 1 yeti boinc 345887528 Jan 31 07:48 shared/HITS.pool.root.1
[2025-01-31 07:49:32]  *** Contents of shared directory: ***
[2025-01-31 07:49:32] insgesamt 674824
[2025-01-31 07:49:32] -rw-r--r-- 2 yeti boinc 342983077 Jan 31 04:26 ATLAS.root_0
[2025-01-31 07:49:32] -rw-r--r-- 2 yeti boinc     17569 Jan 31 04:26 start_atlas.sh
[2025-01-31 07:49:32] -rw-r--r-- 2 yeti boinc    503492 Jan 31 04:26 input.tar.gz
[2025-01-31 07:49:32] -rw------- 1 yeti boinc 345887528 Jan 31 07:48 HITS.pool.root.1
[2025-01-31 07:49:32] -rw------- 1 yeti boinc   1607680 Jan 31 07:49 result.tar.gz
07:49:33 (1549552): run_atlas exited; CPU time 46886.594423
07:49:33 (1549552): called boinc_finish(0)

</stderr_txt>
]]>

©2025 CERN