Jobsub ID 264687.1@dunegpschedd02.fnal.gov
| Jobsub ID | 264687.1@dunegpschedd02.fnal.gov |
| Workflow ID | 11381 |
| 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-28 15:22:07 |
| Site | US_FNAL-T1 |
| Entry | CMSHTPC_T1_US_FNAL_condce_opp1_whole |
| Last heartbeat | 2025-12-28 17:27:24 |
| From worker node | Hostname | dunegli-49579-0-cmswn6018.fnal.gov |
| cpuinfo | AMD EPYC 9354 32-Core Processor |
| OS release | Scientific Linux release 7.9 (Nitrogen) |
| Processors | 1 |
| RSS bytes | 10485760000 (10000 MiB) |
| Wall seconds limit | 171000 (47 hours) |
| GPU | |
| Inner Apptainer? | True |
| Job state | finished |
| Started | 2025-12-28 15:24:17 |
| Input files | monte-carlo-011381-000001
|
| Jobscript | Exit code | 0 |
| Real time | 2h (7375s) |
| CPU time | 2h (7335s = 99%) |
| Max RSS bytes | 4345630720 (4144 MiB) |
| Outputting started | 2025-12-28 17:27:12 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11381/1/001/reco_stage1.root
|
| Finished | 2025-12-28 17:27:24 |
| Saved logs | justin-logs:264687.1-dunegpschedd02.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
vice: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 120353 traces, 0 summary
Retagger: tagging trace set: gauss with 90229 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 90229 traces tagged "gauss"
FrameSaver: q=3.09424e+06 n=1576178 tag=gauss
wclsFrameSaver: saving 120353 traces tagged "wiener"
FrameSaver: q=3.28767e+06 n=1390515 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 21131 XUs and 23681 XVs -> 157 XUVs
C:0 T:1 34641 XUs and 34872 XVs -> 2836 XUVs
C:0 T:2 116947 XUs and 141417 XVs -> 5705 XUVs
C:0 T:3 55280 XUs and 47713 XVs -> 508 XUVs
C:0 T:4 9624 XUs and 8814 XVs -> 233 XUVs
C:0 T:5 45778 XUs and 31649 XVs -> 7992 XUVs
C:0 T:6 89839 XUs and 110772 XVs -> 4590 XUVs
C:0 T:7 38863 XUs and 43926 XVs -> 310 XUVs
C:0 T:8 9968 XUs and 5781 XVs -> 126 XUVs
C:0 T:9 61822 XUs and 49329 XVs -> 6560 XUVs
C:0 T:10 28759 XUs and 17336 XVs -> 4948 XUVs
C:0 T:11 645 XUs and 493 XVs -> 75 XUVs
34040 XUVs total
10250 collection wire objects
31699 potential space points
Neighbour search...
2900371 tests to find 1476826 neighbours
Iterating with no regularization...
Begin: 5.62344e+07
0 4.67243e+07
1 4.59212e+07
2 4.58015e+07
3 4.57657e+07
Now with regularization...
Begin: 3.67167e+07
0 3.6682e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 411396597
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411396597
fLifetime: 30000 [us]
28-Dec-2025 17:27:12 UTC Closed output file "reco_stage1.root"
28-Dec-2025 17:27:12 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 156.308 207.829 269.297 207.668 37.8763 10
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000511941 0.00272926 0.00424335 0.00306188 0.00119826 10
reco:ophit:OpHitFinder 0.171631 0.209509 0.246862 0.207086 0.0200846 10
reco:opflash:OpFlashFinder 0.114131 0.145371 0.195642 0.140406 0.0230883 10
reco:opslicer:OpSlicer 0.319265 0.400418 0.502173 0.414807 0.0505108 10
reco:caldata:DataPrepModule 3.08515 3.12111 3.2371 3.10365 0.0458861 10
reco:wclsdatasp:WireCellToolkit 19.8729 20.8795 21.5626 21.0655 0.569785 10
reco:gaushit:GausHitFinder 0.444399 0.665622 0.864966 0.654977 0.135871 10
reco:nhitsfilter:NumberOfHitsFilter 0.000176379 0.000242138 0.000298937 0.000249981 3.57948e-05 10
reco:reco3d:SpacePointSolver 5.49078 10.5568 19.7842 9.6588 3.96043 10
reco:hitpdune:DisambigFromSpacePoints 0.55982 0.922413 1.38769 0.912451 0.286721 10
reco:pandora:StandardPandora 8.37923 17.7571 27.481 16.105 6.1743 10
reco:pandoraWriter:StandardPandora 0.170493 0.238811 0.308494 0.248319 0.0421692 10
reco:pandoraTrack:LArPandoraTrackCreation 1.27883 1.91172 2.7771 1.98552 0.462224 10
reco:pandoraShower:LArPandoraShowerCreation 1.3305 2.45715 3.74064 2.54567 0.801743 10
reco:pandoracalo:Calorimetry 0.790727 1.17366 1.62159 1.24154 0.268071 10
reco:pandoracalonosce:Calorimetry 0.718436 1.0895 1.5253 1.1528 0.25869 10
reco:pandorapid:Chi2ParticleID 0.00234186 0.00287834 0.00332448 0.00288119 0.000336812 10
reco:pandoracalinoxyzt:CalibrationdEdXPDSP 0.0239352 0.0294545 0.0348997 0.029961 0.00388833 10
reco:pandoracalipidnoxyzt:Chi2ParticleID 0.00219568 0.00266998 0.0032413 0.00267554 0.000356889 10
reco:pandoraShowercalo:ShowerCalorimetry 1.28512 2.75482 4.25675 2.93551 0.929686 10
reco:pandoraShowercalonosce:ShowerCalorimetry 1.25098 2.69681 4.15553 2.8694 0.915621 10
reco:emtrkmichelid:EmTrackMichelId 89.2754 114.987 140.459 115.759 17.5725 10
reco:crttag:SingleCRTMatchingProducer 0.00539387 0.00743956 0.00868898 0.00775094 0.00102865 10
reco:crtreco:TwoCRTMatchingProducer 0.00364499 0.00462699 0.00554039 0.00470889 0.000625346 10
reco:anodepiercerst0:T0RecoAnodePiercers 0.366682 0.512937 0.649475 0.518561 0.0936277 10
reco:pandora2Track:LArPandoraTrackCreation 3.86527 6.941 10.5083 7.34261 2.23506 10
reco:pandora2calo:Calorimetry 2.00178 3.77156 5.56422 4.04515 1.15778 10
reco:pandora2calonosce:Calorimetry 1.91767 3.62576 5.3527 3.91673 1.11349 10
reco:pandora2pid:Chi2ParticleID 0.0051158 0.00684327 0.00871482 0.00694968 0.00116035 10
reco:pandora2calinoxyzt:CalibrationdEdXPDSP 0.0282358 0.0361447 0.0427942 0.0376154 0.00524961 10
reco:pandora2calipidnoxyzt:Chi2ParticleID 0.00504123 0.00676567 0.00865894 0.00686786 0.00118816 10
reco:pandora2Shower:LArPandoraShowerCreation 1.56116 2.59665 3.68668 2.74473 0.71526 10
reco:pandora2Showercalo:ShowerCalorimetry 1.75686 3.34355 4.85712 3.61373 0.994281 10
reco:pandora2Showercalonosce:ShowerCalorimetry 1.65637 3.0938 4.40093 3.36409 0.886042 10
[art]:TriggerResults:TriggerResultInserter 2.6541e-05 3.3509e-05 6.9446e-05 2.9575e-05 1.22086e-05 10
end_path:out1:RootOutput 5.148e-06 7.6616e-06 1.0586e-05 7.6165e-06 1.24542e-06 10
end_path:out1:RootOutput(write) 1.43408 1.81558 2.32889 1.8223 0.29717 10
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5165.02 MB
Peak resident set size usage (VmHWM): 4345.63 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.14 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleAdcToKe: 0.02 sec/event
ToolBasedRawDigitPrepService:dtor: pdspTailPedRemovalZKe: 1.92 sec/event
ToolBasedRawDigitPrepService:dtor: adcKeepAllSignalFinder: 0.08 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleKeToAdc: 0.02 sec/event
ToolBasedRawDigitPrepService:dtor: pdsp_RemoveBadChannels: 0.00 sec/event
Art has completed and will exit with status 0.
lar exit code 0
.:
total 10847756
-rw-r--r-- 1 dunegli fnalgrid 2516897962 Dec 28 16:51 detsim_stage2.root
-rw-r--r-- 1 dunegli fnalgrid 2387711342 Dec 28 16:50 detsim_stage1.root
-rw-r--r-- 1 dunegli fnalgrid 2229716975 Dec 28 17:27 reco_stage1.root
-rw-r--r-- 1 dunegli fnalgrid 1988295212 Dec 28 15:35 g4_stage2.root
-rw-r--r-- 1 dunegli fnalgrid 1904267241 Dec 28 15:27 g4_stage1.root
-rw-r--r-- 1 dunegli fnalgrid 80533220 Dec 28 17:25 Pandora_Events.pndr
-rw-r--r-- 1 dunegli fnalgrid 242835 Dec 28 17:27 jobscript.log
-rw-r--r-- 1 dunegli fnalgrid 217088 Dec 28 17:27 mem.db
-rw-r--r-- 1 dunegli fnalgrid 62376 Dec 28 17:27 Pandora_Geometry.xml
-rw-r--r-- 1 dunegli fnalgrid 36864 Dec 28 17:27 time.db
-rw-r--r-- 1 dunegli fnalgrid 519 Dec 28 16:51 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 dunegli fnalgrid 519 Dec 28 15:35 g4_protoDUNE_hist.root
-rw-r--r-- 1 dunegli fnalgrid 519 Dec 28 17:27 protoDUNE_reco1_hist.root
-rw-r--r-- 1 dunegli fnalgrid 52 Dec 28 15:24 all-input-dids.txt
-rw-r--r-- 1 dunegli fnalgrid 7 Dec 28 17:27 justin-processed-pfns.txt
-rw-r--r-- 1 dunegli fnalgrid 0 Dec 28 16:54 ProtoDUNE.log
-rw-r--r-- 1 dunegli fnalgrid 0 Dec 28 16:51 debugprod.log
