Back to build
Raw log | Switch to full mode | Login

python -u /b/swarming/w/ir/kitchen-checkout/build/scripts/tools/runit.py --show-path --with-third-party-lib -- python /b/swarming/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/collect_task.py --verbose -o /b/swarming/w/ir/tmp/t/tmpJWKyeJ.json --task-output-dir /b/swarming/w/ir/tmp/t/tmp0qz4uk --merge-script /b/swarming/w/ir/cache/builder/src/build/android/pylib/results/presentation/test_results_presentation.py --merge-script-stdout-file /b/swarming/w/ir/tmp/t/tmpRe8bolmerge_script_log --merge-additional-args '["--bucket", "chromium-result-details", "--test-name", "latency_unittests"]' --build-properties '{"bot_id": "swarm1596-c4", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1556198555874897, "id": "8915201259034326704", "project": "chromium", "tags": ["build_address:luci.chromium.ci/android-marshmallow-arm64-rel/14705", "builder:android-marshmallow-arm64-rel", "buildset:commit/git/cb9dae5d0ff597027948ecc85eec11018803a8bb", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cb9dae5d0ff597027948ecc85eec11018803a8bb", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9080631321242183552", "scheduler_job_id:chromium/android-marshmallow-arm64-rel", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "android-marshmallow-arm64-rel", "buildnumber": 14705, "got_angle_revision": "1b0acbb5126e7f7d03bde3bde6d4b2fba20811c8", "got_dawn_revision": "22cee9ae36b23a8908525d668ef4728a26c931c4", "got_nacl_revision": "6abc006f6760ec49350cd45e8bccbff4809725ac", "got_revision": "cb9dae5d0ff597027948ecc85eec11018803a8bb", "got_revision_cp": "refs/heads/master@{#654004}", "got_swarming_client_revision": "aa60736aded9fc32a0e21a81f5fc51f6009d01f3", "got_v8_revision": "2531f0784031894907b009a0a2de46ea8bc04547", "got_v8_revision_cp": "refs/heads/7.6.29@{#1}", "got_webrtc_revision": "03e85d2b3bd38bfea02560661cf947e058f9d361", "got_webrtc_revision_cp": "refs/heads/master@{#27753}", "mastername": "chromium.android", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "cb9dae5d0ff597027948ecc85eec11018803a8bb"}' --summary-json-file /b/swarming/w/ir/tmp/t/tmpNwLEct.json -- swarming collect -server https://chromium-swarm.appspot.com -worker 50 -task-summary-python -task-output-stdout all -verbose -requests-json /b/swarming/w/ir/tmp/t/tmpZ2BGZ7.json in dir /b/swarming/w/ir/k: allow_subannotations: True cmd: ['python', '-u', '/b/swarming/w/ir/kitchen-checkout/build/scripts/tools/runit.py', '--show-path', '--with-third-party-lib', '--', 'python', '/b/swarming/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/collect_task.py', '--verbose', '-o', '/b/swarming/w/ir/tmp/t/tmpJWKyeJ.json', '--task-output-dir', '/b/swarming/w/ir/tmp/t/tmp0qz4uk', '--merge-script', '/b/swarming/w/ir/cache/builder/src/build/android/pylib/results/presentation/test_results_presentation.py', '--merge-script-stdout-file', '/b/swarming/w/ir/tmp/t/tmpRe8bolmerge_script_log', '--merge-additional-args', '["--bucket", "chromium-result-details", "--test-name", "latency_unittests"]', '--build-properties', '{"bot_id": "swarm1596-c4", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1556198555874897, "id": "8915201259034326704", "project": "chromium", "tags": ["build_address:luci.chromium.ci/android-marshmallow-arm64-rel/14705", "builder:android-marshmallow-arm64-rel", "buildset:commit/git/cb9dae5d0ff597027948ecc85eec11018803a8bb", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cb9dae5d0ff597027948ecc85eec11018803a8bb", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9080631321242183552", "scheduler_job_id:chromium/android-marshmallow-arm64-rel", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "android-marshmallow-arm64-rel", "buildnumber": 14705, "got_angle_revision": "1b0acbb5126e7f7d03bde3bde6d4b2fba20811c8", "got_dawn_revision": "22cee9ae36b23a8908525d668ef4728a26c931c4", "got_nacl_revision": "6abc006f6760ec49350cd45e8bccbff4809725ac", "got_revision": "cb9dae5d0ff597027948ecc85eec11018803a8bb", "got_revision_cp": "refs/heads/master@{#654004}", "got_swarming_client_revision": "aa60736aded9fc32a0e21a81f5fc51f6009d01f3", "got_v8_revision": "2531f0784031894907b009a0a2de46ea8bc04547", "got_v8_revision_cp": "refs/heads/7.6.29@{#1}", "got_webrtc_revision": "03e85d2b3bd38bfea02560661cf947e058f9d361", "got_webrtc_revision_cp": "refs/heads/master@{#27753}", "mastername": "chromium.android", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "cb9dae5d0ff597027948ecc85eec11018803a8bb"}', '--summary-json-file', '/b/swarming/w/ir/tmp/t/tmpNwLEct.json', '--', 'swarming', 'collect', '-server', 'https://chromium-swarm.appspot.com', '-worker', '50', '-task-summary-python', '-task-output-stdout', 'all', '-verbose', '-requests-json', '/b/swarming/w/ir/tmp/t/tmpZ2BGZ7.json'] env: FrozenDict([('PATH', '/b/swarming/w/ir/cache/builder/src/third_party/android_tools/sdk/platform-tools:/b/swarming/w/ir/cache/builder/src/build/android:%(PATH)s'), ('CHROME_HEADLESS', '1')]) env_prefixes: {'mapping': FrozenDict([('PATH', ('/b/swarming/w/ir/cache/swarming_client',))]), 'pathsep': ':'} env_suffixes: {'mapping': FrozenDict([]), 'pathsep': ':'} infra_step: False name_tokens: ['latency_unittests on Android device Nexus 5X'] ok_ret: ALL_OK step_test_data: gen_default_step_test_data(...) trigger_specs: [] full environment: ADDRFAM: inet BOTO_CONFIG: /b/swarming/w/ir/tmp/gsutil-task/.boto BUILDBUCKET_EXPERIMENTAL: FALSE CHROME_HEADLESS: 1 CIPD_CACHE_DIR: /b/swarming/cipd_cache/cache CIPD_PROTOCOL: v2 DEVSHELL_CLIENT_PORT: 36648 DOCKER_CONFIG: /b/swarming/w/ir/tmp/docker-cfg-task DOCKER_TMPDIR: /b/swarming/w/ir/tmp/docker-tmp-task GIT_CONFIG_NOSYSTEM: 1 GIT_TERMINAL_PROMPT: 0 HOME: /home/chrome-bot IFACE: eth0 INFRA_GIT_WRAPPER_HOME: /b/swarming/w/ir/tmp/git-home-task LOGDOG_COORDINATOR_HOST: logs.chromium.org LOGDOG_STREAM_PREFIX: buildbucket/cr-buildbucket.appspot.com/8915201259034326704 LOGDOG_STREAM_PROJECT: chromium LOGDOG_STREAM_SERVER_PATH: unix:/b/swarming/w/ir/tmp/ld.sock LOGICAL: eth0 LUCI_CONTEXT: /b/swarming/w/ir/tmp/luci_context.355376662 MAC_CHROMIUM_TMPDIR: /b/swarming/w/ir/tmp/t METHOD: dhcp NO_GCE_CHECK: False PATH: /b/swarming/w/ir/cache/swarming_client:/b/swarming/w/ir/cache/builder/src/third_party/android_tools/sdk/platform-tools:/b/swarming/w/ir/cache/builder/src/build/android:/b/swarming/w/ir/cipd_bin_packages:/b/swarming/w/ir/cipd_bin_packages/bin:/b/swarming/cipd_cache/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin PWD: /b/swarming/w/ir/k PYTHONIOENCODING: UTF-8 PYTHONUNBUFFERED: 1 ROOT_SETUP_LOG: /var/log/messages/chromebuild/root-setup.log SHLVL: 1 STARTUP_LOG: /var/log/messages/chromebuild/startup.log SWARMING_BOT_ID: swarm1596-c4 SWARMING_EXTERNAL_BOT_SETUP: 1 SWARMING_HEADLESS: 1 SWARMING_SERVER: https://chromium-swarm.appspot.com SWARMING_TASK_ID: 446d7b0ca5858311 TEMP: /b/swarming/w/ir/tmp/t TEMPDIR: /b/swarming/w/ir/tmp/t TERM: linux TMP: /b/swarming/w/ir/tmp/t TMPDIR: /b/swarming/w/ir/tmp/t UPSTART_EVENTS: net-device-up UPSTART_INSTANCE: UPSTART_JOB: chromebuild-startup USER: chrome-bot USERNAME: chrome-bot VPYTHON_VIRTUALENV_ROOT: /b/swarming/w/ir/cache/vpython _: /b/swarming/w/ir/cipd_bin_packages/vpython Set PYTHONPATH: /b/swarming/w/ir/kitchen-checkout/build/scripts:/b/swarming/w/ir/kitchen-checkout/build/site_config:/b/swarming/w/ir/kitchen-checkout/build/third_party:/b/swarming/w/ir/kitchen-checkout/build/third_party/buildbot_8_4p1:/b/swarming/w/ir/kitchen-checkout/build/third_party/buildbot_slave_8_4:/b/swarming/w/ir/kitchen-checkout/build/third_party/coverage-3.7.1:/b/swarming/w/ir/kitchen-checkout/build/third_party/decorator_3_3_1:/b/swarming/w/ir/kitchen-checkout/build/third_party/google_api_python_client:/b/swarming/w/ir/kitchen-checkout/build/third_party/httplib2/python2:/b/swarming/w/ir/kitchen-checkout/build/third_party/infra_libs:/b/swarming/w/ir/kitchen-checkout/build/third_party/jinja2:/b/swarming/w/ir/kitchen-checkout/build/third_party/markupsafe:/b/swarming/w/ir/kitchen-checkout/build/third_party/oauth2client:/b/swarming/w/ir/kitchen-checkout/build/third_party/pyasn1:/b/swarming/w/ir/kitchen-checkout/build/third_party/pyasn1-modules:/b/swarming/w/ir/kitchen-checkout/build/third_party/python-rsa:/b/swarming/w/ir/kitchen-checkout/build/third_party/requests_2_10_0:/b/swarming/w/ir/kitchen-checkout/build/third_party/setuptools-0.6c11:/b/swarming/w/ir/kitchen-checkout/build/third_party/sqlalchemy_0_7_1:/b/swarming/w/ir/kitchen-checkout/build/third_party/sqlalchemy_migrate_0_7_1:/b/swarming/w/ir/kitchen-checkout/build/third_party/tempita_0_5:/b/swarming/w/ir/kitchen-checkout/build/third_party/twisted_10_2:/b/swarming/w/ir/kitchen-checkout/build/third_party/uritemplate:/b/swarming/w/ir/kitchen-checkout/build/third_party/site-packages 2019-04-25 06:53:27,833 - root: [DEBUG] Using task_output_dir: '/b/swarming/w/ir/tmp/t/tmp0qz4uk' 2019-04-25 06:53:27,833 - root: [WARNING] task_output_dir '/b/swarming/w/ir/tmp/t/tmp0qz4uk' already exists! 2019-04-25 06:53:27,833 - root: [WARNING] task_output_dir existing content: [] 2019-04-25 06:53:27,833 - root: [INFO] collect_cmd: swarming collect -server https://chromium-swarm.appspot.com -worker 50 -task-summary-python -task-output-stdout all -verbose -requests-json /b/swarming/w/ir/tmp/t/tmpZ2BGZ7.json -output-dir /b/swarming/w/ir/tmp/t/tmp0qz4uk -task-summary-json /b/swarming/w/ir/tmp/t/tmpNwLEct.json [D2019-04-25T06:53:27.840929-07:00 2311 0 auth.go:1265] Minting a new token {"key":"luci_ctx/6124543ccb0771a4c71756551eb23695b805b0180689ca9428449737ecad291e", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-04-25T06:53:27.841022-07:00 2311 0 luci_ctx.go:138] POST http://127.0.0.1:35596/rpc/LuciLocalAuthService.GetOAuthToken {"key":"luci_ctx/6124543ccb0771a4c71756551eb23695b805b0180689ca9428449737ecad291e", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-04-25T06:53:27.843343-07:00 2311 0 auth.go:1222] Token expires in 53m56.156752555s {"key":"luci_ctx/6124543ccb0771a4c71756551eb23695b805b0180689ca9428449737ecad291e", "scopes":"https://www.googleapis.com/auth/userinfo.email"} 446d94f896627610: exit 0 /b/swarming/swarming_bot.1.zip/third_party/requests/__init__.py:83: RequestsDependencyWarning: Old version of cryptography ([1, 2, 3]) may cause slowdown. Additional test environment: CHROME_DEVEL_SANDBOX=/opt/chromium/chrome_sandbox CHROME_HEADLESS=1 LANG=en_US.UTF-8 Command: /b/swarming/w/ir/.swarming_module_cache/vpython/3bcbb9/bin/python ../../build/android/test_wrapper/logdog_wrapper.py --target latency_unittests --logdog-bin-cmd ../../bin/logdog_butler --store-tombstones --gs-results-bucket=chromium-result-details --recover-devices --test-launcher-summary-output=/b/swarming/w/ioorRT04/output.json I 0.000s Main command: bin/../../../build/android/test_runner.py gtest --output-directory bin/../. --runtime-deps-path bin/../gen.runtime/ui/latency/latency_unittests__test_runner_script.runtime_deps --suite latency_unittests -v --store-tombstones --gs-results-bucket=chromium-result-details --recover-devices --test-launcher-summary-output=/b/swarming/w/ioorRT04/output.json I 0.008s Main condition '<lambda>' met I 0.009s Main condition '<lambda>' met I 3.173s TimeoutThread-1-for-prepare_device(01ef8ad6bced4173) condition 'sd_card_ready' met (0.0s) I 3.717s TimeoutThread-1-for-prepare_device(01ef8ad6bced4173) condition 'pm_ready' met (0.6s) I 3.777s TimeoutThread-1-for-prepare_device(01ef8ad6bced4173) condition 'boot_completed' met (0.6s) I 12.849s TimeoutThread-1-for-individual_device_set_up(01ef8ad6bced4173) Setting permissions for org.chromium.native_test. I 15.729s calculate_device_checksums condition '<lambda>' met (0.1s) I 18.161s list_tests(01ef8ad6bced4173) flags: I 18.161s list_tests(01ef8ad6bced4173) --gtest_list_tests I 19.762s list_tests(01ef8ad6bced4173) /sdcard/temp_file-81e8bcac1e995.gtest_out size on device: 2455 I 19.828s Main Using external sharding settings. This is shard 0/1 I 19.829s Main STARTING TRY #1/3 I 19.829s Main Will run 79 tests on 1 devices: 01ef8ad6bced4173 I 25.234s run_tests_on_device(01ef8ad6bced4173) flags: I 25.235s run_tests_on_device(01ef8ad6bced4173) Getting logdog client. I 27.351s run_tests_on_device(01ef8ad6bced4173) /sdcard/temp_file-b678d39460027.gtest_out size on device: 15547 I 27.571s archive Writing text to logdog stream, logcat_logcat_-8211614896469903446_20190425T130546-UTC_01ef8ad6bced4173 I 27.571s run_tests_on_device(01ef8ad6bced4173) Logcat saved to https://luci-logdog.appspot.com/v/?s=chromium%2Fandroid%2Fswarming%2Flogcats%2F446d6af8f4e0c811%2F%2B%2Flogcat_logcat_-8211614896469903446_20190425T130546-UTC_01ef8ad6bced4173 I 28.183s TimeoutThread-1-for-run_tests_on_device(01ef8ad6bced4173) Setting permissions for org.chromium.native_test. I 31.280s run_tests_on_device(01ef8ad6bced4173) >>ScopedMainEntryLogger I 31.281s run_tests_on_device(01ef8ad6bced4173) Note: Google Test filter = AverageLagTrackerTest.ChangeDirectionInFrame:AverageLagTrackerTest.ImperfectScrollPrediction:AverageLagTrackerTest.LargerLatency:AverageLagTrackerTest.NoScrollPrediction:AverageLagTrackerTest.OneSecondInterval:AverageLagTrackerTest.ScrollPrediction:AverageLagTrackerTest.TwoLatencyInfoInSameFrame:FrameMetricsFixedPointTest.Accumulator96bAddSub:FrameMetricsFixedPointTest.Accumulator96bConstructor:FrameMetricsFixedPointTest.Accumulator96bPrecision:FrameMetricsFixedPointTest.kFixedPointMultiplier:FrameMetricsFixedPointTest.kFixedPointRootMultiplier:FrameMetricsFixedPointTest.kFixedPointRootMultiplierSqrt:FrameMetricsFixedPointTest.kFixedPointRootShift:FrameMetricsHistogramsTest.RatioBoundaries:FrameMetricsHistogramsTest.RatioBoundariesDirect:FrameMetricsHistogramsTest.RatioPercentiles50th:FrameMetricsHistogramsTest.RatioPercentiles99th:FrameMetricsHistogramsTest.ResultsAreNonZeroWithSamplesOfZero:FrameMetricsHistogramsTest.ResultsAreZeroWithoutSamples:FrameMetricsHistogramsTest.VSyncBoundaries:FrameMetricsHistogramsTest.VSyncBoundariesDirect:FrameMetricsHistogramsTest.VSyncPercentiles50th:FrameMetricsHistogramsTest.VSyncPercentiles99th:FrameMetricsTest.AccelerationThresholds:FrameMetricsTest.LatencyAccelerationSaturatesOnOverflow:FrameMetricsTest.LatencySaturatesOnOverflow:FrameMetricsTest.LatencySpeedSaturatesOnOverflow:FrameMetricsTest.LatencyThresholds:FrameMetricsTest.PercentilesLatencyBasic:FrameMetricsTest.PercentilesSkipBasic:FrameMetricsTest.PerfectLatencyScores:FrameMetricsTest.PerfectSmoothnessScores:FrameMetricsTest.SawToothShapedLatency:FrameMetricsTest.SawToothShapedSkips:FrameMetricsTest.SkipSaturatesOnOverflow:FrameMetricsTest.SkipThresholds:FrameMetricsTest.SpeedThresholds:FrameMetricsTest.SquareRootApproximation:FrameMetricsTest.StartNewReportPeriodAvoidsOverflowForAcceleration:FrameMetricsTest.StartNewReportPeriodAvoidsOverflowForLatency:FrameMetricsTest.StartNewReportPeriodAvoidsOverflowForSkips:FrameMetricsTest.StartNewReportPeriodAvoidsOverflowForSpeed:FrameMetricsTest.WorstWindowsRangesUpdateCorrectly:FrameMetricsWindowedAnalyzerTest.AllResultsDifferent:FrameMetricsWindowedAnalyzerTest.AllResultsTheSame:FrameMetricsWindowedAnalyzerTest.BadFirstSamples:FrameMetricsWindowedAnalyzerTest.NoAccumulatedPrecisionErrorBasic:FrameMetricsWindowedAnalyzerTest.NoAccumulatedPrecisionErrorBig:FrameMetricsWindowedAnalyzerTest.NoAccumulatedPrecisionErrorBigger:FrameMetricsWindowedAnalyzerTest.ResetWorstValues:FrameMetricsWindowedAnalyzerTest.SmallSampleSize:LatencyInfoParamTraitsTest.Basic:LatencyInfoParamTraitsTest.InvalidData:LatencyInfoTest.AddTwoSeparateEvent:LatencyInfoTest.CoalesceTwoGSU:SkippedFrameTrackerTest.MultipleWillProduceBeforeDidProduce:SkippedFrameTrackerTest.NoFrameProduced:SkippedFrameTrackerTest.NoSkips_ActiveIdleActive_BeginThenWill:SkippedFrameTrackerTest.NoSkips_ActiveIdleActive_FramePulledAfterPush:SkippedFrameTrackerTest.NoSkips_ActiveIdleActive_FramePulledBeforeBF:SkippedFrameTrackerTest.NoSkips_ActiveIdleActive_FramePulledIsPush:SkippedFrameTrackerTest.NoSkips_ActiveIdleActive_JumpInIdle:SkippedFrameTrackerTest.NoSkips_ActiveIdleActive_WillThenBegin:SkippedFrameTrackerTest.NoSkips_BeginThenWill:SkippedFrameTrackerTest.NoSkips_WillThenBegin:SkippedFrameTrackerTest.PulledFramesNotRecorded:SkippedFrameTrackerTest.Skips_DroppedBeginFrames:SkippedFrameTrackerTest.Skips_DroppedBeginFrames_JitterRoundsDown:SkippedFrameTrackerTest.Skips_DroppedBeginFrames_JitterRoundsUp:SkippedFrameTrackerTest.Skips_ProducedOverMultipleBeginFrames:SkippedFrameTrackerTest.WillNotProduceFrame:SkippedFrameTrackerTest.WillNotProduceFrame2:StreamAnalyzerTest.AllResultsDifferent:StreamAnalyzerTest.AllResultsTheSame:StreamAnalyzerTest.PercentilesModifiedByClient:StreamAnalyzerTest.Precision:StreamAnalyzerTest.SamplesForwardedToHistogram:StructTraitsTest.LatencyInfo I 31.281s run_tests_on_device(01ef8ad6bced4173) [==========] Running 79 tests from 10 test suites. I 31.281s run_tests_on_device(01ef8ad6bced4173) [----------] Global test environment set-up. I 31.281s run_tests_on_device(01ef8ad6bced4173) [----------] 7 tests from AverageLagTrackerTest I 31.281s run_tests_on_device(01ef8ad6bced4173) [ RUN ] AverageLagTrackerTest.OneSecondInterval I 31.281s run_tests_on_device(01ef8ad6bced4173) [ OK ] AverageLagTrackerTest.OneSecondInterval (5 ms) I 31.281s run_tests_on_device(01ef8ad6bced4173) [ RUN ] AverageLagTrackerTest.LargerLatency I 31.281s run_tests_on_device(01ef8ad6bced4173) [ OK ] AverageLagTrackerTest.LargerLatency (4 ms) I 31.281s run_tests_on_device(01ef8ad6bced4173) [ RUN ] AverageLagTrackerTest.TwoLatencyInfoInSameFrame I 31.281s run_tests_on_device(01ef8ad6bced4173) [ OK ] AverageLagTrackerTest.TwoLatencyInfoInSameFrame (4 ms) I 31.281s run_tests_on_device(01ef8ad6bced4173) [ RUN ] AverageLagTrackerTest.ChangeDirectionInFrame I 31.281s run_tests_on_device(01ef8ad6bced4173) [ OK ] AverageLagTrackerTest.ChangeDirectionInFrame (4 ms) I 31.282s run_tests_on_device(01ef8ad6bced4173) [ RUN ] AverageLagTrackerTest.NoScrollPrediction I 31.282s run_tests_on_device(01ef8ad6bced4173) [ OK ] AverageLagTrackerTest.NoScrollPrediction (3 ms) I 31.282s run_tests_on_device(01ef8ad6bced4173) [ RUN ] AverageLagTrackerTest.ScrollPrediction I 31.282s run_tests_on_device(01ef8ad6bced4173) [ OK ] AverageLagTrackerTest.ScrollPrediction (4 ms) I 31.282s run_tests_on_device(01ef8ad6bced4173) [ RUN ] AverageLagTrackerTest.ImperfectScrollPrediction I 31.282s run_tests_on_device(01ef8ad6bced4173) [ OK ] AverageLagTrackerTest.ImperfectScrollPrediction (4 ms) I 31.282s run_tests_on_device(01ef8ad6bced4173) [----------] 7 tests from AverageLagTrackerTest (29 ms total) I 31.282s run_tests_on_device(01ef8ad6bced4173) I 31.282s run_tests_on_device(01ef8ad6bced4173) [----------] 7 tests from FrameMetricsFixedPointTest I 31.282s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsFixedPointTest.kFixedPointMultiplier I 31.282s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsFixedPointTest.kFixedPointMultiplier (2 ms) I 31.282s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsFixedPointTest.kFixedPointRootMultiplier I 31.282s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsFixedPointTest.kFixedPointRootMultiplier (1 ms) I 31.282s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsFixedPointTest.kFixedPointRootMultiplierSqrt I 31.283s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsFixedPointTest.kFixedPointRootMultiplierSqrt (1 ms) I 31.283s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsFixedPointTest.kFixedPointRootShift I 31.283s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsFixedPointTest.kFixedPointRootShift (2 ms) I 31.283s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsFixedPointTest.Accumulator96bConstructor I 31.283s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsFixedPointTest.Accumulator96bConstructor (2 ms) I 31.283s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsFixedPointTest.Accumulator96bAddSub I 31.283s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsFixedPointTest.Accumulator96bAddSub (2 ms) I 31.283s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsFixedPointTest.Accumulator96bPrecision I 31.283s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsFixedPointTest.Accumulator96bPrecision (2 ms) I 31.283s run_tests_on_device(01ef8ad6bced4173) [----------] 7 tests from FrameMetricsFixedPointTest (13 ms total) I 31.283s run_tests_on_device(01ef8ad6bced4173) I 31.283s run_tests_on_device(01ef8ad6bced4173) [----------] 20 tests from FrameMetricsTest I 31.283s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsTest.PerfectSmoothnessScores I 31.284s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsTest.PerfectSmoothnessScores (3 ms) I 31.284s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsTest.PerfectLatencyScores I 31.284s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsTest.PerfectLatencyScores (3 ms) I 31.284s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsTest.SawToothShapedSkips I 31.284s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsTest.SawToothShapedSkips (6 ms) I 31.284s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsTest.SawToothShapedLatency I 31.284s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsTest.SawToothShapedLatency (5 ms) I 31.284s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsTest.SkipSaturatesOnOverflow I 31.284s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsTest.SkipSaturatesOnOverflow (5 ms) I 31.284s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsTest.LatencySaturatesOnOverflow I 31.284s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsTest.LatencySaturatesOnOverflow (5 ms) I 31.284s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsTest.LatencySpeedSaturatesOnOverflow I 31.284s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsTest.LatencySpeedSaturatesOnOverflow (8 ms) I 31.284s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsTest.LatencyAccelerationSaturatesOnOverflow I 31.285s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsTest.LatencyAccelerationSaturatesOnOverflow (8 ms) I 31.285s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsTest.SkipThresholds I 31.285s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsTest.SkipThresholds (16 ms) I 31.285s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsTest.LatencyThresholds I 31.285s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsTest.LatencyThresholds (17 ms) I 31.285s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsTest.SpeedThresholds I 31.285s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsTest.SpeedThresholds (34 ms) I 31.285s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsTest.AccelerationThresholds I 31.285s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsTest.AccelerationThresholds (33 ms) I 31.285s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsTest.PercentilesSkipBasic I 31.285s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsTest.PercentilesSkipBasic (1 ms) I 31.285s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsTest.PercentilesLatencyBasic I 31.285s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsTest.PercentilesLatencyBasic (1 ms) I 31.285s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsTest.WorstWindowsRangesUpdateCorrectly I 31.286s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsTest.WorstWindowsRangesUpdateCorrectly (3 ms) I 31.286s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsTest.StartNewReportPeriodAvoidsOverflowForSkips I 31.286s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsTest.StartNewReportPeriodAvoidsOverflowForSkips (1 ms) I 31.286s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsTest.StartNewReportPeriodAvoidsOverflowForLatency I 31.286s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsTest.StartNewReportPeriodAvoidsOverflowForLatency (6 ms) I 31.286s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsTest.StartNewReportPeriodAvoidsOverflowForSpeed I 31.286s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsTest.StartNewReportPeriodAvoidsOverflowForSpeed (6 ms) I 31.286s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsTest.StartNewReportPeriodAvoidsOverflowForAcceleration I 31.286s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsTest.StartNewReportPeriodAvoidsOverflowForAcceleration (6 ms) I 31.286s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsTest.SquareRootApproximation I 31.286s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsTest.SquareRootApproximation (1 ms) I 31.286s run_tests_on_device(01ef8ad6bced4173) [----------] 20 tests from FrameMetricsTest (177 ms total) I 31.286s run_tests_on_device(01ef8ad6bced4173) I 31.286s run_tests_on_device(01ef8ad6bced4173) [----------] 10 tests from FrameMetricsHistogramsTest I 31.286s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsHistogramsTest.RatioBoundariesDirect I 31.286s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsHistogramsTest.RatioBoundariesDirect (2 ms) I 31.286s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsHistogramsTest.VSyncBoundariesDirect I 31.286s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsHistogramsTest.VSyncBoundariesDirect (1 ms) I 31.286s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsHistogramsTest.ResultsAreZeroWithoutSamples I 31.286s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsHistogramsTest.ResultsAreZeroWithoutSamples (1 ms) I 31.286s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsHistogramsTest.ResultsAreNonZeroWithSamplesOfZero I 31.286s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsHistogramsTest.ResultsAreNonZeroWithSamplesOfZero (1 ms) I 31.286s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsHistogramsTest.RatioBoundaries I 31.286s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsHistogramsTest.RatioBoundaries (2 ms) I 31.286s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsHistogramsTest.VSyncBoundaries I 31.286s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsHistogramsTest.VSyncBoundaries (3 ms) I 31.286s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsHistogramsTest.RatioPercentiles50th I 31.286s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsHistogramsTest.RatioPercentiles50th (1 ms) I 31.286s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsHistogramsTest.RatioPercentiles99th I 31.286s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsHistogramsTest.RatioPercentiles99th (1 ms) I 31.286s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsHistogramsTest.VSyncPercentiles50th I 31.286s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsHistogramsTest.VSyncPercentiles50th (1 ms) I 31.286s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsHistogramsTest.VSyncPercentiles99th I 31.286s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsHistogramsTest.VSyncPercentiles99th (1 ms) I 31.286s run_tests_on_device(01ef8ad6bced4173) [----------] 10 tests from FrameMetricsHistogramsTest (19 ms total) I 31.286s run_tests_on_device(01ef8ad6bced4173) I 31.286s run_tests_on_device(01ef8ad6bced4173) [----------] 2 tests from LatencyInfoTest I 31.286s run_tests_on_device(01ef8ad6bced4173) [ RUN ] LatencyInfoTest.AddTwoSeparateEvent I 31.286s run_tests_on_device(01ef8ad6bced4173) [ OK ] LatencyInfoTest.AddTwoSeparateEvent (2 ms) I 31.286s run_tests_on_device(01ef8ad6bced4173) [ RUN ] LatencyInfoTest.CoalesceTwoGSU I 31.286s run_tests_on_device(01ef8ad6bced4173) [ OK ] LatencyInfoTest.CoalesceTwoGSU (1 ms) I 31.286s run_tests_on_device(01ef8ad6bced4173) [----------] 2 tests from LatencyInfoTest (3 ms total) I 31.286s run_tests_on_device(01ef8ad6bced4173) I 31.286s run_tests_on_device(01ef8ad6bced4173) [----------] 17 tests from SkippedFrameTrackerTest I 31.286s run_tests_on_device(01ef8ad6bced4173) [ RUN ] SkippedFrameTrackerTest.NoSkips_BeginThenWill I 31.287s run_tests_on_device(01ef8ad6bced4173) [ OK ] SkippedFrameTrackerTest.NoSkips_BeginThenWill (1 ms) I 31.287s run_tests_on_device(01ef8ad6bced4173) [ RUN ] SkippedFrameTrackerTest.NoSkips_WillThenBegin I 31.287s run_tests_on_device(01ef8ad6bced4173) [ OK ] SkippedFrameTrackerTest.NoSkips_WillThenBegin (2 ms) I 31.287s run_tests_on_device(01ef8ad6bced4173) [ RUN ] SkippedFrameTrackerTest.Skips_ProducedOverMultipleBeginFrames I 31.287s run_tests_on_device(01ef8ad6bced4173) [ OK ] SkippedFrameTrackerTest.Skips_ProducedOverMultipleBeginFrames (2 ms) I 31.287s run_tests_on_device(01ef8ad6bced4173) [ RUN ] SkippedFrameTrackerTest.Skips_DroppedBeginFrames I 31.287s run_tests_on_device(01ef8ad6bced4173) [ OK ] SkippedFrameTrackerTest.Skips_DroppedBeginFrames (1 ms) I 31.287s run_tests_on_device(01ef8ad6bced4173) [ RUN ] SkippedFrameTrackerTest.Skips_DroppedBeginFrames_JitterRoundsDown I 31.287s run_tests_on_device(01ef8ad6bced4173) [ OK ] SkippedFrameTrackerTest.Skips_DroppedBeginFrames_JitterRoundsDown (1 ms) I 31.287s run_tests_on_device(01ef8ad6bced4173) [ RUN ] SkippedFrameTrackerTest.Skips_DroppedBeginFrames_JitterRoundsUp I 31.287s run_tests_on_device(01ef8ad6bced4173) [ OK ] SkippedFrameTrackerTest.Skips_DroppedBeginFrames_JitterRoundsUp (1 ms) I 31.287s run_tests_on_device(01ef8ad6bced4173) [ RUN ] SkippedFrameTrackerTest.NoSkips_ActiveIdleActive_WillThenBegin I 31.287s run_tests_on_device(01ef8ad6bced4173) [ OK ] SkippedFrameTrackerTest.NoSkips_ActiveIdleActive_WillThenBegin (1 ms) I 31.287s run_tests_on_device(01ef8ad6bced4173) [ RUN ] SkippedFrameTrackerTest.NoSkips_ActiveIdleActive_BeginThenWill I 31.287s run_tests_on_device(01ef8ad6bced4173) [ OK ] SkippedFrameTrackerTest.NoSkips_ActiveIdleActive_BeginThenWill (1 ms) I 31.287s run_tests_on_device(01ef8ad6bced4173) [ RUN ] SkippedFrameTrackerTest.NoSkips_ActiveIdleActive_JumpInIdle I 31.287s run_tests_on_device(01ef8ad6bced4173) [ OK ] SkippedFrameTrackerTest.NoSkips_ActiveIdleActive_JumpInIdle (1 ms) I 31.287s run_tests_on_device(01ef8ad6bced4173) [ RUN ] SkippedFrameTrackerTest.WillNotProduceFrame I 31.287s run_tests_on_device(01ef8ad6bced4173) [ OK ] SkippedFrameTrackerTest.WillNotProduceFrame (1 ms) I 31.287s run_tests_on_device(01ef8ad6bced4173) [ RUN ] SkippedFrameTrackerTest.WillNotProduceFrame2 I 31.287s run_tests_on_device(01ef8ad6bced4173) [ OK ] SkippedFrameTrackerTest.WillNotProduceFrame2 (2 ms) I 31.287s run_tests_on_device(01ef8ad6bced4173) [ RUN ] SkippedFrameTrackerTest.PulledFramesNotRecorded I 31.287s run_tests_on_device(01ef8ad6bced4173) [ OK ] SkippedFrameTrackerTest.PulledFramesNotRecorded (1 ms) I 31.287s run_tests_on_device(01ef8ad6bced4173) [ RUN ] SkippedFrameTrackerTest.MultipleWillProduceBeforeDidProduce I 31.287s run_tests_on_device(01ef8ad6bced4173) [ OK ] SkippedFrameTrackerTest.MultipleWillProduceBeforeDidProduce (1 ms) I 31.287s run_tests_on_device(01ef8ad6bced4173) [ RUN ] SkippedFrameTrackerTest.NoSkips_ActiveIdleActive_FramePulledBeforeBF I 31.287s run_tests_on_device(01ef8ad6bced4173) [ OK ] SkippedFrameTrackerTest.NoSkips_ActiveIdleActive_FramePulledBeforeBF (2 ms) I 31.287s run_tests_on_device(01ef8ad6bced4173) [ RUN ] SkippedFrameTrackerTest.NoSkips_ActiveIdleActive_FramePulledAfterPush I 31.287s run_tests_on_device(01ef8ad6bced4173) [ OK ] SkippedFrameTrackerTest.NoSkips_ActiveIdleActive_FramePulledAfterPush (1 ms) I 31.287s run_tests_on_device(01ef8ad6bced4173) [ RUN ] SkippedFrameTrackerTest.NoSkips_ActiveIdleActive_FramePulledIsPush I 31.287s run_tests_on_device(01ef8ad6bced4173) [ OK ] SkippedFrameTrackerTest.NoSkips_ActiveIdleActive_FramePulledIsPush (1 ms) I 31.287s run_tests_on_device(01ef8ad6bced4173) [ RUN ] SkippedFrameTrackerTest.NoFrameProduced I 31.287s run_tests_on_device(01ef8ad6bced4173) [ OK ] SkippedFrameTrackerTest.NoFrameProduced (2 ms) I 31.287s run_tests_on_device(01ef8ad6bced4173) [----------] 17 tests from SkippedFrameTrackerTest (29 ms total) I 31.287s run_tests_on_device(01ef8ad6bced4173) I 31.287s run_tests_on_device(01ef8ad6bced4173) [----------] 5 tests from StreamAnalyzerTest I 31.287s run_tests_on_device(01ef8ad6bced4173) [ RUN ] StreamAnalyzerTest.AllResultsTheSame I 31.287s run_tests_on_device(01ef8ad6bced4173) [ OK ] StreamAnalyzerTest.AllResultsTheSame (37 ms) I 31.287s run_tests_on_device(01ef8ad6bced4173) [ RUN ] StreamAnalyzerTest.AllResultsDifferent I 31.287s run_tests_on_device(01ef8ad6bced4173) [ OK ] StreamAnalyzerTest.AllResultsDifferent (9 ms) I 31.287s run_tests_on_device(01ef8ad6bced4173) [ RUN ] StreamAnalyzerTest.SamplesForwardedToHistogram I 31.287s run_tests_on_device(01ef8ad6bced4173) [ OK ] StreamAnalyzerTest.SamplesForwardedToHistogram (2 ms) I 31.287s run_tests_on_device(01ef8ad6bced4173) [ RUN ] StreamAnalyzerTest.PercentilesModifiedByClient I 31.287s run_tests_on_device(01ef8ad6bced4173) [ OK ] StreamAnalyzerTest.PercentilesModifiedByClient (1 ms) I 31.287s run_tests_on_device(01ef8ad6bced4173) [ RUN ] StreamAnalyzerTest.Precision I 31.287s run_tests_on_device(01ef8ad6bced4173) [ OK ] StreamAnalyzerTest.Precision (90 ms) I 31.287s run_tests_on_device(01ef8ad6bced4173) [----------] 5 tests from StreamAnalyzerTest (143 ms total) I 31.287s run_tests_on_device(01ef8ad6bced4173) I 31.287s run_tests_on_device(01ef8ad6bced4173) [----------] 8 tests from FrameMetricsWindowedAnalyzerTest I 31.287s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsWindowedAnalyzerTest.AllResultsTheSame I 31.287s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsWindowedAnalyzerTest.AllResultsTheSame (15 ms) I 31.287s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsWindowedAnalyzerTest.AllResultsDifferent I 31.287s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsWindowedAnalyzerTest.AllResultsDifferent (1 ms) I 31.287s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsWindowedAnalyzerTest.SmallSampleSize I 31.287s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsWindowedAnalyzerTest.SmallSampleSize (2 ms) I 31.287s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsWindowedAnalyzerTest.BadFirstSamples I 31.288s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsWindowedAnalyzerTest.BadFirstSamples (1 ms) I 31.288s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsWindowedAnalyzerTest.ResetWorstValues I 31.288s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsWindowedAnalyzerTest.ResetWorstValues (1 ms) I 31.288s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsWindowedAnalyzerTest.NoAccumulatedPrecisionErrorBasic I 31.288s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsWindowedAnalyzerTest.NoAccumulatedPrecisionErrorBasic (2 ms) I 31.288s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsWindowedAnalyzerTest.NoAccumulatedPrecisionErrorBig I 31.288s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsWindowedAnalyzerTest.NoAccumulatedPrecisionErrorBig (2 ms) I 31.288s run_tests_on_device(01ef8ad6bced4173) [ RUN ] FrameMetricsWindowedAnalyzerTest.NoAccumulatedPrecisionErrorBigger I 31.288s run_tests_on_device(01ef8ad6bced4173) [ OK ] FrameMetricsWindowedAnalyzerTest.NoAccumulatedPrecisionErrorBigger (2 ms) I 31.288s run_tests_on_device(01ef8ad6bced4173) [----------] 8 tests from FrameMetricsWindowedAnalyzerTest (31 ms total) I 31.288s run_tests_on_device(01ef8ad6bced4173) I 31.288s run_tests_on_device(01ef8ad6bced4173) [----------] 2 tests from LatencyInfoParamTraitsTest I 31.288s run_tests_on_device(01ef8ad6bced4173) [ RUN ] LatencyInfoParamTraitsTest.Basic I 31.288s run_tests_on_device(01ef8ad6bced4173) [ OK ] LatencyInfoParamTraitsTest.Basic (2 ms) I 31.288s run_tests_on_device(01ef8ad6bced4173) [ RUN ] LatencyInfoParamTraitsTest.InvalidData I 31.288s run_tests_on_device(01ef8ad6bced4173) [ OK ] LatencyInfoParamTraitsTest.InvalidData (1 ms) I 31.288s run_tests_on_device(01ef8ad6bced4173) [----------] 2 tests from LatencyInfoParamTraitsTest (4 ms total) I 31.288s run_tests_on_device(01ef8ad6bced4173) I 31.288s run_tests_on_device(01ef8ad6bced4173) [----------] 1 test from StructTraitsTest I 31.288s run_tests_on_device(01ef8ad6bced4173) [ RUN ] StructTraitsTest.LatencyInfo I 31.288s run_tests_on_device(01ef8ad6bced4173) [ OK ] StructTraitsTest.LatencyInfo (3 ms) I 31.288s run_tests_on_device(01ef8ad6bced4173) [----------] 1 test from StructTraitsTest (3 ms total) I 31.288s run_tests_on_device(01ef8ad6bced4173) I 31.288s run_tests_on_device(01ef8ad6bced4173) [----------] Global test environment tear-down I 31.288s run_tests_on_device(01ef8ad6bced4173) [==========] 79 tests from 10 test suites ran. (463 ms total) I 31.288s run_tests_on_device(01ef8ad6bced4173) [ PASSED ] 79 tests. I 31.288s run_tests_on_device(01ef8ad6bced4173) <<ScopedMainEntryLogger I 31.290s run_tests_on_device(01ef8ad6bced4173) Finished running tests on this device. I 31.315s Main FINISHED TRY #1/3 I 31.315s Main All tests completed. C 31.315s Main ******************************************************************************** C 31.315s Main Summary C 31.315s Main ******************************************************************************** C 31.316s Main [==========] 79 tests ran. C 31.316s Main [ PASSED ] 79 tests. C 31.316s Main ******************************************************************************** I 31.317s tear_down_device(01ef8ad6bced4173) Wrote device cache: /b/swarming/w/ir/out/Release/device_cache_01ef8ad6bced4173.json I 31.320s Main Generated json results file at /b/swarming/w/it0Fche2/tmpu0ERbd I 31.320s Main Finishing archiving output. [W2019-04-25T13:05:52.328127Z 31424 0 butler.go:240] Butler Context was cancelled. Initiating shutdown. {"error":"context canceled"} INFO:devil.utils.timeout_retry:condition 'logdog_stopped' not met [E2019-04-25T13:05:52.363808Z 31424 0 main.go:205] Butler terminated with error. {"error":"context canceled"} [E2019-04-25T13:05:52.363847Z 31424 0 main.go:233] Failed to serve. original error: context canceled [I2019-04-25T13:05:52.363955Z 31424 0 main.go:349] Terminating. {"returnCode":250} INFO:devil.utils.timeout_retry:condition 'logdog_stopped' met 2019-04-25 06:53:28,164 - root: [DEBUG] Contents of task_output_dir: ['/b/swarming/w/ir/tmp/t/tmp0qz4uk/446d94f896627610'] 2019-04-25 06:53:28,164 - root: [DEBUG] Found shard_json_files: ['/b/swarming/w/ir/tmp/t/tmp0qz4uk/446d94f896627610/output.json'] 2019-04-25 06:53:28,165 - root: [INFO] merge_cmd: /b/swarming/w/ir/cache/vpython/ba947a/bin/python /b/swarming/w/ir/cache/builder/src/build/android/pylib/results/presentation/test_results_presentation.py --build-properties {"bot_id": "swarm1596-c4", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1556198555874897, "id": "8915201259034326704", "project": "chromium", "tags": ["build_address:luci.chromium.ci/android-marshmallow-arm64-rel/14705", "builder:android-marshmallow-arm64-rel", "buildset:commit/git/cb9dae5d0ff597027948ecc85eec11018803a8bb", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cb9dae5d0ff597027948ecc85eec11018803a8bb", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9080631321242183552", "scheduler_job_id:chromium/android-marshmallow-arm64-rel", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "android-marshmallow-arm64-rel", "buildnumber": 14705, "got_angle_revision": "1b0acbb5126e7f7d03bde3bde6d4b2fba20811c8", "got_dawn_revision": "22cee9ae36b23a8908525d668ef4728a26c931c4", "got_nacl_revision": "6abc006f6760ec49350cd45e8bccbff4809725ac", "got_revision": "cb9dae5d0ff597027948ecc85eec11018803a8bb", "got_revision_cp": "refs/heads/master@{#654004}", "got_swarming_client_revision": "aa60736aded9fc32a0e21a81f5fc51f6009d01f3", "got_v8_revision": "2531f0784031894907b009a0a2de46ea8bc04547", "got_v8_revision_cp": "refs/heads/7.6.29@{#1}", "got_webrtc_revision": "03e85d2b3bd38bfea02560661cf947e058f9d361", "got_webrtc_revision_cp": "refs/heads/master@{#27753}", "mastername": "chromium.android", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "cb9dae5d0ff597027948ecc85eec11018803a8bb"} --summary-json /b/swarming/w/ir/tmp/t/tmpNwLEct.json --task-output-dir /b/swarming/w/ir/tmp/t/tmp0qz4uk --bucket chromium-result-details --test-name latency_unittests -o /b/swarming/w/ir/tmp/t/tmpJWKyeJ.json /b/swarming/w/ir/tmp/t/tmp0qz4uk/446d94f896627610/output.json Running ['/b/swarming/w/ir/cache/vpython/ba947a/bin/python', '/b/swarming/w/ir/cache/builder/src/build/android/pylib/results/presentation/test_results_presentation.py', '--build-properties', '{"bot_id": "swarm1596-c4", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1556198555874897, "id": "8915201259034326704", "project": "chromium", "tags": ["build_address:luci.chromium.ci/android-marshmallow-arm64-rel/14705", "builder:android-marshmallow-arm64-rel", "buildset:commit/git/cb9dae5d0ff597027948ecc85eec11018803a8bb", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cb9dae5d0ff597027948ecc85eec11018803a8bb", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9080631321242183552", "scheduler_job_id:chromium/android-marshmallow-arm64-rel", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "android-marshmallow-arm64-rel", "buildnumber": 14705, "got_angle_revision": "1b0acbb5126e7f7d03bde3bde6d4b2fba20811c8", "got_dawn_revision": "22cee9ae36b23a8908525d668ef4728a26c931c4", "got_nacl_revision": "6abc006f6760ec49350cd45e8bccbff4809725ac", "got_revision": "cb9dae5d0ff597027948ecc85eec11018803a8bb", "got_revision_cp": "refs/heads/master@{#654004}", "got_swarming_client_revision": "aa60736aded9fc32a0e21a81f5fc51f6009d01f3", "got_v8_revision": "2531f0784031894907b009a0a2de46ea8bc04547", "got_v8_revision_cp": "refs/heads/7.6.29@{#1}", "got_webrtc_revision": "03e85d2b3bd38bfea02560661cf947e058f9d361", "got_webrtc_revision_cp": "refs/heads/master@{#27753}", "mastername": "chromium.android", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "cb9dae5d0ff597027948ecc85eec11018803a8bb"}', '--summary-json', '/b/swarming/w/ir/tmp/t/tmpNwLEct.json', '--task-output-dir', '/b/swarming/w/ir/tmp/t/tmp0qz4uk', u'--bucket', u'chromium-result-details', u'--test-name', u'latency_unittests', '-o', '/b/swarming/w/ir/tmp/t/tmpJWKyeJ.json', '/b/swarming/w/ir/tmp/t/tmp0qz4uk/446d94f896627610/output.json'] in None (env: None) Command ['/b/swarming/w/ir/cache/vpython/ba947a/bin/python', '/b/swarming/w/ir/cache/builder/src/build/android/pylib/results/presentation/test_results_presentation.py', '--build-properties', '{"bot_id": "swarm1596-c4", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1556198555874897, "id": "8915201259034326704", "project": "chromium", "tags": ["build_address:luci.chromium.ci/android-marshmallow-arm64-rel/14705", "builder:android-marshmallow-arm64-rel", "buildset:commit/git/cb9dae5d0ff597027948ecc85eec11018803a8bb", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cb9dae5d0ff597027948ecc85eec11018803a8bb", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9080631321242183552", "scheduler_job_id:chromium/android-marshmallow-arm64-rel", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "android-marshmallow-arm64-rel", "buildnumber": 14705, "got_angle_revision": "1b0acbb5126e7f7d03bde3bde6d4b2fba20811c8", "got_dawn_revision": "22cee9ae36b23a8908525d668ef4728a26c931c4", "got_nacl_revision": "6abc006f6760ec49350cd45e8bccbff4809725ac", "got_revision": "cb9dae5d0ff597027948ecc85eec11018803a8bb", "got_revision_cp": "refs/heads/master@{#654004}", "got_swarming_client_revision": "aa60736aded9fc32a0e21a81f5fc51f6009d01f3", "got_v8_revision": "2531f0784031894907b009a0a2de46ea8bc04547", "got_v8_revision_cp": "refs/heads/7.6.29@{#1}", "got_webrtc_revision": "03e85d2b3bd38bfea02560661cf947e058f9d361", "got_webrtc_revision_cp": "refs/heads/master@{#27753}", "mastername": "chromium.android", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "cb9dae5d0ff597027948ecc85eec11018803a8bb"}', '--summary-json', '/b/swarming/w/ir/tmp/t/tmpNwLEct.json', '--task-output-dir', '/b/swarming/w/ir/tmp/t/tmp0qz4uk', u'--bucket', u'chromium-result-details', u'--test-name', u'latency_unittests', '-o', '/b/swarming/w/ir/tmp/t/tmpJWKyeJ.json', '/b/swarming/w/ir/tmp/t/tmp0qz4uk/446d94f896627610/output.json'] returned exit code 0