[taskcluster 2026-01-05 10:52:19.047Z] Task ID: Z4elc5LjQ_ml9KyywhOBjg
[taskcluster 2026-01-05 10:52:19.047Z] Worker ID: 2563475770852126190
[taskcluster 2026-01-05 10:52:19.047Z] Worker Group: us-east4-b
[taskcluster 2026-01-05 10:52:19.047Z] Worker Node Type: projects/757942385826/machineTypes/n2-standard-4
[taskcluster 2026-01-05 10:52:19.047Z] Worker Pool: proj-wpt/ci
[taskcluster 2026-01-05 10:52:19.047Z] Worker Version: 46.1.0
[taskcluster 2026-01-05 10:52:19.047Z] Public IP: 34.86.45.165
[taskcluster 2026-01-05 10:52:19.047Z] Hostname: proj-wpt-ci-eteblq2jtcce6yduaeqszw

[taskcluster 2026-01-05 10:52:20.016Z] === Task Starting ===
+ '[' '' ']'
+ '[' -d /etc/profile.d ']'
+ for i in /etc/profile.d/*.sh
+ '[' -r /etc/profile.d/01-locale-fix.sh ']'
+ . /etc/profile.d/01-locale-fix.sh
+++ /usr/bin/locale-check C.UTF-8
++ eval
+ for i in /etc/profile.d/*.sh
+ '[' -r /etc/profile.d/apps-bin-path.sh ']'
+ . /etc/profile.d/apps-bin-path.sh

...(2525 lines hidden)...

 2:41.87 pid:6128 Full command: /home/test/web-platform-tests/_venv3/bin/chrome/chromedriver --port=60667 --ignore-explicit-port --url-base=/ --enable-chrome-logs --disable-build-check
pid:6128 Starting ChromeDriver 145.0.7616.0 (8814538968ac94ac4f1a49b0dc45249a95d9dc12-refs/branch-heads/7616@{#1}) on port 0
PID 6128 | Starting ChromeDriver 145.0.7616.0 (8814538968ac94ac4f1a49b0dc45249a95d9dc12-refs/branch-heads/7616@{#1}) on port 0
 2:41.87 pid:6128 Only local connections are allowed.
PID 6128 | Only local connections are allowed.
 2:41.87 pid:6128 Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
PID 6128 | Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
 2:41.87 pid:6128 ChromeDriver was started successfully on port 33123.
PID 6128 | ChromeDriver was started successfully on port 33123.
 2:41.87 INFO Webdriver started successfully.
Webdriver started successfully.
 2:41.87 INFO Starting runner
Starting runner
 2:42.29 TEST_START: /infrastructure/webdriver/tests/test_load_file.py
TEST-START | /infrastructure/webdriver/tests/test_load_file.py
 2:42.84 INFO STDOUT: ============================= test session starts ==============================
STDOUT: ============================= test session starts ==============================
 2:42.84 INFO STDOUT: platform linux -- Python 3.10.12, pytest-8.2.1, pluggy-unknown -- /usr/bin/python3
STDOUT: platform linux -- Python 3.10.12, pytest-8.2.1, pluggy-unknown -- /usr/bin/python3
 2:42.84 INFO STDOUT: rootdir: /home/test/web-platform-tests
STDOUT: rootdir: /home/test/web-platform-tests
 2:42.85 INFO STDOUT: plugins: asyncio-0.19.0
STDOUT: plugins: asyncio-0.19.0
 2:42.85 INFO STDOUT: asyncio: mode=strict
STDOUT: asyncio: mode=strict
 2:42.85 INFO STDOUT: collecting ... 
STDOUT: collecting ... 
 2:42.92 INFO STDOUT: collected 1 item
STDOUT: collected 1 item
 2:42.92 INFO STDOUT: infrastructure/webdriver/tests/test_load_file.py::test_load 
STDOUT: infrastructure/webdriver/tests/test_load_file.py::test_load 
 2:43.15 pid:6128 [1767610733.626][WARNING]: You are using an unsupported command-line switch: --disable-build-check. Please don't report bugs that cannot be reproduced with this switch removed.
PID 6128 | [1767610733.626][WARNING]: You are using an unsupported command-line switch: --disable-build-check. Please don't report bugs that cannot be reproduced with this switch removed.
 2:43.21 pid:6128 [6178:6178:0105/105853.685751:WARNING:ui/gfx/linux/gbm_support_x11.cc:49] dri3 extension not supported.
PID 6128 | [6178:6178:0105/105853.685751:WARNING:ui/gfx/linux/gbm_support_x11.cc:49] dri3 extension not supported.
 2:43.21 pid:6128 [6178:6178:0105/105853.688459:WARNING:sandbox/policy/linux/sandbox_linux.cc:405] InitializeSandbox() called with multiple threads in process gpu-process.
PID 6128 | [6178:6178:0105/105853.688459:WARNING:sandbox/policy/linux/sandbox_linux.cc:405] InitializeSandbox() called with multiple threads in process gpu-process.
 2:43.31 pid:6128 [6148:6148:0105/105853.788403:ERROR:dbus/object_proxy.cc:573] Failed to call method: org.freedesktop.DBus.Properties.GetAll: object_path= /org/freedesktop/UPower/devices/DisplayDevice: org.freedesktop.DBus.Error.ServiceUnknown: The name org.freedesktop.UPower was not provided by any .service files
PID 6128 | [6148:6148:0105/105853.788403:ERROR:dbus/object_proxy.cc:573] Failed to call method: org.freedesktop.DBus.Properties.GetAll: object_path= /org/freedesktop/UPower/devices/DisplayDevice: org.freedesktop.DBus.Error.ServiceUnknown: The name org.freedesktop.UPower was not provided by any .service files
 2:43.31 pid:6128 [6148:6148:0105/105853.788426:WARNING:dbus/property.cc:174] GetAll request failed for: org.freedesktop.UPower.Device
PID 6128 | [6148:6148:0105/105853.788426:WARNING:dbus/property.cc:174] GetAll request failed for: org.freedesktop.UPower.Device
 2:43.35 pid:6128 [6148:6148:0105/105853.832474:WARNING:ui/base/idle/idle_linux.cc:113] None of the known D-Bus ScreenSaver services could be used.
PID 6128 | [6148:6148:0105/105853.832474:WARNING:ui/base/idle/idle_linux.cc:113] None of the known D-Bus ScreenSaver services could be used.
 2:43.44 INFO STDOUT: PASSED
STDOUT: PASSED
 2:43.52 INFO STDOUT: ============================== 1 passed in 0.67s ===============================
STDOUT: ============================== 1 passed in 0.67s ===============================
TEST-PASS | /infrastructure/webdriver/tests/test_load_file.py | test_load 
 2:43.52 TEST_END: Test OK. Subtests passed 1/1. Unexpected 0
TEST-OK | /infrastructure/webdriver/tests/test_load_file.py | took 1226ms
 2:43.52 INFO Restarting browser for new test group
Restarting browser for new test group
 2:43.52 INFO Closing logging queue
Closing logging queue
 2:43.52 INFO queue closed
queue closed
 2:43.64 INFO Starting WebDriver: /home/test/web-platform-tests/_venv3/bin/chrome/chromedriver --port=54565 --ignore-explicit-port --url-base=/ --enable-chrome-logs --disable-build-check
Starting WebDriver: /home/test/web-platform-tests/_venv3/bin/chrome/chromedriver --port=54565 --ignore-explicit-port --url-base=/ --enable-chrome-logs --disable-build-check
 2:43.66 INFO Got WebDriver port 46563
Got WebDriver port 46563
 2:43.75 pid:6252 Full command: /home/test/web-platform-tests/_venv3/bin/chrome/chromedriver --port=54565 --ignore-explicit-port --url-base=/ --enable-chrome-logs --disable-build-check
pid:6252 Starting ChromeDriver 145.0.7616.0 (8814538968ac94ac4f1a49b0dc45249a95d9dc12-refs/branch-heads/7616@{#1}) on port 0
PID 6252 | Starting ChromeDriver 145.0.7616.0 (8814538968ac94ac4f1a49b0dc45249a95d9dc12-refs/branch-heads/7616@{#1}) on port 0
 2:43.75 pid:6252 Only local connections are allowed.
PID 6252 | Only local connections are allowed.
 2:43.75 pid:6252 Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
PID 6252 | Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
 2:43.75 pid:6252 ChromeDriver was started successfully on port 46563.
PID 6252 | ChromeDriver was started successfully on port 46563.
 2:43.75 INFO Webdriver started successfully.
Webdriver started successfully.
 2:43.75 INFO Starting runner
Starting runner
 2:44.50 pid:6252 [6298:6298:0105/105854.979523:WARNING:ui/gfx/linux/gbm_support_x11.cc:49] dri3 extension not supported.
PID 6252 | [6298:6298:0105/105854.979523:WARNING:ui/gfx/linux/gbm_support_x11.cc:49] dri3 extension not supported.
 2:44.51 pid:6252 [6298:6298:0105/105854.983793:WARNING:sandbox/policy/linux/sandbox_linux.cc:405] InitializeSandbox() called with multiple threads in process gpu-process.
PID 6252 | [6298:6298:0105/105854.983793:WARNING:sandbox/policy/linux/sandbox_linux.cc:405] InitializeSandbox() called with multiple threads in process gpu-process.
 2:44.51 pid:6252 [1767610734.990][WARNING]: You are using an unsupported command-line switch: --disable-build-check. Please don't report bugs that cannot be reproduced with this switch removed.
PID 6252 | [1767610734.990][WARNING]: You are using an unsupported command-line switch: --disable-build-check. Please don't report bugs that cannot be reproduced with this switch removed.
 2:44.67 pid:6252 [6269:6269:0105/105855.143294:ERROR:dbus/object_proxy.cc:573] Failed to call method: org.freedesktop.DBus.Properties.GetAll: object_path= /org/freedesktop/UPower/devices/DisplayDevice: org.freedesktop.DBus.Error.ServiceUnknown: The name org.freedesktop.UPower was not provided by any .service files
PID 6252 | [6269:6269:0105/105855.143294:ERROR:dbus/object_proxy.cc:573] Failed to call method: org.freedesktop.DBus.Properties.GetAll: object_path= /org/freedesktop/UPower/devices/DisplayDevice: org.freedesktop.DBus.Error.ServiceUnknown: The name org.freedesktop.UPower was not provided by any .service files
 2:44.67 pid:6252 [6269:6269:0105/105855.143319:WARNING:dbus/property.cc:174] GetAll request failed for: org.freedesktop.UPower.Device
PID 6252 | [6269:6269:0105/105855.143319:WARNING:dbus/property.cc:174] GetAll request failed for: org.freedesktop.UPower.Device
 2:44.72 pid:6252 [6269:6269:0105/105855.193311:WARNING:ui/base/idle/idle_linux.cc:113] None of the known D-Bus ScreenSaver services could be used.
PID 6252 | [6269:6269:0105/105855.193311:WARNING:ui/base/idle/idle_linux.cc:113] None of the known D-Bus ScreenSaver services could be used.
 2:44.99 TEST_START: /infrastructure/reftest/reftest_match-print.html
TEST-START | /infrastructure/reftest/reftest_match-print.html
 2:46.26 TEST_END: PASS
TEST-PASS | /infrastructure/reftest/reftest_match-print.html | took 1276ms
 2:46.26 TEST_START: /infrastructure/reftest/reftest_match_fail-print.html
TEST-START | /infrastructure/reftest/reftest_match_fail-print.html
 2:46.86 INFO Image hashes didn't match on page 2, checking pixel differences
Image hashes didn't match on page 2, checking pixel differences
 2:46.90 INFO Found 277 pixels different, maximum difference per channel 255 on page 2
Found 277 pixels different, maximum difference per channel 255 on page 2
 2:46.90 TEST_END: FAIL
TEST-FAIL | /infrastructure/reftest/reftest_match_fail-print.html | took 635ms
 2:46.90 TEST_START: /infrastructure/reftest/reftest_mismatch-num-pages-print.html
TEST-START | /infrastructure/reftest/reftest_mismatch-num-pages-print.html
mem avail: 14163 of 15806 MiB (89.61%), swap free:    0 of    0 MiB ( 0.00%)
 2:47.43 INFO Got different number of pages
Got different number of pages
 2:47.43 TEST_END: PASS
TEST-PASS | /infrastructure/reftest/reftest_mismatch-num-pages-print.html | took 533ms
 2:47.44 TEST_START: /infrastructure/reftest/reftest_mismatch-print.html
TEST-START | /infrastructure/reftest/reftest_mismatch-print.html
 2:48.01 INFO Image hashes didn't match on page 2, checking pixel differences
Image hashes didn't match on page 2, checking pixel differences
 2:48.03 INFO Found 13 pixels different, maximum difference per channel 255 on page 2
Found 13 pixels different, maximum difference per channel 255 on page 2
 2:48.03 TEST_END: PASS
TEST-PASS | /infrastructure/reftest/reftest_mismatch-print.html | took 592ms
 2:48.03 TEST_START: /infrastructure/reftest/reftest_mismatch_fail-print.html
TEST-START | /infrastructure/reftest/reftest_mismatch_fail-print.html
 2:48.64 TEST_END: FAIL
TEST-FAIL | /infrastructure/reftest/reftest_mismatch_fail-print.html | took 613ms
 2:48.64 TEST_START: /infrastructure/reftest/reftest_mismatch_page_margins-print.html
TEST-START | /infrastructure/reftest/reftest_mismatch_page_margins-print.html
 2:49.20 INFO Image hashes didn't match on page 1, checking pixel differences
Image hashes didn't match on page 1, checking pixel differences
 2:49.21 INFO Found 216 pixels different, maximum difference per channel 255 on page 1
Found 216 pixels different, maximum difference per channel 255 on page 1
 2:49.21 TEST_END: PASS
TEST-PASS | /infrastructure/reftest/reftest_mismatch_page_margins-print.html | took 565ms
 2:49.21 TEST_START: /infrastructure/reftest/reftest_wait_0-print.html
TEST-START | /infrastructure/reftest/reftest_wait_0-print.html
 2:51.26 pid:6252 [6269:6284:0105/105901.737121:ERROR:google_apis/gcm/engine/registration_request.cc:291] Registration response error message: PHONE_REGISTRATION_ERROR
PID 6252 | [6269:6284:0105/105901.737121:ERROR:google_apis/gcm/engine/registration_request.cc:291] Registration response error message: PHONE_REGISTRATION_ERROR
 2:51.26 pid:6252 [6269:6284:0105/105901.738719:ERROR:google_apis/gcm/engine/registration_request.cc:291] Registration response error message: PHONE_REGISTRATION_ERROR
PID 6252 | [6269:6284:0105/105901.738719:ERROR:google_apis/gcm/engine/registration_request.cc:291] Registration response error message: PHONE_REGISTRATION_ERROR
 2:51.26 pid:6252 [6269:6284:0105/105901.741277:ERROR:google_apis/gcm/engine/registration_request.cc:291] Registration response error message: PHONE_REGISTRATION_ERROR
PID 6252 | [6269:6284:0105/105901.741277:ERROR:google_apis/gcm/engine/registration_request.cc:291] Registration response error message: PHONE_REGISTRATION_ERROR
 2:51.27 pid:6252 [6269:6284:0105/105901.745582:ERROR:google_apis/gcm/engine/mcs_client.cc:700]   Error code: 401  Error message: Authentication Failed: wrong_secret
PID 6252 | [6269:6284:0105/105901.745582:ERROR:google_apis/gcm/engine/mcs_client.cc:700]   Error code: 401  Error message: Authentication Failed: wrong_secret
 2:51.27 pid:6252 [6269:6284:0105/105901.745598:ERROR:google_apis/gcm/engine/mcs_client.cc:702] Failed to log in to GCM, resetting connection.
PID 6252 | [6269:6284:0105/105901.745598:ERROR:google_apis/gcm/engine/mcs_client.cc:702] Failed to log in to GCM, resetting connection.
 2:52.00 TEST_END: PASS
TEST-PASS | /infrastructure/reftest/reftest_wait_0-print.html | took 2795ms
 2:52.00 TEST_START: /infrastructure/reftest/testdriver-print.html
TEST-START | /infrastructure/reftest/testdriver-print.html
 2:52.70 TEST_END: PASS
TEST-PASS | /infrastructure/reftest/testdriver-print.html | took 695ms
 2:52.70 INFO No more tests
No more tests
 2:52.75 INFO Closing logging queue
Closing logging queue
 2:52.75 INFO queue closed
queue closed
 2:52.85 SUITE_END

web-platform-test
~~~~~~~~~~~~~~~~~
Ran 439 checks (252 subtests, 187 tests)
Expected results: 436
Skipped: 2 tests
Unexpected results: 1
  subtest: 1 (1 fail)

Unexpected Results
------------------
/infrastructure/testdriver/bidi/subscription.html
  FAIL Assert testdriver can subscribe globally - assert_equals: expected "2. POPUP MESSAGE" but got "1. MAIN WINDOW MESSAGE"
    at assertLogEvent (http://web-platform.test:8000/infrastructure/testdriver/bidi/subscription.html:19:9)
    at Test.<anonymous> (http://web-platform.test:8000/infrastructure/testdriver/bidi/subscription.html:135:9)
SUITE-END | took 157s
 2:52.85 INFO Got 1 unexpected results, with 0 unexpected passes
Got 1 unexpected results, with 0 unexpected passes
 2:52.85 wptserve INFO Stopped http server on 127.0.0.1:8001
wptserve Stopped http server on 127.0.0.1:8001
 2:52.85 wptserve INFO Stopped http server on 127.0.0.1:8002
wptserve Stopped http server on 127.0.0.1:8002
 2:52.85 wptserve INFO Stopped http server on 127.0.0.1:8000
wptserve Stopped http server on 127.0.0.1:8000
 2:52.86 wptserve INFO Stopped http server on 127.0.0.1:8003
wptserve Stopped http server on 127.0.0.1:8003
 2:52.87 wptserve INFO Stopped http server on 127.0.0.1:8443
wptserve Stopped http server on 127.0.0.1:8443
 2:52.87 wptserve INFO Stopped http server on 127.0.0.1:8444
wptserve Stopped http server on 127.0.0.1:8444
 2:52.87 wptserve INFO Stopped http server on 127.0.0.1:8445
wptserve Stopped http server on 127.0.0.1:8445
 2:52.87 wptserve INFO Stopped http server on 127.0.0.1:8446
wptserve Stopped http server on 127.0.0.1:8446
 2:52.88 wptserve INFO Stopped WebTransport over HTTP/3 server on 127.0.0.1:11000
wptserve Stopped WebTransport over HTTP/3 server on 127.0.0.1:11000
 2:52.92 wptserve INFO Stopped http server on 127.0.0.1:9000
wptserve Stopped http server on 127.0.0.1:9000
 2:53.09 wptserve INFO Close on: (<AddressFamily.AF_INET: 2>, <SocketKind.SOCK_STREAM: 1>, 6, '', ('127.0.0.1', 8888))
wptserve Close on: (<AddressFamily.AF_INET: 2>, <SocketKind.SOCK_STREAM: 1>, 6, '', ('127.0.0.1', 8888))
 2:53.28 wptserve INFO Close on: (<AddressFamily.AF_INET: 2>, <SocketKind.SOCK_STREAM: 1>, 6, '', ('127.0.0.1', 8889))
wptserve Close on: (<AddressFamily.AF_INET: 2>, <SocketKind.SOCK_STREAM: 1>, 6, '', ('127.0.0.1', 8889))
 2:53.32 INFO Removed font: Ahem.ttf
Removed font: Ahem.ttf
 2:53.35 INFO Closing logging queue
Closing logging queue
 2:53.35 INFO queue closed
queue closed
[taskcluster 2026-01-05 10:59:05.207Z] === Task Finished ===
[taskcluster 2026-01-05 10:59:05.817Z] Unsuccessful task run with exit code: 1 completed in 406.77 seconds