search

seleniumhq-community / docker-seleniarm

Multi-Arch (arm64/armhf/amd64) Docker images for the Selenium Grid Server
https://hub.docker.com/u/seleniarm
Other
249 stars 26 forks source link

[🐛 Bug]: Test suite works on amd64 but not arm64 #27

Closed davidpcaldwell closed 1 year ago

davidpcaldwell commented 1 year ago

What happened?

My Docker-based test suite, developed on amd64 (my old laptop), and running (successfully) on GitHub's CI (presumably under amd64), does not work under arm64; it instead fails because the Selenium remote driver cannot connect to the standalone Selenium browser image on port 4444 in order to trigger that image to perform the test run.

I can't tell how to diagnose this; given that it's an entirely new Apple Silicon machine, it's possible something else environmental is wrong, but so far, the Apple Silicon chip is the only difference of which I know.

Command used to start Selenium Grid with Docker

https://github.com/davidpcaldwell/slime/blob/main/contributor/docker-compose.yaml, using the test11 service.

Here's the GitHub workflow: https://github.com/davidpcaldwell/slime/blob/issue/%23289/.github/workflows/test-jdk11.yaml

Relevant log output

When running on macOS, I get:

JavaException: org.openqa.selenium.SessionNotCreatedException: Could not start a new session. Possible causes are invalid address of the remote server or browser start-up failure.
Build info: version: '4.1.3', revision: '7b1ebf28ef'
System info: host: '5712dd8d19ea', ip: '172.18.0.4', os.name: 'Linux', os.arch: 'aarch64', os.version: '5.15.49-linuxkit', java.version: '11.0.15'
Driver info: org.openqa.selenium.remote.RemoteWebDriver
Command: [null, newSession {capabilities=[Capabilities {browserName: chrome, goog:chromeOptions: {args: [], extensions: []}}], desiredCapabilities=Capabilities {browserName: chrome, goog:chromeOptions: {args: [], extensions: []}}}]
Capabilities {}

When running on the GitHub CI, the above does not happen, and the tests work. See, e.g., this run.

Operating System

macOS

Docker Selenium version (tag)

