microg / GmsCore

Free implementation of Play Services
https://microg.org
Apache License 2.0
8.48k stars 1.71k forks source link

App crashes on start #1703

Closed A-Shahbazi closed 8 months ago

A-Shahbazi commented 2 years ago

App crashes on start using latest release v0.2.24.214816

here's the relevant part of logcat:

04-13 22:03:00.767  1236  3222 I ActivityTaskManager: START u0 {flg=0x10000000 cmp=cab.snapp.passenger.play/cab.snapp.passenger.activities.launcher.LauncherActivity} from uid 2000
04-13 22:03:00.797   719   719 D QCOM PowerHAL: LAUNCH HINT: ON
04-13 22:03:00.802   972   989 E ANDR-PERF-MPCTL: Invalid profile no. 0, total profiles 0 only
04-13 22:03:00.802   719   719 D QCOM PowerHAL: Activity launch hint handled
04-13 22:03:00.805     0     0 I CPU1    : update max cpu_capacity 763
04-13 22:03:00.805     0     0 I CPU3    : update max cpu_capacity 1024
04-13 22:03:00.814 12913 12915 I cmd     : oneway function results will be dropped but finished with status OK and parcel size 4
04-13 22:03:00.813     0     0 W         : dhd_os_check_wakelock_all wakelock c-0 wl-0 wd-0 rx-1 ctl-0 intr-0 scan-0 evt-0
04-13 22:03:00.835  1236  1278 D CompatibilityChangeReporter: Compat change id reported: 136274596; UID 10228; state: DISABLED
04-13 22:03:00.903 12803 12803 W FA      : setCurrentScreen cannot be called while no activity active
04-13 22:03:00.935     0     0 E bcl_peripheral: bcl_handle_vbat Vbat reached Low trip. vbat:3260400
04-13 22:03:00.975 12803 12803 W FA      : setCurrentScreen cannot be called while no activity active
04-13 22:03:00.989 12803 12923 I FA      : Tag Manager is not found and thus will not be used
04-13 22:03:01.002 12803 12803 D AndroidRuntime: Shutting down VM
04-13 22:03:01.003 12803 12803 E AndroidRuntime: FATAL EXCEPTION: main
04-13 22:03:01.003 12803 12803 E AndroidRuntime: Process: cab.snapp.passenger.play, PID: 12803
04-13 22:03:01.003 12803 12803 E AndroidRuntime: java.lang.RuntimeException: Unable to resume activity {cab.snapp.passenger.play/cab.snapp.passenger.activities.launcher.LauncherActivity}: java.lang.StringIndexOutOfBoundsException: String index out of range: -1
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at android.app.ActivityThread.performResumeActivity(ActivityThread.java:4438)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at android.app.ActivityThread.handleResumeActivity(ActivityThread.java:4470)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at android.app.servertransaction.ResumeActivityItem.execute(ResumeActivityItem.java:52)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at android.app.servertransaction.TransactionExecutor.executeLifecycleState(TransactionExecutor.java:176)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at android.app.servertransaction.TransactionExecutor.execute(TransactionExecutor.java:97)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at android.app.ActivityThread$H.handleMessage(ActivityThread.java:2066)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at android.os.Handler.dispatchMessage(Handler.java:106)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at android.os.Looper.loop(Looper.java:223)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at android.app.ActivityThread.main(ActivityThread.java:7664)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at java.lang.reflect.Method.invoke(Native Method)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run(RuntimeInit.java:592)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:947)
04-13 22:03:01.003 12803 12803 E AndroidRuntime: Caused by: java.lang.StringIndexOutOfBoundsException: String index out of range: -1
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at java.lang.String.substring(String.java:2064)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at cab.snapp.core.units.splash.SplashInteractor.handleDefaultOnUnitResume(SourceFile:9)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at cab.snapp.core.units.splash.SplashInteractor.onUnitResume(SourceFile:5)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at cab.snapp.arch.protocol.BaseController.onResume(SourceFile:3)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at androidx.fragment.app.Fragment.performResume(SourceFile:5)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at androidx.fragment.app.FragmentStateManager.resume(SourceFile:3)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at androidx.fragment.app.FragmentManager.moveToState(SourceFile:29)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at androidx.fragment.app.FragmentManager.moveToState(SourceFile:69)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at androidx.fragment.app.FragmentManager.moveFragmentToExpectedState(SourceFile:4)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at androidx.fragment.app.FragmentManager.moveToState(SourceFile:75)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at androidx.fragment.app.FragmentManager.dispatchStateChange(SourceFile:3)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at androidx.fragment.app.FragmentManager.dispatchResume(SourceFile:3)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at androidx.fragment.app.Fragment.performResume(SourceFile:10)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at androidx.fragment.app.FragmentStateManager.resume(SourceFile:3)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at androidx.fragment.app.FragmentManager.moveToState(SourceFile:29)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at androidx.fragment.app.FragmentManager.moveToState(SourceFile:69)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at androidx.fragment.app.FragmentManager.moveFragmentToExpectedState(SourceFile:4)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at androidx.fragment.app.FragmentManager.moveToState(SourceFile:75)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at androidx.fragment.app.FragmentManager.dispatchStateChange(SourceFile:3)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at androidx.fragment.app.FragmentManager.dispatchResume(SourceFile:3)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at androidx.fragment.app.FragmentController.dispatchResume(SourceFile:1)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at androidx.fragment.app.FragmentActivity.onResumeFragments(SourceFile:2)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at androidx.fragment.app.FragmentActivity.onPostResume(SourceFile:2)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at android.app.Activity.performResume(Activity.java:8154)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    at android.app.ActivityThread.performResumeActivity(ActivityThread.java:4428)
04-13 22:03:01.003 12803 12803 E AndroidRuntime:    ... 11 more
04-13 22:03:01.102  3253  3279 W System  : A resource failed to call release. 
04-13 22:03:01.102  3253  3279 I chatty  : uid=10150(com.android.launcher3) FinalizerDaemon identical 1 line
04-13 22:03:01.103  3253  3279 W System  : A resource failed to call release. 
04-13 22:03:01.115  4362  4362 D MeasurementService: onBind: Intent { act=com.google.android.gms.measurement.START pkg=com.google.android.gms }
04-13 22:03:02.333     0     0 E bcl_peripheral: bcl_poll_vbat_high Vbat reached high clear trip. vbat:3519750
04-13 22:03:02.335     0     0 I CPU3    : update max cpu_capacity 493
04-13 22:03:02.337     0     0 I CPU0    : update max cpu_capacity 496
04-13 22:03:02.982     0     0 E bcl_peripheral: bcl_handle_vbat Vbat reached Low trip. vbat:3297450
04-13 22:03:02.991  4362  4381 D GmsLocManagerSvcImpl: getLastLocationWithPackage: cab.snapp.passenger.play
04-13 22:03:02.985     0     0 I CPU0    : update max cpu_capacity 763
04-13 22:03:02.990     0     0 I CPU2    : update max cpu_capacity 1024
04-13 22:03:03.020  4362  4381 D GmsLocProviderReal: uh-ok: last location for gps is null!
04-13 22:03:03.051  3044  4890 W TelephonyPermissions: reportAccessDeniedToReadIdentifiers:cab.snapp.passenger.play:getSubscriptionInfoList:-1
04-13 22:03:03.082     0     0 E bcl_peripheral: bcl_poll_vbat_high Vbat reached high clear trip. vbat:4779450
04-13 22:03:03.086     0     0 I CPU2    : update max cpu_capacity 493
04-13 22:03:03.089     0     0 I CPU0    : update max cpu_capacity 496
04-13 22:03:03.140  1236 12937 I DropBoxManagerService: add tag=data_app_crash isTagEnabled=true flags=0x2
04-13 22:03:03.141  1236  6328 W ActivityTaskManager:   Force finishing activity cab.snapp.passenger.play/cab.snapp.passenger.activities.launcher.LauncherActivity
04-13 22:03:03.162 12803 12803 I Process : Sending signal. PID: 12803 SIG: 9
04-13 22:03:03.184  4362  4381 D GmsLocManagerSvcImpl: getLastLocationWithPackage: cab.snapp.passenger.play
04-13 22:03:03.185     0     0 E bcl_peripheral: bcl_handle_vbat Vbat reached Low trip. vbat:3149250
04-13 22:03:03.191     0     0 I CPU1    : update max cpu_capacity 763
04-13 22:03:03.193  1236  6328 I ActivityManager: Process cab.snapp.passenger.play (pid 12803) has died: fg  TOP 
04-13 22:03:03.195   555   555 I Zygote  : Process 12803 exited due to signal 9 (Killed)
04-13 22:03:03.196  4362  4381 D GmsLocProviderReal: uh-ok: last location for gps is null!
04-13 22:03:03.197  1236  1291 I libprocessgroup: Successfully killed process cgroup uid 10228 pid 12803 in 0ms
04-13 22:03:03.217  1236  6328 W ActivityManager: Scheduling restart of crashed service cab.snapp.passenger.play/com.webengage.sdk.android.ExecutorService in 4632ms for start-requested
04-13 22:03:03.261     0     0 I CPU2    : update max cpu_capacity 1024
04-13 22:03:03.285     0     0 E bcl_peripheral: bcl_poll_vbat_high Vbat reached high clear trip. vbat:4779450
04-13 22:03:03.266  1236  1279 W WindowManager: Failed looking up window session=Session{1cabd8c 1236:1000} callers=com.android.server.wm.WindowManagerService.windowForClientLocked:5446 com.android.server.wm.WindowManagerService.removeWindow:1900 com.android.server.wm.Session.remove:193 
04-13 22:03:03.307     0     0 I CPU2    : update max cpu_capacity 493
04-13 22:03:03.307     0     0 I CPU0    : update max cpu_capacity 496
04-13 22:03:03.351   719   719 D QCOM PowerHAL: LAUNCH HINT: OFF
04-13 22:03:03.353     0     0 I CPU3    : update max cpu_capacity 1024
04-13 22:03:03.352   972   989 E ANDR-PERF-RESOURCEQS: Failed to reset optimization [2, 1]
04-13 22:03:03.355   972   989 E ANDR-PERF-RESOURCEQS: Failed to reset optimization [2, 1]
04-13 22:03:03.404  2646  2683 I ndroid.systemu: NativeAlloc concurrent copying GC freed 245957(9250KB) AllocSpace objects, 0(0B) LOS objects, 54% free, 10MB/22MB, paused 51us total 243.561ms
04-13 22:03:03.645  1236  1278 W ActivityTaskManager: Activity top resumed state loss timeout for ActivityRecord{4cdf078 u0 cab.snapp.passenger.play/cab.snapp.passenger.activities.launcher.LauncherActivity t-1 f}}
04-13 22:03:03.921     0     0 I FG      : fg_soc_irq_handler: power_supply_changed by soc_irq with msoc 9
04-13 22:03:03.933     0     0 E vote    : name[BATTCHG_SUSPEND], client[BATTCHG_UNKNOWN_BATTERY_EN_VOTER,0], enabled[0], val[0]
04-13 22:03:03.934     0     0 D BATTCHG_SUSPEND: BATTCHG_UNKNOWN_BATTERY_EN_VOTER,0 same vote off of val=0
04-13 22:03:03.934     0     0 D BATTCHG_SUSPEND: BATTCHG_UNKNOWN_BATTERY_EN_VOTER,0 Ignoring similar vote off of val=0
04-13 22:03:03.934     0     0 E vote    : name[USB_ICL], client[PSY_ICL_VOTER,0], enabled[1], val[0]
04-13 22:03:03.934     0     0 D USB_ICL : PSY_ICL_VOTER,0 same vote on of val=0
04-13 22:03:03.934     0     0 D USB_ICL : PSY_ICL_VOTER,0 Ignoring similar vote on of val=0
04-13 22:03:03.948     0     0 W healthd : battery l=4 v=3576 t=34.2 h=2 st=2 c=189970 chg=u

