Stderr output

<core_client_version>8.0.4</core_client_version>
<![CDATA[
<stderr_txt>
07:48:28 (35096): wrapper (7.7.26015): starting
07:48:28 (35096): wrapper: running run_atlas (--nthreads 12)
[2025-07-28 07:48:28] Arguments: --nthreads 12
[2025-07-28 07:48:28] Threads: 12
[2025-07-28 07:48:28] Checking for CVMFS
[2025-07-28 07:48:28] Probing /cvmfs/atlas.cern.ch... OK
[2025-07-28 07:48:29] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-07-28 07:48:29] Running cvmfs_config stat atlas.cern.ch
[2025-07-28 07:48:29] VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
[2025-07-28 07:48:29] 2.13.0.0 30494 4921 52364 148840 2 188 2218245 4096000 2733 130560 0 11308415 99.997 173907 259 http://s1ral-cvmfs.openhtc.io/cvmfs/atlas.cern.ch http://192.168.85.111:3128 1
[2025-07-28 07:48:29] CVMFS is ok
[2025-07-28 07:48:29] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-07-28 07:48:29] Checking for apptainer binary...
[2025-07-28 07:48:29] Using apptainer found in PATH at /usr/bin/apptainer
[2025-07-28 07:48:29] Running /usr/bin/apptainer --version
[2025-07-28 07:48:29] apptainer version 1.4.1
[2025-07-28 07:48:29] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-07-28 07:48:30] dualxeon1
[2025-07-28 07:48:30] apptainer works
[2025-07-28 07:48:30] Set ATHENA_PROC_NUMBER=12
[2025-07-28 07:48:30] Set ATHENA_CORE_NUMBER=12
[2025-07-28 07:48:30] Starting ATLAS job with PandaID=6745350959
[2025-07-28 07:48:30] Running command: /usr/bin/apptainer exec -B /cvmfs,/opt/boinc/instance_homes/boinc_31417/slots/2 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2025-07-28 09:37:06]  *** The last 200 lines of the pilot log: ***
[2025-07-28 09:37:06] 2025-07-28 09:36:32,941 | WARNING  | format EVNTtoHITS has no such key: dbData
[2025-07-28 09:37:06] 2025-07-28 09:36:32,941 | WARNING  | format EVNTtoHITS has no such key: dbTime
[2025-07-28 09:37:06] 2025-07-28 09:36:32,947 | INFO     | fitting pss+swap vs Time
[2025-07-28 09:37:06] 2025-07-28 09:36:32,948 | INFO     | sum of square deviations: 369281342.5
[2025-07-28 09:37:06] 2025-07-28 09:36:32,948 | INFO     | sum of deviations: 10117215328.999996
[2025-07-28 09:37:06] 2025-07-28 09:36:32,948 | INFO     | mean x: 1753692152.5
[2025-07-28 09:37:06] 2025-07-28 09:36:32,948 | INFO     | mean y: 2610376.716981132
[2025-07-28 09:37:06] 2025-07-28 09:36:32,949 | INFO     | -- intersect: -48043361855.47073
[2025-07-28 09:37:06] 2025-07-28 09:36:32,949 | INFO     | intersect: -48043361855.47073
[2025-07-28 09:37:06] 2025-07-28 09:36:32,949 | INFO     | chi2: 2.438766417545308
[2025-07-28 09:37:06] 2025-07-28 09:36:32,949 | INFO     | sum of square deviations: 319447850.0
[2025-07-28 09:37:06] 2025-07-28 09:36:32,950 | INFO     | sum of deviations: 16520472925.000002
[2025-07-28 09:37:06] 2025-07-28 09:36:32,950 | INFO     | mean x: 1753692000.0
[2025-07-28 09:37:06] 2025-07-28 09:36:32,950 | INFO     | mean y: 2629136.663366337
[2025-07-28 09:37:06] 2025-07-28 09:36:32,950 | INFO     | -- intersect: -90690800807.50156
[2025-07-28 09:37:06] 2025-07-28 09:36:32,950 | INFO     | intersect: -90690800807.50156
[2025-07-28 09:37:06] 2025-07-28 09:36:32,955 | INFO     | chi2: 1.7431681109515782
[2025-07-28 09:37:06] 2025-07-28 09:36:32,955 | INFO     | current chi2=1.7431681109515782 (change=28.522547366134 %)
[2025-07-28 09:37:06] 2025-07-28 09:36:32,955 | INFO     | sum of square deviations: 274312120.0
[2025-07-28 09:37:06] 2025-07-28 09:36:32,956 | INFO     | sum of deviations: 15640571166.00001
[2025-07-28 09:37:06] 2025-07-28 09:36:32,956 | INFO     | mean x: 1753691847.5
[2025-07-28 09:37:06] 2025-07-28 09:36:32,956 | INFO     | mean y: 2626161.4166666665
[2025-07-28 09:37:06] 2025-07-28 09:36:32,956 | INFO     | -- intersect: -99988370022.26558
[2025-07-28 09:37:06] 2025-07-28 09:36:32,956 | INFO     | intersect: -99988370022.26558
[2025-07-28 09:37:06] 2025-07-28 09:36:32,956 | INFO     | chi2: 1.747044143711401
[2025-07-28 09:37:06] 2025-07-28 09:36:32,957 | INFO     | current chi2=1.747044143711401 (change=-0.22235564863029517 %)
[2025-07-28 09:37:06] 2025-07-28 09:36:32,957 | INFO     | right removable region: 95
[2025-07-28 09:37:06] 2025-07-28 09:36:32,957 | INFO     | sum of square deviations: 319447850.0
[2025-07-28 09:37:06] 2025-07-28 09:36:32,962 | INFO     | sum of deviations: -9537954815.0
[2025-07-28 09:37:06] 2025-07-28 09:36:32,962 | INFO     | mean x: 1753692305.0
[2025-07-28 09:37:06] 2025-07-28 09:36:32,962 | INFO     | mean y: 2669573.7227722774
[2025-07-28 09:37:06] 2025-07-28 09:36:32,962 | INFO     | -- intersect: 52363760639.144554
[2025-07-28 09:37:06] 2025-07-28 09:36:32,962 | INFO     | intersect: 52363760639.144554
[2025-07-28 09:37:06] 2025-07-28 09:36:32,962 | INFO     | chi2: 0.8002917930923777
[2025-07-28 09:37:06] 2025-07-28 09:36:32,963 | INFO     | current chi2=0.8002917930923777 (change=67.18456563388735 %)
[2025-07-28 09:37:06] 2025-07-28 09:36:32,963 | INFO     | sum of square deviations: 274312120.0
[2025-07-28 09:37:06] 2025-07-28 09:36:32,963 | INFO     | sum of deviations: -10706118601.0
[2025-07-28 09:37:06] 2025-07-28 09:36:32,964 | INFO     | mean x: 1753692457.5
[2025-07-28 09:37:06] 2025-07-28 09:36:32,964 | INFO     | mean y: 2673235.5625
[2025-07-28 09:37:06] 2025-07-28 09:36:32,964 | INFO     | -- intersect: 68447477787.66962
[2025-07-28 09:37:06] 2025-07-28 09:36:32,964 | INFO     | intersect: 68447477787.66962
[2025-07-28 09:37:06] 2025-07-28 09:36:32,964 | INFO     | chi2: 0.7565922633516315
[2025-07-28 09:37:06] 2025-07-28 09:36:32,964 | INFO     | current chi2=0.7565922633516315 (change=5.460449565762567 %)
[2025-07-28 09:37:06] 2025-07-28 09:36:32,964 | INFO     | left removable region: 20
[2025-07-28 09:37:06] 2025-07-28 09:36:32,969 | INFO     | sum of square deviations: 130793150.0
[2025-07-28 09:37:06] 2025-07-28 09:36:32,969 | INFO     | sum of deviations: -839803714.0
[2025-07-28 09:37:06] 2025-07-28 09:36:32,969 | INFO     | mean x: 1753692427.0
[2025-07-28 09:37:06] 2025-07-28 09:36:32,969 | INFO     | mean y: 2683363.4133333336
[2025-07-28 09:37:06] 2025-07-28 09:36:32,970 | INFO     | -- intersect: 11262886312.942984
[2025-07-28 09:37:06] 2025-07-28 09:36:32,970 | INFO     | intersect: 11262886312.942984
[2025-07-28 09:37:06] 2025-07-28 09:36:32,970 | INFO     | chi2: 0.010072149091624514
[2025-07-28 09:37:06] 2025-07-28 09:36:32,970 | INFO     | -- intersect: 11262886312.942984
[2025-07-28 09:37:06] 2025-07-28 09:36:32,970 | INFO     | current memory leak: -6.42 B/s (using 75 data points, chi2=0.01)
[2025-07-28 09:37:06] 2025-07-28 09:36:32,971 | INFO     | could have reported an average CPU frequency of 2593 MHz (7 samples)
[2025-07-28 09:37:06] 2025-07-28 09:36:32,971 | INFO     | ..............................
[2025-07-28 09:37:06] 2025-07-28 09:36:32,971 | INFO     | . Timing measurements:
[2025-07-28 09:37:06] 2025-07-28 09:36:32,971 | INFO     | . get job = 0 s
[2025-07-28 09:37:06] 2025-07-28 09:36:32,971 | INFO     | . initial setup = 1 s
[2025-07-28 09:37:06] 2025-07-28 09:36:32,971 | INFO     | . payload setup = 7 s
[2025-07-28 09:37:06] 2025-07-28 09:36:32,971 | INFO     | . stage-in = 0 s
[2025-07-28 09:37:06] 2025-07-28 09:36:32,971 | INFO     | . payload execution = 6431 s
[2025-07-28 09:37:06] 2025-07-28 09:36:32,972 | INFO     | . stage-out = 1 s
[2025-07-28 09:37:06] 2025-07-28 09:36:32,972 | INFO     | . log creation = 0 s
[2025-07-28 09:37:06] 2025-07-28 09:36:32,972 | INFO     | ..............................
[2025-07-28 09:37:06] 2025-07-28 09:36:33,457 | INFO     | PID=38859 has CPU usage=9.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 
[2025-07-28 09:37:06] 2025-07-28 09:36:33,457 | INFO     | .. there are 4 such processes running
[2025-07-28 09:37:06] 2025-07-28 09:36:33,566 | INFO     | 
[2025-07-28 09:37:06] 2025-07-28 09:36:33,566 | INFO     | job summary report
[2025-07-28 09:37:06] 2025-07-28 09:36:33,566 | INFO     | --------------------------------------------------
[2025-07-28 09:37:06] 2025-07-28 09:36:33,566 | INFO     | PanDA job id: 6745350959
[2025-07-28 09:37:06] 2025-07-28 09:36:33,566 | INFO     | task id: 45743349
[2025-07-28 09:37:06] 2025-07-28 09:36:33,566 | INFO     | errors: (none)
[2025-07-28 09:37:06] 2025-07-28 09:36:33,566 | INFO     | status: LOG_TRANSFER = DONE 
[2025-07-28 09:37:06] 2025-07-28 09:36:33,566 | INFO     | pilot state: finished 
[2025-07-28 09:37:06] 2025-07-28 09:36:33,567 | INFO     | transexitcode: 0
[2025-07-28 09:37:06] 2025-07-28 09:36:33,567 | INFO     | exeerrorcode: 0
[2025-07-28 09:37:06] 2025-07-28 09:36:33,567 | INFO     | exeerrordiag: 
[2025-07-28 09:37:06] 2025-07-28 09:36:33,567 | INFO     | exitcode: 0
[2025-07-28 09:37:06] 2025-07-28 09:36:33,567 | INFO     | exitmsg: OK
[2025-07-28 09:37:06] 2025-07-28 09:36:33,567 | INFO     | cpuconsumptiontime: 61129 s
[2025-07-28 09:37:06] 2025-07-28 09:36:33,567 | INFO     | nevents: 400
[2025-07-28 09:37:06] 2025-07-28 09:36:33,567 | INFO     | neventsw: 0
[2025-07-28 09:37:06] 2025-07-28 09:36:33,567 | INFO     | pid: 45563
[2025-07-28 09:37:06] 2025-07-28 09:36:33,567 | INFO     | pgrp: 45563
[2025-07-28 09:37:06] 2025-07-28 09:36:33,568 | INFO     | corecount: 12
[2025-07-28 09:37:06] 2025-07-28 09:36:33,568 | INFO     | event service: False
[2025-07-28 09:37:06] 2025-07-28 09:36:33,568 | INFO     | sizes: {0: 2397271, 1: 2397526, 8: 2397788, 12: 2397816, 6443: 2424779, 6445: 2433823, 6448: 2434007, 6457: 2434201}
[2025-07-28 09:37:06] 2025-07-28 09:36:33,568 | INFO     | --------------------------------------------------
[2025-07-28 09:37:06] 2025-07-28 09:36:33,568 | INFO     | 
[2025-07-28 09:37:06] 2025-07-28 09:36:33,568 | INFO     | executing command: ls -lF /opt/boinc/instance_homes/boinc_31417/slots/2
[2025-07-28 09:37:06] 2025-07-28 09:36:33,604 | INFO     | queue jobs had 0 job(s) [purged]
[2025-07-28 09:37:06] 2025-07-28 09:36:33,604 | INFO     | queue payloads had 0 job(s) [purged]
[2025-07-28 09:37:06] 2025-07-28 09:36:33,604 | INFO     | queue data_in had 0 job(s) [purged]
[2025-07-28 09:37:06] 2025-07-28 09:36:33,604 | INFO     | queue data_out had 0 job(s) [purged]
[2025-07-28 09:37:06] 2025-07-28 09:36:33,605 | INFO     | queue current_data_in had 0 job(s) [purged]
[2025-07-28 09:37:06] 2025-07-28 09:36:33,605 | INFO     | queue validated_jobs had 0 job(s) [purged]
[2025-07-28 09:37:06] 2025-07-28 09:36:33,605 | INFO     | queue validated_payloads had 0 job(s) [purged]
[2025-07-28 09:37:06] 2025-07-28 09:36:33,605 | INFO     | queue monitored_payloads had 0 job(s) [purged]
[2025-07-28 09:37:06] 2025-07-28 09:36:33,605 | INFO     | queue finished_jobs had 0 job(s) [purged]
[2025-07-28 09:37:06] 2025-07-28 09:36:33,605 | INFO     | queue finished_payloads had 0 job(s) [purged]
[2025-07-28 09:37:06] 2025-07-28 09:36:33,605 | INFO     | queue finished_data_in had 1 job(s) [purged]
[2025-07-28 09:37:06] 2025-07-28 09:36:33,605 | INFO     | queue finished_data_out had 0 job(s) [purged]
[2025-07-28 09:37:06] 2025-07-28 09:36:33,606 | INFO     | queue failed_jobs had 0 job(s) [purged]
[2025-07-28 09:37:06] 2025-07-28 09:36:33,606 | INFO     | queue failed_payloads had 0 job(s) [purged]
[2025-07-28 09:37:06] 2025-07-28 09:36:33,606 | INFO     | queue failed_data_in had 0 job(s) [purged]
[2025-07-28 09:37:06] 2025-07-28 09:36:33,606 | INFO     | queue failed_data_out had 0 job(s) [purged]
[2025-07-28 09:37:06] 2025-07-28 09:36:33,606 | INFO     | queue completed_jobs had 0 job(s) [purged]
[2025-07-28 09:37:06] 2025-07-28 09:36:33,606 | INFO     | queue completed_jobids has 1 job(s)
[2025-07-28 09:37:06] 2025-07-28 09:36:33,606 | INFO     | queue realtimelog_payloads had 0 job(s) [purged]
[2025-07-28 09:37:06] 2025-07-28 09:36:33,606 | INFO     | queue messages had 0 job(s) [purged]
[2025-07-28 09:37:06] 2025-07-28 09:36:33,607 | INFO     | job 6745350959 has completed (purged errors)
[2025-07-28 09:37:06] 2025-07-28 09:36:33,607 | INFO     | overall cleanup function is called
[2025-07-28 09:37:06] 2025-07-28 09:36:34,621 | INFO     | --- collectZombieJob: --- 10, [45563]
[2025-07-28 09:37:06] 2025-07-28 09:36:34,621 | INFO     | zombie collector waiting for pid 45563
[2025-07-28 09:37:06] 2025-07-28 09:36:34,621 | INFO     | harmless exception when collecting zombies: [Errno 10] No child processes
[2025-07-28 09:37:06] 2025-07-28 09:36:34,621 | INFO     | collected zombie processes
[2025-07-28 09:37:06] 2025-07-28 09:36:34,621 | INFO     | will attempt to kill all subprocesses of pid=45563
[2025-07-28 09:37:06] 2025-07-28 09:36:34,872 | INFO     | process IDs to be killed: [45563] (in reverse order)
[2025-07-28 09:37:06] 2025-07-28 09:36:34,967 | WARNING  | found no corresponding commands to process id(s)
[2025-07-28 09:37:06] 2025-07-28 09:36:34,967 | INFO     | Do not look for orphan processes in BOINC jobs
[2025-07-28 09:37:06] 2025-07-28 09:36:34,977 | INFO     | did not find any defunct processes belonging to 45563
[2025-07-28 09:37:06] 2025-07-28 09:36:34,984 | INFO     | did not find any defunct processes belonging to 45563
[2025-07-28 09:37:06] 2025-07-28 09:36:34,987 | INFO     | ready for new job
[2025-07-28 09:37:06] 2025-07-28 09:36:34,988 | INFO     | pilot has finished with previous job - re-establishing logging
[2025-07-28 09:37:06] 2025-07-28 09:36:34,989 | INFO     | ***************************************
[2025-07-28 09:37:06] 2025-07-28 09:36:34,990 | INFO     | ***  PanDA Pilot version 3.10.4.12  ***
[2025-07-28 09:37:06] 2025-07-28 09:36:34,990 | INFO     | ***************************************
[2025-07-28 09:37:06] 2025-07-28 09:36:34,990 | INFO     | 
[2025-07-28 09:37:06] 2025-07-28 09:36:34,996 | INFO     | architecture information:
[2025-07-28 09:37:06] 2025-07-28 09:36:34,999 | INFO     | executing command: cat /etc/os-release
[2025-07-28 09:37:06] 2025-07-28 09:36:35,022 | INFO     | cat /etc/os-release:
[2025-07-28 09:37:06] NAME="CentOS Linux"
[2025-07-28 09:37:06] VERSION="7 (Core)"
[2025-07-28 09:37:06] ID="centos"
[2025-07-28 09:37:06] ID_LIKE="rhel fedora"
[2025-07-28 09:37:06] VERSION_ID="7"
[2025-07-28 09:37:06] PRETTY_NAME="CentOS Linux 7 (Core)"
[2025-07-28 09:37:06] ANSI_COLOR="0;31"
[2025-07-28 09:37:06] CPE_NAME="cpe:/o:centos:centos:7"
[2025-07-28 09:37:06] HOME_URL="https://www.centos.org/"
[2025-07-28 09:37:06] BUG_REPORT_URL="https://bugs.centos.org/"
[2025-07-28 09:37:06] 
[2025-07-28 09:37:06] CENTOS_MANTISBT_PROJECT="CentOS-7"
[2025-07-28 09:37:06] CENTOS_MANTISBT_PROJECT_VERSION="7"
[2025-07-28 09:37:06] REDHAT_SUPPORT_PRODUCT="centos"
[2025-07-28 09:37:06] REDHAT_SUPPORT_PRODUCT_VERSION="7"
[2025-07-28 09:37:06] 
[2025-07-28 09:37:06] 2025-07-28 09:36:35,022 | INFO     | ***************************************
[2025-07-28 09:37:06] 2025-07-28 09:36:35,528 | INFO     | executing command: df -mP /opt/boinc/instance_homes/boinc_31417/slots/2
[2025-07-28 09:37:06] 2025-07-28 09:36:35,553 | INFO     | sufficient remaining disk space (12266242048 B)
[2025-07-28 09:37:06] 2025-07-28 09:36:35,553 | WARNING  | since timefloor is set to 0, pilot was only allowed to run one job
[2025-07-28 09:37:06] 2025-07-28 09:36:35,553 | INFO     | current server update state: UPDATING_FINAL
[2025-07-28 09:37:06] 2025-07-28 09:36:35,553 | INFO     | update_server=False
[2025-07-28 09:37:06] 2025-07-28 09:36:35,554 | WARNING  | setting graceful_stop since proceed_with_getjob() returned False (pilot will end)
[2025-07-28 09:37:06] 2025-07-28 09:36:35,554 | WARNING  | data:queue_monitoring:received graceful stop - abort after this iteration
[2025-07-28 09:37:06] 2025-07-28 09:36:35,557 | WARNING  | job:job_monitor:received graceful stop - abort after this iteration
[2025-07-28 09:37:06] 2025-07-28 09:36:35,557 | INFO     | aborting loop
[2025-07-28 09:37:06] 2025-07-28 09:36:35,892 | INFO     | all job control threads have been joined
[2025-07-28 09:37:06] 2025-07-28 09:36:36,039 | INFO     | all payload control threads have been joined
[2025-07-28 09:37:06] 2025-07-28 09:36:36,546 | INFO     | all data control threads have been joined
[2025-07-28 09:37:06] 2025-07-28 09:36:36,561 | INFO     | [job] retrieve thread has finished
[2025-07-28 09:37:06] 2025-07-28 09:36:36,561 | INFO     | [payload] run_realtimelog thread has finished
[2025-07-28 09:37:06] 2025-07-28 09:36:36,562 | INFO     | [job] job monitor thread has finished
[2025-07-28 09:37:06] 2025-07-28 09:36:36,573 | INFO     | [job] create_data_payload thread has finished
[2025-07-28 09:37:06] 2025-07-28 09:36:36,586 | WARNING  | data:copytool_out:received graceful stop - abort after this iteration
[2025-07-28 09:37:06] 2025-07-28 09:36:36,794 | INFO     | [payload] validate_pre thread has finished
[2025-07-28 09:37:06] 2025-07-28 09:36:36,897 | INFO     | [job] control thread has finished
[2025-07-28 09:37:06] 2025-07-28 09:36:37,044 | INFO     | [payload] control thread has finished
[2025-07-28 09:37:06] 2025-07-28 09:36:37,407 | INFO     | [data] copytool_in thread has finished
[2025-07-28 09:37:06] 2025-07-28 09:36:37,471 | INFO     | [payload] validate_post thread has finished
[2025-07-28 09:37:06] 2025-07-28 09:36:37,551 | INFO     | [data] control thread has finished
[2025-07-28 09:37:06] 2025-07-28 09:36:37,682 | INFO     | [payload] execute_payloads thread has finished
[2025-07-28 09:37:06] 2025-07-28 09:36:37,793 | INFO     | [job] validate thread has finished
[2025-07-28 09:37:06] 2025-07-28 09:36:38,071 | INFO     | [payload] failed_post thread has finished
[2025-07-28 09:37:06] 2025-07-28 09:36:38,162 | WARNING  | job:queue_monitor:received graceful stop - abort after this iteration
[2025-07-28 09:37:06] 2025-07-28 09:36:38,591 | INFO     | [data] copytool_out thread has finished
[2025-07-28 09:37:06] 2025-07-28 09:36:39,167 | INFO     | [job] queue monitor thread has finished
[2025-07-28 09:37:06] 2025-07-28 09:36:39,560 | INFO     | [data] queue_monitor thread has finished
[2025-07-28 09:37:06] 2025-07-28 09:36:41,235 | INFO     | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 128069003028288)>', '<ExcThread(monitor, started 128068500825856)>']
[2025-07-28 09:37:06] 2025-07-28 09:36:46,260 | INFO     | all workflow threads have been joined
[2025-07-28 09:37:06] 2025-07-28 09:36:46,260 | INFO     | end of generic workflow (traces error code: 0)
[2025-07-28 09:37:06] 2025-07-28 09:36:46,260 | INFO     | traces error code: 0
[2025-07-28 09:37:06] 2025-07-28 09:36:46,260 | INFO     | pilot has finished (exit code=0, shell exit code=0)
[2025-07-28 09:37:06] 2025-07-28 09:37:05,840 | INFO     | PID=38859 has CPU usage=1.5% CMD=/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/python/3.9.20-x86_64-centos7/bin/python3 pilot3/pilot.py -q BOINC_MCORE -i PR 
[2025-07-28 09:37:06] 2025-07-28 09:37:05,841 | INFO     | .. there are 4 such processes running
[2025-07-28 09:37:06] 2025-07-28 09:37:05,841 | INFO     | found 0 job(s) in 20 queues
[2025-07-28 09:37:06] 2025-07-28 09:37:05,842 | WARNING  | pilot monitor received instruction that args.graceful_stop has been set
[2025-07-28 09:37:06] 2025-07-28 09:37:05,842 | WARNING  | will wait for a maximum of 300 s for threads to finish
[2025-07-28 09:37:06] 2025-07-28 09:37:05,842 | WARNING  | job_aborted has been set - aborting pilot monitoring
[2025-07-28 09:37:06] 2025-07-28 09:37:05,842 | INFO     | [monitor] control thread has ended
[2025-07-28 09:37:06] 2025-07-28 09:37:05,957 [wrapper] ==== pilot stdout END ====
[2025-07-28 09:37:06] 2025-07-28 09:37:05,960 [wrapper] ==== wrapper stdout RESUME ====
[2025-07-28 09:37:06] 2025-07-28 09:37:05,962 [wrapper] pilotpid: 38859
[2025-07-28 09:37:06] 2025-07-28 09:37:05,965 [wrapper] Pilot exit status: 0
[2025-07-28 09:37:06] 2025-07-28 09:37:05,987 [wrapper] pandaids: 6745350959
[2025-07-28 09:37:06] 2025-07-28 09:37:06,043 [wrapper] cleanup supervisor_pilot  125145 38860
[2025-07-28 09:37:06] 2025-07-28 09:37:06,046 [wrapper] Test setup, not cleaning
[2025-07-28 09:37:06] 2025-07-28 09:37:06,051 [wrapper] apfmon messages muted
[2025-07-28 09:37:06] 2025-07-28 09:37:06,059 [wrapper] ==== wrapper stdout END ====
[2025-07-28 09:37:06] 2025-07-28 09:37:06,118 [wrapper] ==== wrapper stderr END ====
[2025-07-28 09:37:06]  *** Error codes and diagnostics ***
[2025-07-28 09:37:06]     "exeErrorCode": 0,
[2025-07-28 09:37:06]     "exeErrorDiag": "",
[2025-07-28 09:37:06]     "pilotErrorCode": 0,
[2025-07-28 09:37:06]     "pilotErrorDiag": "",
[2025-07-28 09:37:06]  *** Listing of results directory ***
[2025-07-28 09:37:06] total 432696
[2025-07-28 09:37:06] -rw-r--r-- 1 boinc boinc    530466 Jul 26 17:41 pilot3.tar.gz
[2025-07-28 09:37:06] -rwx------ 1 boinc boinc     36292 Jul 26 17:47 runpilot2-wrapper.sh
[2025-07-28 09:37:06] -rw-r--r-- 1 boinc boinc      5112 Jul 26 17:47 queuedata.json
[2025-07-28 09:37:06] -rw-rw-r-- 1 boinc boinc       100 Jul 28 07:48 wrapper_26015_x86_64-pc-linux-gnu
[2025-07-28 09:37:06] -rwxr-xr-x 1 boinc boinc      7986 Jul 28 07:48 run_atlas
[2025-07-28 09:37:06] -rw-rw-r-- 1 boinc boinc       105 Jul 28 07:48 job.xml
[2025-07-28 09:37:06] -rw-rw-r-- 1 boinc boinc      9390 Jul 28 07:48 init_data.xml
[2025-07-28 09:37:06] -rw-r--r-- 2 boinc boinc 230198653 Jul 28 07:48 EVNT.45743347._002360.pool.root.1
[2025-07-28 09:37:06] -rw-r--r-- 2 boinc boinc     15095 Jul 28 07:48 start_atlas.sh
[2025-07-28 09:37:06] drwxrwx--x 2 boinc boinc      4096 Jul 28 07:48 shared
[2025-07-28 09:37:06] -rw-r--r-- 2 boinc boinc    542900 Jul 28 07:48 input.tar.gz
[2025-07-28 09:37:06] -rw-rw-r-- 1 boinc boinc         0 Jul 28 07:48 boinc_lockfile
[2025-07-28 09:37:06] -rw-rw-r-- 1 boinc boinc      2563 Jul 28 07:48 pandaJob.out
[2025-07-28 09:37:06] -rw------- 1 boinc boinc    978452 Jul 28 07:48 agis_schedconf.cvmfs.json
[2025-07-28 09:37:06] -rw------- 1 boinc boinc   1593052 Jul 28 07:48 agis_ddmendpoints.agis.ALL.json
[2025-07-28 09:37:06] drwx------ 4 boinc boinc      4096 Jul 28 07:48 pilot3
[2025-07-28 09:37:06] -rw-rw-r-- 1 boinc boinc       529 Jul 28 09:35 boinc_task_state.xml
[2025-07-28 09:37:06] -rw------- 1 boinc boinc 206920416 Jul 28 09:35 HITS.45743349._041872.pool.root.1
[2025-07-28 09:37:06] -rw------- 1 boinc boinc      1022 Jul 28 09:36 memory_monitor_summary.json
[2025-07-28 09:37:06] -rw------- 1 boinc boinc    398227 Jul 28 09:36 log.45743349._041872.job.log.tgz.1
[2025-07-28 09:37:06] -rw------- 1 boinc boinc      7774 Jul 28 09:36 heartbeat.json
[2025-07-28 09:37:06] -rw-rw-r-- 1 boinc boinc      8192 Jul 28 09:36 boinc_mmap_file
[2025-07-28 09:37:06] -rw-rw-r-- 1 boinc boinc        27 Jul 28 09:36 wrapper_checkpoint.txt
[2025-07-28 09:37:06] -rw------- 1 boinc boinc        95 Jul 28 09:37 pilot_heartbeat.json
[2025-07-28 09:37:06] -rw------- 1 boinc boinc       820 Jul 28 09:37 pilotlog.txt
[2025-07-28 09:37:06] -rw------- 1 boinc boinc    642618 Jul 28 09:37 log.45743349._041872.job.log.1
[2025-07-28 09:37:06] -rw------- 1 boinc boinc       357 Jul 28 09:37 output.list
[2025-07-28 09:37:06] -rw-rw-r-- 1 boinc boinc       620 Jul 28 09:37 runtime_log
[2025-07-28 09:37:06] -rw------- 1 boinc boinc   1064960 Jul 28 09:37 result.tar.gz
[2025-07-28 09:37:06] -rw-rw-r-- 1 boinc boinc      8969 Jul 28 09:37 runtime_log.err
[2025-07-28 09:37:06] -rw------- 1 boinc boinc       653 Jul 28 09:37 fUCMDmxAyz7n9Rq4apOajLDm4fhM0noT9bVof3QYDmbA1KDmlMf2Fn.diag
[2025-07-28 09:37:06] -rw-rw-r-- 1 boinc boinc     20729 Jul 28 09:37 stderr.txt
[2025-07-28 09:37:06] HITS file was successfully produced:
[2025-07-28 09:37:06] -rw------- 1 boinc boinc 206920416 Jul 28 09:35 shared/HITS.pool.root.1
[2025-07-28 09:37:06]  *** Contents of shared directory: ***
[2025-07-28 09:37:06] total 428472
[2025-07-28 09:37:06] -rw-r--r-- 2 boinc boinc 230198653 Jul 28 07:48 ATLAS.root_0
[2025-07-28 09:37:06] -rw-r--r-- 2 boinc boinc     15095 Jul 28 07:48 start_atlas.sh
[2025-07-28 09:37:06] -rw-r--r-- 2 boinc boinc    542900 Jul 28 07:48 input.tar.gz
[2025-07-28 09:37:06] -rw------- 1 boinc boinc 206920416 Jul 28 09:35 HITS.pool.root.1
[2025-07-28 09:37:06] -rw------- 1 boinc boinc   1064960 Jul 28 09:37 result.tar.gz
09:37:07 (35096): run_atlas exited; CPU time 61203.656791
09:37:07 (35096): called boinc_finish(0)

</stderr_txt>
]]>

©2025 CERN