2026-01-06 05:33:37,985 - INFO - Domain Default found not creating
2026-01-06 05:33:38,154 - INFO - Project ctest-TestPorts-83782514 not found, creating it
2026-01-06 05:33:38,652 - INFO - Created Project:ctest-TestPorts-83782514, ID : ba8e28ee-d685-4e9b-9c0b-da22fa3397fd
2026-01-06 05:33:40,264 - INFO - ================================================================================
2026-01-06 05:33:40,264 - INFO - STARTING TEST : test_ports_bindings
2026-01-06 05:33:40,264 - 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
2026-01-06 05:33:40,533 - DEBUG - Nothing to compare xmpp stats {'10.0.0.50': {'10.20.0.17': '0'}} with
2026-01-06 05:33:40,533 - INFO - Initial checks done. Running the testcase now
2026-01-06 05:33:40,533 - INFO -
2026-01-06 05:33:41,145 - DEBUG - Response for create_network : {'network': {'id': '6a2e40b4-39fa-4ed5-a73e-5ba141afb927', 'name': 'ctest-vn-84040944', 'tenant_id': 'ba8e28eed6854e9b9c0bda22fa3397fd', 'project_id': 'ba8e28eed6854e9b9c0bda22fa3397fd', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-83782514', 'ctest-vn-84040944'], 'port_security_enabled': True, 'description': ''}}
2026-01-06 05:33:41,350 - DEBUG - Response for create_subnet : {'subnet': {'id': 'faac6c63-d1dd-4461-8da4-f11c9ee2bde4', 'name': '', 'tenant_id': 'ba8e28eed6854e9b9c0bda22fa3397fd', 'network_id': '6a2e40b4-39fa-4ed5-a73e-5ba141afb927', 'ip_version': 4, 'cidr': '101.232.111.64/26', 'allocation_pools': [{'start': '101.232.111.66', 'end': '101.232.111.126'}], 'gateway_ip': '101.232.111.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '101.232.111.66', 'tags': [], 'project_id': 'ba8e28eed6854e9b9c0bda22fa3397fd'}}
2026-01-06 05:33:41,370 - INFO - Created VN ctest-vn-84040944
2026-01-06 05:33:41,424 - DEBUG - VN ctest-vn-84040944 UUID is 6a2e40b4-39fa-4ed5-a73e-5ba141afb927
2026-01-06 05:33:41,538 - DEBUG - Read virtual machine interface {'fq_name': ['default-domain', 'ctest-TestPorts-83782514', 'ctest-vmi-38818862']}
2026-01-06 05:33:41,774 - DEBUG - Response for create_port : {'port': {'name': 'ctest-vmi-38818862', 'id': '2e48cecc-1927-4ace-a3a2-b366deafbc11', 'tenant_id': 'ba8e28eed6854e9b9c0bda22fa3397fd', 'network_id': '6a2e40b4-39fa-4ed5-a73e-5ba141afb927', 'mac_address': '02:2e:48:ce:cc:19', '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': '101.232.111.67', 'subnet_id': 'faac6c63-d1dd-4461-8da4-f11c9ee2bde4'}], 'security_groups': ['50049671-44f5-4df0-a2d0-8e86068f38a9'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': 'ba8e28eed6854e9b9c0bda22fa3397fd'}}
2026-01-06 05:33:41,774 - DEBUG - Created port 2e48cecc-1927-4ace-a3a2-b366deafbc11
2026-01-06 05:33:41,884 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/2e48cecc-1927-4ace-a3a2-b366deafbc11
2026-01-06 05:33:42,218 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/2e48cecc-1927-4ace-a3a2-b366deafbc11
2026-01-06 05:33:42,310 - INFO - VMI 2e48cecc-1927-4ace-a3a2-b366deafbc11 verification in API Server passed
2026-01-06 05:33:42,409 - DEBUG - Response for delete_port : ()
2026-01-06 05:33:42,409 - INFO - Deleted port 2e48cecc-1927-4ace-a3a2-b366deafbc11
2026-01-06 05:33:42,409 - INFO - Deleting VN ctest-vn-84040944
2026-01-06 05:33:42,516 - DEBUG - Response for deleting network ()
2026-01-06 05:33:42,773 - DEBUG - No XMPP flaps were noticed during the test
2026-01-06 05:33:42,773 - INFO - END TEST : test_ports_bindings : PASSED[0:00:02]
2026-01-06 05:33:42,773 - INFO - --------------------------------------------------------------------------------
2026-01-06 05:33:42,776 - INFO - ================================================================================
2026-01-06 05:33:42,776 - INFO - STARTING TEST : test_ports_specific_subnet_ip
2026-01-06 05:33:42,776 - 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
2026-01-06 05:33:43,061 - DEBUG - Nothing to compare xmpp stats {'10.0.0.50': {'10.20.0.17': '0'}} with
2026-01-06 05:33:43,061 - INFO - Initial checks done. Running the testcase now
2026-01-06 05:33:43,061 - INFO -
2026-01-06 05:33:43,240 - DEBUG - Response for create_network : {'network': {'id': '6d74530a-1476-4a9c-9ca0-725db27bd03d', 'name': 'ctest-vn1-67619411', 'tenant_id': 'ba8e28eed6854e9b9c0bda22fa3397fd', 'project_id': 'ba8e28eed6854e9b9c0bda22fa3397fd', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-83782514', 'ctest-vn1-67619411'], 'port_security_enabled': True, 'description': ''}}
2026-01-06 05:33:43,469 - DEBUG - Response for create_subnet : {'subnet': {'id': '0ef0f2ca-d381-43ee-a296-5d863d5581dc', 'name': '', 'tenant_id': 'ba8e28eed6854e9b9c0bda22fa3397fd', 'network_id': '6d74530a-1476-4a9c-9ca0-725db27bd03d', 'ip_version': 4, 'cidr': '168.68.221.192/26', 'allocation_pools': [{'start': '168.68.221.194', 'end': '168.68.221.254'}], 'gateway_ip': '168.68.221.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '168.68.221.194', 'tags': [], 'project_id': 'ba8e28eed6854e9b9c0bda22fa3397fd'}}
2026-01-06 05:33:43,625 - DEBUG - Response for create_subnet : {'subnet': {'id': '710079df-ab73-4d35-b656-3c15eac143ae', 'name': '', 'tenant_id': 'ba8e28eed6854e9b9c0bda22fa3397fd', 'network_id': '6d74530a-1476-4a9c-9ca0-725db27bd03d', 'ip_version': 4, 'cidr': '102.155.216.64/26', 'allocation_pools': [{'start': '102.155.216.66', 'end': '102.155.216.126'}], 'gateway_ip': '102.155.216.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '102.155.216.66', 'tags': [], 'project_id': 'ba8e28eed6854e9b9c0bda22fa3397fd'}}
2026-01-06 05:33:43,643 - INFO - Created VN ctest-vn1-67619411
2026-01-06 05:33:43,696 - DEBUG - VN ctest-vn1-67619411 UUID is 6d74530a-1476-4a9c-9ca0-725db27bd03d
2026-01-06 05:33:44,001 - DEBUG - Response for create_port : {'port': {'name': 'edaff047-179d-4f74-9dcc-3acfaeb616e8', 'id': 'edaff047-179d-4f74-9dcc-3acfaeb616e8', 'tenant_id': 'ba8e28eed6854e9b9c0bda22fa3397fd', 'network_id': '6d74530a-1476-4a9c-9ca0-725db27bd03d', 'mac_address': '02:ed:af:f0:47:17', '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': '168.68.221.197', 'subnet_id': '0ef0f2ca-d381-43ee-a296-5d863d5581dc'}], 'security_groups': ['50049671-44f5-4df0-a2d0-8e86068f38a9'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': 'ba8e28eed6854e9b9c0bda22fa3397fd'}}
2026-01-06 05:33:44,170 - DEBUG - Response for create_port : {'port': {'name': 'b7e215ef-db71-4d8a-8ea9-fb1dc42c805e', 'id': 'b7e215ef-db71-4d8a-8ea9-fb1dc42c805e', 'tenant_id': 'ba8e28eed6854e9b9c0bda22fa3397fd', 'network_id': '6d74530a-1476-4a9c-9ca0-725db27bd03d', 'mac_address': '02:b7:e2:15:ef:db', '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': '102.155.216.69', 'subnet_id': '710079df-ab73-4d35-b656-3c15eac143ae'}], 'security_groups': ['50049671-44f5-4df0-a2d0-8e86068f38a9'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': 'ba8e28eed6854e9b9c0bda22fa3397fd'}}
2026-01-06 05:33:44,230 - DEBUG - Services list from nova: [, , ]
2026-01-06 05:33:44,587 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4967-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4967-1)
2026-01-06 05:33:44,988 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4967-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4967-1)
2026-01-06 05:33:44,988 - INFO - Waiting for VM ctest-vn1-vm1-83728170 to be up..
2026-01-06 05:33:45,035 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-01-06 05:33:50,116 - DEBUG - VM is in ACTIVE state now
2026-01-06 05:33:50,116 - INFO - VM name : ctest-vn1-vm1-83728170
2026-01-06 05:33:50,191 - DEBUG - VM ctest-vn1-vm1-83728170 ID is a5ee7d4f-69dc-4fc6-a577-31836af02a72
2026-01-06 05:33:50,214 - DEBUG - VM ctest-vn1-vm1-83728170 launched on Node cn-jenkins-deploy-platform-ansible-os-4967-1
2026-01-06 05:33:50,293 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine/a5ee7d4f-69dc-4fc6-a577-31836af02a72
2026-01-06 05:33:50,302 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/edaff047-179d-4f74-9dcc-3acfaeb616e8
2026-01-06 05:33:53,559 - 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')
2026-01-06 05:33:53,559 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-83728170 failed!
2026-01-06 05:33:53,620 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-83782514:ctest-vn1-67619411 is 168.68.221.193 and allocation pool is NOT set
2026-01-06 05:33:53,620 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-83782514:ctest-vn1-67619411 is 102.155.216.65 and allocation pool is NOT set
2026-01-06 05:33:57,688 - 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.4 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1005ms\r\nrtt min/avg/max/mdev = 14.408/14.408/14.408/0.000 ms')
2026-01-06 05:33:57,688 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-83728170 passed
2026-01-06 05:33:57,840 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-01-06 05:33:57,840 - DEBUG - Waiting to SSH to VM ctest-vn1-vm1-83728170, IP 168.68.221.197, Port 22
2026-01-06 05:33:58,006 - DEBUG - VM ctest-vn1-vm1-83728170 is ready for SSH connections
2026-01-06 05:33:58,006 - INFO - Waiting for VM ctest-vn1-vm2-09834368 to be up..
2026-01-06 05:33:58,115 - DEBUG - VM is in ACTIVE state now
2026-01-06 05:33:58,115 - INFO - VM name : ctest-vn1-vm2-09834368
2026-01-06 05:33:58,206 - DEBUG - VM ctest-vn1-vm2-09834368 ID is d56c896e-edf5-4cb6-872b-f42b18de4138
2026-01-06 05:33:58,206 - DEBUG - VM ctest-vn1-vm2-09834368 launched on Node cn-jenkins-deploy-platform-ansible-os-4967-1
2026-01-06 05:33:58,304 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine/d56c896e-edf5-4cb6-872b-f42b18de4138
2026-01-06 05:33:58,313 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/b7e215ef-db71-4d8a-8ea9-fb1dc42c805e
2026-01-06 05:33:59,558 - 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.28 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=1.21 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 = 1.209/2.744/4.280/1.535 ms')
2026-01-06 05:33:59,558 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-vn1-vm2-09834368 passed
2026-01-06 05:33:59,708 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-01-06 05:33:59,708 - DEBUG - Waiting to SSH to VM ctest-vn1-vm2-09834368, IP 102.155.216.69, Port 22
2026-01-06 05:33:59,863 - DEBUG - VM ctest-vn1-vm2-09834368 is ready for SSH connections
2026-01-06 05:33:59,863 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-01-06 05:33:59,863 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-01-06 05:33:59,863 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-01-06 05:33:59,864 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 168.68.221.197, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.50, gateway password: c0ntrail123
2026-01-06 05:33:59,864 - DEBUG - ping -s 56 -c 3 -W 1 168.68.221.197
2026-01-06 05:34:02,573 - DEBUG - PING 168.68.221.197 (168.68.221.197): 56 data bytes
64 bytes from 168.68.221.197: seq=0 ttl=63 time=4.025 ms
64 bytes from 168.68.221.197: seq=1 ttl=63 time=1.096 ms
64 bytes from 168.68.221.197: seq=2 ttl=63 time=1.083 ms
--- 168.68.221.197 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.083/2.068/4.025 ms
2026-01-06 05:34:02,573 - INFO - Ping to IP 168.68.221.197 from VM ctest-vn1-vm2-09834368 passed
2026-01-06 05:34:02,574 - INFO - Detaching port b7e215ef-db71-4d8a-8ea9-fb1dc42c805e from VM ctest-vn1-vm2-09834368
2026-01-06 05:34:02,632 - INFO - Deleting VM ctest-vn1-vm2-09834368
2026-01-06 05:34:02,709 - INFO - Detaching port edaff047-179d-4f74-9dcc-3acfaeb616e8 from VM ctest-vn1-vm1-83728170
2026-01-06 05:34:02,742 - INFO - Deleting VM ctest-vn1-vm1-83728170
2026-01-06 05:34:02,990 - DEBUG - Response for delete_port : ()
2026-01-06 05:34:03,150 - DEBUG - Response for delete_port : ()
2026-01-06 05:34:03,150 - INFO - Deleting VN ctest-vn1-67619411
2026-01-06 05:34:03,287 - DEBUG - Response for deleting network ()
2026-01-06 05:34:03,554 - DEBUG - No XMPP flaps were noticed during the test
2026-01-06 05:34:03,554 - INFO - END TEST : test_ports_specific_subnet_ip : PASSED[0:00:21]
2026-01-06 05:34:03,554 - INFO - --------------------------------------------------------------------------------
2026-01-06 05:34:04,424 - INFO - Deleted project: ctest-TestPorts-83782514, ID : ba8e28ee-d685-4e9b-9c0b-da22fa3397fd