justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 233186.0@dunegpschedd02.fnal.gov

Jobsub ID233186.0@dunegpschedd02.fnal.gov
Workflow ID9371
Stage ID1
User namepmelas@fnal.gov
HTCondor Groupgroup_dune
RequestedProcessors1
GPUNo
RSS bytes8388608000 (8000 MiB)
Wall seconds limit86400 (24 hours)
Submitted time2025-10-27 06:10:33
SiteUK_Sheffield
EntryDUNE_UK_Sheffield_lcgce2
Last heartbeat2025-10-27 11:14:32
From worker nodeHostnamewn016.hep
cpuinfoIntel(R) Core(TM) i7-5960X CPU @ 3.00GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes10485760000 (10000 MiB)
Wall seconds limit257400 (71 hours)
GPU
Inner Apptainer?True
Job statefinished
Started2025-10-27 06:12:16
Input filesmonte-carlo-009371-000001
JobscriptExit code0
Real time4h (15849s)
CPU time4h (15507s = 97%)
Max RSS bytes4168876032 (3975 MiB)
Outputting started2025-10-27 10:36:26
Output fileshttps://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/09371/1/001/reco_stage1.root
Finished2025-10-27 11:14:32
Saved logsjustin-logs:233186.0-dunegpschedd02.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

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 136355 traces, 0 summary
Retagger: tagging trace set: gauss with 103834 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 103834 traces tagged "gauss"
FrameSaver: q=3.53704e+06 n=1823455 tag=gauss
wclsFrameSaver: saving 136355 traces tagged "wiener"
FrameSaver: q=3.73738e+06 n=1603577 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 26383 XUs and 29907 XVs -> 293 XUVs
C:0 T:1 65772 XUs and 54614 XVs -> 3882 XUVs
C:0 T:2 142962 XUs and 294495 XVs -> 23566 XUVs
C:0 T:3 43957 XUs and 50198 XVs -> 408 XUVs
C:0 T:4 12817 XUs and 13457 XVs -> 79 XUVs
C:0 T:5 41841 XUs and 38550 XVs -> 4185 XUVs
C:0 T:6 209015 XUs and 163203 XVs -> 35379 XUVs
C:0 T:7 45421 XUs and 33850 XVs -> 666 XUVs
C:0 T:9 60395 XUs and 82346 XVs -> 4725 XUVs
C:0 T:10 64849 XUs and 40050 XVs -> 14621 XUVs
C:0 T:11 121 XUs and 84 XVs -> 10 XUVs
87814 XUVs total
12510 collection wire objects
81725 potential space points
Neighbour search...
25682185 tests to find 9874830 neighbours
Iterating with no regularization...
Begin: 8.55121e+07
0 6.01253e+07
1 5.90262e+07
2 5.8882e+07
3 5.8835e+07
Now with regularization...
Begin: 4.93509e+07
0 4.92935e+07
1 4.92524e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
run: 1 ; subrun: 0 ; event: 10
evttime: 410141626
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 410141626
fLifetime: 30000 [us]
27-Oct-2025 10:36:24 GMT  Closed output file "reco_stage1.root"
27-Oct-2025 10:36:24 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                                          466.565       598.132       916.79        564.513       128.233        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.00103454    0.00392194     0.0063386     0.0040311    0.00169513       10     
reco:ophit:OpHitFinder                             0.335906      0.379119      0.480666       0.36054      0.045682        10     
reco:opflash:OpFlashFinder                          0.16786      0.205611      0.297532      0.192986      0.038987        10     
reco:opslicer:OpSlicer                             0.834383       1.0619        1.45474       1.01846      0.210072        10     
reco:caldata:DataPrepModule                         7.94297       8.52275       9.58824       8.19381      0.657558        10     
reco:wclsdatasp:WireCellToolkit                     51.7973       62.7106       71.2427       62.9293       5.5993         10     
reco:gaushit:GausHitFinder                          1.80468       2.20833       3.4213        2.04806      0.455881        10     
reco:nhitsfilter:NumberOfHitsFilter               0.000539274   0.000724237   0.000976051   0.000748711   0.000121312      10     
reco:reco3d:SpacePointSolver                        11.4921       27.7549       47.4103       25.7566       12.3638        10     
reco:hitpdune:DisambigFromSpacePoints               2.88911       4.21231       7.49108       3.73955       1.38508        10     
reco:pandora:StandardPandora                        35.2131       64.1128       131.965       55.2924       27.7373        10     
reco:pandoraWriter:StandardPandora                 0.518607       0.6316       0.882739      0.603894      0.100882        10     
reco:pandoraTrack:LArPandoraTrackCreation           4.70582       7.30087       12.5221       6.73054       2.25384        10     
reco:pandoraShower:LArPandoraShowerCreation         3.40451       6.93503       15.4406       5.53586       3.34149        10     
reco:pandoracalo:Calorimetry                        2.51561       3.82197       6.40488       3.58694       1.07781        10     
reco:pandoracalonosce:Calorimetry                   2.27199       3.47032       5.90039       3.23696       1.0298         10     
reco:pandorapid:Chi2ParticleID                    0.00791509     0.0105755     0.0132192     0.0102912    0.00142374       10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.079199      0.0950833      0.12104      0.0919896     0.0120687       10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00819407     0.0102392     0.0128259     0.0101441    0.00148727       10     
reco:pandoraShowercalo:ShowerCalorimetry            3.48684       7.34603       16.0477       6.21134       3.48956        10     
reco:pandoraShowercalonosce:ShowerCalorimetry       3.38369       7.15527       15.6131       6.03732       3.39509        10     
reco:emtrkmichelid:EmTrackMichelId                  265.635       313.096       439.265       297.602       49.0228        10     
reco:crttag:SingleCRTMatchingProducer              0.0137233     0.0193068     0.0239029     0.0194313    0.00326445       10     
reco:crtreco:TwoCRTMatchingProducer                0.0115349     0.0149949     0.0206316     0.0142595    0.00274421       10     
reco:anodepiercerst0:T0RecoAnodePiercers            1.60826       2.02949       2.48529       1.90906      0.319773        10     
reco:pandora2Track:LArPandoraTrackCreation          12.6399       23.5349       46.8753       19.7573       9.52094        10     
reco:pandora2calo:Calorimetry                       5.80266       10.7657       21.3207       9.21968       4.27561        10     
reco:pandora2calonosce:Calorimetry                  5.40927       10.2167       20.2409       8.87692       4.07126        10     
reco:pandora2pid:Chi2ParticleID                    0.0201423     0.0257684     0.0394554     0.0235979    0.00578692       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0991785      0.12138      0.170469      0.115409      0.0209049       10     
reco:pandora2calipidnoxyzt:Chi2ParticleID          0.0195624     0.0255939     0.0394454     0.0238569    0.00606011       10     
reco:pandora2Shower:LArPandoraShowerCreation        4.40763       7.90387       14.7213       6.9235         2.816         10     
reco:pandora2Showercalo:ShowerCalorimetry           5.02359       9.41601       18.015        8.30331       3.58301        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      4.71065       8.73692       16.4471       7.74346       3.25471        10     
[art]:TriggerResults:TriggerResultInserter        3.6851e-05    5.25113e-05   0.000124396   4.4447e-05    2.49473e-05      10     
end_path:out1:RootOutput                           4.976e-06    6.2262e-06    1.1212e-05     5.707e-06    1.70015e-06      10     
end_path:out1:RootOutput(write)                     3.3224        4.17028       5.5019        4.14345      0.590096        10     
====================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4969.08 MB
  Peak resident set size usage (VmHWM): 4168.88 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.34 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.05 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   5.69 sec/event
