Jobsub ID 270366.0@dunegpschedd01.fnal.gov
| Jobsub ID | 270366.0@dunegpschedd01.fnal.gov |
| Workflow ID | 11354 |
| 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-27 10:06:34 |
| Site | UK_RAL-PPD |
| Entry | CMSHTPC_T2_UK_SGrid_RALPP_hep206 |
| Last heartbeat | 2025-12-27 14:31:42 |
| From worker node | Hostname | heplnc159.pp.rl.ac.uk |
| cpuinfo | AMD EPYC 7763 64-Core Processor |
| OS release | Scientific Linux release 7.9 (Nitrogen) |
| Processors | 1 |
| RSS bytes | 10485760000 (10000 MiB) |
| Wall seconds limit | 257400 (71 hours) |
| GPU | |
| Inner Apptainer? | True |
| Job state | finished |
| Started | 2025-12-27 10:08:05 |
| Input files | monte-carlo-011354-000001
|
| Jobscript | Exit code | 0 |
| Real time | 4h (15729s) |
| CPU time | 4h (15035s = 95%) |
| Max RSS bytes | 4378669056 (4175 MiB) |
| Outputting started | 2025-12-27 14:30:15 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11354/1/001/reco_stage1.root
|
| Finished | 2025-12-27 14:31:42 |
| Saved logs | justin-logs:270366.0-dunegpschedd01.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
oAdc
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 156082 traces, 0 summary
Retagger: tagging trace set: gauss with 116020 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 116020 traces tagged "gauss"
FrameSaver: q=3.96903e+06 n=2044257 tag=gauss
wclsFrameSaver: saving 156082 traces tagged "wiener"
FrameSaver: q=4.23184e+06 n=1799262 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 50971 XUs and 58657 XVs -> 1017 XUVs
C:0 T:1 123270 XUs and 138840 XVs -> 12319 XUVs
C:0 T:2 166295 XUs and 171558 XVs -> 9686 XUVs
C:0 T:3 76787 XUs and 62165 XVs -> 1437 XUVs
C:0 T:4 9608 XUs and 12239 XVs -> 137 XUVs
C:0 T:5 53517 XUs and 55072 XVs -> 5926 XUVs
C:0 T:6 93763 XUs and 148871 XVs -> 9099 XUVs
C:0 T:7 33561 XUs and 41852 XVs -> 496 XUVs
C:0 T:8 8089 XUs and 8126 XVs -> 132 XUVs
C:0 T:9 60361 XUs and 83274 XVs -> 8719 XUVs
C:0 T:10 29766 XUs and 89057 XVs -> 6525 XUVs
C:0 T:11 151 XUs and 170 XVs -> 19 XUVs
55512 XUVs total
15325 collection wire objects
49476 potential space points
Neighbour search...
4991748 tests to find 2528678 neighbours
Iterating with no regularization...
Begin: 7.89641e+07
0 6.09789e+07
1 5.96989e+07
2 5.95045e+07
3 5.94459e+07
Now with regularization...
Begin: 4.88463e+07
0 4.87718e+07
1 4.87253e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 411372091
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411372091
fLifetime: 30000 [us]
27-Dec-2025 14:30:12 GMT Closed output file "reco_stage1.root"
27-Dec-2025 14:30:12 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 376.457 474.516 583.39 460.863 60.1531 10
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00128389 0.00442648 0.00703288 0.00505913 0.00181274 10
reco:ophit:OpHitFinder 0.284145 0.429143 0.51583 0.433537 0.0676337 10
reco:opflash:OpFlashFinder 0.194743 0.258491 0.322048 0.258546 0.0423954 10
reco:opslicer:OpSlicer 0.616828 0.921744 1.21999 0.968524 0.198158 10
reco:caldata:DataPrepModule 6.37217 7.50884 8.51852 7.62137 0.668309 10
reco:wclsdatasp:WireCellToolkit 33.7191 41.1462 45.2893 41.9823 3.25311 10
reco:gaushit:GausHitFinder 1.07994 1.71107 2.18804 1.76982 0.342603 10
reco:nhitsfilter:NumberOfHitsFilter 0.000465396 0.000732491 0.000989182 0.000739156 0.000127541 10
reco:reco3d:SpacePointSolver 13.1017 23.8579 30.2554 23.8329 4.76014 10
reco:hitpdune:DisambigFromSpacePoints 1.53319 2.36321 3.55496 2.24759 0.680023 10
reco:pandora:StandardPandora 29.7614 48.6873 61.3447 51.2815 11.0495 10
reco:pandoraWriter:StandardPandora 0.472342 0.663971 0.789366 0.668578 0.0893601 10
reco:pandoraTrack:LArPandoraTrackCreation 3.31344 6.15605 7.97664 6.58141 1.22031 10
reco:pandoraShower:LArPandoraShowerCreation 4.28458 6.86407 8.96225 6.98251 1.59917 10
reco:pandoracalo:Calorimetry 2.09172 3.67112 4.50047 3.94084 0.81304 10
reco:pandoracalonosce:Calorimetry 1.84985 3.49608 4.26359 3.82343 0.810466 10
reco:pandorapid:Chi2ParticleID 0.00496299 0.00886295 0.0123332 0.00944646 0.00218153 10
reco:pandoracalinoxyzt:CalibrationdEdXPDSP 0.0521539 0.0860578 0.11583 0.0878924 0.0184266 10
reco:pandoracalipidnoxyzt:Chi2ParticleID 0.00523204 0.00883555 0.0107221 0.00903692 0.00150782 10
reco:pandoraShowercalo:ShowerCalorimetry 3.95827 7.04133 10.1423 6.7269 2.05582 10
reco:pandoraShowercalonosce:ShowerCalorimetry 3.54182 6.69204 9.23198 6.72031 1.82367 10
reco:emtrkmichelid:EmTrackMichelId 218.037 249.613 306.3 245.597 28.266 10
reco:crttag:SingleCRTMatchingProducer 0.0157162 0.0219613 0.0281252 0.0227747 0.00380369 10
reco:crtreco:TwoCRTMatchingProducer 0.00998745 0.0129428 0.0146031 0.0135276 0.00147332 10
reco:anodepiercerst0:T0RecoAnodePiercers 0.925867 1.18787 1.6121 1.10736 0.22282 10
reco:pandora2Track:LArPandoraTrackCreation 13.6546 18.2338 26.1182 17.3636 4.21827 10
reco:pandora2calo:Calorimetry 7.10794 9.51251 12.4527 8.73824 2.11606 10
reco:pandora2calonosce:Calorimetry 6.73002 8.83231 11.0431 8.59071 1.48074 10
reco:pandora2pid:Chi2ParticleID 0.0117289 0.0181791 0.0258204 0.0182073 0.004704 10
reco:pandora2calinoxyzt:CalibrationdEdXPDSP 0.0553192 0.0920444 0.128731 0.0999757 0.0217284 10
reco:pandora2calipidnoxyzt:Chi2ParticleID 0.0117433 0.0174465 0.0241394 0.0177916 0.00462282 10
reco:pandora2Shower:LArPandoraShowerCreation 4.51595 6.35741 8.86044 6.12946 1.33781 10
reco:pandora2Showercalo:ShowerCalorimetry 6.15069 8.1667 10.7162 7.51313 1.61464 10
reco:pandora2Showercalonosce:ShowerCalorimetry 4.97665 6.97916 9.61261 6.58851 1.58635 10
[art]:TriggerResults:TriggerResultInserter 5.3301e-05 8.75217e-05 0.000156665 8.74345e-05 2.83539e-05 10
end_path:out1:RootOutput 9.117e-06 1.30747e-05 1.6131e-05 1.40565e-05 2.39529e-06 10
end_path:out1:RootOutput(write) 2.66468 3.7307 4.76429 3.81189 0.717584 10
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5241.45 MB
Peak resident set size usage (VmHWM): 4378.67 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.09 sec/event
ToolBasedRawDigitPrepService:dtor: adcSampleFiller: 0.35 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleAdcToKe: 0.06 sec/event
ToolBasedRawDigitPrepService:dtor: pdspTailPedRemovalZKe: 4.75 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 11171408
-rw-r--r-- 1 pltdune04 pltdune 2578445787 Dec 27 13:08 detsim_stage2.root
-rw-r--r-- 1 pltdune04 pltdune 2446966458 Dec 27 13:05 detsim_stage1.root
-rw-r--r-- 1 pltdune04 pltdune 2302044036 Dec 27 14:30 reco_stage1.root
-rw-r--r-- 1 pltdune04 pltdune 2052805061 Dec 27 10:32 g4_stage2.root
-rw-r--r-- 1 pltdune04 pltdune 1974551124 Dec 27 10:16 g4_stage1.root
-rw-r--r-- 1 pltdune04 pltdune 84094910 Dec 27 14:24 Pandora_Events.pndr
-rw-r--r-- 1 pltdune04 pltdune 242887 Dec 27 14:30 jobscript.log
-rw-r--r-- 1 pltdune04 pltdune 217088 Dec 27 14:30 mem.db
-rw-r--r-- 1 pltdune04 pltdune 62376 Dec 27 14:30 Pandora_Geometry.xml
-rw-r--r-- 1 pltdune04 pltdune 36864 Dec 27 14:30 time.db
-rw-r--r-- 1 pltdune04 pltdune 519 Dec 27 13:08 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 pltdune04 pltdune 519 Dec 27 10:32 g4_protoDUNE_hist.root
-rw-r--r-- 1 pltdune04 pltdune 519 Dec 27 14:30 protoDUNE_reco1_hist.root
-rw-r--r-- 1 pltdune04 pltdune 52 Dec 27 10:08 all-input-dids.txt
-rw-r--r-- 1 pltdune04 pltdune 7 Dec 27 14:30 justin-processed-pfns.txt
-rw-r--r-- 1 pltdune04 pltdune 0 Dec 27 13:17 ProtoDUNE.log
-rw-r--r-- 1 pltdune04 pltdune 0 Dec 27 13:08 debugprod.log
