cloudstack-issues mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From "venkata swamybabu budumuru (JIRA)" <j...@apache.org>
Subject [jira] [Created] (CLOUDSTACK-2580) [RVR] Failed to deploy Redundant Router VMs
Date Mon, 20 May 2013 10:43:15 GMT
venkata swamybabu budumuru created CLOUDSTACK-2580:
------------------------------------------------------

             Summary: [RVR] Failed to deploy Redundant Router VMs
                 Key: CLOUDSTACK-2580
                 URL: https://issues.apache.org/jira/browse/CLOUDSTACK-2580
             Project: CloudStack
          Issue Type: Bug
      Security Level: Public (Anyone can view this level - this is the default.)
          Components: Network Controller
    Affects Versions: 4.2.0
         Environment: commit # 85d54cd1c088997dd08f0328984bee1a55703636
            Reporter: venkata swamybabu budumuru
            Priority: Blocker
             Fix For: 4.2.0


Steps to reproduce :

1. Have CloudStack setup with advanced zone having a VMware cluster with 1 host

- Adv zone
- 1 VMware cluster
- 1 ESXi 5.1 host

2. Create a network offering with RVR enabled 

mysql> select * from network_offerings where id=14\G
*************************** 1. row ***************************
                       id: 14
                     name: RVROffering
                     uuid: 50fb0832-08b0-417b-ab2f-612a3cef9911
              unique_name: RVROffering
             display_text: RVROffering
                  nw_rate: NULL
                  mc_rate: 10
             traffic_type: Guest
                     tags: NULL
              system_only: 0
             specify_vlan: 0
      service_offering_id: NULL
            conserve_mode: 0
                  created: 2013-05-20 13:04:02
                  removed: NULL
                  default: 0
             availability: Optional
     dedicated_lb_service: 1
shared_source_nat_service: 0
                 sort_key: 0
 redundant_router_service: 1
                    state: Enabled
               guest_type: Isolated
       elastic_ip_service: 0
  eip_associate_public_ip: 0
       elastic_lb_service: 0
        specify_ip_ranges: 0
                   inline: 0
            is_persistent: 0
              internal_lb: 0
                public_lb: 1

3. select * from networks where id=209\G

mysql> select * from networks where id=209\G
*************************** 1. row ***************************
                   id: 209
                 name: RVRNet1
                 uuid: 2b031a8f-ec65-495c-9251-b9aa973334eb
         display_text: RVRNet1
         traffic_type: Guest
broadcast_domain_type: Vlan
        broadcast_uri: vlan://904
              gateway: 10.1.1.1
                 cidr: 10.1.1.0/24
                 mode: Dhcp
  network_offering_id: 14
  physical_network_id: 201
       data_center_id: 2
            guru_name: ExternalGuestNetworkGuru
                state: Implementing
              related: 209
            domain_id: 2
           account_id: 3
                 dns1: NULL
                 dns2: NULL
            guru_data: NULL
           set_fields: 0
             acl_type: Account
       network_domain: cs3cloud.internal
       reservation_id: 377f4a17-24c6-4bb3-9d08-f60e3d3782f1
           guest_type: Isolated
     restart_required: 0
              created: 2013-05-20 13:05:09
              removed: NULL
    specify_ip_ranges: 0
               vpc_id: NULL
          ip6_gateway: NULL
             ip6_cidr: NULL
         network_cidr: NULL
      display_network: 1
       network_acl_id: NULL
4. Create at least one non-ROOT domain user. Login as this user and try to create a VM using
the above network.

Observations:

(i) First router of the RVR setup (in this case r-13-VM) has come up fine.
(ii) But, the second router failed saying the host is in avoid set and then it kept on trying
and it filled the log file with those entries for thousands of times.

Here is the log snippet from mgmt server 

  39355 2013-05-20 09:05:11,087 DEBUG [cloud.async.AsyncJobManagerImpl] (catalina-exec-21:null)
