Jobsub ID 47428.103@dunegpschedd01.fnal.gov

Jobsub ID	47428.103@dunegpschedd01.fnal.gov
Workflow ID	2744
Stage ID	1
User name	ykermaid@fnal.gov
HTCondor Group	group_dune.prod_mcsim
Requested	Processors	1
	GPU	No
	RSS bytes	4193255424 (3999 MiB)
	Wall seconds limit	18000 (5 hours)
Submitted time	2025-09-17 09:17:01
Site	UK_Durham
Entry	DUNE_UK_SGridDurham_ce3
Last heartbeat	2025-09-17 13:52:42
From worker node	Hostname	n241.dur.scotgrid.ac.uk
	cpuinfo	AMD EPYC 7352 24-Core Processor
	OS release	Scientific Linux release 7.9 (Nitrogen)
	Processors	1
	RSS bytes	4194304000 (4000 MiB)
	Wall seconds limit	171000 (47 hours)
	GPU
	Inner Apptainer?	True
Job state	finished
Started	2025-09-17 10:47:13
Input files	vd-protodune:np02vd_raw_run039276_0052_df-s02-d1_dw_0_20250902T123137.hdf5
Jobscript	Exit code	0
	Real time	3h (10943s)
	CPU time	1h (4306s = 39%)
	Max RSS bytes	3232440320 (3082 MiB)
Outputting started	2025-09-17 13:49:37
Output files	vd-protodune-det-reco:np02vd_raw_run039276_0052_df-s02-d1_dw_0_20250902T123137_reco_stage1_20250917T134926_keepup.root
Finished	2025-09-17 13:52:42
Saved logs	justin-logs:47428.103-dunegpschedd01.fnal.gov.logs.tgz
List job events Cached HTCondor job logs

Jobscript log (last 10,000 characters)

clsFrameSaver: no samples within desired window for channel 11639
wclsFrameSaver: no samples within desired window for channel 11639
wclsFrameSaver: no samples within desired window for channel 11640
wclsFrameSaver: no samples within desired window for channel 11640
wclsFrameSaver: no samples within desired window for channel 11641
wclsFrameSaver: no samples within desired window for channel 11641
wclsFrameSaver: no samples within desired window for channel 11642
wclsFrameSaver: no samples within desired window for channel 11642
wclsFrameSaver: no samples within desired window for channel 11643
wclsFrameSaver: no samples within desired window for channel 11643
wclsFrameSaver: no samples within desired window for channel 11644
wclsFrameSaver: no samples within desired window for channel 11644
wclsFrameSaver: no samples within desired window for channel 11645
wclsFrameSaver: no samples within desired window for channel 11645
wclsFrameSaver: no samples within desired window for channel 11646
wclsFrameSaver: no samples within desired window for channel 11646
wclsFrameSaver: no samples within desired window for channel 11646
wclsFrameSaver: no samples within desired window for channel 11647
wclsFrameSaver: no samples within desired window for channel 11647
wclsFrameSaver: no samples within desired window for channel 11648
wclsFrameSaver: no samples within desired window for channel 11649
wclsFrameSaver: no samples within desired window for channel 11650
wclsFrameSaver: no samples within desired window for channel 11650
wclsFrameSaver: no samples within desired window for channel 11651
wclsFrameSaver: no samples within desired window for channel 11651
wclsFrameSaver: no samples within desired window for channel 11653
wclsFrameSaver: no samples within desired window for channel 11654
wclsFrameSaver: no samples within desired window for channel 12188
wclsFrameSaver: no samples within desired window for channel 12189
wclsFrameSaver: no samples within desired window for channel 12190
wclsFrameSaver: no samples within desired window for channel 12191
wclsFrameSaver: no samples within desired window for channel 12191
wclsFrameSaver: no samples within desired window for channel 12192
FrameSaver: q=1.36653e+07 n=1489048 tag=wiener
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 2272 XUs and 3105 XVs -> 92 XUVs
C:0 T:1 1412 XUs and 1227 XVs -> 31 XUVs
C:0 T:2 980 XUs and 1071 XVs -> 60 XUVs
C:0 T:3 898 XUs and 1480 XVs -> 49 XUVs
C:0 T:4 1868 XUs and 2125 XVs -> 196 XUVs
C:0 T:5 942 XUs and 1159 XVs -> 68 XUVs
C:0 T:6 829 XUs and 1096 XVs -> 43 XUVs
C:0 T:7 1819 XUs and 3076 XVs -> 246 XUVs
C:0 T:8 9435 XUs and 14268 XVs -> 1596 XUVs
C:0 T:9 14503 XUs and 16202 XVs -> 1487 XUVs
C:0 T:10 9978 XUs and 12183 XVs -> 2457 XUVs
C:0 T:11 4452 XUs and 4953 XVs -> 669 XUVs
C:0 T:12 9036 XUs and 12704 XVs -> 1779 XUVs
C:0 T:13 3155 XUs and 3456 XVs -> 295 XUVs
C:0 T:14 3686 XUs and 4252 XVs -> 140 XUVs
C:0 T:15 6009 XUs and 6733 XVs -> 614 XUVs
9822 XUVs total
2918 collection wire objects
9822 potential space points
Neighbour search...
741482 tests to find 355696 neighbours
Iterating with no regularization...
Begin: 7.04952e+08
0 6.29654e+08
1 6.23948e+08
2 6.231e+08
3 6.22792e+08
Now with regularization...
Begin: 6.03706e+08
0 6.03471e+08
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
17-Sep-2025 14:49:26 BST  Closed output file "np02vd_raw_run039276_0052_df-s02-d1_dw_0_20250902T123137_reco_stage1_20250917T134926_keepup.root"

