2025-10-09 18:01:26,968 - INFO - Domain Default found not creating 2025-10-09 18:01:27,107 - INFO - Project ctest-TestPorts-96294157 not found, creating it 2025-10-09 18:01:27,535 - INFO - Created Project:ctest-TestPorts-96294157, ID : 06741cb1-14d5-4fc8-a9f5-80afc27b74e5 2025-10-09 18:01:28,895 - INFO - ================================================================================ 2025-10-09 18:01:28,895 - INFO - STARTING TEST : test_ports_bindings 2025-10-09 18:01:28,895 - 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-09 18:01:29,147 - DEBUG - Nothing to compare xmpp stats {'10.0.0.33': {'10.20.0.254': '0'}} with 2025-10-09 18:01:29,147 - INFO - Initial checks done. Running the testcase now 2025-10-09 18:01:29,147 - INFO - 2025-10-09 18:01:29,687 - DEBUG - Response for create_network : {'network': {'id': '8440bc39-7cc0-4a50-afd0-c8304a9f772b', 'name': 'ctest-vn-79619577', 'tenant_id': '06741cb114d54fc8a9f580afc27b74e5', 'project_id': '06741cb114d54fc8a9f580afc27b74e5', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-96294157', 'ctest-vn-79619577'], 'port_security_enabled': True, 'description': ''}} 2025-10-09 18:01:29,921 - DEBUG - Response for create_subnet : {'subnet': {'id': '4ece0a86-fa34-45a9-9d12-e5654e107b4a', 'name': '', 'tenant_id': '06741cb114d54fc8a9f580afc27b74e5', 'network_id': '8440bc39-7cc0-4a50-afd0-c8304a9f772b', 'ip_version': 4, 'cidr': '20.159.110.0/26', 'allocation_pools': [{'start': '20.159.110.2', 'end': '20.159.110.62'}], 'gateway_ip': '20.159.110.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '20.159.110.2', 'tags': [], 'project_id': '06741cb114d54fc8a9f580afc27b74e5'}} 2025-10-09 18:01:29,937 - INFO - Created VN ctest-vn-79619577 2025-10-09 18:01:29,990 - DEBUG - VN ctest-vn-79619577 UUID is 8440bc39-7cc0-4a50-afd0-c8304a9f772b 2025-10-09 18:01:30,095 - DEBUG - Read virtual machine interface {'fq_name': ['default-domain', 'ctest-TestPorts-96294157', 'ctest-vmi-60160464']} 2025-10-09 18:01:30,389 - DEBUG - Response for create_port : {'port': {'name': 'ctest-vmi-60160464', 'id': '2b1cdea4-48d6-4995-a193-6503e2e1959d', 'tenant_id': '06741cb114d54fc8a9f580afc27b74e5', 'network_id': '8440bc39-7cc0-4a50-afd0-c8304a9f772b', 'mac_address': '02:2b:1c:de:a4:48', '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': '20.159.110.3', 'subnet_id': '4ece0a86-fa34-45a9-9d12-e5654e107b4a'}], 'security_groups': ['f26e801e-f136-4c2b-b5f6-fd3e9be3c3e9'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '06741cb114d54fc8a9f580afc27b74e5'}} 2025-10-09 18:01:30,389 - DEBUG - Created port 2b1cdea4-48d6-4995-a193-6503e2e1959d 2025-10-09 18:01:30,494 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/2b1cdea4-48d6-4995-a193-6503e2e1959d 2025-10-09 18:01:30,782 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/2b1cdea4-48d6-4995-a193-6503e2e1959d 2025-10-09 18:01:30,813 - INFO - VMI 2b1cdea4-48d6-4995-a193-6503e2e1959d verification in API Server passed 2025-10-09 18:01:30,895 - DEBUG - Response for delete_port : () 2025-10-09 18:01:30,896 - INFO - Deleted port 2b1cdea4-48d6-4995-a193-6503e2e1959d 2025-10-09 18:01:30,896 - INFO - Deleting VN ctest-vn-79619577 2025-10-09 18:01:31,007 - DEBUG - Response for deleting network () 2025-10-09 18:01:31,271 - DEBUG - No XMPP flaps were noticed during the test
2025-10-09 18:01:31,271 - INFO - END TEST : test_ports_bindings : PASSED[0:00:03]
2025-10-09 18:01:31,271 - INFO - -------------------------------------------------------------------------------- 2025-10-09 18:01:31,274 - INFO - ================================================================================ 2025-10-09 18:01:31,274 - INFO - STARTING TEST : test_ports_specific_subnet_ip 2025-10-09 18:01:31,274 - 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-09 18:01:31,558 - DEBUG - Nothing to compare xmpp stats {'10.0.0.33': {'10.20.0.254': '0'}} with 2025-10-09 18:01:31,558 - INFO - Initial checks done. Running the testcase now 2025-10-09 18:01:31,558 - INFO - 2025-10-09 18:01:31,731 - DEBUG - Response for create_network : {'network': {'id': '04144c19-8e15-461e-8b61-07f1a850dfea', 'name': 'ctest-vn1-92402384', 'tenant_id': '06741cb114d54fc8a9f580afc27b74e5', 'project_id': '06741cb114d54fc8a9f580afc27b74e5', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-96294157', 'ctest-vn1-92402384'], 'port_security_enabled': True, 'description': ''}} 2025-10-09 18:01:31,938 - DEBUG - Response for create_subnet : {'subnet': {'id': 'b01748bf-998d-4442-9bcb-e6bdcb42c96b', 'name': '', 'tenant_id': '06741cb114d54fc8a9f580afc27b74e5', 'network_id': '04144c19-8e15-461e-8b61-07f1a850dfea', 'ip_version': 4, 'cidr': '165.12.23.128/26', 'allocation_pools': [{'start': '165.12.23.130', 'end': '165.12.23.190'}], 'gateway_ip': '165.12.23.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '165.12.23.130', 'tags': [], 'project_id': '06741cb114d54fc8a9f580afc27b74e5'}} 2025-10-09 18:01:32,121 - DEBUG - Response for create_subnet : {'subnet': {'id': 'f7fceac5-edac-444a-a15a-82ea044b8f07', 'name': '', 'tenant_id': '06741cb114d54fc8a9f580afc27b74e5', 'network_id': '04144c19-8e15-461e-8b61-07f1a850dfea', 'ip_version': 4, 'cidr': '150.252.226.192/26', 'allocation_pools': [{'start': '150.252.226.194', 'end': '150.252.226.254'}], 'gateway_ip': '150.252.226.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '150.252.226.194', 'tags': [], 'project_id': '06741cb114d54fc8a9f580afc27b74e5'}} 2025-10-09 18:01:32,139 - INFO - Created VN ctest-vn1-92402384 2025-10-09 18:01:32,190 - DEBUG - VN ctest-vn1-92402384 UUID is 04144c19-8e15-461e-8b61-07f1a850dfea 2025-10-09 18:01:32,479 - DEBUG - Response for create_port : {'port': {'name': 'b3f58330-be22-4a5b-89df-df030573c2f7', 'id': 'b3f58330-be22-4a5b-89df-df030573c2f7', 'tenant_id': '06741cb114d54fc8a9f580afc27b74e5', 'network_id': '04144c19-8e15-461e-8b61-07f1a850dfea', 'mac_address': '02:b3:f5:83:30:be', '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': '165.12.23.133', 'subnet_id': 'b01748bf-998d-4442-9bcb-e6bdcb42c96b'}], 'security_groups': ['f26e801e-f136-4c2b-b5f6-fd3e9be3c3e9'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '06741cb114d54fc8a9f580afc27b74e5'}} 2025-10-09 18:01:32,647 - DEBUG - Response for create_port : {'port': {'name': 'a2d7d979-4dd0-47c4-8ffc-ac3bb3a57d63', 'id': 'a2d7d979-4dd0-47c4-8ffc-ac3bb3a57d63', 'tenant_id': '06741cb114d54fc8a9f580afc27b74e5', 'network_id': '04144c19-8e15-461e-8b61-07f1a850dfea', 'mac_address': '02:a2:d7:d9:79:4d', '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': '150.252.226.197', 'subnet_id': 'f7fceac5-edac-444a-a15a-82ea044b8f07'}], 'security_groups': ['f26e801e-f136-4c2b-b5f6-fd3e9be3c3e9'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '06741cb114d54fc8a9f580afc27b74e5'}} 2025-10-09 18:01:32,697 - DEBUG - Services list from nova: [, , ] 2025-10-09 18:01:33,013 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4272-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4272-1) 2025-10-09 18:01:33,404 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4272-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4272-1) 2025-10-09 18:01:33,405 - INFO - Waiting for VM ctest-vn1-vm1-32933048 to be up.. 2025-10-09 18:01:33,444 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-10-09 18:01:38,511 - DEBUG - VM is in ACTIVE state now 2025-10-09 18:01:38,512 - INFO - VM name : ctest-vn1-vm1-32933048 2025-10-09 18:01:38,586 - DEBUG - VM ctest-vn1-vm1-32933048 ID is 32608671-5a67-4173-8eb0-1410e3dc6342 2025-10-09 18:01:38,605 - DEBUG - VM ctest-vn1-vm1-32933048 launched on Node cn-jenkins-deploy-platform-ansible-os-4272-1 2025-10-09 18:01:38,685 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine/32608671-5a67-4173-8eb0-1410e3dc6342 2025-10-09 18:01:38,693 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/b3f58330-be22-4a5b-89df-df030573c2f7 2025-10-09 18:01:41,957 - 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 1029ms') 2025-10-09 18:01:41,957 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-32933048 failed! 2025-10-09 18:01:42,010 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-96294157:ctest-vn1-92402384 is 165.12.23.129 and allocation pool is NOT set 2025-10-09 18:01:42,010 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-96294157:ctest-vn1-92402384 is 150.252.226.193 and allocation pool is NOT set 2025-10-09 18:01:44,072 - 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.13 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.78 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.783/2.458/3.134/0.675 ms') 2025-10-09 18:01:44,072 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-32933048 passed 2025-10-09 18:01:44,226 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-09 18:01:44,226 - DEBUG - Waiting to SSH to VM ctest-vn1-vm1-32933048, IP 165.12.23.133, Port 22 2025-10-09 18:01:44,291 - 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-10-09 18:01:44,364 - DEBUG - VM ctest-vn1-vm1-32933048 is NOT ready for SSH connections, VM status: ACTIVE 2025-10-09 18:01:49,365 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-09 18:01:49,365 - DEBUG - Waiting to SSH to VM ctest-vn1-vm1-32933048, IP 165.12.23.133, Port 22 2025-10-09 18:01:49,522 - DEBUG - VM ctest-vn1-vm1-32933048 is ready for SSH connections 2025-10-09 18:01:49,522 - INFO - Waiting for VM ctest-vn1-vm2-80921665 to be up.. 2025-10-09 18:01:49,589 - DEBUG - VM is in ACTIVE state now 2025-10-09 18:01:49,589 - INFO - VM name : ctest-vn1-vm2-80921665 2025-10-09 18:01:49,778 - DEBUG - VM ctest-vn1-vm2-80921665 ID is 66b087dc-ce0e-479b-8671-9d1e34e35eb5 2025-10-09 18:01:49,778 - DEBUG - VM ctest-vn1-vm2-80921665 launched on Node cn-jenkins-deploy-platform-ansible-os-4272-1 2025-10-09 18:01:49,845 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine/66b087dc-ce0e-479b-8671-9d1e34e35eb5 2025-10-09 18:01:49,853 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/a2d7d979-4dd0-47c4-8ffc-ac3bb3a57d63 2025-10-09 18:01:51,087 - 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.81 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.458 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.458/1.634/2.811/1.176 ms') 2025-10-09 18:01:51,087 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-vn1-vm2-80921665 passed 2025-10-09 18:01:51,234 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-09 18:01:51,234 - DEBUG - Waiting to SSH to VM ctest-vn1-vm2-80921665, IP 150.252.226.197, Port 22 2025-10-09 18:01:51,389 - DEBUG - VM ctest-vn1-vm2-80921665 is ready for SSH connections 2025-10-09 18:01:51,389 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-09 18:01:51,389 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-09 18:01:51,389 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-09 18:01:51,389 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 165.12.23.133, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.33, gateway password: c0ntrail123 2025-10-09 18:01:51,390 - DEBUG - ping -s 56 -c 3 -W 1 165.12.23.133 2025-10-09 18:01:54,385 - DEBUG - PING 165.12.23.133 (165.12.23.133): 56 data bytes 64 bytes from 165.12.23.133: seq=0 ttl=63 time=3.404 ms 64 bytes from 165.12.23.133: seq=1 ttl=63 time=1.018 ms 64 bytes from 165.12.23.133: seq=2 ttl=63 time=0.727 ms --- 165.12.23.133 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 0.727/1.716/3.404 ms 2025-10-09 18:01:54,385 - INFO - Ping to IP 165.12.23.133 from VM ctest-vn1-vm2-80921665 passed 2025-10-09 18:01:54,385 - INFO - Detaching port a2d7d979-4dd0-47c4-8ffc-ac3bb3a57d63 from VM ctest-vn1-vm2-80921665 2025-10-09 18:01:54,432 - INFO - Deleting VM ctest-vn1-vm2-80921665 2025-10-09 18:01:54,502 - INFO - Detaching port b3f58330-be22-4a5b-89df-df030573c2f7 from VM ctest-vn1-vm1-32933048 2025-10-09 18:01:54,537 - INFO - Deleting VM ctest-vn1-vm1-32933048 2025-10-09 18:01:54,778 - DEBUG - Response for delete_port : () 2025-10-09 18:01:54,940 - DEBUG - Response for delete_port : () 2025-10-09 18:01:54,940 - INFO - Deleting VN ctest-vn1-92402384 2025-10-09 18:01:55,075 - DEBUG - Response for deleting network () 2025-10-09 18:01:55,331 - DEBUG - No XMPP flaps were noticed during the test
2025-10-09 18:01:55,331 - INFO - END TEST : test_ports_specific_subnet_ip : PASSED[0:00:24]
2025-10-09 18:01:55,331 - INFO - -------------------------------------------------------------------------------- 2025-10-09 18:01:56,011 - INFO - Deleted project: ctest-TestPorts-96294157, ID : 06741cb1-14d5-4fc8-a9f5-80afc27b74e5