Jobsub ID 242633.0@dunegpschedd01.fnal.gov
Jobscript log (last 10,000 characters)
space points
Neighbour search...
377602 tests to find 202520 neighbours
Iterating with no regularization...
Begin: 6.04595e+07
0 5.61415e+07
1 5.57724e+07
2 5.57519e+07
Now with regularization...
Begin: 5.36758e+07
0 5.36693e+07
BdtBeamParticleIdTool::SliceFeatures::GetLArTPCIntercepts - inconsistent number of intercepts between a line and the LArTPC
Begin processing the 9th record. run: 20250627 subRun: 1 event: 98 at 03-Nov-2025 17:27:54 EST
Running Ophitfinder with InputDigiType = 'recob'
Found hits: 17892!
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 115215 traces, 115215 summary
Retagger: tagging trace set: gauss with 91386 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 91386 traces tagged "gauss"
FrameSaver: q=3.03379e+06 n=1467344 tag=gauss
wclsFrameSaver: saving 115215 traces tagged "wiener"
FrameSaver: q=3.80438e+06 n=1387429 tag=wiener
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 14505 XUs and 14061 XVs -> 131 XUVs
C:0 T:1 145759 XUs and 98907 XVs -> 3404 XUVs
C:0 T:2 16830 XUs and 17170 XVs -> 437 XUVs
C:0 T:3 12 XUs and 32 XVs -> 0 XUVs
C:0 T:4 6 XUs and 1 XVs -> 0 XUVs
C:0 T:5 60468 XUs and 55232 XVs -> 1533 XUVs
C:0 T:6 50296 XUs and 38033 XVs -> 1403 XUVs
6908 XUVs total
3558 collection wire objects
6908 potential space points
Neighbour search...
157366 tests to find 75454 neighbours
Iterating with no regularization...
Begin: 8.54745e+07
0 7.93389e+07
1 7.88374e+07
2 7.8802e+07
Now with regularization...
Begin: 7.67541e+07
0 7.67426e+07
PcaShowerParticleBuildingAlgorithm::OpeningAngle - principal eigenvalue less than or equal to 0.
Begin processing the 10th record. run: 20250627 subRun: 1 event: 99 at 03-Nov-2025 17:33:57 EST
Running Ophitfinder with InputDigiType = 'recob'
Found hits: 16684!
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 106263 traces, 106263 summary
Retagger: tagging trace set: gauss with 83286 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 83286 traces tagged "gauss"
FrameSaver: q=2.69033e+06 n=1331896 tag=gauss
wclsFrameSaver: saving 106263 traces tagged "wiener"
FrameSaver: q=3.31494e+06 n=1282315 tag=wiener
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 11469 XUs and 10913 XVs -> 81 XUVs
C:0 T:1 94079 XUs and 77554 XVs -> 1745 XUVs
C:0 T:2 8743 XUs and 31274 XVs -> 487 XUVs
C:0 T:4 3 XUs and 6 XVs -> 2 XUVs
C:0 T:5 46377 XUs and 60291 XVs -> 2683 XUVs
C:0 T:6 32073 XUs and 39264 XVs -> 2529 XUVs
7527 XUVs total
2978 collection wire objects
7527 potential space points
Neighbour search...
248517 tests to find 146018 neighbours
Iterating with no regularization...
Begin: 6.79517e+07
0 6.35659e+07
1 6.32072e+07
2 6.31599e+07
Now with regularization...
Begin: 6.06024e+07
0 6.05833e+07
03-Nov-2025 17:38:58 EST  Closed output file "pdhd_prod_beam__226470_57_1_20251008T212500Z_gen_g4_IonScintPDExt.root_227040_10_1_20251010T170024Z_PDInt.root_242633_0_1_20251103T203356Z_detsim_reco1.root"
03-Nov-2025 17:38:58 EST  Closed input file "temp_detsim.root"
======================================================================================================================================
TimeTracker printout (sec)                              Min           Avg           Max         Median          RMS         nEvts   
======================================================================================================================================
Full event                                            222.471       276.243       355.666       271.853       49.4968        10     
--------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                              0.00131119    0.00871174     0.0161805    0.00896544    0.00440765       10     
reco:opdec:Deconvolution                             0.933974       1.43103       1.84097       1.45838      0.254031        10     
reco:ophitspe:OpHitFinderDeco                        0.311516       0.38086      0.436098       0.38694      0.0422891       10     
reco:opflash:OpFlashFinder                           0.0715374      0.13001      0.172512      0.134137      0.0297484       10     
reco:opslicer:OpSlicer                               0.228957      0.400672       0.52671      0.431538      0.106788        10     
reco:wclsdatahd:WireCellToolkit                       66.164        79.5417       95.5195       77.1548       9.77352        10     
reco:gaushit:GausHitFinder                           0.857024       1.40771       2.27911       1.4081       0.406379        10     
reco:nhitsfilter:NumberOfHitsFilter                 0.000582517   0.00081598    0.00103897    0.000817622   0.000127882      10     
reco:reco3d:SpacePointSolver                          1.34114       1.92651       2.91422       1.81329      0.495907        10     
reco:hitpdune:DisambigFromSpacePoints                0.879359       1.61062       2.75745       1.55977      0.474337        10     
reco:pandora:StandardPandora                          24.4191       49.9861       86.2991       41.7851       22.011         10     
reco:pandoraWriter:StandardPandora                   0.338567      0.493814       0.67675      0.485227      0.109053        10     
reco:pandoraTrack:LArPandoraTrackCreation             4.88438       8.9467        12.8729       8.90432       2.51437        10     
reco:pandoraShower:LArPandoraShowerCreation           5.17355       9.40896       14.0973       9.11827       2.5987         10     
reco:pandoracalo:Calorimetry                          1.99183       3.97619       6.36748       3.67005       1.21141        10     
reco:pandoracalonosce:Calorimetry                     2.14983       3.91955       6.32197       3.80126       1.20479        10     
reco:pandoraShowercalo:ShowerCalorimetry              4.32943       9.23779       14.4247       8.30914       3.35043        10     
reco:pandoraShowercalonosce:ShowerCalorimetry         4.74355       8.56892       13.9185       7.69888       2.99479        10     
reco:pandoraGnocchiCalo:GnocchiCalorimetry           0.0584048     0.108557      0.157903      0.114926      0.0342614       10     
reco:pandoraGnocchiCalonosce:GnocchiCalorimetry      0.057536      0.104023      0.147901      0.111752      0.0318737       10     
reco:emtrkmichelid:EmTrackMichelId                    17.3827       23.7208       31.6137       23.9935       4.09722        10     
reco:crttag:SingleCRTMatchingProducer                0.0178316     0.0221396     0.0298718     0.0210685    0.00394579       10     
reco:crtreco:TwoCRTMatchingProducer                  0.0159171     0.0210603     0.0294453     0.0197703     0.0038833       10     
reco:pandora2Track:LArPandoraTrackCreation             15.92        22.5503       29.9098       21.3697       4.01129        10     
reco:pandora2calo:ShowerCalorimetry                   4.53101       7.24463       10.3296       6.65634       1.8702         10     
reco:pandora2calonosce:ShowerCalorimetry              4.3614        7.53916       11.2367       6.73129       2.31012        10     
reco:pandora2GnocchiCalo:GnocchiCalorimetry          0.0614684     0.102959      0.194121      0.0977045     0.0380849       10     
reco:pandora2GnocchiCalonosce:GnocchiCalorimetry     0.0593864     0.100343      0.189327      0.0964076     0.0372792       10     
reco:pandora2Shower:LArPandoraShowerCreation          6.67635       10.307        15.5049       10.3012       2.43415        10     
reco:pandora2Showercalo:ShowerCalorimetry             5.79168       10.2025       14.3872        9.493        3.08635        10     
reco:pandora2Showercalonosce:ShowerCalorimetry        2.90822       9.52472       16.6668       9.19232       3.97576        10     
[art]:TriggerResults:TriggerResultInserter          3.6676e-05    7.3654e-05    0.000146662   7.1962e-05    3.07227e-05      10     
end_path:out1:RootOutput                             8.332e-06    1.73445e-05   4.4003e-05    1.5409e-05    1.0096e-05       10     
end_path:out1:RootOutput(write)                       1.96309       3.08238       3.91777       3.09054      0.655593        10     
======================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
  Peak virtual memory usage (VmPeak)  : 6906.69 MB
  Peak resident set size usage (VmHWM): 4327.62 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Reco returns 0
