Name i9YMDmxA2e5nsSi4ap6QjLDmwznN0nGgGQJmpmIZDmGCnKDm5snaom_0
Workunit 223694814
Created 21 Jun 2024, 22:44:59 UTC
Sent 22 Jun 2024, 5:05:08 UTC
Report deadline 30 Jun 2024, 5:05:08 UTC
Received 22 Jun 2024, 5:20:24 UTC
Server state Over
Outcome Computation error
Client state Compute error
Exit status 0 (0x00000000)
Computer ID 10830559
Run time 7 min 10 sec
CPU time 14 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 66.37 MB
Peak swap size 31.65 GB
Peak disk usage 1.12 GB

Stderr output

<core_client_version>7.7.0</core_client_version>
<![CDATA[
<stderr_txt>
01:09:03 (55858): wrapper (7.7.26015): starting
01:09:03 (55858): wrapper: running run_atlas (--nthreads 8)
[2024-06-22 01:09:03] Arguments: --nthreads 8
[2024-06-22 01:09:03] Threads: 8
[2024-06-22 01:09:03] Checking for CVMFS
[2024-06-22 01:09:04] Probing /cvmfs/atlas.cern.ch... OK
[2024-06-22 01:09:04] Probing /cvmfs/atlas-condb.cern.ch... OK
[2024-06-22 01:09:04] Running cvmfs_config stat atlas.cern.ch
[2024-06-22 01:09:05] 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-22 01:09:05] 2.11.2.0 87978 2051 85692 134154 2 125 14033349 18432000 20091 130560 0 10784892 98.922 22766701 53241 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1
[2024-06-22 01:09:05] CVMFS is ok
[2024-06-22 01:09:05] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2024-06-22 01:09:05] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2024-06-22 01:09:05] Further information can be found at the LHC@home message board.
[2024-06-22 01:09:05] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2024-06-22 01:09:05] Checking for apptainer binary...
[2024-06-22 01:09:05] Using apptainer found in PATH at /usr/bin/apptainer
[2024-06-22 01:09:05] Running /usr/bin/apptainer --version
[2024-06-22 01:09:05] apptainer version 1.3.1-1.el7
[2024-06-22 01:09:05] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2024-06-22 01:09:18] c-212-20.aglt2.org
[2024-06-22 01:09:18] apptainer works
[2024-06-22 01:09:18] Set ATHENA_PROC_NUMBER=8
[2024-06-22 01:09:18] Set ATHENA_CORE_NUMBER=8
[2024-06-22 01:09:18] Starting ATLAS job with PandaID=6240458604
[2024-06-22 01:09:18] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/5 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2024-06-22 01:16:10]  *** The last 200 lines of the pilot log: ***
[2024-06-22 01:16:10]     if _stage_out_new(job, args):
[2024-06-22 01:16:10]   File "/tmp/boinchome/slots/5/pilot3/pilot/control/data.py", line 994, in _stage_out_new
[2024-06-22 01:16:10]     create_log(job.workdir, logfile.lfn, tarball_name, args.cleanup,
[2024-06-22 01:16:10]   File "/tmp/boinchome/slots/5/pilot3/pilot/control/data.py", line 757, in create_log
[2024-06-22 01:16:10]     user.remove_redundant_files(workdir, piloterrors=piloterrors, debugmode=debugmode)
[2024-06-22 01:16:10]   File "/tmp/boinchome/slots/5/pilot3/pilot/user/atlas/common.py", line 2098, in remove_redundant_files
[2024-06-22 01:16:10]     list_work_dir(workdir)
[2024-06-22 01:16:10]   File "/tmp/boinchome/slots/5/pilot3/pilot/user/atlas/common.py", line 2044, in list_work_dir
[2024-06-22 01:16:10]     _, stdout, stderr = execute(cmd)
[2024-06-22 01:16:10]   File "/tmp/boinchome/slots/5/pilot3/pilot/util/container.py", line 94, in execute
[2024-06-22 01:16:10]     process = subprocess.Popen(exe,
[2024-06-22 01:16:10]   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:16:10]   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:16:10] OSError: [Errno 107] Transport endpoint is not connected: '/bin/bash'
[2024-06-22 01:16:10] 
[2024-06-22 01:16:10] None
[2024-06-22 01:16:10] exception has been put in bucket queue belonging to thread 'copytool_out'
[2024-06-22 01:16:10] setting graceful stop in 10 s since there is no point in continuing
[2024-06-22 01:16:10] 2024-06-22 05:13:26,387 | WARNING  | thread 'copytool_out' received an exception from bucket: [Errno 107] Transport endpoint is not connected: '/bin/bash'
[2024-06-22 01:16:10] 2024-06-22 05:13:28,468 | INFO     | monitor loop #42: job 0:6240458604 is in state 'stageout'
[2024-06-22 01:16:10] 2024-06-22 05:13:30,973 | INFO     | monitor loop #43: job 0:6240458604 is in state 'stageout'
[2024-06-22 01:16:10] 2024-06-22 05:13:33,481 | INFO     | monitor loop #44: job 0:6240458604 is in state 'stageout'
[2024-06-22 01:16:10] 2024-06-22 05:13:35,986 | INFO     | monitor loop #45: job 0:6240458604 is in state 'stageout'
[2024-06-22 01:16:10] 2024-06-22 05:13:36,048 | WARNING  | job:queue_monitor:received graceful stop - abort after this iteration
[2024-06-22 01:16:10] 2024-06-22 05:13:36,048 | WARNING  | since job:queue_monitor is responsible for sending job updates, we sleep for 20 s
[2024-06-22 01:16:10] 2024-06-22 05:13:36,049 | WARNING  | job:job_monitor:received graceful stop - abort after this iteration
[2024-06-22 01:16:10] 2024-06-22 05:13:36,049 | INFO     | will abort loop
[2024-06-22 01:16:10] 2024-06-22 05:13:36,211 | INFO     | all data control threads have been joined
[2024-06-22 01:16:10] 2024-06-22 05:13:36,672 | INFO     | all payload control threads have been joined
[2024-06-22 01:16:10] 2024-06-22 05:13:36,770 | INFO     | found 1 job(s) in 20 queues
[2024-06-22 01:16:10] 2024-06-22 05:13:36,770 | INFO     | aborting job 6240458604
[2024-06-22 01:16:10] 2024-06-22 05:13:36,935 | WARNING  | pilot monitor received instruction that args.graceful_stop has been set
[2024-06-22 01:16:10] 2024-06-22 05:13:36,935 | WARNING  | will wait for a maximum of 300 s for threads to finish
[2024-06-22 01:16:10] 2024-06-22 05:13:37,054 | INFO     | [job] job monitor thread has finished
[2024-06-22 01:16:10] 2024-06-22 05:13:37,062 | INFO     | [payload] execute_payloads thread has finished
[2024-06-22 01:16:10] 2024-06-22 05:13:37,094 | INFO     | [job] retrieve thread has finished
[2024-06-22 01:16:10] 2024-06-22 05:13:37,218 | INFO     | [data] control thread has finished
[2024-06-22 01:16:10] 2024-06-22 05:13:37,448 | INFO     | all job control threads have been joined
[2024-06-22 01:16:10] 2024-06-22 05:13:37,678 | INFO     | [payload] control thread has finished
[2024-06-22 01:16:10] 2024-06-22 05:13:37,718 | INFO     | [payload] run_realtimelog thread has finished
[2024-06-22 01:16:10] 2024-06-22 05:13:37,748 | INFO     | [job] validate thread has finished
[2024-06-22 01:16:10] 2024-06-22 05:13:37,907 | INFO     | [payload] failed_post thread has finished
[2024-06-22 01:16:10] 2024-06-22 05:13:38,024 | INFO     | [data] copytool_in thread has finished
[2024-06-22 01:16:10] 2024-06-22 05:13:38,174 | INFO     | [job] create_data_payload thread has finished
[2024-06-22 01:16:10] 2024-06-22 05:13:38,249 | INFO     | [payload] validate_post thread has finished
[2024-06-22 01:16:10] 2024-06-22 05:13:38,362 | INFO     | [payload] validate_pre thread has finished
[2024-06-22 01:16:10] 2024-06-22 05:13:38,454 | INFO     | [job] control thread has finished
[2024-06-22 01:16:10] 2024-06-22 05:13:39,374 | WARNING  | data:queue_monitoring:received graceful stop - abort after this iteration
[2024-06-22 01:16:10] 2024-06-22 05:13:43,388 | INFO     | [data] queue_monitor thread has finished
[2024-06-22 01:16:10] 2024-06-22 05:13:57,150 | INFO     | job 6240458604 has state=failed
[2024-06-22 01:16:10] 2024-06-22 05:13:57,150 | INFO     | preparing for final server update for job 6240458604 in state='failed'
[2024-06-22 01:16:10] 2024-06-22 05:13:58,068 | WARNING  | job_aborted has been set - aborting pilot monitoring
[2024-06-22 01:16:10] 2024-06-22 05:13:58,068 | INFO     | [monitor] control thread has ended
[2024-06-22 01:16:10] 2024-06-22 05:13:58,938 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:00,988 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:03,000 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:05,014 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:07,028 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:09,040 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:11,053 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:13,064 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:15,078 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:17,098 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:19,109 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:21,120 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:23,134 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:25,148 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:27,160 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:29,194 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:31,208 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:33,224 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:35,234 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:37,248 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:39,260 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:41,287 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:43,298 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:45,309 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:47,320 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:49,333 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:51,344 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:53,356 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:55,368 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:57,380 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:14:59,408 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:01,422 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:03,434 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:05,444 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:07,455 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:09,468 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:11,480 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:13,494 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:15,508 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:17,520 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:19,534 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:21,548 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:23,568 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:25,580 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:27,591 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:29,604 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:31,618 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:33,629 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:35,640 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:37,652 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:39,664 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:41,675 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:43,688 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:45,700 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:47,714 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:49,728 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:51,739 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:52,438 | INFO     | proceeding with final server update
[2024-06-22 01:16:10] 2024-06-22 05:15:52,438 | WARNING  | path does not exist: /tmp/boinchome/slots/5/PanDA_Pilot-6240458604/memory_monitor_output.txt
[2024-06-22 01:16:10] 2024-06-22 05:15:52,438 | INFO     | this job has now completed (state=failed)
[2024-06-22 01:16:10] 2024-06-22 05:15:52,438 | INFO     | pilot will not update the server (heartbeat message will be written to file)
[2024-06-22 01:16:10] 2024-06-22 05:15:52,438 | INFO     | job 6240458604 has failed - writing final server update
[2024-06-22 01:16:10] 2024-06-22 05:15:52,438 | WARNING  | making sure that job.state is set to failed since a pilot error code is set
[2024-06-22 01:16:10] 2024-06-22 05:15:52,439 | INFO     | payload/TRF did not report the number of read events
[2024-06-22 01:16:10] 2024-06-22 05:15:52,445 | INFO     | executing command: lscpu
[2024-06-22 01:16:10]   File "/tmp/boinchome/slots/5/pilot3/pilot/common/exception.py", line 466, in run
[2024-06-22 01:16:10]     self._target(**self.kwargs)
[2024-06-22 01:16:10]   File "/tmp/boinchome/slots/5/pilot3/pilot/control/job.py", line 2566, in queue_monitor
[2024-06-22 01:16:10]     update_server(job, args)
[2024-06-22 01:16:10]   File "/tmp/boinchome/slots/5/pilot3/pilot/control/job.py", line 2615, in update_server
[2024-06-22 01:16:10]     send_state(job, args, job.state, metadata=metadata)
[2024-06-22 01:16:10]   File "/tmp/boinchome/slots/5/pilot3/pilot/control/job.py", line 418, in send_state
[2024-06-22 01:16:10]     data = get_data_structure(job, state, args, xml=xml, metadata=metadata)
[2024-06-22 01:16:10]   File "/tmp/boinchome/slots/5/pilot3/pilot/control/job.py", line 745, in get_data_structure
[2024-06-22 01:16:10]     cpumodel = get_cpu_cores(cpumodel)  # add the CPU cores if not present
[2024-06-22 01:16:10]   File "/tmp/boinchome/slots/5/pilot3/pilot/util/workernode.py", line 353, in get_cpu_cores
[2024-06-22 01:16:10]     ec, stdout = lscpu()
[2024-06-22 01:16:10]   File "/tmp/boinchome/slots/5/pilot3/pilot/util/workernode.py", line 333, in lscpu
[2024-06-22 01:16:10]     ec, stdout, _ = execute(cmd)
[2024-06-22 01:16:10]   File "/tmp/boinchome/slots/5/pilot3/pilot/util/container.py", line 94, in execute
[2024-06-22 01:16:10]     process = subprocess.Popen(exe,
[2024-06-22 01:16:10]   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:16:10]     self._execute_child(args, executable, preexec_fn, close_fds,
[2024-06-22 01:16:10]   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:16:10]     raise child_exception_type(errno_num, err_msg, err_filename)
[2024-06-22 01:16:10] unexpected exception caught by thread run() function: (<class 'OSError'>, OSError(107, 'Transport endpoint is not connected'), <traceback object at 0x7f3a4c00c980>)
[2024-06-22 01:16:10] Traceback (most recent call last):
[2024-06-22 01:16:10]   File "/tmp/boinchome/slots/5/pilot3/pilot/common/exception.py", line 466, in run
[2024-06-22 01:16:10]     self._target(**self.kwargs)
[2024-06-22 01:16:10]   File "/tmp/boinchome/slots/5/pilot3/pilot/control/job.py", line 2566, in queue_monitor
[2024-06-22 01:16:10]     update_server(job, args)
[2024-06-22 01:16:10]   File "/tmp/boinchome/slots/5/pilot3/pilot/control/job.py", line 2615, in update_server
[2024-06-22 01:16:10]     send_state(job, args, job.state, metadata=metadata)
[2024-06-22 01:16:10]   File "/tmp/boinchome/slots/5/pilot3/pilot/control/job.py", line 418, in send_state
[2024-06-22 01:16:10]     data = get_data_structure(job, state, args, xml=xml, metadata=metadata)
[2024-06-22 01:16:10]   File "/tmp/boinchome/slots/5/pilot3/pilot/control/job.py", line 745, in get_data_structure
[2024-06-22 01:16:10]     cpumodel = get_cpu_cores(cpumodel)  # add the CPU cores if not present
[2024-06-22 01:16:10]   File "/tmp/boinchome/slots/5/pilot3/pilot/util/workernode.py", line 353, in get_cpu_cores
[2024-06-22 01:16:10]     ec, stdout = lscpu()
[2024-06-22 01:16:10]   File "/tmp/boinchome/slots/5/pilot3/pilot/util/workernode.py", line 333, in lscpu
[2024-06-22 01:16:10]     ec, stdout, _ = execute(cmd)
[2024-06-22 01:16:10]   File "/tmp/boinchome/slots/5/pilot3/pilot/util/container.py", line 94, in execute
[2024-06-22 01:16:10]     process = subprocess.Popen(exe,
[2024-06-22 01:16:10]   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:16:10]     self._execute_child(args, executable, preexec_fn, close_fds,
[2024-06-22 01:16:10]   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:16:10]     raise child_exception_type(errno_num, err_msg, err_filename)
[2024-06-22 01:16:10] OSError: [Errno 107] Transport endpoint is not connected: '/bin/bash'
[2024-06-22 01:16:10] 
[2024-06-22 01:16:10] None
[2024-06-22 01:16:10] exception has been put in bucket queue belonging to thread 'queue_monitor'
[2024-06-22 01:16:10] setting graceful stop in 10 s since there is no point in continuing
[2024-06-22 01:16:10] 2024-06-22 05:15:53,751 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:55,763 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:57,774 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:15:59,784 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:16:01,791 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 139888523376448)>', '<ExcThread(queue_monitor, started 139887906887424)>']
[2024-06-22 01:16:10] 2024-06-22 05:16:03,802 | INFO     | caller=run is remaining thread - safe to abort (names=['<_MainThread(MainThread, started 139888523376448)>'])
[2024-06-22 01:16:10] 2024-06-22 05:16:08,828 | INFO     | all workflow threads have been joined
[2024-06-22 01:16:10] 2024-06-22 05:16:08,828 | INFO     | end of generic workflow (traces error code: 0)
[2024-06-22 01:16:10] 2024-06-22 05:16:08,832 | INFO     | traces error code: 0
[2024-06-22 01:16:10] 2024-06-22 05:16:08,832 | INFO     | pilot has finished (exit code=0, shell exit code=0)
[2024-06-22 01:16:10] ./runpilot2-wrapper.sh: line 15: /usr/bin/date: Transport endpoint is not connected
[2024-06-22 01:16:10]  ==== pilot stdout END ====
[2024-06-22 01:16:10] ./runpilot2-wrapper.sh: line 15: /usr/bin/date: Transport endpoint is not connected
[2024-06-22 01:16:10]  ==== wrapper stdout RESUME ====
[2024-06-22 01:16:10] ./runpilot2-wrapper.sh: line 15: /usr/bin/date: Transport endpoint is not connected
[2024-06-22 01:16:10]  pilotpid: 69988
[2024-06-22 01:16:10] ./runpilot2-wrapper.sh: line 15: /usr/bin/date: Transport endpoint is not connected
[2024-06-22 01:16:10]  Pilot exit status: 0
[2024-06-22 01:16:10] ./runpilot2-wrapper.sh: line 949: /usr/bin/cat: Transport endpoint is not connected
[2024-06-22 01:16:10] ./runpilot2-wrapper.sh: line 949: xargs: command not found
[2024-06-22 01:16:10] ./runpilot2-wrapper.sh: line 949: /usr/bin/cut: Transport endpoint is not connected
[2024-06-22 01:16:10] ./runpilot2-wrapper.sh: line 15: /usr/bin/date: Transport endpoint is not connected
[2024-06-22 01:16:10]  pandaids: 
[2024-06-22 01:16:10] ./runpilot2-wrapper.sh: line 501: /usr/bin/ps: Transport endpoint is not connected
[2024-06-22 01:16:10] ./runpilot2-wrapper.sh: line 15: /usr/bin/date: Transport endpoint is not connected
[2024-06-22 01:16:10]  No supervise_pilot CHILD process found
[2024-06-22 01:16:10] ./runpilot2-wrapper.sh: line 15: /usr/bin/date: Transport endpoint is not connected
[2024-06-22 01:16:10]  Test setup, not cleaning
[2024-06-22 01:16:10] ./runpilot2-wrapper.sh: line 15: /usr/bin/date: Transport endpoint is not connected
[2024-06-22 01:16:10]  ==== wrapper stdout END ====
[2024-06-22 01:16:10] ./runpilot2-wrapper.sh: line 10: /usr/bin/date: Transport endpoint is not connected
[2024-06-22 01:16:10]  ==== wrapper stderr END ====
[2024-06-22 01:16:10] ./runpilot2-wrapper.sh: line 522: /usr/bin/date: Transport endpoint is not connected
[2024-06-22 01:16:10] ./runpilot2-wrapper.sh: line 15: /usr/bin/date: Transport endpoint is not connected
[2024-06-22 01:16:10]  apfmon messages muted
[2024-06-22 01:16:10]  *** Error codes and diagnostics ***
[2024-06-22 01:16:10]  *** Listing of results directory ***
[2024-06-22 01:16:10] total 585496
[2024-06-22 01:16:10] -rw-r--r-- 1 boincer umatlas    469766 Jun 21 18:41 pilot3.tar.gz
[2024-06-22 01:16:10] -rw-r--r-- 1 boincer umatlas      5654 Jun 21 18:42 queuedata.json
[2024-06-22 01:16:10] -rwx------ 1 boincer umatlas     32308 Jun 21 18:44 runpilot2-wrapper.sh
[2024-06-22 01:16:10] -rw-r--r-- 1 boincer umatlas       100 Jun 22 01:08 wrapper_26015_x86_64-pc-linux-gnu
[2024-06-22 01:16:10] -rwxr-xr-x 1 boincer umatlas      7986 Jun 22 01:08 run_atlas
[2024-06-22 01:16:10] -rw-r--r-- 1 boincer umatlas       105 Jun 22 01:08 job.xml
[2024-06-22 01:16:10] -rw-r--r-- 2 boincer umatlas 595935295 Jun 22 01:09 EVNT.40024021._000007.pool.root.1
[2024-06-22 01:16:10] -rw-r--r-- 2 boincer umatlas     17537 Jun 22 01:09 start_atlas.sh
[2024-06-22 01:16:10] drwxrwx--x 2 boincer umatlas      4096 Jun 22 01:09 shared
[2024-06-22 01:16:10] -rw-r--r-- 2 boincer umatlas    482493 Jun 22 01:09 input.tar.gz
[2024-06-22 01:16:10] -rw-r--r-- 1 boincer umatlas         0 Jun 22 01:09 boinc_lockfile
[2024-06-22 01:16:10] -rw-r--r-- 1 boincer umatlas      2513 Jun 22 01:09 pandaJob.out
[2024-06-22 01:16:10] -rw------- 1 boincer umatlas       424 Jun 22 01:09 setup.sh.local
[2024-06-22 01:16:10] -rw------- 1 boincer umatlas   1025953 Jun 22 01:10 agis_schedconf.cvmfs.json
[2024-06-22 01:16:10] -rw------- 1 boincer umatlas         0 Jun 22 01:10 agis_ddmendpoints.agis.ALL.json
[2024-06-22 01:16:10] -rw------- 1 boincer umatlas   1321363 Jun 22 01:10 cric_ddmendpoints.json
[2024-06-22 01:16:10] drwx------ 4 boincer umatlas      4096 Jun 22 01:10 pilot3
[2024-06-22 01:16:10] -rw------- 1 boincer umatlas       545 Jun 22 01:12 heartbeat.json
[2024-06-22 01:16:10] -rw------- 1 boincer umatlas        95 Jun 22 01:12 pilot_heartbeat.json
[2024-06-22 01:16:10] drwxrwx--- 2 boincer umatlas      4096 Jun 22 01:13 PanDA_Pilot-6240458604
[2024-06-22 01:16:10] -rw-r--r-- 1 boincer umatlas      6296 Jun 22 01:14 init_data.xml
[2024-06-22 01:16:10] -rw-r--r-- 1 boincer umatlas       524 Jun 22 01:15 boinc_task_state.xml
[2024-06-22 01:16:10] -rw------- 1 boincer umatlas     43111 Jun 22 01:16 pilotlog.txt
[2024-06-22 01:16:10] -rw------- 1 boincer umatlas     65027 Jun 22 01:16 log.40024023._001517.job.log.1
[2024-06-22 01:16:10] -rw-r--r-- 1 boincer umatlas       428 Jun 22 01:16 runtime_log
[2024-06-22 01:16:10] -rw------- 1 boincer umatlas       609 Jun 22 01:16 i9YMDmxA2e5nsSi4ap6QjLDmwznN0nGgGQJmpmIZDmGCnKDm5snaom.diag
[2024-06-22 01:16:10] -rw-r--r-- 1 boincer umatlas      8192 Jun 22 01:16 boinc_mmap_file
[2024-06-22 01:16:10] -rw-r--r-- 1 boincer umatlas        22 Jun 22 01:16 wrapper_checkpoint.txt
[2024-06-22 01:16:10] -rw-r--r-- 1 boincer umatlas     11289 Jun 22 01:16 runtime_log.err
[2024-06-22 01:16:10] -rw-r--r-- 1 boincer umatlas     27981 Jun 22 01:16 stderr.txt
[2024-06-22 01:16:10] No HITS result produced
[2024-06-22 01:16:10]  *** Contents of shared directory: ***
[2024-06-22 01:16:10] total 582468
[2024-06-22 01:16:10] -rw-r--r-- 2 boincer umatlas 595935295 Jun 22 01:09 ATLAS.root_0
[2024-06-22 01:16:10] -rw-r--r-- 2 boincer umatlas     17537 Jun 22 01:09 start_atlas.sh
[2024-06-22 01:16:10] -rw-r--r-- 2 boincer umatlas    482493 Jun 22 01:09 input.tar.gz
01:16:11 (55858): run_atlas exited; CPU time 14.099643
01:16:11 (55858): called boinc_finish(0)

</stderr_txt>
<message>
upload failure: <file_xfer_error>
  <file_name>i9YMDmxA2e5nsSi4ap6QjLDmwznN0nGgGQJmpmIZDmGCnKDm5snaom_0_r833472567_ATLAS_result</file_name>
  <error_code>-161 (not found)</error_code>
</file_xfer_error>

</message>
]]>


©2024 CERN