Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

App crashes after it is suspended for a long time, then resumed and after a while on some interaction #385

Closed
slavchev opened this issue Mar 16, 2016 · 4 comments
Closed

App crashes after it is suspended for a long time, then resumed and after a while on some interaction #385

slavchev opened this issue Mar 16, 2016 · 4 comments
Labels
bug severity: medium

Comments

@slavchev
Copy link

Reported from @PanayotCankov

03-16 03:28:31.653: E/Genymotion(396): Could not open '/sys/class/power_supply/genymotion_fake_path/present'
03-16 03:28:36.653: E/Genymotion(396): Could not open '/sys/class/power_supply/genymotion_fake_path/present'
03-16 03:28:41.657: E/Genymotion(396): Could not open '/sys/class/power_supply/genymotion_fake_path/present'
03-16 03:28:42.417: D/Genyd(62): Received Set Clipboard
03-16 03:28:42.417: D/Genymotion(62): Received Set Clipboard
03-16 03:28:46.657: E/Genymotion(396): Could not open '/sys/class/power_supply/genymotion_fake_path/present'
03-16 03:28:49.189: V/JS(2786): Track: Navigate to: examples/layouts/layouts-example
03-16 03:28:49.189: D/TNS.JAVA.JsDebugger(2786): Sending console message to inspector:{"seq":0,"body":{"message":{"text":"Track: Navigate to: examples\/layouts\/layouts-example","level":"log","source":"console-api","groupLevel":7,"column":13,"line":10,"repeatCount":1,"type":"log","url":"\/data\/data\/org.nativescript.examples\/files\/app\/common\/navigator.js"}},"type":"event","success":true,"event":"messageAdded"}
03-16 03:28:49.289: A/libc(2786): Fatal signal 11 (SIGSEGV) at 0x00000000 (code=128), thread 2786 (script.examples)
03-16 03:28:49.393: I/DEBUG(125): *** *** *** *** *** *** *** *** *** *** *** *** *** *** *** ***
03-16 03:28:49.393: I/DEBUG(125): Build fingerprint: 'generic/vbox86tp/vbox86tp:4.3/JLS36G/eng.buildbot.20150609.214615:userdebug/test-keys'
03-16 03:28:49.393: I/DEBUG(125): Revision: '0'
03-16 03:28:49.393: I/DEBUG(125): pid: 2786, tid: 2786, name: script.examples  >>> org.nativescript.examples <<<
03-16 03:28:49.393: I/DEBUG(125): signal 11 (SIGSEGV), code 128 (SI_KERNEL), fault addr 00000000
03-16 03:28:49.513: I/DEBUG(125):     eax b9375d60  ebx 97bd8cdc  ecx 000003fc  edx b8fa8f00
03-16 03:28:49.513: I/DEBUG(125):     esi b8fa7f08  edi 000003fe
03-16 03:28:49.513: I/DEBUG(125):     xcs 00000073  xds 0000007b  xes 0000007b  xfs 00000000  xss 0000007b
03-16 03:28:49.513: I/DEBUG(125):     eip 97542bd9  ebp b8fa8f00  esp bf8f269c  flags 00210286
03-16 03:28:49.513: E/Corkscrew(125): unrecognized dwarf higher part encoding: 0xe3
03-16 03:28:49.513: I/DEBUG(125): backtrace:
03-16 03:28:49.513: I/DEBUG(125):     #00  pc 0038abd9  /data/app-lib/org.nativescript.examples-1/libNativeScript.so (v8::internal::HandleScope::DeleteExtensions(v8::internal::Isolate*)+265)
03-16 03:28:49.513: I/DEBUG(125):     #01  pc 0029e226  /data/app-lib/org.nativescript.examples-1/libNativeScript.so (v8::HandleScope::~HandleScope()+70)
03-16 03:28:49.513: I/DEBUG(125):     #02  pc 00249462  /data/app-lib/org.nativescript.examples-1/libNativeScript.so (Java_com_tns_Platform_callJSMethodNative+194)
03-16 03:28:49.513: I/DEBUG(125): stack:
03-16 03:28:49.513: I/DEBUG(125):          bf8f265c  00000000  
03-16 03:28:49.513: I/DEBUG(125):          bf8f2660  00000000  
03-16 03:28:49.513: I/DEBUG(125):          bf8f2664  00000000  
03-16 03:28:49.513: I/DEBUG(125):          bf8f2668  00000000  
03-16 03:28:49.513: I/DEBUG(125):          bf8f266c  00000000  
03-16 03:28:49.513: I/DEBUG(125):          bf8f2670  00000000  
03-16 03:28:49.513: I/DEBUG(125):          bf8f2674  00000000  
03-16 03:28:49.513: I/DEBUG(125):          bf8f2678  00000000  
03-16 03:28:49.513: I/DEBUG(125):          bf8f267c  00000000  
03-16 03:28:49.513: I/DEBUG(125):          bf8f2680  00000000  
03-16 03:28:49.513: I/DEBUG(125):          bf8f2684  00000000  
03-16 03:28:49.513: I/DEBUG(125):          bf8f2688  00000000  
03-16 03:28:49.513: I/DEBUG(125):          bf8f268c  00000000  
03-16 03:28:49.513: I/DEBUG(125):          bf8f2690  00000000  
03-16 03:28:49.513: I/DEBUG(125):          bf8f2694  00000000  
03-16 03:28:49.513: I/DEBUG(125):          bf8f2698  46505845  
03-16 03:28:49.513: I/DEBUG(125):     #00  bf8f269c  b9375d60  [heap]
03-16 03:28:49.513: I/DEBUG(125):          bf8f26a0  97635736  /data/app-lib/org.nativescript.examples-1/libNativeScript.so (v8::internal::Isolate::SetIsolateThreadLocals(v8::internal::Isolate*, v8::internal::Isolate::PerIsolateThreadData*)+6)
03-16 03:28:49.513: I/DEBUG(125):          bf8f26a4  97bd8cdc  /data/app-lib/org.nativescript.examples-1/libNativeScript.so
03-16 03:28:49.513: I/DEBUG(125):          bf8f26a8  97636b66  /data/app-lib/org.nativescript.examples-1/libNativeScript.so (v8::internal::Isolate::Enter()+118)
03-16 03:28:49.513: I/DEBUG(125):          bf8f26ac  00000000  
03-16 03:28:49.513: I/DEBUG(125):          bf8f26b0  b8df2190  [heap]
03-16 03:28:49.513: I/DEBUG(125):          bf8f26b4  9d96705c  /dev/ashmem/dalvik-aux-structure (deleted)
03-16 03:28:49.513: I/DEBUG(125):          bf8f26b8  b60b5563  /system/lib/libdvm.so
03-16 03:28:49.513: I/DEBUG(125):          bf8f26bc  9ecdb4b8  
03-16 03:28:49.513: I/DEBUG(125):          bf8f26c0  b8f7b8c8  [heap]
03-16 03:28:49.513: I/DEBUG(125):          bf8f26c4  000003fc  
03-16 03:28:49.513: I/DEBUG(125):          bf8f26c8  00000000  
03-16 03:28:49.513: I/DEBUG(125):          bf8f26cc  b8db6bd0  [heap]
03-16 03:28:49.513: I/DEBUG(125):          bf8f26d0  bf8f275c  [stack]
03-16 03:28:49.513: I/DEBUG(125):          bf8f26d4  97542ad9  /data/app-lib/org.nativescript.examples-1/libNativeScript.so (v8::internal::HandleScope::DeleteExtensions(v8::internal::Isolate*)+9)
03-16 03:28:49.513: I/DEBUG(125):          bf8f26d8  97bd8cdc  /data/app-lib/org.nativescript.examples-1/libNativeScript.so
03-16 03:28:49.513: I/DEBUG(125):          ........  ........
03-16 03:28:49.513: I/DEBUG(125):     #01  bf8f26ec  b8f826a0  [heap]
03-16 03:28:49.513: I/DEBUG(125):          bf8f26f0  b6246ccc  /system/lib/libdvm.so
03-16 03:28:49.513: I/DEBUG(125):          bf8f26f4  9740647b  /data/app-lib/org.nativescript.examples-1/libNativeScript.so (tns::NativePlatform::CallJSMethodNative(_JNIEnv*, _jobject*, int, _jstring*, int, unsigned char, _jobjectArray*)+11)
03-16 03:28:49.513: I/DEBUG(125):          bf8f26f8  974561e8  /data/app-lib/org.nativescript.examples-1/libNativeScript.so (v8::HandleScope::~HandleScope()+8)
03-16 03:28:49.513: I/DEBUG(125):          bf8f26fc  97bd8cdc  /data/app-lib/org.nativescript.examples-1/libNativeScript.so
03-16 03:28:49.513: I/DEBUG(125):          bf8f2700  b8f826a0  [heap]
03-16 03:28:49.513: I/DEBUG(125):          bf8f2704  bf8f2748  [stack]
03-16 03:28:49.513: I/DEBUG(125):          bf8f2708  97401463  /data/app-lib/org.nativescript.examples-1/libNativeScript.so (Java_com_tns_Platform_callJSMethodNative+195)
03-16 03:28:49.513: I/DEBUG(125):          bf8f270c  bf8f2748  [stack]
03-16 03:28:49.513: I/DEBUG(125):          bf8f2710  94300029  
03-16 03:28:49.513: I/DEBUG(125):          bf8f2714  000001bf  
03-16 03:28:49.513: I/DEBUG(125):          bf8f2718  0600002d  
03-16 03:28:49.513: I/DEBUG(125):          bf8f271c  00000000  
03-16 03:28:49.513: I/DEBUG(125):          bf8f2720  00000000  
03-16 03:28:49.513: I/DEBUG(125):          bf8f2724  38400031  
03-16 03:28:49.513: I/DEBUG(125):          bf8f2728  b6240000  /system/lib/libdvm.so
03-16 03:28:49.565: I/BootReceiver(396): Copying /data/tombstones/tombstone_03 to DropBox (SYSTEM_TOMBSTONE)
03-16 03:28:49.569: W/ActivityManager(396):   Force finishing activity org.nativescript.examples/com.tns.NativeScriptActivity
03-16 03:28:49.577: D/(396): HostConnection::get() New Host Connection established 0xb90aebb8, tid 5914
03-16 03:28:49.577: D/dalvikvm(396): GC_CONCURRENT freed 576K, 57% free 8911K/20700K, paused 3ms+1ms, total 13ms
03-16 03:28:49.585: W/InputDispatcher(396): channel '529e1830 org.nativescript.examples/com.tns.NativeScriptActivity (server)' ~ Consumer closed input channel or an error occurred.  events=0xd
03-16 03:28:49.585: E/InputDispatcher(396): channel '529e1830 org.nativescript.examples/com.tns.NativeScriptActivity (server)' ~ Channel is unrecoverably broken and will be disposed!
03-16 03:28:49.601: D/Zygote(128): Process 2786 terminated by signal (11)
03-16 03:28:49.633: W/InputDispatcher(396): Attempted to unregister already unregistered input channel '529e1830 org.nativescript.examples/com.tns.NativeScriptActivity (server)'
03-16 03:28:49.633: I/WindowState(396): WIN DEATH: Window{529e1830 u0 org.nativescript.examples/com.tns.NativeScriptActivity}
03-16 03:28:49.633: W/ActivityManager(396): Exception thrown during pause
03-16 03:28:49.633: W/ActivityManager(396): android.os.DeadObjectException
03-16 03:28:49.633: W/ActivityManager(396):     at android.os.BinderProxy.transact(Native Method)
03-16 03:28:49.633: W/ActivityManager(396):     at android.app.ApplicationThreadProxy.schedulePauseActivity(ApplicationThreadNative.java:635)
03-16 03:28:49.633: W/ActivityManager(396):     at com.android.server.am.ActivityStack.startPausingLocked(ActivityStack.java:990)
03-16 03:28:49.633: W/ActivityManager(396):     at com.android.server.am.ActivityStack.finishActivityLocked(ActivityStack.java:3834)
03-16 03:28:49.633: W/ActivityManager(396):     at com.android.server.am.ActivityStack.finishActivityLocked(ActivityStack.java:3766)
03-16 03:28:49.633: W/ActivityManager(396):     at com.android.server.am.ActivityManagerService.handleAppCrashLocked(ActivityManagerService.java:8344)
03-16 03:28:49.633: W/ActivityManager(396):     at com.android.server.am.ActivityManagerService.makeAppCrashingLocked(ActivityManagerService.java:8221)
03-16 03:28:49.633: W/ActivityManager(396):     at com.android.server.am.ActivityManagerService.crashApplication(ActivityManagerService.java:8900)
03-16 03:28:49.633: W/ActivityManager(396):     at com.android.server.am.ActivityManagerService.handleApplicationCrashInner(ActivityManagerService.java:8455)
03-16 03:28:49.633: W/ActivityManager(396):     at com.android.server.am.NativeCrashListener$NativeCrashReporter.run(NativeCrashListener.java:86)
03-16 03:28:49.637: I/qtaguid(396): Failed write_ctrl(s 1 10023) res=-1 errno=1
03-16 03:28:49.637: W/NetworkManagementSocketTagger(396): setKernelCountSet(10023, 1) failed with errno -1
03-16 03:28:49.641: I/ActivityManager(396): Process org.nativescript.examples (pid 2786) has died.
03-16 03:28:49.645: D/dalvikvm(396): GC_CONCURRENT freed 745K, 57% free 8974K/20700K, paused 0ms+1ms, total 8ms
03-16 03:28:49.669: I/qtaguid(396): Failed write_ctrl(s 0 10052) res=-1 errno=1
03-16 03:28:49.669: W/NetworkManagementSocketTagger(396): setKernelCountSet(10052, 0) failed with errno -1
03-16 03:28:49.701: W/EGL_genymotion(602): eglSurfaceAttrib not implemented
03-16 03:28:51.657: E/Genymotion(396): Could not open '/sys/class/power_supply/genymotion_fake_path/present'
03-16 03:28:56.657: E/Genymotion(396): Could not open '/sys/class/power_supply/genymotion_fake_path/present'
03-16 03:29:01.657: E/Genymotion(396): Could not open '/sys/class/power_supply/genymotion_fake_path/present'
03-16 03:29:06.661: E/Genymotion(396): Could not open '/sys/class/power_supply/genymotion_fake_path/present'
03-16 03:29:11.661: E/Genymotion(396): Could not open '/sys/class/power_supply/genymotion_fake_path/present'
03-16 03:29:16.661: E/Genymotion(396): Could not open '/sys/class/power_supply/genymotion_fake_path/present'
03-16 03:29:21.661: E/Genymotion(396): Could not open '/sys/class/power_supply/genymotion_fake_path/present'
03-16 03:29:26.665: E/Genymotion(396): Could not open '/sys/class/power_supply/genymotion_fake_path/present'
03-16 03:29:29.009: D/dalvikvm(588): Debugger has detached; object registry had 1 entries
03-16 03:29:29.009: D/dalvikvm(602): Debugger has detached; object registry had 1 entries
03-16 03:29:29.009: D/dalvikvm(5212): Debugger has detached; object registry had 1 entries
03-16 03:29:29.009: D/dalvikvm(396): Debugger has detached; object registry had 1 entries
03-16 03:29:29.009: D/dalvikvm(5192): Debugger has detached; object registry had 1 entries
03-16 03:29:29.009: D/dalvikvm(473): Debugger has detached; object registry had 1 entries
03-16 03:29:29.013: D/dalvikvm(568): Debugger has detached; object registry had 1 entries
03-16 03:29:29.013: D/dalvikvm(630): Debugger has detached; object registry had 1 entries
03-16 03:29:29.013: D/dalvikvm(4277): Debugger has detached; object registry had 1 entries
03-16 03:29:29.013: D/dalvikvm(5249): Debugger has detached; object registry had 1 entries
03-16 03:29:29.605: D/MobileDataStateTracker(396): default: setPolicyDataEnable(enabled=true)
03-16 03:29:31.665: E/Genymotion(396): Could not open '/sys/class/power_supply/genymotion_fake_path/present'
03-16 03:29:36.665: E/Genymotion(396): Could not open '/sys/class/power_supply/genymotion_fake_path/present'
03-16 03:29:41.665: E/Genymotion(396): Could not open '/sys/class/power_supply/genymotion_fake_path/present'
03-16 03:29:
@PanayotCankov PanayotCankov changed the title App crashes on resume App crashes after it is suspended for a long time, then resumed and then on some interaction Mar 16, 2016
@PanayotCankov PanayotCankov changed the title App crashes after it is suspended for a long time, then resumed and then on some interaction App crashes after it is suspended for a long time, then resumed and after a while on some interaction Mar 16, 2016
@atanasovg atanasovg added this to the 2.0.0 (Under Review) milestone Mar 18, 2016
@slavchev
Copy link
Author

It seems to be related to #358. I investigated a few v8::internal::HandleScope::DeleteExtensions problems and so far the only explanation I saw is memory corruption. This also relates to this StackOverflow thread. As an immediate step we can try to upgrade to a newer V8 version and start using memory fences around the critical spots.

@Plamen5kov Plamen5kov added the bug label Apr 7, 2016
@Plamen5kov Plamen5kov removed this from the 2.0.0 milestone Apr 18, 2016
@Plamen5kov
Copy link
Contributor

This issue has been reoccurring for a long time now. We will continue to monitor and fix it completely.

@petekanev petekanev mentioned this issue May 26, 2016
Closed
@slavchev slavchev mentioned this issue Jun 22, 2016
Closed
@Plamen5kov
Copy link
Contributor

related to: #496

@Plamen5kov
Copy link
Contributor

closed in favor of: #358

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
bug severity: medium
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
4 participants
@slavchev @atanasovg @Plamen5kov @pkoleva