justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID263290.14@justin-prod-sched01.dune.hep.ac.uk
Workflow ID3461
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:57:08
SiteUK_Durham
EntryDUNE_UK_SGridDurham_ce3
Last heartbeat2024-09-26 12:14:02
From worker nodeHostnamen187.dur.scotgrid.ac.uk
cpuinfoIntel(R) Xeon(R) Gold 5220 CPU @ 2.20GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4193255424 (3999 MiB)
Wall seconds limit171000 (47 hours)
Inner Apptainer?True
Job statejobscript_error
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-09-26 09:59:54
Input fileshd-protodune:np04hd_raw_run027298_0218_dataflow0_datawriter_0_20240619T150354.hdf5
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-09-26 12:14:02
Saved logsjustin-logs:263290.14-justin-prod-sched01.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

:0 T:4 32 XUs and 152 XVs -> 2 XUVs
C:0 T:5 26597 XUs and 26093 XVs -> 1875 XUVs
C:0 T:6 12973 XUs and 13156 XVs -> 836 XUVs
C:0 T:7 597 XUs and 654 XVs -> 6 XUVs
4272 XUVs total
1199 collection wire objects
4272 potential space points
Neighbour search...
222058 tests to find 117146 neighbours
Iterating with no regularization...
Begin: 4.90316e+07
0 4.4664e+07
1 4.42633e+07
2 4.42287e+07
Now with regularization...
Begin: 4.22638e+07
0 4.225e+07
TwoViewTransverseTracksAlgorithm: failed to calculate correlation coefficient p-value for these numbers
----view 0: 0.0229874 0.0278244 0.0245323 0.024704 0.0276833 0.020483 0.0243015 0.0309076 0.012248 0.012661 0.0213785 
----view 1: 0.000677109 0.00067687 0.000677109 0.00067687 0.000677109 0.00067687 0.000677109 0.000677109 0.00067687 0.000677109 0.00067687 
TwoViewTransverseTracksAlgorithm: failed to calculate correlation coefficient p-value for these numbers
----view 0: 0.0278244 0.0245323 0.024704 0.0276833 0.020483 0.0243015 0.0309076 0.012248 0.012661 0.0213785 0.0218668 
----view 1: 0.00067687 0.000677109 0.00067687 0.000677109 0.00067687 0.000677109 0.000677109 0.00067687 0.000677109 0.00067687 0.000677109 
TwoViewTransverseTracksAlgorithm: failed to calculate correlation coefficient p-value for these numbers
----view 0: 0.0245323 0.024704 0.0276833 0.020483 0.0243015 0.0309076 0.012248 0.012661 0.0213785 0.0218668 0.0112743 
----view 1: 0.000677109 0.00067687 0.000677109 0.00067687 0.000677109 0.000677109 0.00067687 0.000677109 0.00067687 0.000677109 0.000677109 
TwoViewTransverseTracksAlgorithm: failed to calculate correlation coefficient p-value for these numbers
----view 0: 0.024704 0.0276833 0.020483 0.0243015 0.0309076 0.012248 0.012661 0.0213785 0.0218668 0.0112743 0.0175858 
----view 1: 0.00067687 0.000677109 0.00067687 0.000677109 0.000677109 0.00067687 0.000677109 0.00067687 0.000677109 0.000677109 0.000677109 
TwoViewTransverseTracksAlgorithm: failed to calculate correlation coefficient p-value for these numbers
----view 0: 0.0276833 0.020483 0.0243015 0.0309076 0.012248 0.012661 0.0213785 0.0218668 0.0112743 0.0175858 0.0480728 
----view 1: 0.000677109 0.00067687 0.000677109 0.000677109 0.00067687 0.000677109 0.00067687 0.000677109 0.000677109 0.000677109 0.00067687 
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 35th record. run: 27298 subRun: 1 event: 30660 at 26-Sep-2024 12:55:32 BST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 69131 traces, 69131 summary
Retagger: tagging trace set: gauss with 52075 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 52075 traces tagged "gauss"
FrameSaver: q=1.86898e+06 n=963284 tag=gauss
wclsFrameSaver: saving 69131 traces tagged "wiener"
FrameSaver: q=2.1058e+06 n=895932 tag=wiener
4268 hits in TPC 0
6562 hits in TPC 1
6698 hits in TPC 2
2449 hits in TPC 3
4961 hits in TPC 4
6846 hits in TPC 5
6899 hits in TPC 6
3903 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 2 XUs and 23 XVs -> 0 XUVs
C:0 T:1 31039 XUs and 34495 XVs -> 3380 XUVs
C:0 T:2 27034 XUs and 37987 XVs -> 2182 XUVs
C:0 T:3 302 XUs and 265 XVs -> 3 XUVs
C:0 T:4 125 XUs and 227 XVs -> 15 XUVs
C:0 T:5 31151 XUs and 38864 XVs -> 1571 XUVs
C:0 T:6 24923 XUs and 30661 XVs -> 6921 XUVs
C:0 T:7 508 XUs and 465 XVs -> 28 XUVs
14100 XUVs total
2136 collection wire objects
14100 potential space points
Neighbour search...
1922462 tests to find 994756 neighbours
Iterating with no regularization...
Begin: 3.84875e+07
0 3.08126e+07
1 3.01131e+07
2 2.99668e+07
3 2.99183e+07
4 2.9895e+07
Now with regularization...
Begin: 2.79876e+07
0 2.7958e+07
1 2.79409e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

