Android apps do not start

Bug Reports
#1

REPRODUCIBILITY (% or how often):
BUILD ID = OS VERSION (Settings > About product): 4.0.1.48
HARDWARE (Xperia 10):
UI LANGUAGE: English (US)
REGRESSION: (compared to previous public release: Yes, No, ?): Yes

DESCRIPTION: On my wife’s phone, Android apps no longer work after upgrade to 4.0.1.45 or .48.

I upgraded my Xperia 10 Plus at each release and my Android apps work fine. I felt the .48 release was solid and upgraded her phone. Not as fortunate.

I have waded through forum threads and followed the “brutal” option that Jolla provides on their FAQ. I have since flashed her phone four times.

When I flashed directly to 3.4.0.24 and loaded Android Support, then Here Maps, it worked. OTA upgrade to 4.1.0.48 and Aliendalvik is still running. I verified via SSH, systemctl status aliendalvik, reports status as running. I then enter apkd-launcher com.android.settings and on the phone the Android settings does appear.

With the release of the 4.1.0.48 image, I downloaded that today, removed her memory card (just to be ultra thorough, reformatted in on a Linux computer to ext4 and left it blank), then flashed her phone directly to 4.1.0.48.

I only today learned how to skip the tutorial (WHEW!). I entered her Jolla credentials, it shows that she has Predictive Text, Exchange and Android support available. Download those right away, let Sailfish install the native apps, then go to the Store and get Here Maps, installs, then click to run and Here logo splash screen appears, then app minimizes down with a black preview window.

In SSH session, journalctl -f reveals the following as I click on Here Maps on her phone

Feb 16 20:59:22 Xperia10 kernel: binder: 18646 RLIMIT_NICE not set
Feb 16 20:59:22 Xperia10 kernel: binder: 18513 RLIMIT_NICE not set
Feb 16 20:59:25 Xperia10 kernel: binder: 18646 RLIMIT_NICE not set
Feb 16 20:59:25 Xperia10 kernel: binder: 18513 RLIMIT_NICE not set
Feb 16 20:59:28 Xperia10 kernel: binder: 18646 RLIMIT_NICE not set
Feb 16 20:59:28 Xperia10 kernel: binder: 18513 RLIMIT_NICE not set
Feb 16 20:59:31 Xperia10 kernel: binder: 18646 RLIMIT_NICE not set
Feb 16 20:59:31 Xperia10 kernel: binder: 18513 RLIMIT_NICE not set
Feb 16 20:59:32 Xperia10 apkd[17057]: Launching com.here.app.maps
Feb 16 20:59:33 Xperia10 lipstick[7119]: [D] unknown:0 - Specified Desktop file does not exist “/usr/share/applications/system_server.desktop”
Feb 16 20:59:33 Xperia10 invoker[7851]: WARNING: An inactive plugin is misbehaving - tried to show a window!
Feb 16 20:59:33 Xperia10 invoker[7851]: WARNING: requestActivate() called for QQuickView(0xff5888) which has Qt::WindowDoesNotAcceptFocus set.
Feb 16 20:59:34 Xperia10 kernel: binder: 18646 RLIMIT_NICE not set
Feb 16 20:59:34 Xperia10 kernel: binder: 18513 RLIMIT_NICE not set

The same errors did occur when I previously upgraded from 3.4.0.24 to 4.1.0.48.

I ensure it is not just Here Maps that is being problematic, I downloaded a simple HP 48SX emulator via APKPure’s website (not via app, obviously), clicked on it. I can see it install. Click on the icon:

Feb 16 21:06:35 Xperia10 apkd[17057]: Launching org.czo.droid48sx
Feb 16 21:06:35 Xperia10 lipstick[7119]: [D] unknown:0 - Specified Desktop file does not exist “/usr/share/applications/system_server.desktop”
Feb 16 21:06:35 Xperia10 invoker[7851]: WARNING: An inactive plugin is misbehaving - tried to show a window!
Feb 16 21:06:35 Xperia10 invoker[7851]: WARNING: requestActivate() called for QQuickView(0xff5888) which has Qt::WindowDoesNotAcceptFocus set.

Any help that can be provided is greatly appreciated.

2 Likes
#2

I have similar issues on 4.0.1.48, I wonder is it due the Api level update? In my case no Android app launches 100% time, and after a while phone just restarts, probably due Alien Dalvik, so I just disabled Alien Dalvik to start on startup.

And yes I have Sony Xperia 10 aswell

#3

Hi,

I had a similar issue on Xperia X and this message helped me solve the issue (activate developer settings, go to the terminal app) :

devel-su
pkcon remove harbour-themepacksupport
systemctl start aliendalvik
1 Like
UI-Themer missing from OpenRepos
#4

That did it for me, thanks so much! :slight_smile:

#5

I will try that tonight. I am curious, is harbour-themepacksupport part of the baseline Sailfish installation? Since I’ve wiped the phone and flashed with 4.1.0.48 directly, there aren’t any other apps installed. But I will give it a try.

