Name | VETMDmfhN73n7Olcko1bjSoqABFKDmABFKDm7AsVDm09RKDmx1G8Lo_0 |
Workunit | 2335667 |
Created | 2 Oct 2023, 2:19:08 UTC |
Sent | 2 Oct 2023, 2:24:13 UTC |
Report deadline | 9 Oct 2023, 2:24:13 UTC |
Received | 2 Oct 2023, 3:36:36 UTC |
Server state | Over |
Outcome | Success |
Client state | Done |
Exit status | 0 (0x00000000) |
Computer ID | 4933 |
Run time | 33 min 49 sec |
CPU time | 16 min 18 sec |
Validate state | Valid |
Credit | 21.02 |
Device peak FLOPS | 4.47 GFLOPS |
Application version | ATLAS Simulation v3.01 (native_mt) x86_64-pc-linux-gnu |
Peak working set size | 1.57 GB |
Peak swap size | 2.12 GB |
Peak disk usage | 82.85 MB |
<core_client_version>7.16.6</core_client_version> <![CDATA[ <stderr_txt> 21:02:28 (1024198): wrapper (7.7.26015): starting 21:02:28 (1024198): wrapper: running run_atlas (--nthreads 1) [2023-10-01 21:02:28] Arguments: --nthreads 1 [2023-10-01 21:02:28] Threads: 1 [2023-10-01 21:02:28] Checking for CVMFS [2023-10-01 21:02:30] Probing /cvmfs/atlas.cern.ch... OK [2023-10-01 21:02:31] Probing /cvmfs/atlas-condb.cern.ch... OK [2023-10-01 21:02:31] Running cvmfs_config stat atlas.cern.ch [2023-10-01 21:02:31] 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 [2023-10-01 21:02:31] 2.11.0.0 1024409 0 23340 124252 3 1 1297088 4096001 0 130560 0 0 100.000 0 0 http://s1fnal-cvmfs.openhtc.io:8080/cvmfs/atlas.cern.ch DIRECT 1 [2023-10-01 21:02:31] CVMFS is ok [2023-10-01 21:02:31] Efficiency of ATLAS tasks can be improved by the following measure(s): [2023-10-01 21:02:31] Small home clusters do not require a local http proxy but it is suggested if [2023-10-01 21:02:31] more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks. [2023-10-01 21:02:31] Further information can be found at the LHC@home message board. [2023-10-01 21:02:31] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 [2023-10-01 21:02:31] Checking for apptainer binary... [2023-10-01 21:02:31] apptainer is not installed, using version from CVMFS [2023-10-01 21:02:31] Checking apptainer works with /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname [2023-10-01 21:02:31] T5810-2 [2023-10-01 21:02:31] apptainer works [2023-10-01 21:02:32] Starting ATLAS job with PandaID=5977964023 [2023-10-01 21:02:32] Running command: /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/var/lib/boinc-client/slots/1 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh [2023-10-01 21:36:14] *** The last 200 lines of the pilot log: *** [2023-10-01 21:36:14] 2023-10-02 03:35:52,932 | INFO | pilot.util.timing | timing_report | . stage-in = 79 s [2023-10-01 21:36:14] 2023-10-02 03:35:52,932 | INFO | pilot.util.timing | timing_report | . payload execution = 1359 s [2023-10-01 21:36:14] 2023-10-02 03:35:52,932 | INFO | pilot.util.timing | timing_report | . stage-out = 358 s [2023-10-01 21:36:14] 2023-10-02 03:35:52,932 | INFO | pilot.util.timing | timing_report | . log creation = 0 s [2023-10-01 21:36:14] 2023-10-02 03:35:52,932 | INFO | pilot.util.timing | timing_report | .............................. [2023-10-01 21:36:14] 2023-10-02 03:35:52,932 | DEBUG | pilot.control.job | add_timing_and_extracts | could have reported time_log_creation=0 s [2023-10-01 21:36:14] 2023-10-02 03:35:52,932 | DEBUG | pilot.control.job | send_state | data={'jobId': '5977964023', 'state': 'finished', 'timestamp': '2023-10-01T21:35:40-07:00', 'siteNam [2023-10-01 21:36:14] 2023-10-02 03:35:52,933 | DEBUG | pilot.control.job | write_heartbeat_to_file | heartbeat dictionary: {'jobId': '5977964023', 'state': 'finished', 'timestamp': '2023-10-01T21:35:40 [2023-10-01 21:36:14] 2023-10-02 03:35:52,933 | DEBUG | pilot.control.job | write_heartbeat_to_file | wrote heartbeat to file: /var/lib/boinc-client/slots/1/heartbeat.json [2023-10-01 21:36:14] 2023-10-02 03:35:52,934 | DEBUG | pilot.control.job | queue_monitor | job.completed=False [2023-10-01 21:36:14] 2023-10-02 03:35:53,334 | INFO | pilot.control.job | make_job_report | [2023-10-01 21:36:14] 2023-10-02 03:35:53,334 | INFO | pilot.control.job | make_job_report | job summary report [2023-10-01 21:36:14] 2023-10-02 03:35:53,334 | INFO | pilot.control.job | make_job_report | -------------------------------------------------- [2023-10-01 21:36:14] 2023-10-02 03:35:53,334 | INFO | pilot.control.job | make_job_report | PanDA job id: 5977964023 [2023-10-01 21:36:14] 2023-10-02 03:35:53,334 | INFO | pilot.control.job | make_job_report | task id: NULL [2023-10-01 21:36:14] 2023-10-02 03:35:53,334 | INFO | pilot.control.job | make_job_report | errors: (none) [2023-10-01 21:36:14] 2023-10-02 03:35:53,335 | INFO | pilot.control.job | make_job_report | status: LOG_TRANSFER = DONE [2023-10-01 21:36:14] 2023-10-02 03:35:53,335 | INFO | pilot.control.job | make_job_report | pilot state: finished [2023-10-01 21:36:14] 2023-10-02 03:35:53,335 | INFO | pilot.control.job | make_job_report | transexitcode: 0 [2023-10-01 21:36:14] 2023-10-02 03:35:53,335 | INFO | pilot.control.job | make_job_report | exeerrorcode: 0 [2023-10-01 21:36:14] 2023-10-02 03:35:53,335 | INFO | pilot.control.job | make_job_report | exeerrordiag: [2023-10-01 21:36:14] 2023-10-02 03:35:53,335 | INFO | pilot.control.job | make_job_report | exitcode: 0 [2023-10-01 21:36:14] 2023-10-02 03:35:53,335 | INFO | pilot.control.job | make_job_report | exitmsg: OK [2023-10-01 21:36:14] 2023-10-02 03:35:53,335 | INFO | pilot.control.job | make_job_report | cpuconsumptiontime: 978 s [2023-10-01 21:36:14] 2023-10-02 03:35:53,335 | INFO | pilot.control.job | make_job_report | nevents: 2 [2023-10-01 21:36:14] 2023-10-02 03:35:53,336 | INFO | pilot.control.job | make_job_report | neventsw: 0 [2023-10-01 21:36:14] 2023-10-02 03:35:53,336 | INFO | pilot.control.job | make_job_report | pid: 1036154 [2023-10-01 21:36:14] 2023-10-02 03:35:53,336 | INFO | pilot.control.job | make_job_report | pgrp: 1036154 [2023-10-01 21:36:14] 2023-10-02 03:35:53,336 | INFO | pilot.control.job | make_job_report | corecount: 1 [2023-10-01 21:36:14] 2023-10-02 03:35:53,336 | INFO | pilot.control.job | make_job_report | event service: False [2023-10-01 21:36:14] 2023-10-02 03:35:53,336 | INFO | pilot.control.job | make_job_report | sizes: {0: 2458844, 1: 2459043, 12: 2459189, 22: 2459217, 33: 2459245, 44: 2459273, 54: 2459429, 65: [2023-10-01 21:36:14] 2023-10-02 03:35:53,336 | INFO | pilot.control.job | make_job_report | -------------------------------------------------- [2023-10-01 21:36:14] 2023-10-02 03:35:53,336 | INFO | pilot.control.job | make_job_report | [2023-10-01 21:36:14] 2023-10-02 03:35:53,336 | DEBUG | pilot.control.job | has_job_completed | ls -lF /var/lib/boinc-client/slots/1: [2023-10-01 21:36:14] [2023-10-01 21:36:14] 2023-10-02 03:35:53,336 | INFO | pilot.util.container | print_executable | executing command: ls -lF /var/lib/boinc-client/slots/1 [2023-10-01 21:36:14] 2023-10-02 03:35:53,349 | DEBUG | pilot.util.container | execute | subprocess.communicate() will use timeout=864000 s [2023-10-01 21:36:14] 2023-10-02 03:35:53,368 | DEBUG | pilot.control.job | has_job_completed | total 43908 [2023-10-01 21:36:14] -rw------- 1 boinc boinc 1008530 Oct 1 21:04 agis_schedconf.cvmfs.json [2023-10-01 21:36:14] -rw-r--r-- 1 boinc boinc 0 Oct 1 21:02 boinc_lockfile [2023-10-01 21:36:14] -rw-r--r-- 1 boinc boinc 8192 Oct 1 21:35 boinc_mmap_file [2023-10-01 21:36:14] -rw-r--r-- 1 boinc boinc 533 Oct 1 21:29 boinc_task_state.xml [2023-10-01 21:36:14] -rw------- 1 boinc boinc 616848 Oct 1 21:35 ccb1f0a0-ad74-4482-a7aa-5fdba078a791_18829.1.job.log [2023-10-01 21:36:14] -rw------- 1 boinc boinc 183300 Oct 1 21:33 ccb1f0a0-ad74-4482-a7aa-5fdba078a791_18829.1.job.log.tgz [2023-10-01 21:36:14] -rw------- 1 boinc boinc 1369984 Oct 1 21:04 cric_ddmendpoints.json [2023-10-01 21:36:14] -rw-r--r-- 2 boinc boinc 38288972 Oct 1 21:02 EVNT.04972714._000032.pool.root.1 [2023-10-01 21:36:14] -rw------- 1 boinc boinc 6623 Oct 1 21:35 heartbeat.json [2023-10-01 21:36:14] -rw-r--r-- 1 boinc boinc 9025 Oct 1 21:02 init_data.xml [2023-10-01 21:36:14] -rw-r--r-- 2 boinc boinc 446728 Oct 1 21:02 input.tar.gz [2023-10-01 21:36:14] -rw-r--r-- 1 boinc boinc 112 Oct 1 21:02 job.xml [2023-10-01 21:36:14] -rw------- 1 boinc boinc 1023 Oct 1 21:29 memory_monitor_summary.json [2023-10-01 21:36:14] -rw------- 1 boinc boinc 1820547 Oct 1 21:29 output.1.ccb1f0a0-ad74-4482-a7aa-5fdba078a791_18829.pool.root [2023-10-01 21:36:14] -rw------- 1 boinc boinc 464 Oct 1 21:35 output.list [2023-10-01 21:36:14] -rw-r--r-- 1 boinc boinc 2666 Oct 1 21:02 pandaJob.out [2023-10-01 21:36:14] drwxrwx--- 2 boinc boinc 4096 Oct 1 21:35 PanDA_Pilot-5977964023/ [2023-10-01 21:36:14] drwx------ 4 boinc boinc 4096 Oct 1 21:04 pilot3/ [2023-10-01 21:36:14] -rw------- 1 boinc boinc 435700 Oct 1 20:19 pilot3.tar.gz [2023-10-01 21:36:14] -rw------- 1 boinc boinc 604280 Oct 1 21:35 pilotlog.txt [2023-10-01 21:36:14] -rw-r--r-- 1 boinc boinc 4388 Oct 1 20:19 queuedata.json [2023-10-01 21:36:14] -rwxr-xr-x 1 boinc boinc 7986 Oct 1 21:02 run_atlas* [2023-10-01 21:36:14] -rwx------ 1 boinc boinc 27437 Oct 1 20:19 runpilot2-wrapper.sh* [2023-10-01 21:36:14] -rw-r--r-- 1 boinc boinc 407 Oct 1 21:02 runtime_log [2023-10-01 21:36:14] -rw-r--r-- 1 boinc boinc 7829 Oct 1 21:02 runtime_log.err [2023-10-01 21:36:14] -rw------- 1 boinc boinc 424 Oct 1 21:02 setup.sh.local [2023-10-01 21:36:14] drwxrwx--x 2 boinc boinc 4096 Oct 1 21:02 shared/ [2023-10-01 21:36:14] -rw-r--r-- 2 boinc boinc 17632 Oct 1 21:02 start_atlas.sh [2023-10-01 21:36:14] -rw-r--r-- 1 boinc boinc 2038 Oct 1 21:02 stderr.txt [2023-10-01 21:36:14] -rw------- 1 boinc boinc 130 Oct 1 21:02 VETMDmfhN73n7Olcko1bjSoqABFKDmABFKDm7AsVDm09RKDmx1G8Lo.diag [2023-10-01 21:36:14] -rw-r--r-- 1 boinc boinc 107 Oct 1 21:02 wrapper_26015_x86_64-pc-linux-gnu [2023-10-01 21:36:14] -rw-r--r-- 1 boinc boinc 25 Oct 1 21:35 wrapper_checkpoint.txt [2023-10-01 21:36:14] 2023-10-02 03:35:53,369 | INFO | pilot.util.queuehandling | queue_report | queue jobs had 0 job(s) [purged] [2023-10-01 21:36:14] 2023-10-02 03:35:53,369 | INFO | pilot.util.queuehandling | queue_report | queue payloads had 0 job(s) [purged] [2023-10-01 21:36:14] 2023-10-02 03:35:53,369 | INFO | pilot.util.queuehandling | queue_report | queue data_in had 0 job(s) [purged] [2023-10-01 21:36:14] 2023-10-02 03:35:53,369 | INFO | pilot.util.queuehandling | queue_report | queue data_out had 0 job(s) [purged] [2023-10-01 21:36:14] 2023-10-02 03:35:53,369 | INFO | pilot.util.queuehandling | queue_report | queue current_data_in had 0 job(s) [purged] [2023-10-01 21:36:14] 2023-10-02 03:35:53,369 | INFO | pilot.util.queuehandling | queue_report | queue validated_jobs had 0 job(s) [purged] [2023-10-01 21:36:14] 2023-10-02 03:35:53,369 | INFO | pilot.util.queuehandling | queue_report | queue validated_payloads had 0 job(s) [purged] [2023-10-01 21:36:14] 2023-10-02 03:35:53,370 | INFO | pilot.util.queuehandling | queue_report | queue monitored_payloads had 0 job(s) [purged] [2023-10-01 21:36:14] 2023-10-02 03:35:53,370 | INFO | pilot.util.queuehandling | queue_report | queue finished_jobs had 0 job(s) [purged] [2023-10-01 21:36:14] 2023-10-02 03:35:53,370 | INFO | pilot.util.queuehandling | queue_report | queue finished_payloads had 0 job(s) [purged] [2023-10-01 21:36:14] 2023-10-02 03:35:53,370 | INFO | pilot.util.queuehandling | queue_report | queue finished_data_in had 1 job(s) [purged] [2023-10-01 21:36:14] 2023-10-02 03:35:53,370 | INFO | pilot.util.queuehandling | queue_report | queue finished_data_out had 0 job(s) [purged] [2023-10-01 21:36:14] 2023-10-02 03:35:53,370 | INFO | pilot.util.queuehandling | queue_report | queue failed_jobs had 0 job(s) [purged] [2023-10-01 21:36:14] 2023-10-02 03:35:53,370 | INFO | pilot.util.queuehandling | queue_report | queue failed_payloads had 0 job(s) [purged] [2023-10-01 21:36:14] 2023-10-02 03:35:53,370 | INFO | pilot.util.queuehandling | queue_report | queue failed_data_in had 0 job(s) [purged] [2023-10-01 21:36:14] 2023-10-02 03:35:53,370 | INFO | pilot.util.queuehandling | queue_report | queue failed_data_out had 0 job(s) [purged] [2023-10-01 21:36:14] 2023-10-02 03:35:53,371 | INFO | pilot.util.queuehandling | queue_report | queue completed_jobs had 0 job(s) [purged] [2023-10-01 21:36:14] 2023-10-02 03:35:53,371 | INFO | pilot.util.queuehandling | queue_report | queue completed_jobids has 1 job(s) [2023-10-01 21:36:14] 2023-10-02 03:35:53,371 | INFO | pilot.util.queuehandling | queue_report | queue realtimelog_payloads had 0 job(s) [purged] [2023-10-01 21:36:14] 2023-10-02 03:35:53,371 | INFO | pilot.util.queuehandling | queue_report | queue messages had 0 job(s) [purged] [2023-10-01 21:36:14] 2023-10-02 03:35:53,371 | INFO | pilot.control.job | has_job_completed | job 5977964023 has completed (purged errors) [2023-10-01 21:36:14] 2023-10-02 03:35:53,371 | DEBUG | pilot.util.realtimelogger | cleanup | attempting real-time logger cleanup [2023-10-01 21:36:14] 2023-10-02 03:35:53,371 | INFO | pilot.util.processes | cleanup | overall cleanup function is called [2023-10-01 21:36:14] 2023-10-02 03:35:53,377 | DEBUG | pilot.util.processes | cleanup | work directory was removed: /var/lib/boinc-client/slots/1/PanDA_Pilot-5977964023 [2023-10-01 21:36:14] 2023-10-02 03:35:54,382 | INFO | pilot.info.jobdata | collect_zombies | --- collectZombieJob: --- 10, [1036154] [2023-10-01 21:36:14] 2023-10-02 03:35:54,382 | INFO | pilot.info.jobdata | collect_zombies | zombie collector waiting for pid 1036154 [2023-10-01 21:36:14] 2023-10-02 03:35:54,382 | INFO | pilot.info.jobdata | collect_zombies | harmless exception when collecting zombies: [Errno 10] No child processes [2023-10-01 21:36:14] 2023-10-02 03:35:55,386 | INFO | pilot.util.processes | cleanup | collected zombie processes [2023-10-01 21:36:14] 2023-10-02 03:35:55,388 | INFO | pilot.util.processes | cleanup | will now attempt to kill all subprocesses of pid=1036154 [2023-10-01 21:36:14] 2023-10-02 03:35:55,397 | DEBUG | pilot.util.container | execute | subprocess.communicate() will use timeout=864000 s [2023-10-01 21:36:14] 2023-10-02 03:35:55,473 | INFO | pilot.util.processes | kill_processes | process IDs to be killed: [1036154] (in reverse order) [2023-10-01 21:36:14] 2023-10-02 03:35:55,482 | DEBUG | pilot.util.container | execute | subprocess.communicate() will use timeout=864000 s [2023-10-01 21:36:14] 2023-10-02 03:35:55,524 | WARNING | pilot.util.processes | kill_processes | found no corresponding commands to process id(s) [2023-10-01 21:36:14] 2023-10-02 03:35:55,524 | INFO | pilot.util.processes | kill_orphans | Do not look for orphan processes in BOINC jobs [2023-10-01 21:36:14] 2023-10-02 03:35:55,529 | INFO | pilot.util.processes | kill_defunct_children | did not find any defunct processes belonging to 1036154 [2023-10-01 21:36:14] 2023-10-02 03:35:55,533 | INFO | pilot.util.processes | kill_defunct_children | did not find any defunct processes belonging to 1036154 [2023-10-01 21:36:14] 2023-10-02 03:35:55,534 | DEBUG | pilot.util.queuehandling | purge_queue | queue purged [2023-10-01 21:36:14] 2023-10-02 03:35:55,534 | INFO | pilot.control.job | retrieve | ready for new job [2023-10-01 21:36:14] 2023-10-02 03:35:55,534 | INFO | root | retrieve | pilot has finished with previous job - re-establishing logging [2023-10-01 21:36:14] 2023-10-02 03:35:55,535 | INFO | pilot.util.auxiliary | pilot_version_banner | ************************************* [2023-10-01 21:36:14] 2023-10-02 03:35:55,535 | INFO | pilot.util.auxiliary | pilot_version_banner | *** PanDA Pilot version 3.6.9.2 *** [2023-10-01 21:36:14] 2023-10-02 03:35:55,535 | INFO | pilot.util.auxiliary | pilot_version_banner | ************************************* [2023-10-01 21:36:14] 2023-10-02 03:35:55,535 | INFO | pilot.util.auxiliary | pilot_version_banner | [2023-10-01 21:36:14] 2023-10-02 03:35:55,555 | INFO | pilot.util.auxiliary | display_architecture_info | architecture information: [2023-10-01 21:36:14] 2023-10-02 03:35:55,555 | INFO | pilot.util.container | print_executable | executing command: cat /etc/os-release [2023-10-01 21:36:14] 2023-10-02 03:35:55,564 | DEBUG | pilot.util.container | execute | subprocess.communicate() will use timeout=864000 s [2023-10-01 21:36:14] 2023-10-02 03:35:55,568 | INFO | pilot.util.filehandling | dump | cat /etc/os-release: [2023-10-01 21:36:14] NAME="CentOS Linux" [2023-10-01 21:36:14] VERSION="7 (Core)" [2023-10-01 21:36:14] ID="centos" [2023-10-01 21:36:14] ID_LIKE="rhel fedora" [2023-10-01 21:36:14] VERSION_ID="7" [2023-10-01 21:36:14] PRETTY_NAME="CentOS Linux 7 (Core)" [2023-10-01 21:36:14] ANSI_COLOR="0;31" [2023-10-01 21:36:14] CPE_NAME="cpe:/o:centos:centos:7" [2023-10-01 21:36:14] HOME_URL="https://www.centos.org/" [2023-10-01 21:36:14] BUG_REPORT_URL="https://bugs.centos.org/" [2023-10-01 21:36:14] [2023-10-01 21:36:14] CENTOS_MANTISBT_PROJECT="CentOS-7" [2023-10-01 21:36:14] CENTOS_MANTISBT_PROJECT_VERSION="7" [2023-10-01 21:36:14] REDHAT_SUPPORT_PRODUCT="centos" [2023-10-01 21:36:14] REDHAT_SUPPORT_PRODUCT_VERSION="7" [2023-10-01 21:36:14] [2023-10-01 21:36:14] 2023-10-02 03:35:55,569 | INFO | pilot.util.auxiliary | pilot_version_banner | ************************************* [2023-10-01 21:36:14] 2023-10-02 03:35:56,070 | DEBUG | pilot.util.monitoring | check_local_space | checking local space on /var/lib/boinc-client/slots/1 [2023-10-01 21:36:14] 2023-10-02 03:35:56,070 | INFO | pilot.util.container | print_executable | executing command: df -mP /var/lib/boinc-client/slots/1 [2023-10-01 21:36:14] 2023-10-02 03:35:56,078 | DEBUG | pilot.util.container | execute | subprocess.communicate() will use timeout=864000 s [2023-10-01 21:36:14] 2023-10-02 03:35:56,084 | DEBUG | pilot.util.workernode | get_local_disk_space | stdout=Filesystem 1048576-blocks Used Available Capacity Mounted on [2023-10-01 21:36:14] /dev/sda2 479119 17909 436802 4% /var/lib/boinc-client/slots/1 [2023-10-01 21:36:14] 2023-10-02 03:35:56,084 | DEBUG | pilot.util.workernode | get_local_disk_space | stderr= [2023-10-01 21:36:14] 2023-10-02 03:35:56,085 | INFO | pilot.util.monitoring | check_local_space | sufficient remaining disk space (458020093952 B) [2023-10-01 21:36:14] 2023-10-02 03:35:56,085 | WARNING | pilot.control.job | proceed_with_getjob | since timefloor is set to 0, pilot was only allowed to run one job [2023-10-01 21:36:14] 2023-10-02 03:35:56,085 | WARNING | pilot.control.job | retrieve | setting graceful_stop since proceed_with_getjob() returned False (pilot will end) [2023-10-01 21:36:14] 2023-10-02 03:35:56,085 | WARNING | pilot.util.common | should_abort | data:copytool_out:received graceful stop - abort after this iteration [2023-10-01 21:36:14] 2023-10-02 03:35:56,086 | WARNING | pilot.util.common | should_abort | data:queue_monitoring:received graceful stop - abort after this iteration [2023-10-01 21:36:14] 2023-10-02 03:35:56,210 | DEBUG | pilot.control.data | control | data control ending since graceful_stop has been set [2023-10-01 21:36:14] 2023-10-02 03:35:56,290 | WARNING | pilot.util.common | should_abort | job:job_monitor:received graceful stop - abort after this iteration [2023-10-01 21:36:14] 2023-10-02 03:35:56,290 | INFO | pilot.control.job | job_monitor | aborting loop [2023-10-01 21:36:14] 2023-10-02 03:35:56,358 | DEBUG | pilot.control.payload | control | payload control ending since graceful_stop has been set [2023-10-01 21:36:14] 2023-10-02 03:35:56,610 | INFO | pilot.util.queuehandling | abort_jobs_in_queues | found 0 job(s) in 20 queues [2023-10-01 21:36:14] 2023-10-02 03:35:56,610 | WARNING | pilot.control.monitor | run_checks | pilot monitor received instruction that args.graceful_stop has been set [2023-10-01 21:36:14] 2023-10-02 03:35:56,610 | WARNING | pilot.control.monitor | run_checks | will wait for a maximum of 300 s for threads to finish [2023-10-01 21:36:14] 2023-10-02 03:35:57,090 | INFO | pilot.control.job | retrieve | [job] retrieve thread has finished [2023-10-01 21:36:14] 2023-10-02 03:35:57,215 | INFO | pilot.control.data | control | [data] control thread has finished [2023-10-01 21:36:14] 2023-10-02 03:35:57,294 | INFO | pilot.control.job | job_monitor | [job] job monitor thread has finished [2023-10-01 21:36:14] 2023-10-02 03:35:57,362 | DEBUG | pilot.control.job | control | job control ending since graceful_stop has been set [2023-10-01 21:36:14] 2023-10-02 03:35:57,362 | INFO | pilot.control.payload | control | [payload] control thread has finished [2023-10-01 21:36:14] 2023-10-02 03:35:57,362 | INFO | pilot.control.payload | failed_post | [payload] failed_post thread has finished [2023-10-01 21:36:14] 2023-10-02 03:35:57,458 | INFO | pilot.control.job | validate | [job] validate thread has finished [2023-10-01 21:36:14] 2023-10-02 03:35:57,758 | INFO | pilot.control.payload | execute_payloads | [payload] execute_payloads thread has finished [2023-10-01 21:36:14] 2023-10-02 03:35:57,950 | INFO | pilot.control.payload | validate_post | [payload] validate_post thread has finished [2023-10-01 21:36:14] 2023-10-02 03:35:58,039 | WARNING | pilot.util.common | should_abort | job:queue_monitor:received graceful stop - abort after this iteration [2023-10-01 21:36:14] 2023-10-02 03:35:58,090 | INFO | pilot.control.data | copytool_out | [data] copytool_out thread has finished [2023-10-01 21:36:14] 2023-10-02 03:35:58,118 | INFO | pilot.control.data | copytool_in | [data] copytool_in thread has finished [2023-10-01 21:36:14] 2023-10-02 03:35:58,134 | INFO | pilot.control.job | create_data_payload | [job] create_data_payload thread has finished [2023-10-01 21:36:14] 2023-10-02 03:35:58,350 | INFO | pilot.control.payload | validate_pre | [payload] validate_pre thread has finished [2023-10-01 21:36:14] 2023-10-02 03:35:58,366 | INFO | pilot.control.job | control | [job] control thread has finished [2023-10-01 21:36:14] 2023-10-02 03:35:59,042 | INFO | pilot.control.job | queue_monitor | [job] queue monitor thread has finished [2023-10-01 21:36:14] 2023-10-02 03:36:00,090 | INFO | pilot.control.data | queue_monitoring | [data] queue_monitor thread has finished [2023-10-01 21:36:14] 2023-10-02 03:36:06,532 | INFO | pilot.control.payload | get_logging_info | job.realtimelogging is not enabled [2023-10-01 21:36:14] 2023-10-02 03:36:06,532 | DEBUG | pilot.control.payload | run_realtimelog | real-time logging not needed at this point [2023-10-01 21:36:14] 2023-10-02 03:36:06,532 | DEBUG | pilot.control.payload | run_realtimelog | realtime logger was not found, waiting .. [2023-10-01 21:36:14] 2023-10-02 03:36:07,537 | INFO | pilot.control.payload | run_realtimelog | [payload] run_realtimelog thread has finished [2023-10-01 21:36:14] 2023-10-02 03:36:09,006 | INFO | pilot.util.processes | threads_aborted | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 139750 [2023-10-01 21:36:14] 2023-10-02 03:36:09,006 | DEBUG | pilot.workflow.generic | run | will proceed to set job_aborted [2023-10-01 21:36:14] 2023-10-02 03:36:09,662 | WARNING | pilot.control.monitor | run_checks | job_aborted has been set - aborting pilot monitoring [2023-10-01 21:36:14] 2023-10-02 03:36:09,662 | INFO | pilot.control.monitor | control | [monitor] control thread has ended [2023-10-01 21:36:14] 2023-10-02 03:36:14,030 | DEBUG | pilot.workflow.generic | run | all relevant threads have aborted (thread count=1) [2023-10-01 21:36:14] 2023-10-02 03:36:14,030 | INFO | pilot.workflow.generic | run | end of generic workflow (traces error code: 0) [2023-10-01 21:36:14] 2023-10-02 03:36:14,030 | DEBUG | root | <module> | trace=<class 'pilot.workflow.generic.traces'> [2023-10-01 21:36:14] 2023-10-02 03:36:14,085 | DEBUG | pilot.util.processgroups | get_all_child_pids | python3(1028495)---pstree(1049706) [2023-10-01 21:36:14] [2023-10-01 21:36:14] 2023-10-02 03:36:14,086 | INFO | pilot.util.processgroups | find_defunct_subprocesses | child pids=[1028495, 1049706] [2023-10-01 21:36:14] 2023-10-02 03:36:14,118 | DEBUG | pilot.util.processgroups | is_defunct | 1028495: return code=0, stdout=SN [2023-10-01 21:36:14] , stderr= [2023-10-01 21:36:14] 2023-10-02 03:36:14,153 | DEBUG | pilot.util.processgroups | is_defunct | 1049706: return code=1, stdout=, stderr= [2023-10-01 21:36:14] 2023-10-02 03:36:14,154 | INFO | root | list_zombies | no defunct processes were found [2023-10-01 21:36:14] 2023-10-02 03:36:14,154 | INFO | root | wrap_up | traces error code: 0 [2023-10-01 21:36:14] 2023-10-02 03:36:14,154 | INFO | root | wrap_up | pilot has finished (exit code=0, shell exit code=0) [2023-10-01 21:36:14] 2023-10-02 03:36:14,257 [wrapper] ==== pilot stdout END ==== [2023-10-01 21:36:14] 2023-10-02 03:36:14,260 [wrapper] ==== wrapper stdout RESUME ==== [2023-10-01 21:36:14] 2023-10-02 03:36:14,262 [wrapper] pilotpid: 1028495 [2023-10-01 21:36:14] 2023-10-02 03:36:14,264 [wrapper] Pilot exit status: 0 [2023-10-01 21:36:14] 2023-10-02 03:36:14,290 [wrapper] pandaids: 5977964023 [2023-10-01 21:36:14] 2023-10-02 03:36:14,295 [wrapper] apfmon messages muted [2023-10-01 21:36:14] 2023-10-02 03:36:14,297 [wrapper] Test setup, not cleaning [2023-10-01 21:36:14] 2023-10-02 03:36:14,299 [wrapper] ==== wrapper stdout END ==== [2023-10-01 21:36:14] 2023-10-02 03:36:14,301 [wrapper] ==== wrapper stderr END ==== [2023-10-01 21:36:14] 2023-10-02 03:36:14,354 [wrapper] wrapperexiting ec=0, duration=2022 [2023-10-01 21:36:14] 2023-10-02 03:36:14,363 [wrapper] apfmon messages muted [2023-10-01 21:36:14] *** Error codes and diagnostics *** [2023-10-01 21:36:14] "exeErrorCode": 0, [2023-10-01 21:36:14] "exeErrorDiag": "", [2023-10-01 21:36:14] "pilotErrorCode": 0, [2023-10-01 21:36:14] "pilotErrorDiag": "", [2023-10-01 21:36:14] *** Listing of results directory *** [2023-10-01 21:36:14] total 45960 [2023-10-01 21:36:14] -rwx------ 1 boinc boinc 27437 Oct 1 20:19 runpilot2-wrapper.sh [2023-10-01 21:36:14] -rw-r--r-- 1 boinc boinc 4388 Oct 1 20:19 queuedata.json [2023-10-01 21:36:14] -rw------- 1 boinc boinc 435700 Oct 1 20:19 pilot3.tar.gz [2023-10-01 21:36:14] -rw-r--r-- 1 boinc boinc 107 Oct 1 21:02 wrapper_26015_x86_64-pc-linux-gnu [2023-10-01 21:36:14] -rwxr-xr-x 1 boinc boinc 7986 Oct 1 21:02 run_atlas [2023-10-01 21:36:14] -rw-r--r-- 1 boinc boinc 112 Oct 1 21:02 job.xml [2023-10-01 21:36:14] -rw-r--r-- 2 boinc boinc 38288972 Oct 1 21:02 EVNT.04972714._000032.pool.root.1 [2023-10-01 21:36:14] -rw-r--r-- 2 boinc boinc 17632 Oct 1 21:02 start_atlas.sh [2023-10-01 21:36:14] drwxrwx--x 2 boinc boinc 4096 Oct 1 21:02 shared [2023-10-01 21:36:14] -rw-r--r-- 2 boinc boinc 446728 Oct 1 21:02 input.tar.gz [2023-10-01 21:36:14] -rw-r--r-- 1 boinc boinc 9025 Oct 1 21:02 init_data.xml [2023-10-01 21:36:14] -rw-r--r-- 1 boinc boinc 0 Oct 1 21:02 boinc_lockfile [2023-10-01 21:36:14] -rw-r--r-- 1 boinc boinc 2666 Oct 1 21:02 pandaJob.out [2023-10-01 21:36:14] -rw------- 1 boinc boinc 424 Oct 1 21:02 setup.sh.local [2023-10-01 21:36:14] -rw------- 1 boinc boinc 1369984 Oct 1 21:04 cric_ddmendpoints.json [2023-10-01 21:36:14] -rw------- 1 boinc boinc 1008530 Oct 1 21:04 agis_schedconf.cvmfs.json [2023-10-01 21:36:14] drwx------ 4 boinc boinc 4096 Oct 1 21:04 pilot3 [2023-10-01 21:36:14] -rw------- 1 boinc boinc 1820547 Oct 1 21:29 output.1.ccb1f0a0-ad74-4482-a7aa-5fdba078a791_18829.pool.root [2023-10-01 21:36:14] -rw------- 1 boinc boinc 1023 Oct 1 21:29 memory_monitor_summary.json [2023-10-01 21:36:14] -rw-r--r-- 1 boinc boinc 533 Oct 1 21:29 boinc_task_state.xml [2023-10-01 21:36:14] -rw------- 1 boinc boinc 183300 Oct 1 21:33 ccb1f0a0-ad74-4482-a7aa-5fdba078a791_18829.1.job.log.tgz [2023-10-01 21:36:14] -rw------- 1 boinc boinc 6623 Oct 1 21:35 heartbeat.json [2023-10-01 21:36:14] -rw-r--r-- 1 boinc boinc 8192 Oct 1 21:36 boinc_mmap_file [2023-10-01 21:36:14] -rw-r--r-- 1 boinc boinc 25 Oct 1 21:36 wrapper_checkpoint.txt [2023-10-01 21:36:14] -rw------- 1 boinc boinc 9366 Oct 1 21:36 pilotlog.txt [2023-10-01 21:36:14] -rw------- 1 boinc boinc 634830 Oct 1 21:36 ccb1f0a0-ad74-4482-a7aa-5fdba078a791_18829.1.job.log [2023-10-01 21:36:14] -rw------- 1 boinc boinc 464 Oct 1 21:36 output.list [2023-10-01 21:36:14] -rw-r--r-- 1 boinc boinc 748 Oct 1 21:36 runtime_log [2023-10-01 21:36:14] -rw------- 1 boinc boinc 2652160 Oct 1 21:36 result.tar.gz [2023-10-01 21:36:14] -rw------- 1 boinc boinc 633 Oct 1 21:36 VETMDmfhN73n7Olcko1bjSoqABFKDmABFKDm7AsVDm09RKDmx1G8Lo.diag [2023-10-01 21:36:14] -rw-r--r-- 1 boinc boinc 11959 Oct 1 21:36 runtime_log.err [2023-10-01 21:36:14] -rw-r--r-- 1 boinc boinc 29442 Oct 1 21:36 stderr.txt [2023-10-01 21:36:14] HITS file was successfully produced: [2023-10-01 21:36:14] -rw------- 1 boinc boinc 1820547 Oct 1 21:29 shared/HITS.pool.root.1 [2023-10-01 21:36:14] *** Contents of shared directory: *** [2023-10-01 21:36:14] total 42224 [2023-10-01 21:36:14] -rw-r--r-- 2 boinc boinc 38288972 Oct 1 21:02 ATLAS.root_0 [2023-10-01 21:36:14] -rw-r--r-- 2 boinc boinc 17632 Oct 1 21:02 start_atlas.sh [2023-10-01 21:36:14] -rw-r--r-- 2 boinc boinc 446728 Oct 1 21:02 input.tar.gz [2023-10-01 21:36:14] -rw------- 1 boinc boinc 1820547 Oct 1 21:29 HITS.pool.root.1 [2023-10-01 21:36:14] -rw------- 1 boinc boinc 2652160 Oct 1 21:36 result.tar.gz 21:36:15 (1024198): run_atlas exited; CPU time 978.648915 21:36:15 (1024198): called boinc_finish(0) </stderr_txt> ]]>
©2024 CERN