2025-12-03 19:59:39,807 - INFO - Domain Default found not creating 2025-12-03 19:59:40,184 - INFO - Project ctest-TestPorts-23306662 not found, creating it 2025-12-03 19:59:40,847 - INFO - Created Project:ctest-TestPorts-23306662, ID : c5a5da2e-7b4d-45d2-91ee-0f7e8b4155af 2025-12-03 19:59:42,879 - INFO - ================================================================================ 2025-12-03 19:59:42,879 - INFO - STARTING TEST : test_ports_bindings 2025-12-03 19:59:42,879 - INFO - TEST DESCRIPTION : Verify that we are able to create a port with custom port bindings Steps: 1) Create Port with Port bindings profile set to {'foo': 'bar'} 2) Retrieve and verify the same is set 2025-12-03 19:59:43,180 - DEBUG - Nothing to compare xmpp stats {'10.0.0.38': {'10.20.0.254': '0'}} with 2025-12-03 19:59:43,180 - INFO - Initial checks done. Running the testcase now 2025-12-03 19:59:43,180 - INFO - 2025-12-03 19:59:43,873 - DEBUG - Response for create_network : {'network': {'id': '651ccece-cb3f-4f1d-aecf-0a550a4fb435', 'name': 'ctest-vn-70547066', 'tenant_id': 'c5a5da2e7b4d45d291ee0f7e8b4155af', 'project_id': 'c5a5da2e7b4d45d291ee0f7e8b4155af', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-23306662', 'ctest-vn-70547066'], 'port_security_enabled': True, 'description': ''}} 2025-12-03 19:59:44,154 - DEBUG - Response for create_subnet : {'subnet': {'id': 'c13c90e6-a61d-4190-b823-d5e12be44e5c', 'name': '', 'tenant_id': 'c5a5da2e7b4d45d291ee0f7e8b4155af', 'network_id': '651ccece-cb3f-4f1d-aecf-0a550a4fb435', 'ip_version': 4, 'cidr': '105.114.192.192/26', 'allocation_pools': [{'start': '105.114.192.194', 'end': '105.114.192.254'}], 'gateway_ip': '105.114.192.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '105.114.192.194', 'tags': [], 'project_id': 'c5a5da2e7b4d45d291ee0f7e8b4155af'}} 2025-12-03 19:59:44,186 - INFO - Created VN ctest-vn-70547066 2025-12-03 19:59:44,248 - DEBUG - VN ctest-vn-70547066 UUID is 651ccece-cb3f-4f1d-aecf-0a550a4fb435 2025-12-03 19:59:44,418 - DEBUG - Read virtual machine interface {'fq_name': ['default-domain', 'ctest-TestPorts-23306662', 'ctest-vmi-54540859']} 2025-12-03 19:59:44,804 - DEBUG - Response for create_port : {'port': {'name': 'ctest-vmi-54540859', 'id': '7aea90d9-b80c-4c81-ba0c-87db207e0578', 'tenant_id': 'c5a5da2e7b4d45d291ee0f7e8b4155af', 'network_id': '651ccece-cb3f-4f1d-aecf-0a550a4fb435', 'mac_address': '02:7a:ea:90:d9:b8', 'binding:profile': {'foo': 'bar'}, 'binding:vnic_type': 'normal', 'binding:vif_details': {'port_filter': True}, 'binding:vif_type': 'unbound', 'binding:host_id': None, 'allowed_address_pairs': [], 'fixed_ips': [{'ip_address': '105.114.192.195', 'subnet_id': 'c13c90e6-a61d-4190-b823-d5e12be44e5c'}], 'security_groups': ['7651784e-efe8-40b8-acaf-044932b759cb'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': 'c5a5da2e7b4d45d291ee0f7e8b4155af'}} 2025-12-03 19:59:44,804 - DEBUG - Created port 7aea90d9-b80c-4c81-ba0c-87db207e0578 2025-12-03 19:59:44,928 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/7aea90d9-b80c-4c81-ba0c-87db207e0578 2025-12-03 19:59:45,249 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/7aea90d9-b80c-4c81-ba0c-87db207e0578 2025-12-03 19:59:45,298 - INFO - VMI 7aea90d9-b80c-4c81-ba0c-87db207e0578 verification in API Server passed 2025-12-03 19:59:45,429 - DEBUG - Response for delete_port : () 2025-12-03 19:59:45,429 - INFO - Deleted port 7aea90d9-b80c-4c81-ba0c-87db207e0578 2025-12-03 19:59:45,430 - INFO - Deleting VN ctest-vn-70547066 2025-12-03 19:59:45,541 - DEBUG - Response for deleting network () 2025-12-03 19:59:45,847 - DEBUG - No XMPP flaps were noticed during the test
2025-12-03 19:59:45,847 - INFO - END TEST : test_ports_bindings : PASSED[0:00:03]
2025-12-03 19:59:45,848 - INFO - -------------------------------------------------------------------------------- 2025-12-03 19:59:45,856 - INFO - ================================================================================ 2025-12-03 19:59:45,856 - INFO - STARTING TEST : test_ports_specific_subnet_ip 2025-12-03 19:59:45,857 - INFO - TEST DESCRIPTION : Create ports with specific Subnet and IP Create two ports in a VN with 2 subnets and specific IPs Attach to two VMs Ping between them should pass 2025-12-03 19:59:46,166 - DEBUG - Nothing to compare xmpp stats {'10.0.0.38': {'10.20.0.254': '0'}} with 2025-12-03 19:59:46,166 - INFO - Initial checks done. Running the testcase now 2025-12-03 19:59:46,166 - INFO - 2025-12-03 19:59:46,442 - DEBUG - Response for create_network : {'network': {'id': 'c953b17d-dc50-4928-a663-f0d27edde02d', 'name': 'ctest-vn1-23687002', 'tenant_id': 'c5a5da2e7b4d45d291ee0f7e8b4155af', 'project_id': 'c5a5da2e7b4d45d291ee0f7e8b4155af', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-23306662', 'ctest-vn1-23687002'], 'port_security_enabled': True, 'description': ''}} 2025-12-03 19:59:46,674 - DEBUG - Response for create_subnet : {'subnet': {'id': '7fb0c82f-6fce-4b18-b833-4bc556a466f6', 'name': '', 'tenant_id': 'c5a5da2e7b4d45d291ee0f7e8b4155af', 'network_id': 'c953b17d-dc50-4928-a663-f0d27edde02d', 'ip_version': 4, 'cidr': '126.10.224.0/26', 'allocation_pools': [{'start': '126.10.224.2', 'end': '126.10.224.62'}], 'gateway_ip': '126.10.224.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '126.10.224.2', 'tags': [], 'project_id': 'c5a5da2e7b4d45d291ee0f7e8b4155af'}} 2025-12-03 19:59:46,858 - DEBUG - Response for create_subnet : {'subnet': {'id': '7ddb872b-b5fc-4879-97fb-83992d4cb865', 'name': '', 'tenant_id': 'c5a5da2e7b4d45d291ee0f7e8b4155af', 'network_id': 'c953b17d-dc50-4928-a663-f0d27edde02d', 'ip_version': 4, 'cidr': '11.78.107.64/26', 'allocation_pools': [{'start': '11.78.107.66', 'end': '11.78.107.126'}], 'gateway_ip': '11.78.107.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '11.78.107.66', 'tags': [], 'project_id': 'c5a5da2e7b4d45d291ee0f7e8b4155af'}} 2025-12-03 19:59:46,880 - INFO - Created VN ctest-vn1-23687002 2025-12-03 19:59:46,936 - DEBUG - VN ctest-vn1-23687002 UUID is c953b17d-dc50-4928-a663-f0d27edde02d 2025-12-03 19:59:47,412 - DEBUG - Response for create_port : {'port': {'name': '5e63ab34-9fbf-43f8-bcd8-22ec357468e6', 'id': '5e63ab34-9fbf-43f8-bcd8-22ec357468e6', 'tenant_id': 'c5a5da2e7b4d45d291ee0f7e8b4155af', 'network_id': 'c953b17d-dc50-4928-a663-f0d27edde02d', 'mac_address': '02:5e:63:ab:34:9f', 'binding:vnic_type': 'normal', 'binding:vif_details': {'port_filter': True}, 'binding:vif_type': 'unbound', 'binding:host_id': None, 'allowed_address_pairs': [], 'fixed_ips': [{'ip_address': '126.10.224.5', 'subnet_id': '7fb0c82f-6fce-4b18-b833-4bc556a466f6'}], 'security_groups': ['7651784e-efe8-40b8-acaf-044932b759cb'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': 'c5a5da2e7b4d45d291ee0f7e8b4155af'}} 2025-12-03 19:59:47,621 - DEBUG - Response for create_port : {'port': {'name': 'deac85e5-ce31-4ce2-9efa-bd74b4415be8', 'id': 'deac85e5-ce31-4ce2-9efa-bd74b4415be8', 'tenant_id': 'c5a5da2e7b4d45d291ee0f7e8b4155af', 'network_id': 'c953b17d-dc50-4928-a663-f0d27edde02d', 'mac_address': '02:de:ac:85:e5:ce', 'binding:vnic_type': 'normal', 'binding:vif_details': {'port_filter': True}, 'binding:vif_type': 'unbound', 'binding:host_id': None, 'allowed_address_pairs': [], 'fixed_ips': [{'ip_address': '11.78.107.69', 'subnet_id': '7ddb872b-b5fc-4879-97fb-83992d4cb865'}], 'security_groups': ['7651784e-efe8-40b8-acaf-044932b759cb'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': 'c5a5da2e7b4d45d291ee0f7e8b4155af'}} 2025-12-03 19:59:47,692 - DEBUG - Services list from nova: [, , ] 2025-12-03 19:59:48,469 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4835-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4835-1) 2025-12-03 19:59:49,443 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4835-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4835-1) 2025-12-03 19:59:49,443 - INFO - Waiting for VM ctest-vn1-vm1-33138595 to be up.. 2025-12-03 19:59:49,502 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-12-03 19:59:54,662 - DEBUG - VM is in ACTIVE state now 2025-12-03 19:59:54,662 - INFO - VM name : ctest-vn1-vm1-33138595 2025-12-03 19:59:54,797 - DEBUG - VM ctest-vn1-vm1-33138595 ID is e86fb99f-f739-4866-bf4b-4c64861c9cfd 2025-12-03 19:59:54,825 - DEBUG - VM ctest-vn1-vm1-33138595 launched on Node cn-jenkins-deploy-platform-ansible-os-4835-1 2025-12-03 19:59:54,946 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/e86fb99f-f739-4866-bf4b-4c64861c9cfd 2025-12-03 19:59:54,955 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/5e63ab34-9fbf-43f8-bcd8-22ec357468e6 2025-12-03 19:59:58,272 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1031ms') 2025-12-03 19:59:58,272 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-33138595 failed! 2025-12-03 19:59:58,328 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-23306662:ctest-vn1-23687002 is 126.10.224.1 and allocation pool is NOT set 2025-12-03 19:59:58,328 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-23306662:ctest-vn1-23687002 is 11.78.107.65 and allocation pool is NOT set 2025-12-03 20:00:02,427 - DEBUG - (True, 'PING 169.254.0.3 (169.254.0.3) 56(84) bytes of data.\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=9.92 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1023ms\r\nrtt min/avg/max/mdev = 9.922/9.922/9.922/0.000 ms') 2025-12-03 20:00:02,427 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-33138595 passed 2025-12-03 20:00:02,596 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-12-03 20:00:02,596 - DEBUG - Waiting to SSH to VM ctest-vn1-vm1-33138595, IP 126.10.224.5, Port 22 2025-12-03 20:00:02,751 - DEBUG - VM ctest-vn1-vm1-33138595 is ready for SSH connections 2025-12-03 20:00:02,752 - INFO - Waiting for VM ctest-vn1-vm2-63225219 to be up.. 2025-12-03 20:00:02,854 - DEBUG - VM is in ACTIVE state now 2025-12-03 20:00:02,854 - INFO - VM name : ctest-vn1-vm2-63225219 2025-12-03 20:00:02,955 - DEBUG - VM ctest-vn1-vm2-63225219 ID is eae16693-612f-4203-ad0d-6ca932d1277b 2025-12-03 20:00:02,955 - DEBUG - VM ctest-vn1-vm2-63225219 launched on Node cn-jenkins-deploy-platform-ansible-os-4835-1 2025-12-03 20:00:03,050 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/eae16693-612f-4203-ad0d-6ca932d1277b 2025-12-03 20:00:03,066 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/deac85e5-ce31-4ce2-9efa-bd74b4415be8 2025-12-03 20:00:04,349 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n64 bytes from 169.254.0.4: icmp_seq=1 ttl=63 time=6.61 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.618 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.618/3.611/6.605/2.993 ms') 2025-12-03 20:00:04,350 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-vn1-vm2-63225219 passed 2025-12-03 20:00:04,525 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-12-03 20:00:04,527 - DEBUG - Waiting to SSH to VM ctest-vn1-vm2-63225219, IP 11.78.107.69, Port 22 2025-12-03 20:00:04,745 - DEBUG - VM ctest-vn1-vm2-63225219 is ready for SSH connections 2025-12-03 20:00:04,746 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-12-03 20:00:04,746 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-12-03 20:00:04,746 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-12-03 20:00:04,746 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 126.10.224.5, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.38, gateway password: c0ntrail123 2025-12-03 20:00:04,747 - DEBUG - ping -s 56 -c 3 -W 1 126.10.224.5 2025-12-03 20:00:07,720 - DEBUG - PING 126.10.224.5 (126.10.224.5): 56 data bytes 64 bytes from 126.10.224.5: seq=0 ttl=63 time=4.955 ms 64 bytes from 126.10.224.5: seq=1 ttl=63 time=2.473 ms 64 bytes from 126.10.224.5: seq=2 ttl=63 time=1.357 ms --- 126.10.224.5 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.357/2.928/4.955 ms 2025-12-03 20:00:07,720 - INFO - Ping to IP 126.10.224.5 from VM ctest-vn1-vm2-63225219 passed 2025-12-03 20:00:07,721 - INFO - Detaching port deac85e5-ce31-4ce2-9efa-bd74b4415be8 from VM ctest-vn1-vm2-63225219 2025-12-03 20:00:07,812 - INFO - Deleting VM ctest-vn1-vm2-63225219 2025-12-03 20:00:07,891 - INFO - Detaching port 5e63ab34-9fbf-43f8-bcd8-22ec357468e6 from VM ctest-vn1-vm1-33138595 2025-12-03 20:00:07,936 - INFO - Deleting VM ctest-vn1-vm1-33138595 2025-12-03 20:00:08,245 - DEBUG - Response for delete_port : () 2025-12-03 20:00:08,392 - DEBUG - Response for delete_port : () 2025-12-03 20:00:08,392 - INFO - Deleting VN ctest-vn1-23687002 2025-12-03 20:00:08,518 - DEBUG - Response for deleting network () 2025-12-03 20:00:08,803 - DEBUG - No XMPP flaps were noticed during the test
2025-12-03 20:00:08,803 - INFO - END TEST : test_ports_specific_subnet_ip : PASSED[0:00:23]
2025-12-03 20:00:08,804 - INFO - -------------------------------------------------------------------------------- 2025-12-03 20:00:09,680 - INFO - Deleted project: ctest-TestPorts-23306662, ID : c5a5da2e-7b4d-45d2-91ee-0f7e8b4155af