Filed by: ccozmuta [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=364972640&repo=try
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/alyKzL26Se6tEW3eGlPALg/runs/0/artifacts/public/logs/live_backing.log
[task 2022-01-21T13:52:08.240Z] 13:52:08 INFO - TEST-START | dom/media/test/test_mediatrack_consuming_mediastream.html
[task 2022-01-21T13:52:08.625Z] 13:52:08 INFO - GECKO(9220) | MEMORY STAT | vsize 20974922MB | residentFast 937MB
[task 2022-01-21T13:52:08.786Z] 13:52:08 INFO - GECKO(9220) | (firefox:9220): Gdk-ERROR **: 13:52:08.785: The program 'firefox' received an X Window System error.
[task 2022-01-21T13:52:08.792Z] 13:52:08 INFO - GECKO(9220) | This probably reflects a bug in the program.
[task 2022-01-21T13:52:08.793Z] 13:52:08 INFO - GECKO(9220) | The error was 'BadDrawable (invalid Pixmap or Window parameter)'.
[task 2022-01-21T13:52:08.795Z] 13:52:08 INFO - GECKO(9220) | (Details: serial 7520 error_code 9 request_code 55 (core protocol) minor_code 0)
[task 2022-01-21T13:52:08.796Z] 13:52:08 INFO - GECKO(9220) | (Note to programmers: normally, X errors are reported asynchronously;
[task 2022-01-21T13:52:08.797Z] 13:52:08 INFO - GECKO(9220) | that is, you will receive the error a while after causing it.
[task 2022-01-21T13:52:08.798Z] 13:52:08 INFO - GECKO(9220) | To debug your program, run it with the GDK_SYNCHRONIZE environment
[task 2022-01-21T13:52:08.799Z] 13:52:08 INFO - GECKO(9220) | variable to change this behavior. You can then get a meaningful
[task 2022-01-21T13:52:08.800Z] 13:52:08 INFO - GECKO(9220) | backtrace from your debugger if you break on the gdk_x_error() function.)
[task 2022-01-21T13:52:08.847Z] 13:52:08 INFO - GECKO(9220) | Exiting due to channel error.
[task 2022-01-21T13:52:08.849Z] 13:52:08 INFO - GECKO(9220) | Exiting due to channel error.
[task 2022-01-21T13:52:08.872Z] 13:52:08 INFO - GECKO(9220) | Exiting due to channel error.
[task 2022-01-21T13:52:08.888Z] 13:52:08 INFO - GECKO(9220) | Exiting due to channel error.
[task 2022-01-21T13:52:08.890Z] 13:52:08 INFO - GECKO(9220) | Exiting due to channel error.
[task 2022-01-21T13:52:08.891Z] 13:52:08 INFO - GECKO(9220) | Exiting due to channel error.
[task 2022-01-21T13:52:09.008Z] 13:52:09 INFO - TEST-INFO | Main app process: killed by SIGTRAP
[task 2022-01-21T13:52:09.010Z] 13:52:09 INFO - Buffered messages logged at 13:52:08
[task 2022-01-21T13:52:09.011Z] 13:52:09 INFO - TEST-PASS | dom/media/test/test_mediatrack_consuming_mediastream.html | A valid string reason is expected
[task 2022-01-21T13:52:09.012Z] 13:52:09 INFO - TEST-PASS | dom/media/test/test_mediatrack_consuming_mediastream.html | Reason cannot be empty
[task 2022-01-21T13:52:09.013Z] 13:52:09 INFO - TEST-PASS | dom/media/test/test_mediatrack_consuming_mediastream.html | Calls of onaddtrack on audioTracks should be 1.
[task 2022-01-21T13:52:09.014Z] 13:52:09 INFO - TEST-PASS | dom/media/test/test_mediatrack_consuming_mediastream.html | The length of audioTracks should be 1.
[task 2022-01-21T13:52:09.015Z] 13:52:09 INFO - TEST-PASS | dom/media/test/test_mediatrack_consuming_mediastream.html | Audio track should be enabled as default.
[task 2022-01-21T13:52:09.016Z] 13:52:09 INFO - TEST-PASS | dom/media/test/test_mediatrack_consuming_mediastream.html | Calls of onaddtrack on videoTracks should be 1.
[task 2022-01-21T13:52:09.016Z] 13:52:09 INFO - TEST-PASS | dom/media/test/test_mediatrack_consuming_mediastream.html | The length of videoTracks should be 1.
[task 2022-01-21T13:52:09.017Z] 13:52:09 INFO - TEST-PASS | dom/media/test/test_mediatrack_consuming_mediastream.html | The first video track is set selected as default.
[task 2022-01-21T13:52:09.018Z] 13:52:09 INFO - TEST-PASS | dom/media/test/test_mediatrack_consuming_mediastream.html | Calls of onchange on audioTracks should be 1
[task 2022-01-21T13:52:09.019Z] 13:52:09 INFO - TEST-PASS | dom/media/test/test_mediatrack_consuming_mediastream.html | Enabled value of the audio track should be false
[task 2022-01-21T13:52:09.020Z] 13:52:09 INFO - TEST-PASS | dom/media/test/test_mediatrack_consuming_mediastream.html | Calls of onchange on videoTracks should be 1
[task 2022-01-21T13:52:09.021Z] 13:52:09 INFO - TEST-PASS | dom/media/test/test_mediatrack_consuming_mediastream.html | Selected value of the video track should be false
[task 2022-01-21T13:52:09.022Z] 13:52:09 INFO - TEST-PASS | dom/media/test/test_mediatrack_consuming_mediastream.html | SelectedIndex of video tracks should be -1
[task 2022-01-21T13:52:09.023Z] 13:52:09 INFO - TEST-PASS | dom/media/test/test_mediatrack_consuming_mediastream.html | Calls of onchange on audioTracks should be 2
[task 2022-01-21T13:52:09.023Z] 13:52:09 INFO - TEST-PASS | dom/media/test/test_mediatrack_consuming_mediastream.html | Enabled value of the audio track should be true
[task 2022-01-21T13:52:09.025Z] 13:52:09 INFO - TEST-PASS | dom/media/test/test_mediatrack_consuming_mediastream.html | Calls of onchange on videoTracks should be 2
[task 2022-01-21T13:52:09.026Z] 13:52:09 INFO - TEST-PASS | dom/media/test/test_mediatrack_consuming_mediastream.html | Selected value of the video track should be true
[task 2022-01-21T13:52:09.027Z] 13:52:09 INFO - TEST-PASS | dom/media/test/test_mediatrack_consuming_mediastream.html | SelectedIndex of video tracks should be 0
[task 2022-01-21T13:52:09.028Z] 13:52:09 INFO - TEST-PASS | dom/media/test/test_mediatrack_consuming_mediastream.html | Event ended is expected to be fired on element.
[task 2022-01-21T13:52:09.029Z] 13:52:09 INFO - TEST-PASS | dom/media/test/test_mediatrack_consuming_mediastream.html | The length of audioTracks should be 0.
[task 2022-01-21T13:52:09.030Z] 13:52:09 INFO - TEST-PASS | dom/media/test/test_mediatrack_consuming_mediastream.html | The length of videoTracks should be 0.
[task 2022-01-21T13:52:09.031Z] 13:52:09 INFO - Buffered messages finished
[task 2022-01-21T13:52:09.032Z] 13:52:09 ERROR - TEST-UNEXPECTED-FAIL | dom/media/test/test_mediatrack_consuming_mediastream.html | application terminated with exit code -5
[task 2022-01-21T13:52:09.033Z] 13:52:09 INFO - runtests.py | Application ran for: 0:03:54.831171
[task 2022-01-21T13:52:09.033Z] 13:52:09 INFO - zombiecheck | Reading PID log: /tmp/tmp9xcdvq8wpidlog
[task 2022-01-21T13:52:09.034Z] 13:52:09 INFO - ==> process 9220 launched child process 9238
[task 2022-01-21T13:52:09.035Z] 13:52:09 INFO - ==> process 9220 launched child process 9287
[task 2022-01-21T13:52:09.036Z] 13:52:09 INFO - ==> process 9220 launched child process 9316
[task 2022-01-21T13:52:09.043Z] 13:52:09 INFO - ==> process 9220 launched child process 9344
[task 2022-01-21T13:52:09.044Z] 13:52:09 INFO - ==> process 9220 launched child process 9373
<...>
task 2022-01-21T13:52:19.928Z] 13:52:19 INFO - GECKO(10224) | 1642773139927 Marionette DEBUG 1 -> [0,3,"Addon:Install",{"path":"/tmp/tmp0_oslqno.zip","temporary":false}]
[task 2022-01-21T13:52:19.996Z] 13:52:19 INFO - GECKO(10224) | 1642773139994 Marionette DEBUG 1 <- [1,3,null,{"value":"mochikit@mozilla.org"}]
[task 2022-01-21T13:52:19.999Z] 13:52:19 INFO - GECKO(10224) | 1642773139998 Marionette DEBUG 1 -> [0,4,"Marionette:GetContext",{}]
[task 2022-01-21T13:52:20.001Z] 13:52:20 INFO - GECKO(10224) | 1642773140000 Marionette DEBUG 1 <- [1,4,null,{"value":"content"}]
[task 2022-01-21T13:52:20.007Z] 13:52:20 INFO - GECKO(10224) | 1642773140006 Marionette DEBUG 1 -> [0,5,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-01-21T13:52:20.008Z] 13:52:20 INFO - GECKO(10224) | 1642773140007 Marionette DEBUG 1 <- [1,5,null,{"value":null}]
[task 2022-01-21T13:52:20.025Z] 13:52:20 INFO - GECKO(10224) | 1642773140024 Marionette DEBUG 1 -> [0,6,"WebDriver:ExecuteScript",{"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, ... ry=%2Ftmp&cleanupCrashes=true"}],"newSandbox":true,"sandbox":"default","line":1945,"filename":"tests/mochitest/runtests.py"}]
[task 2022-01-21T13:52:20.041Z] 13:52:20 INFO - GECKO(10224) | 1642773140040 Marionette TRACE [7] MarionetteCommands actor created for window id 2
[task 2022-01-21T13:52:20.091Z] 13:52:20 INFO - GECKO(10224) | 1642773140089 Marionette DEBUG 1 <- [1,6,null,{"value":null}]
[task 2022-01-21T13:52:20.107Z] 13:52:20 INFO - GECKO(10224) | 1642773140105 Marionette DEBUG 1 -> [0,7,"Marionette:SetContext",{"value":"content"}]
[task 2022-01-21T13:52:20.108Z] 13:52:20 INFO - GECKO(10224) | 1642773140107 Marionette DEBUG 1 <- [1,7,null,{"value":null}]
[task 2022-01-21T13:52:20.127Z] 13:52:20 INFO - GECKO(10224) | 1642773140126 Marionette DEBUG 1 -> [0,8,"WebDriver:DeleteSession",{}]
[task 2022-01-21T13:52:20.136Z] 13:52:20 INFO - GECKO(10224) | 1642773140135 Marionette DEBUG 1 <- [1,8,null,{"value":null}]
[task 2022-01-21T13:52:20.141Z] 13:52:20 INFO - runtests.py | Waiting for browser...
[task 2022-01-21T13:52:20.148Z] 13:52:20 INFO - GECKO(10224) | 1642773140144 Marionette DEBUG Closed connection 1
[task 2022-01-21T13:52:21.376Z] 13:52:21 INFO - TEST-START | dom/media/webspeech/synth/test/test_bfcache.html
Description
•