justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 260264.1@dunegpschedd02.fnal.gov

Jobsub ID260264.1@dunegpschedd02.fnal.gov
Workflow ID11137
Stage ID1
User namepmelas@fnal.gov
RequestedProcessors1
GPUNo
RSS bytes8388608000 (8000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2025-12-10 13:59:20
SiteUK_QMUL
EntryDUNE_UK_London_QMUL_arcce02
Last heartbeat2025-12-10 21:07:48
From worker nodeHostnamecn030.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-10 18:29:04
Input filesmonte-carlo-011137-000001
JobscriptExit code0
Real time2h (9309s)
CPU time2h (9091s = 97%)
Max RSS bytes4445544448 (4239 MiB)
Outputting started2025-12-10 21:04:15
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11137/1/001/reco_stage1.root
Finished2025-12-10 21:07:48
Saved logsjustin-logs:260264.1-dunegpschedd02.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

leKeToAdc
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 162673 traces, 0 summary
Retagger: tagging trace set: gauss with 119811 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 119811 traces tagged "gauss"
FrameSaver: q=4.12723e+06 n=2027531 tag=gauss
wclsFrameSaver: saving 162673 traces tagged "wiener"
FrameSaver: q=4.40337e+06 n=1775016 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 42296 XUs and 34583 XVs -> 730 XUVs
C:0 T:1 102718 XUs and 87180 XVs -> 12779 XUVs
C:0 T:2 93541 XUs and 104679 XVs -> 7077 XUVs
C:0 T:3 44084 XUs and 43549 XVs -> 238 XUVs
C:0 T:4 21299 XUs and 21463 XVs -> 344 XUVs
C:0 T:5 92527 XUs and 80464 XVs -> 12566 XUVs
C:0 T:6 86063 XUs and 103308 XVs -> 6039 XUVs
C:0 T:7 35643 XUs and 41595 XVs -> 329 XUVs
C:0 T:8 6552 XUs and 9338 XVs -> 81 XUVs
C:0 T:9 46782 XUs and 81695 XVs -> 4624 XUVs
C:0 T:10 41190 XUs and 22600 XVs -> 4369 XUVs
C:0 T:11 142 XUs and 95 XVs -> 12 XUVs
49188 XUVs total
14649 collection wire objects
45437 potential space points
Neighbour search...
4758655 tests to find 2433976 neighbours
Iterating with no regularization...
Begin: 8.22587e+07
0 6.9391e+07
1 6.84187e+07
2 6.82743e+07
3 6.82301e+07
Now with regularization...
Begin: 5.56579e+07
0 5.56017e+07
1 5.55673e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 411032576
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411032576
fLifetime: 30000 [us]
10-Dec-2025 21:04:12 GMT  Closed output file "reco_stage1.root"
10-Dec-2025 21:04:12 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                                          245.138       370.227       449.398       398.366       68.3878        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.000676466    0.0538702     0.512711     0.00318659     0.152951        10     
reco:ophit:OpHitFinder                             0.218802      0.248188      0.281582      0.243462      0.0218861       10     
reco:opflash:OpFlashFinder                         0.163938      0.207138      0.257812      0.198241      0.0260047       10     
reco:opslicer:OpSlicer                             0.534883      0.618874      0.700378      0.616091      0.0558315       10     
reco:caldata:DataPrepModule                         4.87787       5.06228       5.16845       5.08679      0.091815        10     
reco:wclsdatasp:WireCellToolkit                     36.8162       38.9587       40.3991       39.0606       1.0725         10     
reco:gaushit:GausHitFinder                         0.818334       1.14677       1.44665       1.15552      0.199765        10     
reco:nhitsfilter:NumberOfHitsFilter               0.000456327   0.000645155   0.00078995    0.000627292   0.000102824      10     
reco:reco3d:SpacePointSolver                        5.29749       13.2889       27.6933       11.6752       6.01328        10     
reco:hitpdune:DisambigFromSpacePoints               1.21609       2.02414       2.89276       2.03731      0.554689        10     
reco:pandora:StandardPandora                        23.6562       36.8197       57.2123       36.6526       11.4041        10     
reco:pandoraWriter:StandardPandora                 0.281316      0.392886      0.485201      0.383294      0.0593918       10     
reco:pandoraTrack:LArPandoraTrackCreation           3.02334       4.37161       5.55163       4.2235       0.850211        10     
reco:pandoraShower:LArPandoraShowerCreation         2.79326       5.11563       7.18297       4.77041       1.41493        10     
reco:pandoracalo:Calorimetry                        1.4359        2.29298       2.85117       2.25582      0.457295        10     
reco:pandoracalonosce:Calorimetry                   1.30916       2.11788       2.65323       2.08731      0.433318        10     
reco:pandorapid:Chi2ParticleID                    0.00388427    0.00474723    0.00656379    0.00466545    0.000716255      10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0408363     0.0598722     0.103761      0.0582918     0.0164754       10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00378016    0.00442734     0.0051645    0.00456326    0.000485934      10     
reco:pandoraShowercalo:ShowerCalorimetry            2.3418        5.30836       7.44262       5.05527       1.58388        10     
reco:pandoraShowercalonosce:ShowerCalorimetry       2.26984       5.2056        7.2793        4.95633       1.56471        10     
reco:emtrkmichelid:EmTrackMichelId                  126.736       195.536       294.758       193.145       48.0313        10     
reco:crttag:SingleCRTMatchingProducer              0.0120165     0.0181232     0.0425806     0.0143011     0.0086177       10     
reco:crtreco:TwoCRTMatchingProducer               0.00664772     0.0100509     0.0166792    0.00976144    0.00251855       10     
reco:anodepiercerst0:T0RecoAnodePiercers           0.859071       1.06472       1.24151       1.07061      0.132695        10     
reco:pandora2Track:LArPandoraTrackCreation          8.25907       15.4489       20.9317       14.3307       4.15222        10     
reco:pandora2calo:Calorimetry                       3.58419       7.33255       9.77001       7.04011       1.97986        10     
reco:pandora2calonosce:Calorimetry                  3.3833        7.01025       9.42203       6.74744       1.90584        10     
reco:pandora2pid:Chi2ParticleID                   0.00952003     0.0122102     0.0143802     0.0117556    0.00163897       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0508272     0.0702071     0.086669      0.068724      0.010249        10     
reco:pandora2calipidnoxyzt:Chi2ParticleID         0.00903695     0.0116678     0.0136307     0.0114223    0.00154208       10     
reco:pandora2Shower:LArPandoraShowerCreation        3.12726       5.43227       7.25657       5.28902       1.29446        10     
reco:pandora2Showercalo:ShowerCalorimetry           3.20032       6.50878       8.72478       6.34483       1.67605        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      2.89801       6.01631       8.23768       5.9931        1.55726        10     
[art]:TriggerResults:TriggerResultInserter        3.3584e-05    4.65322e-05   0.000115094   3.8282e-05    2.33381e-05      10     
end_path:out1:RootOutput                           5.828e-06    7.2517e-06     1.044e-05     7.055e-06    1.23633e-06      10     
end_path:out1:RootOutput(write)                     1.72043       2.37116        2.874        2.29508      0.389342        10     
====================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5251.31 MB
  Peak resident set size usage (VmHWM): 4445.54 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.07 sec/event
ToolBasedRawDigitPrepService:dtor:                adcSampleFiller:   0.17 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.04 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   2.83 sec/event
ToolBasedRawDigitPrepService:dtor:         adcKeepAllSignalFinder:   0.15 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleKeToAdc:   0.04 sec/event
ToolBasedRawDigitPrepService:dtor:         pdsp_RemoveBadChannels:   0.00 sec/event
Art has completed and will exit with status 0.
lar exit code 0
.:
total 11291140
-rw-r--r-- 1 pildune22 pildune 2603293560 Dec 10 20:00 detsim_stage2.root
-rw-r--r-- 1 pildune22 pildune 2466235040 Dec 10 19:58 detsim_stage1.root
-rw-r--r-- 1 pildune22 pildune 2332733547 Dec 10 21:04 reco_stage1.root
-rw-r--r-- 1 pildune22 pildune 2078817182 Dec 10 18:46 g4_stage2.root
-rw-r--r-- 1 pildune22 pildune 1994626663 Dec 10 18:34 g4_stage1.root
-rw-r--r-- 1 pildune22 pildune   85803320 Dec 10 21:00 Pandora_Events.pndr
-rw-r--r-- 1 pildune22 pildune     242979 Dec 10 21:04 jobscript.log
-rw-r--r-- 1 pildune22 pildune     217088 Dec 10 21:04 mem.db
-rw-r--r-- 1 pildune22 pildune      62376 Dec 10 21:04 Pandora_Geometry.xml
-rw-r--r-- 1 pildune22 pildune      36864 Dec 10 21:04 time.db
-rw-r--r-- 1 pildune22 pildune        519 Dec 10 20:00 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 pildune22 pildune        519 Dec 10 18:46 g4_protoDUNE_hist.root
-rw-r--r-- 1 pildune22 pildune        519 Dec 10 21:04 protoDUNE_reco1_hist.root
-rw-r--r-- 1 pildune22 pildune         52 Dec 10 18:29 all-input-dids.txt
-rw-r--r-- 1 pildune22 pildune          7 Dec 10 21:04 justin-processed-pfns.txt
-rw-r--r-- 1 pildune22 pildune          0 Dec 10 20:06 ProtoDUNE.log
-rw-r--r-- 1 pildune22 pildune          0 Dec 10 20:00 debugprod.log
justIN time: 2026-02-07 13:29:33 UTC       justIN version: 01.06.00