Jobsub ID 14366.0@dunegpschedd02.fnal.gov
| Jobsub ID | 14366.0@dunegpschedd02.fnal.gov | 
| Workflow ID | 373 | 
| Stage ID | 1 | 
| User name | pmelas@fnal.gov | 
| HTCondor Group | group_dune | 
| Requested | Processors | 1 | 
| GPU | No | 
| RSS bytes | 8388608000 (8000 MiB) | 
| Wall seconds limit | 86400 (24 hours) | 
| Submitted time | 2025-08-04 18:10:09 | 
| Site | UK_Edinburgh | 
| Entry | DUNE_UK_SGridECDF_ce1_multicore | 
| Last heartbeat | 2025-08-04 20:23:09 | 
| From worker node | Hostname | node2b03.ecdf.ed.ac.uk | 
| cpuinfo | Intel(R) Xeon(R) Gold 6338 CPU @ 2.00GHz | 
| OS release | Scientific Linux release 7.9 (Nitrogen) | 
| Processors | 1 | 
| RSS bytes | 10485760000 (10000 MiB) | 
| Wall seconds limit | 171000 (47 hours) | 
| GPU |  | 
| Inner Apptainer? | True | 
| Job state | finished | 
| Started | 2025-08-04 18:11:19 | 
| Input files | monte-carlo-000373-000001
  | 
| Jobscript | Exit code | 0 | 
| Real time | 2h (7857s) | 
| CPU time | 2h (7688s = 97%) | 
| Max RSS bytes | 4075978752 (3887 MiB) | 
| Outputting started | 2025-08-04 20:22:17 | 
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/00373/1/001/reco_stage1.root
  | 
| Finished | 2025-08-04 20:23:09 | 
| Saved logs | justin-logs:14366.0-dunegpschedd02.fnal.gov.logs.tgz | 
| List job events     Cached HTCondor job logs | 
Jobscript log (last 10,000 characters)
wDigitPrepService: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 156853 traces, 0 summary
Retagger: tagging trace set: gauss with 118431 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 118431 traces tagged "gauss"
FrameSaver: q=4.19483e+06 n=2077031 tag=gauss
wclsFrameSaver: saving 156853 traces tagged "wiener"
FrameSaver: q=4.42713e+06 n=1824960 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 18835 XUs and 17442 XVs -> 248 XUVs
C:0 T:1 35028 XUs and 34791 XVs -> 2404 XUVs
C:0 T:2 70611 XUs and 146306 XVs -> 4988 XUVs
C:0 T:3 32162 XUs and 59705 XVs -> 341 XUVs
C:0 T:4 14339 XUs and 13329 XVs -> 114 XUVs
C:0 T:5 52175 XUs and 39801 XVs -> 3382 XUVs
C:0 T:6 122833 XUs and 191884 XVs -> 6955 XUVs
C:0 T:7 38403 XUs and 60875 XVs -> 626 XUVs
C:0 T:8 15275 XUs and 10267 XVs -> 143 XUVs
C:0 T:9 100481 XUs and 90775 XVs -> 6337 XUVs
C:0 T:10 44091 XUs and 46791 XVs -> 4446 XUVs
C:0 T:11 309 XUs and 526 XVs -> 51 XUVs
30035 XUVs total
13799 collection wire objects
26979 potential space points
Neighbour search...
897369 tests to find 469562 neighbours
Iterating with no regularization...
Begin: 1.12754e+08
0 9.46719e+07
1 9.3585e+07
2 9.34708e+07
3 9.34456e+07
Now with regularization...
Begin: 8.06757e+07
0 8.06349e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 408461856
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 408461856
fLifetime: 30000 [us]
04-Aug-2025 21:22:14 BST  Closed output file "reco_stage1.root"
04-Aug-2025 21:22:14 BST  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                                          208.146       294.594       344.14        306.498       43.4812        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.000597839   0.00320564    0.00616456    0.00323463     0.0015877       10     
reco:ophit:OpHitFinder                             0.200466      0.251656       0.29776      0.251422      0.0262539       10     
reco:opflash:OpFlashFinder                         0.114872       0.17328      0.201641      0.177921       0.02566        10     
reco:opslicer:OpSlicer                             0.418762       0.5201       0.599153      0.536254      0.0582224       10     
reco:caldata:DataPrepModule                         4.34775       4.49562       4.62028        4.497       0.0748543       10     
reco:wclsdatasp:WireCellToolkit                     35.2132       37.2809       39.6795       36.8402       1.44917        10     
reco:gaushit:GausHitFinder                         0.868143       1.1739        1.32288       1.19545      0.141247        10     
reco:nhitsfilter:NumberOfHitsFilter               0.00040348    0.000530626   0.000669207   0.000511095   8.61559e-05      10     
reco:reco3d:SpacePointSolver                        6.99542       12.5715       18.1922       13.3723       3.32647        10     
reco:hitpdune:DisambigFromSpacePoints              0.777439       1.29897       1.53007       1.38066      0.240928        10     
reco:pandora:StandardPandora                        16.7106       34.6731       54.8657       32.7777       13.2241        10     
reco:pandoraWriter:StandardPandora                 0.277765      0.366284      0.428088      0.383787      0.0466124       10     
reco:pandoraTrack:LArPandoraTrackCreation           2.13463       3.61923       4.93359       3.59732      0.779689        10     
reco:pandoraShower:LArPandoraShowerCreation         2.33152       4.23452       5.30982       4.64581       1.00008        10     
reco:pandoracalo:Calorimetry                        1.1296        1.99663       2.67126       1.99934      0.384384        10     
reco:pandoracalonosce:Calorimetry                   1.00743       1.80738       2.4061        1.82668      0.370801        10     
reco:pandorapid:Chi2ParticleID                    0.00339357    0.00458276    0.00547568    0.00452174    0.00059808       10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0296966     0.0668915     0.173388      0.0431318     0.053155        10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00340069    0.00436054     0.0052876    0.00436858    0.000566179      10     
reco:pandoraShowercalo:ShowerCalorimetry            2.12007       4.28263       5.31502       4.69401       1.05743        10     
reco:pandoraShowercalonosce:ShowerCalorimetry       2.03938       4.16635       5.22408       4.54288       1.03525        10     
reco:emtrkmichelid:EmTrackMichelId                  105.625       140.116       155.718       144.104       15.3857        10     
reco:crttag:SingleCRTMatchingProducer              0.0106977     0.0145317     0.0174296     0.0160851    0.00259568       10     
reco:crtreco:TwoCRTMatchingProducer               0.00637295    0.00862489     0.0100516    0.00896762    0.00104019       10     
reco:anodepiercerst0:T0RecoAnodePiercers            0.49951      0.897774       1.06442      0.975578      0.171775        10     
reco:pandora2Track:LArPandoraTrackCreation          6.81487       12.0475       14.974        12.7423       2.56211        10     
reco:pandora2calo:Calorimetry                       3.10992       5.91752       7.35552       6.28902       1.27857        10     
reco:pandora2calonosce:Calorimetry                  2.9462        5.64852       6.98551       6.00962       1.22203        10     
reco:pandora2pid:Chi2ParticleID                   0.00893277     0.0115193     0.014062      0.0116577    0.00158168       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0392242     0.0663831     0.184442      0.0550502     0.0398788       10     
reco:pandora2calipidnoxyzt:Chi2ParticleID         0.00898431     0.0114918     0.0138708     0.0116434    0.00153482       10     
reco:pandora2Shower:LArPandoraShowerCreation         2.666        4.4696        5.45627       4.6083       0.866773        10     
reco:pandora2Showercalo:ShowerCalorimetry           2.73138       5.21989       6.3797        5.44511       1.11411        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      2.55607       4.87614       6.14548       5.0514        1.04415        10     
[art]:TriggerResults:TriggerResultInserter        3.3548e-05    4.18415e-05   7.8776e-05    3.71315e-05   1.25312e-05      10     
end_path:out1:RootOutput                           4.977e-06    6.1226e-06    1.0376e-05    5.6305e-06    1.51759e-06      10     
end_path:out1:RootOutput(write)                     1.62887       2.21015       2.48251       2.28435      0.260802        10     
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
  Peak virtual memory usage (VmPeak)  : 4880.11 MB
  Peak resident set size usage (VmHWM): 4075.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.06 sec/event
