Play-games-plugin-for-unity: Play Services tries to authenticate, closes the profile popup prematurely, fails

[ZOSDanBatson]

So far I got this working on one of my dozen attempts at setting up a test project but can't seem to get it to work again. When I try to call Social.localUser.Authenticate on device, the Google Play Games Services popup appears with the name of my app and Google Play for a moment, loads, then tries to switch to what I believe is some kind of profile confirmation secondary popup. But that second popup closes immediately, and GPGS spits back an Authentication Failed. Here's my log cat for the authentication bits:

2018-11-16 11:50:18.881 12562-12584/? I/Unity: Starting Auth with token client.

    (Filename: ./Runtime/Export/Debug.bindings.h Line: 43)
2018-11-16 11:50:18.881 12562-12584/? D/TokenFragment: Fragment exists.. calling processRequests
2018-11-16 11:50:18.882 12562-12584/? D/TokenFragment: Building client for: 9fb067f (a:true e:false i:true wc: 272576419934-15i4rvp73stpjcppn1k543r0p1qh5e5m.apps.googleusercontent.com f: false)
2018-11-16 11:50:18.882 12562-12584/? W/PopupManager: You have not specified a View to use as content view for popups. Falling back to the Activity content view. Note that this may not work as expected in multi-screen environments
2018-11-16 11:50:18.889 12562-12584/? D/TokenFragment: Done with processRequest, result is pending.
2018-11-16 11:50:18.890 12562-12584/? I/Unity: ---- [0] -- 101

    (Filename: ./Runtime/Export/Debug.bindings.h Line: 43)
2018-11-16 11:50:18.896 2584-11782/? W/GamesServiceBroker: Client connected with SDK 12451000, Services 14369037, and Games 74660040
2018-11-16 11:50:18.903 2584-21787/? W/GamesServiceBroker: Client connected with SDK 14768000, Services 14369037, and Games 74660040
2018-11-16 11:50:18.913 2584-21787/? I/chatty: uid=10013(com.google.android.gms) GAC_Executor[1] identical 2 lines
2018-11-16 11:50:18.919 2584-21787/? W/GamesServiceBroker: Client connected with SDK 14768000, Services 14369037, and Games 74660040
2018-11-16 11:50:18.921 2584-21783/? W/GamesServiceBroker: Client connected with SDK 14768000, Services 14369037, and Games 74660040
2018-11-16 11:50:19.083 2584-21783/? W/GamesServiceBroker: Client connected with SDK 14768000, Services 14369037, and Games 74660040
2018-11-16 11:50:19.084 2584-21787/? W/GamesServiceBroker: Client connected with SDK 14768000, Services 14369037, and Games 74660040
2018-11-16 11:50:19.094 12562-12562/? I/TokenFragment: onConnected called
2018-11-16 11:50:19.103 2584-5114/? W/GamesServiceBroker: Client connected with SDK 14369000, Services 14369037, and Games 74660040
2018-11-16 11:50:19.107 2584-21783/? W/GamesServiceBroker: Client connected with SDK 14768000, Services 14369037, and Games 74660040
2018-11-16 11:50:19.108 2584-21787/? W/GamesServiceBroker: Client connected with SDK 14768000, Services 14369037, and Games 74660040
2018-11-16 11:50:19.110 2584-21787/? I/chatty: uid=10013(com.google.android.gms) GAC_Executor[1] identical 1 line
2018-11-16 11:50:19.116 2584-21787/? W/GamesServiceBroker: Client connected with SDK 14768000, Services 14369037, and Games 74660040
2018-11-16 11:50:19.116 2584-21783/? W/GamesServiceBroker: Client connected with SDK 14768000, Services 14369037, and Games 74660040
2018-11-16 11:50:19.199 2584-21783/? W/GamesServiceBroker: Client connected with SDK 14768000, Services 14369037, and Games 74660040
2018-11-16 11:50:19.200 2584-21787/? W/GamesServiceBroker: Client connected with SDK 14768000, Services 14369037, and Games 74660040

    --------- beginning of system
