Selenium Grid returns "cannot find Chrome binary" despite using Firefox

[EugeneS30]

Meta -

OS:
Windows 7

Selenium Version:
3.5.2

Geckodriver Version:
0.18.0

Browser:
Firefox 54

Really weird issue here where I attempt to launch a Firefox instance through Grid and get the following error in the Grid log:

org.openqa.selenium.WebDriverException: unknown error: cannot find Chrome binary

Expected Behavior -

Firefox instance is launched on node

Actual Behavior -

The following exception returned on hub:
org.openqa.selenium.WebDriverException: unknown error: cannot find Chrome binary

Despite the fact I do not have Chrome mentioned anywhere in my configuration and it is not installed on the node.

Steps to reproduce -

Hub config:

{
  "port": 4445,
  "newSessionWaitTimeout": -1,
  "servlets" : [],
  "withoutServlets": [],
  "custom": {},
  "capabilityMatcher": "org.openqa.grid.internal.utils.DefaultCapabilityMatcher",
  "throwOnCapabilityNotPresent": true,
  "cleanUpCycle": 5000,
  "role": "hub",
  "debug": false,
  "browserTimeout": 0,
  "timeout": 1800
}

Hub start batch:
java -cp "lib\*;selenium-server-standalone-3.5.2.jar" org.openqa.grid.selenium.GridLauncherV3 -role hub -hubConfig "C:\selenium\hubConfig-3.5.2.json" >"C:\selenium\logs-3.5.2\hub.log" 2>"C:\selenium\logs-3.5.2\hub.error.log"

Node config:

{
  "capabilities":
  [
    {
      "browserName": "firefox",
      "maxInstances": 5,
      "seleniumProtocol": "WebDriver",
      "version": "54",
      "firefox_binary":"C:\\Program Files\\Mozilla Firefox\\firefox.exe"
    }
  ],
  "proxy": "org.openqa.grid.selenium.proxy.DefaultRemoteProxy",
  "maxSession": 5,
  "port": 5555,
  "register": true,
  "registerCycle": 5000,
  "hub": "http://hubhost4445",
  "nodeStatusCheckTimeout": 5000,
  "nodePolling": 5000,
  "role": "node",
  "unregisterIfStillDownAfter": 60000,
  "downPollingLimit": 2,
  "debug": false,
  "servlets" : [],
  "withoutServlets": [],
  "custom": {}
}

Node starter batch:
java -Dwebdriver.gecko.driver="C:\selenium\geckodriver.exe" -jar selenium-server-standalone-3.5.2.jar -role node -nodeConfig "C:\selenium\nodeConfig_3.5.2.json" -debug

Code:

@Test
	public void findMarionetteOnGithub() throws MalformedURLException {

		System.setProperty("webdriver.gecko.driver", "C:\\temp\\geckodriver.exe");
		DesiredCapabilities capabilities = new DesiredCapabilities();
		capabilities.setCapability("marionette", true);
		WebDriver driver = new RemoteWebDriver(new URL("http://hubhost:4445/wd/hub"), capabilities);
		WebDriverWait wait = new WebDriverWait(driver, 10);
		driver.close();

	}

Debug output on hub:

11:09:35.234 DEBUG - Memory-based payload for: {desiredCapabilities={marionette=true}, capabilities={firstMatch=[], desiredCapabilities={marionette=true}, alwaysMatch={}, requiredCapabilities={}}, requiredCapabilities={}}
11:09:35.235 INFO - Mismatched capabilities. Creating a synthetic w3c capability.
11:09:35.235 INFO - Got a request to create a new session: Capabilities [{marionette=true}]
11:09:35.236 DEBUG - Available nodes: [http://nodehost:5555]
11:09:35.236 DEBUG - Trying to create a new session on node http://nodehost:5555
11:09:35.236 INFO - Trying to create a new session on test slot {seleniumProtocol=WebDriver, firefox_binary=C:\Program Files\Mozilla Firefox\firefox.exe, browserName=firefox, maxInstances=5, version=54, platform=VISTA}
11:09:35.236 DEBUG - Closing connections idle longer than 100 MILLISECONDS
11:09:35.236 DEBUG - http-outgoing-536: Close connection
11:09:35.237 DEBUG - CookieSpec selected: default
11:09:35.238 DEBUG - Auth cache not set in the context
11:09:35.238 DEBUG - Connection request: [route: {}->http://nodehost:5555][total kept alive: 0; route allocated: 0 of 2000; total allocated: 0 of 2000]
11:09:35.238 DEBUG - Connection leased: [id: 537][route: {}->http://nodehost:5555][total kept alive: 0; route allocated: 1 of 2000; total allocated: 1 of 2000]
11:09:35.238 DEBUG - Opening connection {}->http://nodehost:5555
11:09:35.238 DEBUG - Connecting to /nodehost:5555
11:09:35.239 DEBUG - Connection established hubhost:57503<->nodehost:5555
11:09:35.239 DEBUG - http-outgoing-537: set socket timeout to 0
11:09:35.240 DEBUG - Executing request POST /wd/hub/session HTTP/1.1
11:09:35.240 DEBUG - Target auth state: UNCHALLENGED
11:09:35.240 DEBUG - Proxy auth state: UNCHALLENGED
11:09:35.240 DEBUG - http-outgoing-537 >> POST /wd/hub/session HTTP/1.1
11:09:35.240 DEBUG - http-outgoing-537 >> Connection: keep-alive
11:09:35.240 DEBUG - http-outgoing-537 >> User-Agent: Apache-HttpClient/4.5.1 (Java/1.8.0_45)
11:09:35.240 DEBUG - http-outgoing-537 >> Host: hubhost:4445
11:09:35.241 DEBUG - http-outgoing-537 >> Accept-Encoding: gzip,deflate
11:09:35.241 DEBUG - http-outgoing-537 >> Content-Type: application/json; charset=UTF-8
11:09:35.241 DEBUG - http-outgoing-537 >> Content-Length: 249
11:09:35.241 DEBUG - http-outgoing-537 >> "POST /wd/hub/session HTTP/1.1[\r][\n]"
11:09:35.241 DEBUG - http-outgoing-537 >> "Connection: keep-alive[\r][\n]"
11:09:35.241 DEBUG - http-outgoing-537 >> "User-Agent: Apache-HttpClient/4.5.1 (Java/1.8.0_45)[\r][\n]"
11:09:35.241 DEBUG - http-outgoing-537 >> "Host: hubhost:4445[\r][\n]"
11:09:35.242 DEBUG - http-outgoing-537 >> "Accept-Encoding: gzip,deflate[\r][\n]"
11:09:35.242 DEBUG - http-outgoing-537 >> "Content-Type: application/json; charset=UTF-8[\r][\n]"
11:09:35.242 DEBUG - http-outgoing-537 >> "Content-Length: 249[\r][\n]"
11:09:35.242 DEBUG - http-outgoing-537 >> "[\r][\n]"
11:09:35.242 DEBUG - http-outgoing-537 >> "{[\n]"
11:09:35.242 DEBUG - http-outgoing-537 >> "  "desiredCapabilities": {[\n]"
11:09:35.242 DEBUG - http-outgoing-537 >> "    "marionette": true[\n]"
11:09:35.243 DEBUG - http-outgoing-537 >> "  },[\n]"
11:09:35.243 DEBUG - http-outgoing-537 >> "  "requiredCapabilities": {},[\n]"
11:09:35.243 DEBUG - http-outgoing-537 >> "  "capabilities": {[\n]"
11:09:35.243 DEBUG - http-outgoing-537 >> "    "desiredCapabilities": {[\n]"
11:09:35.243 DEBUG - http-outgoing-537 >> "      "marionette": true[\n]"
11:09:35.243 DEBUG - http-outgoing-537 >> "    },[\n]"
11:09:35.243 DEBUG - http-outgoing-537 >> "    "requiredCapabilities": {},[\n]"
11:09:35.243 DEBUG - http-outgoing-537 >> "    "alwaysMatch": {},[\n]"
11:09:35.244 DEBUG - http-outgoing-537 >> "    "firstMatch": [][\n]"
11:09:35.244 DEBUG - http-outgoing-537 >> "  }[\n]"
11:09:35.244 DEBUG - http-outgoing-537 >> "}"
11:09:36.111 DEBUG - http-outgoing-537 << "HTTP/1.1 500 Server Error[\r][\n]"
11:09:36.111 DEBUG - http-outgoing-537 << "Content-Type: application/json;charset=utf-8[\r][\n]"
11:09:36.111 DEBUG - http-outgoing-537 << "Content-Length: 8612[\r][\n]"
11:09:36.111 DEBUG - http-outgoing-537 << "Server: Jetty(9.4.5.v20170502)[\r][\n]"
11:09:36.111 DEBUG - http-outgoing-537 << "[\r][\n]"
11:09:36.112 DEBUG - http-outgoing-537 << "{"value":{"stacktrace":"org.openqa.selenium.WebDriverException: unknown error: cannot find Chrome binary\n  (Driver info: chromedriver=2.11.298604 (75ea2fdb5c87f133a8e1b8da16f6091fb7d5321e),platform=Windows NT 6.1 SP1 x86_64) (WARNING: The server did not provide any stacktrace information)\nCommand duration or timeout: 57 milliseconds\nBuild info: version: '3.5.2', revision: '10229a9020', time: '2017-08-21T17:54:21.164Z'\nSystem info: host: 'MS406186F622A9', ip: 'nodehost', os.name: 'Windows 7', os.arch: 'amd64', os.version: '6.1', java.version: '1.8.0_25'\nDriver info: driver.version: unknown\r\n\tat sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)\r\n\tat sun.reflect.NativeConstructorAccessorImpl.newInstance(Unknown Source)\r\n\tat sun.reflect.DelegatingConstructorAccessorImpl.newInstance(Unknown Source)\r\n\tat java.lang.reflect.Constructor.newInstance(Unknown Source)\r\n\tat org.openqa.selenium.remote.ErrorHandler.createThrowable(ErrorHandler.java:215)\r\n\tat org.openqa.selenium.remote.ErrorHandler.throwIfResponseFailed(ErrorHandler.java:167)\r\n\tat org.openqa.selenium.remote.JsonWireProtocolResponse.lambda$new$0(JsonWireProtocolResponse.java:53)\r\n\tat org.openqa.selenium.remote.JsonWireProtocolResponse$$Lambda$121/297298413.apply(Unknown Source)\r\n\tat org.openqa.selenium.remote.JsonWireProtocolResponse.lambda$getResponseFunction$2(JsonWireProtocolResponse.java:91)\r\n\tat org.openqa.selenium.remote.JsonWireProtocolResponse$$Lambda$123/1797835797.apply(Unknown Source)\r\n\tat org.openqa.selenium.remote.ProtocolHandshake.lambda$createSession$24(ProtocolHandshake.java:359)\r\n\tat org.openqa.selenium.remote.ProtocolHandshake$$Lambda$130/440049290.apply(Unknown Source)\r\n\tat java.util.stream.ReferencePipeline$3$1.accept(Unknown Source)\r\n\tat java.util.Spliterators$ArraySpliterator.tryAdvance(Unknown Source)\r\n\tat java.util.stream.ReferencePipeline.forEachWithCancel(Unknown Source)\r\n\tat java.util.stream.AbstractPipeline.copyIntoWithCancel(Unknown Source)\r\n\tat java.util.stream.AbstractPipeline.copyInto(Unknown Source)\r\n\tat java.util.stream.AbstractPipeline.wrapAndCopyInto(Unknown Source)\r\n\tat java.util.stream.FindOps$FindOp.evaluateSequential(Unknown Source)\r\n\tat java.util.stream.AbstractPipeline.evaluate(Unknown Source)\r\n\tat java.util.stream.ReferencePipeline.findFirst(Unknown Source)\r\n\tat org.openqa.selenium.remote.ProtocolHandshake.createSession(ProtocolHandshake.java:362)\r\n\tat org.openqa.selenium.remote.server.ServicedSession$Factory.apply(ServicedSession.java:172)\r\n\tat org.openqa.selenium.remote.server.ActiveSessionFactory.lambda$createSession$15(ActiveSessionFactory.java:148)\r\n\tat org.openqa.selenium.remote.server.ActiveSessionFactory$$Lambda$114/975961810.apply(Unknown Source)\r\n\tat java.util.Optional.map(Unknown Source)\r\n\tat org.openqa.selenium.remote.server.ActiveSessionFactory.createSession(ActiveSessionFactory.java:148)\r\n\tat org.openqa.selenium.remote.server.BeginSession.execute(BeginSession.java:67)\r\n\tat org.openqa.selenium.remote.server.WebDriverServlet.lambda$handle$0(WebDriverServlet.java:231)\r\n\tat org.openqa.selenium.remote.server.WebDriverServlet$$Lambda$46/1504987566.run(Unknown Source)\r\n\tat java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source)\r\n\tat java.util.concurrent.FutureTask.run(Unknown Source)\r\n\tat java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)\r\n\tat java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)\r\n\tat java.lang.Thread.run(Unknown Source)\r\n","stackTrace":[{"fileName":null,"methodName":"newInstance0","className":"sun.reflect.NativeConstructorAccessorImpl","lineNumber":-2},{"fileName":null,"methodName":"newInstance","className":"sun.reflect.NativeConstructorAccessorImpl","lineNumber":-1},{"fileName":null,"methodName":"newInstance","className":"sun.reflect.DelegatingConstructorAccessorImpl","lineNumber":-1},{"fileName":null,"methodName":"newInstance","className":"java.lang.reflect.Constructor","lineNumber":-1},{"fileName":"ErrorHandler.java","methodName":"createThrowable","className":"org.openqa.selenium.remote.ErrorHandler","lineNumber":215},{"fileName":"ErrorHandler.java","methodName":"throwIfResponseFailed","className":"org.openqa.selenium.remote.ErrorHandler","lineNumber":167},{"fileName":"JsonWireProtocolResponse.java","methodName":"lambda$new$0","className":"org.openqa.selenium.remote.JsonWireProtocolResponse","lineNumber":53},{"fileName":null,"methodName":"apply","className":"org.openqa.selenium.remote.JsonWireProtocolResponse$$Lambda$121/297298413","lineNumber":-1},{"fileName":"JsonWireProtocolResponse.java","methodName":"lambda$getResponseFunction$2","className":"org.openqa.selenium.remote.JsonWireProtocolResponse","lineNumber":91},{"fileName":null,"methodName":"apply","className":"org.openqa.selenium.remote.JsonWireProtocolResponse$$Lambda$123/1797835797","lineNumber":-1},{"fileName":"ProtocolHandshake.java","methodName":"lambda$createSession$24","className":"org.openqa.selenium.remote.ProtocolHandshake","lineNumber":359},{"fileName":null,"methodName":"apply","className":"org.openqa.selenium.remote.ProtocolHandshake$$Lambda$130/440049290","lineNumber":-1},{"fileName":null,"methodName":"accept","className":"java.util.stream.ReferencePipeline$3$1","lineNumber":-1},{"fileName":null,"methodName":"tryAdvance","className":"java.util.Spliterators$ArraySpliterator","lineNumber":-1},{"fileName":null,"methodName":"forEachWithCancel","className":"java.util.stream.ReferencePipeline","lineNumber":-1},{"fileName":null,"methodName":"copyIntoWithCancel","className":"java.util.stream.AbstractPipeline","lineNumber":-1},{"fileName":null,"methodName":"copyInto","className":"java.util.stream.AbstractPipeline","lineNumber":-1},{"fileName":null,"methodName":"wrapAndCopyInto","className":"java.util.stream.AbstractPipeline","lineNumber":-1},{"fileName":null,"methodName":"evaluateSequential","className":"java.util.stream.FindOps$FindOp","lineNumber":-1},{"fileName":null,"methodName":"evaluate","className":"java.util.stream.AbstractPipeline","lineNumber":-1},{"fileName":null,"methodName":"findFirst","className":"java.util.stream.ReferencePipeline","lineNumber":-1},{"fileName":"ProtocolHandshake.java","methodName":"createSession","className":"org.openqa.selenium.remote.ProtocolHandshake","lineNumber":362},{"fileName":"ServicedSession.java","methodName":"apply","className":"org.openqa.selenium.remote.server.ServicedSession$Factory","lineNumber":172},{"fileName":"ActiveSessionFactory.java","methodName":"lambda$createSession$15","className":"org.openqa.selenium.remote.server.ActiveSessionFactory","lineNumber":148},{"fileName":null,"methodName":"apply","className":"org.openqa.selenium.remote.server.ActiveSessionFactory$$Lambda$114/975961810","lineNumber":-1},{"fileName":null,"methodName":"map","className":"java.util.Optional","lineNumber":-1},{"fileName":"ActiveSessionFactory.java","methodName":"createSession","className":"org.openqa.selenium.remote.server.ActiveSessionFactory","lineNumber":148},{"fileName":"BeginSession.java","methodName":"execute","className":"org.openqa.selenium.remote.server.BeginSession","lineNumber":67},{"fileName":"WebDriverServlet.java","methodName":"lambda$handle$0","className":"org.openqa.selenium.remote.server.WebDriverServlet","lineNumber":231},{"fileName":null,"methodName":"run","className":"org.openqa.selenium.remote.server.WebDriverServlet$$Lambda$46/1504987566","lineNumber":-1},{"fileName":null,"methodName":"call","className":"java.util.concurrent.Executors$RunnableAdapter","lineNumber":-1},{"fileName":null,"methodName":"run","className":"java.util.concurrent.FutureTask","lineNumber":-1},{"fileName":null,"methodName":"runWorker","className":"java.util.concurrent.ThreadPoolExecutor","lineNumber":-1},{"fileName":null,"methodName":"run","className":"java.util.concurrent.ThreadPoolExecutor$Worker","lineNumber":-1},{"fileName":null,"methodName":"run","className":"java.lang.Thread","lineNumber":-1}],"message":"unknown error: cannot find Ch"
11:09:36.112 DEBUG - http-outgoing-537 << HTTP/1.1 500 Server Error
11:09:36.112 DEBUG - http-outgoing-537 << Content-Type: application/json;charset=utf-8
11:09:36.112 DEBUG - http-outgoing-537 << Content-Length: 8612
11:09:36.112 DEBUG - http-outgoing-537 << Server: Jetty(9.4.5.v20170502)
11:09:36.113 DEBUG - Connection can be kept alive indefinitely
11:09:36.113 DEBUG - http-outgoing-537 << "rome binary\n  (Driver info: chromedriver=2.11.298604 (75ea2fdb5c87f133a8e1b8da16f6091fb7d5321e),platform=Windows NT 6.1 SP1 x86_64) (WARNING: The server did not provide any stacktrace information)\nCommand duration or timeout: 57 milliseconds\nBuild info: version: '3.5.2', revision: '10229a9020', time: '2017-08-21T17:54:21.164Z'\nSystem info: host: 'MS406186F622A9', ip: 'nodehost', os.name: 'Windows 7', os.arch: 'amd64', os.version: '6.1', java.version: '1.8.0_25'\nDriver info: driver.version: unknown","error":"unknown error"},"status":13}"
11:09:36.114 DEBUG - Connection [id: 537][route: {}->http://nodehost:5555] can be kept alive indefinitely
11:09:36.114 DEBUG - Connection released: [id: 537][route: {}->http://nodehost:5555][total kept alive: 1; route allocated: 1 of 2000; total allocated: 1 of 2000]
11:09:36.298 DEBUG - Closing connections idle longer than 100 MILLISECONDS
11:09:36.298 DEBUG - http-outgoing-537: Close connection
11:09:36.299 DEBUG - CookieSpec selected: default
11:09:36.299 DEBUG - Auth cache not set in the context
11:09:36.299 DEBUG - Connection request: [route: {}->http://nodehost:5555][total kept alive: 0; route allocated: 0 of 2000; total allocated: 0 of 2000]
11:09:36.299 DEBUG - Connection leased: [id: 538][route: {}->http://nodehost:5555][total kept alive: 0; route allocated: 1 of 2000; total allocated: 1 of 2000]
11:09:36.299 DEBUG - Opening connection {}->http://nodehost:5555
11:09:36.299 DEBUG - Connecting to /nodehost:5555
11:09:36.300 DEBUG - Connection established gubhost:57507<->nodehost:5555
11:09:36.300 DEBUG - http-outgoing-538: set socket timeout to 5000
11:09:36.300 DEBUG - Executing request GET /wd/hub/status HTTP/1.1
11:09:36.300 DEBUG - Target auth state: UNCHALLENGED
11:09:36.300 DEBUG - Proxy auth state: UNCHALLENGED
11:09:36.300 DEBUG - http-outgoing-538 >> GET /wd/hub/status HTTP/1.1

If add the following line to the code:

capabilities.setBrowserName("firefox");

Then I get the below exception

The same is happening if I define the capabilities object statically like so:

DesiredCapabilities capabilities = DesiredCapabilities.firefox();

org.openqa.selenium.WebDriverException: Error forwarding the new session The listener threw an exception ( listener bug )
Command duration or timeout: 55 milliseconds
Build info: version: '3.5.2', revision: '10229a9', time: '2017-08-21T17:29:55.15Z'
System info: host: 'MSF0795991157F', ip: '10.25.67.134', os.name: 'Windows 7', os.arch: 'amd64', os.version: '6.1', java.version: '1.8.0_45'
Driver info: driver.version: RemoteWebDriver
	at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
	at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62)
	at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45)
	at java.lang.reflect.Constructor.newInstance(Constructor.java:422)
	at org.openqa.selenium.remote.ErrorHandler.createThrowable(ErrorHandler.java:215)
	at org.openqa.selenium.remote.ErrorHandler.throwIfResponseFailed(ErrorHandler.java:167)
	at org.openqa.selenium.remote.JsonWireProtocolResponse.lambda$new$0(JsonWireProtocolResponse.java:53)
	at org.openqa.selenium.remote.JsonWireProtocolResponse$$Lambda$70/1280851663.apply(Unknown Source)
	at org.openqa.selenium.remote.JsonWireProtocolResponse.lambda$getResponseFunction$2(JsonWireProtocolResponse.java:91)
	at org.openqa.selenium.remote.JsonWireProtocolResponse$$Lambda$72/1223867739.apply(Unknown Source)
	at org.openqa.selenium.remote.ProtocolHandshake.lambda$createSession$24(ProtocolHandshake.java:359)
	at org.openqa.selenium.remote.ProtocolHandshake$$Lambda$79/2005435445.apply(Unknown Source)
	at java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:193)
	at java.util.Spliterators$ArraySpliterator.tryAdvance(Spliterators.java:958)
	at java.util.stream.ReferencePipeline.forEachWithCancel(ReferencePipeline.java:126)
	at java.util.stream.AbstractPipeline.copyIntoWithCancel(AbstractPipeline.java:529)
	at java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:516)
	at java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:502)
	at java.util.stream.FindOps$FindOp.evaluateSequential(FindOps.java:152)
	at java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234)
	at java.util.stream.ReferencePipeline.findFirst(ReferencePipeline.java:464)
	at org.openqa.selenium.remote.ProtocolHandshake.createSession(ProtocolHandshake.java:362)
	at org.openqa.selenium.remote.ProtocolHandshake.createSession(ProtocolHandshake.java:136)
	at org.openqa.selenium.remote.HttpCommandExecutor.execute(HttpCommandExecutor.java:142)
	at org.openqa.selenium.remote.RemoteWebDriver.execute(RemoteWebDriver.java:641)
	at org.openqa.selenium.remote.RemoteWebDriver.startSession(RemoteWebDriver.java:254)
	at org.openqa.selenium.remote.RemoteWebDriver.startSession(RemoteWebDriver.java:236)
	at org.openqa.selenium.remote.RemoteWebDriver.<init>(RemoteWebDriver.java:137)
	at org.openqa.selenium.remote.RemoteWebDriver.<init>(RemoteWebDriver.java:174)
	at au.com.permeance.test.functional.configuration.WebDriverTest.findMarionetteOnGithub(WebDriverTest.java:28)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:497)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:47)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:44)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:271)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:70)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:238)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:63)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:236)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:53)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:229)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:309)
	at org.eclipse.jdt.internal.junit4.runner.JUnit4TestReference.run(JUnit4TestReference.java:50)
	at org.eclipse.jdt.internal.junit.runner.TestExecution.run(TestExecution.java:38)
	at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:459)
	at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:675)
	at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.run(RemoteTestRunner.java:382)
	at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.main(RemoteTestRunner.java:192)
