serenity-bdd / serenity-cucumber-starter

A skeleton project for Serenity BDD and Cucumber JVM
Apache License 2.0
180 stars 285 forks source link

Getting Connection time out error after i upgrade it to serenity 3.3.0 #87

Open baskarcsb opened 2 years ago

baskarcsb commented 2 years ago

After i upgrade it to 3.3.0 serenity version, noticed that at the end of execution it throws connection time out.. Note: all my steps are executed successfully but at the end of scenario it throws connection time out

baskarcsb commented 2 years ago

Adding Error info java.lang.RuntimeException: java.net.ConnectException: Connection timed out: connect at io.cucumber.core.plugin.MessageFormatter.writeMessage(MessageFormatter.java:32) at io.cucumber.core.eventbus.AbstractEventPublisher.send(AbstractEventPublisher.java:51) at io.cucumber.core.eventbus.AbstractEventBus.send(AbstractEventBus.java:12) at io.cucumber.core.runtime.SynchronizedEventBus.send(SynchronizedEventBus.java:47) at io.cucumber.core.runtime.CucumberExecutionContext.emitTestRunFinished(CucumberExecutionContext.java:117) at io.cucumber.core.runtime.CucumberExecutionContext.finishTestRun(CucumberExecutionContext.java:98) at io.cucumber.junit.CucumberSerenityRunner$RunCucumber.evaluate(CucumberSerenityRunner.java:291) at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306) at org.junit.runners.ParentRunner.run(ParentRunner.java:413) at org.eclipse.jdt.internal.junit4.runner.JUnit4TestReference.run(JUnit4TestReference.java:93) at org.eclipse.jdt.internal.junit.runner.TestExecution.run(TestExecution.java:40) at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:529) at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:756) at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.run(RemoteTestRunner.java:452) at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.main(RemoteTestRunner.java:210) Caused by: java.net.ConnectException: Connection timed out: connect at java.base/jdk.internal.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at java.base/jdk.internal.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.base/java.lang.reflect.Constructor.newInstance(Constructor.java:490) at java.base/sun.net.www.protocol.http.HttpURLConnection$10.run(HttpURLConnection.java:1974) at java.base/sun.net.www.protocol.http.HttpURLConnection$10.run(HttpURLConnection.java:1969) at java.base/java.security.AccessController.doPrivileged(Native Method) at java.base/sun.net.www.protocol.http.HttpURLConnection.getChainedException(HttpURLConnection.java:1968) at java.base/sun.net.www.protocol.http.HttpURLConnection.getInputStream0(HttpURLConnection.java:1536) at java.base/sun.net.www.protocol.http.HttpURLConnection.getInputStream(HttpURLConnection.java:1520) at java.base/java.net.HttpURLConnection.getResponseCode(HttpURLConnection.java:527) at java.base/sun.net.www.protocol.https.HttpsURLConnectionImpl.getResponseCode(HttpsURLConnectionImpl.java:334) at io.cucumber.core.plugin.UrlOutputStream.getResponseBody(UrlOutputStream.java:125) at io.cucumber.core.plugin.UrlOutputStream.sendRequest(UrlOutputStream.java:87) at io.cucumber.core.plugin.UrlOutputStream.close(UrlOutputStream.java:65) at java.base/sun.nio.cs.StreamEncoder.implClose(StreamEncoder.java:341) at java.base/sun.nio.cs.StreamEncoder.close(StreamEncoder.java:161) at java.base/java.io.OutputStreamWriter.close(OutputStreamWriter.java:255) at io.cucumber.core.plugin.MessageFormatter.writeMessage(MessageFormatter.java:29) ... 14 more Caused by: java.net.ConnectException: Connection timed out: connect at java.base/java.net.PlainSocketImpl.connect0(Native Method) at java.base/java.net.PlainSocketImpl.socketConnect(PlainSocketImpl.java:101) at java.base/java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:412) at java.base/java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:255) at java.base/java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:237) at java.base/java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392) at java.base/java.net.Socket.connect(Socket.java:609) at java.base/sun.security.ssl.SSLSocketImpl.connect(SSLSocketImpl.java:305) at java.base/sun.security.ssl.BaseSSLSocketImpl.connect(BaseSSLSocketImpl.java:173) at java.base/sun.net.NetworkClient.doConnect(NetworkClient.java:182) at java.base/sun.net.www.http.HttpClient.openServer(HttpClient.java:474) at java.base/sun.net.www.http.HttpClient.openServer(HttpClient.java:569) at java.base/sun.net.www.protocol.https.HttpsClient.(HttpsClient.java:266) at java.base/sun.net.www.protocol.https.HttpsClient.New(HttpsClient.java:373) at java.base/sun.net.www.protocol.https.AbstractDelegateHttpsURLConnection.getNewHttpClient(AbstractDelegateHttpsURLConnection.java:203) at java.base/sun.net.www.protocol.http.HttpURLConnection.plainConnect0(HttpURLConnection.java:1232) at java.base/sun.net.www.protocol.http.HttpURLConnection.plainConnect(HttpURLConnection.java:1081) at java.base/sun.net.www.protocol.https.AbstractDelegateHttpsURLConnection.connect(AbstractDelegateHttpsURLConnection.java:189) at java.base/sun.net.www.protocol.http.HttpURLConnection.getInputStream0(HttpURLConnection.java:1592) at java.base/sun.net.www.protocol.http.HttpURLConnection.getInputStream(HttpURLConnection.java:1520) at java.base/sun.net.www.protocol.http.HttpURLConnection.getHeaderFields(HttpURLConnection.java:3122) at java.base/sun.net.www.protocol.https.HttpsURLConnectionImpl.getHeaderFields(HttpsURLConnectionImpl.java:279) at io.cucumber.core.plugin.UrlOutputStream.getResponseBody(UrlOutputStream.java:124) ... 20 more

