| Name | e46KDmURye5n7Olcko1bjSoqABFKDmABFKDmOtvXDmQOrKDmyU631m_0 |
| Workunit | 223691931 |
| Created | 21 Jun 2024, 18:45:46 UTC |
| Sent | 22 Jun 2024, 0:36:12 UTC |
| Report deadline | 30 Jun 2024, 0:36:12 UTC |
| Received | 22 Jun 2024, 5:30:10 UTC |
| Server state | Over |
| Outcome | Computation error |
| Client state | Compute error |
| Exit status | 0 (0x00000000) |
| Computer ID | 10830559 |
| Run time | 4 hours 40 min 33 sec |
| CPU time | 13 hours 31 min 23 sec |
| Validate state | Invalid |
| Credit | 0.00 |
| Device peak FLOPS | 50.70 GFLOPS |
| Application version | ATLAS Simulation v3.01 (native_mt) x86_64-pc-linux-gnu |
| Peak working set size | 2.53 GB |
| Peak swap size | 31.77 GB |
| Peak disk usage | 1.40 GB |
Stderr output
<core_client_version>7.7.0</core_client_version>
<![CDATA[
<stderr_txt>
20:40:36 (4275): wrapper (7.7.26015): starting
20:40:36 (4275): wrapper: running run_atlas (--nthreads 8)
[2024-06-21 20:40:36] Arguments: --nthreads 8
[2024-06-21 20:40:36] Threads: 8
[2024-06-21 20:40:36] Checking for CVMFS
[2024-06-21 20:40:37] Probing /cvmfs/atlas.cern.ch... OK
[2024-06-21 20:40:37] Probing /cvmfs/atlas-condb.cern.ch... OK
[2024-06-21 20:40:37] Running cvmfs_config stat atlas.cern.ch
[2024-06-21 20:40:38] 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-06-21 20:40:38] 2.11.2.0 87978 1782 98140 134148 3 291 14337943 18432000 21283 130560 0 9348095 99.007 16702423 61983 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1
[2024-06-21 20:40:38] CVMFS is ok
[2024-06-21 20:40:38] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2024-06-21 20:40:38] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2024-06-21 20:40:38] Further information can be found at the LHC@home message board.
[2024-06-21 20:40:38] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2024-06-21 20:40:38] Checking for apptainer binary...
[2024-06-21 20:40:38] Using apptainer found in PATH at /usr/bin/apptainer
[2024-06-21 20:40:38] Running /usr/bin/apptainer --version
[2024-06-21 20:40:38] apptainer version 1.3.1-1.el7
[2024-06-21 20:40:38] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2024-06-21 20:40:45] c-212-20.aglt2.org
[2024-06-21 20:40:45] apptainer works
[2024-06-21 20:40:45] Set ATHENA_PROC_NUMBER=8
[2024-06-21 20:40:45] Set ATHENA_CORE_NUMBER=8
[2024-06-21 20:40:45] Starting ATLAS job with PandaID=6240064258
[2024-06-21 20:40:45] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/4 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2024-06-22 01:21:07] *** The last 200 lines of the pilot log: ***
[2024-06-22 01:21:07] 2024-06-22 05:18:24,396 | WARNING | Exception caught: [Errno 107] Transport endpoint is not connected: '/bin/bash'
[2024-06-22 01:21:07] 2024-06-22 05:18:24,397 | WARNING | Traceback (most recent call last):
[2024-06-22 01:21:07] File "/tmp/boinchome/slots/4/pilot3/pilot/util/monitoring.py", line 109, in job_monitor_tasks
[2024-06-22 01:21:07] cpuconsumptiontime = get_current_cpu_consumption_time(job.pid)
[2024-06-22 01:21:07] File "/tmp/boinchome/slots/4/pilot3/pilot/util/processes.py", line 571, in get_current_cpu_consumption_time
[2024-06-22 01:21:07] _, ps_cache, _ = execute("ps -eo pid,ppid -m", mute=True, timeout=60)
[2024-06-22 01:21:07] File "/tmp/boinchome/slots/4/pilot3/pilot/util/container.py", line 94, in execute
[2024-06-22 01:21:07] process = subprocess.Popen(exe,
[2024-06-22 01:21:07] File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/python/3.9.18-x86_64-centos7/lib/python3.9/subprocess.py", line 951, in __init__
[2024-06-22 01:21:07] self._execute_child(args, executable, preexec_fn, close_fds,
[2024-06-22 01:21:07] File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/python/3.9.18-x86_64-centos7/lib/python3.9/subprocess.py", line 1837, in _execute_child
[2024-06-22 01:21:07] raise child_exception_type(errno_num, err_msg, err_filename)
[2024-06-22 01:21:07] OSError: [Errno 107] Transport endpoint is not connected: '/bin/bash'
[2024-06-22 01:21:07]
[2024-06-22 01:21:07] 2024-06-22 05:18:24,397 | WARNING | will send preliminary diagnostics (and pretend job is still running)=Exception caught: [Errno 107] Transport endpoint is not connected: '/bin/bash'
[2024-06-22 01:21:07] 2024-06-22 05:18:24,397 | INFO | pilot will not update the server (heartbeat message will be written to file)
[2024-06-22 01:21:07] 2024-06-22 05:18:24,397 | INFO | job 6240064258 has state 'running' - writing heartbeat
[2024-06-22 01:21:07] 2024-06-22 05:18:24,397 | INFO | payload/TRF did not report the number of read events
[2024-06-22 01:21:07] 2024-06-22 05:18:24,403 | WARNING | command=lscpu does not exist - cannot check number of available cores
[2024-06-22 01:21:07] 2024-06-22 05:18:24,403 | INFO | executing command: grep -o 'avx2[^ ]*\|AVX2[^ ]*' /proc/cpuinfo
[2024-06-22 01:21:07] 2024-06-22 05:18:24,412 | WARNING | exception caught: [Errno 107] Transport endpoint is not connected: '/bin/bash'
[2024-06-22 01:21:07] 2024-06-22 05:18:26,919 | INFO | monitor loop #1168: job 0:6240064258 is in state 'failed'
[2024-06-22 01:21:07] 2024-06-22 05:18:26,919 | INFO | will abort job monitoring soon since job state=failed (job is still in queue)
[2024-06-22 01:21:07] 2024-06-22 05:18:29,422 | INFO | monitor loop #1169: job 0:6240064258 is in state 'failed'
[2024-06-22 01:21:07] 2024-06-22 05:18:29,422 | INFO | will abort job monitoring soon since job state=failed (job is still in queue)
[2024-06-22 01:21:07] 2024-06-22 05:18:31,925 | INFO | monitor loop #1170: job 0:6240064258 is in state 'failed'
[2024-06-22 01:21:07] 2024-06-22 05:18:31,925 | INFO | will abort job monitoring soon since job state=failed (job is still in queue)
[2024-06-22 01:21:07] 2024-06-22 05:18:32,961 | WARNING | job:job_monitor:received graceful stop - abort after this iteration
[2024-06-22 01:21:07] 2024-06-22 05:18:32,961 | INFO | aborting loop
[2024-06-22 01:21:07] 2024-06-22 05:18:33,115 | INFO | all payload control threads have been joined
[2024-06-22 01:21:07] 2024-06-22 05:18:33,574 | INFO | found 1 job(s) in 20 queues
[2024-06-22 01:21:07] 2024-06-22 05:18:33,574 | INFO | aborting job 6240064258
[2024-06-22 01:21:07] 2024-06-22 05:18:33,679 | WARNING | pilot monitor received instruction that args.graceful_stop has been set
[2024-06-22 01:21:07] 2024-06-22 05:18:33,679 | WARNING | will wait for a maximum of 300 s for threads to finish
[2024-06-22 01:21:07] 2024-06-22 05:18:33,701 | WARNING | job:queue_monitor:received graceful stop - abort after this iteration
[2024-06-22 01:21:07] 2024-06-22 05:18:33,701 | WARNING | since job:queue_monitor is responsible for sending job updates, we sleep for 20 s
[2024-06-22 01:21:07] 2024-06-22 05:18:33,807 | INFO | all data control threads have been joined
[2024-06-22 01:21:07] 2024-06-22 05:18:33,852 | INFO | all job control threads have been joined
[2024-06-22 01:21:07] 2024-06-22 05:18:33,954 | WARNING | data:queue_monitoring:received graceful stop - abort after this iteration
[2024-06-22 01:21:07] 2024-06-22 05:18:33,966 | INFO | [job] job monitor thread has finished
[2024-06-22 01:21:07] 2024-06-22 05:18:33,966 | INFO | [job] create_data_payload thread has finished
[2024-06-22 01:21:07] 2024-06-22 05:18:34,120 | INFO | [payload] control thread has finished
[2024-06-22 01:21:07] 2024-06-22 05:18:34,464 | INFO | [payload] validate_pre thread has finished
[2024-06-22 01:21:07] 2024-06-22 05:18:34,495 | INFO | [job] retrieve thread has finished
[2024-06-22 01:21:07] 2024-06-22 05:18:34,705 | INFO | [payload] run_realtimelog thread has finished
[2024-06-22 01:21:07] 2024-06-22 05:18:34,731 | INFO | [data] copytool_in thread has finished
[2024-06-22 01:21:07] 2024-06-22 05:18:34,789 | INFO | [payload] validate_post thread has finished
[2024-06-22 01:21:07] 2024-06-22 05:18:34,812 | INFO | [data] control thread has finished
[2024-06-22 01:21:07] 2024-06-22 05:18:34,857 | INFO | [job] control thread has finished
[2024-06-22 01:21:07] 2024-06-22 05:18:34,992 | INFO | [job] validate thread has finished
[2024-06-22 01:21:07] 2024-06-22 05:18:35,140 | INFO | [payload] failed_post thread has finished
[2024-06-22 01:21:07] 2024-06-22 05:18:37,960 | INFO | [data] queue_monitor thread has finished
[2024-06-22 01:21:07] 2024-06-22 05:18:38,724 | INFO | [payload] execute_payloads thread has finished
[2024-06-22 01:21:07] 2024-06-22 05:18:54,795 | INFO | job 6240064258 has state=failed
[2024-06-22 01:21:07] 2024-06-22 05:18:54,796 | INFO | preparing for final server update for job 6240064258 in state='failed'
[2024-06-22 01:21:07] 2024-06-22 05:18:55,793 | WARNING | job_aborted has been set - aborting pilot monitoring
[2024-06-22 01:21:07] 2024-06-22 05:18:55,793 | INFO | [monitor] control thread has ended
[2024-06-22 01:21:07] 2024-06-22 05:18:55,964 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:18:57,978 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:18:59,989 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:19:01,999 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:19:04,010 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:19:06,020 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:19:08,030 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:19:10,041 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:19:12,053 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:19:14,064 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:19:16,075 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:19:18,085 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:19:20,096 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:19:22,108 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:19:24,118 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:19:26,129 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:19:28,138 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:19:30,148 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:19:32,159 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:19:34,170 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:19:36,181 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:19:38,192 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:19:40,203 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:19:42,215 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:19:44,225 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:19:46,238 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:19:48,250 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:19:50,263 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:19:52,274 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:19:54,285 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:19:56,308 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:19:58,320 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:00,331 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:02,343 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:04,354 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:06,368 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:08,380 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:10,394 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:12,404 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:14,418 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:16,429 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:18,440 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:20,453 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:22,463 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:24,473 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:26,484 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:28,498 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:30,509 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:32,520 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:34,533 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:36,543 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:38,553 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:40,563 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:42,574 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:44,584 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:46,598 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:48,610 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:49,883 | INFO | proceeding with final server update
[2024-06-22 01:21:07] 2024-06-22 05:20:49,884 | INFO | this job has now completed (state=failed)
[2024-06-22 01:21:07] 2024-06-22 05:20:49,884 | INFO | pilot will not update the server (heartbeat message will be written to file)
[2024-06-22 01:21:07] 2024-06-22 05:20:49,884 | INFO | job 6240064258 has failed - writing final server update
[2024-06-22 01:21:07] 2024-06-22 05:20:49,884 | WARNING | making sure that job.state is set to failed since a pilot error code is set
[2024-06-22 01:21:07] 2024-06-22 05:20:49,885 | INFO | payload/TRF did not report the number of read events
[2024-06-22 01:21:07] 2024-06-22 05:20:49,889 | WARNING | command=lscpu does not exist - cannot check number of available cores
[2024-06-22 01:21:07] 2024-06-22 05:20:49,889 | INFO | executing command: grep -o 'avx2[^ ]*\|AVX2[^ ]*' /proc/cpuinfo
[2024-06-22 01:21:07] File "/tmp/boinchome/slots/4/pilot3/pilot/common/exception.py", line 466, in run
[2024-06-22 01:21:07] self._target(**self.kwargs)
[2024-06-22 01:21:07] File "/tmp/boinchome/slots/4/pilot3/pilot/control/job.py", line 2566, in queue_monitor
[2024-06-22 01:21:07] update_server(job, args)
[2024-06-22 01:21:07] File "/tmp/boinchome/slots/4/pilot3/pilot/control/job.py", line 2615, in update_server
[2024-06-22 01:21:07] send_state(job, args, job.state, metadata=metadata)
[2024-06-22 01:21:07] File "/tmp/boinchome/slots/4/pilot3/pilot/control/job.py", line 418, in send_state
[2024-06-22 01:21:07] data = get_data_structure(job, state, args, xml=xml, metadata=metadata)
[2024-06-22 01:21:07] File "/tmp/boinchome/slots/4/pilot3/pilot/control/job.py", line 749, in get_data_structure
[2024-06-22 01:21:07] instruction_sets = has_instruction_sets(['AVX2'])
[2024-06-22 01:21:07] File "/tmp/boinchome/slots/4/pilot3/pilot/util/auxiliary.py", line 520, in has_instruction_sets
[2024-06-22 01:21:07] exit_code, stdout, stderr = execute(cmd)
[2024-06-22 01:21:07] File "/tmp/boinchome/slots/4/pilot3/pilot/util/container.py", line 94, in execute
[2024-06-22 01:21:07] process = subprocess.Popen(exe,
[2024-06-22 01:21:07] File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/python/3.9.18-x86_64-centos7/lib/python3.9/subprocess.py", line 951, in __init__
[2024-06-22 01:21:07] self._execute_child(args, executable, preexec_fn, close_fds,
[2024-06-22 01:21:07] File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/python/3.9.18-x86_64-centos7/lib/python3.9/subprocess.py", line 1837, in _execute_child
[2024-06-22 01:21:07] raise child_exception_type(errno_num, err_msg, err_filename)
[2024-06-22 01:21:07] unexpected exception caught by thread run() function: (<class 'OSError'>, OSError(107, 'Transport endpoint is not connected'), <traceback object at 0x7f3401342080>)
[2024-06-22 01:21:07] Traceback (most recent call last):
[2024-06-22 01:21:07] File "/tmp/boinchome/slots/4/pilot3/pilot/common/exception.py", line 466, in run
[2024-06-22 01:21:07] self._target(**self.kwargs)
[2024-06-22 01:21:07] File "/tmp/boinchome/slots/4/pilot3/pilot/control/job.py", line 2566, in queue_monitor
[2024-06-22 01:21:07] update_server(job, args)
[2024-06-22 01:21:07] File "/tmp/boinchome/slots/4/pilot3/pilot/control/job.py", line 2615, in update_server
[2024-06-22 01:21:07] send_state(job, args, job.state, metadata=metadata)
[2024-06-22 01:21:07] File "/tmp/boinchome/slots/4/pilot3/pilot/control/job.py", line 418, in send_state
[2024-06-22 01:21:07] data = get_data_structure(job, state, args, xml=xml, metadata=metadata)
[2024-06-22 01:21:07] File "/tmp/boinchome/slots/4/pilot3/pilot/control/job.py", line 749, in get_data_structure
[2024-06-22 01:21:07] instruction_sets = has_instruction_sets(['AVX2'])
[2024-06-22 01:21:07] File "/tmp/boinchome/slots/4/pilot3/pilot/util/auxiliary.py", line 520, in has_instruction_sets
[2024-06-22 01:21:07] exit_code, stdout, stderr = execute(cmd)
[2024-06-22 01:21:07] File "/tmp/boinchome/slots/4/pilot3/pilot/util/container.py", line 94, in execute
[2024-06-22 01:21:07] process = subprocess.Popen(exe,
[2024-06-22 01:21:07] File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/python/3.9.18-x86_64-centos7/lib/python3.9/subprocess.py", line 951, in __init__
[2024-06-22 01:21:07] self._execute_child(args, executable, preexec_fn, close_fds,
[2024-06-22 01:21:07] File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/python/3.9.18-x86_64-centos7/lib/python3.9/subprocess.py", line 1837, in _execute_child
[2024-06-22 01:21:07] raise child_exception_type(errno_num, err_msg, err_filename)
[2024-06-22 01:21:07] OSError: [Errno 107] Transport endpoint is not connected: '/bin/bash'
[2024-06-22 01:21:07]
[2024-06-22 01:21:07] None
[2024-06-22 01:21:07] exception has been put in bucket queue belonging to thread 'queue_monitor'
[2024-06-22 01:21:07] setting graceful stop in 10 s since there is no point in continuing
[2024-06-22 01:21:07] 2024-06-22 05:20:50,624 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:52,638 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:54,649 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:56,659 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:20:58,669 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 139861498611520)>', '<ExcThread(queue_monitor, started 139860660688640)>']
[2024-06-22 01:21:07] 2024-06-22 05:21:00,680 | INFO | caller=run is remaining thread - safe to abort (names=['<_MainThread(MainThread, started 139861498611520)>'])
[2024-06-22 01:21:07] 2024-06-22 05:21:05,708 | INFO | all workflow threads have been joined
[2024-06-22 01:21:07] 2024-06-22 05:21:05,708 | INFO | end of generic workflow (traces error code: 0)
[2024-06-22 01:21:07] 2024-06-22 05:21:05,708 | INFO | traces error code: 0
[2024-06-22 01:21:07] 2024-06-22 05:21:05,708 | INFO | pilot has finished (exit code=0, shell exit code=0)
[2024-06-22 01:21:07] ./runpilot2-wrapper.sh: line 15: date: command not found
[2024-06-22 01:21:07] ==== pilot stdout END ====
[2024-06-22 01:21:07] ./runpilot2-wrapper.sh: line 15: date: command not found
[2024-06-22 01:21:07] ==== wrapper stdout RESUME ====
[2024-06-22 01:21:07] ./runpilot2-wrapper.sh: line 15: date: command not found
[2024-06-22 01:21:07] pilotpid: 21643
[2024-06-22 01:21:07] ./runpilot2-wrapper.sh: line 15: date: command not found
[2024-06-22 01:21:07] Pilot exit status: 139
[2024-06-22 01:21:07] ./runpilot2-wrapper.sh: line 949: /usr/bin/cut: Transport endpoint is not connected
[2024-06-22 01:21:07] ./runpilot2-wrapper.sh: line 949: xargs: command not found
[2024-06-22 01:21:07] ./runpilot2-wrapper.sh: line 949: /usr/bin/cat: Transport endpoint is not connected
[2024-06-22 01:21:07] ./runpilot2-wrapper.sh: line 15: date: command not found
[2024-06-22 01:21:07] pandaids:
[2024-06-22 01:21:07] ./runpilot2-wrapper.sh: line 501: /usr/bin/ps: Transport endpoint is not connected
[2024-06-22 01:21:07] ./runpilot2-wrapper.sh: line 15: date: command not found
[2024-06-22 01:21:07] No supervise_pilot CHILD process found
[2024-06-22 01:21:07] ./runpilot2-wrapper.sh: line 15: date: command not found
[2024-06-22 01:21:07] Test setup, not cleaning
[2024-06-22 01:21:07] ./runpilot2-wrapper.sh: line 15: date: command not found
[2024-06-22 01:21:07] ==== wrapper stdout END ====
[2024-06-22 01:21:07] ./runpilot2-wrapper.sh: line 10: date: command not found
[2024-06-22 01:21:07] ==== wrapper stderr END ====
[2024-06-22 01:21:07] ./runpilot2-wrapper.sh: line 522: date: command not found
[2024-06-22 01:21:07] ./runpilot2-wrapper.sh: line 15: date: command not found
[2024-06-22 01:21:07] apfmon messages muted
[2024-06-22 01:21:07] *** Error codes and diagnostics ***
[2024-06-22 01:21:07] *** Listing of results directory ***
[2024-06-22 01:21:07] total 604436
[2024-06-22 01:21:07] -rw-r--r-- 1 boincer umatlas 469766 Jun 21 14:44 pilot3.tar.gz
[2024-06-22 01:21:07] -rwx------ 1 boincer umatlas 32308 Jun 21 14:45 runpilot2-wrapper.sh
[2024-06-22 01:21:07] -rw-r--r-- 1 boincer umatlas 5654 Jun 21 14:45 queuedata.json
[2024-06-22 01:21:07] -rw-r--r-- 1 boincer umatlas 100 Jun 21 20:40 wrapper_26015_x86_64-pc-linux-gnu
[2024-06-22 01:21:07] -rwxr-xr-x 1 boincer umatlas 7986 Jun 21 20:40 run_atlas
[2024-06-22 01:21:07] -rw-r--r-- 1 boincer umatlas 105 Jun 21 20:40 job.xml
[2024-06-22 01:21:07] -rw-r--r-- 2 boincer umatlas 17537 Jun 21 20:40 start_atlas.sh
[2024-06-22 01:21:07] drwxrwx--x 2 boincer umatlas 4096 Jun 21 20:40 shared
[2024-06-22 01:21:07] -rw-r--r-- 2 boincer umatlas 482482 Jun 21 20:40 input.tar.gz
[2024-06-22 01:21:07] -rw-r--r-- 2 boincer umatlas 612385112 Jun 21 20:40 EVNT.40024047._000050.pool.root.1
[2024-06-22 01:21:07] -rw-r--r-- 1 boincer umatlas 0 Jun 21 20:40 boinc_lockfile
[2024-06-22 01:21:07] -rw-r--r-- 1 boincer umatlas 2497 Jun 21 20:40 pandaJob.out
[2024-06-22 01:21:07] -rw------- 1 boincer umatlas 424 Jun 21 20:40 setup.sh.local
[2024-06-22 01:21:07] -rw------- 1 boincer umatlas 1025937 Jun 21 20:42 agis_schedconf.cvmfs.json
[2024-06-22 01:21:07] -rw------- 1 boincer umatlas 0 Jun 21 20:42 agis_ddmendpoints.agis.ALL.json
[2024-06-22 01:21:07] -rw------- 1 boincer umatlas 1321363 Jun 21 20:42 cric_ddmendpoints.json
[2024-06-22 01:21:07] drwx------ 4 boincer umatlas 4096 Jun 21 20:42 pilot3
[2024-06-22 01:21:07] -rw------- 1 boincer umatlas 900 Jun 22 00:50 heartbeat.json
[2024-06-22 01:21:07] -rw-r--r-- 1 boincer umatlas 532 Jun 22 01:18 boinc_task_state.xml
[2024-06-22 01:21:07] -rw------- 1 boincer umatlas 1094 Jun 22 01:18 memory_monitor_summary.json
[2024-06-22 01:21:07] drwxrwx--- 2 boincer umatlas 4096 Jun 22 01:18 PanDA_Pilot-6240064258
[2024-06-22 01:21:07] -rw------- 1 boincer umatlas 95 Jun 22 01:18 pilot_heartbeat.json
[2024-06-22 01:21:07] -rw-r--r-- 1 boincer umatlas 6302 Jun 22 01:20 init_data.xml
[2024-06-22 01:21:07] -rw------- 1 boincer umatlas 1511628 Jun 22 01:21 pilotlog.txt
[2024-06-22 01:21:07] -rw------- 1 boincer umatlas 1535713 Jun 22 01:21 log.40024049._001323.job.log.1
[2024-06-22 01:21:07] -rw-r--r-- 1 boincer umatlas 428 Jun 22 01:21 runtime_log
[2024-06-22 01:21:07] -rw------- 1 boincer umatlas 633 Jun 22 01:21 e46KDmURye5n7Olcko1bjSoqABFKDmABFKDmOtvXDmQOrKDmyU631m.diag
[2024-06-22 01:21:07] -rw-r--r-- 1 boincer umatlas 28 Jun 22 01:21 wrapper_checkpoint.txt
[2024-06-22 01:21:07] -rw-r--r-- 1 boincer umatlas 8192 Jun 22 01:21 boinc_mmap_file
[2024-06-22 01:21:07] -rw-r--r-- 1 boincer umatlas 11208 Jun 22 01:21 runtime_log.err
[2024-06-22 01:21:07] -rw-r--r-- 1 boincer umatlas 28262 Jun 22 01:21 stderr.txt
[2024-06-22 01:21:07] No HITS result produced
[2024-06-22 01:21:07] *** Contents of shared directory: ***
[2024-06-22 01:21:07] total 598532
[2024-06-22 01:21:07] -rw-r--r-- 2 boincer umatlas 17537 Jun 21 20:40 start_atlas.sh
[2024-06-22 01:21:07] -rw-r--r-- 2 boincer umatlas 482482 Jun 21 20:40 input.tar.gz
[2024-06-22 01:21:07] -rw-r--r-- 2 boincer umatlas 612385112 Jun 21 20:40 ATLAS.root_0
01:21:08 (4275): run_atlas exited; CPU time 47318.055877
01:21:08 (4275): called boinc_finish(0)
</stderr_txt>
<message>
upload failure: <file_xfer_error>
<file_name>e46KDmURye5n7Olcko1bjSoqABFKDmABFKDmOtvXDmQOrKDmyU631m_0_r600245808_ATLAS_result</file_name>
<error_code>-161 (not found)</error_code>
</file_xfer_error>
</message>
]]>
©2024 CERN