App deadlocks during a transition.to on Android

I'm having a hard-to-reproduce bug that only occurs on android, infrequently.

In case you've played Shovel Heroes (http://developer.anscamobile.com/showcase/shovel-heroes), it happens during the matcher mini-game when a new round begins, in the middle of the runes animation.

If not - there are timers set up and >= 5 elements being animated at the same time with rotations and translations. Out of maybe 20-30 times I've tested this, I got it to hang 2 times.

In adb logcat, I don't get any messages during the hang (the last messages that were there at the time the hang happened were GC calls, and nothing out of the ordinary before that).

However, when the device falls asleep and after I wake it up, I get the following messages (I think it starts with "window freeze timeout expired", not 100% sure yet):

1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
16
17
18
19
20
21
22
23
24
25
26
27
28
29
30
31
32
33
34
35
36
37
38
39
40
41
42
43
44
45
46
47
48
49
50
51
52
53
54
55
56
57
I/WindowManager(  114): Setting rotation to 1, animFlags=1
I/ActivityManager(  114): Config changed: { scale=1.0 imsi=0/0 loc=en_US touch=3 keys=1/1/2 nav=1/1 orien=2 layout=34 uiMode=17 seq=164}
D/dalvikvm(  191): GC_EXTERNAL_ALLOC freed 142K, 52% free 2996K/6215K, external 5077K/5083K, paused 167ms
W/WindowManager(  114): Window freeze timeout expired.
W/WindowManager(  114): Force clearing orientation change: Window{406d6800 com.progrestar.shovelhero/com.ansca.corona.CoronaActivity paused=false}
W/WindowManager(  114): Force clearing orientation change: Window{406dea00 SurfaceView paused=false}
W/WindowManager(  114): App freeze timeout expired.
W/WindowManager(  114): Force clearing freeze: AppWindowToken{40ff5b60 token=HistoryRecord{40596908 com.progrestar.shovelhero/com.ansca.corona.CoronaActivity}}
W/SurfaceFlinger(  114): timeout expired mFreezeDisplay=1, mFreezeCount=0
W/WindowManager(  114): Window freeze timeout expired.
W/WindowManager(  114): Force clearing orientation change: Window{406d6800 com.progrestar.shovelhero/com.ansca.corona.CoronaActivity paused=false}
W/WindowManager(  114): Force clearing orientation change: Window{406dea00 SurfaceView paused=false}
W/ActivityManager(  114): Activity idle timeout for HistoryRecord{40596908 com.progrestar.shovelhero/com.ansca.corona.CoronaActivity}
D/dalvikvm(  114): GC_EXPLICIT freed 150K, 70% free 5989K/19655K, external 2873K/3588K, paused 67ms
I/InputDispatcher(  114): Application is not responding: Window{406d6800 com.progrestar.shovelhero/com.ansca.corona.CoronaActivity paused=false}.  6762.3ms since event, 5005.2ms since wait started
I/WindowManager(  114): Input event dispatching timed out sending to com.progrestar.shovelhero/com.ansca.corona.CoronaActivity
I/Process (  114): Sending signal. PID: 4185 SIG: 3
I/dalvikvm( 4185): threadid=4: reacting to signal 3
I/dalvikvm( 4185): Wrote stack traces to '/data/anr/traces.txt'
I/Process (  114): Sending signal. PID: 114 SIG: 3
I/dalvikvm(  114): threadid=4: reacting to signal 3
I/dalvikvm(  114): Wrote stack traces to '/data/anr/traces.txt'
I/Process (  114): Sending signal. PID: 196 SIG: 3
I/dalvikvm(  196): threadid=4: reacting to signal 3
I/dalvikvm(  196): Wrote stack traces to '/data/anr/traces.txt'
I/Process (  114): Sending signal. PID: 197 SIG: 3
I/dalvikvm(  197): threadid=4: reacting to signal 3
I/dalvikvm(  197): Wrote stack traces to '/data/anr/traces.txt'
I/Process (  114): Sending signal. PID: 182 SIG: 3
I/dalvikvm(  182): threadid=4: reacting to signal 3
I/dalvikvm(  182): Wrote stack traces to '/data/anr/traces.txt'
D/dalvikvm(  114): GC_EXPLICIT freed 504K, 69% free 6189K/19655K, external 1625K/2137K, paused 61ms
E/ActivityManager(  114): ANR in com.progrestar.shovelhero (com.progrestar.shovelhero/com.ansca.corona.CoronaActivity)
E/ActivityManager(  114): Reason: keyDispatchingTimedOut
E/ActivityManager(  114): Load: 1.69 / 1.93 / 1.87
E/ActivityManager(  114): CPU usage from 7051ms to 6ms ago with 99% awake:
E/ActivityManager(  114):   97% 4185/com.progrestar.shovelhero: 82% user + 14% kernel / faults: 3 minor
E/ActivityManager(  114):   1.4% 114/system_server: 0.9% user + 0.4% kernel / faults: 183 minor 1 major
E/ActivityManager(  114):   0.8% 75/mediaserver: 0.2% user + 0.5% kernel
E/ActivityManager(  114):   0% 31/vsync_workqueue: 0% user + 0% kernel
E/ActivityManager(  114):   0% 50/irq/308-mxt224_: 0% user + 0% kernel
E/ActivityManager(  114):   0.1% 52/gp2a_wq: 0% user + 0.1% kernel
E/ActivityManager(  114):   0% 67/jbd2/mmcblk0p2-: 0% user + 0% kernel
E/ActivityManager(  114):   0.1% 191/com.google.android.inputmethod.latin: 0.1% user + 0% kernel / faults: 1 minor
E/ActivityManager(  114): 100% TOTAL: 83% user + 16% kernel
E/ActivityManager(  114): CPU usage from 332ms to 847ms later:
E/ActivityManager(  114):   96% 4185/com.progrestar.shovelhero: 78% user + 17% kernel
E/ActivityManager(  114):     92% 4195/Thread-12: 72% user + 19% kernel
E/ActivityManager(  114):     3.9% 4202/Thread-12: 3.9% user + 0% kernel
E/ActivityManager(  114):     1.9% 4204/AudioTrackThrea: 0% user + 1.9% kernel
E/ActivityManager(  114):   3.9% 114/system_server: 0% user + 3.9% kernel / faults: 1 minor
E/ActivityManager(  114):     3.9% 150/InputDispatcher: 0% user + 3.9% kernel
E/ActivityManager(  114):     1.9% 125/system_server: 0% user + 1.9% kernel
E/ActivityManager(  114):   1.4% 83/adbd: 0% user + 1.4% kernel
E/ActivityManager(  114): 100% TOTAL: 76% user + 23% kernel
I/InputDispatcher(  114): Dropping event because the pointer is not down.
I/InputDispatcher(  114): Dropping event because the pointer is not down.

[deleted, miscommented]

views:4950 update:2011/10/8 8:54:25
corona forums © 2003-2011