justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 266135.14@justin-prod-sched01.dune.hep.ac.uk

Jobsub ID266135.14@justin-prod-sched01.dune.hep.ac.uk
Workflow ID3552
Stage ID1
User namecalcuttj@fnal.gov
HTCondor Groupgroup_dune.prod_mcsim
RequestedProcessors1
RSS bytes4193255424 (3999 MiB)
Wall seconds limit18000 (5 hours)
Submitted time2024-09-29 02:21:47
SiteUK_Manchester
EntryUBoone_T2_UK_Manchester_ce02
Last heartbeat2024-09-29 03:59:05
From worker nodeHostnamewn1905250.tier2.hep.manchester.ac.uk
cpuinfoAMD EPYC 7513 32-Core Processor
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4193255424 (3999 MiB)
Wall seconds limit257400 (71 hours)
Inner Apptainer?True
Job statefinished
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-09-29 02:23:33
Input fileshd-protodune:np04hd_raw_run029389_0035_dataflow0_datawriter_0_20240929T010747.hdf5
JobscriptExit code0
Real time1h (5618s)
CPU time1h (4882s = 86%)
Outputting started2024-09-29 03:57:11
Output fileshd-protodune-det-reco:np04hd_raw_run029389_0035_dataflow0_datawriter_0_20240929T010747_reco_stage1_reco_stage2_20240929T035657_keepup.root
hd-protodune-det-reco:np04hd_raw_run029389_0035_dataflow0_datawriter_0_20240929T010747_reco_stage1_reco_stage2_20240929T035657_keepup_hists.root
Finished2024-09-29 03:59:05
Saved logsjustin-logs:266135.14-justin-prod-sched01.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

wiener with 46550 traces, 46550 summary
Retagger: tagging trace set: gauss with 34213 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 34213 traces tagged "gauss"
FrameSaver: q=760739 n=621976 tag=gauss
wclsFrameSaver: saving 46550 traces tagged "wiener"
FrameSaver: q=812434 n=556953 tag=wiener
2126 hits in TPC 0
2459 hits in TPC 1
6477 hits in TPC 2
3235 hits in TPC 3
1792 hits in TPC 4
2332 hits in TPC 5
2930 hits in TPC 6
2010 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 92 XUs and 169 XVs -> 72 XUVs
C:0 T:2 23082 XUs and 28838 XVs -> 1149 XUVs
C:0 T:3 25 XUs and 34 XVs -> 2 XUVs
C:0 T:4 15 XUs and 18 XVs -> 1 XUVs
C:0 T:5 3761 XUs and 5696 XVs -> 628 XUVs
C:0 T:6 25262 XUs and 5351 XVs -> 321 XUVs
C:0 T:7 39 XUs and 107 XVs -> 5 XUVs
2178 XUVs total
1009 collection wire objects
2178 potential space points
Neighbour search...
64666 tests to find 39592 neighbours
Iterating with no regularization...
Begin: 8.18571e+06
0 7.90557e+06
1 7.89061e+06
2 7.88869e+06
Now with regularization...
Begin: 7.46118e+06
0 7.46059e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

