Name sPYKDm4f3P7n9Rq4apOajLDm4fhM0noT9bVoFjIUDmfK5KDmqh5Cxn_0
Workunit 231708871
Created 18 Apr 2025, 16:23:30 UTC
Sent 18 Apr 2025, 19:18:53 UTC
Report deadline 26 Apr 2025, 19:18:53 UTC
Received 18 Apr 2025, 19:45:29 UTC
Server state Over
Outcome Computation error
Client state Compute error
Exit status 0 (0x00000000)
Computer ID 10805937
Run time 19 min 40 sec
CPU time 1 min 54 sec
Validate state Invalid
Credit 0.00
Device peak FLOPS 44.09 GFLOPS
Application version ATLAS Simulation v3.01 (native_mt)
x86_64-pc-linux-gnu
Peak working set size 1.14 GB
Peak swap size 1.72 GB
Peak disk usage 437.18 MB

Stderr output

<core_client_version>7.7.0</core_client_version>
<![CDATA[
<stderr_txt>
15:19:43 (29641): wrapper (7.7.26015): starting
15:19:43 (29641): wrapper: running run_atlas (--nthreads 8)
[2025-04-18 15:19:43] Arguments: --nthreads 8
[2025-04-18 15:19:43] Threads: 8
[2025-04-18 15:19:43] Checking for CVMFS
[2025-04-18 15:19:43] Probing /cvmfs/atlas.cern.ch... OK
[2025-04-18 15:19:43] Probing /cvmfs/atlas-condb.cern.ch... OK
[2025-04-18 15:19:43] Running cvmfs_config stat atlas.cern.ch
[2025-04-18 15:19:44] 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
[2025-04-18 15:19:44] 2.11.2.0 21107 19551 161420 145013 1 323 10245466 18432000 27142 130560 0 123626355 98.564 370691911 57052 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1
[2025-04-18 15:19:44] CVMFS is ok
[2025-04-18 15:19:44] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2025-04-18 15:19:44] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2025-04-18 15:19:44] Further information can be found at the LHC@home message board.
[2025-04-18 15:19:44] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2025-04-18 15:19:44] Checking for apptainer binary...
[2025-04-18 15:19:44] Using apptainer found in PATH at /usr/bin/apptainer
[2025-04-18 15:19:44] Running /usr/bin/apptainer --version
[2025-04-18 15:19:44] apptainer version 1.3.2-1.el7
[2025-04-18 15:19:44] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2025-04-18 15:19:46] c-212-4.aglt2.org
[2025-04-18 15:19:46] apptainer works
[2025-04-18 15:19:46] Set ATHENA_PROC_NUMBER=8
[2025-04-18 15:19:46] Set ATHENA_CORE_NUMBER=8
[2025-04-18 15:19:46] Starting ATLAS job with PandaID=6606654271
[2025-04-18 15:19:46] 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
[2025-04-18 15:39:19]  *** The last 200 lines of the pilot log: ***
[2025-04-18 15:39:19]     _, stdout, stderr = execute(cmd)
[2025-04-18 15:39:19]   File "/tmp/boinchome/slots/5/pilot3/pilot/util/container.py", line 85, in execute
[2025-04-18 15:39:19]     process = subprocess.Popen(
[2025-04-18 15:39:19]   File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/python/3.9.20-x86_64-centos7/lib/python3.9/subprocess.py", line 951, in __init__
[2025-04-18 15:39:19]     self._execute_child(args, executable, preexec_fn, close_fds,
[2025-04-18 15:39:19]   File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/python/3.9.20-x86_64-centos7/lib/python3.9/subprocess.py", line 1837, in _execute_child
[2025-04-18 15:39:19]     raise child_exception_type(errno_num, err_msg, err_filename)
[2025-04-18 15:39:19] OSError: [Errno 107] Transport endpoint is not connected: '/bin/bash'
[2025-04-18 15:39:19] 
[2025-04-18 15:39:19] None
[2025-04-18 15:39:19] exception has been put in bucket queue belonging to thread 'copytool_out'
[2025-04-18 15:39:19] setting graceful stop in 10 s since there is no point in continuing
[2025-04-18 15:39:19] 2025-04-18 19:36:36,063 | WARNING  | thread 'copytool_out' received an exception from bucket: [Errno 107] Transport endpoint is not connected: '/bin/bash'
[2025-04-18 15:39:19] 2025-04-18 19:36:38,878 | WARNING  | process 79495 can no longer be monitored (due to stat problems) - aborting
[2025-04-18 15:39:19] 2025-04-18 19:36:38,878 | INFO     | using path: /tmp/boinchome/slots/5/PanDA_Pilot-6606654271/memory_monitor_summary.json (trf name=prmon)
[2025-04-18 15:39:19] 2025-04-18 19:36:39,214 | INFO     | number of running child processes to parent process 79495: 1
[2025-04-18 15:39:19] 2025-04-18 19:36:39,215 | INFO     | maximum number of monitored processes: 6
[2025-04-18 15:39:19] 2025-04-18 19:36:41,718 | INFO     | monitor loop #83: job 0:6606654271 is in state 'failed'
[2025-04-18 15:39:19] 2025-04-18 19:36:41,718 | INFO     | will abort job monitoring soon since job state=failed (job is still in queue)
[2025-04-18 15:39:19] 2025-04-18 19:36:42,337 | INFO     | PID=48894 has CPU usage=10.3% CMD=/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/python/3.9.20-x86_64-centos7/bin/python3 pilot3/pilot.py -q BOINC_MCORE -i PR
[2025-04-18 15:39:19] 2025-04-18 19:36:42,338 | INFO     | .. there are 49 such processes running
[2025-04-18 15:39:19] 2025-04-18 19:36:44,224 | INFO     | monitor loop #84: job 0:6606654271 is in state 'failed'
[2025-04-18 15:39:19] 2025-04-18 19:36:44,224 | INFO     | will abort job monitoring soon since job state=failed (job is still in queue)
[2025-04-18 15:39:19] 2025-04-18 19:36:45,123 | WARNING  | aborting monitor loop since graceful_stop has been set (timing out remaining threads)
[2025-04-18 15:39:19] 2025-04-18 19:36:45,123 | INFO     | found 1 job(s) in 20 queues
[2025-04-18 15:39:19] 2025-04-18 19:36:45,123 | INFO     | aborting job 6606654271
[2025-04-18 15:39:19] 2025-04-18 19:36:45,123 | WARNING  | could not find signal name for signal number None - using SIGTERM
[2025-04-18 15:39:19] 2025-04-18 19:36:45,147 | WARNING  | job:job_monitor:received graceful stop - abort after this iteration
[2025-04-18 15:39:19] 2025-04-18 19:36:45,159 | INFO     | will abort loop
[2025-04-18 15:39:19] 2025-04-18 19:36:45,229 | WARNING  | pilot monitor received instruction that args.graceful_stop has been set
[2025-04-18 15:39:19] 2025-04-18 19:36:45,230 | WARNING  | will wait for a maximum of 300 s for threads to finish
[2025-04-18 15:39:19] 2025-04-18 19:36:45,465 | INFO     | all job control threads have been joined
[2025-04-18 15:39:19] 2025-04-18 19:36:45,880 | INFO     | all data control threads have been joined
[2025-04-18 15:39:19] 2025-04-18 19:36:45,976 | WARNING  | job:queue_monitor:received graceful stop - abort after this iteration
[2025-04-18 15:39:19] 2025-04-18 19:36:45,977 | WARNING  | since job:queue_monitor is responsible for sending job updates, we sleep for 20 s
[2025-04-18 15:39:19] 2025-04-18 19:36:46,165 | INFO     | [job] job monitor thread has finished
[2025-04-18 15:39:19] 2025-04-18 19:36:46,235 | INFO     | [payload] run_realtimelog thread has finished
[2025-04-18 15:39:19] 2025-04-18 19:36:46,415 | INFO     | [payload] validate_pre thread has finished
[2025-04-18 15:39:19] 2025-04-18 19:36:46,472 | INFO     | [job] control thread has finished
[2025-04-18 15:39:19] 2025-04-18 19:36:46,569 | INFO     | all payload control threads have been joined
[2025-04-18 15:39:19] 2025-04-18 19:36:46,886 | INFO     | [data] control thread has finished
[2025-04-18 15:39:19] 2025-04-18 19:36:47,066 | INFO     | [job] retrieve thread has finished
[2025-04-18 15:39:19] 2025-04-18 19:36:47,228 | INFO     | [payload] failed_post thread has finished
[2025-04-18 15:39:19] 2025-04-18 19:36:47,236 | INFO     | [job] validate thread has finished
[2025-04-18 15:39:19] 2025-04-18 19:36:47,335 | WARNING  | data:queue_monitoring:received graceful stop - abort after this iteration
[2025-04-18 15:39:19] 2025-04-18 19:36:47,349 | INFO     | [data] copytool_in thread has finished
[2025-04-18 15:39:19] 2025-04-18 19:36:47,393 | INFO     | [job] create_data_payload thread has finished
[2025-04-18 15:39:19] 2025-04-18 19:36:47,574 | INFO     | [payload] control thread has finished
[2025-04-18 15:39:19] 2025-04-18 19:36:47,580 | INFO     | [payload] validate_post thread has finished
[2025-04-18 15:39:19] 2025-04-18 19:36:50,988 | INFO     | [payload] execute_payloads thread has finished
[2025-04-18 15:39:19] 2025-04-18 19:36:51,343 | INFO     | [data] queue_monitor thread has finished
[2025-04-18 15:39:19] 2025-04-18 19:37:07,079 | INFO     | job 6606654271 has state=failed
[2025-04-18 15:39:19] 2025-04-18 19:37:07,079 | INFO     | preparing for final server update for job 6606654271 in state='failed'
[2025-04-18 15:39:19] 2025-04-18 19:37:07,345 | WARNING  | job_aborted has been set - aborting pilot monitoring
[2025-04-18 15:39:19] 2025-04-18 19:37:07,346 | INFO     | [monitor] control thread has ended
[2025-04-18 15:39:19] 2025-04-18 19:37:08,108 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:37:10,120 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:37:12,130 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:37:14,142 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:37:16,153 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:37:18,163 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:37:20,173 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:37:22,184 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:37:24,198 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:37:26,210 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:37:28,220 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:37:30,231 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:37:32,241 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:37:34,253 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:37:36,264 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:37:38,270 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:37:40,281 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:37:42,291 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:37:44,301 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:37:46,312 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:37:48,322 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:37:50,332 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:37:52,343 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:37:54,354 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:37:56,364 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:37:58,375 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:00,386 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:02,396 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:04,406 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:06,417 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:08,427 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:10,437 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:12,447 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:14,458 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:16,469 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:18,474 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:20,486 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:22,496 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:24,508 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:26,516 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:28,528 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:30,539 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:32,549 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:34,559 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:36,565 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:38,577 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:40,588 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:42,599 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:44,610 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:46,620 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:48,630 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:50,642 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:52,652 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:54,660 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:56,670 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:38:58,682 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:39:00,692 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:39:02,152 | INFO     | proceeding with final server update
[2025-04-18 15:39:19] 2025-04-18 19:39:02,153 | INFO     | this job has now completed (state=failed)
[2025-04-18 15:39:19] 2025-04-18 19:39:02,154 | INFO     | pilot will not update the server (heartbeat message will be written to file)
[2025-04-18 15:39:19] 2025-04-18 19:39:02,154 | INFO     | log transfer has not been attempted: IN_PROGRESS
[2025-04-18 15:39:19] 2025-04-18 19:39:02,154 | INFO     | job 6606654271 has state 'failed' - writing heartbeat
[2025-04-18 15:39:19] 2025-04-18 19:39:02,154 | INFO     | payload/TRF did not report the number of read events
[2025-04-18 15:39:19] 2025-04-18 19:39:02,158 | INFO     | executing command: lscpu
[2025-04-18 15:39:19]   File "/tmp/boinchome/slots/5/pilot3/pilot/common/exception.py", line 466, in run
[2025-04-18 15:39:19]     self._target(**self.kwargs)
[2025-04-18 15:39:19]   File "/tmp/boinchome/slots/5/pilot3/pilot/control/job.py", line 2651, in queue_monitor
[2025-04-18 15:39:19]     update_server(job, args)
[2025-04-18 15:39:19]   File "/tmp/boinchome/slots/5/pilot3/pilot/control/job.py", line 2700, in update_server
[2025-04-18 15:39:19]     send_state(job, args, job.state, metadata=metadata)
[2025-04-18 15:39:19]   File "/tmp/boinchome/slots/5/pilot3/pilot/control/job.py", line 431, in send_state
[2025-04-18 15:39:19]     data = get_data_structure(job, state, args, xml=xml, metadata=metadata)
[2025-04-18 15:39:19]   File "/tmp/boinchome/slots/5/pilot3/pilot/control/job.py", line 758, in get_data_structure
[2025-04-18 15:39:19]     cpumodel, cpu_mhz = get_cpu_info(cpumodel)  # add the CPU cores if not present
[2025-04-18 15:39:19]   File "/tmp/boinchome/slots/5/pilot3/pilot/util/workernode.py", line 368, in get_cpu_info
[2025-04-18 15:39:19]     ec, stdout = lscpu()
[2025-04-18 15:39:19]   File "/tmp/boinchome/slots/5/pilot3/pilot/util/workernode.py", line 347, in lscpu
[2025-04-18 15:39:19]     ec, stdout, _ = execute(cmd)
[2025-04-18 15:39:19]   File "/tmp/boinchome/slots/5/pilot3/pilot/util/container.py", line 85, in execute
[2025-04-18 15:39:19]     process = subprocess.Popen(
[2025-04-18 15:39:19]   File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/python/3.9.20-x86_64-centos7/lib/python3.9/subprocess.py", line 951, in __init__
[2025-04-18 15:39:19]     self._execute_child(args, executable, preexec_fn, close_fds,
[2025-04-18 15:39:19]   File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/python/3.9.20-x86_64-centos7/lib/python3.9/subprocess.py", line 1837, in _execute_child
[2025-04-18 15:39:19]     raise child_exception_type(errno_num, err_msg, err_filename)
[2025-04-18 15:39:19] unexpected exception caught by thread run() function: (<class 'OSError'>, OSError(107, 'Transport endpoint is not connected'), <traceback object at 0x7f932860f740>)
[2025-04-18 15:39:19] Traceback (most recent call last):
[2025-04-18 15:39:19]   File "/tmp/boinchome/slots/5/pilot3/pilot/common/exception.py", line 466, in run
[2025-04-18 15:39:19]     self._target(**self.kwargs)
[2025-04-18 15:39:19]   File "/tmp/boinchome/slots/5/pilot3/pilot/control/job.py", line 2651, in queue_monitor
[2025-04-18 15:39:19]     update_server(job, args)
[2025-04-18 15:39:19]   File "/tmp/boinchome/slots/5/pilot3/pilot/control/job.py", line 2700, in update_server
[2025-04-18 15:39:19]     send_state(job, args, job.state, metadata=metadata)
[2025-04-18 15:39:19]   File "/tmp/boinchome/slots/5/pilot3/pilot/control/job.py", line 431, in send_state
[2025-04-18 15:39:19]     data = get_data_structure(job, state, args, xml=xml, metadata=metadata)
[2025-04-18 15:39:19]   File "/tmp/boinchome/slots/5/pilot3/pilot/control/job.py", line 758, in get_data_structure
[2025-04-18 15:39:19]     cpumodel, cpu_mhz = get_cpu_info(cpumodel)  # add the CPU cores if not present
[2025-04-18 15:39:19]   File "/tmp/boinchome/slots/5/pilot3/pilot/util/workernode.py", line 368, in get_cpu_info
[2025-04-18 15:39:19]     ec, stdout = lscpu()
[2025-04-18 15:39:19]   File "/tmp/boinchome/slots/5/pilot3/pilot/util/workernode.py", line 347, in lscpu
[2025-04-18 15:39:19]     ec, stdout, _ = execute(cmd)
[2025-04-18 15:39:19]   File "/tmp/boinchome/slots/5/pilot3/pilot/util/container.py", line 85, in execute
[2025-04-18 15:39:19]     process = subprocess.Popen(
[2025-04-18 15:39:19]   File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/python/3.9.20-x86_64-centos7/lib/python3.9/subprocess.py", line 951, in __init__
[2025-04-18 15:39:19]     self._execute_child(args, executable, preexec_fn, close_fds,
[2025-04-18 15:39:19]   File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/python/3.9.20-x86_64-centos7/lib/python3.9/subprocess.py", line 1837, in _execute_child
[2025-04-18 15:39:19]     raise child_exception_type(errno_num, err_msg, err_filename)
[2025-04-18 15:39:19] OSError: [Errno 107] Transport endpoint is not connected: '/bin/bash'
[2025-04-18 15:39:19] 
[2025-04-18 15:39:19] None
[2025-04-18 15:39:19] exception has been put in bucket queue belonging to thread 'queue_monitor'
[2025-04-18 15:39:19] setting graceful stop in 10 s since there is no point in continuing
[2025-04-18 15:39:19] 2025-04-18 19:39:02,702 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:39:04,712 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:39:06,722 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:39:08,732 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:39:10,741 | INFO     | waiting for thread to finish: ['<_MainThread(MainThread, started 140270179657536)>', '<ExcThread(queue_monitor, started 140269001373440)>']
[2025-04-18 15:39:19] 2025-04-18 19:39:12,752 | INFO     | caller=run is remaining thread - safe to abort (names=['<_MainThread(MainThread, started 140270179657536)>'])
[2025-04-18 15:39:19] 2025-04-18 19:39:17,777 | INFO     | all workflow threads have been joined
[2025-04-18 15:39:19] 2025-04-18 19:39:17,778 | INFO     | end of generic workflow (traces error code: 0)
[2025-04-18 15:39:19] 2025-04-18 19:39:17,778 | INFO     | traces error code: 0
[2025-04-18 15:39:19] 2025-04-18 19:39:17,779 | INFO     | pilot has finished (exit code=0, shell exit code=0)
[2025-04-18 15:39:19] ./runpilot2-wrapper.sh: line 15: /usr/bin/date: Transport endpoint is not connected
[2025-04-18 15:39:19]  ==== pilot stdout END ====
[2025-04-18 15:39:19] ./runpilot2-wrapper.sh: line 15: /usr/bin/date: Transport endpoint is not connected
[2025-04-18 15:39:19]  ==== wrapper stdout RESUME ====
[2025-04-18 15:39:19] ./runpilot2-wrapper.sh: line 15: /usr/bin/date: Transport endpoint is not connected
[2025-04-18 15:39:19]  pilotpid: 48894
[2025-04-18 15:39:19] ./runpilot2-wrapper.sh: line 15: /usr/bin/date: Transport endpoint is not connected
[2025-04-18 15:39:19]  Pilot exit status: 0
[2025-04-18 15:39:19] ./runpilot2-wrapper.sh: line 1045: /usr/bin/cat: Transport endpoint is not connected
[2025-04-18 15:39:19] ./runpilot2-wrapper.sh: line 1045: /usr/bin/cut: Transport endpoint is not connected
[2025-04-18 15:39:19] ./runpilot2-wrapper.sh: line 1045: xargs: command not found
[2025-04-18 15:39:19] ./runpilot2-wrapper.sh: line 15: /usr/bin/date: Transport endpoint is not connected
[2025-04-18 15:39:19]  pandaids: 
[2025-04-18 15:39:19] ./runpilot2-wrapper.sh: line 546: /usr/bin/ps: Transport endpoint is not connected
[2025-04-18 15:39:19] ./runpilot2-wrapper.sh: line 15: /usr/bin/date: Transport endpoint is not connected
[2025-04-18 15:39:19]  No supervise_pilot CHILD process found
[2025-04-18 15:39:19] ./runpilot2-wrapper.sh: line 15: /usr/bin/date: Transport endpoint is not connected
[2025-04-18 15:39:19]  Test setup, not cleaning
[2025-04-18 15:39:19] ./runpilot2-wrapper.sh: line 15: /usr/bin/date: Transport endpoint is not connected
[2025-04-18 15:39:19]  apfmon messages muted
[2025-04-18 15:39:19] ./runpilot2-wrapper.sh: line 15: /usr/bin/date: Transport endpoint is not connected
[2025-04-18 15:39:19]  ==== wrapper stdout END ====
[2025-04-18 15:39:19] ./runpilot2-wrapper.sh: line 10: /usr/bin/date: Transport endpoint is not connected
[2025-04-18 15:39:19]  ==== wrapper stderr END ====
[2025-04-18 15:39:19]  *** Error codes and diagnostics ***
[2025-04-18 15:39:19]  *** Listing of results directory ***
[2025-04-18 15:39:19] total 223940
[2025-04-18 15:39:19] -rw-r--r-- 1 boincer umatlas    495897 Apr 18 11:45 pilot3.tar.gz
[2025-04-18 15:39:19] -rw-r--r-- 1 boincer umatlas      5111 Apr 18 12:22 queuedata.json
[2025-04-18 15:39:19] -rwx------ 1 boincer umatlas     37140 Apr 18 12:23 runpilot2-wrapper.sh
[2025-04-18 15:39:19] -rw-r--r-- 1 boincer umatlas       100 Apr 18 15:19 wrapper_26015_x86_64-pc-linux-gnu
[2025-04-18 15:39:19] -rwxr-xr-x 1 boincer umatlas      7986 Apr 18 15:19 run_atlas
[2025-04-18 15:39:19] -rw-r--r-- 1 boincer umatlas       105 Apr 18 15:19 job.xml
[2025-04-18 15:39:19] -rw-r--r-- 2 boincer umatlas 225219203 Apr 18 15:19 EVNT.44075481._002775.pool.root.1
[2025-04-18 15:39:19] -rw-r--r-- 2 boincer umatlas     17569 Apr 18 15:19 start_atlas.sh
[2025-04-18 15:39:19] drwxrwx--x 2 boincer umatlas      4096 Apr 18 15:19 shared
[2025-04-18 15:39:19] -rw-r--r-- 2 boincer umatlas    508891 Apr 18 15:19 input.tar.gz
[2025-04-18 15:39:19] -rw-r--r-- 1 boincer umatlas         0 Apr 18 15:19 boinc_lockfile
[2025-04-18 15:39:19] -rw-r--r-- 1 boincer umatlas      2578 Apr 18 15:19 pandaJob.out
[2025-04-18 15:39:19] -rw------- 1 boincer umatlas       467 Apr 18 15:19 setup.sh.local
[2025-04-18 15:39:19] -rw------- 1 boincer umatlas    991292 Apr 18 15:20 agis_schedconf.cvmfs.json
[2025-04-18 15:39:19] -rw------- 1 boincer umatlas   1618536 Apr 18 15:20 agis_ddmendpoints.agis.ALL.json
[2025-04-18 15:39:19] drwx------ 4 boincer umatlas      4096 Apr 18 15:20 pilot3
[2025-04-18 15:39:19] -rw------- 1 boincer umatlas       547 Apr 18 15:22 heartbeat.json
[2025-04-18 15:39:19] -rw-r--r-- 1 boincer umatlas      6383 Apr 18 15:28 init_data.xml
[2025-04-18 15:39:19] -rw------- 1 boincer umatlas        95 Apr 18 15:35 pilot_heartbeat.json
[2025-04-18 15:39:19] -rw------- 1 boincer umatlas      1026 Apr 18 15:36 memory_monitor_summary.json
[2025-04-18 15:39:19] -rw-r--r-- 1 boincer umatlas       527 Apr 18 15:36 boinc_task_state.xml
[2025-04-18 15:39:19] drwxrwx--- 2 boincer umatlas      4096 Apr 18 15:36 PanDA_Pilot-6606654271
[2025-04-18 15:39:19] -rw-r--r-- 1 boincer umatlas        25 Apr 18 15:39 wrapper_checkpoint.txt
[2025-04-18 15:39:19] -rw-r--r-- 1 boincer umatlas      8192 Apr 18 15:39 boinc_mmap_file
[2025-04-18 15:39:19] -rw------- 1 boincer umatlas    117065 Apr 18 15:39 pilotlog.txt
[2025-04-18 15:39:19] -rw------- 1 boincer umatlas    141662 Apr 18 15:39 log.44075483._071445.job.log.1
[2025-04-18 15:39:19] -rw-r--r-- 1 boincer umatlas       428 Apr 18 15:39 runtime_log
[2025-04-18 15:39:19] -rw------- 1 boincer umatlas       627 Apr 18 15:39 sPYKDm4f3P7n9Rq4apOajLDm4fhM0noT9bVoFjIUDmfK5KDmqh5Cxn.diag
[2025-04-18 15:39:19] -rw-r--r-- 1 boincer umatlas     11706 Apr 18 15:39 runtime_log.err
[2025-04-18 15:39:19] -rw-r--r-- 1 boincer umatlas     28250 Apr 18 15:39 stderr.txt
[2025-04-18 15:39:19] No HITS result produced
[2025-04-18 15:39:19]  *** Contents of shared directory: ***
[2025-04-18 15:39:19] total 220464
[2025-04-18 15:39:19] -rw-r--r-- 2 boincer umatlas 225219203 Apr 18 15:19 ATLAS.root_0
[2025-04-18 15:39:19] -rw-r--r-- 2 boincer umatlas     17569 Apr 18 15:19 start_atlas.sh
[2025-04-18 15:39:19] -rw-r--r-- 2 boincer umatlas    508891 Apr 18 15:19 input.tar.gz
15:39:21 (29641): run_atlas exited; CPU time 98.847221
15:39:21 (29641): called boinc_finish(0)

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

</message>
]]>


©2025 CERN