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 00:11:35,333 - root: [DEBUG] Using task_output_dir: '/b/s/w/ir/tmp/t/tmpGxLHxS' 2019-05-23 00:11:35,334 - root: [WARNING] task_output_dir '/b/s/w/ir/tmp/t/tmpGxLHxS' already exists! 2019-05-23 00:11:35,334 - root: [WARNING] task_output_dir existing content: [] 2019-05-23 00:11:35,334 - 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/tmpfJWFQ9.json -output-dir /b/s/w/ir/tmp/t/tmpGxLHxS -task-summary-json /b/s/w/ir/tmp/t/tmpTXPLkF.json [D2019-05-23T00:11:35.344571-07:00 15387 0 auth.go:1265] Minting a new token {"key":"luci_ctx/9434a8e4a393fd13022af7cf782ba4d06668428bc095ae3ed721def9fe9ae55f", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-05-23T00:11:35.344646-07:00 15387 0 luci_ctx.go:138] POST http://127.0.0.1:42963/rpc/LuciLocalAuthService.GetOAuthToken {"key":"luci_ctx/9434a8e4a393fd13022af7cf782ba4d06668428bc095ae3ed721def9fe9ae55f", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-05-23T00:11:35.346500-07:00 15387 0 auth.go:1222] Token expires in 54m9.653547466s {"key":"luci_ctx/9434a8e4a393fd13022af7cf782ba4d06668428bc095ae3ed721def9fe9ae55f", "scopes":"https://www.googleapis.com/auth/userinfo.email"} 44fc5854ab6a8310: 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/modules/audio_coding/audio_decoder_unittests__test_runner_script.runtime_deps --suite audio_decoder_unittests --shard-timeout=900 -v --logcat-output-file /b/swarming/w/iojHFXBo/logcats --store-tombstones --test-launcher-summary-output=/b/swarming/w/iojHFXBo/output.json I 0.007s Main condition '<lambda>' met I 0.008s Main condition '<lambda>' met I 3.198s TimeoutThread-1-for-prepare_device(01e207b2a28dd48f) condition 'sd_card_ready' met (0.0s) I 3.832s TimeoutThread-1-for-prepare_device(01e207b2a28dd48f) condition 'pm_ready' met (0.7s) I 3.899s TimeoutThread-1-for-prepare_device(01e207b2a28dd48f) condition 'boot_completed' met (0.7s) I 11.905s TimeoutThread-1-for-individual_device_set_up(01e207b2a28dd48f) Setting permissions for org.webrtc.native_test. I 14.927s calculate_device_checksums condition '<lambda>' met (0.3s) I 16.712s list_tests(01e207b2a28dd48f) flags: I 16.712s list_tests(01e207b2a28dd48f) --gtest_list_tests I 16.734s TimeoutThread-1-for-list_tests(01e207b2a28dd48f) 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-3cf97e1957526.gtest_out -e org.chromium.native_test.NativeTest.CommandLineFlags --gtest_list_tests "$p"/org.chromium.native_test.NativeTestInstrumentationTestRunner )>/ ... I 18.354s list_tests(01e207b2a28dd48f) /sdcard/temp_file-3cf97e1957526.gtest_out size on device: 689 I 18.483s Main Using external sharding settings. This is shard 0/1 I 18.483s Main STARTING TRY #1/3 I 18.483s Main Will run 22 tests on 1 devices: 01e207b2a28dd48f W 18.586s run_tests_on_device(01e207b2a28dd48f) No tombstones to clear. I 24.531s run_tests_on_device(01e207b2a28dd48f) flags: I 24.531s run_tests_on_device(01e207b2a28dd48f) Getting logdog client. I 24.651s TimeoutThread-1-for-run_tests_on_device(01e207b2a28dd48f) 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-c5e82664c8f9e -e org.chromium.native_test.NativeTestInstrumentationTestRunner.StdoutFile /sdcard/temp_file-b60042fb1387e.gtest_out "$p"/org.chromium.native_test. ... I 26.191s run_tests_on_device(01e207b2a28dd48f) /sdcard/temp_file-b60042fb1387e.gtest_out size on device: 4798 I 26.429s run_tests_on_device(01e207b2a28dd48f) Logcat saved to https://luci-logdog.appspot.com/v/?s=chromium%2Fandroid%2Fswarming%2Flogcats%2F44fa9719bba03811%2F%2B%2Flogcat_logcat_-8315840777862943659_20190522T230126-UTC_01e207b2a28dd48f I 26.430s archive Writing text to logdog stream, logcat_logcat_-8315840777862943659_20190522T230126-UTC_01e207b2a28dd48f I 27.123s TimeoutThread-1-for-run_tests_on_device(01e207b2a28dd48f) Setting permissions for org.webrtc.native_test. I 30.047s run_tests_on_device(01e207b2a28dd48f) >>ScopedMainEntryLogger I 30.047s run_tests_on_device(01e207b2a28dd48f) Note: Google Test filter = AudioDecoderG722StereoTest.EncodeDecode:AudioDecoderG722StereoTest.SetTargetBitrate:AudioDecoderG722Test.EncodeDecode:AudioDecoderG722Test.SetTargetBitrate:AudioDecoderIlbcTest.EncodeDecode:AudioDecoderIlbcTest.SetTargetBitrate:AudioDecoderIsacFixTest.EncodeDecode:AudioDecoderIsacFixTest.SetTargetBitrate:AudioDecoderIsacFloatTest.EncodeDecode:AudioDecoderIsacFloatTest.SetTargetBitrate:AudioDecoderIsacSwbTest.EncodeDecode:AudioDecoderIsacSwbTest.SetTargetBitrate:AudioDecoderOpusStereoTest.EncodeDecode:AudioDecoderOpusStereoTest.SetTargetBitrate:AudioDecoderOpusTest.EncodeDecode:AudioDecoderOpusTest.SetTargetBitrate:AudioDecoderPcm16BTest.EncodeDecode:AudioDecoderPcm16BTest.SetTargetBitrate:AudioDecoderPcmATest.EncodeDecode:AudioDecoderPcmATest.SetTargetBitrate:AudioDecoderPcmUTest.EncodeDecode:AudioDecoderPcmUTest.SetTargetBitrate I 30.047s run_tests_on_device(01e207b2a28dd48f) [==========] Running 22 tests from 11 test suites. I 30.047s run_tests_on_device(01e207b2a28dd48f) [----------] Global test environment set-up. I 30.047s run_tests_on_device(01e207b2a28dd48f) [----------] 2 tests from AudioDecoderPcmUTest I 30.047s run_tests_on_device(01e207b2a28dd48f) [ RUN ] AudioDecoderPcmUTest.EncodeDecode I 30.047s run_tests_on_device(01e207b2a28dd48f) [ OK ] AudioDecoderPcmUTest.EncodeDecode (1 ms) I 30.047s run_tests_on_device(01e207b2a28dd48f) [ RUN ] AudioDecoderPcmUTest.SetTargetBitrate I 30.047s run_tests_on_device(01e207b2a28dd48f) [ OK ] AudioDecoderPcmUTest.SetTargetBitrate (1 ms) I 30.047s run_tests_on_device(01e207b2a28dd48f) [----------] 2 tests from AudioDecoderPcmUTest (2 ms total) I 30.047s run_tests_on_device(01e207b2a28dd48f) I 30.047s run_tests_on_device(01e207b2a28dd48f) [----------] 2 tests from AudioDecoderPcmATest I 30.047s run_tests_on_device(01e207b2a28dd48f) [ RUN ] AudioDecoderPcmATest.EncodeDecode I 30.047s run_tests_on_device(01e207b2a28dd48f) [ OK ] AudioDecoderPcmATest.EncodeDecode (1 ms) I 30.047s run_tests_on_device(01e207b2a28dd48f) [ RUN ] AudioDecoderPcmATest.SetTargetBitrate I 30.047s run_tests_on_device(01e207b2a28dd48f) [ OK ] AudioDecoderPcmATest.SetTargetBitrate (1 ms) I 30.047s run_tests_on_device(01e207b2a28dd48f) [----------] 2 tests from AudioDecoderPcmATest (2 ms total) I 30.047s run_tests_on_device(01e207b2a28dd48f) I 30.047s run_tests_on_device(01e207b2a28dd48f) [----------] 2 tests from AudioDecoderPcm16BTest I 30.047s run_tests_on_device(01e207b2a28dd48f) [ RUN ] AudioDecoderPcm16BTest.EncodeDecode I 30.047s run_tests_on_device(01e207b2a28dd48f) [ OK ] AudioDecoderPcm16BTest.EncodeDecode (1 ms) I 30.047s run_tests_on_device(01e207b2a28dd48f) [ RUN ] AudioDecoderPcm16BTest.SetTargetBitrate I 30.047s run_tests_on_device(01e207b2a28dd48f) [ OK ] AudioDecoderPcm16BTest.SetTargetBitrate (1 ms) I 30.047s run_tests_on_device(01e207b2a28dd48f) [----------] 2 tests from AudioDecoderPcm16BTest (2 ms total) I 30.047s run_tests_on_device(01e207b2a28dd48f) I 30.047s run_tests_on_device(01e207b2a28dd48f) [----------] 2 tests from AudioDecoderIlbcTest I 30.047s run_tests_on_device(01e207b2a28dd48f) [ RUN ] AudioDecoderIlbcTest.EncodeDecode I 30.047s run_tests_on_device(01e207b2a28dd48f) [ OK ] AudioDecoderIlbcTest.EncodeDecode (10 ms) I 30.047s run_tests_on_device(01e207b2a28dd48f) [ RUN ] AudioDecoderIlbcTest.SetTargetBitrate I 30.047s run_tests_on_device(01e207b2a28dd48f) [ OK ] AudioDecoderIlbcTest.SetTargetBitrate (1 ms) I 30.047s run_tests_on_device(01e207b2a28dd48f) [----------] 2 tests from AudioDecoderIlbcTest (11 ms total) I 30.047s run_tests_on_device(01e207b2a28dd48f) I 30.047s run_tests_on_device(01e207b2a28dd48f) [----------] 2 tests from AudioDecoderIsacFloatTest I 30.047s run_tests_on_device(01e207b2a28dd48f) [ RUN ] AudioDecoderIsacFloatTest.EncodeDecode I 30.048s run_tests_on_device(01e207b2a28dd48f) [ OK ] AudioDecoderIsacFloatTest.EncodeDecode (11 ms) I 30.048s run_tests_on_device(01e207b2a28dd48f) [ RUN ] AudioDecoderIsacFloatTest.SetTargetBitrate I 30.048s run_tests_on_device(01e207b2a28dd48f) [ OK ] AudioDecoderIsacFloatTest.SetTargetBitrate (1 ms) I 30.048s run_tests_on_device(01e207b2a28dd48f) [----------] 2 tests from AudioDecoderIsacFloatTest (12 ms total) I 30.048s run_tests_on_device(01e207b2a28dd48f) I 30.048s run_tests_on_device(01e207b2a28dd48f) [----------] 2 tests from AudioDecoderIsacSwbTest I 30.048s run_tests_on_device(01e207b2a28dd48f) [ RUN ] AudioDecoderIsacSwbTest.EncodeDecode I 30.048s run_tests_on_device(01e207b2a28dd48f) [ OK ] AudioDecoderIsacSwbTest.EncodeDecode (11 ms) I 30.048s run_tests_on_device(01e207b2a28dd48f) [ RUN ] AudioDecoderIsacSwbTest.SetTargetBitrate I 30.048s run_tests_on_device(01e207b2a28dd48f) [ OK ] AudioDecoderIsacSwbTest.SetTargetBitrate (1 ms) I 30.048s run_tests_on_device(01e207b2a28dd48f) [----------] 2 tests from AudioDecoderIsacSwbTest (12 ms total) I 30.048s run_tests_on_device(01e207b2a28dd48f) I 30.048s run_tests_on_device(01e207b2a28dd48f) [----------] 2 tests from AudioDecoderIsacFixTest I 30.048s run_tests_on_device(01e207b2a28dd48f) [ RUN ] AudioDecoderIsacFixTest.EncodeDecode I 30.048s run_tests_on_device(01e207b2a28dd48f) [ OK ] AudioDecoderIsacFixTest.EncodeDecode (6 ms) I 30.048s run_tests_on_device(01e207b2a28dd48f) [ RUN ] AudioDecoderIsacFixTest.SetTargetBitrate I 30.048s run_tests_on_device(01e207b2a28dd48f) [ OK ] AudioDecoderIsacFixTest.SetTargetBitrate (1 ms) I 30.048s run_tests_on_device(01e207b2a28dd48f) [----------] 2 tests from AudioDecoderIsacFixTest (7 ms total) I 30.048s run_tests_on_device(01e207b2a28dd48f) I 30.048s run_tests_on_device(01e207b2a28dd48f) [----------] 2 tests from AudioDecoderG722Test I 30.048s run_tests_on_device(01e207b2a28dd48f) [ RUN ] AudioDecoderG722Test.EncodeDecode I 30.048s run_tests_on_device(01e207b2a28dd48f) [ OK ] AudioDecoderG722Test.EncodeDecode (2 ms) I 30.048s run_tests_on_device(01e207b2a28dd48f) [ RUN ] AudioDecoderG722Test.SetTargetBitrate I 30.048s run_tests_on_device(01e207b2a28dd48f) [ OK ] AudioDecoderG722Test.SetTargetBitrate (0 ms) I 30.048s run_tests_on_device(01e207b2a28dd48f) [----------] 2 tests from AudioDecoderG722Test (2 ms total) I 30.048s run_tests_on_device(01e207b2a28dd48f) I 30.048s run_tests_on_device(01e207b2a28dd48f) [----------] 2 tests from AudioDecoderG722StereoTest I 30.048s run_tests_on_device(01e207b2a28dd48f) [ RUN ] AudioDecoderG722StereoTest.EncodeDecode I 30.048s run_tests_on_device(01e207b2a28dd48f) [ OK ] AudioDecoderG722StereoTest.EncodeDecode (4 ms) I 30.048s run_tests_on_device(01e207b2a28dd48f) [ RUN ] AudioDecoderG722StereoTest.SetTargetBitrate I 30.048s run_tests_on_device(01e207b2a28dd48f) [ OK ] AudioDecoderG722StereoTest.SetTargetBitrate (0 ms) I 30.048s run_tests_on_device(01e207b2a28dd48f) [----------] 2 tests from AudioDecoderG722StereoTest (4 ms total) I 30.048s run_tests_on_device(01e207b2a28dd48f) I 30.048s run_tests_on_device(01e207b2a28dd48f) [----------] 2 tests from AudioDecoderOpusTest I 30.048s run_tests_on_device(01e207b2a28dd48f) [ RUN ] AudioDecoderOpusTest.EncodeDecode I 30.048s run_tests_on_device(01e207b2a28dd48f) [ OK ] AudioDecoderOpusTest.EncodeDecode (6 ms) I 30.048s run_tests_on_device(01e207b2a28dd48f) [ RUN ] AudioDecoderOpusTest.SetTargetBitrate I 30.048s run_tests_on_device(01e207b2a28dd48f) [ OK ] AudioDecoderOpusTest.SetTargetBitrate (1 ms) I 30.048s run_tests_on_device(01e207b2a28dd48f) [----------] 2 tests from AudioDecoderOpusTest (7 ms total) I 30.048s run_tests_on_device(01e207b2a28dd48f) I 30.048s run_tests_on_device(01e207b2a28dd48f) [----------] 2 tests from AudioDecoderOpusStereoTest I 30.048s run_tests_on_device(01e207b2a28dd48f) [ RUN ] AudioDecoderOpusStereoTest.EncodeDecode I 30.048s run_tests_on_device(01e207b2a28dd48f) [ OK ] AudioDecoderOpusStereoTest.EncodeDecode (4 ms) I 30.048s run_tests_on_device(01e207b2a28dd48f) [ RUN ] AudioDecoderOpusStereoTest.SetTargetBitrate I 30.048s run_tests_on_device(01e207b2a28dd48f) [ OK ] AudioDecoderOpusStereoTest.SetTargetBitrate (0 ms) I 30.048s run_tests_on_device(01e207b2a28dd48f) [----------] 2 tests from AudioDecoderOpusStereoTest (5 ms total) I 30.048s run_tests_on_device(01e207b2a28dd48f) I 30.048s run_tests_on_device(01e207b2a28dd48f) [----------] Global test environment tear-down I 30.048s run_tests_on_device(01e207b2a28dd48f) [==========] 22 tests from 11 test suites ran. (67 ms total) I 30.048s run_tests_on_device(01e207b2a28dd48f) [ PASSED ] 22 tests. I 30.048s run_tests_on_device(01e207b2a28dd48f) <<ScopedMainEntryLogger I 30.050s run_tests_on_device(01e207b2a28dd48f) Finished running tests on this device. I 30.069s Main FINISHED TRY #1/3 I 30.069s Main All tests completed. C 30.069s Main ******************************************************************************** C 30.069s Main Summary C 30.069s Main ******************************************************************************** C 30.069s Main [==========] 22 tests ran. C 30.069s Main [ PASSED ] 22 tests. C 30.069s Main ******************************************************************************** I 30.070s tear_down_device(01e207b2a28dd48f) Wrote device cache: /b/swarming/w/ir/out/Android64_M_Nexus5X/device_cache_01e207b2a28dd48f.json I 30.236s Main Generated json results file at /b/swarming/w/itaOaGa1/tmpo9vNIY I 30.236s Main Finishing archiving output. [W2019-05-22T23:01:32.020263Z 3539 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-22T23:01:32.060290Z 3539 0 main.go:205] Butler terminated with error. {"error":"context canceled"} [E2019-05-22T23:01:32.060320Z 3539 0 main.go:233] Failed to serve. original error: context canceled [I2019-05-22T23:01:32.060367Z 3539 0 main.go:349] Terminating. {"returnCode":250} INFO:devil.utils.timeout_retry:condition 'logdog_stopped' met 2019-05-23 00:11:37,748 - root: [DEBUG] Contents of task_output_dir: ['/b/s/w/ir/tmp/t/tmpGxLHxS/44fc5854ab6a8310'] 2019-05-23 00:11:37,749 - root: [DEBUG] Found shard_json_files: ['/b/s/w/ir/tmp/t/tmpGxLHxS/44fc5854ab6a8310/output.json'] 2019-05-23 00:11:37,749 - 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/tmpTXPLkF.json --task-output-dir /b/s/w/ir/tmp/t/tmpGxLHxS -o /b/s/w/ir/tmp/t/tmpIc8RlY.json /b/s/w/ir/tmp/t/tmpGxLHxS/44fc5854ab6a8310/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/tmpTXPLkF.json', '--task-output-dir', '/b/s/w/ir/tmp/t/tmpGxLHxS', '-o', '/b/s/w/ir/tmp/t/tmpIc8RlY.json', '/b/s/w/ir/tmp/t/tmpGxLHxS/44fc5854ab6a8310/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/tmpTXPLkF.json', '--task-output-dir', '/b/s/w/ir/tmp/t/tmpGxLHxS', '-o', '/b/s/w/ir/tmp/t/tmpIc8RlY.json', '/b/s/w/ir/tmp/t/tmpGxLHxS/44fc5854ab6a8310/output.json'] returned exit code 0