Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

[grid] decrement the connection per session counter on close #14842 #14854

Merged
merged 2 commits into from
Dec 12, 2024
Merged

[grid] decrement the connection per session counter on close #14842 #14854

merged 2 commits into from
Dec 12, 2024

Conversation

joerg1985
Copy link
Member

@joerg1985 joerg1985 commented Dec 4, 2024 •
edited by qodo-merge-pro bot
Loading

User description

Description

This PR will decrement the counter of the connections per session limit introduced in #14410.

Motivation and Context

This will e.g. allow to close a VNC session and reopen it multiple times.

Types of changes

  • Bug fix (non-breaking change which fixes an issue)
  • New feature (non-breaking change which adds functionality)
  • Breaking change (fix or feature that would cause existing functionality to change)

Checklist

  • I have read the contributing document.
  • My change requires a change to the documentation.
  • I have updated the documentation accordingly.
  • I have added tests to cover my changes.
  • All new and existing tests passed.

PR Type

Bug fix, Enhancement, Tests

Description

  • Added a DELETE endpoint to manage websocket connection closures, ensuring proper decrement of connection counters.
  • Implemented releaseConnection method across various node classes to handle connection lifecycle.
  • Enhanced connection management logic in OneShotNode and LocalNode to prevent counting rejected connections.
  • Updated tests to verify the enforcement of connection limits per session.
  • Improved documentation for connection limit configuration.

Changes walkthrough 📝

Relevant files
Enhancement
7 files
Node.java
Add endpoint and method for websocket connection closure 

java/src/org/openqa/selenium/grid/node/Node.java

  • Added DELETE endpoint for closing websocket connections.
  • Introduced releaseConnection method to manage connection closure.
    		•  +11/-0   
    ProxyNodeWebsockets.java
    Modify WebSocket listener to manage connection lifecycle 

    java/src/org/openqa/selenium/grid/node/ProxyNodeWebsockets.java

  • Modified ForwardingListener to include Node for connection management.
  • Updated onClose method to release connection.
    		•  +8/-3     
    ReleaseConnection.java
    Implement ReleaseConnection class for handling connection release

    java/src/org/openqa/selenium/grid/node/ReleaseConnection.java

  • Implemented ReleaseConnection class to handle connection release
    requests.
  • Ensures HTTP response status is set to 200 upon successful execution.
    		•  +43/-0   
    TryAcquireConnection.java
    Simplify JSON content creation in TryAcquireConnection     

    java/src/org/openqa/selenium/grid/node/TryAcquireConnection.java

    • Replaced ImmutableMap with Map for JSON content creation.
    		 +2/-3     
    OneShotNode.java
    Enhance connection management in OneShotNode                         

    java/src/org/openqa/selenium/grid/node/k8s/OneShotNode.java

  • Added logic to decrement connection counter upon connection release.
  • Ensured rejected connections are not counted.
    		•  +18/-1   
    LocalNode.java
    Improve connection handling in LocalNode                                 

    java/src/org/openqa/selenium/grid/node/local/LocalNode.java

  • Implemented connection release logic to decrement counter.
  • Ensured rejected connections are not counted.
    		•  +25/-1   
    RemoteNode.java
    Add remote connection release functionality                           

    java/src/org/openqa/selenium/grid/node/remote/RemoteNode.java

  • Added releaseConnection method to manage remote connection closure.
    		•  +12/-0   
    Documentation
    1 files
    NodeFlags.java
    Update description for connection limit configuration       

    java/src/org/openqa/selenium/grid/node/config/NodeFlags.java

    • Clarified description for connection limit per session parameter.
    		 +2/-2     
    Tests
    2 files
    AddingNodesTest.java
    Update test node with connection release method                   

    java/test/org/openqa/selenium/grid/distributor/AddingNodesTest.java

    • Added releaseConnection method in test node implementation.
    		 +3/-0     
    DistributedTest.java
    Add test for connection limit enforcement                               

    java/test/org/openqa/selenium/grid/router/DistributedTest.java

  • Added test to verify connection limit enforcement.
  • Utilized BiDiProvider to manage multiple connections.
    		•  +50/-1   

    💡 PR-Agent usage: Comment /help "your question" on any pull request to receive relevant information

    @qodo-merge-pro Qodo Merge Pro
    Copy link
    Contributor

    qodo-merge-pro bot commented Dec 4, 2024

    PR Reviewer Guide 🔍

    Here are some key observations to aid the review process:

    ⏱️ Estimated effort to review: 3 🔵🔵🔵⚪⚪
    🧪 PR contains tests
    🔒 No security concerns identified
    ⚡ Recommended focus areas for review

    Race Condition
    The increment and decrement operations on connectionCounter are not atomic, which could lead to race conditions in high concurrency scenarios

    Race Condition
    Similar to OneShotNode, the connection counter operations are not atomic which could cause issues with concurrent connections

    Error Handling
    The releaseConnection call in onClose does not handle potential exceptions which could leave connections in an inconsistent state

    @qodo-merge-pro Qodo Merge Pro
    Copy link
    Contributor

    qodo-merge-pro bot commented Dec 4, 2024

    PR Code Suggestions ✨

    Explore these optional code suggestions:

    CategorySuggestion                                                                                                                                    Score
    Possible issue
    Prevent race conditions in concurrent connection counter updates by using atomic compare-and-set operations

    Add synchronization to prevent race conditions when incrementing/decrementing the
    connection counter. Use AtomicInteger's compareAndSet() for thread-safe updates.

    java/src/org/openqa/selenium/grid/node/k8s/OneShotNode.java [372-378]

    -if (connectionLimitPerSession > connectionCounter.getAndIncrement()) {
-  return true;
-}
+int current;
+do {
+  current = connectionCounter.get();
+  if (current >= connectionLimitPerSession) {
+    return false;
+  }
+} while (!connectionCounter.compareAndSet(current, current + 1));
+return true;
 
-// ensure a rejected connection will not be counted 
-connectionCounter.getAndDecrement();
-return false;
-
    • Apply this suggestion
    Suggestion importance[1-10]: 9

    Why: The suggestion addresses a critical thread-safety issue by replacing simple increment/decrement operations with atomic compare-and-set, preventing potential race conditions that could lead to connection limit violations.

    		9
    Add defensive null check to prevent potential null pointer exceptions

    Add null check for the connection counter to prevent NullPointerException if the
    slot's counter is not initialized.

    java/src/org/openqa/selenium/grid/node/local/LocalNode.java [648-650]

     AtomicLong counter = slot.getConnectionCounter();
-counter.decrementAndGet();
+if (counter != null) {
+  counter.decrementAndGet();
+}
    • Apply this suggestion
    Suggestion importance[1-10]: 7

    Why: The suggestion prevents potential NullPointerException that could crash the application, improving robustness of the connection management system.

    		7
    General
    Add error handling for failed HTTP responses to prevent silent failures

    Add error handling for failed HTTP responses when releasing connections to prevent
    silent failures.

    java/src/org/openqa/selenium/grid/node/remote/RemoteNode.java [206-208]

     HttpResponse res = client.with(addSecret).execute(req);
+if (res.getStatus() != 200) {
+  throw new RuntimeException("Failed to release connection: " + res.getStatus());
+}
 Values.get(res, Void.class);
    • Apply this suggestion
    Suggestion importance[1-10]: 8

    Why: The suggestion adds crucial error handling for HTTP responses, preventing silent failures that could mask connection release issues and making the system more reliable and debuggable.

    		8

    💡 Need additional feedback ? start a PR chat

    @joerg1985
    Copy link
    Member Author

    @VietND96 you reviewed / merged the original PR, could you have a look at this one please?

    @qodo-merge-pro Qodo Merge Pro
    Copy link
    Contributor

    qodo-merge-pro bot commented Dec 4, 2024 •
    edited
    Loading

    CI Failure Feedback 🧐

    (Checks updated until commit a320f32)

    Action: Ruby / Local Tests (firefox, macos) / Local Tests (firefox, macos)

    Failed stage: Run Bazel [❌]

    Failed test name: Selenium::WebDriver::Firefox::Driver#install_addon

    Failure summary:

    The action failed due to multiple issues in the Selenium WebDriver tests for Firefox:

  • The test Selenium::WebDriver::Firefox::Driver#install_addon failed because it could not locate the
    element with the ID webextensions-selenium-example, resulting in a NoSuchElementError.
  • The test Selenium::WebDriver::DevTools sends commands failed because the expected page title "XHTML
    Test Page" was not found, resulting in an empty title.
  • Several other tests related to Selenium WebDriver DevTools for Firefox were marked as pending or
    failed due to unsupported features or missing methods, such as pin_script and register.

    • Relevant error logs: 
    1:  ##[group]Operating System
2:  macOS
...

