search

jerrellmardis / Amphitheatre

Amphitheatre is an Android TV app that connects with network shares, organizes and serves videos to any Android capable media player app.
Apache License 2.0
437 stars 87 forks source link

OOM Synchronizing Very Large Share #2

Closed JakeWharton closed 10 years ago

JakeWharton commented 10 years ago

I haven't dug into the code yet, but I get OOMs when trying to synchronize my entire share.

                   art  I  Background sticky concurrent mark sweep GC freed 195119(9MB) AllocSpace objects, 0(0B) LOS objects, 230% free,
                            49MB/62MB, paused 1.020ms total 113.741ms
                        I  Background partial concurrent mark sweep GC freed 90603(4MB) AllocSpace objects, 0(0B) LOS objects, 217% free,
                            52MB/64MB, paused 1.538ms total 134.108ms
                        I  Background sticky concurrent mark sweep GC freed 200995(10MB) AllocSpace objects, 0(0B) LOS objects, 185% free
                           , 58MB/72MB, paused 1.338ms total 115.945ms
                        I  Background partial concurrent mark sweep GC freed 77301(4MB) AllocSpace objects, 0(0B) LOS objects, 174% free,
                            62MB/74MB, paused 807us total 147.639ms
                        I  Background sticky concurrent mark sweep GC freed 198383(10MB) AllocSpace objects, 0(0B) LOS objects, 151% free
                           , 68MB/82MB, paused 2.206ms total 104.410ms
                        I  Background partial concurrent mark sweep GC freed 79094(4MB) AllocSpace objects, 0(0B) LOS objects, 142% free,
                            72MB/84MB, paused 2.457ms total 172.552ms
                        I  Background sticky concurrent mark sweep GC freed 195057(10MB) AllocSpace objects, 0(0B) LOS objects, 123% free
                           , 77MB/92MB, paused 2.084ms total 107.538ms
                        I  Background partial concurrent mark sweep GC freed 70351(3MB) AllocSpace objects, 0(0B) LOS objects, 116% free,
                            82MB/94MB, paused 3.815ms total 183.320ms
                        I  Background sticky concurrent mark sweep GC freed 190415(12MB) AllocSpace objects, 0(0B) LOS objects, 104% free
                           , 85MB/102MB, paused 526us total 117.485ms
                        I  Background partial concurrent mark sweep GC freed 195634(9MB) AllocSpace objects, 0(0B) LOS objects, 106% free
                           , 83MB/102MB, paused 568us total 227.757ms
                        I  Background sticky concurrent mark sweep GC freed 201690(14MB) AllocSpace objects, 0(0B) LOS objects, 102% free
                           , 85MB/104MB, paused 1.420ms total 139.381ms
                        I  Background partial concurrent mark sweep GC freed 192194(9MB) AllocSpace objects, 0(0B) LOS objects, 104% free
                           , 83MB/104MB, paused 937us total 212.435ms
   am_on_paused_called  I  [0,com.jerrellmardis.amphitheatre.activity.MainActivity]
   am_on_resume_called  I  [0,com.jerrellmardis.amphitheatre.activity.MainActivity]
                   art  I  Background sticky concurrent mark sweep GC freed 200359(14MB) AllocSpace objects, 0(0B) LOS objects, 102% free
                           , 85MB/104MB, paused 646us total 105.745ms
