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

Jobsub ID	301484.29@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-22 22:51:32
Site	CA_SFU
Entry	DUNE_CA_SFU_lcg-ce3
Last heartbeat	2024-11-23 00:27:05
From worker node	Hostname	cdr232.int.cedar.computecanada.ca
	cpuinfo	Intel(R) Xeon(R) CPU E5-2683 v4 @ 2.10GHz
	OS release	Scientific Linux release 7.9 (Nitrogen)
	Processors	1
	RSS bytes	4194304000 (4000 MiB)
	Wall seconds limit	84598 (23 hours)
	Inner Apptainer?	True
Job state	outputting_failed
Allocator name	justin-allocator-pro.dune.hep.ac.uk
Started	2024-11-22 23:03:40
Input files	fardet-hd:atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50601160_1108_20231205T063550Z_gen_g4_detsim_hitreco__20240509T222135Z_reco2.root
Jobscript	Exit code	0
	Real time	1h (4925s)
	CPU time	1h (3921s = 79%)
Outputting started	2024-11-23 00:26:51
Output files
Finished	2024-11-23 00:27:05
List job events Wrapper job log
Jobscript log (last 10,000 characters)

emshower@BeginModule  22-Nov-2024 16:25:31 PST run: 50601160 subRun: 1 event: 110899
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  EMShower:emshower@BeginModule  22-Nov-2024 16:25:31 PST run: 50601160 subRun: 1 event: 110899
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  EMShower:emshower@BeginModule  22-Nov-2024 16:25:31 PST run: 50601160 subRun: 1 event: 110899
Comparing two wires in the same plane: return failure
%MSG
%MSG-e WireIDIntersectionCheck:  EMShower:emshower@BeginModule  22-Nov-2024 16:25:31 PST run: 50601160 subRun: 1 event: 110899
Comparing two wires in the same plane: return failure
%MSG
Boundary wire vector sizes: 1684, 2023, 1710
minwire 0: 1482
minwire 1: 107
minwire 2: 1730
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
Classifier summary: 
Output 0: 0.0604668, 0.134564, 0.804969, 
Output 1: 0.367075, 0.449255, 0.147945, 0.0357253, 
Output 2: 0.253113, 0.746887, 