2018-11-16 11:50:19.212 1203-1215/? I/ActivityManager: START u0 {act=com.google.android.gms.auth.GOOGLE_SIGN_IN pkg=com.zotest.zomobiletest cmp=com.zotest.zomobiletest/com.google.android.gms.auth.api.signin.internal.SignInHubActivity (has extras)} from uid 10262
2018-11-16 11:50:19.220 811-811/? D/[email protected]: LAUNCH ON
2018-11-16 11:50:19.244 12562-12584/? D/AudioTrack: stop() called with 2220768 frames delivered
2018-11-16 11:50:19.245 1935-2494/? E/bt_btif: register_notification_rsp: Avrcp device is not connected, handle: 0x0
2018-11-16 11:50:19.245 1935-2494/? I/chatty: uid=1002(bluetooth) BluetoothAvrcpH identical 4 lines
2018-11-16 11:50:19.245 1935-2494/? E/bt_btif: register_notification_rsp: Avrcp device is not connected, handle: 0x0
2018-11-16 11:50:19.253 12562-12562/? W/ActivityThread: handleWindowVisibility: no activity for token android.os.BinderProxy@dc54677
2018-11-16 11:50:19.261 1203-1215/? I/ActivityManager: START u0 {act=com.google.android.gms.auth.GOOGLE_SIGN_IN pkg=com.google.android.gms cmp=com.google.android.gms/.auth.api.signin.ui.SignInActivity (has extras)} from uid 10262
2018-11-16 11:50:19.268 811-811/? D/[email protected]: LAUNCH ON
2018-11-16 11:50:19.292 12562-12707/? I/OpenGLRenderer: Initialized EGL, version 1.4
2018-11-16 11:50:19.292 12562-12707/? D/OpenGLRenderer: Swap behavior 1
2018-11-16 11:50:19.294 1203-1245/? I/ActivityManager: Start proc 12708:com.google.android.gms.ui/u0a13 for activity com.google.android.gms/.auth.api.signin.ui.SignInActivity
2018-11-16 11:50:19.294 12708-12708/? I/.android.gms.u: Late-enabling -Xcheck:jni
2018-11-16 11:50:19.297 12708-12708/? E/.android.gms.u: Not starting debugger since process cannot load the jdwp agent.
2018-11-16 11:50:19.309 1972-1972/? I/Elmyra/ElmyraService: Unblocked; current action: LaunchOpa [mIsGestureEnabled -> true; mIsOpaEnabled -> true]
2018-11-16 11:50:19.311 799-799/? I/chatty: uid=1000(system) [email protected] identical 1 line
2018-11-16 11:50:19.314 820-972/? D/CHRE: @ 640238.750: Parsed nanoapp message from host: app ID 0x476f6f676c00100e, endpoint 0x0, msgType 1, payload size 29
2018-11-16 11:50:19.314 820-972/? D/CHRE: @ 640238.750: Parsed nanoapp message from host: app ID 0x476f6f676c00100e, endpoint 0x0, msgType 1, payload size 5
2018-11-16 11:50:19.315 820-972/? D/CHRE: @ 640238.750: Parsed nanoapp message from host: app ID 0x476f6f676c00100e, endpoint 0x0, msgType 1, payload size 2
2018-11-16 11:50:19.315 820-972/? D/CHRE: @ 640238.750: [Elmyra] Recognizer start: 1
2018-11-16 11:50:19.316 820-972/? D/CHRE: @ 640238.750: [Elmyra] Unexpected event: 512
2018-11-16 11:50:19.326 12708-12708/? I/.android.gms.u: The ClassLoaderContext is a special shared library.
2018-11-16 11:50:19.330 12708-12708/? I/chatty: uid=10013 com.google.android.gms.ui identical 2 lines
2018-11-16 11:50:19.338 12708-12708/? I/.android.gms.u: The ClassLoaderContext is a special shared library.
2018-11-16 11:50:19.340 820-972/? W/CHRE: @ 640238.812: Incorrect number of SMGR samples for vendor0: 1
2018-11-16 11:50:19.340 820-972/? W/CHRE: @ 640238.812: Dropping zero readingCount event
2018-11-16 11:50:19.360 820-972/? W/CHRE: @ 640238.812: Incorrect number of SMGR samples for vendor0: 3
2018-11-16 11:50:19.360 820-972/? W/CHRE: @ 640238.812: Incorrect vendor0 SMGR sample sequence
2018-11-16 11:50:19.360 820-972/? W/CHRE: @ 640238.812: Incorrect vendor0 SMGR sample sequence
2018-11-16 11:50:19.362 12708-12708/? W/GmsApplication: Failed to invoke the SupplierSetterRegistry.
2018-11-16 11:50:19.385 1203-1641/? D/ContextHubService: Sending message 1 version 0 from hubHandle 0, appInstance 1, callBackCount 2
2018-11-16 11:50:19.451 12708-12708/? D/NetworkSecurityConfig: Using Network Security Config from resource network_security_config debugBuild: false
2018-11-16 11:50:19.454 12708-12708/? I/ProviderInstaller: Installed default security provider GmsCore_OpenSSL
2018-11-16 11:50:19.558 12708-12708/? W/Primes: Primes not initialized, returning default (no-op) Primes instance which will ignore all calls. Please call Primes.initialize(...) before using any Primes API.
2018-11-16 11:50:19.584 12708-12730/? D/libEGL: loaded /vendor/lib64/egl/libEGL_adreno.so
2018-11-16 11:50:19.633 12708-12730/? D/libEGL: loaded /vendor/lib64/egl/libGLESv1_CM_adreno.so
2018-11-16 11:50:19.641 14737-14769/? I/Finsky: [5443] com.google.android.finsky.bp.an.run(6): Stats for Executor: Db-user_languages_store com.google.android.finsky.bp.ao@c64bfad[Running, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 1]
2018-11-16 11:50:19.650 12708-12730/? D/libEGL: loaded /vendor/lib64/egl/libGLESv2_adreno.so
2018-11-16 11:50:19.684 12708-12708/? D/OpenGLRenderer: Skia GL Pipeline
2018-11-16 11:50:19.707 12708-12733/? I/Adreno: QUALCOMM build                   : 7bf2852, Ie32bfa6f6f
    Build Date                       : 06/03/18
    OpenGL ES Shader Compiler Version: EV031.24.00.00
    Local Branch                     : googdrp
    Remote Branch                    : 
    Remote Branch                    : 
    Reconstruct Branch               : 