InputConnectionWrapper  W  getTextAfterCursor on inactive InputConnection
                        W  getTextAfterCursor on inactive InputConnection
                   art  I  Background partial concurrent mark sweep GC freed 1095509(71MB) AllocSpace objects, 0(0B) LOS objects, 163% fr
                           ee, 22MB/104MB, paused 1.233ms total 138.371ms
    InputEventReceiver  W  Attempted to finish an input event but the input event receiver has already been disposed.
                   art  I  Background sticky concurrent mark sweep GC freed 187981(10MB) AllocSpace objects, 0(0B) LOS objects, 143% free
                           , 42MB/104MB, paused 1.111ms total 120.673ms
                        I  Background partial concurrent mark sweep GC freed 97437(5MB) AllocSpace objects, 0(0B) LOS objects, 141% free,
                            44MB/104MB, paused 1.469ms total 117.344ms
                        I  Background sticky concurrent mark sweep GC freed 182008(10MB) AllocSpace objects, 0(0B) LOS objects, 135% free
                           , 50MB/104MB, paused 593us total 108.854ms
                        I  Background partial concurrent mark sweep GC freed 101172(5MB) AllocSpace objects, 0(0B) LOS objects, 133% free
                           , 53MB/104MB, paused 1.841ms total 142.650ms
                        I  Background sticky concurrent mark sweep GC freed 190111(10MB) AllocSpace objects, 0(0B) LOS objects, 127% free
                           , 58MB/104MB, paused 2.895ms total 116.073ms
                        I  Background partial concurrent mark sweep GC freed 96564(5MB) AllocSpace objects, 0(0B) LOS objects, 125% free,
                            61MB/104MB, paused 1.355ms total 148.287ms
                        I  Background sticky concurrent mark sweep GC freed 185972(10MB) AllocSpace objects, 0(0B) LOS objects, 120% free
                           , 67MB/104MB, paused 1.243ms total 118.253ms
                        I  Background partial concurrent mark sweep GC freed 100304(5MB) AllocSpace objects, 0(0B) LOS objects, 117% free
                           , 69MB/104MB, paused 3.862ms total 170.293ms
                        I  Background sticky concurrent mark sweep GC freed 189253(10MB) AllocSpace objects, 0(0B) LOS objects, 111% free
                           , 75MB/104MB, paused 1.399ms total 127.903ms
                        I  Background partial concurrent mark sweep GC freed 99218(5MB) AllocSpace objects, 0(0B) LOS objects, 109% free,
                            78MB/104MB, paused 1.223ms total 191.643ms
                        I  Background sticky concurrent mark sweep GC freed 181007(9MB) AllocSpace objects, 0(0B) LOS objects, 103% free,
                            84MB/104MB, paused 1.818ms total 131.777ms
                        I  Background partial concurrent mark sweep GC freed 96548(5MB) AllocSpace objects, 0(0B) LOS objects, 101% free,
                            86MB/104MB, paused 879us total 209.361ms
                        I  Background sticky concurrent mark sweep GC freed 185298(10MB) AllocSpace objects, 0(0B) LOS objects, 94% free,
                            91MB/106MB, paused 2.418ms total 113.988ms
                        I  Background partial concurrent mark sweep GC freed 100558(5MB) AllocSpace objects, 0(0B) LOS objects, 91% free,
                            94MB/106MB, paused 1.675ms total 230.332ms
                        I  Background sticky concurrent mark sweep GC freed 188504(10MB) AllocSpace objects, 0(0B) LOS objects, 80% free,
                            100MB/114MB, paused 1.880ms total 122.054ms
                        I  Background partial concurrent mark sweep GC freed 107936(5MB) AllocSpace objects, 0(0B) LOS objects, 76% free,
                            103MB/116MB, paused 879us total 262.056ms
                        I  Background sticky concurrent mark sweep GC freed 186559(10MB) AllocSpace objects, 0(0B) LOS objects, 67% free,
                            108MB/124MB, paused 867us total 115.307ms
                        I  Background partial concurrent mark sweep GC freed 91443(4MB) AllocSpace objects, 0(0B) LOS objects, 64% free,
                           112MB/124MB, paused 2.678ms total 281.785ms
                        I  Background sticky concurrent mark sweep GC freed 175120(9MB) AllocSpace objects, 0(0B) LOS objects, 55% free,
                           118MB/132MB, paused 1.643ms total 120.786ms
                        I  Background partial concurrent mark sweep GC freed 93671(5MB) AllocSpace objects, 0(0B) LOS objects, 52% free,
                           122MB/134MB, paused 1.059ms total 295.718ms
                        I  Background sticky concurrent mark sweep GC freed 185456(10MB) AllocSpace objects, 0(0B) LOS objects, 45% free,
                            127MB/142MB, paused 2.133ms total 112.523ms
                        I  Background partial concurrent mark sweep GC freed 97019(5MB) AllocSpace objects, 0(0B) LOS objects, 41% free,
                           131MB/144MB, paused 1.314ms total 325.673ms
                        I  Background sticky concurrent mark sweep GC freed 188392(10MB) AllocSpace objects, 0(0B) LOS objects, 35% free,
                            137MB/152MB, paused 2.996ms total 126.991ms
                        I  Background sticky concurrent mark sweep GC freed 94204(5MB) AllocSpace objects, 0(0B) LOS objects, 33% free, 1
                           40MB/152MB, paused 2.017ms total 102.979ms
                        I  Background partial concurrent mark sweep GC freed 91484(4MB) AllocSpace objects, 0(0B) LOS objects, 32% free,
                           141MB/154MB, paused 1.309ms total 313.886ms
                        I  Background sticky concurrent mark sweep GC freed 188304(10MB) AllocSpace objects, 0(0B) LOS objects, 27% free,
                            146MB/162MB, paused 4.229ms total 108.989ms
                        I  Background partial concurrent mark sweep GC freed 102126(5MB) AllocSpace objects, 0(0B) LOS objects, 24% free,
                            151MB/164MB, paused 3.073ms total 368.522ms
                        I  Background sticky concurrent mark sweep GC freed 184152(10MB) AllocSpace objects, 0(0B) LOS objects, 20% free,
                            156MB/172MB, paused 4.328ms total 123.676ms
                        I  Background partial concurrent mark sweep GC freed 99666(5MB) AllocSpace objects, 0(0B) LOS objects, 17% free,
                           160MB/174MB, paused 5.450ms total 372.174ms
                        I  Background sticky concurrent mark sweep GC freed 173147(9MB) AllocSpace objects, 0(0B) LOS objects, 13% free,
                           167MB/182MB, paused 1.045ms total 131.391ms
                        I  Background partial concurrent mark sweep GC freed 83301(5MB) AllocSpace objects, 0(0B) LOS objects, 11% free,
                           170MB/184MB, paused 6.164ms total 393.221ms
                        I  Background sticky concurrent mark sweep GC freed 188841(10MB) AllocSpace objects, 0(0B) LOS objects, 8% free,
                           176MB/192MB, paused 2.607ms total 129.883ms
                        I  Clamp target GC heap from 197MB to 192MB
                        I  Background partial concurrent mark sweep GC freed 96029(5MB) AllocSpace objects, 0(0B) LOS objects, 5% free, 1
                           81MB/194MB, paused 7.016ms total 446.845ms
                        I  Background sticky concurrent mark sweep GC freed 121110(6MB) AllocSpace objects, 0(0B) LOS objects, 3% free, 1
                           85MB/198MB, paused 3.463ms total 100.827ms
                        I  Clamp target GC heap from 204MB to 192MB
                        I  Background partial concurrent mark sweep GC freed 61308(3MB) AllocSpace objects, 0(0B) LOS objects, 1% free, 1
                           88MB/198MB, paused 1.442ms total 399.028ms
                        I  WaitForGcToComplete blocked for 260.400583ms for cause Alloc
                        I  Clamp target GC heap from 206MB to 192MB
                        I  Background partial concurrent mark sweep GC freed 33268(1875KB) AllocSpace objects, 0(0B) LOS objects, 0% free
                           , 190MB/200MB, paused 3.170ms total 391.827ms
                        I  WaitForGcToComplete blocked for 271.096749ms for cause Alloc
                        I  Clamp target GC heap from 206MB to 192MB
                        I  Background partial concurrent mark sweep GC freed 20601(1149KB) AllocSpace objects, 0(0B) LOS objects, 0% free
                           , 190MB/200MB, paused 2.608ms total 392.369ms
                        I  WaitForGcToComplete blocked for 296.943167ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Background partial concurrent mark sweep GC freed 13054(736KB) AllocSpace objects, 0(0B) LOS objects, 0% free,
                            191MB/200MB, paused 1.596ms total 410.612ms
                        I  WaitForGcToComplete blocked for 129.988417ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Background partial concurrent mark sweep GC freed 8279(465KB) AllocSpace objects, 0(0B) LOS objects, 0% free,
                           191MB/200MB, paused 2.848ms total 372.988ms
                        I  WaitForGcToComplete blocked for 313.172ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Background partial concurrent mark sweep GC freed 5918(339KB) AllocSpace objects, 0(0B) LOS objects, 0% free,
                           191MB/200MB, paused 1.264ms total 366.894ms
                        I  WaitForGcToComplete blocked for 328.605583ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Background partial concurrent mark sweep GC freed 3772(213KB) AllocSpace objects, 0(0B) LOS objects, 0% free,
                           191MB/200MB, paused 1.079ms total 352.816ms
                        I  WaitForGcToComplete blocked for 345.053750ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Background partial concurrent mark sweep GC freed 2514(146KB) AllocSpace objects, 0(0B) LOS objects, 0% free,
                           191MB/200MB, paused 2.685ms total 369.069ms
                        I  WaitForGcToComplete blocked for 354.663667ms for cause Alloc
                        I  Background sticky concurrent mark sweep GC freed 1675(88KB) AllocSpace objects, 0(0B) LOS objects, 0% free, 19
                           1MB/200MB, paused 6.716ms total 26.941ms
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Background partial concurrent mark sweep GC freed 1389(87KB) AllocSpace objects, 0(0B) LOS objects, 0% free, 1
                           91MB/200MB, paused 2.603ms total 372.877ms
                        I  WaitForGcToComplete blocked for 355.135916ms for cause Alloc
                        I  WaitForGcToComplete blocked for 13.564167ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Background partial concurrent mark sweep GC freed 1042(54KB) AllocSpace objects, 0(0B) LOS objects, 0% free, 1
                           91MB/200MB, paused 1.888ms total 355.220ms
                        I  WaitForGcToComplete blocked for 348.897084ms for cause Alloc
                        I  WaitForGcToComplete blocked for 13.220750ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Background partial concurrent mark sweep GC freed 429(22KB) AllocSpace objects, 0(0B) LOS objects, 0% free, 19
                           1MB/200MB, paused 1.525ms total 350.681ms
                        I  WaitForGcToComplete blocked for 345.495167ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Background partial concurrent mark sweep GC freed 491(35KB) AllocSpace objects, 0(0B) LOS objects, 0% free, 19
                           1MB/200MB, paused 761us total 358.355ms
                        I  WaitForGcToComplete blocked for 351.185917ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Background partial concurrent mark sweep GC freed 355(19KB) AllocSpace objects, 0(0B) LOS objects, 0% free, 19
                           1MB/200MB, paused 1.391ms total 360.887ms
                        I  WaitForGcToComplete blocked for 356.534334ms for cause Alloc
                        I  WaitForGcToComplete blocked for 11.179083ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Background partial concurrent mark sweep GC freed 231(11KB) AllocSpace objects, 0(0B) LOS objects, 0% free, 19
                           1MB/200MB, paused 1.403ms total 359.712ms
                        I  WaitForGcToComplete blocked for 358.263249ms for cause Alloc
                        I  WaitForGcToComplete blocked for 14.522500ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc partial concurrent mark sweep GC freed 94(5KB) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200
                           MB, paused 875us total 364.991ms
                        I  WaitForGcToComplete blocked for 365.552167ms for cause Background
                        I  WaitForGcToComplete blocked for 13.421750ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Background partial concurrent mark sweep GC freed 43(2144B) AllocSpace objects, 0(0B) LOS objects, 0% free, 19
                           1MB/200MB, paused 833us total 363.024ms
                        I  WaitForGcToComplete blocked for 362.263333ms for cause Alloc
                        I  WaitForGcToComplete blocked for 17.425167ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Background partial concurrent mark sweep GC freed 21(880B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191
                           MB/200MB, paused 748us total 345.078ms
                        I  WaitForGcToComplete blocked for 345.705334ms for cause Alloc
                        I  Alloc sticky concurrent mark sweep GC freed 5(336B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200M
                           B, paused 1.392ms total 16.908ms
                        I  WaitForGcToComplete blocked for 16.947833ms for cause Background
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Background partial concurrent mark sweep GC freed 11(800B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191
                           MB/200MB, paused 1.206ms total 350.917ms
                        I  WaitForGcToComplete blocked for 349.705417ms for cause Alloc
                        I  WaitForGcToComplete blocked for 6.271083ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Background partial concurrent mark sweep GC freed 9(304B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191M
                           B/200MB, paused 769us total 362.719ms
                        I  WaitForGcToComplete blocked for 363.050250ms for cause Alloc
                        I  Alloc sticky concurrent mark sweep GC freed 1(32B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200MB
                           , paused 1.215ms total 8.829ms
                        I  WaitForGcToComplete blocked for 9.051750ms for cause Background
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc partial concurrent mark sweep GC freed 9(304B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200
                           MB, paused 1.598ms total 349.239ms
                        I  WaitForGcToComplete blocked for 6.863917ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc partial concurrent mark sweep GC freed 3(96B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200M
                           B, paused 1.482ms total 345.494ms
                        I  WaitForGcToComplete blocked for 345.718084ms for cause Alloc
                        I  WaitForGcToComplete blocked for 345.803833ms for cause Background
                        I  WaitForGcToComplete blocked for 11.533917ms for cause Alloc
                        I  Alloc sticky concurrent mark sweep GC freed 0(0B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200MB,
                            paused 1.381ms total 10.303ms
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc concurrent mark sweep GC freed 6(12KB) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200MB, paus
                           ed 1.591ms total 360.025ms
                        I  WaitForGcToComplete blocked for 15.152500ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc partial concurrent mark sweep GC freed 100(5KB) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/20
                           0MB, paused 1.618ms total 350.577ms
                        I  WaitForGcToComplete blocked for 350.001084ms for cause Background
                        I  WaitForGcToComplete blocked for 14.571583ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc partial concurrent mark sweep GC freed 44(2400B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/2
                           00MB, paused 1.389ms total 350.564ms
                        I  WaitForGcToComplete blocked for 350.047333ms for cause Background
                        I  WaitForGcToComplete blocked for 14.522667ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc partial concurrent mark sweep GC freed 26(1328B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/2
                           00MB, paused 1.616ms total 335.535ms
                        I  WaitForGcToComplete blocked for 335.795667ms for cause Background
                        I  WaitForGcToComplete blocked for 9.686583ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc partial concurrent mark sweep GC freed 6(192B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200
                           MB, paused 1.304ms total 350.064ms
                        I  WaitForGcToComplete blocked for 350.675834ms for cause Background
                        I  WaitForGcToComplete blocked for 9.704416ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Background partial concurrent mark sweep GC freed 7(464B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191M
                           B/200MB, paused 726us total 362.576ms
                        I  WaitForGcToComplete blocked for 363.036667ms for cause Alloc
                        I  WaitForGcToComplete blocked for 363.268084ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc partial concurrent mark sweep GC freed 3(96B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200M
                           B, paused 1.241ms total 360.112ms
                        I  WaitForGcToComplete blocked for 359.032667ms for cause Background
                        I  WaitForGcToComplete blocked for 14.627500ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc partial concurrent mark sweep GC freed 8(464B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200
                           MB, paused 744us total 339.958ms
                        I  WaitForGcToComplete blocked for 338.451833ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc partial concurrent mark sweep GC freed 3(96B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200M
                           B, paused 743us total 348.802ms
                        I  Alloc sticky concurrent mark sweep GC freed 3(112B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200M
                           B, paused 715us total 11.886ms
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc partial concurrent mark sweep GC freed 6(192B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200
                           MB, paused 755us total 355.978ms
                        I  WaitForGcToComplete blocked for 715.789584ms for cause Background
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Background partial concurrent mark sweep GC freed 3(96B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB
                           /200MB, paused 1.532ms total 381.857ms
                        I  WaitForGcToComplete blocked for 382.044500ms for cause Alloc
                        I  WaitForGcToComplete blocked for 391.464334ms for cause Alloc
                        I  Alloc sticky concurrent mark sweep GC freed 0(0B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200MB,
                            paused 1.240ms total 9.625ms
                        I  WaitForGcToComplete blocked for 9.075833ms for cause Background
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Background partial concurrent mark sweep GC freed 3(96B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB
                           /200MB, paused 1.646ms total 357.263ms
                        I  WaitForGcToComplete blocked for 357.835499ms for cause Alloc
                        I  WaitForGcToComplete blocked for 356.711750ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc partial concurrent mark sweep GC freed 3(96B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200M
                           B, paused 1.236ms total 380.687ms
                        I  WaitForGcToComplete blocked for 379.932833ms for cause Background
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Background partial concurrent mark sweep GC freed 3(96B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB
                           /200MB, paused 765us total 365.231ms
                        I  WaitForGcToComplete blocked for 365.586416ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc partial concurrent mark sweep GC freed 0(0B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200MB
                           , paused 765us total 365.108ms
                        I  WaitForGcToComplete blocked for 739.955750ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc concurrent mark sweep GC freed 5(128B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200MB, paus
                           ed 756us total 365.780ms
                        I  WaitForGcToComplete blocked for 365.185416ms for cause Background
                        I  WaitForGcToComplete blocked for 8.713667ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc partial concurrent mark sweep GC freed 4(144B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200
                           MB, paused 1.477ms total 364.418ms
                        I  WaitForGcToComplete blocked for 364.781167ms for cause Alloc
                        I  Alloc sticky concurrent mark sweep GC freed 0(0B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200MB,
                            paused 1.434ms total 11.496ms
                        I  WaitForGcToComplete blocked for 11.915501ms for cause Background
                        I  WaitForGcToComplete blocked for 12.009ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc partial concurrent mark sweep GC freed 1(64B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200M
                           B, paused 756us total 358.665ms
                        I  WaitForGcToComplete blocked for 359.305166ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc partial concurrent mark sweep GC freed 0(0B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200MB
                           , paused 768us total 365.765ms
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc concurrent mark sweep GC freed 1(32B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200MB, pause
                           d 1.410ms total 377.932ms
                        I  WaitForGcToComplete blocked for 739.218083ms for cause Background
                        I  WaitForGcToComplete blocked for 9.915750ms for cause Alloc
                        I  Alloc sticky concurrent mark sweep GC freed 0(0B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200MB,
                            paused 741us total 8.932ms
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc partial concurrent mark sweep GC freed 0(0B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200MB
                           , paused 1.636ms total 365.446ms
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc concurrent mark sweep GC freed 0(0B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200MB, paused
                            774us total 372.651ms
                        I  Forcing collection of SoftReferences for 36B allocation
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc concurrent mark sweep GC freed 0(0B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200MB, paused
                            1.529ms total 377.069ms
                        E  Throwing OutOfMemoryError "Failed to allocate a 36 byte allocation with 19 free bytes"
                        I  Alloc sticky concurrent mark sweep GC freed 0(0B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200MB,
                            paused 1.963ms total 12.886ms
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc partial concurrent mark sweep GC freed 0(0B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200MB
                           , paused 1.671ms total 366.654ms
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc concurrent mark sweep GC freed 0(0B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200MB, paused
                            1.856ms total 370.393ms
                        I  Forcing collection of SoftReferences for 28B allocation
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc concurrent mark sweep GC freed 0(0B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200MB, paused
                            1.518ms total 375.820ms
                        I  WaitForGcToComplete blocked for 3.001006082s for cause Alloc
                        E  Throwing OutOfMemoryError "Failed to allocate a 28 byte allocation with 19 free bytes" (recursive case)
                        E  "FinalizerDaemon" daemon prio=5 tid=8 Runnable
                        E    | group="system" sCount=0 dsCount=0 obj=0x786bc0e0 self=0xb838e300
                        E    | sysTid=11983 nice=0 cgrp=apps sched=0/0 handle=0xb838e718
                        E    | state=R schedstat=( 0 0 0 ) utm=658 stm=109 core=0 HZ=100
                        E    | stack=0x9dd3c000-0x9dd40000 stackSize=1040KB
                        E    at java.lang.ref.FinalizerReference.add(FinalizerReference.java:54)
                        E    at com.android.internal.os.BinderInternal$GcWatcher.finalize(BinderInternal.java:40)
                        E    at java.lang.Daemons$FinalizerDaemon.doFinalize(Daemons.java:190)
                        E    at java.lang.Daemons$FinalizerDaemon.run(Daemons.java:173)
                        E    at java.lang.Thread.run(Thread.java:818)
                        I  Alloc sticky concurrent mark sweep GC freed 0(0B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200MB,
                            paused 1.454ms total 14.381ms
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc partial concurrent mark sweep GC freed 4(112B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200
                           MB, paused 1.680ms total 376.196ms
                        I  WaitForGcToComplete blocked for 11.926250ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc partial concurrent mark sweep GC freed 2(80B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200M
                           B, paused 791us total 375.003ms
                        I  WaitForGcToComplete blocked for 375.364333ms for cause Background
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Background partial concurrent mark sweep GC freed 1(32B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB
                           /200MB, paused 1.635ms total 377.509ms
                        I  WaitForGcToComplete blocked for 380.087167ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Background partial concurrent mark sweep GC freed 4(192B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191M
                           B/200MB, paused 1.281ms total 348.114ms
                        I  WaitForGcToComplete blocked for 346.291417ms for cause Alloc
                        I  WaitForGcToComplete blocked for 7.232001ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc partial concurrent mark sweep GC freed 0(0B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200MB
                           , paused 749us total 347.568ms
                        I  Alloc sticky concurrent mark sweep GC freed 0(0B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200MB,
                            paused 1.658ms total 11.904ms
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc concurrent mark sweep GC freed 0(0B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200MB, paused
                            1.799ms total 353.925ms
                        I  Forcing collection of SoftReferences for 100B allocation
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc concurrent mark sweep GC freed 0(0B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200MB, paused
                            1.345ms total 358.897ms
                        E  Throwing OutOfMemoryError "Failed to allocate a 100 byte allocation with 99 free bytes"
                        I  WaitForGcToComplete blocked for 7.340417ms for cause Alloc
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Background partial concurrent mark sweep GC freed 0(0B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/
                           200MB, paused 1.625ms total 358.422ms
                        I  WaitForGcToComplete blocked for 356.807250ms for cause Alloc
                        I  Alloc sticky concurrent mark sweep GC freed 0(0B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200MB,
                            paused 1.285ms total 9.285ms
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc partial concurrent mark sweep GC freed 0(0B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200MB
                           , paused 1.456ms total 358.866ms
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc concurrent mark sweep GC freed 0(0B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200MB, paused
                            1.299ms total 362.479ms
                        I  Forcing collection of SoftReferences for 130B allocation
                        I  Clamp target GC heap from 207MB to 192MB
                        I  Alloc concurrent mark sweep GC freed 0(0B) AllocSpace objects, 0(0B) LOS objects, 0% free, 191MB/200MB, paused
                            760us total 375.879ms
                        E  Throwing OutOfMemoryError "Failed to allocate a 130 byte allocation with 67 free bytes" (recursive case)
                        E  "AsyncTask #2" prio=5 tid=17 Runnable
                        E    | group="main" sCount=0 dsCount=0 obj=0x78d4c080 self=0xb849c6d8
                        E    | sysTid=12171 nice=10 cgrp=apps/bg_non_interactive sched=0/0 handle=0xb849ca50
                        E    | state=R schedstat=( 0 0 0 ) utm=9267 stm=2815 core=2 HZ=100
                        E    | stack=0x9b833000-0x9b837000 stackSize=1040KB
                        E    at jcifs.smb.SmbFile.getUncPath0(SmbFile.java:1140)
                        E    at jcifs.smb.SmbFile.<init>(SmbFile.java:617)
                        E    at jcifs.smb.SmbFile.<init>(SmbFile.java:603)
                        E    at jcifs.smb.SmbFile.<init>(SmbFile.java:624)
                        E    at jcifs.smb.SmbFile.doFindFirstNext(SmbFile.java:2018)
                        E    at jcifs.smb.SmbFile.doEnum(SmbFile.java:1745)
                        E    at jcifs.smb.SmbFile.listFiles(SmbFile.java:1722)
                        E    at jcifs.smb.SmbFile.listFiles(SmbFile.java:1655)
                        E    at com.jerrellmardis.amphitheatre.util.VideoUtils.getFilesFromDir(VideoUtils.java:212)
                        E    at com.jerrellmardis.amphitheatre.util.VideoUtils.getFilesFromDir(VideoUtils.java:218)
                        E    at com.jerrellmardis.amphitheatre.util.VideoUtils.getFilesFromDir(VideoUtils.java:218)
                        E    at com.jerrellmardis.amphitheatre.task.GetFilesTask.getFiles(GetFilesTask.java:105)
                        E    at com.jerrellmardis.amphitheatre.task.GetFilesTask.doInBackground(GetFilesTask.java:65)
                        E    at com.jerrellmardis.amphitheatre.task.GetFilesTask.doInBackground(GetFilesTask.java:35)
                        E    at android.os.AsyncTask$2.call(AsyncTask.java:288)
                        E    at java.util.concurrent.FutureTask.run(FutureTask.java:237)
                        E    at android.os.AsyncTask$SerialExecutor$1.run(AsyncTask.java:231)
                        E    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1112)
                        E    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:587)
                        E    at java.lang.Thread.run(Thread.java:818)
                        I  WaitForGcToComplete blocked for 5.785917ms for cause Alloc
                        I  Alloc partial concurrent mark sweep GC freed 2416362(174MB) AllocSpace objects, 0(0B) LOS objects, 87% free, 1
                           7MB/200MB, paused 721us total 369.963ms
        AndroidRuntime  E  FATAL EXCEPTION: AsyncTask #2
                        E  Process: com.jerrellmardis.amphitheatre, PID: 11965
                        E  java.lang.RuntimeException: An error occured while executing doInBackground()
                        E      at android.os.AsyncTask$3.done(AsyncTask.java:300)
                        E      at java.util.concurrent.FutureTask.finishCompletion(FutureTask.java:355)
                        E      at java.util.concurrent.FutureTask.setException(FutureTask.java:222)
                        E      at java.util.concurrent.FutureTask.run(FutureTask.java:242)
                        E      at android.os.AsyncTask$SerialExecutor$1.run(AsyncTask.java:231)
                        E      at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1112)
                        E      at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:587)
                        E      at java.lang.Thread.run(Thread.java:818)
                        E  Caused by: java.lang.OutOfMemoryError: OutOfMemoryError thrown while trying to throw OutOfMemoryError; no stac
                           k available
   am_on_paused_called  I  [0,com.jerrellmardis.amphitheatre.activity.MainActivity]
               Process  I  Sending signal. PID: 11965 SIG: 9
JakeWharton commented 10 years ago

You can see the memory drain to 0%, a quick bout of GC thrash, and then the ultimate OOM. Maybe batching or doing background processing would fix.

jerrellmardis commented 10 years ago

Ah, ok. It's probably a bit too aggressive with the number of threads it creates when retrieving the movie data.

jerrellmardis commented 10 years ago

How many files do you have?

JakeWharton commented 10 years ago

Not sure what extensions it looks for, but here's .mkvs:

jake@theflame:/tanker/media$ find . -name *.mkv | wc -l
    4140
jerrellmardis commented 10 years ago

Ok. That's quite a bit more files than what I have. It looks like it's running out of memory while building the initial list of files. It looks for files with the following extensions: ".3gp", ".aaf.", "mp4", ".ts", ".webm", ".m4v", ".mkv", ".divx", ".xvid", ".rec", ".avi", ".flv", ".f4v", ".moi", ".mpeg", ".mpg", ".ogv", ".rm", ".rmvb", ".mov", ".wmv", ".iso", ".vob", ".ifo", ".wtv", ".pyv", ".ogm", ".img"

JakeWharton commented 10 years ago

I got to the API call stage using a single subdir which only has 515 files in it.

jerrellmardis commented 10 years ago

Ah, ok. So you ran into the OOM with a directory with only 515 files? I'll try running it from the root directory on my NAS.

JakeWharton commented 10 years ago

The OOM was on the 4000+ file directory. It never got the the stage where it makes API calls to TMDb. When I ran it on a subdir with only 515 files it got to the stage where it's calling TMDb for data (and still is...).

JakeWharton commented 10 years ago

4 made the situation a lot better. #7 will fix it proper. Closing this guy.