You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@cloudstack.apache.org by "Rayees Namathponnan (JIRA)" <ji...@apache.org> on 2013/12/31 22:46:51 UTC
[jira] [Updated] (CLOUDSTACK-4340) [Automation] Test cases
TestVMLifeCycleStoppedVPCVR.test_07_migrate_instance_in_network failed
during migration
[ https://issues.apache.org/jira/browse/CLOUDSTACK-4340?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ]
Rayees Namathponnan updated CLOUDSTACK-4340:
--------------------------------------------
Assignee: Rayees Namathponnan
> [Automation] Test cases TestVMLifeCycleStoppedVPCVR.test_07_migrate_instance_in_network failed during migration
> ---------------------------------------------------------------------------------------------------------------
>
> Key: CLOUDSTACK-4340
> URL: https://issues.apache.org/jira/browse/CLOUDSTACK-4340
> Project: CloudStack
> Issue Type: Test
> Security Level: Public(Anyone can view this level - this is the default.)
> Components: API, Automation
> Affects Versions: 4.2.0
> Environment: Automation
> 4.2
> Reporter: Rayees Namathponnan
> Assignee: Rayees Namathponnan
> Fix For: 4.3.0
>
> Attachments: management-server.rar
>
>
> Test cases integration.component.test_vpc_vm_life_cycle.TestVMLifeCycleStoppedVPCVR.test_07_migrate_instance_in_network failed with latest build, failed during migration;
> observed below error in automation log
> ----------------------------------------------------------
> Failed to migrate instance, Execute cmd: asyncquery failed, due to: {errorcode : 530, errortext : u'Cannot migrate VM, VM is already presnt on this host, please specify valid destination host to migrate the VM'}
> -------------------- >> begin captured logging << --------------------
> testclient.testcase.TestVMLifeCycleStoppedVPCVR: DEBUG: Check the status of VPC virtual router
> testclient.testcase.TestVMLifeCycleStoppedVPCVR: DEBUG: Checking if the host is available for migration?
> testclient.testcase.TestVMLifeCycleStoppedVPCVR: DEBUG: Validating if the network rules work properly or not?
> testclient.testcase.TestVMLifeCycleStoppedVPCVR: DEBUG: Checking if we can SSH into VM_1 through 10.223.122.78?
> paramiko.transport: DEBUG: starting thread (client mode): 0xad8f910L
> paramiko.transport: INFO: Connected (version 2.0, client OpenSSH_4.3)
> paramiko.transport: DEBUG: kex algos:['diffie-hellman-group-exchange-sha1', 'diffie-hellman-group14-sha1', 'diffie-hellman-group1-sha1'] server key:['ssh-rsa', 'ssh-dss'] client encrypt:['aes128-cbc', '3des-cbc', 'blowfish-cbc', 'cast128-cbc', 'arcfour128', 'arcfour256', 'arcfour', 'aes192-cbc', 'aes256-cbc', 'rijndael-cbc@lysator.liu.se', 'aes128-ctr', 'aes192-ctr', 'aes256-ctr'] server encrypt:['aes128-cbc', '3des-cbc', 'blowfish-cbc', 'cast128-cbc', 'arcfour128', 'arcfour256', 'arcfour', 'aes192-cbc', 'aes256-cbc', 'rijndael-cbc@lysator.liu.se', 'aes128-ctr', 'aes192-ctr', 'aes256-ctr'] client mac:['hmac-md5', 'hmac-sha1', 'hmac-ripemd160', 'hmac-ripemd160@openssh.com', 'hmac-sha1-96', 'hmac-md5-96'] server mac:['hmac-md5', 'hmac-sha1', 'hmac-ripemd160', 'hmac-ripemd160@openssh.com', 'hmac-sha1-96', 'hmac-md5-96'] client compress:['none', 'zlib@openssh.com'] server compress:['none', 'zlib@openssh.com'] client lang:[''] server lang:[''] kex follows?False
> paramiko.transport: DEBUG: Ciphers agreed: local=aes128-ctr, remote=aes128-ctr
> paramiko.transport: DEBUG: using kex diffie-hellman-group1-sha1; server key type ssh-rsa; cipher: local aes128-ctr, remote aes128-ctr; mac: local hmac-sha1, remote hmac-sha1; compression: local none, remote none
> paramiko.transport: DEBUG: Switch to new keys ...
> paramiko.transport: DEBUG: Adding ssh-rsa host key for 10.223.122.78: 0f8b3ff9dc4dce10340227dab3cac032
> paramiko.transport: DEBUG: Trying discovered key 76be480fa6b8ad3b78082d6d19e4ee44 in /root/.ssh/id_rsa
> paramiko.transport: DEBUG: userauth is OK
> paramiko.transport: INFO: Authentication (publickey) failed.
> paramiko.transport: DEBUG: userauth is OK
> paramiko.transport: INFO: Authentication (password) successful!
> sshClient: DEBUG: SSH connect: root@10.223.122.78 with passwd password
> paramiko.transport: DEBUG: EOF in transport thread
> testclient.testcase.TestVMLifeCycleStoppedVPCVR: DEBUG: SSH into VM is successfully
> testclient.testcase.TestVMLifeCycleStoppedVPCVR: DEBUG: Verifying if we can ping to outside world from VM?
> paramiko.transport: DEBUG: [chan 1] Max packet in: 34816 bytes
> paramiko.transport: DEBUG: [chan 1] Max packet out: 32768 bytes
> paramiko.transport: INFO: Secsh channel 1 opened.
> paramiko.transport: DEBUG: [chan 1] Sesch channel 1 request ok
> paramiko.transport: DEBUG: [chan 1] EOF received (1)
> sshClient: DEBUG: {Cmd: ping -c 1 www.google.com via Host: 10.223.122.78} {returns: ['PING www.google.com (74.125.239.145) 56(84) bytes of data.', '64 bytes from nuq05s02-in-f17.1e100.net (74.125.239.145): icmp_seq=1 ttl=48 time=5.49 ms', '', '--- www.google.com ping statistics ---', '1 packets transmitted, 1 received, 0% packet loss, time 0ms', 'rtt min/avg/max/mdev = 5.497/5.497/5.497/0.000 ms']}
> testclient.testcase.TestVMLifeCycleStoppedVPCVR: DEBUG: Checking if we can SSH into VM_1?
> paramiko.transport: DEBUG: [chan 1] EOF sent (1)
> paramiko.transport: DEBUG: starting thread (client mode): 0xad8f590L
> paramiko.transport: INFO: Connected (version 2.0, client OpenSSH_4.3)
> paramiko.transport: DEBUG: kex algos:['diffie-hellman-group-exchange-sha1', 'diffie-hellman-group14-sha1', 'diffie-hellman-group1-sha1'] server key:['ssh-rsa', 'ssh-dss'] client encrypt:['aes128-cbc', '3des-cbc', 'blowfish-cbc', 'cast128-cbc', 'arcfour128', 'arcfour256', 'arcfour', 'aes192-cbc', 'aes256-cbc', 'rijndael-cbc@lysator.liu.se', 'aes128-ctr', 'aes192-ctr', 'aes256-ctr'] server encrypt:['aes128-cbc', '3des-cbc', 'blowfish-cbc', 'cast128-cbc', 'arcfour128', 'arcfour256', 'arcfour', 'aes192-cbc', 'aes256-cbc', 'rijndael-cbc@lysator.liu.se', 'aes128-ctr', 'aes192-ctr', 'aes256-ctr'] client mac:['hmac-md5', 'hmac-sha1', 'hmac-ripemd160', 'hmac-ripemd160@openssh.com', 'hmac-sha1-96', 'hmac-md5-96'] server mac:['hmac-md5', 'hmac-sha1', 'hmac-ripemd160', 'hmac-ripemd160@openssh.com', 'hmac-sha1-96', 'hmac-md5-96'] client compress:['none', 'zlib@openssh.com'] server compress:['none', 'zlib@openssh.com'] client lang:[''] server lang:[''] kex follows?False
> paramiko.transport: DEBUG: Ciphers agreed: local=aes128-ctr, remote=aes128-ctr
> paramiko.transport: DEBUG: using kex diffie-hellman-group1-sha1; server key type ssh-rsa; cipher: local aes128-ctr, remote aes128-ctr; mac: local hmac-sha1, remote hmac-sha1; compression: local none, remote none
> paramiko.transport: DEBUG: Switch to new keys ...
> paramiko.transport: DEBUG: Adding ssh-rsa host key for 10.223.122.80: 0f8b3ff9dc4dce10340227dab3cac032
> paramiko.transport: DEBUG: Trying discovered key 76be480fa6b8ad3b78082d6d19e4ee44 in /root/.ssh/id_rsa
> paramiko.transport: DEBUG: userauth is OK
> paramiko.transport: INFO: Authentication (publickey) failed.
> paramiko.transport: DEBUG: userauth is OK
> paramiko.transport: INFO: Authentication (password) successful!
> sshClient: DEBUG: SSH connect: root@10.223.122.80 with passwd password
> testclient.testcase.TestVMLifeCycleStoppedVPCVR: DEBUG: SSH into VM is successfully
> testclient.testcase.TestVMLifeCycleStoppedVPCVR: DEBUG: Verifying if we can ping to outside world from VM?
> paramiko.transport: DEBUG: [chan 1] Max packet in: 34816 bytes
> paramiko.transport: DEBUG: [chan 1] Max packet out: 32768 bytes
> paramiko.transport: INFO: Secsh channel 1 opened.
> paramiko.transport: DEBUG: [chan 1] Sesch channel 1 request ok
> paramiko.transport: DEBUG: [chan 1] EOF received (1)
> sshClient: DEBUG: {Cmd: ping -c 1 www.google.com via Host: 10.223.122.80} {returns: ['PING www.google.com (74.125.239.148) 56(84) bytes of data.', '64 bytes from nuq05s02-in-f20.1e100.net (74.125.239.148): icmp_seq=1 ttl=48 time=6.24 ms', '', '--- www.google.com ping statistics ---', '1 packets transmitted, 1 received, 0% packet loss, time 0ms', 'rtt min/avg/max/mdev = 6.249/6.249/6.249/0.000 ms']}
> paramiko.transport: DEBUG: [chan 1] EOF sent (1)
> paramiko.transport: DEBUG: EOF in transport thread
> testclient.testcase.TestVMLifeCycleStoppedVPCVR: DEBUG: Migrating VM-ID: 20b35944-9892-48bf-bd6d-a2338a7eb6ad to Host: 44652e87-084e-4076-a068-291943ad92ba
> --------------------- >> end captured logging << ---------------------
> Stacktrace
> File "/usr/local/lib/python2.7/unittest/case.py", line 318, in run
> testMethod()
> File "/Repo_30X/ipcl/cloudstack/test/integration/component/test_vpc_vm_life_cycle.py", line 2536, in test_07_migrate_instance_in_network
> self.fail("Failed to migrate instance, %s" % e)
> File "/usr/local/lib/python2.7/unittest/case.py", line 393, in fail
> raise self.failureException(msg)
> Failed to migrate instance, Execute cmd: asyncquery failed, due to: {errorcode : 530, errortext : u'Cannot migrate VM, VM is already presnt on this host, please specify valid destination host to migrate the VM'}
> Observed below error in MS log
> -----------------------------------------------
> rO9O2ItNksB9HPXXXbDCB5nnnmnast2F-e51Ik24J0-SxLBnsulcBnHJ1GNTKt0rfdZGSmI4YtJuUa2GEJMQ&command=migrateVirtualMachine&signature=8Th9GAOMs0LfB5nUClzYfn9sNSA%3D&response=json
> 2013-08-14 07:05:13,104 DEBUG [cloud.api.ApiServlet] (catalina-exec-4:null) ===START=== 10.223.240.194 -- GET signature=J6dWD736KAA3FeQiSIfJD34Y68o%3D&apiKey=o1rO9O2ItNksB9HPXXXbDCB5nnnmnast2F-e51Ik24J0-SxLBnsulcBnH
> J1GNTKt0rfdZGSmI4YtJuUa2GEJMQ&command=queryAsyncJobResult&response=json&jobid=64530659-1b4b-4f5a-bf9d-f9ddf2b33000
> 2013-08-14 07:05:13,126 DEBUG [cloud.api.ApiServlet] (catalina-exec-4:null) ===END=== 10.223.240.194 -- GET signature=J6dWD736KAA3FeQiSIfJD34Y68o%3D&apiKey=o1rO9O2ItNksB9HPXXXbDCB5nnnmnast2F-e51Ik24J0-SxLBnsulcBnHJ1
> GNTKt0rfdZGSmI4YtJuUa2GEJMQ&command=queryAsyncJobResult&response=json&jobid=64530659-1b4b-4f5a-bf9d-f9ddf2b33000
> 2013-08-14 07:05:13,138 ERROR [cloud.async.AsyncJobManagerImpl] (Job-Executor-139:job-2319 = [ 64530659-1b4b-4f5a-bf9d-f9ddf2b33000 ]) Unexpected exception while executing org.apache.cloudstack.api.command.admin.vm.Mi
> grateVMCmd
> com.cloud.exception.InvalidParameterValueException: Cannot migrate VM, VM is already presnt on this host, please specify valid destination host to migrate the VM
> at com.cloud.vm.UserVmManagerImpl.migrateVirtualMachine(UserVmManagerImpl.java:3939)
> at com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:125)
> at org.apache.cloudstack.api.command.admin.vm.MigrateVMCmd.execute(MigrateVMCmd.java:147)
> at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:158)
> at com.cloud.async.AsyncJobManagerImpl$1.run(AsyncJobManagerImpl.java:531)
> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
> at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334)
> at java.util.concurrent.FutureTask.run(FutureTask.java:166)
> 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:679)
> 2013-08-14 07:05:13,139 DEBUG [cloud.async.AsyncJobManagerImpl] (Job-Executor-139:job-2319 = [ 64530659-1b4b-4f5a-bf9d-f9ddf2b33000 ]) Complete async job-2319 = [ 64530659-1b4b-4f5a-bf9d-f9ddf2b33000 ], jobStatus: 2, resultCode: 530, result: Error Code: 530 Error text: Cannot migrate VM, VM is already presnt on this host, please specify valid destination host to migrate the VM
> 2013-08-14 07:05:13,534 DEBUG [cloud.network.NetworkManagerImpl] (Network-Scavenger-1:null) We found network 494 to be free for the first time. Adding it to the list: 1344217103
> 2013-08-14 07:05:13,537 DEBUG [cloud.network.NetworkModelImpl] (Network-Scavenger-1:null) Network id=497 is not ready for GC as it has vms that are Starting at the moment
--
This message was sent by Atlassian JIRA
(v6.1.5#6160)