justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID80083.1@justin-prod-sched02.dune.hep.ac.uk
Workflow ID3522
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 10:13:39
SiteUK_RAL-Tier1
EntryLIGO_UK_RAL_arc_ce04
Last heartbeat2024-09-27 11:37:42
From worker nodeHostnamedune001-2302515.0-lcg2433.gridpp.rl.ac.uk
cpuinfoAMD EPYC 7452 32-Core Processor
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4193255424 (3999 MiB)
Wall seconds limit216000 (60 hours)
Inner Apptainer?True
Job statefinished
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-09-27 10:29:06
Input fileshd-protodune:np04hd_raw_run029350_0099_dataflow0_datawriter_0_20240927T092614.hdf5
JobscriptExit code0
Real time12m (755s)
CPU time5m (334s = 44%)
Outputting started2024-09-27 10:41:41
Output fileshd-protodune-det-reco:np04hd_raw_run029350_0099_dataflow0_datawriter_0_20240927T092614_reco_stage1_reco_stage2_20240927T104119_keepup.root
hd-protodune-det-reco:np04hd_raw_run029350_0099_dataflow0_datawriter_0_20240927T092614_reco_stage1_reco_stage2_20240927T104119_keepup_hists.root
Finished2024-09-27 11:37:42
Saved logsjustin-logs:80083.1-justin-prod-sched02.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

d. run: 29350 subRun: 1 event: 7724 at 27-Sep-2024 10:40:47 UTC
27-Sep-2024 10:40:48 UTC  Opened output file with pattern "%ifb_reco_stage2_%tc_keepup.root"
Begin processing the 2nd record. run: 29350 subRun: 1 event: 7726 at 27-Sep-2024 10:40:49 UTC
Begin processing the 3rd record. run: 29350 subRun: 1 event: 7728 at 27-Sep-2024 10:40:50 UTC
Begin processing the 4th record. run: 29350 subRun: 1 event: 7730 at 27-Sep-2024 10:40:51 UTC
Begin processing the 5th record. run: 29350 subRun: 1 event: 7732 at 27-Sep-2024 10:40:52 UTC
Begin processing the 6th record. run: 29350 subRun: 1 event: 7734 at 27-Sep-2024 10:40:53 UTC
Begin processing the 7th record. run: 29350 subRun: 1 event: 7736 at 27-Sep-2024 10:40:53 UTC
Begin processing the 8th record. run: 29350 subRun: 1 event: 7738 at 27-Sep-2024 10:40:54 UTC
Begin processing the 9th record. run: 29350 subRun: 1 event: 7740 at 27-Sep-2024 10:40:55 UTC
Begin processing the 10th record. run: 29350 subRun: 1 event: 7742 at 27-Sep-2024 10:40:56 UTC
Begin processing the 11th record. run: 29350 subRun: 1 event: 7744 at 27-Sep-2024 10:40:56 UTC
Begin processing the 12th record. run: 29350 subRun: 1 event: 7746 at 27-Sep-2024 10:40:57 UTC
Begin processing the 13th record. run: 29350 subRun: 1 event: 7748 at 27-Sep-2024 10:40:58 UTC
Begin processing the 14th record. run: 29350 subRun: 1 event: 7750 at 27-Sep-2024 10:40:59 UTC
Begin processing the 15th record. run: 29350 subRun: 1 event: 7752 at 27-Sep-2024 10:41:00 UTC
Begin processing the 16th record. run: 29350 subRun: 1 event: 7754 at 27-Sep-2024 10:41:00 UTC
Begin processing the 17th record. run: 29350 subRun: 1 event: 7756 at 27-Sep-2024 10:41:01 UTC
Begin processing the 18th record. run: 29350 subRun: 1 event: 7758 at 27-Sep-2024 10:41:02 UTC
Begin processing the 19th record. run: 29350 subRun: 1 event: 7760 at 27-Sep-2024 10:41:03 UTC
Begin processing the 20th record. run: 29350 subRun: 1 event: 7762 at 27-Sep-2024 10:41:03 UTC
Begin processing the 21st record. run: 29350 subRun: 1 event: 7764 at 27-Sep-2024 10:41:04 UTC
Begin processing the 22nd record. run: 29350 subRun: 1 event: 7766 at 27-Sep-2024 10:41:05 UTC
Begin processing the 23rd record. run: 29350 subRun: 1 event: 7768 at 27-Sep-2024 10:41:06 UTC
Begin processing the 24th record. run: 29350 subRun: 1 event: 7770 at 27-Sep-2024 10:41:06 UTC
Begin processing the 25th record. run: 29350 subRun: 1 event: 7772 at 27-Sep-2024 10:41:07 UTC
Begin processing the 26th record. run: 29350 subRun: 1 event: 7774 at 27-Sep-2024 10:41:08 UTC
Begin processing the 27th record. run: 29350 subRun: 1 event: 7776 at 27-Sep-2024 10:41:09 UTC
Begin processing the 28th record. run: 29350 subRun: 1 event: 7778 at 27-Sep-2024 10:41:09 UTC
Begin processing the 29th record. run: 29350 subRun: 1 event: 7780 at 27-Sep-2024 10:41:10 UTC
Begin processing the 30th record. run: 29350 subRun: 1 event: 7782 at 27-Sep-2024 10:41:11 UTC
Begin processing the 31st record. run: 29350 subRun: 1 event: 7784 at 27-Sep-2024 10:41:11 UTC
Begin processing the 32nd record. run: 29350 subRun: 1 event: 7786 at 27-Sep-2024 10:41:12 UTC
Begin processing the 33rd record. run: 29350 subRun: 1 event: 7788 at 27-Sep-2024 10:41:13 UTC
Begin processing the 34th record. run: 29350 subRun: 1 event: 7790 at 27-Sep-2024 10:41:14 UTC
Begin processing the 35th record. run: 29350 subRun: 1 event: 7792 at 27-Sep-2024 10:41:14 UTC
Begin processing the 36th record. run: 29350 subRun: 1 event: 7794 at 27-Sep-2024 10:41:15 UTC
Begin processing the 37th record. run: 29350 subRun: 1 event: 7796 at 27-Sep-2024 10:41:16 UTC
Begin processing the 38th record. run: 29350 subRun: 1 event: 7798 at 27-Sep-2024 10:41:17 UTC
Begin processing the 39th record. run: 29350 subRun: 1 event: 7800 at 27-Sep-2024 10:41:17 UTC
27-Sep-2024 10:41:19 UTC  Closed output file "np04hd_raw_run029350_0099_dataflow0_datawriter_0_20240927T092614_reco_stage1_reco_stage2_20240927T104119_keepup.root"
27-Sep-2024 10:41:19 UTC  Closed input file "np04hd_raw_run029350_0099_dataflow0_datawriter_0_20240927T092614_reco_stage1.root"

