2025-10-30 03:00:48,922 - INFO - Domain Default found not creating 2025-10-30 03:00:49,071 - INFO - Project ctest-TestRP-76717234 not found, creating it 2025-10-30 03:00:49,651 - INFO - Created Project:ctest-TestRP-76717234, ID : 2b4985c7-e420-4c17-991a-b1601e663a3d 2025-10-30 03:00:51,159 - DEBUG - Services list from nova: [, , , ] 2025-10-30 03:00:51,159 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-4535-2', 'an-jenkins-deploy-platform-ansible-os-4535-1']} 2025-10-30 03:00:51,162 - INFO - ================================================================================ 2025-10-30 03:00:51,162 - INFO - STARTING TEST : test_rp_interface 2025-10-30 03:00:51,162 - 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-10-30 03:00:52,435 - DEBUG - Nothing to compare xmpp stats {'10.0.0.129': {'10.20.0.131': '0', '10.20.0.254': '0'}, '10.0.0.65': {'10.20.0.254': '0', '10.20.0.131': '0'}} with 2025-10-30 03:00:52,435 - INFO - Initial checks done. Running the testcase now 2025-10-30 03:00:52,436 - INFO - 2025-10-30 03:00:53,131 - DEBUG - Response for create_network : {'network': {'id': '2b8464f8-1211-4f72-b513-9d690d6a0e84', 'name': 'ctest-bgpaas_vn-99718763', 'tenant_id': '2b4985c7e4204c17991ab1601e663a3d', 'project_id': '2b4985c7e4204c17991ab1601e663a3d', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-76717234', 'ctest-bgpaas_vn-99718763'], 'port_security_enabled': True, 'description': ''}} 2025-10-30 03:00:53,441 - DEBUG - Response for create_subnet : {'subnet': {'id': '07b45c05-8f86-42c1-8661-79cf0ce6bbe9', 'name': '', 'tenant_id': '2b4985c7e4204c17991ab1601e663a3d', 'network_id': '2b8464f8-1211-4f72-b513-9d690d6a0e84', 'ip_version': 4, 'cidr': '221.151.139.64/26', 'allocation_pools': [{'start': '221.151.139.66', 'end': '221.151.139.126'}], 'gateway_ip': '221.151.139.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '221.151.139.66', 'tags': [], 'project_id': '2b4985c7e4204c17991ab1601e663a3d'}} 2025-10-30 03:00:53,462 - INFO - Created VN ctest-bgpaas_vn-99718763 2025-10-30 03:00:53,476 - DEBUG - VN ctest-bgpaas_vn-99718763 UUID is 2b8464f8-1211-4f72-b513-9d690d6a0e84 2025-10-30 03:00:53,999 - DEBUG - Response for create_network : {'network': {'id': '6e49c418-9e79-4a2b-93b2-8cfef4a15a0d', 'name': 'ctest-bgpaas_vn-93902056', 'tenant_id': '2b4985c7e4204c17991ab1601e663a3d', 'project_id': '2b4985c7e4204c17991ab1601e663a3d', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-76717234', 'ctest-bgpaas_vn-93902056'], 'port_security_enabled': True, 'description': ''}} 2025-10-30 03:00:54,250 - DEBUG - Response for create_subnet : {'subnet': {'id': '12589ebc-534b-4c8b-926b-dd47fec4fa90', 'name': '', 'tenant_id': '2b4985c7e4204c17991ab1601e663a3d', 'network_id': '6e49c418-9e79-4a2b-93b2-8cfef4a15a0d', 'ip_version': 4, 'cidr': '97.155.108.192/26', 'allocation_pools': [{'start': '97.155.108.194', 'end': '97.155.108.254'}], 'gateway_ip': '97.155.108.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '97.155.108.194', 'tags': [], 'project_id': '2b4985c7e4204c17991ab1601e663a3d'}} 2025-10-30 03:00:54,275 - INFO - Created VN ctest-bgpaas_vn-93902056 2025-10-30 03:00:54,292 - DEBUG - VN ctest-bgpaas_vn-93902056 UUID is 6e49c418-9e79-4a2b-93b2-8cfef4a15a0d 2025-10-30 03:00:55,752 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4535-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4535-2) 2025-10-30 03:00:57,115 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4535-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4535-1) 2025-10-30 03:00:57,116 - INFO - Waiting for VM test_vm to be up.. 2025-10-30 03:00:57,213 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-10-30 03:01:02,310 - DEBUG - VM is in ACTIVE state now 2025-10-30 03:01:02,311 - INFO - VM name : test_vm 2025-10-30 03:01:02,399 - DEBUG - VM test_vm ID is b203a6bf-91e2-441c-a6b2-e283d4f92147 2025-10-30 03:01:02,426 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-4535-2 2025-10-30 03:01:02,525 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine/b203a6bf-91e2-441c-a6b2-e283d4f92147 2025-10-30 03:01:02,824 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine/b203a6bf-91e2-441c-a6b2-e283d4f92147 2025-10-30 03:01:02,860 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine-interface/a49d78c2-d76a-46db-a3fd-5762aad3cbdf 2025-10-30 03:01:06,056 - 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-10-30 03:01:06,056 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2025-10-30 03:01:06,073 - DEBUG - Gateway for vn default-domain:ctest-TestRP-76717234:ctest-bgpaas_vn-99718763 is 221.151.139.65 and allocation pool is NOT set 2025-10-30 03:01:08,133 - 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.07 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.81 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 = 1.806/3.440/5.074/1.634 ms') 2025-10-30 03:01:08,133 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2025-10-30 03:01:08,207 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-30 03:01:08,207 - DEBUG - Waiting to SSH to VM test_vm, IP 221.151.139.67, Port 22 2025-10-30 03:01:08,280 - 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-10-30 03:01:08,366 - DEBUG - VM test_vm is NOT ready for SSH connections, VM status: ACTIVE 2025-10-30 03:01:13,367 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-30 03:01:13,367 - DEBUG - Waiting to SSH to VM test_vm, IP 221.151.139.67, Port 22 2025-10-30 03:01:13,525 - DEBUG - VM test_vm is ready for SSH connections 2025-10-30 03:01:13,526 - INFO - Waiting for VM test2_vm to be up.. 2025-10-30 03:01:13,616 - DEBUG - VM is in ACTIVE state now 2025-10-30 03:01:13,616 - INFO - VM name : test2_vm 2025-10-30 03:01:13,701 - DEBUG - VM test2_vm ID is e313f8a4-2066-422b-99a9-f038338b9cfb 2025-10-30 03:01:13,701 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-4535-1 2025-10-30 03:01:13,787 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine/e313f8a4-2066-422b-99a9-f038338b9cfb 2025-10-30 03:01:13,799 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine-interface/2f40611e-0027-426c-9866-b41e09ed3318 2025-10-30 03:01:14,961 - 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.09 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.345 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.345/1.717/3.089/1.372 ms') 2025-10-30 03:01:14,961 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2025-10-30 03:01:15,030 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-30 03:01:15,030 - DEBUG - Waiting to SSH to VM test2_vm, IP 97.155.108.195, Port 22 2025-10-30 03:01:15,192 - DEBUG - VM test2_vm is ready for SSH connections 2025-10-30 03:01:15,352 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-30 03:01:15,366 - DEBUG - Requesting: http://10.20.0.254:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-76717234:ctest-bgpaas_vn-99718763:ctest-bgpaas_vn-99718763.inet.0 2025-10-30 03:01:15,382 - DEBUG - Requesting: http://10.20.0.131:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-76717234:ctest-bgpaas_vn-99718763:ctest-bgpaas_vn-99718763.inet.0 2025-10-30 03:01:15,393 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-30 03:01:15,393 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 97.155.108.195, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.65, gateway password: c0ntrail123 2025-10-30 03:01:15,393 - DEBUG - ping -s 56 -c 3 -W 1 97.155.108.195 2025-10-30 03:01:19,388 - DEBUG - PING 97.155.108.195 (97.155.108.195): 56 data bytes 64 bytes from 97.155.108.195: seq=0 ttl=63 time=6.619 ms 64 bytes from 97.155.108.195: seq=1 ttl=63 time=1.380 ms 64 bytes from 97.155.108.195: seq=2 ttl=63 time=1.423 ms --- 97.155.108.195 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.380/3.140/6.619 ms 2025-10-30 03:01:19,388 - INFO - Ping to IP 97.155.108.195 from VM test_vm passed 2025-10-30 03:01:19,516 - INFO - Deleting VM test2_vm 2025-10-30 03:01:19,605 - INFO - Deleting VM test_vm 2025-10-30 03:01:19,689 - INFO - Deleting VN ctest-bgpaas_vn-93902056 2025-10-30 03:01:19,743 - DEBUG - VN 6e49c418-9e79-4a2b-93b2-8cfef4a15a0d still in use: Unable to complete operation on network 6e49c418-9e79-4a2b-93b2-8cfef4a15a0d. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-6180de13-68c1-4278-a0d4-401149cf0b18'] 2025-10-30 03:01:19,743 - WARNING - Deleting VN ctest-bgpaas_vn-93902056 failed..Will retry 2025-10-30 03:01:21,945 - DEBUG - Response for deleting network () 2025-10-30 03:01:21,946 - INFO - Deleting VN ctest-bgpaas_vn-99718763 2025-10-30 03:01:22,113 - DEBUG - Response for deleting network () 2025-10-30 03:01:23,393 - DEBUG - No XMPP flaps were noticed during the test
2025-10-30 03:01:23,393 - INFO - END TEST : test_rp_interface : PASSED[0:00:32]
2025-10-30 03:01:23,393 - INFO - -------------------------------------------------------------------------------- 2025-10-30 03:01:23,398 - INFO - ================================================================================ 2025-10-30 03:01:23,398 - INFO - STARTING TEST : test_rp_interface_ext_community 2025-10-30 03:01:23,398 - 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-10-30 03:01:24,717 - DEBUG - Nothing to compare xmpp stats {'10.0.0.129': {'10.20.0.131': '0', '10.20.0.254': '0'}, '10.0.0.65': {'10.20.0.254': '0', '10.20.0.131': '0'}} with 2025-10-30 03:01:24,717 - INFO - Initial checks done. Running the testcase now 2025-10-30 03:01:24,717 - INFO - 2025-10-30 03:01:25,075 - DEBUG - Response for create_network : {'network': {'id': '48db9938-e2d2-4040-ad22-fe8e6a72e55c', 'name': 'ctest-bgpaas_vn-01776708', 'tenant_id': '2b4985c7e4204c17991ab1601e663a3d', 'project_id': '2b4985c7e4204c17991ab1601e663a3d', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-76717234', 'ctest-bgpaas_vn-01776708'], 'port_security_enabled': True, 'description': ''}} 2025-10-30 03:01:25,317 - DEBUG - Response for create_subnet : {'subnet': {'id': '7ba63364-a3df-4957-b528-ac2de07059b7', 'name': '', 'tenant_id': '2b4985c7e4204c17991ab1601e663a3d', 'network_id': '48db9938-e2d2-4040-ad22-fe8e6a72e55c', 'ip_version': 4, 'cidr': '55.237.70.192/26', 'allocation_pools': [{'start': '55.237.70.194', 'end': '55.237.70.254'}], 'gateway_ip': '55.237.70.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '55.237.70.194', 'tags': [], 'project_id': '2b4985c7e4204c17991ab1601e663a3d'}} 2025-10-30 03:01:25,347 - INFO - Created VN ctest-bgpaas_vn-01776708 2025-10-30 03:01:25,362 - DEBUG - VN ctest-bgpaas_vn-01776708 UUID is 48db9938-e2d2-4040-ad22-fe8e6a72e55c 2025-10-30 03:01:25,968 - DEBUG - Response for create_network : {'network': {'id': 'ca72e8bc-b53f-468c-b0b5-9da8864b042a', 'name': 'ctest-bgpaas_vn-64365615', 'tenant_id': '2b4985c7e4204c17991ab1601e663a3d', 'project_id': '2b4985c7e4204c17991ab1601e663a3d', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-76717234', 'ctest-bgpaas_vn-64365615'], 'port_security_enabled': True, 'description': ''}} 2025-10-30 03:01:26,217 - DEBUG - Response for create_subnet : {'subnet': {'id': '7a5f6039-7904-42dc-bdf7-764fdafc890b', 'name': '', 'tenant_id': '2b4985c7e4204c17991ab1601e663a3d', 'network_id': 'ca72e8bc-b53f-468c-b0b5-9da8864b042a', 'ip_version': 4, 'cidr': '148.237.0.128/26', 'allocation_pools': [{'start': '148.237.0.130', 'end': '148.237.0.190'}], 'gateway_ip': '148.237.0.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '148.237.0.130', 'tags': [], 'project_id': '2b4985c7e4204c17991ab1601e663a3d'}} 2025-10-30 03:01:26,240 - INFO - Created VN ctest-bgpaas_vn-64365615 2025-10-30 03:01:26,255 - DEBUG - VN ctest-bgpaas_vn-64365615 UUID is ca72e8bc-b53f-468c-b0b5-9da8864b042a 2025-10-30 03:01:27,656 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4535-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4535-2) 2025-10-30 03:01:28,953 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4535-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4535-1) 2025-10-30 03:01:28,953 - INFO - Waiting for VM test_vm to be up.. 2025-10-30 03:01:29,059 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-10-30 03:01:34,154 - DEBUG - VM is in ACTIVE state now 2025-10-30 03:01:34,154 - INFO - VM name : test_vm 2025-10-30 03:01:34,242 - DEBUG - VM test_vm ID is 8050637f-e42a-4ecd-91dd-2110cf4855bd 2025-10-30 03:01:34,242 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-4535-2 2025-10-30 03:01:34,337 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine/8050637f-e42a-4ecd-91dd-2110cf4855bd 2025-10-30 03:01:34,348 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine-interface/10fc262d-f706-4835-bb20-3dcd7f0c233a 2025-10-30 03:01:37,543 - 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-10-30 03:01:37,543 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2025-10-30 03:01:37,559 - DEBUG - Gateway for vn default-domain:ctest-TestRP-76717234:ctest-bgpaas_vn-01776708 is 55.237.70.193 and allocation pool is NOT set 2025-10-30 03:01:39,621 - 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.55 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.451 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.451/2.501/4.551/2.050 ms') 2025-10-30 03:01:39,621 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2025-10-30 03:01:39,689 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-30 03:01:39,689 - DEBUG - Waiting to SSH to VM test_vm, IP 55.237.70.195, Port 22 2025-10-30 03:01:39,845 - DEBUG - VM test_vm is ready for SSH connections 2025-10-30 03:01:39,845 - INFO - Waiting for VM test2_vm to be up.. 2025-10-30 03:01:39,930 - DEBUG - VM is in ACTIVE state now 2025-10-30 03:01:39,930 - INFO - VM name : test2_vm 2025-10-30 03:01:40,019 - DEBUG - VM test2_vm ID is 7858362c-3c2f-4f29-aeac-3a98845b1220 2025-10-30 03:01:40,019 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-4535-1 2025-10-30 03:01:40,115 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine/7858362c-3c2f-4f29-aeac-3a98845b1220 2025-10-30 03:01:40,128 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine-interface/aecdb57b-3894-4373-9d19-26ff7c19c4b9 2025-10-30 03:01:41,305 - 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.41 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=1.57 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 = 1.574/2.993/4.413/1.419 ms') 2025-10-30 03:01:41,305 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2025-10-30 03:01:41,382 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-30 03:01:41,382 - DEBUG - Waiting to SSH to VM test2_vm, IP 148.237.0.131, Port 22 2025-10-30 03:01:41,550 - DEBUG - VM test2_vm is ready for SSH connections 2025-10-30 03:01:41,704 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-30 03:01:41,718 - DEBUG - Requesting: http://10.20.0.254:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-76717234:ctest-bgpaas_vn-01776708:ctest-bgpaas_vn-01776708.inet.0 2025-10-30 03:01:41,736 - DEBUG - Requesting: http://10.20.0.131:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-76717234:ctest-bgpaas_vn-01776708:ctest-bgpaas_vn-01776708.inet.0 2025-10-30 03:01:41,748 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-30 03:01:41,749 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 148.237.0.131, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.65, gateway password: c0ntrail123 2025-10-30 03:01:41,749 - DEBUG - ping -s 56 -c 3 -W 1 148.237.0.131 2025-10-30 03:01:45,422 - DEBUG - PING 148.237.0.131 (148.237.0.131): 56 data bytes 64 bytes from 148.237.0.131: seq=0 ttl=63 time=6.911 ms 64 bytes from 148.237.0.131: seq=1 ttl=63 time=1.224 ms 64 bytes from 148.237.0.131: seq=2 ttl=63 time=1.305 ms --- 148.237.0.131 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.224/3.146/6.911 ms 2025-10-30 03:01:45,422 - INFO - Ping to IP 148.237.0.131 from VM test_vm passed 2025-10-30 03:01:45,597 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-30 03:01:45,613 - DEBUG - Requesting: http://10.20.0.254:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-76717234:ctest-bgpaas_vn-01776708:ctest-bgpaas_vn-01776708.inet.0 2025-10-30 03:01:45,632 - DEBUG - Requesting: http://10.20.0.131:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-76717234:ctest-bgpaas_vn-01776708:ctest-bgpaas_vn-01776708.inet.0 2025-10-30 03:01:45,915 - INFO - Deleting VM test2_vm 2025-10-30 03:01:45,997 - INFO - Deleting VM test_vm 2025-10-30 03:01:46,064 - INFO - Deleting VN ctest-bgpaas_vn-64365615 2025-10-30 03:01:46,115 - DEBUG - VN ca72e8bc-b53f-468c-b0b5-9da8864b042a still in use: Unable to complete operation on network ca72e8bc-b53f-468c-b0b5-9da8864b042a. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-01cd6697-6cfb-4838-bddd-f21d4922c0de'] 2025-10-30 03:01:46,115 - WARNING - Deleting VN ctest-bgpaas_vn-64365615 failed..Will retry 2025-10-30 03:01:48,267 - DEBUG - Response for deleting network () 2025-10-30 03:01:48,267 - INFO - Deleting VN ctest-bgpaas_vn-01776708 2025-10-30 03:01:48,466 - DEBUG - Response for deleting network () 2025-10-30 03:01:49,757 - DEBUG - No XMPP flaps were noticed during the test
2025-10-30 03:01:49,757 - INFO - END TEST : test_rp_interface_ext_community : PASSED[0:00:26]
2025-10-30 03:01:49,757 - INFO - -------------------------------------------------------------------------------- 2025-10-30 03:01:49,760 - INFO - ================================================================================ 2025-10-30 03:01:49,760 - INFO - STARTING TEST : test_rp_interface_static 2025-10-30 03:01:49,760 - 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-10-30 03:01:51,040 - DEBUG - Nothing to compare xmpp stats {'10.0.0.129': {'10.20.0.131': '0', '10.20.0.254': '0'}, '10.0.0.65': {'10.20.0.254': '0', '10.20.0.131': '0'}} with 2025-10-30 03:01:51,040 - INFO - Initial checks done. Running the testcase now 2025-10-30 03:01:51,040 - INFO - 2025-10-30 03:01:51,356 - DEBUG - Response for create_network : {'network': {'id': 'ad1aa6d5-f89b-4823-bc9e-197b7e99e0a8', 'name': 'ctest-bgpaas_vn-15654931', 'tenant_id': '2b4985c7e4204c17991ab1601e663a3d', 'project_id': '2b4985c7e4204c17991ab1601e663a3d', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-76717234', 'ctest-bgpaas_vn-15654931'], 'port_security_enabled': True, 'description': ''}} 2025-10-30 03:01:51,588 - DEBUG - Response for create_subnet : {'subnet': {'id': 'ce0bebc2-3301-44df-9682-bec2c29eb0fc', 'name': '', 'tenant_id': '2b4985c7e4204c17991ab1601e663a3d', 'network_id': 'ad1aa6d5-f89b-4823-bc9e-197b7e99e0a8', 'ip_version': 4, 'cidr': '142.48.106.0/26', 'allocation_pools': [{'start': '142.48.106.2', 'end': '142.48.106.62'}], 'gateway_ip': '142.48.106.1', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '142.48.106.2', 'tags': [], 'project_id': '2b4985c7e4204c17991ab1601e663a3d'}} 2025-10-30 03:01:51,611 - INFO - Created VN ctest-bgpaas_vn-15654931 2025-10-30 03:01:51,629 - DEBUG - VN ctest-bgpaas_vn-15654931 UUID is ad1aa6d5-f89b-4823-bc9e-197b7e99e0a8 2025-10-30 03:01:52,207 - DEBUG - Response for create_network : {'network': {'id': '7278a148-c674-4709-858f-539a043c449b', 'name': 'ctest-bgpaas_vn-69938994', 'tenant_id': '2b4985c7e4204c17991ab1601e663a3d', 'project_id': '2b4985c7e4204c17991ab1601e663a3d', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-TestRP-76717234', 'ctest-bgpaas_vn-69938994'], 'port_security_enabled': True, 'description': ''}} 2025-10-30 03:01:52,406 - DEBUG - Response for create_subnet : {'subnet': {'id': '9cb27475-25b4-4b1e-9a91-cc8a2fd401f1', 'name': '', 'tenant_id': '2b4985c7e4204c17991ab1601e663a3d', 'network_id': '7278a148-c674-4709-858f-539a043c449b', 'ip_version': 4, 'cidr': '9.171.154.192/26', 'allocation_pools': [{'start': '9.171.154.194', 'end': '9.171.154.254'}], 'gateway_ip': '9.171.154.193', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '9.171.154.194', 'tags': [], 'project_id': '2b4985c7e4204c17991ab1601e663a3d'}} 2025-10-30 03:01:52,437 - INFO - Created VN ctest-bgpaas_vn-69938994 2025-10-30 03:01:52,450 - DEBUG - VN ctest-bgpaas_vn-69938994 UUID is 7278a148-c674-4709-858f-539a043c449b 2025-10-30 03:01:53,845 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4535-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4535-2) 2025-10-30 03:01:55,202 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-4535-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-4535-1) 2025-10-30 03:01:55,202 - INFO - Waiting for VM test_vm to be up.. 2025-10-30 03:01:55,311 - DEBUG - VM is still in BUILD state, Expected: ACTIVE 2025-10-30 03:02:00,407 - DEBUG - VM is in ACTIVE state now 2025-10-30 03:02:00,407 - INFO - VM name : test_vm 2025-10-30 03:02:00,513 - DEBUG - VM test_vm ID is 06e1f215-060c-47bf-88b0-5e3d28f93e1e 2025-10-30 03:02:00,513 - DEBUG - VM test_vm launched on Node an-jenkins-deploy-platform-ansible-os-4535-2 2025-10-30 03:02:00,612 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine/06e1f215-060c-47bf-88b0-5e3d28f93e1e 2025-10-30 03:02:00,626 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine-interface/7849ec2b-4978-4ff8-a154-badf3868ca96 2025-10-30 03:02:03,819 - 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 1026ms') 2025-10-30 03:02:03,819 - DEBUG - Ping to Metadata IP 169.254.0.3 of VM test_vm failed! 2025-10-30 03:02:03,836 - DEBUG - Gateway for vn default-domain:ctest-TestRP-76717234:ctest-bgpaas_vn-15654931 is 142.48.106.1 and allocation pool is NOT set 2025-10-30 03:02:05,900 - 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.94 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=0.492 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.492/1.716/2.940/1.224 ms') 2025-10-30 03:02:05,900 - INFO - Ping to Metadata IP 169.254.0.3 of VM test_vm passed 2025-10-30 03:02:05,977 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-30 03:02:05,977 - DEBUG - Waiting to SSH to VM test_vm, IP 142.48.106.3, Port 22 2025-10-30 03:02:06,148 - DEBUG - VM test_vm is ready for SSH connections 2025-10-30 03:02:06,148 - INFO - Waiting for VM test2_vm to be up.. 2025-10-30 03:02:06,244 - DEBUG - VM is in ACTIVE state now 2025-10-30 03:02:06,244 - INFO - VM name : test2_vm 2025-10-30 03:02:06,341 - DEBUG - VM test2_vm ID is 2d2ad789-bf42-487f-ad86-2c956e499775 2025-10-30 03:02:06,341 - DEBUG - VM test2_vm launched on Node an-jenkins-deploy-platform-ansible-os-4535-1 2025-10-30 03:02:06,433 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine/2d2ad789-bf42-487f-ad86-2c956e499775 2025-10-30 03:02:06,445 - DEBUG - Requesting: http://10.0.0.240:8082/virtual-machine-interface/5a938cae-25c3-4185-8b3d-1799423ef72e 2025-10-30 03:02:07,633 - 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.42 ms\r\n64 bytes from 169.254.0.3: icmp_seq=2 ttl=63 time=2.34 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.337/4.376/6.416/2.039 ms') 2025-10-30 03:02:07,633 - INFO - Ping to Metadata IP 169.254.0.3 of VM test2_vm passed 2025-10-30 03:02:07,704 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-30 03:02:07,705 - DEBUG - Waiting to SSH to VM test2_vm, IP 9.171.154.195, Port 22 2025-10-30 03:02:07,759 - 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-10-30 03:02:07,839 - DEBUG - VM test2_vm is NOT ready for SSH connections, VM status: ACTIVE 2025-10-30 03:02:12,840 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-30 03:02:12,841 - DEBUG - Waiting to SSH to VM test2_vm, IP 9.171.154.195, Port 22 2025-10-30 03:02:13,000 - DEBUG - VM test2_vm is ready for SSH connections 2025-10-30 03:02:13,097 - INFO - Created InterfaceRouteTable ['default-domain', 'ctest-TestRP-76717234', 'ctest-int_table_right-03476782'](UUID 87e378d2-bc8b-46ba-9429-df187e486a51), prefixes : ['78.50.54.0/26'] 2025-10-30 03:02:13,176 - INFO - Added intf route table 87e378d2-bc8b-46ba-9429-df187e486a51 to port 7849ec2b-4978-4ff8-a154-badf3868ca96 2025-10-30 03:02:13,410 - DEBUG - Requesting: http://10.20.0.254:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-76717234:ctest-bgpaas_vn-15654931:ctest-bgpaas_vn-15654931.inet.0 2025-10-30 03:02:13,427 - DEBUG - Requesting: http://10.20.0.131:8083/Snh_ShowRouteReq?x=default-domain:ctest-TestRP-76717234:ctest-bgpaas_vn-15654931:ctest-bgpaas_vn-15654931.inet.0 2025-10-30 03:02:13,441 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2025-10-30 03:02:13,441 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 9.171.154.195, host_string: cirros@169.254.0.3, password: cubswin:)gateway: ubuntu@10.0.0.65, gateway password: c0ntrail123 2025-10-30 03:02:13,441 - DEBUG - ping -s 56 -c 3 -W 1 9.171.154.195 2025-10-30 03:02:17,092 - DEBUG - PING 9.171.154.195 (9.171.154.195): 56 data bytes 64 bytes from 9.171.154.195: seq=0 ttl=63 time=5.442 ms 64 bytes from 9.171.154.195: seq=1 ttl=63 time=1.312 ms 64 bytes from 9.171.154.195: seq=2 ttl=63 time=1.279 ms --- 9.171.154.195 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.279/2.677/5.442 ms 2025-10-30 03:02:17,093 - INFO - Ping to IP 9.171.154.195 from VM test_vm passed 2025-10-30 03:02:17,216 - INFO - Deleting VM test2_vm 2025-10-30 03:02:17,360 - INFO - Deleting VM test_vm 2025-10-30 03:02:17,476 - INFO - Deleting VN ctest-bgpaas_vn-69938994 2025-10-30 03:02:17,520 - DEBUG - VN 7278a148-c674-4709-858f-539a043c449b still in use: Unable to complete operation on network 7278a148-c674-4709-858f-539a043c449b. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-530049a9-453b-4261-88f7-84c999eaf905'] 2025-10-30 03:02:17,520 - WARNING - Deleting VN ctest-bgpaas_vn-69938994 failed..Will retry 2025-10-30 03:02:19,700 - DEBUG - Response for deleting network () 2025-10-30 03:02:19,700 - INFO - Deleting VN ctest-bgpaas_vn-15654931 2025-10-30 03:02:19,863 - DEBUG - Response for deleting network () 2025-10-30 03:02:21,151 - DEBUG - No XMPP flaps were noticed during the test
2025-10-30 03:02:21,151 - INFO - END TEST : test_rp_interface_static : PASSED[0:00:32]
2025-10-30 03:02:21,151 - INFO - -------------------------------------------------------------------------------- 2025-10-30 03:02:21,894 - INFO - Deleted project: ctest-TestRP-76717234, ID : 2b4985c7-e420-4c17-991a-b1601e663a3d