justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID266105.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 00:27:52
SiteUK_Manchester
EntryUBoone_T2_UK_Manchester_ce01
Last heartbeat2024-09-29 02:10:03
From worker nodeHostnamewn2204250.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:58
Input fileshd-protodune:np04hd_raw_run029389_0028_dataflow1_datawriter_0_20240928T233619.hdf5
JobscriptExit code0
Real time1h (5891s)
CPU time1h (5090s = 86%)
Outputting started2024-09-29 02:08:10
Output fileshd-protodune-det-reco:np04hd_raw_run029389_0028_dataflow1_datawriter_0_20240928T233619_reco_stage1_reco_stage2_20240929T020755_keepup.root
hd-protodune-det-reco:np04hd_raw_run029389_0028_dataflow1_datawriter_0_20240928T233619_reco_stage1_reco_stage2_20240929T020755_keepup_hists.root
Finished2024-09-29 02:10:03
Saved logsjustin-logs:266105.14-justin-prod-sched01.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

coincidences...
C:0 T:1 85 XUs and 153 XVs -> 4 XUVs
C:0 T:2 10589 XUs and 7842 XVs -> 221 XUVs
C:0 T:3 217 XUs and 185 XVs -> 27 XUVs
C:0 T:4 144 XUs and 169 XVs -> 5 XUVs
C:0 T:5 41131 XUs and 30369 XVs -> 1106 XUVs
C:0 T:6 13176 XUs and 23432 XVs -> 756 XUVs
C:0 T:7 92 XUs and 124 XVs -> 8 XUVs
2127 XUVs total
1334 collection wire objects
2127 potential space points
Neighbour search...
27735 tests to find 18564 neighbours
Iterating with no regularization...
Begin: 5.65103e+06
0 5.46328e+06
1 5.45636e+06
2 5.45583e+06
Now with regularization...
Begin: 4.91509e+06
0 4.91476e+06
BdtBeamParticleIdTool::SliceFeatures::GetLArTPCIntercepts - inconsistent number of intercepts between a line and the LArTPC
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