no of hits closeby  0   event 30660 TrkackID 2 startx, y, z 32.3472 481.985 11.503  wireno, peakt tpcno 202 1627.34 5 dist 0min T, max_T1270.06 1734.42
no of hits closeby  0   event 30660 TrkackID 2 startx, y, z 32.3472 481.985 11.503  wireno, peakt tpcno 202 1627.34 5 dist 0min T, max_T1270.06 1734.42
26-Sep-2024 12:57:37 BST  Closed output file "np04hd_raw_run027298_0218_dataflow0_datawriter_0_20240619T150354_reco_stage1_reco_stage2_20240926T115737_keepup.root"
26-Sep-2024 12:57:37 BST  Closed input file "np04hd_raw_run027298_0218_dataflow0_datawriter_0_20240619T150354_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              74.773        121.744       198.681       114.689       30.2719        35     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000413616   0.00147511    0.00519113    0.00133278    0.000971248      35     
produce:fembfilter:PDHDFEMBFilter                       0.86906        1.198        1.39657       1.28683      0.172823        35     
produce:wclsdatahd:WireCellToolkit                      42.0748       56.652        66.8658       62.5787       9.87669        35     
produce:gaushit:GausHitFinder                          0.645707       1.14527       2.15678       1.05014      0.398636        35     
produce:nhitsfilter:NumberOfHitsFilter                0.000300356   0.000461037   0.000841288   0.000430344   0.000124128      35     
produce:reco3d:SpacePointSolver                        0.199809       1.07411       2.62312       1.04253      0.557941        35     
produce:hitpdune:DisambigFromSpacePoints               0.307373      0.999855       2.73089      0.797216      0.591461        35     
produce:pandora:StandardPandora                         8.06284       20.1876       51.0198       17.5259       10.0022        35     
produce:pandoraWriter:StandardPandora                  0.124318      0.212798      0.353525      0.191729      0.0651009       35     
produce:pandoraTrack:LArPandoraTrackCreation           0.918204       2.40537       5.29499       2.23333      0.980091        35     
produce:pandoraShower:LArPandoraShowerCreation          0.92064       2.88297       6.91114       2.36927       1.50333        35     
produce:pandoracalo:Calorimetry                         0.42466       1.03508       2.38746      0.908938      0.421015        35     
produce:pandoracalonosce:Calorimetry                   0.385178      0.964224       2.2557       0.837148      0.403044        35     
produce:pandorapid:Chi2ParticleID                     0.00145976    0.00260523     0.0052723    0.00246578    0.000828523      35     
produce:pandoraShowercalo:ShowerCalorimetry            0.799558       2.51119       6.16127       2.17547       1.34465        35     
produce:pandoraShowercalonosce:ShowerCalorimetry        0.79983       2.46219       5.94877       2.15272       1.29947        35     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.0795636     0.176859      0.295109      0.179335      0.064393        35     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0342414     0.0699526     0.117159      0.0678617     0.0250558       35     
produce:emtrkmichelid:EmTrackMichelId                   15.4018       25.077        39.6686       24.7453       6.43281        35     
[art]:TriggerResults:TriggerResultInserter            3.9228e-05    5.69642e-05   0.000142538   5.1349e-05    1.94443e-05      35     
end_path:out1:RootOutput                              1.1044e-05    1.66653e-05   5.0426e-05    1.5186e-05    7.3817e-06       35     
end_path:michelremoving:michelremoving                 0.0341099     0.159444      0.946462      0.0586936     0.183858        35     
end_path:michelremovinggnocchi:michelremoving          0.0301024     0.154342      0.901581      0.0534676     0.179937        35     
end_path:calibanagnocchi:CalibAnaTree                  0.363546      0.933485       1.96576      0.899067      0.354741        35     
end_path:out1:RootOutput(write)                        0.718414       1.24401       2.07105       1.18469      0.363431        35     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5872.28 MB
  Peak resident set size usage (VmHWM): 2969.26 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run027298_0218_dataflow0_datawriter_0_20240619T150354_reco_stage1_reco_stage2_20240926T115737_keepup.root
\tHists: np04hd_raw_run027298_0218_dataflow0_datawriter_0_20240619T150354_reco_stage1_reco_stage2_20240926T115737_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 04:05:07 UTC       justIN version: 01.01.09