2026-03-24 19:41:16,541 - INFO - Domain Default found not creating
2026-03-24 19:41:16,694 - INFO - Project ctest-TestPorts-25089194 not found, creating it
2026-03-24 19:41:17,147 - INFO - Created Project:ctest-TestPorts-25089194, ID : 23a77f35-f7fd-4e84-8fb8-63c888a10d0e
2026-03-24 19:41:18,608 - INFO - ================================================================================
2026-03-24 19:41:18,608 - INFO - STARTING TEST : test_ports_bindings
2026-03-24 19:41:18,608 - 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-03-24 19:41:18,866 - DEBUG - Nothing to compare xmpp stats {'10.0.0.38': {'10.20.0.17': '0'}} with
2026-03-24 19:41:18,867 - INFO - Initial checks done. Running the testcase now
2026-03-24 19:41:18,867 - INFO -
2026-03-24 19:41:19,403 - DEBUG - Response for create_network : {'network': {'id': '36b4a054-f987-490a-894d-33a3269c362c', 'name': 'ctest-vn-69892614', 'tenant_id': '23a77f35f7fd4e848fb863c888a10d0e', 'project_id': '23a77f35f7fd4e848fb863c888a10d0e', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-25089194', 'ctest-vn-69892614'], 'port_security_enabled': True, 'description': ''}}
2026-03-24 19:41:19,616 - DEBUG - Response for create_subnet : {'subnet': {'id': '7c795231-5cfb-492b-aac0-c964d53eae4a', 'name': '', 'tenant_id': '23a77f35f7fd4e848fb863c888a10d0e', 'network_id': '36b4a054-f987-490a-894d-33a3269c362c', 'ip_version': 4, 'cidr': '111.80.120.192/26', 'allocation_pools': [{'start': '111.80.120.194', 'end': '111.80.120.254'}], 'gateway_ip': '111.80.120.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '111.80.120.194', 'tags': [], 'project_id': '23a77f35f7fd4e848fb863c888a10d0e'}}
2026-03-24 19:41:19,632 - INFO - Created VN ctest-vn-69892614
2026-03-24 19:41:19,681 - DEBUG - VN ctest-vn-69892614 UUID is 36b4a054-f987-490a-894d-33a3269c362c
2026-03-24 19:41:19,865 - DEBUG - Read virtual machine interface {'fq_name': ['default-domain', 'ctest-TestPorts-25089194', 'ctest-vmi-77333066']}
2026-03-24 19:41:20,123 - DEBUG - Response for create_port : {'port': {'name': 'ctest-vmi-77333066', 'id': 'dace65ae-84f7-4185-93ab-bd2ceeb5ff72', 'tenant_id': '23a77f35f7fd4e848fb863c888a10d0e', 'network_id': '36b4a054-f987-490a-894d-33a3269c362c', 'mac_address': '02:da:ce:65:ae:84', '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': '111.80.120.195', 'subnet_id': '7c795231-5cfb-492b-aac0-c964d53eae4a'}], 'security_groups': ['b4d03290-ef6f-41ff-83e1-517e6f98946d'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '23a77f35f7fd4e848fb863c888a10d0e'}}
2026-03-24 19:41:20,123 - DEBUG - Created port dace65ae-84f7-4185-93ab-bd2ceeb5ff72
2026-03-24 19:41:20,225 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/dace65ae-84f7-4185-93ab-bd2ceeb5ff72
2026-03-24 19:41:20,519 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/dace65ae-84f7-4185-93ab-bd2ceeb5ff72
2026-03-24 19:41:20,550 - INFO - VMI dace65ae-84f7-4185-93ab-bd2ceeb5ff72 verification in API Server passed
2026-03-24 19:41:20,629 - DEBUG - Response for delete_port : ()
2026-03-24 19:41:20,629 - INFO - Deleted port dace65ae-84f7-4185-93ab-bd2ceeb5ff72
2026-03-24 19:41:20,630 - INFO - Deleting VN ctest-vn-69892614
2026-03-24 19:41:20,720 - DEBUG - Response for deleting network ()
2026-03-24 19:41:20,975 - DEBUG - No XMPP flaps were noticed during the test
2026-03-24 19:41:20,975 - INFO - END TEST : test_ports_bindings : PASSED[0:00:02]
2026-03-24 19:41:20,975 - INFO - --------------------------------------------------------------------------------
2026-03-24 19:41:20,977 - INFO - ================================================================================
2026-03-24 19:41:20,977 - INFO - STARTING TEST : test_ports_specific_subnet_ip
2026-03-24 19:41:20,977 - 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-03-24 19:41:21,265 - DEBUG - Nothing to compare xmpp stats {'10.0.0.38': {'10.20.0.17': '0'}} with
2026-03-24 19:41:21,265 - INFO - Initial checks done. Running the testcase now
2026-03-24 19:41:21,265 - INFO -
2026-03-24 19:41:21,426 - DEBUG - Response for create_network : {'network': {'id': 'b5f7d2e8-f8fa-45bb-aa51-9d859b34a854', 'name': 'ctest-vn1-79476862', 'tenant_id': '23a77f35f7fd4e848fb863c888a10d0e', 'project_id': '23a77f35f7fd4e848fb863c888a10d0e', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-25089194', 'ctest-vn1-79476862'], 'port_security_enabled': True, 'description': ''}}
2026-03-24 19:41:21,585 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ac2c81e7-04a8-4f91-8901-4cc56e8dfe7d', 'name': '', 'tenant_id': '23a77f35f7fd4e848fb863c888a10d0e', 'network_id': 'b5f7d2e8-f8fa-45bb-aa51-9d859b34a854', 'ip_version': 4, 'cidr': '83.209.190.192/26', 'allocation_pools': [{'start': '83.209.190.194', 'end': '83.209.190.254'}], 'gateway_ip': '83.209.190.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '83.209.190.194', 'tags': [], 'project_id': '23a77f35f7fd4e848fb863c888a10d0e'}}
2026-03-24 19:41:21,759 - DEBUG - Response for create_subnet : {'subnet': {'id': 'fae09ca6-17cd-44b7-b8ba-3a4076386f18', 'name': '', 'tenant_id': '23a77f35f7fd4e848fb863c888a10d0e', 'network_id': 'b5f7d2e8-f8fa-45bb-aa51-9d859b34a854', 'ip_version': 4, 'cidr': '38.70.121.128/26', 'allocation_pools': [{'start': '38.70.121.130', 'end': '38.70.121.190'}], 'gateway_ip': '38.70.121.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '38.70.121.130', 'tags': [], 'project_id': '23a77f35f7fd4e848fb863c888a10d0e'}}
2026-03-24 19:41:21,777 - INFO - Created VN ctest-vn1-79476862
2026-03-24 19:41:21,829 - DEBUG - VN ctest-vn1-79476862 UUID is b5f7d2e8-f8fa-45bb-aa51-9d859b34a854
2026-03-24 19:41:22,113 - DEBUG - Response for create_port : {'port': {'name': '0015e3d9-8029-4030-93a2-48da5fe7b6fa', 'id': '0015e3d9-8029-4030-93a2-48da5fe7b6fa', 'tenant_id': '23a77f35f7fd4e848fb863c888a10d0e', 'network_id': 'b5f7d2e8-f8fa-45bb-aa51-9d859b34a854', 'mac_address': '02:00:15:e3:d9:80', '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': '83.209.190.197', 'subnet_id': 'ac2c81e7-04a8-4f91-8901-4cc56e8dfe7d'}], 'security_groups': ['b4d03290-ef6f-41ff-83e1-517e6f98946d'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '23a77f35f7fd4e848fb863c888a10d0e'}}
2026-03-24 19:41:22,273 - DEBUG - Response for create_port : {'port': {'name': 'befd6058-96d8-4cbe-956a-4087a3c3608a', 'id': 'befd6058-96d8-4cbe-956a-4087a3c3608a', 'tenant_id': '23a77f35f7fd4e848fb863c888a10d0e', 'network_id': 'b5f7d2e8-f8fa-45bb-aa51-9d859b34a854', 'mac_address': '02:be:fd:60:58:96', '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': '38.70.121.133', 'subnet_id': 'fae09ca6-17cd-44b7-b8ba-3a4076386f18'}], 'security_groups': ['b4d03290-ef6f-41ff-83e1-517e6f98946d'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '23a77f35f7fd4e848fb863c888a10d0e'}}
2026-03-24 19:41:22,325 - DEBUG - Services list from nova: [, , ]
2026-03-24 19:41:22,648 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-5535-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-5535-1)
2026-03-24 19:41:23,035 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-5535-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-5535-1)
2026-03-24 19:41:23,036 - INFO - Waiting for VM ctest-vn1-vm1-14171290 to be up..
2026-03-24 19:41:23,081 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-03-24 19:41:28,158 - DEBUG - VM is in ACTIVE state now
2026-03-24 19:41:28,158 - INFO - VM name : ctest-vn1-vm1-14171290
2026-03-24 19:41:28,241 - DEBUG - VM ctest-vn1-vm1-14171290 ID is 5c3fd187-85e5-468d-a53f-d14b732fda31
2026-03-24 19:41:28,262 - DEBUG - VM ctest-vn1-vm1-14171290 launched on Node cn-jenkins-deploy-platform-ansible-os-5535-1
2026-03-24 19:41:28,333 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/5c3fd187-85e5-468d-a53f-d14b732fda31
2026-03-24 19:41:28,341 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/0015e3d9-8029-4030-93a2-48da5fe7b6fa
2026-03-24 19:41:31,620 - 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 1023ms')
2026-03-24 19:41:31,621 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-14171290 failed!
2026-03-24 19:41:31,673 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-25089194:ctest-vn1-79476862 is 83.209.190.193 and allocation pool is NOT set
2026-03-24 19:41:31,673 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-25089194:ctest-vn1-79476862 is 38.70.121.129 and allocation pool is NOT set
2026-03-24 19:41:33,735 - 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.21 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.657 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.657/2.434/4.211/1.777 ms')
2026-03-24 19:41:33,735 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-14171290 passed
2026-03-24 19:41:33,885 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-03-24 19:41:33,886 - DEBUG - Waiting to SSH to VM ctest-vn1-vm1-14171290, IP 83.209.190.197, Port 22
2026-03-24 19:41:34,052 - DEBUG - VM ctest-vn1-vm1-14171290 is ready for SSH connections
2026-03-24 19:41:34,052 - INFO - Waiting for VM ctest-vn1-vm2-14498356 to be up..
2026-03-24 19:41:34,127 - DEBUG - VM is in ACTIVE state now
2026-03-24 19:41:34,127 - INFO - VM name : ctest-vn1-vm2-14498356
2026-03-24 19:41:34,200 - DEBUG - VM ctest-vn1-vm2-14498356 ID is 0c73a739-96c3-4991-98ea-c9d0e69dff79
2026-03-24 19:41:34,200 - DEBUG - VM ctest-vn1-vm2-14498356 launched on Node cn-jenkins-deploy-platform-ansible-os-5535-1
2026-03-24 19:41:34,270 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/0c73a739-96c3-4991-98ea-c9d0e69dff79
2026-03-24 19:41:34,280 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/befd6058-96d8-4cbe-956a-4087a3c3608a
2026-03-24 19:41:35,506 - 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=3.18 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.411 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.411/1.797/3.184/1.386 ms')
2026-03-24 19:41:35,506 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-vn1-vm2-14498356 passed
2026-03-24 19:41:35,653 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-03-24 19:41:35,654 - DEBUG - Waiting to SSH to VM ctest-vn1-vm2-14498356, IP 38.70.121.133, Port 22
2026-03-24 19:41:35,813 - DEBUG - VM ctest-vn1-vm2-14498356 is ready for SSH connections
2026-03-24 19:41:35,813 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-03-24 19:41:35,813 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-03-24 19:41:35,814 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-03-24 19:41:35,814 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 83.209.190.197, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.38, gateway password: c0ntrail123
2026-03-24 19:41:35,814 - DEBUG - ping -s 56 -c 3 -W 1 83.209.190.197
2026-03-24 19:41:38,473 - DEBUG - PING 83.209.190.197 (83.209.190.197): 56 data bytes
64 bytes from 83.209.190.197: seq=0 ttl=63 time=3.524 ms
64 bytes from 83.209.190.197: seq=1 ttl=63 time=0.845 ms
64 bytes from 83.209.190.197: seq=2 ttl=63 time=0.760 ms
--- 83.209.190.197 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.760/1.709/3.524 ms
2026-03-24 19:41:38,473 - INFO - Ping to IP 83.209.190.197 from VM ctest-vn1-vm2-14498356 passed
2026-03-24 19:41:38,473 - INFO - Detaching port befd6058-96d8-4cbe-956a-4087a3c3608a from VM ctest-vn1-vm2-14498356
2026-03-24 19:41:38,519 - INFO - Deleting VM ctest-vn1-vm2-14498356
2026-03-24 19:41:38,588 - INFO - Detaching port 0015e3d9-8029-4030-93a2-48da5fe7b6fa from VM ctest-vn1-vm1-14171290
2026-03-24 19:41:38,619 - INFO - Deleting VM ctest-vn1-vm1-14171290
2026-03-24 19:41:38,825 - DEBUG - Response for delete_port : ()
2026-03-24 19:41:38,998 - DEBUG - Response for delete_port : ()
2026-03-24 19:41:38,998 - INFO - Deleting VN ctest-vn1-79476862
2026-03-24 19:41:39,152 - DEBUG - Response for deleting network ()
2026-03-24 19:41:39,406 - DEBUG - No XMPP flaps were noticed during the test
2026-03-24 19:41:39,406 - INFO - END TEST : test_ports_specific_subnet_ip : PASSED[0:00:19]
2026-03-24 19:41:39,406 - INFO - --------------------------------------------------------------------------------
2026-03-24 19:41:40,096 - INFO - Deleted project: ctest-TestPorts-25089194, ID : 23a77f35-f7fd-4e84-8fb8-63c888a10d0e