Closed Bug 1520090 Opened 6 years ago Closed 2 years ago

Intermittent org.mozilla.geckoview.test.PromptDelegateTest#popupTestBlock | java.lang.AssertionError: onLoadRequest should be called specified number of times

Categories

(GeckoView :: General, defect, P3)

Unspecified
All
defect

Tracking

(firefox65 wontfix, firefox66 wontfix, firefox67 affected, firefox69 affected)

RESOLVED WORKSFORME
Tracking Status
firefox65 --- wontfix
firefox66 --- wontfix
firefox67 --- affected
firefox69 --- affected

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Blocks 1 open bug)

Details

(Keywords: intermittent-failure)

Filed by: nbeleuzu [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=221877809&repo=autoland

https://queue.taskcluster.net/v1/task/O4ig-I87R0av3GRfzI52Rw/runs/0/artifacts/public/logs/live_backing.log

[task 2019-01-15T01:17:58.567Z] 01:17:58 INFO - TEST-START | org.mozilla.geckoview.test.PromptDelegateTest.popupTestBlock
[task 2019-01-15T01:20:00.644Z] 01:20:00 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2019-01-15T01:20:00.645Z] 01:20:00 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=125
[task 2019-01-15T01:20:00.645Z] 01:20:00 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: class=org.mozilla.geckoview.test.PromptDelegateTest
[task 2019-01-15T01:20:00.646Z] 01:20:00 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=
[task 2019-01-15T01:20:00.646Z] 01:20:00 INFO - org.mozilla.geckoview.test | Error in popupTestBlock(org.mozilla.geckoview.test.PromptDelegateTest):
[task 2019-01-15T01:20:00.647Z] 01:20:00 INFO - org.mozilla.geckoview.test | org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 120000ms
[task 2019-01-15T01:20:00.647Z] 01:20:00 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutRunnable.run(UiThreadUtils.java:56)
[task 2019-01-15T01:20:00.648Z] 01:20:00 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:730)
[task 2019-01-15T01:20:00.648Z] 01:20:00 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:92)
[task 2019-01-15T01:20:00.649Z] 01:20:00 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils.loopUntilIdle(UiThreadUtils.java:154)
[task 2019-01-15T01:20:00.649Z] 01:20:00 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForInitialLoad(GeckoSessionTestRule.java:1299)
[task 2019-01-15T01:20:00.650Z] 01:20:00 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForOpenSession(GeckoSessionTestRule.java:1247)
[task 2019-01-15T01:20:00.650Z] 01:20:00 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.openSession(GeckoSessionTestRule.java:1243)
[task 2019-01-15T01:20:00.651Z] 01:20:00 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.prepareStatement(GeckoSessionTestRule.java:1225)
[task 2019-01-15T01:20:00.652Z] 01:20:00 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$3$1.run(GeckoSessionTestRule.java:1406)
[task 2019-01-15T01:20:00.652Z] 01:20:00 INFO - org.mozilla.geckoview.test | at android.app.Instrumentation$SyncRunnable.run(Instrumentation.java:1719)
[task 2019-01-15T01:20:00.652Z] 01:20:00 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:730)
[task 2019-01-15T01:20:00.653Z] 01:20:00 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:92)
[task 2019-01-15T01:20:00.653Z] 01:20:00 INFO - org.mozilla.geckoview.test | at android.os.Looper.loop(Looper.java:137)
[task 2019-01-15T01:20:00.653Z] 01:20:00 INFO - org.mozilla.geckoview.test | at android.app.ActivityThread.main(ActivityThread.java:5103)
[task 2019-01-15T01:20:00.654Z] 01:20:00 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invokeNative(Native Method)
[task 2019-01-15T01:20:00.654Z] 01:20:00 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invoke(Method.java:525)
[task 2019-01-15T01:20:00.654Z] 01:20:00 INFO - org.mozilla.geckoview.test | at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:737)
[task 2019-01-15T01:20:00.655Z] 01:20:00 INFO - org.mozilla.geckoview.test | at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:553)
[task 2019-01-15T01:20:00.655Z] 01:20:00 INFO - org.mozilla.geckoview.test | at dalvik.system.NativeStart.main(Native Method)
[task 2019-01-15T01:20:00.749Z] 01:20:00 INFO - org.mozilla.geckoview.test |
[task 2019-01-15T01:20:00.749Z] 01:20:00 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=195
[task 2019-01-15T01:20:00.750Z] 01:20:00 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stack=org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 120000ms
[task 2019-01-15T01:20:00.751Z] 01:20:00 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutRunnable.run(UiThreadUtils.java:56)
[task 2019-01-15T01:20:00.751Z] 01:20:00 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:730)
[task 2019-01-15T01:20:00.752Z] 01:20:00 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:92)
[task 2019-01-15T01:20:00.752Z] 01:20:00 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils.loopUntilIdle(UiThreadUtils.java:154)
[task 2019-01-15T01:20:00.753Z] 01:20:00 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForInitialLoad(GeckoSessionTestRule.java:1299)
[task 2019-01-15T01:20:00.753Z] 01:20:00 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForOpenSession(GeckoSessionTestRule.java:1247)
[task 2019-01-15T01:20:00.754Z] 01:20:00 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.openSession(GeckoSessionTestRule.java:1243)
[task 2019-01-15T01:20:00.754Z] 01:20:00 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.prepareStatement(GeckoSessionTestRule.java:1225)
[task 2019-01-15T01:20:00.755Z] 01:20:00 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$3$1.run(GeckoSessionTestRule.java:1406)
[task 2019-01-15T01:20:00.756Z] 01:20:00 INFO - org.mozilla.geckoview.test | at android.app.Instrumentation$SyncRunnable.run(Instrumentation.java:1719)
[task 2019-01-15T01:20:00.756Z] 01:20:00 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:730)
[task 2019-01-15T01:20:00.757Z] 01:20:00 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:92)
[task 2019-01-15T01:20:00.757Z] 01:20:00 INFO - org.mozilla.geckoview.test | at android.os.Looper.loop(Looper.java:137)
[task 2019-01-15T01:20:00.758Z] 01:20:00 INFO - org.mozilla.geckoview.test | at android.app.ActivityThread.main(ActivityThread.java:5103)
[task 2019-01-15T01:20:00.758Z] 01:20:00 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invokeNative(Native Method)
[task 2019-01-15T01:20:00.759Z] 01:20:00 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invoke(Method.java:525)
[task 2019-01-15T01:20:00.760Z] 01:20:00 INFO - org.mozilla.geckoview.test | at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:737)

