Jobsub ID 270843.1@dunegpschedd01.fnal.gov
| Jobsub ID | 270843.1@dunegpschedd01.fnal.gov |
| Workflow ID | 11408 |
| 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-29 21:07:46 |
| Site | US_FNAL-FermiGrid |
| Entry | FNAL_GPGrid_ce04_mcore_op_duneonly |
| Last heartbeat | 2025-12-29 23:03:26 |
| From worker node | Hostname | dunegli-8189041-0-fnpc22005.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-12-29 21:15:45 |
| Input files | monte-carlo-011408-000001
|
| Jobscript | Exit code | 0 |
| Real time | 1h (6450s) |
| CPU time | 1h (6372s = 98%) |
| Max RSS bytes | 4166950912 (3973 MiB) |
| Outputting started | 2025-12-29 23:03:15 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11408/1/001/reco_stage1.root
|
| Finished | 2025-12-29 23:03:26 |
| Saved logs | justin-logs:270843.1-dunegpschedd01.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
are: 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 122735 traces, 0 summary
Retagger: tagging trace set: gauss with 90709 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 90709 traces tagged "gauss"
FrameSaver: q=3.03935e+06 n=1548393 tag=gauss
wclsFrameSaver: saving 122735 traces tagged "wiener"
FrameSaver: q=3.22601e+06 n=1350091 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 26083 XUs and 28620 XVs -> 205 XUVs
C:0 T:1 68792 XUs and 70325 XVs -> 8037 XUVs
C:0 T:2 111605 XUs and 174034 XVs -> 12225 XUVs
C:0 T:3 45619 XUs and 46420 XVs -> 233 XUVs
C:0 T:4 11260 XUs and 9746 XVs -> 93 XUVs
C:0 T:5 38308 XUs and 26325 XVs -> 4896 XUVs
C:0 T:6 82228 XUs and 85118 XVs -> 4278 XUVs
C:0 T:7 33961 XUs and 33802 XVs -> 248 XUVs
C:0 T:8 9138 XUs and 7464 XVs -> 158 XUVs
C:0 T:9 49489 XUs and 52597 XVs -> 7271 XUVs
C:0 T:10 24473 XUs and 67784 XVs -> 6775 XUVs
C:0 T:11 27 XUs and 14 XVs -> 3 XUVs
44422 XUVs total
10419 collection wire objects
40944 potential space points
Neighbour search...
5649726 tests to find 2714686 neighbours
Iterating with no regularization...
Begin: 5.57654e+07
0 4.28515e+07
1 4.18705e+07
2 4.176e+07
3 4.17213e+07
Now with regularization...
Begin: 3.33012e+07
0 3.32631e+07
1 3.32313e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 411421530
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411421530
fLifetime: 30000 [us]
29-Dec-2025 23:03:14 UTC Closed output file "reco_stage1.root"
29-Dec-2025 23:03:14 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 125.914 174.767 236.405 171.225 33.7364 10
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000674018 0.00255004 0.00379618 0.00285678 0.00105697 10
reco:ophit:OpHitFinder 0.160993 0.198783 0.244369 0.198935 0.0264905 10
reco:opflash:OpFlashFinder 0.0912414 0.131505 0.188108 0.13094 0.0303901 10
reco:opslicer:OpSlicer 0.27737 0.416045 0.634607 0.394831 0.0899135 10
reco:caldata:DataPrepModule 3.29194 3.41937 3.6594 3.39513 0.0991173 10
reco:wclsdatasp:WireCellToolkit 21.5613 22.4134 23.4663 22.4231 0.586825 10
reco:gaushit:GausHitFinder 0.463661 0.628876 0.849364 0.614299 0.119028 10
reco:nhitsfilter:NumberOfHitsFilter 0.000193296 0.00029228 0.000488296 0.000267643 7.76873e-05 10
reco:reco3d:SpacePointSolver 3.61639 7.51559 12.7938 7.29021 2.54885 10
reco:hitpdune:DisambigFromSpacePoints 0.427783 0.790699 1.26142 0.735682 0.252158 10
reco:pandora:StandardPandora 7.07046 15.1656 34.4903 13.0603 7.35369 10
reco:pandoraWriter:StandardPandora 0.150791 0.215045 0.293816 0.200137 0.0444433 10
reco:pandoraTrack:LArPandoraTrackCreation 1.07705 1.64053 2.353 1.70523 0.419292 10
reco:pandoraShower:LArPandoraShowerCreation 0.932216 1.70398 2.75458 1.59456 0.589112 10
reco:pandoracalo:Calorimetry 0.640062 0.993569 1.47134 1.03483 0.267012 10
reco:pandoracalonosce:Calorimetry 0.575689 0.908149 1.36083 0.955077 0.252508 10
reco:pandorapid:Chi2ParticleID 0.0022921 0.00306823 0.00427975 0.00299322 0.000526415 10
reco:pandoracalinoxyzt:CalibrationdEdXPDSP 0.0220223 0.0281082 0.0368212 0.0270822 0.00450601 10
reco:pandoracalipidnoxyzt:Chi2ParticleID 0.00217817 0.00283441 0.00324278 0.00283199 0.000305253 10
reco:pandoraShowercalo:ShowerCalorimetry 0.971968 1.90722 3.25679 1.74132 0.753666 10
reco:pandoraShowercalonosce:ShowerCalorimetry 0.9416 1.8589 3.19834 1.70114 0.744019 10
reco:emtrkmichelid:EmTrackMichelId 71.8649 95.5318 124.549 93.7665 16.5584 10
reco:crttag:SingleCRTMatchingProducer 0.00458938 0.00669556 0.00980151 0.00628498 0.0015821 10
reco:crtreco:TwoCRTMatchingProducer 0.00320961 0.00433423 0.00589175 0.00422171 0.000840675 10
reco:anodepiercerst0:T0RecoAnodePiercers 0.370907 0.489898 0.673633 0.463656 0.101626 10
reco:pandora2Track:LArPandoraTrackCreation 2.94876 5.0632 8.07796 5.01636 1.64243 10
reco:pandora2calo:Calorimetry 1.53944 2.75475 4.55182 2.67716 0.972459 10
reco:pandora2calonosce:Calorimetry 1.44947 2.62052 4.40085 2.55013 0.949542 10
reco:pandora2pid:Chi2ParticleID 0.00549791 0.00682609 0.00825284 0.00675824 0.000996109 10
reco:pandora2calinoxyzt:CalibrationdEdXPDSP 0.0267696 0.0339027 0.0443117 0.0340036 0.00600842 10
reco:pandora2calipidnoxyzt:Chi2ParticleID 0.0053311 0.0067034 0.00796169 0.00681427 0.000951229 10
reco:pandora2Shower:LArPandoraShowerCreation 1.13762 1.935 3.05172 1.94782 0.603499 10
reco:pandora2Showercalo:ShowerCalorimetry 1.35855 2.45177 4.1344 2.40278 0.897537 10
reco:pandora2Showercalonosce:ShowerCalorimetry 1.24985 2.27903 3.88903 2.24245 0.845247 10
[art]:TriggerResults:TriggerResultInserter 2.5398e-05 3.53761e-05 8.7085e-05 2.93655e-05 1.75218e-05 10
end_path:out1:RootOutput 6.262e-06 8.6938e-06 1.1883e-05 8.657e-06 1.53677e-06 10
end_path:out1:RootOutput(write) 1.18297 1.59244 2.08 1.55347 0.292642 10
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4983.19 MB
Peak resident set size usage (VmHWM): 4166.95 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.04 sec/event
ToolBasedRawDigitPrepService:dtor: adcSampleFiller: 0.15 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleAdcToKe: 0.03 sec/event
ToolBasedRawDigitPrepService:dtor: pdspTailPedRemovalZKe: 2.15 sec/event
ToolBasedRawDigitPrepService:dtor: adcKeepAllSignalFinder: 0.08 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleKeToAdc: 0.03 sec/event
ToolBasedRawDigitPrepService:dtor: pdsp_RemoveBadChannels: 0.00 sec/event
Art has completed and will exit with status 0.
lar exit code 0
.:
total 9564012
-rw-r--r-- 1 dunegli fnalgrid 2265680661 Dec 29 22:33 detsim_stage2.root
-rw-r--r-- 1 dunegli fnalgrid 2148904794 Dec 29 22:31 detsim_stage1.root
-rw-r--r-- 1 dunegli fnalgrid 1912004764 Dec 29 23:03 reco_stage1.root
-rw-r--r-- 1 dunegli fnalgrid 1732535374 Dec 29 21:25 g4_stage2.root
-rw-r--r-- 1 dunegli fnalgrid 1668421046 Dec 29 21:18 g4_stage1.root
-rw-r--r-- 1 dunegli fnalgrid 65376650 Dec 29 23:01 Pandora_Events.pndr
-rw-r--r-- 1 dunegli fnalgrid 242965 Dec 29 23:03 jobscript.log
-rw-r--r-- 1 dunegli fnalgrid 217088 Dec 29 23:03 mem.db
-rw-r--r-- 1 dunegli fnalgrid 62376 Dec 29 23:03 Pandora_Geometry.xml
-rw-r--r-- 1 dunegli fnalgrid 36864 Dec 29 23:03 time.db
-rw-r--r-- 1 dunegli fnalgrid 519 Dec 29 22:33 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 dunegli fnalgrid 519 Dec 29 21:25 g4_protoDUNE_hist.root
-rw-r--r-- 1 dunegli fnalgrid 519 Dec 29 23:03 protoDUNE_reco1_hist.root
-rw-r--r-- 1 dunegli fnalgrid 52 Dec 29 21:15 all-input-dids.txt
-rw-r--r-- 1 dunegli fnalgrid 7 Dec 29 23:03 justin-processed-pfns.txt
-rw-r--r-- 1 dunegli fnalgrid 0 Dec 29 22:36 ProtoDUNE.log
-rw-r--r-- 1 dunegli fnalgrid 0 Dec 29 22:33 debugprod.log