[taskcluster 2026-01-02 22:06:40.369Z] Task ID: aKfw8PmVR6WiqhEH5D-eFg
[taskcluster 2026-01-02 22:06:40.369Z] Worker ID: 2038493951097700307
[taskcluster 2026-01-02 22:06:40.369Z] Worker Group: us-east1-c
[taskcluster 2026-01-02 22:06:40.369Z] Worker Node Type: projects/757942385826/machineTypes/n2-standard-4
[taskcluster 2026-01-02 22:06:40.369Z] Worker Pool: proj-wpt/ci
[taskcluster 2026-01-02 22:06:40.369Z] Worker Version: 46.1.0
[taskcluster 2026-01-02 22:06:40.369Z] Public IP: 34.138.28.113
[taskcluster 2026-01-02 22:06:40.369Z] Hostname: proj-wpt-ci-fanpufk-rwovpy2-1jwsja

ac811f28856d - Started downloading
8f84a9f2102e - Started downloading
ac811f28856d - Downloaded in 0.037 seconds
40516d781e70 - Started downloading
44ebbf800033 - Started downloading
44ebbf800033 - Downloaded in 0.049 seconds
8f84a9f2102e - Downloaded in 0.232 seconds
a8884b21e40e - Started downloading
4f4fb700ef54 - Started downloading
4f4fb700ef54 - Downloaded in 0.003 seconds
79c347416ee8 - Started downloading

...(2559 lines hidden)...

Found 277 pixels different, maximum difference per channel 255 on page 2
 3:06.28 TEST_END: FAIL
TEST-FAIL | /infrastructure/reftest/reftest_match_fail-print.html | took 730ms
 3:06.28 TEST_START: /infrastructure/reftest/reftest_mismatch-num-pages-print.html
TEST-START | /infrastructure/reftest/reftest_mismatch-num-pages-print.html
 3:06.87 INFO Got different number of pages
Got different number of pages
 3:06.87 TEST_END: PASS
TEST-PASS | /infrastructure/reftest/reftest_mismatch-num-pages-print.html | took 588ms
 3:06.87 TEST_START: /infrastructure/reftest/reftest_mismatch-print.html
TEST-START | /infrastructure/reftest/reftest_mismatch-print.html
 3:07.50 INFO Image hashes didn't match on page 2, checking pixel differences
Image hashes didn't match on page 2, checking pixel differences
 3:07.52 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
 3:07.52 TEST_END: PASS
TEST-PASS | /infrastructure/reftest/reftest_mismatch-print.html | took 645ms
 3:07.52 TEST_START: /infrastructure/reftest/reftest_mismatch_fail-print.html
TEST-START | /infrastructure/reftest/reftest_mismatch_fail-print.html
 3:08.17 TEST_END: FAIL
TEST-FAIL | /infrastructure/reftest/reftest_mismatch_fail-print.html | took 651ms
 3:08.17 TEST_START: /infrastructure/reftest/reftest_mismatch_page_margins-print.html
TEST-START | /infrastructure/reftest/reftest_mismatch_page_margins-print.html
 3:08.82 INFO Image hashes didn't match on page 1, checking pixel differences
Image hashes didn't match on page 1, checking pixel differences
 3:08.84 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
 3:08.84 TEST_END: PASS
TEST-PASS | /infrastructure/reftest/reftest_mismatch_page_margins-print.html | took 673ms
 3:08.84 TEST_START: /infrastructure/reftest/reftest_wait_0-print.html
TEST-START | /infrastructure/reftest/reftest_wait_0-print.html
 3:10.88 pid:5975 [5992:6007:0102/221234.265021:ERROR:google_apis/gcm/engine/registration_request.cc:291] Registration response error message: DEPRECATED_ENDPOINT
PID 5975 | [5992:6007:0102/221234.265021:ERROR:google_apis/gcm/engine/registration_request.cc:291] Registration response error message: DEPRECATED_ENDPOINT
 3:11.80 TEST_END: PASS
TEST-PASS | /infrastructure/reftest/reftest_wait_0-print.html | took 2959ms
 3:11.81 TEST_START: /infrastructure/reftest/testdriver-print.html
TEST-START | /infrastructure/reftest/testdriver-print.html
 3:12.57 TEST_END: PASS
TEST-PASS | /infrastructure/reftest/testdriver-print.html | took 762ms
 3:12.57 INFO Restarting browser for new test group
Restarting browser for new test group
 3:12.62 INFO Closing logging queue
Closing logging queue
 3:12.62 INFO queue closed
queue closed
 3:12.75 INFO Starting WebDriver: /home/test/web-platform-tests/_venv3/bin/chrome/chromedriver --port=56665 --ignore-explicit-port --url-base=/ --enable-chrome-logs --disable-build-check
Starting WebDriver: /home/test/web-platform-tests/_venv3/bin/chrome/chromedriver --port=56665 --ignore-explicit-port --url-base=/ --enable-chrome-logs --disable-build-check
 3:12.77 INFO Got WebDriver port 44525
