[TIMOB-23901] Android: App stuck on splash screen when app run second time with analytics to true from tiapp.xml

GitHub Issue	n/a
Type	Bug
Priority	Critical
Status	Closed
Resolution	Fixed
Resolution Date	2016-09-30T15:44:00.000+0000
Affected Version/s	Release 5.4.0
Fix Version/s	Release 6.0.0
Components	Android
Labels	n/a
Reporter	Aminul Islam
Assignee	Gary Mathews
Created	2016-09-14T14:39:36.000+0000
Updated	2017-06-07T14:28:07.000+0000

Description

Scenario is create a new app (alloy or classic no matter) with unchecking enabled cloud and install to Android device. It has launch without problem but when press back and close app then run app again from device it was stuck on splash screen. Steps to Reproduce : 1. Create a new alloy or classic apps. 2. Unchecking enabled Appcelerator services. 3. Run on android device. 4. It will launch without problem. 5. Press back button and close the app. 6. Run app again from device it will stuck on splash screen. (See screenshot). *Environment*

Operating System
  Name                        = Mac OS X
  Version                     = 10.11.6
  Architecture                = 64bit
  # CPUs                      = 4
  Memory                      = 8589934592
Node.js
  Node.js Version             = 4.4.4
  npm Version                 = 2.15.1
Titanium CLI
  CLI Version                 = 5.0.9
Titanium SDK
  SDK Version                 = 5.5.0.GA

*Log*

