Skip to Main Content

General Development Discussions

Announcement

For appeals, questions and feedback about Oracle Forums, please email oracle-forums-moderators_us@oracle.com. Technical questions should be asked in the appropriate category. Thank you!

Error communicating with Oracle Load Testing Agent Manager on oats-am://localhost:9001: Timed out af

marialenaMar 2 2017 — edited Mar 7 2017

Hello,

I want to execute an openScript script in OLT.

  • First of all, I have added my databank and my repository in OLT.
  • In Oracle Load Testing Agent Authentication Manager I have left the default host, on port 9001 and with the correct password I have set during OATS installation, for the JMSAdmin user.

pastedImage_1.png

  • When I select the script I want, the only change I do is to increase the JVM heap size as it was suggested by some other oats users:

pastedImage_10.png

  • The data in my databank can be fetched successfully as you can see below:

pastedImage_11.png

  • In autopilot, I haven't changed any of the default settings:

pastedImage_7.png

  • In Manage-> Systems the validation of my credentials is achieved:

pastedImage_17.png

  • So, the error I get after starting the use's ramp up is:

pastedImage_6.png

  • In /etc/hosts file I have these records:

127.0.0.1 localhost

::1 localhost

my ip address EC2AMAZ-1200TTL

  • Relevant log files:

agentmanager_auth:

2017-03-02 15:07:37,129 INFO [URL:t3://EC2AMAZ-1200TTL:8088;Requestor Username: oats-agent;Requestor Key:e7d13621-de9e-4ee2-a8cf-581122b291c1;Requestor Queue:oracle/oats/queue/AgentPoolNotificationQueue;Request ID:1;Request:startagent;] - authentication successful

2017-03-02 15:09:03,029 INFO [URL:t3://EC2AMAZ-1200TTL:8088;Requestor Username: oats-agent;Requestor Key:e7d13621-de9e-4ee2-a8cf-581122b291c1;Requestor Queue:oracle/oats/queue/AgentPoolNotificationQueue;Request ID:2;Request:stopagent;] - authentication successful

agentmanager:

2017-03-02 15:06:46,733 INFO [AgentManagerAuthenticator] Authentication config has been updated on Thu Mar 02 14:33:11 GMT 2017

2017-03-02 15:06:46,789 INFO [AgentProcessDescriptorManager] Loaded process descriptor <AgentProcessDescriptor

descriptorFile=C:\OracleATS\agentmanager\processDescriptors\DataCollector.properties

typeId=olt-dc-java-agent.exe

exe=C:\OracleATS\jdk\jre\bin\olt-dc-java-agent.exe

workingDir=C:\OracleATS\DataCollector\bin

settingsHandler=oracle.oats.agents.processDescriptors.DataCollector.SettingsHandler />

2017-03-02 15:06:46,795 INFO [AgentProcessDescriptorManager] Loaded process descriptor <AgentProcessDescriptor

descriptorFile=C:\OracleATS\agentmanager\processDescriptors\JavaAgent.properties

typeId=empJAgent.exe

exe=C:\OracleATS\jdk\jre\bin\olt-agent.exe

workingDir=C:\OracleATS\agent

settingsHandler=oracle.oats.agents.processDescriptors.JavaAgent.SettingsHandler />

2017-03-02 15:06:46,801 INFO [AgentProcessDescriptorManager] Loaded process descriptor <AgentProcessDescriptor

descriptorFile=C:\OracleATS\agentmanager\processDescriptors\OpenScript.properties

typeId=openScriptCML.exe

exe=C:\OracleATS\jdk\jre\bin\otm-ose-agent.exe

workingDir=C:\OracleATS\agent

settingsHandler=oracle.oats.agents.processDescriptors.OpenScript.SettingsHandler />

2017-03-02 15:06:46,805 INFO [AgentProcessDescriptorManager] Loaded process descriptor <AgentProcessDescriptor

descriptorFile=C:\OracleATS\agentmanager\processDescriptors\ThirdPartyTest.properties

typeId=thirdPartyTest.exe

exe=C:\OracleATS\jdk\jre\bin\otm-3rdparty-agent.exe

workingDir=C:\OracleATS\agent

settingsHandler=oracle.oats.agents.processDescriptors.ThirdPartyTest.SettingsHandler />

2017-03-02 15:06:46,807 INFO [Messenger] Messenger Loaded....

2017-03-02 15:06:46,808 INFO [EmpStartMain] PortListener Loaded....

2017-03-02 15:06:46,811 INFO [ProcessRunnerFactory] Constructed Generic process runner

2017-03-02 15:06:46,813 INFO [EmpStartMain] EmpStart initialization complete: port=9001, agentManagerDir=C:\OracleATS\agentmanager, version=12.5.0.3.1012

2017-03-02 15:06:47,246 INFO [EmpStartMain] Listening on port: 9001

2017-03-02 15:07:33,037 INFO [Messenger] Try server=t3://EC2AMAZ-1200TTL:8088 destination=oracle/oats/queue/AgentPoolNotificationQueue

2017-03-02 15:07:34,640 INFO [Messenger] Got ConnectionFactory

2017-03-02 15:07:34,656 INFO [Messenger] Got destination oracle/oats/queue/AgentPoolNotificationQueue

2017-03-02 15:07:37,082 INFO [Messenger] Created connection.

2017-03-02 15:07:37,120 INFO [Messenger] Created queue session.

2017-03-02 15:07:37,128 INFO [Messenger] Connected to server=t3://EC2AMAZ-1200TTL:8088 destination=oracle/oats/queue/AgentPoolNotificationQueue

2017-03-02 15:07:37,129 INFO [Request] [URL:t3://EC2AMAZ-1200TTL:8088;Requestor Username: oats-agent;Requestor Key:e7d13621-de9e-4ee2-a8cf-581122b291c1;Requestor Queue:oracle/oats/queue/AgentPoolNotificationQueue;Request ID:1;Request:startagent;] - authentication successful

2017-03-02 15:07:37,130 INFO [EmpStartMain] handleStartAgentRequestRequest ID: 1, RKey: e7d13621-de9e-4ee2-a8cf-581122b291c1, RUrl: t3://EC2AMAZ-1200TTL:8088, RUsername: oats-agent, RQueue : oracle/oats/queue/AgentPoolNotificationQueue, Request: startagent, Agent Type: empJAgent.exe, Agent ID: agId2_rnd4d477687-7229-43c0-87a0-ea5d6afc2a99, Agent Cmd : empJAgent.exe -Xmx1024m -classpath determinedAtRunTime oracle.oats.jagent.EntryPoint jms /token: /id:agId2_rnd4d477687-7229-43c0-87a0-ea5d6afc2a99 /version:12.5.0.3.1012 /clusterurl:t3://EC2AMAZ-1200TTL:8088 /clusterhttpurl:http://EC2AMAZ-1200TTL:8088 /pooltopic:oracle/oats/topic/AgentPoolControlTopic /poolqueue:oracle/oats/queue/AgentPoolNotificationQueue /functionalScript, Agent Checksum: [], Agent Credential Type: default, Version: 12.5.0.3.1012

2017-03-02 15:07:37,130 INFO [SettingsHandler] extracted 'debug' command line params for null: -Xmx1024m

2017-03-02 15:07:37,130 INFO [SettingsHandler] Calculated Java debug arg string for null: -Xdebug -Xrunjdwp:transport=dt_socket,address=8686,server=y,suspend=n

2017-03-02 15:07:37,130 INFO [SettingsHandler] Forcing custom debug arguments: -verbose:gc -XX:+HeapDumpOnOutOfMemoryError -Xms512M

2017-03-02 15:07:37,139 INFO [ProcessRunner]

startAgent(

pathToExe=C:\OracleATS\jdk\jre\bin\olt-agent.exe

cmdLineArgs= -XX:+HeapDumpOnOutOfMemoryError -verbose:gc -XX:+HeapDumpOnOutOfMemoryError -Xms512M -classpath ;C:\OracleATS\agent\jars\EntryPointWrapper.jar;C:\OracleATS\agent\jars\Framework.jar oracle.oats.jagent.EntryPointWrapper oracle.oats.jagent.EntryPoint -installdir C:\OracleATS\jdk\jre\..\.. jms /token: /id:agId2_rnd4d477687-7229-43c0-87a0-ea5d6afc2a99 /version:12.5.0.3.1012 /clusterurl:t3://EC2AMAZ-1200TTL:8088 /clusterhttpurl:http://EC2AMAZ-1200TTL:8088 /pooltopic:oracle/oats/topic/AgentPoolControlTopic /poolqueue:oracle/oats/queue/AgentPoolNotificationQueue /functionalScript

workingDir=C:\OracleATS\agent

agentId=agId2_rnd4d477687-7229-43c0-87a0-ea5d6afc2a99

requestor=e7d13621-de9e-4ee2-a8cf-581122b291c1), returning ID 1)

2017-03-02 15:07:37,143 INFO [EmpStartMain] Exception while starting agent

java.lang.UnsatisfiedLinkError: no WindowsAgentProcess64 in java.library.path

at java.lang.ClassLoader.loadLibrary(ClassLoader.java:1886)

at java.lang.Runtime.loadLibrary0(Runtime.java:849)

at java.lang.System.loadLibrary(System.java:1088)

at oracle.oats.empstart.processrunner.windows.WindowsAgentProcess.<clinit>(WindowsAgentProcess.java:26)

at oracle.oats.empstart.processrunner.solaris.AgentProcessFactory.newAgentProcess(AgentProcessFactory.java:14)

at oracle.oats.empstart.processrunner.solaris.ProcessRunner.launchAgent(ProcessRunner.java:146)

at oracle.oats.empstart.EmpStartMain.handleStartAgentRequest(EmpStartMain.java:737)

at oracle.oats.empstart.EmpStartMain.handleRequest(EmpStartMain.java:1136)

at oracle.oats.empstart.EmpStartMain.<init>(EmpStartMain.java:532)

at oracle.oats.empstart.EmpStartMain.main(EmpStartMain.java:423)

2017-03-02 15:07:54,733 ERROR [EmpStartMain] oracle.oats.empstart.PortListener

javax.net.ssl.SSLHandshakeException: Remote host closed connection during handshake

at sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:946)

at sun.security.ssl.SSLSocketImpl.performInitialHandshake(SSLSocketImpl.java:1312)

at sun.security.ssl.SSLSocketImpl.readDataRecord(SSLSocketImpl.java:882)

at sun.security.ssl.AppInputStream.read(AppInputStream.java:102)

at sun.nio.cs.StreamDecoder.readBytes(StreamDecoder.java:283)

at sun.nio.cs.StreamDecoder.implRead(StreamDecoder.java:325)

at sun.nio.cs.StreamDecoder.read(StreamDecoder.java:177)

at java.io.InputStreamReader.read(InputStreamReader.java:184)

at java.io.BufferedReader.fill(BufferedReader.java:154)

at java.io.BufferedReader.readLine(BufferedReader.java:317)

at java.io.BufferedReader.readLine(BufferedReader.java:382)

at oracle.oats.empstart.PortListener.readFromSocket(PortListener.java:142)

at oracle.oats.empstart.PortListener.run(PortListener.java:90)

at java.lang.Thread.run(Thread.java:745)

Caused by: java.io.EOFException: SSL peer shut down incorrectly

at sun.security.ssl.InputRecord.read(InputRecord.java:482)

at sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:927)

