Intermittent dom/media/mediasource/test/test_WaitingOnMissingDataEnded_mp4.html | Test timed out. -
Categories
(Core :: Audio/Video, defect, P5)
Tracking
()
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure)
Filed by: imoraru [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=339810207&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/auEqGR16SWugYV5j51HRpg/runs/0/artifacts/public/logs/live_backing.log
[task 2021-05-16T11:05:59.084Z] 11:00:02 INFO - TEST-START | dom/media/mediasource/test/test_WaitingOnMissingDataEnded_mp4.html
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - Buffered messages logged at 11:00:01
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - TEST-PASS | dom/media/mediasource/test/test_WaitingOnMissingDataEnded_mp4.html | Receive a sourceopen event
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - TEST-PASS | dom/media/mediasource/test/test_WaitingOnMissingDataEnded_mp4.html | fetchWithXHR load uri='bipbop/bipbop_videoinit.mp4' status=200
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - Buffered messages logged at 11:00:02
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - Loading buffer: [0, 887)
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - SourceBuffer buffered ranges grew from TimeRanges: to TimeRanges:
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - TEST-PASS | dom/media/mediasource/test/test_WaitingOnMissingDataEnded_mp4.html | fetchWithXHR load uri='bipbop/bipbop_video1.m4s' status=200
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - TEST-PASS | dom/media/mediasource/test/test_WaitingOnMissingDataEnded_mp4.html | fetchWithXHR load uri='bipbop/bipbop_video2.m4s' status=200
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - TEST-PASS | dom/media/mediasource/test/test_WaitingOnMissingDataEnded_mp4.html | fetchWithXHR load uri='bipbop/bipbop_video3.m4s' status=200
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - TEST-PASS | dom/media/mediasource/test/test_WaitingOnMissingDataEnded_mp4.html | fetchWithXHR load uri='bipbop/bipbop_video4.m4s' status=200
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - Loading buffer: [0, 23860)
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - SourceBuffer buffered ranges grew from TimeRanges: to TimeRanges: [0, 0.801666)
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - Loading buffer: [0, 21595)
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - SourceBuffer buffered ranges grew from TimeRanges: [0, 0.801666) to TimeRanges: [0, 1.601666)
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - Loading buffer: [0, 23429)
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - SourceBuffer buffered ranges grew from TimeRanges: [0, 1.601666) to TimeRanges: [0, 2.403333)
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - Loading buffer: [0, 22446)
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - SourceBuffer buffered ranges grew from TimeRanges: [0, 2.403333) to TimeRanges: [0, 3.203333)
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - TEST-PASS | dom/media/mediasource/test/test_WaitingOnMissingDataEnded_mp4.html | fetchWithXHR load uri='bipbop/bipbop_video6.m4s' status=200
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - TEST-PASS | dom/media/mediasource/test/test_WaitingOnMissingDataEnded_mp4.html | fetchWithXHR load uri='bipbop/bipbop_video7.m4s' status=200
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - Loading buffer: [0, 23773)
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - SourceBuffer buffered ranges grew from TimeRanges: [0, 3.203333) to TimeRanges: [0, 3.203333)[4.005, 4.805)
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - Loading buffer: [0, 21749)
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - SourceBuffer buffered ranges grew from TimeRanges: [0, 3.203333)[4.005, 4.805) to TimeRanges: [0, 3.203333)[4.005, 5.606666)
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - TEST-PASS | dom/media/mediasource/test/test_WaitingOnMissingDataEnded_mp4.html | discontinuous buffered range
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - Invoking play()
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - TEST-PASS | dom/media/mediasource/test/test_WaitingOnMissingDataEnded_mp4.html | Video playing. It should play for a bit, then fire 'waiting'
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - Buffered messages finished
[task 2021-05-16T11:05:59.085Z] 11:05:19 WARNING - TEST-UNEXPECTED-FAIL | dom/media/mediasource/test/test_WaitingOnMissingDataEnded_mp4.html | Test timed out. -
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - TEST-OK | dom/media/mediasource/test/test_WaitingOnMissingDataEnded_mp4.html | took 316179ms
[task 2021-05-16T11:05:59.085Z] 11:05:19 INFO - TEST-START | dom/media/mediasource/test/test_WaitingOnMissingData_mp4.html
[task 2021-05-16T11:05:59.085Z] 11:05:30 INFO - TEST-OK | dom/media/mediasource/test/test_WaitingOnMissingData_mp4.html | took 11070ms
[task 2021-05-16T11:05:59.085Z] 11:05:30 INFO - TEST-START | dom/media/mediasource/test/test_WaitingToEndedTransition_mp4.html
[task 2021-05-16T11:05:59.085Z] 11:05:41 INFO - TEST-OK | dom/media/mediasource/test/test_WaitingToEndedTransition_mp4.html | took 4539ms
[task 2021-05-16T11:05:59.085Z] 11:05:41 INFO - TEST-START | dom/media/mediasource/test/test_WebMTagsBeforeCluster.html
[task 2021-05-16T11:05:59.085Z] 11:05:41 INFO - TEST-OK | dom/media/mediasource/test/test_WebMTagsBeforeCluster.html | took 220ms
[task 2021-05-16T11:05:59.085Z] 11:05:41 INFO - TEST-START | dom/media/mediasource/test/test_trackidchange_mp4.html
[task 2021-05-16T11:05:59.085Z] 11:05:41 INFO - TEST-OK | dom/media/mediasource/test/test_trackidchange_mp4.html | took 244ms
[task 2021-05-16T11:05:59.085Z] 11:05:41 INFO - TEST-START | Shutdown
[task 2021-05-16T11:05:59.085Z] 11:05:41 INFO - Passed: 821
[task 2021-05-16T11:05:59.085Z] 11:05:41 INFO - Failed: 0
[task 2021-05-16T11:05:59.085Z] 11:05:41 INFO - Todo: 2
[task 2021-05-16T11:05:59.085Z] 11:05:41 INFO - Mode: e10s
[task 2021-05-16T11:05:59.085Z] 11:05:41 INFO - Slowest: 316179ms - /tests/dom/media/mediasource/test/test_WaitingOnMissingDataEnded_mp4.html
[task 2021-05-16T11:05:59.085Z] 11:05:41 INFO - SimpleTest FINISHED
[task 2021-05-16T11:05:59.085Z] 11:05:46 INFO - wait for org.mozilla.geckoview.test complete; top activity=com.bitbar.testdroid.monitor
[task 2021-05-16T11:05:59.085Z] 11:05:46 INFO - runtestsremote.py | Application ran for: 0:08:04.233165
[task 2021-05-16T11:05:59.085Z] 11:05:47 INFO - Stopping web server
[task 2021-05-16T11:05:59.085Z] 11:05:47 INFO - Server shut down.
[task 2021-05-16T11:05:59.085Z] 11:05:47 INFO - Web server killed.
[task 2021-05-16T11:05:59.085Z] 11:05:47 INFO - Stopping web socket server
[task 2021-05-16T11:05:59.085Z] 11:05:47 INFO - Stopping ssltunnel
[task 2021-05-16T11:05:59.085Z] 11:05:47 INFO - websocket/process bridge listening on port 8191
[task 2021-05-16T11:05:59.085Z] 11:05:47 INFO - Stopping websocket/process bridge
[task 2021-05-16T11:05:59.085Z] 11:05:47 INFO - leakcheck | refcount logging is off, so leaks can't be detected!
[task 2021-05-16T11:05:59.085Z] 11:05:47 INFO - runtests.py | Running tests: end.
[task 2021-05-16T11:05:59.085Z] 11:05:51 INFO - Buffered messages finished
[task 2021-05-16T11:05:59.085Z] 11:05:51 INFO - Running manifest: dom/media/webaudio/test/blink/mochitest.ini
[task 2021-05-16T11:05:59.085Z] 11:05:55 INFO - PID 2410 | pk12util: PKCS12 IMPORT SUCCESSFUL
[task 2021-05-16T11:05:59.085Z] 11:05:56 INFO - MochitestServer : launching ['/builds/task_162116065615068/workspace/build/hostutils/host-utils-85.0a1.en-US.linux-x86_64/xpcshell', '-g', '/builds/task_162116065615068/workspace/build/hostutils/host-utils-85.0a1.en-US.linux-x86_64', '-f', '/builds/task_162116065615068/workspace/build/hostutils/host-utils-85.0a1.en-US.linux-x86_64/components/httpd.js', '-e', "const _PROFILE_PATH = '/tmp/tmpa3jjx987.mozrunner'; const _SERVER_PORT = '8854'; const _SERVER_ADDR = '10.7.205.245'; const _TEST_PREFIX = undefined; const _DISPLAY_RESULTS = false;", '-f', '/builds/task_162116065615068/workspace/build/tests/mochitest/server.js']
[task 2021-05-16T11:05:59.085Z] 11:05:56 INFO - runtests.py | Server pid: 2419
[task 2021-05-16T11:05:59.085Z] 11:05:56 INFO - runtests.py | Websocket server pid: 2422
[task 2021-05-16T11:05:59.085Z] 11:05:56 INFO - runtests.py | websocket/process bridge pid: 2426
[task 2021-05-16T11:05:59.085Z] 11:05:56 INFO - runtests.py | SSL tunnel pid: 2442
[task 2021-05-16T11:05:59.085Z] 11:05:59 INFO - runtests.py | Running with scheme: http
[task 2021-05-16T11:05:59.085Z] 11:05:59 INFO - runtests.py | Running with e10s: True
[task 2021-05-16T11:05:59.085Z] 11:05:59 INFO - runtests.py | Running with fission: False
[task 2021-05-16T11:05:59.085Z] 11:05:59 INFO - runtests.py | Running with cross-origin iframes: False
[task 2021-05-16T11:05:59.085Z] 11:05:59 INFO - runtests.py | Running with serviceworker_e10s: True
[task 2021-05-16T11:05:59.085Z] 11:05:59 INFO - runtests.py | Running with socketprocess_e10s: False
[task 2021-05-16T11:06:53.593Z] 11:05:59 INFO - runtests.py | Running tests: start.
[task 2021-05-16T11:06:53.593Z] 11:05:59 INFO - adb Granting important runtime permissions to org.mozilla.geckoview.test
[task 2021-05-16T11:06:53.593Z] 11:06:02 INFO - adb launch_application: am start -W -n org.mozilla.geckoview.test/org.mozilla.geckoview.test.TestRunnerActivity -a android.intent.action.MAIN --es env0 MOZ_CRASHREPORTER_NO_REPORT=1 --es env1 MOZ_CRASHREPORTER=1 --es env2 MOZ_CRASHREPORTER_SHUTDOWN=1 --es env3 MOZ_DISABLE_NONLOCAL_CONNECTIONS=1 --es env4 MOZ_IN_AUTOMATION=1 --es env5 R_LOG_LEVEL=6 --es env6 R_LOG_DESTINATION=stderr --es env7 R_LOG_VERBOSE=1 --es env8 XPCOM_DEBUG_BREAK=stack --es env9 MOZ_WEBRENDER=1 --es env10 MOZ_ACCELERATED=1 --es env11 MOZ_UPLOAD_DIR=/data/local/tmp/test_root/mozlog --es env12 MOZ_HIDE_RESULTS_TABLE=1 --es arg0 -no-remote --es arg1 -profile --es arg2 /data/local/tmp/test_root/profile/ --ez use_multiprocess True -d 'http://mochi.test:8888/tests?autorun=1&closeWhenDone=1&logFile=%2Fdata%2Flocal%2Ftmp%2Ftest_root%2Flogs%2Fmochitest.log&fileLevel=INFO&consoleLevel=INFO&hideResultsTable=1&manifestFile=tests.json&dumpOutputDirectory=%2Fdata%2Flocal%2Ftmp%2Ftest_root'
[task 2021-05-16T11:06:53.593Z] 11:06:03 INFO - runtestsremote.py | Application pid: 12389
[task 2021-05-16T11:06:53.593Z] 11:06:06 INFO - SimpleTest START
[task 2021-05-16T11:06:53.593Z] 11:06:06 INFO - TEST-START | dom/media/webaudio/test/blink/test_biquadFilterNodeAllPass.html```
Comment 1•5 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
| Reporter | ||
Comment 2•4 years ago
|
||
| treeherder | ||
New failure instance: https://treeherder.mozilla.org/logviewer?job_id=371234198&repo=mozilla-central
| Comment hidden (Intermittent Failures Robot) |
Comment 4•4 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
| Reporter | ||
Comment 5•3 years ago
|
||
| treeherder | ||
New failure instance: https://treeherder.mozilla.org/logviewer?job_id=382177972&repo=mozilla-central
| Comment hidden (Intermittent Failures Robot) |
Comment 7•3 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
Description
•