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

Jobsub ID	301619.86@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 01:20:25
Site	UK_Lancaster
Entry	UBoone_UK_Lancaster_HEC_grendel_ce02
Last heartbeat	2024-11-23 02:10:21
From worker node	Hostname	comp20-04
	cpuinfo	Intel(R) Xeon(R) Gold 6148 CPU @ 2.40GHz
	OS release	Scientific Linux release 7.9 (Nitrogen)
	Processors	1
	RSS bytes	4194304000 (4000 MiB)
	Wall seconds limit	257400 (71 hours)
	Inner Apptainer?	True
Job state	outputting_failed
Allocator name	justin-allocator-pro.dune.hep.ac.uk
Started	2024-11-23 01:24:31
Input files	fardet-hd:atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6398928_929_20231202T074005Z_gen_g4_detsim_hitreco__20240507T205006Z_reco2.root
Jobscript	Exit code	0
	Real time	45m (2735s)
	CPU time	41m (2481s = 90%)
Outputting started	2024-11-23 02:10:07
Output files
Finished	2024-11-23 02:10:21
List job events Wrapper job log
Jobscript log (last 10,000 characters)

o get min and max tdcs due to vertex determination failure: 0, 199
Classifier summary: 
Output 0: 0.621841, 0.372091, 0.00606818, 
Output 1: 0.933503, 0.0646613, 0.00170481, 0.000130607, 
Output 2: 0.993927, 0.0060725, 

