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

Set PYTHONPATH: /b/s/w/ir/kitchen-checkout/build/scripts:/b/s/w/ir/kitchen-checkout/build/site_config:/b/s/w/ir/kitchen-checkout/build/third_party:/b/s/w/ir/kitchen-checkout/build/third_party/buildbot_8_4p1:/b/s/w/ir/kitchen-checkout/build/third_party/buildbot_slave_8_4:/b/s/w/ir/kitchen-checkout/build/third_party/coverage-3.7.1:/b/s/w/ir/kitchen-checkout/build/third_party/decorator_3_3_1:/b/s/w/ir/kitchen-checkout/build/third_party/google_api_python_client:/b/s/w/ir/kitchen-checkout/build/third_party/httplib2/python2:/b/s/w/ir/kitchen-checkout/build/third_party/infra_libs:/b/s/w/ir/kitchen-checkout/build/third_party/jinja2:/b/s/w/ir/kitchen-checkout/build/third_party/markupsafe:/b/s/w/ir/kitchen-checkout/build/third_party/oauth2client:/b/s/w/ir/kitchen-checkout/build/third_party/pyasn1:/b/s/w/ir/kitchen-checkout/build/third_party/pyasn1-modules:/b/s/w/ir/kitchen-checkout/build/third_party/python-rsa:/b/s/w/ir/kitchen-checkout/build/third_party/requests_2_10_0:/b/s/w/ir/kitchen-checkout/build/third_party/setuptools-0.6c11:/b/s/w/ir/kitchen-checkout/build/third_party/sqlalchemy_0_7_1:/b/s/w/ir/kitchen-checkout/build/third_party/sqlalchemy_migrate_0_7_1:/b/s/w/ir/kitchen-checkout/build/third_party/tempita_0_5:/b/s/w/ir/kitchen-checkout/build/third_party/twisted_10_2:/b/s/w/ir/kitchen-checkout/build/third_party/uritemplate:/b/s/w/ir/kitchen-checkout/build/third_party/site-packages 2019-05-24 01:15:23,291 - root: [DEBUG] Using task_output_dir: '/b/s/w/ir/tmp/t/tmptxU7ZD' 2019-05-24 01:15:23,291 - root: [WARNING] task_output_dir '/b/s/w/ir/tmp/t/tmptxU7ZD' already exists! 2019-05-24 01:15:23,291 - root: [WARNING] task_output_dir existing content: [] 2019-05-24 01:15:23,291 - 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/s/w/ir/tmp/t/tmp5GW5AF.json -output-dir /b/s/w/ir/tmp/t/tmptxU7ZD -task-summary-json /b/s/w/ir/tmp/t/tmpF_sdJg.json [D2019-05-24T01:15:23.302361-07:00 7524 0 auth.go:1265] Minting a new token {"key":"luci_ctx/7d28a429695fb90767758fd40f5117cff3f49bc17a7f4dbb00eff918e45e8890", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-05-24T01:15:23.302447-07:00 7524 0 luci_ctx.go:138] POST http://127.0.0.1:42999/rpc/LuciLocalAuthService.GetOAuthToken {"key":"luci_ctx/7d28a429695fb90767758fd40f5117cff3f49bc17a7f4dbb00eff918e45e8890", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-05-24T01:15:23.304232-07:00 7524 0 auth.go:1222] Token expires in 28m43.695788519s {"key":"luci_ctx/7d28a429695fb90767758fd40f5117cff3f49bc17a7f4dbb00eff918e45e8890", "scopes":"https://www.googleapis.com/auth/userinfo.email"} 4501aefcbb50a610: 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. I 0.000s Main command: bin/../../../build/android/test_runner.py gtest --output-directory bin/../. --runtime-deps-path bin/../gen.runtime/rtc_tools/tools_unittests__test_runner_script.runtime_deps --suite tools_unittests --shard-timeout=900 -v --logcat-output-file /b/swarming/w/ioztC2HI/logcats --store-tombstones --test-launcher-summary-output=/b/swarming/w/ioztC2HI/output.json I 0.007s Main condition '<lambda>' met I 0.007s Main condition '<lambda>' met I 3.168s TimeoutThread-1-for-prepare_device(01e08212a27dcc85) condition 'sd_card_ready' met (0.0s) I 3.737s TimeoutThread-1-for-prepare_device(01e08212a27dcc85) condition 'pm_ready' met (0.6s) I 3.786s TimeoutThread-1-for-prepare_device(01e08212a27dcc85) condition 'boot_completed' met (0.7s) I 13.017s TimeoutThread-1-for-individual_device_set_up(01e08212a27dcc85) Setting permissions for org.webrtc.native_test. I 16.226s calculate_device_checksums condition '<lambda>' met (0.1s) I 24.937s TimeoutThread-1-for-individual_device_set_up(01e08212a27dcc85) Pushing 6 files via .zip of size 69695717 I 47.290s list_tests(01e08212a27dcc85) flags: I 47.290s list_tests(01e08212a27dcc85) --gtest_list_tests I 47.302s TimeoutThread-1-for-list_tests(01e08212a27dcc85) Large shell command will be run from file: ( p=org.webrtc.native_test;am instrument -w -e org.chromium.native_test.NativeTestInstrumentationTestRunner.ShardNanoTimeout 30000000000 -e org.chromium.native_test.NativeTestInstrumentationTestRunner.NativeTestActivity "$p".RTCNativeUnitTestActivity -e org.chromium.native_test.NativeTestInstrumentationTestRunner.StdoutFile /sdcard/temp_file-edbd3a43effb5.gtest_out -e org.chromium.native_test.NativeTest.CommandLineFlags --gtest_list_tests "$p"/org.chromium.native_test.NativeTestInstrumentationTestRunner )>/ ... I 49.034s list_tests(01e08212a27dcc85) /sdcard/temp_file-edbd3a43effb5.gtest_out size on device: 2305 I 49.102s Main Using external sharding settings. This is shard 0/1 I 49.102s Main STARTING TRY #1/3 I 49.102s Main Will run 69 tests on 1 devices: 01e08212a27dcc85 I 52.404s run_tests_on_device(01e08212a27dcc85) flags: I 52.405s run_tests_on_device(01e08212a27dcc85) Getting logdog client. I 52.507s TimeoutThread-1-for-run_tests_on_device(01e08212a27dcc85) Large shell command will be run from file: ( p=org.webrtc.native_test;am instrument -w -e org.chromium.native_test.NativeTestInstrumentationTestRunner.ShardNanoTimeout 900000000000 -e org.chromium.native_test.NativeTestInstrumentationTestRunner.NativeTestActivity "$p".RTCNativeUnitTestActivity -e org.chromium.native_test.NativeTestInstrumentationTestRunner.TestList /data/local/tmp/temp_file-d9bb488c1f966 -e org.chromium.native_test.NativeTestInstrumentationTestRunner.StdoutFile /sdcard/temp_file-e9450bf4febae.gtest_out "$p"/org.chromium.native_test. ... I 84.175s run_tests_on_device(01e08212a27dcc85) /sdcard/temp_file-e9450bf4febae.gtest_out size on device: 14266 I 84.345s run_tests_on_device(01e08212a27dcc85) Logcat saved to https://luci-logdog.appspot.com/v/?s=chromium%2Fandroid%2Fswarming%2Flogcats%2F4500598693181b11%2F%2B%2Flogcat_logcat_-5381509946760856855_20190524T015119-UTC_01e08212a27dcc85 I 84.346s archive Writing text to logdog stream, logcat_logcat_-5381509946760856855_20190524T015119-UTC_01e08212a27dcc85 I 85.156s TimeoutThread-1-for-run_tests_on_device(01e08212a27dcc85) Setting permissions for org.webrtc.native_test. I 87.721s run_tests_on_device(01e08212a27dcc85) >>ScopedMainEntryLogger I 87.721s run_tests_on_device(01e08212a27dcc85) Note: Google Test filter = CommandLineParserTest.GetCommandLineFlagName:CommandLineParserTest.GetCommandLineFlagValue:CommandLineParserTest.IsFlagWellFormed:CommandLineParserTest.IsStandaloneFlag:CommandLineParserTest.ProcessFlags:FrameEditingTest.DeletingEverySecondFrame:FrameEditingTest.EmptySetToCut:FrameEditingTest.InValidInPath:FrameEditingTest.RepeatFrames:FrameEditingTest.ValidInPath:LinearLeastSquares.LinearLeastSquaresNonPerfectSolution:LinearLeastSquares.MatrixIdentityOneObservation:LinearLeastSquares.MatrixManyObservations:LinearLeastSquares.MatrixVectorOneObservation:LinearLeastSquares.ScalarIdentityOneObservation:LinearLeastSquares.ScalarIdentityTwoObservationsOneCall:LinearLeastSquares.ScalarIdentityTwoObservationsTwoCalls:NetworkTesterTest.ServerClient:ReferenceLessVideoAnalysisTest.MatchComputedMetrics:ReferenceLessVideoAnalysisTest.MatchIdenticalFrameClusters:VideoColorAlignerTest.AdjustColorsFrame1x1:VideoColorAlignerTest.AdjustColorsFrame1x1Negative:VideoColorAlignerTest.AdjustColorsFrame2x2:VideoColorAlignerTest.AdjustColorsFrameIdentity:VideoColorAlignerTest.CalculateColorTransformationMatrix:VideoColorAlignerTest.CalculateColorTransformationMatrixIdentity:VideoColorAlignerTest.CalculateColorTransformationMatrixOffset:VideoFileWriterTest.TestParsingFileHeaderY4m:VideoFileWriterTest.TestParsingFileHeaderYuv:VideoFileWriterTest.TestParsingNumberOfFramesY4m:VideoFileWriterTest.TestParsingNumberOfFramesYuv:VideoFileWriterTest.TestPixelContentY4m:VideoFileWriterTest.TestPixelContentYuv:VideoGeometryAlignerTest.CalculateCropRegionArbitrary:VideoGeometryAlignerTest.CalculateCropRegionIdentity:VideoGeometryAlignerTest.CropAndZoomBottom:VideoGeometryAlignerTest.CropAndZoomIdentity:VideoGeometryAlignerTest.CropAndZoomLeft:VideoGeometryAlignerTest.CropAndZoomRight:VideoGeometryAlignerTest.CropAndZoomTop:VideoQualityAnalysisTest.CalculateFrameClustersEmpty:VideoQualityAnalysisTest.CalculateFrameClustersOneOneTwo:VideoQualityAnalysisTest.CalculateFrameClustersOneValue:VideoQualityAnalysisTest.GetMaxRepeatedFramesEmpty:VideoQualityAnalysisTest.GetMaxRepeatedFramesOneOneTwo:VideoQualityAnalysisTest.GetMaxRepeatedFramesOneValue:VideoQualityAnalysisTest.GetMaxSkippedFramesEmpty:VideoQualityAnalysisTest.GetMaxSkippedFramesOneOneTwo:VideoQualityAnalysisTest.GetMaxSkippedFramesOneValue:VideoQualityAnalysisTest.GetTotalNumberOfSkippedFramesEmpty:VideoQualityAnalysisTest.GetTotalNumberOfSkippedFramesOneOneTwo:VideoQualityAnalysisTest.GetTotalNumberOfSkippedFramesOneValue:VideoQualityAnalysisTest.PrintAnalysisResultsEmpty:VideoQualityAnalysisTest.PrintAnalysisResultsOneFrame:VideoQualityAnalysisTest.PrintAnalysisResultsThreeFrames:VideoQualityAnalysisTest.PrintMaxRepeatedAndSkippedFramesDecodeErrorInTest:VideoQualityAnalysisTest.PrintMaxRepeatedAndSkippedFramesSkippedFrames:VideoTemporalAlignerTest.FindMatchingFrameIndicesDuplicateFrames:VideoTemporalAlignerTest.FindMatchingFrameIndicesEmpty:VideoTemporalAlignerTest.FindMatchingFrameIndicesIdentity:VideoTemporalAlignerTest.FindMatchingFrameIndicesLoopAround:VideoTemporalAlignerTest.FindMatchingFrameIndicesStressTest:VideoTemporalAlignerTest.GenerateAlignedReferenceVideo:Y4mFileReaderTest.TestParsingFileHeader:Y4mFileReaderTest.TestParsingNumberOfFrames:Y4mFileReaderTest.TestPixelContent:YuvFileReaderTest.TestParsingFileHeader:YuvFileReaderTest.TestParsingNumberOfFrames:YuvFileReaderTest.TestPixelContent I 87.721s run_tests_on_device(01e08212a27dcc85) [==========] Running 69 tests from 12 test suites. I 87.721s run_tests_on_device(01e08212a27dcc85) [----------] Global test environment set-up. I 87.722s run_tests_on_device(01e08212a27dcc85) [----------] 7 tests from LinearLeastSquares I 87.722s run_tests_on_device(01e08212a27dcc85) [ RUN ] LinearLeastSquares.ScalarIdentityOneObservation I 87.722s run_tests_on_device(01e08212a27dcc85) [ OK ] LinearLeastSquares.ScalarIdentityOneObservation (0 ms) I 87.722s run_tests_on_device(01e08212a27dcc85) [ RUN ] LinearLeastSquares.ScalarIdentityTwoObservationsOneCall I 87.722s run_tests_on_device(01e08212a27dcc85) [ OK ] LinearLeastSquares.ScalarIdentityTwoObservationsOneCall (0 ms) I 87.722s run_tests_on_device(01e08212a27dcc85) [ RUN ] LinearLeastSquares.ScalarIdentityTwoObservationsTwoCalls I 87.722s run_tests_on_device(01e08212a27dcc85) [ OK ] LinearLeastSquares.ScalarIdentityTwoObservationsTwoCalls (0 ms) I 87.722s run_tests_on_device(01e08212a27dcc85) [ RUN ] LinearLeastSquares.MatrixIdentityOneObservation I 87.722s run_tests_on_device(01e08212a27dcc85) [ OK ] LinearLeastSquares.MatrixIdentityOneObservation (0 ms) I 87.722s run_tests_on_device(01e08212a27dcc85) [ RUN ] LinearLeastSquares.MatrixManyObservations I 87.722s run_tests_on_device(01e08212a27dcc85) [ OK ] LinearLeastSquares.MatrixManyObservations (0 ms) I 87.722s run_tests_on_device(01e08212a27dcc85) [ RUN ] LinearLeastSquares.MatrixVectorOneObservation I 87.722s run_tests_on_device(01e08212a27dcc85) [ OK ] LinearLeastSquares.MatrixVectorOneObservation (0 ms) I 87.722s run_tests_on_device(01e08212a27dcc85) [ RUN ] LinearLeastSquares.LinearLeastSquaresNonPerfectSolution I 87.723s run_tests_on_device(01e08212a27dcc85) [ OK ] LinearLeastSquares.LinearLeastSquaresNonPerfectSolution (0 ms) I 87.723s run_tests_on_device(01e08212a27dcc85) [----------] 7 tests from LinearLeastSquares (1 ms total) I 87.723s run_tests_on_device(01e08212a27dcc85) I 87.723s run_tests_on_device(01e08212a27dcc85) [----------] 2 tests from ReferenceLessVideoAnalysisTest I 87.723s run_tests_on_device(01e08212a27dcc85) [ RUN ] ReferenceLessVideoAnalysisTest.MatchComputedMetrics I 87.723s run_tests_on_device(01e08212a27dcc85) [ OK ] ReferenceLessVideoAnalysisTest.MatchComputedMetrics (3438 ms) I 87.723s run_tests_on_device(01e08212a27dcc85) [ RUN ] ReferenceLessVideoAnalysisTest.MatchIdenticalFrameClusters I 87.723s run_tests_on_device(01e08212a27dcc85) [ OK ] ReferenceLessVideoAnalysisTest.MatchIdenticalFrameClusters (3396 ms) I 87.723s run_tests_on_device(01e08212a27dcc85) [----------] 2 tests from ReferenceLessVideoAnalysisTest (6836 ms total) I 87.723s run_tests_on_device(01e08212a27dcc85) I 87.723s run_tests_on_device(01e08212a27dcc85) [----------] 7 tests from VideoColorAlignerTest I 87.723s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoColorAlignerTest.AdjustColorsFrameIdentity I 87.723s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoColorAlignerTest.AdjustColorsFrameIdentity (326 ms) I 87.723s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoColorAlignerTest.AdjustColorsFrame1x1 I 87.724s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoColorAlignerTest.AdjustColorsFrame1x1 (139 ms) I 87.724s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoColorAlignerTest.AdjustColorsFrame1x1Negative I 87.724s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoColorAlignerTest.AdjustColorsFrame1x1Negative (176 ms) I 87.724s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoColorAlignerTest.AdjustColorsFrame2x2 I 87.724s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoColorAlignerTest.AdjustColorsFrame2x2 (175 ms) I 87.724s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoColorAlignerTest.CalculateColorTransformationMatrixIdentity I 87.724s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoColorAlignerTest.CalculateColorTransformationMatrixIdentity (670 ms) I 87.724s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoColorAlignerTest.CalculateColorTransformationMatrixOffset I 87.724s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoColorAlignerTest.CalculateColorTransformationMatrixOffset (181 ms) I 87.724s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoColorAlignerTest.CalculateColorTransformationMatrix I 87.724s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoColorAlignerTest.CalculateColorTransformationMatrix (846 ms) I 87.724s run_tests_on_device(01e08212a27dcc85) [----------] 7 tests from VideoColorAlignerTest (2527 ms total) I 87.724s run_tests_on_device(01e08212a27dcc85) I 87.724s run_tests_on_device(01e08212a27dcc85) [----------] 7 tests from VideoGeometryAlignerTest I 87.724s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoGeometryAlignerTest.CropAndZoomIdentity I 87.725s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoGeometryAlignerTest.CropAndZoomIdentity (174 ms) I 87.725s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoGeometryAlignerTest.CropAndZoomLeft I 87.725s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoGeometryAlignerTest.CropAndZoomLeft (180 ms) I 87.725s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoGeometryAlignerTest.CropAndZoomTop I 87.725s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoGeometryAlignerTest.CropAndZoomTop (172 ms) I 87.725s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoGeometryAlignerTest.CropAndZoomRight I 87.725s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoGeometryAlignerTest.CropAndZoomRight (52 ms) I 87.725s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoGeometryAlignerTest.CropAndZoomBottom I 87.725s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoGeometryAlignerTest.CropAndZoomBottom (46 ms) I 87.725s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoGeometryAlignerTest.CalculateCropRegionIdentity I 87.725s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoGeometryAlignerTest.CalculateCropRegionIdentity (19 ms) I 87.725s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoGeometryAlignerTest.CalculateCropRegionArbitrary I 87.725s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoGeometryAlignerTest.CalculateCropRegionArbitrary (130 ms) I 87.725s run_tests_on_device(01e08212a27dcc85) [----------] 7 tests from VideoGeometryAlignerTest (784 ms total) I 87.726s run_tests_on_device(01e08212a27dcc85) I 87.726s run_tests_on_device(01e08212a27dcc85) [----------] 17 tests from VideoQualityAnalysisTest I 87.726s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoQualityAnalysisTest.PrintAnalysisResultsEmpty I 87.726s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoQualityAnalysisTest.PrintAnalysisResultsEmpty (6 ms) I 87.726s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoQualityAnalysisTest.PrintAnalysisResultsOneFrame I 87.726s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoQualityAnalysisTest.PrintAnalysisResultsOneFrame (2 ms) I 87.726s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoQualityAnalysisTest.PrintAnalysisResultsThreeFrames I 87.726s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoQualityAnalysisTest.PrintAnalysisResultsThreeFrames (1 ms) I 87.726s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoQualityAnalysisTest.PrintMaxRepeatedAndSkippedFramesSkippedFrames I 87.726s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoQualityAnalysisTest.PrintMaxRepeatedAndSkippedFramesSkippedFrames (5 ms) I 87.726s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoQualityAnalysisTest.PrintMaxRepeatedAndSkippedFramesDecodeErrorInTest I 87.726s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoQualityAnalysisTest.PrintMaxRepeatedAndSkippedFramesDecodeErrorInTest (5 ms) I 87.726s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoQualityAnalysisTest.CalculateFrameClustersOneValue I 87.726s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoQualityAnalysisTest.CalculateFrameClustersOneValue (0 ms) I 87.726s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoQualityAnalysisTest.GetMaxRepeatedFramesOneValue I 87.726s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoQualityAnalysisTest.GetMaxRepeatedFramesOneValue (4 ms) I 87.726s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoQualityAnalysisTest.GetMaxSkippedFramesOneValue I 87.726s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoQualityAnalysisTest.GetMaxSkippedFramesOneValue (2 ms) I 87.726s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoQualityAnalysisTest.GetTotalNumberOfSkippedFramesOneValue I 87.726s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoQualityAnalysisTest.GetTotalNumberOfSkippedFramesOneValue (1 ms) I 87.726s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoQualityAnalysisTest.CalculateFrameClustersOneOneTwo I 87.726s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoQualityAnalysisTest.CalculateFrameClustersOneOneTwo (1 ms) I 87.726s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoQualityAnalysisTest.GetMaxRepeatedFramesOneOneTwo I 87.726s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoQualityAnalysisTest.GetMaxRepeatedFramesOneOneTwo (5 ms) I 87.726s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoQualityAnalysisTest.GetMaxSkippedFramesOneOneTwo I 87.726s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoQualityAnalysisTest.GetMaxSkippedFramesOneOneTwo (1 ms) I 87.726s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoQualityAnalysisTest.GetTotalNumberOfSkippedFramesOneOneTwo I 87.726s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoQualityAnalysisTest.GetTotalNumberOfSkippedFramesOneOneTwo (1 ms) I 87.726s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoQualityAnalysisTest.CalculateFrameClustersEmpty I 87.726s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoQualityAnalysisTest.CalculateFrameClustersEmpty (0 ms) I 87.726s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoQualityAnalysisTest.GetMaxRepeatedFramesEmpty I 87.726s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoQualityAnalysisTest.GetMaxRepeatedFramesEmpty (5 ms) I 87.726s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoQualityAnalysisTest.GetMaxSkippedFramesEmpty I 87.726s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoQualityAnalysisTest.GetMaxSkippedFramesEmpty (2 ms) I 87.726s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoQualityAnalysisTest.GetTotalNumberOfSkippedFramesEmpty I 87.726s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoQualityAnalysisTest.GetTotalNumberOfSkippedFramesEmpty (1 ms) I 87.726s run_tests_on_device(01e08212a27dcc85) [----------] 17 tests from VideoQualityAnalysisTest (50 ms total) I 87.726s run_tests_on_device(01e08212a27dcc85) I 87.726s run_tests_on_device(01e08212a27dcc85) [----------] 6 tests from VideoTemporalAlignerTest I 87.726s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoTemporalAlignerTest.FindMatchingFrameIndicesEmpty I 87.726s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoTemporalAlignerTest.FindMatchingFrameIndicesEmpty (97 ms) I 87.726s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoTemporalAlignerTest.FindMatchingFrameIndicesIdentity I 87.726s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoTemporalAlignerTest.FindMatchingFrameIndicesIdentity (611 ms) I 87.726s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoTemporalAlignerTest.FindMatchingFrameIndicesDuplicateFrames I 87.726s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoTemporalAlignerTest.FindMatchingFrameIndicesDuplicateFrames (437 ms) I 87.726s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoTemporalAlignerTest.FindMatchingFrameIndicesLoopAround I 87.726s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoTemporalAlignerTest.FindMatchingFrameIndicesLoopAround (934 ms) I 87.726s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoTemporalAlignerTest.FindMatchingFrameIndicesStressTest I 87.727s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoTemporalAlignerTest.FindMatchingFrameIndicesStressTest (464 ms) I 87.727s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoTemporalAlignerTest.GenerateAlignedReferenceVideo I 87.727s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoTemporalAlignerTest.GenerateAlignedReferenceVideo (505 ms) I 87.727s run_tests_on_device(01e08212a27dcc85) [----------] 6 tests from VideoTemporalAlignerTest (3059 ms total) I 87.727s run_tests_on_device(01e08212a27dcc85) I 87.727s run_tests_on_device(01e08212a27dcc85) [----------] 5 tests from FrameEditingTest I 87.727s run_tests_on_device(01e08212a27dcc85) [ RUN ] FrameEditingTest.ValidInPath I 87.727s run_tests_on_device(01e08212a27dcc85) Done editing! I 87.727s run_tests_on_device(01e08212a27dcc85) [ OK ] FrameEditingTest.ValidInPath (5948 ms) I 87.727s run_tests_on_device(01e08212a27dcc85) [ RUN ] FrameEditingTest.EmptySetToCut I 87.727s run_tests_on_device(01e08212a27dcc85) The set of frames to cut is empty! (l < f) I 87.727s run_tests_on_device(01e08212a27dcc85) [ OK ] FrameEditingTest.EmptySetToCut (19 ms) I 87.727s run_tests_on_device(01e08212a27dcc85) [ RUN ] FrameEditingTest.InValidInPath I 87.727s run_tests_on_device(01e08212a27dcc85) Could not read input file: PATH/THAT/DOES/NOT/EXIST. I 87.727s run_tests_on_device(01e08212a27dcc85) [ OK ] FrameEditingTest.InValidInPath (5 ms) I 87.727s run_tests_on_device(01e08212a27dcc85) [ RUN ] FrameEditingTest.DeletingEverySecondFrame I 87.727s run_tests_on_device(01e08212a27dcc85) Done editing! I 87.727s run_tests_on_device(01e08212a27dcc85) [ OK ] FrameEditingTest.DeletingEverySecondFrame (5940 ms) I 87.727s run_tests_on_device(01e08212a27dcc85) [ RUN ] FrameEditingTest.RepeatFrames I 87.727s run_tests_on_device(01e08212a27dcc85) Done editing! I 87.727s run_tests_on_device(01e08212a27dcc85) [ OK ] FrameEditingTest.RepeatFrames (4588 ms) I 87.727s run_tests_on_device(01e08212a27dcc85) [----------] 5 tests from FrameEditingTest (16506 ms total) I 87.727s run_tests_on_device(01e08212a27dcc85) I 87.727s run_tests_on_device(01e08212a27dcc85) [----------] 5 tests from CommandLineParserTest I 87.727s run_tests_on_device(01e08212a27dcc85) [ RUN ] CommandLineParserTest.ProcessFlags I 87.727s run_tests_on_device(01e08212a27dcc85) [ OK ] CommandLineParserTest.ProcessFlags (0 ms) I 87.727s run_tests_on_device(01e08212a27dcc85) [ RUN ] CommandLineParserTest.IsStandaloneFlag I 87.727s run_tests_on_device(01e08212a27dcc85) [ OK ] CommandLineParserTest.IsStandaloneFlag (0 ms) I 87.727s run_tests_on_device(01e08212a27dcc85) [ RUN ] CommandLineParserTest.IsFlagWellFormed I 87.727s run_tests_on_device(01e08212a27dcc85) [ OK ] CommandLineParserTest.IsFlagWellFormed (0 ms) I 87.727s run_tests_on_device(01e08212a27dcc85) [ RUN ] CommandLineParserTest.GetCommandLineFlagName I 87.727s run_tests_on_device(01e08212a27dcc85) [ OK ] CommandLineParserTest.GetCommandLineFlagName (0 ms) I 87.727s run_tests_on_device(01e08212a27dcc85) [ RUN ] CommandLineParserTest.GetCommandLineFlagValue I 87.727s run_tests_on_device(01e08212a27dcc85) [ OK ] CommandLineParserTest.GetCommandLineFlagValue (0 ms) I 87.727s run_tests_on_device(01e08212a27dcc85) [----------] 5 tests from CommandLineParserTest (1 ms total) I 87.727s run_tests_on_device(01e08212a27dcc85) I 87.727s run_tests_on_device(01e08212a27dcc85) [----------] 3 tests from Y4mFileReaderTest I 87.727s run_tests_on_device(01e08212a27dcc85) [ RUN ] Y4mFileReaderTest.TestParsingFileHeader I 87.727s run_tests_on_device(01e08212a27dcc85) [ OK ] Y4mFileReaderTest.TestParsingFileHeader (1 ms) I 87.727s run_tests_on_device(01e08212a27dcc85) [ RUN ] Y4mFileReaderTest.TestParsingNumberOfFrames I 87.727s run_tests_on_device(01e08212a27dcc85) [ OK ] Y4mFileReaderTest.TestParsingNumberOfFrames (1 ms) I 87.727s run_tests_on_device(01e08212a27dcc85) [ RUN ] Y4mFileReaderTest.TestPixelContent I 87.727s run_tests_on_device(01e08212a27dcc85) [ OK ] Y4mFileReaderTest.TestPixelContent (1 ms) I 87.727s run_tests_on_device(01e08212a27dcc85) [----------] 3 tests from Y4mFileReaderTest (4 ms total) I 87.727s run_tests_on_device(01e08212a27dcc85) I 87.727s run_tests_on_device(01e08212a27dcc85) [----------] 3 tests from YuvFileReaderTest I 87.727s run_tests_on_device(01e08212a27dcc85) [ RUN ] YuvFileReaderTest.TestParsingFileHeader I 87.727s run_tests_on_device(01e08212a27dcc85) [ OK ] YuvFileReaderTest.TestParsingFileHeader (1 ms) I 87.727s run_tests_on_device(01e08212a27dcc85) [ RUN ] YuvFileReaderTest.TestParsingNumberOfFrames I 87.727s run_tests_on_device(01e08212a27dcc85) [ OK ] YuvFileReaderTest.TestParsingNumberOfFrames (1 ms) I 87.727s run_tests_on_device(01e08212a27dcc85) [ RUN ] YuvFileReaderTest.TestPixelContent I 87.727s run_tests_on_device(01e08212a27dcc85) [ OK ] YuvFileReaderTest.TestPixelContent (0 ms) I 87.727s run_tests_on_device(01e08212a27dcc85) [----------] 3 tests from YuvFileReaderTest (2 ms total) I 87.728s run_tests_on_device(01e08212a27dcc85) I 87.728s run_tests_on_device(01e08212a27dcc85) [----------] 6 tests from VideoFileWriterTest I 87.728s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoFileWriterTest.TestParsingFileHeaderY4m I 87.728s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoFileWriterTest.TestParsingFileHeaderY4m (2 ms) I 87.728s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoFileWriterTest.TestParsingFileHeaderYuv I 87.728s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoFileWriterTest.TestParsingFileHeaderYuv (2 ms) I 87.728s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoFileWriterTest.TestParsingNumberOfFramesY4m I 87.728s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoFileWriterTest.TestParsingNumberOfFramesY4m (2 ms) I 87.728s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoFileWriterTest.TestParsingNumberOfFramesYuv I 87.728s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoFileWriterTest.TestParsingNumberOfFramesYuv (2 ms) I 87.728s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoFileWriterTest.TestPixelContentY4m I 87.728s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoFileWriterTest.TestPixelContentY4m (2 ms) I 87.728s run_tests_on_device(01e08212a27dcc85) [ RUN ] VideoFileWriterTest.TestPixelContentYuv I 87.728s run_tests_on_device(01e08212a27dcc85) [ OK ] VideoFileWriterTest.TestPixelContentYuv (2 ms) I 87.728s run_tests_on_device(01e08212a27dcc85) [----------] 6 tests from VideoFileWriterTest (12 ms total) I 87.728s run_tests_on_device(01e08212a27dcc85) I 87.728s run_tests_on_device(01e08212a27dcc85) [----------] 1 test from NetworkTesterTest I 87.728s run_tests_on_device(01e08212a27dcc85) [ RUN ] NetworkTesterTest.ServerClient I 87.728s run_tests_on_device(01e08212a27dcc85) [ OK ] NetworkTesterTest.ServerClient (415 ms) I 87.728s run_tests_on_device(01e08212a27dcc85) [----------] 1 test from NetworkTesterTest (416 ms total) I 87.728s run_tests_on_device(01e08212a27dcc85) I 87.728s run_tests_on_device(01e08212a27dcc85) [----------] Global test environment tear-down I 87.728s run_tests_on_device(01e08212a27dcc85) [==========] 69 tests from 12 test suites ran. (30208 ms total) I 87.728s run_tests_on_device(01e08212a27dcc85) [ PASSED ] 69 tests. I 87.728s run_tests_on_device(01e08212a27dcc85) <<ScopedMainEntryLogger I 87.730s run_tests_on_device(01e08212a27dcc85) Finished running tests on this device. I 87.767s Main FINISHED TRY #1/3 I 87.767s Main All tests completed. C 87.767s Main ******************************************************************************** C 87.767s Main Summary C 87.767s Main ******************************************************************************** C 87.768s Main [==========] 69 tests ran. C 87.768s Main [ PASSED ] 69 tests. C 87.768s Main ******************************************************************************** I 87.769s tear_down_device(01e08212a27dcc85) Wrote device cache: /b/swarming/w/ir/out/Android64_M_Nexus5X/device_cache_01e08212a27dcc85.json I 87.990s Main Generated json results file at /b/swarming/w/itxaf2oZ/tmpLO8Grj I 87.990s Main Finishing archiving output. [W2019-05-24T01:51:54.662337Z 618 0 butler.go:240] Butler Context was cancelled. Initiating shutdown. {"error":"context canceled"} INFO:devil.utils.timeout_retry:condition 'logdog_stopped' not met [E2019-05-24T01:51:54.693348Z 618 0 main.go:205] Butler terminated with error. {"error":"context canceled"} [E2019-05-24T01:51:54.693384Z 618 0 main.go:233] Failed to serve. original error: context canceled [I2019-05-24T01:51:54.693445Z 618 0 main.go:349] Terminating. {"returnCode":250} INFO:devil.utils.timeout_retry:condition 'logdog_stopped' met 2019-05-24 01:15:24,673 - root: [DEBUG] Contents of task_output_dir: ['/b/s/w/ir/tmp/t/tmptxU7ZD/4501aefcbb50a610'] 2019-05-24 01:15:24,673 - root: [DEBUG] Found shard_json_files: ['/b/s/w/ir/tmp/t/tmptxU7ZD/4501aefcbb50a610/output.json'] 2019-05-24 01:15:24,673 - root: [INFO] merge_cmd: /b/s/w/ir/cache/vpython/534772/bin/python /b/s/w/ir/cache/builder/src/testing/merge_scripts/standard_gtest_merge.py --summary-json /b/s/w/ir/tmp/t/tmpF_sdJg.json --task-output-dir /b/s/w/ir/tmp/t/tmptxU7ZD -o /b/s/w/ir/tmp/t/tmp1_F8Rb.json /b/s/w/ir/tmp/t/tmptxU7ZD/4501aefcbb50a610/output.json Running ['/b/s/w/ir/cache/vpython/534772/bin/python', '/b/s/w/ir/cache/builder/src/testing/merge_scripts/standard_gtest_merge.py', '--summary-json', '/b/s/w/ir/tmp/t/tmpF_sdJg.json', '--task-output-dir', '/b/s/w/ir/tmp/t/tmptxU7ZD', '-o', '/b/s/w/ir/tmp/t/tmp1_F8Rb.json', '/b/s/w/ir/tmp/t/tmptxU7ZD/4501aefcbb50a610/output.json'] in None (env: None) Command ['/b/s/w/ir/cache/vpython/534772/bin/python', '/b/s/w/ir/cache/builder/src/testing/merge_scripts/standard_gtest_merge.py', '--summary-json', '/b/s/w/ir/tmp/t/tmpF_sdJg.json', '--task-output-dir', '/b/s/w/ir/tmp/t/tmptxU7ZD', '-o', '/b/s/w/ir/tmp/t/tmp1_F8Rb.json', '/b/s/w/ir/tmp/t/tmptxU7ZD/4501aefcbb50a610/output.json'] returned exit code 0