Failed transaction wit null product id

[MaximKeegan]

I'm receiving SIGABRT at start of application. It's happend after I have purchased an autorenewable subscription and something goes wrong...

2012-03-26 12:32:51.273 DPS[1768:707] +[ASTStoreProductData storeProductDataFromProductIdentifier:]:122 Could not find productData:/var/mobile/Applications/06B09791-C761-42C5-AE4F-43A96A9A8D42/Library/ASTStoreController/productData/ASTStoreProductData.archive
2012-03-26 12:32:51.277 DPS[1768:707] *** Assertion failure in -[ASTStoreController completeTransaction:](), /Users/maximkeegan/Dropbox/Sources_Burda/DPS/DPS/Classes/ASTStoreController/Classes/ASTStoreController.m:972
2012-03-26 12:32:51.281 DPS[1768:707] *** Terminating app due to uncaught exception 'NSInternalInconsistencyException', reason: 'Failed to obtain product data for:(null)'

Deleting app from device, logging out from appstore is not help to fix this error... What i'm doing wrong?

[anystone]

This looks like the StoreKit replaying the transactions, but the ASTStoreKit not knowing how or where to assign the transaction results. This can happen if ASTStoreKit has not finished reading in the configuration information when the StoreKit starts replaying transactions.

How are you initializing the StoreKit? This should not be a problem if you have setup an ASTStoreKitConfig.plist file that contains a valid pointer to your productPlistFile. In that case, the ASTStoreKit should read your configuration before the StoreKit starts replaying transactions. The sample project makes use of the ASTStoreKitgConfig.plist, so you should be able to take a look at that for an example.

Sean.

[MaximKeegan]

Same issue with subscriptions

-[ASTStoreController productsRequest:didReceiveResponse:]:644 Associating valid data for ru.redburda.magazine.6month_subscription : <SKProduct: 0x3aad350>
-[ASTStoreController productsRequest:didReceiveResponse:]:644 Associating valid data for ru.redburda.magazine.7 : <SKProduct: 0x3aad400>
-[ASTStoreController productsRequest:didReceiveResponse:]:644 Associating valid data for ru.redburda.magazine.8 : <SKProduct: 0x3aad4b0>
-[ASTStoreController productsRequest:didReceiveResponse:]:644 Associating valid data for ru.redburda.magazine.9 : <SKProduct: 0x3aad560>
-[ASTStoreController requestDidFinish:]:686 <SKProductsRequest: 0x6aa370>
-[ASTStoreController restoreTransaction:]:960 restoring: ru.redburda.magazine.6month_subscription
-[ASTStoreController completeTransaction:]:889 serverURL:(null) verify:0
+[ASTStoreProductData storeProductDataFromProductIdentifier:]:122 Could not find productData:/var/mobile/Applications/C4ECCB2B-5CD4-455E-B5C8-C336DFE94BF2/Library/ASTStoreController/productData/ASTStoreProductData.archive
*** Assertion failure in -[ASTStoreController completeTransaction:](), /Users/maximkeegan/Dropbox/Sources_Burda/DPS/DPS/Classes/ASTStoreController/Classes/ASTStoreController.m:897
*** Terminating app due to uncaught exception 'NSInternalInconsistencyException', reason: 'Failed to obtain product data for:(null)'
*** First throw call stack:
(0x3566288f 0x33286259 0x35662789 0x34a563ff 0x7041 0x7635 0x7b83 0x33acb7a7 0x355b1afb 0x33acb763 0x33acbdf5 0x33acb02d 0x34a7c4ff 0x3562e547 0x355ba097 0x349f03eb 0x33b7cba3 0x33b7e10b 0x33b7c99b 0x33b71b11 0x35636523 0x356364c5 0x35635313 0x355b84a5 0x355b836d 0x33353439 0x32d90cd5 0xa660d 0x31b8)

I have setted the productPlistFile with products and subscriptions. http://content.screencast.com/users/MaximKeegan/folders/Jing/media/de22a1b0-7909-4bac-9ffb-751f0c4e603a/00000714.png

init in

