| Name | YkhNDm5BAT5nsSi4apGgGQJmABFKDmABFKDm4ySLDmFQVKDmTVo6En_0 |
| Workunit | 223135167 |
| Created | 20 May 2024, 4:53:03 UTC |
| Sent | 20 May 2024, 8:30:34 UTC |
| Report deadline | 28 May 2024, 8:30:34 UTC |
| Received | 21 May 2024, 6:26:02 UTC |
| Server state | Over |
| Outcome | No reply |
| Client state | Compute error |
| Exit status | 0 (0x00000000) |
| Computer ID | 10804962 |
| Run time | 21 hours 24 min 58 sec |
| CPU time | 2 days 12 hours 31 min 9 sec |
| Validate state | Initial |
| Credit | 0.00 |
| Device peak FLOPS | 40.68 GFLOPS |
| Application version | ATLAS Simulation v3.01 (native_mt) x86_64-pc-linux-gnu |
| Peak working set size | 2.54 GB |
| Peak swap size | 31.77 GB |
| Peak disk usage | 1.85 GB |
Stderr output
<core_client_version>7.7.0</core_client_version>
<![CDATA[
<stderr_txt>
04:31:10 (2876): wrapper (7.7.26015): starting
04:31:10 (2876): wrapper: running run_atlas (--nthreads 8)
[2024-05-20 04:31:10] Arguments: --nthreads 8
[2024-05-20 04:31:10] Threads: 8
[2024-05-20 04:31:10] Checking for CVMFS
[2024-05-20 04:31:11] Probing /cvmfs/atlas.cern.ch... OK
[2024-05-20 04:31:12] Probing /cvmfs/atlas-condb.cern.ch... OK
[2024-05-20 04:31:12] Running cvmfs_config stat atlas.cern.ch
[2024-05-20 04:31:14] VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
[2024-05-20 04:31:14] 2.11.2.0 46351 6464 116344 132943 1 217 14440421 18432001 19489 130560 0 42759284 98.596 109539069 51942 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1
[2024-05-20 04:31:14] CVMFS is ok
[2024-05-20 04:31:14] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2024-05-20 04:31:14] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2024-05-20 04:31:14] Further information can be found at the LHC@home message board.
[2024-05-20 04:31:14] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2024-05-20 04:31:14] Checking for apptainer binary...
[2024-05-20 04:31:14] Using apptainer found in PATH at /usr/bin/apptainer
[2024-05-20 04:31:14] Running /usr/bin/apptainer --version
[2024-05-20 04:31:14] apptainer version 1.3.0-1.el7
[2024-05-20 04:31:14] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2024-05-20 04:31:44] c-212-6.aglt2.org
[2024-05-20 04:31:44] apptainer works
[2024-05-20 04:31:44] Set ATHENA_PROC_NUMBER=8
[2024-05-20 04:31:44] Set ATHENA_CORE_NUMBER=8
[2024-05-20 04:31:44] Starting ATLAS job with PandaID=6210308767
[2024-05-20 04:31:44] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/3 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
06:12:36 (2876): BOINC client no longer exists - exiting
06:12:36 (2876): timer handler: client dead, exiting
06:28:52 (57437): wrapper (7.7.26015): starting
06:28:52 (57437): wrapper: running run_atlas (--nthreads 8)
[2024-05-20 06:28:52] Arguments: --nthreads 8
[2024-05-20 06:28:52] Threads: 8
[2024-05-20 06:28:52] This job has been restarted, cleaning up previous attempt
[2024-05-20 06:28:52] Checking for CVMFS
[2024-05-20 06:28:53] Probing /cvmfs/atlas.cern.ch... OK
[2024-05-20 06:28:53] Probing /cvmfs/atlas-condb.cern.ch... OK
[2024-05-20 06:28:53] Running cvmfs_config stat atlas.cern.ch
[2024-05-20 06:28:53] VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
[2024-05-20 06:28:53] 2.11.2.0 58541 23 77828 132945 0 524 15784112 18432001 13006 130560 0 389583 96.657 2228536 57574 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.237.109:6081 1
[2024-05-20 06:28:53] CVMFS is ok
[2024-05-20 06:28:53] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2024-05-20 06:28:53] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2024-05-20 06:28:53] Further information can be found at the LHC@home message board.
[2024-05-20 06:28:53] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2024-05-20 06:28:53] Checking for apptainer binary...
[2024-05-20 06:28:53] Using apptainer found in PATH at /usr/bin/apptainer
[2024-05-20 06:28:53] Running /usr/bin/apptainer --version
[2024-05-20 06:28:53] apptainer version 1.3.0-1.el7
[2024-05-20 06:28:53] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2024-05-20 06:28:55] c-212-6.aglt2.org
[2024-05-20 06:28:55] apptainer works
[2024-05-20 06:28:56] Set ATHENA_PROC_NUMBER=8
[2024-05-20 06:28:56] Set ATHENA_CORE_NUMBER=8
[2024-05-20 06:28:56] Starting ATLAS job with PandaID=6210308767
[2024-05-20 06:28:56] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/3 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
21:00:05 (57437): BOINC client no longer exists - exiting
21:00:05 (57437): timer handler: client dead, exiting
21:11:39 (29853): wrapper (7.7.26015): starting
21:11:39 (29853): wrapper: running run_atlas (--nthreads 8)
[2024-05-20 21:11:39] Arguments: --nthreads 8
[2024-05-20 21:11:39] Threads: 8
[2024-05-20 21:11:39] This job has been restarted, cleaning up previous attempt
[2024-05-20 21:11:39] Checking for CVMFS
[2024-05-20 21:11:40] Probing /cvmfs/atlas.cern.ch... OK
[2024-05-20 21:11:40] Probing /cvmfs/atlas-condb.cern.ch... OK
[2024-05-20 21:11:40] Running cvmfs_config stat atlas.cern.ch
[2024-05-20 21:11:41] VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
[2024-05-20 21:11:41] 2.11.2.0 58541 906 124756 132968 1 84 2045165 18432000 14562 130560 0 4158 64.688 803979 74733 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.231.237:6081 1
[2024-05-20 21:11:41] CVMFS is ok
[2024-05-20 21:11:41] Efficiency of ATLAS tasks can be improved by the following measure(s):
[2024-05-20 21:11:41] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io.
[2024-05-20 21:11:41] Further information can be found at the LHC@home message board.
[2024-05-20 21:11:41] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2024-05-20 21:11:41] Checking for apptainer binary...
[2024-05-20 21:11:41] Using apptainer found in PATH at /usr/bin/apptainer
[2024-05-20 21:11:41] Running /usr/bin/apptainer --version
[2024-05-20 21:11:41] apptainer version 1.3.0-1.el7
[2024-05-20 21:11:41] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2024-05-20 21:11:45] c-212-6.aglt2.org
[2024-05-20 21:11:45] apptainer works
[2024-05-20 21:11:45] Set ATHENA_PROC_NUMBER=8
[2024-05-20 21:11:45] Set ATHENA_CORE_NUMBER=8
[2024-05-20 21:11:45] Starting ATLAS job with PandaID=6210308767
[2024-05-20 21:11:45] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/3 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2024-05-21 02:24:22] *** The last 200 lines of the pilot log: ***
[2024-05-21 02:24:22] 2024-05-21 06:21:39,485 | WARNING | thread 'copytool_out' received an exception from bucket: [Errno 107] Transport endpoint is not connected: '/bin/bash'
[2024-05-21 02:24:22] 2024-05-21 06:21:44,488 | INFO | 18574s have passed since pilot start
[2024-05-21 02:24:22] 2024-05-21 06:21:45,130 | WARNING | Exception caught: [Errno 107] Transport endpoint is not connected: '/bin/bash'
[2024-05-21 02:24:22] 2024-05-21 06:21:45,130 | WARNING | Traceback (most recent call last):
[2024-05-21 02:24:22] File "/tmp/boinchome/slots/3/pilot3/pilot/util/monitoring.py", line 109, in job_monitor_tasks
[2024-05-21 02:24:22] cpuconsumptiontime = get_current_cpu_consumption_time(job.pid)
[2024-05-21 02:24:22] File "/tmp/boinchome/slots/3/pilot3/pilot/util/processes.py", line 571, in get_current_cpu_consumption_time
[2024-05-21 02:24:22] _, ps_cache, _ = execute("ps -eo pid,ppid -m", mute=True, timeout=60)
[2024-05-21 02:24:22] File "/tmp/boinchome/slots/3/pilot3/pilot/util/container.py", line 94, in execute
[2024-05-21 02:24:22] process = subprocess.Popen(exe,
[2024-05-21 02:24:22] 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-05-21 02:24:22] self._execute_child(args, executable, preexec_fn, close_fds,
[2024-05-21 02:24:22] 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-05-21 02:24:22] raise child_exception_type(errno_num, err_msg, err_filename)
[2024-05-21 02:24:22] OSError: [Errno 107] Transport endpoint is not connected: '/bin/bash'
[2024-05-21 02:24:22]
[2024-05-21 02:24:22] 2024-05-21 06:21:45,131 | WARNING | will send preliminary diagnostics (and pretend job is still running)=Exception caught: [Errno 107] Transport endpoint is not connected: '/bin/bash'
[2024-05-21 02:24:22] 2024-05-21 06:21:45,131 | INFO | pilot will not update the server (heartbeat message will be written to file)
[2024-05-21 02:24:22] 2024-05-21 06:21:45,131 | INFO | job 6210308767 has state 'running' - writing heartbeat
[2024-05-21 02:24:22] 2024-05-21 06:21:45,131 | INFO | payload/TRF did not report the number of read events
[2024-05-21 02:24:22] 2024-05-21 06:21:45,134 | INFO | executing command: lscpu
[2024-05-21 02:24:22] 2024-05-21 06:21:45,140 | WARNING | exception caught: [Errno 107] Transport endpoint is not connected: '/bin/bash'
[2024-05-21 02:24:22] 2024-05-21 06:21:47,646 | INFO | monitor loop #1274: job 0:6210308767 is in state 'failed'
[2024-05-21 02:24:22] 2024-05-21 06:21:47,646 | INFO | will abort job monitoring soon since job state=failed (job is still in queue)
[2024-05-21 02:24:22] 2024-05-21 06:21:48,744 | WARNING | data:queue_monitoring:received graceful stop - abort after this iteration
[2024-05-21 02:24:22] 2024-05-21 06:21:48,744 | WARNING | job:job_monitor:received graceful stop - abort after this iteration
[2024-05-21 02:24:22] 2024-05-21 06:21:48,744 | INFO | aborting loop
[2024-05-21 02:24:22] 2024-05-21 06:21:48,748 | INFO | all payload control threads have been joined
[2024-05-21 02:24:22] 2024-05-21 06:21:49,281 | INFO | all data control threads have been joined
[2024-05-21 02:24:22] 2024-05-21 06:21:49,508 | INFO | found 1 job(s) in 20 queues
[2024-05-21 02:24:22] 2024-05-21 06:21:49,508 | INFO | aborting job 6210308767
[2024-05-21 02:24:22] 2024-05-21 06:21:49,584 | WARNING | pilot monitor received instruction that args.graceful_stop has been set
[2024-05-21 02:24:22] 2024-05-21 06:21:49,584 | WARNING | will wait for a maximum of 300 s for threads to finish
[2024-05-21 02:24:22] 2024-05-21 06:21:49,723 | WARNING | job:queue_monitor:received graceful stop - abort after this iteration
[2024-05-21 02:24:22] 2024-05-21 06:21:49,723 | WARNING | since job:queue_monitor is responsible for sending job updates, we sleep for 20 s
[2024-05-21 02:24:22] 2024-05-21 06:21:49,749 | INFO | [job] job monitor thread has finished
[2024-05-21 02:24:22] 2024-05-21 06:21:49,754 | INFO | [payload] control thread has finished
[2024-05-21 02:24:22] 2024-05-21 06:21:49,863 | INFO | [job] validate thread has finished
[2024-05-21 02:24:22] 2024-05-21 06:21:49,984 | INFO | [job] retrieve thread has finished
[2024-05-21 02:24:22] 2024-05-21 06:21:50,193 | INFO | [payload] validate_post thread has finished
[2024-05-21 02:24:22] 2024-05-21 06:21:50,204 | INFO | all job control threads have been joined
[2024-05-21 02:24:22] 2024-05-21 06:21:50,287 | INFO | [data] control thread has finished
[2024-05-21 02:24:22] 2024-05-21 06:21:50,442 | INFO | [payload] validate_pre thread has finished
[2024-05-21 02:24:22] 2024-05-21 06:21:50,819 | INFO | [payload] failed_post thread has finished
[2024-05-21 02:24:22] 2024-05-21 06:21:50,870 | INFO | [payload] run_realtimelog thread has finished
[2024-05-21 02:24:22] 2024-05-21 06:21:50,909 | INFO | [job] create_data_payload thread has finished
[2024-05-21 02:24:22] 2024-05-21 06:21:51,197 | INFO | [data] copytool_in thread has finished
[2024-05-21 02:24:22] 2024-05-21 06:21:51,210 | INFO | [job] control thread has finished
[2024-05-21 02:24:22] 2024-05-21 06:21:52,762 | INFO | [data] queue_monitor thread has finished
[2024-05-21 02:24:22] 2024-05-21 06:21:54,540 | INFO | [payload] execute_payloads thread has finished
[2024-05-21 02:24:22] 2024-05-21 06:22:10,825 | INFO | job 6210308767 has state=failed
[2024-05-21 02:24:22] 2024-05-21 06:22:10,825 | INFO | preparing for final server update for job 6210308767 in state='failed'
[2024-05-21 02:24:22] 2024-05-21 06:22:11,711 | WARNING | job_aborted has been set - aborting pilot monitoring
[2024-05-21 02:24:22] 2024-05-21 06:22:11,712 | INFO | [monitor] control thread has ended
[2024-05-21 02:24:22] 2024-05-21 06:22:11,732 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:22:13,744 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:22:15,756 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:22:17,767 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:22:19,779 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:22:21,791 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:22:23,803 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:22:25,816 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:22:27,828 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:22:29,839 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:22:31,852 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:22:33,864 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:22:35,876 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:22:37,888 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:22:39,900 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:22:41,911 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:22:43,923 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:22:45,935 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:22:47,948 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:22:49,960 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:22:51,972 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:22:53,984 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:22:55,996 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:22:58,007 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:00,019 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:02,031 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:04,042 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:06,052 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:08,064 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:10,076 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:12,088 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:14,099 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:16,110 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:18,122 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:20,133 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:22,145 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:24,158 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:26,171 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:28,183 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:30,195 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:32,207 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:34,219 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:36,231 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:38,244 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:40,256 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:42,268 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:44,280 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:46,292 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:48,304 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:50,316 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:52,328 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:54,340 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:56,352 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:23:58,365 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:24:00,379 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:24:02,391 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:24:04,403 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:24:06,011 | INFO | proceeding with final server update
[2024-05-21 02:24:22] 2024-05-21 06:24:06,012 | INFO | this job has now completed (state=failed)
[2024-05-21 02:24:22] 2024-05-21 06:24:06,012 | INFO | pilot will not update the server (heartbeat message will be written to file)
[2024-05-21 02:24:22] 2024-05-21 06:24:06,012 | INFO | job 6210308767 has failed - writing final server update
[2024-05-21 02:24:22] 2024-05-21 06:24:06,012 | WARNING | making sure that job.state is set to failed since a pilot error code is set
[2024-05-21 02:24:22] 2024-05-21 06:24:06,013 | INFO | payload/TRF did not report the number of read events
[2024-05-21 02:24:22] 2024-05-21 06:24:06,021 | INFO | executing command: lscpu
[2024-05-21 02:24:22] File "/tmp/boinchome/slots/3/pilot3/pilot/common/exception.py", line 450, in run
[2024-05-21 02:24:22] self.target(**self.kwargs)
[2024-05-21 02:24:22] File "/tmp/boinchome/slots/3/pilot3/pilot/control/job.py", line 2529, in queue_monitor
[2024-05-21 02:24:22] update_server(job, args)
[2024-05-21 02:24:22] File "/tmp/boinchome/slots/3/pilot3/pilot/control/job.py", line 2578, in update_server
[2024-05-21 02:24:22] send_state(job, args, job.state, metadata=metadata)
[2024-05-21 02:24:22] File "/tmp/boinchome/slots/3/pilot3/pilot/control/job.py", line 420, in send_state
[2024-05-21 02:24:22] data = get_data_structure(job, state, args, xml=xml, metadata=metadata)
[2024-05-21 02:24:22] File "/tmp/boinchome/slots/3/pilot3/pilot/control/job.py", line 744, in get_data_structure
[2024-05-21 02:24:22] cpumodel = get_cpu_cores(cpumodel) # add the CPU cores if not present
[2024-05-21 02:24:22] File "/tmp/boinchome/slots/3/pilot3/pilot/util/workernode.py", line 353, in get_cpu_cores
[2024-05-21 02:24:22] ec, stdout = lscpu()
[2024-05-21 02:24:22] File "/tmp/boinchome/slots/3/pilot3/pilot/util/workernode.py", line 333, in lscpu
[2024-05-21 02:24:22] ec, stdout, _ = execute(cmd)
[2024-05-21 02:24:22] File "/tmp/boinchome/slots/3/pilot3/pilot/util/container.py", line 94, in execute
[2024-05-21 02:24:22] process = subprocess.Popen(exe,
[2024-05-21 02:24:22] 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-05-21 02:24:22] self._execute_child(args, executable, preexec_fn, close_fds,
[2024-05-21 02:24:22] 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-05-21 02:24:22] raise child_exception_type(errno_num, err_msg, err_filename)
[2024-05-21 02:24:22] exception caught by thread run() function: (<class 'OSError'>, OSError(107, 'Transport endpoint is not connected'), <traceback object at 0x7fd5c9b267c0>)
[2024-05-21 02:24:22] Traceback (most recent call last):
[2024-05-21 02:24:22] File "/tmp/boinchome/slots/3/pilot3/pilot/common/exception.py", line 450, in run
[2024-05-21 02:24:22] self.target(**self.kwargs)
[2024-05-21 02:24:22] File "/tmp/boinchome/slots/3/pilot3/pilot/control/job.py", line 2529, in queue_monitor
[2024-05-21 02:24:22] update_server(job, args)
[2024-05-21 02:24:22] File "/tmp/boinchome/slots/3/pilot3/pilot/control/job.py", line 2578, in update_server
[2024-05-21 02:24:22] send_state(job, args, job.state, metadata=metadata)
[2024-05-21 02:24:22] File "/tmp/boinchome/slots/3/pilot3/pilot/control/job.py", line 420, in send_state
[2024-05-21 02:24:22] data = get_data_structure(job, state, args, xml=xml, metadata=metadata)
[2024-05-21 02:24:22] File "/tmp/boinchome/slots/3/pilot3/pilot/control/job.py", line 744, in get_data_structure
[2024-05-21 02:24:22] cpumodel = get_cpu_cores(cpumodel) # add the CPU cores if not present
[2024-05-21 02:24:22] File "/tmp/boinchome/slots/3/pilot3/pilot/util/workernode.py", line 353, in get_cpu_cores
[2024-05-21 02:24:22] ec, stdout = lscpu()
[2024-05-21 02:24:22] File "/tmp/boinchome/slots/3/pilot3/pilot/util/workernode.py", line 333, in lscpu
[2024-05-21 02:24:22] ec, stdout, _ = execute(cmd)
[2024-05-21 02:24:22] File "/tmp/boinchome/slots/3/pilot3/pilot/util/container.py", line 94, in execute
[2024-05-21 02:24:22] process = subprocess.Popen(exe,
[2024-05-21 02:24:22] 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-05-21 02:24:22] self._execute_child(args, executable, preexec_fn, close_fds,
[2024-05-21 02:24:22] 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-05-21 02:24:22] raise child_exception_type(errno_num, err_msg, err_filename)
[2024-05-21 02:24:22] OSError: [Errno 107] Transport endpoint is not connected: '/bin/bash'
[2024-05-21 02:24:22]
[2024-05-21 02:24:22] None
[2024-05-21 02:24:22] exception has been put in bucket queue belonging to thread 'queue_monitor'
[2024-05-21 02:24:22] setting graceful stop in 10 s since there is no point in continuing
[2024-05-21 02:24:22] 2024-05-21 06:24:06,415 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:24:08,427 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:24:10,439 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:24:12,451 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:24:14,463 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140556330075968)>', '<ExcThread(queue_monitor, started 140555547830016)>']
[2024-05-21 02:24:22] 2024-05-21 06:24:16,476 | INFO | caller=run is remaining thread - safe to abort (names=['<_MainThread(MainThread, started 140556330075968)>'])
[2024-05-21 02:24:22] 2024-05-21 06:24:21,501 | INFO | all workflow threads have been joined
[2024-05-21 02:24:22] 2024-05-21 06:24:21,502 | INFO | end of generic workflow (traces error code: 0)
[2024-05-21 02:24:22] 2024-05-21 06:24:21,502 | INFO | traces error code: 0
[2024-05-21 02:24:22] 2024-05-21 06:24:21,503 | INFO | pilot has finished (exit code=0, shell exit code=0)
[2024-05-21 02:24:22] ./runpilot2-wrapper.sh: line 15: /usr/bin/date: Transport endpoint is not connected
[2024-05-21 02:24:22] ==== pilot stdout END ====
[2024-05-21 02:24:22] ./runpilot2-wrapper.sh: line 15: /usr/bin/date: Transport endpoint is not connected
[2024-05-21 02:24:22] ==== wrapper stdout RESUME ====
[2024-05-21 02:24:22] ./runpilot2-wrapper.sh: line 15: /usr/bin/date: Transport endpoint is not connected
[2024-05-21 02:24:22] pilotpid: 59026
[2024-05-21 02:24:22] ./runpilot2-wrapper.sh: line 15: /usr/bin/date: Transport endpoint is not connected
[2024-05-21 02:24:22] Pilot exit status: 0
[2024-05-21 02:24:22] ./runpilot2-wrapper.sh: line 949: /usr/bin/cut: Transport endpoint is not connected
[2024-05-21 02:24:22] ./runpilot2-wrapper.sh: line 949: xargs: command not found
[2024-05-21 02:24:22] ./runpilot2-wrapper.sh: line 949: /usr/bin/cat: Transport endpoint is not connected
[2024-05-21 02:24:22] ./runpilot2-wrapper.sh: line 15: /usr/bin/date: Transport endpoint is not connected
[2024-05-21 02:24:22] pandaids:
[2024-05-21 02:24:22] ./runpilot2-wrapper.sh: line 501: /usr/bin/ps: Transport endpoint is not connected
[2024-05-21 02:24:22] ./runpilot2-wrapper.sh: line 15: /usr/bin/date: Transport endpoint is not connected
[2024-05-21 02:24:22] No supervise_pilot CHILD process found
[2024-05-21 02:24:22] ./runpilot2-wrapper.sh: line 15: /usr/bin/date: Transport endpoint is not connected
[2024-05-21 02:24:22] Test setup, not cleaning
[2024-05-21 02:24:22] ./runpilot2-wrapper.sh: line 15: /usr/bin/date: Transport endpoint is not connected
[2024-05-21 02:24:22] ==== wrapper stdout END ====
[2024-05-21 02:24:22] ./runpilot2-wrapper.sh: line 10: /usr/bin/date: Transport endpoint is not connected
[2024-05-21 02:24:22] ==== wrapper stderr END ====
[2024-05-21 02:24:22] ./runpilot2-wrapper.sh: line 522: /usr/bin/date: Transport endpoint is not connected
[2024-05-21 02:24:22] ./runpilot2-wrapper.sh: line 15: /usr/bin/date: Transport endpoint is not connected
[2024-05-21 02:24:22] apfmon messages muted
[2024-05-21 02:24:22] *** Error codes and diagnostics ***
[2024-05-21 02:24:22] *** Listing of results directory ***
[2024-05-21 02:24:22] total 1066824
[2024-05-21 02:24:22] drwx------ 6 boincer umatlas 4096 Mar 6 05:21 pilot3
[2024-05-21 02:24:22] -rw-r--r-- 1 boincer umatlas 5633 May 20 00:51 queuedata.json
[2024-05-21 02:24:22] -rwx------ 1 boincer umatlas 32251 May 20 00:52 runpilot2-wrapper.sh
[2024-05-21 02:24:22] -rw------- 1 boincer umatlas 468593 May 20 00:52 pilot3.tar.gz
[2024-05-21 02:24:22] -rw-r--r-- 1 boincer umatlas 100 May 20 04:31 wrapper_26015_x86_64-pc-linux-gnu
[2024-05-21 02:24:22] -rwxr-xr-x 1 boincer umatlas 7986 May 20 04:31 run_atlas
[2024-05-21 02:24:22] -rw-r--r-- 1 boincer umatlas 105 May 20 04:31 job.xml
[2024-05-21 02:24:22] -rw-r--r-- 3 boincer umatlas 542934735 May 20 04:31 EVNT.38776210._000027.pool.root.1
[2024-05-21 02:24:22] -rw-r--r-- 3 boincer umatlas 542934735 May 20 04:31 ATLAS.root_0
[2024-05-21 02:24:22] -rw-r--r-- 2 boincer umatlas 17537 May 20 04:31 start_atlas.sh
[2024-05-21 02:24:22] drwxrwx--x 2 boincer umatlas 4096 May 20 04:31 shared
[2024-05-21 02:24:22] -rw-r--r-- 2 boincer umatlas 481402 May 20 04:31 input.tar.gz
[2024-05-21 02:24:22] -rw-r--r-- 1 boincer umatlas 0 May 20 04:31 boinc_lockfile
[2024-05-21 02:24:22] -rw------- 1 boincer umatlas 1324701 May 20 04:34 cric_ddmendpoints.json
[2024-05-21 02:24:22] -rw-r--r-- 1 boincer umatlas 2642 May 20 21:11 pandaJob.out
[2024-05-21 02:24:22] -rw------- 1 boincer umatlas 424 May 20 21:11 setup.sh.local
[2024-05-21 02:24:22] -rw------- 1 boincer umatlas 1014347 May 20 21:12 agis_schedconf.cvmfs.json
[2024-05-21 02:24:22] -rw------- 1 boincer umatlas 0 May 20 21:12 agis_ddmendpoints.agis.ALL.json
[2024-05-21 02:24:22] -rw------- 1 boincer umatlas 868 May 21 01:51 heartbeat.json
[2024-05-21 02:24:22] -rw-r--r-- 1 boincer umatlas 6304 May 21 02:20 init_data.xml
[2024-05-21 02:24:22] -rw-r--r-- 1 boincer umatlas 533 May 21 02:21 boinc_task_state.xml
[2024-05-21 02:24:22] -rw------- 1 boincer umatlas 1075 May 21 02:21 memory_monitor_summary.json
[2024-05-21 02:24:22] drwxrwx--- 2 boincer umatlas 4096 May 21 02:21 PanDA_Pilot-6210308767
[2024-05-21 02:24:22] -rw------- 1 boincer umatlas 97 May 21 02:21 pilot_heartbeat.json
[2024-05-21 02:24:22] -rw-r--r-- 1 boincer umatlas 8192 May 21 02:24 boinc_mmap_file
[2024-05-21 02:24:22] -rw-r--r-- 1 boincer umatlas 29 May 21 02:24 wrapper_checkpoint.txt
[2024-05-21 02:24:22] -rw------- 1 boincer umatlas 1510050 May 21 02:24 pilotlog.txt
[2024-05-21 02:24:22] -rw------- 1 boincer umatlas 1533419 May 21 02:24 log.38921013._002327.job.log.1
[2024-05-21 02:24:22] -rw-r--r-- 1 boincer umatlas 428 May 21 02:24 runtime_log
[2024-05-21 02:24:22] -rw------- 1 boincer umatlas 912 May 21 02:24 YkhNDm5BAT5nsSi4apGgGQJmABFKDmABFKDm4ySLDmFQVKDmTVo6En.diag
[2024-05-21 02:24:22] -rw-r--r-- 1 boincer umatlas 11368 May 21 02:24 runtime_log.err
[2024-05-21 02:24:22] -rw-r--r-- 1 boincer umatlas 32786 May 21 02:24 stderr.txt
[2024-05-21 02:24:22] No HITS result produced
[2024-05-21 02:24:22] *** Contents of shared directory: ***
[2024-05-21 02:24:22] total 530708
[2024-05-21 02:24:22] -rw-r--r-- 3 boincer umatlas 542934735 May 20 04:31 ATLAS.root_0
[2024-05-21 02:24:22] -rw-r--r-- 2 boincer umatlas 17537 May 20 04:31 start_atlas.sh
[2024-05-21 02:24:22] -rw-r--r-- 2 boincer umatlas 481402 May 20 04:31 input.tar.gz
02:24:24 (29853): run_atlas exited; CPU time 52550.901293
02:24:24 (29853): called boinc_finish(0)
</stderr_txt>
<message>
upload failure: <file_xfer_error>
<file_name>YkhNDm5BAT5nsSi4apGgGQJmABFKDmABFKDm4ySLDmFQVKDmTVo6En_0_r930712025_ATLAS_result</file_name>
<error_code>-161 (not found)</error_code>
</file_xfer_error>
</message>
]]>
©2024 CERN