[INFO] :   I/com.newrelic.agent.android(23789): Harvester: connected
[INFO] :   I/com.newrelic.agent.android(23789): Harvester: Sending 0 HTTP transactions.
[INFO] :   I/com.newrelic.agent.android(23789): Harvester: Sending 0 HTTP errors.
[INFO] :   I/com.newrelic.agent.android(23789): Harvester: Sending 0 activity traces.
[INFO] :   I/com.newrelic.agent.android(23789): Harvester: Sending 0 analytics events.
[INFO] :   D/NetworkController.WifiSignalController( 2868): Change in state from: connected=true,enabled=true,level=4,inetCondition=1,iconGroup=IconGroup(Wi-Fi Icons),activityIn=true,activityOut=true,rssi=-62,lastModified=09-14 08:37:45,ssid="aminul"
[INFO] :   D/NetworkController.WifiSignalController( 2868): 	to: connected=true,enabled=true,level=4,inetCondition=1,iconGroup=IconGroup(Wi-Fi Icons),activityIn=false,activityOut=false,rssi=-62,lastModified=09-14 08:37:45,ssid="aminul"
[INFO] :   D/StatusBar.NetworkController( 2868): dumpIcon[(gone) stat_sys_5signal_5|null stat_sys_wifi_signal_connected_4 (gone) F]
[INFO] :   D/NetworkController.WifiSignalController( 2868): Change in state from: connected=true,enabled=true,level=4,inetCondition=1,iconGroup=IconGroup(Wi-Fi Icons),activityIn=false,activityOut=false,rssi=-62,lastModified=09-14 08:37:47,ssid="aminul"
[INFO] :   D/NetworkController.WifiSignalController( 2868): 	to: connected=true,enabled=true,level=4,inetCondition=1,iconGroup=IconGroup(Wi-Fi Icons),activityIn=true,activityOut=true,rssi=-62,lastModified=09-14 08:37:47,ssid="aminul"
[INFO] :   D/StatusBar.NetworkController( 2868): dumpIcon[(gone) stat_sys_5signal_5|null stat_sys_wifi_signal_inandout_4 (gone) F]
[INFO] :   D/NetworkController.WifiSignalController( 2868): Change in state from: connected=true,enabled=true,level=4,inetCondition=1,iconGroup=IconGroup(Wi-Fi Icons),activityIn=true,activityOut=true,rssi=-62,lastModified=09-14 08:38:07,ssid="aminul"
[INFO] :   D/NetworkController.WifiSignalController( 2868): 	to: connected=true,enabled=true,level=4,inetCondition=1,iconGroup=IconGroup(Wi-Fi Icons),activityIn=false,activityOut=false,rssi=-62,lastModified=09-14 08:38:07,ssid="aminul"
[INFO] :   D/StatusBar.NetworkController( 2868): dumpIcon[(gone) stat_sys_5signal_5|null stat_sys_wifi_signal_connected_4 (gone) F]
[INFO] :   D/NetworkController.WifiSignalController( 2868): Change in state from: connected=true,enabled=true,level=4,inetCondition=1,iconGroup=IconGroup(Wi-Fi Icons),activityIn=false,activityOut=false,rssi=-62,lastModified=09-14 08:38:09,ssid="aminul"
[INFO] :   D/NetworkController.WifiSignalController( 2868): 	to: connected=true,enabled=true,level=4,inetCondition=1,iconGroup=IconGroup(Wi-Fi Icons),activityIn=true,activityOut=true,rssi=-62,lastModified=09-14 08:38:09,ssid="aminul"
[INFO] :   D/StatusBar.NetworkController( 2868): dumpIcon[(gone) stat_sys_5signal_5|null stat_sys_wifi_signal_inandout_4 (gone) F]
[INFO] :   D/NetworkController.WifiSignalController( 2868): Change in state from: connected=true,enabled=true,level=4,inetCondition=1,iconGroup=IconGroup(Wi-Fi Icons),activityIn=true,activityOut=true,rssi=-62,lastModified=09-14 08:38:11,ssid="aminul"
[INFO] :   D/NetworkController.WifiSignalController( 2868): 	to: connected=true,enabled=true,level=4,inetCondition=1,iconGroup=IconGroup(Wi-Fi Icons),activityIn=false,activityOut=false,rssi=-62,lastModified=09-14 08:38:11,ssid="aminul"
[INFO] :   D/StatusBar.NetworkController( 2868): dumpIcon[(gone) stat_sys_5signal_5|null stat_sys_wifi_signal_connected_4 (gone) F]
[INFO] :   D/NetworkController.WifiSignalController( 2868): Change in state from: connected=true,enabled=true,level=4,inetCondition=1,iconGroup=IconGroup(Wi-Fi Icons),activityIn=false,activityOut=false,rssi=-62,lastModified=09-14 08:38:12,ssid="aminul"
[INFO] :   D/NetworkController.WifiSignalController( 2868): 	to: connected=true,enabled=true,level=4,inetCondition=1,iconGroup=IconGroup(Wi-Fi Icons),activityIn=true,activityOut=true,rssi=-62,lastModified=09-14 08:38:12,ssid="aminul"
[INFO] :   D/StatusBar.NetworkController( 2868): dumpIcon[(gone) stat_sys_5signal_5|null stat_sys_wifi_signal_inandout_4 (gone) F]
[INFO] :   E/fb4a(:<default>):GRAPHQL_QUERY_STRING(21121): Trying to set unknown parameter 'first_notification_stories' on query 'DeltaNotificationsQuery'
[INFO] :   E/fb4a(:<default>):GRAPHQL_QUERY_STRING(21121): Trying to set unknown parameter 'first_notification_stories' on query 'DeltaNotificationsQuery'
[INFO] :   D/NetworkController.WifiSignalController( 2868): Change in state from: connected=true,enabled=true,level=4,inetCondition=1,iconGroup=IconGroup(Wi-Fi Icons),activityIn=true,activityOut=true,rssi=-62,lastModified=09-14 08:38:16,ssid="aminul"
[INFO] :   D/NetworkController.WifiSignalController( 2868): 	to: connected=true,enabled=true,level=4,inetCondition=1,iconGroup=IconGroup(Wi-Fi Icons),activityIn=false,activityOut=true,rssi=-62,lastModified=09-14 08:38:16,ssid="aminul"
[INFO] :   D/StatusBar.NetworkController( 2868): dumpIcon[(gone) stat_sys_5signal_5|null stat_sys_wifi_signal_out_4 (gone) F]
[INFO] :   D/NetworkController.WifiSignalController( 2868): Change in state from: connected=true,enabled=true,level=4,inetCondition=1,iconGroup=IconGroup(Wi-Fi Icons),activityIn=false,activityOut=true,rssi=-62,lastModified=09-14 08:38:19,ssid="aminul"
[INFO] :   D/NetworkController.WifiSignalController( 2868): 	to: connected=true,enabled=true,level=4,inetCondition=1,iconGroup=IconGroup(Wi-Fi Icons),activityIn=false,activityOut=false,rssi=-62,lastModified=09-14 08:38:19,ssid="aminul"
[INFO] :   D/StatusBar.NetworkController( 2868): dumpIcon[(gone) stat_sys_5signal_5|null stat_sys_wifi_signal_connected_4 (gone) F]

