1756516 - Intermittent dom/media/webrtc/tests/mochitests/test_getUserMedia_mediaStreamConstructors.html | application terminated with exit code -5

Status: RESOLVED INCOMPLETE

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

Description

[Treeherder Bug Filer]

Filed by: abutkovits [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=368652155&repo=mozilla-beta
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/e4yTNRpQT2q8Zui_Ro8JIA/runs/0/artifacts/public/logs/live_backing.log

---

[task 2022-02-21T20:21:15.168Z] 20:21:15     INFO - TEST-PASS | dom/media/webrtc/tests/mochitests/test_getUserMedia_mediaStreamConstructors.html | stream with stopped tracks should be inactive 
[task 2022-02-21T20:21:15.168Z] 20:21:15     INFO - Call getUserMedia for {"video":true}
[task 2022-02-21T20:21:15.169Z] 20:21:15     INFO - Buffered messages finished
[task 2022-02-21T20:21:15.169Z] 20:21:15    ERROR - TEST-UNEXPECTED-FAIL | dom/media/webrtc/tests/mochitests/test_getUserMedia_mediaStreamConstructors.html | application terminated with exit code -5
[task 2022-02-21T20:21:15.170Z] 20:21:15     INFO - runtests.py | Application ran for: 0:02:31.363266
[task 2022-02-21T20:21:15.170Z] 20:21:15     INFO - zombiecheck | Reading PID log: /tmp/tmpu39a_wsxpidlog
[task 2022-02-21T20:21:15.171Z] 20:21:15     INFO - ==> process 6642 launched child process 6660
[task 2022-02-21T20:21:15.171Z] 20:21:15     INFO - ==> process 6642 launched child process 6711
[task 2022-02-21T20:21:15.172Z] 20:21:15     INFO - ==> process 6642 launched child process 6739
[task 2022-02-21T20:21:15.172Z] 20:21:15     INFO - ==> process 6642 launched child process 6741
[task 2022-02-21T20:21:15.173Z] 20:21:15     INFO - ==> process 6642 launched child process 6784
[task 2022-02-21T20:21:15.173Z] 20:21:15     INFO - ==> process 6642 launched child process 6822
[task 2022-02-21T20:21:15.174Z] 20:21:15     INFO - ==> process 6642 launched child process 6824
[task 2022-02-21T20:21:15.174Z] 20:21:15     INFO - ==> process 6642 launched child process 6881
[task 2022-02-21T20:21:15.174Z] 20:21:15     INFO - ==> process 6642 launched child process 7245
[task 2022-02-21T20:21:15.175Z] 20:21:15     INFO - zombiecheck | Checking for orphan process with PID: 6784
[task 2022-02-21T20:21:15.176Z] 20:21:15     INFO - zombiecheck | Checking for orphan process with PID: 6881
[task 2022-02-21T20:21:15.181Z] 20:21:15     INFO - zombiecheck | Checking for orphan process with PID: 6660
[task 2022-02-21T20:21:15.181Z] 20:21:15     INFO - zombiecheck | Checking for orphan process with PID: 6822
[task 2022-02-21T20:21:15.181Z] 20:21:15     INFO - zombiecheck | Checking for orphan process with PID: 6824
[task 2022-02-21T20:21:15.181Z] 20:21:15     INFO - zombiecheck | Checking for orphan process with PID: 7245
[task 2022-02-21T20:21:15.181Z] 20:21:15     INFO - zombiecheck | Checking for orphan process with PID: 6739
[task 2022-02-21T20:21:15.181Z] 20:21:15     INFO - zombiecheck | Checking for orphan process with PID: 6741
[task 2022-02-21T20:21:15.181Z] 20:21:15     INFO - zombiecheck | Checking for orphan process with PID: 6711
[task 2022-02-21T20:21:15.181Z] 20:21:15     INFO - Stopping web server
[task 2022-02-21T20:21:15.181Z] 20:21:15     INFO - Server shut down.
[task 2022-02-21T20:21:15.181Z] 20:21:15     INFO - Web server killed.
[task 2022-02-21T20:21:15.181Z] 20:21:15     INFO - Stopping web socket server
[task 2022-02-21T20:21:15.181Z] 20:21:15     INFO - Stopping ssltunnel
[task 2022-02-21T20:21:15.198Z] 20:21:15     INFO -  websocket/process bridge listening on port 8191
[task 2022-02-21T20:21:15.259Z] 20:21:15     INFO - Stopping websocket/process bridge
[task 2022-02-21T20:21:15.260Z] 20:21:15  WARNING - leakcheck | refcount logging is off, so leaks can't be detected!
[task 2022-02-21T20:21:15.261Z] 20:21:15     INFO - runtests.py | Running tests: end.
[task 2022-02-21T20:21:15.286Z] 20:21:15     INFO - Buffered messages finished
[task 2022-02-21T20:21:15.287Z] 20:21:15     INFO - Running manifest: dom/media/webspeech/recognition/test/mochitest.ini
[task 2022-02-21T20:21:15.306Z] 20:21:15     INFO -  Setting pipeline to PAUSED ...
[task 2022-02-21T20:21:15.306Z] 20:21:15     INFO -  Pipeline is PREROLLING ...
[task 2022-02-21T20:21:15.308Z] 20:21:15     INFO -  Pipeline is PREROLLED ...
[task 2022-02-21T20:21:15.309Z] 20:21:15     INFO -  Setting pipeline to PLAYING ...
[task 2022-02-21T20:21:15.309Z] 20:21:15     INFO -  New clock: GstSystemClock
[task 2022-02-21T20:21:15.342Z] 20:21:15     INFO -  Got EOS from element "pipeline0".
[task 2022-02-21T20:21:15.343Z] 20:21:15     INFO -  Execution ended after 0:00:00.033345838
[task 2022-02-21T20:21:15.344Z] 20:21:15     INFO -  Setting pipeline to PAUSED ...
[task 2022-02-21T20:21:15.344Z] 20:21:15     INFO -  Setting pipeline to READY ...
[task 2022-02-21T20:21:15.345Z] 20:21:15     INFO -  (gst-launch-1.0:7567): GStreamer-CRITICAL **: 20:21:15.342: gst_object_unref: assertion '((GObject *) object)->ref_count > 0' failed
[task 2022-02-21T20:21:15.345Z] 20:21:15     INFO -  Setting pipeline to NULL ...
[task 2022-02-21T20:21:15.346Z] 20:21:15     INFO -  Freeing pipeline ...
[task 2022-02-21T20:21:15.373Z] 20:21:15     INFO - INFO | runtests.py | ASan using symbolizer at /builds/worker/workspace/build/application/firefox/llvm-symbolizer
[task 2022-02-21T20:21:15.377Z] 20:21:15     INFO - INFO | runtests.py | ASan running in default memory configuration
[task 2022-02-21T20:21:15.378Z] 20:21:15     INFO - UBSan enabled.
[task 2022-02-21T20:21:15.592Z] 20:21:15     INFO - PID 7579 | pk12util: PKCS12 IMPORT SUCCESSFUL
[task 2022-02-21T20:21:15.751Z] 20:21:15     INFO - INFO | runtests.py | ASan using symbolizer at /builds/worker/workspace/build/application/firefox/llvm-symbolizer
[task 2022-02-21T20:21:15.756Z] 20:21:15     INFO - LSan enabled.
[task 2022-02-21T20:21:15.756Z] 20:21:15     INFO - INFO | runtests.py | ASan running in default memory configuration
[task 2022-02-21T20:21:15.756Z] 20:21:15     INFO - UBSan enabled.
[task 2022-02-21T20:21:15.757Z] 20:21:15     INFO - INFO | runtests.py | ASan using symbolizer at /builds/worker/workspace/build/application/firefox/llvm-symbolizer
[task 2022-02-21T20:21:15.760Z] 20:21:15     INFO - INFO | runtests.py | ASan running in default memory configuration
[task 2022-02-21T20:21:15.760Z] 20:21:15     INFO - UBSan enabled.
[task 2022-02-21T20:21:15.772Z] 20:21:15     INFO - MochitestServer : launching ['/builds/worker/workspace/build/tests/bin/xpcshell', '-g', '/builds/worker/workspace/build/application/firefox', '-f', '/builds/worker/workspace/build/tests/bin/components/httpd.js', '-e', "const _PROFILE_PATH = '/tmp/tmpg3xcv4mn.mozrunner'; const _SERVER_PORT = '8888'; const _SERVER_ADDR = '127.0.0.1'; const _TEST_PREFIX = undefined; const _DISPLAY_RESULTS = false;", '-f', '/builds/worker/workspace/build/tests/mochitest/server.js']
[task 2022-02-21T20:21:15.772Z] 20:21:15     INFO - runtests.py | Server pid: 7592
[task 2022-02-21T20:21:15.792Z] 20:21:15     INFO - runtests.py | Websocket server pid: 7595
[task 2022-02-21T20:21:15.822Z] 20:21:15     INFO - runtests.py | websocket/process bridge pid: 7599
[task 2022-02-21T20:21:16.427Z] 20:21:16     INFO - INFO | runtests.py | ASan using symbolizer at /builds/worker/workspace/build/application/firefox/llvm-symbolizer
[task 2022-02-21T20:21:16.431Z] 20:21:16     INFO - INFO | runtests.py | ASan running in default memory configuration
[task 2022-02-21T20:21:16.432Z] 20:21:16     INFO - UBSan enabled.
[task 2022-02-21T20:21:16.436Z] 20:21:16     INFO - runtests.py | SSL tunnel pid: 7614
[task 2022-02-21T20:21:16.437Z] 20:21:16     INFO - runtests.py | Running with scheme: http
[task 2022-02-21T20:21:16.438Z] 20:21:16     INFO - runtests.py | Running with e10s: True
[task 2022-02-21T20:21:16.438Z] 20:21:16     INFO - runtests.py | Running with fission: True
[task 2022-02-21T20:21:16.439Z] 20:21:16     INFO - runtests.py | Running with cross-origin iframes: False
[task 2022-02-21T20:21:16.440Z] 20:21:16     INFO - runtests.py | Running with serviceworker_e10s: True
[task 2022-02-21T20:21:16.440Z] 20:21:16     INFO - runtests.py | Running with socketprocess_e10s: False
[task 2022-02-21T20:21:16.442Z] 20:21:16     INFO - runtests.py | Running tests: start.
[task 2022-02-21T20:21:16.442Z] 20:21:16     INFO - 
[task 2022-02-21T20:21:16.466Z] 20:21:16     INFO - Application command: /builds/worker/workspace/build/application/firefox/firefox -marionette -foreground -profile /tmp/tmpg3xcv4mn.mozrunner
[task 2022-02-21T20:21:16.471Z] 20:21:16     INFO - runtests.py | Application pid: 7622
[task 2022-02-21T20:21:16.472Z] 20:21:16     INFO - TEST-INFO | started process GECKO(7622)
[task 2022-02-21T20:21:17.676Z] 20:21:17     INFO - GECKO(7622) | 1645474877675	Marionette	INFO	Marionette enabled
[task 2022-02-21T20:21:17.867Z] 20:21:17     INFO - GECKO(7622) | 1645474877865	Marionette	TRACE	Received observer notification toplevel-window-ready
[task 2022-02-21T20:21:23.609Z] 20:21:23     INFO - GECKO(7622) | console.warn: SearchSettings: "get: No settings file exists, new profile?" (new NotFoundError("Could not open the file at /tmp/tmpg3xcv4mn.mozrunner/search.json.mozlz4", (void 0)))
[task 2022-02-21T20:21:26.166Z] 20:21:26     INFO - GECKO(7622) | 1645474886165	Marionette	TRACE	Received observer notification marionette-startup-requested
[task 2022-02-21T20:21:26.168Z] 20:21:26     INFO - GECKO(7622) | 1645474886165	Marionette	TRACE	Waiting until startup recorder finished recording startup scripts...
[task 2022-02-21T20:21:26.206Z] 20:21:26     INFO - GECKO(7622) | 1645474886205	Marionette	TRACE	All scripts recorded.
[task 2022-02-21T20:21:26.212Z] 20:21:26     INFO - GECKO(7622) | 1645474886211	Marionette	INFO	Listening on port 2828
[task 2022-02-21T20:21:26.214Z] 20:21:26     INFO - GECKO(7622) | 1645474886212	Marionette	DEBUG	Marionette is listening
[task 2022-02-21T20:21:26.365Z] 20:21:26     INFO - GECKO(7622) | 1645474886364	Marionette	DEBUG	Accepted connection 0 from 127.0.0.1:55708
[task 2022-02-21T20:21:26.376Z] 20:21:26     INFO - GECKO(7622) | 1645474886375	Marionette	DEBUG	Accepted connection 1 from 127.0.0.1:55710
[task 2022-02-21T20:21:26.379Z] 20:21:26     INFO - GECKO(7622) | 1645474886378	Marionette	DEBUG	Closed connection 0
[task 2022-02-21T20:21:26.402Z] 20:21:26     INFO - GECKO(7622) | 1645474886401	Marionette	DEBUG	1 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2022-02-21T20:21:26.441Z] 20:21:26     INFO - GECKO(7622) | 1645474886440	RemoteAgent	TRACE	[19] Document already finished loading: about:blank
[task 2022-02-21T20:21:26.457Z] 20:21:26     INFO - GECKO(7622) | 1645474886455	Marionette	DEBUG	1 <- [1,1,null,{"sessionId":"3bd0c77b-4a42-414b-8ee9-3c42ffb41120","capabilities":{"browserName":"firefox","browserVersion":"98.0" ... .mozrunner","moz:shutdownTimeout":300000,"moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true,"proxy":{}}}]
[task 2022-02-21T20:21:26.486Z] 20:21:26     INFO - GECKO(7622) | 1645474886485	Marionette	DEBUG	1 -> [0,2,"Addon:Install",{"path":"/tmp/tmpozsl92da.zip","temporary":false}]
[task 2022-02-21T20:21:26.835Z] 20:21:26     INFO - GECKO(7622) | 1645474886834	Marionette	DEBUG	1 <- [1,2,null,{"value":"[e-mail]"}]
[task 2022-02-21T20:21:26.861Z] 20:21:26     INFO - GECKO(7622) | 1645474886859	Marionette	DEBUG	1 -> [0,3,"Addon:Install",{"path":"/tmp/tmpjr5ah05r.zip","temporary":false}]
[task 2022-02-21T20:21:26.908Z] 20:21:26     INFO - GECKO(7622) | 1645474886907	Marionette	DEBUG	1 <- [1,3,null,{"value":"[e-mail]"}]
[task 2022-02-21T20:21:26.911Z] 20:21:26     INFO - GECKO(7622) | 1645474886910	Marionette	DEBUG	1 -> [0,4,"Marionette:GetContext",{}]
[task 2022-02-21T20:21:26.913Z] 20:21:26     INFO - GECKO(7622) | 1645474886911	Marionette	DEBUG	1 <- [1,4,null,{"value":"content"}]
[task 2022-02-21T20:21:26.915Z] 20:21:26     INFO - GECKO(7622) | 1645474886914	Marionette	DEBUG	1 -> [0,5,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-02-21T20:21:26.917Z] 20:21:26     INFO - GECKO(7622) | 1645474886915	Marionette	DEBUG	1 <- [1,5,null,{"value":null}]
[task 2022-02-21T20:21:26.923Z] 20:21:26     INFO - GECKO(7622) | 1645474886922	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-02-21T20:21:26.933Z] 20:21:26     INFO - GECKO(7622) | 1645474886932	Marionette	TRACE	[7] MarionetteCommands actor created for window id 2
[task 2022-02-21T20:21:26.948Z] 20:21:26     INFO - GECKO(7622) | 1645474886947	Marionette	DEBUG	1 <- [1,6,null,{"value":null}]
[task 2022-02-21T20:21:26.987Z] 20:21:26     INFO - GECKO(7622) | 1645474886986	Marionette	DEBUG	1 -> [0,7,"Marionette:SetContext",{"value":"content"}]
[task 2022-02-21T20:21:26.991Z] 20:21:26     INFO - GECKO(7622) | 1645474886987	Marionette	DEBUG	1 <- [1,7,null,{"value":null}]
[task 2022-02-21T20:21:27.039Z] 20:21:27     INFO - GECKO(7622) | 1645474887038	Marionette	TRACE	Remoteness change detected. Set new top-level browsing context to 48
[task 2022-02-21T20:21:27.217Z] 20:21:27     INFO - GECKO(7622) | 1645474887216	Marionette	DEBUG	1 -> [0,8,"WebDriver:DeleteSession",{}]
[task 2022-02-21T20:21:27.228Z] 20:21:27     INFO - GECKO(7622) | 1645474887226	Marionette	DEBUG	1 <- [1,8,null,{"value":null}]
[task 2022-02-21T20:21:27.252Z] 20:21:27     INFO - runtests.py | Waiting for browser...
[task 2022-02-21T20:21:27.260Z] 20:21:27     INFO - GECKO(7622) | 1645474887259	Marionette	DEBUG	Closed connection 1

