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-23 07:38:31,568 - root: [DEBUG] Using task_output_dir: '/b/s/w/ir/tmp/t/tmp4hv8Pg' 2019-05-23 07:38:31,569 - root: [WARNING] task_output_dir '/b/s/w/ir/tmp/t/tmp4hv8Pg' already exists! 2019-05-23 07:38:31,569 - root: [WARNING] task_output_dir existing content: [] 2019-05-23 07:38:31,569 - 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/tmpiPPupm.json -output-dir /b/s/w/ir/tmp/t/tmp4hv8Pg -task-summary-json /b/s/w/ir/tmp/t/tmpTLD0qb.json [D2019-05-23T07:38:31.579082-07:00 32635 0 auth.go:1265] Minting a new token {"key":"luci_ctx/b8c8e562bfb7c4af5d7f856c76a522413c57018a0782fe59511d2f282ad4a991", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-05-23T07:38:31.579170-07:00 32635 0 luci_ctx.go:138] POST http://127.0.0.1:45627/rpc/LuciLocalAuthService.GetOAuthToken {"key":"luci_ctx/b8c8e562bfb7c4af5d7f856c76a522413c57018a0782fe59511d2f282ad4a991", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-05-23T07:38:31.581128-07:00 32635 0 auth.go:1222] Token expires in 3m17.418922732s {"key":"luci_ctx/b8c8e562bfb7c4af5d7f856c76a522413c57018a0782fe59511d2f282ad4a991", "scopes":"https://www.googleapis.com/auth/userinfo.email"} 44fde42b38236710: 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/stats/rtc_stats_unittests__test_runner_script.runtime_deps --suite rtc_stats_unittests -v --logcat-output-file /b/swarming/w/iolRTjGl/logcats --store-tombstones --test-launcher-summary-output=/b/swarming/w/iolRTjGl/output.json I 0.007s Main condition '<lambda>' met I 0.008s Main condition '<lambda>' met I 3.190s TimeoutThread-1-for-prepare_device(01e7f066903cb369) condition 'sd_card_ready' met (0.0s) I 3.776s TimeoutThread-1-for-prepare_device(01e7f066903cb369) condition 'pm_ready' met (0.6s) I 3.829s TimeoutThread-1-for-prepare_device(01e7f066903cb369) condition 'boot_completed' met (0.7s) I 12.877s TimeoutThread-1-for-individual_device_set_up(01e7f066903cb369) Setting permissions for org.webrtc.native_test. I 15.658s calculate_device_checksums condition '<lambda>' met (0.1s) I 18.181s list_tests(01e7f066903cb369) flags: I 18.181s list_tests(01e7f066903cb369) --gtest_list_tests I 18.197s TimeoutThread-1-for-list_tests(01e7f066903cb369) 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-fc8eacb22dbb.gtest_out -e org.chromium.native_test.NativeTest.CommandLineFlags --gtest_list_tests "$p"/org.chromium.native_test.NativeTestInstrumentationTestRunner )>/d ... I 19.818s list_tests(01e7f066903cb369) /sdcard/temp_file-fc8eacb22dbb.gtest_out size on device: 258 I 19.890s Main Using external sharding settings. This is shard 0/1 I 19.890s Main STARTING TRY #1/3 I 19.891s Main Will run 10 tests on 1 devices: 01e7f066903cb369 W 19.957s run_tests_on_device(01e7f066903cb369) No tombstones to clear. I 23.273s run_tests_on_device(01e7f066903cb369) flags: I 23.273s run_tests_on_device(01e7f066903cb369) Getting logdog client. I 23.394s TimeoutThread-1-for-run_tests_on_device(01e7f066903cb369) Large shell command will be run from file: ( p=org.webrtc.native_test;am instrument -w -e org.chromium.native_test.NativeTestInstrumentationTestRunner.ShardNanoTimeout 120000000000 -e org.chromium.native_test.NativeTestInstrumentationTestRunner.NativeTestActivity "$p".RTCNativeUnitTestActivity -e org.chromium.native_test.NativeTestInstrumentationTestRunner.TestList /data/local/tmp/temp_file-92aa5c8f756c4 -e org.chromium.native_test.NativeTestInstrumentationTestRunner.StdoutFile /sdcard/temp_file-b013b9b47d9a6.gtest_out "$p"/org.chromium.native_test. ... I 24.849s run_tests_on_device(01e7f066903cb369) /sdcard/temp_file-b013b9b47d9a6.gtest_out size on device: 2053 I 25.137s run_tests_on_device(01e7f066903cb369) Logcat saved to https://luci-logdog.appspot.com/v/?s=chromium%2Fandroid%2Fswarming%2Flogcats%2F44fda63f09e16d11%2F%2B%2Flogcat_logcat_3319692404600788449_20190523T131544-UTC_01e7f066903cb369 I 25.139s archive Writing text to logdog stream, logcat_logcat_3319692404600788449_20190523T131544-UTC_01e7f066903cb369 I 25.761s TimeoutThread-1-for-run_tests_on_device(01e7f066903cb369) Setting permissions for org.webrtc.native_test. I 28.410s run_tests_on_device(01e7f066903cb369) >>ScopedMainEntryLogger I 28.411s run_tests_on_device(01e7f066903cb369) Note: Google Test filter = RTCStatsReport.AddAndGetStats:RTCStatsReport.StatsOrder:RTCStatsReport.Take:RTCStatsReport.TakeMembersFrom:RTCStatsTest.EqualityOperator:RTCStatsTest.IsStandardized:RTCStatsTest.NonStandardGroupId:RTCStatsTest.RTCStatsAndMembers:RTCStatsTest.RTCStatsGrandChild:RTCStatsTest.RTCStatsPrintsValidJson I 28.411s run_tests_on_device(01e7f066903cb369) [==========] Running 10 tests from 2 test suites. I 28.411s run_tests_on_device(01e7f066903cb369) [----------] Global test environment set-up. I 28.411s run_tests_on_device(01e7f066903cb369) [----------] 4 tests from RTCStatsReport I 28.411s run_tests_on_device(01e7f066903cb369) [ RUN ] RTCStatsReport.AddAndGetStats I 28.411s run_tests_on_device(01e7f066903cb369) [ OK ] RTCStatsReport.AddAndGetStats (0 ms) I 28.411s run_tests_on_device(01e7f066903cb369) [ RUN ] RTCStatsReport.StatsOrder I 28.411s run_tests_on_device(01e7f066903cb369) [ OK ] RTCStatsReport.StatsOrder (0 ms) I 28.411s run_tests_on_device(01e7f066903cb369) [ RUN ] RTCStatsReport.Take I 28.411s run_tests_on_device(01e7f066903cb369) [ OK ] RTCStatsReport.Take (0 ms) I 28.411s run_tests_on_device(01e7f066903cb369) [ RUN ] RTCStatsReport.TakeMembersFrom I 28.412s run_tests_on_device(01e7f066903cb369) [ OK ] RTCStatsReport.TakeMembersFrom (0 ms) I 28.412s run_tests_on_device(01e7f066903cb369) [----------] 4 tests from RTCStatsReport (1 ms total) I 28.412s run_tests_on_device(01e7f066903cb369) I 28.412s run_tests_on_device(01e7f066903cb369) [----------] 6 tests from RTCStatsTest I 28.412s run_tests_on_device(01e7f066903cb369) [ RUN ] RTCStatsTest.RTCStatsAndMembers I 28.412s run_tests_on_device(01e7f066903cb369) [ OK ] RTCStatsTest.RTCStatsAndMembers (0 ms) I 28.412s run_tests_on_device(01e7f066903cb369) [ RUN ] RTCStatsTest.EqualityOperator I 28.412s run_tests_on_device(01e7f066903cb369) [ OK ] RTCStatsTest.EqualityOperator (1 ms) I 28.412s run_tests_on_device(01e7f066903cb369) [ RUN ] RTCStatsTest.RTCStatsGrandChild I 28.412s run_tests_on_device(01e7f066903cb369) [ OK ] RTCStatsTest.RTCStatsGrandChild (0 ms) I 28.412s run_tests_on_device(01e7f066903cb369) [ RUN ] RTCStatsTest.RTCStatsPrintsValidJson I 28.412s run_tests_on_device(01e7f066903cb369) {"type":"test-stats","id":"statsId","timestamp":42,"mBool":true,"mInt32":123,"mInt64":1.234567890123457e+18,"mDouble":123.4567890123457,"mString":"123","mSequenceBool":[],"mSequenceInt32":[1],"mSequenceInt64":[-1.234567890123457e+18,1,1.234567890123457e+18],"mSequenceDouble":[123.4567890123457,1234567890123.457],"mSequenceString":["four"]} I 28.413s run_tests_on_device(01e7f066903cb369) [ OK ] RTCStatsTest.RTCStatsPrintsValidJson (0 ms) I 28.413s run_tests_on_device(01e7f066903cb369) [ RUN ] RTCStatsTest.IsStandardized I 28.413s run_tests_on_device(01e7f066903cb369) [ OK ] RTCStatsTest.IsStandardized (0 ms) I 28.413s run_tests_on_device(01e7f066903cb369) [ RUN ] RTCStatsTest.NonStandardGroupId I 28.413s run_tests_on_device(01e7f066903cb369) [ OK ] RTCStatsTest.NonStandardGroupId (0 ms) I 28.413s run_tests_on_device(01e7f066903cb369) [----------] 6 tests from RTCStatsTest (2 ms total) I 28.413s run_tests_on_device(01e7f066903cb369) I 28.413s run_tests_on_device(01e7f066903cb369) [----------] Global test environment tear-down I 28.413s run_tests_on_device(01e7f066903cb369) [==========] 10 tests from 2 test suites ran. (4 ms total) I 28.413s run_tests_on_device(01e7f066903cb369) [ PASSED ] 10 tests. I 28.413s run_tests_on_device(01e7f066903cb369) <<ScopedMainEntryLogger I 28.416s run_tests_on_device(01e7f066903cb369) Finished running tests on this device. I 28.424s Main FINISHED TRY #1/3 I 28.425s Main All tests completed. C 28.425s Main ******************************************************************************** C 28.425s Main Summary C 28.425s Main ******************************************************************************** C 28.426s Main [==========] 10 tests ran. C 28.426s Main [ PASSED ] 10 tests. C 28.426s Main ******************************************************************************** I 28.428s tear_down_device(01e7f066903cb369) Wrote device cache: /b/swarming/w/ir/out/Android32_M_Nexus5X_dbg/device_cache_01e7f066903cb369.json I 28.596s Main Generated json results file at /b/swarming/w/itVqrFXp/tmpkSMDb4 I 28.596s Main Finishing archiving output. [W2019-05-23T13:15:49.441451Z 32093 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-23T13:15:49.485833Z 32093 0 main.go:205] Butler terminated with error. {"error":"context canceled"} [E2019-05-23T13:15:49.485963Z 32093 0 main.go:233] Failed to serve. original error: context canceled [I2019-05-23T13:15:49.486179Z 32093 0 main.go:349] Terminating. {"returnCode":250} INFO:devil.utils.timeout_retry:condition 'logdog_stopped' met 2019-05-23 07:38:31,925 - root: [DEBUG] Contents of task_output_dir: ['/b/s/w/ir/tmp/t/tmp4hv8Pg/44fde42b38236710'] 2019-05-23 07:38:31,925 - root: [DEBUG] Found shard_json_files: ['/b/s/w/ir/tmp/t/tmp4hv8Pg/44fde42b38236710/output.json'] 2019-05-23 07:38:31,926 - root: [INFO] merge_cmd: /b/s/w/ir/cache/vpython/f6423e/bin/python /b/s/w/ir/cache/builder/src/testing/merge_scripts/standard_gtest_merge.py --summary-json /b/s/w/ir/tmp/t/tmpTLD0qb.json --task-output-dir /b/s/w/ir/tmp/t/tmp4hv8Pg -o /b/s/w/ir/tmp/t/tmpD_PAH5.json /b/s/w/ir/tmp/t/tmp4hv8Pg/44fde42b38236710/output.json Running ['/b/s/w/ir/cache/vpython/f6423e/bin/python', '/b/s/w/ir/cache/builder/src/testing/merge_scripts/standard_gtest_merge.py', '--summary-json', '/b/s/w/ir/tmp/t/tmpTLD0qb.json', '--task-output-dir', '/b/s/w/ir/tmp/t/tmp4hv8Pg', '-o', '/b/s/w/ir/tmp/t/tmpD_PAH5.json', '/b/s/w/ir/tmp/t/tmp4hv8Pg/44fde42b38236710/output.json'] in None (env: None) Command ['/b/s/w/ir/cache/vpython/f6423e/bin/python', '/b/s/w/ir/cache/builder/src/testing/merge_scripts/standard_gtest_merge.py', '--summary-json', '/b/s/w/ir/tmp/t/tmpTLD0qb.json', '--task-output-dir', '/b/s/w/ir/tmp/t/tmp4hv8Pg', '-o', '/b/s/w/ir/tmp/t/tmpD_PAH5.json', '/b/s/w/ir/tmp/t/tmp4hv8Pg/44fde42b38236710/output.json'] returned exit code 0