Titanium JIRA Archive
Titanium SDK/CLI (TIMOB)

[TIMOB-26328] Hyperloop: Android - Application freezes when trying to reopen window in 7.3.0

GitHub Issuen/a
TypeBug
PriorityCritical
StatusClosed
ResolutionFixed
Resolution Date2018-08-22T06:35:53.000+0000
Affected Version/sRelease 7.3.0
Fix Version/sRelease 7.3.1, Hyperloop 3.1.2
ComponentsAndroid
Labelsn/a
ReporterHans Knöchel
AssigneeGary Mathews
Created2018-08-21T20:35:20.000+0000
Updated2018-08-22T10:07:05.000+0000

Description

When opening a sample in our [hyperloop-examples](https://github.com/appcelerator/hyperloop-examples) app (available on GitHub), closing the window and trying to open it again, the app freezes, the console is spammed with GC messages and the "Hyperloop_Sample is not responding" error is thrown. An extract of the console:
[DEBUG] Window: Checkpoint: postWindowCreated()
[DEBUG] EGL_emulation: eglMakeCurrent: 0xebcc9080: ver 3 0 (tinfo 0xcfb7e460)
[DEBUG] EGL_emulation: eglMakeCurrent: 0xebcc9080: ver 3 0 (tinfo 0xcfb7e460)
[INFO]  chatty: uid=10089(com.appcelerator.sample.hyperloop) RenderThread identical 1 line
[DEBUG] EGL_emulation: eglMakeCurrent: 0xebcc9080: ver 3 0 (tinfo 0xcfb7e460)
[DEBUG] EGL_emulation: eglMakeCurrent: 0xebcc9080: ver 3 0 (tinfo 0xcfb7e460)
[DEBUG] EGL_emulation: eglMakeCurrent: 0xebcc9080: ver 3 0 (tinfo 0xcfb7e460)
[DEBUG] EGL_emulation: eglMakeCurrent: 0xebcc9080: ver 3 0 (tinfo 0xcfb7e460)
[DEBUG] AndroidRuntime: Shutting down VM
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 44969(3MB) AllocSpace objects, 1(2MB) LOS objects, 6% free, 92MB/98MB, paused 176us total 401.512ms
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 577000(48MB) AllocSpace objects, 0(0B) LOS objects, 6% free, 80MB/86MB, paused 18us total 132.775ms
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 432377(36MB) AllocSpace objects, 0(0B) LOS objects, 7% free, 78MB/84MB, paused 154us total 107.411ms
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 407436(34MB) AllocSpace objects, 0(0B) LOS objects, 6% free, 79MB/85MB, paused 17us total 110.238ms
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 428176(36MB) AllocSpace objects, 0(0B) LOS objects, 7% free, 79MB/85MB, paused 27us total 133.449ms
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 419234(35MB) AllocSpace objects, 0(0B) LOS objects, 6% free, 80MB/86MB, paused 24us total 129.140ms
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 431710(36MB) AllocSpace objects, 0(0B) LOS objects, 5% free, 98MB/104MB, paused 145us total 161.486ms
[INFO]  I/ample.hyperloo: Thread[3,tid=4188,WaitingInMainSignalCatcherLoop,Thread*=0xebd5e000,peer=0x157c0088,"Signal Catcher"]: reacting to signal 3
[INFO]  I/ample.hyperloo:
[INFO]  I/ample.hyperloo: Waiting for a blocking GC ObjectsAllocated
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 295220(26MB) AllocSpace objects, 708(26MB) LOS objects, 3% free, 186MB/192MB, paused 65us total 247.797ms
[INFO]  I/ample.hyperloo: WaitForGcToComplete blocked ObjectsAllocated on HeapTrim for 10.300ms
[INFO]  I/ample.hyperloo: Wrote stack traces to '[tombstoned]'
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 3473(256KB) AllocSpace objects, 1486(140MB) LOS objects, 3% free, 173MB/179MB, paused 168us total 430.896ms
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 1936(159KB) AllocSpace objects, 827(129MB) LOS objects, 2% free, 232MB/238MB, paused 220us total 244.007ms
[INFO]  I/ample.hyperloo: Waiting for a blocking GC Alloc
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 2161(175KB) AllocSpace objects, 924(187MB) LOS objects, 2% free, 196MB/202MB, paused 99us total 174.254ms
[INFO]  I/ample.hyperloo: WaitForGcToComplete blocked Alloc on ObjectsAllocated for 51.648ms
[INFO]  I/ample.hyperloo: Starting a blocking GC Alloc
[INFO]  I/ample.hyperloo: Waiting for a blocking GC Alloc
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 1507(128KB) AllocSpace objects, 643(157MB) LOS objects, 2% free, 226MB/232MB, paused 1.873ms total 257.314ms
[INFO]  I/ample.hyperloo: WaitForGcToComplete blocked Alloc on ObjectsAllocated for 31.177ms
[INFO]  I/ample.hyperloo: Starting a blocking GC Alloc
[INFO]  I/ample.hyperloo: Waiting for a blocking GC Alloc
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 1526(144KB) AllocSpace objects, 651(181MB) LOS objects, 2% free, 202MB/208MB, paused 245us total 138.903ms
[INFO]  I/ample.hyperloo: WaitForGcToComplete blocked Alloc on ObjectsAllocated for 20.362ms
[INFO]  I/ample.hyperloo: Starting a blocking GC Alloc
[INFO]  I/ample.hyperloo: Waiting for a blocking GC Alloc
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 1202(112KB) AllocSpace objects, 510(157MB) LOS objects, 2% free, 226MB/232MB, paused 188us total 116.879ms
[INFO]  I/ample.hyperloo: WaitForGcToComplete blocked Alloc on ObjectsAllocated for 20.659ms
[INFO]  I/ample.hyperloo: Starting a blocking GC Alloc
[INFO]  I/ample.hyperloo: Waiting for a blocking GC Alloc
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 1259(112KB) AllocSpace objects, 537(180MB) LOS objects, 2% free, 202MB/208MB, paused 179us total 106.070ms
[INFO]  I/ample.hyperloo: WaitForGcToComplete blocked Alloc on ObjectsAllocated for 25.840ms
[INFO]  I/ample.hyperloo: Starting a blocking GC Alloc
[INFO]  I/ample.hyperloo: Waiting for a blocking GC Alloc
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 1021(96KB) AllocSpace objects, 435(157MB) LOS objects, 2% free, 225MB/231MB, paused 257us total 106.069ms
[INFO]  I/ample.hyperloo: WaitForGcToComplete blocked Alloc on ObjectsAllocated for 17.598ms
[INFO]  I/ample.hyperloo: Starting a blocking GC Alloc
[INFO]  I/ample.hyperloo: Waiting for a blocking GC Alloc
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 1098(96KB) AllocSpace objects, 468(181MB) LOS objects, 2% free, 202MB/208MB, paused 147us total 106.879ms
[INFO]  I/ample.hyperloo: WaitForGcToComplete blocked Alloc on ObjectsAllocated for 27.588ms
[INFO]  I/ample.hyperloo: Starting a blocking GC Alloc
[INFO]  I/ample.hyperloo: Waiting for a blocking GC Alloc
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 902(80KB) AllocSpace objects, 384(157MB) LOS objects, 2% free, 226MB/232MB, paused 137us total 104.958ms
[INFO]  I/ample.hyperloo: WaitForGcToComplete blocked Alloc on ObjectsAllocated for 17.503ms
[INFO]  I/ample.hyperloo: Starting a blocking GC Alloc
[INFO]  I/ample.hyperloo: Waiting for a blocking GC Alloc
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 992(96KB) AllocSpace objects, 423(182MB) LOS objects, 2% free, 201MB/207MB, paused 25us total 112.998ms
[INFO]  I/ample.hyperloo: WaitForGcToComplete blocked Alloc on ObjectsAllocated for 31.918ms
[INFO]  I/ample.hyperloo: Starting a blocking GC Alloc
[INFO]  I/ample.hyperloo: Waiting for a blocking GC Alloc
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 819(80KB) AllocSpace objects, 348(157MB) LOS objects, 2% free, 226MB/232MB, paused 248us total 107.335ms
[INFO]  I/ample.hyperloo: WaitForGcToComplete blocked Alloc on ObjectsAllocated for 20.945ms
[INFO]  I/ample.hyperloo: Starting a blocking GC Alloc
[INFO]  I/ample.hyperloo: Waiting for a blocking GC Alloc
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 909(80KB) AllocSpace objects, 387(182MB) LOS objects, 2% free, 201MB/207MB, paused 354us total 128.758ms
[INFO]  I/ample.hyperloo: WaitForGcToComplete blocked Alloc on ObjectsAllocated for 44.877ms
[INFO]  I/ample.hyperloo: Starting a blocking GC Alloc
[INFO]  I/ample.hyperloo: Waiting for a blocking GC Alloc
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 749(79KB) AllocSpace objects, 318(155MB) LOS objects, 2% free, 228MB/234MB, paused 222us total 123.708ms
[INFO]  I/ample.hyperloo: WaitForGcToComplete blocked Alloc on ObjectsAllocated for 26.980ms
[INFO]  I/ample.hyperloo: Starting a blocking GC Alloc
[INFO]  I/ample.hyperloo: Waiting for a blocking GC Alloc
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 845(79KB) AllocSpace objects, 360(182MB) LOS objects, 2% free, 201MB/207MB, paused 203us total 109.114ms
[INFO]  I/ample.hyperloo: WaitForGcToComplete blocked Alloc on ObjectsAllocated for 32.219ms
[INFO]  I/ample.hyperloo: Starting a blocking GC Alloc
[INFO]  I/ample.hyperloo: Waiting for a blocking GC Alloc
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 699(64KB) AllocSpace objects, 297(155MB) LOS objects, 2% free, 227MB/233MB, paused 218us total 104.361ms
[INFO]  I/ample.hyperloo: WaitForGcToComplete blocked Alloc on ObjectsAllocated for 20.799ms
[INFO]  I/ample.hyperloo: Starting a blocking GC Alloc
[INFO]  I/ample.hyperloo: Waiting for a blocking GC Alloc
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 796(80KB) AllocSpace objects, 339(183MB) LOS objects, 2% free, 200MB/206MB, paused 300us total 107.692ms
[INFO]  I/ample.hyperloo: WaitForGcToComplete blocked Alloc on ObjectsAllocated for 30.446ms
[INFO]  I/ample.hyperloo: Starting a blocking GC Alloc
[INFO]  I/ample.hyperloo: Waiting for a blocking GC Alloc
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 658(64KB) AllocSpace objects, 279(155MB) LOS objects, 2% free, 228MB/234MB, paused 298us total 105.548ms
[INFO]  I/ample.hyperloo: WaitForGcToComplete blocked Alloc on ObjectsAllocated for 19.052ms
[INFO]  I/ample.hyperloo: Starting a blocking GC Alloc
[INFO]  I/ample.hyperloo: Waiting for a blocking GC Alloc
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 755(80KB) AllocSpace objects, 321(184MB) LOS objects, 2% free, 199MB/205MB, paused 144us total 109.586ms
[INFO]  I/ample.hyperloo: WaitForGcToComplete blocked Alloc on ObjectsAllocated for 31.071ms
[INFO]  I/ample.hyperloo: Starting a blocking GC Alloc
[INFO]  I/ample.hyperloo: Waiting for a blocking GC Alloc
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 622(64KB) AllocSpace objects, 264(155MB) LOS objects, 2% free, 227MB/233MB, paused 300us total 109.719ms
[INFO]  I/ample.hyperloo: WaitForGcToComplete blocked Alloc on ObjectsAllocated for 19.215ms
[INFO]  I/ample.hyperloo: Starting a blocking GC Alloc
[INFO]  I/ample.hyperloo: Waiting for a blocking GC Alloc
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 707(63KB) AllocSpace objects, 300(181MB) LOS objects, 2% free, 202MB/208MB, paused 23us total 114.965ms
[INFO]  I/ample.hyperloo: WaitForGcToComplete blocked Alloc on ObjectsAllocated for 35.303ms
[INFO]  I/ample.hyperloo: Starting a blocking GC Alloc
[INFO]  I/ample.hyperloo: Waiting for a blocking GC Alloc
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 593(63KB) AllocSpace objects, 252(156MB) LOS objects, 2% free, 227MB/233MB, paused 212us total 113.689ms
[INFO]  I/ample.hyperloo: WaitForGcToComplete blocked Alloc on ObjectsAllocated for 22.457ms
[INFO]  I/ample.hyperloo: Starting a blocking GC Alloc
[INFO]  I/ample.hyperloo: Waiting for a blocking GC Alloc
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 678(64KB) AllocSpace objects, 288(182MB) LOS objects, 2% free, 201MB/207MB, paused 248us total 112.856ms
[INFO]  I/ample.hyperloo: WaitForGcToComplete blocked Alloc on ObjectsAllocated for 34.077ms
[INFO]  I/ample.hyperloo: Starting a blocking GC Alloc
[INFO]  I/ample.hyperloo: Waiting for a blocking GC Alloc
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 566(64KB) AllocSpace objects, 240(155MB) LOS objects, 2% free, 228MB/234MB, paused 118us total 113.453ms
[INFO]  I/ample.hyperloo: WaitForGcToComplete blocked Alloc on ObjectsAllocated for 22.574ms
[INFO]  I/ample.hyperloo: Starting a blocking GC Alloc
[INFO]  I/ample.hyperloo: Waiting for a blocking GC Alloc
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 650(64KB) AllocSpace objects, 276(182MB) LOS objects, 2% free, 200MB/206MB, paused 120us total 111.631ms
[INFO]  I/ample.hyperloo: WaitForGcToComplete blocked Alloc on ObjectsAllocated for 31.491ms
[INFO]  I/ample.hyperloo: Starting a blocking GC Alloc
[INFO]  I/ample.hyperloo: Waiting for a blocking GC Alloc
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 544(64KB) AllocSpace objects, 231(155MB) LOS objects, 2% free, 227MB/233MB, paused 178us total 108.944ms
[INFO]  I/ample.hyperloo: WaitForGcToComplete blocked Alloc on ObjectsAllocated for 21.804ms
[INFO]  I/ample.hyperloo: Starting a blocking GC Alloc
[INFO]  I/ample.hyperloo: Waiting for a blocking GC Alloc
[INFO]  I/ample.hyperloo: Background concurrent copying GC freed 630(64KB) AllocSpace objects, 267(183MB) LOS objects, 2% free, 200MB/206MB, paused 352us total 108.461ms
[INFO]  I/ample.hyperloo: WaitForGcToComplete blocked Alloc on ObjectsAllocated for 31.464ms
[INFO]  I/ample.hyperloo: Starting a blocking GC Alloc
[INFO]  I/ample.hyperloo: Waiting for a blocking GC Alloc

Comments

  1. Gary Mathews 2018-08-21

    master: https://github.com/appcelerator/hyperloop.next/pull/302
  2. Hans Knöchel 2018-08-21

    FT works fine! Published [Hyperloop 3.1.2 B1](https://github.com/appcelerator-modules/hyperloop-builds/releases/tag/v3.1.2-beta.1) for QE testing and early adopters (cc [~amukherjee]). *EDIT*: [~gmathews] published [Hyperloop 3.1.2 GA](https://github.com/appcelerator-modules/hyperloop-builds/releases/tag/v3.1.2) which can be used to test. It's affectively the same version, but a different tag.
  3. Samir Mohammed 2018-08-22

    *Closing ticket*. Verified fix in SDK Version: 7.3.1.v20180821233955, 7.4.0.v20180821233840 and SDK Version: 7.5.0.v20180821233900 *FR Passed (Test Steps):*

    Downloaded the Hyperloop examples app https://github.com/appcelerator/hyperloop-examples

    Downloaded and installed Hyperloop 3.1.2.GA

    Ran the application

    Tested various examples and noticed no APP freezes or GC messages

    *Test environment*
       APPC Studio: 5.1.0.201808080937
       APPC CLI: 7.0.5
       Nexus 6p Emulator (7.1)
       Operating System Name: Mac OS High Sierra
       Operating System Version: 10.13
       Node.js Version: 8.9.1
       Xcode 9.2
       

JSON Source