Jobsub ID 236335.1@dunegpschedd02.fnal.gov
| Jobsub ID | 236335.1@dunegpschedd02.fnal.gov | 
| Workflow ID | 9525 | 
| 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-11-02 14:19:37 | 
| Site | NL_SURFsara | 
| Entry | DUNE_SurfSARA_arc03 | 
| Last heartbeat | 2025-11-02 18:38:20 | 
| From worker node | Hostname | wn-da-20.gina.surf.nl | 
| cpuinfo | AMD EPYC 7702P 64-Core Processor | 
| OS release | Scientific Linux release 7.9 (Nitrogen) | 
| Processors | 1 | 
| RSS bytes | 10485760000 (10000 MiB) | 
| Wall seconds limit | 129600 (36 hours) | 
| GPU |  | 
| Inner Apptainer? | True | 
| Job state | finished | 
| Started | 2025-11-02 14:20:58 | 
| Input files | monte-carlo-009525-000001
  | 
| Jobscript | Exit code | 0 | 
| Real time | 4h (15356s) | 
| CPU time | 4h (15257s = 99%) | 
| Max RSS bytes | 4501831680 (4293 MiB) | 
| Outputting started | 2025-11-02 18:36:55 | 
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/09525/1/001/reco_stage1.root
  | 
| Finished | 2025-11-02 18:38:20 | 
| Saved logs | justin-logs:236335.1-dunegpschedd02.fnal.gov.logs.tgz | 
| List job events     Cached HTCondor job logs | 
Jobscript log (last 10,000 characters)
gnalFinder
ToolBasedRawDigitPrepService:prepare:   Running tool adcScaleKeToAdc
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 141134 traces, 0 summary
Retagger: tagging trace set: gauss with 102423 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 102423 traces tagged "gauss"
FrameSaver: q=3.70229e+06 n=1771650 tag=gauss
wclsFrameSaver: saving 141134 traces tagged "wiener"
FrameSaver: q=3.93414e+06 n=1549378 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 41015 XUs and 40626 XVs -> 693 XUVs
C:0 T:1 81457 XUs and 87239 XVs -> 9809 XUVs
C:0 T:2 112620 XUs and 153849 XVs -> 15629 XUVs
C:0 T:3 48612 XUs and 55123 XVs -> 820 XUVs
C:0 T:4 8731 XUs and 8166 XVs -> 59 XUVs
C:0 T:5 33834 XUs and 21167 XVs -> 2649 XUVs
C:0 T:6 112065 XUs and 146961 XVs -> 9083 XUVs
C:0 T:7 42588 XUs and 53363 XVs -> 425 XUVs
C:0 T:8 7743 XUs and 8150 XVs -> 64 XUVs
C:0 T:9 55319 XUs and 71171 XVs -> 4915 XUVs
C:0 T:10 25184 XUs and 46946 XVs -> 4388 XUVs
C:0 T:11 115 XUs and 57 XVs -> 11 XUVs
48545 XUVs total
11705 collection wire objects
40780 potential space points
Neighbour search...
3411076 tests to find 1820694 neighbours
Iterating with no regularization...
Begin: 8.39541e+07
0 6.71921e+07
1 6.60824e+07
2 6.58921e+07
3 6.58294e+07
Now with regularization...
Begin: 5.40934e+07
0 5.40179e+07
1 5.39793e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 410269064
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 410269064
fLifetime: 30000 [us]
02-Nov-2025 19:36:53 CET  Closed output file "reco_stage1.root"
02-Nov-2025 19:36:53 CET  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                                          407.324       518.39        704.585       484.209       83.9857        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.00107904     0.0055242    0.00906555    0.00610195    0.00268306       10     
reco:ophit:OpHitFinder                              0.28502      0.327275      0.403584       0.31857      0.0350222       10     
reco:opflash:OpFlashFinder                         0.190109      0.234075      0.331036      0.224244      0.0417874       10     
reco:opslicer:OpSlicer                             0.610368      0.786694       1.06425      0.764293       0.11271        10     
reco:caldata:DataPrepModule                         5.16571       5.39609       5.81939       5.37666      0.176256        10     
reco:wclsdatasp:WireCellToolkit                     40.6706       77.3441       90.4625       86.3495       17.9878        10     
reco:gaushit:GausHitFinder                          1.09109       1.47739       2.00907       1.3611       0.273371        10     
reco:nhitsfilter:NumberOfHitsFilter               0.000496147   0.000811639   0.00122344    0.000825299   0.00024412       10     
reco:reco3d:SpacePointSolver                        7.88444       18.2272       29.1128       17.556        5.61445        10     
reco:hitpdune:DisambigFromSpacePoints               1.18527       1.87982       2.9718        1.69188      0.530887        10     
reco:pandora:StandardPandora                        27.7917       49.9535       93.7986       43.6927       18.9024        10     
reco:pandoraWriter:StandardPandora                 0.405037      0.526273       0.66797      0.500517      0.0762499       10     
reco:pandoraTrack:LArPandoraTrackCreation           4.62128       7.26154       11.138        7.36592       1.68239        10     
reco:pandoraShower:LArPandoraShowerCreation         4.23218       8.69038       18.224        6.91125       4.07103        10     
reco:pandoracalo:Calorimetry                        2.2248        3.93251       6.81758       3.68909       1.18105        10     
reco:pandoracalonosce:Calorimetry                   2.19602       3.68732       6.44856        3.372        1.11256        10     
reco:pandorapid:Chi2ParticleID                    0.00568115    0.00734964     0.0103593    0.00700659    0.00129133       10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0495836     0.0607793     0.0810747     0.0567533    0.00981554       10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00570032    0.00695556    0.00847431    0.00693017    0.000830287      10     
reco:pandoraShowercalo:ShowerCalorimetry            4.37412       8.51319       18.2597       6.93874       4.11693        10     
reco:pandoraShowercalonosce:ShowerCalorimetry       4.25282       7.83481       15.4307       6.51264       3.37629        10     
reco:emtrkmichelid:EmTrackMichelId                  202.354       246.617       317.593       229.407       37.2487        10     
reco:crttag:SingleCRTMatchingProducer              0.0115052     0.0184844     0.0294089     0.0174334    0.00547197       10     
reco:crtreco:TwoCRTMatchingProducer               0.00958312     0.0148557     0.0202759     0.0150116    0.00360513       10     
reco:anodepiercerst0:T0RecoAnodePiercers           0.884785       1.0624        1.37325       1.01263      0.156622        10     
reco:pandora2Track:LArPandoraTrackCreation          15.2482       22.6907       35.0473       19.3532       6.91668        10     
reco:pandora2calo:Calorimetry                       7.33055       11.1239       17.6746       10.1924       3.47895        10     
reco:pandora2calonosce:Calorimetry                  7.02922       10.588        16.577        9.72592       3.10012        10     
reco:pandora2pid:Chi2ParticleID                    0.0133853     0.0173009     0.0215189     0.0162383    0.00270656       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0614884     0.0777072     0.102005      0.0713078     0.0127022       10     
reco:pandora2calipidnoxyzt:Chi2ParticleID          0.0129383     0.0173201     0.0216457     0.0163283    0.00287153       10     
reco:pandora2Shower:LArPandoraShowerCreation        5.44559       8.57848       12.8275       8.30315       2.59451        10     
reco:pandora2Showercalo:ShowerCalorimetry           6.1903        9.39594       14.6228       9.46037       2.67784        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      5.26572       8.35838       12.3642       8.91413       2.3533         10     
[art]:TriggerResults:TriggerResultInserter        3.2472e-05    5.33286e-05   0.000126572   3.8448e-05    2.91687e-05      10     
end_path:out1:RootOutput                           5.861e-06    7.5904e-06    1.1792e-05     6.888e-06    1.69482e-06      10     
end_path:out1:RootOutput(write)                     2.7231        3.46931       4.49059       3.22168      0.581889        10     
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
  Peak virtual memory usage (VmPeak)  : 5303.64 MB
  Peak resident set size usage (VmHWM): 4501.83 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.23 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.05 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   3.37 sec/event
