justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 270888.0@dunegpschedd01.fnal.gov

Jobsub ID270888.0@dunegpschedd01.fnal.gov
Workflow ID11414
Stage ID1
User namepmelas@fnal.gov
RequestedProcessors1
GPUNo
RSS bytes8388608000 (8000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2025-12-30 06:20:18
SiteUK_QMUL
EntryDUNE_UK_London_QMUL_arcce03
Last heartbeat2025-12-30 09:21:05
From worker nodeHostnamecn028.htc.esc.qmul
cpuinfoIntel(R) Xeon(R) Gold 6248R CPU @ 3.00GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes10485760000 (10000 MiB)
Wall seconds limit171000 (47 hours)
GPU
Inner Apptainer?True
Job statefinished
Started2025-12-30 06:30:28
Input filesmonte-carlo-011414-000001
JobscriptExit code0
Real time2h (10036s)
CPU time2h (9876s = 98%)
Max RSS bytes4149846016 (3957 MiB)
Outputting started2025-12-30 09:17:45
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11414/1/001/reco_stage1.root
Finished2025-12-30 09:21:05
Saved logsjustin-logs:270888.0-dunegpschedd01.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

dsp_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 143079 traces, 0 summary
Retagger: tagging trace set: gauss with 103984 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 103984 traces tagged "gauss"
FrameSaver: q=3.95091e+06 n=1827021 tag=gauss
wclsFrameSaver: saving 143079 traces tagged "wiener"
FrameSaver: q=4.22324e+06 n=1614319 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 34850 XUs and 44070 XVs -> 1663 XUVs
C:0 T:1 102787 XUs and 174297 XVs -> 36755 XUVs
C:0 T:2 52834 XUs and 71900 XVs -> 2330 XUVs
C:0 T:3 29620 XUs and 33485 XVs -> 149 XUVs
C:0 T:4 16281 XUs and 12744 XVs -> 159 XUVs
C:0 T:5 106353 XUs and 82007 XVs -> 15577 XUVs
C:0 T:6 52727 XUs and 60138 XVs -> 3203 XUVs
C:0 T:7 23332 XUs and 23734 XVs -> 153 XUVs
C:0 T:8 10382 XUs and 10361 XVs -> 373 XUVs
C:0 T:9 84754 XUs and 118191 XVs -> 13727 XUVs
C:0 T:10 74902 XUs and 90204 XVs -> 17027 XUVs
C:0 T:11 331 XUs and 279 XVs -> 30 XUVs
91146 XUVs total
11455 collection wire objects
84778 potential space points
Neighbour search...
18551136 tests to find 8219836 neighbours
Iterating with no regularization...
Begin: 7.51799e+07
0 5.94671e+07
1 5.82234e+07
2 5.80141e+07
3 5.79456e+07
4 5.79124e+07
Now with regularization...
Begin: 4.64853e+07
0 4.63796e+07
1 4.62912e+07
2 4.62227e+07
3 4.61677e+07
4 4.6123e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 411429289
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411429289
fLifetime: 30000 [us]
30-Dec-2025 09:17:42 GMT  Closed output file "reco_stage1.root"
30-Dec-2025 09:17:42 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                                          252.738       417.284       594.531       394.607       97.8758        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.00105295    0.00329494    0.00542935    0.00332457     0.0013305       10     
reco:ophit:OpHitFinder                             0.211805      0.267948      0.290528      0.278416      0.0226709       10     
reco:opflash:OpFlashFinder                         0.144382      0.218489       0.26013      0.227726      0.0334705       10     
reco:opslicer:OpSlicer                             0.423716      0.623051      0.781627      0.629315      0.0837722       10     
reco:caldata:DataPrepModule                         5.32729       5.56068       5.82733       5.52349      0.181563        10     
reco:wclsdatasp:WireCellToolkit                     46.4319       50.5149       53.1504       50.2716       2.07775        10     
reco:gaushit:GausHitFinder                          0.78546       1.27458       1.6507        1.24901      0.223558        10     
reco:nhitsfilter:NumberOfHitsFilter               0.000560736   0.000811233   0.00107147    0.000817135   0.000141923      10     
reco:reco3d:SpacePointSolver                        7.75845       14.9861       25.3451       14.5084       5.49955        10     
reco:hitpdune:DisambigFromSpacePoints              0.920479       1.84896       3.06059       1.88959      0.540495        10     
reco:pandora:StandardPandora                        15.3763       29.2169       42.101        28.1967       7.62621        10     
reco:pandoraWriter:StandardPandora                  0.31365      0.450077      0.544807       0.44115      0.0716112       10     
reco:pandoraTrack:LArPandoraTrackCreation           4.99499       9.53218       13.4051       9.55617       2.5525         10     
reco:pandoraShower:LArPandoraShowerCreation         3.21234       9.78299       14.8249       9.57662       3.16165        10     
reco:pandoracalo:Calorimetry                        1.87737       4.1618        6.13764       4.27649       1.3157         10     
reco:pandoracalonosce:Calorimetry                   1.92278       3.90632       5.70314       3.9862        1.17713        10     
reco:pandorapid:Chi2ParticleID                    0.00438267     0.0059392    0.00776105    0.00552494    0.000929017      10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0419919     0.0579854     0.0736387     0.0543317    0.00969571       10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00423301    0.00550017    0.00714212    0.00530096    0.000779937      10     
reco:pandoraShowercalo:ShowerCalorimetry            2.5346        8.16631       12.7467       8.55277       2.98807        10     
reco:pandoraShowercalonosce:ShowerCalorimetry       2.31828       7.91736       12.9966       8.14983       3.02658        10     
reco:emtrkmichelid:EmTrackMichelId                  118.782       184.459       243.083       167.786       42.7503        10     
reco:crttag:SingleCRTMatchingProducer              0.0181492     0.0275762     0.0371751     0.0249166    0.00726478       10     
reco:crtreco:TwoCRTMatchingProducer                0.0160789     0.023806      0.0335281     0.0220561    0.00574527       10     
reco:anodepiercerst0:T0RecoAnodePiercers           0.944906       1.28024       1.85369        1.192       0.305373        10     
reco:pandora2Track:LArPandoraTrackCreation          12.4718       29.5384       53.1618       28.0781       10.568         10     
reco:pandora2calo:Calorimetry                       4.33675       11.9412       23.2085       11.5496       5.02454        10     
reco:pandora2calonosce:Calorimetry                  4.37409       11.3443       22.0912       11.0832       4.79067        10     
reco:pandora2pid:Chi2ParticleID                   0.00825505     0.0133795     0.0249751     0.0124941    0.00422565       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0498341     0.0747864     0.125685      0.0686935     0.0198852       10     
reco:pandora2calipidnoxyzt:Chi2ParticleID         0.00853713     0.0134967     0.0245138     0.0125148    0.00400451       10     
reco:pandora2Shower:LArPandoraShowerCreation        3.80267       8.84961       16.2642       8.32773       3.27224        10     
reco:pandora2Showercalo:ShowerCalorimetry           4.04824       9.95339       19.3021       9.76775       4.17113        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      3.82396       8.45617       16.7551       8.1931        3.66921        10     
[art]:TriggerResults:TriggerResultInserter        4.6375e-05    6.18717e-05   0.000120839   5.15875e-05   2.2805e-05       10     
end_path:out1:RootOutput                           6.538e-06    8.1939e-06    1.0927e-05    7.6715e-06    1.46049e-06      10     
end_path:out1:RootOutput(write)                     1.75812       2.65234       4.46899       2.51352      0.692945        10     
====================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4959.58 MB
  Peak resident set size usage (VmHWM): 4149.85 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.09 sec/event
ToolBasedRawDigitPrepService:dtor:                adcSampleFiller:   0.21 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.05 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   3.42 sec/event
ToolBasedRawDigitPrepService:dtor:         adcKeepAllSignalFinder:   0.19 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 9779416
-rw-r--r-- 1 pildune32 pildune 2302550812 Dec 30 08:06 detsim_stage2.root
-rw-r--r-- 1 pildune32 pildune 2180916786 Dec 30 08:04 detsim_stage1.root
-rw-r--r-- 1 pildune32 pildune 1961239173 Dec 30 09:17 reco_stage1.root
-rw-r--r-- 1 pildune32 pildune 1788835574 Dec 30 06:50 g4_stage2.root
-rw-r--r-- 1 pildune32 pildune 1712063099 Dec 30 06:36 g4_stage1.root
-rw-r--r-- 1 pildune32 pildune   67895430 Dec 30 09:09 Pandora_Events.pndr
-rw-r--r-- 1 pildune32 pildune     242790 Dec 30 09:17 jobscript.log
-rw-r--r-- 1 pildune32 pildune     217088 Dec 30 09:17 mem.db
-rw-r--r-- 1 pildune32 pildune      62376 Dec 30 09:17 Pandora_Geometry.xml
-rw-r--r-- 1 pildune32 pildune      36864 Dec 30 09:17 time.db
-rw-r--r-- 1 pildune32 pildune        519 Dec 30 08:06 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 pildune32 pildune        519 Dec 30 06:50 g4_protoDUNE_hist.root
-rw-r--r-- 1 pildune32 pildune        519 Dec 30 09:17 protoDUNE_reco1_hist.root
-rw-r--r-- 1 pildune32 pildune         52 Dec 30 06:30 all-input-dids.txt
-rw-r--r-- 1 pildune32 pildune          7 Dec 30 09:17 justin-processed-pfns.txt
-rw-r--r-- 1 pildune32 pildune          0 Dec 30 08:13 ProtoDUNE.log
-rw-r--r-- 1 pildune32 pildune          0 Dec 30 08:06 debugprod.log
justIN time: 2026-02-07 00:51:15 UTC       justIN version: 01.06.00