Jobsub ID 246859.0@dunegpschedd02.fnal.gov
| Jobsub ID | 246859.0@dunegpschedd02.fnal.gov |
| Workflow ID | 10244 |
| 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-16 04:28:32 |
| Site | US_FNAL-T1 |
| Entry | CMSHTPC_T1_US_FNAL_condce_opp1_whole |
| Last heartbeat | 2025-11-16 06:19:58 |
| From worker node | Hostname | dunegli-47944-0-cmswn4057.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 | 171000 (47 hours) |
| GPU | |
| Inner Apptainer? | True |
| Job state | finished |
| Started | 2025-11-16 04:31:15 |
| Input files | monte-carlo-010244-000001
|
| Jobscript | Exit code | 0 |
| Real time | 1h (6507s) |
| CPU time | 1h (6465s = 99%) |
| Max RSS bytes | 4058890240 (3870 MiB) |
| Outputting started | 2025-11-16 06:19:42 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/10244/1/001/reco_stage1.root
|
| Finished | 2025-11-16 06:19:58 |
| Saved logs | justin-logs:246859.0-dunegpschedd02.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
dRawDigitPrepService: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 90060 traces, 0 summary
Retagger: tagging trace set: gauss with 69002 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 69002 traces tagged "gauss"
FrameSaver: q=2.47737e+06 n=1210931 tag=gauss
wclsFrameSaver: saving 90060 traces tagged "wiener"
FrameSaver: q=2.61687e+06 n=1071994 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 41826 XUs and 47752 XVs -> 602 XUVs
C:0 T:1 77372 XUs and 82469 XVs -> 3925 XUVs
C:0 T:2 86716 XUs and 80447 XVs -> 3856 XUVs
C:0 T:3 47819 XUs and 38336 XVs -> 376 XUVs
C:0 T:4 4033 XUs and 5251 XVs -> 44 XUVs
C:0 T:5 10164 XUs and 9144 XVs -> 996 XUVs
C:0 T:6 21257 XUs and 14870 XVs -> 692 XUVs
C:0 T:7 11414 XUs and 7836 XVs -> 69 XUVs
C:0 T:8 6656 XUs and 5682 XVs -> 80 XUVs
C:0 T:9 44575 XUs and 47050 XVs -> 6104 XUVs
C:0 T:10 13412 XUs and 19787 XVs -> 3687 XUVs
C:0 T:11 367 XUs and 129 XVs -> 80 XUVs
20511 XUVs total
7248 collection wire objects
19063 potential space points
Neighbour search...
933285 tests to find 542060 neighbours
Iterating with no regularization...
Begin: 5.09524e+07
0 4.36145e+07
1 4.30941e+07
2 4.30114e+07
3 4.2984e+07
Now with regularization...
Begin: 3.57342e+07
0 3.57224e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 410542573
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 410542573
fLifetime: 30000 [us]
16-Nov-2025 06:19:41 UTC Closed output file "reco_stage1.root"
16-Nov-2025 06:19:41 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 133.074 178.925 246.358 175.625 37.119 10
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.0009107 0.00263639 0.00425063 0.00267785 0.0011243 10
reco:ophit:OpHitFinder 0.177656 0.193778 0.229978 0.192705 0.0159088 10
reco:opflash:OpFlashFinder 0.0992197 0.119582 0.143618 0.118508 0.0128318 10
reco:opslicer:OpSlicer 0.331606 0.41237 0.502307 0.407567 0.0615116 10
reco:caldata:DataPrepModule 3.26873 3.37406 3.66265 3.35266 0.109473 10
reco:wclsdatasp:WireCellToolkit 21.7016 22.1257 22.4152 22.1961 0.200306 10
reco:gaushit:GausHitFinder 0.462343 0.656574 0.946266 0.622434 0.152265 10
reco:nhitsfilter:NumberOfHitsFilter 0.000213393 0.000300192 0.000582951 0.00027005 0.000102661 10
reco:reco3d:SpacePointSolver 4.22095 7.96795 12.6121 8.63207 3.00229 10
reco:hitpdune:DisambigFromSpacePoints 0.509771 0.851667 1.43983 0.810485 0.298458 10
reco:pandora:StandardPandora 8.93412 15.9561 28.0112 15.1829 5.7651 10
reco:pandoraWriter:StandardPandora 0.160785 0.215115 0.285267 0.215932 0.0456159 10
reco:pandoraTrack:LArPandoraTrackCreation 1.11953 1.57645 2.10686 1.55543 0.376889 10
reco:pandoraShower:LArPandoraShowerCreation 0.915259 1.81752 3.40559 1.84703 0.761712 10
reco:pandoracalo:Calorimetry 0.645224 0.958453 1.33436 0.948126 0.271091 10
reco:pandoracalonosce:Calorimetry 0.5714 0.875919 1.22575 0.868802 0.255257 10
reco:pandorapid:Chi2ParticleID 0.00241233 0.00307663 0.0055856 0.00287086 0.000861708 10
reco:pandoracalinoxyzt:CalibrationdEdXPDSP 0.0220865 0.02886 0.0349807 0.0287632 0.00456417 10
reco:pandoracalipidnoxyzt:Chi2ParticleID 0.00229824 0.00271095 0.00302282 0.00277388 0.000232842 10
reco:pandoraShowercalo:ShowerCalorimetry 0.918502 2.05418 3.97139 2.04185 0.970209 10
reco:pandoraShowercalonosce:ShowerCalorimetry 0.895859 1.99524 3.88283 1.98095 0.941782 10
reco:emtrkmichelid:EmTrackMichelId 74.6104 97.8829 130.883 96.8995 18.7915 10
reco:crttag:SingleCRTMatchingProducer 0.00416576 0.00714107 0.0118297 0.0068547 0.00257627 10
reco:crtreco:TwoCRTMatchingProducer 0.00320948 0.00428123 0.0057698 0.00417091 0.000951195 10
reco:anodepiercerst0:T0RecoAnodePiercers 0.363958 0.503925 0.689849 0.477672 0.0921756 10
reco:pandora2Track:LArPandoraTrackCreation 3.02557 5.24772 9.16898 5.37102 1.94438 10
reco:pandora2calo:Calorimetry 1.56299 2.85664 5.01266 2.91834 1.15419 10
reco:pandora2calonosce:Calorimetry 1.4734 2.71673 4.77604 2.7824 1.1075 10
reco:pandora2pid:Chi2ParticleID 0.00528717 0.00705497 0.0094008 0.0072902 0.00125282 10
reco:pandora2calinoxyzt:CalibrationdEdXPDSP 0.0255678 0.0348777 0.0449294 0.0350743 0.00657474 10
reco:pandora2calipidnoxyzt:Chi2ParticleID 0.00514798 0.00691038 0.0090955 0.00725928 0.00121042 10
reco:pandora2Shower:LArPandoraShowerCreation 1.18229 1.9587 3.20047 1.99379 0.660346 10
reco:pandora2Showercalo:ShowerCalorimetry 1.37659 2.5126 4.28519 2.57046 0.996446 10
reco:pandora2Showercalonosce:ShowerCalorimetry 1.27234 2.3231 3.89575 2.34811 0.913874 10
[art]:TriggerResults:TriggerResultInserter 2.7982e-05 3.80787e-05 9.3006e-05 3.2747e-05 1.84791e-05 10
end_path:out1:RootOutput 3.847e-06 6.4551e-06 1.1632e-05 6.608e-06 2.25881e-06 10
end_path:out1:RootOutput(write) 1.23308 1.63102 2.20978 1.61074 0.324478 10
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4873.89 MB
Peak resident set size usage (VmHWM): 4058.89 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.03 sec/event
ToolBasedRawDigitPrepService:dtor: pdspTailPedRemovalZKe: 2.12 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 9560140
-rw-r--r-- 1 dunegli fnalgrid 2265060468 Nov 16 05:48 detsim_stage2.root
-rw-r--r-- 1 dunegli fnalgrid 2151817196 Nov 16 05:47 detsim_stage1.root
-rw-r--r-- 1 dunegli fnalgrid 1921236252 Nov 16 06:19 reco_stage1.root
-rw-r--r-- 1 dunegli fnalgrid 1729193337 Nov 16 04:40 g4_stage2.root
-rw-r--r-- 1 dunegli fnalgrid 1653699741 Nov 16 04:34 g4_stage1.root
-rw-r--r-- 1 dunegli fnalgrid 67766730 Nov 16 06:18 Pandora_Events.pndr
-rw-r--r-- 1 dunegli fnalgrid 242816 Nov 16 06:19 jobscript.log
-rw-r--r-- 1 dunegli fnalgrid 217088 Nov 16 06:19 mem.db
-rw-r--r-- 1 dunegli fnalgrid 62376 Nov 16 06:19 Pandora_Geometry.xml
-rw-r--r-- 1 dunegli fnalgrid 36864 Nov 16 06:19 time.db
-rw-r--r-- 1 dunegli fnalgrid 519 Nov 16 05:48 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 dunegli fnalgrid 519 Nov 16 04:40 g4_protoDUNE_hist.root
-rw-r--r-- 1 dunegli fnalgrid 519 Nov 16 06:19 protoDUNE_reco1_hist.root
-rw-r--r-- 1 dunegli fnalgrid 52 Nov 16 04:31 all-input-dids.txt
-rw-r--r-- 1 dunegli fnalgrid 7 Nov 16 06:19 justin-processed-pfns.txt
-rw-r--r-- 1 dunegli fnalgrid 0 Nov 16 05:52 ProtoDUNE.log
-rw-r--r-- 1 dunegli fnalgrid 0 Nov 16 05:48 debugprod.log
