Jobsub ID 263331.35@justin-prod-sched01.dune.hep.ac.uk
| Jobsub ID | 263331.35@justin-prod-sched01.dune.hep.ac.uk |
| Workflow ID | 3448 |
| Stage ID | 1 |
| User name | calcuttj@fnal.gov |
| HTCondor Group | group_dune.prod_mcsim |
| Requested | Processors | 1 |
| RSS bytes | 4193255424 (3999 MiB) |
| Wall seconds limit | 18000 (5 hours) |
| Submitted time | 2024-09-26 10:10:04 |
| Site | UK_Sheffield |
| Entry | DUNE_UK_Sheffield_lcgce1 |
| Last heartbeat | 2024-09-26 12:20:36 |
| From worker node | Hostname | wn032.hep |
| cpuinfo | Intel(R) Xeon(R) Gold 6226 CPU @ 2.70GHz |
| OS release | Scientific Linux release 7.9 (Nitrogen) |
| Processors | 1 |
| RSS bytes | 4193255424 (3999 MiB) |
| Wall seconds limit | 257400 (71 hours) |
| Inner Apptainer? | True |
| Job state | outputting_failed |
| Allocator name | justin-allocator-pro.dune.hep.ac.uk |
| Started | 2024-09-26 10:43:49 |
| Input files | hd-protodune:np04hd_raw_run029097_0111_dataflow7_datawriter_0_20240906T123526.hdf5
|
| Jobscript | Exit code | 1 |
| Real time | 0m (0s) |
| CPU time | 0m (0s = 0%) |
| Outputting started | |
| Output files | |
| Finished | 2024-09-26 12:20:36 |
| List job events Wrapper job log |
Jobscript log (last 10,000 characters)
ed "gauss"
FrameSaver: q=791127 n=729055 tag=gauss
wclsFrameSaver: saving 48613 traces tagged "wiener"
FrameSaver: q=837707 n=663487 tag=wiener
3310 hits in TPC 0
3181 hits in TPC 1
2008 hits in TPC 2
2319 hits in TPC 3
4075 hits in TPC 4
6138 hits in TPC 5
2967 hits in TPC 6
2192 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 995 XUs and 743 XVs -> 13 XUVs
C:0 T:2 4496 XUs and 4921 XVs -> 141 XUVs
C:0 T:3 6 XUs and 11 XVs -> 0 XUVs
C:0 T:4 21 XUs and 61 XVs -> 1 XUVs
C:0 T:5 24085 XUs and 18356 XVs -> 590 XUVs
C:0 T:6 6085 XUs and 7652 XVs -> 1193 XUVs
C:0 T:7 20 XUs and 49 XVs -> 3 XUVs
1941 XUVs total
837 collection wire objects
1941 potential space points
Neighbour search...
73493 tests to find 45190 neighbours
Iterating with no regularization...
Begin: 6.82675e+06
0 6.48404e+06
1 6.46063e+06
2 6.45689e+06
Now with regularization...
Begin: 6.02005e+06
0 6.01801e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
no of hits closeby 0 event 26879 TrkackID 1 startx, y, z 16.2354 364.835 11.8557 wireno, peakt tpcno 100 2612.02 2 dist 426.293min T, max_T528.661 2639.63
no of hits closeby 0 event 26879 TrkackID 8 startx, y, z 100.968 146.415 382.886 wireno, peakt tpcno 446 510.103 5 dist 0min T, max_T5 1268.5
no of hits closeby 0 event 26879 TrkackID 19 startx, y, z -40.0063 99.9981 186.578 wireno, peakt tpcno 429 10.9971 2 dist 0min T, max_T5.96242 519.204
no of hits closeby 0 event 26879 TrkackID 1 startx, y, z 16.2354 364.835 11.8557 wireno, peakt tpcno 100 2612.02 2 dist 426.293min T, max_T528.661 2639.63
no of hits closeby 0 event 26879 TrkackID 8 startx, y, z 100.968 146.415 382.886 wireno, peakt tpcno 446 510.103 5 dist 0min T, max_T5 1268.5
no of hits closeby 0 event 26879 TrkackID 19 startx, y, z -40.0063 99.9981 186.578 wireno, peakt tpcno 429 10.9971 2 dist 0min T, max_T5.96242 519.204
Begin processing the 30th record. run: 29097 subRun: 1 event: 26887 at 26-Sep-2024 12:58:00 BST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 86256 traces, 86256 summary
Retagger: tagging trace set: gauss with 63101 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 63101 traces tagged "gauss"
FrameSaver: q=1.48694e+06 n=1173381 tag=gauss
wclsFrameSaver: saving 86256 traces tagged "wiener"
FrameSaver: q=1.59603e+06 n=1053671 tag=wiener
1280 hits in TPC 0
3497 hits in TPC 1
9108 hits in TPC 2
4890 hits in TPC 3
5358 hits in TPC 4
9107 hits in TPC 5
8992 hits in TPC 6
4161 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 124 XUs and 41 XVs -> 2 XUVs
C:0 T:2 77774 XUs and 45882 XVs -> 1557 XUVs
C:0 T:3 249 XUs and 165 XVs -> 19 XUVs
C:0 T:4 197 XUs and 229 XVs -> 10 XUVs
C:0 T:5 99769 XUs and 114451 XVs -> 5820 XUVs
C:0 T:6 30344 XUs and 28186 XVs -> 1375 XUVs
C:0 T:7 642 XUs and 609 XVs -> 6 XUVs
8789 XUVs total
2041 collection wire objects
8789 potential space points
Neighbour search...
1817297 tests to find 781448 neighbours
Iterating with no regularization...
Begin: 2.36667e+07
0 2.01688e+07
1 2.00224e+07
2 2.00053e+07
Now with regularization...
Begin: 1.93047e+07
0 1.9298e+07
BdtBeamParticleIdTool::SliceFeatures::GetLArTPCIntercepts - inconsistent number of intercepts between a line and the LArTPC
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
no of hits closeby 1 event 26887 TrkackID 0 startx, y, z 342.18 248.945 35.0764 wireno, peakt tpcno 477 2885.02 5 dist 0min T, max_T1190.58 5567.43
no of hits closeby 1 event 26887 TrkackID 0 startx, y, z 342.18 248.945 35.0764 wireno, peakt tpcno 477 2885.02 5 dist 0min T, max_T1190.58 5567.43
26-Sep-2024 13:00:10 BST Closed output file "np04hd_raw_run029097_0111_dataflow7_datawriter_0_20240906T123526_reco_stage1_reco_stage2_20240926T120010_keepup.root"
26-Sep-2024 13:00:10 BST Closed input file "np04hd_raw_run029097_0111_dataflow7_datawriter_0_20240906T123526_reco_stage1.root"
========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
========================================================================================================================================
Full event 66.2672 94.6621 242.037 87.3073 30.88 30
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00044697 0.00178845 0.00431734 0.00137361 0.00114372 30
produce:fembfilter:PDHDFEMBFilter 0.606056 0.630022 0.6852 0.62503 0.0165704 30
produce:wclsdatahd:WireCellToolkit 45.5999 47.5279 52.5496 47.3407 1.44295 30
produce:gaushit:GausHitFinder 0.413954 0.670517 1.28195 0.632399 0.168459 30
produce:nhitsfilter:NumberOfHitsFilter 0.000292193 0.000425861 0.000611439 0.000407393 7.64713e-05 30
produce:reco3d:SpacePointSolver 0.297939 1.16508 6.32958 0.735263 1.2615 30
produce:hitpdune:DisambigFromSpacePoints 0.190798 0.61436 4.24035 0.440944 0.710742 30
produce:pandora:StandardPandora 4.94974 14.3861 100.337 10.6126 16.5809 30
produce:pandoraWriter:StandardPandora 0.0917768 0.158941 0.243605 0.155851 0.0339941 30
produce:pandoraTrack:LArPandoraTrackCreation 1.02463 3.00372 9.46768 2.62194 1.6609 30
produce:pandoraShower:LArPandoraShowerCreation 0.802945 3.50275 13.2524 3.09603 2.44253 30
produce:pandoracalo:Calorimetry 0.453274 1.13452 3.45655 0.984658 0.592278 30
produce:pandoracalonosce:Calorimetry 0.397475 1.06741 3.44008 0.926341 0.593562 30
produce:pandorapid:Chi2ParticleID 0.00130888 0.00174782 0.00297935 0.00171954 0.000346647 30
produce:pandoraShowercalo:ShowerCalorimetry 0.717752 2.69942 9.92171 2.26641 2.00033 30
produce:pandoraShowercalonosce:ShowerCalorimetry 0.805159 2.62778 10.5949 2.20036 2.07413 30
produce:pandoraGnocchiCalo:GnocchiCalorimetry 0.0764242 0.112472 0.188271 0.108051 0.0258675 30
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry 0.0326717 0.0476257 0.0866704 0.0463081 0.0113051 30
produce:emtrkmichelid:EmTrackMichelId 8.31006 13.4632 21.363 12.8635 2.96238 30
[art]:TriggerResults:TriggerResultInserter 3.2573e-05 4.54772e-05 7.8977e-05 4.5568e-05 9.78917e-06 30
end_path:out1:RootOutput 8.976e-06 1.27346e-05 2.2094e-05 1.2681e-05 2.80808e-06 30
end_path:michelremoving:michelremoving 0.0231784 0.0806453 0.207845 0.0528888 0.0552784 30
end_path:michelremovinggnocchi:michelremoving 0.0227815 0.0783061 0.207872 0.0527782 0.0536399 30
end_path:calibanagnocchi:CalibAnaTree 0.2805 0.770877 3.04077 0.624288 0.507335 30
end_path:out1:RootOutput(write) 0.420982 0.672933 1.1163 0.644649 0.163743 30
========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5774.01 MB
Peak resident set size usage (VmHWM): 2624.6 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029097_0111_dataflow7_datawriter_0_20240906T123526_reco_stage1_reco_stage2_20240926T120010_keepup.root
\tHists: np04hd_raw_run029097_0111_dataflow7_datawriter_0_20240906T123526_reco_stage1_reco_stage2_20240926T120010_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