.:
total 11965384
-rw-r--r--. 1 dune osgvo      44833 Nov  3 17:39 jobscript.log
-rw-r--r--. 1 dune osgvo        200 Nov  3 17:39 justin-processed-pfns.txt
-rw-r--r--. 1 dune osgvo        519 Nov  3 17:38 reco_protodunehd_hist.root
-rw-r--r--. 1 dune osgvo       3574 Nov  3 17:38 Pandora_Geometry.xml
-rw-r--r--. 1 dune osgvo     200704 Nov  3 17:38 mem.db
-rw-r--r--. 1 dune osgvo      36864 Nov  3 17:38 time.db
-rw-r--r--. 1 dune osgvo 6279447551 Nov  3 17:38 pdhd_prod_beam__226470_57_1_20251008T212500Z_gen_g4_IonScintPDExt.root_227040_10_1_20251010T170024Z_PDInt.root_242633_0_1_20251103T203356Z_detsim_reco1.root
-rw-r--r--. 1 dune osgvo   56550140 Nov  3 17:36 Pandora_Events.pndr
-rw-r--r--. 1 dune osgvo          0 Nov  3 16:55 ProtoDUNE.log
-rw-r--r--. 1 dune osgvo          0 Nov  3 16:50 debugprod.log
-rw-r--r--. 1 dune osgvo        519 Nov  3 16:50 detsim_single_protodunehd_hist.root
-rw-r--r--. 1 dune osgvo 5916224409 Nov  3 16:50 temp_detsim.root
-rw-r--r--. 1 dune osgvo        121 Nov  3 15:33 all-input-dids.txt