Comments (10)
@sudha1218, thank you for creating this issue. We will troubleshoot it as soon as we can.
Info for maintainers
Triage this issue by using labels.
If information is missing, add a helpful comment and then I-issue-template
label.
If the issue is a question, add the I-question
label.
If the issue is valid but there is no time to troubleshoot it, consider adding the help wanted
label.
If the issue requires changes or fixes from an external project (e.g., ChromeDriver, GeckoDriver, MSEdgeDriver, W3C),
add the applicable G-*
label, and it will provide the correct link and auto-close the
issue.
After troubleshooting the issue, please add the R-awaiting answer
label.
Thank you!
from selenium.
POM File
from selenium.
You might want to ensure that your dependencies are all sorted out first following the steps that I detailed in #13800 (comment)
Once that is done and if the issue persists, please turn on logging as described here and share the logs
from selenium.
Here are the logs for driver.get("URL").
Apr 12, 2024 10:27:30 AM org.openqa.selenium.remote.RemoteWebDriver log
FINE: Executing: get [f06a5c9db2e5c84487d9d0f7cef4105e, get {url=htpps://weatherstack.com}]
Apr 12, 2024 10:27:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient execute0
FINE: Executing request: (POST) /session/f06a5c9db2e5c84487d9d0f7cef4105e/url
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Exchange establishExchange
FINE: [JdkHttpClient-0-0] [9s 250ms] Exchange establishing exchange for http://localhost:43971/session/f06a5c9db2e5c84487d9d0f7cef4105e/url POST,
proxy=null
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Exchange checkFor407
FINE: [JdkHttpClient-0-0] [9s 250ms] Exchange checkFor407: all clear
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Exchange sendHeadersAsync
FINE: [JdkHttpClient-0-0] [9s 251ms] Http1Exchange Sending headers only
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1AsyncReceiver subscribe
FINE: [JdkHttpClient-0-0] [9s 252ms] Http1AsyncReceiver(SocketTube(1)) Subscribed pending jdk.internal.net.http.Http1Response$HeadersReader@469852c0 queue.isEmpty: true
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1AsyncReceiver handlePendingDelegate
FINE: [JdkHttpClient-0-0] [9s 256ms] Http1AsyncReceiver(SocketTube(1)) delegate is now jdk.internal.net.http.Http1Response$HeadersReader@469852c0, demand=1, canRequestMore=true, queue.isEmpty=true
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1AsyncReceiver hasDemand
FINE: [JdkHttpClient-0-0] [9s 256ms] Http1AsyncReceiver(SocketTube(1)) downstream subscription demand is 1
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1AsyncReceiver checkRequestMore
FINE: [JdkHttpClient-0-0] [9s 260ms] Http1AsyncReceiver(SocketTube(1)) checkRequestMore: canRequestMore=true, hasDemand=true
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1AsyncReceiver hasDemand
FINE: [JdkHttpClient-0-0] [9s 261ms] Http1AsyncReceiver(SocketTube(1)) downstream subscription demand is 1
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1AsyncReceiver checkRequestMore
FINE: [JdkHttpClient-0-0] [9s 261ms] Http1AsyncReceiver(SocketTube(1)) checkRequestMore: canRequestMore=true, hasDemand=true
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Exchange sendHeadersAsync
FINE: [JdkHttpClient-0-0] [9s 262ms] Http1Exchange response created in advance
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Exchange connectFlows
FINE: [JdkHttpClient-0-0] [9s 263ms] Http1Exchange SocketTube(1) connecting flows
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe
FINE: [HttpClient-1-SelectorManager] [9s 264ms] Http1AsyncReceiver(SocketTube(1)) Received onSubscribed from upstream
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher subscribe
FINE: [JdkHttpClient-0-0] [9s 264ms] Http1Publisher(SocketTube(1)) got subscriber: SocketTube(1)
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1AsyncReceiver hasDemand
FINE: [JdkHttpClient-0-1] [9s 264ms] Http1AsyncReceiver(SocketTube(1)) downstream subscription demand is 1
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Exchange lambda$sendHeadersAsync$4
FINE: [JdkHttpClient-0-0] [9s 265ms] Http1Exchange requestAction.headers
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$Http1WriteSubscription request
FINE: [JdkHttpClient-0-2] [9s 265ms] Http1Publisher(SocketTube(1)) subscription request(1), demand=1
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Exchange lambda$sendHeadersAsync$4
FINE: [JdkHttpClient-0-0] [9s 266ms] Http1Exchange setting outgoing with headers
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1AsyncReceiver checkRequestMore
FINE: [JdkHttpClient-0-1] [9s 265ms] Http1AsyncReceiver(SocketTube(1)) checkRequestMore: canRequestMore=true, hasDemand=true
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber requestMore
FINE: [JdkHttpClient-0-1] [9s 267ms] Http1AsyncReceiver(SocketTube(1)) Http1TubeSubscriber: requesting one more from upstream
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$WriteTask run
FINE: [JdkHttpClient-0-2] [9s 266ms] Http1Publisher(SocketTube(1)) WriteTask
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Exchange appendToOutgoing
FINE: [JdkHttpClient-0-0] [9s 267ms] Http1Exchange appending to outgoing DataPair [data=[java.nio.HeapByteBuffer[pos=0 lim=306 cap=306]], throwable=null]
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$WriteTask run
FINE: [JdkHttpClient-0-2] [9s 268ms] Http1Publisher(SocketTube(1)) hasOutgoing = true
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Exchange getOutgoing
FINE: [JdkHttpClient-0-2] [9s 268ms] Http1Exchange initiating completion of headersSentCF
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Exchange checkFor407
FINE: [JdkHttpClient-0-2] [9s 269ms] Exchange checkFor407: all clear
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Exchange sendRequestBody
FINE: [JdkHttpClient-0-2] [9s 269ms] Exchange sendRequestBody
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Exchange sendBodyAsync
FINE: [JdkHttpClient-0-2] [9s 269ms] Http1Exchange sendBodyAsync
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Exchange sendBodyAsync
FINE: [JdkHttpClient-0-2] [9s 270ms] Http1Exchange bodySubscriber is class jdk.internal.net.http.Http1Request$FixedContentSubscriber
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Exchange requestMoreBody
FINE: [JdkHttpClient-0-2] [9s 270ms] Http1Exchange requesting more request body from the subscriber
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Exchange$Http1BodySubscriber request
FINE: [JdkHttpClient-0-2] [9s 270ms] jdk.internal.net.http.Http1Request@2f966998 Http1BodySubscriber requesting 1, from jdk.internal.net.http.PullPublisher$Subscription@2ba9e835
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Request$FixedContentSubscriber onNext
FINE: [JdkHttpClient-0-2] [9s 270ms] jdk.internal.net.http.Http1Request@2f966998 onNext
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Exchange appendToOutgoing
FINE: [JdkHttpClient-0-2] [9s 271ms] Http1Exchange appending to outgoing DataPair [data=[java.nio.HeapByteBuffer[pos=0 lim=49 cap=16384]], throwable=null]
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Request$FixedContentSubscriber onComplete
FINE: [JdkHttpClient-0-2] [9s 271ms] jdk.internal.net.http.Http1Request@2f966998 onComplete
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Exchange appendToOutgoing
FINE: [JdkHttpClient-0-2] [9s 271ms] Http1Exchange appending to outgoing DataPair [data=[java.nio.HeapByteBuffer[pos=0 lim=0 cap=0]], throwable=null]
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$WriteTask run
FINE: [JdkHttpClient-0-2] [9s 272ms] Http1Publisher(SocketTube(1)) onNext with 306 bytes
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$Http1WriteSubscription request
FINE: [JdkHttpClient-0-2] [9s 273ms] Http1Publisher(SocketTube(1)) subscription request(1), demand=1
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Exchange requestMoreBody
FINE: [JdkHttpClient-0-2] [9s 273ms] Http1Exchange requesting more request body from the subscriber
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Exchange$Http1BodySubscriber request
FINE: [JdkHttpClient-0-2] [9s 274ms] jdk.internal.net.http.Http1Request@2f966998 Http1BodySubscriber requesting 1, from jdk.internal.net.http.PullPublisher$Subscription@2ba9e835
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$WriteTask run
FINE: [JdkHttpClient-0-2] [9s 274ms] Http1Publisher(SocketTube(1)) onNext with 49 bytes
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$Http1WriteSubscription request
FINE: [JdkHttpClient-0-2] [9s 274ms] Http1Publisher(SocketTube(1)) subscription request(1), demand=1
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Exchange getOutgoing
FINE: [JdkHttpClient-0-2] [9s 275ms] Http1Exchange initiating completion of bodySentCF
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.common.Utils lambda$wrapForDebug$9
FINE: [JdkHttpClient-0-2] [9s 275ms] Http1Exchange sendBodyAsync completed successfully
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Exchange getResponseAsync
FINE: [JdkHttpClient-0-2] [9s 275ms] Http1Exchange reading headers
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Response readHeadersAsync
FINE: [JdkHttpClient-0-2] [9s 281ms] Http1Response(id=4, PlainHttpConnection(SocketTube(1))) Reading Headers: (remaining: 0) READING_HEADERS
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Response readHeadersAsync
FINE: [JdkHttpClient-0-2] [9s 282ms] Http1Response(id=4, PlainHttpConnection(SocketTube(1))) First time around
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Response readHeadersAsync
FINE: [JdkHttpClient-0-2] [9s 282ms] Http1Response(id=4, PlainHttpConnection(SocketTube(1))) headersReader is not yet completed
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$WriteTask run
FINE: [JdkHttpClient-0-2] [9s 283ms] Http1Publisher(SocketTube(1)) completed, stopping jdk.internal.net.http.common.SequentialScheduler@4b753f0a
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1AsyncReceiver asyncReceive
FINE: [HttpClient-1-SelectorManager] [9s 294ms] Http1AsyncReceiver(SocketTube(1)) Putting 122 bytes into the queue
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-2] [9s 294ms] Http1AsyncReceiver(SocketTube(1)) Got 122 bytes for delegate jdk.internal.net.http.Http1Response$HeadersReader@469852c0
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1AsyncReceiver hasDemand
FINE: [JdkHttpClient-0-2] [9s 295ms] Http1AsyncReceiver(SocketTube(1)) downstream subscription demand is 1
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-2] [9s 296ms] Http1AsyncReceiver(SocketTube(1)) Forwarding 122 bytes to delegate jdk.internal.net.http.Http1Response$HeadersReader@469852c0
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Response$HeadersReader handle
FINE: [JdkHttpClient-0-2] [9s 300ms] Http1Response(id=4, PlainHttpConnection(SocketTube(1))) Sending 122/122 bytes to header parser
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Response$HeadersReader handle
FINE: [JdkHttpClient-0-2] [9s 301ms] Http1Response(id=4, PlainHttpConnection(SocketTube(1))) Parsing headers completed. bytes=108
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1AsyncReceiver unsubscribe
FINE: [JdkHttpClient-0-2] [9s 302ms] Http1AsyncReceiver(SocketTube(1)) Unsubscribed jdk.internal.net.http.Http1Response$HeadersReader@469852c0
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Response lambda$readHeadersAsync$0
FINE: [JdkHttpClient-0-2] [9s 302ms] Http1Response(id=4, PlainHttpConnection(SocketTube(1))) Reading Headers: creating Response object; state is now READING_BODY
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.common.Utils lambda$wrapForDebug$9
FINE: [JdkHttpClient-0-2] [9s 302ms] Http1Exchange getResponseAsync completed successfully
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Response readBody
FINE: [JdkHttpClient-0-2] [9s 303ms] Http1Response(id=4, PlainHttpConnection(SocketTube(1))) readBody: return2Cache: true
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Response$ClientRefCountTracker acquire
FINE: [JdkHttpClient-0-2] [9s 305ms] Http1Response(id=4, PlainHttpConnection(SocketTube(1))) Operation started: incrementing ref count for jdk.internal.net.http.HttpClientImpl@6256fa94(1)
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1AsyncReceiver subscribe
FINE: [JdkHttpClient-0-2] [9s 306ms] Http1AsyncReceiver(SocketTube(1)) Subscribed pending jdk.internal.net.http.Http1Response$BodyReader@4f766255/parser=jdk.internal.net.http.ResponseContent$FixedLengthBodyParser@248ffec6 queue.isEmpty: false
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-2] [9s 313ms] Http1AsyncReceiver(SocketTube(1)) Delegate done: 14
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.ResponseContent$FixedLengthBodyParser onSubscribe
FINE: [JdkHttpClient-0-2] [9s 314ms] PlainHttpConnection(SocketTube(1))/ResponseContent/FixedLengthBodyParser length=14, onSubscribe: jdk.internal.net.http.Http1Response$Http1BodySubscriber
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1AsyncReceiver handlePendingDelegate
FINE: [JdkHttpClient-0-2] [9s 315ms] Http1AsyncReceiver(SocketTube(1)) delegate is now jdk.internal.net.http.Http1Response$BodyReader@4f766255/parser=jdk.internal.net.http.ResponseContent$FixedLengthBodyParser@248ffec6, demand=9223372036854775807, canRequestMore=false, queue.isEmpty=false
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-2] [9s 316ms] Http1AsyncReceiver(SocketTube(1)) Got 14 bytes for delegate jdk.internal.net.http.Http1Response$BodyReader@4f766255/parser=jdk.internal.net.http.ResponseContent$FixedLengthBodyParser@248ffec6
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1AsyncReceiver hasDemand
FINE: [JdkHttpClient-0-2] [9s 316ms] Http1AsyncReceiver(SocketTube(1)) downstream subscription demand is 9223372036854775807
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-2] [9s 316ms] Http1AsyncReceiver(SocketTube(1)) Forwarding 14 bytes to delegate jdk.internal.net.http.Http1Response$BodyReader@4f766255/parser=jdk.internal.net.http.ResponseContent$FixedLengthBodyParser@248ffec6
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Response$BodyReader handle
FINE: [JdkHttpClient-0-2] [9s 317ms] Http1Response(id=4, PlainHttpConnection(SocketTube(1))) Sending 14/122 bytes to body parser
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.ResponseContent$FixedLengthBodyParser accept
FINE: [JdkHttpClient-0-2] [9s 317ms] PlainHttpConnection(SocketTube(1))/ResponseContent/FixedLengthBodyParser Parser got 14 bytes (14 remaining / 14)
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.ResponseContent$FixedLengthBodyParser accept
FINE: [JdkHttpClient-0-2] [9s 317ms] PlainHttpConnection(SocketTube(1))/ResponseContent/FixedLengthBodyParser Parser got all expected bytes: completing
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1AsyncReceiver clear
FINE: [JdkHttpClient-0-2] [9s 318ms] Http1AsyncReceiver(SocketTube(1)) cleared
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Response onFinished
FINE: [JdkHttpClient-0-2] [9s 319ms] Http1Response(id=4, PlainHttpConnection(SocketTube(1))) SocketTube(1): return to HTTP/1.1 pool
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber dropSubscription
FINE: [HttpClient-1-SelectorManager] [9s 319ms] Http1AsyncReceiver(SocketTube(1)) Http1TubeSubscriber: dropSubscription
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Response lambda$readBody$2
FINE: [JdkHttpClient-0-2] [9s 319ms] Http1Response(id=4, PlainHttpConnection(SocketTube(1))) Finished reading body: READING_BODY
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1Response$ClientRefCountTracker tryRelease
FINE: [JdkHttpClient-0-2] [9s 320ms] Http1Response(id=4, PlainHttpConnection(SocketTube(1))) Operation finished: decrementing ref count for jdk.internal.net.http.HttpClientImpl@6256fa94(1)
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-2] [9s 320ms] Http1AsyncReceiver(SocketTube(1)) Delegate done: 0
Apr 12, 2024 10:27:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-2] [9s 320ms] Http1AsyncReceiver(SocketTube(1)) Got 0 bytes for delegate null
Apr 12, 2024 10:27:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient execute0
FINE: Ending request (POST) /session/f06a5c9db2e5c84487d9d0f7cef4105e/url in 82ms
Apr 12, 2024 10:27:31 AM org.openqa.selenium.remote.RemoteWebDriver log
FINE: Executed: get (Response: SessionID: f06a5c9db2e5c84487d9d0f7cef4105e, State: success, Value: null)
from selenium.
@sudha1218 - I don't see any errors in the logs. Are you NOT seeing a browser spin off and open the website ?
What happens when you do System.out.println(driver.getTitle());
?
from selenium.
Yes, I am not seeing the browser spin. driver.getTitle() -> null (empty).
from selenium.
I noticed that in #13807 (comment) you mentioned the logs for get() alone.
Can you share the complete logs from the start of the test to the point wherein you close the browser ?
from selenium.
@krmahadevan Please have a look
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.RemoteWebDriver log
FINE: Executing: get [3af0cf27f54127ae63a7501a9cf3044e, get {url=htpps://weatherstack.com}]
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient execute0
FINE: Executing request: (POST) /session/3af0cf27f54127ae63a7501a9cf3044e/url
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Exchange establishExchange
FINE: [JdkHttpClient-0-1] [1s 246ms] Exchange establishing exchange for http://localhost:42830/session/3af0cf27f54127ae63a7501a9cf3044e/url POST,
proxy=null
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Exchange checkFor407
FINE: [JdkHttpClient-0-1] [1s 246ms] Exchange checkFor407: all clear
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange sendHeadersAsync
FINE: [JdkHttpClient-0-1] [1s 247ms] Http1Exchange Sending headers only
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver subscribe
FINE: [JdkHttpClient-0-1] [1s 247ms] Http1AsyncReceiver(SocketTube(1)) Subscribed pending jdk.internal.net.http.Http1Response$HeadersReader@70194713 queue.isEmpty: true
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver handlePendingDelegate
FINE: [JdkHttpClient-0-1] [1s 251ms] Http1AsyncReceiver(SocketTube(1)) delegate is now jdk.internal.net.http.Http1Response$HeadersReader@70194713, demand=1, canRequestMore=true, queue.isEmpty=true
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver hasDemand
FINE: [JdkHttpClient-0-1] [1s 251ms] Http1AsyncReceiver(SocketTube(1)) downstream subscription demand is 1
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver checkRequestMore
FINE: [JdkHttpClient-0-1] [1s 254ms] Http1AsyncReceiver(SocketTube(1)) checkRequestMore: canRequestMore=true, hasDemand=true
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver hasDemand
FINE: [JdkHttpClient-0-1] [1s 255ms] Http1AsyncReceiver(SocketTube(1)) downstream subscription demand is 1
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver checkRequestMore
FINE: [JdkHttpClient-0-1] [1s 255ms] Http1AsyncReceiver(SocketTube(1)) checkRequestMore: canRequestMore=true, hasDemand=true
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange sendHeadersAsync
FINE: [JdkHttpClient-0-1] [1s 256ms] Http1Exchange response created in advance
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange connectFlows
FINE: [JdkHttpClient-0-1] [1s 256ms] Http1Exchange SocketTube(1) connecting flows
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe
FINE: [HttpClient-1-SelectorManager] [1s 256ms] Http1AsyncReceiver(SocketTube(1)) Received onSubscribed from upstream
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher subscribe
FINE: [JdkHttpClient-0-1] [1s 256ms] Http1Publisher(SocketTube(1)) got subscriber: SocketTube(1)
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver hasDemand
FINE: [JdkHttpClient-0-0] [1s 257ms] Http1AsyncReceiver(SocketTube(1)) downstream subscription demand is 1
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver checkRequestMore
FINE: [JdkHttpClient-0-0] [1s 257ms] Http1AsyncReceiver(SocketTube(1)) checkRequestMore: canRequestMore=true, hasDemand=true
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange lambda$sendHeadersAsync$4
FINE: [JdkHttpClient-0-1] [1s 257ms] Http1Exchange requestAction.headers
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber requestMore
FINE: [JdkHttpClient-0-0] [1s 258ms] Http1AsyncReceiver(SocketTube(1)) Http1TubeSubscriber: requesting one more from upstream
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$Http1WriteSubscription request
FINE: [JdkHttpClient-0-2] [1s 257ms] Http1Publisher(SocketTube(1)) subscription request(1), demand=1
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange lambda$sendHeadersAsync$4
FINE: [JdkHttpClient-0-1] [1s 258ms] Http1Exchange setting outgoing with headers
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$WriteTask run
FINE: [JdkHttpClient-0-2] [1s 259ms] Http1Publisher(SocketTube(1)) WriteTask
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange appendToOutgoing
FINE: [JdkHttpClient-0-1] [1s 260ms] Http1Exchange appending to outgoing DataPair [data=[java.nio.HeapByteBuffer[pos=0 lim=306 cap=306]], throwable=null]
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$WriteTask run
FINE: [JdkHttpClient-0-2] [1s 261ms] Http1Publisher(SocketTube(1)) hasOutgoing = false
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange getOutgoing
FINE: [JdkHttpClient-0-2] [1s 261ms] Http1Exchange initiating completion of headersSentCF
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Exchange checkFor407
FINE: [JdkHttpClient-0-2] [1s 262ms] Exchange checkFor407: all clear
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Exchange sendRequestBody
FINE: [JdkHttpClient-0-2] [1s 263ms] Exchange sendRequestBody
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange sendBodyAsync
FINE: [JdkHttpClient-0-2] [1s 263ms] Http1Exchange sendBodyAsync
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange sendBodyAsync
FINE: [JdkHttpClient-0-2] [1s 263ms] Http1Exchange bodySubscriber is class jdk.internal.net.http.Http1Request$FixedContentSubscriber
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange requestMoreBody
FINE: [JdkHttpClient-0-2] [1s 264ms] Http1Exchange requesting more request body from the subscriber
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1BodySubscriber request
FINE: [JdkHttpClient-0-2] [1s 264ms] jdk.internal.net.http.Http1Request@5efed900 Http1BodySubscriber requesting 1, from jdk.internal.net.http.PullPublisher$Subscription@5ac14680
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Request$FixedContentSubscriber onNext
FINE: [JdkHttpClient-0-2] [1s 265ms] jdk.internal.net.http.Http1Request@5efed900 onNext
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange appendToOutgoing
FINE: [JdkHttpClient-0-2] [1s 265ms] Http1Exchange appending to outgoing DataPair [data=[java.nio.HeapByteBuffer[pos=0 lim=49 cap=16384]], throwable=null]
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Request$FixedContentSubscriber onComplete
FINE: [JdkHttpClient-0-2] [1s 265ms] jdk.internal.net.http.Http1Request@5efed900 onComplete
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange appendToOutgoing
FINE: [JdkHttpClient-0-2] [1s 265ms] Http1Exchange appending to outgoing DataPair [data=[java.nio.HeapByteBuffer[pos=0 lim=0 cap=0]], throwable=null]
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$WriteTask run
FINE: [JdkHttpClient-0-2] [1s 266ms] Http1Publisher(SocketTube(1)) onNext with 306 bytes
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$Http1WriteSubscription request
FINE: [JdkHttpClient-0-2] [1s 267ms] Http1Publisher(SocketTube(1)) subscription request(1), demand=1
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange requestMoreBody
FINE: [JdkHttpClient-0-2] [1s 267ms] Http1Exchange requesting more request body from the subscriber
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1BodySubscriber request
FINE: [JdkHttpClient-0-2] [1s 268ms] jdk.internal.net.http.Http1Request@5efed900 Http1BodySubscriber requesting 1, from jdk.internal.net.http.PullPublisher$Subscription@5ac14680
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$WriteTask run
FINE: [JdkHttpClient-0-2] [1s 268ms] Http1Publisher(SocketTube(1)) onNext with 49 bytes
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$Http1WriteSubscription request
FINE: [JdkHttpClient-0-2] [1s 268ms] Http1Publisher(SocketTube(1)) subscription request(1), demand=1
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange getOutgoing
FINE: [JdkHttpClient-0-2] [1s 268ms] Http1Exchange initiating completion of bodySentCF
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.common.Utils lambda$wrapForDebug$9
FINE: [JdkHttpClient-0-2] [1s 269ms] Http1Exchange sendBodyAsync completed successfully
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange getResponseAsync
FINE: [JdkHttpClient-0-2] [1s 269ms] Http1Exchange reading headers
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response readHeadersAsync
FINE: [JdkHttpClient-0-2] [1s 274ms] Http1Response(id=5, PlainHttpConnection(SocketTube(1))) Reading Headers: (remaining: 0) READING_HEADERS
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response readHeadersAsync
FINE: [JdkHttpClient-0-2] [1s 274ms] Http1Response(id=5, PlainHttpConnection(SocketTube(1))) First time around
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response readHeadersAsync
FINE: [JdkHttpClient-0-2] [1s 275ms] Http1Response(id=5, PlainHttpConnection(SocketTube(1))) headersReader is not yet completed
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$WriteTask run
FINE: [JdkHttpClient-0-2] [1s 276ms] Http1Publisher(SocketTube(1)) completed, stopping jdk.internal.net.http.common.SequentialScheduler@5132b6f0
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver asyncReceive
FINE: [HttpClient-1-SelectorManager] [1s 288ms] Http1AsyncReceiver(SocketTube(1)) Putting 122 bytes into the queue
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-2] [1s 289ms] Http1AsyncReceiver(SocketTube(1)) Got 122 bytes for delegate jdk.internal.net.http.Http1Response$HeadersReader@70194713
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver hasDemand
FINE: [JdkHttpClient-0-2] [1s 290ms] Http1AsyncReceiver(SocketTube(1)) downstream subscription demand is 1
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-2] [1s 290ms] Http1AsyncReceiver(SocketTube(1)) Forwarding 122 bytes to delegate jdk.internal.net.http.Http1Response$HeadersReader@70194713
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response$HeadersReader handle
FINE: [JdkHttpClient-0-2] [1s 293ms] Http1Response(id=5, PlainHttpConnection(SocketTube(1))) Sending 122/122 bytes to header parser
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response$HeadersReader handle
FINE: [JdkHttpClient-0-2] [1s 293ms] Http1Response(id=5, PlainHttpConnection(SocketTube(1))) Parsing headers completed. bytes=108
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver unsubscribe
FINE: [JdkHttpClient-0-2] [1s 294ms] Http1AsyncReceiver(SocketTube(1)) Unsubscribed jdk.internal.net.http.Http1Response$HeadersReader@70194713
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response lambda$readHeadersAsync$0
FINE: [JdkHttpClient-0-2] [1s 294ms] Http1Response(id=5, PlainHttpConnection(SocketTube(1))) Reading Headers: creating Response object; state is now READING_BODY
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.common.Utils lambda$wrapForDebug$9
FINE: [JdkHttpClient-0-2] [1s 295ms] Http1Exchange getResponseAsync completed successfully
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response readBody
FINE: [JdkHttpClient-0-2] [1s 296ms] Http1Response(id=5, PlainHttpConnection(SocketTube(1))) readBody: return2Cache: true
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response$ClientRefCountTracker acquire
FINE: [JdkHttpClient-0-2] [1s 300ms] Http1Response(id=5, PlainHttpConnection(SocketTube(1))) Operation started: incrementing ref count for jdk.internal.net.http.HttpClientImpl@1ccc9a80(1)
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver subscribe
FINE: [JdkHttpClient-0-2] [1s 301ms] Http1AsyncReceiver(SocketTube(1)) Subscribed pending jdk.internal.net.http.Http1Response$BodyReader@59bc50a4/parser=jdk.internal.net.http.ResponseContent$FixedLengthBodyParser@a17ab5 queue.isEmpty: false
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-2] [1s 306ms] Http1AsyncReceiver(SocketTube(1)) Delegate done: 14
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.ResponseContent$FixedLengthBodyParser onSubscribe
FINE: [JdkHttpClient-0-2] [1s 307ms] PlainHttpConnection(SocketTube(1))/ResponseContent/FixedLengthBodyParser length=14, onSubscribe: jdk.internal.net.http.Http1Response$Http1BodySubscriber
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver handlePendingDelegate
FINE: [JdkHttpClient-0-2] [1s 309ms] Http1AsyncReceiver(SocketTube(1)) delegate is now jdk.internal.net.http.Http1Response$BodyReader@59bc50a4/parser=jdk.internal.net.http.ResponseContent$FixedLengthBodyParser@a17ab5, demand=9223372036854775807, canRequestMore=false, queue.isEmpty=false
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-2] [1s 310ms] Http1AsyncReceiver(SocketTube(1)) Got 14 bytes for delegate jdk.internal.net.http.Http1Response$BodyReader@59bc50a4/parser=jdk.internal.net.http.ResponseContent$FixedLengthBodyParser@a17ab5
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver hasDemand
FINE: [JdkHttpClient-0-2] [1s 310ms] Http1AsyncReceiver(SocketTube(1)) downstream subscription demand is 9223372036854775807
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-2] [1s 311ms] Http1AsyncReceiver(SocketTube(1)) Forwarding 14 bytes to delegate jdk.internal.net.http.Http1Response$BodyReader@59bc50a4/parser=jdk.internal.net.http.ResponseContent$FixedLengthBodyParser@a17ab5
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response$BodyReader handle
FINE: [JdkHttpClient-0-2] [1s 312ms] Http1Response(id=5, PlainHttpConnection(SocketTube(1))) Sending 14/122 bytes to body parser
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.ResponseContent$FixedLengthBodyParser accept
FINE: [JdkHttpClient-0-2] [1s 313ms] PlainHttpConnection(SocketTube(1))/ResponseContent/FixedLengthBodyParser Parser got 14 bytes (14 remaining / 14)
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.ResponseContent$FixedLengthBodyParser accept
FINE: [JdkHttpClient-0-2] [1s 314ms] PlainHttpConnection(SocketTube(1))/ResponseContent/FixedLengthBodyParser Parser got all expected bytes: completing
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver clear
FINE: [JdkHttpClient-0-2] [1s 314ms] Http1AsyncReceiver(SocketTube(1)) cleared
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response onFinished
FINE: [JdkHttpClient-0-2] [1s 315ms] Http1Response(id=5, PlainHttpConnection(SocketTube(1))) SocketTube(1): return to HTTP/1.1 pool
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber dropSubscription
FINE: [HttpClient-1-SelectorManager] [1s 315ms] Http1AsyncReceiver(SocketTube(1)) Http1TubeSubscriber: dropSubscription
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient execute0
FINE: Ending request (POST) /session/3af0cf27f54127ae63a7501a9cf3044e/url in 71ms
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response lambda$readBody$2
FINE: [JdkHttpClient-0-2] [1s 316ms] Http1Response(id=5, PlainHttpConnection(SocketTube(1))) Finished reading body: READING_BODY
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response$ClientRefCountTracker tryRelease
FINE: [JdkHttpClient-0-2] [1s 329ms] Http1Response(id=5, PlainHttpConnection(SocketTube(1))) Operation finished: decrementing ref count for jdk.internal.net.http.HttpClientImpl@1ccc9a80(1)
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-2] [1s 331ms] Http1AsyncReceiver(SocketTube(1)) Delegate done: 0
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.RemoteWebDriver log
FINE: Executed: get (Response: SessionID: 3af0cf27f54127ae63a7501a9cf3044e, State: success, Value: null)
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-2] [1s 331ms] Http1AsyncReceiver(SocketTube(1)) Got 0 bytes for delegate null
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.RemoteWebDriver log
FINE: Executing: getTitle [3af0cf27f54127ae63a7501a9cf3044e, getTitle {}]
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient execute0
FINE: Executing request: (GET) /session/3af0cf27f54127ae63a7501a9cf3044e/title
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Exchange establishExchange
FINE: [JdkHttpClient-0-2] [1s 333ms] Exchange establishing exchange for http://localhost:42830/session/3af0cf27f54127ae63a7501a9cf3044e/title GET,
proxy=null
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Exchange checkFor407
FINE: [JdkHttpClient-0-2] [1s 334ms] Exchange checkFor407: all clear
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange sendHeadersAsync
FINE: [JdkHttpClient-0-2] [1s 334ms] Http1Exchange Sending headers only
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver subscribe
FINE: [JdkHttpClient-0-2] [1s 335ms] Http1AsyncReceiver(SocketTube(1)) Subscribed pending jdk.internal.net.http.Http1Response$HeadersReader@7346e7b0 queue.isEmpty: true
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver handlePendingDelegate
FINE: [JdkHttpClient-0-2] [1s 335ms] Http1AsyncReceiver(SocketTube(1)) delegate is now jdk.internal.net.http.Http1Response$HeadersReader@7346e7b0, demand=1, canRequestMore=true, queue.isEmpty=true
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver hasDemand
FINE: [JdkHttpClient-0-2] [1s 335ms] Http1AsyncReceiver(SocketTube(1)) downstream subscription demand is 1
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver checkRequestMore
FINE: [JdkHttpClient-0-2] [1s 335ms] Http1AsyncReceiver(SocketTube(1)) checkRequestMore: canRequestMore=true, hasDemand=true
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver hasDemand
FINE: [JdkHttpClient-0-2] [1s 335ms] Http1AsyncReceiver(SocketTube(1)) downstream subscription demand is 1
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver checkRequestMore
FINE: [JdkHttpClient-0-2] [1s 336ms] Http1AsyncReceiver(SocketTube(1)) checkRequestMore: canRequestMore=true, hasDemand=true
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange sendHeadersAsync
FINE: [JdkHttpClient-0-2] [1s 336ms] Http1Exchange response created in advance
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange connectFlows
FINE: [JdkHttpClient-0-2] [1s 336ms] Http1Exchange SocketTube(1) connecting flows
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher subscribe
FINE: [JdkHttpClient-0-2] [1s 336ms] Http1Publisher(SocketTube(1)) got subscriber: SocketTube(1)
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe
FINE: [HttpClient-1-SelectorManager] [1s 336ms] Http1AsyncReceiver(SocketTube(1)) Received onSubscribed from upstream
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange lambda$sendHeadersAsync$4
FINE: [JdkHttpClient-0-2] [1s 336ms] Http1Exchange requestAction.headers
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$Http1WriteSubscription request
FINE: [JdkHttpClient-0-0] [1s 337ms] Http1Publisher(SocketTube(1)) subscription request(1), demand=1
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange lambda$sendHeadersAsync$4
FINE: [JdkHttpClient-0-2] [1s 337ms] Http1Exchange setting outgoing with headers
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver hasDemand
FINE: [JdkHttpClient-0-1] [1s 337ms] Http1AsyncReceiver(SocketTube(1)) downstream subscription demand is 1
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange appendToOutgoing
FINE: [JdkHttpClient-0-2] [1s 337ms] Http1Exchange appending to outgoing DataPair [data=[java.nio.HeapByteBuffer[pos=0 lim=331 cap=331]], throwable=null]
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$WriteTask run
FINE: [JdkHttpClient-0-0] [1s 337ms] Http1Publisher(SocketTube(1)) WriteTask
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver checkRequestMore
FINE: [JdkHttpClient-0-1] [1s 338ms] Http1AsyncReceiver(SocketTube(1)) checkRequestMore: canRequestMore=true, hasDemand=true
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$WriteTask run
FINE: [JdkHttpClient-0-0] [1s 338ms] Http1Publisher(SocketTube(1)) hasOutgoing = true
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber requestMore
FINE: [JdkHttpClient-0-1] [1s 338ms] Http1AsyncReceiver(SocketTube(1)) Http1TubeSubscriber: requesting one more from upstream
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange getOutgoing
FINE: [JdkHttpClient-0-0] [1s 338ms] Http1Exchange initiating completion of headersSentCF
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Exchange checkFor407
FINE: [JdkHttpClient-0-0] [1s 339ms] Exchange checkFor407: all clear
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Exchange sendRequestBody
FINE: [JdkHttpClient-0-0] [1s 339ms] Exchange sendRequestBody
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange sendBodyAsync
FINE: [JdkHttpClient-0-0] [1s 339ms] Http1Exchange sendBodyAsync
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange sendBodyAsync
FINE: [JdkHttpClient-0-0] [1s 340ms] Http1Exchange bodySubscriber is null
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange appendToOutgoing
FINE: [JdkHttpClient-0-0] [1s 340ms] Http1Exchange appending to outgoing DataPair [data=[java.nio.HeapByteBuffer[pos=0 lim=0 cap=0]], throwable=null]
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$WriteTask run
FINE: [JdkHttpClient-0-0] [1s 341ms] Http1Publisher(SocketTube(1)) onNext with 331 bytes
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$Http1WriteSubscription request
FINE: [JdkHttpClient-0-0] [1s 341ms] Http1Publisher(SocketTube(1)) subscription request(1), demand=1
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange getOutgoing
FINE: [JdkHttpClient-0-0] [1s 342ms] Http1Exchange initiating completion of bodySentCF
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.common.Utils lambda$wrapForDebug$9
FINE: [JdkHttpClient-0-0] [1s 342ms] Http1Exchange sendBodyAsync completed successfully
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange getResponseAsync
FINE: [JdkHttpClient-0-0] [1s 342ms] Http1Exchange reading headers
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response readHeadersAsync
FINE: [JdkHttpClient-0-0] [1s 343ms] Http1Response(id=6, PlainHttpConnection(SocketTube(1))) Reading Headers: (remaining: 0) READING_HEADERS
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response readHeadersAsync
FINE: [JdkHttpClient-0-0] [1s 343ms] Http1Response(id=6, PlainHttpConnection(SocketTube(1))) First time around
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response readHeadersAsync
FINE: [JdkHttpClient-0-0] [1s 343ms] Http1Response(id=6, PlainHttpConnection(SocketTube(1))) headersReader is not yet completed
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$WriteTask run
FINE: [JdkHttpClient-0-0] [1s 343ms] Http1Publisher(SocketTube(1)) completed, stopping jdk.internal.net.http.common.SequentialScheduler@131ab535
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver asyncReceive
FINE: [HttpClient-1-SelectorManager] [1s 351ms] Http1AsyncReceiver(SocketTube(1)) Putting 120 bytes into the queue
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-0] [1s 352ms] Http1AsyncReceiver(SocketTube(1)) Got 120 bytes for delegate jdk.internal.net.http.Http1Response$HeadersReader@7346e7b0
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver hasDemand
FINE: [JdkHttpClient-0-0] [1s 352ms] Http1AsyncReceiver(SocketTube(1)) downstream subscription demand is 1
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-0] [1s 352ms] Http1AsyncReceiver(SocketTube(1)) Forwarding 120 bytes to delegate jdk.internal.net.http.Http1Response$HeadersReader@7346e7b0
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response$HeadersReader handle
FINE: [JdkHttpClient-0-0] [1s 352ms] Http1Response(id=6, PlainHttpConnection(SocketTube(1))) Sending 120/120 bytes to header parser
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response$HeadersReader handle
FINE: [JdkHttpClient-0-0] [1s 353ms] Http1Response(id=6, PlainHttpConnection(SocketTube(1))) Parsing headers completed. bytes=108
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver unsubscribe
FINE: [JdkHttpClient-0-0] [1s 353ms] Http1AsyncReceiver(SocketTube(1)) Unsubscribed jdk.internal.net.http.Http1Response$HeadersReader@7346e7b0
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response lambda$readHeadersAsync$0
FINE: [JdkHttpClient-0-0] [1s 353ms] Http1Response(id=6, PlainHttpConnection(SocketTube(1))) Reading Headers: creating Response object; state is now READING_BODY
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.common.Utils lambda$wrapForDebug$9
FINE: [JdkHttpClient-0-0] [1s 353ms] Http1Exchange getResponseAsync completed successfully
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response readBody
FINE: [JdkHttpClient-0-0] [1s 353ms] Http1Response(id=6, PlainHttpConnection(SocketTube(1))) readBody: return2Cache: true
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response$ClientRefCountTracker acquire
FINE: [JdkHttpClient-0-0] [1s 354ms] Http1Response(id=6, PlainHttpConnection(SocketTube(1))) Operation started: incrementing ref count for jdk.internal.net.http.HttpClientImpl@1ccc9a80(1)
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver subscribe
FINE: [JdkHttpClient-0-0] [1s 354ms] Http1AsyncReceiver(SocketTube(1)) Subscribed pending jdk.internal.net.http.Http1Response$BodyReader@7be2d7b4/parser=jdk.internal.net.http.ResponseContent$FixedLengthBodyParser@1b991098 queue.isEmpty: false
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-0] [1s 354ms] Http1AsyncReceiver(SocketTube(1)) Delegate done: 12
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.ResponseContent$FixedLengthBodyParser onSubscribe
FINE: [JdkHttpClient-0-0] [1s 354ms] PlainHttpConnection(SocketTube(1))/ResponseContent/FixedLengthBodyParser length=12, onSubscribe: jdk.internal.net.http.Http1Response$Http1BodySubscriber
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver handlePendingDelegate
FINE: [JdkHttpClient-0-0] [1s 354ms] Http1AsyncReceiver(SocketTube(1)) delegate is now jdk.internal.net.http.Http1Response$BodyReader@7be2d7b4/parser=jdk.internal.net.http.ResponseContent$FixedLengthBodyParser@1b991098, demand=9223372036854775807, canRequestMore=false, queue.isEmpty=false
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-0] [1s 355ms] Http1AsyncReceiver(SocketTube(1)) Got 12 bytes for delegate jdk.internal.net.http.Http1Response$BodyReader@7be2d7b4/parser=jdk.internal.net.http.ResponseContent$FixedLengthBodyParser@1b991098
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver hasDemand
FINE: [JdkHttpClient-0-0] [1s 355ms] Http1AsyncReceiver(SocketTube(1)) downstream subscription demand is 9223372036854775807
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-0] [1s 355ms] Http1AsyncReceiver(SocketTube(1)) Forwarding 12 bytes to delegate jdk.internal.net.http.Http1Response$BodyReader@7be2d7b4/parser=jdk.internal.net.http.ResponseContent$FixedLengthBodyParser@1b991098
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response$BodyReader handle
FINE: [JdkHttpClient-0-0] [1s 355ms] Http1Response(id=6, PlainHttpConnection(SocketTube(1))) Sending 12/120 bytes to body parser
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.ResponseContent$FixedLengthBodyParser accept
FINE: [JdkHttpClient-0-0] [1s 355ms] PlainHttpConnection(SocketTube(1))/ResponseContent/FixedLengthBodyParser Parser got 12 bytes (12 remaining / 12)
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.ResponseContent$FixedLengthBodyParser accept
FINE: [JdkHttpClient-0-0] [1s 355ms] PlainHttpConnection(SocketTube(1))/ResponseContent/FixedLengthBodyParser Parser got all expected bytes: completing
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver clear
FINE: [JdkHttpClient-0-0] [1s 356ms] Http1AsyncReceiver(SocketTube(1)) cleared
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response onFinished
FINE: [JdkHttpClient-0-0] [1s 356ms] Http1Response(id=6, PlainHttpConnection(SocketTube(1))) SocketTube(1): return to HTTP/1.1 pool
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber dropSubscription
FINE: [HttpClient-1-SelectorManager] [1s 357ms] Http1AsyncReceiver(SocketTube(1)) Http1TubeSubscriber: dropSubscription
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient execute0
FINE: Ending request (GET) /session/3af0cf27f54127ae63a7501a9cf3044e/title in 24ms
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response lambda$readBody$2
FINE: [JdkHttpClient-0-0] [1s 357ms] Http1Response(id=6, PlainHttpConnection(SocketTube(1))) Finished reading body: READING_BODY
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.RemoteWebDriver log
FINE: Executed: getTitle (Response: SessionID: 3af0cf27f54127ae63a7501a9cf3044e, State: success, Value: )
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response$ClientRefCountTracker tryRelease
FINE: [JdkHttpClient-0-0] [1s 359ms] Http1Response(id=6, PlainHttpConnection(SocketTube(1))) Operation finished: decrementing ref count for jdk.internal.net.http.HttpClientImpl@1ccc9a80(1)
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-0] [1s 359ms] Http1AsyncReceiver(SocketTube(1)) Delegate done: 0
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-0] [1s 359ms] Http1AsyncReceiver(SocketTube(1)) Got 0 bytes for delegate null
Apr 12, 2024 10:47:31 AM org.openqa.selenium.devtools.Connection send
FINE: -> {
"id": 1,
"method": "Target.getTargets",
"params": {
}
}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$4 send
FINE: Sending text message: {
"id": 1,
"method": "Target.getTargets",
"params": {
}
}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$4 send
FINE: Websocket response to org.openqa.selenium.remote.http.TextMessage@740d2e78 read in 2ms
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$3 onText
FINE: Text message received. Appending data
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$3 onText
FINE: Final part of text message received. Calling listener with {"id":1,"result":{"targetInfos":[{"targetId":"89C28A66A266DCDB4D32CA2C4B707D59","type":"page","title":"data:,","url":"data:,","attached":true,"canAccessOpener":false,"browserContextId":"52845B5880E46F1FF7C1103294EC31F9"}]}}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.devtools.Connection handle
FINE: <- {"id":1,"result":{"targetInfos":[{"targetId":"89C28A66A266DCDB4D32CA2C4B707D59","type":"page","title":"data:,","url":"data:,","attached":true,"canAccessOpener":false,"browserContextId":"52845B5880E46F1FF7C1103294EC31F9"}]}}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.devtools.Connection send
FINE: -> {
"id": 2,
"method": "Target.attachToTarget",
"params": {
"targetId": "89C28A66A266DCDB4D32CA2C4B707D59",
"flatten": true
}
}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$4 send
FINE: Sending text message: {
"id": 2,
"method": "Target.attachToTarget",
"params": {
"targetId": "89C28A66A266DCDB4D32CA2C4B707D59",
"flatten": true
}
}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$4 send
FINE: Websocket response to org.openqa.selenium.remote.http.TextMessage@8ad6665 read in 0ms
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$3 onText
FINE: Text message received. Appending data
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$3 onText
FINE: Final part of text message received. Calling listener with {"method":"Target.attachedToTarget","params":{"sessionId":"499C95BAF69DED471DCCF91D545C78BE","targetInfo":{"targetId":"89C28A66A266DCDB4D32CA2C4B707D59","type":"page","title":"data:,","url":"data:,","attached":true,"canAccessOpener":false,"browserContextId":"52845B5880E46F1FF7C1103294EC31F9"},"waitingForDebugger":false}}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.devtools.Connection handle
FINE: <- {"method":"Target.attachedToTarget","params":{"sessionId":"499C95BAF69DED471DCCF91D545C78BE","targetInfo":{"targetId":"89C28A66A266DCDB4D32CA2C4B707D59","type":"page","title":"data:,","url":"data:,","attached":true,"canAccessOpener":false,"browserContextId":"52845B5880E46F1FF7C1103294EC31F9"},"waitingForDebugger":false}}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$3 onText
FINE: Text message received. Appending data
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$3 onText
FINE: Final part of text message received. Calling listener with {"id":2,"result":{"sessionId":"499C95BAF69DED471DCCF91D545C78BE"}}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.devtools.Connection handle
FINE: <- {"id":2,"result":{"sessionId":"499C95BAF69DED471DCCF91D545C78BE"}}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.devtools.Connection handle
FINE: Method Target.attachedToTarget called with 0 callbacks available
Apr 12, 2024 10:47:31 AM org.openqa.selenium.devtools.Connection send
FINE: -> {
"params": {
"waitForDebuggerOnStart": false,
"flatten": true,
"autoAttach": true
},
"method": "Target.setAutoAttach",
"sessionId": "499C95BAF69DED471DCCF91D545C78BE",
"id": 3
}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$4 send
FINE: Sending text message: {
"params": {
"waitForDebuggerOnStart": false,
"flatten": true,
"autoAttach": true
},
"method": "Target.setAutoAttach",
"sessionId": "499C95BAF69DED471DCCF91D545C78BE",
"id": 3
}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$4 send
FINE: Websocket response to org.openqa.selenium.remote.http.TextMessage@6e4566f1 read in 0ms
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$3 onText
FINE: Text message received. Appending data
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$3 onText
FINE: Final part of text message received. Calling listener with {"id":3,"result":{},"sessionId":"499C95BAF69DED471DCCF91D545C78BE"}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.devtools.Connection handle
FINE: <- {"id":3,"result":{},"sessionId":"499C95BAF69DED471DCCF91D545C78BE"}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.devtools.Connection send
FINE: -> {
"params": {
},
"method": "Log.clear",
"sessionId": "499C95BAF69DED471DCCF91D545C78BE",
"id": 4
}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$4 send
FINE: Sending text message: {
"params": {
},
"method": "Log.clear",
"sessionId": "499C95BAF69DED471DCCF91D545C78BE",
"id": 4
}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$4 send
FINE: Websocket response to org.openqa.selenium.remote.http.TextMessage@6155d082 read in 0ms
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$3 onText
FINE: Text message received. Appending data
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$3 onText
FINE: Final part of text message received. Calling listener with {"id":4,"result":{},"sessionId":"499C95BAF69DED471DCCF91D545C78BE"}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.devtools.Connection handle
FINE: <- {"id":4,"result":{},"sessionId":"499C95BAF69DED471DCCF91D545C78BE"}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.RemoteWebDriver log
FINE: Executing: get [3af0cf27f54127ae63a7501a9cf3044e, get {url=htpps://weatherstack.com}]
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient execute0
FINE: Executing request: (POST) /session/3af0cf27f54127ae63a7501a9cf3044e/url
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Exchange establishExchange
FINE: [JdkHttpClient-0-0] [1s 411ms] Exchange establishing exchange for http://localhost:42830/session/3af0cf27f54127ae63a7501a9cf3044e/url POST,
proxy=null
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Exchange checkFor407
FINE: [JdkHttpClient-0-0] [1s 412ms] Exchange checkFor407: all clear
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange sendHeadersAsync
FINE: [JdkHttpClient-0-0] [1s 412ms] Http1Exchange Sending headers only
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver subscribe
FINE: [JdkHttpClient-0-0] [1s 412ms] Http1AsyncReceiver(SocketTube(1)) Subscribed pending jdk.internal.net.http.Http1Response$HeadersReader@4e58633c queue.isEmpty: true
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver handlePendingDelegate
FINE: [JdkHttpClient-0-0] [1s 413ms] Http1AsyncReceiver(SocketTube(1)) delegate is now jdk.internal.net.http.Http1Response$HeadersReader@4e58633c, demand=1, canRequestMore=true, queue.isEmpty=true
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver hasDemand
FINE: [JdkHttpClient-0-0] [1s 413ms] Http1AsyncReceiver(SocketTube(1)) downstream subscription demand is 1
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver checkRequestMore
FINE: [JdkHttpClient-0-0] [1s 413ms] Http1AsyncReceiver(SocketTube(1)) checkRequestMore: canRequestMore=true, hasDemand=true
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver hasDemand
FINE: [JdkHttpClient-0-0] [1s 413ms] Http1AsyncReceiver(SocketTube(1)) downstream subscription demand is 1
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver checkRequestMore
FINE: [JdkHttpClient-0-0] [1s 413ms] Http1AsyncReceiver(SocketTube(1)) checkRequestMore: canRequestMore=true, hasDemand=true
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange sendHeadersAsync
FINE: [JdkHttpClient-0-0] [1s 413ms] Http1Exchange response created in advance
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange connectFlows
FINE: [JdkHttpClient-0-0] [1s 414ms] Http1Exchange SocketTube(1) connecting flows
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher subscribe
FINE: [JdkHttpClient-0-0] [1s 414ms] Http1Publisher(SocketTube(1)) got subscriber: SocketTube(1)
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe
FINE: [HttpClient-1-SelectorManager] [1s 414ms] Http1AsyncReceiver(SocketTube(1)) Received onSubscribed from upstream
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange lambda$sendHeadersAsync$4
FINE: [JdkHttpClient-0-0] [1s 414ms] Http1Exchange requestAction.headers
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver hasDemand
FINE: [JdkHttpClient-0-1] [1s 415ms] Http1AsyncReceiver(SocketTube(1)) downstream subscription demand is 1
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$Http1WriteSubscription request
FINE: [JdkHttpClient-0-2] [1s 415ms] Http1Publisher(SocketTube(1)) subscription request(1), demand=1
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange lambda$sendHeadersAsync$4
FINE: [JdkHttpClient-0-0] [1s 415ms] Http1Exchange setting outgoing with headers
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver checkRequestMore
FINE: [JdkHttpClient-0-1] [1s 415ms] Http1AsyncReceiver(SocketTube(1)) checkRequestMore: canRequestMore=true, hasDemand=true
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange appendToOutgoing
FINE: [JdkHttpClient-0-0] [1s 415ms] Http1Exchange appending to outgoing DataPair [data=[java.nio.HeapByteBuffer[pos=0 lim=306 cap=306]], throwable=null]
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$WriteTask run
FINE: [JdkHttpClient-0-2] [1s 415ms] Http1Publisher(SocketTube(1)) WriteTask
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$WriteTask run
FINE: [JdkHttpClient-0-2] [1s 416ms] Http1Publisher(SocketTube(1)) hasOutgoing = true
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange getOutgoing
FINE: [JdkHttpClient-0-2] [1s 416ms] Http1Exchange initiating completion of headersSentCF
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber requestMore
FINE: [JdkHttpClient-0-1] [1s 415ms] Http1AsyncReceiver(SocketTube(1)) Http1TubeSubscriber: requesting one more from upstream
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Exchange checkFor407
FINE: [JdkHttpClient-0-2] [1s 416ms] Exchange checkFor407: all clear
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Exchange sendRequestBody
FINE: [JdkHttpClient-0-2] [1s 417ms] Exchange sendRequestBody
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange sendBodyAsync
FINE: [JdkHttpClient-0-2] [1s 417ms] Http1Exchange sendBodyAsync
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange sendBodyAsync
FINE: [JdkHttpClient-0-2] [1s 417ms] Http1Exchange bodySubscriber is class jdk.internal.net.http.Http1Request$FixedContentSubscriber
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange requestMoreBody
FINE: [JdkHttpClient-0-2] [1s 418ms] Http1Exchange requesting more request body from the subscriber
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1BodySubscriber request
FINE: [JdkHttpClient-0-2] [1s 418ms] jdk.internal.net.http.Http1Request@176684ef Http1BodySubscriber requesting 1, from jdk.internal.net.http.PullPublisher$Subscription@49ca2560
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Request$FixedContentSubscriber onNext
FINE: [JdkHttpClient-0-2] [1s 418ms] jdk.internal.net.http.Http1Request@176684ef onNext
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange appendToOutgoing
FINE: [JdkHttpClient-0-2] [1s 418ms] Http1Exchange appending to outgoing DataPair [data=[java.nio.HeapByteBuffer[pos=0 lim=49 cap=16384]], throwable=null]
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Request$FixedContentSubscriber onComplete
FINE: [JdkHttpClient-0-2] [1s 418ms] jdk.internal.net.http.Http1Request@176684ef onComplete
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange appendToOutgoing
FINE: [JdkHttpClient-0-2] [1s 419ms] Http1Exchange appending to outgoing DataPair [data=[java.nio.HeapByteBuffer[pos=0 lim=0 cap=0]], throwable=null]
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$WriteTask run
FINE: [JdkHttpClient-0-2] [1s 419ms] Http1Publisher(SocketTube(1)) onNext with 306 bytes
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$Http1WriteSubscription request
FINE: [JdkHttpClient-0-2] [1s 420ms] Http1Publisher(SocketTube(1)) subscription request(1), demand=1
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange requestMoreBody
FINE: [JdkHttpClient-0-2] [1s 420ms] Http1Exchange requesting more request body from the subscriber
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1BodySubscriber request
FINE: [JdkHttpClient-0-2] [1s 420ms] jdk.internal.net.http.Http1Request@176684ef Http1BodySubscriber requesting 1, from jdk.internal.net.http.PullPublisher$Subscription@49ca2560
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$WriteTask run
FINE: [JdkHttpClient-0-2] [1s 420ms] Http1Publisher(SocketTube(1)) onNext with 49 bytes
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$Http1WriteSubscription request
FINE: [JdkHttpClient-0-2] [1s 421ms] Http1Publisher(SocketTube(1)) subscription request(1), demand=1
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange getOutgoing
FINE: [JdkHttpClient-0-2] [1s 421ms] Http1Exchange initiating completion of bodySentCF
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.common.Utils lambda$wrapForDebug$9
FINE: [JdkHttpClient-0-2] [1s 421ms] Http1Exchange sendBodyAsync completed successfully
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange getResponseAsync
FINE: [JdkHttpClient-0-2] [1s 421ms] Http1Exchange reading headers
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response readHeadersAsync
FINE: [JdkHttpClient-0-2] [1s 421ms] Http1Response(id=7, PlainHttpConnection(SocketTube(1))) Reading Headers: (remaining: 0) READING_HEADERS
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response readHeadersAsync
FINE: [JdkHttpClient-0-2] [1s 422ms] Http1Response(id=7, PlainHttpConnection(SocketTube(1))) First time around
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response readHeadersAsync
FINE: [JdkHttpClient-0-2] [1s 422ms] Http1Response(id=7, PlainHttpConnection(SocketTube(1))) headersReader is not yet completed
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$WriteTask run
FINE: [JdkHttpClient-0-2] [1s 423ms] Http1Publisher(SocketTube(1)) completed, stopping jdk.internal.net.http.common.SequentialScheduler@2578523d
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver asyncReceive
FINE: [HttpClient-1-SelectorManager] [1s 437ms] Http1AsyncReceiver(SocketTube(1)) Putting 122 bytes into the queue
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-2] [1s 438ms] Http1AsyncReceiver(SocketTube(1)) Got 122 bytes for delegate jdk.internal.net.http.Http1Response$HeadersReader@4e58633c
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver hasDemand
FINE: [JdkHttpClient-0-2] [1s 439ms] Http1AsyncReceiver(SocketTube(1)) downstream subscription demand is 1
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-2] [1s 439ms] Http1AsyncReceiver(SocketTube(1)) Forwarding 122 bytes to delegate jdk.internal.net.http.Http1Response$HeadersReader@4e58633c
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response$HeadersReader handle
FINE: [JdkHttpClient-0-2] [1s 439ms] Http1Response(id=7, PlainHttpConnection(SocketTube(1))) Sending 122/122 bytes to header parser
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response$HeadersReader handle
FINE: [JdkHttpClient-0-2] [1s 440ms] Http1Response(id=7, PlainHttpConnection(SocketTube(1))) Parsing headers completed. bytes=108
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver unsubscribe
FINE: [JdkHttpClient-0-2] [1s 440ms] Http1AsyncReceiver(SocketTube(1)) Unsubscribed jdk.internal.net.http.Http1Response$HeadersReader@4e58633c
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response lambda$readHeadersAsync$0
FINE: [JdkHttpClient-0-2] [1s 440ms] Http1Response(id=7, PlainHttpConnection(SocketTube(1))) Reading Headers: creating Response object; state is now READING_BODY
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.common.Utils lambda$wrapForDebug$9
FINE: [JdkHttpClient-0-2] [1s 441ms] Http1Exchange getResponseAsync completed successfully
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response readBody
FINE: [JdkHttpClient-0-2] [1s 441ms] Http1Response(id=7, PlainHttpConnection(SocketTube(1))) readBody: return2Cache: true
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response$ClientRefCountTracker acquire
FINE: [JdkHttpClient-0-2] [1s 441ms] Http1Response(id=7, PlainHttpConnection(SocketTube(1))) Operation started: incrementing ref count for jdk.internal.net.http.HttpClientImpl@1ccc9a80(1)
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver subscribe
FINE: [JdkHttpClient-0-2] [1s 442ms] Http1AsyncReceiver(SocketTube(1)) Subscribed pending jdk.internal.net.http.Http1Response$BodyReader@61c75a45/parser=jdk.internal.net.http.ResponseContent$FixedLengthBodyParser@79be9238 queue.isEmpty: false
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-2] [1s 442ms] Http1AsyncReceiver(SocketTube(1)) Delegate done: 14
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.ResponseContent$FixedLengthBodyParser onSubscribe
FINE: [JdkHttpClient-0-2] [1s 442ms] PlainHttpConnection(SocketTube(1))/ResponseContent/FixedLengthBodyParser length=14, onSubscribe: jdk.internal.net.http.Http1Response$Http1BodySubscriber
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver handlePendingDelegate
FINE: [JdkHttpClient-0-2] [1s 442ms] Http1AsyncReceiver(SocketTube(1)) delegate is now jdk.internal.net.http.Http1Response$BodyReader@61c75a45/parser=jdk.internal.net.http.ResponseContent$FixedLengthBodyParser@79be9238, demand=9223372036854775807, canRequestMore=false, queue.isEmpty=false
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-2] [1s 442ms] Http1AsyncReceiver(SocketTube(1)) Got 14 bytes for delegate jdk.internal.net.http.Http1Response$BodyReader@61c75a45/parser=jdk.internal.net.http.ResponseContent$FixedLengthBodyParser@79be9238
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver hasDemand
FINE: [JdkHttpClient-0-2] [1s 443ms] Http1AsyncReceiver(SocketTube(1)) downstream subscription demand is 9223372036854775807
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-2] [1s 443ms] Http1AsyncReceiver(SocketTube(1)) Forwarding 14 bytes to delegate jdk.internal.net.http.Http1Response$BodyReader@61c75a45/parser=jdk.internal.net.http.ResponseContent$FixedLengthBodyParser@79be9238
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response$BodyReader handle
FINE: [JdkHttpClient-0-2] [1s 443ms] Http1Response(id=7, PlainHttpConnection(SocketTube(1))) Sending 14/122 bytes to body parser
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.ResponseContent$FixedLengthBodyParser accept
FINE: [JdkHttpClient-0-2] [1s 443ms] PlainHttpConnection(SocketTube(1))/ResponseContent/FixedLengthBodyParser Parser got 14 bytes (14 remaining / 14)
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.ResponseContent$FixedLengthBodyParser accept
FINE: [JdkHttpClient-0-2] [1s 443ms] PlainHttpConnection(SocketTube(1))/ResponseContent/FixedLengthBodyParser Parser got all expected bytes: completing
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver clear
FINE: [JdkHttpClient-0-2] [1s 443ms] Http1AsyncReceiver(SocketTube(1)) cleared
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response onFinished
FINE: [JdkHttpClient-0-2] [1s 444ms] Http1Response(id=7, PlainHttpConnection(SocketTube(1))) SocketTube(1): return to HTTP/1.1 pool
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber dropSubscription
FINE: [HttpClient-1-SelectorManager] [1s 444ms] Http1AsyncReceiver(SocketTube(1)) Http1TubeSubscriber: dropSubscription
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient execute0
FINE: Ending request (POST) /session/3af0cf27f54127ae63a7501a9cf3044e/url in 32ms
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response lambda$readBody$2
FINE: [JdkHttpClient-0-2] [1s 444ms] Http1Response(id=7, PlainHttpConnection(SocketTube(1))) Finished reading body: READING_BODY
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.RemoteWebDriver log
FINE: Executed: get (Response: SessionID: 3af0cf27f54127ae63a7501a9cf3044e, State: success, Value: null)
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response$ClientRefCountTracker tryRelease
FINE: [JdkHttpClient-0-2] [1s 445ms] Http1Response(id=7, PlainHttpConnection(SocketTube(1))) Operation finished: decrementing ref count for jdk.internal.net.http.HttpClientImpl@1ccc9a80(1)
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-2] [1s 446ms] Http1AsyncReceiver(SocketTube(1)) Delegate done: 0
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-2] [1s 446ms] Http1AsyncReceiver(SocketTube(1)) Got 0 bytes for delegate null
Apr 12, 2024 10:47:31 AM org.openqa.selenium.devtools.Connection send
FINE: -> {
"params": {
},
"method": "Fetch.disable",
"sessionId": "499C95BAF69DED471DCCF91D545C78BE",
"id": 5
}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$4 send
FINE: Sending text message: {
"params": {
},
"method": "Fetch.disable",
"sessionId": "499C95BAF69DED471DCCF91D545C78BE",
"id": 5
}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$4 send
FINE: Websocket response to org.openqa.selenium.remote.http.TextMessage@4b1d6571 read in 1ms
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$3 onText
FINE: Text message received. Appending data
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$3 onText
FINE: Final part of text message received. Calling listener with {"id":5,"result":{},"sessionId":"499C95BAF69DED471DCCF91D545C78BE"}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.devtools.Connection handle
FINE: <- {"id":5,"result":{},"sessionId":"499C95BAF69DED471DCCF91D545C78BE"}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.devtools.Connection send
FINE: -> {
"params": {
"cacheDisabled": false
},
"method": "Network.setCacheDisabled",
"sessionId": "499C95BAF69DED471DCCF91D545C78BE",
"id": 6
}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$4 send
FINE: Sending text message: {
"params": {
"cacheDisabled": false
},
"method": "Network.setCacheDisabled",
"sessionId": "499C95BAF69DED471DCCF91D545C78BE",
"id": 6
}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$4 send
FINE: Websocket response to org.openqa.selenium.remote.http.TextMessage@77d67cf3 read in 1ms
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$3 onText
FINE: Text message received. Appending data
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$3 onText
FINE: Final part of text message received. Calling listener with {"id":6,"result":{},"sessionId":"499C95BAF69DED471DCCF91D545C78BE"}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.devtools.Connection handle
FINE: <- {"id":6,"result":{},"sessionId":"499C95BAF69DED471DCCF91D545C78BE"}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.devtools.Connection send
FINE: -> {
"id": 7,
"method": "Target.detachFromTarget",
"params": {
"sessionId": "499C95BAF69DED471DCCF91D545C78BE"
}
}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$4 send
FINE: Sending text message: {
"id": 7,
"method": "Target.detachFromTarget",
"params": {
"sessionId": "499C95BAF69DED471DCCF91D545C78BE"
}
}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$4 send
FINE: Websocket response to org.openqa.selenium.remote.http.TextMessage@4f1bfe23 read in 0ms
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$3 onText
FINE: Text message received. Appending data
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$3 onText
FINE: Final part of text message received. Calling listener with {"method":"Target.detachedFromTarget","params":{"sessionId":"499C95BAF69DED471DCCF91D545C78BE","targetId":"89C28A66A266DCDB4D32CA2C4B707D59"}}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.devtools.Connection handle
FINE: <- {"method":"Target.detachedFromTarget","params":{"sessionId":"499C95BAF69DED471DCCF91D545C78BE","targetId":"89C28A66A266DCDB4D32CA2C4B707D59"}}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$3 onText
FINE: Text message received. Appending data
Apr 12, 2024 10:47:31 AM org.openqa.selenium.devtools.Connection handle
FINE: Method Target.detachedFromTarget called with 0 callbacks available
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$3 onText
FINE: Final part of text message received. Calling listener with {"id":7,"result":{}}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.devtools.Connection handle
FINE: <- {"id":7,"result":{}}
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.RemoteWebDriver log
FINE: Executing: close [3af0cf27f54127ae63a7501a9cf3044e, close {}]
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient execute0
FINE: Executing request: (DELETE) /session/3af0cf27f54127ae63a7501a9cf3044e/window
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Exchange establishExchange
FINE: [JdkHttpClient-0-2] [1s 473ms] Exchange establishing exchange for http://localhost:42830/session/3af0cf27f54127ae63a7501a9cf3044e/window DELETE,
proxy=null
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Exchange checkFor407
FINE: [JdkHttpClient-0-2] [1s 474ms] Exchange checkFor407: all clear
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange sendHeadersAsync
FINE: [JdkHttpClient-0-2] [1s 475ms] Http1Exchange Sending headers only
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver subscribe
FINE: [JdkHttpClient-0-2] [1s 475ms] Http1AsyncReceiver(SocketTube(1)) Subscribed pending jdk.internal.net.http.Http1Response$HeadersReader@3d5278c0 queue.isEmpty: true
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver handlePendingDelegate
FINE: [JdkHttpClient-0-2] [1s 475ms] Http1AsyncReceiver(SocketTube(1)) delegate is now jdk.internal.net.http.Http1Response$HeadersReader@3d5278c0, demand=1, canRequestMore=true, queue.isEmpty=true
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver hasDemand
FINE: [JdkHttpClient-0-2] [1s 475ms] Http1AsyncReceiver(SocketTube(1)) downstream subscription demand is 1
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver checkRequestMore
FINE: [JdkHttpClient-0-2] [1s 476ms] Http1AsyncReceiver(SocketTube(1)) checkRequestMore: canRequestMore=true, hasDemand=true
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver hasDemand
FINE: [JdkHttpClient-0-2] [1s 476ms] Http1AsyncReceiver(SocketTube(1)) downstream subscription demand is 1
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver checkRequestMore
FINE: [JdkHttpClient-0-2] [1s 476ms] Http1AsyncReceiver(SocketTube(1)) checkRequestMore: canRequestMore=true, hasDemand=true
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange sendHeadersAsync
FINE: [JdkHttpClient-0-2] [1s 476ms] Http1Exchange response created in advance
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange connectFlows
FINE: [JdkHttpClient-0-2] [1s 476ms] Http1Exchange SocketTube(1) connecting flows
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe
FINE: [HttpClient-1-SelectorManager] [1s 477ms] Http1AsyncReceiver(SocketTube(1)) Received onSubscribed from upstream
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher subscribe
FINE: [JdkHttpClient-0-2] [1s 477ms] Http1Publisher(SocketTube(1)) got subscriber: SocketTube(1)
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange lambda$sendHeadersAsync$4
FINE: [JdkHttpClient-0-2] [1s 478ms] Http1Exchange requestAction.headers
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$Http1WriteSubscription request
FINE: [JdkHttpClient-0-0] [1s 478ms] Http1Publisher(SocketTube(1)) subscription request(1), demand=1
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver hasDemand
FINE: [JdkHttpClient-0-1] [1s 478ms] Http1AsyncReceiver(SocketTube(1)) downstream subscription demand is 1
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$WriteTask run
FINE: [JdkHttpClient-0-0] [1s 478ms] Http1Publisher(SocketTube(1)) WriteTask
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver checkRequestMore
FINE: [JdkHttpClient-0-1] [1s 478ms] Http1AsyncReceiver(SocketTube(1)) checkRequestMore: canRequestMore=true, hasDemand=true
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange lambda$sendHeadersAsync$4
FINE: [JdkHttpClient-0-2] [1s 478ms] Http1Exchange setting outgoing with headers
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber requestMore
FINE: [JdkHttpClient-0-1] [1s 478ms] Http1AsyncReceiver(SocketTube(1)) Http1TubeSubscriber: requesting one more from upstream
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$WriteTask run
FINE: [JdkHttpClient-0-0] [1s 478ms] Http1Publisher(SocketTube(1)) hasOutgoing = false
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange appendToOutgoing
FINE: [JdkHttpClient-0-2] [1s 479ms] Http1Exchange appending to outgoing DataPair [data=[java.nio.HeapByteBuffer[pos=0 lim=310 cap=310]], throwable=null]
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$WriteTask run
FINE: [JdkHttpClient-0-2] [1s 479ms] Http1Publisher(SocketTube(1)) WriteTask
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$WriteTask run
FINE: [JdkHttpClient-0-2] [1s 479ms] Http1Publisher(SocketTube(1)) hasOutgoing = true
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange getOutgoing
FINE: [JdkHttpClient-0-2] [1s 479ms] Http1Exchange initiating completion of headersSentCF
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$WriteTask run
FINE: [JdkHttpClient-0-2] [1s 480ms] Http1Publisher(SocketTube(1)) onNext with 310 bytes
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$Http1WriteSubscription request
FINE: [JdkHttpClient-0-2] [1s 480ms] Http1Publisher(SocketTube(1)) subscription request(1), demand=1
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$WriteTask run
FINE: [JdkHttpClient-0-2] [1s 480ms] Http1Publisher(SocketTube(1)) WriteTask
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$WriteTask run
FINE: [JdkHttpClient-0-2] [1s 481ms] Http1Publisher(SocketTube(1)) hasOutgoing = false
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Exchange checkFor407
FINE: [JdkHttpClient-0-2] [1s 481ms] Exchange checkFor407: all clear
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Exchange sendRequestBody
FINE: [JdkHttpClient-0-2] [1s 481ms] Exchange sendRequestBody
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange sendBodyAsync
FINE: [JdkHttpClient-0-2] [1s 481ms] Http1Exchange sendBodyAsync
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange sendBodyAsync
FINE: [JdkHttpClient-0-2] [1s 482ms] Http1Exchange bodySubscriber is null
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange appendToOutgoing
FINE: [JdkHttpClient-0-2] [1s 482ms] Http1Exchange appending to outgoing DataPair [data=[java.nio.HeapByteBuffer[pos=0 lim=0 cap=0]], throwable=null]
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$WriteTask run
FINE: [JdkHttpClient-0-2] [1s 482ms] Http1Publisher(SocketTube(1)) WriteTask
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$WriteTask run
FINE: [JdkHttpClient-0-2] [1s 482ms] Http1Publisher(SocketTube(1)) hasOutgoing = true
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange getOutgoing
FINE: [JdkHttpClient-0-2] [1s 482ms] Http1Exchange initiating completion of bodySentCF
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange$Http1Publisher$WriteTask run
FINE: [JdkHttpClient-0-2] [1s 483ms] Http1Publisher(SocketTube(1)) completed, stopping jdk.internal.net.http.common.SequentialScheduler@661c085d
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.common.Utils lambda$wrapForDebug$9
FINE: [JdkHttpClient-0-2] [1s 483ms] Http1Exchange sendBodyAsync completed successfully
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Exchange getResponseAsync
FINE: [JdkHttpClient-0-2] [1s 483ms] Http1Exchange reading headers
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response readHeadersAsync
FINE: [JdkHttpClient-0-2] [1s 484ms] Http1Response(id=8, PlainHttpConnection(SocketTube(1))) Reading Headers: (remaining: 0) READING_HEADERS
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response readHeadersAsync
FINE: [JdkHttpClient-0-2] [1s 484ms] Http1Response(id=8, PlainHttpConnection(SocketTube(1))) First time around
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response readHeadersAsync
FINE: [JdkHttpClient-0-2] [1s 484ms] Http1Response(id=8, PlainHttpConnection(SocketTube(1))) headersReader is not yet completed
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient$3 onClose
FINE: Closing websocket
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver asyncReceive
FINE: [HttpClient-1-SelectorManager] [1s 617ms] Http1AsyncReceiver(SocketTube(1)) Putting 120 bytes into the queue
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-2] [1s 618ms] Http1AsyncReceiver(SocketTube(1)) Got 120 bytes for delegate jdk.internal.net.http.Http1Response$HeadersReader@3d5278c0
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver hasDemand
FINE: [JdkHttpClient-0-2] [1s 618ms] Http1AsyncReceiver(SocketTube(1)) downstream subscription demand is 1
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-2] [1s 618ms] Http1AsyncReceiver(SocketTube(1)) Forwarding 120 bytes to delegate jdk.internal.net.http.Http1Response$HeadersReader@3d5278c0
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response$HeadersReader handle
FINE: [JdkHttpClient-0-2] [1s 618ms] Http1Response(id=8, PlainHttpConnection(SocketTube(1))) Sending 120/120 bytes to header parser
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response$HeadersReader handle
FINE: [JdkHttpClient-0-2] [1s 619ms] Http1Response(id=8, PlainHttpConnection(SocketTube(1))) Parsing headers completed. bytes=108
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver unsubscribe
FINE: [JdkHttpClient-0-2] [1s 619ms] Http1AsyncReceiver(SocketTube(1)) Unsubscribed jdk.internal.net.http.Http1Response$HeadersReader@3d5278c0
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response lambda$readHeadersAsync$0
FINE: [JdkHttpClient-0-2] [1s 619ms] Http1Response(id=8, PlainHttpConnection(SocketTube(1))) Reading Headers: creating Response object; state is now READING_BODY
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.common.Utils lambda$wrapForDebug$9
FINE: [JdkHttpClient-0-2] [1s 619ms] Http1Exchange getResponseAsync completed successfully
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response readBody
FINE: [JdkHttpClient-0-2] [1s 619ms] Http1Response(id=8, PlainHttpConnection(SocketTube(1))) readBody: return2Cache: true
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response$ClientRefCountTracker acquire
FINE: [JdkHttpClient-0-2] [1s 619ms] Http1Response(id=8, PlainHttpConnection(SocketTube(1))) Operation started: incrementing ref count for jdk.internal.net.http.HttpClientImpl@1ccc9a80(1)
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver subscribe
FINE: [JdkHttpClient-0-2] [1s 620ms] Http1AsyncReceiver(SocketTube(1)) Subscribed pending jdk.internal.net.http.Http1Response$BodyReader@6b3e69f4/parser=jdk.internal.net.http.ResponseContent$FixedLengthBodyParser@5059f85f queue.isEmpty: false
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-2] [1s 620ms] Http1AsyncReceiver(SocketTube(1)) Delegate done: 12
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.ResponseContent$FixedLengthBodyParser onSubscribe
FINE: [JdkHttpClient-0-2] [1s 620ms] PlainHttpConnection(SocketTube(1))/ResponseContent/FixedLengthBodyParser length=12, onSubscribe: jdk.internal.net.http.Http1Response$Http1BodySubscriber
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver handlePendingDelegate
FINE: [JdkHttpClient-0-2] [1s 620ms] Http1AsyncReceiver(SocketTube(1)) delegate is now jdk.internal.net.http.Http1Response$BodyReader@6b3e69f4/parser=jdk.internal.net.http.ResponseContent$FixedLengthBodyParser@5059f85f, demand=9223372036854775807, canRequestMore=false, queue.isEmpty=false
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-2] [1s 620ms] Http1AsyncReceiver(SocketTube(1)) Got 12 bytes for delegate jdk.internal.net.http.Http1Response$BodyReader@6b3e69f4/parser=jdk.internal.net.http.ResponseContent$FixedLengthBodyParser@5059f85f
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver hasDemand
FINE: [JdkHttpClient-0-2] [1s 621ms] Http1AsyncReceiver(SocketTube(1)) downstream subscription demand is 9223372036854775807
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-2] [1s 621ms] Http1AsyncReceiver(SocketTube(1)) Forwarding 12 bytes to delegate jdk.internal.net.http.Http1Response$BodyReader@6b3e69f4/parser=jdk.internal.net.http.ResponseContent$FixedLengthBodyParser@5059f85f
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response$BodyReader handle
FINE: [JdkHttpClient-0-2] [1s 621ms] Http1Response(id=8, PlainHttpConnection(SocketTube(1))) Sending 12/120 bytes to body parser
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.ResponseContent$FixedLengthBodyParser accept
FINE: [JdkHttpClient-0-2] [1s 621ms] PlainHttpConnection(SocketTube(1))/ResponseContent/FixedLengthBodyParser Parser got 12 bytes (12 remaining / 12)
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.ResponseContent$FixedLengthBodyParser accept
FINE: [JdkHttpClient-0-2] [1s 621ms] PlainHttpConnection(SocketTube(1))/ResponseContent/FixedLengthBodyParser Parser got all expected bytes: completing
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver clear
FINE: [JdkHttpClient-0-2] [1s 621ms] Http1AsyncReceiver(SocketTube(1)) cleared
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response onFinished
FINE: [JdkHttpClient-0-2] [1s 622ms] Http1Response(id=8, PlainHttpConnection(SocketTube(1))) SocketTube(1): return to HTTP/1.1 pool
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber dropSubscription
FINE: [HttpClient-1-SelectorManager] [1s 622ms] Http1AsyncReceiver(SocketTube(1)) Http1TubeSubscriber: dropSubscription
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response lambda$readBody$2
FINE: [JdkHttpClient-0-2] [1s 622ms] Http1Response(id=8, PlainHttpConnection(SocketTube(1))) Finished reading body: READING_BODY
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1Response$ClientRefCountTracker tryRelease
FINE: [JdkHttpClient-0-2] [1s 622ms] Http1Response(id=8, PlainHttpConnection(SocketTube(1))) Operation finished: decrementing ref count for jdk.internal.net.http.HttpClientImpl@1ccc9a80(1)
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-2] [1s 623ms] Http1AsyncReceiver(SocketTube(1)) Delegate done: 0
Apr 12, 2024 10:47:31 AM jdk.internal.net.http.Http1AsyncReceiver flush
FINE: [JdkHttpClient-0-2] [1s 623ms] Http1AsyncReceiver(SocketTube(1)) Got 0 bytes for delegate null
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.http.jdk.JdkHttpClient execute0
FINE: Ending request (DELETE) /session/3af0cf27f54127ae63a7501a9cf3044e/window in 154ms
Apr 12, 2024 10:47:31 AM org.openqa.selenium.remote.RemoteWebDriver log
FINE: Executed: close (Response: SessionID: 3af0cf27f54127ae63a7501a9cf3044e, State: success, Value: [])
from selenium.
There is a typo in the URL (it should be https
): htpps://weatherstack.com
from selenium.
FINE: Executing: get [f06a5c9db2e5c84487d9d0f7cef4105e, get {url=htpps://weatherstack.com}]
from selenium.
Related Issues (20)
- [🐛 Bug]: RemoteWebDriver: Basic Auth URLs broken in Java client since 4.14.0 HOT 4
- [🐛 Bug]: RemoteWebDriver - Implementation mismatch since version 4.14.0 HOT 6
- [🐛 Bug]: chromedriver (version 123) on Mac Sonoma getting timed out when going to Wellsfargo.com due to missing font HOT 3
- [🚀 Feature]: Make selenium-manager optional, provided that you can manage it yourself HOT 2
- [🐛 Bug]: Selenium manger in offline mode emits a warning which it should not do. HOT 3
- code issue[🐛 Bug]: HOT 3
- [🚀 Feature]: execute_cdp_cmd allow retrieval of all requests HOT 4
- [🐛 Bug]: (chromedriver.close Excpetion) Я хотел бы сказать что я ошибся чучуть. Ошибка произошла в момент выхода а не перезагрузки xpath... это было намеренное закрытие chromedriver через объект root cd (chrome driver), так как мой проект отработал. И! Браузер когда я пришёл к компьютеру был открыт но объект сайта не был получен, не знаю почему так произошло HOT 4
- [🐛 Bug]: close method on Mobile Browser iPhone15/Safari does not close the browser window HOT 2
- [🐛 Bug]: PrintsPage method fails on Safari HOT 3
- [🐛 Bug]: deleteAllCookies method fails on Safari Driver HOT 4
- [🐛 Bug]: setWindowRect:true fails when passed to Browser Drivers HOT 2
- [🐛 Bug]: Not able to view Grid Dashboard with version 4.19.1 HOT 5
- [🐛 Bug]: Socks5 Proxy (Chrome) HOT 3
- [🐛 Bug]: Selenium is not opening chrome version 123.0.6312.124; error: could not start a new session. Response code: 500. Message: Session not created: This version of chromedriver only supports chrome version 114 HOT 5
- I have tried to run a node on the same machine as the hub and it connects fine HOT 2
- [🐛 Bug]: Grid endpoints fail to delete or drain a registered node HOT 5
- [🐛 Bug]: [Guice/ErrorInjectingConstructor]: SessionNotCreatedException: Could not start a new session. Response code 500. Message: session not created: Chrome failed to start: exited normally. HOT 4
- [🐛 Bug]: Click() function is not working while running the code but in debug mode it is working fine. HOT 17
Recommend Projects
-
React
A declarative, efficient, and flexible JavaScript library for building user interfaces.
-
Vue.js
🖖 Vue.js is a progressive, incrementally-adoptable JavaScript framework for building UI on the web.
-
Typescript
TypeScript is a superset of JavaScript that compiles to clean JavaScript output.
-
TensorFlow
An Open Source Machine Learning Framework for Everyone
-
Django
The Web framework for perfectionists with deadlines.
-
Laravel
A PHP framework for web artisans
-
D3
Bring data to life with SVG, Canvas and HTML. 📊📈🎉
-
Recommend Topics
-
javascript
JavaScript (JS) is a lightweight interpreted programming language with first-class functions.
-
web
Some thing interesting about web. New door for the world.
-
server
A server is a program made to process requests and deliver data to clients.
-
Machine learning
Machine learning is a way of modeling and interpreting data that allows a piece of software to respond intelligently.
-
Visualization
Some thing interesting about visualization, use data art
-
Game
Some thing interesting about game, make everyone happy.
Recommend Org
-
Facebook
We are working to build community through open source technology. NB: members must have two-factor auth.
-
Microsoft
Open source projects and samples from Microsoft.
-
Google
Google ❤️ Open Source for everyone.
-
Alibaba
Alibaba Open Source for everyone
-
D3
Data-Driven Documents codes.
-
Tencent
China tencent open source team.
from selenium.