justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 241480.0@dunegpschedd01.fnal.gov

Jobsub ID241480.0@dunegpschedd01.fnal.gov
Workflow ID9454
Stage ID1
User namemwrobel@fnal.gov
HTCondor Groupgroup_dune
RequestedProcessors1
GPUNo
RSS bytes9437184000 (9000 MiB)
Wall seconds limit80000 (22 hours)
Submitted time2025-10-31 19:51:22
SiteUS_UChicago
EntryEngage_US_MWT2_uct2_gk02_condce_mcore
Last heartbeat2025-10-31 21:31:46
From worker nodeHostnamemwt2-c042.campuscluster.illinois.edu
cpuinfoAMD EPYC 7443 24-Core Processor
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes10485760000 (10000 MiB)
Wall seconds limit86400 (24 hours)
GPU
Inner Apptainer?True
Job statefinished
Started2025-10-31 19:52:50
Input filesusertests:pdhd_prod_beam__226242_27_1_20251008T182742Z_gen_g4_IonScintPDExt.root_227038_65_1_20251010T163331Z_PDInt.root
JobscriptExit code0
Real time1h (5813s)
CPU time1h (5598s = 96%)
Max RSS bytes6324404224 (6031 MiB)
Outputting started2025-10-31 21:29:43
Output filesusertests:pdhd_prod_beam__226242_27_1_20251008T182742Z_gen_g4_IonScintPDExt.root_227038_65_1_20251010T163331Z_PDInt.root_241480_0_1_20251031T195304Z_detsim_reco1.root
Finished2025-10-31 21:31:46
Saved logsjustin-logs:241480.0-dunegpschedd01.fnal.gov.logs.tgz
List job events     Cached HTCondor job logs

Jobscript log (last 10,000 characters)

nd 399474 neighbours
Iterating with no regularization...
Begin: 5.26972e+07
0 4.58362e+07
1 4.52084e+07
2 4.51471e+07
3 4.51306e+07
Now with regularization...
Begin: 4.34181e+07
0 4.34062e+07
Begin processing the 9th record. run: 20250627 subRun: 1 event: 88 at 31-Oct-2025 16:23:26 CDT

Running Ophitfinder with InputDigiType = 'recob'
Found hits: 15712!
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 96344 traces, 96344 summary
Retagger: tagging trace set: gauss with 75314 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 75314 traces tagged "gauss"
FrameSaver: q=2.36069e+06 n=1187344 tag=gauss
wclsFrameSaver: saving 96344 traces tagged "wiener"
FrameSaver: q=2.85969e+06 n=1134211 tag=wiener
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 10471 XUs and 9941 XVs -> 84 XUVs
C:0 T:1 45651 XUs and 37760 XVs -> 950 XUVs
C:0 T:2 34293 XUs and 57469 XVs -> 4109 XUVs
C:0 T:3 24 XUs and 25 XVs -> 0 XUVs
C:0 T:4 10 XUs and 7 XVs -> 0 XUVs
C:0 T:5 17882 XUs and 15204 XVs -> 227 XUVs
C:0 T:6 38969 XUs and 33774 XVs -> 1583 XUVs
C:0 T:7 13 XUs and 14 XVs -> 6 XUVs
6959 XUVs total
2464 collection wire objects
6959 potential space points
Neighbour search...
306309 tests to find 166872 neighbours
Iterating with no regularization...
Begin: 2.88454e+07
0 2.55348e+07
1 2.52556e+07
2 2.51981e+07
3 2.51782e+07
Now with regularization...
Begin: 2.30531e+07
0 2.3039e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
Begin processing the 10th record. run: 20250627 subRun: 1 event: 89 at 31-Oct-2025 16:26:18 CDT