... 13 more

2017-03-02 15:09:02,992 INFO [Messenger] Try server=t3://EC2AMAZ-1200TTL:8088 destination=oracle/oats/queue/AgentPoolNotificationQueue

2017-03-02 15:09:02,998 INFO [Messenger] Got ConnectionFactory

2017-03-02 15:09:02,999 INFO [Messenger] Got destination oracle/oats/queue/AgentPoolNotificationQueue

2017-03-02 15:09:03,027 INFO [Messenger] Created connection.

2017-03-02 15:09:03,028 INFO [Messenger] Created queue session.

2017-03-02 15:09:03,029 INFO [Messenger] Connected to server=t3://EC2AMAZ-1200TTL:8088 destination=oracle/oats/queue/AgentPoolNotificationQueue

2017-03-02 15:09:03,029 INFO [Request] [URL:t3://EC2AMAZ-1200TTL:8088;Requestor Username: oats-agent;Requestor Key:e7d13621-de9e-4ee2-a8cf-581122b291c1;Requestor Queue:oracle/oats/queue/AgentPoolNotificationQueue;Request ID:2;Request:stopagent;] - authentication successful

2017-03-02 15:09:03,030 ERROR [EmpStartMain] Unknown agent ID: agId2_rnd4d477687-7229-43c0-87a0-ea5d6afc2a99

wls_oats:

2017-03-02 15:07:32,446 WARN [OracleActionBase] Starting autopilot

2017-03-02 15:07:32,460 WARN [OracleActionBase] Started autopilot

2017-03-02 15:09:02,944 WARN [AgentPoolCont] Orphaning agent agId2_rnd4d477687-7229-43c0-87a0-ea5d6afc2a99: Error communicating with Oracle Load Testing Agent Manager on oats-am://localhost:9001: Timed out after 90 seconds.

2017-03-02 15:09:02,945 WARN [AgentPoolCont] Issuing a forced stop for agentagId2_rnd4d477687-7229-43c0-87a0-ea5d6afc2a99

  • When I execute in cmd the netstat -a, I believe that all the ports are set up without any problem (correct me if I am wrong):

pastedImage_58.png

  • Due to a problem I had with OTM, I have to stop the ATSAgent service even if it is automatically running, and run from here: C:\OracleATS\agentmanager\bin , the agentmanager.cmd . When I follow this procedure and keep this cmd window open, the OTM works and I can then connect with the helpers, execute the script etc. However, when I run this cmd file all I can see in the window is just a cursor (no wrapper information etc).

pastedImage_70.png

  • If I try to do the same for the OLT, I get the error mentioned above.
  • If I just go to services and start the service manually, while executing the user's ramp up, the service gets stopped by itself.
  • Also, in the services apart from stopping the agent service, in the LogOn section I am using the administrator's credentials which is the user I am logging in with.

pastedImage_82.png

  • All my credentials are correct according to the log files, so I don't know what is wrong.

Please note that I have tried to do the same and use my hostname and my private IP address, instead of localhost for the agent and it keeps failing with the same error.

I would appreciate any help with this, as I have this problem for a long time and I couldn't find any solution yet.

(Sorry for the long post, it just that I know that most of the time in all pos you ask for log files, check with netstat etc.)

This post has been answered by marialena on Mar 7 2017
Jump to Answer
Comments
Locked Post
New comments cannot be posted to this locked post.
Post Details
Locked on Apr 4 2017
Added on Mar 2 2017
1 comment
1,336 views