- (BOOL)application:(UIApplication *)application didFinishLaunchingWithOptions:(NSDictionary *)launchOptions {    
[ASTStoreController sharedStoreController];
[[ASTStoreController sharedStoreController] requestProductDataFromiTunes:NO];

[anystone]

Hmmm. What would be interesting to know ...

Remove the exception so that it doesn't throw an error, but prints a log instead. This will let your app continue to run.

I'm assuming you have a "Restore Previous Purchases" button somewhere in your app. Press the restore purchases button, and see if you continue to see that log.

Trying to figure out if this is a race condition, or something other type of bug.

[MaximKeegan]

I commented out the line of code which throws an exception. App is launching normally. But when i've pressed Subscribe, Restore or buy it says Purchase in progress. Please wait to complete and try again. App is not asking Login and password and label [sandbox mode] is not displaying...

 -[ASTStoreController productsRequest:didReceiveResponse:]:639 request:<SKProductsRequest: 0x686a30> response:<SKProductsResponse: 0x3a5dfe0>
 -[ASTStoreController productsRequest:didReceiveResponse:]:644 Associating valid data for ru.redburda.magazine.10 : <SKProduct: 0x3a5e0f0>
 -[ASTStoreController productsRequest:didReceiveResponse:]:644 Associating valid data for ru.redburda.magazine.11 : <SKProduct: 0x3a5e910>
 -[ASTStoreController productsRequest:didReceiveResponse:]:644 Associating valid data for ru.redburda.magazine.12 : <SKProduct: 0x3a5ea40>
 -[ASTStoreController productsRequest:didReceiveResponse:]:644 Associating valid data for ru.redburda.magazine.13 : <SKProduct: 0x3a5eaf0>
 -[ASTStoreController productsRequest:didReceiveResponse:]:644 Associating valid data for ru.redburda.magazine.14 : <SKProduct: 0x3a5eba0>
 -[ASTStoreController productsRequest:didReceiveResponse:]:644 Associating valid data for ru.redburda.magazine.15 : <SKProduct: 0x3a5e6e0>
 -[ASTStoreController productsRequest:didReceiveResponse:]:644 Associating valid data for ru.redburda.magazine.2 : <SKProduct: 0x3a5ed10>
 -[ASTStoreController productsRequest:didReceiveResponse:]:644 Associating valid data for ru.redburda.magazine.3 : <SKProduct: 0x3a5edc0>
 -[ASTStoreController productsRequest:didReceiveResponse:]:644 Associating valid data for ru.redburda.magazine.4 : <SKProduct: 0x3a5ee70>
 -[ASTStoreController productsRequest:didReceiveResponse:]:644 Associating valid data for ru.redburda.magazine.5 : <SKProduct: 0x3a5ec70>
 -[ASTStoreController productsRequest:didReceiveResponse:]:644 Associating valid data for ru.redburda.magazine.6 : <SKProduct: 0x3a5eff0>
 -[ASTStoreController productsRequest:didReceiveResponse:]:644 Associating valid data for ru.redburda.magazine.6month_subscription : <SKProduct: 0x3a5f0a0>
 -[ASTStoreController productsRequest:didReceiveResponse:]:644 Associating valid data for ru.redburda.magazine.7 : <SKProduct: 0x3a5f150>
 -[ASTStoreController productsRequest:didReceiveResponse:]:644 Associating valid data for ru.redburda.magazine.8 : <SKProduct: 0x3a5f200>
 -[ASTStoreController productsRequest:didReceiveResponse:]:644 Associating valid data for ru.redburda.magazine.9 : <SKProduct: 0x3a5f2b0>
 -[ASTStoreController requestDidFinish:]:686 <SKProductsRequest: 0x686a30>
 -[ASTStoreController completeTransaction:]:889 serverURL:(null) verify:0
 -[ASTStoreServer configureSubscriptionQueue]:300 Suspending subscription queue
 -[ASTStoreController completeTransaction:]:889 serverURL:(null) verify:0
 -[ASTStoreController completeTransaction:]:889 serverURL:(null) verify:0
 -[ASTStoreController completeTransaction:]:889 serverURL:(null) verify:0
 -[ASTStoreController completeTransaction:]:889 serverURL:(null) verify:0

[anystone]

Well, from the logs there at least it looks like it has found the 6month_subscription. That points to a race condition.

Can you confirm that you created a ASTStoreKitConfig.plist which points to your productPlistFile ? That should have taken care of the startup race condition.