justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 252797.133@dunegpschedd01.fnal.gov

Jobsub ID252797.133@dunegpschedd01.fnal.gov
Workflow ID10258
Stage ID1
User nameepennacc@fnal.gov
HTCondor Groupgroup_dune.prod_mcsim
RequestedProcessors1
GPUNo
RSS bytes4194304000 (4000 MiB)
Wall seconds limit80000 (22 hours)
Submitted time2025-11-16 13:12:00
SiteUK_Edinburgh
EntryDUNE_UK_SGridECDF_ce1_multicore
Last heartbeat2025-11-16 13:32:08
From worker nodeHostnamenode2b04.ecdf.ed.ac.uk
cpuinfoIntel(R) Xeon(R) Gold 6338 CPU @ 2.00GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4194304000 (4000 MiB)
Wall seconds limit171000 (47 hours)
GPU
Inner Apptainer?True
Job statejobscript_error
Started2025-11-16 13:24:59
Input filesfardet-hd:prodgenie_nue_dune10kt_1x2x6_20251004T021532Z_gen_005131_g4_detsim.root
fardet-hd:prodgenie_nue_dune10kt_1x2x6_20251003T234008Z_gen_000588_g4_detsim.root
fardet-hd:prodgenie_nue_dune10kt_1x2x6_20251004T023846Z_gen_005778_g4_detsim.root
fardet-hd:prodgenie_nue_dune10kt_1x2x6_20251004T003235Z_gen_002350_g4_detsim.root
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Max RSS bytes0 (0 MiB)
Outputting started 
Output files
Finished2025-11-16 13:32:08
Saved logsjustin-logs:252797.133-dunegpschedd01.fnal.gov.logs.tgz
List job events     (HTCondor job logs unavailable)

Jobscript log (last 10,000 characters)

