justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 252860.0@dunegpschedd01.fnal.gov

Jobsub ID252860.0@dunegpschedd01.fnal.gov
Workflow ID10263
Stage ID1
User namepmelas@fnal.gov
RequestedProcessors1
GPUNo
RSS bytes8388608000 (8000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2025-11-16 16:33:05
SiteUK_QMUL
EntryDUNE_UK_London_QMUL_arcce02
Last heartbeat2025-11-16 19:35:30
From worker nodeHostnamecn083.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-11-16 16:33:58
Input filesmonte-carlo-010263-000001
JobscriptExit code0
Real time2h (10688s)
CPU time2h (10498s = 98%)
Max RSS bytes4111110144 (3920 MiB)
Outputting started2025-11-16 19:32:07
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/10263/1/001/reco_stage1.root
Finished2025-11-16 19:35:30
Saved logsjustin-logs:252860.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 128716 traces, 0 summary
Retagger: tagging trace set: gauss with 100963 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 100963 traces tagged "gauss"
FrameSaver: q=3.41809e+06 n=1818456 tag=gauss
wclsFrameSaver: saving 128716 traces tagged "wiener"
FrameSaver: q=3.61419e+06 n=1626695 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 27246 XUs and 32368 XVs -> 379 XUVs
C:0 T:1 51973 XUs and 87500 XVs -> 5415 XUVs
C:0 T:2 58264 XUs and 61758 XVs -> 3357 XUVs
C:0 T:3 26821 XUs and 24107 XVs -> 202 XUVs
C:0 T:4 10956 XUs and 11080 XVs -> 77 XUVs
C:0 T:5 35519 XUs and 30195 XVs -> 2410 XUVs
C:0 T:6 98058 XUs and 86832 XVs -> 3306 XUVs
C:0 T:7 41083 XUs and 32922 XVs -> 221 XUVs
C:0 T:8 12467 XUs and 11620 XVs -> 250 XUVs
C:0 T:9 74093 XUs and 83731 XVs -> 5756 XUVs
C:0 T:10 97880 XUs and 42297 XVs -> 6654 XUVs
C:0 T:11 1350 XUs and 755 XVs -> 407 XUVs
28434 XUVs total
11463 collection wire objects
25624 potential space points
Neighbour search...
1238456 tests to find 664328 neighbours
Iterating with no regularization...
Begin: 8.32336e+07
0 6.22436e+07
1 6.1356e+07
2 6.1241e+07
3 6.12047e+07
Now with regularization...
Begin: 5.22035e+07
0 5.21702e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
run: 1 ; subrun: 0 ; event: 10
evttime: 410552715
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 410552715
fLifetime: 30000 [us]
16-Nov-2025 19:32:04 GMT  Closed output file "reco_stage1.root"
16-Nov-2025 19:32:04 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                                          357.57        441.169       560.924       414.235       77.2747        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.00161818    0.00340211    0.00546646    0.00339699    0.00111593       10     
reco:ophit:OpHitFinder                             0.223031       0.25753       0.35713      0.245604      0.0366907       10     
reco:opflash:OpFlashFinder                         0.151441      0.187068      0.225116      0.186468      0.0205633       10     
reco:opslicer:OpSlicer                             0.436132      0.569019       0.75876      0.565887      0.0899198       10     
reco:caldata:DataPrepModule                         5.57179       5.96636       8.46295       5.67651      0.836067        10     
reco:wclsdatasp:WireCellToolkit                     50.9991       56.8103       66.9278       54.3047       5.48756        10     
reco:gaushit:GausHitFinder                         0.968635       1.22592       1.50867       1.15488      0.183434        10     
reco:nhitsfilter:NumberOfHitsFilter               0.000671445   0.000849252   0.00119037    0.000814474   0.000169409      10     
reco:reco3d:SpacePointSolver                        7.40423       12.8718       34.1379       10.5622       7.29741        10     
reco:hitpdune:DisambigFromSpacePoints               1.27139       1.6549        2.23675       1.54779       0.33103        10     
reco:pandora:StandardPandora                        21.4167       29.5736       44.0048       27.4477       8.01212        10     
reco:pandoraWriter:StandardPandora                 0.400403      0.465912      0.551924      0.459535      0.0548235       10     
reco:pandoraTrack:LArPandoraTrackCreation           7.03292       9.86114       13.4591       9.58999       2.0889         10     
reco:pandoraShower:LArPandoraShowerCreation         6.54362       10.8429       18.0225       9.10807       3.64376        10     
reco:pandoracalo:Calorimetry                        2.97951       4.57687       7.78495       4.19553       1.46334        10     
reco:pandoracalonosce:Calorimetry                   2.83673       4.42351       7.61673       3.98811       1.4779         10     
reco:pandorapid:Chi2ParticleID                    0.00519665    0.00601559    0.00850484     0.0057636    0.000921165      10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0491841     0.0571236     0.0845526     0.0544697     0.0100343       10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00477179    0.00570284    0.00820142    0.00550442    0.000933248      10     
reco:pandoraShowercalo:ShowerCalorimetry            5.60302       10.1184       21.5033       7.61176       4.86604        10     
reco:pandoraShowercalonosce:ShowerCalorimetry       5.41431       9.88344       21.1417       7.50154       4.72294        10     
reco:emtrkmichelid:EmTrackMichelId                  142.921       188.399       245.985       176.64        35.5005        10     
reco:crttag:SingleCRTMatchingProducer              0.0258527     0.033238      0.0454603     0.0304881    0.00646892       10     
reco:crtreco:TwoCRTMatchingProducer                0.0229635     0.0280865     0.0417334     0.0249221    0.00570713       10     
reco:anodepiercerst0:T0RecoAnodePiercers            0.86613       1.16278       1.39772       1.13737      0.164875        10     
reco:pandora2Track:LArPandoraTrackCreation          20.9561       31.1849       55.7991       26.6122       10.534         10     
reco:pandora2calo:Calorimetry                       8.43392       13.9784       26.018        12.4925       5.39742        10     
reco:pandora2calonosce:Calorimetry                  8.09956       13.3394       25.3603       11.6751       5.26571        10     
reco:pandora2pid:Chi2ParticleID                    0.0104657      0.01304      0.0175111     0.0127075    0.00204858       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0596157     0.0713994     0.0894575     0.0707896    0.00928123       10     
reco:pandora2calipidnoxyzt:Chi2ParticleID          0.0101908     0.012671      0.0163074     0.0124382    0.00176577       10     
reco:pandora2Shower:LArPandoraShowerCreation        7.76381       10.2711       13.2149       10.0033       2.06307        10     
reco:pandora2Showercalo:ShowerCalorimetry           7.28131       10.9801       17.029        9.27217       3.52541        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      5.81348       9.70656       15.1104       8.6355        3.12581        10     
[art]:TriggerResults:TriggerResultInserter        5.3855e-05    7.03441e-05   0.000137468   6.13545e-05   2.3512e-05       10     
end_path:out1:RootOutput                          1.0039e-05    1.13156e-05   1.8025e-05    1.0683e-05    2.26109e-06      10     
end_path:out1:RootOutput(write)                     1.99116       2.42616       3.4246        2.23364      0.438676        10     
====================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4914.26 MB
  Peak resident set size usage (VmHWM): 4111.11 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.23 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.06 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   3.63 sec/event
ToolBasedRawDigitPrepService:dtor:         adcKeepAllSignalFinder:   0.21 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 9353352
-rw-r--r-- 1 pildune22 pildune 2225405909 Nov 16 18:16 detsim_stage2.root
-rw-r--r-- 1 pildune22 pildune 2116907594 Nov 16 18:14 detsim_stage1.root
-rw-r--r-- 1 pildune22 pildune 1865996743 Nov 16 19:32 reco_stage1.root
-rw-r--r-- 1 pildune22 pildune 1686455306 Nov 16 16:53 g4_stage2.root
-rw-r--r-- 1 pildune22 pildune 1618758224 Nov 16 16:39 g4_stage1.root
-rw-r--r-- 1 pildune22 pildune   63695300 Nov 16 19:24 Pandora_Events.pndr
-rw-r--r-- 1 pildune22 pildune     242804 Nov 16 19:32 jobscript.log
-rw-r--r-- 1 pildune22 pildune     217088 Nov 16 19:32 mem.db
-rw-r--r-- 1 pildune22 pildune      62376 Nov 16 19:32 Pandora_Geometry.xml
-rw-r--r-- 1 pildune22 pildune      36864 Nov 16 19:32 time.db
-rw-r--r-- 1 pildune22 pildune        519 Nov 16 18:16 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 pildune22 pildune        519 Nov 16 16:53 g4_protoDUNE_hist.root
-rw-r--r-- 1 pildune22 pildune        519 Nov 16 19:32 protoDUNE_reco1_hist.root
-rw-r--r-- 1 pildune22 pildune         52 Nov 16 16:33 all-input-dids.txt
-rw-r--r-- 1 pildune22 pildune          7 Nov 16 19:32 justin-processed-pfns.txt
-rw-r--r-- 1 pildune22 pildune          0 Nov 16 18:22 ProtoDUNE.log
-rw-r--r-- 1 pildune22 pildune          0 Nov 16 18:16 debugprod.log
justIN time: 2026-02-09 10:58:17 UTC       justIN version: 01.06.00