2026-03-02 03:00:39,045 - INFO - Domain Default found not creating
2026-03-02 03:00:39,219 - INFO - Project ctest-TestRP-13080169 not found, creating it
2026-03-02 03:00:39,809 - INFO - Created Project:ctest-TestRP-13080169, ID : 410c7512-1cb8-4f16-b282-ef37a1962fd3
2026-03-02 03:00:41,630 - DEBUG - Services list from nova: [, , , ]
2026-03-02 03:00:41,630 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-5413-1', 'an-jenkins-deploy-platform-ansible-os-5413-2']}
2026-03-02 03:00:41,632 - INFO - ================================================================================
2026-03-02 03:00:41,633 - INFO - STARTING TEST : test_rp_interface
2026-03-02 03:00:41,633 - INFO - TEST DESCRIPTION :
1. Create a routing policy with interface match.
2. Launch VMs.
3. Attach policy to VN and confirm if policy takes hold.
2026-03-02 03:00:42,903 - DEBUG - Nothing to compare xmpp stats {'10.0.0.41': {'10.20.0.254': '3', '10.20.0.193': '3'}, '10.0.0.240': {'10.20.0.254': '3', '10.20.0.193': '0'}} with
2026-03-02 03:00:42,903 - INFO - Initial checks done. Running the testcase now
2026-03-02 03:00:42,903 - INFO -
2026-03-02 03:00:43,649 - DEBUG - Response for create_network : {'network': {'id': '2a530589-a9d6-4273-81fd-09688e2a420b', 'name': 'ctest-bgpaas_vn-60201117', 'tenant_id': '410c75121cb84f16b282ef37a1962fd3', 'project_id': '410c75121cb84f16b282ef37a1962fd3', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-13080169', 'ctest-bgpaas_vn-60201117'], 'port_security_enabled': True, 'description': ''}}
2026-03-02 03:00:43,941 - DEBUG - Response for create_subnet : {'subnet': {'id': '8b5b86eb-854b-4955-bf04-224edbfc6a61', 'name': '', 'tenant_id': '410c75121cb84f16b282ef37a1962fd3', 'network_id': '2a530589-a9d6-4273-81fd-09688e2a420b', 'ip_version': 4, 'cidr': '195.170.251.128/26', 'allocation_pools': [{'start': '195.170.251.130', 'end': '195.170.251.190'}], 'gateway_ip': '195.170.251.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '195.170.251.130', 'tags': [], 'project_id': '410c75121cb84f16b282ef37a1962fd3'}}
2026-03-02 03:00:43,971 - INFO - Created VN ctest-bgpaas_vn-60201117
2026-03-02 03:00:43,982 - DEBUG - VN ctest-bgpaas_vn-60201117 UUID is 2a530589-a9d6-4273-81fd-09688e2a420b
2026-03-02 03:00:44,577 - DEBUG - Response for create_network : {'network': {'id': '362a5ef0-e06a-4c46-adba-5b15104ef9dc', 'name': 'ctest-bgpaas_vn-82329581', 'tenant_id': '410c75121cb84f16b282ef37a1962fd3', 'project_id': '410c75121cb84f16b282ef37a1962fd3', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-13080169', 'ctest-bgpaas_vn-82329581'], 'port_security_enabled': True, 'description': ''}}
2026-03-02 03:00:44,874 - DEBUG - Response for create_subnet : {'subnet': {'id': 'e5d3d4a6-ada7-43d2-af36-3e5aa0610c95', 'name': '', 'tenant_id': '410c75121cb84f16b282ef37a1962fd3', 'network_id': '362a5ef0-e06a-4c46-adba-5b15104ef9dc', 'ip_version': 4, 'cidr': '181.2.117.192/26', 'allocation_pools': [{'start': '181.2.117.194', 'end': '181.2.117.254'}], 'gateway_ip': '181.2.117.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '181.2.117.194', 'tags': [], 'project_id': '410c75121cb84f16b282ef37a1962fd3'}}
2026-03-02 03:00:44,904 - INFO - Created VN ctest-bgpaas_vn-82329581
2026-03-02 03:00:44,920 - DEBUG - VN ctest-bgpaas_vn-82329581 UUID is 362a5ef0-e06a-4c46-adba-5b15104ef9dc
2026-03-02 03:00:46,436 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5413-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5413-1)
2026-03-02 03:00:48,010 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5413-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5413-2)
2026-03-02 03:00:48,011 - INFO - Waiting for VM test_vm to be up..
2026-03-02 03:00:48,250 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-03-02 03:00:53,344 - DEBUG - VM is in ACTIVE state now
2026-03-02 03:00:53,344 - INFO - VM name : test_vm
2026-03-02 03:00:53,429 - DEBUG - VM test_vm ID is e409b0b6-b031-4931-8c48-8e4727985ad6
2026-03-02 03:00:53,453 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-5413-1
2026-03-02 03:00:53,535 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/e409b0b6-b031-4931-8c48-8e4727985ad6
2026-03-02 03:00:53,882 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/e409b0b6-b031-4931-8c48-8e4727985ad6
2026-03-02 03:00:53,921 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/a0076601-cc50-4542-bfc1-b676523f5c53
2026-03-02 03:00:57,122 - 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 1032ms')
2026-03-02 03:00:57,122 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed!
2026-03-02 03:00:57,138 - DEBUG - Gateway for vn default-domain:ctest-TestRP-13080169:ctest-bgpaas_vn-60201117 is 195.170.251.129 and allocation pool is NOT set
2026-03-02 03:00:59,204 - 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.60 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=2.39 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 = 2.392/2.495/2.598/0.103 ms')
2026-03-02 03:00:59,204 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed
2026-03-02 03:00:59,276 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-03-02 03:00:59,277 - DEBUG - Waiting to SSH to VM test_vm, IP 195.170.251.131, Port 22
2026-03-02 03:00:59,330 - DEBUG - Error on ssh to cirros@169.254.0.3:22, result: /bin/bash: connect: Connection refused
/bin/bash: line 1: /dev/tcp/169.254.0.3/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.3/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.3/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''}
2026-03-02 03:00:59,418 - DEBUG - VM test_vm is NOT ready for SSH connections, VM status: ACTIVE
2026-03-02 03:01:04,418 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-03-02 03:01:04,418 - DEBUG - Waiting to SSH to VM test_vm, IP 195.170.251.131, Port 22
2026-03-02 03:01:04,575 - DEBUG - VM test_vm is ready for SSH connections
2026-03-02 03:01:04,575 - INFO - Waiting for VM test2_vm to be up..
2026-03-02 03:01:04,672 - DEBUG - VM is in ACTIVE state now
2026-03-02 03:01:04,672 - INFO - VM name : test2_vm
2026-03-02 03:01:04,761 - DEBUG - VM test2_vm ID is f6d894e3-6c83-4389-8590-b49267e0878a
2026-03-02 03:01:04,761 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-5413-2
2026-03-02 03:01:04,853 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/f6d894e3-6c83-4389-8590-b49267e0878a
2026-03-02 03:01:04,863 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/a34a1080-e59f-41b9-bce0-252351e4e4fe
2026-03-02 03:01:06,029 - 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=3.80 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.493 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 = 0.493/2.145/3.798/1.652 ms')
2026-03-02 03:01:06,029 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed
2026-03-02 03:01:06,099 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-03-02 03:01:06,099 - DEBUG - Waiting to SSH to VM test2_vm, IP 181.2.117.195, Port 22
2026-03-02 03:01:06,255 - DEBUG - VM test2_vm is ready for SSH connections
2026-03-02 03:01:06,434 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-03-02 03:01:06,447 - DEBUG - Requesting: http://10.20.0.254:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-13080169:ctest-bgpaas_vn-60201117:ctest-bgpaas_vn-60201117.inet.0
2026-03-02 03:01:06,467 - DEBUG - Requesting: http://10.20.0.193:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-13080169:ctest-bgpaas_vn-60201117:ctest-bgpaas_vn-60201117.inet.0
2026-03-02 03:01:06,480 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-03-02 03:01:06,480 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 181.2.117.195, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.41, gateway password: c0ntrail123
2026-03-02 03:01:06,480 - DEBUG - ping -s 56 -c 3 -W 1 181.2.117.195
2026-03-02 03:01:10,383 - DEBUG - PING 181.2.117.195 (181.2.117.195): 56 data bytes
64 bytes from 181.2.117.195: seq=0 ttl=63 time=7.704 ms
64 bytes from 181.2.117.195: seq=1 ttl=63 time=1.231 ms
64 bytes from 181.2.117.195: seq=2 ttl=63 time=1.139 ms
--- 181.2.117.195 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.139/3.358/7.704 ms
2026-03-02 03:01:10,383 - INFO - Ping to IP 181.2.117.195 from VM test_vm passed
2026-03-02 03:01:10,505 - INFO - Deleting VM test2_vm
2026-03-02 03:01:10,619 - INFO - Deleting VM test_vm
2026-03-02 03:01:10,685 - INFO - Deleting VN ctest-bgpaas_vn-82329581
2026-03-02 03:01:10,731 - DEBUG - VN 362a5ef0-e06a-4c46-adba-5b15104ef9dc still in use: Unable to complete operation on network 362a5ef0-e06a-4c46-adba-5b15104ef9dc. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-b315d1e6-d7d8-4e1e-95a2-6381a7520ff2']
2026-03-02 03:01:10,731 - WARNING - Deleting VN ctest-bgpaas_vn-82329581 failed..Will retry
2026-03-02 03:01:12,918 - DEBUG - Response for deleting network ()
2026-03-02 03:01:12,918 - INFO - Deleting VN ctest-bgpaas_vn-60201117
2026-03-02 03:01:13,204 - DEBUG - Response for deleting network ()
2026-03-02 03:01:14,517 - DEBUG - No XMPP flaps were noticed during the test
2026-03-02 03:01:14,517 - INFO - END TEST : test_rp_interface : PASSED[0:00:33]
2026-03-02 03:01:14,518 - INFO - --------------------------------------------------------------------------------
2026-03-02 03:01:14,520 - INFO - ================================================================================
2026-03-02 03:01:14,520 - INFO - STARTING TEST : test_rp_interface_ext_community
2026-03-02 03:01:14,520 - INFO - TEST DESCRIPTION :
1. Create a routing policy with interface match.
2. Launch VMs.
3. Attach policy to VN and confirm if policy takes hold.
2026-03-02 03:01:15,825 - DEBUG - Nothing to compare xmpp stats {'10.0.0.41': {'10.20.0.254': '3', '10.20.0.193': '3'}, '10.0.0.240': {'10.20.0.254': '3', '10.20.0.193': '0'}} with
2026-03-02 03:01:15,825 - INFO - Initial checks done. Running the testcase now
2026-03-02 03:01:15,825 - INFO -
2026-03-02 03:01:16,133 - DEBUG - Response for create_network : {'network': {'id': '330cc156-a7e1-47ed-84bc-c5fe5f33b6a7', 'name': 'ctest-bgpaas_vn-72553460', 'tenant_id': '410c75121cb84f16b282ef37a1962fd3', 'project_id': '410c75121cb84f16b282ef37a1962fd3', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-13080169', 'ctest-bgpaas_vn-72553460'], 'port_security_enabled': True, 'description': ''}}
2026-03-02 03:01:16,397 - DEBUG - Response for create_subnet : {'subnet': {'id': '72c719d5-9a50-48d1-a416-2c291b49ec55', 'name': '', 'tenant_id': '410c75121cb84f16b282ef37a1962fd3', 'network_id': '330cc156-a7e1-47ed-84bc-c5fe5f33b6a7', 'ip_version': 4, 'cidr': '28.115.216.192/26', 'allocation_pools': [{'start': '28.115.216.194', 'end': '28.115.216.254'}], 'gateway_ip': '28.115.216.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '28.115.216.194', 'tags': [], 'project_id': '410c75121cb84f16b282ef37a1962fd3'}}
2026-03-02 03:01:16,432 - INFO - Created VN ctest-bgpaas_vn-72553460
2026-03-02 03:01:16,448 - DEBUG - VN ctest-bgpaas_vn-72553460 UUID is 330cc156-a7e1-47ed-84bc-c5fe5f33b6a7
2026-03-02 03:01:16,989 - DEBUG - Response for create_network : {'network': {'id': 'f473aaa2-e5e7-49f9-9edf-10ca409f2111', 'name': 'ctest-bgpaas_vn-27936671', 'tenant_id': '410c75121cb84f16b282ef37a1962fd3', 'project_id': '410c75121cb84f16b282ef37a1962fd3', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-13080169', 'ctest-bgpaas_vn-27936671'], 'port_security_enabled': True, 'description': ''}}
2026-03-02 03:01:17,247 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ff6025d5-f10c-4854-a3fb-451a3bb01f79', 'name': '', 'tenant_id': '410c75121cb84f16b282ef37a1962fd3', 'network_id': 'f473aaa2-e5e7-49f9-9edf-10ca409f2111', 'ip_version': 4, 'cidr': '80.130.151.64/26', 'allocation_pools': [{'start': '80.130.151.66', 'end': '80.130.151.126'}], 'gateway_ip': '80.130.151.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '80.130.151.66', 'tags': [], 'project_id': '410c75121cb84f16b282ef37a1962fd3'}}
2026-03-02 03:01:17,269 - INFO - Created VN ctest-bgpaas_vn-27936671
2026-03-02 03:01:17,279 - DEBUG - VN ctest-bgpaas_vn-27936671 UUID is f473aaa2-e5e7-49f9-9edf-10ca409f2111
2026-03-02 03:01:18,817 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5413-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5413-1)
2026-03-02 03:01:20,297 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5413-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5413-2)
2026-03-02 03:01:20,297 - INFO - Waiting for VM test_vm to be up..
2026-03-02 03:01:20,404 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-03-02 03:01:25,521 - DEBUG - VM is in ACTIVE state now
2026-03-02 03:01:25,521 - INFO - VM name : test_vm
2026-03-02 03:01:25,607 - DEBUG - VM test_vm ID is ec201d42-c0a4-4f01-89bb-6a31844c2419
2026-03-02 03:01:25,607 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-5413-1
2026-03-02 03:01:25,695 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/ec201d42-c0a4-4f01-89bb-6a31844c2419
2026-03-02 03:01:25,704 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/61ff3099-ca35-4325-a5a8-b4da70b34e29
2026-03-02 03:01:28,888 - 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 1032ms')
2026-03-02 03:01:28,888 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed!
2026-03-02 03:01:28,904 - DEBUG - Gateway for vn default-domain:ctest-TestRP-13080169:ctest-bgpaas_vn-72553460 is 28.115.216.193 and allocation pool is NOT set
2026-03-02 03:01:30,973 - 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=3.98 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.840 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.840/2.408/3.976/1.568 ms')
2026-03-02 03:01:30,973 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed
2026-03-02 03:01:31,043 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-03-02 03:01:31,043 - DEBUG - Waiting to SSH to VM test_vm, IP 28.115.216.195, Port 22
2026-03-02 03:01:31,210 - DEBUG - VM test_vm is ready for SSH connections
2026-03-02 03:01:31,210 - INFO - Waiting for VM test2_vm to be up..
2026-03-02 03:01:31,299 - DEBUG - VM is in ACTIVE state now
2026-03-02 03:01:31,299 - INFO - VM name : test2_vm
2026-03-02 03:01:31,382 - DEBUG - VM test2_vm ID is 43a51603-a61e-4235-907c-406d68500523
2026-03-02 03:01:31,382 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-5413-2
2026-03-02 03:01:31,467 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/43a51603-a61e-4235-907c-406d68500523
2026-03-02 03:01:31,479 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/d7350af2-e182-47bb-9bb6-182edef372cf
2026-03-02 03:01:32,643 - 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=3.88 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=3.08 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.083/3.481/3.880/0.398 ms')
2026-03-02 03:01:32,643 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed
2026-03-02 03:01:32,712 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-03-02 03:01:32,712 - DEBUG - Waiting to SSH to VM test2_vm, IP 80.130.151.67, Port 22
2026-03-02 03:01:32,871 - DEBUG - VM test2_vm is ready for SSH connections
2026-03-02 03:01:33,038 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-03-02 03:01:33,057 - DEBUG - Requesting: http://10.20.0.254:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-13080169:ctest-bgpaas_vn-72553460:ctest-bgpaas_vn-72553460.inet.0
2026-03-02 03:01:33,075 - DEBUG - Requesting: http://10.20.0.193:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-13080169:ctest-bgpaas_vn-72553460:ctest-bgpaas_vn-72553460.inet.0
2026-03-02 03:01:33,091 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-03-02 03:01:33,091 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 80.130.151.67, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.41, gateway password: c0ntrail123
2026-03-02 03:01:33,092 - DEBUG - ping -s 56 -c 3 -W 1 80.130.151.67
2026-03-02 03:01:36,741 - DEBUG - PING 80.130.151.67 (80.130.151.67): 56 data bytes
64 bytes from 80.130.151.67: seq=0 ttl=63 time=6.998 ms
64 bytes from 80.130.151.67: seq=1 ttl=63 time=1.139 ms
64 bytes from 80.130.151.67: seq=2 ttl=63 time=1.030 ms
--- 80.130.151.67 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.030/3.055/6.998 ms
2026-03-02 03:01:36,741 - INFO - Ping to IP 80.130.151.67 from VM test_vm passed
2026-03-02 03:01:36,954 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-03-02 03:01:36,968 - DEBUG - Requesting: http://10.20.0.254:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-13080169:ctest-bgpaas_vn-72553460:ctest-bgpaas_vn-72553460.inet.0
2026-03-02 03:01:37,985 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-03-02 03:01:37,999 - DEBUG - Requesting: http://10.20.0.254:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-13080169:ctest-bgpaas_vn-72553460:ctest-bgpaas_vn-72553460.inet.0
2026-03-02 03:01:38,015 - DEBUG - Requesting: http://10.20.0.193:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-13080169:ctest-bgpaas_vn-72553460:ctest-bgpaas_vn-72553460.inet.0
2026-03-02 03:01:38,316 - INFO - Deleting VM test2_vm
2026-03-02 03:01:38,392 - INFO - Deleting VM test_vm
2026-03-02 03:01:38,463 - INFO - Deleting VN ctest-bgpaas_vn-27936671
2026-03-02 03:01:38,514 - DEBUG - VN f473aaa2-e5e7-49f9-9edf-10ca409f2111 still in use: Unable to complete operation on network f473aaa2-e5e7-49f9-9edf-10ca409f2111. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-5a9133cb-db3d-4e88-8d68-2fd77a035015']
2026-03-02 03:01:38,514 - WARNING - Deleting VN ctest-bgpaas_vn-27936671 failed..Will retry
2026-03-02 03:01:40,709 - DEBUG - Response for deleting network ()
2026-03-02 03:01:40,709 - INFO - Deleting VN ctest-bgpaas_vn-72553460
2026-03-02 03:01:40,927 - DEBUG - Response for deleting network ()
2026-03-02 03:01:42,196 - DEBUG - No XMPP flaps were noticed during the test
2026-03-02 03:01:42,196 - INFO - --------------------------------------------------------------------------------
2026-03-02 03:01:42,199 - INFO - ================================================================================
2026-03-02 03:01:42,199 - INFO - STARTING TEST : test_rp_interface_static
2026-03-02 03:01:42,199 - INFO - TEST DESCRIPTION :
1. Create a routing policy with interface-static match.
2. Launch VMs.
3. Attach policy to VN and confirm if policy takes hold.
2026-03-02 03:01:43,486 - DEBUG - Nothing to compare xmpp stats {'10.0.0.41': {'10.20.0.254': '3', '10.20.0.193': '3'}, '10.0.0.240': {'10.20.0.254': '3', '10.20.0.193': '0'}} with
2026-03-02 03:01:43,486 - INFO - Initial checks done. Running the testcase now
2026-03-02 03:01:43,486 - INFO -
2026-03-02 03:01:43,760 - DEBUG - Response for create_network : {'network': {'id': 'e4107c27-e839-4162-badc-8775a78fd8b8', 'name': 'ctest-bgpaas_vn-20036717', 'tenant_id': '410c75121cb84f16b282ef37a1962fd3', 'project_id': '410c75121cb84f16b282ef37a1962fd3', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-13080169', 'ctest-bgpaas_vn-20036717'], 'port_security_enabled': True, 'description': ''}}
2026-03-02 03:01:44,008 - DEBUG - Response for create_subnet : {'subnet': {'id': '8a0f3d00-167d-4b59-b2df-4c6652c0b029', 'name': '', 'tenant_id': '410c75121cb84f16b282ef37a1962fd3', 'network_id': 'e4107c27-e839-4162-badc-8775a78fd8b8', 'ip_version': 4, 'cidr': '160.139.23.128/26', 'allocation_pools': [{'start': '160.139.23.130', 'end': '160.139.23.190'}], 'gateway_ip': '160.139.23.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '160.139.23.130', 'tags': [], 'project_id': '410c75121cb84f16b282ef37a1962fd3'}}
2026-03-02 03:01:44,035 - INFO - Created VN ctest-bgpaas_vn-20036717
2026-03-02 03:01:44,047 - DEBUG - VN ctest-bgpaas_vn-20036717 UUID is e4107c27-e839-4162-badc-8775a78fd8b8
2026-03-02 03:01:44,676 - DEBUG - Response for create_network : {'network': {'id': '544d1aff-4486-4430-8801-54a1bba460f7', 'name': 'ctest-bgpaas_vn-51894094', 'tenant_id': '410c75121cb84f16b282ef37a1962fd3', 'project_id': '410c75121cb84f16b282ef37a1962fd3', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-13080169', 'ctest-bgpaas_vn-51894094'], 'port_security_enabled': True, 'description': ''}}
2026-03-02 03:01:44,892 - DEBUG - Response for create_subnet : {'subnet': {'id': '6e2fa7b0-3d4a-4c79-9db7-4b44e931f78d', 'name': '', 'tenant_id': '410c75121cb84f16b282ef37a1962fd3', 'network_id': '544d1aff-4486-4430-8801-54a1bba460f7', 'ip_version': 4, 'cidr': '115.79.112.0/26', 'allocation_pools': [{'start': '115.79.112.2', 'end': '115.79.112.62'}], 'gateway_ip': '115.79.112.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '115.79.112.2', 'tags': [], 'project_id': '410c75121cb84f16b282ef37a1962fd3'}}
2026-03-02 03:01:44,918 - INFO - Created VN ctest-bgpaas_vn-51894094
2026-03-02 03:01:44,931 - DEBUG - VN ctest-bgpaas_vn-51894094 UUID is 544d1aff-4486-4430-8801-54a1bba460f7
2026-03-02 03:01:46,409 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5413-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5413-1)
2026-03-02 03:01:47,847 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5413-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5413-2)
2026-03-02 03:01:47,848 - INFO - Waiting for VM test_vm to be up..
2026-03-02 03:01:47,957 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-03-02 03:01:53,054 - DEBUG - VM is in ACTIVE state now
2026-03-02 03:01:53,054 - INFO - VM name : test_vm
2026-03-02 03:01:53,146 - DEBUG - VM test_vm ID is dee206b1-23e6-4082-b3d2-804740089dfd
2026-03-02 03:01:53,146 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-5413-1
2026-03-02 03:01:53,249 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/dee206b1-23e6-4082-b3d2-804740089dfd
2026-03-02 03:01:53,260 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/1e30ac8a-4b83-4c6d-8dc5-7f65441fe798
2026-03-02 03:01:56,446 - 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 1031ms')
2026-03-02 03:01:56,446 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed!
2026-03-02 03:01:56,460 - DEBUG - Gateway for vn default-domain:ctest-TestRP-13080169:ctest-bgpaas_vn-20036717 is 160.139.23.129 and allocation pool is NOT set
2026-03-02 03:01:58,519 - 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=3.22 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.351 ms\r\n\r\n--- 169.254.0.3 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1000ms\r\nrtt min/avg/max/mdev = 0.351/1.783/3.216/1.432 ms')
2026-03-02 03:01:58,519 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed
2026-03-02 03:01:58,587 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-03-02 03:01:58,588 - DEBUG - Waiting to SSH to VM test_vm, IP 160.139.23.131, Port 22
2026-03-02 03:01:58,750 - DEBUG - VM test_vm is ready for SSH connections
2026-03-02 03:01:58,750 - INFO - Waiting for VM test2_vm to be up..
2026-03-02 03:01:58,846 - DEBUG - VM is in ACTIVE state now
2026-03-02 03:01:58,846 - INFO - VM name : test2_vm
2026-03-02 03:01:58,931 - DEBUG - VM test2_vm ID is 0653e56c-b763-4e5b-9ca8-ad22149cdb86
2026-03-02 03:01:58,932 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-5413-2
2026-03-02 03:01:59,013 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/0653e56c-b763-4e5b-9ca8-ad22149cdb86
2026-03-02 03:01:59,025 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/0e2b7d5f-f1ce-4fb9-a6f6-2b11b6fdfbe8
2026-03-02 03:02:00,179 - 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=4.31 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.31 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 = 1.306/2.808/4.310/1.502 ms')
2026-03-02 03:02:00,179 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed
2026-03-02 03:02:00,246 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-03-02 03:02:00,246 - DEBUG - Waiting to SSH to VM test2_vm, IP 115.79.112.3, Port 22
2026-03-02 03:02:00,414 - DEBUG - VM test2_vm is ready for SSH connections
2026-03-02 03:02:00,514 - INFO - Created InterfaceRouteTable ['default-domain', 'ctest-TestRP-13080169', 'ctest-int_table_right-60928512'](UUID 597dc71e-4023-44f3-8bbf-9209b3a5bd35), prefixes : ['187.116.66.0/26']
2026-03-02 03:02:00,586 - INFO - Added intf route table 597dc71e-4023-44f3-8bbf-9209b3a5bd35 to port 1e30ac8a-4b83-4c6d-8dc5-7f65441fe798
2026-03-02 03:02:00,787 - DEBUG - Requesting: http://10.20.0.254:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-13080169:ctest-bgpaas_vn-20036717:ctest-bgpaas_vn-20036717.inet.0
2026-03-02 03:02:00,808 - DEBUG - Requesting: http://10.20.0.193:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-13080169:ctest-bgpaas_vn-20036717:ctest-bgpaas_vn-20036717.inet.0
2026-03-02 03:02:00,822 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-03-02 03:02:00,822 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 115.79.112.3, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.41, gateway password: c0ntrail123
2026-03-02 03:02:00,822 - DEBUG - ping -s 56 -c 3 -W 1 115.79.112.3
2026-03-02 03:02:04,504 - DEBUG - PING 115.79.112.3 (115.79.112.3): 56 data bytes
64 bytes from 115.79.112.3: seq=0 ttl=63 time=6.984 ms
64 bytes from 115.79.112.3: seq=1 ttl=63 time=1.447 ms
64 bytes from 115.79.112.3: seq=2 ttl=63 time=1.103 ms
--- 115.79.112.3 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.103/3.178/6.984 ms
2026-03-02 03:02:04,504 - INFO - Ping to IP 115.79.112.3 from VM test_vm passed
2026-03-02 03:02:04,635 - INFO - Deleting VM test2_vm
2026-03-02 03:02:04,721 - INFO - Deleting VM test_vm
2026-03-02 03:02:04,798 - INFO - Deleting VN ctest-bgpaas_vn-51894094
2026-03-02 03:02:04,847 - DEBUG - VN 544d1aff-4486-4430-8801-54a1bba460f7 still in use: Unable to complete operation on network 544d1aff-4486-4430-8801-54a1bba460f7. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-f4b1312e-0900-4142-9eba-c2699966e0c3']
2026-03-02 03:02:04,847 - WARNING - Deleting VN ctest-bgpaas_vn-51894094 failed..Will retry
2026-03-02 03:02:07,033 - DEBUG - Response for deleting network ()
2026-03-02 03:02:07,033 - INFO - Deleting VN ctest-bgpaas_vn-20036717
2026-03-02 03:02:07,256 - DEBUG - Response for deleting network ()
2026-03-02 03:02:08,548 - DEBUG - No XMPP flaps were noticed during the test
2026-03-02 03:02:08,548 - INFO - END TEST : test_rp_interface_static : PASSED[0:00:26]
2026-03-02 03:02:08,548 - INFO - --------------------------------------------------------------------------------
2026-03-02 03:02:09,375 - INFO - Deleted project: ctest-TestRP-13080169, ID : 410c7512-1cb8-4f16-b282-ef37a1962fd3