Resolving as WFM because there have no reported failures in the last two months.

Status: NEW → RESOLVED
Closed: 6 years ago
Resolution: --- → WORKSFORME

Recent failure log on beta: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=249002931&repo=mozilla-beta&lineNumber=3048

task 2019-05-29T17:44:11.573Z] 17:44:11     INFO -  org.mozilla.geckoview.test | 	at dalvik.system.NativeStart.main(Native Method)
[task 2019-05-29T17:44:11.573Z] 17:44:11     INFO -  org.mozilla.geckoview.test |
[task 2019-05-29T17:44:11.574Z] 17:44:11     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: test=popupTestBlock
[task 2019-05-29T17:44:11.574Z] 17:44:11     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS_CODE: -2
[task 2019-05-29T17:44:11.574Z] 17:44:11  WARNING -  TEST-UNEXPECTED-FAIL | org.mozilla.geckoview.test.PromptDelegateTest.popupTestBlock | status -2
[task 2019-05-29T17:44:11.574Z] 17:44:11     INFO -  TEST-INFO took 121677ms
[task 2019-05-29T17:44:11.574Z] 17:44:11     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2019-05-29T17:44:11.574Z] 17:44:11     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=99
[task 2019-05-29T17:44:11.574Z] 17:44:11     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: class=org.mozilla.geckoview.test.RuntimeSettingsTest
[task 2019-05-29T17:44:11.575Z] 17:44:11     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=
[task 2019-05-29T17:44:11.575Z] 17:44:11     INFO -  org.mozilla.geckoview.test | org.mozilla.geckoview.test.RuntimeSettingsTest:
[task 2019-05-29T17:44:11.575Z] 17:44:11     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=158
[task 2019-05-29T17:44:11.575Z] 17:44:11     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: test=fontInflation
[task 2019-05-29T17:44:11.575Z] 17:44:11     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS_CODE: 1
[task 2019-05-29T17:44:11.575Z] 17:44:11     INFO -  TEST-START | org.mozilla.geckoview.test.RuntimeSettingsTest.fontInflation
[task 2019-05-29T17:44:15.081Z] 17:44:15     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2019-05-29T17:44:15.081Z] 17:44:15     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=99
[task 2019-05-29T17:44:15.082Z] 17:44:15     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: class=org.mozilla.geckoview.test.RuntimeSettingsTest
[task 2019-05-29T17:44:15.082Z] 17:44:15     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=.
[task 2019-05-29T17:44:15.082Z] 17:44:15     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=158
[task 2019-05-29T17:44:15.082Z] 17:44:15     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: test=fontInflation
[task 2019-05-29T17:44:15.082Z] 17:44:15     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS_CODE: 0
[task 2019-05-29T17:44:15.083Z] 17:44:15     INFO -  TEST-PASS | org.mozilla.geckoview.test.RuntimeSettingsTest.fontInflation | took 3509ms
[task 2019-05-29T17:44:15.083Z] 17:44:15     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2019-05-29T17:44:15.083Z] 17:44:15     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=100
[task 2019-05-29T17:44:15.084Z] 17:44:15     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: class=org.mozilla.geckoview.test.ScreenshotTest
[task 2019-05-29T17:44:15.084Z] 17:44:15     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=
[task 2019-05-29T17:44:15.084Z] 17:44:15     INFO -  org.mozilla.geckoview.test | org.mozilla.geckoview.test.ScreenshotTest:
[task 2019-05-29T17:44:15.084Z] 17:44:15     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=158
[task 2019-05-29T17:44:15.084Z] 17:44:15     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: test=capturePixelsCanBeCalledMultipleTimes
[task 2019-05-29T17:44:15.084Z] 17:44:15     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS_CODE: 1
[task 2019-05-29T17:44:15.084Z] 17:44:15     INFO -  TEST-START | org.mozilla.geckoview.test.ScreenshotTest.capturePixelsCanBeCalledMultipleTimes
[task 2019-05-29T17:44:20.797Z] 17:44:20     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2019-05-29T17:44:20.797Z] 17:44:20     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=100
Flags: needinfo?(cpeterson)

