Closed Bug 1637824 Opened 4 years ago Closed 4 years ago

Intermittent dom/media/tests/mochitest/test_getUserMedia_basicAudio_loopback.html | Error executing test: Error: Audio analysis timed out waitForAnalysisSuccess@https://example.com/tests/dom/media/tests/mochitest/head.js:203:26

Categories

(Core :: WebRTC, defect, P5)

Product:
Core
Component:
WebRTC
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: intermittent-failure)

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

[task 2020-05-13T23:48:06.539Z] 23:48:06 INFO - TEST-START | dom/media/tests/mochitest/test_getUserMedia_basicAudio_loopback.html
[task 2020-05-13T23:48:06.640Z] 23:48:06 INFO - GECKO(3930) | TEST DEVICES: Got loopback audio: Monitor of Null Output
[task 2020-05-13T23:48:06.640Z] 23:48:06 INFO - GECKO(3930) | TEST DEVICES: Got loopback video: Dummy video device (0x0000)
[task 2020-05-13T23:48:06.662Z] 23:48:06 INFO - GECKO(3930) | TEST DEVICES: Got loopback audio: Monitor of Null Output
[task 2020-05-13T23:48:06.663Z] 23:48:06 INFO - GECKO(3930) | TEST DEVICES: Got loopback video: Dummy video device (0x0000)
[task 2020-05-13T23:48:06.849Z] 23:48:06 INFO - GECKO(3930) | [Parent 3930, Main Thread] WARNING: gtk_widget_get_window: assertion 'GTK_IS_WIDGET (widget)' failed: 'glib warning', file /builds/worker/checkouts/gecko/toolkit/xre/nsSigHandlers.cpp, line 135
[task 2020-05-13T23:48:06.849Z] 23:48:06 INFO - GECKO(3930) | (firefox:3930): Gtk-CRITICAL **: 23:48:06.841: gtk_widget_get_window: assertion 'GTK_IS_WIDGET (widget)' failed
[task 2020-05-13T23:48:06.865Z] 23:48:06 INFO - GECKO(3930) | [Parent 3930, Main Thread] WARNING: gtk_widget_get_window: assertion 'GTK_IS_WIDGET (widget)' failed: 'glib warning', file /builds/worker/checkouts/gecko/toolkit/xre/nsSigHandlers.cpp, line 135
[task 2020-05-13T23:48:06.866Z] 23:48:06 INFO - GECKO(3930) | (firefox:3930): Gtk-CRITICAL **: 23:48:06.861: gtk_widget_get_window: assertion 'GTK_IS_WIDGET (widget)' failed
[task 2020-05-13T23:48:06.953Z] 23:48:06 INFO - GECKO(3930) | [Child 4051: Socket Thread]: D/DataChannel Deleting DataChannelConnection 0x7fab4883e800
[task 2020-05-13T23:48:06.954Z] 23:48:06 INFO - GECKO(3930) | [Child 4051: Socket Thread]: D/DataChannel Deleting DataChannelConnection 0x7fab5510e400
[task 2020-05-13T23:49:06.803Z] 23:49:06 INFO - TEST-INFO | started process screentopng
[task 2020-05-13T23:49:07.405Z] 23:49:07 INFO - TEST-INFO | screentopng: exit 0
[task 2020-05-13T23:49:07.406Z] 23:49:07 INFO - <snipped 841 output lines - if you need more context, please use SimpleTest.requestCompleteLog() in your test>
[task 2020-05-13T23:49:07.406Z] 23:49:07 INFO - Buffered messages logged at 23:49:00
[task 2020-05-13T23:49:07.406Z] 23:49:07 INFO - Analysing audio frequency - low:target:high = 0:0:0
[task 2020-05-13T23:49:07.407Z] 23:49:07 INFO - Analysing audio frequency - low:target:high = 0:0:0
[task 2020-05-13T23:49:07.407Z] 23:49:07 INFO - Analysing audio frequency - low:target:high = 0:0:0
[task 2020-05-13T23:49:07.407Z] 23:49:07 INFO - Analysing audio frequency - low:target:high = 0:0:0
[task 2020-05-13T23:49:07.407Z] 23:49:07 INFO - Analysing audio frequency - low:target:high = 0:0:0
[task 2020-05-13T23:49:07.407Z] 23:49:07 INFO - Analysing audio frequency - low:target:high = 0:0:0
[task 2020-05-13T23:49:07.407Z] 23:49:07 INFO - Analysing audio frequency - low:target:high = 0:0:0
[task 2020-05-13T23:49:07.407Z] 23:49:07 INFO - Analysing audio frequency - low:target:high = 0:0:0
[task 2020-05-13T23:49:07.407Z] 23:49:07 INFO - Analysing audio frequency - low:target:high = 0:0:0
[task 2020-05-13T23:49:07.407Z] 23:49:07 INFO - Analysing audio frequency - low:target:high = 0:0:0
[task 2020-05-13T23:49:07.495Z] 23:49:07 INFO - Buffered messages finished
[task 2020-05-13T23:49:07.495Z] 23:49:07 INFO - TEST-UNEXPECTED-FAIL | dom/media/tests/mochitest/test_getUserMedia_basicAudio_loopback.html | Error executing test: Error: Audio analysis timed out waitForAnalysisSuccess@https://example.com/tests/dom/media/tests/mochitest/head.js:203:26 ... @https://example.com/tests/dom/media/tests/mochitest/test_getUserMedia_basicAudio_loopback.html:34:20 ... asyncrunTestWhenReady/<@https://example.com/tests/dom/media/tests/mochitest/head.js:497:30 ... promise callbackrunTestWhenReady@https://example.com/tests/dom/media/tests/mochitest/head.js:497:6 ... @https://example.com/tests/dom/media/tests/mochitest/test_getUserMedia_basicAudio_loopback.html:18:43 ... promise callback*@https://example.com/tests/dom/media/tests/mochitest/test_getUserMedia_basicAudio_loopback.html:18:16 ...
[task 2020-05-13T23:49:07.497Z] 23:49:07 INFO - SimpleTest.ok@https://example.com/tests/SimpleTest/SimpleTest.js:299:16
[task 2020-05-13T23:49:07.498Z] 23:49:07 INFO - runTestWhenReady/<@https://example.com/tests/dom/media/tests/mochitest/head.js:499:9
[task 2020-05-13T23:49:07.498Z] 23:49:07 INFO - promise callbackrunTestWhenReady@https://example.com/tests/dom/media/tests/mochitest/head.js:498:6
[task 2020-05-13T23:49:07.499Z] 23:49:07 INFO - @https://example.com/tests/dom/media/tests/mochitest/test_getUserMedia_basicAudio_loopback.html:18:43
[task 2020-05-13T23:49:07.499Z] 23:49:07 INFO - promise callback@https://example.com/tests/dom/media/tests/mochitest/test_getUserMedia_basicAudio_loopback.html:18:16
[task 2020-05-13T23:49:07.500Z] 23:49:07 ERROR - [SimpleTest.finish()] this test already called finish!
[task 2020-05-13T23:49:07.500Z] 23:49:07 INFO - GECKO(3930) | MEMORY STAT | vsize 2729MB | residentFast 153MB | heapAllocated 16MB
[task 2020-05-13T23:49:07.501Z] 23:49:07 INFO - TEST-UNEXPECTED-ERROR | dom/media/tests/mochitest/test_getUserMedia_basicAudio_loopback.html | called finish() multiple times
[task 2020-05-13T23:49:07.501Z] 23:49:07 INFO - TEST-INFO took 60267ms

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.

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.