justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID301744.44@justin-prod-sched01.dune.hep.ac.uk
Workflow ID4213
Stage ID1
User nameismerio@fnal.gov
HTCondor Groupgroup_dune
RequestedProcessors1
RSS bytes4194304000 (4000 MiB)
Wall seconds limit80000 (22 hours)
Submitted time2024-11-23 04:56:37
SiteUK_Imperial
EntryDUNE_T2_UK_London_IC_ceprod02
Last heartbeat2024-11-23 05:06:17
From worker nodeHostnamewj43.grid.hep.ph.ic.ac.uk
cpuinfoIntel(R) Xeon(R) CPU E5-2620 v4 @ 2.10GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4194304000 (4000 MiB)
Wall seconds limit171000 (47 hours)
Inner Apptainer?True
Job stateoutputting_failed
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-11-23 04:58:19
Input filesfardet-hd:atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50581281_590_20231204T052049Z_gen_g4_detsim_hitreco__20240509T213321Z_reco2.root
JobscriptExit code0
Real time7m (458s)
CPU time1m (113s = 24%)
Outputting started2024-11-23 05:05:57
Output files
Finished2024-11-23 05:06:17
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

ame #29: void art::EventProcessor::process<(art::Level)4>() + 0x2b7 (0x154d1922b537 in /cvmfs/larsoft.opensciencegrid.org/products/art/v3_14_04/slf7.x86_64.e26.prof/lib/libart_Framework_EventProcessor.so)
frame #30: void art::EventProcessor::process<(art::Level)3>() + 0x75 (0x154d19248845 in /cvmfs/larsoft.opensciencegrid.org/products/art/v3_14_04/slf7.x86_64.e26.prof/lib/libart_Framework_EventProcessor.so)
frame #31: void art::EventProcessor::process<(art::Level)2>() + 0x75 (0x154d19248a15 in /cvmfs/larsoft.opensciencegrid.org/products/art/v3_14_04/slf7.x86_64.e26.prof/lib/libart_Framework_EventProcessor.so)
frame #32: void art::EventProcessor::process<(art::Level)1>() + 0x75 (0x154d19248bb5 in /cvmfs/larsoft.opensciencegrid.org/products/art/v3_14_04/slf7.x86_64.e26.prof/lib/libart_Framework_EventProcessor.so)
frame #33: void art::EventProcessor::process<(art::Level)0>() + 0x85 (0x154d19248d65 in /cvmfs/larsoft.opensciencegrid.org/products/art/v3_14_04/slf7.x86_64.e26.prof/lib/libart_Framework_EventProcessor.so)
frame #34: art::EventProcessor::runToCompletion() + 0x19 (0x154d192325b9 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 (0x154d1ea8c252 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 (0x154d1ea859f2 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 (0x154d19e22555 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: 13 with KE=0.190013 GeV, E=0.295672 GeV, p2=0.0762581
Found: 2212 with KE=0.206507 GeV, E=1.14478 GeV, p2=0.430164
CCQEL_MU_P (Nuance 1001, Nu 1, CR 0)
IsLost (NNuLosses: 2) 
Parent Neutrino: 14
Neutrino Energy: 0.519345
Neutrino Momentum:   x: 0.0527892  y: 0.300536  z: 0.420254 length: 0.519347
PrimaryId 1, Nu 1, CR 0, MCPDG 13, Energy 0.295672, Dist. 70.9773, nMCHits 216 (104, 67, 45)
-No matched Pfo
Parent Neutrino: 14
Neutrino Energy: 0.519345
Neutrino Momentum:   x: 0.0527892  y: 0.300536  z: 0.420254 length: 0.519347
PrimaryId 2, Nu 1, CR 0, MCPDG 2212, Energy 1.14478, Dist. 23.2592, nMCHits 94 (10, 50, 34)
-No matched Pfo

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

