Jobsub ID 230785.0@dunegpschedd02.fnal.gov
| Jobsub ID | 230785.0@dunegpschedd02.fnal.gov | 
| Workflow ID | 9147 | 
| 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-19 06:10:11 | 
| Site | UK_QMUL | 
| Entry | DUNE_UK_London_QMUL_arcce03 | 
| Last heartbeat | 2025-10-19 12:41:37 | 
| From worker node | Hostname | cn022.htc.esc.qmul | 
| cpuinfo | Intel(R) Xeon(R) Gold 6248R CPU @ 3.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-10-19 06:12:00 | 
| Input files | monte-carlo-009147-000001
  | 
| Jobscript | Exit code | 0 | 
| Real time | 6h (23152s) | 
| CPU time | 6h (22799s = 98%) | 
| Max RSS bytes | 4750626816 (4530 MiB) | 
| Outputting started | 2025-10-19 12:37:52 | 
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/pmelas/fnal/09147/1/001/reco_stage1.root
  | 
| Finished | 2025-10-19 12:41:37 | 
| Saved logs | justin-logs:230785.0-dunegpschedd02.fnal.gov.logs.tgz | 
| List job events     Cached HTCondor job logs | 
Jobscript log (last 10,000 characters)
dRawDigitPrepService: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 131867 traces, 0 summary
Retagger: tagging trace set: gauss with 97852 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 97852 traces tagged "gauss"
FrameSaver: q=3.40911e+06 n=1720999 tag=gauss
wclsFrameSaver: saving 131867 traces tagged "wiener"
FrameSaver: q=3.65554e+06 n=1516880 tag=wiener
72 X, 28 U, 34 V bad channels
Finding XUV coincidences...
C:0 T:0 40984 XUs and 40223 XVs -> 704 XUVs
C:0 T:1 119042 XUs and 97821 XVs -> 10443 XUVs
C:0 T:2 209567 XUs and 109944 XVs -> 9801 XUVs
C:0 T:3 55958 XUs and 41087 XVs -> 327 XUVs
C:0 T:4 14581 XUs and 12185 XVs -> 182 XUVs
C:0 T:5 72499 XUs and 41626 XVs -> 5442 XUVs
C:0 T:6 130026 XUs and 102953 XVs -> 11501 XUVs
C:0 T:7 37457 XUs and 36186 XVs -> 491 XUVs
C:0 T:8 10255 XUs and 8474 XVs -> 101 XUVs
C:0 T:9 70176 XUs and 72811 XVs -> 4960 XUVs
C:0 T:10 57837 XUs and 12681 XVs -> 3898 XUVs
C:0 T:11 27 XUs and 20 XVs -> 5 XUVs
47855 XUVs total
12195 collection wire objects
43269 potential space points
Neighbour search...
5206465 tests to find 2617360 neighbours
Iterating with no regularization...
Begin: 6.63939e+07
0 5.07319e+07
1 4.97735e+07
2 4.96132e+07
3 4.95545e+07
4 4.95245e+07
Now with regularization...
Begin: 3.92864e+07
0 3.92333e+07
1 3.91964e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
run: 1 ; subrun: 0 ; event: 10
evttime: 409980772
fLifetime: 30000 [us]
run: 1 ; subrun: 0 ; event: 10
evttime: 409980772
fLifetime: 30000 [us]
19-Oct-2025 13:37:49 BST  Closed output file "reco_stage1.root"
19-Oct-2025 13:37:49 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                                          730.421       1049.8        1485.79       1004.86       243.025        10     
------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                             0.0021475     0.0054623    0.00789814    0.00568818    0.00176916       10     
reco:ophit:OpHitFinder                             0.450509       0.63778       1.23289      0.578988       0.21069        10     
reco:opflash:OpFlashFinder                         0.238902       0.36341      0.574377      0.352319      0.090811        10     
reco:opslicer:OpSlicer                             0.868936       1.19138       1.49976       1.15777      0.182337        10     
reco:caldata:DataPrepModule                         8.38046       9.22345       10.5812       9.24998      0.555845        10     
reco:wclsdatasp:WireCellToolkit                     65.1656       69.3685       81.4431       68.1378       4.70753        10     
reco:gaushit:GausHitFinder                          1.85266       2.63958       3.80362       2.57738       0.50334        10     
reco:nhitsfilter:NumberOfHitsFilter               0.000988273   0.00134036    0.00190872    0.00127685    0.000297433      10     
reco:reco3d:SpacePointSolver                        20.7983       38.6655       87.0158       31.8098       19.155         10     
reco:hitpdune:DisambigFromSpacePoints               3.1451        6.0123        11.0234       5.67433       2.27696        10     
reco:pandora:StandardPandora                        53.2329       129.038       283.38        101.631       72.9614        10     
reco:pandoraWriter:StandardPandora                 0.725824      0.983624       1.46544      0.968992      0.206497        10     
reco:pandoraTrack:LArPandoraTrackCreation           17.2067       26.9496       46.9758       24.8671       8.57875        10     
reco:pandoraShower:LArPandoraShowerCreation         16.6271       31.247        66.4801       29.481        13.7243        10     
reco:pandoracalo:Calorimetry                        8.19477       12.559        22.3519       11.6079       4.0714         10     
reco:pandoracalonosce:Calorimetry                   7.74371       12.1363       21.6324       11.2533       3.99844        10     
reco:pandorapid:Chi2ParticleID                    0.00965412     0.0133054     0.0195291     0.0122434    0.00287703       10     
reco:pandoracalinoxyzt:CalibrationdEdXPDSP         0.090786      0.116054      0.152468      0.117054      0.018738        10     
reco:pandoracalipidnoxyzt:Chi2ParticleID          0.00964344     0.0123372     0.0162529     0.0116223    0.00194841       10     
reco:pandoraShowercalo:ShowerCalorimetry            16.8995       32.0337       65.5492       31.2715       13.5498        10     
reco:pandoraShowercalonosce:ShowerCalorimetry       16.5156       31.4695       64.9853       30.5836       13.4504        10     
reco:emtrkmichelid:EmTrackMichelId                  307.402       389.902       474.118       380.213       51.9392        10     
reco:crttag:SingleCRTMatchingProducer              0.0389013     0.0525945     0.0732251     0.0495564     0.0117011       10     
reco:crtreco:TwoCRTMatchingProducer                0.0323151     0.0416676     0.0525463     0.0421919    0.00567612       10     
reco:anodepiercerst0:T0RecoAnodePiercers            1.64553       2.03812       3.1717        1.96106      0.418465        10     
reco:pandora2Track:LArPandoraTrackCreation          55.2854       84.4686       111.435       85.3121       21.4574        10     
reco:pandora2calo:Calorimetry                       24.5446       38.5038       52.6429       39.6114       10.1443        10     
reco:pandora2calonosce:Calorimetry                  23.1613       38.0895       61.3693       37.5744       11.8526        10     
reco:pandora2pid:Chi2ParticleID                    0.0233766     0.0319609     0.046396      0.0309676    0.00660268       10     
reco:pandora2calinoxyzt:CalibrationdEdXPDSP        0.114157      0.154713      0.211514      0.153696      0.0289183       10     
reco:pandora2calipidnoxyzt:Chi2ParticleID          0.0227504     0.0301726     0.0434882     0.0293367    0.00580036       10     
reco:pandora2Shower:LArPandoraShowerCreation        14.3634       24.6679       43.6213       23.7982       8.14063        10     
reco:pandora2Showercalo:ShowerCalorimetry           20.1581       32.9371       58.9432       32.2832       11.1963        10     
reco:pandora2Showercalonosce:ShowerCalorimetry      17.0418       28.8865       52.4771       27.7397       10.3088        10     
[art]:TriggerResults:TriggerResultInserter        7.4021e-05    0.000110821   0.000266107   9.01275e-05   5.41916e-05      10     
end_path:out1:RootOutput                           9.194e-06    1.36046e-05   2.3982e-05    1.1779e-05    4.23087e-06      10     
end_path:out1:RootOutput(write)                     3.80682       5.08552       6.89192       5.0462       0.967376        10     
====================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
  Peak virtual memory usage (VmPeak)  : 5555.11 MB
  Peak resident set size usage (VmHWM): 4750.63 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.11 sec/event
