chromium/tools/perf/testdata/task_output_dir/1/dummy_benchmark.histogram_benchmark_1.reference/benchmark_log.txt

(INFO) 2018-07-06 02:28:24,664 timeout_retry.WaitFor:105  condition '<lambda>' met
(INFO) 2018-07-06 02:28:24,664 timeout_retry.WaitFor:105  condition '<lambda>' met
(WARNING) 2018-07-06 02:28:24,664 desktop_browser_finder.FindAllAvailableBrowsers:274  Chrome build location for mac_x86_64 not found. Browser will be run without Flash.
(INFO) 2018-07-06 02:28:24,829 browser_finder.FindBrowser:123  Chose browser: PossibleDesktopBrowser(type=reference, executable=/b/s/w/ir/third_party/catapult/common/py_utils/py_utils/bin/reference_builds/chrome_stable_mac_x86_64_c8bef32ba36d46afed8fc8483aeb72ce65656986/chrome-mac/Google Chrome.app/Contents/MacOS/Google Chrome, flash=None)
(INFO) 2018-07-06 02:28:24,831 timeout_retry.WaitFor:105  condition '<lambda>' met
(INFO) 2018-07-06 02:28:24,831 timeout_retry.WaitFor:105  condition '<lambda>' met
(WARNING) 2018-07-06 02:28:24,831 desktop_browser_finder.FindAllAvailableBrowsers:274  Chrome build location for mac_x86_64 not found. Browser will be run without Flash.
(INFO) 2018-07-06 02:28:24,991 browser_finder.FindBrowser:123  Chose browser: PossibleDesktopBrowser(type=reference, executable=/b/s/w/ir/third_party/catapult/common/py_utils/py_utils/bin/reference_builds/chrome_stable_mac_x86_64_c8bef32ba36d46afed8fc8483aeb72ce65656986/chrome-mac/Google Chrome.app/Contents/MacOS/Google Chrome, flash=None)
(INFO) 2018-07-06 02:28:24,991 ts_proxy_server.StartServer:68  Tsproxy commandline: ['/b/s/w/ir/.swarming_module_cache/vpython/fe1f6b/bin/python', '/b/s/w/ir/third_party/catapult/telemetry/third_party/tsproxy/tsproxy.py', '--port=0', '--desthost=127.0.0.1']
(INFO) 2018-07-06 02:28:25,075 ts_proxy_server.StartServer:75  TsProxy port: 52132
(INFO) 2018-07-06 02:28:25,075 __init__._StartedForwarding:47  DoNothingForwarder started between 127.0.0.1:52132 and 52132
[ RUN      ] dummy_benchmark.histogram_benchmark_1/dummy_page.html
(INFO) 2018-07-06 02:28:25,077 chrome_tracing_agent._CreateTraceConfigFile:284  Trace config file string: {"trace_config": {"included_categories": ["disabled-by-default-cc.debug", "*", "blink.console"], "record_mode": "record-as-much-as-possible"}}
(INFO) 2018-07-06 02:28:25,099 desktop_browser_backend.Start:239  Starting Chrome [u'/b/s/w/ir/third_party/catapult/common/py_utils/py_utils/bin/reference_builds/chrome_stable_mac_x86_64_c8bef32ba36d46afed8fc8483aeb72ce65656986/chrome-mac/Google Chrome.app/Contents/MacOS/Google Chrome', '--enable-net-benchmarking', '--metrics-recording-only', '--no-default-browser-check', '--no-first-run', '--enable-gpu-benchmarking', '--deny-permission-prompts', '--autoplay-policy=no-user-gesture-required', '--disable-background-networking', '--disable-component-extensions-with-background-pages', '--disable-default-apps', '--disable-search-geolocation-disclosure', '--proxy-server=socks://localhost:52132', '--ignore-certificate-errors-spki-list=PhrPvGIaAMmd29hj8BCZOq096yj7uMpRNHpn5PDxI6I=', '--remote-debugging-port=0', '--enable-crash-reporter-for-testing', '--disable-component-update', '--window-size=1280,1024', '--user-data-dir=/b/s/w/it5yMs1s/tmpQ231hq', '--trace-config-file=/b/s/w/it5yMs1s/tmpjDj7Lc/chrome-trace-config.json', 'about:blank']
(INFO) 2018-07-06 02:28:25,273 __init__._StartedForwarding:47  DoNothingForwarder started between 127.0.0.1:52133 and 52133
(INFO) 2018-07-06 02:28:25,274 chrome_browser_backend._GetDevToolsClient:118  Got devtools config: ws://127.0.0.1:52133/devtools/browser/ccea192b-be00-4fef-aceb-ccc09299a78c
(INFO) 2018-07-06 02:28:25,631 browser._LogBrowserInfo:99  Browser started (pid=29915).
(INFO) 2018-07-06 02:28:25,632 browser._LogBrowserInfo:102  OS: mac highsierra
(INFO) 2018-07-06 02:28:25,655 browser._LogBrowserInfo:105  Detailed OS version: 10.13.3 17D47
(INFO) 2018-07-06 02:28:25,915 browser._LogBrowserInfo:109  Model: MacBookPro 11.5
(INFO) 2018-07-06 02:28:25,915 browser._LogBrowserInfo:111  Browser command line: /b/s/w/ir/third_party/catapult/common/py_utils/py_utils/bin/reference_builds/chrome_stable_mac_x86_64_c8bef32ba36d46afed8fc8483aeb72ce65656986/chrome-mac/Google Chrome.app/Contents/MacOS/Google Chrome --enable-net-benchmarking --metrics-recording-only --no-default-browser-check --no-first-run --enable-gpu-benchmarking --deny-permission-prompts --autoplay-policy=no-user-gesture-required --disable-background-networking --disable-component-extensions-with-background-pages --disable-default-apps --disable-search-geolocation-disclosure --proxy-server=socks://localhost:52132 --ignore-certificate-errors-spki-list=PhrPvGIaAMmd29hj8BCZOq096yj7uMpRNHpn5PDxI6I= --remote-debugging-port=0 --enable-crash-reporter-for-testing --disable-component-update --window-size=1280,1024 --user-data-dir=/b/s/w/it5yMs1s/tmpQ231hq --trace-config-file=/b/s/w/it5yMs1s/tmpjDj7Lc/chrome-trace-config.json --flag-switches-begin --flag-switches-end about:blank
(INFO) 2018-07-06 02:28:25,915 browser._LogBrowserInfo:114  GPU device 0: VENDOR = 0x1002 (ATI), DEVICE = 0x6821
(INFO) 2018-07-06 02:28:25,915 browser._LogBrowserInfo:114  GPU device 1: VENDOR = 0x8086 (Intel), DEVICE = 0xd26
(INFO) 2018-07-06 02:28:25,916 browser._LogBrowserInfo:116  GPU Attributes:
(INFO) 2018-07-06 02:28:25,916 browser._LogBrowserInfo:118    amd_switchable      : True
(INFO) 2018-07-06 02:28:25,916 browser._LogBrowserInfo:118    can_support_threaded_texture_mailbox: False
(INFO) 2018-07-06 02:28:25,916 browser._LogBrowserInfo:118    direct_composition  : False
(INFO) 2018-07-06 02:28:25,916 browser._LogBrowserInfo:118    direct_rendering    : True
(INFO) 2018-07-06 02:28:25,916 browser._LogBrowserInfo:118    driver_date         : 
(INFO) 2018-07-06 02:28:25,916 browser._LogBrowserInfo:118    driver_vendor       : 
(INFO) 2018-07-06 02:28:25,916 browser._LogBrowserInfo:118    driver_version      : 
(INFO) 2018-07-06 02:28:25,916 browser._LogBrowserInfo:118    encrypted_only      : False
(INFO) 2018-07-06 02:28:25,916 browser._LogBrowserInfo:118    gl_extensions       : 
(INFO) 2018-07-06 02:28:25,916 browser._LogBrowserInfo:118    gl_renderer         : 
(INFO) 2018-07-06 02:28:25,916 browser._LogBrowserInfo:118    gl_reset_notification_strategy: 0
(INFO) 2018-07-06 02:28:25,916 browser._LogBrowserInfo:118    gl_vendor           : 
(INFO) 2018-07-06 02:28:25,916 browser._LogBrowserInfo:118    gl_version          : 
(INFO) 2018-07-06 02:28:25,917 browser._LogBrowserInfo:118    gl_ws_extensions    : 
(INFO) 2018-07-06 02:28:25,917 browser._LogBrowserInfo:118    gl_ws_vendor        : 
(INFO) 2018-07-06 02:28:25,917 browser._LogBrowserInfo:118    gl_ws_version       : 
(INFO) 2018-07-06 02:28:25,917 browser._LogBrowserInfo:118    in_process_gpu      : False
(INFO) 2018-07-06 02:28:25,917 browser._LogBrowserInfo:118    initialization_time : 0.027608
(INFO) 2018-07-06 02:28:25,917 browser._LogBrowserInfo:118    jpeg_decode_accelerator_supported: False
(INFO) 2018-07-06 02:28:25,917 browser._LogBrowserInfo:118    max_framerate_denominator: 1
(INFO) 2018-07-06 02:28:25,917 browser._LogBrowserInfo:118    max_framerate_numerator: 30
(INFO) 2018-07-06 02:28:25,917 browser._LogBrowserInfo:118    max_msaa_samples    : 
(INFO) 2018-07-06 02:28:25,917 browser._LogBrowserInfo:118    max_resolution_height: 2160
(INFO) 2018-07-06 02:28:25,917 browser._LogBrowserInfo:118    max_resolution_width: 4096
(INFO) 2018-07-06 02:28:25,917 browser._LogBrowserInfo:118    min_resolution_height: 16
(INFO) 2018-07-06 02:28:25,917 browser._LogBrowserInfo:118    min_resolution_width: 16
(INFO) 2018-07-06 02:28:25,917 browser._LogBrowserInfo:118    optimus             : False
(INFO) 2018-07-06 02:28:25,917 browser._LogBrowserInfo:118    passthrough_cmd_decoder: False
(INFO) 2018-07-06 02:28:25,918 browser._LogBrowserInfo:118    pixel_shader_version: 
(INFO) 2018-07-06 02:28:25,918 browser._LogBrowserInfo:118    process_crash_count : 0
(INFO) 2018-07-06 02:28:25,918 browser._LogBrowserInfo:118    profile             : 3
(INFO) 2018-07-06 02:28:25,918 browser._LogBrowserInfo:118    sandboxed           : True
(INFO) 2018-07-06 02:28:25,918 browser._LogBrowserInfo:118    software_rendering  : False
(INFO) 2018-07-06 02:28:25,918 browser._LogBrowserInfo:118    supports_overlays   : False
(INFO) 2018-07-06 02:28:25,918 browser._LogBrowserInfo:118    vertex_shader_version: 
(INFO) 2018-07-06 02:28:25,918 browser._LogBrowserInfo:118    video_decode_accelerator_flags: 0
(INFO) 2018-07-06 02:28:25,918 browser._LogBrowserInfo:120  Feature Status:
(INFO) 2018-07-06 02:28:25,918 browser._LogBrowserInfo:122    2d_canvas           : enabled
(INFO) 2018-07-06 02:28:25,918 browser._LogBrowserInfo:122    checker_imaging     : disabled_off
(INFO) 2018-07-06 02:28:25,918 browser._LogBrowserInfo:122    flash_3d            : enabled
(INFO) 2018-07-06 02:28:25,918 browser._LogBrowserInfo:122    flash_stage3d       : enabled
(INFO) 2018-07-06 02:28:25,918 browser._LogBrowserInfo:122    flash_stage3d_baseline: enabled
(INFO) 2018-07-06 02:28:25,919 browser._LogBrowserInfo:122    gpu_compositing     : enabled
(INFO) 2018-07-06 02:28:25,919 browser._LogBrowserInfo:122    multiple_raster_threads: enabled_on
(INFO) 2018-07-06 02:28:25,919 browser._LogBrowserInfo:122    native_gpu_memory_buffers: enabled
(INFO) 2018-07-06 02:28:25,919 browser._LogBrowserInfo:122    rasterization       : enabled
(INFO) 2018-07-06 02:28:25,919 browser._LogBrowserInfo:122    surface_synchronization: enabled_on
(INFO) 2018-07-06 02:28:25,919 browser._LogBrowserInfo:122    video_decode        : enabled
(INFO) 2018-07-06 02:28:25,919 browser._LogBrowserInfo:122    webgl               : enabled
(INFO) 2018-07-06 02:28:25,919 browser._LogBrowserInfo:122    webgl2              : enabled
(INFO) 2018-07-06 02:28:25,919 browser._LogBrowserInfo:124  Driver Bug Workarounds:
(INFO) 2018-07-06 02:28:25,919 browser._LogBrowserInfo:126    add_and_true_to_loop_condition
(INFO) 2018-07-06 02:28:25,919 browser._LogBrowserInfo:126    adjust_src_dst_region_for_blitframebuffer
(INFO) 2018-07-06 02:28:25,919 browser._LogBrowserInfo:126    avoid_stencil_buffers
(INFO) 2018-07-06 02:28:25,919 browser._LogBrowserInfo:126    decode_encode_srgb_for_generatemipmap
(INFO) 2018-07-06 02:28:25,919 browser._LogBrowserInfo:126    disable_framebuffer_cmaa
(INFO) 2018-07-06 02:28:25,920 browser._LogBrowserInfo:126    disable_webgl_rgb_multisampling_usage
(INFO) 2018-07-06 02:28:25,920 browser._LogBrowserInfo:126    dont_use_loops_to_initialize_variables
(INFO) 2018-07-06 02:28:25,920 browser._LogBrowserInfo:126    emulate_abs_int_function
(INFO) 2018-07-06 02:28:25,920 browser._LogBrowserInfo:126    get_frag_data_info_bug
(INFO) 2018-07-06 02:28:25,920 browser._LogBrowserInfo:126    init_two_cube_map_levels_before_copyteximage
(INFO) 2018-07-06 02:28:25,920 browser._LogBrowserInfo:126    msaa_is_slow
(INFO) 2018-07-06 02:28:25,920 browser._LogBrowserInfo:126    pack_parameters_workaround_with_pack_buffer
(INFO) 2018-07-06 02:28:25,920 browser._LogBrowserInfo:126    rebind_transform_feedback_before_resume
(INFO) 2018-07-06 02:28:25,920 browser._LogBrowserInfo:126    regenerate_struct_names
(INFO) 2018-07-06 02:28:25,920 browser._LogBrowserInfo:126    remove_invariant_and_centroid_for_essl3
(INFO) 2018-07-06 02:28:25,920 browser._LogBrowserInfo:126    reset_teximage2d_base_level
(INFO) 2018-07-06 02:28:25,920 browser._LogBrowserInfo:126    rewrite_texelfetchoffset_to_texelfetch
(INFO) 2018-07-06 02:28:25,920 browser._LogBrowserInfo:126    scalarize_vec_and_mat_constructor_args
(INFO) 2018-07-06 02:28:25,921 browser._LogBrowserInfo:126    set_zero_level_before_generating_mipmap
(INFO) 2018-07-06 02:28:25,921 browser._LogBrowserInfo:126    unfold_short_circuit_as_ternary_operation
(INFO) 2018-07-06 02:28:25,921 browser._LogBrowserInfo:126    unpack_alignment_workaround_with_unpack_buffer
(INFO) 2018-07-06 02:28:25,921 browser._LogBrowserInfo:126    unpack_image_height_workaround_with_unpack_buffer
(INFO) 2018-07-06 02:28:25,921 browser._LogBrowserInfo:126    use_intermediary_for_copy_texture_image
(INFO) 2018-07-06 02:28:25,921 browser._LogBrowserInfo:126    use_unused_standard_shared_blocks
(INFO) 2018-07-06 02:28:25,936 ts_proxy_server._IssueCommand:97  Issuing command to ts_proxy_server: set rtt 0
(INFO) 2018-07-06 02:28:25,936 ts_proxy_server._IssueCommand:97  Issuing command to ts_proxy_server: set inkbps 0
(INFO) 2018-07-06 02:28:25,936 ts_proxy_server._IssueCommand:97  Issuing command to ts_proxy_server: set outkbps 0
(INFO) 2018-07-06 02:28:25,937 cache_temperature.EnsurePageCacheTemperature:179  PageCacheTemperature: any
(INFO) 2018-07-06 02:28:26,343 chrome_tracing_agent.RecordClockSyncMarker:180  Chrome version: 3359
(INFO) 2018-07-06 02:28:26,447 trace_data.Serialize:190  Trace sizes in bytes: {'traceEvents': 2023625, 'telemetry': 30769, 'tabIds': 36}
(INFO) 2018-07-06 02:28:31,348 trace_data.Serialize:199  trace2html finished in 4.90 seconds.
(INFO) 2018-07-06 02:28:31,349 timeline_based_measurement._ComputeTimelineBasedMetrics:310  Starting to compute metrics on trace
(INFO) 2018-07-06 02:28:32,966 timeline_based_measurement._ComputeTimelineBasedMetrics:316  Processing resulting traces took 1.617 seconds
(INFO) 2018-07-06 02:28:32,973 browser.Close:207  Closing browser (pid=29915) ...
(INFO) 2018-07-06 02:28:33,142 browser.Close:220  Browser is closed.
[       OK ] dummy_benchmark.histogram_benchmark_1/dummy_page.html (8075 ms)
(INFO) 2018-07-06 02:28:33,154 cloud_storage.Insert:378  Uploading /b/s/w/it5yMs1s/tmpbu2_EA.html to gs://chrome-telemetry-output/dummy_page_html_2018-07-06_02-28-25_40532.html
View generated trace files online at https://console.developers.google.com/m/cloudstorage/b/chrome-telemetry-output/o/dummy_page_html_2018-07-06_02-28-25_40532.html for story dummy_page.html
(INFO) 2018-07-06 02:28:35,301 cloud_storage.Insert:378  Uploading /b/s/w/it5yMs1s/tmpSrXtjntelemetry/artifacts/telemetry_testvl00kf to gs://chrome-telemetry-output/f4dcaaae-80fe-11e8-ace2-a860b63c6b79
Uploading logs of page dummy_page.html to https://console.developers.google.com/m/cloudstorage/b/chrome-telemetry-output/o/f4dcaaae-80fe-11e8-ace2-a860b63c6b79 (1 out of 1)
(INFO) 2018-07-06 02:28:36,794 memory_debug.LogHostMemoryUsage:60  Used 5.0 GiB out of 16.0 GiB memory available.
(INFO) 2018-07-06 02:28:36,794 memory_debug.LogHostMemoryUsage:61  Memory usage of top 10 processes groups
(INFO) 2018-07-06 02:28:36,809 memory_debug.LogHostMemoryUsage:77  - python2.7 - 116.5 MiB - pids: ['27519', '27524', '29902']
(INFO) 2018-07-06 02:28:36,809 memory_debug.LogHostMemoryUsage:77  - Python - 105.5 MiB - pids: ['290', '27513', '27514']
(INFO) 2018-07-06 02:28:36,809 memory_debug.LogHostMemoryUsage:77  - NotificationCenter - 45.8 MiB - pids: ['280']
(INFO) 2018-07-06 02:28:36,809 memory_debug.LogHostMemoryUsage:77  - Finder - 43.6 MiB - pids: ['254']
(INFO) 2018-07-06 02:28:36,809 memory_debug.LogHostMemoryUsage:77  - python - 38.3 MiB - pids: ['299']
(INFO) 2018-07-06 02:28:36,809 memory_debug.LogHostMemoryUsage:77  - SecurityAgent - 34.5 MiB - pids: ['24997']
(INFO) 2018-07-06 02:28:36,809 memory_debug.LogHostMemoryUsage:77  - routined - 33.7 MiB - pids: ['285']
(INFO) 2018-07-06 02:28:36,809 memory_debug.LogHostMemoryUsage:77  - suggestd - 33.5 MiB - pids: ['337']
(INFO) 2018-07-06 02:28:36,809 memory_debug.LogHostMemoryUsage:77  - SystemUIServer - 33.2 MiB - pids: ['252']
(INFO) 2018-07-06 02:28:36,809 memory_debug.LogHostMemoryUsage:77  - CalendarAgent - 33.0 MiB - pids: ['297']
(INFO) 2018-07-06 02:28:36,809 memory_debug.LogHostMemoryUsage:78  Current process:
(INFO) 2018-07-06 02:28:36,809 memory_debug._LogProcessInfo:41  57.0 MiB (pid=29902)
[  PASSED  ] 1 test.

