Jobsub ID 298748.1@dunegpschedd01.fnal.gov
| Jobsub ID | 298748.1@dunegpschedd01.fnal.gov |
| Workflow ID | 12204 |
| 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-21 21:22:13 |
| Site | UK_Brunel |
| Entry | CMSHTPC_T2_UK_London_Brunel_dc2_22 |
| Last heartbeat | 2026-01-22 02:24:01 |
| From worker node | Hostname | wn-b7-04-01.brunel.ac.uk |
| cpuinfo | Intel(R) Xeon(R) CPU E5645 @ 2.40GHz |
| 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 | 2026-01-21 21:23:10 |
| Input files | monte-carlo-012204-000001
|
| Jobscript | Exit code | 0 |
| Real time | 4h (17943s) |
| CPU time | 4h (17403s = 96%) |
| Max RSS bytes | 4223389696 (4027 MiB) |
| Outputting started | 2026-01-22 02:22:15 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/12204/1/001/reco_stage1.root
|
| Finished | 2026-01-22 02:24:01 |
| Saved logs | justin-logs:298748.1-dunegpschedd01.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
asedRawDigitPrepService: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 135372 traces, 0 summary
Retagger: tagging trace set: gauss with 102750 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 102750 traces tagged "gauss"
FrameSaver: q=3.5884e+06 n=1830882 tag=gauss
wclsFrameSaver: saving 135372 traces tagged "wiener"
FrameSaver: q=3.80132e+06 n=1620406 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 26992 XUs and 30703 XVs -> 341 XUVs
C:0 T:1 51773 XUs and 60009 XVs -> 4414 XUVs
C:0 T:2 85807 XUs and 87186 XVs -> 4469 XUVs
C:0 T:3 44975 XUs and 39442 XVs -> 291 XUVs
C:0 T:4 10422 XUs and 11492 XVs -> 184 XUVs
C:0 T:5 43620 XUs and 71143 XVs -> 10926 XUVs
C:0 T:6 92104 XUs and 97466 XVs -> 3704 XUVs
C:0 T:7 34558 XUs and 31553 XVs -> 322 XUVs
C:0 T:8 14188 XUs and 10270 XVs -> 315 XUVs
C:0 T:9 118629 XUs and 107200 XVs -> 15784 XUVs
C:0 T:10 55979 XUs and 73331 XVs -> 11447 XUVs
C:0 T:11 171 XUs and 96 XVs -> 16 XUVs
52213 XUVs total
11751 collection wire objects
48582 potential space points
Neighbour search...
7971418 tests to find 3502386 neighbours
Iterating with no regularization...
Begin: 6.63298e+07
0 4.8956e+07
1 4.77127e+07
2 4.75689e+07
3 4.75212e+07
4 4.74965e+07
Now with regularization...
Begin: 3.77527e+07
0 3.7705e+07
1 3.7671e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 411884430
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411884430
fLifetime: 30000 [us]
22-Jan-2026 02:22:09 GMT Closed output file "reco_stage1.root"
22-Jan-2026 02:22:09 GMT 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 422.856 616.892 1051.19 589.282 165.399 10
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00141511 0.00598582 0.0132346 0.00531056 0.0038548 10
reco:ophit:OpHitFinder 0.369428 0.564562 0.789479 0.579753 0.131483 10
reco:opflash:OpFlashFinder 0.216866 0.290942 0.394574 0.285491 0.0579181 10
reco:opslicer:OpSlicer 0.878679 1.32221 1.6905 1.39383 0.295808 10
reco:caldata:DataPrepModule 8.15091 11.1584 14.1868 10.8961 2.15506 10
reco:wclsdatasp:WireCellToolkit 56.7605 74.1352 87.3942 73.7695 8.68373 10
reco:gaushit:GausHitFinder 1.96415 2.40954 3.33543 2.26824 0.413108 10
reco:nhitsfilter:NumberOfHitsFilter 0.000702157 0.000986306 0.00161387 0.00093865 0.000263193 10
reco:reco3d:SpacePointSolver 11.7833 20.7904 48.8273 19.1547 9.88636 10
reco:hitpdune:DisambigFromSpacePoints 2.62322 3.69999 6.6335 3.36169 1.11193 10
reco:pandora:StandardPandora 32.0051 60.4467 163.931 49.9334 35.7106 10
reco:pandoraWriter:StandardPandora 0.532014 0.642508 0.819009 0.63511 0.0920798 10
reco:pandoraTrack:LArPandoraTrackCreation 4.42223 7.61216 12.1381 7.85179 2.21011 10
reco:pandoraShower:LArPandoraShowerCreation 4.15515 8.85933 20.1783 8.33174 4.21039 10
reco:pandoracalo:Calorimetry 2.23819 4.1893 7.42365 4.24852 1.48583 10
reco:pandoracalonosce:Calorimetry 2.01795 3.66665 6.19018 3.62866 1.23306 10
reco:pandorapid:Chi2ParticleID 0.00890019 0.012234 0.0222065 0.0110863 0.00401589 10
reco:pandoracalinoxyzt:CalibrationdEdXPDSP 0.0921599 0.118533 0.161135 0.108475 0.0241114 10
reco:pandoracalipidnoxyzt:Chi2ParticleID 0.00849938 0.0118585 0.0213536 0.0106863 0.00389491 10
reco:pandoraShowercalo:ShowerCalorimetry 4.09645 8.8908 19.9681 8.41528 4.45662 10
reco:pandoraShowercalonosce:ShowerCalorimetry 3.98669 8.02086 14.2934 8.08457 3.1139 10
reco:emtrkmichelid:EmTrackMichelId 224.938 315.275 481.535 291.389 69.7481 10
reco:crttag:SingleCRTMatchingProducer 0.0162528 0.104163 0.36478 0.0406829 0.108749 10
reco:crtreco:TwoCRTMatchingProducer 0.011952 0.0192394 0.0311773 0.0195597 0.00569075 10
reco:anodepiercerst0:T0RecoAnodePiercers 1.9922 2.86285 4.26035 2.67056 0.620161 10
reco:pandora2Track:LArPandoraTrackCreation 13.8856 27.0956 58.8273 25.7887 11.8928 10
reco:pandora2calo:Calorimetry 5.76451 11.9568 28.9073 10.6414 6.15976 10
reco:pandora2calonosce:Calorimetry 5.29945 10.7611 23.3262 9.69728 4.82911 10
reco:pandora2pid:Chi2ParticleID 0.020787 0.0308878 0.0470376 0.027496 0.00870611 10
reco:pandora2calinoxyzt:CalibrationdEdXPDSP 0.10995 0.171309 0.311422 0.13753 0.0716157 10
reco:pandora2calipidnoxyzt:Chi2ParticleID 0.0213033 0.0316765 0.0687075 0.0267524 0.0140946 10
reco:pandora2Shower:LArPandoraShowerCreation 5.13902 8.63696 18.6178 7.58831 3.7664 10
reco:pandora2Showercalo:ShowerCalorimetry 5.61805 9.57915 15.933 8.85294 3.20026 10
reco:pandora2Showercalonosce:ShowerCalorimetry 5.02426 8.93235 15.9119 8.76189 3.04094 10
[art]:TriggerResults:TriggerResultInserter 6.0656e-05 7.91814e-05 0.000157193 6.88205e-05 2.7398e-05 10
end_path:out1:RootOutput 1.0401e-05 1.31721e-05 1.846e-05 1.24635e-05 2.51689e-06 10
end_path:out1:RootOutput(write) 3.19569 4.44755 7.39928 4.1044 1.23968 10
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5033.35 MB
Peak resident set size usage (VmHWM): 4223.39 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.17 sec/event
ToolBasedRawDigitPrepService:dtor: adcSampleFiller: 0.45 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleAdcToKe: 0.10 sec/event
ToolBasedRawDigitPrepService:dtor: pdspTailPedRemovalZKe: 6.56 sec/event
ToolBasedRawDigitPrepService:dtor: adcKeepAllSignalFinder: 0.27 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleKeToAdc: 0.10 sec/event
ToolBasedRawDigitPrepService:dtor: pdsp_RemoveBadChannels: 0.01 sec/event
Art has completed and will exit with status 0.
lar exit code 0
.:
total 10098968
-rw-r--r--. 1 dune000 dune 2374407657 Jan 22 00:35 detsim_stage2.root
-rw-r--r--. 1 dune000 dune 2257058636 Jan 22 00:31 detsim_stage1.root
-rw-r--r--. 1 dune000 dune 2054774402 Jan 22 02:22 reco_stage1.root
-rw-r--r--. 1 dune000 dune 1821910857 Jan 21 21:58 g4_stage2.root
-rw-r--r--. 1 dune000 dune 1759237459 Jan 21 21:38 g4_stage1.root
-rw-r--r--. 1 dune000 dune 73342630 Jan 22 02:15 Pandora_Events.pndr
-rw-r--r--. 1 dune000 dune 242737 Jan 22 02:22 jobscript.log
-rw-r--r--. 1 dune000 dune 217088 Jan 22 02:22 mem.db
-rw-r--r--. 1 dune000 dune 62376 Jan 22 02:22 Pandora_Geometry.xml
-rw-r--r--. 1 dune000 dune 36864 Jan 22 02:22 time.db
-rw-r--r--. 1 dune000 dune 519 Jan 22 00:35 detsim_single_protoDUNE_hist.root
-rw-r--r--. 1 dune000 dune 519 Jan 21 21:58 g4_protoDUNE_hist.root
-rw-r--r--. 1 dune000 dune 519 Jan 22 02:22 protoDUNE_reco1_hist.root
-rw-r--r--. 1 dune000 dune 52 Jan 21 21:23 all-input-dids.txt
-rw-r--r--. 1 dune000 dune 7 Jan 22 02:22 justin-processed-pfns.txt
-rw-r--r--. 1 dune000 dune 0 Jan 22 00:44 ProtoDUNE.log
-rw-r--r--. 1 dune000 dune 0 Jan 22 00:35 debugprod.log
