Jobsub ID 264622.1@dunegpschedd02.fnal.gov
| Jobsub ID | 264622.1@dunegpschedd02.fnal.gov |
| Workflow ID | 11367 |
| 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:14 |
| Site | UK_RAL-PPD |
| Entry | CMSHTPC_T2_UK_SGrid_RALPP_hep208 |
| Last heartbeat | 2025-12-28 02:40:04 |
| From worker node | Hostname | heplnc155.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 23:04:43 |
| Input files | monte-carlo-011367-000001
|
| Jobscript | Exit code | 0 |
| Real time | 3h (12832s) |
| CPU time | 3h (12331s = 96%) |
| Max RSS bytes | 4412059648 (4207 MiB) |
| Outputting started | 2025-12-28 02:38:36 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11367/1/001/reco_stage1.root
|
| Finished | 2025-12-28 02:40:04 |
| Saved logs | justin-logs:264622.1-dunegpschedd02.fnal.gov.logs.tgz |
| List job events Cached HTCondor job logs |
Jobscript log (last 10,000 characters)
Adc
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 156140 traces, 0 summary
Retagger: tagging trace set: gauss with 118647 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 118647 traces tagged "gauss"
FrameSaver: q=4.26313e+06 n=2136866 tag=gauss
wclsFrameSaver: saving 156140 traces tagged "wiener"
FrameSaver: q=4.52749e+06 n=1899498 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 46979 XUs and 37317 XVs -> 606 XUVs
C:0 T:1 129043 XUs and 93513 XVs -> 8074 XUVs
C:0 T:2 46982 XUs and 78882 XVs -> 4484 XUVs
C:0 T:3 26684 XUs and 29932 XVs -> 242 XUVs
C:0 T:4 18950 XUs and 20909 XVs -> 197 XUVs
C:0 T:5 124918 XUs and 88680 XVs -> 11613 XUVs
C:0 T:6 89571 XUs and 103655 XVs -> 3123 XUVs
C:0 T:7 39836 XUs and 45238 XVs -> 350 XUVs
C:0 T:8 13838 XUs and 13277 XVs -> 325 XUVs
C:0 T:9 125040 XUs and 146663 XVs -> 14713 XUVs
C:0 T:10 30817 XUs and 19934 XVs -> 2679 XUVs
C:0 T:11 371 XUs and 276 XVs -> 33 XUVs
46439 XUVs total
15035 collection wire objects
42818 potential space points
Neighbour search...
3915486 tests to find 1903738 neighbours
Iterating with no regularization...
Begin: 9.17996e+07
0 6.70694e+07
1 6.55804e+07
2 6.53173e+07
3 6.52299e+07
4 6.5188e+07
Now with regularization...
Begin: 5.27549e+07
0 5.27059e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 411382701
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411382701
fLifetime: 30000 [us]
28-Dec-2025 02:38:33 GMT Closed output file "reco_stage1.root"
28-Dec-2025 02:38:33 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 303.986 406.42 596.521 398.864 80.3253 10
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00119119 0.00426209 0.00730441 0.00425241 0.0020391 10
reco:ophit:OpHitFinder 0.247264 0.345934 0.472787 0.342073 0.0737591 10
reco:opflash:OpFlashFinder 0.162214 0.229748 0.293827 0.229518 0.041489 10
reco:opslicer:OpSlicer 0.478706 0.763684 1.27587 0.689931 0.237689 10
reco:caldata:DataPrepModule 4.50313 5.3263 7.4903 4.78863 0.955629 10
reco:wclsdatasp:WireCellToolkit 31.7669 34.0155 41.4193 32.4239 2.84485 10
reco:gaushit:GausHitFinder 0.856047 1.18249 1.58828 1.17065 0.232605 10
reco:nhitsfilter:NumberOfHitsFilter 0.00040611 0.000558289 0.000884385 0.000571961 0.000137407 10
reco:reco3d:SpacePointSolver 10.1814 16.9805 27.4554 16.0133 4.77193 10
reco:hitpdune:DisambigFromSpacePoints 1.02137 1.91997 3.43096 1.77589 0.775455 10
reco:pandora:StandardPandora 18.2474 43.2217 75.3692 49.5891 17.415 10
reco:pandoraWriter:StandardPandora 0.334365 0.49412 0.738035 0.453776 0.135658 10
reco:pandoraTrack:LArPandoraTrackCreation 2.4266 4.52199 6.75512 4.59429 1.24385 10
reco:pandoraShower:LArPandoraShowerCreation 2.54612 5.44036 11.0663 4.67893 2.49458 10
reco:pandoracalo:Calorimetry 1.43585 2.63065 3.81509 2.62849 0.676485 10
reco:pandoracalonosce:Calorimetry 1.26936 2.59557 3.95685 2.68634 0.739051 10
reco:pandorapid:Chi2ParticleID 0.00388779 0.00736707 0.0107133 0.00751269 0.00214106 10
reco:pandoracalinoxyzt:CalibrationdEdXPDSP 0.0407071 0.0686789 0.103976 0.0676843 0.0182909 10
reco:pandoracalipidnoxyzt:Chi2ParticleID 0.00394492 0.00714998 0.00938581 0.00779353 0.00172507 10
reco:pandoraShowercalo:ShowerCalorimetry 2.69321 5.49323 8.97536 5.60661 1.88794 10
reco:pandoraShowercalonosce:ShowerCalorimetry 2.59789 5.31037 8.58001 5.03581 1.82129 10
reco:emtrkmichelid:EmTrackMichelId 175.266 221.043 318.27 215.05 38.6161 10
reco:crttag:SingleCRTMatchingProducer 0.0133902 0.0188284 0.0325007 0.0174059 0.00564934 10
reco:crtreco:TwoCRTMatchingProducer 0.00817218 0.0113906 0.0153908 0.0113689 0.00215748 10
reco:anodepiercerst0:T0RecoAnodePiercers 0.77224 1.06154 1.39623 1.13152 0.185117 10
reco:pandora2Track:LArPandoraTrackCreation 10.5719 16.3905 27.6785 15.1959 5.03968 10
reco:pandora2calo:Calorimetry 5.74152 7.95233 11.6518 7.34963 2.07693 10
reco:pandora2calonosce:Calorimetry 5.12048 7.41467 10.5987 6.64589 2.06781 10
reco:pandora2pid:Chi2ParticleID 0.0102406 0.0177752 0.0278216 0.0169207 0.00596597 10
reco:pandora2calinoxyzt:CalibrationdEdXPDSP 0.0492412 0.0904039 0.132513 0.0963762 0.0256397 10
reco:pandora2calipidnoxyzt:Chi2ParticleID 0.0102622 0.0184568 0.0245699 0.0178817 0.00487376 10
reco:pandora2Shower:LArPandoraShowerCreation 3.31975 5.69808 9.73474 5.16681 1.86242 10
reco:pandora2Showercalo:ShowerCalorimetry 4.24707 6.60048 9.81614 5.88287 1.90896 10
reco:pandora2Showercalonosce:ShowerCalorimetry 3.79281 6.05238 8.20515 5.81865 1.50008 10
[art]:TriggerResults:TriggerResultInserter 5.0124e-05 8.44069e-05 0.000190607 7.31115e-05 3.84851e-05 10
end_path:out1:RootOutput 1.0309e-05 1.45401e-05 2.5227e-05 1.40565e-05 4.31148e-06 10
end_path:out1:RootOutput(write) 2.36844 3.35285 4.42196 3.35009 0.585739 10
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5266.97 MB
Peak resident set size usage (VmHWM): 4412.06 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.07 sec/event
ToolBasedRawDigitPrepService:dtor: adcSampleFiller: 0.24 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleAdcToKe: 0.04 sec/event
ToolBasedRawDigitPrepService:dtor: pdspTailPedRemovalZKe: 3.31 sec/event
ToolBasedRawDigitPrepService:dtor: adcKeepAllSignalFinder: 0.13 sec/event
ToolBasedRawDigitPrepService:dtor: adcScaleKeToAdc: 0.04 sec/event
ToolBasedRawDigitPrepService:dtor: pdsp_RemoveBadChannels: 0.00 sec/event
Art has completed and will exit with status 0.
lar exit code 0
.:
total 10775168
-rw-r--r-- 1 pltdune04 pltdune 2512913801 Dec 28 01:28 detsim_stage2.root
-rw-r--r-- 1 pltdune04 pltdune 2378799265 Dec 28 01:26 detsim_stage1.root
-rw-r--r-- 1 pltdune04 pltdune 2227051621 Dec 28 02:38 reco_stage1.root
-rw-r--r-- 1 pltdune04 pltdune 1956529791 Dec 27 23:23 g4_stage2.root
-rw-r--r-- 1 pltdune04 pltdune 1875782061 Dec 27 23:11 g4_stage1.root
-rw-r--r-- 1 pltdune04 pltdune 82081580 Dec 28 02:32 Pandora_Events.pndr
-rw-r--r-- 1 pltdune04 pltdune 243331 Dec 28 02:38 jobscript.log
-rw-r--r-- 1 pltdune04 pltdune 217088 Dec 28 02:38 mem.db
-rw-r--r-- 1 pltdune04 pltdune 62376 Dec 28 02:38 Pandora_Geometry.xml
-rw-r--r-- 1 pltdune04 pltdune 36864 Dec 28 02:38 time.db
-rw-r--r-- 1 pltdune04 pltdune 519 Dec 28 01:28 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 pltdune04 pltdune 519 Dec 27 23:23 g4_protoDUNE_hist.root
-rw-r--r-- 1 pltdune04 pltdune 519 Dec 28 02:38 protoDUNE_reco1_hist.root
-rw-r--r-- 1 pltdune04 pltdune 52 Dec 27 23:04 all-input-dids.txt
-rw-r--r-- 1 pltdune04 pltdune 7 Dec 28 02:38 justin-processed-pfns.txt
-rw-r--r-- 1 pltdune04 pltdune 0 Dec 28 01:35 ProtoDUNE.log
-rw-r--r-- 1 pltdune04 pltdune 0 Dec 28 01:28 debugprod.log
