[
https://issues.apache.org/jira/browse/CLOUDSTACK-4340?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=13741411#comment-13741411
]
Rayees Namathponnan commented on CLOUDSTACK-4340:
-------------------------------------------------
Not found this issue in today's KVM run
> [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: Bug
> 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
> Fix For: 4.2.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', '[email protected]', 'aes128-ctr',
> 'aes192-ctr', 'aes256-ctr'] server encrypt:['aes128-cbc', '3des-cbc',
> 'blowfish-cbc', 'cast128-cbc', 'arcfour128', 'arcfour256', 'arcfour',
> 'aes192-cbc', 'aes256-cbc', '[email protected]', 'aes128-ctr',
> 'aes192-ctr', 'aes256-ctr'] client mac:['hmac-md5', 'hmac-sha1',
> 'hmac-ripemd160', '[email protected]', 'hmac-sha1-96',
> 'hmac-md5-96'] server mac:['hmac-md5', 'hmac-sha1', 'hmac-ripemd160',
> '[email protected]', 'hmac-sha1-96', 'hmac-md5-96'] client
> compress:['none', '[email protected]'] server compress:['none',
> '[email protected]'] 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: [email protected] 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', '[email protected]', 'aes128-ctr',
> 'aes192-ctr', 'aes256-ctr'] server encrypt:['aes128-cbc', '3des-cbc',
> 'blowfish-cbc', 'cast128-cbc', 'arcfour128', 'arcfour256', 'arcfour',
> 'aes192-cbc', 'aes256-cbc', '[email protected]', 'aes128-ctr',
> 'aes192-ctr', 'aes256-ctr'] client mac:['hmac-md5', 'hmac-sha1',
> 'hmac-ripemd160', '[email protected]', 'hmac-sha1-96',
> 'hmac-md5-96'] server mac:['hmac-md5', 'hmac-sha1', 'hmac-ripemd160',
> '[email protected]', 'hmac-sha1-96', 'hmac-md5-96'] client
> compress:['none', '[email protected]'] server compress:['none',
> '[email protected]'] 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: [email protected] 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 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