Jobsub ID 234970.28@dunegpschedd02.fnal.gov
Jobscript log (last 10,000 characters)
: 5.39365e+07
0 5.39248e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
Begin processing the 9th record. run: 20250627 subRun: 1 event: 88 at 29-Oct-2025 20:42:33 UTC
Running Ophitfinder with InputDigiType = 'recob'
Found hits: 17131!
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 105790 traces, 105790 summary
Retagger: tagging trace set: gauss with 83958 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 83958 traces tagged "gauss"
FrameSaver: q=2.69182e+06 n=1365891 tag=gauss
wclsFrameSaver: saving 105790 traces tagged "wiener"
FrameSaver: q=3.50637e+06 n=1342680 tag=wiener
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 13496 XUs and 9606 XVs -> 141 XUVs
C:0 T:1 138320 XUs and 104610 XVs -> 5936 XUVs
C:0 T:2 25221 XUs and 19775 XVs -> 647 XUVs
C:0 T:3 6 XUs and 8 XVs -> 0 XUVs
C:0 T:4 37 XUs and 41 XVs -> 12 XUVs
C:0 T:5 73406 XUs and 49398 XVs -> 3017 XUVs
C:0 T:6 20273 XUs and 11870 XVs -> 371 XUVs
C:0 T:7 9 XUs and 24 XVs -> 0 XUVs
10124 XUVs total
3466 collection wire objects
10124 potential space points
Neighbour search...
458186 tests to find 261438 neighbours
Iterating with no regularization...
Begin: 3.68668e+07
0 3.42658e+07
1 3.40263e+07
2 3.39762e+07
3 3.39575e+07
Now with regularization...
Begin: 3.17021e+07
0 3.16902e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
Begin processing the 10th record. run: 20250627 subRun: 1 event: 89 at 29-Oct-2025 20:44:16 UTC
Running Ophitfinder with InputDigiType = 'recob'
Found hits: 18793!
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 99602 traces, 99602 summary
Retagger: tagging trace set: gauss with 77932 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 77932 traces tagged "gauss"
FrameSaver: q=2.50497e+06 n=1269562 tag=gauss
wclsFrameSaver: saving 99602 traces tagged "wiener"
FrameSaver: q=3.01969e+06 n=1228430 tag=wiener
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 10966 XUs and 10039 XVs -> 64 XUVs
C:0 T:1 36918 XUs and 38231 XVs -> 747 XUVs
C:0 T:2 33459 XUs and 28589 XVs -> 1117 XUVs
C:0 T:3 19 XUs and 19 XVs -> 0 XUVs
C:0 T:4 11 XUs and 11 XVs -> 0 XUVs
C:0 T:5 38621 XUs and 33916 XVs -> 1173 XUVs
C:0 T:6 19801 XUs and 16107 XVs -> 336 XUVs
C:0 T:7 1 XUs and 15 XVs -> 0 XUVs
3437 XUVs total
2138 collection wire objects
3437 potential space points
Neighbour search...
69799 tests to find 41196 neighbours
Iterating with no regularization...
Begin: 4.53459e+07
0 4.22967e+07
1 4.2002e+07
2 4.19637e+07
Now with regularization...
Begin: 3.96578e+07
0 3.96439e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
29-Oct-2025 20:45:44 UTC  Closed output file "pdhd_prod_beam__231691_46_1_20251008T183207Z_gen_g4_IonScintPDExt.root_227038_8_1_20251010T161203Z_PDInt.root_234970_28_1_20251029T193807Z_detsim_reco1.root"
29-Oct-2025 20:45:44 UTC  Closed input file "temp_detsim.root"
======================================================================================================================================
TimeTracker printout (sec)                              Min           Avg           Max         Median          RMS         nEvts   
======================================================================================================================================
Full event                                            84.4711       94.4127       103.996       93.9345       7.14331        10     
--------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                              0.000812519   0.00418637     0.0079383    0.00427377    0.00212165       10     
reco:opdec:Deconvolution                             0.436525      0.653382      0.772275      0.687684      0.0984889       10     
reco:ophitspe:OpHitFinderDeco                        0.0998821     0.108037      0.115418      0.108174     0.00418386       10     
reco:opflash:OpFlashFinder                           0.0422308     0.0821427     0.107037      0.084602      0.0206441       10     
reco:opslicer:OpSlicer                               0.107982      0.194002      0.256738      0.202435      0.0433375       10     
reco:wclsdatahd:WireCellToolkit                       32.3715       32.8856       33.4011       32.6985      0.336552        10     
reco:gaushit:GausHitFinder                           0.460066      0.587243      0.654798      0.601091      0.0557271       10     
reco:nhitsfilter:NumberOfHitsFilter                 0.000190924   0.000268435   0.00045613    0.000249375   6.77939e-05      10     
reco:reco3d:SpacePointSolver                         0.373548      0.676592      0.859403      0.667502       0.13788        10     
reco:hitpdune:DisambigFromSpacePoints                0.378777      0.529202       0.66918      0.520654      0.104161        10     
reco:pandora:StandardPandora                          11.0076       16.6367       23.2807       15.6733       3.43587        10     
reco:pandoraWriter:StandardPandora                    0.14824      0.177863      0.196623      0.179383      0.014195        10     
reco:pandoraTrack:LArPandoraTrackCreation            0.701958       1.16232       1.56303       1.13202      0.231249        10     
reco:pandoraShower:LArPandoraShowerCreation          0.780678       1.29474       1.60983       1.30487      0.215659        10     
reco:pandoracalo:Calorimetry                         0.395736      0.647164      0.864532       0.61533      0.133202        10     
reco:pandoracalonosce:Calorimetry                    0.392126       0.6385       0.842844      0.606478       0.13052        10     
reco:pandoraShowercalo:ShowerCalorimetry             0.827247       1.37545       1.90195       1.31354      0.306069        10     
reco:pandoraShowercalonosce:ShowerCalorimetry        0.789591       1.3055        1.80752       1.23596      0.293024        10     
reco:pandoraGnocchiCalo:GnocchiCalorimetry           0.0277467     0.0368224     0.0470186     0.035788     0.00526589       10     
reco:pandoraGnocchiCalonosce:GnocchiCalorimetry      0.0274239     0.0351999     0.0452543     0.0345276    0.00446099       10     
reco:emtrkmichelid:EmTrackMichelId                    18.4007       23.3289       27.3776       23.1759       2.42582        10     
reco:crttag:SingleCRTMatchingProducer               0.00313536    0.00404683    0.00627806    0.00365778    0.00103486       10     
reco:crtreco:TwoCRTMatchingProducer                 0.00322372    0.00374656    0.00476856    0.00357632    0.000465591      10     
reco:pandora2Track:LArPandoraTrackCreation            2.25215       3.19121       4.24361       3.02608      0.561844        10     
reco:pandora2calo:ShowerCalorimetry                  0.742108       1.21599       1.68535       1.1509       0.284063        10     
reco:pandora2calonosce:ShowerCalorimetry             0.734456       1.1999        1.66919       1.13395      0.281514        10     
reco:pandora2GnocchiCalo:GnocchiCalorimetry          0.0292292     0.0365983     0.0479569     0.0355686    0.00498461       10     
reco:pandora2GnocchiCalonosce:GnocchiCalorimetry     0.0290358     0.0350733     0.0452357     0.0337088    0.00457217       10     
reco:pandora2Shower:LArPandoraShowerCreation         0.912098       1.43682       1.84473       1.43035      0.254564        10     
reco:pandora2Showercalo:ShowerCalorimetry            0.990195       1.62322       2.24784       1.55385      0.374495        10     
reco:pandora2Showercalonosce:ShowerCalorimetry        1.04379       1.60089       2.24617       1.51947      0.367113        10     
[art]:TriggerResults:TriggerResultInserter          1.8536e-05    3.0436e-05    9.6203e-05    2.22225e-05   2.23185e-05      10     
end_path:out1:RootOutput                             5.31e-06     8.8629e-06    2.7863e-05     6.658e-06    6.38985e-06      10     
end_path:out1:RootOutput(write)                       1.24235       1.63761       1.8686        1.6419       0.172248        10     
======================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
  Peak virtual memory usage (VmPeak)  : 6120.64 MB
  Peak resident set size usage (VmHWM): 3927.38 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Reco returns 0
