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

Jobsub ID	108681.30@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 02:01:14
Site	UK_Imperial
Entry	DUNE_T2_UK_London_IC_ceprod02
Last heartbeat	2024-11-23 02:29:03
From worker node	Hostname	wg15.grid.hep.ph.ic.ac.uk
	cpuinfo	Intel(R) Xeon(R) CPU X5650 @ 2.67GHz
	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 02:18:57
Input files	fardet-hd:atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6483936_241_20231207T083633Z_gen_g4_detsim_hitreco__20240510T035347Z_reco2.root
Jobscript	Exit code	0
	Real time	9m (584s)
	CPU time	2m (169s = 28%)
Outputting started	2024-11-23 02:28:42
Output files
Finished	2024-11-23 02:29:03
List job events Wrapper job log
Jobscript log (last 10,000 characters)

e pma::Track3D:  PMAlgTrajFitter:pmtrajfittc@BeginModule  23-Nov-2024 02:27:54 GMT run: 6483936 subRun: 1 event: 24104
Track empty.
%MSG
%MSG-e pma::Track3D:  PMAlgTrajFitter:pmtrajfittc@BeginModule  23-Nov-2024 02:27:54 GMT run: 6483936 subRun: 1 event: 24104
TuneFullTree failed.
%MSG
%MSG-e pma::Track3D:  PMAlgTrajFitter:pmtrajfittc@BeginModule  23-Nov-2024 02:27:55 GMT run: 6483936 subRun: 1 event: 24104
0 enabled hits in AverageDist2 calculation.
%MSG
%MSG-e pma::Track3D:  PMAlgTrajFitter:pmtrajfittc@BeginModule  23-Nov-2024 02:27:55 GMT run: 6483936 subRun: 1 event: 24104
Track empty.
%MSG
%MSG-e pma::Track3D:  PMAlgTrajFitter:pmtrajfittc@BeginModule  23-Nov-2024 02:27:55 GMT run: 6483936 subRun: 1 event: 24104
TuneFullTree failed.
%MSG
Boundary wire vector sizes: 441, 273, 370
minwire 0: 2184
minwire 1: 250
minwire 2: 2372
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 02:28:40 GMT  Closed input file "root://dune.dcache.nikhef.nl:1094/pnfs/nikhef.nl/data/dune/generic/rucio/fardet-hd/a2/64/atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6483936_241_20231207T083633Z_gen_g4_detsim_hitreco__20240510T035347Z_reco2.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                            0.00789654      62.2002       241.141       3.82583       103.324         4     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.00761005    0.00950657     0.014146     0.00813512    0.00269243        4     
reco:linecluster:LineCluster                           0.0822376     0.118649      0.166722      0.112817      0.0366091        4     
reco:trajcluster:TrajCluster                           0.021976      0.0822912     0.246211      0.0304888     0.0948874        4     
reco:pandora:StandardPandora                           0.0440128      59.5248       237.719      0.168188       102.88          4     
reco:pandoraTrack:LArPandoraTrackCreation             0.00024485    0.00104318    0.00336834    0.000279762   0.00134263        4     
reco:pandoraShower:LArPandoraModularShowerCreation    0.000311628   0.00145987    0.00465361    0.00043712    0.00184523        4     
reco:pandoracalo:Calorimetry                          0.000187136   0.000665129    0.0019965    0.000238436   0.00076926        4     
reco:pandorapid:Chi2ParticleID                        8.3841e-05    0.000348401   0.00109981    0.000104977   0.000433914       4     
reco:trkshowersplit:TrackShowerHits                   0.000258066   0.00269645    0.00709455     0.0017166    0.00278324        4     
reco:pmtrack:PMAlgTrackMaker                          0.00292031     0.450719       1.75612      0.0219171     0.753819         4     
reco:pmtrackcalo:Calorimetry                          0.000163573   0.00254263    0.00599359    0.00200669     0.0024304        4     
reco:pmtrackpid:Chi2ParticleID                        7.0552e-05    0.000514052   0.00122799    0.000378831   0.000470001       4     
reco:pmtrajfit:PMAlgTrajFitter                        0.000436933   0.00111731    0.00279843    0.00061695    0.000973373       4     
reco:pmtrajfitcalo:Calorimetry                        0.00015238    0.000173286   0.000196423   0.000172171   1.92968e-05       4     
reco:pmtrajfitpid:Chi2ParticleID                      6.6545e-05    7.0882e-05    7.6938e-05    7.00225e-05   4.44934e-06       4     
reco:pmtracktc:PMAlgTrackMaker                        0.00374728      0.57205       2.17985      0.0523004     0.929109         4     
reco:pmtracktccalo:Calorimetry                        0.000257012   0.00257031    0.00941774    0.000303249   0.00395346        4     
reco:pmtracktcpid:Chi2ParticleID                      8.3941e-05    0.000265283   0.000768924   0.000104133   0.000290933       4     
reco:pmtrajfittc:PMAlgTrajFitter                       0.0253023     0.668851       2.47722      0.0864419      1.04437         4     
reco:pmtrajfittccalo:Calorimetry                      0.000413129   0.00334385     0.011752     0.000605153   0.00485599        4     
reco:pmtrajfittcpid:Chi2ParticleID                    0.000134767   0.000335985   0.00089702    0.000156077   0.00032411        4     
reco:blurredcluster:BlurredClustering                  0.0311456     0.421851       1.30336      0.176447      0.512713         4     
reco:emtrkmichelid:EmTrackMichelId                     0.506627       5.4663        18.9351       1.21176       7.7829          4     
reco:emshower:EMShower                                0.000566683   0.00195032    0.00491681     0.0011589    0.00173072        4     
reco:cvnmap:CVNMapper                                 6.5317e-05     0.0142222     0.056373     0.000225251    0.024336         4     
reco:cvneva:CVNEvaluator                              4.0119e-05    0.000163172   0.000380195   6.9202e-05    0.000153917       3     
reco:energyrecnumu:EnergyReco                         0.00414629    0.00572552    0.00789597    0.00513432    0.00158686        3     
reco:energyrecnue:EnergyReco                           0.0039367    0.00414507    0.00451057    0.00398795    0.000259291       3     
reco:energyrecnc:EnergyReco                           0.00386344    0.00409709    0.00442634    0.00400149    0.000239541       3     
reco:energyrecnumurange:EnergyReco                    0.00380828    0.00405067    0.00447121    0.00387251    0.000298523       3     
reco:energyrecnumumcs:EnergyReco                       0.0037982    0.00408234    0.00453017    0.00391864    0.00032046        3     
reco:opdec:Deconvolution                               0.207381      0.225022      0.259614      0.208072      0.0244617        3     
reco:ophitspe:OpHitFinderDeco                           1.68805       1.90941       2.05897       1.98122      0.159713         3     
reco:opflash:OpFlashFinder                            0.000861744   0.00241344    0.00539646    0.000982112   0.00210989        3     
reco:rns:RandomNumberSaver                            4.7996e-05    0.000200264   0.000442886   0.00010991    0.000173412       3     
reco:anglereconue:NuAngularReco                       0.000337357   0.000698161   0.00134778    0.000409343   0.000460291       3     
reco:anglereconumu:NuAngularReco                      0.000206044   0.000239684   0.000273607   0.000239401   2.75832e-05       3     
reco:anglereconuepfps:NuAngularReco                   0.000275391   0.000853966   0.00191059    0.000375922   0.000748269       3     
reco:anglereconumupfps:NuAngularReco                  0.000283927   0.000328006   0.000363608   0.000336484   3.30774e-05       3     
[art]:TriggerResults:TriggerResultInserter            2.4515e-05    4.6152e-05    8.4701e-05     2.924e-05    2.73264e-05       3     
end_path:out1:RootOutput                               8.568e-06    1.87803e-05    2.783e-05    1.9943e-05    7.90654e-06       3     
end_path:out1:RootOutput(write)                        0.0974726     0.107892      0.121093      0.105111     0.00984157        3     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 6014.18 MB
  Peak resident set size usage (VmHWM): 1203.35 MB
====================================================================================================
%MSG-s ArtException:  PostEndJob 23-Nov-2024 02:28:40 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: 6483936 subRun: 1 event: 24104
      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 3 entries while sim::OpDetDivRecs_opdigi__detsim. has 100 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-db23-fec4-40fa-e15f.root
Validation_ccnc_atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6483936_241_20231207T083633Z_gen_g4_detsim_hitreco__20240510T035347Z_reco2.root
all-input-dids.txt
atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6483936_241_20231207T083633Z_gen_g4_detsim_hitreco__20240510T035347Z_reco2_reco_2024-11-23T_021902Z.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