justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID78440.105@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:39:18
SiteFR_CCIN2P3
EntryDUNE_FR_CCIN2P3_cccondorce03
Last heartbeat2024-09-26 11:26:16
From worker nodeHostnameccwcondor0601
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:55:46
Input fileshd-protodune:np04hd_raw_run029081_0427_dataflow1_datawriter_0_20240904T234442.hdf5
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-09-26 11:26:16
Saved logsjustin-logs:78440.105-justin-prod-sched02.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

906 hits in TPC 4
4770 hits in TPC 5
5174 hits in TPC 6
2346 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 322 XUs and 214 XVs -> 13 XUVs
C:0 T:2 51261 XUs and 58354 XVs -> 2164 XUVs
C:0 T:3 131 XUs and 132 XVs -> 5 XUVs
C:0 T:4 112 XUs and 112 XVs -> 4 XUVs
C:0 T:5 17195 XUs and 12719 XVs -> 807 XUVs
C:0 T:6 48299 XUs and 44687 XVs -> 1374 XUVs
C:0 T:7 370 XUs and 270 XVs -> 19 XUVs
4386 XUVs total
1433 collection wire objects
4386 potential space points
Neighbour search...
347516 tests to find 174026 neighbours
Iterating with no regularization...
Begin: 5.54189e+06
0 4.80319e+06
1 4.75763e+06
2 4.74598e+06
3 4.74251e+06
Now with regularization...
Begin: 4.49622e+06
0 4.49395e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 29th record. run: 29081 subRun: 1 event: 102705 at 26-Sep-2024 12:52:05 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 69411 traces, 69411 summary
Retagger: tagging trace set: gauss with 49600 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 49600 traces tagged "gauss"
FrameSaver: q=1.08519e+06 n=903877 tag=gauss
wclsFrameSaver: saving 69411 traces tagged "wiener"
FrameSaver: q=1.20247e+06 n=820706 tag=wiener
3759 hits in TPC 0
2089 hits in TPC 1
6606 hits in TPC 2
4627 hits in TPC 3
2065 hits in TPC 4
3614 hits in TPC 5
8731 hits in TPC 6
4850 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 1136 XUs and 1339 XVs -> 131 XUVs
C:0 T:2 34451 XUs and 46440 XVs -> 1160 XUVs
C:0 T:3 36 XUs and 51 XVs -> 4 XUVs
C:0 T:4 74 XUs and 110 XVs -> 2 XUVs
C:0 T:5 7026 XUs and 35265 XVs -> 425 XUVs
C:0 T:6 42712 XUs and 69023 XVs -> 3731 XUVs
C:0 T:7 97 XUs and 200 XVs -> 10 XUVs
5463 XUVs total
2004 collection wire objects
5463 potential space points
Neighbour search...
313147 tests to find 159976 neighbours
Iterating with no regularization...
Begin: 1.34908e+07
0 1.13715e+07
1 1.1217e+07
2 1.12012e+07
3 1.11974e+07
Now with regularization...
Begin: 1.06972e+07
0 1.06953e+07
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

no of hits closeby  4   event 102705 TrkackID 11 startx, y, z 4.1835 587.815 220.345  wireno, peakt tpcno 408 2181.56 1 dist 93.5085min T, max_T1952.35 2301.64
no of hits closeby  4   event 102705 TrkackID 11 startx, y, z 4.1835 587.815 220.345  wireno, peakt tpcno 408 2181.56 1 dist 93.5085min T, max_T1952.35 2301.64
Begin processing the 30th record. run: 29081 subRun: 1 event: 102769 at 26-Sep-2024 12:53:23 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 40843 traces, 40843 summary
Retagger: tagging trace set: gauss with 31884 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 31884 traces tagged "gauss"
FrameSaver: q=693781 n=657626 tag=gauss
wclsFrameSaver: saving 40843 traces tagged "wiener"
FrameSaver: q=748468 n=609854 tag=wiener
2223 hits in TPC 0
4212 hits in TPC 1
2307 hits in TPC 2
2585 hits in TPC 3
1515 hits in TPC 4
3912 hits in TPC 5
5310 hits in TPC 6
2500 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 157 XUs and 116 XVs -> 2 XUVs
C:0 T:2 3684 XUs and 3926 XVs -> 239 XUVs
C:0 T:3 204 XUs and 385 XVs -> 13 XUVs
C:0 T:4 3 XUs and 6 XVs -> 0 XUVs
C:0 T:5 21051 XUs and 61055 XVs -> 1282 XUVs
C:0 T:6 11862 XUs and 9164 XVs -> 474 XUVs
C:0 T:7 27 XUs and 38 XVs -> 5 XUVs
2015 XUVs total
860 collection wire objects
2015 potential space points
Neighbour search...
119785 tests to find 64498 neighbours
Iterating with no regularization...
Begin: 9.83276e+06
0 9.40989e+06
1 9.38371e+06
2 9.38011e+06
Now with regularization...
Begin: 8.91508e+06
0 8.91358e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

