justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 271088.0@dunegpschedd01.fnal.gov

Jobsub ID271088.0@dunegpschedd01.fnal.gov
Workflow ID11440
Stage ID1
User namepmelas@fnal.gov
RequestedProcessors1
GPUNo
RSS bytes8388608000 (8000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2025-12-31 16:14:03
SiteUK_QMUL
EntryDUNE_UK_London_QMUL_arcce03
Last heartbeat2025-12-31 19:20:50
From worker nodeHostnamecn076.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-31 16:29:24
Input filesmonte-carlo-011440-000001
JobscriptExit code0
Real time2h (10094s)
CPU time2h (9936s = 98%)
Max RSS bytes4185653248 (3991 MiB)
Outputting started2025-12-31 19:17:39
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11440/1/001/reco_stage1.root
Finished2025-12-31 19:20:50
Saved logsjustin-logs:271088.0-dunegpschedd01.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

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 118007 traces, 0 summary
Retagger: tagging trace set: gauss with 92192 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 92192 traces tagged "gauss"
FrameSaver: q=3.21134e+06 n=1654476 tag=gauss
wclsFrameSaver: saving 118007 traces tagged "wiener"
FrameSaver: q=3.38043e+06 n=1474279 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 24739 XUs and 20926 XVs -> 160 XUVs
C:0 T:1 46962 XUs and 39288 XVs -> 2342 XUVs
C:0 T:2 102581 XUs and 141185 XVs -> 5733 XUVs
C:0 T:3 52712 XUs and 58349 XVs -> 402 XUVs
C:0 T:4 5989 XUs and 11054 XVs -> 39 XUVs
C:0 T:5 22408 XUs and 30613 XVs -> 3332 XUVs
C:0 T:6 121852 XUs and 128920 XVs -> 6760 XUVs
C:0 T:7 44718 XUs and 44119 XVs -> 495 XUVs
C:0 T:8 6410 XUs and 7325 XVs -> 51 XUVs
C:0 T:9 33858 XUs and 55291 XVs -> 2255 XUVs
C:0 T:10 43371 XUs and 39941 XVs -> 10489 XUVs
C:0 T:11 271 XUs and 193 XVs -> 38 XUVs
32096 XUVs total
10616 collection wire objects
29861 potential space points
Neighbour search...
3962945 tests to find 1831048 neighbours
Iterating with no regularization...
Begin: 6.44795e+07
0 5.54691e+07
1 5.48963e+07
2 5.48227e+07
3 5.48013e+07
Now with regularization...
Begin: 4.60746e+07
0 4.60405e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
run: 1 ; subrun: 0 ; event: 10
evttime: 411457727
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411457727
fLifetime: 30000 [us]
31-Dec-2025 19:17:36 GMT  Closed output file "reco_stage1.root"
31-Dec-2025 19:17:36 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                                          257.398       442.368       654.475       435.616       120.733        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.00100884    0.00373076    0.00592286    0.00361819    0.00150424       10     
reco:ophit:OpHitFinder                             0.197623      0.250936      0.334761      0.245842      0.0339838       10     
reco:opflash:OpFlashFinder                         0.125377      0.182314      0.212943      0.188796      0.0230287       10     
reco:opslicer:OpSlicer                             0.440803      0.591427      0.842964      0.582773      0.105969        10     
reco:caldata:DataPrepModule                         4.78535       5.28201       7.55604       5.08589      0.772218        10     
reco:wclsdatasp:WireCellToolkit                     42.463        47.1935       58.8776       46.6809       4.31344        10     
reco:gaushit:GausHitFinder                          0.83158       1.22281       1.55556       1.22227      0.210007        10     
reco:nhitsfilter:NumberOfHitsFilter               0.000669896   0.00082063    0.00115074    0.000764413   0.000144325      10     
reco:reco3d:SpacePointSolver                        8.49293       13.2453       20.2054       12.5575       3.37781        10     
reco:hitpdune:DisambigFromSpacePoints               1.04494       1.8393        2.73667       1.67565       0.4923         10     
reco:pandora:StandardPandora                        13.3627       33.9782       66.3617       30.8735       16.4383        10     
reco:pandoraWriter:StandardPandora                 0.340949      0.478873      0.607119       0.48521      0.0901411       10     
reco:pandoraTrack:LArPandoraTrackCreation           5.53864       10.0169       14.4262       10.3834       2.66572        10     
reco:pandoraShower:LArPandoraShowerCreation         5.16816       13.3393       21.4644       13.2701       5.20082        10     
reco:pandoracalo:Calorimetry                        2.36629       4.65561       7.0094        4.76977       1.43303        10     
reco:pandoracalonosce:Calorimetry                   2.20559       4.41457       6.64218       4.48444       1.35666        10     
reco:pandorapid:Chi2ParticleID                    0.00365709    0.00502684    0.00767231    0.00493031    0.00102744       10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0399147     0.0559055     0.070885      0.0551019    0.00964826       10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00356999    0.00476072    0.00583224    0.00479231    0.000661579      10     
reco:pandoraShowercalo:ShowerCalorimetry            4.02243       12.3534       20.8179       12.3323       5.41095        10     
reco:pandoraShowercalonosce:ShowerCalorimetry       3.82516       12.1685       20.0291       12.1851       5.1798         10     
reco:emtrkmichelid:EmTrackMichelId                  114.303       162.683       210.381       161.162       33.542         10     
reco:crttag:SingleCRTMatchingProducer              0.0225107     0.034061      0.0446818     0.0352621    0.00796506       10     
reco:crtreco:TwoCRTMatchingProducer                0.0200253     0.0307602     0.0406592     0.0326625    0.00696661       10     
reco:anodepiercerst0:T0RecoAnodePiercers           0.740332       1.23605       2.34769       1.14941      0.423627        10     
reco:pandora2Track:LArPandoraTrackCreation          15.6143       38.7609       72.5685       36.7502       16.2309        10     
reco:pandora2calo:Calorimetry                       6.25079       17.3794       34.6423       16.2955       8.07203        10     
reco:pandora2calonosce:Calorimetry                  5.89891       16.8144       33.3224       15.6907       7.8922         10     
reco:pandora2pid:Chi2ParticleID                   0.00789604     0.0131513     0.0226391     0.0118148    0.00449671       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0491364     0.077651      0.130524      0.0715274     0.0237075       10     
reco:pandora2calipidnoxyzt:Chi2ParticleID         0.00786611     0.0128934     0.0214669     0.0116066    0.00429907       10     
reco:pandora2Shower:LArPandoraShowerCreation        6.15989       13.1197       24.0705       12.9803       4.9136         10     
reco:pandora2Showercalo:ShowerCalorimetry           5.68983       14.8255       30.6487       14.3534       6.84513        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      5.06506       13.4211       28.1341       13.0084       6.23706        10     
[art]:TriggerResults:TriggerResultInserter        4.3833e-05    6.23622e-05   0.000116122   5.0318e-05    2.55573e-05      10     
end_path:out1:RootOutput                           7.157e-06    9.3155e-06    1.4101e-05    8.4355e-06    2.23003e-06      10     
end_path:out1:RootOutput(write)                     1.65592       2.47665       4.5768        2.30365      0.801852        10     
====================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4991.15 MB
  Peak resident set size usage (VmHWM): 4185.65 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.25 sec/event
ToolBasedRawDigitPrepService:dtor:         adcKeepAllSignalFinder:   0.18 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 9744200
-rw-r--r-- 1 pildune32 pildune 2302577718 Dec 31 18:02 detsim_stage2.root
-rw-r--r-- 1 pildune32 pildune 2183645819 Dec 31 18:00 detsim_stage1.root
-rw-r--r-- 1 pildune32 pildune 1980270860 Dec 31 19:17 reco_stage1.root
-rw-r--r-- 1 pildune32 pildune 1749934519 Dec 31 16:46 g4_stage2.root
-rw-r--r-- 1 pildune32 pildune 1688479614 Dec 31 16:34 g4_stage1.root
-rw-r--r-- 1 pildune32 pildune   72472530 Dec 31 19:12 Pandora_Events.pndr
-rw-r--r-- 1 pildune32 pildune     243018 Dec 31 19:17 jobscript.log
-rw-r--r-- 1 pildune32 pildune     217088 Dec 31 19:17 mem.db
-rw-r--r-- 1 pildune32 pildune      62376 Dec 31 19:17 Pandora_Geometry.xml
-rw-r--r-- 1 pildune32 pildune      36864 Dec 31 19:17 time.db
-rw-r--r-- 1 pildune32 pildune        519 Dec 31 18:02 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 pildune32 pildune        519 Dec 31 16:46 g4_protoDUNE_hist.root
-rw-r--r-- 1 pildune32 pildune        519 Dec 31 19:17 protoDUNE_reco1_hist.root
-rw-r--r-- 1 pildune32 pildune         52 Dec 31 16:29 all-input-dids.txt
-rw-r--r-- 1 pildune32 pildune          7 Dec 31 19:17 justin-processed-pfns.txt
-rw-r--r-- 1 pildune32 pildune          0 Dec 31 18:10 ProtoDUNE.log
-rw-r--r-- 1 pildune32 pildune          0 Dec 31 18:02 debugprod.log
justIN time: 2026-02-06 23:33:16 UTC       justIN version: 01.06.00