justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 293028.1@dunegpschedd02.fnal.gov

Jobsub ID293028.1@dunegpschedd02.fnal.gov
Workflow ID12203
Stage ID1
User namepmelas@fnal.gov
RequestedProcessors1
GPUNo
RSS bytes8388608000 (8000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2026-01-21 21:22:12
SiteUK_QMUL
EntryDUNE_UK_London_QMUL_arcce03
Last heartbeat2026-01-22 00:45:37
From worker nodeHostnamecn009.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
Started2026-01-21 21:23:28
Input filesmonte-carlo-012203-000001
JobscriptExit code0
Real time3h (11906s)
CPU time3h (11712s = 98%)
Max RSS bytes4302028800 (4102 MiB)
Outputting started2026-01-22 00:41:55
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/12203/1/001/reco_stage1.root
Finished2026-01-22 00:45:37
Saved logsjustin-logs:293028.1-dunegpschedd02.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

: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 99724 traces, 0 summary
Retagger: tagging trace set: gauss with 78384 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 78384 traces tagged "gauss"
FrameSaver: q=2.69212e+06 n=1455328 tag=gauss
wclsFrameSaver: saving 99724 traces tagged "wiener"
FrameSaver: q=2.82981e+06 n=1303894 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 30051 XUs and 23862 XVs -> 222 XUVs
C:0 T:1 54024 XUs and 43057 XVs -> 3005 XUVs
C:0 T:2 116389 XUs and 198441 XVs -> 13751 XUVs
C:0 T:3 45979 XUs and 68160 XVs -> 674 XUVs
C:0 T:4 11163 XUs and 9069 XVs -> 56 XUVs
C:0 T:5 43353 XUs and 26012 XVs -> 3534 XUVs
C:0 T:6 61565 XUs and 94186 XVs -> 17321 XUVs
C:0 T:7 16886 XUs and 19566 XVs -> 496 XUVs
C:0 T:8 4221 XUs and 6454 XVs -> 44 XUVs
C:0 T:9 21247 XUs and 33340 XVs -> 1542 XUVs
C:0 T:10 52338 XUs and 47832 XVs -> 13486 XUVs
C:0 T:11 62 XUs and 32 XVs -> 7 XUVs
54138 XUVs total
9518 collection wire objects
50255 potential space points
Neighbour search...
13921571 tests to find 5515674 neighbours
Iterating with no regularization...
Begin: 4.72559e+07
0 3.96212e+07
1 3.91234e+07
2 3.90476e+07
3 3.90216e+07
Now with regularization...
Begin: 3.22504e+07
0 3.21799e+07
1 3.21239e+07
2 3.20756e+07
3 3.20363e+07
4 3.20063e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
run: 1 ; subrun: 0 ; event: 10
evttime: 411884418
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411884418
fLifetime: 30000 [us]
22-Jan-2026 00:41:51 GMT  Closed output file "reco_stage1.root"
22-Jan-2026 00:41:51 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                                          289.757       424.95        550.646       433.482       82.4754        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.000831208   0.00327968     0.0054223    0.00323399     0.001427        10     
reco:ophit:OpHitFinder                             0.219372      0.295163      0.442626      0.282456      0.0626881       10     
reco:opflash:OpFlashFinder                         0.155789      0.217237      0.283709      0.214873      0.043881        10     
reco:opslicer:OpSlicer                             0.389962      0.676553       1.00796      0.678665      0.157956        10     
reco:caldata:DataPrepModule                         5.27951       6.44529       8.7269        5.66998       1.31128        10     
reco:wclsdatasp:WireCellToolkit                     47.2468       51.8826       62.7685       50.5093       4.5159         10     
reco:gaushit:GausHitFinder                         0.858245       1.52602       2.18221       1.60826      0.382084        10     
reco:nhitsfilter:NumberOfHitsFilter               0.000617841   0.000896017   0.00130878    0.000880288   0.000188189      10     
reco:reco3d:SpacePointSolver                        5.71478       14.079        20.9126       15.3205       4.97194        10     
reco:hitpdune:DisambigFromSpacePoints              0.993002       1.9886        3.34929       1.90452      0.737522        10     
reco:pandora:StandardPandora                        14.7588       34.6041       54.507        34.3412       12.5123        10     
reco:pandoraWriter:StandardPandora                  0.3232       0.460196      0.725167      0.453851      0.109334        10     
reco:pandoraTrack:LArPandoraTrackCreation           3.68726       8.85374       15.8705       8.74802       3.62133        10     
reco:pandoraShower:LArPandoraShowerCreation         2.34293       7.89404       16.7952       7.10484       4.09191        10     
reco:pandoracalo:Calorimetry                        1.71287       3.57495       5.9878        3.9158        1.25821        10     
reco:pandoracalonosce:Calorimetry                   1.51648       3.41994       5.81388       3.78262       1.24075        10     
reco:pandorapid:Chi2ParticleID                     0.0042535    0.00594739     0.0102476    0.00565148    0.00163849       10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0459707     0.0596583     0.0864304     0.0578754     0.0114754       10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00422574    0.00582412    0.00997407     0.0055214     0.0015272       10     
reco:pandoraShowercalo:ShowerCalorimetry            2.10487       6.94517       12.7477       7.44987       3.19614        10     
reco:pandoraShowercalonosce:ShowerCalorimetry       2.04915       6.63032       12.5892       7.47559       3.10973        10     
reco:emtrkmichelid:EmTrackMichelId                  153.481       203.253       248.813       204.578       35.2219        10     
reco:crttag:SingleCRTMatchingProducer              0.0154983     0.0289855     0.0402468     0.0291137    0.00665728       10     
reco:crtreco:TwoCRTMatchingProducer               0.00954466     0.022695      0.0328667     0.0222161    0.00673964       10     
reco:anodepiercerst0:T0RecoAnodePiercers           0.911415       1.32593       1.94635       1.19884      0.330545        10     
reco:pandora2Track:LArPandoraTrackCreation          8.50766       26.3107       42.9199       26.5669       8.85676        10     
reco:pandora2calo:Calorimetry                       5.36741       10.3458       20.391        9.86949       4.27221        10     
reco:pandora2calonosce:Calorimetry                  5.36038       9.59075       18.009        9.34017       3.61884        10     
reco:pandora2pid:Chi2ParticleID                   0.00959846     0.0148092     0.0224963     0.0142949    0.00335849       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0644268     0.0806274      0.12101      0.0778803     0.0151021       10     
reco:pandora2calipidnoxyzt:Chi2ParticleID         0.00982957     0.0147083     0.0211059     0.0141757    0.00319761       10     
reco:pandora2Shower:LArPandoraShowerCreation        4.35527       6.72014       12.5622       6.00834       2.21424        10     
reco:pandora2Showercalo:ShowerCalorimetry           4.75246       8.26684       14.4656       7.54758       2.87291        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      4.39183       6.49663       9.49055       6.17044       1.58896        10     
[art]:TriggerResults:TriggerResultInserter        4.2748e-05    5.89112e-05   0.000102687   5.8147e-05    1.61711e-05      10     
end_path:out1:RootOutput                           6.977e-06    7.9715e-06    1.1207e-05    7.7245e-06    1.15012e-06      10     
end_path:out1:RootOutput(write)                     2.20714       2.77531       4.0735        2.72756      0.501541        10     
====================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5113.41 MB
  Peak resident set size usage (VmHWM): 4302.03 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.25 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.06 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   3.98 sec/event
ToolBasedRawDigitPrepService:dtor:         adcKeepAllSignalFinder:   0.22 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 10001352
-rw-r--r-- 1 pildune32 pildune 2359259709 Jan 21 23:28 detsim_stage2.root
-rw-r--r-- 1 pildune32 pildune 2241085464 Jan 21 23:26 detsim_stage1.root
-rw-r--r-- 1 pildune32 pildune 2021947502 Jan 22 00:41 reco_stage1.root
-rw-r--r-- 1 pildune32 pildune 1812614125 Jan 21 21:48 g4_stage2.root
-rw-r--r-- 1 pildune32 pildune 1736771470 Jan 21 21:31 g4_stage1.root
-rw-r--r-- 1 pildune32 pildune   69088050 Jan 22 00:37 Pandora_Events.pndr
-rw-r--r-- 1 pildune32 pildune     243003 Jan 22 00:41 jobscript.log
-rw-r--r-- 1 pildune32 pildune     217088 Jan 22 00:41 mem.db
-rw-r--r-- 1 pildune32 pildune      62376 Jan 22 00:41 Pandora_Geometry.xml
-rw-r--r-- 1 pildune32 pildune      36864 Jan 22 00:41 time.db
-rw-r--r-- 1 pildune32 pildune        519 Jan 21 23:28 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 pildune32 pildune        519 Jan 21 21:48 g4_protoDUNE_hist.root
-rw-r--r-- 1 pildune32 pildune        519 Jan 22 00:41 protoDUNE_reco1_hist.root
-rw-r--r-- 1 pildune32 pildune         52 Jan 21 21:23 all-input-dids.txt
-rw-r--r-- 1 pildune32 pildune          7 Jan 22 00:41 justin-processed-pfns.txt
-rw-r--r-- 1 pildune32 pildune          0 Jan 21 23:36 ProtoDUNE.log
-rw-r--r-- 1 pildune32 pildune          0 Jan 21 23:29 debugprod.log
justIN time: 2026-02-05 11:16:39 UTC       justIN version: 01.06.00