Solved

App IDs transferring subscriptions to anonymous users

  • 2 February 2022
  • 27 replies
  • 1475 views


Show first post

27 replies

Userlevel 1
Badge +2

Thanks for getting back to me @cody really appreciate it.

 

I’ve managed to recreate this again following the steps above. Logs are below and I’ve also supplied a screenshot of how it manifests itself in our dashboard and the transfer event data.

 


00:54.383.801 [Purchases] - DEBUG: ℹ️ Debug logging enabled
00:54.383.916 [Purchases] - DEBUG: ℹ️ SDK Version - 3.13.1
00:54.383.964 [Purchases] - DEBUG: 👤 Initial App User ID - (null)
00:54.384.132 [Purchases] - DEBUG: 👤 Identifying App User ID: $RCAnonymousID:2d987411791d4553bce4e13eaaf3cd1f
00:54.387.152 [Purchases] - DEBUG: ℹ️ Delegate set
00:54.437.829 [Purchases] - DEBUG: ℹ️ There are no requests currently running, starting request GET /subscribers/$RCAnonymousID0X0P+02d987411791d4553bce4e13eaaf3cd1f
00:54.437.928 [Purchases] - DEBUG: ℹ️ API request started: GET /v1/subscribers/$RCAnonymousID:2d987411791d4553bce4e13eaaf3cd1f
00:54.444.673 [Purchases] - DEBUG: ℹ️ There's a request currently running and 0 requests left in the queue, queueing GET /subscribers/$RCAnonymousID0X0P+02d987411791d4553bce4e13eaaf3cd1f/offerings
00:56.496.887 [Purchases] - DEBUG: ℹ️ API request completed with status: GET /v1/subscribers/$RCAnonymousID:2d987411791d4553bce4e13eaaf3cd1f 201
00:56.529.597 [Purchases] - DEBUG: ℹ️ Sending latest PurchaserInfo to delegate.
00:56.530.394 [Purchases] - DEBUG: ℹ️ Serial request done: GET /subscribers/$RCAnonymousID0X0P+02d987411791d4553bce4e13eaaf3cd1f, 1 requests left in the queue
00:56.531.600 [Purchases] - DEBUG: ℹ️ Starting the next request in the queue, <RCHTTPRequest: httpMethod=GET
path=/subscribers/$RCAnonymousID0X0P+02d987411791d4553bce4e13eaaf3cd1f/offerings
requestBody=(null)
headers={
Authorization = "Bearer <REDACTED>";
}
retried=0
>
00:56.535.351 [Purchases] - DEBUG: ℹ️ There are no requests currently running, starting request GET /subscribers/$RCAnonymousID0X0P+02d987411791d4553bce4e13eaaf3cd1f/offerings
00:56.535.757 [Purchases] - DEBUG: ℹ️ API request started: GET /v1/subscribers/$RCAnonymousID:2d987411791d4553bce4e13eaaf3cd1f/offerings
00:56.680.966 [Purchases] - DEBUG: ℹ️ API request completed with status: GET /v1/subscribers/$RCAnonymousID:2d987411791d4553bce4e13eaaf3cd1f/offerings 200
00:56.682.588 [Purchases] - DEBUG: ℹ️ Requesting products from the store with identifiers: {(
"headtrak_1499_3M"
)}
00:56.683.346 [Purchases] - DEBUG: ℹ️ Serial request done: GET /subscribers/$RCAnonymousID0X0P+02d987411791d4553bce4e13eaaf3cd1f/offerings, 0 requests left in the queue
00:57.956.908 [Purchases] - DEBUG: ℹ️ Products request finished.
00:57.957.124 [Purchases] - DEBUG: 💰 Retrieved SKProducts:
00:57.957.302 [Purchases] - DEBUG: 💰 headtrak_1499_3M - <SKProduct: 0x282359250>
00:57.957.423 [Purchases] - DEBUG: ℹ️ 1 completion handlers waiting on products
01:36.709.983 [Purchases] - DEBUG: ℹ️ applicationDidBecomeActive
02:08.837.631 [Purchases] - DEBUG: ℹ️ applicationDidBecomeActive
02:19.558.720 [Purchases] - DEBUG: ℹ️ applicationDidBecomeActive
02:22.328.634 [Purchases] - DEBUG: ℹ️ There are no requests currently running, starting request POST /subscribers/identify
02:22.328.739 [Purchases] - DEBUG: ℹ️ API request started: POST /v1/subscribers/identify
02:23.011.334 [Purchases] - DEBUG: ℹ️ API request completed with status: POST /v1/subscribers/identify 201
02:23.013.011 [Purchases] - DEBUG: 👤 Log in successful
02:23.020.396 [Purchases] - DEBUG: ℹ️ Serial request done: POST /subscribers/identify, 0 requests left in the queue
02:23.022.444 [Purchases] - DEBUG: ℹ️ There are no requests currently running, starting request GET /subscribers/91df13d0-8afc-47b1-b08a-6ea3b2fff5e9/offerings
02:23.022.582 [Purchases] - DEBUG: ℹ️ API request started: GET /v1/subscribers/91df13d0-8afc-47b1-b08a-6ea3b2fff5e9/offerings
02:23.023.306 [Purchases] - DEBUG: ℹ️ Vending PurchaserInfo from cache.
02:23.172.924 [Purchases] - DEBUG: ℹ️ API request completed with status: GET /v1/subscribers/91df13d0-8afc-47b1-b08a-6ea3b2fff5e9/offerings 200
02:23.174.186 [Purchases] - DEBUG: ℹ️ Serial request done: GET /subscribers/91df13d0-8afc-47b1-b08a-6ea3b2fff5e9/offerings, 0 requests left in the queue
02:25.591.383 [Purchases] - DEBUG: ℹ️ Vending Offerings from cache
02:25.652.902 [Purchases] - DEBUG: ℹ️ Loaded receipt from url file:///private/var/mobile/Containers/Data/Application/80C8F453-4183-48D0-9C19-D12F278FC7A8/StoreKit/sandboxReceipt
02:25.653.020 [Purchases] - DEBUG: ℹ️ Receipt empty, refreshing
02:26.640.220 [Purchases] - DEBUG: ℹ️ Loaded receipt from url file:///private/var/mobile/Containers/Data/Application/80C8F453-4183-48D0-9C19-D12F278FC7A8/StoreKit/sandboxReceipt
02:26.641.806 [Purchases] - DEBUG: ℹ️ Attempting to check intro eligibility locally
02:26.647.225 [Purchases] - INFO: ℹ️ Receipt parsed successfully
02:26.647.618 [Purchases] - DEBUG: ℹ️ No existing requests and products not cached, starting SKProducts request for: {(
"headtrak_1499_3M"
)}
02:26.702.758 [Purchases] - DEBUG: 😻 SKProductsRequest did finish
02:26.703.081 [Purchases] - DEBUG: 😻 SKProductsRequest request received response
02:26.703.705 [Purchases] - DEBUG: ℹ️ Local intro eligibility computed locally. Result: {
"headtrak_1499_3M" = 2;
}
02:29.152.755 [Purchases] - DEBUG: ℹ️ Vending Offerings from cache
02:29.152.909 [Purchases] - DEBUG: ℹ️ makePurchase
02:29.154.327 [Purchases] - DEBUG: 💰 Purchasing product from package - headtrak_1499_3M in Offering 1499_3M
02:29.155.149 [Purchases] - DEBUG: ℹ️ PaymentQueue updatedTransaction: headtrak_1499_3M (null) ((null)) (null) - 0
02:46.363.689 [Purchases] - DEBUG: ℹ️ applicationDidBecomeActive
02:46.377.226 [Purchases] - DEBUG: ℹ️ Vending PurchaserInfo from cache.
02:52.250.158 [Purchases] - DEBUG: ℹ️ PaymentQueue updatedTransaction: headtrak_1499_3M 1000000964493923 ((null)) (null) - 1
02:52.254.141 [Purchases] - DEBUG: ℹ️ Loaded receipt from url file:///private/var/mobile/Containers/Data/Application/80C8F453-4183-48D0-9C19-D12F278FC7A8/StoreKit/sandboxReceipt
02:52.254.621 [Purchases] - DEBUG: ℹ️ Found 0 unsynced attributes for App User ID: 91df13d0-8afc-47b1-b08a-6ea3b2fff5e9
02:52.258.592 [Purchases] - DEBUG: ℹ️ There are no requests currently running, starting request POST /receipts
02:52.258.720 [Purchases] - DEBUG: ℹ️ API request started: POST /v1/receipts
02:52.261.477 [Purchases] - DEBUG: ℹ️ applicationDidBecomeActive
02:52.268.645 [Purchases] - DEBUG: ℹ️ Vending PurchaserInfo from cache.
02:54.488.831 [Purchases] - DEBUG: ℹ️ API request completed with status: POST /v1/receipts 200
02:54.504.201 [Purchases] - DEBUG: ℹ️ Serial request done: POST /receipts, 0 requests left in the queue
02:54.509.894 [Purchases] - DEBUG: ℹ️ Sending updated PurchaserInfo to delegate.
02:54.519.819 [Purchases] - DEBUG: 💰 Finishing transaction headtrak_1499_3M 1000000964493923 ((null))
02:55.565.586 [Purchases] - DEBUG: ℹ️ PaymentQueue removedTransaction: headtrak_1499_3M 1000000964493923 ((null) (null)) (null) - 1
03:34.241.944 [Purchases] - INFO: ℹ️ Logging out user 91df13d0-8afc-47b1-b08a-6ea3b2fff5e9
03:34.245.541 [Purchases] - INFO: ℹ️ Log out successful
03:34.247.687 [Purchases] - DEBUG: ℹ️ There are no requests currently running, starting request GET /subscribers/$RCAnonymousID0X0P+0b74c17fcbc0547f08d7be11db44a9b6d
03:34.247.756 [Purchases] - DEBUG: ℹ️ API request started: GET /v1/subscribers/$RCAnonymousID:b74c17fcbc0547f08d7be11db44a9b6d
03:34.249.156 [Purchases] - DEBUG: ℹ️ There's a request currently running and 0 requests left in the queue, queueing GET /subscribers/$RCAnonymousID0X0P+0b74c17fcbc0547f08d7be11db44a9b6d/offerings
03:34.815.366 [Purchases] - DEBUG: ℹ️ API request completed with status: GET /v1/subscribers/$RCAnonymousID:b74c17fcbc0547f08d7be11db44a9b6d 201
03:34.822.782 [Purchases] - DEBUG: ℹ️ Sending updated PurchaserInfo to delegate.
03:34.823.091 [Purchases] - DEBUG: ℹ️ Serial request done: GET /subscribers/$RCAnonymousID0X0P+0b74c17fcbc0547f08d7be11db44a9b6d, 1 requests left in the queue
03:34.824.484 [Purchases] - DEBUG: ℹ️ Starting the next request in the queue, <RCHTTPRequest: httpMethod=GET
path=/subscribers/$RCAnonymousID0X0P+0b74c17fcbc0547f08d7be11db44a9b6d/offerings
requestBody=(null)
headers={
Authorization = "Bearer <REDACTED>";
}
retried=0
>
03:34.826.929 [Purchases] - DEBUG: ℹ️ There are no requests currently running, starting request GET /subscribers/$RCAnonymousID0X0P+0b74c17fcbc0547f08d7be11db44a9b6d/offerings
03:34.827.146 [Purchases] - DEBUG: ℹ️ API request started: GET /v1/subscribers/$RCAnonymousID:b74c17fcbc0547f08d7be11db44a9b6d/offerings
03:35.050.200 [Purchases] - DEBUG: ℹ️ API request completed with status: GET /v1/subscribers/$RCAnonymousID:b74c17fcbc0547f08d7be11db44a9b6d/offerings 200
03:35.051.307 [Purchases] - DEBUG: ℹ️ Serial request done: GET /subscribers/$RCAnonymousID0X0P+0b74c17fcbc0547f08d7be11db44a9b6d/offerings, 0 requests left in the queue
20:12.432.880 [Purchases] - DEBUG: ℹ️ applicationDidBecomeActive
20:12.442.625 [Purchases] - DEBUG: ℹ️ PurchaserInfo cache is stale, updating from network in foreground.
20:12.444.852 [Purchases] - DEBUG: 😻 PurchaserInfo updated from network.
20:12.444.994 [Purchases] - DEBUG: ℹ️ Offerings cache is stale, updating caches
20:12.452.307 [Purchases] - DEBUG: ℹ️ There are no requests currently running, starting request GET /subscribers/$RCAnonymousID0X0P+0b74c17fcbc0547f08d7be11db44a9b6d
20:12.452.496 [Purchases] - DEBUG: ℹ️ API request started: GET /v1/subscribers/$RCAnonymousID:b74c17fcbc0547f08d7be11db44a9b6d
20:12.456.540 [Purchases] - DEBUG: ℹ️ There's a request currently running and 0 requests left in the queue, queueing GET /subscribers/$RCAnonymousID0X0P+0b74c17fcbc0547f08d7be11db44a9b6d/offerings
20:12.979.590 [Purchases] - DEBUG: ℹ️ API request completed with status: GET /v1/subscribers/$RCAnonymousID:b74c17fcbc0547f08d7be11db44a9b6d 304
20:12.982.523 [Purchases] - DEBUG: ℹ️ Serial request done: GET /subscribers/$RCAnonymousID0X0P+0b74c17fcbc0547f08d7be11db44a9b6d, 1 requests left in the queue
20:12.982.688 [Purchases] - DEBUG: ℹ️ Starting the next request in the queue, <RCHTTPRequest: httpMethod=GET
path=/subscribers/$RCAnonymousID0X0P+0b74c17fcbc0547f08d7be11db44a9b6d/offerings
requestBody=(null)
headers={
Authorization = "Bearer <REDACTED>";
}
retried=0
>
20:12.983.698 [Purchases] - DEBUG: ℹ️ There are no requests currently running, starting request GET /subscribers/$RCAnonymousID0X0P+0b74c17fcbc0547f08d7be11db44a9b6d/offerings
20:12.983.791 [Purchases] - DEBUG: ℹ️ API request started: GET /v1/subscribers/$RCAnonymousID:b74c17fcbc0547f08d7be11db44a9b6d/offerings
20:13.230.299 [Purchases] - DEBUG: ℹ️ API request completed with status: GET /v1/subscribers/$RCAnonymousID:b74c17fcbc0547f08d7be11db44a9b6d/offerings 200
20:13.240.377 [Purchases] - DEBUG: ℹ️ Serial request done: GET /subscribers/$RCAnonymousID0X0P+0b74c17fcbc0547f08d7be11db44a9b6d/offerings, 0 requests left in the queue
20:14.597.147 [Purchases] - DEBUG: ℹ️ PaymentQueue updatedTransaction: headtrak_1499_3M 1000000964511006 ((null)) 1000000964493923 - 1
20:14.608.545 [Purchases] - DEBUG: ℹ️ Loaded receipt from url file:///private/var/mobile/Containers/Data/Application/80C8F453-4183-48D0-9C19-D12F278FC7A8/StoreKit/sandboxReceipt
20:14.608.874 [Purchases] - DEBUG: ℹ️ Found 0 unsynced attributes for App User ID: $RCAnonymousID:b74c17fcbc0547f08d7be11db44a9b6d
20:14.611.035 [Purchases] - DEBUG: ℹ️ There are no requests currently running, starting request POST /receipts
20:14.611.295 [Purchases] - DEBUG: ℹ️ API request started: POST /v1/receipts
20:15.446.006 [Purchases] - DEBUG: ℹ️ API request completed with status: POST /v1/receipts 200
20:15.456.812 [Purchases] - DEBUG: ℹ️ Serial request done: POST /receipts, 0 requests left in the queue
20:15.463.015 [Purchases] - DEBUG: ℹ️ Sending updated PurchaserInfo to delegate.
20:15.471.874 [Purchases] - DEBUG: 💰 Finishing transaction headtrak_1499_3M 1000000964511006 (1000000964493923)
20:16.257.493 [Purchases] - DEBUG: ℹ️ PaymentQueue removedTransaction: headtrak_1499_3M 1000000964511006 (1000000964493923 (null)) (null) - 1