---INTERPRETED-MATCHING-OUTPUT------------------(my version)-----------------------------------------
Found: 13 with KE=0.190013 GeV, E=0.295672 GeV, p2=0.0762581
Found: 2212 with KE=0.206507 GeV, E=1.14478 GeV, p2=0.430164
CCQEL_MU_P (Nuance 1001, Nu 1, CR 0)
IsLost (NNuLosses: 2) 
Parent Neutrino: 14
Neutrino Energy: 0.519345
Neutrino Momentum:   x: 0.0527892  y: 0.300536  z: 0.420254 length: 0.519347
PrimaryId 1, Nu 1, CR 0, MCPDG 13, Energy 0.295672, Dist. 70.9773, nMCHits 216 (104, 67, 45)
-No matched Pfo
Parent Neutrino: 14
Neutrino Energy: 0.519345
Neutrino Momentum:   x: 0.0527892  y: 0.300536  z: 0.420254 length: 0.519347
PrimaryId 2, Nu 1, CR 0, MCPDG 2212, Energy 1.14478, Dist. 23.2592, nMCHits 94 (10, 50, 34)
-No matched Pfo

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

Found: 13 with KE=0.190013 GeV, E=0.295672 GeV, p2=0.0762581
PandoraMonitoring, only able to use default TApplication (limited functionality).
Found: 2212 with KE=0.206507 GeV, E=1.14478 GeV, p2=0.430164
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtrack@BeginModule  23-Nov-2024 05:04:37 GMT run: 50581281 subRun: 1 event: 59001
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtrack@BeginModule  23-Nov-2024 05:04:37 GMT run: 50581281 subRun: 1 event: 59001
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtrack@BeginModule  23-Nov-2024 05:04:37 GMT run: 50581281 subRun: 1 event: 59001
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtrack@BeginModule  23-Nov-2024 05:04:37 GMT run: 50581281 subRun: 1 event: 59001
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtracktc@BeginModule  23-Nov-2024 05:04:38 GMT run: 50581281 subRun: 1 event: 59001
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtracktc@BeginModule  23-Nov-2024 05:04:38 GMT run: 50581281 subRun: 1 event: 59001
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtracktc@BeginModule  23-Nov-2024 05:04:38 GMT run: 50581281 subRun: 1 event: 59001
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtracktc@BeginModule  23-Nov-2024 05:04:38 GMT run: 50581281 subRun: 1 event: 59001
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrajFitter:pmtrajfittc@BeginModule  23-Nov-2024 05:04:38 GMT run: 50581281 subRun: 1 event: 59001
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrajFitter:pmtrajfittc@BeginModule  23-Nov-2024 05:04:38 GMT run: 50581281 subRun: 1 event: 59001
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrajFitter:pmtrajfittc@BeginModule  23-Nov-2024 05:04:38 GMT run: 50581281 subRun: 1 event: 59001
1st wire C:0 T:11 P:2 W:545 does not exist (max wire number: 480)
%MSG
Boundary wire vector sizes: 129, 131, 93
minwire 0: 1379
minwire 1: 1527
minwire 2: 867
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 05:05:05 GMT  Opened output file with pattern "atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50581281_590_20231204T052049Z_gen_g4_detsim_hitreco__20240509T213321Z_reco2_reco_data_2024-11-23T_045824Z.root"
23-Nov-2024 05:05:55 GMT  Closed input file "root://xrootd1.esc.qmul.ac.uk:1094//dune/RSE/fardet-hd/fc/f9/atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50581281_590_20231204T052049Z_gen_g4_detsim_hitreco__20240509T213321Z_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.44 MB
  Peak resident set size usage (VmHWM): 1155.5 MB
====================================================================================================
%MSG-s ArtException:  PostEndJob 23-Nov-2024 05:05:57 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: 50581281 subRun: 1 event: 59001
      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-645d-f083-a3b3-cef2.root
Validation_ccnc_atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50581281_590_20231204T052049Z_gen_g4_detsim_hitreco__20240509T213321Z_reco2.root
all-input-dids.txt
atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50581281_590_20231204T052049Z_gen_g4_detsim_hitreco__20240509T213321Z_reco2_reco_2024-11-23T_045824Z.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
justIN time: 2024-11-23 11:58:55 UTC       justIN version: 01.01.09