2026-06-05 11:59:34,903 - INFO - Domain Default found not creating
2026-06-05 11:59:35,093 - INFO - Project ctest-TestRoutersBasic-28232946 not found, creating it
2026-06-05 11:59:35,675 - INFO - Created Project:ctest-TestRoutersBasic-28232946, ID : d132509b-6028-4948-bc2d-d60a8f97fe23
2026-06-05 11:59:37,348 - INFO - ================================================================================
2026-06-05 11:59:37,348 - INFO - STARTING TEST : test_basic_snat_behavior_without_external_connectivity
2026-06-05 11:59:37,348 - 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-06-05 11:59:38,645 - DEBUG - Nothing to compare xmpp stats {'10.0.0.41': {'10.20.0.200': '0', '10.20.0.192': '0'}, '10.0.0.141': {'10.20.0.192': '0', '10.20.0.200': '0'}} with
2026-06-05 11:59:38,645 - INFO - Initial checks done. Running the testcase now
2026-06-05 11:59:38,645 - INFO -
2026-06-05 11:59:39,634 - INFO - Default SG to be edited for allow all on project: ctest-TestRoutersBasic-28232946
2026-06-05 11:59:39,696 - INFO - Adding rules to the default security group in Project ctest-TestRoutersBasic-28232946
2026-06-05 11:59:39,998 - DEBUG - Reading firewall policy {'fq_name': ['default-domain', 'ctest-TestRoutersBasic-28232946', 'default']}
2026-06-05 11:59:40,457 - DEBUG - Response for create_network : {'network': {'id': '102f2add-af5c-4dbd-b709-267c3fc49481', 'name': 'ctest-vn-68410575', 'tenant_id': 'd132509b60284948bc2dd60a8f97fe23', 'project_id': 'd132509b60284948bc2dd60a8f97fe23', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRoutersBasic-28232946', 'ctest-vn-68410575'], 'port_security_enabled': True, 'description': ''}}
2026-06-05 11:59:40,767 - DEBUG - Response for create_subnet : {'subnet': {'id': '64fd5e4d-9dc0-4948-85d5-92f3d8525cd1', 'name': '', 'tenant_id': 'd132509b60284948bc2dd60a8f97fe23', 'network_id': '102f2add-af5c-4dbd-b709-267c3fc49481', 'ip_version': 4, 'cidr': '38.102.46.128/26', 'allocation_pools': [{'start': '38.102.46.130', 'end': '38.102.46.190'}], 'gateway_ip': '38.102.46.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '38.102.46.130', 'tags': [], 'project_id': 'd132509b60284948bc2dd60a8f97fe23'}}
2026-06-05 11:59:40,794 - INFO - Created VN ctest-vn-68410575
2026-06-05 11:59:40,805 - DEBUG - VN ctest-vn-68410575 UUID is 102f2add-af5c-4dbd-b709-267c3fc49481
2026-06-05 11:59:41,284 - DEBUG - Response for create_network : {'network': {'id': '73bb2366-6e0a-451c-9fe5-b707d767a0d1', 'name': 'ctest-ext_vn-77820214', 'tenant_id': 'd132509b60284948bc2dd60a8f97fe23', 'project_id': 'd132509b60284948bc2dd60a8f97fe23', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': True, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRoutersBasic-28232946', 'ctest-ext_vn-77820214'], 'port_security_enabled': True, 'description': ''}}
2026-06-05 11:59:41,579 - DEBUG - Response for create_subnet : {'subnet': {'id': '1bfa9b9d-bec3-43e4-a3f6-dbb74b9b74a4', 'name': '', 'tenant_id': 'd132509b60284948bc2dd60a8f97fe23', 'network_id': '73bb2366-6e0a-451c-9fe5-b707d767a0d1', 'ip_version': 4, 'cidr': '8.80.176.192/26', 'allocation_pools': [{'start': '8.80.176.194', 'end': '8.80.176.254'}], 'gateway_ip': '8.80.176.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '8.80.176.194', 'tags': [], 'project_id': 'd132509b60284948bc2dd60a8f97fe23'}}
2026-06-05 11:59:41,613 - INFO - Created VN ctest-ext_vn-77820214
2026-06-05 11:59:41,625 - DEBUG - VN ctest-ext_vn-77820214 UUID is 73bb2366-6e0a-451c-9fe5-b707d767a0d1
2026-06-05 11:59:41,780 - DEBUG - Services list from nova: [, , , ]
2026-06-05 11:59:42,970 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5895-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5895-1)
2026-06-05 11:59:44,834 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5895-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5895-2)
2026-06-05 11:59:45,016 - INFO - Setting gateway for router 9aa56a26-8913-406a-86ab-82e89298fd38 to network 73bb2366-6e0a-451c-9fe5-b707d767a0d1
2026-06-05 11:59:45,115 - INFO - Adding interface with subnet_id 64fd5e4d-9dc0-4948-85d5-92f3d8525cd1, port_id None to router 9aa56a26-8913-406a-86ab-82e89298fd38
2026-06-05 11:59:45,786 - INFO - Waiting for VM ctest-TestRoutersBasic-28232946-00979297 to be up..
2026-06-05 11:59:46,031 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-06-05 11:59:51,130 - DEBUG - VM is in ACTIVE state now
2026-06-05 11:59:51,130 - INFO - VM name : ctest-TestRoutersBasic-28232946-00979297
2026-06-05 11:59:51,236 - DEBUG - VM ctest-TestRoutersBasic-28232946-00979297 ID is 3c17c0db-5a6a-4adf-86a6-25eefdbc43d6
2026-06-05 11:59:51,263 - DEBUG - VM ctest-TestRoutersBasic-28232946-00979297 launched on Node an-jenkins-deploy-platform-ansible-os-5895-1
2026-06-05 11:59:51,363 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine/3c17c0db-5a6a-4adf-86a6-25eefdbc43d6
2026-06-05 11:59:51,677 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine/3c17c0db-5a6a-4adf-86a6-25eefdbc43d6
2026-06-05 11:59:51,725 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine-interface/15dfb967-786e-4a9b-90e9-4faf70018fa8
2026-06-05 11:59:54,909 - 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=2 ttl=63 time=3.11 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1015ms\r\nrtt min/avg/max/mdev = 3.105/3.105/3.105/0.000 ms')
2026-06-05 11:59:54,909 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestRoutersBasic-28232946-00979297 passed
2026-06-05 11:59:54,978 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-05 11:59:54,978 - DEBUG - Waiting to SSH to VM ctest-TestRoutersBasic-28232946-00979297, IP 38.102.46.131, Port 22
2026-06-05 11:59:55,139 - DEBUG - VM ctest-TestRoutersBasic-28232946-00979297 is ready for SSH connections
2026-06-05 11:59:55,139 - INFO - Waiting for VM ctest-TestRoutersBasic-28232946-89874147 to be up..
2026-06-05 11:59:55,260 - DEBUG - VM is in ACTIVE state now
2026-06-05 11:59:55,260 - INFO - VM name : ctest-TestRoutersBasic-28232946-89874147
2026-06-05 11:59:55,380 - DEBUG - VM ctest-TestRoutersBasic-28232946-89874147 ID is f6c8ffed-decb-4415-973a-bf037017312f
2026-06-05 11:59:55,380 - DEBUG - VM ctest-TestRoutersBasic-28232946-89874147 launched on Node an-jenkins-deploy-platform-ansible-os-5895-2
2026-06-05 11:59:55,499 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine/f6c8ffed-decb-4415-973a-bf037017312f
2026-06-05 11:59:55,514 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-machine-interface/c059b64f-455b-4fe0-82e4-4a58e35a2ff9
2026-06-05 11:59:58,719 - 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 1011ms')
2026-06-05 11:59:58,719 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM ctest-TestRoutersBasic-28232946-89874147 failed!
2026-06-05 11:59:58,735 - DEBUG - Gateway for vn default-domain:ctest-TestRoutersBasic-28232946:ctest-ext_vn-77820214 is 8.80.176.193 and allocation pool is NOT set
2026-06-05 12:00:02,814 - 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=2 ttl=63 time=9.02 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 1 received, 50% packet loss, time 1007ms\r\nrtt min/avg/max/mdev = 9.023/9.023/9.023/0.000 ms')
2026-06-05 12:00:02,814 - INFO - Ping to Metadata IP 169.254.0.3 of VM ctest-TestRoutersBasic-28232946-89874147 passed
2026-06-05 12:00:02,894 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-05 12:00:02,894 - DEBUG - Waiting to SSH to VM ctest-TestRoutersBasic-28232946-89874147, IP 8.80.176.195, Port 22
2026-06-05 12:00:03,074 - DEBUG - VM ctest-TestRoutersBasic-28232946-89874147 is ready for SSH connections
2026-06-05 12:00:03,075 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-05 12:00:03,075 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 8.80.176.195, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.41, gateway password: c0ntrail123
2026-06-05 12:00:03,075 - DEBUG - ping -s 56 -c 3 -W 1 8.80.176.195
2026-06-05 12:00:06,761 - DEBUG - PING 8.80.176.195 (8.80.176.195): 56 data bytes
64 bytes from 8.80.176.195: seq=0 ttl=62 time=10.288 ms
64 bytes from 8.80.176.195: seq=1 ttl=62 time=1.702 ms
64 bytes from 8.80.176.195: seq=2 ttl=62 time=1.544 ms
--- 8.80.176.195 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.544/4.511/10.288 ms
2026-06-05 12:00:06,761 - INFO - Ping to IP 8.80.176.195 from VM ctest-TestRoutersBasic-28232946-00979297 passed
2026-06-05 12:00:06,761 - INFO - Deleting interface with subnet_id 64fd5e4d-9dc0-4948-85d5-92f3d8525cd1, port_id None from router 9aa56a26-8913-406a-86ab-82e89298fd38
2026-06-05 12:00:07,282 - INFO - Deleting VM ctest-TestRoutersBasic-28232946-89874147
2026-06-05 12:00:07,439 - INFO - Deleting VM ctest-TestRoutersBasic-28232946-00979297
2026-06-05 12:00:07,663 - INFO - Deleting VN ctest-ext_vn-77820214
2026-06-05 12:00:07,810 - DEBUG - VN 73bb2366-6e0a-451c-9fe5-b707d767a0d1 still in use: Unable to complete operation on network 73bb2366-6e0a-451c-9fe5-b707d767a0d1. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-d4c6de0d-02f4-4c42-bdb3-2b9072071bd8']
2026-06-05 12:00:07,810 - WARNING - Deleting VN ctest-ext_vn-77820214 failed..Will retry
2026-06-05 12:00:10,060 - DEBUG - Response for deleting network ()
2026-06-05 12:00:10,060 - INFO - Deleting VN ctest-vn-68410575
2026-06-05 12:00:10,317 - DEBUG - Response for deleting network ()
2026-06-05 12:00:11,634 - DEBUG - No XMPP flaps were noticed during the test
2026-06-05 12:00:11,634 - INFO - END TEST : test_basic_snat_behavior_without_external_connectivity : PASSED[0:00:34]
2026-06-05 12:00:11,634 - INFO - --------------------------------------------------------------------------------
2026-06-05 12:00:12,468 - INFO - Deleted project: ctest-TestRoutersBasic-28232946, ID : d132509b-6028-4948-bc2d-d60a8f97fe23