Jobsub ID 47409.126@dunegpschedd01.fnal.gov

Jobsub ID	47409.126@dunegpschedd01.fnal.gov
Workflow ID	2740
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 08:45:00
Site	UK_Oxford
Entry	DUNE_UK_SGrid_Oxford_arc01
Last heartbeat	2025-09-17 10:44:07
From worker node	Hostname	t2wn176.physics.ox.ac.uk
	cpuinfo	AMD EPYC 9655 96-Core Processor
	OS release	Scientific Linux release 7.9 (Nitrogen)
	Processors	1
	RSS bytes	4194304000 (4000 MiB)
	Wall seconds limit	257400 (71 hours)
	GPU
	Inner Apptainer?	True
Job state	finished
Started	2025-09-17 08:47:24
Input files	vd-protodune:np02vd_raw_run039388_0623_df-s05-d2_dw_0_20250917T021939.hdf5
Jobscript	Exit code	0
	Real time	1h (6638s)
	CPU time	42m (2534s = 38%)
	Max RSS bytes	2733359104 (2606 MiB)
Outputting started	2025-09-17 10:38:03
Output files	vd-protodune-det-reco:np02vd_raw_run039388_0623_df-s05-d2_dw_0_20250917T021939_reco_stage1_20250917T103753_keepup.root
Finished	2025-09-17 10:44:07
Saved logs	justin-logs:47409.126-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 10081
wclsFrameSaver: no samples within desired window for channel 10113
wclsFrameSaver: no samples within desired window for channel 10285
wclsFrameSaver: no samples within desired window for channel 10378
wclsFrameSaver: no samples within desired window for channel 10390
wclsFrameSaver: no samples within desired window for channel 10622
wclsFrameSaver: no samples within desired window for channel 10622
wclsFrameSaver: no samples within desired window for channel 10623
wclsFrameSaver: no samples within desired window for channel 10623
wclsFrameSaver: no samples within desired window for channel 10624
wclsFrameSaver: no samples within desired window for channel 10624
wclsFrameSaver: no samples within desired window for channel 10625
wclsFrameSaver: no samples within desired window for channel 10626
wclsFrameSaver: no samples within desired window for channel 10626
wclsFrameSaver: no samples within desired window for channel 10627
wclsFrameSaver: no samples within desired window for channel 10628
wclsFrameSaver: no samples within desired window for channel 10630
wclsFrameSaver: no samples within desired window for channel 10638
wclsFrameSaver: no samples within desired window for channel 10640
wclsFrameSaver: no samples within desired window for channel 10711
wclsFrameSaver: no samples within desired window for channel 10712
wclsFrameSaver: no samples within desired window for channel 10969
wclsFrameSaver: no samples within desired window for channel 10972
wclsFrameSaver: no samples within desired window for channel 10989
wclsFrameSaver: no samples within desired window for channel 11118
wclsFrameSaver: no samples within desired window for channel 11414
wclsFrameSaver: no samples within desired window for channel 11416
wclsFrameSaver: no samples within desired window for channel 11417
wclsFrameSaver: no samples within desired window for channel 11417
wclsFrameSaver: no samples within desired window for channel 11418
wclsFrameSaver: no samples within desired window for channel 11418
wclsFrameSaver: no samples within desired window for channel 11921
wclsFrameSaver: no samples within desired window for channel 11925
wclsFrameSaver: no samples within desired window for channel 11925
wclsFrameSaver: no samples within desired window for channel 11926
wclsFrameSaver: no samples within desired window for channel 11926
wclsFrameSaver: no samples within desired window for channel 12231
wclsFrameSaver: no samples within desired window for channel 12231
FrameSaver: q=8.87753e+06 n=1038722 tag=wiener
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 724 XUs and 496 XVs -> 41 XUVs
C:0 T:1 909 XUs and 1828 XVs -> 50 XUVs
C:0 T:2 2846 XUs and 2033 XVs -> 85 XUVs
C:0 T:3 770 XUs and 1700 XVs -> 58 XUVs
C:0 T:4 1452 XUs and 1775 XVs -> 117 XUVs
C:0 T:5 1209 XUs and 1859 XVs -> 114 XUVs
C:0 T:6 1545 XUs and 1680 XVs -> 63 XUVs
C:0 T:7 999 XUs and 1389 XVs -> 54 XUVs
C:0 T:8 1358 XUs and 1579 XVs -> 78 XUVs
C:0 T:9 785 XUs and 1016 XVs -> 36 XUVs
C:0 T:10 440 XUs and 375 XVs -> 65 XUVs
C:0 T:11 2392 XUs and 2594 XVs -> 117 XUVs
C:0 T:12 896 XUs and 2376 XVs -> 69 XUVs
C:0 T:13 1678 XUs and 2114 XVs -> 162 XUVs
C:0 T:14 4350 XUs and 5599 XVs -> 268 XUVs
C:0 T:15 8979 XUs and 12252 XVs -> 935 XUVs
2312 XUVs total
1491 collection wire objects
2312 potential space points
Neighbour search...
44692 tests to find 23144 neighbours
Iterating with no regularization...
Begin: 5.2298e+08
0 4.98383e+08
1 4.97015e+08
2 4.96878e+08
Now with regularization...
Begin: 4.89918e+08
0 4.89865e+08
17-Sep-2025 11:37:53 BST  Closed output file "np02vd_raw_run039388_0623_df-s05-d2_dw_0_20250917T021939_reco_stage1_20250917T103753_keepup.root"

