Open Bug 1677151 Opened 5 years ago Updated 5 days ago

Intermittent org.mozilla.geckoview.test.WebExtensionTest#backgroundPortDisconnect | single tracking bug

Categories

(GeckoView :: Extensions, defect, P5)

Unspecified
All
defect

Tracking

(Not tracked)

REOPENED

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, intermittent-testcase)

Attachments

(1 obsolete file)

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


[task 2020-11-13T13:30:23.146Z] 13:30:23     INFO -  TEST-START | org.mozilla.geckoview.test.WebExtensionTest.backgroundPortDisconnect
[task 2020-11-13T13:30:23.278Z] 13:30:23     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=766
[task 2020-11-13T13:30:23.278Z] 13:30:23     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=
[task 2020-11-13T13:30:23.278Z] 13:30:23     INFO -  org.mozilla.geckoview.test | Error in backgroundPortDisconnect(org.mozilla.geckoview.test.WebExtensionTest):
[task 2020-11-13T13:30:23.279Z] 13:30:23     INFO -  org.mozilla.geckoview.test | java.lang.IllegalStateException: result is already complete
[task 2020-11-13T13:30:23.279Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.GeckoResult.complete(GeckoResult.java:796)
[task 2020-11-13T13:30:23.279Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.test.WebExtensionTest$testPortMessage$portDelegate$1.onPortMessage(WebExtensionTest.kt:954)
[task 2020-11-13T13:30:23.279Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.WebExtension$Port.portMessage(WebExtension.java:312)
[task 2020-11-13T13:30:23.280Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.WebExtension$Port.access$100(WebExtension.java:256)
[task 2020-11-13T13:30:23.280Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.WebExtension$Port$1.handleMessage(WebExtension.java:293)
[task 2020-11-13T13:30:23.280Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.gecko.EventDispatcher$2.run(EventDispatcher.java:301)
[task 2020-11-13T13:30:23.280Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at android.os.Handler.handleCallback(Handler.java:751)
[task 2020-11-13T13:30:23.280Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2020-11-13T13:30:23.280Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.test.util.UiThreadUtils.waitForCondition(UiThreadUtils.java:155)
[task 2020-11-13T13:30:23.280Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.test.util.UiThreadUtils.waitForResult(UiThreadUtils.java:80)
[task 2020-11-13T13:30:23.280Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForResult(GeckoSessionTestRule.java:2312)
[task 2020-11-13T13:30:23.281Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.test.WebExtensionTest.testPortDisconnect(WebExtensionTest.kt:1058)
[task 2020-11-13T13:30:23.281Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.test.WebExtensionTest.backgroundPortDisconnect(WebExtensionTest.kt:1071)
[task 2020-11-13T13:30:23.281Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at java.lang.reflect.Method.invoke(Native Method)
[task 2020-11-13T13:30:23.281Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
[task 2020-11-13T13:30:23.281Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
[task 2020-11-13T13:30:23.281Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
[task 2020-11-13T13:30:23.281Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
[task 2020-11-13T13:30:23.281Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at androidx.test.internal.runner.junit4.statement.RunBefores.evaluate(RunBefores.java:80)
[task 2020-11-13T13:30:23.282Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$2.lambda$evaluate$0$GeckoSessionTestRule$2(GeckoSessionTestRule.java:1313)
[task 2020-11-13T13:30:23.282Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.test.rule.-$$Lambda$GeckoSessionTestRule$2$sIbRNaZJgAu-QrUVWSGD8JbPSWM.run(lambda)
[task 2020-11-13T13:30:23.282Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at android.app.Instrumentation$SyncRunnable.run(Instrumentation.java:1950)
[task 2020-11-13T13:30:23.282Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at android.os.Handler.handleCallback(Handler.java:751)
[task 2020-11-13T13:30:23.282Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2020-11-13T13:30:23.282Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at android.os.Looper.loop(Looper.java:154)
[task 2020-11-13T13:30:23.282Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at android.app.ActivityThread.main(ActivityThread.java:6077)
[task 2020-11-13T13:30:23.283Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at java.lang.reflect.Method.invoke(Native Method)
[task 2020-11-13T13:30:23.283Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:866)
[task 2020-11-13T13:30:23.283Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:756)
[task 2020-11-13T13:30:23.283Z] 13:30:23     INFO -  org.mozilla.geckoview.test |
[task 2020-11-13T13:30:23.283Z] 13:30:23     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2020-11-13T13:30:23.283Z] 13:30:23     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: test=backgroundPortDisconnect
[task 2020-11-13T13:30:23.284Z] 13:30:23     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: class=org.mozilla.geckoview.test.WebExtensionTest
[task 2020-11-13T13:30:23.284Z] 13:30:23     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stack=java.lang.IllegalStateException: result is already complete
[task 2020-11-13T13:30:23.284Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.GeckoResult.complete(GeckoResult.java:796)
[task 2020-11-13T13:30:23.284Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.test.WebExtensionTest$testPortMessage$portDelegate$1.onPortMessage(WebExtensionTest.kt:954)
[task 2020-11-13T13:30:23.284Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.WebExtension$Port.portMessage(WebExtension.java:312)
[task 2020-11-13T13:30:23.284Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.WebExtension$Port.access$100(WebExtension.java:256)
[task 2020-11-13T13:30:23.284Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.WebExtension$Port$1.handleMessage(WebExtension.java:293)
[task 2020-11-13T13:30:23.284Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.gecko.EventDispatcher$2.run(EventDispatcher.java:301)
[task 2020-11-13T13:30:23.285Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at android.os.Handler.handleCallback(Handler.java:751)
[task 2020-11-13T13:30:23.285Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2020-11-13T13:30:23.285Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.test.util.UiThreadUtils.waitForCondition(UiThreadUtils.java:155)
[task 2020-11-13T13:30:23.285Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.test.util.UiThreadUtils.waitForResult(UiThreadUtils.java:80)
[task 2020-11-13T13:30:23.285Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForResult(GeckoSessionTestRule.java:2312)
[task 2020-11-13T13:30:23.285Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.test.WebExtensionTest.testPortDisconnect(WebExtensionTest.kt:1058)
[task 2020-11-13T13:30:23.286Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.test.WebExtensionTest.backgroundPortDisconnect(WebExtensionTest.kt:1071)
[task 2020-11-13T13:30:23.286Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at java.lang.reflect.Method.invoke(Native Method)
[task 2020-11-13T13:30:23.286Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
[task 2020-11-13T13:30:23.286Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
[task 2020-11-13T13:30:23.286Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
[task 2020-11-13T13:30:23.286Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
[task 2020-11-13T13:30:23.286Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at androidx.test.internal.runner.junit4.statement.RunBefores.evaluate(RunBefores.java:80)
[task 2020-11-13T13:30:23.287Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$2.lambda$evaluate$0$GeckoSessionTestRule$2(GeckoSessionTestRule.java:1313)
[task 2020-11-13T13:30:23.287Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at org.mozilla.geckoview.test.rule.-$$Lambda$GeckoSessionTestRule$2$sIbRNaZJgAu-QrUVWSGD8JbPSWM.run(lambda)
[task 2020-11-13T13:30:23.287Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at android.app.Instrumentation$SyncRunnable.run(Instrumentation.java:1950)
[task 2020-11-13T13:30:23.287Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at android.os.Handler.handleCallback(Handler.java:751)
[task 2020-11-13T13:30:23.287Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2020-11-13T13:30:23.287Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at android.os.Looper.loop(Looper.java:154)
task 2020-11-13T13:30:23.287Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at android.app.ActivityThread.main(ActivityThread.java:6077)
[task 2020-11-13T13:30:23.287Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at java.lang.reflect.Method.invoke(Native Method)
[task 2020-11-13T13:30:23.287Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:866)
[task 2020-11-13T13:30:23.287Z] 13:30:23     INFO -  org.mozilla.geckoview.test | 	at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:756)
[task 2020-11-13T13:30:23.287Z] 13:30:23     INFO -  org.mozilla.geckoview.test |
[task 2020-11-13T13:30:23.287Z] 13:30:23     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=738
[task 2020-11-13T13:30:23.287Z] 13:30:23     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS_CODE: -2
[task 2020-11-13T13:30:23.288Z] 13:30:23  WARNING -  TEST-UNEXPECTED-FAIL | org.mozilla.geckoview.test.WebExtensionTest.backgroundPortDisconnect | java.lang.IllegalStateException: result is already complete
[task 2020-11-13T13:30:23.288Z] 13:30:23     INFO -  TEST-INFO took 139ms
[task 2020-11-13T13:30:23.288Z] 13:30:23     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=766
[task 2020-11-13T13:30:23.288Z] 13:30:23     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=
[task 2020-11-13T13:30:23.288Z] 13:30:23     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2020-11-13T13:30:23.288Z] 13:30:23     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: test=runInPrivateBrowsing
[task 2020-11-13T13:30:23.288Z] 13:30:23     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: class=org.mozilla.geckoview.test.WebExtensionTest
[task 2020-11-13T13:30:23.288Z] 13:30:23     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=739
[task 2020-11-13T13:30:23.288Z] 13:30:23     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS_CODE: 1```

6c6f5da9-bf33-4082-a19d-7d99e8083d97 Mass rename intermittents due to Bug 1723034.

Summary: Intermittent org.mozilla.geckoview.test.WebExtensionTest.backgroundPortDisconnect | java.lang.IllegalStateException: result is already complete → Intermittent org.mozilla.geckoview.test.WebExtensionTest#backgroundPortDisconnect | java.lang.IllegalStateException: result is already complete

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

Component: General → Extensions
Status: NEW → RESOLVED
Closed: 2 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 2 years ago2 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Summary: Intermittent org.mozilla.geckoview.test.WebExtensionTest#backgroundPortDisconnect | java.lang.IllegalStateException: result is already complete → Intermittent org.mozilla.geckoview.test.WebExtensionTest#backgroundPortDisconnect | single tracking bug
Status: REOPENED → RESOLVED
Closed: 2 years ago2 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 2 years ago2 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 2 years ago2 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 2 years ago1 year ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Attachment #9381591 - Attachment is obsolete: true
Status: REOPENED → RESOLVED
Closed: 1 year ago1 year ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 1 year ago1 year ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 1 year ago11 months ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 11 months ago2 months ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Creator:
Created:
Updated:
Size: