Name | kE8KDmVimN7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDm6CRLDmYkvFin_0 |
Workunit | 231562125 |
Created | 12 Apr 2025, 9:52:42 UTC |
Sent | 12 Apr 2025, 13:01:56 UTC |
Report deadline | 20 Apr 2025, 13:01:56 UTC |
Received | 12 Apr 2025, 13:24:36 UTC |
Server state | Over |
Outcome | Validate error |
Client state | Done |
Exit status | 0 (0x00000000) |
Computer ID | 10868352 |
Run time | 2 min 33 sec |
CPU time | 2 sec |
Validate state | Invalid |
Credit | 0.00 |
Device peak FLOPS | 35.74 GFLOPS |
Application version | ATLAS Simulation v3.01 (native_mt) x86_64-pc-linux-gnu |
Peak working set size | 76.20 MB |
Peak swap size | 1.45 GB |
Peak disk usage | 428.48 MB |
<core_client_version>8.0.4</core_client_version> <![CDATA[ <stderr_txt> 14:21:53 (1288430): wrapper (7.7.26015): starting 14:21:53 (1288430): wrapper: running run_atlas (--nthreads 4) [2025-04-12 14:21:53] Arguments: --nthreads 4 [2025-04-12 14:21:53] Threads: 4 [2025-04-12 14:21:53] Checking for CVMFS [2025-04-12 14:21:53] Probing /cvmfs/atlas.cern.ch... OK [2025-04-12 14:21:53] Probing /cvmfs/atlas-condb.cern.ch... OK [2025-04-12 14:21:53] Running cvmfs_config stat atlas.cern.ch [2025-04-12 14:21:54] 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-12 14:21:54] 2.12.7.0 664557 230 32644 144776 1 16 5984529 6144000 93 130560 0 1503373 100.000 34 2 http://s1ral-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1 [2025-04-12 14:21:54] CVMFS is ok [2025-04-12 14:21:54] Efficiency of ATLAS tasks can be improved by the following measure(s): [2025-04-12 14:21:54] Small home clusters do not require a local http proxy but it is suggested if [2025-04-12 14:21:54] more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks. [2025-04-12 14:21:54] Further information can be found at the LHC@home message board. [2025-04-12 14:21:54] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 [2025-04-12 14:21:54] Checking for apptainer binary... [2025-04-12 14:21:54] apptainer is not installed, using version from CVMFS [2025-04-12 14:21:54] Checking apptainer works with /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname [2025-04-12 14:21:54] mini2 [2025-04-12 14:21:54] apptainer works [2025-04-12 14:21:54] Set ATHENA_PROC_NUMBER=4 [2025-04-12 14:21:54] Set ATHENA_CORE_NUMBER=4 [2025-04-12 14:21:54] Starting ATLAS job with PandaID=6600418294 [2025-04-12 14:21:54] Running command: /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/var/lib/boinc-client/slots/2 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh [2025-04-12 14:24:24] *** The last 200 lines of the pilot log: *** [2025-04-12 14:24:24] 2025-04-12 13:22:10,164 | WARNING | aborting monitor loop since graceful_stop has been set (timing out remaining threads) [2025-04-12 14:24:24] 2025-04-12 13:22:10,164 | WARNING | job:job_monitor:received graceful stop - abort after this iteration [2025-04-12 14:24:24] 2025-04-12 13:22:10,164 | INFO | found 1 job(s) in 20 queues [2025-04-12 14:24:24] 2025-04-12 13:22:10,164 | INFO | aborting loop [2025-04-12 14:24:24] 2025-04-12 13:22:10,165 | INFO | aborting job 6600418294 [2025-04-12 14:24:24] 2025-04-12 13:22:10,165 | WARNING | could not find signal name for signal number None - using SIGTERM [2025-04-12 14:24:24] 2025-04-12 13:22:10,203 | WARNING | pilot monitor received instruction that args.graceful_stop has been set [2025-04-12 14:24:24] 2025-04-12 13:22:10,203 | WARNING | will wait for a maximum of 300 s for threads to finish [2025-04-12 14:24:24] 2025-04-12 13:22:10,304 | INFO | all data control threads have been joined [2025-04-12 14:24:24] 2025-04-12 13:22:11,088 | INFO | job 6600418294 has state=failed [2025-04-12 14:24:24] 2025-04-12 13:22:11,125 | INFO | waiting for log transfer to finish (#1/#60): NOT_DONE [2025-04-12 14:24:24] 2025-04-12 13:22:11,125 | INFO | will perform stage-out for job id=6600418294 [2025-04-12 14:24:24] 2025-04-12 13:22:11,125 | INFO | queue data_out is empty [2025-04-12 14:24:24] 2025-04-12 13:22:11,125 | INFO | copied /var/lib/boinc-client/slots/2/pilot_heartbeat.json to /var/lib/boinc-client/slots/2/PanDA_Pilot-6600418294 [2025-04-12 14:24:24] 2025-04-12 13:22:11,133 | INFO | executing command: ls -lF /var/lib/boinc-client/slots/2/PanDA_Pilot-6600418294 [2025-04-12 14:24:24] 2025-04-12 13:22:11,141 | INFO | will create archive /var/lib/boinc-client/slots/2/log.44075164._042826.job.log.tgz.1 using timeout=90 s for directory size=8.96453857421875e-05 MB [2025-04-12 14:24:24] 2025-04-12 13:22:11,141 | INFO | executing command: pwd;tar cvfz /var/lib/boinc-client/slots/2/log.44075164._042826.job.log.tgz.1 tarball_PandaJob_6600418294_BOINC_MCORE --dereference --one-file-s [2025-04-12 14:24:24] 2025-04-12 13:22:11,147 | INFO | copied /var/lib/boinc-client/slots/2/log.44075164._042826.job.log.tgz.1 to /var/lib/boinc-client/slots/2/PanDA_Pilot-6600418294 [2025-04-12 14:24:24] 2025-04-12 13:22:11,147 | INFO | prepare to stage-out 1 log file(s) [2025-04-12 14:24:24] 2025-04-12 13:22:11,148 | INFO | stage-out will not be done in a container [2025-04-12 14:24:24] 2025-04-12 13:22:11,148 | INFO | configured copytools per activity: acopytools={'pl': ['mv'], 'pr': ['mv'], 'pw': ['mv'], 'read_lan': ['mv'], 'write_lan': ['mv'], 'default': ['rucio']} [2025-04-12 14:24:24] 2025-04-12 13:22:11,148 | INFO | [prepare_destinations][pl]: allowed (local) destinations: ['NDGF-T1_DATADISK'], alt_exclude=['CERN-PROD'] [2025-04-12 14:24:24] 2025-04-12 13:22:11,148 | INFO | [prepare_destinations][pl]: resolved default destination: ddm=NDGF-T1_DATADISK, ddm_alt=None [2025-04-12 14:24:24] 2025-04-12 13:22:11,148 | INFO | [prepare_destinations][pl]: use ddmendpoint_alt=None for fspec.ddmendpoint=NDGF-T1_DATADISK [2025-04-12 14:24:24] 2025-04-12 13:22:11,148 | INFO | trying to use copytool=mv for activity=['pl', 'write_lan', 'w', 'default'] [2025-04-12 14:24:24] 2025-04-12 13:22:11,174 | INFO | [job] job monitor thread has finished [2025-04-12 14:24:24] 2025-04-12 13:22:11,199 | INFO | Resolved protocol to be used for transfer: '{'endpoint': 'davs://dav.ndgf.org:443', 'flavour': 'WEBDAV', 'id': 331, 'path': '/atlas/disk/atlasdatadisk/rucio/'}': l [2025-04-12 14:24:24] 2025-04-12 13:22:11,199 | INFO | ready to transfer (stage-out) files: [ accessmode= [2025-04-12 14:24:24] activity=['pl', 'write_lan', 'w', 'default'] [2025-04-12 14:24:24] allow_lan=True [2025-04-12 14:24:24] allow_wan=False [2025-04-12 14:24:24] checkinputsize=True [2025-04-12 14:24:24] checksum={'adler32': '892cb0a6'} [2025-04-12 14:24:24] dataset=mc23_13p6TeV.700789.Sh_2214_Zmumu_maxHTpTV2_BFilter.simul.log.e8514_e8586_s4162_tid44075164_00 [2025-04-12 14:24:24] ddm_activity=['write_lan', 'write_wan'] [2025-04-12 14:24:24] ddmendpoint=NDGF-T1_DATADISK [2025-04-12 14:24:24] ddmendpoint_alt=None [2025-04-12 14:24:24] direct_access_lan=False [2025-04-12 14:24:24] direct_access_wan=False [2025-04-12 14:24:24] domain= [2025-04-12 14:24:24] filesize=4500 [2025-04-12 14:24:24] filetype=log [2025-04-12 14:24:24] guid=0600eefd-6f88-4d89-903b-afd9f1c21e94 [2025-04-12 14:24:24] inputddms=['NDGF-T1_DATADISK', 'CERN-PROD_DATADISK'] [2025-04-12 14:24:24] is_altstaged=None [2025-04-12 14:24:24] is_tar=False [2025-04-12 14:24:24] lfn=log.44075164._042826.job.log.tgz.1 [2025-04-12 14:24:24] mtime=0 [2025-04-12 14:24:24] protocol_id=None [2025-04-12 14:24:24] protocols=[{'endpoint': 'davs://dav.ndgf.org:443', 'flavour': 'WEBDAV', 'id': 331, 'path': '/atlas/disk/atlasdatadisk/rucio/'}] [2025-04-12 14:24:24] replicas=None [2025-04-12 14:24:24] scope=mc23_13p6TeV [2025-04-12 14:24:24] status=None [2025-04-12 14:24:24] status_code=0 [2025-04-12 14:24:24] storage_token= [2025-04-12 14:24:24] surl=/var/lib/boinc-client/slots/2/PanDA_Pilot-6600418294/log.44075164._042826.job.log.tgz.1 [2025-04-12 14:24:24] turl=davs://dav.ndgf.org:443/atlas/disk/atlasdatadisk/rucio/mc23_13p6TeV/1f/79/log.44075164._042826.job.log.tgz.1 [2025-04-12 14:24:24] workdir=None [2025-04-12 14:24:24] ] [2025-04-12 14:24:24] 2025-04-12 13:22:11,210 | WARNING | job_aborted has been set - aborting pilot monitoring [2025-04-12 14:24:24] 2025-04-12 13:22:11,220 | INFO | all job control threads have been joined [2025-04-12 14:24:24] 2025-04-12 13:22:11,220 | INFO | [monitor] control thread has ended [2025-04-12 14:24:24] 2025-04-12 13:22:11,221 | INFO | transferring file log.44075164._042826.job.log.tgz.1 from /var/lib/boinc-client/slots/2/PanDA_Pilot-6600418294/log.44075164._042826.job.log.tgz.1 to /var/lib/boinc [2025-04-12 14:24:24] 2025-04-12 13:22:11,221 | INFO | executing command: /usr/bin/env mv /var/lib/boinc-client/slots/2/PanDA_Pilot-6600418294/log.44075164._042826.job.log.tgz.1 /var/lib/boinc-client/slots/2/log.440751 [2025-04-12 14:24:24] 2025-04-12 13:22:11,228 | INFO | adding to output.list: log.44075164._042826.job.log.tgz.1 davs://dav.ndgf.org:443/atlas/disk/atlasdatadisk/rucio/mc23_13p6TeV/1f/79/log.44075164._042826.job.log.tg [2025-04-12 14:24:24] 2025-04-12 13:22:11,228 | INFO | alt stage-out settings: ['pl', 'write_lan', 'w', 'default'], allow_altstageout=False, remain_files=0, has_altstorage=True [2025-04-12 14:24:24] 2025-04-12 13:22:11,228 | INFO | summary of transferred files: [2025-04-12 14:24:24] 2025-04-12 13:22:11,228 | INFO | -- lfn=log.44075164._042826.job.log.tgz.1, status_code=0, status=transferred [2025-04-12 14:24:24] 2025-04-12 13:22:11,229 | INFO | stage-out finished correctly [2025-04-12 14:24:24] 2025-04-12 13:22:11,265 | INFO | finished stage-out (of log) for failed payload [2025-04-12 14:24:24] 2025-04-12 13:22:11,305 | INFO | [data] control thread has finished [2025-04-12 14:24:24] 2025-04-12 13:22:11,313 | INFO | all payload control threads have been joined [2025-04-12 14:24:24] 2025-04-12 13:22:11,374 | INFO | [job] retrieve thread has finished [2025-04-12 14:24:24] 2025-04-12 13:22:11,413 | INFO | [job] validate thread has finished [2025-04-12 14:24:24] 2025-04-12 13:22:11,486 | INFO | [payload] failed_post thread has finished [2025-04-12 14:24:24] 2025-04-12 13:22:11,488 | INFO | [payload] validate_post thread has finished [2025-04-12 14:24:24] 2025-04-12 13:22:11,522 | INFO | [job] create_data_payload thread has finished [2025-04-12 14:24:24] 2025-04-12 13:22:11,587 | INFO | [payload] validate_pre thread has finished [2025-04-12 14:24:24] 2025-04-12 13:22:11,676 | INFO | [payload] execute_payloads thread has finished [2025-04-12 14:24:24] 2025-04-12 13:22:12,101 | INFO | [payload] run_realtimelog thread has finished [2025-04-12 14:24:24] 2025-04-12 13:22:12,225 | INFO | [job] control thread has finished [2025-04-12 14:24:24] 2025-04-12 13:22:12,270 | INFO | [data] copytool_out thread has finished [2025-04-12 14:24:24] 2025-04-12 13:22:12,319 | INFO | [payload] control thread has finished [2025-04-12 14:24:24] 2025-04-12 13:22:12,803 | WARNING | data:queue_monitoring:received graceful stop - abort after this iteration [2025-04-12 14:24:24] 2025-04-12 13:22:13,125 | INFO | waiting for log transfer to finish (#2/#60): DONE [2025-04-12 14:24:24] 2025-04-12 13:22:13,125 | INFO | queue data_out is empty [2025-04-12 14:24:24] 2025-04-12 13:22:13,125 | INFO | stage-out of log has completed [2025-04-12 14:24:24] 2025-04-12 13:22:13,125 | INFO | proceeding with server update [2025-04-12 14:24:24] 2025-04-12 13:22:13,125 | INFO | preparing for final server update for job 6600418294 in state='failed' [2025-04-12 14:24:24] 2025-04-12 13:22:16,808 | INFO | [data] queue_monitor thread has finished [2025-04-12 14:24:24] 2025-04-12 13:22:18,544 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:22:20,555 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:22:22,565 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:22:24,575 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:22:26,584 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:22:28,594 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:22:30,604 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:22:32,614 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:22:34,624 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:22:36,634 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:22:38,644 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:22:40,654 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:22:42,664 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:22:44,674 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:22:46,679 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:22:48,679 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:22:50,688 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:22:52,696 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:22:54,706 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:22:56,716 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:22:58,726 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:00,736 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:02,746 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:04,756 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:06,765 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:08,775 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:10,785 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:12,795 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:14,805 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:16,815 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:18,825 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:20,835 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:22,844 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:24,854 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:26,858 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:28,863 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:30,870 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:32,875 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:34,880 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:36,885 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:38,895 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:40,905 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:42,915 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:44,922 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:46,929 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:48,935 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:50,939 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:52,948 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:54,953 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:56,961 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:23:58,969 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:24:00,975 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:24:02,979 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:24:04,985 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:24:06,989 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:24:08,599 | INFO | proceeding with final server update [2025-04-12 14:24:24] 2025-04-12 13:24:08,599 | INFO | this job has now completed (state=failed) [2025-04-12 14:24:24] 2025-04-12 13:24:08,599 | INFO | pilot will not update the server (heartbeat message will be written to file) [2025-04-12 14:24:24] 2025-04-12 13:24:08,599 | INFO | log transfer has been attempted: DONE [2025-04-12 14:24:24] 2025-04-12 13:24:08,599 | INFO | job 6600418294 has failed - writing final server update [2025-04-12 14:24:24] 2025-04-12 13:24:08,599 | WARNING | making sure that job.state is set to failed since a pilot error code is set [2025-04-12 14:24:24] 2025-04-12 13:24:08,600 | INFO | payload/TRF did not report the number of read events [2025-04-12 14:24:24] 2025-04-12 13:24:08,601 | INFO | executing command: lscpu [2025-04-12 14:24:24] File "/var/lib/boinc-client/slots/2/pilot3/pilot/common/exception.py", line 466, in run [2025-04-12 14:24:24] self._target(**self.kwargs) [2025-04-12 14:24:24] File "/var/lib/boinc-client/slots/2/pilot3/pilot/control/job.py", line 2651, in queue_monitor [2025-04-12 14:24:24] update_server(job, args) [2025-04-12 14:24:24] File "/var/lib/boinc-client/slots/2/pilot3/pilot/control/job.py", line 2698, in update_server [2025-04-12 14:24:24] send_state(job, args, job.state, xml=dumps(job.fileinfo), metadata=metadata) [2025-04-12 14:24:24] File "/var/lib/boinc-client/slots/2/pilot3/pilot/control/job.py", line 431, in send_state [2025-04-12 14:24:24] data = get_data_structure(job, state, args, xml=xml, metadata=metadata) [2025-04-12 14:24:24] File "/var/lib/boinc-client/slots/2/pilot3/pilot/control/job.py", line 758, in get_data_structure [2025-04-12 14:24:24] cpumodel, cpu_mhz = get_cpu_info(cpumodel) # add the CPU cores if not present [2025-04-12 14:24:24] ValueError caught by thread run() function: (<class 'ValueError'>, ValueError('too many values to unpack (expected 2)'), <traceback object at 0x769549bbb1c0>) [2025-04-12 14:24:24] Traceback (most recent call last): [2025-04-12 14:24:24] File "/var/lib/boinc-client/slots/2/pilot3/pilot/common/exception.py", line 466, in run [2025-04-12 14:24:24] self._target(**self.kwargs) [2025-04-12 14:24:24] File "/var/lib/boinc-client/slots/2/pilot3/pilot/control/job.py", line 2651, in queue_monitor [2025-04-12 14:24:24] update_server(job, args) [2025-04-12 14:24:24] File "/var/lib/boinc-client/slots/2/pilot3/pilot/control/job.py", line 2698, in update_server [2025-04-12 14:24:24] send_state(job, args, job.state, xml=dumps(job.fileinfo), metadata=metadata) [2025-04-12 14:24:24] File "/var/lib/boinc-client/slots/2/pilot3/pilot/control/job.py", line 431, in send_state [2025-04-12 14:24:24] data = get_data_structure(job, state, args, xml=xml, metadata=metadata) [2025-04-12 14:24:24] File "/var/lib/boinc-client/slots/2/pilot3/pilot/control/job.py", line 758, in get_data_structure [2025-04-12 14:24:24] cpumodel, cpu_mhz = get_cpu_info(cpumodel) # add the CPU cores if not present [2025-04-12 14:24:24] ValueError: too many values to unpack (expected 2) [2025-04-12 14:24:24] [2025-04-12 14:24:24] None [2025-04-12 14:24:24] exception has been put in bucket queue belonging to thread 'queue_monitor' [2025-04-12 14:24:24] setting graceful stop in 10 s since there is no point in continuing [2025-04-12 14:24:24] 2025-04-12 13:24:08,993 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:24:11,001 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:24:13,010 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:24:15,016 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:24:17,024 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 130383585580864)>', '<ExcThread(queue_monitor, started 130382640961280)>'] [2025-04-12 14:24:24] 2025-04-12 13:24:19,026 | INFO | caller=run is remaining thread - safe to abort (names=['<_MainThread(MainThread, started 130383585580864)>']) [2025-04-12 14:24:24] 2025-04-12 13:24:24,035 | INFO | all workflow threads have been joined [2025-04-12 14:24:24] 2025-04-12 13:24:24,035 | INFO | end of generic workflow (traces error code: 0) [2025-04-12 14:24:24] 2025-04-12 13:24:24,035 | INFO | traces error code: 0 [2025-04-12 14:24:24] 2025-04-12 13:24:24,035 | INFO | pilot has finished (exit code=0, shell exit code=0) [2025-04-12 14:24:24] 2025-04-12 13:24:24,080 [wrapper] ==== pilot stdout END ==== [2025-04-12 14:24:24] 2025-04-12 13:24:24,081 [wrapper] ==== wrapper stdout RESUME ==== [2025-04-12 14:24:24] 2025-04-12 13:24:24,082 [wrapper] pilotpid: 1292130 [2025-04-12 14:24:24] 2025-04-12 13:24:24,083 [wrapper] Pilot exit status: 0 [2025-04-12 14:24:24] 2025-04-12 13:24:24,086 [wrapper] pandaids: 6600418294 [2025-04-12 14:24:24] 2025-04-12 13:24:24,097 [wrapper] cleanup supervisor_pilot 1292136 1292131 [2025-04-12 14:24:24] 2025-04-12 13:24:24,098 [wrapper] Test setup, not cleaning [2025-04-12 14:24:24] 2025-04-12 13:24:24,099 [wrapper] apfmon messages muted [2025-04-12 14:24:24] 2025-04-12 13:24:24,100 [wrapper] ==== wrapper stdout END ==== [2025-04-12 14:24:24] 2025-04-12 13:24:24,101 [wrapper] ==== wrapper stderr END ==== [2025-04-12 14:24:24] *** Listing of results directory *** [2025-04-12 14:24:24] total 219616 [2025-04-12 14:24:24] -rw-r--r-- 1 boinc boinc 495897 Apr 12 10:42 pilot3.tar.gz [2025-04-12 14:24:24] -rwx------ 1 boinc boinc 37140 Apr 12 10:52 runpilot2-wrapper.sh [2025-04-12 14:24:24] -rw-r--r-- 1 boinc boinc 5111 Apr 12 10:52 queuedata.json [2025-04-12 14:24:24] -rw-r--r-- 1 boinc boinc 100 Apr 12 14:21 wrapper_26015_x86_64-pc-linux-gnu [2025-04-12 14:24:24] -rwxr-xr-x 1 boinc boinc 7986 Apr 12 14:21 run_atlas [2025-04-12 14:24:24] -rw-r--r-- 1 boinc boinc 105 Apr 12 14:21 job.xml [2025-04-12 14:24:24] -rw-r--r-- 1 boinc boinc 7153 Apr 12 14:21 init_data.xml [2025-04-12 14:24:24] -rw-r--r-- 2 boinc boinc 220938078 Apr 12 14:21 EVNT.44075162._001661.pool.root.1 [2025-04-12 14:24:24] -rw-r--r-- 2 boinc boinc 17569 Apr 12 14:21 start_atlas.sh [2025-04-12 14:24:24] drwxrwx--x 2 boinc boinc 4096 Apr 12 14:21 shared [2025-04-12 14:24:24] -rw-r--r-- 2 boinc boinc 508880 Apr 12 14:21 input.tar.gz [2025-04-12 14:24:24] -rw-r--r-- 1 boinc boinc 0 Apr 12 14:21 boinc_lockfile [2025-04-12 14:24:24] -rw-r--r-- 1 boinc boinc 2549 Apr 12 14:21 pandaJob.out [2025-04-12 14:24:24] -rw------- 1 boinc boinc 424 Apr 12 14:21 setup.sh.local [2025-04-12 14:24:24] -rw------- 1 boinc boinc 986068 Apr 12 14:21 agis_schedconf.cvmfs.json [2025-04-12 14:24:24] -rw------- 1 boinc boinc 1603529 Apr 12 14:21 agis_ddmendpoints.agis.ALL.json [2025-04-12 14:24:24] -rw------- 1 boinc boinc 94 Apr 12 14:21 pilot_heartbeat.json [2025-04-12 14:24:24] drwx------ 4 boinc boinc 4096 Apr 12 14:21 pilot3 [2025-04-12 14:24:24] -rw------- 1 boinc boinc 4500 Apr 12 14:22 log.44075164._042826.job.log.tgz.1 [2025-04-12 14:24:24] drwxrwx--- 2 boinc boinc 4096 Apr 12 14:22 PanDA_Pilot-6600418294 [2025-04-12 14:24:24] -rw-r--r-- 1 boinc boinc 521 Apr 12 14:23 boinc_task_state.xml [2025-04-12 14:24:24] -rw-r--r-- 1 boinc boinc 8192 Apr 12 14:24 boinc_mmap_file [2025-04-12 14:24:24] -rw-r--r-- 1 boinc boinc 22 Apr 12 14:24 wrapper_checkpoint.txt [2025-04-12 14:24:24] -rw------- 1 boinc boinc 31143 Apr 12 14:24 pilotlog.txt [2025-04-12 14:24:24] -rw------- 1 boinc boinc 46984 Apr 12 14:24 log.44075164._042826.job.log.1 [2025-04-12 14:24:24] -rw------- 1 boinc boinc 188 Apr 12 14:24 output.list [2025-04-12 14:24:24] -rw-r--r-- 1 boinc boinc 603 Apr 12 14:24 runtime_log [2025-04-12 14:24:24] -rw------- 1 boinc boinc 61440 Apr 12 14:24 result.tar.gz [2025-04-12 14:24:24] -rw-r--r-- 1 boinc boinc 10834 Apr 12 14:24 runtime_log.err [2025-04-12 14:24:24] -rw------- 1 boinc boinc 626 Apr 12 14:24 kE8KDmVimN7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDm6CRLDmYkvFin.diag [2025-04-12 14:24:24] -rw-r--r-- 1 boinc boinc 28083 Apr 12 14:24 stderr.txt [2025-04-12 14:24:24] No HITS result produced [2025-04-12 14:24:24] *** Contents of shared directory: *** [2025-04-12 14:24:24] total 216344 [2025-04-12 14:24:24] -rw-r--r-- 2 boinc boinc 220938078 Apr 12 14:21 ATLAS.root_0 [2025-04-12 14:24:24] -rw-r--r-- 2 boinc boinc 17569 Apr 12 14:21 start_atlas.sh [2025-04-12 14:24:24] -rw-r--r-- 2 boinc boinc 508880 Apr 12 14:21 input.tar.gz [2025-04-12 14:24:24] -rw------- 1 boinc boinc 61440 Apr 12 14:24 result.tar.gz 14:24:25 (1288430): run_atlas exited; CPU time 2.609008 14:24:25 (1288430): called boinc_finish(0) </stderr_txt> ]]>
©2025 CERN