| Name | mLsMDmT8zx8n9Rq4apOajLDm4fhM0noT9bVo0NGKDm2JeKDmIKColn_0 |
| Workunit | 238404064 |
| Created | 8 Jan 2026, 8:05:35 UTC |
| Sent | 8 Jan 2026, 8:31:24 UTC |
| Report deadline | 16 Jan 2026, 8:31:24 UTC |
| Received | 9 Jan 2026, 1:10:23 UTC |
| Server state | Over |
| Outcome | Computation error |
| Client state | Compute error |
| Exit status | 0 (0x00000000) |
| Computer ID | 10698193 |
| Run time | 13 min 8 sec |
| CPU time | 38 min 9 sec |
| Validate state | Invalid |
| Credit | 0.00 |
| Device peak FLOPS | 39.88 GFLOPS |
| Application version | ATLAS Simulation v3.01 (native_mt) x86_64-pc-linux-gnu |
| Peak working set size | 1.89 GB |
| Peak swap size | 2.82 GB |
| Peak disk usage | 451.66 MB |
Stderr output
<core_client_version>8.2.6</core_client_version>
<![CDATA[
<stderr_txt>
02:55:37 (3315516): wrapper (7.7.26015): starting
02:55:37 (3315516): wrapper: running run_atlas (--nthreads 4)
[2026-01-09 02:55:38] Arguments: --nthreads 4
[2026-01-09 02:55:38] Threads: 4
[2026-01-09 02:55:38] Checking for CVMFS
[2026-01-09 02:55:38] Probing /cvmfs/atlas.cern.ch... OK
[2026-01-09 02:55:38] Probing /cvmfs/atlas-condb.cern.ch... OK
[2026-01-09 02:55:38] Running cvmfs_config stat atlas.cern.ch
[2026-01-09 02:55:38] VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
[2026-01-09 02:55:38] 2.13.3.0 1168739 2150 29440 154925 1 57 32038895 33554433 0 130560 0 1715029 99.990 82573 244 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch http://127.0.0.1:25468 1
[2026-01-09 02:55:38] CVMFS is ok
[2026-01-09 02:55:38] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7
[2026-01-09 02:55:38] Checking for apptainer binary...
[2026-01-09 02:55:38] Using apptainer found in PATH at /usr/bin/apptainer
[2026-01-09 02:55:38] Running /usr/bin/apptainer --version
[2026-01-09 02:55:38] apptainer version 1.4.4
[2026-01-09 02:55:38] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname
[2026-01-09 02:55:38] INFO: /etc/singularity/ exists; cleanup by system administrator is not complete (see https://apptainer.org/docs/admin/latest/singularity_migration.html) Evangelos-Katikos
[2026-01-09 02:55:38] apptainer works
[2026-01-09 02:55:38] Set ATHENA_PROC_NUMBER=4
[2026-01-09 02:55:38] Set ATHENA_CORE_NUMBER=4
[2026-01-09 02:55:38] Starting ATLAS job with PandaID=6962914999
[2026-01-09 02:55:38] Running command: /usr/bin/apptainer exec -B /cvmfs,/home/ek/BOINC/slots/1 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh
[2026-01-09 03:08:43] *** The last 200 lines of the pilot log: ***
[2026-01-09 03:08:43] 2026-01-09 01:07:09,183 | INFO | time since job start (685s) is within the limit (174528.0s)
[2026-01-09 03:08:43] 2026-01-09 01:07:10,189 | WARNING | exception caught (1) in write_json: [Errno 116] Stale file handle: '/home/ek/BOINC/slots/1/pilot_heartbeat.json'
[2026-01-09 03:08:43] 2026-01-09 01:07:10,189 | WARNING | failed to update heartbeat file: /home/ek/BOINC/slots/1/pilot_heartbeat.json
[2026-01-09 03:08:43] 2026-01-09 01:07:11,189 | INFO | time since job start (687s) is within the limit (174528.0s)
[2026-01-09 03:08:43] File "/home/ek/BOINC/slots/1/pilot3/pilot/common/exception.py", line 466, in run
[2026-01-09 03:08:43] File "/home/ek/BOINC/slots/1/pilot3/pilot/control/monitor.py", line 247, in control
[2026-01-09 03:08:43] received exception from bucket queue in generic workflow: error code: 1301, message: An unknown pilot exception has occurred
[2026-01-09 03:08:43] details: [Errno 116] Stale file handle: b'/proc'
[2026-01-09 03:08:43] monitor: exception caught: [Errno 116] Stale file handle: b'/proc'
[2026-01-09 03:08:43] unexpected exception caught by thread run() function: (<class 'pilot.common.exception.PilotException'>, PilotException(OSError(116, 'Stale file handle')), <traceback object at 0x7f60e8ef0640>)
[2026-01-09 03:08:43] Traceback (most recent call last):
[2026-01-09 03:08:43] File "/home/ek/BOINC/slots/1/pilot3/pilot/control/monitor.py", line 222, in control
[2026-01-09 03:08:43] File "/home/ek/BOINC/slots/1/pilot3/pilot/util/psutils.py", line 398, in get_process_info
[2026-01-09 03:08:43] File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/psutil/6.0.0-x86_64-centos7/lib/python3.9/site-packages/psutil/__init__.py", line 1499, in process_iter
[2026-01-09 03:08:43] a = set(pids())
[2026-01-09 03:08:43] File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/psutil/6.0.0-x86_64-centos7/lib/python3.9/site-packages/psutil/__init__.py", line 1443, in pids
[2026-01-09 03:08:43] ret = sorted(_psplatform.pids())
[2026-01-09 03:08:43] File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/psutil/6.0.0-x86_64-centos7/lib/python3.9/site-packages/psutil/_pslinux.py", line 1652, in pids
[2026-01-09 03:08:43] return [int(x) for x in os.listdir(b(get_procfs_path())) if x.isdigit()]
[2026-01-09 03:08:43] OSError: [Errno 116] Stale file handle: b'/proc'
[2026-01-09 03:08:43]
[2026-01-09 03:08:43] The above exception was the direct cause of the following exception:
[2026-01-09 03:08:43]
[2026-01-09 03:08:43] Traceback (most recent call last):
[2026-01-09 03:08:43] File "/home/ek/BOINC/slots/1/pilot3/pilot/common/exception.py", line 466, in run
[2026-01-09 03:08:43] File "/home/ek/BOINC/slots/1/pilot3/pilot/control/monitor.py", line 247, in control
[2026-01-09 03:08:43] pilot.common.exception.PilotException: error code: 1301, message: An unknown pilot exception has occurred
[2026-01-09 03:08:43] details: [Errno 116] Stale file handle: b'/proc'
[2026-01-09 03:08:43]
[2026-01-09 03:08:43] None
[2026-01-09 03:08:43] exception has been put in bucket queue belonging to thread 'monitor'
[2026-01-09 03:08:43] setting graceful stop in 10 s since there is no point in continuing
[2026-01-09 03:08:43] 2026-01-09 01:07:16,427 | WARNING | Exception caught: [Errno 116] Stale file handle: b'/proc'
[2026-01-09 03:08:43] 2026-01-09 01:07:16,428 | WARNING | Traceback (most recent call last):
[2026-01-09 03:08:43] File "/home/ek/BOINC/slots/1/pilot3/pilot/util/monitoring.py", line 193, in set_cpu_consumption_time
[2026-01-09 03:08:43] File "/home/ek/BOINC/slots/1/pilot3/pilot/util/processes.py", line 619, in get_current_cpu_consumption_time
[2026-01-09 03:08:43] File "/home/ek/BOINC/slots/1/pilot3/pilot/util/processes.py", line 191, in get_ps_cache
[2026-01-09 03:08:43] File "/home/ek/BOINC/slots/1/pilot3/pilot/util/psutils.py", line 431, in list_processes_and_threads
[2026-01-09 03:08:43] File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/psutil/6.0.0-x86_64-centos7/lib/python3.9/site-packages/psutil/__init__.py", line 1499, in process_iter
[2026-01-09 03:08:43] a = set(pids())
[2026-01-09 03:08:43] File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/psutil/6.0.0-x86_64-centos7/lib/python3.9/site-packages/psutil/__init__.py", line 1443, in pids
[2026-01-09 03:08:43] ret = sorted(_psplatform.pids())
[2026-01-09 03:08:43] File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/psutil/6.0.0-x86_64-centos7/lib/python3.9/site-packages/psutil/_pslinux.py", line 1652, in pids
[2026-01-09 03:08:43] return [int(x) for x in os.listdir(b(get_procfs_path())) if x.isdigit()]
[2026-01-09 03:08:43] OSError: [Errno 116] Stale file handle: b'/proc'
[2026-01-09 03:08:43]
[2026-01-09 03:08:43] 2026-01-09 01:07:16,428 | WARNING | will send preliminary diagnostics (and pretend job is still running)=Exception caught: [Errno 116] Stale file handle: b'/proc'
[2026-01-09 03:08:43] 2026-01-09 01:07:16,428 | INFO | pilot will not update the server (heartbeat message will be written to file)
[2026-01-09 03:08:43] 2026-01-09 01:07:16,428 | INFO | log transfer has not been attempted: NOT_DONE
[2026-01-09 03:08:43] 2026-01-09 01:07:16,428 | INFO | job 6962914999 has state 'running' - writing heartbeat
[2026-01-09 03:08:43] 2026-01-09 01:07:16,428 | INFO | payload/TRF did not report the number of read events
[2026-01-09 03:08:43] 2026-01-09 01:07:16,430 | WARNING | command=lscpu does not exist - cannot check number of available cores
[2026-01-09 03:08:43] 2026-01-09 01:07:16,430 | WARNING | exception caught: [Errno 116] Stale file handle: '/proc/cpuinfo'
[2026-01-09 03:08:43] 2026-01-09 01:07:18,933 | INFO | monitor loop #56: job 0:6962914999 is in state 'running'
[2026-01-09 03:08:43] 2026-01-09 01:07:18,933 | WARNING | exception caught: [Errno 116] Stale file handle: b'/proc'
[2026-01-09 03:08:43] 2026-01-09 01:07:21,435 | INFO | monitor loop #57: job 0:6962914999 is in state 'running'
[2026-01-09 03:08:43] 2026-01-09 01:07:21,436 | WARNING | exception caught: [Errno 116] Stale file handle: b'/proc'
[2026-01-09 03:08:43] 2026-01-09 01:07:22,252 | WARNING | data:queue_monitoring:received graceful stop - abort after this iteration
[2026-01-09 03:08:43] 2026-01-09 01:07:22,252 | WARNING | job:job_monitor:received graceful stop - abort after this iteration
[2026-01-09 03:08:43] 2026-01-09 01:07:22,252 | INFO | will abort loop
[2026-01-09 03:08:43] 2026-01-09 01:07:22,281 | WARNING | job:queue_monitor:received graceful stop - abort after this iteration
[2026-01-09 03:08:43] 2026-01-09 01:07:22,281 | WARNING | since job:queue_monitor is responsible for sending job updates, we sleep for 20 s
[2026-01-09 03:08:43] 2026-01-09 01:07:22,291 | WARNING | data:copytool_out:received graceful stop - abort after this iteration
[2026-01-09 03:08:43] 2026-01-09 01:07:22,439 | INFO | all data control threads have been joined
[2026-01-09 03:08:43] 2026-01-09 01:07:22,566 | INFO | breaking -- sending SIGTERM to pid=3326230
[2026-01-09 03:08:43] 2026-01-09 01:07:22,566 | INFO | breaking -- sleep 10 s before sending SIGKILL pid=3326230
[2026-01-09 03:08:43] 2026-01-09 01:07:22,591 | INFO | job.realtimelogging is not enabled
[2026-01-09 03:08:43] 2026-01-09 01:07:23,142 | INFO | all job control threads have been joined
[2026-01-09 03:08:43] 2026-01-09 01:07:23,258 | INFO | [job] job monitor thread has finished
[2026-01-09 03:08:43] 2026-01-09 01:07:23,444 | INFO | [data] control thread has finished
[2026-01-09 03:08:43] 2026-01-09 01:07:23,457 | INFO | [payload] validate_post thread has finished
[2026-01-09 03:08:43] 2026-01-09 01:07:23,469 | INFO | [payload] failed_post thread has finished
[2026-01-09 03:08:43] 2026-01-09 01:07:23,535 | INFO | all payload control threads have been joined
[2026-01-09 03:08:43] 2026-01-09 01:07:23,596 | INFO | [payload] run_realtimelog thread has finished
[2026-01-09 03:08:43] 2026-01-09 01:07:23,839 | INFO | [job] retrieve thread has finished
[2026-01-09 03:08:43] 2026-01-09 01:07:23,864 | INFO | [job] validate thread has finished
[2026-01-09 03:08:43] 2026-01-09 01:07:23,945 | INFO | [job] create_data_payload thread has finished
[2026-01-09 03:08:43] 2026-01-09 01:07:23,993 | INFO | [payload] validate_pre thread has finished
[2026-01-09 03:08:43] 2026-01-09 01:07:24,147 | INFO | [job] control thread has finished
[2026-01-09 03:08:43] 2026-01-09 01:07:24,296 | INFO | [data] copytool_out thread has finished
[2026-01-09 03:08:43] 2026-01-09 01:07:24,435 | INFO | [data] copytool_in thread has finished
[2026-01-09 03:08:43] 2026-01-09 01:07:24,540 | INFO | [payload] control thread has finished
[2026-01-09 03:08:43] 2026-01-09 01:07:26,258 | INFO | [data] queue_monitor thread has finished
[2026-01-09 03:08:43] 2026-01-09 01:07:32,571 | INFO |
[2026-01-09 03:08:43]
[2026-01-09 03:08:43] finished pid=3326230 exit_code=None state=failed
[2026-01-09 03:08:43]
[2026-01-09 03:08:43] 2026-01-09 01:07:32,572 | WARNING | detected unset exit_code from wait_graceful - reset to -1
[2026-01-09 03:08:43] 2026-01-09 01:07:32,572 | INFO | using pid=3332098 to kill prmon
[2026-01-09 03:08:43] 2026-01-09 01:07:32,572 | INFO | stopping utility process 'MemoryMonitor' with signal 10
[2026-01-09 03:08:43] 2026-01-09 01:07:32,572 | WARNING | Error sending signal to/waiting for process 3332098: [Errno 3] No such process
[2026-01-09 03:08:43] 2026-01-09 01:07:32,572 | INFO | utility process 3326233 cleanup finished with status=None
[2026-01-09 03:08:43] 2026-01-09 01:07:32,572 | INFO | taking a short nap (3 s) to allow the memory monitor to finish writing to the summary file (#0/#20)
[2026-01-09 03:08:43] 2026-01-09 01:07:35,587 | INFO | taking a short nap (3 s) to allow the memory monitor to finish writing to the summary file (#1/#20)
[2026-01-09 03:08:43] 2026-01-09 01:07:38,602 | INFO | taking a short nap (3 s) to allow the memory monitor to finish writing to the summary file (#2/#20)
[2026-01-09 03:08:43] 2026-01-09 01:07:41,617 | INFO | taking a short nap (3 s) to allow the memory monitor to finish writing to the summary file (#3/#20)
[2026-01-09 03:08:43] 2026-01-09 01:07:44,631 | INFO | taking a short nap (3 s) to allow the memory monitor to finish writing to the summary file (#4/#20)
[2026-01-09 03:08:43] 2026-01-09 01:07:44,770 | INFO | [monitor] cgroup control has ended
[2026-01-09 03:08:43] 2026-01-09 01:07:45,386 | INFO | [job] queue monitor thread has finished
[2026-01-09 03:08:43] 2026-01-09 01:07:46,187 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140054287939392)>', '<ExcThread(execute_payloads, started 140053942609664)>']
[2026-01-09 03:08:43] 2026-01-09 01:07:47,646 | INFO | taking a short nap (3 s) to allow the memory monitor to finish writing to the summary file (#5/#20)
[2026-01-09 03:08:43] 2026-01-09 01:07:48,197 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140054287939392)>', '<ExcThread(execute_payloads, started 140053942609664)>']
[2026-01-09 03:08:43] 2026-01-09 01:07:50,204 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140054287939392)>', '<ExcThread(execute_payloads, started 140053942609664)>']
[2026-01-09 03:08:43] 2026-01-09 01:07:50,654 | INFO | taking a short nap (3 s) to allow the memory monitor to finish writing to the summary file (#6/#20)
[2026-01-09 03:08:43] 2026-01-09 01:07:52,214 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140054287939392)>', '<ExcThread(execute_payloads, started 140053942609664)>']
[2026-01-09 03:08:43] 2026-01-09 01:07:53,663 | INFO | taking a short nap (3 s) to allow the memory monitor to finish writing to the summary file (#7/#20)
[2026-01-09 03:08:43] 2026-01-09 01:07:54,224 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140054287939392)>', '<ExcThread(execute_payloads, started 140053942609664)>']
[2026-01-09 03:08:43] 2026-01-09 01:07:56,234 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140054287939392)>', '<ExcThread(execute_payloads, started 140053942609664)>']
[2026-01-09 03:08:43] 2026-01-09 01:07:56,666 | INFO | taking a short nap (3 s) to allow the memory monitor to finish writing to the summary file (#8/#20)
[2026-01-09 03:08:43] 2026-01-09 01:07:58,245 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140054287939392)>', '<ExcThread(execute_payloads, started 140053942609664)>']
[2026-01-09 03:08:43] 2026-01-09 01:07:59,681 | INFO | taking a short nap (3 s) to allow the memory monitor to finish writing to the summary file (#9/#20)
[2026-01-09 03:08:43] 2026-01-09 01:08:00,255 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140054287939392)>', '<ExcThread(execute_payloads, started 140053942609664)>']
[2026-01-09 03:08:43] 2026-01-09 01:08:02,265 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140054287939392)>', '<ExcThread(execute_payloads, started 140053942609664)>']
[2026-01-09 03:08:43] 2026-01-09 01:08:02,697 | INFO | taking a short nap (3 s) to allow the memory monitor to finish writing to the summary file (#10/#20)
[2026-01-09 03:08:43] 2026-01-09 01:08:04,274 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140054287939392)>', '<ExcThread(execute_payloads, started 140053942609664)>']
[2026-01-09 03:08:43] 2026-01-09 01:08:05,712 | INFO | taking a short nap (3 s) to allow the memory monitor to finish writing to the summary file (#11/#20)
[2026-01-09 03:08:43] 2026-01-09 01:08:06,284 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140054287939392)>', '<ExcThread(execute_payloads, started 140053942609664)>']
[2026-01-09 03:08:43] 2026-01-09 01:08:08,294 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140054287939392)>', '<ExcThread(execute_payloads, started 140053942609664)>']
[2026-01-09 03:08:43] 2026-01-09 01:08:08,727 | INFO | taking a short nap (3 s) to allow the memory monitor to finish writing to the summary file (#12/#20)
[2026-01-09 03:08:43] 2026-01-09 01:08:10,304 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140054287939392)>', '<ExcThread(execute_payloads, started 140053942609664)>']
[2026-01-09 03:08:43] 2026-01-09 01:08:11,742 | INFO | taking a short nap (3 s) to allow the memory monitor to finish writing to the summary file (#13/#20)
[2026-01-09 03:08:43] 2026-01-09 01:08:12,313 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140054287939392)>', '<ExcThread(execute_payloads, started 140053942609664)>']
[2026-01-09 03:08:43] 2026-01-09 01:08:14,323 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140054287939392)>', '<ExcThread(execute_payloads, started 140053942609664)>']
[2026-01-09 03:08:43] 2026-01-09 01:08:14,747 | INFO | taking a short nap (3 s) to allow the memory monitor to finish writing to the summary file (#14/#20)
[2026-01-09 03:08:43] 2026-01-09 01:08:16,333 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140054287939392)>', '<ExcThread(execute_payloads, started 140053942609664)>']
[2026-01-09 03:08:43] 2026-01-09 01:08:17,762 | INFO | taking a short nap (3 s) to allow the memory monitor to finish writing to the summary file (#15/#20)
[2026-01-09 03:08:43] 2026-01-09 01:08:18,343 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140054287939392)>', '<ExcThread(execute_payloads, started 140053942609664)>']
[2026-01-09 03:08:43] 2026-01-09 01:08:20,353 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140054287939392)>', '<ExcThread(execute_payloads, started 140053942609664)>']
[2026-01-09 03:08:43] 2026-01-09 01:08:20,777 | INFO | taking a short nap (3 s) to allow the memory monitor to finish writing to the summary file (#16/#20)
[2026-01-09 03:08:43] 2026-01-09 01:08:22,363 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140054287939392)>', '<ExcThread(execute_payloads, started 140053942609664)>']
[2026-01-09 03:08:43] 2026-01-09 01:08:23,783 | INFO | taking a short nap (3 s) to allow the memory monitor to finish writing to the summary file (#17/#20)
[2026-01-09 03:08:43] 2026-01-09 01:08:24,371 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140054287939392)>', '<ExcThread(execute_payloads, started 140053942609664)>']
[2026-01-09 03:08:43] 2026-01-09 01:08:26,381 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140054287939392)>', '<ExcThread(execute_payloads, started 140053942609664)>']
[2026-01-09 03:08:43] 2026-01-09 01:08:26,798 | INFO | taking a short nap (3 s) to allow the memory monitor to finish writing to the summary file (#18/#20)
[2026-01-09 03:08:43] 2026-01-09 01:08:28,392 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140054287939392)>', '<ExcThread(execute_payloads, started 140053942609664)>']
[2026-01-09 03:08:43] 2026-01-09 01:08:29,798 | INFO | taking a short nap (3 s) to allow the memory monitor to finish writing to the summary file (#19/#20)
[2026-01-09 03:08:43] 2026-01-09 01:08:30,402 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140054287939392)>', '<ExcThread(execute_payloads, started 140053942609664)>']
[2026-01-09 03:08:43] 2026-01-09 01:08:32,412 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140054287939392)>', '<ExcThread(execute_payloads, started 140053942609664)>']
[2026-01-09 03:08:43] 2026-01-09 01:08:32,813 | INFO | taking a short nap (3 s) to allow the memory monitor to finish writing to the summary file (#20/#20)
[2026-01-09 03:08:43] 2026-01-09 01:08:34,422 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140054287939392)>', '<ExcThread(execute_payloads, started 140053942609664)>']
[2026-01-09 03:08:43] 2026-01-09 01:08:35,819 | WARNING | file copy failure: path does not exist: /home/ek/BOINC/slots/1/PanDA_Pilot-6962914999/memory_monitor_summary.json
[2026-01-09 03:08:43] 2026-01-09 01:08:35,820 | WARNING | failed to copy memory monitor output: error code: 1103, message: No such file or directory
[2026-01-09 03:08:43] details: ('file copy failure: path does not exist: /home/ek/BOINC/slots/1/PanDA_Pilot-6962914999/memory_monitor_summary.json',)
[2026-01-09 03:08:43] 2026-01-09 01:08:35,820 | CRITICAL | execute payloads caught an exception (cannot recover): module 'psutil' has no attribute 'FileNotFoundError', Traceback (most recent call last):
[2026-01-09 03:08:43] File "/home/ek/BOINC/slots/1/pilot3/pilot/util/psutils.py", line 340, in find_lingering_processes
[2026-01-09 03:08:43] File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/psutil/6.0.0-x86_64-centos7/lib/python3.9/site-packages/psutil/__init__.py", line 319, in __init__
[2026-01-09 03:08:43] File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/psutil/6.0.0-x86_64-centos7/lib/python3.9/site-packages/psutil/__init__.py", line 355, in _init
[2026-01-09 03:08:43] File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/psutil/6.0.0-x86_64-centos7/lib/python3.9/site-packages/psutil/__init__.py", line 757, in create_time
[2026-01-09 03:08:43] File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/psutil/6.0.0-x86_64-centos7/lib/python3.9/site-packages/psutil/_pslinux.py", line 1717, in wrapper
[2026-01-09 03:08:43] File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/psutil/6.0.0-x86_64-centos7/lib/python3.9/site-packages/psutil/_pslinux.py", line 1948, in create_time
[2026-01-09 03:08:43] File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/psutil/6.0.0-x86_64-centos7/lib/python3.9/site-packages/psutil/_pslinux.py", line 1717, in wrapper
[2026-01-09 03:08:43] File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/psutil/6.0.0-x86_64-centos7/lib/python3.9/site-packages/psutil/_common.py", line 508, in wrapper
[2026-01-09 03:08:43] File "<string>", line 3, in raise_from
[2026-01-09 03:08:43] File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/psutil/6.0.0-x86_64-centos7/lib/python3.9/site-packages/psutil/_common.py", line 506, in wrapper
[2026-01-09 03:08:43] File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/psutil/6.0.0-x86_64-centos7/lib/python3.9/site-packages/psutil/_pslinux.py", line 1780, in _parse_stat_file
[2026-01-09 03:08:43] File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/psutil/6.0.0-x86_64-centos7/lib/python3.9/site-packages/psutil/_common.py", line 851, in bcat
[2026-01-09 03:08:43] File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/psutil/6.0.0-x86_64-centos7/lib/python3.9/site-packages/psutil/_common.py", line 839, in cat
[2026-01-09 03:08:43] File "/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/psutil/6.0.0-x86_64-centos7/lib/python3.9/site-packages/psutil/_common.py", line 799, in open_binary
[2026-01-09 03:08:43] OSError: [Errno 116] Stale file handle: '/proc/3319335/stat'
[2026-01-09 03:08:43]
[2026-01-09 03:08:43] During handling of the above exception, another exception occurred:
[2026-01-09 03:08:43]
[2026-01-09 03:08:43] Traceback (most recent call last):
[2026-01-09 03:08:43] File "/home/ek/BOINC/slots/1/pilot3/pilot/control/payload.py", line 272, in execute_payloads
[2026-01-09 03:08:43] File "/home/ek/BOINC/slots/1/pilot3/pilot/control/payloads/generic.py", line 1029, in run
[2026-01-09 03:08:43] File "/home/ek/BOINC/slots/1/pilot3/pilot/util/psutils.py", line 347, in find_lingering_processes
[2026-01-09 03:08:43] AttributeError: module 'psutil' has no attribute 'FileNotFoundError'
[2026-01-09 03:08:43]
[2026-01-09 03:08:43] 2026-01-09 01:08:36,432 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140054287939392)>', '<ExcThread(execute_payloads, started 140053942609664)>']
[2026-01-09 03:08:43] 2026-01-09 01:08:36,851 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140054287939392)>', '<ExcThread(execute_payloads, started 140053942609664)>']
[2026-01-09 03:08:43] 2026-01-09 01:08:36,851 | INFO | [payload] execute_payloads thread has finished
[2026-01-09 03:08:43] 2026-01-09 01:08:38,441 | INFO | caller=run is remaining thread - safe to abort (names=['<_MainThread(MainThread, started 140054287939392)>'])
[2026-01-09 03:08:43] 2026-01-09 01:08:43,449 | INFO | all workflow threads have been joined
[2026-01-09 03:08:43] 2026-01-09 01:08:43,449 | INFO | end of generic workflow (traces error code: 0)
[2026-01-09 03:08:43] 2026-01-09 01:08:43,449 | INFO | traces error code: 0
[2026-01-09 03:08:43] 2026-01-09 01:08:43,449 | INFO | pilot has finished (exit code=0, shell exit code=0)
[2026-01-09 03:08:43] ./runpilot2-wrapper.sh: line 15: date: command not found
[2026-01-09 03:08:43] ==== pilot stdout END ====
[2026-01-09 03:08:43] ./runpilot2-wrapper.sh: line 15: date: command not found
[2026-01-09 03:08:43] ==== wrapper stdout RESUME ====
[2026-01-09 03:08:43] ./runpilot2-wrapper.sh: line 15: date: command not found
[2026-01-09 03:08:43] pilotpid: 3319335
[2026-01-09 03:08:43] ./runpilot2-wrapper.sh: line 15: date: command not found
[2026-01-09 03:08:43] Pilot exit status: 0
[2026-01-09 03:08:43] ./runpilot2-wrapper.sh: line 15: date: command not found
[2026-01-09 03:08:43] File not found: /home/ek/BOINC/slots/1/pilot3/pandaIDs.out, no payload
[2026-01-09 03:08:43] ./runpilot2-wrapper.sh: line 10: date: command not found
[2026-01-09 03:08:43] File not found: /home/ek/BOINC/slots/1/pilot3/pandaIDs.out, no payload
[2026-01-09 03:08:43] ./runpilot2-wrapper.sh: line 27: ps: command not found
[2026-01-09 03:08:43] ./runpilot2-wrapper.sh: line 15: date: command not found
[2026-01-09 03:08:43] No supervise_pilot CHILD process found
[2026-01-09 03:08:43] ./runpilot2-wrapper.sh: line 36: /dev/null: Stale file handle
[2026-01-09 03:08:43] ./runpilot2-wrapper.sh: line 15: date: command not found
[2026-01-09 03:08:43] Test setup, not cleaning
[2026-01-09 03:08:43] ./runpilot2-wrapper.sh: line 15: date: command not found
[2026-01-09 03:08:43] apfmon messages muted
[2026-01-09 03:08:43] ./runpilot2-wrapper.sh: line 15: date: command not found
[2026-01-09 03:08:43] ==== wrapper stdout END ====
[2026-01-09 03:08:43] ./runpilot2-wrapper.sh: line 10: date: command not found
[2026-01-09 03:08:43] ==== wrapper stderr END ====
[2026-01-09 03:08:43] *** Error codes and diagnostics ***
[2026-01-09 03:08:43] *** Listing of results directory ***
[2026-01-09 03:08:43] total 223380
[2026-01-09 03:08:43] -rw-r--r-- 1 ek ek 579449 Jan 8 09:56 pilot3.tar.gz
[2026-01-09 03:08:43] -rwx------ 1 ek ek 36322 Jan 8 10:01 runpilot2-wrapper.sh
[2026-01-09 03:08:43] -rw-r--r-- 1 ek ek 5112 Jan 8 10:01 queuedata.json
[2026-01-09 03:08:43] -rw-rw-r-- 1 ek ek 100 Jan 9 02:55 wrapper_26015_x86_64-pc-linux-gnu
[2026-01-09 03:08:43] -rwxr-xr-x 1 ek ek 7986 Jan 9 02:55 run_atlas
[2026-01-09 03:08:43] -rw-rw-r-- 1 ek ek 105 Jan 9 02:55 job.xml
[2026-01-09 03:08:43] -rw-r--r-- 2 ek ek 224570083 Jan 9 02:55 EVNT.47898824._000391.pool.root.1
[2026-01-09 03:08:43] drwxrwx--x 2 ek ek 4096 Jan 9 02:55 shared
[2026-01-09 03:08:43] -rw-r--r-- 2 ek ek 592397 Jan 9 02:55 input.tar.gz
[2026-01-09 03:08:43] -rw-r--r-- 2 ek ek 15847 Jan 9 02:55 start_atlas.sh
[2026-01-09 03:08:43] -rw-rw-r-- 1 ek ek 0 Jan 9 02:55 boinc_setup_complete
[2026-01-09 03:08:43] -rw-rw-r-- 1 ek ek 9841 Jan 9 02:55 init_data.xml
[2026-01-09 03:08:43] -rw-rw-r-- 1 ek ek 0 Jan 9 02:55 boinc_lockfile
[2026-01-09 03:08:43] -rw-rw-r-- 1 ek ek 2518 Jan 9 02:55 pandaJob.out
[2026-01-09 03:08:43] -rw------- 1 ek ek 50 Jan 9 02:55 setup.sh.local
[2026-01-09 03:08:43] -rw------- 1 ek ek 989837 Jan 9 02:55 agis_schedconf.cvmfs.json
[2026-01-09 03:08:43] -rw------- 1 ek ek 1516240 Jan 9 02:55 agis_ddmendpoints.agis.ALL.json
[2026-01-09 03:08:43] drwx------ 5 ek ek 4096 Jan 9 02:55 pilot3
[2026-01-09 03:08:43] -rw------- 1 ek ek 564 Jan 9 02:56 heartbeat.json
[2026-01-09 03:08:43] -rw------- 1 ek ek 95 Jan 9 03:05 pilot_heartbeat.json
[2026-01-09 03:08:43] drwxrwx--- 2 ek ek 4096 Jan 9 03:06 PanDA_Pilot-6962914999
[2026-01-09 03:08:43] -rw-rw-r-- 1 ek ek 527 Jan 9 03:07 boinc_task_state.xml
[2026-01-09 03:08:43] -rw-rw-r-- 1 ek ek 25 Jan 9 03:08 wrapper_checkpoint.txt
[2026-01-09 03:08:43] -rw-rw-r-- 1 ek ek 8192 Jan 9 03:08 boinc_mmap_file
[2026-01-09 03:08:43] -rw------- 1 ek ek 131132 Jan 9 03:08 pilotlog.txt
[2026-01-09 03:08:43] -rw------- 1 ek ek 148450 Jan 9 03:08 log.47898826._017964.job.log.1
[2026-01-09 03:08:43] -rw------- 1 ek ek 542 Jan 9 03:08 mLsMDmT8zx8n9Rq4apOajLDm4fhM0noT9bVo0NGKDm2JeKDmIKColn.diag
[2026-01-09 03:08:43] -rw-rw-r-- 1 ek ek 428 Jan 9 03:08 runtime_log
[2026-01-09 03:08:43] -rw-rw-r-- 1 ek ek 10143 Jan 9 03:08 runtime_log.err
[2026-01-09 03:08:43] -rw-rw-r-- 1 ek ek 26808 Jan 9 03:08 stderr.txt
[2026-01-09 03:08:43] No HITS result produced
[2026-01-09 03:08:43] *** Contents of shared directory: ***
[2026-01-09 03:08:43] total 219908
[2026-01-09 03:08:43] -rw-r--r-- 2 ek ek 224570083 Jan 9 02:55 ATLAS.root_0
[2026-01-09 03:08:43] -rw-r--r-- 2 ek ek 592397 Jan 9 02:55 input.tar.gz
[2026-01-09 03:08:43] -rw-r--r-- 2 ek ek 15847 Jan 9 02:55 start_atlas.sh
03:08:45 (3315516): run_atlas exited; CPU time 15.934566
03:08:45 (3315516): called boinc_finish(0)
</stderr_txt>
<message>
upload failure: <file_xfer_error>
<file_name>mLsMDmT8zx8n9Rq4apOajLDm4fhM0noT9bVo0NGKDm2JeKDmIKColn_0_r1121937051_ATLAS_result</file_name>
<error_code>-161 (not found)</error_code>
</file_xfer_error>
</message>
]]>
©2026 CERN