Udara Liyanage created STRATOS-481:
--------------------------------------
Summary: class endpoint Exception after a load test
Key: STRATOS-481
URL: https://issues.apache.org/jira/browse/STRATOS-481
Project: Stratos
Issue Type: Bug
Components: Load Balancer
Affects Versions: 4.0.0 Alpha
Reporter: Udara Liyanage
[2014-02-25 21:50:01,065] DEBUG - LoadBalancerStatisticsNotifier In-flight
request count published to cep: [cluster-id] pak.php.domain [network-partition]
ec2 [value] 0
[2014-02-25 21:50:16,065] DEBUG - LoadBalancerStatisticsNotifier Publishing
load balancer statistics
[2014-02-25 21:50:16,066] DEBUG - LoadBalancerStatisticsNotifier In-flight
request count published to cep: [cluster-id] pak.php.domain [network-partition]
ec2 [value] 0
[2014-02-25 21:50:31,066] DEBUG - LoadBalancerStatisticsNotifier Publishing
load balancer statistics
[2014-02-25 21:50:31,066] DEBUG - LoadBalancerStatisticsNotifier In-flight
request count published to cep: [cluster-id] pak.php.domain [network-partition]
ec2 [value] 0
[2014-02-25 21:50:46,066] DEBUG - LoadBalancerStatisticsNotifier Publishing
load balancer statistics
[2014-02-25 21:50:46,067] DEBUG - LoadBalancerStatisticsNotifier In-flight
request count published to cep: [cluster-id] pak.php.domain [network-partition]
ec2 [value] 0
[2014-02-25 21:51:01,067] DEBUG - LoadBalancerStatisticsNotifier Publishing
load balancer statistics
[2014-02-25 21:51:01,067] DEBUG - LoadBalancerStatisticsNotifier In-flight
request count published to cep: [cluster-id] pak.php.domain [network-partition]
ec2 [value] 0
[2014-02-25 21:51:16,067] DEBUG - LoadBalancerStatisticsNotifier Publishing
load balancer statistics
[2014-02-25 21:51:16,067] DEBUG - LoadBalancerStatisticsNotifier In-flight
request count published to cep: [cluster-id] pak.php.domain [network-partition]
ec2 [value] 0
[2014-02-25 21:51:31,068] DEBUG - LoadBalancerStatisticsNotifier Publishing
load balancer statistics
[2014-02-25 21:51:31,068] DEBUG - LoadBalancerStatisticsNotifier In-flight
request count published to cep: [cluster-id] pak.php.domain [network-partition]
ec2 [value] 0
[2014-02-25 21:51:46,068] DEBUG - LoadBalancerStatisticsNotifier Publishing
load balancer statistics
[2014-02-25 21:51:46,068] DEBUG - LoadBalancerStatisticsNotifier In-flight
request count published to cep: [cluster-id] pak.php.domain [network-partition]
ec2 [value] 0
[2014-02-25 21:52:01,069] DEBUG - LoadBalancerStatisticsNotifier Publishing
load balancer statistics
[2014-02-25 21:52:01,069] DEBUG - LoadBalancerStatisticsNotifier In-flight
request count published to cep: [cluster-id] pak.php.domain [network-partition]
ec2 [value] 0
[2014-02-25 21:52:16,069] DEBUG - LoadBalancerStatisticsNotifier Publishing
load balancer statistics
[2014-02-25 21:52:16,069] DEBUG - LoadBalancerStatisticsNotifier In-flight
request count published to cep: [cluster-id] pak.php.domain [network-partition]
ec2 [value] 0
[2014-02-25 21:52:31,070] DEBUG - LoadBalancerStatisticsNotifier Publishing
load balancer statistics
[2014-02-25 21:52:31,070] DEBUG - LoadBalancerStatisticsNotifier In-flight
request count published to cep: [cluster-id] pak.php.domain [network-partition]
ec2 [value] 0
[2014-02-25 21:52:38,239] DEBUG - SynapseMessageReceiver Synapse received a new
message for message mediation...
[2014-02-25 21:52:38,239] DEBUG - SynapseMessageReceiver Received To:
/www/test2.php
[2014-02-25 21:52:38,239] DEBUG - SynapseMessageReceiver SOAPAction: null
[2014-02-25 21:52:38,239] DEBUG - SynapseMessageReceiver WSA-Action: null
[2014-02-25 21:52:38,239] DEBUG - Axis2SynapseEnvironment Injecting
MessageContext
[2014-02-25 21:52:38,239] DEBUG - Axis2SynapseEnvironment Using Main Sequence
for injected message
[2014-02-25 21:52:38,239] DEBUG - SequenceMediator Start : Sequence <main>
[2014-02-25 21:52:38,239] DEBUG - SequenceMediator Setting the onError handler
: fault for the sequence : main
[2014-02-25 21:52:38,239] DEBUG - SequenceMediator Sequence <SequenceMediator>
:: mediate()
[2014-02-25 21:52:38,239] DEBUG - SequenceMediator Mediation started from
mediator position : 0
[2014-02-25 21:52:38,239] DEBUG - InMediator Start : In mediator
[2014-02-25 21:52:38,239] DEBUG - InMediator Current message is incoming -
executing child mediators
[2014-02-25 21:52:38,239] DEBUG - InMediator Sequence <InMediator> :: mediate()
[2014-02-25 21:52:38,239] DEBUG - InMediator Mediation started from mediator
position : 0
[2014-02-25 21:52:38,239] DEBUG - PropertyMediator Start : Property mediator
[2014-02-25 21:52:38,239] DEBUG - PropertyMediator Setting property :
SERVICE_PREFIX at scope : default to : http://10.142.214.25:8280/ (i.e. result
of expression : $axis2:SERVICE_PREFIX)
[2014-02-25 21:52:38,239] DEBUG - PropertyMediator End : Property mediator
[2014-02-25 21:52:38,239] DEBUG - SendMediator Start : Send mediator
[2014-02-25 21:52:38,239] DEBUG - ClassEndpoint Start sending message
[2014-02-25 21:52:38,239] DEBUG - HttpSessionDispatcher Extracted Host Name :
pak.isuruh.lk
[2014-02-25 21:52:38,239] DEBUG - HttpSessionDispatcher Endpoint Address :
/www/test2.php
[2014-02-25 21:52:38,239] DEBUG - HttpSessionDispatcher Content Type : null
[2014-02-25 21:52:38,239] DEBUG - HttpSessionDispatcher A request received with
the Host Name : pak.isuruh.lk:8280
[2014-02-25 21:52:38,240] DEBUG - HttpSessionDispatcher Couldn't find the
Cookie header to find the session
[2014-02-25 21:52:38,240] DEBUG - HttpSessionDispatcher Did not find a session
info obj.
[2014-02-25 21:52:38,240] DEBUG - TenantAwareLoadBalanceEndpoint Multi-tenancy
enabled, scanning URL for tenant...
[2014-02-25 21:52:38,240] DEBUG - TenantAwareLoadBalanceEndpoint Request URL:
/www/test2.php
[2014-02-25 21:52:38,240] DEBUG - TenantAwareLoadBalanceEndpoint Tenant
identifier regex: t/([^/]*)/
[2014-02-25 21:52:38,240] DEBUG - TenantAwareLoadBalanceEndpoint Tenant
identifier not found in URL
[2014-02-25 21:52:38,240] WARN - SynapseMessageReceiver Executing fault
handler due to exception encountered
[2014-02-25 21:52:38,242] WARN - FaultHandler ERROR_CODE : 0
[2014-02-25 21:52:38,242] WARN - FaultHandler ERROR_MESSAGE : Error occured
when execute the class endpoint
[2014-02-25 21:52:38,242] WARN - FaultHandler ERROR_DETAIL :
org.apache.synapse.SynapseException: Error occured when execute the class
endpoint
at
org.apache.synapse.endpoints.ClassEndpoint.send(ClassEndpoint.java:89)
at
org.apache.synapse.mediators.builtin.SendMediator.mediate(SendMediator.java:97)
at
org.apache.synapse.mediators.AbstractListMediator.mediate(AbstractListMediator.java:77)
at
org.apache.synapse.mediators.AbstractListMediator.mediate(AbstractListMediator.java:47)
at
org.apache.synapse.mediators.filters.InMediator.mediate(InMediator.java:61)
at
org.apache.synapse.mediators.AbstractListMediator.mediate(AbstractListMediator.java:77)
at
org.apache.synapse.mediators.AbstractListMediator.mediate(AbstractListMediator.java:47)
at
org.apache.synapse.mediators.base.SequenceMediator.mediate(SequenceMediator.java:131)
at
org.apache.synapse.core.axis2.Axis2SynapseEnvironment.injectMessage(Axis2SynapseEnvironment.java:228)
at
org.apache.synapse.core.axis2.SynapseMessageReceiver.receive(SynapseMessageReceiver.java:83)
at org.apache.axis2.engine.AxisEngine.receive(AxisEngine.java:180)
at
org.apache.synapse.transport.passthru.ServerWorker.processNonEntityEnclosingRESTHandler(ServerWorker.java:336)
at
org.apache.synapse.transport.passthru.ServerWorker.run(ServerWorker.java:168)
at
org.apache.axis2.transport.base.threads.NativeWorkerPool$1.run(NativeWorkerPool.java:172)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603)
at java.lang.Thread.run(Thread.java:722)
Caused by: java.lang.NullPointerException
at
org.apache.stratos.load.balancer.cache.LoadBalancerCache.getInteger(LoadBalancerCache.java:121)
at
org.apache.stratos.load.balancer.cache.AlgorithmContextCache.getCurrentMemberIndex(AlgorithmContextCache.java:43)
at
org.apache.stratos.load.balancer.algorithm.AlgorithmContext.getCurrentMemberIndex(AlgorithmContext.java:47)
at
org.apache.stratos.load.balancer.algorithm.RoundRobin.getNextMember(RoundRobin.java:53)
at
org.apache.stratos.load.balancer.RequestDelegator.findNextMemberInCluster(RequestDelegator.java:99)
at
org.apache.stratos.load.balancer.RequestDelegator.findNextMemberFromHostName(RequestDelegator.java:54)
at
org.apache.stratos.load.balancer.endpoint.TenantAwareLoadBalanceEndpoint.findNextMember(TenantAwareLoadBalanceEndpoint.java:216)
at
org.apache.stratos.load.balancer.endpoint.TenantAwareLoadBalanceEndpoint.send(TenantAwareLoadBalanceEndpoint.java:124)
at
org.apache.synapse.endpoints.ClassEndpoint.send(ClassEndpoint.java:87)
... 16 more
[2014-02-25 21:52:38,242] WARN - FaultHandler ERROR_EXCEPTION :
org.apache.synapse.SynapseException: Error occured when execute the class
endpoint
[2014-02-25 21:52:38,242] WARN - FaultHandler FaultHandler :
org.apache.synapse.mediators.MediatorFaultHandler@59f91f38
[2014-02-25 21:52:38,242] WARN - MediatorFaultHandler Executing fault handler
mediator : fault
[2014-02-25 21:52:38,242] DEBUG - SequenceMediator Start : Sequence <fault>
[2014-02-25 21:52:38,242] DEBUG - SequenceMediator Sequence <SequenceMediator>
:: mediate()
[2014-02-25 21:52:38,242] DEBUG - SequenceMediator Mediation started from
mediator position : 0
[2014-02-25 21:52:38,242] DEBUG - ScriptMediator Start : Script mediator
[2014-02-25 21:52:38,242] DEBUG - ScriptMediator Scripting language : js source
: specified inline function : mediate
[2014-02-25 21:52:38,246] DEBUG - ScriptMediator End : Script mediator return
value : true
[2014-02-25 21:52:38,246] DEBUG - SwitchMediator Start : Switch mediator
[2014-02-25 21:52:38,246] DEBUG - SwitchMediator XPath :
get-property('ERROR_CODE') evaluates to : 0
[2014-02-25 21:52:38,247] DEBUG - SwitchMediator None of the switch cases
matched - executing default
[2014-02-25 21:52:38,247] DEBUG - AnonymousListMediator Sequence
<AnonymousListMediator> :: mediate()
[2014-02-25 21:52:38,247] DEBUG - AnonymousListMediator Mediation started from
mediator position : 0
[2014-02-25 21:52:38,247] DEBUG - PropertyMediator Start : Property mediator
[2014-02-25 21:52:38,247] DEBUG - PropertyMediator Setting property : HTTP_SC
at scope : axis2 to : 500 (i.e. constant : 500)
[2014-02-25 21:52:38,247] DEBUG - PropertyMediator End : Property mediator
[2014-02-25 21:52:38,247] DEBUG - PropertyMediator Start : Property mediator
[2014-02-25 21:52:38,247] DEBUG - PropertyMediator Removing property :
NO_ENTITY_BODY (scope:axis2)
[2014-02-25 21:52:38,247] DEBUG - PropertyMediator End : Property mediator
[2014-02-25 21:52:38,248] DEBUG - HeaderMediator Start : Header mediator
[2014-02-25 21:52:38,248] DEBUG - HeaderMediator Removing SOAP Header : To
[2014-02-25 21:52:38,248] DEBUG - HeaderMediator End : Header mediator
[2014-02-25 21:52:38,248] DEBUG - PropertyMediator Start : Property mediator
[2014-02-25 21:52:38,248] DEBUG - PropertyMediator Setting property : RESPONSE
at scope : default to : true (i.e. constant : true)
[2014-02-25 21:52:38,248] DEBUG - PropertyMediator End : Property mediator
[2014-02-25 21:52:38,248] DEBUG - PropertyMediator Start : Property mediator
[2014-02-25 21:52:38,248] DEBUG - PropertyMediator Setting property :
messageType at scope : axis2 to : text/html (i.e. constant : text/html)
[2014-02-25 21:52:38,249] DEBUG - PropertyMediator End : Property mediator
[2014-02-25 21:52:38,249] DEBUG - PropertyMediator Start : Property mediator
[2014-02-25 21:52:38,249] DEBUG - PropertyMediator Setting property :
contentType at scope : axis2 to : text/html (i.e. constant : text/html)
[2014-02-25 21:52:38,249] DEBUG - PropertyMediator End : Property mediator
[2014-02-25 21:52:38,249] DEBUG - SendMediator Start : Send mediator
[2014-02-25 21:52:38,249] DEBUG - SendMediator Sending response message using
implicit message properties..
Sending To: null
SOAPAction: null
[2014-02-25 21:52:38,250] DEBUG - SendMediator End : Send mediator
[2014-02-25 21:52:38,250] DEBUG - SequenceMediator End : Sequence <fault>
[2014-02-25 21:52:46,070] DEBUG - LoadBalancerStatisticsNotifier Publishing
load balancer statistics
[2014-02-25 21:52:46,072] DEBUG - LoadBalancerStatisticsNotifier In-flight
request count published to cep: [cluster-id] pak.php.domain [network-partition]
ec2 [value] 0
[2014-02-25 21:53:01,072] DEBUG - LoadBalancerStatisticsNotifier Publishing
load balancer statistics
[2014-02-25 21:53:01,072] DEBUG - LoadBalancerStatisticsNotifier In-flight
request count published to cep: [cluster-id] pak.php.domain [network-partition]
ec2 [value] 0
--
This message was sent by Atlassian JIRA
(v6.1.5#6160)
