Closed Bug 983440 Opened 6 years ago Closed 6 years ago

Intermittent testInputConnection | Waiting for current view to have an active InputConnection. - on Android 2.3

Categories

(Firefox for Android :: Testing, defect)

x86_64
Linux
defect
Not set

Tracking

()

RESOLVED FIXED
Firefox 33

People

(Reporter: gbrown, Assigned: gbrown)

References

Details

Attachments

(1 file)

This is an intermittent (frequent) failure on Android 2.3 robocop tests.

https://tbpl.mozilla.org/php/getParsedLog.php?id=36094202&tree=Ash&full=1

14:45:16     INFO -  1 INFO TEST-START | testInputConnection
14:45:16     INFO -  2 INFO TEST-PASS | testInputConnection | Given message occurred for registered event: {"type":"Gecko:Ready"} - Gecko:Ready should equal Gecko:Ready
14:45:16     INFO -  EventExpecter: no longer listening for Gecko:Ready
14:45:16     INFO -  3 INFO TEST-PASS | testInputConnection | url is not null - /robocop/robocop_input.html#foo should not equal null
14:45:16     INFO -  4 INFO TEST-PASS | testInputConnection | url is not null - /robocop/robocop_input.html#foo should not equal null
14:45:16     INFO -  5 INFO TEST-PASS | testInputConnection | The toolbar is not in the editing state - 
14:45:16     INFO -  6 INFO TEST-PASS | testInputConnection | Waiting for Toolbar to enter editing mode. - 
14:45:16     INFO -  7 INFO TEST-PASS | testInputConnection | Waiting for UrlEditText to be input method target. - 
14:45:16     INFO -  8 INFO TEST-PASS | testInputConnection | url is not null - http://mochi.test:8888/tests/robocop/robocop_input.html#foo should not equal null
14:45:16     INFO -  9 INFO TEST-PASS | testInputConnection | The toolbar is in the editing state - 
14:45:16     INFO -  10 INFO TEST-PASS | testInputConnection | The UrlEditText is the input method target - 
14:45:16     INFO -  11 INFO TEST-PASS | testInputConnection | The toolbar is in the editing state - 
14:45:16     INFO -  12 INFO TEST-PASS | testInputConnection | initiatingAction is not null - org.mozilla.gecko.tests.components.ToolbarComponent$2@4069f198 should not equal null
14:45:16     INFO -  ToolbarTitleTextChangeVerifier: stored title, "".
14:45:16     INFO -  EventExpecter: no longer listening for DOMContentLoaded
14:45:16     INFO -  EventExpecter: no longer listening for DOMTitleChanged
14:45:16     INFO -  ToolbarTitleTextChangeVerifier: state changed to title, "Robocop Input".
14:45:16     INFO -  ToolbarTitleTextChangeVerifier: was satisfied.
14:45:16     INFO -  13 INFO TEST-PASS | testInputConnection | Waiting for Toolbar to exit editing mode. - 
14:45:16     INFO -  14 INFO TEST-PASS | testInputConnection | The toolbar is not in the editing state - 
14:45:16     INFO -  15 INFO TEST-PASS | testInputConnection | The Toolbar title is Robocop Input - Robocop Input should equal Robocop Input
14:45:16     INFO -  16 INFO TEST-PASS | testInputConnection | Must have an InputMethodManager - android.view.inputmethod.InputMethodManager@405e8bb8 should not equal null
14:45:16     INFO -  17 INFO TEST-PASS | testInputConnection | Must have an InputMethodManager - android.view.inputmethod.InputMethodManager@405e8bb8 should not equal null
14:45:16     INFO -  18 INFO TEST-PASS | testInputConnection | Must have an InputMethodManager - android.view.inputmethod.InputMethodManager@405e8bb8 should not equal null
14:45:16     INFO -  19 INFO TEST-PASS | testInputConnection | Must have an InputMethodManager - android.view.inputmethod.InputMethodManager@405e8bb8 should not equal null
14:45:16     INFO -  20 INFO TEST-PASS | testInputConnection | Must have an InputMethodManager - android.view.inputmethod.InputMethodManager@405e8bb8 should not equal null
14:45:16     INFO -  21 INFO TEST-PASS | testInputConnection | Must have an InputMethodManager - android.view.inputmethod.InputMethodManager@405e8bb8 should not equal null
14:45:16     INFO -  22 INFO TEST-PASS | testInputConnection | Must have an InputMethodManager - android.view.inputmethod.InputMethodManager@405e8bb8 should not equal null
14:45:16     INFO -  23 INFO TEST-PASS | testInputConnection | Must have an InputMethodManager - android.view.inputmethod.InputMethodManager@405e8bb8 should not equal null
14:45:16     INFO -  24 INFO TEST-PASS | testInputConnection | Must have an InputMethodManager - android.view.inputmethod.InputMethodManager@405e8bb8 should not equal null
14:45:16     INFO -  25 INFO TEST-PASS | testInputConnection | Must have an InputMethodManager - android.view.inputmethod.InputMethodManager@405e8bb8 should not equal null
14:45:16     INFO -  26 INFO TEST-UNEXPECTED-FAIL | testInputConnection | Waiting for current view to have an active InputConnection. - 
14:45:16     INFO -  27 INFO TEST-END | testInputConnection | finished in 66825ms
14:45:16     INFO -  28 INFO TEST-START | Shutdown
14:45:16     INFO -  29 INFO Passed: 24
14:45:16  WARNING -  30 INFO Failed: 1
14:45:16  WARNING -  One or more unittests failed.
14:45:16     INFO -  31 INFO Todo: 0
14:45:16     INFO -  32 INFO SimpleTest FINISHED
14:45:16     INFO -  INFO | automation.py | Application ran for: 0:01:30.257867

