[taskcluster 2025-12-22 22:08:21.104Z] Task ID: AQrwmevoQlC3OX-ppxMnvQ
[taskcluster 2025-12-22 22:08:21.105Z] Worker ID: 646546383912075248
[taskcluster 2025-12-22 22:08:21.105Z] Worker Group: us-east1-d
[taskcluster 2025-12-22 22:08:21.105Z] Worker Node Type: projects/757942385826/machineTypes/n2-standard-4
[taskcluster 2025-12-22 22:08:21.105Z] Worker Pool: proj-wpt/ci
[taskcluster 2025-12-22 22:08:21.105Z] Worker Version: 46.1.0
[taskcluster 2025-12-22 22:08:21.105Z] Public IP: 35.243.174.58
[taskcluster 2025-12-22 22:08:21.105Z] Hostname: proj-wpt-ci-oekmk-5qsaesa3acuc3qta

ac811f28856d - Started downloading
8f84a9f2102e - Started downloading
ac811f28856d - Downloaded in 0.036 seconds
40516d781e70 - Started downloading
44ebbf800033 - Started downloading
44ebbf800033 - Downloaded in 0.051 seconds
8f84a9f2102e - Downloaded in 0.206 seconds
4f4fb700ef54 - Started downloading
4f4fb700ef54 - Downloaded in 0 seconds
a8884b21e40e - Started downloading
79c347416ee8 - Started downloading

...(2551 lines hidden)...

TEST-PASS | /infrastructure/reftest/reftest_multiple_match-0.html | took 245ms
 2:53.88 TEST_START: /infrastructure/reftest/reftest_multiple_match-1.html
TEST-START | /infrastructure/reftest/reftest_multiple_match-1.html
 2:54.05 TEST_END: PASS
TEST-PASS | /infrastructure/reftest/reftest_multiple_match-1.html | took 172ms
 2:54.05 TEST_START: /infrastructure/reftest/reftest_multiple_mismatch-0.html
TEST-START | /infrastructure/reftest/reftest_multiple_mismatch-0.html
 2:54.25 INFO Image hashes didn't match on page 1, checking pixel differences
Image hashes didn't match on page 1, checking pixel differences
 2:54.29 INFO Found 480000 pixels different, maximum difference per channel 255 on page 1
Found 480000 pixels different, maximum difference per channel 255 on page 1
 2:54.29 INFO Image hashes didn't match on page 1, checking pixel differences
Image hashes didn't match on page 1, checking pixel differences
 2:54.33 INFO Found 480000 pixels different, maximum difference per channel 255 on page 1
Found 480000 pixels different, maximum difference per channel 255 on page 1
 2:54.33 TEST_END: FAIL
TEST-FAIL | /infrastructure/reftest/reftest_multiple_mismatch-0.html | took 277ms
 2:54.33 TEST_START: /infrastructure/reftest/reftest_multiple_mismatch-1.html
TEST-START | /infrastructure/reftest/reftest_multiple_mismatch-1.html
 2:54.53 TEST_END: FAIL
TEST-FAIL | /infrastructure/reftest/reftest_multiple_mismatch-1.html | took 202ms
 2:54.53 TEST_START: /infrastructure/reftest/reftest_ref_timeout.html
TEST-START | /infrastructure/reftest/reftest_ref_timeout.html
 2:56.46 pid:5846 [5863:5878:1222/221355.778291:ERROR:google_apis/gcm/engine/registration_request.cc:291] Registration response error message: DEPRECATED_ENDPOINT
PID 5846 | [5863:5878:1222/221355.778291:ERROR:google_apis/gcm/engine/registration_request.cc:291] Registration response error message: DEPRECATED_ENDPOINT
mem avail: 14069 of 15806 MiB (89.02%), swap free:    0 of    0 MiB ( 0.00%)
 3:09.79 pid:5846 [1766441649.103][SEVERE]: Timed out receiving message from renderer: 15.000
PID 5846 | [1766441649.103][SEVERE]: Timed out receiving message from renderer: 15.000
 3:09.79 TEST_END: TIMEOUT
TEST-TIMEOUT | /infrastructure/reftest/reftest_ref_timeout.html | took 15261ms
 3:09.84 INFO Closing logging queue
Closing logging queue
 3:09.85 INFO queue closed