Got WebDriver port 44525
 3:12.86 pid:6226 Full command: /home/test/web-platform-tests/_venv3/bin/chrome/chromedriver --port=56665 --ignore-explicit-port --url-base=/ --enable-chrome-logs --disable-build-check
pid:6226 Starting ChromeDriver 145.0.7610.0 (5ce65daacb44b6a92564919da63b0f5b3f0a5953-refs/branch-heads/7610@{#1}) on port 0
PID 6226 | Starting ChromeDriver 145.0.7610.0 (5ce65daacb44b6a92564919da63b0f5b3f0a5953-refs/branch-heads/7610@{#1}) on port 0
 3:12.86 pid:6226 Only local connections are allowed.
PID 6226 | Only local connections are allowed.
 3:12.86 pid:6226 Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
PID 6226 | Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
 3:12.86 pid:6226 ChromeDriver was started successfully on port 44525.
PID 6226 | ChromeDriver was started successfully on port 44525.
 3:12.86 INFO Webdriver started successfully.
Webdriver started successfully.
 3:12.86 INFO Starting runner
Starting runner
 3:13.40 TEST_START: /infrastructure/webdriver/tests/test_load_file.py
TEST-START | /infrastructure/webdriver/tests/test_load_file.py
 3:14.10 INFO STDOUT: ============================= test session starts ==============================
STDOUT: ============================= test session starts ==============================
 3:14.10 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
 3:14.11 INFO STDOUT: rootdir: /home/test/web-platform-tests
STDOUT: rootdir: /home/test/web-platform-tests
 3:14.11 INFO STDOUT: plugins: asyncio-0.19.0
STDOUT: plugins: asyncio-0.19.0
 3:14.11 INFO STDOUT: asyncio: mode=strict
STDOUT: asyncio: mode=strict
 3:14.11 INFO STDOUT: collecting ... 
STDOUT: collecting ... 
 3:14.21 INFO STDOUT: collected 1 item
STDOUT: collected 1 item
 3:14.21 INFO STDOUT: infrastructure/webdriver/tests/test_load_file.py::test_load 
STDOUT: infrastructure/webdriver/tests/test_load_file.py::test_load 
 3:14.57 pid:6226 [1767391957.955][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 6226 | [1767391957.955][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.
 3:14.60 pid:6226 [6276:6276:0102/221237.985008:WARNING:ui/gfx/linux/gbm_support_x11.cc:49] dri3 extension not supported.
PID 6226 | [6276:6276:0102/221237.985008:WARNING:ui/gfx/linux/gbm_support_x11.cc:49] dri3 extension not supported.
 3:14.61 pid:6226 [6276:6276:0102/221237.988720:WARNING:sandbox/policy/linux/sandbox_linux.cc:405] InitializeSandbox() called with multiple threads in process gpu-process.
PID 6226 | [6276:6276:0102/221237.988720:WARNING:sandbox/policy/linux/sandbox_linux.cc:405] InitializeSandbox() called with multiple threads in process gpu-process.
 3:14.82 pid:6226 [6246:6246:0102/221238.199623: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 6226 | [6246:6246:0102/221238.199623: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
 3:14.82 pid:6226 [6246:6246:0102/221238.199646:WARNING:dbus/property.cc:174] GetAll request failed for: org.freedesktop.UPower.Device
PID 6226 | [6246:6246:0102/221238.199646:WARNING:dbus/property.cc:174] GetAll request failed for: org.freedesktop.UPower.Device
 3:14.88 pid:6226 [6246:6246:0102/221238.257645:WARNING:ui/base/idle/idle_linux.cc:113] None of the known D-Bus ScreenSaver services could be used.
PID 6226 | [6246:6246:0102/221238.257645:WARNING:ui/base/idle/idle_linux.cc:113] None of the known D-Bus ScreenSaver services could be used.
 3:14.96 INFO STDOUT: PASSED
STDOUT: PASSED
 3:15.04 INFO STDOUT: ============================== 1 passed in 0.93s ===============================
STDOUT: ============================== 1 passed in 0.93s ===============================
TEST-PASS | /infrastructure/webdriver/tests/test_load_file.py | test_load 
 3:15.04 TEST_END: Test OK. Subtests passed 1/1. Unexpected 0
TEST-OK | /infrastructure/webdriver/tests/test_load_file.py | took 1638ms
 3:15.04 INFO Restarting browser for new test group
Restarting browser for new test group
 3:15.04 INFO Closing logging queue
Closing logging queue
 3:15.04 INFO queue closed
queue closed
 3:15.20 INFO Starting WebDriver: /home/test/web-platform-tests/_venv3/bin/chrome/chromedriver --port=40583 --ignore-explicit-port --url-base=/ --enable-chrome-logs --disable-build-check
Starting WebDriver: /home/test/web-platform-tests/_venv3/bin/chrome/chromedriver --port=40583 --ignore-explicit-port --url-base=/ --enable-chrome-logs --disable-build-check
 3:15.23 INFO Got WebDriver port 43213
Got WebDriver port 43213
 3:15.32 pid:6348 Full command: /home/test/web-platform-tests/_venv3/bin/chrome/chromedriver --port=40583 --ignore-explicit-port --url-base=/ --enable-chrome-logs --disable-build-check
pid:6348 Starting ChromeDriver 145.0.7610.0 (5ce65daacb44b6a92564919da63b0f5b3f0a5953-refs/branch-heads/7610@{#1}) on port 0
PID 6348 | Starting ChromeDriver 145.0.7610.0 (5ce65daacb44b6a92564919da63b0f5b3f0a5953-refs/branch-heads/7610@{#1}) on port 0
 3:15.32 pid:6348 Only local connections are allowed.
PID 6348 | Only local connections are allowed.
 3:15.32 pid:6348 Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
PID 6348 | Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
 3:15.32 pid:6348 ChromeDriver was started successfully on port 43213.
PID 6348 | ChromeDriver was started successfully on port 43213.
 3:15.32 INFO Webdriver started successfully.
Webdriver started successfully.
 3:15.32 INFO Starting runner
Starting runner
 3:16.27 pid:6348 [1767391959.653][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 6348 | [1767391959.653][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.
 3:16.28 pid:6348 [6395:6395:0102/221239.666733:WARNING:ui/gfx/linux/gbm_support_x11.cc:49] dri3 extension not supported.
PID 6348 | [6395:6395:0102/221239.666733:WARNING:ui/gfx/linux/gbm_support_x11.cc:49] dri3 extension not supported.
 3:16.29 pid:6348 [6395:6395:0102/221239.671267:WARNING:sandbox/policy/linux/sandbox_linux.cc:405] InitializeSandbox() called with multiple threads in process gpu-process.
PID 6348 | [6395:6395:0102/221239.671267:WARNING:sandbox/policy/linux/sandbox_linux.cc:405] InitializeSandbox() called with multiple threads in process gpu-process.
 3:16.48 pid:6348 [6365:6365:0102/221239.857660: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 6348 | [6365:6365:0102/221239.857660: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
 3:16.48 pid:6348 [6365:6365:0102/221239.857685:WARNING:dbus/property.cc:174] GetAll request failed for: org.freedesktop.UPower.Device
PID 6348 | [6365:6365:0102/221239.857685:WARNING:dbus/property.cc:174] GetAll request failed for: org.freedesktop.UPower.Device
 3:16.53 pid:6348 [6365:6365:0102/221239.914604:WARNING:ui/base/idle/idle_linux.cc:113] None of the known D-Bus ScreenSaver services could be used.
PID 6348 | [6365:6365:0102/221239.914604:WARNING:ui/base/idle/idle_linux.cc:113] None of the known D-Bus ScreenSaver services could be used.
 3:16.66 TEST_START: /infrastructure/crashtests/example.html
TEST-START | /infrastructure/crashtests/example.html
 3:17.20 TEST_END: PASS
TEST-PASS | /infrastructure/crashtests/example.html | took 536ms
 3:17.20 TEST_START: /infrastructure/crashtests/testdriver.html
TEST-START | /infrastructure/crashtests/testdriver.html
 3:17.45 TEST_END: PASS
TEST-PASS | /infrastructure/crashtests/testdriver.html | took 252ms
 3:17.45 INFO No more tests
No more tests
 3:17.50 INFO Closing logging queue
Closing logging queue
 3:17.50 INFO queue closed
queue closed
 3:17.62 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 180s
 3:17.62 INFO Got 1 unexpected results, with 0 unexpected passes
Got 1 unexpected results, with 0 unexpected passes
 3:17.62 wptserve INFO Stopped http server on 127.0.0.1:8000
wptserve Stopped http server on 127.0.0.1:8000
 3:17.63 wptserve INFO Stopped http server on 127.0.0.1:8001
wptserve Stopped http server on 127.0.0.1:8001
 3:17.64 wptserve INFO Stopped http server on 127.0.0.1:8002
wptserve Stopped http server on 127.0.0.1:8002
 3:17.64 wptserve INFO Stopped http server on 127.0.0.1:8003
wptserve Stopped http server on 127.0.0.1:8003
 3:17.64 wptserve INFO Stopped http server on 127.0.0.1:8444
wptserve Stopped http server on 127.0.0.1:8444
 3:17.64 wptserve INFO Stopped http server on 127.0.0.1:8443
wptserve Stopped http server on 127.0.0.1:8443
 3:17.64 wptserve INFO Stopped http server on 127.0.0.1:8445
wptserve Stopped http server on 127.0.0.1:8445
 3:17.65 wptserve INFO Stopped http server on 127.0.0.1:8446
wptserve Stopped http server on 127.0.0.1:8446
 3:17.66 wptserve INFO Stopped http server on 127.0.0.1:9000
wptserve Stopped http server on 127.0.0.1:9000
 3:17.67 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
 3:17.70 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))
 3:17.89 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))
 3:17.94 INFO Removed font: Ahem.ttf
Removed font: Ahem.ttf
 3:17.97 INFO Closing logging queue
Closing logging queue
 3:17.97 INFO queue closed
queue closed
[taskcluster 2026-01-02 22:12:42.968Z] === Task Finished ===
[taskcluster 2026-01-02 22:12:43.746Z] Unsuccessful task run with exit code: 1 completed in 363.38 seconds