14:45:16     INFO -  03-13 14:36:38.897 I/Robocop ( 1692): 21 INFO TEST-PASS | testInputConnection | Must have an InputMethodManager - android.view.inputmethod.InputMethodManager@405e8bb8 should not equal null
14:45:16     INFO -  03-13 14:36:38.947 I/dalvikvm( 1692): Could not find method android.view.View.setActivated, referenced from method org.mozilla.gecko.widget.TwoWayView.setupChild
14:45:16     INFO -  03-13 14:36:38.967 W/dalvikvm( 1692): VFY: unable to resolve virtual method 4180: Landroid/view/View;.setActivated (Z)V
14:45:16     INFO -  03-13 14:36:38.967 D/GeckoTabs( 1692): handleMessage: Content:PageShow
14:45:16     INFO -  03-13 14:36:39.007 I/dalvikvm( 1692): Could not find method android.widget.AdapterView.onInitializeAccessibilityEvent, referenced from method org.mozilla.gecko.widget.TwoWayView.onInitializeAccessibilityEvent
14:45:16     INFO -  03-13 14:36:39.037 W/dalvikvm( 1692): VFY: unable to resolve virtual method 4521: Landroid/widget/AdapterView;.onInitializeAccessibilityEvent (Landroid/view/accessibility/AccessibilityEvent;)V
14:45:16     INFO -  03-13 14:36:39.037 W/dalvikvm( 1692): VFY: unable to find class referenced in signature (Landroid/view/accessibility/AccessibilityNodeInfo;)
14:45:16     INFO -  03-13 14:36:39.047 I/dalvikvm( 1692): Could not find method android.widget.AdapterView.onInitializeAccessibilityNodeInfo, referenced from method org.mozilla.gecko.widget.TwoWayView.onInitializeAccessibilityNodeInfo
14:45:16     INFO -  03-13 14:36:39.047 W/dalvikvm( 1692): VFY: unable to resolve virtual method 4522: Landroid/widget/AdapterView;.onInitializeAccessibilityNodeInfo (Landroid/view/accessibility/AccessibilityNodeInfo;)V
14:45:16     INFO -  03-13 14:36:39.067 I/dalvikvm( 1692): Could not find method android.util.SparseBooleanArray.clone, referenced from method org.mozilla.gecko.widget.TwoWayView.onSaveInstanceState
14:45:16     INFO -  03-13 14:36:39.077 W/dalvikvm( 1692): VFY: unable to resolve virtual method 3882: Landroid/util/SparseBooleanArray;.clone ()Landroid/util/SparseBooleanArray;
14:45:16     INFO -  03-13 14:36:39.117 I/dalvikvm( 1692): Could not find method android.widget.AdapterView.performAccessibilityAction, referenced from method org.mozilla.gecko.widget.TwoWayView.performAccessibilityAction
14:45:16     INFO -  03-13 14:36:39.117 W/dalvikvm( 1692): VFY: unable to resolve virtual method 4529: Landroid/widget/AdapterView;.performAccessibilityAction (ILandroid/os/Bundle;)Z
14:45:16     INFO -  03-13 14:36:39.127 I/dalvikvm( 1692): Could not find method android.view.View.setActivated, referenced from method org.mozilla.gecko.widget.TwoWayView.performItemClick
14:45:16     INFO -  03-13 14:36:39.127 W/dalvikvm( 1692): VFY: unable to resolve virtual method 4180: Landroid/view/View;.setActivated (Z)V
14:45:16     INFO -  03-13 14:36:39.177 D/GeckoTabs( 1692): handleMessage: Content:StateChange
14:45:16     INFO -  03-13 14:36:39.186 I/dalvikvm( 1692): Could not find method android.view.View.setAccessibilityDelegate, referenced from method org.mozilla.gecko.widget.TwoWayView$RecycleBin.addScrapView
14:45:16     INFO -  03-13 14:36:39.186 W/dalvikvm( 1692): VFY: unable to resolve virtual method 4179: Landroid/view/View;.setAccessibilityDelegate (Landroid/view/View$AccessibilityDelegate;)V
14:45:16     INFO -  03-13 14:36:39.207 I/dalvikvm( 1692): Could not find method android.view.View.setAccessibilityDelegate, referenced from method org.mozilla.gecko.widget.TwoWayView$RecycleBin.scrapActiveViews
14:45:16     INFO -  03-13 14:36:39.207 W/dalvikvm( 1692): VFY: unable to resolve virtual method 4179: Landroid/view/View;.setAccessibilityDelegate (Landroid/view/View$AccessibilityDelegate;)V
14:45:16     INFO -  03-13 14:36:39.396 I/Robocop ( 1692): 22 INFO TEST-PASS | testInputConnection | Must have an InputMethodManager - android.view.inputmethod.InputMethodManager@405e8bb8 should not equal null
14:45:16     INFO -  03-13 14:36:39.686 D/GeckoThumbnailHelper( 1692): Using new thumbnail size: 242544 (width 326)
14:45:16     INFO -  03-13 14:36:39.686 D/GeckoThumbnailHelper( 1692): Sending thumbnail event: 326, 186
14:45:16     INFO -  03-13 14:36:39.907 I/Robocop ( 1692): 23 INFO TEST-PASS | testInputConnection | Must have an InputMethodManager - android.view.inputmethod.InputMethodManager@405e8bb8 should not equal null
14:45:16     INFO -  03-13 14:36:40.286 D/GeckoToolbar( 1692): onTabChanged: PAGE_SHOW
14:45:16     INFO -  03-13 14:36:40.286 D/GeckoBrowserApp( 1692): BrowserApp.onTabChanged: 0: PAGE_SHOW
14:45:16     INFO -  03-13 14:36:40.286 D/GeckoToolbar( 1692): onTabChanged: STOP
14:45:16     INFO -  03-13 14:36:40.286 I/GeckoToolbarDisplayLayout( 1692): zerdatime 1788017 - Throbber stop
14:45:16     INFO -  03-13 14:36:40.306 D/GeckoBrowserApp( 1692): BrowserApp.onTabChanged: 0: STOP
14:45:16     INFO -  03-13 14:36:40.430 I/Robocop ( 1692): 24 INFO TEST-PASS | testInputConnection | Must have an InputMethodManager - android.view.inputmethod.InputMethodManager@405e8bb8 should not equal null
14:45:16     INFO -  03-13 14:36:40.617 E/Profiler( 1692): BPUnw: [7 total] thread_register_for_profiling(me=0x2a46d0, stacktop=0x582ffdfb)
14:45:16     INFO -  03-13 14:36:40.937 I/Robocop ( 1692): 25 INFO TEST-PASS | testInputConnection | Must have an InputMethodManager - android.view.inputmethod.InputMethodManager@405e8bb8 should not equal null
14:45:16     INFO -  03-13 14:36:40.977 I/Robocop ( 1692): 26 INFO TEST-UNEXPECTED-FAIL | testInputConnection | Waiting for current view to have an active InputConnection. - 
14:45:16     INFO -  03-13 14:36:40.977 I/Robocop ( 1692): 27 INFO TEST-END | testInputConnection | finished in 66825ms
Assignee: nobody → gbrown
This test still fails on Android 2.3, but now it fails differently, as an intermittent crash on shutdown:

