Search Unity

IAP 1.23 AppNotKnown

Discussion in 'Unity IAP' started by justtime, Oct 22, 2019.

  1. justtime

    justtime

    Joined:
    Oct 6, 2013
    Posts:
    424
    Hi there! In my firebase crashlytics console i got a bunch of IAP OnInitializeFailed errors.
    70% of them AppNotKnown, and other PurchasingUnavailable ? On my several test devices it works fine, and this happens not with all users. How could i find source of this issues?
     
    justtime, Oct 22, 2019
    #1

  2. SamOYUnity3D

    SamOYUnity3D

    Unity Technologies

    Joined:
    May 12, 2019
    Posts:
    626
    Do you know the area where these errors occurred? In some areas people cannot access Google Stores (such as China), which can cause initialization failures, which may be the cause of the problem.
     
    SamOYUnity3D, Oct 22, 2019
    #2

  3. JeffDUnity3D

    JeffDUnity3D

    Joined:
    May 2, 2017
    Posts:
    14,446
    AppNotKnown is the new error return which means there is a problem with the Google user account. I am able to reproduce by changing my Google password online on my PC, but not yet on an unlocked (no password or swipe login) Android device and try to initialize IAP. When you get this return code, you'll want to pop up a dialog and tell the user to check their account on Google Play on the device.
     
    JeffDUnity3D, Oct 22, 2019
    #3
    justtime likes this.

  4. JeffDUnity3D

    JeffDUnity3D

    Joined:
    May 2, 2017
    Posts:
    14,446
    If can find any pattern of device types and/or OS versions in the crash reports, please let us know.
     
    JeffDUnity3D, Oct 22, 2019
    #4

  5. justtime

    justtime

    Joined:
    Oct 6, 2013
    Posts:
    424
    Hi there! I've found another issues.
    I have 2 app versions: free and paid with same functionality. They are the same, except package name of course.
    Before upgrading to the new IAP version all worked fine. Today i prepared new paid version for store, and while testing on my developer device, got two issues. I login on my phone(pixel 3a, android 10) with google play console account as always
    1)Without internet. On startup it shows AppNotKnown. Error stack
    2)With internet. It starts without any errors, but on purchase attempt it shows
    Code (CSharp):
    1. 10.25 17:06:49.824 1294 1858 Error Unity: Invalid receipt, not unlocking content. UnityEngine.Purchasing.Security.InvalidSignatureException: Exception of type 'UnityEngine.Purchasing.Security.InvalidSignatureException' was thrown.
    2. 10.25 17:06:49.824 1294 1858 Error Unity:   at UnityEngine.Purchasing.Security.GooglePlayValidator.Validate (System.String receipt, System.String signature) [0x00000] in <00000000000000000000000000000000>:0
    3. 10.25 17:06:49.824 1294 1858 Error Unity:   at UnityEngine.Purchasing.Security.CrossPlatformValidator.Validate (System.String unityIAPReceipt) [0x00000] in <00000000000000000000000000000000>:0
    4. 10.25 17:06:49.824 1294 1858 Error Unity:   at Purchaser.ProcessPurchase (UnityEngine.Purchasing.PurchaseEventArgs args) [0x00000] in <00000000000000000000000000000000>:0
    5. 10.25 17:06:49.824 1294 1858 Error Unity:   at UnityEngine.Purchasing.PurchasingManager.ProcessPurchaseIfNew (UnityEngine.Purchasing.Product product) [0x00000] in <00000000000000000000000000000000>:0
    6. 10.25 17:06:49.824 1294 1858 Error Unity:   at UnityEngine.Purchasing.JSONStore.OnPurchaseSucceeded (System.String id, System.String receipt, System.String transactionID) [0x00000] in <00000000000000000000000000000000>:0
    7. 10.25 17:06:49.824 1294 1858 Error Unity:   at UnityEngine.Purchasing.ScriptingUnityCallb
    8.  
    Full errors stack

    I have never faced with these issues before IAP update.
     
    Last edited: Oct 25, 2019
    justtime, Oct 25, 2019
    #5

  6. JeffDUnity3D

    JeffDUnity3D

    Joined:
    May 2, 2017
    Posts:
    14,446
    AppNotKnown would likely be expected in this case, you'll want to put up a dialog to the user to check their account on Google Play on the device (which naturally requires Internet access). You'll want to catch the exception, was this on an actual credit card purchase? Is the receipt non null?
     
    JeffDUnity3D, Oct 25, 2019
    #6

  7. justtime

    justtime

    Joined:
    Oct 6, 2013
    Posts:
    424
    It was on my google console developer account(email). With free app it works(though, this error can flash sometimes, but after it replaced with successful initialization and works). Also, on free app i don't see any errors without connection. Problem with another app with same code, but different package name(on the same account with same IAP items names).
    Talking about purchases... so it's test device, i don't know why receipt is invalid. If i close app, and start again(with connection), it unlocks items, purchased before(with receipt error) without any errors.
    And this is only happens on the new IAP version.
     
    justtime, Oct 25, 2019
    #7

  8. JeffDUnity3D

    JeffDUnity3D

    Joined:
    May 2, 2017
    Posts:
    14,446
    Please provide specific steps to reproduce. Is the receipt null, are you checking first? Please show the code you are using.
     
    JeffDUnity3D, Oct 25, 2019
    #8

  9. PlanarBit

    PlanarBit

    Joined:
    Jul 22, 2016
    Posts:
    20
    After upgrading to 1.23 I started getting IStoreListener.OnInitializeFailed() callback with AppNotKnown.
    This happens when I start the game on Android without internet access. And IAP 1.23 doesn't initialize even if internet is turned on afterwards.
    In the same situation IAP 1.22 was retrying in background, instead of failing with unrecoverable error.
     
    PlanarBit, Oct 31, 2019
    #9

  10. JeffDUnity3D

    JeffDUnity3D

    Joined:
    May 2, 2017
    Posts:
    14,446
    Please see my previous post. If you receive this error, you want to alert the user to check Google Play on their device.
     
    JeffDUnity3D, Oct 31, 2019
    #10

  11. justtime

    justtime

    Joined:
    Oct 6, 2013
    Posts:
    424
    HI Jeff! But what if we have this error on test device with properly installed and enabled Google Play? I also have this error ONLY when phone has not connection. What code should i send to you?
     
    justtime, Nov 5, 2019
    #11

  12. justtime

    justtime

    Joined:
    Oct 6, 2013
    Posts:
    424
    Here errors stack on trying to buy item operation. You can find here

    Code (CSharp):
    1. 01.01 00:00:00.000 -1 -1 Info : --------- beginning of main
    2. 11.05 16:05:58.181 26300 26525 Info FrameStatistics: == Frame st
    3. [code=CSharp]11.05 16:06:22.373 26300 26372 Debug Unity: error Exception of type 'UnityEngine.Purchasing.Security.InvalidSignatureException' was thrown.
    4.  
    Full
    Code (csharp):
    1. Satistics ==
    2. 11.05 16:05:58.181 26300 26525 Info FrameStatistics: total frames: 6745
    3. 11.05 16:05:58.181 26300 26525 Info FrameStatistics: Buckets:                        [0]    [1]    [2]    [3]    [4]    [5]
    4. 11.05 16:05:58.181 26300 26525 Info FrameStatistics: idle frames:                     6741     2     0     0     0     0
    5. 11.05 16:05:58.181 26300 26525 Info FrameStatistics: late frames:                     6686     17     13     9     6     5
    6. 11.05 16:05:58.181 26300 26525 Info FrameStatistics: offset from previous frame:      687     6035     11     6     3     1
    7. 11.05 16:05:58.181 26300 26525 Info FrameStatistics: frame latency:                   11     0     6689     31     5     6
    8. 11.05 16:05:59.151 26300 26372 Info Unity: Purchasing product asychronously: ballads_v_4
    9. 11.05 16:05:59.151 26300 26372 Info Unity: UnityEngine.DebugLogHandler:LogFormat(LogType, Object, String, Object[])
    10. 11.05 16:05:59.151 26300 26372 Info Unity: UnityEngine.Logger:Log(LogType, Object)
    11. 11.05 16:05:59.151 26300 26372 Info Unity: UnityEngine.Debug:Log(Object)
    12. 11.05 16:05:59.151 26300 26372 Info Unity: Purchaser:BuyProductID(String)
    13. 11.05 16:05:59.151 26300 26372 Info Unity: JamPacksViewsHolder:OnBuyButtonClick()
    14. 11.05 16:05:59.151 26300 26372 Info Unity: UnityEngine.Events.UnityAction:Invoke()
    15. 11.05 16:05:59.151 26300 26372 Info Unity: UnityEngine.Events.InvokableCall:Invoke()
    16. 11.05 16:05:59.151 26300 26372 Info Unity: UnityEngine.Events.UnityEvent:Invoke()
    17. 11.05 16:05:59.151 26300 26372 Info Unity: UnityEngine.UI.Button:press()
    18. 11.05 16:05:59.151 26300 26372 Info Unity: UnityEngine.UI.Button:OnPointerClick(PointerEventData)
    19. 11.05 16:05:59.151 26300 26372 Info Unity: UnityEngine.EventSystems.ExecuteEvents:Execute(IPointerClickHandler, BaseEventData)
    20. 11.05 16:05:59.151 26300 26372 Info Unity: UnityEngine.EventSystems.EventFunction`1:Invoke(T1, BaseEventData)
    21. 11.05 16:05:59.151 26300 26372 Info Unity: UnityEngine.EventSystems.ExecuteEvents:Execute(GameObject, BaseEventData, EventFunction`1)
    22. 11.05 16:05:59.151 26300 26372 Info Unity: UnityEngine.EventSystems.StandaloneInputModule:processTouchPress(PointerEventData, Boolean, Boolean)
    23. 11.05 16:05:59.151 26300 26372 Info Unity: UnityEngine.EventSystems.StandaloneInputModule:processTouchEvents()
    24. 11.05 16:05:59.151 26300 26372 Info Unity: UnityEngine.EventSystems.StandaloneInputModule:process()
    25. 11.05 16:05:59.151 26300 26372 Info Unity: UnityEngine.EventSystems.EventSystem:Update()
    26. 11.05 16:05:59.151 26300 26372 Info Unity:
    27. 11.05 16:05:59.151 26300 26372 Info Unity: (Filename: ./Runtime/Export/Debug/Debug.bi
    28. 11.05 16:05:59.152 26300 26372 Info UnityIAP: isUnityVrEnabled = false
    29. 11.05 16:05:59.154 26300 26372 Info UnityIAP: onPurchaseProduct: ballads_v_4
    30. 11.05 16:05:59.154 26300 26372 Info UnityIAP: ITEM TYPE:inapp
    31. 01.01 00:00:00.000 -1 -1 Info : --------- beginning of system
    32. 11.05 16:05:59.162 26300 26300 Info Unity: onPause
    33. 11.05 16:05:59.163 26300 26372 Info Unity: purchase({0}): ballads_v_4
    34. 11.05 16:05:59.163 26300 26372 Info Unity: UnityEngine.DebugLogHandler:LogFormat(LogType, Object, String, Object[])
    35. 11.05 16:05:59.163 26300 26372 Info Unity: UnityEngine.Logger:Log(String, Object)
    36. 11.05 16:05:59.163 26300 26372 Info Unity: Purchaser:BuyProductID(String)
    37. 11.05 16:05:59.163 26300 26372 Info Unity: JamPacksViewsHolder:OnBuyButtonClick()
    38. 11.05 16:05:59.163 26300 26372 Info Unity: UnityEngine.Events.UnityAction:Invoke()
    39. 11.05 16:05:59.163 26300 26372 Info Unity: UnityEngine.Events.InvokableCall:Invoke()
    40. 11.05 16:05:59.163 26300 26372 Info Unity: UnityEngine.Events.UnityEvent:Invoke()
    41. 11.05 16:05:59.163 26300 26372 Info Unity: UnityEngine.UI.Button:press()
    42. 11.05 16:05:59.163 26300 26372 Info Unity: UnityEngine.UI.Button:OnPointerClick(PointerEventData)
    43. 11.05 16:05:59.163 26300 26372 Info Unity: UnityEngine.EventSystems.ExecuteEvents:Execute(IPointerClickHandler, BaseEventData)
    44. 11.05 16:05:59.163 26300 26372 Info Unity: UnityEngine.EventSystems.EventFunction`1:Invoke(T1, BaseEventData)
    45. 11.05 16:05:59.163 26300 26372 Info Unity: UnityEngine.EventSystems.ExecuteEvents:Execute(GameObject, BaseEventData, EventFunction`1)
    46. 11.05 16:05:59.163 26300 26372 Info Unity: UnityEngine.EventSystems.StandaloneInputModule:processTouchPress(PointerEventData, Boolean, Boolean)
    47. 11.05 16:05:59.163 26300 26372 Info Unity: UnityEngine.EventSystems.StandaloneInputModule:processTouchEvents()
    48. 11.05 16:05:59.163 26300 26372 Info Unity: UnityEngine.EventSystems.StandaloneInputModule:process()
    49. 11.05 16:05:59.163 26300 26372 Info Unity: UnityEngine.EventSystems.EventSystem:Update()
    50. 11.05 16:05:59.163 26300 26372 Info Unity:
    51. 11.05 16:05:59.163 26300 26372 Info Unity: (Filename: ./Runtime/Export/Debug/Debug.bindings.h Line: 35)
    52. 11.05 16:05:59.163 26300 26372 Info Unity:
    53. 11.05 16:05:59.185 26300 26372 Info Unity: UserSettingsManager OnApplicationPause pauseStatus = True
    54. 11.05 16:05:59.185 26300 26372 Info Unity: UnityEngine.DebugLogHandler:LogFormat(LogType, Object, String, Object[])
    55. 11.05 16:05:59.185 26300 26372 Info Unity: UnityEngine.Logger:Log(LogType, Object)
    56. 11.05 16:05:59.185 26300 26372 Info Unity: UnityEngine.Debug:Log(Object)
    57. 11.05 16:05:59.185 26300 26372 Info Unity: UserSettingsManager:OnApplicationPause(Boolean)
    58. 11.05 16:05:59.185 26300 26372 Info Unity:
    59. 11.05 16:05:59.185 26300 26372 Info Unity: (Filename: ./Runtime/Export/Debug/Debug.bindings.h Line: 35)
    60. 11.05 16:05:59.185 26300 26372 Info Unity:
    61. 11.05 16:05:59.187 26300 26372 Info Unity: CommonSettings SaveVars
    62. 11.05 16:05:59.187 26300 26372 Info Unity: UnityEngine.DebugLogHandler:LogFormat(LogType, Object, String, Object[])
    63. 11.05 16:05:59.187 26300 26372 Info Unity: UnityEngine.Logger:Log(LogType, Object)
    64. 11.05 16:05:59.187 26300 26372 Info Unity: UnityEngine.Debug:Log(Object)
    65. 11.05 16:05:59.187 26300 26372 Info Unity: CommonSettings:SaveVars()
    66. 11.05 16:05:59.187 26300 26372 Info Unity: UnityEngine.Events.UnityAction:Invoke()
    67. 11.05 16:05:59.187 26300 26372 Info Unity: UnityEngine.Events.InvokableCall:Invoke()
    68. 11.05 16:05:59.187 26300 26372 Info Unity: UnityEngine.Events.UnityEvent:Invoke()
    69. 11.05 16:05:59.187 26300 26372 Info Unity: UserSettingsManager:OnApplicationPause(Boolean)
    70. 11.05 16:05:59.187 26300 26372 Info Unity:
    71. 11.05 16:05:59.187 26300 26372 Info Unity: (Filename: ./Runtime/Export/Debug/Debug.bindings.h Line: 35)
    72. 11.05 16:05:59.187 26300 26372 Info Unity:
    73. 11.05 16:05:59.235 26300 26372 Info Unity: UserSettingsManager SyncEs3File
    74. 11.05 16:05:59.235 26300 26372 Info Unity: UnityEngine.DebugLogHandler:LogFormat(LogType, Object, String, Object[])
    75. 11.05 16:05:59.235 26300 26372 Info Unity: UnityEngine.Logger:Log(LogType, Object)
    76. 11.05 16:05:59.235 26300 26372 Info Unity: UnityEngine.Debug:Log(Object)
    77. 11.05 16:05:59.235 26300 26372 Info Unity: UserSettingsManager:SyncEs3File()
    78. 11.05 16:05:59.235 26300 26372 Info Unity: UserSettingsManager:OnApplicationPause(Boolean)
    79. 11.05 16:05:59.235 26300 26372 Info Unity:
    80. 11.05 16:05:59.235 26300 26372 Info Unity: (Filename: ./Runtime/Export/Debug/Debug.bindings.h Line: 35)
    81. 11.05 16:05:59.235 26300 26372 Info Unity:
    82. 11.05 16:05:59.316 26300 26372 Debug Unity: Sensor :        Accelerometer ( 1) ; 0.004791 / 0.00s ; BMI160 Accelerometer / BOSCH
    83. 11.05 16:05:59.323 26300 26300 Warn ActivityThread: handleWindowVisibility: no activity for token android.os.BinderProxy@10cb592
    84. 11.05 16:05:59.341 26300 26300 Info UnityIAP: Creating purchase activity
    85. 11.05 16:05:59.342 26300 26300 Info UnityIAP: oldSkuMetadata is null
    86. 11.05 16:05:59.345 26300 26579 Info UnityIAP: invoking callback
    87. 11.05 16:05:59.345 26300 26579 Info UnityIAP: Constructing buy intent for ballads_v_4, item type: inapp
    88. 11.05 16:05:59.363 26300 26579 Info UnityIAP: Launching buy intent for ballads_v_4. Request code: 999
    89. 11.05 16:05:59.424 26300 26300 Info Unity: windowFocusChanged: false
    90. 11.05 16:06:22.238 26300 26300 Info UnityIAP: onActivityResult
    91. 11.05 16:06:22.238 26300 26300 Info UnityIAP: Purchase data: {"orderId":"GPA.3382-5100-2909-89209","packageName":"com.teq.guitarjampro","productId":"ballads_v_4","purchaseTime":1572962779366,"purchaseState":0,"developerPayload":"{\"developerPayload\":\"\",\"is_free_trial\":false,\"has_introductory_price_trial\":false,\"is_updated\":false,\"accountId\":\"\"}","purchaseToken":"iioehaomeiehpjpabplcckde.AO-J1Ox7hjhAM8SaU14HHzBzXvL9R8w880jihGVmh8MD_jwWOjYm3EDu9EZBxRIq9RrqZtu3x58YEet8-S9QyBb-cQkuNC1lF7LDs27PdLF7mDfvfAQJmHWfZqCfyIQ54QLL50UPA37q"}
    92. 11.05 16:06:22.239 26300 26300 Info UnityIAP: Data signature: fNuLeb7e3dDq9n3suQolifBOLX33OiXwcckTCQz869tdeTe0UMvWk5D7v3NiXMFOoskxtHEPBZgkYRNohHbTGUfqcULeLd7uUGbKvTTgB2KOLz8srw8kUsd63LqxDSp5v8PxkXW6KwwdBXD+iGyGFTMi809L2zW/5LScHDrz/hvdQADARwGySHAxnXtGAwQ3g3O9Z6RU1Pau/wkV3xPmbJw+UIoiTDJZkR7u3VCAwHkKewuKpTAwN+L2Gx4BoVmJ6ENX5DRS8gnid6tvt7TVxL1cULP6PQi5T0pz3YxKySfqVIBxVRIMbjnhVhYXfaSgu86wQY7NM43AfHAi/PuiGg==
    93. 11.05 16:06:22.239 26300 26300 Info UnityIAP: Successful resultcode from purchase activity.
    94. 11.05 16:06:22.239 26300 26300 Info UnityIAP: Purchase data: {"orderId":"GPA.3382-5100-2909-89209","packageName":"com.teq.guitarjampro","productId":"ballads_v_4","purchaseTime":1572962779366,"purchaseState":0,"developerPayload":"{\"developerPayload\":\"\",\"is_free_trial\":false,\"has_introductory_price_trial\":false,\"is_updated\":false,\"accountId\":\"\"}","purchaseToken":"iioehaomeiehpjpabplcckde.AO-J1Ox7hjhAM8SaU14HHzBzXvL9R8w880jihGVmh8MD_jwWOjYm3EDu9EZBxRIq9RrqZtu3x58YEet8-S9QyBb-cQkuNC1lF7LDs27PdLF7mDfvfAQJmHWfZqCfyIQ54QLL50UPA37q"}
    95. 11.05 16:06:22.239 26300 26300 Info UnityIAP: Data signature: fNuLeb7e3dDq9n3suQolifBOLX33OiXwcckTCQz869tdeTe0UMvWk5D7v3NiXMFOoskxtHEPBZgkYRNohHbTGUfqcULeLd7uUGbKvTTgB2KOLz8srw8kUsd63LqxDSp5v8PxkXW6KwwdBXD+iGyGFTMi809L2zW/5LScHDrz/hvdQADARwGySHAxnXtGAwQ3g3O9Z6RU1Pau/wkV3xPmbJw+UIoiTDJZkR7u3VCAwHkKewuKpTAwN+L2Gx4BoVmJ6ENX5DRS8gnid6tvt7TVxL1cULP6PQi5T0pz3YxKySfqVIBxVRIMbjnhVhYXfaSgu86wQY7NM43AfHAi/PuiGg==
    96. 11.05 16:06:22.239 26300 26300 Info UnityIAP: Extras: Bundle[{INAPP_PURCHASE_DATA={"orderId":"GPA.3382-5100-2909-89209","packageName":"com.teq.guitarjampro","productId":"ballads_v_4","purchaseTime":1572962779366,"purchaseState":0,"developerPayload":"{\"developerPayload\":\"\",\"is_free_trial\":false,\"has_introductory_price_trial\":false,\"is_updated\":false,\"accountId\":\"\"}","purchaseToken":"iioehaomeiehpjpabplcckde.AO-J1Ox7hjhAM8SaU14HHzBzXvL9R8w880jihGVmh8MD_jwWOjYm3EDu9EZBxRIq9RrqZtu3x58YEet8-S9QyBb-cQkuNC1lF7LDs27PdLF7mDfvfAQJmHWfZqCfyIQ54QLL50UPA37q"}, INAPP_DATA_SIGNATURE=fNuLeb7e3dDq9n3suQolifBOLX33OiXwcckTCQz869tdeTe0UMvWk5D7v3NiXMFOoskxtHEPBZgkYRNohHbTGUfqcULeLd7uUGbKvTTgB2KOLz8srw8kUsd63LqxDSp5v8PxkXW6KwwdBXD+iGyGFTMi809L2zW/5LScHDrz/hvdQADARwGySHAxnXtGAwQ3g3O9Z6RU1Pau/wkV3xPmbJw+UIoiTDJZkR7u3VCAwHkKewuKpTAwN+L2Gx4BoVmJ6ENX5DRS8gnid6tvt7TVxL1cULP6PQi5T0pz3YxKySfqVIBxVRIMbjnhVhYXfaSgu86wQY7NM43AfHAi/PuiGg==, RESPONSE_CODE=0}]
    97. 11.05 16:06:22.239 26300 26300 Info UnityIAP: Expected item type: inapp
    98. 11.05 16:06:22.240 26300 26300 Info UnityIAP: onIabPurchaseFinished: true
    99. 11.05 16:06:22.240 26300 26300 Info UnityIAP: Success (response: 0:OK)
    100. 11.05 16:06:22.240 26300 26300 Info UnityIAP: Product purchased successfully!
    101. 11.05 16:06:22.241 26300 26300 Info UnityIAP: NotifyUnityOfPurchase
    102. 11.05 16:06:22.291 26300 26300 Info Unity: onResume
    103. 11.05 16:06:22.306 26300 26300 Info Unity: windowFocusChanged: true
    104. 11.05 16:06:22.330 26300 26372 Debug Unity: Sensor :        Accelerometer ( 1) ; 0.004791 / 0.00s ; BMI160 Accelerometer / BOSCH
    105. 11.05 16:06:22.330 26300 26372 Debug Unity: Choreographer available: Enabling VSYNC timing
    106. 11.05 16:06:22.351 26300 26372 Info Unity: UserSettingsManager OnApplicationPause pauseStatus = False
    107. 11.05 16:06:22.351 26300 26372 Info Unity: UnityEngine.DebugLogHandler:LogFormat(LogType, Object, String, Object[])
    108. 11.05 16:06:22.351 26300 26372 Info Unity: UnityEngine.Logger:Log(LogType, Object)
    109. 11.05 16:06:22.351 26300 26372 Info Unity: UnityEngine.Debug:Log(Object)
    110. 11.05 16:06:22.351 26300 26372 Info Unity: UserSettingsManager:OnApplicationPause(Boolean)
    111. 11.05 16:06:22.351 26300 26372 Info Unity:
    112. 11.05 16:06:22.351 26300 26372 Info Unity: (Filename: ./Runtime/Export/Debug/Debug.bindings.h Line: 35)
    113. 11.05 16:06:22.351 26300 26372 Info Unity:
    114. 11.05 16:06:22.373 26300 26372 Error Unity: Invalid receipt, not unlocking content. UnityEngine.Purchasing.Security.InvalidSignatureException: Exception of type 'UnityEngine.Purchasing.Security.InvalidSignatureException' was thrown.
    115. 11.05 16:06:22.373 26300 26372 Error Unity:   at UnityEngine.Purchasing.Security.GooglePlayValidator.Validate (System.String receipt, System.String signature) [0x00000] in <00000000000000000000000000000000>:0
    116. 11.05 16:06:22.373 26300 26372 Error Unity:   at UnityEngine.Purchasing.Security.CrossPlatformValidator.Validate (System.String unityIAPReceipt) [0x00000] in <00000000000000000000000000000000>:0
    117. 11.05 16:06:22.373 26300 26372 Error Unity:   at Purchaser.ProcessPurchase (UnityEngine.Purchasing.PurchaseEventArgs args) [0x00000] in <00000000000000000000000000000000>:0
    118. 11.05 16:06:22.373 26300 26372 Error Unity:   at UnityEngine.Purchasing.PurchasingManager.ProcessPurchaseIfNew (UnityEngine.Purchasing.Product product) [0x00000] in <00000000000000000000000000000000>:0
    119. 11.05 16:06:22.373 26300 26372 Error Unity:   at UnityEngine.Purchasing.JSONStore.OnPurchaseSucceeded (System.String id, System.String receipt, System.String transactionID) [0x00000] in <00000000000000000000000000000000>:0
    120. 11.05 16:06:22.373 26300 26372 Error Unity:   at UnityEngine.Purchasing.ScriptingUnityCallb
    121. 11.05 16:06:22.373 26300 26372 Debug Unity: error Exception of type 'UnityEngine.Purchasing.Security.InvalidSignatureException' was thrown.
    122. 11.05 16:06:22.375 26300 26372 Info UnityIAP: Finish transaction:GPA.3382-5100-2909-89209
    123. 11.05 16:06:22.381 26300 26372 Info Unity: UnityIAP: Promo interface is available for 35 items
    124. 11.05 16:06:22.381 26300 26372 Info Unity: UnityEngine.DebugLogHandler:LogFormat(LogType, Object, String, Object[])
    125. 11.05 16:06:22.381 26300 26372 Info Unity: UnityEngine.Logger:Log(Object)
    126. 11.05 16:06:22.381 26300 26372 Info Unity: UnityEngine.Purchasing.Promo:provideProductsToAds(HashSet`1)
    127. 11.05 16:06:22.381 26300 26372 Info Unity: UnityEngine.Purchasing.JSONStore:OnPurchaseSucceeded(String, String, String)
    128. 11.05 16:06:22.381 26300 26372 Info Unity: UnityEngine.Purchasing.<>c__DisplayClass5_0:<OnPurchaseSucceeded>b__0()
    129. 11.05 16:06:22.381 26300 26372 Info Unity: System.Action:Invoke()
    130. 11.05 16:06:22.381 26300 26372 Info Unity: UnityEngine.Purchasing.Extension.UnityUtil:Update()
    131. 11.05 16:06:22.381 26300 26372 Info Unity:
    132. 11.05 16:06:22.381 26300 26372 Info Unity: (Filename: ./Runtime/Export/Debug/Debug.bindings.h Line: 35)
    133. 11.05 16:06:22.381 26300 26372 Info Unity:
    134. 11.05 16:06:22.395 26300 26525 Info FrameStatistics: == Frame statistics ==
    135. 11.05 16:06:22.396 26300 26525 Info FrameStatistics: total frames: 6803
    136. 11.05 16:06:22.396 26300 26525 Info FrameStatistics: Buckets:                        [0]    [1]    [2]    [3]    [4]    [5]
    137. 11.05 16:06:22.396 26300 26525 Info FrameStatistics: idle frames:                     6799     2     0     0     0     0
    138. 11.05 16:06:22.396 26300 26525 Info FrameStatistics: late frames:                     6741     17     14     10     7     5
    139. 11.05 16:06:22.396 26300 26525 Info FrameStatistics: offset from previous frame:      700     6079     12     6     3     1
    140. 11.05 16:06:22.396 26300 26525 Info FrameStatistics: frame latency:                   11     0     6745     33     5     6
    141. 11.05 16:06:23.404 26300 26525 Info FrameStatistics: == Frame statistics ==
    142. 11.05 16:06:23.404 26300 26525 Info FrameStatistics: total frames: 6862
    143. 11.05 16:06:23.404 26300 26525 Info FrameStatistics: Buckets:                        [0]    [1]    [2]    [3]    [4]    [5]
    144. 11.05 16:06:23.404 26300 26525 Info FrameStatistics: idle frames:                     6858     2     0     0     0     0
    145. 11.05 16:06:23.404 26300 26525 Info FrameStatistics: late frames:                     6796     17     14     10     7     6
    146. 11.05 16:06:23.404 26300 26525 Info FrameStatistics: offset from previous frame:      711     6128     12     7     3     1
    147. 11.05 16:06:23.404 26300 26525 Info FrameStatistics: frame latency:                   12     0     6801     34     6     6
    148. 11.05 16:06:24.407 26300 26525 Info FrameStatistics: == Frame statistics ==
    149. 11.05 16:06:24.407 26300 26525 Info FrameStatistics: total frames: 6922
    150. 11.05 16:06:24.407 26300 26525 Info FrameStatistics: Buckets:                        [0]    [1]    [2]    [3]    [4]    [5]
    151. 11.05 16:06:24.407 26300 26525 Info FrameStatistics: idle frames:                     6918     2     0     0     0     0
    152. 11.05 16:06:24.407 26300 26525 Info FrameStatistics: late frames:                     6856     17     14     10     7     6
    153. 11.05 16:06:24.407 26300 26525 Info FrameStatistics: offset from previous frame:      724     6175     12     7     3     1
    154. 11.05 16:06:24.407 26300 26525 Info FrameStatistics: frame latency:                   12     0     6861     34     6     6
    155. 11.05 16:06:25.410 26300 26525 Info FrameStatistics: == Frame statistics ==
    156. 11.05 16:06:25.410 26300 26525 Info FrameStatistics: total frames: 6982
    157. 11.05 16:06:25.410 26300 26525 Info FrameStatistics: Buckets:                        [0]    [1]    [2]    [3]    [4]    [5]
    158. 11.05 16:06:25.410 26300 26525 Info FrameStatistics: idle frames:                     6978     2     0     0     0     0
    159. 11.05 16:06:25.410 26300 26525 Info FrameStatistics: late frames:                     6916     17     14     10     7     6
    160. 11.05 16:06:25.410 26300 26525 Info FrameStatistics: offset from previous frame:      731     6228     12     7     3     1
    161. 11.05 16:06:25.410 26300 26525 Info FrameStatistics: frame latency:                   12     0     6921     34     6     6
    162. 11.05 16:06:26.414 26300 26525 Info FrameStatistics: == Frame statistics ==
    163. 11.05 16:06:26.414 26300 26525 Info FrameStatistics: total frames: 7042
    164. 11.05 16:06:26.414 26300 26525 Info FrameStatistics: Buckets:                        [0]    [1]    [2]    [3]    [4]    [5]
    165. 11.05 16:06:26.414 26300 26525 Info FrameStatistics: idle frames:                     7038     2     0     0     0     0
    166. 11.05 16:06:26.414 26300 26525 Info FrameStatistics: late frames:                     6976     17     14     10     7     6
    167. 11.05 16:06:26.414 26300 26525 Info FrameStatistics: offset from previous frame:      732     6287     12     7     3     1
    168. 11.05 16:06:26.414 26300 26525 Info FrameStatistics: frame latency:                   12     0     6981     34     6     6
    169. 11.05 16:06:27.416 26300 26525 Info FrameStatistics: == Frame statistics ==
    170. 11.05 16:06:27.417 26300 26525 Info FrameStatistics: total frames: 7102
    171. 11.05 16:06:27.417 26300 26525 Info FrameStatistics: Buckets:                        [0]    [1]    [2]    [3]    [4]    [5]
    172. 11.05 16:06:27.417 26300 26525 Info FrameStatistics: idle frames:                     7098     2     0     0     0     0
    173. 11.05 16:06:27.417 26300 26525 Info FrameStatistics: late frames:                     7036     17     14     10     7     6
    174. 11.05 16:06:27.417 26300 26525 Info FrameStatistics: offset from previous frame:      737     6342     12     7     3     1
    175. 11.05 16:06:27.417 26300 26525 Info FrameStatistics: frame latency:                   12     0     7041     34     6     6
    176. 11.05 16:06:28.418 26300 26525 Info FrameStatistics: == Frame statistics ==
    177. 11.05 16:06:28.419 26300 26525 Info FrameStatistics: total frames: 7162
    178. 11.05 16:06:28.419 26300 26525 Info FrameStatistics: Buckets:                        [0]    [1]    [2]    [3]    [4]    [5]
    179. 11.05 16:06:28.419 26300 26525 Info FrameStatistics: idle frames:                     7158     2     0     0     0     0
    180. 11.05 16:06:28.419 26300 26525 Info FrameStatistics: late frames:                     7096     17     14     10     7     6
    181. 11.05 16:06:28.419 26300 26525 Info FrameStatistics: offset from previous frame:      741     6398     12     7     3     1
    182. 11.05 16:06:28.419 26300 26525 Info FrameStatistics: frame latency:                   12     0     7101     34     6     6
    183. 11.05 16:06:29.421 26300 26525 Info FrameStatistics: == Frame statistics ==
    184. 11.05 16:06:29.421 26300 26525 Info FrameStatistics: total frames: 7222
    185. 11.05 16:06:29.421 26300 26525 Info FrameStatistics: Buckets:                        [0]    [1]    [2]    [3]    [4]    [5]
    186. 11.05 16:06:29.421 26300 26525 Info FrameStatistics: idle frames:                     7218     2     0     0     0     0
    187. 11.05 16:06:29.421 26300 26525 Info FrameStatistics: late frames:                     7156     17     14     10     7     6
    188. 11.05 16:06:29.421 26300 26525 Info FrameStatistics: offset from previous frame:      745     6454     12     7     3     1
    189. 11.05 16:06:29.421 26300 26525 Info FrameStatistics: frame latency:                   12     0     7161     34     6     6
    190. 11.05 16:06:30.424 26300 26525 Info FrameStatistics: == Frame statistics ==
    191. 11.05 16:06:30.425 26300 26525 Info FrameStatistics: total frames: 7282
    192. 11.05 16:06:30.425 26300 26525 Info FrameStatistics: Buckets:                        [0]    [1]    [2]    [3]    [4]    [5]
    193. 11.05 16:06:30.425 26300 26525 Info FrameStatistics: idle frames:                     7278     2     0     0     0     0
    194. 11.05 16:06:30.425 26300 26525 Info FrameStatistics: late frames:                     7216     17     14     10     7     6
    195. 11.05 16:06:30.425 26300 26525 Info FrameStatistics: offset from previous frame:      757     6502     12     7     3     1
    196. 11.05 16:06:30.425 26300 26525 Info FrameStatistics: frame latency:                   12     0     7221     34     6     6
    197. 11.05 16:06:31.427 26300 26525 Info FrameStatistics: == Frame statistics ==
    198. 11.05 16:06:31.428 26300 26525 Info FrameStatistics: total frames: 7342
    199. 11.05 16:06:31.428 26300 26525 Info FrameStatistics: Buckets:                        [0]    [1]    [2]    [3]    [4]    [5]
    200. 11.05 16:06:31.428 26300 26525 Info FrameStatistics: idle frames:                     7338     2     0     0     0     0
    201. 11.05 16:06:31.428 26300 26525 Info FrameStatistics: late frames:                     7276     17     14     10     7     6
    202. 11.05 16:06:31.428 26300 26525 Info FrameStatistics: offset from previous frame:      772     6547     12     7     3     1
    203. 11.05 16:06:31.428 26300 26525 Info FrameStatistics: frame latency:                   12     0     7281     34     6     6
    204. 11.05 16:06:32.430 26300 26525 Info FrameStatistics: == Frame statistics ==
    205. 11.05 16:06:32.430 26300 26525 Info FrameStatistics: total frames: 7402
    206. 11.05 16:06:32.430 26300 26525 Info FrameStatistics: Buckets:                        [0]    [1]    [2]    [3]    [4]    [5]
    207. 11.05 16:06:32.430 26300 26525 Info FrameStatistics: idle frames:                     7398     2     0     0     0     0
    208. 11.05 16:06:32.430 26300 26525 Info FrameStatistics: late frames:                     7336     17     14     10     7     6
    209. 11.05 16:06:32.430 26300 26525 Info FrameStatistics: offset from previous frame:      784     6595     12     7     3     1
    210. 11.05 16:06:32.430 26300 26525 Info FrameStatistics: frame latency:                   12     0     7341     34     6     6
    211. 11.05 16:06:33.433 26300 26525 Info FrameStatistics: == Frame statistics ==
    212. 11.05 16:06:33.433 26300 26525 Info FrameStatistics: total frames: 7462
    213. 11.05 16:06:33.433 26300 26525 Info FrameStatistics: Buckets:                        [0]    [1]    [2]    [3]    [4]    [5]
    214. 11.05 16:06:33.433 26300 26525 Info FrameStatistics: idle frames:                     7458     2     0     0     0     0
    215. 11.05 16:06:33.433 26300 26525 Info FrameStatistics: late frames:                     7396     17     14     10     7     6
    216. 11.05 16:06:33.433 26300 26525 Info FrameStatistics: offset from previous frame:      797     6642     12     7     3     1
    217. 11.05 16:06:33.433 26300 26525 Info FrameStatistics: frame latency:                   12     0     7401     34     6     6
    218. 11.05 16:06:34.435 26300 26525 Info FrameStatistics: == Frame statistics ==
    219. 11.05 16:06:34.436 26300 26525 Info FrameStatistics: total frames: 7522
    220. 11.05 16:06:34.436 26300 26525 Info FrameStatistics: Buckets:                        [0]    [1]    [2]    [3]    [4]    [5]
    221. 11.05 16:06:34.436 26300 26525 Info FrameStatistics: idle frames:                     7518     2     0     0     0     0
    222. 11.05 16:06:34.436 26300 26525 Info FrameStatistics: late frames:                     7456     17     14     10     7     6
    223. 11.05 16:06:34.436 26300 26525 Info FrameStatistics: offset from previous frame:      809     6690     12     7     3     1
    224. 11.05 16:06:34.436 26300 26525 Info FrameStatistics: frame latency:                   12     0     7461     34     6     6
    225. 11.05 16:06:35.439 26300 26525 Info FrameStatistics: == Frame statistics ==
    226. 11.05 16:06:35.439 26300 26525 Info FrameStatistics: total frames: 7582
    227. 11.05 16:06:35.439 26300 26525 Info FrameStatistics: Buckets:                        [0]    [1]    [2]    [3]    [4]    [5]
    228. 11.05 16:06:35.439 26300 26525 Info FrameStatistics: idle frames:                     7578     2     0     0     0     0
    229. 11.05 16:06:35.439 26300 26525 Info FrameStatistics: late frames:                     7516     17     14     10     7     6
    230. 11.05 16:06:35.439 26300 26525 Info FrameStatistics: offset from previous frame:      811     6748     12     7     3     1
    231. 11.05 16:06:35.439 26300 26525 Info FrameStatistics: frame latency:                   12     0     7521     34     6     6
    232. 11.05 16:06:36.441 26300 26525 Info FrameStatistics: == Frame statistics ==
    233. 11.05 16:06:36.441 26300 26525 Info FrameStatistics: total frames: 7642
    234. 11.05 16:06:36.441 26300 26525 Info FrameStatistics: Buckets:                        [0]    [1]    [2]    [3]    [4]    [5]
    235. 11.05 16:06:36.441 26300 26525 Info FrameStatistics: idle frames:                     7638     2     0     0     0     0
    236. 11.05 16:06:36.441 26300 26525 Info FrameStatistics: late frames:                     7576     17     14     10     7     6
    237. 11.05 16:06:36.441 26300 26525 Info FrameStatistics: offset from previous frame:      815     6804     12     7     3     1
    238. 11.05 16:06:36.441 26300 26525 Info FrameStatistics: frame latency:                   12     0     7581     34     6     6
    239. 11.05 16:06:37.444 26300 26525 Info FrameStatistics: == Frame statistics ==
    240. 11.05 16:06:37.445 26300 26525 Info FrameStatistics: total frames: 7702
    241. 11.05 16:06:37.445 26300 26525 Info FrameStatistics: Buckets:                        [0]    [1]    [2]    [3]    [4]    [5]
    242. 11.05 16:06:37.445 26300 26525 Info FrameStatistics: idle frames:                     7698     2     0     0     0     0
    243. 11.05 16:06:37.445 26300 26525 Info FrameStatistics: late frames:                     7636     17     14     10     7     6
    244. 11.05 16:06:37.445 26300 26525 Info FrameStatistics: offset from previous frame:      819     6860     12     7     3     1
    245. 11.05 16:06:37.445 26300 26525 Info FrameStatistics: frame latency:                   12     0     7641     34     6     6
    246. 11.05 16:06:38.447 26300 26525 Info FrameStatistics: == Frame statistics ==
    247. 11.05 16:06:38.447 26300 26525 Info FrameStatistics: total frames: 7762
    248. 11.05 16:06:38.447 26300 26525 Info FrameStatistics: Buckets:                        [0]    [1]    [2]    [3]    [4]    [5]
    249. 11.05 16:06:38.447 26300 26525 Info FrameStatistics: idle frames:                     7758     2     0     0     0     0
    250. 11.05 16:06:38.447 26300 26525 Info FrameStatistics: late frames:                     7696     17     14     10     7     6
    251. 11.05 16:06:38.447 26300 26525 Info FrameStatistics: offset from previous frame:      829     6910     12     7     3     1
    252. 11.05 16:06:38.447 26300 26525 Info FrameStatistics: frame latency:                   12     0     7701     34     6     6
    253. 11.05 16:06:39.450 26300 26525 Info FrameStatistics: == Frame statistics ==
    254. 11.05 16:06:39.450 26300 26525 Info FrameStatistics: total frames: 7822
    255. 11.05 16:06:39.450 26300 26525 Info FrameStatistics: Buckets:                        [0]    [1]    [2]    [3]    [4]    [5]
    256. 11.05 16:06:39.450 26300 26525 Info FrameStatistics: idle frames:                     7818     2     0     0     0     0
    257. 11.05 16:06:39.450 26300 26525 Info FrameStatistics: late frames:                     7756     17     14     10     7     6
    258. 11.05 16:06:39.450 26300 26525 Info FrameStatistics: offset from previous frame:      837     6962     12     7     3     1
    259. 11.05 16:06:39.450 26300 26525 Info FrameStatistics: frame latency:                   12     0     7761     34     6     6
    260. 11.05 16:06:40.453 26300 26525 Info FrameStatistics: == Frame statistics ==
    261. 11.05 16:06:40.453 26300 26525 Info FrameStatistics: total frames: 7882
    262. 11.05 16:06:40.453 26300 26525 Info FrameStatistics: Buckets:                        [0]    [1]    [2]    [3]    [4]    [5]
    263. 11.05 16:06:40.453 26300 26525 Info FrameStatistics: idle frames:                     7878     2     0     0     0     0
    264. 11.05 16:06:40.453 26300 26525 Info FrameStatistics: late frames:                     7816     17     14     10     7     6
    265. 11.05 16:06:40.453 26300 26525 Info FrameStatistics: offset from previous frame:      851     7008     12     7     3     1
    266. 11.05 16:06:40.453 26300 26525 Info FrameStatistics: frame latency:                   12     0     7821     34     6     6
    267.  
    Here the stack for similar another item, it shows when i click buy and native google but dialog appears. You can find here
    Code (CSharp):
    1. 11.05 16:11:13.883 26300 26300 Info UnityIAP: oldSkuMetadata is null
    2.  
    Code (CSharp):
    1. 01.01 00:00:00.000 -1 -1 Info : --------- beginning of main
    2. 11.05 16:11:12.525 26300 26525 Info FrameStatistics: == Frame statistics ==
    3. 11.05 16:11:12.526 26300 26525 Info FrameStatistics: total frames: 24131
    4. 11.05 16:11:12.526 26300 26525 Info FrameStatistics: Buckets:                        [0]    [1]    [2]    [3]    [4]    [5]
    5. 11.05 16:11:12.526 26300 26525 Info FrameStatistics: idle frames:                     24126     2     0     0     0     0
    6. 11.05 16:11:12.526 26300 26525 Info FrameStatistics: late frames:                     24066     17     14     10     7     6
    7. 11.05 16:11:12.526 26300 26525 Info FrameStatistics: offset from previous frame:      3627     20480     12     7     3     1
    8. 11.05 16:11:12.526 26300 26525 Info FrameStatistics: frame latency:                   12     0     24070     34     6     6
    9. 11.05 16:11:13.529 26300 26525 Info FrameStatistics: == Frame statistics ==
    10. 11.05 16:11:13.529 26300 26525 Info FrameStatistics: total frames: 24191
    11. 11.05 16:11:13.529 26300 26525 Info FrameStatistics: Buckets:                        [0]    [1]    [2]    [3]    [4]    [5]
    12. 11.05 16:11:13.529 26300 26525 Info FrameStatistics: idle frames:                     24186     2     0     0     0     0
    13. 11.05 16:11:13.529 26300 26525 Info FrameStatistics: late frames:                     24126     17     14     10     7     6
    14. 11.05 16:11:13.529 26300 26525 Info FrameStatistics: offset from previous frame:      3637     20530     12     7     3     1
    15. 11.05 16:11:13.529 26300 26525 Info FrameStatistics: frame latency:                   12     0     24130     34     6     6
    16. 11.05 16:11:13.746 26300 26372 Info Unity: Purchasing product asychronously: ballads_v_5
    17. 11.05 16:11:13.746 26300 26372 Info Unity: UnityEngine.DebugLogHandler:LogFormat(LogType, Object, String, Object[])
    18. 11.05 16:11:13.746 26300 26372 Info Unity: UnityEngine.Logger:Log(LogType, Object)
    19. 11.05 16:11:13.746 26300 26372 Info Unity: UnityEngine.Debug:Log(Object)
    20. 11.05 16:11:13.746 26300 26372 Info Unity: Purchaser:BuyProductID(String)
    21. 11.05 16:11:13.746 26300 26372 Info Unity: JamPacksViewsHolder:OnBuyButtonClick()
    22. 11.05 16:11:13.746 26300 26372 Info Unity: UnityEngine.Events.UnityAction:Invoke()
    23. 11.05 16:11:13.746 26300 26372 Info Unity: UnityEngine.Events.InvokableCall:Invoke()
    24. 11.05 16:11:13.746 26300 26372 Info Unity: UnityEngine.Events.UnityEvent:Invoke()
    25. 11.05 16:11:13.746 26300 26372 Info Unity: UnityEngine.UI.Button:Press()
    26. 11.05 16:11:13.746 26300 26372 Info Unity: UnityEngine.UI.Button:OnPointerClick(PointerEventData)
    27. 11.05 16:11:13.746 26300 26372 Info Unity: UnityEngine.EventSystems.ExecuteEvents:Execute(IPointerClickHandler, BaseEventData)
    28. 11.05 16:11:13.746 26300 26372 Info Unity: UnityEngine.EventSystems.EventFunction`1:Invoke(T1, BaseEventData)
    29. 11.05 16:11:13.746 26300 26372 Info Unity: UnityEngine.EventSystems.ExecuteEvents:Execute(GameObject, BaseEventData, EventFunction`1)
    30. 11.05 16:11:13.746 26300 26372 Info Unity: UnityEngine.EventSystems.StandaloneInputModule:ProcessTouchPress(PointerEventData, Boolean, Boolean)
    31. 11.05 16:11:13.746 26300 26372 Info Unity: UnityEngine.EventSystems.StandaloneInputModule:ProcessTouchEvents()
    32. 11.05 16:11:13.746 26300 26372 Info Unity: UnityEngine.EventSystems.StandaloneInputModule:Process()
    33. 11.05 16:11:13.746 26300 26372 Info Unity: UnityEngine.EventSystems.EventSystem:Update()
    34. 11.05 16:11:13.746 26300 26372 Info Unity:
    35. 11.05 16:11:13.746 26300 26372 Info Unity: (Filename: ./Runtime/Export/Debug/Debug.bi
    36. 11.05 16:11:13.747 26300 26372 Info UnityIAP: isUnityVrEnabled = false
    37. 11.05 16:11:13.747 26300 26372 Info UnityIAP: onPurchaseProduct: ballads_v_5
    38. 11.05 16:11:13.747 26300 26372 Info UnityIAP: ITEM TYPE:inapp
    39. 01.01 00:00:00.000 -1 -1 Info : --------- beginning of system
    40. 11.05 16:11:13.755 26300 26300 Info Unity: onPause
    41. 11.05 16:11:13.758 26300 26372 Info Unity: purchase({0}): ballads_v_5
    42. 11.05 16:11:13.758 26300 26372 Info Unity: UnityEngine.DebugLogHandler:LogFormat(LogType, Object, String, Object[])
    43. 11.05 16:11:13.758 26300 26372 Info Unity: UnityEngine.Logger:Log(String, Object)
    44. 11.05 16:11:13.758 26300 26372 Info Unity: Purchaser:BuyProductID(String)
    45. 11.05 16:11:13.758 26300 26372 Info Unity: JamPacksViewsHolder:OnBuyButtonClick()
    46. 11.05 16:11:13.758 26300 26372 Info Unity: UnityEngine.Events.UnityAction:Invoke()
    47. 11.05 16:11:13.758 26300 26372 Info Unity: UnityEngine.Events.InvokableCall:Invoke()
    48. 11.05 16:11:13.758 26300 26372 Info Unity: UnityEngine.Events.UnityEvent:Invoke()
    49. 11.05 16:11:13.758 26300 26372 Info Unity: UnityEngine.UI.Button:Press()
    50. 11.05 16:11:13.758 26300 26372 Info Unity: UnityEngine.UI.Button:OnPointerClick(PointerEventData)
    51. 11.05 16:11:13.758 26300 26372 Info Unity: UnityEngine.EventSystems.ExecuteEvents:Execute(IPointerClickHandler, BaseEventData)
    52. 11.05 16:11:13.758 26300 26372 Info Unity: UnityEngine.EventSystems.EventFunction`1:Invoke(T1, BaseEventData)
    53. 11.05 16:11:13.758 26300 26372 Info Unity: UnityEngine.EventSystems.ExecuteEvents:Execute(GameObject, BaseEventData, EventFunction`1)
    54. 11.05 16:11:13.758 26300 26372 Info Unity: UnityEngine.EventSystems.StandaloneInputModule:ProcessTouchPress(PointerEventData, Boolean, Boolean)
    55. 11.05 16:11:13.758 26300 26372 Info Unity: UnityEngine.EventSystems.StandaloneInputModule:ProcessTouchEvents()
    56. 11.05 16:11:13.758 26300 26372 Info Unity: UnityEngine.EventSystems.StandaloneInputModule:Process()
    57. 11.05 16:11:13.758 26300 26372 Info Unity: UnityEngine.EventSystems.EventSystem:Update()
    58. 11.05 16:11:13.758 26300 26372 Info Unity:
    59. 11.05 16:11:13.758 26300 26372 Info Unity: (Filename: ./Runtime/Export/Debug/Debug.bindings.h Line: 35)
    60. 11.05 16:11:13.758 26300 26372 Info Unity:
    61. 11.05 16:11:13.776 26300 26372 Info Unity: UserSettingsManager OnApplicationPause pauseStatus = True
    62. 11.05 16:11:13.776 26300 26372 Info Unity: UnityEngine.DebugLogHandler:LogFormat(LogType, Object, String, Object[])
    63. 11.05 16:11:13.776 26300 26372 Info Unity: UnityEngine.Logger:Log(LogType, Object)
    64. 11.05 16:11:13.776 26300 26372 Info Unity: UnityEngine.Debug:Log(Object)
    65. 11.05 16:11:13.776 26300 26372 Info Unity: UserSettingsManager:OnApplicationPause(Boolean)
    66. 11.05 16:11:13.776 26300 26372 Info Unity:
    67. 11.05 16:11:13.776 26300 26372 Info Unity: (Filename: ./Runtime/Export/Debug/Debug.bindings.h Line: 35)
    68. 11.05 16:11:13.776 26300 26372 Info Unity:
    69. 11.05 16:11:13.777 26300 26372 Info Unity: CommonSettings SaveVars
    70. 11.05 16:11:13.777 26300 26372 Info Unity: UnityEngine.DebugLogHandler:LogFormat(LogType, Object, String, Object[])
    71. 11.05 16:11:13.777 26300 26372 Info Unity: UnityEngine.Logger:Log(LogType, Object)
    72. 11.05 16:11:13.777 26300 26372 Info Unity: UnityEngine.Debug:Log(Object)
    73. 11.05 16:11:13.777 26300 26372 Info Unity: CommonSettings:SaveVars()
    74. 11.05 16:11:13.777 26300 26372 Info Unity: UnityEngine.Events.UnityAction:Invoke()
    75. 11.05 16:11:13.777 26300 26372 Info Unity: UnityEngine.Events.InvokableCall:Invoke()
    76. 11.05 16:11:13.777 26300 26372 Info Unity: UnityEngine.Events.UnityEvent:Invoke()
    77. 11.05 16:11:13.777 26300 26372 Info Unity: UserSettingsManager:OnApplicationPause(Boolean)
    78. 11.05 16:11:13.777 26300 26372 Info Unity:
    79. 11.05 16:11:13.777 26300 26372 Info Unity: (Filename: ./Runtime/Export/Debug/Debug.bindings.h Line: 35)
    80. 11.05 16:11:13.777 26300 26372 Info Unity:
    81. 11.05 16:11:13.799 26300 26372 Info Unity: UserSettingsManager SyncEs3File
    82. 11.05 16:11:13.799 26300 26372 Info Unity: UnityEngine.DebugLogHandler:LogFormat(LogType, Object, String, Object[])
    83. 11.05 16:11:13.799 26300 26372 Info Unity: UnityEngine.Logger:Log(LogType, Object)
    84. 11.05 16:11:13.799 26300 26372 Info Unity: UnityEngine.Debug:Log(Object)
    85. 11.05 16:11:13.799 26300 26372 Info Unity: UserSettingsManager:SyncEs3File()
    86. 11.05 16:11:13.799 26300 26372 Info Unity: UserSettingsManager:OnApplicationPause(Boolean)
    87. 11.05 16:11:13.799 26300 26372 Info Unity:
    88. 11.05 16:11:13.799 26300 26372 Info Unity: (Filename: ./Runtime/Export/Debug/Debug.bindings.h Line: 35)
    89. 11.05 16:11:13.799 26300 26372 Info Unity:
    90. 11.05 16:11:13.869 26300 26372 Debug Unity: Sensor :        Accelerometer ( 1) ; 0.004791 / 0.00s ; BMI160 Accelerometer / BOSCH
    91. 11.05 16:11:13.877 26300 26300 Warn ActivityThread: handleWindowVisibility: no activity for token android.os.BinderProxy@a8f0baa
    92. 11.05 16:11:13.883 26300 26300 Info UnityIAP: Creating purchase activity
    93. 11.05 16:11:13.883 26300 26300 Info UnityIAP: oldSkuMetadata is null
    94. 11.05 16:11:13.883 26300 26579 Info UnityIAP: invoking callback
    95. 11.05 16:11:13.884 26300 26579 Info UnityIAP: Constructing buy intent for ballads_v_5, item type: inapp
    96. 11.05 16:11:13.889 26300 26579 Info UnityIAP: Launching buy intent for ballads_v_5. Request code: 999
    97. 11.05 16:11:13.904 26300 26300 Info Unity: windowFocusChanged: false
    98.  
     
    justtime, Nov 5, 2019
    #12

  13. JeffDUnity3D

    JeffDUnity3D

    Joined:
    May 2, 2017
    Posts:
    14,446
    IAP requires an Internet connection. I don't see any errors in the logs. Are you still discussing the AppNotKnown return code, the topic of this thread? Also, we are looking into an issue where PurchaseFailed is called only the first time a purchase is attempted with no Internet connection. On subsequent purchase attempts with no Internet, there is no callback. We are looking to address this in an upcoming release.
     
    Last edited: Nov 5, 2019
    JeffDUnity3D, Nov 5, 2019
    #13

  14. justtime

    justtime

    Joined:
    Oct 6, 2013
    Posts:
    424
    I'am trying discussing 2 topics.
    1)"IAP requires an Internet connection". But why it shows AppNotKnown error on phone with definitely enabled Google Play? It is developer google console account. Other apps with same version unity iap are working fine.
    2)Second topic is error while purchasing. Errors(in ProcessPurchase method) in this message.
    Here is ProcessPurchase part of code when it happens
    Code (CSharp):
    1. public PurchaseProcessingResult ProcessPurchase(PurchaseEventArgs args)
    2.     {
    3. #if RECEIPT_VALIDATION // Local validation is available for GooglePlay, Apple
    4.         if (m_IsGooglePlayStoreSelected || Application.platform == RuntimePlatform.IPhonePlayer || Application.platform == RuntimePlatform.OSXPlayer || Application.platform == RuntimePlatform.tvOS)
    5.         {
    6.             try
    7.             {
    8.                 if (args.purchasedProduct == null)
    9.                 {
    10.                     Debug.LogWarning("args.purchasedProduct == null");
    11.                 }
    12.              
    13.                 if (args.purchasedProduct.receipt == null)
    14.                 {
    15.                     Debug.LogWarning("args.purchasedProduct.receipt == null");
    16.                 }
    17.              
    18.                 var result = validator.Validate(args.purchasedProduct.receipt);
    19.                 Debug.Log("Receipt is valid. Contents:");
    20.  
    21.                 foreach (IPurchaseReceipt productReceipt in result)
    22.                 {
    23.                     Debug.Log(productReceipt.productID);
    24.                     Debug.Log(productReceipt.purchaseDate);
    25.                     Debug.Log(productReceipt.transactionID);
    26.  
    27.                     GooglePlayReceipt google = productReceipt as GooglePlayReceipt;
    28.                     if (null != google)
    29.                     {
    30.                         Debug.Log(google.purchaseState);
    31.                         Debug.Log(google.purchaseToken);
    32.                     }
    33.  
    34.                     UnityChannelReceipt unityChannel = productReceipt as UnityChannelReceipt;
    35.                     if (null != unityChannel)
    36.                     {
    37.                         Debug.Log(unityChannel.productID);
    38.                         Debug.Log(unityChannel.purchaseDate);
    39.                         Debug.Log(unityChannel.transactionID);
    40.                     }
    41.  
    42.                     AppleInAppPurchaseReceipt apple = productReceipt as AppleInAppPurchaseReceipt;
    43.                     if (null != apple)
    44.                     {
    45.                         Debug.Log(apple.originalTransactionIdentifier);
    46.                         Debug.Log(apple.subscriptionExpirationDate);
    47.                         Debug.Log(apple.cancellationDate);
    48.                         Debug.Log(apple.quantity);
    49.                     }
    50.  
    51.                     // For improved security, consider comparing the signed
    52.                     // IPurchaseReceipt.productId, IPurchaseReceipt.transactionID, and other data
    53.                     // embedded in the signed receipt objects to the data which the game is using
    54.                     // to make this purchase.
    55.                 }
    56.             }
    57.             catch (IAPSecurityException ex)
    58.             {
    59.                 Debug.LogWarning(ex.Message);
    60.                 Debug.LogError($"Invalid receipt, not unlocking content. {ex} {ex.Message}");
    61.                 MyCrashlytics.Instance.LogNonFatal(new Exception($"ProcessPurchase error 1"), $"error {ex.Message}", true);
    62.  
    63.                 return PurchaseProcessingResult.Complete;
    64.             }
    65.         }
    66. #endif

    So, again, here the flow. Internet is on. purchasedProduct and purchasedProduct.receipt are not null. Exception thrown in this line
    Code (CSharp):
    1. var result = validator.Validate(args.purchasedProduct.receipt);
    1)I'am trying to buy item, but got an error(UnityEngine.Purchasing.Security.InvalidSignatureException)
    2)If i reload app, item status is handling ok.

    PS. I am using one unity project for 2 apps, just changing package name. Everything else the same. Could be this a source of problem?
     
    Last edited: Nov 5, 2019
    justtime, Nov 5, 2019
    #14

  15. JeffDUnity3D

    JeffDUnity3D

    Joined:
    May 2, 2017
    Posts:
    14,446
    One issue per thread please to avoid confusion. This thread deals with the topic title AppNotKnown. Please open a separate thread for the other issue. IAP for any app requires the Internet to handle the transactions, and if not, they are not connected to Google Play by definition. IAP transactions do not flow through any Unity online service, they go directly from the app to the respective store through the store native API. We are a pass-through service only. If you get the AppNotKnown error, you'll want the user to check their Google Play account (which requires Internet access)
     
    JeffDUnity3D, Nov 5, 2019
    #15

  16. justtime

    justtime

    Joined:
    Oct 6, 2013
    Posts:
    424
    Today users send me message that he bought non-consumable, but can't get it functional. I check his crashlytics log and found "AppNotKnown" error. What could be wrong with Google Play account, if user has ability to make a purchasing?
     
    justtime, Nov 7, 2019
    #16

  17. JeffDUnity3D

    JeffDUnity3D

    Joined:
    May 2, 2017
    Posts:
    14,446
    We are continuing to investigate.
     
    JeffDUnity3D, Nov 7, 2019
    #17

  18. aimmorato

    aimmorato

    Joined:
    Aug 25, 2017
    Posts:
    1
    some news?
     
    aimmorato, Mar 30, 2020
    #18

  19. SamOYUnity3D

    SamOYUnity3D

    Unity Technologies

    Joined:
    May 12, 2019
    Posts:
    626
    If there is no network or Google Play account is not logged in, initialization will fail and return "Unknown" message.

    On some devices, this issue also occurs if the user manually changes the device date and time.

    In addition, in areas where Google Play services are not accessible, users should use a VPN for in-app purchases.

    In general, we should remind users to check the network and Google Play account status when encountering the "Unknown" message.
     
    SamOYUnity3D, Mar 31, 2020
    #19

  20. robinbobin

    robinbobin

    Joined:
    Aug 22, 2018
    Posts:
    4
    hi all!
    can't find any info if this error message is critical.
    can users buy purchases after?
     
    robinbobin, Apr 20, 2020
    #20

  21. SamOYUnity3D

    SamOYUnity3D

    Unity Technologies

    Joined:
    May 12, 2019
    Posts:
    626
    If the initialization fails, you need to try to initialize IAP again, and users can only purchase after IAP successful initialization.
     
    SamOYUnity3D, Apr 21, 2020
    #21