Jobsub ID 237201.80@dunegpschedd02.fnal.gov

Jobsub ID	237201.80@dunegpschedd02.fnal.gov
Workflow ID	9584
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-11-04 11:44:03
Site	CERN
Entry	CMSHTPC_T2_CH_CERN_ce509
Last heartbeat	2025-11-04 13:20:45
From worker node	Hostname	b9p06p1726.cern.ch
	cpuinfo	AMD EPYC 7543 32-Core Processor
	OS release	Scientific Linux release 7.9 (Nitrogen)
	Processors	1
	RSS bytes	4194304000 (4000 MiB)
	Wall seconds limit	343800 (95 hours)
	GPU
	Inner Apptainer?	True
Job state	finished
Started	2025-11-04 12:16:42
Input files	vd-protodune:np02vd_raw_run040348_1184_df-s04-d2_dw_0_20251104T113606.hdf5
Jobscript	Exit code	0
	Real time	1h (3695s)
	CPU time	58m (3535s = 95%)
	Max RSS bytes	4536086528 (4325 MiB)
Outputting started	2025-11-04 13:18:18
Output files	vd-protodune-det-reco:np02vd_raw_run040348_1184_df-s04-d2_dw_0_20251104T113606_reco_stage1_20251104T131805_keepup.root
Finished	2025-11-04 13:20:45
Saved logs	justin-logs:237201.80-dunegpschedd02.fnal.gov.logs.tgz
List job events Cached HTCondor job logs

Jobscript log (last 10,000 characters)

esired window for channel 11093
wclsFrameSaver: no samples within desired window for channel 11093
wclsFrameSaver: no samples within desired window for channel 11094
wclsFrameSaver: no samples within desired window for channel 11094
wclsFrameSaver: no samples within desired window for channel 11095
wclsFrameSaver: no samples within desired window for channel 11095
wclsFrameSaver: no samples within desired window for channel 11097
wclsFrameSaver: no samples within desired window for channel 11354
wclsFrameSaver: no samples within desired window for channel 11559
wclsFrameSaver: no samples within desired window for channel 11559
wclsFrameSaver: no samples within desired window for channel 11561
wclsFrameSaver: no samples within desired window for channel 11562
wclsFrameSaver: no samples within desired window for channel 11569
wclsFrameSaver: no samples within desired window for channel 11823
wclsFrameSaver: no samples within desired window for channel 12048
wclsFrameSaver: no samples within desired window for channel 12049
wclsFrameSaver: no samples within desired window for channel 12064
wclsFrameSaver: no samples within desired window for channel 12065
wclsFrameSaver: no samples within desired window for channel 12065
wclsFrameSaver: no samples within desired window for channel 12066
wclsFrameSaver: no samples within desired window for channel 12066
wclsFrameSaver: no samples within desired window for channel 12066
wclsFrameSaver: no samples within desired window for channel 12067
wclsFrameSaver: no samples within desired window for channel 12067
wclsFrameSaver: no samples within desired window for channel 12067
wclsFrameSaver: no samples within desired window for channel 12068
wclsFrameSaver: no samples within desired window for channel 12068
wclsFrameSaver: no samples within desired window for channel 12081
wclsFrameSaver: no samples within desired window for channel 12082
wclsFrameSaver: no samples within desired window for channel 12082
wclsFrameSaver: no samples within desired window for channel 12084
wclsFrameSaver: no samples within desired window for channel 12086
wclsFrameSaver: no samples within desired window for channel 12086
wclsFrameSaver: no samples within desired window for channel 12086
wclsFrameSaver: no samples within desired window for channel 12087
wclsFrameSaver: no samples within desired window for channel 12087
wclsFrameSaver: no samples within desired window for channel 12091
wclsFrameSaver: no samples within desired window for channel 12092
FrameSaver: q=7.98067e+06 n=724025 tag=wiener
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 241 XUs and 302 XVs -> 6 XUVs
C:0 T:1 556 XUs and 501 XVs -> 14 XUVs
C:0 T:2 1071 XUs and 911 XVs -> 37 XUVs
C:0 T:3 452 XUs and 397 XVs -> 11 XUVs
C:0 T:4 354 XUs and 469 XVs -> 13 XUVs
C:0 T:5 147 XUs and 176 XVs -> 5 XUVs
C:0 T:6 226 XUs and 225 XVs -> 7 XUVs
C:0 T:7 261 XUs and 293 XVs -> 10 XUVs
C:0 T:8 2124 XUs and 1704 XVs -> 107 XUVs
C:0 T:9 1075 XUs and 1700 XVs -> 108 XUVs
C:0 T:10 1222 XUs and 1322 XVs -> 98 XUVs
C:0 T:11 685 XUs and 788 XVs -> 39 XUVs
C:0 T:12 310 XUs and 494 XVs -> 23 XUVs
C:0 T:13 637 XUs and 727 XVs -> 51 XUVs
C:0 T:14 293 XUs and 291 XVs -> 25 XUVs
C:0 T:15 921 XUs and 1167 XVs -> 55 XUVs
609 XUVs total
521 collection wire objects
609 potential space points
Neighbour search...
4295 tests to find 2176 neighbours
Iterating with no regularization...
Begin: 2.70507e+08
0 2.62784e+08
1 2.6262e+08
Now with regularization...
Begin: 2.58453e+08
0 2.58439e+08
04-Nov-2025 14:18:05 CET  Closed output file "np02vd_raw_run040348_1184_df-s04-d2_dw_0_20251104T113606_reco_stage1_20251104T131805_keepup.root"