Thanks

Attachments

File	Date	Size
0-sa-d2-e2aef72d7ef6d65ac0aa76bdd7a55837.jpg	2016-09-14T14:40:02.000+0000	41120
Studio log.txt	2016-09-14T14:40:10.000+0000	279995

Comments

Chee Kiat Ng 2016-09-14

[~aislam] Hi what's the appc cli core used here? 5.5.0 as well? [~fmerzadyan] want to try reproducing this?
Farzad Merzadyan 2016-09-16

Yes, I got the expected results: app is stuck on splash screen.
Ashraf Abu 2016-09-20

Able to reproduce.
Ashraf Abu 2016-09-20

Interestingly enough, I'm able to reproduce it all the way to 5.2.0.GA (5.3.0.GA included) 5.1.0.GA is unaffected. Will need to look to see if it's the SDK or something else that is causing this. I'm leaning towards something else that's being added recently causing this issue cause if it was something that was present in 5.2.0.GA, it would have been detected long ago. Note, in the logs I'm able to see: 09-19 23:52:46.939 6827 6827 I TiRootActivity: (main) [0,0] checkpoint, on root activity create, savedInstanceState: null This is during the second time. Which means it does at least reach that part.
Ashraf Abu 2016-09-20

[~lchoudhary] Could you test as well to see if it is reproducible in 5.2.0.GA and 5.3.0.GA? And to see if 5.1.0.GA is unaffected? As well as if you are able to test it with older CLIs. Update: I tried 5.4.0-37 CLI, same thing.
Lokesh Choudhary 2016-09-20

[~msamah], It seems my today's tests contradicts your findings, strange. I carried the following tests just using CLI to rule out studio: ||Components||Results|| | SDK: 5.1.0.GA, CLI: 5.1.0, Appc NPM: 4.2.2, services: enabled, analytics: true | App does not freeze | | SDK: 5.2.0.GA, CLI: 5.2.0, Appc NPM: 4.2.3, services: enabled, analytics: true | App does not freeze | | SDK: 5.3.0.GA, CLI: 5.3.0, Appc NPM: 4.2.6, services: enabled, analytics: true | App does not freeze | | SDK: 5.4.0.GA, CLI: 5.4.0, Appc NPM: 4.2.7, services: enabled, hyperloop: enabled, analytics: true | App freezes | | SDK: 5.4.0.GA, CLI: 5.4.0, Appc NPM: 4.2.7, services: disabled, hyperloop: disabled, analytics: false | App freezes | and as for savedInstanceState: null I see the same for 5.3.0 components which does not show the issue.
Gary Mathews 2016-09-20

Both 5.1.0.GA and 5.1.1.GA are unaffected, 5.2.0.GA is affected. I'm currently looking at the changes.
Ashraf Abu 2016-09-21

With results being different, perhaps there's something more to this than just the SDK. Perhaps CLI or something else that is generating some of the Android code is adding/removing something causing a difference in behaviour? Perhaps it's freezing for me an Gary Mathews cause our CLI is not the same version as our SDK?
Chee Kiat Ng 2016-09-21

This may be a bit of a stretch but, could it be related to run-on-main-thread?
Ashraf Abu 2016-09-21

