justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID262986.189@justin-prod-sched01.dune.hep.ac.uk
Workflow ID3448
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 06:47:34
SiteUK_Durham
EntryDUNE_UK_SGridDurham_ce4
Last heartbeat2024-09-26 09:11:05
From worker nodeHostnamen251.dur.scotgrid.ac.uk
cpuinfoAMD EPYC 7763 64-Core Processor
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4193255424 (3999 MiB)
Wall seconds limit171000 (47 hours)
Inner Apptainer?True
Job statefinished
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-09-26 06:51:46
Input fileshd-protodune:np04hd_raw_run029094_0007_dataflow4_datawriter_0_20240906T083604.hdf5
JobscriptExit code0
Real time1h (5623s)
CPU time56m (3369s = 59%)
Outputting started2024-09-26 08:25:29
Output fileshd-protodune-det-reco:np04hd_raw_run029094_0007_dataflow4_datawriter_0_20240906T083604_reco_stage1_reco_stage2_20240926T082520_keepup.root
hd-protodune-det-reco:np04hd_raw_run029094_0007_dataflow4_datawriter_0_20240906T083604_reco_stage1_reco_stage2_20240926T082520_keepup_hists.root
Finished2024-09-26 09:11:05
Saved logsjustin-logs:262986.189-justin-prod-sched01.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

ger: tagging trace set: gauss with 60739 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 60739 traces tagged "gauss"
FrameSaver: q=1.3586e+06 n=1098746 tag=gauss
wclsFrameSaver: saving 85402 traces tagged "wiener"
FrameSaver: q=1.4922e+06 n=994146 tag=wiener
4386 hits in TPC 0
2919 hits in TPC 1
8231 hits in TPC 2
4436 hits in TPC 3
3922 hits in TPC 4
7723 hits in TPC 5
8416 hits in TPC 6
3682 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 13 XUs and 11 XVs -> 1 XUVs
C:0 T:1 5464 XUs and 6605 XVs -> 1103 XUVs
C:0 T:2 36236 XUs and 29308 XVs -> 2512 XUVs
C:0 T:3 305 XUs and 240 XVs -> 14 XUVs
C:0 T:4 27 XUs and 37 XVs -> 2 XUVs
C:0 T:5 29796 XUs and 39951 XVs -> 1588 XUVs
C:0 T:6 28146 XUs and 59140 XVs -> 4054 XUVs
C:0 T:7 425 XUs and 186 XVs -> 7 XUVs
9281 XUVs total
2106 collection wire objects
9281 potential space points
Neighbour search...
579819 tests to find 351790 neighbours
Iterating with no regularization...
Begin: 1.72807e+07
0 1.51963e+07
1 1.50115e+07
2 1.49811e+07
3 1.49717e+07
Now with regularization...
Begin: 1.38823e+07
0 1.38689e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

