766611 - Launching and closing an app, then removing it from the activity list, then re-launching it causes it to never launch ever again

Status: RESOLVED WORKSFORME

(Firefox for Android Graveyard :: Web Apps (PWAs), defect)

Description

[Jason Smith [:jsmith]]

Steps:

1. Install a web application on the latest nightly
2. Launch the web application and close it
3. Go to the activity list and select to remove the app from the list
4. Try to re-launch the application

Expected:

The app launches successfully at the starting point of its launch path.

Actual:

A white screen of nothingness appears. The app never loads.

Comment 1

[Jason Smith [:jsmith]]

Build: 6/20 Nightly
Phone: Samsung Galaxy Nexus
Android OS: 4.04

Comment 2

[Aaron Train [:aaronmt]]

In step 2, define closing?

Also, logs?

Comment 3

[Jason Smith [:jsmith]]

(In reply to Aaron Train [:aaronmt] from comment #2)
> In step 2, define closing?

Hitting the home screen button.

> 
> Also, logs?

At the re-launching point here's what I see:

06-20 11:20:48.679: I/ActivityManager(183): START {act=org.mozilla.gecko.WEBAPP3 dat=https://marketplace-dev.allizom.org/ flg=0x10000000 cmp=org.mozilla.fennec/.WebApps$WebApp3 bnds=[200,185][360,385]} from pid 410
06-20 11:20:48.758: W/GeckoApp(24975): zerdatime 29664193 - onNewIntent
06-20 11:20:48.758: I/GeckoApp(24975): Intent : WEBAPP (org.mozilla.gecko.WEBAPP3) - https://marketplace-dev.allizom.org/
06-20 11:20:48.758: I/GeckoApp(24975): restart
06-20 11:20:48.758: W/GeckoApp(24975): zerdatime 29664194 - onStart
06-20 11:20:48.758: I/GeckoApp(24975): start
06-20 11:20:48.758: I/GeckoApp(24975): resume
06-20 11:20:48.758: I/GeckoApp(24975): application resumed
06-20 11:20:48.828: I/Gecko(24975): [AccessFu] Explore by touch: false
06-20 11:20:48.859: D/OpenGLRenderer(410): Flushing caches (mode 0)
06-20 11:20:48.867: I/GeckoScreenshot(24975): rect: -795.000000, 0.000000, 360.000000, 625.000000
06-20 11:20:49.047: D/OpenGLRenderer(410): Flushing caches (mode 1)

I'll go through the steps again to see if I noticed anything odd, as nothing stands out odd here from first glance.

Comment 4

[Jason Smith [:jsmith]]

Logs from step 3 to step 4:

06-20 11:26:06.008: D/dalvikvm(263): GC_CONCURRENT freed 637K, 37% free 14837K/23431K, paused 5ms+5ms
06-20 11:26:06.117: D/dalvikvm(263): GC_CONCURRENT freed 83K, 35% free 15460K/23431K, paused 2ms+4ms
06-20 11:26:06.492: D/dalvikvm(263): GC_CONCURRENT freed 41K, 31% free 16298K/23431K, paused 2ms+4ms
06-20 11:26:06.937: D/dalvikvm(263): GC_CONCURRENT freed 26K, 26% free 17409K/23431K, paused 4ms+3ms
06-20 11:26:11.554: I/GeckoApp(25718): destroy
06-20 11:26:11.554: I/ActivityManager(183): Killing 25473:org.mozilla.fennec/10035: remove task
06-20 11:26:11.562: D/GeckoFavicons(25718): Closing Favicons database
06-20 11:26:11.640: I/ActivityManager(183): Process org.mozilla.fennec (pid 25473) has died.
06-20 11:26:11.640: I/WindowManager(183): WIN DEATH: Window{418ad658 org.mozilla.fennec/org.mozilla.fennec.App paused=false}
06-20 11:26:11.640: W/WindowManager(183): Force-removing child win Window{419980c0 SurfaceView paused=false} from container Window{418ad658 org.mozilla.fennec/org.mozilla.fennec.App paused=false}
06-20 11:26:11.734: D/dalvikvm(263): GC_CONCURRENT freed 78K, 20% free 18828K/23431K, paused 2ms+5ms
06-20 11:26:16.414: I/ActivityManager(183): START {act=android.intent.action.MAIN cat=[android.intent.category.HOME] flg=0x10200000 cmp=com.android.launcher/com.android.launcher2.Launcher} from pid 183
06-20 11:26:16.531: D/dalvikvm(183): GC_EXPLICIT freed 1184K, 30% free 25916K/36743K, paused 3ms+8ms
06-20 11:26:16.781: D/OpenGLRenderer(263): Flushing caches (mode 0)
06-20 11:26:16.984: W/InputManagerService(183): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@42005628
06-20 11:26:19.609: I/ActivityManager(183): START {act=org.mozilla.gecko.WEBAPP4 dat=http://www.lordofultima.com/?utm_medium=referral&utm_campaign=Mozilla flg=0x10000000 cmp=org.mozilla.fennec/.WebApps$WebApp4 bnds=[360,185][520,385]} from pid 410
06-20 11:26:19.711: I/DEBUG(25718): xxx WebApp
06-20 11:26:19.711: D/dalvikvm(25718): Trying to load lib /data/data/org.mozilla.fennec/lib/libmozglue.so 0x4169a168
06-20 11:26:19.711: D/dalvikvm(25718): Shared lib '/data/data/org.mozilla.fennec/lib/libmozglue.so' already loaded in same CL 0x4169a168
06-20 11:26:19.711: W/GeckoApp(25718): zerdatime 29995146 - onCreate
06-20 11:26:19.719: I/GeckoViewsFactory(25718): Creating custom Gecko view: FormAssistPopup
06-20 11:26:19.719: W/GeckoApp(25718): zerdatime 29995152 - start of getPluginDirectories
06-20 11:26:19.719: W/GeckoApp(25718): zerdatime 29995152 - onStart
06-20 11:26:19.719: I/GeckoApp(25718): start
06-20 11:26:19.726: I/GeckoApp(25718): resume
06-20 11:26:19.726: W/GeckoApp(25718): Loading plugin: com.adobe.flashplayer
06-20 11:26:19.765: W/GeckoApp(25718): zerdatime 29995201 - end of getPluginDirectories
06-20 11:26:19.765: I/GeckoAppShell(25718): dir: /data/data/com.adobe.flashplayer/lib
06-20 11:26:19.765: I/Gecko(25718): [AccessFu] Explore by touch: false
06-20 11:26:19.765: I/GeckoAppShell(25718): env0: null
06-20 11:26:19.773: E/GeckoLibLoad(25718): Loaded libs in 0ms total, 0ms user, 0ms system, 0 faults
06-20 11:26:19.820: D/OpenGLRenderer(410): Flushing caches (mode 1)
06-20 11:26:19.836: D/OpenGLRenderer(410): Flushing caches (mode 0)
06-20 11:26:19.844: W/GeckoProfile(25718): zerdatime 29995274 - start check sessionstore.js exists
06-20 11:26:19.844: W/GeckoProfile(25718): zerdatime 29995275 - finish check sessionstore.js exists
06-20 11:26:19.844: D/GeckoFavicons(25718): Creating Favicons instance
06-20 11:26:19.844: I/GeckoApp(25718): Checking profile migration in: /data/data/org.mozilla.fennec/files/mozilla/oak33s9o.webapp4
06-20 11:26:19.844: D/GeckoFavicons(25718): Creating DatabaseHelper
06-20 11:26:19.844: W/GeckoApp(25718): zerdatime 29995275 - UI almost up
06-20 11:26:19.875: D/dalvikvm(25718): GC_CONCURRENT freed 366K, 4% free 13292K/13767K, paused 2ms+4ms
06-20 11:26:19.898: W/GeckoApp(25718): zerdatime 29995331 - pre checkLaunchState
06-20 11:26:20.023: I/ActivityManager(183): Displayed org.mozilla.fennec/.WebApps$WebApp4: +340ms

Comment 5

[Jason Smith [:jsmith]]

Nominating for k9o - this is a very bad user experience if a user ever hits this.

Comment 6

[Kevin Brosnan [Ex-Mozilla]]

Jason what was the qawanted for?

Comment 7

[Jason Smith [:jsmith]]

(In reply to Kevin Brosnan [:kbrosnan] from comment #6)
> Jason what was the qawanted for?

I think qawanted was flagged originally from the 2nd android webrt triage to re-test this to make sure it's still occurring on the latest nightly.

Comment 8

[Jason Smith [:jsmith]]

Apparently some other patch we landed must have fixed this. I'm no longer getting a reproduction of this issue on a Galaxy Nexus on the latest nightly.