justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID264656.0@justin-prod-sched01.dune.hep.ac.uk
Workflow ID3520
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 04:44:19
SiteUK_RAL-Tier1
EntryLIGO_UK_RAL_arc_ce05
Last heartbeat2024-09-27 05:01:23
From worker nodeHostnamedune001-2145704.0-lcg2538.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 04:46:01
Input fileshd-protodune:np04hd_raw_run029350_0073_dataflow1_datawriter_0_20240927T034759.hdf5
JobscriptExit code0
Real time13m (835s)
CPU time6m (395s = 47%)
Outputting started2024-09-27 04:59:57
Output fileshd-protodune-det-reco:np04hd_raw_run029350_0073_dataflow1_datawriter_0_20240927T034759_reco_stage1_reco_stage2_20240927T045944_keepup.root
hd-protodune-det-reco:np04hd_raw_run029350_0073_dataflow1_datawriter_0_20240927T034759_reco_stage1_reco_stage2_20240927T045944_keepup_hists.root
Finished2024-09-27 05:01:23
Saved logsjustin-logs:264656.0-justin-prod-sched01.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

d. run: 29350 subRun: 1 event: 5695 at 27-Sep-2024 04:59:08 UTC
27-Sep-2024 04:59:09 UTC  Opened output file with pattern "%ifb_reco_stage2_%tc_keepup.root"
Begin processing the 2nd record. run: 29350 subRun: 1 event: 5697 at 27-Sep-2024 04:59:11 UTC
Begin processing the 3rd record. run: 29350 subRun: 1 event: 5699 at 27-Sep-2024 04:59:11 UTC
Begin processing the 4th record. run: 29350 subRun: 1 event: 5701 at 27-Sep-2024 04:59:12 UTC
Begin processing the 5th record. run: 29350 subRun: 1 event: 5703 at 27-Sep-2024 04:59:13 UTC
Begin processing the 6th record. run: 29350 subRun: 1 event: 5705 at 27-Sep-2024 04:59:14 UTC
Begin processing the 7th record. run: 29350 subRun: 1 event: 5707 at 27-Sep-2024 04:59:15 UTC
Begin processing the 8th record. run: 29350 subRun: 1 event: 5709 at 27-Sep-2024 04:59:16 UTC
Begin processing the 9th record. run: 29350 subRun: 1 event: 5711 at 27-Sep-2024 04:59:17 UTC
Begin processing the 10th record. run: 29350 subRun: 1 event: 5713 at 27-Sep-2024 04:59:18 UTC
Begin processing the 11th record. run: 29350 subRun: 1 event: 5715 at 27-Sep-2024 04:59:19 UTC
Begin processing the 12th record. run: 29350 subRun: 1 event: 5717 at 27-Sep-2024 04:59:20 UTC
Begin processing the 13th record. run: 29350 subRun: 1 event: 5719 at 27-Sep-2024 04:59:21 UTC
Begin processing the 14th record. run: 29350 subRun: 1 event: 5721 at 27-Sep-2024 04:59:22 UTC
Begin processing the 15th record. run: 29350 subRun: 1 event: 5723 at 27-Sep-2024 04:59:22 UTC
Begin processing the 16th record. run: 29350 subRun: 1 event: 5725 at 27-Sep-2024 04:59:23 UTC
Begin processing the 17th record. run: 29350 subRun: 1 event: 5727 at 27-Sep-2024 04:59:24 UTC
Begin processing the 18th record. run: 29350 subRun: 1 event: 5729 at 27-Sep-2024 04:59:25 UTC
Begin processing the 19th record. run: 29350 subRun: 1 event: 5731 at 27-Sep-2024 04:59:26 UTC
Begin processing the 20th record. run: 29350 subRun: 1 event: 5733 at 27-Sep-2024 04:59:27 UTC
Begin processing the 21st record. run: 29350 subRun: 1 event: 5735 at 27-Sep-2024 04:59:28 UTC
Begin processing the 22nd record. run: 29350 subRun: 1 event: 5737 at 27-Sep-2024 04:59:29 UTC
Begin processing the 23rd record. run: 29350 subRun: 1 event: 5739 at 27-Sep-2024 04:59:30 UTC
Begin processing the 24th record. run: 29350 subRun: 1 event: 5741 at 27-Sep-2024 04:59:31 UTC
Begin processing the 25th record. run: 29350 subRun: 1 event: 5743 at 27-Sep-2024 04:59:31 UTC
Begin processing the 26th record. run: 29350 subRun: 1 event: 5745 at 27-Sep-2024 04:59:32 UTC
Begin processing the 27th record. run: 29350 subRun: 1 event: 5747 at 27-Sep-2024 04:59:33 UTC
Begin processing the 28th record. run: 29350 subRun: 1 event: 5749 at 27-Sep-2024 04:59:34 UTC
Begin processing the 29th record. run: 29350 subRun: 1 event: 5751 at 27-Sep-2024 04:59:35 UTC
Begin processing the 30th record. run: 29350 subRun: 1 event: 5753 at 27-Sep-2024 04:59:35 UTC
Begin processing the 31st record. run: 29350 subRun: 1 event: 5755 at 27-Sep-2024 04:59:36 UTC
Begin processing the 32nd record. run: 29350 subRun: 1 event: 5757 at 27-Sep-2024 04:59:37 UTC
Begin processing the 33rd record. run: 29350 subRun: 1 event: 5759 at 27-Sep-2024 04:59:37 UTC
Begin processing the 34th record. run: 29350 subRun: 1 event: 5761 at 27-Sep-2024 04:59:38 UTC
Begin processing the 35th record. run: 29350 subRun: 1 event: 5763 at 27-Sep-2024 04:59:39 UTC
Begin processing the 36th record. run: 29350 subRun: 1 event: 5765 at 27-Sep-2024 04:59:40 UTC
Begin processing the 37th record. run: 29350 subRun: 1 event: 5767 at 27-Sep-2024 04:59:41 UTC
Begin processing the 38th record. run: 29350 subRun: 1 event: 5769 at 27-Sep-2024 04:59:42 UTC
Begin processing the 39th record. run: 29350 subRun: 1 event: 5771 at 27-Sep-2024 04:59:43 UTC
27-Sep-2024 04:59:44 UTC  Closed output file "np04hd_raw_run029350_0073_dataflow1_datawriter_0_20240927T034759_reco_stage1_reco_stage2_20240927T045944_keepup.root"
27-Sep-2024 04:59:44 UTC  Closed input file "np04hd_raw_run029350_0073_dataflow1_datawriter_0_20240927T034759_reco_stage1.root"