Hmmm. I'll try to see if I can find the run-on-main-thread part and see if it is related.
Ashraf Abu 2016-09-21

Run-on-main-thread Ticket and PR to check: * TIMOB-19765 * https://github.com/appcelerator/titanium_mobile/pull/7332 Related changes: https://github.com/appcelerator/titanium_mobile/commit/3eafaf5e3bd7399d2ca79f344b8b9247536c36b5
Ashraf Abu 2016-09-21

[~cng] Your hunch seems to be correct. I did a PR that undo that run-on-main-thread PR and now it works correctly. PR that undo TIMOB-19765: https://github.com/appcelerator/titanium_mobile/pull/8406 [~cwilliams] and [~gmathews] Please take a look into my PR and provide feedback.
Ashraf Abu 2016-09-21

Update: [~gmathews] is looking to make a better PR that fixes the issue (as compared to mine which will undo the changes instead).
Gary Mathews 2016-09-21

master: https://github.com/appcelerator/titanium_mobile/pull/8411
Chee Kiat Ng 2016-09-21

[~gmathews] backport for 6.0.X please. as well as 5_5_X.
Ashraf Abu 2016-09-22

[~lchoudhary] The PR fix has been merged into Master branch. I tried it and am still facing the issue. Is it possible to have you try it out as well from the Master branch to see if it works. Perhaps it's just me.
Gary Mathews 2016-09-22

master: https://github.com/appcelerator/titanium_mobile/pull/8421 6_0_X: https://github.com/appcelerator/titanium_mobile/pull/8422 5_5_X: https://github.com/appcelerator/titanium_mobile/pull/8423
Chee Kiat Ng 2016-09-23

bumped out of 5.5.1. We should address this for 6_0_X and beyond.
Chee Kiat Ng 2016-09-23

[~gmathews] if the earlier PR is not the right solution, kindly revert the changes.
Gary Mathews 2016-09-23

