Hi @John_Carter4 ,
Thank you so much for your advise on doing the extended settings change to get detailed logs on sockets.
I understood from the logs that there will be a socket pool sweeper executes every 60 seconds and If we set pub.client:http KeepaliveTimeout say for 20 seconds.
So, for example there is a socket pool sweeper executed at 3:00:00 PM, at same time IS send http request to target system (New socket is created) and this TCP socket connection is expired at 3:00:20 PM (as per keep alive timeout set to 20 seconds), but socket is not closed at 3:00:20PM. It will get closed at next socket pool sweeper execution i.e. at 3:01:00 PM where sweeper looks for all stale connection to close. Please correct me if my understanding is wrong.
wrapper.log bit below for 278130337:
INFO | jvm 7 | 2022/06/15 15:05:13 | SocketPool> 2022-06-15 15:05:13.594 (tid=1228792482) : *** <NetURLConn> starting request; (retryAvailable=true) (connected=false) (outputopen=false) (postOutput=null)
INFO | jvm 7 | 2022/06/15 15:05:13 | SocketPool> 2022-06-15 15:05:13.594 (tid=1228792482) : <SockPool> sock request for key http@5554@localhost
INFO | jvm 7 | 2022/06/15 15:05:13 | SocketPool> 2022-06-15 15:05:13.594 (tid=1228792482) : socket pool NOT found... creating a new one for key http@5554@localhost; handshake is : true
INFO | jvm 7 | 2022/06/15 15:05:13 | >>>>> Connection attempt SUCCEEDED in 0milli-seconds
INFO | jvm 7 | 2022/06/15 15:05:13 | SocketPool> 2022-06-15 15:05:13.594 (tid=1228792482) : Socketpool is empty... created new socket 278130337
INFO | jvm 7 | 2022/06/15 15:05:13 | SocketPool> 2022-06-15 15:05:13.594 (tid=1228792482) : <NetURLConn> received socket 278130337
INFO | jvm 7 | 2022/06/15 15:05:13 | SocketPool> 2022-06-15 15:05:13.594 (tid=1228792482) : *** <NetURLConn> connected=true (isRetry=false)
INFO | jvm 7 | 2022/06/15 15:05:13 | SocketPool> 2022-06-15 15:05:13.594 (tid=1228792482) : *** <NetURLConn> posted request; starting to read response; ISresponseValid=true
INFO | jvm 7 | 2022/06/15 15:05:13 | SocketPool> 2022-06-15 15:05:13.596 (tid=1228792482) : *** <NetURLConn> response code is : 200
INFO | jvm 7 | 2022/06/15 15:05:13 | SocketPool> 2022-06-15 15:05:13.596 (tid=1228792482) : <put> sock request for key http@5554@localhost
INFO | jvm 7 | 2022/06/15 15:05:13 | SocketPool> 2022-06-15 15:05:13.596 (tid=1228792482) : <SocketPool> adding socket 278130337 to the cache
INFO | jvm 7 | 2022/06/15 15:05:13 | SocketPool> 2022-06-15 15:05:13.596 (tid=1228792482) : *** <HttpURLConn> releasing socket 278130337
INFO | jvm 7 | 2022/06/15 15:05:38 | SocketPool> 2022-06-15 15:05:38.046 (tid=1697219554) : <SocketMonitor> sweeping for stale sockets
INFO | jvm 7 | 2022/06/15 15:05:38 | SocketPool> 2022-06-15 15:05:38.046 (tid=1697219554) : <SocketMonitor> Now processing pool http@5554@localhost (socket count=1)
INFO | jvm 7 | 2022/06/15 15:05:38 | SocketPool> 2022-06-15 15:05:38.051 (tid=1697219554) : <SocketPool> adding socket 278130337 to the cache
INFO | jvm 7 | 2022/06/15 15:05:38 | SocketPool> 2022-06-15 15:05:38.051 (tid=1697219554) : <SocketMonitor> socket 278130337 is NOT Stale
INFO | jvm 7 | 2022/06/15 15:05:38 | SocketPool> 2022-06-15 15:05:38.051 (tid=1697219554) : <SocketMonitor> Finished processing pool http@5554@localhost
INFO | jvm 7 | 2022/06/15 15:06:38 | SocketPool> 2022-06-15 15:06:38.051 (tid=1697219554) : <SocketMonitor> sweeping for stale sockets
INFO | jvm 7 | 2022/06/15 15:06:38 | SocketPool> 2022-06-15 15:06:38.051 (tid=1697219554) : <SocketMonitor> Now processing pool http@5554@localhost (socket count=1)
INFO | jvm 7 | 2022/06/15 15:06:38 | SocketPool> 2022-06-15 15:06:38.051 (tid=1697219554) : <SocketMonitor> socket 278130337 is Stale; closing it
INFO | jvm 7 | 2022/06/15 15:06:38 | SocketPool> 2022-06-15 15:06:38.051 (tid=1697219554) : <SocketMonitor> Closed socket=278130337)
INFO | jvm 7 | 2022/06/15 15:06:38 | SocketPool> 2022-06-15 15:06:38.051 (tid=1697219554) : <SocketMonitor> Finished processing pool http@5554@localhost
INFO | jvm 7 | 2022/06/15 15:07:38 | SocketPool> 2022-06-15 15:07:38.052 (tid=1697219554) : <SocketMonitor> sweeping for stale sockets