justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID80616.5@justin-prod-sched02.dune.hep.ac.uk
Workflow ID3531
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 23:14:49
SiteUK_RAL-Tier1
EntryLIGO_UK_RAL_arc_ce04
Last heartbeat2024-09-27 23:29:54
From worker nodeHostnamedune001-2308841.0-lcg2591.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 23:16:24
Input fileshd-protodune:np04hd_raw_run029382_0018_dataflow0_datawriter_0_20240927T222215.hdf5
JobscriptExit code0
Real time12m (731s)
CPU time5m (341s = 46%)
Outputting started2024-09-27 23:28:36
Output fileshd-protodune-det-reco:np04hd_raw_run029382_0018_dataflow0_datawriter_0_20240927T222215_reco_stage1_reco_stage2_20240927T232825_keepup.root
hd-protodune-det-reco:np04hd_raw_run029382_0018_dataflow0_datawriter_0_20240927T222215_reco_stage1_reco_stage2_20240927T232825_keepup_hists.root
Finished2024-09-27 23:29:54
Saved logsjustin-logs:80616.5-justin-prod-sched02.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

d. run: 29382 subRun: 1 event: 1406 at 27-Sep-2024 23:27:52 UTC
27-Sep-2024 23:27:53 UTC  Opened output file with pattern "%ifb_reco_stage2_%tc_keepup.root"
Begin processing the 2nd record. run: 29382 subRun: 1 event: 1408 at 27-Sep-2024 23:27:54 UTC
Begin processing the 3rd record. run: 29382 subRun: 1 event: 1410 at 27-Sep-2024 23:27:55 UTC
Begin processing the 4th record. run: 29382 subRun: 1 event: 1412 at 27-Sep-2024 23:27:56 UTC
Begin processing the 5th record. run: 29382 subRun: 1 event: 1414 at 27-Sep-2024 23:27:57 UTC
Begin processing the 6th record. run: 29382 subRun: 1 event: 1416 at 27-Sep-2024 23:27:58 UTC
Begin processing the 7th record. run: 29382 subRun: 1 event: 1418 at 27-Sep-2024 23:27:58 UTC
Begin processing the 8th record. run: 29382 subRun: 1 event: 1420 at 27-Sep-2024 23:27:59 UTC
Begin processing the 9th record. run: 29382 subRun: 1 event: 1422 at 27-Sep-2024 23:28:00 UTC
Begin processing the 10th record. run: 29382 subRun: 1 event: 1424 at 27-Sep-2024 23:28:01 UTC
Begin processing the 11th record. run: 29382 subRun: 1 event: 1426 at 27-Sep-2024 23:28:02 UTC
Begin processing the 12th record. run: 29382 subRun: 1 event: 1428 at 27-Sep-2024 23:28:02 UTC
Begin processing the 13th record. run: 29382 subRun: 1 event: 1430 at 27-Sep-2024 23:28:03 UTC
Begin processing the 14th record. run: 29382 subRun: 1 event: 1432 at 27-Sep-2024 23:28:04 UTC
Begin processing the 15th record. run: 29382 subRun: 1 event: 1434 at 27-Sep-2024 23:28:05 UTC
Begin processing the 16th record. run: 29382 subRun: 1 event: 1436 at 27-Sep-2024 23:28:06 UTC
Begin processing the 17th record. run: 29382 subRun: 1 event: 1438 at 27-Sep-2024 23:28:06 UTC
Begin processing the 18th record. run: 29382 subRun: 1 event: 1440 at 27-Sep-2024 23:28:07 UTC
Begin processing the 19th record. run: 29382 subRun: 1 event: 1442 at 27-Sep-2024 23:28:08 UTC
Begin processing the 20th record. run: 29382 subRun: 1 event: 1444 at 27-Sep-2024 23:28:09 UTC
Begin processing the 21st record. run: 29382 subRun: 1 event: 1446 at 27-Sep-2024 23:28:10 UTC
Begin processing the 22nd record. run: 29382 subRun: 1 event: 1448 at 27-Sep-2024 23:28:10 UTC
Begin processing the 23rd record. run: 29382 subRun: 1 event: 1450 at 27-Sep-2024 23:28:11 UTC
Begin processing the 24th record. run: 29382 subRun: 1 event: 1452 at 27-Sep-2024 23:28:12 UTC
Begin processing the 25th record. run: 29382 subRun: 1 event: 1454 at 27-Sep-2024 23:28:13 UTC
Begin processing the 26th record. run: 29382 subRun: 1 event: 1456 at 27-Sep-2024 23:28:14 UTC
Begin processing the 27th record. run: 29382 subRun: 1 event: 1458 at 27-Sep-2024 23:28:14 UTC
Begin processing the 28th record. run: 29382 subRun: 1 event: 1460 at 27-Sep-2024 23:28:15 UTC
Begin processing the 29th record. run: 29382 subRun: 1 event: 1462 at 27-Sep-2024 23:28:16 UTC
Begin processing the 30th record. run: 29382 subRun: 1 event: 1464 at 27-Sep-2024 23:28:17 UTC
Begin processing the 31st record. run: 29382 subRun: 1 event: 1466 at 27-Sep-2024 23:28:18 UTC
Begin processing the 32nd record. run: 29382 subRun: 1 event: 1468 at 27-Sep-2024 23:28:18 UTC
Begin processing the 33rd record. run: 29382 subRun: 1 event: 1470 at 27-Sep-2024 23:28:19 UTC
Begin processing the 34th record. run: 29382 subRun: 1 event: 1472 at 27-Sep-2024 23:28:20 UTC
Begin processing the 35th record. run: 29382 subRun: 1 event: 1474 at 27-Sep-2024 23:28:21 UTC
Begin processing the 36th record. run: 29382 subRun: 1 event: 1476 at 27-Sep-2024 23:28:22 UTC
Begin processing the 37th record. run: 29382 subRun: 1 event: 1478 at 27-Sep-2024 23:28:22 UTC
Begin processing the 38th record. run: 29382 subRun: 1 event: 1480 at 27-Sep-2024 23:28:23 UTC
Begin processing the 39th record. run: 29382 subRun: 1 event: 1482 at 27-Sep-2024 23:28:24 UTC
27-Sep-2024 23:28:25 UTC  Closed output file "np04hd_raw_run029382_0018_dataflow0_datawriter_0_20240927T222215_reco_stage1_reco_stage2_20240927T232825_keepup.root"
27-Sep-2024 23:28:25 UTC  Closed input file "np04hd_raw_run029382_0018_dataflow0_datawriter_0_20240927T222215_reco_stage1.root"

