Profile API doesn't seem to explain query time

[bslinger (Ben Slinger)]

Hi there,

I was wondering if somebody could explain to me what I'm missing about the profile API? I'm trying to diagnose why my queries have suddenly gotten slower, so turned profile on for one of them, but the time shown in the profile is much lower than the overall time taken (and shown in the top-level 'took' value)

Here is my query and the response, I appreciate any insight you might be able to give!

GET /podchaser/Podcast/_search
{
  "profile":true,
  "_source": [
    "id",
    "title",
    "image_url",
    "slug",
    "display_rating"
  ],
  "query": {
    "bool": {
      "should": [
        {
          "match": {
            "title.exact": {
              "query": "Drizzle",
              "boost": 150
            }
          }
        },
        {
          "match_phrase": {
            "title": {
              "query": "Drizzle",
              "boost": 50
            }
          }
        },
        {
          "nested": {
            "path": "tags",
            "score_mode": "max",
            "query": {
              "function_score": {
                "query": {
                  "match_phrase": {
                    "tags.text": {
                      "query": "Drizzle",
                      "slop": 20
                    }
                  }
                },
                "functions": [
                  {
                    "field_value_factor": {
                      "field": "tags.relevance",
                      "factor": 5
                    }
                  }
                ]
              }
            }
          }
        }
      ],
      "minimum_should_match": 1
    }
  },
  "size": 4
}

Response: https://gist.github.com/bslinger/aa7d2351613d9df84ac25117d73e296d