Hi raj,
Could not fetch agent's log, instance got killed since it did not send
activate :-(
On Mon, Dec 22, 2014 at 1:13 PM, Rajkumar Rajaratnam <rajkum...@wso2.com>
wrote:
>
> 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
>
--
Udara Liyanage
Software Engineer
WSO2, Inc.: http://wso2.com
lean. enterprise. middleware
web: http://udaraliyanage.wordpress.com
phone: +94 71 443 6897