(WARNING) 2018-07-06 02:28:36,811 histogram_set_json_output_formatter.Format:27  Found existing histograms json but failed to parse it.
(WARNING) 2018-07-06 02:28:36,812 histogram_set_json_output_formatter.Format:27  Found existing histograms json but failed to parse it.
(WARNING) 2018-07-06 02:28:36,813 histogram_set_json_output_formatter.Format:27  Found existing histograms json but failed to parse it.
(WARNING) 2018-07-06 02:28:36,814 histogram_set_json_output_formatter.Format:27  Found existing histograms json but failed to parse it.
(WARNING) 2018-07-06 02:28:36,815 histogram_set_json_output_formatter.Format:27  Found existing histograms json but failed to parse it.
(WARNING) 2018-07-06 02:28:36,816 histogram_set_json_output_formatter.Format:27  Found existing histograms json but failed to parse it.
(WARNING) 2018-07-06 02:28:36,817 histogram_set_json_output_formatter.Format:27  Found existing histograms json but failed to parse it.
View result at file:///b/s/w/it5yMs1s/tmpSrXtjntelemetry/histograms.json
View result at file:///b/s/w/it5yMs1s/tmpSrXtjntelemetry/histograms.json
View result at file:///b/s/w/it5yMs1s/tmpSrXtjntelemetry/histograms.json
View result at file:///b/s/w/it5yMs1s/tmpSrXtjntelemetry/histograms.json
View result at file:///b/s/w/it5yMs1s/tmpSrXtjntelemetry/histograms.json
View result at file:///b/s/w/it5yMs1s/tmpSrXtjntelemetry/histograms.json
View result at file:///b/s/w/it5yMs1s/tmpSrXtjntelemetry/histograms.json
View result at file:///b/s/w/it5yMs1s/tmpSrXtjntelemetry/histograms.json
View result at file:///b/s/w/it5yMs1s/tmpSrXtjntelemetry/test-results.json