Jobsub ID 264031.1@justin-prod-sched01.dune.hep.ac.uk
| Jobsub ID | 264031.1@justin-prod-sched01.dune.hep.ac.uk |
| Workflow ID | 3460 |
| 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 15:00:44 |
| Site | UK_Manchester |
| Entry | UBoone_T2_UK_Manchester_ce01 |
| Last heartbeat | 2024-09-26 16:01:38 |
| From worker node | Hostname | wn2209241.tier2.hep.manchester.ac.uk |
| cpuinfo | AMD EPYC 7513 32-Core Processor |
| 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 15:02:08 |
| Input files | hd-protodune:np04hd_raw_run029218_0096_dataflow6_datawriter_0_20240917T165102.hdf5
|
| Jobscript | Exit code | 1 |
| Real time | 0m (0s) |
| CPU time | 0m (0s = 0%) |
| Outputting started | |
| Output files | |
| Finished | 2024-09-26 16:01:38 |
| Saved logs | justin-logs:264031.1-justin-prod-sched01.dune.hep.ac.uk.logs.tgz |
| List job events Wrapper job log |
Jobscript log (last 10,000 characters)
ts in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 941 XUs and 849 XVs -> 117 XUVs
C:0 T:2 30222 XUs and 54781 XVs -> 3255 XUVs
C:0 T:3 343 XUs and 612 XVs -> 19 XUVs
C:0 T:4 245 XUs and 400 XVs -> 16 XUVs
C:0 T:5 12002 XUs and 17206 XVs -> 666 XUVs
C:0 T:6 23442 XUs and 45179 XVs -> 2457 XUVs
C:0 T:7 91 XUs and 103 XVs -> 5 XUVs
6535 XUVs total
1825 collection wire objects
6535 potential space points
Neighbour search...
631247 tests to find 284054 neighbours
Iterating with no regularization...
Begin: 1.04433e+07
0 9.01538e+06
1 8.89258e+06
2 8.87601e+06
3 8.87122e+06
Now with regularization...
Begin: 8.35019e+06
0 8.34706e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
Begin processing the 30th record. run: 29218 subRun: 1 event: 24086 at 26-Sep-2024 16:58:24 BST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 60908 traces, 60908 summary
Retagger: tagging trace set: gauss with 44850 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 44850 traces tagged "gauss"
FrameSaver: q=942430 n=860420 tag=gauss
wclsFrameSaver: saving 60908 traces tagged "wiener"
FrameSaver: q=1.00854e+06 n=775503 tag=wiener
3538 hits in TPC 0
3504 hits in TPC 1
5541 hits in TPC 2
4979 hits in TPC 3
2998 hits in TPC 4
4634 hits in TPC 5
4615 hits in TPC 6
3189 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 547 XUs and 632 XVs -> 29 XUVs
C:0 T:2 13170 XUs and 43895 XVs -> 1029 XUVs
C:0 T:3 191 XUs and 251 XVs -> 3 XUVs
C:0 T:4 153 XUs and 180 XVs -> 3 XUVs
C:0 T:5 14549 XUs and 17359 XVs -> 264 XUVs
C:0 T:6 9100 XUs and 12672 XVs -> 422 XUVs
C:0 T:7 66 XUs and 117 XVs -> 8 XUVs
1758 XUVs total
976 collection wire objects
1758 potential space points
Neighbour search...
57440 tests to find 32170 neighbours
Iterating with no regularization...
Begin: 7.0012e+06
0 6.23899e+06
1 6.21052e+06
2 6.20629e+06
Now with regularization...
Begin: 6.00868e+06
0 6.00727e+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 24086 TrkackID 1 startx, y, z 77.1395 507.955 452.199 wireno, peakt tpcno 82 1897.91 6 dist 384.718min T, max_T615.278 1909.15
no of hits closeby 0 event 24086 TrkackID 1 startx, y, z 77.1395 507.955 452.199 wireno, peakt tpcno 82 1897.91 6 dist 384.718min T, max_T615.278 1909.15
Begin processing the 31st record. run: 29218 subRun: 1 event: 24094 at 26-Sep-2024 16:59:53 BST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 55735 traces, 55735 summary
Retagger: tagging trace set: gauss with 42634 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 42634 traces tagged "gauss"
FrameSaver: q=940694 n=819124 tag=gauss
wclsFrameSaver: saving 55735 traces tagged "wiener"
FrameSaver: q=1.03021e+06 n=758126 tag=wiener
3025 hits in TPC 0
3390 hits in TPC 1
4990 hits in TPC 2
2634 hits in TPC 3
1470 hits in TPC 4
3885 hits in TPC 5
6980 hits in TPC 6
3378 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 5007 XUs and 5431 XVs -> 1763 XUVs
C:0 T:2 9321 XUs and 15975 XVs -> 996 XUVs
C:0 T:3 335 XUs and 473 XVs -> 16 XUVs
C:0 T:4 291 XUs and 240 XVs -> 9 XUVs
C:0 T:5 19830 XUs and 6519 XVs -> 551 XUVs
C:0 T:6 22044 XUs and 36530 XVs -> 720 XUVs
C:0 T:7 219 XUs and 248 XVs -> 3 XUVs
4058 XUVs total
1546 collection wire objects
4058 potential space points
Neighbour search...
141604 tests to find 87536 neighbours
Iterating with no regularization...
Begin: 7.59509e+06
0 7.02007e+06
1 6.9724e+06
2 6.96823e+06
Now with regularization...
Begin: 6.64246e+06
0 6.64114e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
26-Sep-2024 17:01:09 BST Closed output file "np04hd_raw_run029218_0096_dataflow6_datawriter_0_20240917T165102_reco_stage1_reco_stage2_20240926T160109_keepup.root"
26-Sep-2024 17:01:09 BST Closed input file "np04hd_raw_run029218_0096_dataflow6_datawriter_0_20240917T165102_reco_stage1.root"
========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
========================================================================================================================================
Full event 50.7857 70.5502 94.1728 67.9084 12.2899 31
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000401975 0.00241437 0.00368735 0.00234762 0.000795982 31
produce:fembfilter:PDHDFEMBFilter 0.472191 0.610744 0.807161 0.543864 0.120391 31
produce:wclsdatahd:WireCellToolkit 27.4056 31.5353 40.0988 31.2161 3.15679 31
produce:gaushit:GausHitFinder 0.346631 0.549373 0.838839 0.51334 0.131279 31
produce:nhitsfilter:NumberOfHitsFilter 0.000215746 0.000339014 0.000915572 0.000309482 0.000125199 31
produce:reco3d:SpacePointSolver 0.177167 0.577253 3.83077 0.340665 0.672599 31
produce:hitpdune:DisambigFromSpacePoints 0.11226 0.345773 0.79495 0.291461 0.171078 31
produce:pandora:StandardPandora 3.43247 8.32779 16.6407 7.83288 2.88487 31
produce:pandoraWriter:StandardPandora 0.0816856 0.142978 0.266137 0.130022 0.0486193 31
produce:pandoraTrack:LArPandoraTrackCreation 0.348825 0.924791 2.43988 0.906743 0.414182 31
produce:pandoraShower:LArPandoraShowerCreation 0.382842 1.07024 2.69039 0.899705 0.571614 31
produce:pandoracalo:Calorimetry 0.216144 0.488938 1.10637 0.438818 0.193095 31
produce:pandoracalonosce:Calorimetry 0.197884 0.438583 1.01904 0.380129 0.179345 31
produce:pandorapid:Chi2ParticleID 0.000975114 0.00174905 0.00571657 0.00141056 0.000875946 31
produce:pandoraShowercalo:ShowerCalorimetry 0.329977 1.0071 2.36638 0.918057 0.517665 31
produce:pandoraShowercalonosce:ShowerCalorimetry 0.315711 0.942828 2.31019 0.82338 0.469659 31
produce:pandoraGnocchiCalo:GnocchiCalorimetry 0.0624576 0.11508 0.243451 0.100442 0.0478527 31
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry 0.0211592 0.0374623 0.0857325 0.0327626 0.0144702 31
produce:emtrkmichelid:EmTrackMichelId 14.1715 22.0375 31.9464 20.9351 4.83365 31
[art]:TriggerResults:TriggerResultInserter 1.9807e-05 4.64771e-05 0.000143329 3.9124e-05 2.41761e-05 31
end_path:out1:RootOutput 9.418e-06 1.53567e-05 4.4413e-05 1.2283e-05 7.90612e-06 31
end_path:michelremoving:michelremoving 0.0123542 0.0740508 0.295922 0.0399246 0.0672074 31
end_path:michelremovinggnocchi:michelremoving 0.011634 0.0679414 0.297411 0.0316175 0.0627687 31
end_path:calibanagnocchi:CalibAnaTree 0.143946 0.375768 0.818077 0.362503 0.146166 31
end_path:out1:RootOutput(write) 0.414361 0.753336 1.43357 0.707713 0.247898 31
========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4949.17 MB
Peak resident set size usage (VmHWM): 2603.77 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029218_0096_dataflow6_datawriter_0_20240917T165102_reco_stage1_reco_stage2_20240926T160109_keepup.root
\tHists: np04hd_raw_run029218_0096_dataflow6_datawriter_0_20240917T165102_reco_stage1_reco_stage2_20240926T160109_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