667
***Wiener Filter*******ApplyPostfilter***
Running Ophitfinder with InputDigiType = 'recob'
Found hits: 2371!
Begin processing the 100th record. run: 50601160 subRun: 1 event: 110900 at 22-Nov-2024 16:25:38 PST
> Running Algorithm: Alg0001, LArPreProcessing
> Running Algorithm: Alg0002, LArDLMaster
> Running Algorithm: Alg0003, LArNeutrinoEventValidation
---RAW-MATCHING-OUTPUT--------------------------------------------------------------------------
Failure in algorithm Alg0003, LArNeutrinoEventValidation, STATUS_CODE_NOT_INITIALIZED
111
***Wiener Filter*******ApplyPostfilter***
Running Ophitfinder with InputDigiType = 'recob'
Found hits: 122!
22-Nov-2024 16:25:45 PST  Closed output file "atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50601160_1108_20231205T063550Z_gen_g4_detsim_hitreco__20240509T222135Z_reco2_reco_data_2024-11-22T_230411Z.root"
22-Nov-2024 16:25:45 PST  Closed input file "root://dcdndoor.sdcc.bnl.gov:1094//pnfs/sdcc.bnl.gov/data/dune/RSE/fardet-hd/dc/50/atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50601160_1108_20231205T063550Z_gen_g4_detsim_hitreco__20240509T222135Z_reco2.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              2.28019       40.9264       648.828       13.5508       84.1389        100    
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                 0.0735836     0.166733      0.326897      0.168655      0.0492149       100    
reco:linecluster:LineCluster                           0.473631      0.955051       17.6319       0.73335       1.69192        100    
reco:trajcluster:TrajCluster                           0.217766       1.54647       44.7966      0.230794       5.29933        100    
reco:pandora:StandardPandora                           0.232041       3.41366       74.6825       1.87569       7.69049        100    
reco:pandoraTrack:LArPandoraTrackCreation             0.000178108    0.0110872     0.186029     0.00174071     0.0280471       100    
reco:pandoraShower:LArPandoraModularShowerCreation    0.000249253    0.0221031     0.724088     0.00371191     0.0777407       100    
reco:pandoracalo:Calorimetry                          0.000140044    0.0301269      1.01593     0.00128517     0.114307        100    
reco:pandorapid:Chi2ParticleID                        5.5097e-05    0.000216831   0.00187689    0.000156921   0.000225001      100    
reco:trkshowersplit:TrackShowerHits                   0.000115706    0.0300025      1.00829     0.000844351    0.114066        100    
reco:pmtrack:PMAlgTrackMaker                          0.00177879      3.08812       65.397       0.237123       9.15119        100    
reco:pmtrackcalo:Calorimetry                          0.000119139    0.0181788     0.588419     0.00112799     0.0674152       100    
reco:pmtrackpid:Chi2ParticleID                        4.8906e-05    0.000412468   0.00502084    0.000183806   0.000670146      100    
reco:pmtrajfit:PMAlgTrajFitter                        0.000284467     2.95922       49.924       0.345421       7.66505        100    
reco:pmtrajfitcalo:Calorimetry                        0.00011176     0.0319458      1.0514      0.00165204     0.118698        100    
reco:pmtrajfitpid:Chi2ParticleID                      4.7424e-05    0.000251352   0.00127695     0.0001717    0.000218681      100    
reco:pmtracktc:PMAlgTrackMaker                        0.00163768      3.78753       92.1505       0.24229       11.8122        100    
reco:pmtracktccalo:Calorimetry                        0.000118472    0.0153819     0.325418     0.00131163     0.0492551       100    
reco:pmtracktcpid:Chi2ParticleID                       4.847e-05    0.00038379    0.00388974    0.000202574   0.000544124      100    
reco:pmtrajfittc:PMAlgTrajFitter                      0.000270658     2.42496       64.7796      0.332947       7.26833        100    
reco:pmtrajfittccalo:Calorimetry                      0.00011076     0.0288301      1.07316     0.00162322     0.116011        100    
reco:pmtrajfittcpid:Chi2ParticleID                     4.676e-05    0.000513783   0.00665676    0.000200432   0.00086191       100    
reco:blurredcluster:BlurredClustering                 9.5028e-05      1.36772       12.4138      0.567734       2.02031        100    
reco:emtrkmichelid:EmTrackMichelId                    0.000163783     16.4846       211.728       3.66462       32.9837        100    
reco:emshower:EMShower                                0.000241783    0.0408553     0.355307     0.00846099     0.065375        100    
reco:cvnmap:CVNMapper                                  3.184e-05     0.0146619     0.0627444     0.013132      0.0125896       100    
reco:cvneva:CVNEvaluator                              2.3813e-05      0.82823       2.94273       1.07635      0.557046        100    
reco:energyrecnumu:EnergyReco                         0.000391933    0.0641593      2.44423     0.00520903     0.257438        100    
reco:energyrecnue:EnergyReco                          0.00023335    0.00387406     0.0614256    0.000779937   0.00942747       100    
reco:energyrecnc:EnergyReco                           0.00302702    0.00658704     0.066114     0.00346633    0.00962088       100    
reco:energyrecnumurange:EnergyReco                    0.000256961    0.0619465      2.43104     0.00327986     0.256329        100    
reco:energyrecnumumcs:EnergyReco                      0.00304472     0.0638806      2.41872     0.00467316     0.254907        100    
reco:opdec:Deconvolution                               0.239703      0.792034       1.29816      0.749805      0.233499        100    
reco:ophitspe:OpHitFinderDeco                          0.657028       2.33247       3.99349       2.33749      0.719639        100    
reco:opflash:OpFlashFinder                            0.000209947   0.00174175    0.00403284    0.00173749    0.000771594      100    
reco:rns:RandomNumberSaver                            2.1536e-05    3.62279e-05   0.000319184   2.9726e-05    3.03569e-05      100    
reco:anglereconue:NuAngularReco                       0.000180479   0.00295782     0.0553311    0.000396588   0.00826635       100    
reco:anglereconumu:NuAngularReco                      0.000121245   0.00279901     0.0551622    0.000293992   0.00824642       100    
reco:anglereconuepfps:NuAngularReco                   0.000177373   0.00295069     0.0551789    0.000418999   0.00826393       100    
reco:anglereconumupfps:NuAngularReco                  0.000169982   0.00292681     0.0550816     0.000388      0.0083319       100    
[art]:TriggerResults:TriggerResultInserter            1.3682e-05    1.66913e-05   5.3681e-05    1.54975e-05   4.24401e-06      100    
end_path:out1:RootOutput                               2.619e-06    5.18421e-06   4.9083e-05    3.4455e-06    4.98912e-06      100    
end_path:out1:RootOutput(write)                        0.0113824     0.318638       1.33963      0.313133      0.226493        100    
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 8537.09 MB
  Peak resident set size usage (VmHWM): 2561.42 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_50601160_1108_20231205T063550Z_gen_g4_detsim_hitreco__20240509T222135Z_reco2.root
all-input-dids.txt
atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50601160_1108_20231205T063550Z_gen_g4_detsim_hitreco__20240509T222135Z_reco2_reco_2024-11-22T_230411Z.log
atmnu_max_weighted_randompolicy_dune10kt_1x2x6_50601160_1108_20231205T063550Z_gen_g4_detsim_hitreco__20240509T222135Z_reco2_reco_data_2024-11-22T_230411Z.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