Hi Udara,
Can you attach the agent log?
Thanks.
On Mon, Dec 22, 2014 at 1:04 PM, Udara Liyanage <ud...@wso2.com> wrote:
> Hi raj,
>
> I tested with lates python code base. This time member is in topology and
> instance spawned event is also received. But yet instance activated is not
> sent.
>
> *1) Instance started event received*
>
> 2014-12-22 12:53:49,904:DEBUG:Property added: [key] STRATOS_
> MEMBER_PROPERTY_PRIMARY[value] false
> 2014-12-22 12:53:49,911:DEBUG:Message received:
> 'instance/status/InstanceStartedEvent':
> '{\n "clusterId": "mytomcat.tomcat.domain", \n "clusterInstanceId":
> "app_cartridge_v1-1", \n "instanceId": "", \n "memberId":
> "mytomcat.tomcat.domain5dd544b1-d2d6-4ace-8e31-ecb07e116130", \n
> "networkPartitionId": "p1", \n "partitionId": "P1", \n
> "serviceName": "tomcat"\n}'
>
> 2) Member in topology
>
> *Complete Topology:*
>
>
> '{"topology":{"serviceMap":{"tomcat":{"serviceName":"tomcat","serviceType":"SingleTenant","clusterIdClusterMap":{"mytomcat.tomcat.domain":{"serviceName":"tomcat","clusterId":"mytomcat.tomcat.domain","autoscalePolicyName":"autoscale_policy_1","hostNames":["
> mytomcat.isuruh.lk
> "],"tenantRange":"*","isLbCluster":false,"isKubernetesCluster":false,"memberMap":{"mytomcat.tomcat.domain5dd544b1-d2d6-4ace-8e31-ecb07e116130":{"serviceName":"tomcat","clusterId":"mytomcat.tomcat.domain","memberId":"
> *mytomcat.tomcat.domain5dd544b1-d2d6-4ace-8e31-ecb07e116130*
> ","instanceId":"ap-southeast-1/i-0147e4cc","clusterInstanceId":"app_cartridge_v1-1","networkPartitionId":"p1","partitionId":"P1","initTime":1419232682397,"portMap":{"443":{"protocol":"https","value":443,"proxy":443},"80":{"protocol":"http","value":80,"proxy":80}},"memberPublicIPs":["54.254.118.165"],"defaultPublicIP":"54.254.118.165","memberPrivateIPs":["10.144.150.199"],"defaultPrivateIP":"10.144.150.199","properties":{"PRIMARY":"false","MIN_COUNT":"1"},"memberStateManager":{"stateStack":["Created","Starting"],"identifier":"mytomcat.tomcat.domain5dd544b1-d2d6-4ace-8e31-ecb07e116130"}}},"appId":"app_cartridge_v1","properties":{},"instanceIdToInstanceContextMap":{"app_cartridge_v1-1":{"instanceId":"app_cartridge_v1-1","instanceProperties":{},"lifeCycleStateManager":{"stateStack":["Created"],"identifier":"mytomcat.tomcat.domain_app_cartridge_v1-1"},"networkPartitionId":"p1"}}}},"portMap":{"443":{"protocol":"https","value":443,"proxy":443},"80":{"protocol":"http","value":80,"proxy":80}},"properties":{}}},"initialized":false}}'
>
> *Payload:*
> APP_ID=app_cartridge_v1,GROUP_NAME=null,SERVICE_NAME=tomcat,HOST_NAME=
> mytomcat.isuruh.lk
> ,MULTITENANT=false,TENANT_ID=-1234,TENANT_RANGE=*,CARTRIDGE_ALIAS=mytomcat,CLUSTER_ID=mytomcat.tomcat.domain,CARTRIDGE_KEY=kYcZ4B4DPAeA1RGz,REPO_URL=
> https://github.com/udaraliyanage/php,PORTS=80|443,PROVIDER=apache,PUPPET_IP=10.148.159.109,PUPPET_HOSTNAME=ip-10-148-159-109.ap-southeast-1.compute.internal,PUPPET_DNS_AVAILABLE=null,PUPPET_ENV=null,,,DEPLOYMENT=default,TOKEN=eyJhbGciOiJSUzI1NiJ9.eyJleHAiOjE4OTY4OTAwNDgsInN1YiI6ImFkbWluIiwiYXpwIjoiMjU1UUZET1UwbFlONmY5NE44aUVhQm5LdlBrYSIsImFwcElkIjoiYXBwX2NhcnRyaWRnZV92MSIsImF1ZCI6WyIyNTVRRkRPVTBsWU42Zjk0TjhpRWFCbkt2UGthIl0sImlzcyI6Imh0dHBzOlwvXC9sb2NhbGhvc3Q6OTQ0M1wvb2F1dGgyZW5kcG9pbnRzXC90b2tlbiIsImlhdCI6MTg5MzI5MDA0OH0.XB4wg8gQxzyH0jv5EIiWFjOG0VDZuFBswYG0G6zX3sjOEgXauywoga4pHmb9DWkKZU9nD5qRFLRyyiHi2onWr-TGtLNBn4qgRq94VDwjVgx5in4ND3f7q-xNSpLipMr_g_gtkbp9st-gZVeuB8y3u7jnjE8fuDEs63pQ75Drrhs,MEMBER_ID=
> *mytomcat.tomcat.domain5dd544b1-d2d6-4ace-8e31-ecb07e116130*
> ,INSTANCE_ID=null,CLUSTER_INSTANCE_ID=app_cartridge_v1-1,LB_CLUSTER_ID=null,NETWORK_PARTITION_ID=p1,PARTITION_ID=P1,PRIMARY=false,MIN_COUNT=1
>
> Carbon logs:
>
> [2014-12-22 07:18:41,444] INFO
> {org.apache.stratos.cloud.controller.messaging.publisher.TopologyEventPublisher}
> - Publishing instance spawned event: [service-name] tomcat [cluster-id]
> mytomcat.tomcat.domain [cluster-instance-id] app_cartridge_v1-1 [member-id]
> mytomcat.tomcat.domain5dd544b1-d2d6-4ace-8e31-ecb07e116130 [instance-id]
> ap-southeast-1/i-0147e4cc [network-partition-id] p1 [partition-id] P1
> [lb-cluster-id] null
> [2014-12-22 07:18:41,464] INFO
> {org.apache.stratos.messaging.domain.topology.lifecycle.LifeCycleStateManager}
> - Life Cycle State Manager started for Element [
> mytomcat.tomcat.domain5dd544b1-d2d6-4ace-8e31-ecb07e116130 ], initial
> state: Created
> [2014-12-22 07:18:41,469] INFO
> {org.apache.stratos.messaging.message.processor.topology.InstanceSpawnedMessageProcessor}
> - Member created: [service] tomcat [cluster] mytomcat.tomcat.domain
> [member] mytomcat.tomcat.domain5dd544b1-d2d6-4ace-8e31-ecb07e116130
> [instance] ap-southeast-1/i-0147e4cc [hierarchy-instance] app_cartridge_v1-1
> [2014-12-22 07:18:41,480] INFO
> {org.apache.stratos.manager.topology.receiver.StratosManagerTopologyEventReceiver}
> - [InstanceSpawnedEventListener] Received: class
> org.apache.stratos.messaging.event.topology.InstanceSpawnedEvent
> [2014-12-22 07:24:01,218] INFO
> {org.apache.stratos.manager.listener.InstanceStatusListener} - Instance
> status message received
> [2014-12-22 07:24:01,218] INFO
> {org.apache.stratos.manager.listener.InstanceStatusListener} - Event class
> name:
> org.apache.stratos.messaging.event.instance.status.InstanceStartedEvent
> [2014-12-22 07:24:01,219] INFO
> {org.apache.stratos.manager.listener.InstanceStatusListener} - Cluster id:
> mytomcat.tomcat.domain
> [2014-12-22 07:24:01,220] INFO
> {org.apache.stratos.cloud.controller.messaging.topology.TopologyBuilder} -
> member started event adding status started
> [2014-12-22 07:24:01,235] INFO
> {org.apache.stratos.cloud.controller.messaging.publisher.TopologyEventPublisher}
> - Publishing member started event: [service-name] tomcat [cluster-id]
> mytomcat.tomcat.domain [cluster-instance-id] app_cartridge_v1-1 [member-id]
> mytomcat.tomcat.domain5dd544b1-d2d6-4ace-8e31-ecb07e116130 [instance-id]
> [network-partition-id] p1 [partition-id] P1
> [2014-12-22 07:24:01,250] INFO
> {org.apache.stratos.messaging.message.processor.topology.MemberStartedMessageProcessor}
> - Member started: [service] tomcat [cluster] mytomcat.tomcat.domain
> [member] mytomcat.tomcat.domain5dd544b1-d2d6-4ace-8e31-ecb07e116130
> [2014-12-22 07:24:01,250] INFO
> {org.apache.stratos.manager.topology.receiver.StratosManagerTopologyEventReceiver}
> - [MemberStartedEventListener] Received: class
> org.apache.stratos.messaging.event.topology.MemberStartedEvent
>
>
>
> On Mon, Dec 22, 2014 at 12:26 PM, Udara Liyanage <ud...@wso2.com> wrote:
>>
>> Hi Raj,
>>
>> Thanks for the info. I will check with updated agent.
>>
>> On Mon, Dec 22, 2014 at 12:24 PM, Rajkumar Rajaratnam <rajkum...@wso2.com
>> > wrote:
>>>
>>> Hi Udara,
>>>
>>> Are you using the latest python agent?
>>>
>>> Chamila changed the agent yesterday. Member object doesn't have an
>>> attribute called "memberIp anymore. It has been changed to defaultPrivateIP.
>>>
>>> Latest python agent has this changes.
>>>
>>> Thanks.
>>>
>>> On Mon, Dec 22, 2014 at 12:22 PM, Rajkumar Rajaratnam <
>>> rajkum...@wso2.com> wrote:
>>>
>>>> Just noticed that there is an error in parsing complete topology event.
>>>> So initialization didn't happen as Isuru mentioned.
>>>>
>>>> Thanks.
>>>>
>>>> On Mon, Dec 22, 2014 at 12:19 PM, Rajkumar Rajaratnam <
>>>> rajkum...@wso2.com> wrote:
>>>>
>>>>> Hi,
>>>>>
>>>>> AFAIR, agent will wait for two conditions to happen. It will proceed
>>>>> if either of two conditions becomes true.
>>>>>
>>>>> 1. Member should be in the topology
>>>>> 2. Agent should get instance spawned event from CC
>>>>>
>>>>> So either of them didn't happen for you.
>>>>>
>>>>> Thanks.
>>>>>
>>>>> On Mon, Dec 22, 2014 at 12:17 PM, Isuru Haththotuwa <isu...@apache.org
>>>>> > wrote:
>>>>>
>>>>>> HI Udara,
>>>>>>
>>>>>> There is an error log about parsing the complete Topology event.
>>>>>> Maybe the event did not get parsed correctly, and the required
>>>>>> initialization did not happen.
>>>>>>
>>>>>> On Mon, Dec 22, 2014 at 12:12 PM, Udara Liyanage <ud...@wso2.com>
>>>>>> wrote:
>>>>>>
>>>>>>> Hi Chamila,
>>>>>>>
>>>>>>> I get the ":Waiting for Cartridge Agent to be initialized..." logs
>>>>>>> continuously even though complete topology and complete tenant event is
>>>>>>> already received.
>>>>>>>
>>>>>>>
>>>>>>> 2014-12-22 12:04:47,595:DEBUG:Waiting for Cartridge Agent to be
>>>>>>> initialized...
>>>>>>> 2014-12-22 12:04:48,596:DEBUG:Waiting for Cartridge Agent to be
>>>>>>> initialized...
>>>>>>> 2014-12-22 12:04:49,597:DEBUG:Waiting for Cartridge Agent to be
>>>>>>> initialized...
>>>>>>> 2014-12-22 12:04:49,781:DEBUG:Message received:
>>>>>>> 'topology/CompleteTopologyEvent':
>>>>>>>
>>>>>>> '{"topology":{"serviceMap":{"tomcat":{"serviceName":"tomcat","serviceType":"SingleTenant","clusterIdClusterMap":{"mytomcat.tomcat.domain":{"serviceName":"tomcat","clusterId":"mytomcat.tomcat.domain","autoscalePolicyName":"autoscale_policy_1","hostNames":["
>>>>>>> mytomcat.isuruh.lk
>>>>>>> "],"tenantRange":"*","isLbCluster":false,"isKubernetesCluster":false,"memberMap":{"mytomcat.tomcat.domainf1ee1c36-db95-452d-a1e7-1daf936e9101":{"serviceName":"tomcat","clusterId":"mytomcat.tomcat.domain","memberId":"mytomcat.tomcat.domainf1ee1c36-db95-452d-a1e7-1daf936e9101","instanceId":"ap-southeast-1/i-df7dde12","clusterInstanceId":"app_cartridge_v1-1","networkPartitionId":"p1","partitionId":"P1","initTime":1419229605140,"portMap":{"443":{"protocol":"https","value":443,"proxy":443},"80":{"protocol":"http","value":80,"proxy":80}},"memberPublicIPs":["54.151.190.32"],"defaultPublicIP":"54.151.190.32","memberPrivateIPs":["10.144.68.9"],"defaultPrivateIP":"10.144.68.9","properties":{"PRIMARY":"false","MIN_COUNT":"1"},"memberStateManager":{"stateStack":["Created"],"identifier":"mytomcat.tomcat.domainf1ee1c36-db95-452d-a1e7-1daf936e9101"}}},"appId":"app_cartridge_v1","properties":{},"instanceIdToInstanceContextMap":{"app_cartridge_v1-1":{"instanceId":"app_cartridge_v1-1","instanceProperties":{},"lifeCycleStateManager":{"stateStack":["Created"],"identifier":"mytomcat.tomcat.domain_app_cartridge_v1-1"},"networkPartitionId":"p1"}}}},"portMap":{"443":{"protocol":"https","value":443,"proxy":443},"80":{"protocol":"http","value":80,"proxy":80}},"properties":{}}},"initialized":false}}'
>>>>>>> 2014-12-22 12:04:49,781:DEBUG:Executing handler for event
>>>>>>> 'CompleteTopologyEvent'
>>>>>>> 2014-12-22 12:04:49,781:DEBUG:Complete topology event received
>>>>>>> 2014-12-22 12:04:49,782:ERROR:Error processing
>>>>>>> 'CompleteTopologyEvent' event
>>>>>>> Traceback (most recent call last):
>>>>>>> File
>>>>>>> "/mnt/apache-stratos-python-cartridge-agent-4.1.0-SNAPSHOT/modules/subscriber/eventsubscriber.py",
>>>>>>> line 81, in on_message
>>>>>>> handler(msg)
>>>>>>> File "agent.py", line 255, in on_complete_topology
>>>>>>> event_obj = CompleteTopologyEvent.create_from_json(msg.payload)
>>>>>>> File
>>>>>>> "/mnt/apache-stratos-python-cartridge-agent-4.1.0-SNAPSHOT/modules/event/topology/events.py",
>>>>>>> line 190, in create_from_json
>>>>>>> member_obj.member_ip = member_str["memberIp"]
>>>>>>> KeyError: 'memberIp'
>>>>>>> 2014-12-22 12:04:49,820:DEBUG:Message received:
>>>>>>> 'tenant/CompleteTenantEvent':
>>>>>>> '{"tenants":[]}'
>>>>>>> 2014-12-22 12:04:49,820:DEBUG:Executing handler for event
>>>>>>> 'CompleteTenantEvent'
>>>>>>> 2014-12-22 12:04:49,820:INFO:Complete tenant event updating task
>>>>>>> disabled
>>>>>>>
>>>>>>>
>>>>>>> *Carbon logs:*
>>>>>>>
>>>>>>> TID: [0] [STRATOS] [2014-12-22 06:27:21,240] INFO
>>>>>>> {org.apache.stratos.cloud.controller.messaging.publisher.TopologyEventPublisher}
>>>>>>> - Publishing instance spawned event: [service-name] tomcat [cluster-id]
>>>>>>> mytomcat.tomcat.domain [cluster-instance-id] app_cartridge_v1-1
>>>>>>> [member-id]
>>>>>>> mytomcat.tomcat.domainf1ee1c36-db95-452d-a1e7-1daf936e9101 [instance-id]
>>>>>>> ap-southeast-1/i-df7dde12 [network-partition-id] p1 [partition-id] P1
>>>>>>> [lb-cluster-id] null
>>>>>>> TID: [0] [STRATOS] [2014-12-22 06:27:21,261] INFO
>>>>>>> {org.apache.stratos.messaging.domain.topology.lifecycle.LifeCycleStateManager}
>>>>>>> - Life Cycle State Manager started for Element [
>>>>>>> mytomcat.tomcat.domainf1ee1c36-db95-452d-a1e7-1daf936e9101 ], initial
>>>>>>> state: Created
>>>>>>> TID: [0] [STRATOS] [2014-12-22 06:27:21,264] INFO
>>>>>>> {org.apache.stratos.messaging.message.processor.topology.InstanceSpawnedMessageProcessor}
>>>>>>> - Member created: [service] tomcat [cluster] mytomcat.tomcat.domain
>>>>>>> [member] mytomcat.tomcat.domainf1ee1c36-db95-452d-a1e7-1daf936e9101
>>>>>>> [instance] ap-southeast-1/i-df7dde12 [hierarchy-instance]
>>>>>>> app_cartridge_v1-1
>>>>>>> TID: [0] [STRATOS] [2014-12-22 06:27:21,268] INFO
>>>>>>> {org.apache.stratos.manager.topology.receiver.StratosManagerTopologyEventReceiver}
>>>>>>> - [InstanceSpawnedEventListener] Received: class
>>>>>>> org.apache.stratos.messaging.event.topology.InstanceSpawnedEvent
>>>>>>>
>>>>>>> --
>>>>>>>
>>>>>>> Udara Liyanage
>>>>>>> Software Engineer
>>>>>>> WSO2, Inc.: http://wso2.com
>>>>>>> lean. enterprise. middleware
>>>>>>>
>>>>>>> web: http://udaraliyanage.wordpress.com
>>>>>>> phone:
>>>>>>> +94 71 443 6897
>>>>>>>
>>>>>>> --
>>>>>>> Thanks and Regards,
>>>>>>>
>>>>>>> Isuru H.
>>>>>>> +94 716 358 048* <http://wso2.com/>*
>>>>>>>
>>>>>>>
>>>>>>> * <http://wso2.com/>*
>>>>>>>
>>>>>>>
>>>>>>>
>>>>>
>>>>>
>>>>> --
>>>>> Rajkumar Rajaratnam
>>>>> Committer & PMC Member, Apache Stratos
>>>>> Software Engineer, WSO2
>>>>>
>>>>> Mobile : +94777568639
>>>>> Blog : rajkumarr.com
>>>>>
>>>>
>>>>
>>>>
>>>> --
>>>> Rajkumar Rajaratnam
>>>> Committer & PMC Member, Apache Stratos
>>>> Software Engineer, WSO2
>>>>
>>>> Mobile : +94777568639
>>>> Blog : rajkumarr.com
>>>>
>>>
>>>
>>>
>>> --
>>> Rajkumar Rajaratnam
>>> Committer & PMC Member, Apache Stratos
>>> Software Engineer, WSO2
>>>
>>> Mobile : +94777568639
>>> Blog : rajkumarr.com
>>>
>>
>>
>> --
>>
>> Udara Liyanage
>> Software Engineer
>> WSO2, Inc.: http://wso2.com
>> lean. enterprise. middleware
>>
>> web: http://udaraliyanage.wordpress.com
>> phone: +94 71 443 6897
>>
>
>
> --
>
> Udara Liyanage
> Software Engineer
> WSO2, Inc.: http://wso2.com
> lean. enterprise. middleware
>
> web: http://udaraliyanage.wordpress.com
> phone: +94 71 443 6897
>
--
Rajkumar Rajaratnam
Committer & PMC Member, Apache Stratos
Software Engineer, WSO2
Mobile : +94777568639
Blog : rajkumarr.com