===================================================================================================================================
TimeTracker printout (sec)                           Min           Avg           Max         Median          RMS         nEvts   
===================================================================================================================================
Full event                                        0.771768      0.801427      0.874677      0.797782      0.0199399       39     
-----------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                           0.000203323   0.000294866   0.00118328    0.000259714   0.000149708      39     
produce:fembfilter:PDHDFEMBFilter                 0.770247       0.79951      0.865461      0.796406      0.0189052       39     
[art]:TriggerResults:TriggerResultInserter       3.4061e-05    4.27911e-05   0.000140992   3.8061e-05    1.76066e-05      39     
end_path:out1:RootOutput                          3.329e-06    4.80641e-06   2.2161e-05     4.09e-06     3.03253e-06      39     
end_path:michelremoving:michelremoving            1.22e-05     2.3376e-05    0.000285513   1.5061e-05    4.28401e-05      39     
end_path:michelremovinggnocchi:michelremoving     4.52e-06     9.72192e-06   0.000110301    7.22e-06     1.64832e-05      39     
end_path:calibanagnocchi:CalibAnaTree             4.17e-06     1.00719e-05   0.000132072    6.761e-06     1.989e-05       39     
end_path:out1:RootOutput(write)                  0.000604229   0.00101202    0.00636378    0.000672859   0.00100883       39     
===================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 3634.57 MB
  Peak resident set size usage (VmHWM): 1274.79 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029382_0018_dataflow0_datawriter_0_20240927T222215_reco_stage1_reco_stage2_20240927T232825_keepup.root
\tHists: np04hd_raw_run029382_0018_dataflow0_datawriter_0_20240927T222215_reco_stage1_reco_stage2_20240927T232825_keepup_hists.root
Forming reco metadata
Successfully opened file np04hd_raw_run029382_0018_dataflow0_datawriter_0_20240927T222215_reco_stage1_reco_stage2_20240927T232825_keepup.root
Ran successfully
{
  "name": "np04hd_raw_run029382_0018_dataflow0_datawriter_0_20240927T222215_reco_stage1_reco_stage2_20240927T232825_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": 1727479623.0,
    "core.end_time": 1727479706.0,
    "core.events": [
      1406,
      1408,
      1410,
      1412,
      1414,
      1416,
      1418,
      1420,
      1422,
      1424,
      1426,
      1428,
      1430,
      1432,
      1434,
      1436,
      1438,
      1440,
      1442,
      1444,
      1446,
      1448,
      1450,
      1452,
      1454,
      1456,
      1458,
      1460,
      1462,
      1464,
      1466,
      1468,
      1470,
      1472,
      1474,
      1476,
      1478,
      1480,
      1482
    ],
    "core.event_count": 39,
    "core.first_event_number": 1406,
    "core.last_event_number": 1482,
    "core.data_stream": "cosmics",
    "core.file_content_status": "good",
    "core.file_type": "detector",
    "core.run_type": "hd-protodune",
    "core.runs": [
      29382
    ],
    "core.runs_subruns": [
      2938200001
    ],
    "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_run029382_0018_dataflow0_datawriter_0_20240927T222215.hdf5"
    }
  ]
}Forming hist metadata
formed
{
  "name": "np04hd_raw_run029382_0018_dataflow0_datawriter_0_20240927T222215_reco_stage1_reco_stage2_20240927T232825_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": 1727479623.0,
    "core.end_time": 1727479706.0,
    "core.data_stream": "cosmics",
    "core.file_content_status": "good",
    "core.file_type": "detector",
    "core.run_type": "hd-protodune",
    "core.runs": [
      29382
    ],
    "core.runs_subruns": [
      2938200001
    ],
    "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_run029382_0018_dataflow0_datawriter_0_20240927T222215.hdf5"
    }
  ]
}
justIN time: 2024-09-29 09:26:27 UTC       justIN version: 01.01.08