Jobsub ID 263865.12@justin-prod-sched01.dune.hep.ac.uk
Jobsub ID | 263865.12@justin-prod-sched01.dune.hep.ac.uk |
Workflow ID | 3448 |
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:56:43 |
Site | IT_CNAF |
Entry | CMSHTPC_T1_IT_CNAF_condor_ce02 |
Last heartbeat | 2024-09-26 15:07:54 |
From worker node | Hostname | cn-leo-145.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 | jobscript_error |
Allocator name | justin-allocator-pro.dune.hep.ac.uk |
Started | 2024-09-26 13:58:00 |
Input files | hd-protodune:np04hd_raw_run029097_0129_dataflow6_datawriter_0_20240906T130243.hdf5
|
Jobscript | Exit code | 1 |
Real time | 0m (0s) |
CPU time | 0m (0s = 0%) |
Outputting started | |
Output files | |
Finished | 2024-09-26 15:07:54 |
Saved logs | justin-logs:263865.12-justin-prod-sched01.dune.hep.ac.uk.logs.tgz |
List job events Wrapper job log |
Jobscript log (last 10,000 characters)
0.00124168 0.00126982 0.00127029 0.00126982 0.00119305 0.00115108 0.00115061 0.00115108
----view 1: 0.00240707 0.00288868 0.00648022 0.00335407 0.0107703 0.00142384 0.0013957 0.00130463 0.00196362 0.00421429 0.00454712
TwoViewTransverseTracksAlgorithm: failed to calculate correlation coefficient p-value for these numbers
----view 0: 0.00120258 0.00120211 0.00124168 0.00126982 0.00127029 0.00126982 0.00119305 0.00115108 0.00115061 0.00115108 0.00121689
----view 1: 0.00288868 0.00648022 0.00335407 0.0107703 0.00142384 0.0013957 0.00130463 0.00196362 0.00421429 0.00454712 0.00477028
TwoViewTransverseTracksAlgorithm: failed to calculate correlation coefficient p-value for these numbers
----view 0: 0.00120211 0.00124168 0.00126982 0.00127029 0.00126982 0.00119305 0.00115108 0.00115061 0.00115108 0.00121689 0.00147533
----view 1: 0.00648022 0.00335407 0.0107703 0.00142384 0.0013957 0.00130463 0.00196362 0.00421429 0.00454712 0.00477028 0.00849724
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
Begin processing the 29th record. run: 29097 subRun: 1 event: 31190 at 26-Sep-2024 17:04:22 CEST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 58727 traces, 58727 summary
Retagger: tagging trace set: gauss with 41231 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 41231 traces tagged "gauss"
FrameSaver: q=948051 n=776338 tag=gauss
wclsFrameSaver: saving 58727 traces tagged "wiener"
FrameSaver: q=1.02703e+06 n=699283 tag=wiener
4894 hits in TPC 0
3155 hits in TPC 1
2486 hits in TPC 2
1961 hits in TPC 3
3716 hits in TPC 4
4487 hits in TPC 5
5527 hits in TPC 6
4323 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 785 XUs and 1575 XVs -> 170 XUVs
C:0 T:2 10927 XUs and 24008 XVs -> 755 XUVs
C:0 T:3 61 XUs and 74 XVs -> 3 XUVs
C:0 T:4 610 XUs and 1201 XVs -> 39 XUVs
C:0 T:5 6595 XUs and 10121 XVs -> 877 XUVs
C:0 T:6 33910 XUs and 43218 XVs -> 2207 XUVs
C:0 T:7 422 XUs and 287 XVs -> 12 XUVs
4063 XUVs total
1273 collection wire objects
4063 potential space points
Neighbour search...
166087 tests to find 91570 neighbours
Iterating with no regularization...
Begin: 1.66313e+07
0 1.50804e+07
1 1.49651e+07
2 1.49543e+07
Now with regularization...
Begin: 1.42759e+07
0 1.42721e+07
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
Begin processing the 30th record. run: 29097 subRun: 1 event: 31198 at 26-Sep-2024 17:05:53 CEST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 64862 traces, 64862 summary
Retagger: tagging trace set: gauss with 46417 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 46417 traces tagged "gauss"
FrameSaver: q=1.06545e+06 n=890552 tag=gauss
wclsFrameSaver: saving 64862 traces tagged "wiener"
FrameSaver: q=1.15399e+06 n=815021 tag=wiener
3304 hits in TPC 0
4824 hits in TPC 1
6210 hits in TPC 2
3106 hits in TPC 3
3853 hits in TPC 4
5915 hits in TPC 5
4882 hits in TPC 6
2144 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 566 XUs and 715 XVs -> 5 XUVs
C:0 T:2 21140 XUs and 25555 XVs -> 591 XUVs
C:0 T:3 116 XUs and 287 XVs -> 9 XUVs
C:0 T:4 119 XUs and 380 XVs -> 10 XUVs
C:0 T:5 23149 XUs and 31676 XVs -> 773 XUVs
C:0 T:6 6865 XUs and 26691 XVs -> 462 XUVs
C:0 T:7 782 XUs and 2251 XVs -> 142 XUVs
1992 XUVs total
1209 collection wire objects
1992 potential space points
Neighbour search...
47310 tests to find 25984 neighbours
Iterating with no regularization...
Begin: 9.26872e+06
0 8.56027e+06
1 8.53835e+06
2 8.53406e+06
Now with regularization...
Begin: 8.22833e+06
0 8.2272e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
26-Sep-2024 17:07:29 CEST Closed output file "np04hd_raw_run029097_0129_dataflow6_datawriter_0_20240906T130243_reco_stage1_reco_stage2_20240926T150729_keepup.root"
26-Sep-2024 17:07:29 CEST Closed input file "np04hd_raw_run029097_0129_dataflow6_datawriter_0_20240906T130243_reco_stage1.root"
========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
========================================================================================================================================
Full event 76.8858 98.0468 143.771 92.8135 14.8292 30
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00047686 0.00240965 0.00780362 0.00144649 0.00205105 30
produce:fembfilter:PDHDFEMBFilter 0.656603 0.703651 0.757514 0.703282 0.0210248 30
produce:wclsdatahd:WireCellToolkit 56.6855 59.6275 62.7059 59.6869 1.45367 30
produce:gaushit:GausHitFinder 0.318213 0.533279 0.782892 0.498861 0.132941 30
produce:nhitsfilter:NumberOfHitsFilter 0.000361792 0.000555783 0.00120601 0.000508187 0.000159928 30
produce:reco3d:SpacePointSolver 0.223849 0.953382 3.48641 0.62956 0.763199 30
produce:hitpdune:DisambigFromSpacePoints 0.126977 0.346356 0.976319 0.299195 0.176585 30
produce:pandora:StandardPandora 4.14758 9.41002 22.9499 8.5263 4.34303 30
produce:pandoraWriter:StandardPandora 0.0829436 0.149408 0.25374 0.138589 0.0423631 30
produce:pandoraTrack:LArPandoraTrackCreation 0.606865 2.30098 6.14631 2.04428 1.17956 30
produce:pandoraShower:LArPandoraShowerCreation 0.635157 3.0137 8.01231 2.58339 1.66992 30
produce:pandoracalo:Calorimetry 0.326449 0.934934 2.37508 0.833393 0.443968 30
produce:pandoracalonosce:Calorimetry 0.271631 0.882943 2.35322 0.80402 0.432129 30
produce:pandorapid:Chi2ParticleID 0.00105321 0.00163041 0.00265459 0.00152553 0.000350404 30
produce:pandoraShowercalo:ShowerCalorimetry 0.532185 2.33883 6.50906 2.03775 1.29946 30
produce:pandoraShowercalonosce:ShowerCalorimetry 0.516344 2.28277 6.33507 1.95741 1.24935 30
produce:pandoraGnocchiCalo:GnocchiCalorimetry 0.0581602 0.0966154 0.144636 0.0913006 0.0235314 30
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry 0.0258692 0.0439263 0.0660516 0.0428707 0.0119739 30
produce:emtrkmichelid:EmTrackMichelId 7.32343 12.6671 19.541 11.9096 2.90237 30
[art]:TriggerResults:TriggerResultInserter 5.4151e-05 6.9484e-05 0.000114979 6.52315e-05 1.37276e-05 30
end_path:out1:RootOutput 1.4618e-05 2.14855e-05 3.5705e-05 1.95925e-05 5.09285e-06 30
end_path:michelremoving:michelremoving 0.0236785 0.0682331 0.146548 0.0617161 0.0312928 30
end_path:michelremovinggnocchi:michelremoving 0.018312 0.0649148 0.156948 0.0583148 0.0337542 30
end_path:calibanagnocchi:CalibAnaTree 0.174445 0.673013 1.64569 0.599935 0.323606 30
end_path:out1:RootOutput(write) 0.327921 0.602434 0.944982 0.563675 0.148947 30
========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5822.69 MB
Peak resident set size usage (VmHWM): 2577.32 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029097_0129_dataflow6_datawriter_0_20240906T130243_reco_stage1_reco_stage2_20240926T150729_keepup.root
\tHists: np04hd_raw_run029097_0129_dataflow6_datawriter_0_20240906T130243_reco_stage1_reco_stage2_20240926T150729_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