justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 293442.1@dunegpschedd02.fnal.gov

Jobsub ID293442.1@dunegpschedd02.fnal.gov
Workflow ID12217
Stage ID1
User namepmelas@fnal.gov
RequestedProcessors1
GPUNo
RSS bytes8388608000 (8000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2026-01-22 08:04:45
SiteCERN
EntryCMSHTPC_T2_CH_CERN_ce511
Last heartbeat2026-01-22 12:46:14
From worker nodeHostnameb9p13p1563.cern.ch
cpuinfoIntel(R) Xeon(R) Silver 4216 CPU @ 2.10GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes10485760000 (10000 MiB)
Wall seconds limit343800 (95 hours)
GPU
Inner Apptainer?True
Job statefinished
Started2026-01-22 08:06:22
Input filesmonte-carlo-012217-000001
JobscriptExit code0
Real time4h (16708s)
CPU time4h (15449s = 92%)
Max RSS bytes4169822208 (3976 MiB)
Outputting started2026-01-22 12:44:51
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/12217/1/001/reco_stage1.root
Finished2026-01-22 12:46:14
Saved logsjustin-logs:293442.1-dunegpschedd02.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

ignalFinder
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 103926 traces, 0 summary
Retagger: tagging trace set: gauss with 78202 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 78202 traces tagged "gauss"
FrameSaver: q=2.66017e+06 n=1367235 tag=gauss
wclsFrameSaver: saving 103926 traces tagged "wiener"
FrameSaver: q=2.81014e+06 n=1201229 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:1 107262 XUs and 59874 XVs -> 13361 XUVs
C:0 T:2 44347 XUs and 58236 XVs -> 1934 XUVs
C:0 T:3 25054 XUs and 24143 XVs -> 124 XUVs
C:0 T:4 5370 XUs and 4322 XVs -> 35 XUVs
C:0 T:5 23421 XUs and 14627 XVs -> 4209 XUVs
C:0 T:6 53797 XUs and 61371 XVs -> 2209 XUVs
C:0 T:7 23408 XUs and 24829 XVs -> 89 XUVs
C:0 T:8 5069 XUs and 5846 XVs -> 39 XUVs
C:0 T:9 26688 XUs and 38830 XVs -> 2231 XUVs
C:0 T:10 56042 XUs and 71167 XVs -> 13253 XUVs
C:0 T:11 206 XUs and 144 XVs -> 19 XUVs
37503 XUVs total
9319 collection wire objects
35349 potential space points
Neighbour search...
4969885 tests to find 2388970 neighbours
Iterating with no regularization...
Begin: 4.6933e+07
0 3.79616e+07
1 3.7448e+07
2 3.73751e+07
3 3.73498e+07
Now with regularization...
Begin: 3.04089e+07
0 3.03648e+07
1 3.03365e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 411893367
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411893367
fLifetime: 30000 [us]
22-Jan-2026 13:44:49 CET  Closed output file "reco_stage1.root"
22-Jan-2026 13:44:49 CET  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                                          452.992       603.08        868.204       583.477       109.067        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.00132932    0.00357162    0.00509567    0.00393197    0.00116396       10     
reco:ophit:OpHitFinder                             0.299451      0.387822      0.501946      0.378545      0.0685353       10     
reco:opflash:OpFlashFinder                         0.205995      0.268381      0.329058      0.254151      0.0441533       10     
reco:opslicer:OpSlicer                             0.617857      0.901075       1.04796      0.913388      0.127295        10     
reco:caldata:DataPrepModule                         6.39173       8.40372       10.3561       8.4839        1.6969         10     
reco:wclsdatasp:WireCellToolkit                     50.1785       63.8701       73.5208       65.7889       6.5793         10     
reco:gaushit:GausHitFinder                          1.46066       1.99273       2.53807       1.95944      0.278765        10     
reco:nhitsfilter:NumberOfHitsFilter               0.000664718   0.000779596   0.000996933   0.000762758   8.38501e-05      10     
reco:reco3d:SpacePointSolver                        11.014        23.4902       52.1914       18.9186       11.1571        10     
reco:hitpdune:DisambigFromSpacePoints               2.52928       3.47596       6.43732       3.28917       1.04006        10     
reco:pandora:StandardPandora                        33.1871       51.4075       103.115       44.9057       18.9211        10     
reco:pandoraWriter:StandardPandora                 0.506044      0.641075      0.729288      0.657585      0.0675692       10     
reco:pandoraTrack:LArPandoraTrackCreation           7.39965       10.1755       13.6045       10.0486       1.80074        10     
reco:pandoraShower:LArPandoraShowerCreation         6.58619       9.61669       15.0048       9.09765       2.35125        10     
reco:pandoracalo:Calorimetry                        3.33398       4.50877       6.40781       4.51758      0.942115        10     
reco:pandoracalonosce:Calorimetry                   2.68255       4.35059       6.38802       4.47881       1.02386        10     
reco:pandorapid:Chi2ParticleID                    0.00566032    0.00956685     0.0128809    0.00969324    0.00227148       10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP          0.06117      0.0938178     0.123682      0.0985424     0.017356        10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00536185     0.009078      0.0125023    0.00942485    0.00201655       10     
reco:pandoraShowercalo:ShowerCalorimetry            3.68879       9.65995       20.0563       9.11453       3.95332        10     
reco:pandoraShowercalonosce:ShowerCalorimetry       5.41946       9.23185       17.6227       8.1459        3.12859        10     
reco:emtrkmichelid:EmTrackMichelId                  240.523       310.925       379.317       305.51        47.9216        10     
reco:crttag:SingleCRTMatchingProducer              0.0227509     0.0315942     0.0368459     0.032668     0.00474795       10     
reco:crtreco:TwoCRTMatchingProducer                0.0171179     0.0240218     0.0330863     0.0222937    0.00520272       10     
reco:anodepiercerst0:T0RecoAnodePiercers            1.30532       1.71099       2.51531       1.63976      0.393245        10     
reco:pandora2Track:LArPandoraTrackCreation          12.9038       31.0254       67.4975       27.4209       13.5694        10     
reco:pandora2calo:Calorimetry                       5.25446       12.2485       27.8621       10.5137       5.81651        10     
reco:pandora2calonosce:Calorimetry                  6.91394       11.4257       20.5221       11.0473       3.72032        10     
reco:pandora2pid:Chi2ParticleID                    0.014037      0.0213912     0.0347344     0.0221366    0.00585591       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0765352      0.11648       0.18862       0.10978      0.0322794       10     
reco:pandora2calipidnoxyzt:Chi2ParticleID          0.0142447     0.0211245     0.032811      0.021805     0.00541935       10     
reco:pandora2Shower:LArPandoraShowerCreation        6.1331        9.09473       14.5768       8.35483       2.39422        10     
reco:pandora2Showercalo:ShowerCalorimetry           6.54633       10.3811       18.9958       9.37468       3.5038         10     
reco:pandora2Showercalonosce:ShowerCalorimetry      5.10834       9.47854       19.3714       8.61623       3.85564        10     
[art]:TriggerResults:TriggerResultInserter        4.9533e-05    8.56324e-05   0.000168635   7.7058e-05    3.44984e-05      10     
end_path:out1:RootOutput                           8.021e-06     1.015e-05    1.5487e-05     9.492e-06    2.38368e-06      10     
end_path:out1:RootOutput(write)                     2.49442       3.92041       5.7803        4.02116      0.878438        10     
====================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4982.15 MB
  Peak resident set size usage (VmHWM): 4169.81 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.32 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.05 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   5.27 sec/event
ToolBasedRawDigitPrepService:dtor:         adcKeepAllSignalFinder:   0.31 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 9938624
-rw-r--r--. 1 duneprd np-comp 2344985306 Jan 22 11:59 detsim_stage2.root
-rw-r--r--. 1 duneprd np-comp 2224766281 Jan 22 11:55 detsim_stage1.root
-rw-r--r--. 1 duneprd np-comp 2008108385 Jan 22 13:44 reco_stage1.root
-rw-r--r--. 1 duneprd np-comp 1807653236 Jan 22 09:48 g4_stage2.root
-rw-r--r--. 1 duneprd np-comp 1721666146 Jan 22 09:17 g4_stage1.root
-rw-r--r--. 1 duneprd np-comp   69358980 Jan 22 13:39 Pandora_Events.pndr
-rw-r--r--. 1 duneprd np-comp     243098 Jan 22 13:44 jobscript.log
-rw-r--r--. 1 duneprd np-comp     217088 Jan 22 13:44 mem.db
-rw-r--r--. 1 duneprd np-comp      62376 Jan 22 13:44 Pandora_Geometry.xml
-rw-r--r--. 1 duneprd np-comp      36864 Jan 22 13:44 time.db
-rw-r--r--. 1 duneprd np-comp        519 Jan 22 11:59 detsim_single_protoDUNE_hist.root
-rw-r--r--. 1 duneprd np-comp        519 Jan 22 09:48 g4_protoDUNE_hist.root
-rw-r--r--. 1 duneprd np-comp        519 Jan 22 13:44 protoDUNE_reco1_hist.root
-rw-r--r--. 1 duneprd np-comp         52 Jan 22 09:06 all-input-dids.txt
-rw-r--r--. 1 duneprd np-comp          7 Jan 22 13:44 justin-processed-pfns.txt
-rw-r--r--. 1 duneprd np-comp          0 Jan 22 12:11 ProtoDUNE.log
-rw-r--r--. 1 duneprd np-comp          0 Jan 22 11:59 debugprod.log
justIN time: 2026-02-05 09:52:57 UTC       justIN version: 01.06.00