Closed
Bug 1889779
Opened 2 years ago
Closed 2 years ago
Intermittent dom/media/webrtc/tests/mochitests/test_peerConnection_audioRenegotiationInactiveAnswer.html | single tracking bug
Categories
(Core :: WebRTC: Audio/Video, defect, P5)
Core
WebRTC: Audio/Video
Tracking
()
RESOLVED
INCOMPLETE
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure, intermittent-testcase)
Filed by: ctuns [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=453547183&repo=mozilla-beta
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/SVF437aNSTueMSMfoezBuQ/runs/0/artifacts/public/logs/live_backing.log
[task 2024-04-04T20:39:52.295Z] 20:39:52 INFO - TEST-PASS | dom/media/webrtc/tests/mochitests/test_peerConnection_audioRenegotiationInactiveAnswer.html | Reason cannot be empty
[task 2024-04-04T20:39:52.295Z] 20:39:52 INFO - Buffered messages logged at 20:33:41
[task 2024-04-04T20:39:52.295Z] 20:39:52 INFO - Skipping ICE Server for this test
[task 2024-04-04T20:39:52.296Z] 20:39:52 INFO - Buffered messages finished
[task 2024-04-04T20:39:52.296Z] 20:39:52 INFO - TEST-UNEXPECTED-TIMEOUT | dom/media/webrtc/tests/mochitests/test_peerConnection_audioRenegotiationInactiveAnswer.html | application timed out after 370 seconds with no output
[task 2024-04-04T20:39:52.296Z] 20:39:52 INFO - TEST-INFO took 371029ms
[task 2024-04-04T20:39:52.296Z] 20:39:52 INFO - Buffered messages finished
[task 2024-04-04T20:39:52.296Z] 20:39:52 WARNING - Force-terminating active process(es).
[task 2024-04-04T20:39:52.296Z] 20:39:52 INFO - Determining child pids from psutil...
[task 2024-04-04T20:39:52.296Z] 20:39:52 INFO - [9514, 9517, 9518, 9519, 9520, 9521, 9522]
[task 2024-04-04T20:39:52.296Z] 20:39:52 INFO - ==> process 9513 launched child process 9514
[task 2024-04-04T20:39:52.297Z] 20:39:52 INFO - ==> process 9513 launched child process 9516
[task 2024-04-04T20:39:52.297Z] 20:39:52 INFO - ==> process 9513 launched child process 9517
[task 2024-04-04T20:39:52.297Z] 20:39:52 INFO - ==> process 9513 launched child process 9518
[task 2024-04-04T20:39:52.297Z] 20:39:52 INFO - ==> process 9513 launched child process 9519
[task 2024-04-04T20:39:52.297Z] 20:39:52 INFO - ==> process 9513 launched child process 9520
[task 2024-04-04T20:39:52.297Z] 20:39:52 INFO - ==> process 9513 launched child process 9521
[task 2024-04-04T20:39:52.297Z] 20:39:52 INFO - ==> process 9513 launched child process 9522
[task 2024-04-04T20:39:52.297Z] 20:39:52 INFO - Found child pids: {9514, 9516, 9517, 9518, 9519, 9520, 9521, 9522}
[task 2024-04-04T20:39:52.298Z] 20:39:52 INFO - Failed to get child procs
[task 2024-04-04T20:39:52.298Z] 20:39:52 INFO - Killing process: 9514
[task 2024-04-04T20:39:52.298Z] 20:39:52 INFO - TEST-INFO | started process screencapture
[task 2024-04-04T20:39:52.420Z] 20:39:52 INFO - TEST-INFO | screencapture: exit 0
[task 2024-04-04T20:39:52.420Z] 20:39:52 INFO - Killing process: 9516
[task 2024-04-04T20:39:52.420Z] 20:39:52 INFO - Not taking screenshot here: see the one that was previously logged
[task 2024-04-04T20:39:52.420Z] 20:39:52 INFO - Can't trigger Breakpad, process no longer exists
[task 2024-04-04T20:39:52.420Z] 20:39:52 INFO - Killing process: 9517
[task 2024-04-04T20:39:52.420Z] 20:39:52 INFO - Not taking screenshot here: see the one that was previously logged
[task 2024-04-04T20:39:52.420Z] 20:39:52 INFO - Killing process: 9518
[task 2024-04-04T20:39:52.420Z] 20:39:52 INFO - Not taking screenshot here: see the one that was previously logged
[task 2024-04-04T20:39:52.421Z] 20:39:52 INFO - Killing process: 9519
[task 2024-04-04T20:39:52.421Z] 20:39:52 INFO - Not taking screenshot here: see the one that was previously logged
[task 2024-04-04T20:39:52.421Z] 20:39:52 INFO - Killing process: 9520
[task 2024-04-04T20:39:52.421Z] 20:39:52 INFO - Not taking screenshot here: see the one that was previously logged
[task 2024-04-04T20:39:52.421Z] 20:39:52 INFO - Killing process: 9521
[task 2024-04-04T20:39:52.421Z] 20:39:52 INFO - Not taking screenshot here: see the one that was previously logged
[task 2024-04-04T20:39:52.421Z] 20:39:52 INFO - Killing process: 9522
[task 2024-04-04T20:39:52.421Z] 20:39:52 INFO - Not taking screenshot here: see the one that was previously logged
[task 2024-04-04T20:39:52.421Z] 20:39:52 INFO - Killing process: 9513
[task 2024-04-04T20:39:52.421Z] 20:39:52 INFO - Not taking screenshot here: see the one that was previously logged
[task 2024-04-04T20:39:52.523Z] 20:39:52 INFO - psutil found pid 9513 dead
[task 2024-04-04T20:56:32.677Z] 20:56:32 INFO - Automation Error: mozharness timed out after 1000 seconds running ['/opt/worker/tasks/task_171225826902175/build/venv/bin/python', '-u', '/opt/worker/tasks/task_171225826902175/build/tests/mochitest/runtests.py', 'dom/media/autoplay/test/mochitest/mochitest.toml', 'dom/media/mediasession/test/mochitest.toml', 'dom/media/mediasource/test/mochitest.toml', 'dom/media/mediasource/test/mochitest_compat.toml', 'dom/media/test/mochitest.toml', 'dom/media/test/mochitest_background_video.toml', 'dom/media/test/mochitest_bugs.toml', 'dom/media/test/mochitest_compat.toml', 'dom/media/test/mochitest_eme.toml', 'dom/media/test/mochitest_eme_compat.toml', 'dom/media/test/mochitest_media_engine.toml', 'dom/media/test/mochitest_media_recorder.toml', 'dom/media/test/mochitest_seek.toml', 'dom/media/test/mochitest_stream.toml', 'dom/media/webaudio/test/blink/mochitest.toml', 'dom/media/webaudio/test/mochitest.toml', 'dom/media/webaudio/test/mochitest_audio.toml', 'dom/media/webaudio/test/mochitest_bugs.toml', 'dom/media/webaudio/test/mochitest_media.toml', 'dom/media/webcodecs/test/mochitest.toml', 'dom/media/webrtc/tests/mochitests/identity/mochitest.toml', 'dom/media/webrtc/tests/mochitests/mochitest.toml', 'dom/media/webrtc/tests/mochitests/mochitest_datachannel.toml', 'dom/media/webrtc/tests/mochitests/mochitest_getusermedia.toml', 'dom/media/webrtc/tests/mochitests/mochitest_peerconnection.toml', 'dom/media/webspeech/recognition/test/mochitest.toml', 'dom/media/webspeech/synth/test/mochitest.toml', 'dom/media/webspeech/synth/test/startup/mochitest.toml', 'dom/media/webvtt/test/mochitest/mochitest.toml', 'ipc/glue/test/browser/mochitest_audio_off.toml', 'ipc/glue/test/browser/mochitest_audio_on.toml', '--setpref=layout.css.stylo-threads=4', '--setpref=webgl.out-of-process=false', '--setpref=security.sandbox.content.headless=false', '--setpref=media.peerconnection.mtransport_process=false', '--setpref=network.process.enabled=false', '--setpref=layers.d3d11.enable-blacklist=false', '--appname=/opt/worker/tasks/task_171225826902175/build/application/Firefox.app/Contents/MacOS/firefox', '--utility-path=tests/bin', '--extra-profile-file=tests/bin/plugins', '--symbols-path=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/CMNdE3EvTDCNgsMLwvhy5Q/artifacts/public/build/target.crashreporter-symbols.zip', '--certificate-path=tests/certs', '--quiet', '--log-errorsummary=/opt/worker/tasks/task_171225826902175/build/blobber_upload_dir/mochitest-media_errorsummary.log', '--screenshot-on-fail', '--cleanup-crashes', '--marionette-startup-timeout=180', '--sandbox-read-whitelist=/opt/worker/tasks/task_171225826902175/build', '--log-raw=-', '--subsuite=media']
[task 2024-04-04T20:56:32.679Z] 20:56:32 INFO - Return code: -9
[task 2024-04-04T20:56:32.679Z] 20:56:32 WARNING - Got 1 unexpected statuses
[task 2024-04-04T20:56:32.679Z] 20:56:32 ERROR - No suite end message was emitted by this harness.
[task 2024-04-04T20:56:32.679Z] 20:56:32 INFO - TinderboxPrint: mochitest-mochitest-media<br/>2771/<em class="testfail">1</em>/0
[task 2024-04-04T20:56:32.679Z] 20:56:32 WARNING - setting return code to 2
[task 2024-04-04T20:56:32.679Z] 20:56:32 INFO - The mochitest suite: mochitest-media ran with return status: FAILURE
[task 2024-04-04T20:56:32.679Z] 20:56:32 INFO - Running post-action listener: _package_coverage_data
[task 2024-04-04T20:56:32.679Z] 20:56:32 INFO - Running post-action listener: _resource_record_post_action
[task 2024-04-04T20:56:32.679Z] 20:56:32 INFO - Running post-action listener: process_java_coverage_data
[task 2024-04-04T20:56:32.679Z] 20:56:32 INFO - [mozharness: 2024-04-04 20:56:32.679636Z] Finished run-tests step (success)
[task 2024-04-04T20:56:32.679Z] 20:56:32 INFO - [mozharness: 2024-04-04 20:56:32.679651Z] Running uninstall step.
[task 2024-04-04T20:56:32.679Z] 20:56:32 INFO - Running pre-action listener: _resource_record_pre_action
[task 2024-04-04T20:56:32.679Z] 20:56:32 INFO - Running main action method: uninstall
[task 2024-04-04T20:56:32.679Z] 20:56:32 INFO - Skipping uninstall for non-MSIX test
[task 2024-04-04T20:56:32.679Z] 20:56:32 INFO - Running post-action listener: _resource_record_post_action
[task 2024-04-04T20:56:32.679Z] 20:56:32 INFO - [mozharness: 2024-04-04 20:56:32.679705Z] Finished uninstall step (success)
[task 2024-04-04T20:56:32.679Z] 20:56:32 INFO - Running post-run listener: _resource_record_post_run
[task 2024-04-04T20:56:33.027Z] 20:56:33 INFO - instance_metadata.json not found; unable to determine instance type
[task 2024-04-04T20:56:33.045Z] 20:56:33 INFO - Validating Perfherder data against /opt/worker/tasks/task_171225826902175/mozharness/external_tools/performance-artifact-schema.json
[task 2024-04-04T20:56:33.046Z] 20:56:33 INFO - PERFHERDER_DATA: {"framework": {"name": "job_resource_usage"}, "suites": [{"name": "mochitest.mochitest-media.overall", "extraOptions": ["e10s", "buildbot-unknown"], "subtests": [{"name": "cpu_percent", "value": 16.35387563268263}, {"name": "io_write_bytes", "value": 2526650368}, {"name": "io.read_bytes", "value": 442114048}, {"name": "io_write_time", "value": 4712}, {"name": "io_read_time", "value": 9177}]}, {"name": "mochitest.mochitest-media.start-pulseaudio", "subtests": [{"name": "time", "value": 9.433299965166952e-05}, {"name": "cpu_percent", "value": 0}]}, {"name": "mochitest.mochitest-media.install", "subtests": [{"name": "time", "value": 17.406986209000024}, {"name": "cpu_percent", "value": 12.917638888888888}]}, {"name": "mochitest.mochitest-media.stage-files", "subtests": [{"name": "time", "value": 0.00014441699977396638}, {"name": "cpu_percent", "value": 0}]}, {"name": "mochitest.mochitest-media.run-tests", "subtests": [{"name": "time", "value": 2986.1470274589997}, {"name": "cpu_percent", "value": 16.368537258509722}]}, {"name": "mochitest.mochitest-media.uninstall", "subtests": [{"name": "time", "value": 3.545900017343229e-05}, {"name": "cpu_percent", "value": 0}]}]}
[task 2024-04-04T20:56:33.046Z] 20:56:33 INFO - Total resource usage - Wall time: 3004s; CPU: Can't collect data; Read bytes: 442114048; Write bytes: 2526650368; Read time: 9177; Write time: 4712
[task 2024-04-04T20:56:33.046Z] 20:56:33 INFO - TinderboxPrint: I/O read bytes / time<br/>442,114,048 / 9,177
[task 2024-04-04T20:56:33.046Z] 20:56:33 INFO - TinderboxPrint: I/O write bytes / time<br/>2,526,650,368 / 4,712
[task 2024-04-04T20:56:33.046Z] 20:56:33 INFO - TinderboxPrint: CPU idle<br/>20,244.9 (84.3%)
[task 2024-04-04T20:56:33.046Z] 20:56:33 INFO - TinderboxPrint: CPU system<br/>341.2 (1.4%)
[task 2024-04-04T20:56:33.046Z] 20:56:33 INFO - TinderboxPrint: CPU user<br/>3,441.8 (14.3%)
[task 2024-04-04T20:56:33.047Z] 20:56:33 INFO - TinderboxPrint: Swap in / out<br/>794,329,088 / 0
[task 2024-04-04T20:56:33.049Z] 20:56:33 INFO - start-pulseaudio - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2024-04-04T20:56:33.051Z] 20:56:33 INFO - install - Wall time: 17s; CPU: 13%; Read bytes: 388904960; Write bytes: 376078336; Read time: 14787; Write time: 286
[task 2024-04-04T20:56:33.053Z] 20:56:33 INFO - stage-files - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2024-04-04T20:56:33.109Z] 20:56:33 INFO - run-tests - Wall time: 2986s; CPU: 16%; Read bytes: 434475008; Write bytes: 2139922432; Read time: 8995; Write time: 4418
[task 2024-04-04T20:56:33.113Z] 20:56:33 INFO - uninstall - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2024-04-04T20:56:34.997Z] 20:56:34 WARNING - returning nonzero exit status 2
[taskcluster 2024-04-04T20:56:35.102Z] Exit Code: 2
[taskcluster 2024-04-04T20:56:35.102Z] User Time: 29m41.766783s
[taskcluster 2024-04-04T20:56:35.102Z] Kernel Time: 1m33.773325s
[taskcluster 2024-04-04T20:56:35.102Z] Wall Time: 51m5.966403s
[taskcluster 2024-04-04T20:56:35.102Z] Result: FAILED
[taskcluster 2024-04-04T20:56:35.102Z] === Task Finished ===
[taskcluster 2024-04-04T20:56:35.102Z] Task Duration: 51m5.971839s
[taskcluster 2024-04-04T20:56:35.360Z] Uploading artifact public/logs/localconfig.json from file /opt/worker/tasks/task_171225826902175/logs/localconfig.json with content encoding "gzip", mime type "application/json" and expiry 2024-07-03T17:31:55.911Z
[taskcluster 2024-04-04T20:56:35.676Z] Uploading artifact public/test_info/manifests.list from file /opt/worker/tasks/task_171225826902175/build/blobber_upload_dir/manifests.list with content encoding "gzip", mime type "text/plain; charset=utf-8" and expiry 2024-07-03T17:31:55.911Z
[taskcluster 2024-04-04T20:56:35.941Z] Uploading artifact public/test_info/mochitest-media_errorsummary.log from file /opt/worker/tasks/task_171225826902175/build/blobber_upload_dir/mochitest-media_errorsummary.log with content encoding "gzip", mime type "text/plain" and expiry 2024-07-03T17:31:55.911Z
[taskcluster 2024-04-04T20:56:36.204Z] Uploading artifact public/test_info/mozilla-test-fail-screenshot_k03fxrbl.png from file /opt/worker/tasks/task_171225826902175/build/blobber_upload_dir/mozilla-test-fail-screenshot_k03fxrbl.png with content encoding "identity", mime type "image/png" and expiry 2024-07-03T17:31:55.911Z
[taskcluster 2024-04-04T20:56:36.517Z] Uploading artifact public/test_info/profile_resource-usage.json from file /opt/worker/tasks/task_171225826902175/build/blobber_upload_dir/profile_resource-usage.json with content encoding "gzip", mime type "application/json" and expiry 2024-07-03T17:31:55.911Z
[taskcluster 2024-04-04T20:56:36.853Z] Uploading artifact public/test_info/resource-usage.json from file /opt/worker/tasks/task_171225826902175/build/blobber_upload_dir/resource-usage.json with content encoding "gzip", mime type "application/json" and expiry 2024-07-03T17:31:55.911Z
[taskcluster 2024-04-04T20:56:37.445Z] Uploading artifact public/test_info/system-info.log from file /opt/worker/tasks/task_171225826902175/build/blobber_upload_dir/system-info.log with content encoding "gzip", mime type "text/plain" and expiry 2024-07-03T17:31:55.911Z
[taskcluster 2024-04-04T20:56:37.701Z] Uploading link artifact public/logs/live.log to artifact public/logs/live_backing.log with expiry 2024-07-03T17:31:55.911Z
[taskcluster:error] exit status 2
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 2•2 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.
Status: NEW → RESOLVED
Closed: 2 years ago
Resolution: --- → INCOMPLETE
You need to log in
before you can comment on or make changes to this bug.
Description
•