ToolBasedRawDigitPrepService:dtor:         adcKeepAllSignalFinder:   0.27 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleKeToAdc:   0.05 sec/event
ToolBasedRawDigitPrepService:dtor:         pdsp_RemoveBadChannels:   0.01 sec/event
Art has completed and will exit with status 0.
lar exit code 0
.:
total 10188736
-rw-r--r--. 1 dune004 dune 2390797123 Oct 27 08:54 detsim_stage2.root
-rw-r--r--. 1 dune004 dune 2269348977 Oct 27 08:50 detsim_stage1.root
-rw-r--r--. 1 dune004 dune 2072001033 Oct 27 10:36 reco_stage1.root
-rw-r--r--. 1 dune004 dune 1860225410 Oct 27 06:40 g4_stage2.root
-rw-r--r--. 1 dune004 dune 1766889642 Oct 27 06:21 g4_stage1.root
-rw-r--r--. 1 dune004 dune   73389270 Oct 27 10:28 Pandora_Events.pndr
-rw-r--r--. 1 dune004 dune     242957 Oct 27 10:36 jobscript.log
-rw-r--r--. 1 dune004 dune     217088 Oct 27 10:36 mem.db
-rw-r--r--. 1 dune004 dune      62376 Oct 27 10:36 Pandora_Geometry.xml
-rw-r--r--. 1 dune004 dune      36864 Oct 27 10:36 time.db
-rw-r--r--. 1 dune004 dune        519 Oct 27 08:54 detsim_single_protoDUNE_hist.root
-rw-r--r--. 1 dune004 dune        519 Oct 27 06:40 g4_protoDUNE_hist.root
-rw-r--r--. 1 dune004 dune        519 Oct 27 10:36 protoDUNE_reco1_hist.root
-rw-r--r--. 1 dune004 dune         52 Oct 27 06:12 all-input-dids.txt
-rw-r--r--. 1 dune004 dune          7 Oct 27 10:36 justin-processed-pfns.txt
-rw-r--r--. 1 dune004 dune          0 Oct 27 09:01 ProtoDUNE.log
-rw-r--r--. 1 dune004 dune          0 Oct 27 08:54 debugprod.log
justIN time: 2025-11-03 18:41:12 UTC       justIN version: 01.05.01