==================================================================================================================================
TimeTracker printout (sec)                          Min           Avg           Max         Median          RMS         nEvts   
==================================================================================================================================
Full event                                        236.991       346.497       559.459       320.241       85.7471        19     
----------------------------------------------------------------------------------------------------------------------------------
source:HDF5RawInput3(read)                      7.9871e-05    0.000108607   0.000272202   9.3271e-05    4.3104e-05       19     
produce:tpcrawdecoder:PDVDTPCReader               140.574       218.964       368.226       186.801       66.4235        19     
produce:triggerrawdecoder:PDVDTriggerReader4     0.340899      0.478487      0.672711      0.459794      0.107873        19     
produce:pdvddaphne:DAPHNEReaderPDVD             0.000328218   0.000409507   0.000818229   0.000373216   0.000105966      19     
produce:ophit:OpHitFinder                       0.000177579   0.000283484   0.000919433   0.000238632   0.000156564      19     
produce:opflash:OpFlashFinderVerticalDrift      4.7211e-05    7.96158e-05   0.000313465   6.4388e-05    5.77522e-05      19     
produce:wclsdatavd:WireCellToolkit                49.6128       61.1434       77.215        61.3116       6.99696        19     
produce:gaushit:GausHitFinder                    0.655984       1.23114       1.7056        1.26763      0.340837        19     
produce:nhitsfilter:NumberOfHitsFilter          0.000164119   0.000290104    0.000647     0.000273224   0.000114822      19     
produce:reco3d:SpacePointSolver                   5.75394       13.4161       23.436        13.3346       4.60192        19     
produce:hitpdune:DisambigFromSpacePoints         0.0836275     0.206374      0.358859      0.212393      0.0834879       19     
produce:pandora:StandardPandora                   15.9669       45.191        120.043       37.9237       27.0388        19     
produce:pandoraTrack:LArPandoraTrackCreation     0.359745       1.02774       2.16879      0.794415      0.540122        19     
produce:pandoraGnocalo:GnocchiCalorimetry        0.0133118     0.029623      0.0531148     0.0209298     0.0128398       19     
[art]:TriggerResults:TriggerResultInserter      3.0746e-05    4.60003e-05   0.000103196   3.8188e-05    1.61785e-05      19     
end_path:out1:RootOutput                         8.032e-06    1.15613e-05   3.3802e-05    1.0406e-05    5.40134e-06      19     
end_path:out1:RootOutput(write)                   3.65231       4.74239       5.48598       4.72211      0.593165        19     
==================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4752.58 MB
  Peak resident set size usage (VmHWM): 2733.36 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np02vd_raw_run039388_0623_df-s05-d2_dw_0_20250917T021939_reco_stage1_20250917T103753_keepup.root
\tHists: np02vd_raw_run039388_0623_df-s05-d2_dw_0_20250917T021939_reco_stage1_20250917T103753_keepup_hists.root
Forming reco metadata
Successfully opened file np02vd_raw_run039388_0623_df-s05-d2_dw_0_20250917T021939_reco_stage1_20250917T103753_keepup.root
Ran successfully
{
  "name": "np02vd_raw_run039388_0623_df-s05-d2_dw_0_20250917T021939_reco_stage1_20250917T103753_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": 1758105474.0,
    "core.end_time": 1758105474.0,
    "core.events": [
      48014,
      48018,
      48022,
      48026,
      48030,
      48034,
      48038,
      48042,
      48046,
      48050,
      48054,
      48058,
      48062,
      48066,
      48070,
      48074,
      48078,
      48082,
      48086
    ],
    "core.event_count": 19,
    "core.first_event_number": 48014,
    "core.last_event_number": 48086,
    "core.data_stream": "cosmics",
    "core.file_content_status": "good",
    "core.file_type": "detector",
    "core.run_type": "vd-protodune",
    "core.runs": [
      39388
    ],
    "core.runs_subruns": [
      3938800001
    ],
    "dune.daq_test": false,
    "retention.status": "active",
    "retention.class": "physics"
  },
  "parents": [
    {
      "did": "vd-protodune:np02vd_raw_run039388_0623_df-s05-d2_dw_0_20250917T021939.hdf5"
    }
  ]
}Forming hist metadata
formed
{
  "name": "np02vd_raw_run039388_0623_df-s05-d2_dw_0_20250917T021939_reco_stage1_20250917T103753_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": 1758105474.0,
    "core.end_time": 1758105474.0,
    "core.data_stream": "cosmics",
    "core.file_content_status": "good",
    "core.file_type": "detector",
    "core.run_type": "vd-protodune",
    "core.runs": [
      39388
    ],
    "core.runs_subruns": [
      3938800001
    ],
    "dune.daq_test": false,
    "retention.status": "active",
    "retention.class": "physics"
  },
  "parents": [
    {
      "did": "vd-protodune:np02vd_raw_run039388_0623_df-s05-d2_dw_0_20250917T021939.hdf5"
    }
  ]
}