justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID79331.0@justin-prod-sched02.dune.hep.ac.uk
Workflow ID3450
Stage ID1
User namecalcuttj@fnal.gov
HTCondor Groupgroup_dune.prod_mcsim
RequestedProcessors1
RSS bytes4193255424 (3999 MiB)
Wall seconds limit18000 (5 hours)
Submitted time2024-09-26 15:43:24
SiteUK_Manchester
EntryUBoone_T2_UK_Manchester_ce01
Last heartbeat2024-09-26 17:41:21
From worker nodeHostnamewn1910251.tier2.hep.manchester.ac.uk
cpuinfoIntel(R) Xeon(R) Gold 5118 CPU @ 2.30GHz
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-26 15:45:06
Input fileshd-protodune:np04hd_raw_run029107_1518_dataflow2_datawriter_0_20240907T165414.hdf5
JobscriptExit code0
Real time1h (6878s)
CPU time1h (6324s = 91%)
Outputting started2024-09-26 17:39:45
Output fileshd-protodune-det-reco:np04hd_raw_run029107_1518_dataflow2_datawriter_0_20240907T165414_reco_stage1_reco_stage2_20240926T173931_keepup.root
hd-protodune-det-reco:np04hd_raw_run029107_1518_dataflow2_datawriter_0_20240907T165414_reco_stage1_reco_stage2_20240926T173931_keepup_hists.root
Finished2024-09-26 17:41:21
Saved logsjustin-logs:79331.0-justin-prod-sched02.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

et: wiener with 59630 traces, 59630 summary
Retagger: tagging trace set: gauss with 44190 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 44190 traces tagged "gauss"
FrameSaver: q=947932 n=838338 tag=gauss
wclsFrameSaver: saving 59630 traces tagged "wiener"
FrameSaver: q=1.02121e+06 n=764601 tag=wiener
3147 hits in TPC 0
3882 hits in TPC 1
6075 hits in TPC 2
4259 hits in TPC 3
2464 hits in TPC 4
4569 hits in TPC 5
3991 hits in TPC 6
3302 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 2599 XUs and 3629 XVs -> 433 XUVs
C:0 T:2 16458 XUs and 23666 XVs -> 2120 XUVs
C:0 T:3 334 XUs and 456 XVs -> 20 XUVs
C:0 T:4 59 XUs and 92 XVs -> 2 XUVs
C:0 T:5 6924 XUs and 8426 XVs -> 156 XUVs
C:0 T:6 10982 XUs and 10030 XVs -> 349 XUVs
C:0 T:7 142 XUs and 234 XVs -> 8 XUVs
3088 XUVs total
818 collection wire objects
3088 potential space points
Neighbour search...
160172 tests to find 87410 neighbours
Iterating with no regularization...
Begin: 3.3927e+06
0 2.96117e+06
1 2.89754e+06
2 2.88474e+06
3 2.87978e+06
4 2.87719e+06
Now with regularization...
Begin: 2.4692e+06
0 2.46693e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