submit async job-31, details: AsyncJobVO {id:31, userId: 3, accountId: 3, sessionKey: null,
instanceType: VirtualMachine, instanceId: 12, cmd: org.apache.cloudstack.api.comma       
nd.user.vm.DeployVMCmd, cmdOriginator: null, cmdInfo: {"sessionkey":"Mo6WUsz5nA2NAgP1DR+kefP4PM0\u003d","ctxUserId":"3","serviceOfferingId":"e26d4e7e-ceda-4f2d-bbf9-bbdb1f47cf5c","httpmethod":"GET","zoneId":"e078d6bf-8c54-4a20-a592-c56f7730e69e","templateId":"5c
       c4feee-c12d-11e2-8a66-069f2c0000aa","response":"json","id":"12","networkIds":"2b031a8f-ec65-495c-9251-b9aa973334eb","hypervisor":"VMware","name":"VM1RVRZone2","_":"1369035372563","ctxAccountId":"3","ctxStartEventId":"127","displayname":"VM1RVRZone2"},
cmdVersion        : 0, callbackType: 0, callbackAddress: null, status: 0, processStatus: 0,
resultCode: 0, result: null, initMsid: 7280707764394, completeMsid: null, lastUpdated: null,
lastPolled: null, created: null}


  39411 2013-05-20 09:05:11,459 DEBUG [cloud.storage.StorageManagerImpl] (Job-Executor-31:job-31)
Checking pool: 6 for volume allocation [Vol[12|vm=12|ROOT]], maxSize : 11804569600000, totalAllocatedSize
: 0, askingSize : 2147483648, allocated disable threshold: 0.85
  39412 2013-05-20 09:05:11,459 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-31:job-31)
Trying to find a potenial host and associated storage pools from the suitable host/pool lists
for this VM
  39413 2013-05-20 09:05:11,459 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-31:job-31)
Checking if host: 5 can access any suitable storage pool for volume: ROOT
  39414 2013-05-20 09:05:11,461 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-31:job-31)
Host: 5 can access pool: 6
  39415 2013-05-20 09:05:11,463 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-31:job-31)
Found a potential host id: 5 name: 10.147.40.11 and associated storage pools for this VM
  39416 2013-05-20 09:05:11,465 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-31:job-31)
Returning Deployment Destination: Dest[Zone(Id)-Pod(Id)-Cluster(Id)-Host(Id)-Storage(Volume(Id|Type-->Pool(Id))]
: Dest[Zone(2)-Pod(2)-Cluster(2)-Host(5)-Storage(        Volume(12|ROOT-->Pool(6))]
  39417 2013-05-20 09:05:11,465 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-31:job-31)
Deployment found  - P0=VM[User|VM1RVRZone2], P0=Dest[Zone(Id)-Pod(Id)-Cluster(Id)-Host(Id)-Storage(Volume(Id|Type-->Pool(Id))]
: Dest[Zone(2)-Pod(2)-Cluster(2)-Host(5)-St        orage(Volume(12|ROOT-->Pool(6))]
  39418 2013-05-20 09:05:11,493 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-31:job-31)
VM state transitted from :Starting to Starting with event: OperationRetryvm's original host
id: null new host id: 5 host id before state transition: null
  39419 2013-05-20 09:05:11,510 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-31:job-31)
Hosts's actual total CPU: 9572 and CPU after applying overprovisioning: 9572
  39420 2013-05-20 09:05:11,510 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-31:job-31)
We are allocating VM, increasing the used capacity of this host:5
  39421 2013-05-20 09:05:11,511 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-31:job-31)
Current Used CPU: 1000 , Free CPU:8572 ,Requested CPU: 500
  39422 2013-05-20 09:05:11,511 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-31:job-31)
Current Used RAM: 1342177280 , Free RAM:15827361792 ,Requested RAM: 536870912
  39423 2013-05-20 09:05:11,511 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-31:job-31)
CPU STATS after allocation: for host: 5, old used: 1000, old reserved: 0, actual total: 9572,
total with overprovisioning: 9572; new used:1500, reserved:0; requested cpu:        500,alloc_from_last:false
  39424 2013-05-20 09:05:11,511 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-31:job-31)