380
***Wiener Filter*******ApplyPostfilter***
Running Ophitfinder with InputDigiType = 'recob'
Found hits: 1139!
Begin processing the 100th record. run: 6398928 subRun: 1 event: 93000 at 23-Nov-2024 02:09:59 GMT
> Running Algorithm: Alg0001, LArPreProcessing
> Running Algorithm: Alg0002, LArDLMaster
> Running Algorithm: Alg0003, LArNeutrinoEventValidation
---RAW-MATCHING-OUTPUT--------------------------------------------------------------------------
Failure in algorithm Alg0003, LArNeutrinoEventValidation, STATUS_CODE_NOT_INITIALIZED
%MSG-e ShowerProducedPtrsHolder:   LArPandoraModularShowerCreation:pandoraShower@BeginModule  23-Nov-2024 02:10:01 GMT run: 6398928 subRun: 1 event: 93000
Trying to add data product: InitialTrack. This element does not exist in the element holder
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrajFitter:pmtrajfit@BeginModule  23-Nov-2024 02:10:01 GMT run: 6398928 subRun: 1 event: 93000
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrackMaker:pmtracktc@BeginModule  23-Nov-2024 02:10:01 GMT run: 6398928 subRun: 1 event: 93000
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrajFitter:pmtrajfittc@BeginModule  23-Nov-2024 02:10:01 GMT run: 6398928 subRun: 1 event: 93000
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  EMShower:emshower@BeginModule  23-Nov-2024 02:10:03 GMT run: 6398928 subRun: 1 event: 93000
Comparing two wires in the same plane: return failure
%MSG
241
***Wiener Filter*******ApplyPostfilter***
Running Ophitfinder with InputDigiType = 'recob'
Found hits: 546!
23-Nov-2024 02:10:05 GMT  Closed output file "atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6398928_929_20231202T074005Z_gen_g4_detsim_hitreco__20240507T205006Z_reco2_reco_data_2024-11-23T_012434Z.root"
23-Nov-2024 02:10:05 GMT  Closed input file "root://xrootd.echo.stfc.ac.uk:1094/dune:/protodune/RSE/fardet-hd/6e/02/atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6398928_929_20231202T074005Z_gen_g4_detsim_hitreco__20240507T205006Z_reco2.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              1.06679       25.322        342.253       10.4238       47.7584        100    
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                 0.0365186     0.103369      0.524439      0.0840114     0.0782466       100    
reco:linecluster:LineCluster                           0.115979      0.459495       8.47096      0.312258       0.86052        100    
reco:trajcluster:TrajCluster                           0.0310328     0.937793        34.54       0.126714       4.15023        100    
reco:pandora:StandardPandora                           0.166185       1.89081       18.3803       1.35126       2.16445        100    
reco:pandoraTrack:LArPandoraTrackCreation             0.00013385    0.00530019     0.0675839    0.00140567     0.0111232       100    
reco:pandoraShower:LArPandoraModularShowerCreation    0.000178203   0.00984626     0.225984     0.00263931     0.0242245       100    
reco:pandoracalo:Calorimetry                          0.000106977    0.0122392     0.248137     0.000809607    0.0403047       100    
reco:pandorapid:Chi2ParticleID                        3.8006e-05    0.000150175   0.00173363    0.000117695   0.000178792      100    
reco:trkshowersplit:TrackShowerHits                   5.9184e-05     0.0161932     0.509848     0.000515396    0.0640188       100    
reco:pmtrack:PMAlgTrackMaker                          0.00117066      1.51965       35.1451      0.164705       4.65594        100    
reco:pmtrackcalo:Calorimetry                          8.3835e-05    0.00793464     0.192194     0.000869581    0.0258171       100    
reco:pmtrackpid:Chi2ParticleID                        3.1622e-05    0.000231772   0.00222617    0.000124133   0.000342471      100    
reco:pmtrajfit:PMAlgTrajFitter                        0.000200355     1.30203       21.086       0.229078       3.21296        100    
reco:pmtrajfitcalo:Calorimetry                        6.2613e-05     0.0134554     0.261675     0.00119536     0.0430641       100    
reco:pmtrajfitpid:Chi2ParticleID                      2.7626e-05    0.00016374    0.000711263   0.000131231   0.000129033      100    
reco:pmtracktc:PMAlgTrackMaker                        0.00106651      2.15785       61.3059      0.166132       7.8884         100    
reco:pmtracktccalo:Calorimetry                        7.2909e-05    0.00508655     0.0872311    0.000841704    0.0125844       100    
reco:pmtracktcpid:Chi2ParticleID                      2.8827e-05    0.000218318   0.00163009    0.000125848   0.000264423      100    
reco:pmtrajfittc:PMAlgTrajFitter                      0.000166668     1.11194       17.0054      0.230489       2.57087        100    
reco:pmtrajfittccalo:Calorimetry                      6.1954e-05     0.0119597     0.294925     0.000969702    0.0396588       100    
reco:pmtrajfittcpid:Chi2ParticleID                    2.6125e-05    0.000290956   0.00254774    0.000132899   0.000434266      100    
reco:blurredcluster:BlurredClustering                 6.5345e-05      1.11941       8.1859       0.447862       1.68399        100    
reco:emtrkmichelid:EmTrackMichelId                    9.7729e-05      11.0206       131.059       3.02127       21.074         100    
reco:emshower:EMShower                                0.000161154    0.0243231     0.201216     0.00416509     0.0414716       100    
reco:cvnmap:CVNMapper                                 1.7512e-05     0.0165585     0.0476007     0.015548      0.0120025       100    
reco:cvneva:CVNEvaluator                              1.5636e-05     0.549655      0.855067      0.708212      0.310151        100    
reco:energyrecnumu:EnergyReco                         0.000395468    0.0385749     0.745017     0.00472315      0.11305        100    
reco:energyrecnue:EnergyReco                          0.000153821   0.00180114     0.0227537    0.000532832   0.00370847       100    
reco:energyrecnc:EnergyReco                           0.00193529    0.00353003     0.0250467    0.00226312    0.00379859       100    
reco:energyrecnumurange:EnergyReco                    0.000251699    0.0345083      0.70533     0.00206896     0.106959        100    
reco:energyrecnumumcs:EnergyReco                      0.00144107     0.0357796     0.700536     0.00303523     0.106763        100    
reco:opdec:Deconvolution                               0.0902331     0.421873       2.39968       0.36533      0.255928        100    
reco:ophitspe:OpHitFinderDeco                          0.184585       2.26262       4.4872        2.08997      0.926335        100    
reco:opflash:OpFlashFinder                            0.000147643   0.00136187    0.00499626    0.00131516    0.000641919      100    
reco:rns:RandomNumberSaver                            1.7877e-05    3.42757e-05   0.000253427   3.14465e-05   2.44072e-05      100    
reco:anglereconue:NuAngularReco                       0.000151239   0.00139945     0.0192001    0.000428879   0.00310518       100    
reco:anglereconumu:NuAngularReco                      7.0396e-05    0.00114304     0.0183029    0.000192033   0.00295371       100    
reco:anglereconuepfps:NuAngularReco                   0.000116813   0.00128349     0.0189804    0.000342633    0.0030449       100    
reco:anglereconumupfps:NuAngularReco                  0.000101456   0.00122338     0.0186197    0.000273252   0.00298883       100    
[art]:TriggerResults:TriggerResultInserter             8.97e-06     1.19647e-05   5.8895e-05    1.0742e-05    5.21403e-06      100    
end_path:out1:RootOutput                               2.328e-06    5.92695e-06   2.2654e-05    5.3305e-06    3.17013e-06      100    
end_path:out1:RootOutput(write)                       0.00776524      0.21861      0.752099      0.217921       0.1348         100    
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 9540.67 MB
  Peak resident set size usage (VmHWM): 2475.73 MB
====================================================================================================
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===
Validation_ccnc_atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6398928_929_20231202T074005Z_gen_g4_detsim_hitreco__20240507T205006Z_reco2.root
all-input-dids.txt
atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6398928_929_20231202T074005Z_gen_g4_detsim_hitreco__20240507T205006Z_reco2_reco_2024-11-23T_012434Z.log
atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6398928_929_20231202T074005Z_gen_g4_detsim_hitreco__20240507T205006Z_reco2_reco_data_2024-11-23T_012434Z.root
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