Name | fvWKDmRynz7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmPURLDm2LUtTn_1 |
Workunit | 233804245 |
Created | 26 Jul 2025, 9:54:16 UTC |
Sent | 26 Jul 2025, 12:34:28 UTC |
Report deadline | 3 Aug 2025, 12:34:28 UTC |
Received | 26 Jul 2025, 14:10:33 UTC |
Server state | Over |
Outcome | Success |
Client state | Done |
Exit status | 0 (0x00000000) |
Computer ID | 10674864 |
Run time | 1 hours 25 min 47 sec |
CPU time | 15 hours 20 min 38 sec |
Validate state | Valid |
Credit | 386.77 |
Device peak FLOPS | 34.18 GFLOPS |
Application version | ATLAS Simulation v3.01 (native_mt) x86_64-pc-linux-gnu |
Peak working set size | 2.70 GB |
Peak swap size | 3.21 GB |
Peak disk usage | 566.11 MB |
<core_client_version>7.7.0</core_client_version> <![CDATA[ <stderr_txt> 08:34:43 (17539): wrapper (7.7.26015): starting 08:34:43 (17539): wrapper: running run_atlas (--nthreads 12) [2025-07-26 08:34:43] Arguments: --nthreads 12 [2025-07-26 08:34:43] Threads: 12 [2025-07-26 08:34:43] Checking for CVMFS [2025-07-26 08:34:43] Probing /cvmfs/atlas.cern.ch... OK [2025-07-26 08:34:43] Probing /cvmfs/atlas-condb.cern.ch... OK [2025-07-26 08:34:43] Running cvmfs_config stat atlas.cern.ch [2025-07-26 08:34:43] 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-26 08:34:43] 2.11.2.0 3035 110522 98596 148777 1 58 14803185 20275201 1 130560 0 36589639 99.970 10085936 11085 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1 [2025-07-26 08:34:43] CVMFS is ok [2025-07-26 08:34:43] Efficiency of ATLAS tasks can be improved by the following measure(s): [2025-07-26 08:34:43] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io. [2025-07-26 08:34:43] Further information can be found at the LHC@home message board. [2025-07-26 08:34:43] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 [2025-07-26 08:34:43] Checking for apptainer binary... [2025-07-26 08:34:43] Using apptainer found in PATH at /usr/bin/apptainer [2025-07-26 08:34:43] Running /usr/bin/apptainer --version [2025-07-26 08:34:43] apptainer version 1.3.2-1.el7 [2025-07-26 08:34:43] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname [2025-07-26 08:34:45] c-205-31.aglt2.org [2025-07-26 08:34:45] apptainer works [2025-07-26 08:34:45] Set ATHENA_PROC_NUMBER=12 [2025-07-26 08:34:45] Set ATHENA_CORE_NUMBER=12 [2025-07-26 08:34:45] Starting ATLAS job with PandaID=6745098655 [2025-07-26 08:34:45] 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-07-26 10:00:26] *** The last 200 lines of the pilot log: *** [2025-07-26 10:00:26] protocols=[{'endpoint': 'davs://dav.ndgf.org:443', 'flavour': 'WEBDAV', 'id': 331, 'path': '/atlas/disk/atlasdatadisk/rucio/'}] [2025-07-26 10:00:26] replicas=None [2025-07-26 10:00:26] scope=mc23_13p6TeV [2025-07-26 10:00:26] status=None [2025-07-26 10:00:26] status_code=0 [2025-07-26 10:00:26] storage_token= [2025-07-26 10:00:26] surl=/tmp/boinchome/slots/0/PanDA_Pilot-6745098655/log.45743349._033822.job.log.tgz.1 [2025-07-26 10:00:26] turl=davs://dav.ndgf.org:443/atlas/disk/atlasdatadisk/rucio/mc23_13p6TeV/1a/88/log.45743349._033822.job.log.tgz.1 [2025-07-26 10:00:26] workdir=None [2025-07-26 10:00:26] ] [2025-07-26 10:00:26] 2025-07-26 13:59:58,927 | INFO | transferring file log.45743349._033822.job.log.tgz.1 from /tmp/boinchome/slots/0/PanDA_Pilot-6745098655/log.45743349._033822.job.log.tgz.1 to /tmp/boinchome/slots/ [2025-07-26 10:00:26] 2025-07-26 13:59:58,928 | INFO | executing command: /usr/bin/env mv /tmp/boinchome/slots/0/PanDA_Pilot-6745098655/log.45743349._033822.job.log.tgz.1 /tmp/boinchome/slots/0/log.45743349._033822.job [2025-07-26 10:00:26] 2025-07-26 13:59:58,950 | INFO | adding to output.list: log.45743349._033822.job.log.tgz.1 davs://dav.ndgf.org:443/atlas/disk/atlasdatadisk/rucio/mc23_13p6TeV/1a/88/log.45743349._033822.job.log.tg [2025-07-26 10:00:26] 2025-07-26 13:59:58,951 | INFO | alt stage-out settings: ['pl', 'write_lan', 'w', 'default'], allow_altstageout=False, remain_files=0, has_altstorage=True [2025-07-26 10:00:26] 2025-07-26 13:59:58,951 | INFO | summary of transferred files: [2025-07-26 10:00:26] 2025-07-26 13:59:58,952 | INFO | -- lfn=log.45743349._033822.job.log.tgz.1, status_code=0, status=transferred [2025-07-26 10:00:26] 2025-07-26 13:59:58,952 | INFO | stage-out finished correctly [2025-07-26 10:00:26] 2025-07-26 13:59:59,073 | INFO | monitor loop #382: job 0:6745098655 is in state 'finished' [2025-07-26 10:00:26] 2025-07-26 13:59:59,073 | INFO | will abort job monitoring soon since job state=finished (job is still in queue) [2025-07-26 10:00:26] 2025-07-26 14:00:01,430 | INFO | finished stage-out for finished payload, adding job to finished_jobs queue [2025-07-26 10:00:26] 2025-07-26 14:00:01,576 | INFO | monitor loop #383: job 0:6745098655 is in state 'finished' [2025-07-26 10:00:26] 2025-07-26 14:00:01,576 | INFO | will abort job monitoring soon since job state=finished (job is still in queue) [2025-07-26 10:00:26] 2025-07-26 14:00:02,654 | INFO | job 6745098655 has state=finished [2025-07-26 10:00:26] 2025-07-26 14:00:02,655 | INFO | preparing for final server update for job 6745098655 in state='finished' [2025-07-26 10:00:26] 2025-07-26 14:00:02,655 | INFO | this job has now completed (state=finished) [2025-07-26 10:00:26] 2025-07-26 14:00:02,655 | INFO | pilot will not update the server (heartbeat message will be written to file) [2025-07-26 10:00:26] 2025-07-26 14:00:02,656 | INFO | log transfer has been attempted: DONE [2025-07-26 10:00:26] 2025-07-26 14:00:02,656 | INFO | job 6745098655 has finished - writing final server update [2025-07-26 10:00:26] 2025-07-26 14:00:02,656 | INFO | total number of processed events: 400 (read) [2025-07-26 10:00:26] 2025-07-26 14:00:02,657 | INFO | executing command: lscpu [2025-07-26 10:00:26] 2025-07-26 14:00:02,684 | INFO | executing command: export ATLAS_LOCAL_ROOT_BASE=/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase;source ${ATLAS_LOCAL_ROOT_BASE}/user/atlasLocalSetup.sh --quiet;lsetup [2025-07-26 10:00:26] 2025-07-26 14:00:03,514 | INFO | PID=21377 has CPU usage=6.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-26 10:00:26] 2025-07-26 14:00:04,079 | INFO | monitor loop #384: job 0:6745098655 is in state 'finished' [2025-07-26 10:00:26] 2025-07-26 14:00:04,080 | INFO | will abort job monitoring soon since job state=finished (job is still in queue) [2025-07-26 10:00:26] 2025-07-26 14:00:06,583 | INFO | monitor loop #385: job 0:6745098655 is in state 'finished' [2025-07-26 10:00:26] 2025-07-26 14:00:06,583 | INFO | will abort job monitoring soon since job state=finished (job is still in queue) [2025-07-26 10:00:26] 2025-07-26 14:00:08,525 | INFO | CPU arch script returned: x86-64-v2 [2025-07-26 10:00:26] 2025-07-26 14:00:08,526 | INFO | 5112s have passed since pilot start - server update state is 'UPDATING_FINAL' [2025-07-26 10:00:26] 2025-07-26 14:00:08,529 | INFO | found 12 cores (6 cores per socket, 2 sockets) , CPU MHz: 1695.8333333333333 [2025-07-26 10:00:26] 2025-07-26 14:00:08,531 | INFO | using path: /tmp/boinchome/slots/0/PanDA_Pilot-6745098655/memory_monitor_summary.json (trf name=prmon) [2025-07-26 10:00:26] 2025-07-26 14:00:08,532 | INFO | extracted standard info from prmon json [2025-07-26 10:00:26] 2025-07-26 14:00:08,532 | INFO | extracted standard memory fields from prmon json [2025-07-26 10:00:26] 2025-07-26 14:00:08,533 | WARNING | GPU info not found in prmon json: 'gpu' [2025-07-26 10:00:26] 2025-07-26 14:00:08,533 | WARNING | format EVNTtoHITS has no such key: dbData [2025-07-26 10:00:26] 2025-07-26 14:00:08,533 | WARNING | format EVNTtoHITS has no such key: dbTime [2025-07-26 10:00:26] 2025-07-26 14:00:08,535 | INFO | fitting pss+swap vs Time [2025-07-26 10:00:26] 2025-07-26 14:00:08,535 | INFO | sum of square deviations: 141539398.0 [2025-07-26 10:00:26] 2025-07-26 14:00:08,536 | INFO | sum of deviations: -11001261245.000002 [2025-07-26 10:00:26] 2025-07-26 14:00:08,536 | INFO | mean x: 1753535952.0 [2025-07-26 10:00:26] 2025-07-26 14:00:08,536 | INFO | mean y: 2812562.909090909 [2025-07-26 10:00:26] 2025-07-26 14:00:08,536 | INFO | -- intersect: 136297776248.22717 [2025-07-26 10:00:26] 2025-07-26 14:00:08,536 | INFO | intersect: 136297776248.22717 [2025-07-26 10:00:26] 2025-07-26 14:00:08,536 | INFO | chi2: 0.06458693243077179 [2025-07-26 10:00:26] 2025-07-26 14:00:08,537 | INFO | -- intersect: 136297776248.22717 [2025-07-26 10:00:26] 2025-07-26 14:00:08,537 | INFO | current memory leak: -77.73 B/s (using 77 data points, chi2=0.06) [2025-07-26 10:00:26] 2025-07-26 14:00:08,537 | INFO | could have reported an average CPU frequency of 2032 MHz (6 samples) [2025-07-26 10:00:26] 2025-07-26 14:00:08,537 | INFO | .............................. [2025-07-26 10:00:26] 2025-07-26 14:00:08,537 | INFO | . Timing measurements: [2025-07-26 10:00:26] 2025-07-26 14:00:08,537 | INFO | . get job = 0 s [2025-07-26 10:00:26] 2025-07-26 14:00:08,537 | INFO | . initial setup = 2 s [2025-07-26 10:00:26] 2025-07-26 14:00:08,538 | INFO | . payload setup = 9 s [2025-07-26 10:00:26] 2025-07-26 14:00:08,538 | INFO | . stage-in = 0 s [2025-07-26 10:00:26] 2025-07-26 14:00:08,538 | INFO | . payload execution = 5069 s [2025-07-26 10:00:26] 2025-07-26 14:00:08,538 | INFO | . stage-out = 0 s [2025-07-26 10:00:26] 2025-07-26 14:00:08,538 | INFO | . log creation = 0 s [2025-07-26 10:00:26] 2025-07-26 14:00:08,538 | INFO | .............................. [2025-07-26 10:00:26] 2025-07-26 14:00:08,622 | INFO | [2025-07-26 10:00:26] 2025-07-26 14:00:08,622 | INFO | job summary report [2025-07-26 10:00:26] 2025-07-26 14:00:08,622 | INFO | -------------------------------------------------- [2025-07-26 10:00:26] 2025-07-26 14:00:08,622 | INFO | PanDA job id: 6745098655 [2025-07-26 10:00:26] 2025-07-26 14:00:08,622 | INFO | task id: 45743349 [2025-07-26 10:00:26] 2025-07-26 14:00:08,622 | INFO | errors: (none) [2025-07-26 10:00:26] 2025-07-26 14:00:08,622 | INFO | status: LOG_TRANSFER = DONE [2025-07-26 10:00:26] 2025-07-26 14:00:08,622 | INFO | pilot state: finished [2025-07-26 10:00:26] 2025-07-26 14:00:08,623 | INFO | transexitcode: 0 [2025-07-26 10:00:26] 2025-07-26 14:00:08,623 | INFO | exeerrorcode: 0 [2025-07-26 10:00:26] 2025-07-26 14:00:08,623 | INFO | exeerrordiag: [2025-07-26 10:00:26] 2025-07-26 14:00:08,623 | INFO | exitcode: 0 [2025-07-26 10:00:26] 2025-07-26 14:00:08,623 | INFO | exitmsg: OK [2025-07-26 10:00:26] 2025-07-26 14:00:08,623 | INFO | cpuconsumptiontime: 55172 s [2025-07-26 10:00:26] 2025-07-26 14:00:08,623 | INFO | nevents: 400 [2025-07-26 10:00:26] 2025-07-26 14:00:08,623 | INFO | neventsw: 0 [2025-07-26 10:00:26] 2025-07-26 14:00:08,623 | INFO | pid: 29302 [2025-07-26 10:00:26] 2025-07-26 14:00:08,623 | INFO | pgrp: 29302 [2025-07-26 10:00:26] 2025-07-26 14:00:08,624 | INFO | corecount: 12 [2025-07-26 10:00:26] 2025-07-26 14:00:08,624 | INFO | event service: False [2025-07-26 10:00:26] 2025-07-26 14:00:08,624 | INFO | sizes: {0: 2397474, 5: 2397736, 11: 2397792, 5082: 2424094, 5084: 2433092, 5087: 2433148, 5094: 2433470} [2025-07-26 10:00:26] 2025-07-26 14:00:08,624 | INFO | -------------------------------------------------- [2025-07-26 10:00:26] 2025-07-26 14:00:08,624 | INFO | [2025-07-26 10:00:26] 2025-07-26 14:00:08,624 | INFO | executing command: ls -lF /tmp/boinchome/slots/0 [2025-07-26 10:00:26] 2025-07-26 14:00:08,647 | INFO | queue jobs had 0 job(s) [purged] [2025-07-26 10:00:26] 2025-07-26 14:00:08,647 | INFO | queue payloads had 0 job(s) [purged] [2025-07-26 10:00:26] 2025-07-26 14:00:08,648 | INFO | queue data_in had 0 job(s) [purged] [2025-07-26 10:00:26] 2025-07-26 14:00:08,648 | INFO | queue data_out had 0 job(s) [purged] [2025-07-26 10:00:26] 2025-07-26 14:00:08,648 | INFO | queue current_data_in had 0 job(s) [purged] [2025-07-26 10:00:26] 2025-07-26 14:00:08,648 | INFO | queue validated_jobs had 0 job(s) [purged] [2025-07-26 10:00:26] 2025-07-26 14:00:08,648 | INFO | queue validated_payloads had 0 job(s) [purged] [2025-07-26 10:00:26] 2025-07-26 14:00:08,648 | INFO | queue monitored_payloads had 0 job(s) [purged] [2025-07-26 10:00:26] 2025-07-26 14:00:08,649 | INFO | queue finished_jobs had 0 job(s) [purged] [2025-07-26 10:00:26] 2025-07-26 14:00:08,649 | INFO | queue finished_payloads had 0 job(s) [purged] [2025-07-26 10:00:26] 2025-07-26 14:00:08,649 | INFO | queue finished_data_in had 1 job(s) [purged] [2025-07-26 10:00:26] 2025-07-26 14:00:08,649 | INFO | queue finished_data_out had 0 job(s) [purged] [2025-07-26 10:00:26] 2025-07-26 14:00:08,649 | INFO | queue failed_jobs had 0 job(s) [purged] [2025-07-26 10:00:26] 2025-07-26 14:00:08,650 | INFO | queue failed_payloads had 0 job(s) [purged] [2025-07-26 10:00:26] 2025-07-26 14:00:08,650 | INFO | queue failed_data_in had 0 job(s) [purged] [2025-07-26 10:00:26] 2025-07-26 14:00:08,650 | INFO | queue failed_data_out had 0 job(s) [purged] [2025-07-26 10:00:26] 2025-07-26 14:00:08,650 | INFO | queue completed_jobs had 0 job(s) [purged] [2025-07-26 10:00:26] 2025-07-26 14:00:08,650 | INFO | queue completed_jobids has 1 job(s) [2025-07-26 10:00:26] 2025-07-26 14:00:08,650 | INFO | queue realtimelog_payloads had 0 job(s) [purged] [2025-07-26 10:00:26] 2025-07-26 14:00:08,651 | INFO | queue messages had 0 job(s) [purged] [2025-07-26 10:00:26] 2025-07-26 14:00:08,651 | INFO | job 6745098655 has completed (purged errors) [2025-07-26 10:00:26] 2025-07-26 14:00:08,651 | INFO | overall cleanup function is called [2025-07-26 10:00:26] 2025-07-26 14:00:09,659 | INFO | --- collectZombieJob: --- 10, [29302] [2025-07-26 10:00:26] 2025-07-26 14:00:09,659 | INFO | zombie collector waiting for pid 29302 [2025-07-26 10:00:26] 2025-07-26 14:00:09,659 | INFO | harmless exception when collecting zombies: [Errno 10] No child processes [2025-07-26 10:00:26] 2025-07-26 14:00:09,659 | INFO | collected zombie processes [2025-07-26 10:00:26] 2025-07-26 14:00:09,659 | INFO | will attempt to kill all subprocesses of pid=29302 [2025-07-26 10:00:26] 2025-07-26 14:00:09,756 | INFO | process IDs to be killed: [29302] (in reverse order) [2025-07-26 10:00:26] 2025-07-26 14:00:09,809 | WARNING | found no corresponding commands to process id(s) [2025-07-26 10:00:26] 2025-07-26 14:00:09,810 | INFO | Do not look for orphan processes in BOINC jobs [2025-07-26 10:00:26] 2025-07-26 14:00:09,814 | INFO | did not find any defunct processes belonging to 29302 [2025-07-26 10:00:26] 2025-07-26 14:00:09,817 | INFO | did not find any defunct processes belonging to 29302 [2025-07-26 10:00:26] 2025-07-26 14:00:09,817 | INFO | ready for new job [2025-07-26 10:00:26] 2025-07-26 14:00:09,817 | INFO | pilot has finished with previous job - re-establishing logging [2025-07-26 10:00:26] 2025-07-26 14:00:09,818 | INFO | *************************************** [2025-07-26 10:00:26] 2025-07-26 14:00:09,818 | INFO | *** PanDA Pilot version 3.10.4.12 *** [2025-07-26 10:00:26] 2025-07-26 14:00:09,819 | INFO | *************************************** [2025-07-26 10:00:26] 2025-07-26 14:00:09,819 | INFO | [2025-07-26 10:00:26] 2025-07-26 14:00:09,819 | INFO | architecture information: [2025-07-26 10:00:26] 2025-07-26 14:00:09,820 | INFO | executing command: cat /etc/os-release [2025-07-26 10:00:26] 2025-07-26 14:00:09,836 | INFO | cat /etc/os-release: [2025-07-26 10:00:26] NAME="CentOS Linux" [2025-07-26 10:00:26] VERSION="7 (Core)" [2025-07-26 10:00:26] ID="centos" [2025-07-26 10:00:26] ID_LIKE="rhel fedora" [2025-07-26 10:00:26] VERSION_ID="7" [2025-07-26 10:00:26] PRETTY_NAME="CentOS Linux 7 (Core)" [2025-07-26 10:00:26] ANSI_COLOR="0;31" [2025-07-26 10:00:26] CPE_NAME="cpe:/o:centos:centos:7" [2025-07-26 10:00:26] HOME_URL="https://www.centos.org/" [2025-07-26 10:00:26] BUG_REPORT_URL="https://bugs.centos.org/" [2025-07-26 10:00:26] [2025-07-26 10:00:26] CENTOS_MANTISBT_PROJECT="CentOS-7" [2025-07-26 10:00:26] CENTOS_MANTISBT_PROJECT_VERSION="7" [2025-07-26 10:00:26] REDHAT_SUPPORT_PRODUCT="centos" [2025-07-26 10:00:26] REDHAT_SUPPORT_PRODUCT_VERSION="7" [2025-07-26 10:00:26] [2025-07-26 10:00:26] 2025-07-26 14:00:09,836 | INFO | *************************************** [2025-07-26 10:00:26] 2025-07-26 14:00:10,339 | INFO | executing command: df -mP /tmp/boinchome/slots/0 [2025-07-26 10:00:26] 2025-07-26 14:00:10,356 | INFO | sufficient remaining disk space (29433528320 B) [2025-07-26 10:00:26] 2025-07-26 14:00:10,356 | WARNING | since timefloor is set to 0, pilot was only allowed to run one job [2025-07-26 10:00:26] 2025-07-26 14:00:10,357 | INFO | current server update state: UPDATING_FINAL [2025-07-26 10:00:26] 2025-07-26 14:00:10,357 | INFO | update_server=False [2025-07-26 10:00:26] 2025-07-26 14:00:10,357 | WARNING | setting graceful_stop since proceed_with_getjob() returned False (pilot will end) [2025-07-26 10:00:26] 2025-07-26 14:00:10,357 | WARNING | aborting monitor loop since graceful_stop has been set (timing out remaining threads) [2025-07-26 10:00:26] 2025-07-26 14:00:10,358 | WARNING | data:copytool_out:received graceful stop - abort after this iteration [2025-07-26 10:00:26] 2025-07-26 14:00:10,358 | WARNING | job:queue_monitor:received graceful stop - abort after this iteration [2025-07-26 10:00:26] 2025-07-26 14:00:10,358 | WARNING | job:job_monitor:received graceful stop - abort after this iteration [2025-07-26 10:00:26] 2025-07-26 14:00:10,359 | INFO | found 0 job(s) in 20 queues [2025-07-26 10:00:26] 2025-07-26 14:00:10,359 | INFO | aborting loop [2025-07-26 10:00:26] 2025-07-26 14:00:10,359 | WARNING | pilot monitor received instruction that args.graceful_stop has been set [2025-07-26 10:00:26] 2025-07-26 14:00:10,360 | WARNING | will wait for a maximum of 300 s for threads to finish [2025-07-26 10:00:26] 2025-07-26 14:00:10,685 | INFO | all job control threads have been joined [2025-07-26 10:00:26] 2025-07-26 14:00:10,872 | INFO | all data control threads have been joined [2025-07-26 10:00:26] 2025-07-26 14:00:11,362 | INFO | [job] retrieve thread has finished [2025-07-26 10:00:26] 2025-07-26 14:00:11,364 | INFO | [job] queue monitor thread has finished [2025-07-26 10:00:26] 2025-07-26 14:00:11,365 | INFO | [job] job monitor thread has finished [2025-07-26 10:00:26] 2025-07-26 14:00:11,489 | INFO | all payload control threads have been joined [2025-07-26 10:00:26] 2025-07-26 14:00:11,492 | INFO | [payload] failed_post thread has finished [2025-07-26 10:00:26] 2025-07-26 14:00:11,691 | INFO | [job] control thread has finished [2025-07-26 10:00:26] 2025-07-26 14:00:11,840 | INFO | [payload] validate_pre thread has finished [2025-07-26 10:00:26] 2025-07-26 14:00:11,877 | INFO | [data] control thread has finished [2025-07-26 10:00:26] 2025-07-26 14:00:11,907 | INFO | [data] copytool_in thread has finished [2025-07-26 10:00:26] 2025-07-26 14:00:12,019 | WARNING | data:queue_monitoring:received graceful stop - abort after this iteration [2025-07-26 10:00:26] 2025-07-26 14:00:12,331 | INFO | [payload] validate_post thread has finished [2025-07-26 10:00:26] 2025-07-26 14:00:12,364 | INFO | [data] copytool_out thread has finished [2025-07-26 10:00:26] 2025-07-26 14:00:12,494 | INFO | [payload] control thread has finished [2025-07-26 10:00:26] 2025-07-26 14:00:12,593 | INFO | [job] validate thread has finished [2025-07-26 10:00:26] 2025-07-26 14:00:12,711 | INFO | [job] create_data_payload thread has finished [2025-07-26 10:00:26] 2025-07-26 14:00:12,838 | INFO | [payload] execute_payloads thread has finished [2025-07-26 10:00:26] 2025-07-26 14:00:16,025 | INFO | [data] queue_monitor thread has finished [2025-07-26 10:00:26] 2025-07-26 14:00:20,445 | INFO | job.realtimelogging is not enabled [2025-07-26 10:00:26] 2025-07-26 14:00:21,450 | INFO | [payload] run_realtimelog thread has finished [2025-07-26 10:00:26] 2025-07-26 14:00:21,455 | INFO | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 140387137288000)>', '<ExcThread(monitor, started 140386567710464)>'] [2025-07-26 10:00:26] 2025-07-26 14:00:22,416 | WARNING | job_aborted has been set - aborting pilot monitoring [2025-07-26 10:00:26] 2025-07-26 14:00:22,416 | INFO | [monitor] control thread has ended [2025-07-26 10:00:26] 2025-07-26 14:00:26,481 | INFO | all workflow threads have been joined [2025-07-26 10:00:26] 2025-07-26 14:00:26,481 | INFO | end of generic workflow (traces error code: 0) [2025-07-26 10:00:26] 2025-07-26 14:00:26,481 | INFO | traces error code: 0 [2025-07-26 10:00:26] 2025-07-26 14:00:26,482 | INFO | pilot has finished (exit code=0, shell exit code=0) [2025-07-26 10:00:26] 2025-07-26 14:00:26,562 [wrapper] ==== pilot stdout END ==== [2025-07-26 10:00:26] 2025-07-26 14:00:26,565 [wrapper] ==== wrapper stdout RESUME ==== [2025-07-26 10:00:26] 2025-07-26 14:00:26,569 [wrapper] pilotpid: 21377 [2025-07-26 10:00:26] 2025-07-26 14:00:26,573 [wrapper] Pilot exit status: 0 [2025-07-26 10:00:26] 2025-07-26 14:00:26,589 [wrapper] pandaids: 6745098655 [2025-07-26 10:00:26] 2025-07-26 14:00:26,629 [wrapper] cleanup supervisor_pilot 17730 21378 [2025-07-26 10:00:26] 2025-07-26 14:00:26,633 [wrapper] Test setup, not cleaning [2025-07-26 10:00:26] 2025-07-26 14:00:26,637 [wrapper] apfmon messages muted [2025-07-26 10:00:26] 2025-07-26 14:00:26,641 [wrapper] ==== wrapper stdout END ==== [2025-07-26 10:00:26] 2025-07-26 14:00:26,645 [wrapper] ==== wrapper stderr END ==== [2025-07-26 10:00:26] *** Error codes and diagnostics *** [2025-07-26 10:00:26] "exeErrorCode": 0, [2025-07-26 10:00:26] "exeErrorDiag": "", [2025-07-26 10:00:26] "pilotErrorCode": 0, [2025-07-26 10:00:26] "pilotErrorDiag": "", [2025-07-26 10:00:26] *** Listing of results directory *** [2025-07-26 10:00:26] total 392852 [2025-07-26 10:00:26] -rw-r--r-- 1 boincer umatlas 530466 Jul 26 02:42 pilot3.tar.gz [2025-07-26 10:00:26] -rw-r--r-- 1 boincer umatlas 5112 Jul 26 02:52 queuedata.json [2025-07-26 10:00:26] -rwx------ 1 boincer umatlas 36292 Jul 26 02:54 runpilot2-wrapper.sh [2025-07-26 10:00:26] -rw-r--r-- 1 boincer umatlas 100 Jul 26 08:34 wrapper_26015_x86_64-pc-linux-gnu [2025-07-26 10:00:26] -rwxr-xr-x 1 boincer umatlas 7986 Jul 26 08:34 run_atlas [2025-07-26 10:00:26] -rw-r--r-- 1 boincer umatlas 105 Jul 26 08:34 job.xml [2025-07-26 10:00:26] -rw-r--r-- 2 boincer umatlas 186814344 Jul 26 08:34 EVNT.45743347._001909.pool.root.1 [2025-07-26 10:00:26] -rw-r--r-- 2 boincer umatlas 15095 Jul 26 08:34 start_atlas.sh [2025-07-26 10:00:26] drwxrwx--x 2 boincer umatlas 4096 Jul 26 08:34 shared [2025-07-26 10:00:26] -rw-r--r-- 2 boincer umatlas 542893 Jul 26 08:34 input.tar.gz [2025-07-26 10:00:26] -rw-r--r-- 1 boincer umatlas 0 Jul 26 08:34 boinc_lockfile [2025-07-26 10:00:26] -rw-r--r-- 1 boincer umatlas 2562 Jul 26 08:34 pandaJob.out [2025-07-26 10:00:26] -rw------- 1 boincer umatlas 980117 Jul 26 08:34 agis_schedconf.cvmfs.json [2025-07-26 10:00:26] -rw------- 1 boincer umatlas 1593052 Jul 26 08:34 agis_ddmendpoints.agis.ALL.json [2025-07-26 10:00:26] drwx------ 4 boincer umatlas 4096 Jul 26 08:34 pilot3 [2025-07-26 10:00:26] -rw-r--r-- 1 boincer umatlas 5868 Jul 26 09:55 init_data.xml [2025-07-26 10:00:26] -rw------- 1 boincer umatlas 209882802 Jul 26 09:59 HITS.45743349._033822.pool.root.1 [2025-07-26 10:00:26] -rw-r--r-- 1 boincer umatlas 529 Jul 26 09:59 boinc_task_state.xml [2025-07-26 10:00:26] -rw------- 1 boincer umatlas 1051 Jul 26 09:59 memory_monitor_summary.json [2025-07-26 10:00:26] -rw------- 1 boincer umatlas 372192 Jul 26 09:59 log.45743349._033822.job.log.tgz.1 [2025-07-26 10:00:26] -rw------- 1 boincer umatlas 95 Jul 26 10:00 pilot_heartbeat.json [2025-07-26 10:00:26] -rw------- 1 boincer umatlas 7857 Jul 26 10:00 heartbeat.json [2025-07-26 10:00:26] -rw-r--r-- 1 boincer umatlas 8192 Jul 26 10:00 boinc_mmap_file [2025-07-26 10:00:26] -rw-r--r-- 1 boincer umatlas 27 Jul 26 10:00 wrapper_checkpoint.txt [2025-07-26 10:00:26] -rw------- 1 boincer umatlas 4552 Jul 26 10:00 pilotlog.txt [2025-07-26 10:00:26] -rw------- 1 boincer umatlas 484097 Jul 26 10:00 log.45743349._033822.job.log.1 [2025-07-26 10:00:26] -rw------- 1 boincer umatlas 357 Jul 26 10:00 output.list [2025-07-26 10:00:26] -rw-r--r-- 1 boincer umatlas 620 Jul 26 10:00 runtime_log [2025-07-26 10:00:26] -rw------- 1 boincer umatlas 870400 Jul 26 10:00 result.tar.gz [2025-07-26 10:00:26] -rw-r--r-- 1 boincer umatlas 8662 Jul 26 10:00 runtime_log.err [2025-07-26 10:00:26] -rw------- 1 boincer umatlas 659 Jul 26 10:00 fvWKDmRynz7nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmPURLDm2LUtTn.diag [2025-07-26 10:00:26] -rw-r--r-- 1 boincer umatlas 21938 Jul 26 10:00 stderr.txt [2025-07-26 10:00:26] HITS file was successfully produced: [2025-07-26 10:00:26] -rw------- 1 boincer umatlas 209882802 Jul 26 09:59 shared/HITS.pool.root.1 [2025-07-26 10:00:26] *** Contents of shared directory: *** [2025-07-26 10:00:26] total 388804 [2025-07-26 10:00:26] -rw-r--r-- 2 boincer umatlas 186814344 Jul 26 08:34 ATLAS.root_0 [2025-07-26 10:00:26] -rw-r--r-- 2 boincer umatlas 15095 Jul 26 08:34 start_atlas.sh [2025-07-26 10:00:26] -rw-r--r-- 2 boincer umatlas 542893 Jul 26 08:34 input.tar.gz [2025-07-26 10:00:26] -rw------- 1 boincer umatlas 209882802 Jul 26 09:59 HITS.pool.root.1 [2025-07-26 10:00:26] -rw------- 1 boincer umatlas 870400 Jul 26 10:00 result.tar.gz 10:00:28 (17539): run_atlas exited; CPU time 55142.554067 10:00:28 (17539): called boinc_finish(0) </stderr_txt> ]]>
©2025 CERN