2025-08-15 09:29:02,566 - INFO - Domain Default found not creating 2025-08-15 09:29:02,707 - INFO - Project ctest-TestPorts-44356391 not found, creating it 2025-08-15 09:29:03,165 - INFO - Created Project:ctest-TestPorts-44356391, ID : fcd56f29-7551-41b0-b694-3a35ced166cc 2025-08-15 09:29:04,645 - INFO - ================================================================================ 2025-08-15 09:29:04,645 - INFO - STARTING TEST : test_ports_bindings 2025-08-15 09:29:04,645 - 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-08-15 09:29:04,897 - DEBUG - Nothing to compare xmpp stats {'10.0.0.254': {'10.0.0.254': '0'}} with 2025-08-15 09:29:04,897 - INFO - Initial checks done. Running the testcase now 2025-08-15 09:29:04,897 - INFO - 2025-08-15 09:29:05,402 - DEBUG - Response for create_network : {'network': {'id': '5ac4b5fb-56b7-4e1e-ba94-e55e42ef79e9', 'name': 'ctest-vn-05433886', 'tenant_id': 'fcd56f29755141b0b6943a35ced166cc', 'project_id': 'fcd56f29755141b0b6943a35ced166cc', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-44356391', 'ctest-vn-05433886'], 'port_security_enabled': True, 'description': ''}} 2025-08-15 09:29:05,597 - DEBUG - Response for create_subnet : {'subnet': {'id': 'e4cf647e-6d94-4770-96fa-85e3d088c1ab', 'name': '', 'tenant_id': 'fcd56f29755141b0b6943a35ced166cc', 'network_id': '5ac4b5fb-56b7-4e1e-ba94-e55e42ef79e9', 'ip_version': 4, 'cidr': '116.45.102.128/26', 'allocation_pools': [{'start': '116.45.102.130', 'end': '116.45.102.190'}], 'gateway_ip': '116.45.102.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '116.45.102.130', 'tags': [], 'project_id': 'fcd56f29755141b0b6943a35ced166cc'}} 2025-08-15 09:29:05,611 - INFO - Created VN ctest-vn-05433886 2025-08-15 09:29:05,660 - DEBUG - VN ctest-vn-05433886 UUID is 5ac4b5fb-56b7-4e1e-ba94-e55e42ef79e9 2025-08-15 09:29:05,755 - DEBUG - Read virtual machine interface {'fq_name': ['default-domain', 'ctest-TestPorts-44356391', 'ctest-vmi-58027829']} 2025-08-15 09:29:06,018 - DEBUG - Response for create_port : {'port': {'name': 'ctest-vmi-58027829', 'id': '6615f349-0a0a-4f6c-a928-e353a77e320b', 'tenant_id': 'fcd56f29755141b0b6943a35ced166cc', 'network_id': '5ac4b5fb-56b7-4e1e-ba94-e55e42ef79e9', 'mac_address': '02:66:15:f3:49:0a', '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': '116.45.102.131', 'subnet_id': 'e4cf647e-6d94-4770-96fa-85e3d088c1ab'}], 'security_groups': ['456d3537-02eb-4945-873e-c2c821cd8236'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': 'fcd56f29755141b0b6943a35ced166cc'}} 2025-08-15 09:29:06,018 - DEBUG - Created port 6615f349-0a0a-4f6c-a928-e353a77e320b 2025-08-15 09:29:06,120 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine-interface/6615f349-0a0a-4f6c-a928-e353a77e320b 2025-08-15 09:29:06,414 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine-interface/6615f349-0a0a-4f6c-a928-e353a77e320b 2025-08-15 09:29:06,445 - INFO - VMI 6615f349-0a0a-4f6c-a928-e353a77e320b verification in API Server passed 2025-08-15 09:29:06,528 - DEBUG - Response for delete_port : () 2025-08-15 09:29:06,528 - INFO - Deleted port 6615f349-0a0a-4f6c-a928-e353a77e320b 2025-08-15 09:29:06,528 - INFO - Deleting VN ctest-vn-05433886 2025-08-15 09:29:06,614 - DEBUG - Response for deleting network () 2025-08-15 09:29:06,864 - DEBUG - No XMPP flaps were noticed during the test
2025-08-15 09:29:06,865 - INFO - END TEST : test_ports_bindings : PASSED[0:00:02]
2025-08-15 09:29:06,865 - INFO - -------------------------------------------------------------------------------- 2025-08-15 09:29:06,867 - INFO - ================================================================================ 2025-08-15 09:29:06,867 - INFO - STARTING TEST : test_ports_specific_subnet_ip 2025-08-15 09:29:06,867 - 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-08-15 09:29:07,148 - DEBUG - Nothing to compare xmpp stats {'10.0.0.254': {'10.0.0.254': '0'}} with 2025-08-15 09:29:07,148 - INFO - Initial checks done. Running the testcase now 2025-08-15 09:29:07,148 - INFO - 2025-08-15 09:29:07,305 - DEBUG - Response for create_network : {'network': {'id': '9e1a516d-f2b6-44da-a761-18ea3f0a8a2f', 'name': 'ctest-vn1-42703016', 'tenant_id': 'fcd56f29755141b0b6943a35ced166cc', 'project_id': 'fcd56f29755141b0b6943a35ced166cc', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-44356391', 'ctest-vn1-42703016'], 'port_security_enabled': True, 'description': ''}} 2025-08-15 09:29:07,490 - DEBUG - Response for create_subnet : {'subnet': {'id': 'aae3710d-2c2a-4437-8602-fc09262d21bb', 'name': '', 'tenant_id': 'fcd56f29755141b0b6943a35ced166cc', 'network_id': '9e1a516d-f2b6-44da-a761-18ea3f0a8a2f', 'ip_version': 4, 'cidr': '97.40.112.192/26', 'allocation_pools': [{'start': '97.40.112.194', 'end': '97.40.112.254'}], 'gateway_ip': '97.40.112.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '97.40.112.194', 'tags': [], 'project_id': 'fcd56f29755141b0b6943a35ced166cc'}} 2025-08-15 09:29:07,689 - DEBUG - Response for create_subnet : {'subnet': {'id': '31167394-7440-4c19-afd6-81284414408d', 'name': '', 'tenant_id': 'fcd56f29755141b0b6943a35ced166cc', 'network_id': '9e1a516d-f2b6-44da-a761-18ea3f0a8a2f', 'ip_version': 4, 'cidr': '203.225.133.0/26', 'allocation_pools': [{'start': '203.225.133.2', 'end': '203.225.133.62'}], 'gateway_ip': '203.225.133.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '203.225.133.2', 'tags': [], 'project_id': 'fcd56f29755141b0b6943a35ced166cc'}} 2025-08-15 09:29:07,710 - INFO - Created VN ctest-vn1-42703016 2025-08-15 09:29:07,764 - DEBUG - VN ctest-vn1-42703016 UUID is 9e1a516d-f2b6-44da-a761-18ea3f0a8a2f 2025-08-15 09:29:08,053 - DEBUG - Response for create_port : {'port': {'name': '6e5afedb-6289-4237-b5da-383716051b84', 'id': '6e5afedb-6289-4237-b5da-383716051b84', 'tenant_id': 'fcd56f29755141b0b6943a35ced166cc', 'network_id': '9e1a516d-f2b6-44da-a761-18ea3f0a8a2f', 'mac_address': '02:6e:5a:fe:db:62', '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.40.112.197', 'subnet_id': 'aae3710d-2c2a-4437-8602-fc09262d21bb'}], 'security_groups': ['456d3537-02eb-4945-873e-c2c821cd8236'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': 'fcd56f29755141b0b6943a35ced166cc'}} 2025-08-15 09:29:08,212 - DEBUG - Response for create_port : {'port': {'name': '470d7af3-7057-4010-982f-242d5952c515', 'id': '470d7af3-7057-4010-982f-242d5952c515', 'tenant_id': 'fcd56f29755141b0b6943a35ced166cc', 'network_id': '9e1a516d-f2b6-44da-a761-18ea3f0a8a2f', 'mac_address': '02:47:0d:7a:f3:70', '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': '203.225.133.5', 'subnet_id': '31167394-7440-4c19-afd6-81284414408d'}], 'security_groups': ['456d3537-02eb-4945-873e-c2c821cd8236'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': 'fcd56f29755141b0b6943a35ced166cc'}} 2025-08-15 09:29:08,258 - DEBUG - Services list from nova: [, , ] 2025-08-15 09:29:08,550 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-3862-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-3862-1) 2025-08-15 09:29:08,875 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-3862-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-3862-1) 2025-08-15 09:29:08,875 - INFO - Waiting for VM ctest-vn1-vm1-31376357 to be up.. 2025-08-15 09:29:08,909 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-08-15 09:29:13,992 - DEBUG - VM is in ACTIVE state now 2025-08-15 09:29:13,992 - INFO - VM name : ctest-vn1-vm1-31376357 2025-08-15 09:29:14,062 - DEBUG - VM ctest-vn1-vm1-31376357 ID is c4218e8e-231a-400c-8a98-c9b31e645f32 2025-08-15 09:29:14,078 - DEBUG - VM ctest-vn1-vm1-31376357 launched on Node cn-jenkins-deploy-platform-ansible-os-3862-1. 2025-08-15 09:29:14,147 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine/c4218e8e-231a-400c-8a98-c9b31e645f32 2025-08-15 09:29:14,166 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine-interface/6e5afedb-6289-4237-b5da-383716051b84 2025-08-15 09:29:17,416 - 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 1012ms') 2025-08-15 09:29:17,416 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-31376357 failed! 2025-08-15 09:29:17,468 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-44356391:ctest-vn1-42703016 is 97.40.112.193 and allocation pool is NOT set 2025-08-15 09:29:17,468 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-44356391:ctest-vn1-42703016 is 203.225.133.1 and allocation pool is NOT set 2025-08-15 09:29:19,525 - 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=2.44 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.72 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.717/2.079/2.442/0.362 ms') 2025-08-15 09:29:19,525 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-31376357 passed 2025-08-15 09:29:19,676 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-15 09:29:19,676 - DEBUG - Waiting to SSH to VM ctest-vn1-vm1-31376357, IP 97.40.112.197, Port 22 2025-08-15 09:29:19,732 - DEBUG - Error on ssh to cirros@169.254.0.3:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2025-08-15 09:29:19,796 - DEBUG - VM ctest-vn1-vm1-31376357 is NOT ready for SSH connections, VM status: ACTIVE 2025-08-15 09:29:24,797 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-15 09:29:24,797 - DEBUG - Waiting to SSH to VM ctest-vn1-vm1-31376357, IP 97.40.112.197, Port 22 2025-08-15 09:29:24,955 - DEBUG - VM ctest-vn1-vm1-31376357 is ready for SSH connections 2025-08-15 09:29:24,956 - INFO - Waiting for VM ctest-vn1-vm2-03169871 to be up.. 2025-08-15 09:29:25,021 - DEBUG - VM is in ACTIVE state now 2025-08-15 09:29:25,021 - INFO - VM name : ctest-vn1-vm2-03169871 2025-08-15 09:29:25,085 - DEBUG - VM ctest-vn1-vm2-03169871 ID is 387c1bdf-5a7d-4735-a37c-ca4d13db153b 2025-08-15 09:29:25,086 - DEBUG - VM ctest-vn1-vm2-03169871 launched on Node cn-jenkins-deploy-platform-ansible-os-3862-1. 2025-08-15 09:29:25,149 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine/387c1bdf-5a7d-4735-a37c-ca4d13db153b 2025-08-15 09:29:25,156 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine-interface/470d7af3-7057-4010-982f-242d5952c515 2025-08-15 09:29:26,390 - 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.67 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.348 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.348/2.008/3.668/1.660 ms') 2025-08-15 09:29:26,390 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-vn1-vm2-03169871 passed 2025-08-15 09:29:26,540 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-15 09:29:26,540 - DEBUG - Waiting to SSH to VM ctest-vn1-vm2-03169871, IP 203.225.133.5, Port 22 2025-08-15 09:29:26,691 - DEBUG - VM ctest-vn1-vm2-03169871 is ready for SSH connections 2025-08-15 09:29:26,691 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-15 09:29:26,691 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-15 09:29:26,691 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-08-15 09:29:26,692 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 97.40.112.197, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.254, gateway password: c0ntrail123 2025-08-15 09:29:26,692 - DEBUG - ping -s 56 -c 3 -W 1 97.40.112.197 2025-08-15 09:29:29,631 - DEBUG - PING 97.40.112.197 (97.40.112.197): 56 data bytes 64 bytes from 97.40.112.197: seq=0 ttl=63 time=3.265 ms 64 bytes from 97.40.112.197: seq=1 ttl=63 time=0.818 ms 64 bytes from 97.40.112.197: seq=2 ttl=63 time=0.965 ms --- 97.40.112.197 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 0.818/1.682/3.265 ms 2025-08-15 09:29:29,631 - INFO - Ping to IP 97.40.112.197 from VM ctest-vn1-vm2-03169871 passed 2025-08-15 09:29:29,631 - INFO - Detaching port 470d7af3-7057-4010-982f-242d5952c515 from VM ctest-vn1-vm2-03169871 2025-08-15 09:29:29,674 - INFO - Deleting VM ctest-vn1-vm2-03169871 2025-08-15 09:29:29,736 - INFO - Detaching port 6e5afedb-6289-4237-b5da-383716051b84 from VM ctest-vn1-vm1-31376357 2025-08-15 09:29:29,770 - INFO - Deleting VM ctest-vn1-vm1-31376357 2025-08-15 09:29:29,982 - DEBUG - Response for delete_port : () 2025-08-15 09:29:30,133 - DEBUG - Response for delete_port : () 2025-08-15 09:29:30,134 - INFO - Deleting VN ctest-vn1-42703016 2025-08-15 09:29:30,278 - DEBUG - Response for deleting network () 2025-08-15 09:29:30,541 - DEBUG - No XMPP flaps were noticed during the test
2025-08-15 09:29:30,541 - INFO - END TEST : test_ports_specific_subnet_ip : PASSED[0:00:24]
2025-08-15 09:29:30,541 - INFO - -------------------------------------------------------------------------------- 2025-08-15 09:29:31,252 - INFO - Deleted project: ctest-TestPorts-44356391, ID : fcd56f29-7551-41b0-b694-3a35ced166cc