Jobsub ID 78491.70@justin-prod-sched02.dune.hep.ac.uk
Jobsub ID | 78491.70@justin-prod-sched02.dune.hep.ac.uk |
Workflow ID | 3447 |
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 10:11:15 |
Site | IT_CNAF |
Entry | CMSHTPC_T1_IT_CNAF_condor_ce02 |
Last heartbeat | 2024-09-26 12:18:16 |
From worker node | Hostname | cn-leo-091.cr.cnaf.infn.it |
cpuinfo | Intel(R) Xeon(R) Platinum 8480+ |
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 | outputting_failed |
Allocator name | justin-allocator-pro.dune.hep.ac.uk |
Started | 2024-09-26 10:43:58 |
Input files | hd-protodune:np04hd_raw_run029092_0406_dataflow4_datawriter_0_20240905T234517.hdf5
|
Jobscript | Exit code | 1 |
Real time | 0m (0s) |
CPU time | 0m (0s = 0%) |
Outputting started | |
Output files | |
Finished | 2024-09-26 12:18:16 |
List job events Wrapper job log |
Jobscript log (last 10,000 characters)
in TPC 0
2571 hits in TPC 1
4819 hits in TPC 2
2462 hits in TPC 3
2532 hits in TPC 4
3910 hits in TPC 5
3805 hits in TPC 6
2696 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 921 XUs and 1568 XVs -> 64 XUVs
C:0 T:2 12006 XUs and 15042 XVs -> 395 XUVs
C:0 T:3 19 XUs and 35 XVs -> 0 XUVs
C:0 T:4 34 XUs and 62 XVs -> 1 XUVs
C:0 T:5 42743 XUs and 46933 XVs -> 2478 XUVs
C:0 T:6 41581 XUs and 35383 XVs -> 984 XUVs
C:0 T:7 59 XUs and 158 XVs -> 2 XUVs
3924 XUVs total
1064 collection wire objects
3924 potential space points
Neighbour search...
219662 tests to find 118982 neighbours
Iterating with no regularization...
Begin: 8.10738e+06
0 6.96825e+06
1 6.90594e+06
2 6.89276e+06
3 6.88794e+06
Now with regularization...
Begin: 6.64522e+06
0 6.64269e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
Begin processing the 29th record. run: 29092 subRun: 1 event: 97668 at 26-Sep-2024 13:50:34 CEST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 42121 traces, 42121 summary
Retagger: tagging trace set: gauss with 33107 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 33107 traces tagged "gauss"
FrameSaver: q=756325 n=689530 tag=gauss
wclsFrameSaver: saving 42121 traces tagged "wiener"
FrameSaver: q=795052 n=633567 tag=wiener
2495 hits in TPC 0
1998 hits in TPC 1
4525 hits in TPC 2
4565 hits in TPC 3
1320 hits in TPC 4
2437 hits in TPC 5
4905 hits in TPC 6
2632 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 31 XUs and 51 XVs -> 3 XUVs
C:0 T:2 10886 XUs and 13367 XVs -> 547 XUVs
C:0 T:3 686 XUs and 535 XVs -> 14 XUVs
C:0 T:4 13 XUs and 14 XVs -> 2 XUVs
C:0 T:5 3083 XUs and 3207 XVs -> 85 XUVs
C:0 T:6 7649 XUs and 8140 XVs -> 419 XUVs
C:0 T:7 450 XUs and 356 XVs -> 30 XUVs
1100 XUVs total
787 collection wire objects
1100 potential space points
Neighbour search...
10682 tests to find 5422 neighbours
Iterating with no regularization...
Begin: 5.11544e+06
0 4.91301e+06
1 4.9048e+06
2 4.90451e+06
Now with regularization...
Begin: 4.47797e+06
0 4.47779e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
no of hits closeby 0 event 97668 TrkackID 4 startx, y, z 206.521 433.009 200.109 wireno, peakt tpcno 172 1954.24 5 dist 0min T, max_T2.25711 2620.1
no of hits closeby 0 event 97668 TrkackID 4 startx, y, z 206.521 433.009 200.109 wireno, peakt tpcno 172 1954.24 5 dist 0min T, max_T2.25711 2620.1
Begin processing the 30th record. run: 29092 subRun: 1 event: 97724 at 26-Sep-2024 13:51:57 CEST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 30344 traces, 30344 summary
Retagger: tagging trace set: gauss with 24338 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 24338 traces tagged "gauss"
FrameSaver: q=532555 n=512714 tag=gauss
wclsFrameSaver: saving 30344 traces tagged "wiener"
FrameSaver: q=564153 n=478470 tag=wiener
1005 hits in TPC 0
1456 hits in TPC 1
1758 hits in TPC 2
1396 hits in TPC 3
2892 hits in TPC 4
5886 hits in TPC 5
2247 hits in TPC 6
1821 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 4 XUs and 17 XVs -> 0 XUVs
C:0 T:2 2173 XUs and 1982 XVs -> 35 XUVs
C:0 T:3 5 XUs and 16 XVs -> 5 XUVs
C:0 T:4 755 XUs and 882 XVs -> 74 XUVs
C:0 T:5 10873 XUs and 10682 XVs -> 575 XUVs
C:0 T:6 2877 XUs and 2632 XVs -> 71 XUVs
C:0 T:7 614 XUs and 474 XVs -> 27 XUVs
787 XUVs total
521 collection wire objects
787 potential space points
Neighbour search...
10675 tests to find 5936 neighbours
Iterating with no regularization...
Begin: 3.33043e+06
0 3.12724e+06
1 3.11376e+06
2 3.11311e+06
Now with regularization...
Begin: 2.9003e+06
0 2.89999e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
26-Sep-2024 13:53:15 CEST Closed output file "np04hd_raw_run029092_0406_dataflow4_datawriter_0_20240905T234517_reco_stage1_reco_stage2_20240926T115315_keepup.root"
26-Sep-2024 13:53:15 CEST Closed input file "np04hd_raw_run029092_0406_dataflow4_datawriter_0_20240905T234517_reco_stage1.root"
========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
========================================================================================================================================
Full event 77.2338 96.6897 117.802 96.1191 11.0634 30
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000481481 0.00275951 0.00830017 0.00170412 0.00237377 30
produce:fembfilter:PDHDFEMBFilter 0.672457 0.716705 1.05649 0.699095 0.0740108 30
produce:wclsdatahd:WireCellToolkit 55.1965 58.2467 61.401 58.1674 1.29601 30
produce:gaushit:GausHitFinder 0.33735 0.532382 0.750258 0.517781 0.119848 30
produce:nhitsfilter:NumberOfHitsFilter 0.000329217 0.000535276 0.000701349 0.000526646 9.67926e-05 30
produce:reco3d:SpacePointSolver 0.135375 0.950063 3.13713 0.793788 0.662678 30
produce:hitpdune:DisambigFromSpacePoints 0.122593 0.313593 0.562624 0.312717 0.107659 30
produce:pandora:StandardPandora 4.23158 9.30861 22.7206 8.52182 4.18543 30
produce:pandoraWriter:StandardPandora 0.100142 0.152758 0.211044 0.155837 0.0307022 30
produce:pandoraTrack:LArPandoraTrackCreation 1.16197 2.16612 3.41686 2.23579 0.654382 30
produce:pandoraShower:LArPandoraShowerCreation 0.842985 2.54691 4.26697 2.40763 0.873498 30
produce:pandoracalo:Calorimetry 0.459553 0.868592 1.32777 0.880319 0.247161 30
produce:pandoracalonosce:Calorimetry 0.436333 0.811465 1.23527 0.844358 0.228791 30
produce:pandorapid:Chi2ParticleID 0.00124221 0.00165232 0.00302729 0.00151128 0.000360306 30
produce:pandoraShowercalo:ShowerCalorimetry 0.620156 2.01238 3.58922 1.99988 0.738538 30
produce:pandoraShowercalonosce:ShowerCalorimetry 0.600262 1.95412 3.51522 2.0211 0.717022 30
produce:pandoraGnocchiCalo:GnocchiCalorimetry 0.0448465 0.0919445 0.13231 0.0925413 0.0199166 30
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry 0.0221588 0.0412755 0.0573465 0.0415444 0.00895134 30
produce:emtrkmichelid:EmTrackMichelId 9.4912 14.2442 20.3767 14.58 2.89842 30
[art]:TriggerResults:TriggerResultInserter 4.9848e-05 7.07795e-05 9.599e-05 6.9212e-05 1.01223e-05 30
end_path:out1:RootOutput 1.5578e-05 2.27516e-05 3.4638e-05 2.1294e-05 4.71624e-06 30
end_path:michelremoving:michelremoving 0.0305899 0.0763786 0.223677 0.0577651 0.0448362 30
end_path:michelremovinggnocchi:michelremoving 0.030071 0.0733295 0.228665 0.0521117 0.0447264 30
end_path:calibanagnocchi:CalibAnaTree 0.275588 0.624382 1.03811 0.610843 0.179757 30
end_path:out1:RootOutput(write) 0.318561 0.583608 0.854203 0.588358 0.125491 30
========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5775.47 MB
Peak resident set size usage (VmHWM): 2611.14 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029092_0406_dataflow4_datawriter_0_20240905T234517_reco_stage1_reco_stage2_20240926T115315_keepup.root
\tHists: np04hd_raw_run029092_0406_dataflow4_datawriter_0_20240905T234517_reco_stage1_reco_stage2_20240926T115315_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