latest (not sure how to get the version you're asking for)

jamesmortensen commented 1 year ago

@davidpcaldwell I did a fresh clone of your repository and built and ran the docker-compose command on a Mac M1. I don't see the errors you're seeing. I've attached the full log if it's helpful.

I believe you're using the latest seleniarm/standalone-chromium and standalone-firefox images. If no tag is specified, it should default to latest which would be 4.6.0-20221104.

Is there any other information you can think of that would be helpful in debugging? 

$ uname -a
Darwin local 22.1.0 Darwin Kernel Version 22.1.0: Sun Oct  9 20:14:30 PDT 2022; root:xnu-8792.41.9~2/RELEASE_ARM64_T8103 arm64
$ docker -v
Docker version 20.10.8, build 3967b7d
$ docker compose -f contributor/docker-compose.yaml run test11
[+] Running 2/2
 ⠿ Container contributor_chrome_1   Recreated                                                                                                   5.7s
 ⠿ Container contributor_firefox_1  Recreated                                                                                                   5.7s
[+] Running 2/2
 ⠿ Container contributor_firefox_1  Started                                                                                                     0.6s
 ⠿ Container contributor_chrome_1   Started                                                                                                     0.6s
Downloading https://corretto.aws/downloads/resources/11.0.15.9.1/amazon-corretto-11.0.15.9.1-linux-aarch64.tar.gz ...
Hit:1 http://deb.debian.org/debian bullseye InRelease
Hit:2 http://security.debian.org/debian-security bullseye-security InRelease
Hit:3 http://deb.debian.org/debian bullseye-updates InRelease
Reading package lists... Done
Reading package lists... Done
Building dependency tree... Done
Reading state information... Done
Calculating upgrade... Done
The following packages will be upgraded:
  base-files bash dpkg gpgv libc-bin libc6 libgnutls30 libgssapi-krb5-2 libk5crypto3 libkrb5-3 libkrb5support0 libpcre2-8-0 libssl1.1 libsystemd0
  libtirpc-common libtirpc3 libudev1 tzdata zlib1g
19 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
Need to get 12.3 MB of archives.
After this operation, 12.3 kB disk space will be freed.
Get:1 http://deb.debian.org/debian bullseye/main arm64 base-files arm64 11.1+deb11u5 [70.1 kB]
Get:2 http://security.debian.org/debian-security bullseye-security/main arm64 libk5crypto3 arm64 1.18.3-6+deb11u3 [114 kB]
Get:3 http://deb.debian.org/debian bullseye/main arm64 bash arm64 5.1-2+deb11u1 [1376 kB]
Get:4 http://security.debian.org/debian-security bullseye-security/main arm64 libkrb5support0 arm64 1.18.3-6+deb11u3 [65.0 kB]
Get:5 http://security.debian.org/debian-security bullseye-security/main arm64 libkrb5-3 arm64 1.18.3-6+deb11u3 [346 kB]
Get:6 http://security.debian.org/debian-security bullseye-security/main arm64 libgssapi-krb5-2 arm64 1.18.3-6+deb11u3 [155 kB]
Get:7 http://deb.debian.org/debian bullseye/main arm64 dpkg arm64 1.20.12 [2521 kB]
Get:8 http://deb.debian.org/debian bullseye-updates/main arm64 libc6 arm64 2.31-13+deb11u5 [2460 kB]
Get:9 http://deb.debian.org/debian bullseye-updates/main arm64 libc-bin arm64 2.31-13+deb11u5 [743 kB]
Get:10 http://deb.debian.org/debian bullseye/main arm64 libsystemd0 arm64 247.3-7+deb11u1 [354 kB]
Get:11 http://deb.debian.org/debian bullseye/main arm64 zlib1g arm64 1:1.2.11.dfsg-2+deb11u2 [88.2 kB]
Get:12 http://deb.debian.org/debian bullseye/main arm64 gpgv arm64 2.2.27-2+deb11u2 [610 kB]
Get:13 http://deb.debian.org/debian bullseye/main arm64 libgnutls30 arm64 3.7.1-5+deb11u2 [1262 kB]
Get:14 http://deb.debian.org/debian bullseye/main arm64 libssl1.1 arm64 1.1.1n-0+deb11u3 [1389 kB]
Get:15 http://deb.debian.org/debian bullseye/main arm64 libpcre2-8-0 arm64 10.36-2+deb11u1 [216 kB]
Get:16 http://deb.debian.org/debian bullseye/main arm64 libtirpc-common all 1.3.1-1+deb11u1 [13.5 kB]
Get:17 http://deb.debian.org/debian bullseye/main arm64 libtirpc3 arm64 1.3.1-1+deb11u1 [80.2 kB]
Get:18 http://deb.debian.org/debian bullseye/main arm64 libudev1 arm64 247.3-7+deb11u1 [163 kB]
Get:19 http://deb.debian.org/debian bullseye-updates/main arm64 tzdata all 2021a-1+deb11u8 [284 kB]
Fetched 12.3 MB in 1s (8240 kB/s)
debconf: delaying package configuration, since apt-utils is not installed
(Reading database ... 10495 files and directories currently installed.)
Preparing to unpack .../base-files_11.1+deb11u5_arm64.deb ...
Unpacking base-files (11.1+deb11u5) over (11.1+deb11u3) ...
Setting up base-files (11.1+deb11u5) ...
Installing new version of config file /etc/debian_version ...
(Reading database ... 10495 files and directories currently installed.)
Preparing to unpack .../bash_5.1-2+deb11u1_arm64.deb ...
Unpacking bash (5.1-2+deb11u1) over (5.1-2+b3) ...
Setting up bash (5.1-2+deb11u1) ...
update-alternatives: using /usr/share/man/man7/bash-builtins.7.gz to provide /usr/share/man/man7/builtins.7.gz (builtins.7.gz) in auto mode
(Reading database ... 10494 files and directories currently installed.)
Preparing to unpack .../dpkg_1.20.12_arm64.deb ...
Unpacking dpkg (1.20.12) over (1.20.10) ...
Setting up dpkg (1.20.12) ...
(Reading database ... 10494 files and directories currently installed.)
Preparing to unpack .../libc6_2.31-13+deb11u5_arm64.deb ...
debconf: unable to initialize frontend: Dialog
debconf: (No usable dialog-like program is installed, so the dialog based frontend cannot be used. at /usr/share/perl5/Debconf/FrontEnd/Dialog.pm line 78.)
debconf: falling back to frontend: Readline
debconf: unable to initialize frontend: Dialog
debconf: (No usable dialog-like program is installed, so the dialog based frontend cannot be used. at /usr/share/perl5/Debconf/FrontEnd/Dialog.pm line 78.)
debconf: falling back to frontend: Readline
Unpacking libc6:arm64 (2.31-13+deb11u5) over (2.31-13+deb11u3) ...
Setting up libc6:arm64 (2.31-13+deb11u5) ...
debconf: unable to initialize frontend: Dialog
debconf: (No usable dialog-like program is installed, so the dialog based frontend cannot be used. at /usr/share/perl5/Debconf/FrontEnd/Dialog.pm line 78.)
debconf: falling back to frontend: Readline
(Reading database ... 10494 files and directories currently installed.)
Preparing to unpack .../libc-bin_2.31-13+deb11u5_arm64.deb ...
Unpacking libc-bin (2.31-13+deb11u5) over (2.31-13+deb11u3) ...
Setting up libc-bin (2.31-13+deb11u5) ...
(Reading database ... 10494 files and directories currently installed.)
Preparing to unpack .../libsystemd0_247.3-7+deb11u1_arm64.deb ...
Unpacking libsystemd0:arm64 (247.3-7+deb11u1) over (247.3-7) ...
Setting up libsystemd0:arm64 (247.3-7+deb11u1) ...
(Reading database ... 10494 files and directories currently installed.)
Preparing to unpack .../zlib1g_1%3a1.2.11.dfsg-2+deb11u2_arm64.deb ...
Unpacking zlib1g:arm64 (1:1.2.11.dfsg-2+deb11u2) over (1:1.2.11.dfsg-2+deb11u1) ...
Setting up zlib1g:arm64 (1:1.2.11.dfsg-2+deb11u2) ...
(Reading database ... 10494 files and directories currently installed.)
Preparing to unpack .../gpgv_2.2.27-2+deb11u2_arm64.deb ...
Unpacking gpgv (2.2.27-2+deb11u2) over (2.2.27-2+deb11u1) ...
Setting up gpgv (2.2.27-2+deb11u2) ...
(Reading database ... 10494 files and directories currently installed.)
Preparing to unpack .../libgnutls30_3.7.1-5+deb11u2_arm64.deb ...
Unpacking libgnutls30:arm64 (3.7.1-5+deb11u2) over (3.7.1-5) ...
Setting up libgnutls30:arm64 (3.7.1-5+deb11u2) ...
(Reading database ... 10494 files and directories currently installed.)
Preparing to unpack .../libk5crypto3_1.18.3-6+deb11u3_arm64.deb ...
Unpacking libk5crypto3:arm64 (1.18.3-6+deb11u3) over (1.18.3-6+deb11u1) ...
Setting up libk5crypto3:arm64 (1.18.3-6+deb11u3) ...
(Reading database ... 10494 files and directories currently installed.)
Preparing to unpack .../libkrb5support0_1.18.3-6+deb11u3_arm64.deb ...
Unpacking libkrb5support0:arm64 (1.18.3-6+deb11u3) over (1.18.3-6+deb11u1) ...
Setting up libkrb5support0:arm64 (1.18.3-6+deb11u3) ...
(Reading database ... 10494 files and directories currently installed.)
Preparing to unpack .../libkrb5-3_1.18.3-6+deb11u3_arm64.deb ...
Unpacking libkrb5-3:arm64 (1.18.3-6+deb11u3) over (1.18.3-6+deb11u1) ...
Setting up libkrb5-3:arm64 (1.18.3-6+deb11u3) ...
(Reading database ... 10494 files and directories currently installed.)
Preparing to unpack .../libgssapi-krb5-2_1.18.3-6+deb11u3_arm64.deb ...
Unpacking libgssapi-krb5-2:arm64 (1.18.3-6+deb11u3) over (1.18.3-6+deb11u1) ...
Setting up libgssapi-krb5-2:arm64 (1.18.3-6+deb11u3) ...
(Reading database ... 10494 files and directories currently installed.)
Preparing to unpack .../libssl1.1_1.1.1n-0+deb11u3_arm64.deb ...
Unpacking libssl1.1:arm64 (1.1.1n-0+deb11u3) over (1.1.1n-0+deb11u2) ...
Setting up libssl1.1:arm64 (1.1.1n-0+deb11u3) ...
debconf: unable to initialize frontend: Dialog
debconf: (No usable dialog-like program is installed, so the dialog based frontend cannot be used. at /usr/share/perl5/Debconf/FrontEnd/Dialog.pm line 78.)
debconf: falling back to frontend: Readline
(Reading database ... 10494 files and directories currently installed.)
Preparing to unpack .../libpcre2-8-0_10.36-2+deb11u1_arm64.deb ...
Unpacking libpcre2-8-0:arm64 (10.36-2+deb11u1) over (10.36-2) ...
Setting up libpcre2-8-0:arm64 (10.36-2+deb11u1) ...
(Reading database ... 10494 files and directories currently installed.)
Preparing to unpack .../libtirpc-common_1.3.1-1+deb11u1_all.deb ...
Unpacking libtirpc-common (1.3.1-1+deb11u1) over (1.3.1-1) ...
Setting up libtirpc-common (1.3.1-1+deb11u1) ...
(Reading database ... 10494 files and directories currently installed.)
Preparing to unpack .../libtirpc3_1.3.1-1+deb11u1_arm64.deb ...
Unpacking libtirpc3:arm64 (1.3.1-1+deb11u1) over (1.3.1-1) ...
Setting up libtirpc3:arm64 (1.3.1-1+deb11u1) ...
(Reading database ... 10494 files and directories currently installed.)
Preparing to unpack .../libudev1_247.3-7+deb11u1_arm64.deb ...
Unpacking libudev1:arm64 (247.3-7+deb11u1) over (247.3-7) ...
Setting up libudev1:arm64 (247.3-7+deb11u1) ...
(Reading database ... 10494 files and directories currently installed.)
Preparing to unpack .../tzdata_2021a-1+deb11u8_all.deb ...
Unpacking tzdata (2021a-1+deb11u8) over (2021a-1+deb11u3) ...
Setting up tzdata (2021a-1+deb11u8) ...
debconf: unable to initialize frontend: Dialog
debconf: (No usable dialog-like program is installed, so the dialog based frontend cannot be used. at /usr/share/perl5/Debconf/FrontEnd/Dialog.pm line 78.)
debconf: falling back to frontend: Readline

Current default time zone: 'Etc/UTC'
Local time is now:      Tue Nov 29 18:17:23 UTC 2022.
Universal Time is now:  Tue Nov 29 18:17:23 UTC 2022.
Run 'dpkg-reconfigure tzdata' if you wish to change it.

Processing triggers for libc-bin (2.31-13+deb11u5) ...
Reading package lists... Done
Building dependency tree... Done
Reading state information... Done
The following NEW packages will be installed:
  wget
0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded.
Need to get 946 kB of archives.
After this operation, 3543 kB of additional disk space will be used.
Get:1 http://deb.debian.org/debian bullseye/main arm64 wget arm64 1.21-1+deb11u1 [946 kB]
Fetched 946 kB in 0s (2700 kB/s)
debconf: delaying package configuration, since apt-utils is not installed
Selecting previously unselected package wget.
(Reading database ... 10494 files and directories currently installed.)
Preparing to unpack .../wget_1.21-1+deb11u1_arm64.deb ...
Unpacking wget (1.21-1+deb11u1) ...
Setting up wget (1.21-1+deb11u1) ...
--2022-11-29 18:17:25--  https://corretto.aws/downloads/resources/11.0.15.9.1/amazon-corretto-11.0.15.9.1-linux-aarch64.tar.gz
Resolving corretto.aws (corretto.aws)... 65.8.72.59, 65.8.72.53, 65.8.72.74, ...
Connecting to corretto.aws (corretto.aws)|65.8.72.59|:443... connected.
HTTP request sent, awaiting response... 200 OK
Length: 191298474 (182M) [binary/octet-stream]
Saving to: '/root/Downloads/amazon-corretto-11.0.15.9.1-linux-aarch64.tar.gz'

/root/Downloads/amazon-corretto-11.0. 100%[======================================================================>] 182.44M  9.26MB/s    in 18s     

2022-11-29 18:17:44 (9.89 MB/s) - '/root/Downloads/amazon-corretto-11.0.15.9.1-linux-aarch64.tar.gz' saved [191298474/191298474]

Installed https://corretto.aws/downloads/resources/11.0.15.9.1/amazon-corretto-11.0.15.9.1-linux-aarch64.tar.gz at /slime/local/jdk/11
Installed https://corretto.aws/downloads/resources/11.0.15.9.1/amazon-corretto-11.0.15.9.1-linux-aarch64.tar.gz at /slime/local/jdk/default
No default engine; downloading Rhino ...
Downloading Rhino from https://github.com/mozilla/rhino/releases/download/Rhino1_7_14_Release/rhino-1.7.14.jar
Rhino download: opened connection sun.net.www.protocol.https.DelegateHttpsURLConnection:https://github.com/mozilla/rhino/releases/download/Rhino1_7_14_Release/rhino-1.7.14.jar
Rhino download: getting response code ...
Rhino download status: 200
Installing Rhino ...
Downloading Rhino from https://github.com/mozilla/rhino/releases/download/Rhino1_7_14_Release/rhino-1.7.14.jar
Rhino download: opened connection sun.net.www.protocol.https.DelegateHttpsURLConnection:https://github.com/mozilla/rhino/releases/download/Rhino1_7_14_Release/rhino-1.7.14.jar
Rhino download: getting response code ...
Rhino download status: 200
Installed Rhino at /slime/local/jsh/lib/js.jar

npm notice 
added 97 packages, and audited 98 packages in 6s

24 packages are looking for funding
  run `npm fund` for details

found 0 vulnerabilities
npm notice New major version of npm available! 8.15.0 -> 9.1.2
npm notice Changelog: <https://github.com/npm/cli/releases/tag/v9.1.2>
npm notice Run `npm install -g npm@9.1.2` to update!
npm notice 

added 1 package, and audited 2 packages in 1s

found 0 vulnerabilities
Linting ...
Warning: Nashorn engine is planned to be removed from a future JDK release
Warning: Nashorn engine is planned to be removed from a future JDK release
Warning: Nashorn engine is planned to be removed from a future JDK release
Warning: Nashorn engine is planned to be removed from a future JDK release
Warning: Nashorn engine is planned to be removed from a future JDK release
Warning: Nashorn engine is planned to be removed from a future JDK release
Running TypeScript compiler ...
Running tests ...
Installing Selenium Java driver ...
Installing Rhino ...
Downloading Rhino from https://github.com/mozilla/rhino/releases/download/Rhino1_7_14_Release/rhino-1.7.14.jar
Rhino download: opened connection sun.net.www.protocol.https.DelegateHttpsURLConnection:https://github.com/mozilla/rhino/releases/download/Rhino1_7_14_Release/rhino-1.7.14.jar
Rhino download: getting response code ...
Rhino download status: 200
Installed Rhino at /slime/local/jsh/lib/js.jar
Installing specified version 7.0.109
Unzipping /root/Downloads/apache-tomcat-7.0.109.zip to: /tmp/slime5249559071317002691.tmp/
Installing Tomcat at /slime/local/jsh/lib/tomcat
Warning: Nashorn engine is planned to be removed from a future JDK release
Warning: Nashorn engine is planned to be removed from a future JDK release
Warning: Nashorn engine is planned to be removed from a future JDK release

added 1 package, and audited 2 packages in 2s

found 0 vulnerabilities
Warning: Nashorn engine is planned to be removed from a future JDK release
Warning: Nashorn engine is planned to be removed from a future JDK release
Warning: Nashorn engine is planned to be removed from a future JDK release
Building jsh with arguments [/tmp/slime14408778616044261958.tmp -notest -nodoc -rhino /slime/local/jsh/lib/js.jar]
Loading /slime/jsh/launcher/javac.js
Creating directories ...
Copying launcher scripts ...
Copying Rhino libraries ...
Building jsh application ...
Building launcher ...
Copying bootstrap scripts ...
Creating bundled modules ...
Created module file: /tmp/slime14408778616044261958.tmp/modules/loader.api.slime
Created module file: /tmp/slime14408778616044261958.tmp/modules/js.object.slime
Created module file: /tmp/slime14408778616044261958.tmp/modules/js.document.slime
Created module file: /tmp/slime14408778616044261958.tmp/modules/js.web.slime
Created module file: /tmp/slime14408778616044261958.tmp/modules/js.time.slime
Created module file: /tmp/slime14408778616044261958.tmp/modules/js.debug.slime
Compiling from /slime/jrunscript/host/rhino/java/ to /tmp/slime6712121038145611671.tmp/$jvm/classes
Note: /slime/jrunscript/host/rhino/java/inonit/script/runtime/Properties.java uses or overrides a deprecated API.
Note: Recompile with -Xlint:deprecation for details.
Created module file: /tmp/slime14408778616044261958.tmp/modules/jrunscript.host.slime
Compiling from /slime/rhino/file/java/ to /tmp/slime5084656971594979047.tmp/$jvm/classes
Note: Some input files use or override a deprecated API.
Note: Recompile with -Xlint:deprecation for details.
Note: /slime/rhino/file/java/inonit/script/runtime/io/cygwin/CygwinFilesystem.java uses unchecked or unsafe operations.
Note: Recompile with -Xlint:unchecked for details.
Created module file: /tmp/slime14408778616044261958.tmp/modules/rhino.file.slime
Created module file: /tmp/slime14408778616044261958.tmp/modules/jrunscript.io.slime
Created module file: /tmp/slime14408778616044261958.tmp/modules/jrunscript.tools.install.slime
Created module file: /tmp/slime14408778616044261958.tmp/modules/rhino.document.slime
Created module file: /tmp/slime14408778616044261958.tmp/modules/rhino.shell.slime
Created module file: /tmp/slime14408778616044261958.tmp/modules/jsh.script.slime
Created module file: /tmp/slime14408778616044261958.tmp/modules/rhino.http.client.slime
Created module file: /tmp/slime14408778616044261958.tmp/modules/rhino.http.servlet.slime
Created module file: /tmp/slime14408778616044261958.tmp/modules/rhino.ip.slime
Created module file: /tmp/slime14408778616044261958.tmp/modules/rhino.tools.slime
Compiling from /slime/rhino/ui/java/ to /tmp/slime14221213024334371639.tmp/$jvm/classes
Created module file: /tmp/slime14408778616044261958.tmp/modules/rhino.ui.slime
Created module file: /tmp/slime14408778616044261958.tmp/modules/jsh.unit.slime
Creating plugins directory ...
Created module file: /tmp/slime14408778616044261958.tmp/modules/jsh.tools.install.slime
Creating tools ...
Creating install scripts ...
Bundling source code ...
Running post-installer with arguments [] ... 
Warning: Nashorn engine is planned to be removed from a future JDK release
Warning: Nashorn engine is planned to be removed from a future JDK release
jamesmortensen commented 1 year ago

Could your firewall be getting in the way?

jamesmortensen commented 1 year ago

I also ran the tests on a Linux ARM64 Ubuntu 20.04 VM. I just realized in the output I posted from my Mac that there must have been some process that got stuck because it's missing a lot of data. Here's the last 300 to 400 lines from running on ARM Ubuntu. From what I can tell, it looks like it's a success.

The error message you were getting does indicate that perhaps it's a firewall issue, so I'd recommend starting there.

Here is that log output, if it's helpful. :

REQUEST: GET js/web/module.fifty.ts
REQUEST: GET js/web/module.browser.js
REQUEST: GET js/web/module.js
REQUEST: GET js/web/module.js
REQUEST: GET js/codec/ini.fifty.ts
REQUEST: GET js/codec/ini.js
REQUEST: GET js/codec/test/1.txt
REQUEST: GET js/time/module.fifty.ts
REQUEST: GET js/time/module.js
REQUEST: GET js/time/module.js
REQUEST: GET js/time/old.fifty.ts
REQUEST: GET js/time/module.js
REQUEST: GET js/time/module.js
REQUEST: GET js/time/module.js
REQUEST: POST tools/fifty/result
Receiving POSTed results ...
response = true
Killing browser ...
Exiting with status 0
        Forked process ran without exception is true
      PASSED:  Fifty (Firefox (Selenium))
    PASSED:  fifty
  PASSED:  Browser tests
  Running: tools
    Running: browser
      Running: api
        Running: failure
        PASSED:  failure
        Running: success
        PASSED:  success
      PASSED:  api
    PASSED:  browser
  PASSED:  tools
  Running: node
    Running: runtime
Warning: Nashorn engine is planned to be removed from a future JDK release
Warning: Nashorn engine is planned to be removed from a future JDK release
Warning: Nashorn engine is planned to be removed from a future JDK release
      Running: /slime/loader/node/loader.fifty.ts:suite
        [object Object].identity is 3
        [object Object].loader.type is "object"
        [object Object].loader.files.me.type is "object"
        [object Object].loader.files.me.content is type string
        [object Object].loader.files.foo is null
      PASSED:  /slime/loader/node/loader.fifty.ts:suite
      Forked process ran without exception is true
    PASSED:  runtime
  PASSED:  node
PASSED:  null

Passed.
davidpcaldwell commented 1 year ago

Sounds good. I don't have any firewall configuration I know of, but I'm not a Docker guru, so it sounds like I need to dig deeper and learn more. It's reassuring to know that you were able to get this to work, so it's going to end up being specific to my machine. I'll close this and try to run with it.

davidpcaldwell commented 1 year ago

One interesting thing is that the IP addresses it was trying to use for the Docker nodes are not in the "Docker subnet" configured by Preferences | Resources | Network in Docker Desktop. I don't know enough about the whole implementation to know whether that's a problem or how to fix it, but I'll probably start there.

davidpcaldwell commented 1 year ago

One other interesting thing is that my Intel machine succeeds and my Apple Silicon machine fails, despite having the same Docker network configuration (at least as far as I can tell using the Docker Desktop UI).

I'm still looking.

davidpcaldwell commented 1 year ago

I can ping the chrome container from the test container. When I look at it with NoVNC, there's no browser open.

davidpcaldwell commented 1 year ago

OK, I figured out how to pull logs from the container, which might be useful (and point to the problem?), so I'm going to reopen this. Here's what happened in the Chrome container. I do see at least one thing that looks like an error (the bind() thing). Does this look right, or show something about the problem?

2022-11-17 09:59:36 2022-11-17 14:59:36,249 INFO Included extra file "/etc/supervisor/conf.d/selenium.conf" during parsing
2022-11-17 09:59:36 2022-11-17 14:59:36,261 INFO RPC interface 'supervisor' initialized
2022-11-17 09:59:36 2022-11-17 14:59:36,261 CRIT Server 'unix_http_server' running without any HTTP authentication checking
2022-11-17 09:59:36 2022-11-17 14:59:36,261 INFO supervisord started with pid 8
2022-11-17 09:59:37 2022-11-17 14:59:37,263 INFO spawned: 'xvfb' with pid 9
2022-11-17 09:59:37 2022-11-17 14:59:37,264 INFO spawned: 'vnc' with pid 10
2022-11-17 09:59:37 2022-11-17 14:59:37,266 INFO spawned: 'novnc' with pid 11
2022-11-17 09:59:37 2022-11-17 14:59:37,267 INFO spawned: 'selenium-standalone' with pid 12
2022-11-17 09:59:37 Setting up SE_NODE_GRID_URL...
2022-11-17 09:59:37 2022-11-17 14:59:37,280 INFO success: xvfb entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2022-11-17 09:59:37 2022-11-17 14:59:37,280 INFO success: vnc entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2022-11-17 09:59:37 2022-11-17 14:59:37,280 INFO success: novnc entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2022-11-17 09:59:37 2022-11-17 14:59:37,280 INFO success: selenium-standalone entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2022-11-17 09:59:37 Selenium Grid Standalone configuration: 
2022-11-17 09:59:37 [network]
2022-11-17 09:59:37 relax-checks = true
2022-11-17 09:59:37 
2022-11-17 09:59:37 [node]
2022-11-17 09:59:37 session-timeout = "300"
2022-11-17 09:59:37 override-max-sessions = false
2022-11-17 09:59:37 detect-drivers = false
2022-11-17 09:59:37 drain-after-session-count = 0
2022-11-17 09:59:37 max-sessions = 1
2022-11-17 09:59:37 
2022-11-17 09:59:37 [[node.driver-configuration]]
2022-11-17 09:59:37 display-name = "chrome"
2022-11-17 09:59:37 stereotype = '{"browserName": "chrome", "browserVersion": "107.0", "platformName": "Linux"}'
2022-11-17 09:59:37 max-sessions = 1
2022-11-17 09:59:37 
2022-11-17 09:59:37 Starting Selenium Grid Standalone...
2022-11-17 09:59:37 Tracing is disabled
2022-11-17 09:59:38 14:59:38.172 INFO [LoggingOptions.configureLogEncoding] - Using the system default encoding
2022-11-17 09:59:38 14:59:38.178 INFO [OpenTelemetryTracer.createTracer] - Using OpenTelemetry for tracing
2022-11-17 09:59:39 14:59:39.164 INFO [NodeOptions.getSessionFactories] - Detected 5 available processors
2022-11-17 09:59:39 14:59:39.217 INFO [NodeOptions.report] - Adding chrome for {"browserVersion": "107.0","se:noVncPort": 7900,"browserName": "chrome","platformName": "LINUX","se:vncEnabled": true} 1 times
2022-11-17 09:59:39 14:59:39.257 INFO [Node.<init>] - Binding additional locator mechanisms: relative, name, id
2022-11-17 09:59:39 14:59:39.279 INFO [GridModel.setAvailability] - Switching Node 1cb56b23-981e-46c6-9195-1a50e29a8382 (uri: http://172.18.0.3:4444) from DOWN to UP
2022-11-17 09:59:39 14:59:39.279 INFO [LocalDistributor.add] - Added node 1cb56b23-981e-46c6-9195-1a50e29a8382 at http://172.18.0.3:4444. Health check every 120s
2022-11-17 09:59:39 14:59:39.460 INFO [Standalone.execute] - Started Selenium Standalone 4.6.0 (revision 79f1c02ae20): http://172.18.0.3:4444
2022-11-17 10:02:55 Trapped SIGTERM/SIGINT/x so shutting down supervisord...
2022-11-17 10:03:20 2022-11-17 15:03:20,884 INFO Included extra file "/etc/supervisor/conf.d/selenium.conf" during parsing
2022-11-17 10:03:21 2022-11-17 15:03:21,199 INFO RPC interface 'supervisor' initialized
2022-11-17 10:03:21 2022-11-17 15:03:21,199 CRIT Server 'unix_http_server' running without any HTTP authentication checking
2022-11-17 10:03:21 2022-11-17 15:03:21,199 INFO supervisord started with pid 8
2022-11-17 10:03:22 2022-11-17 15:03:22,201 INFO spawned: 'xvfb' with pid 9
2022-11-17 10:03:22 2022-11-17 15:03:22,204 INFO spawned: 'vnc' with pid 10
2022-11-17 10:03:20 Unlinking stale socket /tmp/supervisor.sock
2022-11-17 10:03:22 2022-11-17 15:03:22,205 INFO spawned: 'novnc' with pid 11
2022-11-17 10:03:22 2022-11-17 15:03:22,206 INFO spawned: 'selenium-standalone' with pid 13
2022-11-17 10:03:22 Setting up SE_NODE_GRID_URL...
2022-11-17 10:03:22 2022-11-17 15:03:22,220 INFO success: xvfb entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2022-11-17 10:03:22 2022-11-17 15:03:22,220 INFO success: vnc entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2022-11-17 10:03:22 2022-11-17 15:03:22,220 INFO success: novnc entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2022-11-17 10:03:22 2022-11-17 15:03:22,220 INFO success: selenium-standalone entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2022-11-17 10:03:22 Selenium Grid Standalone configuration: 
2022-11-17 10:03:22 [network]
2022-11-17 10:03:22 relax-checks = true
2022-11-17 10:03:22 
2022-11-17 10:03:22 [node]
2022-11-17 10:03:22 session-timeout = "300"
2022-11-17 10:03:22 override-max-sessions = false
2022-11-17 10:03:22 detect-drivers = false
2022-11-17 10:03:22 drain-after-session-count = 0
2022-11-17 10:03:22 max-sessions = 1
2022-11-17 10:03:22 
2022-11-17 10:03:22 [[node.driver-configuration]]
2022-11-17 10:03:22 display-name = "chrome"
2022-11-17 10:03:22 stereotype = '{"browserName": "chrome", "browserVersion": "107.0", "platformName": "Linux"}'
2022-11-17 10:03:22 max-sessions = 1
2022-11-17 10:03:22 
2022-11-17 10:03:22 Starting Selenium Grid Standalone...
2022-11-17 10:03:22 Tracing is disabled
2022-11-17 10:03:23 15:03:23.310 INFO [LoggingOptions.configureLogEncoding] - Using the system default encoding
2022-11-17 10:03:23 15:03:23.315 INFO [OpenTelemetryTracer.createTracer] - Using OpenTelemetry for tracing
2022-11-17 10:03:24 15:03:24.129 INFO [NodeOptions.getSessionFactories] - Detected 5 available processors
2022-11-17 10:03:24 15:03:24.181 INFO [NodeOptions.report] - Adding chrome for {"browserVersion": "107.0","se:noVncPort": 7900,"browserName": "chrome","platformName": "LINUX","se:vncEnabled": true} 1 times
2022-11-17 10:03:24 15:03:24.202 INFO [Node.<init>] - Binding additional locator mechanisms: name, id, relative
2022-11-17 10:03:24 15:03:24.236 INFO [GridModel.setAvailability] - Switching Node 83a946ad-9cd5-4a5e-a310-230b84d28a0c (uri: http://172.18.0.3:4444) from DOWN to UP
2022-11-17 10:03:24 15:03:24.237 INFO [LocalDistributor.add] - Added node 83a946ad-9cd5-4a5e-a310-230b84d28a0c at http://172.18.0.3:4444. Health check every 120s
2022-11-17 10:03:24 15:03:24.453 INFO [Standalone.execute] - Started Selenium Standalone 4.6.0 (revision 79f1c02ae20): http://172.18.0.3:4444
2022-11-17 10:10:32 2022-11-17 15:10:32,706 INFO Included extra file "/etc/supervisor/conf.d/selenium.conf" during parsing
2022-11-17 10:10:33 2022-11-17 15:10:33,018 INFO RPC interface 'supervisor' initialized
2022-11-17 10:10:33 2022-11-17 15:10:33,018 CRIT Server 'unix_http_server' running without any HTTP authentication checking
2022-11-17 10:10:33 2022-11-17 15:10:33,018 INFO supervisord started with pid 8
2022-11-17 10:10:34 2022-11-17 15:10:34,020 INFO spawned: 'xvfb' with pid 9
2022-11-17 10:10:34 2022-11-17 15:10:34,022 INFO spawned: 'vnc' with pid 10
2022-11-17 10:10:34 2022-11-17 15:10:34,023 INFO spawned: 'novnc' with pid 11
2022-11-17 10:10:34 2022-11-17 15:10:34,025 INFO spawned: 'selenium-standalone' with pid 12
2022-11-17 10:10:34 Setting up SE_NODE_GRID_URL...
2022-11-17 10:10:34 2022-11-17 15:10:34,045 INFO success: xvfb entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2022-11-17 10:10:34 2022-11-17 15:10:34,045 INFO success: vnc entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2022-11-17 10:10:34 2022-11-17 15:10:34,045 INFO success: novnc entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2022-11-17 10:10:34 2022-11-17 15:10:34,045 INFO success: selenium-standalone entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2022-11-17 10:10:32 Unlinking stale socket /tmp/supervisor.sock
2022-11-17 10:10:34 Selenium Grid Standalone configuration: 
2022-11-17 10:10:34 [network]
2022-11-17 10:10:34 relax-checks = true
2022-11-17 10:10:34 
2022-11-17 10:10:34 [node]
2022-11-17 10:10:34 session-timeout = "300"
2022-11-17 10:10:34 override-max-sessions = false
2022-11-17 10:10:34 detect-drivers = false
2022-11-17 10:10:34 drain-after-session-count = 0
2022-11-17 10:10:34 max-sessions = 1
2022-11-17 10:10:34 
2022-11-17 10:10:34 [[node.driver-configuration]]
2022-11-17 10:10:34 display-name = "chrome"
2022-11-17 10:10:34 stereotype = '{"browserName": "chrome", "browserVersion": "107.0", "platformName": "Linux"}'
2022-11-17 10:10:34 max-sessions = 1
2022-11-17 10:10:34 
2022-11-17 10:10:34 Starting Selenium Grid Standalone...
2022-11-17 10:10:34 Tracing is disabled
2022-11-17 10:10:35 15:10:35.033 INFO [LoggingOptions.configureLogEncoding] - Using the system default encoding
2022-11-17 10:10:35 15:10:35.040 INFO [OpenTelemetryTracer.createTracer] - Using OpenTelemetry for tracing
2022-11-17 10:10:36 15:10:36.074 INFO [NodeOptions.getSessionFactories] - Detected 5 available processors
2022-11-17 10:10:36 15:10:36.101 INFO [NodeOptions.report] - Adding chrome for {"browserVersion": "107.0","se:noVncPort": 7900,"browserName": "chrome","platformName": "LINUX","se:vncEnabled": true} 1 times
2022-11-17 10:10:36 15:10:36.138 INFO [Node.<init>] - Binding additional locator mechanisms: id, name, relative
2022-11-17 10:10:36 15:10:36.168 INFO [GridModel.setAvailability] - Switching Node d9b2d8b7-c04b-4cdb-a52d-f2b7a0d9b948 (uri: http://172.18.0.2:4444) from DOWN to UP
2022-11-17 10:10:36 15:10:36.170 INFO [LocalDistributor.add] - Added node d9b2d8b7-c04b-4cdb-a52d-f2b7a0d9b948 at http://172.18.0.2:4444. Health check every 120s
2022-11-17 10:10:36 15:10:36.397 INFO [Standalone.execute] - Started Selenium Standalone 4.6.0 (revision 79f1c02ae20): http://172.18.0.2:4444
2022-11-17 10:24:20 15:24:20.538 INFO [LocalDistributor.newSession] - Session request received by the Distributor: 
2022-11-17 10:24:20  [Capabilities {browserName: chrome, goog:chromeOptions: {args: [], extensions: []}}]
2022-11-17 10:24:20 Starting ChromeDriver 107.0.5304.87 (f59ffb32abf8c01e9aa298400314bfdf0221b02f-refs/branch-heads/5304@{#1093}) on port 22214
2022-11-17 10:24:20 Only local connections are allowed.
2022-11-17 10:24:20 Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
2022-11-17 10:24:20 ChromeDriver was started successfully.
2022-11-17 10:24:20 [1668698660.624][SEVERE]: bind() failed: Cannot assign requested address (99)
2022-11-17 10:24:21 15:24:21.647 INFO [LocalNode.newSession] - Session created by the Node. Id: ccc905152f64b7a39520bd3c32714acb, Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:35971}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:cdp: http://localhost:35971, se:cdpVersion: 107.0.5304.87, se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.2:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-11-17 10:24:21 15:24:21.651 INFO [LocalDistributor.newSession] - Session created by the Distributor. Id: ccc905152f64b7a39520bd3c32714acb 
2022-11-17 10:24:21  Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:35971}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:bidiEnabled: false, se:cdp: ws://172.18.0.2:4444/sessio..., se:cdpVersion: 107.0.5304.87, se:vnc: ws://172.18.0.2:4444/sessio..., se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.2:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-11-17 10:24:33 15:24:33.817 INFO [LocalSessionMap.lambda$new$0] - Deleted session from local Session Map, Id: ccc905152f64b7a39520bd3c32714acb
2022-11-17 10:24:33 15:24:33.820 INFO [GridModel.release] - Releasing slot for session id ccc905152f64b7a39520bd3c32714acb
2022-11-17 10:24:33 15:24:33.820 INFO [SessionSlot.stop] - Stopping session ccc905152f64b7a39520bd3c32714acb
2022-11-17 10:24:58 15:24:58.132 INFO [LocalDistributor.newSession] - Session request received by the Distributor: 
2022-11-17 10:24:58  [Capabilities {browserName: chrome, goog:chromeOptions: {args: [], extensions: []}}]
2022-11-17 10:24:58 Starting ChromeDriver 107.0.5304.87 (f59ffb32abf8c01e9aa298400314bfdf0221b02f-refs/branch-heads/5304@{#1093}) on port 27847
2022-11-17 10:24:58 Only local connections are allowed.
2022-11-17 10:24:58 Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
2022-11-17 10:24:58 ChromeDriver was started successfully.
2022-11-17 10:24:58 [1668698698.141][SEVERE]: bind() failed: Cannot assign requested address (99)
2022-11-17 10:24:58 15:24:58.513 INFO [LocalNode.newSession] - Session created by the Node. Id: 59097ee1022044b408e7f48c2c133c73, Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:35545}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:cdp: http://localhost:35545, se:cdpVersion: 107.0.5304.87, se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.2:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-11-17 10:24:58 15:24:58.519 INFO [LocalDistributor.newSession] - Session created by the Distributor. Id: 59097ee1022044b408e7f48c2c133c73 
2022-11-17 10:24:58  Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:35545}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:bidiEnabled: false, se:cdp: ws://172.18.0.2:4444/sessio..., se:cdpVersion: 107.0.5304.87, se:vnc: ws://172.18.0.2:4444/sessio..., se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.2:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-11-17 10:25:36 15:25:36.244 INFO [LocalSessionMap.lambda$new$0] - Deleted session from local Session Map, Id: 59097ee1022044b408e7f48c2c133c73
2022-11-17 10:25:36 15:25:36.244 INFO [GridModel.release] - Releasing slot for session id 59097ee1022044b408e7f48c2c133c73
2022-11-17 10:25:36 15:25:36.245 INFO [SessionSlot.stop] - Stopping session 59097ee1022044b408e7f48c2c133c73
2022-11-17 10:25:59 15:25:59.046 INFO [LocalDistributor.newSession] - Session request received by the Distributor: 
2022-11-17 10:25:59  [Capabilities {browserName: chrome, goog:chromeOptions: {args: [], extensions: []}}]
2022-11-17 10:25:59 Starting ChromeDriver 107.0.5304.87 (f59ffb32abf8c01e9aa298400314bfdf0221b02f-refs/branch-heads/5304@{#1093}) on port 7348
2022-11-17 10:25:59 Only local connections are allowed.
2022-11-17 10:25:59 Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
2022-11-17 10:25:59 ChromeDriver was started successfully.
2022-11-17 10:25:59 [1668698759.054][SEVERE]: bind() failed: Cannot assign requested address (99)
2022-11-17 10:25:59 15:25:59.326 INFO [LocalNode.newSession] - Session created by the Node. Id: ddc50555c2415783de269e3977661dd1, Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:38995}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:cdp: http://localhost:38995, se:cdpVersion: 107.0.5304.87, se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.2:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-11-17 10:25:59 15:25:59.328 INFO [LocalDistributor.newSession] - Session created by the Distributor. Id: ddc50555c2415783de269e3977661dd1 
2022-11-17 10:25:59  Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:38995}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:bidiEnabled: false, se:cdp: ws://172.18.0.2:4444/sessio..., se:cdpVersion: 107.0.5304.87, se:vnc: ws://172.18.0.2:4444/sessio..., se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.2:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-11-17 10:26:36 15:26:36.432 INFO [LocalSessionMap.lambda$new$0] - Deleted session from local Session Map, Id: ddc50555c2415783de269e3977661dd1
2022-11-17 10:26:36 15:26:36.432 INFO [GridModel.release] - Releasing slot for session id ddc50555c2415783de269e3977661dd1
2022-11-17 10:26:36 15:26:36.432 INFO [SessionSlot.stop] - Stopping session ddc50555c2415783de269e3977661dd1
2022-11-17 10:27:04 15:27:04.880 INFO [LocalDistributor.newSession] - Session request received by the Distributor: 
2022-11-17 10:27:04  [Capabilities {browserName: chrome, goog:chromeOptions: {args: [], extensions: []}}]
2022-11-17 10:27:04 Starting ChromeDriver 107.0.5304.87 (f59ffb32abf8c01e9aa298400314bfdf0221b02f-refs/branch-heads/5304@{#1093}) on port 30859
2022-11-17 10:27:04 Only local connections are allowed.
2022-11-17 10:27:04 Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
2022-11-17 10:27:04 ChromeDriver was started successfully.
2022-11-17 10:27:04 [1668698824.888][SEVERE]: bind() failed: Cannot assign requested address (99)
2022-11-17 10:27:05 15:27:05.133 INFO [LocalNode.newSession] - Session created by the Node. Id: e22e0e9b4701a1293483096d7745914f, Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:42195}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:cdp: http://localhost:42195, se:cdpVersion: 107.0.5304.87, se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.2:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-11-17 10:27:05 15:27:05.135 INFO [LocalDistributor.newSession] - Session created by the Distributor. Id: e22e0e9b4701a1293483096d7745914f 
2022-11-17 10:27:05  Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:42195}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:bidiEnabled: false, se:cdp: ws://172.18.0.2:4444/sessio..., se:cdpVersion: 107.0.5304.87, se:vnc: ws://172.18.0.2:4444/sessio..., se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.2:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-11-17 10:43:28 15:43:28.582 INFO [LocalSessionMap.lambda$new$0] - Deleted session from local Session Map, Id: e22e0e9b4701a1293483096d7745914f
2022-11-17 10:43:28 15:43:28.583 INFO [GridModel.release] - Releasing slot for session id e22e0e9b4701a1293483096d7745914f
2022-11-17 10:43:28 15:43:28.583 INFO [SessionSlot.stop] - Stopping session e22e0e9b4701a1293483096d7745914f
2022-11-17 10:43:53 15:43:53.726 INFO [GridModel.purgeDeadNodes] - Switching Node http://172.18.0.2:4444 from UP to DOWN
2022-11-17 11:00:48 16:00:48.721 INFO [GridModel.purgeDeadNodes] - Removing Node http://172.18.0.2:4444, DOWN for too long
2022-11-17 14:07:28 19:07:28.198 WARN [SeleniumSpanExporter$1.lambda$export$3] - {"traceId": "6819e4db78b551c158724a6191da5699","eventTime": 1668711136500711238,"eventName": "HTTP request execution complete","attributes": {"http.flavor": 1,"http.handler_class": "org.openqa.selenium.grid.sessionqueue.local.LocalNewSessionQueue","http.host": "chrome:4444","http.method": "POST","http.request_content_length": "365","http.scheme": "HTTP","http.status_code": 500,"http.target": "\u002fsession","http.user_agent": "selenium\u002f4.1.3 (java unix)"}}
2022-11-17 14:07:28 
2022-11-17 14:07:28 19:07:28.199 WARN [SeleniumSpanExporter$1.lambda$export$3] - {"traceId": "2bdf78a465346126490c64d9ed5a3311","eventTime": 1668711136503134867,"eventName": "HTTP request execution complete","attributes": {"http.flavor": 1,"http.handler_class": "org.openqa.selenium.grid.sessionqueue.local.LocalNewSessionQueue","http.host": "chrome:4444","http.method": "POST","http.request_content_length": "365","http.scheme": "HTTP","http.status_code": 500,"http.target": "\u002fsession","http.user_agent": "selenium\u002f4.1.3 (java unix)"}}
2022-11-17 14:07:28 
2022-11-17 18:45:19 2022-11-17 23:45:19,194 INFO Included extra file "/etc/supervisor/conf.d/selenium.conf" during parsing
2022-11-17 18:45:19 2022-11-17 23:45:19,205 INFO RPC interface 'supervisor' initialized
2022-11-17 18:45:19 2022-11-17 23:45:19,205 CRIT Server 'unix_http_server' running without any HTTP authentication checking
2022-11-17 18:45:19 2022-11-17 23:45:19,206 INFO supervisord started with pid 8
2022-11-17 18:45:20 2022-11-17 23:45:20,207 INFO spawned: 'xvfb' with pid 9
2022-11-17 18:45:20 2022-11-17 23:45:20,208 INFO spawned: 'vnc' with pid 10
2022-11-17 18:45:20 2022-11-17 23:45:20,209 INFO spawned: 'novnc' with pid 11
2022-11-17 18:45:20 2022-11-17 23:45:20,211 INFO spawned: 'selenium-standalone' with pid 12
2022-11-17 18:45:20 Setting up SE_NODE_GRID_URL...
2022-11-17 18:45:20 2022-11-17 23:45:20,227 INFO success: xvfb entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2022-11-17 18:45:20 2022-11-17 23:45:20,228 INFO success: vnc entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2022-11-17 18:45:20 2022-11-17 23:45:20,228 INFO success: novnc entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2022-11-17 18:45:20 2022-11-17 23:45:20,228 INFO success: selenium-standalone entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2022-11-17 18:45:20 Selenium Grid Standalone configuration: 
2022-11-17 18:45:20 [network]
2022-11-17 18:45:20 relax-checks = true
2022-11-17 18:45:20 
2022-11-17 18:45:20 [node]
2022-11-17 18:45:20 session-timeout = "300"
2022-11-17 18:45:20 override-max-sessions = false
2022-11-17 18:45:20 detect-drivers = false
2022-11-17 18:45:20 drain-after-session-count = 0
2022-11-17 18:45:20 max-sessions = 1
2022-11-17 18:45:20 
2022-11-17 18:45:20 [[node.driver-configuration]]
2022-11-17 18:45:20 display-name = "chrome"
2022-11-17 18:45:20 stereotype = '{"browserName": "chrome", "browserVersion": "107.0", "platformName": "Linux"}'
2022-11-17 18:45:20 max-sessions = 1
2022-11-17 18:45:20 
2022-11-17 18:45:20 Starting Selenium Grid Standalone...
2022-11-17 18:45:20 Tracing is disabled
2022-11-17 18:45:21 23:45:21.349 INFO [LoggingOptions.configureLogEncoding] - Using the system default encoding
2022-11-17 18:45:21 23:45:21.358 INFO [OpenTelemetryTracer.createTracer] - Using OpenTelemetry for tracing
2022-11-17 18:45:22 23:45:22.386 INFO [NodeOptions.getSessionFactories] - Detected 5 available processors
2022-11-17 18:45:22 23:45:22.426 INFO [NodeOptions.report] - Adding chrome for {"browserVersion": "107.0","se:noVncPort": 7900,"browserName": "chrome","platformName": "LINUX","se:vncEnabled": true} 1 times
2022-11-17 18:45:22 23:45:22.445 INFO [Node.<init>] - Binding additional locator mechanisms: relative, id, name
2022-11-17 18:45:22 23:45:22.489 INFO [GridModel.setAvailability] - Switching Node 1676e997-49e7-42c5-b90d-78f0b4517f9d (uri: http://172.18.0.3:4444) from DOWN to UP
2022-11-17 18:45:22 23:45:22.490 INFO [LocalDistributor.add] - Added node 1676e997-49e7-42c5-b90d-78f0b4517f9d at http://172.18.0.3:4444. Health check every 120s
2022-11-17 18:45:22 23:45:22.694 INFO [Standalone.execute] - Started Selenium Standalone 4.6.0 (revision 79f1c02ae20): http://172.18.0.3:4444
2022-11-17 18:46:50 2022-11-17 23:46:50,929 INFO Included extra file "/etc/supervisor/conf.d/selenium.conf" during parsing
2022-11-17 18:46:50 2022-11-17 23:46:50,940 INFO RPC interface 'supervisor' initialized
2022-11-17 18:46:50 2022-11-17 23:46:50,940 CRIT Server 'unix_http_server' running without any HTTP authentication checking
2022-11-17 18:46:50 2022-11-17 23:46:50,940 INFO supervisord started with pid 7
2022-11-17 18:46:51 2022-11-17 23:46:51,942 INFO spawned: 'xvfb' with pid 8
2022-11-17 18:46:51 2022-11-17 23:46:51,943 INFO spawned: 'vnc' with pid 9
2022-11-17 18:46:51 2022-11-17 23:46:51,944 INFO spawned: 'novnc' with pid 10
2022-11-17 18:46:51 2022-11-17 23:46:51,945 INFO spawned: 'selenium-standalone' with pid 11
2022-11-17 18:46:51 Setting up SE_NODE_GRID_URL...
2022-11-17 18:46:51 2022-11-17 23:46:51,954 INFO success: xvfb entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2022-11-17 18:46:51 2022-11-17 23:46:51,954 INFO success: vnc entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2022-11-17 18:46:51 2022-11-17 23:46:51,954 INFO success: novnc entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2022-11-17 18:46:51 2022-11-17 23:46:51,954 INFO success: selenium-standalone entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2022-11-17 18:46:52 Selenium Grid Standalone configuration: 
2022-11-17 18:46:52 [network]
2022-11-17 18:46:52 relax-checks = true
2022-11-17 18:46:52 
2022-11-17 18:46:52 [node]
2022-11-17 18:46:52 session-timeout = "300"
2022-11-17 18:46:52 override-max-sessions = false
2022-11-17 18:46:52 detect-drivers = false
2022-11-17 18:46:52 drain-after-session-count = 0
2022-11-17 18:46:52 max-sessions = 1
2022-11-17 18:46:52 
2022-11-17 18:46:52 [[node.driver-configuration]]
2022-11-17 18:46:52 display-name = "chrome"
2022-11-17 18:46:52 stereotype = '{"browserName": "chrome", "browserVersion": "107.0", "platformName": "Linux"}'
2022-11-17 18:46:52 max-sessions = 1
2022-11-17 18:46:52 
2022-11-17 18:46:52 Starting Selenium Grid Standalone...
2022-11-17 18:46:52 Tracing is disabled
2022-11-17 18:46:52 23:46:52.845 INFO [LoggingOptions.configureLogEncoding] - Using the system default encoding
2022-11-17 18:46:52 23:46:52.849 INFO [OpenTelemetryTracer.createTracer] - Using OpenTelemetry for tracing
2022-11-17 18:46:53 23:46:53.954 INFO [NodeOptions.getSessionFactories] - Detected 5 available processors
2022-11-17 18:46:53 23:46:53.993 INFO [NodeOptions.report] - Adding chrome for {"browserVersion": "107.0","se:noVncPort": 7900,"browserName": "chrome","platformName": "LINUX","se:vncEnabled": true} 1 times
2022-11-17 18:46:54 23:46:54.007 INFO [Node.<init>] - Binding additional locator mechanisms: id, relative, name
2022-11-17 18:46:54 23:46:54.040 INFO [GridModel.setAvailability] - Switching Node bb867a8f-b0b4-4b5b-9847-0462628e4584 (uri: http://172.18.0.2:4444) from DOWN to UP
2022-11-17 18:46:54 23:46:54.046 INFO [LocalDistributor.add] - Added node bb867a8f-b0b4-4b5b-9847-0462628e4584 at http://172.18.0.2:4444. Health check every 120s
2022-11-17 18:46:54 23:46:54.232 INFO [Standalone.execute] - Started Selenium Standalone 4.6.0 (revision 79f1c02ae20): http://172.18.0.2:4444
2022-11-17 19:14:47 00:14:47.376 INFO [GridModel.purgeDeadNodes] - Switching Node http://172.18.0.2:4444 from UP to DOWN
2022-11-17 19:15:47 00:15:47.376 INFO [GridModel.setAvailability] - Switching Node bb867a8f-b0b4-4b5b-9847-0462628e4584 (uri: http://172.18.0.2:4444) from DOWN to UP
2022-11-17 20:04:59 01:04:59.230 INFO [GridModel.purgeDeadNodes] - Switching Node http://172.18.0.2:4444 from UP to DOWN
2022-11-17 20:22:15 01:22:15.613 INFO [GridModel.purgeDeadNodes] - Removing Node http://172.18.0.2:4444, DOWN for too long
2022-11-17 21:30:43 02:30:43.859 WARN [SeleniumSpanExporter$1.lambda$export$3] - {"traceId": "8df34d91574864d394b0d78e8ef1926e","eventTime": 1668738643852942677,"eventName": "HTTP request execution complete","attributes": {"http.flavor": 1,"http.handler_class": "org.openqa.selenium.grid.sessionqueue.local.LocalNewSessionQueue","http.host": "chrome:4444","http.method": "POST","http.request_content_length": "365","http.scheme": "HTTP","http.status_code": 500,"http.target": "\u002fsession","http.user_agent": "selenium\u002f4.1.3 (java unix)"}}
2022-11-17 21:30:43 
2022-11-17 21:46:49 02:46:49.885 WARN [SeleniumSpanExporter$1.lambda$export$3] - {"traceId": "25c621ecb209170c19e09de5c6772090","eventTime": 1668739609923559887,"eventName": "HTTP request execution complete","attributes": {"http.flavor": 1,"http.handler_class": "org.openqa.selenium.grid.sessionqueue.local.LocalNewSessionQueue","http.host": "chrome:4444","http.method": "POST","http.request_content_length": "365","http.scheme": "HTTP","http.status_code": 500,"http.target": "\u002fsession","http.user_agent": "selenium\u002f4.1.3 (java unix)"}}
2022-11-17 21:46:49 
2022-11-18 10:54:59 15:54:59.852 WARN [SeleniumSpanExporter$1.lambda$export$3] - {"traceId": "e878eea5250e108a5b03426c2baa952b","eventTime": 1668786899850692636,"eventName": "HTTP request execution complete","attributes": {"http.flavor": 1,"http.handler_class": "org.openqa.selenium.grid.sessionqueue.local.LocalNewSessionQueue","http.host": "chrome:4444","http.method": "POST","http.request_content_length": "365","http.scheme": "HTTP","http.status_code": 500,"http.target": "\u002fsession","http.user_agent": "selenium\u002f4.1.3 (java unix)"}}
2022-11-18 10:54:59 
2022-11-18 17:53:30 22:53:30.288 WARN [SeleniumSpanExporter$1.lambda$export$3] - {"traceId": "0640a9a49b2c61793c3dd3d3ad364d57","eventTime": 1668811082594844241,"eventName": "HTTP request execution complete","attributes": {"http.flavor": 1,"http.handler_class": "org.openqa.selenium.grid.sessionqueue.local.LocalNewSessionQueue","http.host": "chrome:4444","http.method": "POST","http.request_content_length": "365","http.scheme": "HTTP","http.status_code": 500,"http.target": "\u002fsession","http.user_agent": "selenium\u002f4.1.3 (java unix)"}}
2022-11-18 17:53:30 
2022-11-18 19:16:39 00:16:39.646 WARN [SeleniumSpanExporter$1.lambda$export$3] - {"traceId": "8813e6e71974e18cc525a99435992922","eventTime": 1668816999642367303,"eventName": "HTTP request execution complete","attributes": {"http.flavor": 1,"http.handler_class": "org.openqa.selenium.grid.sessionqueue.local.LocalNewSessionQueue","http.host": "chrome:4444","http.method": "POST","http.request_content_length": "365","http.scheme": "HTTP","http.status_code": 500,"http.target": "\u002fsession","http.user_agent": "selenium\u002f4.1.3 (java unix)"}}
2022-11-18 19:16:39 
2022-11-18 23:40:34 04:40:34.823 WARN [SeleniumSpanExporter$1.lambda$export$3] - {"traceId": "a4a5c62d5174308cda63d1447ba7378a","eventTime": 1668832834822282510,"eventName": "HTTP request execution complete","attributes": {"http.flavor": 1,"http.handler_class": "org.openqa.selenium.grid.sessionqueue.local.LocalNewSessionQueue","http.host": "chrome:4444","http.method": "POST","http.request_content_length": "365","http.scheme": "HTTP","http.status_code": 500,"http.target": "\u002fsession","http.user_agent": "selenium\u002f4.1.3 (java unix)"}}
2022-11-18 23:40:34 
2022-11-19 10:04:09 15:04:09.056 WARN [SeleniumSpanExporter$1.lambda$export$3] - {"traceId": "a418fec1beb31a2f2d3cea14c92fc7eb","eventTime": 1668870249094822261,"eventName": "HTTP request execution complete","attributes": {"http.flavor": 1,"http.handler_class": "org.openqa.selenium.grid.sessionqueue.local.LocalNewSessionQueue","http.host": "chrome:4444","http.method": "POST","http.request_content_length": "365","http.scheme": "HTTP","http.status_code": 500,"http.target": "\u002fsession","http.user_agent": "selenium\u002f4.1.3 (java unix)"}}
2022-11-19 10:04:09 
2022-11-25 19:39:41 00:39:41.559 WARN [SeleniumSpanExporter$1.lambda$export$3] - {"traceId": "dbd4c8dbae11543bd94cd23b7a5cd468","eventTime": 1669423181562778762,"eventName": "HTTP request execution complete","attributes": {"http.flavor": 1,"http.handler_class": "org.openqa.selenium.grid.sessionqueue.local.LocalNewSessionQueue","http.host": "chrome:4444","http.method": "POST","http.request_content_length": "365","http.scheme": "HTTP","http.status_code": 500,"http.target": "\u002fsession","http.user_agent": "selenium\u002f4.1.3 (java unix)"}}
2022-11-25 19:39:41 
2022-11-26 07:39:25 12:39:25.569 WARN [SeleniumSpanExporter$1.lambda$export$3] - {"traceId": "0c152df3660cc0f52b1894ff10e3130d","eventTime": 1669466365571959928,"eventName": "HTTP request execution complete","attributes": {"http.flavor": 1,"http.handler_class": "org.openqa.selenium.grid.sessionqueue.local.LocalNewSessionQueue","http.host": "chrome:4444","http.method": "POST","http.request_content_length": "365","http.scheme": "HTTP","http.status_code": 500,"http.target": "\u002fsession","http.user_agent": "selenium\u002f4.1.3 (java unix)"}}
2022-11-26 07:39:25 
2022-11-26 10:03:56 15:03:56.749 WARN [SeleniumSpanExporter$1.lambda$export$3] - {"traceId": "e567ac0672a916a23ddeba58f1b7e759","eventTime": 1669475036747396553,"eventName": "HTTP request execution complete","attributes": {"http.flavor": 1,"http.handler_class": "org.openqa.selenium.grid.sessionqueue.local.LocalNewSessionQueue","http.host": "chrome:4444","http.method": "POST","http.request_content_length": "365","http.scheme": "HTTP","http.status_code": 500,"http.target": "\u002fsession","http.user_agent": "selenium\u002f4.1.3 (java unix)"}}
2022-11-26 10:03:56 
2022-12-17 06:33:09 2022-12-17 11:33:09,976 INFO Included extra file "/etc/supervisor/conf.d/selenium.conf" during parsing
2022-12-17 06:33:10 2022-12-17 11:33:10,290 INFO RPC interface 'supervisor' initialized
2022-12-17 06:33:10 2022-12-17 11:33:10,290 CRIT Server 'unix_http_server' running without any HTTP authentication checking
2022-12-17 06:33:10 2022-12-17 11:33:10,290 INFO supervisord started with pid 8
2022-12-17 06:33:11 2022-12-17 11:33:11,292 INFO spawned: 'xvfb' with pid 9
2022-12-17 06:33:11 2022-12-17 11:33:11,294 INFO spawned: 'vnc' with pid 10
2022-12-17 06:33:11 2022-12-17 11:33:11,296 INFO spawned: 'novnc' with pid 11
2022-12-17 06:33:11 2022-12-17 11:33:11,297 INFO spawned: 'selenium-standalone' with pid 12
2022-12-17 06:33:11 Setting up SE_NODE_GRID_URL...
2022-12-17 06:33:11 2022-12-17 11:33:11,307 INFO success: xvfb entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2022-12-17 06:33:11 2022-12-17 11:33:11,307 INFO success: vnc entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2022-12-17 06:33:11 2022-12-17 11:33:11,307 INFO success: novnc entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2022-12-17 06:33:11 2022-12-17 11:33:11,307 INFO success: selenium-standalone entered RUNNING state, process has stayed up for > than 0 seconds (startsecs)
2022-12-17 06:33:11 Selenium Grid Standalone configuration: 
2022-12-17 06:33:11 [network]
2022-12-17 06:33:11 relax-checks = true
2022-12-17 06:33:11 
2022-12-17 06:33:11 [node]
2022-12-17 06:33:11 session-timeout = "300"
2022-12-17 06:33:11 override-max-sessions = false
2022-12-17 06:33:11 detect-drivers = false
2022-12-17 06:33:11 drain-after-session-count = 0
2022-12-17 06:33:11 max-sessions = 1
2022-12-17 06:33:11 
2022-12-17 06:33:11 [[node.driver-configuration]]
2022-12-17 06:33:11 display-name = "chrome"
2022-12-17 06:33:11 stereotype = '{"browserName": "chrome", "browserVersion": "107.0", "platformName": "Linux"}'
2022-12-17 06:33:11 max-sessions = 1
2022-12-17 06:33:11 
2022-12-17 06:33:11 Starting Selenium Grid Standalone...
2022-12-17 06:33:11 Tracing is disabled
2022-12-17 06:33:12 11:33:12.201 INFO [LoggingOptions.configureLogEncoding] - Using the system default encoding
2022-12-17 06:33:12 11:33:12.204 INFO [OpenTelemetryTracer.createTracer] - Using OpenTelemetry for tracing
2022-12-17 06:33:12 11:33:12.693 INFO [NodeOptions.getSessionFactories] - Detected 5 available processors
2022-12-17 06:33:12 11:33:12.717 INFO [NodeOptions.report] - Adding chrome for {"browserVersion": "107.0","se:noVncPort": 7900,"browserName": "chrome","platformName": "LINUX","se:vncEnabled": true} 1 times
2022-12-17 06:33:12 11:33:12.730 INFO [Node.<init>] - Binding additional locator mechanisms: name, id, relative
2022-12-17 06:33:12 11:33:12.754 INFO [GridModel.setAvailability] - Switching Node f4f0578a-164e-48b0-a1d2-7f3ece1c4702 (uri: http://172.18.0.3:4444) from DOWN to UP
2022-12-17 06:33:12 11:33:12.754 INFO [LocalDistributor.add] - Added node f4f0578a-164e-48b0-a1d2-7f3ece1c4702 at http://172.18.0.3:4444. Health check every 120s
2022-12-17 06:33:12 11:33:12.914 INFO [Standalone.execute] - Started Selenium Standalone 4.6.0 (revision 79f1c02ae20): http://172.18.0.3:4444
2022-12-17 06:39:44 11:39:44.950 INFO [LocalDistributor.newSession] - Session request received by the Distributor: 
2022-12-17 06:39:44  [Capabilities {browserName: chrome, goog:chromeOptions: {args: [], extensions: []}}]
2022-12-17 06:39:44 Starting ChromeDriver 107.0.5304.87 (f59ffb32abf8c01e9aa298400314bfdf0221b02f-refs/branch-heads/5304@{#1093}) on port 12888
2022-12-17 06:39:44 Only local connections are allowed.
2022-12-17 06:39:44 Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
2022-12-17 06:39:45 ChromeDriver was started successfully.
2022-12-17 06:39:45 [1671277185.004][SEVERE]: bind() failed: Cannot assign requested address (99)
2022-12-17 06:39:45 11:39:45.693 INFO [LocalNode.newSession] - Session created by the Node. Id: 259a9ec4484946be7dca9a35a3326cb9, Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:40287}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:cdp: http://localhost:40287, se:cdpVersion: 107.0.5304.87, se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 06:39:45 11:39:45.697 INFO [LocalDistributor.newSession] - Session created by the Distributor. Id: 259a9ec4484946be7dca9a35a3326cb9 
2022-12-17 06:39:45  Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:40287}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:bidiEnabled: false, se:cdp: ws://172.18.0.3:4444/sessio..., se:cdpVersion: 107.0.5304.87, se:vnc: ws://172.18.0.3:4444/sessio..., se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 06:39:56 11:39:56.257 INFO [LocalSessionMap.lambda$new$0] - Deleted session from local Session Map, Id: 259a9ec4484946be7dca9a35a3326cb9
2022-12-17 06:33:09 Unlinking stale socket /tmp/supervisor.sock
2022-12-17 06:39:56 11:39:56.258 INFO [GridModel.release] - Releasing slot for session id 259a9ec4484946be7dca9a35a3326cb9
2022-12-17 06:39:56 11:39:56.259 INFO [SessionSlot.stop] - Stopping session 259a9ec4484946be7dca9a35a3326cb9
2022-12-17 06:40:14 11:40:14.973 INFO [LocalDistributor.newSession] - Session request received by the Distributor: 
2022-12-17 06:40:14  [Capabilities {browserName: chrome, goog:chromeOptions: {args: [], extensions: []}}]
2022-12-17 06:40:14 Starting ChromeDriver 107.0.5304.87 (f59ffb32abf8c01e9aa298400314bfdf0221b02f-refs/branch-heads/5304@{#1093}) on port 4063
2022-12-17 06:40:14 Only local connections are allowed.
2022-12-17 06:40:14 Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
2022-12-17 06:40:14 ChromeDriver was started successfully.
2022-12-17 06:40:14 [1671277214.985][SEVERE]: bind() failed: Cannot assign requested address (99)
2022-12-17 06:40:15 11:40:15.235 INFO [LocalNode.newSession] - Session created by the Node. Id: ad988b186c742768b84b4e01f7eff46c, Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:37401}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:cdp: http://localhost:37401, se:cdpVersion: 107.0.5304.87, se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 06:40:15 11:40:15.237 INFO [LocalDistributor.newSession] - Session created by the Distributor. Id: ad988b186c742768b84b4e01f7eff46c 
2022-12-17 06:40:15  Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:37401}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:bidiEnabled: false, se:cdp: ws://172.18.0.3:4444/sessio..., se:cdpVersion: 107.0.5304.87, se:vnc: ws://172.18.0.3:4444/sessio..., se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 06:40:46 11:40:46.602 INFO [LocalSessionMap.lambda$new$0] - Deleted session from local Session Map, Id: ad988b186c742768b84b4e01f7eff46c
2022-12-17 06:40:46 11:40:46.602 INFO [GridModel.release] - Releasing slot for session id ad988b186c742768b84b4e01f7eff46c
2022-12-17 06:40:46 11:40:46.602 INFO [SessionSlot.stop] - Stopping session ad988b186c742768b84b4e01f7eff46c
2022-12-17 06:49:37 11:49:37.510 INFO [LocalDistributor.newSession] - Session request received by the Distributor: 
2022-12-17 06:49:37  [Capabilities {browserName: chrome, goog:chromeOptions: {args: [], extensions: []}}]
2022-12-17 06:49:37 Starting ChromeDriver 107.0.5304.87 (f59ffb32abf8c01e9aa298400314bfdf0221b02f-refs/branch-heads/5304@{#1093}) on port 19366
2022-12-17 06:49:37 Only local connections are allowed.
2022-12-17 06:49:37 Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
2022-12-17 06:49:37 ChromeDriver was started successfully.
2022-12-17 06:49:37 [1671277777.518][SEVERE]: bind() failed: Cannot assign requested address (99)
2022-12-17 06:49:37 11:49:37.797 INFO [LocalNode.newSession] - Session created by the Node. Id: 0719ebf3df4cb360e8823fb5320166cb, Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:42621}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:cdp: http://localhost:42621, se:cdpVersion: 107.0.5304.87, se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 06:49:37 11:49:37.806 INFO [LocalDistributor.newSession] - Session created by the Distributor. Id: 0719ebf3df4cb360e8823fb5320166cb 
2022-12-17 06:49:37  Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:42621}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:bidiEnabled: false, se:cdp: ws://172.18.0.3:4444/sessio..., se:cdpVersion: 107.0.5304.87, se:vnc: ws://172.18.0.3:4444/sessio..., se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 06:49:49 11:49:49.034 INFO [LocalSessionMap.lambda$new$0] - Deleted session from local Session Map, Id: 0719ebf3df4cb360e8823fb5320166cb
2022-12-17 06:49:49 11:49:49.035 INFO [GridModel.release] - Releasing slot for session id 0719ebf3df4cb360e8823fb5320166cb
2022-12-17 06:49:49 11:49:49.035 INFO [SessionSlot.stop] - Stopping session 0719ebf3df4cb360e8823fb5320166cb
2022-12-17 06:50:09 11:50:09.325 INFO [LocalDistributor.newSession] - Session request received by the Distributor: 
2022-12-17 06:50:09  [Capabilities {browserName: chrome, goog:chromeOptions: {args: [], extensions: []}}]
2022-12-17 06:50:09 Starting ChromeDriver 107.0.5304.87 (f59ffb32abf8c01e9aa298400314bfdf0221b02f-refs/branch-heads/5304@{#1093}) on port 23454
2022-12-17 06:50:09 Only local connections are allowed.
2022-12-17 06:50:09 Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
2022-12-17 06:50:09 ChromeDriver was started successfully.
2022-12-17 06:50:09 [1671277809.337][SEVERE]: bind() failed: Cannot assign requested address (99)
2022-12-17 06:50:09 11:50:09.629 INFO [LocalNode.newSession] - Session created by the Node. Id: c7dc72d55636b593e263dd8363f627bd, Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:34683}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:cdp: http://localhost:34683, se:cdpVersion: 107.0.5304.87, se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 06:50:09 11:50:09.632 INFO [LocalDistributor.newSession] - Session created by the Distributor. Id: c7dc72d55636b593e263dd8363f627bd 
2022-12-17 06:50:09  Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:34683}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:bidiEnabled: false, se:cdp: ws://172.18.0.3:4444/sessio..., se:cdpVersion: 107.0.5304.87, se:vnc: ws://172.18.0.3:4444/sessio..., se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 06:50:43 11:50:43.547 INFO [LocalSessionMap.lambda$new$0] - Deleted session from local Session Map, Id: c7dc72d55636b593e263dd8363f627bd
2022-12-17 06:50:43 11:50:43.548 INFO [GridModel.release] - Releasing slot for session id c7dc72d55636b593e263dd8363f627bd
2022-12-17 06:50:43 11:50:43.548 INFO [SessionSlot.stop] - Stopping session c7dc72d55636b593e263dd8363f627bd
2022-12-17 07:11:56 12:11:56.206 INFO [LocalDistributor.newSession] - Session request received by the Distributor: 
2022-12-17 07:11:56  [Capabilities {browserName: chrome, goog:chromeOptions: {args: [], extensions: []}}]
2022-12-17 07:11:56 Starting ChromeDriver 107.0.5304.87 (f59ffb32abf8c01e9aa298400314bfdf0221b02f-refs/branch-heads/5304@{#1093}) on port 29181
2022-12-17 07:11:56 Only local connections are allowed.
2022-12-17 07:11:56 Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
2022-12-17 07:11:56 ChromeDriver was started successfully.
2022-12-17 07:11:56 [1671279116.214][SEVERE]: bind() failed: Cannot assign requested address (99)
2022-12-17 07:11:56 12:11:56.482 INFO [LocalNode.newSession] - Session created by the Node. Id: ce2a10ec913ff2a98de290b108771571, Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:35049}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:cdp: http://localhost:35049, se:cdpVersion: 107.0.5304.87, se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 07:11:56 12:11:56.483 INFO [LocalDistributor.newSession] - Session created by the Distributor. Id: ce2a10ec913ff2a98de290b108771571 
2022-12-17 07:11:56  Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:35049}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:bidiEnabled: false, se:cdp: ws://172.18.0.3:4444/sessio..., se:cdpVersion: 107.0.5304.87, se:vnc: ws://172.18.0.3:4444/sessio..., se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 07:12:06 12:12:06.931 INFO [LocalSessionMap.lambda$new$0] - Deleted session from local Session Map, Id: ce2a10ec913ff2a98de290b108771571
2022-12-17 07:12:06 12:12:06.931 INFO [GridModel.release] - Releasing slot for session id ce2a10ec913ff2a98de290b108771571
2022-12-17 07:12:06 12:12:06.932 INFO [SessionSlot.stop] - Stopping session ce2a10ec913ff2a98de290b108771571
2022-12-17 07:12:25 12:12:25.566 INFO [LocalDistributor.newSession] - Session request received by the Distributor: 
2022-12-17 07:12:25  [Capabilities {browserName: chrome, goog:chromeOptions: {args: [], extensions: []}}]
2022-12-17 07:12:25 Starting ChromeDriver 107.0.5304.87 (f59ffb32abf8c01e9aa298400314bfdf0221b02f-refs/branch-heads/5304@{#1093}) on port 10936
2022-12-17 07:12:25 Only local connections are allowed.
2022-12-17 07:12:25 Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
2022-12-17 07:12:25 ChromeDriver was started successfully.
2022-12-17 07:12:25 [1671279145.573][SEVERE]: bind() failed: Cannot assign requested address (99)
2022-12-17 07:12:25 12:12:25.823 INFO [LocalNode.newSession] - Session created by the Node. Id: 89b8108ce40a117967603e7eda619555, Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:33955}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:cdp: http://localhost:33955, se:cdpVersion: 107.0.5304.87, se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 07:12:25 12:12:25.824 INFO [LocalDistributor.newSession] - Session created by the Distributor. Id: 89b8108ce40a117967603e7eda619555 
2022-12-17 07:12:25  Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:33955}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:bidiEnabled: false, se:cdp: ws://172.18.0.3:4444/sessio..., se:cdpVersion: 107.0.5304.87, se:vnc: ws://172.18.0.3:4444/sessio..., se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 07:12:57 12:12:57.061 INFO [LocalSessionMap.lambda$new$0] - Deleted session from local Session Map, Id: 89b8108ce40a117967603e7eda619555
2022-12-17 07:12:57 12:12:57.061 INFO [GridModel.release] - Releasing slot for session id 89b8108ce40a117967603e7eda619555
2022-12-17 07:12:57 12:12:57.061 INFO [SessionSlot.stop] - Stopping session 89b8108ce40a117967603e7eda619555
2022-12-17 07:19:47 12:19:47.304 INFO [GridModel.purgeDeadNodes] - Switching Node http://172.18.0.3:4444 from UP to DOWN
2022-12-17 07:20:47 12:20:47.304 INFO [GridModel.setAvailability] - Switching Node f4f0578a-164e-48b0-a1d2-7f3ece1c4702 (uri: http://172.18.0.3:4444) from DOWN to UP
2022-12-17 07:27:30 12:27:30.038 INFO [LocalDistributor.newSession] - Session request received by the Distributor: 
2022-12-17 07:27:30  [Capabilities {browserName: chrome, goog:chromeOptions: {args: [], extensions: []}}]
2022-12-17 07:27:30 Starting ChromeDriver 107.0.5304.87 (f59ffb32abf8c01e9aa298400314bfdf0221b02f-refs/branch-heads/5304@{#1093}) on port 23339
2022-12-17 07:27:30 Only local connections are allowed.
2022-12-17 07:27:30 Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
2022-12-17 07:27:30 ChromeDriver was started successfully.
2022-12-17 07:27:30 [1671280050.046][SEVERE]: bind() failed: Cannot assign requested address (99)
2022-12-17 07:27:30 12:27:30.300 INFO [LocalNode.newSession] - Session created by the Node. Id: 7abe39c7f9a2749c2914606d324ece69, Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:42491}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:cdp: http://localhost:42491, se:cdpVersion: 107.0.5304.87, se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 07:27:30 12:27:30.301 INFO [LocalDistributor.newSession] - Session created by the Distributor. Id: 7abe39c7f9a2749c2914606d324ece69 
2022-12-17 07:27:30  Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:42491}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:bidiEnabled: false, se:cdp: ws://172.18.0.3:4444/sessio..., se:cdpVersion: 107.0.5304.87, se:vnc: ws://172.18.0.3:4444/sessio..., se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 07:27:40 12:27:40.911 INFO [LocalSessionMap.lambda$new$0] - Deleted session from local Session Map, Id: 7abe39c7f9a2749c2914606d324ece69
2022-12-17 07:27:40 12:27:40.911 INFO [GridModel.release] - Releasing slot for session id 7abe39c7f9a2749c2914606d324ece69
2022-12-17 07:27:40 12:27:40.911 INFO [SessionSlot.stop] - Stopping session 7abe39c7f9a2749c2914606d324ece69
2022-12-17 07:27:59 12:27:59.483 INFO [LocalDistributor.newSession] - Session request received by the Distributor: 
2022-12-17 07:27:59  [Capabilities {browserName: chrome, goog:chromeOptions: {args: [], extensions: []}}]
2022-12-17 07:27:59 Starting ChromeDriver 107.0.5304.87 (f59ffb32abf8c01e9aa298400314bfdf0221b02f-refs/branch-heads/5304@{#1093}) on port 21900
2022-12-17 07:27:59 Only local connections are allowed.
2022-12-17 07:27:59 Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
2022-12-17 07:27:59 ChromeDriver was started successfully.
2022-12-17 07:27:59 [1671280079.494][SEVERE]: bind() failed: Cannot assign requested address (99)
2022-12-17 07:27:59 12:27:59.769 INFO [LocalNode.newSession] - Session created by the Node. Id: e8d6cf56b2034eb1596a09da862b5288, Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:43709}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:cdp: http://localhost:43709, se:cdpVersion: 107.0.5304.87, se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 07:27:59 12:27:59.770 INFO [LocalDistributor.newSession] - Session created by the Distributor. Id: e8d6cf56b2034eb1596a09da862b5288 
2022-12-17 07:27:59  Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:43709}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:bidiEnabled: false, se:cdp: ws://172.18.0.3:4444/sessio..., se:cdpVersion: 107.0.5304.87, se:vnc: ws://172.18.0.3:4444/sessio..., se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 07:28:31 12:28:31.216 INFO [LocalSessionMap.lambda$new$0] - Deleted session from local Session Map, Id: e8d6cf56b2034eb1596a09da862b5288
2022-12-17 07:28:31 12:28:31.216 INFO [GridModel.release] - Releasing slot for session id e8d6cf56b2034eb1596a09da862b5288
2022-12-17 07:28:31 12:28:31.217 INFO [SessionSlot.stop] - Stopping session e8d6cf56b2034eb1596a09da862b5288
2022-12-17 07:39:00 12:39:00.322 INFO [LocalDistributor.newSession] - Session request received by the Distributor: 
2022-12-17 07:39:00  [Capabilities {browserName: chrome, goog:chromeOptions: {args: [], extensions: []}}]
2022-12-17 07:39:00 Starting ChromeDriver 107.0.5304.87 (f59ffb32abf8c01e9aa298400314bfdf0221b02f-refs/branch-heads/5304@{#1093}) on port 12437
2022-12-17 07:39:00 Only local connections are allowed.
2022-12-17 07:39:00 Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
2022-12-17 07:39:00 ChromeDriver was started successfully.
2022-12-17 07:39:00 [1671280740.330][SEVERE]: bind() failed: Cannot assign requested address (99)
2022-12-17 07:39:00 12:39:00.601 INFO [LocalNode.newSession] - Session created by the Node. Id: bfef8f83dd3ea1c9e74bbd82ea06ab18, Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:34545}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:cdp: http://localhost:34545, se:cdpVersion: 107.0.5304.87, se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 07:39:00 12:39:00.602 INFO [LocalDistributor.newSession] - Session created by the Distributor. Id: bfef8f83dd3ea1c9e74bbd82ea06ab18 
2022-12-17 07:39:00  Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:34545}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:bidiEnabled: false, se:cdp: ws://172.18.0.3:4444/sessio..., se:cdpVersion: 107.0.5304.87, se:vnc: ws://172.18.0.3:4444/sessio..., se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 07:39:11 12:39:11.413 INFO [LocalSessionMap.lambda$new$0] - Deleted session from local Session Map, Id: bfef8f83dd3ea1c9e74bbd82ea06ab18
2022-12-17 07:39:11 12:39:11.413 INFO [GridModel.release] - Releasing slot for session id bfef8f83dd3ea1c9e74bbd82ea06ab18
2022-12-17 07:39:11 12:39:11.413 INFO [SessionSlot.stop] - Stopping session bfef8f83dd3ea1c9e74bbd82ea06ab18
2022-12-17 07:39:30 12:39:30.382 INFO [LocalDistributor.newSession] - Session request received by the Distributor: 
2022-12-17 07:39:30  [Capabilities {browserName: chrome, goog:chromeOptions: {args: [], extensions: []}}]
2022-12-17 07:39:30 Starting ChromeDriver 107.0.5304.87 (f59ffb32abf8c01e9aa298400314bfdf0221b02f-refs/branch-heads/5304@{#1093}) on port 27963
2022-12-17 07:39:30 Only local connections are allowed.
2022-12-17 07:39:30 Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
2022-12-17 07:39:30 ChromeDriver was started successfully.
2022-12-17 07:39:30 [1671280770.390][SEVERE]: bind() failed: Cannot assign requested address (99)
2022-12-17 07:39:30 12:39:30.663 INFO [LocalNode.newSession] - Session created by the Node. Id: 19f328ff05a4b7ab74ad899fb29ab5df, Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:40533}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:cdp: http://localhost:40533, se:cdpVersion: 107.0.5304.87, se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 07:39:30 12:39:30.664 INFO [LocalDistributor.newSession] - Session created by the Distributor. Id: 19f328ff05a4b7ab74ad899fb29ab5df 
2022-12-17 07:39:30  Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:40533}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:bidiEnabled: false, se:cdp: ws://172.18.0.3:4444/sessio..., se:cdpVersion: 107.0.5304.87, se:vnc: ws://172.18.0.3:4444/sessio..., se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 07:40:03 12:40:03.348 INFO [LocalSessionMap.lambda$new$0] - Deleted session from local Session Map, Id: 19f328ff05a4b7ab74ad899fb29ab5df
2022-12-17 07:40:03 12:40:03.349 INFO [GridModel.release] - Releasing slot for session id 19f328ff05a4b7ab74ad899fb29ab5df
2022-12-17 07:40:03 12:40:03.349 INFO [SessionSlot.stop] - Stopping session 19f328ff05a4b7ab74ad899fb29ab5df
2022-12-17 07:58:29 12:58:29.899 INFO [LocalDistributor.newSession] - Session request received by the Distributor: 
2022-12-17 07:58:29  [Capabilities {browserName: chrome, goog:chromeOptions: {args: [], extensions: []}}]
2022-12-17 07:58:29 Starting ChromeDriver 107.0.5304.87 (f59ffb32abf8c01e9aa298400314bfdf0221b02f-refs/branch-heads/5304@{#1093}) on port 13213
2022-12-17 07:58:29 Only local connections are allowed.
2022-12-17 07:58:29 Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
2022-12-17 07:58:29 ChromeDriver was started successfully.
2022-12-17 07:58:29 [1671281909.907][SEVERE]: bind() failed: Cannot assign requested address (99)
2022-12-17 07:58:30 12:58:30.166 INFO [LocalNode.newSession] - Session created by the Node. Id: 78ed7269e2c0e50f2dc87f97dffe1fb2, Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:39547}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:cdp: http://localhost:39547, se:cdpVersion: 107.0.5304.87, se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 07:58:30 12:58:30.167 INFO [LocalDistributor.newSession] - Session created by the Distributor. Id: 78ed7269e2c0e50f2dc87f97dffe1fb2 
2022-12-17 07:58:30  Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:39547}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:bidiEnabled: false, se:cdp: ws://172.18.0.3:4444/sessio..., se:cdpVersion: 107.0.5304.87, se:vnc: ws://172.18.0.3:4444/sessio..., se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 07:58:41 12:58:41.046 INFO [LocalSessionMap.lambda$new$0] - Deleted session from local Session Map, Id: 78ed7269e2c0e50f2dc87f97dffe1fb2
2022-12-17 07:58:41 12:58:41.046 INFO [GridModel.release] - Releasing slot for session id 78ed7269e2c0e50f2dc87f97dffe1fb2
2022-12-17 07:58:41 12:58:41.047 INFO [SessionSlot.stop] - Stopping session 78ed7269e2c0e50f2dc87f97dffe1fb2
2022-12-17 07:59:00 12:59:00.319 INFO [LocalDistributor.newSession] - Session request received by the Distributor: 
2022-12-17 07:59:00  [Capabilities {browserName: chrome, goog:chromeOptions: {args: [], extensions: []}}]
2022-12-17 07:59:00 Starting ChromeDriver 107.0.5304.87 (f59ffb32abf8c01e9aa298400314bfdf0221b02f-refs/branch-heads/5304@{#1093}) on port 23971
2022-12-17 07:59:00 Only local connections are allowed.
2022-12-17 07:59:00 Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
2022-12-17 07:59:00 ChromeDriver was started successfully.
2022-12-17 07:59:00 [1671281940.328][SEVERE]: bind() failed: Cannot assign requested address (99)
2022-12-17 07:59:00 12:59:00.592 INFO [LocalNode.newSession] - Session created by the Node. Id: 6997247457536fdaeac9b8ef72c564c7, Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:39707}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:cdp: http://localhost:39707, se:cdpVersion: 107.0.5304.87, se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 07:59:00 12:59:00.593 INFO [LocalDistributor.newSession] - Session created by the Distributor. Id: 6997247457536fdaeac9b8ef72c564c7 
2022-12-17 07:59:00  Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:39707}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:bidiEnabled: false, se:cdp: ws://172.18.0.3:4444/sessio..., se:cdpVersion: 107.0.5304.87, se:vnc: ws://172.18.0.3:4444/sessio..., se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 07:59:33 12:59:33.437 INFO [LocalSessionMap.lambda$new$0] - Deleted session from local Session Map, Id: 6997247457536fdaeac9b8ef72c564c7
2022-12-17 07:59:33 12:59:33.437 INFO [GridModel.release] - Releasing slot for session id 6997247457536fdaeac9b8ef72c564c7
2022-12-17 07:59:33 12:59:33.437 INFO [SessionSlot.stop] - Stopping session 6997247457536fdaeac9b8ef72c564c7
2022-12-17 08:21:10 13:21:10.659 INFO [LocalDistributor.newSession] - Session request received by the Distributor: 
2022-12-17 08:21:10  [Capabilities {browserName: chrome, goog:chromeOptions: {args: [], extensions: []}}]
2022-12-17 08:21:10 Starting ChromeDriver 107.0.5304.87 (f59ffb32abf8c01e9aa298400314bfdf0221b02f-refs/branch-heads/5304@{#1093}) on port 27493
2022-12-17 08:21:10 Only local connections are allowed.
2022-12-17 08:21:10 Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
2022-12-17 08:21:10 ChromeDriver was started successfully.
2022-12-17 08:21:10 [1671283270.668][SEVERE]: bind() failed: Cannot assign requested address (99)
2022-12-17 08:21:10 13:21:10.934 INFO [LocalNode.newSession] - Session created by the Node. Id: 89c604fa00d267c38dfab2ead0fe5377, Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:36139}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:cdp: http://localhost:36139, se:cdpVersion: 107.0.5304.87, se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 08:21:10 13:21:10.935 INFO [LocalDistributor.newSession] - Session created by the Distributor. Id: 89c604fa00d267c38dfab2ead0fe5377 
2022-12-17 08:21:10  Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:36139}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:bidiEnabled: false, se:cdp: ws://172.18.0.3:4444/sessio..., se:cdpVersion: 107.0.5304.87, se:vnc: ws://172.18.0.3:4444/sessio..., se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 08:21:21 13:21:21.643 INFO [LocalSessionMap.lambda$new$0] - Deleted session from local Session Map, Id: 89c604fa00d267c38dfab2ead0fe5377
2022-12-17 08:21:21 13:21:21.643 INFO [GridModel.release] - Releasing slot for session id 89c604fa00d267c38dfab2ead0fe5377
2022-12-17 08:21:21 13:21:21.643 INFO [SessionSlot.stop] - Stopping session 89c604fa00d267c38dfab2ead0fe5377
2022-12-17 08:21:40 13:21:40.673 INFO [LocalDistributor.newSession] - Session request received by the Distributor: 
2022-12-17 08:21:40  [Capabilities {browserName: chrome, goog:chromeOptions: {args: [], extensions: []}}]
2022-12-17 08:21:40 Starting ChromeDriver 107.0.5304.87 (f59ffb32abf8c01e9aa298400314bfdf0221b02f-refs/branch-heads/5304@{#1093}) on port 26888
2022-12-17 08:21:40 Only local connections are allowed.
2022-12-17 08:21:40 Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
2022-12-17 08:21:40 [16ChromeDriver wa7s1 2started successfully.
2022-12-17 08:21:40 83300.683][SEVERE]: bind() failed: Cannot assign requested address (99)
2022-12-17 08:21:40 13:21:40.938 INFO [LocalNode.newSession] - Session created by the Node. Id: f80233702172e617fc9a1e0ab9fed098, Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:36117}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:cdp: http://localhost:36117, se:cdpVersion: 107.0.5304.87, se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 08:21:40 13:21:40.939 INFO [LocalDistributor.newSession] - Session created by the Distributor. Id: f80233702172e617fc9a1e0ab9fed098 
2022-12-17 08:21:40  Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:36117}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:bidiEnabled: false, se:cdp: ws://172.18.0.3:4444/sessio..., se:cdpVersion: 107.0.5304.87, se:vnc: ws://172.18.0.3:4444/sessio..., se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 08:22:13 13:22:13.665 INFO [LocalSessionMap.lambda$new$0] - Deleted session from local Session Map, Id: f80233702172e617fc9a1e0ab9fed098
2022-12-17 08:22:13 13:22:13.665 INFO [GridModel.release] - Releasing slot for session id f80233702172e617fc9a1e0ab9fed098
2022-12-17 08:22:13 13:22:13.666 INFO [SessionSlot.stop] - Stopping session f80233702172e617fc9a1e0ab9fed098
2022-12-17 08:32:49 13:32:49.507 INFO [LocalDistributor.newSession] - Session request received by the Distributor: 
2022-12-17 08:32:49  [Capabilities {browserName: chrome, goog:chromeOptions: {args: [], extensions: []}}]
2022-12-17 08:32:49 Starting ChromeDriver 107.0.5304.87 (f59ffb32abf8c01e9aa298400314bfdf0221b02f-refs/branch-heads/5304@{#1093}) on port 26334
2022-12-17 08:32:49 Only local connections are allowed.
2022-12-17 08:32:49 Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
2022-12-17 08:32:49 ChromeDriver was started successfully.
2022-12-17 08:32:49 [1671283969.515][SEVERE]: bind() failed: Cannot assign requested address (99)
2022-12-17 08:32:49 13:32:49.778 INFO [LocalNode.newSession] - Session created by the Node. Id: 1e96c226e87f1b52eb5b4a46afc7adfc, Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:39873}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:cdp: http://localhost:39873, se:cdpVersion: 107.0.5304.87, se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 08:32:49 13:32:49.779 INFO [LocalDistributor.newSession] - Session created by the Distributor. Id: 1e96c226e87f1b52eb5b4a46afc7adfc 
2022-12-17 08:32:49  Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:39873}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:bidiEnabled: false, se:cdp: ws://172.18.0.3:4444/sessio..., se:cdpVersion: 107.0.5304.87, se:vnc: ws://172.18.0.3:4444/sessio..., se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 08:33:00 13:33:00.673 INFO [LocalSessionMap.lambda$new$0] - Deleted session from local Session Map, Id: 1e96c226e87f1b52eb5b4a46afc7adfc
2022-12-17 08:33:00 13:33:00.673 INFO [GridModel.release] - Releasing slot for session id 1e96c226e87f1b52eb5b4a46afc7adfc
2022-12-17 08:33:00 13:33:00.673 INFO [SessionSlot.stop] - Stopping session 1e96c226e87f1b52eb5b4a46afc7adfc
2022-12-17 08:33:20 13:33:20.302 INFO [LocalDistributor.newSession] - Session request received by the Distributor: 
2022-12-17 08:33:20  [Capabilities {browserName: chrome, goog:chromeOptions: {args: [], extensions: []}}]
2022-12-17 08:33:20 Starting ChromeDriver 107.0.5304.87 (f59ffb32abf8c01e9aa298400314bfdf0221b02f-refs/branch-heads/5304@{#1093}) on port 32496
2022-12-17 08:33:20 Only local connections are allowed.
2022-12-17 08:33:20 Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
2022-12-17 08:33:20 ChromeDriver was started successfully.
2022-12-17 08:33:20 [1671284000.318][SEVERE]: bind() failed: Cannot assign requested address (99)
2022-12-17 08:33:20 13:33:20.595 INFO [LocalNode.newSession] - Session created by the Node. Id: 35f58cc5eaec8b93e678921b39dbd807, Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:36637}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:cdp: http://localhost:36637, se:cdpVersion: 107.0.5304.87, se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 08:33:20 13:33:20.596 INFO [LocalDistributor.newSession] - Session created by the Distributor. Id: 35f58cc5eaec8b93e678921b39dbd807 
2022-12-17 08:33:20  Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:36637}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:bidiEnabled: false, se:cdp: ws://172.18.0.3:4444/sessio..., se:cdpVersion: 107.0.5304.87, se:vnc: ws://172.18.0.3:4444/sessio..., se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 08:33:52 13:33:52.960 INFO [LocalSessionMap.lambda$new$0] - Deleted session from local Session Map, Id: 35f58cc5eaec8b93e678921b39dbd807
2022-12-17 08:33:52 13:33:52.960 INFO [GridModel.release] - Releasing slot for session id 35f58cc5eaec8b93e678921b39dbd807
2022-12-17 08:33:52 13:33:52.960 INFO [SessionSlot.stop] - Stopping session 35f58cc5eaec8b93e678921b39dbd807
2022-12-17 09:30:16 14:30:16.697 INFO [LocalDistributor.newSession] - Session request received by the Distributor: 
2022-12-17 09:30:16  [Capabilities {browserName: chrome, goog:chromeOptions: {args: [], extensions: []}}]
2022-12-17 09:30:16 Starting ChromeDriver 107.0.5304.87 (f59ffb32abf8c01e9aa298400314bfdf0221b02f-refs/branch-heads/5304@{#1093}) on port 27965
2022-12-17 09:30:16 Only local connections are allowed.
2022-12-17 09:30:16 Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
2022-12-17 09:30:16 ChromeDriver was started successfully.
2022-12-17 09:30:16 [1671287416.704][SEVERE]: bind() failed: Cannot assign requested address (99)
2022-12-17 09:30:16 14:30:16.961 INFO [LocalNode.newSession] - Session created by the Node. Id: b6384c72b283aecc2805f0469686f89b, Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:38039}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:cdp: http://localhost:38039, se:cdpVersion: 107.0.5304.87, se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 09:30:16 14:30:16.961 INFO [LocalDistributor.newSession] - Session created by the Distributor. Id: b6384c72b283aecc2805f0469686f89b 
2022-12-17 09:30:16  Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:38039}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:bidiEnabled: false, se:cdp: ws://172.18.0.3:4444/sessio..., se:cdpVersion: 107.0.5304.87, se:vnc: ws://172.18.0.3:4444/sessio..., se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 09:30:27 14:30:27.683 INFO [LocalSessionMap.lambda$new$0] - Deleted session from local Session Map, Id: b6384c72b283aecc2805f0469686f89b
2022-12-17 09:30:27 14:30:27.683 INFO [GridModel.release] - Releasing slot for session id b6384c72b283aecc2805f0469686f89b
2022-12-17 09:30:27 14:30:27.684 INFO [SessionSlot.stop] - Stopping session b6384c72b283aecc2805f0469686f89b
2022-12-17 09:30:45 14:30:45.947 INFO [LocalDistributor.newSession] - Session request received by the Distributor: 
2022-12-17 09:30:45  [Capabilities {browserName: chrome, goog:chromeOptions: {args: [], extensions: []}}]
2022-12-17 09:30:45 Starting ChromeDriver 107.0.5304.87 (f59ffb32abf8c01e9aa298400314bfdf0221b02f-refs/branch-heads/5304@{#1093}) on port 1173
2022-12-17 09:30:45 Only local connections are allowed.
2022-12-17 09:30:45 Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
2022-12-17 09:30:45 ChromeDriver was started successfully.
2022-12-17 09:30:45 [1671287445.958][SEVERE]: bind() failed: Cannot assign requested address (99)
2022-12-17 09:30:46 14:30:46.214 INFO [LocalNode.newSession] - Session created by the Node. Id: 607584e223cf8b60b95d82ef0aa97bb6, Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:37011}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:cdp: http://localhost:37011, se:cdpVersion: 107.0.5304.87, se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 09:30:46 14:30:46.215 INFO [LocalDistributor.newSession] - Session created by the Distributor. Id: 607584e223cf8b60b95d82ef0aa97bb6 
2022-12-17 09:30:46  Caps: Capabilities {acceptInsecureCerts: false, browserName: chrome, browserVersion: 107.0.5304.87, chrome: {chromedriverVersion: 107.0.5304.87 (f59ffb32abf8..., userDataDir: /tmp/.org.chromium.Chromium...}, goog:chromeOptions: {debuggerAddress: localhost:37011}, networkConnectionEnabled: false, pageLoadStrategy: normal, platformName: LINUX, proxy: Proxy(), se:bidiEnabled: false, se:cdp: ws://172.18.0.3:4444/sessio..., se:cdpVersion: 107.0.5304.87, se:vnc: ws://172.18.0.3:4444/sessio..., se:vncEnabled: true, se:vncLocalAddress: ws://172.18.0.3:7900, setWindowRect: true, strictFileInteractability: false, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unhandledPromptBehavior: dismiss and notify, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
2022-12-17 09:31:18 14:31:18.730 INFO [LocalSessionMap.lambda$new$0] - Deleted session from local Session Map, Id: 607584e223cf8b60b95d82ef0aa97bb6
2022-12-17 09:31:18 14:31:18.730 INFO [GridModel.release] - Releasing slot for session id 607584e223cf8b60b95d82ef0aa97bb6
2022-12-17 09:31:18 14:31:18.731 INFO [SessionSlot.stop] - Stopping session 607584e223cf8b60b95d82ef0aa97bb6
2022-12-17 10:16:13 15:16:13.923 INFO [GridModel.purgeDeadNodes] - Switching Node http://172.18.0.3:4444 from UP to DOWN
2022-12-17 10:16:13 15:16:13.924 INFO [GridModel.setAvailability] - Switching Node f4f0578a-164e-48b0-a1d2-7f3ece1c4702 (uri: http://172.18.0.3:4444) from DOWN to UP
2022-12-17 10:32:39 15:32:39.914 INFO [GridModel.purgeDeadNodes] - Switching Node http://172.18.0.3:4444 from UP to DOWN
2022-12-17 10:36:29 15:36:29.056 INFO [GridModel.setAvailability] - Switching Node f4f0578a-164e-48b0-a1d2-7f3ece1c4702 (uri: http://172.18.0.3:4444) from DOWN to UP
2022-12-17 10:52:00 15:52:00.900 INFO [GridModel.purgeDeadNodes] - Switching Node http://172.18.0.3:4444 from UP to DOWN
2022-12-17 11:08:35 16:08:35.832 INFO [GridModel.purgeDeadNodes] - Removing Node http://172.18.0.3:4444, DOWN for too long
2022-12-19 10:57:19 15:57:19.779 WARN [SeleniumSpanExporter$1.lambda$export$3] - {"traceId": "623b4e7ba6f1517bb07e6063dec23e04","eventTime": 1671465439782179511,"eventName": "HTTP request execution complete","attributes": {"http.flavor": 1,"http.handler_class": "org.openqa.selenium.grid.sessionqueue.local.LocalNewSessionQueue","http.host": "chrome:4444","http.method": "POST","http.request_content_length": "365","http.scheme": "HTTP","http.status_code": 500,"http.target": "\u002fsession","http.user_agent": "selenium\u002f4.1.3 (java unix)"}}
2022-12-19 10:57:19
jamesmortensen commented 1 year ago

Hi @davidpcaldwell have you tried running the tests with your macOS firewall disabled? I am wondering if the firewall is blocking the ports. Can you try that?

If that doesn't work, I'm wondering are you able to run browser tests with seleniarm/standalone-chromium? You can check that using this demo project, assuming you have Node.js and npm installed:

$ docker run --rm -it -p 4444:4444 -p 7900:7900 --shm-size 2g seleniarm/standalone-chromium:latest

Then in another tab:

$ git clone https://github.com/jamesmortensen/wdio-async-demo.git && cd wdio-async-demo
$ npm i
$ npx wdio wdio.async-standalone-chrome.conf.js

You should be able to browse to http://localhost:7900 and see some tests running in Chromium. What I'm wondering if this does is tell us whether the network/firewall issue is between containers or if it's more widespread and affects host to container connections as well.

samuelvi commented 1 year ago

Hi James,

First of all thank you for your great job regarding selenium+arm.

We tried seleniarm/standalone-chromium:latest on AMD and ARM (M1) and couldn't make javascript tests to work properly, we are not sure, but guess that has something to do with security (whitelist-ip or something)

We made it work on AMD and ARM using this version: seleniarm/standalone-chromium:4.5.3-20221025 but would be great using the latest release.

Our stack is based on Symfony/Php,. We use Behat/Mink for functional tests. When our web container contacts seleniarm/standalone-chromium:latest works fine until some javascript action is executed.

If you need further information, please don't hesitate to let me know.

Thank you very much in deed.

Regards,

Samuel

jamesmortensen commented 1 year ago

Hi @samuelvi can you please include a minimal example that I could run that replicates the problem. For @davidpcaldwell I am able to run his tests on my machine, but he can't on his. @davidpcaldwell just curious if you've tried with the same version 4.5.3-20221025?

samuelvi commented 1 year ago

Hi James,

In the process of creating the minimal example you requested us, we realized that the problem had something to do with the Behat library.

We noticed that removing some parameters in the config file sorted out the problem (removed all capabilities) To summarize, the latest docker version worked for us both in AMD and ARM using this behat.yaml configuration:

default:
    ...
    extensions:
        Behat\MinkExtension:
            sessions:
                selenium2:
                    selenium2:
                        wd_host: "http://127.0.0.1:4444/wd/hub"
                        capabilities: {
                            "browser": "chrome",
                        }

Thank you very much!

jamesmortensen commented 1 year ago

You're welcome @samuelvi glad you got it sorted.

jamesmortensen commented 1 year ago

@davidpcaldwell Sorry for the misunderstanding. I want to clarify that running the tests only worked on ARM Ubuntu. (Using an Oracle ARM Ampere ARM64 instance with 12gb RAM and 2 CPU cores). When running on Mac M1, it doesn't pass the linting stage:

docker compose -f contributor/docker-compose.yaml build test11 docker compose -f contributor/docker-compose.yaml run test11

...
Installed Rhino at /slime/local/jsh/lib/js.jar

npm notice 
added 97 packages, and audited 98 packages in 3s

npm notice New major version of npm available! 8.15.0 -> 9.2.0
24 packages are looking for funding
  run `npm fund` for details

npm notice Changelog: <https://github.com/npm/cli/releases/tag/v9.2.0>
found 0 vulnerabilities
npm notice Run `npm install -g npm@9.2.0` to update!
npm notice 

added 1 package, and audited 2 packages in 427ms

found 0 vulnerabilities
Linting ...
Warning: Nashorn engine is planned to be removed from a future JDK release
Warning: Nashorn engine is planned to be removed from a future JDK release
Warning: Nashorn engine is planned to be removed from a future JDK release
Warning: Nashorn engine is planned to be removed from a future JDK release
Warning: Nashorn engine is planned to be removed from a future JDK release
Warning: Nashorn engine is planned to be removed from a future JDK release
Linting failed.

But now, on ARM Ubuntu, after pulling your latest changes, I get this:

Linting ...
Warning: Nashorn engine is planned to be removed from a future JDK release
Warning: Nashorn engine is planned to be removed from a future JDK release
Warning: Nashorn engine is planned to be removed from a future JDK release
Warning: Nashorn engine is planned to be removed from a future JDK release
Warning: Nashorn engine is planned to be removed from a future JDK release
Warning: Nashorn engine is planned to be removed from a future JDK release

[jsh] Script halted because of 1 errors.

[jsh] /slime/contributor/code/license.jsh.js:158: Error: Extension null for log (/slime/contributor/code/license.jsh.js#158)
org.mozilla.javascript.JavaScriptException: Error: Extension null for log (/slime/contributor/code/license.jsh.js#158)
    at org.mozilla.javascript.Interpreter.interpretLoop(Interpreter.java:1295)
    at script(/slime/contributor/code/license.jsh.js:158)
    at script(/slime/contributor/code/license.jsh.js:8)
    at script(/slime/contributor/code/license.jsh.js:1)
    at org.mozilla.javascript.Interpreter.interpret(Interpreter.java:1053)
    at org.mozilla.javascript.InterpretedFunction.exec(InterpretedFunction.java:106)
    at inonit.script.rhino.Source$ReaderSource.evaluate(Source.java:234)
    at inonit.script.rhino.Source.evaluate(Source.java:77)
    at inonit.script.rhino.Engine.script(Engine.java:155)
    at inonit.script.jsh.Rhino$Interface.script(Rhino.java:37)
    at jdk.internal.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
    at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at java.base/java.lang.reflect.Method.invoke(Method.java:566)
    at org.mozilla.javascript.MemberBox.invoke(MemberBox.java:206)
    at org.mozilla.javascript.NativeJavaMethod.call(NativeJavaMethod.java:211)
    at org.mozilla.javascript.Interpreter.interpretLoop(Interpreter.java:1871)
    at script(jrunscript/rhino.js:39)
    at script(jrunscript/expression.js:94)
    at script.newrun(slime://loader/scripts.js:128)
    at script.run(slime://loader/scripts.js:161)
    at script(slime://loader/expression.js:318)
    at script(/slime/jsh/loader/jsh.js:276)
    at script(/slime/jsh/script/plugin.jsh.js:597)
    at script(/slime/jsh/loader/jsh.js:451)
    at script(/slime/jsh/loader/jsh.js:8)
    at org.mozilla.javascript.Interpreter.interpret(Interpreter.java:1053)
    at org.mozilla.javascript.InterpretedFunction.call(InterpretedFunction.java:90)
    at org.mozilla.javascript.ContextFactory.doTopCall(ContextFactory.java:380)
    at org.mozilla.javascript.ScriptRuntime.doTopCall(ScriptRuntime.java:3868)
    at org.mozilla.javascript.InterpretedFunction.exec(InterpretedFunction.java:103)
    at inonit.script.rhino.Source$ReaderSource.evaluate(Source.java:234)
    at inonit.script.rhino.Engine$HostFactory$ExecutorImpl$Unit.execute(Engine.java:312)
    at inonit.script.rhino.Engine$HostFactory$ExecutorImpl.eval(Engine.java:263)
    at inonit.script.engine.Host.run(Host.java:119)
    at inonit.script.engine.Host.run(Host.java:128)
    at inonit.script.jsh.Shell$Execution$1.run(Shell.java:745)
    at inonit.script.jsh.Rhino$ExecutionImpl$ErrorHandlingImpl.run(Rhino.java:126)
    at inonit.script.jsh.Shell$Execution.execute(Shell.java:742)
    at inonit.script.jsh.Rhino$ExecutionImpl.execute(Rhino.java:89)
    at inonit.script.jsh.Rhino$EngineImpl$1.call(Rhino.java:258)
    at inonit.script.jsh.Rhino$EngineImpl$1.call(Rhino.java:255)
    at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
    at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
    at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
    at java.base/java.lang.Thread.run(Thread.java:829)

Linting failed.

Do I have everything I need to be able to replicate? I'm not sure the errors I am seeing are related to anything in docker-seleniarm? Can you confirm? Thank you!

davidpcaldwell commented 1 year ago

No, that is unrelated. I will have a look when I'm back at my desk. Probably I need to create branch specific to this report, as main is moving. Though in this case I'm guessing you captured a log file as .log and it is complaining it doesn't know the file type. If you put that in local/ instead that will be ignored.

I'll also check on the firewall but I doubt it's on.

davidpcaldwell commented 1 year ago

I can confirm that my macOS firewall is not enabled. @jamesmortensen provided a PR to my project to try to set up some additional diagnostics, so I'll have a look at that as soon as I get a chance and make the modifications necessary to get everything running.

jamesmortensen commented 1 year ago

I saw that it was complaining about the log. When I got rid of it, I could move forward, but I ran into disk space issues. I'll try it again next time I am at a computer and have cleared enough space.

jamesmortensen commented 1 year ago

@davidpcaldwell can you see the attached log and confirm that this ran successfully on my Mac M1? It looks like it was. It doesn't solve the problem, but it does hint that there must be some network issue on your M1. Can you share the technique you used to pull logs from the containers? Perhaps we can compare the IP addresses and confirm your theory that Docker is doing something different on your machine.

https://pastebin.com/05EZDajB

davidpcaldwell commented 1 year ago

@jamesmortensen can't tell -- that's only a portion of the output (before the tests reach the Selenium portion).

On what is there, so far, so good!

I'm having a look at your PR presently.

davidpcaldwell commented 1 year ago

Well, I pulled down your changes locally and ran the tests to see whether they would get through the linter and up to the browser stuff, and ... the browser stuff ran and passed, too. I'm running the tests on GitHub CI now and will merge the PR if/when they pass.

Maybe I'll try one more time locally after getting organized, and if it passes again, I'll (re-)close this.

If that is how this ends up, unfortunately, I don't have anywhere to point folks who run across this issue -- I didn't make any changes that would affect this that I am aware of.

davidpcaldwell commented 1 year ago

Well, to be clear on my end, this is now passing on my Apple Silicon machine. I made no changes that I know of that would have affected this. But I'm happy about it! I wish I could add more about what caused the problem. Maybe something upstream? Maybe something I changed locally that affected it in a non-obvious way? I guess most likely something Docker-related, maybe updating the Docker version?

In any case, I'm closing this again, as all seems to be good. Thanks to @jamesmortensen for helping investigate and contributing a CircleCI arm64 implementation that will perhaps help should anything recur or come up in the future.