Note line (20:12.432.880 [Purchases] - DEBUG: ℹ️ applicationDidBecomeActive) is where I brought the back back into the foreground. I didn’t quit the app.

 

You can see the customer details and the timeline below:

 

And the transfer event data:
ID 16c26c32-0da1-419d-b87a-1f6a19d36fd9

 

{  "app_id": “<REDACTED>",  "event_timestamp_ms": 1644317208359,  "store": "APP_STORE",  "transferred_from": [    "$RCAnonymousID:2d987411791d4553bce4e13eaaf3cd1f",    "91df13d0-8afc-47b1-b08a-6ea3b2fff5e9"  ],  "transferred_to": [    "$RCAnonymousID:b74c17fcbc0547f08d7be11db44a9b6d"  ]}

 

If theres anything else you need from me please let me know.

Userlevel 1
Badge +2

Also note if I log back in with the user that purchased the account, the purchaser info shows I don’t have any subscriptions:

DEBUG LOGS:

[Purchases] - DEBUG: ℹ️ There are no requests currently running, starting request POST /subscribers/identify	
[Purchases] - DEBUG: ℹ️ API request started: POST /v1/subscribers/identify
[Purchases] - DEBUG: ℹ️ API request completed with status: POST /v1/subscribers/identify 200
[Purchases] - DEBUG: 👤 Log in successful
[Purchases] - DEBUG: ℹ️ Sending updated PurchaserInfo to delegate.
[Purchases] - DEBUG: ℹ️ Serial request done: POST /subscribers/identify, 0 requests left in the queue
[Purchases] - DEBUG: ℹ️ There are no requests currently running, starting request GET /subscribers/91df13d0-8afc-47b1-b08a-6ea3b2fff5e9/offerings
[Purchases] - DEBUG: ℹ️ API request started: GET /v1/subscribers/91df13d0-8afc-47b1-b08a-6ea3b2fff5e9/offerings
[Purchases] - DEBUG: ℹ️ Vending PurchaserInfo from cache.
[Purchases] - DEBUG: ℹ️ API request completed with status: GET /v1/subscribers/91df13d0-8afc-47b1-b08a-6ea3b2fff5e9/offerings 200
[Purchases] - DEBUG: ℹ️ Serial request done: GET /subscribers/91df13d0-8afc-47b1-b08a-6ea3b2fff5e9/offerings, 0 requests left in the queue

Purchaser info

Object {
"activeSubscriptions": Array [],
"allExpirationDates": Object {},
"allExpirationDatesMillis": Object {},
"allPurchaseDates": Object {},
"allPurchaseDatesMillis": Object {},
"allPurchasedProductIdentifiers": Array [],
"entitlements": Object {
"active": Object {},
"all": Object {},
},
"firstSeen": "2022-02-08T10:27:29Z",
"firstSeenMillis": 1644316049000,
"latestExpirationDate": null,
"latestExpirationDateMillis": null,
"managementURL": null,
"nonSubscriptionTransactions": Array [],
"originalAppUserId": "$RCAnonymousID:2d987411791d4553bce4e13eaaf3cd1f",
"originalApplicationVersion": "1.0",
"originalPurchaseDate": "2013-08-01T07:00:00Z",
"originalPurchaseDateMillis": 1375340400000,
"requestDate": "2022-02-08T11:18:02Z",
"requestDateMillis": 1644319082000,
}

Reply