justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID266105.13@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 00:27:52
SiteUK_Manchester
EntryUBoone_T2_UK_Manchester_ce02
Last heartbeat2024-09-29 02:07:54
From worker nodeHostnamewn2210240.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 00:29:15
Input fileshd-protodune:np04hd_raw_run029389_0029_dataflow1_datawriter_0_20240928T234929.hdf5
JobscriptExit code0
Real time1h (5834s)
CPU time1h (5109s = 87%)
Outputting started2024-09-29 02:06:30
Output fileshd-protodune-det-reco:np04hd_raw_run029389_0029_dataflow1_datawriter_0_20240928T234929_reco_stage1_reco_stage2_20240929T020617_keepup.root
hd-protodune-det-reco:np04hd_raw_run029389_0029_dataflow1_datawriter_0_20240928T234929_reco_stage1_reco_stage2_20240929T020617_keepup_hists.root
Finished2024-09-29 02:07:54
Saved logsjustin-logs:266105.13-justin-prod-sched01.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

gging trace set: gauss with 47769 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 47769 traces tagged "gauss"
FrameSaver: q=925622 n=866225 tag=gauss
wclsFrameSaver: saving 68088 traces tagged "wiener"
FrameSaver: q=1.01488e+06 n=771749 tag=wiener
2117 hits in TPC 0
4697 hits in TPC 1
5841 hits in TPC 2
1713 hits in TPC 3
3477 hits in TPC 4
6633 hits in TPC 5
6869 hits in TPC 6
6306 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 12 XUs and 0 XVs -> 0 XUVs
C:0 T:2 82569 XUs and 104404 XVs -> 1489 XUVs
C:0 T:3 2 XUs and 3 XVs -> 1 XUVs
C:0 T:4 262 XUs and 344 XVs -> 25 XUVs
C:0 T:5 36572 XUs and 41313 XVs -> 1413 XUVs
C:0 T:6 102082 XUs and 154181 XVs -> 3764 XUVs
C:0 T:7 24085 XUs and 29647 XVs -> 5593 XUVs
12285 XUVs total
2316 collection wire objects
12285 potential space points
Neighbour search...
1728203 tests to find 772018 neighbours
Iterating with no regularization...
Begin: 8.66454e+06
0 6.84402e+06
1 6.74528e+06
2 6.72323e+06
3 6.71466e+06
4 6.70991e+06
Now with regularization...
Begin: 6.46621e+06
0 6.46245e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