https://tbpl.mozilla.org/php/getParsedLog.php?id=41654292&tree=Try&full=1
https://tbpl.mozilla.org/php/getParsedLog.php?id=41675610&tree=Try&full=1
https://tbpl.mozilla.org/php/getParsedLog.php?id=41675657&tree=Try&full=1

20:40:40     INFO -  62 INFO TEST-PASS | testInputConnection | Can set empty composition - 3 should equal 3
20:40:40     INFO -  63 INFO TEST-PASS | testInputConnection | Can update composition - foobar should equal foobar
20:40:40     INFO -  64 INFO TEST-PASS | testInputConnection | Can update composition - 6 should equal 6
20:40:40     INFO -  65 INFO TEST-PASS | testInputConnection | Can update composition - 6 should equal 6
20:40:40     INFO -  66 INFO TEST-PASS | testInputConnection | Can finish composition - foobar should equal foobar
20:40:40     INFO -  67 INFO TEST-PASS | testInputConnection | Can finish composition - 6 should equal 6
20:40:40     INFO -  68 INFO TEST-PASS | testInputConnection | Can finish composition - 6 should equal 6
20:40:40     INFO -  69 INFO TEST-PASS | testInputConnection | Can retrieve text before cursor - bar should equal bar
20:40:40     INFO -  70 INFO TEST-PASS | testInputConnection | Can retrieve text after cursor -  should equal 
20:40:40     INFO -  71 INFO TEST-END | testInputConnection | finished in 27358ms
20:40:40     INFO -  72 INFO TEST-START | Shutdown
20:40:40     INFO -  73 INFO Passed: 69
20:40:40     INFO -  74 INFO Failed: 0
20:40:40     INFO -  75 INFO Todo: 0
20:40:40     INFO -  76 INFO SimpleTest FINISHED
20:40:40     INFO -  INFO | automation.py | Application ran for: 0:00:33.713091
20:40:40     INFO -  INFO | zombiecheck | Reading PID log: /tmp/tmpaPCpXTpidlog
20:40:40     INFO -  /data/anr/traces.txt not found
20:40:40     INFO -  mozcrash INFO | Downloading symbols from: https://ftp-ssl.mozilla.org/pub/mozilla.org/firefox/try-builds/gbrown@mozilla.com-b4c553e202e8/try-android/fennec-33.0a1.en-US.android-arm.crashreporter-symbols.zip
20:40:40  WARNING -  PROCESS-CRASH | Shutdown | application crashed [@ libc.so + 0x13980]
20:40:40     INFO -  Crash dump filename: /tmp/tmpeN447P/6be09212-3c27-d376-6ad42478-3f6ff7c9.dmp
20:40:40     INFO -  Operating system: Android
20:40:40     INFO -                    0.0.0 Linux 2.6.29-ge3d684d #1 Mon Dec 16 22:26:51 UTC 2013 armv7l generic/sdk/generic:2.3.7/GINGERBREAD/eng.ubuntu.20140123.014351:eng/test-keys
20:40:40     INFO -  CPU: arm
20:40:40     INFO -       0 CPUs
20:40:40     INFO -  
20:40:40     INFO -  Crash reason:  SIGSEGV
20:40:40     INFO -  Crash address: 0x70005f04
20:40:40     INFO -  
20:40:40     INFO -  Thread 49 (crashed)
20:40:40     INFO -   0  libc.so + 0x13980
20:40:40     INFO -       r4 = 0x70005f00    r5 = 0x650069a0    r6 = 0x00000000    r7 = 0x00000000
20:40:40     INFO -       r8 = 0x0000015c    r9 = 0x00000024   r10 = 0x0031d7d0    fp = 0x00000000
20:40:40     INFO -       sp = 0x57bffa58    lr = 0xafd1406b    pc = 0xafd13980
20:40:40     INFO -      Found by: given as instruction pointer in context
20:40:40     INFO -   1  libc.so + 0x14069
20:40:40     INFO -       sp = 0x57bffa70    pc = 0xafd1406b
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -   2  libc.so + 0x14461
20:40:40     INFO -       sp = 0x57bffa88    pc = 0xafd14463
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -   3  dalvik-heap (deleted) + 0x509456
20:40:40     INFO -       sp = 0x57bffa9c    pc = 0x40512458
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -   4  libc.so + 0x144cf
20:40:40     INFO -       sp = 0x57bffaa0    pc = 0xafd144d1
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -   5  libc.so + 0x1473b
20:40:40     INFO -       sp = 0x57bffaa8    pc = 0xafd1473d
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -   6  libbinder.so + 0x1ac49
20:40:40     INFO -       sp = 0x57bffab0    pc = 0xa821ac4b
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -   7  libdvm.so + 0x9f366
20:40:40     INFO -       sp = 0x57bffac4    pc = 0xaca9f368
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -   8  libdvm.so + 0x438b7
20:40:40     INFO -       sp = 0x57bffac8    pc = 0xaca438b9
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -   9  libdvm.so + 0x8175e
20:40:40     INFO -       sp = 0x57bffacc    pc = 0xaca81760
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  10  dalvik-heap (deleted) + 0x509426
20:40:40     INFO -       sp = 0x57bffad0    pc = 0x40512428
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  11  libdvm.so + 0x8175e
20:40:40     INFO -       sp = 0x57bffad4    pc = 0xaca81760
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  12  dalvik-heap (deleted) + 0x509456
20:40:40     INFO -       sp = 0x57bffae8    pc = 0x40512458
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  13  libdvm.so + 0x9f366
20:40:40     INFO -       sp = 0x57bffaf4    pc = 0xaca9f368
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  14  libbinder.so + 0x1ad67
20:40:40     INFO -       sp = 0x57bffaf8    pc = 0xa821ad69
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  15  libbinder.so + 0x1aebb
20:40:40     INFO -       sp = 0x57bffb00    pc = 0xa821aebd
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  16  dalvik-heap (deleted) + 0x509456
20:40:40     INFO -       sp = 0x57bffb14    pc = 0x40512458
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  17  libbinder.so + 0x1aefb
20:40:40     INFO -       sp = 0x57bffb18    pc = 0xa821aefd
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  18  dalvik-heap (deleted) + 0x509426
20:40:40     INFO -       sp = 0x57bffb20    pc = 0x40512428
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  19  dalvik-heap (deleted) + 0x509456
20:40:40     INFO -       sp = 0x57bffb28    pc = 0x40512458
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  20  libandroid_runtime.so + 0x4cf37
20:40:40     INFO -       sp = 0x57bffb38    pc = 0xad34cf39
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  21  libdvm.so + 0x11e76
20:40:40     INFO -       sp = 0x57bffb50    pc = 0xaca11e78
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  22  dalvik-LinearAlloc (deleted) + 0x466c6
20:40:40     INFO -       sp = 0x57bffb64    pc = 0x442d36c8
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  23  libdvm.so + 0x436d9
20:40:40     INFO -       sp = 0x57bffb70    pc = 0xaca436db
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  24  framework.odex + 0x4c4621
20:40:40     INFO -       sp = 0x57bffb78    pc = 0x4533c623
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  25  libandroid_runtime.so + 0x4cefb
20:40:40     INFO -       sp = 0x57bffb7c    pc = 0xad34cefd
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  26  dalvik-LinearAlloc (deleted) + 0x466c6
20:40:40     INFO -       sp = 0x57bffb88    pc = 0x442d36c8
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  27  libdvm.so + 0x1203e
20:40:40     INFO -       sp = 0x57bffb94    pc = 0xaca12040
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  28  libdvm.so + 0x3c1cb
20:40:40     INFO -       sp = 0x57bffba0    pc = 0xaca3c1cd
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  29  framework.odex + 0x2e53f6
20:40:40     INFO -       sp = 0x57bffba4    pc = 0x4515d3f8
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  30  dalvik-heap (deleted) + 0x1d5ce
20:40:40     INFO -       sp = 0x57bffbb0    pc = 0x400265d0
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  31  libdvm.so + 0x1203e
20:40:40     INFO -       sp = 0x57bffbb4    pc = 0xaca12040
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  32  libdvm.so + 0x17076
20:40:40     INFO -       sp = 0x57bffbb8    pc = 0xaca17078
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  33  libdvm.so + 0x9f366
20:40:40     INFO -       sp = 0x57bffbdc    pc = 0xaca9f368
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  34  libdvm.so + 0x1c116
20:40:40     INFO -       sp = 0x57bffbe0    pc = 0xaca1c118
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  35  libdvm.so + 0x1c086
20:40:40     INFO -       sp = 0x57bffbec    pc = 0xaca1c088
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  36  dalvik-LinearAlloc (deleted) + 0x1a82
20:40:40     INFO -       sp = 0x57bffbf0    pc = 0x4428ea84
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  37  libdvm.so + 0x1b002
20:40:40     INFO -       sp = 0x57bffbf8    pc = 0xaca1b004
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  38  core.odex + 0x16c37a
20:40:40     INFO -       sp = 0x57bffc0c    pc = 0x448fa37c
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  39  dalvik-heap (deleted) + 0x60ebce
20:40:40     INFO -       sp = 0x57bffc14    pc = 0x40617bd0
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  40  dalvik-LinearAlloc (deleted) + 0x13df4e
20:40:40     INFO -       sp = 0x57bffc1c    pc = 0x443caf50
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  41  dalvik-heap (deleted) + 0x39fff6e
20:40:40     INFO -       sp = 0x57bffc34    pc = 0x43a08f70
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  42  libdvm.so + 0xa3b06
20:40:40     INFO -       sp = 0x57bffc5c    pc = 0xacaa3b08
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  43  libdvm.so + 0x16d56
20:40:40     INFO -       sp = 0x57bffc68    pc = 0xaca16d58
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  44  libdvm.so + 0x16dce
20:40:40     INFO -       sp = 0x57bffc6c    pc = 0xaca16dd0
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  45  libdvm.so + 0x16c76
20:40:40     INFO -       sp = 0x57bffc70    pc = 0xaca16c78
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  46  libdvm.so + 0x16c9e
20:40:40     INFO -       sp = 0x57bffc74    pc = 0xaca16ca0
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  47  libdvm.so + 0x16cce
20:40:40     INFO -       sp = 0x57bffc78    pc = 0xaca16cd0
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  48  libdvm.so + 0x16cf2
20:40:40     INFO -       sp = 0x57bffc7c    pc = 0xaca16cf4
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  49  libdvm.so + 0x79537
20:40:40     INFO -       sp = 0x57bffc80    pc = 0xaca79539
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  50  core.odex + 0xcfcf4
20:40:40     INFO -       sp = 0x57bffc8c    pc = 0x4485dcf6
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  51  core.odex + 0xcfcf4
20:40:40     INFO -       sp = 0x57bffc90    pc = 0x4485dcf6
20:40:40     INFO -      Found by: stack scanning
20:40:40     INFO -  52  core.odex + 0xc34ba
20:40:40     INFO -       sp = 0x57bffc9c    pc = 0x448514bc
20:40:40     INFO -      Found by: stack scanning

