INT           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 168100.0@justin-prod-sched02.dune.hep.ac.uk

Jobsub ID168100.0@justin-prod-sched02.dune.hep.ac.uk
Workflow TestingYes
Workflow ID500
Stage ID1
User nameamcnab@fnal.gov
HTCondor Groupgroup_dune
RequestedProcessors1
GPUNo
RSS bytes1073741824 (1024 MiB)
Wall seconds limit3600 (1 hours)
Submitted time2025-04-01 03:38:52
SiteUK_Edinburgh
EntryDUNE_UK_SGridECDF_ce1_multicore
Last heartbeat2025-04-01 04:00:03
From worker nodeHostnamenode2b05.ecdf.ed.ac.uk
cpuinfoIntel(R) Xeon(R) Gold 6338 CPU @ 2.00GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes1073741824 (1024 MiB)
Wall seconds limit171000 (47 hours)
GPU
Inner Apptainer?True
Job statefinished
Allocator namejustin-allocator-int.dune.hep.ac.uk
Started2025-04-01 03:40:51
Input files
JobscriptExit code0
Real time18m (1136s)
CPU time0m (9s = 0%)
Max RSS bytes42262528 (40 MiB)
Outputting started2025-04-01 03:59:47
Output files
Finished2025-04-01 04:00:03
Saved logsjustin-logs:168100.0-justin-prod-sched02.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