no of hits closeby  0   event 2261 TrkackID 6 startx, y, z 153.247 594.812 274.15  wireno, peakt tpcno 388 3219.28 2 dist 191.889min T, max_T1263.97 3233.88
no of hits closeby  0   event 2261 TrkackID 6 startx, y, z 153.247 594.812 274.15  wireno, peakt tpcno 388 3219.28 2 dist 191.889min T, max_T1263.97 3233.88
29-Sep-2024 03:07:55 BST  Closed output file "np04hd_raw_run029389_0028_dataflow1_datawriter_0_20240928T233619_reco_stage1_reco_stage2_20240929T020755_keepup.root"
29-Sep-2024 03:07:55 BST  Closed input file "np04hd_raw_run029389_0028_dataflow1_datawriter_0_20240928T233619_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              71.5773       108.33        197.633       98.5569       26.9445        39     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000507033   0.00318995    0.00638918    0.00328054    0.00137175       39     
produce:fembfilter:PDHDFEMBFilter                      0.754336      0.799874      0.884922      0.799916      0.0321631       39     
produce:wclsdatahd:WireCellToolkit                      40.7284       43.1587       45.7265       43.1345       1.08221        39     
produce:gaushit:GausHitFinder                          0.449591      0.904721       1.55005      0.873254      0.249283        39     
produce:nhitsfilter:NumberOfHitsFilter                0.000268554   0.000453507   0.000866359   0.000430519   0.000105638      39     
produce:reco3d:SpacePointSolver                        0.163041       2.42573       13.3745      0.750549       3.38579        39     
produce:hitpdune:DisambigFromSpacePoints                0.20474      0.833455       2.24036      0.664438      0.520397        39     
produce:pandora:StandardPandora                         5.5981        16.0311       52.4481       13.101        9.55041        39     
produce:pandoraWriter:StandardPandora                  0.133448      0.271919      0.432401      0.252558      0.0731658       39     
produce:pandoraTrack:LArPandoraTrackCreation           0.527603       1.60682       4.08176       1.37057      0.788654        39     
produce:pandoraShower:LArPandoraShowerCreation         0.566187       1.78342       6.51631       1.37872       1.24425        39     
produce:pandoracalo:Calorimetry                        0.327048      0.822201       2.02664      0.734539      0.357519        39     
produce:pandoracalonosce:Calorimetry                   0.272645      0.739045       1.72488      0.664752      0.332419        39     
produce:pandorapid:Chi2ParticleID                      0.0016334    0.00257988    0.00532958    0.00252525    0.000623385      39     
produce:pandoraShowercalo:ShowerCalorimetry            0.424427       1.65417       5.48933       1.19914       1.1342         39     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.422999       1.63718       5.85457       1.34113       1.14688        39     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.117082      0.195868      0.347305      0.184689      0.0522891       39     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0393084     0.0716639     0.158172      0.065194      0.0235794       39     
produce:emtrkmichelid:EmTrackMichelId                   17.7215       33.078        54.2434       30.0404       8.1353         39     
[art]:TriggerResults:TriggerResultInserter            3.6339e-05    7.02274e-05   0.000148579   6.5163e-05    2.39929e-05      39     
end_path:out1:RootOutput                               9.288e-06    1.89097e-05   4.8411e-05    1.6681e-05    8.92046e-06      39     
end_path:michelremoving:michelremoving                 0.0260228     0.154622      0.590525      0.118967      0.148076        39     
end_path:michelremovinggnocchi:michelremoving          0.0222548     0.151587      0.580688      0.111173      0.149734        39     
end_path:calibanagnocchi:CalibAnaTree                  0.221954      0.606764       1.26205       0.54131      0.257032        39     
end_path:out1:RootOutput(write)                        0.638858       1.20732       1.99688       1.14633       0.32088        39     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4991.3 MB
  Peak resident set size usage (VmHWM): 2643.28 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029389_0028_dataflow1_datawriter_0_20240928T233619_reco_stage1_reco_stage2_20240929T020755_keepup.root
\tHists: np04hd_raw_run029389_0028_dataflow1_datawriter_0_20240928T233619_reco_stage1_reco_stage2_20240929T020755_keepup_hists.root
Forming reco metadata
Successfully opened file np04hd_raw_run029389_0028_dataflow1_datawriter_0_20240928T233619_reco_stage1_reco_stage2_20240929T020755_keepup.root
Ran successfully
{
  "name": "np04hd_raw_run029389_0028_dataflow1_datawriter_0_20240928T233619_reco_stage1_reco_stage2_20240929T020755_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": 1727571390.0,
    "core.end_time": 1727575676.0,
    "core.events": [
      2185,
      2187,
      2189,
      2191,
      2193,
      2195,
      2197,
      2199,
      2201,
      2203,
      2205,
      2207,
      2209,
      2211,
      2213,
      2215,
      2217,
      2219,
      2221,
      2223,
      2225,
      2227,
      2229,
      2231,
      2233,
      2235,
      2237,
      2239,
      2241,
      2243,
      2245,
      2247,
      2249,
      2251,
      2253,
      2255,
      2257,
      2259,
      2261
    ],
    "core.event_count": 39,
    "core.first_event_number": 2185,
    "core.last_event_number": 2261,
    "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_0028_dataflow1_datawriter_0_20240928T233619.hdf5"
    }
  ]
}Forming hist metadata
formed
{
  "name": "np04hd_raw_run029389_0028_dataflow1_datawriter_0_20240928T233619_reco_stage1_reco_stage2_20240929T020755_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": 1727571390.0,
    "core.end_time": 1727575676.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_0028_dataflow1_datawriter_0_20240928T233619.hdf5"
    }
  ]
}
justIN time: 2024-09-29 09:29:14 UTC       justIN version: 01.01.08