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

Jobsub ID	301853.1@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 06:52:15
Site	UK_Imperial
Entry	DUNE_T2_UK_London_IC_ceprod03
Last heartbeat	2024-11-23 07:00:31
From worker node	Hostname	wj23.grid.hep.ph.ic.ac.uk
	cpuinfo	Intel(R) Xeon(R) CPU E5-2620 v4 @ 2.10GHz
	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 06:53:05
Input files	fardet-hd:atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6406500_778_20231202T130530Z_gen_g4_detsim_hitreco__20240507T222120Z_reco2.root
Jobscript	Exit code	0
	Real time	7m (432s)
	CPU time	1m (84s = 19%)
Outputting started	2024-11-23 07:00:17
Output files
Finished	2024-11-23 07:00:31
List job events Wrapper job log
Jobscript log (last 10,000 characters)

705 length: 0.840187
PrimaryId 3, Nu 1, CR 0, MCPDG 2212, Energy 1.0469, Dist. 9.0933, nMCHits 46 (14, 18, 14)
-No matched Pfo
Parent Neutrino: 14
Neutrino Energy: 0.840182
Neutrino Momentum:   x: -0.406362  y: 0.130523  z: 0.723705 length: 0.840187
PrimaryId 4, Nu 1, CR 0, MCPDG 2212, Energy 1.07363, Dist. 13.5803, nMCHits 21 (7, 9, 5)
-No matched Pfo

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

---INTERPRETED-MATCHING-OUTPUT------------------(my version)-----------------------------------------
Found: 13 with KE=0.20405 GeV, E=0.309709 GeV, p2=0.0847557
Found: 211 with KE=0.010327 GeV, E=0.149897 GeV, p2=0.00298931
Found: 2212 with KE=0.108623 GeV, E=1.0469 GeV, p2=0.215635
Found: 2212 with KE=0.135358 GeV, E=1.07363 GeV, p2=0.272327
CCRES_MU_P_P_PIPLUS (Nuance 1003, Nu 1, CR 0)
IsLost (NNuLosses: 4) 
Parent Neutrino: 14
Neutrino Energy: 0.840182
Neutrino Momentum:   x: -0.406362  y: 0.130523  z: 0.723705 length: 0.840187
PrimaryId 1, Nu 1, CR 0, MCPDG 13, Energy 0.309709, Dist. 75.2658, nMCHits 196 (99, 63, 34)
-No matched Pfo
Parent Neutrino: 14
Neutrino Energy: 0.840182
Neutrino Momentum:   x: -0.406362  y: 0.130523  z: 0.723705 length: 0.840187
PrimaryId 2, Nu 1, CR 0, MCPDG 211, Energy 0.149897, Dist. 0.58587, nMCHits 70 (24, 26, 20)
-No matched Pfo
Parent Neutrino: 14
Neutrino Energy: 0.840182
Neutrino Momentum:   x: -0.406362  y: 0.130523  z: 0.723705 length: 0.840187
PrimaryId 3, Nu 1, CR 0, MCPDG 2212, Energy 1.0469, Dist. 9.0933, nMCHits 46 (14, 18, 14)
-No matched Pfo
Parent Neutrino: 14
Neutrino Energy: 0.840182
Neutrino Momentum:   x: -0.406362  y: 0.130523  z: 0.723705 length: 0.840187
PrimaryId 4, Nu 1, CR 0, MCPDG 2212, Energy 1.07363, Dist. 13.5803, nMCHits 21 (7, 9, 5)
-No matched Pfo

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

