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/tmpB49aKM.json --task-output-dir /b/swarming/w/ir/tmp/t/tmpJ48iYg --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/tmpS899OWmerge_script_log --merge-additional-args '["--bucket", "chromium-result-details", "--test-name", "gcm_unit_tests"]' --build-properties '{"bot_id": "swarm265-c4", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1553401120262048, "id": "8918134582878724400", "project": "chromium", "tags": ["build_address:luci.chromium.ci/android-kitkat-arm-rel/15741", "builder:android-kitkat-arm-rel", "buildset:commit/git/cc13ccb72be99fcd00eb725a5a85cb54d9e00263", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cc13ccb72be99fcd00eb725a5a85cb54d9e00263", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9083564647785995616", "scheduler_job_id:chromium/android-kitkat-arm-rel", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "android-kitkat-arm-rel", "buildnumber": 15741, "got_angle_revision": "eae464dd3092c1c09c4dc4d51a0f50ac5d007722", "got_dawn_revision": "07950e80fe36028ed9cca0a4a99a8b08e9bb4fdf", "got_nacl_revision": "de8da4841bc3d1ed020d798d5a7fd6fb3d817fa1", "got_revision": "cc13ccb72be99fcd00eb725a5a85cb54d9e00263", "got_revision_cp": "refs/heads/master@{#643710}", "got_swarming_client_revision": "aa60736aded9fc32a0e21a81f5fc51f6009d01f3", "got_v8_revision": "b346546b7795350b8c910ff06f9520e7f03224f0", "got_v8_revision_cp": "refs/heads/7.5.100@{#1}", "got_webrtc_revision": "85a4a93e77b163098e91f41d8e7415181f23d02c", "got_webrtc_revision_cp": "refs/heads/master@{#27257}", "mastername": "chromium.android", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "cc13ccb72be99fcd00eb725a5a85cb54d9e00263"}' --summary-json-file /b/swarming/w/ir/tmp/t/tmpcAYa6j.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/tmpWkXxcG.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/tmpB49aKM.json', '--task-output-dir', '/b/swarming/w/ir/tmp/t/tmpJ48iYg', '--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/tmpS899OWmerge_script_log', '--merge-additional-args', '["--bucket", "chromium-result-details", "--test-name", "gcm_unit_tests"]', '--build-properties', '{"bot_id": "swarm265-c4", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1553401120262048, "id": "8918134582878724400", "project": "chromium", "tags": ["build_address:luci.chromium.ci/android-kitkat-arm-rel/15741", "builder:android-kitkat-arm-rel", "buildset:commit/git/cc13ccb72be99fcd00eb725a5a85cb54d9e00263", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cc13ccb72be99fcd00eb725a5a85cb54d9e00263", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9083564647785995616", "scheduler_job_id:chromium/android-kitkat-arm-rel", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "android-kitkat-arm-rel", "buildnumber": 15741, "got_angle_revision": "eae464dd3092c1c09c4dc4d51a0f50ac5d007722", "got_dawn_revision": "07950e80fe36028ed9cca0a4a99a8b08e9bb4fdf", "got_nacl_revision": "de8da4841bc3d1ed020d798d5a7fd6fb3d817fa1", "got_revision": "cc13ccb72be99fcd00eb725a5a85cb54d9e00263", "got_revision_cp": "refs/heads/master@{#643710}", "got_swarming_client_revision": "aa60736aded9fc32a0e21a81f5fc51f6009d01f3", "got_v8_revision": "b346546b7795350b8c910ff06f9520e7f03224f0", "got_v8_revision_cp": "refs/heads/7.5.100@{#1}", "got_webrtc_revision": "85a4a93e77b163098e91f41d8e7415181f23d02c", "got_webrtc_revision_cp": "refs/heads/master@{#27257}", "mastername": "chromium.android", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "cc13ccb72be99fcd00eb725a5a85cb54d9e00263"}', '--summary-json-file', '/b/swarming/w/ir/tmp/t/tmpcAYa6j.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/tmpWkXxcG.json'] env: {'CHROME_HEADLESS': '1', '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'} env_prefixes: {'PATH': '/b/swarming/w/ir/cache/swarming_client'} env_suffixes: {} infra_step: False name_tokens: ('gcm_unit_tests on Android device Nexus 5',) ok_ret: ALL_OK step_test_data: <lambda>(...) 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: 46536 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/8918134582878724400 LOGDOG_STREAM_PROJECT: chromium LOGDOG_STREAM_SERVER_PATH: unix:/b/swarming/w/ir/tmp/ld.sock LOGICAL: eth0 LUCI_CONTEXT: /b/swarming/w/itSdOEhj/luci_context.825649008 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: swarm265-c4 SWARMING_EXTERNAL_BOT_SETUP: 1 SWARMING_HEADLESS: 1 SWARMING_SERVER: https://chromium-swarm.appspot.com SWARMING_TASK_ID: 43c6bd912f916011 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-03-23 21:59:23,965 - root: [DEBUG] Using task_output_dir: '/b/swarming/w/ir/tmp/t/tmpJ48iYg' 2019-03-23 21:59:23,965 - root: [WARNING] task_output_dir '/b/swarming/w/ir/tmp/t/tmpJ48iYg' already exists! 2019-03-23 21:59:23,965 - root: [WARNING] task_output_dir existing content: [] 2019-03-23 21:59:23,965 - 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/tmpWkXxcG.json -output-dir /b/swarming/w/ir/tmp/t/tmpJ48iYg -task-summary-json /b/swarming/w/ir/tmp/t/tmpcAYa6j.json [D2019-03-23T21:59:23.973273-07:00 28748 0 auth.go:1265] Minting a new token {"key":"luci_ctx/e3c1f9873a109cea9668a0889bc5fcc7e31a089203f3bf61f79019396f30baf8", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-03-23T21:59:23.973357-07:00 28748 0 luci_ctx.go:138] POST http://127.0.0.1:42249/rpc/LuciLocalAuthService.GetOAuthToken {"key":"luci_ctx/e3c1f9873a109cea9668a0889bc5fcc7e31a089203f3bf61f79019396f30baf8", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-03-23T21:59:23.975421-07:00 28748 0 auth.go:1222] Token expires in 47m27.024605362s {"key":"luci_ctx/e3c1f9873a109cea9668a0889bc5fcc7e31a089203f3bf61f79019396f30baf8", "scopes":"https://www.googleapis.com/auth/userinfo.email"} 43c6d4e574fcc510: exit 0 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/9ede37/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/ioPK69U_/output.json I 0.000s Main command: ../../build/android/test_runner.py gtest --suite gcm_unit_tests --output-directory . --runtime-deps-path gen.runtime/google_apis/gcm/gcm_unit_tests__test_runner_script.runtime_deps -v --store-tombstones --gs-results-bucket=chromium-result-details --recover-devices --test-launcher-summary-output=/b/swarming/w/ioPK69U_/output.json I 0.006s Main condition '<lambda>' met I 0.008s Main condition '<lambda>' met I 3.134s TimeoutThread-1-for-prepare_device(03dd6012215d1f2a) condition 'sd_card_ready' met (0.0s) I 3.686s TimeoutThread-1-for-prepare_device(03dd6012215d1f2a) condition 'pm_ready' met (0.6s) I 3.697s TimeoutThread-1-for-prepare_device(03dd6012215d1f2a) condition 'boot_completed' met (0.6s) I 8.022s calculate_device_checksums condition '<lambda>' met (0.5s) I 9.104s TimeoutThread-1-for-individual_device_set_up(03dd6012215d1f2a) Pushing 2529 files via .zip of size 6069427 I 14.851s list_tests(03dd6012215d1f2a) flags: I 14.851s list_tests(03dd6012215d1f2a) --gtest_list_tests I 16.187s list_tests(03dd6012215d1f2a) /storage/emulated/legacy/temp_file-e6b2db3bfad57.gtest_out size on device: 4980 I 16.255s Main Using external sharding settings. This is shard 0/1 I 16.256s Main STARTING TRY #1/3 I 16.256s Main Will run 188 tests on 1 devices: 03dd6012215d1f2a W 16.289s run_tests_on_device(03dd6012215d1f2a) No tombstones to clear. I 18.572s run_tests_on_device(03dd6012215d1f2a) flags: I 18.572s run_tests_on_device(03dd6012215d1f2a) Getting logdog client. I 22.267s run_tests_on_device(03dd6012215d1f2a) /storage/emulated/legacy/temp_file-465e960d8f00d.gtest_out size on device: 43556 I 22.402s run_tests_on_device(03dd6012215d1f2a) Logcat saved to https://luci-logdog.appspot.com/v/?s=chromium%2Fandroid%2Fswarming%2Flogcats%2F43c52873ba587a11%2F%2B%2Flogcat_logcat_4598254317288053905_20190323T205718-UTC_03dd6012215d1f2a I 22.402s archive Writing text to logdog stream, logcat_logcat_4598254317288053905_20190323T205718-UTC_03dd6012215d1f2a I 23.068s run_tests_on_device(03dd6012215d1f2a) >>ScopedMainEntryLogger I 23.068s run_tests_on_device(03dd6012215d1f2a) 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 23.068s run_tests_on_device(03dd6012215d1f2a) [==========] Running 188 tests from 16 test suites. I 23.068s run_tests_on_device(03dd6012215d1f2a) [----------] Global test environment set-up. I 23.068s run_tests_on_device(03dd6012215d1f2a) [----------] 4 tests from MCSMessageTest I 23.068s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSMessageTest.Invalid I 23.068s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSMessageTest.Invalid (1 ms) I 23.068s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSMessageTest.InitInferTag I 23.068s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSMessageTest.InitInferTag (1 ms) I 23.069s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSMessageTest.InitWithTag I 23.069s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSMessageTest.InitWithTag (1 ms) I 23.069s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSMessageTest.InitPassOwnership I 23.069s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSMessageTest.InitPassOwnership (0 ms) I 23.069s run_tests_on_device(03dd6012215d1f2a) [----------] 4 tests from MCSMessageTest (4 ms total) I 23.069s run_tests_on_device(03dd6012215d1f2a) I 23.069s run_tests_on_device(03dd6012215d1f2a) [----------] 4 tests from MCSUtilTest I 23.069s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSUtilTest.BuildLoginRequest I 23.069s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSUtilTest.BuildLoginRequest (1 ms) I 23.069s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSUtilTest.ProtobufToTag I 23.069s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSUtilTest.ProtobufToTag (1 ms) I 23.069s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSUtilTest.PersistentIds I 23.069s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSUtilTest.PersistentIds (0 ms) I 23.069s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSUtilTest.StreamIds I 23.069s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSUtilTest.StreamIds (1 ms) I 23.069s run_tests_on_device(03dd6012215d1f2a) [----------] 4 tests from MCSUtilTest (3 ms total) I 23.069s run_tests_on_device(03dd6012215d1f2a) I 23.069s run_tests_on_device(03dd6012215d1f2a) [----------] 15 tests from GCMSocketStreamTest I 23.069s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMSocketStreamTest.ReadDataSync I 23.069s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMSocketStreamTest.ReadDataSync (12 ms) I 23.069s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMSocketStreamTest.ReadPartialDataSync I 23.069s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMSocketStreamTest.ReadPartialDataSync (4 ms) I 23.069s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMSocketStreamTest.ReadAsync I 23.069s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMSocketStreamTest.ReadAsync (5 ms) I 23.069s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMSocketStreamTest.TwoReadsAtOnce I 23.069s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMSocketStreamTest.TwoReadsAtOnce (4 ms) I 23.069s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMSocketStreamTest.TwoReadsAtOnceWithRebuild I 23.069s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMSocketStreamTest.TwoReadsAtOnceWithRebuild (5 ms) I 23.069s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMSocketStreamTest.ReadError I 23.069s run_tests_on_device(03dd6012215d1f2a) [ERROR:socket_stream.cc(219)] Closing stream with result -2 I 23.069s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMSocketStreamTest.ReadError (4 ms) I 23.069s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMSocketStreamTest.ReadDisconnected I 23.069s run_tests_on_device(03dd6012215d1f2a) [ERROR:socket_stream.cc(219)] Closing stream with result -2 I 23.069s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMSocketStreamTest.ReadDisconnected (5 ms) I 23.069s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMSocketStreamTest.WriteFull I 23.069s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMSocketStreamTest.WriteFull (4 ms) I 23.069s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMSocketStreamTest.WritePartial I 23.069s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMSocketStreamTest.WritePartial (4 ms) I 23.069s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMSocketStreamTest.WritePartialWithLengthChecking I 23.069s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMSocketStreamTest.WritePartialWithLengthChecking (3 ms) I 23.069s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMSocketStreamTest.WriteNone I 23.069s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMSocketStreamTest.WriteNone (5 ms) I 23.069s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMSocketStreamTest.WriteThenRead I 23.069s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMSocketStreamTest.WriteThenRead (4 ms) I 23.069s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMSocketStreamTest.ReadThenWrite I 23.069s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMSocketStreamTest.ReadThenWrite (5 ms) I 23.069s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMSocketStreamTest.WriteError I 23.069s run_tests_on_device(03dd6012215d1f2a) [ERROR:socket_stream.cc(300)] Failed to flush socket. I 23.069s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMSocketStreamTest.WriteError (4 ms) I 23.069s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMSocketStreamTest.WriteDisconnected I 23.069s run_tests_on_device(03dd6012215d1f2a) [ERROR:socket_stream.cc(300)] Failed to flush socket. I 23.070s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMSocketStreamTest.WriteDisconnected (4 ms) I 23.070s run_tests_on_device(03dd6012215d1f2a) [----------] 15 tests from GCMSocketStreamTest (73 ms total) I 23.070s run_tests_on_device(03dd6012215d1f2a) I 23.070s run_tests_on_device(03dd6012215d1f2a) [----------] 3 tests from AccountMappingTest I 23.070s run_tests_on_device(03dd6012215d1f2a) [ RUN ] AccountMappingTest.SerializeAccountMapping I 23.070s run_tests_on_device(03dd6012215d1f2a) [ OK ] AccountMappingTest.SerializeAccountMapping (1 ms) I 23.070s run_tests_on_device(03dd6012215d1f2a) [ RUN ] AccountMappingTest.DeserializeAccountMapping I 23.070s run_tests_on_device(03dd6012215d1f2a) [ OK ] AccountMappingTest.DeserializeAccountMapping (1 ms) I 23.070s run_tests_on_device(03dd6012215d1f2a) [ RUN ] AccountMappingTest.DeserializeAccountMappingInvalidInput I 23.070s run_tests_on_device(03dd6012215d1f2a) [ OK ] AccountMappingTest.DeserializeAccountMappingInvalidInput (1 ms) I 23.070s run_tests_on_device(03dd6012215d1f2a) [----------] 3 tests from AccountMappingTest (3 ms total) I 23.070s run_tests_on_device(03dd6012215d1f2a) I 23.070s run_tests_on_device(03dd6012215d1f2a) [----------] 12 tests from CheckinRequestTest I 23.070s run_tests_on_device(03dd6012215d1f2a) [ RUN ] CheckinRequestTest.FetcherDataAndURL I 23.070s run_tests_on_device(03dd6012215d1f2a) [ OK ] CheckinRequestTest.FetcherDataAndURL (2 ms) I 23.070s run_tests_on_device(03dd6012215d1f2a) [ RUN ] CheckinRequestTest.ResponseBodyEmpty I 23.070s run_tests_on_device(03dd6012215d1f2a) [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 23.070s run_tests_on_device(03dd6012215d1f2a) [ OK ] CheckinRequestTest.ResponseBodyEmpty (4 ms) I 23.070s run_tests_on_device(03dd6012215d1f2a) [ RUN ] CheckinRequestTest.ResponseBodyCorrupted I 23.070s run_tests_on_device(03dd6012215d1f2a) [ERROR:checkin_request.cc(242)] Failed to get checkin response. HTTP Status: 200. Retrying. I 23.070s run_tests_on_device(03dd6012215d1f2a) [ OK ] CheckinRequestTest.ResponseBodyCorrupted (4 ms) I 23.070s run_tests_on_device(03dd6012215d1f2a) [ RUN ] CheckinRequestTest.ResponseHttpStatusUnauthorized I 23.070s run_tests_on_device(03dd6012215d1f2a) [ERROR:checkin_request.cc(231)] No point retrying the checkin with status: 401. Checkin failed. I 23.070s run_tests_on_device(03dd6012215d1f2a) [ OK ] CheckinRequestTest.ResponseHttpStatusUnauthorized (3 ms) I 23.070s run_tests_on_device(03dd6012215d1f2a) [ RUN ] CheckinRequestTest.ResponseHttpStatusBadRequest I 23.070s run_tests_on_device(03dd6012215d1f2a) [ERROR:checkin_request.cc(231)] No point retrying the checkin with status: 400. Checkin failed. I 23.070s run_tests_on_device(03dd6012215d1f2a) [ OK ] CheckinRequestTest.ResponseHttpStatusBadRequest (3 ms) I 23.070s run_tests_on_device(03dd6012215d1f2a) [ RUN ] CheckinRequestTest.ResponseHttpStatusNotOK I 23.070s run_tests_on_device(03dd6012215d1f2a) [ERROR:checkin_request.cc(242)] Failed to get checkin response. HTTP Status: 500. Retrying. I 23.070s run_tests_on_device(03dd6012215d1f2a) [ OK ] CheckinRequestTest.ResponseHttpStatusNotOK (5 ms) I 23.070s run_tests_on_device(03dd6012215d1f2a) [ RUN ] CheckinRequestTest.ResponseMissingAndroidId I 23.070s run_tests_on_device(03dd6012215d1f2a) [ERROR:checkin_request.cc(255)] Android ID or security token is 0. Retrying. I 23.070s run_tests_on_device(03dd6012215d1f2a) [ OK ] CheckinRequestTest.ResponseMissingAndroidId (4 ms) I 23.070s run_tests_on_device(03dd6012215d1f2a) [ RUN ] CheckinRequestTest.ResponseMissingSecurityToken I 23.070s run_tests_on_device(03dd6012215d1f2a) [ERROR:checkin_request.cc(255)] Android ID or security token is 0. Retrying. I 23.070s run_tests_on_device(03dd6012215d1f2a) [ OK ] CheckinRequestTest.ResponseMissingSecurityToken (4 ms) I 23.070s run_tests_on_device(03dd6012215d1f2a) [ RUN ] CheckinRequestTest.AndroidIdEqualsZeroInResponse I 23.070s run_tests_on_device(03dd6012215d1f2a) [ERROR:checkin_request.cc(255)] Android ID or security token is 0. Retrying. I 23.070s run_tests_on_device(03dd6012215d1f2a) [ OK ] CheckinRequestTest.AndroidIdEqualsZeroInResponse (7 ms) I 23.070s run_tests_on_device(03dd6012215d1f2a) [ RUN ] CheckinRequestTest.SecurityTokenEqualsZeroInResponse I 23.070s run_tests_on_device(03dd6012215d1f2a) [ERROR:checkin_request.cc(255)] Android ID or security token is 0. Retrying. I 23.070s run_tests_on_device(03dd6012215d1f2a) [ OK ] CheckinRequestTest.SecurityTokenEqualsZeroInResponse (4 ms) I 23.070s run_tests_on_device(03dd6012215d1f2a) [ RUN ] CheckinRequestTest.SuccessfulFirstTimeCheckin I 23.070s run_tests_on_device(03dd6012215d1f2a) [ OK ] CheckinRequestTest.SuccessfulFirstTimeCheckin (3 ms) I 23.070s run_tests_on_device(03dd6012215d1f2a) [ RUN ] CheckinRequestTest.SuccessfulSubsequentCheckin I 23.070s run_tests_on_device(03dd6012215d1f2a) [ OK ] CheckinRequestTest.SuccessfulSubsequentCheckin (2 ms) I 23.070s run_tests_on_device(03dd6012215d1f2a) [----------] 12 tests from CheckinRequestTest (47 ms total) I 23.070s run_tests_on_device(03dd6012215d1f2a) I 23.070s run_tests_on_device(03dd6012215d1f2a) [----------] 1 test from ConnectionEventTrackerTest I 23.070s run_tests_on_device(03dd6012215d1f2a) [ RUN ] ConnectionEventTrackerTest.SuccessfulAttempt I 23.071s run_tests_on_device(03dd6012215d1f2a) [ OK ] ConnectionEventTrackerTest.SuccessfulAttempt (1 ms) I 23.071s run_tests_on_device(03dd6012215d1f2a) [----------] 1 test from ConnectionEventTrackerTest (1 ms total) I 23.071s run_tests_on_device(03dd6012215d1f2a) I 23.071s run_tests_on_device(03dd6012215d1f2a) [----------] 14 tests from ConnectionFactoryImplTest I 23.071s run_tests_on_device(03dd6012215d1f2a) [ RUN ] ConnectionFactoryImplTest.Initialize I 23.071s run_tests_on_device(03dd6012215d1f2a) [ OK ] ConnectionFactoryImplTest.Initialize (4 ms) I 23.071s run_tests_on_device(03dd6012215d1f2a) [ RUN ] ConnectionFactoryImplTest.ConnectSuccess I 23.071s run_tests_on_device(03dd6012215d1f2a) [ OK ] ConnectionFactoryImplTest.ConnectSuccess (3 ms) I 23.071s run_tests_on_device(03dd6012215d1f2a) [ RUN ] ConnectionFactoryImplTest.ConnectFail I 23.071s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.071s run_tests_on_device(03dd6012215d1f2a) [ OK ] ConnectionFactoryImplTest.ConnectFail (3 ms) I 23.071s run_tests_on_device(03dd6012215d1f2a) [ RUN ] ConnectionFactoryImplTest.FailThenSucceed I 23.071s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.071s run_tests_on_device(03dd6012215d1f2a) [ OK ] ConnectionFactoryImplTest.FailThenSucceed (4 ms) I 23.071s run_tests_on_device(03dd6012215d1f2a) [ RUN ] ConnectionFactoryImplTest.MultipleFailuresThenSucceed I 23.071s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.071s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.071s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.071s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.071s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.071s run_tests_on_device(03dd6012215d1f2a) [ OK ] ConnectionFactoryImplTest.MultipleFailuresThenSucceed (31 ms) I 23.071s run_tests_on_device(03dd6012215d1f2a) [ RUN ] ConnectionFactoryImplTest.FailThenNetworkChangeEvent I 23.071s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.071s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -2 I 23.071s run_tests_on_device(03dd6012215d1f2a) [ OK ] ConnectionFactoryImplTest.FailThenNetworkChangeEvent (4 ms) I 23.071s run_tests_on_device(03dd6012215d1f2a) [ RUN ] ConnectionFactoryImplTest.CanarySucceedsThenDisconnects I 23.071s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.071s run_tests_on_device(03dd6012215d1f2a) [ OK ] ConnectionFactoryImplTest.CanarySucceedsThenDisconnects (5 ms) I 23.071s run_tests_on_device(03dd6012215d1f2a) [ RUN ] ConnectionFactoryImplTest.CanarySucceedsRetryDuringLogin I 23.071s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.071s run_tests_on_device(03dd6012215d1f2a) [ OK ] ConnectionFactoryImplTest.CanarySucceedsRetryDuringLogin (5 ms) I 23.071s run_tests_on_device(03dd6012215d1f2a) [ RUN ] ConnectionFactoryImplTest.FailViaSignalReset I 23.071s run_tests_on_device(03dd6012215d1f2a) [ OK ] ConnectionFactoryImplTest.FailViaSignalReset (3 ms) I 23.071s run_tests_on_device(03dd6012215d1f2a) [ RUN ] ConnectionFactoryImplTest.IgnoreResetWhileConnecting I 23.071s run_tests_on_device(03dd6012215d1f2a) [ OK ] ConnectionFactoryImplTest.IgnoreResetWhileConnecting (3 ms) I 23.071s run_tests_on_device(03dd6012215d1f2a) [ RUN ] ConnectionFactoryImplTest.SignalResetRestoresBackoff I 23.071s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.071s run_tests_on_device(03dd6012215d1f2a) [ OK ] ConnectionFactoryImplTest.SignalResetRestoresBackoff (7 ms) I 23.071s run_tests_on_device(03dd6012215d1f2a) [ RUN ] ConnectionFactoryImplTest.NetworkChangeBeforeFirstConnection I 23.071s run_tests_on_device(03dd6012215d1f2a) [ OK ] ConnectionFactoryImplTest.NetworkChangeBeforeFirstConnection (6 ms) I 23.071s run_tests_on_device(03dd6012215d1f2a) [ RUN ] ConnectionFactoryImplTest.ConnectionResetRace I 23.071s run_tests_on_device(03dd6012215d1f2a) [ OK ] ConnectionFactoryImplTest.ConnectionResetRace (4 ms) I 23.071s run_tests_on_device(03dd6012215d1f2a) [ RUN ] ConnectionFactoryImplTest.MultipleFailuresWrapClientEvents I 23.071s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.071s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.071s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.071s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.071s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.071s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.071s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.071s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.071s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ OK ] ConnectionFactoryImplTest.MultipleFailuresWrapClientEvents (520 ms) I 23.072s run_tests_on_device(03dd6012215d1f2a) [----------] 14 tests from ConnectionFactoryImplTest (605 ms total) I 23.072s run_tests_on_device(03dd6012215d1f2a) I 23.072s run_tests_on_device(03dd6012215d1f2a) [----------] 20 tests from GCMConnectionHandlerImplTest I 23.072s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMConnectionHandlerImplTest.Init I 23.072s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMConnectionHandlerImplTest.Init (9 ms) I 23.072s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMConnectionHandlerImplTest.InitFailedVersionCheck I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_handler_impl.cc(295)] Invalid GCM version response: 37 I 23.072s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMConnectionHandlerImplTest.InitFailedVersionCheck (8 ms) I 23.072s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMConnectionHandlerImplTest.InitTimeout I 23.072s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_handler_impl.cc(471)] Timed out waiting for GCM Protocol buffer. I 23.073s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMConnectionHandlerImplTest.InitTimeout (109 ms) I 23.073s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMConnectionHandlerImplTest.InitIncompleteTimeout I 23.073s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_handler_impl.cc(471)] Timed out waiting for GCM Protocol buffer. I 23.073s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMConnectionHandlerImplTest.InitIncompleteTimeout (115 ms) I 23.073s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMConnectionHandlerImplTest.ReInit I 23.073s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_handler_impl.cc(471)] Timed out waiting for GCM Protocol buffer. I 23.073s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMConnectionHandlerImplTest.ReInit (129 ms) I 23.073s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMConnectionHandlerImplTest.RecvMsg I 23.073s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMConnectionHandlerImplTest.RecvMsg (40 ms) I 23.073s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMConnectionHandlerImplTest.Recv2Msgs I 23.073s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMConnectionHandlerImplTest.Recv2Msgs (4 ms) I 23.073s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMConnectionHandlerImplTest.RecvLongMsg I 23.073s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMConnectionHandlerImplTest.RecvLongMsg (4 ms) I 23.073s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMConnectionHandlerImplTest.RecvLongMsg2Parts I 23.073s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMConnectionHandlerImplTest.RecvLongMsg2Parts (4 ms) I 23.073s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMConnectionHandlerImplTest.Recv2LongMsgs I 23.073s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMConnectionHandlerImplTest.Recv2LongMsgs (4 ms) I 23.073s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMConnectionHandlerImplTest.ReadTimeout I 23.073s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_handler_impl.cc(471)] Timed out waiting for GCM Protocol buffer. I 23.073s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMConnectionHandlerImplTest.ReadTimeout (104 ms) I 23.073s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMConnectionHandlerImplTest.RecvMsgNoData I 23.073s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMConnectionHandlerImplTest.RecvMsgNoData (5 ms) I 23.073s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMConnectionHandlerImplTest.SendMsg I 23.073s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMConnectionHandlerImplTest.SendMsg (4 ms) I 23.073s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMConnectionHandlerImplTest.SendMsgSocketDisconnected I 23.073s run_tests_on_device(03dd6012215d1f2a) [ERROR:socket_stream.cc(300)] Failed to flush socket. I 23.073s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMConnectionHandlerImplTest.SendMsgSocketDisconnected (4 ms) I 23.073s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMConnectionHandlerImplTest.ExtraLargeDataPacket I 23.073s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMConnectionHandlerImplTest.ExtraLargeDataPacket (5 ms) I 23.073s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMConnectionHandlerImplTest.2ExtraLargeDataPacketMsgs I 23.073s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMConnectionHandlerImplTest.2ExtraLargeDataPacketMsgs (5 ms) I 23.073s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMConnectionHandlerImplTest.InvalidTag I 23.073s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_handler_impl.cc(399)] Received message of invalid type 100 I 23.073s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMConnectionHandlerImplTest.InvalidTag (5 ms) I 23.073s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMConnectionHandlerImplTest.RecvMsgSplitSize I 23.073s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMConnectionHandlerImplTest.RecvMsgSplitSize (5 ms) I 23.073s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMConnectionHandlerImplTest.InvalidData I 23.073s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_handler_impl.cc(409)] Unable to parse GCM message of type 8 I 23.073s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMConnectionHandlerImplTest.InvalidData (4 ms) I 23.073s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMConnectionHandlerImplTest.InvalidDataLong I 23.073s run_tests_on_device(03dd6012215d1f2a) [ERROR:connection_handler_impl.cc(428)] Unable to parse GCM message of type 8 I 23.073s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMConnectionHandlerImplTest.InvalidDataLong (9 ms) I 23.073s run_tests_on_device(03dd6012215d1f2a) [----------] 20 tests from GCMConnectionHandlerImplTest (579 ms total) I 23.073s run_tests_on_device(03dd6012215d1f2a) I 23.073s run_tests_on_device(03dd6012215d1f2a) [----------] 17 tests from GCMStoreImplTest I 23.073s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMStoreImplTest.LoadNew I 23.073s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMStoreImplTest.LoadNew (15 ms) I 23.073s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMStoreImplTest.LoadWithoutCreatingNewStore I 23.073s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMStoreImplTest.LoadWithoutCreatingNewStore (1 ms) I 23.073s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMStoreImplTest.LoadWithEmptyDirectory I 23.073s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMStoreImplTest.LoadWithEmptyDirectory (2 ms) I 23.074s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMStoreImplTest.DeviceCredentials I 23.074s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMStoreImplTest.DeviceCredentials (17 ms) I 23.074s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMStoreImplTest.LastCheckinInfo I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(1033)] Failed to restore last checkin time. Using default = 0. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMStoreImplTest.LastCheckinInfo (18 ms) I 23.074s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMStoreImplTest.GServicesSettings_ProtocolV2 I 23.074s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMStoreImplTest.GServicesSettings_ProtocolV2 (17 ms) I 23.074s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMStoreImplTest.Registrations I 23.074s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMStoreImplTest.Registrations (16 ms) I 23.074s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMStoreImplTest.IncomingMessages I 23.074s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMStoreImplTest.IncomingMessages (34 ms) I 23.074s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMStoreImplTest.OutgoingMessages I 23.074s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMStoreImplTest.OutgoingMessages (34 ms) I 23.074s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMStoreImplTest.IncomingAndOutgoingMessages I 23.074s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMStoreImplTest.IncomingAndOutgoingMessages (51 ms) I 23.074s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMStoreImplTest.PerAppMessageLimits I 23.074s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMStoreImplTest.PerAppMessageLimits (77 ms) I 23.074s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMStoreImplTest.AccountMapping I 23.074s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMStoreImplTest.AccountMapping (23 ms) I 23.074s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMStoreImplTest.HeartbeatInterval I 23.074s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMStoreImplTest.HeartbeatInterval (19 ms) I 23.074s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMStoreImplTest.AddMessageAfterDestroy I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.074s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.075s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.075s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.075s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.075s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.075s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.075s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.075s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.075s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.075s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.075s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.075s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMStoreImplTest.AddMessageAfterDestroy (23 ms) I 23.075s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMStoreImplTest.ReloadAfterClose I 23.075s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMStoreImplTest.ReloadAfterClose (8 ms) I 23.075s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMStoreImplTest.LastTokenFetchTime I 23.075s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(1114)] Failed to restore last token fetching time. Using default = 0. I 23.075s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMStoreImplTest.LastTokenFetchTime (18 ms) I 23.075s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMStoreImplTest.InstanceIDData I 23.075s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMStoreImplTest.InstanceIDData (19 ms) I 23.075s run_tests_on_device(03dd6012215d1f2a) [----------] 17 tests from GCMStoreImplTest (397 ms total) I 23.075s run_tests_on_device(03dd6012215d1f2a) I 23.075s run_tests_on_device(03dd6012215d1f2a) [----------] 12 tests from GServicesSettingsTest I 23.075s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GServicesSettingsTest.DefaultSettingsAndDigest I 23.075s run_tests_on_device(03dd6012215d1f2a) [ OK ] GServicesSettingsTest.DefaultSettingsAndDigest (1 ms) I 23.075s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GServicesSettingsTest.CalculateDigest I 23.075s run_tests_on_device(03dd6012215d1f2a) [ OK ] GServicesSettingsTest.CalculateDigest (1 ms) I 23.075s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GServicesSettingsTest.UpdateFromEmptyLoadResult I 23.075s run_tests_on_device(03dd6012215d1f2a) [ OK ] GServicesSettingsTest.UpdateFromEmptyLoadResult (1 ms) I 23.075s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GServicesSettingsTest.UpdateFromLoadResultWithSettingMissing I 23.075s run_tests_on_device(03dd6012215d1f2a) [ OK ] GServicesSettingsTest.UpdateFromLoadResultWithSettingMissing (0 ms) I 23.075s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GServicesSettingsTest.UpdateFromLoadResult I 23.075s run_tests_on_device(03dd6012215d1f2a) [ OK ] GServicesSettingsTest.UpdateFromLoadResult (0 ms) I 23.075s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GServicesSettingsTest.CheckinResponseMinimumCheckinInterval I 23.075s run_tests_on_device(03dd6012215d1f2a) [ OK ] GServicesSettingsTest.CheckinResponseMinimumCheckinInterval (1 ms) I 23.075s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GServicesSettingsTest.CheckinResponseUpdateCheckinInterval I 23.075s run_tests_on_device(03dd6012215d1f2a) [ OK ] GServicesSettingsTest.CheckinResponseUpdateCheckinInterval (1 ms) I 23.075s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GServicesSettingsTest.CheckinResponseUpdateRegistrationURL I 23.075s run_tests_on_device(03dd6012215d1f2a) [ OK ] GServicesSettingsTest.CheckinResponseUpdateRegistrationURL (1 ms) I 23.075s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GServicesSettingsTest.CheckinResponseUpdateCheckinURL I 23.075s run_tests_on_device(03dd6012215d1f2a) [ OK ] GServicesSettingsTest.CheckinResponseUpdateCheckinURL (1 ms) I 23.075s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GServicesSettingsTest.CheckinResponseUpdateMCSHostname I 23.075s run_tests_on_device(03dd6012215d1f2a) [ OK ] GServicesSettingsTest.CheckinResponseUpdateMCSHostname (0 ms) I 23.075s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GServicesSettingsTest.CheckinResponseUpdateMCSSecurePort I 23.075s run_tests_on_device(03dd6012215d1f2a) [ OK ] GServicesSettingsTest.CheckinResponseUpdateMCSSecurePort (0 ms) I 23.075s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GServicesSettingsTest.UpdateFromCheckinResponseSettingsDiff I 23.075s run_tests_on_device(03dd6012215d1f2a) [ OK ] GServicesSettingsTest.UpdateFromCheckinResponseSettingsDiff (1 ms) I 23.075s run_tests_on_device(03dd6012215d1f2a) [----------] 12 tests from GServicesSettingsTest (10 ms total) I 23.075s run_tests_on_device(03dd6012215d1f2a) I 23.075s run_tests_on_device(03dd6012215d1f2a) [----------] 14 tests from HeartbeatManagerTest I 23.075s run_tests_on_device(03dd6012215d1f2a) [ RUN ] HeartbeatManagerTest.Init I 23.075s run_tests_on_device(03dd6012215d1f2a) [ OK ] HeartbeatManagerTest.Init (0 ms) I 23.075s run_tests_on_device(03dd6012215d1f2a) [ RUN ] HeartbeatManagerTest.AckBeforeStart I 23.075s run_tests_on_device(03dd6012215d1f2a) [ OK ] HeartbeatManagerTest.AckBeforeStart (1 ms) I 23.075s run_tests_on_device(03dd6012215d1f2a) [ RUN ] HeartbeatManagerTest.Start I 23.075s run_tests_on_device(03dd6012215d1f2a) [ OK ] HeartbeatManagerTest.Start (1 ms) I 23.076s run_tests_on_device(03dd6012215d1f2a) [ RUN ] HeartbeatManagerTest.AckedHeartbeat I 23.076s run_tests_on_device(03dd6012215d1f2a) [ OK ] HeartbeatManagerTest.AckedHeartbeat (1 ms) I 23.076s run_tests_on_device(03dd6012215d1f2a) [ RUN ] HeartbeatManagerTest.UnackedHeartbeat I 23.076s run_tests_on_device(03dd6012215d1f2a) [WARNING:heartbeat_manager.cc(165)] Lost connection to MCS, reconnecting. I 23.076s run_tests_on_device(03dd6012215d1f2a) [ OK ] HeartbeatManagerTest.UnackedHeartbeat (0 ms) I 23.076s run_tests_on_device(03dd6012215d1f2a) [ RUN ] HeartbeatManagerTest.UpdateIntervalThenStart I 23.076s run_tests_on_device(03dd6012215d1f2a) [ OK ] HeartbeatManagerTest.UpdateIntervalThenStart (0 ms) I 23.076s run_tests_on_device(03dd6012215d1f2a) [ RUN ] HeartbeatManagerTest.StartThenUpdateInterval I 23.076s run_tests_on_device(03dd6012215d1f2a) [ OK ] HeartbeatManagerTest.StartThenUpdateInterval (1 ms) I 23.076s run_tests_on_device(03dd6012215d1f2a) [ RUN ] HeartbeatManagerTest.UpdateTimerBeforeStart I 23.076s run_tests_on_device(03dd6012215d1f2a) [ OK ] HeartbeatManagerTest.UpdateTimerBeforeStart (1 ms) I 23.076s run_tests_on_device(03dd6012215d1f2a) [ RUN ] HeartbeatManagerTest.UpdateTimerAfterStart I 23.076s run_tests_on_device(03dd6012215d1f2a) [ OK ] HeartbeatManagerTest.UpdateTimerAfterStart (0 ms) I 23.076s run_tests_on_device(03dd6012215d1f2a) [ RUN ] HeartbeatManagerTest.Stop I 23.076s run_tests_on_device(03dd6012215d1f2a) [ OK ] HeartbeatManagerTest.Stop (0 ms) I 23.076s run_tests_on_device(03dd6012215d1f2a) [ RUN ] HeartbeatManagerTest.MissedHeartbeat I 23.076s run_tests_on_device(03dd6012215d1f2a) [ OK ] HeartbeatManagerTest.MissedHeartbeat (1 ms) I 23.076s run_tests_on_device(03dd6012215d1f2a) [ RUN ] HeartbeatManagerTest.SetClientHeartbeatInterval I 23.076s run_tests_on_device(03dd6012215d1f2a) [ OK ] HeartbeatManagerTest.SetClientHeartbeatInterval (1 ms) I 23.076s run_tests_on_device(03dd6012215d1f2a) [ RUN ] HeartbeatManagerTest.ClientIntervalInvalid I 23.076s run_tests_on_device(03dd6012215d1f2a) [ OK ] HeartbeatManagerTest.ClientIntervalInvalid (0 ms) I 23.076s run_tests_on_device(03dd6012215d1f2a) [ RUN ] HeartbeatManagerTest.ClientIntervalAfterHeartbeatTriggered I 23.076s run_tests_on_device(03dd6012215d1f2a) [ OK ] HeartbeatManagerTest.ClientIntervalAfterHeartbeatTriggered (0 ms) I 23.076s run_tests_on_device(03dd6012215d1f2a) [----------] 14 tests from HeartbeatManagerTest (10 ms total) I 23.076s run_tests_on_device(03dd6012215d1f2a) I 23.076s run_tests_on_device(03dd6012215d1f2a) [----------] 30 tests from MCSClientTest I 23.076s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.InitializeNew I 23.076s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.InitializeNew (10 ms) I 23.076s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.InitializeExisting I 23.076s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.InitializeExisting (15 ms) I 23.076s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.LoginSuccess I 23.076s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.LoginSuccess (9 ms) I 23.076s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.FailLogin I 23.076s run_tests_on_device(03dd6012215d1f2a) [ERROR:mcs_client.cc(708)] Failed to log in to GCM, resetting connection. I 23.076s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.FailLogin (11 ms) I 23.076s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.SendMessageNoRMQ I 23.076s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.SendMessageNoRMQ (11 ms) I 23.076s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.SendMessageNoRMQWhileDisconnected I 23.076s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.SendMessageNoRMQWhileDisconnected (10 ms) I 23.076s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.SendMessageRMQ I 23.076s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.SendMessageRMQ (10 ms) I 23.076s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.SendMessageRMQWhileDisconnected I 23.076s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.SendMessageRMQWhileDisconnected (15 ms) I 23.076s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.SendMessageRMQOnRestart I 23.076s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.SendMessageRMQOnRestart (20 ms) I 23.076s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.SendMessageRMQWithStreamAck I 23.076s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.SendMessageRMQWithStreamAck (31 ms) I 23.076s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.SendMessageRMQAckOnReconnect I 23.076s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.SendMessageRMQAckOnReconnect (30 ms) I 23.076s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.SendMessageRMQPartialAckOnReconnect I 23.076s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.SendMessageRMQPartialAckOnReconnect (25 ms) I 23.076s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.SelectiveAckMidStream I 23.076s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.SelectiveAckMidStream (26 ms) I 23.077s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.AckOnLogin I 23.077s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.AckOnLogin (25 ms) I 23.077s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.AckOnSend I 23.077s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.AckOnSend (18 ms) I 23.077s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.AckWhenLimitReachedWithHeartbeat I 23.077s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.AckWhenLimitReachedWithHeartbeat (37 ms) I 23.077s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.ExpiredTTLOnSend I 23.077s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.ExpiredTTLOnSend (9 ms) I 23.077s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.ExpiredTTLOnRestart I 23.077s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.ExpiredTTLOnRestart (16 ms) I 23.077s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.CollapseKeysSameApp I 23.077s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.CollapseKeysSameApp (30 ms) I 23.077s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.CollapseKeysDifferentApp I 23.077s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.CollapseKeysDifferentApp (15 ms) I 23.077s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.CollapseKeysDifferentUser I 23.077s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.CollapseKeysDifferentUser (15 ms) I 23.077s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.CustomHeartbeatIntervalTooShort I 23.077s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.CustomHeartbeatIntervalTooShort (15 ms) I 23.077s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.CustomHeartbeatIntervalTooLong I 23.077s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.CustomHeartbeatIntervalTooLong (15 ms) I 23.077s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.CustomHeartbeatIntervalSingleInterval I 23.077s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.CustomHeartbeatIntervalSingleInterval (19 ms) I 23.077s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.CustomHeartbeatIntervalSetBeforeInitialize I 23.077s run_tests_on_device(03dd6012215d1f2a) [ERROR:gcm_store_impl.cc(799)] GCMStore db doesn't exist. I 23.077s run_tests_on_device(03dd6012215d1f2a) [ERROR:mcs_client.cc(526)] GCM Update failed! I 23.077s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.CustomHeartbeatIntervalSetBeforeInitialize (9 ms) I 23.077s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.CustomHeartbeatIntervalSetBeforeLogin I 23.077s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.CustomHeartbeatIntervalSetBeforeLogin (12 ms) I 23.077s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.CustomHeartbeatIntervalSecondIntervalLonger I 23.077s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.CustomHeartbeatIntervalSecondIntervalLonger (19 ms) I 23.077s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.CustomHeartbeatIntervalSecondIntervalShorter I 23.077s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.CustomHeartbeatIntervalSecondIntervalShorter (18 ms) I 23.077s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.CustomHeartbeatIntervalRemoveShorterInterval I 23.077s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.CustomHeartbeatIntervalRemoveShorterInterval (19 ms) I 23.077s run_tests_on_device(03dd6012215d1f2a) [ RUN ] MCSClientTest.AckWhenImmediateAckRequested I 23.077s run_tests_on_device(03dd6012215d1f2a) [ OK ] MCSClientTest.AckWhenImmediateAckRequested (22 ms) I 23.077s run_tests_on_device(03dd6012215d1f2a) [----------] 30 tests from MCSClientTest (539 ms total) I 23.077s run_tests_on_device(03dd6012215d1f2a) I 23.077s run_tests_on_device(03dd6012215d1f2a) [----------] 19 tests from GCMRegistrationRequestTest I 23.077s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMRegistrationRequestTest.RequestSuccessful I 23.077s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMRegistrationRequestTest.RequestSuccessful (3 ms) I 23.077s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMRegistrationRequestTest.RequestDataAndURL I 23.077s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMRegistrationRequestTest.RequestDataAndURL (1 ms) I 23.077s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMRegistrationRequestTest.RequestRegistrationWithMultipleSenderIds I 23.077s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMRegistrationRequestTest.RequestRegistrationWithMultipleSenderIds (1 ms) I 23.077s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMRegistrationRequestTest.ResponseParsing I 23.077s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMRegistrationRequestTest.ResponseParsing (2 ms) I 23.077s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMRegistrationRequestTest.ResponseParsingFailed I 23.077s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMRegistrationRequestTest.ResponseParsingFailed (3 ms) I 23.077s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMRegistrationRequestTest.ResponseHttpStatusNotOK I 23.077s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMRegistrationRequestTest.ResponseHttpStatusNotOK (3 ms) I 23.077s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMRegistrationRequestTest.ResponseMissingRegistrationId I 23.078s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMRegistrationRequestTest.ResponseMissingRegistrationId (4 ms) I 23.078s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMRegistrationRequestTest.ResponseDeviceRegistrationError I 23.078s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMRegistrationRequestTest.ResponseDeviceRegistrationError (3 ms) I 23.078s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMRegistrationRequestTest.ResponseAuthenticationError I 23.078s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMRegistrationRequestTest.ResponseAuthenticationError (3 ms) I 23.078s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMRegistrationRequestTest.ResponseInternalServerError I 23.078s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMRegistrationRequestTest.ResponseInternalServerError (3 ms) I 23.078s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMRegistrationRequestTest.ResponseInvalidParameters I 23.078s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMRegistrationRequestTest.ResponseInvalidParameters (2 ms) I 23.078s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMRegistrationRequestTest.ResponseInvalidSender I 23.078s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMRegistrationRequestTest.ResponseInvalidSender (3 ms) I 23.078s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMRegistrationRequestTest.ResponseInvalidSenderBadRequest I 23.078s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMRegistrationRequestTest.ResponseInvalidSenderBadRequest (2 ms) I 23.078s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMRegistrationRequestTest.ResponseQuotaExceeded I 23.078s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMRegistrationRequestTest.ResponseQuotaExceeded (2 ms) I 23.078s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMRegistrationRequestTest.ResponseTooManyRegistrations I 23.078s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMRegistrationRequestTest.ResponseTooManyRegistrations (2 ms) I 23.078s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMRegistrationRequestTest.RequestNotSuccessful I 23.078s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMRegistrationRequestTest.RequestNotSuccessful (3 ms) I 23.078s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMRegistrationRequestTest.ResponseHttpNotOk I 23.078s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMRegistrationRequestTest.ResponseHttpNotOk (3 ms) I 23.078s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMRegistrationRequestTest.MaximumAttemptsReachedWithZeroRetries I 23.078s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMRegistrationRequestTest.MaximumAttemptsReachedWithZeroRetries (2 ms) I 23.078s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMRegistrationRequestTest.MaximumAttemptsReached I 23.078s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMRegistrationRequestTest.MaximumAttemptsReached (4 ms) I 23.078s run_tests_on_device(03dd6012215d1f2a) [----------] 19 tests from GCMRegistrationRequestTest (50 ms total) I 23.078s run_tests_on_device(03dd6012215d1f2a) I 23.078s run_tests_on_device(03dd6012215d1f2a) [----------] 4 tests from InstanceIDGetTokenRequestTest I 23.078s run_tests_on_device(03dd6012215d1f2a) [ RUN ] InstanceIDGetTokenRequestTest.RequestSuccessful I 23.078s run_tests_on_device(03dd6012215d1f2a) [ OK ] InstanceIDGetTokenRequestTest.RequestSuccessful (2 ms) I 23.078s run_tests_on_device(03dd6012215d1f2a) [ RUN ] InstanceIDGetTokenRequestTest.RequestDataAndURL I 23.078s run_tests_on_device(03dd6012215d1f2a) [ OK ] InstanceIDGetTokenRequestTest.RequestDataAndURL (2 ms) I 23.078s run_tests_on_device(03dd6012215d1f2a) [ RUN ] InstanceIDGetTokenRequestTest.RequestDataWithSubtype I 23.078s run_tests_on_device(03dd6012215d1f2a) [ OK ] InstanceIDGetTokenRequestTest.RequestDataWithSubtype (1 ms) I 23.078s run_tests_on_device(03dd6012215d1f2a) [ RUN ] InstanceIDGetTokenRequestTest.ResponseHttpStatusNotOK I 23.078s run_tests_on_device(03dd6012215d1f2a) [ OK ] InstanceIDGetTokenRequestTest.ResponseHttpStatusNotOK (2 ms) I 23.078s run_tests_on_device(03dd6012215d1f2a) [----------] 4 tests from InstanceIDGetTokenRequestTest (8 ms total) I 23.078s run_tests_on_device(03dd6012215d1f2a) I 23.078s run_tests_on_device(03dd6012215d1f2a) [----------] 13 tests from GCMUnregistrationRequestTest I 23.078s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMUnregistrationRequestTest.RequestDataPassedToFetcher I 23.078s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMUnregistrationRequestTest.RequestDataPassedToFetcher (1 ms) I 23.078s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMUnregistrationRequestTest.SuccessfulUnregistration I 23.078s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMUnregistrationRequestTest.SuccessfulUnregistration (2 ms) I 23.078s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMUnregistrationRequestTest.ResponseHttpStatusNotOK I 23.078s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMUnregistrationRequestTest.ResponseHttpStatusNotOK (3 ms) I 23.078s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMUnregistrationRequestTest.ResponseEmpty I 23.078s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMUnregistrationRequestTest.ResponseEmpty (3 ms) I 23.078s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMUnregistrationRequestTest.InvalidParametersError I 23.078s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMUnregistrationRequestTest.InvalidParametersError (2 ms) I 23.078s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMUnregistrationRequestTest.DeviceRegistrationError I 23.078s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMUnregistrationRequestTest.DeviceRegistrationError (1 ms) I 23.078s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMUnregistrationRequestTest.UnkwnownError I 23.078s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMUnregistrationRequestTest.UnkwnownError (2 ms) I 23.078s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMUnregistrationRequestTest.ServiceUnavailable I 23.079s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMUnregistrationRequestTest.ServiceUnavailable (3 ms) I 23.079s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMUnregistrationRequestTest.InternalServerError I 23.079s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMUnregistrationRequestTest.InternalServerError (3 ms) I 23.079s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMUnregistrationRequestTest.IncorrectAppId I 23.079s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMUnregistrationRequestTest.IncorrectAppId (3 ms) I 23.079s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMUnregistrationRequestTest.ResponseParsingFailed I 23.079s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMUnregistrationRequestTest.ResponseParsingFailed (3 ms) I 23.079s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMUnregistrationRequestTest.MaximumAttemptsReachedWithZeroRetries I 23.079s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMUnregistrationRequestTest.MaximumAttemptsReachedWithZeroRetries (2 ms) I 23.079s run_tests_on_device(03dd6012215d1f2a) [ RUN ] GCMUnregistrationRequestTest.MaximumAttemptsReached I 23.079s run_tests_on_device(03dd6012215d1f2a) [ OK ] GCMUnregistrationRequestTest.MaximumAttemptsReached (4 ms) I 23.079s run_tests_on_device(03dd6012215d1f2a) [----------] 13 tests from GCMUnregistrationRequestTest (35 ms total) I 23.079s run_tests_on_device(03dd6012215d1f2a) I 23.079s run_tests_on_device(03dd6012215d1f2a) [----------] 6 tests from InstaceIDDeleteTokenRequestTest I 23.079s run_tests_on_device(03dd6012215d1f2a) [ RUN ] InstaceIDDeleteTokenRequestTest.RequestDataPassedToFetcher I 23.079s run_tests_on_device(03dd6012215d1f2a) [ OK ] InstaceIDDeleteTokenRequestTest.RequestDataPassedToFetcher (2 ms) I 23.079s run_tests_on_device(03dd6012215d1f2a) [ RUN ] InstaceIDDeleteTokenRequestTest.RequestDataWithSubtype I 23.079s run_tests_on_device(03dd6012215d1f2a) [ OK ] InstaceIDDeleteTokenRequestTest.RequestDataWithSubtype (2 ms) I 23.079s run_tests_on_device(03dd6012215d1f2a) [ RUN ] InstaceIDDeleteTokenRequestTest.SuccessfulUnregistration I 23.079s run_tests_on_device(03dd6012215d1f2a) [ OK ] InstaceIDDeleteTokenRequestTest.SuccessfulUnregistration (2 ms) I 23.079s run_tests_on_device(03dd6012215d1f2a) [ RUN ] InstaceIDDeleteTokenRequestTest.ResponseHttpStatusNotOK I 23.079s run_tests_on_device(03dd6012215d1f2a) [ OK ] InstaceIDDeleteTokenRequestTest.ResponseHttpStatusNotOK (3 ms) I 23.079s run_tests_on_device(03dd6012215d1f2a) [ RUN ] InstaceIDDeleteTokenRequestTest.InvalidParametersError I 23.079s run_tests_on_device(03dd6012215d1f2a) [ OK ] InstaceIDDeleteTokenRequestTest.InvalidParametersError (2 ms) I 23.079s run_tests_on_device(03dd6012215d1f2a) [ RUN ] InstaceIDDeleteTokenRequestTest.UnkwnownError I 23.079s run_tests_on_device(03dd6012215d1f2a) [ OK ] InstaceIDDeleteTokenRequestTest.UnkwnownError (2 ms) I 23.079s run_tests_on_device(03dd6012215d1f2a) [----------] 6 tests from InstaceIDDeleteTokenRequestTest (13 ms total) I 23.079s run_tests_on_device(03dd6012215d1f2a) I 23.079s run_tests_on_device(03dd6012215d1f2a) [----------] Global test environment tear-down I 23.079s run_tests_on_device(03dd6012215d1f2a) [==========] 188 tests from 16 test suites ran. (2384 ms total) I 23.079s run_tests_on_device(03dd6012215d1f2a) [ PASSED ] 188 tests. I 23.079s run_tests_on_device(03dd6012215d1f2a) <<ScopedMainEntryLogger I 23.085s run_tests_on_device(03dd6012215d1f2a) Finished running tests on this device. I 23.101s Main FINISHED TRY #1/3 I 23.101s Main All tests completed. C 23.101s Main ******************************************************************************** C 23.102s Main Summary C 23.102s Main ******************************************************************************** C 23.102s Main [==========] 188 tests ran. C 23.102s Main [ PASSED ] 188 tests. C 23.102s Main ******************************************************************************** I 23.104s tear_down_device(03dd6012215d1f2a) Wrote device cache: /b/swarming/w/ir/out/Release/device_cache_03dd6012215d1f2a.json I 23.110s Main Generated json results file at /b/swarming/w/itYAWcBo/tmpxWcBmc I 23.110s Main Finishing archiving output. [W2019-03-23T20:57:23.394696Z 2545 0 butler.go:240] Butler Context was cancelled. Initiating shutdown. {"error":"context canceled"} INFO:devil.utils.timeout_retry:condition 'logdog_stopped' not met [E2019-03-23T20:57:23.443534Z 2545 0 main.go:205] Butler terminated with error. {"error":"context canceled"} [E2019-03-23T20:57:23.443574Z 2545 0 main.go:233] Failed to serve. original error: context canceled [I2019-03-23T20:57:23.443684Z 2545 0 main.go:349] Terminating. {"returnCode":250} INFO:devil.utils.timeout_retry:condition 'logdog_stopped' met 2019-03-23 21:59:24,341 - root: [DEBUG] Contents of task_output_dir: ['/b/swarming/w/ir/tmp/t/tmpJ48iYg/43c6d4e574fcc510'] 2019-03-23 21:59:24,341 - root: [DEBUG] Found shard_json_files: ['/b/swarming/w/ir/tmp/t/tmpJ48iYg/43c6d4e574fcc510/output.json'] 2019-03-23 21:59:24,341 - 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": "swarm265-c4", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1553401120262048, "id": "8918134582878724400", "project": "chromium", "tags": ["build_address:luci.chromium.ci/android-kitkat-arm-rel/15741", "builder:android-kitkat-arm-rel", "buildset:commit/git/cc13ccb72be99fcd00eb725a5a85cb54d9e00263", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cc13ccb72be99fcd00eb725a5a85cb54d9e00263", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9083564647785995616", "scheduler_job_id:chromium/android-kitkat-arm-rel", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "android-kitkat-arm-rel", "buildnumber": 15741, "got_angle_revision": "eae464dd3092c1c09c4dc4d51a0f50ac5d007722", "got_dawn_revision": "07950e80fe36028ed9cca0a4a99a8b08e9bb4fdf", "got_nacl_revision": "de8da4841bc3d1ed020d798d5a7fd6fb3d817fa1", "got_revision": "cc13ccb72be99fcd00eb725a5a85cb54d9e00263", "got_revision_cp": "refs/heads/master@{#643710}", "got_swarming_client_revision": "aa60736aded9fc32a0e21a81f5fc51f6009d01f3", "got_v8_revision": "b346546b7795350b8c910ff06f9520e7f03224f0", "got_v8_revision_cp": "refs/heads/7.5.100@{#1}", "got_webrtc_revision": "85a4a93e77b163098e91f41d8e7415181f23d02c", "got_webrtc_revision_cp": "refs/heads/master@{#27257}", "mastername": "chromium.android", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "cc13ccb72be99fcd00eb725a5a85cb54d9e00263"} --summary-json /b/swarming/w/ir/tmp/t/tmpcAYa6j.json --task-output-dir /b/swarming/w/ir/tmp/t/tmpJ48iYg --bucket chromium-result-details --test-name gcm_unit_tests -o /b/swarming/w/ir/tmp/t/tmpB49aKM.json /b/swarming/w/ir/tmp/t/tmpJ48iYg/43c6d4e574fcc510/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": "swarm265-c4", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1553401120262048, "id": "8918134582878724400", "project": "chromium", "tags": ["build_address:luci.chromium.ci/android-kitkat-arm-rel/15741", "builder:android-kitkat-arm-rel", "buildset:commit/git/cc13ccb72be99fcd00eb725a5a85cb54d9e00263", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cc13ccb72be99fcd00eb725a5a85cb54d9e00263", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9083564647785995616", "scheduler_job_id:chromium/android-kitkat-arm-rel", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "android-kitkat-arm-rel", "buildnumber": 15741, "got_angle_revision": "eae464dd3092c1c09c4dc4d51a0f50ac5d007722", "got_dawn_revision": "07950e80fe36028ed9cca0a4a99a8b08e9bb4fdf", "got_nacl_revision": "de8da4841bc3d1ed020d798d5a7fd6fb3d817fa1", "got_revision": "cc13ccb72be99fcd00eb725a5a85cb54d9e00263", "got_revision_cp": "refs/heads/master@{#643710}", "got_swarming_client_revision": "aa60736aded9fc32a0e21a81f5fc51f6009d01f3", "got_v8_revision": "b346546b7795350b8c910ff06f9520e7f03224f0", "got_v8_revision_cp": "refs/heads/7.5.100@{#1}", "got_webrtc_revision": "85a4a93e77b163098e91f41d8e7415181f23d02c", "got_webrtc_revision_cp": "refs/heads/master@{#27257}", "mastername": "chromium.android", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "cc13ccb72be99fcd00eb725a5a85cb54d9e00263"}', '--summary-json', '/b/swarming/w/ir/tmp/t/tmpcAYa6j.json', '--task-output-dir', '/b/swarming/w/ir/tmp/t/tmpJ48iYg', u'--bucket', u'chromium-result-details', u'--test-name', u'gcm_unit_tests', '-o', '/b/swarming/w/ir/tmp/t/tmpB49aKM.json', '/b/swarming/w/ir/tmp/t/tmpJ48iYg/43c6d4e574fcc510/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": "swarm265-c4", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1553401120262048, "id": "8918134582878724400", "project": "chromium", "tags": ["build_address:luci.chromium.ci/android-kitkat-arm-rel/15741", "builder:android-kitkat-arm-rel", "buildset:commit/git/cc13ccb72be99fcd00eb725a5a85cb54d9e00263", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cc13ccb72be99fcd00eb725a5a85cb54d9e00263", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9083564647785995616", "scheduler_job_id:chromium/android-kitkat-arm-rel", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "android-kitkat-arm-rel", "buildnumber": 15741, "got_angle_revision": "eae464dd3092c1c09c4dc4d51a0f50ac5d007722", "got_dawn_revision": "07950e80fe36028ed9cca0a4a99a8b08e9bb4fdf", "got_nacl_revision": "de8da4841bc3d1ed020d798d5a7fd6fb3d817fa1", "got_revision": "cc13ccb72be99fcd00eb725a5a85cb54d9e00263", "got_revision_cp": "refs/heads/master@{#643710}", "got_swarming_client_revision": "aa60736aded9fc32a0e21a81f5fc51f6009d01f3", "got_v8_revision": "b346546b7795350b8c910ff06f9520e7f03224f0", "got_v8_revision_cp": "refs/heads/7.5.100@{#1}", "got_webrtc_revision": "85a4a93e77b163098e91f41d8e7415181f23d02c", "got_webrtc_revision_cp": "refs/heads/master@{#27257}", "mastername": "chromium.android", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "cc13ccb72be99fcd00eb725a5a85cb54d9e00263"}', '--summary-json', '/b/swarming/w/ir/tmp/t/tmpcAYa6j.json', '--task-output-dir', '/b/swarming/w/ir/tmp/t/tmpJ48iYg', u'--bucket', u'chromium-result-details', u'--test-name', u'gcm_unit_tests', '-o', '/b/swarming/w/ir/tmp/t/tmpB49aKM.json', '/b/swarming/w/ir/tmp/t/tmpJ48iYg/43c6d4e574fcc510/output.json'] returned exit code 0