20:40:40     INFO -  06-12 20:32:15.353 I/Robocop ( 1938): 71 INFO TEST-END | testInputConnection | finished in 27358ms
20:40:40     INFO -  06-12 20:32:15.353 I/Robocop ( 1938): 72 INFO TEST-START | Shutdown
20:40:40     INFO -  06-12 20:32:15.353 I/Robocop ( 1938): 73 INFO Passed: 69
20:40:40     INFO -  06-12 20:32:15.363 I/Robocop ( 1938): 74 INFO Failed: 0
20:40:40     INFO -  06-12 20:32:15.363 I/Robocop ( 1938): 75 INFO Todo: 0
20:40:40     INFO -  06-12 20:32:15.363 I/Robocop ( 1938): 76 INFO SimpleTest FINISHED
20:40:40     INFO -  06-12 20:32:15.413 I/GeckoDump( 1938): Robocop:Quit received -- requesting quit
20:40:40     INFO -  06-12 20:32:15.533 D/        (  118): HostConnection::get() New Host Connection established 0x273ea0, tid 118
20:40:40     INFO -  06-12 20:32:15.603 D/GeckoLayerClient( 1938): Window-size changed to (1024,533)
20:40:40     INFO -  06-12 20:32:17.254 W/GeckoEventDispatcher( 1938): No listeners for SearchEngines:Data
20:40:40     INFO -  06-12 20:32:17.673 E/GeckoConsole( 1938): [JavaScript Error: "win is undefined" {file: "chrome://browser/content/browser.js" line: 3424}]
20:40:40     INFO -  06-12 20:32:18.874 D/Zygote  (   36): Process 1938 terminated by signal (11)
I noticed this on one local run:

