justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID263339.85@justin-prod-sched01.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 10:13:47
SiteUK_Sheffield
EntryDUNE_UK_Sheffield_lcgce1
Last heartbeat2024-09-26 12:20:01
From worker nodeHostnamewn035.hep
cpuinfoAMD EPYC 7352 24-Core Processor
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4193255424 (3999 MiB)
Wall seconds limit257400 (71 hours)
Inner Apptainer?True
Job stateoutputting_failed
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-09-26 10:45:10
Input fileshd-protodune:np04hd_raw_run029081_0578_dataflow6_datawriter_0_20240905T015102.hdf5
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-09-26 12:20:01
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

aces tagged "gauss"
FrameSaver: q=887209 n=731419 tag=gauss
wclsFrameSaver: saving 53206 traces tagged "wiener"
FrameSaver: q=963007 n=662815 tag=wiener
1569 hits in TPC 0
996 hits in TPC 1
6140 hits in TPC 2
3479 hits in TPC 3
3124 hits in TPC 4
2697 hits in TPC 5
6920 hits in TPC 6
2702 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 162 XUs and 89 XVs -> 10 XUVs
C:0 T:2 29816 XUs and 23631 XVs -> 515 XUVs
C:0 T:3 137 XUs and 122 XVs -> 9 XUVs
C:0 T:4 34 XUs and 82 XVs -> 5 XUVs
C:0 T:5 15541 XUs and 47998 XVs -> 5438 XUVs
C:0 T:6 54018 XUs and 25271 XVs -> 1418 XUVs
C:0 T:7 455 XUs and 381 XVs -> 12 XUVs
7407 XUVs total
1380 collection wire objects
7407 potential space points
Neighbour search...
1031143 tests to find 555874 neighbours
Iterating with no regularization...
Begin: 8.60047e+06
0 7.35241e+06
1 7.271e+06
2 7.25492e+06
3 7.24882e+06
Now with regularization...
Begin: 6.71254e+06
0 6.7076e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 29th record. run: 29081 subRun: 1 event: 138950 at 26-Sep-2024 12:50:34 BST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 56940 traces, 56940 summary
Retagger: tagging trace set: gauss with 41986 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 41986 traces tagged "gauss"
FrameSaver: q=898453 n=785330 tag=gauss
wclsFrameSaver: saving 56940 traces tagged "wiener"
FrameSaver: q=974974 n=707017 tag=wiener
2084 hits in TPC 0
1494 hits in TPC 1
5423 hits in TPC 2
3746 hits in TPC 3
2636 hits in TPC 4
3720 hits in TPC 5
7073 hits in TPC 6
4267 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 573 XUs and 282 XVs -> 4 XUVs
C:0 T:2 35331 XUs and 55878 XVs -> 1707 XUVs
C:0 T:3 3995 XUs and 8077 XVs -> 20 XUVs
C:0 T:4 84 XUs and 113 XVs -> 6 XUVs
C:0 T:5 11487 XUs and 16544 XVs -> 337 XUVs
C:0 T:6 48189 XUs and 109064 XVs -> 3804 XUVs
C:0 T:7 272 XUs and 458 XVs -> 5 XUVs
5883 XUVs total
1584 collection wire objects
5883 potential space points
Neighbour search...
386599 tests to find 201788 neighbours
Iterating with no regularization...
Begin: 1.29171e+07
0 9.79205e+06
1 9.58041e+06
2 9.54958e+06
3 9.53906e+06
4 9.53387e+06
Now with regularization...
Begin: 9.08722e+06
0 9.08361e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 30th record. run: 29081 subRun: 1 event: 138958 at 26-Sep-2024 12:51:55 BST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 69132 traces, 69132 summary
Retagger: tagging trace set: gauss with 52149 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 52149 traces tagged "gauss"
FrameSaver: q=1.11415e+06 n=1001643 tag=gauss
wclsFrameSaver: saving 69132 traces tagged "wiener"
FrameSaver: q=1.19153e+06 n=909492 tag=wiener
4413 hits in TPC 0
4473 hits in TPC 1
8038 hits in TPC 2
4006 hits in TPC 3
4561 hits in TPC 4
7483 hits in TPC 5
2216 hits in TPC 6
1086 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 863 XUs and 843 XVs -> 57 XUVs
C:0 T:2 19107 XUs and 33591 XVs -> 996 XUVs
C:0 T:3 411 XUs and 613 XVs -> 30 XUVs
C:0 T:4 149 XUs and 207 XVs -> 7 XUVs
C:0 T:5 22204 XUs and 18297 XVs -> 574 XUVs
C:0 T:6 4145 XUs and 3818 XVs -> 63 XUVs
C:0 T:7 43 XUs and 32 XVs -> 3 XUVs
1730 XUVs total
1165 collection wire objects
1730 potential space points
Neighbour search...
24412 tests to find 13736 neighbours
Iterating with no regularization...
Begin: 6.71822e+06
0 6.18861e+06
1 6.1707e+06
2 6.16952e+06
Now with regularization...
Begin: 5.80086e+06
0 5.80054e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

