Jobsub ID 47430.37@dunegpschedd01.fnal.gov

Jobsub ID	47430.37@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:21:02
Site	NL_NIKHEF
Entry	VIRGO_NL_NIKHEF_juk_multicore
Last heartbeat	2025-09-17 11:53:59
From worker node	Hostname	wn-lot-017.farm.nikhef.nl
	cpuinfo	AMD EPYC 7702P 64-Core Processor
	OS release	Scientific Linux release 7.9 (Nitrogen)
	Processors	1
	RSS bytes	4194304000 (4000 MiB)
	Wall seconds limit	129600 (36 hours)
	GPU
	Inner Apptainer?	True
Job state	finished
Started	2025-09-17 10:57:08
Input files	vd-protodune:np02vd_raw_run039275_0527_df-s03-d1_dw_0_20250902T083523.hdf5
Jobscript	Exit code	0
	Real time	55m (3343s)
	CPU time	52m (3132s = 93%)
	Max RSS bytes	3178483712 (3031 MiB)
Outputting started	2025-09-17 11:52:51
Output files	vd-protodune-det-reco:np02vd_raw_run039275_0527_df-s03-d1_dw_0_20250902T083523_reco_stage1_20250917T115242_keepup.root
Finished	2025-09-17 11:53:59
Saved logs	justin-logs:47430.37-dunegpschedd01.fnal.gov.logs.tgz
List job events Cached HTCondor job logs

Jobscript log (last 10,000 characters)

desired window for channel 8253
wclsFrameSaver: no samples within desired window for channel 8254
wclsFrameSaver: no samples within desired window for channel 8254
wclsFrameSaver: no samples within desired window for channel 8254
wclsFrameSaver: no samples within desired window for channel 8255
wclsFrameSaver: no samples within desired window for channel 8256
wclsFrameSaver: no samples within desired window for channel 8953
wclsFrameSaver: no samples within desired window for channel 8953
wclsFrameSaver: no samples within desired window for channel 9491
wclsFrameSaver: no samples within desired window for channel 9491
wclsFrameSaver: no samples within desired window for channel 9493
wclsFrameSaver: no samples within desired window for channel 9535
wclsFrameSaver: no samples within desired window for channel 9787
wclsFrameSaver: no samples within desired window for channel 9899
wclsFrameSaver: no samples within desired window for channel 9968
wclsFrameSaver: no samples within desired window for channel 10071
wclsFrameSaver: no samples within desired window for channel 10551
wclsFrameSaver: no samples within desired window for channel 10782
wclsFrameSaver: no samples within desired window for channel 10783
wclsFrameSaver: no samples within desired window for channel 10784
wclsFrameSaver: no samples within desired window for channel 10784
wclsFrameSaver: no samples within desired window for channel 10977
wclsFrameSaver: no samples within desired window for channel 10985
wclsFrameSaver: no samples within desired window for channel 10985
wclsFrameSaver: no samples within desired window for channel 11412
wclsFrameSaver: no samples within desired window for channel 11412
wclsFrameSaver: no samples within desired window for channel 11413
wclsFrameSaver: no samples within desired window for channel 11949
wclsFrameSaver: no samples within desired window for channel 11949
wclsFrameSaver: no samples within desired window for channel 11950
wclsFrameSaver: no samples within desired window for channel 11950
wclsFrameSaver: no samples within desired window for channel 11951
wclsFrameSaver: no samples within desired window for channel 11952
wclsFrameSaver: no samples within desired window for channel 11952
wclsFrameSaver: no samples within desired window for channel 11952
wclsFrameSaver: no samples within desired window for channel 11953
wclsFrameSaver: no samples within desired window for channel 11954
wclsFrameSaver: no samples within desired window for channel 11957
wclsFrameSaver: no samples within desired window for channel 12265
FrameSaver: q=6.9633e+06 n=791208 tag=wiener
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 773 XUs and 814 XVs -> 32 XUVs
C:0 T:1 789 XUs and 847 XVs -> 20 XUVs
C:0 T:2 498 XUs and 511 XVs -> 17 XUVs
C:0 T:3 421 XUs and 555 XVs -> 24 XUVs
C:0 T:4 828 XUs and 1318 XVs -> 88 XUVs
C:0 T:5 159 XUs and 250 XVs -> 11 XUVs
C:0 T:6 1152 XUs and 1689 XVs -> 100 XUVs
C:0 T:7 549 XUs and 480 XVs -> 34 XUVs
C:0 T:8 1512 XUs and 2463 XVs -> 78 XUVs
C:0 T:9 2026 XUs and 1724 XVs -> 101 XUVs
C:0 T:10 664 XUs and 839 XVs -> 58 XUVs
C:0 T:11 1557 XUs and 1766 XVs -> 97 XUVs
C:0 T:12 1790 XUs and 1529 XVs -> 113 XUVs
C:0 T:13 1109 XUs and 707 XVs -> 53 XUVs
C:0 T:14 1301 XUs and 1192 XVs -> 94 XUVs
C:0 T:15 4441 XUs and 4195 XVs -> 313 XUVs
1233 XUVs total
1039 collection wire objects
1233 potential space points
Neighbour search...
9745 tests to find 4348 neighbours
Iterating with no regularization...
Begin: 5.69566e+08
0 5.56338e+08
1 5.56216e+08
Now with regularization...
Begin: 5.47188e+08
0 5.47184e+08
17-Sep-2025 13:52:42 CEST  Closed output file "np02vd_raw_run039275_0527_df-s03-d1_dw_0_20250902T083523_reco_stage1_20250917T115242_keepup.root"

