Jobsub ID 234970.8@dunegpschedd02.fnal.gov
Jobscript log (last 10,000 characters)
XVs -> 1617 XUVs
5723 XUVs total
1875 collection wire objects
5723 potential space points
Neighbour search...
258021 tests to find 157254 neighbours
Iterating with no regularization...
Begin: 6.9209e+07
0 5.85052e+07
1 5.80702e+07
2 5.80088e+07
3 5.79867e+07
Now with regularization...
Begin: 5.613e+07
0 5.61166e+07
Begin processing the 9th record. run: 20250627 subRun: 1 event: 88 at 29-Oct-2025 20:38:00 UTC
Running Ophitfinder with InputDigiType = 'recob'
Found hits: 13137!
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 87391 traces, 87391 summary
Retagger: tagging trace set: gauss with 68841 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 68841 traces tagged "gauss"
FrameSaver: q=1.88194e+06 n=1005246 tag=gauss
wclsFrameSaver: saving 87391 traces tagged "wiener"
FrameSaver: q=2.46027e+06 n=994067 tag=wiener
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 7748 XUs and 6751 XVs -> 41 XUVs
C:0 T:1 51505 XUs and 52119 XVs -> 1754 XUVs
C:0 T:2 59592 XUs and 40995 XVs -> 2844 XUVs
C:0 T:3 25 XUs and 14 XVs -> 0 XUVs
C:0 T:5 28706 XUs and 22653 XVs -> 511 XUVs
C:0 T:6 38946 XUs and 17938 XVs -> 519 XUVs
5669 XUVs total
2370 collection wire objects
5669 potential space points
Neighbour search...
233905 tests to find 132962 neighbours
Iterating with no regularization...
Begin: 2.60931e+07
0 2.40331e+07
1 2.38816e+07
2 2.38645e+07
Now with regularization...
Begin: 2.24117e+07
0 2.24054e+07
Begin processing the 10th record. run: 20250627 subRun: 1 event: 89 at 29-Oct-2025 20:39:17 UTC
Running Ophitfinder with InputDigiType = 'recob'
Found hits: 17073!
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 96614 traces, 96614 summary
Retagger: tagging trace set: gauss with 76600 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 76600 traces tagged "gauss"
FrameSaver: q=2.22659e+06 n=1172973 tag=gauss
wclsFrameSaver: saving 96614 traces tagged "wiener"
FrameSaver: q=2.83243e+06 n=1115702 tag=wiener
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 14290 XUs and 9033 XVs -> 91 XUVs
C:0 T:1 77959 XUs and 46799 XVs -> 1639 XUVs
C:0 T:2 11627 XUs and 18042 XVs -> 821 XUVs
C:0 T:3 26 XUs and 181 XVs -> 6 XUVs
C:0 T:4 23 XUs and 10 XVs -> 0 XUVs
C:0 T:5 49682 XUs and 24608 XVs -> 674 XUVs
C:0 T:6 14216 XUs and 17388 XVs -> 475 XUVs
3706 XUVs total
2010 collection wire objects
3706 potential space points
Neighbour search...
57508 tests to find 33874 neighbours
Iterating with no regularization...
Begin: 3.50149e+07
0 3.34224e+07
1 3.33238e+07
2 3.33125e+07
Now with regularization...
Begin: 3.21841e+07
0 3.21819e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
29-Oct-2025 20:40:46 UTC  Closed output file "pdhd_prod_beam__231691_94_1_20251008T183449Z_gen_g4_IonScintPDExt.root_227038_4_1_20251010T161155Z_PDInt.root_234970_8_1_20251029T193745Z_detsim_reco1.root"
29-Oct-2025 20:40:46 UTC  Closed input file "temp_detsim.root"
======================================================================================================================================
TimeTracker printout (sec)                              Min           Avg           Max         Median          RMS         nEvts   
======================================================================================================================================
Full event                                            64.081        94.6372        143.2        87.5619       25.4157        10     
--------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                              0.000418301   0.00400202    0.00656913    0.00428498    0.00198688       10     
reco:opdec:Deconvolution                             0.518213      0.615148       0.77413      0.588675      0.0743381       10     
reco:ophitspe:OpHitFinderDeco                        0.100592       0.10716      0.127809      0.104454     0.00742415       10     
reco:opflash:OpFlashFinder                           0.0490144     0.0713219     0.0941813     0.0662166     0.0153088       10     
reco:opslicer:OpSlicer                               0.151636      0.181918      0.245183      0.175524      0.0254827       10     
reco:wclsdatahd:WireCellToolkit                       31.0682       31.8454       32.518        31.793       0.370196        10     
reco:gaushit:GausHitFinder                           0.330821      0.511845      0.762727      0.504141      0.129887        10     
reco:nhitsfilter:NumberOfHitsFilter                 0.000164404   0.00026379    0.000490619   0.000241828   8.69164e-05      10     
reco:reco3d:SpacePointSolver                         0.338451      0.691746       1.20718       0.51939       0.31979        10     
reco:hitpdune:DisambigFromSpacePoints                0.223599      0.491428      0.918198       0.37177      0.237277        10     
reco:pandora:StandardPandora                          6.77419       22.7469       62.0202        18.86        15.8686        10     
reco:pandoraWriter:StandardPandora                   0.112588       0.17271       0.23448      0.168342      0.0458808       10     
reco:pandoraTrack:LArPandoraTrackCreation            0.609739       1.09647       1.77024       1.01023      0.410218        10     
reco:pandoraShower:LArPandoraShowerCreation          0.587289       1.10364       2.33599      0.929936      0.506683        10     
reco:pandoracalo:Calorimetry                         0.353123      0.573911      0.974136      0.559852      0.192814        10     
reco:pandoracalonosce:Calorimetry                    0.347826      0.566901      0.967694      0.551113      0.190751        10     
reco:pandoraShowercalo:ShowerCalorimetry             0.636001       1.13568       2.54977      0.937902      0.545912        10     
reco:pandoraShowercalonosce:ShowerCalorimetry        0.607111       1.10635       2.5696       0.911014      0.556945        10     
reco:pandoraGnocchiCalo:GnocchiCalorimetry           0.0223712     0.0339802     0.0504568     0.0323868    0.00728205       10     
reco:pandoraGnocchiCalonosce:GnocchiCalorimetry      0.0218578     0.0329899     0.050532      0.0321152    0.00737626       10     
reco:emtrkmichelid:EmTrackMichelId                    14.3339       21.2906       29.8476       20.8313       4.36641        10     
reco:crttag:SingleCRTMatchingProducer               0.00295076    0.00377437    0.00553236     0.0034701    0.000831162      10     
reco:crtreco:TwoCRTMatchingProducer                 0.00228019    0.00294318    0.00425262    0.00292106    0.00050511       10     
reco:pandora2Track:LArPandoraTrackCreation            1.51478       2.67168       5.30053       2.38784       1.09626        10     
reco:pandora2calo:ShowerCalorimetry                  0.535456       1.00944       2.34486      0.838675      0.514296        10     
reco:pandora2calonosce:ShowerCalorimetry             0.520812      0.989069       2.32278      0.820929       0.51354        10     
reco:pandora2GnocchiCalo:GnocchiCalorimetry          0.0226679     0.033411      0.0498749     0.0331255     0.0067092       10     
reco:pandora2GnocchiCalonosce:GnocchiCalorimetry     0.0215851     0.0323616     0.0500603     0.0319205    0.00687274       10     
reco:pandora2Shower:LArPandoraShowerCreation         0.645275       1.22211       2.48786       1.05628      0.535752        10     
reco:pandora2Showercalo:ShowerCalorimetry            0.733059       1.34723       2.95779       1.1465       0.645214        10     
reco:pandora2Showercalonosce:ShowerCalorimetry       0.702174       1.31346       2.8766        1.10987       0.63326        10     
[art]:TriggerResults:TriggerResultInserter          2.1311e-05    3.77894e-05   0.000119128   3.06485e-05   2.76813e-05      10     
end_path:out1:RootOutput                             6.252e-06    1.18487e-05   3.2663e-05     9.954e-06    7.0511e-06       10     
end_path:out1:RootOutput(write)                       1.17429       1.55981       2.12173       1.44665      0.311895        10     
======================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
  Peak virtual memory usage (VmPeak)  : 6182.81 MB
  Peak resident set size usage (VmHWM): 3977.95 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Reco returns 0
