Add timing for query parsing to GraphQLController

naptime-graphql/src/main/scala/org/coursera/naptime/ari/graphql/controllers/GraphQLController.scala

@@ -118,7 +118,10 @@ class GraphQLController @Inject() (
       variables: JsObject,
       operation: Option[String]): Future[OutgoingQuery] = {
     Future {
-      QueryParser.parse(query) match {
+      val parsedQuery = metricsCollector.timeQueryParsing {
+        QueryParser.parse(query)
+      }
+      parsedQuery match {
         case Success(queryAst) =>
           val baseFilter: IncomingQuery => Future[OutgoingQuery] = (incoming: IncomingQuery) => {
             val context = SangriaGraphQlContext(fetcher, requestHeader, ec, incoming.debugMode)

naptime-graphql/src/main/scala/org/coursera/naptime/ari/graphql/controllers/middleware/MetricsCollectionMiddleware.scala

@@ -39,14 +39,27 @@ class MetricsCollectionMiddleware(
 
 trait GraphQLMetricsCollector {
   def markFieldError(fieldName: String): Unit
+  def timeQueryParsing[A](f: => A): A
 }
 
 class LoggingMetricsCollector extends GraphQLMetricsCollector with StrictLogging {
   def markFieldError(fieldName: String): Unit = {
     logger.info(s"Error when loading field $fieldName")
   }
+
+  def timeQueryParsing[A](f: => A): A = {
+    val before = System.currentTimeMillis()
+    val res = f
+    val after = System.currentTimeMillis()
+    logger.info(s"Parsed query in ${after - before}ms")
+    res
+  }
 }
 
 class NoopMetricsCollector extends GraphQLMetricsCollector with StrictLogging {
   def markFieldError(fieldName: String): Unit = ()
+
+  def timeQueryParsing[A](f: => A): A = {
+    f
+  }
 }

version.sbt

@@ -1 +1 @@
-version in ThisBuild := "0.8.4"
+version in ThisBuild := "0.8.5"