Jobsub ID 207247.16@dunegpschedd02.fnal.gov

Jobsub ID	207247.16@dunegpschedd02.fnal.gov
Workflow ID	8090
Stage ID	1
User name	calcuttj@fnal.gov
HTCondor Group	group_dune
Requested	Processors	1
	GPU	No
	RSS bytes	8387559424 (7999 MiB)
	Wall seconds limit	80000 (22 hours)
Submitted time	2025-09-26 14:09:37
Site	UK_RAL-PPD
Entry	CMSHTPC_T2_UK_SGrid_RALPP_hep206
Last heartbeat	2025-09-26 17:03:51
From worker node	Hostname	heplnc161.pp.rl.ac.uk
	cpuinfo	AMD EPYC 7763 64-Core Processor
	OS release	Scientific Linux release 7.9 (Nitrogen)
	Processors	1
	RSS bytes	10485760000 (10000 MiB)
	Wall seconds limit	257400 (71 hours)
	GPU
	Inner Apptainer?	True
Job state	finished
Started	2025-09-26 15:24:55
Input files	usertests:prod_beam_p5GeV_protodunehd_1_212254_181_1758823043_pdint_TPC1_pdint_TPC2_pdint_TPC5_pdint_TPC6.root
Jobscript	Exit code	0
	Real time	1h (5795s)
	CPU time	1h (5565s = 96%)
	Max RSS bytes	6710108160 (6399 MiB)
Outputting started	2025-09-26 17:01:32
Output files	usertests:prod_beam_p5GeV_protodunehd_1_207247_16_1758900306_detsim_reco1.root
Finished	2025-09-26 17:03:51
Saved logs	justin-logs:207247.16-dunegpschedd02.fnal.gov.logs.tgz
List job events Cached HTCondor job logs

Jobscript log (last 10,000 characters)

aces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 74178 traces tagged "gauss"
FrameSaver: q=2.31761e+06 n=1152003 tag=gauss
wclsFrameSaver: saving 91068 traces tagged "wiener"
FrameSaver: q=2.99584e+06 n=1121457 tag=wiener
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 91598 traces, 91598 summary
Retagger: tagging trace set: gauss with 76078 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 76078 traces tagged "gauss"
FrameSaver: q=2.28266e+06 n=1264515 tag=gauss
wclsFrameSaver: saving 91598 traces tagged "wiener"
FrameSaver: q=2.76515e+06 n=1232497 tag=wiener
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 100591 traces, 100591 summary
Retagger: tagging trace set: gauss with 78479 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 78479 traces tagged "gauss"
FrameSaver: q=2.41223e+06 n=1244220 tag=gauss
wclsFrameSaver: saving 100591 traces tagged "wiener"
FrameSaver: q=3.01225e+06 n=1217831 tag=wiener
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 93095 traces, 93095 summary
Retagger: tagging trace set: gauss with 74565 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 74565 traces tagged "gauss"
FrameSaver: q=2.09714e+06 n=1142112 tag=gauss
wclsFrameSaver: saving 93095 traces tagged "wiener"
FrameSaver: q=2.82979e+06 n=1096434 tag=wiener
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 101052 traces, 101052 summary
Retagger: tagging trace set: gauss with 79421 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 79421 traces tagged "gauss"
FrameSaver: q=2.50415e+06 n=1224005 tag=gauss
wclsFrameSaver: saving 101052 traces tagged "wiener"
FrameSaver: q=3.22173e+06 n=1185071 tag=wiener
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 89410 traces, 89410 summary
Retagger: tagging trace set: gauss with 71435 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 71435 traces tagged "gauss"
FrameSaver: q=2.17811e+06 n=1152109 tag=gauss
wclsFrameSaver: saving 89410 traces tagged "wiener"
FrameSaver: q=2.62196e+06 n=1108637 tag=wiener
26-Sep-2025 18:01:30 BST  Closed output file "prod_beam_p5GeV_protodunehd_1_207247_16_1758900306_detsim_reco1.root"
26-Sep-2025 18:01:30 BST  Closed input file "prod_beam_p5GeV_protodunehd_1_207247_16_1758900306_detsim.root"

