justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID78449.131@justin-prod-sched02.dune.hep.ac.uk
Workflow ID3447
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:53:20
SiteFR_CCIN2P3
EntryDUNE_FR_CCIN2P3_cccondorce02
Last heartbeat2024-09-26 11:13:06
From worker nodeHostnameccwcondor0636
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 10:00:41
Input fileshd-protodune:np04hd_raw_run029081_1021_dataflow4_datawriter_0_20240905T090945.hdf5
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-09-26 11:13:06
Saved logsjustin-logs:78449.131-justin-prod-sched02.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

Vs -> 1195 XUVs
C:0 T:3 158 XUs and 198 XVs -> 3 XUVs
C:0 T:4 97 XUs and 74 XVs -> 2 XUVs
C:0 T:5 40410 XUs and 33352 XVs -> 2732 XUVs
C:0 T:6 59131 XUs and 45662 XVs -> 1482 XUVs
C:0 T:7 26 XUs and 38 XVs -> 0 XUVs
5483 XUVs total
2199 collection wire objects
5483 potential space points
Neighbour search...
263039 tests to find 119136 neighbours
Iterating with no regularization...
Begin: 1.28694e+07
0 1.10009e+07
1 1.08877e+07
2 1.08708e+07
3 1.08651e+07
Now with regularization...
Begin: 1.02881e+07
0 1.02849e+07
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: 29081 subRun: 1 event: 245268 at 26-Sep-2024 13:00:00 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 82577 traces, 82577 summary
Retagger: tagging trace set: gauss with 61395 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 61395 traces tagged "gauss"
FrameSaver: q=1.30845e+06 n=1139457 tag=gauss
wclsFrameSaver: saving 82577 traces tagged "wiener"
FrameSaver: q=1.42714e+06 n=1035742 tag=wiener
3482 hits in TPC 0
4956 hits in TPC 1
8723 hits in TPC 2
5142 hits in TPC 3
4320 hits in TPC 4
7698 hits in TPC 5
6288 hits in TPC 6
4107 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 7 XUs and 11 XVs -> 0 XUVs
C:0 T:1 12857 XUs and 5742 XVs -> 97 XUVs
C:0 T:2 58262 XUs and 129177 XVs -> 6207 XUVs
C:0 T:3 237 XUs and 191 XVs -> 5 XUVs
C:0 T:4 138 XUs and 166 XVs -> 8 XUVs
C:0 T:5 55360 XUs and 64357 XVs -> 3655 XUVs
C:0 T:6 39493 XUs and 71733 XVs -> 1502 XUVs
C:0 T:7 1179 XUs and 886 XVs -> 46 XUVs
11520 XUVs total
2737 collection wire objects
11520 potential space points
Neighbour search...
1871484 tests to find 836396 neighbours
Iterating with no regularization...
Begin: 1.57418e+07
0 1.31108e+07
1 1.29289e+07
2 1.29079e+07
3 1.29016e+07
Now with regularization...
Begin: 1.21452e+07
0 1.21408e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 30th record. run: 29081 subRun: 1 event: 245276 at 26-Sep-2024 13:01:37 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 77272 traces, 77272 summary
Retagger: tagging trace set: gauss with 58214 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 58214 traces tagged "gauss"
FrameSaver: q=1.36939e+06 n=1115560 tag=gauss
wclsFrameSaver: saving 77272 traces tagged "wiener"
FrameSaver: q=1.46516e+06 n=1013474 tag=wiener
2484 hits in TPC 0
3407 hits in TPC 1
4928 hits in TPC 2
5061 hits in TPC 3
4955 hits in TPC 4
6779 hits in TPC 5
8308 hits in TPC 6
5994 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 5 XUs and 9 XVs -> 0 XUVs
C:0 T:1 233 XUs and 112 XVs -> 0 XUVs
C:0 T:2 30194 XUs and 24330 XVs -> 864 XUVs
C:0 T:3 755 XUs and 1291 XVs -> 85 XUVs
C:0 T:4 105 XUs and 209 XVs -> 50 XUVs
C:0 T:5 27322 XUs and 33809 XVs -> 5175 XUVs
C:0 T:6 36677 XUs and 24649 XVs -> 603 XUVs
C:0 T:7 2180 XUs and 10539 XVs -> 437 XUVs
7214 XUVs total
1580 collection wire objects
7214 potential space points
Neighbour search...
740140 tests to find 392384 neighbours
Iterating with no regularization...
Begin: 1.54728e+07
0 1.42849e+07
1 1.4166e+07
2 1.41444e+07
3 1.41367e+07
Now with regularization...
Begin: 1.32861e+07
0 1.32802e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