2018-11-16 11:50:19.707 12708-12733/? I/Adreno: Build Config                     : S L 4.0.10 AArch64
2018-11-16 11:50:19.710 2584-3077/? W/GamesServiceBroker: Client connected with SDK 14369000, Services 14369037, and Games 74660040
2018-11-16 11:50:19.713 2584-21787/? W/GamesServiceBroker: Client connected with SDK 14768000, Services 14369037, and Games 74660040
2018-11-16 11:50:19.715 2584-21783/? W/GamesServiceBroker: Client connected with SDK 14768000, Services 14369037, and Games 74660040
2018-11-16 11:50:19.716 12708-12733/? I/Adreno: PFP: 0x005ff110, ME: 0x005ff066
2018-11-16 11:50:19.718 2584-21783/? W/GamesServiceBroker: Client connected with SDK 14768000, Services 14369037, and Games 74660040
2018-11-16 11:50:19.725 2584-21783/? W/GamesServiceBroker: Client connected with SDK 14768000, Services 14369037, and Games 74660040
2018-11-16 11:50:19.726 2584-21787/? W/GamesServiceBroker: Client connected with SDK 14768000, Services 14369037, and Games 74660040
2018-11-16 11:50:19.727 12708-12733/? I/ConfigStore: android::hardware::configstore::V1_0::ISurfaceFlingerConfigs::hasWideColorDisplay retrieved: 1
2018-11-16 11:50:19.727 12708-12733/? I/ConfigStore: android::hardware::configstore::V1_0::ISurfaceFlingerConfigs::hasHDRDisplay retrieved: 0
2018-11-16 11:50:19.727 12708-12733/? I/OpenGLRenderer: Initialized EGL, version 1.4
2018-11-16 11:50:19.727 12708-12733/? D/OpenGLRenderer: Swap behavior 1
2018-11-16 11:50:19.747 811-811/? D/[email protected]: LAUNCH OFF
2018-11-16 11:50:19.756 1203-1254/? I/ActivityManager: Displayed com.google.android.gms/.auth.api.signin.ui.SignInActivity: +463ms (total +495ms)
2018-11-16 11:50:19.876 2143-2214/? I/QCNEJ/CndHalConnector: -> SND notifyWifiStatusChanged(RatInfo{type=1, subType=101, state=CONNECTED, v4=IfaceAddrPair{iface=wlan0, addr=192.168.221.89}, v6=IfaceAddrPair{iface=, addr=}, timestamp=2018-11-16 11:50:19.876, isAndroidValidated=true, netHandle=2026335293453, slotIdx=0} WifiInfo{freq=FIVE_GHz, state=3, ssid=ZOS-WiFi, bssid=cc:d5:39:bb:88:bd, dns=[8.8.8.8, 4.2.2.2, 0.0.0.0, 0.0.0.0, ]})
2018-11-16 11:50:19.881 2584-21787/? W/GamesServiceBroker: Client connected with SDK 14768000, Services 14369037, and Games 74660040
2018-11-16 11:50:19.881 7304-7326/? I/CarrierServices: [16884] bkt.onCapabilitiesChanged: TeleWifiMonitor.NetworkCallback.onCapabilitiesChanged
2018-11-16 11:50:19.883 2584-21783/? W/GamesServiceBroker: Client connected with SDK 14768000, Services 14369037, and Games 74660040
2018-11-16 11:50:19.885 1203-1215/? I/ActivityManager: START u0 {cmp=com.google.android.gms/.common.api.GoogleApiActivity (has extras)} from uid 10013
2018-11-16 11:50:19.886 811-811/? D/[email protected]: LAUNCH ON
2018-11-16 11:50:19.897 12708-12708/? W/ActivityThread: handleWindowVisibility: no activity for token android.os.BinderProxy@54a17e3
2018-11-16 11:50:19.898 7304-7326/? I/CarrierServices: [16884] bxd.a: FiST: Wifi connectivity status true
2018-11-16 11:50:19.900 7304-7358/? I/CarrierServices: [16902] bei.handleMessage: RCS is disabled, skipping config update request
2018-11-16 11:50:19.900 1203-1215/? I/ActivityManager: START u0 {act=com.google.android.gms.games.SIGN_IN flg=0x4000000 pkg=com.google.android.play.games cmp=com.google.android.play.games/com.google.android.gms.games.ui.signin.SignInActivity (has extras)} from uid 10013
2018-11-16 11:50:19.901 7304-7326/? I/CarrierServices: [16884] bxi.d: Connected state: [1], networkType: [WIFI]
2018-11-16 11:50:19.902 7304-7304/? I/CarrierServices: [2] bkw.onReceive: TeleWifiMonitor.updateSignalState, (is connected: true, signal level: 99%, link speed: 144Mbps) -> (is connected: true, signal level: 96%, link speed: 144Mbps)
2018-11-16 11:50:19.906 7304-7304/? I/CarrierServices: [2] bfn.a: onWifiStateChanged
2018-11-16 11:50:19.909 811-811/? D/[email protected]: LAUNCH ON
2018-11-16 11:50:19.931 1203-1245/? I/ActivityManager: Start proc 12740:com.google.android.play.games.ui/u0a187 for activity com.google.android.play.games/com.google.android.gms.games.ui.signin.SignInActivity
2018-11-16 11:50:19.935 12740-12740/? I/d.play.games.u: Late-enabling -Xcheck:jni
2018-11-16 11:50:19.940 12740-12740/? E/d.play.games.u: Not starting debugger since process cannot load the jdwp agent.
2018-11-16 11:50:20.023 12740-12740/? W/PrimesInit: Primes instant initialization
2018-11-16 11:50:20.023 12740-12757/? W/Primes: background initialization
2018-11-16 11:50:20.028 12740-12757/? I/PrimesTesting: GserviceFlagsSupplier.get()
2018-11-16 11:50:20.029 12740-12740/? I/GAv4-SVC: Google Analytics 14.7.68 is starting up.
2018-11-16 11:50:20.072 12740-12765/? D/libEGL: loaded /vendor/lib64/egl/libEGL_adreno.so
2018-11-16 11:50:20.079 12740-12765/? D/libEGL: loaded /vendor/lib64/egl/libGLESv1_CM_adreno.so
2018-11-16 11:50:20.081 12740-12740/? I/AppLifecycleTracker: onActivityCreated: 
2018-11-16 11:50:20.091 12740-12765/? D/libEGL: loaded /vendor/lib64/egl/libGLESv2_adreno.so
2018-11-16 11:50:20.103 12740-12740/? W/DynamiteModule: Local module descriptor class for com.google.android.gms.googlecertificates not found.
2018-11-16 11:50:20.106 12740-12740/? W/d.play.games.u: Unsupported class loader
2018-11-16 11:50:20.109 12740-12740/? W/d.play.games.u: Skipping duplicate class check due to unsupported classloader
2018-11-16 11:50:20.110 12740-12740/? I/DynamiteModule: Considering local module com.google.android.gms.googlecertificates:0 and remote module com.google.android.gms.googlecertificates:4
2018-11-16 11:50:20.110 12740-12740/? I/DynamiteModule: Selected remote version of com.google.android.gms.googlecertificates, version >= 4
2018-11-16 11:50:20.121 12740-12740/? W/d.play.games.u: Unsupported class loader
2018-11-16 11:50:20.173 14737-14769/? I/Finsky: [5443] com.google.android.finsky.bp.an.run(6): Stats for Executor: Db-frosting.db com.google.android.finsky.bp.ao@8a1ba75[Running, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 9]
2018-11-16 11:50:20.287 12740-12740/? W/d.play.games.u: Verification of void e.c() took 152.687ms
2018-11-16 11:50:20.380 12740-12740/? I/AppLifecycleTracker: onActivityStarted: 
2018-11-16 11:50:20.385 12740-12740/? I/AppLifecycleTracker: onActivityResumed: 
2018-11-16 11:50:20.386 12740-12740/? D/OpenGLRenderer: Skia GL Pipeline
2018-11-16 11:50:20.411 12740-12740/? I/SignInActivity: Transition from -1 to 0
2018-11-16 11:50:20.421 12740-12766/? I/Adreno: QUALCOMM build                   : 7bf2852, Ie32bfa6f6f
    Build Date                       : 06/03/18
    OpenGL ES Shader Compiler Version: EV031.24.00.00
    Local Branch                     : googdrp
    Remote Branch                    : 
    Remote Branch                    : 
    Reconstruct Branch               : 
