| Name | 9kaNDmvowO5n9Rq4apoT9bVoABFKDmABFKDmlqFKDm0TFKDmkH0R8n_0 |
| Workunit | 222849753 |
| Created | 8 May 2024, 13:47:37 UTC |
| Sent | 8 May 2024, 13:47:39 UTC |
| Report deadline | 16 May 2024, 13:47:39 UTC |
| Received | 16 May 2024, 13:50:28 UTC |
| Server state | Over |
| Outcome | Computation error |
| Client state | Compute error |
| Exit status | 0 (0x00000000) |
| Computer ID | 10603258 |
| Run time | 5 days 13 hours 21 min 21 sec |
| CPU time | 5 days 15 hours 25 min 17 sec |
| Validate state | Invalid |
| Credit | 0.00 |
| Device peak FLOPS | 30.54 GFLOPS |
| Application version | ATLAS Simulation v3.01 (native_mt) x86_64-pc-linux-gnu |
| Peak working set size | 1.87 GB |
| Peak swap size | 31.96 GB |
| Peak disk usage | 2.86 GB |
Stderr output
<core_client_version>7.16.11</core_client_version>
<![CDATA[
<stderr_txt>
06:49:37 (107591): wrapper (7.7.26015): starting
06:49:37 (107591): wrapper: running run_atlas (--nthreads 12)
[2024-05-08 06:49:37] Arguments: --nthreads 12
[2024-05-08 06:49:37] Threads: 12
[2024-05-08 06:49:37] Checking for CVMFS
[2024-05-08 06:49:38] Probing /cvmfs/atlas.cern.ch... OK
[2024-05-08 06:49:38] Probing /cvmfs/atlas-condb.cern.ch... OK
[2024-05-08 06:49:38] Running cvmfs_config stat atlas.cern.ch
[2024-05-08 06:49:40] 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
[2024-05-08 06:49:40] 2.10.1.0 198194 170597 205924 132520 1 72 27432873 45568000 27390 130560 0 980471992 99.757 587859342 18624 http://cvmfs-s1bnl.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://206.12.9.163:3129 1
[2024-05-08 06:49:40] CVMFS is ok
[2024-05-08 06:49:40] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2024-05-08 06:49:40] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2024-05-08 06:49:40] Further information can be found at the LHC@home message board.
[2024-05-08 06:49:40] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2024-05-08 06:49:40] Checking for apptainer binary...
[2024-05-08 06:49:40] Using apptainer found in PATH at /usr/bin/apptainer
[2024-05-08 06:49:40] Running /usr/bin/apptainer --version
[2024-05-08 06:49:42] apptainer version 1.1.8-1.el7
[2024-05-08 06:49:42] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2024-05-08 06:49:44] 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/0/.apptainertmp], will not forward new value [/home/boinc] from parent process environment wns0121.triumf.lcg
[2024-05-08 06:49:44] apptainer works
[2024-05-08 06:49:44] Set ATHENA_PROC_NUMBER=12
[2024-05-08 06:49:44] Set ATHENA_CORE_NUMBER=12
[2024-05-08 06:49:44] Starting ATLAS job with PandaID=6199129038
[2024-05-08 06:49:44] Running command: /usr/bin/apptainer exec -B /cvmfs,/home/boinc/slots/0 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2024-05-16 06:49:00] *** The last 200 lines of the pilot log: ***
[2024-05-16 06:49:00] 2024-05-16 13:40:26,035 | INFO | monitor loop #19507: job 0:6199129038 is in state 'running'
[2024-05-16 06:49:00] 2024-05-16 13:40:38,464 | INFO | (instant) CPU consumption time for pid=122676: 15238.19 (rounded to 15238)
[2024-05-16 06:49:00] 2024-05-16 13:40:38,464 | INFO | neither /home/boinc/slots/0/PanDA_Pilot-6199129038/memory_monitor_summary.json, nor /home/boinc/slots/0/memory_monitor_summary.json exist
[2024-05-16 06:49:00] 2024-05-16 13:40:38,464 | INFO | using path: /home/boinc/slots/0/PanDA_Pilot-6199129038/memory_monitor_output.txt (trf name=prmon)
[2024-05-16 06:49:00] 2024-05-16 13:40:38,903 | INFO | oom_score(pilot) = 0, oom_score(payload) = 0
[2024-05-16 06:49:00] 2024-05-16 13:40:42,896 | INFO | number of running child processes to parent process 122676: 20
[2024-05-16 06:49:00] 2024-05-16 13:40:42,896 | INFO | maximum number of monitored processes: 21
[2024-05-16 06:49:00] 2024-05-16 13:40:42,896 | INFO | will not send any job update
[2024-05-16 06:49:00] 2024-05-16 13:40:45,477 | INFO | monitor loop #19508: job 0:6199129038 is in state 'running'
[2024-05-16 06:49:00] 2024-05-16 13:41:04,516 | INFO | (instant) CPU consumption time for pid=122676: 15239.21 (rounded to 15239)
[2024-05-16 06:49:00] 2024-05-16 13:41:04,517 | INFO | neither /home/boinc/slots/0/PanDA_Pilot-6199129038/memory_monitor_summary.json, nor /home/boinc/slots/0/memory_monitor_summary.json exist
[2024-05-16 06:49:00] 2024-05-16 13:41:04,517 | INFO | using path: /home/boinc/slots/0/PanDA_Pilot-6199129038/memory_monitor_output.txt (trf name=prmon)
[2024-05-16 06:49:00] 2024-05-16 13:41:10,228 | INFO | oom_score(pilot) = 0, oom_score(payload) = 0
[2024-05-16 06:49:00] 2024-05-16 13:41:15,769 | INFO | number of running child processes to parent process 122676: 17
[2024-05-16 06:49:00] 2024-05-16 13:41:15,769 | INFO | maximum number of monitored processes: 21
[2024-05-16 06:49:00] 2024-05-16 13:41:15,769 | INFO | will not send any job update
[2024-05-16 06:49:00] 2024-05-16 13:41:18,317 | INFO | monitor loop #19509: job 0:6199129038 is in state 'running'
[2024-05-16 06:49:00] 2024-05-16 13:41:30,664 | INFO | (instant) CPU consumption time for pid=122676: 15239.21 (rounded to 15239)
[2024-05-16 06:49:00] 2024-05-16 13:41:30,665 | INFO | neither /home/boinc/slots/0/PanDA_Pilot-6199129038/memory_monitor_summary.json, nor /home/boinc/slots/0/memory_monitor_summary.json exist
[2024-05-16 06:49:00] 2024-05-16 13:41:30,665 | INFO | using path: /home/boinc/slots/0/PanDA_Pilot-6199129038/memory_monitor_output.txt (trf name=prmon)
[2024-05-16 06:49:00] 2024-05-16 13:41:30,906 | INFO | neither /home/boinc/slots/0/PanDA_Pilot-6199129038/memory_monitor_summary.json, nor /home/boinc/slots/0/memory_monitor_summary.json exist
[2024-05-16 06:49:00] 2024-05-16 13:41:30,906 | INFO | using path: /home/boinc/slots/0/PanDA_Pilot-6199129038/memory_monitor_output.txt (trf name=prmon)
[2024-05-16 06:49:00] 2024-05-16 13:41:31,122 | INFO | max memory (maxPSS) used by the payload is within the allowed limit: 4382528 B (2 * maxRSS = 786432000 B)
[2024-05-16 06:49:00] 2024-05-16 13:41:31,122 | INFO | oom_score(pilot) = 0, oom_score(payload) = 0
[2024-05-16 06:49:00] 2024-05-16 13:41:31,123 | INFO | payload log (log.EVNTtoHITS) within allowed size limit (2147483648 B): 669133 B
[2024-05-16 06:49:00] 2024-05-16 13:41:31,123 | INFO | payload log (payload.stdout) within allowed size limit (2147483648 B): 6419 B
[2024-05-16 06:49:00] 2024-05-16 13:41:31,123 | INFO | executing command: df -mP /home/boinc/slots/0
[2024-05-16 06:49:00] 2024-05-16 13:41:31,520 | INFO | sufficient remaining disk space (2090835378176 B)
[2024-05-16 06:49:00] 2024-05-16 13:41:31,521 | INFO | work directory size check will use 61362667520 B as a max limit (10% grace limit added)
[2024-05-16 06:49:00] 2024-05-16 13:41:31,563 | INFO | size of work directory /home/boinc/slots/0/PanDA_Pilot-6199129038: 1988644696 B (within 61362667520 B limit)
[2024-05-16 06:49:00] 2024-05-16 13:41:31,563 | INFO | pfn file=/home/boinc/slots/0/PanDA_Pilot-6199129038/HITS.38734053._002409.pool.root.1 does not exist (skip from workdir size calculation)
[2024-05-16 06:49:00] 2024-05-16 13:41:31,563 | INFO | total size of present files: 0 B (workdir size: 1988644696 B)
[2024-05-16 06:49:00] 2024-05-16 13:41:31,563 | INFO | output file size check: skipping output file /home/boinc/slots/0/PanDA_Pilot-6199129038/HITS.38734053._002409.pool.root.1 since it does not exist
[2024-05-16 06:49:00] 2024-05-16 13:41:46,067 | INFO | number of running child processes to parent process 122676: 20
[2024-05-16 06:49:00] 2024-05-16 13:41:46,067 | INFO | maximum number of monitored processes: 21
[2024-05-16 06:49:00] 2024-05-16 13:41:46,068 | INFO | will not send any job update
[2024-05-16 06:49:00] 2024-05-16 13:41:48,672 | INFO | monitor loop #19510: job 0:6199129038 is in state 'running'
[2024-05-16 06:49:00] 2024-05-16 13:41:51,463 | INFO | 690648s have passed since pilot start
[2024-05-16 06:49:00] 2024-05-16 13:42:11,086 | INFO | (instant) CPU consumption time for pid=122676: 15240.220000000001 (rounded to 15240)
[2024-05-16 06:49:00] 2024-05-16 13:42:11,086 | INFO | neither /home/boinc/slots/0/PanDA_Pilot-6199129038/memory_monitor_summary.json, nor /home/boinc/slots/0/memory_monitor_summary.json exist
[2024-05-16 06:49:00] 2024-05-16 13:42:11,086 | INFO | using path: /home/boinc/slots/0/PanDA_Pilot-6199129038/memory_monitor_output.txt (trf name=prmon)
[2024-05-16 06:49:00] 2024-05-16 13:42:12,068 | INFO | oom_score(pilot) = 0, oom_score(payload) = 0
[2024-05-16 06:49:00] 2024-05-16 13:42:26,424 | INFO | number of running child processes to parent process 122676: 17
[2024-05-16 06:49:00] 2024-05-16 13:42:26,425 | INFO | maximum number of monitored processes: 21
[2024-05-16 06:49:00] 2024-05-16 13:42:26,425 | INFO | will not send any job update
[2024-05-16 06:49:00] 2024-05-16 13:42:29,066 | INFO | monitor loop #19511: job 0:6199129038 is in state 'running'
[2024-05-16 06:49:00] 2024-05-16 13:42:39,051 | INFO | running: iteration=10860 pid=122676 exit_code=None
[2024-05-16 06:49:00] 2024-05-16 13:42:40,494 | INFO | (instant) CPU consumption time for pid=122676: 15240.23 (rounded to 15240)
[2024-05-16 06:49:00] 2024-05-16 13:42:40,494 | INFO | neither /home/boinc/slots/0/PanDA_Pilot-6199129038/memory_monitor_summary.json, nor /home/boinc/slots/0/memory_monitor_summary.json exist
[2024-05-16 06:49:00] 2024-05-16 13:42:40,494 | INFO | using path: /home/boinc/slots/0/PanDA_Pilot-6199129038/memory_monitor_output.txt (trf name=prmon)
[2024-05-16 06:49:00] 2024-05-16 13:42:40,747 | INFO | oom_score(pilot) = 0, oom_score(payload) = 0
[2024-05-16 06:49:00] 2024-05-16 13:42:42,311 | INFO | number of running child processes to parent process 122676: 20
[2024-05-16 06:49:00] 2024-05-16 13:42:42,315 | INFO | maximum number of monitored processes: 21
[2024-05-16 06:49:00] 2024-05-16 13:42:42,315 | INFO | will send heartbeat for job in 'running' state
[2024-05-16 06:49:00] 2024-05-16 13:42:42,315 | INFO | pilot will not update the server (heartbeat message will be written to file)
[2024-05-16 06:49:00] 2024-05-16 13:42:42,315 | INFO | job 6199129038 has state 'running' - writing heartbeat
[2024-05-16 06:49:00] 2024-05-16 13:42:42,315 | INFO | payload/TRF did not report the number of read events
[2024-05-16 06:49:00] 2024-05-16 13:42:42,325 | INFO | executing command: lscpu
[2024-05-16 06:49:00] 2024-05-16 13:42:42,465 | INFO | found 48 cores (24 cores per socket, 2 sockets)
[2024-05-16 06:49:00] 2024-05-16 13:42:42,466 | INFO | executing command: grep -o 'avx2[^ ]*\|AVX2[^ ]*' /proc/cpuinfo
[2024-05-16 06:49:00] 2024-05-16 13:42:42,646 | 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-05-16 06:49:00] 2024-05-16 13:43:53,810 | INFO | 690770s have passed since pilot start
[2024-05-16 06:49:00] 2024-05-16 13:45:54,424 | INFO | 690891s have passed since pilot start
[2024-05-16 06:49:00] 2024-05-16 13:46:10,944 | INFO | CPU arch script returned: x86-64-v4
[2024-05-16 06:49:00] 2024-05-16 13:46:10,944 | INFO | neither /home/boinc/slots/0/PanDA_Pilot-6199129038/memory_monitor_summary.json, nor /home/boinc/slots/0/memory_monitor_summary.json exist
[2024-05-16 06:49:00] 2024-05-16 13:46:10,944 | INFO | using path: /home/boinc/slots/0/PanDA_Pilot-6199129038/memory_monitor_output.txt (trf name=prmon)
[2024-05-16 06:49:00] 2024-05-16 13:46:26,140 | INFO | extracted standard info from memory monitor json
[2024-05-16 06:49:00] 2024-05-16 13:46:26,140 | WARNING | standard memory fields were not found in memory monitor json (or json doesn't exist yet)
[2024-05-16 06:49:00] 2024-05-16 13:46:26,446 | INFO | fitting pss+swap vs Time
[2024-05-16 06:49:00] 2024-05-16 13:46:26,455 | INFO | model: linear, x: [1715176395.0, 1715176456.0, 1715176517.0, 1715176578.0, 1715176639.0, 1715176700.0, 1715176761.0, 1715176822.0, 1715176883.0, 1715176944.0, 1715
[2024-05-16 06:49:00] 2024-05-16 13:46:26,459 | INFO | sum of square deviations: 434237092796993.56
[2024-05-16 06:49:00] 2024-05-16 13:46:32,879 | INFO | sum of deviations: 411794597812730.44
[2024-05-16 06:49:00] 2024-05-16 13:46:32,892 | INFO | mean x: 1715515686.625206
[2024-05-16 06:49:00] 2024-05-16 13:46:32,901 | INFO | mean y: 4602525.623282652
[2024-05-16 06:49:00] 2024-05-16 13:46:32,901 | INFO | -- intersect: -1622250877.5831506
[2024-05-16 06:49:00] 2024-05-16 13:46:32,901 | INFO | intersect: -1622250877.5831506
[2024-05-16 06:49:00] 2024-05-16 13:46:32,967 | INFO | chi2: 41.97397825946831
[2024-05-16 06:49:00] 2024-05-16 13:46:32,976 | INFO | model: linear, x: [1715176395.0, 1715176456.0, 1715176517.0, 1715176578.0, 1715176639.0, 1715176700.0, 1715176761.0, 1715176822.0, 1715176883.0, 1715176944.0, 1715
[2024-05-16 06:49:00] 2024-05-16 13:46:32,979 | INFO | sum of square deviations: 433619664508632.75
[2024-05-16 06:49:00] 2024-05-16 13:46:41,287 | INFO | sum of deviations: 411543859379160.94
[2024-05-16 06:49:00] 2024-05-16 13:46:41,288 | INFO | mean x: 1715515525.6590304
[2024-05-16 06:49:00] 2024-05-16 13:46:41,289 | INFO | mean y: 4602460.25520022
[2024-05-16 06:49:00] 2024-05-16 13:46:41,289 | INFO | -- intersect: -1623575267.9265246
[2024-05-16 06:49:00] 2024-05-16 13:46:41,289 | INFO | intersect: -1623575267.9265246
[2024-05-16 06:49:00] 2024-05-16 13:46:41,298 | INFO | chi2: 41.96735709115314
[2024-05-16 06:49:00] 2024-05-16 13:46:41,298 | INFO | current chi2=41.96735709115314 (change=0.015774459771816133 %)
[2024-05-16 06:49:00] 2024-05-16 13:46:41,298 | INFO | right removable region: 10912
[2024-05-16 06:49:00] 2024-05-16 13:46:41,312 | INFO | model: linear, x: [1715176700.0, 1715176761.0, 1715176822.0, 1715176883.0, 1715176944.0, 1715177010.0, 1715177067.0, 1715177129.0, 1715177188.0, 1715177250.0, 1715
[2024-05-16 06:49:00] 2024-05-16 13:46:41,316 | INFO | sum of square deviations: 433661649056656.44
[2024-05-16 06:49:00] 2024-05-16 13:47:23,754 | INFO | sum of deviations: 404610019935323.8
[2024-05-16 06:49:00] 2024-05-16 13:47:23,755 | INFO | mean x: 1715515842.022267
[2024-05-16 06:49:00] 2024-05-16 13:47:23,755 | INFO | mean y: 4604465.765417392
[2024-05-16 06:49:00] 2024-05-16 13:47:23,755 | INFO | -- intersect: -1595986457.0194323
[2024-05-16 06:49:00] 2024-05-16 13:47:23,755 | INFO | intersect: -1595986457.0194323
[2024-05-16 06:49:00] 2024-05-16 13:47:23,763 | INFO | chi2: 37.69441542216128
[2024-05-16 06:49:00] 2024-05-16 13:47:23,763 | INFO | current chi2=37.69441542216128 (change=10.195752260727556 %)
[2024-05-16 06:49:00] 2024-05-16 13:47:23,764 | INFO | left removable region: 10
[2024-05-16 06:49:00] 2024-05-16 13:47:23,989 | INFO | model: linear, x: [1715177010.0, 1715177067.0, 1715177129.0, 1715177188.0, 1715177250.0, 1715177312.0, 1715177372.0, 1715177432.0, 1715177496.0, 1715177554.0, 1715
[2024-05-16 06:49:00] 2024-05-16 13:47:24,435 | INFO | sum of square deviations: 432347183772445.56
[2024-05-16 06:49:00] 2024-05-16 13:47:38,070 | INFO | sum of deviations: 397660053873869.0
[2024-05-16 06:49:00] 2024-05-16 13:47:38,071 | INFO | mean x: 1715515804.257384
[2024-05-16 06:49:00] 2024-05-16 13:47:38,071 | INFO | mean y: 4606188.327187672
[2024-05-16 06:49:00] 2024-05-16 13:47:38,071 | INFO | -- intersect: -1573274118.8601923
[2024-05-16 06:49:00] 2024-05-16 13:47:38,071 | INFO | intersect: -1573274118.8601923
[2024-05-16 06:49:00] 2024-05-16 13:47:38,079 | INFO | chi2: 34.077345603386014
[2024-05-16 06:49:00] 2024-05-16 13:47:38,079 | INFO | -- intersect: -1573274118.8601923
[2024-05-16 06:49:00] 2024-05-16 13:47:38,079 | INFO | current memory leak: 0.92 B/s (using 10902 data points, chi2=34.08)
[2024-05-16 06:49:00] 2024-05-16 13:47:40,591 | INFO | monitor loop #19512: job 0:6199129038 is in state 'running'
[2024-05-16 06:49:00] 2024-05-16 13:47:56,574 | INFO | (instant) CPU consumption time for pid=122676: 15246.220000000001 (rounded to 15246)
[2024-05-16 06:49:00] 2024-05-16 13:47:56,574 | INFO | neither /home/boinc/slots/0/PanDA_Pilot-6199129038/memory_monitor_summary.json, nor /home/boinc/slots/0/memory_monitor_summary.json exist
[2024-05-16 06:49:00] 2024-05-16 13:47:56,575 | INFO | using path: /home/boinc/slots/0/PanDA_Pilot-6199129038/memory_monitor_output.txt (trf name=prmon)
[2024-05-16 06:49:00] 2024-05-16 13:47:58,742 | INFO | neither /home/boinc/slots/0/PanDA_Pilot-6199129038/memory_monitor_summary.json, nor /home/boinc/slots/0/memory_monitor_summary.json exist
[2024-05-16 06:49:00] 2024-05-16 13:47:58,742 | INFO | using path: /home/boinc/slots/0/PanDA_Pilot-6199129038/memory_monitor_output.txt (trf name=prmon)
[2024-05-16 06:49:00] 2024-05-16 13:48:04,864 | CRITICAL | max running time (691200s) minus grace time (180s) has been exceeded - time to abort pilot
[2024-05-16 06:49:00] 2024-05-16 13:48:04,864 | INFO | setting REACHED_MAXTIME and graceful stop
[2024-05-16 06:49:00] 2024-05-16 13:48:04,864 | INFO | [monitor] control thread has ended
[2024-05-16 06:49:00] 2024-05-16 13:48:04,937 | INFO | breaking -- sending SIGTERM to pid=122676
[2024-05-16 06:49:00] 2024-05-16 13:48:04,937 | INFO | breaking -- sleep 10 s before sending SIGKILL pid=122676
[2024-05-16 06:49:00] 2024-05-16 13:48:06,078 | INFO | all data control threads have been joined
[2024-05-16 06:49:00] 2024-05-16 13:48:06,095 | INFO | job.realtimelogging is not enabled
[2024-05-16 06:49:00] 2024-05-16 13:48:06,123 | INFO | max memory (maxPSS) used by the payload is within the allowed limit: 4382528 B (2 * maxRSS = 786432000 B)
[2024-05-16 06:49:00] 2024-05-16 13:48:06,123 | INFO | oom_score(pilot) = 0, oom_score(payload) = 0
[2024-05-16 06:49:00] 2024-05-16 13:48:06,123 | INFO | reaping zombies for max 20 seconds
[2024-05-16 06:49:00] 2024-05-16 13:48:06,135 | INFO | checking for looping job (in state=running)
[2024-05-16 06:49:00] 2024-05-16 13:48:06,135 | INFO | using looping job limit: 7200 s
[2024-05-16 06:49:00] 2024-05-16 13:48:06,136 | INFO | executing command: find /home/boinc/slots/0/PanDA_Pilot-6199129038 -mmin -120
[2024-05-16 06:49:00] 2024-05-16 13:48:06,727 | INFO | found 60 files that were recently updated
[2024-05-16 06:49:00] 2024-05-16 13:48:06,847 | INFO | file /home/boinc/slots/0/PanDA_Pilot-6199129038/athenaMP-workers-EVNTtoHITS-sim/worker_11/ntuple.pmon.stream is the most recently updated file (at time=1715867086)
[2024-05-16 06:49:00] 2024-05-16 13:48:06,971 | INFO | files were last touched 0h 3m 20s ago (current time: 1715867286)
[2024-05-16 06:49:00] 2024-05-16 13:48:07,082 | INFO | all payload control threads have been joined
[2024-05-16 06:49:00] 2024-05-16 13:48:07,095 | INFO | [job] retrieve thread has finished
[2024-05-16 06:49:00] 2024-05-16 13:48:07,137 | INFO | [payload] run_realtimelog thread has finished
[2024-05-16 06:49:00] 2024-05-16 13:48:07,141 | INFO | all job control threads have been joined
[2024-05-16 06:49:00] 2024-05-16 13:48:07,161 | WARNING | since job:queue_monitor is responsible for sending job updates, we sleep for 20 s
[2024-05-16 06:49:00] 2024-05-16 13:48:07,186 | INFO | [data] control thread has finished
[2024-05-16 06:49:00] 2024-05-16 13:48:07,203 | INFO | payload log (log.EVNTtoHITS) within allowed size limit (2147483648 B): 669133 B
[2024-05-16 06:49:00] 2024-05-16 13:48:07,407 | INFO | payload log (payload.stdout) within allowed size limit (2147483648 B): 6419 B
[2024-05-16 06:49:00] 2024-05-16 13:48:07,407 | INFO | executing command: df -mP /home/boinc/slots/0
[2024-05-16 06:49:00] 2024-05-16 13:48:07,235 | INFO | [payload] validate_post thread has finished
[2024-05-16 06:49:00] 2024-05-16 13:48:07,260 | INFO | [payload] failed_post thread has finished
[2024-05-16 06:49:00] 2024-05-16 13:48:08,085 | INFO | [payload] validate_pre thread has finished
[2024-05-16 06:49:00] 2024-05-16 13:48:08,110 | INFO | [payload] control thread has finished
[2024-05-16 06:49:00] 2024-05-16 13:48:08,189 | INFO | [data] copytool_in thread has finished
[2024-05-16 06:49:00] 2024-05-16 13:48:08,209 | INFO | [data] copytool_out thread has finished
[2024-05-16 06:49:00] 2024-05-16 13:48:08,229 | INFO | [job] validate thread has finished
[2024-05-16 06:49:00] 2024-05-16 13:48:08,267 | INFO | [job] create_data_payload thread has finished
[2024-05-16 06:49:00] 2024-05-16 13:48:08,355 | INFO | sufficient remaining disk space (2087871053824 B)
[2024-05-16 06:49:00] 2024-05-16 13:48:08,355 | INFO | work directory size check will use 61362667520 B as a max limit (10% grace limit added)
[2024-05-16 06:49:00] 2024-05-16 13:48:08,401 | INFO | [job] control thread has finished
[2024-05-16 06:49:00] 2024-05-16 13:48:08,773 | INFO | size of work directory /home/boinc/slots/0/PanDA_Pilot-6199129038: 1989833391 B (within 61362667520 B limit)
[2024-05-16 06:49:00] 2024-05-16 13:48:08,773 | INFO | pfn file=/home/boinc/slots/0/PanDA_Pilot-6199129038/HITS.38734053._002409.pool.root.1 does not exist (skip from workdir size calculation)
[2024-05-16 06:49:00] 2024-05-16 13:48:08,773 | INFO | total size of present files: 0 B (workdir size: 1989833391 B)
[2024-05-16 06:49:00] 2024-05-16 13:48:08,773 | INFO | output file size check: skipping output file /home/boinc/slots/0/PanDA_Pilot-6199129038/HITS.38734053._002409.pool.root.1 since it does not exist
[2024-05-16 06:49:00] 2024-05-16 13:48:09,194 | INFO | [data] queue_monitor thread has finished
[2024-05-16 06:49:00] 2024-05-16 13:48:13,041 | INFO | number of running child processes to parent process 122676: 1
[2024-05-16 06:49:00] 2024-05-16 13:48:13,041 | INFO | maximum number of monitored processes: 21
[2024-05-16 06:49:00] 2024-05-16 13:48:13,041 | INFO | will not send any job update
[2024-05-16 06:49:00] 2024-05-16 13:48:13,041 | INFO | will abort loop
[2024-05-16 06:49:00] 2024-05-16 13:48:14,047 | INFO | [job] job monitor thread has finished
[2024-05-16 06:49:00] 2024-05-16 13:48:14,991 | INFO |
[2024-05-16 06:49:00]
[2024-05-16 06:49:00] finished pid=122676 exit_code=None state=failed
[2024-05-16 06:49:00]
[2024-05-16 06:49:00] 2024-05-16 13:48:14,991 | WARNING | detected unset exit_code from wait_graceful - reset to -1
[2024-05-16 06:49:00] 2024-05-16 13:48:15,311 | INFO | using pid=132405 to kill prmon
[2024-05-16 06:49:00] 2024-05-16 13:48:15,311 | INFO | stopping utility process 'MemoryMonitor' with signal 10
[2024-05-16 06:49:00] 2024-05-16 13:48:15,311 | WARNING | Error sending signal to/waiting for process 132405: [Errno 3] No such process
[2024-05-16 06:49:00] 2024-05-16 13:48:15,311 | INFO | utility process 122678 cleanup finished with status=None
[2024-05-16 06:49:00] 2024-05-16 13:48:15,570 | INFO | copied /home/boinc/slots/0/PanDA_Pilot-6199129038/memory_monitor_summary.json to /home/boinc/slots/0
[2024-05-16 06:49:00] 2024-05-16 13:48:15,570 | INFO | CPU consumption time: 10774.84 s (rounded to 10775 s)
[2024-05-16 06:49:00] 2024-05-16 13:48:15,570 | WARNING | main payload execution returned non-zero exit code: -1
[2024-05-16 06:49:00] 2024-05-16 13:48:15,666 | INFO | scanning dmesg message for subprocess=131933 for memory errors
[2024-05-16 06:49:00] 2024-05-16 13:48:15,666 | INFO | executing command: dmesg|grep 131933
[2024-05-16 06:49:00] 2024-05-16 13:48:18,688 | WARNING | job report does not exist: /home/boinc/slots/0/PanDA_Pilot-6199129038/jobReport.json
[2024-05-16 06:49:00] 2024-05-16 13:48:18,771 | WARNING | metadata does not exist: /home/boinc/slots/0/PanDA_Pilot-6199129038/metadata.xml
[2024-05-16 06:49:00] 2024-05-16 13:48:18,771 | WARNING | file does not exist: /home/boinc/slots/0/PanDA_Pilot-6199129038/metadata.xml
[2024-05-16 06:49:00] 2024-05-16 13:48:18,771 | INFO | generated guid for lfn=HITS.38734053._002409.pool.root.1: 36E452A6-811B-470E-9BA6-29209185051C
[2024-05-16 06:49:00] 2024-05-16 13:48:18,771 | WARNING | aborting payload error diagnosis since an error has already been set: [1315, 1187]
[2024-05-16 06:49:00] 2024-05-16 13:48:23,029 | INFO | [payload] execute_payloads thread has finished
[2024-05-16 06:49:00] 2024-05-16 13:48:23,759 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139687267260224)>', '<ExcThread(queue_monitor, started 139686731298560)>']
[2024-05-16 06:49:00] 2024-05-16 13:48:25,771 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139687267260224)>', '<ExcThread(queue_monitor, started 139686731298560)>']
[2024-05-16 06:49:00] 2024-05-16 13:48:27,783 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139687267260224)>', '<ExcThread(queue_monitor, started 139686731298560)>']
[2024-05-16 06:49:00] 2024-05-16 13:48:29,795 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139687267260224)>', '<ExcThread(queue_monitor, started 139686731298560)>']
[2024-05-16 06:49:00] 2024-05-16 13:48:30,469 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139687267260224)>', '<ExcThread(queue_monitor, started 139686731298560)>']
[2024-05-16 06:49:00] 2024-05-16 13:48:30,469 | INFO | [job] queue monitor thread has finished
[2024-05-16 06:49:00] 2024-05-16 13:48:31,807 | INFO | caller=run is remaining thread - safe to abort (names=['<_MainThread(MainThread, started 139687267260224)>'])
[2024-05-16 06:49:00] 2024-05-16 13:48:36,833 | INFO | all workflow threads have been joined
[2024-05-16 06:49:00] 2024-05-16 13:48:36,833 | INFO | end of generic workflow (traces error code: 0)
[2024-05-16 06:49:00] 2024-05-16 13:48:36,835 | INFO | traces error code: 0
[2024-05-16 06:49:00] 2024-05-16 13:48:36,900 | INFO | pilot has finished (exit code=0, shell exit code=0)
[2024-05-16 06:49:00] 2024-05-16 13:48:40,339 [wrapper] ==== pilot stdout END ====
[2024-05-16 06:49:00] 2024-05-16 13:48:40,390 [wrapper] ==== wrapper stdout RESUME ====
[2024-05-16 06:49:00] 2024-05-16 13:48:40,543 [wrapper] pilotpid: 112640
[2024-05-16 06:49:00] 2024-05-16 13:48:40,653 [wrapper] Pilot exit status: 0
[2024-05-16 06:49:00] 2024-05-16 13:48:41,173 [wrapper] pandaids: 6199129038
[2024-05-16 06:49:00] 2024-05-16 13:48:42,877 [wrapper] cleanup: SIGTERM to supervisor_pilot 2605 112641
[2024-05-16 06:49:00] 2024-05-16 13:48:42,881 [wrapper] Test setup, not cleaning
[2024-05-16 06:49:00] 2024-05-16 13:48:42,922 [wrapper] ==== wrapper stdout END ====
[2024-05-16 06:49:00] 2024-05-16 13:48:43,066 [wrapper] ==== wrapper stderr END ====
[2024-05-16 06:49:00] 2024-05-16 13:48:43,360 [wrapper] apfmon messages muted
[2024-05-16 06:49:00] *** Error codes and diagnostics ***
[2024-05-16 06:49:00] *** Listing of results directory ***
[2024-05-16 06:49:01] total 937004
[2024-05-16 06:49:01] -rw-r--r-- 1 boinc boinc 5633 May 8 06:46 queuedata.json
[2024-05-16 06:49:01] -rwx------ 1 boinc boinc 32251 May 8 06:47 runpilot2-wrapper.sh
[2024-05-16 06:49:01] -rw-r--r-- 1 boinc boinc 468928 May 8 06:47 pilot3.tar.gz
[2024-05-16 06:49:01] -rw-r--r-- 1 boinc boinc 100 May 8 06:49 wrapper_26015_x86_64-pc-linux-gnu
[2024-05-16 06:49:01] -rwxr-xr-x 1 boinc boinc 7986 May 8 06:49 run_atlas
[2024-05-16 06:49:01] -rw-r--r-- 1 boinc boinc 105 May 8 06:49 job.xml
[2024-05-16 06:49:01] -rw-r--r-- 2 boinc boinc 329319690 May 8 06:49 EVNT.38734051._000661.pool.root.1
[2024-05-16 06:49:01] -rw-r--r-- 1 boinc boinc 6621 May 8 06:49 init_data.xml
[2024-05-16 06:49:01] -rw-r--r-- 2 boinc boinc 17537 May 8 06:49 start_atlas.sh
[2024-05-16 06:49:01] drwxrwx--x 2 boinc boinc 4096 May 8 06:49 shared
[2024-05-16 06:49:01] -rw-r--r-- 2 boinc boinc 481735 May 8 06:49 input.tar.gz
[2024-05-16 06:49:01] -rw-r--r-- 1 boinc boinc 0 May 8 06:49 boinc_lockfile
[2024-05-16 06:49:01] -rw-r--r-- 1 boinc boinc 2851 May 8 06:49 pandaJob.out
[2024-05-16 06:49:01] -rw------- 1 boinc boinc 424 May 8 06:49 setup.sh.local
[2024-05-16 06:49:01] -rw------- 1 boinc boinc 1001067 May 8 06:51 agis_schedconf.cvmfs.json
[2024-05-16 06:49:01] -rw------- 1 boinc boinc 0 May 8 06:51 agis_ddmendpoints.agis.ALL.json
[2024-05-16 06:49:01] -rw------- 1 boinc boinc 1317658 May 8 06:51 cric_ddmendpoints.json
[2024-05-16 06:49:01] drwx------ 4 boinc boinc 4096 May 8 06:51 pilot3
[2024-05-16 06:49:01] -rw------- 1 boinc boinc 95 May 16 06:47 pilot_heartbeat.json
[2024-05-16 06:49:01] -rw------- 1 boinc boinc 945 May 16 06:47 heartbeat.json
[2024-05-16 06:49:01] -rw-r--r-- 1 boinc boinc 534 May 16 06:48 boinc_task_state.xml
[2024-05-16 06:49:01] drwxrwx--- 3 boinc boinc 4096 May 16 06:48 PanDA_Pilot-6199129038
[2024-05-16 06:49:01] -rw------- 1 boinc boinc 1085 May 16 06:48 memory_monitor_summary.json
[2024-05-16 06:49:01] -rw------- 1 boinc boinc 208882723 May 16 06:48 pilotlog.txt
[2024-05-16 06:49:01] -rw------- 1 boinc boinc 208896713 May 16 06:48 log.38734053._002409.job.log.1
[2024-05-16 06:49:01] -rw-r--r-- 1 boinc boinc 571 May 16 06:48 runtime_log
[2024-05-16 06:49:01] -rw------- 1 boinc boinc 208906240 May 16 06:48 result.tar.gz
[2024-05-16 06:49:01] -rw-r--r-- 1 boinc boinc 10615 May 16 06:48 runtime_log.err
[2024-05-16 06:49:01] -rw------- 1 boinc boinc 661 May 16 06:48 9kaNDmvowO5n9Rq4apoT9bVoABFKDmABFKDmlqFKDm0TFKDmkH0R8n.diag
[2024-05-16 06:49:01] -rw-r--r-- 1 boinc boinc 8192 May 16 06:48 boinc_mmap_file
[2024-05-16 06:49:01] -rw-r--r-- 1 boinc boinc 30 May 16 06:49 wrapper_checkpoint.txt
[2024-05-16 06:49:01] -rw-r--r-- 1 boinc boinc 26705 May 16 06:49 stderr.txt
[2024-05-16 06:49:01] No HITS result produced
[2024-05-16 06:49:01] *** Contents of shared directory: ***
[2024-05-16 06:49:01] total 526116
[2024-05-16 06:49:01] -rw-r--r-- 2 boinc boinc 329319690 May 8 06:49 ATLAS.root_0
[2024-05-16 06:49:01] -rw-r--r-- 2 boinc boinc 17537 May 8 06:49 start_atlas.sh
[2024-05-16 06:49:01] -rw-r--r-- 2 boinc boinc 481735 May 8 06:49 input.tar.gz
[2024-05-16 06:49:01] -rw------- 1 boinc boinc 208906240 May 16 06:48 result.tar.gz
06:49:02 (107591): run_atlas exited; CPU time 13814.623608
06:49:02 (107591): called boinc_finish(0)
</stderr_txt>
<message>
upload failure: <file_xfer_error>
<file_name>9kaNDmvowO5n9Rq4apoT9bVoABFKDmABFKDmlqFKDm0TFKDmkH0R8n_0_r154489101_ATLAS_result</file_name>
<error_code>-131 (file size too big)</error_code>
</file_xfer_error>
</message>
]]>
©2024 CERN