Support tracing metrics for measureValueAsync method

tools/perf/benchmarks/blink_perf.py

 # Copyright 2013 The Chromium Authors. All rights reserved.
 # Use of this source code is governed by a BSD-style license that can be
 # found in the LICENSE file.
 
 import os
 
 from core import path_util
 from core import perf_benchmark
 
 from telemetry import benchmark
@@ skipping 61 matching lines @@
   ps = story.StorySet(base_dir=os.getcwd() + os.sep,
                       serving_dirs=serving_dirs)
   for url in page_urls:
     ps.AddStory(page_module.Page(
         url, ps, ps.base_dir,
         shared_page_state_class=shared_page_state_class))
   return ps
 
 
 def _ComputeTraceEventsThreadTimeForBlinkPerf(
-    renderer_thread, trace_events_to_measure):
+    model, renderer_thread, trace_events_to_measure):
   """ Compute the CPU duration for each of |trace_events_to_measure| during
   blink_perf test.
 
   Args:
     renderer_thread: the renderer thread which run blink_perf test.
     trace_events_to_measure: a list of string names of trace events to measure
     CPU duration for.
 
   Returns:
     a dictionary in which each key is a trace event' name (from
     |trace_events_to_measure| list), and value is a list of numbers that
     represents to total cpu time of that trace events in each blink_perf test.
   """
   trace_cpu_time_metrics = {}
 
   # Collect the bounds of "blink_perf.runTest" events.
   test_runs_bounds = []
   for event in renderer_thread.async_slices:
     if event.name == "blink_perf.runTest":
       test_runs_bounds.append(bounds.Bounds.CreateFromEvent(event))
   test_runs_bounds.sort(key=lambda b: b.min)
 
   for t in trace_events_to_measure:
     trace_cpu_time_metrics[t] = [0.0] * len(test_runs_bounds)
 
   for event_name in trace_events_to_measure:
     curr_test_runs_bound_index = 0
-    for event in renderer_thread.IterAllSlicesOfName(event_name):
+    seen_uuids = set()
+    for event in model.IterAllEventsOfName(event_name):
+      # Trace events can be duplicated in some cases. Filter out trace events
+      # that have duplicated uuid.

[nednguyen, 2017/05/05 15:11:26]

Daniel: I found about this when BlobRequest metrics are seem to be double count.
This is probably already a bug in the current blob_storage benchmark.

+      event_uuid = None
+      if event.args:
+        event_uuid = event.args.get('uuid')
+      if event_uuid and event_uuid in seen_uuids:
+        continue
+      elif event_uuid:
+        seen_uuids.add(event_uuid)
       while (curr_test_runs_bound_index < len(test_runs_bounds) and
              event.start > test_runs_bounds[curr_test_runs_bound_index].max):
         curr_test_runs_bound_index += 1
       if curr_test_runs_bound_index >= len(test_runs_bounds):
         break
       curr_test_bound = test_runs_bounds[curr_test_runs_bound_index]
       intersect_wall_time = bounds.Bounds.GetOverlapBetweenBounds(
           curr_test_bound, bounds.Bounds.CreateFromEvent(event))
       if event.thread_duration and event.duration:
         intersect_cpu_time = (
             intersect_wall_time * event.thread_duration / event.duration)
       else:
         intersect_cpu_time = intersect_wall_time
       trace_cpu_time_metrics[event_name][curr_test_runs_bound_index] += (
           intersect_cpu_time)
-
   return trace_cpu_time_metrics
 
 
-
 class _BlinkPerfMeasurement(legacy_page_test.LegacyPageTest):
   """Tuns a blink performance test and reports the results."""
 
   def __init__(self):
     super(_BlinkPerfMeasurement, self).__init__()
     with open(os.path.join(os.path.dirname(__file__),
                            'blink_perf.js'), 'r') as f:
       self._blink_perf_js = f.read()
 
   def WillNavigateToPage(self, page, tab):
@@ skipping 59 matching lines @@
     if tab.EvaluateJavaScript('testRunner.isWaitingForTracingStart'):
       trace_data = self._ContinueTestRunWithTracing(tab)
       trace_value = trace.TraceValue(page, trace_data)
       results.AddValue(trace_value)
 
       trace_events_to_measure = tab.EvaluateJavaScript(
           'window.testRunner.traceEventsToMeasure')
       model = model_module.TimelineModel(trace_data)
       renderer_thread = model.GetRendererThreadFromTabId(tab.id)
       trace_cpu_time_metrics = _ComputeTraceEventsThreadTimeForBlinkPerf(
-          renderer_thread, trace_events_to_measure)
+          model, renderer_thread, trace_events_to_measure)
 
     log = tab.EvaluateJavaScript('document.getElementById("log").innerHTML')
 
     for line in log.splitlines():
       if line.startswith("FATAL: "):
         print line
         continue
       if not line.startswith('values '):
         continue
       parts = line.split()
@@ skipping 173 matching lines @@
 
 
 @benchmark.Owner(emails=['hayato@chromium.org'])
 class BlinkPerfShadowDOM(_BlinkPerfBenchmark):
   tag = 'shadow_dom'
   subdir = 'ShadowDOM'
 
   @classmethod
   def ShouldDisable(cls, possible_browser):  # http://crbug.com/702319
     return possible_browser.platform.GetDeviceTypeName() == 'Nexus 5X'
-