Jobsub ID 301689.98@justin-prod-sched01.dune.hep.ac.uk

Jobsub ID	301689.98@justin-prod-sched01.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 03:58:43
Site	UK_Imperial
Entry	DUNE_T2_UK_London_IC_ceprod01
Last heartbeat	2024-11-23 04:06:58
From worker node	Hostname	wh19.grid.hep.ph.ic.ac.uk
	cpuinfo	Intel(R) Xeon(R) CPU E5-2650 v2 @ 2.60GHz
	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 03:59:39
Input files	fardet-hd:atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50542963_146_20231202T010506Z_gen_g4_detsim_hitreco__20240507T205410Z_reco2.root
Jobscript	Exit code	0
	Real time	7m (424s)
	CPU time	1m (76s = 17%)
Outputting started	2024-11-23 04:06:44
Output files
Finished	2024-11-23 04:06:58
List job events Wrapper job log
Jobscript log (last 10,000 characters)

df7a325b9 in /cvmfs/larsoft.opensciencegrid.org/products/art/v3_14_04/slf7.x86_64.e26.prof/lib/libart_Framework_EventProcessor.so)
frame #35: art::run_art(int, char**, boost::program_options::options_description&, std::vector<std::unique_ptr<art::OptionsHandler, std::default_delete<art::OptionsHandler> >, std::allocator<std::unique_ptr<art::OptionsHandler, std::default_delete<art::OptionsHandler> > > >&&) + 0x2762 (0x14bdfd28c252 in /cvmfs/larsoft.opensciencegrid.org/products/art/v3_14_04/slf7.x86_64.e26.prof/lib/libart_Framework_Art.so)
frame #36: artapp(int, char**, bool) + 0x732 (0x14bdfd2859f2 in /cvmfs/larsoft.opensciencegrid.org/products/art/v3_14_04/slf7.x86_64.e26.prof/lib/libart_Framework_Art.so)
frame #37: main + 0xe (0x40124e in lar)
frame #38: __libc_start_main + 0xf5 (0x14bdf8622555 in /lib64/libc.so.6)
frame #39: lar() [0x4012d0]

AdaBoostDecisionTree::Initialize - Invalid xml file.
AdaBoostDecisionTree::Initialize - Invalid xml file.
AdaBoostDecisionTree::Initialize - Invalid xml file.
AdaBoostDecisionTree::Initialize - Invalid xml file.
Failure in algorithm Alg0002, LArDLVertexing, unknown exception
PandoraContentApi::GetList(*this, m_inputVertexListName, pVertexList) throw STATUS_CODE_NOT_INITIALIZED
    in function: GetHitRegion
    in file:     /exp/dune/app/users/ismerio/env-testreco/srcs/larpandoracontent/larpandoradlcontent/LArVertex/DlVertexingAlgorithm.cc line#: 624
Failure in algorithm Alg0003, LArDLVertexing, STATUS_CODE_NOT_INITIALIZED
> Running Algorithm: Alg0003, LArNeutrinoEventValidation
---RAW-MATCHING-OUTPUT--------------------------------------------------------------------------
Found: 2212 with KE=0.281344 GeV, E=1.21962 GeV, p2=0.607109
Found: 11 with KE=0.568133 GeV, E=0.568651 GeV, p2=0.323363
CCRES_E_P (Nuance 1003, Nu 1, CR 0)
IsLost (NNuLosses: 2) 
Parent Neutrino: 12
Neutrino Energy: 1.16487
Neutrino Momentum:   x: 0.309268  y: -0.590456  z: 0.955321 length: 1.16487
PrimaryId 1, Nu 1, CR 0, MCPDG 2212, Energy 1.21962, Dist. 11.7016, nMCHits 71 (21, 24, 26)
-No matched Pfo
Parent Neutrino: 12
Neutrino Energy: 1.16487
Neutrino Momentum:   x: 0.309268  y: -0.590456  z: 0.955321 length: 1.16487
PrimaryId 2, Nu 1, CR 0, MCPDG 11, Energy 0.568651, Dist. 18.8701, nMCHits 41 (18, 18, 5)
-No matched Pfo

------------------------------------------------------------------------------------------------

---INTERPRETED-MATCHING-OUTPUT------------------(my version)-----------------------------------------
Found: 2212 with KE=0.281344 GeV, E=1.21962 GeV, p2=0.607109
Found: 11 with KE=0.568133 GeV, E=0.568651 GeV, p2=0.323363
CCRES_E_P (Nuance 1003, Nu 1, CR 0)
IsLost (NNuLosses: 2) 
Parent Neutrino: 12
Neutrino Energy: 1.16487
Neutrino Momentum:   x: 0.309268  y: -0.590456  z: 0.955321 length: 1.16487
PrimaryId 1, Nu 1, CR 0, MCPDG 2212, Energy 1.21962, Dist. 11.7016, nMCHits 71 (21, 24, 26)
-No matched Pfo
Parent Neutrino: 12
Neutrino Energy: 1.16487
Neutrino Momentum:   x: 0.309268  y: -0.590456  z: 0.955321 length: 1.16487
PrimaryId 2, Nu 1, CR 0, MCPDG 11, Energy 0.568651, Dist. 18.8701, nMCHits 41 (18, 18, 5)
-No matched Pfo