System Android Version: 11 Custom ROM: LineageOS 18.1

ale5000-git commented 2 years ago

Could you please try the latest nightly build of microG GmsCore and report back if the problem still happens?

A-Shahbazi commented 2 years ago

I can confirm that the issue is fixed with the latest nightly.

mtlive commented 1 year ago

I have a similar problem with the same app even though I tried new releases (v0.2.27.223616 , v0.2.26.223616).

03-12 16:21:03.086 28184 28184 E AndroidRuntime: FATAL EXCEPTION: main
03-12 16:21:03.086 28184 28184 E AndroidRuntime: Process: cab.snapp.passenger, PID: 28184
03-12 16:21:03.086 28184 28184 E AndroidRuntime: java.lang.RuntimeException: Unable to resume activity {cab.snapp.passenger/cab.snapp.passenger.app_starter.LauncherActivity}: java.lang.StringIndexOutOfBoundsException: String index out of range: -1
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at android.app.ActivityThread.performResumeActivity(ActivityThread.java:3822)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at android.app.ActivityThread.handleResumeActivity(ActivityThread.java:3854)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at android.app.servertransaction.ResumeActivityItem.execute(ResumeActivityItem.java:51)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at android.app.servertransaction.TransactionExecutor.executeLifecycleState(TransactionExecutor.java:145)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at android.app.servertransaction.TransactionExecutor.execute(TransactionExecutor.java:70)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at android.app.ActivityThread$H.handleMessage(ActivityThread.java:1816)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at android.os.Handler.dispatchMessage(Handler.java:106)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at android.os.Looper.loop(Looper.java:193)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at android.app.ActivityThread.main(ActivityThread.java:6718)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at java.lang.reflect.Method.invoke(Native Method)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run(RuntimeInit.java:491)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:858)
03-12 16:21:03.086 28184 28184 E AndroidRuntime: Caused by: java.lang.StringIndexOutOfBoundsException: String index out of range: -1
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at java.lang.String.substring(String.java:2036)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at cab.snapp.passenger.framework.c.b.getServiceVersionName(SourceFile:36)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at cab.snapp.passenger.app_starter.units.splash.a.reportGooglePLayServiceVersion$impl_ProdRelease(SourceFile:282)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at cab.snapp.passenger.app_starter.units.splash.a.handleDefaultOnUnitResume(SourceFile:231)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at cab.snapp.passenger.app_starter.units.splash.a.onUnitResume(SourceFile:140)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at cab.snapp.arch.protocol.BaseController.onResume(SourceFile:62)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at androidx.fragment.app.Fragment.performResume(SourceFile:3180)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at androidx.fragment.app.FragmentStateManager.resume(SourceFile:606)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at androidx.fragment.app.FragmentStateManager.moveToExpectedState(SourceFile:285)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at androidx.fragment.app.FragmentStore.moveToExpectedState(SourceFile:113)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at androidx.fragment.app.FragmentManager.moveToState(SourceFile:1424)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at androidx.fragment.app.FragmentManager.dispatchStateChange(SourceFile:2968)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at androidx.fragment.app.FragmentManager.dispatchResume(SourceFile:2900)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at androidx.fragment.app.Fragment.performResume(SourceFile:3189)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at androidx.fragment.app.FragmentStateManager.resume(SourceFile:606)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at androidx.fragment.app.FragmentStateManager.moveToExpectedState(SourceFile:285)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at androidx.fragment.app.FragmentStore.moveToExpectedState(SourceFile:113)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at androidx.fragment.app.FragmentManager.moveToState(SourceFile:1424)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at androidx.fragment.app.FragmentManager.dispatchStateChange(SourceFile:2968)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at androidx.fragment.app.FragmentManager.dispatchResume(SourceFile:2900)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at androidx.fragment.app.FragmentController.dispatchResume(SourceFile:285)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at androidx.fragment.app.FragmentActivity.onResumeFragments(SourceFile:334)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at androidx.fragment.app.FragmentActivity.onPostResume(SourceFile:323)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at androidx.appcompat.app.AppCompatActivity.onPostResume(SourceFile:240)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at android.app.Activity.performResume(Activity.java:7325)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        at android.app.ActivityThread.performResumeActivity(ActivityThread.java:3814)
03-12 16:21:03.086 28184 28184 E AndroidRuntime:        ... 11 more
03-12 16:21:03.267 28184 28184 E WebEngage: App has crashed
03-12 16:21:03.267 28184 28184 E WebEngage: java.lang.RuntimeException: Unable to resume activity {cab.snapp.passenger/cab.snapp.passenger.app_starter.LauncherActivity}: java.lang.StringIndexOutOfBoundsException: String index out of range: -1
03-12 16:21:03.312 19731 19731 D MeasurementService: onBind: Intent { act=com.google.android.gms.measurement.START pkg=com.google.android.gms }
03-12 16:21:03.315 27907 27983 I AppMetrica-Attribution: Choosing distribution data: ClidsInfo(chosen=Candidate(clids=null, source=APP), candidates=[Candidate(clids=null, source=APP)])
03-12 16:21:03.330 27907 27983 I AppMetrica-Attribution: Choosing distribution data: ClidsInfo(chosen=Candidate(clids=null, source=APP), candidates=[Candidate(clids=null, source=APP)])
03-12 16:21:03.385 27907 27982 I AppMetrica-Attribution: Choosing distribution data: ClidsInfo(chosen=Candidate(clids=null, source=APP), candidates=[Candidate(clids=null, source=APP)])
03-12 16:21:03.615   672   688 W ActivityManager:   Force finishing activity cab.snapp.passenger/.app_starter.LauncherActivity
03-12 16:21:03.398 27907 27982 I AppMetrica-Attribution: Choosing distribution data: ClidsInfo(chosen=Candidate(clids=null, source=APP), candidates=[Candidate(clids=null, source=APP)])
03-12 16:21:03.680 28184 28184 I Process : Sending signal. PID: 28184 SIG: 9
03-12 16:21:03.703   672  2523 I ActivityManager: Process cab.snapp.passenger (pid 28184) has died: fore TOP
03-12 16:21:03.705   672   721 W libprocessgroup: kill(-28184, 9) failed: No such process
03-12 16:21:03.705   672   721 I libprocessgroup: Successfully killed process cgroup uid 10091 pid 28184 in 0ms

