2026-05-12 11:45:53,684 - INFO - Domain Default found not creating 2026-05-12 11:45:53,872 - INFO - Project ctest-TestRoutersBasic-69932723 not found, creating it 2026-05-12 11:45:54,417 - INFO - Created Project:ctest-TestRoutersBasic-69932723, ID : 722aa9af-1a54-49d7-880c-25f1bd7f488a 2026-05-12 11:45:56,105 - INFO - ================================================================================ 2026-05-12 11:45:56,105 - INFO - STARTING TEST : test_basic_snat_behavior_without_external_connectivity 2026-05-12 11:45:56,105 - INFO - TEST DESCRIPTION : Create an external network, a router set router-gateway to external network launch a private network and attach it to router validate left vm pinging right vm through Snat 2026-05-12 11:45:56,374 - DEBUG - Nothing to compare xmpp stats {'10.0.0.22': {'10.20.0.17': '0'}} with 2026-05-12 11:45:56,374 - INFO - Initial checks done. Running the testcase now 2026-05-12 11:45:56,374 - INFO - 2026-05-12 11:45:57,173 - INFO - Default SG to be edited for allow all on project: ctest-TestRoutersBasic-69932723 2026-05-12 11:45:57,274 - INFO - Adding rules to the default security group in Project ctest-TestRoutersBasic-69932723 2026-05-12 11:45:57,602 - DEBUG - Reading firewall policy {'fq_name': ['default-domain', 'ctest-TestRoutersBasic-69932723', 'default']} 2026-05-12 11:45:57,930 - DEBUG - Response for create_network : {'network': {'id': 'df5053ce-8774-4f10-af89-c3de7f15970a', 'name': 'ctest-vn-49098510', 'tenant_id': '722aa9af1a5449d7880c25f1bd7f488a', 'project_id': '722aa9af1a5449d7880c25f1bd7f488a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRoutersBasic-69932723', 'ctest-vn-49098510'], 'port_security_enabled': True, 'description': ''}} 2026-05-12 11:45:58,111 - DEBUG - Response for create_subnet : {'subnet': {'id': '69d26cad-1041-45eb-92f9-dc6550aa33c7', 'name': '', 'tenant_id': '722aa9af1a5449d7880c25f1bd7f488a', 'network_id': 'df5053ce-8774-4f10-af89-c3de7f15970a', 'ip_version': 4, 'cidr': '202.54.211.192/26', 'allocation_pools': [{'start': '202.54.211.194', 'end': '202.54.211.254'}], 'gateway_ip': '202.54.211.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '202.54.211.194', 'tags': [], 'project_id': '722aa9af1a5449d7880c25f1bd7f488a'}} 2026-05-12 11:45:58,135 - INFO - Created VN ctest-vn-49098510 2026-05-12 11:45:58,190 - DEBUG - VN ctest-vn-49098510 UUID is df5053ce-8774-4f10-af89-c3de7f15970a 2026-05-12 11:45:58,541 - DEBUG - Response for create_network : {'network': {'id': 'bc51081d-038d-4797-91a4-353b48d89d5d', 'name': 'ctest-ext_vn-72231552', 'tenant_id': '722aa9af1a5449d7880c25f1bd7f488a', 'project_id': '722aa9af1a5449d7880c25f1bd7f488a', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': True, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRoutersBasic-69932723', 'ctest-ext_vn-72231552'], 'port_security_enabled': True, 'description': ''}} 2026-05-12 11:45:58,746 - DEBUG - Response for create_subnet : {'subnet': {'id': '8c38f945-89cb-4320-baa9-33abef6a2b43', 'name': '', 'tenant_id': '722aa9af1a5449d7880c25f1bd7f488a', 'network_id': 'bc51081d-038d-4797-91a4-353b48d89d5d', 'ip_version': 4, 'cidr': '169.215.146.192/26', 'allocation_pools': [{'start': '169.215.146.194', 'end': '169.215.146.254'}], 'gateway_ip': '169.215.146.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '169.215.146.194', 'tags': [], 'project_id': '722aa9af1a5449d7880c25f1bd7f488a'}} 2026-05-12 11:45:58,765 - INFO - Created VN ctest-ext_vn-72231552 2026-05-12 11:45:58,818 - DEBUG - VN ctest-ext_vn-72231552 UUID is bc51081d-038d-4797-91a4-353b48d89d5d 2026-05-12 11:45:59,000 - DEBUG - Services list from nova: [, , ] 2026-05-12 11:46:00,163 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-5770-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-5770-1) 2026-05-12 11:46:01,449 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-5770-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-5770-1) 2026-05-12 11:46:01,533 - INFO - Setting gateway for router d1673eb6-e15a-46aa-b01d-37b84b4e67a5 to network bc51081d-038d-4797-91a4-353b48d89d5d 2026-05-12 11:46:01,610 - INFO - Adding interface with subnet_id 69d26cad-1041-45eb-92f9-dc6550aa33c7, port_id None to router d1673eb6-e15a-46aa-b01d-37b84b4e67a5 2026-05-12 11:46:02,063 - INFO - Waiting for VM ctest-TestRoutersBasic-69932723-87334906 to be up.. 2026-05-12 11:46:02,231 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-05-12 11:46:07,342 - DEBUG - VM is in ACTIVE state now 2026-05-12 11:46:07,342 - INFO - VM name : ctest-TestRoutersBasic-69932723-87334906 2026-05-12 11:46:07,439 - DEBUG - VM ctest-TestRoutersBasic-69932723-87334906 ID is bb370341-ccfd-4931-90c9-89f8b771df8a 2026-05-12 11:46:07,464 - DEBUG - VM ctest-TestRoutersBasic-69932723-87334906 launched on Node cn-jenkins-deploy-platform-ansible-os-5770-1 2026-05-12 11:46:07,545 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine/bb370341-ccfd-4931-90c9-89f8b771df8a 2026-05-12 11:46:07,843 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine/bb370341-ccfd-4931-90c9-89f8b771df8a 2026-05-12 11:46:07,880 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine-interface/f48c7aa9-0d46-4921-aa31-af37955b44e4 2026-05-12 11:46:11,143 - 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 1021ms') 2026-05-12 11:46:11,143 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestRoutersBasic-69932723-87334906 failed! 2026-05-12 11:46:11,198 - DEBUG - Gateway for vn default-domain:ctest-TestRoutersBasic-69932723:ctest-vn-49098510 is 202.54.211.193 and allocation pool is NOT set 2026-05-12 11:46:13,262 - 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.63 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.484 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.484/1.557/2.630/1.073 ms') 2026-05-12 11:46:13,263 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestRoutersBasic-69932723-87334906 passed 2026-05-12 11:46:13,414 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-12 11:46:13,414 - DEBUG - Waiting to SSH to VM ctest-TestRoutersBasic-69932723-87334906, IP 202.54.211.195, Port 22 2026-05-12 11:46:13,573 - DEBUG - VM ctest-TestRoutersBasic-69932723-87334906 is ready for SSH connections 2026-05-12 11:46:13,573 - INFO - Waiting for VM ctest-TestRoutersBasic-69932723-33622403 to be up.. 2026-05-12 11:46:13,659 - DEBUG - VM is in ACTIVE state now 2026-05-12 11:46:13,659 - INFO - VM name : ctest-TestRoutersBasic-69932723-33622403 2026-05-12 11:46:13,738 - DEBUG - VM ctest-TestRoutersBasic-69932723-33622403 ID is 2d5bff39-a500-4057-a581-59db6a9d8c8c 2026-05-12 11:46:13,738 - DEBUG - VM ctest-TestRoutersBasic-69932723-33622403 launched on Node cn-jenkins-deploy-platform-ansible-os-5770-1 2026-05-12 11:46:13,826 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine/2d5bff39-a500-4057-a581-59db6a9d8c8c 2026-05-12 11:46:13,835 - DEBUG - Requesting: http://10.0.0.22:8082/virtual-machine-interface/4ae81345-714e-48ac-9214-effa36306d64 2026-05-12 11:46:15,091 - 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.25 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.578 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.578/1.913/3.249/1.335 ms') 2026-05-12 11:46:15,091 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-TestRoutersBasic-69932723-33622403 passed 2026-05-12 11:46:15,250 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-12 11:46:15,250 - DEBUG - Waiting to SSH to VM ctest-TestRoutersBasic-69932723-33622403, IP 169.215.146.195, Port 22 2026-05-12 11:46:15,413 - DEBUG - VM ctest-TestRoutersBasic-69932723-33622403 is ready for SSH connections 2026-05-12 11:46:15,413 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-12 11:46:15,413 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 169.215.146.195, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.22, gateway password: c0ntrail123 2026-05-12 11:46:15,413 - DEBUG - ping -s 56 -c 3 -W 1 169.215.146.195 2026-05-12 11:46:19,143 - DEBUG - PING 169.215.146.195 (169.215.146.195): 56 data bytes 64 bytes from 169.215.146.195: seq=0 ttl=62 time=8.126 ms 64 bytes from 169.215.146.195: seq=1 ttl=62 time=1.168 ms 64 bytes from 169.215.146.195: seq=2 ttl=62 time=1.178 ms --- 169.215.146.195 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.168/3.490/8.126 ms 2026-05-12 11:46:19,143 - INFO - Ping to IP 169.215.146.195 from VM ctest-TestRoutersBasic-69932723-87334906 passed 2026-05-12 11:46:19,143 - INFO - Deleting interface with subnet_id 69d26cad-1041-45eb-92f9-dc6550aa33c7, port_id None from router d1673eb6-e15a-46aa-b01d-37b84b4e67a5 2026-05-12 11:46:19,349 - INFO - Deleting VM ctest-TestRoutersBasic-69932723-33622403 2026-05-12 11:46:19,421 - INFO - Deleting VM ctest-TestRoutersBasic-69932723-87334906 2026-05-12 11:46:19,527 - INFO - Deleting VN ctest-ext_vn-72231552 2026-05-12 11:46:19,603 - DEBUG - VN bc51081d-038d-4797-91a4-353b48d89d5d still in use: Unable to complete operation on network bc51081d-038d-4797-91a4-353b48d89d5d. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-0adcf6e8-99ec-4c7e-a03a-b6166fd99739'] 2026-05-12 11:46:19,603 - WARNING - Deleting VN ctest-ext_vn-72231552 failed..Will retry 2026-05-12 11:46:21,713 - DEBUG - Response for deleting network () 2026-05-12 11:46:21,713 - INFO - Deleting VN ctest-vn-49098510 2026-05-12 11:46:21,825 - DEBUG - Response for deleting network () 2026-05-12 11:46:22,091 - DEBUG - No XMPP flaps were noticed during the test
2026-05-12 11:46:22,091 - INFO - END TEST : test_basic_snat_behavior_without_external_connectivity : PASSED[0:00:26]
2026-05-12 11:46:22,091 - INFO - -------------------------------------------------------------------------------- 2026-05-12 11:46:22,810 - INFO - Deleted project: ctest-TestRoutersBasic-69932723, ID : 722aa9af-1a54-49d7-880c-25f1bd7f488a