======================================================================================================================================
TimeTracker printout (sec)                              Min           Avg           Max         Median          RMS         nEvts   
======================================================================================================================================
Full event                                            107.371       133.695       167.439       129.291       17.8721        10     
--------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                              0.00195701    0.00511563    0.00861078    0.00497824    0.00218123       10     
reco:opdec:Deconvolution                             0.683155      0.831392       1.0831       0.792387       0.11898        10     
reco:ophitspe:OpHitFinderDeco                        0.123825      0.150744      0.240877       0.13506      0.0341321       10     
reco:opflash:OpFlashFinder                           0.0752213     0.090852      0.125361      0.0872865     0.015467        10     
reco:opslicer:OpSlicer                               0.134615      0.238155      0.331183      0.225818      0.060455        10     
reco:wclsdatahd:WireCellToolkit                       40.7354       42.8987       46.3712       41.7245       2.09425        10     
reco:gaushit:GausHitFinder                           0.619332      0.772828       1.01657      0.761983      0.119079        10     
reco:nhitsfilter:NumberOfHitsFilter                  0.0002725    0.000490386   0.000944851   0.00034905    0.000248459      10     
reco:reco3d:SpacePointSolver                         0.361077      0.893636       2.14301      0.731771       0.46531        10     
reco:hitpdune:DisambigFromSpacePoints                0.437999      0.671751       1.16608      0.632207      0.200471        10     
reco:pandora:StandardPandora                          12.8915       25.4701       55.7399       21.4746       12.2387        10     
reco:pandoraWriter:StandardPandora                   0.200084      0.294325      0.445639      0.304513      0.0712939       10     
reco:pandoraTrack:LArPandoraTrackCreation             1.18805       1.84082       3.03822       1.76537      0.523025        10     
reco:pandoraShower:LArPandoraShowerCreation          0.867377       1.85674       2.68704       1.90911      0.500459        10     
reco:pandoracalo:Calorimetry                         0.628943      0.931995       1.31761      0.881639      0.208387        10     
reco:pandoracalonosce:Calorimetry                    0.518004      0.842276       1.24255      0.811645      0.193725        10     
reco:pandoraShowercalo:ShowerCalorimetry             0.558401       1.70374       2.82797       1.6703       0.579571        10     
reco:pandoraShowercalonosce:ShowerCalorimetry        0.550287       1.62136       2.54027       1.63134      0.506311        10     
reco:pandoraGnocchiCalo:GnocchiCalorimetry           0.0397102     0.0457102     0.0575565      0.04401     0.00560296       10     
reco:pandoraGnocchiCalonosce:GnocchiCalorimetry      0.0365743     0.0448808     0.058435      0.0428742    0.00656119       10     
reco:emtrkmichelid:EmTrackMichelId                    28.3259       35.6325       42.3029       36.1675       3.56586        10     
reco:crttag:SingleCRTMatchingProducer               0.00514319    0.00807929      0.01129     0.00753717    0.00233231       10     
reco:crtreco:TwoCRTMatchingProducer                 0.00398363    0.00581861    0.00854114    0.00580732    0.00133813       10     
reco:pandora2Track:LArPandoraTrackCreation            2.11617       4.94013       7.73483       4.76056       1.6379         10     
reco:pandora2calo:ShowerCalorimetry                  0.497845       1.62016       2.88031       1.44682      0.648103        10     
reco:pandora2calonosce:ShowerCalorimetry              0.48994       1.63917       3.00752       1.44016      0.709833        10     
reco:pandora2GnocchiCalo:GnocchiCalorimetry          0.035877      0.0497918     0.0744582      0.0451       0.0114859       10     
reco:pandora2GnocchiCalonosce:GnocchiCalorimetry     0.0388205     0.0492983     0.0753715     0.0459414     0.0106173       10     
reco:pandora2Shower:LArPandoraShowerCreation         0.738889       2.15509       4.33875       1.97727      0.922229        10     
reco:pandora2Showercalo:ShowerCalorimetry            0.754313       2.10132       3.20932        2.02        0.686078        10     
reco:pandora2Showercalonosce:ShowerCalorimetry       0.855641       2.06113       3.17288       2.01257      0.643955        10     
[art]:TriggerResults:TriggerResultInserter          2.6509e-05    4.35075e-05   0.000129363   3.41445e-05   2.89519e-05      10     
end_path:out1:RootOutput                             9.969e-06    1.48018e-05   3.6248e-05    1.2007e-05    7.37204e-06      10     
end_path:out1:RootOutput(write)                       1.83775       2.09812       2.47514       2.02076       0.22461        10     
======================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 6222.35 MB
  Peak resident set size usage (VmHWM): 3951.85 MB
  Details saved in: 'mem.db'
====================================================================================================

{'art_out': 'prod_beam_p5GeV_protodunehd_1_207247_16_1758900306_detsim_reco1.root', 'start_time': 1758904664.3483212, 'end_time': 1758906091.349546}
lsing
total 12G
-rw-r--r-- 1 pltdune01 pltdune 5.9G Sep 26 18:01 prod_beam_p5GeV_protodunehd_1_207247_16_1758900306_detsim_reco1.root
-rw-r--r-- 1 pltdune01 pltdune 5.6G Sep 26 17:37 prod_beam_p5GeV_protodunehd_1_207247_16_1758900306_detsim.root
-rw-r--r-- 1 pltdune01 pltdune  53M Sep 26 18:00 Pandora_Events.pndr
-rw-r--r-- 1 pltdune01 pltdune 196K Sep 26 18:01 mem.db
-rw-r--r-- 1 pltdune01 pltdune 181K Sep 26 18:01 jobscript.log
-rw-r--r-- 1 pltdune01 pltdune  36K Sep 26 18:01 time.db
-rw-r--r-- 1 pltdune01 pltdune  13K Sep 26 18:01 prod_beam_p5GeV_protodunehd_1_207247_16_1758900306_detsim_reco1.log
-rw-r--r-- 1 pltdune01 pltdune  13K Sep 26 18:01 prod_beam_p5GeV_protodunehd_1_207247_16_1758900306_detsim_reco1.err
-rw-r--r-- 1 pltdune01 pltdune  12K Sep 26 17:37 prod_beam_p5GeV_protodunehd_1_207247_16_1758900306_detsim.log
-rw-r--r-- 1 pltdune01 pltdune 4.4K Sep 26 17:37 prod_beam_p5GeV_protodunehd_1_207247_16_1758900306_detsim.err
-rw-r--r-- 1 pltdune01 pltdune 3.5K Sep 26 18:01 Pandora_Geometry.xml
-rw-r--r-- 1 pltdune01 pltdune  519 Sep 26 17:37 detsim_single_protodunehd_hist.root
-rw-r--r-- 1 pltdune01 pltdune  519 Sep 26 18:01 reco_protodunehd_hist.root
-rw-r--r-- 1 pltdune01 pltdune  111 Sep 26 16:25 all-input-dids.txt
-rw-r--r-- 1 pltdune01 pltdune    0 Sep 26 17:40 ProtoDUNE.log
-rw-r--r-- 1 pltdune01 pltdune    0 Sep 26 17:37 debugprod.log
disk usage
12G	.