ToolBasedRawDigitPrepService:dtor:         adcKeepAllSignalFinder:   0.12 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 10920912
-rw-r--r--. 1 dune009 dune 2541573394 Nov  2 18:08 detsim_stage2.root
-rw-r--r--. 1 dune009 dune 2410288039 Nov  2 18:05 detsim_stage1.root
-rw-r--r--. 1 dune009 dune 2259058538 Nov  2 19:36 reco_stage1.root
-rw-r--r--. 1 dune009 dune 1988684721 Nov  2 15:42 g4_stage2.root
-rw-r--r--. 1 dune009 dune 1899955338 Nov  2 15:27 g4_stage1.root
-rw-r--r--. 1 dune009 dune   82644890 Nov  2 19:31 Pandora_Events.pndr
-rw-r--r--. 1 dune009 dune     243434 Nov  2 19:36 jobscript.log
-rw-r--r--. 1 dune009 dune     217088 Nov  2 19:36 mem.db
-rw-r--r--. 1 dune009 dune      62376 Nov  2 19:36 Pandora_Geometry.xml
-rw-r--r--. 1 dune009 dune      36864 Nov  2 19:36 time.db
-rw-r--r--. 1 dune009 dune        519 Nov  2 18:08 detsim_single_protoDUNE_hist.root
-rw-r--r--. 1 dune009 dune        519 Nov  2 15:42 g4_protoDUNE_hist.root
-rw-r--r--. 1 dune009 dune        519 Nov  2 19:36 protoDUNE_reco1_hist.root
-rw-r--r--. 1 dune009 dune         52 Nov  2 15:20 all-input-dids.txt
-rw-r--r--. 1 dune009 dune          7 Nov  2 19:36 justin-processed-pfns.txt
-rw-r--r--. 1 dune009 dune          0 Nov  2 18:17 ProtoDUNE.log
-rw-r--r--. 1 dune009 dune          0 Nov  2 18:08 debugprod.log