==================================================================================================================================
TimeTracker printout (sec)                          Min           Avg           Max         Median          RMS         nEvts   
==================================================================================================================================
Full event                                        130.516       183.09        324.533       163.793       51.951         18     
----------------------------------------------------------------------------------------------------------------------------------
source:HDF5RawInput3(read)                      5.8229e-05    8.14462e-05   0.000178784   7.6458e-05    2.48446e-05      18     
produce:tpcrawdecoder:PDVDTPCReader               16.5654       17.3691       18.308        17.3346      0.447547        18     
produce:triggerrawdecoder:PDVDTriggerReader4     0.0347214     0.0349256     0.0359857     0.0348316    0.000279674      18     
produce:pdvddaphne:DAPHNEReaderPDVD               4.28329       5.4904        6.65016       5.60886      0.741738        18     
produce:ophit:OpHitFinder                        0.0450876     0.0609828     0.0904344     0.0525031     0.0154773       18     
produce:opflash:OpFlashFinderVerticalDrift      0.00750116     0.0156857     0.026754      0.0154182    0.00554654       18     
produce:wclsdatavd:WireCellToolkit                64.7947       74.756        83.2824       76.5559       5.89714        18     
produce:gaushit:GausHitFinder                    0.869542       1.28878       1.78078       1.2091       0.281151        18     
produce:nhitsfilter:NumberOfHitsFilter          0.000290033   0.000542057   0.00107421    0.000450067   0.000234794      18     
produce:reco3d:SpacePointSolver                   8.25382       14.8685       23.2981       12.3411       4.94731        18     
produce:hitpdune:DisambigFromSpacePoints         0.0976672     0.218006      0.424406      0.184178      0.094684        18     
produce:pandora:StandardPandora                   20.3376       62.9925       192.245       43.1873       46.2006        18     
produce:pandoraTrack:LArPandoraTrackCreation     0.386265       1.03192       1.86592      0.841677       0.43844        18     
produce:pandoraGnocalo:GnocchiCalorimetry        0.0199759     0.030357      0.0409524     0.0274082     0.0065339       18     
[art]:TriggerResults:TriggerResultInserter      1.4988e-05    1.98032e-05   4.6177e-05     1.855e-05    6.49716e-06      18     
end_path:out1:RootOutput                         4.168e-06    5.18544e-06   1.8835e-05    4.3235e-06    3.31599e-06      18     
end_path:out1:RootOutput(write)                   4.33921       4.90053       5.40165       4.91093      0.263888        18     
==================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5061.66 MB
  Peak resident set size usage (VmHWM): 3178.48 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np02vd_raw_run039275_0527_df-s03-d1_dw_0_20250902T083523_reco_stage1_20250917T115242_keepup.root
\tHists: np02vd_raw_run039275_0527_df-s03-d1_dw_0_20250902T083523_reco_stage1_20250917T115242_keepup_hists.root
Forming reco metadata
Successfully opened file np02vd_raw_run039275_0527_df-s03-d1_dw_0_20250902T083523_reco_stage1_20250917T115242_keepup.root
Ran successfully
{
  "name": "np02vd_raw_run039275_0527_df-s03-d1_dw_0_20250902T083523_reco_stage1_20250917T115242_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": 1758109962.0,
    "core.end_time": 1758109962.0,
    "core.events": [
      189727,
      189747,
      189767,
      189787,
      189807,
      189827,
      189847,
      189867,
      189887,
      189907,
      189927,
      189947,
      189967,
      189987,
      190007,
      190027,
      190047,
      190067
    ],
    "core.event_count": 18,
    "core.first_event_number": 189727,
    "core.last_event_number": 190067,
    "core.data_stream": "physics",
    "core.file_content_status": "good",
    "core.file_type": "detector",
    "core.run_type": "vd-protodune",
    "core.runs": [
      39275
    ],
    "core.runs_subruns": [
      3927500001
    ],
    "dune.daq_test": false,
    "retention.status": "active",
    "retention.class": "physics"
  },
  "parents": [
    {
      "did": "vd-protodune:np02vd_raw_run039275_0527_df-s03-d1_dw_0_20250902T083523.hdf5"
    }
  ]
}Forming hist metadata
formed
{
  "name": "np02vd_raw_run039275_0527_df-s03-d1_dw_0_20250902T083523_reco_stage1_20250917T115242_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": 1758109962.0,
    "core.end_time": 1758109962.0,
    "core.data_stream": "physics",
    "core.file_content_status": "good",
    "core.file_type": "detector",
    "core.run_type": "vd-protodune",
    "core.runs": [
      39275
    ],
    "core.runs_subruns": [
      3927500001
    ],
    "dune.daq_test": false,
    "retention.status": "active",
    "retention.class": "physics"
  },
  "parents": [
    {
      "did": "vd-protodune:np02vd_raw_run039275_0527_df-s03-d1_dw_0_20250902T083523.hdf5"
    }
  ]
}