RAM STATS after allocation: for host: 5, old used: 1342177280, old reserved: 0, total: 17169539072;
new used: 1879048192, reserved: 0; requested mem: 536870912,alloc_from        _last:false
  39425 2013-05-20 09:05:11,517 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-31:job-31)
VM is being created in podId: 2
  39426 2013-05-20 09:05:11,523 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-31:job-31)
Lock is acquired for network id 209 as a part of network implement
  39427 2013-05-20 09:05:11,523 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-31:job-31)
Asking ExternalGuestNetworkGuru to implement Ntwk[209|Guest|14]
  39428 2013-05-20 09:05:11,690 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-31:job-31)
Creating a source nat ip for network Ntwk[209|Guest|14]
  39429 2013-05-20 09:05:11,697 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-31:job-31)
lock account 3 is acquired
  39430 2013-05-20 09:05:11,748 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-31:job-31)
Releasing lock account 3
  39431 2013-05-20 09:05:11,756 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-31:job-31)
Asking VirtualRouter to implemenet Ntwk[209|Guest|14]
  39432 2013-05-20 09:05:11,767 DEBUG [network.router.VirtualNetworkApplianceManagerImpl]
(Job-Executor-31:job-31) Lock is acquired for network id 209 as a part of router startup in
Dest[Zone(Id)-Pod(Id)-Cluster(Id)-Host(Id)-Storage(Volume(Id|Type-->Pool(Id))] : Dest[Zo
       ne(2)-Pod(2)-Cluster(2)-Host(5)-Storage(Volume(12|ROOT-->Pool(6))]
  39433 2013-05-20 09:05:11,837 DEBUG [network.router.VirtualNetworkApplianceManagerImpl]
(Job-Executor-31:job-31) Adding nic for Virtual Router in Guest network Ntwk[209|Guest|14]
  39434 2013-05-20 09:05:11,843 DEBUG [network.router.VirtualNetworkApplianceManagerImpl]
(Job-Executor-31:job-31) Adding nic for Virtual Router in Control network
  39435 2013-05-20 09:05:11,849 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-31:job-31)
Found existing network configuration for offering [Network Offering [3-Control-System-Control-Network]:
Ntwk[207|Control|3]
  39436 2013-05-20 09:05:11,849 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-31:job-31)
Releasing lock for Acct[1-system]
  39437 2013-05-20 09:05:11,850 DEBUG [network.router.VirtualNetworkApplianceManagerImpl]
(Job-Executor-31:job-31) Adding nic for Virtual Router in Public network
  39438 2013-05-20 09:05:11,856 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-31:job-31)
Found existing network configuration for offering [Network Offering [1-Public-System-Public-Network]:
Ntwk[205|Public|1]
  39439 2013-05-20 09:05:11,856 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-31:job-31)
Releasing lock for Acct[1-system]
  39440 2013-05-20 09:05:11,866 DEBUG [network.router.VirtualNetworkApplianceManagerImpl]
(Job-Executor-31:job-31) Creating the router 13 in datacenter com.cloud.dc.DataCenterVO$$EnhancerByCGLIB$$4b80e605@2
  39441 2013-05-20 09:05:11,866 DEBUG [network.router.VirtualNetworkApplianceManagerImpl]
(Job-Executor-31:job-31) Allocating the domR with the hypervisor type VMware
  39442 2013-05-20 09:05:11,872 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-31:job-31)
Allocating entries for VM: VM[DomainRouter|r-13-VM]
  39443 2013-05-20 09:05:11,880 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-31:job-31)
Allocating nics for VM[DomainRouter|r-13-VM]
  39444 2013-05-20 09:05:11,882 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-31:job-31)
Allocating nic for vm VM[DomainRouter|r-13-VM] in network Ntwk[209|Guest|14] with requested
profile NicProfile[0-0-null-10.1.1.116-vlan://904
  39445 2013-05-20 09:05:11,904 DEBUG [cloud.network.NetworkModelImpl] (Job-Executor-31:job-31)
Service SecurityGroup is not supported in the network id=209
  39446 2013-05-20 09:05:11,908 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-31:job-31)
