Jobsub ID 264653.0@dunegpschedd02.fnal.gov
| Jobsub ID | 264653.0@dunegpschedd02.fnal.gov |
| Workflow ID | 11375 |
| 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-28 08:49:45 |
| Site | US_UCSD |
| Entry | CMSHTPC_T2_US_UCSD_gw6 |
| Last heartbeat | 2025-12-28 12:51:25 |
| From worker node | Hostname | sdsc-52.t2.ucsd.edu |
| cpuinfo | Intel(R) Xeon(R) CPU E5-2680 v4 @ 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 | 2025-12-28 08:57:22 |
| Input files | monte-carlo-011375-000001
|
| Jobscript | Exit code | 0 |
| Real time | 3h (13989s) |
| CPU time | 3h (13609s = 97%) |
| Max RSS bytes | 4401123328 (4197 MiB) |
| Outputting started | 2025-12-28 12:50:32 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11375/1/001/reco_stage1.root
|
| Finished | 2025-12-28 12:51:25 |
| Saved logs | justin-logs:264653.0-dunegpschedd02.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
olBasedRawDigitPrepService:prepare: 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 113147 traces, 0 summary
Retagger: tagging trace set: gauss with 89646 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 89646 traces tagged "gauss"
FrameSaver: q=3.41801e+06 n=1674813 tag=gauss
wclsFrameSaver: saving 113147 traces tagged "wiener"
FrameSaver: q=3.61023e+06 n=1517453 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 32101 XUs and 38638 XVs -> 1009 XUVs
C:0 T:1 52137 XUs and 53662 XVs -> 3905 XUVs
C:0 T:2 155189 XUs and 187708 XVs -> 9980 XUVs
C:0 T:3 69653 XUs and 69871 XVs -> 769 XUVs
C:0 T:4 6635 XUs and 8263 XVs -> 43 XUVs
C:0 T:5 19745 XUs and 18212 XVs -> 1547 XUVs
C:0 T:6 97118 XUs and 134847 XVs -> 6113 XUVs
C:0 T:8 4195 XUs and 3256 XVs -> 35 XUVs
C:0 T:9 20235 XUs and 31335 XVs -> 1952 XUVs
C:0 T:10 40902 XUs and 30957 XVs -> 4325 XUVs
C:0 T:11 523 XUs and 361 XVs -> 46 XUVs
29724 XUVs total
10352 collection wire objects
27530 potential space points
Neighbour search...
2553824 tests to find 1085766 neighbours
Iterating with no regularization...
Begin: 1.06335e+08
0 8.26641e+07
1 8.08366e+07
2 8.05929e+07
3 8.05235e+07
Now with regularization...
Begin: 6.69003e+07
0 6.67931e+07
1 6.67564e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 411391104
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411391104
fLifetime: 30000 [us]
28-Dec-2025 04:50:29 PST Closed output file "reco_stage1.root"
28-Dec-2025 04:50:29 PST 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 356.438 583.878 789.274 577.558 141.871 10
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000884222 0.00356184 0.0065889 0.0038117 0.00161118 10
reco:ophit:OpHitFinder 0.264813 0.453163 0.603947 0.478392 0.116961 10
reco:opflash:OpFlashFinder 0.168771 0.269865 0.38896 0.249764 0.0679033 10
reco:opslicer:OpSlicer 0.632915 1.06228 1.55363 1.06132 0.34771 10
reco:caldata:DataPrepModule 5.71335 6.88006 8.95987 6.23045 1.26153 10
reco:wclsdatasp:WireCellToolkit 42.5029 50.959 62.7746 51.4975 5.04922 10
reco:gaushit:GausHitFinder 1.29295 1.91617 3.21271 1.72192 0.624141 10
reco:nhitsfilter:NumberOfHitsFilter 0.000570354 0.000805695 0.00111123 0.00078898 0.000176995 10
reco:reco3d:SpacePointSolver 12.0636 23.4253 36.718 21.7642 8.87828 10
reco:hitpdune:DisambigFromSpacePoints 2.17007 4.61113 7.47193 4.83439 1.78566 10
reco:pandora:StandardPandora 44.8759 74.8963 152.997 56.8133 36.4185 10
reco:pandoraWriter:StandardPandora 0.407543 0.746424 1.01928 0.725137 0.181299 10
reco:pandoraTrack:LArPandoraTrackCreation 4.21322 10.6366 18.491 9.51855 4.39058 10
reco:pandoraShower:LArPandoraShowerCreation 4.38115 10.5051 22.4227 7.83818 5.84799 10
reco:pandoracalo:Calorimetry 2.1839 4.67372 7.80267 4.40166 1.73078 10
reco:pandoracalonosce:Calorimetry 1.9956 4.44621 7.65797 3.82869 1.86985 10
reco:pandorapid:Chi2ParticleID 0.00640475 0.00999413 0.0141248 0.0105017 0.0028318 10
reco:pandoracalinoxyzt:CalibrationdEdXPDSP 0.0653083 0.1041 0.139585 0.107907 0.0273487 10
reco:pandoracalipidnoxyzt:Chi2ParticleID 0.00586311 0.0102337 0.0138444 0.0111382 0.002841 10
reco:pandoraShowercalo:ShowerCalorimetry 4.20246 8.61154 16.4786 8.04293 3.72317 10
reco:pandoraShowercalonosce:ShowerCalorimetry 3.9371 8.00786 14.0975 6.47039 3.63288 10
reco:emtrkmichelid:EmTrackMichelId 174.303 278.424 355.057 289.071 53.6898 10
reco:crttag:SingleCRTMatchingProducer 0.0187231 0.0305532 0.0414673 0.0294006 0.00709224 10
reco:crtreco:TwoCRTMatchingProducer 0.0117219 0.0194595 0.0268878 0.0207515 0.0052573 10
reco:anodepiercerst0:T0RecoAnodePiercers 1.61094 2.32607 2.99724 2.30682 0.455028 10
reco:pandora2Track:LArPandoraTrackCreation 15.6763 33.0204 53.7455 30.1969 12.7091 10
reco:pandora2calo:Calorimetry 6.60773 13.0269 22.4944 11.0345 4.90402 10
reco:pandora2calonosce:Calorimetry 5.48868 11.3981 18.2787 10.1308 4.33607 10
reco:pandora2pid:Chi2ParticleID 0.0140367 0.024231 0.0386574 0.0220748 0.0083899 10
reco:pandora2calinoxyzt:CalibrationdEdXPDSP 0.0798918 0.119727 0.180926 0.113215 0.0327885 10
reco:pandora2calipidnoxyzt:Chi2ParticleID 0.0136933 0.0237121 0.0385608 0.0214079 0.00856958 10
reco:pandora2Shower:LArPandoraShowerCreation 4.29177 9.34686 13.9064 8.51525 3.0272 10
reco:pandora2Showercalo:ShowerCalorimetry 5.13385 10.5119 15.6586 11.2053 3.28819 10
reco:pandora2Showercalonosce:ShowerCalorimetry 4.67591 9.57824 15.514 9.79729 3.46561 10
[art]:TriggerResults:TriggerResultInserter 3.7465e-05 5.77194e-05 0.000134746 4.79e-05 2.8305e-05 10
end_path:out1:RootOutput 7.334e-06 9.0515e-06 1.3714e-05 8.162e-06 2.01842e-06 10
end_path:out1:RootOutput(write) 2.41147 3.66362 5.4981 3.63838 0.932908 10
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5220.42 MB
Peak resident set size usage (VmHWM): 4401.12 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.27 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleAdcToKe: 0.06 sec/event
ToolBasedRawDigitPrepService:dtor: pdspTailPedRemovalZKe: 4.16 sec/event
ToolBasedRawDigitPrepService:dtor: adcKeepAllSignalFinder: 0.20 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 11179904
-rw-r--r--. 1 cuser cuser 2587006814 Dec 28 03:10 detsim_stage2.root
-rw-r--r--. 1 cuser cuser 2446288364 Dec 28 03:08 detsim_stage1.root
-rw-r--r--. 1 cuser cuser 2319193204 Dec 28 04:50 reco_stage1.root
-rw-r--r--. 1 cuser cuser 2055941893 Dec 28 01:22 g4_stage2.root
-rw-r--r--. 1 cuser cuser 1952929520 Dec 28 01:05 g4_stage1.root
-rw-r--r--. 1 cuser cuser 86247060 Dec 28 04:44 Pandora_Events.pndr
-rw-r--r--. 1 cuser cuser 242776 Dec 28 04:50 jobscript.log
-rw-r--r--. 1 cuser cuser 217088 Dec 28 04:50 mem.db
-rw-r--r--. 1 cuser cuser 62376 Dec 28 04:50 Pandora_Geometry.xml
-rw-r--r--. 1 cuser cuser 36864 Dec 28 04:50 time.db
-rw-r--r--. 1 cuser cuser 519 Dec 28 03:10 detsim_single_protoDUNE_hist.root
-rw-r--r--. 1 cuser cuser 519 Dec 28 01:22 g4_protoDUNE_hist.root
-rw-r--r--. 1 cuser cuser 519 Dec 28 04:50 protoDUNE_reco1_hist.root
-rw-r--r--. 1 cuser cuser 52 Dec 28 00:57 all-input-dids.txt
-rw-r--r--. 1 cuser cuser 7 Dec 28 04:50 justin-processed-pfns.txt
-rw-r--r--. 1 cuser cuser 0 Dec 28 03:16 ProtoDUNE.log
-rw-r--r--. 1 cuser cuser 0 Dec 28 03:10 debugprod.log