justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 79970.5@justin-prod-sched02.dune.hep.ac.uk

Jobsub ID79970.5@justin-prod-sched02.dune.hep.ac.uk
Workflow ID3512
Stage ID1
User namecalcuttj@fnal.gov
HTCondor Groupgroup_dune.prod_mcsim
RequestedProcessors1
RSS bytes4193255424 (3999 MiB)
Wall seconds limit18000 (5 hours)
Submitted time2024-09-27 08:23:06
SiteUS_FNAL-FermiGrid
EntryFNAL_GPGrid_ce04_mcore_op_duneonly
Last heartbeat2024-09-27 17:40:01
From worker nodeHostnamedunegli-4171995-0-fnpc7013.fnal.gov
cpuinfoAMD Opteron(tm) Processor 6376
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4193255424 (3999 MiB)
Wall seconds limit172800 (48 hours)
Inner Apptainer?True
Job statefinished
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-09-27 13:37:35
Input fileshd-protodune:np04hd_raw_run027346_0072_dataflow3_datawriter_0_20240621T154529.hdf5
JobscriptExit code0
Real time3h (13608s)
CPU time3h (12083s = 88%)
Outputting started2024-09-27 17:24:25
Output fileshd-protodune-det-reco:np04hd_raw_run027346_0072_dataflow3_datawriter_0_20240621T154529_reco_stage1_reco_stage2_20240927T172334_keepup.root
hd-protodune-det-reco:np04hd_raw_run027346_0072_dataflow3_datawriter_0_20240621T154529_reco_stage1_reco_stage2_20240927T172334_keepup_hists.root
Finished2024-09-27 17:40:01
Saved logsjustin-logs:79970.5-justin-prod-sched02.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

66267 traces, 66267 summary
Retagger: tagging trace set: gauss with 51593 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 51593 traces tagged "gauss"
FrameSaver: q=1.84253e+06 n=969582 tag=gauss
wclsFrameSaver: saving 66267 traces tagged "wiener"
FrameSaver: q=1.99688e+06 n=887052 tag=wiener
4147 hits in TPC 0
5298 hits in TPC 1
7178 hits in TPC 2
4760 hits in TPC 3
3457 hits in TPC 4
4028 hits in TPC 5
5760 hits in TPC 6
5279 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 6616 XUs and 4613 XVs -> 244 XUVs
C:0 T:2 20312 XUs and 18661 XVs -> 713 XUVs
C:0 T:3 512 XUs and 610 XVs -> 25 XUVs
C:0 T:4 213 XUs and 159 XVs -> 9 XUVs
C:0 T:5 8837 XUs and 9202 XVs -> 299 XUVs
C:0 T:6 40430 XUs and 19490 XVs -> 607 XUVs
C:0 T:7 3154 XUs and 3598 XVs -> 549 XUVs
2446 XUVs total
1287 collection wire objects
2446 potential space points
Neighbour search...
83896 tests to find 42986 neighbours
Iterating with no regularization...
Begin: 7.72406e+07
0 6.23414e+07
1 6.08132e+07
2 6.07726e+07
Now with regularization...
Begin: 5.94491e+07
0 5.94317e+07
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

27-Sep-2024 17:23:34 UTC  Closed output file "np04hd_raw_run027346_0072_dataflow3_datawriter_0_20240621T154529_reco_stage1_reco_stage2_20240927T172334_keepup.root"
27-Sep-2024 17:23:34 UTC  Closed input file "np04hd_raw_run027346_0072_dataflow3_datawriter_0_20240621T154529_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              212.231       291.758       386.037       280.672       49.3492        35     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000810274    0.0140474     0.361338     0.00409728     0.0595911       35     
produce:fembfilter:PDHDFEMBFilter                       1.55439       2.45282       3.72886       2.04237      0.749138        35     
produce:wclsdatahd:WireCellToolkit                      78.2155       92.2865       109.406       91.8745       8.55038        35     
produce:gaushit:GausHitFinder                           1.23278       1.99497       3.09351       1.98191      0.435343        35     
produce:nhitsfilter:NumberOfHitsFilter                0.000700058    0.0011619    0.00206503    0.00115962    0.000262158      35     
produce:reco3d:SpacePointSolver                        0.506305       1.65618       3.25555       1.32744      0.801778        35     
produce:hitpdune:DisambigFromSpacePoints                0.50582       1.31116       2.24124       1.2294       0.486303        35     
produce:pandora:StandardPandora                         14.8456       37.4382       57.5761       37.5247       12.5641        35     
produce:pandoraWriter:StandardPandora                  0.239429      0.395251      0.567519      0.390467      0.0814215       35     
produce:pandoraTrack:LArPandoraTrackCreation            1.61139       3.72215       7.54902       3.51752       1.33541        35     
produce:pandoraShower:LArPandoraShowerCreation          1.18275       4.32787       8.94547       3.8818        1.89711        35     
produce:pandoracalo:Calorimetry                        0.748965       1.70215       2.86145       1.5772       0.551727        35     
produce:pandoracalonosce:Calorimetry                   0.671824       1.55919       2.54141       1.47438      0.499599        35     
produce:pandorapid:Chi2ParticleID                     0.00308753    0.00465972    0.00656175    0.00450209    0.000893628      35     
produce:pandoraShowercalo:ShowerCalorimetry            0.970964       3.60242       7.03099       3.25489       1.55512        35     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.927595       3.37915       6.22157       3.08041       1.41248        35     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.206252      0.336744      0.545658      0.325574      0.0819947       35     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0632918     0.102896      0.162966      0.100358      0.0241271       35     
produce:emtrkmichelid:EmTrackMichelId                   90.3789       132.228       186.038       125.298       27.9251        35     
[art]:TriggerResults:TriggerResultInserter             3.999e-05    7.10906e-05   0.000170744   6.2574e-05    2.7274e-05       35     
end_path:out1:RootOutput                              1.2557e-05    1.80438e-05   6.5023e-05    1.5139e-05    9.81643e-06      35     
end_path:michelremoving:michelremoving                 0.0352017     0.176596      0.959884      0.0703817     0.196701        35     
end_path:michelremovinggnocchi:michelremoving          0.0296472      0.16979      0.957755      0.0614069     0.197131        35     
end_path:calibanagnocchi:CalibAnaTree                  0.424712       1.19588       2.24011       1.13912      0.412588        35     
end_path:out1:RootOutput(write)                        0.902916       1.53692       2.28793       1.51791      0.377834        35     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4946.5 MB
  Peak resident set size usage (VmHWM): 2601.78 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run027346_0072_dataflow3_datawriter_0_20240621T154529_reco_stage1_reco_stage2_20240927T172334_keepup.root
