Jobsub ID 12802.9@dunegpschedd02.fnal.gov

Jobsub ID	12802.9@dunegpschedd02.fnal.gov
Workflow ID	111
Stage ID	1
User name	higuera@fnal.gov
HTCondor Group	group_dune.prod.mcsim
Requested	Processors	1
	GPU	No
	RSS bytes	4194304000 (4000 MiB)
	Wall seconds limit	80000 (22 hours)
Submitted time	2025-07-30 12:38:07
Site	UK_Edinburgh
Entry	DUNE_UK_SGridECDF_ce1
Last heartbeat	2025-07-30 12:47:00
From worker node	Hostname	node2b01.ecdf.ed.ac.uk
	cpuinfo	Intel(R) Xeon(R) Gold 6338 CPU @ 2.00GHz
	OS release	Scientific Linux release 7.9 (Nitrogen)
	Processors	1
	RSS bytes	4194304000 (4000 MiB)
	Wall seconds limit	171000 (47 hours)
	GPU
	Inner Apptainer?	True
Job state	jobscript_error
Started	2025-07-30 12:39:28
Input files	fardet-vd:prodmarley_nue_cc_flat_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_20250205T182714Z_gen_004618_supernova_g4stage1_g4stage2_detsim_reco.root
Jobscript	Exit code	20
	Real time	0m (0s)
	CPU time	0m (0s = 0%)
	Max RSS bytes	0 (0 MiB)
Outputting started
Output files
Finished	2025-07-30 12:47:00
Saved logs	justin-logs:12802.9-dunegpschedd02.fnal.gov.logs.tgz
List job events Cached HTCondor job logs
Jobscript log (last 10,000 characters)

