justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID263236.135@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:30:33
SiteFR_CCIN2P3
EntryDUNE_FR_CCIN2P3_cccondorce02
Last heartbeat2024-09-26 10:50:57
From worker nodeHostnameccwcondor0630
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:31:54
Input fileshd-protodune:np04hd_raw_run029107_0462_dataflow3_datawriter_0_20240906T232526.hdf5
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-09-26 10:50:57
Saved logsjustin-logs:263236.135-justin-prod-sched01.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

XVs -> 325 XUVs
C:0 T:6 5071 XUs and 4584 XVs -> 215 XUVs
C:0 T:7 142 XUs and 272 XVs -> 3 XUVs
1444 XUVs total
728 collection wire objects
1444 potential space points
Neighbour search...
41684 tests to find 26492 neighbours
Iterating with no regularization...
Begin: 2.1455e+06
0 1.87133e+06
1 1.85242e+06
2 1.84943e+06
3 1.84847e+06
Now with regularization...
Begin: 1.68896e+06
0 1.68841e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 29th record. run: 29107 subRun: 1 event: 111131 at 26-Sep-2024 12:35:42 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 79420 traces, 79420 summary
Retagger: tagging trace set: gauss with 57832 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 57832 traces tagged "gauss"
FrameSaver: q=1.37049e+06 n=1081126 tag=gauss
wclsFrameSaver: saving 79420 traces tagged "wiener"
FrameSaver: q=1.47894e+06 n=980248 tag=wiener
1847 hits in TPC 0
445 hits in TPC 1
7275 hits in TPC 2
5770 hits in TPC 3
4909 hits in TPC 4
5463 hits in TPC 5
9914 hits in TPC 6
5214 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 35 XUs and 22 XVs -> 0 XUVs
C:0 T:2 29322 XUs and 46186 XVs -> 2086 XUVs
C:0 T:3 63 XUs and 112 XVs -> 5 XUVs
C:0 T:4 37 XUs and 47 XVs -> 1 XUVs
C:0 T:5 17578 XUs and 18881 XVs -> 863 XUVs
C:0 T:6 32785 XUs and 42299 XVs -> 871 XUVs
C:0 T:7 353 XUs and 426 XVs -> 9 XUVs
3835 XUVs total
2090 collection wire objects
3835 potential space points
Neighbour search...
85343 tests to find 49116 neighbours
Iterating with no regularization...
Begin: 1.32871e+07
0 1.2421e+07
1 1.23627e+07
2 1.2357e+07
Now with regularization...
Begin: 1.15982e+07
0 1.15959e+07
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

no of hits closeby  1   event 111131 TrkackID 14 startx, y, z 14.7464 589.756 330.305  wireno, peakt tpcno 11 11.1041 5 dist 0.313561min T, max_T2.13754 1548.7
no of hits closeby  1   event 111131 TrkackID 14 startx, y, z 14.7464 589.756 330.305  wireno, peakt tpcno 11 11.1041 5 dist 0.313561min T, max_T2.13754 1548.7
Begin processing the 30th record. run: 29107 subRun: 1 event: 111139 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 95937 traces, 95937 summary
Retagger: tagging trace set: gauss with 69963 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 69963 traces tagged "gauss"
FrameSaver: q=1.64945e+06 n=1304808 tag=gauss
wclsFrameSaver: saving 95937 traces tagged "wiener"
FrameSaver: q=1.79815e+06 n=1177516 tag=wiener
6308 hits in TPC 0
10343 hits in TPC 1
9427 hits in TPC 2
5970 hits in TPC 3
4688 hits in TPC 4
6757 hits in TPC 5
5741 hits in TPC 6
3280 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 6 XUs and 7 XVs -> 0 XUVs
C:0 T:1 9347 XUs and 7836 XVs -> 556 XUVs
C:0 T:2 47556 XUs and 69738 XVs -> 1450 XUVs
C:0 T:3 197 XUs and 288 XVs -> 6 XUVs
C:0 T:4 1359 XUs and 5443 XVs -> 299 XUVs
C:0 T:5 24760 XUs and 50985 XVs -> 931 XUVs
C:0 T:6 22445 XUs and 26561 XVs -> 1155 XUVs
C:0 T:7 159 XUs and 339 XVs -> 8 XUVs
4405 XUVs total
2069 collection wire objects
4405 potential space points
Neighbour search...
207799 tests to find 93996 neighbours
Iterating with no regularization...
Begin: 2.77592e+07
0 2.59577e+07
1 2.58175e+07
2 2.58058e+07
Now with regularization...
Begin: 2.50968e+07
0 2.50919e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLArTPCIntercepts - inconsistent number of intercepts between a line and the LArTPC
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