Earlier PRs [#8411](https://github.com/appcelerator/titanium_mobile/pull/8411), [#8412](https://github.com/appcelerator/titanium_mobile/pull/8412) are both still valid and should not be reverted. I have closed [#8421](https://github.com/appcelerator/titanium_mobile/pull/8421), [#8422](https://github.com/appcelerator/titanium_mobile/pull/842) and [#8423](https://github.com/appcelerator/titanium_mobile/pull/843) as the PRs below address the issue correctly. master: https://github.com/appcelerator/titanium_mobile/pull/8426 6_0_X: https://github.com/appcelerator/titanium_mobile/pull/8427
Lokesh Choudhary 2016-09-30

Verified the fix. The app does not get stuck when launched second time. Closing. Environment: Appc Studio : 4.8.0.201609292239 Ti SDK : 6.0.0.v20160930084353, 6.1.0.v20160930092242 Ti CLI : 5.0.10 Alloy : 1.9.2 MAC El Capitan : 10.11.6 Appc NPM : 4.2.8-7 Appc CLI : 6.0.0-54 Node: 4.4.4 Nexus 5 - Android 6.0.1
Dirlei Dionísio 2016-10-17

Using Ti SDK 4.x and 5.x the problem does not occur with "run-on-main-thread" = false on tiapp.xml.

Douglas Alves 2017-03-13

Apparently the version 6.0.0 did not fix the issue! Environment: Appc Studio : 4.8.1.201612050850 Ti SDK : 6.0.2.GA MAC El Capitan : 10.12.3 Node: 4.6.0 Nexus 6P - Android 7.1.1 Error:

    03-13 08:16:06.167: I/TiRootActivity(965): (main) [0,0] checkpoint, on root activity create, savedInstanceState: null
    
    03-13 08:15:53.048: A/libc(908): Fatal signal 11 (SIGSEGV), code 1, fault addr 0x0 in tid 926 (KrollRuntimeThr)
    03-13 08:15:53.051: W/(375): debuggerd: handling request: pid=908 uid=10315 gid=10315 tid=926
    03-13 08:15:53.196: A/DEBUG(950): *** *** *** *** *** *** *** *** *** *** *** *** *** *** *** ***
    03-13 08:15:53.197: A/DEBUG(950): Build fingerprint: 'google/angler/angler:7.1.1/N4F26O/3582057:user/release-keys'
    03-13 08:15:53.197: A/DEBUG(950): Revision: '0'
    03-13 08:15:53.197: A/DEBUG(950): ABI: 'arm'
    03-13 08:15:53.197: A/DEBUG(950): pid: 908, tid: 926, name: KrollRuntimeThr  >>> com.douglas.upflix <<<
    03-13 08:15:53.197: A/DEBUG(950): signal 11 (SIGSEGV), code 1 (SEGV_MAPERR), fault addr 0x0
    03-13 08:15:53.197: A/DEBUG(950):     r0 00000000  r1 e3040000  r2 75646f4d  r3 0000656c
    03-13 08:15:53.197: A/DEBUG(950):     r4 00000000  r5 d4751dc8  r6 e3067420  r7 00000000
    03-13 08:15:53.197: A/DEBUG(950):     r8 00000000  r9 d474dd78  sl ecd4d364  fp ef507008
    03-13 08:15:53.197: A/DEBUG(950):     ip d27801bc  sp ecd4d2b0  lr d3f2dfa3  pc d400c204  cpsr a0070010
    03-13 08:15:53.200: A/DEBUG(950): backtrace:
    03-13 08:15:53.202: A/DEBUG(950):     #00 pc 003a7204  /data/app/com.douglas.upflix-2/lib/arm/libkroll-v8.so (_ZN2v86Object3GetENS_5LocalINS_5ValueEEE+8)
    03-13 08:15:53.202: A/DEBUG(950):     #01 pc 002c8f9f  /data/app/com.douglas.upflix-2/lib/arm/libkroll-v8.so (Java_org_appcelerator_kroll_runtime_v8_V8Runtime_nativeRunModule+106)
    03-13 08:15:53.202: A/DEBUG(950):     #02 pc 00814abd  /data/app/com.douglas.upflix-2/oat/arm/base.odex (offset 0x745000)
    03-13 08:15:54.218: E/(950): debuggerd: failed to kill process 908: No such process

    03-13 08:16:06.167: I/TiRootActivity(965): (main) [0,0] checkpoint, on root activity create, savedInstanceState: null
    
    03-13 08:15:53.048: A/libc(908): Fatal signal 11 (SIGSEGV), code 1, fault addr 0x0 in tid 926 (KrollRuntimeThr)
    03-13 08:15:53.051: W/(375): debuggerd: handling request: pid=908 uid=10315 gid=10315 tid=926
    03-13 08:15:53.196: A/DEBUG(950): *** *** *** *** *** *** *** *** *** *** *** *** *** *** *** ***
    03-13 08:15:53.197: A/DEBUG(950): Build fingerprint: 'google/angler/angler:7.1.1/N4F26O/3582057:user/release-keys'
    03-13 08:15:53.197: A/DEBUG(950): Revision: '0'
    03-13 08:15:53.197: A/DEBUG(950): ABI: 'arm'
    03-13 08:15:53.197: A/DEBUG(950): pid: 908, tid: 926, name: KrollRuntimeThr  >>> com.douglas.upflix <<<
    03-13 08:15:53.197: A/DEBUG(950): signal 11 (SIGSEGV), code 1 (SEGV_MAPERR), fault addr 0x0
    03-13 08:15:53.197: A/DEBUG(950):     r0 00000000  r1 e3040000  r2 75646f4d  r3 0000656c
    03-13 08:15:53.197: A/DEBUG(950):     r4 00000000  r5 d4751dc8  r6 e3067420  r7 00000000
    03-13 08:15:53.197: A/DEBUG(950):     r8 00000000  r9 d474dd78  sl ecd4d364  fp ef507008
    03-13 08:15:53.197: A/DEBUG(950):     ip d27801bc  sp ecd4d2b0  lr d3f2dfa3  pc d400c204  cpsr a0070010
    03-13 08:15:53.200: A/DEBUG(950): backtrace:
    03-13 08:15:53.202: A/DEBUG(950):     #00 pc 003a7204  /data/app/com.douglas.upflix-2/lib/arm/libkroll-v8.so (_ZN2v86Object3GetENS_5LocalINS_5ValueEEE+8)
    03-13 08:15:53.202: A/DEBUG(950):     #01 pc 002c8f9f  /data/app/com.douglas.upflix-2/lib/arm/libkroll-v8.so (Java_org_appcelerator_kroll_runtime_v8_V8Runtime_nativeRunModule+106)
    03-13 08:15:53.202: A/DEBUG(950):     #02 pc 00814abd  /data/app/com.douglas.upflix-2/oat/arm/base.odex (offset 0x745000)
    03-13 08:15:54.218: E/(950): debuggerd: failed to kill process 908: No such process

Douglas Alves 2017-03-13

Apparently the version 6.0.0 did not fix the issue! Environment: Appc Studio : 4.8.1.201612050850 Ti SDK : 6.0.2.GA MAC El Capitan : 10.12.3 Node: 4.6.0 Nexus 6P - Android 7.1.1 Error: 03-13 08:16:06.167: I/TiRootActivity(965): (main) [0,0] checkpoint, on root activity create, savedInstanceState: null 03-13 08:15:53.048: A/libc(908): Fatal signal 11 (SIGSEGV), code 1, fault addr 0x0 in tid 926 (KrollRuntimeThr) 03-13 08:15:53.051: W/(375): debuggerd: handling request: pid=908 uid=10315 gid=10315 tid=926 03-13 08:15:53.196: A/DEBUG(950): *** *** *** *** *** *** *** *** *** *** *** *** *** *** *** *** 03-13 08:15:53.197: A/DEBUG(950): Build fingerprint: 'google/angler/angler:7.1.1/N4F26O/3582057:user/release-keys' 03-13 08:15:53.197: A/DEBUG(950): Revision: '0' 03-13 08:15:53.197: A/DEBUG(950): ABI: 'arm' 03-13 08:15:53.197: A/DEBUG(950): pid: 908, tid: 926, name: KrollRuntimeThr >>> com.douglas.upflix <<< 03-13 08:15:53.197: A/DEBUG(950): signal 11 (SIGSEGV), code 1 (SEGV_MAPERR), fault addr 0x0 03-13 08:15:53.197: A/DEBUG(950): r0 00000000 r1 e3040000 r2 75646f4d r3 0000656c 03-13 08:15:53.197: A/DEBUG(950): r4 00000000 r5 d4751dc8 r6 e3067420 r7 00000000 03-13 08:15:53.197: A/DEBUG(950): r8 00000000 r9 d474dd78 sl ecd4d364 fp ef507008 03-13 08:15:53.197: A/DEBUG(950): ip d27801bc sp ecd4d2b0 lr d3f2dfa3 pc d400c204 cpsr a0070010 03-13 08:15:53.200: A/DEBUG(950): backtrace: 03-13 08:15:53.202: A/DEBUG(950): #00 pc 003a7204 /data/app/com.douglas.upflix-2/lib/arm/libkroll-v8.so (_ZN2v86Object3GetENS_5LocalINS_5ValueEEE+8) 03-13 08:15:53.202: A/DEBUG(950): #01 pc 002c8f9f /data/app/com.douglas.upflix-2/lib/arm/libkroll-v8.so (Java_org_appcelerator_kroll_runtime_v8_V8Runtime_nativeRunModule+106) 03-13 08:15:53.202: A/DEBUG(950): #02 pc 00814abd /data/app/com.douglas.upflix-2/oat/arm/base.odex (offset 0x745000) 03-13 08:15:54.218: E/(950): debuggerd: failed to kill process 908: No such process
Wilson Liaw 2017-06-07

For some reasons I still need to use 5.5.1, any chance to back port the fix?

JSON Source