justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID263262.45@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:48:34
SiteFR_CCIN2P3
EntryDUNE_FR_CCIN2P3_cccondorce02
Last heartbeat2024-09-26 11:07:27
From worker nodeHostnameccwcondor0583
cpuinfoAMD EPYC 7453 28-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:49:34
Input fileshd-protodune:np04hd_raw_run029107_0837_dataflow1_datawriter_0_20240907T042612.hdf5
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-09-26 11:07:27
Saved logsjustin-logs:263262.45-justin-prod-sched01.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

:3 240 XUs and 187 XVs -> 5 XUVs
C:0 T:4 152 XUs and 214 XVs -> 18 XUVs
C:0 T:5 45663 XUs and 52311 XVs -> 1934 XUVs
C:0 T:6 30764 XUs and 16768 XVs -> 379 XUVs
C:0 T:7 110 XUs and 126 XVs -> 4 XUVs
2961 XUVs total
1303 collection wire objects
2961 potential space points
Neighbour search...
70785 tests to find 44636 neighbours
Iterating with no regularization...
Begin: 6.34362e+06
0 5.94422e+06
1 5.91984e+06
2 5.91495e+06
Now with regularization...
Begin: 5.51956e+06
0 5.51746e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

no of hits closeby  1   event 201121 TrkackID 10 startx, y, z 181.61 601.351 369.305  wireno, peakt tpcno 455 4910.93 5 dist 0min T, max_T3443.52 5753
no of hits closeby  1   event 201121 TrkackID 10 startx, y, z 181.61 601.351 369.305  wireno, peakt tpcno 455 4910.93 5 dist 0min T, max_T3443.52 5753
Begin processing the 29th record. run: 29107 subRun: 1 event: 201129 at 26-Sep-2024 12:54:41 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 80760 traces, 80760 summary
Retagger: tagging trace set: gauss with 58690 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 58690 traces tagged "gauss"
FrameSaver: q=1.35404e+06 n=1051874 tag=gauss
wclsFrameSaver: saving 80760 traces tagged "wiener"
FrameSaver: q=1.47227e+06 n=946341 tag=wiener
5127 hits in TPC 0
4310 hits in TPC 1
7379 hits in TPC 2
5325 hits in TPC 3
3616 hits in TPC 4
6232 hits in TPC 5
5626 hits in TPC 6
3745 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 1866 XUs and 975 XVs -> 91 XUVs
C:0 T:2 25309 XUs and 31366 XVs -> 1104 XUVs
C:0 T:3 170 XUs and 148 XVs -> 0 XUVs
C:0 T:4 15 XUs and 23 XVs -> 0 XUVs
C:0 T:5 55681 XUs and 44841 XVs -> 3331 XUVs
C:0 T:6 21161 XUs and 21402 XVs -> 807 XUVs
C:0 T:7 509 XUs and 411 XVs -> 3 XUVs
5336 XUVs total
1693 collection wire objects
5336 potential space points
Neighbour search...
236886 tests to find 118496 neighbours
Iterating with no regularization...
Begin: 2.8198e+07
0 2.12818e+07
1 2.08387e+07
2 2.07578e+07
3 2.0733e+07
4 2.0722e+07
Now with regularization...
Begin: 1.97258e+07
0 1.97166e+07
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: 201137 at 26-Sep-2024 12:56:09 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 53931 traces, 53931 summary
Retagger: tagging trace set: gauss with 38808 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 38808 traces tagged "gauss"
FrameSaver: q=786321 n=661718 tag=gauss
wclsFrameSaver: saving 53931 traces tagged "wiener"
FrameSaver: q=856595 n=597452 tag=wiener
4256 hits in TPC 0
3733 hits in TPC 1
4187 hits in TPC 2
2573 hits in TPC 3
1780 hits in TPC 4
3242 hits in TPC 5
3779 hits in TPC 6
2188 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 9201 XUs and 7991 XVs -> 194 XUVs
C:0 T:2 8963 XUs and 11942 XVs -> 411 XUVs
C:0 T:3 308 XUs and 352 XVs -> 25 XUVs
C:0 T:4 25 XUs and 43 XVs -> 0 XUVs
C:0 T:5 7109 XUs and 6293 XVs -> 179 XUVs
C:0 T:6 12424 XUs and 19930 XVs -> 499 XUVs
C:0 T:7 6 XUs and 4 XVs -> 0 XUVs
1308 XUVs total
649 collection wire objects
1308 potential space points
Neighbour search...
34782 tests to find 19352 neighbours
Iterating with no regularization...
Begin: 6.68129e+06
0 6.46518e+06
1 6.45858e+06
2 6.45809e+06
Now with regularization...
Begin: 6.12015e+06
0 6.11992e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