26-Sep-2024 12:54:25 CEST  Closed output file "np04hd_raw_run029081_0427_dataflow1_datawriter_0_20240904T234442_reco_stage1_reco_stage2_20240926T105425_keepup.root"
26-Sep-2024 12:54:25 CEST  Closed input file "np04hd_raw_run029081_0427_dataflow1_datawriter_0_20240904T234442_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              61.337        81.751        120.032       77.0478       14.6282        30     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.00045489    0.00257146    0.00506291    0.00266796    0.00124653       30     
produce:fembfilter:PDHDFEMBFilter                      0.492602      0.535243      0.657632      0.517018      0.0413518       30     
produce:wclsdatahd:WireCellToolkit                      31.9042       34.7089       40.3514       33.8519       2.07674        30     
produce:gaushit:GausHitFinder                          0.293976      0.554474      0.893648      0.534064      0.151958        30     
produce:nhitsfilter:NumberOfHitsFilter                0.000210303   0.00031079    0.000598278   0.000293343   7.9047e-05       30     
produce:reco3d:SpacePointSolver                        0.229514       1.07877       4.10837      0.779782      0.864228        30     
produce:hitpdune:DisambigFromSpacePoints               0.150744      0.409959       1.17245      0.353513       0.20938        30     
produce:pandora:StandardPandora                         3.93077       9.88983       21.9944       8.79444       4.07462        30     
produce:pandoraWriter:StandardPandora                  0.0822333     0.127401      0.239672       0.11827      0.0325944       30     
produce:pandoraTrack:LArPandoraTrackCreation           0.688922       1.33424       2.86099       1.15452      0.501901        30     
produce:pandoraShower:LArPandoraShowerCreation         0.641009       1.64966       4.7389        1.33374      0.921121        30     
produce:pandoracalo:Calorimetry                        0.334259      0.646692       1.65236      0.584325      0.272383        30     
produce:pandoracalonosce:Calorimetry                   0.325559      0.585414       1.48593      0.511811      0.254128        30     
produce:pandorapid:Chi2ParticleID                     0.00120311    0.00170321    0.00509832    0.00147012    0.000728478      30     
produce:pandoraShowercalo:ShowerCalorimetry            0.466323       1.41495       3.82376       1.16052      0.749741        30     
produce:pandoraShowercalonosce:ShowerCalorimetry        0.42816       1.3482        3.95682       1.1185       0.711258        30     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.0551295     0.102498      0.221249      0.0914641     0.0330367       30     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0238813     0.0386424     0.0677818     0.0371042    0.00959843       30     
produce:emtrkmichelid:EmTrackMichelId                   17.1894       25.8688       40.9483       24.1037       5.98119        30     
[art]:TriggerResults:TriggerResultInserter            3.3532e-05    6.16527e-05   0.000148567   5.1902e-05    2.64519e-05      30     
end_path:out1:RootOutput                               1.033e-05    1.64325e-05   5.0554e-05    1.47175e-05   7.13115e-06      30     
end_path:michelremoving:michelremoving                 0.0177621     0.0854507     0.422454      0.0455068     0.0815551       30     
end_path:michelremovinggnocchi:michelremoving          0.0174973      0.07845      0.405916      0.0369673     0.0786432       30     
end_path:calibanagnocchi:CalibAnaTree                  0.208928      0.459046       1.00386      0.424879      0.153806        30     
end_path:out1:RootOutput(write)                        0.382124      0.603625      0.967316      0.584449      0.135331        30     
========================================================================================================================================

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

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