2025-10-22 08:48:18,874 - INFO - Domain Default found not creating 2025-10-22 08:48:19,029 - INFO - Project ctest-TestPorts-55821026 not found, creating it 2025-10-22 08:48:19,564 - INFO - Created Project:ctest-TestPorts-55821026, ID : c2e29733-9674-46c2-9a36-8303983b051c 2025-10-22 08:48:21,010 - INFO - ================================================================================ 2025-10-22 08:48:21,010 - INFO - STARTING TEST : test_ports_bindings 2025-10-22 08:48:21,010 - 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 2025-10-22 08:48:21,268 - DEBUG - Nothing to compare xmpp stats {'10.0.0.33': {'10.20.0.17': '0'}} with 2025-10-22 08:48:21,268 - INFO - Initial checks done. Running the testcase now 2025-10-22 08:48:21,269 - INFO - 2025-10-22 08:48:21,871 - DEBUG - Response for create_network : {'network': {'id': 'b51e54de-18e5-4fb3-bd70-f69e87124e0f', 'name': 'ctest-vn-30384625', 'tenant_id': 'c2e29733967446c29a368303983b051c', 'project_id': 'c2e29733967446c29a368303983b051c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-55821026', 'ctest-vn-30384625'], 'port_security_enabled': True, 'description': ''}} 2025-10-22 08:48:22,054 - DEBUG - Response for create_subnet : {'subnet': {'id': '8769a692-e03d-40d6-8687-05bc00891e4f', 'name': '', 'tenant_id': 'c2e29733967446c29a368303983b051c', 'network_id': 'b51e54de-18e5-4fb3-bd70-f69e87124e0f', 'ip_version': 4, 'cidr': '29.61.29.192/26', 'allocation_pools': [{'start': '29.61.29.194', 'end': '29.61.29.254'}], 'gateway_ip': '29.61.29.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '29.61.29.194', 'tags': [], 'project_id': 'c2e29733967446c29a368303983b051c'}} 2025-10-22 08:48:22,079 - INFO - Created VN ctest-vn-30384625 2025-10-22 08:48:22,130 - DEBUG - VN ctest-vn-30384625 UUID is b51e54de-18e5-4fb3-bd70-f69e87124e0f 2025-10-22 08:48:22,238 - DEBUG - Read virtual machine interface {'fq_name': ['default-domain', 'ctest-TestPorts-55821026', 'ctest-vmi-06968340']} 2025-10-22 08:48:22,479 - DEBUG - Response for create_port : {'port': {'name': 'ctest-vmi-06968340', 'id': 'b98e3af1-a0f2-46af-8ce3-37d7f5622bab', 'tenant_id': 'c2e29733967446c29a368303983b051c', 'network_id': 'b51e54de-18e5-4fb3-bd70-f69e87124e0f', 'mac_address': '02:b9:8e:3a:f1:a0', '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': '29.61.29.195', 'subnet_id': '8769a692-e03d-40d6-8687-05bc00891e4f'}], 'security_groups': ['29c53fb6-30d9-407a-870a-be65a8d31e9f'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': 'c2e29733967446c29a368303983b051c'}} 2025-10-22 08:48:22,479 - DEBUG - Created port b98e3af1-a0f2-46af-8ce3-37d7f5622bab 2025-10-22 08:48:22,582 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/b98e3af1-a0f2-46af-8ce3-37d7f5622bab 2025-10-22 08:48:22,877 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/b98e3af1-a0f2-46af-8ce3-37d7f5622bab 2025-10-22 08:48:22,912 - INFO - VMI b98e3af1-a0f2-46af-8ce3-37d7f5622bab verification in API Server passed 2025-10-22 08:48:23,020 - DEBUG - Response for delete_port : () 2025-10-22 08:48:23,021 - INFO - Deleted port b98e3af1-a0f2-46af-8ce3-37d7f5622bab 2025-10-22 08:48:23,021 - INFO - Deleting VN ctest-vn-30384625 2025-10-22 08:48:23,144 - DEBUG - Response for deleting network () 2025-10-22 08:48:23,400 - DEBUG - No XMPP flaps were noticed during the test
2025-10-22 08:48:23,400 - INFO - END TEST : test_ports_bindings : PASSED[0:00:02]
2025-10-22 08:48:23,400 - INFO - -------------------------------------------------------------------------------- 2025-10-22 08:48:23,402 - INFO - ================================================================================ 2025-10-22 08:48:23,402 - INFO - STARTING TEST : test_ports_specific_subnet_ip 2025-10-22 08:48:23,402 - 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 2025-10-22 08:48:23,688 - DEBUG - Nothing to compare xmpp stats {'10.0.0.33': {'10.20.0.17': '0'}} with 2025-10-22 08:48:23,688 - INFO - Initial checks done. Running the testcase now 2025-10-22 08:48:23,688 - INFO - 2025-10-22 08:48:23,877 - DEBUG - Response for create_network : {'network': {'id': '4b1529c4-1d74-41be-a0cd-b147ee439de7', 'name': 'ctest-vn1-66931212', 'tenant_id': 'c2e29733967446c29a368303983b051c', 'project_id': 'c2e29733967446c29a368303983b051c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-55821026', 'ctest-vn1-66931212'], 'port_security_enabled': True, 'description': ''}} 2025-10-22 08:48:24,046 - DEBUG - Response for create_subnet : {'subnet': {'id': '5b46204e-3e9b-4f2c-8c92-f29cba26fc58', 'name': '', 'tenant_id': 'c2e29733967446c29a368303983b051c', 'network_id': '4b1529c4-1d74-41be-a0cd-b147ee439de7', 'ip_version': 4, 'cidr': '82.14.233.192/26', 'allocation_pools': [{'start': '82.14.233.194', 'end': '82.14.233.254'}], 'gateway_ip': '82.14.233.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '82.14.233.194', 'tags': [], 'project_id': 'c2e29733967446c29a368303983b051c'}} 2025-10-22 08:48:24,214 - DEBUG - Response for create_subnet : {'subnet': {'id': 'bb193963-d84d-47aa-912f-06810ac2b780', 'name': '', 'tenant_id': 'c2e29733967446c29a368303983b051c', 'network_id': '4b1529c4-1d74-41be-a0cd-b147ee439de7', 'ip_version': 4, 'cidr': '19.226.226.64/26', 'allocation_pools': [{'start': '19.226.226.66', 'end': '19.226.226.126'}], 'gateway_ip': '19.226.226.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '19.226.226.66', 'tags': [], 'project_id': 'c2e29733967446c29a368303983b051c'}} 2025-10-22 08:48:24,235 - INFO - Created VN ctest-vn1-66931212 2025-10-22 08:48:24,286 - DEBUG - VN ctest-vn1-66931212 UUID is 4b1529c4-1d74-41be-a0cd-b147ee439de7 2025-10-22 08:48:24,586 - DEBUG - Response for create_port : {'port': {'name': 'db3baa99-61e6-4747-8a77-cd40cec04421', 'id': 'db3baa99-61e6-4747-8a77-cd40cec04421', 'tenant_id': 'c2e29733967446c29a368303983b051c', 'network_id': '4b1529c4-1d74-41be-a0cd-b147ee439de7', 'mac_address': '02:db:3b:aa:99:61', '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.14.233.197', 'subnet_id': '5b46204e-3e9b-4f2c-8c92-f29cba26fc58'}], 'security_groups': ['29c53fb6-30d9-407a-870a-be65a8d31e9f'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': 'c2e29733967446c29a368303983b051c'}} 2025-10-22 08:48:24,760 - DEBUG - Response for create_port : {'port': {'name': 'f9b4c162-13dc-43b8-a26b-b30e95581f99', 'id': 'f9b4c162-13dc-43b8-a26b-b30e95581f99', 'tenant_id': 'c2e29733967446c29a368303983b051c', 'network_id': '4b1529c4-1d74-41be-a0cd-b147ee439de7', 'mac_address': '02:f9:b4:c1:62:13', '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': '19.226.226.69', 'subnet_id': 'bb193963-d84d-47aa-912f-06810ac2b780'}], 'security_groups': ['29c53fb6-30d9-407a-870a-be65a8d31e9f'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': 'c2e29733967446c29a368303983b051c'}} 2025-10-22 08:48:24,825 - DEBUG - Services list from nova: [, , ] 2025-10-22 08:48:25,162 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4417-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4417-1) 2025-10-22 08:48:25,581 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4417-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4417-1) 2025-10-22 08:48:25,581 - INFO - Waiting for VM ctest-vn1-vm1-76567565 to be up.. 2025-10-22 08:48:25,625 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-10-22 08:48:30,702 - DEBUG - VM is in ACTIVE state now 2025-10-22 08:48:30,702 - INFO - VM name : ctest-vn1-vm1-76567565 2025-10-22 08:48:30,776 - DEBUG - VM ctest-vn1-vm1-76567565 ID is 5082a3ce-19f3-4373-af03-815ef071bf44 2025-10-22 08:48:30,797 - DEBUG - VM ctest-vn1-vm1-76567565 launched on Node cn-jenkins-deploy-platform-ansible-os-4417-1 2025-10-22 08:48:30,878 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine/5082a3ce-19f3-4373-af03-815ef071bf44 2025-10-22 08:48:30,886 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/db3baa99-61e6-4747-8a77-cd40cec04421 2025-10-22 08:48:34,131 - 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 1005ms') 2025-10-22 08:48:34,131 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-76567565 failed! 2025-10-22 08:48:34,186 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-55821026:ctest-vn1-66931212 is 82.14.233.193 and allocation pool is NOT set 2025-10-22 08:48:34,186 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-55821026:ctest-vn1-66931212 is 19.226.226.65 and allocation pool is NOT set 2025-10-22 08:48:38,257 - 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=6.75 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1010ms\r\nrtt min/avg/max/mdev = 6.754/6.754/6.754/0.000 ms') 2025-10-22 08:48:38,258 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-76567565 passed 2025-10-22 08:48:38,406 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-22 08:48:38,406 - DEBUG - Waiting to SSH to VM ctest-vn1-vm1-76567565, IP 82.14.233.197, Port 22 2025-10-22 08:48:38,577 - DEBUG - VM ctest-vn1-vm1-76567565 is ready for SSH connections 2025-10-22 08:48:38,577 - INFO - Waiting for VM ctest-vn1-vm2-46863896 to be up.. 2025-10-22 08:48:38,675 - DEBUG - VM is in ACTIVE state now 2025-10-22 08:48:38,676 - INFO - VM name : ctest-vn1-vm2-46863896 2025-10-22 08:48:38,761 - DEBUG - VM ctest-vn1-vm2-46863896 ID is 2f553011-bbb6-4083-9abe-115856056dcc 2025-10-22 08:48:38,762 - DEBUG - VM ctest-vn1-vm2-46863896 launched on Node cn-jenkins-deploy-platform-ansible-os-4417-1 2025-10-22 08:48:38,845 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine/2f553011-bbb6-4083-9abe-115856056dcc 2025-10-22 08:48:38,853 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/f9b4c162-13dc-43b8-a26b-b30e95581f99 2025-10-22 08:48:40,092 - 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.444 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.444/1.606/2.769/1.162 ms') 2025-10-22 08:48:40,092 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-vn1-vm2-46863896 passed 2025-10-22 08:48:40,238 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-22 08:48:40,238 - DEBUG - Waiting to SSH to VM ctest-vn1-vm2-46863896, IP 19.226.226.69, Port 22 2025-10-22 08:48:40,394 - DEBUG - VM ctest-vn1-vm2-46863896 is ready for SSH connections 2025-10-22 08:48:40,394 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-22 08:48:40,394 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-22 08:48:40,394 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-22 08:48:40,394 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 82.14.233.197, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.33, gateway password: c0ntrail123 2025-10-22 08:48:40,394 - DEBUG - ping -s 56 -c 3 -W 1 82.14.233.197 2025-10-22 08:48:43,073 - DEBUG - PING 82.14.233.197 (82.14.233.197): 56 data bytes 64 bytes from 82.14.233.197: seq=0 ttl=63 time=4.028 ms 64 bytes from 82.14.233.197: seq=1 ttl=63 time=0.850 ms 64 bytes from 82.14.233.197: seq=2 ttl=63 time=0.790 ms --- 82.14.233.197 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 0.790/1.889/4.028 ms 2025-10-22 08:48:43,074 - INFO - Ping to IP 82.14.233.197 from VM ctest-vn1-vm2-46863896 passed 2025-10-22 08:48:43,074 - INFO - Detaching port f9b4c162-13dc-43b8-a26b-b30e95581f99 from VM ctest-vn1-vm2-46863896 2025-10-22 08:48:43,129 - INFO - Deleting VM ctest-vn1-vm2-46863896 2025-10-22 08:48:43,192 - INFO - Detaching port db3baa99-61e6-4747-8a77-cd40cec04421 from VM ctest-vn1-vm1-76567565 2025-10-22 08:48:43,229 - INFO - Deleting VM ctest-vn1-vm1-76567565 2025-10-22 08:48:43,455 - DEBUG - Response for delete_port : () 2025-10-22 08:48:43,632 - DEBUG - Response for delete_port : () 2025-10-22 08:48:43,632 - INFO - Deleting VN ctest-vn1-66931212 2025-10-22 08:48:43,774 - DEBUG - Response for deleting network () 2025-10-22 08:48:44,036 - DEBUG - No XMPP flaps were noticed during the test
2025-10-22 08:48:44,036 - INFO - END TEST : test_ports_specific_subnet_ip : PASSED[0:00:21]
2025-10-22 08:48:44,036 - INFO - -------------------------------------------------------------------------------- 2025-10-22 08:48:44,716 - INFO - Deleted project: ctest-TestPorts-55821026, ID : c2e29733-9674-46c2-9a36-8303983b051c