Thank you.

#6

I am actually considering a risky move - to back up my phone, wipe it and flash directly 4.1.0.48, too. I will then see if Android works on my phone still.

#7

I tried your suggestion. I theorized themepacksupport was not part of the default installation of Sailfish, but I tried nonetheless.

| Sailfish OS 4.0.1.48 (Koli)
'—
[defaultuser@Xperia10 ~]$ devel-su
Password:
[root@Xperia10 defaultuser]# systemctl stop aliendalvik
[root@Xperia10 defaultuser]# pkcon remove harbour-themepacksupport
Resolving [ ] (0%) Package not found: harbour-themepacksupport
Command failed: This tool could not find the installed package: No packages were found
[root@Xperia10 defaultuser]# systemctl start aliendalvik

Still no resolution. I feel so ignorant at this point. Any other suggestions?

#8

Continuing my search, I found in TJC info about Android debugged. I then followed instructions from Jolla Zendesk to obtain Android logs. I will post just a few seconds before trying to run the simple HP48SX app and maybe there is someone who has understanding to decipher it.

02-20 16:27:00.058 87 99 I SurfaceFlinger: ALIEN: discarding frame without app/window (system process).
02-20 16:27:32.782 87 118 D BatteryStatsImpl: Got readings for an invalid user’s uid 100000
02-20 16:27:32.782 87 118 D KernelUidCpuTimeReader: Removing uids 100000-100000
02-20 16:27:32.787 87 118 E KernelWakelockReader: neither /proc/wakelocks nor /d/wakeup_sources exists
02-20 16:27:32.788 87 118 W BatteryStatsImpl: Couldn’t get kernel wake lock stats
02-20 16:27:33.140 87 124 I ALIEN : alien processing window (de-)activation: 0. TARGET/SOURCE PKG: org.czo.droid48sx
02-20 16:27:33.146 87 124 I ALIEN : alien relaunching app: org.czo.droid48sx
02-20 16:27:33.147 87 124 I ActivityManager: START u0 {act=android.intent.action.MAIN cat=[android.intent.category.LAUNCHER] flg=0x10004000 pkg=org.czo.droid48sx cmp=org.czo.droid48sx/.X48} from uid 1000
02-20 16:27:30.707 87 99 I chatty : uid=1000(system) SFThread identical 3 lines
02-20 16:27:33.183 87 99 I SurfaceFlinger: ALIEN: discarding frame without app/window (system process).
02-20 16:27:33.191 526 526 D FakeHome: onPause
02-20 16:27:33.205 87 230 E ActivityManager: applyOptionsLocked: Unknown animationType=0
02-20 16:27:33.208 87 99 I SurfaceFlinger: ALIEN: discarding frame without app/window (system process).
02-20 16:27:33.253 87 114 I ActivityManager: Start proc 862:org.czo.droid48sx/u0a40 for activity org.czo.droid48sx/.X48
02-20 16:27:33.254 862 862 E libprocessgroup: Failed to make and chown /acct/uid_10040: Read-only file system
02-20 16:27:33.254 862 862 W Zygote : createProcessGroup failed, kernel missing CONFIG_CGROUP_CPUACCT?
02-20 16:27:33.254 862 862 I Zygote : seccomp disabled by setenforce 0
02-20 16:27:33.257 87 99 I SurfaceFlinger: ALIEN: discarding frame without app/window (system process).
02-20 16:27:33.260 862 862 E g.czo.droid48s: Not starting debugger since process cannot load the jdwp agent.
02-20 16:27:33.287 87 99 I SurfaceFlinger: ALIEN: discarding frame without app/window (system process).
02-20 16:27:33.337 87 99 I chatty : uid=1000(system) SFThread identical 3 lines
02-20 16:27:33.369 87 99 I SurfaceFlinger: ALIEN: discarding frame without app/window (system process).
02-20 16:27:33.393 87 99 I SurfaceFlinger: ALIEN: new app: org.czo.droid48sx vs system
02-20 16:27:33.398 87 99 I SurfaceFlinger: ALIEN: preparing new window @0xcfd2ed80-0xcfd2ed80-org.czo.droid48sx
02-20 16:27:33.398 87 99 I SurfaceFlinger: ALIEN: raising window: org.czo.droid48sx
02-20 16:27:33.404 862 862 I x48 : starting activity
02-20 16:27:33.416 862 862 D AndroidRuntime: Shutting down VM
02-20 16:27:33.418 862 862 E AndroidRuntime: FATAL EXCEPTION: main
02-20 16:27:33.418 862 862 E AndroidRuntime: Process: org.czo.droid48sx, PID: 862
02-20 16:27:33.418 862 862 E AndroidRuntime: java.lang.RuntimeException: Unable to start activity ComponentInfo{org.czo.droid48sx/org.czo.droid48sx.X48}: java.lang.NullPointerException: Attempt to invoke virtual method ‘java.lang.String java.lang.String.replace(java.lang.CharSequence, java.lang.CharSequence)’ on a null object reference
02-20 16:27:33.418 862 862 E AndroidRuntime: at android.app.ActivityThread.performLaunchActivity(ActivityThread.java:2913)
02-20 16:27:33.418 862 862 E AndroidRuntime: at android.app.ActivityThread.handleLaunchActivity(ActivityThread.java:3048)
02-20 16:27:33.418 862 862 E AndroidRuntime: at android.app.servertransaction.LaunchActivityItem.execute(LaunchActivityItem.java:78)
02-20 16:27:33.418 862 862 E AndroidRuntime: at android.app.servertransaction.TransactionExecutor.executeCallbacks(TransactionExecutor.java:108)
02-20 16:27:33.418 862 862 E AndroidRuntime: at android.app.servertransaction.TransactionExecutor.execute(TransactionExecutor.java:68)
02-20 16:27:33.418 862 862 E AndroidRuntime: at android.app.ActivityThread$H.handleMessage(ActivityThread.java:1808)
02-20 16:27:33.418 862 862 E AndroidRuntime: at android.os.Handler.dispatchMessage(Handler.java:106)
02-20 16:27:33.418 862 862 E AndroidRuntime: at android.os.Looper.loop(Looper.java:193)
02-20 16:27:33.418 862 862 E AndroidRuntime: at android.app.ActivityThread.main(ActivityThread.java:6669)
02-20 16:27:33.418 862 862 E AndroidRuntime: at java.lang.reflect.Method.invoke(Native Method)
02-20 16:27:33.418 862 862 E AndroidRuntime: at com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run(RuntimeInit.java:493)
02-20 16:27:33.418 862 862 E AndroidRuntime: at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:858)
02-20 16:27:33.418 862 862 E AndroidRuntime: Caused by: java.lang.NullPointerException: Attempt to invoke virtual method ‘java.lang.String java.lang.String.replace(java.lang.CharSequence, java.lang.CharSequence)’ on a null object reference
02-20 16:27:33.418 862 862 E AndroidRuntime: at android.os.Parcel.createException(Parcel.java:1956)
02-20 16:27:33.418 862 862 E AndroidRuntime: at android.os.Parcel.readException(Parcel.java:1918)
02-20 16:27:33.418 862 862 E AndroidRuntime: at android.os.Parcel.readException(Parcel.java:1868)
02-20 16:27:33.418 862 862 E AndroidRuntime: at android.os.storage.IStorageManager$Stub$Proxy.getVolumeList(IStorageManager.java:895)
02-20 16:27:33.418 862 862 E AndroidRuntime: at android.os.storage.StorageManager.getVolumeList(StorageManager.java:1169)
02-20 16:27:33.418 862 862 E AndroidRuntime: at android.os.Environment$UserEnvironment.getExternalDirs(Environment.java:91)
02-20 16:27:33.418 862 862 E AndroidRuntime: at android.os.Environment$UserEnvironment.buildExternalStorageAppFilesDirs(Environment.java:135)
02-20 16:27:33.418 862 862 E AndroidRuntime: at android.os.Environment.buildExternalStorageAppFilesDirs(Environment.java:783)
02-20 16:27:33.418 862 862 E AndroidRuntime: at android.app.ContextImpl.getExternalFilesDirs(ContextImpl.java:665)
02-20 16:27:33.418 862 862 E AndroidRuntime: at android.app.ContextImpl.getExternalFilesDir(ContextImpl.java:658)
02-20 16:27:33.418 862 862 E AndroidRuntime: at android.content.ContextWrapper.getExternalFilesDir(ContextWrapper.java:249)
02-20 16:27:33.418 862 862 E AndroidRuntime: at org.czo.droid48sx.X48.onCreate(X48.java:62)
02-20 16:27:33.418 862 862 E AndroidRuntime: at android.app.Activity.performCreate(Activity.java:7136)
02-20 16:27:33.418 862 862 E AndroidRuntime: at android.app.Activity.performCreate(Activity.java:7127)
02-20 16:27:33.418 862 862 E AndroidRuntime: at android.app.Instrumentation.callActivityOnCreate(Instrumentation.java:1271)
02-20 16:27:33.418 862 862 E AndroidRuntime: at android.app.ActivityThread.performLaunchActivity(ActivityThread.java:2893)
02-20 16:27:33.418 862 862 E AndroidRuntime: … 11 more
02-20 16:27:33.418 862 862 E AndroidRuntime: Caused by: android.os.RemoteException: Remote stack trace:
02-20 16:27:33.418 862 862 E AndroidRuntime: at android.os.storage.VolumeInfo.getInternalPathForUser(VolumeInfo.java:323)
02-20 16:27:33.418 862 862 E AndroidRuntime: at android.os.storage.VolumeInfo.buildStorageVolume(VolumeInfo.java:344)
02-20 16:27:33.418 862 862 E AndroidRuntime: at com.android.server.StorageManagerService.getVolumeList(StorageManagerService.java:2769)