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

python -u /b/swarming/w/ir/kitchen-checkout/build/scripts/tools/runit.py --show-path --with-third-party-lib -- python /b/swarming/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/collect_task.py --verbose -o /b/swarming/w/ir/tmp/t/tmpYuqJrg.json --task-output-dir /b/swarming/w/ir/tmp/t/tmpQ2blE2 --merge-script /b/swarming/w/ir/cache/builder/src/build/android/pylib/results/presentation/test_results_presentation.py --merge-script-stdout-file /b/swarming/w/ir/tmp/t/tmpWc8yM3merge_script_log --merge-additional-args '["--bucket", "chromium-result-details", "--test-name", "gcm_unit_tests"]' --build-properties '{"bot_id": "swarm1596-c4", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1556198555874897, "id": "8915201259034326704", "project": "chromium", "tags": ["build_address:luci.chromium.ci/android-marshmallow-arm64-rel/14705", "builder:android-marshmallow-arm64-rel", "buildset:commit/git/cb9dae5d0ff597027948ecc85eec11018803a8bb", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cb9dae5d0ff597027948ecc85eec11018803a8bb", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9080631321242183552", "scheduler_job_id:chromium/android-marshmallow-arm64-rel", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "android-marshmallow-arm64-rel", "buildnumber": 14705, "got_angle_revision": "1b0acbb5126e7f7d03bde3bde6d4b2fba20811c8", "got_dawn_revision": "22cee9ae36b23a8908525d668ef4728a26c931c4", "got_nacl_revision": "6abc006f6760ec49350cd45e8bccbff4809725ac", "got_revision": "cb9dae5d0ff597027948ecc85eec11018803a8bb", "got_revision_cp": "refs/heads/master@{#654004}", "got_swarming_client_revision": "aa60736aded9fc32a0e21a81f5fc51f6009d01f3", "got_v8_revision": "2531f0784031894907b009a0a2de46ea8bc04547", "got_v8_revision_cp": "refs/heads/7.6.29@{#1}", "got_webrtc_revision": "03e85d2b3bd38bfea02560661cf947e058f9d361", "got_webrtc_revision_cp": "refs/heads/master@{#27753}", "mastername": "chromium.android", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "cb9dae5d0ff597027948ecc85eec11018803a8bb"}' --summary-json-file /b/swarming/w/ir/tmp/t/tmpIioO0t.json -- swarming collect -server https://chromium-swarm.appspot.com -worker 50 -task-summary-python -task-output-stdout all -verbose -requests-json /b/swarming/w/ir/tmp/t/tmpCS4PKS.json in dir /b/swarming/w/ir/k: allow_subannotations: True cmd: ['python', '-u', '/b/swarming/w/ir/kitchen-checkout/build/scripts/tools/runit.py', '--show-path', '--with-third-party-lib', '--', 'python', '/b/swarming/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/collect_task.py', '--verbose', '-o', '/b/swarming/w/ir/tmp/t/tmpYuqJrg.json', '--task-output-dir', '/b/swarming/w/ir/tmp/t/tmpQ2blE2', '--merge-script', '/b/swarming/w/ir/cache/builder/src/build/android/pylib/results/presentation/test_results_presentation.py', '--merge-script-stdout-file', '/b/swarming/w/ir/tmp/t/tmpWc8yM3merge_script_log', '--merge-additional-args', '["--bucket", "chromium-result-details", "--test-name", "gcm_unit_tests"]', '--build-properties', '{"bot_id": "swarm1596-c4", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1556198555874897, "id": "8915201259034326704", "project": "chromium", "tags": ["build_address:luci.chromium.ci/android-marshmallow-arm64-rel/14705", "builder:android-marshmallow-arm64-rel", "buildset:commit/git/cb9dae5d0ff597027948ecc85eec11018803a8bb", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cb9dae5d0ff597027948ecc85eec11018803a8bb", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9080631321242183552", "scheduler_job_id:chromium/android-marshmallow-arm64-rel", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "android-marshmallow-arm64-rel", "buildnumber": 14705, "got_angle_revision": "1b0acbb5126e7f7d03bde3bde6d4b2fba20811c8", "got_dawn_revision": "22cee9ae36b23a8908525d668ef4728a26c931c4", "got_nacl_revision": "6abc006f6760ec49350cd45e8bccbff4809725ac", "got_revision": "cb9dae5d0ff597027948ecc85eec11018803a8bb", "got_revision_cp": "refs/heads/master@{#654004}", "got_swarming_client_revision": "aa60736aded9fc32a0e21a81f5fc51f6009d01f3", "got_v8_revision": "2531f0784031894907b009a0a2de46ea8bc04547", "got_v8_revision_cp": "refs/heads/7.6.29@{#1}", "got_webrtc_revision": "03e85d2b3bd38bfea02560661cf947e058f9d361", "got_webrtc_revision_cp": "refs/heads/master@{#27753}", "mastername": "chromium.android", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "cb9dae5d0ff597027948ecc85eec11018803a8bb"}', '--summary-json-file', '/b/swarming/w/ir/tmp/t/tmpIioO0t.json', '--', 'swarming', 'collect', '-server', 'https://chromium-swarm.appspot.com', '-worker', '50', '-task-summary-python', '-task-output-stdout', 'all', '-verbose', '-requests-json', '/b/swarming/w/ir/tmp/t/tmpCS4PKS.json'] env: FrozenDict([('PATH', '/b/swarming/w/ir/cache/builder/src/third_party/android_tools/sdk/platform-tools:/b/swarming/w/ir/cache/builder/src/build/android:%(PATH)s'), ('CHROME_HEADLESS', '1')]) env_prefixes: {'mapping': FrozenDict([('PATH', ('/b/swarming/w/ir/cache/swarming_client',))]), 'pathsep': ':'} env_suffixes: {'mapping': FrozenDict([]), 'pathsep': ':'} infra_step: False name_tokens: ['gcm_unit_tests on Android device Nexus 5X'] ok_ret: ALL_OK step_test_data: gen_default_step_test_data(...) trigger_specs: [] full environment: ADDRFAM: inet BOTO_CONFIG: /b/swarming/w/ir/tmp/gsutil-task/.boto BUILDBUCKET_EXPERIMENTAL: FALSE CHROME_HEADLESS: 1 CIPD_CACHE_DIR: /b/swarming/cipd_cache/cache CIPD_PROTOCOL: v2 DEVSHELL_CLIENT_PORT: 36648 DOCKER_CONFIG: /b/swarming/w/ir/tmp/docker-cfg-task DOCKER_TMPDIR: /b/swarming/w/ir/tmp/docker-tmp-task GIT_CONFIG_NOSYSTEM: 1 GIT_TERMINAL_PROMPT: 0 HOME: /home/chrome-bot IFACE: eth0 INFRA_GIT_WRAPPER_HOME: /b/swarming/w/ir/tmp/git-home-task LOGDOG_COORDINATOR_HOST: logs.chromium.org LOGDOG_STREAM_PREFIX: buildbucket/cr-buildbucket.appspot.com/8915201259034326704 LOGDOG_STREAM_PROJECT: chromium LOGDOG_STREAM_SERVER_PATH: unix:/b/swarming/w/ir/tmp/ld.sock LOGICAL: eth0 LUCI_CONTEXT: /b/swarming/w/ir/tmp/luci_context.355376662 MAC_CHROMIUM_TMPDIR: /b/swarming/w/ir/tmp/t METHOD: dhcp NO_GCE_CHECK: False PATH: /b/swarming/w/ir/cache/swarming_client:/b/swarming/w/ir/cache/builder/src/third_party/android_tools/sdk/platform-tools:/b/swarming/w/ir/cache/builder/src/build/android:/b/swarming/w/ir/cipd_bin_packages:/b/swarming/w/ir/cipd_bin_packages/bin:/b/swarming/cipd_cache/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin PWD: /b/swarming/w/ir/k PYTHONIOENCODING: UTF-8 PYTHONUNBUFFERED: 1 ROOT_SETUP_LOG: /var/log/messages/chromebuild/root-setup.log SHLVL: 1 STARTUP_LOG: /var/log/messages/chromebuild/startup.log SWARMING_BOT_ID: swarm1596-c4 SWARMING_EXTERNAL_BOT_SETUP: 1 SWARMING_HEADLESS: 1 SWARMING_SERVER: https://chromium-swarm.appspot.com SWARMING_TASK_ID: 446d7b0ca5858311 TEMP: /b/swarming/w/ir/tmp/t TEMPDIR: /b/swarming/w/ir/tmp/t TERM: linux TMP: /b/swarming/w/ir/tmp/t TMPDIR: /b/swarming/w/ir/tmp/t UPSTART_EVENTS: net-device-up UPSTART_INSTANCE: UPSTART_JOB: chromebuild-startup USER: chrome-bot USERNAME: chrome-bot VPYTHON_VIRTUALENV_ROOT: /b/swarming/w/ir/cache/vpython _: /b/swarming/w/ir/cipd_bin_packages/vpython Set PYTHONPATH: /b/swarming/w/ir/kitchen-checkout/build/scripts:/b/swarming/w/ir/kitchen-checkout/build/site_config:/b/swarming/w/ir/kitchen-checkout/build/third_party:/b/swarming/w/ir/kitchen-checkout/build/third_party/buildbot_8_4p1:/b/swarming/w/ir/kitchen-checkout/build/third_party/buildbot_slave_8_4:/b/swarming/w/ir/kitchen-checkout/build/third_party/coverage-3.7.1:/b/swarming/w/ir/kitchen-checkout/build/third_party/decorator_3_3_1:/b/swarming/w/ir/kitchen-checkout/build/third_party/google_api_python_client:/b/swarming/w/ir/kitchen-checkout/build/third_party/httplib2/python2:/b/swarming/w/ir/kitchen-checkout/build/third_party/infra_libs:/b/swarming/w/ir/kitchen-checkout/build/third_party/jinja2:/b/swarming/w/ir/kitchen-checkout/build/third_party/markupsafe:/b/swarming/w/ir/kitchen-checkout/build/third_party/oauth2client:/b/swarming/w/ir/kitchen-checkout/build/third_party/pyasn1:/b/swarming/w/ir/kitchen-checkout/build/third_party/pyasn1-modules:/b/swarming/w/ir/kitchen-checkout/build/third_party/python-rsa:/b/swarming/w/ir/kitchen-checkout/build/third_party/requests_2_10_0:/b/swarming/w/ir/kitchen-checkout/build/third_party/setuptools-0.6c11:/b/swarming/w/ir/kitchen-checkout/build/third_party/sqlalchemy_0_7_1:/b/swarming/w/ir/kitchen-checkout/build/third_party/sqlalchemy_migrate_0_7_1:/b/swarming/w/ir/kitchen-checkout/build/third_party/tempita_0_5:/b/swarming/w/ir/kitchen-checkout/build/third_party/twisted_10_2:/b/swarming/w/ir/kitchen-checkout/build/third_party/uritemplate:/b/swarming/w/ir/kitchen-checkout/build/third_party/site-packages 2019-04-25 06:53:31,059 - root: [DEBUG] Using task_output_dir: '/b/swarming/w/ir/tmp/t/tmpQ2blE2' 2019-04-25 06:53:31,059 - root: [WARNING] task_output_dir '/b/swarming/w/ir/tmp/t/tmpQ2blE2' already exists! 2019-04-25 06:53:31,060 - root: [WARNING] task_output_dir existing content: [] 2019-04-25 06:53:31,060 - 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/tmpCS4PKS.json -output-dir /b/swarming/w/ir/tmp/t/tmpQ2blE2 -task-summary-json /b/swarming/w/ir/tmp/t/tmpIioO0t.json [D2019-04-25T06:53:31.067226-07:00 2520 0 auth.go:1265] Minting a new token {"key":"luci_ctx/6124543ccb0771a4c71756551eb23695b805b0180689ca9428449737ecad291e", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-04-25T06:53:31.067296-07:00 2520 0 luci_ctx.go:138] POST http://127.0.0.1:35596/rpc/LuciLocalAuthService.GetOAuthToken {"key":"luci_ctx/6124543ccb0771a4c71756551eb23695b805b0180689ca9428449737ecad291e", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-04-25T06:53:31.069612-07:00 2520 0 auth.go:1222] Token expires in 53m52.930505135s {"key":"luci_ctx/6124543ccb0771a4c71756551eb23695b805b0180689ca9428449737ecad291e", "scopes":"https://www.googleapis.com/auth/userinfo.email"} 446d94d2ca9fa410: exit 0 /b/swarming/swarming_bot.1.zip/third_party/requests/__init__.py:83: RequestsDependencyWarning: Old version of cryptography ([1, 2, 3]) may cause slowdown. Additional test environment: CHROME_DEVEL_SANDBOX=/opt/chromium/chrome_sandbox CHROME_HEADLESS=1 LANG=en_US.UTF-8 Command: /b/swarming/w/ir/.swarming_module_cache/vpython/3bcbb9/bin/python ../../build/android/test_wrapper/logdog_wrapper.py --target gcm_unit_tests --logdog-bin-cmd ../../bin/logdog_butler --store-tombstones --gs-results-bucket=chromium-result-details --recover-devices --test-launcher-summary-output=/b/swarming/w/ioDblHq8/output.json I 0.000s Main command: bin/../../../build/android/test_runner.py gtest --output-directory bin/../. --runtime-deps-path bin/../gen.runtime/google_apis/gcm/gcm_unit_tests__test_runner_script.runtime_deps --suite gcm_unit_tests -v --store-tombstones --gs-results-bucket=chromium-result-details --recover-devices --test-launcher-summary-output=/b/swarming/w/ioDblHq8/output.json I 0.007s Main condition '<lambda>' met I 0.009s Main condition '<lambda>' met I 3.187s TimeoutThread-1-for-prepare_device(01e15da9a27dae8e) condition 'sd_card_ready' met (0.0s) I 3.766s TimeoutThread-1-for-prepare_device(01e15da9a27dae8e) condition 'pm_ready' met (0.6s) I 3.806s TimeoutThread-1-for-prepare_device(01e15da9a27dae8e) condition 'boot_completed' met (0.7s) I 12.794s TimeoutThread-1-for-individual_device_set_up(01e15da9a27dae8e) Setting permissions for org.chromium.native_test. I 16.120s calculate_device_checksums condition '<lambda>' met (0.1s) I 17.775s TimeoutThread-1-for-individual_device_set_up(01e15da9a27dae8e) Pushing 2530 files via .zip of size 6015703 I 39.120s list_tests(01e15da9a27dae8e) flags: I 39.121s list_tests(01e15da9a27dae8e) --gtest_list_tests I 40.710s list_tests(01e15da9a27dae8e) /sdcard/temp_file-18b764912a96e.gtest_out size on device: 4980 I 40.831s Main Using external sharding settings. This is shard 0/1 I 40.831s Main STARTING TRY #1/3 I 40.832s Main Will run 188 tests on 1 devices: 01e15da9a27dae8e W 40.935s run_tests_on_device(01e15da9a27dae8e) No tombstones to clear. I 44.778s run_tests_on_device(01e15da9a27dae8e) flags: I 44.778s run_tests_on_device(01e15da9a27dae8e) Getting logdog client. I 49.699s run_tests_on_device(01e15da9a27dae8e) /sdcard/temp_file-6588fb42df16d.gtest_out size on device: 43581 I 49.917s archive Writing text to logdog stream, logcat_logcat_4598254317288053905_20190425T130559-UTC_01e15da9a27dae8e I 49.919s run_tests_on_device(01e15da9a27dae8e) Logcat saved to https://luci-logdog.appspot.com/v/?s=chromium%2Fandroid%2Fswarming%2Flogcats%2F446d6ad47f6b2611%2F%2B%2Flogcat_logcat_4598254317288053905_20190425T130559-UTC_01e15da9a27dae8e I 50.568s TimeoutThread-1-for-run_tests_on_device(01e15da9a27dae8e) Setting permissions for org.chromium.native_test. I 53.830s run_tests_on_device(01e15da9a27dae8e) >>ScopedMainEntryLogger I 53.831s run_tests_on_device(01e15da9a27dae8e) Note: Google Test filter = AccountMappingTest.DeserializeAccountMapping:AccountMappingTest.DeserializeAccountMappingInvalidInput:AccountMappingTest.SerializeAccountMapping:CheckinRequestTest.AndroidIdEqualsZeroInResponse:CheckinRequestTest.FetcherDataAndURL:CheckinRequestTest.ResponseBodyCorrupted:CheckinRequestTest.ResponseBodyEmpty:CheckinRequestTest.ResponseHttpStatusBadRequest:CheckinRequestTest.ResponseHttpStatusNotOK:CheckinRequestTest.ResponseHttpStatusUnauthorized:CheckinRequestTest.ResponseMissingAndroidId:CheckinRequestTest.ResponseMissingSecurityToken:CheckinRequestTest.SecurityTokenEqualsZeroInResponse:CheckinRequestTest.SuccessfulFirstTimeCheckin:CheckinRequestTest.SuccessfulSubsequentCheckin:ConnectionEventTrackerTest.SuccessfulAttempt:ConnectionFactoryImplTest.CanarySucceedsRetryDuringLogin:ConnectionFactoryImplTest.CanarySucceedsThenDisconnects:ConnectionFactoryImplTest.ConnectFail:ConnectionFactoryImplTest.ConnectSuccess:ConnectionFactoryImplTest.ConnectionResetRace:ConnectionFactoryImplTest.FailThenNetworkChangeEvent:ConnectionFactoryImplTest.FailThenSucceed:ConnectionFactoryImplTest.FailViaSignalReset:ConnectionFactoryImplTest.IgnoreResetWhileConnecting:ConnectionFactoryImplTest.Initialize:ConnectionFactoryImplTest.MultipleFailuresThenSucceed:ConnectionFactoryImplTest.MultipleFailuresWrapClientEvents:ConnectionFactoryImplTest.NetworkChangeBeforeFirstConnection:ConnectionFactoryImplTest.SignalResetRestoresBackoff:GCMConnectionHandlerImplTest.2ExtraLargeDataPacketMsgs:GCMConnectionHandlerImplTest.ExtraLargeDataPacket:GCMConnectionHandlerImplTest.Init:GCMConnectionHandlerImplTest.InitFailedVersionCheck:GCMConnectionHandlerImplTest.InitIncompleteTimeout:GCMConnectionHandlerImplTest.InitTimeout:GCMConnectionHandlerImplTest.InvalidData:GCMConnectionHandlerImplTest.InvalidDataLong:GCMConnectionHandlerImplTest.InvalidTag:GCMConnectionHandlerImplTest.ReInit:GCMConnectionHandlerImplTest.ReadTimeout:GCMConnectionHandlerImplTest.Recv2LongMsgs:GCMConnectionHandlerImplTest.Recv2Msgs:GCMConnectionHandlerImplTest.RecvLongMsg:GCMConnectionHandlerImplTest.RecvLongMsg2Parts:GCMConnectionHandlerImplTest.RecvMsg:GCMConnectionHandlerImplTest.RecvMsgNoData:GCMConnectionHandlerImplTest.RecvMsgSplitSize:GCMConnectionHandlerImplTest.SendMsg:GCMConnectionHandlerImplTest.SendMsgSocketDisconnected:GCMRegistrationRequestTest.MaximumAttemptsReached:GCMRegistrationRequestTest.MaximumAttemptsReachedWithZeroRetries:GCMRegistrationRequestTest.RequestDataAndURL:GCMRegistrationRequestTest.RequestNotSuccessful:GCMRegistrationRequestTest.RequestRegistrationWithMultipleSenderIds:GCMRegistrationRequestTest.RequestSuccessful:GCMRegistrationRequestTest.ResponseAuthenticationError:GCMRegistrationRequestTest.ResponseDeviceRegistrationError:GCMRegistrationRequestTest.ResponseHttpNotOk:GCMRegistrationRequestTest.ResponseHttpStatusNotOK:GCMRegistrationRequestTest.ResponseInternalServerError:GCMRegistrationRequestTest.ResponseInvalidParameters:GCMRegistrationRequestTest.ResponseInvalidSender:GCMRegistrationRequestTest.ResponseInvalidSenderBadRequest:GCMRegistrationRequestTest.ResponseMissingRegistrationId:GCMRegistrationRequestTest.ResponseParsing:GCMRegistrationRequestTest.ResponseParsingFailed:GCMRegistrationRequestTest.ResponseQuotaExceeded:GCMRegistrationRequestTest.ResponseTooManyRegistrations:GCMSocketStreamTest.ReadAsync:GCMSocketStreamTest.ReadDataSync:GCMSocketStreamTest.ReadDisconnected:GCMSocketStreamTest.ReadError:GCMSocketStreamTest.ReadPartialDataSync:GCMSocketStreamTest.ReadThenWrite:GCMSocketStreamTest.TwoReadsAtOnce:GCMSocketStreamTest.TwoReadsAtOnceWithRebuild:GCMSocketStreamTest.WriteDisconnected:GCMSocketStreamTest.WriteError:GCMSocketStreamTest.WriteFull:GCMSocketStreamTest.WriteNone:GCMSocketStreamTest.WritePartial:GCMSocketStreamTest.WritePartialWithLengthChecking:GCMSocketStreamTest.WriteThenRead:GCMStoreImplTest.AccountMapping:GCMStoreImplTest.AddMessageAfterDestroy:GCMStoreImplTest.DeviceCredentials:GCMStoreImplTest.GServicesSettings_ProtocolV2:GCMStoreImplTest.HeartbeatInterval:GCMStoreImplTest.IncomingAndOutgoingMessages:GCMStoreImplTest.IncomingMessages:GCMStoreImplTest.InstanceIDData:GCMStoreImplTest.LastCheckinInfo:GCMStoreImplTest.LastTokenFetchTime:GCMStoreImplTest.LoadNew:GCMStoreImplTest.LoadWithEmptyDirectory:GCMStoreImplTest.LoadWithoutCreatingNewStore:GCMStoreImplTest.OutgoingMessages:GCMStoreImplTest.PerAppMessageLimits:GCMStoreImplTest.Registrations:GCMStoreImplTest.ReloadAfterClose:GCMUnregistrationRequestTest.DeviceRegistrationError:GCMUnregistrationRequestTest.IncorrectAppId:GCMUnregistrationRequestTest.InternalServerError:GCMUnregistrationRequestTest.InvalidParametersError:GCMUnregistrationRequestTest.MaximumAttemptsReached:GCMUnregistrationRequestTest.MaximumAttemptsReachedWithZeroRetries:GCMUnregistrationRequestTest.RequestDataPassedToFetcher:GCMUnregistrationRequestTest.ResponseEmpty:GCMUnregistrationRequestTest.ResponseHttpStatusNotOK:GCMUnregistrationRequestTest.ResponseParsingFailed:GCMUnregistrationRequestTest.ServiceUnavailable:GCMUnregistrationRequestTest.SuccessfulUnregistration:GCMUnregistrationRequestTest.UnkwnownError:GServicesSettingsTest.CalculateDigest:GServicesSettingsTest.CheckinResponseMinimumCheckinInterval:GServicesSettingsTest.CheckinResponseUpdateCheckinInterval:GServicesSettingsTest.CheckinResponseUpdateCheckinURL:GServicesSettingsTest.CheckinResponseUpdateMCSHostname:GServicesSettingsTest.CheckinResponseUpdateMCSSecurePort:GServicesSettingsTest.CheckinResponseUpdateRegistrationURL:GServicesSettingsTest.DefaultSettingsAndDigest:GServicesSettingsTest.UpdateFromCheckinResponseSettingsDiff:GServicesSettingsTest.UpdateFromEmptyLoadResult:GServicesSettingsTest.UpdateFromLoadResult:GServicesSettingsTest.UpdateFromLoadResultWithSettingMissing:HeartbeatManagerTest.AckBeforeStart:HeartbeatManagerTest.AckedHeartbeat:HeartbeatManagerTest.ClientIntervalAfterHeartbeatTriggered:HeartbeatManagerTest.ClientIntervalInvalid:HeartbeatManagerTest.Init:HeartbeatManagerTest.MissedHeartbeat:HeartbeatManagerTest.SetClientHeartbeatInterval:HeartbeatManagerTest.Start:HeartbeatManagerTest.StartThenUpdateInterval:HeartbeatManagerTest.Stop:HeartbeatManagerTest.UnackedHeartbeat:HeartbeatManagerTest.UpdateIntervalThenStart:HeartbeatManagerTest.UpdateTimerAfterStart:HeartbeatManagerTest.UpdateTimerBeforeStart:InstaceIDDeleteTokenRequestTest.InvalidParametersError:InstaceIDDeleteTokenRequestTest.RequestDataPassedToFetcher:InstaceIDDeleteTokenRequestTest.RequestDataWithSubtype:InstaceIDDeleteTokenRequestTest.ResponseHttpStatusNotOK:InstaceIDDeleteTokenRequestTest.SuccessfulUnregistration:InstaceIDDeleteTokenRequestTest.UnkwnownError:InstanceIDGetTokenRequestTest.RequestDataAndURL:InstanceIDGetTokenRequestTest.RequestDataWithSubtype:InstanceIDGetTokenRequestTest.RequestSuccessful:InstanceIDGetTokenRequestTest.ResponseHttpStatusNotOK:MCSClientTest.AckOnLogin:MCSClientTest.AckOnSend:MCSClientTest.AckWhenImmediateAckRequested:MCSClientTest.AckWhenLimitReachedWithHeartbeat:MCSClientTest.CollapseKeysDifferentApp:MCSClientTest.CollapseKeysDifferentUser:MCSClientTest.CollapseKeysSameApp:MCSClientTest.CustomHeartbeatIntervalRemoveShorterInterval:MCSClientTest.CustomHeartbeatIntervalSecondIntervalLonger:MCSClientTest.CustomHeartbeatIntervalSecondIntervalShorter:MCSClientTest.CustomHeartbeatIntervalSetBeforeInitialize:MCSClientTest.CustomHeartbeatIntervalSetBeforeLogin:MCSClientTest.CustomHeartbeatIntervalSingleInterval:MCSClientTest.CustomHeartbeatIntervalTooLong:MCSClientTest.CustomHeartbeatIntervalTooShort:MCSClientTest.ExpiredTTLOnRestart:MCSClientTest.ExpiredTTLOnSend:MCSClientTest.FailLogin:MCSClientTest.InitializeExisting:MCSClientTest.InitializeNew:MCSClientTest.LoginSuccess:MCSClientTest.SelectiveAckMidStream:MCSClientTest.SendMessageNoRMQ:MCSClientTest.SendMessageNoRMQWhileDisconnected:MCSClientTest.SendMessageRMQ:MCSClientTest.SendMessageRMQAckOnReconnect:MCSClientTest.SendMessageRMQOnRestart:MCSClientTest.SendMessageRMQPartialAckOnReconnect:MCSClientTest.SendMessageRMQWhileDisconnected:MCSClientTest.SendMessageRMQWithStreamAck:MCSMessageTest.InitInferTag:MCSMessageTest.InitPassOwnership:MCSMessageTest.InitWithTag:MCSMessageTest.Invalid:MCSUtilTest.BuildLoginRequest:MCSUtilTest.PersistentIds:MCSUtilTest.ProtobufToTag:MCSUtilTest.StreamIds I 53.831s run_tests_on_device(01e15da9a27dae8e) [==========] Running 188 tests from 16 test suites. I 53.831s run_tests_on_device(01e15da9a27dae8e) [----------] Global test environment set-up. I 53.831s run_tests_on_device(01e15da9a27dae8e) [----------] 4 tests from MCSMessageTest I 53.831s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSMessageTest.Invalid I 53.831s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSMessageTest.Invalid (1 ms) I 53.831s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSMessageTest.InitInferTag I 53.831s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSMessageTest.InitInferTag (2 ms) I 53.831s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSMessageTest.InitWithTag I 53.831s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSMessageTest.InitWithTag (2 ms) I 53.831s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSMessageTest.InitPassOwnership I 53.831s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSMessageTest.InitPassOwnership (1 ms) I 53.832s run_tests_on_device(01e15da9a27dae8e) [----------] 4 tests from MCSMessageTest (7 ms total) I 53.832s run_tests_on_device(01e15da9a27dae8e) I 53.832s run_tests_on_device(01e15da9a27dae8e) [----------] 4 tests from MCSUtilTest I 53.832s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSUtilTest.BuildLoginRequest I 53.832s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSUtilTest.BuildLoginRequest (2 ms) I 53.832s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSUtilTest.ProtobufToTag I 53.832s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSUtilTest.ProtobufToTag (1 ms) I 53.832s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSUtilTest.PersistentIds I 53.832s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSUtilTest.PersistentIds (1 ms) I 53.832s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSUtilTest.StreamIds I 53.832s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSUtilTest.StreamIds (2 ms) I 53.832s run_tests_on_device(01e15da9a27dae8e) [----------] 4 tests from MCSUtilTest (7 ms total) I 53.832s run_tests_on_device(01e15da9a27dae8e) I 53.832s run_tests_on_device(01e15da9a27dae8e) [----------] 15 tests from GCMSocketStreamTest I 53.832s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMSocketStreamTest.ReadDataSync I 53.833s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMSocketStreamTest.ReadDataSync (11 ms) I 53.833s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMSocketStreamTest.ReadPartialDataSync I 53.833s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMSocketStreamTest.ReadPartialDataSync (4 ms) I 53.833s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMSocketStreamTest.ReadAsync I 53.833s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMSocketStreamTest.ReadAsync (4 ms) I 53.833s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMSocketStreamTest.TwoReadsAtOnce I 53.833s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMSocketStreamTest.TwoReadsAtOnce (6 ms) I 53.833s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMSocketStreamTest.TwoReadsAtOnceWithRebuild I 53.833s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMSocketStreamTest.TwoReadsAtOnceWithRebuild (4 ms) I 53.833s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMSocketStreamTest.ReadError I 53.833s run_tests_on_device(01e15da9a27dae8e) [ERROR:socket_stream.cc(219)] Closing stream with result -2 I 53.833s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMSocketStreamTest.ReadError (6 ms) I 53.833s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMSocketStreamTest.ReadDisconnected I 53.833s run_tests_on_device(01e15da9a27dae8e) [ERROR:socket_stream.cc(219)] Closing stream with result -2 I 53.834s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMSocketStreamTest.ReadDisconnected (4 ms) I 53.834s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMSocketStreamTest.WriteFull I 53.834s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMSocketStreamTest.WriteFull (4 ms) I 53.834s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMSocketStreamTest.WritePartial I 53.834s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMSocketStreamTest.WritePartial (4 ms) I 53.834s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMSocketStreamTest.WritePartialWithLengthChecking I 53.834s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMSocketStreamTest.WritePartialWithLengthChecking (4 ms) I 53.834s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMSocketStreamTest.WriteNone I 53.834s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMSocketStreamTest.WriteNone (4 ms) I 53.834s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMSocketStreamTest.WriteThenRead I 53.834s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMSocketStreamTest.WriteThenRead (4 ms) I 53.834s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMSocketStreamTest.ReadThenWrite I 53.834s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMSocketStreamTest.ReadThenWrite (4 ms) I 53.834s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMSocketStreamTest.WriteError I 53.835s run_tests_on_device(01e15da9a27dae8e) [ERROR:socket_stream.cc(300)] Failed to flush socket. I 53.835s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMSocketStreamTest.WriteError (5 ms) I 53.835s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMSocketStreamTest.WriteDisconnected I 53.835s run_tests_on_device(01e15da9a27dae8e) [ERROR:socket_stream.cc(300)] Failed to flush socket. I 53.835s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMSocketStreamTest.WriteDisconnected (5 ms) I 53.835s run_tests_on_device(01e15da9a27dae8e) [----------] 15 tests from GCMSocketStreamTest (77 ms total) I 53.835s run_tests_on_device(01e15da9a27dae8e) I 53.835s run_tests_on_device(01e15da9a27dae8e) [----------] 3 tests from AccountMappingTest I 53.835s run_tests_on_device(01e15da9a27dae8e) [ RUN ] AccountMappingTest.SerializeAccountMapping I 53.835s run_tests_on_device(01e15da9a27dae8e) [ OK ] AccountMappingTest.SerializeAccountMapping (1 ms) I 53.835s run_tests_on_device(01e15da9a27dae8e) [ RUN ] AccountMappingTest.DeserializeAccountMapping I 53.835s run_tests_on_device(01e15da9a27dae8e) [ OK ] AccountMappingTest.DeserializeAccountMapping (1 ms) I 53.835s run_tests_on_device(01e15da9a27dae8e) [ RUN ] AccountMappingTest.DeserializeAccountMappingInvalidInput I 53.835s run_tests_on_device(01e15da9a27dae8e) [ OK ] AccountMappingTest.DeserializeAccountMappingInvalidInput (2 ms) I 53.836s run_tests_on_device(01e15da9a27dae8e) [----------] 3 tests from AccountMappingTest (4 ms total) I 53.836s run_tests_on_device(01e15da9a27dae8e) I 53.836s run_tests_on_device(01e15da9a27dae8e) [----------] 12 tests from CheckinRequestTest I 53.836s run_tests_on_device(01e15da9a27dae8e) [ RUN ] CheckinRequestTest.FetcherDataAndURL I 53.836s run_tests_on_device(01e15da9a27dae8e) [ OK ] CheckinRequestTest.FetcherDataAndURL (3 ms) I 53.836s run_tests_on_device(01e15da9a27dae8e) [ RUN ] CheckinRequestTest.ResponseBodyEmpty I 53.836s run_tests_on_device(01e15da9a27dae8e) [libprotobuf ERROR ../../third_party/protobuf/src/google/protobuf/message_lite.cc:121] Can't parse message of type "checkin_proto.AndroidCheckinResponse" because it is missing required fields: (cannot determine missing fields for lite message)[ERROR:checkin_request.cc(242)] Failed to get checkin response. HTTP Status: 200. Retrying. I 53.836s run_tests_on_device(01e15da9a27dae8e) [ OK ] CheckinRequestTest.ResponseBodyEmpty (5 ms) I 53.836s run_tests_on_device(01e15da9a27dae8e) [ RUN ] CheckinRequestTest.ResponseBodyCorrupted I 53.836s run_tests_on_device(01e15da9a27dae8e) [ERROR:checkin_request.cc(242)] Failed to get checkin response. HTTP Status: 200. Retrying. I 53.836s run_tests_on_device(01e15da9a27dae8e) [ OK ] CheckinRequestTest.ResponseBodyCorrupted (4 ms) I 53.836s run_tests_on_device(01e15da9a27dae8e) [ RUN ] CheckinRequestTest.ResponseHttpStatusUnauthorized I 53.836s run_tests_on_device(01e15da9a27dae8e) [ERROR:checkin_request.cc(231)] No point retrying the checkin with status: 401. Checkin failed. I 53.836s run_tests_on_device(01e15da9a27dae8e) [ OK ] CheckinRequestTest.ResponseHttpStatusUnauthorized (4 ms) I 53.837s run_tests_on_device(01e15da9a27dae8e) [ RUN ] CheckinRequestTest.ResponseHttpStatusBadRequest I 53.837s run_tests_on_device(01e15da9a27dae8e) [ERROR:checkin_request.cc(231)] No point retrying the checkin with status: 400. Checkin failed. I 53.837s run_tests_on_device(01e15da9a27dae8e) [ OK ] CheckinRequestTest.ResponseHttpStatusBadRequest (4 ms) I 53.837s run_tests_on_device(01e15da9a27dae8e) [ RUN ] CheckinRequestTest.ResponseHttpStatusNotOK I 53.837s run_tests_on_device(01e15da9a27dae8e) [ERROR:checkin_request.cc(242)] Failed to get checkin response. HTTP Status: 500. Retrying. I 53.837s run_tests_on_device(01e15da9a27dae8e) [ OK ] CheckinRequestTest.ResponseHttpStatusNotOK (4 ms) I 53.837s run_tests_on_device(01e15da9a27dae8e) [ RUN ] CheckinRequestTest.ResponseMissingAndroidId I 53.837s run_tests_on_device(01e15da9a27dae8e) [ERROR:checkin_request.cc(255)] Android ID or security token is 0. Retrying. I 53.837s run_tests_on_device(01e15da9a27dae8e) [ OK ] CheckinRequestTest.ResponseMissingAndroidId (5 ms) I 53.837s run_tests_on_device(01e15da9a27dae8e) [ RUN ] CheckinRequestTest.ResponseMissingSecurityToken I 53.837s run_tests_on_device(01e15da9a27dae8e) [ERROR:checkin_request.cc(255)] Android ID or security token is 0. Retrying. I 53.837s run_tests_on_device(01e15da9a27dae8e) [ OK ] CheckinRequestTest.ResponseMissingSecurityToken (4 ms) I 53.837s run_tests_on_device(01e15da9a27dae8e) [ RUN ] CheckinRequestTest.AndroidIdEqualsZeroInResponse I 53.838s run_tests_on_device(01e15da9a27dae8e) [ERROR:checkin_request.cc(255)] Android ID or security token is 0. Retrying. I 53.838s run_tests_on_device(01e15da9a27dae8e) [ OK ] CheckinRequestTest.AndroidIdEqualsZeroInResponse (4 ms) I 53.838s run_tests_on_device(01e15da9a27dae8e) [ RUN ] CheckinRequestTest.SecurityTokenEqualsZeroInResponse I 53.838s run_tests_on_device(01e15da9a27dae8e) [ERROR:checkin_request.cc(255)] Android ID or security token is 0. Retrying. I 53.838s run_tests_on_device(01e15da9a27dae8e) [ OK ] CheckinRequestTest.SecurityTokenEqualsZeroInResponse (4 ms) I 53.838s run_tests_on_device(01e15da9a27dae8e) [ RUN ] CheckinRequestTest.SuccessfulFirstTimeCheckin I 53.838s run_tests_on_device(01e15da9a27dae8e) [ OK ] CheckinRequestTest.SuccessfulFirstTimeCheckin (3 ms) I 53.838s run_tests_on_device(01e15da9a27dae8e) [ RUN ] CheckinRequestTest.SuccessfulSubsequentCheckin I 53.838s run_tests_on_device(01e15da9a27dae8e) [ OK ] CheckinRequestTest.SuccessfulSubsequentCheckin (3 ms) I 53.838s run_tests_on_device(01e15da9a27dae8e) [----------] 12 tests from CheckinRequestTest (50 ms total) I 53.838s run_tests_on_device(01e15da9a27dae8e) I 53.838s run_tests_on_device(01e15da9a27dae8e) [----------] 1 test from ConnectionEventTrackerTest I 53.838s run_tests_on_device(01e15da9a27dae8e) [ RUN ] ConnectionEventTrackerTest.SuccessfulAttempt I 53.838s run_tests_on_device(01e15da9a27dae8e) [ OK ] ConnectionEventTrackerTest.SuccessfulAttempt (2 ms) I 53.839s run_tests_on_device(01e15da9a27dae8e) [----------] 1 test from ConnectionEventTrackerTest (2 ms total) I 53.839s run_tests_on_device(01e15da9a27dae8e) I 53.839s run_tests_on_device(01e15da9a27dae8e) [----------] 14 tests from ConnectionFactoryImplTest I 53.839s run_tests_on_device(01e15da9a27dae8e) [ RUN ] ConnectionFactoryImplTest.Initialize I 53.839s run_tests_on_device(01e15da9a27dae8e) [ OK ] ConnectionFactoryImplTest.Initialize (5 ms) I 53.839s run_tests_on_device(01e15da9a27dae8e) [ RUN ] ConnectionFactoryImplTest.ConnectSuccess I 53.839s run_tests_on_device(01e15da9a27dae8e) [ OK ] ConnectionFactoryImplTest.ConnectSuccess (4 ms) I 53.839s run_tests_on_device(01e15da9a27dae8e) [ RUN ] ConnectionFactoryImplTest.ConnectFail I 53.839s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.839s run_tests_on_device(01e15da9a27dae8e) [ OK ] ConnectionFactoryImplTest.ConnectFail (4 ms) I 53.839s run_tests_on_device(01e15da9a27dae8e) [ RUN ] ConnectionFactoryImplTest.FailThenSucceed I 53.839s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.839s run_tests_on_device(01e15da9a27dae8e) [ OK ] ConnectionFactoryImplTest.FailThenSucceed (5 ms) I 53.839s run_tests_on_device(01e15da9a27dae8e) [ RUN ] ConnectionFactoryImplTest.MultipleFailuresThenSucceed I 53.840s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.840s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.840s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.840s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.840s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.840s run_tests_on_device(01e15da9a27dae8e) [ OK ] ConnectionFactoryImplTest.MultipleFailuresThenSucceed (32 ms) I 53.840s run_tests_on_device(01e15da9a27dae8e) [ RUN ] ConnectionFactoryImplTest.FailThenNetworkChangeEvent I 53.840s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.840s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -2 I 53.840s run_tests_on_device(01e15da9a27dae8e) [ OK ] ConnectionFactoryImplTest.FailThenNetworkChangeEvent (14 ms) I 53.840s run_tests_on_device(01e15da9a27dae8e) [ RUN ] ConnectionFactoryImplTest.CanarySucceedsThenDisconnects I 53.840s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.840s run_tests_on_device(01e15da9a27dae8e) [ OK ] ConnectionFactoryImplTest.CanarySucceedsThenDisconnects (12 ms) I 53.841s run_tests_on_device(01e15da9a27dae8e) [ RUN ] ConnectionFactoryImplTest.CanarySucceedsRetryDuringLogin I 53.841s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.841s run_tests_on_device(01e15da9a27dae8e) [ OK ] ConnectionFactoryImplTest.CanarySucceedsRetryDuringLogin (12 ms) I 53.841s run_tests_on_device(01e15da9a27dae8e) [ RUN ] ConnectionFactoryImplTest.FailViaSignalReset I 53.841s run_tests_on_device(01e15da9a27dae8e) [ OK ] ConnectionFactoryImplTest.FailViaSignalReset (10 ms) I 53.841s run_tests_on_device(01e15da9a27dae8e) [ RUN ] ConnectionFactoryImplTest.IgnoreResetWhileConnecting I 53.841s run_tests_on_device(01e15da9a27dae8e) [ OK ] ConnectionFactoryImplTest.IgnoreResetWhileConnecting (9 ms) I 53.841s run_tests_on_device(01e15da9a27dae8e) [ RUN ] ConnectionFactoryImplTest.SignalResetRestoresBackoff I 53.841s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.841s run_tests_on_device(01e15da9a27dae8e) [ OK ] ConnectionFactoryImplTest.SignalResetRestoresBackoff (13 ms) I 53.841s run_tests_on_device(01e15da9a27dae8e) [ RUN ] ConnectionFactoryImplTest.NetworkChangeBeforeFirstConnection I 53.841s run_tests_on_device(01e15da9a27dae8e) [ OK ] ConnectionFactoryImplTest.NetworkChangeBeforeFirstConnection (9 ms) I 53.841s run_tests_on_device(01e15da9a27dae8e) [ RUN ] ConnectionFactoryImplTest.ConnectionResetRace I 53.841s run_tests_on_device(01e15da9a27dae8e) [ OK ] ConnectionFactoryImplTest.ConnectionResetRace (10 ms) I 53.842s run_tests_on_device(01e15da9a27dae8e) [ RUN ] ConnectionFactoryImplTest.MultipleFailuresWrapClientEvents I 53.842s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.842s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.842s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.842s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.842s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.842s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.842s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.842s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.842s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.842s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.842s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.842s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.842s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.843s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.843s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.843s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.843s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.843s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.843s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.843s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.843s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.843s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.843s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.843s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.843s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.843s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.843s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.844s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.844s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.844s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.844s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.844s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.844s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.844s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.844s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.844s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.844s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.844s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.844s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.844s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.844s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.845s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.845s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.845s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.845s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.845s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.845s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.845s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.845s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.845s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.845s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 53.845s run_tests_on_device(01e15da9a27dae8e) [ OK ] ConnectionFactoryImplTest.MultipleFailuresWrapClientEvents (546 ms) I 53.845s run_tests_on_device(01e15da9a27dae8e) [----------] 14 tests from ConnectionFactoryImplTest (693 ms total) I 53.845s run_tests_on_device(01e15da9a27dae8e) I 53.845s run_tests_on_device(01e15da9a27dae8e) [----------] 20 tests from GCMConnectionHandlerImplTest I 53.845s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMConnectionHandlerImplTest.Init I 53.846s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMConnectionHandlerImplTest.Init (19 ms) I 53.846s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMConnectionHandlerImplTest.InitFailedVersionCheck I 53.846s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_handler_impl.cc(295)] Invalid GCM version response: 37 I 53.846s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMConnectionHandlerImplTest.InitFailedVersionCheck (18 ms) I 53.846s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMConnectionHandlerImplTest.InitTimeout I 53.846s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_handler_impl.cc(471)] Timed out waiting for GCM Protocol buffer. I 53.846s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMConnectionHandlerImplTest.InitTimeout (121 ms) I 53.846s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMConnectionHandlerImplTest.InitIncompleteTimeout I 53.846s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_handler_impl.cc(471)] Timed out waiting for GCM Protocol buffer. I 53.846s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMConnectionHandlerImplTest.InitIncompleteTimeout (131 ms) I 53.846s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMConnectionHandlerImplTest.ReInit I 53.846s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_handler_impl.cc(471)] Timed out waiting for GCM Protocol buffer. I 53.846s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMConnectionHandlerImplTest.ReInit (135 ms) I 53.846s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMConnectionHandlerImplTest.RecvMsg I 53.847s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMConnectionHandlerImplTest.RecvMsg (20 ms) I 53.847s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMConnectionHandlerImplTest.Recv2Msgs I 53.847s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMConnectionHandlerImplTest.Recv2Msgs (17 ms) I 53.847s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMConnectionHandlerImplTest.RecvLongMsg I 53.847s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMConnectionHandlerImplTest.RecvLongMsg (17 ms) I 53.847s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMConnectionHandlerImplTest.RecvLongMsg2Parts I 53.847s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMConnectionHandlerImplTest.RecvLongMsg2Parts (16 ms) I 53.847s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMConnectionHandlerImplTest.Recv2LongMsgs I 53.847s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMConnectionHandlerImplTest.Recv2LongMsgs (13 ms) I 53.847s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMConnectionHandlerImplTest.ReadTimeout I 53.847s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_handler_impl.cc(471)] Timed out waiting for GCM Protocol buffer. I 53.847s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMConnectionHandlerImplTest.ReadTimeout (122 ms) I 53.847s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMConnectionHandlerImplTest.RecvMsgNoData I 53.847s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMConnectionHandlerImplTest.RecvMsgNoData (21 ms) I 53.847s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMConnectionHandlerImplTest.SendMsg I 53.848s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMConnectionHandlerImplTest.SendMsg (15 ms) I 53.848s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMConnectionHandlerImplTest.SendMsgSocketDisconnected I 53.848s run_tests_on_device(01e15da9a27dae8e) [ERROR:socket_stream.cc(300)] Failed to flush socket. I 53.848s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMConnectionHandlerImplTest.SendMsgSocketDisconnected (16 ms) I 53.848s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMConnectionHandlerImplTest.ExtraLargeDataPacket I 53.848s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMConnectionHandlerImplTest.ExtraLargeDataPacket (14 ms) I 53.848s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMConnectionHandlerImplTest.2ExtraLargeDataPacketMsgs I 53.848s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMConnectionHandlerImplTest.2ExtraLargeDataPacketMsgs (15 ms) I 53.848s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMConnectionHandlerImplTest.InvalidTag I 53.848s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_handler_impl.cc(399)] Received message of invalid type 100 I 53.848s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMConnectionHandlerImplTest.InvalidTag (13 ms) I 53.848s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMConnectionHandlerImplTest.RecvMsgSplitSize I 53.848s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMConnectionHandlerImplTest.RecvMsgSplitSize (11 ms) I 53.848s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMConnectionHandlerImplTest.InvalidData I 53.849s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_handler_impl.cc(409)] Unable to parse GCM message of type 8 I 53.849s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMConnectionHandlerImplTest.InvalidData (12 ms) I 53.849s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMConnectionHandlerImplTest.InvalidDataLong I 53.849s run_tests_on_device(01e15da9a27dae8e) [ERROR:connection_handler_impl.cc(428)] Unable to parse GCM message of type 8 I 53.849s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMConnectionHandlerImplTest.InvalidDataLong (12 ms) I 53.849s run_tests_on_device(01e15da9a27dae8e) [----------] 20 tests from GCMConnectionHandlerImplTest (772 ms total) I 53.849s run_tests_on_device(01e15da9a27dae8e) I 53.849s run_tests_on_device(01e15da9a27dae8e) [----------] 17 tests from GCMStoreImplTest I 53.849s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMStoreImplTest.LoadNew I 53.849s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMStoreImplTest.LoadNew (22 ms) I 53.849s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMStoreImplTest.LoadWithoutCreatingNewStore I 53.849s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMStoreImplTest.LoadWithoutCreatingNewStore (6 ms) I 53.849s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMStoreImplTest.LoadWithEmptyDirectory I 53.849s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMStoreImplTest.LoadWithEmptyDirectory (6 ms) I 53.849s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMStoreImplTest.DeviceCredentials I 53.850s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMStoreImplTest.DeviceCredentials (28 ms) I 53.850s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMStoreImplTest.LastCheckinInfo I 53.850s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(1033)] Failed to restore last checkin time. Using default = 0. I 53.850s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMStoreImplTest.LastCheckinInfo (42 ms) I 53.850s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMStoreImplTest.GServicesSettings_ProtocolV2 I 53.850s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMStoreImplTest.GServicesSettings_ProtocolV2 (34 ms) I 53.850s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMStoreImplTest.Registrations I 53.850s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMStoreImplTest.Registrations (24 ms) I 53.850s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMStoreImplTest.IncomingMessages I 53.850s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMStoreImplTest.IncomingMessages (55 ms) I 53.850s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMStoreImplTest.OutgoingMessages I 53.850s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMStoreImplTest.OutgoingMessages (60 ms) I 53.850s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMStoreImplTest.IncomingAndOutgoingMessages I 53.850s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMStoreImplTest.IncomingAndOutgoingMessages (95 ms) I 53.851s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMStoreImplTest.PerAppMessageLimits I 53.851s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMStoreImplTest.PerAppMessageLimits (134 ms) I 53.851s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMStoreImplTest.AccountMapping I 53.851s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMStoreImplTest.AccountMapping (25 ms) I 53.851s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMStoreImplTest.HeartbeatInterval I 53.851s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMStoreImplTest.HeartbeatInterval (23 ms) I 53.851s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMStoreImplTest.AddMessageAfterDestroy I 53.851s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.851s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.851s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.851s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.851s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.851s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.851s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.852s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.852s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.852s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.852s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.852s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.852s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.852s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.852s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.852s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.852s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.853s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.853s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.853s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.853s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.853s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.853s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.853s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.853s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.853s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.854s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.854s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.854s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.854s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.854s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.854s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.854s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.854s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.854s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.854s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.854s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.854s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.854s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.854s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 53.855s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMStoreImplTest.AddMessageAfterDestroy (23 ms) I 53.855s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMStoreImplTest.ReloadAfterClose I 53.855s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMStoreImplTest.ReloadAfterClose (14 ms) I 53.855s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMStoreImplTest.LastTokenFetchTime I 53.855s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(1114)] Failed to restore last token fetching time. Using default = 0. I 53.855s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMStoreImplTest.LastTokenFetchTime (18 ms) I 53.855s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMStoreImplTest.InstanceIDData I 53.855s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMStoreImplTest.InstanceIDData (20 ms) I 53.855s run_tests_on_device(01e15da9a27dae8e) [----------] 17 tests from GCMStoreImplTest (636 ms total) I 53.855s run_tests_on_device(01e15da9a27dae8e) I 53.855s run_tests_on_device(01e15da9a27dae8e) [----------] 12 tests from GServicesSettingsTest I 53.855s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GServicesSettingsTest.DefaultSettingsAndDigest I 53.855s run_tests_on_device(01e15da9a27dae8e) [ OK ] GServicesSettingsTest.DefaultSettingsAndDigest (5 ms) I 53.855s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GServicesSettingsTest.CalculateDigest I 53.856s run_tests_on_device(01e15da9a27dae8e) [ OK ] GServicesSettingsTest.CalculateDigest (4 ms) I 53.856s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GServicesSettingsTest.UpdateFromEmptyLoadResult I 53.856s run_tests_on_device(01e15da9a27dae8e) [ OK ] GServicesSettingsTest.UpdateFromEmptyLoadResult (4 ms) I 53.856s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GServicesSettingsTest.UpdateFromLoadResultWithSettingMissing I 53.856s run_tests_on_device(01e15da9a27dae8e) [ OK ] GServicesSettingsTest.UpdateFromLoadResultWithSettingMissing (3 ms) I 53.856s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GServicesSettingsTest.UpdateFromLoadResult I 53.856s run_tests_on_device(01e15da9a27dae8e) [ OK ] GServicesSettingsTest.UpdateFromLoadResult (3 ms) I 53.856s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GServicesSettingsTest.CheckinResponseMinimumCheckinInterval I 53.856s run_tests_on_device(01e15da9a27dae8e) [ OK ] GServicesSettingsTest.CheckinResponseMinimumCheckinInterval (3 ms) I 53.856s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GServicesSettingsTest.CheckinResponseUpdateCheckinInterval I 53.856s run_tests_on_device(01e15da9a27dae8e) [ OK ] GServicesSettingsTest.CheckinResponseUpdateCheckinInterval (3 ms) I 53.856s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GServicesSettingsTest.CheckinResponseUpdateRegistrationURL I 53.856s run_tests_on_device(01e15da9a27dae8e) [ OK ] GServicesSettingsTest.CheckinResponseUpdateRegistrationURL (1 ms) I 53.856s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GServicesSettingsTest.CheckinResponseUpdateCheckinURL I 53.857s run_tests_on_device(01e15da9a27dae8e) [ OK ] GServicesSettingsTest.CheckinResponseUpdateCheckinURL (1 ms) I 53.857s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GServicesSettingsTest.CheckinResponseUpdateMCSHostname I 53.857s run_tests_on_device(01e15da9a27dae8e) [ OK ] GServicesSettingsTest.CheckinResponseUpdateMCSHostname (1 ms) I 53.857s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GServicesSettingsTest.CheckinResponseUpdateMCSSecurePort I 53.857s run_tests_on_device(01e15da9a27dae8e) [ OK ] GServicesSettingsTest.CheckinResponseUpdateMCSSecurePort (1 ms) I 53.857s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GServicesSettingsTest.UpdateFromCheckinResponseSettingsDiff I 53.857s run_tests_on_device(01e15da9a27dae8e) [ OK ] GServicesSettingsTest.UpdateFromCheckinResponseSettingsDiff (1 ms) I 53.857s run_tests_on_device(01e15da9a27dae8e) [----------] 12 tests from GServicesSettingsTest (33 ms total) I 53.857s run_tests_on_device(01e15da9a27dae8e) I 53.857s run_tests_on_device(01e15da9a27dae8e) [----------] 14 tests from HeartbeatManagerTest I 53.857s run_tests_on_device(01e15da9a27dae8e) [ RUN ] HeartbeatManagerTest.Init I 53.858s run_tests_on_device(01e15da9a27dae8e) [ OK ] HeartbeatManagerTest.Init (1 ms) I 53.858s run_tests_on_device(01e15da9a27dae8e) [ RUN ] HeartbeatManagerTest.AckBeforeStart I 53.858s run_tests_on_device(01e15da9a27dae8e) [ OK ] HeartbeatManagerTest.AckBeforeStart (2 ms) I 53.858s run_tests_on_device(01e15da9a27dae8e) [ RUN ] HeartbeatManagerTest.Start I 53.858s run_tests_on_device(01e15da9a27dae8e) [ OK ] HeartbeatManagerTest.Start (1 ms) I 53.858s run_tests_on_device(01e15da9a27dae8e) [ RUN ] HeartbeatManagerTest.AckedHeartbeat I 53.858s run_tests_on_device(01e15da9a27dae8e) [ OK ] HeartbeatManagerTest.AckedHeartbeat (1 ms) I 53.858s run_tests_on_device(01e15da9a27dae8e) [ RUN ] HeartbeatManagerTest.UnackedHeartbeat I 53.858s run_tests_on_device(01e15da9a27dae8e) [WARNING:heartbeat_manager.cc(165)] Lost connection to MCS, reconnecting. I 53.858s run_tests_on_device(01e15da9a27dae8e) [ OK ] HeartbeatManagerTest.UnackedHeartbeat (2 ms) I 53.858s run_tests_on_device(01e15da9a27dae8e) [ RUN ] HeartbeatManagerTest.UpdateIntervalThenStart I 53.858s run_tests_on_device(01e15da9a27dae8e) [ OK ] HeartbeatManagerTest.UpdateIntervalThenStart (1 ms) I 53.858s run_tests_on_device(01e15da9a27dae8e) [ RUN ] HeartbeatManagerTest.StartThenUpdateInterval I 53.858s run_tests_on_device(01e15da9a27dae8e) [ OK ] HeartbeatManagerTest.StartThenUpdateInterval (1 ms) I 53.858s run_tests_on_device(01e15da9a27dae8e) [ RUN ] HeartbeatManagerTest.UpdateTimerBeforeStart I 53.858s run_tests_on_device(01e15da9a27dae8e) [ OK ] HeartbeatManagerTest.UpdateTimerBeforeStart (1 ms) I 53.858s run_tests_on_device(01e15da9a27dae8e) [ RUN ] HeartbeatManagerTest.UpdateTimerAfterStart I 53.859s run_tests_on_device(01e15da9a27dae8e) [ OK ] HeartbeatManagerTest.UpdateTimerAfterStart (1 ms) I 53.859s run_tests_on_device(01e15da9a27dae8e) [ RUN ] HeartbeatManagerTest.Stop I 53.859s run_tests_on_device(01e15da9a27dae8e) [ OK ] HeartbeatManagerTest.Stop (1 ms) I 53.859s run_tests_on_device(01e15da9a27dae8e) [ RUN ] HeartbeatManagerTest.MissedHeartbeat I 53.859s run_tests_on_device(01e15da9a27dae8e) [ OK ] HeartbeatManagerTest.MissedHeartbeat (1 ms) I 53.859s run_tests_on_device(01e15da9a27dae8e) [ RUN ] HeartbeatManagerTest.SetClientHeartbeatInterval I 53.859s run_tests_on_device(01e15da9a27dae8e) [ OK ] HeartbeatManagerTest.SetClientHeartbeatInterval (1 ms) I 53.859s run_tests_on_device(01e15da9a27dae8e) [ RUN ] HeartbeatManagerTest.ClientIntervalInvalid I 53.859s run_tests_on_device(01e15da9a27dae8e) [ OK ] HeartbeatManagerTest.ClientIntervalInvalid (1 ms) I 53.859s run_tests_on_device(01e15da9a27dae8e) [ RUN ] HeartbeatManagerTest.ClientIntervalAfterHeartbeatTriggered I 53.859s run_tests_on_device(01e15da9a27dae8e) [ OK ] HeartbeatManagerTest.ClientIntervalAfterHeartbeatTriggered (1 ms) I 53.859s run_tests_on_device(01e15da9a27dae8e) [----------] 14 tests from HeartbeatManagerTest (18 ms total) I 53.859s run_tests_on_device(01e15da9a27dae8e) I 53.859s run_tests_on_device(01e15da9a27dae8e) [----------] 30 tests from MCSClientTest I 53.859s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.InitializeNew I 53.859s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.InitializeNew (7 ms) I 53.859s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.InitializeExisting I 53.859s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.InitializeExisting (17 ms) I 53.859s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.LoginSuccess I 53.859s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.LoginSuccess (8 ms) I 53.860s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.FailLogin I 53.860s run_tests_on_device(01e15da9a27dae8e) [ERROR:mcs_client.cc(707)] Failed to log in to GCM, resetting connection. I 53.860s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.FailLogin (9 ms) I 53.860s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.SendMessageNoRMQ I 53.860s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.SendMessageNoRMQ (8 ms) I 53.860s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.SendMessageNoRMQWhileDisconnected I 53.860s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.SendMessageNoRMQWhileDisconnected (8 ms) I 53.860s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.SendMessageRMQ I 53.860s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.SendMessageRMQ (8 ms) I 53.860s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.SendMessageRMQWhileDisconnected I 53.860s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.SendMessageRMQWhileDisconnected (14 ms) I 53.860s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.SendMessageRMQOnRestart I 53.860s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.SendMessageRMQOnRestart (21 ms) I 53.860s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.SendMessageRMQWithStreamAck I 53.860s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.SendMessageRMQWithStreamAck (55 ms) I 53.860s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.SendMessageRMQAckOnReconnect I 53.860s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.SendMessageRMQAckOnReconnect (40 ms) I 53.860s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.SendMessageRMQPartialAckOnReconnect I 53.860s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.SendMessageRMQPartialAckOnReconnect (42 ms) I 53.860s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.SelectiveAckMidStream I 53.861s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.SelectiveAckMidStream (33 ms) I 53.861s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.AckOnLogin I 53.861s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.AckOnLogin (29 ms) I 53.861s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.AckOnSend I 53.861s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.AckOnSend (23 ms) I 53.861s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.AckWhenLimitReachedWithHeartbeat I 53.861s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.AckWhenLimitReachedWithHeartbeat (56 ms) I 53.861s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.ExpiredTTLOnSend I 53.861s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.ExpiredTTLOnSend (13 ms) I 53.861s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.ExpiredTTLOnRestart I 53.861s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.ExpiredTTLOnRestart (26 ms) I 53.861s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.CollapseKeysSameApp I 53.861s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.CollapseKeysSameApp (15 ms) I 53.861s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.CollapseKeysDifferentApp I 53.861s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.CollapseKeysDifferentApp (16 ms) I 53.861s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.CollapseKeysDifferentUser I 53.861s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.CollapseKeysDifferentUser (16 ms) I 53.861s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.CustomHeartbeatIntervalTooShort I 53.861s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.CustomHeartbeatIntervalTooShort (19 ms) I 53.861s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.CustomHeartbeatIntervalTooLong I 53.861s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.CustomHeartbeatIntervalTooLong (17 ms) I 53.862s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.CustomHeartbeatIntervalSingleInterval I 53.862s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.CustomHeartbeatIntervalSingleInterval (24 ms) I 53.862s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.CustomHeartbeatIntervalSetBeforeInitialize I 53.862s run_tests_on_device(01e15da9a27dae8e) [ERROR:gcm_store_impl.cc(799)] GCMStore db doesn't exist. I 53.862s run_tests_on_device(01e15da9a27dae8e) [ERROR:mcs_client.cc(525)] GCM Update failed! I 53.862s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.CustomHeartbeatIntervalSetBeforeInitialize (13 ms) I 53.862s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.CustomHeartbeatIntervalSetBeforeLogin I 53.862s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.CustomHeartbeatIntervalSetBeforeLogin (16 ms) I 53.862s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.CustomHeartbeatIntervalSecondIntervalLonger I 53.862s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.CustomHeartbeatIntervalSecondIntervalLonger (25 ms) I 53.862s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.CustomHeartbeatIntervalSecondIntervalShorter I 53.862s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.CustomHeartbeatIntervalSecondIntervalShorter (21 ms) I 53.862s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.CustomHeartbeatIntervalRemoveShorterInterval I 53.862s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.CustomHeartbeatIntervalRemoveShorterInterval (24 ms) I 53.862s run_tests_on_device(01e15da9a27dae8e) [ RUN ] MCSClientTest.AckWhenImmediateAckRequested I 53.862s run_tests_on_device(01e15da9a27dae8e) [ OK ] MCSClientTest.AckWhenImmediateAckRequested (30 ms) I 53.862s run_tests_on_device(01e15da9a27dae8e) [----------] 30 tests from MCSClientTest (662 ms total) I 53.862s run_tests_on_device(01e15da9a27dae8e) I 53.862s run_tests_on_device(01e15da9a27dae8e) [----------] 19 tests from GCMRegistrationRequestTest I 53.862s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMRegistrationRequestTest.RequestSuccessful I 53.863s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMRegistrationRequestTest.RequestSuccessful (11 ms) I 53.863s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMRegistrationRequestTest.RequestDataAndURL I 53.863s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMRegistrationRequestTest.RequestDataAndURL (9 ms) I 53.863s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMRegistrationRequestTest.RequestRegistrationWithMultipleSenderIds I 53.863s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMRegistrationRequestTest.RequestRegistrationWithMultipleSenderIds (9 ms) I 53.863s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMRegistrationRequestTest.ResponseParsing I 53.863s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMRegistrationRequestTest.ResponseParsing (8 ms) I 53.863s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMRegistrationRequestTest.ResponseParsingFailed I 53.863s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMRegistrationRequestTest.ResponseParsingFailed (9 ms) I 53.863s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMRegistrationRequestTest.ResponseHttpStatusNotOK I 53.863s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMRegistrationRequestTest.ResponseHttpStatusNotOK (9 ms) I 53.863s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMRegistrationRequestTest.ResponseMissingRegistrationId I 53.863s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMRegistrationRequestTest.ResponseMissingRegistrationId (10 ms) I 53.863s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMRegistrationRequestTest.ResponseDeviceRegistrationError I 53.863s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMRegistrationRequestTest.ResponseDeviceRegistrationError (9 ms) I 53.863s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMRegistrationRequestTest.ResponseAuthenticationError I 53.863s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMRegistrationRequestTest.ResponseAuthenticationError (9 ms) I 53.863s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMRegistrationRequestTest.ResponseInternalServerError I 53.863s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMRegistrationRequestTest.ResponseInternalServerError (9 ms) I 53.863s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMRegistrationRequestTest.ResponseInvalidParameters I 53.863s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMRegistrationRequestTest.ResponseInvalidParameters (7 ms) I 53.863s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMRegistrationRequestTest.ResponseInvalidSender I 53.863s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMRegistrationRequestTest.ResponseInvalidSender (7 ms) I 53.863s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMRegistrationRequestTest.ResponseInvalidSenderBadRequest I 53.864s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMRegistrationRequestTest.ResponseInvalidSenderBadRequest (7 ms) I 53.864s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMRegistrationRequestTest.ResponseQuotaExceeded I 53.864s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMRegistrationRequestTest.ResponseQuotaExceeded (7 ms) I 53.864s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMRegistrationRequestTest.ResponseTooManyRegistrations I 53.864s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMRegistrationRequestTest.ResponseTooManyRegistrations (8 ms) I 53.864s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMRegistrationRequestTest.RequestNotSuccessful I 53.864s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMRegistrationRequestTest.RequestNotSuccessful (7 ms) I 53.864s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMRegistrationRequestTest.ResponseHttpNotOk I 53.864s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMRegistrationRequestTest.ResponseHttpNotOk (8 ms) I 53.864s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMRegistrationRequestTest.MaximumAttemptsReachedWithZeroRetries I 53.864s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMRegistrationRequestTest.MaximumAttemptsReachedWithZeroRetries (7 ms) I 53.864s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMRegistrationRequestTest.MaximumAttemptsReached I 53.864s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMRegistrationRequestTest.MaximumAttemptsReached (9 ms) I 53.864s run_tests_on_device(01e15da9a27dae8e) [----------] 19 tests from GCMRegistrationRequestTest (165 ms total) I 53.864s run_tests_on_device(01e15da9a27dae8e) I 53.864s run_tests_on_device(01e15da9a27dae8e) [----------] 4 tests from InstanceIDGetTokenRequestTest I 53.864s run_tests_on_device(01e15da9a27dae8e) [ RUN ] InstanceIDGetTokenRequestTest.RequestSuccessful I 53.864s run_tests_on_device(01e15da9a27dae8e) [ OK ] InstanceIDGetTokenRequestTest.RequestSuccessful (7 ms) I 53.864s run_tests_on_device(01e15da9a27dae8e) [ RUN ] InstanceIDGetTokenRequestTest.RequestDataAndURL I 53.864s run_tests_on_device(01e15da9a27dae8e) [ OK ] InstanceIDGetTokenRequestTest.RequestDataAndURL (6 ms) I 53.864s run_tests_on_device(01e15da9a27dae8e) [ RUN ] InstanceIDGetTokenRequestTest.RequestDataWithSubtype I 53.864s run_tests_on_device(01e15da9a27dae8e) [ OK ] InstanceIDGetTokenRequestTest.RequestDataWithSubtype (6 ms) I 53.864s run_tests_on_device(01e15da9a27dae8e) [ RUN ] InstanceIDGetTokenRequestTest.ResponseHttpStatusNotOK I 53.864s run_tests_on_device(01e15da9a27dae8e) [ OK ] InstanceIDGetTokenRequestTest.ResponseHttpStatusNotOK (9 ms) I 53.864s run_tests_on_device(01e15da9a27dae8e) [----------] 4 tests from InstanceIDGetTokenRequestTest (28 ms total) I 53.864s run_tests_on_device(01e15da9a27dae8e) I 53.865s run_tests_on_device(01e15da9a27dae8e) [----------] 13 tests from GCMUnregistrationRequestTest I 53.865s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMUnregistrationRequestTest.RequestDataPassedToFetcher I 53.865s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMUnregistrationRequestTest.RequestDataPassedToFetcher (6 ms) I 53.865s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMUnregistrationRequestTest.SuccessfulUnregistration I 53.865s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMUnregistrationRequestTest.SuccessfulUnregistration (7 ms) I 53.865s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMUnregistrationRequestTest.ResponseHttpStatusNotOK I 53.865s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMUnregistrationRequestTest.ResponseHttpStatusNotOK (9 ms) I 53.865s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMUnregistrationRequestTest.ResponseEmpty I 53.865s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMUnregistrationRequestTest.ResponseEmpty (7 ms) I 53.865s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMUnregistrationRequestTest.InvalidParametersError I 53.865s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMUnregistrationRequestTest.InvalidParametersError (7 ms) I 53.865s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMUnregistrationRequestTest.DeviceRegistrationError I 53.865s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMUnregistrationRequestTest.DeviceRegistrationError (7 ms) I 53.865s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMUnregistrationRequestTest.UnkwnownError I 53.865s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMUnregistrationRequestTest.UnkwnownError (6 ms) I 53.865s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMUnregistrationRequestTest.ServiceUnavailable I 53.865s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMUnregistrationRequestTest.ServiceUnavailable (8 ms) I 53.865s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMUnregistrationRequestTest.InternalServerError I 53.865s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMUnregistrationRequestTest.InternalServerError (8 ms) I 53.865s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMUnregistrationRequestTest.IncorrectAppId I 53.865s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMUnregistrationRequestTest.IncorrectAppId (7 ms) I 53.865s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMUnregistrationRequestTest.ResponseParsingFailed I 53.865s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMUnregistrationRequestTest.ResponseParsingFailed (7 ms) I 53.865s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMUnregistrationRequestTest.MaximumAttemptsReachedWithZeroRetries I 53.865s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMUnregistrationRequestTest.MaximumAttemptsReachedWithZeroRetries (6 ms) I 53.865s run_tests_on_device(01e15da9a27dae8e) [ RUN ] GCMUnregistrationRequestTest.MaximumAttemptsReached I 53.865s run_tests_on_device(01e15da9a27dae8e) [ OK ] GCMUnregistrationRequestTest.MaximumAttemptsReached (8 ms) I 53.866s run_tests_on_device(01e15da9a27dae8e) [----------] 13 tests from GCMUnregistrationRequestTest (100 ms total) I 53.866s run_tests_on_device(01e15da9a27dae8e) I 53.866s run_tests_on_device(01e15da9a27dae8e) [----------] 6 tests from InstaceIDDeleteTokenRequestTest I 53.866s run_tests_on_device(01e15da9a27dae8e) [ RUN ] InstaceIDDeleteTokenRequestTest.RequestDataPassedToFetcher I 53.866s run_tests_on_device(01e15da9a27dae8e) [ OK ] InstaceIDDeleteTokenRequestTest.RequestDataPassedToFetcher (5 ms) I 53.866s run_tests_on_device(01e15da9a27dae8e) [ RUN ] InstaceIDDeleteTokenRequestTest.RequestDataWithSubtype I 53.866s run_tests_on_device(01e15da9a27dae8e) [ OK ] InstaceIDDeleteTokenRequestTest.RequestDataWithSubtype (7 ms) I 53.866s run_tests_on_device(01e15da9a27dae8e) [ RUN ] InstaceIDDeleteTokenRequestTest.SuccessfulUnregistration I 53.866s run_tests_on_device(01e15da9a27dae8e) [ OK ] InstaceIDDeleteTokenRequestTest.SuccessfulUnregistration (7 ms) I 53.866s run_tests_on_device(01e15da9a27dae8e) [ RUN ] InstaceIDDeleteTokenRequestTest.ResponseHttpStatusNotOK I 53.866s run_tests_on_device(01e15da9a27dae8e) [ OK ] InstaceIDDeleteTokenRequestTest.ResponseHttpStatusNotOK (8 ms) I 53.866s run_tests_on_device(01e15da9a27dae8e) [ RUN ] InstaceIDDeleteTokenRequestTest.InvalidParametersError I 53.866s run_tests_on_device(01e15da9a27dae8e) [ OK ] InstaceIDDeleteTokenRequestTest.InvalidParametersError (7 ms) I 53.866s run_tests_on_device(01e15da9a27dae8e) [ RUN ] InstaceIDDeleteTokenRequestTest.UnkwnownError I 53.866s run_tests_on_device(01e15da9a27dae8e) [ OK ] InstaceIDDeleteTokenRequestTest.UnkwnownError (7 ms) I 53.866s run_tests_on_device(01e15da9a27dae8e) [----------] 6 tests from InstaceIDDeleteTokenRequestTest (42 ms total) I 53.866s run_tests_on_device(01e15da9a27dae8e) I 53.866s run_tests_on_device(01e15da9a27dae8e) [----------] Global test environment tear-down I 53.866s run_tests_on_device(01e15da9a27dae8e) [==========] 188 tests from 16 test suites ran. (3320 ms total) I 53.866s run_tests_on_device(01e15da9a27dae8e) [ PASSED ] 188 tests. I 53.866s run_tests_on_device(01e15da9a27dae8e) <<ScopedMainEntryLogger I 53.876s run_tests_on_device(01e15da9a27dae8e) Finished running tests on this device. I 53.891s Main FINISHED TRY #1/3 I 53.891s Main All tests completed. C 53.892s Main ******************************************************************************** C 53.892s Main Summary C 53.892s Main ******************************************************************************** C 53.893s Main [==========] 188 tests ran. C 53.893s Main [ PASSED ] 188 tests. C 53.893s Main ******************************************************************************** I 53.898s tear_down_device(01e15da9a27dae8e) Wrote device cache: /b/swarming/w/ir/out/Release/device_cache_01e15da9a27dae8e.json I 53.911s Main Generated json results file at /b/swarming/w/itGwmcNU/tmplp89Dd I 53.912s Main Finishing archiving output. [W2019-04-25T13:06:08.592852Z 12011 0 butler.go:240] Butler Context was cancelled. Initiating shutdown. {"error":"context canceled"} INFO:devil.utils.timeout_retry:condition 'logdog_stopped' not met [E2019-04-25T13:06:08.620341Z 12011 0 main.go:205] Butler terminated with error. {"error":"context canceled"} [E2019-04-25T13:06:08.620417Z 12011 0 main.go:233] Failed to serve. original error: context canceled [I2019-04-25T13:06:08.620631Z 12011 0 main.go:349] Terminating. {"returnCode":250} INFO:devil.utils.timeout_retry:condition 'logdog_stopped' met 2019-04-25 06:53:31,389 - root: [DEBUG] Contents of task_output_dir: ['/b/swarming/w/ir/tmp/t/tmpQ2blE2/446d94d2ca9fa410'] 2019-04-25 06:53:31,389 - root: [DEBUG] Found shard_json_files: ['/b/swarming/w/ir/tmp/t/tmpQ2blE2/446d94d2ca9fa410/output.json'] 2019-04-25 06:53:31,390 - root: [INFO] merge_cmd: /b/swarming/w/ir/cache/vpython/ba947a/bin/python /b/swarming/w/ir/cache/builder/src/build/android/pylib/results/presentation/test_results_presentation.py --build-properties {"bot_id": "swarm1596-c4", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1556198555874897, "id": "8915201259034326704", "project": "chromium", "tags": ["build_address:luci.chromium.ci/android-marshmallow-arm64-rel/14705", "builder:android-marshmallow-arm64-rel", "buildset:commit/git/cb9dae5d0ff597027948ecc85eec11018803a8bb", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cb9dae5d0ff597027948ecc85eec11018803a8bb", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9080631321242183552", "scheduler_job_id:chromium/android-marshmallow-arm64-rel", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "android-marshmallow-arm64-rel", "buildnumber": 14705, "got_angle_revision": "1b0acbb5126e7f7d03bde3bde6d4b2fba20811c8", "got_dawn_revision": "22cee9ae36b23a8908525d668ef4728a26c931c4", "got_nacl_revision": "6abc006f6760ec49350cd45e8bccbff4809725ac", "got_revision": "cb9dae5d0ff597027948ecc85eec11018803a8bb", "got_revision_cp": "refs/heads/master@{#654004}", "got_swarming_client_revision": "aa60736aded9fc32a0e21a81f5fc51f6009d01f3", "got_v8_revision": "2531f0784031894907b009a0a2de46ea8bc04547", "got_v8_revision_cp": "refs/heads/7.6.29@{#1}", "got_webrtc_revision": "03e85d2b3bd38bfea02560661cf947e058f9d361", "got_webrtc_revision_cp": "refs/heads/master@{#27753}", "mastername": "chromium.android", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "cb9dae5d0ff597027948ecc85eec11018803a8bb"} --summary-json /b/swarming/w/ir/tmp/t/tmpIioO0t.json --task-output-dir /b/swarming/w/ir/tmp/t/tmpQ2blE2 --bucket chromium-result-details --test-name gcm_unit_tests -o /b/swarming/w/ir/tmp/t/tmpYuqJrg.json /b/swarming/w/ir/tmp/t/tmpQ2blE2/446d94d2ca9fa410/output.json Running ['/b/swarming/w/ir/cache/vpython/ba947a/bin/python', '/b/swarming/w/ir/cache/builder/src/build/android/pylib/results/presentation/test_results_presentation.py', '--build-properties', '{"bot_id": "swarm1596-c4", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1556198555874897, "id": "8915201259034326704", "project": "chromium", "tags": ["build_address:luci.chromium.ci/android-marshmallow-arm64-rel/14705", "builder:android-marshmallow-arm64-rel", "buildset:commit/git/cb9dae5d0ff597027948ecc85eec11018803a8bb", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cb9dae5d0ff597027948ecc85eec11018803a8bb", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9080631321242183552", "scheduler_job_id:chromium/android-marshmallow-arm64-rel", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "android-marshmallow-arm64-rel", "buildnumber": 14705, "got_angle_revision": "1b0acbb5126e7f7d03bde3bde6d4b2fba20811c8", "got_dawn_revision": "22cee9ae36b23a8908525d668ef4728a26c931c4", "got_nacl_revision": "6abc006f6760ec49350cd45e8bccbff4809725ac", "got_revision": "cb9dae5d0ff597027948ecc85eec11018803a8bb", "got_revision_cp": "refs/heads/master@{#654004}", "got_swarming_client_revision": "aa60736aded9fc32a0e21a81f5fc51f6009d01f3", "got_v8_revision": "2531f0784031894907b009a0a2de46ea8bc04547", "got_v8_revision_cp": "refs/heads/7.6.29@{#1}", "got_webrtc_revision": "03e85d2b3bd38bfea02560661cf947e058f9d361", "got_webrtc_revision_cp": "refs/heads/master@{#27753}", "mastername": "chromium.android", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "cb9dae5d0ff597027948ecc85eec11018803a8bb"}', '--summary-json', '/b/swarming/w/ir/tmp/t/tmpIioO0t.json', '--task-output-dir', '/b/swarming/w/ir/tmp/t/tmpQ2blE2', u'--bucket', u'chromium-result-details', u'--test-name', u'gcm_unit_tests', '-o', '/b/swarming/w/ir/tmp/t/tmpYuqJrg.json', '/b/swarming/w/ir/tmp/t/tmpQ2blE2/446d94d2ca9fa410/output.json'] in None (env: None) Command ['/b/swarming/w/ir/cache/vpython/ba947a/bin/python', '/b/swarming/w/ir/cache/builder/src/build/android/pylib/results/presentation/test_results_presentation.py', '--build-properties', '{"bot_id": "swarm1596-c4", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1556198555874897, "id": "8915201259034326704", "project": "chromium", "tags": ["build_address:luci.chromium.ci/android-marshmallow-arm64-rel/14705", "builder:android-marshmallow-arm64-rel", "buildset:commit/git/cb9dae5d0ff597027948ecc85eec11018803a8bb", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cb9dae5d0ff597027948ecc85eec11018803a8bb", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9080631321242183552", "scheduler_job_id:chromium/android-marshmallow-arm64-rel", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "android-marshmallow-arm64-rel", "buildnumber": 14705, "got_angle_revision": "1b0acbb5126e7f7d03bde3bde6d4b2fba20811c8", "got_dawn_revision": "22cee9ae36b23a8908525d668ef4728a26c931c4", "got_nacl_revision": "6abc006f6760ec49350cd45e8bccbff4809725ac", "got_revision": "cb9dae5d0ff597027948ecc85eec11018803a8bb", "got_revision_cp": "refs/heads/master@{#654004}", "got_swarming_client_revision": "aa60736aded9fc32a0e21a81f5fc51f6009d01f3", "got_v8_revision": "2531f0784031894907b009a0a2de46ea8bc04547", "got_v8_revision_cp": "refs/heads/7.6.29@{#1}", "got_webrtc_revision": "03e85d2b3bd38bfea02560661cf947e058f9d361", "got_webrtc_revision_cp": "refs/heads/master@{#27753}", "mastername": "chromium.android", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "cb9dae5d0ff597027948ecc85eec11018803a8bb"}', '--summary-json', '/b/swarming/w/ir/tmp/t/tmpIioO0t.json', '--task-output-dir', '/b/swarming/w/ir/tmp/t/tmpQ2blE2', u'--bucket', u'chromium-result-details', u'--test-name', u'gcm_unit_tests', '-o', '/b/swarming/w/ir/tmp/t/tmpYuqJrg.json', '/b/swarming/w/ir/tmp/t/tmpQ2blE2/446d94d2ca9fa410/output.json'] returned exit code 0