justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID263965.34@justin-prod-sched01.dune.hep.ac.uk
Workflow ID3451
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 14:31:13
SiteUK_Sheffield
EntryDUNE_UK_Sheffield_lcgce1
Last heartbeat2024-09-26 15:54:32
From worker nodeHostnamewn033.hep
cpuinfoIntel(R) Xeon(R) Gold 6226 CPU @ 2.70GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4193255424 (3999 MiB)
Wall seconds limit257400 (71 hours)
Inner Apptainer?True
Job statejobscript_error
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-09-26 14:33:29
Input fileshd-protodune:np04hd_raw_run029107_2172_dataflow5_datawriter_0_20240908T025533.hdf5
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-09-26 15:54:32
Saved logsjustin-logs:263965.34-justin-prod-sched01.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

rization...
Begin: 1.04226e+07
0 1.04188e+07
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 29th record. run: 29107 subRun: 1 event: 521565 at 26-Sep-2024 16:48:49 BST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 77433 traces, 77433 summary
Retagger: tagging trace set: gauss with 59576 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 59576 traces tagged "gauss"
FrameSaver: q=1.35523e+06 n=1167026 tag=gauss
wclsFrameSaver: saving 77433 traces tagged "wiener"
FrameSaver: q=1.43289e+06 n=1059214 tag=wiener
4869 hits in TPC 0
3698 hits in TPC 1
7006 hits in TPC 2
3641 hits in TPC 3
4958 hits in TPC 4
6169 hits in TPC 5
6566 hits in TPC 6
5436 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 933 XUs and 931 XVs -> 35 XUVs
C:0 T:2 15290 XUs and 18942 XVs -> 391 XUVs
C:0 T:3 320 XUs and 501 XVs -> 65 XUVs
C:0 T:4 91 XUs and 167 XVs -> 4 XUVs
C:0 T:5 21268 XUs and 19676 XVs -> 435 XUVs
C:0 T:6 27410 XUs and 29249 XVs -> 1554 XUVs
C:0 T:7 9 XUs and 9 XVs -> 0 XUVs
2484 XUVs total
1240 collection wire objects
2484 potential space points
Neighbour search...
58722 tests to find 33978 neighbours
Iterating with no regularization...
Begin: 1.34206e+07
0 1.17252e+07
1 1.16433e+07
2 1.16335e+07
Now with regularization...
Begin: 1.10058e+07
0 1.10033e+07
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--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

no of hits closeby  6   event 521565 TrkackID 4 startx, y, z 27.8231 488.938 9.66703  wireno, peakt tpcno 393 8.70308 5 dist 0.331633min T, max_T6.2922 1263.74
no of hits closeby  6   event 521565 TrkackID 4 startx, y, z 27.8231 488.938 9.66703  wireno, peakt tpcno 393 8.70308 5 dist 0.331633min T, max_T6.2922 1263.74
Begin processing the 30th record. run: 29107 subRun: 1 event: 521573 at 26-Sep-2024 16:51:02 BST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 89143 traces, 89143 summary
Retagger: tagging trace set: gauss with 67859 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 67859 traces tagged "gauss"
FrameSaver: q=1.43818e+06 n=1300818 tag=gauss
wclsFrameSaver: saving 89143 traces tagged "wiener"
FrameSaver: q=1.54287e+06 n=1191732 tag=wiener
6208 hits in TPC 0
6598 hits in TPC 1
8970 hits in TPC 2
5428 hits in TPC 3
3735 hits in TPC 4
9037 hits in TPC 5
6131 hits in TPC 6
3187 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 2942 XUs and 4102 XVs -> 593 XUVs
C:0 T:2 26726 XUs and 53774 XVs -> 1457 XUVs
C:0 T:3 25 XUs and 21 XVs -> 1 XUVs
C:0 T:4 157 XUs and 173 XVs -> 2 XUVs
C:0 T:5 37627 XUs and 43706 XVs -> 883 XUVs
C:0 T:6 19193 XUs and 31554 XVs -> 831 XUVs
C:0 T:7 102 XUs and 134 XVs -> 7 XUVs
3774 XUVs total
1689 collection wire objects
3774 potential space points
Neighbour search...
113288 tests to find 65976 neighbours
Iterating with no regularization...
Begin: 1.24262e+07
0 1.17538e+07
1 1.17313e+07
2 1.17284e+07
Now with regularization...
Begin: 1.11054e+07
0 1.10975e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

