2026-01-20 16:04:49,474 - INFO - Domain Default found not creating
2026-01-20 16:04:49,636 - INFO - Project ctest-TestPorts-13342464 not found, creating it
2026-01-20 16:04:50,132 - INFO - Created Project:ctest-TestPorts-13342464, ID : 069d00b3-c198-49e1-9d37-ae841300e44a
2026-01-20 16:04:51,583 - INFO - ================================================================================
2026-01-20 16:04:51,583 - INFO - STARTING TEST : test_ports_bindings
2026-01-20 16:04:51,583 - 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-20 16:04:51,846 - DEBUG - Nothing to compare xmpp stats {'10.0.0.249': {'10.20.0.14': '0'}} with
2026-01-20 16:04:51,847 - INFO - Initial checks done. Running the testcase now
2026-01-20 16:04:51,847 - INFO -
2026-01-20 16:04:52,376 - DEBUG - Response for create_network : {'network': {'id': '35e3963d-489e-4372-b810-5d525edd5a79', 'name': 'ctest-vn-30055563', 'tenant_id': '069d00b3c19849e19d37ae841300e44a', 'project_id': '069d00b3c19849e19d37ae841300e44a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-13342464', 'ctest-vn-30055563'], 'port_security_enabled': True, 'description': ''}}
2026-01-20 16:04:52,565 - DEBUG - Response for create_subnet : {'subnet': {'id': '695878d2-eba9-4780-b6ec-4f40df292c51', 'name': '', 'tenant_id': '069d00b3c19849e19d37ae841300e44a', 'network_id': '35e3963d-489e-4372-b810-5d525edd5a79', 'ip_version': 4, 'cidr': '194.244.71.128/26', 'allocation_pools': [{'start': '194.244.71.130', 'end': '194.244.71.190'}], 'gateway_ip': '194.244.71.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '194.244.71.130', 'tags': [], 'project_id': '069d00b3c19849e19d37ae841300e44a'}}
2026-01-20 16:04:52,586 - INFO - Created VN ctest-vn-30055563
2026-01-20 16:04:52,642 - DEBUG - VN ctest-vn-30055563 UUID is 35e3963d-489e-4372-b810-5d525edd5a79
2026-01-20 16:04:52,750 - DEBUG - Read virtual machine interface {'fq_name': ['default-domain', 'ctest-TestPorts-13342464', 'ctest-vmi-91440216']}
2026-01-20 16:04:53,025 - DEBUG - Response for create_port : {'port': {'name': 'ctest-vmi-91440216', 'id': '78f07888-6af2-45ee-9761-7c2a61a1d71a', 'tenant_id': '069d00b3c19849e19d37ae841300e44a', 'network_id': '35e3963d-489e-4372-b810-5d525edd5a79', 'mac_address': '02:78:f0:78:88:6a', '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': '194.244.71.131', 'subnet_id': '695878d2-eba9-4780-b6ec-4f40df292c51'}], 'security_groups': ['1eedace4-a4e5-4bc2-8698-03cc50cd9676'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '069d00b3c19849e19d37ae841300e44a'}}
2026-01-20 16:04:53,025 - DEBUG - Created port 78f07888-6af2-45ee-9761-7c2a61a1d71a
2026-01-20 16:04:53,130 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/78f07888-6af2-45ee-9761-7c2a61a1d71a
2026-01-20 16:04:53,422 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/78f07888-6af2-45ee-9761-7c2a61a1d71a
2026-01-20 16:04:53,456 - INFO - VMI 78f07888-6af2-45ee-9761-7c2a61a1d71a verification in API Server passed
2026-01-20 16:04:53,551 - DEBUG - Response for delete_port : ()
2026-01-20 16:04:53,551 - INFO - Deleted port 78f07888-6af2-45ee-9761-7c2a61a1d71a
2026-01-20 16:04:53,551 - INFO - Deleting VN ctest-vn-30055563
2026-01-20 16:04:53,659 - DEBUG - Response for deleting network ()
2026-01-20 16:04:53,930 - DEBUG - No XMPP flaps were noticed during the test
2026-01-20 16:04:53,930 - INFO - END TEST : test_ports_bindings : PASSED[0:00:02]
2026-01-20 16:04:53,931 - INFO - --------------------------------------------------------------------------------
2026-01-20 16:04:53,933 - INFO - ================================================================================
2026-01-20 16:04:53,933 - INFO - STARTING TEST : test_ports_specific_subnet_ip
2026-01-20 16:04:53,933 - 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-20 16:04:54,226 - DEBUG - Nothing to compare xmpp stats {'10.0.0.249': {'10.20.0.14': '0'}} with
2026-01-20 16:04:54,227 - INFO - Initial checks done. Running the testcase now
2026-01-20 16:04:54,227 - INFO -
2026-01-20 16:04:54,421 - DEBUG - Response for create_network : {'network': {'id': '973e1a3f-b7e1-4ce6-aaa7-0e81dbb7686a', 'name': 'ctest-vn1-32584866', 'tenant_id': '069d00b3c19849e19d37ae841300e44a', 'project_id': '069d00b3c19849e19d37ae841300e44a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-13342464', 'ctest-vn1-32584866'], 'port_security_enabled': True, 'description': ''}}
2026-01-20 16:04:54,637 - DEBUG - Response for create_subnet : {'subnet': {'id': '74d1bcab-9f01-40d1-a796-166f5e6b95ad', 'name': '', 'tenant_id': '069d00b3c19849e19d37ae841300e44a', 'network_id': '973e1a3f-b7e1-4ce6-aaa7-0e81dbb7686a', 'ip_version': 4, 'cidr': '170.177.255.64/26', 'allocation_pools': [{'start': '170.177.255.66', 'end': '170.177.255.126'}], 'gateway_ip': '170.177.255.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '170.177.255.66', 'tags': [], 'project_id': '069d00b3c19849e19d37ae841300e44a'}}
2026-01-20 16:04:54,802 - DEBUG - Response for create_subnet : {'subnet': {'id': '35b8ef8f-b07e-4f81-b824-623191535e48', 'name': '', 'tenant_id': '069d00b3c19849e19d37ae841300e44a', 'network_id': '973e1a3f-b7e1-4ce6-aaa7-0e81dbb7686a', 'ip_version': 4, 'cidr': '140.6.113.64/26', 'allocation_pools': [{'start': '140.6.113.66', 'end': '140.6.113.126'}], 'gateway_ip': '140.6.113.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '140.6.113.66', 'tags': [], 'project_id': '069d00b3c19849e19d37ae841300e44a'}}
2026-01-20 16:04:54,821 - INFO - Created VN ctest-vn1-32584866
2026-01-20 16:04:54,874 - DEBUG - VN ctest-vn1-32584866 UUID is 973e1a3f-b7e1-4ce6-aaa7-0e81dbb7686a
2026-01-20 16:04:55,191 - DEBUG - Response for create_port : {'port': {'name': '9aaedcc6-4f93-413c-9b81-618c2e090bb3', 'id': '9aaedcc6-4f93-413c-9b81-618c2e090bb3', 'tenant_id': '069d00b3c19849e19d37ae841300e44a', 'network_id': '973e1a3f-b7e1-4ce6-aaa7-0e81dbb7686a', 'mac_address': '02:9a:ae:dc:c6:4f', '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': '170.177.255.69', 'subnet_id': '74d1bcab-9f01-40d1-a796-166f5e6b95ad'}], 'security_groups': ['1eedace4-a4e5-4bc2-8698-03cc50cd9676'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '069d00b3c19849e19d37ae841300e44a'}}
2026-01-20 16:04:55,400 - DEBUG - Response for create_port : {'port': {'name': '29ea1c8d-2a9d-40c0-902c-ff8c290929ba', 'id': '29ea1c8d-2a9d-40c0-902c-ff8c290929ba', 'tenant_id': '069d00b3c19849e19d37ae841300e44a', 'network_id': '973e1a3f-b7e1-4ce6-aaa7-0e81dbb7686a', 'mac_address': '02:29:ea:1c:8d:2a', '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': '140.6.113.69', 'subnet_id': '35b8ef8f-b07e-4f81-b824-623191535e48'}], 'security_groups': ['1eedace4-a4e5-4bc2-8698-03cc50cd9676'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '069d00b3c19849e19d37ae841300e44a'}}
2026-01-20 16:04:55,464 - DEBUG - Services list from nova: [, , ]
2026-01-20 16:04:55,813 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-5050-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-5050-1)
2026-01-20 16:04:56,226 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-5050-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-5050-1)
2026-01-20 16:04:56,226 - INFO - Waiting for VM ctest-vn1-vm1-55163902 to be up..
2026-01-20 16:04:56,266 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-01-20 16:05:01,352 - DEBUG - VM is in ACTIVE state now
2026-01-20 16:05:01,353 - INFO - VM name : ctest-vn1-vm1-55163902
2026-01-20 16:05:01,437 - DEBUG - VM ctest-vn1-vm1-55163902 ID is 542a3222-5e71-4477-b55f-98e4841b414a
2026-01-20 16:05:01,463 - DEBUG - VM ctest-vn1-vm1-55163902 launched on Node cn-jenkins-deploy-platform-ansible-os-5050-1
2026-01-20 16:05:01,568 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/542a3222-5e71-4477-b55f-98e4841b414a
2026-01-20 16:05:01,578 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/9aaedcc6-4f93-413c-9b81-618c2e090bb3
2026-01-20 16:05:04,845 - 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 1025ms')
2026-01-20 16:05:04,845 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-55163902 failed!
2026-01-20 16:05:04,906 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-13342464:ctest-vn1-32584866 is 170.177.255.65 and allocation pool is NOT set
2026-01-20 16:05:04,906 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-13342464:ctest-vn1-32584866 is 140.6.113.65 and allocation pool is NOT set
2026-01-20 16:05:08,984 - 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.16 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1011ms\r\nrtt min/avg/max/mdev = 8.160/8.160/8.160/0.000 ms')
2026-01-20 16:05:08,984 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-55163902 passed
2026-01-20 16:05:09,134 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-01-20 16:05:09,134 - DEBUG - Waiting to SSH to VM ctest-vn1-vm1-55163902, IP 170.177.255.69, Port 22
2026-01-20 16:05:09,290 - DEBUG - VM ctest-vn1-vm1-55163902 is ready for SSH connections
2026-01-20 16:05:09,290 - INFO - Waiting for VM ctest-vn1-vm2-85229232 to be up..
2026-01-20 16:05:09,372 - DEBUG - VM is in ACTIVE state now
2026-01-20 16:05:09,372 - INFO - VM name : ctest-vn1-vm2-85229232
2026-01-20 16:05:09,455 - DEBUG - VM ctest-vn1-vm2-85229232 ID is 9b37225d-694c-42df-bbb6-3723b1887c40
2026-01-20 16:05:09,455 - DEBUG - VM ctest-vn1-vm2-85229232 launched on Node cn-jenkins-deploy-platform-ansible-os-5050-1
2026-01-20 16:05:09,542 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/9b37225d-694c-42df-bbb6-3723b1887c40
2026-01-20 16:05:09,552 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/29ea1c8d-2a9d-40c0-902c-ff8c290929ba
2026-01-20 16:05:10,807 - 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=2.77 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.392 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 0.392/1.581/2.771/1.189 ms')
2026-01-20 16:05:10,807 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-vn1-vm2-85229232 passed
2026-01-20 16:05:10,954 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-01-20 16:05:10,954 - DEBUG - Waiting to SSH to VM ctest-vn1-vm2-85229232, IP 140.6.113.69, Port 22
2026-01-20 16:05:11,109 - DEBUG - VM ctest-vn1-vm2-85229232 is ready for SSH connections
2026-01-20 16:05:11,110 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-01-20 16:05:11,110 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-01-20 16:05:11,110 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-01-20 16:05:11,110 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 170.177.255.69, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.249, gateway password: c0ntrail123
2026-01-20 16:05:11,110 - DEBUG - ping -s 56 -c 3 -W 1 170.177.255.69
2026-01-20 16:05:13,784 - DEBUG - PING 170.177.255.69 (170.177.255.69): 56 data bytes
64 bytes from 170.177.255.69: seq=0 ttl=63 time=3.850 ms
64 bytes from 170.177.255.69: seq=1 ttl=63 time=0.803 ms
64 bytes from 170.177.255.69: seq=2 ttl=63 time=1.076 ms
--- 170.177.255.69 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.803/1.909/3.850 ms
2026-01-20 16:05:13,784 - INFO - Ping to IP 170.177.255.69 from VM ctest-vn1-vm2-85229232 passed
2026-01-20 16:05:13,784 - INFO - Detaching port 29ea1c8d-2a9d-40c0-902c-ff8c290929ba from VM ctest-vn1-vm2-85229232
2026-01-20 16:05:13,835 - INFO - Deleting VM ctest-vn1-vm2-85229232
2026-01-20 16:05:13,903 - INFO - Detaching port 9aaedcc6-4f93-413c-9b81-618c2e090bb3 from VM ctest-vn1-vm1-55163902
2026-01-20 16:05:13,950 - INFO - Deleting VM ctest-vn1-vm1-55163902
2026-01-20 16:05:14,214 - DEBUG - Response for delete_port : ()
2026-01-20 16:05:14,414 - DEBUG - Response for delete_port : ()
2026-01-20 16:05:14,414 - INFO - Deleting VN ctest-vn1-32584866
2026-01-20 16:05:14,574 - DEBUG - Response for deleting network ()
2026-01-20 16:05:14,828 - DEBUG - No XMPP flaps were noticed during the test
2026-01-20 16:05:14,828 - INFO - END TEST : test_ports_specific_subnet_ip : PASSED[0:00:21]
2026-01-20 16:05:14,828 - INFO - --------------------------------------------------------------------------------
2026-01-20 16:05:15,526 - INFO - Deleted project: ctest-TestPorts-13342464, ID : 069d00b3-c198-49e1-9d37-ae841300e44a