justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 252862.1@dunegpschedd01.fnal.gov

Jobsub ID252862.1@dunegpschedd01.fnal.gov
Workflow ID10265
Stage ID1
User namepmelas@fnal.gov
RequestedProcessors1
GPUNo
RSS bytes8388608000 (8000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2025-11-16 16:33:06
SiteUK_Lancaster
EntryUBoone_UK_Lancaster_HEC_grendel_ce02
Last heartbeat2025-11-16 18:53:43
From worker nodeHostnamecomp23-09
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-11-16 16:34:24
Input filesmonte-carlo-010265-000001
JobscriptExit code0
Real time2h (8278s)
CPU time2h (8097s = 97%)
Max RSS bytes4087914496 (3898 MiB)
Outputting started2025-11-16 18:52:22
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/10265/1/001/reco_stage1.root
Finished2025-11-16 18:53:43
Saved logsjustin-logs:252862.1-dunegpschedd01.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

dcScaleKeToAdc
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 133422 traces, 0 summary
Retagger: tagging trace set: gauss with 100705 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 100705 traces tagged "gauss"
FrameSaver: q=3.62263e+06 n=1752316 tag=gauss
wclsFrameSaver: saving 133422 traces tagged "wiener"
FrameSaver: q=3.83219e+06 n=1548820 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 23494 XUs and 20883 XVs -> 208 XUVs
C:0 T:1 35741 XUs and 34041 XVs -> 2110 XUVs
C:0 T:2 93470 XUs and 94529 XVs -> 6204 XUVs
C:0 T:3 47289 XUs and 43011 XVs -> 349 XUVs
C:0 T:4 9966 XUs and 12611 XVs -> 147 XUVs
C:0 T:5 32405 XUs and 28834 XVs -> 3441 XUVs
C:0 T:6 101926 XUs and 111141 XVs -> 5933 XUVs
C:0 T:7 41798 XUs and 44813 XVs -> 517 XUVs
C:0 T:8 8031 XUs and 4672 XVs -> 45 XUVs
C:0 T:9 50118 XUs and 41668 XVs -> 4226 XUVs
C:0 T:10 91230 XUs and 102718 XVs -> 15415 XUVs
C:0 T:11 128 XUs and 71 XVs -> 7 XUVs
38602 XUVs total
10888 collection wire objects
35949 potential space points
Neighbour search...
4047557 tests to find 1860952 neighbours
Iterating with no regularization...
Begin: 7.29906e+07
0 6.392e+07
1 6.30294e+07
2 6.28914e+07
3 6.28491e+07
Now with regularization...
Begin: 5.10142e+07
0 5.09683e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 410552692
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 410552692
fLifetime: 30000 [us]
16-Nov-2025 18:52:18 GMT  Closed output file "reco_stage1.root"
16-Nov-2025 18:52:18 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                                          248.013       307.867       399.82        309.989       42.9485        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.000996907   0.00273189    0.00469414    0.00291457    0.00108197       10     
reco:ophit:OpHitFinder                             0.188734      0.215658      0.237207      0.216267      0.0154778       10     
reco:opflash:OpFlashFinder                         0.131389      0.153438      0.180066      0.151375      0.0172087       10     
reco:opslicer:OpSlicer                             0.404621      0.515722      0.591882      0.532881      0.0583694       10     
reco:caldata:DataPrepModule                         4.70899       4.85879       4.97117       4.87271      0.0828975       10     
reco:wclsdatasp:WireCellToolkit                     39.5574       42.4305       44.5545       42.9532       1.52169        10     
reco:gaushit:GausHitFinder                         0.903761       1.08009       1.34745       1.05532      0.150524        10     
reco:nhitsfilter:NumberOfHitsFilter               0.00045436    0.00057718    0.000681489   0.000577092   6.65841e-05      10     
reco:reco3d:SpacePointSolver                        5.81432       10.5067       17.3818       9.00324       3.61442        10     
reco:hitpdune:DisambigFromSpacePoints               1.23267       1.56911       2.26382        1.505       0.300568        10     
reco:pandora:StandardPandora                        17.3443       24.819        40.4383       23.0944       6.01397        10     
reco:pandoraWriter:StandardPandora                  0.33944      0.395898      0.481301      0.399287      0.0401172       10     
reco:pandoraTrack:LArPandoraTrackCreation           4.08943       6.73355       10.4551       6.59653        1.864         10     
reco:pandoraShower:LArPandoraShowerCreation          3.073        5.4906        8.51778       5.57956       1.59679        10     
reco:pandoracalo:Calorimetry                        1.82834       2.88648       4.45096       2.7066       0.759209        10     
reco:pandoracalonosce:Calorimetry                   1.65331       2.60202       3.9361        2.44104      0.722111        10     
reco:pandorapid:Chi2ParticleID                    0.00408998    0.00481799     0.0059594    0.00478632    0.000616799      10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0426236     0.0517952     0.0668557     0.0506598    0.00642888       10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00401572    0.00475101    0.00589586    0.00476935    0.000562689      10     
reco:pandoraShowercalo:ShowerCalorimetry            2.82945       5.03271       7.70288       5.22975       1.47595        10     
reco:pandoraShowercalonosce:ShowerCalorimetry       2.82853       4.89508       7.36104       4.81205       1.30963        10     
reco:emtrkmichelid:EmTrackMichelId                  119.513       139.885       171.613       140.657       14.9966        10     
reco:crttag:SingleCRTMatchingProducer              0.0162077     0.0242186     0.032663      0.0247781    0.00488829       10     
reco:crtreco:TwoCRTMatchingProducer                0.0100368     0.017171      0.0226692     0.0177955    0.00384953       10     
reco:anodepiercerst0:T0RecoAnodePiercers           0.825155       1.00156       1.32779      0.932578       0.15407        10     
reco:pandora2Track:LArPandoraTrackCreation          10.9088       19.5712       27.5748        19.37        5.41607        10     
reco:pandora2calo:Calorimetry                       4.15179       7.38615       10.9772       7.73388       2.05743        10     
reco:pandora2calonosce:Calorimetry                  3.99759       6.82868       10.1536       7.41621       1.89895        10     
reco:pandora2pid:Chi2ParticleID                   0.00975616     0.0111042     0.0128627     0.010953     0.000991201      10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0543896     0.064563      0.0808759     0.0656089     0.0070308       10     
reco:pandora2calipidnoxyzt:Chi2ParticleID         0.00984986     0.0111612     0.0128972     0.0111084    0.00100568       10     
reco:pandora2Shower:LArPandoraShowerCreation        3.16466       5.15098       6.87861       5.42831       1.01512        10     
reco:pandora2Showercalo:ShowerCalorimetry           3.51034       6.07929       8.49292       6.62185       1.63723        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      3.13457       5.24761       7.4698        5.46967       1.3358         10     
[art]:TriggerResults:TriggerResultInserter        3.9809e-05    4.71422e-05   9.4546e-05    4.15125e-05   1.59088e-05      10     
end_path:out1:RootOutput                           6.923e-06    8.3254e-06    1.1678e-05    8.2385e-06    1.27086e-06      10     
end_path:out1:RootOutput(write)                     1.79642       2.20453       3.69146       2.10566      0.528055        10     
====================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4901 MB
  Peak resident set size usage (VmHWM): 4087.91 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.07 sec/event
ToolBasedRawDigitPrepService:dtor:                adcSampleFiller:   0.18 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.04 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   3.04 sec/event
ToolBasedRawDigitPrepService:dtor:         adcKeepAllSignalFinder:   0.17 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 9630362
-rw-r--r-- 1 pltdune004 pltdune 2287492548 Nov 16 17:59 detsim_stage2.root
-rw-r--r-- 1 pltdune004 pltdune 2175772988 Nov 16 17:57 detsim_stage1.root
-rw-r--r-- 1 pltdune004 pltdune 1954257246 Nov 16 18:52 reco_stage1.root
-rw-r--r-- 1 pltdune004 pltdune 1720556038 Nov 16 16:50 g4_stage2.root
-rw-r--r-- 1 pltdune004 pltdune 1652799315 Nov 16 16:39 g4_stage1.root
-rw-r--r-- 1 pltdune004 pltdune   70047690 Nov 16 18:48 Pandora_Events.pndr
-rw-r--r-- 1 pltdune004 pltdune     242700 Nov 16 18:52 jobscript.log
-rw-r--r-- 1 pltdune004 pltdune     217088 Nov 16 18:52 mem.db
-rw-r--r-- 1 pltdune004 pltdune      62376 Nov 16 18:52 Pandora_Geometry.xml
-rw-r--r-- 1 pltdune004 pltdune      36864 Nov 16 18:52 time.db
-rw-r--r-- 1 pltdune004 pltdune        519 Nov 16 17:59 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 pltdune004 pltdune        519 Nov 16 16:50 g4_protoDUNE_hist.root
-rw-r--r-- 1 pltdune004 pltdune        519 Nov 16 18:52 protoDUNE_reco1_hist.root
-rw-r--r-- 1 pltdune004 pltdune         52 Nov 16 16:34 all-input-dids.txt
-rw-r--r-- 1 pltdune004 pltdune          7 Nov 16 18:52 justin-processed-pfns.txt
-rw-r--r-- 1 pltdune004 pltdune          0 Nov 16 18:03 ProtoDUNE.log
-rw-r--r-- 1 pltdune004 pltdune          0 Nov 16 17:59 debugprod.log
justIN time: 2026-02-09 10:52:21 UTC       justIN version: 01.06.00