Closed Bug 1611102 Opened 5 years ago Closed 5 years ago

Intermittent TinderboxPrint: Per-test run of ...\RTCPeerConnection-remote-track-mute.https.html<br/>: FAILURE

Categories

(Core :: WebRTC, defect, P5)

Product:
Core
Component:
WebRTC
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: malexandru [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=286111295&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/OxoTH6ZeROCCv7pXCOurqg/runs/0/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/OxoTH6ZeROCCv7pXCOurqg/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1

[task 2020-01-23T09:03:30.942Z] 09:03:30 INFO - TEST-OK | /webrtc/RTCPeerConnection-remote-track-mute.https.html | took 10271ms
[task 2020-01-23T09:03:30.942Z] 09:03:30 INFO - No more tests
[task 2020-01-23T09:03:30.949Z] 09:03:30 INFO - PID 5876 | 1579770210912 Marionette INFO Stopped listening on port 49412
[task 2020-01-23T09:03:32.344Z] 09:03:32 INFO - PID 5876 | [Parent 5828, Gecko_IOThread] WARNING: file z:/task_1579760385/build/src/ipc/chromium/src/base/process_util_win.cc, line 160
[task 2020-01-23T09:03:32.652Z] 09:03:32 INFO - Browser exited with return code 0
[task 2020-01-23T09:03:32.652Z] 09:03:32 INFO - PROCESS LEAKS None
[task 2020-01-23T09:03:32.653Z] 09:03:32 INFO - PROCESS LEAKS None
[task 2020-01-23T09:03:32.653Z] 09:03:32 INFO - Closing logging queue
[task 2020-01-23T09:03:32.653Z] 09:03:32 INFO - queue closed
[task 2020-01-23T09:03:32.654Z] 09:03:32 INFO - PROCESS LEAKS None
[task 2020-01-23T09:03:32.654Z] 09:03:32 INFO - Got 0 unexpected results
[task 2020-01-23T09:03:32.654Z] 09:03:32 INFO - SUITE-END | took 108s
[task 2020-01-23T09:03:32.694Z] 09:03:32 INFO - Closing logging queue
[task 2020-01-23T09:03:32.694Z] 09:03:32 INFO - queue closed
[task 2020-01-23T09:03:32.801Z] 09:03:32 INFO - ## All results ##
[task 2020-01-23T09:03:32.801Z] 09:03:32 INFO -
[task 2020-01-23T09:03:32.802Z] 09:03:32 INFO - ### /webrtc/RTCPeerConnection-remote-track-mute.https.html ###
[task 2020-01-23T09:03:32.802Z] 09:03:32 INFO - | Subtest | Results | Messages |
[task 2020-01-23T09:03:32.802Z] 09:03:32 INFO - |------------------------------------------------------------------------------------------|---------|----------|
[task 2020-01-23T09:03:32.803Z] 09:03:32 INFO - | | OK | |
[task 2020-01-23T09:03:32.803Z] 09:03:32 INFO - | ontrack: track goes from muted to unmuted | PASS | |
[task 2020-01-23T09:03:32.803Z] 09:03:32 INFO - | Changing transceiver direction to 'inactive' mutes the remote track | PASS | |
[task 2020-01-23T09:03:32.803Z] 09:03:32 INFO - | Changing transceiver direction to 'sendrecv' unmutes the remote track | PASS | |
[task 2020-01-23T09:03:32.803Z] 09:03:32 INFO - | transceiver.stop() on one side (without renegotiation) causes mute events on the other | PASS | |
[task 2020-01-23T09:03:32.803Z] 09:03:32 INFO - | pc.close() on one side causes mute events on the other | PASS | |
[task 2020-01-23T09:03:32.804Z] 09:03:32 INFO -
[task 2020-01-23T09:03:32.804Z] 09:03:32 INFO - ## Slow tests ##
[task 2020-01-23T09:03:32.804Z] 09:03:32 INFO -
[task 2020-01-23T09:03:32.804Z] 09:03:32 INFO - | Test | Result | Longest duration (ms) | Timeout (ms) |
[task 2020-01-23T09:03:32.804Z] 09:03:32 INFO - |----------------------------------------------------------|--------|-----------------------|--------------|
[task 2020-01-23T09:03:32.804Z] 09:03:32 INFO - | /webrtc/RTCPeerConnection-remote-track-mute.https.html | OK | 10375 | 10000 |
[task 2020-01-23T09:03:32.804Z] 09:03:32 INFO -
[task 2020-01-23T09:03:32.804Z] 09:03:32 INFO - ::: Running tests in a loop 10 times : FAIL
[task 2020-01-23T09:03:32.805Z] 09:03:32 INFO - :::
[task 2020-01-23T09:03:32.805Z] 09:03:32 ERROR - ::: Test verification FAIL
[task 2020-01-23T09:03:32.805Z] 09:03:32 INFO - :::
[task 2020-01-23T09:03:32.976Z] 09:03:32 ERROR - Return code: 1
[task 2020-01-23T09:03:32.977Z] 09:03:32 ERROR - # TBPL FAILURE #
[task 2020-01-23T09:03:32.977Z] 09:03:32 WARNING - setting return code to 2
[task 2020-01-23T09:03:32.977Z] 09:03:32 ERROR - TinderboxPrint: Per-test run of ...\RTCPeerConnection-remote-track-mute.https.html<br/>: FAILURE
[task 2020-01-23T09:03:32.981Z] 09:03:32 INFO - Running command: ['Z:\task_1579768369\build\venv\Scripts\python', '-u', 'Z:\task_1579768369\build\tests\web-platform\runtests.py', '--log-raw=-', '--log-raw=Z:\task_1579768369\build\blobber_upload_dir\wpt_raw.log', '--log-wptreport=Z:\task_1579768369\build\blobber_upload_dir\wptreport.json', '--log-errorsummary=Z:\task_1579768369\build\blobber_upload_dir\wpt_errorsummary.log', '--binary=Z:\task_1579768369\build\application\firefox\firefox.exe', u'--symbols-path=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/EZb6Ml8sQ8mNDTa53d40Dw/artifacts/public/build/target.crashreporter-symbols.zip', '--stackwalk-binary=Z:\task_1579768369\build\win32-minidump_stackwalk.exe', '--stackfix-dir=Z:\task_1579768369\build\tests\bin', '--run-by-dir=3', '--no-pause-after-test', '--test-type=testharness', '--setpref=media.peerconnection.mtransport_process=false', '--setpref=network.process.enabled=false', '--prefs-root=Z:\task_1579768369\build\tests\web-platform/prefs', '--processes=1', '--config=Z:\task_1579768369\build\tests\web-platform/wptrunner.ini', '--ca-cert-path=Z:\task_1579768369\build\tests\web-platform/tests/tools/certs/cacert.pem', '--host-key-path=Z:\task_1579768369\build\tests\web-platform/tests/tools/certs/web-platform.test.key', '--host-cert-path=Z:\task_1579768369\build\tests\web-platform/tests/tools/certs/web-platform.test.pem', '--certutil-binary=Z:\task_1579768369\build\tests/bin/certutil', '--verify-log-full', '--verify', u'tests/web-platform/tests/webrtc/RTCPeerConnection-setLocalDescription-answer.html'] in Z:\task_1579768369\build
[task 2020-01-23T09:03:32.982Z] 09:03:32 INFO - Copy/paste: Z:\task_1579768369\build\venv\Scripts\python -u Z:\task_1579768369\build\tests\web-platform\runtests.py --log-raw=- --log-raw=Z:\task_1579768369\build\blobber_upload_dir\wpt_raw.log --log-wptreport=Z:\task_1579768369\build\blobber_upload_dir\wptreport.json --log-errorsummary=Z:\task_1579768369\build\blobber_upload_dir\wpt_errorsummary.log --binary=Z:\task_1579768369\build\application\firefox\firefox.exe --symbols-path=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/EZb6Ml8sQ8mNDTa53d40Dw/artifacts/public/build/target.crashreporter-symbols.zip --stackwalk-binary=Z:\task_1579768369\build\win32-minidump_stackwalk.exe --stackfix-dir=Z:\task_1579768369\build\tests\bin --run-by-dir=3 --no-pause-after-test --test-type=testharness --setpref=media.peerconnection.mtransport_process=false --setpref=network.process.enabled=false --prefs-root=Z:\task_1579768369\build\tests\web-platform/prefs --processes=1 --config=Z:\task_1579768369\build\tests\web-platform/wptrunner.ini --ca-cert-path=Z:\task_1579768369\build\tests\web-platform/tests/tools/certs/cacert.pem --host-key-path=Z:\task_1579768369\build\tests\web-platform/tests/tools/certs/web-platform.test.key --host-cert-path=Z:\task_1579768369\build\tests\web-platform/tests/tools/certs/web-platform.test.pem --certutil-binary=Z:\task_1579768369\build\tests/bin/certutil --verify-log-full --verify tests/web-platform/tests/webrtc/RTCPeerConnection-setLocalDescription-answer.html
[task 2020-01-23T09:03:32.982Z] 09:03:32 INFO - Using env: (same as previous command)
[task 2020-01-23T09:03:32.982Z] 09:03:32 INFO - Calling ['Z:\task_1579768369\build\venv\Scripts\python', '-u', 'Z:\task_1579768369\build\tests\web-platform\runtests.py', '--log-raw=-', '--log-raw=Z:\task_1579768369\build\blobber_upload_dir\wpt_raw.log', '--log-wptreport=Z:\task_1579768369\build\blobber_upload_dir\wptreport.json', '--log-errorsummary=Z:\task_1579768369\build\blobber_upload_dir\wpt_errorsummary.log', '--binary=Z:\task_1579768369\build\application\firefox\firefox.exe', u'--symbols-path=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/EZb6Ml8sQ8mNDTa53d40Dw/artifacts/public/build/target.crashreporter-symbols.zip', '--stackwalk-binary=Z:\task_1579768369\build\win32-minidump_stackwalk.exe', '--stackfix-dir=Z:\task_1579768369\build\tests\bin', '--run-by-dir=3', '--no-pause-after-test', '--test-type=testharness', '--setpref=media.peerconnection.mtransport_process=false', '--setpref=network.process.enabled=false', '--prefs-root=Z:\task_1579768369\build\tests\web-platform/prefs', '--processes=1', '--config=Z:\task_1579768369\build\tests\web-platform/wptrunner.ini', '--ca-cert-path=Z:\task_1579768369\build\tests\web-platform/tests/tools/certs/cacert.pem', '--host-key-path=Z:\task_1579768369\build\tests\web-platform/tests/tools/certs/web-platform.test.key', '--host-cert-path=Z:\task_1579768369\build\tests\web-platform/tests/tools/certs/web-platform.test.pem', '--certutil-binary=Z:\task_1579768369\build\tests/bin/certutil', '--verify-log-full', '--verify', u'tests/web-platform/tests/webrtc/RTCPeerConnection-setLocalDescription-answer.html'] with output_timeout 1000
[task 2020-01-23T09:03:33.340Z] 09:03:33 INFO - :::
[task 2020-01-23T09:03:33.340Z] 09:03:33 INFO - ::: Running test verification step "Running tests in a loop 10 times"...
[task 2020-01-23T09:03:33.340Z] 09:03:33 INFO - :::
[task 2020-01-23T09:03:33.655Z] 09:03:33 INFO - mozversion application_buildid: 20200123055728
[task 2020-01-23T09:03:33.655Z] 09:03:33 INFO - mozversion application_changeset: c0d7cf71074de0d9ccadb96de2d98dec211e6d2f
[task 2020-01-23T09:03:33.655Z] 09:03:33 INFO - mozversion application_display_name: Firefox Nightly
[task 2020-01-23T09:03:33.655Z] 09:03:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
[task 2020-01-23T09:03:33.655Z] 09:03:33 INFO - mozversion application_name: Firefox
[task 2020-01-23T09:03:33.656Z] 09:03:33 INFO - mozversion application_remotingname: firefox
[task 2020-01-23T09:03:33.656Z] 09:03:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland
[task 2020-01-23T09:03:33.656Z] 09:03:33 INFO - mozversion application_vendor: Mozilla
[task 2020-01-23T09:03:33.656Z] 09:03:33 INFO - mozversion application_version: 74.0a1
[task 2020-01-23T09:03:33.656Z] 09:03:33 INFO - mozversion platform_buildid: 20200123055728
[task 2020-01-23T09:03:33.656Z] 09:03:33 INFO - mozversion platform_changeset: c0d7cf71074de0d9ccadb96de2d98dec211e6d2f
[task 2020-01-23T09:03:33.656Z] 09:03:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland
[task 2020-01-23T09:03:33.657Z] 09:03:33 INFO - mozversion platform_version: 74.0a1
[task 2020-01-23T09:03:37.735Z] 09:03:37 INFO - Using 1 client processes
[task 2020-01-23T09:03:43.115Z] 09:03:43 INFO - SUITE-START | Running 1 tests
[task 2020-01-23T09:03:43.115Z] 09:03:43 INFO - Running testharness tests
[task 2020-01-23T09:03:43.138Z] 09:03:43 INFO - Setting up ssl
[task 2020-01-23T09:03:43.185Z] 09:03:43 INFO - certutil |
[task 2020-01-23T09:03:43.240Z] 09:03:43 INFO - certutil |
[task 2020-01-23T09:03:43.259Z] 09:03:43 INFO - certutil |
[task 2020-01-23T09:03:43.259Z] 09:03:43 INFO - Certificate Nickname Trust Attributes
[task 2020-01-23T09:03:43.259Z] 09:03:43 INFO - SSL,S/MIME,JAR/XPI
[task 2020-01-23T09:03:43.259Z] 09:03:43 INFO -
[task 2020-01-23T09:03:43.259Z] 09:03:43 INFO - web-platform-tests CT,,
[task 2020-01-23T09:03:43.259Z] 09:03:43 INFO -
[task 2020-01-23T09:03:43.259Z] 09:03:43 INFO - Application command: Z:\task_1579768369\build\application\firefox\firefox.exe -marionette about:blank --wait-for-browser -profile c:\users\task_1579768369\appdata\local\temp\tmpiuubev.mozrunner
[task 2020-01-23T09:03:43.266Z] 09:03:43 INFO - Starting runner
[task 2020-01-23T09:03:43.685Z] 09:03:43 INFO - PID 3536 | 1579770223684 addons.webextension.doh-rollout@mozilla.org WARN Loading extension 'doh-rollout@mozilla.org': Reading manifest: Invalid extension permission: networkStatus
[task 2020-01-23T09:03:44.566Z] 09:03:44 INFO - PID 3536 | 1579770224562 addons.webextension.screenshots@mozilla.org WARN Loading extension 'screenshots@mozilla.org': Reading manifest: Invalid extension permission: mozillaAddons
[task 2020-01-23T09:03:44.566Z] 09:03:44 INFO - PID 3536 | 1579770224562 addons.webextension.screenshots@mozilla.org WARN Loading extension 'screenshots@mozilla.org': Reading manifest: Invalid extension permission: telemetry
[task 2020-01-23T09:03:44.566Z] 09:03:44 INFO - PID 3536 | 1579770224562 addons.webextension.screenshots@mozilla.org WARN Loading extension 'screenshots@mozilla.org': Reading manifest: Invalid extension permission: resource://pdf.js/
[task 2020-01-23T09:03:44.566Z] 09:03:44 INFO - PID 3536 | 1579770224562 addons.webextension.screenshots@mozilla.org WARN Loading extension 'screenshots@mozilla.org': Reading manifest: Invalid extension permission: about:reader*
[task 2020-01-23T09:03:46.362Z] 09:03:46 INFO - PID 3536 | 1579770226359 Marionette INFO Listening on port 49520
[task 2020-01-23T09:03:46.656Z] 09:03:46 INFO - TEST-START | /webrtc/RTCPeerConnection-setLocalDescription-answer.html

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

Status: NEW → RESOLVED
Closed: 5 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.