Running Ophitfinder with InputDigiType = 'recob'
Found hits: 11874!
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=6000 keeping as is
Retagger: tagging trace set: wiener with 97521 traces, 97521 summary
Retagger: tagging trace set: gauss with 78683 traces, 0 summary
wclsFrameSaver saving cooked to 6000 ticks
wclsFrameSaver: saving 78683 traces tagged "gauss"
FrameSaver: q=2.5701e+06 n=1271669 tag=gauss
wclsFrameSaver: saving 97521 traces tagged "wiener"
FrameSaver: q=3.32664e+06 n=1234309 tag=wiener
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 14266 XUs and 11335 XVs -> 128 XUVs
C:0 T:1 120190 XUs and 96203 XVs -> 4168 XUVs
C:0 T:2 19131 XUs and 14335 XVs -> 767 XUVs
C:0 T:3 0 XUs and 6 XVs -> 0 XUVs
C:0 T:4 7 XUs and 9 XVs -> 3 XUVs
C:0 T:5 50990 XUs and 30945 XVs -> 1604 XUVs
C:0 T:6 22970 XUs and 19057 XVs -> 1159 XUVs
C:0 T:7 8 XUs and 18 XVs -> 2 XUVs
7831 XUVs total
3454 collection wire objects
7831 potential space points
Neighbour search...
543963 tests to find 165618 neighbours
Iterating with no regularization...
Begin: 6.92697e+07
0 6.37928e+07
1 6.34525e+07
2 6.34316e+07
Now with regularization...
Begin: 6.11666e+07
0 6.11612e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
31-Oct-2025 16:29:42 CDT  Closed output file "pdhd_prod_beam__226242_27_1_20251008T182742Z_gen_g4_IonScintPDExt.root_227038_65_1_20251010T163331Z_PDInt.root_241480_0_1_20251031T195304Z_detsim_reco1.root"
31-Oct-2025 16:29:42 CDT  Closed input file "temp_detsim.root"

======================================================================================================================================
TimeTracker printout (sec)                              Min           Avg           Max         Median          RMS         nEvts   
======================================================================================================================================
Full event                                            108.337       150.281       198.363       146.759       25.4846        10     
--------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                              0.00145093    0.00712153     0.0135592    0.00773165    0.00393108       10     
reco:opdec:Deconvolution                              0.70597      0.852103       1.01644      0.834672      0.106061        10     
reco:ophitspe:OpHitFinderDeco                        0.195319      0.211451      0.226142      0.211569      0.0100687       10     
reco:opflash:OpFlashFinder                           0.0579394     0.0810148      0.11342      0.0767659     0.0162265       10     
reco:opslicer:OpSlicer                               0.173098      0.244861      0.306983      0.240475      0.0377389       10     
reco:wclsdatahd:WireCellToolkit                       47.7164       51.6469       55.0082       51.6598       2.59458        10     
reco:gaushit:GausHitFinder                           0.698722      0.919186       1.13365      0.907644      0.150772        10     
reco:nhitsfilter:NumberOfHitsFilter                 0.000306978   0.000442825   0.000666213   0.000433511   9.98467e-05      10     
reco:reco3d:SpacePointSolver                         0.465926       1.21866       3.25729       1.17141      0.757439        10     
reco:hitpdune:DisambigFromSpacePoints                0.426656      0.786308       1.14389      0.755331      0.219523        10     
reco:pandora:StandardPandora                          10.7618       25.7717       36.3036       25.3362       7.33719        10     
reco:pandoraWriter:StandardPandora                   0.249775      0.350126      0.455932       0.34205      0.0598745       10     
reco:pandoraTrack:LArPandoraTrackCreation             1.13636       2.35556       3.56962       2.52037      0.811712        10     
reco:pandoraShower:LArPandoraShowerCreation           1.13216       2.2759        4.24319       2.10313       1.05941        10     
reco:pandoracalo:Calorimetry                         0.596359       1.13963       1.99145       0.98035      0.427172        10     
reco:pandoracalonosce:Calorimetry                     0.60012       1.11887       1.8918        1.10191      0.377135        10     
reco:pandoraShowercalo:ShowerCalorimetry              1.08592       2.26666       5.24495       1.86705       1.20945        10     
reco:pandoraShowercalonosce:ShowerCalorimetry         1.08537       2.15099       4.99529       1.69454       1.11854        10     
reco:pandoraGnocchiCalo:GnocchiCalorimetry           0.0586622     0.0682758     0.0791287     0.0678701    0.00610278       10     
reco:pandoraGnocchiCalonosce:GnocchiCalorimetry      0.0587323     0.0678914     0.0896201     0.0649092     0.009033        10     
reco:emtrkmichelid:EmTrackMichelId                    22.8478       37.335        50.3866       34.6898       8.36102        10     
reco:crttag:SingleCRTMatchingProducer               0.00602124    0.00914355     0.0106709    0.00939334    0.00123466       10     
reco:crtreco:TwoCRTMatchingProducer                 0.00451091    0.00695619    0.00924543    0.00676038    0.00128305       10     
reco:pandora2Track:LArPandoraTrackCreation              3.1         6.00793       11.1199       5.50314       2.3956         10     
reco:pandora2calo:ShowerCalorimetry                   0.91961       1.91545       4.42555       1.58999       1.01024        10     
reco:pandora2calonosce:ShowerCalorimetry             0.893104       1.84027       3.91975       1.55306      0.922494        10     
reco:pandora2GnocchiCalo:GnocchiCalorimetry          0.0411139     0.0676116     0.0854561     0.0669348     0.0115773       10     
reco:pandora2GnocchiCalonosce:GnocchiCalorimetry     0.0455579     0.0662726     0.0806576     0.0654387    0.00963237       10     
reco:pandora2Shower:LArPandoraShowerCreation          1.02029       2.26793       3.62698       2.19596      0.887072        10     
reco:pandora2Showercalo:ShowerCalorimetry             1.22333       2.31519       4.22582       2.12585      0.871723        10     
reco:pandora2Showercalonosce:ShowerCalorimetry        1.19218       2.25742       4.24337       1.94385       0.90674        10     
[art]:TriggerResults:TriggerResultInserter           4.268e-05     5.745e-05    0.000152557   4.6332e-05    3.19208e-05      10     
end_path:out1:RootOutput                             1.048e-05    1.72974e-05   4.7068e-05    1.3926e-05    1.02643e-05      10     
end_path:out1:RootOutput(write)                       2.06909       2.48373       2.81918       2.53381      0.249478        10     
======================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 6145.88 MB
  Peak resident set size usage (VmHWM): 3912.28 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Reco returns 0
