Jobsub ID 233012.1@dunegpschedd02.fnal.gov
| Jobsub ID | 233012.1@dunegpschedd02.fnal.gov | 
| Workflow ID | 9349 | 
| 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-10-26 07:14:19 | 
| Site | UK_Brunel | 
| Entry | CMSHTPC_T2_UK_London_Brunel_dc2_26 | 
| Last heartbeat | 2025-10-26 10:45:01 | 
| From worker node | Hostname | wn-a4-10 | 
| cpuinfo | AMD EPYC 7452 32-Core Processor | 
| 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-10-26 07:15:26 | 
| Input files | monte-carlo-009349-000001
  | 
| Jobscript | Exit code | 0 | 
| Real time | 3h (12168s) | 
| CPU time | 3h (11789s = 96%) | 
| Max RSS bytes | 4356288512 (4154 MiB) | 
| Outputting started | 2025-10-26 10:39:14 | 
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/09349/1/001/reco_stage1.root
  | 
| Finished | 2025-10-26 10:45:01 | 
| Saved logs | justin-logs:233012.1-dunegpschedd02.fnal.gov.logs.tgz | 
| List job events     Cached HTCondor job logs | 
Jobscript log (last 10,000 characters)
lBasedRawDigitPrepService: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 134947 traces, 0 summary
Retagger: tagging trace set: gauss with 103733 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 103733 traces tagged "gauss"
FrameSaver: q=3.66451e+06 n=1865896 tag=gauss
wclsFrameSaver: saving 134947 traces tagged "wiener"
FrameSaver: q=3.87474e+06 n=1659396 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 37429 XUs and 33398 XVs -> 556 XUVs
C:0 T:1 66993 XUs and 59239 XVs -> 5195 XUVs
C:0 T:2 51163 XUs and 59906 XVs -> 3461 XUVs
C:0 T:3 24137 XUs and 27071 XVs -> 203 XUVs
C:0 T:4 18575 XUs and 16974 XVs -> 164 XUVs
C:0 T:5 88059 XUs and 67642 XVs -> 5221 XUVs
C:0 T:6 107712 XUs and 99447 XVs -> 4775 XUVs
C:0 T:7 44731 XUs and 40285 XVs -> 470 XUVs
C:0 T:8 9763 XUs and 6843 XVs -> 56 XUVs
C:0 T:9 54933 XUs and 56322 XVs -> 4104 XUVs
C:0 T:10 45359 XUs and 36176 XVs -> 4895 XUVs
C:0 T:11 26 XUs and 42 XVs -> 3 XUVs
29103 XUVs total
11885 collection wire objects
26553 potential space points
Neighbour search...
1129665 tests to find 592602 neighbours
Iterating with no regularization...
Begin: 7.1873e+07
0 6.07508e+07
1 5.98155e+07
2 5.96836e+07
3 5.96475e+07
Now with regularization...
Begin: 4.89955e+07
0 4.89689e+07
run: 1 ; subrun: 0 ; event: 10
evttime: 410122336
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 410122336
fLifetime: 30000 [us]
26-Oct-2025 10:38:12 GMT  Closed output file "reco_stage1.root"
26-Oct-2025 10:38:12 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                                          282.236       378.974       486.414       390.726       66.4648        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                            0.000811073   0.00333712    0.00493803     0.0037156    0.00129075       10     
reco:ophit:OpHitFinder                             0.251485      0.312308       0.35347      0.310097      0.0287968       10     
reco:opflash:OpFlashFinder                         0.158894      0.216508       0.27921      0.220093       0.03288        10     
reco:opslicer:OpSlicer                             0.513034      0.744692      0.902084      0.750728      0.106263        10     
reco:caldata:DataPrepModule                         4.76889       5.1373        5.49515       5.12016      0.226879        10     
reco:wclsdatasp:WireCellToolkit                     31.4336       36.1549       38.8911       36.8244       2.55181        10     
reco:gaushit:GausHitFinder                         0.881016       1.13771       1.37887       1.15788      0.180836        10     
reco:nhitsfilter:NumberOfHitsFilter               0.000424942   0.000578154   0.000838664    0.0005546    0.000113352      10     
reco:reco3d:SpacePointSolver                        7.71471       15.3663       24.1735       14.5848       4.9012         10     
reco:hitpdune:DisambigFromSpacePoints               1.17722       1.68002       2.40923       1.72814      0.380916        10     
reco:pandora:StandardPandora                        16.0275       35.518        62.5325       31.6158       13.3471        10     
reco:pandoraWriter:StandardPandora                 0.363299      0.481321      0.691657      0.472086      0.0937496       10     
reco:pandoraTrack:LArPandoraTrackCreation           3.05946       4.62402       6.43201       4.37116       1.09649        10     
reco:pandoraShower:LArPandoraShowerCreation         2.45791       4.98912       8.03023       5.10166       1.62236        10     
reco:pandoracalo:Calorimetry                        1.54397       2.28781       3.20018       2.15033      0.539726        10     
reco:pandoracalonosce:Calorimetry                   1.39453       2.07208       2.89073       1.96529      0.474098        10     
reco:pandorapid:Chi2ParticleID                    0.00495245    0.00634401    0.00781118    0.00621588    0.000897772      10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.0443862     0.0572214     0.0880228     0.0559078     0.0122084       10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00486514    0.00602608    0.00774519    0.00565264    0.000880544      10     
reco:pandoraShowercalo:ShowerCalorimetry            2.24876       4.48406       7.53419       4.60516       1.4902         10     
reco:pandoraShowercalonosce:ShowerCalorimetry       2.19948       4.4421        7.81247       4.27102       1.56126        10     
reco:emtrkmichelid:EmTrackMichelId                  165.802       211.866       273.621       218.028       34.3173        10     
reco:crttag:SingleCRTMatchingProducer             0.00925324     0.0128358     0.0180259     0.012442      0.0025764       10     
reco:crtreco:TwoCRTMatchingProducer               0.00746347    0.00940773     0.0113848    0.00967842    0.00127124       10     
reco:anodepiercerst0:T0RecoAnodePiercers           0.735522      0.942877       1.21835       0.9109        0.14778        10     
reco:pandora2Track:LArPandoraTrackCreation          8.16228       15.2137       22.2863       14.8689       4.46117        10     
reco:pandora2calo:Calorimetry                       3.57393       6.33141       9.39586       6.46319       1.69255        10     
reco:pandora2calonosce:Calorimetry                  3.38032       5.97227       8.67195       6.05084       1.54204        10     
reco:pandora2pid:Chi2ParticleID                    0.0106152     0.0153316     0.020599      0.0143524    0.00294775       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.0499081     0.0691683     0.0962313     0.0669264     0.0128139       10     
reco:pandora2calipidnoxyzt:Chi2ParticleID          0.0104775     0.0149506     0.0185633     0.0142931    0.00253347       10     
reco:pandora2Shower:LArPandoraShowerCreation        3.14751       5.32482       7.45643       5.50004       1.24686        10     
reco:pandora2Showercalo:ShowerCalorimetry           3.18648       5.31197       7.31749       5.38733       1.23056        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      2.93688       4.80764       6.59121       4.95384       1.09062        10     
[art]:TriggerResults:TriggerResultInserter        3.7711e-05    5.68905e-05   0.000157215   4.6226e-05    3.38288e-05      10     
end_path:out1:RootOutput                           9.051e-06    1.51483e-05   3.6951e-05    1.2565e-05    7.67182e-06      10     
end_path:out1:RootOutput(write)                     2.61205       3.23745       3.77086       3.34737      0.414338        10     
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
  Peak virtual memory usage (VmPeak)  : 5177.65 MB
  Peak resident set size usage (VmHWM): 4356.29 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.21 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.04 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   3.19 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 10731480
