Jobsub ID 263763.52@justin-prod-sched01.dune.hep.ac.uk
| Jobsub ID | 263763.52@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 13:24:49 |
| Site | UK_Durham |
| Entry | DUNE_UK_SGridDurham_ce3 |
| Last heartbeat | 2024-09-26 15:13:57 |
| From worker node | Hostname | n231.dur.scotgrid.ac.uk |
| cpuinfo | Intel(R) Xeon(R) Gold 5220 CPU @ 2.20GHz |
| OS release | Scientific Linux release 7.9 (Nitrogen) |
| Processors | 1 |
| RSS bytes | 4193255424 (3999 MiB) |
| Wall seconds limit | 171000 (47 hours) |
| Inner Apptainer? | True |
| Job state | jobscript_error |
| Allocator name | justin-allocator-pro.dune.hep.ac.uk |
| Started | 2024-09-26 13:26:02 |
| Input files | hd-protodune:np04hd_raw_run029097_0002_dataflow5_datawriter_0_20240906T101815.hdf5
|
| Jobscript | Exit code | 1 |
| Real time | 0m (0s) |
| CPU time | 0m (0s = 0%) |
| Outputting started | |
| Output files | |
| Finished | 2024-09-26 15:13:57 |
| Saved logs | justin-logs:263763.52-justin-prod-sched01.dune.hep.ac.uk.logs.tgz |
| List job events Wrapper job log |
Jobscript log (last 10,000 characters)
iener
2289 hits in TPC 0
2417 hits in TPC 1
10158 hits in TPC 2
4634 hits in TPC 3
2500 hits in TPC 4
4393 hits in TPC 5
7542 hits in TPC 6
3685 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 608 XUs and 403 XVs -> 1 XUVs
C:0 T:2 54580 XUs and 76532 XVs -> 1614 XUVs
C:0 T:3 316 XUs and 529 XVs -> 8 XUVs
C:0 T:4 209 XUs and 272 XVs -> 20 XUVs
C:0 T:5 16232 XUs and 10077 XVs -> 363 XUVs
C:0 T:6 58529 XUs and 79576 XVs -> 2540 XUVs
C:0 T:7 393 XUs and 498 XVs -> 27 XUVs
4573 XUVs total
1767 collection wire objects
4573 potential space points
Neighbour search...
193059 tests to find 109292 neighbours
Iterating with no regularization...
Begin: 6.45162e+06
0 5.77752e+06
1 5.7306e+06
2 5.72511e+06
Now with regularization...
Begin: 5.41766e+06
0 5.41598e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
Begin processing the 29th record. run: 29097 subRun: 1 event: 709 at 26-Sep-2024 16:09:16 BST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 58254 traces, 58254 summary
Retagger: tagging trace set: gauss with 43326 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 43326 traces tagged "gauss"
FrameSaver: q=904237 n=826068 tag=gauss
wclsFrameSaver: saving 58254 traces tagged "wiener"
FrameSaver: q=974467 n=753093 tag=wiener
3199 hits in TPC 0
4777 hits in TPC 1
3362 hits in TPC 2
2371 hits in TPC 3
3023 hits in TPC 4
5818 hits in TPC 5
4911 hits in TPC 6
3714 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 424 XUs and 388 XVs -> 3 XUVs
C:0 T:2 8384 XUs and 18125 XVs -> 302 XUVs
C:0 T:3 45 XUs and 71 XVs -> 2 XUVs
C:0 T:4 52 XUs and 63 XVs -> 1 XUVs
C:0 T:5 38369 XUs and 56662 XVs -> 1310 XUVs
C:0 T:6 17126 XUs and 40345 XVs -> 1355 XUVs
C:0 T:7 243 XUs and 185 XVs -> 4 XUVs
2977 XUVs total
1072 collection wire objects
2977 potential space points
Neighbour search...
216225 tests to find 108732 neighbours
Iterating with no regularization...
Begin: 6.1833e+06
0 5.54624e+06
1 5.4956e+06
2 5.48995e+06
3 5.48834e+06
Now with regularization...
Begin: 5.25475e+06
0 5.25382e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
Begin processing the 30th record. run: 29097 subRun: 1 event: 749 at 26-Sep-2024 16:11:11 BST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 70049 traces, 70049 summary
Retagger: tagging trace set: gauss with 51886 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 51886 traces tagged "gauss"
FrameSaver: q=1.15037e+06 n=937598 tag=gauss
wclsFrameSaver: saving 70049 traces tagged "wiener"
FrameSaver: q=1.28938e+06 n=860326 tag=wiener
3426 hits in TPC 0
3310 hits in TPC 1
7307 hits in TPC 2
4602 hits in TPC 3
4552 hits in TPC 4
6151 hits in TPC 5
4994 hits in TPC 6
2306 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 5352 XUs and 3324 XVs -> 31 XUVs
C:0 T:2 59196 XUs and 132475 XVs -> 7733 XUVs
C:0 T:3 34 XUs and 63 XVs -> 2 XUVs
C:0 T:4 192 XUs and 150 XVs -> 3 XUVs
C:0 T:5 63549 XUs and 35465 XVs -> 1121 XUVs
C:0 T:6 15800 XUs and 18261 XVs -> 591 XUVs
C:0 T:7 435 XUs and 417 XVs -> 13 XUVs
9494 XUVs total
1893 collection wire objects
9494 potential space points
Neighbour search...
1170828 tests to find 613258 neighbours
Iterating with no regularization...
Begin: 1.89404e+07
0 1.65325e+07
1 1.63886e+07
2 1.63636e+07
3 1.63539e+07
Now with regularization...
Begin: 1.57979e+07
0 1.57898e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
26-Sep-2024 16:13:20 BST Closed output file "np04hd_raw_run029097_0002_dataflow5_datawriter_0_20240906T101815_reco_stage1_reco_stage2_20240926T151320_keepup.root"
26-Sep-2024 16:13:20 BST Closed input file "np04hd_raw_run029097_0002_dataflow5_datawriter_0_20240906T101815_reco_stage1.root"
========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
========================================================================================================================================
Full event 79.4444 108.074 155.225 101.103 18.1954 30
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000398887 0.00125192 0.00301402 0.000891319 0.000823297 30
produce:fembfilter:PDHDFEMBFilter 0.701569 0.885786 1.09812 0.855665 0.16483 30
produce:wclsdatahd:WireCellToolkit 44.5495 55.8574 67.2692 55.9868 7.27382 30
produce:gaushit:GausHitFinder 0.567009 0.949123 1.41149 0.892195 0.243333 30
produce:nhitsfilter:NumberOfHitsFilter 0.000265131 0.000397341 0.000692892 0.00038672 8.95477e-05 30
produce:reco3d:SpacePointSolver 0.275784 1.018 2.97258 0.869606 0.619314 30
produce:hitpdune:DisambigFromSpacePoints 0.205544 0.705727 1.27165 0.669797 0.289134 30
produce:pandora:StandardPandora 5.41262 16.3614 50.8583 14.1934 8.11597 30
produce:pandoraWriter:StandardPandora 0.124779 0.19388 0.282172 0.193558 0.0438748 30
produce:pandoraTrack:LArPandoraTrackCreation 1.01584 1.75708 3.18218 1.59658 0.569369 30
produce:pandoraShower:LArPandoraShowerCreation 1.00222 1.84782 3.31235 1.72364 0.464845 30
produce:pandoracalo:Calorimetry 0.476022 0.784474 1.25385 0.708615 0.203905 30
produce:pandoracalonosce:Calorimetry 0.380472 0.717859 1.24747 0.647657 0.207904 30
produce:pandorapid:Chi2ParticleID 0.00134925 0.00233474 0.00530586 0.00211748 0.00080837 30
produce:pandoraShowercalo:ShowerCalorimetry 0.846901 1.64674 3.01815 1.56616 0.431548 30
produce:pandoraShowercalonosce:ShowerCalorimetry 0.559252 1.62399 3.00017 1.54383 0.44548 30
produce:pandoraGnocchiCalo:GnocchiCalorimetry 0.0910568 0.174756 0.307089 0.148259 0.0615684 30
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry 0.0360129 0.0670703 0.11176 0.0591975 0.0221238 30
produce:emtrkmichelid:EmTrackMichelId 12.8994 21.5287 29.2057 21.2834 4.11071 30
[art]:TriggerResults:TriggerResultInserter 2.9882e-05 3.90629e-05 8.8708e-05 3.70635e-05 1.07669e-05 30
end_path:out1:RootOutput 9.214e-06 1.19232e-05 3.0592e-05 1.10945e-05 3.7281e-06 30
end_path:michelremoving:michelremoving 0.0238207 0.0928981 0.513824 0.0494368 0.100356 30
end_path:michelremovinggnocchi:michelremoving 0.0221956 0.0900813 0.508306 0.043787 0.100216 30
end_path:calibanagnocchi:CalibAnaTree 0.258848 0.59372 1.08722 0.550703 0.183814 30
end_path:out1:RootOutput(write) 0.557112 1.00409 1.56954 0.960914 0.263193 30
========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5772.81 MB
Peak resident set size usage (VmHWM): 2799.71 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029097_0002_dataflow5_datawriter_0_20240906T101815_reco_stage1_reco_stage2_20240926T151320_keepup.root
\tHists: np04hd_raw_run029097_0002_dataflow5_datawriter_0_20240906T101815_reco_stage1_reco_stage2_20240926T151320_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