26-Sep-2024 12:53:23 BST  Closed output file "np04hd_raw_run029081_0578_dataflow6_datawriter_0_20240905T015102_reco_stage1_reco_stage2_20240926T115323_keepup.root"
26-Sep-2024 12:53:23 BST  Closed input file "np04hd_raw_run029081_0578_dataflow6_datawriter_0_20240905T015102_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              64.3201       84.4235       120.062       82.4949       12.8483        30     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000276567   0.00167789    0.00351584    0.00156096    0.000846467      30     
produce:fembfilter:PDHDFEMBFilter                      0.516434      0.711697       1.85219      0.685076      0.235331        30     
produce:wclsdatahd:WireCellToolkit                      37.0335       39.8482       41.975        40.0334       1.54925        30     
produce:gaushit:GausHitFinder                          0.332601      0.560353       0.83206       0.56283      0.133817        30     
produce:nhitsfilter:NumberOfHitsFilter                0.000210411   0.000331443   0.000511936   0.000323471   7.63198e-05      30     
produce:reco3d:SpacePointSolver                        0.0750711      1.22766       3.39098       1.1412       0.857254        30     
produce:hitpdune:DisambigFromSpacePoints               0.155565      0.391428      0.907329      0.392317      0.159952        30     
produce:pandora:StandardPandora                         4.48785       9.59585       19.8229       8.61217       4.05963        30     
produce:pandoraWriter:StandardPandora                  0.0854447     0.137664      0.206726      0.135997      0.0345122       30     
produce:pandoraTrack:LArPandoraTrackCreation           0.345227      0.963929       2.20239      0.839515      0.375751        30     
produce:pandoraShower:LArPandoraShowerCreation         0.481366       1.21094       3.52635       1.06348       0.62075        30     
produce:pandoracalo:Calorimetry                        0.217458      0.503253       1.28223      0.478644      0.192659        30     
produce:pandoracalonosce:Calorimetry                   0.186255      0.446073       1.1188       0.414165      0.178199        30     
produce:pandorapid:Chi2ParticleID                     0.000958367   0.00151796    0.00277093    0.00139044    0.000370567      30     
produce:pandoraShowercalo:ShowerCalorimetry             0.51225       1.0235        2.85627       0.96034      0.493441        30     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.354403       1.02079       2.76571      0.937995      0.554569        30     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.0711564      0.12338      0.219211      0.119636      0.0346695       30     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0250222     0.045134      0.0862062     0.0412574     0.0135182       30     
produce:emtrkmichelid:EmTrackMichelId                   15.7772       25.2969       41.1506       24.4893       5.96953        30     
[art]:TriggerResults:TriggerResultInserter            1.4457e-05    2.90807e-05   6.7358e-05    2.1185e-05    1.61752e-05      30     
end_path:out1:RootOutput                               3.487e-06    5.21057e-06   2.0649e-05    4.1575e-06     3.323e-06       30     
end_path:michelremoving:michelremoving                 0.0150644     0.0682956     0.295189      0.0299689      0.07069        30     
end_path:michelremovinggnocchi:michelremoving          0.014303      0.0671281     0.351435      0.0286102     0.0758408       30     
end_path:calibanagnocchi:CalibAnaTree                  0.148441      0.367864       1.03869      0.340143      0.166226        30     
end_path:out1:RootOutput(write)                        0.435987      0.679305      0.955598      0.667568      0.142936        30     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4952.5 MB
  Peak resident set size usage (VmHWM): 2363.6 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029081_0578_dataflow6_datawriter_0_20240905T015102_reco_stage1_reco_stage2_20240926T115323_keepup.root
\tHists: np04hd_raw_run029081_0578_dataflow6_datawriter_0_20240905T015102_reco_stage1_reco_stage2_20240926T115323_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 06:00:17 UTC       justIN version: 01.01.09