justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 269134.1@dunegpschedd01.fnal.gov

Jobsub ID269134.1@dunegpschedd01.fnal.gov
Workflow ID11267
Stage ID1
User namepmelas@fnal.gov
RequestedProcessors1
GPUNo
RSS bytes8388608000 (8000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2025-12-18 22:20:15
SiteUK_Manchester
EntryUBoone_T2_UK_Manchester_ce02
Last heartbeat2025-12-19 03:25:43
From worker nodeHostnamewn1904251.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-12-18 22:21:11
Input filesmonte-carlo-011267-000001
JobscriptExit code0
Real time5h (18170s)
CPU time4h (17628s = 97%)
Max RSS bytes4783095808 (4561 MiB)
Outputting started2025-12-19 03:24:02
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11267/1/001/reco_stage1.root
Finished2025-12-19 03:25:43
Saved logsjustin-logs:269134.1-dunegpschedd01.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

cKeepAllSignalFinder
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 161622 traces, 0 summary
Retagger: tagging trace set: gauss with 124663 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 124663 traces tagged "gauss"
FrameSaver: q=4.18013e+06 n=2266529 tag=gauss
wclsFrameSaver: saving 161622 traces tagged "wiener"
FrameSaver: q=4.4063e+06 n=2017351 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 37892 XUs and 29327 XVs -> 269 XUVs
C:0 T:1 68791 XUs and 56378 XVs -> 4233 XUVs
C:0 T:2 208960 XUs and 174792 XVs -> 8162 XUVs
C:0 T:3 93554 XUs and 66261 XVs -> 849 XUVs
C:0 T:4 11093 XUs and 16952 XVs -> 170 XUVs
C:0 T:5 59077 XUs and 86614 XVs -> 8714 XUVs
C:0 T:6 104889 XUs and 66777 XVs -> 2891 XUVs
C:0 T:7 43402 XUs and 24659 XVs -> 177 XUVs
C:0 T:8 13998 XUs and 14330 XVs -> 278 XUVs
C:0 T:9 108174 XUs and 140312 XVs -> 7724 XUVs
C:0 T:10 46138 XUs and 31644 XVs -> 6246 XUVs
C:0 T:11 296 XUs and 215 XVs -> 41 XUVs
39754 XUVs total
15278 collection wire objects
36121 potential space points
Neighbour search...
2075861 tests to find 1084400 neighbours
Iterating with no regularization...
Begin: 9.7615e+07
0 7.94164e+07
1 7.82875e+07
2 7.81755e+07
3 7.81431e+07
Now with regularization...
Begin: 6.75287e+07
0 6.75019e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 411200972
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411200972
fLifetime: 30000 [us]
19-Dec-2025 03:23:56 GMT  Closed output file "reco_stage1.root"
19-Dec-2025 03:23:56 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                                          391.753       553.189       714.399       540.715       87.2486        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.000966063    0.0042577    0.00775422    0.00375915    0.00211127       10     
reco:ophit:OpHitFinder                             0.333634      0.431217      0.503113      0.441893      0.0535474       10     
reco:opflash:OpFlashFinder                         0.226903      0.276185      0.357302      0.269636      0.0407995       10     
reco:opslicer:OpSlicer                             0.853386       1.07227       1.31983       1.04582       0.13821        10     
reco:caldata:DataPrepModule                         7.0601        7.53047       7.85115       7.62851      0.245222        10     
reco:wclsdatasp:WireCellToolkit                     38.0225       44.0899       55.0781       43.2014       4.18421        10     
reco:gaushit:GausHitFinder                          1.39185       2.07838       2.55882       2.1193       0.342575        10     
reco:nhitsfilter:NumberOfHitsFilter               0.000577113   0.000773146   0.00105154    0.000786817   0.000128748      10     
reco:reco3d:SpacePointSolver                        18.5992       36.1917       61.2624       34.0618       11.9213        10     
reco:hitpdune:DisambigFromSpacePoints               1.98574       3.24219       4.50245       3.27214      0.717488        10     
reco:pandora:StandardPandora                        25.7701       71.7111       141.445       63.2946       30.9028        10     
reco:pandoraWriter:StandardPandora                 0.534182       0.70691      0.975056      0.671616      0.116935        10     
reco:pandoraTrack:LArPandoraTrackCreation           4.41426       7.03194       10.9751       6.6367        2.00778        10     
reco:pandoraShower:LArPandoraShowerCreation         4.4455        7.82375       17.1552       6.9406        3.45415        10     
reco:pandoracalo:Calorimetry                        2.89007       3.84244       5.45931       3.74855      0.753242        10     
reco:pandoracalonosce:Calorimetry                   2.59479       3.60482       4.69051       3.47045      0.684831        10     
reco:pandorapid:Chi2ParticleID                    0.00773996    0.00929196     0.0123016    0.00892161     0.0014804       10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0509537     0.0881048     0.129788      0.0887291     0.0197819       10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00584632    0.00886042     0.0119651    0.00880722    0.00161204       10     
reco:pandoraShowercalo:ShowerCalorimetry            4.84807        8.366        16.3321       8.14236       2.9228         10     
reco:pandoraShowercalonosce:ShowerCalorimetry       4.76003       8.21327       16.3856       7.72293       2.97525        10     
reco:emtrkmichelid:EmTrackMichelId                  208.727       273.955       305.638       278.181       27.9905        10     
reco:crttag:SingleCRTMatchingProducer              0.0190235     0.0216786     0.0262035     0.0214765    0.00239884       10     
reco:crtreco:TwoCRTMatchingProducer                0.011534      0.0134326     0.0170455     0.0131369    0.00166551       10     
reco:anodepiercerst0:T0RecoAnodePiercers           0.962125       1.18846       1.47594       1.19157       0.16264        10     
reco:pandora2Track:LArPandoraTrackCreation          14.9052       21.5777       35.6891       21.0902       5.56207        10     
reco:pandora2calo:Calorimetry                       6.66794       10.9045       16.8451       10.7731        2.479         10     
reco:pandora2calonosce:Calorimetry                  7.09278       10.1366       15.9882       10.0281       2.26878        10     
reco:pandora2pid:Chi2ParticleID                    0.0131678     0.0221094     0.028932      0.0207445    0.00473211       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0895622     0.107834      0.133128      0.102212      0.0158311       10     
reco:pandora2calipidnoxyzt:Chi2ParticleID          0.0131472     0.0218522     0.0289676     0.0203885    0.00471168       10     
reco:pandora2Shower:LArPandoraShowerCreation        5.40581       7.26245       11.914        7.11875       1.74776        10     
reco:pandora2Showercalo:ShowerCalorimetry           7.00798       9.12814       13.6452       8.97196       1.84906        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      5.25647       8.13778       12.4665       8.29786       1.85619        10     
[art]:TriggerResults:TriggerResultInserter        5.2449e-05    8.8037e-05    0.000165971   7.9028e-05    2.99374e-05      10     
end_path:out1:RootOutput                           5.811e-06    1.22603e-05   1.8325e-05    1.23835e-05   3.43283e-06      10     
end_path:out1:RootOutput(write)                     3.45719       4.23663       5.26263       4.21125      0.594808        10     
====================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5602.78 MB
  Peak resident set size usage (VmHWM): 4783.1 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.34 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.06 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   4.74 sec/event
ToolBasedRawDigitPrepService:dtor:         adcKeepAllSignalFinder:   0.20 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleKeToAdc:   0.06 sec/event
ToolBasedRawDigitPrepService:dtor:         pdsp_RemoveBadChannels:   0.00 sec/event
Art has completed and will exit with status 0.
lar exit code 0
.:
total 12097764
-rw-r--r-- 1 dune01 dune01 2778722628 Dec 19 01:49 detsim_stage2.root
-rw-r--r-- 1 dune01 dune01 2634873930 Dec 19 01:46 detsim_stage1.root
-rw-r--r-- 1 dune01 dune01 2522756257 Dec 19 03:23 reco_stage1.root
-rw-r--r-- 1 dune01 dune01 2239875041 Dec 18 22:52 g4_stage2.root
-rw-r--r-- 1 dune01 dune01 2122364447 Dec 18 22:30 g4_stage1.root
-rw-r--r-- 1 dune01 dune01   88885850 Dec 19 03:17 Pandora_Events.pndr
-rw-r--r-- 1 dune01 dune01     242926 Dec 19 03:24 jobscript.log
-rw-r--r-- 1 dune01 dune01     217088 Dec 19 03:23 mem.db
-rw-r--r-- 1 dune01 dune01      62376 Dec 19 03:23 Pandora_Geometry.xml
-rw-r--r-- 1 dune01 dune01      36864 Dec 19 03:23 time.db
-rw-r--r-- 1 dune01 dune01        519 Dec 19 01:49 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 dune01 dune01        519 Dec 18 22:52 g4_protoDUNE_hist.root
-rw-r--r-- 1 dune01 dune01        519 Dec 19 03:23 protoDUNE_reco1_hist.root
-rw-r--r-- 1 dune01 dune01         52 Dec 18 22:21 all-input-dids.txt
-rw-r--r-- 1 dune01 dune01          7 Dec 19 03:23 justin-processed-pfns.txt
-rw-r--r-- 1 dune01 dune01          0 Dec 19 01:57 ProtoDUNE.log
-rw-r--r-- 1 dune01 dune01          0 Dec 19 01:49 debugprod.log
justIN time: 2026-02-07 08:07:15 UTC       justIN version: 01.06.00