Jobsub ID 296619.0@dunegpschedd02.fnal.gov
| Jobsub ID | 296619.0@dunegpschedd02.fnal.gov |
| Workflow ID | 12547 |
| 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-30 07:26:55 |
| Site | US_FNAL-FermiGrid |
| Entry | FNAL_GPGrid_ce04_mcore_op_duneonly |
| Last heartbeat | 2026-01-30 10:25:46 |
| From worker node | Hostname | dunegli-8484075-0-fnpc19130.fnal.gov |
| cpuinfo | AMD EPYC 7502 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 | 2026-01-30 07:28:09 |
| Input files | monte-carlo-012547-000001
|
| Jobscript | Exit code | 0 |
| Real time | 2h (10637s) |
| CPU time | 2h (10552s = 99%) |
| Max RSS bytes | 4261199872 (4063 MiB) |
| Outputting started | 2026-01-30 10:25:27 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/12547/1/001/reco_stage1.root
|
| Finished | 2026-01-30 10:25:46 |
| Saved logs | justin-logs:296619.0-dunegpschedd02.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
ce: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 160708 traces, 0 summary
Retagger: tagging trace set: gauss with 120725 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 120725 traces tagged "gauss"
FrameSaver: q=4.03634e+06 n=2109606 tag=gauss
wclsFrameSaver: saving 160708 traces tagged "wiener"
FrameSaver: q=4.28814e+06 n=1854727 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 48117 XUs and 59346 XVs -> 748 XUVs
C:0 T:1 119496 XUs and 134064 XVs -> 9499 XUVs
C:0 T:2 97104 XUs and 119215 XVs -> 7324 XUVs
C:0 T:3 42019 XUs and 46247 XVs -> 553 XUVs
C:0 T:4 15051 XUs and 14912 XVs -> 109 XUVs
C:0 T:5 83863 XUs and 64025 XVs -> 8009 XUVs
C:0 T:6 152586 XUs and 134753 XVs -> 9052 XUVs
C:0 T:7 50233 XUs and 48571 XVs -> 513 XUVs
C:0 T:8 9966 XUs and 5782 XVs -> 100 XUVs
C:0 T:9 76036 XUs and 78431 XVs -> 6736 XUVs
C:0 T:10 73801 XUs and 31471 XVs -> 9305 XUVs
C:0 T:11 47 XUs and 30 XVs -> 8 XUVs
51956 XUVs total
15501 collection wire objects
47653 potential space points
Neighbour search...
5440229 tests to find 2703358 neighbours
Iterating with no regularization...
Begin: 7.33882e+07
0 5.95397e+07
1 5.86009e+07
2 5.8471e+07
3 5.84302e+07
Now with regularization...
Begin: 4.79671e+07
0 4.79239e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 412053794
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 412053794
fLifetime: 30000 [us]
30-Jan-2026 10:25:26 UTC Closed output file "reco_stage1.root"
30-Jan-2026 10:25:26 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 211.06 337.958 447.501 352.285 61.7116 10
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000682546 0.00272677 0.00364585 0.00305018 0.000883147 10
reco:ophit:OpHitFinder 0.21697 0.251496 0.269834 0.258501 0.0183341 10
reco:opflash:OpFlashFinder 0.117073 0.15542 0.186312 0.160698 0.0214424 10
reco:opslicer:OpSlicer 0.455029 0.611173 0.721471 0.621299 0.0888569 10
reco:caldata:DataPrepModule 4.19686 4.33922 4.53206 4.33938 0.0956506 10
reco:wclsdatasp:WireCellToolkit 28.3028 31.7177 33.2437 32.3842 1.72322 10
reco:gaushit:GausHitFinder 0.654696 0.990629 1.25995 1.04232 0.162774 10
reco:nhitsfilter:NumberOfHitsFilter 0.000382424 0.000558528 0.000681726 0.00054431 9.37874e-05 10
reco:reco3d:SpacePointSolver 6.43058 13.7267 19.8652 13.4487 3.524 10
reco:hitpdune:DisambigFromSpacePoints 0.801121 1.52112 2.3534 1.57879 0.397311 10
reco:pandora:StandardPandora 12.4691 33.675 47.3216 34.9962 9.84876 10
reco:pandoraWriter:StandardPandora 0.291565 0.424042 0.535572 0.440424 0.0673498 10
reco:pandoraTrack:LArPandoraTrackCreation 2.68134 4.60527 6.35991 4.35186 1.34219 10
reco:pandoraShower:LArPandoraShowerCreation 1.83778 5.09119 9.49595 4.6993 2.16401 10
reco:pandoracalo:Calorimetry 1.27749 2.09814 3.08783 2.24048 0.508115 10
reco:pandoracalonosce:Calorimetry 1.18837 1.9414 2.96775 2.0397 0.487309 10
reco:pandorapid:Chi2ParticleID 0.00450253 0.00526618 0.00606633 0.00528158 0.000473275 10
reco:pandoracalinoxyzt:CalibrationdEdXPDSP 0.0361333 0.0486919 0.065194 0.0496214 0.00821996 10
reco:pandoracalipidnoxyzt:Chi2ParticleID 0.00443244 0.00500504 0.00551734 0.00498803 0.000379613 10
reco:pandoraShowercalo:ShowerCalorimetry 1.57082 4.50633 8.07275 4.71568 1.70943 10
reco:pandoraShowercalonosce:ShowerCalorimetry 1.79172 4.21034 6.13224 4.31936 1.34431 10
reco:emtrkmichelid:EmTrackMichelId 124.211 180.879 236.496 184.397 29.1649 10
reco:crttag:SingleCRTMatchingProducer 0.00879032 0.0130295 0.017858 0.0132532 0.00318966 10
reco:crtreco:TwoCRTMatchingProducer 0.00476654 0.00904226 0.0129259 0.00868362 0.00248531 10
reco:anodepiercerst0:T0RecoAnodePiercers 0.504986 0.795275 1.05159 0.792439 0.166995 10
reco:pandora2Track:LArPandoraTrackCreation 5.22208 15.3157 23.2766 14.2002 5.77688 10
reco:pandora2calo:Calorimetry 2.39808 6.83109 11.2927 6.17623 2.86465 10
reco:pandora2calonosce:Calorimetry 2.2051 6.08813 10.2775 5.99693 2.42092 10
reco:pandora2pid:Chi2ParticleID 0.00942283 0.0133427 0.0159614 0.0134618 0.00200256 10
reco:pandora2calinoxyzt:CalibrationdEdXPDSP 0.0400699 0.0631817 0.0983875 0.0621672 0.0145581 10
reco:pandora2calipidnoxyzt:Chi2ParticleID 0.00903729 0.0129566 0.0153123 0.0131392 0.00186209 10
reco:pandora2Shower:LArPandoraShowerCreation 2.1203 5.08466 8.31053 4.99856 1.73998 10
reco:pandora2Showercalo:ShowerCalorimetry 2.04983 5.11542 8.46288 5.14657 1.69576 10
reco:pandora2Showercalonosce:ShowerCalorimetry 1.85874 4.74255 6.72571 4.84494 1.50324 10
[art]:TriggerResults:TriggerResultInserter 2.3231e-05 4.31414e-05 9.382e-05 4.1001e-05 1.88301e-05 10
end_path:out1:RootOutput 5.83e-06 8.271e-06 1.093e-05 8.015e-06 1.49049e-06 10
end_path:out1:RootOutput(write) 1.92667 2.93706 3.93791 2.99861 0.526439 10
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5068.84 MB
Peak resident set size usage (VmHWM): 4261.2 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.06 sec/event
ToolBasedRawDigitPrepService:dtor: adcSampleFiller: 0.18 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleAdcToKe: 0.04 sec/event
ToolBasedRawDigitPrepService:dtor: pdspTailPedRemovalZKe: 2.68 sec/event
ToolBasedRawDigitPrepService:dtor: adcKeepAllSignalFinder: 0.10 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleKeToAdc: 0.04 sec/event
ToolBasedRawDigitPrepService:dtor: pdsp_RemoveBadChannels: 0.00 sec/event
Art has completed and will exit with status 0.
lar exit code 0
.:
total 10467988
-rw-r--r-- 1 dunegli fnalgrid 2438832222 Jan 30 09:27 detsim_stage2.root
-rw-r--r-- 1 dunegli fnalgrid 2315586904 Jan 30 09:25 detsim_stage1.root
-rw-r--r-- 1 dunegli fnalgrid 2159129866 Jan 30 10:25 reco_stage1.root
-rw-r--r-- 1 dunegli fnalgrid 1894687960 Jan 30 07:43 g4_stage2.root
-rw-r--r-- 1 dunegli fnalgrid 1827492062 Jan 30 07:32 g4_stage1.root
-rw-r--r-- 1 dunegli fnalgrid 82862470 Jan 30 10:20 Pandora_Events.pndr
-rw-r--r-- 1 dunegli fnalgrid 242742 Jan 30 10:25 jobscript.log
-rw-r--r-- 1 dunegli fnalgrid 217088 Jan 30 10:25 mem.db
-rw-r--r-- 1 dunegli fnalgrid 62376 Jan 30 10:25 Pandora_Geometry.xml
-rw-r--r-- 1 dunegli fnalgrid 36864 Jan 30 10:25 time.db
-rw-r--r-- 1 dunegli fnalgrid 519 Jan 30 09:27 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 dunegli fnalgrid 519 Jan 30 07:43 g4_protoDUNE_hist.root
-rw-r--r-- 1 dunegli fnalgrid 519 Jan 30 10:25 protoDUNE_reco1_hist.root
-rw-r--r-- 1 dunegli fnalgrid 52 Jan 30 07:28 all-input-dids.txt
-rw-r--r-- 1 dunegli fnalgrid 7 Jan 30 10:25 justin-processed-pfns.txt
-rw-r--r-- 1 dunegli fnalgrid 0 Jan 30 09:32 ProtoDUNE.log
-rw-r--r-- 1 dunegli fnalgrid 0 Jan 30 09:27 debugprod.log