Caused by: org.openqa.grid.common.exception.GridException: Error forwarding the new session The listener threw an exception ( listener bug )
	at org.openqa.grid.web.servlet.handler.RequestHandler.process(RequestHandler.java:110)
	at org.openqa.grid.web.servlet.DriverServlet.process(DriverServlet.java:84)
	at org.openqa.grid.web.servlet.DriverServlet.doPost(DriverServlet.java:68)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
	at org.seleniumhq.jetty9.servlet.ServletHolder.handle(ServletHolder.java:841)
	at org.seleniumhq.jetty9.servlet.ServletHandler.doHandle(ServletHandler.java:535)
	at org.seleniumhq.jetty9.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:188)
	at org.seleniumhq.jetty9.server.session.SessionHandler.doHandle(SessionHandler.java:1595)
	at org.seleniumhq.jetty9.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:188)
	at org.seleniumhq.jetty9.server.handler.ContextHandler.doHandle(ContextHandler.java:1253)
	at org.seleniumhq.jetty9.server.handler.ScopedHandler.nextScope(ScopedHandler.java:168)
	at org.seleniumhq.jetty9.servlet.ServletHandler.doScope(ServletHandler.java:473)
	at org.seleniumhq.jetty9.server.session.SessionHandler.doScope(SessionHandler.java:1564)
	at org.seleniumhq.jetty9.server.handler.ScopedHandler.nextScope(ScopedHandler.java:166)
	at org.seleniumhq.jetty9.server.handler.ContextHandler.doScope(ContextHandler.java:1155)
	at org.seleniumhq.jetty9.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
	at org.seleniumhq.jetty9.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132)
	at org.seleniumhq.jetty9.server.Server.handle(Server.java:564)
	at org.seleniumhq.jetty9.server.HttpChannel.handle(HttpChannel.java:317)
	at org.seleniumhq.jetty9.server.HttpConnection.onFillable(HttpConnection.java:251)
	at org.seleniumhq.jetty9.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:279)
	at org.seleniumhq.jetty9.io.FillInterest.fillable(FillInterest.java:110)
	at org.seleniumhq.jetty9.io.ChannelEndPoint$2.run(ChannelEndPoint.java:124)
	at org.seleniumhq.jetty9.util.thread.Invocable.invokePreferred(Invocable.java:128)
	at org.seleniumhq.jetty9.util.thread.Invocable$InvocableExecutor.invoke(Invocable.java:222)
	at org.seleniumhq.jetty9.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:294)
	at org.seleniumhq.jetty9.util.thread.strategy.EatWhatYouKill.run(EatWhatYouKill.java:199)
	at org.seleniumhq.jetty9.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:672)
	at org.seleniumhq.jetty9.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:590)
	at java.lang.Thread.run(Thread.java:745)

