Open
Bug 1909057
Opened 1 year ago
Updated 1 year ago
Intermittent TVw2 ::: Test verification FAIL | TinderboxPrint: Per-test run of .../storage-access-permission.sub.https.window.js<br/>: FAILURE
Categories
(Core :: Privacy: Anti-Tracking, defect, P5)
Core
Privacy: Anti-Tracking
Tracking
()
NEW
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure, test-verify-fail)
Filed by: nfay [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=467236912&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/YNZGBCg6SLWWM7CYeAyK1Q/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/YNZGBCg6SLWWM7CYeAyK1Q/runs/1/artifacts/public/logs/live_backing.log&only_show_unexpected=1
[task 2024-07-20T16:41:49.986Z] 16:41:49 INFO - TEST-START | /storage-access-api/storage-access-permission.sub.https.window.html
[task 2024-07-20T16:41:49.986Z] 16:41:49 INFO - Run 10/10
[task 2024-07-20T16:41:49.991Z] 16:41:49 INFO - Closing window 2997fe78-8d04-4db6-b92f-1c520164ee56
[task 2024-07-20T16:41:51.128Z] 16:41:51 INFO -
[task 2024-07-20T16:41:51.128Z] 16:41:51 INFO - TEST-KNOWN-INTERMITTENT-PASS | /storage-access-api/storage-access-permission.sub.https.window.html | Permissions grants are observable across same-origin iframes
[task 2024-07-20T16:41:51.128Z] 16:41:51 INFO -
[task 2024-07-20T16:41:51.128Z] 16:41:51 INFO - TEST-KNOWN-INTERMITTENT-PASS | /storage-access-api/storage-access-permission.sub.https.window.html | Permissions grants are observable across same-site iframes
[task 2024-07-20T16:41:51.128Z] 16:41:51 INFO -
[task 2024-07-20T16:41:51.128Z] 16:41:51 INFO - TEST-KNOWN-INTERMITTENT-PASS | /storage-access-api/storage-access-permission.sub.https.window.html | IFrame tests
[task 2024-07-20T16:41:51.128Z] 16:41:51 INFO - ....
[task 2024-07-20T16:41:51.128Z] 16:41:51 INFO - TEST-OK | /storage-access-api/storage-access-permission.sub.https.window.html | took 1140ms
[task 2024-07-20T16:41:51.128Z] 16:41:51 INFO - No more tests
[task 2024-07-20T16:41:51.135Z] 16:41:51 INFO - PID 3118 | 1721493711130 Marionette INFO Stopped listening on port 51256
[task 2024-07-20T16:41:52.056Z] 16:41:52 INFO - Browser exited with return code 0
[task 2024-07-20T16:41:52.058Z] 16:41:52 INFO - Closing logging queue
[task 2024-07-20T16:41:52.059Z] 16:41:52 INFO - queue closed
[task 2024-07-20T16:41:52.069Z] 16:41:52 INFO - SUITE-END | took 17s
[task 2024-07-20T16:41:52.069Z] 16:41:52 INFO - Got 0 unexpected results, with 0 unexpected passes
[task 2024-07-20T16:41:52.071Z] 16:41:52 INFO - wptserve Stopped WebTransport over HTTP/3 server on 127.0.0.1:11000
[task 2024-07-20T16:41:52.183Z] 16:41:52 INFO - wptserve Stopped http server on 127.0.0.1:8443
[task 2024-07-20T16:41:52.333Z] 16:41:52 INFO - wptserve Stopped http server on 127.0.0.1:8000
[task 2024-07-20T16:41:52.528Z] 16:41:52 INFO - wptserve Stopped http server on 127.0.0.1:8001
[task 2024-07-20T16:41:52.529Z] 16:41:52 INFO - wptserve Stopped http server on 127.0.0.1:8444
[task 2024-07-20T16:41:52.530Z] 16:41:52 INFO - wptserve Close on: (<AddressFamily.AF_INET: 2>, <SocketKind.SOCK_STREAM: 1>, 6, '', ('127.0.0.1', 8888))
[task 2024-07-20T16:41:52.531Z] 16:41:52 INFO - wptserve Stopped http server on 127.0.0.1:8446
[task 2024-07-20T16:41:52.534Z] 16:41:52 INFO - wptserve Stopped http server on 127.0.0.1:8002
[task 2024-07-20T16:41:52.534Z] 16:41:52 INFO - wptserve Stopped http server on 127.0.0.1:9000
[task 2024-07-20T16:41:52.534Z] 16:41:52 INFO - wptserve Close on: (<AddressFamily.AF_INET: 2>, <SocketKind.SOCK_STREAM: 1>, 6, '', ('127.0.0.1', 8889))
[task 2024-07-20T16:41:52.534Z] 16:41:52 INFO - wptserve Stopped http server on 127.0.0.1:8003
[task 2024-07-20T16:41:52.534Z] 16:41:52 INFO - wptserve Stopped http server on 127.0.0.1:8445
[task 2024-07-20T16:41:52.677Z] 16:41:52 INFO - Removed font: Ahem.ttf
[task 2024-07-20T16:41:52.728Z] 16:41:52 INFO - Closing logging queue
[task 2024-07-20T16:41:52.729Z] 16:41:52 INFO - queue closed
[task 2024-07-20T16:41:52.760Z] 16:41:52 INFO - ::: Ran 10 of expected 10 iterations.
[task 2024-07-20T16:41:52.761Z] 16:41:52 INFO - ## All results ##
[task 2024-07-20T16:41:52.761Z] 16:41:52 INFO -
[task 2024-07-20T16:41:52.761Z] 16:41:52 INFO - ### /storage-access-api/storage-access-permission.sub.https.window.html ###
[task 2024-07-20T16:41:52.762Z] 16:41:52 INFO - | Subtest | Results | Messages |
[task 2024-07-20T16:41:52.765Z] 16:41:52 INFO - |----------------------------------------------------------------|----------------------------|----------------------------------------------------------------------------|
[task 2024-07-20T16:41:52.765Z] 16:41:52 INFO - | | OK | |
[task 2024-07-20T16:41:52.765Z] 16:41:52 INFO - | `Permissions grants are observable across same-origin iframes` | **FAIL: 2/10, PASS: 8/10** | `assert_equals: expected (string) "granted" but got (undefined) undefined` |
[task 2024-07-20T16:41:52.765Z] 16:41:52 INFO - | `Permissions grants are observable across same-site iframes` | PASS | |
[task 2024-07-20T16:41:52.765Z] 16:41:52 INFO - | `IFrame tests` | PASS | |
[task 2024-07-20T16:41:52.765Z] 16:41:52 INFO - | `Permission default state can be queried` | PASS | |
[task 2024-07-20T16:41:52.765Z] 16:41:52 INFO - | `Permission granted state can be queried` | PASS | |
[task 2024-07-20T16:41:52.765Z] 16:41:52 INFO - | `Permission denied state is hidden` | PASS | |
[task 2024-07-20T16:41:52.765Z] 16:41:52 INFO - | `Permission state can be observed` | PASS | |
[task 2024-07-20T16:41:52.765Z] 16:41:52 INFO -
[task 2024-07-20T16:41:52.765Z] 16:41:52 INFO - ## Unstable results ##
[task 2024-07-20T16:41:52.765Z] 16:41:52 INFO -
[task 2024-07-20T16:41:52.765Z] 16:41:52 INFO - | Test | Subtest | Results | Messages |
[task 2024-07-20T16:41:52.765Z] 16:41:52 INFO - |-----------------------------------------------------------------------|----------------------------------------------------------------|----------------------------|----------------------------------------------------------------------------|
[task 2024-07-20T16:41:52.765Z] 16:41:52 INFO - | `/storage-access-api/storage-access-permission.sub.https.window.html` | `Permissions grants are observable across same-origin iframes` | **FAIL: 2/10, PASS: 8/10** | `assert_equals: expected (string) "granted" but got (undefined) undefined` |
[task 2024-07-20T16:41:52.766Z] 16:41:52 INFO -
[task 2024-07-20T16:41:52.766Z] 16:41:52 INFO - ::: Running tests in a loop 10 times : FAIL
[task 2024-07-20T16:41:52.766Z] 16:41:52 INFO - :::
[task 2024-07-20T16:41:52.767Z] 16:41:52 ERROR - ::: Test verification FAIL
[task 2024-07-20T16:41:52.767Z] 16:41:52 INFO - :::
[task 2024-07-20T16:41:53.143Z] 16:41:53 INFO - Return code: 1
[task 2024-07-20T16:41:53.144Z] 16:41:53 WARNING - setting return code to 2
[task 2024-07-20T16:41:53.144Z] 16:41:53 ERROR - TinderboxPrint: Per-test run of .../storage-access-permission.sub.https.window.js<br/>: FAILURE
[task 2024-07-20T16:41:53.144Z] 16:41:53 INFO - Running post-action listener: _package_coverage_data
[task 2024-07-20T16:41:53.144Z] 16:41:53 INFO - Running post-action listener: _resource_record_post_action
[task 2024-07-20T16:41:53.144Z] 16:41:53 INFO - Running post-action listener: process_java_coverage_data
[task 2024-07-20T16:41:53.144Z] 16:41:53 INFO - Running post-action listener: stop_device
[task 2024-07-20T16:41:53.144Z] 16:41:53 INFO - [mozharness: 2024-07-20 16:41:53.144282Z] Finished run-tests step (success)
[task 2024-07-20T16:41:53.144Z] 16:41:53 INFO - Running post-run listener: _resource_record_post_run
[task 2024-07-20T16:41:53.360Z] 16:41:53 INFO - Total resource usage - Wall time: 85s; CPU: 40%; Read bytes: 0; Write bytes: 649478144; Read time: 0; Write time: 330480
[task 2024-07-20T16:41:53.360Z] 16:41:53 INFO - TinderboxPrint: CPU usage<br/>40.2%
[task 2024-07-20T16:41:53.360Z] 16:41:53 INFO - TinderboxPrint: I/O read bytes / time<br/>0 / 0
[task 2024-07-20T16:41:53.360Z] 16:41:53 INFO - TinderboxPrint: I/O write bytes / time<br/>649,478,144 / 330,480
[task 2024-07-20T16:41:53.360Z] 16:41:53 INFO - TinderboxPrint: CPU idle<br/>186.8 (55.4%)
[task 2024-07-20T16:41:53.360Z] 16:41:53 INFO - TinderboxPrint: CPU iowait<br/>15.0 (4.5%)
[task 2024-07-20T16:41:53.361Z] 16:41:53 INFO - TinderboxPrint: CPU system<br/>16.7 (5.0%)
[task 2024-07-20T16:41:53.361Z] 16:41:53 INFO - TinderboxPrint: CPU user<br/>117.6 (34.9%)
[task 2024-07-20T16:41:53.361Z] 16:41:53 INFO - TinderboxPrint: Swap in / out<br/>0 / 0
[task 2024-07-20T16:41:53.361Z] 16:41:53 INFO - pull - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2024-07-20T16:41:53.361Z] 16:41:53 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-07-20T16:41:53.361Z] 16:41:53 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-07-20T16:41:53.362Z] 16:41:53 INFO - install - Wall time: 11s; CPU: 25%; Read bytes: 0; Write bytes: 2236416; Read time: 0; Write time: 116
[task 2024-07-20T16:41:53.366Z] 16:41:53 INFO - run-tests - Wall time: 74s; CPU: 42%; Read bytes: 0; Write bytes: 647241728; Read time: 0; Write time: 330364
[task 2024-07-20T16:41:53.498Z] 16:41:53 WARNING - returning nonzero exit status 2
[task 2024-07-20T16:41:53.820Z] cleanup
[task 2024-07-20T16:41:53.820Z] + cleanup
[task 2024-07-20T16:41:53.820Z] + local rv=2
[task 2024-07-20T16:41:53.820Z] + [[ -s /builds/worker/.xsession-errors ]]
[task 2024-07-20T16:41:53.820Z] + cp /builds/worker/.xsession-errors /builds/worker/artifacts/public/xsession-errors.log
[task 2024-07-20T16:41:53.822Z] + '[' ']'
[task 2024-07-20T16:41:53.822Z] + true
[task 2024-07-20T16:41:53.822Z] + cleanup_xvfb
[task 2024-07-20T16:41:53.822Z] ++ pidof Xvfb
[task 2024-07-20T16:41:53.826Z] + local xvfb_pid=50
[task 2024-07-20T16:41:53.826Z] + local vnc=false
[task 2024-07-20T16:41:53.826Z] + local interactive=false
[task 2024-07-20T16:41:53.826Z] + '[' -n 50 ']'
[task 2024-07-20T16:41:53.826Z] + [[ false == false ]]
[task 2024-07-20T16:41:53.826Z] + [[ false == false ]]
[task 2024-07-20T16:41:53.826Z] + kill 50
[task 2024-07-20T16:41:53.826Z] + screen -XS xvfb quit
[task 2024-07-20T16:41:53.846Z] + exit 2
[taskcluster 2024-07-20 16:41:54.334Z] === Task Finished ===
[taskcluster 2024-07-20 16:41:55.944Z] Unsuccessful task run with exit code: 2 completed in 342.894 seconds
| Comment hidden (Intermittent Failures Robot) |
You need to log in
before you can comment on or make changes to this bug.
Description
•