2026-08-25 08:21:17,073 - INFO - Domain Default found not creating
2026-08-25 08:21:17,244 - INFO - Project ctest-TestPorts-93556895 not found, creating it
2026-08-25 08:21:17,760 - INFO - Created Project:ctest-TestPorts-93556895, ID : 463faacc-77b1-4357-a955-bb068eb47049
2026-08-25 08:21:19,284 - INFO - ================================================================================
2026-08-25 08:21:19,285 - INFO - STARTING TEST : test_ports_bindings
2026-08-25 08:21:19,285 - 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-08-25 08:21:19,546 - DEBUG - Nothing to compare xmpp stats {'10.0.0.177': {'10.20.0.14': '0'}} with
2026-08-25 08:21:19,546 - INFO - Initial checks done. Running the testcase now
2026-08-25 08:21:19,546 - INFO -
2026-08-25 08:21:20,166 - DEBUG - Response for create_network : {'network': {'id': '104fcb41-cea3-4e54-b0cb-7b9bf3f7b9d0', 'name': 'ctest-vn-99138303', 'tenant_id': '463faacc77b14357a955bb068eb47049', 'project_id': '463faacc77b14357a955bb068eb47049', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-93556895', 'ctest-vn-99138303'], 'port_security_enabled': True, 'description': ''}}
2026-08-25 08:21:20,389 - DEBUG - Response for create_subnet : {'subnet': {'id': '896a1b63-5eba-4cdf-8b08-288e41a5c2b5', 'name': '', 'tenant_id': '463faacc77b14357a955bb068eb47049', 'network_id': '104fcb41-cea3-4e54-b0cb-7b9bf3f7b9d0', 'ip_version': 4, 'cidr': '191.52.10.128/26', 'allocation_pools': [{'start': '191.52.10.130', 'end': '191.52.10.190'}], 'gateway_ip': '191.52.10.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '191.52.10.130', 'tags': [], 'project_id': '463faacc77b14357a955bb068eb47049'}}
2026-08-25 08:21:20,407 - INFO - Created VN ctest-vn-99138303
2026-08-25 08:21:20,459 - DEBUG - VN ctest-vn-99138303 UUID is 104fcb41-cea3-4e54-b0cb-7b9bf3f7b9d0
2026-08-25 08:21:20,563 - DEBUG - Read virtual machine interface {'fq_name': ['default-domain', 'ctest-TestPorts-93556895', 'ctest-vmi-91581252']}
2026-08-25 08:21:20,861 - DEBUG - Response for create_port : {'port': {'name': 'ctest-vmi-91581252', 'id': 'cfb835d8-a7a4-4102-8f03-0afe1a754f83', 'tenant_id': '463faacc77b14357a955bb068eb47049', 'network_id': '104fcb41-cea3-4e54-b0cb-7b9bf3f7b9d0', 'mac_address': '02:cf:b8:35:d8: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': '191.52.10.131', 'subnet_id': '896a1b63-5eba-4cdf-8b08-288e41a5c2b5'}], 'security_groups': ['140680d9-7826-4fd0-b310-36f12884889a'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'tags': [], 'port_security_enabled': True, 'description': '', 'project_id': '463faacc77b14357a955bb068eb47049'}}
2026-08-25 08:21:20,861 - DEBUG - Created port cfb835d8-a7a4-4102-8f03-0afe1a754f83
2026-08-25 08:21:20,967 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-machine-interface/cfb835d8-a7a4-4102-8f03-0afe1a754f83
2026-08-25 08:21:21,294 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-machine-interface/cfb835d8-a7a4-4102-8f03-0afe1a754f83
2026-08-25 08:21:21,328 - INFO - VMI cfb835d8-a7a4-4102-8f03-0afe1a754f83 verification in API Server passed
2026-08-25 08:21:21,438 - DEBUG - Response for delete_port : ()
2026-08-25 08:21:21,438 - INFO - Deleted port cfb835d8-a7a4-4102-8f03-0afe1a754f83
2026-08-25 08:21:21,438 - INFO - Deleting VN ctest-vn-99138303
2026-08-25 08:21:21,564 - DEBUG - Response for deleting network ()
2026-08-25 08:21:21,839 - DEBUG - No XMPP flaps were noticed during the test
2026-08-25 08:21:21,839 - INFO - END TEST : test_ports_bindings : PASSED[0:00:02]
2026-08-25 08:21:21,839 - INFO - --------------------------------------------------------------------------------
2026-08-25 08:21:21,843 - INFO - ================================================================================
2026-08-25 08:21:21,843 - INFO - STARTING TEST : test_ports_specific_subnet_ip
2026-08-25 08:21:21,843 - 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-08-25 08:21:22,136 - DEBUG - Nothing to compare xmpp stats {'10.0.0.177': {'10.20.0.14': '0'}} with
2026-08-25 08:21:22,136 - INFO - Initial checks done. Running the testcase now
2026-08-25 08:21:22,136 - INFO -
2026-08-25 08:21:22,333 - DEBUG - Response for create_network : {'network': {'id': '9458eaab-9b94-40a1-94f6-33fc189d381f', 'name': 'ctest-vn1-32677563', 'tenant_id': '463faacc77b14357a955bb068eb47049', 'project_id': '463faacc77b14357a955bb068eb47049', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-93556895', 'ctest-vn1-32677563'], 'port_security_enabled': True, 'description': ''}}
2026-08-25 08:21:22,540 - DEBUG - Response for create_subnet : {'subnet': {'id': '50204826-b735-47ca-a976-b3793735b4e4', 'name': '', 'tenant_id': '463faacc77b14357a955bb068eb47049', 'network_id': '9458eaab-9b94-40a1-94f6-33fc189d381f', 'ip_version': 4, 'cidr': '65.184.134.0/26', 'allocation_pools': [{'start': '65.184.134.2', 'end': '65.184.134.62'}], 'gateway_ip': '65.184.134.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '65.184.134.2', 'tags': [], 'project_id': '463faacc77b14357a955bb068eb47049'}}
2026-08-25 08:21:22,766 - DEBUG - Response for create_subnet : {'subnet': {'id': '6e22a45e-6ddf-4033-b63e-a28f0781075a', 'name': '', 'tenant_id': '463faacc77b14357a955bb068eb47049', 'network_id': '9458eaab-9b94-40a1-94f6-33fc189d381f', 'ip_version': 4, 'cidr': '86.54.199.0/26', 'allocation_pools': [{'start': '86.54.199.2', 'end': '86.54.199.62'}], 'gateway_ip': '86.54.199.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '86.54.199.2', 'tags': [], 'project_id': '463faacc77b14357a955bb068eb47049'}}
2026-08-25 08:21:22,784 - INFO - Created VN ctest-vn1-32677563
2026-08-25 08:21:22,839 - DEBUG - VN ctest-vn1-32677563 UUID is 9458eaab-9b94-40a1-94f6-33fc189d381f
2026-08-25 08:21:23,169 - DEBUG - Response for create_port : {'port': {'name': 'dff1d0b4-ae48-4d73-98a7-08e3d3159c0c', 'id': 'dff1d0b4-ae48-4d73-98a7-08e3d3159c0c', 'tenant_id': '463faacc77b14357a955bb068eb47049', 'network_id': '9458eaab-9b94-40a1-94f6-33fc189d381f', 'mac_address': '02:df:f1:d0:b4:ae', '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': '65.184.134.5', 'subnet_id': '50204826-b735-47ca-a976-b3793735b4e4'}], 'security_groups': ['140680d9-7826-4fd0-b310-36f12884889a'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'tags': [], 'port_security_enabled': True, 'description': '', 'project_id': '463faacc77b14357a955bb068eb47049'}}
2026-08-25 08:21:23,367 - DEBUG - Response for create_port : {'port': {'name': 'a52e7255-aafe-4f73-9507-20e0b4c0f43b', 'id': 'a52e7255-aafe-4f73-9507-20e0b4c0f43b', 'tenant_id': '463faacc77b14357a955bb068eb47049', 'network_id': '9458eaab-9b94-40a1-94f6-33fc189d381f', 'mac_address': '02:a5:2e:72:55:aa', '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': '86.54.199.5', 'subnet_id': '6e22a45e-6ddf-4033-b63e-a28f0781075a'}], 'security_groups': ['140680d9-7826-4fd0-b310-36f12884889a'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'tags': [], 'port_security_enabled': True, 'description': '', 'project_id': '463faacc77b14357a955bb068eb47049'}}
2026-08-25 08:21:23,426 - DEBUG - Services list from nova: [, , ]
2026-08-25 08:21:23,824 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-6219-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-6219-1)
2026-08-25 08:21:24,254 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-6219-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-6219-1)
2026-08-25 08:21:24,254 - INFO - Waiting for VM ctest-vn1-vm1-74811433 to be up..
2026-08-25 08:21:24,302 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-08-25 08:21:29,353 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-08-25 08:21:34,429 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-08-25 08:21:39,509 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-08-25 08:21:44,584 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-08-25 08:21:49,672 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-08-25 08:21:54,749 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-08-25 08:21:59,831 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-08-25 08:22:04,912 - DEBUG - VM is in ACTIVE state now
2026-08-25 08:22:04,912 - INFO - VM name : ctest-vn1-vm1-74811433
2026-08-25 08:22:04,992 - DEBUG - VM ctest-vn1-vm1-74811433 ID is 0bfb4816-ecd5-454d-bfcd-d1c9acc4c46e
2026-08-25 08:22:05,013 - DEBUG - VM ctest-vn1-vm1-74811433 launched on Node cn-jenkins-deploy-platform-ansible-os-6219-1
2026-08-25 08:22:05,100 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-machine/0bfb4816-ecd5-454d-bfcd-d1c9acc4c46e
2026-08-25 08:22:05,109 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-machine-interface/dff1d0b4-ae48-4d73-98a7-08e3d3159c0c
2026-08-25 08:22:08,379 - DEBUG - (True, 'PING 169.254.0.4 (169.254.0.4) 56(84) bytes of data.\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1022ms')
2026-08-25 08:22:08,379 - DEBUG - Ping to Metadata IP 169.254.0.4 of VM ctest-vn1-vm1-74811433 failed!
2026-08-25 08:22:08,435 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-93556895:ctest-vn1-32677563 is 65.184.134.1 and allocation pool is NOT set
2026-08-25 08:22:08,435 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-93556895:ctest-vn1-32677563 is 86.54.199.1 and allocation pool is NOT set
2026-08-25 08:22:10,495 - 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=13.5 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=1.95 ms\r\n\r\n--- 169.254.0.4 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1002ms\r\nrtt min/avg/max/mdev = 1.954/7.750/13.546/5.796 ms')
2026-08-25 08:22:10,495 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-vn1-vm1-74811433 passed
2026-08-25 08:22:10,647 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-08-25 08:22:10,647 - DEBUG - Waiting to SSH to VM ctest-vn1-vm1-74811433, IP 65.184.134.5, Port 22
2026-08-25 08:22:10,713 - DEBUG - Error on ssh to cirros@169.254.0.4:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.4/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.4/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.4/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2026-08-25 08:22:10,790 - DEBUG - VM ctest-vn1-vm1-74811433 is NOT ready for SSH connections, VM status: ACTIVE
2026-08-25 08:22:15,791 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-08-25 08:22:15,791 - DEBUG - Waiting to SSH to VM ctest-vn1-vm1-74811433, IP 65.184.134.5, Port 22
2026-08-25 08:22:15,956 - DEBUG - VM ctest-vn1-vm1-74811433 is ready for SSH connections
2026-08-25 08:22:15,956 - INFO - Waiting for VM ctest-vn1-vm2-56937403 to be up..
2026-08-25 08:22:16,031 - DEBUG - VM is in ACTIVE state now
2026-08-25 08:22:16,031 - INFO - VM name : ctest-vn1-vm2-56937403
2026-08-25 08:22:16,106 - DEBUG - VM ctest-vn1-vm2-56937403 ID is b62cd9d3-bcaa-45a6-8bf7-26854bddaa08
2026-08-25 08:22:16,106 - DEBUG - VM ctest-vn1-vm2-56937403 launched on Node cn-jenkins-deploy-platform-ansible-os-6219-1
2026-08-25 08:22:16,172 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-machine/b62cd9d3-bcaa-45a6-8bf7-26854bddaa08
2026-08-25 08:22:16,181 - DEBUG - Requesting: http://10.0.0.177:8082/virtual-machine-interface/a52e7255-aafe-4f73-9507-20e0b4c0f43b
2026-08-25 08:22:17,419 - 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=3.70 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.501 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 = 0.501/2.100/3.699/1.599 ms')
2026-08-25 08:22:17,420 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm2-56937403 passed
2026-08-25 08:22:17,575 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-08-25 08:22:17,575 - DEBUG - Waiting to SSH to VM ctest-vn1-vm2-56937403, IP 86.54.199.5, Port 22
2026-08-25 08:22:17,742 - DEBUG - VM ctest-vn1-vm2-56937403 is ready for SSH connections
2026-08-25 08:22:17,742 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-08-25 08:22:17,742 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-08-25 08:22:17,742 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-08-25 08:22:17,742 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 65.184.134.5, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.177, gateway password: c0ntrail123
2026-08-25 08:22:17,743 - DEBUG - ping -s 56 -c 3 -W 1 65.184.134.5
2026-08-25 08:22:21,732 - DEBUG - PING 65.184.134.5 (65.184.134.5): 56 data bytes
64 bytes from 65.184.134.5: seq=0 ttl=63 time=3.937 ms
64 bytes from 65.184.134.5: seq=1 ttl=63 time=1.105 ms
64 bytes from 65.184.134.5: seq=2 ttl=63 time=1.149 ms
--- 65.184.134.5 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.105/2.063/3.937 ms
2026-08-25 08:22:21,733 - INFO - Ping to IP 65.184.134.5 from VM ctest-vn1-vm2-56937403 passed
2026-08-25 08:22:21,733 - INFO - Detaching port a52e7255-aafe-4f73-9507-20e0b4c0f43b from VM ctest-vn1-vm2-56937403
2026-08-25 08:22:21,786 - INFO - Deleting VM ctest-vn1-vm2-56937403
2026-08-25 08:22:21,861 - INFO - Detaching port dff1d0b4-ae48-4d73-98a7-08e3d3159c0c from VM ctest-vn1-vm1-74811433
2026-08-25 08:22:21,895 - INFO - Deleting VM ctest-vn1-vm1-74811433
2026-08-25 08:22:22,139 - DEBUG - Response for delete_port : ()
2026-08-25 08:22:22,293 - DEBUG - Response for delete_port : ()
2026-08-25 08:22:22,294 - INFO - Deleting VN ctest-vn1-32677563
2026-08-25 08:22:22,426 - DEBUG - Response for deleting network ()
2026-08-25 08:22:22,699 - DEBUG - No XMPP flaps were noticed during the test
2026-08-25 08:22:22,699 - INFO - END TEST : test_ports_specific_subnet_ip : PASSED[0:01:01]
2026-08-25 08:22:22,699 - INFO - --------------------------------------------------------------------------------
2026-08-25 08:22:23,415 - INFO - Deleted project: ctest-TestPorts-93556895, ID : 463faacc-77b1-4357-a955-bb068eb47049