search

libreliodev / android

Android Customizable Reader - Librelio Digital Publishing Suite
www.librelio.com
226 stars 129 forks source link

Crash: BillingActivity error #261

Closed libreliodev closed 10 years ago

libreliodev commented 10 years ago

cc @intrications

APP_VERSION_CODE=31 APP_VERSION_NAME=1.3.0 ANDROID_VERSION=4.1.2 PHONE_MODEL=GT-S7710 CUSTOM_DATA= STACK_TRACE=java.lang.RuntimeException: An error occured while executing doInBackground() at android.os.AsyncTask$3.done(AsyncTask.java:299) at java.util.concurrent.FutureTask$Sync.innerSetException(FutureTask.java:273) at java.util.concurrent.FutureTask.setException(FutureTask.java:124) at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:307) at java.util.concurrent.FutureTask.run(FutureTask.java:137) at android.os.AsyncTask$SerialExecutor$1.run(AsyncTask.java:230) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1076) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:569) at java.lang.Thread.run(Thread.java:856) Caused by: java.lang.NullPointerException at com.librelio.activity.BillingActivity$7$1.doInBackground(BillingActivity.java:402) at com.librelio.activity.BillingActivity$7$1.doInBackground(BillingActivity.java:375) at android.os.AsyncTask$2.call(AsyncTask.java:287) at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:305) ... 5 more java.lang.NullPointerException at com.librelio.activity.BillingActivity$7$1.doInBackground(BillingActivity.java:402) at com.librelio.activity.BillingActivity$7$1.doInBackground(BillingActivity.java:375) at android.os.AsyncTask$2.call(AsyncTask.java:287) at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:305) at java.util.concurrent.FutureTask.run(FutureTask.java:137) at android.os.AsyncTask$SerialExecutor$1.run(AsyncTask.java:230) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1076) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:569) at java.lang.Thread.run(Thread.java:856)

