Closed Bug 1760566 Opened 2 years ago Closed 2 years ago

Intermittent TVw TinderboxPrint: Per-test run of ...\calc-margins-table-caption.html<br/>: FAILURE

Categories

(Core :: Layout, defect, P5)

Product:
Core
Component:
Layout
Type:
defect

Tracking

()

Status:
RESOLVED DUPLICATE of bug 1760565
Tracking Flags:
Tracking Status
firefox-esr91 --- unaffected
firefox98 --- unaffected
firefox99 --- unaffected
firefox100 --- affected

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Regression)

Details

(Keywords: intermittent-failure, regression)

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

[task 2022-03-21T09:46:14.001Z] 09:46:14     INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2022-03-21T09:46:14.003Z] 09:46:14     INFO - Closing logging queue
[task 2022-03-21T09:46:14.003Z] 09:46:14     INFO - queue closed
[task 2022-03-21T09:46:14.004Z] 09:46:14  WARNING - Firefox didn't exit cleanly, not processing leak logs
[task 2022-03-21T09:46:14.221Z] 09:46:14     INFO - Got 0 unexpected results, with 0 unexpected passes
[task 2022-03-21T09:46:14.225Z] 09:46:14     INFO - SUITE-END | took 9s
[task 2022-03-21T09:46:14.316Z] 09:46:14     INFO - wptserve Stopped http server on 127.0.0.1:8000
[task 2022-03-21T09:46:14.596Z] 09:46:14     INFO - wptserve Stopped http server on 127.0.0.1:8001
[task 2022-03-21T09:46:14.598Z] 09:46:14     INFO - wptserve Stopped http server on 127.0.0.1:8002
[task 2022-03-21T09:46:14.599Z] 09:46:14     INFO - wptserve Stopped http server on 127.0.0.1:8003
[task 2022-03-21T09:46:14.628Z] 09:46:14     INFO - wptserve Stopped http server on 127.0.0.1:8443
[task 2022-03-21T09:46:14.643Z] 09:46:14     INFO - wptserve Stopped http server on 127.0.0.1:8444
[task 2022-03-21T09:46:14.674Z] 09:46:14     INFO - wptserve Close on: (<AddressFamily.AF_INET: 2>, <SocketKind.SOCK_STREAM: 1>, 6, '', ('127.0.0.1', 8889))
[task 2022-03-21T09:46:14.676Z] 09:46:14     INFO - wptserve Close on: (<AddressFamily.AF_INET: 2>, <SocketKind.SOCK_STREAM: 1>, 6, '', ('127.0.0.1', 8888))
[task 2022-03-21T09:46:14.677Z] 09:46:14     INFO - wptserve Stopped http server on 127.0.0.1:8445
[task 2022-03-21T09:46:14.677Z] 09:46:14     INFO - wptserve Stopped http server on 127.0.0.1:8446
[task 2022-03-21T09:46:14.721Z] 09:46:14     INFO - wptserve Stopped http server on 127.0.0.1:9000
[task 2022-03-21T09:46:14.752Z] 09:46:14     INFO - Removed font: Ahem.ttf
[task 2022-03-21T09:46:14.817Z] 09:46:14     INFO - Closing logging queue
[task 2022-03-21T09:46:14.818Z] 09:46:14     INFO - queue closed
[task 2022-03-21T09:46:14.862Z] 09:46:14     INFO - ::: Ran 1 of expected 10 iterations.
[task 2022-03-21T09:46:14.867Z] 09:46:14     INFO - ::: Reached iteration timeout before finishing 2 or more repeat runs.
[task 2022-03-21T09:46:14.867Z] 09:46:14     INFO - ::: At least 2 successful repeat runs are required to validate stability.
[task 2022-03-21T09:46:14.868Z] 09:46:14     INFO - ::: Running tests in a loop 10 times : FAIL
[task 2022-03-21T09:46:14.868Z] 09:46:14     INFO - :::
[task 2022-03-21T09:46:14.869Z] 09:46:14  WARNING - ::: Test verification TIMEOUT
[task 2022-03-21T09:46:14.869Z] 09:46:14     INFO - :::
[task 2022-03-21T09:46:15.148Z] 09:46:15    ERROR - Return code: 1
[task 2022-03-21T09:46:15.149Z] 09:46:15    ERROR - # TBPL FAILURE #
[task 2022-03-21T09:46:15.149Z] 09:46:15  WARNING - setting return code to 2
[task 2022-03-21T09:46:15.149Z] 09:46:15    ERROR - TinderboxPrint: Per-test run of ...\calc-margins-table-caption.html<br/>: FAILURE
[task 2022-03-21T09:46:15.152Z] 09:46:15     INFO - Running command: ['Z:\\task_164785417073044\\build\\venv\\Scripts\\python', '-u', 'Z:\\task_164785417073044\\build\\tests\\web-platform\\runtests.py', '--log-raw=-', '--log-raw=Z:\\task_164785417073044\\build\\blobber_upload_dir\\wpt-test2_raw.log', '--log-wptreport=Z:\\task_164785417073044\\build\\blobber_upload_dir\\wptreport.json', '--log-errorsummary=Z:\\task_164785417073044\\build\\blobber_upload_dir\\wpt-test2_errorsummary.log', '--symbols-path=Z:\\task_164785417073044\\build\\symbols', '--stackwalk-binary=Z:/task_164785417073044/fetches\\minidump-stackwalk\\minidump-stackwalk.exe', '--stackfix-dir=Z:\\task_164785417073044\\build\\tests\\bin', '--no-pause-after-test', '--instrument-to-file=Z:\\task_164785417073044\\build\\blobber_upload_dir\\wpt_instruments.txt', '--specialpowers-path=Z:\\task_164785417073044\\build\\tests\\extensions\\specialpowers@mozilla.org.xpi', '--processes=1', '--binary=Z:\\task_164785417073044\\build\\application\\firefox\\firefox.exe', '--install-fonts', '--test-type=reftest', '--setpref=fission.autostart=true', '--setpref=media.peerconnection.mtransport_process=false', '--setpref=network.process.enabled=false', '--setpref=layers.d3d11.enable-blacklist=false', '--prefs-root=Z:\\task_164785417073044\\build\\tests\\web-platform/prefs', '--config=Z:\\task_164785417073044\\build\\tests\\web-platform/wptrunner.ini', '--ca-cert-path=Z:\\task_164785417073044\\build\\tests\\web-platform/tests/tools/certs/cacert.pem', '--host-key-path=Z:\\task_164785417073044\\build\\tests\\web-platform/tests/tools/certs/web-platform.test.key', '--host-cert-path=Z:\\task_164785417073044\\build\\tests\\web-platform/tests/tools/certs/web-platform.test.pem', '--certutil-binary=Z:\\task_164785417073044\\build\\tests/bin/certutil', '--verify-log-full', '--verify', 'tests/web-platform/tests/css/css-tables/tentative/section-no-tbody-fixed-distribution.html'] in Z:\task_164785417073044\build
[task 2022-03-21T09:46:15.153Z] 09:46:15     INFO - Copy/paste: Z:\task_164785417073044\build\venv\Scripts\python -u Z:\task_164785417073044\build\tests\web-platform\runtests.py --log-raw=- --log-raw=Z:\task_164785417073044\build\blobber_upload_dir\wpt-test2_raw.log --log-wptreport=Z:\task_164785417073044\build\blobber_upload_dir\wptreport.json --log-errorsummary=Z:\task_164785417073044\build\blobber_upload_dir\wpt-test2_errorsummary.log --symbols-path=Z:\task_164785417073044\build\symbols --stackwalk-binary=Z:/task_164785417073044/fetches\minidump-stackwalk\minidump-stackwalk.exe --stackfix-dir=Z:\task_164785417073044\build\tests\bin --no-pause-after-test --instrument-to-file=Z:\task_164785417073044\build\blobber_upload_dir\wpt_instruments.txt --specialpowers-path=Z:\task_164785417073044\build\tests\extensions\specialpowers@mozilla.org.xpi --processes=1 --binary=Z:\task_164785417073044\build\application\firefox\firefox.exe --install-fonts --test-type=reftest --setpref=fission.autostart=true --setpref=media.peerconnection.mtransport_process=false --setpref=network.process.enabled=false --setpref=layers.d3d11.enable-blacklist=false --prefs-root=Z:\task_164785417073044\build\tests\web-platform/prefs --config=Z:\task_164785417073044\build\tests\web-platform/wptrunner.ini --ca-cert-path=Z:\task_164785417073044\build\tests\web-platform/tests/tools/certs/cacert.pem --host-key-path=Z:\task_164785417073044\build\tests\web-platform/tests/tools/certs/web-platform.test.key --host-cert-path=Z:\task_164785417073044\build\tests\web-platform/tests/tools/certs/web-platform.test.pem --certutil-binary=Z:\task_164785417073044\build\tests/bin/certutil --verify-log-full --verify tests/web-platform/tests/css/css-tables/tentative/section-no-tbody-fixed-distribution.html
[task 2022-03-21T09:46:15.153Z] 09:46:15     INFO - Using env: (same as previous command)
[task 2022-03-21T09:46:15.153Z] 09:46:15     INFO - Calling ['Z:\\task_164785417073044\\build\\venv\\Scripts\\python', '-u', 'Z:\\task_164785417073044\\build\\tests\\web-platform\\runtests.py', '--log-raw=-', '--log-raw=Z:\\task_164785417073044\\build\\blobber_upload_dir\\wpt-test2_raw.log', '--log-wptreport=Z:\\task_164785417073044\\build\\blobber_upload_dir\\wptreport.json', '--log-errorsummary=Z:\\task_164785417073044\\build\\blobber_upload_dir\\wpt-test2_errorsummary.log', '--symbols-path=Z:\\task_164785417073044\\build\\symbols', '--stackwalk-binary=Z:/task_164785417073044/fetches\\minidump-stackwalk\\minidump-stackwalk.exe', '--stackfix-dir=Z:\\task_164785417073044\\build\\tests\\bin', '--no-pause-after-test', '--instrument-to-file=Z:\\task_164785417073044\\build\\blobber_upload_dir\\wpt_instruments.txt', '--specialpowers-path=Z:\\task_164785417073044\\build\\tests\\extensions\\specialpowers@mozilla.org.xpi', '--processes=1', '--binary=Z:\\task_164785417073044\\build\\application\\firefox\\firefox.exe', '--install-fonts', '--test-type=reftest', '--setpref=fission.autostart=true', '--setpref=media.peerconnection.mtransport_process=false', '--setpref=network.process.enabled=false', '--setpref=layers.d3d11.enable-blacklist=false', '--prefs-root=Z:\\task_164785417073044\\build\\tests\\web-platform/prefs', '--config=Z:\\task_164785417073044\\build\\tests\\web-platform/wptrunner.ini', '--ca-cert-path=Z:\\task_164785417073044\\build\\tests\\web-platform/tests/tools/certs/cacert.pem', '--host-key-path=Z:\\task_164785417073044\\build\\tests\\web-platform/tests/tools/certs/web-platform.test.key', '--host-cert-path=Z:\\task_164785417073044\\build\\tests\\web-platform/tests/tools/certs/web-platform.test.pem', '--certutil-binary=Z:\\task_164785417073044\\build\\tests/bin/certutil', '--verify-log-full', '--verify', 'tests/web-platform/tests/css/css-tables/tentative/section-no-tbody-fixed-distribution.html'] with output_timeout 1000
[task 2022-03-21T09:46:15.493Z] 09:46:15     INFO - :::
[task 2022-03-21T09:46:15.493Z] 09:46:15     INFO - ::: Running test verification step "Running tests in a loop 10 times"...
Regressed by: 1757450

:mozilla.org, since you are the author of the regressor, bug 1757450, could you take a look?
For more information, please visit auto_nag documentation.

Flags: needinfo?(wptsync)

Set release status flags based on info from the regressing bug 1757450

status-firefox100: --- → affected
status-firefox98: --- → unaffected
status-firefox99: --- → unaffected
status-firefox-esr91: --- → unaffected
Has Regression Range: --- → yes

This seems to be the same thing as bug 1760565.

The log that's linked from comment 0 clearly shows us running the test 10 times in a loop (labeled 0/10 up to 9/10), in 9 seconds (SUITE-END | took 9s); but then the harness apparently fails to see that, and instead declares that we Ran 1 of expected 10 iterations [...] Reached iteration timeout before finishing 2 or more repeat runs.

Status: NEW → RESOLVED
Closed: 2 years ago
Resolution: --- → DUPLICATE
Flags: needinfo?(wptsync)
You need to log in before you can comment on or make changes to this bug.