justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID263262.46@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_cccondorce03
Last heartbeat2024-09-26 11:10:10
From worker nodeHostnameccwcondor0788
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:35
Input fileshd-protodune:np04hd_raw_run029107_0816_dataflow6_datawriter_0_20240907T040926.hdf5
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-09-26 11:10:10
Saved logsjustin-logs:263262.46-justin-prod-sched01.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

4388e+06
2 8.3358e+06
Now with regularization...
Begin: 7.80855e+06
0 7.80602e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 29th record. run: 29107 subRun: 1 event: 196094 at 26-Sep-2024 12:58:38 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 60524 traces, 60524 summary
Retagger: tagging trace set: gauss with 47023 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 47023 traces tagged "gauss"
FrameSaver: q=993554 n=887303 tag=gauss
wclsFrameSaver: saving 60524 traces tagged "wiener"
FrameSaver: q=1.06895e+06 n=819205 tag=wiener
5133 hits in TPC 0
4809 hits in TPC 1
4230 hits in TPC 2
2004 hits in TPC 3
4229 hits in TPC 4
4612 hits in TPC 5
4423 hits in TPC 6
2797 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 7101 XUs and 9014 XVs -> 758 XUVs
C:0 T:2 5973 XUs and 7099 XVs -> 300 XUVs
C:0 T:3 148 XUs and 111 XVs -> 2 XUVs
C:0 T:4 101 XUs and 117 XVs -> 7 XUVs
C:0 T:5 11120 XUs and 10671 XVs -> 650 XUVs
C:0 T:6 10229 XUs and 7471 XVs -> 211 XUVs
C:0 T:7 103 XUs and 93 XVs -> 0 XUVs
1928 XUVs total
838 collection wire objects
1928 potential space points
Neighbour search...
79456 tests to find 50292 neighbours
Iterating with no regularization...
Begin: 6.6023e+06
0 6.37085e+06
1 6.36147e+06
2 6.35987e+06
Now with regularization...
Begin: 6.01564e+06
0 6.01535e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

no of hits closeby  0   event 196094 TrkackID 0 startx, y, z 121.09 419.481 4.52006  wireno, peakt tpcno 462 4129.58 5 dist 0min T, max_T3326.25 4874.69
no of hits closeby  6   event 196094 TrkackID 4 startx, y, z 199.693 602.793 392.821  wireno, peakt tpcno 266 3270 5 dist 2.35859min T, max_T1991.38 4534.68
no of hits closeby  0   event 196094 TrkackID 0 startx, y, z 121.09 419.481 4.52006  wireno, peakt tpcno 462 4129.58 5 dist 0min T, max_T3326.25 4874.69
no of hits closeby  6   event 196094 TrkackID 4 startx, y, z 199.693 602.793 392.821  wireno, peakt tpcno 266 3270 5 dist 2.35859min T, max_T1991.38 4534.68
Begin processing the 30th record. run: 29107 subRun: 1 event: 196110 at 26-Sep-2024 12:59:52 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 61585 traces, 61585 summary
Retagger: tagging trace set: gauss with 47162 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 47162 traces tagged "gauss"
FrameSaver: q=1.08781e+06 n=922668 tag=gauss
wclsFrameSaver: saving 61585 traces tagged "wiener"
FrameSaver: q=1.15853e+06 n=841007 tag=wiener
2801 hits in TPC 0
4662 hits in TPC 1
3933 hits in TPC 2
3088 hits in TPC 3
4052 hits in TPC 4
7020 hits in TPC 5
4491 hits in TPC 6
3439 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 9 XUs and 4 XVs -> 0 XUVs
C:0 T:1 508 XUs and 447 XVs -> 22 XUVs
C:0 T:2 9848 XUs and 9519 XVs -> 286 XUVs
C:0 T:3 51 XUs and 29 XVs -> 0 XUVs
C:0 T:4 175 XUs and 284 XVs -> 1 XUVs
C:0 T:5 14542 XUs and 26091 XVs -> 1375 XUVs
C:0 T:6 9585 XUs and 12692 XVs -> 287 XUVs
C:0 T:7 347 XUs and 470 XVs -> 33 XUVs
2004 XUVs total
1247 collection wire objects
2004 potential space points
Neighbour search...
33230 tests to find 19210 neighbours
Iterating with no regularization...
Begin: 6.99598e+06
0 6.5967e+06
1 6.57692e+06
2 6.57542e+06
Now with regularization...
Begin: 6.05672e+06
0 6.05629e+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--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