Allocating nic for vm VM[DomainRouter|r-13-VM] in network Ntwk[207|Control|3] with requested
profile null
  39447 2013-05-20 09:05:11,923 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-31:job-31)
Allocating nic for vm VM[DomainRouter|r-13-VM] in network Ntwk[205|Public|1] with requested
profile NicProfile[0-0-null-10.147.44.62-vlan://44
  39448 2013-05-20 09:05:11,938 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-31:job-31)
Allocaing disks for VM[DomainRouter|r-13-VM]
  39449 2013-05-20 09:05:11,948 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-31:job-31)
Allocation completed for VM: VM[DomainRouter|r-13-VM]
  39450 2013-05-20 09:05:11,983 DEBUG [network.router.VirtualNetworkApplianceManagerImpl]
(Job-Executor-31:job-31) Adding nic for Virtual Router in Guest network Ntwk[209|Guest|14]
  39451 2013-05-20 09:05:11,995 DEBUG [network.router.VirtualNetworkApplianceManagerImpl]
(Job-Executor-31:job-31) Adding nic for Virtual Router in Control network
  39452 2013-05-20 09:05:12,003 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-31:job-31)
Found existing network configuration for offering [Network Offering [3-Control-System-Control-Network]:
Ntwk[207|Control|3]
  39453 2013-05-20 09:05:12,003 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-31:job-31)
Releasing lock for Acct[1-system]
  39454 2013-05-20 09:05:12,005 DEBUG [network.router.VirtualNetworkApplianceManagerImpl]
(Job-Executor-31:job-31) Adding nic for Virtual Router in Public network
  39455 2013-05-20 09:05:12,013 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-31:job-31)
Found existing network configuration for offering [Network Offering [1-Public-System-Public-Network]:
Ntwk[205|Public|1]
  39456 2013-05-20 09:05:12,014 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-31:job-31)
Releasing lock for Acct[1-system]
  39457 2013-05-20 09:05:12,020 INFO  [network.router.VirtualNetworkApplianceManagerImpl]
(Job-Executor-31:job-31) Use same MAC as previous RvR, the MAC is 06:6c:2a:00:00:0d
  39458 2013-05-20 09:05:12,027 DEBUG [network.router.VirtualNetworkApplianceManagerImpl]
(Job-Executor-31:job-31) Creating the router 14 in datacenter com.cloud.dc.DataCenterVO$$EnhancerByCGLIB$$4b80e605@2
  39459 2013-05-20 09:05:12,028 DEBUG [network.router.VirtualNetworkApplianceManagerImpl]
(Job-Executor-31:job-31) Allocating the domR with the hypervisor type VMware
  39460 2013-05-20 09:05:12,034 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-31:job-31)
Allocating entries for VM: VM[DomainRouter|r-14-VM]
  39461 2013-05-20 09:05:12,041 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-31:job-31)
Allocating nics for VM[DomainRouter|r-14-VM]
  39462 2013-05-20 09:05:12,042 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-31:job-31)
Allocating nic for vm VM[DomainRouter|r-14-VM] in network Ntwk[209|Guest|14] with requested
profile NicProfile[0-0-null-10.1.1.98-vlan://904
  39463 2013-05-20 09:05:12,071 DEBUG [cloud.network.NetworkModelImpl] (Job-Executor-31:job-31)
Service SecurityGroup is not supported in the network id=209
  39464 2013-05-20 09:05:12,075 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-31:job-31)
Allocating nic for vm VM[DomainRouter|r-14-VM] in network Ntwk[207|Control|3] with requested
profile null
  39465 2013-05-20 09:05:12,091 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-31:job-31)
Allocating nic for vm VM[DomainRouter|r-14-VM] in network Ntwk[205|Public|1] with requested
profile NicProfile[0-0-null-10.147.44.62-vlan://44
  39466 2013-05-20 09:05:12,106 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-31:job-31)
Allocaing disks for VM[DomainRouter|r-14-VM]
  39467 2013-05-20 09:05:12,117 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-31:job-31)
