justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID79989.132@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 08:41:26
SiteUS_FNAL-FermiGrid
EntryFNAL_GPGrid_ce04_mcore_op_duneonly
Last heartbeat2024-09-27 18:35:26
From worker nodeHostnamedunegli-4172017-0-fnpc7019.fnal.gov
cpuinfoAMD Opteron(tm) Processor 6376
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 13:43:59
Input fileshd-protodune:np04hd_raw_run027408_0078_dataflow1_datawriter_0_20240624T163126.hdf5
JobscriptExit code0
Real time4h (17394s)
CPU time4h (15637s = 89%)
Outputting started2024-09-27 18:33:54
Output fileshd-protodune-det-reco:np04hd_raw_run027408_0078_dataflow1_datawriter_0_20240624T163126_reco_stage1_reco_stage2_20240927T183332_keepup.root
hd-protodune-det-reco:np04hd_raw_run027408_0078_dataflow1_datawriter_0_20240624T163126_reco_stage1_reco_stage2_20240927T183332_keepup_hists.root
Finished2024-09-27 18:35:26
Saved logsjustin-logs:79989.132-justin-prod-sched02.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

aces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 30982 traces tagged "gauss"
FrameSaver: q=1.13387e+06 n=557924 tag=gauss
wclsFrameSaver: saving 42527 traces tagged "wiener"
FrameSaver: q=1.24079e+06 n=504579 tag=wiener
1171 hits in TPC 0
799 hits in TPC 1
5409 hits in TPC 2
2413 hits in TPC 3
2061 hits in TPC 4
3868 hits in TPC 5
4839 hits in TPC 6
3438 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 211 XUs and 56 XVs -> 0 XUVs
C:0 T:2 14434 XUs and 45704 XVs -> 706 XUVs
C:0 T:3 369 XUs and 396 XVs -> 26 XUVs
C:0 T:4 794 XUs and 656 XVs -> 38 XUVs
C:0 T:5 37152 XUs and 26183 XVs -> 891 XUVs
C:0 T:6 12245 XUs and 25194 XVs -> 1093 XUVs
C:0 T:7 1496 XUs and 2059 XVs -> 43 XUVs
2797 XUVs total
1276 collection wire objects
2797 potential space points
Neighbour search...
97657 tests to find 51892 neighbours
Iterating with no regularization...
Begin: 3.61927e+07
0 3.36467e+07
1 3.34516e+07
2 3.34342e+07
Now with regularization...
Begin: 3.25715e+07
0 3.25659e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

