Open
Bug 1946218
Opened 6 months ago
Updated 6 days ago
Intermittent TEST-UNEXPECTED-TIMEOUT | /webdriver/tests/bidi/network/add_intercept/url_patterns.py | expected OK
Categories
(Remote Protocol :: WebDriver BiDi, defect, P5)
Remote Protocol
WebDriver BiDi
Tracking
(Not tracked)
REOPENED
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure)
Filed by: amarc [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=493449971&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/SH6ta5IlQVC2aw0K0GehLg/runs/0/artifacts/public/logs/live_backing.log
[task 2025-02-05T17:34:49.635Z] 17:34:49 INFO - PID 15912 | 1738776889633 RemoteAgent TRACE Received command network.removeIntercept for destination ROOT
[task 2025-02-05T17:34:49.636Z] 17:34:49 INFO - PID 15912 | 1738776889633 RemoteAgent DEBUG WebDriverBiDiConnection 033aebd3-57e3-4636-aed2-2b774c96b998 <- {"type":"success","id":550,"result":{}}
[task 2025-02-05T17:34:49.654Z] 17:34:49 INFO - PID 15912 | NetworkHelper.parseSecurityInfo threw an exception: Security state 0 has no known STATE_IS_* flags.
[task 2025-02-05T17:34:49.654Z] 17:34:49 INFO - PID 15912 | console.error: "Security state 0 has no known STATE_IS_* flags."
[task 2025-02-05T17:34:49.672Z] 17:34:49 INFO - PID 15912 | 1738776889670 RemoteAgent DEBUG WebDriverBiDiConnection 033aebd3-57e3-4636-aed2-2b774c96b998 -> {"id":551,"method":"browsingContext.close","params":{"context":"9a32f1ac-ada6-4031-b2cb-02f675e24802"}}
[task 2025-02-05T17:34:49.672Z] 17:34:49 INFO - PID 15912 | 1738776889671 RemoteAgent TRACE Received command browsingContext.close for destination ROOT
[task 2025-02-05T17:34:49.675Z] 17:34:49 INFO - PID 15912 | 1738776889670 RemoteAgent TRACE WebDriverProcessData actor created for PID 19088
[task 2025-02-05T17:34:49.743Z] 17:34:49 INFO - PID 15912 | 1738776889739 RemoteAgent TRACE [9a32f1ac-ada6-4031-b2cb-02f675e24802] Navigation already marked as finished, navigationId: b1e35d3a-e0c2-4761-a204-fde1215cf3f1
[task 2025-02-05T17:34:49.746Z] 17:34:49 INFO - PID 15912 | 1738776889745 RemoteAgent TRACE MessageHandler WINDOW_GLOBAL for session 493a0206-5de7-4395-bb85-ec7eead9e782 is being destroyed
[task 2025-02-05T17:34:49.747Z] 17:34:49 INFO - PID 15912 | 1738776889745 RemoteAgent DEBUG WebDriverBiDiConnection 033aebd3-57e3-4636-aed2-2b774c96b998 <- {"type":"success","id":551,"result":{}}
[task 2025-02-05T17:34:49.748Z] 17:34:49 INFO - PID 15912 | 1738776889747 RemoteAgent TRACE Unregistered MessageHandler WINDOW_GLOBAL for session 493a0206-5de7-4395-bb85-ec7eead9e782
[task 2025-02-05T17:34:49.829Z] 17:34:49 INFO - PID 15912 | 1738776889827 RemoteAgent DEBUG WebDriverBiDiConnection 033aebd3-57e3-4636-aed2-2b774c96b998 <- {"type":"success","id":549,"result":{"realm":"f088f92d-7df0-4499-95b2-89b4d156fc92","type":"exception","exceptionDetails":{"columnNumber":22,"exception":{"type":"error"},"lineNumber":9,"stackTrace":{"callFrames":[{"columnNumber":22,"functionName":"","lineNumber":9,"url":"about:blank"}]},"text":"TypeError: NetworkError when attempting to fetch resource."}}}
[task 2025-02-05T17:34:49.831Z] 17:34:49 INFO - PID 15912 | 1738776889828 RemoteAgent TRACE Received command network._setDecodedBodySize for destination ROOT
[task 2025-02-05T17:34:49.831Z] 17:34:49 INFO - PID 15912 | 1738776889829 RemoteAgent TRACE network.interceptEvent returned null, skipping event: network._beforeStopRequest, data: [object Object]
[task 2025-02-05T17:34:49.879Z] 17:34:49 INFO - PID 15912 | 1738776889877 RemoteAgent DEBUG WebDriverBiDiConnection 033aebd3-57e3-4636-aed2-2b774c96b998 -> {"id":552,"method":"session.unsubscribe","params":{"subscriptions":["85731410-3246-4bdb-acde-1aea810930c5"]}}
[task 2025-02-05T17:34:49.879Z] 17:34:49 INFO - PID 15912 | 1738776889877 RemoteAgent TRACE Received command session.unsubscribe for destination ROOT
[task 2025-02-05T17:34:49.881Z] 17:34:49 INFO - PID 15912 | 1738776889879 RemoteAgent DEBUG WebDriverBiDiConnection 033aebd3-57e3-4636-aed2-2b774c96b998 <- {"type":"error","id":552,"error":"unknown error","message":"TypeError: (destructured parameter) is null","stacktrace":"update/<@chrome://remote/content/shared/messagehandler/EventsDispatcher.sys.mjs:153:27\nupdate@chrome://remote/content/shared/ ... ontent/server/WebSocketTransport.sys.mjs:127:18\nhandleEvent@chrome://remote/content/server/WebSocketTransport.sys.mjs:109:14\n"}
[task 2025-02-05T17:34:49.930Z] 17:34:49 INFO - PID 15912 | 1738776889929 RemoteAgent DEBUG WebDriverBiDiConnection 033aebd3-57e3-4636-aed2-2b774c96b998 closed
[task 2025-02-05T17:34:49.932Z] 17:34:49 INFO - PID 15912 | 1738776889930 webdriver::server DEBUG -> POST /session/493a0206-5de7-4395-bb85-ec7eead9e782/timeouts {"implicit": 0}
[task 2025-02-05T17:34:49.948Z] 17:34:49 INFO - PID 15912 | 1738776889946 Marionette DEBUG 0 -> [0,1092,"WebDriver:SetTimeouts",{"implicit":0}]
[task 2025-02-05T17:34:49.951Z] 17:34:49 INFO - PID 15912 | 1738776889947 Marionette DEBUG 0 <- [1,1092,null,{"value":null}]
[task 2025-02-05T17:34:49.953Z] 17:34:49 INFO - PID 15912 | 1738776889948 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2025-02-05T17:34:49.953Z] 17:34:49 INFO - PID 15912 | 1738776889952 webdriver::server DEBUG -> POST /session/493a0206-5de7-4395-bb85-ec7eead9e782/timeouts {"pageLoad": 300000}
[task 2025-02-05T17:34:49.970Z] 17:34:49 INFO - PID 15912 | 1738776889969 Marionette DEBUG 0 -> [0,1093,"WebDriver:SetTimeouts",{"pageLoad":300000}]
[task 2025-02-05T17:34:49.975Z] 17:34:49 INFO - PID 15912 | 1738776889970 Marionette DEBUG 0 <- [1,1093,null,{"value":null}]
[task 2025-02-05T17:34:49.975Z] 17:34:49 INFO - PID 15912 | 1738776889971 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2025-02-05T17:34:49.976Z] 17:34:49 INFO - PID 15912 | 1738776889972 webdriver::server DEBUG -> POST /session/493a0206-5de7-4395-bb85-ec7eead9e782/timeouts {"script": 30000}
[task 2025-02-05T17:34:49.976Z] 17:34:49 INFO - PID 15912 | 1738776889973 Marionette DEBUG 0 -> [0,1094,"WebDriver:SetTimeouts",{"script":30000}]
[task 2025-02-05T17:34:49.979Z] 17:34:49 INFO - PID 15912 | 1738776889974 Marionette DEBUG 0 <- [1,1094,null,{"value":null}]
[task 2025-02-05T17:34:49.979Z] 17:34:49 INFO - PID 15912 | 1738776889976 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2025-02-05T17:34:49.980Z] 17:34:49 INFO - PID 15912 | 1738776889977 webdriver::server DEBUG -> GET /session/493a0206-5de7-4395-bb85-ec7eead9e782/window
[task 2025-02-05T17:34:49.982Z] 17:34:49 INFO - PID 15912 | 1738776889979 Marionette DEBUG 0 -> [0,1095,"WebDriver:GetWindowHandle",{}]
[task 2025-02-05T17:34:49.982Z] 17:34:49 INFO - PID 15912 | 1738776889979 Marionette DEBUG 0 <- [1,1095,null,{"value":"a5c64369-af9c-4d6f-ad15-a468a1b3ec30"}]
[task 2025-02-05T17:34:49.985Z] 17:34:49 INFO - PID 15912 | 1738776889983 webdriver::server DEBUG <- 200 OK {"value":"a5c64369-af9c-4d6f-ad15-a468a1b3ec30"}
[task 2025-02-05T17:34:49.986Z] 17:34:49 INFO - PID 15912 | 1738776889984 webdriver::server DEBUG -> GET /session/493a0206-5de7-4395-bb85-ec7eead9e782/window
[task 2025-02-05T17:34:50.009Z] 17:34:50 INFO - PID 15912 | 1738776890007 Marionette DEBUG 0 -> [0,1096,"WebDriver:GetWindowHandle",{}]
[task 2025-02-05T17:34:50.016Z] 17:34:50 INFO - PID 15912 | 1738776890008 Marionette DEBUG 0 <- [1,1096,null,{"value":"a5c64369-af9c-4d6f-ad15-a468a1b3ec30"}]
[task 2025-02-05T17:34:50.021Z] 17:34:50 INFO - PID 15912 | 1738776890010 webdriver::server DEBUG <- 200 OK {"value":"a5c64369-af9c-4d6f-ad15-a468a1b3ec30"}
[task 2025-02-05T17:34:50.023Z] 17:34:50 INFO - PID 15912 | 1738776890015 webdriver::server DEBUG -> GET /session/493a0206-5de7-4395-bb85-ec7eead9e782/window/handles
[task 2025-02-05T17:34:50.023Z] 17:34:50 INFO - PID 15912 | 1738776890017 Marionette DEBUG 0 -> [0,1097,"WebDriver:GetWindowHandles",{}]
[task 2025-02-05T17:34:50.027Z] 17:34:50 INFO - PID 15912 | 1738776890018 Marionette DEBUG 0 <- [1,1097,null,["a5c64369-af9c-4d6f-ad15-a468a1b3ec30"]]
[task 2025-02-05T17:34:50.027Z] 17:34:50 INFO - PID 15912 | 1738776890020 webdriver::server DEBUG <- 200 OK {"value":["a5c64369-af9c-4d6f-ad15-a468a1b3ec30"]}
[task 2025-02-05T17:34:50.027Z] 17:34:50 INFO - PID 15912 | 1738776890025 webdriver::server DEBUG -> POST /session/493a0206-5de7-4395-bb85-ec7eead9e782/window {"handle": "a5c64369-af9c-4d6f-ad15-a468a1b3ec30"}
[task 2025-02-05T17:34:50.030Z] 17:34:50 INFO - PID 15912 | 1738776890029 Marionette DEBUG 0 -> [0,1098,"WebDriver:SwitchToWindow",{"handle":"a5c64369-af9c-4d6f-ad15-a468a1b3ec30"}]
[task 2025-02-05T17:34:50.038Z] 17:34:50 INFO - PID 15912 | 1738776890037 Marionette DEBUG 0 <- [1,1098,null,{"value":null}]
[task 2025-02-05T17:34:50.048Z] 17:34:50 INFO - PID 15912 | 1738776890046 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2025-02-05T17:34:50.050Z] 17:34:50 INFO - PID 15912 | 1738776890049 webdriver::server DEBUG -> POST /session/493a0206-5de7-4395-bb85-ec7eead9e782/alert/dismiss {}
[task 2025-02-05T17:34:50.051Z] 17:34:50 INFO - PID 15912 | 1738776890050 Marionette DEBUG 0 -> [0,1099,"WebDriver:DismissAlert",{}]
[task 2025-02-05T17:34:50.053Z] 17:34:50 INFO - PID 15912 | 1738776890051 Marionette DEBUG 0 <- [1,1099,{"error":"no such alert","message":"","stacktrace":"RemoteError@chrome://remote/content/shared/RemoteError.sys.mjs:8:8\nWebDriverError@chrome://remote/content/shared/webdriver/Er ... ote/content/marionette/server.sys.mjs:263:9\n_onJSONObjectReady/<@chrome://remote/content/marionette/transport.sys.mjs:494:20\n"},null]
[task 2025-02-05T17:34:50.056Z] 17:34:50 INFO - PID 15912 | 1738776890053 webdriver::server DEBUG <- 404 Not Found {"value":{"error":"no such alert","message":"","stacktrace":"RemoteError@chrome://remote/content/shared/Remo ... ontent/marionette/server.sys.mjs:263:9\n_onJSONObjectReady/<@chrome://remote/content/marionette/transport.sys.mjs:494:20\n"}}
[task 2025-02-05T17:34:50.056Z] 17:34:50 INFO - PID 15912 | 1738776890054 webdriver::server DEBUG -> POST /session/493a0206-5de7-4395-bb85-ec7eead9e782/window {"handle": "a5c64369-af9c-4d6f-ad15-a468a1b3ec30"}
[task 2025-02-05T17:34:50.063Z] 17:34:50 INFO - PID 15912 | 1738776890062 Marionette DEBUG 0 -> [0,1100,"WebDriver:SwitchToWindow",{"handle":"a5c64369-af9c-4d6f-ad15-a468a1b3ec30"}]
[task 2025-02-05T17:34:50.064Z] 17:34:50 INFO - PID 15912 | 1738776890063 Marionette DEBUG 0 <- [1,1100,null,{"value":null}]
[task 2025-02-05T17:34:50.066Z] 17:34:50 INFO - PID 15912 | 1738776890064 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2025-02-05T17:34:50.067Z] 17:34:50 INFO - PID 15912 | 1738776890064 webdriver::server DEBUG -> GET /session/493a0206-5de7-4395-bb85-ec7eead9e782/window
[task 2025-02-05T17:34:50.067Z] 17:34:50 INFO - PID 15912 | 1738776890066 Marionette DEBUG 0 -> [0,1101,"WebDriver:GetWindowHandle",{}]
[task 2025-02-05T17:34:50.068Z] 17:34:50 INFO - PID 15912 | 1738776890066 Marionette DEBUG 0 <- [1,1101,null,{"value":"a5c64369-af9c-4d6f-ad15-a468a1b3ec30"}]
[task 2025-02-05T17:34:50.069Z] 17:34:50 INFO - PID 15912 | 1738776890067 webdriver::server DEBUG <- 200 OK {"value":"a5c64369-af9c-4d6f-ad15-a468a1b3ec30"}
[task 2025-02-05T17:34:50.071Z] 17:34:50 INFO - PID 15912 | 1738776890068 webdriver::server DEBUG -> GET /session/493a0206-5de7-4395-bb85-ec7eead9e782/window/handles
[task 2025-02-05T17:34:50.071Z] 17:34:50 INFO - PID 15912 | 1738776890070 Marionette DEBUG 0 -> [0,1102,"WebDriver:GetWindowHandles",{}]
[task 2025-02-05T17:34:50.071Z] 17:34:50 INFO - PID 15912 | 1738776890070 Marionette DEBUG 0 <- [1,1102,null,["a5c64369-af9c-4d6f-ad15-a468a1b3ec30"]]
[task 2025-02-05T17:34:50.074Z] 17:34:50 INFO - PID 15912 | 1738776890072 webdriver::server DEBUG <- 200 OK {"value":["a5c64369-af9c-4d6f-ad15-a468a1b3ec30"]}
[task 2025-02-05T17:34:50.074Z] 17:34:50 INFO - PID 15912 | 1738776890073 webdriver::server DEBUG -> POST /session/493a0206-5de7-4395-bb85-ec7eead9e782/window {"handle": "a5c64369-af9c-4d6f-ad15-a468a1b3ec30"}
[task 2025-02-05T17:34:50.076Z] 17:34:50 INFO - PID 15912 | 1738776890075 Marionette DEBUG 0 -> [0,1103,"WebDriver:SwitchToWindow",{"handle":"a5c64369-af9c-4d6f-ad15-a468a1b3ec30"}]
[task 2025-02-05T17:34:50.077Z] 17:34:50 INFO - PID 15912 | 1738776890077 Marionette DEBUG 0 <- [1,1103,null,{"value":null}]
[task 2025-02-05T17:34:50.091Z] 17:34:50 INFO - PID 15912 | 1738776890089 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2025-02-05T17:34:50.092Z] 17:34:50 INFO - PID 15912 | 1738776890090 webdriver::server DEBUG -> POST /session/493a0206-5de7-4395-bb85-ec7eead9e782/window/rect {"width": 800, "height": 600}
[task 2025-02-05T17:34:50.093Z] 17:34:50 INFO - PID 15912 | 1738776890092 Marionette DEBUG 0 -> [0,1104,"WebDriver:SetWindowRect",{"height":600,"width":800}]
[task 2025-02-05T17:34:50.095Z] 17:34:50 INFO - PID 15912 | 1738776890094 Marionette TRACE Checking window geometry 800x600 @ (100, 100)
[task 2025-02-05T17:34:50.096Z] 17:34:50 INFO - PID 15912 | 1738776890095 Marionette TRACE Requested window geometry matches
[task 2025-02-05T17:34:50.097Z] 17:34:50 INFO - PID 15912 | 1738776890096 Marionette DEBUG 0 <- [1,1104,null,{"x":100,"y":100,"width":800,"height":600}]
[task 2025-02-05T17:34:50.099Z] 17:34:50 INFO - PID 15912 | 1738776890097 webdriver::server DEBUG <- 200 OK {"value":{"x":100,"y":100,"width":800,"height":600}}
[task 2025-02-05T17:34:50.100Z] 17:34:50 INFO - PID 15912 | 1738776890098 webdriver::server DEBUG -> POST /session/493a0206-5de7-4395-bb85-ec7eead9e782/frame {"id": null}
[task 2025-02-05T17:34:50.101Z] 17:34:50 INFO - PID 15912 | 1738776890101 Marionette DEBUG 0 -> [0,1105,"WebDriver:SwitchToFrame",{"id":null}]
[task 2025-02-05T17:34:50.105Z] 17:34:50 INFO - PID 15912 | 1738776890104 Marionette DEBUG 0 <- [1,1105,null,{"value":null}]
[task 2025-02-05T17:34:50.114Z] 17:34:50 INFO - PID 15912 | 1738776890105 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2025-02-05T17:34:50.362Z] 17:34:50 INFO - STDOUT: tests/web-platform/tests/webdriver/tests/bidi/network/add_intercept/url_patterns.py::test_string_patterns_not_matching[https:/{wpt_host}/??-https:/{wpt_host}/?]
[task 2025-02-05T17:34:50.362Z] 17:34:50 INFO - STDOUT: ERROR
[task 2025-02-05T17:34:50.372Z] 17:34:50 INFO - PID 15912 | 1738776890371 webdriver::server DEBUG -> DELETE /session/493a0206-5de7-4395-bb85-ec7eead9e782
[task 2025-02-05T17:34:50.377Z] 17:34:50 INFO - PID 15912 | 1738776890376 Marionette DEBUG 0 -> [0,1106,"Marionette:Quit",{"flags":["eForceQuit"]}]
[task 2025-02-05T17:34:50.379Z] 17:34:50 INFO - PID 15912 | 1738776890378 Marionette INFO Stopped listening on port 42448
[task 2025-02-05T17:34:50.432Z] 17:34:50 INFO - PID 15912 | 1738776890430 Marionette TRACE [3] MarionetteCommands actor destroyed for window id 8589934593
[task 2025-02-05T17:34:50.434Z] 17:34:50 INFO - PID 15912 | 1738776890432 WebDriver BiDi DEBUG Unregistered session handler: /session/493a0206-5de7-4395-bb85-ec7eead9e782
[task 2025-02-05T17:34:50.462Z] 17:34:50 INFO - PID 15912 | 1738776890460 RemoteAgent TRACE MessageHandler ROOT for session 493a0206-5de7-4395-bb85-ec7eead9e782 is being destroyed
[task 2025-02-05T17:34:50.463Z] 17:34:50 INFO - PID 15912 | 1738776890461 RemoteAgent TRACE Unregistered MessageHandler ROOT for session 493a0206-5de7-4395-bb85-ec7eead9e782
[task 2025-02-05T17:34:50.704Z] 17:34:50 INFO - PID 15912 | -----------------------------------------------------
[task 2025-02-05T17:34:50.704Z] 17:34:50 INFO - PID 15912 | Suppressions used:
[task 2025-02-05T17:34:50.704Z] 17:34:50 INFO - PID 15912 | count bytes template
[task 2025-02-05T17:34:50.704Z] 17:34:50 INFO - PID 15912 | 31 16288 nsComponentManagerImpl
[task 2025-02-05T17:34:50.704Z] 17:34:50 INFO - PID 15912 | 2 288 libfontconfig.so
[task 2025-02-05T17:34:50.704Z] 17:34:50 INFO - PID 15912 | 1 9496 style::sharing::SHARING_CACHE_KEY
[task 2025-02-05T17:34:50.704Z] 17:34:50 INFO - PID 15912 | 1 4104 style::bloom::BLOOM_KEY
[task 2025-02-05T17:34:50.704Z] 17:34:50 INFO - PID 15912 | -----------------------------------------------------
[task 2025-02-05T17:34:50.730Z] 17:34:50 INFO - PID 15912 | 1738776890729 Marionette TRACE Received observer notification quit-application
[task 2025-02-05T17:34:50.742Z] 17:34:50 INFO - PID 15912 | 1738776890740 Marionette TRACE Received observer notification quit-application
[task 2025-02-05T17:34:50.745Z] 17:34:50 INFO - PID 15912 | 1738776890740 RemoteAgent DEBUG Resetting recommended pref browser.contentblocking.introCount
[task 2025-02-05T17:34:50.745Z] 17:34:50 INFO - PID 15912 | 1738776890741 RemoteAgent DEBUG Resetting recommended pref browser.search.update
[task 2025-02-05T17:34:50.746Z] 17:34:50 INFO - PID 15912 | 1738776890741 RemoteAgent DEBUG Resetting recommended pref browser.tabs.remote.unloadDelayMs
[task 2025-02-05T17:34:50.754Z] 17:34:50 INFO - PID 15912 | 1738776890746 RemoteAgent DEBUG Resetting recommended pref browser.tabs.warnOnClose
[task 2025-02-05T17:34:50.754Z] 17:34:50 INFO - PID 15912 | 1738776890746 RemoteAgent DEBUG Resetting recommended pref browser.tabs.warnOnCloseOtherTabs
[task 2025-02-05T17:34:50.755Z] 17:34:50 INFO - PID 15912 | 1738776890746 RemoteAgent DEBUG Resetting recommended pref browser.tabs.warnOnOpen
[task 2025-02-05T17:34:50.755Z] 17:34:50 INFO - PID 15912 | 1738776890747 RemoteAgent DEBUG Resetting recommended pref browser.usedOnWindows10.introURL
[task 2025-02-05T17:34:50.756Z] 17:34:50 INFO - PID 15912 | 1738776890747 RemoteAgent DEBUG Resetting recommended pref datareporting.policy.dataSubmissionPolicyAccepted
[task 2025-02-05T17:34:50.756Z] 17:34:50 INFO - PID 15912 | 1738776890748 RemoteAgent DEBUG Resetting recommended pref dom.navigation.navigationRateLimit.count
[task 2025-02-05T17:34:50.757Z] 17:34:50 INFO - PID 15912 | 1738776890748 RemoteAgent DEBUG Resetting recommended pref dom.screenorientation.allow-lock
[task 2025-02-05T17:34:50.758Z] 17:34:50 INFO - PID 15912 | 1738776890748 RemoteAgent DEBUG Resetting recommended pref network.connectivity-service.enabled
[task 2025-02-05T17:34:50.763Z] 17:34:50 INFO - PID 15912 | 1738776890753 RemoteAgent DEBUG Resetting recommended pref privacy.trackingprotection.enabled
[task 2025-02-05T17:34:50.764Z] 17:34:50 INFO - PID 15912 | 1738776890754 RemoteAgent DEBUG Resetting recommended pref remote.prefs.recommended.applied
[task 2025-02-05T17:34:50.765Z] 17:34:50 INFO - PID 15912 | 1738776890754 RemoteAgent DEBUG Resetting recommended pref security.fileuri.strict_origin_policy
[task 2025-02-05T17:34:50.768Z] 17:34:50 INFO - PID 15912 | 1738776890755 RemoteAgent DEBUG Resetting recommended pref services.settings.loglevel
[task 2025-02-05T17:34:50.769Z] 17:34:50 INFO - PID 15912 | 1738776890755 RemoteAgent DEBUG Resetting recommended pref signon.autofillForms
[task 2025-02-05T17:34:50.770Z] 17:34:50 INFO - PID 15912 | 1738776890766 RemoteAgent DEBUG Resetting recommended pref widget.windows.window_occlusion_tracking.enabled
[task 2025-02-05T17:34:50.772Z] 17:34:50 INFO - PID 15912 | 1738776890767 RemoteAgent DEBUG Resetting recommended pref permissions.isolateBy.userContext
[task 2025-02-05T17:34:50.773Z] 17:34:50 INFO - PID 15912 | 1738776890767 RemoteAgent TRACE Received observer notification quit-application
[task 2025-02-05T17:34:50.782Z] 17:34:50 INFO - PID 15912 | 1738776890776 Marionette DEBUG Marionette stopped listening
[task 2025-02-05T17:34:50.801Z] 17:34:50 INFO - PID 15912 | 1738776890800 Marionette DEBUG 0 <- [1,1106,null,{"cause":"shutdown","forced":false,"in_app":true}]
[task 2025-02-05T17:34:50.965Z] 17:34:50 INFO - PID 15912 | 1738776890964 RemoteAgent TRACE MessageHandler WINDOW_GLOBAL for session 493a0206-5de7-4395-bb85-ec7eead9e782 is being destroyed
[task 2025-02-05T17:34:50.967Z] 17:34:50 INFO - PID 15912 | 1738776890966 RemoteAgent TRACE Unregistered MessageHandler WINDOW_GLOBAL for session 493a0206-5de7-4395-bb85-ec7eead9e782
[task 2025-02-05T17:34:51.114Z] 17:34:51 INFO - PID 15912 | 1738776891112 webdriver::server DEBUG Teardown session
[task 2025-02-05T17:34:51.143Z] 17:34:51 INFO - PID 15912 | 1738776891142 Marionette DEBUG Closed connection 0
[task 2025-02-05T17:34:52.490Z] 17:34:52 INFO - PID 15912 | -----------------------------------------------------
[task 2025-02-05T17:34:52.491Z] 17:34:52 INFO - PID 15912 | Suppressions used:
[task 2025-02-05T17:34:52.493Z] 17:34:52 INFO - PID 15912 | count bytes template
[task 2025-02-05T17:34:52.495Z] 17:34:52 INFO - PID 15912 | 31 16288 nsComponentManagerImpl
[task 2025-02-05T17:34:52.497Z] 17:34:52 INFO - PID 15912 | 2 288 libfontconfig.so
[task 2025-02-05T17:34:52.498Z] 17:34:52 INFO - PID 15912 | 1 9496 style::sharing::SHARING_CACHE_KEY
[task 2025-02-05T17:34:52.500Z] 17:34:52 INFO - PID 15912 | 1 4104 style::bloom::BLOOM_KEY
[task 2025-02-05T17:34:52.501Z] 17:34:52 INFO - PID 15912 | -----------------------------------------------------
[task 2025-02-05T17:34:54.690Z] 17:34:54 INFO - PID 15912 | -----------------------------------------------------
[task 2025-02-05T17:34:54.691Z] 17:34:54 INFO - PID 15912 | Suppressions used:
[task 2025-02-05T17:34:54.692Z] 17:34:54 INFO - PID 15912 | count bytes template
[task 2025-02-05T17:34:54.693Z] 17:34:54 INFO - PID 15912 | 31 16288 nsComponentManagerImpl
[task 2025-02-05T17:34:54.694Z] 17:34:54 INFO - PID 15912 | 2 288 libfontconfig.so
[task 2025-02-05T17:34:54.695Z] 17:34:54 INFO - PID 15912 | 1 9496 style::sharing::SHARING_CACHE_KEY
[task 2025-02-05T17:34:54.697Z] 17:34:54 INFO - PID 15912 | 1 4104 style::bloom::BLOOM_KEY
[task 2025-02-05T17:34:54.697Z] 17:34:54 INFO - PID 15912 | -----------------------------------------------------
[task 2025-02-05T17:34:55.264Z] 17:34:55 INFO - PID 15912 | -----------------------------------------------------
[task 2025-02-05T17:34:55.267Z] 17:34:55 INFO - PID 15912 | Suppressions used:
[task 2025-02-05T17:34:55.269Z] 17:34:55 INFO - PID 15912 | count bytes template
[task 2025-02-05T17:34:55.270Z] 17:34:55 INFO - PID 15912 | 31 16288 nsComponentManagerImpl
[task 2025-02-05T17:34:55.272Z] 17:34:55 INFO - PID 15912 | 2 288 libfontconfig.so
[task 2025-02-05T17:34:55.274Z] 17:34:55 INFO - PID 15912 | 1 9496 style::sharing::SHARING_CACHE_KEY
[task 2025-02-05T17:34:55.275Z] 17:34:55 INFO - PID 15912 | 1 4104 style::bloom::BLOOM_KEY
[task 2025-02-05T17:34:55.277Z] 17:34:55 INFO - PID 15912 | -----------------------------------------------------
[task 2025-02-05T17:34:55.691Z] 17:34:55 INFO - PID 15912 | [Parent 17027, IPC I/O Parent] WARNING: Process 19055 may be hanging at shutdown; will wait for up to 40000ms: file /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/process_watcher_posix_sigchld.cc:190
[task 2025-02-05T17:34:56.840Z] 17:34:56 INFO - PID 15912 | -----------------------------------------------------
[task 2025-02-05T17:34:56.842Z] 17:34:56 INFO - PID 15912 | Suppressions used:
[task 2025-02-05T17:34:56.844Z] 17:34:56 INFO - PID 15912 | count bytes template
[task 2025-02-05T17:34:56.846Z] 17:34:56 INFO - PID 15912 | 31 16288 nsComponentManagerImpl
[task 2025-02-05T17:34:56.848Z] 17:34:56 INFO - PID 15912 | 2 288 libfontconfig.so
[task 2025-02-05T17:34:56.850Z] 17:34:56 INFO - PID 15912 | 1 9496 style::sharing::SHARING_CACHE_KEY
[task 2025-02-05T17:34:56.851Z] 17:34:56 INFO - PID 15912 | 1 4104 style::bloom::BLOOM_KEY
[task 2025-02-05T17:34:56.853Z] 17:34:56 INFO - PID 15912 | -----------------------------------------------------
[task 2025-02-05T17:34:57.092Z] 17:34:57 INFO - PID 15912 | [Parent 17027, IPC I/O Parent] WARNING: Process 19088 may be hanging at shutdown; will wait for up to 38600ms: file /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/process_watcher_posix_sigchld.cc:190
[task 2025-02-05T17:34:57.736Z] 17:34:57 INFO - PID 15912 | -----------------------------------------------------
[task 2025-02-05T17:34:57.738Z] 17:34:57 INFO - PID 15912 | Suppressions used:
[task 2025-02-05T17:34:57.740Z] 17:34:57 INFO - PID 15912 | count bytes template
[task 2025-02-05T17:34:57.741Z] 17:34:57 INFO - PID 15912 | 31 16288 nsComponentManagerImpl
[task 2025-02-05T17:34:57.744Z] 17:34:57 INFO - PID 15912 | 2 288 libfontconfig.so
[task 2025-02-05T17:34:57.744Z] 17:34:57 INFO - PID 15912 | 1 9496 style::sharing::SHARING_CACHE_KEY
[task 2025-02-05T17:34:57.745Z] 17:34:57 INFO - PID 15912 | 1 4104 style::bloom::BLOOM_KEY
[task 2025-02-05T17:34:57.746Z] 17:34:57 INFO - PID 15912 | -----------------------------------------------------
[task 2025-02-05T17:34:57.893Z] 17:34:57 INFO - PID 15912 | [Parent 17027, IPC I/O Parent] WARNING: Process 19090 may be hanging at shutdown; will wait for up to 37800ms: file /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/process_watcher_posix_sigchld.cc:190
[task 2025-02-05T17:34:58.038Z] 17:34:58 INFO - PID 15912 | -----------------------------------------------------
[task 2025-02-05T17:34:58.038Z] 17:34:58 INFO - PID 15912 | Suppressions used:
[task 2025-02-05T17:34:58.039Z] 17:34:58 INFO - PID 15912 | count bytes template
[task 2025-02-05T17:34:58.039Z] 17:34:58 INFO - PID 15912 | 31 16288 nsComponentManagerImpl
[task 2025-02-05T17:34:58.039Z] 17:34:58 INFO - PID 15912 | 2 288 libfontconfig.so
[task 2025-02-05T17:34:58.040Z] 17:34:58 INFO - PID 15912 | -----------------------------------------------------
[task 2025-02-05T17:34:58.102Z] 17:34:58 INFO - PID 15912 | -----------------------------------------------------
[task 2025-02-05T17:34:58.102Z] 17:34:58 INFO - PID 15912 | Suppressions used:
[task 2025-02-05T17:34:58.102Z] 17:34:58 INFO - PID 15912 | count bytes template
[task 2025-02-05T17:34:58.102Z] 17:34:58 INFO - PID 15912 | 31 16288 nsComponentManagerImpl
[task 2025-02-05T17:34:58.103Z] 17:34:58 INFO - PID 15912 | 2 288 libfontconfig.so
[task 2025-02-05T17:34:58.104Z] 17:34:58 INFO - PID 15912 | -----------------------------------------------------
[task 2025-02-05T17:34:58.293Z] 17:34:58 INFO - PID 15912 | [Parent 17027, IPC I/O Parent] WARNING: Process 19142 may be hanging at shutdown; will wait for up to 37400ms: file /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/process_watcher_posix_sigchld.cc:190
[task 2025-02-05T17:34:58.372Z] 17:34:58 INFO - PID 15912 | -----------------------------------------------------
[task 2025-02-05T17:34:58.372Z] 17:34:58 INFO - PID 15912 | Suppressions used:
[task 2025-02-05T17:34:58.372Z] 17:34:58 INFO - PID 15912 | count bytes template
[task 2025-02-05T17:34:58.372Z] 17:34:58 INFO - PID 15912 | 31 16288 nsComponentManagerImpl
[task 2025-02-05T17:34:58.372Z] 17:34:58 INFO - PID 15912 | 2 288 libfontconfig.so
[task 2025-02-05T17:34:58.372Z] 17:34:58 INFO - PID 15912 | -----------------------------------------------------
[task 2025-02-05T17:34:58.494Z] 17:34:58 INFO - PID 15912 | [Parent 17027, IPC I/O Parent] WARNING: Process 17224 may be hanging at shutdown; will wait for up to 37200ms: file /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/process_watcher_posix_sigchld.cc:190
[task 2025-02-05T17:34:58.554Z] 17:34:58 INFO - PID 15912 | -----------------------------------------------------
[task 2025-02-05T17:34:58.554Z] 17:34:58 INFO - PID 15912 | Suppressions used:
[task 2025-02-05T17:34:58.554Z] 17:34:58 INFO - PID 15912 | count bytes template
[task 2025-02-05T17:34:58.554Z] 17:34:58 INFO - PID 15912 | 31 16288 nsComponentManagerImpl
[task 2025-02-05T17:34:58.554Z] 17:34:58 INFO - PID 15912 | 2 288 libfontconfig.so
[task 2025-02-05T17:34:58.554Z] 17:34:58 INFO - PID 15912 | 1 9496 style::sharing::SHARING_CACHE_KEY
[task 2025-02-05T17:34:58.554Z] 17:34:58 INFO - PID 15912 | 1 4104 style::bloom::BLOOM_KEY
[task 2025-02-05T17:34:58.554Z] 17:34:58 INFO - PID 15912 | -----------------------------------------------------
[task 2025-02-05T17:34:58.567Z] 17:34:58 INFO - PID 15912 | -----------------------------------------------------
[task 2025-02-05T17:34:58.567Z] 17:34:58 INFO - PID 15912 | Suppressions used:
[task 2025-02-05T17:34:58.567Z] 17:34:58 INFO - PID 15912 | count bytes template
[task 2025-02-05T17:34:58.567Z] 17:34:58 INFO - PID 15912 | 31 16288 nsComponentManagerImpl
[task 2025-02-05T17:34:58.567Z] 17:34:58 INFO - PID 15912 | 2 288 libfontconfig.so
[task 2025-02-05T17:34:58.567Z] 17:34:58 INFO - PID 15912 | 1 9496 style::sharing::SHARING_CACHE_KEY
[task 2025-02-05T17:34:58.567Z] 17:34:58 INFO - PID 15912 | 1 4104 style::bloom::BLOOM_KEY
[task 2025-02-05T17:34:58.567Z] 17:34:58 INFO - PID 15912 | -----------------------------------------------------
[task 2025-02-05T17:34:58.670Z] 17:34:58 INFO - PID 15912 | -----------------------------------------------------
[task 2025-02-05T17:34:58.670Z] 17:34:58 INFO - PID 15912 | Suppressions used:
[task 2025-02-05T17:34:58.670Z] 17:34:58 INFO - PID 15912 | count bytes template
[task 2025-02-05T17:34:58.670Z] 17:34:58 INFO - PID 15912 | 31 16288 nsComponentManagerImpl
[task 2025-02-05T17:34:58.671Z] 17:34:58 INFO - PID 15912 | 2 288 libfontconfig.so
[task 2025-02-05T17:34:58.671Z] 17:34:58 INFO - PID 15912 | -----------------------------------------------------
[task 2025-02-05T17:35:04.111Z] 17:35:04 INFO - TEST-UNEXPECTED-TIMEOUT | /webdriver/tests/bidi/network/add_intercept/url_patterns.py | expected OK
[task 2025-02-05T17:35:04.111Z] 17:35:04 INFO - TEST-INFO took 105006ms
|
||
Updated•6 months ago
|
|
||
Updated•3 months ago
|
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
|
|
||
Comment 5•2 months ago
|
||
This doesn't seem to be a high frequent failure anymore.
Summary: High frequency TEST-UNEXPECTED-TIMEOUT | /webdriver/tests/bidi/network/add_intercept/url_patterns.py | expected OK → Intermittent TEST-UNEXPECTED-TIMEOUT | /webdriver/tests/bidi/network/add_intercept/url_patterns.py | expected OK
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
You need to log in
before you can comment on or make changes to this bug.
Description
•