===================================================================================================================================
TimeTracker printout (sec)                           Min           Avg           Max         Median          RMS         nEvts   
===================================================================================================================================
Full event                                        0.633613      0.872149       1.04122      0.901426      0.0981925       39     
-----------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                           0.000182102   0.000330146   0.00190296    0.000275583   0.00026553       39     
produce:fembfilter:PDHDFEMBFilter                 0.631822      0.870134       1.03018      0.899741      0.0975673       39     
[art]:TriggerResults:TriggerResultInserter       3.6661e-05    4.71824e-05   0.000162962   4.1511e-05    2.03293e-05      39     
end_path:out1:RootOutput                          3.41e-06     5.1969e-06     2.714e-05     4.15e-06     3.79059e-06      39     
end_path:michelremoving:michelremoving            1.203e-05    2.94067e-05   0.000505686     1.5e-05     7.74485e-05      39     
end_path:michelremovinggnocchi:michelremoving     3.871e-06    8.92713e-06   0.000121872     5.7e-06     1.83653e-05      39     
end_path:calibanagnocchi:CalibAnaTree             3.53e-06     9.05582e-06   0.000138712    5.48e-06     2.10712e-05      39     
end_path:out1:RootOutput(write)                  0.000504766    0.0010377    0.00701362    0.000677719   0.00113362       39     
===================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 3661.98 MB
  Peak resident set size usage (VmHWM): 1261.28 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029350_0073_dataflow1_datawriter_0_20240927T034759_reco_stage1_reco_stage2_20240927T045944_keepup.root
\tHists: np04hd_raw_run029350_0073_dataflow1_datawriter_0_20240927T034759_reco_stage1_reco_stage2_20240927T045944_keepup_hists.root
Forming reco metadata
Successfully opened file np04hd_raw_run029350_0073_dataflow1_datawriter_0_20240927T034759_reco_stage1_reco_stage2_20240927T045944_keepup.root
Ran successfully
{
  "name": "np04hd_raw_run029350_0073_dataflow1_datawriter_0_20240927T034759_reco_stage1_reco_stage2_20240927T045944_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": 1727413084.0,
    "core.end_time": 1727413185.0,
    "core.events": [
      5695,
      5697,
      5699,
      5701,
      5703,
      5705,
      5707,
      5709,
      5711,
      5713,
      5715,
      5717,
      5719,
      5721,
      5723,
      5725,
      5727,
      5729,
      5731,
      5733,
      5735,
      5737,
      5739,
      5741,
      5743,
      5745,
      5747,
      5749,
      5751,
      5753,
      5755,
      5757,
      5759,
      5761,
      5763,
      5765,
      5767,
      5769,
      5771
    ],
    "core.event_count": 39,
    "core.first_event_number": 5695,
    "core.last_event_number": 5771,
    "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_0073_dataflow1_datawriter_0_20240927T034759.hdf5"
    }
  ]
}Forming hist metadata
formed
{
  "name": "np04hd_raw_run029350_0073_dataflow1_datawriter_0_20240927T034759_reco_stage1_reco_stage2_20240927T045944_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": 1727413084.0,
    "core.end_time": 1727413185.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_0073_dataflow1_datawriter_0_20240927T034759.hdf5"
    }
  ]
}
justIN time: 2024-11-17 06:10:44 UTC       justIN version: 01.01.09