2025-11-10 16:12:17,746 - INFO - Domain Default found not creating 2025-11-10 16:12:18,061 - INFO - Project ctest-TestRoutersBasic-06380058 not found, creating it 2025-11-10 16:12:18,676 - INFO - Created Project:ctest-TestRoutersBasic-06380058, ID : eb8b9df8-a017-4c49-adff-57659cfa1865 2025-11-10 16:12:20,722 - INFO - ================================================================================ 2025-11-10 16:12:20,722 - INFO - STARTING TEST : test_basic_snat_behavior_without_external_connectivity 2025-11-10 16:12:20,722 - 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 2025-11-10 16:12:21,023 - DEBUG - Nothing to compare xmpp stats {'10.0.0.27': {'10.20.0.254': '0'}} with 2025-11-10 16:12:21,023 - INFO - Initial checks done. Running the testcase now 2025-11-10 16:12:21,023 - INFO - 2025-11-10 16:12:21,962 - INFO - Default SG to be edited for allow all on project: ctest-TestRoutersBasic-06380058 2025-11-10 16:12:22,063 - INFO - Adding rules to the default security group in Project ctest-TestRoutersBasic-06380058 2025-11-10 16:12:22,418 - DEBUG - Reading firewall policy {'fq_name': ['default-domain', 'ctest-TestRoutersBasic-06380058', 'default']} 2025-11-10 16:12:22,866 - DEBUG - Response for create_network : {'network': {'id': 'dff589b3-af68-4930-88cc-c49d4c17462b', 'name': 'ctest-vn-87557990', 'tenant_id': 'eb8b9df8a0174c49adff57659cfa1865', 'project_id': 'eb8b9df8a0174c49adff57659cfa1865', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRoutersBasic-06380058', 'ctest-vn-87557990'], 'port_security_enabled': True, 'description': ''}} 2025-11-10 16:12:23,139 - DEBUG - Response for create_subnet : {'subnet': {'id': '0309996d-aeb4-4538-a5a0-4a86f7716672', 'name': '', 'tenant_id': 'eb8b9df8a0174c49adff57659cfa1865', 'network_id': 'dff589b3-af68-4930-88cc-c49d4c17462b', 'ip_version': 4, 'cidr': '82.229.157.0/26', 'allocation_pools': [{'start': '82.229.157.2', 'end': '82.229.157.62'}], 'gateway_ip': '82.229.157.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '82.229.157.2', 'tags': [], 'project_id': 'eb8b9df8a0174c49adff57659cfa1865'}} 2025-11-10 16:12:23,161 - INFO - Created VN ctest-vn-87557990 2025-11-10 16:12:23,219 - DEBUG - VN ctest-vn-87557990 UUID is dff589b3-af68-4930-88cc-c49d4c17462b 2025-11-10 16:12:23,696 - DEBUG - Response for create_network : {'network': {'id': '550bcffd-dc40-4be7-8f6d-2f1615662940', 'name': 'ctest-ext_vn-28557573', 'tenant_id': 'eb8b9df8a0174c49adff57659cfa1865', 'project_id': 'eb8b9df8a0174c49adff57659cfa1865', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': True, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRoutersBasic-06380058', 'ctest-ext_vn-28557573'], 'port_security_enabled': True, 'description': ''}} 2025-11-10 16:12:23,907 - DEBUG - Response for create_subnet : {'subnet': {'id': '4b4098be-5467-4bb7-a33c-85272d2fcaf1', 'name': '', 'tenant_id': 'eb8b9df8a0174c49adff57659cfa1865', 'network_id': '550bcffd-dc40-4be7-8f6d-2f1615662940', 'ip_version': 4, 'cidr': '89.59.70.0/26', 'allocation_pools': [{'start': '89.59.70.2', 'end': '89.59.70.62'}], 'gateway_ip': '89.59.70.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '89.59.70.2', 'tags': [], 'project_id': 'eb8b9df8a0174c49adff57659cfa1865'}} 2025-11-10 16:12:23,927 - INFO - Created VN ctest-ext_vn-28557573 2025-11-10 16:12:23,983 - DEBUG - VN ctest-ext_vn-28557573 UUID is 550bcffd-dc40-4be7-8f6d-2f1615662940 2025-11-10 16:12:24,273 - DEBUG - Services list from nova: [, , ] 2025-11-10 16:12:25,712 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4681-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4681-1) 2025-11-10 16:12:27,118 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-4681-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-4681-1) 2025-11-10 16:12:27,187 - INFO - Setting gateway for router e6be7913-b1e0-41df-8298-bb6fe0bc2f96 to network 550bcffd-dc40-4be7-8f6d-2f1615662940 2025-11-10 16:12:27,265 - INFO - Adding interface with subnet_id 0309996d-aeb4-4538-a5a0-4a86f7716672, port_id None to router e6be7913-b1e0-41df-8298-bb6fe0bc2f96 2025-11-10 16:12:27,654 - INFO - Waiting for VM ctest-TestRoutersBasic-06380058-01129590 to be up.. 2025-11-10 16:12:27,811 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-11-10 16:12:32,980 - DEBUG - VM is in ACTIVE state now 2025-11-10 16:12:32,980 - INFO - VM name : ctest-TestRoutersBasic-06380058-01129590 2025-11-10 16:12:33,135 - DEBUG - VM ctest-TestRoutersBasic-06380058-01129590 ID is 6fee1434-c9e5-414e-8367-0100964d3c9a 2025-11-10 16:12:33,174 - DEBUG - VM ctest-TestRoutersBasic-06380058-01129590 launched on Node cn-jenkins-deploy-platform-ansible-os-4681-1 2025-11-10 16:12:33,304 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine/6fee1434-c9e5-414e-8367-0100964d3c9a 2025-11-10 16:12:33,658 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine/6fee1434-c9e5-414e-8367-0100964d3c9a 2025-11-10 16:12:33,703 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine-interface/3976677a-e329-4d5f-83ed-f4937e8ff456 2025-11-10 16:12:36,983 - 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 1005ms') 2025-11-10 16:12:36,983 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestRoutersBasic-06380058-01129590 failed! 2025-11-10 16:12:37,042 - DEBUG - Gateway for vn default-domain:ctest-TestRoutersBasic-06380058:ctest-vn-87557990 is 82.229.157.1 and allocation pool is NOT set 2025-11-10 16:12:39,126 - 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.18 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=3.29 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 = 3.288/4.733/6.178/1.445 ms') 2025-11-10 16:12:39,127 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestRoutersBasic-06380058-01129590 passed 2025-11-10 16:12:39,262 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-11-10 16:12:39,262 - DEBUG - Waiting to SSH to VM ctest-TestRoutersBasic-06380058-01129590, IP 82.229.157.3, Port 22 2025-11-10 16:12:39,430 - DEBUG - VM ctest-TestRoutersBasic-06380058-01129590 is ready for SSH connections 2025-11-10 16:12:39,430 - INFO - Waiting for VM ctest-TestRoutersBasic-06380058-09384466 to be up.. 2025-11-10 16:12:39,626 - DEBUG - VM is in ACTIVE state now 2025-11-10 16:12:39,626 - INFO - VM name : ctest-TestRoutersBasic-06380058-09384466 2025-11-10 16:12:39,788 - DEBUG - VM ctest-TestRoutersBasic-06380058-09384466 ID is 544874b9-9f8b-49cd-81e6-ab94e41d650c 2025-11-10 16:12:39,789 - DEBUG - VM ctest-TestRoutersBasic-06380058-09384466 launched on Node cn-jenkins-deploy-platform-ansible-os-4681-1 2025-11-10 16:12:39,946 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine/544874b9-9f8b-49cd-81e6-ab94e41d650c 2025-11-10 16:12:39,965 - DEBUG - Requesting: http://10.0.0.27:8082/virtual-machine-interface/5effac2b-94f5-4e29-8ece-2589929c0288 2025-11-10 16:12:41,264 - 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.35 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=0.864 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.864/2.606/4.348/1.742 ms') 2025-11-10 16:12:41,265 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-TestRoutersBasic-06380058-09384466 passed 2025-11-10 16:12:41,431 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-11-10 16:12:41,431 - DEBUG - Waiting to SSH to VM ctest-TestRoutersBasic-06380058-09384466, IP 89.59.70.3, Port 22 2025-11-10 16:12:41,637 - DEBUG - VM ctest-TestRoutersBasic-06380058-09384466 is ready for SSH connections 2025-11-10 16:12:41,637 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-11-10 16:12:41,637 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 89.59.70.3, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.27, gateway password: c0ntrail123 2025-11-10 16:12:41,637 - DEBUG - ping -s 56 -c 3 -W 1 89.59.70.3 2025-11-10 16:12:45,654 - DEBUG - PING 89.59.70.3 (89.59.70.3): 56 data bytes 64 bytes from 89.59.70.3: seq=0 ttl=62 time=9.210 ms 64 bytes from 89.59.70.3: seq=1 ttl=62 time=1.936 ms 64 bytes from 89.59.70.3: seq=2 ttl=62 time=1.322 ms --- 89.59.70.3 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.322/4.156/9.210 ms 2025-11-10 16:12:45,654 - INFO - Ping to IP 89.59.70.3 from VM ctest-TestRoutersBasic-06380058-01129590 passed 2025-11-10 16:12:45,654 - INFO - Deleting interface with subnet_id 0309996d-aeb4-4538-a5a0-4a86f7716672, port_id None from router e6be7913-b1e0-41df-8298-bb6fe0bc2f96 2025-11-10 16:12:45,973 - INFO - Deleting VM ctest-TestRoutersBasic-06380058-09384466 2025-11-10 16:12:46,045 - INFO - Deleting VM ctest-TestRoutersBasic-06380058-01129590 2025-11-10 16:12:46,133 - INFO - Deleting VN ctest-ext_vn-28557573 2025-11-10 16:12:46,230 - DEBUG - VN 550bcffd-dc40-4be7-8f6d-2f1615662940 still in use: Unable to complete operation on network 550bcffd-dc40-4be7-8f6d-2f1615662940. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-3c684dc7-88c7-412b-b1e6-9422814f8d14'] 2025-11-10 16:12:46,230 - WARNING - Deleting VN ctest-ext_vn-28557573 failed..Will retry 2025-11-10 16:12:48,430 - DEBUG - Response for deleting network () 2025-11-10 16:12:48,430 - INFO - Deleting VN ctest-vn-87557990 2025-11-10 16:12:48,556 - DEBUG - Response for deleting network () 2025-11-10 16:12:48,851 - DEBUG - No XMPP flaps were noticed during the test
2025-11-10 16:12:48,852 - INFO - END TEST : test_basic_snat_behavior_without_external_connectivity : PASSED[0:00:28]
2025-11-10 16:12:48,852 - INFO - -------------------------------------------------------------------------------- 2025-11-10 16:12:49,996 - INFO - Deleted project: ctest-TestRoutersBasic-06380058, ID : eb8b9df8-a017-4c49-adff-57659cfa1865