2018-11-16 11:50:20.421 12740-12766/? I/Adreno: Build Config                     : S L 4.0.10 AArch64
2018-11-16 11:50:20.425 12740-12766/? I/Adreno: PFP: 0x005ff110, ME: 0x005ff066
2018-11-16 11:50:20.430 12740-12766/? I/ConfigStore: android::hardware::configstore::V1_0::ISurfaceFlingerConfigs::hasWideColorDisplay retrieved: 1
2018-11-16 11:50:20.430 12740-12766/? I/ConfigStore: android::hardware::configstore::V1_0::ISurfaceFlingerConfigs::hasHDRDisplay retrieved: 0
2018-11-16 11:50:20.430 12740-12766/? I/OpenGLRenderer: Initialized EGL, version 1.4
2018-11-16 11:50:20.430 12740-12766/? D/OpenGLRenderer: Swap behavior 1
2018-11-16 11:50:20.530 620-647/? D/SurfaceFlinger: duplicate layer name: changing com.google.android.play.games/com.google.android.gms.games.ui.signin.SignInActivity to com.google.android.play.games/com.google.android.gms.games.ui.signin.SignInActivity#1
2018-11-16 11:50:20.551 12740-12740/? W/InputMethodManager: Ignoring onBind: cur seq=3228, given seq=3227
2018-11-16 11:50:20.611 2584-3447/? W/GamesServiceBroker: Client connected with SDK 14768000, Services 14369037, and Games 74660040
2018-11-16 11:50:20.611 1203-1254/? I/ActivityManager: Displayed com.google.android.play.games/com.google.android.gms.games.ui.signin.SignInActivity: +678ms (total +704ms)
2018-11-16 11:50:22.279 12171-12189/? E/memtrack: Couldn't load memtrack module
2018-11-16 11:50:22.279 12171-12189/? W/android.os.Debug: failed to get memory consumption info: -1
2018-11-16 11:50:22.330 795-1900/? D/audio_hw_primary: disable_audio_route: usecase(5) reset and update mixer path: audio-ull-playback speaker
2018-11-16 11:50:22.330 811-811/? D/[email protected]: AUDIO LOW LATENCY OFF
2018-11-16 11:50:22.330 795-1900/? D/audio_hw_primary: disable_snd_device: snd_device(2: speaker)
2018-11-16 11:50:24.086 12740-12740/? E/ViewRootImpl[SignInActivity]: Attempting to destroy the window while drawing!
      window=android.view.ViewRootImpl@c68526f, title=com.google.android.play.games/com.google.android.gms.games.ui.signin.SignInActivity
