Jobsub ID 242475.71@dunegpschedd01.fnal.gov
Jobscript log (last 10,000 characters)
7
Now with regularization...
Begin: 3.90714e+07
0 3.90481e+07
Begin processing the 9th record. run: 20250627 subRun: 1 event: 98 at 03-Nov-2025 16:12:45 CST
Running Ophitfinder with InputDigiType = 'recob'
Found hits: 17151!
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 106856 traces, 106856 summary
Retagger: tagging trace set: gauss with 85962 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 85962 traces tagged "gauss"
FrameSaver: q=2.72283e+06 n=1411081 tag=gauss
wclsFrameSaver: saving 106856 traces tagged "wiener"
FrameSaver: q=3.56411e+06 n=1377636 tag=wiener
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 19661 XUs and 14857 XVs -> 184 XUVs
C:0 T:1 124188 XUs and 102943 XVs -> 2709 XUVs
C:0 T:2 13906 XUs and 17846 XVs -> 550 XUVs
C:0 T:4 5 XUs and 4 XVs -> 0 XUVs
C:0 T:5 30282 XUs and 38460 XVs -> 712 XUVs
C:0 T:6 27271 XUs and 24737 XVs -> 2008 XUVs
6163 XUVs total
2923 collection wire objects
6163 potential space points
Neighbour search...
212821 tests to find 125892 neighbours
Iterating with no regularization...
Begin: 3.35325e+07
0 3.15569e+07
1 3.13716e+07
2 3.13507e+07
Now with regularization...
Begin: 2.99709e+07
0 2.9961e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLArTPCIntercepts - inconsistent number of intercepts between a line and the LArTPC
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
Begin processing the 10th record. run: 20250627 subRun: 1 event: 99 at 03-Nov-2025 16:20:36 CST
Running Ophitfinder with InputDigiType = 'recob'
Found hits: 15942!
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 85359 traces, 85359 summary
Retagger: tagging trace set: gauss with 68131 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 68131 traces tagged "gauss"
FrameSaver: q=1.86385e+06 n=969451 tag=gauss
wclsFrameSaver: saving 85359 traces tagged "wiener"
FrameSaver: q=2.54267e+06 n=944238 tag=wiener
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 8565 XUs and 7156 XVs -> 115 XUVs
C:0 T:1 65393 XUs and 67919 XVs -> 2481 XUVs
C:0 T:2 62152 XUs and 26369 XVs -> 371 XUVs
C:0 T:4 2 XUs and 4 XVs -> 0 XUVs
C:0 T:5 29348 XUs and 16615 XVs -> 663 XUVs
C:0 T:6 51000 XUs and 15439 XVs -> 447 XUVs
4077 XUVs total
1518 collection wire objects
4077 potential space points
Neighbour search...
155769 tests to find 68268 neighbours
Iterating with no regularization...
Begin: 4.14808e+07
0 3.83709e+07
1 3.81076e+07
2 3.80813e+07
Now with regularization...
Begin: 3.71185e+07
0 3.71117e+07
03-Nov-2025 16:25:01 CST Closed output file "pdhd_prod_beam__231902_21_1_20251008T212423Z_gen_g4_IonScintPDExt.root_227040_179_1_20251010T172342Z_PDInt.root_242475_71_1_20251103T184956Z_detsim_reco1.root"
03-Nov-2025 16:25:01 CST Closed input file "temp_detsim.root"
======================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
======================================================================================================================================
Full event 253.816 425.011 785.292 337.975 178.267 10
--------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00139098 0.0146291 0.0390941 0.0114163 0.0102425 10
reco:opdec:Deconvolution 1.41286 1.86022 2.39377 1.8189 0.259996 10
reco:ophitspe:OpHitFinderDeco 0.291235 0.409875 0.4954 0.423756 0.062124 10
reco:opflash:OpFlashFinder 0.108199 0.185655 0.26293 0.181177 0.0451148 10
reco:opslicer:OpSlicer 0.419712 0.533102 0.705802 0.508519 0.0877038 10
reco:wclsdatahd:WireCellToolkit 84.116 92.2418 104.956 89.9407 6.77929 10
reco:gaushit:GausHitFinder 1.1971 1.84919 3.10736 1.66316 0.560157 10
reco:nhitsfilter:NumberOfHitsFilter 0.000688319 0.000976358 0.00176321 0.000867365 0.000312613 10
reco:reco3d:SpacePointSolver 1.84093 3.08956 5.61398 2.75305 1.31215 10
reco:hitpdune:DisambigFromSpacePoints 0.872704 2.29321 5.59028 1.68339 1.27635 10
reco:pandora:StandardPandora 27.5813 88.3521 262.414 55.9678 68.0171 10
reco:pandoraWriter:StandardPandora 0.483621 0.714334 1.10983 0.677582 0.184011 10
reco:pandoraTrack:LArPandoraTrackCreation 5.28561 11.8384 22.1408 10.4126 5.26281 10
reco:pandoraShower:LArPandoraShowerCreation 5.52451 13.1418 31.0312 10.7619 7.12772 10
reco:pandoracalo:Calorimetry 2.42729 5.52885 10.6133 4.12487 2.83434 10
reco:pandoracalonosce:Calorimetry 2.41828 5.53217 10.5427 4.23755 2.78305 10
reco:pandoraShowercalo:ShowerCalorimetry 5.26943 12.6771 31.8918 8.93279 7.78054 10
reco:pandoraShowercalonosce:ShowerCalorimetry 4.99991 12.1634 30.3906 8.61363 7.35212 10
reco:pandoraGnocchiCalo:GnocchiCalorimetry 0.110182 0.149434 0.240847 0.13623 0.0375903 10
reco:pandoraGnocchiCalonosce:GnocchiCalorimetry 0.105231 0.142848 0.226482 0.129644 0.0357262 10
reco:emtrkmichelid:EmTrackMichelId 42.7979 65.3315 106.793 61.8469 20.3383 10
reco:crttag:SingleCRTMatchingProducer 0.0211223 0.0301101 0.0514274 0.0233527 0.0105453 10
reco:crtreco:TwoCRTMatchingProducer 0.0211673 0.0270175 0.0434514 0.0237059 0.00719666 10
reco:pandora2Track:LArPandoraTrackCreation 15.6366 32.5167 70.5275 24.7635 18.5432 10
reco:pandora2calo:ShowerCalorimetry 4.99262 11.6962 28.8539 7.76869 7.40769 10
reco:pandora2calonosce:ShowerCalorimetry 4.38531 11.3665 27.3913 7.41505 7.8822 10
reco:pandora2GnocchiCalo:GnocchiCalorimetry 0.0725021 0.145594 0.238686 0.135969 0.0466123 10
reco:pandora2GnocchiCalonosce:GnocchiCalorimetry 0.0831809 0.144421 0.247221 0.130469 0.0458991 10
reco:pandora2Shower:LArPandoraShowerCreation 6.12762 15.0685 33.061 11.9294 8.56907 10
reco:pandora2Showercalo:ShowerCalorimetry 5.98732 15.5939 33.8831 10.2553 9.87761 10
reco:pandora2Showercalonosce:ShowerCalorimetry 5.78126 15.4702 34.7123 10.3367 9.85286 10
[art]:TriggerResults:TriggerResultInserter 7.1971e-05 0.000174395 0.000800673 8.91615e-05 0.000212103 10
end_path:out1:RootOutput 1.007e-05 2.40975e-05 6.1564e-05 1.79485e-05 1.44169e-05 10
end_path:out1:RootOutput(write) 3.55261 4.57917 8.02249 4.07816 1.35419 10
======================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 6790.05 MB
Peak resident set size usage (VmHWM): 4532.47 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Reco returns 0
.:
total 13349648
-rw-r--r-- 1 dune osgvo 39861 Nov 3 16:25 jobscript.log
-rw-r--r-- 1 dune osgvo 201 Nov 3 16:25 justin-processed-pfns.txt
-rw-r--r-- 1 dune osgvo 519 Nov 3 16:25 reco_protodunehd_hist.root
-rw-r--r-- 1 dune osgvo 3574 Nov 3 16:25 Pandora_Geometry.xml
-rw-r--r-- 1 dune osgvo 200704 Nov 3 16:25 mem.db
-rw-r--r-- 1 dune osgvo 36864 Nov 3 16:25 time.db
-rw-r--r-- 1 dune osgvo 7006832705 Nov 3 16:25 pdhd_prod_beam__231902_21_1_20251008T212423Z_gen_g4_IonScintPDExt.root_227040_179_1_20251010T172342Z_PDInt.root_242475_71_1_20251103T184956Z_detsim_reco1.root
-rw-r--r-- 1 dune osgvo 63315690 Nov 3 16:22 Pandora_Events.pndr
-rw-r--r-- 1 dune osgvo 0 Nov 3 15:19 ProtoDUNE.log
-rw-r--r-- 1 dune osgvo 0 Nov 3 15:10 debugprod.log
-rw-r--r-- 1 dune osgvo 519 Nov 3 15:10 detsim_single_protodunehd_hist.root
-rw-r--r-- 1 dune osgvo 6599567052 Nov 3 15:10 temp_detsim.root
-rw-r--r-- 1 dune osgvo 122 Nov 3 12:49 all-input-dids.txt
