| Name | moPLDmMZad5n7Olcko1bjSoqABFKDmABFKDmOtvXDmF0pKDmAI1Qam_0 |
| Workunit | 223643322 |
| Created | 17 Jun 2024, 23:04:57 UTC |
| Sent | 18 Jun 2024, 6:22:51 UTC |
| Report deadline | 26 Jun 2024, 6:22:51 UTC |
| Received | 27 Jun 2024, 18:23:47 UTC |
| Server state | Over |
| Outcome | Validate error |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 10603223 |
| Run time | 14 min 47 sec |
| CPU time | 1 min 44 sec |
| Validate state | Invalid |
| Credit | 0.00 |
| Device peak FLOPS | 48.75 GFLOPS |
| Application version | ATLAS Simulation v3.01 (native_mt) x86_64-pc-linux-gnu |
| Peak working set size | 2.00 GB |
| Peak swap size | 2.53 GB |
| Peak disk usage | 1.16 GB |
Stderr output
<core_client_version>7.16.11</core_client_version>
<![CDATA[
<stderr_txt>
14:10:30 (2565): wrapper (7.7.26015): starting
14:10:30 (2565): wrapper: running run_atlas (--nthreads 12)
[1998-01-03 14:10:30] Arguments: --nthreads 12
[1998-01-03 14:10:30] Threads: 12
[1998-01-03 14:10:30] Checking for CVMFS
[1998-01-03 14:10:37] Probing /cvmfs/atlas.cern.ch... OK
[1998-01-03 14:11:17] Probing /cvmfs/atlas-condb.cern.ch... OK
[1998-01-03 14:11:17] Running cvmfs_config stat atlas.cern.ch
[1998-01-03 14:11:18] 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
[1998-01-03 14:11:18] 2.10.1.0 2762 0 28436 134353 3 1 39970864 45568000 0 130560 0 0 0.000 1141 3907 http://cvmfs-s1bnl.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://206.12.9.162:3129 1
[1998-01-03 14:11:18] CVMFS is ok
[1998-01-03 14:11:18] Efficiency of ATLAS tasks can be improved by the following measure(s):
[1998-01-03 14:11:18] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[1998-01-03 14:11:18] Further information can be found at the LHC@home message board.
[1998-01-03 14:11:18] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[1998-01-03 14:11:18] Checking for apptainer binary...
[1998-01-03 14:11:18] Using apptainer found in PATH at /usr/bin/apptainer
[1998-01-03 14:11:18] Running /usr/bin/apptainer --version
[1998-01-03 14:11:18] apptainer version 1.1.8-1.el7
[1998-01-03 14:11:18] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[1998-01-03 14:11:18] INFO: /etc/singularity/ exists; cleanup by system administrator is not complete (see https://apptainer.org/docs/admin/latest/singularity_migration.html) WARNING: Environment variable TMPDIR already has value [/home/boinc/slots/1/.apptainertmp], will not forward new value [/home/boinc] from parent process environment wns0040.triumf.lcg
[1998-01-03 14:11:18] apptainer works
[1998-01-03 14:11:18] Set ATHENA_PROC_NUMBER=12
[1998-01-03 14:11:18] Set ATHENA_CORE_NUMBER=12
[1998-01-03 14:11:19] Starting ATLAS job with PandaID=6235056392
[1998-01-03 14:11:19] Running command: /usr/bin/apptainer exec -B /cvmfs,/home/boinc/slots/1 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2024-06-27 11:23:42] *** The last 200 lines of the pilot log: ***
[2024-06-27 11:23:42] 1998-01-03 22:23:53,060 | INFO | neither /home/boinc/slots/1/PanDA_Pilot-6235056392/memory_monitor_summary.json, nor /home/boinc/slots/1/memory_monitor_summary.json exist
[2024-06-27 11:23:42] 1998-01-03 22:23:53,060 | INFO | using path: /home/boinc/slots/1/PanDA_Pilot-6235056392/memory_monitor_output.txt (trf name=prmon)
[2024-06-27 11:23:42] 1998-01-03 22:23:53,061 | INFO | oom_score(pilot) = 0, oom_score(payload) = 0
[2024-06-27 11:23:42] 1998-01-03 22:23:53,197 | INFO | number of running child processes to parent process 24359: 6
[2024-06-27 11:23:42] 1998-01-03 22:23:53,197 | INFO | maximum number of monitored processes: 6
[2024-06-27 11:23:42] 1998-01-03 22:23:55,703 | INFO | monitor loop #62: job 0:6235056392 is in state 'running'
[2024-06-27 11:23:42] 1998-01-03 22:24:05,898 | INFO | (instant) CPU consumption time for pid=24359: 62.53 (rounded to 63)
[2024-06-27 11:23:42] 1998-01-03 22:24:05,899 | INFO | neither /home/boinc/slots/1/PanDA_Pilot-6235056392/memory_monitor_summary.json, nor /home/boinc/slots/1/memory_monitor_summary.json exist
[2024-06-27 11:23:42] 1998-01-03 22:24:05,899 | INFO | using path: /home/boinc/slots/1/PanDA_Pilot-6235056392/memory_monitor_output.txt (trf name=prmon)
[2024-06-27 11:23:42] 1998-01-03 22:24:05,900 | INFO | oom_score(pilot) = 0, oom_score(payload) = 0
[2024-06-27 11:23:42] 1998-01-03 22:24:06,030 | INFO | number of running child processes to parent process 24359: 6
[2024-06-27 11:23:42] 1998-01-03 22:24:06,030 | INFO | maximum number of monitored processes: 6
[2024-06-27 11:23:42] 1998-01-03 22:24:08,538 | INFO | monitor loop #63: job 0:6235056392 is in state 'running'
[2024-06-27 11:23:42] 1998-01-03 22:24:18,729 | INFO | (instant) CPU consumption time for pid=24359: 75.33999999999999 (rounded to 75)
[2024-06-27 11:23:42] 1998-01-03 22:24:18,730 | INFO | neither /home/boinc/slots/1/PanDA_Pilot-6235056392/memory_monitor_summary.json, nor /home/boinc/slots/1/memory_monitor_summary.json exist
[2024-06-27 11:23:42] 1998-01-03 22:24:18,730 | INFO | using path: /home/boinc/slots/1/PanDA_Pilot-6235056392/memory_monitor_output.txt (trf name=prmon)
[2024-06-27 11:23:42] 1998-01-03 22:24:18,731 | INFO | oom_score(pilot) = 0, oom_score(payload) = 0
[2024-06-27 11:23:42] 1998-01-03 22:24:18,868 | INFO | number of running child processes to parent process 24359: 6
[2024-06-27 11:23:42] 1998-01-03 22:24:18,869 | INFO | maximum number of monitored processes: 6
[2024-06-27 11:23:42] 1998-01-03 22:24:21,376 | INFO | monitor loop #64: job 0:6235056392 is in state 'running'
[2024-06-27 11:23:42] 1998-01-03 22:24:31,565 | INFO | (instant) CPU consumption time for pid=24359: 88.20999999999998 (rounded to 88)
[2024-06-27 11:23:42] 1998-01-03 22:24:31,566 | INFO | neither /home/boinc/slots/1/PanDA_Pilot-6235056392/memory_monitor_summary.json, nor /home/boinc/slots/1/memory_monitor_summary.json exist
[2024-06-27 11:23:42] 1998-01-03 22:24:31,566 | INFO | using path: /home/boinc/slots/1/PanDA_Pilot-6235056392/memory_monitor_output.txt (trf name=prmon)
[2024-06-27 11:23:42] 1998-01-03 22:24:31,567 | INFO | neither /home/boinc/slots/1/PanDA_Pilot-6235056392/memory_monitor_summary.json, nor /home/boinc/slots/1/memory_monitor_summary.json exist
[2024-06-27 11:23:42] 1998-01-03 22:24:31,567 | INFO | using path: /home/boinc/slots/1/PanDA_Pilot-6235056392/memory_monitor_output.txt (trf name=prmon)
[2024-06-27 11:23:42] 1998-01-03 22:24:31,568 | INFO | max memory (maxPSS) used by the payload is within the allowed limit: 1989219 B (2 * maxRSS = 786432000 B)
[2024-06-27 11:23:42] 1998-01-03 22:24:31,568 | INFO | oom_score(pilot) = 0, oom_score(payload) = 0
[2024-06-27 11:23:42] 1998-01-03 22:24:31,569 | INFO | payload log (log.EVNTtoHITS) within allowed size limit (2147483648 B): 588144 B
[2024-06-27 11:23:42] 1998-01-03 22:24:31,569 | INFO | payload log (payload.stdout) within allowed size limit (2147483648 B): 9339 B
[2024-06-27 11:23:42] 1998-01-03 22:24:31,569 | INFO | executing command: df -mP /home/boinc/slots/1
[2024-06-27 11:23:42] 1998-01-03 22:24:31,593 | INFO | sufficient remaining disk space (2236945006592 B)
[2024-06-27 11:23:42] 1998-01-03 22:24:31,594 | INFO | work directory size check will use 61362667520 B as a max limit (10% grace limit added)
[2024-06-27 11:23:42] 1998-01-03 22:24:31,595 | INFO | size of work directory /home/boinc/slots/1/PanDA_Pilot-6235056392: 808847 B (within 61362667520 B limit)
[2024-06-27 11:23:42] 1998-01-03 22:24:31,595 | INFO | pfn file=/home/boinc/slots/1/PanDA_Pilot-6235056392/HITS.38921001._060725.pool.root.1 does not exist (skip from workdir size calculation)
[2024-06-27 11:23:42] 1998-01-03 22:24:31,595 | INFO | total size of present files: 0 B (workdir size: 808847 B)
[2024-06-27 11:23:42] 1998-01-03 22:24:31,595 | INFO | output file size check: skipping output file /home/boinc/slots/1/PanDA_Pilot-6235056392/HITS.38921001._060725.pool.root.1 since it does not exist
[2024-06-27 11:23:42] 1998-01-03 22:24:31,716 | INFO | number of running child processes to parent process 24359: 6
[2024-06-27 11:23:42] 1998-01-03 22:24:31,717 | INFO | maximum number of monitored processes: 6
[2024-06-27 11:23:42] 1998-01-03 22:24:34,223 | INFO | monitor loop #65: job 0:6235056392 is in state 'running'
[2024-06-27 11:23:42] 2024-06-27 18:23:09,000 | CRITICAL | max running time (691200s) minus grace time (180s) has been exceeded - time to abort pilot
[2024-06-27 11:23:42] 2024-06-27 18:23:09,001 | INFO | setting REACHED_MAXTIME and graceful stop
[2024-06-27 11:23:42] 2024-06-27 18:23:09,001 | INFO | [monitor] control thread has ended
[2024-06-27 11:23:42] 2024-06-27 18:23:09,752 | INFO | breaking -- sending SIGTERM to pid=24359
[2024-06-27 11:23:42] 2024-06-27 18:23:09,753 | INFO | breaking -- sleep 10 s before sending SIGKILL pid=24359
[2024-06-27 11:23:42] 2024-06-27 18:23:09,913 | INFO | all data control threads have been joined
[2024-06-27 11:23:42] 2024-06-27 18:23:10,007 | INFO | all payload control threads have been joined
[2024-06-27 11:23:42] 2024-06-27 18:23:10,390 | INFO | [data] copytool_in thread has finished
[2024-06-27 11:23:42] 2024-06-27 18:23:10,611 | INFO | all job control threads have been joined
[2024-06-27 11:23:42] 2024-06-27 18:23:10,812 | INFO | [payload] failed_post thread has finished
[2024-06-27 11:23:42] 2024-06-27 18:23:10,831 | INFO | [job] retrieve thread has finished
[2024-06-27 11:23:42] 2024-06-27 18:23:10,920 | INFO | [data] control thread has finished
[2024-06-27 11:23:42] 2024-06-27 18:23:10,937 | INFO | [job] create_data_payload thread has finished
[2024-06-27 11:23:42] 2024-06-27 18:23:11,015 | INFO | [payload] control thread has finished
[2024-06-27 11:23:42] 2024-06-27 18:23:11,191 | INFO | [payload] validate_post thread has finished
[2024-06-27 11:23:42] 2024-06-27 18:23:11,236 | INFO | job.realtimelogging is not enabled
[2024-06-27 11:23:42] 2024-06-27 18:23:11,243 | INFO | [job] validate thread has finished
[2024-06-27 11:23:42] 2024-06-27 18:23:11,439 | INFO | [payload] validate_pre thread has finished
[2024-06-27 11:23:42] 2024-06-27 18:23:11,619 | INFO | [job] control thread has finished
[2024-06-27 11:23:42] 2024-06-27 18:23:12,012 | WARNING | since job:queue_monitor is responsible for sending job updates, we sleep for 20 s
[2024-06-27 11:23:42] 2024-06-27 18:23:12,013 | INFO | (instant) CPU consumption time for pid=24359: 4.109999999999999 (rounded to 4)
[2024-06-27 11:23:42] 2024-06-27 18:23:12,014 | INFO | neither /home/boinc/slots/1/PanDA_Pilot-6235056392/memory_monitor_summary.json, nor /home/boinc/slots/1/memory_monitor_summary.json exist
[2024-06-27 11:23:42] 2024-06-27 18:23:12,014 | INFO | using path: /home/boinc/slots/1/PanDA_Pilot-6235056392/memory_monitor_output.txt (trf name=prmon)
[2024-06-27 11:23:42] 2024-06-27 18:23:12,015 | INFO | oom_score(pilot) = 0, oom_score(payload) = 0
[2024-06-27 11:23:42] 2024-06-27 18:23:12,125 | INFO | number of running child processes to parent process 24359: 1
[2024-06-27 11:23:42] 2024-06-27 18:23:12,126 | INFO | maximum number of monitored processes: 6
[2024-06-27 11:23:42] 2024-06-27 18:23:12,126 | INFO | will send heartbeat for job in 'running' state
[2024-06-27 11:23:42] 2024-06-27 18:23:12,127 | WARNING | the max batch system time limit has been reached
[2024-06-27 11:23:42] 2024-06-27 18:23:12,127 | INFO | this job has now completed (state=failed)
[2024-06-27 11:23:42] 2024-06-27 18:23:12,127 | INFO | pilot will not update the server (heartbeat message will be written to file)
[2024-06-27 11:23:42] 2024-06-27 18:23:12,127 | INFO | job 6235056392 has failed - writing final server update
[2024-06-27 11:23:42] 2024-06-27 18:23:12,128 | WARNING | making sure that job.state is set to failed since a pilot error code is set
[2024-06-27 11:23:42] 2024-06-27 18:23:12,128 | INFO | payload/TRF did not report the number of read events
[2024-06-27 11:23:42] 2024-06-27 18:23:12,139 | INFO | executing command: lscpu
[2024-06-27 11:23:42] 2024-06-27 18:23:12,226 | INFO | found 48 cores (24 cores per socket, 2 sockets)
[2024-06-27 11:23:42] 2024-06-27 18:23:12,227 | INFO | executing command: grep -o 'avx2[^ ]*\|AVX2[^ ]*' /proc/cpuinfo
[2024-06-27 11:23:42] 2024-06-27 18:23:12,243 | INFO | [payload] run_realtimelog thread has finished
[2024-06-27 11:23:42] 2024-06-27 18:23:12,289 | INFO | executing command: export ATLAS_LOCAL_ROOT_BASE=/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase;source ${ATLAS_LOCAL_ROOT_BASE}/user/atlasLocalSetup.sh --quiet;lsetup
[2024-06-27 11:23:42] 2024-06-27 18:23:12,307 | INFO | [data] copytool_out thread has finished
[2024-06-27 11:23:42] 2024-06-27 18:23:14,362 | INFO | [data] queue_monitor thread has finished
[2024-06-27 11:23:42] 2024-06-27 18:23:19,341 | INFO | CPU arch script returned: x86-64-v4
[2024-06-27 11:23:42] 2024-06-27 18:23:19,342 | INFO | neither /home/boinc/slots/1/PanDA_Pilot-6235056392/memory_monitor_summary.json, nor /home/boinc/slots/1/memory_monitor_summary.json exist
[2024-06-27 11:23:42] 2024-06-27 18:23:19,343 | INFO | using path: /home/boinc/slots/1/PanDA_Pilot-6235056392/memory_monitor_output.txt (trf name=prmon)
[2024-06-27 11:23:42] 2024-06-27 18:23:19,344 | INFO | extracted standard info from memory monitor json
[2024-06-27 11:23:42] 2024-06-27 18:23:19,344 | WARNING | standard memory fields were not found in memory monitor json (or json doesn't exist yet)
[2024-06-27 11:23:42] 2024-06-27 18:23:19,345 | WARNING | wrong length of table data, x=[883865827.0, 883865888.0, 883865949.0, 883866010.0, 883866071.0, 883866132.0, 883866193.0], y=[1123024.0, 1124517.0, 1124914.0, 1142
[2024-06-27 11:23:42] 2024-06-27 18:23:19,346 | INFO | ..............................
[2024-06-27 11:23:42] 2024-06-27 18:23:19,346 | INFO | . Timing measurements:
[2024-06-27 11:23:42] 2024-06-27 18:23:19,346 | INFO | . get job = 0 s
[2024-06-27 11:23:42] 2024-06-27 18:23:19,346 | INFO | . initial setup = 2 s
[2024-06-27 11:23:42] 2024-06-27 18:23:19,346 | INFO | . payload setup = 6 s
[2024-06-27 11:23:42] 2024-06-27 18:23:19,346 | INFO | . stage-in = 0 s
[2024-06-27 11:23:42] 2024-06-27 18:23:19,346 | INFO | . payload execution = 0 s
[2024-06-27 11:23:42] 2024-06-27 18:23:19,346 | INFO | . stage-out = 0 s
[2024-06-27 11:23:42] 2024-06-27 18:23:19,347 | INFO | . log creation = 0 s
[2024-06-27 11:23:42] 2024-06-27 18:23:19,347 | INFO | ..............................
[2024-06-27 11:23:42] 2024-06-27 18:23:19,361 | INFO | building log extracts (sent to the server as 'pilotLog')
[2024-06-27 11:23:42] 2024-06-27 18:23:19,361 | INFO | executing command: tail -n 20 /home/boinc/slots/1/PanDA_Pilot-6235056392/pilotlog.txt
[2024-06-27 11:23:42] 2024-06-27 18:23:19,377 | WARNING | detected the following tail of warning/fatal messages in the pilot log:
[2024-06-27 11:23:42] - Log from pilotlog.txt -
[2024-06-27 11:23:42] 2024-06-27 18:23:12,307 | INFO | [data] copytool_out thread has finished
[2024-06-27 11:23:42] 2024-06-27 18:23:14,362 | INFO | [data] queue_monitor thread has finished
[2024-06-27 11:23:42] 2024-06-27 18:23:19,341 | INFO | CPU arch script returned: x86-64-v4
[2024-06-27 11:23:42] 2024-06-27 18:23:19,342 | INFO | neither /home/boinc/slots/1/PanDA_Pilot-6235056392/memory_monitor_summary.json, nor /home/boinc/slots/1/memory_monitor_summary.json exist
[2024-06-27 11:23:42] 2024-06-27 18:23:19,343 | INFO | using path: /home/boinc/slots/1/PanDA_Pilot-6235056392/memory_monitor_output.txt (trf name=prmon)
[2024-06-27 11:23:42] 2024-06-27 18:23:19,344 | INFO | extracted standard info from memory monitor json
[2024-06-27 11:23:42] 2024-06-27 18:23:19,344 | WARNING | standard memory fields were not found in memory monitor json (or json doesn't exist yet)
[2024-06-27 11:23:42] 2024-06-27 18:23:19,345 | WARNING | wrong length of table data, x=[883865827.0, 883865888.0, 883865949.0, 883866010.0, 883866071.0, 883866132.0, 883866193.0], y=[1123024.0, 1124517.0, 1124914.0, 1142
[2024-06-27 11:23:42] 2024-06-27 18:23:19,346 | INFO | ..............................
[2024-06-27 11:23:42] 2024-06-27 18:23:19,346 | INFO | . Timing measurements:
[2024-06-27 11:23:42] 2024-06-27 18:23:19,346 | INFO | . get job = 0 s
[2024-06-27 11:23:42] 2024-06-27 18:23:19,346 | INFO | . initial setup = 2 s
[2024-06-27 11:23:42] 2024-06-27 18:23:19,346 | INFO | . payload setup = 6 s
[2024-06-27 11:23:42] 2024-06-27 18:23:19,346 | INFO | . stage-in = 0 s
[2024-06-27 11:23:42] 2024-06-27 18:23:19,346 | INFO | . payload execution = 0 s
[2024-06-27 11:23:42] 2024-06-27 18:23:19,346 | INFO | . stage-out = 0 s
[2024-06-27 11:23:42] 2024-06-27 18:23:19,347 | INFO | . log creation = 0 s
[2024-06-27 11:23:42] 2024-06-27 18:23:19,347 | INFO | ..............................
[2024-06-27 11:23:42] 2024-06-27 18:23:19,361 | INFO | building log extracts (sent to the server as 'pilotLog')
[2024-06-27 11:23:42] 2024-06-27 18:23:19,361 | INFO | executing command: tail -n 20 /home/boinc/slots/1/PanDA_Pilot-6235056392/pilotlog.txt
[2024-06-27 11:23:42] 2024-06-27 18:23:19,377 | WARNING |
[2024-06-27 11:23:42] [begin log extracts]
[2024-06-27 11:23:42] - Log from pilotlog.txt -
[2024-06-27 11:23:42] 2024-06-27 18:23:12,307 | INFO | [data] copytool_out thread has finished
[2024-06-27 11:23:42] 2024-06-27 18:23:14,362 | INFO | [data] queue_monitor thread has finished
[2024-06-27 11:23:42] 2024-06-27 18:23:19,341 | INFO | CPU arch script returned: x86-64-v4
[2024-06-27 11:23:42] 2024-06-27 18:23:19,342 | INFO | neither /home/boinc/slots/1/PanDA_Pilot-6235056392/memory_monitor_summary.json, nor /home/boinc/slots/1/memory_monitor_summary.json exist
[2024-06-27 11:23:42] 2024-06-27 18:23:19,343 | INFO | using path: /home/boinc/slots/1/PanDA_Pilot-6235056392/memory_monitor_output.txt (trf name=prmon)
[2024-06-27 11:23:42] 2024-06-27 18:23:19,344 | INFO | extracted standard info from memory monitor json
[2024-06-27 11:23:42] 2024-06-27 18:23:19,344 | WARNING | standard memory fields were not found in memory monitor json (or json doesn't exist yet)
[2024-06-27 11:23:42] 2024-06-27 18:23:19,345 | WARNING | wrong length of table data, x=[883865827.0, 883865888.0, 883865949.0, 883866010.0, 883866071.0, 883866132.0, 883866193.0], y=[1123024.0, 1124517.0, 1124914.0, 1142
[2024-06-27 11:23:42] 2024-06-27 18:23:19,346 | INFO | ..............................
[2024-06-27 11:23:42] 2024-06-27 18:23:19,346 | INFO | . Timing measurements:
[2024-06-27 11:23:42] 2024-06-27 18:23:19,346 | INFO | . get job = 0 s
[2024-06-27 11:23:42] 2024-06-27 18:23:19,346 | INFO | . initial setup = 2 s
[2024-06-27 11:23:42] 2024-06-27 18:23:19,346 | INFO | . payload setup = 6 s
[2024-06-27 11:23:42] 2024-06-27 18:23:19,346 | INFO | . stage-in = 0 s
[2024-06-27 11:23:42] 2024-06-27 18:23:19,346 | INFO | . payload execution = 0 s
[2024-06-27 11:23:42] 2024-06-27 18:23:19,346 | INFO | . stage-out = 0 s
[2024-06-27 11:23:42] 2024-06-27 18:23:19,347 | INFO | . log creation = 0 s
[2024-06-27 11:23:42] 2024-06-27 18:23:19,347 | INFO | ..............................
[2024-06-27 11:23:42] 2024-06-27 18:23:19,361 | INFO | building log extracts (sent to the server as 'pilotLog')
[2024-06-27 11:23:42] 2024-06-27 18:23:19,361 | INFO | executing command: tail -n 20 /home/boinc/slots/1/PanDA_Pilot-6235056392/pilotlog.txt
[2024-06-27 11:23:42] [end log extracts]
[2024-06-27 11:23:42] 2024-06-27 18:23:19,378 | WARNING | pilotErrorCodes = [1213] (will report primary/first error code)
[2024-06-27 11:23:42] 2024-06-27 18:23:19,378 | WARNING | pilotErrorDiags = ['the max batch system time limit has been reached'] (will report primary/first error diag)
[2024-06-27 11:23:42] 2024-06-27 18:23:19,379 | WARNING | job state is 'failed' - order log transfer and abort job_monitor() (2)
[2024-06-27 11:23:42] 2024-06-27 18:23:19,458 | INFO | will abort loop
[2024-06-27 11:23:42] 2024-06-27 18:23:19,804 | INFO |
[2024-06-27 11:23:42]
[2024-06-27 11:23:42] finished pid=24359 exit_code=None state=failed
[2024-06-27 11:23:42]
[2024-06-27 11:23:42] 2024-06-27 18:23:19,804 | WARNING | detected unset exit_code from wait_graceful - reset to -1
[2024-06-27 11:23:42] 2024-06-27 18:23:19,807 | INFO | using pid=35229 to kill prmon
[2024-06-27 11:23:42] 2024-06-27 18:23:19,807 | INFO | stopping utility process 'MemoryMonitor' with signal 10
[2024-06-27 11:23:42] 2024-06-27 18:23:19,807 | INFO | process 35229 no longer exists
[2024-06-27 11:23:42] 2024-06-27 18:23:19,807 | INFO | utility process 24361 cleanup finished with status=True
[2024-06-27 11:23:42] 2024-06-27 18:23:19,808 | INFO | taking a short nap (3 s) to allow the memory monitor to finish writing to the summary file (#0/#20)
[2024-06-27 11:23:42] 2024-06-27 18:23:20,464 | INFO | [job] job monitor thread has finished
[2024-06-27 11:23:42] 2024-06-27 18:23:22,824 | INFO | copied /home/boinc/slots/1/PanDA_Pilot-6235056392/memory_monitor_summary.json to /home/boinc/slots/1
[2024-06-27 11:23:42] 2024-06-27 18:23:22,824 | INFO | CPU consumption time: 26.119999999999997 s (rounded to 26 s)
[2024-06-27 11:23:42] 2024-06-27 18:23:22,824 | WARNING | main payload execution returned non-zero exit code: -1
[2024-06-27 11:23:42] 2024-06-27 18:23:22,825 | INFO | scanning dmesg message for subprocess=36993 for memory errors
[2024-06-27 11:23:42] 2024-06-27 18:23:22,825 | INFO | executing command: dmesg|grep 36993
[2024-06-27 11:23:42] 2024-06-27 18:23:22,845 | INFO | scanning dmesg message for subprocess=36994 for memory errors
[2024-06-27 11:23:42] 2024-06-27 18:23:22,846 | INFO | executing command: dmesg|grep 36994
[2024-06-27 11:23:42] 2024-06-27 18:23:22,864 | INFO | scanning dmesg message for subprocess=36995 for memory errors
[2024-06-27 11:23:42] 2024-06-27 18:23:22,864 | INFO | executing command: dmesg|grep 36995
[2024-06-27 11:23:42] 2024-06-27 18:23:22,881 | INFO | scanning dmesg message for subprocess=36908 for memory errors
[2024-06-27 11:23:42] 2024-06-27 18:23:22,882 | INFO | executing command: dmesg|grep 36908
[2024-06-27 11:23:42] 2024-06-27 18:23:22,898 | INFO | scanning dmesg message for subprocess=37008 for memory errors
[2024-06-27 11:23:42] 2024-06-27 18:23:22,898 | INFO | executing command: dmesg|grep 37008
[2024-06-27 11:23:42] 2024-06-27 18:23:22,917 | WARNING | job report does not exist: /home/boinc/slots/1/PanDA_Pilot-6235056392/jobReport.json
[2024-06-27 11:23:42] 2024-06-27 18:23:22,918 | WARNING | metadata does not exist: /home/boinc/slots/1/PanDA_Pilot-6235056392/metadata.xml
[2024-06-27 11:23:42] 2024-06-27 18:23:22,918 | WARNING | file does not exist: /home/boinc/slots/1/PanDA_Pilot-6235056392/metadata.xml
[2024-06-27 11:23:42] 2024-06-27 18:23:22,918 | INFO | generated guid for lfn=HITS.38921001._060725.pool.root.1: CD4D62D9-7714-4C85-B9BB-DF42AD1A0F78
[2024-06-27 11:23:42] 2024-06-27 18:23:22,918 | WARNING | aborting payload error diagnosis since an error has already been set: [1213, 1315, 1187]
[2024-06-27 11:23:42] 2024-06-27 18:23:24,000 | INFO | [payload] execute_payloads thread has finished
[2024-06-27 11:23:42] 2024-06-27 18:23:25,050 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139858792486720)>', '<ExcThread(queue_monitor, started 139858177660672)>']
[2024-06-27 11:23:42] 2024-06-27 18:23:27,064 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139858792486720)>', '<ExcThread(queue_monitor, started 139858177660672)>']
[2024-06-27 11:23:42] 2024-06-27 18:23:29,077 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139858792486720)>', '<ExcThread(queue_monitor, started 139858177660672)>']
[2024-06-27 11:23:42] 2024-06-27 18:23:31,092 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139858792486720)>', '<ExcThread(queue_monitor, started 139858177660672)>']
[2024-06-27 11:23:42] 2024-06-27 18:23:33,107 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139858792486720)>', '<ExcThread(queue_monitor, started 139858177660672)>']
[2024-06-27 11:23:42] 2024-06-27 18:23:35,121 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139858792486720)>', '<ExcThread(queue_monitor, started 139858177660672)>']
[2024-06-27 11:23:42] 2024-06-27 18:23:35,129 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139858792486720)>', '<ExcThread(queue_monitor, started 139858177660672)>']
[2024-06-27 11:23:42] 2024-06-27 18:23:35,129 | INFO | [job] queue monitor thread has finished
[2024-06-27 11:23:42] 2024-06-27 18:23:37,136 | INFO | caller=run is remaining thread - safe to abort (names=['<_MainThread(MainThread, started 139858792486720)>'])
[2024-06-27 11:23:42] 2024-06-27 18:23:42,163 | INFO | all workflow threads have been joined
[2024-06-27 11:23:42] 2024-06-27 18:23:42,164 | INFO | end of generic workflow (traces error code: 0)
[2024-06-27 11:23:42] 2024-06-27 18:23:42,164 | INFO | traces error code: 0
[2024-06-27 11:23:42] 2024-06-27 18:23:42,165 | INFO | pilot has finished (exit code=0, shell exit code=0)
[2024-06-27 11:23:42] 2024-06-27 18:23:42,268 [wrapper] ==== pilot stdout END ====
[2024-06-27 11:23:42] 2024-06-27 18:23:42,272 [wrapper] ==== wrapper stdout RESUME ====
[2024-06-27 11:23:42] 2024-06-27 18:23:42,276 [wrapper] pilotpid: 11414
[2024-06-27 11:23:42] 2024-06-27 18:23:42,280 [wrapper] Pilot exit status: 0
[2024-06-27 11:23:42] 2024-06-27 18:23:42,292 [wrapper] pandaids: 6235056392
[2024-06-27 11:23:42] 2024-06-27 18:23:42,368 [wrapper] cleanup supervisor_pilot 11419 11415
[2024-06-27 11:23:42] 2024-06-27 18:23:42,372 [wrapper] Test setup, not cleaning
[2024-06-27 11:23:42] 2024-06-27 18:23:42,376 [wrapper] ==== wrapper stdout END ====
[2024-06-27 11:23:42] 2024-06-27 18:23:42,379 [wrapper] ==== wrapper stderr END ====
[2024-06-27 11:23:42] 2024-06-27 18:23:42,387 [wrapper] apfmon messages muted
[2024-06-27 11:23:42] *** Error codes and diagnostics ***
[2024-06-27 11:23:42] "exeErrorCode": 0,
[2024-06-27 11:23:42] "exeErrorDiag": "",
[2024-06-27 11:23:42] "pilotErrorCode": 1213,
[2024-06-27 11:23:42] "pilotErrorDiag": "the max batch system time limit has been reached",
[2024-06-27 11:23:42] *** Listing of results directory ***
[2024-06-27 11:23:42] total 606396
[2024-06-27 11:23:42] -rw-r--r-- 1 boinc boinc 100 Jan 3 1998 wrapper_26015_x86_64-pc-linux-gnu
[2024-06-27 11:23:42] -rwxr-xr-x 1 boinc boinc 7986 Jan 3 1998 run_atlas
[2024-06-27 11:23:42] -rw-r--r-- 1 boinc boinc 105 Jan 3 1998 job.xml
[2024-06-27 11:23:42] -rw-r--r-- 2 boinc boinc 617038186 Jan 3 1998 EVNT.38776190._000763.pool.root.1
[2024-06-27 11:23:42] -rw-r--r-- 2 boinc boinc 17537 Jan 3 1998 start_atlas.sh
[2024-06-27 11:23:42] drwxrwx--x 2 boinc boinc 4096 Jan 3 1998 shared
[2024-06-27 11:23:42] -rw-r--r-- 2 boinc boinc 482531 Jan 3 1998 input.tar.gz
[2024-06-27 11:23:42] -rw-r--r-- 1 boinc boinc 0 Jan 3 1998 boinc_lockfile
[2024-06-27 11:23:42] -rw-r--r-- 1 boinc boinc 2656 Jan 3 1998 pandaJob.out
[2024-06-27 11:23:42] -rw------- 1 boinc boinc 424 Jan 3 1998 setup.sh.local
[2024-06-27 11:23:42] -rw------- 1 boinc boinc 1034827 Jan 3 1998 agis_schedconf.cvmfs.json
[2024-06-27 11:23:42] -rw------- 1 boinc boinc 0 Jan 3 1998 agis_ddmendpoints.agis.ALL.json
[2024-06-27 11:23:42] -rw------- 1 boinc boinc 1321363 Jan 3 1998 cric_ddmendpoints.json
[2024-06-27 11:23:42] drwx------ 4 boinc boinc 4096 Jan 3 1998 pilot3
[2024-06-27 11:23:42] -rw------- 1 boinc boinc 94 Jan 3 1998 pilot_heartbeat.json
[2024-06-27 11:23:42] -rw-r--r-- 1 boinc boinc 469766 Jun 17 15:58 pilot3.tar.gz
[2024-06-27 11:23:42] -rwx------ 1 boinc boinc 32308 Jun 17 16:03 runpilot2-wrapper.sh
[2024-06-27 11:23:42] -rw-r--r-- 1 boinc boinc 5654 Jun 17 16:04 queuedata.json
[2024-06-27 11:23:42] -rw-r--r-- 1 boinc boinc 6629 Jun 27 11:23 init_data.xml
[2024-06-27 11:23:42] -rw------- 1 boinc boinc 2171 Jun 27 11:23 heartbeat.json
[2024-06-27 11:23:42] drwxrwx--- 2 boinc boinc 4096 Jun 27 11:23 PanDA_Pilot-6235056392
[2024-06-27 11:23:42] -rw------- 1 boinc boinc 1021 Jun 27 11:23 memory_monitor_summary.json
[2024-06-27 11:23:42] -rw-r--r-- 1 boinc boinc 8192 Jun 27 11:23 boinc_mmap_file
[2024-06-27 11:23:42] -rw-r--r-- 1 boinc boinc 24 Jun 27 11:23 wrapper_checkpoint.txt
[2024-06-27 11:23:42] -rw-r--r-- 1 boinc boinc 527 Jun 27 11:23 boinc_task_state.xml
[2024-06-27 11:23:42] -rw------- 1 boinc boinc 99021 Jun 27 11:23 pilotlog.txt
[2024-06-27 11:23:42] -rw------- 1 boinc boinc 141782 Jun 27 11:23 log.38921001._060725.job.log.1
[2024-06-27 11:23:42] -rw-r--r-- 1 boinc boinc 571 Jun 27 11:23 runtime_log
[2024-06-27 11:23:42] -rw------- 1 boinc boinc 153600 Jun 27 11:23 result.tar.gz
[2024-06-27 11:23:42] -rw-r--r-- 1 boinc boinc 10987 Jun 27 11:23 runtime_log.err
[2024-06-27 11:23:42] -rw------- 1 boinc boinc 647 Jun 27 11:23 moPLDmMZad5n7Olcko1bjSoqABFKDmABFKDmOtvXDmF0pKDmAI1Qam.diag
[2024-06-27 11:23:42] -rw-r--r-- 1 boinc boinc 26171 Jun 27 11:23 stderr.txt
[2024-06-27 11:23:42] No HITS result produced
[2024-06-27 11:23:42] *** Contents of shared directory: ***
[2024-06-27 11:23:42] total 603228
[2024-06-27 11:23:42] -rw-r--r-- 2 boinc boinc 617038186 Jan 3 1998 ATLAS.root_0
[2024-06-27 11:23:42] -rw-r--r-- 2 boinc boinc 17537 Jan 3 1998 start_atlas.sh
[2024-06-27 11:23:42] -rw-r--r-- 2 boinc boinc 482531 Jan 3 1998 input.tar.gz
[2024-06-27 11:23:42] -rw------- 1 boinc boinc 153600 Jun 27 11:23 result.tar.gz
11:23:44 (2565): run_atlas exited; CPU time 25.718279
11:23:44 (2565): called boinc_finish(0)
</stderr_txt>
]]>
©2024 CERN