2026-05-14 02:02:12,655 - INFO - Domain Default found not creating
2026-05-14 02:02:12,861 - INFO - Project ctest-TestPorts-32069667 not found, creating it
2026-05-14 02:02:13,332 - INFO - Created Project:ctest-TestPorts-32069667, ID : 32d9ba3e-1292-4729-9510-993197477ec0
2026-05-14 02:02:15,057 - INFO - ================================================================================
2026-05-14 02:02:15,057 - INFO - STARTING TEST : test_ports_bindings
2026-05-14 02:02:15,057 - 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-05-14 02:02:15,313 - DEBUG - Nothing to compare xmpp stats {'10.0.0.50': {'10.20.0.17': '0'}} with
2026-05-14 02:02:15,313 - INFO - Initial checks done. Running the testcase now
2026-05-14 02:02:15,313 - INFO -
2026-05-14 02:02:15,915 - DEBUG - Response for create_network : {'network': {'id': '53514ab7-94b1-4ad6-a97a-e00b4addbff9', 'name': 'ctest-vn-25915129', 'tenant_id': '32d9ba3e129247299510993197477ec0', 'project_id': '32d9ba3e129247299510993197477ec0', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-32069667', 'ctest-vn-25915129'], 'port_security_enabled': True, 'description': ''}}
2026-05-14 02:02:16,120 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a646a11a-b3c7-4965-bfd0-389cb0b6efa6', 'name': '', 'tenant_id': '32d9ba3e129247299510993197477ec0', 'network_id': '53514ab7-94b1-4ad6-a97a-e00b4addbff9', 'ip_version': 4, 'cidr': '206.175.49.128/26', 'allocation_pools': [{'start': '206.175.49.130', 'end': '206.175.49.190'}], 'gateway_ip': '206.175.49.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '206.175.49.130', 'tags': [], 'project_id': '32d9ba3e129247299510993197477ec0'}}
2026-05-14 02:02:16,143 - INFO - Created VN ctest-vn-25915129
2026-05-14 02:02:16,195 - DEBUG - VN ctest-vn-25915129 UUID is 53514ab7-94b1-4ad6-a97a-e00b4addbff9
2026-05-14 02:02:16,304 - DEBUG - Read virtual machine interface {'fq_name': ['default-domain', 'ctest-TestPorts-32069667', 'ctest-vmi-53239802']}
2026-05-14 02:02:16,561 - DEBUG - Response for create_port : {'port': {'name': 'ctest-vmi-53239802', 'id': '74864767-a79e-4e8b-b616-f449eca64eca', 'tenant_id': '32d9ba3e129247299510993197477ec0', 'network_id': '53514ab7-94b1-4ad6-a97a-e00b4addbff9', 'mac_address': '02:74:86:47:67:a7', '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': '206.175.49.131', 'subnet_id': 'a646a11a-b3c7-4965-bfd0-389cb0b6efa6'}], 'security_groups': ['80b62740-b0a0-4a5c-9da3-b9d021424dcc'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '32d9ba3e129247299510993197477ec0'}}
2026-05-14 02:02:16,561 - DEBUG - Created port 74864767-a79e-4e8b-b616-f449eca64eca
2026-05-14 02:02:16,671 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/74864767-a79e-4e8b-b616-f449eca64eca
2026-05-14 02:02:16,979 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/74864767-a79e-4e8b-b616-f449eca64eca
2026-05-14 02:02:17,023 - INFO - VMI 74864767-a79e-4e8b-b616-f449eca64eca verification in API Server passed
2026-05-14 02:02:17,169 - DEBUG - Response for delete_port : ()
2026-05-14 02:02:17,169 - INFO - Deleted port 74864767-a79e-4e8b-b616-f449eca64eca
2026-05-14 02:02:17,169 - INFO - Deleting VN ctest-vn-25915129
2026-05-14 02:02:17,282 - DEBUG - Response for deleting network ()
2026-05-14 02:02:17,540 - DEBUG - No XMPP flaps were noticed during the test
2026-05-14 02:02:17,540 - INFO - END TEST : test_ports_bindings : PASSED[0:00:02]
2026-05-14 02:02:17,540 - INFO - --------------------------------------------------------------------------------
2026-05-14 02:02:17,543 - INFO - ================================================================================
2026-05-14 02:02:17,543 - INFO - STARTING TEST : test_ports_specific_subnet_ip
2026-05-14 02:02:17,543 - 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-05-14 02:02:17,844 - DEBUG - Nothing to compare xmpp stats {'10.0.0.50': {'10.20.0.17': '0'}} with
2026-05-14 02:02:17,845 - INFO - Initial checks done. Running the testcase now
2026-05-14 02:02:17,845 - INFO -
2026-05-14 02:02:18,030 - DEBUG - Response for create_network : {'network': {'id': '6833b0f2-c769-4049-af26-8b7895f18bce', 'name': 'ctest-vn1-33302649', 'tenant_id': '32d9ba3e129247299510993197477ec0', 'project_id': '32d9ba3e129247299510993197477ec0', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-32069667', 'ctest-vn1-33302649'], 'port_security_enabled': True, 'description': ''}}
2026-05-14 02:02:18,259 - DEBUG - Response for create_subnet : {'subnet': {'id': '78a442a6-0ad3-4cc9-a031-3b96d742bcac', 'name': '', 'tenant_id': '32d9ba3e129247299510993197477ec0', 'network_id': '6833b0f2-c769-4049-af26-8b7895f18bce', 'ip_version': 4, 'cidr': '187.144.17.64/26', 'allocation_pools': [{'start': '187.144.17.66', 'end': '187.144.17.126'}], 'gateway_ip': '187.144.17.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '187.144.17.66', 'tags': [], 'project_id': '32d9ba3e129247299510993197477ec0'}}
2026-05-14 02:02:18,405 - DEBUG - Response for create_subnet : {'subnet': {'id': '003f78a6-a5c8-4788-bd28-4ac8c31a9fd3', 'name': '', 'tenant_id': '32d9ba3e129247299510993197477ec0', 'network_id': '6833b0f2-c769-4049-af26-8b7895f18bce', 'ip_version': 4, 'cidr': '124.37.114.128/26', 'allocation_pools': [{'start': '124.37.114.130', 'end': '124.37.114.190'}], 'gateway_ip': '124.37.114.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '124.37.114.130', 'tags': [], 'project_id': '32d9ba3e129247299510993197477ec0'}}
2026-05-14 02:02:18,425 - INFO - Created VN ctest-vn1-33302649
2026-05-14 02:02:18,483 - DEBUG - VN ctest-vn1-33302649 UUID is 6833b0f2-c769-4049-af26-8b7895f18bce
2026-05-14 02:02:18,823 - DEBUG - Response for create_port : {'port': {'name': 'e7f17145-a6d5-4209-83ee-38dd7e1184bb', 'id': 'e7f17145-a6d5-4209-83ee-38dd7e1184bb', 'tenant_id': '32d9ba3e129247299510993197477ec0', 'network_id': '6833b0f2-c769-4049-af26-8b7895f18bce', 'mac_address': '02:e7:f1:71:45:a6', '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': '187.144.17.69', 'subnet_id': '78a442a6-0ad3-4cc9-a031-3b96d742bcac'}], 'security_groups': ['80b62740-b0a0-4a5c-9da3-b9d021424dcc'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '32d9ba3e129247299510993197477ec0'}}
2026-05-14 02:02:19,011 - DEBUG - Response for create_port : {'port': {'name': '834d9a7b-eab3-4723-8b6d-8693b0ce029c', 'id': '834d9a7b-eab3-4723-8b6d-8693b0ce029c', 'tenant_id': '32d9ba3e129247299510993197477ec0', 'network_id': '6833b0f2-c769-4049-af26-8b7895f18bce', 'mac_address': '02:83:4d:9a:7b:ea', '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': '124.37.114.133', 'subnet_id': '003f78a6-a5c8-4788-bd28-4ac8c31a9fd3'}], 'security_groups': ['80b62740-b0a0-4a5c-9da3-b9d021424dcc'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '32d9ba3e129247299510993197477ec0'}}
2026-05-14 02:02:19,076 - DEBUG - Services list from nova: [, , ]
2026-05-14 02:02:19,503 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-5776-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-5776-1)
2026-05-14 02:02:20,009 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-5776-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-5776-1)
2026-05-14 02:02:20,009 - INFO - Waiting for VM ctest-vn1-vm1-98376109 to be up..
2026-05-14 02:02:20,070 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-05-14 02:02:25,159 - DEBUG - VM is in ACTIVE state now
2026-05-14 02:02:25,159 - INFO - VM name : ctest-vn1-vm1-98376109
2026-05-14 02:02:25,257 - DEBUG - VM ctest-vn1-vm1-98376109 ID is 7893b6b9-9d52-4a43-9430-5878141f0fae
2026-05-14 02:02:25,278 - DEBUG - VM ctest-vn1-vm1-98376109 launched on Node cn-jenkins-deploy-platform-ansible-os-5776-1
2026-05-14 02:02:25,362 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine/7893b6b9-9d52-4a43-9430-5878141f0fae
2026-05-14 02:02:25,370 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/e7f17145-a6d5-4209-83ee-38dd7e1184bb
2026-05-14 02:02:28,616 - 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 1014ms')
2026-05-14 02:02:28,616 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-98376109 failed!
2026-05-14 02:02:28,671 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-32069667:ctest-vn1-33302649 is 187.144.17.65 and allocation pool is NOT set
2026-05-14 02:02:28,671 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-32069667:ctest-vn1-33302649 is 124.37.114.129 and allocation pool is NOT set
2026-05-14 02:02:32,744 - 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=7.27 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1018ms\r\nrtt min/avg/max/mdev = 7.268/7.268/7.268/0.000 ms')
2026-05-14 02:02:32,744 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-98376109 passed
2026-05-14 02:02:32,895 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-05-14 02:02:32,895 - DEBUG - Waiting to SSH to VM ctest-vn1-vm1-98376109, IP 187.144.17.69, Port 22
2026-05-14 02:02:33,061 - DEBUG - VM ctest-vn1-vm1-98376109 is ready for SSH connections
2026-05-14 02:02:33,061 - INFO - Waiting for VM ctest-vn1-vm2-91186554 to be up..
2026-05-14 02:02:33,150 - DEBUG - VM is in ACTIVE state now
2026-05-14 02:02:33,150 - INFO - VM name : ctest-vn1-vm2-91186554
2026-05-14 02:02:33,235 - DEBUG - VM ctest-vn1-vm2-91186554 ID is 7b5d984e-9f3c-4cd7-b948-3a87c2450f04
2026-05-14 02:02:33,235 - DEBUG - VM ctest-vn1-vm2-91186554 launched on Node cn-jenkins-deploy-platform-ansible-os-5776-1
2026-05-14 02:02:33,329 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine/7b5d984e-9f3c-4cd7-b948-3a87c2450f04
2026-05-14 02:02:33,340 - DEBUG - Requesting: http://10.0.0.50:8082/virtual-machine-interface/834d9a7b-eab3-4723-8b6d-8693b0ce029c
2026-05-14 02:02:34,590 - 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.24 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.511 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.511/1.876/3.242/1.365 ms')
2026-05-14 02:02:34,590 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-vn1-vm2-91186554 passed
2026-05-14 02:02:34,747 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-05-14 02:02:34,747 - DEBUG - Waiting to SSH to VM ctest-vn1-vm2-91186554, IP 124.37.114.133, Port 22
2026-05-14 02:02:34,902 - DEBUG - VM ctest-vn1-vm2-91186554 is ready for SSH connections
2026-05-14 02:02:34,902 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-05-14 02:02:34,902 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-05-14 02:02:34,902 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-05-14 02:02:34,902 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 187.144.17.69, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.50, gateway password: c0ntrail123
2026-05-14 02:02:34,902 - DEBUG - ping -s 56 -c 3 -W 1 187.144.17.69
2026-05-14 02:02:37,587 - DEBUG - PING 187.144.17.69 (187.144.17.69): 56 data bytes
64 bytes from 187.144.17.69: seq=0 ttl=63 time=4.127 ms
64 bytes from 187.144.17.69: seq=1 ttl=63 time=1.240 ms
64 bytes from 187.144.17.69: seq=2 ttl=63 time=0.970 ms
--- 187.144.17.69 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.970/2.112/4.127 ms
2026-05-14 02:02:37,587 - INFO - Ping to IP 187.144.17.69 from VM ctest-vn1-vm2-91186554 passed
2026-05-14 02:02:37,588 - INFO - Detaching port 834d9a7b-eab3-4723-8b6d-8693b0ce029c from VM ctest-vn1-vm2-91186554
2026-05-14 02:02:37,649 - INFO - Deleting VM ctest-vn1-vm2-91186554
2026-05-14 02:02:37,724 - INFO - Detaching port e7f17145-a6d5-4209-83ee-38dd7e1184bb from VM ctest-vn1-vm1-98376109
2026-05-14 02:02:37,759 - INFO - Deleting VM ctest-vn1-vm1-98376109
2026-05-14 02:02:38,004 - DEBUG - Response for delete_port : ()
2026-05-14 02:02:38,183 - DEBUG - Response for delete_port : ()
2026-05-14 02:02:38,184 - INFO - Deleting VN ctest-vn1-33302649
2026-05-14 02:02:38,339 - DEBUG - Response for deleting network ()
2026-05-14 02:02:38,601 - DEBUG - No XMPP flaps were noticed during the test
2026-05-14 02:02:38,601 - INFO - END TEST : test_ports_specific_subnet_ip : PASSED[0:00:21]
2026-05-14 02:02:38,601 - INFO - --------------------------------------------------------------------------------
2026-05-14 02:02:39,321 - INFO - Deleted project: ctest-TestPorts-32069667, ID : 32d9ba3e-1292-4729-9510-993197477ec0