2025-11-12 09:09:29,053 - INFO - Domain Default found not creating
2025-11-12 09:09:29,277 - INFO - Project ctest-TestPorts-75961412 not found, creating it
2025-11-12 09:09:29,917 - INFO - Created Project:ctest-TestPorts-75961412, ID : 25228e4e-9e01-4e3e-9a42-18d4b5a7663d
2025-11-12 09:09:31,537 - INFO - ================================================================================
2025-11-12 09:09:31,537 - INFO - STARTING TEST : test_ports_bindings
2025-11-12 09:09:31,537 - 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-11-12 09:09:31,819 - DEBUG - Nothing to compare xmpp stats {'10.0.0.19': {'10.20.0.25': '0'}} with
2025-11-12 09:09:31,819 - INFO - Initial checks done. Running the testcase now
2025-11-12 09:09:31,819 - INFO -
2025-11-12 09:09:32,427 - DEBUG - Response for create_network : {'network': {'id': 'bab2d2c7-4b35-4e5a-84f8-768a3c5e2aad', 'name': 'ctest-vn-18693048', 'tenant_id': '25228e4e9e014e3e9a4218d4b5a7663d', 'project_id': '25228e4e9e014e3e9a4218d4b5a7663d', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-75961412', 'ctest-vn-18693048'], 'port_security_enabled': True, 'description': ''}}
2025-11-12 09:09:32,666 - DEBUG - Response for create_subnet : {'subnet': {'id': '5a9f75cb-312e-4d3f-ac5c-c138fe3a06ce', 'name': '', 'tenant_id': '25228e4e9e014e3e9a4218d4b5a7663d', 'network_id': 'bab2d2c7-4b35-4e5a-84f8-768a3c5e2aad', 'ip_version': 4, 'cidr': '70.50.7.128/26', 'allocation_pools': [{'start': '70.50.7.130', 'end': '70.50.7.190'}], 'gateway_ip': '70.50.7.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '70.50.7.130', 'tags': [], 'project_id': '25228e4e9e014e3e9a4218d4b5a7663d'}}
2025-11-12 09:09:32,684 - INFO - Created VN ctest-vn-18693048
2025-11-12 09:09:32,740 - DEBUG - VN ctest-vn-18693048 UUID is bab2d2c7-4b35-4e5a-84f8-768a3c5e2aad
2025-11-12 09:09:32,857 - DEBUG - Read virtual machine interface {'fq_name': ['default-domain', 'ctest-TestPorts-75961412', 'ctest-vmi-70167191']}
2025-11-12 09:09:33,125 - DEBUG - Response for create_port : {'port': {'name': 'ctest-vmi-70167191', 'id': 'a583171c-80e6-483f-bdae-804ace444af6', 'tenant_id': '25228e4e9e014e3e9a4218d4b5a7663d', 'network_id': 'bab2d2c7-4b35-4e5a-84f8-768a3c5e2aad', 'mac_address': '02:a5:83:17:1c:80', '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': '70.50.7.131', 'subnet_id': '5a9f75cb-312e-4d3f-ac5c-c138fe3a06ce'}], 'security_groups': ['3e600ea8-56f4-41ca-bf12-bca93506a55b'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '25228e4e9e014e3e9a4218d4b5a7663d'}}
2025-11-12 09:09:33,125 - DEBUG - Created port a583171c-80e6-483f-bdae-804ace444af6
2025-11-12 09:09:33,232 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-machine-interface/a583171c-80e6-483f-bdae-804ace444af6
2025-11-12 09:09:33,534 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-machine-interface/a583171c-80e6-483f-bdae-804ace444af6
2025-11-12 09:09:33,571 - INFO - VMI a583171c-80e6-483f-bdae-804ace444af6 verification in API Server passed
2025-11-12 09:09:33,674 - DEBUG - Response for delete_port : ()
2025-11-12 09:09:33,674 - INFO - Deleted port a583171c-80e6-483f-bdae-804ace444af6
2025-11-12 09:09:33,674 - INFO - Deleting VN ctest-vn-18693048
2025-11-12 09:09:33,793 - DEBUG - Response for deleting network ()
2025-11-12 09:09:34,054 - DEBUG - No XMPP flaps were noticed during the test
2025-11-12 09:09:34,054 - INFO - END TEST : test_ports_bindings : PASSED[0:00:03]
2025-11-12 09:09:34,054 - INFO - --------------------------------------------------------------------------------
2025-11-12 09:09:34,058 - INFO - ================================================================================
2025-11-12 09:09:34,058 - INFO - STARTING TEST : test_ports_specific_subnet_ip
2025-11-12 09:09:34,058 - 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-11-12 09:09:34,355 - DEBUG - Nothing to compare xmpp stats {'10.0.0.19': {'10.20.0.25': '0'}} with
2025-11-12 09:09:34,355 - INFO - Initial checks done. Running the testcase now
2025-11-12 09:09:34,355 - INFO -
2025-11-12 09:09:34,543 - DEBUG - Response for create_network : {'network': {'id': 'dde07cf9-2c26-47d9-ac88-556cc6d18dc4', 'name': 'ctest-vn1-16242656', 'tenant_id': '25228e4e9e014e3e9a4218d4b5a7663d', 'project_id': '25228e4e9e014e3e9a4218d4b5a7663d', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-75961412', 'ctest-vn1-16242656'], 'port_security_enabled': True, 'description': ''}}
2025-11-12 09:09:34,762 - DEBUG - Response for create_subnet : {'subnet': {'id': 'adb1906b-a137-4ed7-915f-fd306d87873a', 'name': '', 'tenant_id': '25228e4e9e014e3e9a4218d4b5a7663d', 'network_id': 'dde07cf9-2c26-47d9-ac88-556cc6d18dc4', 'ip_version': 4, 'cidr': '78.45.26.0/26', 'allocation_pools': [{'start': '78.45.26.2', 'end': '78.45.26.62'}], 'gateway_ip': '78.45.26.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '78.45.26.2', 'tags': [], 'project_id': '25228e4e9e014e3e9a4218d4b5a7663d'}}
2025-11-12 09:09:34,923 - DEBUG - Response for create_subnet : {'subnet': {'id': '039328b6-d9fd-4861-92e0-f366688c43aa', 'name': '', 'tenant_id': '25228e4e9e014e3e9a4218d4b5a7663d', 'network_id': 'dde07cf9-2c26-47d9-ac88-556cc6d18dc4', 'ip_version': 4, 'cidr': '58.178.110.128/26', 'allocation_pools': [{'start': '58.178.110.130', 'end': '58.178.110.190'}], 'gateway_ip': '58.178.110.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '58.178.110.130', 'tags': [], 'project_id': '25228e4e9e014e3e9a4218d4b5a7663d'}}
2025-11-12 09:09:34,945 - INFO - Created VN ctest-vn1-16242656
2025-11-12 09:09:35,000 - DEBUG - VN ctest-vn1-16242656 UUID is dde07cf9-2c26-47d9-ac88-556cc6d18dc4
2025-11-12 09:09:35,357 - DEBUG - Response for create_port : {'port': {'name': 'a330cbbc-c302-47e3-937b-692c5e70b372', 'id': 'a330cbbc-c302-47e3-937b-692c5e70b372', 'tenant_id': '25228e4e9e014e3e9a4218d4b5a7663d', 'network_id': 'dde07cf9-2c26-47d9-ac88-556cc6d18dc4', 'mac_address': '02:a3:30:cb:bc:c3', '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': '78.45.26.5', 'subnet_id': 'adb1906b-a137-4ed7-915f-fd306d87873a'}], 'security_groups': ['3e600ea8-56f4-41ca-bf12-bca93506a55b'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '25228e4e9e014e3e9a4218d4b5a7663d'}}
2025-11-12 09:09:35,538 - DEBUG - Response for create_port : {'port': {'name': 'd527d5f8-bcc9-4f43-9afe-f14bb71194f1', 'id': 'd527d5f8-bcc9-4f43-9afe-f14bb71194f1', 'tenant_id': '25228e4e9e014e3e9a4218d4b5a7663d', 'network_id': 'dde07cf9-2c26-47d9-ac88-556cc6d18dc4', 'mac_address': '02:d5:27:d5:f8:bc', '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': '58.178.110.133', 'subnet_id': '039328b6-d9fd-4861-92e0-f366688c43aa'}], 'security_groups': ['3e600ea8-56f4-41ca-bf12-bca93506a55b'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '25228e4e9e014e3e9a4218d4b5a7663d'}}
2025-11-12 09:09:35,605 - DEBUG - Services list from nova: [, , ]
2025-11-12 09:09:35,997 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4701-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4701-1)
2025-11-12 09:09:36,468 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4701-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4701-1)
2025-11-12 09:09:36,469 - INFO - Waiting for VM ctest-vn1-vm1-53133217 to be up..
2025-11-12 09:09:36,514 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2025-11-12 09:09:41,601 - DEBUG - VM is in ACTIVE state now
2025-11-12 09:09:41,601 - INFO - VM name : ctest-vn1-vm1-53133217
2025-11-12 09:09:41,683 - DEBUG - VM ctest-vn1-vm1-53133217 ID is a1432711-b514-49d4-9355-0c6679b3aad3
2025-11-12 09:09:41,707 - DEBUG - VM ctest-vn1-vm1-53133217 launched on Node cn-jenkins-deploy-platform-ansible-os-4701-1
2025-11-12 09:09:41,796 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-machine/a1432711-b514-49d4-9355-0c6679b3aad3
2025-11-12 09:09:41,807 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-machine-interface/a330cbbc-c302-47e3-937b-692c5e70b372
2025-11-12 09:09:45,079 - 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 1025ms')
2025-11-12 09:09:45,079 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-53133217 failed!
2025-11-12 09:09:45,136 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-75961412:ctest-vn1-16242656 is 78.45.26.1 and allocation pool is NOT set
2025-11-12 09:09:45,136 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-75961412:ctest-vn1-16242656 is 58.178.110.129 and allocation pool is NOT set
2025-11-12 09:09:49,207 - 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=14.8 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 14.752/14.752/14.752/0.000 ms')
2025-11-12 09:09:49,207 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-53133217 passed
2025-11-12 09:09:49,364 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-11-12 09:09:49,364 - DEBUG - Waiting to SSH to VM ctest-vn1-vm1-53133217, IP 78.45.26.5, Port 22
2025-11-12 09:09:49,530 - DEBUG - VM ctest-vn1-vm1-53133217 is ready for SSH connections
2025-11-12 09:09:49,531 - INFO - Waiting for VM ctest-vn1-vm2-88165378 to be up..
2025-11-12 09:09:49,624 - DEBUG - VM is in ACTIVE state now
2025-11-12 09:09:49,624 - INFO - VM name : ctest-vn1-vm2-88165378
2025-11-12 09:09:49,701 - DEBUG - VM ctest-vn1-vm2-88165378 ID is fd9615ef-dae9-4179-ba20-331930b0e8fc
2025-11-12 09:09:49,703 - DEBUG - VM ctest-vn1-vm2-88165378 launched on Node cn-jenkins-deploy-platform-ansible-os-4701-1
2025-11-12 09:09:49,782 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-machine/fd9615ef-dae9-4179-ba20-331930b0e8fc
2025-11-12 09:09:49,791 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-machine-interface/d527d5f8-bcc9-4f43-9afe-f14bb71194f1
2025-11-12 09:09:51,041 - 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.98 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.526 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.526/1.750/2.975/1.224 ms')
2025-11-12 09:09:51,041 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-vn1-vm2-88165378 passed
2025-11-12 09:09:51,196 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-11-12 09:09:51,196 - DEBUG - Waiting to SSH to VM ctest-vn1-vm2-88165378, IP 58.178.110.133, Port 22
2025-11-12 09:09:51,355 - DEBUG - VM ctest-vn1-vm2-88165378 is ready for SSH connections
2025-11-12 09:09:51,355 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-11-12 09:09:51,355 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-11-12 09:09:51,355 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-11-12 09:09:51,356 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 78.45.26.5, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.19, gateway password: c0ntrail123
2025-11-12 09:09:51,356 - DEBUG - ping -s 56 -c 3 -W 1 78.45.26.5
2025-11-12 09:09:54,069 - DEBUG - PING 78.45.26.5 (78.45.26.5): 56 data bytes
64 bytes from 78.45.26.5: seq=0 ttl=63 time=3.844 ms
64 bytes from 78.45.26.5: seq=1 ttl=63 time=0.914 ms
64 bytes from 78.45.26.5: seq=2 ttl=63 time=0.874 ms
--- 78.45.26.5 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.874/1.877/3.844 ms
2025-11-12 09:09:54,070 - INFO - Ping to IP 78.45.26.5 from VM ctest-vn1-vm2-88165378 passed
2025-11-12 09:09:54,070 - INFO - Detaching port d527d5f8-bcc9-4f43-9afe-f14bb71194f1 from VM ctest-vn1-vm2-88165378
2025-11-12 09:09:54,128 - INFO - Deleting VM ctest-vn1-vm2-88165378
2025-11-12 09:09:54,214 - INFO - Detaching port a330cbbc-c302-47e3-937b-692c5e70b372 from VM ctest-vn1-vm1-53133217
2025-11-12 09:09:54,253 - INFO - Deleting VM ctest-vn1-vm1-53133217
2025-11-12 09:09:54,542 - DEBUG - Response for delete_port : ()
2025-11-12 09:09:54,731 - DEBUG - Response for delete_port : ()
2025-11-12 09:09:54,731 - INFO - Deleting VN ctest-vn1-16242656
2025-11-12 09:09:54,920 - DEBUG - Response for deleting network ()
2025-11-12 09:09:55,213 - DEBUG - No XMPP flaps were noticed during the test
2025-11-12 09:09:55,213 - INFO - END TEST : test_ports_specific_subnet_ip : PASSED[0:00:21]
2025-11-12 09:09:55,213 - INFO - --------------------------------------------------------------------------------
2025-11-12 09:09:55,904 - INFO - Deleted project: ctest-TestPorts-75961412, ID : 25228e4e-9e01-4e3e-9a42-18d4b5a7663d