Closed Bug 1763733 Opened 4 years ago Closed 3 years ago

Intermittent org.mozilla.geckoview.test.SelectionActionDelegateTest#collapseToStart[#contenteditable] | org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 30000ms

Categories

(GeckoView :: General, defect, P5)

Unspecified
All
defect

Tracking

(Not tracked)

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: intermittent-failure)

Filed by: abutkovits [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=373805766&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Gcfv1gEZQs2RqMK1quMlgQ/runs/0/artifacts/public/logs/live_backing.log


[task 2022-04-07T22:05:05.290Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): Error
[task 2022-04-07T22:05:05.290Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 30000ms
[task 2022-04-07T22:05:05.290Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutRunnable.run(UiThreadUtils.java:49)
[task 2022-04-07T22:05:05.290Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at android.os.Handler.handleCallback(Handler.java:751)
[task 2022-04-07T22:05:05.290Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2022-04-07T22:05:05.291Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at org.mozilla.geckoview.test.util.UiThreadUtils.waitForCondition(UiThreadUtils.java:158)
[task 2022-04-07T22:05:05.291Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForMessage(GeckoSessionTestRule.java:2183)
[task 2022-04-07T22:05:05.291Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.evaluateJS(GeckoSessionTestRule.java:2143)
[task 2022-04-07T22:05:05.291Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at org.mozilla.geckoview.test.BaseSessionTest.evaluateJS(BaseSessionTest.kt:214)
[task 2022-04-07T22:05:05.291Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at org.mozilla.geckoview.test.SelectionActionDelegateTest$SelectedDiv.selectTo(SelectionActionDelegateTest.kt:402)
[task 2022-04-07T22:05:05.291Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at org.mozilla.geckoview.test.SelectionActionDelegateTest$SelectedDiv.select(SelectionActionDelegateTest.kt:407)
[task 2022-04-07T22:05:05.292Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at org.mozilla.geckoview.test.SelectionActionDelegateTest.testThat(SelectionActionDelegateTest.kt:287)
[task 2022-04-07T22:05:05.292Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at org.mozilla.geckoview.test.SelectionActionDelegateTest.access$testThat(SelectionActionDelegateTest.kt:37)
[task 2022-04-07T22:05:05.292Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at org.mozilla.geckoview.test.SelectionActionDelegateTest$collapseToStart$1.invoke(SelectionActionDelegateTest.kt:207)
[task 2022-04-07T22:05:05.292Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at org.mozilla.geckoview.test.SelectionActionDelegateTest$collapseToStart$1.invoke(SelectionActionDelegateTest.kt:206)
[task 2022-04-07T22:05:05.292Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at org.mozilla.geckoview.test.SelectionActionDelegateTest.assumingEditable(SelectionActionDelegateTest.kt:393)
[task 2022-04-07T22:05:05.293Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at org.mozilla.geckoview.test.SelectionActionDelegateTest.collapseToStart(SelectionActionDelegateTest.kt:206)
[task 2022-04-07T22:05:05.293Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at java.lang.reflect.Method.invoke(Native Method)
[task 2022-04-07T22:05:05.293Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
[task 2022-04-07T22:05:05.293Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
[task 2022-04-07T22:05:05.293Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
[task 2022-04-07T22:05:05.293Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
[task 2022-04-07T22:05:05.294Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
[task 2022-04-07T22:05:05.294Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$2.lambda$evaluate$0$org-mozilla-geckoview-test-rule-GeckoSessionTestRule$2(GeckoSessionTestRule.java:1451)
[task 2022-04-07T22:05:05.294Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$2$$ExternalSyntheticLambda0.run(Unknown Source)
[task 2022-04-07T22:05:05.294Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:428)
[task 2022-04-07T22:05:05.294Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at java.util.concurrent.FutureTask.run(FutureTask.java:237)
[task 2022-04-07T22:05:05.294Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at android.app.Instrumentation$SyncRunnable.run(Instrumentation.java:1950)
[task 2022-04-07T22:05:05.295Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at android.os.Handler.handleCallback(Handler.java:751)
[task 2022-04-07T22:05:05.295Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2022-04-07T22:05:05.295Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at android.os.Looper.loop(Looper.java:154)
[task 2022-04-07T22:05:05.295Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at android.app.ActivityThread.main(ActivityThread.java:6077)
[task 2022-04-07T22:05:05.295Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at java.lang.reflect.Method.invoke(Native Method)
[task 2022-04-07T22:05:05.295Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:866)
[task 2022-04-07T22:05:05.295Z] 22:05:05     INFO -  04-07 22:05:04.171 E/GeckoSessionTestRule( 3487): 	at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:756)
[task 2022-04-07T22:05:05.296Z] 22:05:05     INFO -  04-07 22:05:04.174 D/GeckoViewConsole( 3487): onEvent GeckoView:WebExtension:PortMessageFromApp {"message":{"id":"394cf857-58c3-4503-b640-bd6bf1911330","args":{"oldPrefs":{"geckoview.selection_action.show_on_focus":null,"layout.accessiblecaret.script_change_update_mode":1}},"type":"RestorePrefs"}}
[task 2022-04-07T22:05:05.296Z] 22:05:05     INFO -  04-07 22:05:04.190 D/EGL_emulation(22479): eglMakeCurrent: 0x7a982d27be00: ver 3 0 (tinfo 0x7a982d2b4720)
[task 2022-04-07T22:05:05.296Z] 22:05:05     INFO -  04-07 22:05:04.192 D/GeckoViewContent( 3487): handleEvent: DOMWindowClose
[task 2022-04-07T22:05:05.296Z] 22:05:05     INFO -  04-07 22:05:04.192 D/GeckoViewConsole( 3487): onEvent GeckoView:WebExtension:List null
[task 2022-04-07T22:05:05.296Z] 22:05:05     INFO -  04-07 22:05:04.196 I/Gecko   ( 3487): nsWindow[0x7a97bf99ea00]::Show 0
[task 2022-04-07T22:05:05.296Z] 22:05:05     INFO -  04-07 22:05:04.196 E/GeckoSessionTestRule( 3487): test_end c5ee677f-bc83-49bd-9e28-2d35f3d0f059 collapseToStart[#contenteditable](org.mozilla.geckoview.test.SelectionActionDelegateTest)
[task 2022-04-07T22:05:05.297Z] 22:05:05  WARNING -  TEST-UNEXPECTED-FAIL | org.mozilla.geckoview.test.SelectionActionDelegateTest#collapseToStart[#contenteditable] | org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 30000ms
[task 2022-04-07T22:05:05.297Z] 22:05:05     INFO -  TEST-INFO took 31117ms
[task 2022-04-07T22:05:05.297Z] 22:05:05     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=884
[task 2022-04-07T22:05:05.297Z] 22:05:05     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=
[task 2022-04-07T22:05:05.297Z] 22:05:05     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2022-04-07T22:05:05.297Z] 22:05:05     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: test=selectAll[#contenteditable]
[task 2022-04-07T22:05:05.297Z] 22:05:05     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: class=org.mozilla.geckoview.test.SelectionActionDelegateTest
[task 2022-04-07T22:05:05.297Z] 22:05:05     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=573
[task 2022-04-07T22:05:05.297Z] 22:05:05     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS_CODE: 1
Status: NEW → RESOLVED
Closed: 4 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 4 years ago3 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.