Jobsub ID 242635.0@dunegpschedd01.fnal.gov
Jobscript log (last 10,000 characters)
T:5 23998 XUs and 21046 XVs -> 571 XUVs
C:0 T:6 38350 XUs and 40633 XVs -> 1197 XUVs
C:0 T:7 81 XUs and 57 XVs -> 8 XUVs
5951 XUVs total
2693 collection wire objects
5951 potential space points
Neighbour search...
246759 tests to find 115750 neighbours
Iterating with no regularization...
Begin: 4.31214e+07
0 4.0884e+07
1 4.07441e+07
2 4.07277e+07
Now with regularization...
Begin: 3.91199e+07
0 3.91124e+07
Begin processing the 9th record. run: 20250627 subRun: 1 event: 98 at 03-Nov-2025 16:35:42 CST
Running Ophitfinder with InputDigiType = 'recob'
Found hits: 19175!
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 110984 traces, 110984 summary
Retagger: tagging trace set: gauss with 87734 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 87734 traces tagged "gauss"
FrameSaver: q=3.1162e+06 n=1524226 tag=gauss
wclsFrameSaver: saving 110984 traces tagged "wiener"
FrameSaver: q=3.91816e+06 n=1452779 tag=wiener
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 11045 XUs and 12348 XVs -> 203 XUVs
C:0 T:1 98867 XUs and 141106 XVs -> 9569 XUVs
C:0 T:2 54990 XUs and 63128 XVs -> 2305 XUVs
C:0 T:4 6 XUs and 3 XVs -> 0 XUVs
C:0 T:5 21633 XUs and 14355 XVs -> 390 XUVs
C:0 T:6 31780 XUs and 23164 XVs -> 1087 XUVs
13554 XUVs total
3619 collection wire objects
13554 potential space points
Neighbour search...
1421608 tests to find 712772 neighbours
Iterating with no regularization...
Begin: 3.65758e+07
0 3.30995e+07
1 3.28183e+07
2 3.2782e+07
3 3.27708e+07
Now with regularization...
Begin: 3.00489e+07
0 3.00393e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
Begin processing the 10th record. run: 20250627 subRun: 1 event: 99 at 03-Nov-2025 16:39:15 CST
Running Ophitfinder with InputDigiType = 'recob'
Found hits: 13677!
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 86812 traces, 86812 summary
Retagger: tagging trace set: gauss with 67932 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 67932 traces tagged "gauss"
FrameSaver: q=1.9472e+06 n=1024470 tag=gauss
wclsFrameSaver: saving 86812 traces tagged "wiener"
FrameSaver: q=2.40426e+06 n=994994 tag=wiener
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 6120 XUs and 6764 XVs -> 23 XUVs
C:0 T:1 22640 XUs and 25534 XVs -> 758 XUVs
C:0 T:2 9532 XUs and 11121 XVs -> 357 XUVs
C:0 T:4 63 XUs and 77 XVs -> 8 XUVs
C:0 T:5 13576 XUs and 15938 XVs -> 1404 XUVs
C:0 T:6 29735 XUs and 34420 XVs -> 1444 XUVs
3994 XUVs total
1721 collection wire objects
3994 potential space points
Neighbour search...
111546 tests to find 66528 neighbours
Iterating with no regularization...
Begin: 2.48298e+07
0 2.25985e+07
1 2.24672e+07
2 2.2448e+07
Now with regularization...
Begin: 2.08615e+07
0 2.08546e+07
03-Nov-2025 16:41:28 CST Closed output file "pdhd_prod_beam__226699_30_1_20251009T172404Z_gen_g4_IonScintPDExt.root_227040_125_1_20251010T170823Z_PDInt.root_242635_0_1_20251103T204003Z_detsim_reco1.root"
03-Nov-2025 16:41:28 CST Closed input file "temp_detsim.root"
======================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
======================================================================================================================================
Full event 128.096 201.78 274.898 202.04 46.4483 10
--------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00155691 0.0085004 0.0146657 0.0086221 0.00365218 10
reco:opdec:Deconvolution 0.82295 1.02575 1.28458 1.00405 0.135462 10
reco:ophitspe:OpHitFinderDeco 0.176035 0.23282 0.331207 0.224019 0.0390332 10
reco:opflash:OpFlashFinder 0.0930967 0.120929 0.179042 0.111843 0.0257689 10
reco:opslicer:OpSlicer 0.222896 0.324252 0.383545 0.333195 0.0437921 10
reco:wclsdatahd:WireCellToolkit 48.2684 51.5442 56.9888 50.8622 2.75254 10
reco:gaushit:GausHitFinder 0.866257 1.14097 1.44181 1.18163 0.16458 10
reco:nhitsfilter:NumberOfHitsFilter 0.000371 0.000520865 0.000899316 0.0004904 0.000143676 10
reco:reco3d:SpacePointSolver 0.517047 1.60516 2.5469 1.80398 0.576504 10
reco:hitpdune:DisambigFromSpacePoints 0.544664 1.2124 1.7301 1.15026 0.420864 10
reco:pandora:StandardPandora 13.0455 38.354 69.4435 32.0389 18.5997 10
reco:pandoraWriter:StandardPandora 0.339429 0.448595 0.532733 0.454641 0.0642436 10
reco:pandoraTrack:LArPandoraTrackCreation 2.22842 4.71785 7.35794 4.52018 1.80148 10
reco:pandoraShower:LArPandoraShowerCreation 2.28862 5.01117 7.46373 5.38216 1.69641 10
reco:pandoracalo:Calorimetry 1.01567 2.47797 4.48054 2.15723 1.06827 10
reco:pandoracalonosce:Calorimetry 1.009 2.26842 3.95556 2.10862 0.922639 10
reco:pandoraShowercalo:ShowerCalorimetry 2.28098 4.6565 7.51825 4.83331 1.72564 10
reco:pandoraShowercalonosce:ShowerCalorimetry 2.22527 4.55828 6.85392 5.24793 1.61663 10
reco:pandoraGnocchiCalo:GnocchiCalorimetry 0.0701568 0.0885274 0.116779 0.0894282 0.0136873 10
reco:pandoraGnocchiCalonosce:GnocchiCalorimetry 0.0686335 0.086042 0.117886 0.0864931 0.014063 10
reco:emtrkmichelid:EmTrackMichelId 31.36 45.1559 59.2802 42.1007 8.55785 10
reco:crttag:SingleCRTMatchingProducer 0.00821418 0.0113753 0.0134882 0.0118733 0.00140707 10
reco:crtreco:TwoCRTMatchingProducer 0.00639533 0.00957059 0.011201 0.010422 0.00173258 10
reco:pandora2Track:LArPandoraTrackCreation 5.20525 11.1893 15.0468 12.0244 3.66549 10
reco:pandora2calo:ShowerCalorimetry 1.59421 4.08897 6.07682 4.91817 1.6149 10
reco:pandora2calonosce:ShowerCalorimetry 1.66175 3.70753 5.76058 4.44743 1.40999 10
reco:pandora2GnocchiCalo:GnocchiCalorimetry 0.0441109 0.0859064 0.104453 0.0927399 0.0180389 10
reco:pandora2GnocchiCalonosce:GnocchiCalorimetry 0.0406534 0.0832447 0.103121 0.0900927 0.0178195 10
reco:pandora2Shower:LArPandoraShowerCreation 1.85138 4.87197 6.77164 5.51672 1.64584 10
reco:pandora2Showercalo:ShowerCalorimetry 1.85255 4.8291 8.05752 5.5101 1.89212 10
reco:pandora2Showercalonosce:ShowerCalorimetry 2.1441 4.68051 7.51837 5.20767 1.79994 10
[art]:TriggerResults:TriggerResultInserter 3.0056e-05 5.76507e-05 0.000132541 4.5005e-05 2.86874e-05 10
end_path:out1:RootOutput 1.1001e-05 1.66414e-05 3.9043e-05 1.3701e-05 7.93375e-06 10
end_path:out1:RootOutput(write) 2.42547 2.96286 4.02944 2.82146 0.47709 10
======================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 6458.9 MB
Peak resident set size usage (VmHWM): 4220.26 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Reco returns 0
.:
total 12597024
-rw-r--r-- 1 dune osgvo 39364 Nov 3 16:41 jobscript.log
-rw-r--r-- 1 dune osgvo 201 Nov 3 16:41 justin-processed-pfns.txt
-rw-r--r-- 1 dune osgvo 519 Nov 3 16:41 reco_protodunehd_hist.root
-rw-r--r-- 1 dune osgvo 3574 Nov 3 16:41 Pandora_Geometry.xml
-rw-r--r-- 1 dune osgvo 200704 Nov 3 16:41 mem.db
-rw-r--r-- 1 dune osgvo 36864 Nov 3 16:41 time.db
-rw-r--r-- 1 dune osgvo 6619735866 Nov 3 16:41 pdhd_prod_beam__226699_30_1_20251009T172404Z_gen_g4_IonScintPDExt.root_227040_125_1_20251010T170823Z_PDInt.root_242635_0_1_20251103T204003Z_detsim_reco1.root
-rw-r--r-- 1 dune osgvo 61478910 Nov 3 16:40 Pandora_Events.pndr
-rw-r--r-- 1 dune osgvo 0 Nov 3 16:09 ProtoDUNE.log
-rw-r--r-- 1 dune osgvo 0 Nov 3 16:05 debugprod.log
-rw-r--r-- 1 dune osgvo 519 Nov 3 16:05 detsim_single_protodunehd_hist.root
-rw-r--r-- 1 dune osgvo 6217806304 Nov 3 16:05 temp_detsim.root
-rw-r--r-- 1 dune osgvo 122 Nov 3 14:40 all-input-dids.txt
