justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID80065.176@justin-prod-sched02.dune.hep.ac.uk
Workflow ID3518
Stage ID1
User namecalcuttj@fnal.gov
HTCondor Groupgroup_dune.prod_mcsim
RequestedProcessors1
RSS bytes4193255424 (3999 MiB)
Wall seconds limit18000 (5 hours)
Submitted time2024-09-27 09:50:56
SiteUS_FNAL-FermiGrid
EntryFNAL_GPGrid_ce03_mcore_op_duneonly
Last heartbeat2024-09-27 17:54:04
From worker nodeHostnamedunegli-3950242-0-fnpc7567.fnal.gov
cpuinfoIntel(R) Xeon(R) CPU E5-2650 v2 @ 2.60GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4193255424 (3999 MiB)
Wall seconds limit172800 (48 hours)
Inner Apptainer?True
Job statefinished
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-09-27 14:34:12
Input fileshd-protodune:np04hd_raw_run027404_0294_dataflow1_datawriter_0_20240624T124344.hdf5
JobscriptExit code0
Real time2h (9936s)
CPU time2h (8898s = 89%)
Outputting started2024-09-27 17:19:50
Output fileshd-protodune-det-reco:np04hd_raw_run027404_0294_dataflow1_datawriter_0_20240624T124344_reco_stage1_reco_stage2_20240927T171938_keepup.root
hd-protodune-det-reco:np04hd_raw_run027404_0294_dataflow1_datawriter_0_20240624T124344_reco_stage1_reco_stage2_20240927T171938_keepup_hists.root
Finished2024-09-27 17:54:04
Saved logsjustin-logs:80065.176-justin-prod-sched02.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

aving cooked to 5859 ticks
wclsFrameSaver: saving 36473 traces tagged "gauss"
FrameSaver: q=1.31153e+06 n=672140 tag=gauss
wclsFrameSaver: saving 47613 traces tagged "wiener"
FrameSaver: q=1.44023e+06 n=616462 tag=wiener
5717 hits in TPC 0
4706 hits in TPC 1
3856 hits in TPC 2
3390 hits in TPC 3
1773 hits in TPC 4
4595 hits in TPC 5
3479 hits in TPC 6
2853 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 20 XUs and 17 XVs -> 2 XUVs
C:0 T:1 30366 XUs and 11313 XVs -> 1443 XUVs
C:0 T:2 7739 XUs and 9130 XVs -> 336 XUVs
C:0 T:3 176 XUs and 307 XVs -> 9 XUVs
C:0 T:4 53 XUs and 55 XVs -> 6 XUVs
C:0 T:5 19336 XUs and 24064 XVs -> 1087 XUVs
C:0 T:6 3829 XUs and 5044 XVs -> 267 XUVs
C:0 T:7 539 XUs and 651 XVs -> 40 XUVs
3190 XUVs total
929 collection wire objects
3190 potential space points
Neighbour search...
143178 tests to find 65830 neighbours
Iterating with no regularization...
Begin: 3.62975e+07
0 3.4829e+07
1 3.4682e+07
2 3.4672e+07
Now with regularization...
Begin: 3.41578e+07
0 3.41546e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

