Jobsub ID 270450.0@dunegpschedd01.fnal.gov
| Jobsub ID | 270450.0@dunegpschedd01.fnal.gov |
| Workflow ID | 11365 |
| 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 22:55:13 |
| Site | UK_RAL-PPD |
| Entry | CMSHTPC_T2_UK_SGrid_RALPP_hep206 |
| Last heartbeat | 2025-12-28 03:18:45 |
| 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 22:58:05 |
| Input files | monte-carlo-011365-000001
|
| Jobscript | Exit code | 0 |
| Real time | 4h (15554s) |
| CPU time | 4h (14925s = 95%) |
| Max RSS bytes | 4484100096 (4276 MiB) |
| Outputting started | 2025-12-28 03:17:20 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11365/1/001/reco_stage1.root
|
| Finished | 2025-12-28 03:18:45 |
| Saved logs | justin-logs:270450.0-dunegpschedd01.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
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 158884 traces, 0 summary
Retagger: tagging trace set: gauss with 119709 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 119709 traces tagged "gauss"
FrameSaver: q=4.28816e+06 n=2158257 tag=gauss
wclsFrameSaver: saving 158884 traces tagged "wiener"
FrameSaver: q=4.54667e+06 n=1914319 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 39057 XUs and 26676 XVs -> 384 XUVs
C:0 T:1 94454 XUs and 67356 XVs -> 10005 XUVs
C:0 T:2 54789 XUs and 97982 XVs -> 2817 XUVs
C:0 T:3 29281 XUs and 45359 XVs -> 212 XUVs
C:0 T:4 19582 XUs and 17903 XVs -> 286 XUVs
C:0 T:5 122892 XUs and 79474 XVs -> 25591 XUVs
C:0 T:6 129648 XUs and 112862 XVs -> 4698 XUVs
C:0 T:7 55131 XUs and 44336 XVs -> 562 XUVs
C:0 T:8 11636 XUs and 14050 XVs -> 189 XUVs
C:0 T:9 160304 XUs and 161186 XVs -> 27855 XUVs
C:0 T:10 59762 XUs and 52067 XVs -> 6503 XUVs
C:0 T:11 112 XUs and 91 XVs -> 15 XUVs
79117 XUVs total
14139 collection wire objects
74419 potential space points
Neighbour search...
21084997 tests to find 8097814 neighbours
Iterating with no regularization...
Begin: 8.92152e+07
0 7.40072e+07
1 7.29468e+07
2 7.28003e+07
3 7.27596e+07
Now with regularization...
Begin: 6.03328e+07
0 6.02916e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 411382723
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411382723
fLifetime: 30000 [us]
28-Dec-2025 03:17:18 GMT Closed output file "reco_stage1.root"
28-Dec-2025 03:17:18 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 391.672 492.297 593.55 498.277 74.1434 10
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00109367 0.00373842 0.00643556 0.0034351 0.00177967 10
reco:ophit:OpHitFinder 0.276876 0.373244 0.470036 0.345343 0.0689722 10
reco:opflash:OpFlashFinder 0.154678 0.246071 0.294944 0.258215 0.0427066 10
reco:opslicer:OpSlicer 0.574085 0.889749 1.1421 0.931248 0.204902 10
reco:caldata:DataPrepModule 4.70126 6.42701 7.77571 6.60594 1.08766 10
reco:wclsdatasp:WireCellToolkit 37.3611 40.3072 44.743 39.9012 2.05556 10
reco:gaushit:GausHitFinder 1.05012 1.77729 2.33629 1.78897 0.35816 10
reco:nhitsfilter:NumberOfHitsFilter 0.000401236 0.00083003 0.00180319 0.00074088 0.000378606 10
reco:reco3d:SpacePointSolver 15.9381 28.3073 45.3422 26.2815 8.11339 10
reco:hitpdune:DisambigFromSpacePoints 1.08672 2.47037 3.33736 2.38215 0.623696 10
reco:pandora:StandardPandora 26.8286 56.1945 84.1074 55.5578 20.5501 10
reco:pandoraWriter:StandardPandora 0.353416 0.608971 1.03267 0.54848 0.218879 10
reco:pandoraTrack:LArPandoraTrackCreation 2.91846 5.8983 9.68015 5.38916 2.04209 10
reco:pandoraShower:LArPandoraShowerCreation 3.32135 6.72749 10.0518 6.04684 2.18409 10
reco:pandoracalo:Calorimetry 2.29012 3.41895 4.77451 3.27231 0.920115 10
reco:pandoracalonosce:Calorimetry 2.07248 3.19746 5.63078 2.67599 1.10481 10
reco:pandorapid:Chi2ParticleID 0.0051826 0.00816757 0.0127876 0.00828147 0.00227536 10
reco:pandoracalinoxyzt:CalibrationdEdXPDSP 0.0412606 0.0737006 0.100609 0.0799712 0.0204655 10
reco:pandoracalipidnoxyzt:Chi2ParticleID 0.00512526 0.00770852 0.0118485 0.00804004 0.00194856 10
reco:pandoraShowercalo:ShowerCalorimetry 3.96781 7.49067 10.7944 6.61874 2.5811 10
reco:pandoraShowercalonosce:ShowerCalorimetry 3.56546 7.06937 11.0411 6.76146 2.59863 10
reco:emtrkmichelid:EmTrackMichelId 214.263 255.618 295.282 258.506 28.0542 10
reco:crttag:SingleCRTMatchingProducer 0.014412 0.0176255 0.0215017 0.0165843 0.00259186 10
reco:crtreco:TwoCRTMatchingProducer 0.00892253 0.0120869 0.0147373 0.0121736 0.00189026 10
reco:anodepiercerst0:T0RecoAnodePiercers 0.892666 1.22989 1.43217 1.29337 0.15781 10
reco:pandora2Track:LArPandoraTrackCreation 15.85 20.2003 25.2979 20.5948 3.08612 10
reco:pandora2calo:Calorimetry 5.9928 9.89912 13.0699 9.96959 1.90876 10
reco:pandora2calonosce:Calorimetry 5.45367 8.65301 11.064 8.68679 1.58951 10
reco:pandora2pid:Chi2ParticleID 0.0111851 0.0176384 0.0291571 0.015387 0.00529475 10
reco:pandora2calinoxyzt:CalibrationdEdXPDSP 0.0541422 0.0860156 0.125137 0.0867614 0.0230987 10
reco:pandora2calipidnoxyzt:Chi2ParticleID 0.0114853 0.0178642 0.0293708 0.0168139 0.00539666 10
reco:pandora2Shower:LArPandoraShowerCreation 3.70737 6.02925 7.97676 6.2392 1.09881 10
reco:pandora2Showercalo:ShowerCalorimetry 4.9784 7.82608 10.2062 8.02758 1.55295 10
reco:pandora2Showercalonosce:ShowerCalorimetry 5.67078 7.26518 9.70608 6.86271 1.35036 10
[art]:TriggerResults:TriggerResultInserter 5.4743e-05 0.000101673 0.000182754 8.63775e-05 4.17742e-05 10
end_path:out1:RootOutput 9.317e-06 1.53057e-05 2.4406e-05 1.50485e-05 4.17158e-06 10
end_path:out1:RootOutput(write) 3.013 3.77268 4.70849 3.63393 0.493871 10
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5326.54 MB
Peak resident set size usage (VmHWM): 4484.1 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.08 sec/event
ToolBasedRawDigitPrepService:dtor: adcSampleFiller: 0.29 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleAdcToKe: 0.05 sec/event
ToolBasedRawDigitPrepService:dtor: pdspTailPedRemovalZKe: 4.13 sec/event
ToolBasedRawDigitPrepService:dtor: adcKeepAllSignalFinder: 0.17 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleKeToAdc: 0.05 sec/event
ToolBasedRawDigitPrepService:dtor: pdsp_RemoveBadChannels: 0.00 sec/event
Art has completed and will exit with status 0.
lar exit code 0
.:
total 11150472
-rw-r--r-- 1 pltdune04 pltdune 2579464695 Dec 28 01:53 detsim_stage2.root
-rw-r--r-- 1 pltdune04 pltdune 2442181292 Dec 28 01:50 detsim_stage1.root
-rw-r--r-- 1 pltdune04 pltdune 2314368050 Dec 28 03:17 reco_stage1.root
-rw-r--r-- 1 pltdune04 pltdune 2035984027 Dec 27 23:22 g4_stage2.root
-rw-r--r-- 1 pltdune04 pltdune 1958801195 Dec 27 23:06 g4_stage1.root
-rw-r--r-- 1 pltdune04 pltdune 86604780 Dec 28 03:10 Pandora_Events.pndr
-rw-r--r-- 1 pltdune04 pltdune 243082 Dec 28 03:17 jobscript.log
-rw-r--r-- 1 pltdune04 pltdune 217088 Dec 28 03:17 mem.db
-rw-r--r-- 1 pltdune04 pltdune 62376 Dec 28 03:17 Pandora_Geometry.xml
-rw-r--r-- 1 pltdune04 pltdune 36864 Dec 28 03:17 time.db
-rw-r--r-- 1 pltdune04 pltdune 519 Dec 28 01:53 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 pltdune04 pltdune 519 Dec 27 23:22 g4_protoDUNE_hist.root
-rw-r--r-- 1 pltdune04 pltdune 519 Dec 28 03:17 protoDUNE_reco1_hist.root
-rw-r--r-- 1 pltdune04 pltdune 52 Dec 27 22:58 all-input-dids.txt
-rw-r--r-- 1 pltdune04 pltdune 7 Dec 28 03:17 justin-processed-pfns.txt
-rw-r--r-- 1 pltdune04 pltdune 0 Dec 28 02:01 ProtoDUNE.log
-rw-r--r-- 1 pltdune04 pltdune 0 Dec 28 01:53 debugprod.log