26-Sep-2024 13:01:08 CEST  Closed output file "np04hd_raw_run029107_0816_dataflow6_datawriter_0_20240907T040926_reco_stage1_reco_stage2_20240926T110108_keepup.root"
26-Sep-2024 13:01:08 CEST  Closed input file "np04hd_raw_run029107_0816_dataflow6_datawriter_0_20240907T040926_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              73.5006       112.258       205.213       104.851       32.2638        30     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000531774   0.00348294    0.00606125    0.00388437    0.00142672       30     
produce:fembfilter:PDHDFEMBFilter                      0.498884      0.711103       1.03528      0.735276      0.109347        30     
produce:wclsdatahd:WireCellToolkit                      33.8053       41.2989       47.0665       42.8648       3.77297        30     
produce:gaushit:GausHitFinder                          0.420362      0.793487       1.36415       0.72741      0.239164        30     
produce:nhitsfilter:NumberOfHitsFilter                0.000243456   0.00037199    0.000501698   0.000369857   7.29606e-05      30     
produce:reco3d:SpacePointSolver                        0.303806       1.36717       3.27981       1.1242       0.896017        30     
produce:hitpdune:DisambigFromSpacePoints               0.207963       0.70482       1.75551      0.551283      0.413478        30     
produce:pandora:StandardPandora                         6.14577        17.23        55.0507       14.5316       10.3104        30     
produce:pandoraWriter:StandardPandora                  0.111934      0.184436      0.338676      0.174121      0.0525227       30     
produce:pandoraTrack:LArPandoraTrackCreation            0.57647       2.4776        6.35639       2.16945       1.41214        30     
produce:pandoraShower:LArPandoraShowerCreation         0.422484       3.30279       12.1478       2.48825       2.36832        30     
produce:pandoracalo:Calorimetry                        0.274346       1.12993       3.52757      0.818885      0.686195        30     
produce:pandoracalonosce:Calorimetry                   0.192574       1.05359       3.23298      0.807304      0.690634        30     
produce:pandorapid:Chi2ParticleID                     0.00109526    0.00228863     0.0038738    0.00221458    0.000723986      30     
produce:pandoraShowercalo:ShowerCalorimetry            0.410352       2.76333       11.6434       2.20294       2.10719        30     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.377442       2.55618       10.8497       2.01436       2.06237        30     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.0733921     0.155338      0.292222      0.146922      0.059616        30     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0194004     0.0588648     0.121828      0.0606692     0.0226841       30     
produce:emtrkmichelid:EmTrackMichelId                   17.6343       34.3328       63.0149       33.6084       9.68318        30     
[art]:TriggerResults:TriggerResultInserter            4.0325e-05    7.29988e-05   0.000125846    6.936e-05    1.63014e-05      30     
end_path:out1:RootOutput                              1.1512e-05    1.94461e-05    3.751e-05    1.9311e-05    6.10463e-06      30     
end_path:michelremoving:michelremoving                 0.0249946      0.12213      0.349006      0.0642091     0.0962577       30     
end_path:michelremovinggnocchi:michelremoving          0.0196415     0.115391      0.372372      0.0652728     0.0924607       30     
end_path:calibanagnocchi:CalibAnaTree                  0.230226      0.820323       2.2152       0.694021      0.462972        30     
end_path:out1:RootOutput(write)                        0.494189      0.833503       1.41828       0.77946      0.236187        30     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4969.8 MB
  Peak resident set size usage (VmHWM): 2390.5 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029107_0816_dataflow6_datawriter_0_20240907T040926_reco_stage1_reco_stage2_20240926T110108_keepup.root
\tHists: np04hd_raw_run029107_0816_dataflow6_datawriter_0_20240907T040926_reco_stage1_reco_stage2_20240926T110108_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 09:24:33 UTC       justIN version: 01.01.08