Intermittent TEST-UNEXPECTED-TIMEOUT | browser/base/content/test/webrtc/browser_devices_get_user_media_paused.js | application timed out after 370 seconds with no output
Categories
(Core :: WebRTC, defect, P5)
Tracking
()
People
(Reporter: intermittent-bug-filer, Unassigned)
References
Details
(Keywords: intermittent-failure)
Filed by: malexandru [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=334784980&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/HPVWpHS4S7GIcKyEHhr6Rw/runs/1/artifacts/public/logs/live_backing.log
Reftest URL: https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/HPVWpHS4S7GIcKyEHhr6Rw/runs/1/artifacts/public/logs/live_backing.log&only_show_unexpected=1
[task 2021-03-29T15:40:15.154Z] 15:40:15 INFO - TEST-PASS | browser/base/content/test/webrtc/browser_devices_get_user_media_paused.js | popup WebRTC indicator hidden -
[task 2021-03-29T15:40:15.191Z] 15:40:15 INFO - getUserMedia screen: disabling the stream shows the paused indicator
[task 2021-03-29T15:40:15.191Z] 15:40:15 INFO - requesting devices
[task 2021-03-29T15:40:17.541Z] 15:40:17 INFO - GECKO(13781) | [Child 13857: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7f1ec95c8c00 == 0 [pid = 13857] [id = 4] [url = about:blank]
[task 2021-03-29T15:40:21.615Z] 15:40:21 INFO - GECKO(13781) | [Child 13857: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (7f1ee5e63ac0) [pid = 13857] [serial = 11] [outer = 0] [url = about:blank]
[task 2021-03-29T15:40:22.273Z] 15:40:22 INFO - GECKO(13781) | [Child 14609: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (7fa320990000) [pid = 14609] [serial = 2] [outer = 0] [url = about:blank]
[task 2021-03-29T15:40:25.667Z] 15:40:25 INFO - GECKO(13781) | [Child 13857: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (7f1ec95ca400) [pid = 13857] [serial = 12] [outer = 0] [url = about:blank]
[task 2021-03-29T15:46:35.685Z] 15:46:35 INFO - Buffered messages logged at 15:40:09
[task 2021-03-29T15:46:35.686Z] 15:46:35 INFO - Entering test bound test
[task 2021-03-29T15:46:35.686Z] 15:46:35 INFO - Buffered messages finished
[task 2021-03-29T15:46:35.687Z] 15:46:35 ERROR - TEST-UNEXPECTED-TIMEOUT | browser/base/content/test/webrtc/browser_devices_get_user_media_paused.js | application timed out after 370 seconds with no output
[task 2021-03-29T15:46:35.687Z] 15:46:35 ERROR - Force-terminating active process(es).
[task 2021-03-29T15:46:35.688Z] 15:46:35 INFO - Determining child pids from psutil...
[task 2021-03-29T15:46:35.709Z] 15:46:35 INFO - [14414, 14495, 14609, 14707, 14809, 14897, 13857, 13879, 13911, 13917, 13920, 14009, 14053, 14058, 14218, 14312]
[task 2021-03-29T15:46:35.710Z] 15:46:35 INFO - ==> process 13781 launched child process 13798
[task 2021-03-29T15:46:35.711Z] 15:46:35 INFO - ==> process 13781 launched child process 13857
[task 2021-03-29T15:46:35.711Z] 15:46:35 INFO - ==> process 13781 launched child process 13879
[task 2021-03-29T15:46:35.712Z] 15:46:35 INFO - ==> process 13781 launched child process 13911
[task 2021-03-29T15:46:35.712Z] 15:46:35 INFO - ==> process 13781 launched child process 13917
[task 2021-03-29T15:46:35.713Z] 15:46:35 INFO - ==> process 13781 launched child process 13920
[task 2021-03-29T15:46:35.713Z] 15:46:35 INFO - ==> process 13781 launched child process 14009
[task 2021-03-29T15:46:35.713Z] 15:46:35 INFO - ==> process 13781 launched child process 14053
[task 2021-03-29T15:46:35.714Z] 15:46:35 INFO - ==> process 13781 launched child process 14058
[task 2021-03-29T15:46:35.714Z] 15:46:35 INFO - ==> process 13781 launched child process 14218
[task 2021-03-29T15:46:35.715Z] 15:46:35 INFO - ==> process 13781 launched child process 14312
[task 2021-03-29T15:46:35.715Z] 15:46:35 INFO - ==> process 13781 launched child process 14414
[task 2021-03-29T15:46:35.716Z] 15:46:35 INFO - ==> process 13781 launched child process 14495
[task 2021-03-29T15:46:35.716Z] 15:46:35 INFO - ==> process 13781 launched child process 14609
[task 2021-03-29T15:46:35.717Z] 15:46:35 INFO - ==> process 13781 launched child process 14707
[task 2021-03-29T15:46:35.717Z] 15:46:35 INFO - ==> process 13781 launched child process 14809
[task 2021-03-29T15:46:35.717Z] 15:46:35 INFO - ==> process 13781 launched child process 14897
[task 2021-03-29T15:46:35.718Z] 15:46:35 INFO - Found child pids: set([13920, 13857, 14053, 13798, 14897, 14312, 14009, 14058, 13911, 14414, 14609, 14707, 14218, 13879, 14809, 13917, 14495])
[task 2021-03-29T15:46:35.718Z] 15:46:35 INFO - Failed to get child procs
[task 2021-03-29T15:46:35.719Z] 15:46:35 INFO - Killing process: 13920
[task 2021-03-29T15:46:35.719Z] 15:46:35 INFO - TEST-INFO | started process screentopng
[task 2021-03-29T16:03:15.750Z] 16:03:15 INFO - Automation Error: mozprocess timed out after 1000 seconds running ['/builds/worker/workspace/build/venv/bin/python', '-u', '/builds/worker/workspace/build/tests/mochitest/runtests.py', '--enable-webrender', '--setpref=fission.autostart=true', '--setpref=dom.serviceWorkers.parent_intercept=true', '--setpref=media.peerconnection.mtransport_process=false', '--setpref=network.process.enabled=false', '--setpref=layers.d3d11.enable-blacklist=false', '--appname=/builds/worker/workspace/build/application/firefox/firefox', '--utility-path=tests/bin', '--extra-profile-file=tests/bin/plugins', '--symbols-path=/builds/worker/workspace/build/symbols', '--certificate-path=tests/certs', '--setpref=webgl.force-enabled=true', '--quiet', '--log-raw=/builds/worker/workspace/build/blobber_upload_dir/mochitest-browser-chrome-test2_raw.log', '--log-errorsummary=/builds/worker/workspace/build/blobber_upload_dir/mochitest-browser-chrome-test2_errorsummary.log', '--use-test-media-devices', '--screenshot-on-fail', '--cleanup-crashes', '--marionette-startup-timeout=180', '--sandbox-read-whitelist=/builds/worker/workspace/build', '--log-raw=-', '--flavor=browser', '--chunk-by-runtime', '--verify-max-time=900', '--verify', u'browser/base/content/test/webrtc/browser_devices_get_user_media_paused.js']
[task 2021-03-29T16:03:15.784Z] 16:03:15 ERROR - timed out after 1000 seconds of no output
[task 2021-03-29T16:03:15.785Z] 16:03:15 ERROR - Return code: -15
[task 2021-03-29T16:03:15.786Z] 16:03:15 INFO - TinderboxPrint: mochitest-mochitest-browser-chrome<br/>9502/0/0
[task 2021-03-29T16:03:15.786Z] 16:03:15 ERROR - # TBPL FAILURE #
[task 2021-03-29T16:03:15.787Z] 16:03:15 WARNING - setting return code to 2
[task 2021-03-29T16:03:15.787Z] 16:03:15 ERROR - TinderboxPrint: Per-test run of .../browser_devices_get_user_media_paused.js<br/>: FAILURE
[task 2021-03-29T16:03:15.787Z] 16:03:15 INFO - Per-test suites: {}
[task 2021-03-29T16:03:15.788Z] 16:03:15 INFO - Per-test suites: {}
[task 2021-03-29T16:03:15.788Z] 16:03:15 INFO - Running post-action listener: _package_coverage_data
[task 2021-03-29T16:03:15.788Z] 16:03:15 INFO - Running post-action listener: _resource_record_post_action
[task 2021-03-29T16:03:15.788Z] 16:03:15 INFO - Running post-action listener: process_java_coverage_data
[task 2021-03-29T16:03:15.788Z] 16:03:15 INFO - [mozharness: 2021-03-29 16:03:15.787305Z] Finished run-tests step (success)
[task 2021-03-29T16:03:15.788Z] 16:03:15 INFO - Running post-run listener: _resource_record_post_run
[task 2021-03-29T16:03:15.918Z] 16:03:15 INFO - Validating Perfherder data against /builds/worker/workspace/mozharness/external_tools/performance-artifact-schema.json
[task 2021-03-29T16:03:15.922Z] 16:03:15 INFO - PERFHERDER_DATA: {"framework": {"name": "job_resource_usage"}, "suites": [{"subtests": [{"name": "cpu_percent", "value": 34.40981375358148}, {"name": "io_write_bytes", "value": 2661179392}, {"name": "io.read_bytes", "value": 356352}, {"name": "io_write_time", "value": 303884}, {"name": "io_read_time", "value": 20}], "extraOptions": ["e10s", "taskcluster-m5.large"], "name": ".overall"}, {"subtests": [{"name": "time", "value": 0.037017107009887695}], "name": ".start-pulseaudio"}, {"subtests": [{"name": "time", "value": 14.089407920837402}, {"name": "cpu_percent", "value": 50.315384615384616}], "name": ".install"}, {"subtests": [{"name": "time", "value": 0.0011870861053466797}], "name": ".stage-files"}, {"subtests": [{"name": "time", "value": 2781.1809628009796}, {"name": "cpu_percent", "value": 34.32414476053277}], "name": ".run-tests"}]}
[task 2021-03-29T16:03:15.922Z] 16:03:15 INFO - Total resource usage - Wall time: 2795s; CPU: 34.0%; Read bytes: 356352; Write bytes: 2661179392; Read time: 20; Write time: 303884
[task 2021-03-29T16:03:15.924Z] 16:03:15 INFO - TinderboxPrint: CPU usage<br/>34.3%
[task 2021-03-29T16:03:15.924Z] 16:03:15 INFO - TinderboxPrint: I/O read bytes / time<br/>356,352 / 20
[task 2021-03-29T16:03:15.924Z] 16:03:15 INFO - TinderboxPrint: I/O write bytes / time<br/>2,661,179,392 / 303,884
[task 2021-03-29T16:03:15.924Z] 16:03:15 INFO - TinderboxPrint: CPU idle<br/>3,628.6 (65.3%)
[task 2021-03-29T16:03:15.924Z] 16:03:15 INFO - TinderboxPrint: CPU nice<br/>548.8 (9.9%)
[task 2021-03-29T16:03:15.924Z] 16:03:15 INFO - TinderboxPrint: CPU system<br/>170.8 (3.1%)
[task 2021-03-29T16:03:15.924Z] 16:03:15 INFO - TinderboxPrint: CPU user<br/>1,190.6 (21.4%)
[task 2021-03-29T16:03:15.925Z] 16:03:15 INFO - TinderboxPrint: Swap in / out<br/>0 / 0
[task 2021-03-29T16:03:15.926Z] 16:03:15 INFO - start-pulseaudio - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2021-03-29T16:03:15.927Z] 16:03:15 INFO - install - Wall time: 14s; CPU: 50.0%; Read bytes: 0; Write bytes: 8339456; Read time: 0; Write time: 3868
[task 2021-03-29T16:03:15.928Z] 16:03:15 INFO - stage-files - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2021-03-29T16:03:15.944Z] 16:03:15 INFO - run-tests - Wall time: 2781s; CPU: 34.0%; Read bytes: 356352; Write bytes: 2647810048; Read time: 20; Write time: 299044
[task 2021-03-29T16:03:16.301Z] 16:03:16 WARNING - returning nonzero exit status 2
[task 2021-03-29T16:03:16.332Z] cleanup
[task 2021-03-29T16:03:16.332Z] + cleanup
[task 2021-03-29T16:03:16.332Z] + local rv=2
[task 2021-03-29T16:03:16.332Z] + [[ -s /builds/worker/.xsession-errors ]]
[task 2021-03-29T16:03:16.332Z] + cp /builds/worker/.xsession-errors /builds/worker/artifacts/public/xsession-errors.log
[task 2021-03-29T16:03:16.334Z] + '[' ']'
[task 2021-03-29T16:03:16.335Z] + true
[task 2021-03-29T16:03:16.335Z] + cleanup_xvfb
[task 2021-03-29T16:03:16.335Z] ++ pidof Xvfb
[task 2021-03-29T16:03:16.345Z] + local xvfb_pid=49
[task 2021-03-29T16:03:16.345Z] + local vnc=false
[task 2021-03-29T16:03:16.345Z] + local interactive=false
[task 2021-03-29T16:03:16.345Z] + '[' -n 49 ']'
[task 2021-03-29T16:03:16.345Z] + [[ false == false ]]
[task 2021-03-29T16:03:16.345Z] + [[ false == false ]]
[task 2021-03-29T16:03:16.346Z] + kill 49
[task 2021-03-29T16:03:16.346Z] + screen -XS xvfb quit
[task 2021-03-29T16:03:16.394Z] + exit 2
[taskcluster 2021-03-29 16:03:16.757Z] === Task Finished ===
[taskcluster 2021-03-29 16:03:23.352Z] Unsuccessful task run with exit code: 2 completed in 2919.945 seconds```
| Comment hidden (Intermittent Failures Robot) |
Comment 2•5 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
Comment 3•5 years ago
|
||
Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=337965788&repo=autoland&lineNumber=6882
| Comment hidden (Intermittent Failures Robot) |
Comment 5•5 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
| Comment hidden (Intermittent Failures Robot) |
Comment 7•5 years ago
|
||
Recent failur elog: https://treeherder.mozilla.org/logviewer?job_id=350318242&repo=autoland&lineNumber=7003
[task 2021-09-02T10:00:58.372Z] 10:00:58 INFO - TEST-START | browser/base/content/test/webrtc/browser_devices_get_user_media_paused.js
[task 2021-09-02T10:00:58.423Z] 10:00:58 INFO - GECKO(3578) | [Child 4172, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-09-02T10:00:58.436Z] 10:00:58 INFO - GECKO(3578) | [Child 4172, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-09-02T10:00:58.440Z] 10:00:58 INFO - GECKO(3578) | [Child 4172: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 5 (7fd10ed64740) [pid = 4172] [serial = 1] [outer = 0] [url = https://example.com/browser/browser/base/content/test/webrtc/get_user_media.html]
[task 2021-09-02T10:00:58.447Z] 10:00:58 INFO - GECKO(3578) | [Child 4172: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 4 (7fd10ed64c80) [pid = 4172] [serial = 4] [outer = 0] [url = https://example.com/browser/browser/base/content/test/webrtc/get_user_media.html]
[task 2021-09-02T10:00:58.448Z] 10:00:58 INFO - GECKO(3578) | [Child 4172: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 3 (7fd0f4f15c00) [pid = 4172] [serial = 2] [outer = 0] [url = about:blank]
[task 2021-09-02T10:00:58.448Z] 10:00:58 INFO - GECKO(3578) | [Child 4172: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (7fd0f9d31000) [pid = 4172] [serial = 5] [outer = 0] [url = about:blank]
[task 2021-09-02T10:00:58.448Z] 10:00:58 INFO - GECKO(3578) | [Child 4172: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (7fd0f4f1c000) [pid = 4172] [serial = 3] [outer = 0] [url = https://example.com/browser/browser/base/content/test/webrtc/get_user_media.html]
[task 2021-09-02T10:00:58.449Z] 10:00:58 INFO - GECKO(3578) | [Child 4172: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (7fd0f3843800) [pid = 4172] [serial = 6] [outer = 0] [url = https://example.com/browser/browser/base/content/test/webrtc/get_user_media.html]
[task 2021-09-02T10:00:58.449Z] 10:00:58 INFO - GECKO(3578) | [Child 4172, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3357
[task 2021-09-02T10:00:58.452Z] 10:00:58 INFO - GECKO(3578) | [Child 4172, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-09-02T10:00:58.456Z] 10:00:58 INFO - GECKO(3578) | [Child 4172, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-09-02T10:00:58.456Z] 10:00:58 INFO - GECKO(3578) | [Child 4172, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-09-02T10:00:58.458Z] 10:00:58 INFO - GECKO(3578) | [Child 4172, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-09-02T10:00:58.467Z] 10:00:58 INFO - GECKO(3578) | [Child 4333: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f7e1a215000 == 1 [pid = 4333] [id = 0]
[task 2021-09-02T10:00:58.468Z] 10:00:58 INFO - GECKO(3578) | [Child 4333: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (7f7e34064740) [pid = 4333] [serial = 1] [outer = 0]
[task 2021-09-02T10:00:58.468Z] 10:00:58 INFO - GECKO(3578) | [Child 4333: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (7f7e1a216000) [pid = 4333] [serial = 2] [outer = 7f7e34064740]
[task 2021-09-02T10:00:58.469Z] 10:00:58 INFO - GECKO(3578) | [Child 4172, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4438
[task 2021-09-02T10:00:58.691Z] 10:00:58 INFO - GECKO(3578) | [Child 4333, Main Thread] WARNING: NS_ENSURE_TRUE(info) failed: file /builds/worker/checkouts/gecko/extensions/permissions/PermissionDelegateHandler.cpp:348
[task 2021-09-02T10:00:58.702Z] 10:00:58 INFO - GECKO(3578) | [Child 4333: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 3 (7f7e1a21c000) [pid = 4333] [serial = 3] [outer = 7f7e34064740]
[task 2021-09-02T10:00:58.734Z] 10:00:58 INFO - GECKO(3578) | TEST DEVICES: Using media devices:
[task 2021-09-02T10:00:58.735Z] 10:00:58 INFO - GECKO(3578) | audio: Monitor of Null Output
[task 2021-09-02T10:00:58.736Z] 10:00:58 INFO - GECKO(3578) | video: Dummy video device (0x0000)
[task 2021-09-02T10:00:58.848Z] 10:00:58 INFO - TEST-PASS | browser/base/content/test/webrtc/browser_devices_get_user_media_paused.js | should start the test without any prior popup notification -
[task 2021-09-02T10:00:58.849Z] 10:00:58 INFO - TEST-PASS | browser/base/content/test/webrtc/browser_devices_get_user_media_paused.js | should start the test with the permission panel hidden -
[task 2021-09-02T10:00:58.903Z] 10:00:58 INFO - getUserMedia audio+video: disabling the stream shows the paused indicator
[task 2021-09-02T10:00:58.915Z] 10:00:58 INFO - requesting devices
[task 2021-09-02T10:00:59.048Z] 10:00:59 INFO - TEST-PASS | browser/base/content/test/webrtc/browser_devices_get_user_media_paused.js | webRTC-shareDevices notification shown -
[task 2021-09-02T10:00:59.050Z] 10:00:59 INFO - TEST-PASS | browser/base/content/test/webrtc/browser_devices_get_user_media_paused.js | notification panel open -
[task 2021-09-02T10:00:59.052Z] 10:00:59 INFO - TEST-PASS | browser/base/content/test/webrtc/browser_devices_get_user_media_paused.js | notification panel populated -
[task 2021-09-02T10:00:59.087Z] 10:00:59 INFO - TEST-PASS | browser/base/content/test/webrtc/browser_devices_get_user_media_paused.js | Microphone selector visible -
[task 2021-09-02T10:00:59.087Z] 10:00:59 INFO - TEST-PASS | browser/base/content/test/webrtc/browser_devices_get_user_media_paused.js | Microphone selector list should be hidden. -
[task 2021-09-02T10:00:59.087Z] 10:00:59 INFO - TEST-PASS | browser/base/content/test/webrtc/browser_devices_get_user_media_paused.js | Microphone selector label should not be hidden. -
[task 2021-09-02T10:00:59.088Z] 10:00:59 INFO - TEST-PASS | browser/base/content/test/webrtc/browser_devices_get_user_media_paused.js | Microphone label should be showing the lone device label. -
[task 2021-09-02T10:00:59.088Z] 10:00:59 INFO - TEST-PASS | browser/base/content/test/webrtc/browser_devices_get_user_media_paused.js | Camera selector visible -
[task 2021-09-02T10:00:59.088Z] 10:00:59 INFO - TEST-PASS | browser/base/content/test/webrtc/browser_devices_get_user_media_paused.js | Camera selector list should be hidden. -
[task 2021-09-02T10:00:59.092Z] 10:00:59 INFO - TEST-PASS | browser/base/content/test/webrtc/browser_devices_get_user_media_paused.js | Camera selector label should not be hidden. -
[task 2021-09-02T10:00:59.094Z] 10:00:59 INFO - TEST-PASS | browser/base/content/test/webrtc/browser_devices_get_user_media_paused.js | Camera label should be showing the lone device label. -
[task 2021-09-02T10:00:59.097Z] 10:00:59 INFO - TEST-PASS | browser/base/content/test/webrtc/browser_devices_get_user_media_paused.js | Speaker selector hidden -
[task 2021-09-02T10:00:59.099Z] 10:00:59 INFO - TEST-PASS | browser/base/content/test/webrtc/browser_devices_get_user_media_paused.js | screen selector hidden -
[task 2021-09-02T10:00:59.099Z] 10:00:59 INFO - GECKO(3578) | [Child 4333, Main Thread] WARNING: NS_ENSURE_TRUE(info) failed: file /builds/worker/checkouts/gecko/extensions/permissions/PermissionDelegateHandler.cpp:348
[task 2021-09-02T10:00:59.133Z] 10:00:59 INFO - GECKO(3578) | [2021-09-02T10:00:59Z WARN audioipc_server::server] Promotion of content process thread to real-time error
[task 2021-09-02T10:00:59.162Z] 10:00:59 INFO - GECKO(3578) | [Parent 3578: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7fd0ea150400 == 9 [pid = 3578] [id = 20]
[task 2021-09-02T10:00:59.164Z] 10:00:59 INFO - GECKO(3578) | [Parent 3578: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 33 (7fd0fb4e43c0) [pid = 3578] [serial = 42] [outer = 0]
[task 2021-09-02T10:00:59.166Z] 10:00:59 INFO - GECKO(3578) | [Parent 3578: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 34 (7fd0ea27a800) [pid = 3578] [serial = 43] [outer = 7fd0fb4e43c0]
[task 2021-09-02T10:00:59.207Z] 10:00:59 INFO - GECKO(3578) | [Parent 3578, Main Thread] WARNING: NS_ENSURE_TRUE(rootFrame) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp:4233
[task 2021-09-02T10:00:59.267Z] 10:00:59 INFO - TEST-PASS | browser/base/content/test/webrtc/browser_devices_get_user_media_paused.js | expected camera and microphone to be shared - {"video":true,"audio":true} deepEqual {"audio":true,"video":true} -
[task 2021-09-02T10:01:01.274Z] 10:01:01 INFO - TEST-PASS | browser/base/content/test/webrtc/browser_devices_get_user_media_paused.js | WebRTC menu should be hidden -
[task 2021-09-02T10:01:01.277Z] 10:01:01 INFO - TEST-PASS | browser/base/content/test/webrtc/browser_devices_get_user_media_paused.js | popup WebRTC indicator hidden -
[task 2021-09-02T10:01:01.280Z] 10:01:01 INFO - getUserMedia screen: disabling the stream shows the paused indicator
[task 2021-09-02T10:01:01.283Z] 10:01:01 INFO - requesting devices
[task 2021-09-02T10:01:06.334Z] 10:01:06 INFO - GECKO(3578) | [Child 3953: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7f40c4614800 == 0 [pid = 3953] [id = 2] [url = about:blank]
[task 2021-09-02T10:01:10.421Z] 10:01:10 INFO - GECKO(3578) | [Child 3953: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (7f40de464740) [pid = 3953] [serial = 5] [outer = 0] [url = about:blank]
[task 2021-09-02T10:01:10.882Z] 10:01:10 INFO - GECKO(3578) | [Child 4333: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (7f7e1a216000) [pid = 4333] [serial = 2] [outer = 0] [url = about:blank]
[task 2021-09-02T10:01:14.501Z] 10:01:14 INFO - GECKO(3578) | [Child 3953: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (7f40c4616800) [pid = 3953] [serial = 6] [outer = 0] [url = about:blank]
[task 2021-09-02T10:07:24.504Z] 10:07:24 INFO - Buffered messages logged at 10:00:58
[task 2021-09-02T10:07:24.505Z] 10:07:24 INFO - Entering test bound test
[task 2021-09-02T10:07:24.505Z] 10:07:24 INFO - Buffered messages finished
[task 2021-09-02T10:07:24.506Z] 10:07:24 ERROR - TEST-UNEXPECTED-TIMEOUT | browser/base/content/test/webrtc/browser_devices_get_user_media_paused.js | application timed out after 370 seconds with no output
[task 2021-09-02T10:07:24.506Z] 10:07:24 ERROR - Force-terminating active process(es).
[task 2021-09-02T10:07:24.507Z] 10:07:24 INFO - Determining child pids from psutil...
[task 2021-09-02T10:07:24.517Z] 10:07:24 INFO - [3647, 3671, 3721, 3725, 3766, 3817, 3820, 3825, 3923, 3953, 3981, 3984, 4037, 4041, 4172, 4183, 4258, 4333, 4356, 4420, 4475]
[task 2021-09-02T10:07:24.517Z] 10:07:24 INFO - ==> process 3578 launched child process 3596
[task 2021-09-02T10:07:24.518Z] 10:07:24 INFO - ==> process 3578 launched child process 3647
[task 2021-09-02T10:07:24.518Z] 10:07:24 INFO - ==> process 3578 launched child process 3671
[task 2021-09-02T10:07:24.519Z] 10:07:24 INFO - ==> process 3578 launched child process 3721
[task 2021-09-02T10:07:24.519Z] 10:07:24 INFO - ==> process 3578 launched child process 3725
[task 2021-09-02T10:07:24.520Z] 10:07:24 INFO - ==> process 3578 launched child process 3766
[task 2021-09-02T10:07:24.520Z] 10:07:24 INFO - ==> process 3578 launched child process 3817
[task 2021-09-02T10:07:24.521Z] 10:07:24 INFO - ==> process 3578 launched child process 3820
[task 2021-09-02T10:07:24.521Z] 10:07:24 INFO - ==> process 3578 launched child process 3825
[task 2021-09-02T10:07:24.522Z] 10:07:24 INFO - ==> process 3578 launched child process 3923
[task 2021-09-02T10:07:24.522Z] 10:07:24 INFO - ==> process 3578 launched child process 3953
[task 2021-09-02T10:07:24.523Z] 10:07:24 INFO - ==> process 3578 launched child process 3981
[task 2021-09-02T10:07:24.523Z] 10:07:24 INFO - ==> process 3578 launched child process 3984
[task 2021-09-02T10:07:24.524Z] 10:07:24 INFO - ==> process 3578 launched child process 4037
[task 2021-09-02T10:07:24.524Z] 10:07:24 INFO - ==> process 3578 launched child process 4041
[task 2021-09-02T10:07:24.525Z] 10:07:24 INFO - ==> process 3578 launched child process 4172
[task 2021-09-02T10:07:24.525Z] 10:07:24 INFO - ==> process 3578 launched child process 4183
[task 2021-09-02T10:07:24.526Z] 10:07:24 INFO - ==> process 3578 launched child process 4258
[task 2021-09-02T10:07:24.527Z] 10:07:24 INFO - ==> process 3578 launched child process 4333
[task 2021-09-02T10:07:24.527Z] 10:07:24 INFO - ==> process 3578 launched child process 4356
[task 2021-09-02T10:07:24.528Z] 10:07:24 INFO - ==> process 3578 launched child process 4420
[task 2021-09-02T10:07:24.528Z] 10:07:24 INFO - ==> process 3578 launched child process 4475
[task 2021-09-02T10:07:24.529Z] 10:07:24 INFO - Found child pids: {4356, 3721, 3596, 3725, 3981, 3984, 4258, 3766, 3647, 4420, 4037, 4041, 4172, 3923, 3671, 4183, 3817, 3820, 4333, 3825, 3953, 4475}
[task 2021-09-02T10:07:24.529Z] 10:07:24 INFO - Failed to get child procs
| Comment hidden (Intermittent Failures Robot) |
Comment 9•5 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
Comment 10•4 years ago
|
||
Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=355600210&repo=autoland&lineNumber=3350
| Comment hidden (Intermittent Failures Robot) |
Comment 12•4 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
Comment 13•4 years ago
|
||
Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=358631361&repo=autoland&lineNumber=6880
| 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) |
| 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) |
| 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•4 years ago
|
Description
•