ToolBasedRawDigitPrepService:dtor:                adcSampleFiller:   0.18 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.04 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   2.85 sec/event
ToolBasedRawDigitPrepService:dtor:         adcKeepAllSignalFinder:   0.12 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 10091184
-rw-r--r-- 1 gl05pi6 eddie_users 2382495030 Aug  4 20:31 detsim_stage2.root
-rw-r--r-- 1 gl05pi6 eddie_users 2260612423 Aug  4 20:29 detsim_stage1.root
-rw-r--r-- 1 gl05pi6 eddie_users 2090109874 Aug  4 21:22 reco_stage1.root
-rw-r--r-- 1 gl05pi6 eddie_users 1799369223 Aug  4 19:25 g4_stage2.root
-rw-r--r-- 1 gl05pi6 eddie_users 1719769614 Aug  4 19:16 g4_stage1.root
-rw-r--r-- 1 gl05pi6 eddie_users   80136230 Aug  4 21:18 Pandora_Events.pndr
-rw-r--r-- 1 gl05pi6 eddie_users     491749 Aug  4 21:22 jobscript.log
-rw-r--r-- 1 gl05pi6 eddie_users     217088 Aug  4 21:22 mem.db
-rw-r--r-- 1 gl05pi6 eddie_users      62376 Aug  4 21:22 Pandora_Geometry.xml
-rw-r--r-- 1 gl05pi6 eddie_users      36864 Aug  4 21:22 time.db
-rw-r--r-- 1 gl05pi6 eddie_users        519 Aug  4 20:31 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 gl05pi6 eddie_users        519 Aug  4 19:25 g4_protoDUNE_hist.root
-rw-r--r-- 1 gl05pi6 eddie_users        519 Aug  4 21:22 protoDUNE_reco1_hist.root
-rw-r--r-- 1 gl05pi6 eddie_users         52 Aug  4 19:11 all-input-dids.txt
-rw-r--r-- 1 gl05pi6 eddie_users          7 Aug  4 21:22 justin-processed-pfns.txt
-rw-r--r-- 1 gl05pi6 eddie_users          0 Aug  4 20:36 ProtoDUNE.log
-rw-r--r-- 1 gl05pi6 eddie_users          0 Aug  4 20:31 debugprod.log