2026-02-12 09:53:13,215 - INFO - Domain Default found not creating
2026-02-12 09:53:13,382 - INFO - Project ctest-TestPorts-86380502 not found, creating it
2026-02-12 09:53:13,869 - INFO - Created Project:ctest-TestPorts-86380502, ID : 4178fa11-4f57-461d-8c65-12d4ab2d9c32
2026-02-12 09:53:15,441 - INFO - ================================================================================
2026-02-12 09:53:15,441 - INFO - STARTING TEST : test_ports_bindings
2026-02-12 09:53:15,441 - 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-02-12 09:53:15,706 - DEBUG - Nothing to compare xmpp stats {'10.0.0.50': {'10.20.0.17': '0'}} with
2026-02-12 09:53:15,706 - INFO - Initial checks done. Running the testcase now
2026-02-12 09:53:15,706 - INFO -
2026-02-12 09:53:16,300 - DEBUG - Response for create_network : {'network': {'id': 'a764afae-7b3e-41a5-9632-3b5129be3a06', 'name': 'ctest-vn-95540696', 'tenant_id': '4178fa114f57461d8c6512d4ab2d9c32', 'project_id': '4178fa114f57461d8c6512d4ab2d9c32', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-86380502', 'ctest-vn-95540696'], 'port_security_enabled': True, 'description': ''}}
2026-02-12 09:53:16,523 - DEBUG - Response for create_subnet : {'subnet': {'id': '49b9a72d-30d4-4465-ba25-9ef0c8652191', 'name': '', 'tenant_id': '4178fa114f57461d8c6512d4ab2d9c32', 'network_id': 'a764afae-7b3e-41a5-9632-3b5129be3a06', 'ip_version': 4, 'cidr': '43.213.192.128/26', 'allocation_pools': [{'start': '43.213.192.130', 'end': '43.213.192.190'}], 'gateway_ip': '43.213.192.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '43.213.192.130', 'tags': [], 'project_id': '4178fa114f57461d8c6512d4ab2d9c32'}}
2026-02-12 09:53:16,542 - INFO - Created VN ctest-vn-95540696
2026-02-12 09:53:16,595 - DEBUG - VN ctest-vn-95540696 UUID is a764afae-7b3e-41a5-9632-3b5129be3a06
2026-02-12 09:53:16,681 - DEBUG - Read virtual machine interface {'fq_name': ['default-domain', 'ctest-TestPorts-86380502', 'ctest-vmi-58014249']}
2026-02-12 09:53:16,920 - DEBUG - Response for create_port : {'port': {'name': 'ctest-vmi-58014249', 'id': '0e381b64-711e-4398-b441-1df3d082b638', 'tenant_id': '4178fa114f57461d8c6512d4ab2d9c32', 'network_id': 'a764afae-7b3e-41a5-9632-3b5129be3a06', 'mac_address': '02:0e:38:1b:64:71', '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': '43.213.192.131', 'subnet_id': '49b9a72d-30d4-4465-ba25-9ef0c8652191'}], 'security_groups': ['748f7c58-be1a-4351-afae-88075aa4b4a1'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '4178fa114f57461d8c6512d4ab2d9c32'}}
2026-02-12 09:53:16,920 - DEBUG - Created port 0e381b64-711e-4398-b441-1df3d082b638
2026-02-12 09:53:17,027 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/0e381b64-711e-4398-b441-1df3d082b638
2026-02-12 09:53:17,321 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/0e381b64-711e-4398-b441-1df3d082b638
2026-02-12 09:53:17,363 - INFO - VMI 0e381b64-711e-4398-b441-1df3d082b638 verification in API Server passed
2026-02-12 09:53:17,462 - DEBUG - Response for delete_port : ()
2026-02-12 09:53:17,462 - INFO - Deleted port 0e381b64-711e-4398-b441-1df3d082b638
2026-02-12 09:53:17,462 - INFO - Deleting VN ctest-vn-95540696
2026-02-12 09:53:17,572 - DEBUG - Response for deleting network ()
2026-02-12 09:53:17,834 - DEBUG - No XMPP flaps were noticed during the test
2026-02-12 09:53:17,834 - INFO - END TEST : test_ports_bindings : PASSED[0:00:02]
2026-02-12 09:53:17,834 - INFO - --------------------------------------------------------------------------------
2026-02-12 09:53:17,837 - INFO - ================================================================================
2026-02-12 09:53:17,837 - INFO - STARTING TEST : test_ports_specific_subnet_ip
2026-02-12 09:53:17,838 - 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-02-12 09:53:18,128 - DEBUG - Nothing to compare xmpp stats {'10.0.0.50': {'10.20.0.17': '0'}} with
2026-02-12 09:53:18,128 - INFO - Initial checks done. Running the testcase now
2026-02-12 09:53:18,128 - INFO -
2026-02-12 09:53:18,305 - DEBUG - Response for create_network : {'network': {'id': 'd2040070-fe8b-4248-87a3-cb4437c31f5d', 'name': 'ctest-vn1-54890808', 'tenant_id': '4178fa114f57461d8c6512d4ab2d9c32', 'project_id': '4178fa114f57461d8c6512d4ab2d9c32', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-86380502', 'ctest-vn1-54890808'], 'port_security_enabled': True, 'description': ''}}
2026-02-12 09:53:18,518 - DEBUG - Response for create_subnet : {'subnet': {'id': '41ea0913-7e75-42d8-b98d-bf44a0d4babd', 'name': '', 'tenant_id': '4178fa114f57461d8c6512d4ab2d9c32', 'network_id': 'd2040070-fe8b-4248-87a3-cb4437c31f5d', 'ip_version': 4, 'cidr': '198.168.88.192/26', 'allocation_pools': [{'start': '198.168.88.194', 'end': '198.168.88.254'}], 'gateway_ip': '198.168.88.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '198.168.88.194', 'tags': [], 'project_id': '4178fa114f57461d8c6512d4ab2d9c32'}}
2026-02-12 09:53:18,684 - DEBUG - Response for create_subnet : {'subnet': {'id': '9988d2aa-801a-4a82-bd2a-6e42917e2f4a', 'name': '', 'tenant_id': '4178fa114f57461d8c6512d4ab2d9c32', 'network_id': 'd2040070-fe8b-4248-87a3-cb4437c31f5d', 'ip_version': 4, 'cidr': '47.205.42.64/26', 'allocation_pools': [{'start': '47.205.42.66', 'end': '47.205.42.126'}], 'gateway_ip': '47.205.42.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '47.205.42.66', 'tags': [], 'project_id': '4178fa114f57461d8c6512d4ab2d9c32'}}
2026-02-12 09:53:18,707 - INFO - Created VN ctest-vn1-54890808
2026-02-12 09:53:18,759 - DEBUG - VN ctest-vn1-54890808 UUID is d2040070-fe8b-4248-87a3-cb4437c31f5d
2026-02-12 09:53:19,070 - DEBUG - Response for create_port : {'port': {'name': '5eb9bbea-8788-4bda-9a3e-cc170360b281', 'id': '5eb9bbea-8788-4bda-9a3e-cc170360b281', 'tenant_id': '4178fa114f57461d8c6512d4ab2d9c32', 'network_id': 'd2040070-fe8b-4248-87a3-cb4437c31f5d', 'mac_address': '02:5e:b9:bb:ea:87', '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': '198.168.88.197', 'subnet_id': '41ea0913-7e75-42d8-b98d-bf44a0d4babd'}], 'security_groups': ['748f7c58-be1a-4351-afae-88075aa4b4a1'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '4178fa114f57461d8c6512d4ab2d9c32'}}
2026-02-12 09:53:19,249 - DEBUG - Response for create_port : {'port': {'name': '2910b40d-0978-44a2-8f88-25805a141238', 'id': '2910b40d-0978-44a2-8f88-25805a141238', 'tenant_id': '4178fa114f57461d8c6512d4ab2d9c32', 'network_id': 'd2040070-fe8b-4248-87a3-cb4437c31f5d', 'mac_address': '02:29:10:b4:0d:09', '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': '47.205.42.69', 'subnet_id': '9988d2aa-801a-4a82-bd2a-6e42917e2f4a'}], 'security_groups': ['748f7c58-be1a-4351-afae-88075aa4b4a1'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '4178fa114f57461d8c6512d4ab2d9c32'}}
2026-02-12 09:53:19,307 - DEBUG - Services list from nova: [, , ]
2026-02-12 09:53:19,653 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-5313-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-5313-1)
2026-02-12 09:53:20,129 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-5313-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-5313-1)
2026-02-12 09:53:20,129 - INFO - Waiting for VM ctest-vn1-vm1-96432677 to be up..
2026-02-12 09:53:20,169 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-02-12 09:53:25,253 - DEBUG - VM is in ACTIVE state now
2026-02-12 09:53:25,253 - INFO - VM name : ctest-vn1-vm1-96432677
2026-02-12 09:53:25,328 - DEBUG - VM ctest-vn1-vm1-96432677 ID is a942e86a-afa6-45aa-b468-ad83ad73ce56
2026-02-12 09:53:25,346 - DEBUG - VM ctest-vn1-vm1-96432677 launched on Node cn-jenkins-deploy-platform-ansible-os-5313-1
2026-02-12 09:53:25,423 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine/a942e86a-afa6-45aa-b468-ad83ad73ce56
2026-02-12 09:53:25,432 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/5eb9bbea-8788-4bda-9a3e-cc170360b281
2026-02-12 09:53:28,678 - 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 1007ms')
2026-02-12 09:53:28,678 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-96432677 failed!
2026-02-12 09:53:28,731 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-86380502:ctest-vn1-54890808 is 198.168.88.193 and allocation pool is NOT set
2026-02-12 09:53:28,731 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-86380502:ctest-vn1-54890808 is 47.205.42.65 and allocation pool is NOT set
2026-02-12 09:53:30,796 - 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=3.99 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.74 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 = 1.738/2.863/3.988/1.125 ms')
2026-02-12 09:53:30,797 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-96432677 passed
2026-02-12 09:53:30,951 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-12 09:53:30,951 - DEBUG - Waiting to SSH to VM ctest-vn1-vm1-96432677, IP 198.168.88.197, Port 22
2026-02-12 09:53:31,117 - DEBUG - VM ctest-vn1-vm1-96432677 is ready for SSH connections
2026-02-12 09:53:31,117 - INFO - Waiting for VM ctest-vn1-vm2-37891668 to be up..
2026-02-12 09:53:31,197 - DEBUG - VM is in ACTIVE state now
2026-02-12 09:53:31,197 - INFO - VM name : ctest-vn1-vm2-37891668
2026-02-12 09:53:31,277 - DEBUG - VM ctest-vn1-vm2-37891668 ID is a861e963-4e7e-44d8-9753-a2792cf570ca
2026-02-12 09:53:31,277 - DEBUG - VM ctest-vn1-vm2-37891668 launched on Node cn-jenkins-deploy-platform-ansible-os-5313-1
2026-02-12 09:53:31,352 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine/a861e963-4e7e-44d8-9753-a2792cf570ca
2026-02-12 09:53:31,360 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/2910b40d-0978-44a2-8f88-25805a141238
2026-02-12 09:53:32,612 - 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=5.85 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.870 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.870/3.362/5.854/2.492 ms')
2026-02-12 09:53:32,612 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-vn1-vm2-37891668 passed
2026-02-12 09:53:32,759 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-12 09:53:32,759 - DEBUG - Waiting to SSH to VM ctest-vn1-vm2-37891668, IP 47.205.42.69, Port 22
2026-02-12 09:53:32,914 - DEBUG - VM ctest-vn1-vm2-37891668 is ready for SSH connections
2026-02-12 09:53:32,914 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-12 09:53:32,914 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-12 09:53:32,914 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-12 09:53:32,914 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 198.168.88.197, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.50, gateway password: c0ntrail123
2026-02-12 09:53:32,914 - DEBUG - ping -s 56 -c 3 -W 1 198.168.88.197
2026-02-12 09:53:35,670 - DEBUG - PING 198.168.88.197 (198.168.88.197): 56 data bytes
64 bytes from 198.168.88.197: seq=0 ttl=63 time=3.982 ms
64 bytes from 198.168.88.197: seq=1 ttl=63 time=0.882 ms
64 bytes from 198.168.88.197: seq=2 ttl=63 time=1.172 ms
--- 198.168.88.197 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.882/2.012/3.982 ms
2026-02-12 09:53:35,671 - INFO - Ping to IP 198.168.88.197 from VM ctest-vn1-vm2-37891668 passed
2026-02-12 09:53:35,671 - INFO - Detaching port 2910b40d-0978-44a2-8f88-25805a141238 from VM ctest-vn1-vm2-37891668
2026-02-12 09:53:35,722 - INFO - Deleting VM ctest-vn1-vm2-37891668
2026-02-12 09:53:35,806 - INFO - Detaching port 5eb9bbea-8788-4bda-9a3e-cc170360b281 from VM ctest-vn1-vm1-96432677
2026-02-12 09:53:35,850 - INFO - Deleting VM ctest-vn1-vm1-96432677
2026-02-12 09:53:36,133 - DEBUG - Response for delete_port : ()
2026-02-12 09:53:36,359 - DEBUG - Response for delete_port : ()
2026-02-12 09:53:36,359 - INFO - Deleting VN ctest-vn1-54890808
2026-02-12 09:53:36,542 - DEBUG - Response for deleting network ()
2026-02-12 09:53:36,797 - DEBUG - No XMPP flaps were noticed during the test
2026-02-12 09:53:36,797 - INFO - END TEST : test_ports_specific_subnet_ip : PASSED[0:00:19]
2026-02-12 09:53:36,797 - INFO - --------------------------------------------------------------------------------
2026-02-12 09:53:37,607 - INFO - Deleted project: ctest-TestPorts-86380502, ID : 4178fa11-4f57-461d-8c65-12d4ab2d9c32