baskarcsb commented 2 years ago

is any one is facing this issue?...

wakaleo commented 2 years ago

Can you try with 3.3.2?

baskarcsb commented 1 year ago

The same connection time-out issue has appeared even with 3.3.4 latest version

wakaleo commented 1 year ago

I can't reproduce this.

baskarcsb commented 1 year ago

John, I can reproduce the issue by using the existing serenity cucumber skeleton project. Note: the same issue is not appearing in 3.1.15 version... and works well.

However when i upgraded the serenity version to 3.3.4 version then the below issue is appearing.

I took the Sample project from: serenity-cucumber-starter/pom.xml at master · serenity-bdd/serenity-cucumber-starter · GitHub https://github.com/serenity-bdd/serenity-cucumber-starter/blob/master/pom.xml

& Here is the complete console report for your reference.

Error: R:localhost/127.0.0.1:50877 http://127.0.0.1:50877] 06:52:54.867 [AsyncHttpClient-1-3] DEBUG org.asynchttpclient.netty.handler.HttpHandler - Unexpected I/O exception on channel [id: 0xb578678e, L:/127.0.0.1:50883 http://127.0.0.1:50883 - R:localhost/127.0.0.1:50877 http://127.0.0.1:50877] java.io.IOException: An existing connection was forcibly closed by the remote host

