Jobsub ID 263681.6@justin-prod-sched01.dune.hep.ac.uk
| Jobsub ID | 263681.6@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 13:07:21 |
| Site | ES_PIC |
| Entry | DUNE_T1_ES_PIC_ce14-multicore |
| Last heartbeat | 2024-09-26 14:41:39 |
| From worker node | Hostname | tds211.pic.es |
| cpuinfo | Intel(R) Xeon(R) CPU E5-2640 v3 @ 2.60GHz |
| OS release | Scientific Linux release 7.9 (Nitrogen) |
| Processors | 1 |
| RSS bytes | 4193255424 (3999 MiB) |
| Wall seconds limit | 216000 (60 hours) |
| Inner Apptainer? | True |
| Job state | jobscript_error |
| Allocator name | justin-allocator-pro.dune.hep.ac.uk |
| Started | 2024-09-26 13:08:18 |
| Input files | hd-protodune:np04hd_raw_run029107_1983_dataflow4_datawriter_0_20240908T000453.hdf5
|
| Jobscript | Exit code | 1 |
| Real time | 0m (0s) |
| CPU time | 0m (0s = 0%) |
| Outputting started | |
| Output files | |
| Finished | 2024-09-26 14:41:39 |
| Saved logs | justin-logs:263681.6-justin-prod-sched01.dune.hep.ac.uk.logs.tgz |
| List job events Wrapper job log |
Jobscript log (last 10,000 characters)
0 hits in TPC 6
2180 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 123 XUs and 114 XVs -> 2 XUVs
C:0 T:2 30162 XUs and 31691 XVs -> 1365 XUVs
C:0 T:3 432 XUs and 573 XVs -> 15 XUVs
C:0 T:4 1703 XUs and 3343 XVs -> 75 XUVs
C:0 T:5 22598 XUs and 34466 XVs -> 2702 XUVs
C:0 T:6 4584 XUs and 3044 XVs -> 122 XUVs
C:0 T:7 34 XUs and 53 XVs -> 3 XUVs
4284 XUVs total
1744 collection wire objects
4284 potential space points
Neighbour search...
142052 tests to find 86314 neighbours
Iterating with no regularization...
Begin: 6.50258e+06
0 5.86001e+06
1 5.7976e+06
2 5.78737e+06
3 5.78353e+06
Now with regularization...
Begin: 5.20782e+06
0 5.20562e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
Begin processing the 29th record. run: 29107 subRun: 1 event: 476188 at 26-Sep-2024 16:38:26 CEST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 33980 traces, 33980 summary
Retagger: tagging trace set: gauss with 25388 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 25388 traces tagged "gauss"
FrameSaver: q=595336 n=471765 tag=gauss
wclsFrameSaver: saving 33980 traces tagged "wiener"
FrameSaver: q=647831 n=428553 tag=wiener
1889 hits in TPC 0
1162 hits in TPC 1
1707 hits in TPC 2
823 hits in TPC 3
2920 hits in TPC 4
3998 hits in TPC 5
2899 hits in TPC 6
2198 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 396 XUs and 749 XVs -> 14 XUVs
C:0 T:1 499 XUs and 383 XVs -> 24 XUVs
C:0 T:2 1210 XUs and 697 XVs -> 36 XUVs
C:0 T:3 129 XUs and 84 XVs -> 18 XUVs
C:0 T:4 53 XUs and 142 XVs -> 2 XUVs
C:0 T:5 6209 XUs and 7549 XVs -> 885 XUVs
C:0 T:6 9036 XUs and 4086 XVs -> 209 XUVs
C:0 T:7 157 XUs and 151 XVs -> 18 XUVs
1206 XUVs total
761 collection wire objects
1206 potential space points
Neighbour search...
17092 tests to find 9918 neighbours
Iterating with no regularization...
Begin: 5.0165e+06
0 4.85476e+06
1 4.84477e+06
2 4.84388e+06
Now with regularization...
Begin: 4.33251e+06
0 4.3322e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
Begin processing the 30th record. run: 29107 subRun: 1 event: 476196 at 26-Sep-2024 16:39:31 CEST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 82668 traces, 82668 summary
Retagger: tagging trace set: gauss with 61096 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 61096 traces tagged "gauss"
FrameSaver: q=1.2902e+06 n=1123824 tag=gauss
wclsFrameSaver: saving 82668 traces tagged "wiener"
FrameSaver: q=1.39364e+06 n=1015738 tag=wiener
6945 hits in TPC 0
6543 hits in TPC 1
6164 hits in TPC 2
3054 hits in TPC 3
1586 hits in TPC 4
5203 hits in TPC 5
8971 hits in TPC 6
5076 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 396 XUs and 147 XVs -> 7 XUVs
C:0 T:1 2173 XUs and 2024 XVs -> 124 XUVs
C:0 T:2 29987 XUs and 39285 XVs -> 1430 XUVs
C:0 T:3 128 XUs and 136 XVs -> 7 XUVs
C:0 T:4 99 XUs and 194 XVs -> 6 XUVs
C:0 T:5 14446 XUs and 28619 XVs -> 1234 XUVs
C:0 T:6 44006 XUs and 29997 XVs -> 659 XUVs
C:0 T:7 382 XUs and 233 XVs -> 7 XUVs
3474 XUVs total
1369 collection wire objects
3474 potential space points
Neighbour search...
271420 tests to find 147576 neighbours
Iterating with no regularization...
Begin: 5.71037e+06
0 5.31934e+06
1 5.29637e+06
2 5.2925e+06
Now with regularization...
Begin: 4.99097e+06
0 4.98962e+06
TestBeamParticleCreationAlgorithm::SetupTestBeamVertex - Test beam particle has no initial vertex
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLArTPCIntercepts - inconsistent number of intercepts between a line and the LArTPC
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
26-Sep-2024 16:41:20 CEST Closed output file "np04hd_raw_run029107_1983_dataflow4_datawriter_0_20240908T000453_reco_stage1_reco_stage2_20240926T144120_keepup.root"
26-Sep-2024 16:41:20 CEST Closed input file "np04hd_raw_run029107_1983_dataflow4_datawriter_0_20240908T000453_reco_stage1.root"
========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
========================================================================================================================================
Full event 64.8862 105.353 160.93 98.2671 23.4742 30
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00038651 0.00210885 0.00351681 0.00206972 0.000870119 30
produce:fembfilter:PDHDFEMBFilter 0.578221 0.659846 0.765553 0.64027 0.0499593 30
produce:wclsdatahd:WireCellToolkit 41.833 49.1926 58.7182 47.4879 4.70618 30
produce:gaushit:GausHitFinder 0.371442 0.830706 1.35621 0.820108 0.232682 30
produce:nhitsfilter:NumberOfHitsFilter 0.000203213 0.000399713 0.000663434 0.000379521 0.000101135 30
produce:reco3d:SpacePointSolver 0.120747 1.01145 3.15786 0.763808 0.793971 30
produce:hitpdune:DisambigFromSpacePoints 0.170083 0.650888 1.53289 0.564377 0.371613 30
produce:pandora:StandardPandora 3.49176 15.0132 31.7944 13.529 7.5288 30
produce:pandoraWriter:StandardPandora 0.0851724 0.166393 0.26543 0.163904 0.049025 30
produce:pandoraTrack:LArPandoraTrackCreation 0.501044 2.00292 5.87413 1.67384 1.23045 30
produce:pandoraShower:LArPandoraShowerCreation 0.373738 2.33063 8.57816 1.71983 1.7935 30
produce:pandoracalo:Calorimetry 0.26506 0.875943 2.47526 0.723915 0.488031 30
produce:pandoracalonosce:Calorimetry 0.234836 0.823857 2.52138 0.705912 0.496555 30
produce:pandorapid:Chi2ParticleID 0.00115556 0.00197589 0.00328258 0.00195394 0.000498629 30
produce:pandoraShowercalo:ShowerCalorimetry 0.31944 2.03034 6.21767 1.45149 1.46382 30
produce:pandoraShowercalonosce:ShowerCalorimetry 0.314553 1.86762 5.7096 1.4495 1.26695 30
produce:pandoraGnocchiCalo:GnocchiCalorimetry 0.0690515 0.143248 0.215032 0.14326 0.0382832 30
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry 0.0244956 0.049529 0.079318 0.0480524 0.014385 30
produce:emtrkmichelid:EmTrackMichelId 12.473 26.0297 39.3887 25.4554 7.41373 30
[art]:TriggerResults:TriggerResultInserter 2.4407e-05 3.95048e-05 7.2149e-05 3.73485e-05 1.13577e-05 30
end_path:out1:RootOutput 7.908e-06 3.87119e-05 0.000817931 1.05295e-05 0.000144747 30
end_path:michelremoving:michelremoving 0.0196899 0.0714878 0.261093 0.0417294 0.0698067 30
end_path:michelremovinggnocchi:michelremoving 0.0179242 0.0677187 0.257585 0.037242 0.0696047 30
end_path:calibanagnocchi:CalibAnaTree 0.169704 0.634088 1.73877 0.584422 0.346463 30
end_path:out1:RootOutput(write) 0.398123 0.789874 1.19086 0.812449 0.210078 30
========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4961.14 MB
Peak resident set size usage (VmHWM): 2609.34 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029107_1983_dataflow4_datawriter_0_20240908T000453_reco_stage1_reco_stage2_20240926T144120_keepup.root
\tHists: np04hd_raw_run029107_1983_dataflow4_datawriter_0_20240908T000453_reco_stage1_reco_stage2_20240926T144120_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
