Jobsub ID 259349.1@dunegpschedd02.fnal.gov

Jobsub ID	259349.1@dunegpschedd02.fnal.gov
Workflow ID	11103
Stage ID	1
User name	avizcaya@fnal.gov
Requested	Processors	1
	GPU	No
	RSS bytes	9437184000 (9000 MiB)
	Wall seconds limit	80000 (22 hours)
Submitted time	2025-12-09 04:35:19
Site	US_FNAL-FermiGrid
Entry	FNAL_GPGrid_ce03_mcore_op_duneonly
Last heartbeat	2025-12-09 05:18:05
From worker node	Hostname	dunegli-7860545-0-fnpc23052.fnal.gov
	cpuinfo	AMD EPYC 7543 32-Core Processor
	OS release	Scientific Linux release 7.9 (Nitrogen)
	Processors	1
	RSS bytes	10485760000 (10000 MiB)
	Wall seconds limit	172800 (48 hours)
	GPU
	Inner Apptainer?	True
Job state	jobscript_error
Started	2025-12-09 04:37:34
Input files	usertests:pdhd_prod_beam__241846_7_1_20251112T031313Z_gen_g4_IonScintPDExt.root_263961_70_1_20251205T175333Z_PDInt.root
Jobscript	Exit code	1
	Real time	0m (0s)
	CPU time	0m (0s = 0%)
	Max RSS bytes	0 (0 MiB)
Outputting started
Output files
Finished	2025-12-09 05:18:05
Saved logs	justin-logs:259349.1-dunegpschedd02.fnal.gov.logs.tgz
List job events Cached HTCondor job logs
Jobscript log (last 10,000 characters)