ToolBasedRawDigitPrepService:dtor:                adcSampleFiller:   0.35 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleAdcToKe:   0.07 sec/event
ToolBasedRawDigitPrepService:dtor:          pdspTailPedRemovalZKe:   5.61 sec/event
ToolBasedRawDigitPrepService:dtor:         adcKeepAllSignalFinder:   0.30 sec/event
ToolBasedRawDigitPrepService:dtor:                adcScaleKeToAdc:   0.07 sec/event
ToolBasedRawDigitPrepService:dtor:         pdsp_RemoveBadChannels:   0.01 sec/event
Art has completed and will exit with status 0.
lar exit code 0
.:
total 12286516
-rw-r--r-- 1 pildune32 pildune 2815810290 Oct 19 10:39 detsim_stage2.root
-rw-r--r-- 1 pildune32 pildune 2669161942 Oct 19 10:35 detsim_stage1.root
-rw-r--r-- 1 pildune32 pildune 2588208838 Oct 19 13:37 reco_stage1.root
-rw-r--r-- 1 pildune32 pildune 2250331534 Oct 19 07:51 g4_stage2.root
-rw-r--r-- 1 pildune32 pildune 2160821524 Oct 19 07:21 g4_stage1.root
-rw-r--r-- 1 pildune32 pildune   96446810 Oct 19 13:27 Pandora_Events.pndr
-rw-r--r-- 1 pildune32 pildune     243530 Oct 19 13:37 jobscript.log
-rw-r--r-- 1 pildune32 pildune     217088 Oct 19 13:37 mem.db
-rw-r--r-- 1 pildune32 pildune      62376 Oct 19 13:37 Pandora_Geometry.xml
-rw-r--r-- 1 pildune32 pildune      36864 Oct 19 13:37 time.db
-rw-r--r-- 1 pildune32 pildune        519 Oct 19 10:39 detsim_single_protoDUNE_hist.root
-rw-r--r-- 1 pildune32 pildune        519 Oct 19 07:51 g4_protoDUNE_hist.root
-rw-r--r-- 1 pildune32 pildune        519 Oct 19 13:37 protoDUNE_reco1_hist.root
-rw-r--r-- 1 pildune32 pildune         52 Oct 19 07:12 all-input-dids.txt
-rw-r--r-- 1 pildune32 pildune          7 Oct 19 13:37 justin-processed-pfns.txt
-rw-r--r-- 1 pildune32 pildune          0 Oct 19 10:55 ProtoDUNE.log
-rw-r--r-- 1 pildune32 pildune          0 Oct 19 10:39 debugprod.log