27-Sep-2024 17:19:38 UTC  Closed output file "np04hd_raw_run027404_0294_dataflow1_datawriter_0_20240624T124344_reco_stage1_reco_stage2_20240927T171938_keepup.root"
27-Sep-2024 17:19:38 UTC  Closed input file "np04hd_raw_run027404_0294_dataflow1_datawriter_0_20240624T124344_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              94.9993       217.477       310.005       219.205       44.7755        35     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000613951   0.00950819     0.231366     0.00280795     0.0381051       35     
produce:fembfilter:PDHDFEMBFilter                      0.752621       1.93425       3.87237       1.81931      0.542798        35     
produce:wclsdatahd:WireCellToolkit                      46.2064       58.0207       74.2074       61.2183       7.60982        35     
produce:gaushit:GausHitFinder                          0.460643       1.35363       2.00961       1.29462      0.347495        35     
produce:nhitsfilter:NumberOfHitsFilter                0.000254745   0.000521305   0.000708094   0.000507579   8.89469e-05      35     
produce:reco3d:SpacePointSolver                         0.16315       1.79534       5.72062       1.40578       1.18593        35     
produce:hitpdune:DisambigFromSpacePoints               0.127614       1.36509       3.11929       1.20581      0.717053        35     
produce:pandora:StandardPandora                         4.82456       43.0527       104.304       39.5697       18.3597        35     
produce:pandoraWriter:StandardPandora                  0.0967168     0.249935      0.421256      0.231946      0.0678811       35     
produce:pandoraTrack:LArPandoraTrackCreation           0.561491       3.83266       8.61625       3.59492       1.58007        35     
produce:pandoraShower:LArPandoraShowerCreation         0.456301       4.39573       10.6424       3.95737       2.15892        35     
produce:pandoracalo:Calorimetry                         0.25762       1.66561       4.27875       1.61063      0.702532        35     
produce:pandoracalonosce:Calorimetry                   0.231066       1.58766       3.96537       1.56024      0.661511        35     
produce:pandorapid:Chi2ParticleID                     0.00143122    0.00342591    0.00594906    0.00303569    0.00109941       35     
produce:pandoraShowercalo:ShowerCalorimetry            0.352441       3.75592       8.80976       3.51815       1.90677        35     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.334968       3.5756        9.05586       3.19069       1.84225        35     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.0573516     0.210139      0.484773      0.179162      0.0860659       35     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0215719     0.0758508     0.168485      0.0617746     0.0312163       35     
produce:emtrkmichelid:EmTrackMichelId                   33.6439       87.3727       129.803       86.1653       20.2016        35     
[art]:TriggerResults:TriggerResultInserter            3.0864e-05    6.04819e-05   9.0881e-05     6.101e-05    1.22593e-05      35     
end_path:out1:RootOutput                               7.373e-06    1.19308e-05   2.7334e-05     1.095e-05    3.81703e-06      35     
end_path:michelremoving:michelremoving                 0.0309972      0.13274      0.569289      0.0640212     0.148306        35     
end_path:michelremovinggnocchi:michelremoving          0.0274789     0.129026      0.570623      0.0585233       0.15          35     
end_path:calibanagnocchi:CalibAnaTree                  0.335658       1.47568       2.54593       1.45509      0.505951        35     
end_path:out1:RootOutput(write)                        0.612792       1.33207       2.25106       1.34837       0.32673        35     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5020.85 MB
  Peak resident set size usage (VmHWM): 2682.4 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run027404_0294_dataflow1_datawriter_0_20240624T124344_reco_stage1_reco_stage2_20240927T171938_keepup.root
\tHists: np04hd_raw_run027404_0294_dataflow1_datawriter_0_20240624T124344_reco_stage1_reco_stage2_20240927T171938_keepup_hists.root
Forming reco metadata
Successfully opened file np04hd_raw_run027404_0294_dataflow1_datawriter_0_20240624T124344_reco_stage1_reco_stage2_20240927T171938_keepup.root
Ran successfully
{
  "name": "np04hd_raw_run027404_0294_dataflow1_datawriter_0_20240624T124344_reco_stage1_reco_stage2_20240927T171938_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": 1727449891.0,
    "core.end_time": 1727457579.0,
    "core.events": [
      41161,
      41165,
      41169,
      41173,
      41177,
      41181,
      41185,
      41189,
      41193,
      41197,
      41201,
      41205,
      41209,
      41213,
      41217,
      41221,
      41225,
      41229,
      41233,
      41237,
      41241,
      41245,
      41249,
      41253,
      41257,
      41261,
      41265,
      41269,
      41273,
      41277,
      41281,
      41285,
      41289,
      41293,
      41297
    ],
    "core.event_count": 35,
    "core.first_event_number": 41161,
    "core.last_event_number": 41297,
    "core.data_stream": "physics",
    "core.file_content_status": "good",
    "core.file_type": "detector",
    "core.run_type": "hd-protodune",
    "core.runs": [
      27404
    ],
    "core.runs_subruns": [
      2740400001
    ],
    "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_run027404_0294_dataflow1_datawriter_0_20240624T124344.hdf5"
    }
  ]
}Forming hist metadata
formed
{
  "name": "np04hd_raw_run027404_0294_dataflow1_datawriter_0_20240624T124344_reco_stage1_reco_stage2_20240927T171938_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": 1727449891.0,
    "core.end_time": 1727457579.0,
    "core.data_stream": "physics",
    "core.file_content_status": "good",
    "core.file_type": "detector",
    "core.run_type": "hd-protodune",
    "core.runs": [
      27404
    ],
    "core.runs_subruns": [
      2740400001
    ],
    "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_run027404_0294_dataflow1_datawriter_0_20240624T124344.hdf5"
    }
  ]
}
justIN time: 2024-09-29 13:32:39 UTC       justIN version: 01.01.08