.:
total 10857108
-rw-r--r-- 1 dune osgvo      39047 Oct 31 16:29 jobscript.log
-rw-r--r-- 1 dune osgvo        200 Oct 31 16:29 justin-processed-pfns.txt
-rw-r--r-- 1 dune osgvo        519 Oct 31 16:29 reco_protodunehd_hist.root
-rw-r--r-- 1 dune osgvo       3574 Oct 31 16:29 Pandora_Geometry.xml
-rw-r--r-- 1 dune osgvo     200704 Oct 31 16:29 mem.db
-rw-r--r-- 1 dune osgvo      36864 Oct 31 16:29 time.db
-rw-r--r-- 1 dune osgvo 5696634027 Oct 31 16:29 pdhd_prod_beam__226242_27_1_20251008T182742Z_gen_g4_IonScintPDExt.root_227038_65_1_20251010T163331Z_PDInt.root_241480_0_1_20251031T195304Z_detsim_reco1.root
-rw-r--r-- 1 dune osgvo   49574380 Oct 31 16:27 Pandora_Events.pndr
-rw-r--r-- 1 dune osgvo          0 Oct 31 16:05 ProtoDUNE.log
-rw-r--r-- 1 dune osgvo          0 Oct 31 16:02 debugprod.log
-rw-r--r-- 1 dune osgvo        519 Oct 31 16:02 detsim_single_protodunehd_hist.root
-rw-r--r-- 1 dune osgvo 5371143187 Oct 31 16:02 temp_detsim.root
-rw-r--r-- 1 dune osgvo        121 Oct 31 14:53 all-input-dids.txt
justIN time: 2025-11-05 04:51:49 UTC       justIN version: 01.05.01