Stderr output

<core_client_version>7.7.0</core_client_version>
<![CDATA[
<stderr_txt>
19:20:22 (29043): wrapper (7.7.26015): starting
19:20:22 (29043): wrapper: running run_atlas (--nthreads 4)
[2025-02-21 19:20:22] Arguments: --nthreads 4
[2025-02-21 19:20:22] Threads: 4
[2025-02-21 19:20:22] Checking for CVMFS
[2025-02-21 19:20:22] Probing /cvmfs/atlas.cern.ch... OK
[2025-02-21 19:20:22] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-02-21 19:20:22] Running cvmfs_config stat atlas.cern.ch
[2025-02-21 19:20:22] 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-02-21 19:20:22] 2.11.2.0 2943 304790 91880 142921 1 55 16859777 20275201 1 130560 0 18410340 99.988 6237905 46582 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1
[2025-02-21 19:20:22] CVMFS is ok
[2025-02-21 19:20:22] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2025-02-21 19:20:22] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2025-02-21 19:20:22] Further information can be found at the LHC@home message board.
[2025-02-21 19:20:22] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-02-21 19:20:22] Checking for apptainer binary...
[2025-02-21 19:20:22] Using apptainer found in PATH at /usr/bin/apptainer
[2025-02-21 19:20:22] Running /usr/bin/apptainer --version
[2025-02-21 19:20:22] apptainer version 1.3.2-1.el7
[2025-02-21 19:20:22] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-02-21 19:20:23] c-205-34.aglt2.org
[2025-02-21 19:20:23] apptainer works
[2025-02-21 19:20:23] Set ATHENA_PROC_NUMBER=4
[2025-02-21 19:20:23] Set ATHENA_CORE_NUMBER=4
[2025-02-21 19:20:23] Starting ATLAS job with PandaID=6522458010
[2025-02-21 19:20:23] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/0 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2025-02-21 22:48:36]  *** The last 200 lines of the pilot log: ***
[2025-02-21 22:48:36] 2025-02-22 03:48:21,958 | INFO     | mean y: 2403246.5326633165
[2025-02-21 22:48:36] 2025-02-22 03:48:21,959 | INFO     | -- intersect: 5989386945.663549
[2025-02-21 22:48:36] 2025-02-22 03:48:21,959 | INFO     | intersect: 5989386945.663549
[2025-02-21 22:48:36] 2025-02-22 03:48:21,959 | INFO     | chi2: 1.826918442229814
[2025-02-21 22:48:36] 2025-02-22 03:48:21,959 | INFO     | current chi2=1.826918442229814 (change=57.40181389966824 %)
[2025-02-21 22:48:36] 2025-02-22 03:48:21,959 | INFO     | model: linear, x: [1740184262.0, 1740184323.0, 1740184384.0, 1740184445.0, 1740184506.0, 1740184567.0, 1740184628.0, 1740184689.0, 1740184750.0, 1740184811.0, 1740
[2025-02-21 22:48:36] 2025-02-22 03:48:21,959 | INFO     | sum of square deviations: 2263977332.5
[2025-02-21 22:48:36] 2025-02-22 03:48:21,960 | INFO     | sum of deviations: -42952582852.49999
[2025-02-21 22:48:36] 2025-02-22 03:48:21,960 | INFO     | mean x: 1740190148.5
[2025-02-21 22:48:36] 2025-02-22 03:48:21,960 | INFO     | mean y: 2432582.0463917525
[2025-02-21 22:48:36] 2025-02-22 03:48:21,960 | INFO     | -- intersect: 33017631303.145123
[2025-02-21 22:48:36] 2025-02-22 03:48:21,960 | INFO     | intersect: 33017631303.145123
[2025-02-21 22:48:36] 2025-02-22 03:48:21,960 | INFO     | chi2: 0.5177826798227624
[2025-02-21 22:48:36] 2025-02-22 03:48:21,960 | INFO     | current chi2=0.5177826798227624 (change=71.65813930966773 %)
[2025-02-21 22:48:36] 2025-02-22 03:48:21,961 | INFO     | model: linear, x: [1740184567.0, 1740184628.0, 1740184689.0, 1740184750.0, 1740184811.0, 1740184872.0, 1740184933.0, 1740184994.0, 1740185055.0, 1740185116.0, 1740
[2025-02-21 22:48:36] 2025-02-22 03:48:21,961 | INFO     | sum of square deviations: 2093397390.0
[2025-02-21 22:48:36] 2025-02-22 03:48:21,961 | INFO     | sum of deviations: -51066795135.99999
[2025-02-21 22:48:36] 2025-02-22 03:48:21,961 | INFO     | mean x: 1740190301.0
[2025-02-21 22:48:36] 2025-02-22 03:48:21,962 | INFO     | mean y: 2439664.2645502645
[2025-02-21 22:48:36] 2025-02-22 03:48:21,962 | INFO     | -- intersect: 42453023592.25022
[2025-02-21 22:48:36] 2025-02-22 03:48:21,962 | INFO     | intersect: 42453023592.25022
[2025-02-21 22:48:36] 2025-02-22 03:48:21,962 | INFO     | chi2: 0.20768960883778328
[2025-02-21 22:48:36] 2025-02-22 03:48:21,962 | INFO     | current chi2=0.20768960883778328 (change=59.888652724174605 %)
[2025-02-21 22:48:36] 2025-02-22 03:48:21,962 | INFO     | model: linear, x: [1740184872.0, 1740184933.0, 1740184994.0, 1740185055.0, 1740185116.0, 1740185177.0, 1740185238.0, 1740185299.0, 1740185360.0, 1740185421.0, 1740
[2025-02-21 22:48:36] 2025-02-22 03:48:21,962 | INFO     | sum of square deviations: 1931608310.0
[2025-02-21 22:48:36] 2025-02-22 03:48:21,963 | INFO     | sum of deviations: -46220108944.00001
[2025-02-21 22:48:36] 2025-02-22 03:48:21,963 | INFO     | mean x: 1740190453.5
[2025-02-21 22:48:36] 2025-02-22 03:48:21,963 | INFO     | mean y: 2435092.152173913
[2025-02-21 22:48:36] 2025-02-22 03:48:21,963 | INFO     | -- intersect: 41642239563.73202
[2025-02-21 22:48:36] 2025-02-22 03:48:21,963 | INFO     | intersect: 41642239563.73202
[2025-02-21 22:48:36] 2025-02-22 03:48:21,963 | INFO     | chi2: 0.20678592886506317
[2025-02-21 22:48:36] 2025-02-22 03:48:21,963 | INFO     | current chi2=0.20678592886506317 (change=0.43511082609141977 %)
[2025-02-21 22:48:36] 2025-02-22 03:48:21,963 | INFO     | left removable region: 40
[2025-02-21 22:48:36] 2025-02-22 03:48:21,964 | INFO     | model: linear, x: [1740186092.0, 1740186153.0, 1740186214.0, 1740186275.0, 1740186336.0, 1740186397.0, 1740186458.0, 1740186519.0, 1740186580.0, 1740186641.0, 1740
[2025-02-21 22:48:36] 2025-02-22 03:48:21,964 | INFO     | sum of square deviations: 1223016419.5
[2025-02-21 22:48:36] 2025-02-22 03:48:21,964 | INFO     | sum of deviations: -21493803840.0
[2025-02-21 22:48:36] 2025-02-22 03:48:21,964 | INFO     | mean x: 1740190880.5
[2025-02-21 22:48:36] 2025-02-22 03:48:21,964 | INFO     | mean y: 2409924.139240506
[2025-02-21 22:48:36] 2025-02-22 03:48:21,964 | INFO     | -- intersect: 30585254792.98843
[2025-02-21 22:48:36] 2025-02-22 03:48:21,964 | INFO     | intersect: 30585254792.98843
[2025-02-21 22:48:36] 2025-02-22 03:48:21,965 | INFO     | chi2: 0.1599253057533183
[2025-02-21 22:48:36] 2025-02-22 03:48:21,965 | INFO     | -- intersect: 30585254792.98843
[2025-02-21 22:48:36] 2025-02-22 03:48:21,965 | INFO     | current memory leak: -17.57 B/s (using 158 data points, chi2=0.16)
[2025-02-21 22:48:36] 2025-02-22 03:48:21,965 | INFO     | ..............................
[2025-02-21 22:48:36] 2025-02-22 03:48:21,965 | INFO     | . Timing measurements:
[2025-02-21 22:48:36] 2025-02-22 03:48:21,966 | INFO     | . get job = 0 s
[2025-02-21 22:48:36] 2025-02-22 03:48:21,966 | INFO     | . initial setup = 2 s
[2025-02-21 22:48:36] 2025-02-22 03:48:21,966 | INFO     | . payload setup = 4 s
[2025-02-21 22:48:36] 2025-02-22 03:48:21,966 | INFO     | . stage-in = 0 s
[2025-02-21 22:48:36] 2025-02-22 03:48:21,966 | INFO     | . payload execution = 12440 s
[2025-02-21 22:48:36] 2025-02-22 03:48:21,966 | INFO     | . stage-out = 1 s
[2025-02-21 22:48:36] 2025-02-22 03:48:21,966 | INFO     | . log creation = 0 s
[2025-02-21 22:48:36] 2025-02-22 03:48:21,966 | INFO     | ..............................
[2025-02-21 22:48:36] 2025-02-22 03:48:22,010 | INFO     | 
[2025-02-21 22:48:36] 2025-02-22 03:48:22,010 | INFO     | job summary report
[2025-02-21 22:48:36] 2025-02-22 03:48:22,010 | INFO     | --------------------------------------------------
[2025-02-21 22:48:36] 2025-02-22 03:48:22,010 | INFO     | PanDA job id: 6522458010
[2025-02-21 22:48:36] 2025-02-22 03:48:22,011 | WARNING  | process 6646 can no longer be monitored (due to stat problems) - aborting
[2025-02-21 22:48:36] 2025-02-22 03:48:22,011 | INFO     | task id: 43078919
[2025-02-21 22:48:36] 2025-02-22 03:48:22,012 | INFO     | errors: (none)
[2025-02-21 22:48:36] 2025-02-22 03:48:22,012 | INFO     | using path: /tmp/boinchome/slots/0/PanDA_Pilot-6522458010/memory_monitor_summary.json (trf name=prmon)
[2025-02-21 22:48:36] 2025-02-22 03:48:22,012 | INFO     | status: LOG_TRANSFER = DONE 
[2025-02-21 22:48:36] 2025-02-22 03:48:22,012 | INFO     | pilot state: finished 
[2025-02-21 22:48:36] 2025-02-22 03:48:22,012 | INFO     | transexitcode: 0
[2025-02-21 22:48:36] 2025-02-22 03:48:22,012 | INFO     | exeerrorcode: 0
[2025-02-21 22:48:36] 2025-02-22 03:48:22,012 | INFO     | exeerrordiag: 
[2025-02-21 22:48:36] 2025-02-22 03:48:22,012 | INFO     | using path: /tmp/boinchome/slots/0/PanDA_Pilot-6522458010/memory_monitor_summary.json (trf name=prmon)
[2025-02-21 22:48:36] 2025-02-22 03:48:22,012 | INFO     | exitcode: 0
[2025-02-21 22:48:36] 2025-02-22 03:48:22,012 | INFO     | exitmsg: OK
[2025-02-21 22:48:36] 2025-02-22 03:48:22,012 | INFO     | cpuconsumptiontime: 46400 s
[2025-02-21 22:48:36] 2025-02-22 03:48:22,013 | INFO     | nevents: 400
[2025-02-21 22:48:36] 2025-02-22 03:48:22,013 | INFO     | neventsw: 0
[2025-02-21 22:48:36] 2025-02-22 03:48:22,013 | INFO     | pid: 6646
[2025-02-21 22:48:36] 2025-02-22 03:48:22,013 | INFO     | pgrp: 6646
[2025-02-21 22:48:36] 2025-02-22 03:48:22,013 | INFO     | corecount: 4
[2025-02-21 22:48:36] 2025-02-22 03:48:22,013 | INFO     | event service: False
[2025-02-21 22:48:36] 2025-02-22 03:48:22,013 | INFO     | sizes: {0: 2383361, 3: 2383567, 10: 2383595, 12448: 2413281, 12450: 2422222, 12452: 2422278, 12457: 2422576}
[2025-02-21 22:48:36] 2025-02-22 03:48:22,013 | INFO     | payload log (log.EVNTtoHITS) within allowed size limit (2147483648 B): 2485344 B
[2025-02-21 22:48:36] 2025-02-22 03:48:22,013 | INFO     | --------------------------------------------------
[2025-02-21 22:48:36] 2025-02-22 03:48:22,014 | INFO     | 
[2025-02-21 22:48:36] 2025-02-22 03:48:22,014 | INFO     | payload log (payload.stdout) within allowed size limit (2147483648 B): 17476 B
[2025-02-21 22:48:36] 2025-02-22 03:48:22,014 | INFO     | executing command: ls -lF /tmp/boinchome/slots/0
[2025-02-21 22:48:36] 2025-02-22 03:48:22,014 | INFO     | executing command: df -mP /tmp/boinchome/slots/0
[2025-02-21 22:48:36] 2025-02-22 03:48:22,024 | INFO     | queue jobs had 0 job(s) [purged]
[2025-02-21 22:48:36] 2025-02-22 03:48:22,024 | INFO     | queue payloads had 0 job(s) [purged]
[2025-02-21 22:48:36] 2025-02-22 03:48:22,024 | INFO     | queue data_in had 0 job(s) [purged]
[2025-02-21 22:48:36] 2025-02-22 03:48:22,024 | INFO     | queue data_out had 0 job(s) [purged]
[2025-02-21 22:48:36] 2025-02-22 03:48:22,024 | INFO     | queue current_data_in had 0 job(s) [purged]
[2025-02-21 22:48:36] 2025-02-22 03:48:22,024 | INFO     | queue validated_jobs had 0 job(s) [purged]
[2025-02-21 22:48:36] 2025-02-22 03:48:22,024 | INFO     | queue validated_payloads had 0 job(s) [purged]
[2025-02-21 22:48:36] 2025-02-22 03:48:22,024 | INFO     | queue monitored_payloads had 0 job(s) [purged]
[2025-02-21 22:48:36] 2025-02-22 03:48:22,024 | INFO     | sufficient remaining disk space (29038215168 B)
[2025-02-21 22:48:36] 2025-02-22 03:48:22,025 | INFO     | queue finished_jobs had 0 job(s) [purged]
[2025-02-21 22:48:36] 2025-02-22 03:48:22,025 | INFO     | work directory size check will use 2537553920 B as a max limit (10% grace limit added)
[2025-02-21 22:48:36] 2025-02-22 03:48:22,025 | INFO     | queue finished_payloads had 0 job(s) [purged]
[2025-02-21 22:48:36] 2025-02-22 03:48:22,025 | INFO     | queue finished_data_in had 1 job(s) [purged]
[2025-02-21 22:48:36] 2025-02-22 03:48:22,025 | INFO     | queue finished_data_out had 0 job(s) [purged]
[2025-02-21 22:48:36] 2025-02-22 03:48:22,025 | INFO     | queue failed_jobs had 0 job(s) [purged]
[2025-02-21 22:48:36] 2025-02-22 03:48:22,025 | INFO     | queue failed_payloads had 0 job(s) [purged]
[2025-02-21 22:48:36] 2025-02-22 03:48:22,025 | INFO     | queue failed_data_in had 0 job(s) [purged]
[2025-02-21 22:48:36] 2025-02-22 03:48:22,025 | INFO     | queue failed_data_out had 0 job(s) [purged]
[2025-02-21 22:48:36] 2025-02-22 03:48:22,025 | INFO     | queue completed_jobs had 0 job(s) [purged]
[2025-02-21 22:48:36] 2025-02-22 03:48:22,025 | INFO     | queue completed_jobids has 1 job(s)
[2025-02-21 22:48:36] 2025-02-22 03:48:22,026 | INFO     | queue realtimelog_payloads had 0 job(s) [purged]
[2025-02-21 22:48:36] 2025-02-22 03:48:22,026 | INFO     | queue messages had 0 job(s) [purged]
[2025-02-21 22:48:36] 2025-02-22 03:48:22,026 | INFO     | job 6522458010 has completed (purged errors)
[2025-02-21 22:48:36] 2025-02-22 03:48:22,026 | INFO     | overall cleanup function is called
[2025-02-21 22:48:36] 2025-02-22 03:48:22,026 | INFO     | size of work directory /tmp/boinchome/slots/0/PanDA_Pilot-6522458010: 2836968 B (within 2537553920 B limit)
[2025-02-21 22:48:36] 2025-02-22 03:48:22,026 | INFO     | pfn file=/tmp/boinchome/slots/0/PanDA_Pilot-6522458010/HITS.43078919._084907.pool.root.1 does not exist (skip from workdir size calculation)
[2025-02-21 22:48:36] 2025-02-22 03:48:22,027 | INFO     | total size of present files: 0 B (workdir size: 2836968 B)
[2025-02-21 22:48:36] 2025-02-22 03:48:22,027 | INFO     | output file size check: skipping output file /tmp/boinchome/slots/0/PanDA_Pilot-6522458010/HITS.43078919._084907.pool.root.1 since it does not exist
[2025-02-21 22:48:36] 2025-02-22 03:48:22,055 | INFO     | number of running child processes to parent process 6646: 1
[2025-02-21 22:48:36] 2025-02-22 03:48:22,055 | INFO     | maximum number of monitored processes: 6
[2025-02-21 22:48:36] 2025-02-22 03:48:22,055 | INFO     | aborting job monitoring since job object (job id=6522458010) has expired
[2025-02-21 22:48:36] 2025-02-22 03:48:23,034 | INFO     | --- collectZombieJob: --- 10, [6646]
[2025-02-21 22:48:36] 2025-02-22 03:48:23,034 | INFO     | zombie collector waiting for pid 6646
[2025-02-21 22:48:36] 2025-02-22 03:48:23,060 | INFO     | harmless exception when collecting zombies: [Errno 10] No child processes
[2025-02-21 22:48:36] 2025-02-22 03:48:23,061 | INFO     | collected zombie processes
[2025-02-21 22:48:36] 2025-02-22 03:48:23,061 | INFO     | will attempt to kill all subprocesses of pid=6646
[2025-02-21 22:48:36] 2025-02-22 03:48:23,099 | INFO     | process IDs to be killed: [6646] (in reverse order)
[2025-02-21 22:48:36] 2025-02-22 03:48:23,120 | WARNING  | found no corresponding commands to process id(s)
[2025-02-21 22:48:36] 2025-02-22 03:48:23,121 | INFO     | Do not look for orphan processes in BOINC jobs
[2025-02-21 22:48:36] 2025-02-22 03:48:23,121 | INFO     | did not find any defunct processes belonging to 6646
[2025-02-21 22:48:36] 2025-02-22 03:48:23,122 | INFO     | did not find any defunct processes belonging to 6646
[2025-02-21 22:48:36] 2025-02-22 03:48:23,122 | INFO     | ready for new job
[2025-02-21 22:48:36] 2025-02-22 03:48:23,122 | INFO     | pilot has finished with previous job - re-establishing logging
[2025-02-21 22:48:36] 2025-02-22 03:48:23,123 | INFO     | **************************************
[2025-02-21 22:48:36] 2025-02-22 03:48:23,123 | INFO     | ***  PanDA Pilot version 3.9.4.15  ***
[2025-02-21 22:48:36] 2025-02-22 03:48:23,123 | INFO     | **************************************
[2025-02-21 22:48:36] 2025-02-22 03:48:23,123 | INFO     | 
[2025-02-21 22:48:36] 2025-02-22 03:48:23,124 | INFO     | architecture information:
[2025-02-21 22:48:36] 2025-02-22 03:48:23,124 | INFO     | executing command: cat /etc/os-release
[2025-02-21 22:48:36] 2025-02-22 03:48:23,131 | INFO     | cat /etc/os-release:
[2025-02-21 22:48:36] NAME="CentOS Linux"
[2025-02-21 22:48:36] VERSION="7 (Core)"
[2025-02-21 22:48:36] ID="centos"
[2025-02-21 22:48:36] ID_LIKE="rhel fedora"
[2025-02-21 22:48:36] VERSION_ID="7"
[2025-02-21 22:48:36] PRETTY_NAME="CentOS Linux 7 (Core)"
[2025-02-21 22:48:36] ANSI_COLOR="0;31"
[2025-02-21 22:48:36] CPE_NAME="cpe:/o:centos:centos:7"
[2025-02-21 22:48:36] HOME_URL="https://www.centos.org/"
[2025-02-21 22:48:36] BUG_REPORT_URL="https://bugs.centos.org/"
[2025-02-21 22:48:36] 
[2025-02-21 22:48:36] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2025-02-21 22:48:36] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2025-02-21 22:48:36] REDHAT_SUPPORT_PRODUCT="centos"
[2025-02-21 22:48:36] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2025-02-21 22:48:36] 
[2025-02-21 22:48:36] 2025-02-22 03:48:23,132 | INFO     | **************************************
[2025-02-21 22:48:36] 2025-02-22 03:48:23,305 | INFO     | PID=32620 has CPU usage=4.0% 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 
[2025-02-21 22:48:36] 2025-02-22 03:48:23,635 | INFO     | executing command: df -mP /tmp/boinchome/slots/0
[2025-02-21 22:48:36] 2025-02-22 03:48:23,650 | INFO     | sufficient remaining disk space (29042409472 B)
[2025-02-21 22:48:36] 2025-02-22 03:48:23,650 | WARNING  | since timefloor is set to 0, pilot was only allowed to run one job
[2025-02-21 22:48:36] 2025-02-22 03:48:23,651 | WARNING  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2025-02-21 22:48:36] 2025-02-22 03:48:23,651 | WARNING  | job:job_monitor:received graceful stop - abort after this iteration
[2025-02-21 22:48:36] 2025-02-22 03:48:23,651 | INFO     | aborting loop
[2025-02-21 22:48:36] 2025-02-22 03:48:23,651 | WARNING  | job:queue_monitor:received graceful stop - abort after this iteration
[2025-02-21 22:48:36] 2025-02-22 03:48:23,652 | WARNING  | data:copytool_out:received graceful stop - abort after this iteration
[2025-02-21 22:48:36] 2025-02-22 03:48:23,652 | WARNING  | aborting monitor loop since graceful_stop has been set (timing out remaining threads)
[2025-02-21 22:48:36] 2025-02-22 03:48:23,653 | INFO     | found 0 job(s) in 20 queues
[2025-02-21 22:48:36] 2025-02-22 03:48:23,653 | WARNING  | pilot monitor received instruction that args.graceful_stop has been set
[2025-02-21 22:48:36] 2025-02-22 03:48:23,653 | WARNING  | will wait for a maximum of 300 s for threads to finish
[2025-02-21 22:48:36] 2025-02-22 03:48:23,793 | INFO     | all payload control threads have been joined
[2025-02-21 22:48:36] 2025-02-22 03:48:23,844 | INFO     | all job control threads have been joined
[2025-02-21 22:48:36] 2025-02-22 03:48:23,885 | INFO     | all data control threads have been joined
[2025-02-21 22:48:36] 2025-02-22 03:48:24,656 | INFO     | [job] retrieve thread has finished
[2025-02-21 22:48:36] 2025-02-22 03:48:24,657 | INFO     | [job] job monitor thread has finished
[2025-02-21 22:48:36] 2025-02-22 03:48:24,657 | INFO     | [job] queue monitor thread has finished
[2025-02-21 22:48:36] 2025-02-22 03:48:24,798 | INFO     | [payload] control thread has finished
[2025-02-21 22:48:36] 2025-02-22 03:48:24,802 | INFO     | [payload] validate_post thread has finished
[2025-02-21 22:48:36] 2025-02-22 03:48:24,849 | INFO     | [job] control thread has finished
[2025-02-21 22:48:36] 2025-02-22 03:48:24,890 | INFO     | [data] control thread has finished
[2025-02-21 22:48:36] 2025-02-22 03:48:24,925 | INFO     | [payload] run_realtimelog thread has finished
[2025-02-21 22:48:36] 2025-02-22 03:48:25,350 | INFO     | [payload] execute_payloads thread has finished
[2025-02-21 22:48:36] 2025-02-22 03:48:25,530 | INFO     | [payload] failed_post thread has finished
[2025-02-21 22:48:36] 2025-02-22 03:48:25,563 | INFO     | [job] create_data_payload thread has finished
[2025-02-21 22:48:36] 2025-02-22 03:48:25,565 | INFO     | [data] copytool_in thread has finished
[2025-02-21 22:48:36] 2025-02-22 03:48:25,589 | INFO     | [job] validate thread has finished
[2025-02-21 22:48:36] 2025-02-22 03:48:25,657 | INFO     | [data] copytool_out thread has finished
[2025-02-21 22:48:36] 2025-02-22 03:48:25,708 | INFO     | [payload] validate_pre thread has finished
[2025-02-21 22:48:36] 2025-02-22 03:48:26,901 | WARNING  | data:queue_monitoring:received graceful stop - abort after this iteration
[2025-02-21 22:48:36] 2025-02-22 03:48:30,906 | INFO     | [data] queue_monitor thread has finished
[2025-02-21 22:48:36] 2025-02-22 03:48:31,716 | INFO     | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 139847390529344)>', '<ExcThread(monitor, started 139846634936064)>']
[2025-02-21 22:48:36] 2025-02-22 03:48:32,694 | WARNING  | job_aborted has been set - aborting pilot monitoring
[2025-02-21 22:48:36] 2025-02-22 03:48:32,695 | INFO     | [monitor] control thread has ended
[2025-02-21 22:48:36] 2025-02-22 03:48:36,736 | INFO     | all workflow threads have been joined
[2025-02-21 22:48:36] 2025-02-22 03:48:36,736 | INFO     | end of generic workflow (traces error code: 0)
[2025-02-21 22:48:36] 2025-02-22 03:48:36,736 | INFO     | traces error code: 0
[2025-02-21 22:48:36] 2025-02-22 03:48:36,736 | INFO     | pilot has finished (exit code=0, shell exit code=0)
[2025-02-21 22:48:36] 2025-02-22 03:48:36,796 [wrapper] ==== pilot stdout END ====
[2025-02-21 22:48:36] 2025-02-22 03:48:36,797 [wrapper] ==== wrapper stdout RESUME ====
[2025-02-21 22:48:36] 2025-02-22 03:48:36,799 [wrapper] pilotpid: 32620
[2025-02-21 22:48:36] 2025-02-22 03:48:36,801 [wrapper] Pilot exit status: 0
[2025-02-21 22:48:36] 2025-02-22 03:48:36,808 [wrapper] pandaids: 6522458010
[2025-02-21 22:48:36] 2025-02-22 03:48:36,822 [wrapper] cleanup supervisor_pilot  2690 32621
[2025-02-21 22:48:36] 2025-02-22 03:48:36,824 [wrapper] Test setup, not cleaning
[2025-02-21 22:48:36] 2025-02-22 03:48:36,828 [wrapper] apfmon messages muted
[2025-02-21 22:48:36] 2025-02-22 03:48:36,830 [wrapper] ==== wrapper stdout END ====
[2025-02-21 22:48:36] 2025-02-22 03:48:36,832 [wrapper] ==== wrapper stderr END ====
[2025-02-21 22:48:36]  *** Error codes and diagnostics ***
[2025-02-21 22:48:36]     "exeErrorCode": 0,
[2025-02-21 22:48:36]     "exeErrorDiag": "",
[2025-02-21 22:48:36]     "pilotErrorCode": 0,
[2025-02-21 22:48:36]     "pilotErrorDiag": "",
[2025-02-21 22:48:36]  *** Listing of results directory ***
[2025-02-21 22:48:36] total 656436
[2025-02-21 22:48:36] -rw-r--r-- 1 boincer umatlas      5118 Feb 21 14:15 queuedata.json
[2025-02-21 22:48:36] -rw-r--r-- 1 boincer umatlas    491065 Feb 21 14:15 pilot3.tar.gz
[2025-02-21 22:48:36] -rwx------ 1 boincer umatlas     35865 Feb 21 14:18 runpilot2-wrapper.sh
[2025-02-21 22:48:36] -rw-r--r-- 1 boincer umatlas       100 Feb 21 19:20 wrapper_26015_x86_64-pc-linux-gnu
[2025-02-21 22:48:36] -rwxr-xr-x 1 boincer umatlas      7986 Feb 21 19:20 run_atlas
[2025-02-21 22:48:36] -rw-r--r-- 1 boincer umatlas       105 Feb 21 19:20 job.xml
[2025-02-21 22:48:36] -rw-r--r-- 2 boincer umatlas     17569 Feb 21 19:20 start_atlas.sh
[2025-02-21 22:48:36] drwxrwx--x 2 boincer umatlas      4096 Feb 21 19:20 shared
[2025-02-21 22:48:36] -rw-r--r-- 2 boincer umatlas    503558 Feb 21 19:20 input.tar.gz
[2025-02-21 22:48:36] -rw-r--r-- 2 boincer umatlas 340864254 Feb 21 19:20 EVNT.43078917._002486.pool.root.1
[2025-02-21 22:48:36] -rw-r--r-- 1 boincer umatlas         0 Feb 21 19:20 boinc_lockfile
[2025-02-21 22:48:36] -rw-r--r-- 1 boincer umatlas      2546 Feb 21 19:20 pandaJob.out
[2025-02-21 22:48:36] -rw------- 1 boincer umatlas       424 Feb 21 19:20 setup.sh.local
[2025-02-21 22:48:36] -rw------- 1 boincer umatlas    987681 Feb 21 19:20 agis_schedconf.cvmfs.json
[2025-02-21 22:48:36] drwx------ 4 boincer umatlas      4096 Feb 21 19:20 pilot3
[2025-02-21 22:48:36] -rw-r--r-- 1 boincer umatlas      6154 Feb 21 22:45 init_data.xml
[2025-02-21 22:48:36] -rw------- 1 boincer umatlas 324447271 Feb 21 22:47 HITS.43078919._084907.pool.root.1
[2025-02-21 22:48:36] -rw------- 1 boincer umatlas        95 Feb 21 22:47 pilot_heartbeat.json
[2025-02-21 22:48:36] -rw-r--r-- 1 boincer umatlas       531 Feb 21 22:47 boinc_task_state.xml
[2025-02-21 22:48:36] -rw------- 1 boincer umatlas      1039 Feb 21 22:48 memory_monitor_summary.json
[2025-02-21 22:48:36] -rw------- 1 boincer umatlas   1582569 Feb 21 22:48 agis_ddmendpoints.agis.ALL.json
[2025-02-21 22:48:36] -rw------- 1 boincer umatlas    325182 Feb 21 22:48 log.43078919._084907.job.log.tgz.1
[2025-02-21 22:48:36] -rw------- 1 boincer umatlas      7746 Feb 21 22:48 heartbeat.json
[2025-02-21 22:48:36] -rw-r--r-- 1 boincer umatlas      8192 Feb 21 22:48 boinc_mmap_file
[2025-02-21 22:48:36] -rw-r--r-- 1 boincer umatlas        28 Feb 21 22:48 wrapper_checkpoint.txt
[2025-02-21 22:48:36] -rw------- 1 boincer umatlas      4655 Feb 21 22:48 pilotlog.txt
[2025-02-21 22:48:36] -rw------- 1 boincer umatlas   1212761 Feb 21 22:48 log.43078919._084907.job.log.1
[2025-02-21 22:48:36] -rw------- 1 boincer umatlas       357 Feb 21 22:48 output.list
[2025-02-21 22:48:36] -rw-r--r-- 1 boincer umatlas       620 Feb 21 22:48 runtime_log
[2025-02-21 22:48:36] -rw------- 1 boincer umatlas   1556480 Feb 21 22:48 result.tar.gz
[2025-02-21 22:48:36] -rw-r--r-- 1 boincer umatlas     11014 Feb 21 22:48 runtime_log.err
[2025-02-21 22:48:36] -rw------- 1 boincer umatlas       661 Feb 21 22:48 DcUMDmXin56nsSi4ap6QjLDmwznN0nGgGQJmkKkKDm7rsKDmk8hwdm.diag
[2025-02-21 22:48:36] -rw-r--r-- 1 boincer umatlas     22154 Feb 21 22:48 stderr.txt
[2025-02-21 22:48:36] HITS file was successfully produced:
[2025-02-21 22:48:36] -rw------- 1 boincer umatlas 324447271 Feb 21 22:47 shared/HITS.pool.root.1
[2025-02-21 22:48:36]  *** Contents of shared directory: ***
[2025-02-21 22:48:36] total 651756
[2025-02-21 22:48:36] -rw-r--r-- 2 boincer umatlas     17569 Feb 21 19:20 start_atlas.sh
[2025-02-21 22:48:36] -rw-r--r-- 2 boincer umatlas    503558 Feb 21 19:20 input.tar.gz
[2025-02-21 22:48:36] -rw-r--r-- 2 boincer umatlas 340864254 Feb 21 19:20 ATLAS.root_0
[2025-02-21 22:48:36] -rw------- 1 boincer umatlas 324447271 Feb 21 22:47 HITS.pool.root.1
[2025-02-21 22:48:36] -rw------- 1 boincer umatlas   1556480 Feb 21 22:48 result.tar.gz
22:48:37 (29043): run_atlas exited; CPU time 46370.844293
22:48:37 (29043): called boinc_finish(0)

</stderr_txt>
]]>

©2025 CERN