-16 13:31:42.403847 +0000][Debug  ][ExDbgMsg          ] [ccdcacli447.in2p3.fr:30134] Moving MsgHandler: 0x8097080 (message: kXR_read (handle: 0x00000000, offset: 18651644, size: 179419272) ) from out-queu to in-queue.
[2025-11-16 13:31:45.229805 +0000][Error  ][AsyncSock         ] [ccdcacli447.in2p3.fr:30134.0] Socket error encountered: [ERROR] Socket error
[2025-11-16 13:31:45.229842 +0000][Debug  ][AsyncSock         ] [ccdcacli447.in2p3.fr:30134.0] Closing the socket
[2025-11-16 13:31:45.229850 +0000][Debug  ][Poller            ] <[::ffff:192.41.105.37]:56006><--><[::ffff:134.158.209.218]:30134> Removing socket from the poller
[2025-11-16 13:31:45.229899 +0000][Debug  ][PostMaster        ] [ccdcacli447.in2p3.fr:30134] Recovering error for stream #0: [ERROR] Socket error.
[2025-11-16 13:31:45.229904 +0000][Debug  ][PostMaster        ] [ccdcacli447.in2p3.fr:30134] Reporting disconnection to queued message handlers.
[2025-11-16 13:31:45.229911 +0000][Debug  ][XRootD            ] [ccdcacli447.in2p3.fr:30134] Handling error while processing kXR_read (handle: 0x00000000, offset: 18651644, size: 179419272): [ERROR] Socket error.
[2025-11-16 13:31:45.229916 +0000][Error  ][XRootD            ] [ccdcacli447.in2p3.fr:30134] Unable to get the response to request kXR_read (handle: 0x00000000, offset: 18651644, size: 179419272)
[2025-11-16 13:31:45.229921 +0000][Debug  ][ExDbgMsg          ] [ccdcacli447.in2p3.fr:30134] Passing to the thread-pool MsgHandler: 0x8097080 (message: kXR_read (handle: 0x00000000, offset: 18651644, size: 179419272) ).
[2025-11-16 13:31:45.230044 +0000][Debug  ][ExDbgMsg          ] [ccdcacli447.in2p3.fr:30134] Calling MsgHandler: 0x8097080 (message: kXR_read (handle: 0x00000000, offset: 18651644, size: 179419272) ) with status: [ERROR] Socket error.
[2025-11-16 13:31:45.230072 +0000][Debug  ][File              ] [0x756ede0@root://ccxrootdegee.in2p3.fr:1094/pnfs/in2p3.fr/data/dune/disk/fardet-hd/0a/84/prodgenie_nue_dune10kt_1x2x6_20251004T021532Z_gen_005131_g4_detsim.root?xrdcl.requuid=77b25f11-598c-46b4-adf1-0711837cc209] Running the recovery procedure
[2025-11-16 13:31:45.230112 +0000][Debug  ][ExDbgMsg          ] [ccxrootdegee.in2p3.fr:1094] MsgHandler created: 0x7d43b60 (message: kXR_open (file: pnfs/in2p3.fr/data/dune/disk/fardet-hd/0a/84/prodgenie_nue_dune10kt_1x2x6_20251004T021532Z_gen_005131_g4_detsim.root, mode: 00, flags: kXR_open_read ) ).
[2025-11-16 13:31:45.230133 +0000][Debug  ][ExDbgMsg          ] [ccdcacli447.in2p3.fr:30134] Destroying MsgHandler: 0x8097080.
[2025-11-16 13:31:45.230169 +0000][Debug  ][ExDbgMsg          ] [ccxrootdegee.in2p3.fr:1094] Moving MsgHandler: 0x7d43b60 (message: kXR_open (file: pnfs/in2p3.fr/data/dune/disk/fardet-hd/0a/84/prodgenie_nue_dune10kt_1x2x6_20251004T021532Z_gen_005131_g4_detsim.root, mode: 00, flags: kXR_open_read ) ) from out-queu to in-queue.
[2025-11-16 13:31:45.516980 +0000][Debug  ][ExDbgMsg          ] [msg: 0x8091ff0] Assigned MsgHandler: 0x7d43b60.
[2025-11-16 13:31:45.517029 +0000][Debug  ][ExDbgMsg          ] [handler: 0x7d43b60] Removed MsgHandler: 0x7d43b60 from the in-queue.
[2025-11-16 13:31:45.517161 +0000][Debug  ][XRootD            ] [ccxrootdegee.in2p3.fr:1094] Handling error while processing kXR_open (file: pnfs/in2p3.fr/data/dune/disk/fardet-hd/0a/84/prodgenie_nue_dune10kt_1x2x6_20251004T021532Z_gen_005131_g4_detsim.root, mode: 00, flags: kXR_open_read ): [ERROR] Error response: bad address.
[2025-11-16 13:31:45.517242 +0000][Debug  ][ExDbgMsg          ] [ccxrootdegee.in2p3.fr:1094] Calling MsgHandler: 0x7d43b60 (message: kXR_open (file: pnfs/in2p3.fr/data/dune/disk/fardet-hd/0a/84/prodgenie_nue_dune10kt_1x2x6_20251004T021532Z_gen_005131_g4_detsim.root, mode: 00, flags: kXR_open_read ) ) with status: [ERROR] Error response: bad address.
[2025-11-16 13:31:45.517326 +0000][Debug  ][File              ] [0x756ede0@root://ccxrootdegee.in2p3.fr:1094/pnfs/in2p3.fr/data/dune/disk/fardet-hd/0a/84/prodgenie_nue_dune10kt_1x2x6_20251004T021532Z_gen_005131_g4_detsim.root?xrdcl.requuid=77b25f11-598c-46b4-adf1-0711837cc209] Open has returned with status [ERROR] Server responded with an error: [3012] Internal timeout
[2025-11-16 13:31:45.517334 +0000][Debug  ][File              ] [0x756ede0@root://ccxrootdegee.in2p3.fr:1094/pnfs/in2p3.fr/data/dune/disk/fardet-hd/0a/84/prodgenie_nue_dune10kt_1x2x6_20251004T021532Z_gen_005131_g4_detsim.root?xrdcl.requuid=77b25f11-598c-46b4-adf1-0711837cc209] Error while opening at ccxrootdegee.in2p3.fr:1094: [ERROR] Server responded with an error: [3012] Internal timeout
[2025-11-16 13:31:45.517402 +0000][Debug  ][ExDbgMsg          ] [ccxrootdegee.in2p3.fr:1094] Destroying MsgHandler: 0x7d43b60.
16-Nov-2025 13:31:45 GMT  Opened output file with pattern "prodgenie_nue_dune10kt_1x2x6_20251004T021532Z_gen_005131_g4_detsim_20251116T132505Z_reco.root"

====================================================================================================================
TimeTracker printout (sec)            Min           Avg           Max         Median          RMS         nEvts   
====================================================================================================================
[ No processed events ]
====================================================================================================================

====================================================================================================
MemoryTracker summary (base-10 MB units used)

  Peak virtual memory usage (VmPeak)  : 1399.83 MB
  Peak resident set size usage (VmHWM): 668.701 MB
  Details saved in: 'mem.db'
====================================================================================================
%MSG-s ArtException:  PostEndJob 16-Nov-2025 13:31:45 GMT ModuleEndJob
---- EventProcessorFailure BEGIN
  EventProcessor: an exception occurred during current event processing
  ---- ScheduleExecutionFailure BEGIN
    Path: ProcessingStopped.
    ---- FileReadError BEGIN
      ---- FatalRootError BEGIN
        Fatal Root Error: TNetXNGFile::ReadBuffer
        [ERROR] Server responded with an error: [3012] Internal timeout
        ROOT severity: 3000
      ---- FatalRootError END
      
      The above exception was thrown while processing module TriggerPrimitiveMakerTPC/tpmakerTPCsimpleThr run: 8528 subRun: 0 event: 51301
    ---- FileReadError END
    Exception going through path makers
  ---- ScheduleExecutionFailure END
---- EventProcessorFailure END
---- FatalRootError BEGIN
  Fatal Root Error: TNetXNGFile::TNetXNGFile
  The remote file is not open
  ROOT severity: 3000
---- FatalRootError END
---- FatalRootError BEGIN
  Fatal Root Error: TNetXNGFile::Close
  [ERROR] Server responded with an error: [3012] Internal timeout
  ROOT severity: 3000
---- FatalRootError END
---- FatalRootError BEGIN
  Fatal Root Error: TNetXNGFile::Close
  [ERROR] Server responded with an error: [3012] Internal timeout
  ROOT severity: 3000
---- FatalRootError END
%MSG
[2025-11-16 13:31:45.929768 +0000][Debug  ][JobMgr            ] Stopping the job manager...
[2025-11-16 13:31:45.930355 +0000][Debug  ][JobMgr            ] Job manager stopped
[2025-11-16 13:31:45.930440 +0000][Debug  ][TaskMgr           ] Stopping the task manager...
[2025-11-16 13:31:45.930507 +0000][Debug  ][TaskMgr           ] Task manager stopped
[2025-11-16 13:31:45.930512 +0000][Debug  ][Poller            ] Stopping the poller...
[2025-11-16 13:31:45.930718 +0000][Debug  ][AsyncSock         ] [ccdcacli447.in2p3.fr:30097.0] Closing the socket
[2025-11-16 13:31:45.930727 +0000][Debug  ][PostMaster        ] [ccdcacli447.in2p3.fr:30097] Destroying stream
[2025-11-16 13:31:45.930757 +0000][Debug  ][AsyncSock         ] [ccdcacli447.in2p3.fr:30097.0] Closing the socket
[2025-11-16 13:31:45.930790 +0000][Debug  ][AsyncSock         ] [ccdcacli447.in2p3.fr:30134.0] Closing the socket
[2025-11-16 13:31:45.930796 +0000][Debug  ][PostMaster        ] [ccdcacli447.in2p3.fr:30134] Destroying stream
[2025-11-16 13:31:45.930800 +0000][Debug  ][AsyncSock         ] [ccdcacli447.in2p3.fr:30134.0] Closing the socket
[2025-11-16 13:31:45.930808 +0000][Debug  ][AsyncSock         ] [ccdcacli447.in2p3.fr:30178.0] Closing the socket
[2025-11-16 13:31:45.930815 +0000][Debug  ][PostMaster        ] [ccdcacli447.in2p3.fr:30178] Destroying stream
[2025-11-16 13:31:45.930818 +0000][Debug  ][AsyncSock         ] [ccdcacli447.in2p3.fr:30178.0] Closing the socket
[2025-11-16 13:31:45.930828 +0000][Debug  ][AsyncSock         ] [ccdcacli447.in2p3.fr:30301.0] Closing the socket
[2025-11-16 13:31:45.930833 +0000][Debug  ][PostMaster        ] [ccdcacli447.in2p3.fr:30301] Destroying stream
[2025-11-16 13:31:45.930836 +0000][Debug  ][AsyncSock         ] [ccdcacli447.in2p3.fr:30301.0] Closing the socket
[2025-11-16 13:31:45.930846 +0000][Debug  ][AsyncSock         ] [ccdcacli447.in2p3.fr:30770.0] Closing the socket
[2025-11-16 13:31:45.930851 +0000][Debug  ][PostMaster        ] [ccdcacli447.in2p3.fr:30770] Destroying stream
[2025-11-16 13:31:45.930854 +0000][Debug  ][AsyncSock         ] [ccdcacli447.in2p3.fr:30770.0] Closing the socket
[2025-11-16 13:31:45.930862 +0000][Debug  ][AsyncSock         ] [ccdcacli447.in2p3.fr:30939.0] Closing the socket
[2025-11-16 13:31:45.930867 +0000][Debug  ][PostMaster        ] [ccdcacli447.in2p3.fr:30939] Destroying stream
[2025-11-16 13:31:45.930870 +0000][Debug  ][AsyncSock         ] [ccdcacli447.in2p3.fr:30939.0] Closing the socket
[2025-11-16 13:31:45.930878 +0000][Debug  ][AsyncSock         ] [ccxrootdegee.in2p3.fr:1094.0] Closing the socket
[2025-11-16 13:31:45.930884 +0000][Debug  ][Poller            ] <[::ffff:192.41.105.37]:39308><--><[::ffff:134.158.209.218]:1094> Removing socket from the poller
[2025-11-16 13:31:45.931022 +0000][Debug  ][PostMaster        ] [ccxrootdegee.in2p3.fr:1094] Destroying stream
[2025-11-16 13:31:45.931037 +0000][Debug  ][AsyncSock         ] [ccxrootdegee.in2p3.fr:1094.0] Closing the socket
Art has completed and will exit with status 1.
justIN time: 2025-12-19 12:23:12 UTC       justIN version: 01.05.03