2026-02-03 02:38:10,181 - INFO - Domain Default found not creating
2026-02-03 02:38:10,335 - INFO - Project ctest-TestPorts-00682753 not found, creating it
2026-02-03 02:38:11,071 - INFO - Created Project:ctest-TestPorts-00682753, ID : 59a810c6-2606-49ea-afde-6a1f461c7431
2026-02-03 02:38:12,551 - INFO - ================================================================================
2026-02-03 02:38:12,551 - INFO - STARTING TEST : test_ports_bindings
2026-02-03 02:38:12,551 - 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-03 02:38:12,805 - DEBUG - Nothing to compare xmpp stats {'10.0.0.27': {'10.20.0.254': '0'}} with
2026-02-03 02:38:12,805 - INFO - Initial checks done. Running the testcase now
2026-02-03 02:38:12,805 - INFO -
2026-02-03 02:38:13,341 - DEBUG - Response for create_network : {'network': {'id': '99e24184-6894-46d2-b5f4-4b0ba09940c3', 'name': 'ctest-vn-40027947', 'tenant_id': '59a810c6260649eaafde6a1f461c7431', 'project_id': '59a810c6260649eaafde6a1f461c7431', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-00682753', 'ctest-vn-40027947'], 'port_security_enabled': True, 'description': ''}}
2026-02-03 02:38:13,560 - DEBUG - Response for create_subnet : {'subnet': {'id': '4c649eea-f6d0-4f50-b1db-44dfc5e52144', 'name': '', 'tenant_id': '59a810c6260649eaafde6a1f461c7431', 'network_id': '99e24184-6894-46d2-b5f4-4b0ba09940c3', 'ip_version': 4, 'cidr': '131.191.108.64/26', 'allocation_pools': [{'start': '131.191.108.66', 'end': '131.191.108.126'}], 'gateway_ip': '131.191.108.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '131.191.108.66', 'tags': [], 'project_id': '59a810c6260649eaafde6a1f461c7431'}}
2026-02-03 02:38:13,575 - INFO - Created VN ctest-vn-40027947
2026-02-03 02:38:13,628 - DEBUG - VN ctest-vn-40027947 UUID is 99e24184-6894-46d2-b5f4-4b0ba09940c3
2026-02-03 02:38:13,730 - DEBUG - Read virtual machine interface {'fq_name': ['default-domain', 'ctest-TestPorts-00682753', 'ctest-vmi-85738431']}
2026-02-03 02:38:13,998 - DEBUG - Response for create_port : {'port': {'name': 'ctest-vmi-85738431', 'id': 'ef77b022-c7c3-4f4e-adbb-d7f658b79aa0', 'tenant_id': '59a810c6260649eaafde6a1f461c7431', 'network_id': '99e24184-6894-46d2-b5f4-4b0ba09940c3', 'mac_address': '02:ef:77:b0:22:c7', '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': '131.191.108.67', 'subnet_id': '4c649eea-f6d0-4f50-b1db-44dfc5e52144'}], 'security_groups': ['6dd2a4e5-3001-4633-b0a8-8b423513150b'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '59a810c6260649eaafde6a1f461c7431'}}
2026-02-03 02:38:13,998 - DEBUG - Created port ef77b022-c7c3-4f4e-adbb-d7f658b79aa0
2026-02-03 02:38:14,100 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine-interface/ef77b022-c7c3-4f4e-adbb-d7f658b79aa0
2026-02-03 02:38:14,390 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine-interface/ef77b022-c7c3-4f4e-adbb-d7f658b79aa0
2026-02-03 02:38:14,422 - INFO - VMI ef77b022-c7c3-4f4e-adbb-d7f658b79aa0 verification in API Server passed
2026-02-03 02:38:14,517 - DEBUG - Response for delete_port : ()
2026-02-03 02:38:14,517 - INFO - Deleted port ef77b022-c7c3-4f4e-adbb-d7f658b79aa0
2026-02-03 02:38:14,518 - INFO - Deleting VN ctest-vn-40027947
2026-02-03 02:38:14,627 - DEBUG - Response for deleting network ()
2026-02-03 02:38:14,881 - DEBUG - No XMPP flaps were noticed during the test
2026-02-03 02:38:14,881 - INFO - END TEST : test_ports_bindings : PASSED[0:00:02]
2026-02-03 02:38:14,881 - INFO - --------------------------------------------------------------------------------
2026-02-03 02:38:14,883 - INFO - ================================================================================
2026-02-03 02:38:14,883 - INFO - STARTING TEST : test_ports_specific_subnet_ip
2026-02-03 02:38:14,883 - 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-03 02:38:15,169 - DEBUG - Nothing to compare xmpp stats {'10.0.0.27': {'10.20.0.254': '0'}} with
2026-02-03 02:38:15,169 - INFO - Initial checks done. Running the testcase now
2026-02-03 02:38:15,170 - INFO -
2026-02-03 02:38:15,336 - DEBUG - Response for create_network : {'network': {'id': '49120274-2a40-4330-931f-03552c0faf86', 'name': 'ctest-vn1-83926479', 'tenant_id': '59a810c6260649eaafde6a1f461c7431', 'project_id': '59a810c6260649eaafde6a1f461c7431', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-00682753', 'ctest-vn1-83926479'], 'port_security_enabled': True, 'description': ''}}
2026-02-03 02:38:15,538 - DEBUG - Response for create_subnet : {'subnet': {'id': '1bb1116f-a80c-4d2a-95ff-9979fd289c50', 'name': '', 'tenant_id': '59a810c6260649eaafde6a1f461c7431', 'network_id': '49120274-2a40-4330-931f-03552c0faf86', 'ip_version': 4, 'cidr': '97.86.30.128/26', 'allocation_pools': [{'start': '97.86.30.130', 'end': '97.86.30.190'}], 'gateway_ip': '97.86.30.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '97.86.30.130', 'tags': [], 'project_id': '59a810c6260649eaafde6a1f461c7431'}}
2026-02-03 02:38:15,760 - DEBUG - Response for create_subnet : {'subnet': {'id': '8d93f269-7557-4155-b014-924c96ef0a98', 'name': '', 'tenant_id': '59a810c6260649eaafde6a1f461c7431', 'network_id': '49120274-2a40-4330-931f-03552c0faf86', 'ip_version': 4, 'cidr': '82.211.155.128/26', 'allocation_pools': [{'start': '82.211.155.130', 'end': '82.211.155.190'}], 'gateway_ip': '82.211.155.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '82.211.155.130', 'tags': [], 'project_id': '59a810c6260649eaafde6a1f461c7431'}}
2026-02-03 02:38:15,778 - INFO - Created VN ctest-vn1-83926479
2026-02-03 02:38:15,832 - DEBUG - VN ctest-vn1-83926479 UUID is 49120274-2a40-4330-931f-03552c0faf86
2026-02-03 02:38:16,141 - DEBUG - Response for create_port : {'port': {'name': 'b2641608-7675-4ac8-9aaf-b86f001c22db', 'id': 'b2641608-7675-4ac8-9aaf-b86f001c22db', 'tenant_id': '59a810c6260649eaafde6a1f461c7431', 'network_id': '49120274-2a40-4330-931f-03552c0faf86', 'mac_address': '02:b2:64:16:08:76', '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': '97.86.30.133', 'subnet_id': '1bb1116f-a80c-4d2a-95ff-9979fd289c50'}], 'security_groups': ['6dd2a4e5-3001-4633-b0a8-8b423513150b'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '59a810c6260649eaafde6a1f461c7431'}}
2026-02-03 02:38:16,291 - DEBUG - Response for create_port : {'port': {'name': 'cc7230f1-8947-442b-88f7-f67d23d97e9b', 'id': 'cc7230f1-8947-442b-88f7-f67d23d97e9b', 'tenant_id': '59a810c6260649eaafde6a1f461c7431', 'network_id': '49120274-2a40-4330-931f-03552c0faf86', 'mac_address': '02:cc:72:30:f1:89', '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': '82.211.155.133', 'subnet_id': '8d93f269-7557-4155-b014-924c96ef0a98'}], 'security_groups': ['6dd2a4e5-3001-4633-b0a8-8b423513150b'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '59a810c6260649eaafde6a1f461c7431'}}
2026-02-03 02:38:16,343 - DEBUG - Services list from nova: [, , ]
2026-02-03 02:38:16,655 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-5183-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-5183-1)
2026-02-03 02:38:17,011 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-5183-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-5183-1)
2026-02-03 02:38:17,011 - INFO - Waiting for VM ctest-vn1-vm1-13072001 to be up..
2026-02-03 02:38:17,046 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-02-03 02:38:22,117 - DEBUG - VM is in ACTIVE state now
2026-02-03 02:38:22,118 - INFO - VM name : ctest-vn1-vm1-13072001
2026-02-03 02:38:22,187 - DEBUG - VM ctest-vn1-vm1-13072001 ID is 0f325eaf-d5b9-4a9a-9c17-35a0fb222ce1
2026-02-03 02:38:22,206 - DEBUG - VM ctest-vn1-vm1-13072001 launched on Node cn-jenkins-deploy-platform-ansible-os-5183-1
2026-02-03 02:38:22,281 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine/0f325eaf-d5b9-4a9a-9c17-35a0fb222ce1
2026-02-03 02:38:22,291 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine-interface/b2641608-7675-4ac8-9aaf-b86f001c22db
2026-02-03 02:38:25,553 - 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 1016ms')
2026-02-03 02:38:25,553 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-13072001 failed!
2026-02-03 02:38:25,608 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-00682753:ctest-vn1-83926479 is 97.86.30.129 and allocation pool is NOT set
2026-02-03 02:38:25,608 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-00682753:ctest-vn1-83926479 is 82.211.155.129 and allocation pool is NOT set
2026-02-03 02:38:27,673 - 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.90 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=2.67 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 2.667/3.284/3.901/0.617 ms')
2026-02-03 02:38:27,673 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-13072001 passed
2026-02-03 02:38:27,824 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-03 02:38:27,824 - DEBUG - Waiting to SSH to VM ctest-vn1-vm1-13072001, IP 97.86.30.133, Port 22
2026-02-03 02:38:27,980 - DEBUG - VM ctest-vn1-vm1-13072001 is ready for SSH connections
2026-02-03 02:38:27,980 - INFO - Waiting for VM ctest-vn1-vm2-93061912 to be up..
2026-02-03 02:38:28,060 - DEBUG - VM is in ACTIVE state now
2026-02-03 02:38:28,060 - INFO - VM name : ctest-vn1-vm2-93061912
2026-02-03 02:38:28,126 - DEBUG - VM ctest-vn1-vm2-93061912 ID is a154d9a8-4570-461f-9d87-927f608d72d9
2026-02-03 02:38:28,126 - DEBUG - VM ctest-vn1-vm2-93061912 launched on Node cn-jenkins-deploy-platform-ansible-os-5183-1
2026-02-03 02:38:28,193 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine/a154d9a8-4570-461f-9d87-927f608d72d9
2026-02-03 02:38:28,201 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine-interface/cc7230f1-8947-442b-88f7-f67d23d97e9b
2026-02-03 02:38:29,424 - 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.93 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.486 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1000ms\r\nrtt min/avg/max/mdev = 0.486/1.709/2.933/1.223 ms')
2026-02-03 02:38:29,424 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-vn1-vm2-93061912 passed
2026-02-03 02:38:29,572 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-03 02:38:29,572 - DEBUG - Waiting to SSH to VM ctest-vn1-vm2-93061912, IP 82.211.155.133, Port 22
2026-02-03 02:38:29,736 - DEBUG - VM ctest-vn1-vm2-93061912 is ready for SSH connections
2026-02-03 02:38:29,736 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-03 02:38:29,736 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-03 02:38:29,736 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-03 02:38:29,736 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 97.86.30.133, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.27, gateway password: c0ntrail123
2026-02-03 02:38:29,736 - DEBUG - ping -s 56 -c 3 -W 1 97.86.30.133
2026-02-03 02:38:32,359 - DEBUG - PING 97.86.30.133 (97.86.30.133): 56 data bytes
64 bytes from 97.86.30.133: seq=0 ttl=63 time=3.578 ms
64 bytes from 97.86.30.133: seq=1 ttl=63 time=0.783 ms
64 bytes from 97.86.30.133: seq=2 ttl=63 time=0.756 ms
--- 97.86.30.133 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.756/1.705/3.578 ms
2026-02-03 02:38:32,359 - INFO - Ping to IP 97.86.30.133 from VM ctest-vn1-vm2-93061912 passed
2026-02-03 02:38:32,359 - INFO - Detaching port cc7230f1-8947-442b-88f7-f67d23d97e9b from VM ctest-vn1-vm2-93061912
2026-02-03 02:38:32,406 - INFO - Deleting VM ctest-vn1-vm2-93061912
2026-02-03 02:38:32,471 - INFO - Detaching port b2641608-7675-4ac8-9aaf-b86f001c22db from VM ctest-vn1-vm1-13072001
2026-02-03 02:38:32,505 - INFO - Deleting VM ctest-vn1-vm1-13072001
2026-02-03 02:38:32,750 - DEBUG - Response for delete_port : ()
2026-02-03 02:38:32,886 - DEBUG - Response for delete_port : ()
2026-02-03 02:38:32,886 - INFO - Deleting VN ctest-vn1-83926479
2026-02-03 02:38:33,017 - DEBUG - Response for deleting network ()
2026-02-03 02:38:33,273 - DEBUG - No XMPP flaps were noticed during the test
2026-02-03 02:38:33,273 - INFO - END TEST : test_ports_specific_subnet_ip : PASSED[0:00:19]
2026-02-03 02:38:33,273 - INFO - --------------------------------------------------------------------------------
2026-02-03 02:38:33,963 - INFO - Deleted project: ctest-TestPorts-00682753, ID : 59a810c6-2606-49ea-afde-6a1f461c7431