\tHists: np04hd_raw_run027346_0072_dataflow3_datawriter_0_20240621T154529_reco_stage1_reco_stage2_20240927T172334_keepup_hists.root
Forming reco metadata
Successfully opened file np04hd_raw_run027346_0072_dataflow3_datawriter_0_20240621T154529_reco_stage1_reco_stage2_20240927T172334_keepup.root
Ran successfully
{
  "name": "np04hd_raw_run027346_0072_dataflow3_datawriter_0_20240621T154529_reco_stage1_reco_stage2_20240927T172334_keepup.root",
  "namespace": "hd-protodune-det-reco",
  "metadata": {
    "core.file_format": "artroot",
    "core.application.name": "reco",
    "core.application.family": "dunesw",
    "core.application.version": "v09_91_02d01",
    "core.data_tier": "full-reconstructed",
    "dune.config_file": "standard_reco_stage2_calibration_protodunehd_keepup.fcl",
    "dune.campaign": "hd-protodune-reco-keepup-v0",
    "core.start_time": 1727447500.0,
    "core.end_time": 1727457848.0,
    "core.events": [
      10116,
      10120,
      10124,
      10128,
      10132,
      10136,
      10140,
      10144,
      10148,
      10152,
      10156,
      10160,
      10164,
      10168,
      10172,
      10176,
      10180,
      10184,
      10188,
      10192,
      10196,
      10200,
      10204,
      10208,
      10212,
      10216,
      10220,
      10224,
      10228,
      10232,
      10236,
      10240,
      10244,
      10248,
      10252
    ],
    "core.event_count": 35,
    "core.first_event_number": 10116,
    "core.last_event_number": 10252,
    "core.data_stream": "physics",
    "core.file_content_status": "good",
    "core.file_type": "detector",
    "core.run_type": "hd-protodune",
    "core.runs": [
      27346
    ],
    "core.runs_subruns": [
      2734600001
    ],
    "dune.daq_test": false,
    "retention.status": "active",
    "retention.class": "physics",
    "origin.applications.config_files": {
      "reco1": "standard_reco_stage1_protodunehd_keepup.fcl"
    },
    "origin.applications.versions": {
      "reco1": "v09_91_02d01"
    },
    "origin.applications.names": [
      "reco1"
    ]
  },
  "parents": [
    {
      "did": "hd-protodune:np04hd_raw_run027346_0072_dataflow3_datawriter_0_20240621T154529.hdf5"
    }
  ]
}Forming hist metadata
formed
{
  "name": "np04hd_raw_run027346_0072_dataflow3_datawriter_0_20240621T154529_reco_stage1_reco_stage2_20240927T172334_keepup_hists.root",
  "namespace": "hd-protodune-det-reco",
  "metadata": {
    "core.file_format": "root",
    "core.application.name": "reco",
    "core.application.family": "dunesw",
    "core.application.version": "v09_91_02d01",
    "core.data_tier": "root-tuple-virtual",
    "dune.config_file": "standard_reco_stage2_calibration_protodunehd_keepup.fcl",
    "dune.campaign": "hd-protodune-reco-keepup-v0",
    "core.start_time": 1727447500.0,
    "core.end_time": 1727457848.0,
    "core.data_stream": "physics",
    "core.file_content_status": "good",
    "core.file_type": "detector",
    "core.run_type": "hd-protodune",
    "core.runs": [
      27346
    ],
    "core.runs_subruns": [
      2734600001
    ],
    "dune.daq_test": false,
    "retention.status": "active",
    "retention.class": "physics",
    "origin.applications.config_files": {
      "reco1": "standard_reco_stage1_protodunehd_keepup.fcl"
    },
    "origin.applications.versions": {
      "reco1": "v09_91_02d01"
    },
    "origin.applications.names": [
      "reco1"
    ]
  },
  "parents": [
    {
      "did": "hd-protodune:np04hd_raw_run027346_0072_dataflow3_datawriter_0_20240621T154529.hdf5"
    }
  ]
}
justIN time: 2024-11-17 08:54:21 UTC       justIN version: 01.01.09