justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID263247.4@justin-prod-sched01.dune.hep.ac.uk
Workflow ID3449
Stage ID1
User namecalcuttj@fnal.gov
HTCondor Groupgroup_dune.prod_mcsim
RequestedProcessors1
RSS bytes4193255424 (3999 MiB)
Wall seconds limit18000 (5 hours)
Submitted time2024-09-26 09:33:15
SiteFR_CCIN2P3
EntryDUNE_FR_CCIN2P3_cccondorce02
Last heartbeat2024-09-26 10:40:11
From worker nodeHostnameccwcondor0488
cpuinfoAMD EPYC 7302 16-Core Processor
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4193255424 (3999 MiB)
Wall seconds limit106200 (29 hours)
Inner Apptainer?True
Job statejobscript_error
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-09-26 09:36:07
Input fileshd-protodune:np04hd_raw_run029107_0730_dataflow6_datawriter_0_20240907T030107.hdf5
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-09-26 10:40:11
Saved logsjustin-logs:263247.4-justin-prod-sched01.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

..
681808 tests to find 345186 neighbours
Iterating with no regularization...
Begin: 1.02433e+07
0 8.83151e+06
1 8.70339e+06
2 8.68145e+06
3 8.67379e+06
Now with regularization...
Begin: 8.25745e+06
0 8.25207e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 29th record. run: 29107 subRun: 1 event: 175454 at 26-Sep-2024 12:36:11 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 64892 traces, 64892 summary
Retagger: tagging trace set: gauss with 47532 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 47532 traces tagged "gauss"
FrameSaver: q=986476 n=853248 tag=gauss
wclsFrameSaver: saving 64892 traces tagged "wiener"
FrameSaver: q=1.07965e+06 n=776962 tag=wiener
4126 hits in TPC 0
2722 hits in TPC 1
5112 hits in TPC 2
2178 hits in TPC 3
2002 hits in TPC 4
3913 hits in TPC 5
8210 hits in TPC 6
4931 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 128 XUs and 265 XVs -> 5 XUVs
C:0 T:2 12197 XUs and 26842 XVs -> 755 XUVs
C:0 T:3 51 XUs and 54 XVs -> 3 XUVs
C:0 T:4 31 XUs and 40 XVs -> 3 XUVs
C:0 T:5 27149 XUs and 21865 XVs -> 1500 XUVs
C:0 T:6 36096 XUs and 77775 XVs -> 3945 XUVs
C:0 T:7 137 XUs and 166 XVs -> 4 XUVs
6215 XUVs total
1836 collection wire objects
6215 potential space points
Neighbour search...
433039 tests to find 240500 neighbours
Iterating with no regularization...
Begin: 5.95636e+06
0 5.08098e+06
1 5.00656e+06
2 4.99376e+06
3 4.98958e+06
Now with regularization...
Begin: 4.54412e+06
0 4.54114e+06
TwoViewTransverseTracksAlgorithm: failed to calculate correlation coefficient p-value for these numbers
----view 0: 0.00255013 0.00202608 0.00114584 0.00155592 0.00133467 0.00159168 0.00205898 0.00237656 0.00208616 0.00181532 0.00199223 
----view 1: 0.00136089 0.00136662 0.00138235 0.00139427 0.00136852 0.00119543 0.00114918 0.00139856 0.00135279 0.00134182 0.00147343 
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 30th record. run: 29107 subRun: 1 event: 175462 at 26-Sep-2024 12:37:47 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 59169 traces, 59169 summary
Retagger: tagging trace set: gauss with 42986 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 42986 traces tagged "gauss"
FrameSaver: q=953138 n=786233 tag=gauss
wclsFrameSaver: saving 59169 traces tagged "wiener"
FrameSaver: q=1.02357e+06 n=708569 tag=wiener
3959 hits in TPC 0
2776 hits in TPC 1
4200 hits in TPC 2
3154 hits in TPC 3
3692 hits in TPC 4
4838 hits in TPC 5
3722 hits in TPC 6
3111 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 145 XUs and 75 XVs -> 9 XUVs
C:0 T:1 300 XUs and 328 XVs -> 26 XUVs
C:0 T:2 10709 XUs and 14593 XVs -> 2229 XUVs
C:0 T:3 562 XUs and 600 XVs -> 20 XUVs
C:0 T:4 159 XUs and 134 XVs -> 6 XUVs
C:0 T:5 15988 XUs and 14421 XVs -> 1222 XUVs
C:0 T:6 11517 XUs and 9930 XVs -> 310 XUVs
C:0 T:7 252 XUs and 202 XVs -> 10 XUVs
3832 XUVs total
1010 collection wire objects
3832 potential space points
Neighbour search...
199000 tests to find 123184 neighbours
Iterating with no regularization...
Begin: 9.01387e+06
0 8.47116e+06
1 8.41327e+06
2 8.40203e+06
3 8.39869e+06
Now with regularization...
Begin: 7.71641e+06
0 7.7139e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