-rw-r--r--. 1 pildune003 dunepil 2492313988 Oct 26 09:32 detsim_stage2.root
-rw-r--r--. 1 pildune003 dunepil 2361725628 Oct 26 09:30 detsim_stage1.root
-rw-r--r--. 1 pildune003 dunepil 2196203470 Oct 26 10:38 reco_stage1.root
-rw-r--r--. 1 pildune003 dunepil 1977009667 Oct 26 07:34 g4_stage2.root
-rw-r--r--. 1 pildune003 dunepil 1881815305 Oct 26 07:21 g4_stage1.root
-rw-r--r--. 1 pildune003 dunepil   79346430 Oct 26 10:32 Pandora_Events.pndr
-rw-r--r--. 1 pildune003 dunepil     242883 Oct 26 10:38 jobscript.log
-rw-r--r--. 1 pildune003 dunepil     217088 Oct 26 10:38 mem.db
-rw-r--r--. 1 pildune003 dunepil      62376 Oct 26 10:38 Pandora_Geometry.xml
-rw-r--r--. 1 pildune003 dunepil      36864 Oct 26 10:38 time.db
-rw-r--r--. 1 pildune003 dunepil        519 Oct 26 09:32 detsim_single_protoDUNE_hist.root
-rw-r--r--. 1 pildune003 dunepil        519 Oct 26 07:34 g4_protoDUNE_hist.root
-rw-r--r--. 1 pildune003 dunepil        519 Oct 26 10:38 protoDUNE_reco1_hist.root
-rw-r--r--. 1 pildune003 dunepil         52 Oct 26 07:15 all-input-dids.txt
-rw-r--r--. 1 pildune003 dunepil          7 Oct 26 10:38 justin-processed-pfns.txt
-rw-r--r--. 1 pildune003 dunepil          0 Oct 26 09:39 ProtoDUNE.log
-rw-r--r--. 1 pildune003 dunepil          0 Oct 26 09:32 debugprod.log