justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID80110.4@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 12:15:14
SiteUK_RAL-Tier1
EntryLIGO_UK_RAL_arc_ce05
Last heartbeat2024-09-27 12:53:13
From worker nodeHostnamedune001-2152155.0-lcg2701.gridpp.rl.ac.uk
cpuinfoAMD EPYC 9654 96-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 12:29:17
Input fileshd-protodune:np04hd_raw_run029350_0109_dataflow1_datawriter_0_20240927T113554.hdf5
JobscriptExit code0
Real time11m (709s)
CPU time4m (259s = 36%)
Outputting started2024-09-27 12:41:07
Output fileshd-protodune-det-reco:np04hd_raw_run029350_0109_dataflow1_datawriter_0_20240927T113554_reco_stage1_reco_stage2_20240927T124056_keepup.root
hd-protodune-det-reco:np04hd_raw_run029350_0109_dataflow1_datawriter_0_20240927T113554_reco_stage1_reco_stage2_20240927T124056_keepup_hists.root
Finished2024-09-27 12:53:13
Saved logsjustin-logs:80110.4-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: 8503 at 27-Sep-2024 12:40:29 UTC
27-Sep-2024 12:40:30 UTC  Opened output file with pattern "%ifb_reco_stage2_%tc_keepup.root"
Begin processing the 2nd record. run: 29350 subRun: 1 event: 8505 at 27-Sep-2024 12:40:32 UTC
Begin processing the 3rd record. run: 29350 subRun: 1 event: 8507 at 27-Sep-2024 12:40:32 UTC
Begin processing the 4th record. run: 29350 subRun: 1 event: 8509 at 27-Sep-2024 12:40:33 UTC
Begin processing the 5th record. run: 29350 subRun: 1 event: 8511 at 27-Sep-2024 12:40:33 UTC
Begin processing the 6th record. run: 29350 subRun: 1 event: 8513 at 27-Sep-2024 12:40:34 UTC
Begin processing the 7th record. run: 29350 subRun: 1 event: 8515 at 27-Sep-2024 12:40:35 UTC
Begin processing the 8th record. run: 29350 subRun: 1 event: 8517 at 27-Sep-2024 12:40:35 UTC
Begin processing the 9th record. run: 29350 subRun: 1 event: 8519 at 27-Sep-2024 12:40:36 UTC
Begin processing the 10th record. run: 29350 subRun: 1 event: 8521 at 27-Sep-2024 12:40:37 UTC
Begin processing the 11th record. run: 29350 subRun: 1 event: 8523 at 27-Sep-2024 12:40:37 UTC
Begin processing the 12th record. run: 29350 subRun: 1 event: 8525 at 27-Sep-2024 12:40:38 UTC
Begin processing the 13th record. run: 29350 subRun: 1 event: 8527 at 27-Sep-2024 12:40:38 UTC
Begin processing the 14th record. run: 29350 subRun: 1 event: 8529 at 27-Sep-2024 12:40:39 UTC
Begin processing the 15th record. run: 29350 subRun: 1 event: 8531 at 27-Sep-2024 12:40:40 UTC
Begin processing the 16th record. run: 29350 subRun: 1 event: 8533 at 27-Sep-2024 12:40:40 UTC
Begin processing the 17th record. run: 29350 subRun: 1 event: 8535 at 27-Sep-2024 12:40:41 UTC
Begin processing the 18th record. run: 29350 subRun: 1 event: 8537 at 27-Sep-2024 12:40:41 UTC
Begin processing the 19th record. run: 29350 subRun: 1 event: 8539 at 27-Sep-2024 12:40:42 UTC
Begin processing the 20th record. run: 29350 subRun: 1 event: 8541 at 27-Sep-2024 12:40:43 UTC
Begin processing the 21st record. run: 29350 subRun: 1 event: 8543 at 27-Sep-2024 12:40:43 UTC
Begin processing the 22nd record. run: 29350 subRun: 1 event: 8545 at 27-Sep-2024 12:40:44 UTC
Begin processing the 23rd record. run: 29350 subRun: 1 event: 8547 at 27-Sep-2024 12:40:45 UTC
Begin processing the 24th record. run: 29350 subRun: 1 event: 8549 at 27-Sep-2024 12:40:45 UTC
Begin processing the 25th record. run: 29350 subRun: 1 event: 8551 at 27-Sep-2024 12:40:46 UTC
Begin processing the 26th record. run: 29350 subRun: 1 event: 8553 at 27-Sep-2024 12:40:47 UTC
Begin processing the 27th record. run: 29350 subRun: 1 event: 8555 at 27-Sep-2024 12:40:47 UTC
Begin processing the 28th record. run: 29350 subRun: 1 event: 8557 at 27-Sep-2024 12:40:48 UTC
Begin processing the 29th record. run: 29350 subRun: 1 event: 8559 at 27-Sep-2024 12:40:48 UTC
Begin processing the 30th record. run: 29350 subRun: 1 event: 8561 at 27-Sep-2024 12:40:49 UTC
Begin processing the 31st record. run: 29350 subRun: 1 event: 8563 at 27-Sep-2024 12:40:50 UTC
Begin processing the 32nd record. run: 29350 subRun: 1 event: 8565 at 27-Sep-2024 12:40:50 UTC
Begin processing the 33rd record. run: 29350 subRun: 1 event: 8567 at 27-Sep-2024 12:40:51 UTC
Begin processing the 34th record. run: 29350 subRun: 1 event: 8569 at 27-Sep-2024 12:40:52 UTC
Begin processing the 35th record. run: 29350 subRun: 1 event: 8571 at 27-Sep-2024 12:40:52 UTC
Begin processing the 36th record. run: 29350 subRun: 1 event: 8573 at 27-Sep-2024 12:40:53 UTC
Begin processing the 37th record. run: 29350 subRun: 1 event: 8575 at 27-Sep-2024 12:40:53 UTC
Begin processing the 38th record. run: 29350 subRun: 1 event: 8577 at 27-Sep-2024 12:40:54 UTC
Begin processing the 39th record. run: 29350 subRun: 1 event: 8579 at 27-Sep-2024 12:40:55 UTC
27-Sep-2024 12:40:56 UTC  Closed output file "np04hd_raw_run029350_0109_dataflow1_datawriter_0_20240927T113554_reco_stage1_reco_stage2_20240927T124056_keepup.root"
27-Sep-2024 12:40:56 UTC  Closed input file "np04hd_raw_run029350_0109_dataflow1_datawriter_0_20240927T113554_reco_stage1.root"