26-Sep-2024 12:40:27 CEST  Closed output file "np04hd_raw_run029107_0462_dataflow3_datawriter_0_20240906T232526_reco_stage1_reco_stage2_20240926T104027_keepup.root"
26-Sep-2024 12:40:27 CEST  Closed input file "np04hd_raw_run029107_0462_dataflow3_datawriter_0_20240906T232526_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              59.3803       102.498       162.853       101.296       22.6885        30     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000582211   0.00308782    0.00772181    0.00320549    0.00145789       30     
produce:fembfilter:PDHDFEMBFilter                       0.52905      0.686259      0.821466      0.690579      0.0718164       30     
produce:wclsdatahd:WireCellToolkit                      36.491         42.46        51.4366       43.1031       3.11315        30     
produce:gaushit:GausHitFinder                          0.446776      0.902004       5.39308      0.739748      0.852796        30     
produce:nhitsfilter:NumberOfHitsFilter                0.000257452   0.000472149   0.00237029    0.000371225   0.000397081      30     
produce:reco3d:SpacePointSolver                        0.232745       1.51534       8.68444       1.00952       1.65765        29     
produce:hitpdune:DisambigFromSpacePoints               0.169844      0.651256       1.87971      0.576073      0.376128        29     
produce:pandora:StandardPandora                         5.65337       12.9343       31.3905       11.1683       5.95771        29     
produce:pandoraWriter:StandardPandora                  0.100114      0.170488      0.278349      0.155728      0.0463967       29     
produce:pandoraTrack:LArPandoraTrackCreation           0.703524       2.05291       4.74791       1.89509      0.942581        29     
produce:pandoraShower:LArPandoraShowerCreation         0.551472       2.61375       7.51878        2.271        1.61128        29     
produce:pandoracalo:Calorimetry                        0.338885      0.948852       2.57071       0.87958      0.458159        29     
produce:pandoracalonosce:Calorimetry                   0.348288      0.886018       1.78875      0.847639      0.379041        29     
produce:pandorapid:Chi2ParticleID                     0.00150719    0.00233211    0.00508356    0.00227345    0.000649643      29     
produce:pandoraShowercalo:ShowerCalorimetry            0.448134       2.16595       6.09983       1.90443       1.29043        29     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.424873       2.08901       5.94619       1.75869       1.24377        29     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.0632798     0.143945      0.240313      0.146955      0.0432271       29     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.029733      0.0549722     0.0891006     0.0566622     0.0165128       29     
produce:emtrkmichelid:EmTrackMichelId                   17.6068       32.3272       48.8894       31.7652       6.85117        29     
[art]:TriggerResults:TriggerResultInserter            4.3441e-05    7.63196e-05   0.000142026   7.6218e-05    1.77994e-05      30     
end_path:out1:RootOutput                              1.1321e-05    2.11264e-05   3.4294e-05    2.0704e-05    4.26446e-06      30     
end_path:michelremoving:michelremoving                 6.43e-05      0.0953374     0.415592      0.0518585     0.094242        30     
end_path:michelremovinggnocchi:michelremoving          6.96e-05      0.0893106     0.415496      0.0441992     0.0947172       30     
end_path:calibanagnocchi:CalibAnaTree                 5.4722e-05     0.634223       1.62858       0.56512      0.363207        30     
end_path:out1:RootOutput(write)                        0.455323       0.79657       1.59549      0.758995      0.240042        30     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5032.51 MB
  Peak resident set size usage (VmHWM): 2451.35 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029107_0462_dataflow3_datawriter_0_20240906T232526_reco_stage1_reco_stage2_20240926T104027_keepup.root
\tHists: np04hd_raw_run029107_0462_dataflow3_datawriter_0_20240906T232526_reco_stage1_reco_stage2_20240926T104027_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:11:21 UTC       justIN version: 01.01.09