2026-05-04 04:10:02,281 - INFO - Domain Default found not creating 2026-05-04 04:10:02,487 - INFO - Project ctest-AnalyticsTestSanityWithResource-70378297 not found, creating it 2026-05-04 04:10:03,177 - INFO - Created Project:ctest-AnalyticsTestSanityWithResource-70378297, ID : 711b033b-e2c7-4e7b-a7f3-f1944ade6940 2026-05-04 04:10:05,745 - DEBUG - Response for create_network : {'network': {'id': 'df2f8407-3df7-4f40-a8d3-bf4c63fbebf4', 'name': 'ctest-vn1-00505497', 'tenant_id': '711b033be2c74e7ba7f3f1944ade6940', 'project_id': '711b033be2c74e7ba7f3f1944ade6940', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-70378297', 'ctest-vn1-00505497'], 'port_security_enabled': True, 'description': ''}} 2026-05-04 04:10:06,064 - DEBUG - Response for create_subnet : {'subnet': {'id': 'a8d68edb-864b-49b4-98a5-908ae2686e9c', 'name': '', 'tenant_id': '711b033be2c74e7ba7f3f1944ade6940', 'network_id': 'df2f8407-3df7-4f40-a8d3-bf4c63fbebf4', 'ip_version': 4, 'cidr': '2.76.249.64/26', 'allocation_pools': [{'start': '2.76.249.66', 'end': '2.76.249.126'}], 'gateway_ip': '2.76.249.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '2.76.249.66', 'tags': [], 'project_id': '711b033be2c74e7ba7f3f1944ade6940'}} 2026-05-04 04:10:06,090 - INFO - Created VN ctest-vn1-00505497 2026-05-04 04:10:06,102 - DEBUG - VN ctest-vn1-00505497 UUID is df2f8407-3df7-4f40-a8d3-bf4c63fbebf4 2026-05-04 04:10:06,212 - DEBUG - Services list from nova: [, , , ] 2026-05-04 04:10:06,212 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-5740-1', 'an-jenkins-deploy-platform-ansible-os-5740-2']} 2026-05-04 04:10:07,589 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5740-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5740-1) 2026-05-04 04:10:09,222 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5740-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5740-1) 2026-05-04 04:10:09,223 - DEBUG - Requesting: http://10.0.0.129:8082/domains 2026-05-04 04:10:09,535 - DEBUG - Requesting: http://10.0.0.129:8082/domains 2026-05-04 04:10:09,569 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c 2026-05-04 04:10:09,588 - DEBUG - Requesting: http://10.0.0.129:8082/project/711b033b-e2c7-4e7b-a7f3-f1944ade6940 2026-05-04 04:10:09,726 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/df2f8407-3df7-4f40-a8d3-bf4c63fbebf4 2026-05-04 04:10:09,760 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/df2f8407-3df7-4f40-a8d3-bf4c63fbebf4 2026-05-04 04:10:09,777 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/b2707d3d-9877-4c16-b1c8-031de92f1a6e 2026-05-04 04:10:09,788 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/b2707d3d-9877-4c16-b1c8-031de92f1a6e 2026-05-04 04:10:09,798 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/31c4be65-ebe8-4c67-b43f-65323a6eb1f0 2026-05-04 04:10:09,807 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-04 04:10:09,807 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/df2f8407-3df7-4f40-a8d3-bf4c63fbebf4 2026-05-04 04:10:09,828 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/b2707d3d-9877-4c16-b1c8-031de92f1a6e 2026-05-04 04:10:09,858 - INFO - Verified VN network id 14 for VN df2f8407-3df7-4f40-a8d3-bf4c63fbebf4 2026-05-04 04:10:09,858 - INFO - Verifications in API Server for VN ctest-vn1-00505497 passed 2026-05-04 04:10:09,858 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/df2f8407-3df7-4f40-a8d3-bf4c63fbebf4 2026-05-04 04:10:09,872 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/b2707d3d-9877-4c16-b1c8-031de92f1a6e 2026-05-04 04:10:09,892 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/b2707d3d-9877-4c16-b1c8-031de92f1a6e 2026-05-04 04:10:09,904 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/31c4be65-ebe8-4c67-b43f-65323a6eb1f0 2026-05-04 04:10:09,917 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497', 'interests': '1', 'advertised': '1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-70378297', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16082217961002585920', 'uuid-lslong': '12165277353273715700'}, 'enable': 'true', 'created': '2026-05-04T04:10:05', 'last-modified': '2026-05-04T04:10:05', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.905143'} 2026-05-04 04:10:09,928 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-04 04:10:09,934 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-70378297', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16082217961002585920', 'uuid-lslong': '12165277353273715700'}, 'enable': 'true', 'created': '2026-05-04T04:10:05', 'last-modified': '2026-05-04T04:10:05', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.922231'} 2026-05-04 04:10:09,948 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-04 04:10:09,964 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-70378297', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16082217961002585920', 'uuid-lslong': '12165277353273715700'}, 'enable': 'true', 'created': '2026-05-04T04:10:05', 'last-modified': '2026-05-04T04:10:05', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:03.952771'} 2026-05-04 04:10:09,976 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-04 04:10:09,976 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-00505497 passed 2026-05-04 04:10:09,976 - DEBUG - ====Verifying policy data for ctest-vn1-00505497 in API_Server ====== 2026-05-04 04:10:09,976 - DEBUG - Requesting: http://10.0.0.129:8082/domains 2026-05-04 04:10:09,983 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c 2026-05-04 04:10:09,994 - DEBUG - Requesting: http://10.0.0.129:8082/project/711b033b-e2c7-4e7b-a7f3-f1944ade6940 2026-05-04 04:10:10,093 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/df2f8407-3df7-4f40-a8d3-bf4c63fbebf4 2026-05-04 04:10:10,119 - DEBUG - =>VN ctest-vn1-00505497 has no policy to be verified 2026-05-04 04:10:10,119 - DEBUG - Verifying the vn in opserver 2026-05-04 04:10:10,119 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497 virtual network link through opserver 10.0.0.129 2026-05-04 04:10:10,119 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks 2026-05-04 04:10:10,481 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks 2026-05-04 04:10:10,642 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497?flat'} 2026-05-04 04:10:10,642 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497 virtual network link through opserver 10.0.0.50 2026-05-04 04:10:10,642 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-05-04 04:10:10,999 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-05-04 04:10:11,075 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497?flat'} 2026-05-04 04:10:11,075 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497 virtual network link through opserver 10.0.0.249 2026-05-04 04:10:11,076 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2026-05-04 04:10:11,389 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2026-05-04 04:10:11,479 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497?flat'} 2026-05-04 04:10:11,479 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497 is found in opserver 2026-05-04 04:10:11,499 - DEBUG - VRF ids for VN ctest-vn1-00505497: {'10.0.0.41': '4'} 2026-05-04 04:10:11,499 - INFO - Waiting for VM ctest-vn1_vm1-31497109 to be up.. 2026-05-04 04:10:11,629 - DEBUG - VM is in ACTIVE state now 2026-05-04 04:10:11,630 - INFO - VM name : ctest-vn1_vm1-31497109 2026-05-04 04:10:11,728 - DEBUG - VM ctest-vn1_vm1-31497109 ID is 6753d411-d266-496a-92d5-12e6b6699667 2026-05-04 04:10:11,760 - DEBUG - VM ctest-vn1_vm1-31497109 launched on Node an-jenkins-deploy-platform-ansible-os-5740-1 2026-05-04 04:10:11,863 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/6753d411-d266-496a-92d5-12e6b6699667 2026-05-04 04:10:12,191 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/6753d411-d266-496a-92d5-12e6b6699667 2026-05-04 04:10:12,233 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/9ed03708-cdc6-49dd-80f6-094603009472 2026-05-04 04:10:15,438 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1016ms') 2026-05-04 04:10:15,439 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vn1_vm1-31497109 failed! 2026-05-04 04:10:15,456 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497 is 2.76.249.65 and allocation pool is NOT set 2026-05-04 04:10:19,535 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1014ms') 2026-05-04 04:10:19,536 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vn1_vm1-31497109 failed! 2026-05-04 04:10:19,555 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497 is 2.76.249.65 and allocation pool is NOT set 2026-05-04 04:10:23,630 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1010ms') 2026-05-04 04:10:23,630 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vn1_vm1-31497109 failed! 2026-05-04 04:10:23,648 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497 is 2.76.249.65 and allocation pool is NOT set 2026-05-04 04:10:27,722 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1013ms') 2026-05-04 04:10:27,722 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vn1_vm1-31497109 failed! 2026-05-04 04:10:27,740 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497 is 2.76.249.65 and allocation pool is NOT set 2026-05-04 04:10:31,825 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1023ms') 2026-05-04 04:10:31,825 - DEBUG - Ping to Metadata IP 169.254.0.5 of VM ctest-vn1_vm1-31497109 failed! 2026-05-04 04:10:31,843 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497 is 2.76.249.65 and allocation pool is NOT set 2026-05-04 04:10:33,914 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n64 bytes from 169.254.0.5: icmp_seq=1 ttl=63 time=4.97 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=1.99 ms\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1000ms\r\nrtt min/avg/max/mdev = 1.987/3.476/4.965/1.489 ms') 2026-05-04 04:10:33,914 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-vn1_vm1-31497109 passed 2026-05-04 04:10:33,998 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-04 04:10:33,998 - DEBUG - Waiting to SSH to VM ctest-vn1_vm1-31497109, IP 2.76.249.67, Port 22 2026-05-04 04:10:34,056 - DEBUG - Error on ssh to cirros@169.254.0.5:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.5/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.5/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.5/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-05-04 04:10:34,178 - DEBUG - VM ctest-vn1_vm1-31497109 is NOT ready for SSH connections, VM status: ACTIVE 2026-05-04 04:10:39,179 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-04 04:10:39,179 - DEBUG - Waiting to SSH to VM ctest-vn1_vm1-31497109, IP 2.76.249.67, Port 22 2026-05-04 04:10:39,358 - DEBUG - VM ctest-vn1_vm1-31497109 is ready for SSH connections 2026-05-04 04:10:39,358 - INFO - Waiting for VM ctest-vn1_vm2-92516347 to be up.. 2026-05-04 04:10:39,449 - DEBUG - VM is in ACTIVE state now 2026-05-04 04:10:39,449 - INFO - VM name : ctest-vn1_vm2-92516347 2026-05-04 04:10:39,534 - DEBUG - VM ctest-vn1_vm2-92516347 ID is feadb3fc-4e33-4ab2-8fe6-beb9da5e6ee7 2026-05-04 04:10:39,534 - DEBUG - VM ctest-vn1_vm2-92516347 launched on Node an-jenkins-deploy-platform-ansible-os-5740-1 2026-05-04 04:10:39,628 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/feadb3fc-4e33-4ab2-8fe6-beb9da5e6ee7 2026-05-04 04:10:39,642 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/49117e98-e9c4-4a22-8bb9-daa8b1443cee 2026-05-04 04:10:40,850 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n64 bytes from 169.254.0.6: icmp_seq=1 ttl=63 time=3.10 ms\r\n64 bytes from 169.254.0.6: icmp_seq=2 ttl=63 time=3.55 ms\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1000ms\r\nrtt min/avg/max/mdev = 3.099/3.322/3.545/0.223 ms') 2026-05-04 04:10:40,850 - INFO - Ping to Metadata IP 169.254.0.6 of VM ctest-vn1_vm2-92516347 passed 2026-05-04 04:10:40,925 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-04 04:10:40,925 - DEBUG - Waiting to SSH to VM ctest-vn1_vm2-92516347, IP 2.76.249.68, Port 22 2026-05-04 04:10:40,993 - DEBUG - Error on ssh to cirros@169.254.0.6:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.6/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.6/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.6/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-05-04 04:10:41,107 - DEBUG - VM ctest-vn1_vm2-92516347 is NOT ready for SSH connections, VM status: ACTIVE 2026-05-04 04:10:46,108 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-04 04:10:46,108 - DEBUG - Waiting to SSH to VM ctest-vn1_vm2-92516347, IP 2.76.249.68, Port 22 2026-05-04 04:10:46,281 - DEBUG - VM ctest-vn1_vm2-92516347 is ready for SSH connections 2026-05-04 04:10:46,649 - DEBUG - Response for create_network : {'network': {'id': '633d6c79-d3d0-4843-9929-3e9a779660a6', 'name': 'ctest-vn2-47014571', 'tenant_id': '711b033be2c74e7ba7f3f1944ade6940', 'project_id': '711b033be2c74e7ba7f3f1944ade6940', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-70378297', 'ctest-vn2-47014571'], 'port_security_enabled': True, 'description': ''}} 2026-05-04 04:10:47,003 - DEBUG - Response for create_subnet : {'subnet': {'id': '82056189-9da3-4af1-9206-4c81f462f2d3', 'name': '', 'tenant_id': '711b033be2c74e7ba7f3f1944ade6940', 'network_id': '633d6c79-d3d0-4843-9929-3e9a779660a6', 'ip_version': 4, 'cidr': '133.227.48.64/26', 'allocation_pools': [{'start': '133.227.48.66', 'end': '133.227.48.126'}], 'gateway_ip': '133.227.48.65', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '133.227.48.66', 'tags': [], 'project_id': '711b033be2c74e7ba7f3f1944ade6940'}} 2026-05-04 04:10:47,033 - INFO - Created VN ctest-vn2-47014571 2026-05-04 04:10:47,051 - DEBUG - VN ctest-vn2-47014571 UUID is 633d6c79-d3d0-4843-9929-3e9a779660a6 2026-05-04 04:10:47,490 - DEBUG - Response for create_network : {'network': {'id': '34ce0969-d631-4e60-a504-3e07ed41cc2d', 'name': 'ctest-fip_vn-53977699', 'tenant_id': '711b033be2c74e7ba7f3f1944ade6940', 'project_id': '711b033be2c74e7ba7f3f1944ade6940', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': [], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-70378297', 'ctest-fip_vn-53977699'], 'port_security_enabled': True, 'description': ''}} 2026-05-04 04:10:47,749 - DEBUG - Response for create_subnet : {'subnet': {'id': '08218dfe-5102-4193-8056-e637c5aba461', 'name': '', 'tenant_id': '711b033be2c74e7ba7f3f1944ade6940', 'network_id': '34ce0969-d631-4e60-a504-3e07ed41cc2d', 'ip_version': 4, 'cidr': '5.1.117.128/26', 'allocation_pools': [{'start': '5.1.117.130', 'end': '5.1.117.190'}], 'gateway_ip': '5.1.117.129', 'enable_dhcp': True, 'ipv6_ra_mode': None, 'ipv6_address_mode': None, 'dns_nameservers': [], 'host_routes': [], 'dns_server_address': '5.1.117.130', 'tags': [], 'project_id': '711b033be2c74e7ba7f3f1944ade6940'}} 2026-05-04 04:10:47,780 - INFO - Created VN ctest-fip_vn-53977699 2026-05-04 04:10:47,800 - DEBUG - VN ctest-fip_vn-53977699 UUID is 34ce0969-d631-4e60-a504-3e07ed41cc2d 2026-05-04 04:10:47,894 - DEBUG - Hosts: {'nova': ['an-jenkins-deploy-platform-ansible-os-5740-1', 'an-jenkins-deploy-platform-ansible-os-5740-2']} 2026-05-04 04:10:49,420 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5740-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5740-2) 2026-05-04 04:10:51,143 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5740-2), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5740-2) 2026-05-04 04:10:52,852 - INFO - VM ([]) created on node: (an-jenkins-deploy-platform-ansible-os-5740-1), Zone: (nova:an-jenkins-deploy-platform-ansible-os-5740-1) 2026-05-04 04:10:52,852 - DEBUG - Requesting: http://10.0.0.129:8082/domains 2026-05-04 04:10:52,861 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c 2026-05-04 04:10:52,873 - DEBUG - Requesting: http://10.0.0.129:8082/project/711b033b-e2c7-4e7b-a7f3-f1944ade6940 2026-05-04 04:10:52,976 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/df2f8407-3df7-4f40-a8d3-bf4c63fbebf4 2026-05-04 04:10:52,990 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/df2f8407-3df7-4f40-a8d3-bf4c63fbebf4 2026-05-04 04:10:53,002 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/b2707d3d-9877-4c16-b1c8-031de92f1a6e 2026-05-04 04:10:53,011 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/b2707d3d-9877-4c16-b1c8-031de92f1a6e 2026-05-04 04:10:53,021 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/31c4be65-ebe8-4c67-b43f-65323a6eb1f0 2026-05-04 04:10:53,029 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-04 04:10:53,029 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/df2f8407-3df7-4f40-a8d3-bf4c63fbebf4 2026-05-04 04:10:53,041 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/b2707d3d-9877-4c16-b1c8-031de92f1a6e 2026-05-04 04:10:53,066 - INFO - Verified VN network id 14 for VN df2f8407-3df7-4f40-a8d3-bf4c63fbebf4 2026-05-04 04:10:53,066 - INFO - Verifications in API Server for VN ctest-vn1-00505497 passed 2026-05-04 04:10:53,067 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/df2f8407-3df7-4f40-a8d3-bf4c63fbebf4 2026-05-04 04:10:53,079 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/b2707d3d-9877-4c16-b1c8-031de92f1a6e 2026-05-04 04:10:53,088 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/b2707d3d-9877-4c16-b1c8-031de92f1a6e 2026-05-04 04:10:53,098 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/31c4be65-ebe8-4c67-b43f-65323a6eb1f0 2026-05-04 04:10:53,117 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497', 'interests': '1', 'advertised': '1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-70378297', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16082217961002585920', 'uuid-lslong': '12165277353273715700'}, 'enable': 'true', 'created': '2026-05-04T04:10:05', 'last-modified': '2026-05-04T04:10:05', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:47.103176'} 2026-05-04 04:10:53,124 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-04 04:10:53,140 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-70378297', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16082217961002585920', 'uuid-lslong': '12165277353273715700'}, 'enable': 'true', 'created': '2026-05-04T04:10:05', 'last-modified': '2026-05-04T04:10:05', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:47.118742'} 2026-05-04 04:10:53,151 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-04 04:10:53,157 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-70378297', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16082217961002585920', 'uuid-lslong': '12165277353273715700'}, 'enable': 'true', 'created': '2026-05-04T04:10:05', 'last-modified': '2026-05-04T04:10:05', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:47.146494'} 2026-05-04 04:10:53,163 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-04 04:10:53,163 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-00505497 passed 2026-05-04 04:10:53,164 - DEBUG - ====Verifying policy data for ctest-vn1-00505497 in API_Server ====== 2026-05-04 04:10:53,164 - DEBUG - Requesting: http://10.0.0.129:8082/domains 2026-05-04 04:10:53,172 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c 2026-05-04 04:10:53,188 - DEBUG - Requesting: http://10.0.0.129:8082/project/711b033b-e2c7-4e7b-a7f3-f1944ade6940 2026-05-04 04:10:53,381 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/df2f8407-3df7-4f40-a8d3-bf4c63fbebf4 2026-05-04 04:10:53,402 - DEBUG - =>VN ctest-vn1-00505497 has no policy to be verified 2026-05-04 04:10:53,402 - DEBUG - Verifying the vn in opserver 2026-05-04 04:10:53,402 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497 virtual network link through opserver 10.0.0.129 2026-05-04 04:10:53,402 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks 2026-05-04 04:10:53,638 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497?flat'} 2026-05-04 04:10:53,638 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497 virtual network link through opserver 10.0.0.50 2026-05-04 04:10:53,638 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-05-04 04:10:53,864 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497?flat'} 2026-05-04 04:10:53,864 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497 virtual network link through opserver 10.0.0.249 2026-05-04 04:10:53,864 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2026-05-04 04:10:54,084 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497?flat'} 2026-05-04 04:10:54,084 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497 is found in opserver 2026-05-04 04:10:54,105 - DEBUG - VRF ids for VN ctest-vn1-00505497: {'10.0.0.41': '4'} 2026-05-04 04:10:54,105 - DEBUG - Requesting: http://10.0.0.129:8082/domains 2026-05-04 04:10:54,115 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c 2026-05-04 04:10:54,176 - DEBUG - Requesting: http://10.0.0.129:8082/project/711b033b-e2c7-4e7b-a7f3-f1944ade6940 2026-05-04 04:10:54,319 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/633d6c79-d3d0-4843-9929-3e9a779660a6 2026-05-04 04:10:54,339 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/633d6c79-d3d0-4843-9929-3e9a779660a6 2026-05-04 04:10:54,356 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/4a74f0a5-0f05-44d1-8d0e-7f60715a8a69 2026-05-04 04:10:54,381 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/4a74f0a5-0f05-44d1-8d0e-7f60715a8a69 2026-05-04 04:10:54,391 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/3dc4f0ec-83a4-42a5-922b-89f309bdab4c 2026-05-04 04:10:54,412 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-05-04 04:10:54,412 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/633d6c79-d3d0-4843-9929-3e9a779660a6 2026-05-04 04:10:54,425 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/4a74f0a5-0f05-44d1-8d0e-7f60715a8a69 2026-05-04 04:10:54,444 - INFO - Verified VN network id 15 for VN 633d6c79-d3d0-4843-9929-3e9a779660a6 2026-05-04 04:10:54,444 - INFO - Verifications in API Server for VN ctest-vn2-47014571 passed 2026-05-04 04:10:54,445 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/633d6c79-d3d0-4843-9929-3e9a779660a6 2026-05-04 04:10:54,459 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/4a74f0a5-0f05-44d1-8d0e-7f60715a8a69 2026-05-04 04:10:54,473 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/4a74f0a5-0f05-44d1-8d0e-7f60715a8a69 2026-05-04 04:10:54,486 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/3dc4f0ec-83a4-42a5-922b-89f309bdab4c 2026-05-04 04:10:54,512 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-70378297', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7150991053834700867', 'uuid-lslong': '11036421195000340646'}, 'enable': 'true', 'created': '2026-05-04T04:10:46', 'last-modified': '2026-05-04T04:10:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:07.595028'} 2026-05-04 04:10:54,522 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-05-04 04:10:54,540 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-70378297', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7150991053834700867', 'uuid-lslong': '11036421195000340646'}, 'enable': 'true', 'created': '2026-05-04T04:10:46', 'last-modified': '2026-05-04T04:10:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:07.616474'} 2026-05-04 04:10:54,552 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-05-04 04:10:54,563 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-70378297', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7150991053834700867', 'uuid-lslong': '11036421195000340646'}, 'enable': 'true', 'created': '2026-05-04T04:10:46', 'last-modified': '2026-05-04T04:10:46', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:07.653565'} 2026-05-04 04:10:54,574 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-05-04 04:10:54,574 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-47014571 passed 2026-05-04 04:10:54,575 - DEBUG - ====Verifying policy data for ctest-vn2-47014571 in API_Server ====== 2026-05-04 04:10:54,575 - DEBUG - Requesting: http://10.0.0.129:8082/domains 2026-05-04 04:10:54,583 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c 2026-05-04 04:10:54,604 - DEBUG - Requesting: http://10.0.0.129:8082/project/711b033b-e2c7-4e7b-a7f3-f1944ade6940 2026-05-04 04:10:54,706 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/633d6c79-d3d0-4843-9929-3e9a779660a6 2026-05-04 04:10:54,725 - DEBUG - =>VN ctest-vn2-47014571 has no policy to be verified 2026-05-04 04:10:54,725 - DEBUG - Verifying the vn in opserver 2026-05-04 04:10:54,725 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571 virtual network link through opserver 10.0.0.129 2026-05-04 04:10:54,725 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks 2026-05-04 04:10:54,865 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571?flat'} 2026-05-04 04:10:54,865 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571 virtual network link through opserver 10.0.0.50 2026-05-04 04:10:54,865 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-05-04 04:10:55,328 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571?flat'} 2026-05-04 04:10:55,328 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571 virtual network link through opserver 10.0.0.249 2026-05-04 04:10:55,328 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2026-05-04 04:10:55,697 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571?flat'} 2026-05-04 04:10:55,697 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571 is found in opserver 2026-05-04 04:10:55,709 - DEBUG - VRF ids for VN ctest-vn2-47014571: {'10.0.0.41': '5', '10.0.0.141': '4'} 2026-05-04 04:10:55,709 - DEBUG - Requesting: http://10.0.0.129:8082/domains 2026-05-04 04:10:55,720 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c 2026-05-04 04:10:55,738 - DEBUG - Requesting: http://10.0.0.129:8082/project/711b033b-e2c7-4e7b-a7f3-f1944ade6940 2026-05-04 04:10:55,877 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/34ce0969-d631-4e60-a504-3e07ed41cc2d 2026-05-04 04:10:55,890 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/34ce0969-d631-4e60-a504-3e07ed41cc2d 2026-05-04 04:10:55,902 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/2b0a1993-7b51-46fd-b268-a4930f323f40 2026-05-04 04:10:55,912 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/2b0a1993-7b51-46fd-b268-a4930f323f40 2026-05-04 04:10:55,922 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/a5646f66-7eec-4e6e-8524-410c08aaebed 2026-05-04 04:10:55,931 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-05-04 04:10:55,931 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/34ce0969-d631-4e60-a504-3e07ed41cc2d 2026-05-04 04:10:55,941 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/2b0a1993-7b51-46fd-b268-a4930f323f40 2026-05-04 04:10:55,960 - INFO - Verified VN network id 16 for VN 34ce0969-d631-4e60-a504-3e07ed41cc2d 2026-05-04 04:10:55,960 - INFO - Verifications in API Server for VN ctest-fip_vn-53977699 passed 2026-05-04 04:10:55,960 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/34ce0969-d631-4e60-a504-3e07ed41cc2d 2026-05-04 04:10:55,970 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/2b0a1993-7b51-46fd-b268-a4930f323f40 2026-05-04 04:10:55,979 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/2b0a1993-7b51-46fd-b268-a4930f323f40 2026-05-04 04:10:55,987 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/a5646f66-7eec-4e6e-8524-410c08aaebed 2026-05-04 04:10:56,002 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-70378297', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3804989085344419424', 'uuid-lslong': '11890697119931157549'}, 'enable': 'true', 'created': '2026-05-04T04:10:47', 'last-modified': '2026-05-04T04:10:47', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:08.312637'} 2026-05-04 04:10:56,009 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-05-04 04:10:56,016 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-70378297', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3804989085344419424', 'uuid-lslong': '11890697119931157549'}, 'enable': 'true', 'created': '2026-05-04T04:10:47', 'last-modified': '2026-05-04T04:10:47', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:08.323587'} 2026-05-04 04:10:56,023 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-05-04 04:10:56,029 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-70378297', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3804989085344419424', 'uuid-lslong': '11890697119931157549'}, 'enable': 'true', 'created': '2026-05-04T04:10:47', 'last-modified': '2026-05-04T04:10:47', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:08.340741'} 2026-05-04 04:10:56,035 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-05-04 04:10:56,036 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-fip_vn-53977699 passed 2026-05-04 04:10:56,036 - DEBUG - ====Verifying policy data for ctest-fip_vn-53977699 in API_Server ====== 2026-05-04 04:10:56,036 - DEBUG - Requesting: http://10.0.0.129:8082/domains 2026-05-04 04:10:56,042 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c 2026-05-04 04:10:56,055 - DEBUG - Requesting: http://10.0.0.129:8082/project/711b033b-e2c7-4e7b-a7f3-f1944ade6940 2026-05-04 04:10:56,152 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/34ce0969-d631-4e60-a504-3e07ed41cc2d 2026-05-04 04:10:56,164 - DEBUG - =>VN ctest-fip_vn-53977699 has no policy to be verified 2026-05-04 04:10:56,164 - DEBUG - Verifying the vn in opserver 2026-05-04 04:10:56,164 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699 virtual network link through opserver 10.0.0.129 2026-05-04 04:10:56,164 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks 2026-05-04 04:10:56,177 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699?flat'} 2026-05-04 04:10:56,177 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699 virtual network link through opserver 10.0.0.50 2026-05-04 04:10:56,177 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-05-04 04:10:56,192 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699?flat'} 2026-05-04 04:10:56,192 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699 virtual network link through opserver 10.0.0.249 2026-05-04 04:10:56,192 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2026-05-04 04:10:56,209 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699?flat'} 2026-05-04 04:10:56,209 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699 is found in opserver 2026-05-04 04:10:56,220 - DEBUG - VRF ids for VN ctest-fip_vn-53977699: {'10.0.0.141': '5'} 2026-05-04 04:10:56,220 - INFO - Waiting for VM ctest-fvn_vm1-46968082 to be up.. 2026-05-04 04:10:56,326 - DEBUG - VM is in ACTIVE state now 2026-05-04 04:10:56,326 - INFO - VM name : ctest-fvn_vm1-46968082 2026-05-04 04:10:56,414 - DEBUG - VM ctest-fvn_vm1-46968082 ID is 17c1f148-238a-4101-a721-67f41bf99324 2026-05-04 04:10:56,414 - DEBUG - VM ctest-fvn_vm1-46968082 launched on Node an-jenkins-deploy-platform-ansible-os-5740-2 2026-05-04 04:10:56,517 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/17c1f148-238a-4101-a721-67f41bf99324 2026-05-04 04:10:56,530 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/799f2995-468f-4f69-ab23-1178e691c7d5 2026-05-04 04:10:59,728 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1011ms') 2026-05-04 04:10:59,728 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-fvn_vm1-46968082 failed! 2026-05-04 04:10:59,744 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699 is 5.1.117.129 and allocation pool is NOT set 2026-05-04 04:11:03,827 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1017ms') 2026-05-04 04:11:03,827 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-fvn_vm1-46968082 failed! 2026-05-04 04:11:03,844 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699 is 5.1.117.129 and allocation pool is NOT set 2026-05-04 04:11:07,917 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1013ms') 2026-05-04 04:11:07,917 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-fvn_vm1-46968082 failed! 2026-05-04 04:11:07,936 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699 is 5.1.117.129 and allocation pool is NOT set 2026-05-04 04:11:12,013 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1015ms') 2026-05-04 04:11:12,014 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-fvn_vm1-46968082 failed! 2026-05-04 04:11:12,033 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699 is 5.1.117.129 and allocation pool is NOT set 2026-05-04 04:11:16,111 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 0 received, 100% packet loss, time 1013ms') 2026-05-04 04:11:16,111 - DEBUG - Ping to Metadata IP 169.254.0.6 of VM ctest-fvn_vm1-46968082 failed! 2026-05-04 04:11:16,127 - DEBUG - Gateway for vn default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699 is 5.1.117.129 and allocation pool is NOT set 2026-05-04 04:11:18,197 - DEBUG - (True, 'PING 169.254.0.6 (169.254.0.6) 56(84) bytes of data.\r\n64 bytes from 169.254.0.6: icmp_seq=1 ttl=63 time=5.07 ms\r\n64 bytes from 169.254.0.6: icmp_seq=2 ttl=63 time=1.12 ms\r\n\r\n--- 169.254.0.6 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 1.119/3.094/5.070/1.975 ms') 2026-05-04 04:11:18,197 - INFO - Ping to Metadata IP 169.254.0.6 of VM ctest-fvn_vm1-46968082 passed 2026-05-04 04:11:18,272 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-04 04:11:18,272 - DEBUG - Waiting to SSH to VM ctest-fvn_vm1-46968082, IP 5.1.117.131, Port 22 2026-05-04 04:11:18,339 - DEBUG - Error on ssh to cirros@169.254.0.6:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.6/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.6/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.6/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-05-04 04:11:18,439 - DEBUG - VM ctest-fvn_vm1-46968082 is NOT ready for SSH connections, VM status: ACTIVE 2026-05-04 04:11:23,440 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-04 04:11:23,440 - DEBUG - Waiting to SSH to VM ctest-fvn_vm1-46968082, IP 5.1.117.131, Port 22 2026-05-04 04:11:23,537 - DEBUG - Error on ssh to cirros@169.254.0.6:22, result: /bin/bash: connect: Connection refused /bin/bash: line 1: /dev/tcp/169.254.0.6/22: Connection refused {'failed': True, 'command': '(echo > /dev/tcp/169.254.0.6/22)', 'real_command': '/bin/bash -l -c "(echo > /dev/tcp/169.254.0.6/22)"', 'return_code': 1, 'succeeded': False, 'stderr': ''} 2026-05-04 04:11:23,626 - DEBUG - VM ctest-fvn_vm1-46968082 is NOT ready for SSH connections, VM status: ACTIVE 2026-05-04 04:11:28,627 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-04 04:11:28,627 - DEBUG - Waiting to SSH to VM ctest-fvn_vm1-46968082, IP 5.1.117.131, Port 22 2026-05-04 04:11:28,794 - DEBUG - VM ctest-fvn_vm1-46968082 is ready for SSH connections 2026-05-04 04:11:28,795 - INFO - Waiting for VM ctest-vn2_vm2-97834820 to be up.. 2026-05-04 04:11:28,881 - DEBUG - VM is in ACTIVE state now 2026-05-04 04:11:28,881 - INFO - VM name : ctest-vn2_vm2-97834820 2026-05-04 04:11:28,974 - DEBUG - VM ctest-vn2_vm2-97834820 ID is bcf9f402-a4da-470a-aa99-3406bfda2061 2026-05-04 04:11:28,974 - DEBUG - VM ctest-vn2_vm2-97834820 launched on Node an-jenkins-deploy-platform-ansible-os-5740-2 2026-05-04 04:11:29,065 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/bcf9f402-a4da-470a-aa99-3406bfda2061 2026-05-04 04:11:29,080 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/1aa0ab1c-b2bf-472e-b524-67fde0c8559f 2026-05-04 04:11:30,276 - DEBUG - (True, 'PING 169.254.0.5 (169.254.0.5) 56(84) bytes of data.\r\n64 bytes from 169.254.0.5: icmp_seq=1 ttl=63 time=4.66 ms\r\n64 bytes from 169.254.0.5: icmp_seq=2 ttl=63 time=3.10 ms\r\n\r\n--- 169.254.0.5 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 3.098/3.880/4.662/0.782 ms') 2026-05-04 04:11:30,276 - INFO - Ping to Metadata IP 169.254.0.5 of VM ctest-vn2_vm2-97834820 passed 2026-05-04 04:11:30,351 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-04 04:11:30,351 - DEBUG - Waiting to SSH to VM ctest-vn2_vm2-97834820, IP 133.227.48.67, Port 22 2026-05-04 04:11:30,522 - DEBUG - VM ctest-vn2_vm2-97834820 is ready for SSH connections 2026-05-04 04:11:30,522 - INFO - Waiting for VM mltf_vm to be up.. 2026-05-04 04:11:30,615 - DEBUG - VM is in ACTIVE state now 2026-05-04 04:11:30,615 - INFO - VM name : mltf_vm 2026-05-04 04:11:30,715 - DEBUG - VM mltf_vm ID is 2f1b8b83-d7c0-4ce3-bc72-6660eb9216cd 2026-05-04 04:11:30,715 - DEBUG - VM mltf_vm launched on Node an-jenkins-deploy-platform-ansible-os-5740-1 2026-05-04 04:11:30,938 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine/2f1b8b83-d7c0-4ce3-bc72-6660eb9216cd 2026-05-04 04:11:30,956 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/0ef9920a-8ac0-410a-9b97-b749e26ac52b 2026-05-04 04:11:30,973 - DEBUG - Requesting: http://10.0.0.249:8082/virtual-machine-interface/c1f05482-d16b-498d-b9da-dca6da2c49af 2026-05-04 04:11:32,172 - DEBUG - (True, 'PING 169.254.0.7 (169.254.0.7) 56(84) bytes of data.\r\n64 bytes from 169.254.0.7: icmp_seq=1 ttl=63 time=2.89 ms\r\n64 bytes from 169.254.0.7: icmp_seq=2 ttl=63 time=0.576 ms\r\n\r\n--- 169.254.0.7 ping statistics ---\r\n2 packets transmitted, 2 received, 0% packet loss, time 1001ms\r\nrtt min/avg/max/mdev = 0.576/1.733/2.890/1.157 ms') 2026-05-04 04:11:32,172 - INFO - Ping to Metadata IP 169.254.0.7 of VM mltf_vm passed 2026-05-04 04:11:32,251 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-04 04:11:32,251 - DEBUG - Waiting to SSH to VM mltf_vm, IP 2.76.249.69, Port 22 2026-05-04 04:11:32,418 - DEBUG - VM mltf_vm is ready for SSH connections 2026-05-04 04:11:32,493 - DEBUG - verify_vm_launched is skipped since self.vm_launch_flag is set 2026-05-04 04:11:32,493 - DEBUG - Waiting to SSH to VM mltf_vm, IP 2.76.249.69, Port 22 2026-05-04 04:11:32,665 - DEBUG - VM mltf_vm is ready for SSH connections 2026-05-04 04:11:32,668 - INFO - ================================================================================ 2026-05-04 04:11:32,668 - INFO - STARTING TEST : test_verify_session_sampling_teardown 2026-05-04 04:11:32,668 - INFO - TEST DESCRIPTION : 1.query client session samples 2.query server session samples 3.query client session to get number of sessions exported 4.query session record table for teardown bytes/pkts 5.query sample count after teardown on server side 2026-05-04 04:11:33,952 - DEBUG - Skipping xmpp flap check 2026-05-04 04:11:33,952 - INFO - Initial checks done. Running the testcase now 2026-05-04 04:11:33,952 - INFO - 2026-05-04 04:11:34,089 - INFO - Setting flow export rate: 100 2026-05-04 04:11:34,142 - DEBUG - Policy np_rules : [rule_sequence = None, rule_uuid = None, direction = <>, protocol = icmp, src_addresses = [subnet = None, virtual_network = any, security_group = None, network_policy = None, subnet_list = []], src_ports = [start_port = -1, end_port = -1], application = [], dst_addresses = [subnet = None, virtual_network = any, security_group = None, network_policy = None, subnet_list = []], dst_ports = [start_port = -1, end_port = -1], action_list = simple_action = pass, gateway_name = None, apply_service = [], service_properties = None, mirror_to = None, assign_routing_instance = None, log = False, alert = False, qos_action = None, host_based_service = False, ethertype = None, created = None, last_modified = None, description = None] 2026-05-04 04:11:34,541 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': 'df2f8407-3df7-4f40-a8d3-bf4c63fbebf4', 'name': 'ctest-vn1-00505497', 'tenant_id': '711b033be2c74e7ba7f3f1944ade6940', 'project_id': '711b033be2c74e7ba7f3f1944ade6940', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['a8d68edb-864b-49b4-98a5-908ae2686e9c'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-70378297', 'ctest-vn1-00505497'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-70378297', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '2.76.249.64/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-05-04 04:11:34,757 - DEBUG - Response for mapping policy(s) with vn {'network': {'id': '633d6c79-d3d0-4843-9929-3e9a779660a6', 'name': 'ctest-vn2-47014571', 'tenant_id': '711b033be2c74e7ba7f3f1944ade6940', 'project_id': '711b033be2c74e7ba7f3f1944ade6940', 'admin_state_up': True, 'shared': False, 'status': 'ACTIVE', 'router:external': False, 'mtu': 0, 'subnets': ['82056189-9da3-4af1-9206-4c81f462f2d3'], 'fq_name': ['default-domain', 'ctest-AnalyticsTestSanityWithResource-70378297', 'ctest-vn2-47014571'], 'policys': [['default-domain', 'ctest-AnalyticsTestSanityWithResource-70378297', 'policy1']], 'subnet_ipam': [{'subnet_cidr': '133.227.48.64/26', 'ipam_fq_name': ['default-domain', 'default-project', 'default-network-ipam']}], 'port_security_enabled': True, 'description': ''}} 2026-05-04 04:11:34,885 - DEBUG - Requesting: http://10.0.0.129:8082/domains 2026-05-04 04:11:34,892 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c 2026-05-04 04:11:34,945 - DEBUG - Requesting: http://10.0.0.129:8082/project/711b033b-e2c7-4e7b-a7f3-f1944ade6940 2026-05-04 04:11:35,071 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/df2f8407-3df7-4f40-a8d3-bf4c63fbebf4 2026-05-04 04:11:35,090 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/df2f8407-3df7-4f40-a8d3-bf4c63fbebf4 2026-05-04 04:11:35,102 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/b2707d3d-9877-4c16-b1c8-031de92f1a6e 2026-05-04 04:11:35,113 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/b2707d3d-9877-4c16-b1c8-031de92f1a6e 2026-05-04 04:11:35,122 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/31c4be65-ebe8-4c67-b43f-65323a6eb1f0 2026-05-04 04:11:35,130 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-04 04:11:35,130 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/df2f8407-3df7-4f40-a8d3-bf4c63fbebf4 2026-05-04 04:11:35,140 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/b2707d3d-9877-4c16-b1c8-031de92f1a6e 2026-05-04 04:11:35,159 - INFO - Verified VN network id 14 for VN df2f8407-3df7-4f40-a8d3-bf4c63fbebf4 2026-05-04 04:11:35,159 - INFO - Verifications in API Server for VN ctest-vn1-00505497 passed 2026-05-04 04:11:35,159 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/df2f8407-3df7-4f40-a8d3-bf4c63fbebf4 2026-05-04 04:11:35,171 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/b2707d3d-9877-4c16-b1c8-031de92f1a6e 2026-05-04 04:11:35,192 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/b2707d3d-9877-4c16-b1c8-031de92f1a6e 2026-05-04 04:11:35,232 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/31c4be65-ebe8-4c67-b43f-65323a6eb1f0 2026-05-04 04:11:35,285 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497', 'interests': '1', 'advertised': '1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-70378297', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16082217961002585920', 'uuid-lslong': '12165277353273715700'}, 'enable': 'true', 'created': '2026-05-04T04:10:05', 'last-modified': '2026-05-04T04:11:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.796027'} 2026-05-04 04:11:35,309 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-04 04:11:35,315 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-70378297', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16082217961002585920', 'uuid-lslong': '12165277353273715700'}, 'enable': 'true', 'created': '2026-05-04T04:10:05', 'last-modified': '2026-05-04T04:11:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.822509'} 2026-05-04 04:11:35,324 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-04 04:11:35,330 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-70378297', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16082217961002585920', 'uuid-lslong': '12165277353273715700'}, 'enable': 'true', 'created': '2026-05-04T04:10:05', 'last-modified': '2026-05-04T04:11:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:00.820411'} 2026-05-04 04:11:35,339 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-04 04:11:35,339 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-00505497 passed 2026-05-04 04:11:35,339 - DEBUG - ====Verifying policy data for ctest-vn1-00505497 in API_Server ====== 2026-05-04 04:11:35,339 - DEBUG - Requesting: http://10.0.0.129:8082/domains 2026-05-04 04:11:35,346 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c 2026-05-04 04:11:35,359 - DEBUG - Requesting: http://10.0.0.129:8082/project/711b033b-e2c7-4e7b-a7f3-f1944ade6940 2026-05-04 04:11:35,447 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/df2f8407-3df7-4f40-a8d3-bf4c63fbebf4 2026-05-04 04:11:35,461 - DEBUG - ==>Verifying data for policy with id: 1fc10ffc-6d3b-4346-9bcc-4eb2f5c034b3, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-70378297', 'policy1'] 2026-05-04 04:11:35,462 - INFO - VN ctest-vn1-00505497 Policy verification: verify_vn_policy_in_api_server, status: True 2026-05-04 04:11:35,462 - DEBUG - Verifying the vn in opserver 2026-05-04 04:11:35,462 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497 virtual network link through opserver 10.0.0.129 2026-05-04 04:11:35,462 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks 2026-05-04 04:11:35,476 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497?flat'} 2026-05-04 04:11:35,476 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497 virtual network link through opserver 10.0.0.50 2026-05-04 04:11:35,476 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-05-04 04:11:35,491 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497?flat'} 2026-05-04 04:11:35,491 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497 virtual network link through opserver 10.0.0.249 2026-05-04 04:11:35,491 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2026-05-04 04:11:35,507 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497?flat'} 2026-05-04 04:11:35,507 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497 is found in opserver 2026-05-04 04:11:35,520 - DEBUG - VRF ids for VN ctest-vn1-00505497: {'10.0.0.41': '4'} 2026-05-04 04:11:35,520 - DEBUG - Requesting: http://10.0.0.129:8082/domains 2026-05-04 04:11:35,527 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c 2026-05-04 04:11:35,540 - DEBUG - Requesting: http://10.0.0.129:8082/project/711b033b-e2c7-4e7b-a7f3-f1944ade6940 2026-05-04 04:11:35,645 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/633d6c79-d3d0-4843-9929-3e9a779660a6 2026-05-04 04:11:35,660 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/633d6c79-d3d0-4843-9929-3e9a779660a6 2026-05-04 04:11:35,672 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/4a74f0a5-0f05-44d1-8d0e-7f60715a8a69 2026-05-04 04:11:35,684 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/4a74f0a5-0f05-44d1-8d0e-7f60715a8a69 2026-05-04 04:11:35,693 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/3dc4f0ec-83a4-42a5-922b-89f309bdab4c 2026-05-04 04:11:35,700 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-05-04 04:11:35,700 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/633d6c79-d3d0-4843-9929-3e9a779660a6 2026-05-04 04:11:35,710 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/4a74f0a5-0f05-44d1-8d0e-7f60715a8a69 2026-05-04 04:11:35,730 - INFO - Verified VN network id 15 for VN 633d6c79-d3d0-4843-9929-3e9a779660a6 2026-05-04 04:11:35,730 - INFO - Verifications in API Server for VN ctest-vn2-47014571 passed 2026-05-04 04:11:35,730 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/633d6c79-d3d0-4843-9929-3e9a779660a6 2026-05-04 04:11:35,743 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/4a74f0a5-0f05-44d1-8d0e-7f60715a8a69 2026-05-04 04:11:35,757 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/4a74f0a5-0f05-44d1-8d0e-7f60715a8a69 2026-05-04 04:11:35,767 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/3dc4f0ec-83a4-42a5-922b-89f309bdab4c 2026-05-04 04:11:35,783 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571', 'interests': '0-1', 'advertised': '0-1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-70378297', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7150991053834700867', 'uuid-lslong': '11036421195000340646'}, 'enable': 'true', 'created': '2026-05-04T04:10:46', 'last-modified': '2026-05-04T04:11:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.065742'} 2026-05-04 04:11:35,791 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-05-04 04:11:35,800 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-70378297', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7150991053834700867', 'uuid-lslong': '11036421195000340646'}, 'enable': 'true', 'created': '2026-05-04T04:10:46', 'last-modified': '2026-05-04T04:11:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.083061'} 2026-05-04 04:11:35,810 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-05-04 04:11:35,816 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-70378297', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7150991053834700867', 'uuid-lslong': '11036421195000340646'}, 'enable': 'true', 'created': '2026-05-04T04:10:46', 'last-modified': '2026-05-04T04:11:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.101026'} 2026-05-04 04:11:35,825 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-05-04 04:11:35,825 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-47014571 passed 2026-05-04 04:11:35,825 - DEBUG - ====Verifying policy data for ctest-vn2-47014571 in API_Server ====== 2026-05-04 04:11:35,825 - DEBUG - Requesting: http://10.0.0.129:8082/domains 2026-05-04 04:11:35,832 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c 2026-05-04 04:11:35,843 - DEBUG - Requesting: http://10.0.0.129:8082/project/711b033b-e2c7-4e7b-a7f3-f1944ade6940 2026-05-04 04:11:35,933 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/633d6c79-d3d0-4843-9929-3e9a779660a6 2026-05-04 04:11:35,944 - DEBUG - ==>Verifying data for policy with id: 1fc10ffc-6d3b-4346-9bcc-4eb2f5c034b3, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-70378297', 'policy1'] 2026-05-04 04:11:35,944 - INFO - VN ctest-vn2-47014571 Policy verification: verify_vn_policy_in_api_server, status: True 2026-05-04 04:11:35,944 - DEBUG - Verifying the vn in opserver 2026-05-04 04:11:35,944 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571 virtual network link through opserver 10.0.0.129 2026-05-04 04:11:35,945 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks 2026-05-04 04:11:35,960 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571?flat'} 2026-05-04 04:11:35,960 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571 virtual network link through opserver 10.0.0.50 2026-05-04 04:11:35,960 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-05-04 04:11:35,976 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571?flat'} 2026-05-04 04:11:35,976 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571 virtual network link through opserver 10.0.0.249 2026-05-04 04:11:35,976 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2026-05-04 04:11:35,995 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571?flat'} 2026-05-04 04:11:35,995 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571 is found in opserver 2026-05-04 04:11:36,009 - DEBUG - VRF ids for VN ctest-vn2-47014571: {'10.0.0.41': '5', '10.0.0.141': '4'} 2026-05-04 04:11:36,009 - DEBUG - Requesting: http://10.0.0.129:8082/domains 2026-05-04 04:11:36,015 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c 2026-05-04 04:11:36,028 - DEBUG - Requesting: http://10.0.0.129:8082/project/711b033b-e2c7-4e7b-a7f3-f1944ade6940 2026-05-04 04:11:36,122 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/df2f8407-3df7-4f40-a8d3-bf4c63fbebf4 2026-05-04 04:11:36,135 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/df2f8407-3df7-4f40-a8d3-bf4c63fbebf4 2026-05-04 04:11:36,146 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/b2707d3d-9877-4c16-b1c8-031de92f1a6e 2026-05-04 04:11:36,156 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/b2707d3d-9877-4c16-b1c8-031de92f1a6e 2026-05-04 04:11:36,165 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/31c4be65-ebe8-4c67-b43f-65323a6eb1f0 2026-05-04 04:11:36,172 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-04 04:11:36,173 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/df2f8407-3df7-4f40-a8d3-bf4c63fbebf4 2026-05-04 04:11:36,183 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/b2707d3d-9877-4c16-b1c8-031de92f1a6e 2026-05-04 04:11:36,201 - INFO - Verified VN network id 14 for VN df2f8407-3df7-4f40-a8d3-bf4c63fbebf4 2026-05-04 04:11:36,202 - INFO - Verifications in API Server for VN ctest-vn1-00505497 passed 2026-05-04 04:11:36,202 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/df2f8407-3df7-4f40-a8d3-bf4c63fbebf4 2026-05-04 04:11:36,212 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/b2707d3d-9877-4c16-b1c8-031de92f1a6e 2026-05-04 04:11:36,222 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/b2707d3d-9877-4c16-b1c8-031de92f1a6e 2026-05-04 04:11:36,232 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/31c4be65-ebe8-4c67-b43f-65323a6eb1f0 2026-05-04 04:11:36,246 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497', 'interests': '1', 'advertised': '1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-70378297', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16082217961002585920', 'uuid-lslong': '12165277353273715700'}, 'enable': 'true', 'created': '2026-05-04T04:10:05', 'last-modified': '2026-05-04T04:11:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.757033'} 2026-05-04 04:11:36,252 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-04 04:11:36,258 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-70378297', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16082217961002585920', 'uuid-lslong': '12165277353273715700'}, 'enable': 'true', 'created': '2026-05-04T04:10:05', 'last-modified': '2026-05-04T04:11:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.765773'} 2026-05-04 04:11:36,269 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-04 04:11:36,275 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-70378297', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '16082217961002585920', 'uuid-lslong': '12165277353273715700'}, 'enable': 'true', 'created': '2026-05-04T04:10:05', 'last-modified': '2026-05-04T04:11:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:01.765648'} 2026-05-04 04:11:36,282 - DEBUG - Route Targets: ['target:64512:8000007'] 2026-05-04 04:11:36,282 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn1-00505497 passed 2026-05-04 04:11:36,283 - DEBUG - ====Verifying policy data for ctest-vn1-00505497 in API_Server ====== 2026-05-04 04:11:36,283 - DEBUG - Requesting: http://10.0.0.129:8082/domains 2026-05-04 04:11:36,289 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c 2026-05-04 04:11:36,301 - DEBUG - Requesting: http://10.0.0.129:8082/project/711b033b-e2c7-4e7b-a7f3-f1944ade6940 2026-05-04 04:11:36,398 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/df2f8407-3df7-4f40-a8d3-bf4c63fbebf4 2026-05-04 04:11:36,407 - DEBUG - ==>Verifying data for policy with id: 1fc10ffc-6d3b-4346-9bcc-4eb2f5c034b3, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-70378297', 'policy1'] 2026-05-04 04:11:36,407 - INFO - VN ctest-vn1-00505497 Policy verification: verify_vn_policy_in_api_server, status: True 2026-05-04 04:11:36,408 - DEBUG - Verifying the vn in opserver 2026-05-04 04:11:36,408 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497 virtual network link through opserver 10.0.0.129 2026-05-04 04:11:36,408 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks 2026-05-04 04:11:36,421 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497?flat'} 2026-05-04 04:11:36,421 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497 virtual network link through opserver 10.0.0.50 2026-05-04 04:11:36,421 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-05-04 04:11:36,442 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497?flat'} 2026-05-04 04:11:36,442 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497 virtual network link through opserver 10.0.0.249 2026-05-04 04:11:36,442 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2026-05-04 04:11:36,458 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497?flat'} 2026-05-04 04:11:36,458 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497 is found in opserver 2026-05-04 04:11:36,470 - DEBUG - VRF ids for VN ctest-vn1-00505497: {'10.0.0.41': '4'} 2026-05-04 04:11:36,470 - DEBUG - Requesting: http://10.0.0.129:8082/domains 2026-05-04 04:11:36,477 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c 2026-05-04 04:11:36,488 - DEBUG - Requesting: http://10.0.0.129:8082/project/711b033b-e2c7-4e7b-a7f3-f1944ade6940 2026-05-04 04:11:36,591 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/633d6c79-d3d0-4843-9929-3e9a779660a6 2026-05-04 04:11:36,604 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/633d6c79-d3d0-4843-9929-3e9a779660a6 2026-05-04 04:11:36,617 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/4a74f0a5-0f05-44d1-8d0e-7f60715a8a69 2026-05-04 04:11:36,626 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/4a74f0a5-0f05-44d1-8d0e-7f60715a8a69 2026-05-04 04:11:36,635 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/3dc4f0ec-83a4-42a5-922b-89f309bdab4c 2026-05-04 04:11:36,645 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-05-04 04:11:36,645 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/633d6c79-d3d0-4843-9929-3e9a779660a6 2026-05-04 04:11:36,657 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/4a74f0a5-0f05-44d1-8d0e-7f60715a8a69 2026-05-04 04:11:36,675 - INFO - Verified VN network id 15 for VN 633d6c79-d3d0-4843-9929-3e9a779660a6 2026-05-04 04:11:36,675 - INFO - Verifications in API Server for VN ctest-vn2-47014571 passed 2026-05-04 04:11:36,675 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/633d6c79-d3d0-4843-9929-3e9a779660a6 2026-05-04 04:11:36,690 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/4a74f0a5-0f05-44d1-8d0e-7f60715a8a69 2026-05-04 04:11:36,699 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/4a74f0a5-0f05-44d1-8d0e-7f60715a8a69 2026-05-04 04:11:36,708 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/3dc4f0ec-83a4-42a5-922b-89f309bdab4c 2026-05-04 04:11:36,721 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571', 'interests': '0-1', 'advertised': '0-1', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-70378297', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7150991053834700867', 'uuid-lslong': '11036421195000340646'}, 'enable': 'true', 'created': '2026-05-04T04:10:46', 'last-modified': '2026-05-04T04:11:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.004479'} 2026-05-04 04:11:36,728 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-05-04 04:11:36,735 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-70378297', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7150991053834700867', 'uuid-lslong': '11036421195000340646'}, 'enable': 'true', 'created': '2026-05-04T04:10:46', 'last-modified': '2026-05-04T04:11:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.018520'} 2026-05-04 04:11:36,743 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-05-04 04:11:36,749 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-70378297', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '7150991053834700867', 'uuid-lslong': '11036421195000340646'}, 'enable': 'true', 'created': '2026-05-04T04:10:46', 'last-modified': '2026-05-04T04:11:34', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:02.034059'} 2026-05-04 04:11:36,756 - DEBUG - Route Targets: ['target:64512:8000008'] 2026-05-04 04:11:36,756 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-vn2-47014571 passed 2026-05-04 04:11:36,756 - DEBUG - ====Verifying policy data for ctest-vn2-47014571 in API_Server ====== 2026-05-04 04:11:36,756 - DEBUG - Requesting: http://10.0.0.129:8082/domains 2026-05-04 04:11:36,763 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c 2026-05-04 04:11:36,776 - DEBUG - Requesting: http://10.0.0.129:8082/project/711b033b-e2c7-4e7b-a7f3-f1944ade6940 2026-05-04 04:11:36,879 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/633d6c79-d3d0-4843-9929-3e9a779660a6 2026-05-04 04:11:36,891 - DEBUG - ==>Verifying data for policy with id: 1fc10ffc-6d3b-4346-9bcc-4eb2f5c034b3, fqn: ['default-domain', 'ctest-AnalyticsTestSanityWithResource-70378297', 'policy1'] 2026-05-04 04:11:36,891 - INFO - VN ctest-vn2-47014571 Policy verification: verify_vn_policy_in_api_server, status: True 2026-05-04 04:11:36,891 - DEBUG - Verifying the vn in opserver 2026-05-04 04:11:36,891 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571 virtual network link through opserver 10.0.0.129 2026-05-04 04:11:36,891 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks 2026-05-04 04:11:36,905 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571?flat'} 2026-05-04 04:11:36,905 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571 virtual network link through opserver 10.0.0.50 2026-05-04 04:11:36,905 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-05-04 04:11:36,922 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571?flat'} 2026-05-04 04:11:36,922 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571 virtual network link through opserver 10.0.0.249 2026-05-04 04:11:36,922 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2026-05-04 04:11:36,939 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571?flat'} 2026-05-04 04:11:36,939 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571 is found in opserver 2026-05-04 04:11:36,951 - DEBUG - VRF ids for VN ctest-vn2-47014571: {'10.0.0.41': '5', '10.0.0.141': '4'} 2026-05-04 04:11:36,951 - DEBUG - Requesting: http://10.0.0.129:8082/domains 2026-05-04 04:11:36,957 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c 2026-05-04 04:11:36,968 - DEBUG - Requesting: http://10.0.0.129:8082/project/711b033b-e2c7-4e7b-a7f3-f1944ade6940 2026-05-04 04:11:37,069 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/34ce0969-d631-4e60-a504-3e07ed41cc2d 2026-05-04 04:11:37,082 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/34ce0969-d631-4e60-a504-3e07ed41cc2d 2026-05-04 04:11:37,093 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/2b0a1993-7b51-46fd-b268-a4930f323f40 2026-05-04 04:11:37,101 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/2b0a1993-7b51-46fd-b268-a4930f323f40 2026-05-04 04:11:37,108 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/a5646f66-7eec-4e6e-8524-410c08aaebed 2026-05-04 04:11:37,116 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-05-04 04:11:37,117 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/34ce0969-d631-4e60-a504-3e07ed41cc2d 2026-05-04 04:11:37,129 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/2b0a1993-7b51-46fd-b268-a4930f323f40 2026-05-04 04:11:37,147 - INFO - Verified VN network id 16 for VN 34ce0969-d631-4e60-a504-3e07ed41cc2d 2026-05-04 04:11:37,147 - INFO - Verifications in API Server for VN ctest-fip_vn-53977699 passed 2026-05-04 04:11:37,147 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/34ce0969-d631-4e60-a504-3e07ed41cc2d 2026-05-04 04:11:37,158 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/2b0a1993-7b51-46fd-b268-a4930f323f40 2026-05-04 04:11:37,172 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/2b0a1993-7b51-46fd-b268-a4930f323f40 2026-05-04 04:11:37,187 - DEBUG - Requesting: http://10.0.0.129:8082/route-target/a5646f66-7eec-4e6e-8524-410c08aaebed 2026-05-04 04:11:37,218 - DEBUG - Control-node 10.0.0.129 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699', 'interests': '0', 'advertised': '0', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-70378297', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3804989085344419424', 'uuid-lslong': '11890697119931157549'}, 'enable': 'true', 'created': '2026-05-04T04:10:47', 'last-modified': '2026-05-04T04:10:47', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:49.523374'} 2026-05-04 04:11:37,233 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-05-04 04:11:37,241 - DEBUG - Control-node 10.0.0.50 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-70378297', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3804989085344419424', 'uuid-lslong': '11890697119931157549'}, 'enable': 'true', 'created': '2026-05-04T04:10:47', 'last-modified': '2026-05-04T04:10:47', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:49.548348'} 2026-05-04 04:11:37,249 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-05-04 04:11:37,257 - DEBUG - Control-node 10.0.0.249 : VN object is : {'node_name': 'virtual-network:default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699', 'interests': '-', 'advertised': '-', 'dbentryflags': None, 'obj_info': {'sequence_number': '0', 'origin': 'Cassandra', 'data': {'id-perms': {'permissions': {'owner': 'ctest-AnalyticsTestSanityWithResource-70378297', 'owner-access': '7', 'group': 'member', 'group-access': '7', 'other-access': '7'}, 'uuid': {'uuid-mslong': '3804989085344419424', 'uuid-lslong': '11890697119931157549'}, 'enable': 'true', 'created': '2026-05-04T04:10:47', 'last-modified': '2026-05-04T04:10:47', 'description': None, 'user-visible': 'true', 'creator': None}}}, 'neighbors': None, 'last_modified': '00:00:49.569152'} 2026-05-04 04:11:37,267 - DEBUG - Route Targets: ['target:64512:8000009'] 2026-05-04 04:11:37,267 - INFO - On all control nodes, Config, RI and RT verification for VN ctest-fip_vn-53977699 passed 2026-05-04 04:11:37,267 - DEBUG - ====Verifying policy data for ctest-fip_vn-53977699 in API_Server ====== 2026-05-04 04:11:37,267 - DEBUG - Requesting: http://10.0.0.129:8082/domains 2026-05-04 04:11:37,274 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c 2026-05-04 04:11:37,286 - DEBUG - Requesting: http://10.0.0.129:8082/project/711b033b-e2c7-4e7b-a7f3-f1944ade6940 2026-05-04 04:11:37,390 - DEBUG - Requesting: http://10.0.0.129:8082/virtual-network/34ce0969-d631-4e60-a504-3e07ed41cc2d 2026-05-04 04:11:37,402 - DEBUG - =>VN ctest-fip_vn-53977699 has no policy to be verified 2026-05-04 04:11:37,402 - DEBUG - Verifying the vn in opserver 2026-05-04 04:11:37,402 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699 virtual network link through opserver 10.0.0.129 2026-05-04 04:11:37,402 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/virtual-networks 2026-05-04 04:11:37,417 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699', 'href': 'http://10.0.0.129:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699?flat'} 2026-05-04 04:11:37,417 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699 virtual network link through opserver 10.0.0.50 2026-05-04 04:11:37,417 - DEBUG - Requesting: http://10.0.0.50:8081/analytics/uves/virtual-networks 2026-05-04 04:11:37,434 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699', 'href': 'http://10.0.0.50:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699?flat'} 2026-05-04 04:11:37,434 - DEBUG - Verifying the default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699 virtual network link through opserver 10.0.0.249 2026-05-04 04:11:37,434 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/virtual-networks 2026-05-04 04:11:37,460 - DEBUG - vn link and name as {'name': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699', 'href': 'http://10.0.0.249:8081/analytics/uves/virtual-network/default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699?flat'} 2026-05-04 04:11:37,460 - INFO - Validated that VN default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699 is found in opserver 2026-05-04 04:11:37,474 - DEBUG - VRF ids for VN ctest-fip_vn-53977699: {'10.0.0.141': '5'} 2026-05-04 04:11:37,474 - INFO - start time= 1777867897474959 2026-05-04 04:11:37,475 - DEBUG - Running remote_cmd, Cmd : ping -s 56 -c 3 -W 1 133.227.48.67, host_string: cirros@169.254.0.5, password: gocubsgogateway: ubuntu@10.0.0.41, gateway password: c0ntrail123 2026-05-04 04:11:37,475 - DEBUG - ping -s 56 -c 3 -W 1 133.227.48.67 2026-05-04 04:11:41,169 - DEBUG - PING 133.227.48.67 (133.227.48.67): 56 data bytes 64 bytes from 133.227.48.67: seq=0 ttl=63 time=6.708 ms 64 bytes from 133.227.48.67: seq=1 ttl=63 time=1.603 ms 64 bytes from 133.227.48.67: seq=2 ttl=63 time=1.597 ms --- 133.227.48.67 ping statistics --- 3 packets transmitted, 3 packets received, 0% packet loss round-trip min/avg/max = 1.597/3.302/6.708 ms 2026-05-04 04:11:41,169 - INFO - Ping to IP 133.227.48.67 from VM ctest-vn1_vm1-31497109 passed 2026-05-04 04:11:51,170 - INFO - Verify session samples and teardown pkts 2026-05-04 04:11:51,170 - INFO - Verifying SessionSeriesTable through opserver 10.0.0.129 2026-05-04 04:11:51,174 - DEBUG - Posting: http://10.0.0.129:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1777867897474959, 'end_time': 1777867911174555, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'} 2026-05-04 04:11:52,197 - DEBUG - [{'T': 1777867899167607}, {'T': 1777867900167668}, {'T': 1777867901167753}] 2026-05-04 04:11:52,198 - DEBUG - Posting: http://10.0.0.129:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1777867897474959, 'end_time': 1777867912198033, 'select_fields': ['T'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'server'} 2026-05-04 04:11:53,222 - DEBUG - [{'T': 1777867899721658}, {'T': 1777867900721775}, {'T': 1777867901722061}] 2026-05-04 04:11:53,222 - DEBUG - Posting: http://10.0.0.129:8081/analytics/query, payload {'table': 'SessionSeriesTable', 'start_time': 1777867897474959, 'end_time': 1777867913222561, 'select_fields': ['vn', 'remote_vn', 'sample_count'], 'where': [[{'name': 'vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497', 'op': 1, 'value2': None}, {'name': 'remote_vn', 'value': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571', 'op': 1, 'value2': None}, {'name': 'protocol', 'value': '1', 'op': 1, 'value2': None}]], 'session_type': 'client'} 2026-05-04 04:11:54,247 - DEBUG - [{'remote_vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571', 'vn': 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497', 'sample_count': 3}] 2026-05-04 04:11:54,247 - INFO - wait for the flows to get expire 2026-05-04 04:15:14,248 - DEBUG - Requesting: http://10.0.0.129:8081/analytics/uves/generator/an-jenkins-deploy-platform-ansible-os-5740-1:Compute:contrail-vrouter-agent:0?flat 2026-05-04 04:15:14,361 - DEBUG - Requesting: http://10.0.0.249:8081/analytics/uves/vrouter/an-jenkins-deploy-platform-ansible-os-5740-1?flat 2026-05-04 04:15:15,067 - INFO - Deleted policy policy1 2026-05-04 04:15:15,189 - INFO - Setting flow export rate: None 2026-05-04 04:15:16,508 - ERROR - AssertionError Python 3.9.25: /usr/bin/python3 Mon May 4 04:15:14 2026 A problem occurred in a Python script. Here is the sequence of function calls leading up to the error, in the order they occurred. /contrail-test/tcutils/wrappers.py in wrapper(self=, *args=(), **kwargs={}) 78 log.info('Initial checks done. Running the testcase now') 79 log.info('') 80 result = function(self, *args, **kwargs) 81 if self.inputs.upgrade: 82 pid = os.getpid() result = None function = self = args = () kwargs = {} /contrail-test/serial_scripts/analytics/test_analytics_resource.py in test_verify_session_sampling_teardown(self=) 1281 src_vn = self.res.vn1_fixture.vn_fq_name 1282 dst_vn = self.res.vn2_fixture.vn_fq_name 1283 result = self.verify_session_sampling_teardown(start_time, src_vn, dst_vn) 1284 1285 assert result,'Failed to get expected number of samples' result = True self = self.verify_session_sampling_teardown = > start_time = '1777867897474959' src_vn = 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497' dst_vn = 'default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571' /contrail-test/serial_scripts/analytics/base.py in verify_session_sampling_teardown(self=, start_time='1777867897474959', src_vn='default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497', dst_vn='default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571') 486 flow_record = self.analytics_obj.get_flows_vrouter_uve( 487 vrouter=vm_host) 488 assert not flow_record,'flows not got deleted even after 240 sec' 489 490 res = self.analytics_obj.ops_inspect[ip].post_query( flow_record = 6 AssertionError: flows not got deleted even after 240 sec __cause__ = None __class__ = __context__ = None __delattr__ = __dict__ = {} __dir__ = __doc__ = 'Assertion failed.' __eq__ = __format__ = __ge__ = __getattribute__ = __gt__ = __hash__ = __init__ = __init_subclass__ = __le__ = __lt__ = __ne__ = __new__ = __reduce__ = __reduce_ex__ = __repr__ = __setattr__ = __setstate__ = __sizeof__ = __str__ = __subclasshook__ = __suppress_context__ = False __traceback__ = args = ('flows not got deleted even after 240 sec',) with_traceback = The above is a description of an error in a Python program. Here is the original traceback: Traceback (most recent call last): File "/contrail-test/tcutils/wrappers.py", line 80, in wrapper result = function(self, *args, **kwargs) File "/contrail-test/serial_scripts/analytics/test_analytics_resource.py", line 1283, in test_verify_session_sampling_teardown result = self.verify_session_sampling_teardown(start_time, src_vn, dst_vn) File "/contrail-test/serial_scripts/analytics/base.py", line 488, in verify_session_sampling_teardown assert not flow_record,'flows not got deleted even after 240 sec' AssertionError: flows not got deleted even after 240 sec 2026-05-04 04:15:16,510 - DEBUG - Skipping xmpp flap check 2026-05-04 04:15:16,510 - INFO -