===================================================================================================================================
TimeTracker printout (sec)                           Min           Avg           Max         Median          RMS         nEvts   
===================================================================================================================================
Full event                                        0.471659      0.621039      0.780342      0.618057      0.0624177       39     
-----------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                           0.000170917   0.000326418   0.00218386    0.000266331   0.000307931      39     
produce:fembfilter:PDHDFEMBFilter                  0.47032      0.619029      0.770007      0.616638      0.0614668       39     
[art]:TriggerResults:TriggerResultInserter       3.6145e-05    5.2359e-05    0.000208724   4.4758e-05    2.69386e-05      39     
end_path:out1:RootOutput                          3.916e-06    6.80203e-06   3.1538e-05     4.817e-06    4.94526e-06      39     
end_path:michelremoving:michelremoving           1.0896e-05    2.94601e-05   0.00039261    1.6344e-05    5.97559e-05      39     
end_path:michelremovinggnocchi:michelremoving     2.444e-06    6.9559e-06    8.4247e-05     3.946e-06    1.28579e-05      39     
end_path:calibanagnocchi:CalibAnaTree             2.073e-06    5.39841e-06   7.7197e-05     3.165e-06    1.16898e-05      39     
end_path:out1:RootOutput(write)                  0.000506983   0.00112803     0.0059074    0.000738351   0.000982446      39     
===================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 3666.14 MB
  Peak resident set size usage (VmHWM): 1161.99 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029350_0109_dataflow1_datawriter_0_20240927T113554_reco_stage1_reco_stage2_20240927T124056_keepup.root
\tHists: np04hd_raw_run029350_0109_dataflow1_datawriter_0_20240927T113554_reco_stage1_reco_stage2_20240927T124056_keepup_hists.root
Forming reco metadata
Successfully opened file np04hd_raw_run029350_0109_dataflow1_datawriter_0_20240927T113554_reco_stage1_reco_stage2_20240927T124056_keepup.root
Ran successfully
{
  "name": "np04hd_raw_run029350_0109_dataflow1_datawriter_0_20240927T113554_reco_stage1_reco_stage2_20240927T124056_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": 1727440780.0,
    "core.end_time": 1727440857.0,
    "core.events": [
      8503,
      8505,
      8507,
      8509,
      8511,
      8513,
      8515,
      8517,
      8519,
      8521,
      8523,
      8525,
      8527,
      8529,
      8531,
      8533,
      8535,
      8537,
      8539,
      8541,
      8543,
      8545,
      8547,
      8549,
      8551,
      8553,
      8555,
      8557,
      8559,
      8561,
      8563,
      8565,
      8567,
      8569,
      8571,
      8573,
      8575,
      8577,
      8579
    ],
    "core.event_count": 39,
    "core.first_event_number": 8503,
    "core.last_event_number": 8579,
    "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_0109_dataflow1_datawriter_0_20240927T113554.hdf5"
    }
  ]
}Forming hist metadata
formed
{
  "name": "np04hd_raw_run029350_0109_dataflow1_datawriter_0_20240927T113554_reco_stage1_reco_stage2_20240927T124056_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": 1727440780.0,
    "core.end_time": 1727440857.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_0109_dataflow1_datawriter_0_20240927T113554.hdf5"
    }
  ]
}
justIN time: 2024-11-17 06:06:21 UTC       justIN version: 01.01.09