justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 269087.1@dunegpschedd01.fnal.gov

Jobsub ID269087.1@dunegpschedd01.fnal.gov
Workflow ID11261
Stage ID1
User namepmelas@fnal.gov
HTCondor Groupgroup_dune
RequestedProcessors1
GPUNo
RSS bytes8388608000 (8000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2025-12-18 16:44:59
SiteUK_QMUL
EntryDUNE_UK_London_QMUL_arcce03
Last heartbeat2025-12-18 20:20:20
From worker nodeHostnamecn067.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-18 16:45:50
Input filesmonte-carlo-011261-000001
JobscriptExit code0
Real time3h (12477s)
CPU time3h (12299s = 98%)
Max RSS bytes4609982464 (4396 MiB)
Outputting started2025-12-18 20:13:48
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/11261/1/001/reco_stage1.root
Finished2025-12-18 20:20:20
Saved logsjustin-logs:269087.1-dunegpschedd01.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

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 165882 traces, 0 summary
Retagger: tagging trace set: gauss with 129080 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 129080 traces tagged "gauss"
FrameSaver: q=4.43797e+06 n=2342008 tag=gauss
wclsFrameSaver: saving 165882 traces tagged "wiener"
FrameSaver: q=4.69355e+06 n=2095043 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 37975 XUs and 35892 XVs -> 289 XUVs
C:0 T:1 72436 XUs and 64988 XVs -> 4310 XUVs
C:0 T:2 148028 XUs and 171973 XVs -> 8103 XUVs
C:0 T:3 62292 XUs and 72090 XVs -> 659 XUVs
C:0 T:4 16785 XUs and 16249 XVs -> 157 XUVs
C:0 T:5 72042 XUs and 57193 XVs -> 5640 XUVs
C:0 T:6 92875 XUs and 112265 XVs -> 3776 XUVs
C:0 T:7 37917 XUs and 46390 XVs -> 380 XUVs
C:0 T:8 11210 XUs and 12869 XVs -> 312 XUVs
C:0 T:9 68425 XUs and 91006 XVs -> 9729 XUVs
C:0 T:10 80215 XUs and 62681 XVs -> 6476 XUVs
C:0 T:11 169 XUs and 119 XVs -> 11 XUVs
39842 XUVs total
15561 collection wire objects
36123 potential space points
Neighbour search...
2030257 tests to find 1059458 neighbours
Iterating with no regularization...
Begin: 7.61061e+07
0 6.21162e+07
1 6.10017e+07
2 6.08557e+07
3 6.08182e+07
Now with regularization...
Begin: 4.78596e+07
0 4.78251e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
run: 1 ; subrun: 0 ; event: 10
evttime: 411196496
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 411196496
fLifetime: 30000 [us]
18-Dec-2025 20:13:46 GMT  Closed output file "reco_stage1.root"
18-Dec-2025 20:13:46 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                                          379.279       553.978       753.801       528.525       114.131        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.00111155    0.00358169    0.00602875    0.00351172    0.00150019       10     
reco:ophit:OpHitFinder                              0.2673       0.303053       0.35432      0.300034      0.024798        10     
reco:opflash:OpFlashFinder                         0.219317      0.276038      0.345141      0.285478      0.0410012       10     
reco:opslicer:OpSlicer                             0.538545      0.724989      0.851009      0.755268      0.105041        10     
reco:caldata:DataPrepModule                         5.27346       5.48191       5.8424        5.45425       0.16199        10     
reco:wclsdatasp:WireCellToolkit                     46.536        49.6045       54.6666       49.2077       2.02623        10     
reco:gaushit:GausHitFinder                          1.05988       1.61872       2.00228       1.59904      0.279595        10     
reco:nhitsfilter:NumberOfHitsFilter               0.000726307   0.000977041   0.00113874    0.000990068   0.000138984      10     
reco:reco3d:SpacePointSolver                        11.1521       17.2199       25.7342       15.487        4.51305        10     
reco:hitpdune:DisambigFromSpacePoints               1.58507        2.737        4.10185       2.52589      0.764064        10     
reco:pandora:StandardPandora                        29.7238       56.446        81.1681       50.8175       19.444         10     
reco:pandoraWriter:StandardPandora                 0.411945      0.563972      0.692472      0.554429      0.0851578       10     
reco:pandoraTrack:LArPandoraTrackCreation           9.87848       13.5808       19.1227       12.7591       2.95692        10     
reco:pandoraShower:LArPandoraShowerCreation         9.49702       18.3286       27.6307       17.8073       5.60863        10     
reco:pandoracalo:Calorimetry                        4.56674       6.15205       9.15646       5.62176       1.45934        10     
reco:pandoracalonosce:Calorimetry                   4.17203       5.87399       8.81533       5.42143       1.43121        10     
reco:pandorapid:Chi2ParticleID                    0.00542601    0.00646626    0.00752969    0.00653944    0.000654528      10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0524482     0.0720376     0.0857781     0.0714157    0.00997228       10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00533456    0.00617871    0.00732763     0.006117     0.000704324      10     
reco:pandoraShowercalo:ShowerCalorimetry            7.59264       16.2393       25.3322       15.8117       5.32474        10     
reco:pandoraShowercalonosce:ShowerCalorimetry       7.70287       15.8725       25.1332       14.9757       5.25511        10     
reco:emtrkmichelid:EmTrackMichelId                  153.082       209.567       264.649       205.817       33.8887        10     
reco:crttag:SingleCRTMatchingProducer              0.0232276     0.0339852     0.0430382     0.0332332    0.00548648       10     
reco:crtreco:TwoCRTMatchingProducer                0.0195043     0.0281676     0.0336322     0.0286756    0.00368258       10     
reco:anodepiercerst0:T0RecoAnodePiercers            1.04249       1.32171       1.49808       1.32248      0.133629        10     
reco:pandora2Track:LArPandoraTrackCreation          28.8248       47.5816       69.9364       46.329        12.4618        10     
reco:pandora2calo:Calorimetry                       11.645        20.2916       30.7999       19.5372       5.56353        10     
reco:pandora2calonosce:Calorimetry                  11.074        19.108        29.9292       18.4873       5.41654        10     
reco:pandora2pid:Chi2ParticleID                    0.0116659     0.0162934     0.0234391     0.0154798    0.00322163       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0645513     0.0931029     0.125101       0.09399      0.0163635       10     
reco:pandora2calipidnoxyzt:Chi2ParticleID          0.0115274     0.0156324     0.021448      0.0152108    0.00281936       10     
reco:pandora2Shower:LArPandoraShowerCreation        8.63134       13.8041       21.2872       13.9947       3.80406        10     
reco:pandora2Showercalo:ShowerCalorimetry           9.20721       15.1985       23.7143       15.0235       4.15887        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      7.00559       12.5216       20.6255       12.3409       3.79011        10     
[art]:TriggerResults:TriggerResultInserter        4.5465e-05    5.59632e-05   0.000121145   4.76515e-05   2.19611e-05      10     
end_path:out1:RootOutput                           7.453e-06    8.5397e-06    1.2806e-05    7.9705e-06    1.4979e-06       10     
end_path:out1:RootOutput(write)                     2.23251       3.09718       4.12141       3.04222      0.549792        10     
====================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5420.27 MB
  Peak resident set size usage (VmHWM): 4609.98 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.42 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 11599884
-rw-r--r-- 1 pildune32 pildune 2666301511 Dec 18 18:39 detsim_stage2.root
-rw-r--r-- 1 pildune32 pildune 2525213215 Dec 18 18:37 detsim_stage1.root
-rw-r--r-- 1 pildune32 pildune 2411551293 Dec 18 20:13 reco_stage1.root
-rw-r--r-- 1 pildune32 pildune 2136354949 Dec 18 17:07 g4_stage2.root
-rw-r--r-- 1 pildune32 pildune 2049504982 Dec 18 16:51 g4_stage1.root
-rw-r--r-- 1 pildune32 pildune   88739440 Dec 18 20:05 Pandora_Events.pndr
-rw-r--r-- 1 pildune32 pildune     242953 Dec 18 20:13 jobscript.log
-rw-r--r-- 1 pildune32 pildune     217088 Dec 18 20:13 mem.db
-rw-r--r-- 1 pildune32 pildune      62376 Dec 18 20:13 Pandora_Geometry.xml
-rw-r--r-- 1 pildune32 pildune      36864 Dec 18 20:13 time.db
-rw-r--r-- 1 pildune32 pildune        519 Dec 18 18:39 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 pildune32 pildune        519 Dec 18 17:07 g4_protoDUNE_hist.root
-rw-r--r-- 1 pildune32 pildune        519 Dec 18 20:13 protoDUNE_reco1_hist.root
-rw-r--r-- 1 pildune32 pildune         52 Dec 18 16:45 all-input-dids.txt
-rw-r--r-- 1 pildune32 pildune          7 Dec 18 20:13 justin-processed-pfns.txt
-rw-r--r-- 1 pildune32 pildune          0 Dec 18 18:46 ProtoDUNE.log
-rw-r--r-- 1 pildune32 pildune          0 Dec 18 18:39 debugprod.log
justIN time: 2025-12-19 07:15:09 UTC       justIN version: 01.05.03