Jobsub ID 233051.1@dunegpschedd02.fnal.gov
| Jobsub ID | 233051.1@dunegpschedd02.fnal.gov |
| Workflow ID | 9354 |
| Stage ID | 1 |
| User name | pmelas@fnal.gov |
| HTCondor Group | group_dune |
| Requested | Processors | 1 |
| GPU | No |
| RSS bytes | 8388608000 (8000 MiB) |
| Wall seconds limit | 86400 (24 hours) |
| Submitted time | 2025-10-26 13:20:38 |
| Site | UK_RAL-PPD |
| Entry | CMSHTPC_T2_UK_SGrid_RALPP_hep208 |
| Last heartbeat | 2025-10-26 18:12:21 |
| From worker node | Hostname | heplnc152.pp.rl.ac.uk |
| cpuinfo | AMD EPYC 7452 32-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-10-26 13:21:23 |
| Input files | monte-carlo-009354-000001
|
| Jobscript | Exit code | 0 |
| Real time | 4h (17363s) |
| CPU time | 4h (16645s = 95%) |
| Max RSS bytes | 4479946752 (4272 MiB) |
| Outputting started | 2025-10-26 18:10:47 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/09354/1/001/reco_stage1.root
|
| Finished | 2025-10-26 18:12:21 |
| Saved logs | justin-logs:233051.1-dunegpschedd02.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
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 155012 traces, 0 summary
Retagger: tagging trace set: gauss with 114476 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 114476 traces tagged "gauss"
FrameSaver: q=4.0114e+06 n=1949939 tag=gauss
wclsFrameSaver: saving 155012 traces tagged "wiener"
FrameSaver: q=4.25782e+06 n=1699542 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 39655 XUs and 25962 XVs -> 560 XUVs
C:0 T:1 90910 XUs and 57742 XVs -> 5888 XUVs
C:0 T:2 96920 XUs and 131390 XVs -> 6355 XUVs
C:0 T:3 48240 XUs and 56243 XVs -> 740 XUVs
C:0 T:4 12636 XUs and 14125 XVs -> 135 XUVs
C:0 T:5 50830 XUs and 41477 XVs -> 3276 XUVs
C:0 T:6 122753 XUs and 75070 XVs -> 8580 XUVs
C:0 T:7 36549 XUs and 25929 XVs -> 392 XUVs
C:0 T:8 9860 XUs and 12740 XVs -> 190 XUVs
C:0 T:9 75954 XUs and 130483 XVs -> 9696 XUVs
C:0 T:10 61074 XUs and 19504 XVs -> 4605 XUVs
C:0 T:11 69 XUs and 43 XVs -> 7 XUVs
40424 XUVs total
13791 collection wire objects
37138 potential space points
Neighbour search...
3129794 tests to find 1552178 neighbours
Iterating with no regularization...
Begin: 8.71534e+07
0 6.878e+07
1 6.76061e+07
2 6.7435e+07
3 6.73824e+07
Now with regularization...
Begin: 5.51817e+07
0 5.51488e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 410127545
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 410127545
fLifetime: 30000 [us]
26-Oct-2025 18:10:44 GMT Closed output file "reco_stage1.root"
26-Oct-2025 18:10:44 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 377.405 626.829 834.691 628.38 142.265 10
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.0013937 0.00473813 0.0084441 0.00491227 0.00214673 10
reco:ophit:OpHitFinder 0.323879 0.395594 0.503215 0.393214 0.0517187 10
reco:opflash:OpFlashFinder 0.199307 0.236065 0.319454 0.223501 0.0348099 10
reco:opslicer:OpSlicer 0.722775 1.03722 1.40366 1.06474 0.177211 10
reco:caldata:DataPrepModule 6.35369 7.1226 7.863 7.11523 0.392566 10
reco:wclsdatasp:WireCellToolkit 39.0861 46.6092 50.1265 47.0867 2.84304 10
reco:gaushit:GausHitFinder 1.29204 1.90472 2.69814 1.81558 0.438059 10
reco:nhitsfilter:NumberOfHitsFilter 0.00072578 0.00096563 0.00135252 0.000923013 0.000190762 10
reco:reco3d:SpacePointSolver 9.7455 25.9849 51.5101 21.6579 12.2658 10
reco:hitpdune:DisambigFromSpacePoints 1.39193 2.64086 4.0281 2.41963 0.793072 10
reco:pandora:StandardPandora 19.9971 65.266 119.448 57.8033 29.875 10
reco:pandoraWriter:StandardPandora 0.455045 0.753342 0.916527 0.764038 0.144884 10
reco:pandoraTrack:LArPandoraTrackCreation 3.57399 8.81612 13.6551 9.11327 2.82623 10
reco:pandoraShower:LArPandoraShowerCreation 3.53055 10.7284 16.4036 10.8026 4.04196 10
reco:pandoracalo:Calorimetry 2.10529 4.7045 6.41145 4.69779 1.26218 10
reco:pandoracalonosce:Calorimetry 2.01226 4.47071 6.48557 4.41027 1.3023 10
reco:pandorapid:Chi2ParticleID 0.00766244 0.0099081 0.0122374 0.00924835 0.00165895 10
reco:pandoracalinoxyzt:CalibrationdEdXPDSP 0.0766315 0.0998716 0.125189 0.0985228 0.0128217 10
reco:pandoracalipidnoxyzt:Chi2ParticleID 0.00752145 0.00897592 0.0113063 0.00861421 0.00143512 10
reco:pandoraShowercalo:ShowerCalorimetry 3.47888 10.8349 15.8007 11.0426 3.88194 10
reco:pandoraShowercalonosce:ShowerCalorimetry 3.11634 10.6244 14.9679 11.698 3.69926 10
reco:emtrkmichelid:EmTrackMichelId 233.603 331.707 415.239 344.32 56.9751 10
reco:crttag:SingleCRTMatchingProducer 0.0166587 0.0256205 0.0361431 0.0233381 0.00559005 10
reco:crtreco:TwoCRTMatchingProducer 0.0117616 0.0182339 0.0220156 0.0187224 0.00346613 10
reco:anodepiercerst0:T0RecoAnodePiercers 0.911627 1.35038 1.61712 1.38359 0.199965 10
reco:pandora2Track:LArPandoraTrackCreation 11.5053 29.0905 42.8978 29.6963 9.30424 10
reco:pandora2calo:Calorimetry 5.58163 13.7868 19.7906 14.194 4.4195 10
reco:pandora2calonosce:Calorimetry 5.13341 13.0002 18.739 12.8522 4.19189 10
reco:pandora2pid:Chi2ParticleID 0.0153312 0.0240487 0.0333721 0.0231472 0.00584884 10
reco:pandora2calinoxyzt:CalibrationdEdXPDSP 0.0735511 0.123168 0.160066 0.121743 0.0286113 10
reco:pandora2calipidnoxyzt:Chi2ParticleID 0.0142326 0.0230322 0.0324377 0.0222683 0.00599697 10
reco:pandora2Shower:LArPandoraShowerCreation 4.22456 10.5009 14.7421 10.4134 3.42466 10
reco:pandora2Showercalo:ShowerCalorimetry 4.25277 10.9418 15.1435 12.0216 3.41412 10
reco:pandora2Showercalonosce:ShowerCalorimetry 3.30621 9.34377 13.5245 9.83135 3.09829 10
[art]:TriggerResults:TriggerResultInserter 5.3341e-05 7.99209e-05 0.000218362 6.5569e-05 4.66562e-05 10
end_path:out1:RootOutput 9.728e-06 1.20358e-05 2.133e-05 1.10915e-05 3.28135e-06 10
end_path:out1:RootOutput(write) 3.18621 4.43955 5.5268 4.53942 0.726671 10
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5304.52 MB
Peak resident set size usage (VmHWM): 4479.95 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.30 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleAdcToKe: 0.06 sec/event
ToolBasedRawDigitPrepService:dtor: pdspTailPedRemovalZKe: 4.49 sec/event
ToolBasedRawDigitPrepService:dtor: adcKeepAllSignalFinder: 0.18 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleKeToAdc: 0.07 sec/event
ToolBasedRawDigitPrepService:dtor: pdsp_RemoveBadChannels: 0.01 sec/event
Art has completed and will exit with status 0.
lar exit code 0
.:
total 11039028
-rw-r--r-- 1 pltdune04 pltdune 2565953599 Oct 26 16:23 detsim_stage2.root
-rw-r--r-- 1 pltdune04 pltdune 2435062015 Oct 26 16:20 detsim_stage1.root
-rw-r--r-- 1 pltdune04 pltdune 2301961289 Oct 26 18:10 reco_stage1.root
-rw-r--r-- 1 pltdune04 pltdune 2003494433 Oct 26 13:46 g4_stage2.root
-rw-r--r-- 1 pltdune04 pltdune 1910385696 Oct 26 13:28 g4_stage1.root
-rw-r--r-- 1 pltdune04 pltdune 86479050 Oct 26 18:02 Pandora_Events.pndr
-rw-r--r-- 1 pltdune04 pltdune 242769 Oct 26 18:10 jobscript.log
-rw-r--r-- 1 pltdune04 pltdune 217088 Oct 26 18:10 mem.db
-rw-r--r-- 1 pltdune04 pltdune 62376 Oct 26 18:10 Pandora_Geometry.xml
-rw-r--r-- 1 pltdune04 pltdune 36864 Oct 26 18:10 time.db
-rw-r--r-- 1 pltdune04 pltdune 519 Oct 26 16:23 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 pltdune04 pltdune 519 Oct 26 13:46 g4_protoDUNE_hist.root
-rw-r--r-- 1 pltdune04 pltdune 519 Oct 26 18:10 protoDUNE_reco1_hist.root
-rw-r--r-- 1 pltdune04 pltdune 52 Oct 26 13:21 all-input-dids.txt
-rw-r--r-- 1 pltdune04 pltdune 7 Oct 26 18:10 justin-processed-pfns.txt
-rw-r--r-- 1 pltdune04 pltdune 0 Oct 26 16:33 ProtoDUNE.log
-rw-r--r-- 1 pltdune04 pltdune 0 Oct 26 16:23 debugprod.log
