Closed Bug 1569031 Opened 5 years ago Closed 1 year ago

Intermittent org.mozilla.geckoview.test.MediaElementTest#oggPlayMedia | status -2

Categories

(Core :: Audio/Video: Playback, defect, P5)

Unspecified
Android
defect

Tracking

()

RESOLVED WORKSFORME
Tracking Status
firefox70 --- fix-optional

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Blocks 1 open bug)

Details

(Keywords: intermittent-failure, regression)

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


[task 2019-07-25T20:41:10.236Z] 20:41:10 INFO - TEST-START | org.mozilla.geckoview.test.MediaElementTest.oggPlayMedia
[task 2019-07-25T20:41:56.518Z] 20:41:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=488
[task 2019-07-25T20:41:56.520Z] 20:41:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=
[task 2019-07-25T20:41:56.520Z] 20:41:56 INFO - org.mozilla.geckoview.test | Error in oggPlayMedia(org.mozilla.geckoview.test.MediaElementTest):
[task 2019-07-25T20:41:56.520Z] 20:41:56 INFO - org.mozilla.geckoview.test | org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 45000ms
[task 2019-07-25T20:41:56.520Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutRunnable.run(UiThreadUtils.java:58)
[task 2019-07-25T20:41:56.520Z] 20:41:56 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:751)
[task 2019-07-25T20:41:56.520Z] 20:41:56 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2019-07-25T20:41:56.520Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils.waitForCondition(UiThreadUtils.java:161)
[task 2019-07-25T20:41:56.520Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitUntilCalled(GeckoSessionTestRule.java:1528)
[task 2019-07-25T20:41:56.520Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitUntilCalled(GeckoSessionTestRule.java:1470)
[task 2019-07-25T20:41:56.520Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitUntilCalled(GeckoSessionTestRule.java:1423)
[task 2019-07-25T20:41:56.520Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.MediaElementTest.waitUntilState(MediaElementTest.kt:73)
[task 2019-07-25T20:41:56.520Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.MediaElementTest.waitUntilVideoReady(MediaElementTest.kt:91)
[task 2019-07-25T20:41:56.524Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.MediaElementTest.waitUntilVideoReady$default(MediaElementTest.kt:89)
[task 2019-07-25T20:41:56.524Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.MediaElementTest.playMedia(MediaElementTest.kt:129)
[task 2019-07-25T20:41:56.524Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.MediaElementTest.oggPlayMedia(MediaElementTest.kt:220)
[task 2019-07-25T20:41:56.524Z] 20:41:56 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invoke(Native Method)
[task 2019-07-25T20:41:56.524Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
[task 2019-07-25T20:41:56.524Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
[task 2019-07-25T20:41:56.524Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
[task 2019-07-25T20:41:56.524Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
[task 2019-07-25T20:41:56.524Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$2.lambda$evaluate$0$GeckoSessionTestRule$2(GeckoSessionTestRule.java:1261)
[task 2019-07-25T20:41:56.524Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.-$$Lambda$GeckoSessionTestRule$2$mzZNnl5Bu5F2_4xGxj0DHU4J33I.run(lambda)
[task 2019-07-25T20:41:56.524Z] 20:41:56 INFO - org.mozilla.geckoview.test | at android.app.Instrumentation$SyncRunnable.run(Instrumentation.java:1950)
[task 2019-07-25T20:41:56.524Z] 20:41:56 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:751)
[task 2019-07-25T20:41:56.524Z] 20:41:56 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2019-07-25T20:41:56.524Z] 20:41:56 INFO - org.mozilla.geckoview.test | at android.os.Looper.loop(Looper.java:154)
[task 2019-07-25T20:41:56.524Z] 20:41:56 INFO - org.mozilla.geckoview.test | at android.app.ActivityThread.main(ActivityThread.java:6077)
[task 2019-07-25T20:41:56.524Z] 20:41:56 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invoke(Native Method)
[task 2019-07-25T20:41:56.524Z] 20:41:56 INFO - org.mozilla.geckoview.test | at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:866)
[task 2019-07-25T20:41:56.524Z] 20:41:56 INFO - org.mozilla.geckoview.test | at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:756)
[task 2019-07-25T20:41:56.524Z] 20:41:56 INFO - org.mozilla.geckoview.test |
[task 2019-07-25T20:41:56.524Z] 20:41:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2019-07-25T20:41:56.524Z] 20:41:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: test=oggPlayMedia
[task 2019-07-25T20:41:56.524Z] 20:41:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: class=org.mozilla.geckoview.test.MediaElementTest
[task 2019-07-25T20:41:56.524Z] 20:41:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stack=org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutException: Timed out after 45000ms
[task 2019-07-25T20:41:56.524Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils$TimeoutRunnable.run(UiThreadUtils.java:58)
[task 2019-07-25T20:41:56.524Z] 20:41:56 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:751)
[task 2019-07-25T20:41:56.524Z] 20:41:56 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2019-07-25T20:41:56.524Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.util.UiThreadUtils.waitForCondition(UiThreadUtils.java:161)
[task 2019-07-25T20:41:56.524Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitUntilCalled(GeckoSessionTestRule.java:1528)
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitUntilCalled(GeckoSessionTestRule.java:1470)
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule.waitUntilCalled(GeckoSessionTestRule.java:1423)
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.MediaElementTest.waitUntilState(MediaElementTest.kt:73)
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.MediaElementTest.waitUntilVideoReady(MediaElementTest.kt:91)
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.MediaElementTest.waitUntilVideoReady$default(MediaElementTest.kt:89)
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.MediaElementTest.playMedia(MediaElementTest.kt:129)
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.MediaElementTest.oggPlayMedia(MediaElementTest.kt:220)
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invoke(Native Method)
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.GeckoSessionTestRule$2.lambda$evaluate$0$GeckoSessionTestRule$2(GeckoSessionTestRule.java:1261)
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | at org.mozilla.geckoview.test.rule.-$$Lambda$GeckoSessionTestRule$2$mzZNnl5Bu5F2_4xGxj0DHU4J33I.run(lambda)
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | at android.app.Instrumentation$SyncRunnable.run(Instrumentation.java:1950)
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | at android.os.Handler.handleCallback(Handler.java:751)
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | at android.os.Handler.dispatchMessage(Handler.java:95)
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | at android.os.Looper.loop(Looper.java:154)
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | at android.app.ActivityThread.main(ActivityThread.java:6077)
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | at java.lang.reflect.Method.invoke(Native Method)
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:866)
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:756)
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test |
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=194
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS_CODE: -2
[task 2019-07-25T20:41:56.525Z] 20:41:56 WARNING - TEST-UNEXPECTED-FAIL | org.mozilla.geckoview.test.MediaElementTest.oggPlayMedia | status -2
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - TEST-INFO took 46286ms
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: numtests=488
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: stream=
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: id=AndroidJUnitRunner
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: test=webmSeekMedia
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: class=org.mozilla.geckoview.test.MediaElementTest
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS: current=195
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_STATUS_CODE: 1
[task 2019-07-25T20:41:56.525Z] 20:41:56 INFO - TEST-START | org.mozilla.geckoview.test.MediaElementTest.webmSeekMedia

Moving this bug to the "Audio/Video: Playback" component because it is a test failure in oggPlayMedia(org.mozilla.geckoview.test.MediaElementTest).

Component: General → Audio/Video: Playback
OS: All → Android
Product: GeckoView → Core
Version: unspecified → Trunk

To me this looks like a test problem. I'm taking a stab at rewriting the Media tests in a less intermittent way, since this is a lot more frequent on x86_64 debug.

Assignee: nobody → agi

Happy to take a patch here for 70; I'm just marking this fix-optional to remove it from weekly triage.

Assignee: agi → nobody

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

Summary: Intermittent org.mozilla.geckoview.test.MediaElementTest.oggPlayMedia | status -2 → Intermittent org.mozilla.geckoview.test.MediaElementTest#oggPlayMedia | status -2
Severity: normal → S3
Severity: normal → S3
Status: NEW → RESOLVED
Closed: 1 year ago
Resolution: --- → WORKSFORME
You need to log in before you can comment on or make changes to this bug.