2018-11-16 11:50:24.092 12740-12740/? I/SignInActivity: Transition from 0 to 1
2018-11-16 11:50:24.095 12740-12740/? I/SignInActivity: Transition from 1 to 3
2018-11-16 11:50:24.102 2584-3447/? W/GamesServiceBroker: Client connected with SDK 14768000, Services 14369037, and Games 74660040
2018-11-16 11:50:24.105 2584-11782/? W/GamesServiceBroker: Client connected with SDK 14768000, Services 14369037, and Games 74660040
2018-11-16 11:50:24.119 12740-12740/? I/SignInActivity: Transition from 3 to 4
2018-11-16 11:50:24.125 811-811/? D/[email protected]: LAUNCH OFF
2018-11-16 11:50:24.126 2584-3447/? W/GamesServiceBroker: Client connected with SDK 14768000, Services 14369037, and Games 74660040
2018-11-16 11:50:24.142 2444-2444/? W/ChimeraUtils: Non Chimera context
2018-11-16 11:50:24.142 2444-2444/? W/ChimeraUtils: Non Chimera context
2018-11-16 11:50:24.290 2584-6520/? W/Conscrypt: Could not set socket write timeout: java.net.SocketException: Socket closed
2018-11-16 11:50:24.291 2584-6520/? W/Conscrypt:     at com.google.android.gms.org.conscrypt.Platform.setSocketWriteTimeout(:com.google.android.gms@[email protected] (100400-217746893):2)
2018-11-16 11:50:24.291 2584-6520/? W/Conscrypt:     at com.google.android.gms.org.conscrypt.ConscryptFileDescriptorSocket.setSoWriteTimeout(:com.google.android.gms@[email protected] (100400-217746893):2)
2018-11-16 11:50:24.306 2584-6520/? W/Conscrypt: Could not set socket write timeout: java.net.SocketException: Socket closed
2018-11-16 11:50:24.306 2584-6520/? W/Conscrypt:     at com.google.android.gms.org.conscrypt.Platform.setSocketWriteTimeout(:com.google.android.gms@[email protected] (100400-217746893):2)
2018-11-16 11:50:24.306 2584-6520/? W/Conscrypt:     at com.google.android.gms.org.conscrypt.ConscryptFileDescriptorSocket.setSoWriteTimeout(:com.google.android.gms@[email protected] (100400-217746893):2)
2018-11-16 11:50:24.336 620-647/? W/SurfaceFlinger: Attempting to set client state on removed layer: com.google.android.play.games/com.google.android.gms.games.ui.signin.SignInActivity#1
2018-11-16 11:50:24.336 620-647/? W/SurfaceFlinger: Attempting to destroy on removed layer: com.google.android.play.games/com.google.android.gms.games.ui.signin.SignInActivity#1
2018-11-16 11:50:24.456 12740-12740/? I/SignInActivity: Transition from 4 to 5
2018-11-16 11:50:24.469 12740-12740/? I/SignInActivity: Transition from 5 to 6
2018-11-16 11:50:24.487 2584-11782/? W/GamesServiceBroker: Client connected with SDK 14768000, Services 14369037, and Games 74660040
2018-11-16 11:50:24.487 2584-3447/? W/GamesServiceBroker: Client connected with SDK 14768000, Services 14369037, and Games 74660040
2018-11-16 11:50:24.567 12740-12740/? I/SignInActivity: Transition from 6 to 11
2018-11-16 11:50:24.567 12740-12740/? W/SignInActivity: onSignInFailed()...
2018-11-16 11:50:24.567 12740-12740/? W/SignInActivity: Sign in failed during 6
2018-11-16 11:50:24.567 12740-12740/? W/SignInActivity: ==> Returning non-OK result: 10002
2018-11-16 11:50:24.571 12740-12740/? I/AppLifecycleTracker: onActivityPaused: 
2018-11-16 11:50:24.574 2584-11782/? W/GamesServiceBroker: Client connected with SDK 14768000, Services 14369037, and Games 74660040
2018-11-16 11:50:24.591 12708-12708/? W/AutoManageHelper: Unresolved error while connecting client. Stopping auto-manage.
2018-11-16 11:50:24.611 12708-12717/? W/System: A resource failed to call close. 
2018-11-16 11:50:24.657 12562-12562/? E/TokenFragment: Setting result error code to: 16
2018-11-16 11:50:24.657 12562-12562/? D/TokenPendingResult:  Calling onResult for callback: GooglePlayGames.Android.TokenResultCallback result: Status: Status{statusCode=CANCELED, resolution=null} email:  id: access: 
2018-11-16 11:50:24.658 12562-12562/? D/TokenFragment: onResume called
2018-11-16 11:50:24.669 1972-1972/? I/Elmyra/ElmyraService: Gated by NavigationBarVisibility [mIsNavigationHidden -> true; mExceptions -> [DismissTimer [mReceiverRegistered -> true], SnoozeAlarm [mReceiverRegistered -> true], SilenceCall [mSilenceSettingEnabled -> true], SettingsAction]]
2018-11-16 11:50:24.670 820-972/? D/CHRE: @ 640244.125: Parsed nanoapp message from host: app ID 0x476f6f676c00100e, endpoint 0x0, msgType 1, payload size 2
2018-11-16 11:50:24.670 820-972/? D/CHRE: @ 640244.125: [Elmyra] Recognizer start: 0
2018-11-16 11:50:24.675 1935-2494/? E/bt_btif: register_notification_rsp: Avrcp device is not connected, handle: 0x0
2018-11-16 11:50:24.675 1935-2494/? I/chatty: uid=1002(bluetooth) BluetoothAvrcpH identical 4 lines
2018-11-16 11:50:24.675 1935-2494/? E/bt_btif: register_notification_rsp: Avrcp device is not connected, handle: 0x0
2018-11-16 11:50:24.676 792-792/? W/AshmemAllocator: ashmem_create_region(7680) returning hidl_memory(0x769562c100, 7680)
2018-11-16 11:50:24.680 792-792/? W/AshmemAllocator: ashmem_create_region(7680) returning hidl_memory(0x769562c100, 7680)
2018-11-16 11:50:24.683 795-16675/? D/audio_hw_primary: enable_snd_device: snd_device(2: speaker)
2018-11-16 11:50:24.683 795-16675/? D/audio_route: Apply path: speaker
2018-11-16 11:50:24.684 811-811/? D/[email protected]: AUDIO STREAMING ON
2018-11-16 11:50:24.684 795-16675/? D/ACDB-LOADER: ACDB -> send_audio_cal, acdb_id = 15, path = 0, app id = 0x11130, sample rate = 48000
2018-11-16 11:50:24.684 795-16675/? D/ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_GAIN_DEP_STEP_TABLE, vol index 1
2018-11-16 11:50:24.684 795-16675/? E/ACDB-LOADER: Error: ACDB AudProc vol returned = -19
2018-11-16 11:50:24.684 795-16675/? D/ACDB-LOADER: ACDB -> GET_AFE_TOPOLOGY_ID for adcd_id 15, Topology Id 1025e
2018-11-16 11:50:24.684 795-16675/? D/audio_hw_primary: enable_audio_route: usecase(5) apply and update mixer path: audio-ull-playback speaker
2018-11-16 11:50:24.684 795-16675/? D/audio_route: Apply path: audio-ull-playback speaker
2018-11-16 11:50:24.688 1203-5855/? I/ActivityManager: Killing 11448:com.google.android.apps.translate/u0a153 (adj 906): empty #17
2018-11-16 11:50:24.688 1203-1246/? W/libprocessgroup: kill(-11448, 9) failed: No such process
2018-11-16 11:50:24.700 12740-12740/? I/AppLifecycleTracker: onActivityStopped: 
2018-11-16 11:50:24.704 795-16675/? D/audio_hw_primary: out_write: retry previous failed cal level set
2018-11-16 11:50:24.704 795-16675/? W/qc_adm: margin check: adm_request_focus_v2(p) failed diff -48
2018-11-16 11:50:24.704 795-16675/? W/qc_adm: margin check: adm_abandon_focus(p) failed diff -48
2018-11-16 11:50:24.704 811-811/? D/[email protected]: AUDIO STREAMING OFF
2018-11-16 11:50:24.704 811-811/? D/[email protected]: AUDIO LOW LATENCY ON
2018-11-16 11:50:24.705 1203-1246/? W/libprocessgroup: kill(-11448, 9) failed: No such process
2018-11-16 11:50:24.713 12740-12740/? I/AppLifecycleTracker: onActivityDestroyed: 
2018-11-16 11:50:24.725 786-786/? I/Zygote: Process 11448 exited due to signal (9)
2018-11-16 11:50:24.745 1203-1246/? W/libprocessgroup: kill(-11448, 9) failed: No such process
2018-11-16 11:50:24.745 1203-1246/? I/libprocessgroup: Successfully killed process cgroup uid 10153 pid 11448 in 57ms
2018-11-16 11:50:24.801 620-646/? W/SurfaceFlinger: Attempting to set client state on removed layer: com.google.android.gms/com.google.android.gms.auth.api.signin.ui.SignInActivity#0
2018-11-16 11:50:24.801 620-646/? W/SurfaceFlinger: Attempting to destroy on removed layer: com.google.android.gms/com.google.android.gms.auth.api.signin.ui.SignInActivity#0
2018-11-16 11:50:24.816 620-647/? W/SurfaceFlinger: Attempting to set client state on removed layer: Dim Layer for - Task=12081#0
2018-11-16 11:50:24.816 620-647/? W/SurfaceFlinger: Attempting to destroy on removed layer: Dim Layer for - Task=12081#0
2018-11-16 11:50:24.816 620-776/? W/SurfaceFlinger: Attempting to set client state on removed layer: Surface(name=Dim Layer for - Task=12081)/@0x4c55c41 - animation-leash#0
2018-11-16 11:50:24.816 620-776/? W/SurfaceFlinger: Attempting to destroy on removed layer: Surface(name=Dim Layer for - Task=12081)/@0x4c55c41 - animation-leash#0
2018-11-16 11:50:24.918 620-775/? W/SurfaceFlinger: Attempting to set client state on removed layer: com.zotest.zomobiletest/com.google.android.gms.auth.api.signin.internal.SignInHubActivity#0
2018-11-16 11:50:24.918 620-775/? W/SurfaceFlinger: Attempting to destroy on removed layer: com.zotest.zomobiletest/com.google.android.gms.auth.api.signin.internal.SignInHubActivity#0
2018-11-16 11:50:25.684 14737-14769/? I/Finsky: [5443] com.google.android.finsky.bp.an.run(6): Stats for Executor: Db-scheduler_logging_store.db com.google.android.finsky.bp.ao@e2e92d0[Running, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 10]