29-Sep-2024 04:56:57 BST  Closed output file "np04hd_raw_run029389_0035_dataflow0_datawriter_0_20240929T010747_reco_stage1_reco_stage2_20240929T035657_keepup.root"
29-Sep-2024 04:56:58 BST  Closed input file "np04hd_raw_run029389_0035_dataflow0_datawriter_0_20240929T010747_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              62.9414       101.426       188.678       95.6144       25.5104        39     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000646887   0.00351424    0.00603443    0.00382222    0.00128868       39     
produce:fembfilter:PDHDFEMBFilter                      0.567831      0.856241       1.04206      0.862487      0.0779993       39     
produce:wclsdatahd:WireCellToolkit                      34.9886       42.9974       52.7946       42.0862       3.80212        39     
produce:gaushit:GausHitFinder                          0.378102      0.830068       1.48327      0.799248       0.2127         39     
produce:nhitsfilter:NumberOfHitsFilter                0.000269377   0.000388793   0.00074401    0.000364516   9.19791e-05      39     
produce:reco3d:SpacePointSolver                        0.188497       1.21125       4.68094      0.751638       1.17036        39     
produce:hitpdune:DisambigFromSpacePoints               0.140616      0.684051       2.16051      0.610419      0.366903        39     
produce:pandora:StandardPandora                         4.72633       13.6937       43.4383       12.4361       7.32096        39     
produce:pandoraWriter:StandardPandora                  0.124555      0.235679      0.463668      0.223268      0.0687773       39     
produce:pandoraTrack:LArPandoraTrackCreation           0.485472        1.331        4.83484       1.1237       0.760815        39     
produce:pandoraShower:LArPandoraShowerCreation         0.308327       1.70449       7.81053       1.34262       1.2836         39     
produce:pandoracalo:Calorimetry                        0.274673      0.740912       2.33807      0.644293      0.371191        39     
produce:pandoracalonosce:Calorimetry                   0.243164       0.66088       2.13368      0.593528      0.346364        39     
produce:pandorapid:Chi2ParticleID                     0.00115616    0.00213633    0.00429826    0.00210279    0.000583329      39     
produce:pandoraShowercalo:ShowerCalorimetry            0.243217       1.62793       7.74668       1.25654       1.28954        39     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.237438       1.53347       6.8021        1.33043       1.1369         39     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.0750305     0.173396      0.356254       0.16755      0.0562865       39     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0275032     0.0606016      0.13846      0.0585654     0.020323        39     
produce:emtrkmichelid:EmTrackMichelId                   14.0406       31.0519       61.1034       28.9287       9.56846        39     
[art]:TriggerResults:TriggerResultInserter            4.1258e-05    6.03474e-05   0.000107332    5.292e-05    1.67471e-05      39     
end_path:out1:RootOutput                              1.3665e-05    2.00341e-05   5.7428e-05    1.8294e-05    7.40288e-06      39     
end_path:michelremoving:michelremoving                 0.0196936     0.124251      0.551753      0.0569644     0.127922        39     
end_path:michelremovinggnocchi:michelremoving          0.0172875     0.122073      0.542223      0.0530869     0.127825        39     
end_path:calibanagnocchi:CalibAnaTree                  0.166972      0.535801       1.48783      0.488086      0.262789        39     
end_path:out1:RootOutput(write)                         0.49489       1.05418       1.78752       1.03047      0.270735        39     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4969.54 MB
  Peak resident set size usage (VmHWM): 2611.71 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029389_0035_dataflow0_datawriter_0_20240929T010747_reco_stage1_reco_stage2_20240929T035657_keepup.root
\tHists: np04hd_raw_run029389_0035_dataflow0_datawriter_0_20240929T010747_reco_stage1_reco_stage2_20240929T035657_keepup_hists.root
Forming reco metadata
Successfully opened file np04hd_raw_run029389_0035_dataflow0_datawriter_0_20240929T010747_reco_stage1_reco_stage2_20240929T035657_keepup.root
Ran successfully
{
  "name": "np04hd_raw_run029389_0035_dataflow0_datawriter_0_20240929T010747_reco_stage1_reco_stage2_20240929T035657_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": 1727578209.0,
    "core.end_time": 1727582219.0,
    "core.events": [
      2732,
      2734,
      2736,
      2738,
      2740,
      2742,
      2744,
      2746,
      2748,
      2750,
      2752,
      2754,
      2756,
      2758,
      2760,
      2762,
      2764,
      2766,
      2768,
      2770,
      2772,
      2774,
      2776,
      2778,
      2780,
      2782,
      2784,
      2786,
      2788,
      2790,
      2792,
      2794,
      2796,
      2798,
      2800,
      2802,
      2804,
      2806,
      2808
    ],
    "core.event_count": 39,
    "core.first_event_number": 2732,
    "core.last_event_number": 2808,
    "core.data_stream": "cosmics",
    "core.file_content_status": "good",
    "core.file_type": "detector",
    "core.run_type": "hd-protodune",
    "core.runs": [
      29389
    ],
    "core.runs_subruns": [
      2938900001
    ],
    "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_run029389_0035_dataflow0_datawriter_0_20240929T010747.hdf5"
    }
  ]
}Forming hist metadata
formed
{
  "name": "np04hd_raw_run029389_0035_dataflow0_datawriter_0_20240929T010747_reco_stage1_reco_stage2_20240929T035657_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": 1727578209.0,
    "core.end_time": 1727582219.0,
    "core.data_stream": "cosmics",
    "core.file_content_status": "good",
    "core.file_type": "detector",
    "core.run_type": "hd-protodune",
    "core.runs": [
      29389
    ],
    "core.runs_subruns": [
      2938900001
    ],
    "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_run029389_0035_dataflow0_datawriter_0_20240929T010747.hdf5"
    }
  ]
}
justIN time: 2024-11-17 03:11:55 UTC       justIN version: 01.01.09