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

{ "shards": [ { "bot_dimensions": [ { "key": "android_devices", "value": [ "1" ] }, { "key": "caches", "value": [ "swarming_module_cache_vpython" ] }, { "key": "cpu_governor", "value": [ "powersave" ] }, { "key": "device_gms_core_version", "value": [ "4.3.23" ] }, { "key": "device_os", "value": [ "K", "KTU84P" ] }, { "key": "device_os_flavor", "value": [ "google" ] }, { "key": "device_playstore_version", "value": [ "4.5.10" ] }, { "key": "device_type", "value": [ "hammerhead" ] }, { "key": "gce", "value": [ "0" ] }, { "key": "id", "value": [ "build87-b4--device1" ] }, { "key": "inside_docker", "value": [ "1", "stock" ] }, { "key": "locale", "value": [ "en_US.UTF-8" ] }, { "key": "os", "value": [ "Android" ] }, { "key": "pool", "value": [ "Chrome" ] }, { "key": "python", "value": [ "2.7.12" ] }, { "key": "server_version", "value": [ "4216-cf4a3cd" ] }, { "key": "temp_band", "value": [ "<30" ] }, { "key": "zone", "value": [ "us", "us-mtv", "us-mtv-chops", "us-mtv-chops-b", "us-mtv-chops-b-4" ] } ], "bot_id": "build87-b4--device1", "bot_version": "c7f0c187ee2160053ce935aa86119b526086da1e165dea02547e2f5a35dc9e3f", "cipd_pins": { "client_package": { "package_name": "infra/tools/cipd/linux-amd64", "version": "nFftZl2kFquaI2EUmPGwzbc5sIbCocl9L55UeASqlLsC" }, "packages": [ { "package_name": "infra/python/cpython/linux-amd64", "path": ".swarming_module", "version": "46c0c897ca0f053799ee41fd148bb7a47232df47" }, { "package_name": "infra/tools/luci/logdog/butler/linux-amd64", "path": ".swarming_module", "version": "2737ea8ed9b958f4d5aa9ffe106115a649ada241" }, { "package_name": "infra/tools/luci/vpython-native/linux-amd64", "path": ".swarming_module", "version": "OAXVAmcUSrvDygYUrCDzv20LRono9938YOHPu0zKowgC" }, { "package_name": "infra/tools/luci/vpython/linux-amd64", "path": ".swarming_module", "version": "ucaOciwAE9aweCUDOrmSvyiwrjmbywuB0NzAGUXIHjAC" }, { "package_name": "infra/tools/luci/logdog/butler/linux-amd64", "path": "bin", "version": "a57ad614c01fec9fa4259473c8ea3fd992d7c349" } ] }, "completed_ts": "2019-03-24T07:49:16.357290", "cost_saved_usd": 0.005097438590259043, "created_ts": "2019-03-24T20:21:47.745576", "deduped_from": "43c77daba5c8b111", "duration": 30.77993106842041, "modified_ts": "2019-03-24T20:21:47.791232", "name": "gcm_unit_tests on Android device Nexus 5/Android/b49a09cb59/KitKat Phone Tester (dbg)/12595", "output": "Additional test environment:\n CHROME_DEVEL_SANDBOX=/opt/chromium/chrome_sandbox\n CHROME_HEADLESS=1\n LANG=en_US.UTF-8\nCommand: /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/io5xTLwH/output.json\n\nI 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/io5xTLwH/output.json\nI 0.006s Main condition '<lambda>' met\nI 0.008s Main condition '<lambda>' met\nI 3.140s TimeoutThread-1-for-prepare_device(0609288600622f17) condition 'sd_card_ready' met (0.0s)\nI 3.697s TimeoutThread-1-for-prepare_device(0609288600622f17) condition 'pm_ready' met (0.6s)\nI 3.707s TimeoutThread-1-for-prepare_device(0609288600622f17) condition 'boot_completed' met (0.6s)\nI 11.596s calculate_device_checksums condition '<lambda>' met (0.1s)\nI 13.421s TimeoutThread-1-for-individual_device_set_up(0609288600622f17) Pushing 2529 files via .zip of size 6069427\nI 19.343s list_tests(0609288600622f17) flags:\nI 19.343s list_tests(0609288600622f17) --gtest_list_tests\nI 20.743s list_tests(0609288600622f17) /storage/emulated/legacy/temp_file-1175b4496df47.gtest_out size on device: 4980\nI 20.811s Main Using external sharding settings. This is shard 0/1\nI 20.811s Main STARTING TRY #1/3\nI 20.811s Main Will run 188 tests on 1 devices: 0609288600622f17\nW 20.836s run_tests_on_device(0609288600622f17) No tombstones to clear.\nI 23.241s run_tests_on_device(0609288600622f17) flags:\nI 23.241s run_tests_on_device(0609288600622f17) Getting logdog client.\nI 27.730s run_tests_on_device(0609288600622f17) /storage/emulated/legacy/temp_file-b4e15a1536521.gtest_out size on device: 43568\nI 27.897s run_tests_on_device(0609288600622f17) Logcat saved to https://luci-logdog.appspot.com/v/?s=chromium%2Fandroid%2Fswarming%2Flogcats%2F43c77daba5c8b111%2F%2B%2Flogcat_logcat_4598254317288053905_20190324T074906-UTC_0609288600622f17\nI 27.898s archive Writing text to logdog stream, logcat_logcat_4598254317288053905_20190324T074906-UTC_0609288600622f17\nI 28.532s run_tests_on_device(0609288600622f17) >>ScopedMainEntryLogger\nI 28.532s run_tests_on_device(0609288600622f17) 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\nI 28.532s run_tests_on_device(0609288600622f17) [==========] Running 188 tests from 16 test suites.\nI 28.532s run_tests_on_device(0609288600622f17) [----------] Global test environment set-up.\nI 28.532s run_tests_on_device(0609288600622f17) [----------] 4 tests from MCSMessageTest\nI 28.532s run_tests_on_device(0609288600622f17) [ RUN ] MCSMessageTest.Invalid\nI 28.532s run_tests_on_device(0609288600622f17) [ OK ] MCSMessageTest.Invalid (1 ms)\nI 28.532s run_tests_on_device(0609288600622f17) [ RUN ] MCSMessageTest.InitInferTag\nI 28.532s run_tests_on_device(0609288600622f17) [ OK ] MCSMessageTest.InitInferTag (1 ms)\nI 28.532s run_tests_on_device(0609288600622f17) [ RUN ] MCSMessageTest.InitWithTag\nI 28.532s run_tests_on_device(0609288600622f17) [ OK ] MCSMessageTest.InitWithTag (1 ms)\nI 28.532s run_tests_on_device(0609288600622f17) [ RUN ] MCSMessageTest.InitPassOwnership\nI 28.532s run_tests_on_device(0609288600622f17) [ OK ] MCSMessageTest.InitPassOwnership (1 ms)\nI 28.532s run_tests_on_device(0609288600622f17) [----------] 4 tests from MCSMessageTest (4 ms total)\nI 28.532s run_tests_on_device(0609288600622f17) \nI 28.532s run_tests_on_device(0609288600622f17) [----------] 4 tests from MCSUtilTest\nI 28.532s run_tests_on_device(0609288600622f17) [ RUN ] MCSUtilTest.BuildLoginRequest\nI 28.532s run_tests_on_device(0609288600622f17) [ OK ] MCSUtilTest.BuildLoginRequest (1 ms)\nI 28.532s run_tests_on_device(0609288600622f17) [ RUN ] MCSUtilTest.ProtobufToTag\nI 28.532s run_tests_on_device(0609288600622f17) [ OK ] MCSUtilTest.ProtobufToTag (1 ms)\nI 28.532s run_tests_on_device(0609288600622f17) [ RUN ] MCSUtilTest.PersistentIds\nI 28.532s run_tests_on_device(0609288600622f17) [ OK ] MCSUtilTest.PersistentIds (1 ms)\nI 28.533s run_tests_on_device(0609288600622f17) [ RUN ] MCSUtilTest.StreamIds\nI 28.533s run_tests_on_device(0609288600622f17) [ OK ] MCSUtilTest.StreamIds (1 ms)\nI 28.533s run_tests_on_device(0609288600622f17) [----------] 4 tests from MCSUtilTest (4 ms total)\nI 28.533s run_tests_on_device(0609288600622f17) \nI 28.533s run_tests_on_device(0609288600622f17) [----------] 15 tests from GCMSocketStreamTest\nI 28.533s run_tests_on_device(0609288600622f17) [ RUN ] GCMSocketStreamTest.ReadDataSync\nI 28.533s run_tests_on_device(0609288600622f17) [ OK ] GCMSocketStreamTest.ReadDataSync (20 ms)\nI 28.533s run_tests_on_device(0609288600622f17) [ RUN ] GCMSocketStreamTest.ReadPartialDataSync\nI 28.533s run_tests_on_device(0609288600622f17) [ OK ] GCMSocketStreamTest.ReadPartialDataSync (12 ms)\nI 28.533s run_tests_on_device(0609288600622f17) [ RUN ] GCMSocketStreamTest.ReadAsync\nI 28.533s run_tests_on_device(0609288600622f17) [ OK ] GCMSocketStreamTest.ReadAsync (9 ms)\nI 28.533s run_tests_on_device(0609288600622f17) [ RUN ] GCMSocketStreamTest.TwoReadsAtOnce\nI 28.533s run_tests_on_device(0609288600622f17) [ OK ] GCMSocketStreamTest.TwoReadsAtOnce (17 ms)\nI 28.533s run_tests_on_device(0609288600622f17) [ RUN ] GCMSocketStreamTest.TwoReadsAtOnceWithRebuild\nI 28.533s run_tests_on_device(0609288600622f17) [ OK ] GCMSocketStreamTest.TwoReadsAtOnceWithRebuild (9 ms)\nI 28.533s run_tests_on_device(0609288600622f17) [ RUN ] GCMSocketStreamTest.ReadError\nI 28.533s run_tests_on_device(0609288600622f17) [ERROR:socket_stream.cc(219)] Closing stream with result -2\nI 28.533s run_tests_on_device(0609288600622f17) [ OK ] GCMSocketStreamTest.ReadError (9 ms)\nI 28.533s run_tests_on_device(0609288600622f17) [ RUN ] GCMSocketStreamTest.ReadDisconnected\nI 28.533s run_tests_on_device(0609288600622f17) [ERROR:socket_stream.cc(219)] Closing stream with result -2\nI 28.533s run_tests_on_device(0609288600622f17) [ OK ] GCMSocketStreamTest.ReadDisconnected (9 ms)\nI 28.533s run_tests_on_device(0609288600622f17) [ RUN ] GCMSocketStreamTest.WriteFull\nI 28.533s run_tests_on_device(0609288600622f17) [ OK ] GCMSocketStreamTest.WriteFull (9 ms)\nI 28.533s run_tests_on_device(0609288600622f17) [ RUN ] GCMSocketStreamTest.WritePartial\nI 28.533s run_tests_on_device(0609288600622f17) [ OK ] GCMSocketStreamTest.WritePartial (9 ms)\nI 28.533s run_tests_on_device(0609288600622f17) [ RUN ] GCMSocketStreamTest.WritePartialWithLengthChecking\nI 28.533s run_tests_on_device(0609288600622f17) [ OK ] GCMSocketStreamTest.WritePartialWithLengthChecking (6 ms)\nI 28.533s run_tests_on_device(0609288600622f17) [ RUN ] GCMSocketStreamTest.WriteNone\nI 28.533s run_tests_on_device(0609288600622f17) [ OK ] GCMSocketStreamTest.WriteNone (9 ms)\nI 28.533s run_tests_on_device(0609288600622f17) [ RUN ] GCMSocketStreamTest.WriteThenRead\nI 28.533s run_tests_on_device(0609288600622f17) [ OK ] GCMSocketStreamTest.WriteThenRead (10 ms)\nI 28.533s run_tests_on_device(0609288600622f17) [ RUN ] GCMSocketStreamTest.ReadThenWrite\nI 28.533s run_tests_on_device(0609288600622f17) [ OK ] GCMSocketStreamTest.ReadThenWrite (9 ms)\nI 28.533s run_tests_on_device(0609288600622f17) [ RUN ] GCMSocketStreamTest.WriteError\nI 28.533s run_tests_on_device(0609288600622f17) [ERROR:socket_stream.cc(300)] Failed to flush socket.\nI 28.533s run_tests_on_device(0609288600622f17) [ OK ] GCMSocketStreamTest.WriteError (10 ms)\nI 28.533s run_tests_on_device(0609288600622f17) [ RUN ] GCMSocketStreamTest.WriteDisconnected\nI 28.533s run_tests_on_device(0609288600622f17) [ERROR:socket_stream.cc(300)] Failed to flush socket.\nI 28.533s run_tests_on_device(0609288600622f17) [ OK ] GCMSocketStreamTest.WriteDisconnected (9 ms)\nI 28.533s run_tests_on_device(0609288600622f17) [----------] 15 tests from GCMSocketStreamTest (159 ms total)\nI 28.533s run_tests_on_device(0609288600622f17) \nI 28.533s run_tests_on_device(0609288600622f17) [----------] 3 tests from AccountMappingTest\nI 28.533s run_tests_on_device(0609288600622f17) [ RUN ] AccountMappingTest.SerializeAccountMapping\nI 28.533s run_tests_on_device(0609288600622f17) [ OK ] AccountMappingTest.SerializeAccountMapping (1 ms)\nI 28.533s run_tests_on_device(0609288600622f17) [ RUN ] AccountMappingTest.DeserializeAccountMapping\nI 28.533s run_tests_on_device(0609288600622f17) [ OK ] AccountMappingTest.DeserializeAccountMapping (1 ms)\nI 28.533s run_tests_on_device(0609288600622f17) [ RUN ] AccountMappingTest.DeserializeAccountMappingInvalidInput\nI 28.533s run_tests_on_device(0609288600622f17) [ OK ] AccountMappingTest.DeserializeAccountMappingInvalidInput (0 ms)\nI 28.533s run_tests_on_device(0609288600622f17) [----------] 3 tests from AccountMappingTest (3 ms total)\nI 28.533s run_tests_on_device(0609288600622f17) \nI 28.533s run_tests_on_device(0609288600622f17) [----------] 12 tests from CheckinRequestTest\nI 28.533s run_tests_on_device(0609288600622f17) [ RUN ] CheckinRequestTest.FetcherDataAndURL\nI 28.533s run_tests_on_device(0609288600622f17) [ OK ] CheckinRequestTest.FetcherDataAndURL (3 ms)\nI 28.533s run_tests_on_device(0609288600622f17) [ RUN ] CheckinRequestTest.ResponseBodyEmpty\nI 28.533s run_tests_on_device(0609288600622f17) [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.\nI 28.533s run_tests_on_device(0609288600622f17) [ OK ] CheckinRequestTest.ResponseBodyEmpty (9 ms)\nI 28.534s run_tests_on_device(0609288600622f17) [ RUN ] CheckinRequestTest.ResponseBodyCorrupted\nI 28.534s run_tests_on_device(0609288600622f17) [ERROR:checkin_request.cc(242)] Failed to get checkin response. HTTP Status: 200. Retrying.\nI 28.534s run_tests_on_device(0609288600622f17) [ OK ] CheckinRequestTest.ResponseBodyCorrupted (9 ms)\nI 28.534s run_tests_on_device(0609288600622f17) [ RUN ] CheckinRequestTest.ResponseHttpStatusUnauthorized\nI 28.534s run_tests_on_device(0609288600622f17) [ERROR:checkin_request.cc(231)] No point retrying the checkin with status: 401. Checkin failed.\nI 28.534s run_tests_on_device(0609288600622f17) [ OK ] CheckinRequestTest.ResponseHttpStatusUnauthorized (5 ms)\nI 28.534s run_tests_on_device(0609288600622f17) [ RUN ] CheckinRequestTest.ResponseHttpStatusBadRequest\nI 28.534s run_tests_on_device(0609288600622f17) [ERROR:checkin_request.cc(231)] No point retrying the checkin with status: 400. Checkin failed.\nI 28.534s run_tests_on_device(0609288600622f17) [ OK ] CheckinRequestTest.ResponseHttpStatusBadRequest (4 ms)\nI 28.534s run_tests_on_device(0609288600622f17) [ RUN ] CheckinRequestTest.ResponseHttpStatusNotOK\nI 28.534s run_tests_on_device(0609288600622f17) [ERROR:checkin_request.cc(242)] Failed to get checkin response. HTTP Status: 500. Retrying.\nI 28.534s run_tests_on_device(0609288600622f17) [ OK ] CheckinRequestTest.ResponseHttpStatusNotOK (6 ms)\nI 28.534s run_tests_on_device(0609288600622f17) [ RUN ] CheckinRequestTest.ResponseMissingAndroidId\nI 28.534s run_tests_on_device(0609288600622f17) [ERROR:checkin_request.cc(255)] Android ID or security token is 0. Retrying.\nI 28.534s run_tests_on_device(0609288600622f17) [ OK ] CheckinRequestTest.ResponseMissingAndroidId (7 ms)\nI 28.534s run_tests_on_device(0609288600622f17) [ RUN ] CheckinRequestTest.ResponseMissingSecurityToken\nI 28.534s run_tests_on_device(0609288600622f17) [ERROR:checkin_request.cc(255)] Android ID or security token is 0. Retrying.\nI 28.534s run_tests_on_device(0609288600622f17) [ OK ] CheckinRequestTest.ResponseMissingSecurityToken (7 ms)\nI 28.534s run_tests_on_device(0609288600622f17) [ RUN ] CheckinRequestTest.AndroidIdEqualsZeroInResponse\nI 28.534s run_tests_on_device(0609288600622f17) [ERROR:checkin_request.cc(255)] Android ID or security token is 0. Retrying.\nI 28.534s run_tests_on_device(0609288600622f17) [ OK ] CheckinRequestTest.AndroidIdEqualsZeroInResponse (9 ms)\nI 28.534s run_tests_on_device(0609288600622f17) [ RUN ] CheckinRequestTest.SecurityTokenEqualsZeroInResponse\nI 28.534s run_tests_on_device(0609288600622f17) [ERROR:checkin_request.cc(255)] Android ID or security token is 0. Retrying.\nI 28.534s run_tests_on_device(0609288600622f17) [ OK ] CheckinRequestTest.SecurityTokenEqualsZeroInResponse (7 ms)\nI 28.534s run_tests_on_device(0609288600622f17) [ RUN ] CheckinRequestTest.SuccessfulFirstTimeCheckin\nI 28.534s run_tests_on_device(0609288600622f17) [ OK ] CheckinRequestTest.SuccessfulFirstTimeCheckin (3 ms)\nI 28.534s run_tests_on_device(0609288600622f17) [ RUN ] CheckinRequestTest.SuccessfulSubsequentCheckin\nI 28.534s run_tests_on_device(0609288600622f17) [ OK ] CheckinRequestTest.SuccessfulSubsequentCheckin (4 ms)\nI 28.534s run_tests_on_device(0609288600622f17) [----------] 12 tests from CheckinRequestTest (76 ms total)\nI 28.534s run_tests_on_device(0609288600622f17) \nI 28.534s run_tests_on_device(0609288600622f17) [----------] 1 test from ConnectionEventTrackerTest\nI 28.534s run_tests_on_device(0609288600622f17) [ RUN ] ConnectionEventTrackerTest.SuccessfulAttempt\nI 28.534s run_tests_on_device(0609288600622f17) [ OK ] ConnectionEventTrackerTest.SuccessfulAttempt (1 ms)\nI 28.534s run_tests_on_device(0609288600622f17) [----------] 1 test from ConnectionEventTrackerTest (1 ms total)\nI 28.534s run_tests_on_device(0609288600622f17) \nI 28.534s run_tests_on_device(0609288600622f17) [----------] 14 tests from ConnectionFactoryImplTest\nI 28.534s run_tests_on_device(0609288600622f17) [ RUN ] ConnectionFactoryImplTest.Initialize\nI 28.534s run_tests_on_device(0609288600622f17) [ OK ] ConnectionFactoryImplTest.Initialize (6 ms)\nI 28.534s run_tests_on_device(0609288600622f17) [ RUN ] ConnectionFactoryImplTest.ConnectSuccess\nI 28.534s run_tests_on_device(0609288600622f17) [ OK ] ConnectionFactoryImplTest.ConnectSuccess (6 ms)\nI 28.534s run_tests_on_device(0609288600622f17) [ RUN ] ConnectionFactoryImplTest.ConnectFail\nI 28.534s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.534s run_tests_on_device(0609288600622f17) [ OK ] ConnectionFactoryImplTest.ConnectFail (5 ms)\nI 28.534s run_tests_on_device(0609288600622f17) [ RUN ] ConnectionFactoryImplTest.FailThenSucceed\nI 28.534s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.534s run_tests_on_device(0609288600622f17) [ OK ] ConnectionFactoryImplTest.FailThenSucceed (7 ms)\nI 28.534s run_tests_on_device(0609288600622f17) [ RUN ] ConnectionFactoryImplTest.MultipleFailuresThenSucceed\nI 28.534s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.534s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.534s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.534s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.534s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.534s run_tests_on_device(0609288600622f17) [ OK ] ConnectionFactoryImplTest.MultipleFailuresThenSucceed (34 ms)\nI 28.534s run_tests_on_device(0609288600622f17) [ RUN ] ConnectionFactoryImplTest.FailThenNetworkChangeEvent\nI 28.534s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -2\nI 28.535s run_tests_on_device(0609288600622f17) [ OK ] ConnectionFactoryImplTest.FailThenNetworkChangeEvent (6 ms)\nI 28.535s run_tests_on_device(0609288600622f17) [ RUN ] ConnectionFactoryImplTest.CanarySucceedsThenDisconnects\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ OK ] ConnectionFactoryImplTest.CanarySucceedsThenDisconnects (7 ms)\nI 28.535s run_tests_on_device(0609288600622f17) [ RUN ] ConnectionFactoryImplTest.CanarySucceedsRetryDuringLogin\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ OK ] ConnectionFactoryImplTest.CanarySucceedsRetryDuringLogin (8 ms)\nI 28.535s run_tests_on_device(0609288600622f17) [ RUN ] ConnectionFactoryImplTest.FailViaSignalReset\nI 28.535s run_tests_on_device(0609288600622f17) [ OK ] ConnectionFactoryImplTest.FailViaSignalReset (5 ms)\nI 28.535s run_tests_on_device(0609288600622f17) [ RUN ] ConnectionFactoryImplTest.IgnoreResetWhileConnecting\nI 28.535s run_tests_on_device(0609288600622f17) [ OK ] ConnectionFactoryImplTest.IgnoreResetWhileConnecting (6 ms)\nI 28.535s run_tests_on_device(0609288600622f17) [ RUN ] ConnectionFactoryImplTest.SignalResetRestoresBackoff\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ OK ] ConnectionFactoryImplTest.SignalResetRestoresBackoff (10 ms)\nI 28.535s run_tests_on_device(0609288600622f17) [ RUN ] ConnectionFactoryImplTest.NetworkChangeBeforeFirstConnection\nI 28.535s run_tests_on_device(0609288600622f17) [ OK ] ConnectionFactoryImplTest.NetworkChangeBeforeFirstConnection (5 ms)\nI 28.535s run_tests_on_device(0609288600622f17) [ RUN ] ConnectionFactoryImplTest.ConnectionResetRace\nI 28.535s run_tests_on_device(0609288600622f17) [ OK ] ConnectionFactoryImplTest.ConnectionResetRace (5 ms)\nI 28.535s run_tests_on_device(0609288600622f17) [ RUN ] ConnectionFactoryImplTest.MultipleFailuresWrapClientEvents\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.535s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.536s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.536s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.536s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.536s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.536s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.536s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.536s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.536s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.536s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.536s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.536s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.536s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.536s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.536s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.536s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.536s run_tests_on_device(0609288600622f17) [ERROR:connection_factory_impl.cc(413)] Failed to connect to MCS endpoint with error -104\nI 28.536s run_tests_on_device(0609288600622f17) [ OK ] ConnectionFactoryImplTest.MultipleFailuresWrapClientEvents (570 ms)\nI 28.536s run_tests_on_device(0609288600622f17) [----------] 14 tests from ConnectionFactoryImplTest (682 ms total)\nI 28.536s run_tests_on_device(0609288600622f17) \nI 28.536s run_tests_on_device(0609288600622f17) [----------] 20 tests from GCMConnectionHandlerImplTest\nI 28.536s run_tests_on_device(0609288600622f17) [ RUN ] GCMConnectionHandlerImplTest.Init\nI 28.536s run_tests_on_device(0609288600622f17) [ OK ] GCMConnectionHandlerImplTest.Init (9 ms)\nI 28.536s run_tests_on_device(0609288600622f17) [ RUN ] GCMConnectionHandlerImplTest.InitFailedVersionCheck\nI 28.536s run_tests_on_device(0609288600622f17) [ERROR:connection_handler_impl.cc(295)] Invalid GCM version response: 37\nI 28.536s run_tests_on_device(0609288600622f17) [ OK ] GCMConnectionHandlerImplTest.InitFailedVersionCheck (8 ms)\nI 28.536s run_tests_on_device(0609288600622f17) [ RUN ] GCMConnectionHandlerImplTest.InitTimeout\nI 28.536s run_tests_on_device(0609288600622f17) [ERROR:connection_handler_impl.cc(471)] Timed out waiting for GCM Protocol buffer.\nI 28.536s run_tests_on_device(0609288600622f17) [ OK ] GCMConnectionHandlerImplTest.InitTimeout (113 ms)\nI 28.536s run_tests_on_device(0609288600622f17) [ RUN ] GCMConnectionHandlerImplTest.InitIncompleteTimeout\nI 28.536s run_tests_on_device(0609288600622f17) [ERROR:connection_handler_impl.cc(471)] Timed out waiting for GCM Protocol buffer.\nI 28.536s run_tests_on_device(0609288600622f17) [ OK ] GCMConnectionHandlerImplTest.InitIncompleteTimeout (115 ms)\nI 28.536s run_tests_on_device(0609288600622f17) [ RUN ] GCMConnectionHandlerImplTest.ReInit\nI 28.536s run_tests_on_device(0609288600622f17) [ERROR:connection_handler_impl.cc(471)] Timed out waiting for GCM Protocol buffer.\nI 28.536s run_tests_on_device(0609288600622f17) [ OK ] GCMConnectionHandlerImplTest.ReInit (125 ms)\nI 28.536s run_tests_on_device(0609288600622f17) [ RUN ] GCMConnectionHandlerImplTest.RecvMsg\nI 28.536s run_tests_on_device(0609288600622f17) [ OK ] GCMConnectionHandlerImplTest.RecvMsg (9 ms)\nI 28.536s run_tests_on_device(0609288600622f17) [ RUN ] GCMConnectionHandlerImplTest.Recv2Msgs\nI 28.536s run_tests_on_device(0609288600622f17) [ OK ] GCMConnectionHandlerImplTest.Recv2Msgs (9 ms)\nI 28.536s run_tests_on_device(0609288600622f17) [ RUN ] GCMConnectionHandlerImplTest.RecvLongMsg\nI 28.536s run_tests_on_device(0609288600622f17) [ OK ] GCMConnectionHandlerImplTest.RecvLongMsg (9 ms)\nI 28.536s run_tests_on_device(0609288600622f17) [ RUN ] GCMConnectionHandlerImplTest.RecvLongMsg2Parts\nI 28.536s run_tests_on_device(0609288600622f17) [ OK ] GCMConnectionHandlerImplTest.RecvLongMsg2Parts (9 ms)\nI 28.536s run_tests_on_device(0609288600622f17) [ RUN ] GCMConnectionHandlerImplTest.Recv2LongMsgs\nI 28.536s run_tests_on_device(0609288600622f17) [ OK ] GCMConnectionHandlerImplTest.Recv2LongMsgs (9 ms)\nI 28.536s run_tests_on_device(0609288600622f17) [ RUN ] GCMConnectionHandlerImplTest.ReadTimeout\nI 28.536s run_tests_on_device(0609288600622f17) [ERROR:connection_handler_impl.cc(471)] Timed out waiting for GCM Protocol buffer.\nI 28.536s run_tests_on_device(0609288600622f17) [ OK ] GCMConnectionHandlerImplTest.ReadTimeout (125 ms)\nI 28.536s run_tests_on_device(0609288600622f17) [ RUN ] GCMConnectionHandlerImplTest.RecvMsgNoData\nI 28.536s run_tests_on_device(0609288600622f17) [ OK ] GCMConnectionHandlerImplTest.RecvMsgNoData (9 ms)\nI 28.536s run_tests_on_device(0609288600622f17) [ RUN ] GCMConnectionHandlerImplTest.SendMsg\nI 28.536s run_tests_on_device(0609288600622f17) [ OK ] GCMConnectionHandlerImplTest.SendMsg (8 ms)\nI 28.536s run_tests_on_device(0609288600622f17) [ RUN ] GCMConnectionHandlerImplTest.SendMsgSocketDisconnected\nI 28.536s run_tests_on_device(0609288600622f17) [ERROR:socket_stream.cc(300)] Failed to flush socket.\nI 28.536s run_tests_on_device(0609288600622f17) [ OK ] GCMConnectionHandlerImplTest.SendMsgSocketDisconnected (8 ms)\nI 28.537s run_tests_on_device(0609288600622f17) [ RUN ] GCMConnectionHandlerImplTest.ExtraLargeDataPacket\nI 28.537s run_tests_on_device(0609288600622f17) [ OK ] GCMConnectionHandlerImplTest.ExtraLargeDataPacket (10 ms)\nI 28.537s run_tests_on_device(0609288600622f17) [ RUN ] GCMConnectionHandlerImplTest.2ExtraLargeDataPacketMsgs\nI 28.537s run_tests_on_device(0609288600622f17) [ OK ] GCMConnectionHandlerImplTest.2ExtraLargeDataPacketMsgs (12 ms)\nI 28.537s run_tests_on_device(0609288600622f17) [ RUN ] GCMConnectionHandlerImplTest.InvalidTag\nI 28.537s run_tests_on_device(0609288600622f17) [ERROR:connection_handler_impl.cc(399)] Received message of invalid type 100\nI 28.537s run_tests_on_device(0609288600622f17) [ OK ] GCMConnectionHandlerImplTest.InvalidTag (10 ms)\nI 28.537s run_tests_on_device(0609288600622f17) [ RUN ] GCMConnectionHandlerImplTest.RecvMsgSplitSize\nI 28.537s run_tests_on_device(0609288600622f17) [ OK ] GCMConnectionHandlerImplTest.RecvMsgSplitSize (9 ms)\nI 28.537s run_tests_on_device(0609288600622f17) [ RUN ] GCMConnectionHandlerImplTest.InvalidData\nI 28.537s run_tests_on_device(0609288600622f17) [ERROR:connection_handler_impl.cc(409)] Unable to parse GCM message of type 8\nI 28.537s run_tests_on_device(0609288600622f17) [ OK ] GCMConnectionHandlerImplTest.InvalidData (9 ms)\nI 28.537s run_tests_on_device(0609288600622f17) [ RUN ] GCMConnectionHandlerImplTest.InvalidDataLong\nI 28.537s run_tests_on_device(0609288600622f17) [ERROR:connection_handler_impl.cc(428)] Unable to parse GCM message of type 8\nI 28.537s run_tests_on_device(0609288600622f17) [ OK ] GCMConnectionHandlerImplTest.InvalidDataLong (9 ms)\nI 28.537s run_tests_on_device(0609288600622f17) [----------] 20 tests from GCMConnectionHandlerImplTest (628 ms total)\nI 28.537s run_tests_on_device(0609288600622f17) \nI 28.537s run_tests_on_device(0609288600622f17) [----------] 17 tests from GCMStoreImplTest\nI 28.537s run_tests_on_device(0609288600622f17) [ RUN ] GCMStoreImplTest.LoadNew\nI 28.537s run_tests_on_device(0609288600622f17) [ OK ] GCMStoreImplTest.LoadNew (17 ms)\nI 28.537s run_tests_on_device(0609288600622f17) [ RUN ] GCMStoreImplTest.LoadWithoutCreatingNewStore\nI 28.537s run_tests_on_device(0609288600622f17) [ OK ] GCMStoreImplTest.LoadWithoutCreatingNewStore (1 ms)\nI 28.537s run_tests_on_device(0609288600622f17) [ RUN ] GCMStoreImplTest.LoadWithEmptyDirectory\nI 28.537s run_tests_on_device(0609288600622f17) [ OK ] GCMStoreImplTest.LoadWithEmptyDirectory (1 ms)\nI 28.537s run_tests_on_device(0609288600622f17) [ RUN ] GCMStoreImplTest.DeviceCredentials\nI 28.537s run_tests_on_device(0609288600622f17) [ OK ] GCMStoreImplTest.DeviceCredentials (19 ms)\nI 28.537s run_tests_on_device(0609288600622f17) [ RUN ] GCMStoreImplTest.LastCheckinInfo\nI 28.537s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(1033)] Failed to restore last checkin time. Using default = 0.\nI 28.537s run_tests_on_device(0609288600622f17) [ OK ] GCMStoreImplTest.LastCheckinInfo (33 ms)\nI 28.537s run_tests_on_device(0609288600622f17) [ RUN ] GCMStoreImplTest.GServicesSettings_ProtocolV2\nI 28.537s run_tests_on_device(0609288600622f17) [ OK ] GCMStoreImplTest.GServicesSettings_ProtocolV2 (25 ms)\nI 28.537s run_tests_on_device(0609288600622f17) [ RUN ] GCMStoreImplTest.Registrations\nI 28.537s run_tests_on_device(0609288600622f17) [ OK ] GCMStoreImplTest.Registrations (28 ms)\nI 28.537s run_tests_on_device(0609288600622f17) [ RUN ] GCMStoreImplTest.IncomingMessages\nI 28.537s run_tests_on_device(0609288600622f17) [ OK ] GCMStoreImplTest.IncomingMessages (56 ms)\nI 28.537s run_tests_on_device(0609288600622f17) [ RUN ] GCMStoreImplTest.OutgoingMessages\nI 28.537s run_tests_on_device(0609288600622f17) [ OK ] GCMStoreImplTest.OutgoingMessages (43 ms)\nI 28.537s run_tests_on_device(0609288600622f17) [ RUN ] GCMStoreImplTest.IncomingAndOutgoingMessages\nI 28.537s run_tests_on_device(0609288600622f17) [ OK ] GCMStoreImplTest.IncomingAndOutgoingMessages (85 ms)\nI 28.537s run_tests_on_device(0609288600622f17) [ RUN ] GCMStoreImplTest.PerAppMessageLimits\nI 28.537s run_tests_on_device(0609288600622f17) [ OK ] GCMStoreImplTest.PerAppMessageLimits (92 ms)\nI 28.537s run_tests_on_device(0609288600622f17) [ RUN ] GCMStoreImplTest.AccountMapping\nI 28.537s run_tests_on_device(0609288600622f17) [ OK ] GCMStoreImplTest.AccountMapping (37 ms)\nI 28.537s run_tests_on_device(0609288600622f17) [ RUN ] GCMStoreImplTest.HeartbeatInterval\nI 28.537s run_tests_on_device(0609288600622f17) [ OK ] GCMStoreImplTest.HeartbeatInterval (24 ms)\nI 28.537s run_tests_on_device(0609288600622f17) [ RUN ] GCMStoreImplTest.AddMessageAfterDestroy\nI 28.537s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.537s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.537s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.537s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.537s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.537s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.537s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.537s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.537s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.537s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(559)] GCMStore db doesn't exist.\nI 28.538s run_tests_on_device(0609288600622f17) [ OK ] GCMStoreImplTest.AddMessageAfterDestroy (18 ms)\nI 28.538s run_tests_on_device(0609288600622f17) [ RUN ] GCMStoreImplTest.ReloadAfterClose\nI 28.538s run_tests_on_device(0609288600622f17) [ OK ] GCMStoreImplTest.ReloadAfterClose (29 ms)\nI 28.538s run_tests_on_device(0609288600622f17) [ RUN ] GCMStoreImplTest.LastTokenFetchTime\nI 28.538s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(1114)] Failed to restore last token fetching time. Using default = 0.\nI 28.538s run_tests_on_device(0609288600622f17) [ OK ] GCMStoreImplTest.LastTokenFetchTime (23 ms)\nI 28.538s run_tests_on_device(0609288600622f17) [ RUN ] GCMStoreImplTest.InstanceIDData\nI 28.538s run_tests_on_device(0609288600622f17) [ OK ] GCMStoreImplTest.InstanceIDData (42 ms)\nI 28.538s run_tests_on_device(0609288600622f17) [----------] 17 tests from GCMStoreImplTest (578 ms total)\nI 28.538s run_tests_on_device(0609288600622f17) \nI 28.538s run_tests_on_device(0609288600622f17) [----------] 12 tests from GServicesSettingsTest\nI 28.538s run_tests_on_device(0609288600622f17) [ RUN ] GServicesSettingsTest.DefaultSettingsAndDigest\nI 28.538s run_tests_on_device(0609288600622f17) [ OK ] GServicesSettingsTest.DefaultSettingsAndDigest (2 ms)\nI 28.538s run_tests_on_device(0609288600622f17) [ RUN ] GServicesSettingsTest.CalculateDigest\nI 28.538s run_tests_on_device(0609288600622f17) [ OK ] GServicesSettingsTest.CalculateDigest (1 ms)\nI 28.538s run_tests_on_device(0609288600622f17) [ RUN ] GServicesSettingsTest.UpdateFromEmptyLoadResult\nI 28.538s run_tests_on_device(0609288600622f17) [ OK ] GServicesSettingsTest.UpdateFromEmptyLoadResult (1 ms)\nI 28.538s run_tests_on_device(0609288600622f17) [ RUN ] GServicesSettingsTest.UpdateFromLoadResultWithSettingMissing\nI 28.538s run_tests_on_device(0609288600622f17) [ OK ] GServicesSettingsTest.UpdateFromLoadResultWithSettingMissing (1 ms)\nI 28.538s run_tests_on_device(0609288600622f17) [ RUN ] GServicesSettingsTest.UpdateFromLoadResult\nI 28.538s run_tests_on_device(0609288600622f17) [ OK ] GServicesSettingsTest.UpdateFromLoadResult (2 ms)\nI 28.538s run_tests_on_device(0609288600622f17) [ RUN ] GServicesSettingsTest.CheckinResponseMinimumCheckinInterval\nI 28.538s run_tests_on_device(0609288600622f17) [ OK ] GServicesSettingsTest.CheckinResponseMinimumCheckinInterval (1 ms)\nI 28.539s run_tests_on_device(0609288600622f17) [ RUN ] GServicesSettingsTest.CheckinResponseUpdateCheckinInterval\nI 28.539s run_tests_on_device(0609288600622f17) [ OK ] GServicesSettingsTest.CheckinResponseUpdateCheckinInterval (1 ms)\nI 28.539s run_tests_on_device(0609288600622f17) [ RUN ] GServicesSettingsTest.CheckinResponseUpdateRegistrationURL\nI 28.539s run_tests_on_device(0609288600622f17) [ OK ] GServicesSettingsTest.CheckinResponseUpdateRegistrationURL (1 ms)\nI 28.539s run_tests_on_device(0609288600622f17) [ RUN ] GServicesSettingsTest.CheckinResponseUpdateCheckinURL\nI 28.539s run_tests_on_device(0609288600622f17) [ OK ] GServicesSettingsTest.CheckinResponseUpdateCheckinURL (1 ms)\nI 28.539s run_tests_on_device(0609288600622f17) [ RUN ] GServicesSettingsTest.CheckinResponseUpdateMCSHostname\nI 28.539s run_tests_on_device(0609288600622f17) [ OK ] GServicesSettingsTest.CheckinResponseUpdateMCSHostname (1 ms)\nI 28.539s run_tests_on_device(0609288600622f17) [ RUN ] GServicesSettingsTest.CheckinResponseUpdateMCSSecurePort\nI 28.539s run_tests_on_device(0609288600622f17) [ OK ] GServicesSettingsTest.CheckinResponseUpdateMCSSecurePort (1 ms)\nI 28.539s run_tests_on_device(0609288600622f17) [ RUN ] GServicesSettingsTest.UpdateFromCheckinResponseSettingsDiff\nI 28.539s run_tests_on_device(0609288600622f17) [ OK ] GServicesSettingsTest.UpdateFromCheckinResponseSettingsDiff (1 ms)\nI 28.539s run_tests_on_device(0609288600622f17) [----------] 12 tests from GServicesSettingsTest (17 ms total)\nI 28.539s run_tests_on_device(0609288600622f17) \nI 28.539s run_tests_on_device(0609288600622f17) [----------] 14 tests from HeartbeatManagerTest\nI 28.539s run_tests_on_device(0609288600622f17) [ RUN ] HeartbeatManagerTest.Init\nI 28.539s run_tests_on_device(0609288600622f17) [ OK ] HeartbeatManagerTest.Init (1 ms)\nI 28.539s run_tests_on_device(0609288600622f17) [ RUN ] HeartbeatManagerTest.AckBeforeStart\nI 28.539s run_tests_on_device(0609288600622f17) [ OK ] HeartbeatManagerTest.AckBeforeStart (1 ms)\nI 28.539s run_tests_on_device(0609288600622f17) [ RUN ] HeartbeatManagerTest.Start\nI 28.539s run_tests_on_device(0609288600622f17) [ OK ] HeartbeatManagerTest.Start (1 ms)\nI 28.539s run_tests_on_device(0609288600622f17) [ RUN ] HeartbeatManagerTest.AckedHeartbeat\nI 28.539s run_tests_on_device(0609288600622f17) [ OK ] HeartbeatManagerTest.AckedHeartbeat (1 ms)\nI 28.539s run_tests_on_device(0609288600622f17) [ RUN ] HeartbeatManagerTest.UnackedHeartbeat\nI 28.539s run_tests_on_device(0609288600622f17) [WARNING:heartbeat_manager.cc(165)] Lost connection to MCS, reconnecting.\nI 28.539s run_tests_on_device(0609288600622f17) [ OK ] HeartbeatManagerTest.UnackedHeartbeat (1 ms)\nI 28.539s run_tests_on_device(0609288600622f17) [ RUN ] HeartbeatManagerTest.UpdateIntervalThenStart\nI 28.539s run_tests_on_device(0609288600622f17) [ OK ] HeartbeatManagerTest.UpdateIntervalThenStart (0 ms)\nI 28.539s run_tests_on_device(0609288600622f17) [ RUN ] HeartbeatManagerTest.StartThenUpdateInterval\nI 28.539s run_tests_on_device(0609288600622f17) [ OK ] HeartbeatManagerTest.StartThenUpdateInterval (0 ms)\nI 28.539s run_tests_on_device(0609288600622f17) [ RUN ] HeartbeatManagerTest.UpdateTimerBeforeStart\nI 28.539s run_tests_on_device(0609288600622f17) [ OK ] HeartbeatManagerTest.UpdateTimerBeforeStart (1 ms)\nI 28.539s run_tests_on_device(0609288600622f17) [ RUN ] HeartbeatManagerTest.UpdateTimerAfterStart\nI 28.539s run_tests_on_device(0609288600622f17) [ OK ] HeartbeatManagerTest.UpdateTimerAfterStart (1 ms)\nI 28.539s run_tests_on_device(0609288600622f17) [ RUN ] HeartbeatManagerTest.Stop\nI 28.539s run_tests_on_device(0609288600622f17) [ OK ] HeartbeatManagerTest.Stop (1 ms)\nI 28.539s run_tests_on_device(0609288600622f17) [ RUN ] HeartbeatManagerTest.MissedHeartbeat\nI 28.539s run_tests_on_device(0609288600622f17) [ OK ] HeartbeatManagerTest.MissedHeartbeat (1 ms)\nI 28.539s run_tests_on_device(0609288600622f17) [ RUN ] HeartbeatManagerTest.SetClientHeartbeatInterval\nI 28.539s run_tests_on_device(0609288600622f17) [ OK ] HeartbeatManagerTest.SetClientHeartbeatInterval (1 ms)\nI 28.539s run_tests_on_device(0609288600622f17) [ RUN ] HeartbeatManagerTest.ClientIntervalInvalid\nI 28.539s run_tests_on_device(0609288600622f17) [ OK ] HeartbeatManagerTest.ClientIntervalInvalid (1 ms)\nI 28.539s run_tests_on_device(0609288600622f17) [ RUN ] HeartbeatManagerTest.ClientIntervalAfterHeartbeatTriggered\nI 28.539s run_tests_on_device(0609288600622f17) [ OK ] HeartbeatManagerTest.ClientIntervalAfterHeartbeatTriggered (0 ms)\nI 28.539s run_tests_on_device(0609288600622f17) [----------] 14 tests from HeartbeatManagerTest (12 ms total)\nI 28.539s run_tests_on_device(0609288600622f17) \nI 28.539s run_tests_on_device(0609288600622f17) [----------] 30 tests from MCSClientTest\nI 28.539s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.InitializeNew\nI 28.539s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.InitializeNew (8 ms)\nI 28.539s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.InitializeExisting\nI 28.539s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.InitializeExisting (19 ms)\nI 28.539s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.LoginSuccess\nI 28.539s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.LoginSuccess (8 ms)\nI 28.539s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.FailLogin\nI 28.539s run_tests_on_device(0609288600622f17) [ERROR:mcs_client.cc(708)] Failed to log in to GCM, resetting connection.\nI 28.539s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.FailLogin (11 ms)\nI 28.540s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.SendMessageNoRMQ\nI 28.540s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.SendMessageNoRMQ (14 ms)\nI 28.540s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.SendMessageNoRMQWhileDisconnected\nI 28.540s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.SendMessageNoRMQWhileDisconnected (12 ms)\nI 28.540s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.SendMessageRMQ\nI 28.540s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.SendMessageRMQ (15 ms)\nI 28.540s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.SendMessageRMQWhileDisconnected\nI 28.540s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.SendMessageRMQWhileDisconnected (24 ms)\nI 28.540s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.SendMessageRMQOnRestart\nI 28.540s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.SendMessageRMQOnRestart (32 ms)\nI 28.540s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.SendMessageRMQWithStreamAck\nI 28.540s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.SendMessageRMQWithStreamAck (48 ms)\nI 28.540s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.SendMessageRMQAckOnReconnect\nI 28.540s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.SendMessageRMQAckOnReconnect (37 ms)\nI 28.540s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.SendMessageRMQPartialAckOnReconnect\nI 28.540s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.SendMessageRMQPartialAckOnReconnect (43 ms)\nI 28.540s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.SelectiveAckMidStream\nI 28.540s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.SelectiveAckMidStream (50 ms)\nI 28.540s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.AckOnLogin\nI 28.540s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.AckOnLogin (33 ms)\nI 28.540s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.AckOnSend\nI 28.540s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.AckOnSend (24 ms)\nI 28.540s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.AckWhenLimitReachedWithHeartbeat\nI 28.540s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.AckWhenLimitReachedWithHeartbeat (61 ms)\nI 28.540s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.ExpiredTTLOnSend\nI 28.540s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.ExpiredTTLOnSend (14 ms)\nI 28.540s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.ExpiredTTLOnRestart\nI 28.540s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.ExpiredTTLOnRestart (19 ms)\nI 28.540s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.CollapseKeysSameApp\nI 28.540s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.CollapseKeysSameApp (19 ms)\nI 28.540s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.CollapseKeysDifferentApp\nI 28.540s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.CollapseKeysDifferentApp (16 ms)\nI 28.540s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.CollapseKeysDifferentUser\nI 28.540s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.CollapseKeysDifferentUser (18 ms)\nI 28.540s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.CustomHeartbeatIntervalTooShort\nI 28.540s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.CustomHeartbeatIntervalTooShort (17 ms)\nI 28.540s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.CustomHeartbeatIntervalTooLong\nI 28.540s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.CustomHeartbeatIntervalTooLong (15 ms)\nI 28.540s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.CustomHeartbeatIntervalSingleInterval\nI 28.540s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.CustomHeartbeatIntervalSingleInterval (23 ms)\nI 28.540s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.CustomHeartbeatIntervalSetBeforeInitialize\nI 28.540s run_tests_on_device(0609288600622f17) [ERROR:gcm_store_impl.cc(799)] GCMStore db doesn't exist.\nI 28.540s run_tests_on_device(0609288600622f17) [ERROR:mcs_client.cc(526)] GCM Update failed!\nI 28.540s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.CustomHeartbeatIntervalSetBeforeInitialize (20 ms)\nI 28.540s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.CustomHeartbeatIntervalSetBeforeLogin\nI 28.540s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.CustomHeartbeatIntervalSetBeforeLogin (20 ms)\nI 28.540s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.CustomHeartbeatIntervalSecondIntervalLonger\nI 28.540s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.CustomHeartbeatIntervalSecondIntervalLonger (31 ms)\nI 28.540s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.CustomHeartbeatIntervalSecondIntervalShorter\nI 28.540s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.CustomHeartbeatIntervalSecondIntervalShorter (42 ms)\nI 28.540s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.CustomHeartbeatIntervalRemoveShorterInterval\nI 28.540s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.CustomHeartbeatIntervalRemoveShorterInterval (28 ms)\nI 28.540s run_tests_on_device(0609288600622f17) [ RUN ] MCSClientTest.AckWhenImmediateAckRequested\nI 28.540s run_tests_on_device(0609288600622f17) [ OK ] MCSClientTest.AckWhenImmediateAckRequested (36 ms)\nI 28.540s run_tests_on_device(0609288600622f17) [----------] 30 tests from MCSClientTest (770 ms total)\nI 28.541s run_tests_on_device(0609288600622f17) \nI 28.541s run_tests_on_device(0609288600622f17) [----------] 19 tests from GCMRegistrationRequestTest\nI 28.541s run_tests_on_device(0609288600622f17) [ RUN ] GCMRegistrationRequestTest.RequestSuccessful\nI 28.541s run_tests_on_device(0609288600622f17) [ OK ] GCMRegistrationRequestTest.RequestSuccessful (7 ms)\nI 28.541s run_tests_on_device(0609288600622f17) [ RUN ] GCMRegistrationRequestTest.RequestDataAndURL\nI 28.541s run_tests_on_device(0609288600622f17) [ OK ] GCMRegistrationRequestTest.RequestDataAndURL (6 ms)\nI 28.541s run_tests_on_device(0609288600622f17) [ RUN ] GCMRegistrationRequestTest.RequestRegistrationWithMultipleSenderIds\nI 28.541s run_tests_on_device(0609288600622f17) [ OK ] GCMRegistrationRequestTest.RequestRegistrationWithMultipleSenderIds (3 ms)\nI 28.541s run_tests_on_device(0609288600622f17) [ RUN ] GCMRegistrationRequestTest.ResponseParsing\nI 28.541s run_tests_on_device(0609288600622f17) [ OK ] GCMRegistrationRequestTest.ResponseParsing (4 ms)\nI 28.541s run_tests_on_device(0609288600622f17) [ RUN ] GCMRegistrationRequestTest.ResponseParsingFailed\nI 28.541s run_tests_on_device(0609288600622f17) [ OK ] GCMRegistrationRequestTest.ResponseParsingFailed (6 ms)\nI 28.541s run_tests_on_device(0609288600622f17) [ RUN ] GCMRegistrationRequestTest.ResponseHttpStatusNotOK\nI 28.541s run_tests_on_device(0609288600622f17) [ OK ] GCMRegistrationRequestTest.ResponseHttpStatusNotOK (8 ms)\nI 28.541s run_tests_on_device(0609288600622f17) [ RUN ] GCMRegistrationRequestTest.ResponseMissingRegistrationId\nI 28.541s run_tests_on_device(0609288600622f17) [ OK ] GCMRegistrationRequestTest.ResponseMissingRegistrationId (8 ms)\nI 28.541s run_tests_on_device(0609288600622f17) [ RUN ] GCMRegistrationRequestTest.ResponseDeviceRegistrationError\nI 28.541s run_tests_on_device(0609288600622f17) [ OK ] GCMRegistrationRequestTest.ResponseDeviceRegistrationError (7 ms)\nI 28.541s run_tests_on_device(0609288600622f17) [ RUN ] GCMRegistrationRequestTest.ResponseAuthenticationError\nI 28.541s run_tests_on_device(0609288600622f17) [ OK ] GCMRegistrationRequestTest.ResponseAuthenticationError (6 ms)\nI 28.541s run_tests_on_device(0609288600622f17) [ RUN ] GCMRegistrationRequestTest.ResponseInternalServerError\nI 28.541s run_tests_on_device(0609288600622f17) [ OK ] GCMRegistrationRequestTest.ResponseInternalServerError (7 ms)\nI 28.541s run_tests_on_device(0609288600622f17) [ RUN ] GCMRegistrationRequestTest.ResponseInvalidParameters\nI 28.541s run_tests_on_device(0609288600622f17) [ OK ] GCMRegistrationRequestTest.ResponseInvalidParameters (4 ms)\nI 28.541s run_tests_on_device(0609288600622f17) [ RUN ] GCMRegistrationRequestTest.ResponseInvalidSender\nI 28.541s run_tests_on_device(0609288600622f17) [ OK ] GCMRegistrationRequestTest.ResponseInvalidSender (4 ms)\nI 28.541s run_tests_on_device(0609288600622f17) [ RUN ] GCMRegistrationRequestTest.ResponseInvalidSenderBadRequest\nI 28.541s run_tests_on_device(0609288600622f17) [ OK ] GCMRegistrationRequestTest.ResponseInvalidSenderBadRequest (5 ms)\nI 28.541s run_tests_on_device(0609288600622f17) [ RUN ] GCMRegistrationRequestTest.ResponseQuotaExceeded\nI 28.541s run_tests_on_device(0609288600622f17) [ OK ] GCMRegistrationRequestTest.ResponseQuotaExceeded (4 ms)\nI 28.541s run_tests_on_device(0609288600622f17) [ RUN ] GCMRegistrationRequestTest.ResponseTooManyRegistrations\nI 28.541s run_tests_on_device(0609288600622f17) [ OK ] GCMRegistrationRequestTest.ResponseTooManyRegistrations (4 ms)\nI 28.541s run_tests_on_device(0609288600622f17) [ RUN ] GCMRegistrationRequestTest.RequestNotSuccessful\nI 28.541s run_tests_on_device(0609288600622f17) [ OK ] GCMRegistrationRequestTest.RequestNotSuccessful (6 ms)\nI 28.541s run_tests_on_device(0609288600622f17) [ RUN ] GCMRegistrationRequestTest.ResponseHttpNotOk\nI 28.541s run_tests_on_device(0609288600622f17) [ OK ] GCMRegistrationRequestTest.ResponseHttpNotOk (7 ms)\nI 28.541s run_tests_on_device(0609288600622f17) [ RUN ] GCMRegistrationRequestTest.MaximumAttemptsReachedWithZeroRetries\nI 28.541s run_tests_on_device(0609288600622f17) [ OK ] GCMRegistrationRequestTest.MaximumAttemptsReachedWithZeroRetries (4 ms)\nI 28.541s run_tests_on_device(0609288600622f17) [ RUN ] GCMRegistrationRequestTest.MaximumAttemptsReached\nI 28.541s run_tests_on_device(0609288600622f17) [ OK ] GCMRegistrationRequestTest.MaximumAttemptsReached (9 ms)\nI 28.541s run_tests_on_device(0609288600622f17) [----------] 19 tests from GCMRegistrationRequestTest (112 ms total)\nI 28.541s run_tests_on_device(0609288600622f17) \nI 28.541s run_tests_on_device(0609288600622f17) [----------] 4 tests from InstanceIDGetTokenRequestTest\nI 28.541s run_tests_on_device(0609288600622f17) [ RUN ] InstanceIDGetTokenRequestTest.RequestSuccessful\nI 28.541s run_tests_on_device(0609288600622f17) [ OK ] InstanceIDGetTokenRequestTest.RequestSuccessful (4 ms)\nI 28.541s run_tests_on_device(0609288600622f17) [ RUN ] InstanceIDGetTokenRequestTest.RequestDataAndURL\nI 28.541s run_tests_on_device(0609288600622f17) [ OK ] InstanceIDGetTokenRequestTest.RequestDataAndURL (3 ms)\nI 28.541s run_tests_on_device(0609288600622f17) [ RUN ] InstanceIDGetTokenRequestTest.RequestDataWithSubtype\nI 28.541s run_tests_on_device(0609288600622f17) [ OK ] InstanceIDGetTokenRequestTest.RequestDataWithSubtype (3 ms)\nI 28.541s run_tests_on_device(0609288600622f17) [ RUN ] InstanceIDGetTokenRequestTest.ResponseHttpStatusNotOK\nI 28.541s run_tests_on_device(0609288600622f17) [ OK ] InstanceIDGetTokenRequestTest.ResponseHttpStatusNotOK (6 ms)\nI 28.541s run_tests_on_device(0609288600622f17) [----------] 4 tests from InstanceIDGetTokenRequestTest (16 ms total)\nI 28.541s run_tests_on_device(0609288600622f17) \nI 28.541s run_tests_on_device(0609288600622f17) [----------] 13 tests from GCMUnregistrationRequestTest\nI 28.541s run_tests_on_device(0609288600622f17) [ RUN ] GCMUnregistrationRequestTest.RequestDataPassedToFetcher\nI 28.541s run_tests_on_device(0609288600622f17) [ OK ] GCMUnregistrationRequestTest.RequestDataPassedToFetcher (3 ms)\nI 28.542s run_tests_on_device(0609288600622f17) [ RUN ] GCMUnregistrationRequestTest.SuccessfulUnregistration\nI 28.542s run_tests_on_device(0609288600622f17) [ OK ] GCMUnregistrationRequestTest.SuccessfulUnregistration (4 ms)\nI 28.542s run_tests_on_device(0609288600622f17) [ RUN ] GCMUnregistrationRequestTest.ResponseHttpStatusNotOK\nI 28.542s run_tests_on_device(0609288600622f17) [ OK ] GCMUnregistrationRequestTest.ResponseHttpStatusNotOK (7 ms)\nI 28.542s run_tests_on_device(0609288600622f17) [ RUN ] GCMUnregistrationRequestTest.ResponseEmpty\nI 28.542s run_tests_on_device(0609288600622f17) [ OK ] GCMUnregistrationRequestTest.ResponseEmpty (6 ms)\nI 28.542s run_tests_on_device(0609288600622f17) [ RUN ] GCMUnregistrationRequestTest.InvalidParametersError\nI 28.542s run_tests_on_device(0609288600622f17) [ OK ] GCMUnregistrationRequestTest.InvalidParametersError (4 ms)\nI 28.542s run_tests_on_device(0609288600622f17) [ RUN ] GCMUnregistrationRequestTest.DeviceRegistrationError\nI 28.542s run_tests_on_device(0609288600622f17) [ OK ] GCMUnregistrationRequestTest.DeviceRegistrationError (4 ms)\nI 28.542s run_tests_on_device(0609288600622f17) [ RUN ] GCMUnregistrationRequestTest.UnkwnownError\nI 28.542s run_tests_on_device(0609288600622f17) [ OK ] GCMUnregistrationRequestTest.UnkwnownError (4 ms)\nI 28.542s run_tests_on_device(0609288600622f17) [ RUN ] GCMUnregistrationRequestTest.ServiceUnavailable\nI 28.542s run_tests_on_device(0609288600622f17) [ OK ] GCMUnregistrationRequestTest.ServiceUnavailable (6 ms)\nI 28.542s run_tests_on_device(0609288600622f17) [ RUN ] GCMUnregistrationRequestTest.InternalServerError\nI 28.542s run_tests_on_device(0609288600622f17) [ OK ] GCMUnregistrationRequestTest.InternalServerError (7 ms)\nI 28.542s run_tests_on_device(0609288600622f17) [ RUN ] GCMUnregistrationRequestTest.IncorrectAppId\nI 28.542s run_tests_on_device(0609288600622f17) [ OK ] GCMUnregistrationRequestTest.IncorrectAppId (6 ms)\nI 28.542s run_tests_on_device(0609288600622f17) [ RUN ] GCMUnregistrationRequestTest.ResponseParsingFailed\nI 28.542s run_tests_on_device(0609288600622f17) [ OK ] GCMUnregistrationRequestTest.ResponseParsingFailed (8 ms)\nI 28.542s run_tests_on_device(0609288600622f17) [ RUN ] GCMUnregistrationRequestTest.MaximumAttemptsReachedWithZeroRetries\nI 28.542s run_tests_on_device(0609288600622f17) [ OK ] GCMUnregistrationRequestTest.MaximumAttemptsReachedWithZeroRetries (4 ms)\nI 28.542s run_tests_on_device(0609288600622f17) [ RUN ] GCMUnregistrationRequestTest.MaximumAttemptsReached\nI 28.542s run_tests_on_device(0609288600622f17) [ OK ] GCMUnregistrationRequestTest.MaximumAttemptsReached (9 ms)\nI 28.542s run_tests_on_device(0609288600622f17) [----------] 13 tests from GCMUnregistrationRequestTest (76 ms total)\nI 28.542s run_tests_on_device(0609288600622f17) \nI 28.542s run_tests_on_device(0609288600622f17) [----------] 6 tests from InstaceIDDeleteTokenRequestTest\nI 28.542s run_tests_on_device(0609288600622f17) [ RUN ] InstaceIDDeleteTokenRequestTest.RequestDataPassedToFetcher\nI 28.542s run_tests_on_device(0609288600622f17) [ OK ] InstaceIDDeleteTokenRequestTest.RequestDataPassedToFetcher (3 ms)\nI 28.542s run_tests_on_device(0609288600622f17) [ RUN ] InstaceIDDeleteTokenRequestTest.RequestDataWithSubtype\nI 28.542s run_tests_on_device(0609288600622f17) [ OK ] InstaceIDDeleteTokenRequestTest.RequestDataWithSubtype (3 ms)\nI 28.542s run_tests_on_device(0609288600622f17) [ RUN ] InstaceIDDeleteTokenRequestTest.SuccessfulUnregistration\nI 28.542s run_tests_on_device(0609288600622f17) [ OK ] InstaceIDDeleteTokenRequestTest.SuccessfulUnregistration (4 ms)\nI 28.542s run_tests_on_device(0609288600622f17) [ RUN ] InstaceIDDeleteTokenRequestTest.ResponseHttpStatusNotOK\nI 28.542s run_tests_on_device(0609288600622f17) [ OK ] InstaceIDDeleteTokenRequestTest.ResponseHttpStatusNotOK (6 ms)\nI 28.542s run_tests_on_device(0609288600622f17) [ RUN ] InstaceIDDeleteTokenRequestTest.InvalidParametersError\nI 28.542s run_tests_on_device(0609288600622f17) [ OK ] InstaceIDDeleteTokenRequestTest.InvalidParametersError (4 ms)\nI 28.542s run_tests_on_device(0609288600622f17) [ RUN ] InstaceIDDeleteTokenRequestTest.UnkwnownError\nI 28.542s run_tests_on_device(0609288600622f17) [ OK ] InstaceIDDeleteTokenRequestTest.UnkwnownError (4 ms)\nI 28.542s run_tests_on_device(0609288600622f17) [----------] 6 tests from InstaceIDDeleteTokenRequestTest (25 ms total)\nI 28.542s run_tests_on_device(0609288600622f17) \nI 28.542s run_tests_on_device(0609288600622f17) [----------] Global test environment tear-down\nI 28.542s run_tests_on_device(0609288600622f17) [==========] 188 tests from 16 test suites ran. (3173 ms total)\nI 28.542s run_tests_on_device(0609288600622f17) [ PASSED ] 188 tests.\nI 28.542s run_tests_on_device(0609288600622f17) <<ScopedMainEntryLogger\nI 28.548s run_tests_on_device(0609288600622f17) Finished running tests on this device.\nI 28.554s Main FINISHED TRY #1/3\nI 28.555s Main All tests completed.\nC 28.555s Main ********************************************************************************\nC 28.555s Main Summary\nC 28.555s Main ********************************************************************************\nC 28.555s Main [==========] 188 tests ran.\nC 28.555s Main [ PASSED ] 188 tests.\nC 28.555s Main ********************************************************************************\nI 28.558s tear_down_device(0609288600622f17) Wrote device cache: /b/swarming/w/ir/out/Debug/device_cache_0609288600622f17.json\nI 28.564s Main Generated json results file at /b/swarming/w/itjMC2BQ/tmpBV22Fy\nI 28.564s Main Finishing archiving output.\n[W2019-03-24T07:49:11.973719Z 375 0 butler.go:240] Butler Context was cancelled. Initiating shutdown. {\"error\":\"context canceled\"}\nINFO:devil.utils.timeout_retry:condition 'logdog_stopped' not met\n[E2019-03-24T07:49:12.079286Z 375 0 main.go:205] Butler terminated with error. {\"error\":\"context canceled\"}\n[E2019-03-24T07:49:12.079366Z 375 0 main.go:233] Failed to serve.\noriginal error: context canceled\n\n[I2019-03-24T07:49:12.079451Z 375 0 main.go:349] Terminating. {\"returnCode\":250}\nINFO:devil.utils.timeout_retry:condition 'logdog_stopped' met\n", "outputs_ref": { "isolated": "edb82e90dfdc1316b85133a2dfc678669749f825", "isolatedserver": "https://isolateserver.appspot.com", "namespace": "default-gzip" }, "run_id": "43c77daba5c8b111", "server_versions": [ "4216-cf4a3cd" ], "started_ts": "2019-03-24T07:48:31.344804", "state": "COMPLETED", "tags": [ "build_is_experimental:false", "buildername:KitKat Phone Tester (dbg)", "buildnumber:12595", "data:b49a09cb59d7bfeb6ba0e3b0c987edb3c3688d8f", "device_os:KTU84P", "device_type:hammerhead", "master:chromium.android", "name:gcm_unit_tests", "os:Android", "pool:Chrome", "priority:25", "project:chromium", "purpose:CI", "purpose:luci", "purpose:post-commit", "service_account:none", "slavename:swarm96-c4", "spec_name:chromium.ci:KitKat Phone Tester (dbg)", "stepname:gcm_unit_tests on Android device Nexus 5", "swarming.pool.template:none", "swarming.pool.version:d172b3da50f79bdc0892909417b8871a46e09913", "user:None" ], "task_id": "43ca2f528f67be10" } ] }