2026-09-02 00:21:06,000 - INFO - Domain Default found not creating 2026-09-02 00:21:06,163 - INFO - Project ctest-TestRoutersBasic-19312603 not found, creating it 2026-09-02 00:21:06,671 - INFO - Created Project:ctest-TestRoutersBasic-19312603, ID : 62716d8c-24c1-4b60-9d4f-b7cf4794017f 2026-09-02 00:21:09,080 - INFO - ================================================================================ 2026-09-02 00:21:09,081 - INFO - STARTING TEST : test_basic_snat_behavior_without_external_connectivity 2026-09-02 00:21:09,081 - 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-09-02 00:21:09,346 - DEBUG - Nothing to compare xmpp stats {'10.0.0.38': {'10.20.0.25': '0'}} with 2026-09-02 00:21:09,346 - INFO - Initial checks done. Running the testcase now 2026-09-02 00:21:09,346 - INFO - 2026-09-02 00:21:10,095 - INFO - Default SG to be edited for allow all on project: ctest-TestRoutersBasic-19312603 2026-09-02 00:21:10,190 - INFO - Adding rules to the default security group in Project ctest-TestRoutersBasic-19312603 2026-09-02 00:21:10,518 - DEBUG - Reading firewall policy {'fq_name': ['default-domain', 'ctest-TestRoutersBasic-19312603', 'default']} 2026-09-02 00:21:10,829 - DEBUG - Response for create_network : {'network': {'id': '5de98668-cdfe-4e44-befc-07b0c43de246', 'name': 'ctest-vn-68852523', 'tenant_id': '62716d8c24c14b609d4fb7cf4794017f', 'project_id': '62716d8c24c14b609d4fb7cf4794017f', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRoutersBasic-19312603', 'ctest-vn-68852523'], 'port_security_enabled': True, 'description': ''}} 2026-09-02 00:21:11,007 - DEBUG - Response for create_subnet : {'subnet': {'id': '3dc8120a-80b0-42ca-b4c6-bce6afe88465', 'name': '', 'tenant_id': '62716d8c24c14b609d4fb7cf4794017f', 'network_id': '5de98668-cdfe-4e44-befc-07b0c43de246', 'ip_version': 4, 'cidr': '221.201.222.192/26', 'allocation_pools': [{'start': '221.201.222.194', 'end': '221.201.222.254'}], 'gateway_ip': '221.201.222.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '221.201.222.194', 'tags': [], 'project_id': '62716d8c24c14b609d4fb7cf4794017f'}} 2026-09-02 00:21:11,026 - INFO - Created VN ctest-vn-68852523 2026-09-02 00:21:11,078 - DEBUG - VN ctest-vn-68852523 UUID is 5de98668-cdfe-4e44-befc-07b0c43de246 2026-09-02 00:21:11,463 - DEBUG - Response for create_network : {'network': {'id': '574e8080-4557-4773-88f9-2871ff66a729', 'name': 'ctest-ext_vn-22910963', 'tenant_id': '62716d8c24c14b609d4fb7cf4794017f', 'project_id': '62716d8c24c14b609d4fb7cf4794017f', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': True, 'mtu': 0, 'tags': [], 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRoutersBasic-19312603', 'ctest-ext_vn-22910963'], 'port_security_enabled': True, 'description': ''}} 2026-09-02 00:21:11,650 - DEBUG - Response for create_subnet : {'subnet': {'id': '2180a460-dbdf-43b2-8233-a616eb123415', 'name': '', 'tenant_id': '62716d8c24c14b609d4fb7cf4794017f', 'network_id': '574e8080-4557-4773-88f9-2871ff66a729', 'ip_version': 4, 'cidr': '185.202.106.0/26', 'allocation_pools': [{'start': '185.202.106.2', 'end': '185.202.106.62'}], 'gateway_ip': '185.202.106.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '185.202.106.2', 'tags': [], 'project_id': '62716d8c24c14b609d4fb7cf4794017f'}} 2026-09-02 00:21:11,669 - INFO - Created VN ctest-ext_vn-22910963 2026-09-02 00:21:11,722 - DEBUG - VN ctest-ext_vn-22910963 UUID is 574e8080-4557-4773-88f9-2871ff66a729 2026-09-02 00:21:11,930 - DEBUG - Services list from nova: [, , ] 2026-09-02 00:21:12,279 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-6242-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-6242-1) 2026-09-02 00:21:12,668 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-6242-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-6242-1) 2026-09-02 00:21:12,746 - INFO - Setting gateway for router c72a7230-2a94-4c52-a490-0a3f917d4c7f to network 574e8080-4557-4773-88f9-2871ff66a729 2026-09-02 00:21:12,800 - INFO - Adding interface with subnet_id 3dc8120a-80b0-42ca-b4c6-bce6afe88465, port_id None to router c72a7230-2a94-4c52-a490-0a3f917d4c7f 2026-09-02 00:21:13,040 - INFO - Waiting for VM ctest-TestRoutersBasic-19312603-37050334 to be up.. 2026-09-02 00:21:13,107 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-02 00:21:18,187 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-02 00:21:23,272 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-02 00:21:28,356 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-02 00:21:33,435 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-02 00:21:38,572 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-02 00:21:43,651 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-02 00:21:48,728 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-09-02 00:21:53,820 - DEBUG - VM is in ACTIVE state now 2026-09-02 00:21:53,820 - INFO - VM name : ctest-TestRoutersBasic-19312603-37050334 2026-09-02 00:21:53,893 - DEBUG - VM ctest-TestRoutersBasic-19312603-37050334 ID is 8151fd38-7239-4258-b19c-c4968ece87bc 2026-09-02 00:21:53,912 - DEBUG - VM ctest-TestRoutersBasic-19312603-37050334 launched on Node cn-jenkins-deploy-platform-ansible-os-6242-1 2026-09-02 00:21:53,984 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/8151fd38-7239-4258-b19c-c4968ece87bc 2026-09-02 00:21:54,299 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/8151fd38-7239-4258-b19c-c4968ece87bc 2026-09-02 00:21:54,328 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/60a98b05-440b-497b-b8ef-554d386560c2 2026-09-02 00:21:57,572 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=9.49 ms\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1006ms\r\nrtt min/avg/max/mdev = 9.493/9.493/9.493/0.000 ms') 2026-09-02 00:21:57,572 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-TestRoutersBasic-19312603-37050334 passed 2026-09-02 00:21:57,726 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-09-02 00:21:57,726 - DEBUG - Waiting to SSH to VM ctest-TestRoutersBasic-19312603-37050334, IP 221.201.222.195, Port 22 2026-09-02 00:21:57,881 - DEBUG - VM ctest-TestRoutersBasic-19312603-37050334 is ready for SSH connections 2026-09-02 00:21:57,881 - INFO - Waiting for VM ctest-TestRoutersBasic-19312603-04114413 to be up.. 2026-09-02 00:21:57,962 - DEBUG - VM is in ACTIVE state now 2026-09-02 00:21:57,963 - INFO - VM name : ctest-TestRoutersBasic-19312603-04114413 2026-09-02 00:21:58,045 - DEBUG - VM ctest-TestRoutersBasic-19312603-04114413 ID is 9f78c647-e599-45ea-8454-6fe870760e23 2026-09-02 00:21:58,045 - DEBUG - VM ctest-TestRoutersBasic-19312603-04114413 launched on Node cn-jenkins-deploy-platform-ansible-os-6242-1 2026-09-02 00:21:58,122 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine/9f78c647-e599-45ea-8454-6fe870760e23 2026-09-02 00:21:58,132 - DEBUG - Requesting: http://10.0.0.38:8082/virtual-machine-interface/629dce21-9236-4970-a142-0c906bcb87ce 2026-09-02 00:21:59,383 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n64 bytes from 169.254.0.6: icmp_seq=1 ttl=63 time=3.22 ms\r\n64 bytes from 169.254.0.6: icmp_seq=2 ttl=63 time=0.495 ms\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.495/1.859/3.223/1.364 ms') 2026-09-02 00:21:59,383 - INFO - Ping to Metadata IP 169.254.0.6 of VM ctest-TestRoutersBasic-19312603-04114413 passed 2026-09-02 00:21:59,534 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-09-02 00:21:59,534 - DEBUG - Waiting to SSH to VM ctest-TestRoutersBasic-19312603-04114413, IP 185.202.106.4, Port 22 2026-09-02 00:21:59,690 - DEBUG - VM ctest-TestRoutersBasic-19312603-04114413 is ready for SSH connections 2026-09-02 00:21:59,690 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-09-02 00:21:59,690 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 185.202.106.4, host_string: cirros@169.254.0.5, password: cubswin:)gateway: ubuntu@10.0.0.38, gateway password: c0ntrail123 2026-09-02 00:21:59,690 - DEBUG - ping -s 56 -c 3 -W 1 185.202.106.4 2026-09-02 00:22:02,731 - DEBUG - PING 185.202.106.4 (185.202.106.4): 56 data bytes 64 bytes from 185.202.106.4: seq=0 ttl=62 time=7.488 ms 64 bytes from 185.202.106.4: seq=1 ttl=62 time=1.455 ms 64 bytes from 185.202.106.4: seq=2 ttl=62 time=0.998 ms --- 185.202.106.4 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 0.998/3.313/7.488 ms 2026-09-02 00:22:02,732 - INFO - Ping to IP 185.202.106.4 from VM ctest-TestRoutersBasic-19312603-37050334 passed 2026-09-02 00:22:02,732 - INFO - Deleting interface with subnet_id 3dc8120a-80b0-42ca-b4c6-bce6afe88465, port_id None from router c72a7230-2a94-4c52-a490-0a3f917d4c7f 2026-09-02 00:22:03,011 - INFO - Deleting VM ctest-TestRoutersBasic-19312603-04114413 2026-09-02 00:22:03,120 - INFO - Deleting VM ctest-TestRoutersBasic-19312603-37050334 2026-09-02 00:22:03,210 - INFO - Deleting VN ctest-ext_vn-22910963 2026-09-02 00:22:03,305 - DEBUG - VN 574e8080-4557-4773-88f9-2871ff66a729 still in use: Unable to complete operation on network 574e8080-4557-4773-88f9-2871ff66a729. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-f3224793-3ec0-4023-b33f-512124eea7d1'] 2026-09-02 00:22:03,305 - WARNING - Deleting VN ctest-ext_vn-22910963 failed..Will retry 2026-09-02 00:22:05,456 - DEBUG - Response for deleting network () 2026-09-02 00:22:05,456 - INFO - Deleting VN ctest-vn-68852523 2026-09-02 00:22:05,573 - DEBUG - Response for deleting network () 2026-09-02 00:22:05,837 - DEBUG - No XMPP flaps were noticed during the test
2026-09-02 00:22:05,837 - INFO - END TEST : test_basic_snat_behavior_without_external_connectivity : PASSED[0:00:56]
2026-09-02 00:22:05,837 - INFO - -------------------------------------------------------------------------------- 2026-09-02 00:22:06,585 - INFO - Deleted project: ctest-TestRoutersBasic-19312603, ID : 62716d8c-24c1-4b60-9d4f-b7cf4794017f