26-Sep-2024 18:39:31 BST  Closed output file "np04hd_raw_run029107_1518_dataflow2_datawriter_0_20240907T165414_reco_stage1_reco_stage2_20240926T173931_keepup.root"
26-Sep-2024 18:39:31 BST  Closed input file "np04hd_raw_run029107_1518_dataflow2_datawriter_0_20240907T165414_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              66.1359       154.333       212.281       154.703       28.6752        30     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000691428   0.00563391     0.0794313    0.00286928     0.0138441       30     
produce:fembfilter:PDHDFEMBFilter                      0.726817       1.09847       1.58142       1.1015       0.129241        30     
produce:wclsdatahd:WireCellToolkit                      52.9533       64.5123       72.1573       65.0597       4.45657        30     
produce:gaushit:GausHitFinder                          0.676549       1.16399       1.6502        1.20961      0.265779        30     
produce:nhitsfilter:NumberOfHitsFilter                0.000348815    0.0010254     0.0139045    0.000581528   0.00239537       30     
produce:reco3d:SpacePointSolver                        0.308619       1.31153       5.04712      0.719279       1.15601        29     
produce:hitpdune:DisambigFromSpacePoints               0.402031      0.889396       1.89365      0.862796      0.400359        29     
produce:pandora:StandardPandora                         7.65284       18.4163       33.6743       17.9519       6.40257        29     
produce:pandoraWriter:StandardPandora                  0.127367      0.228515      0.395948      0.237281      0.0664717       29     
produce:pandoraTrack:LArPandoraTrackCreation            1.09511       2.99725       6.72097       2.86538       1.36226        29     
produce:pandoraShower:LArPandoraShowerCreation          0.65721       3.38912       6.18269       2.89729       1.46972        29     
produce:pandoracalo:Calorimetry                        0.547474       1.22476       2.49047        1.143       0.455729        29     
produce:pandoracalonosce:Calorimetry                   0.511147       1.17649       2.63072       1.0648       0.500778        29     
produce:pandorapid:Chi2ParticleID                     0.00163843    0.00314201     0.0060122    0.00291402    0.00108899       29     
produce:pandoraShowercalo:ShowerCalorimetry            0.508901       2.82207       4.89708       2.79762       1.09397        29     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.459188       2.72821       4.74865       2.44216       1.11209        29     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.0956219     0.206197      0.452011      0.201761      0.0798772       29     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0392768     0.0820976     0.165423      0.0842151     0.0284645       29     
produce:emtrkmichelid:EmTrackMichelId                   32.5168       52.3307       71.5873       52.3927        8.482         29     
[art]:TriggerResults:TriggerResultInserter            5.4437e-05    7.85873e-05   0.000164312   7.7559e-05    1.84746e-05      30     
end_path:out1:RootOutput                               1.306e-05    2.01381e-05   4.7561e-05    1.9093e-05    6.19459e-06      30     
end_path:michelremoving:michelremoving                4.6418e-05     0.132718      0.407173      0.0709977     0.119968        30     
end_path:michelremovinggnocchi:michelremoving         2.3391e-05     0.127527      0.400837      0.0700617     0.115617        30     
end_path:calibanagnocchi:CalibAnaTree                 2.8644e-05     0.953837       2.25253      0.849656      0.455752        30     
end_path:out1:RootOutput(write)                        0.477024       1.28342       2.2777        1.22749      0.339978        30     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4907.31 MB
  Peak resident set size usage (VmHWM): 2528.03 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029107_1518_dataflow2_datawriter_0_20240907T165414_reco_stage1_reco_stage2_20240926T173931_keepup.root
\tHists: np04hd_raw_run029107_1518_dataflow2_datawriter_0_20240907T165414_reco_stage1_reco_stage2_20240926T173931_keepup_hists.root
Forming reco metadata
Successfully opened file np04hd_raw_run029107_1518_dataflow2_datawriter_0_20240907T165414_reco_stage1_reco_stage2_20240926T173931_keepup.root
Ran successfully
{
  "name": "np04hd_raw_run029107_1518_dataflow2_datawriter_0_20240907T165414_reco_stage1_reco_stage2_20240926T173931_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": 1727367668.0,
    "core.end_time": 1727372372.0,
    "core.events": [
      364338,
      364346,
      364354,
      364362,
      364370,
      364378,
      364386,
      364394,
      364410,
      364418,
      364426,
      364434,
      364442,
      364450,
      364458,
      364466,
      364474,
      364482,
      364490,
      364498,
      364506,
      364514,
      364522,
      364530,
      364538,
      364546,
      364554,
      364562,
      364570,
      364586
    ],
    "core.event_count": 30,
    "core.first_event_number": 364338,
    "core.last_event_number": 364586,
    "core.data_stream": "physics",
    "core.file_content_status": "good",
    "core.file_type": "detector",
    "core.run_type": "hd-protodune",
    "core.runs": [
      29107
    ],
    "core.runs_subruns": [
      2910700001
    ],
    "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_run029107_1518_dataflow2_datawriter_0_20240907T165414.hdf5"
    }
  ]
}Forming hist metadata
formed
{
  "name": "np04hd_raw_run029107_1518_dataflow2_datawriter_0_20240907T165414_reco_stage1_reco_stage2_20240926T173931_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": 1727367668.0,
    "core.end_time": 1727372372.0,
    "core.data_stream": "physics",
    "core.file_content_status": "good",
    "core.file_type": "detector",
    "core.run_type": "hd-protodune",
    "core.runs": [
      29107
    ],
    "core.runs_subruns": [
      2910700001
    ],
    "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_run029107_1518_dataflow2_datawriter_0_20240907T165414.hdf5"
    }
  ]
}
justIN time: 2024-11-17 08:34:22 UTC       justIN version: 01.01.09