2025-10-23 23:36:51,374 - INFO - Domain Default found not creating
2025-10-23 23:36:51,541 - INFO - Project ctest-TestPorts-59189012 not found, creating it
2025-10-23 23:36:52,016 - INFO - Created Project:ctest-TestPorts-59189012, ID : becd1cd8-fa53-420b-8a20-a9c4efee5d16
2025-10-23 23:36:53,734 - INFO - ================================================================================
2025-10-23 23:36:53,734 - INFO - STARTING TEST : test_ports_bindings
2025-10-23 23:36:53,735 - 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-23 23:36:53,994 - DEBUG - Nothing to compare xmpp stats {'10.0.0.242': {'10.20.0.17': '0'}} with
2025-10-23 23:36:53,994 - INFO - Initial checks done. Running the testcase now
2025-10-23 23:36:53,994 - INFO -
2025-10-23 23:36:54,617 - DEBUG - Response for create_network : {'network': {'id': '3533eb64-21db-4e13-8100-acd916b45b12', 'name': 'ctest-vn-03965042', 'tenant_id': 'becd1cd8fa53420b8a20a9c4efee5d16', 'project_id': 'becd1cd8fa53420b8a20a9c4efee5d16', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-59189012', 'ctest-vn-03965042'], 'port_security_enabled': True, 'description': ''}}
2025-10-23 23:36:54,845 - DEBUG - Response for create_subnet : {'subnet': {'id': '45475200-279f-49a9-a914-3249fe013451', 'name': '', 'tenant_id': 'becd1cd8fa53420b8a20a9c4efee5d16', 'network_id': '3533eb64-21db-4e13-8100-acd916b45b12', 'ip_version': 4, 'cidr': '164.33.54.0/26', 'allocation_pools': [{'start': '164.33.54.2', 'end': '164.33.54.62'}], 'gateway_ip': '164.33.54.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '164.33.54.2', 'tags': [], 'project_id': 'becd1cd8fa53420b8a20a9c4efee5d16'}}
2025-10-23 23:36:54,864 - INFO - Created VN ctest-vn-03965042
2025-10-23 23:36:54,920 - DEBUG - VN ctest-vn-03965042 UUID is 3533eb64-21db-4e13-8100-acd916b45b12
2025-10-23 23:36:55,041 - DEBUG - Read virtual machine interface {'fq_name': ['default-domain', 'ctest-TestPorts-59189012', 'ctest-vmi-46128465']}
2025-10-23 23:36:55,292 - DEBUG - Response for create_port : {'port': {'name': 'ctest-vmi-46128465', 'id': 'aa987a6b-1828-4dce-a238-fec3c08faefd', 'tenant_id': 'becd1cd8fa53420b8a20a9c4efee5d16', 'network_id': '3533eb64-21db-4e13-8100-acd916b45b12', 'mac_address': '02:aa:98:7a:6b:18', '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': '164.33.54.3', 'subnet_id': '45475200-279f-49a9-a914-3249fe013451'}], 'security_groups': ['80e5f0e5-0211-4e41-a193-19aa49a129ad'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': 'becd1cd8fa53420b8a20a9c4efee5d16'}}
2025-10-23 23:36:55,292 - DEBUG - Created port aa987a6b-1828-4dce-a238-fec3c08faefd
2025-10-23 23:36:55,400 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-machine-interface/aa987a6b-1828-4dce-a238-fec3c08faefd
2025-10-23 23:36:55,734 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-machine-interface/aa987a6b-1828-4dce-a238-fec3c08faefd
2025-10-23 23:36:55,770 - INFO - VMI aa987a6b-1828-4dce-a238-fec3c08faefd verification in API Server passed
2025-10-23 23:36:55,868 - DEBUG - Response for delete_port : ()
2025-10-23 23:36:55,868 - INFO - Deleted port aa987a6b-1828-4dce-a238-fec3c08faefd
2025-10-23 23:36:55,868 - INFO - Deleting VN ctest-vn-03965042
2025-10-23 23:36:55,980 - DEBUG - Response for deleting network ()
2025-10-23 23:36:56,257 - DEBUG - No XMPP flaps were noticed during the test
2025-10-23 23:36:56,257 - INFO - END TEST : test_ports_bindings : PASSED[0:00:03]
2025-10-23 23:36:56,257 - INFO - --------------------------------------------------------------------------------
2025-10-23 23:36:56,260 - INFO - ================================================================================
2025-10-23 23:36:56,261 - INFO - STARTING TEST : test_ports_specific_subnet_ip
2025-10-23 23:36:56,261 - 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-23 23:36:56,542 - DEBUG - Nothing to compare xmpp stats {'10.0.0.242': {'10.20.0.17': '0'}} with
2025-10-23 23:36:56,542 - INFO - Initial checks done. Running the testcase now
2025-10-23 23:36:56,542 - INFO -
2025-10-23 23:36:56,732 - DEBUG - Response for create_network : {'network': {'id': '820f9fee-e1cf-4303-98f2-3d93c2a67fe6', 'name': 'ctest-vn1-37846558', 'tenant_id': 'becd1cd8fa53420b8a20a9c4efee5d16', 'project_id': 'becd1cd8fa53420b8a20a9c4efee5d16', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-59189012', 'ctest-vn1-37846558'], 'port_security_enabled': True, 'description': ''}}
2025-10-23 23:36:56,896 - DEBUG - Response for create_subnet : {'subnet': {'id': '8aa7c773-77c2-4a2b-b22f-0ac93fb50613', 'name': '', 'tenant_id': 'becd1cd8fa53420b8a20a9c4efee5d16', 'network_id': '820f9fee-e1cf-4303-98f2-3d93c2a67fe6', 'ip_version': 4, 'cidr': '209.13.69.0/26', 'allocation_pools': [{'start': '209.13.69.2', 'end': '209.13.69.62'}], 'gateway_ip': '209.13.69.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '209.13.69.2', 'tags': [], 'project_id': 'becd1cd8fa53420b8a20a9c4efee5d16'}}
2025-10-23 23:36:57,098 - DEBUG - Response for create_subnet : {'subnet': {'id': '800565c9-14bf-4bdd-ae35-b2ece3ed9ecb', 'name': '', 'tenant_id': 'becd1cd8fa53420b8a20a9c4efee5d16', 'network_id': '820f9fee-e1cf-4303-98f2-3d93c2a67fe6', 'ip_version': 4, 'cidr': '210.23.142.64/26', 'allocation_pools': [{'start': '210.23.142.66', 'end': '210.23.142.126'}], 'gateway_ip': '210.23.142.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '210.23.142.66', 'tags': [], 'project_id': 'becd1cd8fa53420b8a20a9c4efee5d16'}}
2025-10-23 23:36:57,122 - INFO - Created VN ctest-vn1-37846558
2025-10-23 23:36:57,176 - DEBUG - VN ctest-vn1-37846558 UUID is 820f9fee-e1cf-4303-98f2-3d93c2a67fe6
2025-10-23 23:36:57,503 - DEBUG - Response for create_port : {'port': {'name': '9ab45be9-5c31-4ed0-8163-9323fb761f34', 'id': '9ab45be9-5c31-4ed0-8163-9323fb761f34', 'tenant_id': 'becd1cd8fa53420b8a20a9c4efee5d16', 'network_id': '820f9fee-e1cf-4303-98f2-3d93c2a67fe6', 'mac_address': '02:9a:b4:5b:e9:5c', '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': '209.13.69.5', 'subnet_id': '8aa7c773-77c2-4a2b-b22f-0ac93fb50613'}], 'security_groups': ['80e5f0e5-0211-4e41-a193-19aa49a129ad'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': 'becd1cd8fa53420b8a20a9c4efee5d16'}}
2025-10-23 23:36:57,687 - DEBUG - Response for create_port : {'port': {'name': '8d28a4d2-0cd2-41d5-b3ae-c01c0fa45aa1', 'id': '8d28a4d2-0cd2-41d5-b3ae-c01c0fa45aa1', 'tenant_id': 'becd1cd8fa53420b8a20a9c4efee5d16', 'network_id': '820f9fee-e1cf-4303-98f2-3d93c2a67fe6', 'mac_address': '02:8d:28:a4:d2:0c', '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': '210.23.142.69', 'subnet_id': '800565c9-14bf-4bdd-ae35-b2ece3ed9ecb'}], 'security_groups': ['80e5f0e5-0211-4e41-a193-19aa49a129ad'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': 'becd1cd8fa53420b8a20a9c4efee5d16'}}
2025-10-23 23:36:57,750 - DEBUG - Services list from nova: [, , ]
2025-10-23 23:36:58,149 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4471-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4471-1)
2025-10-23 23:36:58,589 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4471-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4471-1)
2025-10-23 23:36:58,589 - INFO - Waiting for VM ctest-vn1-vm1-82946976 to be up..
2025-10-23 23:36:58,639 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2025-10-23 23:37:03,720 - DEBUG - VM is in ACTIVE state now
2025-10-23 23:37:03,721 - INFO - VM name : ctest-vn1-vm1-82946976
2025-10-23 23:37:03,801 - DEBUG - VM ctest-vn1-vm1-82946976 ID is a1793e50-7136-4793-bca9-4421aca182da
2025-10-23 23:37:03,824 - DEBUG - VM ctest-vn1-vm1-82946976 launched on Node cn-jenkins-deploy-platform-ansible-os-4471-1
2025-10-23 23:37:03,914 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-machine/a1793e50-7136-4793-bca9-4421aca182da
2025-10-23 23:37:03,924 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-machine-interface/9ab45be9-5c31-4ed0-8163-9323fb761f34
2025-10-23 23:37:07,209 - 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-23 23:37:07,209 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-82946976 failed!
2025-10-23 23:37:07,264 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-59189012:ctest-vn1-37846558 is 209.13.69.1 and allocation pool is NOT set
2025-10-23 23:37:07,264 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-59189012:ctest-vn1-37846558 is 210.23.142.65 and allocation pool is NOT set
2025-10-23 23:37:11,338 - 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 1013ms')
2025-10-23 23:37:11,338 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-82946976 failed!
2025-10-23 23:37:11,400 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-59189012:ctest-vn1-37846558 is 209.13.69.1 and allocation pool is NOT set
2025-10-23 23:37:11,400 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-59189012:ctest-vn1-37846558 is 210.23.142.65 and allocation pool is NOT set
2025-10-23 23:37:13,462 - 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.61 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.670 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 = 0.670/1.637/2.605/0.967 ms')
2025-10-23 23:37:13,463 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-82946976 passed
2025-10-23 23:37:13,620 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-23 23:37:13,620 - DEBUG - Waiting to SSH to VM ctest-vn1-vm1-82946976, IP 209.13.69.5, Port 22
2025-10-23 23:37:13,785 - DEBUG - VM ctest-vn1-vm1-82946976 is ready for SSH connections
2025-10-23 23:37:13,785 - INFO - Waiting for VM ctest-vn1-vm2-08062799 to be up..
2025-10-23 23:37:13,872 - DEBUG - VM is in ACTIVE state now
2025-10-23 23:37:13,872 - INFO - VM name : ctest-vn1-vm2-08062799
2025-10-23 23:37:13,952 - DEBUG - VM ctest-vn1-vm2-08062799 ID is eaccb3a6-3cc8-4710-8d63-8c448502bbf6
2025-10-23 23:37:13,952 - DEBUG - VM ctest-vn1-vm2-08062799 launched on Node cn-jenkins-deploy-platform-ansible-os-4471-1
2025-10-23 23:37:14,037 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-machine/eaccb3a6-3cc8-4710-8d63-8c448502bbf6
2025-10-23 23:37:14,049 - DEBUG - Requesting: http://10.0.0.242:8082/virtual-machine-interface/8d28a4d2-0cd2-41d5-b3ae-c01c0fa45aa1
2025-10-23 23:37:15,297 - 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.18 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.493 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.493/1.836/3.180/1.343 ms')
2025-10-23 23:37:15,297 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-vn1-vm2-08062799 passed
2025-10-23 23:37:15,448 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-23 23:37:15,448 - DEBUG - Waiting to SSH to VM ctest-vn1-vm2-08062799, IP 210.23.142.69, Port 22
2025-10-23 23:37:15,614 - DEBUG - VM ctest-vn1-vm2-08062799 is ready for SSH connections
2025-10-23 23:37:15,614 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-23 23:37:15,614 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-23 23:37:15,614 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-10-23 23:37:15,614 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 209.13.69.5, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.242, gateway password: c0ntrail123
2025-10-23 23:37:15,614 - DEBUG - ping -s 56 -c 3 -W 1 209.13.69.5
2025-10-23 23:37:18,347 - DEBUG - PING 209.13.69.5 (209.13.69.5): 56 data bytes
64 bytes from 209.13.69.5: seq=0 ttl=63 time=4.237 ms
64 bytes from 209.13.69.5: seq=1 ttl=63 time=0.968 ms
64 bytes from 209.13.69.5: seq=2 ttl=63 time=1.021 ms
--- 209.13.69.5 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.968/2.075/4.237 ms
2025-10-23 23:37:18,347 - INFO - Ping to IP 209.13.69.5 from VM ctest-vn1-vm2-08062799 passed
2025-10-23 23:37:18,348 - INFO - Detaching port 8d28a4d2-0cd2-41d5-b3ae-c01c0fa45aa1 from VM ctest-vn1-vm2-08062799
2025-10-23 23:37:18,420 - INFO - Deleting VM ctest-vn1-vm2-08062799
2025-10-23 23:37:18,510 - INFO - Detaching port 9ab45be9-5c31-4ed0-8163-9323fb761f34 from VM ctest-vn1-vm1-82946976
2025-10-23 23:37:18,550 - INFO - Deleting VM ctest-vn1-vm1-82946976
2025-10-23 23:37:18,842 - DEBUG - Response for delete_port : ()
2025-10-23 23:37:19,085 - DEBUG - Response for delete_port : ()
2025-10-23 23:37:19,085 - INFO - Deleting VN ctest-vn1-37846558
2025-10-23 23:37:19,274 - DEBUG - Response for deleting network ()
2025-10-23 23:37:19,533 - DEBUG - No XMPP flaps were noticed during the test
2025-10-23 23:37:19,533 - INFO - END TEST : test_ports_specific_subnet_ip : PASSED[0:00:23]
2025-10-23 23:37:19,534 - INFO - --------------------------------------------------------------------------------
2025-10-23 23:37:20,287 - INFO - Deleted project: ctest-TestPorts-59189012, ID : becd1cd8-fa53-420b-8a20-a9c4efee5d16