1565422 - Intermittent org.mozilla.geckoview.test.ContentDelegateTest#crashContentMultipleSessions | status -2

Status: RESOLVED FIXED

(GeckoView :: General, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: rgurzau [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=256038442&repo=autoland
Full log: https://queue.taskcluster.net/v1/task/DVdR-ZnMRXSxWxV27RkDGQ/runs/0/artifacts/public/logs/live_backing.log

---

[task 2019-07-11T21:48:16.264Z] 21:48:16 INFO - TEST-START | org.mozilla.geckoview.test.ContentDelegateTest.crashContentMultipleSessions
[task 2019-07-11T21:50:43.049Z] 21:50:43 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2019-07-11T21:50:43.050Z] 21:50:43 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=6
[task 2019-07-11T21:50:43.050Z] 21:50:43 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: class=org.mozilla.geckoview.test.ContentDelegateTest
[task 2019-07-11T21:50:43.050Z] 21:50:43 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=
[task 2019-07-11T21:50:43.050Z] 21:50:43 INFO - org.mozilla.geckoview.test | Error in crashContentMultipleSessions(org.mozilla.geckoview.test.ContentDelegateTest):
[task 2019-07-11T21:50:43.050Z] 21:50:43 INFO - org.mozilla.geckoview.test | org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 120000ms
[task 2019-07-11T21:50:43.050Z] 21:50:43 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutRunnable.run(UiThreadUtils.java:58)
[task 2019-07-11T21:50:43.051Z] 21:50:43 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:730)
[task 2019-07-11T21:50:43.051Z] 21:50:43 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:92)
[task 2019-07-11T21:50:43.051Z] 21:50:43 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils.waitForCondition(UiThreadUtils.java:161)
[task 2019-07-11T21:50:43.052Z] 21:50:43 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitUntilCalled(GeckoSessionTestRule.java:1528)
[task 2019-07-11T21:50:43.053Z] 21:50:43 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitUntilCalled(GeckoSessionTestRule.java:1470)
[task 2019-07-11T21:50:43.054Z] 21:50:43 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitUntilCalled(GeckoSessionTestRule.java:1423)
[task 2019-07-11T21:50:43.054Z] 21:50:43 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.ContentDelegateTest.crashContentMultipleSessions(ContentDelegateTest.kt:169)
[task 2019-07-11T21:50:43.055Z] 21:50:43 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invokeNative(Native Method)
[task 2019-07-11T21:50:43.056Z] 21:50:43 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invoke(Method.java:525)
[task 2019-07-11T21:50:43.056Z] 21:50:43 INFO - org.mozilla.geckoview.test | at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
[task 2019-07-11T21:50:43.057Z] 21:50:43 INFO - org.mozilla.geckoview.test | at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
[task 2019-07-11T21:50:43.057Z] 21:50:43 INFO - org.mozilla.geckoview.test | at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
[task 2019-07-11T21:50:43.058Z] 21:50:43 INFO - org.mozilla.geckoview.test | at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
[task 2019-07-11T21:50:43.058Z] 21:50:43 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$2.lambda$evaluate$0$GeckoSessionTestRule$2(GeckoSessionTestRule.java:1261)
[task 2019-07-11T21:50:43.059Z] 21:50:43 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$2$$Lambda$0.run(Unknown Source)
[task 2019-07-11T21:50:43.059Z] 21:50:43 INFO - org.mozilla.geckoview.test | at android.app.Instrumentation$SyncRunnable.run(Instrumentation.java:1719)
[task 2019-07-11T21:50:43.060Z] 21:50:43 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:730)
[task 2019-07-11T21:50:43.060Z] 21:50:43 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:92)
[task 2019-07-11T21:50:43.061Z] 21:50:43 INFO - org.mozilla.geckoview.test | at android.os.Looper.loop(Looper.java:137)
[task 2019-07-11T21:50:43.061Z] 21:50:43 INFO - org.mozilla.geckoview.test | at android.app.ActivityThread.main(ActivityThread.java:5103)
[task 2019-07-11T21:50:43.062Z] 21:50:43 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invokeNative(Native Method)
[task 2019-07-11T21:50:43.063Z] 21:50:43 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invoke(Method.java:525)
[task 2019-07-11T21:50:43.064Z] 21:50:43 INFO - org.mozilla.geckoview.test | at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:737)
[task 2019-07-11T21:50:43.065Z] 21:50:43 INFO - org.mozilla.geckoview.test | at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:553)
[task 2019-07-11T21:50:43.065Z] 21:50:43 INFO - org.mozilla.geckoview.test | at dalvik.system.NativeStart.main(Native Method)
[task 2019-07-11T21:50:43.066Z] 21:50:43 INFO - org.mozilla.geckoview.test |
[task 2019-07-11T21:50:43.066Z] 21:50:43 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=49
[task 2019-07-11T21:50:43.067Z] 21:50:43 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stack=org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 120000ms
[task 2019-07-11T21:50:43.068Z] 21:50:43 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutRunnable.run(UiThreadUtils.java:58)
[task 2019-07-11T21:50:43.069Z] 21:50:43 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:730)
[task 2019-07-11T21:50:43.069Z] 21:50:43 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:92)
[task 2019-07-11T21:50:43.069Z] 21:50:43 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils.waitForCondition(UiThreadUtils.java:161)
[task 2019-07-11T21:50:43.070Z] 21:50:43 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitUntilCalled(GeckoSessionTestRule.java:1528)
[task 2019-07-11T21:50:43.070Z] 21:50:43 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitUntilCalled(GeckoSessionTestRule.java:1470)
[task 2019-07-11T21:50:43.071Z] 21:50:43 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitUntilCalled(GeckoSessionTestRule.java:1423)
[task 2019-07-11T21:50:43.071Z] 21:50:43 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.ContentDelegateTest.crashContentMultipleSessions(ContentDelegateTest.kt:169)
[task 2019-07-11T21:50:43.071Z] 21:50:43 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invokeNative(Native Method)
[task 2019-07-11T21:50:43.071Z] 21:50:43 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invoke(Method.java:525)
[task 2019-07-11T21:50:43.071Z] 21:50:43 INFO - org.mozilla.geckoview.test | at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
[task 2019-07-11T21:50:43.071Z] 21:50:43 INFO - org.mozilla.geckoview.test | at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
[task 2019-07-11T21:50:43.071Z] 21:50:43 INFO - org.mozilla.geckoview.test | at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
[task 2019-07-11T21:50:43.071Z] 21:50:43 INFO - org.mozilla.geckoview.test | at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
[task 2019-07-11T21:50:43.071Z] 21:50:43 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$2.lambda$evaluate$0$GeckoSessionTestRule$2(GeckoSessionTestRule.java:1261)
[task 2019-07-11T21:50:43.071Z] 21:50:43 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$2$$Lambda$0.run(Unknown Source)
[task 2019-07-11T21:50:43.072Z] 21:50:43 INFO - org.mozilla.geckoview.test | at android.app.Instrumentation$SyncRunnable.run(Instrumentation.java:1719)
[task 2019-07-11T21:50:43.072Z] 21:50:43 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:730)
[task 2019-07-11T21:50:43.073Z] 21:50:43 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:92)
[task 2019-07-11T21:50:43.073Z] 21:50:43 INFO - org.mozilla.geckoview.test | at android.os.Looper.loop(Looper.java:137)
[task 2019-07-11T21:50:43.073Z] 21:50:43 INFO - org.mozilla.geckoview.test | at android.app.ActivityThread.main(ActivityThread.java:5103)
[task 2019-07-11T21:50:43.073Z] 21:50:43 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invokeNative(Native Method)
[task 2019-07-11T21:50:43.073Z] 21:50:43 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invoke(Method.java:525)
[task 2019-07-11T21:50:43.073Z] 21:50:43 INFO - org.mozilla.geckoview.test | at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:737)
[task 2019-07-11T21:50:43.073Z] 21:50:43 INFO - org.mozilla.geckoview.test | at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:553)
[task 2019-07-11T21:50:43.074Z] 21:50:43 INFO - org.mozilla.geckoview.test | at dalvik.system.NativeStart.main(Native Method)
[task 2019-07-11T21:50:43.074Z] 21:50:43 INFO - org.mozilla.geckoview.test |
[task 2019-07-11T21:50:43.074Z] 21:50:43 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: test=crashContentMultipleSessions
[task 2019-07-11T21:50:43.074Z] 21:50:43 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS_CODE: -2
[task 2019-07-11T21:50:43.074Z] 21:50:43 WARNING - TEST-UNEXPECTED-FAIL | org.mozilla.geckoview.test.ContentDelegateTest.crashContentMultipleSessions | status -2
[task 2019-07-11T21:50:43.074Z] 21:50:43 INFO - TEST-INFO took 146808ms

