Closed Bug 1761856 Opened 4 years ago Closed 4 years ago

Intermittent org.mozilla.geckoview.test.WebExtensionTest#runInPrivateBrowsing | org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 30000ms

Categories

(GeckoView :: Extensions, defect, P5)

Product:
GeckoView
Component:
Extensions
Platform:
Unspecified
All
Type:
defect

Tracking

(Not tracked)

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

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

[task 2022-03-28T20:55:11.682Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): Error
[task 2022-03-28T20:55:11.682Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 30000ms
[task 2022-03-28T20:55:11.682Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): 	at org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutRunnable.run(UiThreadUtils.java:49)
[task 2022-03-28T20:55:11.682Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): 	at android.os.Handler.handleCallback(Handler.java:751)
[task 2022-03-28T20:55:11.682Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): 	at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2022-03-28T20:55:11.682Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): 	at org.mozilla.geckoview.test.util.UiThreadUtils.waitForCondition(UiThreadUtils.java:158)
[task 2022-03-28T20:55:11.682Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): 	at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitUntilCalled(GeckoSessionTestRule.java:1741)
[task 2022-03-28T20:55:11.683Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): 	at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForPageStops(GeckoSessionTestRule.java:1522)
[task 2022-03-28T20:55:11.683Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): 	at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForPageStop(GeckoSessionTestRule.java:1497)
[task 2022-03-28T20:55:11.683Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): 	at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForPageStop(GeckoSessionTestRule.java:1487)
[task 2022-03-28T20:55:11.683Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): 	at org.mozilla.geckoview.test.WebExtensionTest.runInPrivateBrowsing(WebExtensionTest.kt:279)
[task 2022-03-28T20:55:11.683Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): 	at java.lang.reflect.Method.invoke(Native Method)
[task 2022-03-28T20:55:11.683Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): 	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
[task 2022-03-28T20:55:11.684Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): 	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
[task 2022-03-28T20:55:11.684Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): 	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
[task 2022-03-28T20:55:11.684Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): 	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
[task 2022-03-28T20:55:11.684Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): 	at androidx.test.internal.runner.junit4.statement.RunBefores.evaluate(RunBefores.java:80)
[task 2022-03-28T20:55:11.684Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): 	at org.junit.rules.Verifier$1.evaluate(Verifier.java:35)
[task 2022-03-28T20:55:11.684Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): 	at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$2.lambda$evaluate$0$org-mozilla-geckoview-test-rule-GeckoSessionTestRule$2(GeckoSessionTestRule.java:1451)
[task 2022-03-28T20:55:11.685Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): 	at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$2$$ExternalSyntheticLambda0.run(Unknown Source)
[task 2022-03-28T20:55:11.685Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): 	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:428)
[task 2022-03-28T20:55:11.685Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): 	at java.util.concurrent.FutureTask.run(FutureTask.java:237)
[task 2022-03-28T20:55:11.685Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): 	at android.app.Instrumentation$SyncRunnable.run(Instrumentation.java:1950)
[task 2022-03-28T20:55:11.685Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): 	at android.os.Handler.handleCallback(Handler.java:751)
[task 2022-03-28T20:55:11.685Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): 	at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2022-03-28T20:55:11.685Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): 	at android.os.Looper.loop(Looper.java:154)
[task 2022-03-28T20:55:11.685Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): 	at android.app.ActivityThread.main(ActivityThread.java:6077)
[task 2022-03-28T20:55:11.686Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): 	at java.lang.reflect.Method.invoke(Native Method)
[task 2022-03-28T20:55:11.686Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): 	at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:866)
[task 2022-03-28T20:55:11.686Z] 20:55:11     INFO -  03-28 20:55:11.085 E/GeckoSessionTestRule( 3490): 	at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:756)
[task 2022-03-28T20:55:11.686Z] 20:55:11     INFO -  03-28 20:55:11.088 D/GeckoViewConsole( 3490): onEvent GeckoView:WebExtension:PortMessageFromApp {"message":{"id":"24903d21-e322-46d2-9da9-1a319823d233","args":{"oldPrefs":{"extensions.isembedded":null}},"type":"RestorePrefs"}}
[task 2022-03-28T20:55:11.686Z] 20:55:11     INFO -  03-28 20:55:11.099 D/GeckoViewContent( 3490): handleEvent: DOMWindowClose
[task 2022-03-28T20:55:11.686Z] 20:55:11     INFO -  03-28 20:55:11.100 D/GeckoViewConsole( 3490): onEvent GeckoView:WebExtension:List null
[task 2022-03-28T20:55:11.686Z] 20:55:11     INFO -  03-28 20:55:11.103 I/Gecko   ( 3490): nsWindow[0x76781ce3a100]::Show 0
[task 2022-03-28T20:55:11.687Z] 20:55:11     INFO -  03-28 20:55:11.103 E/GeckoSessionTestRule( 3490): test_end c5ee677f-bc83-49bd-9e28-2d35f3d0f059 runInPrivateBrowsing(org.mozilla.geckoview.test.WebExtensionTest)
[task 2022-03-28T20:55:11.687Z] 20:55:11  WARNING -  TEST-UNEXPECTED-FAIL | org.mozilla.geckoview.test.WebExtensionTest#runInPrivateBrowsing | org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 30000ms
[task 2022-03-28T20:55:11.687Z] 20:55:11     INFO -  TEST-INFO took 30152ms
[task 2022-03-28T20:55:11.687Z] 20:55:11     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=883
[task 2022-03-28T20:55:11.687Z] 20:55:11     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=
[task 2022-03-28T20:55:11.687Z] 20:55:11     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2022-03-28T20:55:11.687Z] 20:55:11     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: test=badFileType
[task 2022-03-28T20:55:11.688Z] 20:55:11     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: class=org.mozilla.geckoview.test.WebExtensionTest
[task 2022-03-28T20:55:11.688Z] 20:55:11     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=851
[task 2022-03-28T20:55:11.688Z] 20:55:11     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS_CODE: 1
[task 2022-03-28T20:55:11.688Z] 20:55:11     INFO -  TEST-START | org.mozilla.geckoview.test.WebExtensionTest#badFileType

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.

Status: NEW → RESOLVED
Closed: 4 years ago
Resolution: --- → INCOMPLETE

Moving some WebExtension bugs to the GeckoView::Extensions component.

Component: General → Extensions
You need to log in before you can comment on or make changes to this bug.