Comment 1

[Intermittent Failures Robot]

1 failures in 2992 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-beta: 1

Platform and build breakdown:

• linux1804-64-asan-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1756516&startday=2022-02-21&endday=2022-02-27&tree=all

Comment 2

[BugBot [:suhaib / :marco/ :calixte]]

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

Comment 3

[Treeherder Bug Filer]

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=372960491&repo=try

Comment 4

[Intermittent Failures Robot]

1 failures in 3323 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• try: 1

Platform and build breakdown:

• linux1804-64-asan-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1756516&startday=2022-03-28&endday=2022-04-03&tree=all

Comment 5

[Intermittent Failures Robot]

2 failures in 2948 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• try: 1
• mozilla-beta: 1

Platform and build breakdown:

• linux1804-64-asan-qr: 2
  • opt: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1756516&startday=2022-04-11&endday=2022-04-17&tree=all

Comment 6

[Intermittent Failures Robot]

1 failures in 3540 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• try: 1

Platform and build breakdown:

• linux1804-64-asan-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1756516&startday=2022-05-02&endday=2022-05-08&tree=all

Comment 7

[Intermittent Failures Robot]

1 failures in 2624 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-release: 1

Platform and build breakdown:

• linux1804-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1756516&startday=2022-05-23&endday=2022-05-29&tree=all

Comment 8

[BugBot [:suhaib / :marco/ :calixte]]

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