5T175333Z_PDInt.root"
%MSG-i Root_Information:  TriggerResultInserter:TriggerResults@Construction  TClass::Init() 09-Dec-2025 04:38:44 UTC ModuleConstruction
no dictionary for class sim::IDE is available
ROOT severity: 2000
%MSG
09-Dec-2025 04:38:44 UTC  Opened input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/usertests/c6/01/pdhd_prod_beam__241846_7_1_20251112T031313Z_gen_g4_IonScintPDExt.root_263961_70_1_20251205T175333Z_PDInt.root"
Begin processing the 1st record. run: 20250627 subRun: 1 event: 100 at 09-Dec-2025 04:38:44 UTC
%MSG-w PhotonBackTrackerService:  ProcessEvent 09-Dec-2025 04:38:50 UTC  run: 20250627 subRun: 1 event: 100
Rebuild failed to get the OpDetBTRs. This is expected when running on a generation or simulation step.
%MSG
SimDepoSource got 957483 depos from art tag "InputTag: label = 'IonAndScint', instance = ''" returns: okay
Larwirecell::SimDepoSource got 957483 associated depos from InputTag: label = 'IonAndScint', instance = 'priorSCE'
SimDepoSource: ready with 957483 depos spanning: [-3249.35, 2992.23]us
Retagger: tagging trace set: daq with 10240 traces, 0 summary
wclsFrameSaver: saving raw::RawDigits tagged "daq"
09-Dec-2025 04:43:47 UTC  Opened output file with pattern "temp_detsim.root"
%MSG-i FastCloning:  PostProcessEvent 09-Dec-2025 04:43:47 UTC  run: 20250627 subRun: 1 event: 100
Fast cloning event data products from input file.
%MSG
Begin processing the 2nd record. run: 20250627 subRun: 1 event: 101 at 09-Dec-2025 04:44:17 UTC
%MSG-w PhotonBackTrackerService:  ProcessEvent 09-Dec-2025 04:44:21 UTC  run: 20250627 subRun: 1 event: 101
Rebuild failed to get the OpDetBTRs. This is expected when running on a generation or simulation step.
%MSG
SimDepoSource got 1133050 depos from art tag "InputTag: label = 'IonAndScint', instance = ''" returns: okay
Larwirecell::SimDepoSource got 1133050 associated depos from InputTag: label = 'IonAndScint', instance = 'priorSCE'
SimDepoSource: ready with 1133050 depos spanning: [-3312.46, 3004.45]us
Retagger: tagging trace set: daq with 10240 traces, 0 summary
wclsFrameSaver: saving raw::RawDigits tagged "daq"
Begin processing the 3rd record. run: 20250627 subRun: 1 event: 102 at 09-Dec-2025 04:51:26 UTC
%MSG-w PhotonBackTrackerService:  ProcessEvent 09-Dec-2025 04:51:31 UTC  run: 20250627 subRun: 1 event: 102
Rebuild failed to get the OpDetBTRs. This is expected when running on a generation or simulation step.
%MSG
SimDepoSource got 849880 depos from art tag "InputTag: label = 'IonAndScint', instance = ''" returns: okay
Larwirecell::SimDepoSource got 849880 associated depos from InputTag: label = 'IonAndScint', instance = 'priorSCE'
SimDepoSource: ready with 849880 depos spanning: [-3317.62, 3060.65]us
Retagger: tagging trace set: daq with 10240 traces, 0 summary
wclsFrameSaver: saving raw::RawDigits tagged "daq"
Begin processing the 4th record. run: 20250627 subRun: 1 event: 103 at 09-Dec-2025 04:56:43 UTC
%MSG-w PhotonBackTrackerService:  ProcessEvent 09-Dec-2025 04:56:47 UTC  run: 20250627 subRun: 1 event: 103
Rebuild failed to get the OpDetBTRs. This is expected when running on a generation or simulation step.
%MSG
SimDepoSource got 1134305 depos from art tag "InputTag: label = 'IonAndScint', instance = ''" returns: okay
Larwirecell::SimDepoSource got 1134305 associated depos from InputTag: label = 'IonAndScint', instance = 'priorSCE'
SimDepoSource: ready with 1134305 depos spanning: [-3289.48, 3097.2]us
Retagger: tagging trace set: daq with 10240 traces, 0 summary
wclsFrameSaver: saving raw::RawDigits tagged "daq"
Begin processing the 5th record. run: 20250627 subRun: 1 event: 104 at 09-Dec-2025 05:02:47 UTC
%MSG-w PhotonBackTrackerService:  ProcessEvent 09-Dec-2025 05:02:52 UTC  run: 20250627 subRun: 1 event: 104
Rebuild failed to get the OpDetBTRs. This is expected when running on a generation or simulation step.
%MSG
SimDepoSource got 1527194 depos from art tag "InputTag: label = 'IonAndScint', instance = ''" returns: okay
Larwirecell::SimDepoSource got 1527194 associated depos from InputTag: label = 'IonAndScint', instance = 'priorSCE'
SimDepoSource: ready with 1527194 depos spanning: [-3314.17, 3093.4]us
Retagger: tagging trace set: daq with 10240 traces, 0 summary
wclsFrameSaver: saving raw::RawDigits tagged "daq"
Begin processing the 6th record. run: 20250627 subRun: 1 event: 105 at 09-Dec-2025 05:11:18 UTC
R__unzip: error -5 in inflate (zlib)
%MSG-w ParticleInventory:  ProcessEvent 09-Dec-2025 05:11:19 UTC  run: 20250627 subRun: 1 event: 105
Rebuild failed to get the MCParticles. This is expected when running on a generation or simulation step.
%MSG
R__unzip: error -5 in inflate (zlib)
%MSG-w ParticleInventory:  ProcessEvent 09-Dec-2025 05:11:20 UTC  run: 20250627 subRun: 1 event: 105
Rebuild failed to get the MCParticles. This is expected when running on a generation or simulation step.
%MSG
R__unzip: error -5 in inflate (zlib)
%MSG-w ParticleInventory:  ProcessEvent 09-Dec-2025 05:11:20 UTC  run: 20250627 subRun: 1 event: 105
Rebuild failed to get the MCParticles. This is expected when running on a generation or simulation step.
%MSG
%MSG-w PhotonBackTrackerService:  ProcessEvent 09-Dec-2025 05:11:20 UTC  run: 20250627 subRun: 1 event: 105
Rebuild failed to get the OpDetBTRs. This is expected when running on a generation or simulation step.
%MSG
SimDepoSource got 1139072 depos from art tag "InputTag: label = 'IonAndScint', instance = ''" returns: okay
Larwirecell::SimDepoSource got 1139072 associated depos from InputTag: label = 'IonAndScint', instance = 'priorSCE'
SimDepoSource: ready with 1139072 depos spanning: [-3192.4, 3065]us
Retagger: tagging trace set: daq with 10240 traces, 0 summary
wclsFrameSaver: saving raw::RawDigits tagged "daq"
R__unzip: error -5 in inflate (zlib)
09-Dec-2025 05:17:34 UTC  Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/usertests/c6/01/pdhd_prod_beam__241846_7_1_20251112T031313Z_gen_g4_IonScintPDExt.root_263961_70_1_20251205T175333Z_PDInt.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                    0.00888845      315.95        503.994       334.848       157.358         6     
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.00310553    0.00778526    0.00888845    0.00866241    0.00209602        6     
simulate:rns:RandomNumberSaver                8.8459e-05    0.000215991   0.000734686   0.000123171   0.000232349       6     
simulate:tpcrawdecoder:WireCellToolkit          282.291       360.621       476.853       351.67        65.5754         6     
simulate:opdigi:OpDetDigitizerProtoDUNEHD       9.65798       14.1626       22.5891       13.392        4.06452         6     
simulate:crt:CRTSimRefac                       0.0860761     0.146997      0.196031      0.164644      0.0386453        5     
[art]:TriggerResults:TriggerResultInserter    6.0326e-05     9.93e-05     0.000232405   6.9894e-05    6.67534e-05       5     
end_path:out1:RootOutput                      1.1973e-05    2.55734e-05   6.4574e-05     1.538e-05    1.99068e-05       5     
end_path:out1:RootOutput(write)                 3.02461       3.51568       4.05394       3.38219      0.383495         5     
================================================================================================================================
%MSG-i NuRandomService:  RootOutput:out1@EndJob 09-Dec-2025 05:17:34 UTC  ModuleEndJob