Comment 1

[Intermittent Failures Robot]

16 failures in 4710 pushes (0.003 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 10
• mozilla-inbound: 4
• try: 1
• mozilla-central: 1

Platform breakdown:

• android-em-4-3-armv7-api16: 16

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1565422&startday=2019-07-08&endday=2019-07-14&tree=all

Comment 2

[[ex-Mozilla] Agi Sferro | :agi]

This was caused by Bug 1557096. See here: https://treeherder.mozilla.org/#/jobs?repo=autoland&selectedJob=256443751&searchStr=junit5&tochange=4629e855ea33d85f8adcc6e76264ac779b799bd1&fromchange=2df4e34175d24a7865ea0a623a6353ba9afb9779 (note this bug landed on the 11th too but was backed out).

Comment 3

[Intermittent Failures Robot]

23 failures in 4298 pushes (0.005 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 11
• mozilla-inbound: 4
• mozilla-central: 4
• try: 4

Platform breakdown:

• android-em-4-3-armv7-api16: 15
• android-em-7-0-x86_64: 8

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1565422&startday=2019-07-15&endday=2019-07-21&tree=all

Comment 4

[Intermittent Failures Robot]

9 failures in 4608 pushes (0.002 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• try: 5
• autoland: 1
• mozilla-central: 2
• mozilla-inbound: 1

Platform breakdown:

• android-em-7-0-x86_64: 6
• android-em-4-3-armv7-api16: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1565422&startday=2019-07-22&endday=2019-07-28&tree=all

Comment 5

[Intermittent Failures Robot]

18 failures in 4439 pushes (0.004 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• try: 7
• autoland: 9
• mozilla-central: 1
• mozilla-inbound: 1

Platform breakdown:

• android-em-7-0-x86_64: 13
• android-em-4-3-armv7-api16: 5

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1565422&startday=2019-07-29&endday=2019-08-04&tree=all

Comment 6

[[ex-Mozilla] Agi Sferro | :agi]

Attachment: Bug 1565422 - Fix intermittent crashContentMultipleSessions.

This test makes the implicit assumption that the two events cannot happen near
instantaneously, but as evidence from the test results, sometimes they do. This
patch fixes the intermittent by waiting for both events at the same time.

Comment 7

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/4c3ebc637611
Fix intermittent crashContentMultipleSessions. r=droeh

Comment 8

[Andrei Ciure[:aciure]]

https://hg.mozilla.org/mozilla-central/rev/4c3ebc637611

Comment 9

[Intermittent Failures Robot]

2 failures in 4666 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-inbound: 2

Platform breakdown:

• android-em-4-3-armv7-api16: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1565422&startday=2019-08-05&endday=2019-08-11&tree=all

Comment 10

[[ex-Mozilla] Agi Sferro | :agi]

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