Of note, I believe, is the error result:

TokenPendingResult:  Calling onResult for callback: GooglePlayGames.Android.TokenResultCallback result: Status: Status{statusCode=CANCELED, resolution=null} email:  id: access:

And the non-OK result:

SignInActivity: ==> Returning non-OK result: 10002

But I'm not sure what I'm doing wrong. This worked once, so it can't be the hardware and it can't be the code. So it must be either my config or GPGS itself, but how do I find out which? I've tried starting from scratch a bunch of times. I'm super confident that I've set up my key and package correctly and configured it correctly in the Google Play Console. Does anyone have any advice? I've run the trouble shooting guides and gone through several tutorials. I'm also using the project code from the Minimal sample app, reconfigured with my own key, package name, etc.

[wivlaro]

Some of the error codes seem to get mixed up in this library.
You might be getting this one from here:

RESULT_SIGN_IN_FAILED
Result code sent back to the calling Activity when signing in fails.

The attempt to sign in to the Games service failed. For example, this might happen if the network is flaky, or the user's account has been disabled, or consent could not be obtained.

Constant Value: 10002

https://developers.google.com/android/reference/com/google/android/gms/games/GamesActivityResultCodes

[olehkuznetsov]

Have you checked all possible issues from http://developers.google.com/games/services/android/troubleshooting already?

