justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 248111.0@dunegpschedd02.fnal.gov

Jobsub ID248111.0@dunegpschedd02.fnal.gov
Workflow ID10333
Stage ID1
User namepmelas@fnal.gov
RequestedProcessors1
GPUNo
RSS bytes8388608000 (8000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2025-11-18 15:27:52
SiteUK_Manchester
EntryUBoone_T2_UK_Manchester_ce02
Last heartbeat2025-11-18 19:19:36
From worker nodeHostnamewn2210241.tier2.hep.manchester.ac.uk
cpuinfoAMD EPYC 7513 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
Started2025-11-18 15:29:22
Input filesmonte-carlo-010333-000001
JobscriptExit code0
Real time3h (13730s)
CPU time3h (13222s = 96%)
Max RSS bytes4006281216 (3820 MiB)
Outputting started2025-11-18 19:18:13
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/10333/1/001/reco_stage1.root
Finished2025-11-18 19:19:35
Saved logsjustin-logs:248111.0-dunegpschedd02.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

llSignalFinder
ToolBasedRawDigitPrepService:prepare:   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 112367 traces, 0 summary
Retagger: tagging trace set: gauss with 88287 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 88287 traces tagged "gauss"
FrameSaver: q=2.98431e+06 n=1590560 tag=gauss
wclsFrameSaver: saving 112367 traces tagged "wiener"
FrameSaver: q=3.1651e+06 n=1430749 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 19479 XUs and 19467 XVs -> 149 XUVs
C:0 T:1 33973 XUs and 29316 XVs -> 1600 XUVs
C:0 T:2 69897 XUs and 100613 XVs -> 3030 XUVs
C:0 T:3 37217 XUs and 39682 XVs -> 250 XUVs
C:0 T:4 9651 XUs and 8666 XVs -> 53 XUVs
C:0 T:5 31372 XUs and 25974 XVs -> 3635 XUVs
C:0 T:6 101446 XUs and 111316 XVs -> 8782 XUVs
C:0 T:7 38569 XUs and 38447 XVs -> 801 XUVs
C:0 T:8 7993 XUs and 9452 XVs -> 107 XUVs
C:0 T:9 57965 XUs and 78511 XVs -> 4474 XUVs
C:0 T:10 48800 XUs and 40518 XVs -> 11438 XUVs
C:0 T:11 259 XUs and 236 XVs -> 49 XUVs
34368 XUVs total
9497 collection wire objects
31466 potential space points
Neighbour search...
5310062 tests to find 2259366 neighbours
Iterating with no regularization...
Begin: 6.06443e+07
0 5.15508e+07
1 5.08521e+07
2 5.07509e+07
3 5.07223e+07
Now with regularization...
Begin: 4.25616e+07
0 4.25174e+07
1 4.24895e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 410591947
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 410591947
fLifetime: 30000 [us]
18-Nov-2025 19:18:10 GMT  Closed output file "reco_stage1.root"
18-Nov-2025 19:18:10 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                                          323.891       419.291       524.608       415.054       65.2293        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.00103837    0.00515736     0.0086147    0.00483932    0.00222151       10     
reco:ophit:OpHitFinder                             0.265972      0.350635      0.427929      0.351162      0.0555815       10     
reco:opflash:OpFlashFinder                         0.138926      0.188451      0.277693      0.173608      0.0407939       10     
reco:opslicer:OpSlicer                             0.557556      0.801908       1.03938      0.732863      0.169249        10     
reco:caldata:DataPrepModule                         6.29991       7.48518       8.67613       7.61086      0.748333        10     
reco:wclsdatasp:WireCellToolkit                     36.2714       46.5277       54.4337       47.9598       5.24241        10     
reco:gaushit:GausHitFinder                         0.946197       1.49143       2.03817       1.4656       0.348927        10     
reco:nhitsfilter:NumberOfHitsFilter               0.000610157   0.000883783   0.00204976    0.000751784   0.000405041      10     
reco:reco3d:SpacePointSolver                        9.76275       16.9154       28.4772       15.1597       5.0728         10     
reco:hitpdune:DisambigFromSpacePoints              0.966671       1.72882       2.68696       1.64997      0.510967        10     
reco:pandora:StandardPandora                        20.6703       31.9038       48.6635       31.7034       8.71795        10     
reco:pandoraWriter:StandardPandora                 0.340568      0.569722      0.770734      0.590931      0.151804        10     
reco:pandoraTrack:LArPandoraTrackCreation           3.03356       5.35774       8.80297       5.22882       1.81311        10     
reco:pandoraShower:LArPandoraShowerCreation          2.485        6.33841       14.3972       5.02868       3.39857        10     
reco:pandoracalo:Calorimetry                        1.49239       2.9493        4.6629        2.54825       1.12549        10     
reco:pandoracalonosce:Calorimetry                   1.13581       2.58201       5.15977       2.13394       1.2555         10     
reco:pandorapid:Chi2ParticleID                    0.00334798    0.00611421     0.0084141    0.00666258    0.00179836       10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0317565     0.0573422     0.080195      0.0591299     0.0165734       10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00394882    0.00583885    0.00801367    0.00558135    0.00144159       10     
reco:pandoraShowercalo:ShowerCalorimetry            3.00738       6.75683       15.1628       5.69482       3.60873        10     
reco:pandoraShowercalonosce:ShowerCalorimetry       2.97755       6.99522       19.5073       6.10469       4.85401        10     
reco:emtrkmichelid:EmTrackMichelId                  168.55        213.307       247.425       206.688       23.0875        10     
reco:crttag:SingleCRTMatchingProducer              0.0160288     0.0255301     0.0360508     0.0233798     0.0068573       10     
reco:crtreco:TwoCRTMatchingProducer                0.0119116     0.0174824     0.0234737     0.0159579    0.00413968       10     
reco:anodepiercerst0:T0RecoAnodePiercers           0.564937      0.998926       1.43277      0.940496       0.24957        10     
reco:pandora2Track:LArPandoraTrackCreation          11.0193       19.192        28.0517       20.3524       5.26161        10     
reco:pandora2calo:Calorimetry                       5.25358       10.209        18.0291       10.0635       3.77986        10     
reco:pandora2calonosce:Calorimetry                  4.70948       9.97109       19.8598       8.98214       4.27698        10     
reco:pandora2pid:Chi2ParticleID                    0.0100986     0.0170459     0.0222668     0.0179572    0.00331133       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0482602     0.0833286     0.0988607     0.0891136     0.017456        10     
reco:pandora2calipidnoxyzt:Chi2ParticleID         0.00839679     0.0153459     0.0189144     0.0172818    0.00381801       10     
reco:pandora2Shower:LArPandoraShowerCreation        4.39288       7.28921       13.7953       7.04785       2.61849        10     
reco:pandora2Showercalo:ShowerCalorimetry           4.85768        8.809        14.0162       8.78042       2.73721        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      4.24874       6.82017       11.1418       5.81044       2.25069        10     
[art]:TriggerResults:TriggerResultInserter        8.3327e-05    0.000131658   0.000250361   0.000118247   4.57117e-05      10     
end_path:out1:RootOutput                          1.2333e-05    1.84958e-05   3.3373e-05    1.62605e-05   6.4617e-06       10     
end_path:out1:RootOutput(write)                     2.75129       3.31131       4.12035       3.08949      0.423592        10     
====================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4838.89 MB
  Peak resident set size usage (VmHWM): 4006.28 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.11 sec/event
ToolBasedRawDigitPrepService:dtor:                adcSampleFiller:   0.36 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.07 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   4.64 sec/event
ToolBasedRawDigitPrepService:dtor:         adcKeepAllSignalFinder:   0.20 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleKeToAdc:   0.07 sec/event
ToolBasedRawDigitPrepService:dtor:         pdsp_RemoveBadChannels:   0.00 sec/event
Art has completed and will exit with status 0.
lar exit code 0
.:
total 9582880
-rw-r--r-- 1 dune01 dune01 2278076129 Nov 18 18:05 detsim_stage2.root
-rw-r--r-- 1 dune01 dune01 2165498792 Nov 18 18:03 detsim_stage1.root
-rw-r--r-- 1 dune01 dune01 1921660134 Nov 18 19:18 reco_stage1.root
-rw-r--r-- 1 dune01 dune01 1727562757 Nov 18 15:53 g4_stage2.root
-rw-r--r-- 1 dune01 dune01 1654796117 Nov 18 15:37 g4_stage1.root
-rw-r--r-- 1 dune01 dune01   64649550 Nov 18 19:12 Pandora_Events.pndr
-rw-r--r-- 1 dune01 dune01     242725 Nov 18 19:18 jobscript.log
-rw-r--r-- 1 dune01 dune01     217088 Nov 18 19:18 mem.db
-rw-r--r-- 1 dune01 dune01      62376 Nov 18 19:18 Pandora_Geometry.xml
-rw-r--r-- 1 dune01 dune01      36864 Nov 18 19:18 time.db
-rw-r--r-- 1 dune01 dune01        519 Nov 18 18:05 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 dune01 dune01        519 Nov 18 15:53 g4_protoDUNE_hist.root
-rw-r--r-- 1 dune01 dune01        519 Nov 18 19:18 protoDUNE_reco1_hist.root
-rw-r--r-- 1 dune01 dune01         52 Nov 18 15:29 all-input-dids.txt
-rw-r--r-- 1 dune01 dune01          7 Nov 18 19:18 justin-processed-pfns.txt
-rw-r--r-- 1 dune01 dune01          0 Nov 18 18:12 ProtoDUNE.log
-rw-r--r-- 1 dune01 dune01          0 Nov 18 18:05 debugprod.log
justIN time: 2026-02-09 06:07:31 UTC       justIN version: 01.06.00