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/tmp16oOmx.json --task-output-dir /b/swarming/w/ir/tmp/t/tmpOCbhaU --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/tmpQ7NZYPmerge_script_log --merge-additional-args '["--bucket", "chromium-result-details", "--test-name", "gcm_unit_tests"]' --build-properties '{"attempt_start_ts": 1551814694000000, "blamelist": ["bungeman@chromium.org"], "bot_id": "swarm1736-c4", "buildbucket": {"build": {"bucket": "luci.chromium.try", "created_by": "user:5071639625-1lppvbtck1morgivc6sq4dul7klu27sd@developer.gserviceaccount.com", "created_ts": 1551814721480501, "id": "8919798042567208000", "project": "chromium", "tags": ["build_address:luci.chromium.try/android-kitkat-arm-rel/204080", "builder:android-kitkat-arm-rel", "buildset:patch/gerrit/chromium-review.googlesource.com/1504002/1", "cq_experimental:false", "user_agent:cq"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "android-kitkat-arm-rel", "buildnumber": 204080, "category": "cq", "got_angle_revision": "f094bac949922dabc3dd6944f3dec04111e953b6", "got_dawn_revision": "b47470daa7377a804df5d94e7a93b5925a57f84a", "got_nacl_revision": "1ed9878b8eb68c1e0d0268754dafcf83e747fa8f", "got_revision": "79d7f822d09d101a0ed5ae719b2d62f750c4cad2", "got_revision_cp": "refs/heads/master@{#637770}", "got_swarming_client_revision": "7a61cf37d6a0163f0ec02d495289a1d038e62457", "got_v8_revision": "6641700a356c9a321198ea8beefcd9323a4da862", "got_v8_revision_cp": "refs/heads/7.4.282@{#1}", "got_webrtc_revision": "7949f215c1183d8bfc5b13f86594a03d3d648f68", "got_webrtc_revision_cp": "refs/heads/master@{#26971}", "mastername": "tryserver.chromium.android", "patch_gerrit_url": "https://chromium-review.googlesource.com", "patch_issue": 1504002, "patch_project": "chromium/src", "patch_ref": "refs/changes/02/1504002/1", "patch_repository_url": "https://chromium.googlesource.com/chromium/src", "patch_set": 1, "patch_storage": "gerrit", "path_config": "generic", "reason": "CQ", "recipe": "chromium_trybot", "repository": "https://chromium.googlesource.com/chromium/src", "revision": "HEAD"}' --summary-json-file /b/swarming/w/ir/tmp/t/tmpAU63pw.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/tmpAmJrq8.json in dir /b/swarming/w/ir/k: allow_subannotations: True base_name: 'gcm_unit_tests on Android device Nexus 5 (with patch)' 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/tmp16oOmx.json', '--task-output-dir', '/b/swarming/w/ir/tmp/t/tmpOCbhaU', '--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/tmpQ7NZYPmerge_script_log', '--merge-additional-args', '["--bucket", "chromium-result-details", "--test-name", "gcm_unit_tests"]', '--build-properties', '{"attempt_start_ts": 1551814694000000, "blamelist": ["bungeman@chromium.org"], "bot_id": "swarm1736-c4", "buildbucket": {"build": {"bucket": "luci.chromium.try", "created_by": "user:5071639625-1lppvbtck1morgivc6sq4dul7klu27sd@developer.gserviceaccount.com", "created_ts": 1551814721480501, "id": "8919798042567208000", "project": "chromium", "tags": ["build_address:luci.chromium.try/android-kitkat-arm-rel/204080", "builder:android-kitkat-arm-rel", "buildset:patch/gerrit/chromium-review.googlesource.com/1504002/1", "cq_experimental:false", "user_agent:cq"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "android-kitkat-arm-rel", "buildnumber": 204080, "category": "cq", "got_angle_revision": "f094bac949922dabc3dd6944f3dec04111e953b6", "got_dawn_revision": "b47470daa7377a804df5d94e7a93b5925a57f84a", "got_nacl_revision": "1ed9878b8eb68c1e0d0268754dafcf83e747fa8f", "got_revision": "79d7f822d09d101a0ed5ae719b2d62f750c4cad2", "got_revision_cp": "refs/heads/master@{#637770}", "got_swarming_client_revision": "7a61cf37d6a0163f0ec02d495289a1d038e62457", "got_v8_revision": "6641700a356c9a321198ea8beefcd9323a4da862", "got_v8_revision_cp": "refs/heads/7.4.282@{#1}", "got_webrtc_revision": "7949f215c1183d8bfc5b13f86594a03d3d648f68", "got_webrtc_revision_cp": "refs/heads/master@{#26971}", "mastername": "tryserver.chromium.android", "patch_gerrit_url": "https://chromium-review.googlesource.com", "patch_issue": 1504002, "patch_project": "chromium/src", "patch_ref": "refs/changes/02/1504002/1", "patch_repository_url": "https://chromium.googlesource.com/chromium/src", "patch_set": 1, "patch_storage": "gerrit", "path_config": "generic", "reason": "CQ", "recipe": "chromium_trybot", "repository": "https://chromium.googlesource.com/chromium/src", "revision": "HEAD"}', '--summary-json-file', '/b/swarming/w/ir/tmp/t/tmpAU63pw.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/tmpAmJrq8.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: 'gcm_unit_tests on Android device Nexus 5 (with patch)' nest_level: 0 ok_ret: frozenset([0]) 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: 38628 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/8919798042567208000 LOGDOG_STREAM_PROJECT: chromium LOGDOG_STREAM_SERVER_PATH: unix:/b/swarming/w/ir/tmp/ld.sock LOGICAL: eth0 LUCI_CONTEXT: /b/swarming/w/itCVcoTy/luci_context.696147010 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: swarm1736-c4 SWARMING_EXTERNAL_BOT_SETUP: 1 SWARMING_HEADLESS: 1 SWARMING_SERVER: https://chromium-swarm.appspot.com SWARMING_TASK_ID: 43682f118f683711 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-05 12:15:00,506 - root: [DEBUG] Using task_output_dir: '/b/swarming/w/ir/tmp/t/tmpOCbhaU' 2019-03-05 12:15:00,506 - root: [WARNING] task_output_dir '/b/swarming/w/ir/tmp/t/tmpOCbhaU' already exists! 2019-03-05 12:15:00,506 - root: [WARNING] task_output_dir existing content: [] 2019-03-05 12:15:00,506 - 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/tmpAmJrq8.json -output-dir /b/swarming/w/ir/tmp/t/tmpOCbhaU -task-summary-json /b/swarming/w/ir/tmp/t/tmpAU63pw.json [D2019-03-05T12:15:00.513054-08:00 22257 0 auth.go:1265] Minting a new token {"key":"luci_ctx/e23679e4891db04b1b6418ac069e8bed2055de4eb8430a6046c68af31fddec14", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-03-05T12:15:00.513123-08:00 22257 0 luci_ctx.go:138] POST http://127.0.0.1:43453/rpc/LuciLocalAuthService.GetOAuthToken {"key":"luci_ctx/e23679e4891db04b1b6418ac069e8bed2055de4eb8430a6046c68af31fddec14", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-03-05T12:15:00.514693-08:00 22257 0 auth.go:1222] Token expires in 53m30.485339193s {"key":"luci_ctx/e23679e4891db04b1b6418ac069e8bed2055de4eb8430a6046c68af31fddec14", "scopes":"https://www.googleapis.com/auth/userinfo.email"} 4368418e3af59510: 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/ioQoWSyn/output.json I 0.000s Main command: /b/swarming/w/ir/build/android/test_runner.py gtest --suite gcm_unit_tests --output-directory /b/swarming/w/ir/out/Release --runtime-deps-path /b/swarming/w/ir/out/Release/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/ioQoWSyn/output.json I 0.007s Main condition '<lambda>' met I 0.009s Main condition '<lambda>' met I 3.146s TimeoutThread-1-for-prepare_device(0602ff62f0e96dad) condition 'sd_card_ready' met (0.0s) I 3.692s TimeoutThread-1-for-prepare_device(0602ff62f0e96dad) condition 'pm_ready' met (0.6s) I 3.702s TimeoutThread-1-for-prepare_device(0602ff62f0e96dad) condition 'boot_completed' met (0.6s) I 7.440s calculate_device_checksums condition '<lambda>' met (0.0s) I 8.658s TimeoutThread-1-for-individual_device_set_up(0602ff62f0e96dad) Pushing 2428 files via .zip of size 6035778 I 15.068s list_tests(0602ff62f0e96dad) flags: I 15.068s list_tests(0602ff62f0e96dad) --gtest_list_tests I 16.303s list_tests(0602ff62f0e96dad) /storage/emulated/legacy/temp_file-8498667859e2c.gtest_out size on device: 4980 I 16.371s Main Using external sharding settings. This is shard 0/1 I 16.372s Main STARTING TRY #1/3 I 16.372s Main Will run 188 tests on 1 devices: 0602ff62f0e96dad I 18.550s run_tests_on_device(0602ff62f0e96dad) flags: I 18.551s run_tests_on_device(0602ff62f0e96dad) Getting logdog client. I 22.700s run_tests_on_device(0602ff62f0e96dad) /storage/emulated/legacy/temp_file-791db099127c4.gtest_out size on device: 43565 I 23.018s run_tests_on_device(0602ff62f0e96dad) Logcat saved to https://luci-logdog.appspot.com/v/?s=chromium%2Fandroid%2Fswarming%2Flogcats%2F4368343dc0e7fc11%2F%2B%2Flogcat_logcat_4598254317288053905_20190305T194451-UTC_0602ff62f0e96dad I 23.018s archive Writing text to logdog stream, logcat_logcat_4598254317288053905_20190305T194451-UTC_0602ff62f0e96dad I 23.620s run_tests_on_device(0602ff62f0e96dad) >>ScopedMainEntryLogger I 23.620s run_tests_on_device(0602ff62f0e96dad) 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.620s run_tests_on_device(0602ff62f0e96dad) [==========] Running 188 tests from 16 test suites. I 23.620s run_tests_on_device(0602ff62f0e96dad) [----------] Global test environment set-up. I 23.620s run_tests_on_device(0602ff62f0e96dad) [----------] 4 tests from MCSMessageTest I 23.620s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSMessageTest.Invalid I 23.620s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSMessageTest.Invalid (1 ms) I 23.620s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSMessageTest.InitInferTag I 23.620s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSMessageTest.InitInferTag (1 ms) I 23.620s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSMessageTest.InitWithTag I 23.620s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSMessageTest.InitWithTag (1 ms) I 23.620s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSMessageTest.InitPassOwnership I 23.620s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSMessageTest.InitPassOwnership (0 ms) I 23.620s run_tests_on_device(0602ff62f0e96dad) [----------] 4 tests from MCSMessageTest (3 ms total) I 23.620s run_tests_on_device(0602ff62f0e96dad) I 23.620s run_tests_on_device(0602ff62f0e96dad) [----------] 4 tests from MCSUtilTest I 23.620s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSUtilTest.BuildLoginRequest I 23.620s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSUtilTest.BuildLoginRequest (1 ms) I 23.620s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSUtilTest.ProtobufToTag I 23.620s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSUtilTest.ProtobufToTag (0 ms) I 23.620s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSUtilTest.PersistentIds I 23.620s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSUtilTest.PersistentIds (1 ms) I 23.620s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSUtilTest.StreamIds I 23.621s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSUtilTest.StreamIds (1 ms) I 23.621s run_tests_on_device(0602ff62f0e96dad) [----------] 4 tests from MCSUtilTest (3 ms total) I 23.621s run_tests_on_device(0602ff62f0e96dad) I 23.621s run_tests_on_device(0602ff62f0e96dad) [----------] 15 tests from GCMSocketStreamTest I 23.621s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMSocketStreamTest.ReadDataSync I 23.621s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMSocketStreamTest.ReadDataSync (15 ms) I 23.621s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMSocketStreamTest.ReadPartialDataSync I 23.621s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMSocketStreamTest.ReadPartialDataSync (7 ms) I 23.621s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMSocketStreamTest.ReadAsync I 23.621s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMSocketStreamTest.ReadAsync (8 ms) I 23.621s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMSocketStreamTest.TwoReadsAtOnce I 23.621s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMSocketStreamTest.TwoReadsAtOnce (8 ms) I 23.621s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMSocketStreamTest.TwoReadsAtOnceWithRebuild I 23.621s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMSocketStreamTest.TwoReadsAtOnceWithRebuild (7 ms) I 23.621s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMSocketStreamTest.ReadError I 23.621s run_tests_on_device(0602ff62f0e96dad) [ERROR:socket_stream.cc(219)] Closing stream with result -2 I 23.621s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMSocketStreamTest.ReadError (7 ms) I 23.621s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMSocketStreamTest.ReadDisconnected I 23.621s run_tests_on_device(0602ff62f0e96dad) [ERROR:socket_stream.cc(219)] Closing stream with result -2 I 23.621s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMSocketStreamTest.ReadDisconnected (7 ms) I 23.621s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMSocketStreamTest.WriteFull I 23.621s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMSocketStreamTest.WriteFull (8 ms) I 23.621s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMSocketStreamTest.WritePartial I 23.621s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMSocketStreamTest.WritePartial (7 ms) I 23.621s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMSocketStreamTest.WritePartialWithLengthChecking I 23.621s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMSocketStreamTest.WritePartialWithLengthChecking (5 ms) I 23.621s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMSocketStreamTest.WriteNone I 23.621s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMSocketStreamTest.WriteNone (7 ms) I 23.621s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMSocketStreamTest.WriteThenRead I 23.621s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMSocketStreamTest.WriteThenRead (7 ms) I 23.621s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMSocketStreamTest.ReadThenWrite I 23.621s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMSocketStreamTest.ReadThenWrite (6 ms) I 23.621s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMSocketStreamTest.WriteError I 23.621s run_tests_on_device(0602ff62f0e96dad) [ERROR:socket_stream.cc(300)] Failed to flush socket. I 23.621s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMSocketStreamTest.WriteError (7 ms) I 23.621s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMSocketStreamTest.WriteDisconnected I 23.621s run_tests_on_device(0602ff62f0e96dad) [ERROR:socket_stream.cc(300)] Failed to flush socket. I 23.621s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMSocketStreamTest.WriteDisconnected (7 ms) I 23.621s run_tests_on_device(0602ff62f0e96dad) [----------] 15 tests from GCMSocketStreamTest (116 ms total) I 23.621s run_tests_on_device(0602ff62f0e96dad) I 23.621s run_tests_on_device(0602ff62f0e96dad) [----------] 3 tests from AccountMappingTest I 23.621s run_tests_on_device(0602ff62f0e96dad) [ RUN ] AccountMappingTest.SerializeAccountMapping I 23.621s run_tests_on_device(0602ff62f0e96dad) [ OK ] AccountMappingTest.SerializeAccountMapping (1 ms) I 23.621s run_tests_on_device(0602ff62f0e96dad) [ RUN ] AccountMappingTest.DeserializeAccountMapping I 23.622s run_tests_on_device(0602ff62f0e96dad) [ OK ] AccountMappingTest.DeserializeAccountMapping (0 ms) I 23.622s run_tests_on_device(0602ff62f0e96dad) [ RUN ] AccountMappingTest.DeserializeAccountMappingInvalidInput I 23.622s run_tests_on_device(0602ff62f0e96dad) [ OK ] AccountMappingTest.DeserializeAccountMappingInvalidInput (1 ms) I 23.622s run_tests_on_device(0602ff62f0e96dad) [----------] 3 tests from AccountMappingTest (3 ms total) I 23.622s run_tests_on_device(0602ff62f0e96dad) I 23.622s run_tests_on_device(0602ff62f0e96dad) [----------] 12 tests from CheckinRequestTest I 23.622s run_tests_on_device(0602ff62f0e96dad) [ RUN ] CheckinRequestTest.FetcherDataAndURL I 23.622s run_tests_on_device(0602ff62f0e96dad) [ OK ] CheckinRequestTest.FetcherDataAndURL (3 ms) I 23.622s run_tests_on_device(0602ff62f0e96dad) [ RUN ] CheckinRequestTest.ResponseBodyEmpty I 23.622s run_tests_on_device(0602ff62f0e96dad) [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.622s run_tests_on_device(0602ff62f0e96dad) [ OK ] CheckinRequestTest.ResponseBodyEmpty (6 ms) I 23.622s run_tests_on_device(0602ff62f0e96dad) [ RUN ] CheckinRequestTest.ResponseBodyCorrupted I 23.622s run_tests_on_device(0602ff62f0e96dad) [ERROR:checkin_request.cc(242)] Failed to get checkin response. HTTP Status: 200. Retrying. I 23.622s run_tests_on_device(0602ff62f0e96dad) [ OK ] CheckinRequestTest.ResponseBodyCorrupted (10 ms) I 23.622s run_tests_on_device(0602ff62f0e96dad) [ RUN ] CheckinRequestTest.ResponseHttpStatusUnauthorized I 23.622s run_tests_on_device(0602ff62f0e96dad) [ERROR:checkin_request.cc(231)] No point retrying the checkin with status: 401. Checkin failed. I 23.622s run_tests_on_device(0602ff62f0e96dad) [ OK ] CheckinRequestTest.ResponseHttpStatusUnauthorized (4 ms) I 23.622s run_tests_on_device(0602ff62f0e96dad) [ RUN ] CheckinRequestTest.ResponseHttpStatusBadRequest I 23.622s run_tests_on_device(0602ff62f0e96dad) [ERROR:checkin_request.cc(231)] No point retrying the checkin with status: 400. Checkin failed. I 23.622s run_tests_on_device(0602ff62f0e96dad) [ OK ] CheckinRequestTest.ResponseHttpStatusBadRequest (4 ms) I 23.622s run_tests_on_device(0602ff62f0e96dad) [ RUN ] CheckinRequestTest.ResponseHttpStatusNotOK I 23.622s run_tests_on_device(0602ff62f0e96dad) [ERROR:checkin_request.cc(242)] Failed to get checkin response. HTTP Status: 500. Retrying. I 23.622s run_tests_on_device(0602ff62f0e96dad) [ OK ] CheckinRequestTest.ResponseHttpStatusNotOK (6 ms) I 23.622s run_tests_on_device(0602ff62f0e96dad) [ RUN ] CheckinRequestTest.ResponseMissingAndroidId I 23.622s run_tests_on_device(0602ff62f0e96dad) [ERROR:checkin_request.cc(255)] Android ID or security token is 0. Retrying. I 23.622s run_tests_on_device(0602ff62f0e96dad) [ OK ] CheckinRequestTest.ResponseMissingAndroidId (6 ms) I 23.622s run_tests_on_device(0602ff62f0e96dad) [ RUN ] CheckinRequestTest.ResponseMissingSecurityToken I 23.622s run_tests_on_device(0602ff62f0e96dad) [ERROR:checkin_request.cc(255)] Android ID or security token is 0. Retrying. I 23.622s run_tests_on_device(0602ff62f0e96dad) [ OK ] CheckinRequestTest.ResponseMissingSecurityToken (6 ms) I 23.622s run_tests_on_device(0602ff62f0e96dad) [ RUN ] CheckinRequestTest.AndroidIdEqualsZeroInResponse I 23.622s run_tests_on_device(0602ff62f0e96dad) [ERROR:checkin_request.cc(255)] Android ID or security token is 0. Retrying. I 23.622s run_tests_on_device(0602ff62f0e96dad) [ OK ] CheckinRequestTest.AndroidIdEqualsZeroInResponse (6 ms) I 23.622s run_tests_on_device(0602ff62f0e96dad) [ RUN ] CheckinRequestTest.SecurityTokenEqualsZeroInResponse I 23.622s run_tests_on_device(0602ff62f0e96dad) [ERROR:checkin_request.cc(255)] Android ID or security token is 0. Retrying. I 23.622s run_tests_on_device(0602ff62f0e96dad) [ OK ] CheckinRequestTest.SecurityTokenEqualsZeroInResponse (6 ms) I 23.622s run_tests_on_device(0602ff62f0e96dad) [ RUN ] CheckinRequestTest.SuccessfulFirstTimeCheckin I 23.622s run_tests_on_device(0602ff62f0e96dad) [ OK ] CheckinRequestTest.SuccessfulFirstTimeCheckin (5 ms) I 23.622s run_tests_on_device(0602ff62f0e96dad) [ RUN ] CheckinRequestTest.SuccessfulSubsequentCheckin I 23.622s run_tests_on_device(0602ff62f0e96dad) [ OK ] CheckinRequestTest.SuccessfulSubsequentCheckin (3 ms) I 23.622s run_tests_on_device(0602ff62f0e96dad) [----------] 12 tests from CheckinRequestTest (65 ms total) I 23.622s run_tests_on_device(0602ff62f0e96dad) I 23.622s run_tests_on_device(0602ff62f0e96dad) [----------] 1 test from ConnectionEventTrackerTest I 23.622s run_tests_on_device(0602ff62f0e96dad) [ RUN ] ConnectionEventTrackerTest.SuccessfulAttempt I 23.622s run_tests_on_device(0602ff62f0e96dad) [ OK ] ConnectionEventTrackerTest.SuccessfulAttempt (1 ms) I 23.622s run_tests_on_device(0602ff62f0e96dad) [----------] 1 test from ConnectionEventTrackerTest (1 ms total) I 23.622s run_tests_on_device(0602ff62f0e96dad) I 23.622s run_tests_on_device(0602ff62f0e96dad) [----------] 14 tests from ConnectionFactoryImplTest I 23.622s run_tests_on_device(0602ff62f0e96dad) [ RUN ] ConnectionFactoryImplTest.Initialize I 23.622s run_tests_on_device(0602ff62f0e96dad) [ OK ] ConnectionFactoryImplTest.Initialize (5 ms) I 23.622s run_tests_on_device(0602ff62f0e96dad) [ RUN ] ConnectionFactoryImplTest.ConnectSuccess I 23.623s run_tests_on_device(0602ff62f0e96dad) [ OK ] ConnectionFactoryImplTest.ConnectSuccess (4 ms) I 23.623s run_tests_on_device(0602ff62f0e96dad) [ RUN ] ConnectionFactoryImplTest.ConnectFail I 23.623s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.623s run_tests_on_device(0602ff62f0e96dad) [ OK ] ConnectionFactoryImplTest.ConnectFail (4 ms) I 23.623s run_tests_on_device(0602ff62f0e96dad) [ RUN ] ConnectionFactoryImplTest.FailThenSucceed I 23.623s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.623s run_tests_on_device(0602ff62f0e96dad) [ OK ] ConnectionFactoryImplTest.FailThenSucceed (6 ms) I 23.623s run_tests_on_device(0602ff62f0e96dad) [ RUN ] ConnectionFactoryImplTest.MultipleFailuresThenSucceed I 23.623s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.623s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.623s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.623s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.623s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.623s run_tests_on_device(0602ff62f0e96dad) [ OK ] ConnectionFactoryImplTest.MultipleFailuresThenSucceed (31 ms) I 23.623s run_tests_on_device(0602ff62f0e96dad) [ RUN ] ConnectionFactoryImplTest.FailThenNetworkChangeEvent I 23.623s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.623s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -2 I 23.623s run_tests_on_device(0602ff62f0e96dad) [ OK ] ConnectionFactoryImplTest.FailThenNetworkChangeEvent (8 ms) I 23.623s run_tests_on_device(0602ff62f0e96dad) [ RUN ] ConnectionFactoryImplTest.CanarySucceedsThenDisconnects I 23.623s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.623s run_tests_on_device(0602ff62f0e96dad) [ OK ] ConnectionFactoryImplTest.CanarySucceedsThenDisconnects (9 ms) I 23.623s run_tests_on_device(0602ff62f0e96dad) [ RUN ] ConnectionFactoryImplTest.CanarySucceedsRetryDuringLogin I 23.623s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.623s run_tests_on_device(0602ff62f0e96dad) [ OK ] ConnectionFactoryImplTest.CanarySucceedsRetryDuringLogin (6 ms) I 23.623s run_tests_on_device(0602ff62f0e96dad) [ RUN ] ConnectionFactoryImplTest.FailViaSignalReset I 23.623s run_tests_on_device(0602ff62f0e96dad) [ OK ] ConnectionFactoryImplTest.FailViaSignalReset (5 ms) I 23.623s run_tests_on_device(0602ff62f0e96dad) [ RUN ] ConnectionFactoryImplTest.IgnoreResetWhileConnecting I 23.623s run_tests_on_device(0602ff62f0e96dad) [ OK ] ConnectionFactoryImplTest.IgnoreResetWhileConnecting (5 ms) I 23.623s run_tests_on_device(0602ff62f0e96dad) [ RUN ] ConnectionFactoryImplTest.SignalResetRestoresBackoff I 23.623s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.623s run_tests_on_device(0602ff62f0e96dad) [ OK ] ConnectionFactoryImplTest.SignalResetRestoresBackoff (9 ms) I 23.623s run_tests_on_device(0602ff62f0e96dad) [ RUN ] ConnectionFactoryImplTest.NetworkChangeBeforeFirstConnection I 23.623s run_tests_on_device(0602ff62f0e96dad) [ OK ] ConnectionFactoryImplTest.NetworkChangeBeforeFirstConnection (4 ms) I 23.623s run_tests_on_device(0602ff62f0e96dad) [ RUN ] ConnectionFactoryImplTest.ConnectionResetRace I 23.623s run_tests_on_device(0602ff62f0e96dad) [ OK ] ConnectionFactoryImplTest.ConnectionResetRace (4 ms) I 23.623s run_tests_on_device(0602ff62f0e96dad) [ RUN ] ConnectionFactoryImplTest.MultipleFailuresWrapClientEvents I 23.623s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.623s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.623s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.623s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.623s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.623s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.623s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.623s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.623s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.623s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.623s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.623s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.623s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.623s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.623s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ OK ] ConnectionFactoryImplTest.MultipleFailuresWrapClientEvents (520 ms) I 23.624s run_tests_on_device(0602ff62f0e96dad) [----------] 14 tests from ConnectionFactoryImplTest (623 ms total) I 23.624s run_tests_on_device(0602ff62f0e96dad) I 23.624s run_tests_on_device(0602ff62f0e96dad) [----------] 20 tests from GCMConnectionHandlerImplTest I 23.624s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMConnectionHandlerImplTest.Init I 23.624s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMConnectionHandlerImplTest.Init (13 ms) I 23.624s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMConnectionHandlerImplTest.InitFailedVersionCheck I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_handler_impl.cc(295)] Invalid GCM version response: 37 I 23.624s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMConnectionHandlerImplTest.InitFailedVersionCheck (7 ms) I 23.624s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMConnectionHandlerImplTest.InitTimeout I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_handler_impl.cc(471)] Timed out waiting for GCM Protocol buffer. I 23.624s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMConnectionHandlerImplTest.InitTimeout (114 ms) I 23.624s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMConnectionHandlerImplTest.InitIncompleteTimeout I 23.624s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_handler_impl.cc(471)] Timed out waiting for GCM Protocol buffer. I 23.624s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMConnectionHandlerImplTest.InitIncompleteTimeout (113 ms) I 23.624s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMConnectionHandlerImplTest.ReInit I 23.625s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_handler_impl.cc(471)] Timed out waiting for GCM Protocol buffer. I 23.625s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMConnectionHandlerImplTest.ReInit (138 ms) I 23.625s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMConnectionHandlerImplTest.RecvMsg I 23.625s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMConnectionHandlerImplTest.RecvMsg (7 ms) I 23.625s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMConnectionHandlerImplTest.Recv2Msgs I 23.625s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMConnectionHandlerImplTest.Recv2Msgs (7 ms) I 23.625s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMConnectionHandlerImplTest.RecvLongMsg I 23.625s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMConnectionHandlerImplTest.RecvLongMsg (7 ms) I 23.625s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMConnectionHandlerImplTest.RecvLongMsg2Parts I 23.625s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMConnectionHandlerImplTest.RecvLongMsg2Parts (7 ms) I 23.625s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMConnectionHandlerImplTest.Recv2LongMsgs I 23.625s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMConnectionHandlerImplTest.Recv2LongMsgs (7 ms) I 23.625s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMConnectionHandlerImplTest.ReadTimeout I 23.625s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_handler_impl.cc(471)] Timed out waiting for GCM Protocol buffer. I 23.625s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMConnectionHandlerImplTest.ReadTimeout (120 ms) I 23.625s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMConnectionHandlerImplTest.RecvMsgNoData I 23.625s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMConnectionHandlerImplTest.RecvMsgNoData (7 ms) I 23.625s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMConnectionHandlerImplTest.SendMsg I 23.625s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMConnectionHandlerImplTest.SendMsg (7 ms) I 23.625s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMConnectionHandlerImplTest.SendMsgSocketDisconnected I 23.625s run_tests_on_device(0602ff62f0e96dad) [ERROR:socket_stream.cc(300)] Failed to flush socket. I 23.625s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMConnectionHandlerImplTest.SendMsgSocketDisconnected (7 ms) I 23.625s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMConnectionHandlerImplTest.ExtraLargeDataPacket I 23.625s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMConnectionHandlerImplTest.ExtraLargeDataPacket (9 ms) I 23.625s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMConnectionHandlerImplTest.2ExtraLargeDataPacketMsgs I 23.625s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMConnectionHandlerImplTest.2ExtraLargeDataPacketMsgs (9 ms) I 23.625s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMConnectionHandlerImplTest.InvalidTag I 23.625s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_handler_impl.cc(399)] Received message of invalid type 100 I 23.625s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMConnectionHandlerImplTest.InvalidTag (8 ms) I 23.625s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMConnectionHandlerImplTest.RecvMsgSplitSize I 23.625s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMConnectionHandlerImplTest.RecvMsgSplitSize (8 ms) I 23.625s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMConnectionHandlerImplTest.InvalidData I 23.625s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_handler_impl.cc(409)] Unable to parse GCM message of type 8 I 23.625s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMConnectionHandlerImplTest.InvalidData (7 ms) I 23.625s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMConnectionHandlerImplTest.InvalidDataLong I 23.625s run_tests_on_device(0602ff62f0e96dad) [ERROR:connection_handler_impl.cc(428)] Unable to parse GCM message of type 8 I 23.625s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMConnectionHandlerImplTest.InvalidDataLong (8 ms) I 23.625s run_tests_on_device(0602ff62f0e96dad) [----------] 20 tests from GCMConnectionHandlerImplTest (612 ms total) I 23.625s run_tests_on_device(0602ff62f0e96dad) I 23.625s run_tests_on_device(0602ff62f0e96dad) [----------] 17 tests from GCMStoreImplTest I 23.625s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMStoreImplTest.LoadNew I 23.625s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMStoreImplTest.LoadNew (15 ms) I 23.625s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMStoreImplTest.LoadWithoutCreatingNewStore I 23.625s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMStoreImplTest.LoadWithoutCreatingNewStore (1 ms) I 23.625s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMStoreImplTest.LoadWithEmptyDirectory I 23.625s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMStoreImplTest.LoadWithEmptyDirectory (1 ms) I 23.625s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMStoreImplTest.DeviceCredentials I 23.625s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMStoreImplTest.DeviceCredentials (17 ms) I 23.625s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMStoreImplTest.LastCheckinInfo I 23.625s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(1033)] Failed to restore last checkin time. Using default = 0. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMStoreImplTest.LastCheckinInfo (14 ms) I 23.626s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMStoreImplTest.GServicesSettings_ProtocolV2 I 23.626s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMStoreImplTest.GServicesSettings_ProtocolV2 (17 ms) I 23.626s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMStoreImplTest.Registrations I 23.626s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMStoreImplTest.Registrations (24 ms) I 23.626s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMStoreImplTest.IncomingMessages I 23.626s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMStoreImplTest.IncomingMessages (47 ms) I 23.626s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMStoreImplTest.OutgoingMessages I 23.626s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMStoreImplTest.OutgoingMessages (48 ms) I 23.626s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMStoreImplTest.IncomingAndOutgoingMessages I 23.626s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMStoreImplTest.IncomingAndOutgoingMessages (128 ms) I 23.626s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMStoreImplTest.PerAppMessageLimits I 23.626s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMStoreImplTest.PerAppMessageLimits (137 ms) I 23.626s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMStoreImplTest.AccountMapping I 23.626s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMStoreImplTest.AccountMapping (24 ms) I 23.626s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMStoreImplTest.HeartbeatInterval I 23.626s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMStoreImplTest.HeartbeatInterval (26 ms) I 23.626s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMStoreImplTest.AddMessageAfterDestroy I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.626s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.627s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.627s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.627s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.627s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.627s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.627s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.627s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.627s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist. I 23.627s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMStoreImplTest.AddMessageAfterDestroy (28 ms) I 23.627s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMStoreImplTest.ReloadAfterClose I 23.627s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMStoreImplTest.ReloadAfterClose (11 ms) I 23.627s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMStoreImplTest.LastTokenFetchTime I 23.627s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(1114)] Failed to restore last token fetching time. Using default = 0. I 23.627s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMStoreImplTest.LastTokenFetchTime (18 ms) I 23.627s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMStoreImplTest.InstanceIDData I 23.627s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMStoreImplTest.InstanceIDData (23 ms) I 23.627s run_tests_on_device(0602ff62f0e96dad) [----------] 17 tests from GCMStoreImplTest (584 ms total) I 23.627s run_tests_on_device(0602ff62f0e96dad) I 23.627s run_tests_on_device(0602ff62f0e96dad) [----------] 12 tests from GServicesSettingsTest I 23.627s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GServicesSettingsTest.DefaultSettingsAndDigest I 23.627s run_tests_on_device(0602ff62f0e96dad) [ OK ] GServicesSettingsTest.DefaultSettingsAndDigest (1 ms) I 23.627s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GServicesSettingsTest.CalculateDigest I 23.627s run_tests_on_device(0602ff62f0e96dad) [ OK ] GServicesSettingsTest.CalculateDigest (1 ms) I 23.627s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GServicesSettingsTest.UpdateFromEmptyLoadResult I 23.627s run_tests_on_device(0602ff62f0e96dad) [ OK ] GServicesSettingsTest.UpdateFromEmptyLoadResult (2 ms) I 23.627s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GServicesSettingsTest.UpdateFromLoadResultWithSettingMissing I 23.627s run_tests_on_device(0602ff62f0e96dad) [ OK ] GServicesSettingsTest.UpdateFromLoadResultWithSettingMissing (0 ms) I 23.627s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GServicesSettingsTest.UpdateFromLoadResult I 23.627s run_tests_on_device(0602ff62f0e96dad) [ OK ] GServicesSettingsTest.UpdateFromLoadResult (0 ms) I 23.627s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GServicesSettingsTest.CheckinResponseMinimumCheckinInterval I 23.627s run_tests_on_device(0602ff62f0e96dad) [ OK ] GServicesSettingsTest.CheckinResponseMinimumCheckinInterval (1 ms) I 23.627s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GServicesSettingsTest.CheckinResponseUpdateCheckinInterval I 23.627s run_tests_on_device(0602ff62f0e96dad) [ OK ] GServicesSettingsTest.CheckinResponseUpdateCheckinInterval (1 ms) I 23.627s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GServicesSettingsTest.CheckinResponseUpdateRegistrationURL I 23.627s run_tests_on_device(0602ff62f0e96dad) [ OK ] GServicesSettingsTest.CheckinResponseUpdateRegistrationURL (1 ms) I 23.627s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GServicesSettingsTest.CheckinResponseUpdateCheckinURL I 23.627s run_tests_on_device(0602ff62f0e96dad) [ OK ] GServicesSettingsTest.CheckinResponseUpdateCheckinURL (1 ms) I 23.627s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GServicesSettingsTest.CheckinResponseUpdateMCSHostname I 23.627s run_tests_on_device(0602ff62f0e96dad) [ OK ] GServicesSettingsTest.CheckinResponseUpdateMCSHostname (0 ms) I 23.627s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GServicesSettingsTest.CheckinResponseUpdateMCSSecurePort I 23.627s run_tests_on_device(0602ff62f0e96dad) [ OK ] GServicesSettingsTest.CheckinResponseUpdateMCSSecurePort (0 ms) I 23.627s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GServicesSettingsTest.UpdateFromCheckinResponseSettingsDiff I 23.627s run_tests_on_device(0602ff62f0e96dad) [ OK ] GServicesSettingsTest.UpdateFromCheckinResponseSettingsDiff (1 ms) I 23.627s run_tests_on_device(0602ff62f0e96dad) [----------] 12 tests from GServicesSettingsTest (12 ms total) I 23.627s run_tests_on_device(0602ff62f0e96dad) I 23.627s run_tests_on_device(0602ff62f0e96dad) [----------] 14 tests from HeartbeatManagerTest I 23.627s run_tests_on_device(0602ff62f0e96dad) [ RUN ] HeartbeatManagerTest.Init I 23.627s run_tests_on_device(0602ff62f0e96dad) [ OK ] HeartbeatManagerTest.Init (0 ms) I 23.627s run_tests_on_device(0602ff62f0e96dad) [ RUN ] HeartbeatManagerTest.AckBeforeStart I 23.627s run_tests_on_device(0602ff62f0e96dad) [ OK ] HeartbeatManagerTest.AckBeforeStart (1 ms) I 23.627s run_tests_on_device(0602ff62f0e96dad) [ RUN ] HeartbeatManagerTest.Start I 23.628s run_tests_on_device(0602ff62f0e96dad) [ OK ] HeartbeatManagerTest.Start (1 ms) I 23.628s run_tests_on_device(0602ff62f0e96dad) [ RUN ] HeartbeatManagerTest.AckedHeartbeat I 23.628s run_tests_on_device(0602ff62f0e96dad) [ OK ] HeartbeatManagerTest.AckedHeartbeat (1 ms) I 23.628s run_tests_on_device(0602ff62f0e96dad) [ RUN ] HeartbeatManagerTest.UnackedHeartbeat I 23.628s run_tests_on_device(0602ff62f0e96dad) [WARNING:heartbeat_manager.cc(165)] Lost connection to MCS, reconnecting. I 23.628s run_tests_on_device(0602ff62f0e96dad) [ OK ] HeartbeatManagerTest.UnackedHeartbeat (1 ms) I 23.628s run_tests_on_device(0602ff62f0e96dad) [ RUN ] HeartbeatManagerTest.UpdateIntervalThenStart I 23.628s run_tests_on_device(0602ff62f0e96dad) [ OK ] HeartbeatManagerTest.UpdateIntervalThenStart (0 ms) I 23.628s run_tests_on_device(0602ff62f0e96dad) [ RUN ] HeartbeatManagerTest.StartThenUpdateInterval I 23.628s run_tests_on_device(0602ff62f0e96dad) [ OK ] HeartbeatManagerTest.StartThenUpdateInterval (1 ms) I 23.628s run_tests_on_device(0602ff62f0e96dad) [ RUN ] HeartbeatManagerTest.UpdateTimerBeforeStart I 23.628s run_tests_on_device(0602ff62f0e96dad) [ OK ] HeartbeatManagerTest.UpdateTimerBeforeStart (1 ms) I 23.628s run_tests_on_device(0602ff62f0e96dad) [ RUN ] HeartbeatManagerTest.UpdateTimerAfterStart I 23.628s run_tests_on_device(0602ff62f0e96dad) [ OK ] HeartbeatManagerTest.UpdateTimerAfterStart (1 ms) I 23.628s run_tests_on_device(0602ff62f0e96dad) [ RUN ] HeartbeatManagerTest.Stop I 23.628s run_tests_on_device(0602ff62f0e96dad) [ OK ] HeartbeatManagerTest.Stop (0 ms) I 23.628s run_tests_on_device(0602ff62f0e96dad) [ RUN ] HeartbeatManagerTest.MissedHeartbeat I 23.628s run_tests_on_device(0602ff62f0e96dad) [ OK ] HeartbeatManagerTest.MissedHeartbeat (0 ms) I 23.628s run_tests_on_device(0602ff62f0e96dad) [ RUN ] HeartbeatManagerTest.SetClientHeartbeatInterval I 23.628s run_tests_on_device(0602ff62f0e96dad) [ OK ] HeartbeatManagerTest.SetClientHeartbeatInterval (0 ms) I 23.628s run_tests_on_device(0602ff62f0e96dad) [ RUN ] HeartbeatManagerTest.ClientIntervalInvalid I 23.628s run_tests_on_device(0602ff62f0e96dad) [ OK ] HeartbeatManagerTest.ClientIntervalInvalid (1 ms) I 23.628s run_tests_on_device(0602ff62f0e96dad) [ RUN ] HeartbeatManagerTest.ClientIntervalAfterHeartbeatTriggered I 23.628s run_tests_on_device(0602ff62f0e96dad) [ OK ] HeartbeatManagerTest.ClientIntervalAfterHeartbeatTriggered (1 ms) I 23.628s run_tests_on_device(0602ff62f0e96dad) [----------] 14 tests from HeartbeatManagerTest (11 ms total) I 23.628s run_tests_on_device(0602ff62f0e96dad) I 23.628s run_tests_on_device(0602ff62f0e96dad) [----------] 30 tests from MCSClientTest I 23.628s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.InitializeNew I 23.628s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.InitializeNew (10 ms) I 23.628s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.InitializeExisting I 23.628s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.InitializeExisting (17 ms) I 23.628s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.LoginSuccess I 23.628s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.LoginSuccess (10 ms) I 23.628s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.FailLogin I 23.628s run_tests_on_device(0602ff62f0e96dad) [ERROR:mcs_client.cc(708)] Failed to log in to GCM, resetting connection. I 23.628s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.FailLogin (11 ms) I 23.628s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.SendMessageNoRMQ I 23.628s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.SendMessageNoRMQ (16 ms) I 23.628s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.SendMessageNoRMQWhileDisconnected I 23.628s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.SendMessageNoRMQWhileDisconnected (18 ms) I 23.628s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.SendMessageRMQ I 23.628s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.SendMessageRMQ (16 ms) I 23.628s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.SendMessageRMQWhileDisconnected I 23.628s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.SendMessageRMQWhileDisconnected (20 ms) I 23.628s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.SendMessageRMQOnRestart I 23.628s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.SendMessageRMQOnRestart (17 ms) I 23.628s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.SendMessageRMQWithStreamAck I 23.628s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.SendMessageRMQWithStreamAck (31 ms) I 23.629s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.SendMessageRMQAckOnReconnect I 23.629s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.SendMessageRMQAckOnReconnect (37 ms) I 23.629s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.SendMessageRMQPartialAckOnReconnect I 23.629s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.SendMessageRMQPartialAckOnReconnect (26 ms) I 23.629s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.SelectiveAckMidStream I 23.629s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.SelectiveAckMidStream (24 ms) I 23.629s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.AckOnLogin I 23.629s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.AckOnLogin (24 ms) I 23.629s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.AckOnSend I 23.629s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.AckOnSend (19 ms) I 23.629s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.AckWhenLimitReachedWithHeartbeat I 23.629s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.AckWhenLimitReachedWithHeartbeat (62 ms) I 23.629s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.ExpiredTTLOnSend I 23.629s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.ExpiredTTLOnSend (11 ms) I 23.629s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.ExpiredTTLOnRestart I 23.629s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.ExpiredTTLOnRestart (28 ms) I 23.629s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.CollapseKeysSameApp I 23.629s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.CollapseKeysSameApp (21 ms) I 23.629s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.CollapseKeysDifferentApp I 23.629s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.CollapseKeysDifferentApp (23 ms) I 23.629s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.CollapseKeysDifferentUser I 23.629s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.CollapseKeysDifferentUser (26 ms) I 23.629s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.CustomHeartbeatIntervalTooShort I 23.629s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.CustomHeartbeatIntervalTooShort (31 ms) I 23.629s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.CustomHeartbeatIntervalTooLong I 23.629s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.CustomHeartbeatIntervalTooLong (23 ms) I 23.629s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.CustomHeartbeatIntervalSingleInterval I 23.629s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.CustomHeartbeatIntervalSingleInterval (27 ms) I 23.629s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.CustomHeartbeatIntervalSetBeforeInitialize I 23.629s run_tests_on_device(0602ff62f0e96dad) [ERROR:gcm_store_impl.cc(799)] GCMStore db doesn't exist. I 23.629s run_tests_on_device(0602ff62f0e96dad) [ERROR:mcs_client.cc(526)] GCM Update failed! I 23.629s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.CustomHeartbeatIntervalSetBeforeInitialize (14 ms) I 23.629s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.CustomHeartbeatIntervalSetBeforeLogin I 23.629s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.CustomHeartbeatIntervalSetBeforeLogin (18 ms) I 23.629s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.CustomHeartbeatIntervalSecondIntervalLonger I 23.629s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.CustomHeartbeatIntervalSecondIntervalLonger (26 ms) I 23.629s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.CustomHeartbeatIntervalSecondIntervalShorter I 23.629s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.CustomHeartbeatIntervalSecondIntervalShorter (27 ms) I 23.629s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.CustomHeartbeatIntervalRemoveShorterInterval I 23.629s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.CustomHeartbeatIntervalRemoveShorterInterval (27 ms) I 23.629s run_tests_on_device(0602ff62f0e96dad) [ RUN ] MCSClientTest.AckWhenImmediateAckRequested I 23.629s run_tests_on_device(0602ff62f0e96dad) [ OK ] MCSClientTest.AckWhenImmediateAckRequested (34 ms) I 23.629s run_tests_on_device(0602ff62f0e96dad) [----------] 30 tests from MCSClientTest (705 ms total) I 23.629s run_tests_on_device(0602ff62f0e96dad) I 23.629s run_tests_on_device(0602ff62f0e96dad) [----------] 19 tests from GCMRegistrationRequestTest I 23.629s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMRegistrationRequestTest.RequestSuccessful I 23.629s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMRegistrationRequestTest.RequestSuccessful (7 ms) I 23.629s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMRegistrationRequestTest.RequestDataAndURL I 23.629s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMRegistrationRequestTest.RequestDataAndURL (5 ms) I 23.629s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMRegistrationRequestTest.RequestRegistrationWithMultipleSenderIds I 23.629s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMRegistrationRequestTest.RequestRegistrationWithMultipleSenderIds (4 ms) I 23.630s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMRegistrationRequestTest.ResponseParsing I 23.630s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMRegistrationRequestTest.ResponseParsing (3 ms) I 23.630s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMRegistrationRequestTest.ResponseParsingFailed I 23.630s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMRegistrationRequestTest.ResponseParsingFailed (5 ms) I 23.630s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMRegistrationRequestTest.ResponseHttpStatusNotOK I 23.630s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMRegistrationRequestTest.ResponseHttpStatusNotOK (5 ms) I 23.630s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMRegistrationRequestTest.ResponseMissingRegistrationId I 23.630s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMRegistrationRequestTest.ResponseMissingRegistrationId (7 ms) I 23.630s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMRegistrationRequestTest.ResponseDeviceRegistrationError I 23.630s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMRegistrationRequestTest.ResponseDeviceRegistrationError (5 ms) I 23.630s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMRegistrationRequestTest.ResponseAuthenticationError I 23.630s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMRegistrationRequestTest.ResponseAuthenticationError (5 ms) I 23.630s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMRegistrationRequestTest.ResponseInternalServerError I 23.630s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMRegistrationRequestTest.ResponseInternalServerError (6 ms) I 23.630s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMRegistrationRequestTest.ResponseInvalidParameters I 23.630s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMRegistrationRequestTest.ResponseInvalidParameters (3 ms) I 23.630s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMRegistrationRequestTest.ResponseInvalidSender I 23.630s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMRegistrationRequestTest.ResponseInvalidSender (4 ms) I 23.630s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMRegistrationRequestTest.ResponseInvalidSenderBadRequest I 23.630s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMRegistrationRequestTest.ResponseInvalidSenderBadRequest (4 ms) I 23.630s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMRegistrationRequestTest.ResponseQuotaExceeded I 23.630s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMRegistrationRequestTest.ResponseQuotaExceeded (3 ms) I 23.630s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMRegistrationRequestTest.ResponseTooManyRegistrations I 23.630s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMRegistrationRequestTest.ResponseTooManyRegistrations (3 ms) I 23.630s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMRegistrationRequestTest.RequestNotSuccessful I 23.630s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMRegistrationRequestTest.RequestNotSuccessful (4 ms) I 23.630s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMRegistrationRequestTest.ResponseHttpNotOk I 23.630s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMRegistrationRequestTest.ResponseHttpNotOk (6 ms) I 23.630s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMRegistrationRequestTest.MaximumAttemptsReachedWithZeroRetries I 23.630s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMRegistrationRequestTest.MaximumAttemptsReachedWithZeroRetries (3 ms) I 23.630s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMRegistrationRequestTest.MaximumAttemptsReached I 23.630s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMRegistrationRequestTest.MaximumAttemptsReached (7 ms) I 23.630s run_tests_on_device(0602ff62f0e96dad) [----------] 19 tests from GCMRegistrationRequestTest (95 ms total) I 23.630s run_tests_on_device(0602ff62f0e96dad) I 23.630s run_tests_on_device(0602ff62f0e96dad) [----------] 4 tests from InstanceIDGetTokenRequestTest I 23.630s run_tests_on_device(0602ff62f0e96dad) [ RUN ] InstanceIDGetTokenRequestTest.RequestSuccessful I 23.630s run_tests_on_device(0602ff62f0e96dad) [ OK ] InstanceIDGetTokenRequestTest.RequestSuccessful (4 ms) I 23.630s run_tests_on_device(0602ff62f0e96dad) [ RUN ] InstanceIDGetTokenRequestTest.RequestDataAndURL I 23.630s run_tests_on_device(0602ff62f0e96dad) [ OK ] InstanceIDGetTokenRequestTest.RequestDataAndURL (3 ms) I 23.630s run_tests_on_device(0602ff62f0e96dad) [ RUN ] InstanceIDGetTokenRequestTest.RequestDataWithSubtype I 23.630s run_tests_on_device(0602ff62f0e96dad) [ OK ] InstanceIDGetTokenRequestTest.RequestDataWithSubtype (3 ms) I 23.630s run_tests_on_device(0602ff62f0e96dad) [ RUN ] InstanceIDGetTokenRequestTest.ResponseHttpStatusNotOK I 23.630s run_tests_on_device(0602ff62f0e96dad) [ OK ] InstanceIDGetTokenRequestTest.ResponseHttpStatusNotOK (5 ms) I 23.630s run_tests_on_device(0602ff62f0e96dad) [----------] 4 tests from InstanceIDGetTokenRequestTest (15 ms total) I 23.630s run_tests_on_device(0602ff62f0e96dad) I 23.630s run_tests_on_device(0602ff62f0e96dad) [----------] 13 tests from GCMUnregistrationRequestTest I 23.630s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMUnregistrationRequestTest.RequestDataPassedToFetcher I 23.630s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMUnregistrationRequestTest.RequestDataPassedToFetcher (2 ms) I 23.630s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMUnregistrationRequestTest.SuccessfulUnregistration I 23.630s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMUnregistrationRequestTest.SuccessfulUnregistration (3 ms) I 23.630s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMUnregistrationRequestTest.ResponseHttpStatusNotOK I 23.631s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMUnregistrationRequestTest.ResponseHttpStatusNotOK (6 ms) I 23.631s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMUnregistrationRequestTest.ResponseEmpty I 23.631s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMUnregistrationRequestTest.ResponseEmpty (5 ms) I 23.631s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMUnregistrationRequestTest.InvalidParametersError I 23.631s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMUnregistrationRequestTest.InvalidParametersError (4 ms) I 23.631s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMUnregistrationRequestTest.DeviceRegistrationError I 23.631s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMUnregistrationRequestTest.DeviceRegistrationError (4 ms) I 23.631s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMUnregistrationRequestTest.UnkwnownError I 23.631s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMUnregistrationRequestTest.UnkwnownError (3 ms) I 23.631s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMUnregistrationRequestTest.ServiceUnavailable I 23.631s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMUnregistrationRequestTest.ServiceUnavailable (6 ms) I 23.631s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMUnregistrationRequestTest.InternalServerError I 23.631s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMUnregistrationRequestTest.InternalServerError (5 ms) I 23.631s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMUnregistrationRequestTest.IncorrectAppId I 23.631s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMUnregistrationRequestTest.IncorrectAppId (5 ms) I 23.631s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMUnregistrationRequestTest.ResponseParsingFailed I 23.631s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMUnregistrationRequestTest.ResponseParsingFailed (6 ms) I 23.631s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMUnregistrationRequestTest.MaximumAttemptsReachedWithZeroRetries I 23.631s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMUnregistrationRequestTest.MaximumAttemptsReachedWithZeroRetries (3 ms) I 23.631s run_tests_on_device(0602ff62f0e96dad) [ RUN ] GCMUnregistrationRequestTest.MaximumAttemptsReached I 23.631s run_tests_on_device(0602ff62f0e96dad) [ OK ] GCMUnregistrationRequestTest.MaximumAttemptsReached (7 ms) I 23.631s run_tests_on_device(0602ff62f0e96dad) [----------] 13 tests from GCMUnregistrationRequestTest (63 ms total) I 23.631s run_tests_on_device(0602ff62f0e96dad) I 23.631s run_tests_on_device(0602ff62f0e96dad) [----------] 6 tests from InstaceIDDeleteTokenRequestTest I 23.631s run_tests_on_device(0602ff62f0e96dad) [ RUN ] InstaceIDDeleteTokenRequestTest.RequestDataPassedToFetcher I 23.631s run_tests_on_device(0602ff62f0e96dad) [ OK ] InstaceIDDeleteTokenRequestTest.RequestDataPassedToFetcher (2 ms) I 23.631s run_tests_on_device(0602ff62f0e96dad) [ RUN ] InstaceIDDeleteTokenRequestTest.RequestDataWithSubtype I 23.631s run_tests_on_device(0602ff62f0e96dad) [ OK ] InstaceIDDeleteTokenRequestTest.RequestDataWithSubtype (3 ms) I 23.631s run_tests_on_device(0602ff62f0e96dad) [ RUN ] InstaceIDDeleteTokenRequestTest.SuccessfulUnregistration I 23.631s run_tests_on_device(0602ff62f0e96dad) [ OK ] InstaceIDDeleteTokenRequestTest.SuccessfulUnregistration (3 ms) I 23.631s run_tests_on_device(0602ff62f0e96dad) [ RUN ] InstaceIDDeleteTokenRequestTest.ResponseHttpStatusNotOK I 23.631s run_tests_on_device(0602ff62f0e96dad) [ OK ] InstaceIDDeleteTokenRequestTest.ResponseHttpStatusNotOK (5 ms) I 23.631s run_tests_on_device(0602ff62f0e96dad) [ RUN ] InstaceIDDeleteTokenRequestTest.InvalidParametersError I 23.631s run_tests_on_device(0602ff62f0e96dad) [ OK ] InstaceIDDeleteTokenRequestTest.InvalidParametersError (5 ms) I 23.631s run_tests_on_device(0602ff62f0e96dad) [ RUN ] InstaceIDDeleteTokenRequestTest.UnkwnownError I 23.631s run_tests_on_device(0602ff62f0e96dad) [ OK ] InstaceIDDeleteTokenRequestTest.UnkwnownError (3 ms) I 23.631s run_tests_on_device(0602ff62f0e96dad) [----------] 6 tests from InstaceIDDeleteTokenRequestTest (22 ms total) I 23.631s run_tests_on_device(0602ff62f0e96dad) I 23.631s run_tests_on_device(0602ff62f0e96dad) [----------] Global test environment tear-down I 23.631s run_tests_on_device(0602ff62f0e96dad) [==========] 188 tests from 16 test suites ran. (2941 ms total) I 23.631s run_tests_on_device(0602ff62f0e96dad) [ PASSED ] 188 tests. I 23.631s run_tests_on_device(0602ff62f0e96dad) <<ScopedMainEntryLogger I 23.638s run_tests_on_device(0602ff62f0e96dad) Finished running tests on this device. I 23.644s Main FINISHED TRY #1/3 I 23.645s Main All tests completed. C 23.645s Main ******************************************************************************** C 23.645s Main Summary C 23.645s Main ******************************************************************************** C 23.646s Main [==========] 188 tests ran. C 23.646s Main [ PASSED ] 188 tests. C 23.646s Main ******************************************************************************** I 23.648s tear_down_device(0602ff62f0e96dad) Wrote device cache: /b/swarming/w/ir/out/Release/device_cache_0602ff62f0e96dad.json I 23.655s Main Generated json results file at /b/swarming/w/itcSBKe8/tmpZUEgac I 23.655s Main Finishing archiving output. [W2019-03-05T19:44:57.016204Z 28947 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-05T19:44:57.064161Z 28947 0 main.go:205] Butler terminated with error. {"error":"context canceled"} [E2019-03-05T19:44:57.064228Z 28947 0 main.go:233] Failed to serve. original error: context canceled [I2019-03-05T19:44:57.064297Z 28947 0 main.go:349] Terminating. {"returnCode":250} INFO:devil.utils.timeout_retry:condition 'logdog_stopped' met 2019-03-05 12:15:00,896 - root: [DEBUG] Contents of task_output_dir: ['/b/swarming/w/ir/tmp/t/tmpOCbhaU/4368418e3af59510'] 2019-03-05 12:15:00,896 - root: [DEBUG] Found shard_json_files: ['/b/swarming/w/ir/tmp/t/tmpOCbhaU/4368418e3af59510/output.json'] 2019-03-05 12:15:00,897 - 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 {"attempt_start_ts": 1551814694000000, "blamelist": ["bungeman@chromium.org"], "bot_id": "swarm1736-c4", "buildbucket": {"build": {"bucket": "luci.chromium.try", "created_by": "user:5071639625-1lppvbtck1morgivc6sq4dul7klu27sd@developer.gserviceaccount.com", "created_ts": 1551814721480501, "id": "8919798042567208000", "project": "chromium", "tags": ["build_address:luci.chromium.try/android-kitkat-arm-rel/204080", "builder:android-kitkat-arm-rel", "buildset:patch/gerrit/chromium-review.googlesource.com/1504002/1", "cq_experimental:false", "user_agent:cq"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "android-kitkat-arm-rel", "buildnumber": 204080, "category": "cq", "got_angle_revision": "f094bac949922dabc3dd6944f3dec04111e953b6", "got_dawn_revision": "b47470daa7377a804df5d94e7a93b5925a57f84a", "got_nacl_revision": "1ed9878b8eb68c1e0d0268754dafcf83e747fa8f", "got_revision": "79d7f822d09d101a0ed5ae719b2d62f750c4cad2", "got_revision_cp": "refs/heads/master@{#637770}", "got_swarming_client_revision": "7a61cf37d6a0163f0ec02d495289a1d038e62457", "got_v8_revision": "6641700a356c9a321198ea8beefcd9323a4da862", "got_v8_revision_cp": "refs/heads/7.4.282@{#1}", "got_webrtc_revision": "7949f215c1183d8bfc5b13f86594a03d3d648f68", "got_webrtc_revision_cp": "refs/heads/master@{#26971}", "mastername": "tryserver.chromium.android", "patch_gerrit_url": "https://chromium-review.googlesource.com", "patch_issue": 1504002, "patch_project": "chromium/src", "patch_ref": "refs/changes/02/1504002/1", "patch_repository_url": "https://chromium.googlesource.com/chromium/src", "patch_set": 1, "patch_storage": "gerrit", "path_config": "generic", "reason": "CQ", "recipe": "chromium_trybot", "repository": "https://chromium.googlesource.com/chromium/src", "revision": "HEAD"} --summary-json /b/swarming/w/ir/tmp/t/tmpAU63pw.json --task-output-dir /b/swarming/w/ir/tmp/t/tmpOCbhaU --bucket chromium-result-details --test-name gcm_unit_tests -o /b/swarming/w/ir/tmp/t/tmp16oOmx.json /b/swarming/w/ir/tmp/t/tmpOCbhaU/4368418e3af59510/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', '{"attempt_start_ts": 1551814694000000, "blamelist": ["bungeman@chromium.org"], "bot_id": "swarm1736-c4", "buildbucket": {"build": {"bucket": "luci.chromium.try", "created_by": "user:5071639625-1lppvbtck1morgivc6sq4dul7klu27sd@developer.gserviceaccount.com", "created_ts": 1551814721480501, "id": "8919798042567208000", "project": "chromium", "tags": ["build_address:luci.chromium.try/android-kitkat-arm-rel/204080", "builder:android-kitkat-arm-rel", "buildset:patch/gerrit/chromium-review.googlesource.com/1504002/1", "cq_experimental:false", "user_agent:cq"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "android-kitkat-arm-rel", "buildnumber": 204080, "category": "cq", "got_angle_revision": "f094bac949922dabc3dd6944f3dec04111e953b6", "got_dawn_revision": "b47470daa7377a804df5d94e7a93b5925a57f84a", "got_nacl_revision": "1ed9878b8eb68c1e0d0268754dafcf83e747fa8f", "got_revision": "79d7f822d09d101a0ed5ae719b2d62f750c4cad2", "got_revision_cp": "refs/heads/master@{#637770}", "got_swarming_client_revision": "7a61cf37d6a0163f0ec02d495289a1d038e62457", "got_v8_revision": "6641700a356c9a321198ea8beefcd9323a4da862", "got_v8_revision_cp": "refs/heads/7.4.282@{#1}", "got_webrtc_revision": "7949f215c1183d8bfc5b13f86594a03d3d648f68", "got_webrtc_revision_cp": "refs/heads/master@{#26971}", "mastername": "tryserver.chromium.android", "patch_gerrit_url": "https://chromium-review.googlesource.com", "patch_issue": 1504002, "patch_project": "chromium/src", "patch_ref": "refs/changes/02/1504002/1", "patch_repository_url": "https://chromium.googlesource.com/chromium/src", "patch_set": 1, "patch_storage": "gerrit", "path_config": "generic", "reason": "CQ", "recipe": "chromium_trybot", "repository": "https://chromium.googlesource.com/chromium/src", "revision": "HEAD"}', '--summary-json', '/b/swarming/w/ir/tmp/t/tmpAU63pw.json', '--task-output-dir', '/b/swarming/w/ir/tmp/t/tmpOCbhaU', u'--bucket', u'chromium-result-details', u'--test-name', u'gcm_unit_tests', '-o', '/b/swarming/w/ir/tmp/t/tmp16oOmx.json', '/b/swarming/w/ir/tmp/t/tmpOCbhaU/4368418e3af59510/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', '{"attempt_start_ts": 1551814694000000, "blamelist": ["bungeman@chromium.org"], "bot_id": "swarm1736-c4", "buildbucket": {"build": {"bucket": "luci.chromium.try", "created_by": "user:5071639625-1lppvbtck1morgivc6sq4dul7klu27sd@developer.gserviceaccount.com", "created_ts": 1551814721480501, "id": "8919798042567208000", "project": "chromium", "tags": ["build_address:luci.chromium.try/android-kitkat-arm-rel/204080", "builder:android-kitkat-arm-rel", "buildset:patch/gerrit/chromium-review.googlesource.com/1504002/1", "cq_experimental:false", "user_agent:cq"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "android-kitkat-arm-rel", "buildnumber": 204080, "category": "cq", "got_angle_revision": "f094bac949922dabc3dd6944f3dec04111e953b6", "got_dawn_revision": "b47470daa7377a804df5d94e7a93b5925a57f84a", "got_nacl_revision": "1ed9878b8eb68c1e0d0268754dafcf83e747fa8f", "got_revision": "79d7f822d09d101a0ed5ae719b2d62f750c4cad2", "got_revision_cp": "refs/heads/master@{#637770}", "got_swarming_client_revision": "7a61cf37d6a0163f0ec02d495289a1d038e62457", "got_v8_revision": "6641700a356c9a321198ea8beefcd9323a4da862", "got_v8_revision_cp": "refs/heads/7.4.282@{#1}", "got_webrtc_revision": "7949f215c1183d8bfc5b13f86594a03d3d648f68", "got_webrtc_revision_cp": "refs/heads/master@{#26971}", "mastername": "tryserver.chromium.android", "patch_gerrit_url": "https://chromium-review.googlesource.com", "patch_issue": 1504002, "patch_project": "chromium/src", "patch_ref": "refs/changes/02/1504002/1", "patch_repository_url": "https://chromium.googlesource.com/chromium/src", "patch_set": 1, "patch_storage": "gerrit", "path_config": "generic", "reason": "CQ", "recipe": "chromium_trybot", "repository": "https://chromium.googlesource.com/chromium/src", "revision": "HEAD"}', '--summary-json', '/b/swarming/w/ir/tmp/t/tmpAU63pw.json', '--task-output-dir', '/b/swarming/w/ir/tmp/t/tmpOCbhaU', u'--bucket', u'chromium-result-details', u'--test-name', u'gcm_unit_tests', '-o', '/b/swarming/w/ir/tmp/t/tmp16oOmx.json', '/b/swarming/w/ir/tmp/t/tmpOCbhaU/4368418e3af59510/output.json'] returned exit code 0