Closed Bug 1596192 Opened 5 years ago Closed 2 years ago

Intermittent org.mozilla.geckoview.test.ContentDelegateTest#stopHungProcessNull | java.lang.AssertionError: The script did not complete.

Categories

(GeckoView :: General, defect, P5)

Unspecified
All
defect

Tracking

(firefox72 affected)

RESOLVED WORKSFORME
Tracking Status
firefox72 --- affected

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Blocks 1 open bug)

Details

(Keywords: intermittent-failure)

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


[task 2019-11-13T16:29:09.331Z] 16:29:09 INFO - TEST-START | org.mozilla.geckoview.test.ContentDelegateTest.stopHungProcessNull
[task 2019-11-13T16:29:14.546Z] 16:29:14 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=548
[task 2019-11-13T16:29:14.558Z] 16:29:14 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=
[task 2019-11-13T16:29:14.558Z] 16:29:14 INFO - org.mozilla.geckoview.test | Error in stopHungProcessNull(org.mozilla.geckoview.test.ContentDelegateTest):
[task 2019-11-13T16:29:14.558Z] 16:29:14 INFO - org.mozilla.geckoview.test | java.lang.AssertionError: The script did not complete.
[task 2019-11-13T16:29:14.558Z] 16:29:14 INFO - org.mozilla.geckoview.test | Expected: "Started"
[task 2019-11-13T16:29:14.558Z] 16:29:14 INFO - org.mozilla.geckoview.test | but: was "Finished"
[task 2019-11-13T16:29:14.558Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.hamcrest.MatcherAssert.assertThat(MatcherAssert.java:20)
[task 2019-11-13T16:29:14.558Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.junit.Assert.assertThat(Assert.java:956)
[task 2019-11-13T16:29:14.558Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.junit.rules.ErrorCollector$1.call(ErrorCollector.java:65)
[task 2019-11-13T16:29:14.558Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.junit.rules.ErrorCollector.checkSucceeds(ErrorCollector.java:78)
[task 2019-11-13T16:29:14.558Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.junit.rules.ErrorCollector.checkThat(ErrorCollector.java:63)
[task 2019-11-13T16:29:14.558Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.checkThat(GeckoSessionTestRule.java:797)
[task 2019-11-13T16:29:14.558Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.BaseSessionTest.assertThat(BaseSessionTest.kt:75)
[task 2019-11-13T16:29:14.558Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.ContentDelegateTest$stopHungProcessNull$1.onPageStop(ContentDelegateTest.kt:384)
[task 2019-11-13T16:29:14.558Z] 16:29:14 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invoke(Native Method)
[task 2019-11-13T16:29:14.558Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$1.invoke(GeckoSessionTestRule.java:1055)
[task 2019-11-13T16:29:14.558Z] 16:29:14 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Proxy.invoke(Proxy.java:813)
[task 2019-11-13T16:29:14.558Z] 16:29:14 INFO - org.mozilla.geckoview.test | at $Proxy22.onPageStop(Unknown Source)
[task 2019-11-13T16:29:14.558Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.GeckoSession$5.handleMessage(GeckoSession.java:722)
[task 2019-11-13T16:29:14.558Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.GeckoSession$5.handleMessage(GeckoSession.java:711)
[task 2019-11-13T16:29:14.558Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.GeckoSessionHandler.handleMessage(GeckoSessionHandler.java:90)
[task 2019-11-13T16:29:14.558Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.gecko.EventDispatcher$3.run(EventDispatcher.java:373)
[task 2019-11-13T16:29:14.558Z] 16:29:14 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:751)
[task 2019-11-13T16:29:14.558Z] 16:29:14 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2019-11-13T16:29:14.558Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils.waitForCondition(UiThreadUtils.java:161)
[task 2019-11-13T16:29:14.558Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitUntilCalled(GeckoSessionTestRule.java:1533)
[task 2019-11-13T16:29:14.558Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForPageStops(GeckoSessionTestRule.java:1332)
[task 2019-11-13T16:29:14.558Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForPageStop(GeckoSessionTestRule.java:1307)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.ContentDelegateTest.stopHungProcessNull(ContentDelegateTest.kt:390)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invoke(Native Method)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$2.lambda$evaluate$0$GeckoSessionTestRule$2(GeckoSessionTestRule.java:1266)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.-$$Lambda$GeckoSessionTestRule$2$mzZNnl5Bu5F2_4xGxj0DHU4J33I.run(lambda)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at android.app.Instrumentation$SyncRunnable.run(Instrumentation.java:1950)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:751)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at android.os.Looper.loop(Looper.java:154)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at android.app.ActivityThread.main(ActivityThread.java:6077)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invoke(Native Method)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:866)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:756)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test |
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: test=stopHungProcessNull
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: class=org.mozilla.geckoview.test.ContentDelegateTest
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stack=java.lang.AssertionError: The script did not complete.
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | Expected: "Started"
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | but: was "Finished"
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.hamcrest.MatcherAssert.assertThat(MatcherAssert.java:20)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.junit.Assert.assertThat(Assert.java:956)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.junit.rules.ErrorCollector$1.call(ErrorCollector.java:65)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.junit.rules.ErrorCollector.checkSucceeds(ErrorCollector.java:78)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.junit.rules.ErrorCollector.checkThat(ErrorCollector.java:63)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.checkThat(GeckoSessionTestRule.java:797)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.BaseSessionTest.assertThat(BaseSessionTest.kt:75)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.ContentDelegateTest$stopHungProcessNull$1.onPageStop(ContentDelegateTest.kt:384)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invoke(Native Method)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$1.invoke(GeckoSessionTestRule.java:1055)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Proxy.invoke(Proxy.java:813)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at $Proxy22.onPageStop(Unknown Source)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.GeckoSession$5.handleMessage(GeckoSession.java:722)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.GeckoSession$5.handleMessage(GeckoSession.java:711)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.GeckoSessionHandler.handleMessage(GeckoSessionHandler.java:90)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.gecko.EventDispatcher$3.run(EventDispatcher.java:373)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:751)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils.waitForCondition(UiThreadUtils.java:161)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitUntilCalled(GeckoSessionTestRule.java:1533)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForPageStops(GeckoSessionTestRule.java:1332)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitForPageStop(GeckoSessionTestRule.java:1307)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.ContentDelegateTest.stopHungProcessNull(ContentDelegateTest.kt:390)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invoke(Native Method)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$2.lambda$evaluate$0$GeckoSessionTestRule$2(GeckoSessionTestRule.java:1266)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.-$$Lambda$GeckoSessionTestRule$2$mzZNnl5Bu5F2_4xGxj0DHU4J33I.run(lambda)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at android.app.Instrumentation$SyncRunnable.run(Instrumentation.java:1950)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:751)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at android.os.Looper.loop(Looper.java:154)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at android.app.ActivityThread.main(ActivityThread.java:6077)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invoke(Native Method)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:866)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:756)
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test |
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=10
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS_CODE: -2
[task 2019-11-13T16:29:14.559Z] 16:29:14 WARNING - TEST-UNEXPECTED-FAIL | org.mozilla.geckoview.test.ContentDelegateTest.stopHungProcessNull | status -2
[task 2019-11-13T16:29:14.559Z] 16:29:14 INFO - TEST-INFO took 5222ms

Summary: Intermittent org.mozilla.geckoview.test.ContentDelegateTest.stopHungProcessNull | status -2 → Intermittent org.mozilla.geckoview.test.ContentDelegateTest.stopHungProcessNull | java.lang.AssertionError: The script did not complete.

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

Summary: Intermittent org.mozilla.geckoview.test.ContentDelegateTest.stopHungProcessNull | java.lang.AssertionError: The script did not complete. → Intermittent org.mozilla.geckoview.test.ContentDelegateTest#stopHungProcessNull | java.lang.AssertionError: The script did not complete.
Severity: normal → S3
Status: NEW → RESOLVED
Closed: 2 years ago
Resolution: --- → WORKSFORME
You need to log in before you can comment on or make changes to this bug.