[ZOSDanBatson]

Have you checked all possible issues from http://developers.google.com/games/services/android/troubleshooting already?

Yes, at the request of the Google rep I reached out to. Unfortunately everything in that guide seemed to be on the up and up. For more info, I'm doing this with a Unity project, so many of the files are generated automatically by Unity. But I've had it build the Android Studio project so I could dive more deeply into the files that got generated to see if they match the details mentioned in the troubleshoot guide, and they do.

[olehkuznetsov]

Can you check, please, if this cloud client is "272576419934-15i4rvp73stpjcppn1k543r0p1qh5e5m.apps.googleusercontent.com" web app and not an android app, please?
This is the one you've specified as web client id in Play Games Setup dialog window.
I saw couple of times already an usage of the android client instead of the web one.

[ZOSDanBatson]

It's supposed to be an Android app. I have no web components to my app.

I see what your pointing out, and if I remove that field from the config dialog and leave it blank (it does, after all, say "optional") I get this error instead:

ERROR: Server Auth Code and ID Token require web clientId to configured

[olehkuznetsov]

So, you need to leave it blank and you need to remove not needed options from PlayGamesClientConfiguration.Builder()

Probably you can remove
var config = new PlayGamesClientConfiguration.Builder()
.Build();
PlayGamesPlatform.InitializeInstance(config);
those lines at all in your code.