06-13 10:20:45.168 I/Robocop ( 1214): 24 INFO TEST-START | Shutdown
06-13 10:20:45.168 I/Robocop ( 1214): 25 INFO Passed: 21
06-13 10:20:45.168 I/Robocop ( 1214): 26 INFO Failed: 0
06-13 10:20:45.178 I/Robocop ( 1214): 27 INFO Todo: 0
06-13 10:20:45.178 I/Robocop ( 1214): 28 INFO SimpleTest FINISHED
06-13 10:20:45.188 I/GeckoDump( 1214): Robocop:Quit received -- requesting quit
06-13 10:20:46.728 W/SharedBufferStack( 1214): waitForCondition(LockCondition) timed out (identity=50, status=0). CPU may be pegged. trying again.
06-13 10:20:48.879 W/SharedBufferStack( 1214): waitForCondition(LockCondition) timed out (identity=50, status=0). CPU may be pegged. trying again.
06-13 10:20:49.894 W/SharedBufferStack( 1214): waitForCondition(LockCondition) timed out (identity=50, status=0). CPU may be pegged. trying again.
06-13 10:20:50.889 W/SharedBufferStack( 1214): waitForCondition(LockCondition) timed out (identity=50, status=0). CPU may be pegged. trying again.
06-13 10:20:51.899 W/SharedBufferStack( 1214): waitForCondition(LockCondition) timed out (identity=50, status=0). CPU may be pegged. trying again.
06-13 10:20:52.799 W/ActivityManager(   64): Activity pause timeout for HistoryRecord{4064ada8 org.mozilla.fennec_gbrown/.App}
06-13 10:20:52.889 W/ActivityManager(   64): Duplicate finish request for HistoryRecord{4064ada8 org.mozilla.fennec_gbrown/.App}
06-13 10:20:53.198 W/InputDispatcher(   64): Permission denied: injecting event from pid 1214 uid 10017 to window with input channel 40722718 com.mozilla.SUTAgentAndroid/com.mozilla.SUTAgentAndroid.SUTAgentAndroid (server) owned by uid 10022
06-13 10:20:53.198 W/WindowManager(   64): Input event injection permission denied.
06-13 10:20:53.208 W/ActivityManager(   64): Duplicate finish request for HistoryRecord{4064ada8 org.mozilla.fennec_gbrown/.App}
06-13 10:20:53.318 I/TestRunner( 1214): failed: testInputConnection(org.mozilla.gecko.tests.testInputConnection)
06-13 10:20:53.318 I/TestRunner( 1214): ----- begin exception -----
06-13 10:20:53.318 I/TestRunner( 1214): 
06-13 10:20:53.318 I/TestRunner( 1214): java.lang.NoSuchMethodException
06-13 10:20:53.318 I/TestRunner( 1214): 	at java.lang.Class.getDeclaredFields(Native Method)
06-13 10:20:53.318 I/TestRunner( 1214): 	at java.lang.ClassCache.getDeclaredFields(ClassCache.java:315)
06-13 10:20:53.318 I/TestRunner( 1214): 	at java.lang.Class.getDeclaredField(Class.java:665)
06-13 10:20:53.318 I/TestRunner( 1214): 	at org.mozilla.gecko.tests.helpers.FrameworkHelper.getClassField(FrameworkHelper.java:31)
06-13 10:20:53.318 I/TestRunner( 1214): 	at org.mozilla.gecko.tests.helpers.FrameworkHelper.getField(FrameworkHelper.java:45)
06-13 10:20:53.318 I/TestRunner( 1214): 	at org.mozilla.gecko.tests.helpers.FrameworkHelper.getViewContext(FrameworkHelper.java:82)
06-13 10:20:53.318 I/TestRunner( 1214): 	at org.mozilla.gecko.tests.components.GeckoViewComponent$TextInput.testInputConnection(GeckoViewComponent.java:140)
06-13 10:20:53.318 I/TestRunner( 1214): 	at org.mozilla.gecko.tests.testInputConnection.testInputConnection(testInputConnection.java:30)
06-13 10:20:53.318 I/TestRunner( 1214): 	at java.lang.reflect.Method.invokeNative(Native Method)
06-13 10:20:53.318 I/TestRunner( 1214): 	at java.lang.reflect.Method.invoke(Method.java:507)
06-13 10:20:53.318 I/TestRunner( 1214): 	at android.test.InstrumentationTestCase.runMethod(InstrumentationTestCase.java:204)
06-13 10:20:53.318 I/TestRunner( 1214): 	at android.test.InstrumentationTestCase.runTest(InstrumentationTestCase.java:194)
06-13 10:20:53.318 I/TestRunner( 1214): 	at android.test.ActivityInstrumentationTestCase2.runTest(ActivityInstrumentationTestCase2.java:186)
06-13 10:20:53.318 I/TestRunner( 1214): 	at junit.framework.TestCase.runBare(TestCase.java:127)
06-13 10:20:53.318 I/TestRunner( 1214): 	at junit.framework.TestResult$1.protect(TestResult.java:106)
06-13 10:20:53.318 I/TestRunner( 1214): 	at junit.framework.TestResult.runProtected(TestResult.java:124)
06-13 10:20:53.318 I/TestRunner( 1214): 	at junit.framework.TestResult.run(TestResult.java:109)
06-13 10:20:53.318 I/TestRunner( 1214): 	at junit.framework.TestCase.run(TestCase.java:118)
06-13 10:20:53.318 I/TestRunner( 1214): 	at android.test.AndroidTestRunner.runTest(AndroidTestRunner.java:169)
06-13 10:20:53.318 I/TestRunner( 1214): 	at android.test.AndroidTestRunner.runTest(AndroidTestRunner.java:154)
06-13 10:20:53.318 I/TestRunner( 1214): 	at android.test.InstrumentationTestRunner.onStart(InstrumentationTestRunner.java:529)
06-13 10:20:53.318 I/TestRunner( 1214): 	at android.app.Instrumentation$InstrumentationThread.run(Instrumentation.java:1448)
06-13 10:20:53.318 I/TestRunner( 1214): ----- end exception -----
06-13 10:20:53.348 I/TestRunner( 1214): finished: testInputConnection(org.mozilla.gecko.tests.testInputConnection)
06-13 10:20:53.359 I/ActivityManager(   64): Force stopping package org.mozilla.fennec_gbrown uid=10017
06-13 10:20:53.368 I/Process (   64): Sending signal. PID: 1214 SIG: 9
I was able to intermittently reproduce the NoSuchMethodException shown in Comment 5. https://code.google.com/p/roboguice/issues/detail?id=226 suggests that this is a known issue fixed in Honeycomb.