.:
total 12257884
-rw-r--r-- 1 dunegli fnalgrid      39161 Oct 29 20:45 jobscript.log
-rw-r--r-- 1 dunegli fnalgrid        199 Oct 29 20:45 justin-processed-pfns.txt
-rw-r--r-- 1 dunegli fnalgrid        519 Oct 29 20:45 reco_protodunehd_hist.root
-rw-r--r-- 1 dunegli fnalgrid       3574 Oct 29 20:45 Pandora_Geometry.xml
-rw-r--r-- 1 dunegli fnalgrid     200704 Oct 29 20:45 mem.db
-rw-r--r-- 1 dunegli fnalgrid      36864 Oct 29 20:45 time.db
-rw-r--r-- 1 dunegli fnalgrid 6436150511 Oct 29 20:45 pdhd_prod_beam__231691_46_1_20251008T183207Z_gen_g4_IonScintPDExt.root_227038_8_1_20251010T161203Z_PDInt.root_234970_28_1_20251029T193807Z_detsim_reco1.root
-rw-r--r-- 1 dunegli fnalgrid   57124560 Oct 29 20:45 Pandora_Events.pndr
-rw-r--r-- 1 dunegli fnalgrid          0 Oct 29 20:30 ProtoDUNE.log
-rw-r--r-- 1 dunegli fnalgrid          0 Oct 29 20:28 debugprod.log
-rw-r--r-- 1 dunegli fnalgrid        519 Oct 29 20:28 detsim_single_protodunehd_hist.root
-rw-r--r-- 1 dunegli fnalgrid 6058494955 Oct 29 20:28 temp_detsim.root
-rw-r--r-- 1 dunegli fnalgrid        120 Oct 29 19:38 all-input-dids.txt