816:  �[32m[1,890 / 1,912]�[0m 2 / 30 tests;�[0m Testing //rb/spec/integration/selenium/webdriver:timeout-firefox; 112s local, disk-cache ... (3 actions, 1 running)
817:  �[32m[1,890 / 1,912]�[0m 2 / 30 tests;�[0m Testing //rb/spec/integration/selenium/webdriver:timeout-firefox; 124s local, disk-cache ... (3 actions, 1 running)
818:  �[32m[1,890 / 1,912]�[0m 2 / 30 tests;�[0m Testing //rb/spec/integration/selenium/webdriver:timeout-firefox; 130s local, disk-cache ... (3 actions, 2 running)
819:  �[35mFLAKY: �[0m//rb/spec/integration/selenium/webdriver:timeout-firefox (Summary)
820:  ==================== Test output for //rb/spec/integration/selenium/webdriver:timeout-firefox:
821:  /Users/runner/.bazel/execroot/_main/bazel-out/darwin_arm64-fastbuild/testlogs/rb/spec/integration/selenium/webdriver/timeout-firefox/test_attempts/attempt_1.log
822:  Running Ruby specs:
823:  �[32mINFO: �[0mFrom Testing //rb/spec/integration/selenium/webdriver:timeout-firefox:
824:  An error occurred in a `before(:suite)` hook.
825:  Failure/Error: (io = @io.to_io).wait_readable(@read_timeout) or raise Net::ReadTimeout.new(io)
...

838:  # ./rb/lib/selenium/webdriver/common/driver.rb:53:in `for'
839:  # /Users/runner/work/selenium/selenium/rb/spec/integration/selenium/webdriver/spec_support/test_environment.rb:253:in `firefox_driver'
840:  # /Users/runner/work/selenium/selenium/rb/spec/integration/selenium/webdriver/spec_support/test_environment.rb:171:in `create_driver!'
841:  # /Users/runner/work/selenium/selenium/rb/spec/integration/selenium/webdriver/spec_support/test_environment.rb:61:in `driver_instance'
842:  # /Users/runner/work/selenium/selenium/rb/spec/integration/selenium/webdriver/spec_support/test_environment.rb:206:in `current_env'
843:  # /Users/runner/work/selenium/selenium/rb/spec/integration/selenium/webdriver/spec_support/test_environment.rb:42:in `print_env'
844:  # /Users/runner/work/selenium/selenium/rb/spec/integration/selenium/webdriver/spec_helper.rb:41:in `block (2 levels) in <top (required)>'
845:  Finished in 1 minute 1.78 seconds (files took 0.30714 seconds to load)
846:  0 examples, 0 failures, 1 error occurred outside of examples
847:  ================================================================================
848:  �[32m[1,891 / 1,912]�[0m 3 / 30 tests;�[0m [Sched] Testing //rb/spec/integration/selenium/webdriver:error-firefox; 18s ... (3 actions, 1 running)
849:  �[32m[1,891 / 1,912]�[0m 3 / 30 tests;�[0m [Sched] Testing //rb/spec/integration/selenium/webdriver:error-firefox; 20s ... (3 actions, 1 running)
850:  �[32m[1,891 / 1,912]�[0m 3 / 30 tests;�[0m [Sched] Testing //rb/spec/integration/selenium/webdriver:error-firefox; 30s ... (3 actions, 1 running)
...

908:  2024-12-11 03:20:30 DEBUG Selenium [:command]    >>> http://127.0.0.1:4444/session/ced37c67-763f-4649-b01a-8b8498f88134/url | {"url":"http://localhost:49816/blank.html"} 
909:  2024-12-11 03:20:30 DEBUG Selenium [:header]      > {"Accept"=>"application/json", "Content-Type"=>"application/json; charset=UTF-8", "User-Agent"=>"selenium/4.28.0.nightly (ruby macosx)", "Content-Length"=>"43"} 
910:  2024-12-11 03:20:31 DEBUG Selenium [:header]    <<<  {"content-type"=>["application/json; charset=utf-8"], "cache-control"=>["no-cache"], "content-length"=>["14"], "date"=>["Wed, 11 Dec 2024 03:20:30 GMT"]} 
911:  2024-12-11 03:20:31 DEBUG Selenium [:command] <- {"value":null} 
912:  2024-12-11 03:20:31 DEBUG Selenium [:command] -> POST session/ced37c67-763f-4649-b01a-8b8498f88134/element 
913:  2024-12-11 03:20:31 DEBUG Selenium [:command]    >>> http://127.0.0.1:4444/session/ced37c67-763f-4649-b01a-8b8498f88134/element | {"using":"css selector","value":"#webextensions\\-selenium\\-example"} 
914:  2024-12-11 03:20:31 DEBUG Selenium [:header]      > {"Accept"=>"application/json", "Content-Type"=>"application/json; charset=UTF-8", "User-Agent"=>"selenium/4.28.0.nightly (ruby macosx)", "Content-Length"=>"70"} 
915:  2024-12-11 03:20:31 DEBUG Selenium [:header]    <<<  {"content-type"=>["application/json; charset=utf-8"], "cache-control"=>["no-cache"], "content-length"=>["419"], "date"=>["Wed, 11 Dec 2024 03:20:31 GMT"]} 
916:  2024-12-11 03:20:31 DEBUG Selenium [:command] <- {"value":{"error":"no such element","message":"Unable to locate element: #webextensions\\-selenium\\-example","stacktrace":"RemoteError@chrome://remote/content/shared/RemoteError.sys.mjs:8:8\nWebDriverError@chrome://remote/content/shared/webdriver/Errors.sys.mjs:193:5\nNoSuchElementError@chrome://remote/content/shared/webdriver/Errors.sys.mjs:511:5\ndom.find/</<@chrome://remote/content/shared/DOM.sys.mjs:136:16\n"}} 
...

935:  2024-12-11 03:20:33 DEBUG Selenium [:command] -> POST session 
936:  2024-12-11 03:20:33 DEBUG Selenium [:command]    >>> http://127.0.0.1:4444/session | {"capabilities":{"alwaysMatch":{"acceptInsecureCerts":true,"browserName":"firefox","moz:firefoxOptions":{"binary":"external/_main~pin_browsers_extension~mac_firefox/Firefox.app/Contents/MacOS/firefox","prefs":{"remote.active-protocols":3}},"moz:debuggerAddress":true}}} 
937:  2024-12-11 03:20:33 DEBUG Selenium [:header]      > {"Accept"=>"application/json", "Content-Type"=>"application/json; charset=UTF-8", "User-Agent"=>"selenium/4.28.0.nightly (ruby macosx)", "Content-Length"=>"269"} 
938:  1733887233380	webdriver::server	DEBUG	-> POST /session {"capabilities":{"alwaysMatch":{"acceptInsecureCerts":true,"browserName":"firefox","moz:firefoxOptions":{"bi ... xtension~mac_firefox/Firefox.app/Contents/MacOS/firefox","prefs":{"remote.active-protocols":3}},"moz:debuggerAddress":true}}}
939:  1733887233382	geckodriver::capabilities	DEBUG	Trying to read firefox version from ini files
940:  1733887233387	geckodriver::capabilities	DEBUG	Found version 133.0
941:  1733887233396	mozrunner::runner	INFO	Running command: MOZ_CRASHREPORTER="1" MOZ_CRASHREPORTER_NO_REPORT="1" MOZ_CRASHREPORTER_SHUTDOWN="1" MOZ_NO_REMOTE="1" "exte ... s" "localhost" "-foreground" "-no-remote" "-profile" "/var/folders/0w/4z5l9vds32nbkz7l22n8j6s80000gn/T/rust_mozprofile8G9qXh"
942:  1733887233397	geckodriver::marionette	DEBUG	Waiting 60s to connect to browser on 127.0.0.1
943:  1733887233397	geckodriver::browser	TRACE	Failed to open /var/folders/0w/4z5l9vds32nbkz7l22n8j6s80000gn/T/rust_mozprofile8G9qXh/MarionetteActivePort
944:  1733887233397	geckodriver::marionette	TRACE	Retrying in 100ms
945:  1733887233580	geckodriver::browser	TRACE	Failed to open /var/folders/0w/4z5l9vds32nbkz7l22n8j6s80000gn/T/rust_mozprofile8G9qXh/MarionetteActivePort
946:  1733887233581	geckodriver::marionette	TRACE	Retrying in 100ms
947:  1733887233819	geckodriver::browser	TRACE	Failed to open /var/folders/0w/4z5l9vds32nbkz7l22n8j6s80000gn/T/rust_mozprofile8G9qXh/MarionetteActivePort
948:  1733887233819	geckodriver::marionette	TRACE	Retrying in 100ms
949:  1733887234064	geckodriver::browser	TRACE	Failed to open /var/folders/0w/4z5l9vds32nbkz7l22n8j6s80000gn/T/rust_mozprofile8G9qXh/MarionetteActivePort
950:  1733887234064	geckodriver::marionette	TRACE	Retrying in 100ms
951:  console.warn: services.settings: Ignoring preference override of remote settings server
952:  console.warn: services.settings: Allow by setting MOZ_REMOTE_SETTINGS_DEVTOOLS=1 in the environment
953:  1733887234314	geckodriver::browser	TRACE	Failed to open /var/folders/0w/4z5l9vds32nbkz7l22n8j6s80000gn/T/rust_mozprofile8G9qXh/MarionetteActivePort
954:  1733887234314	geckodriver::marionette	TRACE	Retrying in 100ms
955:  1733887234420	geckodriver::browser	TRACE	Failed to open /var/folders/0w/4z5l9vds32nbkz7l22n8j6s80000gn/T/rust_mozprofile8G9qXh/MarionetteActivePort
...

1013:  1733887234609	RemoteAgent	DEBUG	Setting recommended pref security.remote_settings.intermediates.enabled to false
1014:  1733887234609	RemoteAgent	DEBUG	Setting recommended pref signon.autofillForms to false
1015:  1733887234609	RemoteAgent	DEBUG	Setting recommended pref signon.rememberSignons to false
1016:  1733887234609	RemoteAgent	DEBUG	Setting recommended pref toolkit.telemetry.server to https://%(server)s/telemetry-dummy/
1017:  1733887234609	RemoteAgent	DEBUG	Setting recommended pref widget.windows.window_occlusion_tracking.enabled to false
1018:  1733887234611	RemoteAgent	DEBUG	WebDriver BiDi enabled
1019:  1733887234612	RemoteAgent	DEBUG	CDP enabled
1020:  1733887234613	Marionette	INFO	Marionette enabled
1021:  1733887234666	geckodriver::browser	TRACE	Failed to open /var/folders/0w/4z5l9vds32nbkz7l22n8j6s80000gn/T/rust_mozprofile8G9qXh/MarionetteActivePort
1022:  1733887234666	geckodriver::marionette	TRACE	Retrying in 100ms
1023:  1733887234914	geckodriver::browser	TRACE	Failed to open /var/folders/0w/4z5l9vds32nbkz7l22n8j6s80000gn/T/rust_mozprofile8G9qXh/MarionetteActivePort
1024:  1733887234914	geckodriver::marionette	TRACE	Retrying in 100ms
1025:  1733887235164	geckodriver::browser	TRACE	Failed to open /var/folders/0w/4z5l9vds32nbkz7l22n8j6s80000gn/T/rust_mozprofile8G9qXh/MarionetteActivePort
1026:  1733887235164	geckodriver::marionette	TRACE	Retrying in 100ms
1027:  1733887235291	geckodriver::browser	TRACE	Failed to open /var/folders/0w/4z5l9vds32nbkz7l22n8j6s80000gn/T/rust_mozprofile8G9qXh/MarionetteActivePort
1028:  1733887235291	geckodriver::marionette	TRACE	Retrying in 100ms
1029:  1733887235345	Marionette	TRACE	Received observer notification final-ui-startup
1030:  1733887235348	RemoteAgent	TRACE	Received observer notification final-ui-startup
1031:  1733887235465	geckodriver::browser	TRACE	Failed to open /var/folders/0w/4z5l9vds32nbkz7l22n8j6s80000gn/T/rust_mozprofile8G9qXh/MarionetteActivePort
1032:  1733887235465	geckodriver::marionette	TRACE	Retrying in 100ms
1033:  console.error: "Warning: unrecognized command line flag" "-remote-allow-hosts"
1034:  1733887235529	Marionette	INFO	Listening on port 49838
1035:  1733887235531	Marionette	DEBUG	Marionette is listening
1036:  Read port: 49838
1037:  1733887235705	RemoteAgent	TRACE	Available local IP addresses: 127.0.0.1, [::1]
1038:  !!! could not start server on port 9222: [Exception... "Component returned failure code: 0x804b0036 (NS_ERROR_SOCKET_ADDRESS_IN_USE) [nsIServerSocket.init]"  nsresult: "0x804b0036 (NS_ERROR_SOCKET_ADDRESS_IN_USE)"  location: "JS frame :: chrome://remote/content/server/httpd.sys.mjs :: _start :: line 556"  data: no]
1039:  1733887235713	RemoteAgent	ERROR	Unable to stop listener: [Exception... "Unexpected error"  nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)"  location: "JS frame :: chrome://remote/content/server/httpd.sys.mjs :: stop :: line 610"  data: no] Stack trace: stop()@httpd.sys.mjs:610
1040:  #stop()@RemoteAgent.sys.mjs:353
1041:  1733887235713	RemoteAgent	ERROR	Unable to start remote agent: : [Exception... "Component is not available"  nsresult: "0x80040111 (NS_ERROR_NOT_AVAILABLE)"  location: "JS frame :: chrome://remote/content/server/httpd.sys.mjs :: _start :: line 601"  data: no] Stack trace: _start()@httpd.sys.mjs:601
1042:  #listen()@RemoteAgent.sys.mjs:272
1043:  1733887235721	Marionette	DEBUG	Accepted connection 0 from 127.0.0.1:49839
1044:  1733887235760	geckodriver::marionette	DEBUG	Connection to Marionette established on 127.0.0.1:49838.
1045:  1733887235795	Marionette	DEBUG	0 -> [0,1,"WebDriver:NewSession",{"acceptInsecureCerts":true,"browserName":"firefox"}]
1046:  1733887235798	RemoteAgent	WARN	TLS certificate errors will be ignored for this session
1047:  1733887235799	Marionette	DEBUG	Waiting for initial application window
1048:  1733887238812	Marionette	TRACE	Received observer notification browser-idle-startup-tasks-finished
1049:  1733887238812	RemoteAgent	TRACE	Received observer notification browser-idle-startup-tasks-finished
1050:  1733887238817	RemoteAgent	TRACE	[9] ProgressListener Start: expectNavigation=false resolveWhenStarted=false unloadTimeout=5000 waitForExplicitStart=false
1051:  1733887238817	RemoteAgent	TRACE	[9] ProgressListener Setting unload timer (5000ms)
1052:  1733887238818	RemoteAgent	TRACE	[9] Wait for initial navigation: isInitial=false, isLoadingDocument=false
1053:  1733887238818	RemoteAgent	TRACE	[9] Document already finished loading: about:blank
1054:  1733887238818	RemoteAgent	TRACE	[9] ProgressListener Stop: has error=false url=about:blank
1055:  1733887238838	Marionette	DEBUG	0 <- [1,1,null,{"sessionId":"64222434-cc6b-4b9b-b2b6-2780190e0e91","capabilities":{"acceptInsecureCerts":true,"browserName":"firefox","browserVersion":"133.0","platformName":"mac","unhandledPromptBehavior":"dismiss and notify","userAgent":"Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:133.0) Gecko/20100101 Firefox/133.0","moz:buildID":"20241121140525","moz:headless":false,"moz:platformVersion":"23.6.0","moz:processID":14464,"moz:profile":"/var/folders/0w/4z5l9vds32nbkz7l22n8j6s80000gn/T/rust_mozprofile8G9qXh","moz:shutdownTimeout":60000,"pageLoadStrategy":"normal","timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"setWindowRect":true,"strictFileInteractability":false,"moz:accessibilityChecks":false,"moz:debuggerAddress":"127.0.0.1:9222","moz:webdriverClick":true,"moz:windowless":false,"proxy":{}}}]
1056:  1733887238849	webdriver::server	DEBUG	<- 200 OK {"value":{"sessionId":"64222434-cc6b-4b9b-b2b6-2780190e0e91","capabilities":{"acceptInsecureCerts":true,"browserNam ... r":"dismiss and notify","userAgent":"Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:133.0) Gecko/20100101 Firefox/133.0"}}}
1057:  2024-12-11 03:20:38 DEBUG Selenium [:header]    <<<  {"content-type"=>["application/json; charset=utf-8"], "cache-control"=>["no-cache"], "content-length"=>["849"], "date"=>["Wed, 11 Dec 2024 03:20:33 GMT"]} 
1058:  2024-12-11 03:20:38 DEBUG Selenium [:command] <- {"value":{"sessionId":"64222434-cc6b-4b9b-b2b6-2780190e0e91","capabilities":{"acceptInsecureCerts":true,"browserName":"firefox","browserVersion":"133.0","moz:accessibilityChecks":false,"moz:buildID":"20241121140525","moz:debuggerAddress":"127.0.0.1:9222","moz:geckodriverVersion":"0.35.0","moz:headless":false,"moz:platformVersion":"23.6.0","moz:processID":14464,"moz:profile":"/var/folders/0w/4z5l9vds32nbkz7l22n8j6s80000gn/T/rust_mozprofile8G9qXh","moz:shutdownTimeout":60000,"moz:webdriverClick":true,"moz:windowless":false,"pageLoadStrategy":"normal","platformName":"mac","proxy":{},"setWindowRect":true,"strictFileInteractability":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"unhandledPromptBehavior":"dismiss and notify","userAgent":"Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:133.0) Gecko/20100101 Firefox/133.0"}}} 
1059:  install and uninstall xpi file (FAILED - 1)
...

1083:  2024-12-11 03:20:39 DEBUG Selenium [:command] <- {"value":null} 
1084:  2024-12-11 03:20:39 DEBUG Selenium [:command] -> POST session/64222434-cc6b-4b9b-b2b6-2780190e0e91/element 
1085:  2024-12-11 03:20:39 DEBUG Selenium [:command]    >>> http://127.0.0.1:4444/session/64222434-cc6b-4b9b-b2b6-2780190e0e91/element | {"using":"css selector","value":"#webextensions\\-selenium\\-example"} 
1086:  2024-12-11 03:20:39 DEBUG Selenium [:header]      > {"Accept"=>"application/json", "Content-Type"=>"application/json; charset=UTF-8", "User-Agent"=>"selenium/4.28.0.nightly (ruby macosx)", "Content-Length"=>"70"} 
1087:  1733887239430	webdriver::server	DEBUG	-> POST /session/64222434-cc6b-4b9b-b2b6-2780190e0e91/element {"using":"css selector","value":"#webextensions\\-selenium\\-example"}
1088:  1733887239438	Marionette	DEBUG	0 -> [0,4,"WebDriver:FindElement",{"using":"css selector","value":"#webextensions\\-selenium\\-example"}]
1089:  1733887239488	RemoteAgent	TRACE	WebDriverProcessData actor created for PID 14659
1090:  1733887239491	Marionette	TRACE	[11] MarionetteCommands actor created for window id 10737418241
1091:  1733887239561	Marionette	DEBUG	0 <- [1,4,{"error":"no such element","message":"Unable to locate element: #webextensions\\-selenium\\-example","stacktrace":"RemoteError@chrome://remote/content/shared/RemoteError.sys.mjs:8:8\nWebDriverError@chrome://remote/content/shared/webdriver/Er ... chrome://remote/content/shared/webdriver/Errors.sys.mjs:511:5\ndom.find/</<@chrome://remote/content/shared/DOM.sys.mjs:136:16\n"},null]
1092:  1733887239562	webdriver::server	DEBUG	<- 404 Not Found {"value":{"error":"no such element","message":"Unable to locate element: #webextensions\\-selenium\\-example ... e://remote/content/shared/webdriver/Errors.sys.mjs:511:5\ndom.find/</<@chrome://remote/content/shared/DOM.sys.mjs:136:16\n"}}
1093:  2024-12-11 03:20:39 DEBUG Selenium [:header]    <<<  {"content-type"=>["application/json; charset=utf-8"], "cache-control"=>["no-cache"], "content-length"=>["419"], "date"=>["Wed, 11 Dec 2024 03:20:38 GMT"]} 
1094:  2024-12-11 03:20:39 DEBUG Selenium [:command] <- {"value":{"error":"no such element","message":"Unable to locate element: #webextensions\\-selenium\\-example","stacktrace":"RemoteError@chrome://remote/content/shared/RemoteError.sys.mjs:8:8\nWebDriverError@chrome://remote/content/shared/webdriver/Errors.sys.mjs:193:5\nNoSuchElementError@chrome://remote/content/shared/webdriver/Errors.sys.mjs:511:5\ndom.find/</<@chrome://remote/content/shared/DOM.sys.mjs:136:16\n"}} 
...

1157:  1733887240125	RemoteAgent	DEBUG	Resetting recommended pref security.notification_enable_delay
1158:  1733887240125	RemoteAgent	DEBUG	Resetting recommended pref security.remote_settings.intermediates.enabled
1159:  1733887240125	RemoteAgent	DEBUG	Resetting recommended pref signon.autofillForms
1160:  1733887240125	RemoteAgent	DEBUG	Resetting recommended pref signon.rememberSignons
1161:  1733887240126	RemoteAgent	DEBUG	Resetting recommended pref toolkit.telemetry.server
1162:  1733887240126	RemoteAgent	DEBUG	Resetting recommended pref widget.windows.window_occlusion_tracking.enabled
1163:  1733887240126	RemoteAgent	TRACE	Received observer notification quit-application
1164:  1733887240130	Marionette	DEBUG	Marionette stopped listening
1165:  1733887240131	RemoteAgent	ERROR	Unable to stop listener: [Exception... "Unexpected error"  nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)"  location: "JS frame :: chrome://remote/content/server/httpd.sys.mjs :: stop :: line 610"  data: no] Stack trace: stop()@httpd.sys.mjs:610
...

1189:  2024-12-11 03:20:40 DEBUG Selenium [:command] -> POST session 
1190:  2024-12-11 03:20:40 DEBUG Selenium [:command]    >>> http://127.0.0.1:4444/session | {"capabilities":{"alwaysMatch":{"acceptInsecureCerts":true,"browserName":"firefox","moz:firefoxOptions":{"binary":"external/_main~pin_browsers_extension~mac_firefox/Firefox.app/Contents/MacOS/firefox","prefs":{"remote.active-protocols":3}},"moz:debuggerAddress":true}}} 
1191:  2024-12-11 03:20:40 DEBUG Selenium [:header]      > {"Accept"=>"application/json", "Content-Type"=>"application/json; charset=UTF-8", "User-Agent"=>"selenium/4.28.0.nightly (ruby macosx)", "Content-Length"=>"269"} 
1192:  1733887240800	webdriver::server	DEBUG	-> POST /session {"capabilities":{"alwaysMatch":{"acceptInsecureCerts":true,"browserName":"firefox","moz:firefoxOptions":{"bi ... xtension~mac_firefox/Firefox.app/Contents/MacOS/firefox","prefs":{"remote.active-protocols":3}},"moz:debuggerAddress":true}}}
1193:  1733887240801	geckodriver::capabilities	DEBUG	Trying to read firefox version from ini files
1194:  1733887240804	geckodriver::capabilities	DEBUG	Found version 133.0
1195:  1733887240823	mozrunner::runner	INFO	Running command: MOZ_CRASHREPORTER="1" MOZ_CRASHREPORTER_NO_REPORT="1" MOZ_CRASHREPORTER_SHUTDOWN="1" MOZ_NO_REMOTE="1" "exte ... s" "localhost" "-foreground" "-no-remote" "-profile" "/var/folders/0w/4z5l9vds32nbkz7l22n8j6s80000gn/T/rust_mozprofile0szvO1"
1196:  1733887240824	geckodriver::marionette	DEBUG	Waiting 60s to connect to browser on 127.0.0.1
1197:  1733887240824	geckodriver::browser	TRACE	Failed to open /var/folders/0w/4z5l9vds32nbkz7l22n8j6s80000gn/T/rust_mozprofile0szvO1/MarionetteActivePort
1198:  1733887240824	geckodriver::marionette	TRACE	Retrying in 100ms
1199:  1733887241034	geckodriver::browser	TRACE	Failed to open /var/folders/0w/4z5l9vds32nbkz7l22n8j6s80000gn/T/rust_mozprofile0szvO1/MarionetteActivePort
1200:  1733887241034	geckodriver::marionette	TRACE	Retrying in 100ms
1201:  console.warn: services.settings: Ignoring preference override of remote settings server
1202:  console.warn: services.settings: Allow by setting MOZ_REMOTE_SETTINGS_DEVTOOLS=1 in the environment
1203:  1733887241282	geckodriver::browser	TRACE	Failed to open /var/folders/0w/4z5l9vds32nbkz7l22n8j6s80000gn/T/rust_mozprofile0szvO1/MarionetteActivePort
1204:  1733887241282	geckodriver::marionette	TRACE	Retrying in 100ms
1205:  1733887241482	geckodriver::browser	TRACE	Failed to open /var/folders/0w/4z5l9vds32nbkz7l22n8j6s80000gn/T/rust_mozprofile0szvO1/MarionetteActivePort
...

1263:  1733887241523	RemoteAgent	DEBUG	Setting recommended pref security.remote_settings.intermediates.enabled to false
1264:  1733887241523	RemoteAgent	DEBUG	Setting recommended pref signon.autofillForms to false
1265:  1733887241523	RemoteAgent	DEBUG	Setting recommended pref signon.rememberSignons to false
1266:  1733887241523	RemoteAgent	DEBUG	Setting recommended pref toolkit.telemetry.server to https://%(server)s/telemetry-dummy/
1267:  1733887241523	RemoteAgent	DEBUG	Setting recommended pref widget.windows.window_occlusion_tracking.enabled to false
1268:  1733887241524	RemoteAgent	DEBUG	WebDriver BiDi enabled
1269:  1733887241525	RemoteAgent	DEBUG	CDP enabled
1270:  1733887241526	Marionette	INFO	Marionette enabled
1271:  1733887241731	geckodriver::browser	TRACE	Failed to open /var/folders/0w/4z5l9vds32nbkz7l22n8j6s80000gn/T/rust_mozprofile0szvO1/MarionetteActivePort
1272:  1733887241731	geckodriver::marionette	TRACE	Retrying in 100ms
1273:  1733887241981	geckodriver::browser	TRACE	Failed to open /var/folders/0w/4z5l9vds32nbkz7l22n8j6s80000gn/T/rust_mozprofile0szvO1/MarionetteActivePort
1274:  1733887241981	geckodriver::marionette	TRACE	Retrying in 100ms
1275:  1733887242065	Marionette	TRACE	Received observer notification final-ui-startup
1276:  1733887242067	RemoteAgent	TRACE	Received observer notification final-ui-startup
1277:  1733887242120	geckodriver::browser	TRACE	Failed to open /var/folders/0w/4z5l9vds32nbkz7l22n8j6s80000gn/T/rust_mozprofile0szvO1/MarionetteActivePort
1278:  1733887242120	geckodriver::marionette	TRACE	Retrying in 100ms
1279:  console.error: "Warning: unrecognized command line flag" "-remote-allow-hosts"
1280:  1733887242235	Marionette	INFO	Listening on port 49852
1281:  1733887242236	Marionette	DEBUG	Marionette is listening
1282:  Read port: 49852
1283:  1733887242405	RemoteAgent	TRACE	Available local IP addresses: 127.0.0.1, [::1]
1284:  !!! could not start server on port 9222: [Exception... "Component returned failure code: 0x804b0036 (NS_ERROR_SOCKET_ADDRESS_IN_USE) [nsIServerSocket.init]"  nsresult: "0x804b0036 (NS_ERROR_SOCKET_ADDRESS_IN_USE)"  location: "JS frame :: chrome://remote/content/server/httpd.sys.mjs :: _start :: line 556"  data: no]
1285:  1733887242414	RemoteAgent	ERROR	Unable to stop listener: [Exception... "Unexpected error"  nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)"  location: "JS frame :: chrome://remote/content/server/httpd.sys.mjs :: stop :: line 610"  data: no] Stack trace: stop()@httpd.sys.mjs:610
1286:  #stop()@RemoteAgent.sys.mjs:353
1287:  1733887242414	RemoteAgent	ERROR	Unable to start remote agent: : [Exception... "Component is not available"  nsresult: "0x80040111 (NS_ERROR_NOT_AVAILABLE)"  location: "JS frame :: chrome://remote/content/server/httpd.sys.mjs :: _start :: line 601"  data: no] Stack trace: _start()@httpd.sys.mjs:601
1288:  #listen()@RemoteAgent.sys.mjs:272
1289:  1733887242427	Marionette	DEBUG	Accepted connection 0 from 127.0.0.1:49853
1290:  1733887242464	geckodriver::marionette	DEBUG	Connection to Marionette established on 127.0.0.1:49852.
1291:  1733887242517	Marionette	DEBUG	0 -> [0,1,"WebDriver:NewSession",{"acceptInsecureCerts":true,"browserName":"firefox"}]
1292:  1733887242521	RemoteAgent	WARN	TLS certificate errors will be ignored for this session
1293:  1733887242522	Marionette	DEBUG	Waiting for initial application window
1294:  1733887246373	Marionette	TRACE	Received observer notification browser-idle-startup-tasks-finished
1295:  1733887246373	RemoteAgent	TRACE	Received observer notification browser-idle-startup-tasks-finished
1296:  1733887246384	RemoteAgent	TRACE	[9] ProgressListener Start: expectNavigation=false resolveWhenStarted=false unloadTimeout=5000 waitForExplicitStart=false
1297:  1733887246384	RemoteAgent	TRACE	[9] ProgressListener Setting unload timer (5000ms)
1298:  1733887246384	RemoteAgent	TRACE	[9] Wait for initial navigation: isInitial=false, isLoadingDocument=false
1299:  1733887246384	RemoteAgent	TRACE	[9] Document already finished loading: about:blank
1300:  1733887246384	RemoteAgent	TRACE	[9] ProgressListener Stop: has error=false url=about:blank
1301:  1733887246426	Marionette	DEBUG	0 <- [1,1,null,{"sessionId":"2ca644fb-12b3-4831-a1ae-0c91a0dbef04","capabilities":{"acceptInsecureCerts":true,"browserName":"firefox","browserVersion":"133.0","platformName":"mac","unhandledPromptBehavior":"dismiss and notify","userAgent":"Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:133.0) Gecko/20100101 Firefox/133.0","moz:buildID":"20241121140525","moz:headless":false,"moz:platformVersion":"23.6.0","moz:processID":14675,"moz:profile":"/var/folders/0w/4z5l9vds32nbkz7l22n8j6s80000gn/T/rust_mozprofile0szvO1","moz:shutdownTimeout":60000,"pageLoadStrategy":"normal","timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"setWindowRect":true,"strictFileInteractability":false,"moz:accessibilityChecks":false,"moz:debuggerAddress":"127.0.0.1:9222","moz:webdriverClick":true,"moz:windowless":false,"proxy":{}}}]
1302:  1733887246452	webdriver::server	DEBUG	<- 200 OK {"value":{"sessionId":"2ca644fb-12b3-4831-a1ae-0c91a0dbef04","capabilities":{"acceptInsecureCerts":true,"browserNam ... r":"dismiss and notify","userAgent":"Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:133.0) Gecko/20100101 Firefox/133.0"}}}
1303:  2024-12-11 03:20:46 DEBUG Selenium [:header]    <<<  {"content-type"=>["application/json; charset=utf-8"], "cache-control"=>["no-cache"], "content-length"=>["849"], "date"=>["Wed, 11 Dec 2024 03:20:40 GMT"]} 
1304:  2024-12-11 03:20:46 DEBUG Selenium [:command] <- {"value":{"sessionId":"2ca644fb-12b3-4831-a1ae-0c91a0dbef04","capabilities":{"acceptInsecureCerts":true,"browserName":"firefox","browserVersion":"133.0","moz:accessibilityChecks":false,"moz:buildID":"20241121140525","moz:debuggerAddress":"127.0.0.1:9222","moz:geckodriverVersion":"0.35.0","moz:headless":false,"moz:platformVersion":"23.6.0","moz:processID":14675,"moz:profile":"/var/folders/0w/4z5l9vds32nbkz7l22n8j6s80000gn/T/rust_mozprofile0szvO1","moz:shutdownTimeout":60000,"moz:webdriverClick":true,"moz:windowless":false,"pageLoadStrategy":"normal","platformName":"mac","proxy":{},"setWindowRect":true,"strictFileInteractability":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"unhandledPromptBehavior":"dismiss and notify","userAgent":"Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:133.0) Gecko/20100101 Firefox/133.0"}}} 
1305:  install and uninstall signed zip file (FAILED - 2)
...

1587:  1733887248319	RemoteAgent	DEBUG	Resetting recommended pref security.notification_enable_delay
1588:  1733887248319	RemoteAgent	DEBUG	Resetting recommended pref security.remote_settings.intermediates.enabled
1589:  1733887248319	RemoteAgent	DEBUG	Resetting recommended pref signon.autofillForms
1590:  1733887248320	RemoteAgent	DEBUG	Resetting recommended pref signon.rememberSignons
1591:  1733887248320	RemoteAgent	DEBUG	Resetting recommended pref toolkit.telemetry.server
1592:  1733887248321	RemoteAgent	DEBUG	Resetting recommended pref widget.windows.window_occlusion_tracking.enabled
1593:  1733887248321	RemoteAgent	TRACE	Received observer notification quit-application
1594:  1733887248323	Marionette	DEBUG	Marionette stopped listening
1595:  1733887248323	RemoteAgent	ERROR	Unable to stop listener: [Exception... "Unexpected error"  nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)"  location: "JS frame :: chrome://remote/content/server/httpd.sys.mjs :: stop :: line 610"  data: no] Stack trace: stop()@httpd.sys.mjs:610
...

1609:  2024-12-11 03:20:48 DEBUG Selenium [:process] Checking if 14670 is exited: 
1610:  2024-12-11 03:20:48 DEBUG Selenium [:process]   -> exit code is 15 
1611:  2024-12-11 03:20:48 DEBUG Selenium [:process] Checking if 14670 is exited: 
1612:  2024-12-11 03:20:48 DEBUG Selenium [:process]   -> exit code is 15 
1613:  2024-12-11 03:20:48 DEBUG Selenium [:process]   -> stopped 14670 
1614:  Pending: (Failures listed here are expected and do not affect your suite's status)
1615:  1) Selenium::WebDriver::Firefox::Driver#print_options prints full page
1616:  # Test guarded; Guarded by {:platform=>:macosx, :reason=>"showing half resolution of what expected"};
1617:  Got 1 failure:
1618:  1.1) Failure/Error: expect(width).to be >= viewport_width
1619:  expected: >= 1280
1620:  got:    632
1621:  # ./rb/spec/integration/selenium/webdriver/firefox/driver_spec.rb:58:in `block (3 levels) in <module:Firefox>'
1622:  Failures:
1623:  1) Selenium::WebDriver::Firefox::Driver#install_addon install and uninstall xpi file
1624:  Failure/Error: injected = driver.find_element(id: 'webextensions-selenium-example')
1625:  Selenium::WebDriver::Error::NoSuchElementError:
1626:  Unable to locate element: #webextensions\-selenium\-example; For documentation on this error, please visit: https://www.selenium.dev/documentation/webdriver/troubleshooting/errors#no-such-element-exception
1627:  # ./rb/lib/selenium/webdriver/remote/response.rb:63:in `add_cause'
1628:  # ./rb/lib/selenium/webdriver/remote/response.rb:41:in `error'
...

1633:  # ./rb/lib/selenium/webdriver/remote/http/default.rb:103:in `request'
1634:  # ./rb/lib/selenium/webdriver/remote/http/common.rb:68:in `call'
1635:  # ./rb/lib/selenium/webdriver/remote/bridge.rb:685:in `execute'
1636:  # ./rb/lib/selenium/webdriver/remote/bridge.rb:553:in `find_element_by'
1637:  # ./rb/lib/selenium/webdriver/common/search_context.rb:71:in `find_element'
1638:  # ./rb/spec/integration/selenium/webdriver/firefox/driver_spec.rb:74:in `block (3 levels) in <module:Firefox>'
1639:  # ------------------
1640:  # --- Caused by: ---
1641:  # Selenium::WebDriver::Error::WebDriverError:
1642:  #   RemoteError@chrome://remote/content/shared/RemoteError.sys.mjs:8:8
1643:  WebDriverError@chrome://remote/content/shared/webdriver/Errors.sys.mjs:193:5
1644:  NoSuchElementError@chrome://remote/content/shared/webdriver/Errors.sys.mjs:511:5
1645:  dom.find/</<@chrome://remote/content/shared/DOM.sys.mjs:136:16
1646:  2) Selenium::WebDriver::Firefox::Driver#install_addon install and uninstall signed zip file
1647:  Failure/Error: injected = driver.find_element(id: 'webextensions-selenium-example')
1648:  Selenium::WebDriver::Error::NoSuchElementError:
1649:  Unable to locate element: #webextensions\-selenium\-example; For documentation on this error, please visit: https://www.selenium.dev/documentation/webdriver/troubleshooting/errors#no-such-element-exception
1650:  # ./rb/lib/selenium/webdriver/remote/response.rb:63:in `add_cause'
1651:  # ./rb/lib/selenium/webdriver/remote/response.rb:41:in `error'
...

1656:  # ./rb/lib/selenium/webdriver/remote/http/default.rb:103:in `request'
1657:  # ./rb/lib/selenium/webdriver/remote/http/common.rb:68:in `call'
1658:  # ./rb/lib/selenium/webdriver/remote/bridge.rb:685:in `execute'
1659:  # ./rb/lib/selenium/webdriver/remote/bridge.rb:553:in `find_element_by'
1660:  # ./rb/lib/selenium/webdriver/common/search_context.rb:71:in `find_element'
1661:  # ./rb/spec/integration/selenium/webdriver/firefox/driver_spec.rb:89:in `block (3 levels) in <module:Firefox>'
1662:  # ------------------
1663:  # --- Caused by: ---
1664:  # Selenium::WebDriver::Error::WebDriverError:
1665:  #   RemoteError@chrome://remote/content/shared/RemoteError.sys.mjs:8:8
1666:  WebDriverError@chrome://remote/content/shared/webdriver/Errors.sys.mjs:193:5
1667:  NoSuchElementError@chrome://remote/content/shared/webdriver/Errors.sys.mjs:511:5
1668:  dom.find/</<@chrome://remote/content/shared/DOM.sys.mjs:136:16
1669:  Finished in 58.89 seconds (files took 0.32975 seconds to load)
1670:  10 examples, 2 failures, 1 pending
1671:  Failed examples:
...

1727:  �[32m[1,916 / 1,917]�[0m 28 / 30 tests;�[0m Testing //rb/spec/integration/selenium/webdriver:devtools-firefox; 262s local, disk-cache
1728:  �[31m�[1mFAIL: �[0m//rb/spec/integration/selenium/webdriver:devtools-firefox (see /Users/runner/.bazel/execroot/_main/bazel-out/darwin_arm64-fastbuild/testlogs/rb/spec/integration/selenium/webdriver/devtools-firefox/test_attempts/attempt_1.log)
1729:  �[32m[1,916 / 1,917]�[0m 28 / 30 tests;�[0m Testing //rb/spec/integration/selenium/webdriver:devtools-firefox; 264s local, disk-cache
1730:  �[32m[1,916 / 1,917]�[0m 28 / 30 tests;�[0m Testing //rb/spec/integration/selenium/webdriver:devtools-firefox; 541s local, disk-cache
1731:  �[31m�[1mFAIL: �[0m//rb/spec/integration/selenium/webdriver:devtools-firefox (see /Users/runner/.bazel/execroot/_main/bazel-out/darwin_arm64-fastbuild/testlogs/rb/spec/integration/selenium/webdriver/devtools-firefox/test_attempts/attempt_2.log)
1732:  �[32m[1,916 / 1,917]�[0m 28 / 30 tests;�[0m Testing //rb/spec/integration/selenium/webdriver:devtools-firefox; 542s local, disk-cache
1733:  �[32m[1,916 / 1,917]�[0m 28 / 30 tests;�[0m Testing //rb/spec/integration/selenium/webdriver:devtools-firefox; 836s local, disk-cache
1734:  �[31m�[1mFAIL: �[0m//rb/spec/integration/selenium/webdriver:devtools-firefox (see /Users/runner/.bazel/execroot/_main/bazel-out/darwin_arm64-fastbuild/testlogs/rb/spec/integration/selenium/webdriver/devtools-firefox/test.log)
1735:  �[31m�[1mFAILED: �[0m//rb/spec/integration/selenium/webdriver:devtools-firefox (Summary)
...

1742:  browser: firefox
1743:  driver: firefox
1744:  version: 133.0
1745:  platform: macosx
1746:  ci: github
1747:  rbe: false
1748:  ruby: ruby 3.1.6p260 (2024-05-29 revision a777087be6) [arm64-darwin23]
1749:  Selenium::WebDriver::DevTools
1750:  sends commands (FAILED - 1)
1751:  maps methods to classes
1752:  supports events (PENDING: Test guarded; Guarded by {:browser=>:firefox, :reason=>"https://bugzilla.mozilla.org/show_bug.cgi?id=1819965"};)
1753:  propagates errors in events (PENDING: Test guarded; Guarded by {:browser=>:firefox, :reason=>"https://bugzilla.mozilla.org/show_bug.cgi?id=1819965"};)
1754:  2024-12-11 03:27:21 WARN Selenium [:on_log_event] [DEPRECATION] Driver#on_log_event on Firefox is deprecated. Use the script.add_console_message_handler or the script.add_javascript_error_handler methods instead. 
1755:  notifies about log messages (PENDING: Test guarded; Guarded by {:browser=>:firefox, :reason=>"https://bugzilla.mozilla.org/show_bug.cgi?id=1819965"};)
1756:  2024-12-11 03:27:35 WARN Selenium [:on_log_event] [DEPRECATION] Driver#on_log_event on Firefox is deprecated. Use the script.add_console_message_handler or the script.add_javascript_error_handler methods instead. 
1757:  notifies about document log messages (PENDING: Test guarded; Guarded by {:browser=>:firefox, :reason=>"Firefox & Chrome parse document differently"};)
1758:  2024-12-11 03:27:57 WARN Selenium [:on_log_event] [DEPRECATION] Driver#on_log_event on Firefox is deprecated. Use the script.add_console_message_handler or the script.add_javascript_error_handler methods instead. 
1759:  notifies about document log messages (PENDING: Test guarded; Guarded by {:browser=>[:chrome, :edge, :firefox], :reason=>"https://bugzilla.mozilla.org/show_bug.cgi?id=1819965"};)
1760:  2024-12-11 03:28:18 WARN Selenium [:on_log_event] [DEPRECATION] Driver#on_log_event on Firefox is deprecated. Use the script.add_console_message_handler or the script.add_javascript_error_handler methods instead. 
1761:  notifies about exceptions (PENDING: Test guarded; Guarded by {:browser=>:firefox, :reason=>"https://bugzilla.mozilla.org/show_bug.cgi?id=1819965"};)
1762:  2024-12-11 03:28:39 WARN Selenium [:on_log_event] [DEPRECATION] Driver#on_log_event on Firefox is deprecated. Use the script.add_console_message_handler or the script.add_javascript_error_handler methods instead. 
...

1778:  ensures pinned script is available on new pages (PENDING: Test guarded; Guarded by {:browser=>:firefox, :reason=>"No reason given"};)
1779:  allows to unpin script (PENDING: Test guarded; Guarded by {:browser=>:firefox, :reason=>"No reason given"};)
1780:  ensures unpinned scripts are not available on new pages (PENDING: Test guarded; Guarded by {:browser=>:firefox, :reason=>"No reason given"};)
1781:  handles arguments in pinned script (PENDING: Test guarded; Guarded by {:browser=>:firefox, :reason=>"No reason given"};)
1782:  supports async pinned scripts (PENDING: Test guarded; Guarded by {:browser=>:firefox, :reason=>"No reason given"};)
1783:  Pending: (Failures listed here are expected and do not affect your suite's status)
1784:  1) Selenium::WebDriver::DevTools supports events
1785:  # Test guarded; Guarded by {:browser=>:firefox, :reason=>"https://bugzilla.mozilla.org/show_bug.cgi?id=1819965"};
1786:  Got 1 failure:
1787:  1.1) Failure/Error:
1788:  expect { |block|
1789:  driver.devtools.page.enable
1790:  driver.devtools.page.on(:load_event_fired, &block)
1791:  driver.navigate.to url_for('xhtmlTest.html')
1792:  sleep 0.5
1793:  }.to yield_control
1794:  expected given block to yield control but did not yield
1795:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:41:in `block (2 levels) in <module:WebDriver>'
1796:  2) Selenium::WebDriver::DevTools propagates errors in events
1797:  # Test guarded; Guarded by {:browser=>:firefox, :reason=>"https://bugzilla.mozilla.org/show_bug.cgi?id=1819965"};
1798:  Got 1 failure:
1799:  2.1) Failure/Error:
1800:  expect {
1801:  driver.devtools.page.enable
1802:  driver.devtools.page.on(:load_event_fired) { raise 'This is fine!' }
1803:  driver.navigate.to url_for('xhtmlTest.html')
1804:  sleep 0.5
1805:  }.to raise_error(RuntimeError, 'This is fine!')
1806:  expected RuntimeError with "This is fine!" but nothing was raised
1807:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:51:in `block (2 levels) in <module:WebDriver>'
1808:  3) Selenium::WebDriver::DevTools notifies about log messages
1809:  # Test guarded; Guarded by {:browser=>:firefox, :reason=>"https://bugzilla.mozilla.org/show_bug.cgi?id=1819965"};
1810:  Got 1 failure:
1811:  3.1) Failure/Error:
...

1821:  -[(an object having attributes {:args => ["I like cheese"], :type => :log}),
1822:  - (an object having attributes {:args => [true], :type => :log}),
1823:  - (an object having attributes {:args => [nil], :type => :log}),
1824:  - (an object having attributes {:args => [{"type" => "undefined"}], :type => :log})]
1825:  +[]
1826:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:100:in `block (2 levels) in <module:WebDriver>'
1827:  4) Selenium::WebDriver::DevTools notifies about document log messages
1828:  # Test guarded; Guarded by {:browser=>:firefox, :reason=>"Firefox & Chrome parse document differently"};
1829:  Failure/Error: wait.until { !logs.empty? }
1830:  Selenium::WebDriver::Error::TimeoutError:
1831:  timed out after 10 seconds
1832:  # ./rb/lib/selenium/webdriver/common/wait.rb:73:in `until'
1833:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:115:in `block (2 levels) in <module:WebDriver>'
1834:  5) Selenium::WebDriver::DevTools notifies about document log messages
1835:  # Test guarded; Guarded by {:browser=>[:chrome, :edge, :firefox], :reason=>"https://bugzilla.mozilla.org/show_bug.cgi?id=1819965"};
1836:  Failure/Error: wait.until { !logs.empty? }
1837:  Selenium::WebDriver::Error::TimeoutError:
1838:  timed out after 10 seconds
1839:  # ./rb/lib/selenium/webdriver/common/wait.rb:73:in `until'
1840:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:129:in `block (2 levels) in <module:WebDriver>'
1841:  6) Selenium::WebDriver::DevTools notifies about exceptions
1842:  # Test guarded; Guarded by {:browser=>:firefox, :reason=>"https://bugzilla.mozilla.org/show_bug.cgi?id=1819965"};
1843:  Failure/Error: wait.until { exceptions.any? }
1844:  Selenium::WebDriver::Error::TimeoutError:
1845:  timed out after 10 seconds
1846:  # ./rb/lib/selenium/webdriver/common/wait.rb:73:in `until'
1847:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:143:in `block (2 levels) in <module:WebDriver>'
1848:  7) Selenium::WebDriver::DevTools notifies about DOM mutations
1849:  # Test guarded; Guarded by {:browser=>:firefox, :reason=>"Runtime.addBinding not yet supported"};
1850:  Failure/Error: driver.on_log_event(:mutation) { |mutation| mutations.push(mutation) }
1851:  Selenium::WebDriver::Error::WebDriverError:
1852:  : Runtime.addBinding: RemoteAgentError@chrome://remote/content/cdp/Error.sys.mjs:18:5
1853:  UnknownMethodError@chrome://remote/content/cdp/Error.sys.mjs:101:7
...

1855:  receiveMessage@chrome://remote/content/cdp/sessions/ContentProcessSession.sys.mjs:79:45
1856:  # ./rb/lib/selenium/webdriver/devtools.rb:49:in `send_cmd'
1857:  # ./rb/lib/selenium/devtools/v85/runtime.rb:177:in `add_binding'
1858:  # ./rb/lib/selenium/webdriver/common/driver_extensions/has_log_events.rb:120:in `log_mutation_events'
1859:  # ./rb/lib/selenium/webdriver/common/driver_extensions/has_log_events.rb:74:in `on_log_event'
1860:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:153:in `block (2 levels) in <module:WebDriver>'
1861:  8) Selenium::WebDriver::DevTools#register on any request
1862:  # Test guarded; Guarded by {:browser=>:firefox, :reason=>"Fetch.enable is not yet supported"};
1863:  Failure/Error: driver.register(username: username, password: password)
1864:  NoMethodError:
1865:  undefined method `register' for #<Selenium::WebDriver::Firefox::Driver:0x79660cd741e03ae0 browser=:firefox>
1866:  driver.register(username: username, password: password)
1867:  ^^^^^^^^^
1868:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:65:in `block (3 levels) in <module:WebDriver>'
1869:  9) Selenium::WebDriver::DevTools#register based on URL
1870:  # Test guarded; Guarded by {:browser=>:firefox, :reason=>"Fetch.enable is not yet supported"};
1871:  Failure/Error: driver.register(username: username, password: password, uri: /localhost/)
1872:  NoMethodError:
1873:  undefined method `register' for #<Selenium::WebDriver::Firefox::Driver:0x..fe0fb19b7c88de152 browser=:firefox>
1874:  driver.register(username: username, password: password, uri: /localhost/)
1875:  ^^^^^^^^^
1876:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:73:in `block (3 levels) in <module:WebDriver>'
1877:  10) Selenium::WebDriver::DevTools#intercept continues requests
1878:  # Test guarded; Guarded by {:browser=>:firefox, :reason=>"Fetch.enable is not yet supported"};
1879:  Failure/Error:
1880:  driver.intercept do |request, &continue|
1881:  requests << request
1882:  continue.call(request)
1883:  end
1884:  Selenium::WebDriver::Error::WebDriverError:
1885:  : Fetch.enable: RemoteAgentError@chrome://remote/content/cdp/Error.sys.mjs:18:5
1886:  UnknownMethodError@chrome://remote/content/cdp/Error.sys.mjs:101:7
...

1888:  receiveMessage@chrome://remote/content/cdp/sessions/ContentProcessSession.sys.mjs:79:45
1889:  # ./rb/lib/selenium/webdriver/devtools.rb:49:in `send_cmd'
1890:  # ./rb/lib/selenium/devtools/v85/fetch.rb:44:in `enable'
1891:  # ./rb/lib/selenium/webdriver/devtools/network_interceptor.rb:52:in `intercept'
1892:  # ./rb/lib/selenium/webdriver/common/driver_extensions/has_network_interception.rb:71:in `intercept'
1893:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:170:in `block (3 levels) in <module:WebDriver>'
1894:  11) Selenium::WebDriver::DevTools#intercept changes requests
1895:  # Test guarded; Guarded by {:browser=>:firefox, :reason=>"Fetch.enable is not yet supported"};
1896:  Failure/Error:
1897:  driver.intercept do |request, &continue|
1898:  uri = URI(request.url)
1899:  if uri.path.end_with?('one.js')
1900:  uri.path = '/devtools_request_interception_test/two.js'
1901:  request.url = uri.to_s
1902:  end
1903:  request.post_data = {foo: 'bar'}.to_json
1904:  continue.call(request)
1905:  Selenium::WebDriver::Error::WebDriverError:
1906:  : Fetch.enable: RemoteAgentError@chrome://remote/content/cdp/Error.sys.mjs:18:5
1907:  UnknownMethodError@chrome://remote/content/cdp/Error.sys.mjs:101:7
...

1909:  receiveMessage@chrome://remote/content/cdp/sessions/ContentProcessSession.sys.mjs:79:45
1910:  # ./rb/lib/selenium/webdriver/devtools.rb:49:in `send_cmd'
1911:  # ./rb/lib/selenium/devtools/v85/fetch.rb:44:in `enable'
1912:  # ./rb/lib/selenium/webdriver/devtools/network_interceptor.rb:52:in `intercept'
1913:  # ./rb/lib/selenium/webdriver/common/driver_extensions/has_network_interception.rb:71:in `intercept'
1914:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:180:in `block (3 levels) in <module:WebDriver>'
1915:  12) Selenium::WebDriver::DevTools#intercept continues responses
1916:  # Test guarded; Guarded by {:browser=>:firefox, :reason=>"Fetch.enable is not yet supported"};
1917:  Failure/Error:
1918:  driver.intercept do |request, &continue|
1919:  continue.call(request) do |response|
1920:  responses << response
1921:  end
1922:  end
1923:  Selenium::WebDriver::Error::WebDriverError:
1924:  : Fetch.enable: RemoteAgentError@chrome://remote/content/cdp/Error.sys.mjs:18:5
1925:  UnknownMethodError@chrome://remote/content/cdp/Error.sys.mjs:101:7
...

1927:  receiveMessage@chrome://remote/content/cdp/sessions/ContentProcessSession.sys.mjs:79:45
1928:  # ./rb/lib/selenium/webdriver/devtools.rb:49:in `send_cmd'
1929:  # ./rb/lib/selenium/devtools/v85/fetch.rb:44:in `enable'
1930:  # ./rb/lib/selenium/webdriver/devtools/network_interceptor.rb:52:in `intercept'
1931:  # ./rb/lib/selenium/webdriver/common/driver_extensions/has_network_interception.rb:71:in `intercept'
1932:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:196:in `block (3 levels) in <module:WebDriver>'
1933:  13) Selenium::WebDriver::DevTools#intercept changes responses
1934:  # Test guarded; Guarded by {:browser=>:firefox, :reason=>"Fetch.enable is not yet supported"};
1935:  Failure/Error:
1936:  driver.intercept do |request, &continue|
1937:  continue.call(request) do |response|
1938:  response.body << '<h4 id="appended">Appended!</h4>' if request.url.include?('html5Page.html')
1939:  end
1940:  end
1941:  Selenium::WebDriver::Error::WebDriverError:
1942:  : Fetch.enable: RemoteAgentError@chrome://remote/content/cdp/Error.sys.mjs:18:5
1943:  UnknownMethodError@chrome://remote/content/cdp/Error.sys.mjs:101:7
...

1945:  receiveMessage@chrome://remote/content/cdp/sessions/ContentProcessSession.sys.mjs:79:45
1946:  # ./rb/lib/selenium/webdriver/devtools.rb:49:in `send_cmd'
1947:  # ./rb/lib/selenium/devtools/v85/fetch.rb:44:in `enable'
1948:  # ./rb/lib/selenium/webdriver/devtools/network_interceptor.rb:52:in `intercept'
1949:  # ./rb/lib/selenium/webdriver/common/driver_extensions/has_network_interception.rb:71:in `intercept'
1950:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:207:in `block (3 levels) in <module:WebDriver>'
1951:  14) Selenium::WebDriver::DevTools#pin_script allows to pin script
1952:  # Test guarded; Guarded by {:browser=>:firefox, :reason=>"No reason given"};
1953:  Failure/Error: script = driver.pin_script('return document.title;')
1954:  NoMethodError:
1955:  undefined method `pin_script' for #<Selenium::WebDriver::Firefox::Driver:0x52fcb934cf13555a browser=:firefox>
1956:  script = driver.pin_script('return document.title;')
1957:  ^^^^^^^^^^^
1958:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:223:in `block (3 levels) in <module:WebDriver>'
1959:  15) Selenium::WebDriver::DevTools#pin_script ensures pinned script is available on new pages
1960:  # Test guarded; Guarded by {:browser=>:firefox, :reason=>"No reason given"};
1961:  Failure/Error: script = driver.pin_script('return document.title;')
1962:  NoMethodError:
1963:  undefined method `pin_script' for #<Selenium::WebDriver::Firefox::Driver:0x..fad74e5b8898a1ff8 browser=:firefox>
1964:  script = driver.pin_script('return document.title;')
1965:  ^^^^^^^^^^^
1966:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:229:in `block (3 levels) in <module:WebDriver>'
1967:  16) Selenium::WebDriver::DevTools#pin_script allows to unpin script
1968:  # Test guarded; Guarded by {:browser=>:firefox, :reason=>"No reason given"};
1969:  Failure/Error: script = driver.pin_script('return document.title;')
1970:  NoMethodError:
1971:  undefined method `pin_script' for #<Selenium::WebDriver::Firefox::Driver:0x..fb98d103c4be12044 browser=:firefox>
1972:  script = driver.pin_script('return document.title;')
1973:  ^^^^^^^^^^^
1974:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:235:in `block (3 levels) in <module:WebDriver>'
1975:  17) Selenium::WebDriver::DevTools#pin_script ensures unpinned scripts are not available on new pages
1976:  # Test guarded; Guarded by {:browser=>:firefox, :reason=>"No reason given"};
1977:  Failure/Error: script = driver.pin_script('return document.title;')
1978:  NoMethodError:
1979:  undefined method `pin_script' for #<Selenium::WebDriver::Firefox::Driver:0x..f94053ca00658ea30 browser=:firefox>
1980:  script = driver.pin_script('return document.title;')
1981:  ^^^^^^^^^^^
1982:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:242:in `block (3 levels) in <module:WebDriver>'
1983:  18) Selenium::WebDriver::DevTools#pin_script handles arguments in pinned script
1984:  # Test guarded; Guarded by {:browser=>:firefox, :reason=>"No reason given"};
1985:  Failure/Error: script = driver.pin_script('return arguments;')
1986:  NoMethodError:
1987:  undefined method `pin_script' for #<Selenium::WebDriver::Firefox::Driver:0x..fe09d6f2bc0cfbbec browser=:firefox>
1988:  script = driver.pin_script('return arguments;')
1989:  ^^^^^^^^^^^
1990:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:249:in `block (3 levels) in <module:WebDriver>'
1991:  19) Selenium::WebDriver::DevTools#pin_script supports async pinned scripts
1992:  # Test guarded; Guarded by {:browser=>:firefox, :reason=>"No reason given"};
1993:  Failure/Error: script = driver.pin_script('arguments[0]()')
1994:  NoMethodError:
1995:  undefined method `pin_script' for #<Selenium::WebDriver::Firefox::Driver:0x..fb159baf83274268 browser=:firefox>
1996:  script = driver.pin_script('arguments[0]()')
1997:  ^^^^^^^^^^^
1998:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:255:in `block (3 levels) in <module:WebDriver>'
1999:  Failures:
2000:  1) Selenium::WebDriver::DevTools sends commands
2001:  Failure/Error: expect(driver.title).to eq('XHTML Test Page')
2002:  expected: "XHTML Test Page"
2003:  got: ""
2004:  (compared using ==)
2005:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:30:in `block (2 levels) in <module:WebDriver>'
2006:  Finished in 4 minutes 22.2 seconds (files took 0.19582 seconds to load)
2007:  21 examples, 1 failure, 19 pending
2008:  Failed examples:
...

2013:  browser: firefox
2014:  driver: firefox
2015:  version: 133.0
2016:  platform: macosx
2017:  ci: github
2018:  rbe: false
2019:  ruby: ruby 3.1.6p260 (2024-05-29 revision a777087be6) [arm64-darwin23]
2020:  Selenium::WebDriver::DevTools
2021:  sends commands (FAILED - 1)
2022:  maps methods to classes
2023:  supports events (PENDING: Test guarded; Guarded by {:browser=>:firefox, :reason=>"https://bugzilla.mozilla.org/show_bug.cgi?id=1819965"};)
2024:  propagates errors in events (PENDING: Test guarded; Guarded by {:browser=>:firefox, :reason=>"https://bugzilla.mozilla.org/show_bug.cgi?id=1819965"};)
2025:  2024-12-11 03:31:45 WARN Selenium [:on_log_event] [DEPRECATION] Driver#on_log_event on Firefox is deprecated. Use the script.add_console_message_handler or the script.add_javascript_error_handler methods instead. 
2026:  notifies about log messages (PENDING: Test guarded; Guarded by {:browser=>:firefox, :reason=>"https://bugzilla.mozilla.org/show_bug.cgi?id=1819965"};)
2027:  2024-12-11 03:32:00 WARN Selenium [:on_log_event] [DEPRECATION] Driver#on_log_event on Firefox is deprecated. Use the script.add_console_message_handler or the script.add_javascript_error_handler methods instead. 
2028:  notifies about document log messages (PENDING: Test guarded; Guarded by {:browser=>:firefox, :reason=>"Firefox & Chrome parse document differently"};)
2029:  2024-12-11 03:32:21 WARN Selenium [:on_log_event] [DEPRECATION] Driver#on_log_event on Firefox is deprecated. Use the script.add_console_message_handler or the script.add_javascript_error_handler methods instead. 
2030:  notifies about document log messages (PENDING: Test guarded; Guarded by {:browser=>[:chrome, :edge, :firefox], :reason=>"https://bugzilla.mozilla.org/show_bug.cgi?id=1819965"};)
2031:  2024-12-11 03:32:43 WARN Selenium [:on_log_event] [DEPRECATION] Driver#on_log_event on Firefox is deprecated. Use the script.add_console_message_handler or the script.add_javascript_error_handler methods instead. 
2032:  notifies about exceptions (PENDING: Test guarded; Guarded by {:browser=>:firefox, :reason=>"https://bugzilla.mozilla.org/show_bug.cgi?id=1819965"};)
2033:  2024-12-11 03:33:05 WARN Selenium [:on_log_event] [DEPRECATION] Driver#on_log_event on Firefox is deprecated. Use the script.add_console_message_handler or the script.add_javascript_error_handler methods instead. 
...

2049:  ensures pinned script is available on new pages (PENDING: Test guarded; Guarded by {:browser=>:firefox, :reason=>"No reason given"};)
2050:  allows to unpin script (PENDING: Test guarded; Guarded by {:browser=>:firefox, :reason=>"No reason given"};)
2051:  ensures unpinned scripts are not available on new pages (PENDING: Test guarded; Guarded by {:browser=>:firefox, :reason=>"No reason given"};)
2052:  handles arguments in pinned script (PENDING: Test guarded; Guarded by {:browser=>:firefox, :reason=>"No reason given"};)
2053:  supports async pinned scripts (PENDING: Test guarded; Guarded by {:browser=>:firefox, :reason=>"No reason given"};)
2054:  Pending: (Failures listed here are expected and do not affect your suite's status)
2055:  1) Selenium::WebDriver::DevTools supports events
2056:  # Test guarded; Guarded by {:browser=>:firefox, :reason=>"https://bugzilla.mozilla.org/show_bug.cgi?id=1819965"};
2057:  Got 1 failure:
2058:  1.1) Failure/Error:
2059:  expect { |block|
2060:  driver.devtools.page.enable
2061:  driver.devtools.page.on(:load_event_fired, &block)
2062:  driver.navigate.to url_for('xhtmlTest.html')
2063:  sleep 0.5
2064:  }.to yield_control
2065:  expected given block to yield control but did not yield
2066:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:41:in `block (2 levels) in <module:WebDriver>'
2067:  2) Selenium::WebDriver::DevTools propagates errors in events
2068:  # Test guarded; Guarded by {:browser=>:firefox, :reason=>"https://bugzilla.mozilla.org/show_bug.cgi?id=1819965"};
2069:  Got 1 failure:
2070:  2.1) Failure/Error:
2071:  expect {
2072:  driver.devtools.page.enable
2073:  driver.devtools.page.on(:load_event_fired) { raise 'This is fine!' }
2074:  driver.navigate.to url_for('xhtmlTest.html')
2075:  sleep 0.5
2076:  }.to raise_error(RuntimeError, 'This is fine!')
2077:  expected RuntimeError with "This is fine!" but nothing was raised
2078:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:51:in `block (2 levels) in <module:WebDriver>'
2079:  3) Selenium::WebDriver::DevTools notifies about log messages
2080:  # Test guarded; Guarded by {:browser=>:firefox, :reason=>"https://bugzilla.mozilla.org/show_bug.cgi?id=1819965"};
2081:  Got 1 failure:
2082:  3.1) Failure/Error:
...

2092:  -[(an object having attributes {:args => ["I like cheese"], :type => :log}),
2093:  - (an object having attributes {:args => [true], :type => :log}),
2094:  - (an object having attributes {:args => [nil], :type => :log}),
2095:  - (an object having attributes {:args => [{"type" => "undefined"}], :type => :log})]
2096:  +[]
2097:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:100:in `block (2 levels) in <module:WebDriver>'
2098:  4) Selenium::WebDriver::DevTools notifies about document log messages
2099:  # Test guarded; Guarded by {:browser=>:firefox, :reason=>"Firefox & Chrome parse document differently"};
2100:  Failure/Error: wait.until { !logs.empty? }
2101:  Selenium::WebDriver::Error::TimeoutError:
2102:  timed out after 10 seconds
2103:  # ./rb/lib/selenium/webdriver/common/wait.rb:73:in `until'
2104:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:115:in `block (2 levels) in <module:WebDriver>'
2105:  5) Selenium::WebDriver::DevTools notifies about document log messages
2106:  # Test guarded; Guarded by {:browser=>[:chrome, :edge, :firefox], :reason=>"https://bugzilla.mozilla.org/show_bug.cgi?id=1819965"};
2107:  Failure/Error: wait.until { !logs.empty? }
2108:  Selenium::WebDriver::Error::TimeoutError:
2109:  timed out after 10 seconds
2110:  # ./rb/lib/selenium/webdriver/common/wait.rb:73:in `until'
2111:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:129:in `block (2 levels) in <module:WebDriver>'
2112:  6) Selenium::WebDriver::DevTools notifies about exceptions
2113:  # Test guarded; Guarded by {:browser=>:firefox, :reason=>"https://bugzilla.mozilla.org/show_bug.cgi?id=1819965"};
2114:  Failure/Error: wait.until { exceptions.any? }
2115:  Selenium::WebDriver::Error::TimeoutError:
2116:  timed out after 10 seconds
2117:  # ./rb/lib/selenium/webdriver/common/wait.rb:73:in `until'
2118:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:143:in `block (2 levels) in <module:WebDriver>'
2119:  7) Selenium::WebDriver::DevTools notifies about DOM mutations
2120:  # Test guarded; Guarded by {:browser=>:firefox, :reason=>"Runtime.addBinding not yet supported"};
2121:  Failure/Error: driver.on_log_event(:mutation) { |mutation| mutations.push(mutation) }
2122:  Selenium::WebDriver::Error::WebDriverError:
2123:  : Runtime.addBinding: RemoteAgentError@chrome://remote/content/cdp/Error.sys.mjs:18:5
2124:  UnknownMethodError@chrome://remote/content/cdp/Error.sys.mjs:101:7
...

2126:  receiveMessage@chrome://remote/content/cdp/sessions/ContentProcessSession.sys.mjs:79:45
2127:  # ./rb/lib/selenium/webdriver/devtools.rb:49:in `send_cmd'
2128:  # ./rb/lib/selenium/devtools/v85/runtime.rb:177:in `add_binding'
2129:  # ./rb/lib/selenium/webdriver/common/driver_extensions/has_log_events.rb:120:in `log_mutation_events'
2130:  # ./rb/lib/selenium/webdriver/common/driver_extensions/has_log_events.rb:74:in `on_log_event'
2131:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:153:in `block (2 levels) in <module:WebDriver>'
2132:  8) Selenium::WebDriver::DevTools#register on any request
2133:  # Test guarded; Guarded by {:browser=>:firefox, :reason=>"Fetch.enable is not yet supported"};
2134:  Failure/Error: driver.register(username: username, password: password)
2135:  NoMethodError:
2136:  undefined method `register' for #<Selenium::WebDriver::Firefox::Driver:0x..fc96cc9604bd675e2 browser=:firefox>
2137:  driver.register(username: username, password: password)
2138:  ^^^^^^^^^
2139:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:65:in `block (3 levels) in <module:WebDriver>'
2140:  9) Selenium::WebDriver::DevTools#register based on URL
2141:  # Test guarded; Guarded by {:browser=>:firefox, :reason=>"Fetch.enable is not yet supported"};
2142:  Failure/Error: driver.register(username: username, password: password, uri: /localhost/)
2143:  NoMethodError:
2144:  undefined method `register' for #<Selenium::WebDriver::Firefox::Driver:0x62f7c241d0392172 browser=:firefox>
2145:  driver.register(username: username, password: password, uri: /localhost/)
2146:  ^^^^^^^^^
2147:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:73:in `block (3 levels) in <module:WebDriver>'
2148:  10) Selenium::WebDriver::DevTools#intercept continues requests
2149:  # Test guarded; Guarded by {:browser=>:firefox, :reason=>"Fetch.enable is not yet supported"};
2150:  Failure/Error:
2151:  driver.intercept do |request, &continue|
2152:  requests << request
2153:  continue.call(request)
2154:  end
2155:  Selenium::WebDriver::Error::WebDriverError:
2156:  : Fetch.enable: RemoteAgentError@chrome://remote/content/cdp/Error.sys.mjs:18:5
2157:  UnknownMethodError@chrome://remote/content/cdp/Error.sys.mjs:101:7
...

2159:  receiveMessage@chrome://remote/content/cdp/sessions/ContentProcessSession.sys.mjs:79:45
2160:  # ./rb/lib/selenium/webdriver/devtools.rb:49:in `send_cmd'
2161:  # ./rb/lib/selenium/devtools/v85/fetch.rb:44:in `enable'
2162:  # ./rb/lib/selenium/webdriver/devtools/network_interceptor.rb:52:in `intercept'
2163:  # ./rb/lib/selenium/webdriver/common/driver_extensions/has_network_interception.rb:71:in `intercept'
2164:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:170:in `block (3 levels) in <module:WebDriver>'
2165:  11) Selenium::WebDriver::DevTools#intercept changes requests
2166:  # Test guarded; Guarded by {:browser=>:firefox, :reason=>"Fetch.enable is not yet supported"};
2167:  Failure/Error:
2168:  driver.intercept do |request, &continue|
2169:  uri = URI(request.url)
2170:  if uri.path.end_with?('one.js')
2171:  uri.path = '/devtools_request_interception_test/two.js'
2172:  request.url = uri.to_s
2173:  end
2174:  request.post_data = {foo: 'bar'}.to_json
2175:  continue.call(request)
2176:  Selenium::WebDriver::Error::WebDriverError:
2177:  : Fetch.enable: RemoteAgentError@chrome://remote/content/cdp/Error.sys.mjs:18:5
2178:  UnknownMethodError@chrome://remote/content/cdp/Error.sys.mjs:101:7
...

2180:  receiveMessage@chrome://remote/content/cdp/sessions/ContentProcessSession.sys.mjs:79:45
2181:  # ./rb/lib/selenium/webdriver/devtools.rb:49:in `send_cmd'
2182:  # ./rb/lib/selenium/devtools/v85/fetch.rb:44:in `enable'
2183:  # ./rb/lib/selenium/webdriver/devtools/network_interceptor.rb:52:in `intercept'
2184:  # ./rb/lib/selenium/webdriver/common/driver_extensions/has_network_interception.rb:71:in `intercept'
2185:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:180:in `block (3 levels) in <module:WebDriver>'
2186:  12) Selenium::WebDriver::DevTools#intercept continues responses
2187:  # Test guarded; Guarded by {:browser=>:firefox, :reason=>"Fetch.enable is not yet supported"};
2188:  Failure/Error:
2189:  driver.intercept do |request, &continue|
2190:  continue.call(request) do |response|
2191:  responses << response
2192:  end
2193:  end
2194:  Selenium::WebDriver::Error::WebDriverError:
2195:  : Fetch.enable: RemoteAgentError@chrome://remote/content/cdp/Error.sys.mjs:18:5
2196:  UnknownMethodError@chrome://remote/content/cdp/Error.sys.mjs:101:7
...

2198:  receiveMessage@chrome://remote/content/cdp/sessions/ContentProcessSession.sys.mjs:79:45
2199:  # ./rb/lib/selenium/webdriver/devtools.rb:49:in `send_cmd'
2200:  # ./rb/lib/selenium/devtools/v85/fetch.rb:44:in `enable'
2201:  # ./rb/lib/selenium/webdriver/devtools/network_interceptor.rb:52:in `intercept'
2202:  # ./rb/lib/selenium/webdriver/common/driver_extensions/has_network_interception.rb:71:in `intercept'
2203:  # ./rb/spec/integration/selenium/webdriver/devtools_spec.rb:196:in `block (3 levels) in <module:WebDriver>'
2204:  13) Selenium::WebDriver::DevTools#intercept chang...

    @VietND96 VietND96 merged commit 4ea71ca into trunk Dec 12, 2024
    32 of 33 checks passed
    @VietND96 VietND96 deleted the decrement-connection-counter branch December 12, 2024 03:35
    Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
    Reviewers

    @VietND96 VietND96 VietND96 approved these changes

    Assignees
    No one assigned
    Labels
    Review effort [1-5]: 3
    Projects
    None yet
    Milestone
    No milestone
    Development

    Successfully merging this pull request may close these issues.
    2 participants
    @joerg1985 @VietND96