Jobsub ID 264534.1@dunegpschedd02.fnal.gov
| Jobsub ID | 264534.1@dunegpschedd02.fnal.gov |
| Workflow ID | 11356 |
| Stage ID | 1 |
| User name | pmelas@fnal.gov |
| Requested | Processors | 1 |
| GPU | No |
| RSS bytes | 8388608000 (8000 MiB) |
| Wall seconds limit | 86400 (24 hours) |
| Submitted time | 2025-12-27 10:06:34 |
| Site | UK_Lancaster |
| Entry | UBoone_UK_Lancaster_HEC_grendel_ce02 |
| Last heartbeat | 2025-12-27 13:33:25 |
| From worker node | Hostname | comp02-22 |
| cpuinfo | Intel(R) Xeon(R) CPU E5-2620 v4 @ 2.10GHz |
| OS release | Scientific Linux release 7.9 (Nitrogen) |
| Processors | 1 |
| RSS bytes | 10485760000 (10000 MiB) |
| Wall seconds limit | 257400 (71 hours) |
| GPU | |
| Inner Apptainer? | True |
| Job state | finished |
| Started | 2025-12-27 10:14:20 |
| Input files | monte-carlo-011356-000001
|
| Jobscript | Exit code | 0 |
| Real time | 3h (11839s) |
| CPU time | 3h (11659s = 98%) |
| Max RSS bytes | 4788277248 (4566 MiB) |
| Outputting started | 2025-12-27 13:31:40 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11356/1/001/reco_stage1.root
|
| Finished | 2025-12-27 13:33:25 |
| Saved logs | justin-logs:264534.1-dunegpschedd02.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
nnels
ToolBasedRawDigitPrepService:endEvent: End processing run 1 event 10 with 7 tools.
CookedFrameSource: got 15360 recob::Wire objects
input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 174845 traces, 0 summary
Retagger: tagging trace set: gauss with 127090 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 127090 traces tagged "gauss"
FrameSaver: q=4.20029e+06 n=2158370 tag=gauss
wclsFrameSaver: saving 174845 traces tagged "wiener"
FrameSaver: q=4.48085e+06 n=1869022 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 42777 XUs and 33961 XVs -> 520 XUVs
C:0 T:1 108401 XUs and 87096 XVs -> 11551 XUVs
C:0 T:2 58059 XUs and 132637 XVs -> 15876 XUVs
C:0 T:3 20335 XUs and 35108 XVs -> 203 XUVs
C:0 T:4 15825 XUs and 14984 XVs -> 157 XUVs
C:0 T:5 69014 XUs and 52564 XVs -> 6193 XUVs
C:0 T:6 173106 XUs and 194023 XVs -> 20276 XUVs
C:0 T:7 52223 XUs and 51531 XVs -> 709 XUVs
C:0 T:8 10748 XUs and 8777 XVs -> 161 XUVs
C:0 T:9 71859 XUs and 74480 XVs -> 4387 XUVs
C:0 T:10 96934 XUs and 96582 XVs -> 18411 XUVs
C:0 T:11 103 XUs and 85 XVs -> 10 XUVs
78454 XUVs total
17181 collection wire objects
73135 potential space points
Neighbour search...
15379137 tests to find 6633322 neighbours
Iterating with no regularization...
Begin: 6.59267e+07
0 5.40278e+07
1 5.30896e+07
2 5.29537e+07
3 5.29138e+07
Now with regularization...
Begin: 4.09825e+07
0 4.08951e+07
1 4.08192e+07
2 4.07579e+07
3 4.07073e+07
4 4.06663e+07
5 4.06333e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 411372070
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411372070
fLifetime: 30000 [us]
27-Dec-2025 13:31:34 GMT Closed output file "reco_stage1.root"
27-Dec-2025 13:31:34 GMT Closed input file "detsim_stage2.root"
DataPrepModule::endJob: # events processed: 10
DataPrepModule::endJob: # events skipped: 0
====================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
====================================================================================================================================
Full event 292.361 410.704 539.637 399.581 69.3314 10
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000814213 0.00360087 0.00566993 0.00382745 0.0014238 10
reco:ophit:OpHitFinder 0.251309 0.301075 0.339129 0.303661 0.0258326 10
reco:opflash:OpFlashFinder 0.177766 0.232732 0.278317 0.233442 0.0271302 10
reco:opslicer:OpSlicer 0.607974 0.72733 0.861898 0.724587 0.0828135 10
reco:caldata:DataPrepModule 5.42648 5.63684 6.15131 5.57845 0.196287 10
reco:wclsdatasp:WireCellToolkit 40.0163 45.5961 56.3513 43.8388 4.78036 10
reco:gaushit:GausHitFinder 1.17044 1.48369 2.07154 1.4686 0.254063 10
reco:nhitsfilter:NumberOfHitsFilter 0.000418138 0.000668733 0.000865994 0.000670116 0.00013804 10
reco:reco3d:SpacePointSolver 7.23653 19.021 36.6775 18.8712 7.27922 10
reco:hitpdune:DisambigFromSpacePoints 1.61799 2.72384 4.05769 2.72765 0.661395 10
reco:pandora:StandardPandora 25.9141 50.6521 89.2988 49.1078 18.8734 10
reco:pandoraWriter:StandardPandora 0.349206 0.508343 0.827943 0.478003 0.132304 10
reco:pandoraTrack:LArPandoraTrackCreation 3.55231 6.53357 9.91304 6.36267 1.80636 10
reco:pandoraShower:LArPandoraShowerCreation 3.00732 6.53608 10.352 6.07011 2.24692 10
reco:pandoracalo:Calorimetry 1.71364 3.17452 4.55187 3.18419 0.818336 10
reco:pandoracalonosce:Calorimetry 1.52237 2.85927 4.19139 2.81172 0.773741 10
reco:pandorapid:Chi2ParticleID 0.00514626 0.00623673 0.00780877 0.00593659 0.000904167 10
reco:pandoracalinoxyzt:CalibrationdEdXPDSP 0.0566144 0.0706021 0.0924991 0.0701271 0.00965676 10
reco:pandoracalipidnoxyzt:Chi2ParticleID 0.00515307 0.00604885 0.00736729 0.00600782 0.000700551 10
reco:pandoraShowercalo:ShowerCalorimetry 2.978 6.27365 9.94414 5.79255 1.95729 10
reco:pandoraShowercalonosce:ShowerCalorimetry 2.92824 6.07863 9.76746 5.60605 1.87855 10
reco:emtrkmichelid:EmTrackMichelId 156.169 191.745 239.176 185.653 23.9362 10
reco:crttag:SingleCRTMatchingProducer 0.0141625 0.0196866 0.030491 0.0180579 0.00513932 10
reco:crtreco:TwoCRTMatchingProducer 0.00735402 0.0133254 0.0208299 0.0122992 0.0039415 10
reco:anodepiercerst0:T0RecoAnodePiercers 1.57826 1.76228 2.0771 1.74082 0.151742 10
reco:pandora2Track:LArPandoraTrackCreation 10.2008 19.6734 30.0226 18.6483 5.2046 10
reco:pandora2calo:Calorimetry 4.41085 8.07388 12.2653 7.67207 2.01416 10
reco:pandora2calonosce:Calorimetry 4.16831 7.66282 11.623 7.15127 1.9342 10
reco:pandora2pid:Chi2ParticleID 0.0112353 0.0157563 0.021922 0.0144761 0.0030638 10
reco:pandora2calinoxyzt:CalibrationdEdXPDSP 0.0675455 0.0933535 0.144748 0.0899837 0.020264 10
reco:pandora2calipidnoxyzt:Chi2ParticleID 0.0108087 0.0155326 0.0213843 0.0144961 0.00292563 10
reco:pandora2Shower:LArPandoraShowerCreation 3.50181 6.2814 9.48167 5.76518 1.60878 10
reco:pandora2Showercalo:ShowerCalorimetry 3.92898 7.22634 10.7198 6.85739 1.72262 10
reco:pandora2Showercalonosce:ShowerCalorimetry 3.69601 6.73192 10.5063 6.2742 1.71336 10
[art]:TriggerResults:TriggerResultInserter 3.6412e-05 5.54063e-05 0.000117164 4.65635e-05 2.32949e-05 10
end_path:out1:RootOutput 9.379e-06 1.16518e-05 1.7574e-05 1.0239e-05 2.68524e-06 10
end_path:out1:RootOutput(write) 2.11194 2.85876 3.77093 2.74354 0.45569 10
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5597.45 MB
Peak resident set size usage (VmHWM): 4788.28 MB
Details saved in: 'mem.db'
====================================================================================================
ToolBasedRawDigitPrepService:dtor: Event count: 10
ToolBasedRawDigitPrepService:dtor: Call count: 60
ToolBasedRawDigitPrepService:dtor: Time report for 7 tools.
ToolBasedRawDigitPrepService:dtor: digitReader: 0.08 sec/event
ToolBasedRawDigitPrepService:dtor: adcSampleFiller: 0.21 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleAdcToKe: 0.05 sec/event
ToolBasedRawDigitPrepService:dtor: pdspTailPedRemovalZKe: 3.45 sec/event
ToolBasedRawDigitPrepService:dtor: adcKeepAllSignalFinder: 0.15 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleKeToAdc: 0.05 sec/event
ToolBasedRawDigitPrepService:dtor: pdsp_RemoveBadChannels: 0.00 sec/event
Art has completed and will exit with status 0.
lar exit code 0
.:
total 11166407
-rw-r--r-- 1 pltdune004 pltdune 2584519460 Dec 27 12:21 detsim_stage2.root
-rw-r--r-- 1 pltdune004 pltdune 2446037838 Dec 27 12:18 detsim_stage1.root
-rw-r--r-- 1 pltdune004 pltdune 2298005256 Dec 27 13:31 reco_stage1.root
-rw-r--r-- 1 pltdune004 pltdune 2057915608 Dec 27 10:37 g4_stage2.root
-rw-r--r-- 1 pltdune004 pltdune 1965718565 Dec 27 10:21 g4_stage1.root
-rw-r--r-- 1 pltdune004 pltdune 81638610 Dec 27 13:26 Pandora_Events.pndr
-rw-r--r-- 1 pltdune004 pltdune 243025 Dec 27 13:31 jobscript.log
-rw-r--r-- 1 pltdune004 pltdune 217088 Dec 27 13:31 mem.db
-rw-r--r-- 1 pltdune004 pltdune 62376 Dec 27 13:31 Pandora_Geometry.xml
-rw-r--r-- 1 pltdune004 pltdune 36864 Dec 27 13:31 time.db
-rw-r--r-- 1 pltdune004 pltdune 519 Dec 27 12:21 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 pltdune004 pltdune 519 Dec 27 10:37 g4_protoDUNE_hist.root
-rw-r--r-- 1 pltdune004 pltdune 519 Dec 27 13:31 protoDUNE_reco1_hist.root
-rw-r--r-- 1 pltdune004 pltdune 52 Dec 27 10:14 all-input-dids.txt
-rw-r--r-- 1 pltdune004 pltdune 7 Dec 27 13:31 justin-processed-pfns.txt
-rw-r--r-- 1 pltdune004 pltdune 0 Dec 27 12:27 ProtoDUNE.log
-rw-r--r-- 1 pltdune004 pltdune 0 Dec 27 12:21 debugprod.log
