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 2014/09/21 21:50:34 UTC
[jira] [Closed] (CLOUDSTACK-6618) [Automation] BVT test case
failing with ssh connection error
[ https://issues.apache.org/jira/browse/CLOUDSTACK-6618?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ]
Rayees Namathponnan closed CLOUDSTACK-6618.
-------------------------------------------
Not found this issue in latets run
> [Automation] BVT test case failing with ssh connection error
> -------------------------------------------------------------
>
> Key: CLOUDSTACK-6618
> URL: https://issues.apache.org/jira/browse/CLOUDSTACK-6618
> Project: CloudStack
> Issue Type: Test
> Security Level: Public(Anyone can view this level - this is the default.)
> Components: Automation
> Affects Versions: 4.4.0
> Reporter: Rayees Namathponnan
> Assignee: Gaurav Aradhye
> Priority: Critical
> Fix For: 4.4.0
>
>
> This is a place holder of issue observed in BVT, need more analysis.
> There are few test case failing while establishing SSH connection,
> integration.smoke.test_network.TestPortForwarding.test_01_port_fwd_on_src_nat
> test_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: ========Sending GET Cmd : queryAsyncJobResult=======
> requests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216
> requests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?signature=ELyUq0KT3FA6q3b%2F92LqrS6%2FJAU%3D&apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&command=queryAsyncJobResult&response=json&jobid=43bb248a-7751-4eb0-9456-d007b22e56bc HTTP/1.1" 200 939
> test_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: Response : {jobprocstatus : 0, created : u'2014-05-08T20:34:07+0000', cmd : u'org.apache.cloudstack.api.command.user.firewall.CreatePortForwardingRuleCmd', userid : u'b0ee86a2-d6e9-11e3-ba11-1258f5fe9d0b', jobstatus : 1, jobid : u'43bb248a-7751-4eb0-9456-d007b22e56bc', jobresultcode : 0, jobresulttype : u'object', jobresult : {networkid : u'24c2f881-a06e-4bdd-ae5c-0fe02f296070', virtualmachinename : u'VM-4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6', protocol : u'tcp', virtualmachineid : u'4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6', publicport : u'2222', cidrlist : u'', fordisplay : True, ipaddressid : u'48bdb986-45d6-400c-9d26-6ebeff4316d1', virtualmachinedisplayname : u'Test VM', vmguestip : u'192.168.200.3', state : u'Active', publicendport : u'2222', privateport : u'22', privateendport : u'22', ipaddress : u'10.220.164.52', id : u'5c24906d-69bb-40bb-bf5a-090ca5acb012', tags : []}, accountid : u'b0ee7914-d6e9-11e3-ba11-1258f5fe9d0b'}
> test_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: ===Jobid:43bb248a-7751-4eb0-9456-d007b22e56bc ; StartTime:Thu May 8 20:33:42 2014 ; EndTime:Thu May 8 20:33:47 2014 ; TotalTime:-5===
> test_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: Response : {jobprocstatus : 0, created : u'2014-05-08T20:34:07+0000', cmd : u'org.apache.cloudstack.api.command.user.firewall.CreatePortForwardingRuleCmd', userid : u'b0ee86a2-d6e9-11e3-ba11-1258f5fe9d0b', jobstatus : 1, jobid : u'43bb248a-7751-4eb0-9456-d007b22e56bc', jobresultcode : 0, jobresulttype : u'object', jobresult : {networkid : u'24c2f881-a06e-4bdd-ae5c-0fe02f296070', virtualmachinename : u'VM-4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6', protocol : u'tcp', virtualmachineid : u'4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6', publicport : u'2222', cidrlist : u'', fordisplay : True, ipaddressid : u'48bdb986-45d6-400c-9d26-6ebeff4316d1', virtualmachinedisplayname : u'Test VM', vmguestip : u'192.168.200.3', state : u'Active', publicendport : u'2222', privateport : u'22', privateendport : u'22', ipaddress : u'10.220.164.52', id : u'5c24906d-69bb-40bb-bf5a-090ca5acb012', tags : []}, accountid : u'b0ee7914-d6e9-11e3-ba11-1258f5fe9d0b'}
> test_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: Payload: {'apiKey': u'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA', 'response': 'json', 'command': 'listPortForwardingRules', 'signature': 'NzSPBRvKOWOQ7IqpLQZjrxhEGpo=', 'id': u'5c24906d-69bb-40bb-bf5a-090ca5acb012'}
> test_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: ========Sending GET Cmd : listPortForwardingRules=======
> requests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216
> requests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&response=json&command=listPortForwardingRules&signature=NzSPBRvKOWOQ7IqpLQZjrxhEGpo%3D&id=5c24906d-69bb-40bb-bf5a-090ca5acb012 HTTP/1.1" 200 607
> test_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: Response : [{networkid : u'24c2f881-a06e-4bdd-ae5c-0fe02f296070', virtualmachinename : u'VM-4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6', protocol : u'tcp', virtualmachineid : u'4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6', publicport : u'2222', cidrlist : u'', fordisplay : True, ipaddressid : u'48bdb986-45d6-400c-9d26-6ebeff4316d1', virtualmachinedisplayname : u'Test VM', vmguestip : u'192.168.200.3', state : u'Active', publicendport : u'2222', privateport : u'22', privateendport : u'22', ipaddress : u'10.220.164.52', id : u'5c24906d-69bb-40bb-bf5a-090ca5acb012', tags : []}]
> test_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: SSHing into VM with IP address 192.168.200.3 with NAT IP 10.220.164.52
> sshClient: DEBUG: ====Trying SSH Connection: Host:10.220.164.52 User:root Port:22 RetryCnt:20===
> sshClient: ERROR: SshClient: Exception under createConnection: ['Traceback (most recent call last):\n', ' File "/local/jenkins/workspace/xenrt-bvt-adv-xs/work.27/env/local/lib/python2.7/site-packages/marvin/sshClient.py", line 123, in createConnection\n timeout=self.timeout)\n', ' File "/usr/local/lib/python2.7/dist-packages/paramiko/client.py", line 236, in connect\n retry_on_signal(lambda: sock.connect(addr))\n', ' File "/usr/local/lib/python2.7/dist-packages/paramiko/util.py", line 279, in retry_on_signal\n return function()\n', ' File "/usr/local/lib/python2.7/dist-packages/paramiko/client.py", line 236, in <lambda>\n retry_on_signal(lambda: sock.connect(addr))\n', ' File "/usr/lib/python2.7/socket.py", line 224, in meth\n return getattr(self._sock,name)(*args)\n', 'timeout: timed out\n']
> Traceback (most recent call last):
> File "/local/jenkins/workspace/xenrt-bvt-adv-xs/work.27/env/local/lib/python2.7/site-packages/marvin/sshClient.py", line 123, in createConnection
> timeout=self.timeout)
> File "/usr/local/lib/python2.7/dist-packages/paramiko/client.py", line 236, in connect
> retry_on_signal(lambda: sock.connect(addr))
> File "/usr/local/lib/python2.7/dist-packages/paramiko/util.py", line 279, in retry_on_signal
> return function()
> File "/usr/local/lib/python2.7/dist-packages/paramiko/client.py", line 236, in <lambda>
> retry_on_signal(lambda: sock.connect(addr))
> File "/usr/lib/python2.7/socket.py", line 224, in meth
> return getattr(self._sock,name)(*args)
> timeout: timed out
> test_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): CRITICAL: FAILED: test_01_port_fwd_on_src_nat: ['Traceback (most recent call last):\n', ' File "/usr/lib/python2.7/unittest/case.py", line 332, in run\n testMethod()\n', ' File "/home/jenkins/workspace/xenrt-bvt-adv-xs/cloudstack.git/test/integration/smoke/test_network.py", line 387, in test_01_port_fwd_on_src_nat\n (self.virtual_machine.ipaddress, e)\n', ' File "/usr/lib/python2.7/unittest/case.py", line 413, in fail\n raise self.failureException(msg)\n', 'AssertionError: SSH Access failed for 192.168.200.3: SSH connection has Failed. Waited 600s. Error is SSH Connection Failed\n']
> --------------------- >> end captured logging << ---------------------
> Stacktrace
> File "/usr/lib/python2.7/unittest/case.py", line 332, in run
> testMethod()
> File "/home/jenkins/workspace/xenrt-bvt-adv-xs/cloudstack.git/test/integration/smoke/test_network.py", line 387, in test_01_port_fwd_on_src_nat
> (self.virtual_machine.ipaddress, e)
> File "/usr/lib/python2.7/unittest/case.py", line 413, in fail
> raise self.failureException(msg)
> 'SSH Access failed for 192.168.200.3: SSH connection has Failed. Waited 600s. Error is SSH Connection Failed\n-------------------- >> begin captured stdout << ---------------------\n=== TestName: test_01_port_fwd_on_src_nat | Status : FAILED ===\n\n\n--------------------- >> end captured stdout << ----------------------\n-------------------- >> begin captured logging << --------------------\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Payload: {\'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'command\': \'listDomains\', \'signature\': \'ctalIurZt9TyhD+SmdjEEFJ+Ask=\', \'response\': \'json\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: ========Sending GET Cmd : listDomains=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&command=listDomains&signature=ctalIurZt9TyhD%2BSmdjEEFJ%2BAsk%3D&response=json HTTP/1.1" 200 159\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Response : [{path : u\'ROOT\', haschild : False, id : u\'88e3046c-d6e9-11e3-ba11-1258f5fe9d0b\', name : u\'ROOT\', level : 0}]\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Payload: {\'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'name\': u\'XenRT-Zone-0\', \'command\': \'listZones\', \'signature\': \'pbUfWFF3msTJPtxOM8LuQpLrlzU=\', \'response\': \'json\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: ========Sending GET Cmd : listZones=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&name=XenRT-Zone-0&command=listZones&signature=pbUfWFF3msTJPtxOM8LuQpLrlzU%3D&response=json HTTP/1.1" 200 417\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Response : [{localstorageenabled : False, name : u\'XenRT-Zone-0\', guestcidraddress : u\'192.168.200.0/24\', tags : [], zonetoken : u\'90ba0d6e-9b3d-3dfc-86b0-a5fb83156a43\', dns1 : u\'10.219.128.34\', securitygroupsenabled : False, allocationstate : u\'Enabled\', internaldns1 : u\'10.219.128.34\', dhcpprovider : u\'VirtualRouter\', networktype : u\'Advanced\', id : u\'6080fb58-a52b-4987-8bb0-4e58a53455ec\'}]\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Payload: {\'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'templatefilter\': \'featured\', \'command\': \'listTemplates\', \'signature\': \'2UaIag3I4793CA/AiL67R+bPKxQ=\', \'zoneid\': u\'6080fb58-a52b-4987-8bb0-4e58a53455ec\', \'response\': \'json\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: ========Sending GET Cmd : listTemplates=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&templatefilter=featured&command=listTemplates&signature=2UaIag3I4793CA%2FAiL67R%2BbPKxQ%3D&zoneid=6080fb58-a52b-4987-8bb0-4e58a53455ec&response=json HTTP/1.1" 200 822\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Response : [{domain : u\'ROOT\', domainid : u\'88e3046c-d6e9-11e3-ba11-1258f5fe9d0b\', ostypename : u\'CentOS 5.6 (64-bit)\', zoneid : u\'6080fb58-a52b-4987-8bb0-4e58a53455ec\', displaytext : u\'CentOS 5.6(64-bit) no GUI (XenServer)\', ostypeid : u\'8915b1d2-d6e9-11e3-ba11-1258f5fe9d0b\', passwordenabled : False, id : u\'88ebfbd0-d6e9-11e3-ba11-1258f5fe9d0b\', size : 21474836480, isready : True, format : u\'VHD\', templatetype : u\'BUILTIN\', zonename : u\'XenRT-Zone-0\', status : u\'Download Complete\', isdynamicallyscalable : True, tags : [], isfeatured : True, sshkeyenabled : False, isextractable : True, crossZones : True, account : u\'system\', name : u\'CentOS 5.6(64-bit) no GUI (XenServer)\', created : u\'2014-05-08T20:08:53+0000\', hypervisor : u\'XenServer\', ispublic : True, checksum : u\'905cec879afd9c9d22ecc8036131a180\'}]\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Payload: {\'username\': \'test-account-TestVpcSite2SiteVpn-test_nic_secondaryip_add_remove-M111Q9\', \'domainid\': u\'88e3046c-d6e9-11e3-ba11-1258f5fe9d0b\', \'firstname\': \'test\', \'lastname\': \'test\', \'response\': \'json\', \'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'command\': \'createAccount\', \'accounttype\': 2, \'signature\': \'HgIb6r7osojFjt+FRSRHN0X7KyU=\', \'password\': \'password\', \'email\': \'test-account@test.com\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: ========Sending GET Cmd : createAccount=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?username=test-account-TestVpcSite2SiteVpn-test_nic_secondaryip_add_remove-M111Q9&domainid=88e3046c-d6e9-11e3-ba11-1258f5fe9d0b&firstname=test&lastname=test&response=json&apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&command=createAccount&accounttype=2&signature=HgIb6r7osojFjt%2BFRSRHN0X7KyU%3D&password=password&email=test-account%40test.com HTTP/1.1" 200 1781\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Response : {primarystorageavailable : u\'Unlimited\', domain : u\'ROOT\', domainid : u\'88e3046c-d6e9-11e3-ba11-1258f5fe9d0b\', vpclimit : u\'Unlimited\', iplimit : u\'Unlimited\', volumelimit : u\'Unlimited\', memorytotal : 0, secondarystorageavailable : u\'Unlimited\', vmtotal : 0, cputotal : 0, vpctotal : 0, id : u\'aa3c4080-8cdf-480c-99c8-01dfbb34fb22\', cpuavailable : u\'Unlimited\', snapshotlimit : u\'Unlimited\', networklimit : u\'Unlimited\', iptotal : 0, volumetotal : 0, projectlimit : u\'Unlimited\', state : u\'enabled\', networktotal : 0, accounttype : 2, networkavailable : u\'Unlimited\', primarystoragetotal : 0, templatelimit : u\'Unlimited\', snapshottotal : 0, templateavailable : u\'Unlimited\', vmlimit : u\'Unlimited\', vpcavailable : u\'Unlimited\', memoryavailable : u\'Unlimited\', secondarystoragetotal : 0, templatetotal : 0, projecttotal : 0, user : [{username : u\'test-account-TestVpcSite2SiteVpn-test_nic_secondaryip_add_remove-M111Q9\', account : u\'test-account-TestVpcSite2SiteVpn-test_nic_secondaryip_add_remove-M111Q9\', domainid : u\'88e3046c-d6e9-11e3-ba11-1258f5fe9d0b\', firstname : u\'test\', created : u\'2014-05-08T20:32:35+0000\', lastname : u\'test\', domain : u\'ROOT\', id : u\'900bf0c4-2e72-4e50-80e8-a2a5f491f775\', iscallerchilddomain : False, state : u\'enabled\', accounttype : 2, email : u\'test-account@test.com\', isdefault : False, accountid : u\'aa3c4080-8cdf-480c-99c8-01dfbb34fb22\'}], groups : [u\'DOMAIN_ADMIN\', u\'DomainGrp-88e3046c-d6e9-11e3-ba11-1258f5fe9d0b\'], projectavailable : u\'Unlimited\', isdefault : False, primarystoragelimit : u\'Unlimited\', secondarystoragelimit : u\'Unlimited\', volumeavailable : u\'Unlimited\', name : u\'test-account-TestVpcSite2SiteVpn-test_nic_secondaryip_add_remove-M111Q9\', vmavailable : u\'Unlimited\', ipavailable : u\'13\', memorylimit : u\'Unlimited\', cpulimit : u\'Unlimited\', snapshotavailable : u\'Unlimited\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Payload: {\'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'cpunumber\': 1, \'memory\': 128, \'cpuspeed\': 100, \'response\': \'json\', \'name\': \'Tiny Instance\', \'command\': \'createServiceOffering\', \'signature\': \'ouAJOW40gj7tN2zfD2oe5W813AA=\', \'displaytext\': \'Tiny Instance\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: ========Sending GET Cmd : createServiceOffering=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&cpunumber=1&memory=128&cpuspeed=100&response=json&name=Tiny+Instance&command=createServiceOffering&signature=ouAJOW40gj7tN2zfD2oe5W813AA%3D&displaytext=Tiny+Instance HTTP/1.1" 200 376\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Response : {iscustomized : False, name : u\'Tiny Instance\', created : u\'2014-05-08T20:32:35+0000\', storagetype : u\'shared\', limitcpuuse : False, memory : 128, offerha : False, isvolatile : False, cpunumber : 1, cpuspeed : 100, displaytext : u\'Tiny Instance\', issystem : False, id : u\'be440a0c-e43e-42ec-9da7-f5db0245b314\', defaultuse : False}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Payload: {\'domainid\': u\'88e3046c-d6e9-11e3-ba11-1258f5fe9d0b\', \'zoneid\': u\'6080fb58-a52b-4987-8bb0-4e58a53455ec\', \'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'userdata\': \'TFNMTUZESzdMQlhaT1hXRFBHM09aV0QyQktTRDlRMEcwS1hBV0RHTjRUMzVCSkZNRzFOMjFJQkRLVUlFVjVRMjc2UDdJWVhWV05BNjBVU0NYMldLRTQyTFIzNjhJUjNWR0hLMjJWTjdBNzJNMzZaTlJLMUlGRDUwMDJNUEZKMk1NUUVEVzI0SkYzSlhSSlpOSEFIWENOVTFVTzFFNFJIVzFUUlozRDY0NkM5VERGOEJGV0Q3OFNSTFM0NlZXVU1DNktOT1FDMDA0WVNSRUFUSUVCQ1dWSk9JNTVZSlQ2WUk1WUhOTFNSWE5JR1U5REtXTzFERUZVTlFUVjFOTTQ3WE9QQkxaN0wyRk0yU05XRjYwTlNFTDA3WlZIMzNNWDJPS1g1RUFQQlFHUVNZM0E0R1hYSjlQMkZTUTBKVkdGTVQyQTJMRjdMNjVBU1JaODFVSThWN0FCMFZaQjZMUk5BSVZQTTYwRFc4UzNVREJSWklGRzNPMkVaSzJZU1Q4NjgxT080MzVIVzhaSTQ5MFhXWFAxWDgzT1EwSDVUNVNGNDhaOElLRjdVQ1ZIODE0Sk9OV1k0RUhZOUgwRUYwQzNXUkVDVDdQMlhBMjJDN0Y0TTkzVjdPMFVQQTg2M0FRNzBYMU1LU1RZTzEwVVM0TkVJSElDUkMzSkE0SDE0WEFCSEJNU1QzNElQMFRSM0hZQ1ZYVTFVNjhMTUw2V1RPMUM5VDlTN1MxOFhRVFVVREwzTzYzMDVHTkY2OVFBS1ZOMkdERFZGTk1BOTlTWjhQODZPRDBNRDk1NUJONU5RRkYzT0dEMktKNDlUWVNIWkY2ODFQQUVNUlQzOFJKUFdXQVhTSlpSUzU0SkdDUFk4TEQ1SU45NUU4WVVOOEFOME5MRTlWRFVOVkkxVVUzOUcwSDkxWlVPRjdOQ0NLSThHRjRZT1NORFQ1MFRJTlNPME5TNk85Q0c2RTY1QlhLUUFNNURCNExEMUJHRDU4V0Q2QjBaVUtLSFpVVjg3OFdQQk04UTROV0lISVMyUERXNFpCR08yVExZMTYzUlZTNlZKS1JWMVpPVEhZV0RUTTBDVDFUMk9QUTFQQzZHMjFCQkZSODZSSVIwUkYyOEU1N1A0T1gwN1JZNTVGOFRZUUJNMFVHUjdEQjJFUEFPV0tQQkEyNjVTM0o4V1Q2UUMwRjJaS0VHVjhNS0lCRlozQzhLUzdLT1VGN1BWVElDTU83V0o4MVIwNExXSlYzTFdCUkE2RTJINjRPUTQyVzZJTDNSRlNFWURFT1hZOUEzUVoyV0lFUlVPOE9JNFlUNDZJMkIwMTY3NllDMVJCQjc4WDVGM1JNME1JSk1RV1MxQTFTMUEyR09ZR05QMFREUUc4Nk9GWVhTSUNYVDdDNjRQVUNYM1BUT0VUNEJCUURTVFFZV043NVBOUFlUQzhTSThEMlhUV0tQTUNTVjNHUUJTNDgxVkc5NDJPSzNMMFMzV1JKNUZDREFMTU9MMVhTV1hWNVlHWElDVUpBMkNBQTFDOERHRkVQU0tCRkVHVzVUTVBBUFFDT09TVkFETURFQTVWNkhaTjFFQ1RUOTRHVVpZUlJWTkNTM09SR1RWTERJTUszMFdSM05GVVZIN0VWVVk4SjAyWlVESDVLRUsxTjJPUFhJNkEyOVdUQzUxTTg1REhFQjM5MVo4QzlRNEg1WTNVRzc0RFNUQUNYWkQ1RVJDWUxBTDJOWTAzOUJHWjNJTEgyVkZNTUZHT0VKR1pDUE0zOVhRNDhKTktXRDJKRVVNMzNLSkZJUUFWSDNPOU1QOTlERTZEV0lFRTJXQThCMDNHVEdOVDZDTVZMM0RXOUhJRVdUV0daMERKUzc5STdPVTBTNUtXMDI4WDFLVlQ3NjU5SjIwODdFT1lBSlpYWThRV0xEREU4Q0FTNUxOOVlSSENFRVBKRDQyQlZCUk1WSEJEVVlGSFlENk9XQU8zUzJQVFczUEJEWjI2QTIwUlRVMDJCMFdMNEFJTDg0TDhRU0FaSjczU1VPN05LR05GODAyUUVWODM4Q1I4TEVBSUo5UlhHOUw5N0REVzEwSU9SREg1MFo5UU4zTk1PTkVMNk9PWVdNOUtaTVhHUk1QMkVOUTE0TzhYQzEwNUY3MDBWQlJaV0VIMEgwM05WQ0lWTVQwMU9QWFRIN09PQUNLTjFYRUIwUU9OWU5DM0VBSEhYWDdFRzlDMjlOTEtOWlY2UjhJOTZPUk02REMwR0JENEk4OTUwMUg4NE5QS0FWTDdTTlBZTjQ0V0RWN1I3N0tPMTlGUlQyVzczUlBUWUJXS1dKMk02NUhMVk8zN0ZOUEE5Q01PSklMT1pQUTlRWklHUDFLOFlaSFFMNEE2MkRBVUtIUDJHR0xVR05JVDNUVDIzODNRWEZOVjZCM0VFQTlHR1dDQlo4MVo2Q0Y2VUVQVDU1MjFUQ0dJUzhLRUQ4Q0hZV0xBWjkyRFU0QkoyQUJGSDI3M1dROUhZTzRTSjhMWVdSUk9FTUdQWFA4Mlg3MUNaWkFFMTQxNTZUOEdEV0ZSOVJRRFNYVTBUSjJWWlROODVMMEJNSTdKWERTWkY3Q0pTWDFURVpUSExYTDBaU0MwMVI4VkFBTUo3OUlESFNKQjNPUklLQTQ4RElKTVFFQjAxWklLUTYxSzNQVTFHUEQ5Sko3SFNGT1ZSNE5KUzE1UUZJWThKMVRUQ0FNRVkyRDZPNEVCTjdETjhET0pWOVZTRzdOSTU1RzBCODlGQk5YQUtFTTNaQ0pMTDc2VDZaOURPR09WNEUyVktGOFNUU0RYVlFKSVowNFpZWTYwQUFYM1lTTFpaTFo2REVRQ1oyWDBPSkRNQkdPWUxJVTJIMFJPR0RGUzJFVllBRzJPTDg1SU81MzJFNzdHOVgwN1kyRUVIRkVMSjBRT043TFdURFpKM0dDTFlHNExYNVRUNlZNOUNDVkZBUk5ZUVFTSEgwUE1WQlVETUdQWlRYRVVHWFI3RzFIRVBXV04wWDJSM01LWE5ONlBTVkZRNzVGMlFOMDUyQ0swWVlFVzZIUFVXWlMxUlhKWlhJWlJWSzEzVVU3SUpHR0dVWjJYVkU3UUFZRUlJS0ZCSDgzSDBHN1BZNEwxS0ZVQTdSWjdLS042QkozVVU0UDc1V0pQMDJRRkpDOVdWUk9DTklTV0cyQUFESUZTSEZVRE1ETEo2Q1k4RjlOMjVMUDZSWk1OMVA2SFZKVlRQSEFHMzZNSDNGQ0I1QUk0QUxOTDJZMEU1M0JUSFU4QkJDWDY4Wk1TRzAxQTFVV1NJTjZSN0ZTTVFVV0JVUUlIRVk0SlRKSFBaTERBNTY5WQ==\', \'serviceofferingid\': u\'be440a0c-e43e-42ec-9da7-f5db0245b314\', \'displayname\': \'Test VM\', \'signature\': \'AkjkuPDIvajF3cEgjjtox2L2jF4=\', \'templateid\': u\'88ebfbd0-d6e9-11e3-ba11-1258f5fe9d0b\', \'response\': \'json\', \'account\': u\'test-account-TestVpcSite2SiteVpn-test_nic_secondaryip_add_remove-M111Q9\', \'command\': \'deployVirtualMachine\', \'hypervisor\': \'XenServer\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: ========Sending GET Cmd : deployVirtualMachine=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?domainid=88e3046c-d6e9-11e3-ba11-1258f5fe9d0b&zoneid=6080fb58-a52b-4987-8bb0-4e58a53455ec&apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&userdata=TFNMTUZESzdMQlhaT1hXRFBHM09aV0QyQktTRDlRMEcwS1hBV0RHTjRUMzVCSkZNRzFOMjFJQkRLVUlFVjVRMjc2UDdJWVhWV05BNjBVU0NYMldLRTQyTFIzNjhJUjNWR0hLMjJWTjdBNzJNMzZaTlJLMUlGRDUwMDJNUEZKMk1NUUVEVzI0SkYzSlhSSlpOSEFIWENOVTFVTzFFNFJIVzFUUlozRDY0NkM5VERGOEJGV0Q3OFNSTFM0NlZXVU1DNktOT1FDMDA0WVNSRUFUSUVCQ1dWSk9JNTVZSlQ2WUk1WUhOTFNSWE5JR1U5REtXTzFERUZVTlFUVjFOTTQ3WE9QQkxaN0wyRk0yU05XRjYwTlNFTDA3WlZIMzNNWDJPS1g1RUFQQlFHUVNZM0E0R1hYSjlQMkZTUTBKVkdGTVQyQTJMRjdMNjVBU1JaODFVSThWN0FCMFZaQjZMUk5BSVZQTTYwRFc4UzNVREJSWklGRzNPMkVaSzJZU1Q4NjgxT080MzVIVzhaSTQ5MFhXWFAxWDgzT1EwSDVUNVNGNDhaOElLRjdVQ1ZIODE0Sk9OV1k0RUhZOUgwRUYwQzNXUkVDVDdQMlhBMjJDN0Y0TTkzVjdPMFVQQTg2M0FRNzBYMU1LU1RZTzEwVVM0TkVJSElDUkMzSkE0SDE0WEFCSEJNU1QzNElQMFRSM0hZQ1ZYVTFVNjhMTUw2V1RPMUM5VDlTN1MxOFhRVFVVREwzTzYzMDVHTkY2OVFBS1ZOMkdERFZGTk1BOTlTWjhQODZPRDBNRDk1NUJONU5RRkYzT0dEMktKNDlUWVNIWkY2ODFQQUVNUlQzOFJKUFdXQVhTSlpSUzU0SkdDUFk4TEQ1SU45NUU4WVVOOEFOME5MRTlWRFVOVkkxVVUzOUcwSDkxWlVPRjdOQ0NLSThHRjRZT1NORFQ1MFRJTlNPME5TNk85Q0c2RTY1QlhLUUFNNURCNExEMUJHRDU4V0Q2QjBaVUtLSFpVVjg3OFdQQk04UTROV0lISVMyUERXNFpCR08yVExZMTYzUlZTNlZKS1JWMVpPVEhZV0RUTTBDVDFUMk9QUTFQQzZHMjFCQkZSODZSSVIwUkYyOEU1N1A0T1gwN1JZNTVGOFRZUUJNMFVHUjdEQjJFUEFPV0tQQkEyNjVTM0o4V1Q2UUMwRjJaS0VHVjhNS0lCRlozQzhLUzdLT1VGN1BWVElDTU83V0o4MVIwNExXSlYzTFdCUkE2RTJINjRPUTQyVzZJTDNSRlNFWURFT1hZOUEzUVoyV0lFUlVPOE9JNFlUNDZJMkIwMTY3NllDMVJCQjc4WDVGM1JNME1JSk1RV1MxQTFTMUEyR09ZR05QMFREUUc4Nk9GWVhTSUNYVDdDNjRQVUNYM1BUT0VUNEJCUURTVFFZV043NVBOUFlUQzhTSThEMlhUV0tQTUNTVjNHUUJTNDgxVkc5NDJPSzNMMFMzV1JKNUZDREFMTU9MMVhTV1hWNVlHWElDVUpBMkNBQTFDOERHRkVQU0tCRkVHVzVUTVBBUFFDT09TVkFETURFQTVWNkhaTjFFQ1RUOTRHVVpZUlJWTkNTM09SR1RWTERJTUszMFdSM05GVVZIN0VWVVk4SjAyWlVESDVLRUsxTjJPUFhJNkEyOVdUQzUxTTg1REhFQjM5MVo4QzlRNEg1WTNVRzc0RFNUQUNYWkQ1RVJDWUxBTDJOWTAzOUJHWjNJTEgyVkZNTUZHT0VKR1pDUE0zOVhRNDhKTktXRDJKRVVNMzNLSkZJUUFWSDNPOU1QOTlERTZEV0lFRTJXQThCMDNHVEdOVDZDTVZMM0RXOUhJRVdUV0daMERKUzc5STdPVTBTNUtXMDI4WDFLVlQ3NjU5SjIwODdFT1lBSlpYWThRV0xEREU4Q0FTNUxOOVlSSENFRVBKRDQyQlZCUk1WSEJEVVlGSFlENk9XQU8zUzJQVFczUEJEWjI2QTIwUlRVMDJCMFdMNEFJTDg0TDhRU0FaSjczU1VPN05LR05GODAyUUVWODM4Q1I4TEVBSUo5UlhHOUw5N0REVzEwSU9SREg1MFo5UU4zTk1PTkVMNk9PWVdNOUtaTVhHUk1QMkVOUTE0TzhYQzEwNUY3MDBWQlJaV0VIMEgwM05WQ0lWTVQwMU9QWFRIN09PQUNLTjFYRUIwUU9OWU5DM0VBSEhYWDdFRzlDMjlOTEtOWlY2UjhJOTZPUk02REMwR0JENEk4OTUwMUg4NE5QS0FWTDdTTlBZTjQ0V0RWN1I3N0tPMTlGUlQyVzczUlBUWUJXS1dKMk02NUhMVk8zN0ZOUEE5Q01PSklMT1pQUTlRWklHUDFLOFlaSFFMNEE2MkRBVUtIUDJHR0xVR05JVDNUVDIzODNRWEZOVjZCM0VFQTlHR1dDQlo4MVo2Q0Y2VUVQVDU1MjFUQ0dJUzhLRUQ4Q0hZV0xBWjkyRFU0QkoyQUJGSDI3M1dROUhZTzRTSjhMWVdSUk9FTUdQWFA4Mlg3MUNaWkFFMTQxNTZUOEdEV0ZSOVJRRFNYVTBUSjJWWlROODVMMEJNSTdKWERTWkY3Q0pTWDFURVpUSExYTDBaU0MwMVI4VkFBTUo3OUlESFNKQjNPUklLQTQ4RElKTVFFQjAxWklLUTYxSzNQVTFHUEQ5Sko3SFNGT1ZSNE5KUzE1UUZJWThKMVRUQ0FNRVkyRDZPNEVCTjdETjhET0pWOVZTRzdOSTU1RzBCODlGQk5YQUtFTTNaQ0pMTDc2VDZaOURPR09WNEUyVktGOFNUU0RYVlFKSVowNFpZWTYwQUFYM1lTTFpaTFo2REVRQ1oyWDBPSkRNQkdPWUxJVTJIMFJPR0RGUzJFVllBRzJPTDg1SU81MzJFNzdHOVgwN1kyRUVIRkVMSjBRT043TFdURFpKM0dDTFlHNExYNVRUNlZNOUNDVkZBUk5ZUVFTSEgwUE1WQlVETUdQWlRYRVVHWFI3RzFIRVBXV04wWDJSM01LWE5ONlBTVkZRNzVGMlFOMDUyQ0swWVlFVzZIUFVXWlMxUlhKWlhJWlJWSzEzVVU3SUpHR0dVWjJYVkU3UUFZRUlJS0ZCSDgzSDBHN1BZNEwxS0ZVQTdSWjdLS042QkozVVU0UDc1V0pQMDJRRkpDOVdWUk9DTklTV0cyQUFESUZTSEZVRE1ETEo2Q1k4RjlOMjVMUDZSWk1OMVA2SFZKVlRQSEFHMzZNSDNGQ0I1QUk0QUxOTDJZMEU1M0JUSFU4QkJDWDY4Wk1TRzAxQTFVV1NJTjZSN0ZTTVFVV0JVUUlIRVk0SlRKSFBaTERBNTY5WQ%3D%3D&serviceofferingid=be440a0c-e43e-42ec-9da7-f5db0245b314&displayname=Test+VM&signature=AkjkuPDIvajF3cEgjjtox2L2jF4%3D&templateid=88ebfbd0-d6e9-11e3-ba11-1258f5fe9d0b&response=json&account=test-account-TestVpcSite2SiteVpn-test_nic_secondaryip_add_remove-M111Q9&command=deployVirtualMachine&hypervisor=XenServer HTTP/1.1" 200 129\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: === Jobid: cdf242ab-557a-4cd8-bfe3-a17982770260 Started ===\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Payload: {\'signature\': \'KUy+uQ3HQmvgM246cw1IieyyupQ=\', \'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'command\': \'queryAsyncJobResult\', \'response\': \'json\', \'jobid\': u\'cdf242ab-557a-4cd8-bfe3-a17982770260\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: ========Sending GET Cmd : queryAsyncJobResult=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?signature=KUy%2BuQ3HQmvgM246cw1IieyyupQ%3D&apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&command=queryAsyncJobResult&response=json&jobid=cdf242ab-557a-4cd8-bfe3-a17982770260 HTTP/1.1" 200 430\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Response : {jobprocstatus : 0, created : u\'2014-05-08T20:32:35+0000\', cmd : u\'org.apache.cloudstack.api.command.admin.vm.DeployVMCmdByAdmin\', userid : u\'b0ee86a2-d6e9-11e3-ba11-1258f5fe9d0b\', jobstatus : 0, jobid : u\'cdf242ab-557a-4cd8-bfe3-a17982770260\', jobresultcode : 0, jobinstanceid : u\'4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', jobinstancetype : u\'VirtualMachine\', accountid : u\'b0ee7914-d6e9-11e3-ba11-1258f5fe9d0b\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: === JobId:cdf242ab-557a-4cd8-bfe3-a17982770260 is Still Processing, Will TimeOut in:3595 ====\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Payload: {\'signature\': \'KUy+uQ3HQmvgM246cw1IieyyupQ=\', \'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'command\': \'queryAsyncJobResult\', \'response\': \'json\', \'jobid\': u\'cdf242ab-557a-4cd8-bfe3-a17982770260\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: ========Sending GET Cmd : queryAsyncJobResult=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?signature=KUy%2BuQ3HQmvgM246cw1IieyyupQ%3D&apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&command=queryAsyncJobResult&response=json&jobid=cdf242ab-557a-4cd8-bfe3-a17982770260 HTTP/1.1" 200 430\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Response : {jobprocstatus : 0, created : u\'2014-05-08T20:32:35+0000\', cmd : u\'org.apache.cloudstack.api.command.admin.vm.DeployVMCmdByAdmin\', userid : u\'b0ee86a2-d6e9-11e3-ba11-1258f5fe9d0b\', jobstatus : 0, jobid : u\'cdf242ab-557a-4cd8-bfe3-a17982770260\', jobresultcode : 0, jobinstanceid : u\'4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', jobinstancetype : u\'VirtualMachine\', accountid : u\'b0ee7914-d6e9-11e3-ba11-1258f5fe9d0b\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: === JobId:cdf242ab-557a-4cd8-bfe3-a17982770260 is Still Processing, Will TimeOut in:3590 ====\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Payload: {\'signature\': \'KUy+uQ3HQmvgM246cw1IieyyupQ=\', \'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'command\': \'queryAsyncJobResult\', \'response\': \'json\', \'jobid\': u\'cdf242ab-557a-4cd8-bfe3-a17982770260\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: ========Sending GET Cmd : queryAsyncJobResult=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?signature=KUy%2BuQ3HQmvgM246cw1IieyyupQ%3D&apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&command=queryAsyncJobResult&response=json&jobid=cdf242ab-557a-4cd8-bfe3-a17982770260 HTTP/1.1" 200 430\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Response : {jobprocstatus : 0, created : u\'2014-05-08T20:32:35+0000\', cmd : u\'org.apache.cloudstack.api.command.admin.vm.DeployVMCmdByAdmin\', userid : u\'b0ee86a2-d6e9-11e3-ba11-1258f5fe9d0b\', jobstatus : 0, jobid : u\'cdf242ab-557a-4cd8-bfe3-a17982770260\', jobresultcode : 0, jobinstanceid : u\'4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', jobinstancetype : u\'VirtualMachine\', accountid : u\'b0ee7914-d6e9-11e3-ba11-1258f5fe9d0b\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: === JobId:cdf242ab-557a-4cd8-bfe3-a17982770260 is Still Processing, Will TimeOut in:3585 ====\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Payload: {\'signature\': \'KUy+uQ3HQmvgM246cw1IieyyupQ=\', \'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'command\': \'queryAsyncJobResult\', \'response\': \'json\', \'jobid\': u\'cdf242ab-557a-4cd8-bfe3-a17982770260\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: ========Sending GET Cmd : queryAsyncJobResult=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?signature=KUy%2BuQ3HQmvgM246cw1IieyyupQ%3D&apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&command=queryAsyncJobResult&response=json&jobid=cdf242ab-557a-4cd8-bfe3-a17982770260 HTTP/1.1" 200 430\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Response : {jobprocstatus : 0, created : u\'2014-05-08T20:32:35+0000\', cmd : u\'org.apache.cloudstack.api.command.admin.vm.DeployVMCmdByAdmin\', userid : u\'b0ee86a2-d6e9-11e3-ba11-1258f5fe9d0b\', jobstatus : 0, jobid : u\'cdf242ab-557a-4cd8-bfe3-a17982770260\', jobresultcode : 0, jobinstanceid : u\'4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', jobinstancetype : u\'VirtualMachine\', accountid : u\'b0ee7914-d6e9-11e3-ba11-1258f5fe9d0b\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: === JobId:cdf242ab-557a-4cd8-bfe3-a17982770260 is Still Processing, Will TimeOut in:3580 ====\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Payload: {\'signature\': \'KUy+uQ3HQmvgM246cw1IieyyupQ=\', \'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'command\': \'queryAsyncJobResult\', \'response\': \'json\', \'jobid\': u\'cdf242ab-557a-4cd8-bfe3-a17982770260\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: ========Sending GET Cmd : queryAsyncJobResult=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?signature=KUy%2BuQ3HQmvgM246cw1IieyyupQ%3D&apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&command=queryAsyncJobResult&response=json&jobid=cdf242ab-557a-4cd8-bfe3-a17982770260 HTTP/1.1" 200 430\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Response : {jobprocstatus : 0, created : u\'2014-05-08T20:32:35+0000\', cmd : u\'org.apache.cloudstack.api.command.admin.vm.DeployVMCmdByAdmin\', userid : u\'b0ee86a2-d6e9-11e3-ba11-1258f5fe9d0b\', jobstatus : 0, jobid : u\'cdf242ab-557a-4cd8-bfe3-a17982770260\', jobresultcode : 0, jobinstanceid : u\'4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', jobinstancetype : u\'VirtualMachine\', accountid : u\'b0ee7914-d6e9-11e3-ba11-1258f5fe9d0b\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: === JobId:cdf242ab-557a-4cd8-bfe3-a17982770260 is Still Processing, Will TimeOut in:3575 ====\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Payload: {\'signature\': \'KUy+uQ3HQmvgM246cw1IieyyupQ=\', \'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'command\': \'queryAsyncJobResult\', \'response\': \'json\', \'jobid\': u\'cdf242ab-557a-4cd8-bfe3-a17982770260\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: ========Sending GET Cmd : queryAsyncJobResult=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?signature=KUy%2BuQ3HQmvgM246cw1IieyyupQ%3D&apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&command=queryAsyncJobResult&response=json&jobid=cdf242ab-557a-4cd8-bfe3-a17982770260 HTTP/1.1" 200 430\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Response : {jobprocstatus : 0, created : u\'2014-05-08T20:32:35+0000\', cmd : u\'org.apache.cloudstack.api.command.admin.vm.DeployVMCmdByAdmin\', userid : u\'b0ee86a2-d6e9-11e3-ba11-1258f5fe9d0b\', jobstatus : 0, jobid : u\'cdf242ab-557a-4cd8-bfe3-a17982770260\', jobresultcode : 0, jobinstanceid : u\'4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', jobinstancetype : u\'VirtualMachine\', accountid : u\'b0ee7914-d6e9-11e3-ba11-1258f5fe9d0b\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: === JobId:cdf242ab-557a-4cd8-bfe3-a17982770260 is Still Processing, Will TimeOut in:3570 ====\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Payload: {\'signature\': \'KUy+uQ3HQmvgM246cw1IieyyupQ=\', \'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'command\': \'queryAsyncJobResult\', \'response\': \'json\', \'jobid\': u\'cdf242ab-557a-4cd8-bfe3-a17982770260\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: ========Sending GET Cmd : queryAsyncJobResult=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?signature=KUy%2BuQ3HQmvgM246cw1IieyyupQ%3D&apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&command=queryAsyncJobResult&response=json&jobid=cdf242ab-557a-4cd8-bfe3-a17982770260 HTTP/1.1" 200 430\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Response : {jobprocstatus : 0, created : u\'2014-05-08T20:32:35+0000\', cmd : u\'org.apache.cloudstack.api.command.admin.vm.DeployVMCmdByAdmin\', userid : u\'b0ee86a2-d6e9-11e3-ba11-1258f5fe9d0b\', jobstatus : 0, jobid : u\'cdf242ab-557a-4cd8-bfe3-a17982770260\', jobresultcode : 0, jobinstanceid : u\'4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', jobinstancetype : u\'VirtualMachine\', accountid : u\'b0ee7914-d6e9-11e3-ba11-1258f5fe9d0b\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: === JobId:cdf242ab-557a-4cd8-bfe3-a17982770260 is Still Processing, Will TimeOut in:3565 ====\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Payload: {\'signature\': \'KUy+uQ3HQmvgM246cw1IieyyupQ=\', \'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'command\': \'queryAsyncJobResult\', \'response\': \'json\', \'jobid\': u\'cdf242ab-557a-4cd8-bfe3-a17982770260\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: ========Sending GET Cmd : queryAsyncJobResult=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?signature=KUy%2BuQ3HQmvgM246cw1IieyyupQ%3D&apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&command=queryAsyncJobResult&response=json&jobid=cdf242ab-557a-4cd8-bfe3-a17982770260 HTTP/1.1" 200 430\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Response : {jobprocstatus : 0, created : u\'2014-05-08T20:32:35+0000\', cmd : u\'org.apache.cloudstack.api.command.admin.vm.DeployVMCmdByAdmin\', userid : u\'b0ee86a2-d6e9-11e3-ba11-1258f5fe9d0b\', jobstatus : 0, jobid : u\'cdf242ab-557a-4cd8-bfe3-a17982770260\', jobresultcode : 0, jobinstanceid : u\'4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', jobinstancetype : u\'VirtualMachine\', accountid : u\'b0ee7914-d6e9-11e3-ba11-1258f5fe9d0b\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: === JobId:cdf242ab-557a-4cd8-bfe3-a17982770260 is Still Processing, Will TimeOut in:3560 ====\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Payload: {\'signature\': \'KUy+uQ3HQmvgM246cw1IieyyupQ=\', \'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'command\': \'queryAsyncJobResult\', \'response\': \'json\', \'jobid\': u\'cdf242ab-557a-4cd8-bfe3-a17982770260\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: ========Sending GET Cmd : queryAsyncJobResult=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?signature=KUy%2BuQ3HQmvgM246cw1IieyyupQ%3D&apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&command=queryAsyncJobResult&response=json&jobid=cdf242ab-557a-4cd8-bfe3-a17982770260 HTTP/1.1" 200 430\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Response : {jobprocstatus : 0, created : u\'2014-05-08T20:32:35+0000\', cmd : u\'org.apache.cloudstack.api.command.admin.vm.DeployVMCmdByAdmin\', userid : u\'b0ee86a2-d6e9-11e3-ba11-1258f5fe9d0b\', jobstatus : 0, jobid : u\'cdf242ab-557a-4cd8-bfe3-a17982770260\', jobresultcode : 0, jobinstanceid : u\'4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', jobinstancetype : u\'VirtualMachine\', accountid : u\'b0ee7914-d6e9-11e3-ba11-1258f5fe9d0b\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: === JobId:cdf242ab-557a-4cd8-bfe3-a17982770260 is Still Processing, Will TimeOut in:3555 ====\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Payload: {\'signature\': \'KUy+uQ3HQmvgM246cw1IieyyupQ=\', \'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'command\': \'queryAsyncJobResult\', \'response\': \'json\', \'jobid\': u\'cdf242ab-557a-4cd8-bfe3-a17982770260\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: ========Sending GET Cmd : queryAsyncJobResult=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?signature=KUy%2BuQ3HQmvgM246cw1IieyyupQ%3D&apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&command=queryAsyncJobResult&response=json&jobid=cdf242ab-557a-4cd8-bfe3-a17982770260 HTTP/1.1" 200 430\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Response : {jobprocstatus : 0, created : u\'2014-05-08T20:32:35+0000\', cmd : u\'org.apache.cloudstack.api.command.admin.vm.DeployVMCmdByAdmin\', userid : u\'b0ee86a2-d6e9-11e3-ba11-1258f5fe9d0b\', jobstatus : 0, jobid : u\'cdf242ab-557a-4cd8-bfe3-a17982770260\', jobresultcode : 0, jobinstanceid : u\'4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', jobinstancetype : u\'VirtualMachine\', accountid : u\'b0ee7914-d6e9-11e3-ba11-1258f5fe9d0b\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: === JobId:cdf242ab-557a-4cd8-bfe3-a17982770260 is Still Processing, Will TimeOut in:3550 ====\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Payload: {\'signature\': \'KUy+uQ3HQmvgM246cw1IieyyupQ=\', \'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'command\': \'queryAsyncJobResult\', \'response\': \'json\', \'jobid\': u\'cdf242ab-557a-4cd8-bfe3-a17982770260\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: ========Sending GET Cmd : queryAsyncJobResult=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?signature=KUy%2BuQ3HQmvgM246cw1IieyyupQ%3D&apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&command=queryAsyncJobResult&response=json&jobid=cdf242ab-557a-4cd8-bfe3-a17982770260 HTTP/1.1" 200 430\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Response : {jobprocstatus : 0, created : u\'2014-05-08T20:32:35+0000\', cmd : u\'org.apache.cloudstack.api.command.admin.vm.DeployVMCmdByAdmin\', userid : u\'b0ee86a2-d6e9-11e3-ba11-1258f5fe9d0b\', jobstatus : 0, jobid : u\'cdf242ab-557a-4cd8-bfe3-a17982770260\', jobresultcode : 0, jobinstanceid : u\'4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', jobinstancetype : u\'VirtualMachine\', accountid : u\'b0ee7914-d6e9-11e3-ba11-1258f5fe9d0b\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: === JobId:cdf242ab-557a-4cd8-bfe3-a17982770260 is Still Processing, Will TimeOut in:3545 ====\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Payload: {\'signature\': \'KUy+uQ3HQmvgM246cw1IieyyupQ=\', \'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'command\': \'queryAsyncJobResult\', \'response\': \'json\', \'jobid\': u\'cdf242ab-557a-4cd8-bfe3-a17982770260\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: ========Sending GET Cmd : queryAsyncJobResult=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?signature=KUy%2BuQ3HQmvgM246cw1IieyyupQ%3D&apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&command=queryAsyncJobResult&response=json&jobid=cdf242ab-557a-4cd8-bfe3-a17982770260 HTTP/1.1" 200 430\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Response : {jobprocstatus : 0, created : u\'2014-05-08T20:32:35+0000\', cmd : u\'org.apache.cloudstack.api.command.admin.vm.DeployVMCmdByAdmin\', userid : u\'b0ee86a2-d6e9-11e3-ba11-1258f5fe9d0b\', jobstatus : 0, jobid : u\'cdf242ab-557a-4cd8-bfe3-a17982770260\', jobresultcode : 0, jobinstanceid : u\'4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', jobinstancetype : u\'VirtualMachine\', accountid : u\'b0ee7914-d6e9-11e3-ba11-1258f5fe9d0b\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: === JobId:cdf242ab-557a-4cd8-bfe3-a17982770260 is Still Processing, Will TimeOut in:3540 ====\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Payload: {\'signature\': \'KUy+uQ3HQmvgM246cw1IieyyupQ=\', \'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'command\': \'queryAsyncJobResult\', \'response\': \'json\', \'jobid\': u\'cdf242ab-557a-4cd8-bfe3-a17982770260\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: ========Sending GET Cmd : queryAsyncJobResult=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?signature=KUy%2BuQ3HQmvgM246cw1IieyyupQ%3D&apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&command=queryAsyncJobResult&response=json&jobid=cdf242ab-557a-4cd8-bfe3-a17982770260 HTTP/1.1" 200 430\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Response : {jobprocstatus : 0, created : u\'2014-05-08T20:32:35+0000\', cmd : u\'org.apache.cloudstack.api.command.admin.vm.DeployVMCmdByAdmin\', userid : u\'b0ee86a2-d6e9-11e3-ba11-1258f5fe9d0b\', jobstatus : 0, jobid : u\'cdf242ab-557a-4cd8-bfe3-a17982770260\', jobresultcode : 0, jobinstanceid : u\'4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', jobinstancetype : u\'VirtualMachine\', accountid : u\'b0ee7914-d6e9-11e3-ba11-1258f5fe9d0b\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: === JobId:cdf242ab-557a-4cd8-bfe3-a17982770260 is Still Processing, Will TimeOut in:3535 ====\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Payload: {\'signature\': \'KUy+uQ3HQmvgM246cw1IieyyupQ=\', \'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'command\': \'queryAsyncJobResult\', \'response\': \'json\', \'jobid\': u\'cdf242ab-557a-4cd8-bfe3-a17982770260\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: ========Sending GET Cmd : queryAsyncJobResult=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?signature=KUy%2BuQ3HQmvgM246cw1IieyyupQ%3D&apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&command=queryAsyncJobResult&response=json&jobid=cdf242ab-557a-4cd8-bfe3-a17982770260 HTTP/1.1" 200 430\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Response : {jobprocstatus : 0, created : u\'2014-05-08T20:32:35+0000\', cmd : u\'org.apache.cloudstack.api.command.admin.vm.DeployVMCmdByAdmin\', userid : u\'b0ee86a2-d6e9-11e3-ba11-1258f5fe9d0b\', jobstatus : 0, jobid : u\'cdf242ab-557a-4cd8-bfe3-a17982770260\', jobresultcode : 0, jobinstanceid : u\'4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', jobinstancetype : u\'VirtualMachine\', accountid : u\'b0ee7914-d6e9-11e3-ba11-1258f5fe9d0b\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: === JobId:cdf242ab-557a-4cd8-bfe3-a17982770260 is Still Processing, Will TimeOut in:3530 ====\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Payload: {\'signature\': \'KUy+uQ3HQmvgM246cw1IieyyupQ=\', \'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'command\': \'queryAsyncJobResult\', \'response\': \'json\', \'jobid\': u\'cdf242ab-557a-4cd8-bfe3-a17982770260\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: ========Sending GET Cmd : queryAsyncJobResult=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?signature=KUy%2BuQ3HQmvgM246cw1IieyyupQ%3D&apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&command=queryAsyncJobResult&response=json&jobid=cdf242ab-557a-4cd8-bfe3-a17982770260 HTTP/1.1" 200 430\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Response : {jobprocstatus : 0, created : u\'2014-05-08T20:32:35+0000\', cmd : u\'org.apache.cloudstack.api.command.admin.vm.DeployVMCmdByAdmin\', userid : u\'b0ee86a2-d6e9-11e3-ba11-1258f5fe9d0b\', jobstatus : 0, jobid : u\'cdf242ab-557a-4cd8-bfe3-a17982770260\', jobresultcode : 0, jobinstanceid : u\'4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', jobinstancetype : u\'VirtualMachine\', accountid : u\'b0ee7914-d6e9-11e3-ba11-1258f5fe9d0b\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: === JobId:cdf242ab-557a-4cd8-bfe3-a17982770260 is Still Processing, Will TimeOut in:3525 ====\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Payload: {\'signature\': \'KUy+uQ3HQmvgM246cw1IieyyupQ=\', \'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'command\': \'queryAsyncJobResult\', \'response\': \'json\', \'jobid\': u\'cdf242ab-557a-4cd8-bfe3-a17982770260\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: ========Sending GET Cmd : queryAsyncJobResult=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?signature=KUy%2BuQ3HQmvgM246cw1IieyyupQ%3D&apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&command=queryAsyncJobResult&response=json&jobid=cdf242ab-557a-4cd8-bfe3-a17982770260 HTTP/1.1" 200 430\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Response : {jobprocstatus : 0, created : u\'2014-05-08T20:32:35+0000\', cmd : u\'org.apache.cloudstack.api.command.admin.vm.DeployVMCmdByAdmin\', userid : u\'b0ee86a2-d6e9-11e3-ba11-1258f5fe9d0b\', jobstatus : 0, jobid : u\'cdf242ab-557a-4cd8-bfe3-a17982770260\', jobresultcode : 0, jobinstanceid : u\'4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', jobinstancetype : u\'VirtualMachine\', accountid : u\'b0ee7914-d6e9-11e3-ba11-1258f5fe9d0b\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: === JobId:cdf242ab-557a-4cd8-bfe3-a17982770260 is Still Processing, Will TimeOut in:3520 ====\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Payload: {\'signature\': \'KUy+uQ3HQmvgM246cw1IieyyupQ=\', \'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'command\': \'queryAsyncJobResult\', \'response\': \'json\', \'jobid\': u\'cdf242ab-557a-4cd8-bfe3-a17982770260\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: ========Sending GET Cmd : queryAsyncJobResult=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?signature=KUy%2BuQ3HQmvgM246cw1IieyyupQ%3D&apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&command=queryAsyncJobResult&response=json&jobid=cdf242ab-557a-4cd8-bfe3-a17982770260 HTTP/1.1" 200 430\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Response : {jobprocstatus : 0, created : u\'2014-05-08T20:32:35+0000\', cmd : u\'org.apache.cloudstack.api.command.admin.vm.DeployVMCmdByAdmin\', userid : u\'b0ee86a2-d6e9-11e3-ba11-1258f5fe9d0b\', jobstatus : 0, jobid : u\'cdf242ab-557a-4cd8-bfe3-a17982770260\', jobresultcode : 0, jobinstanceid : u\'4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', jobinstancetype : u\'VirtualMachine\', accountid : u\'b0ee7914-d6e9-11e3-ba11-1258f5fe9d0b\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: === JobId:cdf242ab-557a-4cd8-bfe3-a17982770260 is Still Processing, Will TimeOut in:3515 ====\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Payload: {\'signature\': \'KUy+uQ3HQmvgM246cw1IieyyupQ=\', \'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'command\': \'queryAsyncJobResult\', \'response\': \'json\', \'jobid\': u\'cdf242ab-557a-4cd8-bfe3-a17982770260\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: ========Sending GET Cmd : queryAsyncJobResult=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?signature=KUy%2BuQ3HQmvgM246cw1IieyyupQ%3D&apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&command=queryAsyncJobResult&response=json&jobid=cdf242ab-557a-4cd8-bfe3-a17982770260 HTTP/1.1" 200 1956\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Response : {jobprocstatus : 0, created : u\'2014-05-08T20:32:35+0000\', cmd : u\'org.apache.cloudstack.api.command.admin.vm.DeployVMCmdByAdmin\', userid : u\'b0ee86a2-d6e9-11e3-ba11-1258f5fe9d0b\', jobstatus : 1, jobid : u\'cdf242ab-557a-4cd8-bfe3-a17982770260\', jobresultcode : 0, jobresulttype : u\'object\', jobresult : {domain : u\'ROOT\', domainid : u\'88e3046c-d6e9-11e3-ba11-1258f5fe9d0b\', haenable : False, templatename : u\'CentOS 5.6(64-bit) no GUI (XenServer)\', securitygroup : [], zoneid : u\'6080fb58-a52b-4987-8bb0-4e58a53455ec\', cpunumber : 1, ostypeid : 142, passwordenabled : False, instancename : u\'i-12-15-VM\', id : u\'4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', hostname : u\'cl09-C-03\', displayvm : True, state : u\'Running\', guestosid : u\'8915b1d2-d6e9-11e3-ba11-1258f5fe9d0b\', memory : 128, serviceofferingid : u\'be440a0c-e43e-42ec-9da7-f5db0245b314\', zonename : u\'XenRT-Zone-0\', isdynamicallyscalable : True, displayname : u\'Test VM\', tags : [], nic : [{networkid : u\'24c2f881-a06e-4bdd-ae5c-0fe02f296070\', macaddress : u\'02:00:1e:4d:00:01\', isolationuri : u\'vlan://913\', type : u\'Isolated\', broadcasturi : u\'vlan://913\', traffictype : u\'Guest\', netmask : u\'255.255.255.0\', ipaddress : u\'192.168.200.3\', id : u\'9a5fbedd-d596-435a-a0b6-695dea4f61d7\', networkname : u\'test-account-TestVpcSite2SiteVpn-test_nic_secondaryip_add_remove-M111Q9-network\', gateway : u\'192.168.200.1\', isdefault : True}], cpuspeed : 100, jobstatus : 0, templateid : u\'88ebfbd0-d6e9-11e3-ba11-1258f5fe9d0b\', affinitygroup : [], account : u\'test-account-TestVpcSite2SiteVpn-test_nic_secondaryip_add_remove-M111Q9\', hostid : u\'09215d5c-5d36-4081-b10e-b40f81ded71b\', name : u\'VM-4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', created : u\'2014-05-08T20:32:35+0000\', hypervisor : u\'XenServer\', jobid : u\'cdf242ab-557a-4cd8-bfe3-a17982770260\', rootdevicetype : u\'ROOT\', rootdeviceid : 0, serviceofferingname : u\'Tiny Instance\', templatedisplaytext : u\'CentOS 5.6(64-bit) no GUI (XenServer)\'}, accountid : u\'b0ee7914-d6e9-11e3-ba11-1258f5fe9d0b\'}\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: ===Jobid:cdf242ab-557a-4cd8-bfe3-a17982770260 ; StartTime:Thu May 8 20:32:11 2014 ; EndTime:Thu May 8 20:33:37 2014 ; TotalTime:-85===\ntest_nic_secondaryip_add_remove (integration.smoke.test_multipleips_per_nic.TestDeployVM): DEBUG: Response : {jobprocstatus : 0, created : u\'2014-05-08T20:32:35+0000\', cmd : u\'org.apache.cloudstack.api.command.admin.vm.DeployVMCmdByAdmin\', userid : u\'b0ee86a2-d6e9-11e3-ba11-1258f5fe9d0b\', jobstatus : 1, jobid : u\'cdf242ab-557a-4cd8-bfe3-a17982770260\', jobresultcode : 0, jobresulttype : u\'object\', jobresult : {domain : u\'ROOT\', domainid : u\'88e3046c-d6e9-11e3-ba11-1258f5fe9d0b\', haenable : False, templatename : u\'CentOS 5.6(64-bit) no GUI (XenServer)\', securitygroup : [], zoneid : u\'6080fb58-a52b-4987-8bb0-4e58a53455ec\', cpunumber : 1, ostypeid : 142, passwordenabled : False, instancename : u\'i-12-15-VM\', id : u\'4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', hostname : u\'cl09-C-03\', displayvm : True, state : u\'Running\', guestosid : u\'8915b1d2-d6e9-11e3-ba11-1258f5fe9d0b\', memory : 128, serviceofferingid : u\'be440a0c-e43e-42ec-9da7-f5db0245b314\', zonename : u\'XenRT-Zone-0\', isdynamicallyscalable : True, displayname : u\'Test VM\', tags : [], nic : [{networkid : u\'24c2f881-a06e-4bdd-ae5c-0fe02f296070\', macaddress : u\'02:00:1e:4d:00:01\', isolationuri : u\'vlan://913\', type : u\'Isolated\', broadcasturi : u\'vlan://913\', traffictype : u\'Guest\', netmask : u\'255.255.255.0\', ipaddress : u\'192.168.200.3\', id : u\'9a5fbedd-d596-435a-a0b6-695dea4f61d7\', networkname : u\'test-account-TestVpcSite2SiteVpn-test_nic_secondaryip_add_remove-M111Q9-network\', gateway : u\'192.168.200.1\', isdefault : True}], cpuspeed : 100, jobstatus : 0, templateid : u\'88ebfbd0-d6e9-11e3-ba11-1258f5fe9d0b\', affinitygroup : [], account : u\'test-account-TestVpcSite2SiteVpn-test_nic_secondaryip_add_remove-M111Q9\', hostid : u\'09215d5c-5d36-4081-b10e-b40f81ded71b\', name : u\'VM-4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', created : u\'2014-05-08T20:32:35+0000\', hypervisor : u\'XenServer\', jobid : u\'cdf242ab-557a-4cd8-bfe3-a17982770260\', rootdevicetype : u\'ROOT\', rootdeviceid : 0, serviceofferingname : u\'Tiny Instance\', templatedisplaytext : u\'CentOS 5.6(64-bit) no GUI (XenServer)\'}, accountid : u\'b0ee7914-d6e9-11e3-ba11-1258f5fe9d0b\'}\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: ::::::::::::STARTED : TC: test_01_port_fwd_on_src_nat :::::::::::\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: Payload: {\'domainid\': u\'88e3046c-d6e9-11e3-ba11-1258f5fe9d0b\', \'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'response\': \'json\', \'listall\': True, \'account\': u\'test-account-TestVpcSite2SiteVpn-test_nic_secondaryip_add_remove-M111Q9\', \'command\': \'listPublicIpAddresses\', \'signature\': \'cMXvTRoXh0+nG+HN5w6g5zXs20o=\'}\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: ========Sending GET Cmd : listPublicIpAddresses=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?domainid=88e3046c-d6e9-11e3-ba11-1258f5fe9d0b&apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&response=json&listall=True&account=test-account-TestVpcSite2SiteVpn-test_nic_secondaryip_add_remove-M111Q9&command=listPublicIpAddresses&signature=cMXvTRoXh0%2BnG%2BHN5w6g5zXs20o%3D HTTP/1.1" 200 916\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: Response : [{networkid : u\'06c48461-12cd-4376-a029-38a286b1e6e0\', domain : u\'ROOT\', domainid : u\'88e3046c-d6e9-11e3-ba11-1258f5fe9d0b\', isstaticnat : False, zoneid : u\'6080fb58-a52b-4987-8bb0-4e58a53455ec\', allocated : u\'2014-05-08T20:32:37+0000\', id : u\'48bdb986-45d6-400c-9d26-6ebeff4316d1\', physicalnetworkid : u\'63ae8941-6ee5-41ef-b532-ff4fe8707d96\', fordisplay : True, issourcenat : True, vlanid : u\'bbc10cb3-379c-4dfd-afff-e4fe948fd365\', state : u\'Allocated\', forvirtualnetwork : True, zonename : u\'XenRT-Zone-0\', tags : [], associatednetworkname : u\'test-account-TestVpcSite2SiteVpn-test_nic_secondaryip_add_remove-M111Q9-network\', vlanname : u\'vlan://untagged\', associatednetworkid : u\'24c2f881-a06e-4bdd-ae5c-0fe02f296070\', ipaddress : u\'10.220.164.52\', isportable : False, account : u\'test-account-TestVpcSite2SiteVpn-test_nic_secondaryip_add_remove-M111Q9\', issystem : False}]\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: Payload: {\'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'id\': u\'4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', \'response\': \'json\', \'command\': \'listVirtualMachines\', \'signature\': \'lYvLE+XWNUQBSvxnNn8ycgrLTF4=\'}\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: ========Sending GET Cmd : listVirtualMachines=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&id=4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6&response=json&command=listVirtualMachines&signature=lYvLE%2BXWNUQBSvxnNn8ycgrLTF4%3D HTTP/1.1" 200 1573\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: Response : [{domain : u\'ROOT\', domainid : u\'88e3046c-d6e9-11e3-ba11-1258f5fe9d0b\', haenable : False, templatename : u\'CentOS 5.6(64-bit) no GUI (XenServer)\', securitygroup : [], zoneid : u\'6080fb58-a52b-4987-8bb0-4e58a53455ec\', cpunumber : 1, ostypeid : 142, passwordenabled : False, instancename : u\'i-12-15-VM\', id : u\'4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', hostname : u\'cl09-C-03\', displayvm : True, state : u\'Running\', guestosid : u\'8915b1d2-d6e9-11e3-ba11-1258f5fe9d0b\', memory : 128, serviceofferingid : u\'be440a0c-e43e-42ec-9da7-f5db0245b314\', zonename : u\'XenRT-Zone-0\', isdynamicallyscalable : True, displayname : u\'Test VM\', tags : [], nic : [{networkid : u\'24c2f881-a06e-4bdd-ae5c-0fe02f296070\', macaddress : u\'02:00:1e:4d:00:01\', isolationuri : u\'vlan://913\', type : u\'Isolated\', broadcasturi : u\'vlan://913\', traffictype : u\'Guest\', netmask : u\'255.255.255.0\', ipaddress : u\'192.168.200.3\', id : u\'9a5fbedd-d596-435a-a0b6-695dea4f61d7\', networkname : u\'test-account-TestVpcSite2SiteVpn-test_nic_secondaryip_add_remove-M111Q9-network\', gateway : u\'192.168.200.1\', isdefault : True}], cpuspeed : 100, templateid : u\'88ebfbd0-d6e9-11e3-ba11-1258f5fe9d0b\', affinitygroup : [], account : u\'test-account-TestVpcSite2SiteVpn-test_nic_secondaryip_add_remove-M111Q9\', hostid : u\'09215d5c-5d36-4081-b10e-b40f81ded71b\', name : u\'VM-4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', created : u\'2014-05-08T20:32:35+0000\', hypervisor : u\'XenServer\', rootdevicetype : u\'ROOT\', rootdeviceid : 0, serviceofferingname : u\'Tiny Instance\', templatedisplaytext : u\'CentOS 5.6(64-bit) no GUI (XenServer)\'}]\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: Payload: {\'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'protocol\': \'TCP\', \'endport\': 2222, \'cidrlist\': \'0.0.0.0/0\', \'ipaddressid\': u\'48bdb986-45d6-400c-9d26-6ebeff4316d1\', \'command\': \'createFirewallRule\', \'signature\': \'NtkiQvfPLK7BTa+zwTVavbEEbJk=\', \'startport\': 2222, \'response\': \'json\'}\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: ========Sending GET Cmd : createFirewallRule=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&protocol=TCP&endport=2222&cidrlist=0.0.0.0%2F0&ipaddressid=48bdb986-45d6-400c-9d26-6ebeff4316d1&command=createFirewallRule&signature=NtkiQvfPLK7BTa%2BzwTVavbEEbJk%3D&startport=2222&response=json HTTP/1.1" 200 127\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: === Jobid: 274e68f7-7256-42ed-bdc1-f048bd474e87 Started ===\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: Payload: {\'signature\': \'WSFXcElWYF3qBimWsSWfBjmyIyc=\', \'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'command\': \'queryAsyncJobResult\', \'response\': \'json\', \'jobid\': u\'274e68f7-7256-42ed-bdc1-f048bd474e87\'}\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: ========Sending GET Cmd : queryAsyncJobResult=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?signature=WSFXcElWYF3qBimWsSWfBjmyIyc%3D&apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&command=queryAsyncJobResult&response=json&jobid=274e68f7-7256-42ed-bdc1-f048bd474e87 HTTP/1.1" 200 436\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: Response : {jobprocstatus : 0, created : u\'2014-05-08T20:34:02+0000\', cmd : u\'org.apache.cloudstack.api.command.user.firewall.CreateFirewallRuleCmd\', userid : u\'b0ee86a2-d6e9-11e3-ba11-1258f5fe9d0b\', jobstatus : 0, jobid : u\'274e68f7-7256-42ed-bdc1-f048bd474e87\', jobresultcode : 0, jobinstanceid : u\'4a08c565-cdb8-401a-9ba1-775780cf3b51\', jobinstancetype : u\'FirewallRule\', accountid : u\'b0ee7914-d6e9-11e3-ba11-1258f5fe9d0b\'}\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: === JobId:274e68f7-7256-42ed-bdc1-f048bd474e87 is Still Processing, Will TimeOut in:3595 ====\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: Payload: {\'signature\': \'WSFXcElWYF3qBimWsSWfBjmyIyc=\', \'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'command\': \'queryAsyncJobResult\', \'response\': \'json\', \'jobid\': u\'274e68f7-7256-42ed-bdc1-f048bd474e87\'}\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: ========Sending GET Cmd : queryAsyncJobResult=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?signature=WSFXcElWYF3qBimWsSWfBjmyIyc%3D&apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&command=queryAsyncJobResult&response=json&jobid=274e68f7-7256-42ed-bdc1-f048bd474e87 HTTP/1.1" 200 701\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: Response : {jobprocstatus : 0, created : u\'2014-05-08T20:34:02+0000\', cmd : u\'org.apache.cloudstack.api.command.user.firewall.CreateFirewallRuleCmd\', userid : u\'b0ee86a2-d6e9-11e3-ba11-1258f5fe9d0b\', jobstatus : 1, jobid : u\'274e68f7-7256-42ed-bdc1-f048bd474e87\', jobresultcode : 0, jobresulttype : u\'object\', jobresult : {networkid : u\'24c2f881-a06e-4bdd-ae5c-0fe02f296070\', startport : u\'2222\', endport : u\'2222\', fordisplay : True, cidrlist : u\'0.0.0.0/0\', tags : [], ipaddressid : u\'48bdb986-45d6-400c-9d26-6ebeff4316d1\', state : u\'Active\', protocol : u\'tcp\', ipaddress : u\'10.220.164.52\', id : u\'4a08c565-cdb8-401a-9ba1-775780cf3b51\'}, accountid : u\'b0ee7914-d6e9-11e3-ba11-1258f5fe9d0b\'}\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: ===Jobid:274e68f7-7256-42ed-bdc1-f048bd474e87 ; StartTime:Thu May 8 20:33:37 2014 ; EndTime:Thu May 8 20:33:42 2014 ; TotalTime:-5===\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: Response : {jobprocstatus : 0, created : u\'2014-05-08T20:34:02+0000\', cmd : u\'org.apache.cloudstack.api.command.user.firewall.CreateFirewallRuleCmd\', userid : u\'b0ee86a2-d6e9-11e3-ba11-1258f5fe9d0b\', jobstatus : 1, jobid : u\'274e68f7-7256-42ed-bdc1-f048bd474e87\', jobresultcode : 0, jobresulttype : u\'object\', jobresult : {networkid : u\'24c2f881-a06e-4bdd-ae5c-0fe02f296070\', startport : u\'2222\', endport : u\'2222\', fordisplay : True, cidrlist : u\'0.0.0.0/0\', tags : [], ipaddressid : u\'48bdb986-45d6-400c-9d26-6ebeff4316d1\', state : u\'Active\', protocol : u\'tcp\', ipaddress : u\'10.220.164.52\', id : u\'4a08c565-cdb8-401a-9ba1-775780cf3b51\'}, accountid : u\'b0ee7914-d6e9-11e3-ba11-1258f5fe9d0b\'}\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: Payload: {\'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'virtualmachineid\': u\'4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', \'ipaddressid\': u\'48bdb986-45d6-400c-9d26-6ebeff4316d1\', \'signature\': \'dSLIBRvEpZ9gHjchdnfNva5sXZI=\', \'command\': \'createPortForwardingRule\', \'privateport\': 22, \'protocol\': \'TCP\', \'publicport\': 2222, \'response\': \'json\'}\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: ========Sending GET Cmd : createPortForwardingRule=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&virtualmachineid=4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6&ipaddressid=48bdb986-45d6-400c-9d26-6ebeff4316d1&signature=dSLIBRvEpZ9gHjchdnfNva5sXZI%3D&command=createPortForwardingRule&privateport=22&protocol=TCP&publicport=2222&response=json HTTP/1.1" 200 133\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: === Jobid: 43bb248a-7751-4eb0-9456-d007b22e56bc Started ===\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: Payload: {\'signature\': \'ELyUq0KT3FA6q3b/92LqrS6/JAU=\', \'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'command\': \'queryAsyncJobResult\', \'response\': \'json\', \'jobid\': u\'43bb248a-7751-4eb0-9456-d007b22e56bc\'}\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: ========Sending GET Cmd : queryAsyncJobResult=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?signature=ELyUq0KT3FA6q3b%2F92LqrS6%2FJAU%3D&apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&command=queryAsyncJobResult&response=json&jobid=43bb248a-7751-4eb0-9456-d007b22e56bc HTTP/1.1" 200 442\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: Response : {jobprocstatus : 0, created : u\'2014-05-08T20:34:07+0000\', cmd : u\'org.apache.cloudstack.api.command.user.firewall.CreatePortForwardingRuleCmd\', userid : u\'b0ee86a2-d6e9-11e3-ba11-1258f5fe9d0b\', jobstatus : 0, jobid : u\'43bb248a-7751-4eb0-9456-d007b22e56bc\', jobresultcode : 0, jobinstanceid : u\'5c24906d-69bb-40bb-bf5a-090ca5acb012\', jobinstancetype : u\'FirewallRule\', accountid : u\'b0ee7914-d6e9-11e3-ba11-1258f5fe9d0b\'}\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: === JobId:43bb248a-7751-4eb0-9456-d007b22e56bc is Still Processing, Will TimeOut in:3595 ====\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: Payload: {\'signature\': \'ELyUq0KT3FA6q3b/92LqrS6/JAU=\', \'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'command\': \'queryAsyncJobResult\', \'response\': \'json\', \'jobid\': u\'43bb248a-7751-4eb0-9456-d007b22e56bc\'}\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: ========Sending GET Cmd : queryAsyncJobResult=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?signature=ELyUq0KT3FA6q3b%2F92LqrS6%2FJAU%3D&apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&command=queryAsyncJobResult&response=json&jobid=43bb248a-7751-4eb0-9456-d007b22e56bc HTTP/1.1" 200 939\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: Response : {jobprocstatus : 0, created : u\'2014-05-08T20:34:07+0000\', cmd : u\'org.apache.cloudstack.api.command.user.firewall.CreatePortForwardingRuleCmd\', userid : u\'b0ee86a2-d6e9-11e3-ba11-1258f5fe9d0b\', jobstatus : 1, jobid : u\'43bb248a-7751-4eb0-9456-d007b22e56bc\', jobresultcode : 0, jobresulttype : u\'object\', jobresult : {networkid : u\'24c2f881-a06e-4bdd-ae5c-0fe02f296070\', virtualmachinename : u\'VM-4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', protocol : u\'tcp\', virtualmachineid : u\'4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', publicport : u\'2222\', cidrlist : u\'\', fordisplay : True, ipaddressid : u\'48bdb986-45d6-400c-9d26-6ebeff4316d1\', virtualmachinedisplayname : u\'Test VM\', vmguestip : u\'192.168.200.3\', state : u\'Active\', publicendport : u\'2222\', privateport : u\'22\', privateendport : u\'22\', ipaddress : u\'10.220.164.52\', id : u\'5c24906d-69bb-40bb-bf5a-090ca5acb012\', tags : []}, accountid : u\'b0ee7914-d6e9-11e3-ba11-1258f5fe9d0b\'}\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: ===Jobid:43bb248a-7751-4eb0-9456-d007b22e56bc ; StartTime:Thu May 8 20:33:42 2014 ; EndTime:Thu May 8 20:33:47 2014 ; TotalTime:-5===\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: Response : {jobprocstatus : 0, created : u\'2014-05-08T20:34:07+0000\', cmd : u\'org.apache.cloudstack.api.command.user.firewall.CreatePortForwardingRuleCmd\', userid : u\'b0ee86a2-d6e9-11e3-ba11-1258f5fe9d0b\', jobstatus : 1, jobid : u\'43bb248a-7751-4eb0-9456-d007b22e56bc\', jobresultcode : 0, jobresulttype : u\'object\', jobresult : {networkid : u\'24c2f881-a06e-4bdd-ae5c-0fe02f296070\', virtualmachinename : u\'VM-4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', protocol : u\'tcp\', virtualmachineid : u\'4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', publicport : u\'2222\', cidrlist : u\'\', fordisplay : True, ipaddressid : u\'48bdb986-45d6-400c-9d26-6ebeff4316d1\', virtualmachinedisplayname : u\'Test VM\', vmguestip : u\'192.168.200.3\', state : u\'Active\', publicendport : u\'2222\', privateport : u\'22\', privateendport : u\'22\', ipaddress : u\'10.220.164.52\', id : u\'5c24906d-69bb-40bb-bf5a-090ca5acb012\', tags : []}, accountid : u\'b0ee7914-d6e9-11e3-ba11-1258f5fe9d0b\'}\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: Payload: {\'apiKey\': u\'_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA\', \'response\': \'json\', \'command\': \'listPortForwardingRules\', \'signature\': \'NzSPBRvKOWOQ7IqpLQZjrxhEGpo=\', \'id\': u\'5c24906d-69bb-40bb-bf5a-090ca5acb012\'}\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: ========Sending GET Cmd : listPortForwardingRules=======\nrequests.packages.urllib3.connectionpool: INFO: Starting new HTTP connection (1): 10.220.76.216\nrequests.packages.urllib3.connectionpool: DEBUG: "GET /client/api?apiKey=_t8I_QRk5MYnervjP2uhqvxHU-VwLg3ejEqlmXBkwuhASoa2EJQvduQL9W3z84eVxAneIPvTdC8OBmwqc4GcYA&response=json&command=listPortForwardingRules&signature=NzSPBRvKOWOQ7IqpLQZjrxhEGpo%3D&id=5c24906d-69bb-40bb-bf5a-090ca5acb012 HTTP/1.1" 200 607\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: Response : [{networkid : u\'24c2f881-a06e-4bdd-ae5c-0fe02f296070\', virtualmachinename : u\'VM-4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', protocol : u\'tcp\', virtualmachineid : u\'4ba4a117-ff61-4ce7-809d-ba4e9a6c08b6\', publicport : u\'2222\', cidrlist : u\'\', fordisplay : True, ipaddressid : u\'48bdb986-45d6-400c-9d26-6ebeff4316d1\', virtualmachinedisplayname : u\'Test VM\', vmguestip : u\'192.168.200.3\', state : u\'Active\', publicendport : u\'2222\', privateport : u\'22\', privateendport : u\'22\', ipaddress : u\'10.220.164.52\', id : u\'5c24906d-69bb-40bb-bf5a-090ca5acb012\', tags : []}]\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): DEBUG: SSHing into VM with IP address 192.168.200.3 with NAT IP 10.220.164.52\nsshClient: DEBUG: ====Trying SSH Connection: Host:10.220.164.52 User:root Port:22 RetryCnt:20===\nsshClient: ERROR: SshClient: Exception under createConnection: [\'Traceback (most recent call last):\\n\', \' File "/local/jenkins/workspace/xenrt-bvt-adv-xs/work.27/env/local/lib/python2.7/site-packages/marvin/sshClient.py", line 123, in createConnection\\n timeout=self.timeout)\\n\', \' File "/usr/local/lib/python2.7/dist-packages/paramiko/client.py", line 236, in connect\\n retry_on_signal(lambda: sock.connect(addr))\\n\', \' File "/usr/local/lib/python2.7/dist-packages/paramiko/util.py", line 279, in retry_on_signal\\n return function()\\n\', \' File "/usr/local/lib/python2.7/dist-packages/paramiko/client.py", line 236, in <lambda>\\n retry_on_signal(lambda: sock.connect(addr))\\n\', \' File "/usr/lib/python2.7/socket.py", line 224, in meth\\n return getattr(self._sock,name)(*args)\\n\', \'timeout: timed out\\n\']\nTraceback (most recent call last):\n File "/local/jenkins/workspace/xenrt-bvt-adv-xs/work.27/env/local/lib/python2.7/site-packages/marvin/sshClient.py", line 123, in createConnection\n timeout=self.timeout)\n File "/usr/local/lib/python2.7/dist-packages/paramiko/client.py", line 236, in connect\n retry_on_signal(lambda: sock.connect(addr))\n File "/usr/local/lib/python2.7/dist-packages/paramiko/util.py", line 279, in retry_on_signal\n return function()\n File "/usr/local/lib/python2.7/dist-packages/paramiko/client.py", line 236, in <lambda>\n retry_on_signal(lambda: sock.connect(addr))\n File "/usr/lib/python2.7/socket.py", line 224, in meth\n return getattr(self._sock,name)(*args)\ntimeout: timed out\ntest_01_port_fwd_on_src_nat (integration.smoke.test_network.TestPortForwarding): CRITICAL: FAILED: test_01_port_fwd_on_src_nat: [\'Traceback (most recent call last):\\n\', \' File "/usr/lib/python2.7/unittest/case.py", line 332, in run\\n testMethod()\\n\', \' File "/home/jenkins/workspace/xenrt-bvt-adv-xs/cloudstack.git/test/integration/smoke/test_network.py", line 387, in test_01_port_fwd_on_src_nat\\n (self.virtual_machine.ipaddress, e)\\n\', \' File "/usr/lib/python2.7/unittest/case.py", line 413, in fail\\n raise self.failureException(msg)\\n\', \'AssertionError: SSH Access failed for 192.168.200.3: SSH connection has Failed. Waited 600s. Error is SSH Connection Failed\\n\']\n--------------------- >> end captured logging << ---------------------'
> Standard Output
> === TestName: test_01_port_fwd_on_src_nat | Status : FAILED ===
> Standard Error
> ====Trying SSH Connection: Host:10.220.164.52 User:root Port:22 RetryCnt:20===
> SshClient: Exception under createConnection: ['Traceback (most recent call last):\n', ' File "/local/jenkins/workspace/xenrt-bvt-adv-xs/work.27/env/local/lib/python2.7/site-packages/marvin/sshClient.py", line 123, in createConnection\n timeout=self.timeout)\n', ' File "/usr/local/lib/python2.7/dist-packages/paramiko/client.py", line 236, in connect\n retry_on_signal(lambda: sock.connect(addr))\n', ' File "/usr/local/lib/python2.7/dist-packages/paramiko/util.py", line 279, in retry_on_signal\n return function()\n', ' File "/usr/local/lib/python2.7/dist-packages/paramiko/client.py", line 236, in <lambda>\n retry_on_signal(lambda: sock.connect(addr))\n', ' File "/usr/lib/python2.7/socket.py", line 224, in meth\n return getattr(self._sock,name)(*args)\n', 'timeout: timed out\n']
> Traceback (most recent call last):
> File "/local/jenkins/workspace/xenrt-bvt-adv-xs/work.27/env/local/lib/python2.7/site-packages/marvin/sshClient.py", line 123, in createConnection
> timeout=self.timeout)
> File "/usr/local/lib/python2.7/dist-packages/paramiko/client.py", line 236, in connect
> retry_on_signal(lambda: sock.connect(addr))
> File "/usr/local/lib/python2.7/dist-packages/paramiko/util.py", line 279, in retry_on_signal
> return function()
> File "/usr/local/lib/python2.7/dist-packages/paramiko/client.py", line 236, in <lambda>
> retry_on_signal(lambda: sock.connect(addr))
> File "/usr/lib/python2.7/socket.py", line 224, in meth
> return getattr(self._sock,name)(*args)
> timeout: timed out
--
This message was sent by Atlassian JIRA
(v6.3.4#6332)