===================================================================================================================================
TimeTracker printout (sec)                           Min           Avg           Max         Median          RMS         nEvts   
===================================================================================================================================
Full event                                        0.711854       0.75407      0.893046      0.736265      0.0389953       39     
-----------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                           0.00024914    0.00032103    0.000979839   0.000287553   0.000119164      39     
produce:fembfilter:PDHDFEMBFilter                 0.710063       0.75211      0.884233      0.734507      0.0381098       39     
[art]:TriggerResults:TriggerResultInserter       3.5938e-05    4.29796e-05   0.000115778   3.8903e-05    1.37243e-05      39     
end_path:out1:RootOutput                          3.516e-06    4.59762e-06   1.9918e-05     4.098e-06    2.56463e-06      39     
end_path:michelremoving:michelremoving           1.3115e-05    2.28693e-05   0.000266072   1.5589e-05    3.97007e-05      39     
end_path:michelremovinggnocchi:michelremoving     5.089e-06    9.24618e-06   9.3266e-05     7.134e-06    1.36872e-05      39     
end_path:calibanagnocchi:CalibAnaTree             4.228e-06    8.68964e-06   8.9038e-05     6.502e-06    1.30928e-05      39     
end_path:out1:RootOutput(write)                  0.000696213   0.00103865    0.00640697    0.000737972   0.000978443      39     
===================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 3649.97 MB
  Peak resident set size usage (VmHWM): 1260.15 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029350_0099_dataflow0_datawriter_0_20240927T092614_reco_stage1_reco_stage2_20240927T104119_keepup.root
\tHists: np04hd_raw_run029350_0099_dataflow0_datawriter_0_20240927T092614_reco_stage1_reco_stage2_20240927T104119_keepup_hists.root
Forming reco metadata
Successfully opened file np04hd_raw_run029350_0099_dataflow0_datawriter_0_20240927T092614_reco_stage1_reco_stage2_20240927T104119_keepup.root
Ran successfully
{
  "name": "np04hd_raw_run029350_0099_dataflow0_datawriter_0_20240927T092614_reco_stage1_reco_stage2_20240927T104119_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": 1727433599.0,
    "core.end_time": 1727433679.0,
    "core.events": [
      7724,
      7726,
      7728,
      7730,
      7732,
      7734,
      7736,
      7738,
      7740,
      7742,
      7744,
      7746,
      7748,
      7750,
      7752,
      7754,
      7756,
      7758,
      7760,
      7762,
      7764,
      7766,
      7768,
      7770,
      7772,
      7774,
      7776,
      7778,
      7780,
      7782,
      7784,
      7786,
      7788,
      7790,
      7792,
      7794,
      7796,
      7798,
      7800
    ],
    "core.event_count": 39,
    "core.first_event_number": 7724,
    "core.last_event_number": 7800,
    "core.data_stream": "cosmics",
    "core.file_content_status": "good",
    "core.file_type": "detector",
    "core.run_type": "hd-protodune",
    "core.runs": [
      29350
    ],
    "core.runs_subruns": [
      2935000001
    ],
    "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_run029350_0099_dataflow0_datawriter_0_20240927T092614.hdf5"
    }
  ]
}Forming hist metadata
formed
{
  "name": "np04hd_raw_run029350_0099_dataflow0_datawriter_0_20240927T092614_reco_stage1_reco_stage2_20240927T104119_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": 1727433599.0,
    "core.end_time": 1727433679.0,
    "core.data_stream": "cosmics",
    "core.file_content_status": "good",
    "core.file_type": "detector",
    "core.run_type": "hd-protodune",
    "core.runs": [
      29350
    ],
    "core.runs_subruns": [
      2935000001
    ],
    "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_run029350_0099_dataflow0_datawriter_0_20240927T092614.hdf5"
    }
  ]
}
justIN time: 2024-09-29 11:31:59 UTC       justIN version: 01.01.08