Jobsub ID 250834.0@dunegpschedd02.fnal.gov
| Jobsub ID | 250834.0@dunegpschedd02.fnal.gov |
| Workflow ID | 10620 |
| 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-11-24 20:39:32 |
| Site | US_FNAL-FermiGrid |
| Entry | FNAL_GPGrid_ce03_mcore_op_duneonly |
| Last heartbeat | 2025-11-24 23:28:56 |
| From worker node | Hostname | dunegli-7725125-0-fnpc22013.fnal.gov |
| cpuinfo | AMD EPYC 7543 32-Core Processor |
| OS release | Scientific Linux release 7.9 (Nitrogen) |
| Processors | 1 |
| RSS bytes | 10485760000 (10000 MiB) |
| Wall seconds limit | 172800 (48 hours) |
| GPU | |
| Inner Apptainer? | True |
| Job state | finished |
| Started | 2025-11-24 21:15:15 |
| Input files | monte-carlo-010620-000001
|
| Jobscript | Exit code | 0 |
| Real time | 2h (8004s) |
| CPU time | 2h (7927s = 99%) |
| Max RSS bytes | 4091088896 (3901 MiB) |
| Outputting started | 2025-11-24 23:28:39 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/10620/1/001/reco_stage1.root
|
| Finished | 2025-11-24 23:28:56 |
| Saved logs | justin-logs:250834.0-dunegpschedd02.fnal.gov.logs.tgz |
| List job events (HTCondor job logs unavailable) |
Jobscript log (last 10,000 characters)
tPrepService:prepare: Running tool adcScaleKeToAdc
ToolBasedRawDigitPrepService:prepare: Running tool pdsp_RemoveBadChannels
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 114762 traces, 0 summary
Retagger: tagging trace set: gauss with 91114 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 91114 traces tagged "gauss"
FrameSaver: q=3.23153e+06 n=1621301 tag=gauss
wclsFrameSaver: saving 114762 traces tagged "wiener"
FrameSaver: q=3.4075e+06 n=1457234 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 19460 XUs and 17788 XVs -> 90 XUVs
C:0 T:1 25108 XUs and 24192 XVs -> 1322 XUVs
C:0 T:2 82785 XUs and 84947 XVs -> 4924 XUVs
C:0 T:3 44071 XUs and 34517 XVs -> 207 XUVs
C:0 T:4 9738 XUs and 10786 XVs -> 64 XUVs
C:0 T:5 28896 XUs and 26246 XVs -> 2068 XUVs
C:0 T:6 90932 XUs and 99815 XVs -> 4077 XUVs
C:0 T:7 36332 XUs and 41644 XVs -> 300 XUVs
C:0 T:8 8755 XUs and 8927 XVs -> 93 XUVs
C:0 T:9 58093 XUs and 68270 XVs -> 7369 XUVs
C:0 T:10 29257 XUs and 19665 XVs -> 3936 XUVs
C:0 T:11 337 XUs and 163 XVs -> 30 XUVs
24480 XUVs total
8673 collection wire objects
22876 potential space points
Neighbour search...
1448442 tests to find 745176 neighbours
Iterating with no regularization...
Begin: 8.30489e+07
0 7.56085e+07
1 7.50144e+07
2 7.49154e+07
3 7.48866e+07
Now with regularization...
Begin: 6.55495e+07
0 6.55206e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 410717097
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 410717097
fLifetime: 30000 [us]
24-Nov-2025 23:28:38 UTC Closed output file "reco_stage1.root"
24-Nov-2025 23:28:38 UTC 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 170.636 226.858 293.853 220.376 34.8496 10
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00084041 0.00359065 0.00575918 0.00428637 0.00152729 10
reco:ophit:OpHitFinder 0.1684 0.204209 0.231958 0.201176 0.0206096 10
reco:opflash:OpFlashFinder 0.0939664 0.128511 0.153912 0.136815 0.0194963 10
reco:opslicer:OpSlicer 0.330003 0.444237 0.566689 0.448907 0.0726724 10
reco:caldata:DataPrepModule 3.63801 3.80226 3.99807 3.76228 0.132747 10
reco:wclsdatasp:WireCellToolkit 26.8998 28.143 29.9912 27.8488 0.970473 10
reco:gaushit:GausHitFinder 0.616058 0.801582 1.12309 0.778643 0.137811 10
reco:nhitsfilter:NumberOfHitsFilter 0.000590086 0.000907272 0.00137872 0.000791397 0.000250298 10
reco:reco3d:SpacePointSolver 7.47898 10.3704 15.4279 9.38918 2.30356 10
reco:hitpdune:DisambigFromSpacePoints 0.72053 1.07014 1.60007 1.01175 0.265451 10
reco:pandora:StandardPandora 9.90466 18.8776 28.3021 17.9332 5.31057 10
reco:pandoraWriter:StandardPandora 0.276653 0.389544 0.499587 0.386493 0.0607243 10
reco:pandoraTrack:LArPandoraTrackCreation 1.64621 3.78408 7.93908 3.77398 1.60146 10
reco:pandoraShower:LArPandoraShowerCreation 1.20232 3.27824 5.88626 2.99646 1.32741 10
reco:pandoracalo:Calorimetry 0.791465 1.8162 3.893 1.78436 0.789126 10
reco:pandoracalonosce:Calorimetry 0.690495 1.53921 3.56217 1.34756 0.734044 10
reco:pandorapid:Chi2ParticleID 0.00302817 0.0040196 0.00627503 0.00367374 0.000980397 10
reco:pandoracalinoxyzt:CalibrationdEdXPDSP 0.0279233 0.0360322 0.0451308 0.0343965 0.0048682 10
reco:pandoracalipidnoxyzt:Chi2ParticleID 0.0030883 0.00403396 0.0047372 0.0041071 0.000427637 10
reco:pandoraShowercalo:ShowerCalorimetry 1.14298 3.00937 5.81807 2.68571 1.26871 10
reco:pandoraShowercalonosce:ShowerCalorimetry 1.11443 2.99266 5.53799 2.67206 1.30274 10
reco:emtrkmichelid:EmTrackMichelId 92.7489 115.411 139.269 115.004 13.4314 10
reco:crttag:SingleCRTMatchingProducer 0.0104784 0.0138491 0.021967 0.0135566 0.00354888 10
reco:crtreco:TwoCRTMatchingProducer 0.0048477 0.00680004 0.0108801 0.00648948 0.00177851 10
reco:anodepiercerst0:T0RecoAnodePiercers 0.525638 0.630871 0.774821 0.613379 0.0796942 10
reco:pandora2Track:LArPandoraTrackCreation 6.52306 10.1199 18.9573 8.87911 3.51572 10
reco:pandora2calo:Calorimetry 2.17395 4.36159 9.64153 4.12906 1.88084 10
reco:pandora2calonosce:Calorimetry 2.02397 4.0068 8.35753 3.62864 1.58581 10
reco:pandora2pid:Chi2ParticleID 0.00674362 0.00860362 0.0103757 0.00870004 0.00103209 10
reco:pandora2calinoxyzt:CalibrationdEdXPDSP 0.0371465 0.0461226 0.0547387 0.0459123 0.00503279 10
reco:pandora2calipidnoxyzt:Chi2ParticleID 0.00729348 0.00867858 0.0103948 0.00864142 0.000766607 10
reco:pandora2Shower:LArPandoraShowerCreation 1.82139 2.88819 4.00568 2.76608 0.549529 10
reco:pandora2Showercalo:ShowerCalorimetry 1.75249 3.33511 4.90926 3.27269 0.803483 10
reco:pandora2Showercalonosce:ShowerCalorimetry 1.61581 3.1403 4.48118 3.2686 0.762437 10
[art]:TriggerResults:TriggerResultInserter 4.3863e-05 6.37154e-05 0.000147268 5.6667e-05 2.82343e-05 10
end_path:out1:RootOutput 1.1712e-05 1.42631e-05 1.9817e-05 1.287e-05 2.64658e-06 10
end_path:out1:RootOutput(write) 1.56419 2.00313 2.52107 2.03298 0.276198 10
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4903.74 MB
Peak resident set size usage (VmHWM): 4091.09 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.19 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleAdcToKe: 0.05 sec/event
ToolBasedRawDigitPrepService:dtor: pdspTailPedRemovalZKe: 2.26 sec/event
ToolBasedRawDigitPrepService:dtor: adcKeepAllSignalFinder: 0.09 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 9654736
-rw-r--r-- 1 dunegli fnalgrid 2285389199 Nov 24 22:49 detsim_stage2.root
-rw-r--r-- 1 dunegli fnalgrid 2170806832 Nov 24 22:48 detsim_stage1.root
-rw-r--r-- 1 dunegli fnalgrid 1957914031 Nov 24 23:28 reco_stage1.root
-rw-r--r-- 1 dunegli fnalgrid 1742231967 Nov 24 21:26 g4_stage2.root
-rw-r--r-- 1 dunegli fnalgrid 1658226279 Nov 24 21:18 g4_stage1.root
-rw-r--r-- 1 dunegli fnalgrid 71263740 Nov 24 23:26 Pandora_Events.pndr
-rw-r--r-- 1 dunegli fnalgrid 242761 Nov 24 23:28 jobscript.log
-rw-r--r-- 1 dunegli fnalgrid 217088 Nov 24 23:28 mem.db
-rw-r--r-- 1 dunegli fnalgrid 62376 Nov 24 23:28 Pandora_Geometry.xml
-rw-r--r-- 1 dunegli fnalgrid 36864 Nov 24 23:28 time.db
-rw-r--r-- 1 dunegli fnalgrid 519 Nov 24 22:49 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 dunegli fnalgrid 519 Nov 24 21:26 g4_protoDUNE_hist.root
-rw-r--r-- 1 dunegli fnalgrid 519 Nov 24 23:28 protoDUNE_reco1_hist.root
-rw-r--r-- 1 dunegli fnalgrid 52 Nov 24 21:15 all-input-dids.txt
-rw-r--r-- 1 dunegli fnalgrid 7 Nov 24 23:28 justin-processed-pfns.txt
-rw-r--r-- 1 dunegli fnalgrid 0 Nov 24 22:53 ProtoDUNE.log
-rw-r--r-- 1 dunegli fnalgrid 0 Nov 24 22:49 debugprod.log