Intermittent org.mozilla.geckoview.test.TextInputDelegateTest#inputConnection_bug1650705[#input] | org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 30000ms
Categories
(GeckoView :: IME, defect, P5)
Tracking
(firefox88 fixed, firefox89 fixed)
People
(Reporter: intermittent-bug-filer, Assigned: m_kato)
References
(Regression)
Details
(Keywords: intermittent-failure, regression, Whiteboard: [retriggered][stockwell unknown])
Attachments
(1 file)
Filed by: abutkovits [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=330667525&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/MzoV96xkRZuVtuy3F3ehpw/runs/0/artifacts/public/logs/live_backing.log
[task 2021-02-21T18:05:30.601Z] 18:05:30 INFO - TEST-START | org.mozilla.geckoview.test.TextInputDelegateTest.inputConnection_bug1650705[#input]
[task 2021-02-21T18:06:01.678Z] 18:06:01 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=784
[task 2021-02-21T18:06:01.678Z] 18:06:01 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=
[task 2021-02-21T18:06:01.679Z] 18:06:01 INFO - org.mozilla.geckoview.test | Error in inputConnection_bug1650705[#input](org.mozilla.geckoview.test.TextInputDelegateTest):
[task 2021-02-21T18:06:01.679Z] 18:06:01 INFO - org.mozilla.geckoview.test | org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 30000ms
[task 2021-02-21T18:06:01.679Z] 18:06:01 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutRunnable.run(UiThreadUtils.java:52)
[task 2021-02-21T18:06:01.679Z] 18:06:01 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:751)
[task 2021-02-21T18:06:01.679Z] 18:06:01 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2021-02-21T18:06:01.679Z] 18:06:01 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils.waitForCondition(UiThreadUtils.java:155)
[task 2021-02-21T18:06:01.680Z] 18:06:01 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForMessage(GeckoSessionTestRule.java:1927)
[task 2021-02-21T18:06:01.680Z] 18:06:01 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.evaluateJS(GeckoSessionTestRule.java:1912)
[task 2021-02-21T18:06:01.680Z] 18:06:01 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$ExtensionPromise.getValue(GeckoSessionTestRule.java:1882)
[task 2021-02-21T18:06:01.680Z] 18:06:01 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.TextInputDelegateTest.setSelection(TextInputDelegateTest.kt:171)
[task 2021-02-21T18:06:01.681Z] 18:06:01 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.TextInputDelegateTest.inputConnection_bug1650705(TextInputDelegateTest.kt:936)
[task 2021-02-21T18:06:01.681Z] 18:06:01 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invoke(Native Method)
[task 2021-02-21T18:06:01.681Z] 18:06:01 INFO - org.mozilla.geckoview.test | at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
[task 2021-02-21T18:06:01.681Z] 18:06:01 INFO - org.mozilla.geckoview.test | at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
[task 2021-02-21T18:06:01.681Z] 18:06:01 INFO - org.mozilla.geckoview.test | at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
[task 2021-02-21T18:06:01.682Z] 18:06:01 INFO - org.mozilla.geckoview.test | at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
[task 2021-02-21T18:06:01.682Z] 18:06:01 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$2.lambda$evaluate$0$GeckoSessionTestRule$2(GeckoSessionTestRule.java:1313)
[task 2021-02-21T18:06:01.682Z] 18:06:01 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.-$$Lambda$GeckoSessionTestRule$2$sIbRNaZJgAu-QrUVWSGD8JbPSWM.run(lambda)
[task 2021-02-21T18:06:01.682Z] 18:06:01 INFO - org.mozilla.geckoview.test | at android.app.Instrumentation$SyncRunnable.run(Instrumentation.java:1950)
[task 2021-02-21T18:06:01.683Z] 18:06:01 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:751)
[task 2021-02-21T18:06:01.683Z] 18:06:01 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2021-02-21T18:06:01.683Z] 18:06:01 INFO - org.mozilla.geckoview.test | at android.os.Looper.loop(Looper.java:154)
[task 2021-02-21T18:06:01.683Z] 18:06:01 INFO - org.mozilla.geckoview.test | at android.app.ActivityThread.main(ActivityThread.java:6077)
[task 2021-02-21T18:06:01.683Z] 18:06:01 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invoke(Native Method)
[task 2021-02-21T18:06:01.683Z] 18:06:01 INFO - org.mozilla.geckoview.test | at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:866)
[task 2021-02-21T18:06:01.683Z] 18:06:01 INFO - org.mozilla.geckoview.test | at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:756)
[task 2021-02-21T18:06:01.684Z] 18:06:01 INFO - org.mozilla.geckoview.test |
[task 2021-02-21T18:06:01.684Z] 18:06:01 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2021-02-21T18:06:01.684Z] 18:06:01 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: test=inputConnection_bug1650705[#input]
[task 2021-02-21T18:06:01.684Z] 18:06:01 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: class=org.mozilla.geckoview.test.TextInputDelegateTest
[task 2021-02-21T18:06:01.684Z] 18:06:01 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stack=org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 30000ms
[task 2021-02-21T18:06:01.684Z] 18:06:01 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutRunnable.run(UiThreadUtils.java:52)
[task 2021-02-21T18:06:01.685Z] 18:06:01 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:751)
[task 2021-02-21T18:06:01.685Z] 18:06:01 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2021-02-21T18:06:01.685Z] 18:06:01 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils.waitForCondition(UiThreadUtils.java:155)
[task 2021-02-21T18:06:01.685Z] 18:06:01 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForMessage(GeckoSessionTestRule.java:1927)
[task 2021-02-21T18:06:01.685Z] 18:06:01 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.evaluateJS(GeckoSessionTestRule.java:1912)
[task 2021-02-21T18:06:01.686Z] 18:06:01 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$ExtensionPromise.getValue(GeckoSessionTestRule.java:1882)
[task 2021-02-21T18:06:01.686Z] 18:06:01 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.TextInputDelegateTest.setSelection(TextInputDelegateTest.kt:171)
[task 2021-02-21T18:06:01.686Z] 18:06:01 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.TextInputDelegateTest.inputConnection_bug1650705(TextInputDelegateTest.kt:936)
[task 2021-02-21T18:06:01.686Z] 18:06:01 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invoke(Native Method)
[task 2021-02-21T18:06:01.686Z] 18:06:01 INFO - org.mozilla.geckoview.test | at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
[task 2021-02-21T18:06:01.687Z] 18:06:01 INFO - org.mozilla.geckoview.test | at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
[task 2021-02-21T18:06:01.687Z] 18:06:01 INFO - org.mozilla.geckoview.test | at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
[task 2021-02-21T18:06:01.687Z] 18:06:01 INFO - org.mozilla.geckoview.test | at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
[task 2021-02-21T18:06:01.687Z] 18:06:01 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$2.lambda$evaluate$0$GeckoSessionTestRule$2(GeckoSessionTestRule.java:1313)
[task 2021-02-21T18:06:01.687Z] 18:06:01 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.-$$Lambda$GeckoSessionTestRule$2$sIbRNaZJgAu-QrUVWSGD8JbPSWM.run(lambda)
[task 2021-02-21T18:06:01.687Z] 18:06:01 INFO - org.mozilla.geckoview.test | at android.app.Instrumentation$SyncRunnable.run(Instrumentation.java:1950)
[task 2021-02-21T18:06:01.688Z] 18:06:01 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:751)
[task 2021-02-21T18:06:01.688Z] 18:06:01 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2021-02-21T18:06:01.688Z] 18:06:01 INFO - org.mozilla.geckoview.test | at android.os.Looper.loop(Looper.java:154)
[task 2021-02-21T18:06:01.688Z] 18:06:01 INFO - org.mozilla.geckoview.test | at android.app.ActivityThread.main(ActivityThread.java:6077)
[task 2021-02-21T18:06:01.688Z] 18:06:01 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invoke(Native Method)
[task 2021-02-21T18:06:01.688Z] 18:06:01 INFO - org.mozilla.geckoview.test | at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:866)
[task 2021-02-21T18:06:01.690Z] 18:06:01 INFO - org.mozilla.geckoview.test | at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:756)
[task 2021-02-21T18:06:01.690Z] 18:06:01 INFO - org.mozilla.geckoview.test |
[task 2021-02-21T18:06:01.690Z] 18:06:01 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=614
[task 2021-02-21T18:06:01.690Z] 18:06:01 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS_CODE: -2
[task 2021-02-21T18:06:01.690Z] 18:06:01 WARNING - TEST-UNEXPECTED-FAIL | org.mozilla.geckoview.test.TextInputDelegateTest.inputConnection_bug1650705[#input] | org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 30000ms```
Comment hidden (Intermittent Failures Robot) |
Comment 2•4 years ago
|
||
Makoto can you take a look at this intermittent please?
Updated•4 years ago
|
Comment 4•4 years ago
|
||
There are 27 total failures in the last 7 days on
- android-em-7-0-x86_64 debug and opt
- android-em-7-0-x86_64-qr debug and opt
Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=331350712&repo=autoland&lineNumber=12915
[task 2021-02-26T15:29:06.359Z] 15:29:06 INFO - TEST-START | org.mozilla.geckoview.test.TextInputDelegateTest.inputConnection_bug1650705[#input]
[task 2021-02-26T15:29:38.933Z] 15:29:38 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=794
[task 2021-02-26T15:29:38.933Z] 15:29:38 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=
[task 2021-02-26T15:29:38.933Z] 15:29:38 INFO - org.mozilla.geckoview.test | Error in inputConnection_bug1650705#input:
[task 2021-02-26T15:29:38.934Z] 15:29:38 INFO - org.mozilla.geckoview.test | org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 30000ms
[task 2021-02-26T15:29:38.934Z] 15:29:38 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutRunnable.run(UiThreadUtils.java:52)
[task 2021-02-26T15:29:38.934Z] 15:29:38 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:751)
[task 2021-02-26T15:29:38.934Z] 15:29:38 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2021-02-26T15:29:38.934Z] 15:29:38 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils.waitForCondition(UiThreadUtils.java:155)
[task 2021-02-26T15:29:38.934Z] 15:29:38 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForMessage(GeckoSessionTestRule.java:1931)
[task 2021-02-26T15:29:38.934Z] 15:29:38 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.evaluateJS(GeckoSessionTestRule.java:1916)
[task 2021-02-26T15:29:38.934Z] 15:29:38 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$ExtensionPromise.getValue(GeckoSessionTestRule.java:1886)
[task 2021-02-26T15:29:38.934Z] 15:29:38 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.TextInputDelegateTest.setSelection(TextInputDelegateTest.kt:171)
[task 2021-02-26T15:29:38.934Z] 15:29:38 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.TextInputDelegateTest.inputConnection_bug1650705(TextInputDelegateTest.kt:936)
[task 2021-02-26T15:29:38.935Z] 15:29:38 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invoke(Native Method)
[task 2021-02-26T15:29:38.935Z] 15:29:38 INFO - org.mozilla.geckoview.test | at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
[task 2021-02-26T15:29:38.935Z] 15:29:38 INFO - org.mozilla.geckoview.test | at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
[task 2021-02-26T15:29:38.935Z] 15:29:38 INFO - org.mozilla.geckoview.test | at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
[task 2021-02-26T15:29:38.935Z] 15:29:38 INFO - org.mozilla.geckoview.test | at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
[task 2021-02-26T15:29:38.939Z] 15:29:38 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$2.lambda$evaluate$0$GeckoSessionTestRule$2(GeckoSessionTestRule.java:1317)
[task 2021-02-26T15:29:38.939Z] 15:29:38 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.-$$Lambda$GeckoSessionTestRule$2$cmP_QJg-X16GIlt8KIQd32egmfU.run(lambda)
[task 2021-02-26T15:29:38.939Z] 15:29:38 INFO - org.mozilla.geckoview.test | at android.app.Instrumentation$SyncRunnable.run(Instrumentation.java:1950)
[task 2021-02-26T15:29:38.939Z] 15:29:38 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:751)
[task 2021-02-26T15:29:38.939Z] 15:29:38 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2021-02-26T15:29:38.939Z] 15:29:38 INFO - org.mozilla.geckoview.test | at android.os.Looper.loop(Looper.java:154)
[task 2021-02-26T15:29:38.939Z] 15:29:38 INFO - org.mozilla.geckoview.test | at android.app.ActivityThread.main(ActivityThread.java:6077)
[task 2021-02-26T15:29:38.939Z] 15:29:38 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invoke(Native Method)
[task 2021-02-26T15:29:38.939Z] 15:29:38 INFO - org.mozilla.geckoview.test | at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:866)
[task 2021-02-26T15:29:38.939Z] 15:29:38 INFO - org.mozilla.geckoview.test | at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:756)
[task 2021-02-26T15:29:39.119Z] 15:29:39 INFO - 02-26 15:29:38.175 D/GeckoViewConsole( 3171): onEvent GeckoView:WebExtension:PortMessageFromApp {"message":{"id":"d0c0146f-f42e-41d8-a0e7-caaa2fe0c8d0","args":{"oldPrefs":{"dom.select_events.textcontrols.enabled":true}},"type":"RestorePrefs"}}
[task 2021-02-26T15:29:39.119Z] 15:29:39 INFO - 02-26 15:29:38.193 D/GeckoViewContent( 3171): handleEvent: DOMWindowClose
[task 2021-02-26T15:29:39.119Z] 15:29:39 INFO - 02-26 15:29:38.195 D/GeckoViewConsole( 3171): onEvent GeckoView:WebExtension:List null
[task 2021-02-26T15:29:39.119Z] 15:29:39 INFO - 02-26 15:29:38.199 I/Gecko ( 3171): nsWindow[0x7b4ae0c37600]::Show 0
[task 2021-02-26T15:29:39.119Z] 15:29:39 INFO - 02-26 15:29:38.200 E/GeckoSessionTestRule( 3171): test_end c5ee677f-bc83-49bd-9e28-2d35f3d0f059 inputConnection_bug1650705#input
[task 2021-02-26T15:29:39.119Z] 15:29:39 WARNING - TEST-UNEXPECTED-FAIL | org.mozilla.geckoview.test.TextInputDelegateTest.inputConnection_bug1650705[#input] | org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 30000ms
[task 2021-02-26T15:29:39.120Z] 15:29:39 INFO - TEST-INFO took 32740ms
[task 2021-02-26T15:29:39.120Z] 15:29:39 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=794
[task 2021-02-26T15:29:39.120Z] 15:29:39 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=
[task 2021-02-26T15:29:39.120Z] 15:29:39 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2021-02-26T15:29:39.120Z] 15:29:39 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: test=inputConnection_setSelection[#input]
[task 2021-02-26T15:29:39.120Z] 15:29:39 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: class=org.mozilla.geckoview.test.TextInputDelegateTest
[task 2021-02-26T15:29:39.120Z] 15:29:39 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=623
[task 2021-02-26T15:29:39.120Z] 15:29:39 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS_CODE: 1
Updated•4 years ago
|
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Assignee | ||
Comment 9•4 years ago
|
||
Assignee | ||
Comment 10•4 years ago
|
||
Bug 1650705's geckoview-junit test counts the number of input event times.
It is unnecessary to wait for selection event and Gecko may not sometimes
fire selection event on input or textarea element. So use
InputConnection.setSelection directly instead of waiting for DOM event.
Comment 11•4 years ago
|
||
Comment 12•4 years ago
|
||
bugherder |
![]() |
||
Comment 13•4 years ago
|
||
bugherder uplift |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment 16•4 years ago
|
||
6c6f5da9-bf33-4082-a19d-7d99e8083d97 Mass rename intermittents due to Bug 1723034.
Comment 17•3 years ago
|
||
Moving some input bugs to the new GeckoView::IME component.
Description
•