[barancev]

Please provide the complete execution log from the client side as well as the node log.

DesiredCapabilities capabilities = DesiredCapabilities.firefox();
capabilities.setCapability("marionette", true);
WebDriver driver = new RemoteWebDriver(new URL("http://hubhost:4445/wd/hub"), capabilities);

Also take note that geckodriver requires minimum Firefox 55.

[EugeneS30]

nodelog.txt
@barancev Thanks for the reply. Not sure what is the difference between client side log and node log. Please find the full node log attached

(collected using -debug argument).

I am using FF version 55. According to GeckoDriver version, it is officially recommended to use FF above version 53 so 54 seemed appropriate.

From looking at the log it appears that Chrome is set as default:

Binding default provider to: org.openqa.selenium.chrome.ChromeDriverService

It is unclear though how to force FF given setting browser name returns error as described in the initial post.

Thanks!
Eugene

[barancev]

The provided log was obtained when you did not set browserName capability.
Either init capabilities as
DesiredCapabilities capabilities = DesiredCapabilities.firefox();
or set browser name
capabilities.setBrowserName("firefox");

[barancev]

Also it's recommented to upgrade to Selneium 3.5.3

[EugeneS30]

@barancev Hi, as mentioned in my original post, if I explicitly set firefox through DesiredCapabilities or through setBrowserName, I get the below exception:

org.openqa.selenium.WebDriverException: Error forwarding the new session The listener threw an exception ( listener bug )

The session request doesn't even reach node in such case so the log on the node is empty.

The exception is only visible on the grid hub and is included in the original post.

Please let me know if I can provide any other helpful information.

P.S. Also upgraded to 3.5.3 as recommended, however this made no difference in the above described behavior.

[barancev]

The log provided in the original post tells us that you did not set browserName:

11:09:35.234 DEBUG - Memory-based payload for: {desiredCapabilities={marionette=true}, capabilities={firstMatch=[], desiredCapabilities={marionette=true}, alwaysMatch={}, requiredCapabilities={}}, requiredCapabilities={}}

[EugeneS30]

@barancev That's correct, I didn't. And when I did, I ended up with the other exception that I have mentioned:

org.openqa.selenium.WebDriverException: Error forwarding the new session The listener threw an exception ( listener bug )

[barancev]

Please provide the node log with properly set browserName.

[barancev]

Oh, sorry, the hub log

[EugeneS30]

hub.error.log.txt
@barancev Please find the attached hub debug with browserName set to firefox.

[barancev]

Thers is no attachment.

[EugeneS30]

@barancev My apologies. Attached to the above post.
Thanks