2025-10-22 15:09:43,723 - INFO - Domain Default found not creating 2025-10-22 15:09:44,025 - INFO - Project ctest-TestPorts-06736212 not found, creating it 2025-10-22 15:09:44,683 - INFO - Created Project:ctest-TestPorts-06736212, ID : 34e89934-77a2-49e8-9439-f2e142e8293e 2025-10-22 15:09:46,822 - INFO - ================================================================================ 2025-10-22 15:09:46,822 - INFO - STARTING TEST : test_ports_bindings 2025-10-22 15:09:46,822 - 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 15:09:47,144 - DEBUG - Nothing to compare xmpp stats {'10.0.0.141': {'10.20.0.17': '0'}} with 2025-10-22 15:09:47,144 - INFO - Initial checks done. Running the testcase now 2025-10-22 15:09:47,144 - INFO - 2025-10-22 15:09:47,887 - DEBUG - Response for create_network : {'network': {'id': '3e1f5853-17e6-498e-9de6-0323f80d965f', 'name': 'ctest-vn-53202602', 'tenant_id': '34e8993477a249e89439f2e142e8293e', 'project_id': '34e8993477a249e89439f2e142e8293e', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-06736212', 'ctest-vn-53202602'], 'port_security_enabled': True, 'description': ''}} 2025-10-22 15:09:48,097 - DEBUG - Response for create_subnet : {'subnet': {'id': '3d768ce8-74c2-41c7-9a43-c6ca22ff6c12', 'name': '', 'tenant_id': '34e8993477a249e89439f2e142e8293e', 'network_id': '3e1f5853-17e6-498e-9de6-0323f80d965f', 'ip_version': 4, 'cidr': '170.106.251.64/26', 'allocation_pools': [{'start': '170.106.251.66', 'end': '170.106.251.126'}], 'gateway_ip': '170.106.251.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '170.106.251.66', 'tags': [], 'project_id': '34e8993477a249e89439f2e142e8293e'}} 2025-10-22 15:09:48,115 - INFO - Created VN ctest-vn-53202602 2025-10-22 15:09:48,169 - DEBUG - VN ctest-vn-53202602 UUID is 3e1f5853-17e6-498e-9de6-0323f80d965f 2025-10-22 15:09:48,319 - DEBUG - Read virtual machine interface {'fq_name': ['default-domain', 'ctest-TestPorts-06736212', 'ctest-vmi-63913613']} 2025-10-22 15:09:48,616 - DEBUG - Response for create_port : {'port': {'name': 'ctest-vmi-63913613', 'id': '4ad465cc-5e18-49d8-b4ec-ef3c521c9e7c', 'tenant_id': '34e8993477a249e89439f2e142e8293e', 'network_id': '3e1f5853-17e6-498e-9de6-0323f80d965f', 'mac_address': '02:4a:d4:65:cc:5e', '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': '170.106.251.67', 'subnet_id': '3d768ce8-74c2-41c7-9a43-c6ca22ff6c12'}], 'security_groups': ['33efb742-aea4-440b-923e-c9b2f1c86d5c'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '34e8993477a249e89439f2e142e8293e'}} 2025-10-22 15:09:48,617 - DEBUG - Created port 4ad465cc-5e18-49d8-b4ec-ef3c521c9e7c 2025-10-22 15:09:48,725 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine-interface/4ad465cc-5e18-49d8-b4ec-ef3c521c9e7c 2025-10-22 15:09:49,070 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine-interface/4ad465cc-5e18-49d8-b4ec-ef3c521c9e7c 2025-10-22 15:09:49,118 - INFO - VMI 4ad465cc-5e18-49d8-b4ec-ef3c521c9e7c verification in API Server passed 2025-10-22 15:09:49,244 - DEBUG - Response for delete_port : () 2025-10-22 15:09:49,244 - INFO - Deleted port 4ad465cc-5e18-49d8-b4ec-ef3c521c9e7c 2025-10-22 15:09:49,244 - INFO - Deleting VN ctest-vn-53202602 2025-10-22 15:09:49,382 - DEBUG - Response for deleting network () 2025-10-22 15:09:49,678 - DEBUG - No XMPP flaps were noticed during the test
2025-10-22 15:09:49,678 - INFO - END TEST : test_ports_bindings : PASSED[0:00:03]
2025-10-22 15:09:49,679 - INFO - -------------------------------------------------------------------------------- 2025-10-22 15:09:49,682 - INFO - ================================================================================ 2025-10-22 15:09:49,682 - INFO - STARTING TEST : test_ports_specific_subnet_ip 2025-10-22 15:09:49,682 - 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 15:09:49,989 - DEBUG - Nothing to compare xmpp stats {'10.0.0.141': {'10.20.0.17': '0'}} with 2025-10-22 15:09:49,989 - INFO - Initial checks done. Running the testcase now 2025-10-22 15:09:49,989 - INFO - 2025-10-22 15:09:50,221 - DEBUG - Response for create_network : {'network': {'id': '4ca8f625-e657-4786-bdb6-a8dd4904574d', 'name': 'ctest-vn1-33290774', 'tenant_id': '34e8993477a249e89439f2e142e8293e', 'project_id': '34e8993477a249e89439f2e142e8293e', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-06736212', 'ctest-vn1-33290774'], 'port_security_enabled': True, 'description': ''}} 2025-10-22 15:09:50,373 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ab57b2e3-9e68-46f9-ae5f-ed7e610ca6e1', 'name': '', 'tenant_id': '34e8993477a249e89439f2e142e8293e', 'network_id': '4ca8f625-e657-4786-bdb6-a8dd4904574d', 'ip_version': 4, 'cidr': '206.124.137.128/26', 'allocation_pools': [{'start': '206.124.137.130', 'end': '206.124.137.190'}], 'gateway_ip': '206.124.137.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '206.124.137.130', 'tags': [], 'project_id': '34e8993477a249e89439f2e142e8293e'}} 2025-10-22 15:09:50,617 - DEBUG - Response for create_subnet : {'subnet': {'id': '7b594dd9-aaea-4855-8a65-26438522b1aa', 'name': '', 'tenant_id': '34e8993477a249e89439f2e142e8293e', 'network_id': '4ca8f625-e657-4786-bdb6-a8dd4904574d', 'ip_version': 4, 'cidr': '212.214.241.0/26', 'allocation_pools': [{'start': '212.214.241.2', 'end': '212.214.241.62'}], 'gateway_ip': '212.214.241.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '212.214.241.2', 'tags': [], 'project_id': '34e8993477a249e89439f2e142e8293e'}} 2025-10-22 15:09:50,666 - INFO - Created VN ctest-vn1-33290774 2025-10-22 15:09:50,730 - DEBUG - VN ctest-vn1-33290774 UUID is 4ca8f625-e657-4786-bdb6-a8dd4904574d 2025-10-22 15:09:51,178 - DEBUG - Response for create_port : {'port': {'name': '2669a3fd-2fb8-4b2b-a379-48c8b8f08b97', 'id': '2669a3fd-2fb8-4b2b-a379-48c8b8f08b97', 'tenant_id': '34e8993477a249e89439f2e142e8293e', 'network_id': '4ca8f625-e657-4786-bdb6-a8dd4904574d', 'mac_address': '02:26:69:a3:fd:2f', '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': '206.124.137.133', 'subnet_id': 'ab57b2e3-9e68-46f9-ae5f-ed7e610ca6e1'}], 'security_groups': ['33efb742-aea4-440b-923e-c9b2f1c86d5c'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '34e8993477a249e89439f2e142e8293e'}} 2025-10-22 15:09:51,377 - DEBUG - Response for create_port : {'port': {'name': 'edcb1a30-3418-455b-a56e-70cf72e4566c', 'id': 'edcb1a30-3418-455b-a56e-70cf72e4566c', 'tenant_id': '34e8993477a249e89439f2e142e8293e', 'network_id': '4ca8f625-e657-4786-bdb6-a8dd4904574d', 'mac_address': '02:ed:cb:1a:30:34', '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': '212.214.241.5', 'subnet_id': '7b594dd9-aaea-4855-8a65-26438522b1aa'}], 'security_groups': ['33efb742-aea4-440b-923e-c9b2f1c86d5c'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '34e8993477a249e89439f2e142e8293e'}} 2025-10-22 15:09:51,440 - DEBUG - Services list from nova: [, , ] 2025-10-22 15:09:52,101 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4433-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4433-1) 2025-10-22 15:09:52,877 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4433-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4433-1) 2025-10-22 15:09:52,877 - INFO - Waiting for VM ctest-vn1-vm1-42883484 to be up.. 2025-10-22 15:09:52,949 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-10-22 15:09:58,101 - DEBUG - VM is in ACTIVE state now 2025-10-22 15:09:58,101 - INFO - VM name : ctest-vn1-vm1-42883484 2025-10-22 15:09:58,200 - DEBUG - VM ctest-vn1-vm1-42883484 ID is 89ec3235-1a97-4f84-84d6-97a1a2153d87 2025-10-22 15:09:58,236 - DEBUG - VM ctest-vn1-vm1-42883484 launched on Node cn-jenkins-deploy-platform-ansible-os-4433-1 2025-10-22 15:09:58,339 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine/89ec3235-1a97-4f84-84d6-97a1a2153d87 2025-10-22 15:09:58,349 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine-interface/2669a3fd-2fb8-4b2b-a379-48c8b8f08b97 2025-10-22 15:10:01,611 - 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 15:10:01,611 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-42883484 failed! 2025-10-22 15:10:01,673 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-06736212:ctest-vn1-33290774 is 206.124.137.129 and allocation pool is NOT set 2025-10-22 15:10:01,673 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-06736212:ctest-vn1-33290774 is 212.214.241.1 and allocation pool is NOT set 2025-10-22 15:10:05,765 - 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-10-22 15:10:05,765 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-42883484 failed! 2025-10-22 15:10:05,829 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-06736212:ctest-vn1-33290774 is 206.124.137.129 and allocation pool is NOT set 2025-10-22 15:10:05,829 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-06736212:ctest-vn1-33290774 is 212.214.241.1 and allocation pool is NOT set 2025-10-22 15:10:07,904 - 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=5.66 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.84 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 = 1.836/3.747/5.659/1.911 ms') 2025-10-22 15:10:07,904 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-42883484 passed 2025-10-22 15:10:08,078 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-22 15:10:08,078 - DEBUG - Waiting to SSH to VM ctest-vn1-vm1-42883484, IP 206.124.137.133, Port 22 2025-10-22 15:10:08,170 - 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-22 15:10:08,346 - DEBUG - VM ctest-vn1-vm1-42883484 is NOT ready for SSH connections, VM status: ACTIVE 2025-10-22 15:10:13,347 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-22 15:10:13,347 - DEBUG - Waiting to SSH to VM ctest-vn1-vm1-42883484, IP 206.124.137.133, Port 22 2025-10-22 15:10:13,540 - DEBUG - VM ctest-vn1-vm1-42883484 is ready for SSH connections 2025-10-22 15:10:13,541 - INFO - Waiting for VM ctest-vn1-vm2-53660759 to be up.. 2025-10-22 15:10:13,675 - DEBUG - VM is in ACTIVE state now 2025-10-22 15:10:13,675 - INFO - VM name : ctest-vn1-vm2-53660759 2025-10-22 15:10:13,767 - DEBUG - VM ctest-vn1-vm2-53660759 ID is fe081f73-fc50-46e2-aaa3-0e208177f27d 2025-10-22 15:10:13,768 - DEBUG - VM ctest-vn1-vm2-53660759 launched on Node cn-jenkins-deploy-platform-ansible-os-4433-1 2025-10-22 15:10:13,867 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine/fe081f73-fc50-46e2-aaa3-0e208177f27d 2025-10-22 15:10:13,879 - DEBUG - Requesting: http://10.0.0.141:8082/virtual-machine-interface/edcb1a30-3418-455b-a56e-70cf72e4566c 2025-10-22 15:10:15,153 - 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=4.24 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.671 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.671/2.456/4.242/1.785 ms') 2025-10-22 15:10:15,153 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-vn1-vm2-53660759 passed 2025-10-22 15:10:15,314 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-22 15:10:15,314 - DEBUG - Waiting to SSH to VM ctest-vn1-vm2-53660759, IP 212.214.241.5, Port 22 2025-10-22 15:10:15,497 - DEBUG - VM ctest-vn1-vm2-53660759 is ready for SSH connections 2025-10-22 15:10:15,497 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-22 15:10:15,497 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-22 15:10:15,497 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-22 15:10:15,497 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 206.124.137.133, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.141, gateway password: c0ntrail123 2025-10-22 15:10:15,497 - DEBUG - ping -s 56 -c 3 -W 1 206.124.137.133 2025-10-22 15:10:18,626 - DEBUG - PING 206.124.137.133 (206.124.137.133): 56 data bytes 64 bytes from 206.124.137.133: seq=0 ttl=63 time=8.398 ms 64 bytes from 206.124.137.133: seq=1 ttl=63 time=1.517 ms 64 bytes from 206.124.137.133: seq=2 ttl=63 time=1.057 ms --- 206.124.137.133 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.057/3.657/8.398 ms 2025-10-22 15:10:18,626 - INFO - Ping to IP 206.124.137.133 from VM ctest-vn1-vm2-53660759 passed 2025-10-22 15:10:18,626 - INFO - Detaching port edcb1a30-3418-455b-a56e-70cf72e4566c from VM ctest-vn1-vm2-53660759 2025-10-22 15:10:18,700 - INFO - Deleting VM ctest-vn1-vm2-53660759 2025-10-22 15:10:18,813 - INFO - Detaching port 2669a3fd-2fb8-4b2b-a379-48c8b8f08b97 from VM ctest-vn1-vm1-42883484 2025-10-22 15:10:18,864 - INFO - Deleting VM ctest-vn1-vm1-42883484 2025-10-22 15:10:19,174 - DEBUG - Response for delete_port : () 2025-10-22 15:10:19,367 - DEBUG - Response for delete_port : () 2025-10-22 15:10:19,367 - INFO - Deleting VN ctest-vn1-33290774 2025-10-22 15:10:19,545 - DEBUG - Response for deleting network () 2025-10-22 15:10:19,803 - DEBUG - No XMPP flaps were noticed during the test
2025-10-22 15:10:19,804 - INFO - END TEST : test_ports_specific_subnet_ip : PASSED[0:00:30]
2025-10-22 15:10:19,804 - INFO - -------------------------------------------------------------------------------- 2025-10-22 15:10:20,550 - INFO - Deleted project: ctest-TestPorts-06736212, ID : 34e89934-77a2-49e8-9439-f2e142e8293e