[ZOSDanBatson]

Unfortunately, I'm going to need more than that for the service I'm ultimately going to be interfacing with. I will need:

var config = new PlayGamesClientConfiguration.Builder().RequestServerAuthCode(false).RequestIdToken().Build();

[ZOSDanBatson]

The Google rep is trying to tell me that I have to upload an APK and start an Alpha test, but that doesn't make any sense to me. Also I tried that and it still didn't work. But at any rate, I don't want to publish the app or put it on the store, or make it available to the public. In order to upload the APK I had to fill out a Content Ratings questionnaire with meaningless answers, and upload a bunch of bogus temp textures I slapped together and write the word "Test" in a bunch of text fields. I started an "Internal Test" and now it says "Pending Publication." What is pending? Why do I need to wait to test my app? What if I need to make a change, do I need to upload a new APK? That'll bloat my dev turnaround time substantially. I can't imagine indie devs trying to set up their first app are spending that much time fighting with Google.

Shouldn't it be way easier to just run a simple proof of concept test on my own machine?

[olehkuznetsov]

RequestServerAuthCode(false).RequestIdToken()

For whose two you need to link web app in Games Console and set it as web client id in Play Games Setup Dialog. You can use any web url during web app linking it is not used currently.

There is no requirement to publish anything on Play Store to test PGS integration. Alpha and Internal Test are not required too.

[ZOSDanBatson]

There is no requirement to publish anything on Play Store to test PGS integration. Alpha and Internal Test are not required too.

That's what I figured as well. Thank you for confirming that.

For whose two you need to link web app in Games Console and set it as web client id in Play Games Setup Dialog. You can use any web url during web app linking it is not used currently.

That makes sense. And that's what I've done, but I still fail authentication. If I remove those two calls from Builder, I connect fine. But with those it fails 95% of the time.

[wivlaro]

FWIW I'm getting exactly the same thing at the moment. I have actually gone down a layer and am testing against the Google Play Games Android Java SDK. If I have requestIdToken in the builder, it always comes back with REQUIRE_SIGN_IN error code 4. Without it, it works fine, but I cannot then get the idToken to verify on the server that the user is who they say they are. So I suspect it's an issue lower down the stack.

I have been trying with and without request id/request id token/request profile/request server auth code. It seems to work without requestIdToken, but never with it.

[olehkuznetsov]

Check which client id do you provide in 'Web App Client ID' field.
It should be web client id not android client id. You should have linked web app in Google Play Console. Use that web app client id.

[ZOSDanBatson]

Oh I see what you're saying now, I will try that and get back to you! Thanks!

[wivlaro]

Oh my god. I had my "server" client id as an 'other' client id instead of a 'web' client id. They look basically the same. I have just seen it work for the first time the way it should with the idToken coming through. This has been such a painful experience. Hopefully that was it.

[ZOSDanBatson]

Okay I was finally able to get it to work. Thank you very much for the assist.

The Web Client ID was the right way to go. Once I got that properly configured it did the trick. The part that wasn't intuitive was the redirect_uri. For anyone running into the same problem because the Google API Console isn't super intuitive:

In the credentials section, under the Oauth consent screen tab, toward the bottom is an "Authorized domains" section. In order to add an Authorized domain, you need to type it into the box right below that says example.com. In my case, zotest.com.

Then, under the settings for the web client id credentials I created, there's a section called "Authorized redirect URIs." In there I added my fake URI. It was a URI in the zotest.com domain.

One bit that was very easy to get tripped up on when adding these in. Once you type into one of those boxes the domain/URI you want, click outside the box. It should add it to a readonly list right above the box with a trash can icon. if you don't see it do that, click back into the edit box and back out of the edit box to get it to refresh. Once it registers, don't forget to hit Save. It does not auto save.

[olehkuznetsov]

Thank you for update.

[ivribalko]

To clarify: you have to create a new app of type Web (yours is likely an Android-type one) in your Linked apps in Google Play Console, specify whatever url for it (it's not used) and provide its OAuth2 Client ID for the web app client id field in Window → Google Play Game Services → Android setup.

[piyushCloudcade]

@whitepyjamas Hi ,
I am facing the exact same issue. Can u please elaborate on the issue? I cannot find any Linked apps option in Google play console

[ivribalko]

@whitepyjamas Hi ,
I am facing the exact same issue. Can u please elaborate on the issue? I cannot find any Linked apps option in Google play console

@piyushCloudcade Hi! It is mentioned in the docs regarding setting up GPGS. Find it in classic Console view mode under Game services -> Select your app -> Linked apps (screenshot).