29-Sep-2024 03:06:17 BST  Closed output file "np04hd_raw_run029389_0029_dataflow1_datawriter_0_20240928T234929_reco_stage1_reco_stage2_20240929T020617_keepup.root"
29-Sep-2024 03:06:17 BST  Closed input file "np04hd_raw_run029389_0029_dataflow1_datawriter_0_20240928T234929_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              77.0957       107.849       180.596       106.508       22.7941        39     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000564721   0.00273645    0.00570794    0.00280808    0.00123334       39     
produce:fembfilter:PDHDFEMBFilter                      0.674386       0.83018       1.01727       0.83342      0.0614816       39     
produce:wclsdatahd:WireCellToolkit                      39.5278       44.9265       52.5761       44.5296       3.1892         39     
produce:gaushit:GausHitFinder                           0.36461      0.872147       1.24877       0.89543      0.189045        39     
produce:nhitsfilter:NumberOfHitsFilter                0.000248077   0.000423101   0.00190307    0.000368332   0.000254148      39     
produce:reco3d:SpacePointSolver                        0.137139       2.07599       16.8684      0.680912       3.13896        39     
produce:hitpdune:DisambigFromSpacePoints               0.229149      0.745532       1.69444      0.659395       0.38916        39     
produce:pandora:StandardPandora                         4.74399       13.869        35.7153       12.0284       6.06065        39     
produce:pandoraWriter:StandardPandora                  0.101661      0.226185      0.408921      0.223256      0.0622757       39     
produce:pandoraTrack:LArPandoraTrackCreation           0.313321       1.3921        3.59828       1.26816      0.618329        39     
produce:pandoraShower:LArPandoraShowerCreation         0.544837       1.69139       4.44946       1.5037       0.797253        39     
produce:pandoracalo:Calorimetry                        0.225375      0.757152       1.86037      0.694416      0.303551        39     
produce:pandoracalonosce:Calorimetry                   0.201019      0.679541       1.69114      0.616524      0.289208        39     
produce:pandorapid:Chi2ParticleID                      0.0012685    0.00226748    0.00511147    0.00219671    0.00062381       39     
produce:pandoraShowercalo:ShowerCalorimetry            0.492173       1.61429       4.6646        1.48634      0.794011        39     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.482788       1.56536       4.57663       1.48973      0.764673        39     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.0795982     0.180226      0.265376      0.180783      0.0415946       39     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0349463     0.0639681     0.102063      0.0626331     0.0142162       39     
produce:emtrkmichelid:EmTrackMichelId                   19.1674       34.2976       59.4807       32.0398       9.59014        39     
[art]:TriggerResults:TriggerResultInserter            2.5578e-05    4.7073e-05    0.000115146    4.296e-05    1.5134e-05       39     
end_path:out1:RootOutput                               8.406e-06    1.26012e-05   3.5527e-05    1.2003e-05    4.13698e-06      39     
end_path:michelremoving:michelremoving                 0.0186747     0.146093      0.565427      0.0483315     0.154685        39     
end_path:michelremovinggnocchi:michelremoving          0.0166512     0.142652      0.569057      0.0429179     0.157265        39     
end_path:calibanagnocchi:CalibAnaTree                  0.120167      0.560002       1.19319      0.546548      0.222857        39     
end_path:out1:RootOutput(write)                         0.56478       1.03603       1.56511       1.03536      0.223939        39     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5008.25 MB
  Peak resident set size usage (VmHWM): 2647.31 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029389_0029_dataflow1_datawriter_0_20240928T234929_reco_stage1_reco_stage2_20240929T020617_keepup.root
\tHists: np04hd_raw_run029389_0029_dataflow1_datawriter_0_20240928T234929_reco_stage1_reco_stage2_20240929T020617_keepup_hists.root
Forming reco metadata
Successfully opened file np04hd_raw_run029389_0029_dataflow1_datawriter_0_20240928T234929_reco_stage1_reco_stage2_20240929T020617_keepup.root
Ran successfully
{
  "name": "np04hd_raw_run029389_0029_dataflow1_datawriter_0_20240928T234929_reco_stage1_reco_stage2_20240929T020617_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": 1727571315.0,
    "core.end_time": 1727575579.0,
    "core.events": [
      2263,
      2265,
      2267,
      2269,
      2271,
      2273,
      2275,
      2277,
      2279,
      2281,
      2283,
      2285,
      2287,
      2289,
      2291,
      2293,
      2295,
      2297,
      2299,
      2301,
      2303,
      2305,
      2307,
      2309,
      2311,
      2313,
      2315,
      2317,
      2319,
      2321,
      2323,
      2325,
      2327,
      2329,
      2331,
      2333,
      2335,
      2337,
      2339
    ],
    "core.event_count": 39,
    "core.first_event_number": 2263,
    "core.last_event_number": 2339,
    "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_0029_dataflow1_datawriter_0_20240928T234929.hdf5"
    }
  ]
}Forming hist metadata
formed
{
  "name": "np04hd_raw_run029389_0029_dataflow1_datawriter_0_20240928T234929_reco_stage1_reco_stage2_20240929T020617_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": 1727571315.0,
    "core.end_time": 1727575579.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_0029_dataflow1_datawriter_0_20240928T234929.hdf5"
    }
  ]
}
justIN time: 2024-09-29 09:31:15 UTC       justIN version: 01.01.08