==================================================================================================================================
TimeTracker printout (sec)                          Min           Avg           Max         Median          RMS         nEvts   
==================================================================================================================================
Full event                                        397.942       603.864       1196.15       543.086       186.577        18     
----------------------------------------------------------------------------------------------------------------------------------
source:HDF5RawInput3(read)                       6.899e-05    0.000137567   0.000246404   0.000102553   6.21795e-05      18     
produce:tpcrawdecoder:PDVDTPCReader               228.722       303.665       527.597       267.364       89.9967        18     
produce:triggerrawdecoder:PDVDTriggerReader4     0.0600526     0.0659621     0.0759567     0.0651398    0.00546524       18     
produce:pdvddaphne:DAPHNEReaderPDVD               19.6801       34.9046       59.0842       30.067        11.1434        18     
produce:ophit:OpHitFinder                        0.0468253     0.0614559     0.0843966      0.06105      0.0110543       18     
produce:opflash:OpFlashFinderVerticalDrift      0.00725638     0.0147713     0.0287834      0.01358     0.00458527       18     
produce:wclsdatavd:WireCellToolkit                69.8142       90.8555       128.829       88.287        16.155         18     
produce:gaushit:GausHitFinder                     1.01054       1.89614       3.59123       1.74593      0.727019        18     
produce:nhitsfilter:NumberOfHitsFilter          0.000352735   0.000575487   0.000961213   0.000557065   0.000166807      18     
produce:reco3d:SpacePointSolver                   12.8898       26.1355       41.8873       26.5987       8.55888        18     
produce:hitpdune:DisambigFromSpacePoints         0.231329      0.418038      0.681993       0.4162       0.140403        18     
produce:pandora:StandardPandora                   50.3728       137.259       453.179       110.302       95.3828        18     
produce:pandoraTrack:LArPandoraTrackCreation     0.727714       2.22934       5.72178       2.43129       1.17135        18     
produce:pandoraGnocalo:GnocchiCalorimetry        0.0272541     0.0454656     0.0983843     0.0427953     0.0159247       18     
[art]:TriggerResults:TriggerResultInserter      1.4758e-05    3.23388e-05   0.000107543   2.54475e-05   2.07472e-05      18     
end_path:out1:RootOutput                         6.472e-06    1.19776e-05   3.1269e-05    1.06855e-05   5.78792e-06      18     
end_path:out1:RootOutput(write)                   5.23542       6.22868       11.1084       6.01144       1.2399         18     
==================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5133.89 MB
  Peak resident set size usage (VmHWM): 3232.44 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np02vd_raw_run039276_0052_df-s02-d1_dw_0_20250902T123137_reco_stage1_20250917T134926_keepup.root
\tHists: np02vd_raw_run039276_0052_df-s02-d1_dw_0_20250902T123137_reco_stage1_20250917T134926_keepup_hists.root
Forming reco metadata
Successfully opened file np02vd_raw_run039276_0052_df-s02-d1_dw_0_20250902T123137_reco_stage1_20250917T134926_keepup.root
Ran successfully
{
  "name": "np02vd_raw_run039276_0052_df-s02-d1_dw_0_20250902T123137_reco_stage1_20250917T134926_keepup.root",
  "namespace": "vd-protodune-det-reco",
  "metadata": {
    "core.file_format": "artroot",
    "core.application.name": "reco",
    "core.application.family": "dunesw",
    "core.application.version": "v10_10_00d00",
    "core.data_tier": "full-reconstructed",
    "dune.config_file": "standard_reco_stage1_protodunevd_keepup_all.fcl",
    "dune.campaign": "vd-protodune-reco-keepup-v0",
    "core.start_time": 1758116967.0,
    "core.end_time": 1758116967.0,
    "core.events": [
      18723,
      18743,
      18763,
      18783,
      18803,
      18823,
      18843,
      18863,
      18883,
      18903,
      18923,
      18943,
      18963,
      18983,
      19003,
      19023,
      19043,
      19063
    ],
    "core.event_count": 18,
    "core.first_event_number": 18723,
    "core.last_event_number": 19063,
    "core.data_stream": "physics",
    "core.file_content_status": "good",
    "core.file_type": "detector",
    "core.run_type": "vd-protodune",
    "core.runs": [
      39276
    ],
    "core.runs_subruns": [
      3927600001
    ],
    "dune.daq_test": false,
    "retention.status": "active",
    "retention.class": "physics"
  },
  "parents": [
    {
      "did": "vd-protodune:np02vd_raw_run039276_0052_df-s02-d1_dw_0_20250902T123137.hdf5"
    }
  ]
}Forming hist metadata
formed
{
  "name": "np02vd_raw_run039276_0052_df-s02-d1_dw_0_20250902T123137_reco_stage1_20250917T134926_keepup_hists.root",
  "namespace": "vd-protodune-det-reco",
  "metadata": {
    "core.file_format": "root",
    "core.application.name": "reco",
    "core.application.family": "dunesw",
    "core.application.version": "v10_10_00d00",
    "core.data_tier": "root-tuple-virtual",
    "dune.config_file": "standard_reco_stage1_protodunevd_keepup_all.fcl",
    "dune.campaign": "vd-protodune-reco-keepup-v0",
    "core.start_time": 1758116967.0,
    "core.end_time": 1758116967.0,
    "core.data_stream": "physics",
    "core.file_content_status": "good",
    "core.file_type": "detector",
    "core.run_type": "vd-protodune",
    "core.runs": [
      39276
    ],
    "core.runs_subruns": [
      3927600001
    ],
    "dune.daq_test": false,
    "retention.status": "active",
    "retention.class": "physics"
  },
  "parents": [
    {
      "did": "vd-protodune:np02vd_raw_run039276_0052_df-s02-d1_dw_0_20250902T123137.hdf5"
    }
  ]
}