2026-06-04 13:48:26,109 - INFO - Domain Default found not creating
2026-06-04 13:48:26,283 - INFO - Project ctest-TestRP-61186909 not found, creating it
2026-06-04 13:48:26,888 - INFO - Created Project:ctest-TestRP-61186909, ID : 98b36fc4-cd3f-41b1-9c39-95a5141f7970
2026-06-04 13:48:28,418 - DEBUG - Services list from nova: [, , , ]
2026-06-04 13:48:28,418 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-5890-2', 'an-jenkins-deploy-platform-ansible-os-5890-1']}
2026-06-04 13:48:28,421 - INFO - ================================================================================
2026-06-04 13:48:28,421 - INFO - STARTING TEST : test_rp_interface
2026-06-04 13:48:28,422 - 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-06-04 13:48:29,707 - DEBUG - Nothing to compare xmpp stats {'10.0.0.22': {'10.20.0.25': '0', '10.20.0.14': '0'}, '10.0.0.19': {'10.20.0.14': '0', '10.20.0.254': '0'}} with
2026-06-04 13:48:29,707 - INFO - Initial checks done. Running the testcase now
2026-06-04 13:48:29,707 - INFO -
2026-06-04 13:48:30,431 - DEBUG - Response for create_network : {'network': {'id': '9f86d99a-e287-40dc-9eee-8bc59f7b1eb0', 'name': 'ctest-bgpaas_vn-62427056', 'tenant_id': '98b36fc4cd3f41b19c3995a5141f7970', 'project_id': '98b36fc4cd3f41b19c3995a5141f7970', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-61186909', 'ctest-bgpaas_vn-62427056'], 'port_security_enabled': True, 'description': ''}}
2026-06-04 13:48:30,732 - DEBUG - Response for create_subnet : {'subnet': {'id': '31872272-d420-4817-80a3-1f4dd211ef03', 'name': '', 'tenant_id': '98b36fc4cd3f41b19c3995a5141f7970', 'network_id': '9f86d99a-e287-40dc-9eee-8bc59f7b1eb0', 'ip_version': 4, 'cidr': '15.165.15.192/26', 'allocation_pools': [{'start': '15.165.15.194', 'end': '15.165.15.254'}], 'gateway_ip': '15.165.15.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '15.165.15.194', 'tags': [], 'project_id': '98b36fc4cd3f41b19c3995a5141f7970'}}
2026-06-04 13:48:30,753 - INFO - Created VN ctest-bgpaas_vn-62427056
2026-06-04 13:48:30,764 - DEBUG - VN ctest-bgpaas_vn-62427056 UUID is 9f86d99a-e287-40dc-9eee-8bc59f7b1eb0
2026-06-04 13:48:31,282 - DEBUG - Response for create_network : {'network': {'id': '3a365b31-8acf-4a82-bacb-896293260a8d', 'name': 'ctest-bgpaas_vn-00392923', 'tenant_id': '98b36fc4cd3f41b19c3995a5141f7970', 'project_id': '98b36fc4cd3f41b19c3995a5141f7970', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-61186909', 'ctest-bgpaas_vn-00392923'], 'port_security_enabled': True, 'description': ''}}
2026-06-04 13:48:31,511 - DEBUG - Response for create_subnet : {'subnet': {'id': '82ff0977-5d7c-4974-9097-d587cd724fbe', 'name': '', 'tenant_id': '98b36fc4cd3f41b19c3995a5141f7970', 'network_id': '3a365b31-8acf-4a82-bacb-896293260a8d', 'ip_version': 4, 'cidr': '180.109.207.64/26', 'allocation_pools': [{'start': '180.109.207.66', 'end': '180.109.207.126'}], 'gateway_ip': '180.109.207.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '180.109.207.66', 'tags': [], 'project_id': '98b36fc4cd3f41b19c3995a5141f7970'}}
2026-06-04 13:48:31,546 - INFO - Created VN ctest-bgpaas_vn-00392923
2026-06-04 13:48:31,559 - DEBUG - VN ctest-bgpaas_vn-00392923 UUID is 3a365b31-8acf-4a82-bacb-896293260a8d
2026-06-04 13:48:33,065 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5890-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5890-2)
2026-06-04 13:48:34,574 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5890-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5890-1)
2026-06-04 13:48:34,575 - INFO - Waiting for VM test_vm to be up..
2026-06-04 13:48:34,681 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-06-04 13:48:39,768 - DEBUG - VM is in ACTIVE state now
2026-06-04 13:48:39,768 - INFO - VM name : test_vm
2026-06-04 13:48:39,861 - DEBUG - VM test_vm ID is 049d2108-e5d5-4790-ba43-d4318fd2531a
2026-06-04 13:48:39,888 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-5890-2
2026-06-04 13:48:39,975 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/049d2108-e5d5-4790-ba43-d4318fd2531a
2026-06-04 13:48:40,273 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/049d2108-e5d5-4790-ba43-d4318fd2531a
2026-06-04 13:48:40,313 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/283447e5-c7a9-4d43-aafc-1643ef685112
2026-06-04 13:48:43,491 - 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-04 13:48:43,491 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed!
2026-06-04 13:48:43,505 - DEBUG - Gateway for vn default-domain:ctest-TestRP-61186909:ctest-bgpaas_vn-62427056 is 15.165.15.193 and allocation pool is NOT set
2026-06-04 13:48:45,570 - 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.10 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.509 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.509/1.802/3.096/1.293 ms')
2026-06-04 13:48:45,570 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed
2026-06-04 13:48:45,638 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 13:48:45,638 - DEBUG - Waiting to SSH to VM test_vm, IP 15.165.15.195, Port 22
2026-06-04 13:48:45,809 - DEBUG - VM test_vm is ready for SSH connections
2026-06-04 13:48:45,810 - INFO - Waiting for VM test2_vm to be up..
2026-06-04 13:48:45,902 - DEBUG - VM is in ACTIVE state now
2026-06-04 13:48:45,902 - INFO - VM name : test2_vm
2026-06-04 13:48:45,995 - DEBUG - VM test2_vm ID is 3a9e319a-cbba-49eb-80e5-b2fbabf14f08
2026-06-04 13:48:45,996 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-5890-1
2026-06-04 13:48:46,081 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/3a9e319a-cbba-49eb-80e5-b2fbabf14f08
2026-06-04 13:48:46,093 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/362be117-711e-4b45-8f69-b4f1c0dd8d6d
2026-06-04 13:48:47,264 - 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.01 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=3.83 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.827/3.919/4.012/0.092 ms')
2026-06-04 13:48:47,264 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed
2026-06-04 13:48:47,337 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 13:48:47,338 - DEBUG - Waiting to SSH to VM test2_vm, IP 180.109.207.67, Port 22
2026-06-04 13:48:47,496 - DEBUG - VM test2_vm is ready for SSH connections
2026-06-04 13:48:47,645 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 13:48:47,662 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-61186909:ctest-bgpaas_vn-62427056:ctest-bgpaas_vn-62427056.inet.0
2026-06-04 13:48:47,675 - DEBUG - Requesting: http://10.20.0.254:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-61186909:ctest-bgpaas_vn-62427056:ctest-bgpaas_vn-62427056.inet.0
2026-06-04 13:48:47,688 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 13:48:47,688 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 180.109.207.67, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.19, gateway password: c0ntrail123
2026-06-04 13:48:47,688 - DEBUG - ping -s 56 -c 3 -W 1 180.109.207.67
2026-06-04 13:48:51,605 - DEBUG - PING 180.109.207.67 (180.109.207.67): 56 data bytes
64 bytes from 180.109.207.67: seq=0 ttl=63 time=8.605 ms
64 bytes from 180.109.207.67: seq=1 ttl=63 time=1.639 ms
64 bytes from 180.109.207.67: seq=2 ttl=63 time=1.637 ms
--- 180.109.207.67 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.637/3.960/8.605 ms
2026-06-04 13:48:51,606 - INFO - Ping to IP 180.109.207.67 from VM test_vm passed
2026-06-04 13:48:51,707 - INFO - Deleting VM test2_vm
2026-06-04 13:48:51,789 - INFO - Deleting VM test_vm
2026-06-04 13:48:51,859 - INFO - Deleting VN ctest-bgpaas_vn-00392923
2026-06-04 13:48:51,908 - DEBUG - VN 3a365b31-8acf-4a82-bacb-896293260a8d still in use: Unable to complete operation on network 3a365b31-8acf-4a82-bacb-896293260a8d. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-fa0dc880-8566-415c-aef4-7fd90efb2dda']
2026-06-04 13:48:51,908 - WARNING - Deleting VN ctest-bgpaas_vn-00392923 failed..Will retry
2026-06-04 13:48:54,069 - DEBUG - Response for deleting network ()
2026-06-04 13:48:54,069 - INFO - Deleting VN ctest-bgpaas_vn-62427056
2026-06-04 13:48:54,259 - DEBUG - Response for deleting network ()
2026-06-04 13:48:55,542 - DEBUG - No XMPP flaps were noticed during the test
2026-06-04 13:48:55,542 - INFO - END TEST : test_rp_interface : PASSED[0:00:27]
2026-06-04 13:48:55,542 - INFO - --------------------------------------------------------------------------------
2026-06-04 13:48:55,545 - INFO - ================================================================================
2026-06-04 13:48:55,545 - INFO - STARTING TEST : test_rp_interface_ext_community
2026-06-04 13:48:55,545 - 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-06-04 13:48:56,810 - DEBUG - Nothing to compare xmpp stats {'10.0.0.22': {'10.20.0.25': '0', '10.20.0.14': '0'}, '10.0.0.19': {'10.20.0.14': '0', '10.20.0.254': '0'}} with
2026-06-04 13:48:56,810 - INFO - Initial checks done. Running the testcase now
2026-06-04 13:48:56,810 - INFO -
2026-06-04 13:48:57,101 - DEBUG - Response for create_network : {'network': {'id': '8a7fd3cb-2a21-4949-9502-36e4c720723f', 'name': 'ctest-bgpaas_vn-97215021', 'tenant_id': '98b36fc4cd3f41b19c3995a5141f7970', 'project_id': '98b36fc4cd3f41b19c3995a5141f7970', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-61186909', 'ctest-bgpaas_vn-97215021'], 'port_security_enabled': True, 'description': ''}}
2026-06-04 13:48:57,315 - DEBUG - Response for create_subnet : {'subnet': {'id': '53d76d1a-a6f8-4e40-b020-64b24aa54b63', 'name': '', 'tenant_id': '98b36fc4cd3f41b19c3995a5141f7970', 'network_id': '8a7fd3cb-2a21-4949-9502-36e4c720723f', 'ip_version': 4, 'cidr': '50.46.228.0/26', 'allocation_pools': [{'start': '50.46.228.2', 'end': '50.46.228.62'}], 'gateway_ip': '50.46.228.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '50.46.228.2', 'tags': [], 'project_id': '98b36fc4cd3f41b19c3995a5141f7970'}}
2026-06-04 13:48:57,340 - INFO - Created VN ctest-bgpaas_vn-97215021
2026-06-04 13:48:57,351 - DEBUG - VN ctest-bgpaas_vn-97215021 UUID is 8a7fd3cb-2a21-4949-9502-36e4c720723f
2026-06-04 13:48:57,927 - DEBUG - Response for create_network : {'network': {'id': '392a3714-1f6f-4fd9-ad23-411f59305478', 'name': 'ctest-bgpaas_vn-50254527', 'tenant_id': '98b36fc4cd3f41b19c3995a5141f7970', 'project_id': '98b36fc4cd3f41b19c3995a5141f7970', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-61186909', 'ctest-bgpaas_vn-50254527'], 'port_security_enabled': True, 'description': ''}}
2026-06-04 13:48:58,185 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ca276262-867c-4319-b12f-dce6fa18a85b', 'name': '', 'tenant_id': '98b36fc4cd3f41b19c3995a5141f7970', 'network_id': '392a3714-1f6f-4fd9-ad23-411f59305478', 'ip_version': 4, 'cidr': '45.145.216.0/26', 'allocation_pools': [{'start': '45.145.216.2', 'end': '45.145.216.62'}], 'gateway_ip': '45.145.216.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '45.145.216.2', 'tags': [], 'project_id': '98b36fc4cd3f41b19c3995a5141f7970'}}
2026-06-04 13:48:58,210 - INFO - Created VN ctest-bgpaas_vn-50254527
2026-06-04 13:48:58,221 - DEBUG - VN ctest-bgpaas_vn-50254527 UUID is 392a3714-1f6f-4fd9-ad23-411f59305478
2026-06-04 13:48:59,567 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5890-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5890-2)
2026-06-04 13:49:00,954 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5890-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5890-1)
2026-06-04 13:49:00,954 - INFO - Waiting for VM test_vm to be up..
2026-06-04 13:49:01,044 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-06-04 13:49:06,134 - DEBUG - VM is in ACTIVE state now
2026-06-04 13:49:06,134 - INFO - VM name : test_vm
2026-06-04 13:49:06,282 - DEBUG - VM test_vm ID is f33dfaa9-c0fa-4cac-8e26-839cbf4b6522
2026-06-04 13:49:06,282 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-5890-2
2026-06-04 13:49:06,400 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/f33dfaa9-c0fa-4cac-8e26-839cbf4b6522
2026-06-04 13:49:06,418 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/15d80661-b56a-4c79-9587-25ee305a3aa4
2026-06-04 13:49:09,602 - 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 1007ms')
2026-06-04 13:49:09,602 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed!
2026-06-04 13:49:09,616 - DEBUG - Gateway for vn default-domain:ctest-TestRP-61186909:ctest-bgpaas_vn-97215021 is 50.46.228.1 and allocation pool is NOT set
2026-06-04 13:49:11,683 - 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.92 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.454 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.454/2.186/3.919/1.732 ms')
2026-06-04 13:49:11,684 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed
2026-06-04 13:49:11,754 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 13:49:11,754 - DEBUG - Waiting to SSH to VM test_vm, IP 50.46.228.3, Port 22
2026-06-04 13:49:11,924 - DEBUG - VM test_vm is ready for SSH connections
2026-06-04 13:49:11,924 - INFO - Waiting for VM test2_vm to be up..
2026-06-04 13:49:12,007 - DEBUG - VM is in ACTIVE state now
2026-06-04 13:49:12,007 - INFO - VM name : test2_vm
2026-06-04 13:49:12,092 - DEBUG - VM test2_vm ID is 50cd9515-b0d4-4129-b22a-c920954cf13a
2026-06-04 13:49:12,092 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-5890-1
2026-06-04 13:49:12,209 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/50cd9515-b0d4-4129-b22a-c920954cf13a
2026-06-04 13:49:12,224 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/b0b9e2c8-1d7b-466b-9e4b-3fa16083db21
2026-06-04 13:49:13,407 - 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.55 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.567 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.567/2.057/3.548/1.490 ms')
2026-06-04 13:49:13,407 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed
2026-06-04 13:49:13,477 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 13:49:13,478 - DEBUG - Waiting to SSH to VM test2_vm, IP 45.145.216.3, Port 22
2026-06-04 13:49:13,640 - DEBUG - VM test2_vm is ready for SSH connections
2026-06-04 13:49:13,809 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 13:49:13,824 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-61186909:ctest-bgpaas_vn-97215021:ctest-bgpaas_vn-97215021.inet.0
2026-06-04 13:49:13,839 - DEBUG - Requesting: http://10.20.0.254:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-61186909:ctest-bgpaas_vn-97215021:ctest-bgpaas_vn-97215021.inet.0
2026-06-04 13:49:13,853 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 13:49:13,854 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 45.145.216.3, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.19, gateway password: c0ntrail123
2026-06-04 13:49:13,854 - DEBUG - ping -s 56 -c 3 -W 1 45.145.216.3
2026-06-04 13:49:17,558 - DEBUG - PING 45.145.216.3 (45.145.216.3): 56 data bytes
64 bytes from 45.145.216.3: seq=0 ttl=63 time=7.818 ms
64 bytes from 45.145.216.3: seq=1 ttl=63 time=1.662 ms
64 bytes from 45.145.216.3: seq=2 ttl=63 time=1.411 ms
--- 45.145.216.3 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.411/3.630/7.818 ms
2026-06-04 13:49:17,558 - INFO - Ping to IP 45.145.216.3 from VM test_vm passed
2026-06-04 13:49:17,741 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 13:49:17,755 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-61186909:ctest-bgpaas_vn-97215021:ctest-bgpaas_vn-97215021.inet.0
2026-06-04 13:49:17,772 - DEBUG - Requesting: http://10.20.0.254:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-61186909:ctest-bgpaas_vn-97215021:ctest-bgpaas_vn-97215021.inet.0
2026-06-04 13:49:18,076 - INFO - Deleting VM test2_vm
2026-06-04 13:49:18,173 - INFO - Deleting VM test_vm
2026-06-04 13:49:18,244 - INFO - Deleting VN ctest-bgpaas_vn-50254527
2026-06-04 13:49:18,290 - DEBUG - VN 392a3714-1f6f-4fd9-ad23-411f59305478 still in use: Unable to complete operation on network 392a3714-1f6f-4fd9-ad23-411f59305478. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-2d542ec1-dc9f-417d-baa3-fe13cc053ad1']
2026-06-04 13:49:18,290 - WARNING - Deleting VN ctest-bgpaas_vn-50254527 failed..Will retry
2026-06-04 13:49:20,450 - DEBUG - Response for deleting network ()
2026-06-04 13:49:20,450 - INFO - Deleting VN ctest-bgpaas_vn-97215021
2026-06-04 13:49:20,639 - DEBUG - Response for deleting network ()
2026-06-04 13:49:21,919 - DEBUG - No XMPP flaps were noticed during the test
2026-06-04 13:49:21,919 - INFO - --------------------------------------------------------------------------------
2026-06-04 13:49:21,922 - INFO - ================================================================================
2026-06-04 13:49:21,922 - INFO - STARTING TEST : test_rp_interface_static
2026-06-04 13:49:21,922 - 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-06-04 13:49:23,199 - DEBUG - Nothing to compare xmpp stats {'10.0.0.22': {'10.20.0.25': '0', '10.20.0.14': '0'}, '10.0.0.19': {'10.20.0.14': '0', '10.20.0.254': '0'}} with
2026-06-04 13:49:23,199 - INFO - Initial checks done. Running the testcase now
2026-06-04 13:49:23,199 - INFO -
2026-06-04 13:49:23,468 - DEBUG - Response for create_network : {'network': {'id': '12860281-1257-404c-a887-f3d3a2e97572', 'name': 'ctest-bgpaas_vn-36093189', 'tenant_id': '98b36fc4cd3f41b19c3995a5141f7970', 'project_id': '98b36fc4cd3f41b19c3995a5141f7970', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-61186909', 'ctest-bgpaas_vn-36093189'], 'port_security_enabled': True, 'description': ''}}
2026-06-04 13:49:23,743 - DEBUG - Response for create_subnet : {'subnet': {'id': 'd3d1086b-30e8-4744-8b5e-91164bb0576b', 'name': '', 'tenant_id': '98b36fc4cd3f41b19c3995a5141f7970', 'network_id': '12860281-1257-404c-a887-f3d3a2e97572', 'ip_version': 4, 'cidr': '2.129.176.64/26', 'allocation_pools': [{'start': '2.129.176.66', 'end': '2.129.176.126'}], 'gateway_ip': '2.129.176.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '2.129.176.66', 'tags': [], 'project_id': '98b36fc4cd3f41b19c3995a5141f7970'}}
2026-06-04 13:49:23,770 - INFO - Created VN ctest-bgpaas_vn-36093189
2026-06-04 13:49:23,783 - DEBUG - VN ctest-bgpaas_vn-36093189 UUID is 12860281-1257-404c-a887-f3d3a2e97572
2026-06-04 13:49:24,310 - DEBUG - Response for create_network : {'network': {'id': '5672558c-1c76-4b40-a2dc-3592a698e40b', 'name': 'ctest-bgpaas_vn-44515777', 'tenant_id': '98b36fc4cd3f41b19c3995a5141f7970', 'project_id': '98b36fc4cd3f41b19c3995a5141f7970', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-61186909', 'ctest-bgpaas_vn-44515777'], 'port_security_enabled': True, 'description': ''}}
2026-06-04 13:49:24,540 - DEBUG - Response for create_subnet : {'subnet': {'id': '339b77a1-d402-450f-9c12-39448831a03a', 'name': '', 'tenant_id': '98b36fc4cd3f41b19c3995a5141f7970', 'network_id': '5672558c-1c76-4b40-a2dc-3592a698e40b', 'ip_version': 4, 'cidr': '148.53.254.192/26', 'allocation_pools': [{'start': '148.53.254.194', 'end': '148.53.254.254'}], 'gateway_ip': '148.53.254.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '148.53.254.194', 'tags': [], 'project_id': '98b36fc4cd3f41b19c3995a5141f7970'}}
2026-06-04 13:49:24,563 - INFO - Created VN ctest-bgpaas_vn-44515777
2026-06-04 13:49:24,575 - DEBUG - VN ctest-bgpaas_vn-44515777 UUID is 5672558c-1c76-4b40-a2dc-3592a698e40b
2026-06-04 13:49:25,940 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5890-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5890-2)
2026-06-04 13:49:27,360 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5890-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5890-1)
2026-06-04 13:49:27,361 - INFO - Waiting for VM test_vm to be up..
2026-06-04 13:49:27,459 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2026-06-04 13:49:32,549 - DEBUG - VM is in ACTIVE state now
2026-06-04 13:49:32,549 - INFO - VM name : test_vm
2026-06-04 13:49:32,629 - DEBUG - VM test_vm ID is c890ca07-1be7-4ba5-8909-ebcabc3f72d8
2026-06-04 13:49:32,629 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-5890-2
2026-06-04 13:49:32,720 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/c890ca07-1be7-4ba5-8909-ebcabc3f72d8
2026-06-04 13:49:32,734 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/39414765-7f95-406d-80a2-c4c4d9019708
2026-06-04 13:49:35,934 - 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-06-04 13:49:35,934 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed!
2026-06-04 13:49:35,950 - DEBUG - Gateway for vn default-domain:ctest-TestRP-61186909:ctest-bgpaas_vn-36093189 is 2.129.176.65 and allocation pool is NOT set
2026-06-04 13:49:38,010 - 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.94 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.842 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.842/2.393/3.944/1.551 ms')
2026-06-04 13:49:38,011 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed
2026-06-04 13:49:38,082 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 13:49:38,082 - DEBUG - Waiting to SSH to VM test_vm, IP 2.129.176.67, Port 22
2026-06-04 13:49:38,252 - DEBUG - VM test_vm is ready for SSH connections
2026-06-04 13:49:38,252 - INFO - Waiting for VM test2_vm to be up..
2026-06-04 13:49:38,342 - DEBUG - VM is in ACTIVE state now
2026-06-04 13:49:38,342 - INFO - VM name : test2_vm
2026-06-04 13:49:38,435 - DEBUG - VM test2_vm ID is e5095c98-e2c6-4151-8d13-03072acb1328
2026-06-04 13:49:38,435 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-5890-1
2026-06-04 13:49:38,530 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/e5095c98-e2c6-4151-8d13-03072acb1328
2026-06-04 13:49:38,543 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/34ae3476-70a5-4583-b9f3-4683898e5a91
2026-06-04 13:49:39,721 - 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.37 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=2.49 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.487/4.429/6.371/1.942 ms')
2026-06-04 13:49:39,721 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed
2026-06-04 13:49:39,795 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 13:49:39,795 - DEBUG - Waiting to SSH to VM test2_vm, IP 148.53.254.195, Port 22
2026-06-04 13:49:39,971 - DEBUG - VM test2_vm is ready for SSH connections
2026-06-04 13:49:40,081 - INFO - Created InterfaceRouteTable ['default-domain', 'ctest-TestRP-61186909', 'ctest-int_table_right-39688950'](UUID f865afab-005e-4be1-9554-b8ffc54a5ce0), prefixes : ['169.43.3.0/26']
2026-06-04 13:49:40,173 - INFO - Added intf route table f865afab-005e-4be1-9554-b8ffc54a5ce0 to port 39414765-7f95-406d-80a2-c4c4d9019708
2026-06-04 13:49:40,418 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-61186909:ctest-bgpaas_vn-36093189:ctest-bgpaas_vn-36093189.inet.0
2026-06-04 13:49:40,432 - DEBUG - Requesting: http://10.20.0.254:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-61186909:ctest-bgpaas_vn-36093189:ctest-bgpaas_vn-36093189.inet.0
2026-06-04 13:49:40,445 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2026-06-04 13:49:40,445 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 148.53.254.195, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.19, gateway password: c0ntrail123
2026-06-04 13:49:40,445 - DEBUG - ping -s 56 -c 3 -W 1 148.53.254.195
2026-06-04 13:49:44,116 - DEBUG - PING 148.53.254.195 (148.53.254.195): 56 data bytes
64 bytes from 148.53.254.195: seq=0 ttl=63 time=8.099 ms
64 bytes from 148.53.254.195: seq=1 ttl=63 time=1.752 ms
64 bytes from 148.53.254.195: seq=2 ttl=63 time=1.638 ms
--- 148.53.254.195 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.638/3.829/8.099 ms
2026-06-04 13:49:44,117 - INFO - Ping to IP 148.53.254.195 from VM test_vm passed
2026-06-04 13:49:44,244 - INFO - Deleting VM test2_vm
2026-06-04 13:49:44,344 - INFO - Deleting VM test_vm
2026-06-04 13:49:44,420 - INFO - Deleting VN ctest-bgpaas_vn-44515777
2026-06-04 13:49:44,485 - DEBUG - VN 5672558c-1c76-4b40-a2dc-3592a698e40b still in use: Unable to complete operation on network 5672558c-1c76-4b40-a2dc-3592a698e40b. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-65f4bfba-e941-4792-b11b-2c5796df2efe']
2026-06-04 13:49:44,485 - WARNING - Deleting VN ctest-bgpaas_vn-44515777 failed..Will retry
2026-06-04 13:49:46,694 - DEBUG - Response for deleting network ()
2026-06-04 13:49:46,694 - INFO - Deleting VN ctest-bgpaas_vn-36093189
2026-06-04 13:49:46,887 - DEBUG - Response for deleting network ()
2026-06-04 13:49:48,162 - DEBUG - No XMPP flaps were noticed during the test
2026-06-04 13:49:48,162 - INFO - END TEST : test_rp_interface_static : PASSED[0:00:27]
2026-06-04 13:49:48,163 - INFO - --------------------------------------------------------------------------------
2026-06-04 13:49:48,884 - INFO - Deleted project: ctest-TestRP-61186909, ID : 98b36fc4-cd3f-41b1-9c39-95a5141f7970