2025-08-07 14:21:58,927 - INFO - Domain Default found not creating
2025-08-07 14:21:59,075 - INFO - Project ctest-TestPorts-58804159 not found, creating it
2025-08-07 14:21:59,536 - INFO - Created Project:ctest-TestPorts-58804159, ID : 936eeb6d-e2c2-4761-81a1-0e7cd6a32fbd
2025-08-07 14:22:00,993 - INFO - ================================================================================
2025-08-07 14:22:00,993 - INFO - STARTING TEST : test_ports_bindings
2025-08-07 14:22:00,993 - 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-07 14:22:01,252 - DEBUG - Nothing to compare xmpp stats {'10.0.0.254': {'10.20.0.254': '0'}} with
2025-08-07 14:22:01,252 - INFO - Initial checks done. Running the testcase now
2025-08-07 14:22:01,252 - INFO -
2025-08-07 14:22:01,804 - DEBUG - Response for create_network : {'network': {'id': '4e3d4782-2f2f-402a-8778-66692e550766', 'name': 'ctest-vn-88124030', 'tenant_id': '936eeb6de2c2476181a10e7cd6a32fbd', 'project_id': '936eeb6de2c2476181a10e7cd6a32fbd', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-58804159', 'ctest-vn-88124030'], 'port_security_enabled': True, 'description': ''}}
2025-08-07 14:22:02,014 - DEBUG - Response for create_subnet : {'subnet': {'id': '36d1b81d-1179-4322-bce2-34127c064941', 'name': '', 'tenant_id': '936eeb6de2c2476181a10e7cd6a32fbd', 'network_id': '4e3d4782-2f2f-402a-8778-66692e550766', 'ip_version': 4, 'cidr': '216.171.45.0/26', 'allocation_pools': [{'start': '216.171.45.2', 'end': '216.171.45.62'}], 'gateway_ip': '216.171.45.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '216.171.45.2', 'tags': [], 'project_id': '936eeb6de2c2476181a10e7cd6a32fbd'}}
2025-08-07 14:22:02,033 - INFO - Created VN ctest-vn-88124030
2025-08-07 14:22:02,086 - DEBUG - VN ctest-vn-88124030 UUID is 4e3d4782-2f2f-402a-8778-66692e550766
2025-08-07 14:22:02,202 - DEBUG - Read virtual machine interface {'fq_name': ['default-domain', 'ctest-TestPorts-58804159', 'ctest-vmi-12885222']}
2025-08-07 14:22:02,464 - DEBUG - Response for create_port : {'port': {'name': 'ctest-vmi-12885222', 'id': 'c12e4711-829c-4e2d-bf1a-5d4d905ba507', 'tenant_id': '936eeb6de2c2476181a10e7cd6a32fbd', 'network_id': '4e3d4782-2f2f-402a-8778-66692e550766', 'mac_address': '02:c1:2e:47:11:82', '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': '216.171.45.3', 'subnet_id': '36d1b81d-1179-4322-bce2-34127c064941'}], 'security_groups': ['a78db1fc-3ade-46f9-b078-1cf70ada384d'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '936eeb6de2c2476181a10e7cd6a32fbd'}}
2025-08-07 14:22:02,464 - DEBUG - Created port c12e4711-829c-4e2d-bf1a-5d4d905ba507
2025-08-07 14:22:02,570 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine-interface/c12e4711-829c-4e2d-bf1a-5d4d905ba507
2025-08-07 14:22:02,859 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine-interface/c12e4711-829c-4e2d-bf1a-5d4d905ba507
2025-08-07 14:22:02,890 - INFO - VMI c12e4711-829c-4e2d-bf1a-5d4d905ba507 verification in API Server passed
2025-08-07 14:22:02,983 - DEBUG - Response for delete_port : ()
2025-08-07 14:22:02,983 - INFO - Deleted port c12e4711-829c-4e2d-bf1a-5d4d905ba507
2025-08-07 14:22:02,983 - INFO - Deleting VN ctest-vn-88124030
2025-08-07 14:22:03,085 - DEBUG - Response for deleting network ()
2025-08-07 14:22:03,341 - DEBUG - No XMPP flaps were noticed during the test
2025-08-07 14:22:03,341 - INFO - END TEST : test_ports_bindings : PASSED[0:00:03]
2025-08-07 14:22:03,342 - INFO - --------------------------------------------------------------------------------
2025-08-07 14:22:03,345 - INFO - ================================================================================
2025-08-07 14:22:03,345 - INFO - STARTING TEST : test_ports_specific_subnet_ip
2025-08-07 14:22:03,345 - 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-07 14:22:03,628 - DEBUG - Nothing to compare xmpp stats {'10.0.0.254': {'10.20.0.254': '0'}} with
2025-08-07 14:22:03,628 - INFO - Initial checks done. Running the testcase now
2025-08-07 14:22:03,628 - INFO -
2025-08-07 14:22:03,810 - DEBUG - Response for create_network : {'network': {'id': '8652fbcd-fce0-49b6-b1c0-faefbd4232be', 'name': 'ctest-vn1-89722474', 'tenant_id': '936eeb6de2c2476181a10e7cd6a32fbd', 'project_id': '936eeb6de2c2476181a10e7cd6a32fbd', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-58804159', 'ctest-vn1-89722474'], 'port_security_enabled': True, 'description': ''}}
2025-08-07 14:22:03,989 - DEBUG - Response for create_subnet : {'subnet': {'id': '542c59f6-7ca6-4bfc-981e-25fcba0b338c', 'name': '', 'tenant_id': '936eeb6de2c2476181a10e7cd6a32fbd', 'network_id': '8652fbcd-fce0-49b6-b1c0-faefbd4232be', 'ip_version': 4, 'cidr': '27.203.247.128/26', 'allocation_pools': [{'start': '27.203.247.130', 'end': '27.203.247.190'}], 'gateway_ip': '27.203.247.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '27.203.247.130', 'tags': [], 'project_id': '936eeb6de2c2476181a10e7cd6a32fbd'}}
2025-08-07 14:22:04,136 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a07e887e-dd8c-47c3-b378-b46a58a23501', 'name': '', 'tenant_id': '936eeb6de2c2476181a10e7cd6a32fbd', 'network_id': '8652fbcd-fce0-49b6-b1c0-faefbd4232be', 'ip_version': 4, 'cidr': '51.160.228.64/26', 'allocation_pools': [{'start': '51.160.228.66', 'end': '51.160.228.126'}], 'gateway_ip': '51.160.228.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '51.160.228.66', 'tags': [], 'project_id': '936eeb6de2c2476181a10e7cd6a32fbd'}}
2025-08-07 14:22:04,158 - INFO - Created VN ctest-vn1-89722474
2025-08-07 14:22:04,214 - DEBUG - VN ctest-vn1-89722474 UUID is 8652fbcd-fce0-49b6-b1c0-faefbd4232be
2025-08-07 14:22:04,515 - DEBUG - Response for create_port : {'port': {'name': 'c9086582-6c20-4509-8c8e-d4ae1a160161', 'id': 'c9086582-6c20-4509-8c8e-d4ae1a160161', 'tenant_id': '936eeb6de2c2476181a10e7cd6a32fbd', 'network_id': '8652fbcd-fce0-49b6-b1c0-faefbd4232be', 'mac_address': '02:c9:08:65:82:6c', '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': '27.203.247.133', 'subnet_id': '542c59f6-7ca6-4bfc-981e-25fcba0b338c'}], 'security_groups': ['a78db1fc-3ade-46f9-b078-1cf70ada384d'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '936eeb6de2c2476181a10e7cd6a32fbd'}}
2025-08-07 14:22:04,711 - DEBUG - Response for create_port : {'port': {'name': 'c73bb690-6961-461e-a5e0-95929fe87083', 'id': 'c73bb690-6961-461e-a5e0-95929fe87083', 'tenant_id': '936eeb6de2c2476181a10e7cd6a32fbd', 'network_id': '8652fbcd-fce0-49b6-b1c0-faefbd4232be', 'mac_address': '02:c7:3b:b6:90:69', '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': '51.160.228.69', 'subnet_id': 'a07e887e-dd8c-47c3-b378-b46a58a23501'}], 'security_groups': ['a78db1fc-3ade-46f9-b078-1cf70ada384d'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '936eeb6de2c2476181a10e7cd6a32fbd'}}
2025-08-07 14:22:04,776 - DEBUG - Services list from nova: [, , ]
2025-08-07 14:22:05,111 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-3771-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-3771-1)
2025-08-07 14:22:05,552 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-3771-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-3771-1)
2025-08-07 14:22:05,552 - INFO - Waiting for VM ctest-vn1-vm1-84784954 to be up..
2025-08-07 14:22:05,605 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2025-08-07 14:22:10,676 - DEBUG - VM is in ACTIVE state now
2025-08-07 14:22:10,676 - INFO - VM name : ctest-vn1-vm1-84784954
2025-08-07 14:22:10,746 - DEBUG - VM ctest-vn1-vm1-84784954 ID is 286b6a12-67bf-4ad1-b79b-d63604923460
2025-08-07 14:22:10,767 - DEBUG - VM ctest-vn1-vm1-84784954 launched on Node cn-jenkins-deploy-platform-ansible-os-3771-1
2025-08-07 14:22:10,845 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine/286b6a12-67bf-4ad1-b79b-d63604923460
2025-08-07 14:22:10,853 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine-interface/c9086582-6c20-4509-8c8e-d4ae1a160161
2025-08-07 14:22:14,127 - 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 1031ms')
2025-08-07 14:22:14,127 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-84784954 failed!
2025-08-07 14:22:14,182 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-58804159:ctest-vn1-89722474 is 27.203.247.129 and allocation pool is NOT set
2025-08-07 14:22:14,182 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-58804159:ctest-vn1-89722474 is 51.160.228.65 and allocation pool is NOT set
2025-08-07 14:22:16,242 - 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=6.75 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.45 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.447/4.099/6.752/2.652 ms')
2025-08-07 14:22:16,243 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-84784954 passed
2025-08-07 14:22:16,398 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 14:22:16,399 - DEBUG - Waiting to SSH to VM ctest-vn1-vm1-84784954, IP 27.203.247.133, Port 22
2025-08-07 14:22:16,554 - DEBUG - VM ctest-vn1-vm1-84784954 is ready for SSH connections
2025-08-07 14:22:16,554 - INFO - Waiting for VM ctest-vn1-vm2-91109401 to be up..
2025-08-07 14:22:16,637 - DEBUG - VM is in ACTIVE state now
2025-08-07 14:22:16,637 - INFO - VM name : ctest-vn1-vm2-91109401
2025-08-07 14:22:16,711 - DEBUG - VM ctest-vn1-vm2-91109401 ID is 054e7cde-9671-460b-8a02-5933b2c2b068
2025-08-07 14:22:16,711 - DEBUG - VM ctest-vn1-vm2-91109401 launched on Node cn-jenkins-deploy-platform-ansible-os-3771-1
2025-08-07 14:22:16,791 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine/054e7cde-9671-460b-8a02-5933b2c2b068
2025-08-07 14:22:16,802 - DEBUG - Requesting: http://10.0.0.254:8082/virtual-machine-interface/c73bb690-6961-461e-a5e0-95929fe87083
2025-08-07 14:22:18,048 - 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.03 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.362 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.362/1.697/3.032/1.335 ms')
2025-08-07 14:22:18,048 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-vn1-vm2-91109401 passed
2025-08-07 14:22:18,202 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 14:22:18,202 - DEBUG - Waiting to SSH to VM ctest-vn1-vm2-91109401, IP 51.160.228.69, Port 22
2025-08-07 14:22:18,362 - DEBUG - VM ctest-vn1-vm2-91109401 is ready for SSH connections
2025-08-07 14:22:18,362 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 14:22:18,362 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 14:22:18,362 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-08-07 14:22:18,363 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 27.203.247.133, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.254, gateway password: c0ntrail123
2025-08-07 14:22:18,363 - DEBUG - ping -s 56 -c 3 -W 1 27.203.247.133
2025-08-07 14:22:21,007 - DEBUG - PING 27.203.247.133 (27.203.247.133): 56 data bytes
64 bytes from 27.203.247.133: seq=0 ttl=63 time=3.309 ms
64 bytes from 27.203.247.133: seq=1 ttl=63 time=1.017 ms
64 bytes from 27.203.247.133: seq=2 ttl=63 time=0.987 ms
--- 27.203.247.133 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.987/1.771/3.309 ms
2025-08-07 14:22:21,007 - INFO - Ping to IP 27.203.247.133 from VM ctest-vn1-vm2-91109401 passed
2025-08-07 14:22:21,007 - INFO - Detaching port c73bb690-6961-461e-a5e0-95929fe87083 from VM ctest-vn1-vm2-91109401
2025-08-07 14:22:21,056 - INFO - Deleting VM ctest-vn1-vm2-91109401
2025-08-07 14:22:21,131 - INFO - Detaching port c9086582-6c20-4509-8c8e-d4ae1a160161 from VM ctest-vn1-vm1-84784954
2025-08-07 14:22:21,164 - INFO - Deleting VM ctest-vn1-vm1-84784954
2025-08-07 14:22:21,561 - DEBUG - Response for delete_port : ()
2025-08-07 14:22:21,738 - DEBUG - Response for delete_port : ()
2025-08-07 14:22:21,738 - INFO - Deleting VN ctest-vn1-89722474
2025-08-07 14:22:21,875 - DEBUG - Response for deleting network ()
2025-08-07 14:22:22,133 - DEBUG - No XMPP flaps were noticed during the test
2025-08-07 14:22:22,133 - INFO - END TEST : test_ports_specific_subnet_ip : PASSED[0:00:19]
2025-08-07 14:22:22,133 - INFO - --------------------------------------------------------------------------------
2025-08-07 14:22:22,832 - INFO - Deleted project: ctest-TestPorts-58804159, ID : 936eeb6d-e2c2-4761-81a1-0e7cd6a32fbd