Found: 13 with KE=0.20405 GeV, E=0.309709 GeV, p2=0.0847557
PandoraMonitoring, only able to use default TApplication (limited functionality).
Found: 211 with KE=0.010327 GeV, E=0.149897 GeV, p2=0.00298931
Found: 2212 with KE=0.108623 GeV, E=1.0469 GeV, p2=0.215635
Found: 2212 with KE=0.135358 GeV, E=1.07363 GeV, p2=0.272327
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtrack@BeginModule  23-Nov-2024 06:58:45 GMT run: 6406500 subRun: 1 event: 77801
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtrack@BeginModule  23-Nov-2024 06:58:45 GMT run: 6406500 subRun: 1 event: 77801
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtrack@BeginModule  23-Nov-2024 06:58:45 GMT run: 6406500 subRun: 1 event: 77801
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtrack@BeginModule  23-Nov-2024 06:58:45 GMT run: 6406500 subRun: 1 event: 77801
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtrack@BeginModule  23-Nov-2024 06:58:45 GMT run: 6406500 subRun: 1 event: 77801
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtracktc@BeginModule  23-Nov-2024 06:58:45 GMT run: 6406500 subRun: 1 event: 77801
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtracktc@BeginModule  23-Nov-2024 06:58:45 GMT run: 6406500 subRun: 1 event: 77801
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtracktc@BeginModule  23-Nov-2024 06:58:45 GMT run: 6406500 subRun: 1 event: 77801
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtracktc@BeginModule  23-Nov-2024 06:58:45 GMT run: 6406500 subRun: 1 event: 77801
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtracktc@BeginModule  23-Nov-2024 06:58:45 GMT run: 6406500 subRun: 1 event: 77801
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtracktc@BeginModule  23-Nov-2024 06:58:45 GMT run: 6406500 subRun: 1 event: 77801
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtracktc@BeginModule  23-Nov-2024 06:58:45 GMT run: 6406500 subRun: 1 event: 77801
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtracktc@BeginModule  23-Nov-2024 06:58:45 GMT run: 6406500 subRun: 1 event: 77801
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtracktc@BeginModule  23-Nov-2024 06:58:45 GMT run: 6406500 subRun: 1 event: 77801
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtracktc@BeginModule  23-Nov-2024 06:58:45 GMT run: 6406500 subRun: 1 event: 77801
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtracktc@BeginModule  23-Nov-2024 06:58:45 GMT run: 6406500 subRun: 1 event: 77801
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtracktc@BeginModule  23-Nov-2024 06:58:45 GMT run: 6406500 subRun: 1 event: 77801
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrajFitter:pmtrajfittc@BeginModule  23-Nov-2024 06:58:45 GMT run: 6406500 subRun: 1 event: 77801
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrajFitter:pmtrajfittc@BeginModule  23-Nov-2024 06:58:45 GMT run: 6406500 subRun: 1 event: 77801
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrajFitter:pmtrajfittc@BeginModule  23-Nov-2024 06:58:45 GMT run: 6406500 subRun: 1 event: 77801
1st wire C:0 T:3 P:2 W:519 does not exist (max wire number: 480)
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrajFitter:pmtrajfittc@BeginModule  23-Nov-2024 06:58:45 GMT run: 6406500 subRun: 1 event: 77801
1st wire C:0 T:3 P:2 W:603 does not exist (max wire number: 480)
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrajFitter:pmtrajfittc@BeginModule  23-Nov-2024 06:58:45 GMT run: 6406500 subRun: 1 event: 77801
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrajFitter:pmtrajfittc@BeginModule  23-Nov-2024 06:58:45 GMT run: 6406500 subRun: 1 event: 77801
Comparing two wires in the same plane: return failure
%MSG
Boundary wire vector sizes: 147, 131, 81
minwire 0: 495
minwire 1: 2364
minwire 2: 274
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 06:59:14 GMT  Opened output file with pattern "atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6406500_778_20231202T130530Z_gen_g4_detsim_hitreco__20240507T222120Z_reco2_reco_data_2024-11-23T_065308Z.root"
23-Nov-2024 07:00:16 GMT  Closed input file "root://mover.pp.rl.ac.uk:1094/pnfs/pp.rl.ac.uk/data/dune/fardet-hd/3d/1f/atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6406500_778_20231202T130530Z_gen_g4_detsim_hitreco__20240507T222120Z_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.45 MB
  Peak resident set size usage (VmHWM): 1182.26 MB
====================================================================================================
%MSG-s ArtException:  PostEndJob 23-Nov-2024 07:00:17 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: 6406500 subRun: 1 event: 77801
      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-7cce-bdfb-3e34-3f38.root
Validation_ccnc_atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6406500_778_20231202T130530Z_gen_g4_detsim_hitreco__20240507T222120Z_reco2.root
all-input-dids.txt
atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6406500_778_20231202T130530Z_gen_g4_detsim_hitreco__20240507T222120Z_reco2_reco_2024-11-23T_065308Z.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