2026-02-03 17:17:20,574 - INFO - Domain Default found not creating 2026-02-03 17:17:20,795 - INFO - Project ctest-TestRoutersBasic-28812665 not found, creating it 2026-02-03 17:17:21,293 - INFO - Created Project:ctest-TestRoutersBasic-28812665, ID : 80e84173-9a9d-4626-822c-bd30764143f0 2026-02-03 17:17:22,983 - INFO - ================================================================================ 2026-02-03 17:17:22,983 - INFO - STARTING TEST : test_basic_snat_behavior_without_external_connectivity 2026-02-03 17:17:22,984 - 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-02-03 17:17:23,248 - DEBUG - Nothing to compare xmpp stats {'10.0.0.19': {'10.20.0.17': '0'}} with 2026-02-03 17:17:23,248 - INFO - Initial checks done. Running the testcase now 2026-02-03 17:17:23,248 - INFO - 2026-02-03 17:17:24,039 - INFO - Default SG to be edited for allow all on project: ctest-TestRoutersBasic-28812665 2026-02-03 17:17:24,137 - INFO - Adding rules to the default security group in Project ctest-TestRoutersBasic-28812665 2026-02-03 17:17:24,477 - DEBUG - Reading firewall policy {'fq_name': ['default-domain', 'ctest-TestRoutersBasic-28812665', 'default']} 2026-02-03 17:17:24,809 - DEBUG - Response for create_network : {'network': {'id': '5304b3b7-d09c-46ae-b787-d0ba221a5615', 'name': 'ctest-vn-36103226', 'tenant_id': '80e841739a9d4626822cbd30764143f0', 'project_id': '80e841739a9d4626822cbd30764143f0', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRoutersBasic-28812665', 'ctest-vn-36103226'], 'port_security_enabled': True, 'description': ''}} 2026-02-03 17:17:24,986 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a1fe72d6-fc3e-440c-8705-fe37e006d7a5', 'name': '', 'tenant_id': '80e841739a9d4626822cbd30764143f0', 'network_id': '5304b3b7-d09c-46ae-b787-d0ba221a5615', 'ip_version': 4, 'cidr': '44.247.91.192/26', 'allocation_pools': [{'start': '44.247.91.194', 'end': '44.247.91.254'}], 'gateway_ip': '44.247.91.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '44.247.91.194', 'tags': [], 'project_id': '80e841739a9d4626822cbd30764143f0'}} 2026-02-03 17:17:25,009 - INFO - Created VN ctest-vn-36103226 2026-02-03 17:17:25,065 - DEBUG - VN ctest-vn-36103226 UUID is 5304b3b7-d09c-46ae-b787-d0ba221a5615 2026-02-03 17:17:25,414 - DEBUG - Response for create_network : {'network': {'id': '929b1537-c7af-4aa1-977b-5c720292b1ad', 'name': 'ctest-ext_vn-63639357', 'tenant_id': '80e841739a9d4626822cbd30764143f0', 'project_id': '80e841739a9d4626822cbd30764143f0', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': True, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRoutersBasic-28812665', 'ctest-ext_vn-63639357'], 'port_security_enabled': True, 'description': ''}} 2026-02-03 17:17:25,649 - DEBUG - Response for create_subnet : {'subnet': {'id': '139f1f67-2ce3-4b64-a95f-2f12cba93be9', 'name': '', 'tenant_id': '80e841739a9d4626822cbd30764143f0', 'network_id': '929b1537-c7af-4aa1-977b-5c720292b1ad', 'ip_version': 4, 'cidr': '37.100.112.0/26', 'allocation_pools': [{'start': '37.100.112.2', 'end': '37.100.112.62'}], 'gateway_ip': '37.100.112.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '37.100.112.2', 'tags': [], 'project_id': '80e841739a9d4626822cbd30764143f0'}} 2026-02-03 17:17:25,670 - INFO - Created VN ctest-ext_vn-63639357 2026-02-03 17:17:25,725 - DEBUG - VN ctest-ext_vn-63639357 UUID is 929b1537-c7af-4aa1-977b-5c720292b1ad 2026-02-03 17:17:25,916 - DEBUG - Services list from nova: [, , ] 2026-02-03 17:17:27,104 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-5192-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-5192-1) 2026-02-03 17:17:28,451 - INFO - VM ([]) created on node: (cn-jenkins-deploy-platform-ansible-os-5192-1), Zone: (nova:cn-jenkins-deploy-platform-ansible-os-5192-1) 2026-02-03 17:17:28,527 - INFO - Setting gateway for router 8b68844f-3524-420e-97df-6ebccd45d241 to network 929b1537-c7af-4aa1-977b-5c720292b1ad 2026-02-03 17:17:28,599 - INFO - Adding interface with subnet_id a1fe72d6-fc3e-440c-8705-fe37e006d7a5, port_id None to router 8b68844f-3524-420e-97df-6ebccd45d241 2026-02-03 17:17:29,057 - INFO - Waiting for VM ctest-TestRoutersBasic-28812665-68035960 to be up.. 2026-02-03 17:17:29,272 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2026-02-03 17:17:34,365 - DEBUG - VM is in ACTIVE state now 2026-02-03 17:17:34,365 - INFO - VM name : ctest-TestRoutersBasic-28812665-68035960 2026-02-03 17:17:34,454 - DEBUG - VM ctest-TestRoutersBasic-28812665-68035960 ID is e03f03ae-0371-4c95-8519-42f53a1f829f 2026-02-03 17:17:34,477 - DEBUG - VM ctest-TestRoutersBasic-28812665-68035960 launched on Node cn-jenkins-deploy-platform-ansible-os-5192-1 2026-02-03 17:17:34,565 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-machine/e03f03ae-0371-4c95-8519-42f53a1f829f 2026-02-03 17:17:34,869 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-machine/e03f03ae-0371-4c95-8519-42f53a1f829f 2026-02-03 17:17:34,910 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-machine-interface/a75e93f6-84b4-455c-b386-a130021178e6 2026-02-03 17:17:38,189 - 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 1024ms') 2026-02-03 17:17:38,189 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestRoutersBasic-28812665-68035960 failed! 2026-02-03 17:17:38,245 - DEBUG - Gateway for vn default-domain:ctest-TestRoutersBasic-28812665:ctest-vn-36103226 is 44.247.91.193 and allocation pool is NOT set 2026-02-03 17:17:40,312 - 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.75 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=2.68 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 = 2.678/4.712/6.746/2.034 ms') 2026-02-03 17:17:40,312 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestRoutersBasic-28812665-68035960 passed 2026-02-03 17:17:40,469 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-02-03 17:17:40,469 - DEBUG - Waiting to SSH to VM ctest-TestRoutersBasic-28812665-68035960, IP 44.247.91.195, Port 22 2026-02-03 17:17:40,639 - DEBUG - VM ctest-TestRoutersBasic-28812665-68035960 is ready for SSH connections 2026-02-03 17:17:40,639 - INFO - Waiting for VM ctest-TestRoutersBasic-28812665-18842334 to be up.. 2026-02-03 17:17:40,759 - DEBUG - VM is in ACTIVE state now 2026-02-03 17:17:40,759 - INFO - VM name : ctest-TestRoutersBasic-28812665-18842334 2026-02-03 17:17:40,852 - DEBUG - VM ctest-TestRoutersBasic-28812665-18842334 ID is 2e38fcbb-1760-4740-9fd0-39c6e317e0e2 2026-02-03 17:17:40,852 - DEBUG - VM ctest-TestRoutersBasic-28812665-18842334 launched on Node cn-jenkins-deploy-platform-ansible-os-5192-1 2026-02-03 17:17:40,942 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-machine/2e38fcbb-1760-4740-9fd0-39c6e317e0e2 2026-02-03 17:17:40,951 - DEBUG - Requesting: http://10.0.0.19:8082/virtual-machine-interface/d2c9791d-4eb3-41b9-a26d-d865fd4597b1 2026-02-03 17:17:42,213 - 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.06 ms\r\n64 bytes from 169.254.0.4: icmp_seq=2 ttl=63 time=1.02 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 = 1.020/2.538/4.056/1.518 ms') 2026-02-03 17:17:42,214 - INFO - Ping to Metadata IP 169.254.0.4 of VM ctest-TestRoutersBasic-28812665-18842334 passed 2026-02-03 17:17:42,369 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-02-03 17:17:42,369 - DEBUG - Waiting to SSH to VM ctest-TestRoutersBasic-28812665-18842334, IP 37.100.112.3, Port 22 2026-02-03 17:17:42,541 - DEBUG - VM ctest-TestRoutersBasic-28812665-18842334 is ready for SSH connections 2026-02-03 17:17:42,541 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-02-03 17:17:42,541 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 37.100.112.3, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.19, gateway password: c0ntrail123 2026-02-03 17:17:42,541 - DEBUG - ping -s 56 -c 3 -W 1 37.100.112.3 2026-02-03 17:17:46,551 - DEBUG - PING 37.100.112.3 (37.100.112.3): 56 data bytes 64 bytes from 37.100.112.3: seq=0 ttl=62 time=6.903 ms 64 bytes from 37.100.112.3: seq=1 ttl=62 time=1.223 ms 64 bytes from 37.100.112.3: seq=2 ttl=62 time=1.383 ms --- 37.100.112.3 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.223/3.169/6.903 ms 2026-02-03 17:17:46,551 - INFO - Ping to IP 37.100.112.3 from VM ctest-TestRoutersBasic-28812665-68035960 passed 2026-02-03 17:17:46,552 - INFO - Deleting interface with subnet_id a1fe72d6-fc3e-440c-8705-fe37e006d7a5, port_id None from router 8b68844f-3524-420e-97df-6ebccd45d241 2026-02-03 17:17:46,765 - INFO - Deleting VM ctest-TestRoutersBasic-28812665-18842334 2026-02-03 17:17:46,841 - INFO - Deleting VM ctest-TestRoutersBasic-28812665-68035960 2026-02-03 17:17:46,923 - INFO - Deleting VN ctest-ext_vn-63639357 2026-02-03 17:17:47,001 - DEBUG - VN 929b1537-c7af-4aa1-977b-5c720292b1ad still in use: Unable to complete operation on network 929b1537-c7af-4aa1-977b-5c720292b1ad. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-12889b90-133d-4def-994b-69f441a4f76e'] 2026-02-03 17:17:47,001 - WARNING - Deleting VN ctest-ext_vn-63639357 failed..Will retry 2026-02-03 17:17:49,122 - DEBUG - Response for deleting network () 2026-02-03 17:17:49,123 - INFO - Deleting VN ctest-vn-36103226 2026-02-03 17:17:49,244 - DEBUG - Response for deleting network () 2026-02-03 17:17:49,499 - DEBUG - No XMPP flaps were noticed during the test
2026-02-03 17:17:49,499 - INFO - END TEST : test_basic_snat_behavior_without_external_connectivity : PASSED[0:00:27]
2026-02-03 17:17:49,499 - INFO - -------------------------------------------------------------------------------- 2026-02-03 17:17:50,273 - INFO - Deleted project: ctest-TestRoutersBasic-28812665, ID : 80e84173-9a9d-4626-822c-bd30764143f0