2026-05-04 04:15:16,510 - INFO - END TEST : test_verify_session_sampling_teardown : FAILED[0:03:44]

2026-05-04 04:15:16,510 - INFO - -------------------------------------------------------------------------------- 2026-05-04 04:15:16,512 - INFO - Deleting VM mltf_vm 2026-05-04 04:15:16,589 - INFO - Deleting VM ctest-fvn_vm1-46968082 2026-05-04 04:15:16,683 - INFO - Deleting VM ctest-vn2_vm2-97834820 2026-05-04 04:15:16,767 - INFO - Deleting VN ctest-fip_vn-53977699 2026-05-04 04:15:16,816 - DEBUG - VN 34ce0969-d631-4e60-a504-3e07ed41cc2d still in use: Unable to complete operation on network 34ce0969-d631-4e60-a504-3e07ed41cc2d. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-5b042763-5a4c-4b7b-ade2-3a482b23995d'] 2026-05-04 04:15:16,816 - WARNING - Deleting VN ctest-fip_vn-53977699 failed..Will retry 2026-05-04 04:15:19,100 - DEBUG - Response for deleting network () 2026-05-04 04:15:19,101 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/2b0a1993-7b51-46fd-b268-a4930f323f40 2026-05-04 04:15:19,139 - DEBUG - Response Code: 404 2026-05-04 04:15:19,140 - DEBUG - Requesting: http://10.0.0.129:8082/domains 2026-05-04 04:15:19,150 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c 2026-05-04 04:15:19,165 - DEBUG - Requesting: http://10.0.0.129:8082/project/711b033b-e2c7-4e7b-a7f3-f1944ade6940 2026-05-04 04:15:19,293 - INFO - Validated that VN ctest-fip_vn-53977699 is not found in API Server 2026-05-04 04:15:19,305 - DEBUG - VN ctest-fip_vn-53977699 is not present in Agent 10.0.0.41 2026-05-04 04:15:19,315 - DEBUG - VN ctest-fip_vn-53977699 is not present in Agent 10.0.0.141 2026-05-04 04:15:19,315 - INFO - Validated that VN ctest-fip_vn-53977699 is not in any agent 2026-05-04 04:15:19,323 - DEBUG - VRF 5 is not seen in agent 10.0.0.141 2026-05-04 04:15:19,329 - DEBUG - Vrouter 10.0.0.141 does not have vrf 5 for VN ctest-fip_vn-53977699 2026-05-04 04:15:19,329 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-fip_vn-53977699 2026-05-04 04:15:19,359 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-fip_vn-53977699 info 2026-05-04 04:15:19,359 - INFO - Deleting VN ctest-vn2-47014571 2026-05-04 04:15:19,621 - DEBUG - Response for deleting network () 2026-05-04 04:15:19,621 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/4a74f0a5-0f05-44d1-8d0e-7f60715a8a69 2026-05-04 04:15:19,628 - DEBUG - Response Code: 404 2026-05-04 04:15:19,628 - DEBUG - Requesting: http://10.0.0.129:8082/domains 2026-05-04 04:15:19,635 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c 2026-05-04 04:15:19,651 - DEBUG - Requesting: http://10.0.0.129:8082/project/711b033b-e2c7-4e7b-a7f3-f1944ade6940 2026-05-04 04:15:19,761 - INFO - Validated that VN ctest-vn2-47014571 is not found in API Server 2026-05-04 04:15:19,774 - DEBUG - VN ctest-vn2-47014571 is not present in Agent 10.0.0.41 2026-05-04 04:15:19,789 - DEBUG - VN ctest-vn2-47014571 is not present in Agent 10.0.0.141 2026-05-04 04:15:19,789 - INFO - Validated that VN ctest-vn2-47014571 is not in any agent 2026-05-04 04:15:19,797 - DEBUG - VRF 5 is not seen in agent 10.0.0.41 2026-05-04 04:15:19,805 - DEBUG - Vrouter 10.0.0.41 does not have vrf 5 for VN ctest-vn2-47014571 2026-05-04 04:15:19,813 - DEBUG - VRF 4 is not seen in agent 10.0.0.141 2026-05-04 04:15:19,819 - DEBUG - Vrouter 10.0.0.141 does not have vrf 4 for VN ctest-vn2-47014571 2026-05-04 04:15:19,819 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn2-47014571 2026-05-04 04:15:19,847 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn2-47014571 info 2026-05-04 04:15:19,847 - INFO - Deleting VM ctest-vn1_vm2-92516347 2026-05-04 04:15:19,946 - INFO - Deleting VM ctest-vn1_vm1-31497109 2026-05-04 04:15:20,036 - INFO - Deleting VN ctest-vn1-00505497 2026-05-04 04:15:20,090 - DEBUG - VN df2f8407-3df7-4f40-a8d3-bf4c63fbebf4 still in use: Unable to complete operation on network df2f8407-3df7-4f40-a8d3-bf4c63fbebf4. There are one or more ports still in use on the network. Neutron server returns request_ids: ['req-d4553b55-56db-40d4-8455-e16f188c3b66'] 2026-05-04 04:15:20,091 - WARNING - Deleting VN ctest-vn1-00505497 failed..Will retry 2026-05-04 04:15:22,279 - DEBUG - Response for deleting network () 2026-05-04 04:15:22,279 - DEBUG - Requesting: http://10.0.0.129:8082/routing-instance/b2707d3d-9877-4c16-b1c8-031de92f1a6e 2026-05-04 04:15:22,285 - DEBUG - Response Code: 404 2026-05-04 04:15:22,286 - DEBUG - Requesting: http://10.0.0.129:8082/domains 2026-05-04 04:15:22,292 - DEBUG - Requesting: http://10.0.0.129:8082/domain/de444c91-1c2e-4590-9dad-cf698cd9c62c 2026-05-04 04:15:22,316 - DEBUG - Requesting: http://10.0.0.129:8082/project/711b033b-e2c7-4e7b-a7f3-f1944ade6940 2026-05-04 04:15:22,423 - INFO - Validated that VN ctest-vn1-00505497 is not found in API Server 2026-05-04 04:15:22,435 - DEBUG - VN ctest-vn1-00505497 is not present in Agent 10.0.0.41 2026-05-04 04:15:22,448 - DEBUG - VN ctest-vn1-00505497 is not present in Agent 10.0.0.141 2026-05-04 04:15:22,448 - INFO - Validated that VN ctest-vn1-00505497 is not in any agent 2026-05-04 04:15:22,455 - DEBUG - VRF 4 is not seen in agent 10.0.0.41 2026-05-04 04:15:22,468 - DEBUG - Vrouter 10.0.0.41 does not have vrf 4 for VN ctest-vn1-00505497 2026-05-04 04:15:22,468 - INFO - Validated that all vrouters do not have the route table for VN default-domain:ctest-AnalyticsTestSanityWithResource-70378297:ctest-vn1-00505497 2026-05-04 04:15:22,493 - INFO - Validated that Routing instances and Config db in Control-nodes does not have VN ctest-vn1-00505497 info 2026-05-04 04:15:23,378 - INFO - Deleted project: ctest-AnalyticsTestSanityWithResource-70378297, ID : 711b033b-e2c7-4e7b-a7f3-f1944ade6940