no of hits closeby  0   event 521573 TrkackID 2 startx, y, z 239.192 588.443 119.048  wireno, peakt tpcno 390 3011 2 dist 310.985min T, max_T5.02322 3039.1
no of hits closeby  0   event 521573 TrkackID 2 startx, y, z 239.192 588.443 119.048  wireno, peakt tpcno 390 3011 2 dist 310.985min T, max_T5.02322 3039.1
26-Sep-2024 16:53:34 BST  Closed output file "np04hd_raw_run029107_2172_dataflow5_datawriter_0_20240908T025533_reco_stage1_reco_stage2_20240926T155334_keepup.root"
26-Sep-2024 16:53:34 BST  Closed input file "np04hd_raw_run029107_2172_dataflow5_datawriter_0_20240908T025533_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              70.1668       110.216       165.621       108.132       24.8326        30     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000416352   0.00134044    0.00473996    0.000999364   0.00106856       30     
produce:fembfilter:PDHDFEMBFilter                      0.610897       0.79012       1.02103      0.822549      0.124286        30     
produce:wclsdatahd:WireCellToolkit                      45.4048       57.2915       64.978        60.1192       6.61553        30     
produce:gaushit:GausHitFinder                          0.409711      0.856194       1.7162       0.754717      0.301522        30     
produce:nhitsfilter:NumberOfHitsFilter                0.000281848   0.000465257   0.000802084   0.000439615   0.000125093      30     
produce:reco3d:SpacePointSolver                        0.151632       1.35553       9.2762       0.972573       1.62289        30     
produce:hitpdune:DisambigFromSpacePoints               0.250364      0.702576       1.83626      0.677249      0.361082        30     
produce:pandora:StandardPandora                         6.27266       15.9588       32.7587       14.2452       6.92899        30     
produce:pandoraWriter:StandardPandora                  0.103501      0.198652      0.336514      0.184912      0.0652513       30     
produce:pandoraTrack:LArPandoraTrackCreation           0.679989       2.89104       7.72387       2.4469        1.56341        30     
produce:pandoraShower:LArPandoraShowerCreation         0.855714       3.55202       9.22818       2.69605       2.49411        30     
produce:pandoracalo:Calorimetry                        0.321438       1.17186       3.24556      0.899824      0.642867        30     
produce:pandoracalonosce:Calorimetry                   0.279495       1.12508       3.00737      0.948198      0.620831        30     
produce:pandorapid:Chi2ParticleID                     0.00113031    0.00206279    0.00326192    0.00203297    0.000537884      30     
produce:pandoraShowercalo:ShowerCalorimetry            0.606625       3.0766        8.37897       2.28229       2.05282        30     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.601117       3.03947       7.84857       2.36637       2.06307        30     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.0681438     0.163568      0.306637      0.149492      0.0712513       30     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0270548      0.06688      0.128122      0.0541192      0.03206        30     
produce:emtrkmichelid:EmTrackMichelId                   9.99552       15.7384       23.3815       15.6396       3.75243        30     
[art]:TriggerResults:TriggerResultInserter            2.6169e-05    5.58808e-05   9.7832e-05    5.67365e-05   1.50958e-05      30     
end_path:out1:RootOutput                               8.827e-06    1.61368e-05   3.5858e-05    1.55375e-05   5.65102e-06      30     
end_path:michelremoving:michelremoving                 0.0320901     0.107546      0.353302      0.083101      0.0824491       30     
end_path:michelremovinggnocchi:michelremoving          0.0303878     0.102521      0.329657      0.0801043     0.0727506       30     
end_path:calibanagnocchi:CalibAnaTree                  0.211728      0.883349       2.45863      0.781386      0.493687        30     
end_path:out1:RootOutput(write)                        0.508791      0.893207       1.4151        0.87854      0.240795        30     
========================================================================================================================================

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

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