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

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-05-20 16:06:12,676 - root: [DEBUG] Using task_output_dir: '/b/swarming/w/ir/tmp/t/tmpZdIKaJ' 2019-05-20 16:06:12,676 - root: [WARNING] task_output_dir '/b/swarming/w/ir/tmp/t/tmpZdIKaJ' already exists! 2019-05-20 16:06:12,676 - root: [WARNING] task_output_dir existing content: [] 2019-05-20 16:06:12,676 - 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/tmpqr9TRW.json -output-dir /b/swarming/w/ir/tmp/t/tmpZdIKaJ -task-summary-json /b/swarming/w/ir/tmp/t/tmp3rcKiR.json [D2019-05-20T16:06:12.686939-07:00 3618 0 auth.go:1265] Minting a new token {"key":"luci_ctx/8c57c2b4b3125d6cb20f645ed2a5f8bf3abd3c439b4961627e7419e815203f19", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-05-20T16:06:12.687020-07:00 3618 0 luci_ctx.go:138] POST http://127.0.0.1:33024/rpc/LuciLocalAuthService.GetOAuthToken {"key":"luci_ctx/8c57c2b4b3125d6cb20f645ed2a5f8bf3abd3c439b4961627e7419e815203f19", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-05-20T16:06:12.688912-07:00 3618 0 auth.go:1222] Token expires in 33m22.311150145s {"key":"luci_ctx/8c57c2b4b3125d6cb20f645ed2a5f8bf3abd3c439b4961627e7419e815203f19", "scopes":"https://www.googleapis.com/auth/userinfo.email"} 44f04539f8f72110: 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/a01b17/bin/python ../../build/android/test_wrapper/logdog_wrapper.py --target jingle_unittests --logdog-bin-cmd ../../bin/logdog_butler --store-tombstones --test-launcher-summary-output=/b/swarming/w/iomGJi6P/output.json --gs-results-bucket=chromium-result-details --recover-devices I 0.000s Main command: bin/../../../build/android/test_runner.py gtest --output-directory bin/../. --runtime-deps-path bin/../gen.runtime/jingle/jingle_unittests__test_runner_script.runtime_deps --suite jingle_unittests -v --store-tombstones --test-launcher-summary-output=/b/swarming/w/iomGJi6P/output.json --gs-results-bucket=chromium-result-details --recover-devices I 0.007s Main condition '<lambda>' met I 0.008s Main condition '<lambda>' met I 3.140s TimeoutThread-1-for-prepare_device(07dafe6013cc3713) condition 'sd_card_ready' met (0.0s) I 3.697s TimeoutThread-1-for-prepare_device(07dafe6013cc3713) condition 'pm_ready' met (0.6s) I 3.717s TimeoutThread-1-for-prepare_device(07dafe6013cc3713) condition 'boot_completed' met (0.6s) I 7.678s calculate_device_checksums condition '<lambda>' met (0.1s) I 9.041s TimeoutThread-1-for-individual_device_set_up(07dafe6013cc3713) Pushing 2559 files via .zip of size 6141357 I 15.672s list_tests(07dafe6013cc3713) flags: I 15.672s list_tests(07dafe6013cc3713) --gtest_list_tests I 16.976s list_tests(07dafe6013cc3713) /storage/emulated/legacy/temp_file-27636d4e69d01.gtest_out size on device: 1622 I 17.080s Main Using external sharding settings. This is shard 0/1 I 17.080s Main STARTING TRY #1/3 I 17.080s Main Will run 64 tests on 1 devices: 07dafe6013cc3713 W 17.148s run_tests_on_device(07dafe6013cc3713) No tombstones to clear. I 19.786s run_tests_on_device(07dafe6013cc3713) flags: I 19.786s run_tests_on_device(07dafe6013cc3713) Getting logdog client. I 21.636s run_tests_on_device(07dafe6013cc3713) /storage/emulated/legacy/temp_file-f5704c0a3f1d5.gtest_out size on device: 11440 I 21.769s run_tests_on_device(07dafe6013cc3713) Logcat saved to https://luci-logdog.appspot.com/v/?s=chromium%2Fandroid%2Fswarming%2Flogcats%2F44efee945da28d11%2F%2B%2Flogcat_logcat_-5312257532627004412_20190520T212132-UTC_07dafe6013cc3713 I 21.770s archive Writing text to logdog stream, logcat_logcat_-5312257532627004412_20190520T212132-UTC_07dafe6013cc3713 I 22.392s run_tests_on_device(07dafe6013cc3713) >>ScopedMainEntryLogger I 22.392s run_tests_on_device(07dafe6013cc3713) Note: Google Test filter = ConnectionSettingsTest.Basic:ConnectionSettingsTest.Empty:ConnectionSettingsTest.TrySslTcpFirst:FakeSSLClientSocketTest.MalformedServerHello:FakeSSLClientSocketTest.PassThroughMethods:FakeSSLClientSocketTest.PeerClosedDuringHandshake:FakeSSLClientSocketTest.ResetSocket:FakeSSLClientSocketTest.SuccessfulHandshakeAsync:FakeSSLClientSocketTest.SuccessfulHandshakeSync:FakeSSLClientSocketTest.UnsuccessfulHandshakeConnectError:FakeSSLClientSocketTest.UnsuccessfulHandshakeReadError:FakeSSLClientSocketTest.UnsuccessfulHandshakeWriteError:LoginSettingsTest.Basic:LoginSettingsTest.Redirect:NonBlockingPushClientTest.NotificationStateChange:NonBlockingPushClientTest.OnIncomingNotification:NonBlockingPushClientTest.SendNotification:NonBlockingPushClientTest.SendPing:NonBlockingPushClientTest.UpdateCredentials:NonBlockingPushClientTest.UpdateSubscriptions:NotificationTest.BinaryData:PushClientTest.CreateDefaultOffIOThread:PushClientTest.CreateDefaultOnIOThread:PushClientTest.CreateDefaultOnIOThreadOnIOThread:PushNotificationsSendUpdateTaskTest.MakeUpdateMessage:PushNotificationsSubscribeTaskTest.MakeSubscriptionMessage:SendPingTaskTest.MakePingStanza:SingleLoginAttemptTest.Basic:SingleLoginAttemptTest.CredentialsRejected:SingleLoginAttemptTest.Error:SingleLoginAttemptTest.ErrorThenSuccess:SingleLoginAttemptTest.Redirect:SingleLoginAttemptTest.RedirectEmpty:SingleLoginAttemptTest.RedirectHostOnly:SingleLoginAttemptTest.RedirectInvalidPort:SingleLoginAttemptTest.RedirectMissingSeeOtherHost:SingleLoginAttemptTest.RedirectMissingText:SingleLoginAttemptTest.RedirectZeroPort:TaskPumpTest.Basic:TaskPumpTest.Stop:ThreadWrapperTest.Clear:ThreadWrapperTest.ClearDelayed:ThreadWrapperTest.ClearDestroyed:ThreadWrapperTest.Dispose:ThreadWrapperTest.Post:ThreadWrapperTest.PostDelayed:ThreadWrapperTest.SendDuringSend:ThreadWrapperTest.SendSameThread:ThreadWrapperTest.SendToOtherThread:WeakXmppClientTest.InvalidationViaDestructor:WeakXmppClientTest.InvalidationViaInvalidate:WeakXmppClientTest.InvalidationViaStop:XmlElementUtilTest.MakeBoolXmlElement:XmlElementUtilTest.MakeIntXmlElement:XmlElementUtilTest.MakeStringXmlElement:XmlElementUtilTest.XmlElementToString:XmppPushClientTest.ConnectAndSubscribe:XmppPushClientTest.Disconnect:XmppPushClientTest.OnIncomingNotification:XmppPushClientTest.RejectCredentials:XmppPushClientTest.SendNotification:XmppPushClientTest.SendNotificationPending:XmppPushClientTest.SendPing:XmppPushClientTest.SubscriptionError I 22.392s run_tests_on_device(07dafe6013cc3713) [==========] Running 64 tests from 15 test suites. I 22.392s run_tests_on_device(07dafe6013cc3713) [----------] Global test environment set-up. I 22.392s run_tests_on_device(07dafe6013cc3713) [----------] 9 tests from FakeSSLClientSocketTest I 22.392s run_tests_on_device(07dafe6013cc3713) [ RUN ] FakeSSLClientSocketTest.PassThroughMethods I 22.392s run_tests_on_device(07dafe6013cc3713) [ OK ] FakeSSLClientSocketTest.PassThroughMethods (1 ms) I 22.392s run_tests_on_device(07dafe6013cc3713) [ RUN ] FakeSSLClientSocketTest.SuccessfulHandshakeSync I 22.392s run_tests_on_device(07dafe6013cc3713) [ OK ] FakeSSLClientSocketTest.SuccessfulHandshakeSync (41 ms) I 22.392s run_tests_on_device(07dafe6013cc3713) [ RUN ] FakeSSLClientSocketTest.SuccessfulHandshakeAsync I 22.392s run_tests_on_device(07dafe6013cc3713) [ OK ] FakeSSLClientSocketTest.SuccessfulHandshakeAsync (208 ms) I 22.392s run_tests_on_device(07dafe6013cc3713) [ RUN ] FakeSSLClientSocketTest.ResetSocket I 22.392s run_tests_on_device(07dafe6013cc3713) [ OK ] FakeSSLClientSocketTest.ResetSocket (26 ms) I 22.392s run_tests_on_device(07dafe6013cc3713) [ RUN ] FakeSSLClientSocketTest.UnsuccessfulHandshakeConnectError I 22.393s run_tests_on_device(07dafe6013cc3713) [ OK ] FakeSSLClientSocketTest.UnsuccessfulHandshakeConnectError (1 ms) I 22.393s run_tests_on_device(07dafe6013cc3713) [ RUN ] FakeSSLClientSocketTest.UnsuccessfulHandshakeWriteError I 22.393s run_tests_on_device(07dafe6013cc3713) [ OK ] FakeSSLClientSocketTest.UnsuccessfulHandshakeWriteError (2 ms) I 22.393s run_tests_on_device(07dafe6013cc3713) [ RUN ] FakeSSLClientSocketTest.UnsuccessfulHandshakeReadError I 22.393s run_tests_on_device(07dafe6013cc3713) [ OK ] FakeSSLClientSocketTest.UnsuccessfulHandshakeReadError (8 ms) I 22.393s run_tests_on_device(07dafe6013cc3713) [ RUN ] FakeSSLClientSocketTest.PeerClosedDuringHandshake I 22.393s run_tests_on_device(07dafe6013cc3713) [ OK ] FakeSSLClientSocketTest.PeerClosedDuringHandshake (7 ms) I 22.393s run_tests_on_device(07dafe6013cc3713) [ RUN ] FakeSSLClientSocketTest.MalformedServerHello I 22.393s run_tests_on_device(07dafe6013cc3713) [ OK ] FakeSSLClientSocketTest.MalformedServerHello (8 ms) I 22.393s run_tests_on_device(07dafe6013cc3713) [----------] 9 tests from FakeSSLClientSocketTest (305 ms total) I 22.393s run_tests_on_device(07dafe6013cc3713) I 22.393s run_tests_on_device(07dafe6013cc3713) [----------] 2 tests from TaskPumpTest I 22.393s run_tests_on_device(07dafe6013cc3713) [ RUN ] TaskPumpTest.Basic I 22.393s run_tests_on_device(07dafe6013cc3713) [ OK ] TaskPumpTest.Basic (1 ms) I 22.393s run_tests_on_device(07dafe6013cc3713) [ RUN ] TaskPumpTest.Stop I 22.393s run_tests_on_device(07dafe6013cc3713) [ OK ] TaskPumpTest.Stop (1 ms) I 22.393s run_tests_on_device(07dafe6013cc3713) [----------] 2 tests from TaskPumpTest (2 ms total) I 22.393s run_tests_on_device(07dafe6013cc3713) I 22.393s run_tests_on_device(07dafe6013cc3713) [----------] 9 tests from ThreadWrapperTest I 22.393s run_tests_on_device(07dafe6013cc3713) [ RUN ] ThreadWrapperTest.Post I 22.393s run_tests_on_device(07dafe6013cc3713) [ OK ] ThreadWrapperTest.Post (1 ms) I 22.393s run_tests_on_device(07dafe6013cc3713) [ RUN ] ThreadWrapperTest.PostDelayed I 22.393s run_tests_on_device(07dafe6013cc3713) [ OK ] ThreadWrapperTest.PostDelayed (41 ms) I 22.393s run_tests_on_device(07dafe6013cc3713) [ RUN ] ThreadWrapperTest.Clear I 22.393s run_tests_on_device(07dafe6013cc3713) [ OK ] ThreadWrapperTest.Clear (1 ms) I 22.393s run_tests_on_device(07dafe6013cc3713) [ RUN ] ThreadWrapperTest.ClearDelayed I 22.393s run_tests_on_device(07dafe6013cc3713) [ OK ] ThreadWrapperTest.ClearDelayed (41 ms) I 22.393s run_tests_on_device(07dafe6013cc3713) [ RUN ] ThreadWrapperTest.ClearDestroyed I 22.393s run_tests_on_device(07dafe6013cc3713) [ OK ] ThreadWrapperTest.ClearDestroyed (1 ms) I 22.393s run_tests_on_device(07dafe6013cc3713) [ RUN ] ThreadWrapperTest.SendSameThread I 22.393s run_tests_on_device(07dafe6013cc3713) [ OK ] ThreadWrapperTest.SendSameThread (1 ms) I 22.393s run_tests_on_device(07dafe6013cc3713) [ RUN ] ThreadWrapperTest.SendToOtherThread I 22.393s run_tests_on_device(07dafe6013cc3713) [ OK ] ThreadWrapperTest.SendToOtherThread (3 ms) I 22.393s run_tests_on_device(07dafe6013cc3713) [ RUN ] ThreadWrapperTest.SendDuringSend I 22.393s run_tests_on_device(07dafe6013cc3713) [ OK ] ThreadWrapperTest.SendDuringSend (3 ms) I 22.393s run_tests_on_device(07dafe6013cc3713) [ RUN ] ThreadWrapperTest.Dispose I 22.393s run_tests_on_device(07dafe6013cc3713) [ OK ] ThreadWrapperTest.Dispose (1 ms) I 22.393s run_tests_on_device(07dafe6013cc3713) [----------] 9 tests from ThreadWrapperTest (96 ms total) I 22.393s run_tests_on_device(07dafe6013cc3713) I 22.393s run_tests_on_device(07dafe6013cc3713) [----------] 3 tests from WeakXmppClientTest I 22.393s run_tests_on_device(07dafe6013cc3713) [ RUN ] WeakXmppClientTest.InvalidationViaInvalidate I 22.393s run_tests_on_device(07dafe6013cc3713) [ OK ] WeakXmppClientTest.InvalidationViaInvalidate (3 ms) I 22.393s run_tests_on_device(07dafe6013cc3713) [ RUN ] WeakXmppClientTest.InvalidationViaStop I 22.393s run_tests_on_device(07dafe6013cc3713) [ OK ] WeakXmppClientTest.InvalidationViaStop (2 ms) I 22.393s run_tests_on_device(07dafe6013cc3713) [ RUN ] WeakXmppClientTest.InvalidationViaDestructor I 22.393s run_tests_on_device(07dafe6013cc3713) [ OK ] WeakXmppClientTest.InvalidationViaDestructor (2 ms) I 22.393s run_tests_on_device(07dafe6013cc3713) [----------] 3 tests from WeakXmppClientTest (7 ms total) I 22.393s run_tests_on_device(07dafe6013cc3713) I 22.393s run_tests_on_device(07dafe6013cc3713) [----------] 3 tests from ConnectionSettingsTest I 22.393s run_tests_on_device(07dafe6013cc3713) [ RUN ] ConnectionSettingsTest.Empty I 22.393s run_tests_on_device(07dafe6013cc3713) [ OK ] ConnectionSettingsTest.Empty (1 ms) I 22.393s run_tests_on_device(07dafe6013cc3713) [ RUN ] ConnectionSettingsTest.Basic I 22.394s run_tests_on_device(07dafe6013cc3713) [ OK ] ConnectionSettingsTest.Basic (1 ms) I 22.394s run_tests_on_device(07dafe6013cc3713) [ RUN ] ConnectionSettingsTest.TrySslTcpFirst I 22.394s run_tests_on_device(07dafe6013cc3713) [ OK ] ConnectionSettingsTest.TrySslTcpFirst (1 ms) I 22.394s run_tests_on_device(07dafe6013cc3713) [----------] 3 tests from ConnectionSettingsTest (4 ms total) I 22.394s run_tests_on_device(07dafe6013cc3713) I 22.394s run_tests_on_device(07dafe6013cc3713) [----------] 2 tests from LoginSettingsTest I 22.394s run_tests_on_device(07dafe6013cc3713) [ RUN ] LoginSettingsTest.Basic I 22.394s run_tests_on_device(07dafe6013cc3713) [ OK ] LoginSettingsTest.Basic (2 ms) I 22.394s run_tests_on_device(07dafe6013cc3713) [ RUN ] LoginSettingsTest.Redirect I 22.394s run_tests_on_device(07dafe6013cc3713) [ OK ] LoginSettingsTest.Redirect (0 ms) I 22.394s run_tests_on_device(07dafe6013cc3713) [----------] 2 tests from LoginSettingsTest (2 ms total) I 22.394s run_tests_on_device(07dafe6013cc3713) I 22.394s run_tests_on_device(07dafe6013cc3713) [----------] 11 tests from SingleLoginAttemptTest I 22.394s run_tests_on_device(07dafe6013cc3713) [ RUN ] SingleLoginAttemptTest.Basic I 22.394s run_tests_on_device(07dafe6013cc3713) [ OK ] SingleLoginAttemptTest.Basic (8 ms) I 22.394s run_tests_on_device(07dafe6013cc3713) [ RUN ] SingleLoginAttemptTest.Error I 22.394s run_tests_on_device(07dafe6013cc3713) [ OK ] SingleLoginAttemptTest.Error (7 ms) I 22.394s run_tests_on_device(07dafe6013cc3713) [ RUN ] SingleLoginAttemptTest.ErrorThenSuccess I 22.394s run_tests_on_device(07dafe6013cc3713) [ OK ] SingleLoginAttemptTest.ErrorThenSuccess (6 ms) I 22.394s run_tests_on_device(07dafe6013cc3713) [ RUN ] SingleLoginAttemptTest.Redirect I 22.394s run_tests_on_device(07dafe6013cc3713) [ OK ] SingleLoginAttemptTest.Redirect (6 ms) I 22.394s run_tests_on_device(07dafe6013cc3713) [ RUN ] SingleLoginAttemptTest.RedirectHostOnly I 22.394s run_tests_on_device(07dafe6013cc3713) [ OK ] SingleLoginAttemptTest.RedirectHostOnly (5 ms) I 22.394s run_tests_on_device(07dafe6013cc3713) [ RUN ] SingleLoginAttemptTest.RedirectZeroPort I 22.394s run_tests_on_device(07dafe6013cc3713) [ OK ] SingleLoginAttemptTest.RedirectZeroPort (6 ms) I 22.394s run_tests_on_device(07dafe6013cc3713) [ RUN ] SingleLoginAttemptTest.RedirectInvalidPort I 22.394s run_tests_on_device(07dafe6013cc3713) [ OK ] SingleLoginAttemptTest.RedirectInvalidPort (5 ms) I 22.394s run_tests_on_device(07dafe6013cc3713) [ RUN ] SingleLoginAttemptTest.RedirectEmpty I 22.394s run_tests_on_device(07dafe6013cc3713) [ OK ] SingleLoginAttemptTest.RedirectEmpty (7 ms) I 22.394s run_tests_on_device(07dafe6013cc3713) [ RUN ] SingleLoginAttemptTest.RedirectMissingText I 22.394s run_tests_on_device(07dafe6013cc3713) [ OK ] SingleLoginAttemptTest.RedirectMissingText (6 ms) I 22.394s run_tests_on_device(07dafe6013cc3713) [ RUN ] SingleLoginAttemptTest.RedirectMissingSeeOtherHost I 22.394s run_tests_on_device(07dafe6013cc3713) [ OK ] SingleLoginAttemptTest.RedirectMissingSeeOtherHost (6 ms) I 22.394s run_tests_on_device(07dafe6013cc3713) [ RUN ] SingleLoginAttemptTest.CredentialsRejected I 22.394s run_tests_on_device(07dafe6013cc3713) [ OK ] SingleLoginAttemptTest.CredentialsRejected (5 ms) I 22.394s run_tests_on_device(07dafe6013cc3713) [----------] 11 tests from SingleLoginAttemptTest (69 ms total) I 22.394s run_tests_on_device(07dafe6013cc3713) I 22.394s run_tests_on_device(07dafe6013cc3713) [----------] 6 tests from NonBlockingPushClientTest I 22.394s run_tests_on_device(07dafe6013cc3713) [ RUN ] NonBlockingPushClientTest.UpdateSubscriptions I 22.394s run_tests_on_device(07dafe6013cc3713) [ OK ] NonBlockingPushClientTest.UpdateSubscriptions (1 ms) I 22.394s run_tests_on_device(07dafe6013cc3713) [ RUN ] NonBlockingPushClientTest.UpdateCredentials I 22.394s run_tests_on_device(07dafe6013cc3713) [ OK ] NonBlockingPushClientTest.UpdateCredentials (1 ms) I 22.394s run_tests_on_device(07dafe6013cc3713) [ RUN ] NonBlockingPushClientTest.SendNotification I 22.394s run_tests_on_device(07dafe6013cc3713) [ OK ] NonBlockingPushClientTest.SendNotification (1 ms) I 22.394s run_tests_on_device(07dafe6013cc3713) [ RUN ] NonBlockingPushClientTest.SendPing I 22.394s run_tests_on_device(07dafe6013cc3713) [ OK ] NonBlockingPushClientTest.SendPing (1 ms) I 22.394s run_tests_on_device(07dafe6013cc3713) [ RUN ] NonBlockingPushClientTest.NotificationStateChange I 22.394s run_tests_on_device(07dafe6013cc3713) [ OK ] NonBlockingPushClientTest.NotificationStateChange (1 ms) I 22.394s run_tests_on_device(07dafe6013cc3713) [ RUN ] NonBlockingPushClientTest.OnIncomingNotification I 22.394s run_tests_on_device(07dafe6013cc3713) [ OK ] NonBlockingPushClientTest.OnIncomingNotification (1 ms) I 22.394s run_tests_on_device(07dafe6013cc3713) [----------] 6 tests from NonBlockingPushClientTest (7 ms total) I 22.394s run_tests_on_device(07dafe6013cc3713) I 22.394s run_tests_on_device(07dafe6013cc3713) [----------] 1 test from NotificationTest I 22.394s run_tests_on_device(07dafe6013cc3713) [ RUN ] NotificationTest.BinaryData I 22.394s run_tests_on_device(07dafe6013cc3713) [ OK ] NotificationTest.BinaryData (0 ms) I 22.395s run_tests_on_device(07dafe6013cc3713) [----------] 1 test from NotificationTest (1 ms total) I 22.395s run_tests_on_device(07dafe6013cc3713) I 22.395s run_tests_on_device(07dafe6013cc3713) [----------] 3 tests from PushClientTest I 22.395s run_tests_on_device(07dafe6013cc3713) [ RUN ] PushClientTest.CreateDefaultOnIOThread I 22.395s run_tests_on_device(07dafe6013cc3713) [ OK ] PushClientTest.CreateDefaultOnIOThread (2 ms) I 22.395s run_tests_on_device(07dafe6013cc3713) [ RUN ] PushClientTest.CreateDefaultOffIOThread I 22.395s run_tests_on_device(07dafe6013cc3713) [ OK ] PushClientTest.CreateDefaultOffIOThread (2 ms) I 22.395s run_tests_on_device(07dafe6013cc3713) [ RUN ] PushClientTest.CreateDefaultOnIOThreadOnIOThread I 22.395s run_tests_on_device(07dafe6013cc3713) [ OK ] PushClientTest.CreateDefaultOnIOThreadOnIOThread (2 ms) I 22.395s run_tests_on_device(07dafe6013cc3713) [----------] 3 tests from PushClientTest (6 ms total) I 22.395s run_tests_on_device(07dafe6013cc3713) I 22.395s run_tests_on_device(07dafe6013cc3713) [----------] 1 test from PushNotificationsSendUpdateTaskTest I 22.395s run_tests_on_device(07dafe6013cc3713) [ RUN ] PushNotificationsSendUpdateTaskTest.MakeUpdateMessage I 22.395s run_tests_on_device(07dafe6013cc3713) [ OK ] PushNotificationsSendUpdateTaskTest.MakeUpdateMessage (0 ms) I 22.395s run_tests_on_device(07dafe6013cc3713) [----------] 1 test from PushNotificationsSendUpdateTaskTest (0 ms total) I 22.395s run_tests_on_device(07dafe6013cc3713) I 22.395s run_tests_on_device(07dafe6013cc3713) [----------] 1 test from PushNotificationsSubscribeTaskTest I 22.395s run_tests_on_device(07dafe6013cc3713) [ RUN ] PushNotificationsSubscribeTaskTest.MakeSubscriptionMessage I 22.395s run_tests_on_device(07dafe6013cc3713) [ OK ] PushNotificationsSubscribeTaskTest.MakeSubscriptionMessage (1 ms) I 22.395s run_tests_on_device(07dafe6013cc3713) [----------] 1 test from PushNotificationsSubscribeTaskTest (1 ms total) I 22.395s run_tests_on_device(07dafe6013cc3713) I 22.395s run_tests_on_device(07dafe6013cc3713) [----------] 1 test from SendPingTaskTest I 22.395s run_tests_on_device(07dafe6013cc3713) [ RUN ] SendPingTaskTest.MakePingStanza I 22.395s run_tests_on_device(07dafe6013cc3713) [ OK ] SendPingTaskTest.MakePingStanza (1 ms) I 22.395s run_tests_on_device(07dafe6013cc3713) [----------] 1 test from SendPingTaskTest (1 ms total) I 22.395s run_tests_on_device(07dafe6013cc3713) I 22.395s run_tests_on_device(07dafe6013cc3713) [----------] 4 tests from XmlElementUtilTest I 22.395s run_tests_on_device(07dafe6013cc3713) [ RUN ] XmlElementUtilTest.XmlElementToString I 22.395s run_tests_on_device(07dafe6013cc3713) [ OK ] XmlElementUtilTest.XmlElementToString (1 ms) I 22.395s run_tests_on_device(07dafe6013cc3713) [ RUN ] XmlElementUtilTest.MakeBoolXmlElement I 22.395s run_tests_on_device(07dafe6013cc3713) [ OK ] XmlElementUtilTest.MakeBoolXmlElement (1 ms) I 22.395s run_tests_on_device(07dafe6013cc3713) [ RUN ] XmlElementUtilTest.MakeIntXmlElement I 22.395s run_tests_on_device(07dafe6013cc3713) [ OK ] XmlElementUtilTest.MakeIntXmlElement (0 ms) I 22.395s run_tests_on_device(07dafe6013cc3713) [ RUN ] XmlElementUtilTest.MakeStringXmlElement I 22.395s run_tests_on_device(07dafe6013cc3713) [ OK ] XmlElementUtilTest.MakeStringXmlElement (1 ms) I 22.395s run_tests_on_device(07dafe6013cc3713) [----------] 4 tests from XmlElementUtilTest (3 ms total) I 22.395s run_tests_on_device(07dafe6013cc3713) I 22.395s run_tests_on_device(07dafe6013cc3713) [----------] 8 tests from XmppPushClientTest I 22.395s run_tests_on_device(07dafe6013cc3713) [ RUN ] XmppPushClientTest.OnIncomingNotification I 22.395s run_tests_on_device(07dafe6013cc3713) [ OK ] XmppPushClientTest.OnIncomingNotification (3 ms) I 22.395s run_tests_on_device(07dafe6013cc3713) [ RUN ] XmppPushClientTest.ConnectAndSubscribe I 22.395s run_tests_on_device(07dafe6013cc3713) [ OK ] XmppPushClientTest.ConnectAndSubscribe (2 ms) I 22.395s run_tests_on_device(07dafe6013cc3713) [ RUN ] XmppPushClientTest.Disconnect I 22.395s run_tests_on_device(07dafe6013cc3713) [ OK ] XmppPushClientTest.Disconnect (2 ms) I 22.395s run_tests_on_device(07dafe6013cc3713) [ RUN ] XmppPushClientTest.RejectCredentials I 22.395s run_tests_on_device(07dafe6013cc3713) [ OK ] XmppPushClientTest.RejectCredentials (2 ms) I 22.395s run_tests_on_device(07dafe6013cc3713) [ RUN ] XmppPushClientTest.SubscriptionError I 22.395s run_tests_on_device(07dafe6013cc3713) [ OK ] XmppPushClientTest.SubscriptionError (2 ms) I 22.395s run_tests_on_device(07dafe6013cc3713) [ RUN ] XmppPushClientTest.SendNotification I 22.395s run_tests_on_device(07dafe6013cc3713) [ OK ] XmppPushClientTest.SendNotification (2 ms) I 22.395s run_tests_on_device(07dafe6013cc3713) [ RUN ] XmppPushClientTest.SendPing I 22.395s run_tests_on_device(07dafe6013cc3713) [ OK ] XmppPushClientTest.SendPing (2 ms) I 22.395s run_tests_on_device(07dafe6013cc3713) [ RUN ] XmppPushClientTest.SendNotificationPending I 22.395s run_tests_on_device(07dafe6013cc3713) [ OK ] XmppPushClientTest.SendNotificationPending (2 ms) I 22.396s run_tests_on_device(07dafe6013cc3713) [----------] 8 tests from XmppPushClientTest (19 ms total) I 22.396s run_tests_on_device(07dafe6013cc3713) I 22.396s run_tests_on_device(07dafe6013cc3713) [----------] Global test environment tear-down I 22.396s run_tests_on_device(07dafe6013cc3713) [==========] 64 tests from 15 test suites ran. (531 ms total) I 22.396s run_tests_on_device(07dafe6013cc3713) [ PASSED ] 64 tests. I 22.396s run_tests_on_device(07dafe6013cc3713) <<ScopedMainEntryLogger I 22.398s run_tests_on_device(07dafe6013cc3713) Finished running tests on this device. I 22.399s Main FINISHED TRY #1/3 I 22.399s Main All tests completed. C 22.400s Main ******************************************************************************** C 22.400s Main Summary C 22.400s Main ******************************************************************************** C 22.400s Main [==========] 64 tests ran. C 22.400s Main [ PASSED ] 64 tests. C 22.400s Main ******************************************************************************** I 22.402s tear_down_device(07dafe6013cc3713) Wrote device cache: /b/swarming/w/ir/out/Release/device_cache_07dafe6013cc3713.json I 22.406s Main Generated json results file at /b/swarming/w/itQILI9r/tmpVzuqG9 I 22.406s Main Finishing archiving output. [W2019-05-20T21:21:35.511939Z 2345 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-20T21:21:35.554495Z 2345 0 main.go:205] Butler terminated with error. {"error":"context canceled"} [E2019-05-20T21:21:35.554552Z 2345 0 main.go:233] Failed to serve. original error: context canceled [I2019-05-20T21:21:35.554601Z 2345 0 main.go:349] Terminating. {"returnCode":250} INFO:devil.utils.timeout_retry:condition 'logdog_stopped' met 2019-05-20 16:06:14,591 - root: [DEBUG] Contents of task_output_dir: ['/b/swarming/w/ir/tmp/t/tmpZdIKaJ/44f04539f8f72110'] 2019-05-20 16:06:14,591 - root: [DEBUG] Found shard_json_files: ['/b/swarming/w/ir/tmp/t/tmpZdIKaJ/44f04539f8f72110/output.json'] 2019-05-20 16:06:14,591 - 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 {"blamelist": ["adettenb@microsoft.com"], "bot_id": "swarm1739-c4", "buildbucket": {"build": {"bucket": "luci.chromium.try", "created_by": "user:5071639625-1lppvbtck1morgivc6sq4dul7klu27sd@developer.gserviceaccount.com", "created_ts": 1558390983083306, "id": "8912902332481114224", "project": "chromium", "tags": ["build_address:luci.chromium.try/android-kitkat-arm-rel/266040", "builder:android-kitkat-arm-rel", "buildset:patch/gerrit/chromium-review.googlesource.com/1611021/17", "cq_experimental:false", "user_agent:cq"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "android-kitkat-arm-rel", "buildnumber": 266040, "category": "cq", "got_angle_revision": "7a026133ee45d4088d7a86fd464116fc3a186c36", "got_dawn_revision": "2bc3169f0d64a07469b73c318a2e4c887f8eb17a", "got_nacl_revision": "ca374f5112fca6b36fc5d73e117a60b82f394993", "got_revision": "15450175775febd225040000cc86c5c8e7447787", "got_revision_cp": "refs/heads/master@{#661499}", "got_swarming_client_revision": "1b65f4e862045f3ba430a4cbd0643f5b1b66c230", "got_v8_revision": "71714da93ff99adc9e79a7813328ea91660573e5", "got_v8_revision_cp": "refs/heads/7.6.222@{#1}", "got_webrtc_revision": "1ff16c87aa63d4f9b63a238fc0664b5e625e9884", "got_webrtc_revision_cp": "refs/heads/master@{#27992}", "mastername": "tryserver.chromium.android", "patch_gerrit_url": "https://chromium-review.googlesource.com", "patch_issue": 1611021, "patch_project": "chromium/src", "patch_ref": "refs/changes/21/1611021/17", "patch_repository_url": "https://chromium.googlesource.com/chromium/src", "patch_set": 17, "patch_storage": "gerrit", "path_config": "generic", "reason": "CQ", "recipe": "chromium_trybot", "repository": "https://chromium.googlesource.com/chromium/src", "revision": "HEAD"} --summary-json /b/swarming/w/ir/tmp/t/tmp3rcKiR.json --task-output-dir /b/swarming/w/ir/tmp/t/tmpZdIKaJ --bucket chromium-result-details --test-name jingle_unittests -o /b/swarming/w/ir/tmp/t/tmpTCRrVz.json /b/swarming/w/ir/tmp/t/tmpZdIKaJ/44f04539f8f72110/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', '{"blamelist": ["adettenb@microsoft.com"], "bot_id": "swarm1739-c4", "buildbucket": {"build": {"bucket": "luci.chromium.try", "created_by": "user:5071639625-1lppvbtck1morgivc6sq4dul7klu27sd@developer.gserviceaccount.com", "created_ts": 1558390983083306, "id": "8912902332481114224", "project": "chromium", "tags": ["build_address:luci.chromium.try/android-kitkat-arm-rel/266040", "builder:android-kitkat-arm-rel", "buildset:patch/gerrit/chromium-review.googlesource.com/1611021/17", "cq_experimental:false", "user_agent:cq"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "android-kitkat-arm-rel", "buildnumber": 266040, "category": "cq", "got_angle_revision": "7a026133ee45d4088d7a86fd464116fc3a186c36", "got_dawn_revision": "2bc3169f0d64a07469b73c318a2e4c887f8eb17a", "got_nacl_revision": "ca374f5112fca6b36fc5d73e117a60b82f394993", "got_revision": "15450175775febd225040000cc86c5c8e7447787", "got_revision_cp": "refs/heads/master@{#661499}", "got_swarming_client_revision": "1b65f4e862045f3ba430a4cbd0643f5b1b66c230", "got_v8_revision": "71714da93ff99adc9e79a7813328ea91660573e5", "got_v8_revision_cp": "refs/heads/7.6.222@{#1}", "got_webrtc_revision": "1ff16c87aa63d4f9b63a238fc0664b5e625e9884", "got_webrtc_revision_cp": "refs/heads/master@{#27992}", "mastername": "tryserver.chromium.android", "patch_gerrit_url": "https://chromium-review.googlesource.com", "patch_issue": 1611021, "patch_project": "chromium/src", "patch_ref": "refs/changes/21/1611021/17", "patch_repository_url": "https://chromium.googlesource.com/chromium/src", "patch_set": 17, "patch_storage": "gerrit", "path_config": "generic", "reason": "CQ", "recipe": "chromium_trybot", "repository": "https://chromium.googlesource.com/chromium/src", "revision": "HEAD"}', '--summary-json', '/b/swarming/w/ir/tmp/t/tmp3rcKiR.json', '--task-output-dir', '/b/swarming/w/ir/tmp/t/tmpZdIKaJ', u'--bucket', u'chromium-result-details', u'--test-name', u'jingle_unittests', '-o', '/b/swarming/w/ir/tmp/t/tmpTCRrVz.json', '/b/swarming/w/ir/tmp/t/tmpZdIKaJ/44f04539f8f72110/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', '{"blamelist": ["adettenb@microsoft.com"], "bot_id": "swarm1739-c4", "buildbucket": {"build": {"bucket": "luci.chromium.try", "created_by": "user:5071639625-1lppvbtck1morgivc6sq4dul7klu27sd@developer.gserviceaccount.com", "created_ts": 1558390983083306, "id": "8912902332481114224", "project": "chromium", "tags": ["build_address:luci.chromium.try/android-kitkat-arm-rel/266040", "builder:android-kitkat-arm-rel", "buildset:patch/gerrit/chromium-review.googlesource.com/1611021/17", "cq_experimental:false", "user_agent:cq"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "android-kitkat-arm-rel", "buildnumber": 266040, "category": "cq", "got_angle_revision": "7a026133ee45d4088d7a86fd464116fc3a186c36", "got_dawn_revision": "2bc3169f0d64a07469b73c318a2e4c887f8eb17a", "got_nacl_revision": "ca374f5112fca6b36fc5d73e117a60b82f394993", "got_revision": "15450175775febd225040000cc86c5c8e7447787", "got_revision_cp": "refs/heads/master@{#661499}", "got_swarming_client_revision": "1b65f4e862045f3ba430a4cbd0643f5b1b66c230", "got_v8_revision": "71714da93ff99adc9e79a7813328ea91660573e5", "got_v8_revision_cp": "refs/heads/7.6.222@{#1}", "got_webrtc_revision": "1ff16c87aa63d4f9b63a238fc0664b5e625e9884", "got_webrtc_revision_cp": "refs/heads/master@{#27992}", "mastername": "tryserver.chromium.android", "patch_gerrit_url": "https://chromium-review.googlesource.com", "patch_issue": 1611021, "patch_project": "chromium/src", "patch_ref": "refs/changes/21/1611021/17", "patch_repository_url": "https://chromium.googlesource.com/chromium/src", "patch_set": 17, "patch_storage": "gerrit", "path_config": "generic", "reason": "CQ", "recipe": "chromium_trybot", "repository": "https://chromium.googlesource.com/chromium/src", "revision": "HEAD"}', '--summary-json', '/b/swarming/w/ir/tmp/t/tmp3rcKiR.json', '--task-output-dir', '/b/swarming/w/ir/tmp/t/tmpZdIKaJ', u'--bucket', u'chromium-result-details', u'--test-name', u'jingle_unittests', '-o', '/b/swarming/w/ir/tmp/t/tmpTCRrVz.json', '/b/swarming/w/ir/tmp/t/tmpZdIKaJ/44f04539f8f72110/output.json'] returned exit code 0