@A-Shahbazi Does it still work for you in the new version?

A-Shahbazi commented 11 months ago

Surprisingly the issue persists using 233515000 and 233013058 versions which are newer builds than the provided nightly. The culprit must be somewhere in between commits a749f34 and dd8c560 ?

A-Shahbazi commented 9 months ago

The cause of the crash seems to be different. Here's the part of logcat after launching app using microG v0.3.0.233515:

12-27 22:57:14.525     0     0 W dhdpcie_suspend_dev: Enter
12-27 22:57:14.548     0     0 I msm_pcie_disable: PCIe: Assert the reset of endpoint of RC0.
12-27 22:57:14.839  9971 12143 D org.fourthline.cling.protocol.async.ReceivingSearch: execute receiving search
12-27 22:57:14.840  9971 12143 D org.fourthline.cling.protocol.async.ReceivingSearch: Invalid search request, did not contain ST header: (IncomingSearchRequest) M-SEARCH
12-27 22:57:14.924     0     0 I         : [Touch] 1 finger pressed:<0>( 459,1126,  47)
12-27 22:57:14.942  1376  1388 E ANDR-PERF-MPCTL: Invalid profile no. 0, total profiles 0 only
12-27 22:57:14.947  1561  2096 E LightsService: Light requested not available on this device. 2
12-27 22:57:15.030     0     0 I         : [Touch]  finger released:<0>( 459,1126,  73)
12-27 22:57:15.046  1561 10699 I ActivityTaskManager: START u0 {act=android.intent.action.MAIN cat=[android.intent.category.LAUNCHER] flg=0x10200000 cmp=cab.snapp.passenger/.app_starter.LauncherActivity bnds=[313,915][584,1295]} from uid 10138
12-27 22:57:15.056  1093  1093 D QCOM PowerHAL: LAUNCH HINT: ON
12-27 22:57:15.058  1093  1093 D QCOM PowerHAL: Activity launch hint handled
12-27 22:57:15.089 11987 11987 D AppCompatDelegate: Checking for metadata for AppLocalesMetadataHolderService : Service not found
12-27 22:57:15.090  1561  1723 D CompatibilityChangeReporter: Compat change id reported: 136274596; UID 10237; state: ENABLED
12-27 22:57:15.113 11987 12019 D AppMeasurementService: Not yet implemented: onActivityCreated
12-27 22:57:15.144 11987 12019 D AppMeasurementService: Not yet implemented: onActivityStarted
12-27 22:57:15.181 11987 12019 D AppMeasurementService: Not yet implemented: setCurrentScreen
12-27 22:57:15.190 10115 11098 D LocationManager: bound by: GetServiceRequest{serviceId=LOCATION_MANAGER, gmsVersion=12451000, packageName='cab.snapp.passenger', extras=Bundle[{client_name=locationServices}]}
12-27 22:57:15.193 10115 10510 D LocationManager: registerLocationUpdates (callback) by cab.snapp.passenger
12-27 22:57:15.194 11987 12019 D AppMeasurementService: Not yet implemented: onActivityResumed
12-27 22:57:15.198 10115 10510 D LocationManager: requestLocationSettingsDialog by cab.snapp.passenger
12-27 22:57:15.204 11987 11987 D AndroidRuntime: Shutting down VM
12-27 22:57:15.205 11987 11987 E AndroidRuntime: FATAL EXCEPTION: main
12-27 22:57:15.205 11987 11987 E AndroidRuntime: Process: cab.snapp.passenger, PID: 11987
12-27 22:57:15.205 11987 11987 E AndroidRuntime: java.lang.RuntimeException: Unable to resume activity {cab.snapp.passenger/cab.snapp.passenger.app_starter.LauncherActivity}: java.lang.StringIndexOutOfBoundsException: String index out of range: -1
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at android.app.ActivityThread.performResumeActivity(ActivityThread.java:4438)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at android.app.ActivityThread.handleResumeActivity(ActivityThread.java:4470)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at android.app.servertransaction.ResumeActivityItem.execute(ResumeActivityItem.java:52)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at android.app.servertransaction.TransactionExecutor.executeLifecycleState(TransactionExecutor.java:176)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at android.app.servertransaction.TransactionExecutor.execute(TransactionExecutor.java:97)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at android.app.ActivityThread$H.handleMessage(ActivityThread.java:2066)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at android.os.Handler.dispatchMessage(Handler.java:106)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at android.os.Looper.loop(Looper.java:223)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at android.app.ActivityThread.main(ActivityThread.java:7664)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at java.lang.reflect.Method.invoke(Native Method)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run(RuntimeInit.java:592)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:947)
12-27 22:57:15.205 11987 11987 E AndroidRuntime: Caused by: java.lang.StringIndexOutOfBoundsException: String index out of range: -1
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at java.lang.String.substring(String.java:2064)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at cab.snapp.passenger.framework.c.b.getServiceVersionName(SourceFile:36)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at cab.snapp.passenger.app_starter.units.splash.a.reportGooglePLayServiceVersion$impl_productionOrganic1Release(SourceFile:341)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at cab.snapp.passenger.app_starter.units.splash.a.handleDefaultOnUnitResume(SourceFile:283)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at cab.snapp.passenger.app_starter.units.splash.a.onUnitResume(SourceFile:161)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at cab.snapp.arch.protocol.BaseController.onResume(SourceFile:55)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at androidx.fragment.app.Fragment.performResume(SourceFile:3205)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at androidx.fragment.app.FragmentStateManager.resume(SourceFile:646)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at androidx.fragment.app.FragmentStateManager.moveToExpectedState(SourceFile:296)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at androidx.fragment.app.FragmentStore.moveToExpectedState(SourceFile:114)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at androidx.fragment.app.FragmentManager.moveToState(SourceFile:1455)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at androidx.fragment.app.FragmentManager.dispatchStateChange(SourceFile:3034)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at androidx.fragment.app.FragmentManager.dispatchResume(SourceFile:2966)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at androidx.fragment.app.Fragment.performResume(SourceFile:3214)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at androidx.fragment.app.FragmentStateManager.resume(SourceFile:646)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at androidx.fragment.app.FragmentStateManager.moveToExpectedState(SourceFile:296)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at androidx.fragment.app.FragmentStore.moveToExpectedState(SourceFile:114)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at androidx.fragment.app.FragmentManager.moveToState(SourceFile:1455)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at androidx.fragment.app.FragmentManager.dispatchStateChange(SourceFile:3034)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at androidx.fragment.app.FragmentManager.dispatchResume(SourceFile:2966)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at androidx.fragment.app.FragmentController.dispatchResume(SourceFile:285)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at androidx.fragment.app.FragmentActivity.onResumeFragments(SourceFile:333)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at androidx.fragment.app.FragmentActivity.onPostResume(SourceFile:322)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at androidx.appcompat.app.AppCompatActivity.onPostResume(SourceFile:245)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at android.app.Activity.performResume(Activity.java:8154)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    at android.app.ActivityThread.performResumeActivity(ActivityThread.java:4428)
12-27 22:57:15.205 11987 11987 E AndroidRuntime:    ... 11 more
12-27 22:57:15.211 10115 10115 W SafeParcel: class com.google.android.gms.location.LocationSettingsResult has no default constructor
12-27 22:57:15.218 10115 10115 W SafeParcel: class com.google.android.gms.location.LocationSettingsStates has no default constructor
12-27 22:57:15.221 10115 10160 D NetworkLocation: Schedule high-power scan now
12-27 22:57:15.223  1561  2086 I WifiService: startScan uid=10158
12-27 22:57:15.229  1561  1719 W LocationManagerService: blocking 0,0 location from gps provider
12-27 22:57:15.234 11987 11987 E WebEngage: App has crashed
12-27 22:57:15.234 11987 11987 E WebEngage: java.lang.RuntimeException: Unable to resume activity {cab.snapp.passenger/cab.snapp.passenger.app_starter.LauncherActivity}: java.lang.StringIndexOutOfBoundsException: String index out of range: -1
12-27 22:57:15.240 10115 10160 D NetworkLocation: Schedule high-power scan in 9981ms
12-27 22:57:15.248  9861  9861 I AlertService: onNotificationPosted.............
12-27 22:57:15.250  9861  9861 I AlertService: text -- ▼ 171 b/s 7.5 MiB  ▲ 245 b/s 658.8 KiB
12-27 22:57:15.250  9861  9861 I AlertService: title -- TOR & DNSCRYPT
12-27 22:57:15.250  9861  9861 I AlertService: tickerText:null
12-27 22:57:15.250  9861  9861 I AlertService: extrasText:▼ 171 b/s 7.5 MiB  ▲ 245 b/s 658.8 KiB
12-27 22:57:15.250  9861  9861 I AlertService: messageContent:▼ 171 b/s 7.5 MiB  ▲ 245 b/s 658.8 KiB
12-27 22:57:15.250  9861  9861 I AlertService: messageLength:10
12-27 22:57:15.250  9861  9861 I AlertService: band_type:0
12-27 22:57:15.262     0     0 I CFG80211-TRACE) __wl_cfg80211_scan: START SCAN
12-27 22:57:15.262     0     0 W         : Runtime Resume is called in wl_cfg80211_scan
12-27 22:57:15.262     0     0 I msm_pcie_enable: PCIe: Assert the reset of endpoint of RC0.
12-27 22:57:15.267     0     0 I msm_pcie_enable: PCIe RC0 PHY is ready!
12-27 22:57:15.278     0     0 I msm_pcie_enable: PCIe: Release the reset of endpoint of RC0.
12-27 22:57:15.291 11887 11963 I AppMetrica-Attribution: Choosing distribution data: ClidsInfo(chosen=Candidate(clids=null, source=APP), candidates=[Candidate(clids=null, source=APP)])
12-27 22:57:15.314     0     0 I msm_pcie_enable: PCIe RC0 link initialized
12-27 22:57:15.314     0     0 W dhdpcie_resume_dev: Enter
12-27 22:57:15.316     0     0 W         : DHD Runtime PM Disabled
12-27 22:57:15.312 11887 11963 I AppMetrica-Attribution: Choosing distribution data: ClidsInfo(chosen=Candidate(clids=null, source=APP), candidates=[Candidate(clids=null, source=APP)])
12-27 22:57:15.368 11987 12019 D AppMeasurementService: Not yet implemented: logEvent
12-27 22:57:15.370  1166  1166 E Layer   : [Surface(name=Task=1352)/@0xab04667 - animation-leash#0] No local sync point found
12-27 22:57:15.370  1166  1166 E Layer   : [Surface(name=Task=1352)/@0xab04667 - animation-leash#0] No local sync point found
12-27 22:57:15.370  1166  1166 E Layer   : [Surface(name=Task=1)/@0x2965cf1 - animation-leash#0] No local sync point found
12-27 22:57:15.370  1166  1166 E Layer   : [Surface(name=Task=1)/@0x2965cf1 - animation-leash#0] No local sync point found
12-27 22:57:15.493 11887 11962 I AppMetrica-Attribution: Choosing distribution data: ClidsInfo(chosen=Candidate(clids=null, source=APP), candidates=[Candidate(clids=null, source=APP)])
12-27 22:57:15.869 11987 12178 W FirebaseCrashlytics: Timeout exceeded while awaiting app exception callback from Analytics listener.
12-27 22:57:15.873  1561 12180 I DropBoxManagerService: add tag=data_app_crash isTagEnabled=true flags=0x2
12-27 22:57:15.873  1561 10699 W ActivityTaskManager:   Force finishing activity cab.snapp.passenger/.app_starter.LauncherActivity
12-27 22:57:15.882  1561 12180 W DropBoxManagerService: Dropping: data_app_crash (3370 > 0 bytes)
12-27 22:57:15.988     0     0 I FG      : update_sram_data: soc:[74], soc_raw[7036], voltage:[3923469], ocv:[4026313], current:[373838], batt_temp:[327], charge_raw [1790268 / 3167000]
12-27 22:57:16.048  2268  2303 I ndroid.systemu: NativeAlloc concurrent copying GC freed 52341(2509KB) AllocSpace objects, 4(80KB) LOS objects, 49% free, 12MB/24MB, paused 51us total 153.852ms
12-27 22:57:16.053  2268  2304 W JavaBinder: BinderProxy is being destroyed but the application did not call unlinkToDeath to unlink all of its death recipients beforehand.  Releasing leaked death recipient: com.android.systemui.qs.external.TileLifecycleManager
12-27 22:57:16.053  2268  2304 I BpBinder: onLastStrongRef automatically unlinking death recipients: <uncached descriptor>
12-27 22:57:16.053  2268  2304 W JavaBinder: BinderProxy is being destroyed but the application did not call unlinkToDeath to unlink all of its death recipients beforehand.  Releasing leaked death recipient: com.android.systemui.qs.external.TileLifecycleManager
12-27 22:57:16.053  2268  2304 I BpBinder: onLastStrongRef automatically unlinking death recipients: <uncached descriptor>
12-27 22:57:16.053  2268  2304 W JavaBinder: BinderProxy is being destroyed but the application did not call unlinkToDeath to unlink all of its death recipients beforehand.  Releasing leaked death recipient: com.android.systemui.qs.external.TileLifecycleManager
12-27 22:57:16.053  2268  2304 I BpBinder: onLastStrongRef automatically unlinking death recipients: <uncached descriptor>
12-27 22:57:16.374  1561  1723 W ActivityTaskManager: Activity top resumed state loss timeout for ActivityRecord{7e5aaaa u0 cab.snapp.passenger/.app_starter.LauncherActivity t1352 f}}
12-27 22:57:16.387  1561  1723 W ActivityTaskManager: Activity pause timeout for ActivityRecord{7e5aaaa u0 cab.snapp.passenger/.app_starter.LauncherActivity t1352 f}}
12-27 22:57:16.437  1093  1093 D QCOM PowerHAL: LAUNCH HINT: OFF
12-27 22:57:16.439  1376  1388 E ANDR-PERF-RESOURCEQS: Failed to reset optimization [2, 1]
12-27 22:57:16.439  1376  1388 E ANDR-PERF-RESOURCEQS: Failed to reset optimization [2, 1]
12-27 22:57:17.357  9971 10040 I Registry: Maintaining registry...
12-27 22:57:17.357  9971 10040 I Registry: Device '(RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:cb7b4a0c-8946-44b9-8122-30cc86111715, Descriptor: http://192.168.1.100:1313/, Root: true' expires in seconds: 1666
12-27 22:57:17.357  9971 10040 I Registry: Device '(RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:4d696e69-444c-164e-9d41-264a9178759c, Descriptor: http://192.168.1.106:8200/rootDesc.xml, Root: true' expires in seconds: 1561
12-27 22:57:17.357  9971 10040 I Registry: Device '(RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:3afeb097-d869-a0a5-7a4d-13c01e3fe9a2, Descriptor: http://192.168.1.100:1874/, Root: true' expires in seconds: 1669
12-27 22:57:17.357  9971 10040 I Registry: Device '(RemoteDevice) Identity: (RemoteDeviceIdentity) UDN: uuid:91aa832e-f65a-4893-e704-542bf06572d0, Descriptor: http://192.168.1.100:1426/, Root: true' expires in seconds: 1670
12-27 22:57:17.357  9971 10040 I Registry: Executing pending operations: 0
12-27 22:57:18.295  9861  9861 I AlertService: onNotificationPosted.............
12-27 22:57:18.297  9861  9861 I AlertService: text -- ▼ 15  kb/s 7.5 MiB  ▲ 19  kb/s 665.6 KiB
12-27 22:57:18.298  9861  9861 I AlertService: title -- TOR & DNSCRYPT
12-27 22:57:18.298  9861  9861 I AlertService: tickerText:null
12-27 22:57:18.298  9861  9861 I AlertService: extrasText:▼ 15  kb/s 7.5 MiB  ▲ 19  kb/s 665.6 KiB
12-27 22:57:18.298  9861  9861 I AlertService: messageContent:▼ 15  kb/s 7.5 MiB  ▲ 19  kb/s 665.6 KiB
12-27 22:57:18.298  9861  9861 I AlertService: messageLength:10
12-27 22:57:18.299  9861  9861 I AlertService: band_type:0
A-Shahbazi commented 8 months ago

I can confirm this is fixed using latest nightly df6f331

mortezadadgar commented 2 months ago

I don't think it's fixed see https://github.com/microg/GmsCore/issues/1899