26-Sep-2024 09:25:20 BST  Closed output file "np04hd_raw_run029094_0007_dataflow4_datawriter_0_20240906T083604_reco_stage1_reco_stage2_20240926T082520_keepup.root"
26-Sep-2024 09:25:20 BST  Closed input file "np04hd_raw_run029094_0007_dataflow4_datawriter_0_20240906T083604_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              57.8039       81.8854       118.648       81.8913       14.8386        30     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000533273   0.00231516    0.00449083    0.00233371    0.000889679      30     
produce:fembfilter:PDHDFEMBFilter                      0.633155      0.672755       0.71448      0.675093      0.017631        30     
produce:wclsdatahd:WireCellToolkit                      31.408        35.7556       37.6763       35.9404       1.30358        30     
produce:gaushit:GausHitFinder                          0.316873      0.706576       1.20201      0.706333      0.212958        30     
produce:nhitsfilter:NumberOfHitsFilter                0.000189811   0.000340349   0.00048447    0.000341834   6.59131e-05      30     
produce:reco3d:SpacePointSolver                        0.078539      0.737563       3.14209      0.561953      0.635929        30     
produce:hitpdune:DisambigFromSpacePoints               0.0961824      0.50816       1.13991      0.481798      0.269268        30     
produce:pandora:StandardPandora                         3.42414       11.1092       23.0253       10.202        4.7658         30     
produce:pandoraWriter:StandardPandora                  0.0915596     0.150257      0.216511      0.149331      0.0350085       30     
produce:pandoraTrack:LArPandoraTrackCreation           0.330281       1.08202       2.62888      0.950781      0.553767        30     
produce:pandoraShower:LArPandoraShowerCreation         0.328678       1.32174       3.75174       1.27892      0.801874        30     
produce:pandoracalo:Calorimetry                        0.203246      0.579761       1.05651      0.593464      0.226418        30     
produce:pandoracalonosce:Calorimetry                   0.168536      0.504989       0.9746       0.502544      0.207834        30     
produce:pandorapid:Chi2ParticleID                     0.00134623    0.00198307    0.00404542    0.00190477    0.000582767      30     
produce:pandoraShowercalo:ShowerCalorimetry            0.256809       1.19203       3.43869       1.11822      0.721819        30     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.251107       1.15722       3.17019       1.13915      0.688856        30     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.0715464     0.149446      0.211357      0.147642      0.0378981       30     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0234006     0.0502164     0.0711846     0.0515477     0.0125418       30     
produce:emtrkmichelid:EmTrackMichelId                   14.1102       24.7376       36.5893       24.7978       5.40252        30     
[art]:TriggerResults:TriggerResultInserter            2.7292e-05    4.9777e-05    0.000192616   3.72505e-05   3.34137e-05      30     
end_path:out1:RootOutput                              1.2343e-05    1.75839e-05   3.3915e-05    1.5049e-05    5.62521e-06      30     
end_path:michelremoving:michelremoving                 0.013939      0.0855551     0.375243      0.0323747     0.099127        30     
end_path:michelremovinggnocchi:michelremoving          0.014977      0.0832485     0.361172      0.029134      0.0978594       30     
end_path:calibanagnocchi:CalibAnaTree                  0.116243      0.404455      0.771344      0.398645      0.169541        30     
end_path:out1:RootOutput(write)                        0.413578      0.760221       1.21324       0.74321       0.19215        30     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4924.58 MB
  Peak resident set size usage (VmHWM): 2588.5 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029094_0007_dataflow4_datawriter_0_20240906T083604_reco_stage1_reco_stage2_20240926T082520_keepup.root
\tHists: np04hd_raw_run029094_0007_dataflow4_datawriter_0_20240906T083604_reco_stage1_reco_stage2_20240926T082520_keepup_hists.root
Forming reco metadata
Successfully opened file np04hd_raw_run029094_0007_dataflow4_datawriter_0_20240906T083604_reco_stage1_reco_stage2_20240926T082520_keepup.root
Ran successfully
{
  "name": "np04hd_raw_run029094_0007_dataflow4_datawriter_0_20240906T083604_reco_stage1_reco_stage2_20240926T082520_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": 1727336618.0,
    "core.end_time": 1727339121.0,
    "core.events": [
      1660,
      1668,
      1676,
      1708,
      1716,
      1724,
      1732,
      1740,
      1748,
      1756,
      1764,
      1772,
      1780,
      1788,
      1796,
      1804,
      1812,
      1820,
      1828,
      1836,
      1844,
      1852,
      1860,
      1868,
      1876,
      1884,
      1892,
      1908,
      1916,
      1924
    ],
    "core.event_count": 30,
    "core.first_event_number": 1660,
    "core.last_event_number": 1924,
    "core.data_stream": "cosmics",
    "core.file_content_status": "good",
    "core.file_type": "detector",
    "core.run_type": "hd-protodune",
    "core.runs": [
      29094
    ],
    "core.runs_subruns": [
      2909400001
    ],
    "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_run029094_0007_dataflow4_datawriter_0_20240906T083604.hdf5"
    }
  ]
}Forming hist metadata
formed
{
  "name": "np04hd_raw_run029094_0007_dataflow4_datawriter_0_20240906T083604_reco_stage1_reco_stage2_20240926T082520_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": 1727336618.0,
    "core.end_time": 1727339121.0,
    "core.data_stream": "cosmics",
    "core.file_content_status": "good",
    "core.file_type": "detector",
    "core.run_type": "hd-protodune",
    "core.runs": [
      29094
    ],
    "core.runs_subruns": [
      2909400001
    ],
    "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_run029094_0007_dataflow4_datawriter_0_20240906T083604.hdf5"
    }
  ]
}
justIN time: 2024-09-29 11:28:20 UTC       justIN version: 01.01.08