Intermittent /html/semantics/embedded-content/media-elements/track/track-element/track-element-src-change-error.html | HTMLTrackElement 'src' attribute mutations - assert_unreached: 'error' event did not fire, stage = 4 Reached unreachable code
Categories
(Core :: DOM: Core & HTML, defect, P3)
Tracking
()
People
(Reporter: intermittent-bug-filer, Unassigned)
References
(Regression)
Details
(Keywords: intermittent-failure, regression, Whiteboard: [retriggered][stockwell disabled])
Attachments
(1 file)
Filed by: aciure [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=273044694&repo=autoland
Full log: https://queue.taskcluster.net/v1/task/J_mQOjteSPO1-L1TJEo5Ag/runs/0/artifacts/public/logs/live_backing.log
[task 2019-10-26T00:04:46.915Z] 00:04:46 INFO - TEST-START | /html/semantics/embedded-content/media-elements/track/track-element/track-element-src-change-error.html
[task 2019-10-26T00:04:46.915Z] 00:04:46 INFO - Closing window 82
[task 2019-10-26T00:04:47.490Z] 00:04:47 INFO -
[task 2019-10-26T00:04:47.490Z] 00:04:47 INFO - TEST-UNEXPECTED-FAIL | /html/semantics/embedded-content/media-elements/track/track-element/track-element-src-change-error.html | HTMLTrackElement 'src' attribute mutations - assert_unreached: 'error' event did not fire, stage = 4 Reached unreachable code
[task 2019-10-26T00:04:47.490Z] 00:04:47 INFO - step_onLoad@http://web-platform.test:8000/html/semantics/embedded-content/media-elements/track/track-element/track-element-src-change-error.html:25:37
[task 2019-10-26T00:04:47.490Z] 00:04:47 INFO - Test.prototype.step@http://web-platform.test:8000/resources/testharness.js:1908:25
[task 2019-10-26T00:04:47.490Z] 00:04:47 INFO - Test.prototype.step_func/<@http://web-platform.test:8000/resources/testharness.js:1932:35
[task 2019-10-26T00:04:47.490Z] 00:04:47 INFO - EventHandlerNonNull*@http://web-platform.test:8000/html/semantics/embedded-content/media-elements/track/track-element/track-element-src-change-error.html:82:30
[task 2019-10-26T00:04:47.490Z] 00:04:47 INFO - Test.prototype.step@http://web-platform.test:8000/resources/testharness.js:1908:25
[task 2019-10-26T00:04:47.490Z] 00:04:47 INFO - async_test@http://web-platform.test:8000/resources/testharness.js:576:22
[task 2019-10-26T00:04:47.490Z] 00:04:47 INFO - @http://web-platform.test:8000/html/semantics/embedded-content/media-elements/track/track-element/track-element-src-change-error.html:8:15
[task 2019-10-26T00:04:47.490Z] 00:04:47 INFO - TEST-OK | /html/semantics/embedded-content/media-elements/track/track-element/track-element-src-change-error.html | took 547ms
[task 2019-10-26T00:04:47.491Z] 00:04:47 INFO - PID 2278 | 1572048287464 Marionette INFO Stopped listening on port 50110
[task 2019-10-26T00:04:48.283Z] 00:04:48 INFO - Browser exited with return code 0
[task 2019-10-26T00:04:48.283Z] 00:04:48 INFO - PROCESS LEAKS None
[task 2019-10-26T00:04:48.283Z] 00:04:48 INFO - Closing logging queue
[task 2019-10-26T00:04:48.283Z] 00:04:48 INFO - queue closed
[task 2019-10-26T00:04:48.303Z] 00:04:48 INFO - Setting up ssl
[task 2019-10-26T00:04:48.353Z] 00:04:48 INFO - certutil |
[task 2019-10-26T00:04:48.379Z] 00:04:48 INFO - certutil |
[task 2019-10-26T00:04:48.412Z] 00:04:48 INFO - certutil |
[task 2019-10-26T00:04:48.412Z] 00:04:48 INFO - Certificate Nickname Trust Attributes
[task 2019-10-26T00:04:48.412Z] 00:04:48 INFO - SSL,S/MIME,JAR/XPI
[task 2019-10-26T00:04:48.412Z] 00:04:48 INFO -
[task 2019-10-26T00:04:48.412Z] 00:04:48 INFO - web-platform-tests CT,,
[task 2019-10-26T00:04:48.412Z] 00:04:48 INFO -
[task 2019-10-26T00:04:48.439Z] 00:04:48 INFO - Application command: /Users/cltbld/tasks/task_1572047630/build/application/Firefox Nightly.app/Contents/MacOS/firefox --marionette about:blank -foreground -profile /var/folders/zw/128m5fxs26bcf56v5_bgpjzh000017/T/tmp6pEPhB.mozrunner
[task 2019-10-26T00:04:48.449Z] 00:04:48 INFO - Starting runner
[task 2019-10-26T00:04:49.253Z] 00:04:49 INFO - PID 2320 | 1572048289223 addons.webextension.screenshots@mozilla.org WARN Loading extension 'screenshots@mozilla.org': Reading manifest: Invalid extension permission: mozillaAddons
[task 2019-10-26T00:04:49.253Z] 00:04:49 INFO - PID 2320 | 1572048289223 addons.webextension.screenshots@mozilla.org WARN Loading extension 'screenshots@mozilla.org': Reading manifest: Invalid extension permission: telemetry
[task 2019-10-26T00:04:49.253Z] 00:04:49 INFO - PID 2320 | 1572048289224 addons.webextension.screenshots@mozilla.org WARN Loading extension 'screenshots@mozilla.org': Reading manifest: Invalid extension permission: resource://pdf.js/
[task 2019-10-26T00:04:49.253Z] 00:04:49 INFO - PID 2320 | 1572048289224 addons.webextension.screenshots@mozilla.org WARN Loading extension 'screenshots@mozilla.org': Reading manifest: Invalid extension permission: about:reader*
[task 2019-10-26T00:04:51.877Z] 00:04:51 INFO - PID 2320 | 1572048291860 Marionette INFO Listening on port 50110
Comment 1•6 years ago
|
||
Comment hidden (Intermittent Failures Robot) |
Comment 3•6 years ago
|
||
Retrigger results point to bug 1591227.
Mike please take a look.
Updated•6 years ago
|
Comment hidden (Intermittent Failures Robot) |
Comment 5•6 years ago
|
||
Hi Geoff, do we backout here or disable the test?
There are 96 total failures since October 25th.
Comment hidden (Intermittent Failures Robot) |
Comment 7•6 years ago
|
||
![]() |
||
Comment 8•6 years ago
|
||
(In reply to Andreea Pavel [:apavel] from comment #5)
Hi Geoff, do we backout here or disable the test?
If in doubt, it's best to check with the patch author.
Comment hidden (Intermittent Failures Robot) |
Comment 10•6 years ago
|
||
Comment 11•6 years ago
|
||
Backed out changeset 84c97e387e08 (bug 1591638) for failing at track-element-src-change-error.html on a CLOSED TREE.
Backout link: https://hg.mozilla.org/integration/autoland/rev/475496111203207e076e6ac8c62d4dfc87df871f
Log link: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=274048940&repo=autoland&lineNumber=3293
Log snippet:
[task 2019-11-01T10:15:17.586Z] 10:15:17 INFO - TEST-START | /html/semantics/embedded-content/media-elements/track/track-element/track-element-src-change-error.html
[task 2019-11-01T10:15:17.589Z] 10:15:17 INFO - Closing window 82
[task 2019-11-01T10:15:18.318Z] 10:15:18 INFO -
[task 2019-11-01T10:15:18.318Z] 10:15:18 INFO - TEST-UNEXPECTED-FAIL | /html/semantics/embedded-content/media-elements/track/track-element/track-element-src-change-error.html | HTMLTrackElement 'src' attribute mutations - assert_unreached: 'error' event did not fire, stage = 4 Reached unreachable code
[task 2019-11-01T10:15:18.318Z] 10:15:18 INFO - step_onLoad@http://web-platform.test:8000/html/semantics/embedded-content/media-elements/track/track-element/track-element-src-change-error.html:25:37
[task 2019-11-01T10:15:18.318Z] 10:15:18 INFO - Test.prototype.step@http://web-platform.test:8000/resources/testharness.js:1908:25
[task 2019-11-01T10:15:18.319Z] 10:15:18 INFO - Test.prototype.step_func/<@http://web-platform.test:8000/resources/testharness.js:1932:35
[task 2019-11-01T10:15:18.319Z] 10:15:18 INFO - EventHandlerNonNull*@http://web-platform.test:8000/html/semantics/embedded-content/media-elements/track/track-element/track-element-src-change-error.html:82:30
[task 2019-11-01T10:15:18.319Z] 10:15:18 INFO - Test.prototype.step@http://web-platform.test:8000/resources/testharness.js:1908:25
[task 2019-11-01T10:15:18.319Z] 10:15:18 INFO - async_test@http://web-platform.test:8000/resources/testharness.js:576:22
[task 2019-11-01T10:15:18.319Z] 10:15:18 INFO - @http://web-platform.test:8000/html/semantics/embedded-content/media-elements/track/track-element/track-element-src-change-error.html:8:15
[task 2019-11-01T10:15:18.319Z] 10:15:18 INFO - TEST-UNEXPECTED-OK | /html/semantics/embedded-content/media-elements/track/track-element/track-element-src-change-error.html | expected PASS
[task 2019-11-01T10:15:18.319Z] 10:15:18 INFO - TEST-INFO took 744ms
[task 2019-11-01T10:15:18.322Z] 10:15:18 INFO - PID 2284 | 1572603318308 Marionette INFO Stopped listening on port 50208
[task 2019-11-01T10:15:19.015Z] 10:15:19 INFO - Browser exited with return code 0
[task 2019-11-01T10:15:19.015Z] 10:15:19 INFO - PROCESS LEAKS None
[task 2019-11-01T10:15:19.020Z] 10:15:19 INFO - Closing logging queue
[task 2019-11-01T10:15:19.020Z] 10:15:19 INFO - queue closed
[task 2019-11-01T10:15:19.040Z] 10:15:19 INFO - Setting up ssl
[task 2019-11-01T10:15:19.120Z] 10:15:19 INFO - certutil |
[task 2019-11-01T10:15:19.161Z] 10:15:19 INFO - certutil |
[task 2019-11-01T10:15:19.170Z] 10:15:19 INFO - certutil |
[task 2019-11-01T10:15:19.170Z] 10:15:19 INFO - Certificate Nickname Trust Attributes
[task 2019-11-01T10:15:19.170Z] 10:15:19 INFO - SSL,S/MIME,JAR/XPI
[task 2019-11-01T10:15:19.170Z] 10:15:19 INFO -
[task 2019-11-01T10:15:19.170Z] 10:15:19 INFO - web-platform-tests CT,,
[task 2019-11-01T10:15:19.170Z] 10:15:19 INFO -
Comment 12•6 years ago
|
||
I'd love to diagnose this rather than try to wallpaper over it - is there a way I can capture the contents of the error that fired?
Comment 13•6 years ago
|
||
I'll abandon my patch then in the hope of getting this fixed and not swept under the wpt metada update.
Updated•6 years ago
|
Comment hidden (Intermittent Failures Robot) |
Comment 15•6 years ago
|
||
(In reply to Mike Conley (:mconley) (:⚙️) (Wayyyy behind on needinfos) from comment #12)
I'd love to diagnose this rather than try to wallpaper over it - is there a way I can capture the contents of the error that fired?
Mike since this reached the disabling queue, should we disable it until you have a fix?
Comment hidden (Intermittent Failures Robot) |
Comment 17•6 years ago
|
||
I'd love to diagnose this rather than try to wallpaper over it - is there a way I can capture the contents of the error that fired?
AFAICT from the log the problem is that an error didn't fire. It could be that the test is assuming the error will fire in some sepcific time interval and we aren't consistently hitting that limit? Indeed [1] looks suspiciously like a 100ms timeout, which is very short.
Comment hidden (Intermittent Failures Robot) |
Comment 19•6 years ago
|
||
(In reply to James Graham [:jgraham] from comment #17)
AFAICT from the log the problem is that an error didn't fire. It could be that the test is assuming the error will fire in some sepcific time interval and we aren't consistently hitting that limit? Indeed [1] looks suspiciously like a 100ms timeout, which is very short.
Hm, good catch, yeah - this looks like we expect an error, and we give 100ms for it to show up? Any thoughts on what we should do about this?
Comment hidden (Intermittent Failures Robot) |
Updated•6 years ago
|
Comment hidden (Intermittent Failures Robot) |
Comment 22•6 years ago
|
||
Geoff do we disable until a fix is ready or wait for the fix?
![]() |
||
Comment 23•6 years ago
|
||
In light of comment 12 and the recent discussion here, let's leave it up to mconley.
:mconley - Be aware that this is failing very frequently and is well above the disable-recommended threshold. Failures are all on osx; we would only disable on osx.
Comment 24•6 years ago
|
||
I'm not the right person to make this call, since at least according to comment 17, this might be a case of a test being too sensitive to underlying timing issues. I think we should wait for jgraham to respond here.
Updated•6 years ago
|
Updated•6 years ago
|
Comment 25•6 years ago
|
||
Updated the patch in case we want to disable the test on mac.
Comment hidden (Intermittent Failures Robot) |
Comment 27•6 years ago
|
||
Comment hidden (Intermittent Failures Robot) |
Updated•6 years ago
|
Comment 29•6 years ago
|
||
bugherder |
Comment hidden (Intermittent Failures Robot) |
Updated•6 years ago
|
Comment 31•6 years ago
|
||
I (finally) did a try push of this with the timeout increased to 1s, and it was still intermittent, so I think there's something more subtle going on.
Comment hidden (Intermittent Failures Robot) |
Updated•4 years ago
|
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Updated•3 years ago
|
Comment 44•10 months ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.
Updated•10 months ago
|
Description
•