justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 271089.1@dunegpschedd01.fnal.gov

Jobsub ID271089.1@dunegpschedd01.fnal.gov
Workflow ID11441
Stage ID1
User namepmelas@fnal.gov
RequestedProcessors1
GPUNo
RSS bytes8388608000 (8000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2025-12-31 16:14:03
SiteUK_RAL-PPD
EntryCMSHTPC_T2_UK_SGrid_RALPP_hep206
Last heartbeat2025-12-31 19:34:31
From worker nodeHostnameheplnc157.pp.rl.ac.uk
cpuinfoAMD EPYC 7763 64-Core Processor
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes10485760000 (10000 MiB)
Wall seconds limit257400 (71 hours)
GPU
Inner Apptainer?True
Job statefinished
Started2025-12-31 16:29:26
Input filesmonte-carlo-011441-000001
JobscriptExit code0
Real time3h (11021s)
CPU time2h (10601s = 96%)
Max RSS bytes4090118144 (3900 MiB)
Outputting started2025-12-31 19:33:07
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11441/1/001/reco_stage1.root
Finished2025-12-31 19:34:31
Saved logsjustin-logs:271089.1-dunegpschedd01.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 122141 traces, 0 summary
Retagger: tagging trace set: gauss with 95575 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 95575 traces tagged "gauss"
FrameSaver: q=3.27667e+06 n=1668277 tag=gauss
wclsFrameSaver: saving 122141 traces tagged "wiener"
FrameSaver: q=3.47164e+06 n=1484856 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 32276 XUs and 22698 XVs -> 309 XUVs
C:0 T:1 56365 XUs and 46370 XVs -> 4069 XUVs
C:0 T:2 157977 XUs and 160559 XVs -> 5926 XUVs
C:0 T:3 74021 XUs and 69083 XVs -> 498 XUVs
C:0 T:4 11715 XUs and 9477 XVs -> 152 XUVs
C:0 T:5 36877 XUs and 25635 XVs -> 3638 XUVs
C:0 T:6 92640 XUs and 53449 XVs -> 4268 XUVs
C:0 T:7 23250 XUs and 19797 XVs -> 120 XUVs
C:0 T:8 5951 XUs and 7675 XVs -> 180 XUVs
C:0 T:9 40441 XUs and 58762 XVs -> 3166 XUVs
C:0 T:10 26142 XUs and 37845 XVs -> 3739 XUVs
C:0 T:11 260 XUs and 212 XVs -> 36 XUVs
26101 XUVs total
10261 collection wire objects
23980 potential space points
Neighbour search...
1060322 tests to find 560536 neighbours
Iterating with no regularization...
Begin: 7.3865e+07
0 5.9295e+07
1 5.83458e+07
2 5.82208e+07
3 5.81823e+07
Now with regularization...
Begin: 4.88963e+07
0 4.88669e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 411457716
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411457716
fLifetime: 30000 [us]
31-Dec-2025 19:33:06 GMT  Closed output file "reco_stage1.root"
31-Dec-2025 19:33:06 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                                          225.459       319.701       420.878       324.308       48.7621        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.00137945    0.00386609    0.00679605    0.00395537    0.00157646       10     
reco:ophit:OpHitFinder                             0.214957      0.299679      0.393507      0.283372      0.0595153       10     
reco:opflash:OpFlashFinder                         0.111286      0.172112      0.212929       0.1729       0.0283576       10     
reco:opslicer:OpSlicer                             0.436137      0.670377      0.967046      0.632589       0.19007        10     
reco:caldata:DataPrepModule                         4.34674       5.31505       7.50253       4.68599       1.18839        10     
reco:wclsdatasp:WireCellToolkit                     28.8311       33.9829       41.3067       32.2206       4.01844        10     
reco:gaushit:GausHitFinder                         0.727653       1.1269        1.92732      0.978074       0.35931        10     
reco:nhitsfilter:NumberOfHitsFilter               0.000357902   0.000572387   0.00104728    0.000533202   0.000197774      10     
reco:reco3d:SpacePointSolver                        7.11948       14.3942       25.3922       12.8812       5.21469        10     
reco:hitpdune:DisambigFromSpacePoints              0.994771       1.42756       2.13872       1.33688      0.381331        10     
reco:pandora:StandardPandora                        15.2214       27.3254       45.2047       26.6325       8.24804        10     
reco:pandoraWriter:StandardPandora                 0.267042      0.407917      0.782613      0.369259       0.13801        10     
reco:pandoraTrack:LArPandoraTrackCreation           1.97295       3.19713       5.10181       3.20418      0.873499        10     
reco:pandoraShower:LArPandoraShowerCreation         1.51911       3.38626       5.51663       3.31199       1.10371        10     
reco:pandoracalo:Calorimetry                        1.23927       1.80027       2.60595       1.7235        0.36876        10     
reco:pandoracalonosce:Calorimetry                   1.02625       1.60279       2.21726       1.58792       0.29576        10     
reco:pandorapid:Chi2ParticleID                    0.00400343    0.00477998    0.00656002    0.00443041    0.00087393       10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0311968     0.0407479     0.0533147     0.0406236    0.00577603       10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00409767    0.00463539    0.00672572    0.00431896    0.000745499      10     
reco:pandoraShowercalo:ShowerCalorimetry            1.4012        3.76423       5.94467       3.88881       1.22449        10     
reco:pandoraShowercalonosce:ShowerCalorimetry       1.37534       3.6453        4.80891       4.00883       1.09854        10     
reco:emtrkmichelid:EmTrackMichelId                  126.592       175.652       223.83        177.587       25.1897        10     
reco:crttag:SingleCRTMatchingProducer              0.0106662     0.015913      0.0202825     0.0158577    0.00293465       10     
reco:crtreco:TwoCRTMatchingProducer                0.0062913    0.00958824     0.0136914    0.00981897    0.00199454       10     
reco:anodepiercerst0:T0RecoAnodePiercers           0.684402      0.936446       1.19099      0.926465      0.179423        10     
reco:pandora2Track:LArPandoraTrackCreation          7.41397       11.5126       14.1553       11.6242       2.15126        10     
reco:pandora2calo:Calorimetry                       3.69218       6.3008        9.57954       6.2904        1.69079        10     
reco:pandora2calonosce:Calorimetry                  3.0709        5.56329       7.64626       5.67898       1.48168        10     
reco:pandora2pid:Chi2ParticleID                   0.00824828     0.0120961     0.0195296     0.0108367    0.00367218       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0419554     0.0606443     0.0982443     0.0550484     0.0175881       10     
reco:pandora2calipidnoxyzt:Chi2ParticleID         0.00817433     0.0120889     0.0199547     0.0109385    0.00364516       10     
reco:pandora2Shower:LArPandoraShowerCreation        2.16217       3.90623       5.7757        3.80994       1.0452         10     
reco:pandora2Showercalo:ShowerCalorimetry           2.68371       5.2658        7.88004       5.15085       1.62116        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      2.10776       4.8965        7.68596       4.71237       1.5428         10     
[art]:TriggerResults:TriggerResultInserter        4.9212e-05    7.64346e-05   0.000176792   5.71775e-05   4.11243e-05      10     
end_path:out1:RootOutput                           7.915e-06    1.21136e-05   2.0689e-05    1.09605e-05   3.2202e-06       10     
end_path:out1:RootOutput(write)                     2.20408       2.85291       4.13317       2.60735      0.616068        10     
====================================================================================================================================

====================================================================================================
MemoryTracker summary (base-10 MB units used)

  Peak virtual memory usage (VmPeak)  : 4937.21 MB
  Peak resident set size usage (VmHWM): 4090.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.06 sec/event
ToolBasedRawDigitPrepService:dtor:                adcSampleFiller:   0.24 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.04 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   3.32 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 9753500
-rw-r--r-- 1 pltdune04 pltdune 2302900204 Dec 31 18:38 detsim_stage2.root
-rw-r--r-- 1 pltdune04 pltdune 2185085546 Dec 31 18:35 detsim_stage1.root
-rw-r--r-- 1 pltdune04 pltdune 1981149527 Dec 31 19:33 reco_stage1.root
-rw-r--r-- 1 pltdune04 pltdune 1758354626 Dec 31 16:47 g4_stage2.root
-rw-r--r-- 1 pltdune04 pltdune 1685943792 Dec 31 16:35 g4_stage1.root
-rw-r--r-- 1 pltdune04 pltdune   73531610 Dec 31 19:29 Pandora_Events.pndr
-rw-r--r-- 1 pltdune04 pltdune     242856 Dec 31 19:33 jobscript.log
-rw-r--r-- 1 pltdune04 pltdune     217088 Dec 31 19:33 mem.db
-rw-r--r-- 1 pltdune04 pltdune      62376 Dec 31 19:33 Pandora_Geometry.xml
-rw-r--r-- 1 pltdune04 pltdune      36864 Dec 31 19:33 time.db
-rw-r--r-- 1 pltdune04 pltdune        519 Dec 31 18:38 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 pltdune04 pltdune        519 Dec 31 16:47 g4_protoDUNE_hist.root
-rw-r--r-- 1 pltdune04 pltdune        519 Dec 31 19:33 protoDUNE_reco1_hist.root
-rw-r--r-- 1 pltdune04 pltdune         52 Dec 31 16:29 all-input-dids.txt
-rw-r--r-- 1 pltdune04 pltdune          7 Dec 31 19:33 justin-processed-pfns.txt
-rw-r--r-- 1 pltdune04 pltdune          0 Dec 31 18:43 ProtoDUNE.log
-rw-r--r-- 1 pltdune04 pltdune          0 Dec 31 18:38 debugprod.log
justIN time: 2026-02-06 23:33:10 UTC       justIN version: 01.06.00