nl:21094.0] Closing the socket
[2025-04-01 04:57:44.821226 +0100][Debug  ][Poller            ] <x><--><x> Removing socket from the poller
[2025-04-01 04:57:44.821241 +0100][Error  ][PostMaster        ] [otter12.grid.surfsara.nl:21094] elapsed = 0, pConnectionWindow = 120 seconds.
[2025-04-01 04:57:44.821247 +0100][Info   ][PostMaster        ] [otter12.grid.surfsara.nl:21094] Attempting reconnection in 120 seconds.
[2025-04-01 04:57:44.821254 +0100][Debug  ][TaskMgr           ] Registering task: "StreamConnectorTask for otter12.grid.surfsara.nl:21094" to be run at: [2025-04-01 04:59:44 +0100]
[2025-04-01 04:59:44.812324 +0100][Debug  ][PostMaster        ] [otter12.grid.surfsara.nl:21094] Found 1 address(es): [::ffff:145.100.34.53]:21094
[2025-04-01 04:59:44.812363 +0100][Debug  ][AsyncSock         ] [otter12.grid.surfsara.nl:21094.0] Attempting connection to [::ffff:145.100.34.53]:21094
[2025-04-01 04:59:44.812390 +0100][Debug  ][Poller            ] Adding socket 0x21e12f0 to the poller
[2025-04-01 04:59:44.812424 +0100][Debug  ][TaskMgr           ] Done with task: "StreamConnectorTask for otter12.grid.surfsara.nl:21094"
[2025-04-01 04:59:44.830603 +0100][Debug  ][AsyncSock         ] [otter12.grid.surfsara.nl:21094.0] Async connection call returned
[2025-04-01 04:59:44.830621 +0100][Error  ][AsyncSock         ] [otter12.grid.surfsara.nl:21094.0] Unable to connect: connection refused
[2025-04-01 04:59:44.830626 +0100][Debug  ][AsyncSock         ] [otter12.grid.surfsara.nl:21094.0] Closing the socket
[2025-04-01 04:59:44.830633 +0100][Debug  ][Poller            ] <x><--><x> Removing socket from the poller
[2025-04-01 04:59:44.830651 +0100][Error  ][PostMaster        ] [otter12.grid.surfsara.nl:21094] elapsed = 0, pConnectionWindow = 120 seconds.
[2025-04-01 04:59:44.830661 +0100][Error  ][PostMaster        ] [otter12.grid.surfsara.nl:21094] Unable to recover: [ERROR] Connection error.
[2025-04-01 04:59:44.830675 +0100][Error  ][XRootD            ] [otter12.grid.surfsara.nl:21094] Impossible to send message kXR_open (file: pnfs/grid.sara.nl/data/dune/disk/RSE/testpro/bb/7f/awt-download-2023-03-07-01.txt, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ). Trying to recover.
[2025-04-01 04:59:44.830684 +0100][Debug  ][XRootD            ] [otter12.grid.surfsara.nl:21094] Handling error while processing kXR_open (file: pnfs/grid.sara.nl/data/dune/disk/RSE/testpro/bb/7f/awt-download-2023-03-07-01.txt, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ): [FATAL] Connection error.
[2025-04-01 04:59:44.830694 +0100][Debug  ][ExDbgMsg          ] [otter12.grid.surfsara.nl:21094] Passing to the thread-pool MsgHandler: 0x2201010 (message: kXR_open (file: pnfs/grid.sara.nl/data/dune/disk/RSE/testpro/bb/7f/awt-download-2023-03-07-01.txt, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) ).
[2025-04-01 04:59:44.830717 +0100][Debug  ][ExDbgMsg          ] [otter12.grid.surfsara.nl:21094] Calling MsgHandler: 0x2201010 (message: kXR_open (file: pnfs/grid.sara.nl/data/dune/disk/RSE/testpro/bb/7f/awt-download-2023-03-07-01.txt, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) ) with status: [FATAL] Connection error.
[2025-04-01 04:59:44.830751 +0100][Debug  ][File              ] [0x21e0840@root://otter12.grid.surfsara.nl:21094/pnfs/grid.sara.nl/data/dune/disk/RSE/testpro/bb/7f/awt-download-2023-03-07-01.txt?xrdcl.requuid=54bec240-a7a7-4718-9c89-f3d375138f38] Open has returned with status [FATAL] Connection error
[2025-04-01 04:59:44.830764 +0100][Debug  ][File              ] [0x21e0840@root://otter12.grid.surfsara.nl:21094/pnfs/grid.sara.nl/data/dune/disk/RSE/testpro/bb/7f/awt-download-2023-03-07-01.txt?xrdcl.requuid=54bec240-a7a7-4718-9c89-f3d375138f38] Error while opening at otter12.grid.surfsara.nl:21094: [FATAL] Connection error
[2025-04-01 04:59:44.830779 +0100][Debug  ][ExDbgMsg          ] [otter12.grid.surfsara.nl:21094] Destroying MsgHandler: 0x2201010.
Run: [FATAL] Connection error:  (source)
[2025-04-01 04:59:44.831085 +0100][Debug  ][JobMgr            ] Stopping the job manager...
[2025-04-01 04:59:44.831220 +0100][Debug  ][JobMgr            ] Job manager stopped
[2025-04-01 04:59:44.831228 +0100][Debug  ][TaskMgr           ] Stopping the task manager...
[2025-04-01 04:59:44.831306 +0100][Debug  ][TaskMgr           ] Task manager stopped
[2025-04-01 04:59:44.831312 +0100][Debug  ][Poller            ] Stopping the poller...
[2025-04-01 04:59:44.831663 +0100][Debug  ][AsyncSock         ] [otter12.grid.surfsara.nl:21094.0] Closing the socket
[2025-04-01 04:59:44.831673 +0100][Debug  ][PostMaster        ] [otter12.grid.surfsara.nl:21094] Destroying stream
[2025-04-01 04:59:44.831680 +0100][Debug  ][AsyncSock         ] [otter12.grid.surfsara.nl:21094.0] Closing the socket
'xrdcp --force --nopbar --verbose root://otter12.grid.surfsara.nl:21094/pnfs/grid.sara.nl/data/dune/disk/RSE/testpro/bb/7f/awt-download-2023-03-07-01.txt downloaded.txt' returns 51
{
    "created_timestamp": null,
    "creator": "dunepro",
    "fid": "gLIUGU9XTeCmBNst",
    "metadata": {},
    "name": "awt-1743478855-gkoWxQFyKV",
    "namespace": "testpro",
    "retired": false,
    "retired_by": null,
    "retired_timestamp": null,
    "size": 0,
    "updated_by": null,
    "updated_timestamp": null
}
metacat file declare returns 0
GFAL_CONFIG_DIR:    GFAL_PLUGIN_DIR: 
justin-rucio-upload attempt 1
DEBUG:urllib3.connectionpool:Starting new HTTPS connection (1): dune-rucio.fnal.gov:443
DEBUG:urllib3.connectionpool:https://dune-rucio.fnal.gov:443 "GET /auth/x509_proxy HTTP/1.1" 401 132
DEBUG:charset_normalizer:Encoding detection: ascii is most likely the one.
DEBUG:charset_normalizer:Encoding detection: ascii is most likely the one.
DEBUG:charset_normalizer:Encoding detection: ascii is most likely the one.
--- Upload try 1/1
--- Rucio upload 1/1 fails: Cannot authenticate.
Details: Cannot authenticate to account justinreadonly with given credentials
--- Exit with 99
'justin-rucio-upload --rse SURFSARA --protocol davs --scope testpro --dataset awt-uploads-202513 awt-1743478855-gkoWxQFyKV --timeout 1200' returns 99


subject   : /C=UK/O=eScience/OU=Manchester/L=HEP/CN=justin-jobs-production.dune.hep.ac.uk/CN=17710010/CN=174347885144
issuer    : /C=UK/O=eScience/OU=Manchester/L=HEP/CN=justin-jobs-production.dune.hep.ac.uk/CN=17710010
identity  : /C=UK/O=eScience/OU=Manchester/L=HEP/CN=justin-jobs-production.dune.hep.ac.uk/CN=17710010
type      : RFC compliant proxy
strength  : 2048 bits
path      : /home/awt-proxy.pem
timeleft  : 167:41:04
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  : 167:28:15
uri       : voms1.fnal.gov:15042

===== Results =====

Download/upload commands:
xrdcp --force --nopbar --verbose $read_pfn downloaded.txt
echo '{"namespace":"testpro","name":"FILENAME","size":0}' >tmp.json
metacat file declare --json -f tmp.json "dune:all"
justin-rucio-upload --rse $rse_name --protocol $write_protocol --scope testpro --dataset awt-uploads-202513 --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== UK_Edinburgh DUNE_CA_SFU 0 99 root://lcg-dunese1.sfu.computecanada.ca:1094//dune/RSE/testpro/bb/7f/awt-download-2023-03-07-01.txt davs
==awt== UK_Edinburgh DUNE_CERN_EOS 0 99 root://eospublic.cern.ch:1094//eos/experiment/neutplatform/protodune/dune/testpro/bb/7f/awt-download-2023-03-07-01.txt davs
==awt== UK_Edinburgh DUNE_ES_PIC 0 99 root://xrootd.pic.es:1094/pnfs/pic.es/data/dune/RSE/testpro/bb/7f/awt-download-2023-03-07-01.txt davs
==awt== UK_Edinburgh DUNE_FR_CCIN2P3_DISK 0 99 root://ccxrootdegee.in2p3.fr:1094/pnfs/in2p3.fr/data/dune/disk/testpro/bb/7f/awt-download-2023-03-07-01.txt davs
==awt== UK_Edinburgh DUNE_IT_INFN_CNAF 0 99 root://xrootd-archive.cr.cnaf.infn.it:1096//dune/testpro/bb/7f/awt-download-2023-03-07-01.txt davs
==awt== UK_Edinburgh DUNE_UK_GLASGOW 0 99 root://cephc02.gla.scotgrid.ac.uk:1094//cephfs/dune/RSE/testpro/bb/7f/awt-download-2023-03-07-01.txt davs
==awt== UK_Edinburgh DUNE_UK_LANCASTER_CEPH 0 99 root://xgate.hec.lancs.ac.uk:1094//cephfs/grid/dune/testpro/bb/7f/awt-download-2023-03-07-01.txt davs
==awt== UK_Edinburgh DUNE_UK_MANCHESTER_CEPH 0 99 root://meitner.tier2.hep.manchester.ac.uk:1094//cephfs/experiments/dune/RSE/testpro/bb/7f/awt-download-2023-03-07-01.txt davs
==awt== UK_Edinburgh 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== UK_Edinburgh DUNE_US_FNAL_DISK_STAGE 51 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== UK_Edinburgh 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== UK_Edinburgh 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== UK_Edinburgh QMUL 0 99 root://xrootd1.esc.qmul.ac.uk:1094//dune/RSE/testpro/bb/7f/awt-download-2023-03-07-01.txt davs
==awt== UK_Edinburgh 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== UK_Edinburgh 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== UK_Edinburgh SURFSARA 51 99 root://otter12.grid.surfsara.nl:21094/pnfs/grid.sara.nl/data/dune/disk/RSE/testpro/bb/7f/awt-download-2023-03-07-01.txt davs
justIN time: 2025-04-11 05:35:21 UTC       justIN version: 01.04.rc0