Jobsub ID 301807.0@dunegpschedd01.fnal.gov
| Jobsub ID | 301807.0@dunegpschedd01.fnal.gov |
| Workflow ID | 12457 |
| 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 | 2026-01-27 21:01:50 |
| Site | US_FNAL-FermiGrid |
| Entry | FNAL_GPGrid_ce04_mcore_op_duneonly |
| Last heartbeat | 2026-01-28 00:19:20 |
| From worker node | Hostname | dunegli-8449683-0-fnpc17002.fnal.gov |
| cpuinfo | Intel(R) Xeon(R) CPU E5-2690 v4 @ 2.60GHz |
| 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 | 2026-01-27 21:03:04 |
| Input files | monte-carlo-012457-000001
|
| Jobscript | Exit code | 0 |
| Real time | 3h (11760s) |
| CPU time | 3h (11493s = 97%) |
| Max RSS bytes | 3928678400 (3746 MiB) |
| Outputting started | 2026-01-28 00:19:04 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/12457/1/001/reco_stage1.root
|
| Finished | 2026-01-28 00:19:20 |
| Saved logs | justin-logs:301807.0-dunegpschedd01.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
re: Running tool adcKeepAllSignalFinder
ToolBasedRawDigitPrepService: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 87441 traces, 0 summary
Retagger: tagging trace set: gauss with 69416 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 69416 traces tagged "gauss"
FrameSaver: q=2.31459e+06 n=1279435 tag=gauss
wclsFrameSaver: saving 87441 traces tagged "wiener"
FrameSaver: q=2.43041e+06 n=1154774 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:1 42628 XUs and 53917 XVs -> 4255 XUVs
C:0 T:2 82407 XUs and 88403 XVs -> 2719 XUVs
C:0 T:3 47283 XUs and 38572 XVs -> 195 XUVs
C:0 T:4 6224 XUs and 7776 XVs -> 69 XUVs
C:0 T:5 17546 XUs and 18048 XVs -> 1717 XUVs
C:0 T:6 77326 XUs and 89115 XVs -> 4971 XUVs
C:0 T:7 32986 XUs and 34373 XVs -> 310 XUVs
C:0 T:8 4454 XUs and 4285 XVs -> 33 XUVs
C:0 T:9 20889 XUs and 25914 XVs -> 1307 XUVs
C:0 T:10 36004 XUs and 42289 XVs -> 7676 XUVs
C:0 T:11 193 XUs and 143 XVs -> 25 XUVs
23277 XUVs total
7776 collection wire objects
21857 potential space points
Neighbour search...
2975365 tests to find 1355522 neighbours
Iterating with no regularization...
Begin: 5.63233e+07
0 4.97438e+07
1 4.94478e+07
2 4.94156e+07
Now with regularization...
Begin: 4.38278e+07
0 4.38052e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 412004769
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 412004769
fLifetime: 30000 [us]
28-Jan-2026 00:19:01 UTC Closed output file "reco_stage1.root"
28-Jan-2026 00:19: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 295.133 403.905 560.162 399.12 82.9058 10
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00144426 0.00399562 0.00657962 0.00380363 0.0017107 10
reco:ophit:OpHitFinder 0.175096 0.266433 0.402873 0.235327 0.0781407 10
reco:opflash:OpFlashFinder 0.080685 0.140008 0.223724 0.150754 0.0410737 10
reco:opslicer:OpSlicer 0.399025 0.624534 1.17416 0.510337 0.246045 10
reco:caldata:DataPrepModule 4.91395 5.83762 8.25037 5.14777 1.23521 10
reco:wclsdatasp:WireCellToolkit 41.0017 45.0574 52.3855 44.5015 2.77846 10
reco:gaushit:GausHitFinder 0.878377 1.18434 1.53671 1.18278 0.170454 10
reco:nhitsfilter:NumberOfHitsFilter 0.000491005 0.000680991 0.000905806 0.000674722 0.000124493 10
reco:reco3d:SpacePointSolver 6.5326 11.0566 19.8345 10.6397 3.76487 10
reco:hitpdune:DisambigFromSpacePoints 1.15537 1.87092 2.91217 1.86241 0.461705 10
reco:pandora:StandardPandora 19.5385 30.8011 47.4553 31.0789 8.10017 10
reco:pandoraWriter:StandardPandora 0.312834 0.430152 0.554416 0.4433 0.0634772 10
reco:pandoraTrack:LArPandoraTrackCreation 3.88618 7.32757 11.7706 7.55701 2.31447 10
reco:pandoraShower:LArPandoraShowerCreation 2.87806 7.83253 16.2095 8.27569 3.47712 10
reco:pandoracalo:Calorimetry 1.68966 3.21995 5.43452 3.33478 1.05089 10
reco:pandoracalonosce:Calorimetry 1.52448 3.10058 5.25034 3.09204 1.12633 10
reco:pandorapid:Chi2ParticleID 0.0041773 0.00556704 0.00838115 0.00539504 0.00115877 10
reco:pandoracalinoxyzt:CalibrationdEdXPDSP 0.0461714 0.0594594 0.074897 0.0592245 0.00851745 10
reco:pandoracalipidnoxyzt:Chi2ParticleID 0.00407484 0.00521189 0.00607924 0.00538081 0.000665308 10
reco:pandoraShowercalo:ShowerCalorimetry 2.52658 6.8884 13.533 7.30416 2.97386 10
reco:pandoraShowercalonosce:ShowerCalorimetry 2.39715 6.58881 12.6162 7.12265 2.70388 10
reco:emtrkmichelid:EmTrackMichelId 151.229 192.312 305.744 179.069 43.0382 10
reco:crttag:SingleCRTMatchingProducer 0.0247131 0.0319742 0.0411285 0.0317128 0.00515462 10
reco:crtreco:TwoCRTMatchingProducer 0.0197755 0.024616 0.0298319 0.0256645 0.00306457 10
reco:anodepiercerst0:T0RecoAnodePiercers 1.34891 1.9293 2.41707 1.94943 0.360397 10
reco:pandora2Track:LArPandoraTrackCreation 12.8852 27.1829 40.777 27.2042 9.31172 10
reco:pandora2calo:Calorimetry 5.04227 11.566 22.3481 10.3675 5.44984 10
reco:pandora2calonosce:Calorimetry 4.98654 10.0795 16.565 8.96165 4.21696 10
reco:pandora2pid:Chi2ParticleID 0.00952109 0.015484 0.0250793 0.0137688 0.00512503 10
reco:pandora2calinoxyzt:CalibrationdEdXPDSP 0.0633708 0.0855105 0.123373 0.0819213 0.0205787 10
reco:pandora2calipidnoxyzt:Chi2ParticleID 0.00949679 0.0156563 0.0239524 0.0147685 0.00447166 10
reco:pandora2Shower:LArPandoraShowerCreation 4.75615 7.62582 12.4959 7.07332 2.53429 10
reco:pandora2Showercalo:ShowerCalorimetry 3.53548 9.09919 20.6626 8.08683 5.00961 10
reco:pandora2Showercalonosce:ShowerCalorimetry 2.96345 8.48346 20.0266 7.92136 4.72742 10
[art]:TriggerResults:TriggerResultInserter 5.2463e-05 7.57522e-05 0.000148841 6.6617e-05 2.74238e-05 10
end_path:out1:RootOutput 9.164e-06 1.15334e-05 1.6143e-05 1.0839e-05 2.15173e-06 10
end_path:out1:RootOutput(write) 1.69876 3.01418 5.08967 2.65941 1.07659 10
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4736.71 MB
Peak resident set size usage (VmHWM): 3928.68 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.10 sec/event
ToolBasedRawDigitPrepService:dtor: adcSampleFiller: 0.24 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleAdcToKe: 0.06 sec/event
ToolBasedRawDigitPrepService:dtor: pdspTailPedRemovalZKe: 3.59 sec/event
ToolBasedRawDigitPrepService:dtor: adcKeepAllSignalFinder: 0.18 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleKeToAdc: 0.06 sec/event
ToolBasedRawDigitPrepService:dtor: pdsp_RemoveBadChannels: 0.00 sec/event
Art has completed and will exit with status 0.
lar exit code 0
.:
total 8993668
-rw-r--r-- 1 dunegli fnalgrid 2157079070 Jan 27 23:09 detsim_stage2.root
-rw-r--r-- 1 dunegli fnalgrid 2052011445 Jan 27 23:06 detsim_stage1.root
-rw-r--r-- 1 dunegli fnalgrid 1812620375 Jan 28 00:19 reco_stage1.root
-rw-r--r-- 1 dunegli fnalgrid 1593581095 Jan 27 21:27 g4_stage2.root
-rw-r--r-- 1 dunegli fnalgrid 1525871788 Jan 27 21:10 g4_stage1.root
-rw-r--r-- 1 dunegli fnalgrid 67722070 Jan 28 00:15 Pandora_Events.pndr
-rw-r--r-- 1 dunegli fnalgrid 242836 Jan 28 00:19 jobscript.log
-rw-r--r-- 1 dunegli fnalgrid 217088 Jan 28 00:19 mem.db
-rw-r--r-- 1 dunegli fnalgrid 62376 Jan 28 00:19 Pandora_Geometry.xml
-rw-r--r-- 1 dunegli fnalgrid 36864 Jan 28 00:19 time.db
-rw-r--r-- 1 dunegli fnalgrid 519 Jan 27 23:09 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 dunegli fnalgrid 519 Jan 27 21:27 g4_protoDUNE_hist.root
-rw-r--r-- 1 dunegli fnalgrid 519 Jan 28 00:19 protoDUNE_reco1_hist.root
-rw-r--r-- 1 dunegli fnalgrid 52 Jan 27 21:03 all-input-dids.txt
-rw-r--r-- 1 dunegli fnalgrid 7 Jan 28 00:19 justin-processed-pfns.txt
-rw-r--r-- 1 dunegli fnalgrid 0 Jan 27 23:15 ProtoDUNE.log
-rw-r--r-- 1 dunegli fnalgrid 0 Jan 27 23:09 debugprod.log