26-Sep-2024 13:03:23 CEST  Closed output file "np04hd_raw_run029081_1021_dataflow4_datawriter_0_20240905T090945_reco_stage1_reco_stage2_20240926T110323_keepup.root"
26-Sep-2024 13:03:23 CEST  Closed input file "np04hd_raw_run029081_1021_dataflow4_datawriter_0_20240905T090945_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              63.762        91.8668       161.636       87.5459       21.1528        30     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000690332   0.00310536    0.00501368    0.00354381    0.00106941       30     
produce:fembfilter:PDHDFEMBFilter                      0.505795      0.853618       7.84508      0.546029       1.30422        30     
produce:wclsdatahd:WireCellToolkit                      32.1086       35.9751       40.6317       35.7377       2.20248        30     
produce:gaushit:GausHitFinder                          0.395293      0.623935       1.17089      0.601008      0.172642        30     
produce:nhitsfilter:NumberOfHitsFilter                0.000254666   0.000353696   0.000551262   0.000330338   7.92645e-05      30     
produce:reco3d:SpacePointSolver                        0.160102      0.969984       3.63386      0.626429      0.871215        30     
produce:hitpdune:DisambigFromSpacePoints               0.137399      0.465112       1.20065      0.429188      0.253636        30     
produce:pandora:StandardPandora                         4.80434       12.4745       37.6999       11.1673       6.94133        30     
produce:pandoraWriter:StandardPandora                  0.0955536     0.144186      0.247121      0.143838      0.0384387       30     
produce:pandoraTrack:LArPandoraTrackCreation           0.630997       1.80548       4.37977       1.5609       0.954189        30     
produce:pandoraShower:LArPandoraShowerCreation          0.46125       2.36932       8.12285       1.77553       1.60117        30     
produce:pandoracalo:Calorimetry                        0.280884      0.844148       2.20535      0.706692      0.463078        30     
produce:pandoracalonosce:Calorimetry                   0.305658      0.808696       2.16011      0.671421      0.463637        30     
produce:pandorapid:Chi2ParticleID                      0.0012349    0.00188205    0.00372265    0.00169869    0.000585953      30     
produce:pandoraShowercalo:ShowerCalorimetry             0.48397       2.1251        6.1441        1.75912       1.34562        30     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.593428       1.96406       5.68328       1.64348       1.2332         30     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.0670602     0.112819      0.174639      0.117894      0.027965        30     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0232735     0.0429922     0.0728088     0.0435223     0.0112895       30     
produce:emtrkmichelid:EmTrackMichelId                   19.2859       28.6077       48.7573       27.4653       6.92189        30     
[art]:TriggerResults:TriggerResultInserter            2.4866e-05    6.02855e-05   0.00011184     5.876e-05    1.72501e-05      30     
end_path:out1:RootOutput                               9.417e-06    1.66626e-05   4.0526e-05    1.5645e-05    6.08873e-06      30     
end_path:michelremoving:michelremoving                 0.0160878     0.0964803     0.309832      0.0623589     0.078889        30     
end_path:michelremovinggnocchi:michelremoving          0.0151614     0.0954495     0.387008      0.0692815     0.0882589       30     
end_path:calibanagnocchi:CalibAnaTree                  0.212414      0.612999       1.56833      0.443164      0.319099        30     
end_path:out1:RootOutput(write)                        0.428052      0.658907       1.08527      0.677177        0.143         30     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4966.59 MB
  Peak resident set size usage (VmHWM): 2320.29 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029081_1021_dataflow4_datawriter_0_20240905T090945_reco_stage1_reco_stage2_20240926T110323_keepup.root
\tHists: np04hd_raw_run029081_1021_dataflow4_datawriter_0_20240905T090945_reco_stage1_reco_stage2_20240926T110323_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:20:18 UTC       justIN version: 01.01.08