26-Sep-2024 12:39:14 CEST  Closed output file "np04hd_raw_run029107_0730_dataflow6_datawriter_0_20240907T030107_reco_stage1_reco_stage2_20240926T103914_keepup.root"
26-Sep-2024 12:39:14 CEST  Closed input file "np04hd_raw_run029107_0730_dataflow6_datawriter_0_20240907T030107_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              54.6724       92.2751       149.891       91.8582       20.3392        30     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000534108    0.0027276    0.00466619    0.00288962     0.0010293       30     
produce:fembfilter:PDHDFEMBFilter                      0.532089      0.616915      0.785116      0.584562      0.0817326       30     
produce:wclsdatahd:WireCellToolkit                      35.9105       42.2457       50.6203       42.0004       4.10527        30     
produce:gaushit:GausHitFinder                          0.287986       0.64679       1.30078      0.669108      0.208009        30     
produce:nhitsfilter:NumberOfHitsFilter                0.00019053    0.000388453   0.000912383   0.000367519   0.000140633      30     
produce:reco3d:SpacePointSolver                        0.148223       1.26137       8.05777       0.88376       1.39285        30     
produce:hitpdune:DisambigFromSpacePoints               0.0924201     0.457376       1.19372      0.436044      0.259332        30     
produce:pandora:StandardPandora                         2.62614       11.1113       27.2213       10.1705        5.876         30     
produce:pandoraWriter:StandardPandora                  0.0491338     0.151453      0.317877      0.137913      0.0601389       30     
produce:pandoraTrack:LArPandoraTrackCreation           0.352589       1.12416       2.59838       1.06667      0.533872        30     
produce:pandoraShower:LArPandoraShowerCreation         0.255197        1.332        2.8189        1.24444      0.714294        30     
produce:pandoracalo:Calorimetry                        0.140129        0.532        1.15548      0.489002      0.242757        30     
produce:pandoracalonosce:Calorimetry                   0.122986      0.480413       1.13511      0.492584      0.222255        30     
produce:pandorapid:Chi2ParticleID                     0.00087884    0.00174485    0.00482785    0.00153691    0.000769385      30     
produce:pandoraShowercalo:ShowerCalorimetry            0.220661       1.14949       2.98319       1.13997      0.627023        30     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.214519       1.07225       2.71699       1.05362      0.560317        30     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.0461501     0.130213      0.237571      0.130618      0.0437903       30     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.016147      0.0433934     0.0786678     0.0417026     0.0138522       30     
produce:emtrkmichelid:EmTrackMichelId                    13.01        28.4346       46.532        28.5856       7.89265        30     
[art]:TriggerResults:TriggerResultInserter            1.7373e-05    3.42195e-05   0.000100219   2.7116e-05    1.76446e-05      30     
end_path:out1:RootOutput                               6.502e-06    8.25027e-06    2.648e-05    7.6095e-06    3.51655e-06      30     
end_path:michelremoving:michelremoving                 0.0123713     0.0858541     0.376333      0.0425691     0.0900334       30     
end_path:michelremovinggnocchi:michelremoving          0.0109354     0.0793662     0.348465      0.0397536     0.0823071       30     
end_path:calibanagnocchi:CalibAnaTree                  0.119847      0.411844      0.948459      0.386288      0.188922        30     
end_path:out1:RootOutput(write)                        0.337249      0.765855       1.46464      0.752341      0.243452        30     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4931.62 MB
  Peak resident set size usage (VmHWM): 2356.27 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029107_0730_dataflow6_datawriter_0_20240907T030107_reco_stage1_reco_stage2_20240926T103914_keepup.root
\tHists: np04hd_raw_run029107_0730_dataflow6_datawriter_0_20240907T030107_reco_stage1_reco_stage2_20240926T103914_keepup_hists.root
Forming reco metadata
/cvmfs/larsoft.opensciencegrid.org/products/python/v3_9_15/Linux64bit+3.10-2.17/bin/python: No module named meta_maker
Error in reco metadata
justIN time: 2024-09-29 11:19:09 UTC       justIN version: 01.01.08