Summary of seeds computed by the NuRandomService
Random policy: 'random'
  master seed: 883082231
  seed within: [ 1 ; 900000000 ]

%MSG

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

  Peak virtual memory usage (VmPeak)  : 9491.12 MB
  Peak resident set size usage (VmHWM): 7784.2 MB
  Details saved in: 'mem.db'
====================================================================================================

TrigReport ---------- Event summary -------------
TrigReport Events total = 6 passed = 5 failed = 1

TrigReport ---------- Modules in End-path ----------
TrigReport        Run    Success      Error Name
TrigReport          5          5          0 out1

TimeReport ---------- Time summary [sec] -------
TimeReport CPU = 2191.366258 Real = 2329.565321

MemReport  ---------- Memory summary [base-10 MB] ------
MemReport  VmPeak = 9491.12 VmHWM = 7784.2

%MSG-s ArtException:  PostEndJob 09-Dec-2025 05:17:35 UTC ModuleEndJob
---- EventProcessorFailure BEGIN
  EventProcessor: an exception occurred during current event processing
  ---- ScheduleExecutionFailure BEGIN
    Path: ProcessingStopped.
    ---- FileReadError BEGIN
      ---- FatalRootError BEGIN
        Fatal Root Error: TBasket::ReadBasketBuffers
        fNbytes = 79073608, fKeylen = 109, fObjlen = 332007173, noutot = 83886075, nout=0, nin=5616535, nbuf=16777215
        ROOT severity: 3000
      ---- FatalRootError END
      
      The above exception was thrown while processing module CRTSimRefac/crt run: 20250627 subRun: 1 event: 105
    ---- FileReadError END
    Exception going through path simulate
  ---- ScheduleExecutionFailure END
---- EventProcessorFailure END
---- FatalRootError BEGIN
  Fatal Root Error: TTree::SetEntries
  Tree branches have different numbers of entries, eg EventAuxiliary has 5 entries while art::RNGsnapshots_rns__IonScintPDExt. has 10 entries.
  ROOT severity: 2000
---- FatalRootError END
%MSG
Art has completed and will exit with status 1.
Detsim returns 1