[ 
https://issues.apache.org/jira/browse/STRATOS-481?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=13939054#comment-13939054
 ] 

Udara Liyanage commented on STRATOS-481:
----------------------------------------

I got fallowing logs in wso2carbon.log file 

TID: [0] [LB] [2014-03-18 16:28:32,823] DEBUG 
{org.apache.stratos.load.balancer.endpoint.TenantAwareLoadBalanceEndpoint} -  
Multi-tenancy enabled, scanning URL for tenant... 
TID: [0] [LB] [2014-03-18 16:28:32,823] DEBUG 
{org.apache.stratos.load.balancer.endpoint.TenantAwareLoadBalanceEndpoint} -  
Request URL: /t/abc.com/webapps/example/jsp/jsp2/tagfiles/hello.jsp  
TID: [0] [LB] [2014-03-18 16:28:32,824] DEBUG 
{org.apache.stratos.load.balancer.endpoint.TenantAwareLoadBalanceEndpoint} -  
Tenant identifier regex: t/([^/]*)/  
TID: [0] [LB] [2014-03-18 16:28:32,824] DEBUG 
{org.apache.stratos.load.balancer.endpoint.TenantAwareLoadBalanceEndpoint} -  
Identifying tenant using tenant domain... 
TID: [0] [LB] [2014-03-18 16:28:32,824] DEBUG 
{org.apache.stratos.load.balancer.endpoint.TenantAwareLoadBalanceEndpoint} -  
Tenant identifier found: [tenant-domain] abc.com [tenant-id] -1 

And in wso2-elb.log 

2014-03-18 16:28:12,192 [-] [PassThroughMessageProcessor-226]  WARN 
__SynapseService Executing fault sequence mediator : fault
2014-03-18 16:28:32,825 [-] [PassThroughMessageProcessor-229]  WARN 
__SynapseService Executing fault handler due to exception encountered
2014-03-18 16:28:32,825 [-] [PassThroughMessageProcessor-229]  WARN 
__SynapseService ERROR_CODE : 0 ERROR_MESSAGE : Error occured when execute the 
class endpoint
2014-03-18 16:28:32,825 [-] [PassThroughMessageProcessor-229]  WARN 
__SynapseService Executing fault sequence mediator : fault


> 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
>            Reporter: Udara Liyanage
>            Assignee: Imesh Gunaratne
>             Fix For: 4.0.0 Alpha
>
>
> [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.2#6252)

Reply via email to