Jobsub ID 262639.0@justin-prod-sched01.dune.hep.ac.uk
| Jobsub ID | 262639.0@justin-prod-sched01.dune.hep.ac.uk |
| Workflow Testing | Yes |
| Workflow ID | 1 |
| Stage ID | 1 |
| User name | amcnab@fnal.gov |
| HTCondor Group | group_dune.prod_mcsim |
| Requested | Processors | 1 |
| RSS bytes | 1073741824 (1024 MiB) |
| Wall seconds limit | 3600 (1 hours) |
| Submitted time | 2024-09-26 01:17:52 |
| Site | US_FNAL-T1 |
| Entry | CMSHTPC_T1_US_FNAL_condce_opp1_whole |
| Last heartbeat | 2024-09-26 02:49:34 |
| From worker node | Hostname | dunegli-35005-0-cmswn2324.fnal.gov |
| cpuinfo | Intel(R) Xeon(R) CPU E5-2670 v3 @ 2.30GHz |
| OS release | Scientific Linux release 7.9 (Nitrogen) |
| Processors | 1 |
| RSS bytes | 1073741824 (1024 MiB) |
| Wall seconds limit | 171000 (47 hours) |
| Inner Apptainer? | True |
| Job state | finished |
| Allocator name | justin-allocator-pro.dune.hep.ac.uk |
| Started | 2024-09-26 01:18:45 |
| Input files | |
| Jobscript | Exit code | 0 |
| Real time | 1h (5441s) |
| CPU time | 0m (13s = 0%) |
| Outputting started | 2024-09-26 02:49:28 |
| Output files | |
| Finished | 2024-09-26 02:49:34 |
| Saved logs | justin-logs:262639.0-justin-prod-sched01.dune.hep.ac.uk.logs.tgz |
| List job events Wrapper job log |
Jobscript log (last 10,000 characters)
lib3.connectionpool:https://dune-rucio.fnal.gov:443 "GET /dids/testpro/awt-1727313528-UUXvAXaB0c/meta?plugin=DID_COLUMN HTTP/1.1" 503 299
[33;1m2024-09-26 02:45:25,736 WARNING Waiting 0.25s due to reason: server returned 503 [0m
WARNING:baseclient:Waiting 0.25s due to reason: server returned 503
DEBUG:urllib3.connectionpool:Starting new HTTPS connection (5): dune-rucio.fnal.gov:443
DEBUG:urllib3.connectionpool:https://dune-rucio.fnal.gov:443 "GET /dids/testpro/awt-1727313528-UUXvAXaB0c/meta?plugin=DID_COLUMN HTTP/1.1" 404 129
DEBUG:root:File DID does not exist
DEBUG:urllib3.connectionpool:https://dune-rucio.fnal.gov:443 "POST /replicas HTTP/1.1" 201 7
INFO:root:Successfully added replica in Rucio catalogue at SURFSARA
DEBUG:root:gfal.Default: connecting to storage
DEBUG:root:gfal.Default: checking if file exists None
DEBUG:root:Checking if root://penguin12.grid.surfsara.nl:21094/pnfs/grid.sara.nl/data/dune/disk/RSE/testpro/45/d8/awt-1727313528-UUXvAXaB0c exists
DEBUG:root:gfal.Default: checking if file exists root://penguin12.grid.surfsara.nl:21094/pnfs/grid.sara.nl/data/dune/disk/RSE/testpro/45/d8/awt-1727313528-UUXvAXaB0c
DEBUG:root:gfal.Default: closing protocol connection
DEBUG:root:[{'hostname': 'webdav.grid.surfsara.nl', 'scheme': 'davs', 'port': 2880, 'prefix': '/pnfs/grid.sara.nl/data/dune/disk/RSE', 'impl': 'rucio.rse.protocols.gfal.Default', 'domains': {'lan': {'read': 2, 'write': 1, 'delete': 1}, 'wan': {'read': 2, 'write': 1, 'delete': 1, 'third_party_copy_read': 1, 'third_party_copy_write': 1}}, 'extended_attributes': None}, {'hostname': 'penguin12.grid.surfsara.nl', 'scheme': 'root', 'port': 21094, 'prefix': '/pnfs/grid.sara.nl/data/dune/disk/RSE', 'impl': 'rucio.rse.protocols.gfal.Default', 'domains': {'lan': {'read': 1, 'write': 1, 'delete': 2}, 'wan': {'read': 1, 'write': 1, 'delete': 2, 'third_party_copy_read': 10, 'third_party_copy_write': 10}}, 'extended_attributes': None}]
INFO:root:Trying upload with root to SURFSARA
DEBUG:root:Processing upload with the domain: wan
DEBUG:root:gfal.Default: connecting to storage
DEBUG:root:The PFN created from the LFN: root://penguin12.grid.surfsara.nl:21094/pnfs/grid.sara.nl/data/dune/disk/RSE/testpro/45/d8/awt-1727313528-UUXvAXaB0c
DEBUG:root:gfal.Default: checking if file exists root://penguin12.grid.surfsara.nl:21094/pnfs/grid.sara.nl/data/dune/disk/RSE/testpro/45/d8/awt-1727313528-UUXvAXaB0c
DEBUG:root:gfal.Default: checking if file exists root://penguin12.grid.surfsara.nl:21094/pnfs/grid.sara.nl/data/dune/disk/RSE/testpro/45/d8/awt-1727313528-UUXvAXaB0c.rucio.upload
DEBUG:root:put: Attempt 1
DEBUG:root:gfal.Default: uploading file from awt-1727313528-UUXvAXaB0c to root://penguin12.grid.surfsara.nl:21094/pnfs/grid.sara.nl/data/dune/disk/RSE/testpro/45/d8/awt-1727313528-UUXvAXaB0c.rucio.upload
INFO:root:Successful upload of temporary file. root://penguin12.grid.surfsara.nl:21094/pnfs/grid.sara.nl/data/dune/disk/RSE/testpro/45/d8/awt-1727313528-UUXvAXaB0c.rucio.upload
DEBUG:root:skip_upload_stat=False
DEBUG:root:stat: pfn=root://penguin12.grid.surfsara.nl:21094/pnfs/grid.sara.nl/data/dune/disk/RSE/testpro/45/d8/awt-1727313528-UUXvAXaB0c.rucio.upload
DEBUG:root:gfal.Default: getting stats of file root://penguin12.grid.surfsara.nl:21094/pnfs/grid.sara.nl/data/dune/disk/RSE/testpro/45/d8/awt-1727313528-UUXvAXaB0c.rucio.upload
DEBUG:root:Filesize: Expected=26 Found=26
DEBUG:root:Checksum: Expected=5feb06ff Found=5feb06ff
DEBUG:root:Renaming file root://penguin12.grid.surfsara.nl:21094/pnfs/grid.sara.nl/data/dune/disk/RSE/testpro/45/d8/awt-1727313528-UUXvAXaB0c.rucio.upload to root://penguin12.grid.surfsara.nl:21094/pnfs/grid.sara.nl/data/dune/disk/RSE/testpro/45/d8/awt-1727313528-UUXvAXaB0c
DEBUG:root:gfal.Default: renaming file from root://penguin12.grid.surfsara.nl:21094/pnfs/grid.sara.nl/data/dune/disk/RSE/testpro/45/d8/awt-1727313528-UUXvAXaB0c.rucio.upload to root://penguin12.grid.surfsara.nl:21094/pnfs/grid.sara.nl/data/dune/disk/RSE/testpro/45/d8/awt-1727313528-UUXvAXaB0c
DEBUG:root:gfal.Default: closing protocol connection
DEBUG:root:Upload done.
INFO:root:Successfully uploaded file awt-1727313528-UUXvAXaB0c
DEBUG:urllib3.connectionpool:Starting new HTTPS connection (1): dune-rucio.fnal.gov:443
/cvmfs/dune.opensciencegrid.org/products/dune/rucio/v34_4_2/NULL/lib/python3.9/site-packages/urllib3/connectionpool.py:1061: InsecureRequestWarning: Unverified HTTPS request is being made to host 'dune-rucio.fnal.gov'. Adding certificate verification is strongly advised. See: https://urllib3.readthedocs.io/en/1.26.x/advanced-usage.html#ssl-warnings
warnings.warn(
DEBUG:urllib3.connectionpool:https://dune-rucio.fnal.gov:443 "POST /traces/ HTTP/1.1" 503 299
DEBUG:dogpile.lock:value creation lock <dogpile.cache.region.CacheRegion._LockWrapper object at 0x14c0e6178e50> acquired
DEBUG:dogpile.lock:Calling creation function for previously expired value
DEBUG:dogpile.cache.region:Cache value generated in 0.000 seconds for key(s): "host_to_choose_choice['https://dune-rucio.fnal.gov']"
DEBUG:dogpile.lock:Released creation lock
DEBUG:urllib3.connectionpool:Resetting dropped connection: dune-rucio.fnal.gov
DEBUG:urllib3.connectionpool:https://dune-rucio.fnal.gov:443 "PUT /replicas HTTP/1.1" 503 299
[33;1m2024-09-26 02:48:47,625 WARNING Waiting 0.25s due to reason: server returned 503 [0m
WARNING:baseclient:Waiting 0.25s due to reason: server returned 503
DEBUG:urllib3.connectionpool:Resetting dropped connection: dune-rucio.fnal.gov
DEBUG:urllib3.connectionpool:https://dune-rucio.fnal.gov:443 "PUT /replicas HTTP/1.1" 503 299
[33;1m2024-09-26 02:49:02,974 WARNING Waiting 0.5s due to reason: server returned 503 [0m
WARNING:baseclient:Waiting 0.5s due to reason: server returned 503
DEBUG:urllib3.connectionpool:Resetting dropped connection: dune-rucio.fnal.gov
DEBUG:urllib3.connectionpool:https://dune-rucio.fnal.gov:443 "PUT /replicas HTTP/1.1" 503 299
[33;1m2024-09-26 02:49:18,693 WARNING Waiting 1.0s due to reason: server returned 503 [0m
WARNING:baseclient:Waiting 1.0s due to reason: server returned 503
ERROR:root:Failed to update replica state for file awt-1727313528-UUXvAXaB0c
DEBUG:root:Details: An unknown exception occurred.
Details: no error information passed (http status code: 503)
DEBUG:urllib3.connectionpool:Resetting dropped connection: dune-rucio.fnal.gov
DEBUG:urllib3.connectionpool:https://dune-rucio.fnal.gov:443 "POST /dids/testpro/awt-uploads-202439/dids HTTP/1.1" 201 7
--- Upload try 1/1
--- Rucio upload 1/1 fails: None of the given files have been uploaded.
--- Exit with 99
'justin-rucio-upload --rse SURFSARA --protocol davs --scope testpro --dataset awt-uploads-202439 awt-1727313528-UUXvAXaB0c --timeout 1200' returns 99
subject : /C=UK/O=eScience/OU=Manchester/L=HEP/CN=justin-jobs-production.dune.hep.ac.uk/CN=2021060471/CN=172731352496
issuer : /C=UK/O=eScience/OU=Manchester/L=HEP/CN=justin-jobs-production.dune.hep.ac.uk/CN=2021060471
identity : /C=UK/O=eScience/OU=Manchester/L=HEP/CN=justin-jobs-production.dune.hep.ac.uk/CN=2021060471
type : RFC compliant proxy
strength : 2048 bits
path : /home/awt-proxy.pem
timeleft : 166:29:18
key usage : Digital Signature, Key Encipherment, Key Agreement
=== VO dune extension information ===
VO : dune
subject : /C=UK/O=eScience/OU=Manchester/L=HEP/CN=justin-jobs-production.dune.hep.ac.uk
issuer : /DC=org/DC=incommon/C=US/ST=Illinois/O=Fermi Research Alliance/CN=voms1.fnal.gov
attribute : /dune/Role=Production/Capability=NULL
attribute : /dune/Role=NULL/Capability=NULL
timeleft : 144:47:37
uri : voms1.fnal.gov:15042
===== Results =====
Download/upload commands:
xrdcp --force --nopbar --verbose $read_pfn downloaded.txt
justin-rucio-upload --rse $rse_name --protocol $write_protocol --scope testpro --dataset --timeout 1200 FILENAME
Use the wrapper job link on the page for the job on the justIN Dashboard to find the full log file, with errors from these commands
Each line: $JUSTIN_SITE_NAME $rse_name $download_retval $upload_retval $read_pfn $write_protocol
==awt== US_FNAL-T1 DUNE_CERN_EOS 0 0 root://eospublic.cern.ch:1094//eos/experiment/neutplatform/protodune/dune/testpro/bb/7f/awt-download-2023-03-07-01.txt davs
==awt== US_FNAL-T1 DUNE_ES_PIC 0 0 root://xrootd.pic.es:1094/pnfs/pic.es/data/dune/RSE/testpro/bb/7f/awt-download-2023-03-07-01.txt davs
==awt== US_FNAL-T1 DUNE_FR_CCIN2P3_DISK 0 0 root://ccxrootdegee.in2p3.fr:1094/pnfs/in2p3.fr/data/dune/disk/testpro/bb/7f/awt-download-2023-03-07-01.txt davs
==awt== US_FNAL-T1 DUNE_UK_LANCASTER_CEPH 0 0 root://xgate.hec.lancs.ac.uk:1094//cephfs/grid/dune/testpro/bb/7f/awt-download-2023-03-07-01.txt davs
==awt== US_FNAL-T1 DUNE_US_BNL_SDCC 0 99 root://dcdndoor.sdcc.bnl.gov:1094//pnfs/sdcc.bnl.gov/data/dune/RSE/testpro/bb/7f/awt-download-2023-03-07-01.txt davs
==awt== US_FNAL-T1 DUNE_US_FNAL_DISK_STAGE 0 99 root://fndca1.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/testpro/bb/7f/awt-download-2023-03-07-01.txt davs
==awt== US_FNAL-T1 MANCHESTER 54 99 root://bohr3226.tier2.hep.manchester.ac.uk:1094//dune/RSE/testpro/bb/7f/awt-download-2023-03-07-01.txt davs
==awt== US_FNAL-T1 NIKHEF 0 99 root://dune.dcache.nikhef.nl:1094/pnfs/nikhef.nl/data/dune/generic/rucio/testpro/bb/7f/awt-download-2023-03-07-01.txt davs
==awt== US_FNAL-T1 PRAGUE 0 99 root://golias100.farm.particle.cz:1094/dpm/farm.particle.cz/home/dune/RSE/testpro/bb/7f/awt-download-2023-03-07-01.txt davs
==awt== US_FNAL-T1 QMUL 51 99 root://xrootd01.esc.qmul.ac.uk:1094//dune/RSE/testpro/bb/7f/awt-download-2023-03-07-01.txt davs
==awt== US_FNAL-T1 RAL-PP 0 99 root://mover.pp.rl.ac.uk:1094/pnfs/pp.rl.ac.uk/data/dune/testpro/bb/7f/awt-download-2023-03-07-01.txt davs
==awt== US_FNAL-T1 RAL_ECHO 0 99 root://xrootd.echo.stfc.ac.uk:1094/dune:/protodune/RSE/testpro/bb/7f/awt-download-2023-03-07-01.txt davs
==awt== US_FNAL-T1 SURFSARA 0 99 root://penguin12.grid.surfsara.nl:21094/pnfs/grid.sara.nl/data/dune/disk/RSE/testpro/bb/7f/awt-download-2023-03-07-01.txt davs 