Jobsub ID 263965.34@justin-prod-sched01.dune.hep.ac.uk
Jobsub ID | 263965.34@justin-prod-sched01.dune.hep.ac.uk |
Workflow ID | 3451 |
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 14:31:13 |
Site | UK_Sheffield |
Entry | DUNE_UK_Sheffield_lcgce1 |
Last heartbeat | 2024-09-26 15:54:32 |
From worker node | Hostname | wn033.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 | jobscript_error |
Allocator name | justin-allocator-pro.dune.hep.ac.uk |
Started | 2024-09-26 14:33:29 |
Input files | hd-protodune:np04hd_raw_run029107_2172_dataflow5_datawriter_0_20240908T025533.hdf5
|
Jobscript | Exit code | 1 |
Real time | 0m (0s) |
CPU time | 0m (0s = 0%) |
Outputting started | |
Output files | |
Finished | 2024-09-26 15:54:32 |
Saved logs | justin-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