Open Bug 1912640 Opened 3 months ago Updated 3 months ago

Intermittent TV TinderboxPrint: Per-test run of .../control-active-with-multiple-clicks.html<br/>: FAILURE

Categories

(Testing :: web-platform-tests, defect, P5)

Product:
Testing
Component:
web-platform-tests
Type:
defect

Tracking

(firefox-esr115 unaffected, firefox-esr128 unaffected, firefox129 unaffected, firefox130 unaffected, firefox131 affected)

Tracking Flags:
Tracking Status
firefox-esr115 --- unaffected
firefox-esr128 --- unaffected
firefox129 --- unaffected
firefox130 --- unaffected
firefox131 --- affected

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Regression)

Details

(Keywords: intermittent-failure, regression, test-verify-fail)

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

[task 2024-08-11T07:26:45.646Z] 07:26:45     INFO - TEST-OK | /html/semantics/forms/the-label-element/control-active-with-multiple-clicks.html | took 8804ms
[task 2024-08-11T07:26:45.647Z] 07:26:45     INFO - No more tests
[task 2024-08-11T07:26:45.648Z] 07:26:45     INFO - PID 5023 | 1723361205647	Marionette	INFO	Stopped listening on port 50208
[task 2024-08-11T07:26:46.236Z] 07:26:46     INFO - Browser exited with return code 0
[task 2024-08-11T07:26:46.237Z] 07:26:46     INFO - Closing logging queue
[task 2024-08-11T07:26:46.238Z] 07:26:46     INFO - queue closed
[task 2024-08-11T07:26:46.256Z] 07:26:46     INFO - SUITE-END | took 90s
[task 2024-08-11T07:26:46.257Z] 07:26:46     INFO - Got 0 unexpected results, with 0 unexpected passes
[task 2024-08-11T07:26:46.258Z] 07:26:46     INFO - wptserve Stopped WebTransport over HTTP/3 server on 127.0.0.1:11000
[task 2024-08-11T07:26:46.358Z] 07:26:46     INFO - wptserve Stopped http server on 127.0.0.1:8000
[task 2024-08-11T07:26:46.358Z] 07:26:46     INFO - wptserve Stopped http server on 127.0.0.1:8002
[task 2024-08-11T07:26:46.358Z] 07:26:46     INFO - wptserve Stopped http server on 127.0.0.1:8444
[task 2024-08-11T07:26:46.359Z] 07:26:46     INFO - wptserve Stopped http server on 127.0.0.1:8445
[task 2024-08-11T07:26:46.383Z] 07:26:46     INFO - wptserve Close on: (<AddressFamily.AF_INET: 2>, <SocketKind.SOCK_STREAM: 1>, 6, '', ('127.0.0.1', 8888))
[task 2024-08-11T07:26:46.384Z] 07:26:46     INFO - wptserve Close on: (<AddressFamily.AF_INET: 2>, <SocketKind.SOCK_STREAM: 1>, 6, '', ('127.0.0.1', 8889))
[task 2024-08-11T07:26:46.384Z] 07:26:46     INFO - wptserve Stopped http server on 127.0.0.1:8003
[task 2024-08-11T07:26:46.573Z] 07:26:46     INFO - wptserve Stopped http server on 127.0.0.1:9000
[task 2024-08-11T07:26:46.627Z] 07:26:46     INFO - wptserve Stopped http server on 127.0.0.1:8001
[task 2024-08-11T07:26:46.628Z] 07:26:46     INFO - wptserve Stopped http server on 127.0.0.1:8443
[task 2024-08-11T07:26:46.628Z] 07:26:46     INFO - wptserve Stopped http server on 127.0.0.1:8446
[task 2024-08-11T07:26:46.763Z] 07:26:46     INFO - Closing logging queue
[task 2024-08-11T07:26:46.763Z] 07:26:46     INFO - queue closed
[task 2024-08-11T07:26:46.821Z] 07:26:46     INFO - ::: Ran 10 of expected 10 iterations.
[task 2024-08-11T07:26:46.821Z] 07:26:46     INFO - ## All results ##
[task 2024-08-11T07:26:46.821Z] 07:26:46     INFO - 
[task 2024-08-11T07:26:46.822Z] 07:26:46     INFO - ### /html/semantics/forms/the-label-element/control-active-with-multiple-clicks.html ###
[task 2024-08-11T07:26:46.822Z] 07:26:46     INFO - |                                        Subtest                                        | Results | Messages |
[task 2024-08-11T07:26:46.822Z] 07:26:46     INFO - |---------------------------------------------------------------------------------------|---------|----------|
[task 2024-08-11T07:26:46.823Z] 07:26:46     INFO - |                                                                                       | OK      |          |
[task 2024-08-11T07:26:46.823Z] 07:26:46     INFO - | `Control should be :active on mousedown when clicking the label twice in succession.` | PASS    |          |
[task 2024-08-11T07:26:46.823Z] 07:26:46     INFO - 
[task 2024-08-11T07:26:46.823Z] 07:26:46     INFO - ## Slow tests ##
[task 2024-08-11T07:26:46.824Z] 07:26:46     INFO - 
[task 2024-08-11T07:26:46.824Z] 07:26:46     INFO - |                                        Test                                        | Result | Longest duration (ms) | Timeout (ms) |
[task 2024-08-11T07:26:46.824Z] 07:26:46     INFO - |------------------------------------------------------------------------------------|--------|-----------------------|--------------|
[task 2024-08-11T07:26:46.825Z] 07:26:46     INFO - | `/html/semantics/forms/the-label-element/control-active-with-multiple-clicks.html` | `OK`   | `9360`                | `10000`      |
[task 2024-08-11T07:26:46.825Z] 07:26:46     INFO - 
[task 2024-08-11T07:26:46.825Z] 07:26:46     INFO - ::: Running tests in a loop 10 times : FAIL
[task 2024-08-11T07:26:46.825Z] 07:26:46     INFO - :::
[task 2024-08-11T07:26:46.826Z] 07:26:46    ERROR - ::: Test verification FAIL
[task 2024-08-11T07:26:46.826Z] 07:26:46     INFO - :::
[task 2024-08-11T07:26:47.238Z] 07:26:47     INFO - Return code: 1
[task 2024-08-11T07:26:47.239Z] 07:26:47  WARNING - setting return code to 2
[task 2024-08-11T07:26:47.239Z] 07:26:47    ERROR - TinderboxPrint: Per-test run of .../control-active-with-multiple-clicks.html<br/>: FAILURE
[task 2024-08-11T07:26:47.239Z] 07:26:47     INFO - Running post-action listener: _package_coverage_data
[task 2024-08-11T07:26:47.239Z] 07:26:47     INFO - Running post-action listener: _resource_record_post_action
[task 2024-08-11T07:26:47.239Z] 07:26:47     INFO - Running post-action listener: process_java_coverage_data
[task 2024-08-11T07:26:47.239Z] 07:26:47     INFO - Running post-action listener: stop_device
[task 2024-08-11T07:26:47.239Z] 07:26:47     INFO - [mozharness: 2024-08-11 07:26:47.239754Z] Finished run-tests step (success)
[task 2024-08-11T07:26:47.239Z] 07:26:47     INFO - Running post-run listener: _resource_record_post_run
[task 2024-08-11T07:26:47.544Z] 07:26:47     INFO - Total resource usage - Wall time: 384s; CPU: 14%; Read bytes: 81510400; Write bytes: 2184978432; Read time: 2201; Write time: 6352
[task 2024-08-11T07:26:47.544Z] 07:26:47     INFO - TinderboxPrint: CPU usage<br/>13.9%
[task 2024-08-11T07:26:47.544Z] 07:26:47     INFO - TinderboxPrint: I/O read bytes / time<br/>81,510,400 / 2,201
[task 2024-08-11T07:26:47.544Z] 07:26:47     INFO - TinderboxPrint: I/O write bytes / time<br/>2,184,978,432 / 6,352
[task 2024-08-11T07:26:47.544Z] 07:26:47     INFO - TinderboxPrint: CPU idle<br/>3,989.5 (86.6%)
[task 2024-08-11T07:26:47.544Z] 07:26:47     INFO - TinderboxPrint: CPU system<br/>166.5 (3.6%)
[task 2024-08-11T07:26:47.544Z] 07:26:47     INFO - TinderboxPrint: CPU user<br/>450.3 (9.8%)
[task 2024-08-11T07:26:47.544Z] 07:26:47     INFO - TinderboxPrint: Swap in / out<br/>354,254,848 / 0
[task 2024-08-11T07:26:47.545Z] 07:26:47     INFO - pull - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2024-08-11T07:26:47.545Z] 07:26:47     INFO - start-emulator - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2024-08-11T07:26:47.546Z] 07:26:47     INFO - verify-device - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2024-08-11T07:26:47.548Z] 07:26:47     INFO - install - Wall time: 23s; CPU: 14%; Read bytes: 304174592; Write bytes: 300326912; Read time: 20345; Write time: 496
[task 2024-08-11T07:26:47.566Z] 07:26:47     INFO - run-tests - Wall time: 361s; CPU: 14%; Read bytes: 77537280; Write bytes: 1884545024; Read time: 2064; Write time: 5855
[task 2024-08-11T07:26:48.174Z] 07:26:48  WARNING - returning nonzero exit status 2
[taskcluster 2024-08-11T07:26:48.543Z]    Exit Code: 2
[taskcluster 2024-08-11T07:26:48.543Z]    User Time: 7m19.77768s
[taskcluster 2024-08-11T07:26:48.543Z]  Kernel Time: 2m9.578849s
[taskcluster 2024-08-11T07:26:48.543Z]    Wall Time: 7m45.168438s
[taskcluster 2024-08-11T07:26:48.543Z]       Result: FAILED
[taskcluster 2024-08-11T07:26:48.543Z] === Task Finished ===
[taskcluster 2024-08-11T07:26:48.543Z] Task Duration: 7m45.173698s
[taskcluster 2024-08-11T07:26:48.888Z] Uploading artifact public/logs/localconfig.json from file /opt/worker/tasks/task_172335514260774/logs/localconfig.json with content encoding "gzip", mime type "application/json" and expiry 2025-08-11T06:34:30.694Z
[taskcluster 2024-08-11T07:26:49.209Z] Uploading artifact public/test_info/profile_resource-usage.json from file /opt/worker/tasks/task_172335514260774/build/blobber_upload_dir/profile_resource-usage.json with content encoding "gzip", mime type "application/json" and expiry 2025-08-11T06:34:30.694Z
[taskcluster 2024-08-11T07:26:49.485Z] Uploading artifact public/test_info/resource-usage.json from file /opt/worker/tasks/task_172335514260774/build/blobber_upload_dir/resource-usage.json with content encoding "gzip", mime type "application/json" and expiry 2025-08-11T06:34:30.694Z
[taskcluster 2024-08-11T07:26:49.826Z] Uploading artifact public/test_info/wpt-test1_errorsummary.log from file /opt/worker/tasks/task_172335514260774/build/blobber_upload_dir/wpt-test1_errorsummary.log with content encoding "gzip", mime type "text/plain" and expiry 2025-08-11T06:34:30.694Z
[taskcluster 2024-08-11T07:26:50.088Z] Uploading artifact public/test_info/wpt-test2_errorsummary.log from file /opt/worker/tasks/task_172335514260774/build/blobber_upload_dir/wpt-test2_errorsummary.log with content encoding "gzip", mime type "text/plain" and expiry 2025-08-11T06:34:30.694Z
[taskcluster 2024-08-11T07:26:50.440Z] Uploading artifact public/test_info/wpt-test3_errorsummary.log from file /opt/worker/tasks/task_172335514260774/build/blobber_upload_dir/wpt-test3_errorsummary.log with content encoding "gzip", mime type "text/plain" and expiry 2025-08-11T06:34:30.694Z
[taskcluster 2024-08-11T07:26:50.699Z] Uploading artifact public/test_info/wpt-test4_errorsummary.log from file /opt/worker/tasks/task_172335514260774/build/blobber_upload_dir/wpt-test4_errorsummary.log with content encoding "gzip", mime type "text/plain" and expiry 2025-08-11T06:34:30.694Z
[taskcluster 2024-08-11T07:26:50.956Z] Uploading artifact public/test_info/wpt-test5_errorsummary.log from file /opt/worker/tasks/task_172335514260774/build/blobber_upload_dir/wpt-test5_errorsummary.log with content encoding "gzip", mime type "text/plain" and expiry 2025-08-11T06:34:30.694Z
[taskcluster 2024-08-11T07:26:51.215Z] Uploading artifact public/test_info/wpt-test6_errorsummary.log from file /opt/worker/tasks/task_172335514260774/build/blobber_upload_dir/wpt-test6_errorsummary.log with content encoding "gzip", mime type "text/plain" and expiry 2025-08-11T06:34:30.694Z
[taskcluster 2024-08-11T07:26:51.489Z] Uploading artifact public/test_info/wpt-test7_errorsummary.log from file /opt/worker/tasks/task_172335514260774/build/blobber_upload_dir/wpt-test7_errorsummary.log with content encoding "gzip", mime type "text/plain" and expiry 2025-08-11T06:34:30.694Z
[taskcluster 2024-08-11T07:26:51.757Z] Uploading artifact public/test_info/wpt_instruments.txt from file /opt/worker/tasks/task_172335514260774/build/blobber_upload_dir/wpt_instruments.txt with content encoding "gzip", mime type "text/plain; charset=utf-8" and expiry 2025-08-11T06:34:30.694Z
[taskcluster 2024-08-11T07:26:52.014Z] Uploading artifact public/test_info/wptreport.json from file /opt/worker/tasks/task_172335514260774/build/blobber_upload_dir/wptreport.json with content encoding "gzip", mime type "application/json" and expiry 2025-08-11T06:34:30.694Z
[taskcluster 2024-08-11T07:26:52.287Z] Uploading link artifact public/logs/live.log to artifact public/logs/live_backing.log with expiry 2025-08-11T06:34:30.694Z
[taskcluster:error] exit status 2

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

status-firefox129: --- → unaffected
status-firefox130: --- → unaffected
status-firefox131: --- → affected
status-firefox-esr115: --- → unaffected
status-firefox-esr128: --- → unaffected
You need to log in before you can comment on or make changes to this bug.