With this change, try runs fail intermittently only due to bug 1025968, so I "transfer" the test disabled comment to that bug.

https://tbpl.mozilla.org/?tree=Try&rev=06e1c01790b5
Attachment #8440756 - Flags: review?(nchen)
Comment on attachment 8440756 [details] [diff] [review]
guard against NoSuchMethodException

Review of attachment 8440756 [details] [diff] [review]:
-----------------------------------------------------------------

Any theory why it only happens intermittently? Seems like that bug would cause this all the time.

::: mobile/android/base/tests/helpers/FrameworkHelper.java
@@ +30,5 @@
>              try {
>                  return cls.getDeclaredField(fieldName);
> +            // NoSuchFieldException is expected. Before Honeycomb, NoSuchMethodException
> +            // is also possible.
> +            } catch (final Exception e) {

catch NoSuchMethodException separately, with a comment explaining why it can be thrown.
Attachment #8440756 - Flags: review?(nchen) → feedback+
Comment on attachment 8440756 [details] [diff] [review]
guard against NoSuchMethodException

> catch NoSuchMethodException separately, with a comment explaining why it can be thrown.

That causes a build error:

 0:58.97 /home/gbrown/src/mobile/android/base/tests/helpers/FrameworkHelper.java:34: exception java.lang.NoSuchMethodException is never thrown in body of corresponding try statement
 0:58.97             } catch (final NoSuchMethodException e) {
 0:58.97               ^

so I think catching Exception is the best way forward.
Attachment #8440756 - Flags: review?(nchen)
Comment on attachment 8440756 [details] [diff] [review]
guard against NoSuchMethodException

Review of attachment 8440756 [details] [diff] [review]:
-----------------------------------------------------------------

(In reply to Geoff Brown [:gbrown] from comment #8)
> Comment on attachment 8440756 [details] [diff] [review]
> guard against NoSuchMethodException
> 
> > catch NoSuchMethodException separately, with a comment explaining why it can be thrown.
> 
> That causes a build error:
> 
>  0:58.97
> /home/gbrown/src/mobile/android/base/tests/helpers/FrameworkHelper.java:34:
> exception java.lang.NoSuchMethodException is never thrown in body of
> corresponding try statement
>  0:58.97             } catch (final NoSuchMethodException e) {
>  0:58.97               ^
> 
> so I think catching Exception is the best way forward.

Ok. r+ with a better comment explaining why NoSuchMethodException could be thrown
Attachment #8440756 - Flags: review?(nchen) → review+
(In reply to Jim Chen [:jchen :nchen] from comment #7)
> Any theory why it only happens intermittently? Seems like that bug would
> cause this all the time.

It is odd. I do not have an explanation.

When NoSuchMethodException is thrown, getDeclaredField has been called on class org.mozilla.gecko.gfx.LayerView with field name "mContext". But sometimes those exact same conditions result in NoSuchFieldException.
With verbose comment: https://hg.mozilla.org/integration/mozilla-inbound/rev/b6e9b199df46

testInputConnection remains disabled, but now on account of bug 1025968.
Whiteboard: [leave open] [test disabled on Android 2.3]
https://hg.mozilla.org/mozilla-central/rev/b6e9b199df46
Status: NEW → RESOLVED
Closed: 6 years ago
Resolution: --- → FIXED
Target Milestone: --- → Firefox 33
You need to log in before you can comment on or make changes to this bug.