justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 13272.1@dunegpschedd02.fnal.gov

Jobsub ID13272.1@dunegpschedd02.fnal.gov
Workflow ID175
Stage ID1
User namepmelas@fnal.gov
HTCondor Groupgroup_dune
RequestedProcessors1
GPUNo
RSS bytes8388608000 (8000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2025-07-31 11:04:47
SiteUK_Lancaster
EntryUBoone_UK_Lancaster_HEC_grendel_ce02
Last heartbeat2025-07-31 14:06:57
From worker nodeHostnamecomp22-03
cpuinfoIntel(R) Xeon(R) Gold 6248 CPU @ 2.50GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes10485760000 (10000 MiB)
Wall seconds limit257400 (71 hours)
GPU
Inner Apptainer?True
Job statefinished
Started2025-07-31 11:06:37
Input filesmonte-carlo-000175-000001
JobscriptExit code0
Real time2h (9055s)
CPU time2h (8781s = 96%)
Max RSS bytes4221149184 (4025 MiB)
Outputting started2025-07-31 13:37:33
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/00175/1/001/reco_stage1.root
Finished2025-07-31 14:06:57
Saved logsjustin-logs:13272.1-dunegpschedd02.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

oolBasedRawDigitPrepService: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 121530 traces, 0 summary
Retagger: tagging trace set: gauss with 95042 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 95042 traces tagged "gauss"
FrameSaver: q=3.29311e+06 n=1738281 tag=gauss
wclsFrameSaver: saving 121530 traces tagged "wiener"
FrameSaver: q=3.4747e+06 n=1551569 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 40193 XUs and 42142 XVs -> 384 XUVs
C:0 T:1 80175 XUs and 75198 XVs -> 4045 XUVs
C:0 T:2 77392 XUs and 113367 XVs -> 3279 XUVs
C:0 T:3 41941 XUs and 53074 XVs -> 217 XUVs
C:0 T:4 6059 XUs and 9752 XVs -> 110 XUVs
C:0 T:5 23687 XUs and 27626 XVs -> 2080 XUVs
C:0 T:6 55028 XUs and 41688 XVs -> 1623 XUVs
C:0 T:7 25943 XUs and 16977 XVs -> 142 XUVs
C:0 T:8 10551 XUs and 11448 XVs -> 208 XUVs
C:0 T:9 73499 XUs and 130294 XVs -> 11080 XUVs
C:0 T:10 42977 XUs and 32103 XVs -> 3809 XUVs
C:0 T:11 192 XUs and 117 XVs -> 22 XUVs
26999 XUVs total
11676 collection wire objects
24908 potential space points
Neighbour search...
2191878 tests to find 931868 neighbours
Iterating with no regularization...
Begin: 7.06272e+07
0 5.42067e+07
1 5.30687e+07
2 5.29235e+07
3 5.28922e+07
Now with regularization...
Begin: 4.29663e+07
0 4.29104e+07
1 4.2888e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 408352918
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 408352918
fLifetime: 30000 [us]
31-Jul-2025 14:37:30 BST  Closed output file "reco_stage1.root"
31-Jul-2025 14:37:30 BST  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                                          295.963       372.124       522.422       365.406       62.0002        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.000881539   0.00293789    0.00436973    0.00309279    0.00102165       10     
reco:ophit:OpHitFinder                             0.184182      0.222987       0.25235      0.223128      0.0175847       10     
reco:opflash:OpFlashFinder                         0.111198      0.162435       0.21221      0.160745      0.0276306       10     
reco:opslicer:OpSlicer                             0.467814      0.535026      0.640603      0.535098      0.0453546       10     
reco:caldata:DataPrepModule                         4.75638       4.98807       5.15624       4.99658      0.103329        10     
reco:wclsdatasp:WireCellToolkit                     44.5772       46.7981       50.3907       46.3137       1.6886         10     
reco:gaushit:GausHitFinder                         0.970198       1.15761       1.41659       1.09828      0.137396        10     
reco:nhitsfilter:NumberOfHitsFilter               0.000579057   0.000691082   0.000866823    0.0006858    9.12724e-05      10     
reco:reco3d:SpacePointSolver                        7.70385       13.159        28.0259       10.222        6.16445        10     
reco:hitpdune:DisambigFromSpacePoints               1.2417        1.73012       2.56109       1.77065       0.34248        10     
reco:pandora:StandardPandora                        23.7091       36.6722       65.1991       31.309        13.9503        10     
reco:pandoraWriter:StandardPandora                 0.376722      0.435712       0.55433      0.424501      0.0484042       10     
reco:pandoraTrack:LArPandoraTrackCreation           5.91259       9.08372       12.9469       8.30926       2.38765        10     
reco:pandoraShower:LArPandoraShowerCreation         5.19968       9.18329       15.9846       9.36784        3.041         10     
reco:pandoracalo:Calorimetry                        2.50421       3.88744       5.64721       3.62216       1.01786        10     
reco:pandoracalonosce:Calorimetry                   2.24377       3.56815       5.35948       3.33353      0.939398        10     
reco:pandorapid:Chi2ParticleID                    0.00433203    0.00510153    0.00601629    0.00498401    0.00059648       10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0483461     0.0807818     0.323455      0.0535854     0.0809832       10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00428748    0.00488265    0.00576953    0.00470027    0.00050353       10     
reco:pandoraShowercalo:ShowerCalorimetry            4.57845       7.82267       12.7153       8.00818       2.47126        10     
reco:pandoraShowercalonosce:ShowerCalorimetry       4.58558       7.71761       11.623        7.53528       1.96264        10     
reco:emtrkmichelid:EmTrackMichelId                  129.937       153.455       195.988       151.947       17.2431        10     
reco:crttag:SingleCRTMatchingProducer              0.0216157     0.0289525     0.0367728     0.0276029    0.00563121       10     
reco:crtreco:TwoCRTMatchingProducer                0.0140232     0.0224817     0.0267955     0.0245853     0.0042667       10     
reco:anodepiercerst0:T0RecoAnodePiercers           0.785382       1.01565       1.19605       1.03342      0.130066        10     
reco:pandora2Track:LArPandoraTrackCreation          19.5654       27.6233       43.2753       26.1778       6.63133        10     
reco:pandora2calo:Calorimetry                       5.97417       10.0089       17.0172       9.8614        2.79052        10     
reco:pandora2calonosce:Calorimetry                  5.69631       9.25518       14.938        9.12198       2.2308         10     
reco:pandora2pid:Chi2ParticleID                   0.00996916     0.0115168     0.0150994      0.01089     0.00156396       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0581074     0.0674145     0.0823163     0.0686291    0.00693071       10     
reco:pandora2calipidnoxyzt:Chi2ParticleID         0.00968442     0.0112723     0.0144495     0.0104846    0.00142165       10     
reco:pandora2Shower:LArPandoraShowerCreation        4.64639       6.5307        8.87199       6.42282       1.27726        10     
reco:pandora2Showercalo:ShowerCalorimetry           4.48751       7.88074       12.7702       7.73336       2.14379        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      3.78869       6.58669       10.2397       6.56421       1.61507        10     
[art]:TriggerResults:TriggerResultInserter        4.4356e-05    5.44173e-05   0.000112721   4.8409e-05    1.95825e-05      10     
end_path:out1:RootOutput                           6.922e-06    9.5085e-06    1.2564e-05     8.607e-06    2.09475e-06      10     
end_path:out1:RootOutput(write)                     1.91833       2.24616       2.98917       2.21821      0.307614        10     
====================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5036.9 MB
  Peak resident set size usage (VmHWM): 4221.15 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.18 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.04 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   3.06 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 9709592
-rw-r--r-- 1 pltdune002 pltdune 2308360244 Jul 31 13:33 detsim_stage2.root
-rw-r--r-- 1 pltdune002 pltdune 2195556305 Jul 31 13:32 detsim_stage1.root
-rw-r--r-- 1 pltdune002 pltdune 1986547777 Jul 31 14:37 reco_stage1.root
-rw-r--r-- 1 pltdune002 pltdune 1728864080 Jul 31 12:24 g4_stage2.root
-rw-r--r-- 1 pltdune002 pltdune 1649225468 Jul 31 12:12 g4_stage1.root
-rw-r--r-- 1 pltdune002 pltdune   73454060 Jul 31 14:32 Pandora_Events.pndr
-rw-r--r-- 1 pltdune002 pltdune     243149 Jul 31 14:37 jobscript.log
-rw-r--r-- 1 pltdune002 pltdune     217088 Jul 31 14:37 mem.db
-rw-r--r-- 1 pltdune002 pltdune      62376 Jul 31 14:37 Pandora_Geometry.xml
-rw-r--r-- 1 pltdune002 pltdune      36864 Jul 31 14:37 time.db
-rw-r--r-- 1 pltdune002 pltdune        519 Jul 31 13:33 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 pltdune002 pltdune        519 Jul 31 12:24 g4_protoDUNE_hist.root
-rw-r--r-- 1 pltdune002 pltdune        519 Jul 31 14:37 protoDUNE_reco1_hist.root
-rw-r--r-- 1 pltdune002 pltdune         52 Jul 31 12:06 all-input-dids.txt
-rw-r--r-- 1 pltdune002 pltdune          7 Jul 31 14:37 justin-processed-pfns.txt
-rw-r--r-- 1 pltdune002 pltdune          0 Jul 31 13:40 ProtoDUNE.log
-rw-r--r-- 1 pltdune002 pltdune          0 Jul 31 13:33 debugprod.log
justIN time: 2025-08-05 00:40:31 UTC       justIN version: 01.04.00