Agi will continue investigating these junit test failures when he returns from PTO.

Flags: needinfo?(cpeterson)
Status: RESOLVED → REOPENED
Resolution: WORKSFORME → ---
Flags: needinfo?(droeh)

:Dylan are there any updates on this patch?
Thank you.

Flags: needinfo?(droeh)

(In reply to Natalia Csoregi [:nataliaCs] from comment #22)

:Dylan are there any updates on this patch?
Thank you.

As far as I can tell this is only failing on android-em-4-3-armv7-api16, which will not be running GV JUnit tests much longer. I can temporarily disable the test if the failures are causing too much noise, but I'd prefer to just let it stay.

Flags: needinfo?(droeh)

That's alright, thank you.
Removing the disable-recommended tag.

Whiteboard: [stockwell disable-recommended]
Whiteboard: [stockwell disable-recommended]
Whiteboard: [stockwell disable-recommended]
Summary: Intermittent org.mozilla.geckoview.test.PromptDelegateTest.popupTestBlock | status -2 → Intermittent org.mozilla.geckoview.test.PromptDelegateTest.popupTestBlock | java.lang.AssertionError: onLoadRequest should be called specified number of times
See Also: → 1610030

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

Summary: Intermittent org.mozilla.geckoview.test.PromptDelegateTest.popupTestBlock | java.lang.AssertionError: onLoadRequest should be called specified number of times → Intermittent org.mozilla.geckoview.test.PromptDelegateTest#popupTestBlock | java.lang.AssertionError: onLoadRequest should be called specified number of times
Severity: normal → S3
Status: REOPENED → RESOLVED
Closed: 6 years ago2 years ago
Resolution: --- → WORKSFORME
You need to log in before you can comment on or make changes to this bug.