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

Jobsub ID	108728.1@justin-prod-sched02.dune.hep.ac.uk
Workflow ID	4213
Stage ID	1
User name	ismerio@fnal.gov
HTCondor Group	group_dune
Requested	Processors	1
	RSS bytes	4194304000 (4000 MiB)
	Wall seconds limit	80000 (22 hours)
Submitted time	2024-11-23 04:01:57
Site	UK_Imperial
Entry	DUNE_T2_UK_London_IC_ceprod00
Last heartbeat	2024-11-23 04:11:34
From worker node	Hostname	wm04.grid.hep.ph.ic.ac.uk
	cpuinfo	AMD EPYC 7742 64-Core Processor
	OS release	Scientific Linux release 7.9 (Nitrogen)
	Processors	1
	RSS bytes	4194304000 (4000 MiB)
	Wall seconds limit	171000 (47 hours)
	Inner Apptainer?	True
Job state	outputting_failed
Allocator name	justin-allocator-pro.dune.hep.ac.uk
Started	2024-11-23 04:03:11
Input files	fardet-hd:atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6207207_162_20231120T132911Z_gen_g4_detsim_hitreco__20240503T061710Z_reco2.root
Jobscript	Exit code	0
	Real time	8m (486s)
	CPU time	1m (104s = 21%)
Outputting started	2024-11-23 04:11:17
Output files
Finished	2024-11-23 04:11:34
List job events Wrapper job log
Jobscript log (last 10,000 characters)

PMAlgTrajFitter:pmtrajfittc@BeginModule  23-Nov-2024 04:10:31 GMT run: 6207207 subRun: 1 event: 32402
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrajFitter:pmtrajfittc@BeginModule  23-Nov-2024 04:10:31 GMT run: 6207207 subRun: 1 event: 32402
1st wire C:0 T:8 P:2 W:642 does not exist (max wire number: 480)
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrajFitter:pmtrajfittc@BeginModule  23-Nov-2024 04:10:31 GMT run: 6207207 subRun: 1 event: 32402
1st wire C:0 T:8 P:2 W:591 does not exist (max wire number: 480)
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrajFitter:pmtrajfittc@BeginModule  23-Nov-2024 04:10:31 GMT run: 6207207 subRun: 1 event: 32402
Comparing two wires in the same plane: return failure
%MSG
Boundary wire vector sizes: 1250, 1288, 923
minwire 0: 1261
minwire 1: 1639
minwire 2: 1045
Used alternate method to get min and max tdcs due to vertex determination failure: 0, 199
Used alternate method to get min and max tdcs due to vertex determination failure: 0, 199
Used alternate method to get min and max tdcs due to vertex determination failure: 0, 199
Could not find serving_default in model signatures.
[libprotobuf FATAL /cvmfs/larsoft.opensciencegrid.org/products/protobuf/v3_21_12a/Linux64bit+3.10-2.17-e26/include/google/protobuf/map.h:1300] CHECK failed: it != end(): key not found: serving_default
23-Nov-2024 04:11:16 GMT  Closed input file "root://xrootd.echo.stfc.ac.uk:1094/dune:/protodune/RSE/fardet-hd/0a/28/atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6207207_162_20231120T132911Z_gen_g4_detsim_hitreco__20240503T061710Z_reco2.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                            0.00895784      109.804        219.6        109.804       109.795         2     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.00895784     0.0358778     0.0627978     0.0358778      0.02692         2     
reco:linecluster:LineCluster                           0.157417      0.283196      0.408974      0.283196      0.125778         2     
reco:trajcluster:TrajCluster                           0.0290567     0.486541      0.944025      0.486541      0.457484         2     
reco:pandora:StandardPandora                           0.893919       109.531       218.168       109.531       108.637         2     
reco:pandoraTrack:LArPandoraTrackCreation             0.000186323   0.00142029    0.00265426    0.00142029    0.00123397        2     
reco:pandoraShower:LArPandoraModularShowerCreation    0.000178087   0.00213975    0.00410141    0.00213975    0.00196166        2     
reco:pandoracalo:Calorimetry                          0.00011073    0.000842303   0.00157388    0.000842303   0.000731573       2     
reco:pandorapid:Chi2ParticleID                        3.9544e-05    0.000385999   0.000732455   0.000385999   0.000346456       2     
reco:trkshowersplit:TrackShowerHits                   0.000668234    0.0142903     0.0279124     0.0142903     0.0136221        2     
reco:pmtrack:PMAlgTrackMaker                           0.447881       1.56485       2.68182       1.56485       1.11697         2     
reco:pmtrackcalo:Calorimetry                          0.000129114   0.00560212     0.0110751    0.00560212     0.005473         2     
reco:pmtrackpid:Chi2ParticleID                        3.8623e-05    0.000599159    0.0011597    0.000599159   0.000560536       2     
reco:pmtrajfit:PMAlgTrajFitter                        0.000462616   0.000925321   0.00138802    0.000925321   0.000462704       2     
reco:pmtrajfitcalo:Calorimetry                        7.0834e-05    7.5002e-05     7.917e-05    7.5002e-05     4.168e-06        2     
reco:pmtrajfitpid:Chi2ParticleID                      2.9366e-05    3.3759e-05    3.8152e-05    3.3759e-05     4.393e-06        2     
reco:pmtracktc:PMAlgTrackMaker                        0.00124284      1.63932       3.2774        1.63932       1.63808         2     
reco:pmtracktccalo:Calorimetry                         6.88e-05     0.00218381    0.00429882    0.00218381    0.00211501        2     
reco:pmtracktcpid:Chi2ParticleID                      2.8134e-05    0.000201546   0.000374959   0.000201546   0.000173412       2     
reco:pmtrajfittc:PMAlgTrajFitter                      0.000167226     1.21501       2.42984       1.21501       1.21484         2     
reco:pmtrajfittccalo:Calorimetry                       6.338e-05    0.00864965     0.0172359    0.00864965    0.00858627        2     
reco:pmtrajfittcpid:Chi2ParticleID                    7.6754e-05    0.000403494   0.000730233   0.000403494   0.000326739       2     
reco:blurredcluster:BlurredClustering                 0.000452996    0.372969      0.745485      0.372969      0.372516         2     
reco:emtrkmichelid:EmTrackMichelId                    0.00132512      12.2974       24.5936       12.2974       12.2961         2     
reco:emshower:EMShower                                0.00227457    0.00249456    0.00271456    0.00249456    0.000219999       2     
reco:cvnmap:CVNMapper                                 0.000215117    0.0156057     0.0309963     0.0156057     0.0153906        2     
reco:cvneva:CVNEvaluator                              0.000316609   0.000316609   0.000316609   0.000316609        0            1     
reco:energyrecnumu:EnergyReco                         0.00446868    0.00446868    0.00446868    0.00446868         0            1     
reco:energyrecnue:EnergyReco                          0.00257565    0.00257565    0.00257565    0.00257565         0            1     
reco:energyrecnc:EnergyReco                           0.00247843    0.00247843    0.00247843    0.00247843         0            1     
reco:energyrecnumurange:EnergyReco                    0.00229079    0.00229079    0.00229079    0.00229079         0            1     
reco:energyrecnumumcs:EnergyReco                       0.0023055     0.0023055     0.0023055     0.0023055         0            1     
reco:opdec:Deconvolution                               0.180877      0.180877      0.180877      0.180877          0            1     
reco:ophitspe:OpHitFinderDeco                           0.48393       0.48393       0.48393       0.48393          0            1     
reco:opflash:OpFlashFinder                            0.00312735    0.00312735    0.00312735    0.00312735         0            1     
reco:rns:RandomNumberSaver                            0.000380128   0.000380128   0.000380128   0.000380128        0            1     
reco:anglereconue:NuAngularReco                       0.000804762   0.000804762   0.000804762   0.000804762        0            1     
reco:anglereconumu:NuAngularReco                      0.000166074   0.000166074   0.000166074   0.000166074        0            1     
reco:anglereconuepfps:NuAngularReco                   0.00110787    0.00110787    0.00110787    0.00110787         0            1     
reco:anglereconumupfps:NuAngularReco                  0.000168739   0.000168739   0.000168739   0.000168739        0            1     
[art]:TriggerResults:TriggerResultInserter            4.5115e-05    4.5115e-05    4.5115e-05    4.5115e-05         0            1     
end_path:out1:RootOutput                              1.3726e-05    1.3726e-05    1.3726e-05    1.3726e-05         0            1     
end_path:out1:RootOutput(write)                        0.0294327     0.0294327     0.0294327     0.0294327         0            1     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 37158.1 MB
  Peak resident set size usage (VmHWM): 1210.67 MB