queue closed
 3:09.92 INFO Starting WebDriver: /home/test/web-platform-tests/_venv3/bin/chrome/chromedriver --port=34377 --ignore-explicit-port --url-base=/ --enable-chrome-logs --disable-build-check
Starting WebDriver: /home/test/web-platform-tests/_venv3/bin/chrome/chromedriver --port=34377 --ignore-explicit-port --url-base=/ --enable-chrome-logs --disable-build-check
 3:09.94 INFO Got WebDriver port 44899
Got WebDriver port 44899
 3:10.03 pid:6187 Full command: /home/test/web-platform-tests/_venv3/bin/chrome/chromedriver --port=34377 --ignore-explicit-port --url-base=/ --enable-chrome-logs --disable-build-check
pid:6187 Starting ChromeDriver 145.0.7592.0 (f10c71c0f07ac9b2e99672d730cc41dd6cde729e-refs/branch-heads/7592@{#1}) on port 0
PID 6187 | Starting ChromeDriver 145.0.7592.0 (f10c71c0f07ac9b2e99672d730cc41dd6cde729e-refs/branch-heads/7592@{#1}) on port 0
 3:10.03 pid:6187 Only local connections are allowed.
PID 6187 | Only local connections are allowed.
 3:10.03 pid:6187 Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
PID 6187 | Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
 3:10.03 pid:6187 ChromeDriver was started successfully on port 44899.
PID 6187 | ChromeDriver was started successfully on port 44899.
 3:10.03 INFO Webdriver started successfully.
Webdriver started successfully.
 3:10.03 INFO Starting runner
Starting runner
 3:10.70 pid:6187 [1766441650.018][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 6187 | [1766441650.018][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:10.75 pid:6187 [6234:6234:1222/221410.066697:WARNING:ui/gfx/linux/gbm_support_x11.cc:49] dri3 extension not supported.
PID 6187 | [6234:6234:1222/221410.066697:WARNING:ui/gfx/linux/gbm_support_x11.cc:49] dri3 extension not supported.
 3:10.75 pid:6187 [6234:6234:1222/221410.070122:WARNING:sandbox/policy/linux/sandbox_linux.cc:405] InitializeSandbox() called with multiple threads in process gpu-process.
PID 6187 | [6234:6234:1222/221410.070122:WARNING:sandbox/policy/linux/sandbox_linux.cc:405] InitializeSandbox() called with multiple threads in process gpu-process.
 3:10.85 pid:6187 [6204:6204:1222/221410.165260: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 6187 | [6204:6204:1222/221410.165260: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:10.85 pid:6187 [6204:6204:1222/221410.165549:WARNING:dbus/property.cc:174] GetAll request failed for: org.freedesktop.UPower.Device
PID 6187 | [6204:6204:1222/221410.165549:WARNING:dbus/property.cc:174] GetAll request failed for: org.freedesktop.UPower.Device
 3:10.89 pid:6187 [6204:6204:1222/221410.203803:WARNING:ui/base/idle/idle_linux.cc:113] None of the known D-Bus ScreenSaver services could be used.
PID 6187 | [6204:6204:1222/221410.203803:WARNING:ui/base/idle/idle_linux.cc:113] None of the known D-Bus ScreenSaver services could be used.
 3:10.98 TEST_START: /infrastructure/reftest/reftest_timeout.html
TEST-START | /infrastructure/reftest/reftest_timeout.html
 3:13.15 pid:6187 [6204:6219:1222/221412.471918:ERROR:google_apis/gcm/engine/registration_request.cc:291] Registration response error message: PHONE_REGISTRATION_ERROR
PID 6187 | [6204:6219:1222/221412.471918:ERROR:google_apis/gcm/engine/registration_request.cc:291] Registration response error message: PHONE_REGISTRATION_ERROR
 3:13.15 pid:6187 [6204:6219:1222/221412.472214:ERROR:google_apis/gcm/engine/registration_request.cc:291] Registration response error message: PHONE_REGISTRATION_ERROR
PID 6187 | [6204:6219:1222/221412.472214:ERROR:google_apis/gcm/engine/registration_request.cc:291] Registration response error message: PHONE_REGISTRATION_ERROR
 3:13.16 pid:6187 [6204:6219:1222/221412.473003:ERROR:google_apis/gcm/engine/registration_request.cc:291] Registration response error message: PHONE_REGISTRATION_ERROR
PID 6187 | [6204:6219:1222/221412.473003:ERROR:google_apis/gcm/engine/registration_request.cc:291] Registration response error message: PHONE_REGISTRATION_ERROR
 3:26.04 pid:6187 [1766441665.355][SEVERE]: Timed out receiving message from renderer: 15.000
PID 6187 | [1766441665.355][SEVERE]: Timed out receiving message from renderer: 15.000
 3:26.04 TEST_END: TIMEOUT
TEST-TIMEOUT | /infrastructure/reftest/reftest_timeout.html | took 15067ms
 3:26.10 INFO Closing logging queue
Closing logging queue
 3:26.10 INFO queue closed
queue closed
 3:26.16 INFO Starting WebDriver: /home/test/web-platform-tests/_venv3/bin/chrome/chromedriver --port=60757 --ignore-explicit-port --url-base=/ --enable-chrome-logs --disable-build-check
Starting WebDriver: /home/test/web-platform-tests/_venv3/bin/chrome/chromedriver --port=60757 --ignore-explicit-port --url-base=/ --enable-chrome-logs --disable-build-check
 3:26.18 INFO Got WebDriver port 41023
Got WebDriver port 41023
 3:26.27 pid:6331 Full command: /home/test/web-platform-tests/_venv3/bin/chrome/chromedriver --port=60757 --ignore-explicit-port --url-base=/ --enable-chrome-logs --disable-build-check
pid:6331 Starting ChromeDriver 145.0.7592.0 (f10c71c0f07ac9b2e99672d730cc41dd6cde729e-refs/branch-heads/7592@{#1}) on port 0
PID 6331 | Starting ChromeDriver 145.0.7592.0 (f10c71c0f07ac9b2e99672d730cc41dd6cde729e-refs/branch-heads/7592@{#1}) on port 0
 3:26.27 pid:6331 Only local connections are allowed.
PID 6331 | Only local connections are allowed.
 3:26.27 pid:6331 Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
PID 6331 | Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
 3:26.27 pid:6331 ChromeDriver was started successfully on port 41023.
PID 6331 | ChromeDriver was started successfully on port 41023.
 3:26.27 INFO Webdriver started successfully.
Webdriver started successfully.
 3:26.27 INFO Starting runner
Starting runner
 3:26.96 pid:6331 [6378:6378:1222/221426.277621:WARNING:ui/gfx/linux/gbm_support_x11.cc:49] dri3 extension not supported.
PID 6331 | [6378:6378:1222/221426.277621:WARNING:ui/gfx/linux/gbm_support_x11.cc:49] dri3 extension not supported.
 3:26.96 pid:6331 [6378:6378:1222/221426.280212:WARNING:sandbox/policy/linux/sandbox_linux.cc:405] InitializeSandbox() called with multiple threads in process gpu-process.
PID 6331 | [6378:6378:1222/221426.280212:WARNING:sandbox/policy/linux/sandbox_linux.cc:405] InitializeSandbox() called with multiple threads in process gpu-process.
 3:27.12 pid:6331 [1766441666.439][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 6331 | [1766441666.439][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:27.13 pid:6331 [6348:6348:1222/221426.444868: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 6331 | [6348:6348:1222/221426.444868: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:27.13 pid:6331 [6348:6348:1222/221426.444885:WARNING:dbus/property.cc:174] GetAll request failed for: org.freedesktop.UPower.Device
PID 6331 | [6348:6348:1222/221426.444885:WARNING:dbus/property.cc:174] GetAll request failed for: org.freedesktop.UPower.Device
 3:27.16 pid:6331 [6348:6348:1222/221426.478916:WARNING:ui/base/idle/idle_linux.cc:113] None of the known D-Bus ScreenSaver services could be used.
PID 6331 | [6348:6348:1222/221426.478916:WARNING:ui/base/idle/idle_linux.cc:113] None of the known D-Bus ScreenSaver services could be used.
 3:27.28 TEST_START: /infrastructure/reftest/reftest_wait_0.html
TEST-START | /infrastructure/reftest/reftest_wait_0.html
 3:29.45 TEST_END: PASS
TEST-PASS | /infrastructure/reftest/reftest_wait_0.html | took 2172ms
 3:29.45 TEST_START: /infrastructure/reftest/reftest_wait_TestRendered.html
TEST-START | /infrastructure/reftest/reftest_wait_TestRendered.html
 3:29.56 pid:6331 [6348:6363:1222/221428.874315:ERROR:google_apis/gcm/engine/registration_request.cc:291] Registration response error message: DEPRECATED_ENDPOINT
PID 6331 | [6348:6363:1222/221428.874315:ERROR:google_apis/gcm/engine/registration_request.cc:291] Registration response error message: DEPRECATED_ENDPOINT
 3:29.73 TEST_END: PASS
TEST-PASS | /infrastructure/reftest/reftest_wait_TestRendered.html | took 285ms
 3:29.73 TEST_START: /infrastructure/reftest/reftest_window_load.html
TEST-START | /infrastructure/reftest/reftest_window_load.html
 3:29.99 TEST_END: PASS
TEST-PASS | /infrastructure/reftest/reftest_window_load.html | took 256ms
 3:29.99 TEST_START: /infrastructure/reftest/size.html
TEST-START | /infrastructure/reftest/size.html
 3:30.40 TEST_END: PASS
TEST-PASS | /infrastructure/reftest/size.html | took 412ms
 3:30.40 TEST_START: /infrastructure/reftest/testdriver-iframe.sub.html
TEST-START | /infrastructure/reftest/testdriver-iframe.sub.html
 3:30.90 TEST_END: PASS
TEST-PASS | /infrastructure/reftest/testdriver-iframe.sub.html | took 496ms
 3:30.90 TEST_START: /infrastructure/reftest/testdriver-in-ref.html
TEST-START | /infrastructure/reftest/testdriver-in-ref.html
 3:31.30 TEST_END: PASS
TEST-PASS | /infrastructure/reftest/testdriver-in-ref.html | took 398ms
 3:31.30 TEST_START: /infrastructure/reftest/testdriver.html
TEST-START | /infrastructure/reftest/testdriver.html
 3:31.31 TEST_END: PASS
TEST-PASS | /infrastructure/reftest/testdriver.html | took 8ms
 3:31.31 TEST_START: /infrastructure/reftest-wait.html
TEST-START | /infrastructure/reftest-wait.html
 3:32.62 TEST_END: PASS
TEST-PASS | /infrastructure/reftest-wait.html | took 1318ms
 3:32.62 INFO No more tests
No more tests
 3:32.68 INFO Closing logging queue
Closing logging queue
 3:32.68 INFO queue closed
queue closed
 3:32.75 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 161s
 3:32.75 INFO Got 1 unexpected results, with 0 unexpected passes
Got 1 unexpected results, with 0 unexpected passes
 3:32.75 wptserve INFO Stopped http server on 127.0.0.1:8001
wptserve Stopped http server on 127.0.0.1:8001
 3:32.75 wptserve INFO Stopped http server on 127.0.0.1:8000
wptserve Stopped http server on 127.0.0.1:8000
 3:32.75 wptserve INFO Stopped http server on 127.0.0.1:8002
wptserve Stopped http server on 127.0.0.1:8002
 3:32.77 wptserve INFO Stopped http server on 127.0.0.1:8003
wptserve Stopped http server on 127.0.0.1:8003
 3:32.77 wptserve INFO Stopped http server on 127.0.0.1:8443
wptserve Stopped http server on 127.0.0.1:8443
 3:32.77 wptserve INFO Stopped http server on 127.0.0.1:8444
wptserve Stopped http server on 127.0.0.1:8444
 3:32.79 wptserve INFO Stopped http server on 127.0.0.1:8445
wptserve Stopped http server on 127.0.0.1:8445
 3:32.79 wptserve INFO Stopped http server on 127.0.0.1:8446
wptserve Stopped http server on 127.0.0.1:8446
 3:32.82 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:32.84 wptserve INFO Stopped http server on 127.0.0.1:9000
wptserve Stopped http server on 127.0.0.1:9000
 3:32.88 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:33.20 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:33.24 INFO Removed font: Ahem.ttf
Removed font: Ahem.ttf
 3:33.26 INFO Closing logging queue
Closing logging queue
 3:33.26 INFO queue closed
queue closed
[taskcluster 2025-12-22 22:14:33.561Z] === Task Finished ===
[taskcluster 2025-12-22 22:14:34.292Z] Unsuccessful task run with exit code: 1 completed in 373.19 seconds