Closed Bug 1632214 Opened 5 years ago Closed 4 years ago

Intermittent TEST-UNEXPECTED-TIMEOUT | toolkit/content/tests/browser/browser_autoplay_policy_web_audio_with_gum.js | application timed out after 370 seconds with no output

Categories

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

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

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


task 2020-04-22T15:00:00.111Z] 15:00:00 INFO - TEST-PASS | toolkit/content/tests/browser/browser_autoplay_policy_web_audio_with_gum.js | AudioContext is not started yet. - true == true -
[task 2020-04-22T15:00:00.112Z] 15:00:00 INFO - - calling gum with {"audio":true}
[task 2020-04-22T15:00:00.112Z] 15:00:00 INFO - - calling resume() again
[task 2020-04-22T15:00:00.112Z] 15:00:00 INFO - Console message: [JavaScript Warning: "An AudioContext was prevented from starting automatically. It must be created or resumed after a user gesture on the page." {file: "chrome://mochitests/content/browser/toolkit/content/tests/browser/browser_autoplay_policy_web_audio_with_gum.js" line: 92}]
[task 2020-04-22T15:00:00.112Z] 15:00:00 INFO - Buffered messages finished
[task 2020-04-22T15:00:00.112Z] 15:00:00 ERROR - TEST-UNEXPECTED-TIMEOUT | toolkit/content/tests/browser/browser_autoplay_policy_web_audio_with_gum.js | application timed out after 370 seconds with no output
[task 2020-04-22T15:00:00.112Z] 15:00:00 ERROR - Force-terminating active process(es).
[task 2020-04-22T15:00:00.113Z] 15:00:00 INFO - Determining child pids from psutil...
[task 2020-04-22T15:00:00.113Z] 15:00:00 INFO - [7352]
[task 2020-04-22T15:00:00.113Z] 15:00:00 INFO - ==> process 7352 launched child process 10640 ("Z:\task_1587564232\build\application\firefox\firefox.exe" -contentproc --channel="7352.0.841638226\2036473427" -parentBuildID 20200422131352 -prefsHandle 2212 -prefMapHandle 2188 -prefsLen 1 -prefMapSize 231008 -appdir "Z:\task_1587564232\build\application\firefox\browser" - 7352 gpu)
[task 2020-04-22T15:00:00.113Z] 15:00:00 INFO - ==> process 7352 launched child process 4716 ("Z:\task_1587564232\build\application\firefox\firefox.exe" -contentproc --channel="7352.6.1869311495\1852870272" -childID 1 -isForBrowser -prefsHandle 2852 -prefMapHandle 2004 -prefsLen 1541 -prefMapSize 231008 -parentBuildID 20200422131352 -appdir "Z:\task_1587564232\build\application\firefox\browser" - 7352 tab)
[task 2020-04-22T15:00:00.114Z] 15:00:00 INFO - ==> process 7352 launched child process 10224 ("Z:\task_1587564232\build\application\firefox\firefox.exe" -contentproc --channel="7352.13.2055370712\78987107" -childID 2 -isForBrowser -prefsHandle 2860 -prefMapHandle 2864 -prefsLen 1682 -prefMapSize 231008 -parentBuildID 20200422131352 -appdir "Z:\task_1587564232\build\application\firefox\browser" - 7352 tab)
[task 2020-04-22T15:00:00.114Z] 15:00:00 INFO - ==> process 7352 launched child process 10540 ("Z:\task_1587564232\build\application\firefox\firefox.exe" -contentproc --channel="7352.20.1704882094\539752973" -childID 3 -isForBrowser -prefsHandle 4772 -prefMapHandle 4768 -prefsLen 1743 -prefMapSize 231008 -parentBuildID 20200422131352 -appdir "Z:\task_1587564232\build\application\firefox\browser" - 7352 tab)
[task 2020-04-22T15:00:00.114Z] 15:00:00 INFO - ==> process 7352 launched child process 4468 ("Z:\task_1587564232\build\application\firefox\firefox.exe" -contentproc --channel="7352.27.486344474\1844069901" -childID 4 -isForBrowser -prefsHandle 3576 -prefMapHandle 3672 -prefsLen 11447 -prefMapSize 231008 -parentBuildID 20200422131352 -appdir "Z:\task_1587564232\build\application\firefox\browser" - 7352 tab)
[task 2020-04-22T15:00:00.114Z] 15:00:00 INFO - ==> process 7352 launched child process 8208 ("Z:\task_1587564232\build\application\firefox\firefox.exe" -contentproc --channel="7352.34.1813532790\1850712336" -childID 5 -isForBrowser -prefsHandle 3536 -prefMapHandle 4600 -prefsLen 11529 -prefMapSize 231008 -parentBuildID 20200422131352 -appdir "Z:\task_1587564232\build\application\firefox\browser" - 7352 tab)
[task 2020-04-22T15:00:00.115Z] 15:00:00 INFO - ==> process 7352 launched child process 1108 ("Z:\task_1587564232\build\application\firefox\firefox.exe" -contentproc --channel="7352.41.852068822\142974193" -parentBuildID 20200422131352 -prefsHandle 3092 -prefMapHandle 3492 -prefsLen 11704 -prefMapSize 231008 -appdir "Z:\task_1587564232\build\application\firefox\browser" - 7352 rdd)
[task 2020-04-22T15:00:00.115Z] 15:00:00 INFO - Found child pids: set([10224, 8208, 10540, 4716, 10640, 4468, 7352, 1108])
[task 2020-04-22T15:00:00.115Z] 15:00:00 INFO - Killing process: 10224
[task 2020-04-22T15:00:00.115Z] 15:00:00 INFO - TEST-INFO | started process screenshot
[task 2020-04-22T15:00:00.359Z] 15:00:00 INFO - TEST-INFO | screenshot: exit 0
[task 2020-04-22T15:00:00.359Z] 15:00:00 INFO - Can't trigger Breakpad, just killing process
[task 2020-04-22T15:00:00.409Z] 15:00:00 INFO - psutil found pid 10224 dead
[task 2020-04-22T15:00:00.409Z] 15:00:00 INFO - Killing process: 8208
[task 2020-04-22T15:00:00.409Z] 15:00:00 INFO - Not taking screenshot here: see the one that was previously logged
[task 2020-04-22T15:00:00.410Z] 15:00:00 INFO - Can't trigger Breakpad, just killing process
[task 2020-04-22T15:00:00.481Z] 15:00:00 INFO - psutil found pid 8208 dead
[task 2020-04-22T15:00:00.482Z] 15:00:00 INFO - Killing process: 10540

Status: NEW → RESOLVED
Closed: 4 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.