06:52:37.783 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:56939 : 1 06:52:38.601 [Forwarding findElement on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/element' 06:52:38.601 [Forwarding findElement on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/element' 06:52:38.612 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/element HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 58 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 88

06:52:38.612 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:38.616 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/execute/sync ' 06:52:38.616 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/execute/sync' 06:52:38.627 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/execute/sync HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 48780 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 14

06:52:38.627 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:38.631 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/execute/sync ' 06:52:38.632 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/execute/sync' 06:52:38.642 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/execute/sync HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 48780 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 14

06:52:38.642 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:38.645 [Forwarding executeScript on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/execute/sync ' 06:52:38.645 [Forwarding executeScript on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/execute/sync' 06:52:38.649 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/execute/sync HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 61 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 20

06:52:38.649 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:38.884 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:50877 : 1 06:52:38.884 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:56939 : 1 06:52:39.983 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:50877 : 1 06:52:39.983 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:56939 : 1 06:52:41.083 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:50877 : 1 06:52:41.083 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:56939 : 1 06:52:42.183 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:50877 : 1 06:52:42.183 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:56939 : 1 06:52:43.283 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:50877 : 1 06:52:43.283 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:56939 : 1 06:52:43.650 [Forwarding setTimeout on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/timeouts' 06:52:43.651 [Forwarding setTimeout on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/timeouts' 06:52:43.652 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/timeouts HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 22 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 14

06:52:43.652 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:43.656 [Forwarding findElement on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/element' 06:52:43.656 [Forwarding findElement on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/element' 06:52:43.663 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/element HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 58 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 88

06:52:43.664 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:43.667 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/execute/sync ' 06:52:43.667 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/execute/sync' 06:52:43.676 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/execute/sync HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 48780 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 14

06:52:43.676 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:43.680 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/execute/sync ' 06:52:43.680 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/execute/sync' 06:52:43.688 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/execute/sync HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 48780 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 14

06:52:43.689 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:43.692 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/execute/sync ' 06:52:43.692 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/execute/sync' 06:52:43.702 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/execute/sync HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 48780 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 14

06:52:43.702 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:43.704 [Forwarding setTimeout on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/timeouts' 06:52:43.704 [Forwarding setTimeout on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/timeouts' 06:52:43.705 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/timeouts HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 22 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 14

06:52:43.705 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:43.710 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/execute/sync ' 06:52:43.710 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/execute/sync' 06:52:43.718 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/execute/sync HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 48780 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 14

06:52:43.718 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:43.719 [Forwarding isElementEnabled on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'GET' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/element/ff35fde8-5cdb-438c-938a-f0a8de61bd64/enabled ' 06:52:43.720 [Forwarding isElementEnabled on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for GET '/session/9202230806878ec5c8d2f696f1621d23/element/ff35fde8-5cdb-438c-938a-f0a8de61bd64/enabled' 06:52:43.728 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultFullHttpRequest(decodeResult: success, version: HTTP/1.1, content: EmptyByteBufBE) GET /session/9202230806878ec5c8d2f696f1621d23/element/ff35fde8-5cdb-438c-938a-f0a8de61bd64/enabled HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Cache-Control: no-cache Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 14

06:52:43.728 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:43.731 [Forwarding actions on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/actions' 06:52:43.731 [Forwarding actions on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/actions' 06:52:43.844 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/actions HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 630 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 14

06:52:43.844 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:43.846 [Forwarding clearElement on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/element/ff35fde8-5cdb-438c-938a-f0a8de61bd64/clear ' 06:52:43.846 [Forwarding clearElement on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/element/ff35fde8-5cdb-438c-938a-f0a8de61bd64/clear' 06:52:43.874 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/element/ff35fde8-5cdb-438c-938a-f0a8de61bd64/clear HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 50 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 14

06:52:43.874 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:43.876 [Forwarding sendKeysToElement on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/element/ff35fde8-5cdb-438c-938a-f0a8de61bd64/value ' 06:52:43.876 [Forwarding sendKeysToElement on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/element/ff35fde8-5cdb-438c-938a-f0a8de61bd64/value' 06:52:43.899 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/element/ff35fde8-5cdb-438c-938a-f0a8de61bd64/value HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 161 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 14

06:52:43.899 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:43.902 [Forwarding sendKeysToElement on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/element/ff35fde8-5cdb-438c-938a-f0a8de61bd64/value ' 06:52:43.902 [Forwarding sendKeysToElement on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/element/ff35fde8-5cdb-438c-938a-f0a8de61bd64/value' 06:52:43.916 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/element/ff35fde8-5cdb-438c-938a-f0a8de61bd64/value HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 95 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 14

06:52:43.917 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:43.919 [Forwarding sendKeysToElement on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/element/ff35fde8-5cdb-438c-938a-f0a8de61bd64/value ' 06:52:43.919 [Forwarding sendKeysToElement on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/element/ff35fde8-5cdb-438c-938a-f0a8de61bd64/value' 06:52:43.937 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/element/ff35fde8-5cdb-438c-938a-f0a8de61bd64/value HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 95 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 14

06:52:43.938 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:43.940 [Forwarding executeScript on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/execute/sync ' 06:52:43.940 [Forwarding executeScript on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/execute/sync' 06:52:43.943 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/execute/sync HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 61 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 20

06:52:43.943 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:44.382 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:50877 : 1 06:52:44.382 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:56939 : 1 06:52:45.483 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:50877 : 1 06:52:45.483 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:56939 : 1 06:52:46.583 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:50877 : 1 06:52:46.583 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:56939 : 1 06:52:47.683 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:50877 : 1 06:52:47.683 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:56939 : 1 06:52:48.782 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:50877 : 1 06:52:48.782 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:56939 : 1 06:52:48.947 [Forwarding findElement on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/element' 06:52:48.947 [Forwarding findElement on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/element' 06:52:48.957 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/element HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 57 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 88

06:52:48.957 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:48.961 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/execute/sync ' 06:52:48.961 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/execute/sync' 06:52:48.971 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/execute/sync HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 48780 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 14

06:52:48.971 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:48.975 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/execute/sync ' 06:52:48.975 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/execute/sync' 06:52:48.982 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/execute/sync HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 48780 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 14

06:52:48.982 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:48.986 [Forwarding findElement on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/element' 06:52:48.986 [Forwarding findElement on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/element' 06:52:48.991 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/element HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 57 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 88

06:52:48.992 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:48.995 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/execute/sync ' 06:52:48.995 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/execute/sync' 06:52:49.004 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/execute/sync HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 48780 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 14

06:52:49.004 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:49.007 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/execute/sync ' 06:52:49.008 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/execute/sync' 06:52:49.016 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/execute/sync HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 48780 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 14

06:52:49.016 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:49.017 [Forwarding isElementEnabled on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'GET' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/element/159919a7-5896-48b5-8319-f4949a8598b9/enabled ' 06:52:49.017 [Forwarding isElementEnabled on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for GET '/session/9202230806878ec5c8d2f696f1621d23/element/159919a7-5896-48b5-8319-f4949a8598b9/enabled' 06:52:49.024 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultFullHttpRequest(decodeResult: success, version: HTTP/1.1, content: EmptyByteBufBE) GET /session/9202230806878ec5c8d2f696f1621d23/element/159919a7-5896-48b5-8319-f4949a8598b9/enabled HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Cache-Control: no-cache Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 14

06:52:49.024 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:49.027 [Forwarding actions on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/actions' 06:52:49.027 [Forwarding actions on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/actions' 06:52:49.247 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/actions HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 630 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 14

06:52:49.247 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:49.251 [Forwarding findElement on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/element' 06:52:49.251 [Forwarding findElement on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/element' 06:52:49.412 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/element HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 54 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 88

06:52:49.412 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:49.416 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/execute/sync ' 06:52:49.416 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/execute/sync' 06:52:49.518 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/execute/sync HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 48780 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 14

06:52:49.519 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:49.524 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/execute/sync ' 06:52:49.524 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/execute/sync' 06:52:49.542 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/execute/sync HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 48780 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 14

06:52:49.543 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:49.546 [Forwarding findElement on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/element' 06:52:49.546 [Forwarding findElement on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/element' 06:52:49.553 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/element HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 54 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 88

06:52:49.553 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:49.557 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/execute/sync ' 06:52:49.557 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/execute/sync' 06:52:49.566 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/execute/sync HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 48780 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 14

06:52:49.566 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:49.570 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/execute/sync ' 06:52:49.570 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/execute/sync' 06:52:49.579 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/execute/sync HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 48780 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 14

06:52:49.579 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:49.591 [main] DEBUG net.thucydides.core.steps.StepInterceptor - STEP DONE: launchCpolApplication 06:52:49.594 [main] DEBUG net.thucydides.core.steps.StepInterceptor - STARTING STEP: LoginSteps.givenIamonthehomepage - thisTestExecutedUrlIs 06:52:49.595 [main] DEBUG net.thucydides.core.steps.StepInterceptor - STEP DONE: thisTestExecutedUrlIs 06:52:49.597 [main] DEBUG net.thucydides.core.steps.StepInterceptor - STARTING STEP: LoginSteps.givenIamonthehomepage - isUserLoggedIn 06:52:49.600 [Forwarding findElement on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/element' 06:52:49.600 [Forwarding findElement on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/element' 06:52:49.612 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/element HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 69 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 88

06:52:49.612 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:49.616 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/execute/sync ' 06:52:49.616 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/execute/sync' 06:52:49.625 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/execute/sync HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 48780 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 14

06:52:49.626 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:49.630 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/execute/sync ' 06:52:49.630 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/execute/sync' 06:52:49.639 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/execute/sync HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 48780 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 14

06:52:49.639 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:49.642 [Forwarding findElement on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/element' 06:52:49.642 [Forwarding findElement on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/element' 06:52:49.648 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/element HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 69 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 88

06:52:49.649 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:49.652 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/execute/sync ' 06:52:49.652 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/execute/sync' 06:52:49.661 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/execute/sync HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 48780 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 14

06:52:49.661 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:49.662 [Forwarding getElementText on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'GET' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/element/da49e6e7-e429-4ae3-9f00-cd772e081830/text ' 06:52:49.662 [Forwarding getElementText on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for GET '/session/9202230806878ec5c8d2f696f1621d23/element/da49e6e7-e429-4ae3-9f00-cd772e081830/text' 06:52:49.674 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultFullHttpRequest(decodeResult: success, version: HTTP/1.1, content: EmptyByteBufBE) GET /session/9202230806878ec5c8d2f696f1621d23/element/da49e6e7-e429-4ae3-9f00-cd772e081830/text HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Cache-Control: no-cache Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 16

06:52:49.674 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:49.676 [main] DEBUG net.thucydides.core.steps.StepInterceptor - STEP DONE: isUserLoggedIn Given I am on the CPOL Home page # com.cpol.bdd.steps.LoginSteps.givenIamonthehomepage() 06:52:49.690 [main] DEBUG net.thucydides.core.steps.StepInterceptor - STARTING STEP: LoginSteps.verifyUserLoggedIntoCpolApplicaiton - verifyUserLoggedIntoCpolApplication 06:52:49.691 [Forwarding executeScript on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/execute/sync ' 06:52:49.691 [Forwarding executeScript on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/execute/sync' 06:52:49.696 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/execute/sync HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 61 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 20

06:52:49.696 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:49.882 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:50877 : 1 06:52:49.882 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:56939 : 1 06:52:50.982 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:50877 : 1 06:52:50.982 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:56939 : 1 06:52:52.082 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:50877 : 1 06:52:52.082 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:56939 : 1 06:52:53.183 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:50877 : 1 06:52:53.183 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:56939 : 1 06:52:54.282 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:50877 : 1 06:52:54.282 [AsyncHttpClient-1-1] DEBUG org.asynchttpclient.netty.channel.DefaultChannelPool - Entry count for : http://localhost:56939 : 1 06:52:54.699 [Forwarding findElement on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/element' 06:52:54.699 [Forwarding findElement on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/element' 06:52:54.708 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/element HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 69 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 88

06:52:54.708 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:54.712 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/execute/sync ' 06:52:54.712 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/execute/sync' 06:52:54.721 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/execute/sync HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 48780 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpResponse(decodeResult: success, version: HTTP/1.1) HTTP/1.1 200 OK Content-Type: application/json; charset=utf-8 cache-control: no-cache content-length: 14

06:52:54.721 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.channel.ChannelManager - Adding key: http://localhost:56939 for channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] 06:52:54.725 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using pooled Channel '[id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939]' for 'POST' to ' http://localhost:56939/session/9202230806878ec5c8d2f696f1621d23/execute/sync ' 06:52:54.725 [Forwarding isElementDisplayed on session 9202230806878ec5c8d2f696f1621d23 to remote] DEBUG org.asynchttpclient.netty.request.NettyRequestSender - Using open Channel [id: 0xcb966f4b, L:/127.0.0.1:50876 - R:localhost/127.0.0.1:56939] for POST '/session/9202230806878ec5c8d2f696f1621d23/execute/sync' 06:52:54.734 [AsyncHttpClient-1-2] DEBUG org.asynchttpclient.netty.handler.HttpHandler -

Request DefaultHttpRequest(decodeResult: success, version: HTTP/1.1) POST /session/9202230806878ec5c8d2f696f1621d23/execute/sync HTTP/1.1 User-Agent: selenium/4.4.0 (java windows) Content-Length: 48780 Content-Type: application/json; charset=utf-8 host: localhost:56939 accept: /

Response DefaultHttpRespon

baskarcsb commented 1 year ago

Hi John, I have tried with the 3.3.2 version but still I am seeing this issue. - see the below error messages for your reference.

java.lang.RuntimeException: java.net.ConnectException: Connection timed out: connect at io.cucumber.core.plugin.MessageFormatter.writeMessage(MessageFormatter.java:32) at io.cucumber.core.eventbus.AbstractEventPublisher.send(AbstractEventPublisher.java:51) at io.cucumber.core.eventbus.AbstractEventBus.send(AbstractEventBus.java:12) at io.cucumber.core.runtime.SynchronizedEventBus.send(SynchronizedEventBus.java:47) at io.cucumber.core.runtime.CucumberExecutionContext.emitTestRunFinished(CucumberExecutionContext.java:117) at io.cucumber.core.runtime.CucumberExecutionContext.finishTestRun(CucumberExecutionContext.java:98) at io.cucumber.junit.CucumberSerenityRunner$RunCucumber.evaluate(CucumberSerenityRunner.java:291) at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306) at org.junit.runners.ParentRunner.run(ParentRunner.java:413) at org.eclipse.jdt.internal.junit4.runner.JUnit4TestReference.run(JUnit4TestReference.java:93) at org.eclipse.jdt.internal.junit.runner.TestExecution.run(TestExecution.java:40) at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:529) at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:756) at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.run(RemoteTestRunner.java:452) at org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.main(RemoteTestRunner.java:210) Caused by: java.net.ConnectException: Connection timed out: connect at java.base/jdk.internal.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at java.base/jdk.internal.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.base/java.lang.reflect.Constructor.newInstance(Constructor.java:490) at java.base/sun.net.www.protocol.http.HttpURLConnection$10.run(HttpURLConnection.java:1974) at java.base/sun.net.www.protocol.http.HttpURLConnection$10.run(HttpURLConnection.java:1969) at java.base/java.security.AccessController.doPrivileged(Native Method) at java.base/sun.net.www.protocol.http.HttpURLConnection.getChainedException(HttpURLConnection.java:1968) at java.base/sun.net.www.protocol.http.HttpURLConnection.getInputStream0(HttpURLConnection.java:1536) at java.base/sun.net.www.protocol.http.HttpURLConnection.getInputStream(HttpURLConnection.java:1520) at java.base/java.net.HttpURLConnection.getResponseCode(HttpURLConnection.java:527) at java.base/sun.net.www.protocol.https.HttpsURLConnectionImpl.getResponseCode(HttpsURLConnectionImpl.java:334) at io.cucumber.core.plugin.UrlOutputStream.getResponseBody(UrlOutputStream.java:125) at io.cucumber.core.plugin.UrlOutputStream.sendRequest(UrlOutputStream.java:87) at io.cucumber.core.plugin.UrlOutputStream.close(UrlOutputStream.java:65) at java.base/sun.nio.cs.StreamEncoder.implClose(StreamEncoder.java:341) at java.base/sun.nio.cs.StreamEncoder.close(StreamEncoder.java:161) at java.base/java.io.OutputStreamWriter.close(OutputStreamWriter.java:255) at io.cucumber.core.plugin.MessageFormatter.writeMessage(MessageFormatter.java:29) ... 14 more Caused by: java.net.ConnectException: Connection timed out: connect at java.base/java.net.PlainSocketImpl.connect0(Native Method) at java.base/java.net.PlainSocketImpl.socketConnect(PlainSocketImpl.java:101) at java.base/java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:412) at java.base/java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:255) at java.base/java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:237) at java.base/java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392) at java.base/java.net.Socket.connect(Socket.java:609) at java.base/sun.security.ssl.SSLSocketImpl.connect(SSLSocketImpl.java:305) at java.base/sun.security.ssl.BaseSSLSocketImpl.connect(BaseSSLSocketImpl.java:173) at java.base/sun.net.NetworkClient.doConnect(NetworkClient.java:182) at java.base/sun.net.www.http.HttpClient.openServer(HttpClient.java:508) at java.base/sun.net.www.http.HttpClient.openServer(HttpClient.java:603) at java.base/sun.net.www.protocol.https.HttpsClient.(HttpsClient.java:266) at java.base/sun.net.www.protocol.https.HttpsClient.New(HttpsClient.java:373) at java.base/sun.net.www.protocol.https.AbstractDelegateHttpsURLConnection.getNewHttpClient(AbstractDelegateHttpsURLConnection.java:207) at java.base/sun.net.www.protocol.http.HttpURLConnection.plainConnect0(HttpURLConnection.java:1232) at java.base/sun.net.www.protocol.http.HttpURLConnection.plainConnect(HttpURLConnection.java:1081) at java.base/sun.net.www.protocol.https.AbstractDelegateHttpsURLConnection.connect(AbstractDelegateHttpsURLConnection.java:193) at java.base/sun.net.www.protocol.http.HttpURLConnection.getInputStream0(HttpURLConnection.java:1592) at java.base/sun.net.www.protocol.http.HttpURLConnection.getInputStream(HttpURLConnection.java:1520) at java.base/sun.net.www.protocol.http.HttpURLConnection.getHeaderFields(HttpURLConnection.java:3137) at java.base/sun.net.www.protocol.https.HttpsURLConnectionImpl.getHeaderFields(HttpsURLConnectionImpl.java:279) at io.cucumber.core.plugin.UrlOutputStream.getResponseBody(UrlOutputStream.java:124) ... 20 more

On Wed, Aug 31, 2022 at 12:16 PM John Ferguson Smart < @.***> wrote:

Can you try with 3.3.2?

— Reply to this email directly, view it on GitHub https://github.com/serenity-bdd/serenity-cucumber-starter/issues/87#issuecomment-1232529738, or unsubscribe https://github.com/notifications/unsubscribe-auth/ACMENGF3QKF3SL5LVHWQO4DV335TRANCNFSM56EOPDYA . You are receiving this because you authored the thread.Message ID: @.***>

wakaleo commented 1 year ago

Are you sure it is related to Serenity? It looks like Cucumber code

baskarcsb commented 1 year ago

Hi John, now I have tested with the new serenity version 3.4.1.

Resolved No connection time-out issue occurs. - Resolved

Found New observation: Serenity is taking at least 4 -5 minutes to aggregate the serenity report. After the GWT test execution is completed....

Note: This issue is not found in 3.1.15 versions.

wakaleo commented 1 year ago

Thanks for the update. I haven't seen any particular performance issues on the recent versions, but the reports are more comprehensive. Can you provide a sample project that displays this behaviour?

baskarcsb commented 1 year ago

Thank you, John, I am in the process of creating a sample project and I will let you know once it was ready....

Before that, I would like the share, the issue reproducible steps that I found in 3.4.1 version.

Issue Reproducible steps: Test 1 - No issues Test 2 - Found performance issues

Tested on Serenity Version: 3.4.1

Test 1: Test Description: Test Load and generates the aggregated report faster -> when a project contains 1 or 2 or few scenarios

Result: No issues and I haven't seen any particular performance issues

Eg: Feature -> Login Folder contains only 2 scenario's

Final Result: It ran faster and aggregated the report faster.

===========================================================================

Test 2:

Test Description: when a project contains More feature folders + 1000's of scenario's - > Then I have noticed the below odd behavior....

Test Precondition: Project should contain More feature folders + 1000's of scenario's - see the example below

Step 1: I ran a single scenario test via maven (only a single test scenario).

Step 2: When the test starts via maven it takes close to 1 or 2 minutes to start the execution. (Note: I didn't see this behavior in 3.1.15 version) .

Note: I am Assuming that it is loading all the feature scenarios before it executes the above scenario.

Step 3: Started Execution for the above scenario -> i don't see any performance issues with GWT execution (this is fast as expected) - No issues

Step 4: and finally, at the end of test it takes additional 3-4 minutes for generating and aggregating the final report I am Assuming that it is loading all the feature scenarios before it aggregate the test -> (i am guessing.. this is taking longer than the usual)

To replicate the above issue. we need the below following setup:

Test feature contains many features folder and 1000+ scenario's -- see the example below

eg: Feature -> Login Folder contains -> 30 scenario's Feature -> Login1 Folder contains -> 30 scenario's Feature -> Login2 Folder contains -> 30 scenario's Feature -> Login3 Folder contains -> 30 scenario's Feature -> Login4 Folder contains -> 30 scenario's Feature -> Login5 Folder contains -> 30 scenario's Feature -> Login6 Folder contains -> 30 scenario's Feature -> Login7 Folder contains -> 30 scenario's Feature -> Login8 Folder contains -> 30 scenario's Feature -> Login9 Folder contains -> 30 scenario's Feature -> Login10 Folder contains -> 30 scenario's Feature -> Login11 Folder contains -> 30 scenario's Feature -> Login12 Folder contains -> 30 scenario's Feature -> Login13 Folder contains -> 30 scenario's Feature -> Login14 Folder contains -> 30 scenario's Feature -> Login15 Folder contains -> 30 scenario's Feature -> Login16 Folder contains -> 30 scenario's Feature -> Login17 Folder contains -> 30 scenario's Feature -> Login18 Folder contains -> 30 scenario's Feature -> Login19 Folder contains -> 30 scenario's Feature -> Login20 Folder contains -> 30 scenario's Feature -> Login21 Folder contains -> 30 scenario's Feature -> Login22 Folder contains -> 30 scenario's Feature -> Login23 Folder contains -> 30 scenario's Feature -> Login24 Folder contains -> 30 scenario's Feature -> Login25 Folder contains -> 30 scenario's Feature -> Login26 Folder contains -> 30 scenario's Feature -> Login27 Folder contains -> 30 scenario's Feature -> Login28 Folder contains -> 30 scenario's Feature -> Login29 Folder contains -> 30 scenario's Feature -> Login30 Folder contains -> 30 scenario's Feature -> Login31 Folder contains -> 30 scenario's Feature -> Login32 Folder contains -> 30 scenario's Feature -> Login33 Folder contains -> 30 scenario's