Jobsub ID 263765.12@justin-prod-sched01.dune.hep.ac.uk
Jobsub ID | 263765.12@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:24:52 |
Site | UK_Durham |
Entry | DUNE_UK_SGridDurham_ce3 |
Last heartbeat | 2024-09-26 15:03:39 |
From worker node | Hostname | n172.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:30 |
Input files | hd-protodune:np04hd_raw_run029107_1982_dataflow6_datawriter_0_20240908T000357.hdf5
|
Jobscript | Exit code | 1 |
Real time | 0m (0s) |
CPU time | 0m (0s = 0%) |
Outputting started | |
Output files | |
Finished | 2024-09-26 15:03:39 |
Saved logs | justin-logs:263765.12-justin-prod-sched01.dune.hep.ac.uk.logs.tgz |
List job events Wrapper job log |
Jobscript log (last 10,000 characters)
------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
Begin processing the 29th record. run: 29107 subRun: 1 event: 475982 at 26-Sep-2024 15:59:45 BST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 66738 traces, 66738 summary
Retagger: tagging trace set: gauss with 49268 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 49268 traces tagged "gauss"
FrameSaver: q=1.04992e+06 n=933247 tag=gauss
wclsFrameSaver: saving 66738 traces tagged "wiener"
FrameSaver: q=1.13723e+06 n=849095 tag=wiener
3784 hits in TPC 0
3721 hits in TPC 1
8044 hits in TPC 2
3489 hits in TPC 3
4325 hits in TPC 4
7827 hits in TPC 5
4639 hits in TPC 6
1387 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 32 XUs and 21 XVs -> 1 XUVs
C:0 T:2 23837 XUs and 71617 XVs -> 1074 XUVs
C:0 T:3 201 XUs and 375 XVs -> 30 XUVs
C:0 T:4 507 XUs and 430 XVs -> 5 XUVs
C:0 T:5 61284 XUs and 37329 XVs -> 511 XUVs
C:0 T:6 25907 XUs and 57403 XVs -> 3032 XUVs
C:0 T:7 9 XUs and 23 XVs -> 1 XUVs
4654 XUVs total
1214 collection wire objects
4654 potential space points
Neighbour search...
398050 tests to find 160728 neighbours
Iterating with no regularization...
Begin: 6.99708e+06
0 6.36419e+06
1 6.33243e+06
2 6.32744e+06
Now with regularization...
Begin: 6.05796e+06
0 6.05544e+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 475982 TrkackID 7 startx, y, z 48.8271 228.554 16.8677 wireno, peakt tpcno 210 3053.11 2 dist 218.468min T, max_T2048.92 3080.24
no of hits closeby 0 event 475982 TrkackID 7 startx, y, z 48.8271 228.554 16.8677 wireno, peakt tpcno 210 3053.11 2 dist 218.468min T, max_T2048.92 3080.24
Begin processing the 30th record. run: 29107 subRun: 1 event: 475990 at 26-Sep-2024 16:01:39 BST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 75352 traces, 75352 summary
Retagger: tagging trace set: gauss with 57191 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 57191 traces tagged "gauss"
FrameSaver: q=1.24294e+06 n=1045101 tag=gauss
wclsFrameSaver: saving 75352 traces tagged "wiener"
FrameSaver: q=1.32207e+06 n=938891 tag=wiener
1651 hits in TPC 0
2931 hits in TPC 1
6447 hits in TPC 2
3721 hits in TPC 3
6075 hits in TPC 4
9307 hits in TPC 5
5719 hits in TPC 6
2982 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 214 XUs and 121 XVs -> 1 XUVs
C:0 T:2 16193 XUs and 33202 XVs -> 462 XUVs
C:0 T:3 98 XUs and 146 XVs -> 4 XUVs
C:0 T:4 419 XUs and 190 XVs -> 4 XUVs
C:0 T:5 52075 XUs and 32228 XVs -> 857 XUVs
C:0 T:6 12450 XUs and 14485 XVs -> 501 XUVs
C:0 T:7 172 XUs and 136 XVs -> 7 XUVs
1836 XUVs total
1109 collection wire objects
1836 potential space points
Neighbour search...
31724 tests to find 19514 neighbours
Iterating with no regularization...
Begin: 7.09104e+06
0 6.56911e+06
1 6.53619e+06
2 6.53032e+06
Now with regularization...
Begin: 6.18321e+06
0 6.18069e+06
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
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
no of hits closeby 0 event 475990 TrkackID 7 startx, y, z 343.898 559.349 69.8634 wireno, peakt tpcno 20 5132.07 6 dist 94.0678min T, max_T781 5132.07
no of hits closeby 0 event 475990 TrkackID 7 startx, y, z 343.898 559.349 69.8634 wireno, peakt tpcno 20 5132.07 6 dist 94.0678min T, max_T781 5132.07
26-Sep-2024 16:03:15 BST Closed output file "np04hd_raw_run029107_1982_dataflow6_datawriter_0_20240908T000357_reco_stage1_reco_stage2_20240926T150315_keepup.root"
26-Sep-2024 16:03:15 BST Closed input file "np04hd_raw_run029107_1982_dataflow6_datawriter_0_20240908T000357_reco_stage1.root"
========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
========================================================================================================================================
Full event 63.0421 100.001 162.687 96.1847 19.8984 30
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000300649 0.00117209 0.00362983 0.0010161 0.000848863 30
produce:fembfilter:PDHDFEMBFilter 0.711034 0.820273 1.15266 0.791664 0.101226 30
produce:wclsdatahd:WireCellToolkit 44.136 48.5913 55.4539 47.7748 3.22773 30
produce:gaushit:GausHitFinder 0.368627 0.813865 1.26789 0.810279 0.204075 30
produce:nhitsfilter:NumberOfHitsFilter 0.000242994 0.000374183 0.000536971 0.000366983 7.21269e-05 30
produce:reco3d:SpacePointSolver 0.0747815 1.12947 3.79534 0.846917 0.889096 30
produce:hitpdune:DisambigFromSpacePoints 0.120785 0.609882 1.41544 0.548308 0.301556 30
produce:pandora:StandardPandora 3.74337 14.1301 36.7711 12.5807 6.73834 30
produce:pandoraWriter:StandardPandora 0.0929858 0.171608 0.256221 0.169882 0.0377315 30
produce:pandoraTrack:LArPandoraTrackCreation 0.641106 2.33569 5.78653 2.02931 1.16835 30
produce:pandoraShower:LArPandoraShowerCreation 0.382601 2.68137 6.22079 2.41564 1.42268 30
produce:pandoracalo:Calorimetry 0.292233 0.96408 2.49083 0.83712 0.442905 30
produce:pandoracalonosce:Calorimetry 0.256948 0.890653 2.30726 0.779026 0.417218 30
produce:pandorapid:Chi2ParticleID 0.00122418 0.00196064 0.00285495 0.00191236 0.000376533 30
produce:pandoraShowercalo:ShowerCalorimetry 0.290469 2.34748 5.74187 2.22024 1.23487 30
produce:pandoraShowercalonosce:ShowerCalorimetry 0.282296 2.32559 5.59392 2.06852 1.27186 30
produce:pandoraGnocchiCalo:GnocchiCalorimetry 0.0684443 0.138705 0.256799 0.138985 0.0416677 30
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry 0.027077 0.0561675 0.105391 0.0562144 0.0162265 30
produce:emtrkmichelid:EmTrackMichelId 10.1851 20.0146 31.6219 19.4704 4.85055 30
[art]:TriggerResults:TriggerResultInserter 2.4708e-05 4.20269e-05 0.000134082 3.84705e-05 1.81071e-05 30
end_path:out1:RootOutput 7.579e-06 1.20921e-05 4.083e-05 1.03495e-05 5.85607e-06 30
end_path:michelremoving:michelremoving 0.0203747 0.0910115 0.31324 0.0603221 0.0778528 30
end_path:michelremovinggnocchi:michelremoving 0.0199735 0.0860369 0.300893 0.0532764 0.0753513 30
end_path:calibanagnocchi:CalibAnaTree 0.186698 0.739636 1.84064 0.719365 0.349264 30
end_path:out1:RootOutput(write) 0.422645 0.870681 1.55799 0.834311 0.244661 30
========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5846.59 MB
Peak resident set size usage (VmHWM): 2927.49 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029107_1982_dataflow6_datawriter_0_20240908T000357_reco_stage1_reco_stage2_20240926T150315_keepup.root
\tHists: np04hd_raw_run029107_1982_dataflow6_datawriter_0_20240908T000357_reco_stage1_reco_stage2_20240926T150315_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