26-Sep-2024 12:57:09 CEST  Closed output file "np04hd_raw_run029107_0837_dataflow1_datawriter_0_20240907T042612_reco_stage1_reco_stage2_20240926T105709_keepup.root"
26-Sep-2024 12:57:09 CEST  Closed input file "np04hd_raw_run029107_0837_dataflow1_datawriter_0_20240907T042612_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              59.3599       96.523        163.809       98.869        22.3425        30     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000517807   0.00298506    0.00518563    0.00309482    0.00117497       30     
produce:fembfilter:PDHDFEMBFilter                      0.499488      0.636124      0.890896       0.64619       0.11083        30     
produce:wclsdatahd:WireCellToolkit                      31.5205       39.2794       46.5404       41.9351       4.99567        30     
produce:gaushit:GausHitFinder                          0.327246      0.654524        1.006        0.60313       0.18542        30     
produce:nhitsfilter:NumberOfHitsFilter                0.000253003   0.000341996   0.000554866   0.000332195   7.52439e-05      30     
produce:reco3d:SpacePointSolver                        0.215988       1.82251       8.57191       1.17519       1.93913        30     
produce:hitpdune:DisambigFromSpacePoints               0.153642      0.531273       1.1888       0.437062      0.315174        30     
produce:pandora:StandardPandora                         4.92821       12.3192       27.648        12.0415       5.45917        30     
produce:pandoraWriter:StandardPandora                  0.0772789     0.148766      0.293162      0.136491      0.0468461       30     
produce:pandoraTrack:LArPandoraTrackCreation           0.582425       1.70496       3.80007       1.60837      0.767209        30     
produce:pandoraShower:LArPandoraShowerCreation         0.543922       2.12803       5.5891        2.01225       1.12452        30     
produce:pandoracalo:Calorimetry                        0.319934      0.814231       1.68451      0.723729      0.320025        30     
produce:pandoracalonosce:Calorimetry                   0.272102      0.769532       1.80565       0.69882      0.337298        30     
produce:pandorapid:Chi2ParticleID                     0.00118965    0.00199302    0.00404064    0.00173999    0.000641227      30     
produce:pandoraShowercalo:ShowerCalorimetry            0.446867       1.88192       5.58513       1.86967       1.06774        30     
produce:pandoraShowercalonosce:ShowerCalorimetry        0.42877       1.80178       5.04495       1.75584      0.989389        30     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.0705306     0.136926      0.265289      0.126152      0.0466953       30     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0232457     0.0473708     0.0932726     0.0424782     0.0163934       30     
produce:emtrkmichelid:EmTrackMichelId                   17.8988       30.1819       55.031        29.9122       8.03538        30     
[art]:TriggerResults:TriggerResultInserter            2.6971e-05    6.26555e-05   0.000102481   6.48165e-05   1.69587e-05      30     
end_path:out1:RootOutput                               7.815e-06    1.52897e-05   3.2171e-05    1.4943e-05    4.6556e-06       30     
end_path:michelremoving:michelremoving                 0.0183655     0.0961409     0.449421      0.0469539     0.107037        30     
end_path:michelremovinggnocchi:michelremoving          0.0167298     0.0909913     0.444333      0.0447811      0.1009         30     
end_path:calibanagnocchi:CalibAnaTree                  0.212811      0.569352       1.49321      0.474779      0.285197        30     
end_path:out1:RootOutput(write)                        0.366813      0.705451       1.19609      0.662431      0.192038        30     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4926.61 MB
  Peak resident set size usage (VmHWM): 2343.67 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029107_0837_dataflow1_datawriter_0_20240907T042612_reco_stage1_reco_stage2_20240926T105709_keepup.root
\tHists: np04hd_raw_run029107_0837_dataflow1_datawriter_0_20240907T042612_reco_stage1_reco_stage2_20240926T105709_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-11-17 05:15:42 UTC       justIN version: 01.01.09