==================================================================================================================================
TimeTracker printout (sec)                          Min           Avg           Max         Median          RMS         nEvts   
==================================================================================================================================
Full event                                        72.4114       158.467       644.451       117.023       118.966        23     
----------------------------------------------------------------------------------------------------------------------------------
source:HDF5RawInput3(read)                      6.4861e-05    9.09379e-05   0.000154172   7.7221e-05    2.63907e-05      23     
produce:tpcrawdecoder:PDVDTPCReader               4.25287       4.9241        6.30769       4.7664       0.581903        23     
produce:triggerrawdecoder:PDVDTriggerReader4     0.0134682     0.0169067     0.032645      0.0150021     0.004476        23     
produce:pdvddaphne:DAPHNEReaderPDVD             0.000297983   0.000372024   0.000854198   0.000359224   0.000106579      23     
produce:ophit:OpHitFinder                       6.5281e-05    0.000129599   0.000740687   0.00010152    0.000132195      23     
produce:opflash:OpFlashFinderVerticalDrift      4.6091e-05    7.95447e-05   0.000453175    6.084e-05    8.05837e-05      23     
produce:wclsdatavd:WireCellToolkit                43.0276       68.7863       119.609       66.9321       20.1055        23     
produce:gaushit:GausHitFinder                    0.611561       1.14997       1.62557       1.17202      0.295497        23     
produce:nhitsfilter:NumberOfHitsFilter          0.000171811   0.000260988   0.000552616   0.000250433   7.52824e-05      23     
produce:reco3d:SpacePointSolver                   6.20067       11.8713       21.8566       11.4487       4.30702        23     
produce:hitpdune:DisambigFromSpacePoints         0.0793716     0.227287      0.656437      0.171531      0.142998        23     
produce:pandora:StandardPandora                   8.03347       63.2842       508.028       30.6538       102.413        23     
produce:pandoraTrack:LArPandoraTrackCreation     0.365319      0.922893       1.67773      0.895461      0.389424        23     
produce:pandoraGnocalo:GnocchiCalorimetry        0.0143066     0.0282906     0.0443435     0.0268874    0.00828722       23     
[art]:TriggerResults:TriggerResultInserter      1.3631e-05    2.4595e-05    6.9711e-05     2.25e-05     1.26238e-05      23     
end_path:out1:RootOutput                         3.53e-06     7.91178e-06    2.556e-05      6.4e-06     5.14187e-06      23     
end_path:out1:RootOutput(write)                   4.67822       7.21361       8.79873       7.62819       1.12701        23     
==================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 6484.65 MB
  Peak resident set size usage (VmHWM): 4536.09 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np02vd_raw_run040348_1184_df-s04-d2_dw_0_20251104T113606_reco_stage1_20251104T131805_keepup.root
\tHists: np02vd_raw_run040348_1184_df-s04-d2_dw_0_20251104T113606_reco_stage1_20251104T131805_keepup_hists.root
Forming reco metadata
Successfully opened file np02vd_raw_run040348_1184_df-s04-d2_dw_0_20251104T113606_reco_stage1_20251104T131805_keepup.root
Ran successfully
{
  "name": "np02vd_raw_run040348_1184_df-s04-d2_dw_0_20251104T113606_reco_stage1_20251104T131805_keepup.root",
  "namespace": "vd-protodune-det-reco",
  "metadata": {
    "core.file_format": "artroot",
    "core.application.name": "reco",
    "core.application.family": "dunesw",
    "core.application.version": "v10_11_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": 1762262286.0,
    "core.end_time": 1762262286.0,
    "core.events": [
      109450,
      109454,
      109458,
      109462,
      109466,
      109470,
      109474,
      109478,
      109482,
      109486,
      109490,
      109494,
      109498,
      109502,
      109506,
      109510,
      109514,
      109518,
      109522,
      109526,
      109530,
      109534,
      109538
    ],
    "core.event_count": 23,
    "core.first_event_number": 109450,
    "core.last_event_number": 109538,
    "core.data_stream": "cosmics",
    "core.file_content_status": "good",
    "core.file_type": "detector",
    "core.run_type": "vd-protodune",
    "core.runs": [
      40348
    ],
    "core.runs_subruns": [
      4034800001
    ],
    "dune.daq_test": false,
    "retention.status": "active",
    "retention.class": "physics"
  },
  "parents": [
    {
      "did": "vd-protodune:np02vd_raw_run040348_1184_df-s04-d2_dw_0_20251104T113606.hdf5"
    }
  ]
}Forming hist metadata
formed
{
  "name": "np02vd_raw_run040348_1184_df-s04-d2_dw_0_20251104T113606_reco_stage1_20251104T131805_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_11_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": 1762262286.0,
    "core.end_time": 1762262286.0,
    "core.data_stream": "cosmics",
    "core.file_content_status": "good",
    "core.file_type": "detector",
    "core.run_type": "vd-protodune",
    "core.runs": [
      40348
    ],
    "core.runs_subruns": [
      4034800001
    ],
    "dune.daq_test": false,
    "retention.status": "active",
    "retention.class": "physics"
  },
  "parents": [
    {
      "did": "vd-protodune:np02vd_raw_run040348_1184_df-s04-d2_dw_0_20251104T113606.hdf5"
    }
  ]
}