Jobsub ID 263319.40@justin-prod-sched01.dune.hep.ac.uk
| Jobsub ID | 263319.40@justin-prod-sched01.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:05:04 |
| Site | IT_CNAF |
| Entry | CMSHTPC_T1_IT_CNAF_condor_ce02 |
| Last heartbeat | 2024-09-26 12:09:23 |
| From worker node | Hostname | cn-leo-162.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:28:52 |
| Input files | hd-protodune:np04hd_raw_run029081_0880_dataflow5_datawriter_0_20240905T063726.hdf5
|
| Jobscript | Exit code | 1 |
| Real time | 0m (0s) |
| CPU time | 0m (0s = 0%) |
| Outputting started | |
| Output files | |
| Finished | 2024-09-26 12:09:23 |
| List job events Wrapper job log |
Jobscript log (last 10,000 characters)
232 tests to find 6210 neighbours
Iterating with no regularization...
Begin: 3.99983e+06
0 3.73025e+06
1 3.72705e+06
Now with regularization...
Begin: 3.50977e+06
0 3.50909e+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: 29081 subRun: 1 event: 211429 at 26-Sep-2024 13:38:58 CEST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 68173 traces, 68173 summary
Retagger: tagging trace set: gauss with 51948 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 51948 traces tagged "gauss"
FrameSaver: q=1.05323e+06 n=951805 tag=gauss
wclsFrameSaver: saving 68173 traces tagged "wiener"
FrameSaver: q=1.13014e+06 n=867379 tag=wiener
5385 hits in TPC 0
4941 hits in TPC 1
4222 hits in TPC 2
2415 hits in TPC 3
4550 hits in TPC 4
6974 hits in TPC 5
4660 hits in TPC 6
2580 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 2429 XUs and 1905 XVs -> 37 XUVs
C:0 T:2 24719 XUs and 45601 XVs -> 542 XUVs
C:0 T:3 4 XUs and 4 XVs -> 0 XUVs
C:0 T:4 76 XUs and 85 XVs -> 0 XUVs
C:0 T:5 48481 XUs and 23883 XVs -> 1761 XUVs
C:0 T:6 16397 XUs and 32428 XVs -> 1108 XUVs
C:0 T:7 175 XUs and 227 XVs -> 6 XUVs
3454 XUVs total
1246 collection wire objects
3454 potential space points
Neighbour search...
219064 tests to find 120476 neighbours
Iterating with no regularization...
Begin: 7.62127e+06
0 7.22572e+06
1 7.19768e+06
2 7.19293e+06
Now with regularization...
Begin: 6.87045e+06
0 6.86857e+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
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
no of hits closeby 0 event 211429 TrkackID 4 startx, y, z 265.457 403.966 110.398 wireno, peakt tpcno 314 3372.07 2 dist 31.4178min T, max_T5 3399.74
no of hits closeby 0 event 211429 TrkackID 4 startx, y, z 265.457 403.966 110.398 wireno, peakt tpcno 314 3372.07 2 dist 31.4178min T, max_T5 3399.74
Begin processing the 30th record. run: 29081 subRun: 1 event: 211437 at 26-Sep-2024 13:40:49 CEST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 61100 traces, 61100 summary
Retagger: tagging trace set: gauss with 45735 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 45735 traces tagged "gauss"
FrameSaver: q=1.00465e+06 n=857320 tag=gauss
wclsFrameSaver: saving 61100 traces tagged "wiener"
FrameSaver: q=1.08997e+06 n=779456 tag=wiener
2052 hits in TPC 0
2375 hits in TPC 1
6878 hits in TPC 2
3044 hits in TPC 3
3693 hits in TPC 4
5717 hits in TPC 5
5642 hits in TPC 6
3288 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 983 XUs and 892 XVs -> 14 XUVs
C:0 T:2 83739 XUs and 32803 XVs -> 1058 XUVs
C:0 T:3 254 XUs and 267 XVs -> 13 XUVs
C:0 T:4 325 XUs and 438 XVs -> 20 XUVs
C:0 T:5 17224 XUs and 18699 XVs -> 527 XUVs
C:0 T:6 23273 XUs and 28380 XVs -> 691 XUVs
C:0 T:7 29 XUs and 67 XVs -> 3 XUVs
2326 XUVs total
1334 collection wire objects
2326 potential space points
Neighbour search...
56644 tests to find 31858 neighbours
Iterating with no regularization...
Begin: 1.51788e+07
0 1.42788e+07
1 1.42279e+07
2 1.42253e+07
Now with regularization...
Begin: 1.3644e+07
0 1.36421e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
26-Sep-2024 13:42:33 CEST Closed output file "np04hd_raw_run029081_0880_dataflow5_datawriter_0_20240905T063726_reco_stage1_reco_stage2_20240926T114233_keepup.root"
26-Sep-2024 13:42:33 CEST Closed input file "np04hd_raw_run029081_0880_dataflow5_datawriter_0_20240905T063726_reco_stage1.root"
========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
========================================================================================================================================
Full event 86.2435 107.96 158.763 105.915 15.1752 30
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000669813 0.00247659 0.00769825 0.00169098 0.00191865 30
produce:fembfilter:PDHDFEMBFilter 0.684186 0.74125 0.98813 0.733074 0.0501394 30
produce:wclsdatahd:WireCellToolkit 60.6479 63.9307 67.8063 64.0341 1.88364 30
produce:gaushit:GausHitFinder 0.286098 0.563807 0.820331 0.568144 0.125967 30
produce:nhitsfilter:NumberOfHitsFilter 0.000360275 0.000582376 0.000885811 0.000581377 0.000112242 30
produce:reco3d:SpacePointSolver 0.189424 1.41566 10.0779 0.79614 1.9104 30
produce:hitpdune:DisambigFromSpacePoints 0.112577 0.372479 1.265 0.35285 0.211079 30
produce:pandora:StandardPandora 3.32191 10.2349 31.7955 9.73463 5.34735 30
produce:pandoraWriter:StandardPandora 0.0799429 0.163555 0.243059 0.169145 0.036785 30
produce:pandoraTrack:LArPandoraTrackCreation 0.93081 2.35353 4.9351 2.38887 0.872898 30
produce:pandoraShower:LArPandoraShowerCreation 1.06666 2.9367 5.5472 2.78921 1.24493 30
produce:pandoracalo:Calorimetry 0.414057 0.945996 1.84579 0.961851 0.317961 30
produce:pandoracalonosce:Calorimetry 0.341534 0.899974 1.76841 0.873256 0.314133 30
produce:pandorapid:Chi2ParticleID 0.00103443 0.00171396 0.00293731 0.00164576 0.000353577 30
produce:pandoraShowercalo:ShowerCalorimetry 0.624596 2.27965 4.14847 2.31021 0.887645 30
produce:pandoraShowercalonosce:ShowerCalorimetry 0.626151 2.23222 4.05404 2.25595 0.866807 30
produce:pandoraGnocchiCalo:GnocchiCalorimetry 0.0502346 0.100526 0.140221 0.0995989 0.0230589 30
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry 0.0255388 0.0452733 0.0617236 0.0467486 0.00960852 30
produce:emtrkmichelid:EmTrackMichelId 10.1696 16.859 24.535 16.7633 3.71291 30
[art]:TriggerResults:TriggerResultInserter 4.5527e-05 8.50183e-05 0.000132601 8.3198e-05 1.61292e-05 30
end_path:out1:RootOutput 1.4914e-05 2.81705e-05 4.8157e-05 2.70095e-05 7.39968e-06 30
end_path:michelremoving:michelremoving 0.0246482 0.0875856 0.22362 0.0692395 0.0510024 30
end_path:michelremovinggnocchi:michelremoving 0.0205369 0.0827815 0.221184 0.0604186 0.0518965 30
end_path:calibanagnocchi:CalibAnaTree 0.223934 0.679152 1.33223 0.670214 0.244988 30
end_path:out1:RootOutput(write) 0.347265 0.628713 0.976137 0.615428 0.142974 30
========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5792.52 MB
Peak resident set size usage (VmHWM): 2614.14 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029081_0880_dataflow5_datawriter_0_20240905T063726_reco_stage1_reco_stage2_20240926T114233_keepup.root
\tHists: np04hd_raw_run029081_0880_dataflow5_datawriter_0_20240905T063726_reco_stage1_reco_stage2_20240926T114233_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
