2026-02-07 14:36:40,372 - INFO - Domain Default found not creating
2026-02-07 14:36:40,519 - INFO - Project ctest-TestPorts-06383930 not found, creating it
2026-02-07 14:36:40,975 - INFO - Created Project:ctest-TestPorts-06383930, ID : 8caadea6-cd57-4d55-a980-51a9eca8f11c
2026-02-07 14:36:42,509 - INFO - ================================================================================
2026-02-07 14:36:42,509 - INFO - STARTING TEST : test_ports_bindings
2026-02-07 14:36:42,509 - 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-02-07 14:36:42,769 - DEBUG - Nothing to compare xmpp stats {'10.0.0.33': {'10.20.0.17': '0'}} with
2026-02-07 14:36:42,769 - INFO - Initial checks done. Running the testcase now
2026-02-07 14:36:42,769 - INFO -
2026-02-07 14:36:43,482 - DEBUG - Response for create_network : {'network': {'id': '880b943f-2ae0-46e5-aadb-f930ecbb7e84', 'name': 'ctest-vn-83150092', 'tenant_id': '8caadea6cd574d55a98051a9eca8f11c', 'project_id': '8caadea6cd574d55a98051a9eca8f11c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-06383930', 'ctest-vn-83150092'], 'port_security_enabled': True, 'description': ''}}
2026-02-07 14:36:43,859 - DEBUG - Response for create_subnet : {'subnet': {'id': '455be1cc-8a69-45a6-8c83-8ddfbbfccb4a', 'name': '', 'tenant_id': '8caadea6cd574d55a98051a9eca8f11c', 'network_id': '880b943f-2ae0-46e5-aadb-f930ecbb7e84', 'ip_version': 4, 'cidr': '44.244.29.64/26', 'allocation_pools': [{'start': '44.244.29.66', 'end': '44.244.29.126'}], 'gateway_ip': '44.244.29.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '44.244.29.66', 'tags': [], 'project_id': '8caadea6cd574d55a98051a9eca8f11c'}}
2026-02-07 14:36:43,884 - INFO - Created VN ctest-vn-83150092
2026-02-07 14:36:43,938 - DEBUG - VN ctest-vn-83150092 UUID is 880b943f-2ae0-46e5-aadb-f930ecbb7e84
2026-02-07 14:36:44,048 - DEBUG - Read virtual machine interface {'fq_name': ['default-domain', 'ctest-TestPorts-06383930', 'ctest-vmi-82756500']}
2026-02-07 14:36:44,331 - DEBUG - Response for create_port : {'port': {'name': 'ctest-vmi-82756500', 'id': '5bf05a8d-c60e-4fde-9343-212e8e06c7cb', 'tenant_id': '8caadea6cd574d55a98051a9eca8f11c', 'network_id': '880b943f-2ae0-46e5-aadb-f930ecbb7e84', 'mac_address': '02:5b:f0:5a:8d:c6', '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': '44.244.29.67', 'subnet_id': '455be1cc-8a69-45a6-8c83-8ddfbbfccb4a'}], 'security_groups': ['ed3776d1-73e9-419f-b723-38fc42e685f1'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '8caadea6cd574d55a98051a9eca8f11c'}}
2026-02-07 14:36:44,331 - DEBUG - Created port 5bf05a8d-c60e-4fde-9343-212e8e06c7cb
2026-02-07 14:36:44,434 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/5bf05a8d-c60e-4fde-9343-212e8e06c7cb
2026-02-07 14:36:44,724 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/5bf05a8d-c60e-4fde-9343-212e8e06c7cb
2026-02-07 14:36:44,758 - INFO - VMI 5bf05a8d-c60e-4fde-9343-212e8e06c7cb verification in API Server passed
2026-02-07 14:36:44,849 - DEBUG - Response for delete_port : ()
2026-02-07 14:36:44,849 - INFO - Deleted port 5bf05a8d-c60e-4fde-9343-212e8e06c7cb
2026-02-07 14:36:44,849 - INFO - Deleting VN ctest-vn-83150092
2026-02-07 14:36:44,941 - DEBUG - Response for deleting network ()
2026-02-07 14:36:45,195 - DEBUG - No XMPP flaps were noticed during the test
2026-02-07 14:36:45,195 - INFO - END TEST : test_ports_bindings : PASSED[0:00:03]
2026-02-07 14:36:45,195 - INFO - --------------------------------------------------------------------------------
2026-02-07 14:36:45,197 - INFO - ================================================================================
2026-02-07 14:36:45,197 - INFO - STARTING TEST : test_ports_specific_subnet_ip
2026-02-07 14:36:45,197 - 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-02-07 14:36:45,483 - DEBUG - Nothing to compare xmpp stats {'10.0.0.33': {'10.20.0.17': '0'}} with
2026-02-07 14:36:45,483 - INFO - Initial checks done. Running the testcase now
2026-02-07 14:36:45,483 - INFO -
2026-02-07 14:36:45,651 - DEBUG - Response for create_network : {'network': {'id': 'cabb1935-3436-43a6-89f4-760db7585fb4', 'name': 'ctest-vn1-34160508', 'tenant_id': '8caadea6cd574d55a98051a9eca8f11c', 'project_id': '8caadea6cd574d55a98051a9eca8f11c', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestPorts-06383930', 'ctest-vn1-34160508'], 'port_security_enabled': True, 'description': ''}}
2026-02-07 14:36:45,858 - DEBUG - Response for create_subnet : {'subnet': {'id': '781393af-ae8b-4b18-b16e-2a6772a4d749', 'name': '', 'tenant_id': '8caadea6cd574d55a98051a9eca8f11c', 'network_id': 'cabb1935-3436-43a6-89f4-760db7585fb4', 'ip_version': 4, 'cidr': '47.138.77.192/26', 'allocation_pools': [{'start': '47.138.77.194', 'end': '47.138.77.254'}], 'gateway_ip': '47.138.77.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '47.138.77.194', 'tags': [], 'project_id': '8caadea6cd574d55a98051a9eca8f11c'}}
2026-02-07 14:36:46,028 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd7db2418-4460-41ce-a08a-1bb64a97e68b', 'name': '', 'tenant_id': '8caadea6cd574d55a98051a9eca8f11c', 'network_id': 'cabb1935-3436-43a6-89f4-760db7585fb4', 'ip_version': 4, 'cidr': '190.219.156.192/26', 'allocation_pools': [{'start': '190.219.156.194', 'end': '190.219.156.254'}], 'gateway_ip': '190.219.156.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '190.219.156.194', 'tags': [], 'project_id': '8caadea6cd574d55a98051a9eca8f11c'}}
2026-02-07 14:36:46,045 - INFO - Created VN ctest-vn1-34160508
2026-02-07 14:36:46,094 - DEBUG - VN ctest-vn1-34160508 UUID is cabb1935-3436-43a6-89f4-760db7585fb4
2026-02-07 14:36:46,377 - DEBUG - Response for create_port : {'port': {'name': 'aa204ed3-def2-4e31-996a-1911be41dcba', 'id': 'aa204ed3-def2-4e31-996a-1911be41dcba', 'tenant_id': '8caadea6cd574d55a98051a9eca8f11c', 'network_id': 'cabb1935-3436-43a6-89f4-760db7585fb4', 'mac_address': '02:aa:20:4e:d3:de', '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': '47.138.77.197', 'subnet_id': '781393af-ae8b-4b18-b16e-2a6772a4d749'}], 'security_groups': ['ed3776d1-73e9-419f-b723-38fc42e685f1'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '8caadea6cd574d55a98051a9eca8f11c'}}
2026-02-07 14:36:46,539 - DEBUG - Response for create_port : {'port': {'name': 'b6bb524b-2616-4b56-b094-b05b9d6760a3', 'id': 'b6bb524b-2616-4b56-b094-b05b9d6760a3', 'tenant_id': '8caadea6cd574d55a98051a9eca8f11c', 'network_id': 'cabb1935-3436-43a6-89f4-760db7585fb4', 'mac_address': '02:b6:bb:52:4b:26', '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': '190.219.156.197', 'subnet_id': 'd7db2418-4460-41ce-a08a-1bb64a97e68b'}], 'security_groups': ['ed3776d1-73e9-419f-b723-38fc42e685f1'], 'admin_state_up': True, 'device_id': '', 'device_owner': '', 'status': 'DOWN', 'port_security_enabled': True, 'description': '', 'project_id': '8caadea6cd574d55a98051a9eca8f11c'}}
2026-02-07 14:36:46,591 - DEBUG - Services list from nova: [, , ]
2026-02-07 14:36:46,905 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-5231-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-5231-1)
2026-02-07 14:36:47,269 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-5231-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-5231-1)
2026-02-07 14:36:47,270 - INFO - Waiting for VM ctest-vn1-vm1-83856889 to be up..
2026-02-07 14:36:47,309 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-02-07 14:36:52,379 - DEBUG - VM is in ACTIVE state now
2026-02-07 14:36:52,379 - INFO - VM name : ctest-vn1-vm1-83856889
2026-02-07 14:36:52,446 - DEBUG - VM ctest-vn1-vm1-83856889 ID is 3aa94177-25c3-4506-a48b-2d70dd3ec986
2026-02-07 14:36:52,465 - DEBUG - VM ctest-vn1-vm1-83856889 launched on Node cn-jenkins-deploy-platform-ansible-os-5231-1
2026-02-07 14:36:52,530 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine/3aa94177-25c3-4506-a48b-2d70dd3ec986
2026-02-07 14:36:52,537 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/aa204ed3-def2-4e31-996a-1911be41dcba
2026-02-07 14:36:55,794 - 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 1032ms')
2026-02-07 14:36:55,794 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-83856889 failed!
2026-02-07 14:36:55,850 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-06383930:ctest-vn1-34160508 is 47.138.77.193 and allocation pool is NOT set
2026-02-07 14:36:55,850 - DEBUG - Gateway for vn default-domain:ctest-TestPorts-06383930:ctest-vn1-34160508 is 190.219.156.193 and allocation pool is NOT set
2026-02-07 14:36:57,910 - 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=6.88 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.344 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.344/3.613/6.883/3.269 ms')
2026-02-07 14:36:57,910 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-vn1-vm1-83856889 passed
2026-02-07 14:36:58,062 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-07 14:36:58,063 - DEBUG - Waiting to SSH to VM ctest-vn1-vm1-83856889, IP 47.138.77.197, Port 22
2026-02-07 14:36:58,218 - DEBUG - VM ctest-vn1-vm1-83856889 is ready for SSH connections
2026-02-07 14:36:58,218 - INFO - Waiting for VM ctest-vn1-vm2-46186276 to be up..
2026-02-07 14:36:58,294 - DEBUG - VM is in ACTIVE state now
2026-02-07 14:36:58,294 - INFO - VM name : ctest-vn1-vm2-46186276
2026-02-07 14:36:58,361 - DEBUG - VM ctest-vn1-vm2-46186276 ID is 59df5c0a-2cf7-4409-9886-9f1addf77f23
2026-02-07 14:36:58,361 - DEBUG - VM ctest-vn1-vm2-46186276 launched on Node cn-jenkins-deploy-platform-ansible-os-5231-1
2026-02-07 14:36:58,430 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine/59df5c0a-2cf7-4409-9886-9f1addf77f23
2026-02-07 14:36:58,437 - DEBUG - Requesting: http://10.0.0.33:8082/virtual-machine-interface/b6bb524b-2616-4b56-b094-b05b9d6760a3
2026-02-07 14:36:59,673 - 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.89 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.495 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 = 0.495/1.691/2.888/1.196 ms')
2026-02-07 14:36:59,673 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-vn1-vm2-46186276 passed
2026-02-07 14:36:59,822 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-07 14:36:59,823 - DEBUG - Waiting to SSH to VM ctest-vn1-vm2-46186276, IP 190.219.156.197, Port 22
2026-02-07 14:36:59,974 - DEBUG - VM ctest-vn1-vm2-46186276 is ready for SSH connections
2026-02-07 14:36:59,974 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-07 14:36:59,974 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-07 14:36:59,974 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-02-07 14:36:59,974 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 47.138.77.197, host_string: cirros@169.254.0.4, password: cubswin:)gateway: ubuntu@10.0.0.33, gateway password: c0ntrail123
2026-02-07 14:36:59,974 - DEBUG - ping -s 56 -c 3 -W 1 47.138.77.197
2026-02-07 14:37:02,617 - DEBUG - PING 47.138.77.197 (47.138.77.197): 56 data bytes
64 bytes from 47.138.77.197: seq=0 ttl=63 time=3.326 ms
64 bytes from 47.138.77.197: seq=1 ttl=63 time=0.805 ms
64 bytes from 47.138.77.197: seq=2 ttl=63 time=0.814 ms
--- 47.138.77.197 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 0.805/1.648/3.326 ms
2026-02-07 14:37:02,617 - INFO - Ping to IP 47.138.77.197 from VM ctest-vn1-vm2-46186276 passed
2026-02-07 14:37:02,617 - INFO - Detaching port b6bb524b-2616-4b56-b094-b05b9d6760a3 from VM ctest-vn1-vm2-46186276
2026-02-07 14:37:02,664 - INFO - Deleting VM ctest-vn1-vm2-46186276
2026-02-07 14:37:02,739 - INFO - Detaching port aa204ed3-def2-4e31-996a-1911be41dcba from VM ctest-vn1-vm1-83856889
2026-02-07 14:37:02,776 - INFO - Deleting VM ctest-vn1-vm1-83856889
2026-02-07 14:37:02,980 - DEBUG - Response for delete_port : ()
2026-02-07 14:37:03,117 - DEBUG - Response for delete_port : ()
2026-02-07 14:37:03,117 - INFO - Deleting VN ctest-vn1-34160508
2026-02-07 14:37:03,236 - DEBUG - Response for deleting network ()
2026-02-07 14:37:03,491 - DEBUG - No XMPP flaps were noticed during the test
2026-02-07 14:37:03,491 - INFO - END TEST : test_ports_specific_subnet_ip : PASSED[0:00:18]
2026-02-07 14:37:03,491 - INFO - --------------------------------------------------------------------------------
2026-02-07 14:37:04,190 - INFO - Deleted project: ctest-TestPorts-06383930, ID : 8caadea6-cd57-4d55-a980-51a9eca8f11c