Decorator for generating New Relic timing metrics (#3464)

* fiddling with nr metrics

* more nr metric tinkering

* actually profile search

* rm unused

* lint

* move decorators to support app

backend/audit/validators.py

@@ -1,6 +1,7 @@
 import os
 import json
 import logging
+
 from jsonschema import Draft7Validator, FormatChecker, validate
 from jsonschema.exceptions import ValidationError as JSONSchemaValidationError
 
@@ -12,7 +13,6 @@
 from openpyxl import load_workbook
 from pypdf import PdfReader
 
-
 from audit.intakelib import (
     additional_ueis_named_ranges,
     additional_eins_named_ranges,
@@ -33,6 +33,7 @@
     SECONDARY_AUDITORS_TEMPLATE_DEFINITION,
     NOTES_TO_SEFA_TEMPLATE_DEFINITION,
 )
+from support.decorators import newrelic_timing_metric
 
 
 logger = logging.getLogger(__name__)
@@ -392,6 +393,7 @@ def _scan_file(file):
         )
 
 
+@newrelic_timing_metric("validate_file_infection")
 def validate_file_infection(file):
     """Files must pass an AV scan"""
     logger.info(f"Attempting to scan file: {file}.")

backend/dissemination/views.py

@@ -30,6 +30,7 @@
     OneTimeAccess,
 )
 from dissemination.summary_reports import generate_summary_report
+from support.decorators import newrelic_timing_metric
 
 from users.permissions import can_read_tribal
 
@@ -128,6 +129,7 @@ def get(self, request, *args, **kwargs):
             },
         )
 
+    @newrelic_timing_metric("search")
     def post(self, request, *args, **kwargs):
         """
         When accessing the search page through post, run a search and display the results.

backend/support/decorators.py

@@ -0,0 +1,24 @@
+import functools
+import logging
+import time
+
+import newrelic.agent
+
+logger = logging.getLogger(__name__)
+
+
+def newrelic_timing_metric(metric_name):
+    def inner(func):
+        @functools.wraps(func)
+        def wrapper_timer(*args, **kwargs):
+            start_time = time.perf_counter()
+            value = func(*args, **kwargs)
+            end_time = time.perf_counter()
+            run_time = end_time - start_time
+            logger.info(f"{metric_name} executed in {run_time:.4f} secs")
+            newrelic.agent.record_custom_metric(f"Custom/{metric_name}", run_time)
+            return value
+
+        return wrapper_timer
+
+    return inner