justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 267430.0@dunegpschedd01.fnal.gov

Jobsub ID267430.0@dunegpschedd01.fnal.gov
Workflow ID11194
Stage ID1
User namepmelas@fnal.gov
HTCondor Groupgroup_dune
RequestedProcessors1
GPUNo
RSS bytes8388608000 (8000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2025-12-12 18:07:42
SiteUK_QMUL
EntryDUNE_UK_London_QMUL_arcce03
Last heartbeat2025-12-12 22:33:43
From worker nodeHostnamecn055.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-12 18:08:41
Input filesmonte-carlo-011194-000001
JobscriptExit code0
Real time4h (15693s)
CPU time4h (15443s = 98%)
Max RSS bytes4537602048 (4327 MiB)
Outputting started2025-12-12 22:30:14
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11194/1/001/reco_stage1.root
Finished2025-12-12 22:33:43
Saved logsjustin-logs:267430.0-dunegpschedd01.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

els
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 149792 traces, 0 summary
Retagger: tagging trace set: gauss with 115581 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 115581 traces tagged "gauss"
FrameSaver: q=4.14597e+06 n=2068025 tag=gauss
wclsFrameSaver: saving 149792 traces tagged "wiener"
FrameSaver: q=4.40118e+06 n=1841466 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 40814 XUs and 37510 XVs -> 1932 XUVs
C:0 T:1 106040 XUs and 103798 XVs -> 19388 XUVs
C:0 T:2 128080 XUs and 121826 XVs -> 5429 XUVs
C:0 T:3 64071 XUs and 52889 XVs -> 446 XUVs
C:0 T:4 8481 XUs and 10345 XVs -> 45 XUVs
C:0 T:5 34622 XUs and 40699 XVs -> 3279 XUVs
C:0 T:6 105945 XUs and 141939 XVs -> 4693 XUVs
C:0 T:7 44144 XUs and 55527 XVs -> 409 XUVs
C:0 T:8 6591 XUs and 8199 XVs -> 102 XUVs
C:0 T:9 50384 XUs and 82140 XVs -> 8513 XUVs
C:0 T:10 78096 XUs and 66969 XVs -> 6020 XUVs
C:0 T:11 436 XUs and 373 XVs -> 40 XUVs
50296 XUVs total
13077 collection wire objects
45151 potential space points
Neighbour search...
5042673 tests to find 2512194 neighbours
Iterating with no regularization...
Begin: 9.19427e+07
0 7.16344e+07
1 7.04859e+07
2 7.03054e+07
3 7.02465e+07
Now with regularization...
Begin: 5.79625e+07
0 5.78908e+07
1 5.78373e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
run: 1 ; subrun: 0 ; event: 10
evttime: 411076724
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411076724
fLifetime: 30000 [us]
12-Dec-2025 22:30:11 GMT  Closed output file "reco_stage1.root"
12-Dec-2025 22:30:11 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                                          525.827       700.826       930.961       683.809       127.127        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.000854938   0.00385342    0.00596378    0.00425054    0.00152687       10     
reco:ophit:OpHitFinder                             0.277679      0.383314      0.469175      0.382333      0.0531095       10     
reco:opflash:OpFlashFinder                         0.237291      0.277454      0.325013      0.281027      0.0264228       10     
reco:opslicer:OpSlicer                             0.623605      0.990523       1.24054      0.999414      0.165483        10     
reco:caldata:DataPrepModule                         6.06359       7.10523       7.92295       7.10041      0.646298        10     
reco:wclsdatasp:WireCellToolkit                     52.9031       57.7498       62.502        57.645        3.26148        10     
reco:gaushit:GausHitFinder                          1.3945        2.03984       2.65223       1.92996      0.363186        10     
reco:nhitsfilter:NumberOfHitsFilter               0.000858968    0.0010731    0.00153956    0.00103831     0.0001923       10     
reco:reco3d:SpacePointSolver                         13.57        24.5012       42.7432       25.2183       7.95169        10     
reco:hitpdune:DisambigFromSpacePoints               2.13692       3.59062       5.12983       3.4525        1.01894        10     
reco:pandora:StandardPandora                        38.606        71.0318       136.678       63.4723       27.5183        10     
reco:pandoraWriter:StandardPandora                 0.500197      0.725381      0.941593      0.782199      0.147741        10     
reco:pandoraTrack:LArPandoraTrackCreation           10.845        15.589        20.6146       15.3197       3.34219        10     
reco:pandoraShower:LArPandoraShowerCreation         12.0727       19.1913       27.0839       20.103        5.14996        10     
reco:pandoracalo:Calorimetry                        5.00368       7.32872       9.70909       6.9468        1.68419        10     
reco:pandoracalonosce:Calorimetry                   4.6077        7.13543       10.5655       6.46925       1.89354        10     
reco:pandorapid:Chi2ParticleID                    0.00513284    0.00932691     0.0126527    0.00887091    0.00243107       10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0595621     0.0898162     0.113047      0.0921401     0.0172308       10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00514013    0.00892207     0.0111407    0.00890921    0.00198187       10     
reco:pandoraShowercalo:ShowerCalorimetry            11.9713       19.1073       27.3379       19.1402       5.50239        10     
reco:pandoraShowercalonosce:ShowerCalorimetry       11.3818       18.7528       27.129        18.9012       5.54201        10     
reco:emtrkmichelid:EmTrackMichelId                  229.345       288.471       363.044       283.24        43.9086        10     
reco:crttag:SingleCRTMatchingProducer              0.0208695     0.0348715     0.0476108     0.0344781    0.00783824       10     
reco:crtreco:TwoCRTMatchingProducer                0.0187667     0.0301446     0.0390868     0.0294155    0.00586392       10     
reco:anodepiercerst0:T0RecoAnodePiercers            1.26463       1.49012       1.94698       1.46823      0.193506        10     
reco:pandora2Track:LArPandoraTrackCreation          37.5182       53.1639       68.0231       55.1853       10.5332        10     
reco:pandora2calo:Calorimetry                       16.975        23.3294       29.7377       22.998        4.76043        10     
reco:pandora2calonosce:Calorimetry                  16.2717       22.4082       28.158        22.6506       4.21298        10     
reco:pandora2pid:Chi2ParticleID                    0.0153939     0.022426      0.030459      0.021621     0.00502755       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0963018     0.117537      0.144326      0.115721      0.0150723       10     
reco:pandora2calipidnoxyzt:Chi2ParticleID          0.016918      0.0226812     0.0283903     0.0224632    0.00358174       10     
reco:pandora2Shower:LArPandoraShowerCreation        11.3428       15.5922       19.5514       15.3981       2.73348        10     
reco:pandora2Showercalo:ShowerCalorimetry           14.6691       19.7744       26.8172       19.2038       3.64675        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      12.7527       16.7086       23.0089       16.6495       2.83386        10     
[art]:TriggerResults:TriggerResultInserter        4.1636e-05    7.10311e-05   0.000168278   6.4188e-05    3.41587e-05      10     
end_path:out1:RootOutput                           7.842e-06    1.12903e-05   2.7816e-05    9.7155e-06    5.57466e-06      10     
end_path:out1:RootOutput(write)                     2.86606       3.85973       5.09073       3.58402      0.654484        10     
====================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5344.78 MB
  Peak resident set size usage (VmHWM): 4537.6 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.28 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.06 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   4.48 sec/event
ToolBasedRawDigitPrepService:dtor:         adcKeepAllSignalFinder:   0.25 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 11590904
-rw-r--r-- 1 pildune32 pildune 2658683887 Dec 12 20:30 detsim_stage2.root
-rw-r--r-- 1 pildune32 pildune 2518913818 Dec 12 20:27 detsim_stage1.root
-rw-r--r-- 1 pildune32 pildune 2390846990 Dec 12 22:30 reco_stage1.root
-rw-r--r-- 1 pildune32 pildune 2147202907 Dec 12 18:33 g4_stage2.root
-rw-r--r-- 1 pildune32 pildune 2067309327 Dec 12 18:15 g4_stage1.root
-rw-r--r-- 1 pildune32 pildune   85512700 Dec 12 22:21 Pandora_Events.pndr
-rw-r--r-- 1 pildune32 pildune     243164 Dec 12 22:30 jobscript.log
-rw-r--r-- 1 pildune32 pildune     217088 Dec 12 22:30 mem.db
-rw-r--r-- 1 pildune32 pildune      62376 Dec 12 22:30 Pandora_Geometry.xml
-rw-r--r-- 1 pildune32 pildune      36864 Dec 12 22:30 time.db
-rw-r--r-- 1 pildune32 pildune        519 Dec 12 20:30 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 pildune32 pildune        519 Dec 12 18:33 g4_protoDUNE_hist.root
-rw-r--r-- 1 pildune32 pildune        519 Dec 12 22:30 protoDUNE_reco1_hist.root
-rw-r--r-- 1 pildune32 pildune         52 Dec 12 18:08 all-input-dids.txt
-rw-r--r-- 1 pildune32 pildune          7 Dec 12 22:30 justin-processed-pfns.txt
-rw-r--r-- 1 pildune32 pildune          0 Dec 12 20:43 ProtoDUNE.log
-rw-r--r-- 1 pildune32 pildune          0 Dec 12 20:30 debugprod.log
justIN time: 2025-12-20 01:55:46 UTC       justIN version: 01.05.03