2025-12-25 03:12:30,395 - INFO - Domain Default found not creating
2025-12-25 03:12:30,597 - INFO - Project ctest-TestRP-33464389 not found, creating it
2025-12-25 03:12:31,209 - INFO - Created Project:ctest-TestRP-33464389, ID : 994bdac0-cff2-469e-80ed-c89978aca274
2025-12-25 03:12:33,192 - DEBUG - Services list from nova: [, , , ]
2025-12-25 03:12:33,193 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-4927-1', 'an-jenkins-deploy-platform-ansible-os-4927-2']}
2025-12-25 03:12:33,196 - INFO - ================================================================================
2025-12-25 03:12:33,196 - INFO - STARTING TEST : test_rp_interface
2025-12-25 03:12:33,196 - 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.
2025-12-25 03:12:34,482 - DEBUG - Nothing to compare xmpp stats {'10.0.0.19': {'10.20.0.18': '0', '10.20.0.14': '0'}, '10.0.0.130': {'10.20.0.14': '0', '10.20.0.209': '0'}} with
2025-12-25 03:12:34,482 - INFO - Initial checks done. Running the testcase now
2025-12-25 03:12:34,482 - INFO -
2025-12-25 03:12:35,284 - DEBUG - Response for create_network : {'network': {'id': 'a0bf0485-5d68-4afe-a199-f4de657011ec', 'name': 'ctest-bgpaas_vn-12233179', 'tenant_id': '994bdac0cff2469e80edc89978aca274', 'project_id': '994bdac0cff2469e80edc89978aca274', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-33464389', 'ctest-bgpaas_vn-12233179'], 'port_security_enabled': True, 'description': ''}}
2025-12-25 03:12:35,552 - DEBUG - Response for create_subnet : {'subnet': {'id': '0a632789-edac-49f5-b0ee-ca33b119b597', 'name': '', 'tenant_id': '994bdac0cff2469e80edc89978aca274', 'network_id': 'a0bf0485-5d68-4afe-a199-f4de657011ec', 'ip_version': 4, 'cidr': '190.225.217.128/26', 'allocation_pools': [{'start': '190.225.217.130', 'end': '190.225.217.190'}], 'gateway_ip': '190.225.217.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '190.225.217.130', 'tags': [], 'project_id': '994bdac0cff2469e80edc89978aca274'}}
2025-12-25 03:12:35,575 - INFO - Created VN ctest-bgpaas_vn-12233179
2025-12-25 03:12:35,588 - DEBUG - VN ctest-bgpaas_vn-12233179 UUID is a0bf0485-5d68-4afe-a199-f4de657011ec
2025-12-25 03:12:36,127 - DEBUG - Response for create_network : {'network': {'id': 'e96c9a40-738f-4eed-bf8a-89176e0f5b5d', 'name': 'ctest-bgpaas_vn-12557121', 'tenant_id': '994bdac0cff2469e80edc89978aca274', 'project_id': '994bdac0cff2469e80edc89978aca274', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-33464389', 'ctest-bgpaas_vn-12557121'], 'port_security_enabled': True, 'description': ''}}
2025-12-25 03:12:36,394 - DEBUG - Response for create_subnet : {'subnet': {'id': '3561154e-ecd7-4663-afc8-6313f86803fd', 'name': '', 'tenant_id': '994bdac0cff2469e80edc89978aca274', 'network_id': 'e96c9a40-738f-4eed-bf8a-89176e0f5b5d', 'ip_version': 4, 'cidr': '126.165.140.64/26', 'allocation_pools': [{'start': '126.165.140.66', 'end': '126.165.140.126'}], 'gateway_ip': '126.165.140.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '126.165.140.66', 'tags': [], 'project_id': '994bdac0cff2469e80edc89978aca274'}}
2025-12-25 03:12:36,437 - INFO - Created VN ctest-bgpaas_vn-12557121
2025-12-25 03:12:36,453 - DEBUG - VN ctest-bgpaas_vn-12557121 UUID is e96c9a40-738f-4eed-bf8a-89176e0f5b5d
2025-12-25 03:12:38,062 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4927-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4927-1)
2025-12-25 03:12:39,680 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4927-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4927-2)
2025-12-25 03:12:39,681 - INFO - Waiting for VM test_vm to be up..
2025-12-25 03:12:39,811 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2025-12-25 03:12:44,912 - DEBUG - VM is in ACTIVE state now
2025-12-25 03:12:44,913 - INFO - VM name : test_vm
2025-12-25 03:12:45,015 - DEBUG - VM test_vm ID is 4f2f6b58-3d73-4544-8f3f-dba6bbe14564
2025-12-25 03:12:45,059 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-4927-1
2025-12-25 03:12:45,163 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/4f2f6b58-3d73-4544-8f3f-dba6bbe14564
2025-12-25 03:12:45,535 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/4f2f6b58-3d73-4544-8f3f-dba6bbe14564
2025-12-25 03:12:45,585 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/462f9d9c-f074-4500-82e7-f222595c27bc
2025-12-25 03:12:48,788 - 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 1030ms')
2025-12-25 03:12:48,788 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed!
2025-12-25 03:12:48,804 - DEBUG - Gateway for vn default-domain:ctest-TestRP-33464389:ctest-bgpaas_vn-12233179 is 190.225.217.129 and allocation pool is NOT set
2025-12-25 03:12:50,867 - 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.83 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.530 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.530/2.182/3.834/1.652 ms')
2025-12-25 03:12:50,867 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed
2025-12-25 03:12:50,943 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-25 03:12:50,943 - DEBUG - Waiting to SSH to VM test_vm, IP 190.225.217.131, Port 22
2025-12-25 03:12:51,119 - DEBUG - VM test_vm is ready for SSH connections
2025-12-25 03:12:51,119 - INFO - Waiting for VM test2_vm to be up..
2025-12-25 03:12:51,217 - DEBUG - VM is in ACTIVE state now
2025-12-25 03:12:51,217 - INFO - VM name : test2_vm
2025-12-25 03:12:51,316 - DEBUG - VM test2_vm ID is 8075d79f-2e69-4638-80bf-1f31d14d59c4
2025-12-25 03:12:51,316 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-4927-2
2025-12-25 03:12:51,421 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/8075d79f-2e69-4638-80bf-1f31d14d59c4
2025-12-25 03:12:51,432 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/0ccd80f1-c017-4097-8914-00460617c919
2025-12-25 03:12:52,605 - 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=5.60 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=2.48 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.476/4.037/5.598/1.561 ms')
2025-12-25 03:12:52,605 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed
2025-12-25 03:12:52,682 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-25 03:12:52,682 - DEBUG - Waiting to SSH to VM test2_vm, IP 126.165.140.67, Port 22
2025-12-25 03:12:52,747 - 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': ''}
2025-12-25 03:12:52,855 - DEBUG - VM test2_vm is NOT ready for SSH connections, VM status: ACTIVE
2025-12-25 03:12:57,856 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-25 03:12:57,856 - DEBUG - Waiting to SSH to VM test2_vm, IP 126.165.140.67, Port 22
2025-12-25 03:12:58,024 - DEBUG - VM test2_vm is ready for SSH connections
2025-12-25 03:12:58,200 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-25 03:12:58,226 - DEBUG - Requesting: http://10.20.0.18:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-33464389:ctest-bgpaas_vn-12233179:ctest-bgpaas_vn-12233179.inet.0
2025-12-25 03:12:58,247 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-33464389:ctest-bgpaas_vn-12233179:ctest-bgpaas_vn-12233179.inet.0
2025-12-25 03:12:58,261 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-25 03:12:58,261 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 126.165.140.67, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.19, gateway password: c0ntrail123
2025-12-25 03:12:58,261 - DEBUG - ping -s 56 -c 3 -W 1 126.165.140.67
2025-12-25 03:13:02,295 - DEBUG - PING 126.165.140.67 (126.165.140.67): 56 data bytes
64 bytes from 126.165.140.67: seq=0 ttl=63 time=6.334 ms
64 bytes from 126.165.140.67: seq=1 ttl=63 time=1.656 ms
64 bytes from 126.165.140.67: seq=2 ttl=63 time=1.413 ms
--- 126.165.140.67 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.413/3.134/6.334 ms
2025-12-25 03:13:02,296 - INFO - Ping to IP 126.165.140.67 from VM test_vm passed
2025-12-25 03:13:02,422 - INFO - Deleting VM test2_vm
2025-12-25 03:13:02,649 - INFO - Deleting VM test_vm
2025-12-25 03:13:02,800 - INFO - Deleting VN ctest-bgpaas_vn-12557121
2025-12-25 03:13:02,853 - DEBUG - VN e96c9a40-738f-4eed-bf8a-89176e0f5b5d still in use: Unable to complete operation on network e96c9a40-738f-4eed-bf8a-89176e0f5b5d. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-63cfd3d8-8d10-465c-8be8-1f91ce062a2d']
2025-12-25 03:13:02,854 - WARNING - Deleting VN ctest-bgpaas_vn-12557121 failed..Will retry
2025-12-25 03:13:05,044 - DEBUG - Response for deleting network ()
2025-12-25 03:13:05,044 - INFO - Deleting VN ctest-bgpaas_vn-12233179
2025-12-25 03:13:05,248 - DEBUG - Response for deleting network ()
2025-12-25 03:13:06,554 - DEBUG - No XMPP flaps were noticed during the test
2025-12-25 03:13:06,554 - INFO - END TEST : test_rp_interface : PASSED[0:00:33]
2025-12-25 03:13:06,554 - INFO - --------------------------------------------------------------------------------
2025-12-25 03:13:06,560 - INFO - ================================================================================
2025-12-25 03:13:06,560 - INFO - STARTING TEST : test_rp_interface_ext_community
2025-12-25 03:13:06,561 - 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.
2025-12-25 03:13:07,873 - DEBUG - Nothing to compare xmpp stats {'10.0.0.19': {'10.20.0.18': '0', '10.20.0.14': '0'}, '10.0.0.130': {'10.20.0.14': '0', '10.20.0.209': '0'}} with
2025-12-25 03:13:07,873 - INFO - Initial checks done. Running the testcase now
2025-12-25 03:13:07,873 - INFO -
2025-12-25 03:13:08,210 - DEBUG - Response for create_network : {'network': {'id': '41bda504-00d2-49a3-ad7b-35583631320a', 'name': 'ctest-bgpaas_vn-67598867', 'tenant_id': '994bdac0cff2469e80edc89978aca274', 'project_id': '994bdac0cff2469e80edc89978aca274', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-33464389', 'ctest-bgpaas_vn-67598867'], 'port_security_enabled': True, 'description': ''}}
2025-12-25 03:13:08,465 - DEBUG - Response for create_subnet : {'subnet': {'id': '351d4925-08d6-471b-b9de-3e3b7e54e305', 'name': '', 'tenant_id': '994bdac0cff2469e80edc89978aca274', 'network_id': '41bda504-00d2-49a3-ad7b-35583631320a', 'ip_version': 4, 'cidr': '121.170.238.192/26', 'allocation_pools': [{'start': '121.170.238.194', 'end': '121.170.238.254'}], 'gateway_ip': '121.170.238.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '121.170.238.194', 'tags': [], 'project_id': '994bdac0cff2469e80edc89978aca274'}}
2025-12-25 03:13:08,492 - INFO - Created VN ctest-bgpaas_vn-67598867
2025-12-25 03:13:08,505 - DEBUG - VN ctest-bgpaas_vn-67598867 UUID is 41bda504-00d2-49a3-ad7b-35583631320a
2025-12-25 03:13:09,011 - DEBUG - Response for create_network : {'network': {'id': 'a0c19a8b-0d22-4ba6-b31d-82a4576b8116', 'name': 'ctest-bgpaas_vn-66345147', 'tenant_id': '994bdac0cff2469e80edc89978aca274', 'project_id': '994bdac0cff2469e80edc89978aca274', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-33464389', 'ctest-bgpaas_vn-66345147'], 'port_security_enabled': True, 'description': ''}}
2025-12-25 03:13:09,263 - DEBUG - Response for create_subnet : {'subnet': {'id': '95dfbd35-4006-40a2-a347-ec8cb11cc91d', 'name': '', 'tenant_id': '994bdac0cff2469e80edc89978aca274', 'network_id': 'a0c19a8b-0d22-4ba6-b31d-82a4576b8116', 'ip_version': 4, 'cidr': '185.202.100.192/26', 'allocation_pools': [{'start': '185.202.100.194', 'end': '185.202.100.254'}], 'gateway_ip': '185.202.100.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '185.202.100.194', 'tags': [], 'project_id': '994bdac0cff2469e80edc89978aca274'}}
2025-12-25 03:13:09,288 - INFO - Created VN ctest-bgpaas_vn-66345147
2025-12-25 03:13:09,301 - DEBUG - VN ctest-bgpaas_vn-66345147 UUID is a0c19a8b-0d22-4ba6-b31d-82a4576b8116
2025-12-25 03:13:10,816 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4927-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4927-1)
2025-12-25 03:13:12,406 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4927-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4927-2)
2025-12-25 03:13:12,406 - INFO - Waiting for VM test_vm to be up..
2025-12-25 03:13:12,535 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2025-12-25 03:13:17,634 - DEBUG - VM is in ACTIVE state now
2025-12-25 03:13:17,634 - INFO - VM name : test_vm
2025-12-25 03:13:17,747 - DEBUG - VM test_vm ID is e4b34513-e7e8-41b7-b89a-5fbc64a48696
2025-12-25 03:13:17,747 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-4927-1
2025-12-25 03:13:17,860 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/e4b34513-e7e8-41b7-b89a-5fbc64a48696
2025-12-25 03:13:17,871 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/ac30b278-a7ed-4416-9310-f8bbd8095799
2025-12-25 03:13:21,078 - 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')
2025-12-25 03:13:21,078 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed!
2025-12-25 03:13:21,096 - DEBUG - Gateway for vn default-domain:ctest-TestRP-33464389:ctest-bgpaas_vn-67598867 is 121.170.238.193 and allocation pool is NOT set
2025-12-25 03:13:23,160 - 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=9.10 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.95 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.950/5.524/9.099/3.574 ms')
2025-12-25 03:13:23,160 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed
2025-12-25 03:13:23,233 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-25 03:13:23,233 - DEBUG - Waiting to SSH to VM test_vm, IP 121.170.238.195, Port 22
2025-12-25 03:13:23,388 - DEBUG - VM test_vm is ready for SSH connections
2025-12-25 03:13:23,388 - INFO - Waiting for VM test2_vm to be up..
2025-12-25 03:13:23,492 - DEBUG - VM is in ACTIVE state now
2025-12-25 03:13:23,492 - INFO - VM name : test2_vm
2025-12-25 03:13:23,591 - DEBUG - VM test2_vm ID is 098d1416-4216-4651-a04a-d6083e9445c9
2025-12-25 03:13:23,592 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-4927-2
2025-12-25 03:13:23,700 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/098d1416-4216-4651-a04a-d6083e9445c9
2025-12-25 03:13:23,718 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/c8f13576-e645-476b-aaad-35708e5facbf
2025-12-25 03:13:24,887 - 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=5.97 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.999 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.999/3.484/5.969/2.485 ms')
2025-12-25 03:13:24,888 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed
2025-12-25 03:13:24,957 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-25 03:13:24,957 - DEBUG - Waiting to SSH to VM test2_vm, IP 185.202.100.195, Port 22
2025-12-25 03:13:25,124 - DEBUG - VM test2_vm is ready for SSH connections
2025-12-25 03:13:25,308 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-25 03:13:25,325 - DEBUG - Requesting: http://10.20.0.18:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-33464389:ctest-bgpaas_vn-67598867:ctest-bgpaas_vn-67598867.inet.0
2025-12-25 03:13:25,353 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-33464389:ctest-bgpaas_vn-67598867:ctest-bgpaas_vn-67598867.inet.0
2025-12-25 03:13:25,367 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-25 03:13:25,367 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 185.202.100.195, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.19, gateway password: c0ntrail123
2025-12-25 03:13:25,367 - DEBUG - ping -s 56 -c 3 -W 1 185.202.100.195
2025-12-25 03:13:29,073 - DEBUG - PING 185.202.100.195 (185.202.100.195): 56 data bytes
64 bytes from 185.202.100.195: seq=0 ttl=63 time=6.016 ms
64 bytes from 185.202.100.195: seq=1 ttl=63 time=1.315 ms
64 bytes from 185.202.100.195: seq=2 ttl=63 time=1.341 ms
--- 185.202.100.195 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.315/2.890/6.016 ms
2025-12-25 03:13:29,073 - INFO - Ping to IP 185.202.100.195 from VM test_vm passed
2025-12-25 03:13:29,252 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-25 03:13:29,265 - DEBUG - Requesting: http://10.20.0.18:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-33464389:ctest-bgpaas_vn-67598867:ctest-bgpaas_vn-67598867.inet.0
2025-12-25 03:13:30,282 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-25 03:13:30,296 - DEBUG - Requesting: http://10.20.0.18:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-33464389:ctest-bgpaas_vn-67598867:ctest-bgpaas_vn-67598867.inet.0
2025-12-25 03:13:30,312 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-33464389:ctest-bgpaas_vn-67598867:ctest-bgpaas_vn-67598867.inet.0
2025-12-25 03:13:30,594 - INFO - Deleting VM test2_vm
2025-12-25 03:13:30,699 - INFO - Deleting VM test_vm
2025-12-25 03:13:30,796 - INFO - Deleting VN ctest-bgpaas_vn-66345147
2025-12-25 03:13:30,849 - DEBUG - VN a0c19a8b-0d22-4ba6-b31d-82a4576b8116 still in use: Unable to complete operation on network a0c19a8b-0d22-4ba6-b31d-82a4576b8116. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-6690e5a1-29de-402f-88c7-f8ef31f38723']
2025-12-25 03:13:30,850 - WARNING - Deleting VN ctest-bgpaas_vn-66345147 failed..Will retry
2025-12-25 03:13:33,031 - DEBUG - Response for deleting network ()
2025-12-25 03:13:33,031 - INFO - Deleting VN ctest-bgpaas_vn-67598867
2025-12-25 03:13:33,283 - DEBUG - Response for deleting network ()
2025-12-25 03:13:34,609 - DEBUG - No XMPP flaps were noticed during the test
2025-12-25 03:13:34,609 - INFO - --------------------------------------------------------------------------------
2025-12-25 03:13:34,612 - INFO - ================================================================================
2025-12-25 03:13:34,612 - INFO - STARTING TEST : test_rp_interface_static
2025-12-25 03:13:34,612 - 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.
2025-12-25 03:13:35,900 - DEBUG - Nothing to compare xmpp stats {'10.0.0.19': {'10.20.0.18': '0', '10.20.0.14': '0'}, '10.0.0.130': {'10.20.0.14': '0', '10.20.0.209': '0'}} with
2025-12-25 03:13:35,901 - INFO - Initial checks done. Running the testcase now
2025-12-25 03:13:35,901 - INFO -
2025-12-25 03:13:36,196 - DEBUG - Response for create_network : {'network': {'id': '0d76b857-3ea4-4a63-8216-f9a54d8c9ff1', 'name': 'ctest-bgpaas_vn-24939276', 'tenant_id': '994bdac0cff2469e80edc89978aca274', 'project_id': '994bdac0cff2469e80edc89978aca274', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-33464389', 'ctest-bgpaas_vn-24939276'], 'port_security_enabled': True, 'description': ''}}
2025-12-25 03:13:36,521 - DEBUG - Response for create_subnet : {'subnet': {'id': '68ea1741-53af-4e08-8627-87dc2a9252e3', 'name': '', 'tenant_id': '994bdac0cff2469e80edc89978aca274', 'network_id': '0d76b857-3ea4-4a63-8216-f9a54d8c9ff1', 'ip_version': 4, 'cidr': '83.13.232.128/26', 'allocation_pools': [{'start': '83.13.232.130', 'end': '83.13.232.190'}], 'gateway_ip': '83.13.232.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '83.13.232.130', 'tags': [], 'project_id': '994bdac0cff2469e80edc89978aca274'}}
2025-12-25 03:13:36,554 - INFO - Created VN ctest-bgpaas_vn-24939276
2025-12-25 03:13:36,571 - DEBUG - VN ctest-bgpaas_vn-24939276 UUID is 0d76b857-3ea4-4a63-8216-f9a54d8c9ff1
2025-12-25 03:13:37,153 - DEBUG - Response for create_network : {'network': {'id': '5b5adb1b-d975-4cd8-afd5-3f16bda2291a', 'name': 'ctest-bgpaas_vn-65613966', 'tenant_id': '994bdac0cff2469e80edc89978aca274', 'project_id': '994bdac0cff2469e80edc89978aca274', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-33464389', 'ctest-bgpaas_vn-65613966'], 'port_security_enabled': True, 'description': ''}}
2025-12-25 03:13:37,429 - DEBUG - Response for create_subnet : {'subnet': {'id': 'eec7761b-faf2-48ae-a6a1-18bd24038928', 'name': '', 'tenant_id': '994bdac0cff2469e80edc89978aca274', 'network_id': '5b5adb1b-d975-4cd8-afd5-3f16bda2291a', 'ip_version': 4, 'cidr': '95.3.222.64/26', 'allocation_pools': [{'start': '95.3.222.66', 'end': '95.3.222.126'}], 'gateway_ip': '95.3.222.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '95.3.222.66', 'tags': [], 'project_id': '994bdac0cff2469e80edc89978aca274'}}
2025-12-25 03:13:37,463 - INFO - Created VN ctest-bgpaas_vn-65613966
2025-12-25 03:13:37,475 - DEBUG - VN ctest-bgpaas_vn-65613966 UUID is 5b5adb1b-d975-4cd8-afd5-3f16bda2291a
2025-12-25 03:13:39,026 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4927-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4927-1)
2025-12-25 03:13:40,646 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4927-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4927-2)
2025-12-25 03:13:40,646 - INFO - Waiting for VM test_vm to be up..
2025-12-25 03:13:40,747 - DEBUG - VM is still in BUILD state, Expected: ACTIVE
2025-12-25 03:13:45,855 - DEBUG - VM is in ACTIVE state now
2025-12-25 03:13:45,855 - INFO - VM name : test_vm
2025-12-25 03:13:45,952 - DEBUG - VM test_vm ID is 22a68381-76bb-43b2-b0e2-c99d36c9ba84
2025-12-25 03:13:45,952 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-4927-1
2025-12-25 03:13:46,059 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/22a68381-76bb-43b2-b0e2-c99d36c9ba84
2025-12-25 03:13:46,072 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/70873fb8-9f94-4603-8c2d-ec2d272592ba
2025-12-25 03:13:49,238 - 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 1003ms')
2025-12-25 03:13:49,238 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed!
2025-12-25 03:13:49,255 - DEBUG - Gateway for vn default-domain:ctest-TestRP-33464389:ctest-bgpaas_vn-24939276 is 83.13.232.129 and allocation pool is NOT set
2025-12-25 03:13:51,326 - 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=9.17 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.12 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.116/5.145/9.174/4.029 ms')
2025-12-25 03:13:51,326 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed
2025-12-25 03:13:51,397 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-25 03:13:51,398 - DEBUG - Waiting to SSH to VM test_vm, IP 83.13.232.131, Port 22
2025-12-25 03:13:51,572 - DEBUG - VM test_vm is ready for SSH connections
2025-12-25 03:13:51,572 - INFO - Waiting for VM test2_vm to be up..
2025-12-25 03:13:51,670 - DEBUG - VM is in ACTIVE state now
2025-12-25 03:13:51,670 - INFO - VM name : test2_vm
2025-12-25 03:13:51,763 - DEBUG - VM test2_vm ID is 4e15670e-5de0-48fa-a929-738c8a90d59d
2025-12-25 03:13:51,764 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-4927-2
2025-12-25 03:13:51,857 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine/4e15670e-5de0-48fa-a929-738c8a90d59d
2025-12-25 03:13:51,868 - DEBUG - Requesting: http://10.0.0.23:8082/virtual-machine-interface/c511b4e5-3369-43ea-8b27-4a7f28ca0ab0
2025-12-25 03:13:53,038 - 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.36 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.520 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.520/2.438/4.356/1.918 ms')
2025-12-25 03:13:53,038 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed
2025-12-25 03:13:53,109 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-25 03:13:53,109 - DEBUG - Waiting to SSH to VM test2_vm, IP 95.3.222.67, Port 22
2025-12-25 03:13:53,265 - DEBUG - VM test2_vm is ready for SSH connections
2025-12-25 03:13:53,364 - INFO - Created InterfaceRouteTable ['default-domain', 'ctest-TestRP-33464389', 'ctest-int_table_right-27973020'](UUID cbd1a9eb-0a2a-41fb-b93e-bc228ed3670e), prefixes : ['107.246.38.192/26']
2025-12-25 03:13:53,440 - INFO - Added intf route table cbd1a9eb-0a2a-41fb-b93e-bc228ed3670e to port 70873fb8-9f94-4603-8c2d-ec2d272592ba
2025-12-25 03:13:53,669 - DEBUG - Requesting: http://10.20.0.18:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-33464389:ctest-bgpaas_vn-24939276:ctest-bgpaas_vn-24939276.inet.0
2025-12-25 03:13:53,687 - DEBUG - Requesting: http://10.20.0.14:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-33464389:ctest-bgpaas_vn-24939276:ctest-bgpaas_vn-24939276.inet.0
2025-12-25 03:13:53,702 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set
2025-12-25 03:13:53,702 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 95.3.222.67, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.19, gateway password: c0ntrail123
2025-12-25 03:13:53,702 - DEBUG - ping -s 56 -c 3 -W 1 95.3.222.67
2025-12-25 03:13:57,561 - DEBUG - PING 95.3.222.67 (95.3.222.67): 56 data bytes
64 bytes from 95.3.222.67: seq=0 ttl=63 time=6.095 ms
64 bytes from 95.3.222.67: seq=1 ttl=63 time=1.409 ms
64 bytes from 95.3.222.67: seq=2 ttl=63 time=1.332 ms
--- 95.3.222.67 ping statistics ---
3 packets transmitted, 3 packets received, 0% packet loss
round-trip min/avg/max = 1.332/2.945/6.095 ms
2025-12-25 03:13:57,561 - INFO - Ping to IP 95.3.222.67 from VM test_vm passed
2025-12-25 03:13:57,693 - INFO - Deleting VM test2_vm
2025-12-25 03:13:57,796 - INFO - Deleting VM test_vm
2025-12-25 03:13:57,877 - INFO - Deleting VN ctest-bgpaas_vn-65613966
2025-12-25 03:13:57,946 - DEBUG - VN 5b5adb1b-d975-4cd8-afd5-3f16bda2291a still in use: Unable to complete operation on network 5b5adb1b-d975-4cd8-afd5-3f16bda2291a. There are one or more ports still in use on the network.
Neutron server returns request_ids: ['req-8e152d79-ed22-4e24-b86e-616ed7868244']
2025-12-25 03:13:57,946 - WARNING - Deleting VN ctest-bgpaas_vn-65613966 failed..Will retry
2025-12-25 03:14:00,185 - DEBUG - Response for deleting network ()
2025-12-25 03:14:00,186 - INFO - Deleting VN ctest-bgpaas_vn-24939276
2025-12-25 03:14:00,414 - DEBUG - Response for deleting network ()
2025-12-25 03:14:01,724 - DEBUG - No XMPP flaps were noticed during the test
2025-12-25 03:14:01,724 - INFO - END TEST : test_rp_interface_static : PASSED[0:00:27]
2025-12-25 03:14:01,724 - INFO - --------------------------------------------------------------------------------
2025-12-25 03:14:02,702 - INFO - Deleted project: ctest-TestRP-33464389, ID : 994bdac0-cff2-469e-80ed-c89978aca274