LOGCAT=08-15 19:02:31.429 D/Event (28213): No subscripers registered for event class de.greenrobot.event.NoSubscriberEvent 08-15 19:02:31.440 D/Event (28213): No subscripers registered for event class com.librelio.event.ChangeInDownloadedMagazinesEvent 08-15 19:02:31.440 D/Event (28213): No subscripers registered for event class de.greenrobot.event.NoSubscriberEvent 08-15 19:02:31.440 D/Event (28213): No subscripers registered for event class com.librelio.event.ChangeInDownloadedMagazinesEvent 08-15 19:02:31.440 D/Event (28213): No subscripers registered for event class de.greenrobot.event.NoSubscriberEvent 08-15 19:02:31.440 D/Event (28213): No subscripers registered for event class com.librelio.event.ChangeInDownloadedMagazinesEvent 08-15 19:02:31.440 D/Event (28213): No subscripers registered for event class de.greenrobot.event.NoSubscriberEvent 08-15 19:02:31.440 D/Event (28213): No subscripers registered for event class com.librelio.event.ChangeInDownloadedMagazinesEvent 08-15 19:02:31.440 D/Event (28213): No subscripers registered for event class de.greenrobot.event.NoSubscriberEvent 08-15 19:02:31.440 D/Event (28213): No subscripers registered for event class com.librelio.event.ChangeInDownloadedMagazinesEvent 08-15 19:02:31.440 D/Event (28213): No subscripers registered for event class de.greenrobot.event.NoSubscriberEvent 08-15 19:02:31.440 D/Event (28213): No subscripers registered for event class com.librelio.event.ChangeInDownloadedMagazinesEvent 08-15 19:02:31.440 D/Event (28213): No subscripers registered for event class de.greenrobot.event.NoSubscriberEvent 08-15 19:02:31.440 D/Event (28213): No subscripers registered for event class com.librelio.event.ChangeInDownloadedMagazinesEvent 08-15 19:02:31.440 D/Event (28213): No subscripers registered for event class de.greenrobot.event.NoSubscriberEvent 08-15 19:02:31.450 D/Event (28213): No subscripers registered for event class com.librelio.event.ChangeInDownloadedMagazinesEvent 08-15 19:02:31.450 D/Event (28213): No subscripers registered for event class de.greenrobot.event.NoSubscriberEvent 08-15 19:02:31.450 D/Event (28213): No subscripers registered for event class com.librelio.event.ChangeInDownloadedMagazinesEvent 08-15 19:02:31.450 D/Event (28213): No subscripers registered for event class de.greenrobot.event.NoSubscriberEvent 08-15 19:02:31.450 D/Event (28213): No subscripers registered for event class com.librelio.event.ChangeInDownloadedMagazinesEvent 08-15 19:02:31.450 D/Event (28213): No subscripers registered for event class de.greenrobot.event.NoSubscriberEvent 08-15 19:02:31.450 D/Event (28213): No subscripers registered for event class com.librelio.event.ChangeInDownloadedMagazinesEvent 08-15 19:02:31.450 D/Event (28213): No subscripers registered for event class de.greenrobot.event.NoSubscriberEvent 08-15 19:02:31.450 D/Event (28213): No subscripers registered for event class com.librelio.event.ChangeInDownloadedMagazinesEvent 08-15 19:02:31.450 D/Event (28213): No subscripers registered for event class de.greenrobot.event.NoSubscriberEvent 08-15 19:02:31.460 D/Event (28213): No subscripers registered for event class com.librelio.event.ChangeInDownloadedMagazinesEvent 08-15 19:02:31.460 D/Event (28213): No subscripers registered for event class de.greenrobot.event.NoSubscriberEvent 08-15 19:02:31.460 D/Event (28213): No subscripers registered for event class com.librelio.event.ChangeInDownloadedMagazinesEvent 08-15 19:02:31.460 D/Event (28213): No subscripers registered for event class de.greenrobot.event.NoSubscriberEvent 08-15 19:02:31.480 D/ProgressBar(28213): setProgressDrawable mProgressDrawable = null, d = android.graphics.drawable.LayerDrawable@41e779b0needUpdate = false 08-15 19:02:31.480 D/ProgressBar(28213): setProgress = 0 08-15 19:02:31.480 D/ProgressBar(28213): setProgress = 0, fromUser = false 08-15 19:02:31.480 D/ProgressBar(28213): mProgress = 0mIndeterminate = false, mMin = 0, mMax = 100 08-15 19:02:32.861 D/dalvikvm(28213): GC_FOR_ALLOC freed 576K, 14% free 13271K/15303K, paused 31ms, total 31ms 08-15 19:02:32.871 I/dalvikvm-heap(28213): Grow heap (frag case) to 13.761MB for 272416-byte allocation 08-15 19:02:32.911 D/dalvikvm(28213): GC_FOR_ALLOC freed 59K, 14% free 13477K/15623K, paused 37ms, total 37ms 08-15 19:02:33.011 D/dalvikvm(28213): GC_FOR_ALLOC freed 296K, 14% free 13495K/15623K, paused 65ms, total 65ms 08-15 19:02:33.331 D/ProgressBar(28213): setProgressDrawable mProgressDrawable = null, d = android.graphics.drawable.LayerDrawable@42116a20needUpdate = false 08-15 19:02:33.331 D/ProgressBar(28213): setProgress = 0 08-15 19:02:33.331 D/ProgressBar(28213): setProgress = 0, fromUser = false 08-15 19:02:33.331 D/ProgressBar(28213): mProgress = 0mIndeterminate = false, mMin = 0, mMax = 100 08-15 19:02:35.443 D/dalvikvm(28213): GC_CONCURRENT freed 1290K, 14% free 13537K/15623K, paused 14ms+20ms, total 77ms 08-15 19:02:35.483 D/dalvikvm(28213): GC_FOR_ALLOC freed 203K, 13% free 13702K/15623K, paused 34ms, total 34ms 08-15 19:02:35.544 D/dalvikvm(28213): GC_FOR_ALLOC freed 305K, 14% free 13623K/15751K, paused 29ms, total 30ms 08-15 19:02:35.544 I/dalvikvm-heap(28213): Grow heap (frag case) to 14.136MB for 304336-byte allocation 08-15 19:02:35.574 D/dalvikvm(28213): GC_FOR_ALLOC freed <1K, 14% free 13920K/16071K, paused 25ms, total 26ms 08-15 19:02:35.854 D/ProgressBar(28213): setProgressDrawable mProgressDrawable = null, d = android.graphics.drawable.LayerDrawable@4211c768needUpdate = false 08-15 19:02:35.854 D/ProgressBar(28213): setProgress = 0 08-15 19:02:35.854 D/ProgressBar(28213): setProgress = 0, fromUser = false 08-15 19:02:35.854 D/ProgressBar(28213): mProgress = 0mIndeterminate = false, mMin = 0, mMax = 100 08-15 19:02:38.206 D/ProgressBar(28213): setProgressDrawable mProgressDrawable = null, d = android.graphics.drawable.LayerDrawable@422da180needUpdate = false 08-15 19:02:38.206 D/ProgressBar(28213): setProgress = 0 08-15 19:02:38.206 D/ProgressBar(28213): setProgress = 0, fromUser = false 08-15 19:02:38.206 D/ProgressBar(28213): mProgress = 0mIndeterminate = false, mMin = 0, mMax = 100 08-15 19:02:40.028 D/WebView (28213): loadUrlImpl: called 08-15 19:02:40.028 D/WebCore (28213): uiOverrideUrlLoading: shouldOverrideUrlLoading() returnsfalse 08-15 19:02:40.028 D/webcore (28213): CORE loadUrl: called 08-15 19:02:40.028 D/webkit (28213): Firewall not null 08-15 19:02:40.038 D/webkit (28213): euler: isUrlBlocked = false 08-15 19:02:40.038 I/GATE (28213): DEV_ACTION_COMPLETED 08-15 19:02:40.088 E/SQLiteLog(28213): (14) cannot open file at line 30241 of [00bb9c9ce4] 08-15 19:02:40.088 E/SQLiteLog(28213): (14) os_unix.c:30241: (2) open(/NotificationPermissions.db) - 08-15 19:02:40.088 D/WebKit (28213): ERROR: 08-15 19:02:40.088 D/WebKit (28213): SQLite database failed to load from /NotificationPermissions.db 08-15 19:02:40.088 D/WebKit (28213): Cause - unable to open database file 08-15 19:02:40.088 D/WebKit (28213): 08-15 19:02:40.088 D/WebKit (28213): external/webkit/Source/WebCore/platform/sql/SQLiteDatabase.cpp(71) : bool WebCore::SQLiteDatabase::open(const WTF::String&, bool) 08-15 19:02:40.088 E/SQLiteLog(28213): (14) cannot open file at line 30241 of [00bb9c9ce4] 08-15 19:02:40.088 E/SQLiteLog(28213): (14) os_unix.c:30241: (2) open(/NotificationPermissions.db) - 08-15 19:02:40.088 D/WebKit (28213): ERROR: 08-15 19:02:40.088 D/WebKit (28213): SQLite database failed to load from /NotificationPermissions.db 08-15 19:02:40.088 D/WebKit (28213): Cause - unable to open database file 08-15 19:02:40.088 D/WebKit (28213): 08-15 19:02:40.088 D/WebKit (28213): external/webkit/Source/WebCore/platform/sql/SQLiteDatabase.cpp(71) : bool WebCore::SQLiteDatabase::open(const WTF::String&, bool) 08-15 19:02:40.238 D/ProgressBar(28213): setProgress = 0 08-15 19:02:40.238 D/ProgressBar(28213): setProgress = 0, fromUser = false 08-15 19:02:40.238 D/ProgressBar(28213): mProgress = 0mIndeterminate = false, mMin = 0, mMax = 100 08-15 19:02:40.278 D/dalvikvm(28213): GC_CONCURRENT freed 2064K, 16% free 14326K/16967K, paused 44ms+63ms, total 308ms 08-15 19:02:40.278 D/dalvikvm(28213): WAIT_FOR_CONCURRENT_GC blocked 255ms 08-15 19:02:40.328 D/WebView (28213): onSizeChanged - w:480 h:0 08-15 19:02:40.458 D/dalvikvm(28213): GC_FOR_ALLOC freed 546K, 19% free 13894K/16967K, paused 62ms, total 62ms 08-15 19:02:40.458 I/dalvikvm-heap(28213): Grow heap (frag case) to 14.401MB for 304336-byte allocation 08-15 19:02:40.508 D/dalvikvm(28213): GC_FOR_ALLOC freed 2K, 18% free 14189K/17287K, paused 47ms, total 47ms 08-15 19:02:40.598 E/SpannableStringBuilder(28213): SPAN_EXCLUSIVE_EXCLUSIVE spans cannot have a zero length 08-15 19:02:40.598 E/SpannableStringBuilder(28213): SPAN_EXCLUSIVE_EXCLUSIVE spans cannot have a zero length 08-15 19:02:50.718 D/dalvikvm(28213): GC_FOR_ALLOC freed 545K, 18% free 14243K/17287K, paused 34ms, total 36ms 08-15 19:02:50.959 D/ProgressBar(28213): setProgressDrawable mProgressDrawable = null, d = android.graphics.drawable.LayerDrawable@41ca5e68needUpdate = false 08-15 19:02:50.959 D/ProgressBar(28213): setProgress = 0 08-15 19:02:50.959 D/ProgressBar(28213): setProgress = 0, fromUser = false 08-15 19:02:50.959 D/ProgressBar(28213): mProgress = 0mIndeterminate = false, mMin = 0, mMax = 100 08-15 19:02:59.517 E/chromium(28213): external/chromium/net/socket/ssl_client_socket_openssl.cc:792: [0815/190259:ERROR:ssl_client_socket_openssl.cc(792)] handshake failed; returned 0, SSL error code 5, net_error -107 08-15 19:02:59.517 E/chromium(28213): external/chromium/net/socket/ssl_client_socket_openssl.cc:792: [0815/190259:ERROR:ssl_client_socket_openssl.cc(792)] handshake failed; returned 0, SSL error code 5, net_error -107 08-15 19:02:59.517 W/chromium(28213): external/chromium/net/http/http_stream_factory_impl_job.cc:865: [0815/190259:WARNING:http_stream_factory_impl_job.cc(865)] Falling back to SSLv3 because host is TLS intolerant: 08-15 19:03:13.072 D/dalvikvm(28213): GC_FOR_ALLOC freed 355K, 18% free 14328K/17287K, paused 41ms, total 42ms 08-15 19:03:20.459 W/dalvikvm(28213): threadid=32: thread exiting with uncaught exception (group=0x412f82a0) 08-15 19:03:20.479 W/GAV2 (28213): Thread[AsyncTask #3,5,main]: dispatch call queued. Need to call GAServiceManager.getInstance().initialize(). 08-15 19:03:20.479 E/ACRA (28213): ACRA caught a RuntimeException exception for com.niveales.montagnes. Building report. 08-15 19:03:20.489 D/ACRA (28213): Using custom Report Fields 08-15 19:03:20.759 I/ACRA (28213): READ_LOGS granted! ACRA can include LogCat and DropBox data. 08-15 19:03:20.849 D/ACRA (28213): Retrieving logcat output...

intrications commented 10 years ago

Looks like it's not receiving the information correctly from Google Play:

//Retrieve relevant in app items
skuDetails = billingService.getSkuDetails(3, getPackageName(), "inapp", querySkus);
ArrayList<String> details = skuDetails.getStringArrayList("DETAILS_LIST");

//Retrieve relevant subscriptions
skuDetails = billingService.getSkuDetails(3, getPackageName(), "subs", querySkus);
ArrayList<String> subsDetails = skuDetails.getStringArrayList("DETAILS_LIST");

//Combine in app and subscriptions
details.addAll(subsDetails); << NullPointerException - details is null?
libreliodev commented 10 years ago

@intrications Thanks. Is this something we can fix or need to update?

intrications commented 10 years ago

@libreliodev I've no idea. I haven't really touched that part of the code so I don't know how it works.

Unless something has been changed in the Google Play Developer Console about in-app billing I would expect it is a one-off crash. The Play Store client may just have sent no data by mistake.

libreliodev commented 10 years ago

@intrications Thanks. We have requested more info from the user, let's see what comes out.

libreliodev commented 10 years ago

@intrications The user has reported to us that the crash occurred (several times) after a download had been interrupted due to connectivity issues. He was finally able to download the magazine