27-Sep-2024 18:33:32 UTC  Closed output file "np04hd_raw_run027408_0078_dataflow1_datawriter_0_20240624T163126_reco_stage1_reco_stage2_20240927T183332_keepup.root"
27-Sep-2024 18:33:32 UTC  Closed input file "np04hd_raw_run027408_0078_dataflow1_datawriter_0_20240624T163126_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              192.181       395.651       583.271       394.254       84.246         35     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000884013   0.00476786     0.0160075    0.00364968    0.00332288       35     
produce:fembfilter:PDHDFEMBFilter                       1.24951       1.71411       2.25509       1.65873      0.270364        35     
produce:wclsdatahd:WireCellToolkit                      78.8267       94.3997       115.518       91.8836       10.4957        35     
produce:gaushit:GausHitFinder                           1.07784       2.33868       3.60073       2.24784      0.517314        35     
produce:nhitsfilter:NumberOfHitsFilter                0.000699141   0.00138501    0.00337625    0.00126016    0.000436326      35     
produce:reco3d:SpacePointSolver                        0.688049       3.10804       11.1803       2.57366       2.01965        35     
produce:hitpdune:DisambigFromSpacePoints               0.568316       1.94937       4.34615       1.74727       0.77101        35     
produce:pandora:StandardPandora                         14.5827       88.1811       226.25        84.9205       47.3683        35     
produce:pandoraWriter:StandardPandora                  0.279359       0.5101       0.820432      0.486783      0.115188        35     
produce:pandoraTrack:LArPandoraTrackCreation            1.98663       6.31782       16.2219       5.74883       2.90946        35     
produce:pandoraShower:LArPandoraShowerCreation          1.91227       6.73731       15.1104       5.47834       3.23525        35     
produce:pandoracalo:Calorimetry                        0.890952       2.71023       5.83207       2.43289       1.14239        35     
produce:pandoracalonosce:Calorimetry                   0.818555       2.57367       5.54189       2.26429       1.1337         35     
produce:pandorapid:Chi2ParticleID                     0.00375208    0.00574659    0.00893962    0.00547277    0.00128283       35     
produce:pandoraShowercalo:ShowerCalorimetry             1.50068       5.65206       13.2728       4.63402       2.92398        35     
produce:pandoraShowercalonosce:ShowerCalorimetry        1.44196       5.35189       12.726        4.46271       2.73676        35     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.212281      0.384885      0.625709      0.382998      0.0836336       35     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0721649      0.12055      0.205165      0.117996      0.0258453       35     
produce:emtrkmichelid:EmTrackMichelId                   83.241        169.167       220.518       172.269       31.4412        35     
[art]:TriggerResults:TriggerResultInserter            4.4877e-05    7.32983e-05   0.00015806    6.9797e-05    1.87518e-05      35     
end_path:out1:RootOutput                              1.2645e-05    1.8747e-05    4.4921e-05    1.6798e-05    6.79504e-06      35     
end_path:michelremoving:michelremoving                 0.039956      0.154179      0.580919      0.0809295     0.157274        35     
end_path:michelremovinggnocchi:michelremoving          0.0359933     0.148044      0.594919      0.0769637     0.158543        35     
end_path:calibanagnocchi:CalibAnaTree                  0.564169       2.05952       4.16772       1.86199      0.824627        35     
end_path:out1:RootOutput(write)                        0.924083       1.85287       2.49491       1.80965       0.34261        35     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5033.8 MB
  Peak resident set size usage (VmHWM): 2697.49 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run027408_0078_dataflow1_datawriter_0_20240624T163126_reco_stage1_reco_stage2_20240927T183332_keepup.root
\tHists: np04hd_raw_run027408_0078_dataflow1_datawriter_0_20240624T163126_reco_stage1_reco_stage2_20240927T183332_keepup_hists.root
Forming reco metadata
Successfully opened file np04hd_raw_run027408_0078_dataflow1_datawriter_0_20240624T163126_reco_stage1_reco_stage2_20240927T183332_keepup.root
Ran successfully
{
  "name": "np04hd_raw_run027408_0078_dataflow1_datawriter_0_20240624T163126_reco_stage1_reco_stage2_20240927T183332_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": 1727448079.0,
    "core.end_time": 1727462014.0,
    "core.events": [
      10921,
      10925,
      10929,
      10933,
      10937,
      10941,
      10945,
      10949,
      10953,
      10957,
      10961,
      10965,
      10969,
      10973,
      10977,
      10981,
      10985,
      10989,
      10993,
      10997,
      11001,
      11005,
      11009,
      11013,
      11017,
      11021,
      11025,
      11029,
      11033,
      11037,
      11041,
      11045,
      11049,
      11053,
      11057
    ],
    "core.event_count": 35,
    "core.first_event_number": 10921,
    "core.last_event_number": 11057,
    "core.data_stream": "physics",
    "core.file_content_status": "good",
    "core.file_type": "detector",
    "core.run_type": "hd-protodune",
    "core.runs": [
      27408
    ],
    "core.runs_subruns": [
      2740800001
    ],
    "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_run027408_0078_dataflow1_datawriter_0_20240624T163126.hdf5"
    }
  ]
}Forming hist metadata
formed
{
  "name": "np04hd_raw_run027408_0078_dataflow1_datawriter_0_20240624T163126_reco_stage1_reco_stage2_20240927T183332_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": 1727448079.0,
    "core.end_time": 1727462014.0,
    "core.data_stream": "physics",
    "core.file_content_status": "good",
    "core.file_type": "detector",
    "core.run_type": "hd-protodune",
    "core.runs": [
      27408
    ],
    "core.runs_subruns": [
      2740800001
    ],
    "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_run027408_0078_dataflow1_datawriter_0_20240624T163126.hdf5"
    }
  ]
}
justIN time: 2024-09-29 13:28:52 UTC       justIN version: 01.01.08