Jobsub ID 256403.0@dunegpschedd02.fnal.gov

Jobsub ID	256403.0@dunegpschedd02.fnal.gov
Workflow ID	10925
Stage ID	1
User name	higuera@fnal.gov
HTCondor Group	group_dune.prod_mcsim
Requested	Processors	1
	GPU	No
	RSS bytes	9437184000 (9000 MiB)
	Wall seconds limit	80000 (22 hours)
Submitted time	2025-12-02 15:20:07
Site	NL_SURFsara
Entry	DUNE_SurfSARA_arc01
Last heartbeat	2025-12-02 16:19:16
From worker node	Hostname	wn-la-18.gina.surf.nl
	cpuinfo	AMD EPYC 9754 128-Core Processor
	OS release	Scientific Linux release 7.9 (Nitrogen)
	Processors	1
	RSS bytes	10485760000 (10000 MiB)
	Wall seconds limit	129600 (36 hours)
	GPU
	Inner Apptainer?	True
Job state	jobscript_error
Started	2025-12-02 15:21:42
Input files	hd-protodune:pdhd_prod_beam__238986_72_1_20251106T221507Z_gen_g4_IonScintPDExt.root_250499_127_1_20251124T141726Z_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-02 16:19:16
Saved logs	justin-logs:256403.0-dunegpschedd02.fnal.gov.logs.tgz
List job events Cached HTCondor job logs
Jobscript log (last 10,000 characters)

0 1 2 3 5 6 7 8 9 10 11 12 13 15 16 17 18 19 20 21 22 23 25 26 27 28 29 30 31 32 33 35 36 37 38 39 41 43 44 48 51 53 54 58 61 63 64 68 71 73 74 78 80 81 82 83 88 89 90 91 92 93 98 99 100 101 102 103 108 109 110 111 112 113 118 119 122 123 126 128 132 133 136 138 142 143 146 148 152 153 156 158 
Inputer: "wclsSimDepoSource:"
Outputer: "wclsSimChannelSink:postdrift"
Outputer: "wclsFrameSaver:simdigits"
wclsFrameSaver: promising to produce raw::RawDigits named "daq"
02-Dec-2025 16:22:36 CET  Initiating request to open input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/hd-protodune/0d/69/pdhd_prod_beam__238986_72_1_20251106T221507Z_gen_g4_IonScintPDExt.root_250499_127_1_20251124T141726Z_PDInt.root"
%MSG-i Root_Information:  TriggerResultInserter:TriggerResults@Construction  TClass::Init() 02-Dec-2025 16:22:42 CET ModuleConstruction
no dictionary for class sim::IDE is available
ROOT severity: 2000
%MSG
02-Dec-2025 16:22:42 CET  Opened input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/hd-protodune/0d/69/pdhd_prod_beam__238986_72_1_20251106T221507Z_gen_g4_IonScintPDExt.root_250499_127_1_20251124T141726Z_PDInt.root"
Begin processing the 1st record. run: 20250623 subRun: 1 event: 30 at 02-Dec-2025 16:22:52 CET
%MSG-w PhotonBackTrackerService:  ProcessEvent 02-Dec-2025 16:23:00 CET  run: 20250623 subRun: 1 event: 30
Rebuild failed to get the OpDetBTRs. This is expected when running on a generation or simulation step.
%MSG
SimDepoSource got 895087 depos from art tag "InputTag: label = 'IonAndScint', instance = ''" returns: okay
Larwirecell::SimDepoSource got 895087 associated depos from InputTag: label = 'IonAndScint', instance = 'priorSCE'
SimDepoSource: ready with 895087 depos spanning: [-3211.27, 3031.85]us
Retagger: tagging trace set: daq with 10240 traces, 0 summary
wclsFrameSaver: saving raw::RawDigits tagged "daq"
02-Dec-2025 16:31:23 CET  Opened output file with pattern "temp_detsim.root"
%MSG-i FastCloning:  PostProcessEvent 02-Dec-2025 16:31:24 CET  run: 20250623 subRun: 1 event: 30
Fast cloning event data products from input file.
%MSG
Begin processing the 2nd record. run: 20250623 subRun: 1 event: 31 at 02-Dec-2025 16:34:57 CET
%MSG-w PhotonBackTrackerService:  ProcessEvent 02-Dec-2025 16:35:05 CET  run: 20250623 subRun: 1 event: 31
Rebuild failed to get the OpDetBTRs. This is expected when running on a generation or simulation step.
%MSG
SimDepoSource got 1376424 depos from art tag "InputTag: label = 'IonAndScint', instance = ''" returns: okay
Larwirecell::SimDepoSource got 1376424 associated depos from InputTag: label = 'IonAndScint', instance = 'priorSCE'
SimDepoSource: ready with 1376424 depos spanning: [-3223.6, 3104.58]us
Retagger: tagging trace set: daq with 10240 traces, 0 summary
wclsFrameSaver: saving raw::RawDigits tagged "daq"
Begin processing the 3rd record. run: 20250623 subRun: 1 event: 32 at 02-Dec-2025 16:46:37 CET
%MSG-w PhotonBackTrackerService:  ProcessEvent 02-Dec-2025 16:46:46 CET  run: 20250623 subRun: 1 event: 32
Rebuild failed to get the OpDetBTRs. This is expected when running on a generation or simulation step.
%MSG
SimDepoSource got 1100822 depos from art tag "InputTag: label = 'IonAndScint', instance = ''" returns: okay
Larwirecell::SimDepoSource got 1100822 associated depos from InputTag: label = 'IonAndScint', instance = 'priorSCE'
SimDepoSource: ready with 1100822 depos spanning: [-3283.27, 3095.98]us
Retagger: tagging trace set: daq with 10240 traces, 0 summary
wclsFrameSaver: saving raw::RawDigits tagged "daq"
Begin processing the 4th record. run: 20250623 subRun: 1 event: 33 at 02-Dec-2025 16:55:50 CET
%MSG-w PhotonBackTrackerService:  ProcessEvent 02-Dec-2025 16:55:59 CET  run: 20250623 subRun: 1 event: 33
Rebuild failed to get the OpDetBTRs. This is expected when running on a generation or simulation step.
%MSG
SimDepoSource got 1189028 depos from art tag "InputTag: label = 'IonAndScint', instance = ''" returns: okay
Larwirecell::SimDepoSource got 1189028 associated depos from InputTag: label = 'IonAndScint', instance = 'priorSCE'
SimDepoSource: ready with 1189028 depos spanning: [-3314.84, 3094.01]us
Retagger: tagging trace set: daq with 10240 traces, 0 summary
wclsFrameSaver: saving raw::RawDigits tagged "daq"
Begin processing the 5th record. run: 20250623 subRun: 1 event: 34 at 02-Dec-2025 17:05:58 CET
R__unzip: error -5 in inflate (zlib)
%MSG-w ParticleInventory:  ProcessEvent 02-Dec-2025 17:06:03 CET  run: 20250623 subRun: 1 event: 34
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 02-Dec-2025 17:06:06 CET  run: 20250623 subRun: 1 event: 34
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 02-Dec-2025 17:06:10 CET  run: 20250623 subRun: 1 event: 34
Rebuild failed to get the MCParticles. This is expected when running on a generation or simulation step.
%MSG
%MSG-w PhotonBackTrackerService:  ProcessEvent 02-Dec-2025 17:06:10 CET  run: 20250623 subRun: 1 event: 34
Rebuild failed to get the OpDetBTRs. This is expected when running on a generation or simulation step.
%MSG
SimDepoSource got 1359706 depos from art tag "InputTag: label = 'IonAndScint', instance = ''" returns: okay
Larwirecell::SimDepoSource got 1359706 associated depos from InputTag: label = 'IonAndScint', instance = 'priorSCE'
SimDepoSource: ready with 1359706 depos spanning: [-3239.84, 2993.5]us
Retagger: tagging trace set: daq with 10240 traces, 0 summary
wclsFrameSaver: saving raw::RawDigits tagged "daq"
R__unzip: error -5 in inflate (zlib)
02-Dec-2025 17:18:33 CET  Closed input file "root://fndcadoor.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/hd-protodune/0d/69/pdhd_prod_beam__238986_72_1_20251106T221507Z_gen_g4_IonScintPDExt.root_250499_127_1_20251124T141726Z_PDInt.root"

