Jobsub ID 79031.1@justin-prod-sched02.dune.hep.ac.uk
Jobsub ID | 79031.1@justin-prod-sched02.dune.hep.ac.uk |
Workflow ID | 3449 |
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 14:02:34 |
Site | IT_CNAF |
Entry | CMSHTPC_T1_IT_CNAF_condor_ce02 |
Last heartbeat | 2024-09-26 15:48:08 |
From worker node | Hostname | cn-608-05-08.cr.cnaf.infn.it |
cpuinfo | Intel(R) Xeon(R) CPU E5-2697 v4 @ 2.30GHz |
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 14:03:18 |
Input files | hd-protodune:np04hd_raw_run029107_0710_dataflow2_datawriter_0_20240907T024456.hdf5
|
Jobscript | Exit code | 1 |
Real time | 0m (0s) |
CPU time | 0m (0s = 0%) |
Outputting started | |
Output files | |
Finished | 2024-09-26 15:48:08 |
Saved logs | justin-logs:79031.1-justin-prod-sched02.dune.hep.ac.uk.logs.tgz |
List job events Wrapper job log |
Jobscript log (last 10,000 characters)
6788 neighbours
Iterating with no regularization...
Begin: 6.24998e+06
0 6.05446e+06
1 6.04938e+06
Now with regularization...
Begin: 5.65351e+06
0 5.65286e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
no of hits closeby 4 event 170642 TrkackID 15 startx, y, z -72.9251 78.1152 274.733 wireno, peakt tpcno 131 543.969 6 dist 1.48619min T, max_T5 913
no of hits closeby 4 event 170642 TrkackID 15 startx, y, z -72.9251 78.1152 274.733 wireno, peakt tpcno 131 543.969 6 dist 1.48619min T, max_T5 913
Begin processing the 29th record. run: 29107 subRun: 1 event: 170650 at 26-Sep-2024 17:42:10 CEST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 38267 traces, 38267 summary
Retagger: tagging trace set: gauss with 29333 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 29333 traces tagged "gauss"
FrameSaver: q=703130 n=587323 tag=gauss
wclsFrameSaver: saving 38267 traces tagged "wiener"
FrameSaver: q=770065 n=538075 tag=wiener
3454 hits in TPC 0
2342 hits in TPC 1
4648 hits in TPC 2
1994 hits in TPC 3
2923 hits in TPC 4
4557 hits in TPC 5
1698 hits in TPC 6
1215 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 4733 XUs and 6653 XVs -> 934 XUVs
C:0 T:2 8441 XUs and 6860 XVs -> 361 XUVs
C:0 T:3 1430 XUs and 3655 XVs -> 212 XUVs
C:0 T:4 186 XUs and 220 XVs -> 16 XUVs
C:0 T:5 12890 XUs and 17711 XVs -> 693 XUVs
C:0 T:6 2155 XUs and 1497 XVs -> 91 XUVs
C:0 T:7 14 XUs and 8 XVs -> 0 XUVs
2307 XUVs total
615 collection wire objects
2307 potential space points
Neighbour search...
107263 tests to find 64238 neighbours
Iterating with no regularization...
Begin: 5.31141e+06
0 4.34123e+06
1 4.27753e+06
2 4.27137e+06
3 4.26972e+06
Now with regularization...
Begin: 4.11129e+06
0 4.10989e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
Begin processing the 30th record. run: 29107 subRun: 1 event: 170690 at 26-Sep-2024 17:44:30 CEST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 85348 traces, 85348 summary
Retagger: tagging trace set: gauss with 62190 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 62190 traces tagged "gauss"
FrameSaver: q=1.29545e+06 n=1117299 tag=gauss
wclsFrameSaver: saving 85348 traces tagged "wiener"
FrameSaver: q=1.39446e+06 n=1002883 tag=wiener
7318 hits in TPC 0
5396 hits in TPC 1
6845 hits in TPC 2
4065 hits in TPC 3
3937 hits in TPC 4
6622 hits in TPC 5
7433 hits in TPC 6
2735 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 1520 XUs and 805 XVs -> 39 XUVs
C:0 T:2 24741 XUs and 42660 XVs -> 3733 XUVs
C:0 T:3 19 XUs and 14 XVs -> 0 XUVs
C:0 T:4 160 XUs and 206 XVs -> 9 XUVs
C:0 T:5 36736 XUs and 35628 XVs -> 1070 XUVs
C:0 T:6 23565 XUs and 30971 XVs -> 1323 XUVs
C:0 T:7 717 XUs and 1570 XVs -> 34 XUVs
6208 XUVs total
1891 collection wire objects
6208 potential space points
Neighbour search...
429634 tests to find 256828 neighbours
Iterating with no regularization...
Begin: 8.34542e+06
0 7.63209e+06
1 7.57626e+06
2 7.5652e+06
3 7.56122e+06
Now with regularization...
Begin: 6.9747e+06
0 6.97198e+06
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 5 event 170690 TrkackID 11 startx, y, z 32.3265 600.002 455.095 wireno, peakt tpcno 325 15 5 dist 0.915694min T, max_T6.19508 2215.07
no of hits closeby 5 event 170690 TrkackID 11 startx, y, z 32.3265 600.002 455.095 wireno, peakt tpcno 325 15 5 dist 0.915694min T, max_T6.19508 2215.07
26-Sep-2024 17:47:40 CEST Closed output file "np04hd_raw_run029107_0710_dataflow2_datawriter_0_20240907T024456_reco_stage1_reco_stage2_20240926T154740_keepup.root"
26-Sep-2024 17:47:40 CEST Closed input file "np04hd_raw_run029107_0710_dataflow2_datawriter_0_20240907T024456_reco_stage1.root"
========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
========================================================================================================================================
Full event 98.4193 160.071 253.609 152.375 38.3238 30
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000591445 0.0027307 0.00464345 0.00262882 0.00127663 30
produce:fembfilter:PDHDFEMBFilter 0.681541 0.924667 1.08401 1.05695 0.172037 30
produce:wclsdatahd:WireCellToolkit 53.9112 70.4988 84.9547 70.8993 8.75147 30
produce:gaushit:GausHitFinder 0.525259 1.08634 1.81821 1.03515 0.353965 30
produce:nhitsfilter:NumberOfHitsFilter 0.000237828 0.000473442 0.000709576 0.000473674 0.000110644 30
produce:reco3d:SpacePointSolver 0.218873 1.72475 10.0242 1.1266 1.94146 30
produce:hitpdune:DisambigFromSpacePoints 0.238702 1.09202 3.1452 0.886166 0.831419 30
produce:pandora:StandardPandora 7.65344 21.418 51.9159 18.6248 10.9855 30
produce:pandoraWriter:StandardPandora 0.117027 0.216613 0.416808 0.204214 0.0742329 30
produce:pandoraTrack:LArPandoraTrackCreation 0.97748 2.8204 9.62479 2.837 1.69291 30
produce:pandoraShower:LArPandoraShowerCreation 0.914389 3.09708 8.38711 2.65174 1.79159 30
produce:pandoracalo:Calorimetry 0.541873 1.26811 3.26048 1.03341 0.643089 30
produce:pandoracalonosce:Calorimetry 0.48859 1.20414 2.81951 0.978383 0.626191 30
produce:pandorapid:Chi2ParticleID 0.00140941 0.00284898 0.00520095 0.00264557 0.000967648 30
produce:pandoraShowercalo:ShowerCalorimetry 0.854061 2.85861 7.94474 2.22203 1.7519 30
produce:pandoraShowercalonosce:ShowerCalorimetry 0.820867 2.75361 7.46661 2.34458 1.63846 30
produce:pandoraGnocchiCalo:GnocchiCalorimetry 0.107875 0.187387 0.325091 0.168128 0.0637666 30
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry 0.0390419 0.0725911 0.129398 0.0663298 0.0256179 30
produce:emtrkmichelid:EmTrackMichelId 23.4751 46.3128 76.043 43.2135 12.3999 30
[art]:TriggerResults:TriggerResultInserter 2.7527e-05 5.78763e-05 8.9284e-05 5.61775e-05 1.60669e-05 30
end_path:out1:RootOutput 8.344e-06 1.3691e-05 2.9911e-05 1.16455e-05 4.92048e-06 30
end_path:michelremoving:michelremoving 0.0282473 0.116245 0.355996 0.0672271 0.0931151 30
end_path:michelremovinggnocchi:michelremoving 0.0328903 0.110479 0.34553 0.0640176 0.0907373 30
end_path:calibanagnocchi:CalibAnaTree 0.395621 0.999635 3.0951 0.844277 0.600215 30
end_path:out1:RootOutput(write) 0.571315 1.1563 2.02682 1.07583 0.384363 30
========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4914.48 MB
Peak resident set size usage (VmHWM): 2269.38 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029107_0710_dataflow2_datawriter_0_20240907T024456_reco_stage1_reco_stage2_20240926T154740_keepup.root
\tHists: np04hd_raw_run029107_0710_dataflow2_datawriter_0_20240907T024456_reco_stage1_reco_stage2_20240926T154740_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