justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 271356.1@dunegpschedd01.fnal.gov

Jobsub ID271356.1@dunegpschedd01.fnal.gov
Workflow ID11478
Stage ID1
User namepmelas@fnal.gov
RequestedProcessors1
GPUNo
RSS bytes8388608000 (8000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2026-01-02 19:14:48
SiteUK_RAL-PPD
EntryCMSHTPC_T2_UK_SGrid_RALPP_hep206
Last heartbeat2026-01-02 23:50:53
From worker nodeHostnameheplnc145.pp.rl.ac.uk
cpuinfoAMD EPYC 7452 32-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
Started2026-01-02 19:16:05
Input filesmonte-carlo-011478-000001
JobscriptExit code0
Real time4h (16403s)
CPU time4h (15803s = 96%)
Max RSS bytes4157112320 (3964 MiB)
Outputting started2026-01-02 23:49:29
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11478/1/001/reco_stage1.root
Finished2026-01-02 23:50:53
Saved logsjustin-logs:271356.1-dunegpschedd01.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

aleKeToAdc
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 137710 traces, 0 summary
Retagger: tagging trace set: gauss with 104671 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 104671 traces tagged "gauss"
FrameSaver: q=3.53775e+06 n=1853359 tag=gauss
wclsFrameSaver: saving 137710 traces tagged "wiener"
FrameSaver: q=3.73569e+06 n=1625259 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 16262 XUs and 19394 XVs -> 238 XUVs
C:0 T:1 45521 XUs and 39694 XVs -> 4637 XUVs
C:0 T:2 84074 XUs and 134765 XVs -> 7915 XUVs
C:0 T:3 34002 XUs and 54662 XVs -> 274 XUVs
C:0 T:4 16002 XUs and 15635 XVs -> 272 XUVs
C:0 T:5 114068 XUs and 126012 XVs -> 17850 XUVs
C:0 T:6 127456 XUs and 136139 XVs -> 6433 XUVs
C:0 T:7 45155 XUs and 49111 XVs -> 386 XUVs
C:0 T:8 7609 XUs and 5526 XVs -> 52 XUVs
C:0 T:9 49784 XUs and 58241 XVs -> 5345 XUVs
C:0 T:10 54535 XUs and 43477 XVs -> 5519 XUVs
C:0 T:11 71 XUs and 49 XVs -> 5 XUVs
48926 XUVs total
14178 collection wire objects
45992 potential space points
Neighbour search...
6554824 tests to find 3021414 neighbours
Iterating with no regularization...
Begin: 6.79249e+07
0 5.60149e+07
1 5.52071e+07
2 5.50739e+07
3 5.5031e+07
Now with regularization...
Begin: 4.49098e+07
0 4.48617e+07
1 4.48218e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 411500424
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411500424
fLifetime: 30000 [us]
02-Jan-2026 23:49:26 GMT  Closed output file "reco_stage1.root"
02-Jan-2026 23:49:26 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                                          442.831       533.337       740.68        491.245       93.4506        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.00141181    0.00425242     0.0069911    0.00453146    0.00183163       10     
reco:ophit:OpHitFinder                             0.267458      0.371591      0.447738      0.378289      0.0531497       10     
reco:opflash:OpFlashFinder                         0.160007      0.218678      0.260105      0.213595      0.0270098       10     
reco:opslicer:OpSlicer                             0.523302      0.984083       1.1814        1.07822       0.22838        10     
reco:caldata:DataPrepModule                         4.8163        6.84927       7.56549       7.09325      0.765875        10     
reco:wclsdatasp:WireCellToolkit                     37.1487       42.3047       47.6451       41.6036       3.61798        10     
reco:gaushit:GausHitFinder                          1.12616       1.52032       1.81915       1.59203      0.232042        10     
reco:nhitsfilter:NumberOfHitsFilter               0.000571278   0.00083363    0.00109287    0.00084524    0.000149073      10     
reco:reco3d:SpacePointSolver                        11.2527       18.279        30.3843       16.7234       5.56731        10     
reco:hitpdune:DisambigFromSpacePoints               1.43888       2.1845        3.50228       1.93565      0.648925        10     
reco:pandora:StandardPandora                        30.0823       56.2027       99.6364       49.7787       23.6128        10     
reco:pandoraWriter:StandardPandora                 0.408632      0.599784      0.900174      0.599463      0.142758        10     
reco:pandoraTrack:LArPandoraTrackCreation           4.63641       6.54747       11.7365       5.92587       2.01563        10     
reco:pandoraShower:LArPandoraShowerCreation         4.33102       7.73436       13.5085       7.47204       2.59018        10     
reco:pandoracalo:Calorimetry                        2.07644       3.53481       6.47217       3.2675        1.19476        10     
reco:pandoracalonosce:Calorimetry                   2.26295       3.32922       5.49475       3.0529       0.890071        10     
reco:pandorapid:Chi2ParticleID                    0.00565721    0.00829882     0.011331     0.00841082    0.00163654       10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0487076     0.0832748     0.114787      0.086373      0.0200394       10     
reco:pandoracalipidnoxyzt:Chi2ParticleID           0.005354     0.00777732     0.0108234    0.00758708    0.00157952       10     
reco:pandoraShowercalo:ShowerCalorimetry            4.25303       7.80928       13.4262       6.90748       2.48762        10     
reco:pandoraShowercalonosce:ShowerCalorimetry       4.77234       7.20057       13.2353       6.26386       2.45883        10     
reco:emtrkmichelid:EmTrackMichelId                  251.667       295.145       379.642       276.447       42.6431        10     
reco:crttag:SingleCRTMatchingProducer              0.0129859     0.0261004     0.0468553     0.024446      0.0101401       10     
reco:crtreco:TwoCRTMatchingProducer               0.00874612     0.0161565     0.0236862     0.016122      0.0047145       10     
reco:anodepiercerst0:T0RecoAnodePiercers           0.699833       1.1282        1.51007       1.12187      0.244078        10     
reco:pandora2Track:LArPandoraTrackCreation          13.0668       22.6335       36.4281       19.7252       7.27789        10     
reco:pandora2calo:Calorimetry                       5.56202       10.7366       17.569        9.35032       4.09864        10     
reco:pandora2calonosce:Calorimetry                  5.14541       9.10789       14.3506       8.34208       2.88121        10     
reco:pandora2pid:Chi2ParticleID                    0.0133972     0.0190625     0.0259966     0.0195617    0.00464295       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0564877     0.0936599      0.13541      0.0947489     0.0279774       10     
reco:pandora2calipidnoxyzt:Chi2ParticleID          0.0127597     0.0184089     0.0250744     0.0185714    0.00439389       10     
reco:pandora2Shower:LArPandoraShowerCreation        4.44484       8.01598       12.7498       6.55331       2.76086        10     
reco:pandora2Showercalo:ShowerCalorimetry           5.60034       8.75873       13.5081       7.84846       2.51726        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      4.10649       7.6941        13.3273       7.22373       2.73963        10     
[art]:TriggerResults:TriggerResultInserter        4.8531e-05    8.25719e-05   0.00016456    7.3178e-05    3.15493e-05      10     
end_path:out1:RootOutput                           9.699e-06    1.27028e-05   1.8154e-05    1.2408e-05    2.25937e-06      10     
end_path:out1:RootOutput(write)                     3.04049       3.99394       5.47361       3.7996       0.783631        10     
====================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4977.52 MB
  Peak resident set size usage (VmHWM): 4157.11 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.10 sec/event
ToolBasedRawDigitPrepService:dtor:                adcSampleFiller:   0.29 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.06 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   4.29 sec/event
ToolBasedRawDigitPrepService:dtor:         adcKeepAllSignalFinder:   0.17 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleKeToAdc:   0.06 sec/event
ToolBasedRawDigitPrepService:dtor:         pdsp_RemoveBadChannels:   0.01 sec/event
Art has completed and will exit with status 0.
lar exit code 0
.:
total 10561580
-rw-r--r-- 1 pltdune04 pltdune 2468103530 Jan  2 22:17 detsim_stage2.root
-rw-r--r-- 1 pltdune04 pltdune 2341499792 Jan  2 22:14 detsim_stage1.root
-rw-r--r-- 1 pltdune04 pltdune 2180770872 Jan  2 23:49 reco_stage1.root
-rw-r--r-- 1 pltdune04 pltdune 1906687902 Jan  2 19:40 g4_stage2.root
-rw-r--r-- 1 pltdune04 pltdune 1835887035 Jan  2 19:24 g4_stage1.root
-rw-r--r-- 1 pltdune04 pltdune   81496600 Jan  2 23:43 Pandora_Events.pndr
-rw-r--r-- 1 pltdune04 pltdune     243553 Jan  2 23:49 jobscript.log
-rw-r--r-- 1 pltdune04 pltdune     217088 Jan  2 23:49 mem.db
-rw-r--r-- 1 pltdune04 pltdune      62376 Jan  2 23:49 Pandora_Geometry.xml
-rw-r--r-- 1 pltdune04 pltdune      36864 Jan  2 23:49 time.db
-rw-r--r-- 1 pltdune04 pltdune        519 Jan  2 22:17 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 pltdune04 pltdune        519 Jan  2 19:40 g4_protoDUNE_hist.root
-rw-r--r-- 1 pltdune04 pltdune        519 Jan  2 23:49 protoDUNE_reco1_hist.root
-rw-r--r-- 1 pltdune04 pltdune         52 Jan  2 19:16 all-input-dids.txt
-rw-r--r-- 1 pltdune04 pltdune          7 Jan  2 23:49 justin-processed-pfns.txt
-rw-r--r-- 1 pltdune04 pltdune          0 Jan  2 22:26 ProtoDUNE.log
-rw-r--r-- 1 pltdune04 pltdune          0 Jan  2 22:17 debugprod.log
justIN time: 2026-02-06 22:22:28 UTC       justIN version: 01.06.00