================================================================================================================================
TimeTracker printout (sec)                        Min           Avg           Max         Median          RMS         nEvts   
================================================================================================================================
Full event                                     0.0146783      467.981       691.224       543.587       242.019         5     
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                        0.00923626     0.0290367     0.0984073     0.0114352     0.0347288        5     
simulate:rns:RandomNumberSaver                5.7895e-05    0.000141951   0.000333147   8.8962e-05    0.000100529       5     
simulate:tpcrawdecoder:WireCellToolkit          477.503       574.266       696.727       552.882       83.5823         5     
simulate:opdigi:OpDetDigitizerProtoDUNEHD       25.4255       37.3731       43.0026       39.4873       6.20142         5     
simulate:crt:CRTSimRefac                       0.0625008     0.0765777     0.0889353     0.0774374    0.00953937        4     
[art]:TriggerResults:TriggerResultInserter    3.0856e-05    4.78685e-05   8.5137e-05    3.77405e-05   2.19977e-05       4     
end_path:out1:RootOutput                       5.478e-06    1.0991e-05    2.5166e-05     6.66e-06     8.23057e-06       4     
end_path:out1:RootOutput(write)                 4.3213        4.55799       4.74879       4.58094       0.17263         4     
================================================================================================================================
%MSG-i NuRandomService:  RootOutput:out1@EndJob 02-Dec-2025 17:18:33 CET  ModuleEndJob

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

%MSG

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

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

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

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

TimeReport ---------- Time summary [sec] -------
TimeReport CPU = 2995.458794 Real = 3348.487359

MemReport  ---------- Memory summary [base-10 MB] ------
MemReport  VmPeak = 9646.37 VmHWM = 7934.95

%MSG-s ArtException:  PostEndJob 02-Dec-2025 17:18:34 CET 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 = 84994177, fKeylen = 109, fObjlen = 362906890, noutot = 184549365, nout=0, nin=5625496, nbuf=16777215
        ROOT severity: 3000
      ---- FatalRootError END
      
      The above exception was thrown while processing module CRTSimRefac/crt run: 20250623 subRun: 1 event: 34
    ---- 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 4 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