Jobsub ID 263228.1@dunegpschedd02.fnal.gov
| Jobsub ID | 263228.1@dunegpschedd02.fnal.gov |
| Workflow ID | 11243 |
| 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-18 10:38:44 |
| Site | US_FNAL-T1 |
| Entry | CMSHTPC_T1_US_FNAL_condce_opp1_whole |
| Last heartbeat | 2025-12-18 13:51:21 |
| From worker node | Hostname | dunegli-49199-0-cmswn2413.fnal.gov |
| cpuinfo | AMD EPYC 7551 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-18 10:39:26 |
| Input files | monte-carlo-011243-000001
|
| Jobscript | Exit code | 0 |
| Real time | 3h (11496s) |
| CPU time | 3h (11380s = 98%) |
| Max RSS bytes | 4283523072 (4085 MiB) |
| Outputting started | 2025-12-18 13:51:03 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11243/1/001/reco_stage1.root
|
| Finished | 2025-12-18 13:51:21 |
| Saved logs | justin-logs:263228.1-dunegpschedd02.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
ice: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 129713 traces, 0 summary
Retagger: tagging trace set: gauss with 96512 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 96512 traces tagged "gauss"
FrameSaver: q=3.21031e+06 n=1675340 tag=gauss
wclsFrameSaver: saving 129713 traces tagged "wiener"
FrameSaver: q=3.414e+06 n=1467212 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 17982 XUs and 17393 XVs -> 140 XUVs
C:0 T:1 32265 XUs and 33795 XVs -> 2395 XUVs
C:0 T:2 69924 XUs and 95743 XVs -> 8865 XUVs
C:0 T:3 26644 XUs and 24563 XVs -> 574 XUVs
C:0 T:4 12753 XUs and 13896 XVs -> 89 XUVs
C:0 T:5 51387 XUs and 48830 XVs -> 5111 XUVs
C:0 T:6 132004 XUs and 133327 XVs -> 9789 XUVs
C:0 T:7 48015 XUs and 43930 XVs -> 428 XUVs
C:0 T:8 8362 XUs and 10973 XVs -> 102 XUVs
C:0 T:9 60441 XUs and 104239 XVs -> 5235 XUVs
C:0 T:10 51969 XUs and 19518 XVs -> 3591 XUVs
C:0 T:11 180 XUs and 142 XVs -> 26 XUVs
36345 XUVs total
13062 collection wire objects
33390 potential space points
Neighbour search...
2768192 tests to find 1418822 neighbours
Iterating with no regularization...
Begin: 6.79816e+07
0 5.34483e+07
1 5.24493e+07
2 5.23057e+07
3 5.22616e+07
Now with regularization...
Begin: 4.33055e+07
0 4.32694e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 411191448
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411191448
fLifetime: 30000 [us]
18-Dec-2025 13:51:01 UTC Closed output file "reco_stage1.root"
18-Dec-2025 13:51:01 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 274.781 335.162 421.332 321.669 49.9545 10
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000838395 0.0031804 0.00518156 0.00324715 0.00141056 10
reco:ophit:OpHitFinder 0.25722 0.299496 0.32998 0.307076 0.0248039 10
reco:opflash:OpFlashFinder 0.16743 0.209752 0.257661 0.218028 0.0294915 10
reco:opslicer:OpSlicer 0.589785 0.718549 0.874499 0.717667 0.0952539 10
reco:caldata:DataPrepModule 5.24601 5.35228 5.55866 5.32672 0.0839633 10
reco:wclsdatasp:WireCellToolkit 31.126 34.44 36.2697 35.487 1.85531 10
reco:gaushit:GausHitFinder 0.910177 1.17084 1.3791 1.17049 0.150786 10
reco:nhitsfilter:NumberOfHitsFilter 0.000449422 0.000543144 0.000756884 0.000531108 8.17767e-05 10
reco:reco3d:SpacePointSolver 7.81437 14.5944 24.0442 13.2826 5.01956 10
reco:hitpdune:DisambigFromSpacePoints 1.16888 1.52665 2.07422 1.42026 0.296821 10
reco:pandora:StandardPandora 17.5038 31.8312 45.6551 31.647 9.79513 10
reco:pandoraWriter:StandardPandora 0.365606 0.43368 0.506661 0.430307 0.0474549 10
reco:pandoraTrack:LArPandoraTrackCreation 4.00782 5.25539 7.9869 4.91063 1.24062 10
reco:pandoraShower:LArPandoraShowerCreation 3.27217 5.78091 9.22164 5.38775 1.76933 10
reco:pandoracalo:Calorimetry 1.8683 2.50186 3.70703 2.30531 0.61885 10
reco:pandoracalonosce:Calorimetry 1.72804 2.32177 3.54481 2.05835 0.600501 10
reco:pandorapid:Chi2ParticleID 0.00511544 0.00649232 0.00966754 0.00566301 0.00146973 10
reco:pandoracalinoxyzt:CalibrationdEdXPDSP 0.042213 0.0521346 0.0647886 0.0514545 0.00669328 10
reco:pandoracalipidnoxyzt:Chi2ParticleID 0.00504458 0.00578691 0.0071827 0.00550311 0.000710858 10
reco:pandoraShowercalo:ShowerCalorimetry 3.62288 5.04393 7.29812 4.34702 1.395 10
reco:pandoraShowercalonosce:ShowerCalorimetry 3.22665 5.02487 8.41007 4.38607 1.74374 10
reco:emtrkmichelid:EmTrackMichelId 142.623 166.083 196.407 162.685 16.6895 10
reco:crttag:SingleCRTMatchingProducer 0.0108254 0.013968 0.0165301 0.0138141 0.00172363 10
reco:crtreco:TwoCRTMatchingProducer 0.00793825 0.0103044 0.0128931 0.0102113 0.0014251 10
reco:anodepiercerst0:T0RecoAnodePiercers 0.74866 0.903727 1.15729 0.840736 0.126851 10
reco:pandora2Track:LArPandoraTrackCreation 11.2072 16.7395 26.0077 15.5356 4.8714 10
reco:pandora2calo:Calorimetry 4.62816 7.39027 11.1852 6.66162 2.06208 10
reco:pandora2calonosce:Calorimetry 4.85676 6.93094 10.5103 6.35155 2.07143 10
reco:pandora2pid:Chi2ParticleID 0.0126011 0.0157146 0.0203739 0.0160731 0.00240783 10
reco:pandora2calinoxyzt:CalibrationdEdXPDSP 0.0517532 0.0661188 0.0819781 0.0660436 0.00918127 10
reco:pandora2calipidnoxyzt:Chi2ParticleID 0.0121194 0.0148224 0.0194053 0.0146699 0.00232384 10
reco:pandora2Shower:LArPandoraShowerCreation 3.86981 5.9144 8.71995 5.45482 1.62811 10
reco:pandora2Showercalo:ShowerCalorimetry 4.33164 6.15267 8.89012 5.64789 1.61772 10
reco:pandora2Showercalonosce:ShowerCalorimetry 3.45114 5.21545 7.86344 4.95399 1.36535 10
[art]:TriggerResults:TriggerResultInserter 4.008e-05 5.43672e-05 0.000127301 4.703e-05 2.45475e-05 10
end_path:out1:RootOutput 8.661e-06 1.07884e-05 1.633e-05 9.76e-06 2.49718e-06 10
end_path:out1:RootOutput(write) 2.61633 3.0373 3.69625 2.94884 0.348282 10
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5104.46 MB
Peak resident set size usage (VmHWM): 4283.52 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.07 sec/event
ToolBasedRawDigitPrepService:dtor: adcSampleFiller: 0.20 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleAdcToKe: 0.05 sec/event
ToolBasedRawDigitPrepService:dtor: pdspTailPedRemovalZKe: 3.45 sec/event
ToolBasedRawDigitPrepService:dtor: adcKeepAllSignalFinder: 0.11 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 10800104
-rw-r--r-- 1 dunegli fnalgrid 2509568932 Dec 18 12:52 detsim_stage2.root
-rw-r--r-- 1 dunegli fnalgrid 2380295269 Dec 18 12:50 detsim_stage1.root
-rw-r--r-- 1 dunegli fnalgrid 2205068749 Dec 18 13:51 reco_stage1.root
-rw-r--r-- 1 dunegli fnalgrid 1982699816 Dec 18 10:58 g4_stage2.root
-rw-r--r-- 1 dunegli fnalgrid 1904550074 Dec 18 10:45 g4_stage1.root
-rw-r--r-- 1 dunegli fnalgrid 76496880 Dec 18 13:47 Pandora_Events.pndr
-rw-r--r-- 1 dunegli fnalgrid 243025 Dec 18 13:51 jobscript.log
-rw-r--r-- 1 dunegli fnalgrid 217088 Dec 18 13:51 mem.db
-rw-r--r-- 1 dunegli fnalgrid 62376 Dec 18 13:51 Pandora_Geometry.xml
-rw-r--r-- 1 dunegli fnalgrid 36864 Dec 18 13:51 time.db
-rw-r--r-- 1 dunegli fnalgrid 519 Dec 18 12:52 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 dunegli fnalgrid 519 Dec 18 10:58 g4_protoDUNE_hist.root
-rw-r--r-- 1 dunegli fnalgrid 519 Dec 18 13:51 protoDUNE_reco1_hist.root
-rw-r--r-- 1 dunegli fnalgrid 52 Dec 18 10:39 all-input-dids.txt
-rw-r--r-- 1 dunegli fnalgrid 7 Dec 18 13:51 justin-processed-pfns.txt
-rw-r--r-- 1 dunegli fnalgrid 0 Dec 18 12:57 ProtoDUNE.log
-rw-r--r-- 1 dunegli fnalgrid 0 Dec 18 12:52 debugprod.log