.:
total 11538592
-rw-r--r-- 1 dunegli fnalgrid      39456 Oct 29 20:40 jobscript.log
-rw-r--r-- 1 dunegli fnalgrid        199 Oct 29 20:40 justin-processed-pfns.txt
-rw-r--r-- 1 dunegli fnalgrid        519 Oct 29 20:40 reco_protodunehd_hist.root
-rw-r--r-- 1 dunegli fnalgrid       3574 Oct 29 20:40 Pandora_Geometry.xml
-rw-r--r-- 1 dunegli fnalgrid     200704 Oct 29 20:40 mem.db
-rw-r--r-- 1 dunegli fnalgrid      36864 Oct 29 20:40 time.db
-rw-r--r-- 1 dunegli fnalgrid 6055946321 Oct 29 20:40 pdhd_prod_beam__231691_94_1_20251008T183449Z_gen_g4_IonScintPDExt.root_227038_4_1_20251010T161155Z_PDInt.root_234970_8_1_20251029T193745Z_detsim_reco1.root
-rw-r--r-- 1 dunegli fnalgrid   53242220 Oct 29 20:40 Pandora_Events.pndr
-rw-r--r-- 1 dunegli fnalgrid          0 Oct 29 20:25 ProtoDUNE.log
-rw-r--r-- 1 dunegli fnalgrid          0 Oct 29 20:23 debugprod.log
-rw-r--r-- 1 dunegli fnalgrid        519 Oct 29 20:23 detsim_single_protodunehd_hist.root
-rw-r--r-- 1 dunegli fnalgrid 5706020515 Oct 29 20:23 temp_detsim.root
-rw-r--r-- 1 dunegli fnalgrid        120 Oct 29 19:37 all-input-dids.txt