justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 108520.158@justin-prod-sched02.dune.hep.ac.uk

Jobsub ID108520.158@justin-prod-sched02.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-22 22:45:48
SiteNL_NIKHEF
EntryVIRGO_NL_NIKHEF_klomp
Last heartbeat2024-11-22 22:58:53
From worker nodeHostnamewn-choc-034.farm.nikhef.nl
cpuinfoIntel(R) Xeon(R) CPU E5-2650 v4 @ 2.20GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4194304000 (4000 MiB)
Wall seconds limit129600 (36 hours)
Inner Apptainer?True
Job statefinished
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-11-22 22:55:34
Input filesfardet-hd:atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6472619_185_20231208T061712Z_gen_g4_detsim_hitreco__20240510T043335Z_reco2.root
JobscriptExit code0
Real time2m (134s)
CPU time2m (129s = 96%)
Outputting started2024-11-22 22:57:49
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/ismerio/04213/1/Validation_ccnc_atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6472619_185_20231208T061712Z_gen_g4_detsim_hitreco__20240510T043335Z_reco2.root
Finished2024-11-22 22:58:53
Saved logsjustin-logs:108520.158-justin-prod-sched02.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

Run: 1 event: 18503
TuneFullTree failed.
%MSG
%MSG-e pma::Track3D:  PMAlgTrajFitter:pmtrajfittc@BeginModule  22-Nov-2024 23:57:48 CET run: 6472619 subRun: 1 event: 18503
0 enabled hits in AverageDist2 calculation.
%MSG
%MSG-e pma::Track3D:  PMAlgTrajFitter:pmtrajfittc@BeginModule  22-Nov-2024 23:57:48 CET run: 6472619 subRun: 1 event: 18503
Track empty.
%MSG
%MSG-e pma::Track3D:  PMAlgTrajFitter:pmtrajfittc@BeginModule  22-Nov-2024 23:57:48 CET run: 6472619 subRun: 1 event: 18503
TuneFullTree failed.
%MSG
%MSG-e pma::Track3D:  PMAlgTrajFitter:pmtrajfittc@BeginModule  22-Nov-2024 23:57:48 CET run: 6472619 subRun: 1 event: 18503
0 enabled hits in AverageDist2 calculation.
%MSG
%MSG-e pma::Track3D:  PMAlgTrajFitter:pmtrajfittc@BeginModule  22-Nov-2024 23:57:48 CET run: 6472619 subRun: 1 event: 18503
Track empty.
%MSG
%MSG-e pma::Track3D:  PMAlgTrajFitter:pmtrajfittc@BeginModule  22-Nov-2024 23:57:48 CET run: 6472619 subRun: 1 event: 18503
TuneFullTree failed.
%MSG
%MSG-e pma::Track3D:  PMAlgTrajFitter:pmtrajfittc@BeginModule  22-Nov-2024 23:57:48 CET run: 6472619 subRun: 1 event: 18503
Flip, endpoint closer to vStart.
%MSG
%MSG-e WireIDIntersectionCheck:  PMAlgTrajFitter:pmtrajfittc@BeginModule  22-Nov-2024 23:57:48 CET run: 6472619 subRun: 1 event: 18503
Comparing two wires in the same plane: return failure
%MSG
22-Nov-2024 23:57:48 CET  Closed input file "root://dune.dcache.nikhef.nl:1094/pnfs/nikhef.nl/data/dune/generic/rucio/fardet-hd/a2/7a/atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6472619_185_20231208T061712Z_gen_g4_detsim_hitreco__20240510T043335Z_reco2.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                            0.00113491      6.81459       16.8414       3.60123       7.24076         3     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.00109637    0.00128249    0.00161618    0.00113491    0.000236482       3     
reco:linecluster:LineCluster                           0.0108041     0.0751143     0.160443      0.0540962     0.0628715        3     
reco:trajcluster:TrajCluster                          0.00176848     0.725803       2.10334      0.0723016     0.974491         3     
reco:pandora:StandardPandora                            2.14027       2.94744       3.53493       3.16712      0.590178         3     
reco:pandoraTrack:LArPandoraTrackCreation             0.000199035    0.0117783     0.0285945    0.00654134     0.0121695        3     
reco:pandoraShower:LArPandoraModularShowerCreation    0.000614924    0.0454435     0.117147      0.0185683     0.0512292        3     
reco:pandoracalo:Calorimetry                          0.000134811    0.0184355     0.0499488    0.00522296     0.0223798        3     
reco:pandorapid:Chi2ParticleID                        5.1672e-05    0.000673081   0.00165514    0.000312436   0.00070253        3     
reco:trkshowersplit:TrackShowerHits                   0.000172992    0.0209793     0.0590201    0.00374473     0.0269384        3     
reco:pmtrack:PMAlgTrackMaker                          0.00434281      3.01974        8.497        0.55788       3.87959         3     
reco:pmtrackcalo:Calorimetry                          0.000274435    0.0222504     0.0651618    0.00131507     0.0303459        3     
reco:pmtrackpid:Chi2ParticleID                        9.4785e-05    0.000417763   0.000968506   0.000189999   0.000391369       3     
reco:pmtrajfit:PMAlgTrajFitter                        0.00607123      1.83991       3.6521        1.86156       1.48856         3     
reco:pmtrajfitcalo:Calorimetry                        0.000270365    0.0192792     0.0544882    0.00307915     0.0249229        3     
reco:pmtrajfitpid:Chi2ParticleID                      8.6043e-05    0.000234009   0.000362491   0.000253493   0.000113697       3     
reco:pmtracktc:PMAlgTrackMaker                        0.00445121      3.66139       9.96016       1.01955       4.47314         3     
reco:pmtracktccalo:Calorimetry                        0.000247548    0.0390194      0.11427     0.00254008     0.0532188        3     
reco:pmtracktcpid:Chi2ParticleID                       8.22e-05     0.000419095   0.000898716   0.000276369   0.000348284       3     
reco:pmtrajfittc:PMAlgTrajFitter                       0.0579006      3.31321       9.19385      0.687887       4.16618         3     
reco:pmtrajfittccalo:Calorimetry                      0.000281321    0.0231299     0.066541     0.00256744     0.0307105        3     
reco:pmtrajfittcpid:Chi2ParticleID                    8.5659e-05    0.000491308   0.00111786    0.000270402   0.000449416       3     
reco:blurredcluster:BlurredClustering                  0.166559      0.240632      0.314704      0.240632      0.0740722        2     
reco:emtrkmichelid:EmTrackMichelId                     0.337484       3.00242       5.66736       3.00242       2.66494         2     
reco:emshower:EMShower                                0.00184753    0.00580235    0.00975717    0.00580235    0.00395482        2     
reco:cvnmap:CVNMapper                                 4.2842e-05    0.00621794     0.012393     0.00621794     0.0061751        2     
reco:cvneva:CVNEvaluator                              2.6237e-05     0.594756       1.18949      0.594756       0.59473         2     
reco:energyrecnumu:EnergyReco                         0.00265813    0.00635426     0.0100504    0.00635426    0.00369613        2     
reco:energyrecnue:EnergyReco                          0.000225727   0.000641158   0.00105659    0.000641158   0.000415431       2     
reco:energyrecnc:EnergyReco                           0.00253083    0.00307681    0.00362278    0.00307681    0.000545974       2     
reco:energyrecnumurange:EnergyReco                    0.00256253    0.00349636    0.00443019    0.00349636    0.000933827       2     
reco:energyrecnumumcs:EnergyReco                      0.00255426    0.00508644    0.00761861    0.00508644    0.00253217        2     
reco:opdec:Deconvolution                               0.0850919     0.169458      0.253824      0.169458      0.0843659        2     
reco:ophitspe:OpHitFinderDeco                          0.570881       1.14874       1.7266        1.14874      0.577861         2     
reco:opflash:OpFlashFinder                            0.000462995   0.00255065     0.0046383    0.00255065    0.00208765        2     
reco:rns:RandomNumberSaver                             1.994e-05    0.000300251   0.000580563   0.000300251   0.000280312       2     
reco:anglereconue:NuAngularReco                       0.000197444   0.000902171    0.0016069    0.000902171   0.000704726       2     
reco:anglereconumu:NuAngularReco                      0.000146495   0.000397395   0.000648295   0.000397395    0.0002509        2     
reco:anglereconuepfps:NuAngularReco                   0.000190958   0.00155693     0.0029229    0.00155693    0.00136597        2     
reco:anglereconumupfps:NuAngularReco                  0.000169959   0.000444876   0.000719792   0.000444876   0.000274917       2     
[art]:TriggerResults:TriggerResultInserter            1.1872e-05    2.79685e-05   4.4065e-05    2.79685e-05   1.60965e-05       2     
end_path:out1:RootOutput                               2.891e-06    8.7185e-06    1.4546e-05    8.7185e-06    5.8275e-06        2     
end_path:out1:RootOutput(write)                        0.0486663     0.177829      0.306992      0.177829      0.129163         2     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 6415.44 MB
  Peak resident set size usage (VmHWM): 1666.67 MB
====================================================================================================
%MSG-s ArtException:  PostEndJob 22-Nov-2024 23:57:48 CET ModuleEndJob
---- EventProcessorFailure BEGIN
  EventProcessor: an exception occurred during current event processing
  ---- ScheduleExecutionFailure BEGIN
    Path: ProcessingStopped.
    ---- BadAlloc BEGIN
      A bad_alloc exception was thrown while processing module BlurredClustering/blurredcluster run: 6472619 subRun: 1 event: 18503
      The job has probably exhausted the virtual memory available to the process.
    ---- BadAlloc 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 2 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-b7b7-4566-2b59-5217.root
Validation_ccnc_atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6472619_185_20231208T061712Z_gen_g4_detsim_hitreco__20240510T043335Z_reco2.root
all-input-dids.txt
atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6472619_185_20231208T061712Z_gen_g4_detsim_hitreco__20240510T043335Z_reco2_reco_2024-11-22T_225537Z.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-25 08:44:31 UTC       justIN version: 01.01.09