2026-01-22 02:13:38,953 - INFO - Domain Default found not creating 2026-01-22 02:13:39,111 - INFO - Project ctest-TestPorts-38063285 not found, creating it 2026-01-22 02:13:39,618 - INFO - Created Project:ctest-TestPorts-38063285, ID : 94269091-ca73-4ffc-bae8-222768f5893b 2026-01-22 02:13:41,145 - INFO - ================================================================================ 2026-01-22 02:13:41,145 - INFO - STARTING TEST : test_ports_bindings 2026-01-22 02:13:41,145 - 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 2026-01-22 02:13:42,426 - DEBUG - Nothing to compare xmpp stats {'10.0.0.23': {'10.20.0.19': '0', '10.20.0.5': '0'}, '10.0.0.141': {'10.20.0.19': '0', '10.20.0.5': '0'}} with 2026-01-22 02:13:42,426 - INFO - Initial checks done. Running the testcase now 2026-01-22 02:13:42,426 - INFO - 2026-01-22 02:13:43,164 - DEBUG - Response for create_network : {'network': {'id': '1a255b3d-fd19-4465-8edc-4c5293c4dd3e', 'name': 'ctest-vn-79701396', 'tenant_id': '94269091ca734ffcbae8222768f5893b', 'project_id': '94269091ca734ffcbae8222768f5893b', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-38063285', 'ctest-vn-79701396'], 'port_security_enabled': True, 'description': ''}} 2026-01-22 02:13:43,466 - DEBUG - Response for create_subnet : {'subnet': {'id': '345dfcd9-e443-4e14-affd-d9ed0a82b6ee', 'name': '', 'tenant_id': '94269091ca734ffcbae8222768f5893b', 'network_id': '1a255b3d-fd19-4465-8edc-4c5293c4dd3e', 'ip_version': 4, 'cidr': '147.243.8.64/26', 'allocation_pools': [{'start': '147.243.8.66', 'end': '147.243.8.126'}], 'gateway_ip': '147.243.8.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '147.243.8.66', 'tags': [], 'project_id': '94269091ca734ffcbae8222768f5893b'}} 2026-01-22 02:13:43,487 - INFO - Created VN ctest-vn-79701396 2026-01-22 02:13:43,500 - DEBUG - VN ctest-vn-79701396 UUID is 1a255b3d-fd19-4465-8edc-4c5293c4dd3e 2026-01-22 02:13:43,573 - DEBUG - Read virtual machine interface {'fq_name': ['default-domain', 'ctest-TestPorts-38063285', 'ctest-vmi-27678021']} 2026-01-22 02:13:43,937 - DEBUG - Response for create_port : {'port': {'name': 'ctest-vmi-27678021', 'id': '9e2ab98d-8fa1-4a1e-a4f8-70b0b368f309', 'tenant_id': '94269091ca734ffcbae8222768f5893b', 'network_id': '1a255b3d-fd19-4465-8edc-4c5293c4dd3e', 'mac_address': '02:9e:2a:b9:8d:8f', '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': '147.243.8.67', 'subnet_id': '345dfcd9-e443-4e14-affd-d9ed0a82b6ee'}], 'security_groups': ['893fc0b9-fc45-44ac-9bbe-d071ce3a018b'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '94269091ca734ffcbae8222768f5893b'}} 2026-01-22 02:13:43,937 - DEBUG - Created port 9e2ab98d-8fa1-4a1e-a4f8-70b0b368f309 2026-01-22 02:13:44,010 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/9e2ab98d-8fa1-4a1e-a4f8-70b0b368f309 2026-01-22 02:13:44,316 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/9e2ab98d-8fa1-4a1e-a4f8-70b0b368f309 2026-01-22 02:13:44,361 - INFO - VMI 9e2ab98d-8fa1-4a1e-a4f8-70b0b368f309 verification in API Server passed 2026-01-22 02:13:44,525 - DEBUG - Response for delete_port : () 2026-01-22 02:13:44,525 - INFO - Deleted port 9e2ab98d-8fa1-4a1e-a4f8-70b0b368f309 2026-01-22 02:13:44,526 - INFO - Deleting VN ctest-vn-79701396 2026-01-22 02:13:44,708 - DEBUG - Response for deleting network () 2026-01-22 02:13:46,000 - DEBUG - No XMPP flaps were noticed during the test
2026-01-22 02:13:46,000 - INFO - END TEST : test_ports_bindings : PASSED[0:00:05]
2026-01-22 02:13:46,000 - INFO - -------------------------------------------------------------------------------- 2026-01-22 02:13:46,005 - INFO - ================================================================================ 2026-01-22 02:13:46,005 - INFO - STARTING TEST : test_ports_specific_subnet_ip 2026-01-22 02:13:46,005 - 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 2026-01-22 02:13:47,288 - DEBUG - Nothing to compare xmpp stats {'10.0.0.23': {'10.20.0.19': '0', '10.20.0.5': '0'}, '10.0.0.141': {'10.20.0.19': '0', '10.20.0.5': '0'}} with 2026-01-22 02:13:47,288 - INFO - Initial checks done. Running the testcase now 2026-01-22 02:13:47,289 - INFO - 2026-01-22 02:13:47,575 - DEBUG - Response for create_network : {'network': {'id': '5be1600e-eef3-4655-9693-f44abd78f8b7', 'name': 'ctest-vn1-02796054', 'tenant_id': '94269091ca734ffcbae8222768f5893b', 'project_id': '94269091ca734ffcbae8222768f5893b', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-38063285', 'ctest-vn1-02796054'], 'port_security_enabled': True, 'description': ''}} 2026-01-22 02:13:47,835 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd38afb2d-3198-4c3b-a312-6833fc1bd019', 'name': '', 'tenant_id': '94269091ca734ffcbae8222768f5893b', 'network_id': '5be1600e-eef3-4655-9693-f44abd78f8b7', 'ip_version': 4, 'cidr': '201.68.194.64/26', 'allocation_pools': [{'start': '201.68.194.66', 'end': '201.68.194.126'}], 'gateway_ip': '201.68.194.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '201.68.194.66', 'tags': [], 'project_id': '94269091ca734ffcbae8222768f5893b'}} 2026-01-22 02:13:48,086 - DEBUG - Response for create_subnet : {'subnet': {'id': 'acce429b-1ed7-445d-ab09-ec49338719aa', 'name': '', 'tenant_id': '94269091ca734ffcbae8222768f5893b', 'network_id': '5be1600e-eef3-4655-9693-f44abd78f8b7', 'ip_version': 4, 'cidr': '1.62.160.192/26', 'allocation_pools': [{'start': '1.62.160.194', 'end': '1.62.160.254'}], 'gateway_ip': '1.62.160.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '1.62.160.194', 'tags': [], 'project_id': '94269091ca734ffcbae8222768f5893b'}} 2026-01-22 02:13:48,112 - INFO - Created VN ctest-vn1-02796054 2026-01-22 02:13:48,127 - DEBUG - VN ctest-vn1-02796054 UUID is 5be1600e-eef3-4655-9693-f44abd78f8b7 2026-01-22 02:13:48,501 - DEBUG - Response for create_port : {'port': {'name': 'efd996d0-0130-4dff-b28a-432390055b2d', 'id': 'efd996d0-0130-4dff-b28a-432390055b2d', 'tenant_id': '94269091ca734ffcbae8222768f5893b', 'network_id': '5be1600e-eef3-4655-9693-f44abd78f8b7', 'mac_address': '02:ef:d9:96:d0:01', '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': '201.68.194.69', 'subnet_id': 'd38afb2d-3198-4c3b-a312-6833fc1bd019'}], 'security_groups': ['893fc0b9-fc45-44ac-9bbe-d071ce3a018b'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '94269091ca734ffcbae8222768f5893b'}} 2026-01-22 02:13:48,797 - DEBUG - Response for create_port : {'port': {'name': 'bebf79e0-dbe0-460d-99df-5cc97a43dc89', 'id': 'bebf79e0-dbe0-460d-99df-5cc97a43dc89', 'tenant_id': '94269091ca734ffcbae8222768f5893b', 'network_id': '5be1600e-eef3-4655-9693-f44abd78f8b7', 'mac_address': '02:be:bf:79:e0:db', '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': '1.62.160.197', 'subnet_id': 'acce429b-1ed7-445d-ab09-ec49338719aa'}], 'security_groups': ['893fc0b9-fc45-44ac-9bbe-d071ce3a018b'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '94269091ca734ffcbae8222768f5893b'}} 2026-01-22 02:13:48,858 - DEBUG - Services list from nova: [, , , ] 2026-01-22 02:13:49,357 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5055-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5055-1) 2026-01-22 02:13:49,851 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5055-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5055-2) 2026-01-22 02:13:49,852 - INFO - Waiting for VM ctest-vn1-vm1-55192721 to be up.. 2026-01-22 02:13:49,904 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-01-22 02:13:54,992 - DEBUG - VM is in ACTIVE state now 2026-01-22 02:13:54,992 - INFO - VM name : ctest-vn1-vm1-55192721 2026-01-22 02:13:55,079 - DEBUG - VM ctest-vn1-vm1-55192721 ID is 53ff8e29-7a47-48d4-956c-079135b1f22f 2026-01-22 02:13:55,113 - DEBUG - VM ctest-vn1-vm1-55192721 launched on Node an-jenkins-deploy-platform-ansible-os-5055-1 2026-01-22 02:13:55,201 - DEBUG - Requesting: http://10.0.0.131:8082/virtual-machine/53ff8e29-7a47-48d4-956c-079135b1f22f 2026-01-22 02:13:55,509 - DEBUG - Requesting: http://10.0.0.131:8082/virtual-machine/53ff8e29-7a47-48d4-956c-079135b1f22f 2026-01-22 02:13:55,544 - DEBUG - Requesting: http://10.0.0.131:8082/virtual-machine-interface/efd996d0-0130-4dff-b28a-432390055b2d 2026-01-22 02:13:58,734 - 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 1026ms') 2026-01-22 02:13:58,734 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-55192721 failed! 2026-01-22 02:13:58,748 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-38063285:ctest-vn1-02796054 is 201.68.194.65 and allocation pool is NOT set 2026-01-22 02:13:58,748 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-38063285:ctest-vn1-02796054 is 1.62.160.193 and allocation pool is NOT set 2026-01-22 02:14:02,831 - 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=8.82 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1022ms\r\nrtt min/avg/max/mdev = 8.823/8.823/8.823/0.000 ms') 2026-01-22 02:14:02,831 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-55192721 passed 2026-01-22 02:14:02,904 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-22 02:14:02,904 - DEBUG - Waiting to SSH to VM ctest-vn1-vm1-55192721, IP 201.68.194.69, Port 22 2026-01-22 02:14:02,972 - DEBUG - Error on ssh to cirros@169.254.0.3:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-01-22 02:14:03,070 - DEBUG - VM ctest-vn1-vm1-55192721 is NOT ready for SSH connections, VM status: ACTIVE 2026-01-22 02:14:08,071 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-22 02:14:08,071 - DEBUG - Waiting to SSH to VM ctest-vn1-vm1-55192721, IP 201.68.194.69, Port 22 2026-01-22 02:14:08,241 - DEBUG - VM ctest-vn1-vm1-55192721 is ready for SSH connections 2026-01-22 02:14:08,241 - INFO - Waiting for VM ctest-vn1-vm2-52789113 to be up.. 2026-01-22 02:14:08,326 - DEBUG - VM is in ACTIVE state now 2026-01-22 02:14:08,326 - INFO - VM name : ctest-vn1-vm2-52789113 2026-01-22 02:14:08,409 - DEBUG - VM ctest-vn1-vm2-52789113 ID is f4a9f707-78b8-410a-9cc5-b3020b3e1aea 2026-01-22 02:14:08,409 - DEBUG - VM ctest-vn1-vm2-52789113 launched on Node an-jenkins-deploy-platform-ansible-os-5055-2 2026-01-22 02:14:08,506 - DEBUG - Requesting: http://10.0.0.131:8082/virtual-machine/f4a9f707-78b8-410a-9cc5-b3020b3e1aea 2026-01-22 02:14:08,517 - DEBUG - Requesting: http://10.0.0.131:8082/virtual-machine-interface/bebf79e0-dbe0-460d-99df-5cc97a43dc89 2026-01-22 02:14:09,679 - 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=1 ttl=63 time=4.62 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.514 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.514/2.568/4.622/2.054 ms') 2026-01-22 02:14:09,679 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm2-52789113 passed 2026-01-22 02:14:09,751 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-22 02:14:09,751 - DEBUG - Waiting to SSH to VM ctest-vn1-vm2-52789113, IP 1.62.160.197, Port 22 2026-01-22 02:14:09,908 - DEBUG - VM ctest-vn1-vm2-52789113 is ready for SSH connections 2026-01-22 02:14:09,908 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-22 02:14:09,908 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-22 02:14:09,908 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-01-22 02:14:09,908 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 201.68.194.69, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.141, gateway password: c0ntrail123 2026-01-22 02:14:09,908 - DEBUG - ping -s 56 -c 3 -W 1 201.68.194.69 2026-01-22 02:14:12,593 - DEBUG - PING 201.68.194.69 (201.68.194.69): 56 data bytes 64 bytes from 201.68.194.69: seq=0 ttl=63 time=4.855 ms 64 bytes from 201.68.194.69: seq=1 ttl=63 time=1.188 ms 64 bytes from 201.68.194.69: seq=2 ttl=63 time=1.603 ms --- 201.68.194.69 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.188/2.548/4.855 ms 2026-01-22 02:14:12,593 - INFO - Ping to IP 201.68.194.69 from VM ctest-vn1-vm2-52789113 passed 2026-01-22 02:14:12,594 - INFO - Detaching port bebf79e0-dbe0-460d-99df-5cc97a43dc89 from VM ctest-vn1-vm2-52789113 2026-01-22 02:14:12,651 - INFO - Deleting VM ctest-vn1-vm2-52789113 2026-01-22 02:14:12,720 - INFO - Detaching port efd996d0-0130-4dff-b28a-432390055b2d from VM ctest-vn1-vm1-55192721 2026-01-22 02:14:12,754 - INFO - Deleting VM ctest-vn1-vm1-55192721 2026-01-22 02:14:13,117 - DEBUG - Response for delete_port : () 2026-01-22 02:14:13,366 - DEBUG - Response for delete_port : () 2026-01-22 02:14:13,366 - INFO - Deleting VN ctest-vn1-02796054 2026-01-22 02:14:13,564 - DEBUG - Response for deleting network () 2026-01-22 02:14:14,851 - DEBUG - No XMPP flaps were noticed during the test
2026-01-22 02:14:14,851 - INFO - END TEST : test_ports_specific_subnet_ip : PASSED[0:00:28]
2026-01-22 02:14:14,851 - INFO - -------------------------------------------------------------------------------- 2026-01-22 02:14:15,576 - INFO - Deleted project: ctest-TestPorts-38063285, ID : 94269091-ca73-4ffc-bae8-222768f5893b