Allocation completed for VM: VM[DomainRouter|r-14-VM]


  39611 2013-05-20 09:05:19,056 INFO  [vmware.resource.VmwareResource] (DirectAgent-249:10.147.40.11)
Executing resource StartCommand: {"vm":{"id":13,"name":"r-13-VM","bootloader":"HVM","type":"DomainRouter","cpus":1,"minSpeed":500,"maxSpeed":500,"minRam":134217728,"max
       Ram":134217728,"arch":"i686","os":"Debian GNU/Linux 5.0 (32-bit)","bootArgs":" template=domP
name=r-13-VM eth2ip=10.147.44.62 eth2mask=255.255.255.0 gateway=10.147.44.1 eth0ip=10.1.1.116
eth0mask=255.255.255.0 redundant_router=1 guestgw=10.1.1.1 guestbrd=10.1.1.        255 guestcidrsize=24
router_pr=100 domain=cs3cloud.internal dhcprange=10.1.1.1 eth1ip=10.147.40.88 eth1mask=255.255.254.0
mgmtcidr=10.147.59.0/24 localgw=10.147.40.1 type=router disable_rp_filter=true extra_pubnics=2
dns1=10.103.128.16 nic_macs=02:00:03:d6:00:02        |02:00:2a:8a:00:05|06:6c:2a:00:00:0d|02:00:56:54:00:01|02:00:10:d1:00:02","rebootOnCrash":false,"enableHA":false,"limitCpuUse":false,"vncPassword":"28b1b1b36e34462a","params":{"nicAdapter":"E1000"},"uuid":"2403c36a-3e1f-4a44-948a-049644e8f873","disks":[{"id":13,
       "name":"ROOT-13","mountPoint":"/export/home/swamy/primary.campo.vmw.1","path":"ROOT-13-13","size":2097152000,"type":"ROOT","storagePoolType":"NetworkFilesystem","storagePoolUuid":"b5671f5d-c64c-36e7-9249-6d87010c7bac","deviceId":0}],"nics":[{"deviceId":2,"networ
       kRateMbps":200,"defaultNic":true,"uuid":"4addb6ed-d5bc-4b29-9b0d-4ee3fa24a719","ip":"10.147.44.62","netmask":"255.255.255.0","gateway":"10.147.44.1","mac":"06:6c:2a:00:00:0d","dns1":"10.103.128.16","broadcastType":"Vlan","type":"Public","broadcastUri":"vlan://44
       ","isolationUri":"vlan://44","isSecurityGroupEnabled":false},{"deviceId":0,"networkRateMbps":200,"defaultNic":false,"uuid":"43ec010d-93d2-4625-8f64-76e4da797f72","ip":"10.1.1.116","netmask":"255.255.255.0","mac":"02:00:03:d6:00:02","dns1":"10.103.128.16","broadc
       astType":"Vlan","type":"Guest","broadcastUri":"vlan://904","isolationUri":"vlan://904","isSecurityGroupEnabled":false},{"deviceId":1,"networkRateMbps":-1,"defaultNic":false,"uuid":"212b8db8-bb53-4dde-81d0-751be079dc1e","ip":"10.147.40.88","netmask":"255.255.254.
       0","gateway":"10.147.40.1","mac":"02:00:2a:8a:00:05","broadcastType":"Native","type":"Control","isSecurityGroupEnabled":false},{"deviceId":3,"networkRateMbps":-1,"defaultNic":false,"ip":"0.0.0.0","netmask":"255.255.255.255","gateway":"10.147.44.1","mac":"02:00:5
       6:54:00:01","dns1":"10.103.128.16","broadcastType":"Vlan","type":"Public","broadcastUri":"vlan://44","isolationUri":"vlan://44","isSecurityGroupEnabled":false},{"deviceId":4,"networkRateMbps":-1,"defaultNic":false,"ip":"0.0.0.0","netmask":"255.255.255.255","gate
       way":"10.147.44.1","mac":"02:00:10:d1:00:02","dns1":"10.103.128.16","broadcastType":"Vlan","type":"Public","broadcastUri":"vlan://44","isolationUri":"vlan://44","isSecurityGroupEnabled":false}]},"hostIp":"10.147.40.11","wait":0}
  39612 2013-05-20 09:05:19,057 DEBUG [vmware.resource.VmwareResource] (DirectAgent-249:10.147.40.11)
VM r-13-VM will be started with NIC device type: E1000


 39807 2013-05-20 09:06:48,252 DEBUG [agent.transport.Request] (DirectAgent-249:null) Seq
5-2133262447: Processing:  { Ans: , MgmtId: 7280707764394, via: 5, Ver: v1, Flags: 110, [{"StartAnswer":{"vm":{"id":13,"name":"r-13-VM","bootloader":"HVM","type":"DomainRouter","c
       pus":1,"minSpeed":500,"maxSpeed":500,"minRam":134217728,"maxRam":134217728,"arch":"i686","os":"Debian
GNU/Linux 5.0 (32-bit)","bootArgs":" template=domP name=r-13-VM eth2ip=10.147.44.62 eth2mask=255.255.255.0
gateway=10.147.44.1 eth0ip=10.1.1.116 eth0mask=255.25        5.255.0 redundant_router=1 guestgw=10.1.1.1
guestbrd=10.1.1.255 guestcidrsize=24 router_pr=100 domain=cs3cloud.internal dhcprange=10.1.1.1
eth1ip=10.147.40.88 eth1mask=255.255.254.0 mgmtcidr=10.147.59.0/24 localgw=10.147.40.1 type=router
disable_rp_filter=true e        xtra_pubnics=2 dns1=10.103.128.16 nic_macs=02:00:03:d6:00:02|02:00:2a:8a:00:05|06:6c:2a:00:00:0d|02:00:56:54:00:01|02:00:10:d1:00:02","rebootOnCrash":false,"enableHA":false,"limitCpuUse":false,"vncPassword":"28b1b1b36e34462a","params":{"nicAdapter":"E1000"},"uui
       d":"2403c36a-3e1f-4a44-948a-049644e8f873","disks":[{"id":13,"name":"ROOT-13","mountPoint":"/export/home/swamy/primary.campo.vmw.1","path":"ROOT-13-13","size":2097152000,"type":"ROOT","storagePoolType":"NetworkFilesystem","storagePoolUuid":"b5671f5d-c64c-36e7-924
       9-6d87010c7bac","deviceId":0}],"nics":[{"deviceId":2,"networkRateMbps":200,"defaultNic":true,"uuid":"4addb6ed-d5bc-4b29-9b0d-4ee3fa24a719","ip":"10.147.44.62","netmask":"255.255.255.0","gateway":"10.147.44.1","mac":"06:6c:2a:00:00:0d","dns1":"10.103.128.16","bro
       adcastType":"Vlan","type":"Public","broadcastUri":"vlan://44","isolationUri":"vlan://44","isSecurityGroupEnabled":false},{"deviceId":0,"networkRateMbps":200,"defaultNic":false,"uuid":"43ec010d-93d2-4625-8f64-76e4da797f72","ip":"10.1.1.116","netmask":"255.255.255
       .0","mac":"02:00:03:d6:00:02","dns1":"10.103.128.16","broadcastType":"Vlan","type":"Guest","broadcastUri":"vlan://904","isolationUri":"vlan://904","isSecurityGroupEnabled":false},{"deviceId":1,"networkRateMbps":-1,"defaultNic":false,"uuid":"212b8db8-bb53-4dde-81
       d0-751be079dc1e","ip":"10.147.40.88","netmask":"255.255.254.0","gateway":"10.147.40.1","mac":"02:00:2a:8a:00:05","broadcastType":"Native","type":"Control","isSecurityGroupEnabled":false},{"deviceId":3,"networkRateMbps":-1,"defaultNic":false,"ip":"0.0.0.0","netma
       sk":"255.255.255.255","gateway":"10.147.44.1","mac":"02:00:56:54:00:01","dns1":"10.103.128.16","broadcastType":"Vlan","type":"Public","broadcastUri":"vlan://44","isolationUri":"vlan://44","isSecurityGroupEnabled":false},{"deviceId":4,"networkRateMbps":-1,"defaul
       tNic":false,"ip":"0.0.0.0","netmask":"255.255.255.255","gateway":"10.147.44.1","mac":"02:00:10:d1:00:02","dns1":"10.103.128.16","broadcastType":"Vlan","type":"Public","broadcastUri":"vlan://44","isolationUri":"vlan://44","isSecurityGroupEnabled":false}]},"result
       ":true,"wait":0}},{"check.CheckSshAnswer":{"result":true,"wait":0}},{"GetDomRVersionAnswer":{"templateVersion":"Cloudstack
Release 4.2.0 Tue Apr 16 04:09:58 UTC 2013","scriptsVersion":"12ed1584c0a9d218d203bdb1f85433f7\n","result":true,"details":"Cloudstack
Relea        se 4.2.0 Tue Apr 16 04:09:58 UTC 2013&12ed1584c0a9d218d203bdb1f85433f7\n","wait":0}},{"NetworkUsageAnswer":{"routerName":"r-13-VM","bytesSent":0,"bytesReceived":0,"result":true,"details":"","wait":0}},{"routing.IpAssocAnswer":{"results":["10.147.44.62
- success"        ],"result":true,"wait":0}},{"Answer":{"result":false,"details":"deleteipAlias
failed due to bash: /root/deleteipAlias.sh: No such file or directory\n","wait":0}}] }
  39808 2013-05-20 09:06:48,253 DEBUG [agent.transport.Request] (Job-Executor-31:job-31) Seq
5-2133262447: Received:  { Ans: , MgmtId: 7280707764394, via: 5, Ver: v1, Flags: 110, { StartAnswer,
CheckSshAnswer, GetDomRVersionAnswer, NetworkUsageAnswer, IpAssocAnswer, Ans        wer }
}


  39812 2013-05-20 09:06:48,316 DEBUG [network.router.VirtualNetworkApplianceManagerImpl]
(Job-Executor-31:job-31) Starting router VM[DomainRouter|r-14-VM]
  39813 2013-05-20 09:06:48,323 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-31:job-31)
VM state transitted from :Stopped to Starting with event: StartRequestedvm's original host
id: null new host id: null host id before state transition: null
  39814 2013-05-20 09:06:48,324 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-31:job-31)
Successfully transitioned to start state for VM[DomainRouter|r-14-VM] reservation id = 65b3144f-83ff-4ce7-9131-9e7b68273916
  39815 2013-05-20 09:06:48,330 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-31:job-31)
Trying to deploy VM, vm has dcId: 2 and podId: null
  39816 2013-05-20 09:06:48,330 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-31:job-31)
Deploy avoids pods: [2], clusters: null, hosts: null
  39817 2013-05-20 09:06:48,334 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-31:job-31)
Deploy avoids pods: [2], clusters: null, hosts: null
  39818 2013-05-20 09:06:48,336 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-31:job-31)
DeploymentPlanner allocation algorithm: com.cloud.deploy.FirstFitPlanner_EnhancerByCloudStack_4c69dc2f@7f9dcbc7
  39819 2013-05-20 09:06:48,336 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-31:job-31)
Trying to allocate a host and storage pools from dc:2, pod:null,cluster:null, requested cpu:
500, requested ram: 134217728
  39820 2013-05-20 09:06:48,336 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-31:job-31)
Is ROOT volume READY (pool already allocated)?: No
  39821 2013-05-20 09:06:48,336 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-31:job-31)
Searching all possible resources under this Zone: 2
  39822 2013-05-20 09:06:48,338 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-31:job-31)
Listing clusters in order of aggregate capacity, that have (atleast one host with) enough
CPU and RAM capacity under this Zone: 2

Attaching all the required logs along with db dump.




--
This message is automatically generated by JIRA.
If you think it was sent incorrectly, please contact your JIRA administrators
For more information on JIRA, see: http://www.atlassian.com/software/jira

Mime
View raw message