====================================================================================================
%MSG-s ArtException:  PostEndJob 23-Nov-2024 04:11:16 GMT ModuleEndJob
---- EventProcessorFailure BEGIN
  EventProcessor: an exception occurred during current event processing
  ---- ScheduleExecutionFailure BEGIN
    Path: ProcessingStopped.
    ---- StdException BEGIN
      An exception was thrown while processing module CVNEvaluator/cvneva run: 6207207 subRun: 1 event: 32402
      CHECK failed: it != end(): key not found: serving_default
    ---- StdException END
    Exception going through path reco
  ---- ScheduleExecutionFailure END
---- EventProcessorFailure END
---- FatalRootError BEGIN
  Fatal Root Error: TTree::SetEntries
  Tree branches have different numbers of entries, eg EventAuxiliary has 1 entries while sim::OpDetDivRecs_opdigi__detsim. has 200 entries.
  ROOT severity: 2000
---- FatalRootError END
%MSG
Art has completed and will exit with status 1.
=== End last 100 lines of lar log file ===
RootOutput-b6d4-20ef-6f6a-cc57.root
Validation_ccnc_atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6207207_162_20231120T132911Z_gen_g4_detsim_hitreco__20240503T061710Z_reco2.root
all-input-dids.txt
atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6207207_162_20231120T132911Z_gen_g4_detsim_hitreco__20240503T061710Z_reco2_reco_2024-11-23T_040314Z.log
debugprod.log
jobscript.log
justin-processed-pfns.txt
reco2_hist.root
MyPandoraSettings_Master_Atmos_DUNEFD.xml
MyPandoraSettings_Master_DUNEFD.xml
build_slf7.x86_64
localProducts_larsoft_v09_91_02_e26_prof
setup_env-testreco.sh
srcs
temp.txt
temp2.txt
test
work