ity           ] Env: overriding entry: requesttimeout=4096 with 14400
[2025-07-30 13:39:58.327411 +0100][Debug  ][Utility           ] Env: overriding entry: redirectlimit=16 with 64
[2025-07-30 13:39:58.327440 +0100][Debug  ][Utility           ] Env: overriding entry: multiprotocol=0 with 1
[2025-07-30 13:39:58.327946 +0100][Debug  ][File              ] [0xeeb80e0@root://fndca1.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-vd/12/0d/prodmarley_nue_cc_flat_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_20250205T182714Z_gen_004618_supernova_g4stage1_g4stage2_detsim_reco.root?xrdcl.requuid=94763c5d-9abf-4600-ba39-abdff2b0f44b] Sending an open command
[2025-07-30 13:39:58.328615 +0100][Debug  ][Utility           ] Env: trying to get a non-existent string entry: pollerpreference
[2025-07-30 13:39:58.328739 +0100][Debug  ][Poller            ] Available pollers: built-in
[2025-07-30 13:39:58.328744 +0100][Debug  ][Poller            ] Attempting to create a poller according to preference: built-in
[2025-07-30 13:39:58.328749 +0100][Debug  ][Poller            ] Creating poller: built-in
[2025-07-30 13:39:58.328859 +0100][Debug  ][Poller            ] Creating and starting the built-in poller...
[2025-07-30 13:39:58.329428 +0100][Debug  ][Poller            ] Using 1 poller threads
[2025-07-30 13:39:58.329477 +0100][Debug  ][TaskMgr           ] Starting the task manager...
[2025-07-30 13:39:58.329766 +0100][Debug  ][TaskMgr           ] Task manager started
[2025-07-30 13:39:58.329819 +0100][Debug  ][JobMgr            ] Starting the job manager...
[2025-07-30 13:39:58.329916 +0100][Debug  ][JobMgr            ] Job manager started, 3 workers
[2025-07-30 13:39:58.330034 +0100][Debug  ][TaskMgr           ] Registering task: "FileTimer task" to be run at: [2025-07-30 13:39:58 +0100]
[2025-07-30 13:39:58.330444 +0100][Debug  ][ExDbgMsg          ] [fndca1.fnal.gov:1094] MsgHandler created: 0xee86d70 (message: kXR_open (file: pnfs/fnal.gov/usr/dune/persistent/staging/fardet-vd/12/0d/prodmarley_nue_cc_flat_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_20250205T182714Z_gen_004618_supernova_g4stage1_g4stage2_detsim_reco.root, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) ).
[2025-07-30 13:39:58.331020 +0100][Debug  ][PostMaster        ] Creating new channel to: root://fndca1.fnal.gov:1094/
[2025-07-30 13:39:58.331386 +0100][Debug  ][PostMaster        ] [fndca1.fnal.gov:1094] Stream parameters: Network Stack: IPAuto, Connection Window: 30, ConnectionRetry: 5, Stream Error Window: 1800
[2025-07-30 13:39:58.331570 +0100][Debug  ][TaskMgr           ] Registering task: "TickGeneratorTask for: root://fndca1.fnal.gov:1094/" to be run at: [2025-07-30 13:40:13 +0100]
[2025-07-30 13:39:58.332886 +0100][Debug  ][PostMaster        ] [fndca1.fnal.gov:1094] Found 1 address(es): [::ffff:131.225.69.121]:1094
[2025-07-30 13:39:58.332985 +0100][Debug  ][AsyncSock         ] [fndca1.fnal.gov:1094.0] Attempting connection to [::ffff:131.225.69.121]:1094
[2025-07-30 13:39:58.333078 +0100][Debug  ][Poller            ] Adding socket 0xeeb7fc0 to the poller
[2025-07-30 13:39:58.458626 +0100][Debug  ][AsyncSock         ] [fndca1.fnal.gov:1094.0] Async connection call returned
[2025-07-30 13:39:58.459039 +0100][Debug  ][XRootDTransport   ] [fndca1.fnal.gov:1094.0] Sending out the initial hand shake + kXR_protocol
[2025-07-30 13:39:58.584807 +0100][Debug  ][XRootDTransport   ] [fndca1.fnal.gov:1094.0] Got the server hand shake response (type: manager [], protocol version 500)
[2025-07-30 13:39:58.585040 +0100][Debug  ][XRootDTransport   ] [fndca1.fnal.gov:1094.0] kXR_protocol successful (type: manager [], protocol version 500)
[2025-07-30 13:39:58.586352 +0100][Debug  ][XRootDTransport   ] [fndca1.fnal.gov:1094.0] Sending out kXR_login request, username: gl05pi6, cgi: xrd.cc=uk&xrd.tz=0&xrd.appname=lar&xrd.info=&xrd.hostname=node2b01.ecdf.ed.ac.uk&xrd.rn=v5.5.5, dual-stack: false, private IPv4: false, private IPv6: false
[2025-07-30 13:39:58.586416 +0100][Debug  ][AsyncSock         ] [fndca1.fnal.gov:1094.0] TLS hand-shake exchange.
[2025-07-30 13:39:58.722575 +0100][Debug  ][AsyncSock         ] [fndca1.fnal.gov:1094.0] TLS hand-shake exchange.
[2025-07-30 13:39:58.850238 +0100][Debug  ][AsyncSock         ] [fndca1.fnal.gov:1094.0] TLS hand-shake exchange.
[2025-07-30 13:39:58.850557 +0100][Info   ][AsyncSock         ] [fndca1.fnal.gov:1094.0] TLS hand-shake done.
[2025-07-30 13:39:58.976108 +0100][Debug  ][XRootDTransport   ] [fndca1.fnal.gov:1094.0] Logged in, session: 2df91eb2f075b7098547b5bcdf346389
[2025-07-30 13:39:58.976134 +0100][Debug  ][XRootDTransport   ] [fndca1.fnal.gov:1094.0] Authentication is required: &P=ztn,0:4096:&P=gsi,v:10400,c:ssl,ca:3cbc995f
[2025-07-30 13:39:58.976178 +0100][Debug  ][XRootDTransport   ] [fndca1.fnal.gov:1094.0] Sending authentication data
[2025-07-30 13:39:58.988054 +0100][Debug  ][XRootDTransport   ] [fndca1.fnal.gov:1094.0] Trying to authenticate using ztn
[2025-07-30 13:39:58.988105 +0100][Debug  ][XRootDTransport   ] [fndca1.fnal.gov:1094.0] Cannot get credentials for protocol ztn: Secztn: No token found; runtime fetch disallowed.
[2025-07-30 13:39:59.004061 +0100][Debug  ][XRootDTransport   ] [fndca1.fnal.gov:1094.0] Trying to authenticate using gsi
[2025-07-30 13:39:59.995166 +0100][Debug  ][XRootDTransport   ] [fndca1.fnal.gov:1094.0] Sending more authentication data for gsi
[2025-07-30 13:40:00.142081 +0100][Debug  ][XRootDTransport   ] [fndca1.fnal.gov:1094.0] Authenticated with gsi.
[2025-07-30 13:40:00.142238 +0100][Debug  ][PostMaster        ] [fndca1.fnal.gov:1094] Stream 0 connected (IPv4).
[2025-07-30 13:40:00.159443 +0100][Debug  ][Utility           ] Monitor library name not set. No monitoring
[2025-07-30 13:40:00.159912 +0100][Debug  ][ExDbgMsg          ] [fndca1.fnal.gov:1094] Moving MsgHandler: 0xee86d70 (message: kXR_open (file: pnfs/fnal.gov/usr/dune/persistent/staging/fardet-vd/12/0d/prodmarley_nue_cc_flat_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_20250205T182714Z_gen_004618_supernova_g4stage1_g4stage2_detsim_reco.root, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) ) from out-queu to in-queue.
[2025-07-30 13:40:00.294690 +0100][Debug  ][ExDbgMsg          ] [msg: 0xeecb060] Assigned MsgHandler: 0xee86d70.
[2025-07-30 13:40:00.294743 +0100][Debug  ][ExDbgMsg          ] [handler: 0xee86d70] Removed MsgHandler: 0xee86d70 from the in-queue.
[2025-07-30 13:40:00.295111 +0100][Debug  ][XRootD            ] [fndca1.fnal.gov:1094] Handling error while processing kXR_open (file: pnfs/fnal.gov/usr/dune/persistent/staging/fardet-vd/12/0d/prodmarley_nue_cc_flat_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_20250205T182714Z_gen_004618_supernova_g4stage1_g4stage2_detsim_reco.root, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ): [ERROR] Error response: bad address.
[2025-07-30 13:40:00.295377 +0100][Debug  ][ExDbgMsg          ] [fndca1.fnal.gov:1094] Calling MsgHandler: 0xee86d70 (message: kXR_open (file: pnfs/fnal.gov/usr/dune/persistent/staging/fardet-vd/12/0d/prodmarley_nue_cc_flat_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_20250205T182714Z_gen_004618_supernova_g4stage1_g4stage2_detsim_reco.root, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) ) with status: [ERROR] Error response: bad address.
[2025-07-30 13:40:00.295613 +0100][Debug  ][File              ] [0xeeb80e0@root://fndca1.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-vd/12/0d/prodmarley_nue_cc_flat_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_20250205T182714Z_gen_004618_supernova_g4stage1_g4stage2_detsim_reco.root?xrdcl.requuid=94763c5d-9abf-4600-ba39-abdff2b0f44b] Open has returned with status [ERROR] Server responded with an error: [3012] Failed to open file (Pool unavailable [1010])
[2025-07-30 13:40:00.295669 +0100][Debug  ][File              ] [0xeeb80e0@root://fndca1.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-vd/12/0d/prodmarley_nue_cc_flat_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_20250205T182714Z_gen_004618_supernova_g4stage1_g4stage2_detsim_reco.root?xrdcl.requuid=94763c5d-9abf-4600-ba39-abdff2b0f44b] Error while opening at fndca1.fnal.gov:1094: [ERROR] Server responded with an error: [3012] Failed to open file (Pool unavailable [1010])
[2025-07-30 13:40:00.295828 +0100][Debug  ][ExDbgMsg          ] [fndca1.fnal.gov:1094] Destroying MsgHandler: 0xee86d70.
MultiPandoraApiImpl::DeletePandoraInstances - unable to find daughter instances associated with primary 0
%MSG-s ArtException:  TriggerResultInserter:TriggerResults@Construction  30-Jul-2025 13:40:00 BST ModuleConstruction
cet::exception caught in art
---- FileOpenError BEGIN
  RootInputFileSequence::initFile(): Input file root://fndca1.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/fardet-vd/12/0d/prodmarley_nue_cc_flat_radiological_decay0_dunevd10kt_1x8x14_3view_30deg_20250205T182714Z_gen_004618_supernova_g4stage1_g4stage2_detsim_reco.root was not found or could not be opened.
---- FileOpenError END
%MSG
[2025-07-30 13:40:00.372387 +0100][Debug  ][JobMgr            ] Stopping the job manager...
[2025-07-30 13:40:00.372784 +0100][Debug  ][JobMgr            ] Job manager stopped
[2025-07-30 13:40:00.372878 +0100][Debug  ][TaskMgr           ] Stopping the task manager...
[2025-07-30 13:40:00.373035 +0100][Debug  ][TaskMgr           ] Task manager stopped
[2025-07-30 13:40:00.373052 +0100][Debug  ][Poller            ] Stopping the poller...
[2025-07-30 13:40:00.373584 +0100][Debug  ][AsyncSock         ] [fndca1.fnal.gov:1094.0] Closing the socket
[2025-07-30 13:40:00.373696 +0100][Debug  ][Poller            ] <[::ffff:192.41.105.34]:36466><--><[::ffff:131.225.69.121]:1094> Removing socket from the poller
[2025-07-30 13:40:00.374260 +0100][Debug  ][PostMaster        ] [fndca1.fnal.gov:1094] Destroying stream
[2025-07-30 13:40:00.374368 +0100][Debug  ][AsyncSock         ] [fndca1.fnal.gov:1094.0] Closing the socket
Art has completed and will exit with status 20.