---SUMMARY--------------------------------------------------------------------------------------
#CorrectNu: 0/1, Fraction: 0
#Lost: 1 
------------------------------------------------------------------------------------------------

Found: 2212 with KE=0.281344 GeV, E=1.21962 GeV, p2=0.607109
PandoraMonitoring, only able to use default TApplication (limited functionality).
Found: 11 with KE=0.568133 GeV, E=0.568651 GeV, p2=0.323363
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtrack@BeginModule  23-Nov-2024 04:05:19 GMT run: 50542963 subRun: 1 event: 14601
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtrack@BeginModule  23-Nov-2024 04:05:19 GMT run: 50542963 subRun: 1 event: 14601
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtrack@BeginModule  23-Nov-2024 04:05:19 GMT run: 50542963 subRun: 1 event: 14601
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtrack@BeginModule  23-Nov-2024 04:05:19 GMT run: 50542963 subRun: 1 event: 14601
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtrack@BeginModule  23-Nov-2024 04:05:19 GMT run: 50542963 subRun: 1 event: 14601
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtrack@BeginModule  23-Nov-2024 04:05:19 GMT run: 50542963 subRun: 1 event: 14601
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtracktc@BeginModule  23-Nov-2024 04:05:19 GMT run: 50542963 subRun: 1 event: 14601
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtracktc@BeginModule  23-Nov-2024 04:05:19 GMT run: 50542963 subRun: 1 event: 14601
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtracktc@BeginModule  23-Nov-2024 04:05:19 GMT run: 50542963 subRun: 1 event: 14601
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtracktc@BeginModule  23-Nov-2024 04:05:19 GMT run: 50542963 subRun: 1 event: 14601
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtracktc@BeginModule  23-Nov-2024 04:05:19 GMT run: 50542963 subRun: 1 event: 14601
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtracktc@BeginModule  23-Nov-2024 04:05:19 GMT run: 50542963 subRun: 1 event: 14601
Comparing two wires in the same plane: return failure
%MSG
%MSG-e pma::Track3D:  PMAlgTrackMaker:pmtracktc@BeginModule  23-Nov-2024 04:05:19 GMT run: 50542963 subRun: 1 event: 14601
Flip, endpoint closer to vStart.
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrajFitter:pmtrajfittc@BeginModule  23-Nov-2024 04:05:19 GMT run: 50542963 subRun: 1 event: 14601
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrajFitter:pmtrajfittc@BeginModule  23-Nov-2024 04:05:19 GMT run: 50542963 subRun: 1 event: 14601
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrajFitter:pmtrajfittc@BeginModule  23-Nov-2024 04:05:19 GMT run: 50542963 subRun: 1 event: 14601
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrajFitter:pmtrajfittc@BeginModule  23-Nov-2024 04:05:19 GMT run: 50542963 subRun: 1 event: 14601
Comparing two wires in the same plane: return failure
%MSG
Boundary wire vector sizes: 74, 61, 53
minwire 0: 2575
minwire 1: 475
minwire 2: 2678
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:05:45 GMT  Opened output file with pattern "atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50542963_146_20231202T010506Z_gen_g4_detsim_hitreco__20240507T205410Z_reco2_reco_data_2024-11-23T_035943Z.root"
23-Nov-2024 04:06:43 GMT  Closed input file "root://xrootd1.esc.qmul.ac.uk:1094//dune/RSE/fardet-hd/e8/bc/atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50542963_146_20231202T010506Z_gen_g4_detsim_hitreco__20240507T205410Z_reco2.root"
Malformed TimeTracker database.  The TimeEvent table is empty, but
the TimeModule table is not.  This can happen if an exception has
been thrown from a module while processing the first event.  Any
saved database file is suspect and should not be used.

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

  Peak virtual memory usage (VmPeak)  : 7071.41 MB
  Peak resident set size usage (VmHWM): 1172.72 MB
====================================================================================================
%MSG-s ArtException:  PostEndJob 23-Nov-2024 04:06:44 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: 50542963 subRun: 1 event: 14601
      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 0 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-dc25-8f3d-7e47-8e1a.root
Validation_ccnc_atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50542963_146_20231202T010506Z_gen_g4_detsim_hitreco__20240507T205410Z_reco2.root
all-input-dids.txt
atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50542963_146_20231202T010506Z_gen_g4_detsim_hitreco__20240507T205410Z_reco2_reco_2024-11-23T_035943Z.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